Strip off the domain part from the User-Name

Thomas Wunder thomas.wunder at swt-bamberg.de
Fri Mar 25 10:39:19 CET 2011


On Thursday 24 March 2011 09:36:28 Phil Mayers wrote:
> Please post a full debug. It's not possible to find the real cause of 
> your problem from the snippet.
(see attachment)
> 
> I am guessing that you're attempting to modify the username; you can't 
> do that, EAP will complain (as you're seeing)
Yes, I've tried to modify the username (using a policy which I've invoked as the first item of my authorize blocks in inner-tunnel and default) but since I realized that this doesn't help either I don't do so any more (removed the policy).
By the way this was the policy which I have used:
        strip_off_domain{
                if( User-Name =~ /^(.*)\\(.*)/ ){
                        update request {
                                User-Name := "%{2}"
                        }
                }
        }

Apart from this, what can I do have rlm_mschap cope with the domain prefix?

Thanks in advance!
-------------- next part --------------
FreeRADIUS Version 2.1.10, for host x86_64-pc-linux-gnu, built on Nov 14 2010 at 21:12:30
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/freeradius/radiusd.conf
including configuration file /etc/freeradius/proxy.conf
including configuration file /etc/freeradius/clients.conf
including files in directory /etc/freeradius/modules/
including configuration file /etc/freeradius/modules/smbpasswd
including configuration file /etc/freeradius/modules/mac2vlan
including configuration file /etc/freeradius/modules/acct_unique
including configuration file /etc/freeradius/modules/mac2ip
including configuration file /etc/freeradius/modules/attr_filter
including configuration file /etc/freeradius/modules/files
including configuration file /etc/freeradius/modules/linelog
including configuration file /etc/freeradius/modules/pam
including configuration file /etc/freeradius/modules/cui
including configuration file /etc/freeradius/modules/perl
including configuration file /etc/freeradius/modules/sqlcounter_expire_on_login
including configuration file /etc/freeradius/modules/policy
including configuration file /etc/freeradius/modules/always
including configuration file /etc/freeradius/modules/etc_group
including configuration file /etc/freeradius/modules/inner-eap
including configuration file /etc/freeradius/modules/ippool
including configuration file /etc/freeradius/modules/digest
including configuration file /etc/freeradius/modules/detail
including configuration file /etc/freeradius/modules/ntlm_auth
including configuration file /etc/freeradius/modules/wimax
including configuration file /etc/freeradius/modules/detail.example.com
including configuration file /etc/freeradius/modules/mschap
including configuration file /etc/freeradius/modules/otp
including configuration file /etc/freeradius/modules/attr_rewrite
including configuration file /etc/freeradius/modules/detail.log
including configuration file /etc/freeradius/modules/krb5
including configuration file /etc/freeradius/modules/pap
including configuration file /etc/freeradius/modules/checkval
including configuration file /etc/freeradius/modules/expiration
including configuration file /etc/freeradius/modules/sql_log
including configuration file /etc/freeradius/modules/sradutmp
including configuration file /etc/freeradius/modules/ldap
including configuration file /etc/freeradius/modules/logintime
including configuration file /etc/freeradius/modules/echo
including configuration file /etc/freeradius/modules/realm
including configuration file /etc/freeradius/modules/chap
including configuration file /etc/freeradius/modules/passwd
including configuration file /etc/freeradius/modules/radutmp
including configuration file /etc/freeradius/modules/unix
including configuration file /etc/freeradius/modules/expr
including configuration file /etc/freeradius/modules/exec
including configuration file /etc/freeradius/modules/smsotp
including configuration file /etc/freeradius/modules/preprocess
including configuration file /etc/freeradius/modules/counter
including configuration file /etc/freeradius/eap.conf
including configuration file /etc/freeradius/policy.conf
including files in directory /etc/freeradius/sites-enabled/
including configuration file /etc/freeradius/sites-enabled/default
including configuration file /etc/freeradius/sites-enabled/inner-tunnel
main {
        user = "freerad"
        group = "freerad"
        allow_core_dumps = no
}
including dictionary file /etc/freeradius/dictionary
main {
        prefix = "/usr"
        localstatedir = "/var"
        logdir = "/var/log/freeradius"
        libdir = "/usr/lib/freeradius"
        radacctdir = "/var/log/freeradius/radacct"
        hostname_lookups = no
        max_request_time = 30
        cleanup_delay = 5
        max_requests = 1024
        pidfile = "/var/run/freeradius/freeradius.pid"
        checkrad = "/usr/sbin/checkrad"
        debug_level = 0
        proxy_requests = yes
 log {
        stripped_names = no
        auth = yes
        auth_badpass = no
        auth_goodpass = no
 }
 security {
        max_attributes = 200
        reject_delay = 1
        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
 }
 realm LOCAL {
 }
 realm testpc {
 }
radiusd: #### Loading Clients ####
 client localhost {
        ipaddr = 127.0.0.1
        require_message_authenticator = no
        secret = "testing123"
        nastype = "other"
 }
 client swtswitch01 {
        ipaddr = 141.13.106.126
        require_message_authenticator = no
        secret = "g4XpaVh4r78x"
        nastype = "other"
 }
 client ap-llab {
        ipaddr = 141.13.106.112
        require_message_authenticator = no
        secret = "a1pllabsecret234"
        nastype = "other"
 }
 client ap-slab {
        ipaddr = 141.13.106.113
        require_message_authenticator = no
        secret = "a2pslabsecret567"
        nastype = "other"
 }
 client vpn1 {
        ipaddr = 141.13.106.16
        require_message_authenticator = no
        secret = "jzghsbA78NwYNZRoVAR"
        nastype = "other"
 }
 client vpn2 {
        ipaddr = 141.13.106.142
        require_message_authenticator = no
        secret = "6Ri0XB0viFkP2KYMuux"
        nastype = "other"
 }
 client ddwrt {
        ipaddr = 141.13.106.77
        require_message_authenticator = no
        secret = "testing123"
        nastype = "other"
 }
radiusd: #### Instantiating modules ####
 instantiate {
 Module: Linked to module rlm_exec
 Module: Instantiating module "exec" from file /etc/freeradius/modules/exec
  exec {
        wait = no
        input_pairs = "request"
        shell_escape = yes
  }
 Module: Linked to module rlm_expr
 Module: Instantiating module "expr" from file /etc/freeradius/modules/expr
 Module: Linked to module rlm_expiration
 Module: Instantiating module "expiration" from file /etc/freeradius/modules/expiration
  expiration {
        reply-message = "Password Has Expired  "
  }
 Module: Linked to module rlm_logintime
 Module: Instantiating module "logintime" from file /etc/freeradius/modules/logintime
  logintime {
        reply-message = "You are calling outside your allowed timespan  "
        minimum-timeout = 60
  }
 }
radiusd: #### Loading Virtual Servers ####
server inner-tunnel { # from file /etc/freeradius/sites-enabled/inner-tunnel
 modules {
 Module: Checking authenticate {...} for more modules to load
 Module: Linked to module rlm_krb5
 Module: Instantiating module "krb5" from file /etc/freeradius/modules/krb5
  krb5 {
        keytab = "/etc/freeradius/freeradius.keytab"
        service_principal = "freeradius/radius1.staff.swt.wiai.uni-bamberg.de"
  }
rlm_krb5: krb5_init ok
 Module: Linked to module rlm_mschap
 Module: Instantiating module "mschap" from file /etc/freeradius/modules/mschap
  mschap {
        use_mppe = yes
        require_encryption = yes
        require_strong = yes
        with_ntdomain_hack = no
  }
 Module: Linked to module rlm_eap
 Module: Instantiating module "eap" from file /etc/freeradius/eap.conf
  eap {
        default_eap_type = "md5"
        timer_expire = 60
        ignore_unknown_eap_types = no
        cisco_accounting_username_bug = no
        max_sessions = 4096
  }
 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 = "/etc/freeradius/certs/server.key"
        certificate_file = "/etc/freeradius/certs/server.pem"
        CA_file = "/etc/freeradius/certs/ca.pem"
        private_key_password = "whatever"
        dh_file = "/etc/freeradius/certs/dh"
        random_file = "/etc/freeradius/certs/random"
        fragment_size = 1024
        include_length = yes
        check_crl = no
        cipher_list = "DEFAULT"
        make_cert_command = "/etc/freeradius/certs/bootstrap"
    cache {
        enable = yes
        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 = yes
        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_preprocess
 Module: Instantiating module "preprocess" from file /etc/freeradius/modules/preprocess
  preprocess {
        huntgroups = "/etc/freeradius/huntgroups"
        hints = "/etc/freeradius/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: Loading virtual module swt_policy
 Module: Loading virtual module prefer_kerberos
 Module: Loading virtual module prefer_kerberos
 Module: Loading virtual module prefer_kerberos
 Module: Loading virtual module prefer_kerberos
 Module: Loading virtual module prefer_kerberos
 Module: Loading virtual module prefer_kerberos
 Module: Linked to module rlm_always
 Module: Instantiating module "reject" from file /etc/freeradius/modules/always
  always reject {
        rcode = "reject"
        simulcount = 0
        mpp = no
  }
 Module: Linked to module rlm_ldap
 Module: Instantiating module "ldap" from file /etc/freeradius/modules/ldap
  ldap {
        server = "ldap-master.staff.swt.wiai.uni-bamberg.de"
        port = 389
        password = "ldappw"
        identity = "cn=ldapadmin,dc=uni-bamberg,dc=de"
        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 = "ou=swt,ou=wiai,dc=uni-bamberg,dc=de"
        filter = "(&(objectClass=posixAccount)(uid=%{mschap:User-Name:-%{User-Name}}))"
        base_filter = "(objectclass=radiusprofile)"
        auto_header = no
        access_attr_used_for_allow = yes
        groupname_attribute = "cn"
        groupmembership_filter = "(&(objectClass=posixGroup)(|(uid=%{mschap:User-Name:-%{User-Name}})(memberUid=%{mschap:User-Name:-%{User-Name}})))"
        groupmembership_attribute = "radiusGroupName"
        dictionary_mapping = "/etc/freeradius/ldap.attrmap"
        ldap_debug = 0
        ldap_connections_number = 5
        compare_check_items = no
        do_xlat = yes
        edir_account_policy_check = no
        set_auth_type = yes
  }
rlm_ldap: Registering ldap_groupcmp for Ldap-Group
rlm_ldap: Registering ldap_xlat with xlat_name ldap
rlm_ldap: Over-riding set_auth_type, as there is no module ldap listed in the "authenticate" section.
rlm_ldap: reading ldap<->radius mappings from file /etc/freeradius/ldap.attrmap
rlm_ldap: LDAP radiusCheckItem mapped to RADIUS $GENERIC$
rlm_ldap: LDAP radiusReplyItem mapped to RADIUS $GENERIC$
rlm_ldap: LDAP radiusCalledStationId mapped to RADIUS Called-Station-Id
rlm_ldap: LDAP sambaNtPassword mapped to RADIUS NT-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: 0x245b690
 Module: Checking session {...} for more modules to load
 Module: Linked to module rlm_radutmp
 Module: Instantiating module "radutmp" from file /etc/freeradius/modules/radutmp
  radutmp {
        filename = "/var/log/freeradius/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: Loading virtual module assign_vlan_policy
 Module: Linked to module rlm_attr_filter
 Module: Instantiating module "attr_filter.access_reject" from file /etc/freeradius/modules/attr_filter
  attr_filter attr_filter.access_reject {
        attrsfile = "/etc/freeradius/attrs.access_reject"
        key = "%{User-Name}"
  }
 } # modules
} # server
server { # from file /etc/freeradius/radiusd.conf
 modules {
 Module: Checking authenticate {...} for more modules to load
 Module: Checking authorize {...} for more modules to load
 Module: Loading virtual module swt_vpn_policy
 Module: Checking preacct {...} for more modules to load
 Module: Linked to module rlm_acct_unique
 Module: Instantiating module "acct_unique" from file /etc/freeradius/modules/acct_unique
  acct_unique {
        key = "User-Name, Acct-Session-Id, NAS-IP-Address, Client-IP-Address, NAS-Port"
  }
 Module: Linked to module rlm_realm
 Module: Instantiating module "suffix" from file /etc/freeradius/modules/realm
  realm suffix {
        format = "suffix"
        delimiter = "@"
        ignore_default = no
        ignore_null = no
  }
 Module: Linked to module rlm_files
 Module: Instantiating module "files" from file /etc/freeradius/modules/files
  files {
        usersfile = "/etc/freeradius/users"
        acctusersfile = "/etc/freeradius/acct_users"
        preproxy_usersfile = "/etc/freeradius/preproxy_users"
        compat = "no"
  }
 Module: Checking accounting {...} for more modules to load
 Module: Linked to module rlm_detail
 Module: Instantiating module "detail" from file /etc/freeradius/modules/detail
  detail {
        detailfile = "/var/log/freeradius/radacct/%{Client-IP-Address}/detail-%Y%m%d"
        header = "%t"
        detailperm = 384
        dirperm = 493
        locking = no
        log_packet_header = no
  }
 Module: Instantiating module "attr_filter.accounting_response" from file /etc/freeradius/modules/attr_filter
  attr_filter attr_filter.accounting_response {
        attrsfile = "/etc/freeradius/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
 Module: Loading virtual module assign_vlan_policy
 } # modules
} # server
radiusd: #### Opening IP addresses and Ports ####
listen {
        type = "auth"
        ipaddr = *
        port = 0
}
listen {
        type = "acct"
        ipaddr = *
        port = 0
}
Listening on authentication address * port 1812
Listening on accounting address * port 1813
Listening on proxy address * port 1814
Ready to process requests.














rad_recv: Access-Request packet from host 141.13.106.126 port 48647, id=104, length=341
        Framed-MTU = 1480
        NAS-IP-Address = 141.13.106.126
        NAS-Identifier = "swtprocurve01"
        User-Name = "testpc\\tom1"
        Service-Type = Framed-User
        Framed-Protocol = PPP
        NAS-Port = 31
        NAS-Port-Type = Ethernet
        NAS-Port-Id = "31"
        Called-Station-Id = "c0-91-34-c3-44-00"
        Calling-Station-Id = "00-19-99-0f-ff-dd"
        Connect-Info = "CONNECT Ethernet 1000Mbps Full duplex"
        Tunnel-Type:0 = VLAN
        Tunnel-Medium-Type:0 = IEEE-802
        Tunnel-Private-Group-Id:0 = "2049"
        EAP-Message = 0x02080010017465737470635c746f6d31
        Message-Authenticator = 0xa169b00d3fc73990064fa69aeb07fce8
        MS-RAS-Vendor = 11
        HP-Capability-Advert = 0x011a0000000b28
        HP-Capability-Advert = 0x011a0000000b2e
        HP-Capability-Advert = 0x011a0000000b30
        HP-Capability-Advert = 0x011a0000000b3d
        HP-Capability-Advert = 0x0138
        HP-Capability-Advert = 0x013a
        HP-Capability-Advert = 0x0140
        HP-Capability-Advert = 0x0141
        HP-Capability-Advert = 0x0151
# Executing section authorize from file /etc/freeradius/sites-enabled/default
+- entering group authorize {...}
[eap] EAP packet type response id 8 length 16
[eap] No EAP Start, assuming it's an on-going EAP conversation
++[eap] returns updated
++- entering policy swt_vpn_policy {...}
+++? if (Called-Station-Id == "vpn1" && LDAP-Group == "vpn-staff" )
? Evaluating (Called-Station-Id == "vpn1" ) -> FALSE
? Skipping (LDAP-Group == "vpn-staff" )
+++? if (Called-Station-Id == "vpn1" && LDAP-Group == "vpn-staff" ) -> FALSE
+++? elsif (Called-Station-Id == "vpn2" && LDAP-Group == "vpn-others" )
? Evaluating (Called-Station-Id == "vpn2" ) -> FALSE
? Skipping (LDAP-Group == "vpn-others" )
+++? elsif (Called-Station-Id == "vpn2" && LDAP-Group == "vpn-others" ) -> FALSE
++- policy swt_vpn_policy returns updated
[ldap] performing user authorization for testpc\tom1
[ldap]  expand: (&(objectClass=posixAccount)(uid=%{mschap:User-Name:-%{User-Name}})) -> (&(objectClass=posixAccount)(uid=tom1))
[ldap]  expand: ou=swt,ou=wiai,dc=uni-bamberg,dc=de -> ou=swt,ou=wiai,dc=uni-bamberg,dc=de
  [ldap] ldap_get_conn: Checking Id: 0
  [ldap] ldap_get_conn: Got Id: 0
  [ldap] attempting LDAP reconnection
  [ldap] (re)connect to ldap-master.staff.swt.wiai.uni-bamberg.de:389, authentication 0
  [ldap] bind as cn=ldapadmin,dc=uni-bamberg,dc=de/ldappw to ldap-master.staff.swt.wiai.uni-bamberg.de:389
  [ldap] waiting for bind result ...
  [ldap] Bind was successful
  [ldap] performing search in ou=swt,ou=wiai,dc=uni-bamberg,dc=de, with filter (&(objectClass=posixAccount)(uid=tom1))
[ldap] No default NMAS login sequence
[ldap] looking for check items in directory...
  [ldap] sambaNtPassword -> NT-Password == 0x3043423639343838303546373937424632413832383037393733423839353337
[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 testpc\tom1 authorized to use remote access
  [ldap] ldap_release_conn: Release Id: 0
++[ldap] returns ok
Found Auth-Type = EAP
# Executing group from file /etc/freeradius/sites-enabled/default
+- entering group authenticate {...}
[eap] EAP Identity
[eap] processing type md5
rlm_eap_md5: Issuing Challenge
++[eap] returns handled
Sending Access-Challenge of id 104 to 141.13.106.126 port 48647
        EAP-Message = 0x010900160410a086f7f9a0dfdd9e83b6a474beeaee04
        Message-Authenticator = 0x00000000000000000000000000000000
        State = 0xdaa802b3daa1068d059e5652a4713843
Finished request 0.
Going to the next request
Waking up in 4.9 seconds.
rad_recv: Access-Request packet from host 141.13.106.126 port 48647, id=105, length=349
        Framed-MTU = 1480
        NAS-IP-Address = 141.13.106.126
        NAS-Identifier = "swtprocurve01"
        User-Name = "testpc\\tom1"
        Service-Type = Framed-User
        Framed-Protocol = PPP
        NAS-Port = 31
        NAS-Port-Type = Ethernet
        NAS-Port-Id = "31"
        Called-Station-Id = "c0-91-34-c3-44-00"
        Calling-Station-Id = "00-19-99-0f-ff-dd"
        Connect-Info = "CONNECT Ethernet 1000Mbps Full duplex"
        Tunnel-Type:0 = VLAN
        Tunnel-Medium-Type:0 = IEEE-802
        Tunnel-Private-Group-Id:0 = "2049"
        State = 0xdaa802b3daa1068d059e5652a4713843
        EAP-Message = 0x020900060319
        Message-Authenticator = 0x9d5e0e43bed60fe4670ad274e853c061
        MS-RAS-Vendor = 11
        HP-Capability-Advert = 0x011a0000000b28
        HP-Capability-Advert = 0x011a0000000b2e
        HP-Capability-Advert = 0x011a0000000b30
        HP-Capability-Advert = 0x011a0000000b3d
        HP-Capability-Advert = 0x0138
        HP-Capability-Advert = 0x013a
        HP-Capability-Advert = 0x0140
        HP-Capability-Advert = 0x0141
        HP-Capability-Advert = 0x0151
# Executing section authorize from file /etc/freeradius/sites-enabled/default
+- entering group authorize {...}
[eap] EAP packet type response id 9 length 6
[eap] No EAP Start, assuming it's an on-going EAP conversation
++[eap] returns updated
++- entering policy swt_vpn_policy {...}
+++? if (Called-Station-Id == "vpn1" && LDAP-Group == "vpn-staff" )
? Evaluating (Called-Station-Id == "vpn1" ) -> FALSE
? Skipping (LDAP-Group == "vpn-staff" )
+++? if (Called-Station-Id == "vpn1" && LDAP-Group == "vpn-staff" ) -> FALSE
+++? elsif (Called-Station-Id == "vpn2" && LDAP-Group == "vpn-others" )
? Evaluating (Called-Station-Id == "vpn2" ) -> FALSE
? Skipping (LDAP-Group == "vpn-others" )
+++? elsif (Called-Station-Id == "vpn2" && LDAP-Group == "vpn-others" ) -> FALSE
++- policy swt_vpn_policy returns updated
[ldap] performing user authorization for testpc\tom1
[ldap]  expand: (&(objectClass=posixAccount)(uid=%{mschap:User-Name:-%{User-Name}})) -> (&(objectClass=posixAccount)(uid=tom1))
[ldap]  expand: ou=swt,ou=wiai,dc=uni-bamberg,dc=de -> ou=swt,ou=wiai,dc=uni-bamberg,dc=de
  [ldap] ldap_get_conn: Checking Id: 0
  [ldap] ldap_get_conn: Got Id: 0
  [ldap] performing search in ou=swt,ou=wiai,dc=uni-bamberg,dc=de, with filter (&(objectClass=posixAccount)(uid=tom1))
[ldap] No default NMAS login sequence
[ldap] looking for check items in directory...
  [ldap] sambaNtPassword -> NT-Password == 0x3043423639343838303546373937424632413832383037393733423839353337
[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 testpc\tom1 authorized to use remote access
  [ldap] ldap_release_conn: Release Id: 0
++[ldap] returns ok
Found Auth-Type = EAP
# Executing group from file /etc/freeradius/sites-enabled/default
+- 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] Flushing SSL sessions (of #0)
[tls] Initiate
[tls] Start returned 1
++[eap] returns handled
Sending Access-Challenge of id 105 to 141.13.106.126 port 48647
        EAP-Message = 0x010a00061920
        Message-Authenticator = 0x00000000000000000000000000000000
        State = 0xdaa802b3dba21b8d059e5652a4713843
Finished request 1.
Going to the next request
Waking up in 4.9 seconds.
rad_recv: Access-Request packet from host 141.13.106.126 port 48647, id=106, length=463
        Framed-MTU = 1480
        NAS-IP-Address = 141.13.106.126
        NAS-Identifier = "swtprocurve01"
        User-Name = "testpc\\tom1"
        Service-Type = Framed-User
        Framed-Protocol = PPP
        NAS-Port = 31
        NAS-Port-Type = Ethernet
        NAS-Port-Id = "31"
        Called-Station-Id = "c0-91-34-c3-44-00"
        Calling-Station-Id = "00-19-99-0f-ff-dd"
        Connect-Info = "CONNECT Ethernet 1000Mbps Full duplex"
        Tunnel-Type:0 = VLAN
        Tunnel-Medium-Type:0 = IEEE-802
        Tunnel-Private-Group-Id:0 = "2049"
        State = 0xdaa802b3dba21b8d059e5652a4713843
        EAP-Message = 0x020a007819800000006e16030100690100006503014d8c5f96b5445cd4d8dcc674e2d69089aa055b3e4348de490afd52a8ab01f79f000018002f00350005000ac013c014c009c00a00320038001300040100002400000010000e00000b7465737470635c746f6d31000a0006000400170018000b00020100
        Message-Authenticator = 0xe389988e3f6349b37abcecfd1becc9a3
        MS-RAS-Vendor = 11
        HP-Capability-Advert = 0x011a0000000b28
        HP-Capability-Advert = 0x011a0000000b2e
        HP-Capability-Advert = 0x011a0000000b30
        HP-Capability-Advert = 0x011a0000000b3d
        HP-Capability-Advert = 0x0138
        HP-Capability-Advert = 0x013a
        HP-Capability-Advert = 0x0140
        HP-Capability-Advert = 0x0141
        HP-Capability-Advert = 0x0151
# Executing section authorize from file /etc/freeradius/sites-enabled/default
+- entering group authorize {...}
[eap] EAP packet type response id 10 length 120
[eap] Continuing tunnel setup.
++[eap] returns ok
Found Auth-Type = EAP
# Executing group from file /etc/freeradius/sites-enabled/default
+- entering group authenticate {...}
[eap] Request found, released from the list
[eap] EAP/peap
[eap] processing type peap
[peap] processing EAP-TLS
  TLS Length 110
[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 0069], ClientHello  
[peap]     TLS_accept: SSLv3 read client hello A
[peap] >>> TLS 1.0 Handshake [length 004a], ServerHello  
[peap]     TLS_accept: SSLv3 write server hello A
[peap] >>> TLS 1.0 Handshake [length 08ae], 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 106 to 141.13.106.126 port 48647
        EAP-Message = 0x010b040019c00000090b160301004a0200004603014d8c5f9409042889a21400b533b02f5a1c9795ed0b6f9cfaf8751f1fac8fd421202aa0d61d25aaed0b041184b6a6287001bbc6167e744e969de2266452e706e8f4002f0016030108ae0b0008aa0008a70003d0308203cc308202b4a003020102020102300d06092a864886f70d010104050030819f310b3009060355040613024445310b30090603550408130242593110300e0603550407130742616d6265726731263024060355040a141d556e69766572736974c3a4742042616d62657267204c73742e205357543125302306092a864886f70d0109011616746563686e696b407377742d6261
        EAP-Message = 0x6d626572672e6465312230200603550403131953575420436572746966696361746520417574686f72697479301e170d3131303331303130343232305a170d3132303330393130343232305a308199310b3009060355040613024445310b300906035504081302425931263024060355040a141d556e69766572736974c3a4742042616d62657267204c73742e20535754312e302c06035504031325726164697573312e73746166662e7377742e776961692e756e692d62616d626572672e64653125302306092a864886f70d0109011616746563686e696b407377742d62616d626572672e646530820122300d06092a864886f70d01010105000382
        EAP-Message = 0x010f003082010a0282010100b5913179548416c13b821a05c1a61e0232aedcd87c864ca2017e4b9de05aa9122fbe2722f9e02540cbc19d0a81ec1d25362148b63420d93baad596f8684311e6b1ca5849a18e9ae333a937a28098a8d25d4674af4bbfdfabfcf4c08b12d0504675cca1e6e5373585adb1752a582a0e16ae194883f3228b90d605e187a1cb192d3804ec0c203fa4c8953d47e0ded1ed9480895df61e8fed91a7d0b120ab4867244897e424c64e6323e2345031daa86c2f5933385e1ab6c982bac61e02b9b17348a198f5491f44044f72148714e42a97228136d367a874f10c55a6596eb5c228a7506bec16e46a119e6b33b9ed03409bb302
        EAP-Message = 0x03cee744e061eee93ebf3e60778e2f0203010001a317301530130603551d25040c300a06082b06010505070301300d06092a864886f70d01010405000382010100929cda8af67a63249a16f030f3538382e3461133e34d2b3fe6602ffc5c02e8828a1b53bd751da80113a12f09d0d99049f5dd2e65ec6d5bd3b30f2bd5fda99a73837d0b7b50619e0000b2cea05141e2f7dd81ab4483d0d83cf06642f9d4e40de228ccdcfb563c731e2e388a08095d287bc492962b10b34d36d30057c20d21107b7124f277cd0b31fb3327aba00b24465627f6ba23973e584e5b03c23b17d04e10966f19e5b3bcc29021bf38021263e21b0a3b77ece61c8ffd26c679a4
        EAP-Message = 0x65d8d76f3eacc7d8a4fe4d43
        Message-Authenticator = 0x00000000000000000000000000000000
        State = 0xdaa802b3d8a31b8d059e5652a4713843
Finished request 2.
Going to the next request
Waking up in 4.9 seconds.
rad_recv: Access-Request packet from host 141.13.106.126 port 48647, id=107, length=349
        Framed-MTU = 1480
        NAS-IP-Address = 141.13.106.126
        NAS-Identifier = "swtprocurve01"
        User-Name = "testpc\\tom1"
        Service-Type = Framed-User
        Framed-Protocol = PPP
        NAS-Port = 31
        NAS-Port-Type = Ethernet
        NAS-Port-Id = "31"
        Called-Station-Id = "c0-91-34-c3-44-00"
        Calling-Station-Id = "00-19-99-0f-ff-dd"
        Connect-Info = "CONNECT Ethernet 1000Mbps Full duplex"
        Tunnel-Type:0 = VLAN
        Tunnel-Medium-Type:0 = IEEE-802
        Tunnel-Private-Group-Id:0 = "2049"
        State = 0xdaa802b3d8a31b8d059e5652a4713843
        EAP-Message = 0x020b00061900
        Message-Authenticator = 0x2a009296f6630cd8fd07d79586d92055
        MS-RAS-Vendor = 11
        HP-Capability-Advert = 0x011a0000000b28
        HP-Capability-Advert = 0x011a0000000b2e
        HP-Capability-Advert = 0x011a0000000b30
        HP-Capability-Advert = 0x011a0000000b3d
        HP-Capability-Advert = 0x0138
        HP-Capability-Advert = 0x013a
        HP-Capability-Advert = 0x0140
        HP-Capability-Advert = 0x0141
        HP-Capability-Advert = 0x0151
# Executing section authorize from file /etc/freeradius/sites-enabled/default
+- entering group authorize {...}
[eap] EAP packet type response id 11 length 6
[eap] Continuing tunnel setup.
++[eap] returns ok
Found Auth-Type = EAP
# Executing group from file /etc/freeradius/sites-enabled/default
+- 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 107 to 141.13.106.126 port 48647
        EAP-Message = 0x010c03fc1940198a1372c0bacd525b92a66b9a9ebd138287bff539e1fa97bd669e9bde23bab157c63aeb3543d38ab5566d7f7ee9c4c2d74cc3d3616f75260004d1308204cd308203b5a003020102020900d5b348c26db11232300d06092a864886f70d010105050030819f310b3009060355040613024445310b30090603550408130242593110300e0603550407130742616d6265726731263024060355040a141d556e69766572736974c3a4742042616d62657267204c73742e205357543125302306092a864886f70d0109011616746563686e696b407377742d62616d626572672e64653122302006035504031319535754204365727469666963
        EAP-Message = 0x61746520417574686f72697479301e170d3131303331303130333831355a170d3132303330393130333831355a30819f310b3009060355040613024445310b30090603550408130242593110300e0603550407130742616d6265726731263024060355040a141d556e69766572736974c3a4742042616d62657267204c73742e205357543125302306092a864886f70d0109011616746563686e696b407377742d62616d626572672e6465312230200603550403131953575420436572746966696361746520417574686f7269747930820122300d06092a864886f70d01010105000382010f003082010a0282010100c5746be6f2647175720513f4a5
        EAP-Message = 0x97e60a73d937370b712b23d6ff80ceb6adaa69e231bc9a9c8d4133ef87df85ee362759beb15056ae6d38c5ba74d10a4dfb94cfe3ea3fd6e2c570b61a41abe4ff6a9c57e84e5f1fa2e8bfa00baf650127cd458cbda2a14e0661019ac44ea77ad5c8b816c55c6aa5c662bae9fdaa2205a4eecf0b36ba624c6c0c385540e0cd9069cec7675e42ad9b92dcc3eff21d24717704af96ca11eeea6550d2bfc6a6fa95ed46dbe7e707a8999dcfe89071675e740b37e8e2500ec01b66f072b9ca34c725ecff25d0a0caf3c7f18d5f5735cbb8f4193a2be87374c784aee936d65de8a388910b5fe8903c6bdce46ffe946361d3a8bea072790203010001a382010830
        EAP-Message = 0x820104301d0603551d0e041604145f702bd186c24049f25783fc71b0be2c90564a9d3081d40603551d230481cc3081c980145f702bd186c24049f25783fc71b0be2c90564a9da181a5a481a230819f310b3009060355040613024445310b30090603550408130242593110300e0603550407130742616d6265726731263024060355040a141d556e69766572736974c3a4742042616d62657267204c73742e205357543125302306092a864886f70d0109011616746563686e696b407377742d62616d626572672e6465312230200603550403131953575420436572746966696361746520417574686f72697479820900d5b348c26db11232300c0603
        EAP-Message = 0x551d130405300301
        Message-Authenticator = 0x00000000000000000000000000000000
        State = 0xdaa802b3d9a41b8d059e5652a4713843
Finished request 3.
Going to the next request
Waking up in 4.9 seconds.
rad_recv: Access-Request packet from host 141.13.106.126 port 48647, id=108, length=349
        Framed-MTU = 1480
        NAS-IP-Address = 141.13.106.126
        NAS-Identifier = "swtprocurve01"
        User-Name = "testpc\\tom1"
        Service-Type = Framed-User
        Framed-Protocol = PPP
        NAS-Port = 31
        NAS-Port-Type = Ethernet
        NAS-Port-Id = "31"
        Called-Station-Id = "c0-91-34-c3-44-00"
        Calling-Station-Id = "00-19-99-0f-ff-dd"
        Connect-Info = "CONNECT Ethernet 1000Mbps Full duplex"
        Tunnel-Type:0 = VLAN
        Tunnel-Medium-Type:0 = IEEE-802
        Tunnel-Private-Group-Id:0 = "2049"
        State = 0xdaa802b3d9a41b8d059e5652a4713843
        EAP-Message = 0x020c00061900
        Message-Authenticator = 0x180295c2469830ddca31f645037cb1c2
        MS-RAS-Vendor = 11
        HP-Capability-Advert = 0x011a0000000b28
        HP-Capability-Advert = 0x011a0000000b2e
        HP-Capability-Advert = 0x011a0000000b30
        HP-Capability-Advert = 0x011a0000000b3d
        HP-Capability-Advert = 0x0138
        HP-Capability-Advert = 0x013a
        HP-Capability-Advert = 0x0140
        HP-Capability-Advert = 0x0141
        HP-Capability-Advert = 0x0151
# Executing section authorize from file /etc/freeradius/sites-enabled/default
+- entering group authorize {...}
[eap] EAP packet type response id 12 length 6
[eap] Continuing tunnel setup.
++[eap] returns ok
Found Auth-Type = EAP
# Executing group from file /etc/freeradius/sites-enabled/default
+- 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 108 to 141.13.106.126 port 48647
        EAP-Message = 0x010d0125190001ff300d06092a864886f70d01010505000382010100035d2016161164d50abd6a0e7f451dbc6146b6e5b4c7e9539274acc3abf59d96a3869544dfd82339b97ee41da2dae726a4ca5bdc650628c3002165e3710e2b809ebe6080399fdd13576ccda8fb213f420229798e3b32986f1ead8058f9e9fea31695376b90d4c779d1f32f987d5aca5d2ccd7300907a55efa0ea8ff2bdf64ce5351345691cf55032fe48b75373bc14028b24b6a25c93f480c12887a20a6d44ee74f2f3473a4902cc67ec63581f20f91c3e3672a48e1e1d3188d44d8d7eb5045b32ae5311e7f614a903d7a245d02cd386e8d79cd0df6b69023789c97738eba23789
        EAP-Message = 0x0da2e48fe62884cccfb075aa24783bee7dfe071f41aa7efe142e88c26ab2a616030100040e000000
        Message-Authenticator = 0x00000000000000000000000000000000
        State = 0xdaa802b3dea51b8d059e5652a4713843
Finished request 4.
Going to the next request
Waking up in 4.9 seconds.
rad_recv: Access-Request packet from host 141.13.106.126 port 48647, id=109, length=681
        Framed-MTU = 1480
        NAS-IP-Address = 141.13.106.126
        NAS-Identifier = "swtprocurve01"
        User-Name = "testpc\\tom1"
        Service-Type = Framed-User
        Framed-Protocol = PPP
        NAS-Port = 31
        NAS-Port-Type = Ethernet
        NAS-Port-Id = "31"
        Called-Station-Id = "c0-91-34-c3-44-00"
        Calling-Station-Id = "00-19-99-0f-ff-dd"
        Connect-Info = "CONNECT Ethernet 1000Mbps Full duplex"
        Tunnel-Type:0 = VLAN
        Tunnel-Medium-Type:0 = IEEE-802
        Tunnel-Private-Group-Id:0 = "2049"
        State = 0xdaa802b3dea51b8d059e5652a4713843
        EAP-Message = 0x020d01501980000001461603010106100001020100a0305960b1bf3028edf878f555be6cf8d88a610d62e5ec4a889b6a088cecdbcb575634e8b805538bcc7feee802ca01e6c9d98a794b75f6af348bf5348902f271df5d0b8b1aff8f0e46eb56dd39d97746983c18ac4159fcb841a2c91ecbf03c42e07811636f03703e013ea859b5bb91e353534eb22a73698f4ae480364ac3f70fa765007c5d45c7f96f0d12aaca51320ed0d1d8ad94a5a6e294cc02800382dba819a0e96ff3b00e90a6bcfa1f7bc94eda9895672864f73fd815237ea1f9a4bd0dbf9e0bf07f03d2f8bc08ea40dea2bafc4c3e6247cc6d305f397435332813fbe290496ca7f6bde636
        EAP-Message = 0xcefc68ef6377e2916c887014a6cd99bb499b7b88329f8b2714030100010116030100302521e36a5f9c1ac59cc68934a3d08e1a6eb2bac6e6744ba048922a066947e4dc5edf86d92e331259c87b29603bcb6df5
        Message-Authenticator = 0xde2547f2c43e1e27e134a1dabbdfae95
        MS-RAS-Vendor = 11
        HP-Capability-Advert = 0x011a0000000b28
        HP-Capability-Advert = 0x011a0000000b2e
        HP-Capability-Advert = 0x011a0000000b30
        HP-Capability-Advert = 0x011a0000000b3d
        HP-Capability-Advert = 0x0138
        HP-Capability-Advert = 0x013a
        HP-Capability-Advert = 0x0140
        HP-Capability-Advert = 0x0141
        HP-Capability-Advert = 0x0151
# Executing section authorize from file /etc/freeradius/sites-enabled/default
+- entering group authorize {...}
[eap] EAP packet type response id 13 length 253
[eap] Continuing tunnel setup.
++[eap] returns ok
Found Auth-Type = EAP
# Executing group from file /etc/freeradius/sites-enabled/default
+- 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
  SSL: adding session 2aa0d61d25aaed0b041184b6a6287001bbc6167e744e969de2266452e706e8f4 to cache
[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 109 to 141.13.106.126 port 48647
        EAP-Message = 0x010e0041190014030100010116030100300f3720663a3638dc7c1967df787e077bd04291190bcd056883dbb6633bd569edb1f73be295a8b8767cefdfaf74acd740
        Message-Authenticator = 0x00000000000000000000000000000000
        State = 0xdaa802b3dfa61b8d059e5652a4713843
Finished request 5.
Going to the next request
Waking up in 4.9 seconds.
rad_recv: Access-Request packet from host 141.13.106.126 port 48647, id=110, length=349
        Framed-MTU = 1480
        NAS-IP-Address = 141.13.106.126
        NAS-Identifier = "swtprocurve01"
        User-Name = "testpc\\tom1"
        Service-Type = Framed-User
        Framed-Protocol = PPP
        NAS-Port = 31
        NAS-Port-Type = Ethernet
        NAS-Port-Id = "31"
        Called-Station-Id = "c0-91-34-c3-44-00"
        Calling-Station-Id = "00-19-99-0f-ff-dd"
        Connect-Info = "CONNECT Ethernet 1000Mbps Full duplex"
        Tunnel-Type:0 = VLAN
        Tunnel-Medium-Type:0 = IEEE-802
        Tunnel-Private-Group-Id:0 = "2049"
        State = 0xdaa802b3dfa61b8d059e5652a4713843
        EAP-Message = 0x020e00061900
        Message-Authenticator = 0x114ffd477d2ba591d1e6b605bfd02a30
        MS-RAS-Vendor = 11
        HP-Capability-Advert = 0x011a0000000b28
        HP-Capability-Advert = 0x011a0000000b2e
        HP-Capability-Advert = 0x011a0000000b30
        HP-Capability-Advert = 0x011a0000000b3d
        HP-Capability-Advert = 0x0138
        HP-Capability-Advert = 0x013a
        HP-Capability-Advert = 0x0140
        HP-Capability-Advert = 0x0141
        HP-Capability-Advert = 0x0151
# Executing section authorize from file /etc/freeradius/sites-enabled/default
+- entering group authorize {...}
[eap] EAP packet type response id 14 length 6
[eap] Continuing tunnel setup.
++[eap] returns ok
Found Auth-Type = EAP
# Executing group from file /etc/freeradius/sites-enabled/default
+- 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
[peap] Session established.  Decoding tunneled attributes.
[peap] Peap state TUNNEL ESTABLISHED
++[eap] returns handled
Sending Access-Challenge of id 110 to 141.13.106.126 port 48647
        EAP-Message = 0x010f002b19001703010020fb6c5d87cc328e990fadb14484444a38184ea2b0d9c91d2e61618e3a0c4bba92
        Message-Authenticator = 0x00000000000000000000000000000000
        State = 0xdaa802b3dca71b8d059e5652a4713843
Finished request 6.
Going to the next request
Waking up in 4.9 seconds.
rad_recv: Access-Request packet from host 141.13.106.126 port 48647, id=111, length=402
        Framed-MTU = 1480
        NAS-IP-Address = 141.13.106.126
        NAS-Identifier = "swtprocurve01"
        User-Name = "testpc\\tom1"
        Service-Type = Framed-User
        Framed-Protocol = PPP
        NAS-Port = 31
        NAS-Port-Type = Ethernet
        NAS-Port-Id = "31"
        Called-Station-Id = "c0-91-34-c3-44-00"
        Calling-Station-Id = "00-19-99-0f-ff-dd"
        Connect-Info = "CONNECT Ethernet 1000Mbps Full duplex"
        Tunnel-Type:0 = VLAN
        Tunnel-Medium-Type:0 = IEEE-802
        Tunnel-Private-Group-Id:0 = "2049"
        State = 0xdaa802b3dca71b8d059e5652a4713843
        EAP-Message = 0x020f003b1900170301003065ba0f6fba6129ac0561b5753590ba27f42e28d964aef88d247492cbdace5bab6d13b6dfc2b943f86ecfeb5e54c06573
        Message-Authenticator = 0x64d8ace1fcb53bca8d15273761110ba7
        MS-RAS-Vendor = 11
        HP-Capability-Advert = 0x011a0000000b28
        HP-Capability-Advert = 0x011a0000000b2e
        HP-Capability-Advert = 0x011a0000000b30
        HP-Capability-Advert = 0x011a0000000b3d
        HP-Capability-Advert = 0x0138
        HP-Capability-Advert = 0x013a
        HP-Capability-Advert = 0x0140
        HP-Capability-Advert = 0x0141
        HP-Capability-Advert = 0x0151
# Executing section authorize from file /etc/freeradius/sites-enabled/default
+- entering group authorize {...}
[eap] EAP packet type response id 15 length 59
[eap] Continuing tunnel setup.
++[eap] returns ok
Found Auth-Type = EAP
# Executing group from file /etc/freeradius/sites-enabled/default
+- 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] Peap state WAITING FOR INNER IDENTITY
[peap] Identity - testpc\tom1
[peap] Got inner identity 'testpc\tom1'
[peap] Setting default EAP type for tunneled EAP session.
[peap] Got tunneled request
        EAP-Message = 0x020f0010017465737470635c746f6d31
server  {
  PEAP: Setting User-Name to testpc\tom1
Sending tunneled request
        EAP-Message = 0x020f0010017465737470635c746f6d31
        FreeRADIUS-Proxied-To = 127.0.0.1
        User-Name = "testpc\\tom1"
server inner-tunnel {
# Executing section authorize from file /etc/freeradius/sites-enabled/inner-tunnel
+- entering group authorize {...}
++[preprocess] returns ok
[eap] EAP packet type response id 15 length 16
[eap] No EAP Start, assuming it's an on-going EAP conversation
++[eap] returns updated
++- entering policy swt_policy {...}
+++? if (( outer.request:Called-Station-Id == "02-6F-83-3A-AD-B8:staff.1.swt.wiai.uni-bamberg.de" || Called-Station-Id == "02-6F-83-3A-AD-B8:staff.1.swt.wiai.uni-bamberg.de" ) && LDAP-Group == "ap_llab-staff" )
?? Evaluating (outer.request:Called-Station-Id == "02-6F-83-3A-AD-B8:staff.1.swt.wiai.uni-bamberg.de" ) -> FALSE
    (Attribute Called-Station-Id was not found)
?? Evaluating (Called-Station-Id == "02-6F-83-3A-AD-B8:staff.1.swt.wiai.uni-bamberg.de" ) -> FALSE
? Skipping (LDAP-Group == "ap_llab-staff" )
+++? if (( outer.request:Called-Station-Id == "02-6F-83-3A-AD-B8:staff.1.swt.wiai.uni-bamberg.de" || Called-Station-Id == "02-6F-83-3A-AD-B8:staff.1.swt.wiai.uni-bamberg.de" ) && LDAP-Group == "ap_llab-staff" ) -> FALSE
+++? elsif (( outer.request:Called-Station-Id == "0013100adbcf" || Called-Station-Id == "0013100adbcf" ) && LDAP-Group=="ap_llab-staff" )
?? Evaluating (outer.request:Called-Station-Id == "0013100adbcf" ) -> FALSE
    (Attribute Called-Station-Id was not found)
?? Evaluating (Called-Station-Id == "0013100adbcf" ) -> FALSE
? Skipping (LDAP-Group=="ap_llab-staff" )
+++? elsif (( outer.request:Called-Station-Id == "0013100adbcf" || Called-Station-Id == "0013100adbcf" ) && LDAP-Group=="ap_llab-staff" ) -> FALSE
+++? elsif (( outer.request:Called-Station-Id == "02-6F-83-3A-B5-E8:staff.2.swt.wiai.uni-bamberg.de" || Called-Station-Id == "02-6F-83-3A-B5-E8:staff.2.swt.wiai.uni-bamberg.de" ) && LDAP-Group == "ap_slab-staff" )
?? Evaluating (outer.request:Called-Station-Id == "02-6F-83-3A-B5-E8:staff.2.swt.wiai.uni-bamberg.de" ) -> FALSE
    (Attribute Called-Station-Id was not found)
?? Evaluating (Called-Station-Id == "02-6F-83-3A-B5-E8:staff.2.swt.wiai.uni-bamberg.de" ) -> FALSE
? Skipping (LDAP-Group == "ap_slab-staff" )
+++? elsif (( outer.request:Called-Station-Id == "02-6F-83-3A-B5-E8:staff.2.swt.wiai.uni-bamberg.de" || Called-Station-Id == "02-6F-83-3A-B5-E8:staff.2.swt.wiai.uni-bamberg.de" ) && LDAP-Group == "ap_slab-staff" ) -> FALSE
+++? elsif (outer.request:Called-Station-Id == "02-6F-83-3A-AD-B9:others.1.swt.wiai.uni-bamberg.de" || Called-Station-Id == "02-6F-83-3A-AD-B9:others.1.swt.wiai.uni-bamberg.de" )
? Evaluating (outer.request:Called-Station-Id == "02-6F-83-3A-AD-B9:others.1.swt.wiai.uni-bamberg.de" ) -> FALSE
    (Attribute Called-Station-Id was not found)
? Evaluating (Called-Station-Id == "02-6F-83-3A-AD-B9:others.1.swt.wiai.uni-bamberg.de" ) -> FALSE
+++? elsif (outer.request:Called-Station-Id == "02-6F-83-3A-AD-B9:others.1.swt.wiai.uni-bamberg.de" || Called-Station-Id == "02-6F-83-3A-AD-B9:others.1.swt.wiai.uni-bamberg.de" ) -> FALSE
+++? elsif (outer.request:Called-Station-Id == "02-6F-83-3A-B5-E9:others.2.swt.wiai.uni-bamberg.de" || Called-Station-Id == "02-6F-83-3A-B5-E9:others.2.swt.wiai.uni-bamberg.de" )
? Evaluating (outer.request:Called-Station-Id == "02-6F-83-3A-B5-E9:others.2.swt.wiai.uni-bamberg.de" ) -> FALSE
    (Attribute Called-Station-Id was not found)
? Evaluating (Called-Station-Id == "02-6F-83-3A-B5-E9:others.2.swt.wiai.uni-bamberg.de" ) -> FALSE
+++? elsif (outer.request:Called-Station-Id == "02-6F-83-3A-B5-E9:others.2.swt.wiai.uni-bamberg.de" || Called-Station-Id == "02-6F-83-3A-B5-E9:others.2.swt.wiai.uni-bamberg.de" ) -> FALSE
+++? elsif (( outer.request:Called-Station-Id == "c0-91-34-c3-44-00" || Called-Station-Id == "c0-91-34-c3-44-00" ) && ( LDAP-Group == "swtswitch01-staff" || LDAP-Group == "swtswitch01-others" ) )
?? Evaluating (outer.request:Called-Station-Id == "c0-91-34-c3-44-00" ) -> TRUE
?? Skipping (Called-Station-Id == "c0-91-34-c3-44-00" )
  [ldap] Entering ldap_groupcmp()
        expand: ou=swt,ou=wiai,dc=uni-bamberg,dc=de -> ou=swt,ou=wiai,dc=uni-bamberg,dc=de
        expand: (&(objectClass=posixAccount)(uid=%{mschap:User-Name:-%{User-Name}})) -> (&(objectClass=posixAccount)(uid=tom1))
  [ldap] ldap_get_conn: Checking Id: 0
  [ldap] ldap_get_conn: Got Id: 0
  [ldap] performing search in ou=swt,ou=wiai,dc=uni-bamberg,dc=de, with filter (&(objectClass=posixAccount)(uid=tom1))
  [ldap] ldap_release_conn: Release Id: 0
        expand: (&(objectClass=posixGroup)(|(uid=%{mschap:User-Name:-%{User-Name}})(memberUid=%{mschap:User-Name:-%{User-Name}}))) -> (&(objectClass=posixGroup)(|(uid=tom1)(memberUid=tom1)))
  [ldap] ldap_get_conn: Checking Id: 0
  [ldap] ldap_get_conn: Got Id: 0
  [ldap] performing search in ou=swt,ou=wiai,dc=uni-bamberg,dc=de, with filter (&(cn=swtswitch01-staff)(&(objectClass=posixGroup)(|(uid=tom1)(memberUid=tom1))))
  [ldap] object not found
  [ldap] ldap_release_conn: Release Id: 0
  [ldap] ldap_get_conn: Checking Id: 0
  [ldap] ldap_get_conn: Got Id: 0
  [ldap] performing search in uid=tom1,ou=students,ou=people,ou=swt,ou=wiai,dc=uni-bamberg,dc=de, with filter (objectclass=*)
rlm_ldap::ldap_groupcmp: ldap_get_values() failed
  [ldap] ldap_release_conn: Release Id: 0
?? Evaluating (LDAP-Group == "swtswitch01-staff" ) -> FALSE
  [ldap] Entering ldap_groupcmp()
        expand: ou=swt,ou=wiai,dc=uni-bamberg,dc=de -> ou=swt,ou=wiai,dc=uni-bamberg,dc=de
        expand: (&(objectClass=posixGroup)(|(uid=%{mschap:User-Name:-%{User-Name}})(memberUid=%{mschap:User-Name:-%{User-Name}}))) -> (&(objectClass=posixGroup)(|(uid=tom1)(memberUid=tom1)))
  [ldap] ldap_get_conn: Checking Id: 0
  [ldap] ldap_get_conn: Got Id: 0
  [ldap] performing search in ou=swt,ou=wiai,dc=uni-bamberg,dc=de, with filter (&(cn=swtswitch01-others)(&(objectClass=posixGroup)(|(uid=tom1)(memberUid=tom1))))
rlm_ldap::ldap_groupcmp: User found in group swtswitch01-others
  [ldap] ldap_release_conn: Release Id: 0
?? Evaluating (LDAP-Group == "swtswitch01-others" ) -> TRUE
+++? elsif (( outer.request:Called-Station-Id == "c0-91-34-c3-44-00" || Called-Station-Id == "c0-91-34-c3-44-00" ) && ( LDAP-Group == "swtswitch01-staff" || LDAP-Group == "swtswitch01-others" ) ) -> TRUE
+++- entering elsif (( outer.request:Called-Station-Id == "c0-91-34-c3-44-00" || Called-Station-Id == "c0-91-34-c3-44-00" ) && ( LDAP-Group == "swtswitch01-staff" || LDAP-Group == "swtswitch01-others" ) ) {...}
++++- entering policy prefer_kerberos {...}
+++++? if (User-Password )
? Evaluating (User-Password ) -> FALSE
+++++? if (User-Password ) -> FALSE
+++++- entering else else {...}
++++++[mschap] returns noop
+++++- else else returns noop
++++- policy prefer_kerberos returns noop
+++- elsif (( outer.request:Called-Station-Id == "c0-91-34-c3-44-00" || Called-Station-Id == "c0-91-34-c3-44-00" ) && ( LDAP-Group == "swtswitch01-staff" || LDAP-Group == "swtswitch01-others" ) ) returns noop
+++ ... skipping else for request 7: Preceding "if" was taken
++- policy swt_policy returns noop
[ldap] performing user authorization for testpc\tom1
[ldap]  expand: (&(objectClass=posixAccount)(uid=%{mschap:User-Name:-%{User-Name}})) -> (&(objectClass=posixAccount)(uid=tom1))
[ldap]  expand: ou=swt,ou=wiai,dc=uni-bamberg,dc=de -> ou=swt,ou=wiai,dc=uni-bamberg,dc=de
  [ldap] ldap_get_conn: Checking Id: 0
  [ldap] ldap_get_conn: Got Id: 0
  [ldap] performing search in ou=swt,ou=wiai,dc=uni-bamberg,dc=de, with filter (&(objectClass=posixAccount)(uid=tom1))
[ldap] No default NMAS login sequence
[ldap] looking for check items in directory...
  [ldap] sambaNtPassword -> NT-Password == 0x3043423639343838303546373937424632413832383037393733423839353337
[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 testpc\tom1 authorized to use remote access
  [ldap] ldap_release_conn: Release Id: 0
++[ldap] returns ok
Found Auth-Type = EAP
# Executing group from file /etc/freeradius/sites-enabled/inner-tunnel
+- 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 = 0x011000251a011000201055a24ece35e0333bf81e9f82769dadec7465737470635c746f6d31
        Message-Authenticator = 0x00000000000000000000000000000000
        State = 0x277a49e0276a535e5cea6860f59c4be0
[peap] Got tunneled reply RADIUS code 11
        EAP-Message = 0x011000251a011000201055a24ece35e0333bf81e9f82769dadec7465737470635c746f6d31
        Message-Authenticator = 0x00000000000000000000000000000000
        State = 0x277a49e0276a535e5cea6860f59c4be0
[peap] Got tunneled Access-Challenge
++[eap] returns handled
Sending Access-Challenge of id 111 to 141.13.106.126 port 48647
        EAP-Message = 0x0110004b190017030100406a600def42e1852b147073e0c48d91e22b5fadffd505513d9b45f7fef372e697416baeb601f0abb4ab795ff160bc26c82576090047fc451a04767848086cc390
        Message-Authenticator = 0x00000000000000000000000000000000
        State = 0xdaa802b3ddb81b8d059e5652a4713843
Finished request 7.
Going to the next request
Waking up in 4.9 seconds.
rad_recv: Access-Request packet from host 141.13.106.126 port 48647, id=112, length=434
        Framed-MTU = 1480
        NAS-IP-Address = 141.13.106.126
        NAS-Identifier = "swtprocurve01"
        User-Name = "testpc\\tom1"
        Service-Type = Framed-User
        Framed-Protocol = PPP
        NAS-Port = 31
        NAS-Port-Type = Ethernet
        NAS-Port-Id = "31"
        Called-Station-Id = "c0-91-34-c3-44-00"
        Calling-Station-Id = "00-19-99-0f-ff-dd"
        Connect-Info = "CONNECT Ethernet 1000Mbps Full duplex"
        Tunnel-Type:0 = VLAN
        Tunnel-Medium-Type:0 = IEEE-802
        Tunnel-Private-Group-Id:0 = "2049"
        State = 0xdaa802b3ddb81b8d059e5652a4713843
        EAP-Message = 0x0210005b19001703010050833c7a00ba667d8a8f466f19a1c5d3e45788ef767fa6863cce8e1b685c8ac7c1e07c370ec56f3a4512ce059461cf21980f057e6fb0d95cc6b6aead9bf0face623255821580d1a888914e2384419435fe
        Message-Authenticator = 0x10934ac071e94150e657ed92db705ec8
        MS-RAS-Vendor = 11
        HP-Capability-Advert = 0x011a0000000b28
        HP-Capability-Advert = 0x011a0000000b2e
        HP-Capability-Advert = 0x011a0000000b30
        HP-Capability-Advert = 0x011a0000000b3d
        HP-Capability-Advert = 0x0138
        HP-Capability-Advert = 0x013a
        HP-Capability-Advert = 0x0140
        HP-Capability-Advert = 0x0141
        HP-Capability-Advert = 0x0151
# Executing section authorize from file /etc/freeradius/sites-enabled/default
+- entering group authorize {...}
[eap] EAP packet type response id 16 length 91
[eap] Continuing tunnel setup.
++[eap] returns ok
Found Auth-Type = EAP
# Executing group from file /etc/freeradius/sites-enabled/default
+- 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] Peap state phase2
[peap] EAP type mschapv2
[peap] Got tunneled request
        EAP-Message = 0x0210003f1a0210003a3155ab734b97d17343fc420165cc600c720000000000000000ca37e422367aaf0545e685283ac9648d625eb1435d650cf900746f6d31
server  {
  PEAP: Setting User-Name to testpc\tom1
Sending tunneled request
        EAP-Message = 0x0210003f1a0210003a3155ab734b97d17343fc420165cc600c720000000000000000ca37e422367aaf0545e685283ac9648d625eb1435d650cf900746f6d31
        FreeRADIUS-Proxied-To = 127.0.0.1
        User-Name = "testpc\\tom1"
        State = 0x277a49e0276a535e5cea6860f59c4be0
server inner-tunnel {
# Executing section authorize from file /etc/freeradius/sites-enabled/inner-tunnel
+- entering group authorize {...}
++[preprocess] returns ok
[eap] EAP packet type response id 16 length 63
[eap] No EAP Start, assuming it's an on-going EAP conversation
++[eap] returns updated
++- entering policy swt_policy {...}
+++? if (( outer.request:Called-Station-Id == "02-6F-83-3A-AD-B8:staff.1.swt.wiai.uni-bamberg.de" || Called-Station-Id == "02-6F-83-3A-AD-B8:staff.1.swt.wiai.uni-bamberg.de" ) && LDAP-Group == "ap_llab-staff" )
?? Evaluating (outer.request:Called-Station-Id == "02-6F-83-3A-AD-B8:staff.1.swt.wiai.uni-bamberg.de" ) -> FALSE
    (Attribute Called-Station-Id was not found)
?? Evaluating (Called-Station-Id == "02-6F-83-3A-AD-B8:staff.1.swt.wiai.uni-bamberg.de" ) -> FALSE
? Skipping (LDAP-Group == "ap_llab-staff" )
+++? if (( outer.request:Called-Station-Id == "02-6F-83-3A-AD-B8:staff.1.swt.wiai.uni-bamberg.de" || Called-Station-Id == "02-6F-83-3A-AD-B8:staff.1.swt.wiai.uni-bamberg.de" ) && LDAP-Group == "ap_llab-staff" ) -> FALSE
+++? elsif (( outer.request:Called-Station-Id == "0013100adbcf" || Called-Station-Id == "0013100adbcf" ) && LDAP-Group=="ap_llab-staff" )
?? Evaluating (outer.request:Called-Station-Id == "0013100adbcf" ) -> FALSE
    (Attribute Called-Station-Id was not found)
?? Evaluating (Called-Station-Id == "0013100adbcf" ) -> FALSE
? Skipping (LDAP-Group=="ap_llab-staff" )
+++? elsif (( outer.request:Called-Station-Id == "0013100adbcf" || Called-Station-Id == "0013100adbcf" ) && LDAP-Group=="ap_llab-staff" ) -> FALSE
+++? elsif (( outer.request:Called-Station-Id == "02-6F-83-3A-B5-E8:staff.2.swt.wiai.uni-bamberg.de" || Called-Station-Id == "02-6F-83-3A-B5-E8:staff.2.swt.wiai.uni-bamberg.de" ) && LDAP-Group == "ap_slab-staff" )
?? Evaluating (outer.request:Called-Station-Id == "02-6F-83-3A-B5-E8:staff.2.swt.wiai.uni-bamberg.de" ) -> FALSE
    (Attribute Called-Station-Id was not found)
?? Evaluating (Called-Station-Id == "02-6F-83-3A-B5-E8:staff.2.swt.wiai.uni-bamberg.de" ) -> FALSE
? Skipping (LDAP-Group == "ap_slab-staff" )
+++? elsif (( outer.request:Called-Station-Id == "02-6F-83-3A-B5-E8:staff.2.swt.wiai.uni-bamberg.de" || Called-Station-Id == "02-6F-83-3A-B5-E8:staff.2.swt.wiai.uni-bamberg.de" ) && LDAP-Group == "ap_slab-staff" ) -> FALSE
+++? elsif (outer.request:Called-Station-Id == "02-6F-83-3A-AD-B9:others.1.swt.wiai.uni-bamberg.de" || Called-Station-Id == "02-6F-83-3A-AD-B9:others.1.swt.wiai.uni-bamberg.de" )
? Evaluating (outer.request:Called-Station-Id == "02-6F-83-3A-AD-B9:others.1.swt.wiai.uni-bamberg.de" ) -> FALSE
    (Attribute Called-Station-Id was not found)
? Evaluating (Called-Station-Id == "02-6F-83-3A-AD-B9:others.1.swt.wiai.uni-bamberg.de" ) -> FALSE
+++? elsif (outer.request:Called-Station-Id == "02-6F-83-3A-AD-B9:others.1.swt.wiai.uni-bamberg.de" || Called-Station-Id == "02-6F-83-3A-AD-B9:others.1.swt.wiai.uni-bamberg.de" ) -> FALSE
+++? elsif (outer.request:Called-Station-Id == "02-6F-83-3A-B5-E9:others.2.swt.wiai.uni-bamberg.de" || Called-Station-Id == "02-6F-83-3A-B5-E9:others.2.swt.wiai.uni-bamberg.de" )
? Evaluating (outer.request:Called-Station-Id == "02-6F-83-3A-B5-E9:others.2.swt.wiai.uni-bamberg.de" ) -> FALSE
    (Attribute Called-Station-Id was not found)
? Evaluating (Called-Station-Id == "02-6F-83-3A-B5-E9:others.2.swt.wiai.uni-bamberg.de" ) -> FALSE
+++? elsif (outer.request:Called-Station-Id == "02-6F-83-3A-B5-E9:others.2.swt.wiai.uni-bamberg.de" || Called-Station-Id == "02-6F-83-3A-B5-E9:others.2.swt.wiai.uni-bamberg.de" ) -> FALSE
+++? elsif (( outer.request:Called-Station-Id == "c0-91-34-c3-44-00" || Called-Station-Id == "c0-91-34-c3-44-00" ) && ( LDAP-Group == "swtswitch01-staff" || LDAP-Group == "swtswitch01-others" ) )
?? Evaluating (outer.request:Called-Station-Id == "c0-91-34-c3-44-00" ) -> TRUE
?? Skipping (Called-Station-Id == "c0-91-34-c3-44-00" )
  [ldap] Entering ldap_groupcmp()
        expand: ou=swt,ou=wiai,dc=uni-bamberg,dc=de -> ou=swt,ou=wiai,dc=uni-bamberg,dc=de
        expand: (&(objectClass=posixAccount)(uid=%{mschap:User-Name:-%{User-Name}})) -> (&(objectClass=posixAccount)(uid=tom1))
  [ldap] ldap_get_conn: Checking Id: 0
  [ldap] ldap_get_conn: Got Id: 0
  [ldap] performing search in ou=swt,ou=wiai,dc=uni-bamberg,dc=de, with filter (&(objectClass=posixAccount)(uid=tom1))
  [ldap] ldap_release_conn: Release Id: 0
        expand: (&(objectClass=posixGroup)(|(uid=%{mschap:User-Name:-%{User-Name}})(memberUid=%{mschap:User-Name:-%{User-Name}}))) -> (&(objectClass=posixGroup)(|(uid=tom1)(memberUid=tom1)))
  [ldap] ldap_get_conn: Checking Id: 0
  [ldap] ldap_get_conn: Got Id: 0
  [ldap] performing search in ou=swt,ou=wiai,dc=uni-bamberg,dc=de, with filter (&(cn=swtswitch01-staff)(&(objectClass=posixGroup)(|(uid=tom1)(memberUid=tom1))))
  [ldap] object not found
  [ldap] ldap_release_conn: Release Id: 0
  [ldap] ldap_get_conn: Checking Id: 0
  [ldap] ldap_get_conn: Got Id: 0
  [ldap] performing search in uid=tom1,ou=students,ou=people,ou=swt,ou=wiai,dc=uni-bamberg,dc=de, with filter (objectclass=*)
rlm_ldap::ldap_groupcmp: ldap_get_values() failed
  [ldap] ldap_release_conn: Release Id: 0
?? Evaluating (LDAP-Group == "swtswitch01-staff" ) -> FALSE
  [ldap] Entering ldap_groupcmp()
        expand: ou=swt,ou=wiai,dc=uni-bamberg,dc=de -> ou=swt,ou=wiai,dc=uni-bamberg,dc=de
        expand: (&(objectClass=posixGroup)(|(uid=%{mschap:User-Name:-%{User-Name}})(memberUid=%{mschap:User-Name:-%{User-Name}}))) -> (&(objectClass=posixGroup)(|(uid=tom1)(memberUid=tom1)))
  [ldap] ldap_get_conn: Checking Id: 0
  [ldap] ldap_get_conn: Got Id: 0
  [ldap] performing search in ou=swt,ou=wiai,dc=uni-bamberg,dc=de, with filter (&(cn=swtswitch01-others)(&(objectClass=posixGroup)(|(uid=tom1)(memberUid=tom1))))
rlm_ldap::ldap_groupcmp: User found in group swtswitch01-others
  [ldap] ldap_release_conn: Release Id: 0
?? Evaluating (LDAP-Group == "swtswitch01-others" ) -> TRUE
+++? elsif (( outer.request:Called-Station-Id == "c0-91-34-c3-44-00" || Called-Station-Id == "c0-91-34-c3-44-00" ) && ( LDAP-Group == "swtswitch01-staff" || LDAP-Group == "swtswitch01-others" ) ) -> TRUE
+++- entering elsif (( outer.request:Called-Station-Id == "c0-91-34-c3-44-00" || Called-Station-Id == "c0-91-34-c3-44-00" ) && ( LDAP-Group == "swtswitch01-staff" || LDAP-Group == "swtswitch01-others" ) ) {...}
++++- entering policy prefer_kerberos {...}
+++++? if (User-Password )
? Evaluating (User-Password ) -> FALSE
+++++? if (User-Password ) -> FALSE
+++++- entering else else {...}
++++++[mschap] returns noop
+++++- else else returns noop
++++- policy prefer_kerberos returns noop
+++- elsif (( outer.request:Called-Station-Id == "c0-91-34-c3-44-00" || Called-Station-Id == "c0-91-34-c3-44-00" ) && ( LDAP-Group == "swtswitch01-staff" || LDAP-Group == "swtswitch01-others" ) ) returns noop
+++ ... skipping else for request 8: Preceding "if" was taken
++- policy swt_policy returns noop
[ldap] performing user authorization for testpc\tom1
[ldap]  expand: (&(objectClass=posixAccount)(uid=%{mschap:User-Name:-%{User-Name}})) -> (&(objectClass=posixAccount)(uid=tom1))
[ldap]  expand: ou=swt,ou=wiai,dc=uni-bamberg,dc=de -> ou=swt,ou=wiai,dc=uni-bamberg,dc=de
  [ldap] ldap_get_conn: Checking Id: 0
  [ldap] ldap_get_conn: Got Id: 0
  [ldap] performing search in ou=swt,ou=wiai,dc=uni-bamberg,dc=de, with filter (&(objectClass=posixAccount)(uid=tom1))
[ldap] No default NMAS login sequence
[ldap] looking for check items in directory...
  [ldap] sambaNtPassword -> NT-Password == 0x3043423639343838303546373937424632413832383037393733423839353337
[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 testpc\tom1 authorized to use remote access
  [ldap] ldap_release_conn: Release Id: 0
++[ldap] returns ok
Found Auth-Type = EAP
# Executing group from file /etc/freeradius/sites-enabled/inner-tunnel
+- entering group authenticate {...}
[eap] Request found, released from the list
[eap] EAP/mschapv2
[eap] processing type mschapv2
[mschapv2] # Executing group from file /etc/freeradius/sites-enabled/inner-tunnel
[mschapv2] +- entering group MS-CHAP {...}
[mschap] No Cleartext-Password configured.  Cannot create LM-Password.
[mschap] Found NT-Password
[mschap] ERROR: User-Name (testpc\tom1) is not the same as MS-CHAP Name (tom1) from EAP-MSCHAPv2
++[mschap] returns reject
[eap] Freeing handler
++[eap] returns reject
Failed to authenticate the user.
Login incorrect: [testpc\\tom1] (from client swtswitch01 port 0 via TLS tunnel)
} # server inner-tunnel
[peap] Got tunneled reply code 3
        EAP-Message = 0x04100004
        Message-Authenticator = 0x00000000000000000000000000000000
[peap] Got tunneled reply RADIUS code 3
        EAP-Message = 0x04100004
        Message-Authenticator = 0x00000000000000000000000000000000
[peap] Tunneled authentication was rejected.
[peap] FAILURE
++[eap] returns handled
Sending Access-Challenge of id 112 to 141.13.106.126 port 48647
        EAP-Message = 0x0111002b19001703010020327373eb03ba85e44d78a280f947ed5356a4ee80d51d5ce2d064218be840ca10
        Message-Authenticator = 0x00000000000000000000000000000000
        State = 0xdaa802b3d2b91b8d059e5652a4713843
Finished request 8.
Going to the next request
Waking up in 4.9 seconds.
rad_recv: Access-Request packet from host 141.13.106.126 port 48647, id=113, length=386
        Framed-MTU = 1480
        NAS-IP-Address = 141.13.106.126
        NAS-Identifier = "swtprocurve01"
        User-Name = "testpc\\tom1"
        Service-Type = Framed-User
        Framed-Protocol = PPP
        NAS-Port = 31
        NAS-Port-Type = Ethernet
        NAS-Port-Id = "31"
        Called-Station-Id = "c0-91-34-c3-44-00"
        Calling-Station-Id = "00-19-99-0f-ff-dd"
        Connect-Info = "CONNECT Ethernet 1000Mbps Full duplex"
        Tunnel-Type:0 = VLAN
        Tunnel-Medium-Type:0 = IEEE-802
        Tunnel-Private-Group-Id:0 = "2049"
        State = 0xdaa802b3d2b91b8d059e5652a4713843
        EAP-Message = 0x0211002b19001703010020db9f0a75862aa2ea830bcbf628eea820c4fdcab3f1eb7792e4fbab8baa80f528
        Message-Authenticator = 0xb2c314f71ac19a94a27e1bcc84ab648d
        MS-RAS-Vendor = 11
        HP-Capability-Advert = 0x011a0000000b28
        HP-Capability-Advert = 0x011a0000000b2e
        HP-Capability-Advert = 0x011a0000000b30
        HP-Capability-Advert = 0x011a0000000b3d
        HP-Capability-Advert = 0x0138
        HP-Capability-Advert = 0x013a
        HP-Capability-Advert = 0x0140
        HP-Capability-Advert = 0x0141
        HP-Capability-Advert = 0x0151
# Executing section authorize from file /etc/freeradius/sites-enabled/default
+- entering group authorize {...}
[eap] EAP packet type response id 17 length 43
[eap] Continuing tunnel setup.
++[eap] returns ok
Found Auth-Type = EAP
# Executing group from file /etc/freeradius/sites-enabled/default
+- 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] Peap state send tlv failure
[peap] Received EAP-TLV response.
[peap]  The users session was previously rejected: returning reject (again.)
[peap]  *** This means you need to read the PREVIOUS messages in the debug output
[peap]  *** to find out the reason why the user was rejected.
[peap]  *** Look for "reject" or "fail".  Those earlier messages will tell you.
[peap]  *** what went wrong, and how to fix the problem.
  SSL: Removing session 2aa0d61d25aaed0b041184b6a6287001bbc6167e744e969de2266452e706e8f4 from the cache
[eap] Handler failed in EAP/peap
[eap] Failed in EAP select
++[eap] returns invalid
Failed to authenticate the user.
Login incorrect: [testpc\\tom1] (from client swtswitch01 port 31 cli 00-19-99-0f-ff-dd)
Using Post-Auth-Type Reject
  WARNING: Unknown value specified for Post-Auth-Type.  Cannot perform requested action.
# Executing group from file /etc/freeradius/sites-enabled/default
Delaying reject of request 9 for 1 seconds
Going to the next request
Waking up in 0.9 seconds.
Sending delayed reject for request 9
Sending Access-Reject of id 113 to 141.13.106.126 port 48647
        EAP-Message = 0x04110004
        Message-Authenticator = 0x00000000000000000000000000000000
Waking up in 3.9 seconds.
Cleaning up request 0 ID 104 with timestamp +18
Cleaning up request 1 ID 105 with timestamp +18
Cleaning up request 2 ID 106 with timestamp +18
Cleaning up request 3 ID 107 with timestamp +18
Cleaning up request 4 ID 108 with timestamp +18
Cleaning up request 5 ID 109 with timestamp +18
Cleaning up request 6 ID 110 with timestamp +18
Cleaning up request 7 ID 111 with timestamp +18
Cleaning up request 8 ID 112 with timestamp +18
Waking up in 1.0 seconds.
Cleaning up request 9 ID 113 with timestamp +18
Ready to process requests.


More information about the Freeradius-Users mailing list