Re: Hostapd-0.5.5 and freeradius-server-2.1.1

28 Oct 2008

      Le mardi 28 octobre 2008 10:19, tnt@kalik.net a écrit :
...
Have you enabled sql in the accounting section? Can you post the
freeradius debug (radiusd -X)? Accounting-Request should be coming
straight after Access-Accept.
accounting {
   detail
   unix
   radutmp
   sql
   sql_log
}
Her my site-ennable/default for accounting (without comment !)

Very long post : When I started radisud -X
FreeRADIUS Version 2.1.0, for host i686-pc-linux-gnu, built on Oct 26 2008 at 
04:54:28
Copyright (C) 1999-2008 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 /usr/etc/raddb/radiusd.conf
including configuration file /usr/etc/raddb/proxy.conf
including configuration file /usr/etc/raddb/clients.conf
including files in directory /usr/etc/raddb/modules/
including configuration file /usr/etc/raddb/modules/sradutmp
including configuration file /usr/etc/raddb/modules/passwd
including configuration file /usr/etc/raddb/modules/files
including configuration file /usr/etc/raddb/modules/exec
including configuration file /usr/etc/raddb/modules/always
including configuration file /usr/etc/raddb/modules/policy
including configuration file /usr/etc/raddb/modules/logintime
including configuration file /usr/etc/raddb/modules/detail
including configuration file /usr/etc/raddb/modules/checkval
including configuration file /usr/etc/raddb/modules/linelog
including configuration file /usr/etc/raddb/modules/ippool
including configuration file /usr/etc/raddb/modules/chap
including configuration file /usr/etc/raddb/modules/preprocess
including configuration file /usr/etc/raddb/modules/expr
including configuration file /usr/etc/raddb/modules/digest
including configuration file /usr/etc/raddb/modules/smbpasswd
including configuration file /usr/etc/raddb/modules/pam
including configuration file /usr/etc/raddb/modules/echo
including configuration file /usr/etc/raddb/modules/sql_log
including configuration file /usr/etc/raddb/modules/ldap
including configuration file /usr/etc/raddb/modules/etc_group
including configuration file /usr/etc/raddb/modules/unix
including configuration file /usr/etc/raddb/modules/radutmp
including configuration file /usr/etc/raddb/modules/pap
including configuration file /usr/etc/raddb/modules/inner-eap
including configuration file /usr/etc/raddb/modules/realm
including configuration file /usr/etc/raddb/modules/mschap
including configuration file /usr/etc/raddb/modules/detail.example.com
including configuration file /usr/etc/raddb/modules/wimax
including configuration file /usr/etc/raddb/modules/detail.log
including configuration file /usr/etc/raddb/modules/acct_unique
including configuration file /usr/etc/raddb/modules/attr_filter
including configuration file /usr/etc/raddb/modules/mac2vlan
including configuration file /usr/etc/raddb/modules/attr_rewrite
including configuration file /usr/etc/raddb/modules/krb5
including configuration file /usr/etc/raddb/modules/expiration
including configuration file /usr/etc/raddb/modules/counter
including configuration file /usr/etc/raddb/modules/mac2ip
including configuration file /usr/etc/raddb/eap.conf
including configuration file /usr/etc/raddb/sql.conf
including configuration file /usr/etc/raddb/sql/mysql/dialup.conf
including configuration file /usr/etc/raddb/sql/mysql/counter.conf
including configuration file /usr/etc/raddb/policy.conf
including files in directory /usr/etc/raddb/sites-enabled/
including configuration file /usr/etc/raddb/sites-enabled/default
including configuration file /usr/etc/raddb/sites-enabled/inner-tunnel
including dictionary file /usr/etc/raddb/dictionary
main {
        prefix = "/usr"
        localstatedir = "/usr/var"
        logdir = "/usr/var/log/radius"
        libdir = "/usr/lib"
        radacctdir = "/usr/var/log/radius/radacct"
        hostname_lookups = no
        max_request_time = 30
        cleanup_delay = 5
        max_requests = 1024
        allow_core_dumps = no
        pidfile = "/usr/var/run/radiusd/radiusd.pid"
        checkrad = "/usr/sbin/checkrad"
        debug_level = 0
        proxy_requests = yes
 log {
        stripped_names = no
        auth = no
        auth_badpass = no
        auth_goodpass = no
 }
 security {
        max_attributes = 200
        reject_delay = 1
        status_server = yes
 }
}
 client localhost {
        ipaddr = 127.0.0.1
        require_message_authenticator = no
        secret = "fszd79772mvtib96"
        shortname = "localhost"
        nastype = "other"
 }
 client 10.1.1.254 {
        require_message_authenticator = no
        secret = "fszd79772mvtib96"
        shortname = "private-network-1"
        nastype = "other"
 }
radiusd: #### Loading Realms and Home Servers ####
 proxy server {
        retry_delay = 30
        retry_count = 1
        default_fallback = no
        dead_time = 300
        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
        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
 }
 home_server_pool my_auth_failover {
        type = fail-over
        home_server = localhost
 }
 realm example.com {
        auth_pool = my_auth_failover
 }
 realm LOCAL {
 }
radiusd: #### Instantiating modules ####
 instantiate {
 Module: Linked to module rlm_exec
 Module: Instantiating exec
  exec {
        wait = no
        input_pairs = "request"
        shell_escape = yes
  }
 Module: Linked to module rlm_expr
 Module: Instantiating expr
 Module: Linked to module rlm_expiration
 Module: Instantiating expiration
  expiration {
        reply-message = "Password Has Expired  "
  }
 Module: Linked to module rlm_logintime
 Module: Instantiating logintime
  logintime {
        reply-message = "You are calling outside your allowed timespan  "
        minimum-timeout = 60
  }
 }
