Strip off the domain part from the User-Name

Thomas Wunder thomas.wunder at swt-bamberg.de
Fri Apr 1 14:43:40 CEST 2011


On Friday 01 April 2011 14:37:34 Phil Mayers wrote:
> Don't see the logfile...
sorry my bad...
-------------- 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 = yes
  }
 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: 0x276e7d0
 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=212, length=341
        Framed-MTU = 1480
        NAS-IP-Address = 141.13.106.126
        NAS-Identifier = "swtprocurve01"
        User-Name = "winmac\\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 = "c8-bc-c8-96-a3-3e"
        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 = 0x020600100177696e6d61635c746f6d31
        Message-Authenticator = 0x837dc928a9188b58c38b87d11bc4e885
        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 6 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 winmac\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 winmac\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 212 to 141.13.106.126 port 48647
        EAP-Message = 0x010700160410b911ba3bd52f35f09e62e65f9795c975
        Message-Authenticator = 0x00000000000000000000000000000000
        State = 0xc3f6a313c3f1a7f82dc969b24e44d683
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=213, length=349
        Framed-MTU = 1480
        NAS-IP-Address = 141.13.106.126
        NAS-Identifier = "swtprocurve01"
        User-Name = "winmac\\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 = "c8-bc-c8-96-a3-3e"
        Connect-Info = "CONNECT Ethernet 1000Mbps Full duplex"
        Tunnel-Type:0 = VLAN
        Tunnel-Medium-Type:0 = IEEE-802
        Tunnel-Private-Group-Id:0 = "2049"
        State = 0xc3f6a313c3f1a7f82dc969b24e44d683
        EAP-Message = 0x020700060319
        Message-Authenticator = 0x9b800c92f54c206eb7a0a01637c62477
        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 7 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 winmac\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 winmac\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 213 to 141.13.106.126 port 48647
        EAP-Message = 0x010800061920
        Message-Authenticator = 0x00000000000000000000000000000000
        State = 0xc3f6a313c2febaf82dc969b24e44d683
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=214, length=468
        Framed-MTU = 1480
        NAS-IP-Address = 141.13.106.126
        NAS-Identifier = "swtprocurve01"
        User-Name = "winmac\\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 = "c8-bc-c8-96-a3-3e"
        Connect-Info = "CONNECT Ethernet 1000Mbps Full duplex"
        Tunnel-Type:0 = VLAN
        Tunnel-Medium-Type:0 = IEEE-802
        Tunnel-Private-Group-Id:0 = "2049"
        State = 0xc3f6a313c2febaf82dc969b24e44d683
        EAP-Message = 0x0208007d198000000073160301006e0100006a03014d95818e0f2886c4ea7d7229a36189f291404d58e7206cf93137c6740138d8f7000018002f00350005000ac013c014c009c00a003200380013000401000029ff0100010000000010000e00000b77696e6d61635c746f6d31000a0006000400170018000b00020100
        Message-Authenticator = 0x8c4c870d7f7c4fc2da779578b409484c
        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 125