radiusd: #### Loading Virtual Servers ####
server inner-tunnel {
 modules {
 Module: Checking authenticate {...} for more modules to load
 Module: Linked to module rlm_pap
 Module: Instantiating pap
  pap {
        encryption_scheme = "auto"
        auto_header = no
  }
 Module: Linked to module rlm_chap
 Module: Instantiating chap
 Module: Linked to module rlm_mschap
 Module: Instantiating mschap
  mschap {
        use_mppe = yes
        require_encryption = no
        require_strong = no
        with_ntdomain_hack = no
  }
 Module: Linked to module rlm_unix
 Module: Instantiating unix
  unix {
        radwtmp = "/usr/var/log/radius/radwtmp"
  }
 Module: Linked to module rlm_ldap
 Module: Instantiating ldap
  ldap {
        server = "10.1.1.254"
        port = 389
        password = ""
        identity = ""
        net_timeout = 1
        timeout = 4
        timelimit = 3
        tls_mode = no
        start_tls = no
        tls_require_cert = "allow"
   tls {
        start_tls = no
        require_cert = "allow"
   }
        basedn = "dc=dom-sln,dc=local"
        filter = "(&(uid=%{Stripped-User-Name:-%{User-Name}})
(dialupAccess=yes))"
        base_filter = "(objectclass=radiusprofile)"
        auto_header = no
        access_attr = "dialupAccess"
        access_attr_used_for_allow = yes
        groupname_attribute = "cn"
        groupmembership_filter = "(|(&(objectClass=GroupOfNames)
(member=%{Ldap-UserDn}))(&(objectClass=GroupOfUniqueNames)
(uniquemember=%{Ldap-UserDn})))"
        dictionary_mapping = "/usr/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 /usr/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 userPassord mapped to RADIUS LM-Password
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 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
conns: 0x81662d8
 Module: Linked to module rlm_eap
 Module: Instantiating eap
  eap {
        default_eap_type = "md5"
        timer_expire = 60
        ignore_unknown_eap_types = no
        cisco_accounting_username_bug = no
        max_sessions = 2048
  }
 Module: Linked to sub-module rlm_eap_md5
 Module: Instantiating eap-md5
 Module: Linked to sub-module rlm_eap_leap
 Module: Instantiating eap-leap
 Module: Linked to sub-module rlm_eap_gtc
 Module: Instantiating eap-gtc
   gtc {
        challenge = "Password: "
        auth_type = "PAP"
   }
 Module: Linked to sub-module rlm_eap_tls
 Module: Instantiating eap-tls
   tls {
        rsa_key_exchange = no
        dh_key_exchange = yes
        rsa_key_length = 512
        dh_key_length = 512
        verify_depth = 0
        pem_file_type = yes
        private_key_file = "/usr/etc/raddb/certs/server.pem"
        certificate_file = "/usr/etc/raddb/certs/server.pem"
        CA_file = "/usr/etc/raddb/certs/ca.pem"
        private_key_password = "whatever"
        dh_file = "/usr/etc/raddb/certs/dh"
        random_file = "/usr/etc/raddb/certs/random"
        fragment_size = 1024
        include_length = yes
        check_crl = no
        cipher_list = "DEFAULT"
        make_cert_command = "/usr/etc/raddb/certs/bootstrap"
    cache {
        enable = no
        lifetime = 24
        max_entries = 255
    }
   }
 Module: Linked to sub-module rlm_eap_ttls
 Module: Instantiating eap-ttls
   ttls {
        default_eap_type = "md5"
        copy_request_to_tunnel = no
        use_tunneled_reply = no
        virtual_server = "inner-tunnel"
   }
 Module: Linked to sub-module rlm_eap_peap
 Module: Instantiating eap-peap
   peap {
        default_eap_type = "mschapv2"
        copy_request_to_tunnel = no
        use_tunneled_reply = no
        proxy_tunneled_request_as_eap = yes
        virtual_server = "inner-tunnel"
   }
 Module: Linked to sub-module rlm_eap_mschapv2
 Module: Instantiating eap-mschapv2
   mschapv2 {
        with_ntdomain_hack = no
   }
 Module: Checking authorize {...} for more modules to load
 Module: Linked to module rlm_realm
 Module: Instantiating suffix
  realm suffix {
        format = "suffix"
        delimiter = "@"
        ignore_default = no
        ignore_null = no
  }
 Module: Linked to module rlm_files
 Module: Instantiating files
  files {
        usersfile = "/usr/etc/raddb/users"
        acctusersfile = "/usr/etc/raddb/acct_users"
        preproxy_usersfile = "/usr/etc/raddb/preproxy_users"
        compat = "no"
  }
 Module: Linked to module rlm_sql
 Module: Instantiating sql
  sql {
        driver = "rlm_sql_mysql"
        server = "localhost"
        port = ""
        login = "root"
        password = "fszd7977"
        radius_db = "radius"
        read_groups = yes
        sqltrace = yes
        sqltracefile = "/usr/var/log/radius/sqltrace.sql"
        readclients = no
        deletestalesessions = yes
        num_sql_socks = 5
        sql_user_name = "%{User-Name}"
        default_user_profile = ""
        nas_query = "SELECT id, nasname, shortname, type, secret FROM nas"
        authorize_check_query = "SELECT id, username, attribute, value, op           
FROM radcheck           WHERE username = '%{SQL-User-Name}'           ORDER 
BY id"
        authorize_reply_query = "SELECT id, username, attribute, value, op           
FROM radreply           WHERE username = '%{SQL-User-Name}'           ORDER 
BY id"
        authorize_group_check_query = "SELECT id, groupname, attribute,           
Value, op           FROM radgroupcheck           WHERE groupname 
= '%{Sql-Group}'           ORDER BY id"
        authorize_group_reply_query = "SELECT id, groupname, attribute,           
value, op           FROM radgroupreply           WHERE groupname 
= '%{Sql-Group}'           ORDER BY id"
        accounting_onoff_query = "          UPDATE radacct           SET              
acctstoptime       =  '%S',              acctsessiontime    =  
unix_timestamp('%S') -                                    
unix_timestamp(acctstarttime),              acctterminatecause 
=  '%{Acct-Terminate-Cause}',              acctstopdelay      
=  %{%{Acct-Delay-Time}:-0}           WHERE acctstoptime IS NULL           
AND nasipaddress      =  '%{NAS-IP-Address}'           AND acctstarttime     
<= '%S'"
        accounting_update_query = "           UPDATE radacct           SET              
framedipaddress = '%{Framed-IP-Address}',              acctsessiontime     
= '%{Acct-Session-Time}',              acctinputoctets     
= '%{%{Acct-Input-Gigawords}:-0}'  << 
32 |                                    '%{%{Acct-Input-Octets}:-0}',              
acctoutputoctets    = '%{%{Acct-Output-Gigawords}:-0}' << 
32 |                                    '%{%{Acct-Output-Octets}:-0}'           
WHERE acctsessionid = '%{Acct-Session-Id}'           AND username        
= '%{SQL-User-Name}'           AND nasipaddress    = '%{NAS-IP-Address}'"
        accounting_update_query_alt = "           INSERT INTO radacct             
(acctsessionid,    acctuniqueid,      username,              realm,            
nasipaddress,      nasportid,              nasporttype,      acctstarttime,     
acctsessiontime,              acctauthentic,    connectinfo_start, 
acctinputoctets,              acctoutputoctets, calledstationid,   
callingstationid,              servicetype,      framedprotocol,    
framedipaddress,              acctstartdelay,   xascendsessionsvrkey)           
VALUES             
('%{Acct-Session-Id}', '%{Acct-Unique-Session-Id}',              '%{SQL-User-Name}',              '%{Realm}', '%{NAS-IP-Address}', '%{NAS-Port}',              '%{NAS-Port-Type}',              
DATE_SUB('%S',                       INTERVAL (%{%{Acct-Session-Time}:-0} 
+                                 %{%{Acct-Delay-Time}:-0}) 
SECOND),                       '%{Acct-Session-Time}',              '%{Acct-Authentic}', '',              '%{%{Acct-Input-Gigawords}:-0}' 
<< 
32 |              '%{%{Acct-Input-Octets}:-0}',              '%{%{Acct-Output-Gigawords}:-0}' 
<< 
32 |              '%{%{Acct-Output-Octets}:-0}',              '%{Called-Station-Id}', '%{Calling-Station-Id}',              '%{Service-Type}', '%{Framed-Protocol}',              '%{Framed-IP-Address}',              '0', '%{X-Ascend-Session-Svr-Key}')"
        accounting_start_query = "           INSERT INTO radacct             
(acctsessionid,    acctuniqueid,     username,              realm,            
nasipaddress,     nasportid,              nasporttype,      acctstarttime,    
acctstoptime,              acctsessiontime,  acctauthentic,    
connectinfo_start,              connectinfo_stop, acctinputoctets,  
acctoutputoctets,              calledstationid,  callingstationid, 
acctterminatecause,              servicetype,      framedprotocol,   
framedipaddress,              acctstartdelay,   acctstopdelay,    
xascendsessionsvrkey)           VALUES             
('%{Acct-Session-Id}', '%{Acct-Unique-Session-Id}',              '%{SQL-User-Name}',              '%{Realm}', '%{NAS-IP-Address}', '%{NAS-Port}',              '%{NAS-Port-Type}', '%S', 
NULL,              '0', '%{Acct-Authentic}', '%{Connect-Info}',              '', '0', '0',              '%{Called-Station-Id}', '%{Calling-Station-Id}', '',              '%{Service-Type}', '%{Framed-Protocol}', '%{Framed-IP-Address}',              '%{%{Acct-Delay-Time}:-0}', '0', '%{X-Ascend-Session-Svr-Key}')"
        accounting_start_query_alt = "           UPDATE radacct SET              
acctstarttime     = '%S',              acctstartdelay    
= '%{%{Acct-Delay-Time}:-0}',              connectinfo_start 
= '%{Connect-Info}'           WHERE acctsessionid  = '%{Acct-Session-Id}'           
AND username         = '%{SQL-User-Name}'           AND nasipaddress     
= '%{NAS-IP-Address}'"
        accounting_stop_query = "           UPDATE radacct SET              
acctstoptime       = '%S',              acctsessiontime    
= '%{Acct-Session-Time}',              acctinputoctets    
= '%{%{Acct-Input-Gigawords}:-0}' << 
32 |                                   '%{%{Acct-Input-Octets}:-0}',              
acctoutputoctets   = '%{%{Acct-Output-Gigawords}:-0}' << 
32 |                                   '%{%{Acct-Output-Octets}:-0}',              
acctterminatecause = '%{Acct-Terminate-Cause}',              acctstopdelay      
= '%{%{Acct-Delay-Time}:-0}',              connectinfo_stop   
= '%{Connect-Info}'           WHERE acctsessionid   = '%{Acct-Session-Id}'           
AND username          = '%{SQL-User-Name}'           AND nasipaddress      
= '%{NAS-IP-Address}'"
        accounting_stop_query_alt = "           INSERT INTO radacct             
(acctsessionid, acctuniqueid, username,              realm, nasipaddress, 
nasportid,              nasporttype, acctstarttime, acctstoptime,              
acctsessiontime, acctauthentic, connectinfo_start,              
connectinfo_stop, acctinputoctets, acctoutputoctets,              
calledstationid, callingstationid, acctterminatecause,              
servicetype, framedprotocol, framedipaddress,              acctstartdelay, 
acctstopdelay)           VALUES             
('%{Acct-Session-Id}', '%{Acct-Unique-Session-Id}',              '%{SQL-User-Name}',              '%{Realm}', '%{NAS-IP-Address}', '%{NAS-Port}',              '%{NAS-Port-Type}',              
DATE_SUB('%S',                  INTERVAL (%{%{Acct-Session-Time}:-0} 
+                  %{%{Acct-Delay-Time}:-0}) 
SECOND),              '%S', '%{Acct-Session-Time}', '%{Acct-Authentic}', '',              '%{Connect-Info}',              '%{%{Acct-Input-Gigawords}:-0}' 
<< 
32 |              '%{%{Acct-Input-Octets}:-0}',              '%{%{Acct-Output-Gigawords}:-0}' 
<< 
32 |              '%{%{Acct-Output-Octets}:-0}',              '%{Called-Station-Id}', '%{Calling-Station-Id}',              '%{Acct-Terminate-Cause}',              '%{Service-Type}', '%{Framed-Protocol}', '%{Framed-IP-Address}',              '0', '%{%{Acct-Delay-Time}:-0}')"
        group_membership_query = "SELECT groupname           FROM radusergroup           
WHERE username = '%{SQL-User-Name}'           ORDER BY priority"
        connect_failure_retry_delay = 60
        simul_count_query = ""
        simul_verify_query = "SELECT radacctid, acctsessionid, username,                                
nasipaddress, nasportid, framedipaddress,                                
callingstationid, framedprotocol                                FROM radacct                                
WHERE username = '%{SQL-User-Name}'                                AND 
acctstoptime IS NULL"
        postauth_query = "INSERT INTO radpostauth                           
(username, pass, reply, authdate)                           VALUES 
(                           '%{User-Name}',                           '%{%{User-Password}:-%{Chap-Password}}',                           '%{reply:Packet-Type}', '%S')"
        safe-characters 
= "@abcdefghijklmnopqrstuvwxyzABCDEFGHIJKLMNOPQRSTUVWXYZ0123456789.-_: /"
  }
rlm_sql (sql): Driver rlm_sql_mysql (module rlm_sql_mysql) loaded and linked
rlm_sql (sql): Attempting to connect to root@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
 Module: Linked to module rlm_checkval
 Module: Instantiating checkval
  checkval {
        item-name = "Calling-Station-Id"
        check-name = "Calling-Station-Id"
        data-type = "string"
        notfound-reject = no
  }
rlm_checkval: Registered name Calling-Station-Id for attribute 31
 Module: Checking session {...} for more modules to load
 Module: Linked to module rlm_radutmp
 Module: Instantiating radutmp
  radutmp {
        filename = "/usr/var/log/radius/radutmp"
        username = "%{User-Name}"
        case_sensitive = yes
        check_with_nas = yes
        perm = 384
        callerid = yes
  }
 Module: Checking post-proxy {...} for more modules to load
 Module: Checking post-auth {...} for more modules to load
 Module: Linked to module rlm_detail
 Module: Instantiating reply_log
  detail reply_log {
        detailfile 
= "/usr/var/log/radius/radacct/%{Client-IP-Address}/reply-detail-%Y%m%d"
        header = "%t"
        detailperm = 384
        dirperm = 493
        locking = no
        log_packet_header = no
  }
 Module: Linked to module rlm_sql_log
 Module: Instantiating sql_log
  sql_log {
        path = "/usr/var/log/radius/radacct/sql-relay"
        Post-Auth = "INSERT INTO radpostauth                     (username, 
pass, reply, authdate) VALUES                        
('%{User-Name}', '%{User-Password:-Chap-Password}',                '%{reply:Packet-Type}', '%S');"
        sql_user_name = "%{%{User-Name}:-DEFAULT}"
        safe-characters 
= "@abcdefghijklmnopqrstuvwxyzABCDEFGHIJKLMNOPQRSTUVWXYZ0123456789.-_: /"
  }
 Module: Linked to module rlm_attr_filter
 Module: Instantiating attr_filter.access_reject
  attr_filter attr_filter.access_reject {
        attrsfile = "/usr/etc/raddb/attrs.access_reject"
        key = "%{User-Name}"
  }
 }
}
 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 = "/usr/etc/raddb/huntgroups"
        hints = "/usr/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: 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 
= "/usr/var/log/radius/radacct/%{Client-IP-Address}/detail-%Y%m%d"
        header = "%t"
        detailperm = 384
        dirperm = 493
        locking = no
        log_packet_header = no
  }
 Module: Instantiating attr_filter.accounting_response
  attr_filter attr_filter.accounting_response {
        attrsfile = "/usr/etc/raddb/attrs.accounting_response"
        key = "%{User-Name}"
  }
 Module: Checking session {...} for more modules to load
 Module: Checking post-proxy {...} for more modules to load
 Module: Checking post-auth {...} for more modules to load
 }
radiusd: #### Opening IP addresses and Ports ####
listen {
        type = "auth"
        ipaddr = 10.1.1.254
        port = 0
}
listen {
        type = "acct"
        ipaddr = 10.1.1.254
        port = 0
}
Listening on authentication address 10.1.1.254 port 1812
Listening on accounting address 10.1.1.254 port 1813
Listening on proxy address 10.1.1.254 port 1814
Ready to process requests.

My Clients.conf :
client 10.1.1.254 {
	secret		= fszd79772mvtib96
	shortname	= private-network-1
	nastype		= other
}
Part of hostap :
# serveur auth
auth_server_addr=10.1.1.254
auth_server_port=1812
auth_server_shared_secret=fszd79772mvtib96

# serveur acct
acct_server_addr=10.1.1.254
acct_server_port=1813
auth_server_shared_secret=fszd79772mvtib96

And when transaction is received :
rad_recv: Access-Request packet from host 10.1.1.254 port 32781, id=1, 
length=166
        User-Name = "bea"
        NAS-IP-Address = 10.3.1.1
        NAS-Identifier = "private-network-1"
        NAS-Port = 0
        Called-Station-Id = "00-18-4D-76-22-19:Debian-AP"
        Calling-Station-Id = "00-1A-70-AE-D4-53"
        Framed-MTU = 1400
        NAS-Port-Type = Wireless-802.11
        Connect-Info = "CONNECT 0Mbps 802.11"
        EAP-Message = 0x0201000801626561
        Message-Authenticator = 0xccdfdac75325b2b440b69cfe5db93f46
+- entering group authorize {...}
++[preprocess] returns ok
++[chap] returns noop
++[mschap] returns noop
[suffix] No '@' in User-Name = "bea", looking up realm NULL
[suffix] No such realm "NULL"
++[suffix] returns noop
[eap] EAP packet type response id 1 length 8
[eap] No EAP Start, assuming it's an on-going EAP conversation
++[eap] returns updated
++[unix] returns updated
++[files] returns noop
[ldap] performing user authorization for bea
WARNING: Deprecated conditional expansion ":-".  See "man unlang" for details
        expand: (&(uid=%{Stripped-User-Name:-%{User-Name}})
(dialupAccess=yes)) -> (&(uid=bea)(dialupAccess=yes))
        expand: dc=dom-sln,dc=local -> dc=dom-sln,dc=local
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 10.1.1.254:389, authentication 0
rlm_ldap: bind as / to 10.1.1.254:389
rlm_ldap: waiting for bind result ...
rlm_ldap: Bind was successful
rlm_ldap: performing search in dc=dom-sln,dc=local, with filter (&(uid=bea)
(dialupAccess=yes))
[ldap] checking if remote access for bea is allowed by dialupAccess
[ldap] looking for check items in directory...
rlm_ldap: radiusNASIpAddress -> NAS-IP-Address == 10.3.1.1
rlm_ldap: sambaNtPassword -> NT-Password == 
0x4535314146423843313739373146344444423839444130303942363842343935
rlm_ldap: sambaLmPassword -> LM-Password == 
0x3343303836453237453535453532313436313534443245314442334242343439
rlm_ldap: radiusCallingStationId -> Calling-Station-Id == "00-1A-70-AE-D4-53"
rlm_ldap: radiusCalledStationId -> Called-Station-Id 
== "00-18-4D-76-22-19:Debian-AP"
[ldap] looking for reply items in directory...
rlm_ldap: radiusIdleTimeout -> Idle-Timeout = 25
rlm_ldap: radiusSessionTimeout -> Session-Timeout = 25
rlm_ldap: radiusFramedMTU -> Framed-MTU = 1234
rlm_ldap: radiusFramedRouting -> Framed-Routing = None
rlm_ldap: radiusFramedIPNetmask -> Framed-IP-Netmask = 255.255.255.0
rlm_ldap: radiusFramedIPAddress -> Framed-IP-Address = 10.3.1.252
rlm_ldap: radiusFramedProtocol -> Framed-Protocol = PPP
rlm_ldap: radiusServiceType -> Service-Type = Framed-User
WARNING: No "known good" password was found in LDAP.  Are you sure that the 
user is configured correctly?
[ldap] user bea authorized to use remote access
rlm_ldap: ldap_release_conn: Release Id: 0
++[ldap] returns ok
rlm_checkval: Item Name: Calling-Station-Id, Value: 00-1A-70-AE-D4-53
rlm_checkval: Value Name: Calling-Station-Id, Value: 00-1A-70-AE-D4-53
++[checkval] returns ok
++[expiration] returns noop
++[logintime] returns noop
[pap] Normalizing NT-Password from hex encoding
[pap] Normalizing LM-Password from hex encoding
[pap] Found existing Auth-Type, not changing it.
++[pap] returns noop
Found Auth-Type = EAP
+- entering group authenticate {...}
[eap] EAP Identity
[eap] processing type md5
rlm_eap_md5: Issuing Challenge
++[eap] returns handled
Sending Access-Challenge of id 1 to 10.1.1.254 port 32781
        Idle-Timeout = 25
        Session-Timeout = 25
        Framed-MTU = 1234
        Framed-Routing = None
        Framed-IP-Netmask = 255.255.255.0
        Framed-IP-Address = 10.3.1.252
        Framed-Protocol = PPP
        Service-Type = Framed-User
        EAP-Message = 0x0102001604100fd8bf3f2cc05a2f8e74f988c2194b35
        Message-Authenticator = 0x00000000000000000000000000000000
        State = 0xd0c9e9b2d0cbed858c934a168f6818f8