[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 115
[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 006e], ClientHello  
[peap]     TLS_accept: SSLv3 read client hello A
[peap] >>> TLS 1.0 Handshake [length 0051], 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 214 to 141.13.106.126 port 48647
        EAP-Message = 0x0109040019c00000091216030100510200004d03014d959dadf94d0630d871f587ac719d69b6a7902e48707a3d37d67503299dd37220c47a2d5ada38619f5a7f0fc0afc18a4b036b29e67690feefa143072925f35463002f000005ff0100010016030108ae0b0008aa0008a70003d0308203cc308202b4a003020102020102300d06092a864886f70d010104050030819f310b3009060355040613024445310b30090603550408130242593110300e0603550407130742616d6265726731263024060355040a141d556e69766572736974c3a4742042616d62657267204c73742e205357543125302306092a864886f70d0109011616746563686e696b
        EAP-Message = 0x407377742d62616d626572672e6465312230200603550403131953575420436572746966696361746520417574686f72697479301e170d3131303331303130343232305a170d3132303330393130343232305a308199310b3009060355040613024445310b300906035504081302425931263024060355040a141d556e69766572736974c3a4742042616d62657267204c73742e20535754312e302c06035504031325726164697573312e73746166662e7377742e776961692e756e692d62616d626572672e64653125302306092a864886f70d0109011616746563686e696b407377742d62616d626572672e646530820122300d06092a864886f70d
        EAP-Message = 0x01010105000382010f003082010a0282010100b5913179548416c13b821a05c1a61e0232aedcd87c864ca2017e4b9de05aa9122fbe2722f9e02540cbc19d0a81ec1d25362148b63420d93baad596f8684311e6b1ca5849a18e9ae333a937a28098a8d25d4674af4bbfdfabfcf4c08b12d0504675cca1e6e5373585adb1752a582a0e16ae194883f3228b90d605e187a1cb192d3804ec0c203fa4c8953d47e0ded1ed9480895df61e8fed91a7d0b120ab4867244897e424c64e6323e2345031daa86c2f5933385e1ab6c982bac61e02b9b17348a198f5491f44044f72148714e42a97228136d367a874f10c55a6596eb5c228a7506bec16e46a119e6b33
        EAP-Message = 0xb9ed03409bb30203cee744e061eee93ebf3e60778e2f0203010001a317301530130603551d25040c300a06082b06010505070301300d06092a864886f70d01010405000382010100929cda8af67a63249a16f030f3538382e3461133e34d2b3fe6602ffc5c02e8828a1b53bd751da80113a12f09d0d99049f5dd2e65ec6d5bd3b30f2bd5fda99a73837d0b7b50619e0000b2cea05141e2f7dd81ab4483d0d83cf06642f9d4e40de228ccdcfb563c731e2e388a08095d287bc492962b10b34d36d30057c20d21107b7124f277cd0b31fb3327aba00b24465627f6ba23973e584e5b03c23b17d04e10966f19e5b3bcc29021bf38021263e21b0a3b77ece6
        EAP-Message = 0x1c8ffd26c679a465d8d76f3e
        Message-Authenticator = 0x00000000000000000000000000000000
        State = 0xc3f6a313c1ffbaf82dc969b24e44d683
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=215, length=349
        Framed-MTU = 1480
        NAS-IP-Address = 141.13.106.126
        NAS-Identifier = "swtprocurve01"
        User-Name = "winmac\\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 = "c8-bc-c8-96-a3-3e"
        Connect-Info = "CONNECT Ethernet 1000Mbps Full duplex"
        Tunnel-Type:0 = VLAN
        Tunnel-Medium-Type:0 = IEEE-802
        Tunnel-Private-Group-Id:0 = "2049"
        State = 0xc3f6a313c1ffbaf82dc969b24e44d683
        EAP-Message = 0x020900061900
        Message-Authenticator = 0x9bdb6f6b16ec72aac79c80ad005f2fdc
        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] 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 215 to 141.13.106.126 port 48647
        EAP-Message = 0x010a03fc1940acc7d8a4fe4d43198a1372c0bacd525b92a66b9a9ebd138287bff539e1fa97bd669e9bde23bab157c63aeb3543d38ab5566d7f7ee9c4c2d74cc3d3616f75260004d1308204cd308203b5a003020102020900d5b348c26db11232300d06092a864886f70d010105050030819f310b3009060355040613024445310b30090603550408130242593110300e0603550407130742616d6265726731263024060355040a141d556e69766572736974c3a4742042616d62657267204c73742e205357543125302306092a864886f70d0109011616746563686e696b407377742d62616d626572672e646531223020060355040313195357542043
        EAP-Message = 0x6572746966696361746520417574686f72697479301e170d3131303331303130333831355a170d3132303330393130333831355a30819f310b3009060355040613024445310b30090603550408130242593110300e0603550407130742616d6265726731263024060355040a141d556e69766572736974c3a4742042616d62657267204c73742e205357543125302306092a864886f70d0109011616746563686e696b407377742d62616d626572672e6465312230200603550403131953575420436572746966696361746520417574686f7269747930820122300d06092a864886f70d01010105000382010f003082010a0282010100c5746be6f264
        EAP-Message = 0x7175720513f4a597e60a73d937370b712b23d6ff80ceb6adaa69e231bc9a9c8d4133ef87df85ee362759beb15056ae6d38c5ba74d10a4dfb94cfe3ea3fd6e2c570b61a41abe4ff6a9c57e84e5f1fa2e8bfa00baf650127cd458cbda2a14e0661019ac44ea77ad5c8b816c55c6aa5c662bae9fdaa2205a4eecf0b36ba624c6c0c385540e0cd9069cec7675e42ad9b92dcc3eff21d24717704af96ca11eeea6550d2bfc6a6fa95ed46dbe7e707a8999dcfe89071675e740b37e8e2500ec01b66f072b9ca34c725ecff25d0a0caf3c7f18d5f5735cbb8f4193a2be87374c784aee936d65de8a388910b5fe8903c6bdce46ffe946361d3a8bea07279020301
        EAP-Message = 0x0001a382010830820104301d0603551d0e041604145f702bd186c24049f25783fc71b0be2c90564a9d3081d40603551d230481cc3081c980145f702bd186c24049f25783fc71b0be2c90564a9da181a5a481a230819f310b3009060355040613024445310b30090603550408130242593110300e0603550407130742616d6265726731263024060355040a141d556e69766572736974c3a4742042616d62657267204c73742e205357543125302306092a864886f70d0109011616746563686e696b407377742d62616d626572672e6465312230200603550403131953575420436572746966696361746520417574686f72697479820900d5b348c26d
        EAP-Message = 0xb11232300c060355
        Message-Authenticator = 0x00000000000000000000000000000000
        State = 0xc3f6a313c0fcbaf82dc969b24e44d683
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=216, length=349
        Framed-MTU = 1480
        NAS-IP-Address = 141.13.106.126
        NAS-Identifier = "swtprocurve01"
        User-Name = "winmac\\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 = "c8-bc-c8-96-a3-3e"
        Connect-Info = "CONNECT Ethernet 1000Mbps Full duplex"
        Tunnel-Type:0 = VLAN
        Tunnel-Medium-Type:0 = IEEE-802
        Tunnel-Private-Group-Id:0 = "2049"
        State = 0xc3f6a313c0fcbaf82dc969b24e44d683
        EAP-Message = 0x020a00061900
        Message-Authenticator = 0xa746eec1797c55600ad20ba5fe6e87d4
        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 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 216 to 141.13.106.126 port 48647
        EAP-Message = 0x010b012c19001d13040530030101ff300d06092a864886f70d01010505000382010100035d2016161164d50abd6a0e7f451dbc6146b6e5b4c7e9539274acc3abf59d96a3869544dfd82339b97ee41da2dae726a4ca5bdc650628c3002165e3710e2b809ebe6080399fdd13576ccda8fb213f420229798e3b32986f1ead8058f9e9fea31695376b90d4c779d1f32f987d5aca5d2ccd7300907a55efa0ea8ff2bdf64ce5351345691cf55032fe48b75373bc14028b24b6a25c93f480c12887a20a6d44ee74f2f3473a4902cc67ec63581f20f91c3e3672a48e1e1d3188d44d8d7eb5045b32ae5311e7f614a903d7a245d02cd386e8d79cd0df6b69023789
        EAP-Message = 0xc97738eba237890da2e48fe62884cccfb075aa24783bee7dfe071f41aa7efe142e88c26ab2a616030100040e000000
        Message-Authenticator = 0x00000000000000000000000000000000
        State = 0xc3f6a313c7fdbaf82dc969b24e44d683
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=217, length=681
        Framed-MTU = 1480
        NAS-IP-Address = 141.13.106.126
        NAS-Identifier = "swtprocurve01"
        User-Name = "winmac\\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 = "c8-bc-c8-96-a3-3e"
        Connect-Info = "CONNECT Ethernet 1000Mbps Full duplex"
        Tunnel-Type:0 = VLAN
        Tunnel-Medium-Type:0 = IEEE-802
        Tunnel-Private-Group-Id:0 = "2049"
        State = 0xc3f6a313c7fdbaf82dc969b24e44d683
        EAP-Message = 0x020b01501980000001461603010106100001020100a9aa644c76ca3feac7a8820d5dacaf21c707e9611e9e6941cf3294d47bca262c53933160a8fbb134f16ef7bf881bf45d50025b7dae628e62320aab2c1582784f83dfc1389d958db9bf47bc09ca22248afcde1678766e21996643cb1bfc006949ca7cbd2af5d69782a7c8b35725a18e5b8e1523e03b3eda45e998d73cc1d56af9c1ba53cd4d4bcc40881ae3aaad8b7749ce8f77e4042d029d2d00e4add1a94f60ef4ca95fb344dee4a391e962856be9e3ebc10efe85cf251d6d9f3a4b2825e35b7bf3b722c60182d382230031f1177722a0e2d34e19ee5f637840a5a302b458d1ab2fb7860908d12b
        EAP-Message = 0xcc0dfcd40318be86eb5045bd78f991ae943df4c7b58ed503140301000101160301003064db947cedbf0fef72278a5a8ef8dc912cd6b07f826fd4cbb0700ec54fb983d49f2b2cdd819330123f4c2f2840328d44
        Message-Authenticator = 0xf01b30dd0310664546c9b81463ac4680
        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 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 c47a2d5ada38619f5a7f0fc0afc18a4b036b29e67690feefa143072925f35463 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 217 to 141.13.106.126 port 48647
        EAP-Message = 0x010c0041190014030100010116030100305a87aecaf49d346c766863f3c2090d6e235adb78ea51a337b21679db4035d0316f0ce7e40779612a488a8d3e561d9cb6
        Message-Authenticator = 0x00000000000000000000000000000000
        State = 0xc3f6a313c6fabaf82dc969b24e44d683
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=218, length=349
        Framed-MTU = 1480
        NAS-IP-Address = 141.13.106.126
        NAS-Identifier = "swtprocurve01"
        User-Name = "winmac\\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 = "c8-bc-c8-96-a3-3e"
        Connect-Info = "CONNECT Ethernet 1000Mbps Full duplex"
        Tunnel-Type:0 = VLAN
        Tunnel-Medium-Type:0 = IEEE-802
        Tunnel-Private-Group-Id:0 = "2049"
        State = 0xc3f6a313c6fabaf82dc969b24e44d683
        EAP-Message = 0x020c00061900
        Message-Authenticator = 0x5b07c004e66b7638d5a00ec1d988900a
        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 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 218 to 141.13.106.126 port 48647
        EAP-Message = 0x010d002b190017030100204c377b1357dfb99fc5f8dd6d2bcd94095342c124f550812591dce9f98d500bf4
        Message-Authenticator = 0x00000000000000000000000000000000
        State = 0xc3f6a313c5fbbaf82dc969b24e44d683
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=219, length=402
        Framed-MTU = 1480
        NAS-IP-Address = 141.13.106.126
        NAS-Identifier = "swtprocurve01"
        User-Name = "winmac\\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 = "c8-bc-c8-96-a3-3e"
        Connect-Info = "CONNECT Ethernet 1000Mbps Full duplex"
        Tunnel-Type:0 = VLAN
        Tunnel-Medium-Type:0 = IEEE-802
        Tunnel-Private-Group-Id:0 = "2049"
        State = 0xc3f6a313c5fbbaf82dc969b24e44d683
        EAP-Message = 0x020d003b19001703010030b804f2fe75fe2f0e17ba6f72c4d6c72550f30b4adf93b41be4ecc10306a59b3b0c42f582f025c80d5bffd25e6a9a0a66
        Message-Authenticator = 0xe97f29abe3489aa827f97a1fff3b7f13
        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 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 - winmac\tom1
[peap] Got inner identity 'winmac\tom1'
[peap] Setting default EAP type for tunneled EAP session.
[peap] Got tunneled request
        EAP-Message = 0x020d00100177696e6d61635c746f6d31
server  {
  PEAP: Setting User-Name to winmac\tom1
Sending tunneled request
        EAP-Message = 0x020d00100177696e6d61635c746f6d31
        FreeRADIUS-Proxied-To = 127.0.0.1
        User-Name = "winmac\\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 13 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 winmac\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 winmac\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 = 0x010e00251a010e00201063cd3a38b24ef8b88f57c1573c704fc477696e6d61635c746f6d31
        Message-Authenticator = 0x00000000000000000000000000000000
        State = 0x5eec5cb65ee2468609d9967e229a34c4
[peap] Got tunneled reply RADIUS code 11
        EAP-Message = 0x010e00251a010e00201063cd3a38b24ef8b88f57c1573c704fc477696e6d61635c746f6d31
        Message-Authenticator = 0x00000000000000000000000000000000
        State = 0x5eec5cb65ee2468609d9967e229a34c4
[peap] Got tunneled Access-Challenge
++[eap] returns handled
Sending Access-Challenge of id 219 to 141.13.106.126 port 48647
        EAP-Message = 0x010e004b190017030100405e07edc2cc4f2c7f2c2979f2b01fe78e5d78b33d7289d06393edc6ded5cd61d6c33efd44e882265a586640d4b07317c30d70c8d7b011154eb2e95ee70e08261f
        Message-Authenticator = 0x00000000000000000000000000000000
        State = 0xc3f6a313c4f8baf82dc969b24e44d683
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=220, length=434
        Framed-MTU = 1480
        NAS-IP-Address = 141.13.106.126
        NAS-Identifier = "swtprocurve01"
        User-Name = "winmac\\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 = "c8-bc-c8-96-a3-3e"
        Connect-Info = "CONNECT Ethernet 1000Mbps Full duplex"
        Tunnel-Type:0 = VLAN
        Tunnel-Medium-Type:0 = IEEE-802
        Tunnel-Private-Group-Id:0 = "2049"
        State = 0xc3f6a313c4f8baf82dc969b24e44d683
        EAP-Message = 0x020e005b190017030100506724bfba027405236cfabadecc9836354872e0f364dda6b0e9cdadb0c8e642dc100fd4ec21a88e957ee4cacbcd77d992412cea300433c7fddd83ecafda4a183db851c61d02a2bd6651d8f48210d25363
        Message-Authenticator = 0xbbccf6021af4e8ca7d2731cdc746a402
        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 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 = 0x020e003f1a020e003a31499a835753d8ad7de607fc70a4b511d2000000000000000016b28ad5114675b9c6f44d99ea590bf223f6c43e3a5d4f8200746f6d31
server  {
  PEAP: Setting User-Name to winmac\tom1
Sending tunneled request
        EAP-Message = 0x020e003f1a020e003a31499a835753d8ad7de607fc70a4b511d2000000000000000016b28ad5114675b9c6f44d99ea590bf223f6c43e3a5d4f8200746f6d31
        FreeRADIUS-Proxied-To = 127.0.0.1
        User-Name = "winmac\\tom1"
        State = 0x5eec5cb65ee2468609d9967e229a34c4
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 14 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 winmac\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 winmac\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 (winmac\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: [winmac\\tom1] (from client swtswitch01 port 0 via TLS tunnel)
} # server inner-tunnel
[peap] Got tunneled reply code 3
        EAP-Message = 0x040e0004
        Message-Authenticator = 0x00000000000000000000000000000000
[peap] Got tunneled reply RADIUS code 3
        EAP-Message = 0x040e0004
        Message-Authenticator = 0x00000000000000000000000000000000
[peap] Tunneled authentication was rejected.
[peap] FAILURE
++[eap] returns handled
Sending Access-Challenge of id 220 to 141.13.106.126 port 48647
        EAP-Message = 0x010f002b1900170301002009931164a45b02a0f6da742b22b40da1dac4a970fd5f034686aec93fb63979ef
        Message-Authenticator = 0x00000000000000000000000000000000
        State = 0xc3f6a313cbf9baf82dc969b24e44d683
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=221, length=386
        Framed-MTU = 1480
        NAS-IP-Address = 141.13.106.126
        NAS-Identifier = "swtprocurve01"
        User-Name = "winmac\\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 = "c8-bc-c8-96-a3-3e"
        Connect-Info = "CONNECT Ethernet 1000Mbps Full duplex"
        Tunnel-Type:0 = VLAN
        Tunnel-Medium-Type:0 = IEEE-802
        Tunnel-Private-Group-Id:0 = "2049"
        State = 0xc3f6a313cbf9baf82dc969b24e44d683
        EAP-Message = 0x020f002b190017030100209d2656120ac5614883bc0969e5c983a87deef32e987f286934201c0c25af668d
        Message-Authenticator = 0x90f0f21ce36d8ff78835a86bc4680452
        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 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 c47a2d5ada38619f5a7f0fc0afc18a4b036b29e67690feefa143072925f35463 from the cache
[eap] Handler failed in EAP/peap
[eap] Failed in EAP select
++[eap] returns invalid
Failed to authenticate the user.
Login incorrect: [winmac\\tom1] (from client swtswitch01 port 31 cli c8-bc-c8-96-a3-3e)
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 221 to 141.13.106.126 port 48647
        EAP-Message = 0x040f0004
        Message-Authenticator = 0x00000000000000000000000000000000
Waking up in 3.9 seconds.
Cleaning up request 0 ID 212 with timestamp +11
Cleaning up request 1 ID 213 with timestamp +11
Cleaning up request 2 ID 214 with timestamp +11
Cleaning up request 3 ID 215 with timestamp +11
Cleaning up request 4 ID 216 with timestamp +11
Cleaning up request 5 ID 217 with timestamp +11
Cleaning up request 6 ID 218 with timestamp +11
Cleaning up request 7 ID 219 with timestamp +11
Cleaning up request 8 ID 220 with timestamp +11
Waking up in 1.0 seconds.
Cleaning up request 9 ID 221 with timestamp +11
Ready to process requests.


More information about the Freeradius-Users mailing list