Finished request 0.
Going to the next request
Waking up in 4.9 seconds.
rad_recv: Access-Request packet from host 10.1.1.254 port 32781, id=2, 
length=182
        User-Name = "bea"
        NAS-IP-Address = 10.3.1.1
        NAS-Identifier = "private-network-1"
        NAS-Port = 0
        Called-Station-Id = "00-18-4D-76-22-19:Debian-AP"
        Calling-Station-Id = "00-1A-70-AE-D4-53"
        Framed-MTU = 1400
        NAS-Port-Type = Wireless-802.11
        Connect-Info = "CONNECT 0Mbps 802.11"
        EAP-Message = 0x020200060319
        State = 0xd0c9e9b2d0cbed858c934a168f6818f8
        Message-Authenticator = 0x516ed8f8d25c8f69968798cb026094fb
+- entering group authorize {...}
++[preprocess] returns ok
++[chap] returns noop
++[mschap] returns noop
[suffix] No '@' in User-Name = "bea", looking up realm NULL
[suffix] No such realm "NULL"
++[suffix] returns noop
[eap] EAP packet type response id 2 length 6
[eap] No EAP Start, assuming it's an on-going EAP conversation
++[eap] returns updated
++[unix] returns updated
++[files] returns noop
[ldap] performing user authorization for bea
WARNING: Deprecated conditional expansion ":-".  See "man unlang" for details
        expand: (&(uid=%{Stripped-User-Name:-%{User-Name}})
(dialupAccess=yes)) -> (&(uid=bea)(dialupAccess=yes))
        expand: dc=dom-sln,dc=local -> dc=dom-sln,dc=local
rlm_ldap: ldap_get_conn: Checking Id: 0
rlm_ldap: ldap_get_conn: Got Id: 0
rlm_ldap: performing search in dc=dom-sln,dc=local, with filter (&(uid=bea)
(dialupAccess=yes))
[ldap] checking if remote access for bea is allowed by dialupAccess
[ldap] looking for check items in directory...
rlm_ldap: radiusNASIpAddress -> NAS-IP-Address == 10.3.1.1
rlm_ldap: sambaNtPassword -> NT-Password == 
0x4535314146423843313739373146344444423839444130303942363842343935
rlm_ldap: sambaLmPassword -> LM-Password == 
0x3343303836453237453535453532313436313534443245314442334242343439
rlm_ldap: radiusCallingStationId -> Calling-Station-Id == "00-1A-70-AE-D4-53"
rlm_ldap: radiusCalledStationId -> Called-Station-Id 
== "00-18-4D-76-22-19:Debian-AP"
[ldap] looking for reply items in directory...
rlm_ldap: radiusIdleTimeout -> Idle-Timeout = 25
rlm_ldap: radiusSessionTimeout -> Session-Timeout = 25
rlm_ldap: radiusFramedMTU -> Framed-MTU = 1234
rlm_ldap: radiusFramedRouting -> Framed-Routing = None
rlm_ldap: radiusFramedIPNetmask -> Framed-IP-Netmask = 255.255.255.0
rlm_ldap: radiusFramedIPAddress -> Framed-IP-Address = 10.3.1.252
rlm_ldap: radiusFramedProtocol -> Framed-Protocol = PPP
rlm_ldap: radiusServiceType -> Service-Type = Framed-User
WARNING: No "known good" password was found in LDAP.  Are you sure that the 
user is configured correctly?
[ldap] user bea authorized to use remote access
rlm_ldap: ldap_release_conn: Release Id: 0
++[ldap] returns ok
rlm_checkval: Item Name: Calling-Station-Id, Value: 00-1A-70-AE-D4-53
rlm_checkval: Value Name: Calling-Station-Id, Value: 00-1A-70-AE-D4-53
++[checkval] returns ok
++[expiration] returns noop
++[logintime] returns noop
[pap] Normalizing NT-Password from hex encoding
[pap] Normalizing LM-Password from hex encoding
[pap] Found existing Auth-Type, not changing it.
++[pap] returns noop
Found Auth-Type = EAP
+- entering group authenticate {...}
[eap] Request found, released from the list
[eap] EAP NAK
[eap] EAP-NAK asked for EAP-Type/peap
[eap] processing type tls
[tls] Initiate
[tls] Start returned 1
++[eap] returns handled
Sending Access-Challenge of id 2 to 10.1.1.254 port 32781
        Idle-Timeout = 25
        Session-Timeout = 25
        Framed-MTU = 1234
        Framed-Routing = None
        Framed-IP-Netmask = 255.255.255.0
        Framed-IP-Address = 10.3.1.252
        Framed-Protocol = PPP
        Service-Type = Framed-User
        EAP-Message = 0x010300061920
        Message-Authenticator = 0x00000000000000000000000000000000
        State = 0xd0c9e9b2d1caf0858c934a168f6818f8
Finished request 1.
Going to the next request
Waking up in 4.9 seconds.
rad_recv: Access-Request packet from host 10.1.1.254 port 32781, id=3, 
length=256
        User-Name = "bea"
        NAS-IP-Address = 10.3.1.1
        NAS-Identifier = "private-network-1"
        NAS-Port = 0
        Called-Station-Id = "00-18-4D-76-22-19:Debian-AP"
        Calling-Station-Id = "00-1A-70-AE-D4-53"
        Framed-MTU = 1400
        NAS-Port-Type = Wireless-802.11
        Connect-Info = "CONNECT 0Mbps 802.11"
        EAP-Message = 
0x0203005019800000004616030100410100003d03014906dfa3a4617fb96e8ebce362cf5008a0b3c371d3f6091793c9d7e69ecdc77c00001600040005000a000900640062000300060013001200630100
        State = 0xd0c9e9b2d1caf0858c934a168f6818f8
        Message-Authenticator = 0x4dfdc9004843a90be1d32b0ee36898e5
+- entering group authorize {...}
++[preprocess] returns ok
++[chap] returns noop
++[mschap] returns noop
[suffix] No '@' in User-Name = "bea", looking up realm NULL
[suffix] No such realm "NULL"
++[suffix] returns noop
[eap] EAP packet type response id 3 length 80
[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 70
[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 0041], ClientHello
[peap]     TLS_accept: SSLv3 read client hello A
[peap] >>> TLS 1.0 Handshake [length 002a], ServerHello
[peap]     TLS_accept: SSLv3 write server hello A
[peap] >>> TLS 1.0 Handshake [length 085e], 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 3 to 10.1.1.254 port 32781
        EAP-Message = 
0x0104040019c00000089b160301002a0200002603014906dfa8917d11f6f9786f74040df7e83714ff37f7520a371f3e9c280e66e88f00000400160301085e0b00085a0008570003a6308203a23082028aa003020102020101300d06092a864886f70d0101040500308193310b3009060355040613024652310f300d060355040813065261646975733112301006035504071309536f6d65776865726531153013060355040a130c4578616d706c6520496e632e3120301e06092a864886f70d010901161161646d696e406578616d706c652e636f6d312630240603550403131d4578616d706c6520436572746966696361746520417574686f72697479
        EAP-Message = 
0x301e170d3038313031373233313435375a170d3039313031373233313435375a307c310b3009060355040613024652310f300d0603550408130652616469757331153013060355040a130c4578616d706c6520496e632e312330210603550403131a4578616d706c65205365727665722043657274696669636174653120301e06092a864886f70d010901161161646d696e406578616d706c652e636f6d30820122300d06092a864886f70d01010105000382010f003082010a02820101009f1b18c9cbdd6c43edd5c23d9bc7cbf08e4ecaf0958c2825c3f23f0f493fe997dbaacf88b650125b655623e8197746c70bd522256e1f26af1c9f76b2ffd0
        EAP-Message = 
0xac11d04d3064e74828c85a73d1e70c26aa02b32204e4c2b5add407a6201cbb39b495751b17fc4341b2526f320a934a253376c9bbfab5f60089929ab11ed86fd57228a74b86512cc16d3ed19ffb282f5a254da1db5b24c0da5793ff6c6f9884f84288384280d53fa54b0e1a73cc024ca6db3649bc1817663a4508182ea67ebbbf5c7792e36d34445304bef55262585a23f502fc281e01b52d270253fbe0221492718c1fde74d7adebf536a35629422b1884b3448876a0d8887a90099f1db640abd0130203010001a317301530130603551d25040c300a06082b06010505070301300d06092a864886f70d010104050003820101003775e0d7bde359a695
        EAP-Message = 
0xef93c07a4be731136e779626227ec39dfb3acf4a381c766356d44621e5a9c36ba076e4cfc3fc08dcea23761ff6b7db1a179340465b04c5cb611e481447dc6d1329b7f967b3929c349f5cb016c9ffb409dd02f99ef42beab089183344307c509697c0390309c6b3be484f0bd76b16aeb27cd62646174e3bb98759aae9a0aa5e8992484baebcfa65cde05c7c96645c6a7ac8ba558516042221eabe5a887d5265bec4c7ec4eecf9a4d03e4f75390170eb70547cf16da3cb144dd6166c97d710b6a1ffaae81e3df9aba9c320fcb84fee21eb4b7d93ed7a45ed5d51293e2899bb06a47bf4eb9ee9c6bb934a0e4f1809311885f4d2b1678a9d080004ab308204
        EAP-Message = 0xa73082038fa0030201020209
        Message-Authenticator = 0x00000000000000000000000000000000
        State = 0xd0c9e9b2d2cdf0858c934a168f6818f8
Finished request 2.
Going to the next request
Waking up in 4.9 seconds.
rad_recv: Access-Request packet from host 10.1.1.254 port 32781, id=4, 
length=182
        User-Name = "bea"
        NAS-IP-Address = 10.3.1.1
        NAS-Identifier = "private-network-1"
        NAS-Port = 0
        Called-Station-Id = "00-18-4D-76-22-19:Debian-AP"
        Calling-Station-Id = "00-1A-70-AE-D4-53"
        Framed-MTU = 1400
        NAS-Port-Type = Wireless-802.11
        Connect-Info = "CONNECT 0Mbps 802.11"
        EAP-Message = 0x020400061900
        State = 0xd0c9e9b2d2cdf0858c934a168f6818f8
        Message-Authenticator = 0xe3d97d4829be927ffcaa80df35362580
+- entering group authorize {...}
++[preprocess] returns ok
++[chap] returns noop
++[mschap] returns noop
[suffix] No '@' in User-Name = "bea", 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 4 to 10.1.1.254 port 32781
        EAP-Message = 
0x010503fc194000c6024c7a46240d47300d06092a864886f70d0101050500308193310b3009060355040613024652310f300d060355040813065261646975733112301006035504071309536f6d65776865726531153013060355040a130c4578616d706c6520496e632e3120301e06092a864886f70d010901161161646d696e406578616d706c652e636f6d312630240603550403131d4578616d706c6520436572746966696361746520417574686f72697479301e170d3038313031373233313435375a170d3038313131363233313435375a308193310b3009060355040613024652310f300d060355040813065261646975733112301006035504
        EAP-Message = 
0x071309536f6d65776865726531153013060355040a130c4578616d706c6520496e632e3120301e06092a864886f70d010901161161646d696e406578616d706c652e636f6d312630240603550403131d4578616d706c6520436572746966696361746520417574686f7269747930820122300d06092a864886f70d01010105000382010f003082010a0282010100c0a9ef38baefb57727d839c901e088fcdba33b4fefd5f5eaec71cd35863742130dba5c4970cd37264ad993c29ca1a3c252b15a41f5c86042372ef6a74fcd69a0311adaddc585a3d8a5133e35beb18bd8194fc0c976209a488cc6ba704de8e051b6d946d1e514f1aa9f2ae76c05e042
        EAP-Message = 
0x5abcc33cd5fa78c1966fd9afd541f1846421eb6b6cdc43fe60b3700db730019556b6e0598799627405476c33444a993bddc59d4f1cccf96dbe8c3633ad3b4dabe9fe4921813189cc03596006cb72d039561fab545db347b12728230297b86faf7642ea7ed4de9563a2c343fa6e0e0f852790975445d303019eb6b8f66c923b88efae4f00cbf6ac34683b9ae168371d56cd0203010001a381fb3081f8301d0603551d0e04160414d3f4feccb65b46ae12166f8bd6c64949d9205bd93081c80603551d230481c03081bd8014d3f4feccb65b46ae12166f8bd6c64949d9205bd9a18199a48196308193310b3009060355040613024652310f300d06035504
        EAP-Message = 
0x0813065261646975733112301006035504071309536f6d65776865726531153013060355040a130c4578616d706c6520496e632e3120301e06092a864886f70d010901161161646d696e406578616d706c652e636f6d312630240603550403131d4578616d706c6520436572746966696361746520417574686f72697479820900c6024c7a46240d47300c0603551d13040530030101ff300d06092a864886f70d01010505000382010100693a6b8540fafa70aeffe7e11e57dd68789f34d9fa6ac7fd311460f3d62c25253b01ab757b83a9e1bcd16477b6a547b86917d4cd6345bcacf14a66f14cb3a24cf5a2e8e47d01bf751be8c05e1c66b84fc241
        EAP-Message = 0xee005d4044257cbc
        Message-Authenticator = 0x00000000000000000000000000000000
        State = 0xd0c9e9b2d3ccf0858c934a168f6818f8
Finished request 3.
Going to the next request
Waking up in 4.8 seconds.
rad_recv: Access-Request packet from host 10.1.1.254 port 32781, id=5, 
length=182
        User-Name = "bea"
        NAS-IP-Address = 10.3.1.1
        NAS-Identifier = "private-network-1"
        NAS-Port = 0
        Called-Station-Id = "00-18-4D-76-22-19:Debian-AP"
        Calling-Station-Id = "00-1A-70-AE-D4-53"
        Framed-MTU = 1400
        NAS-Port-Type = Wireless-802.11
        Connect-Info = "CONNECT 0Mbps 802.11"
        EAP-Message = 0x020500061900
        State = 0xd0c9e9b2d3ccf0858c934a168f6818f8
        Message-Authenticator = 0x60f31492dec5e3a289886225166185a2
+- entering group authorize {...}
++[preprocess] returns ok
++[chap] returns noop
++[mschap] returns noop
[suffix] No '@' in User-Name = "bea", looking up realm NULL
[suffix] No such realm "NULL"
++[suffix] returns noop
[eap] EAP packet type response id 5 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 5 to 10.1.1.254 port 32781
        EAP-Message = 
0x010600b519002fad7322b52d4fb7af68752506cdf885a47d8e5f1596c0d1c7635b7a44f85bf165fa6cc9084f76850e9810865455f360203da137b472ca3b1b096ae099c63491fbcb2b6aee602d890359cc11b7531d1f1cf987f07272c22e90414c8b629e1cdcef86cf8c0e9ed50f526c6115f5512d29a9494e2af8c7e21d08c30a97cfd75f8e7317e305aaeb48f02c791a837ffc21e5f8e3d158c1520a6fd0b6f442c50eb16374d25906da0416030100040e000000
        Message-Authenticator = 0x00000000000000000000000000000000
        State = 0xd0c9e9b2d4cff0858c934a168f6818f8
Finished request 4.
Going to the next request
Waking up in 4.8 seconds.
rad_recv: Access-Request packet from host 10.1.1.254 port 32781, id=6, 
length=498
        User-Name = "bea"
        NAS-IP-Address = 10.3.1.1
        NAS-Identifier = "private-network-1"
        NAS-Port = 0
        Called-Station-Id = "00-18-4D-76-22-19:Debian-AP"
        Calling-Station-Id = "00-1A-70-AE-D4-53"
        Framed-MTU = 1400
        NAS-Port-Type = Wireless-802.11
        Connect-Info = "CONNECT 0Mbps 802.11"
        EAP-Message = 
0x020601401980000001361603010106100001020100375234a497d6960d8ff753dfab2ae3beb2df67633830d3eb7ce55d8f898ff5547282879002207b3777957b6e4d3e886b9955d17f1adb6318081907aeddc9f51ca72d7d621d1779c1034406bf04b749862f44dcf2f6f2984eec60925c386459ba682cbfa4669fe9d11144ea854edc4107f87d499bc7f2a6dd2b4360b5e51183dca01bacd4c25a5d1c3f50765ac22fcc54f8ace3a9a853f457d05df628219e78b46e7ac8b7aa5f20a1efd18f5c091a37c89f9cc97049d4a04829028785c610854d34e5525d882b8dac515962e9df9ae5b04c3776a3fc509e397ea10a742a192c5f1126e27c4e198559
        EAP-Message = 
0x62ed6c6457eebf5017c0152637465d2eeadff264bc4217b51403010001011603010020346993e76e13274f447970c4e5283fc9476568d528f03dd7e68234b4da29d102
        State = 0xd0c9e9b2d4cff0858c934a168f6818f8
        Message-Authenticator = 0xc997adb792269d4da190c4a00cfc7515
+- entering group authorize {...}
++[preprocess] returns ok
++[chap] returns noop
++[mschap] returns noop
[suffix] No '@' in User-Name = "bea", looking up realm NULL
[suffix] No such realm "NULL"
++[suffix] returns noop
[eap] EAP packet type response id 6 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 310
[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 6 to 10.1.1.254 port 32781
        EAP-Message = 
0x0107003119001403010001011603010020777a87f2a0ea0ce6b3f408ce7228a640caf51efd86239a0af6c86eba663991fd
        Message-Authenticator = 0x00000000000000000000000000000000
        State = 0xd0c9e9b2d5cef0858c934a168f6818f8
Finished request 5.
Going to the next request
Waking up in 4.7 seconds.
rad_recv: Access-Request packet from host 10.1.1.254 port 32781, id=7, 
length=182
        User-Name = "bea"
        NAS-IP-Address = 10.3.1.1
        NAS-Identifier = "private-network-1"
        NAS-Port = 0
        Called-Station-Id = "00-18-4D-76-22-19:Debian-AP"
        Calling-Station-Id = "00-1A-70-AE-D4-53"
        Framed-MTU = 1400
        NAS-Port-Type = Wireless-802.11
        Connect-Info = "CONNECT 0Mbps 802.11"
        EAP-Message = 0x020700061900
        State = 0xd0c9e9b2d5cef0858c934a168f6818f8
        Message-Authenticator = 0xb624378d0a963604aa32cee78fa70e29
+- entering group authorize {...}
++[preprocess] returns ok
++[chap] returns noop
++[mschap] returns noop
[suffix] No '@' in User-Name = "bea", looking up realm NULL
[suffix] No such realm "NULL"
++[suffix] returns noop
[eap] EAP packet type response id 7 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 7 to 10.1.1.254 port 32781
        EAP-Message = 
0x01080020190017030100154dca55a5b1d4b6b7fb11babc1cda61f711bbd8e500
        Message-Authenticator = 0x00000000000000000000000000000000
        State = 0xd0c9e9b2d6c1f0858c934a168f6818f8
Finished request 6.
Going to the next request
Waking up in 4.6 seconds.
rad_recv: Access-Request packet from host 10.1.1.254 port 32781, id=8, 
length=207
        User-Name = "bea"
        NAS-IP-Address = 10.3.1.1
        NAS-Identifier = "private-network-1"
        NAS-Port = 0
        Called-Station-Id = "00-18-4D-76-22-19:Debian-AP"
        Calling-Station-Id = "00-1A-70-AE-D4-53"
        Framed-MTU = 1400
        NAS-Port-Type = Wireless-802.11
        Connect-Info = "CONNECT 0Mbps 802.11"
        EAP-Message = 
0x0208001f19001703010014cb6396a93cf1db318717cce9211291e3d2ce5c3f
        State = 0xd0c9e9b2d6c1f0858c934a168f6818f8
        Message-Authenticator = 0x3a89546410e1df60c0187b6278b0ed18
+- entering group authorize {...}
++[preprocess] returns ok
++[chap] returns noop
++[mschap] returns noop
[suffix] No '@' in User-Name = "bea", looking up realm NULL
[suffix] No such realm "NULL"
++[suffix] returns noop
[eap] EAP packet type response id 8 length 31
[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 - bea
[peap] Got tunnled request
        EAP-Message = 0x0208000801626561
server (null) {
  PEAP: Got tunneled identity of bea
  PEAP: Setting default EAP type for tunneled EAP session.
  PEAP: Setting User-Name to bea
Sending tunneled request
        EAP-Message = 0x0208000801626561
        FreeRADIUS-Proxied-To = 127.0.0.1
        User-Name = "bea"
server inner-tunnel {
+- entering group authorize {...}
++[chap] returns noop
++[mschap] returns noop
++[unix] returns updated
[suffix] No '@' in User-Name = "bea", looking up realm NULL
[suffix] No such realm "NULL"
++[suffix] returns noop
++[control] returns noop
[eap] EAP packet type response id 8 length 8
[eap] No EAP Start, assuming it's an on-going EAP conversation
++[eap] returns updated
++[files] returns noop
[ldap] performing user authorization for bea
WARNING: Deprecated conditional expansion ":-".  See "man unlang" for details
        expand: (&(uid=%{Stripped-User-Name:-%{User-Name}})
(dialupAccess=yes)) -> (&(uid=bea)(dialupAccess=yes))
        expand: dc=dom-sln,dc=local -> dc=dom-sln,dc=local
rlm_ldap: ldap_get_conn: Checking Id: 0
rlm_ldap: ldap_get_conn: Got Id: 0
rlm_ldap: performing search in dc=dom-sln,dc=local, with filter (&(uid=bea)
(dialupAccess=yes))
[ldap] checking if remote access for bea is allowed by dialupAccess
[ldap] looking for check items in directory...
rlm_ldap: radiusNASIpAddress -> NAS-IP-Address == 10.3.1.1
rlm_ldap: sambaNtPassword -> NT-Password == 
0x4535314146423843313739373146344444423839444130303942363842343935
rlm_ldap: sambaLmPassword -> LM-Password == 
0x3343303836453237453535453532313436313534443245314442334242343439
rlm_ldap: radiusCallingStationId -> Calling-Station-Id == "00-1A-70-AE-D4-53"
rlm_ldap: radiusCalledStationId -> Called-Station-Id 
== "00-18-4D-76-22-19:Debian-AP"
[ldap] looking for reply items in directory...
rlm_ldap: radiusIdleTimeout -> Idle-Timeout = 25
rlm_ldap: radiusSessionTimeout -> Session-Timeout = 25
rlm_ldap: radiusFramedMTU -> Framed-MTU = 1234
rlm_ldap: radiusFramedRouting -> Framed-Routing = None
rlm_ldap: radiusFramedIPNetmask -> Framed-IP-Netmask = 255.255.255.0
rlm_ldap: radiusFramedIPAddress -> Framed-IP-Address = 10.3.1.252
rlm_ldap: radiusFramedProtocol -> Framed-Protocol = PPP
rlm_ldap: radiusServiceType -> Service-Type = Framed-User
WARNING: No "known good" password was found in LDAP.  Are you sure that the 
user is configured correctly?
[ldap] user bea authorized to use remote access
rlm_ldap: ldap_release_conn: Release Id: 0
++[ldap] returns ok
        expand: %{User-Name} -> bea
[sql] sql_set_user escaped user --> 'bea'
rlm_sql (sql): Reserving sql socket id: 4
        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 = 'bea'           ORDER BY id
rlm_sql_mysql: query:  SELECT id, username, attribute, value, op           
FROM radcheck           WHERE username = 'bea'           ORDER BY id
        expand: SELECT groupname           FROM radusergroup           WHERE 
username = '%{SQL-User-Name}'           ORDER BY priority -> SELECT groupname           
FROM radusergroup           WHERE username = 'bea'           ORDER BY 
priority
rlm_sql_mysql: query:  SELECT groupname           FROM radusergroup           
WHERE username = 'bea'           ORDER BY priority
rlm_sql (sql): Released sql socket id: 4
[sql] User bea not found
++[sql] returns notfound
rlm_checkval: Could not find item named Calling-Station-Id in request
++[checkval] returns notfound
++[expiration] returns noop
++[logintime] returns noop
[pap] Normalizing NT-Password from hex encoding
[pap] Normalizing LM-Password from hex encoding
[pap] Found existing Auth-Type, not changing it.
++[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
        Idle-Timeout = 25
        Session-Timeout = 25
        Framed-MTU = 1234
        Framed-Routing = None
        Framed-IP-Netmask = 255.255.255.0
        Framed-IP-Address = 10.3.1.252
        Framed-Protocol = PPP
        Service-Type = Framed-User
        EAP-Message = 
0x0109001d1a010900181066b04d1dc4de928fc4bc24c467af69d5626561
        Message-Authenticator = 0x00000000000000000000000000000000
        State = 0x292c110629250b10a9fc612803547e19
[peap] Got tunneled reply RADIUS code 11
        Idle-Timeout = 25
        Session-Timeout = 25
        Framed-MTU = 1234
        Framed-Routing = None
        Framed-IP-Netmask = 255.255.255.0
        Framed-IP-Address = 10.3.1.252
        Framed-Protocol = PPP
        Service-Type = Framed-User
        EAP-Message = 
0x0109001d1a010900181066b04d1dc4de928fc4bc24c467af69d5626561
        Message-Authenticator = 0x00000000000000000000000000000000
        State = 0x292c110629250b10a9fc612803547e19
[peap] Got tunneled Access-Challenge
++[eap] returns handled
Sending Access-Challenge of id 8 to 10.1.1.254 port 32781
        EAP-Message = 
0x01090034190017030100293cf5bc57969690c34a292dd65e95fa6515b405544a258c4aad1b3087afb28f0c2e6c6ad3dfc05a216b
        Message-Authenticator = 0x00000000000000000000000000000000
        State = 0xd0c9e9b2d7c0f0858c934a168f6818f8
Finished request 7.
Going to the next request
Waking up in 4.5 seconds.
rad_recv: Access-Request packet from host 10.1.1.254 port 32781, id=9, 
length=261
        User-Name = "bea"
        NAS-IP-Address = 10.3.1.1
        NAS-Identifier = "private-network-1"
        NAS-Port = 0
        Called-Station-Id = "00-18-4D-76-22-19:Debian-AP"
        Calling-Station-Id = "00-1A-70-AE-D4-53"
        Framed-MTU = 1400
        NAS-Port-Type = Wireless-802.11
        Connect-Info = "CONNECT 0Mbps 802.11"
        EAP-Message = 
0x020900551900170301004a2b12ebf5926073e001804518d01dbd30dbd49e861a7038ad577ddaae4c2af902490a8f5d58cbe47a087550a8258fa2b931ef5eb873861e69f380c792f6262355b53a0c1424ce2985607a
        State = 0xd0c9e9b2d7c0f0858c934a168f6818f8
        Message-Authenticator = 0x155fd175df80a2c0c385a5f29b4daec1
+- entering group authorize {...}
++[preprocess] returns ok
++[chap] returns noop
++[mschap] returns noop
[suffix] No '@' in User-Name = "bea", looking up realm NULL
[suffix] No such realm "NULL"
++[suffix] returns noop
[eap] EAP packet type response id 9 length 85
[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 tunnled request
        EAP-Message = 
0x0209003e1a020900393173ec28908a73eccf5829f6e80ee55abc000000000000000041a4b7ca6e0f4a8567ee07c6499c6baba6014cb59c2294ae00626561
server (null) {
  PEAP: Setting User-Name to bea
Sending tunneled request
        EAP-Message = 
0x0209003e1a020900393173ec28908a73eccf5829f6e80ee55abc000000000000000041a4b7ca6e0f4a8567ee07c6499c6baba6014cb59c2294ae00626561
        FreeRADIUS-Proxied-To = 127.0.0.1
        User-Name = "bea"
        State = 0x292c110629250b10a9fc612803547e19
server inner-tunnel {
+- entering group authorize {...}
++[chap] returns noop
++[mschap] returns noop
++[unix] returns updated
[suffix] No '@' in User-Name = "bea", looking up realm NULL
[suffix] No such realm "NULL"
++[suffix] returns noop
++[control] returns noop
[eap] EAP packet type response id 9 length 62
[eap] No EAP Start, assuming it's an on-going EAP conversation
++[eap] returns updated
++[files] returns noop
[ldap] performing user authorization for bea
WARNING: Deprecated conditional expansion ":-".  See "man unlang" for details
        expand: (&(uid=%{Stripped-User-Name:-%{User-Name}})
(dialupAccess=yes)) -> (&(uid=bea)(dialupAccess=yes))
        expand: dc=dom-sln,dc=local -> dc=dom-sln,dc=local
rlm_ldap: ldap_get_conn: Checking Id: 0
rlm_ldap: ldap_get_conn: Got Id: 0
rlm_ldap: performing search in dc=dom-sln,dc=local, with filter (&(uid=bea)
(dialupAccess=yes))
[ldap] checking if remote access for bea is allowed by dialupAccess
[ldap] looking for check items in directory...
rlm_ldap: radiusNASIpAddress -> NAS-IP-Address == 10.3.1.1
rlm_ldap: sambaNtPassword -> NT-Password == 
0x4535314146423843313739373146344444423839444130303942363842343935
rlm_ldap: sambaLmPassword -> LM-Password == 
0x3343303836453237453535453532313436313534443245314442334242343439
rlm_ldap: radiusCallingStationId -> Calling-Station-Id == "00-1A-70-AE-D4-53"
rlm_ldap: radiusCalledStationId -> Called-Station-Id 
== "00-18-4D-76-22-19:Debian-AP"
[ldap] looking for reply items in directory...
rlm_ldap: radiusIdleTimeout -> Idle-Timeout = 25
rlm_ldap: radiusSessionTimeout -> Session-Timeout = 25
rlm_ldap: radiusFramedMTU -> Framed-MTU = 1234
rlm_ldap: radiusFramedRouting -> Framed-Routing = None
rlm_ldap: radiusFramedIPNetmask -> Framed-IP-Netmask = 255.255.255.0
rlm_ldap: radiusFramedIPAddress -> Framed-IP-Address = 10.3.1.252
rlm_ldap: radiusFramedProtocol -> Framed-Protocol = PPP
rlm_ldap: radiusServiceType -> Service-Type = Framed-User
WARNING: No "known good" password was found in LDAP.  Are you sure that the 
user is configured correctly?
[ldap] user bea authorized to use remote access
rlm_ldap: ldap_release_conn: Release Id: 0
++[ldap] returns ok
        expand: %{User-Name} -> bea
[sql] sql_set_user escaped user --> 'bea'
rlm_sql (sql): Reserving sql socket id: 3
        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 = 'bea'           ORDER BY id
rlm_sql_mysql: query:  SELECT id, username, attribute, value, op           
FROM radcheck           WHERE username = 'bea'           ORDER BY id
        expand: SELECT groupname           FROM radusergroup           WHERE 
username = '%{SQL-User-Name}'           ORDER BY priority -> SELECT groupname           
FROM radusergroup           WHERE username = 'bea'           ORDER BY 
priority
rlm_sql_mysql: query:  SELECT groupname           FROM radusergroup           
WHERE username = 'bea'           ORDER BY priority
rlm_sql (sql): Released sql socket id: 3
[sql] User bea not found
++[sql] returns notfound
rlm_checkval: Could not find item named Calling-Station-Id in request
++[checkval] returns notfound
++[expiration] returns noop
++[logintime] returns noop
[pap] Normalizing NT-Password from hex encoding
[pap] Normalizing LM-Password from hex encoding
[pap] Found existing Auth-Type, not changing it.
++[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] +- entering group MS-CHAP {...}
[mschap] Found LM-Password
[mschap] Found NT-Password
[mschap] Told to do MS-CHAPv2 for bea with NT-Password
[mschap] adding MS-CHAPv2 MPPE keys
++[mschap] returns ok
MSCHAP Success
++[eap] returns handled
} # server inner-tunnel
[peap] Got tunneled reply code 11
        Idle-Timeout = 25
        Session-Timeout = 25
        Framed-MTU = 1234
        Framed-Routing = None
        Framed-IP-Netmask = 255.255.255.0
        Framed-IP-Address = 10.3.1.252
        Framed-Protocol = PPP
        Service-Type = Framed-User
        EAP-Message = 
0x010a00331a0309002e533d33354339434638354233363344453436453242383831333038443130423830384530383737443645
        Message-Authenticator = 0x00000000000000000000000000000000
        State = 0x292c110628260b10a9fc612803547e19
[peap] Got tunneled reply RADIUS code 11
        Idle-Timeout = 25
        Session-Timeout = 25
        Framed-MTU = 1234
        Framed-Routing = None
        Framed-IP-Netmask = 255.255.255.0
        Framed-IP-Address = 10.3.1.252
        Framed-Protocol = PPP
        Service-Type = Framed-User
        EAP-Message = 
0x010a00331a0309002e533d33354339434638354233363344453436453242383831333038443130423830384530383737443645
        Message-Authenticator = 0x00000000000000000000000000000000
        State = 0x292c110628260b10a9fc612803547e19
[peap] Got tunneled Access-Challenge
++[eap] returns handled
Sending Access-Challenge of id 9 to 10.1.1.254 port 32781
        EAP-Message = 
0x010a004a1900170301003f0b72389f0d24fc51e45af62d845aed8cb0a560f4214333813e767673c5a78acb7537a0af435d53248999c06496b4de8f2b268a62683d219796c212b17d59dc
        Message-Authenticator = 0x00000000000000000000000000000000
        State = 0xd0c9e9b2d8c3f0858c934a168f6818f8
Finished request 8.
Going to the next request
Waking up in 4.5 seconds.
rad_recv: Access-Request packet from host 10.1.1.254 port 32781, id=10, 
length=205
        User-Name = "bea"
        NAS-IP-Address = 10.3.1.1
        NAS-Identifier = "private-network-1"
        NAS-Port = 0
        Called-Station-Id = "00-18-4D-76-22-19:Debian-AP"
        Calling-Station-Id = "00-1A-70-AE-D4-53"
        Framed-MTU = 1400
        NAS-Port-Type = Wireless-802.11
        Connect-Info = "CONNECT 0Mbps 802.11"
        EAP-Message = 
0x020a001d19001703010012e85a8a48fde3135620f7e7a23b11ba0b9eff
        State = 0xd0c9e9b2d8c3f0858c934a168f6818f8
        Message-Authenticator = 0x1f33fe96c0a432621a03ce6fcfeef689
+- entering group authorize {...}
++[preprocess] returns ok
++[chap] returns noop
++[mschap] returns noop
[suffix] No '@' in User-Name = "bea", looking up realm NULL
[suffix] No such realm "NULL"
++[suffix] returns noop
[eap] EAP packet type response id 10 length 29
[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 tunnled request
        EAP-Message = 0x020a00061a03
server (null) {
  PEAP: Setting User-Name to bea
Sending tunneled request
        EAP-Message = 0x020a00061a03
        FreeRADIUS-Proxied-To = 127.0.0.1
        User-Name = "bea"
        State = 0x292c110628260b10a9fc612803547e19
server inner-tunnel {
+- entering group authorize {...}
++[chap] returns noop
++[mschap] returns noop
++[unix] returns updated
[suffix] No '@' in User-Name = "bea", looking up realm NULL
[suffix] No such realm "NULL"
++[suffix] returns noop
++[control] returns noop
[eap] EAP packet type response id 10 length 6
[eap] No EAP Start, assuming it's an on-going EAP conversation
++[eap] returns updated
++[files] returns noop
[ldap] performing user authorization for bea
WARNING: Deprecated conditional expansion ":-".  See "man unlang" for details
        expand: (&(uid=%{Stripped-User-Name:-%{User-Name}})
(dialupAccess=yes)) -> (&(uid=bea)(dialupAccess=yes))
        expand: dc=dom-sln,dc=local -> dc=dom-sln,dc=local
rlm_ldap: ldap_get_conn: Checking Id: 0
rlm_ldap: ldap_get_conn: Got Id: 0
rlm_ldap: performing search in dc=dom-sln,dc=local, with filter (&(uid=bea)
(dialupAccess=yes))
[ldap] checking if remote access for bea is allowed by dialupAccess
[ldap] looking for check items in directory...
rlm_ldap: radiusNASIpAddress -> NAS-IP-Address == 10.3.1.1
rlm_ldap: sambaNtPassword -> NT-Password == 
0x4535314146423843313739373146344444423839444130303942363842343935
rlm_ldap: sambaLmPassword -> LM-Password == 
0x3343303836453237453535453532313436313534443245314442334242343439
rlm_ldap: radiusCallingStationId -> Calling-Station-Id == "00-1A-70-AE-D4-53"
rlm_ldap: radiusCalledStationId -> Called-Station-Id 
== "00-18-4D-76-22-19:Debian-AP"
[ldap] looking for reply items in directory...
rlm_ldap: radiusIdleTimeout -> Idle-Timeout = 25
rlm_ldap: radiusSessionTimeout -> Session-Timeout = 25
rlm_ldap: radiusFramedMTU -> Framed-MTU = 1234
rlm_ldap: radiusFramedRouting -> Framed-Routing = None
rlm_ldap: radiusFramedIPNetmask -> Framed-IP-Netmask = 255.255.255.0
rlm_ldap: radiusFramedIPAddress -> Framed-IP-Address = 10.3.1.252
rlm_ldap: radiusFramedProtocol -> Framed-Protocol = PPP
rlm_ldap: radiusServiceType -> Service-Type = Framed-User
WARNING: No "known good" password was found in LDAP.  Are you sure that the 
user is configured correctly?
[ldap] user bea authorized to use remote access
rlm_ldap: ldap_release_conn: Release Id: 0
++[ldap] returns ok
        expand: %{User-Name} -> bea
[sql] sql_set_user escaped user --> 'bea'
rlm_sql (sql): Reserving sql socket id: 2
        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 = 'bea'           ORDER BY id
rlm_sql_mysql: query:  SELECT id, username, attribute, value, op           
FROM radcheck           WHERE username = 'bea'           ORDER BY id
        expand: SELECT groupname           FROM radusergroup           WHERE 
username = '%{SQL-User-Name}'           ORDER BY priority -> SELECT groupname           
FROM radusergroup           WHERE username = 'bea'           ORDER BY 
priority
rlm_sql_mysql: query:  SELECT groupname           FROM radusergroup           
WHERE username = 'bea'           ORDER BY priority
rlm_sql (sql): Released sql socket id: 2
[sql] User bea not found
++[sql] returns notfound
rlm_checkval: Could not find item named Calling-Station-Id in request
++[checkval] returns notfound
++[expiration] returns noop
++[logintime] returns noop
[pap] Normalizing NT-Password from hex encoding
[pap] Normalizing LM-Password from hex encoding
[pap] Found existing Auth-Type, not changing it.
++[pap] returns noop
Found Auth-Type = EAP
+- entering group authenticate {...}
[eap] Request found, released from the list
[eap] EAP/mschapv2
[eap] processing type mschapv2
[eap] Freeing handler
++[eap] returns ok
+- entering group post-auth {...}

expand: /usr/var/log/radius/radacct/%{Client-IP-Address}/reply-detail-%Y%m%d -> /usr/var/log/radius/radacct/10.1.1.254/reply-detail-20081028
[reply_log] /usr/var/log/radius/radacct/%{Client-IP-Address}/reply-detail-%Y%m%d 
expands to /usr/var/log/radius/radacct/10.1.1.254/reply-detail-20081028
        expand: %t -> Tue Oct 28 10:47:21 2008
++[reply_log] returns ok
        expand: %{User-Name} -> bea
[sql] sql_set_user escaped user --> 'bea'
        expand: %{User-Password} ->
        expand: %{Chap-Password} ->
        expand: INSERT INTO radpostauth                           (username, 
pass, reply, authdate)                           VALUES 
(                           '%{User-Name}',                           '%{%{User-Password}:-%{Chap-Password}}',                           '%{reply:Packet-Type}', '%S') -> 
INSERT INTO radpostauth                           (username, pass, reply, 
authdate)                           VALUES 
(                           'bea',                           '',                           'Access-Accept', '2008-10-28 
10:47:21')

expand: /usr/var/log/radius/sqltrace.sql -> /usr/var/log/radius/sqltrace.sql
rlm_sql (sql) in sql_postauth: query is INSERT INTO radpostauth                           
(username, pass, reply, authdate)                           VALUES 
(                           'bea',                           '',                           'Access-Accept', '2008-10-28 
10:47:21')
rlm_sql (sql): Reserving sql socket id: 1
rlm_sql_mysql: query:  INSERT INTO radpostauth                           
(username, pass, reply, authdate)                           VALUES 
(                           'bea',                           '',                           'Access-Accept', '2008-10-28 
10:47:21')
rlm_sql (sql): Released sql socket id: 1
++[sql] returns ok
[sql_log] Processing sql_log_postauth
        expand: %{User-Name} -> bea
        expand: %{%{User-Name}:-DEFAULT} -> bea
[sql_log] sql_set_user escaped user --> 'bea'
WARNING: Deprecated conditional expansion ":-".  See "man unlang" for details
        expand: INSERT INTO radpostauth                          (username, 
pass, reply, authdate) VALUES                        
('%{User-Name}', '%{User-Password:-Chap-Password}',                '%{reply:Packet-Type}', '%S'); -> 
INSERT INTO radpostauth                       (username, pass, reply, 
authdate) VALUES                           
('bea', 'Chap-Password',                'Access-Accept', '2008-10-28 
10:47:21');

expand: /usr/var/log/radius/radacct/sql-relay -> /usr/var/log/radius/radacct/sql-relay
++[sql_log] returns ok
} # server inner-tunnel
[peap] Got tunneled reply code 2
        Idle-Timeout = 25
        Session-Timeout = 25
        Framed-MTU = 1234
        Framed-Routing = None
        Framed-IP-Netmask = 255.255.255.0
        Framed-IP-Address = 10.3.1.252
        Framed-Protocol = PPP
        Service-Type = Framed-User
        EAP-Message = 0x030a0004
        Message-Authenticator = 0x00000000000000000000000000000000
        User-Name = "bea"
[peap] Got tunneled reply RADIUS code 2
        Idle-Timeout = 25
        Session-Timeout = 25
        Framed-MTU = 1234
        Framed-Routing = None
        Framed-IP-Netmask = 255.255.255.0
        Framed-IP-Address = 10.3.1.252
        Framed-Protocol = PPP
        Service-Type = Framed-User
        EAP-Message = 0x030a0004
        Message-Authenticator = 0x00000000000000000000000000000000
        User-Name = "bea"
[peap] Tunneled authentication was successful.
[peap] SUCCESS
++[eap] returns handled
Sending Access-Challenge of id 10 to 10.1.1.254 port 32781
        EAP-Message = 
0x010b00261900170301001b29ddda2b04ad25b7f66ecf4b43e9b255fdff6db7d6c062de85c742
        Message-Authenticator = 0x00000000000000000000000000000000
        State = 0xd0c9e9b2d9c2f0858c934a168f6818f8
Finished request 9.
Going to the next request
Waking up in 4.4 seconds.
rad_recv: Access-Request packet from host 10.1.1.254 port 32781, id=11, 
length=214
        User-Name = "bea"
        NAS-IP-Address = 10.3.1.1
        NAS-Identifier = "private-network-1"
        NAS-Port = 0
        Called-Station-Id = "00-18-4D-76-22-19:Debian-AP"
        Calling-Station-Id = "00-1A-70-AE-D4-53"
        Framed-MTU = 1400
        NAS-Port-Type = Wireless-802.11
        Connect-Info = "CONNECT 0Mbps 802.11"
        EAP-Message = 
0x020b00261900170301001b8d43798e65bff4f8ade2b919a0eafdca90c414f811d09d5da0b85b
        State = 0xd0c9e9b2d9c2f0858c934a168f6818f8
        Message-Authenticator = 0xc997980f54e64969a7768480f84ff49a
+- entering group authorize {...}
++[preprocess] returns ok
++[chap] returns noop
++[mschap] returns noop
[suffix] No '@' in User-Name = "bea", looking up realm NULL
[suffix] No such realm "NULL"
++[suffix] returns noop
[eap] EAP packet type response id 11 length 38
[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] Success
[eap] Freeing handler
++[eap] returns ok
+- entering group post-auth {...}
++[exec] returns noop
Sending Access-Accept of id 11 to 10.1.1.254 port 32781
        MS-MPPE-Recv-Key = 
0xf7be958fe079a1ecafbd0276109901a31d417e2af41b7a051c08129ec714c2a1
        MS-MPPE-Send-Key = 
0xb8ea0eea0c85e504af3042326fd99847bee58c3841a445339d2c94be3df702ad
        EAP-Message = 0x030b0004
        Message-Authenticator = 0x00000000000000000000000000000000
        User-Name = "bea"
Finished request 10.
Going to the next request

Passwords are reals, but it's not a product, so !

I saw that :
rad_recv: Accounting-Request packet from host 10.1.1.254 port 32782, id=14, 
length=199
Received Accounting-Request packet from 10.1.1.254 with invalid signature!  
(Shared secret is incorrect.) Dropping packet without response.
Going to the next request
Waking up in 0.9 seconds.
Cleaning up request 26 ID 14 with timestamp +300
Ready to process requests.

But when I search on web, i found that secrets are not the same... hum, yes 
but they are !
Or : 
http://www.mail-archive.com/freeradius-users@lists.cistron.nl/msg02421.html
Most interesting, but I have the lastest hostapd !
And if Hostap send bad request, I couldn't have data in radpostauth !?

Thank's

Re: Hostapd-0.5.5 and freeradius-server-2.1.1

lolo