iPad PEAP MSCHAPv2
Óscar Remírez de Ganuza Satrústegui
oscarrdg at unav.es
Thu Nov 19 16:54:40 CET 2015
Sorry, it got clipped...
I send again requests #10 and #11 (the last one):
(10) Received Access-Request Id 92 from xxxxxx:45903 to xxx12.225:1812
length 264
(10) User-Name = "oscarrdg at unav.es"
(10) NAS-IP-Address = xxxxxx
(10) NAS-Port = 0
(10) NAS-Identifier = "xxxxxx"
(10) NAS-Port-Type = Wireless-802.11
(10) Calling-Station-Id = "344DF73C9C98"
(10) Called-Station-Id = "001A1E003250"
(10) Service-Type = Framed-User
(10) Framed-MTU = 1100
(10) EAP-Message =
0x020b00341900170303002900000000000000019b4ab8036a75b9c14b9fbef72722cf152e7eae150e66cd2df891b0db7b49041513
(10) State = 0x4a7c50d94377497df1395bb8ee5037b2
(10) Aruba-Essid-Name = "eduroam-pre"
(10) Aruba-Location-Id = "10.9.1"
(10) Aruba-AP-Group = "Amigos"
(10) Aruba-Device-Type = "Android"
(10) Message-Authenticator = 0x3ed798db1779514513dd6cf8a43755bc
(10) session-state: No cached attributes
(10) # Executing section authorize from file
/usr/local/etc2/freeradius/etc/raddb/sites-enabled/default
(10) authorize {
(10) policy filter_username {
(10) if (!&User-Name) {
(10) if (!&User-Name) -> FALSE
(10) if (&User-Name =~ / /) {
(10) if (&User-Name =~ / /) -> FALSE
(10) if (&User-Name =~ /@.*@/ ) {
(10) if (&User-Name =~ /@.*@/ ) -> FALSE
(10) if (&User-Name =~ /\.\./ ) {
(10) if (&User-Name =~ /\.\./ ) -> FALSE
(10) if ((&User-Name =~ /@/) && (&User-Name !~ /@(.+)\.(.+)$/)) {
(10) if ((&User-Name =~ /@/) && (&User-Name !~ /@(.+)\.(.+)$/)) ->
FALSE
(10) if (&User-Name =~ /\.$/) {
(10) if (&User-Name =~ /\.$/) -> FALSE
(10) if (&User-Name =~ /@\./) {
(10) if (&User-Name =~ /@\./) -> FALSE
(10) } # policy filter_username = notfound
(10) [preprocess] = ok
(10) auth_log: EXPAND
/usr/local/etc2/freeradius/var/log/radius/radacct/%{%{Packet-Src-IP-Address}:-%{Packet-Src-IPv6-Address}}/auth-detail-%Y%m%d
(10) auth_log: -->
/usr/local/etc2/freeradius/var/log/radius/radacct/xxxxxx/auth-detail-20151119
(10) auth_log:
/usr/local/etc2/freeradius/var/log/radius/radacct/%{%{Packet-Src-IP-Address}:-%{Packet-Src-IPv6-Address}}/auth-detail-%Y%m%d
expands to
/usr/local/etc2/freeradius/var/log/radius/radacct/xxxxxx/auth-detail-20151119
(10) auth_log: EXPAND %t
(10) auth_log: --> Thu Nov 19 16:13:11 2015
(10) [auth_log] = ok
(10) [chap] = noop
(10) [mschap] = noop
(10) [digest] = noop
(10) suffix: Checking for suffix after "@"
(10) suffix: Looking up realm "unav.es" for User-Name = "oscarrdg at unav.es"
(10) suffix: Found realm "~^(.*\.)?unav\.es$"
(10) suffix: Adding Stripped-User-Name = "oscarrdg"
(10) suffix: Adding Realm = "unav.es"
(10) suffix: Authentication realm is LOCAL
(10) [suffix] = ok
(10) ntdomain: Request already has destination realm set. Ignoring
(10) [ntdomain] = noop
(10) eap: Peer sent EAP Response (code 2) ID 11 length 52
(10) eap: Continuing tunnel setup
(10) [eap] = ok
(10) } # authorize = ok
(10) Found Auth-Type = EAP
(10) # Executing group from file
/usr/local/etc2/freeradius/etc/raddb/sites-enabled/default
(10) authenticate {
(10) eap: Expiring EAP session with state 0x4a7c50d94377497d
(10) eap: Finished EAP session with state 0x4a7c50d94377497d
(10) eap: Previous EAP request found for state 0x4a7c50d94377497d, released
from the list
(10) eap: Peer sent packet with method EAP PEAP (25)
(10) eap: Calling submodule eap_peap to process data
(10) eap_peap: Continuing EAP-TLS
(10) eap_peap: [eaptls verify] = ok
(10) eap_peap: Done initial handshake
(10) eap_peap: [eaptls process] = ok
(10) eap_peap: Session established. Decoding tunneled attributes
(10) eap_peap: PEAP state WAITING FOR INNER IDENTITY
(10) eap_peap: Identity - oscarrdg at unav.es
(10) eap_peap: Got inner identity 'oscarrdg at unav.es'
(10) eap_peap: Setting default EAP type for tunneled EAP session
(10) eap_peap: Got tunneled request
(10) eap_peap: EAP-Message = 0x020b0015016f7363617272646740756e61762e6573
(10) eap_peap: Setting User-Name to oscarrdg at unav.es
(10) eap_peap: Sending tunneled request to inner-tunnel
(10) eap_peap: EAP-Message = 0x020b0015016f7363617272646740756e61762e6573
(10) eap_peap: FreeRADIUS-Proxied-To = 127.0.0.1
(10) eap_peap: User-Name = "oscarrdg at unav.es"
(10) eap_peap: NAS-IP-Address = xxxxxx
(10) eap_peap: NAS-Port = 0
(10) eap_peap: NAS-Identifier = "xxxxxx"
(10) eap_peap: NAS-Port-Type = Wireless-802.11
(10) eap_peap: Calling-Station-Id = "344DF73C9C98"
(10) eap_peap: Called-Station-Id = "001A1E003250"
(10) eap_peap: Service-Type = Framed-User
(10) eap_peap: Framed-MTU = 1100
(10) eap_peap: Aruba-Essid-Name = "eduroam-pre"
(10) eap_peap: Aruba-Location-Id = "10.9.1"
(10) eap_peap: Aruba-AP-Group = "Amigos"
(10) eap_peap: Aruba-Device-Type = "Android"
(10) eap_peap: Event-Timestamp = "Nov 19 2015 16:13:11 CET"
(10) Virtual server inner-tunnel received request
(10) EAP-Message = 0x020b0015016f7363617272646740756e61762e6573
(10) FreeRADIUS-Proxied-To = 127.0.0.1
(10) User-Name = "oscarrdg at unav.es"
(10) NAS-IP-Address = xxxxxx
(10) NAS-Port = 0
(10) NAS-Identifier = "xxxxxx"
(10) NAS-Port-Type = Wireless-802.11
(10) Calling-Station-Id = "344DF73C9C98"
(10) Called-Station-Id = "001A1E003250"
(10) Service-Type = Framed-User
(10) Framed-MTU = 1100
(10) Aruba-Essid-Name = "eduroam-pre"
(10) Aruba-Location-Id = "10.9.1"
(10) Aruba-AP-Group = "Amigos"
(10) Aruba-Device-Type = "Android"
(10) Event-Timestamp = "Nov 19 2015 16:13:11 CET"
(10) server inner-tunnel {
(10) # Executing section authorize from file
/usr/local/etc2/freeradius/etc/raddb/sites-enabled/inner-tunnel
(10) authorize {
(10) [chap] = noop
(10) [mschap] = noop
(10) suffix: Checking for suffix after "@"
(10) suffix: Looking up realm "unav.es" for User-Name = "oscarrdg at unav.es"
(10) suffix: Found realm "~^(.*\.)?unav\.es$"
(10) suffix: Adding Stripped-User-Name = "oscarrdg"
(10) suffix: Adding Realm = "unav.es"
(10) suffix: Authentication realm is LOCAL
(10) [suffix] = ok
(10) ntdomain: Request already has destination realm set. Ignoring
(10) [ntdomain] = noop
(10) update control {
(10) &Proxy-To-Realm := LOCAL
(10) } # update control = noop
(10) eap: Peer sent EAP Response (code 2) ID 11 length 21
(10) eap: EAP-Identity reply, returning 'ok' so we can short-circuit the
rest of authorize
(10) [eap] = ok
(10) } # authorize = ok
(10) Found Auth-Type = EAP
(10) # Executing group from file
/usr/local/etc2/freeradius/etc/raddb/sites-enabled/inner-tunnel
(10) authenticate {
(10) eap: Peer sent packet with method EAP Identity (1)
(10) eap: Calling submodule eap_mschapv2 to process data
(10) eap_mschapv2: Issuing Challenge
(10) eap: Sending EAP Request (code 1) ID 12 length 43
(10) eap: EAP session adding &reply:State = 0x739669f1739a7348
(10) [eap] = handled
(10) } # authenticate = handled
(10) } # server inner-tunnel
(10) Virtual server sending reply
(10) EAP-Message =
0x010c002b1a010c0026109be6bd2966f7837a669e8c6ec412fec8667265657261646975732d332e302e3130
(10) Message-Authenticator = 0x00000000000000000000000000000000
(10) State = 0x739669f1739a7348a02455fb687f2caa
(10) eap_peap: Got tunneled reply code 11
(10) eap_peap: EAP-Message =
0x010c002b1a010c0026109be6bd2966f7837a669e8c6ec412fec8667265657261646975732d332e302e3130
(10) eap_peap: Message-Authenticator = 0x00000000000000000000000000000000
(10) eap_peap: State = 0x739669f1739a7348a02455fb687f2caa
(10) eap_peap: Got tunneled reply RADIUS code 11
(10) eap_peap: EAP-Message =
0x010c002b1a010c0026109be6bd2966f7837a669e8c6ec412fec8667265657261646975732d332e302e3130
(10) eap_peap: Message-Authenticator = 0x00000000000000000000000000000000
(10) eap_peap: State = 0x739669f1739a7348a02455fb687f2caa
(10) eap_peap: Got tunneled Access-Challenge
(10) eap: Sending EAP Request (code 1) ID 12 length 74
(10) eap: EAP session adding &reply:State = 0x4a7c50d94070497d
(10) [eap] = handled
(10) } # authenticate = handled
(10) Using Post-Auth-Type Challenge
(10) Post-Auth-Type sub-section not found. Ignoring.
(10) # Executing group from file
/usr/local/etc2/freeradius/etc/raddb/sites-enabled/default
(10) Sent Access-Challenge Id 92 from xxx12.225:1812 to xxxxxx:45903 length
0
(10) EAP-Message =
0x010c004a1900170303003f6a2a84ab3ae80e6445376747acac3a67092800521bd121ed59a9f1d8a3e4558a30aea29eae313c5e6b4befec0d80e2fbdd0f7c8ce5d3d791f671f36e56facd
(10) Message-Authenticator = 0x00000000000000000000000000000000
(10) State = 0x4a7c50d94070497df1395bb8ee5037b2
(10) Finished request
Waking up in 4.8 seconds.
(11) Received Access-Request Id 240 from xxxxxx:45903 to xxx12.225:1812
length 318
(11) User-Name = "oscarrdg at unav.es"
(11) NAS-IP-Address = xxxxxx
(11) NAS-Port = 0
(11) NAS-Identifier = "xxxxxx"
(11) NAS-Port-Type = Wireless-802.11
(11) Calling-Station-Id = "344DF73C9C98"
(11) Called-Station-Id = "001A1E003250"
(11) Service-Type = Framed-User
(11) Framed-MTU = 1100
(11) EAP-Message =
0x020c006a1900170303005f000000000000000253f426d0e803b2f101d786b3751058056be43652b9dfc3ef648ed4fa31005509bd18cfeea0fae8d7c1e20a69507c7355e0f78b6d034f70f812ce1d73e78815d519b082725844b86344c1ae97ccd9d6232d64a6c67831e3
(11) State = 0x4a7c50d94070497df1395bb8ee5037b2
(11) Aruba-Essid-Name = "eduroam-pre"
(11) Aruba-Location-Id = "10.9.1"
(11) Aruba-AP-Group = "Amigos"
(11) Aruba-Device-Type = "Android"
(11) Message-Authenticator = 0xfc041f435db6453937530e6ad7ad9998
(11) session-state: No cached attributes
(11) # Executing section authorize from file
/usr/local/etc2/freeradius/etc/raddb/sites-enabled/default
(11) authorize {
(11) policy filter_username {
(11) if (!&User-Name) {
(11) if (!&User-Name) -> FALSE
(11) if (&User-Name =~ / /) {
(11) if (&User-Name =~ / /) -> FALSE
(11) if (&User-Name =~ /@.*@/ ) {
(11) if (&User-Name =~ /@.*@/ ) -> FALSE
(11) if (&User-Name =~ /\.\./ ) {
(11) if (&User-Name =~ /\.\./ ) -> FALSE
(11) if ((&User-Name =~ /@/) && (&User-Name !~ /@(.+)\.(.+)$/)) {
(11) if ((&User-Name =~ /@/) && (&User-Name !~ /@(.+)\.(.+)$/)) ->
FALSE
(11) if (&User-Name =~ /\.$/) {
(11) if (&User-Name =~ /\.$/) -> FALSE
(11) if (&User-Name =~ /@\./) {
(11) if (&User-Name =~ /@\./) -> FALSE
(11) } # policy filter_username = notfound
(11) [preprocess] = ok
(11) auth_log: EXPAND
/usr/local/etc2/freeradius/var/log/radius/radacct/%{%{Packet-Src-IP-Address}:-%{Packet-Src-IPv6-Address}}/auth-detail-%Y%m%d
(11) auth_log: -->
/usr/local/etc2/freeradius/var/log/radius/radacct/xxxxxx/auth-detail-20151119
(11) auth_log:
/usr/local/etc2/freeradius/var/log/radius/radacct/%{%{Packet-Src-IP-Address}:-%{Packet-Src-IPv6-Address}}/auth-detail-%Y%m%d
expands to
/usr/local/etc2/freeradius/var/log/radius/radacct/xxxxxx/auth-detail-20151119
(11) auth_log: EXPAND %t
(11) auth_log: --> Thu Nov 19 16:13:11 2015
(11) [auth_log] = ok
(11) [chap] = noop
(11) [mschap] = noop
(11) [digest] = noop
(11) suffix: Checking for suffix after "@"
(11) suffix: Looking up realm "unav.es" for User-Name = "oscarrdg at unav.es"
(11) suffix: Found realm "~^(.*\.)?unav\.es$"
(11) suffix: Adding Stripped-User-Name = "oscarrdg"
(11) suffix: Adding Realm = "unav.es"
(11) suffix: Authentication realm is LOCAL
(11) [suffix] = ok
(11) ntdomain: Request already has destination realm set. Ignoring
(11) [ntdomain] = noop
(11) eap: Peer sent EAP Response (code 2) ID 12 length 106
(11) eap: Continuing tunnel setup
(11) [eap] = ok
(11) } # authorize = ok
(11) Found Auth-Type = EAP
(11) # Executing group from file
/usr/local/etc2/freeradius/etc/raddb/sites-enabled/default
(11) authenticate {
(11) eap: Expiring EAP session with state 0x739669f1739a7348
(11) eap: Finished EAP session with state 0x4a7c50d94070497d
(11) eap: Previous EAP request found for state 0x4a7c50d94070497d, released
from the list
(11) eap: Peer sent packet with method EAP PEAP (25)
(11) eap: Calling submodule eap_peap to process data
(11) eap_peap: Continuing EAP-TLS
(11) eap_peap: [eaptls verify] = ok
(11) eap_peap: Done initial handshake
(11) eap_peap: [eaptls process] = ok
(11) eap_peap: Session established. Decoding tunneled attributes
(11) eap_peap: PEAP state phase2
(11) eap_peap: EAP method MSCHAPv2 (26)
(11) eap_peap: Got tunneled request
(11) eap_peap: EAP-Message =
0x020c004b1a020c00463116ba4ea3b0d512edfb61cc1111d4f2310000000000000000d4ced6b15b809861069531ec2cb89e3001db98c94f9018e8006f7363617272646740756e61762e6573
(11) eap_peap: Setting User-Name to oscarrdg at unav.es
(11) eap_peap: Sending tunneled request to inner-tunnel
(11) eap_peap: EAP-Message =
0x020c004b1a020c00463116ba4ea3b0d512edfb61cc1111d4f2310000000000000000d4ced6b15b809861069531ec2cb89e3001db98c94f9018e8006f7363617272646740756e61762e6573
(11) eap_peap: FreeRADIUS-Proxied-To = 127.0.0.1
(11) eap_peap: User-Name = "oscarrdg at unav.es"
(11) eap_peap: State = 0x739669f1739a7348a02455fb687f2caa
(11) eap_peap: NAS-IP-Address = xxxxxx
(11) eap_peap: NAS-Port = 0
(11) eap_peap: NAS-Identifier = "xxxxxx"
(11) eap_peap: NAS-Port-Type = Wireless-802.11
(11) eap_peap: Calling-Station-Id = "344DF73C9C98"
(11) eap_peap: Called-Station-Id = "001A1E003250"
(11) eap_peap: Service-Type = Framed-User
(11) eap_peap: Framed-MTU = 1100
(11) eap_peap: Aruba-Essid-Name = "eduroam-pre"
(11) eap_peap: Aruba-Location-Id = "10.9.1"
(11) eap_peap: Aruba-AP-Group = "Amigos"
(11) eap_peap: Aruba-Device-Type = "Android"
(11) eap_peap: Event-Timestamp = "Nov 19 2015 16:13:11 CET"
(11) Virtual server inner-tunnel received request
(11) EAP-Message =
0x020c004b1a020c00463116ba4ea3b0d512edfb61cc1111d4f2310000000000000000d4ced6b15b809861069531ec2cb89e3001db98c94f9018e8006f7363617272646740756e61762e6573
(11) FreeRADIUS-Proxied-To = 127.0.0.1
(11) User-Name = "oscarrdg at unav.es"
(11) State = 0x739669f1739a7348a02455fb687f2caa
(11) NAS-IP-Address = xxxxxx
(11) NAS-Port = 0
(11) NAS-Identifier = "xxxxxx"
(11) NAS-Port-Type = Wireless-802.11
(11) Calling-Station-Id = "344DF73C9C98"
(11) Called-Station-Id = "001A1E003250"
(11) Service-Type = Framed-User
(11) Framed-MTU = 1100
(11) Aruba-Essid-Name = "eduroam-pre"
(11) Aruba-Location-Id = "10.9.1"
(11) Aruba-AP-Group = "Amigos"
(11) Aruba-Device-Type = "Android"
(11) Event-Timestamp = "Nov 19 2015 16:13:11 CET"
(11) server inner-tunnel {
(11) session-state: No cached attributes
(11) # Executing section authorize from file
/usr/local/etc2/freeradius/etc/raddb/sites-enabled/inner-tunnel
(11) authorize {
(11) [chap] = noop
(11) [mschap] = noop
(11) suffix: Checking for suffix after "@"
(11) suffix: Looking up realm "unav.es" for User-Name = "oscarrdg at unav.es"
(11) suffix: Found realm "~^(.*\.)?unav\.es$"
(11) suffix: Adding Stripped-User-Name = "oscarrdg"
(11) suffix: Adding Realm = "unav.es"
(11) suffix: Authentication realm is LOCAL
(11) [suffix] = ok
(11) ntdomain: Request already has destination realm set. Ignoring
(11) [ntdomain] = noop
(11) update control {
(11) &Proxy-To-Realm := LOCAL
(11) } # update control = noop
(11) eap: Peer sent EAP Response (code 2) ID 12 length 75
(11) eap: No EAP Start, assuming it's an on-going EAP conversation
(11) [eap] = updated
(11) policy unav.authorize.inner {
(11) if ( "%{client:group}" == 'wireless' ) {
(11) EXPAND %{client:group}
(11) --> wireless
(11) if ( "%{client:group}" == 'wireless' ) -> TRUE
(11) if ( "%{client:group}" == 'wireless' ) {
(11) policy unav.reject.otherdomain {
(11) if ( Realm == "NULL" || Realm =~ /^(.*\.)?unav\.es$/ ||
Realm == "UNAV-PDC-01" ) {
(11) if ( Realm == "NULL" || Realm =~ /^(.*\.)?unav\.es$/ ||
Realm == "UNAV-PDC-01" ) -> TRUE
(11) ( Realm == "NULL" || Realm =~ /^(.*\.)?unav\.es$/ || Realm
== "UNAV-PDC-01" ) { ... } # empty sub-section is ignored
(11) ... skipping else for request 11: Preceding "if" was taken
(11) } # policy unav.reject.otherdomain = updated
(11) policy unav.reject.bloqueado {
(11) if ( Ldap-Group == "unav.radius.bloqueado" ) {
(11) Searching for user in group "unav.radius.bloqueado"
rlm_ldap (ldap): Reserved connection (0)
(11) EXPAND (uid=%{%{Stripped-User-Name}:-%{User-Name}})
(11) --> (uid=oscarrdg)
(11) Performing search in "ou=radius,o=accounts,dc=unav,dc=es"
with filter "(uid=oscarrdg)", scope "sub"
(11) Waiting for search result...
(11) User object found at DN
"uid=oscarrdg,ou=radius,o=accounts,dc=unav,dc=es"
(11) Checking user object's member attributes
(11) Performing unfiltered search in
"uid=oscarrdg,ou=radius,o=accounts,dc=unav,dc=es", scope "base"
(11) Waiting for search result...
(11) Processing member value
"uid=unav.radius.vpn.ssl,ou=groups,ou=radius,o=accounts,dc=unav,dc=es" as a
DN
(11) Resolving group DN
"uid=unav.radius.vpn.ssl,ou=groups,ou=radius,o=accounts,dc=unav,dc=es" to
group name
(11) Performing unfiltered search in
"uid=unav.radius.vpn.ssl,ou=groups,ou=radius,o=accounts,dc=unav,dc=es",
scope "base"
(11) Waiting for search result...
(11) Group DN
"uid=unav.radius.vpn.ssl,ou=groups,ou=radius,o=accounts,dc=unav,dc=es"
resolves to name "unav.radius.vpn.ssl"
(11) Processing member value
"uid=unav.radius.eapol.n1,ou=groups,ou=radius,o=accounts,dc=unav,dc=es" as
a DN
(11) Resolving group DN
"uid=unav.radius.eapol.n1,ou=groups,ou=radius,o=accounts,dc=unav,dc=es" to
group name
(11) Performing unfiltered search in
"uid=unav.radius.eapol.n1,ou=groups,ou=radius,o=accounts,dc=unav,dc=es",
scope "base"
(11) Waiting for search result...
(11) Group DN
"uid=unav.radius.eapol.n1,ou=groups,ou=radius,o=accounts,dc=unav,dc=es"
resolves to name "unav.radius.eapol.n1"
(11) Processing member value
"uid=unav.radius.wifi.n1,ou=groups,ou=radius,o=accounts,dc=unav,dc=es" as a
DN
(11) Resolving group DN
"uid=unav.radius.wifi.n1,ou=groups,ou=radius,o=accounts,dc=unav,dc=es" to
group name
(11) Performing unfiltered search in
"uid=unav.radius.wifi.n1,ou=groups,ou=radius,o=accounts,dc=unav,dc=es",
scope "base"
(11) Waiting for search result...
(11) Group DN
"uid=unav.radius.wifi.n1,ou=groups,ou=radius,o=accounts,dc=unav,dc=es"
resolves to name "unav.radius.wifi.n1"
(11) Processing member value
"uid=unav.radius.vpn.ssl.si,ou=groups,ou=radius,o=accounts,dc=unav,dc=es"
as a DN
(11) Resolving group DN
"uid=unav.radius.vpn.ssl.si,ou=groups,ou=radius,o=accounts,dc=unav,dc=es"
to group name
(11) Performing unfiltered search in "uid=
unav.radius.vpn.ssl.si,ou=groups,ou=radius,o=accounts,dc=unav,dc=es", scope
"base"
(11) Waiting for search result...
(11) Group DN
"uid=unav.radius.vpn.ssl.si,ou=groups,ou=radius,o=accounts,dc=unav,dc=es"
resolves to name "unav.radius.vpn.ssl.si"
(11) Processing member value
"uid=unav.radius.vpn.ipsec,ou=groups,ou=radius,o=accounts,dc=unav,dc=es" as
a DN
(11) Resolving group DN
"uid=unav.radius.vpn.ipsec,ou=groups,ou=radius,o=accounts,dc=unav,dc=es" to
group name
(11) Performing unfiltered search in
"uid=unav.radius.vpn.ipsec,ou=groups,ou=radius,o=accounts,dc=unav,dc=es",
scope "base"
(11) Waiting for search result...
(11) Group DN
"uid=unav.radius.vpn.ipsec,ou=groups,ou=radius,o=accounts,dc=unav,dc=es"
resolves to name "unav.radius.vpn.ipsec"
rlm_ldap (ldap): Released connection (0)
rlm_ldap (ldap): Need 5 more connections to reach 10 spares
rlm_ldap (ldap): Opening additional connection (5), 1 of 27 pending slots
used
rlm_ldap (ldap): Connecting to ldap://ldap.unav.es:389
TLS: certificate [CN=AddTrust External CA Root,OU=AddTrust External TTP
Network,O=AddTrust AB,C=SE] is not valid - error -8172:Peer's certificate
issuer has been marked as not trusted by the user..
rlm_ldap (ldap): Waiting for bind result...
rlm_ldap (ldap): Bind successful
(11) User is not a member of "unav.radius.bloqueado"
(11) if ( Ldap-Group == "unav.radius.bloqueado" ) -> FALSE
(11) } # policy unav.reject.bloqueado = updated
rlm_ldap (ldap): Reserved connection (1)
(11) ldap: EXPAND (uid=%{%{Stripped-User-Name}:-%{User-Name}})
(11) ldap: --> (uid=oscarrdg)
(11) ldap: Performing search in "ou=radius,o=accounts,dc=unav,dc=es" with
filter "(uid=oscarrdg)", scope "sub"
(11) ldap: Waiting for search result...
(11) ldap: User object found at DN
"uid=oscarrdg,ou=radius,o=accounts,dc=unav,dc=es"
(11) ldap: Processing user attributes
(11) ldap: control:Password-With-Header +=
'{sha}0sURRyN1nxp/BMx+Q5nBqwR7CB0='
rlm_ldap (ldap): Released connection (1)
(11) [ldap] = updated
(11) update reply {
(11) EXPAND %{request:User-Name}
(11) --> oscarrdg at unav.es
(11) &User-Name = oscarrdg at unav.es
(11) } # update reply = noop
(11) if ( Ldap-Group == "unav.radius.wifi.all" ) {
(11) Searching for user in group "unav.radius.wifi.all"
rlm_ldap (ldap): Reserved connection (2)
(11) Using user DN from request
"uid=oscarrdg,ou=radius,o=accounts,dc=unav,dc=es"
(11) Checking user object's member attributes
(11) Performing unfiltered search in
"uid=oscarrdg,ou=radius,o=accounts,dc=unav,dc=es", scope "base"
(11) Waiting for search result...
(11) Processing member value
"uid=unav.radius.vpn.ssl,ou=groups,ou=radius,o=accounts,dc=unav,dc=es" as a
DN
(11) Resolving group DN
"uid=unav.radius.vpn.ssl,ou=groups,ou=radius,o=accounts,dc=unav,dc=es" to
group name
(11) Performing unfiltered search in
"uid=unav.radius.vpn.ssl,ou=groups,ou=radius,o=accounts,dc=unav,dc=es",
scope "base"
(11) Waiting for search result...
(11) Group DN
"uid=unav.radius.vpn.ssl,ou=groups,ou=radius,o=accounts,dc=unav,dc=es"
resolves to name "unav.radius.vpn.ssl"
(11) Processing member value
"uid=unav.radius.eapol.n1,ou=groups,ou=radius,o=accounts,dc=unav,dc=es" as
a DN
(11) Resolving group DN
"uid=unav.radius.eapol.n1,ou=groups,ou=radius,o=accounts,dc=unav,dc=es" to
group name
(11) Performing unfiltered search in
"uid=unav.radius.eapol.n1,ou=groups,ou=radius,o=accounts,dc=unav,dc=es",
scope "base"
(11) Waiting for search result...
(11) Group DN
"uid=unav.radius.eapol.n1,ou=groups,ou=radius,o=accounts,dc=unav,dc=es"
resolves to name "unav.radius.eapol.n1"
(11) Processing member value
"uid=unav.radius.wifi.n1,ou=groups,ou=radius,o=accounts,dc=unav,dc=es" as a
DN
(11) Resolving group DN
"uid=unav.radius.wifi.n1,ou=groups,ou=radius,o=accounts,dc=unav,dc=es" to
group name
(11) Performing unfiltered search in
"uid=unav.radius.wifi.n1,ou=groups,ou=radius,o=accounts,dc=unav,dc=es",
scope "base"
(11) Waiting for search result...
(11) Group DN
"uid=unav.radius.wifi.n1,ou=groups,ou=radius,o=accounts,dc=unav,dc=es"
resolves to name "unav.radius.wifi.n1"
(11) Processing member value
"uid=unav.radius.vpn.ssl.si,ou=groups,ou=radius,o=accounts,dc=unav,dc=es"
as a DN
(11) Resolving group DN
"uid=unav.radius.vpn.ssl.si,ou=groups,ou=radius,o=accounts,dc=unav,dc=es"
to group name
(11) Performing unfiltered search in
"uid=unav.radius.vpn.ssl.si,ou=groups,ou=radius,o=accounts,dc=unav,dc=es",
scope "base"
(11) Waiting for search result...
(11) Group DN
"uid=unav.radius.vpn.ssl.si,ou=groups,ou=radius,o=accounts,dc=unav,dc=es"
resolves to name "unav.radius.vpn.ssl.si"
(11) Processing member value
"uid=unav.radius.vpn.ipsec,ou=groups,ou=radius,o=accounts,dc=unav,dc=es" as
a DN
(11) Resolving group DN
"uid=unav.radius.vpn.ipsec,ou=groups,ou=radius,o=accounts,dc=unav,dc=es" to
group name
(11) Performing unfiltered search in
"uid=unav.radius.vpn.ipsec,ou=groups,ou=radius,o=accounts,dc=unav,dc=es",
scope "base"
(11) Waiting for search result...
(11) Group DN
"uid=unav.radius.vpn.ipsec,ou=groups,ou=radius,o=accounts,dc=unav,dc=es"
resolves to name "unav.radius.vpn.ipsec"
rlm_ldap (ldap): Released connection (2)
(11) User is not a member of "unav.radius.wifi.all"
(11) if ( Ldap-Group == "unav.radius.wifi.all" ) -> FALSE
(11) elsif ( Ldap-Group == "unav.radius.wifi.n1" ) {
(11) Searching for user in group "unav.radius.wifi.n1"
rlm_ldap (ldap): Reserved connection (3)
(11) Using user DN from request
"uid=oscarrdg,ou=radius,o=accounts,dc=unav,dc=es"
(11) Checking user object's member attributes
(11) Performing unfiltered search in
"uid=oscarrdg,ou=radius,o=accounts,dc=unav,dc=es", scope "base"
(11) Waiting for search result...
(11) Processing member value
"uid=unav.radius.vpn.ssl,ou=groups,ou=radius,o=accounts,dc=unav,dc=es" as a
DN
(11) Resolving group DN
"uid=unav.radius.vpn.ssl,ou=groups,ou=radius,o=accounts,dc=unav,dc=es" to
group name
(11) Performing unfiltered search in
"uid=unav.radius.vpn.ssl,ou=groups,ou=radius,o=accounts,dc=unav,dc=es",
scope "base"
(11) Waiting for search result...
(11) Group DN
"uid=unav.radius.vpn.ssl,ou=groups,ou=radius,o=accounts,dc=unav,dc=es"
resolves to name "unav.radius.vpn.ssl"
(11) Processing member value
"uid=unav.radius.eapol.n1,ou=groups,ou=radius,o=accounts,dc=unav,dc=es" as
a DN
(11) Resolving group DN
"uid=unav.radius.eapol.n1,ou=groups,ou=radius,o=accounts,dc=unav,dc=es" to
group name
(11) Performing unfiltered search in
"uid=unav.radius.eapol.n1,ou=groups,ou=radius,o=accounts,dc=unav,dc=es",
scope "base"
(11) Waiting for search result...
(11) Group DN
"uid=unav.radius.eapol.n1,ou=groups,ou=radius,o=accounts,dc=unav,dc=es"
resolves to name "unav.radius.eapol.n1"
(11) Processing member value
"uid=unav.radius.wifi.n1,ou=groups,ou=radius,o=accounts,dc=unav,dc=es" as a
DN
(11) Resolving group DN
"uid=unav.radius.wifi.n1,ou=groups,ou=radius,o=accounts,dc=unav,dc=es" to
group name
(11) Performing unfiltered search in
"uid=unav.radius.wifi.n1,ou=groups,ou=radius,o=accounts,dc=unav,dc=es",
scope "base"
(11) Waiting for search result...
(11) Group DN
"uid=unav.radius.wifi.n1,ou=groups,ou=radius,o=accounts,dc=unav,dc=es"
resolves to name "unav.radius.wifi.n1"
(11) User found in group "unav.radius.wifi.n1". Comparison
between membership: name (resolved from DN
"uid=unav.radius.wifi.n1,ou=groups,ou=radius,o=accounts,dc=unav,d?"),
check: name
rlm_ldap (ldap): Released connection (3)
(11) elsif ( Ldap-Group == "unav.radius.wifi.n1" ) -> TRUE
(11) elsif ( Ldap-Group == "unav.radius.wifi.n1" ) {
(11) update reply {
(11) &Reply-Message += 'role.n1'
(11) &Aruba-User-Role := 'role.n1'
(11) } # update reply = noop
(11) } # elsif ( Ldap-Group == "unav.radius.wifi.n1" ) = noop
(11) ... skipping elsif for request 11: Preceding "if" was taken
(11) ... skipping elsif for request 11: Preceding "if" was taken
(11) ... skipping elsif for request 11: Preceding "if" was taken
(11) ... skipping elsif for request 11: Preceding "if" was taken
(11) ... skipping elsif for request 11: Preceding "if" was taken
(11) ... skipping elsif for request 11: Preceding "if" was taken
(11) ... skipping elsif for request 11: Preceding "if" was taken
(11) ... skipping else for request 11: Preceding "if" was taken
(11) } # if ( "%{client:group}" == 'wireless' ) = updated
(11) ... skipping elsif for request 11: Preceding "if" was taken
(11) ... skipping elsif for request 11: Preceding "if" was taken
(11) ... skipping else for request 11: Preceding "if" was taken
(11) } # policy unav.authorize.inner = updated
(11) [expiration] = noop
(11) [logintime] = noop
(11) pap: Converted: Password-With-Header -> SHA1-Password
(11) pap: Removing &control:Password-With-Header
(11) pap: Normalizing SHA1-Password from base64 encoding, 28 bytes -> 20
bytes
(11) pap: WARNING: Auth-Type already set. Not setting to PAP
(11) [pap] = noop
(11) if (control:Cleartext-Password) {
(11) if (control:Cleartext-Password) -> FALSE
(11) } # authorize = updated
(11) Found Auth-Type = EAP
(11) # Executing group from file
/usr/local/etc2/freeradius/etc/raddb/sites-enabled/inner-tunnel
(11) authenticate {
(11) eap: Expiring EAP session with state 0x739669f1739a7348
(11) eap: Finished EAP session with state 0x739669f1739a7348
(11) eap: Previous EAP request found for state 0x739669f1739a7348, released
from the list
(11) eap: Peer sent packet with method EAP MSCHAPv2 (26)
(11) eap: Calling submodule eap_mschapv2 to process data
(11) eap_mschapv2: # Executing group from file
/usr/local/etc2/freeradius/etc/raddb/sites-enabled/inner-tunnel
(11) eap_mschapv2: Auth-Type MS-CHAP {
(11) mschap: Creating challenge hash with username: oscarrdg at unav.es
(11) mschap: Client is using MS-CHAPv2
(11) mschap: Executing: /usr/bin/ntlm_auth --request-nt-key
--username=%{%{Stripped-User-Name}:-%{%{User-Name}:-None}}
--challenge=%{%{mschap:Challenge}:-00}
--nt-response=%{%{mschap:NT-Response}:-00}:
(11) mschap: EXPAND
--username=%{%{Stripped-User-Name}:-%{%{User-Name}:-None}}
(11) mschap: --> --username=oscarrdg
(11) mschap: Creating challenge hash with username: oscarrdg at unav.es
(11) mschap: EXPAND --challenge=%{%{mschap:Challenge}:-00}
(11) mschap: --> --challenge=c159f634076ecce6
(11) mschap: EXPAND --nt-response=%{%{mschap:NT-Response}:-00}
(11) mschap: -->
--nt-response=d4ced6b15b809861069531ec2cb89e3001db98c94f9018e8
(11) mschap: Program returned code (0) and output 'NT_KEY:
751E91FBC94E37990A2A5B973C29E4D3'
(11) mschap: Adding MS-CHAPv2 MPPE keys
(11) [mschap] = ok
(11) } # Auth-Type MS-CHAP = ok
(11) MSCHAP Success
(11) eap: Sending EAP Request (code 1) ID 13 length 51
(11) eap: EAP session adding &reply:State = 0x739669f1729b7348
(11) [eap] = handled
(11) } # authenticate = handled
(11) } # server inner-tunnel
(11) Virtual server sending reply
(11) User-Name = "oscarrdg at unav.es"
(11) Reply-Message += "role.n1"
(11) Aruba-User-Role := "role.n1"
(11) EAP-Message =
0x010d00331a030c002e533d38443639364430423633413735314239363137343538304636313145354531323335434636443942
(11) Message-Authenticator = 0x00000000000000000000000000000000
(11) State = 0x739669f1729b7348a02455fb687f2caa
(11) eap_peap: Got tunneled reply code 11
(11) eap_peap: User-Name = "oscarrdg at unav.es"
(11) eap_peap: Reply-Message += "role.n1"
(11) eap_peap: Aruba-User-Role := "role.n1"
(11) eap_peap: EAP-Message =
0x010d00331a030c002e533d38443639364430423633413735314239363137343538304636313145354531323335434636443942
(11) eap_peap: Message-Authenticator = 0x00000000000000000000000000000000
(11) eap_peap: State = 0x739669f1729b7348a02455fb687f2caa
(11) eap_peap: Got tunneled reply RADIUS code 11
(11) eap_peap: User-Name = "oscarrdg at unav.es"
(11) eap_peap: Reply-Message += "role.n1"
(11) eap_peap: Aruba-User-Role := "role.n1"
(11) eap_peap: EAP-Message =
0x010d00331a030c002e533d38443639364430423633413735314239363137343538304636313145354531323335434636443942
(11) eap_peap: Message-Authenticator = 0x00000000000000000000000000000000
(11) eap_peap: State = 0x739669f1729b7348a02455fb687f2caa
(11) eap_peap: Got tunneled Access-Challenge
(11) eap: Sending EAP Request (code 1) ID 13 length 82
(11) eap: EAP session adding &reply:State = 0x4a7c50d94171497d
(11) [eap] = handled
(11) } # authenticate = handled
(11) Using Post-Auth-Type Challenge
(11) Post-Auth-Type sub-section not found. Ignoring.
(11) # Executing group from file
/usr/local/etc2/freeradius/etc/raddb/sites-enabled/default
(11) Sent Access-Challenge Id 240 from xxx12.225:1812 to xxxxxx:45903
length 0
(11) EAP-Message =
0x010d0052190017030300476a2a84ab3ae80e65df331667562db833be49b2c3281f498c160a1da57850e4c4db22bfebfcec126265d589bbfe90d31b5ded9e845dd71e0e30a7911af58f1d022b04703a397886
(11) Message-Authenticator = 0x00000000000000000000000000000000
(11) State = 0x4a7c50d94171497df1395bb8ee5037b2
(11) Finished request
Waking up in 4.7 seconds.
*Oscar Remírez de Ganuza Satrústegui*
IT Services
Universidad de Navarra
Tel. +34 948425600 x803130
http://www.unav.edu/web/it/
On Thu, Nov 19, 2015 at 4:49 PM, Óscar Remírez de Ganuza Satrústegui <
oscarrdg at unav.es> wrote:
> Good afternoon,
>
> As I told on a previous email, we are migrating previous radius (2.1.9)
> authentication to a new instance of freeradius (3.0.10).
>
> I am experiencing some problems authenticating some devices.
>
> I have previously tested with eapol_test that the new freeradius is
> working ok with both:
> - EAP TTLS - PAP
> - PEAP - MSCHAPv2
>
> But when testing PEAP on some devices, it is not working properly.
>
> It looks I am getting authorized properly, and even authenticated:
> (11) [mschap] = ok
> (11) } # Auth-Type MS-CHAP = ok
> (11) MSCHAP Success
>
> But I am not getting a final Access-Accept (nor an Access-Reject), and it
> the authentication fails....
>
> Any idea where could be the problem?
>
> Thanks a lot!
>
> Copyright (C) 1999-2015 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
> For more information about these matters, see the file named COPYRIGHT
> Starting - reading configuration files ...
> including dictionary file
> /usr/local/etc2/freeradius/share/freeradius/dictionary
> including dictionary file
> /usr/local/etc2/freeradius/share/freeradius/dictionary.dhcp
> including dictionary file
> /usr/local/etc2/freeradius/share/freeradius/dictionary.vqp
> including dictionary file /usr/local/etc2/freeradius/etc/raddb/dictionary
> including configuration file
> /usr/local/etc2/freeradius/etc/raddb/radiusd.conf
> including configuration file
> /usr/local/etc2/freeradius/etc/raddb/proxy.conf
> including configuration file
> /usr/local/etc2/freeradius/etc/raddb/clients.conf
> including files in directory
> /usr/local/etc2/freeradius/etc/raddb/mods-enabled/
> including configuration file
> /usr/local/etc2/freeradius/etc/raddb/mods-enabled/always
> including configuration file
> /usr/local/etc2/freeradius/etc/raddb/mods-enabled/attr_filter
> including configuration file
> /usr/local/etc2/freeradius/etc/raddb/mods-enabled/cache_eap
> including configuration file
> /usr/local/etc2/freeradius/etc/raddb/mods-enabled/chap
> including configuration file
> /usr/local/etc2/freeradius/etc/raddb/mods-enabled/detail
> including configuration file
> /usr/local/etc2/freeradius/etc/raddb/mods-enabled/detail.log
> including configuration file
> /usr/local/etc2/freeradius/etc/raddb/mods-enabled/digest
> including configuration file
> /usr/local/etc2/freeradius/etc/raddb/mods-enabled/dhcp
> including configuration file
> /usr/local/etc2/freeradius/etc/raddb/mods-enabled/dynamic_clients
> including configuration file
> /usr/local/etc2/freeradius/etc/raddb/mods-enabled/eap
> including configuration file
> /usr/local/etc2/freeradius/etc/raddb/mods-enabled/echo
> including configuration file
> /usr/local/etc2/freeradius/etc/raddb/mods-enabled/exec
> including configuration file
> /usr/local/etc2/freeradius/etc/raddb/mods-enabled/expiration
> including configuration file
> /usr/local/etc2/freeradius/etc/raddb/mods-enabled/expr
> including configuration file
> /usr/local/etc2/freeradius/etc/raddb/mods-enabled/files
> including configuration file
> /usr/local/etc2/freeradius/etc/raddb/mods-enabled/linelog
> including configuration file
> /usr/local/etc2/freeradius/etc/raddb/mods-enabled/logintime
> including configuration file
> /usr/local/etc2/freeradius/etc/raddb/mods-enabled/mschap
> including configuration file
> /usr/local/etc2/freeradius/etc/raddb/mods-enabled/ntlm_auth
> including configuration file
> /usr/local/etc2/freeradius/etc/raddb/mods-enabled/pap
> including configuration file
> /usr/local/etc2/freeradius/etc/raddb/mods-enabled/passwd
> including configuration file
> /usr/local/etc2/freeradius/etc/raddb/mods-enabled/preprocess
> including configuration file
> /usr/local/etc2/freeradius/etc/raddb/mods-enabled/radutmp
> including configuration file
> /usr/local/etc2/freeradius/etc/raddb/mods-enabled/realm
> including configuration file
> /usr/local/etc2/freeradius/etc/raddb/mods-enabled/replicate
> including configuration file
> /usr/local/etc2/freeradius/etc/raddb/mods-enabled/soh
> including configuration file
> /usr/local/etc2/freeradius/etc/raddb/mods-enabled/sradutmp
> including configuration file
> /usr/local/etc2/freeradius/etc/raddb/mods-enabled/unix
> including configuration file
> /usr/local/etc2/freeradius/etc/raddb/mods-enabled/unpack
> including configuration file
> /usr/local/etc2/freeradius/etc/raddb/mods-enabled/utf8
> including configuration file
> /usr/local/etc2/freeradius/etc/raddb/mods-enabled/ldap
> including configuration file
> /usr/local/etc2/freeradius/etc/raddb/mods-enabled/ippool
> including files in directory /usr/local/etc2/freeradius/etc/raddb/policy.d/
> including configuration file
> /usr/local/etc2/freeradius/etc/raddb/policy.d/abfab-tr
> including configuration file
> /usr/local/etc2/freeradius/etc/raddb/policy.d/accounting
> including configuration file
> /usr/local/etc2/freeradius/etc/raddb/policy.d/canonicalization
> including configuration file
> /usr/local/etc2/freeradius/etc/raddb/policy.d/control
> including configuration file
> /usr/local/etc2/freeradius/etc/raddb/policy.d/cui
> including configuration file
> /usr/local/etc2/freeradius/etc/raddb/policy.d/debug
> including configuration file
> /usr/local/etc2/freeradius/etc/raddb/policy.d/dhcp
> including configuration file
> /usr/local/etc2/freeradius/etc/raddb/policy.d/eap
> including configuration file
> /usr/local/etc2/freeradius/etc/raddb/policy.d/filter
> including configuration file
> /usr/local/etc2/freeradius/etc/raddb/policy.d/operator-name
> including configuration file
> /usr/local/etc2/freeradius/etc/raddb/policy.d/unav.policies
> including files in directory
> /usr/local/etc2/freeradius/etc/raddb/sites-enabled/
> including configuration file
> /usr/local/etc2/freeradius/etc/raddb/sites-enabled/default
> including configuration file
> /usr/local/etc2/freeradius/etc/raddb/sites-enabled/inner-tunnel
> including configuration file
> /usr/local/etc2/freeradius/etc/raddb/sites-enabled/status
> main {
> security {
> user = "radius"
> group = "radius"
> allow_core_dumps = no
> }
> name = "radiusd"
> prefix = "/usr/local/etc2/freeradius"
> localstatedir = "/usr/local/etc2/freeradius/var"
> logdir = "/usr/local/etc2/freeradius/var/log/radius"
> run_dir = "/usr/local/etc2/freeradius/var/run/radiusd"
> }
> main {
> name = "radiusd"
> prefix = "/usr/local/etc2/freeradius"
> localstatedir = "/usr/local/etc2/freeradius/var"
> sbindir = "/usr/local/etc2/freeradius/sbin"
> logdir = "/usr/local/etc2/freeradius/var/log/radius"
> run_dir = "/usr/local/etc2/freeradius/var/run/radiusd"
> libdir = "/usr/local/etc2/freeradius/lib"
> radacctdir = "/usr/local/etc2/freeradius/var/log/radius/radacct"
> hostname_lookups = no
> max_request_time = 30
> cleanup_delay = 5
> max_requests = 16384
> pidfile = "/usr/local/etc2/freeradius/var/run/radiusd/radiusd.pid"
> checkrad = "/usr/local/etc2/freeradius/sbin/checkrad"
> debug_level = 0
> proxy_requests = yes
> log {
> stripped_names = no
> auth = yes
> auth_badpass = no
> auth_goodpass = no
> colourise = yes
> msg_denied = "You are already logged in - access denied"
> }
> resources {
> }
> security {
> max_attributes = 200
> reject_delay = 1.000000
> status_server = yes
> allow_vulnerable_openssl = "CVE-2014-0160"
> }
> }
> 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
> }
> home_server localhost {
> ipaddr = 127.0.0.1
> port = 1812
> type = "auth"
> secret = <<< secret >>>
> response_window = 20.000000
> response_timeouts = 1
> max_outstanding = 65536
> zombie_period = 40
> status_check = "status-server"
> ping_interval = 30
> check_interval = 30
> check_timeout = 4
> num_answers_to_alive = 3
> revive_interval = 120
> limit {
> max_connections = 16
> max_requests = 0
> lifetime = 0
> idle_timeout = 0
> }
> coa {
> irt = 2
> mrt = 16
> mrc = 5
> mrd = 30
> }
> }
> home_server radiusproxy1 {
> ipaddr = 159.23xxxx
> port = 1812
> type = "auth+acct"
> secret = <<< secret >>>
> response_window = 20.000000
> response_timeouts = 1
> max_outstanding = 65536
> zombie_period = 40
> status_check = "status-server"
> ping_interval = 30
> check_interval = 30
> check_timeout = 4
> num_answers_to_alive = 3
> revive_interval = 60
> limit {
> max_connections = 16
> max_requests = 0
> lifetime = 0
> idle_timeout = 0
> }
> coa {
> irt = 2
> mrt = 16
> mrc = 5
> mrd = 30
> }
> }
> home_server radiusproxy2 {
> ipaddr = 159.237xxx
> port = 1812
> type = "auth+acct"
> secret = <<< secret >>>
> response_window = 20.000000
> response_timeouts = 1
> max_outstanding = 65536
> zombie_period = 40
> status_check = "status-server"
> ping_interval = 30
> check_interval = 30
> check_timeout = 4
> num_answers_to_alive = 3
> revive_interval = 60
> limit {
> max_connections = 16
> max_requests = 0
> lifetime = 0
> idle_timeout = 0
> }
> coa {
> irt = 2
> mrt = 16
> mrc = 5
> mrd = 30
> }
> }
> realm ~^(.*\.)?unav\.es$ {
> }
> realm UNAV-PDC-01 {
> }
> realm LOCAL {
> }
> realm NULL {
> }
> home_server_pool radiusproxy_pool {
> type = fail-over
> home_server = xxx
> home_server = xxx
> }
> realm ~.+$ {
> pool = radiusproxy_pool
> nostrip
> }
> home_server_pool my_auth_failover {
> type = fail-over
> home_server = localhost
> }
> radiusd: #### Loading Clients ####
> client localhost {
> ipaddr = 127.0.0.1
> require_message_authenticator = no
> secret = <<< secret >>>
> nas_type = "other"
> proto = "*"
> limit {
> max_connections = 16
> lifetime = 0
> idle_timeout = 30
> }
> }
> client localhost_ipv6 {
> ipv6addr = ::1
> require_message_authenticator = no
> secret = <<< secret >>>
> limit {
> max_connections = 16
> lifetime = 0
> idle_timeout = 30
> }
> }
> client WirelessSW_Dere {
> ipaddr = xxx
> netmask = 32
> require_message_authenticator = no
> secret = <<< secret >>>
> shortname = "WirelessSW"
> limit {
> max_connections = 16
> lifetime = 0
> idle_timeout = 30
> }
> }
> client WirelessSW_PRE {
> ipaddr = xxx
> netmask = 32
> require_message_authenticator = no
> secret = <<< secret >>>
> shortname = "WirelessSW"
> limit {
> max_connections = 16
> lifetime = 0
> idle_timeout = 30
> }
> }
>
> Debugger not attached
> # Creating Auth-Type = digest
> # Creating Autz-Type = Status-Server
> radiusd: #### Instantiating modules ####
> # Loaded module rlm_always
> # Loading module "reject" from file
> /usr/local/etc2/freeradius/etc/raddb/mods-enabled/always
> always reject {
> rcode = "reject"
> simulcount = 0
> mpp = no
> }
> # Loading module "fail" from file
> /usr/local/etc2/freeradius/etc/raddb/mods-enabled/always
> always fail {
> rcode = "fail"
> simulcount = 0
> mpp = no
> }
> # Loading module "ok" from file
> /usr/local/etc2/freeradius/etc/raddb/mods-enabled/always
> always ok {
> rcode = "ok"
> simulcount = 0
> mpp = no
> }
> # Loading module "handled" from file
> /usr/local/etc2/freeradius/etc/raddb/mods-enabled/always
> always handled {
> rcode = "handled"
> simulcount = 0
> mpp = no
> }
> # Loading module "invalid" from file
> /usr/local/etc2/freeradius/etc/raddb/mods-enabled/always
> always invalid {
> rcode = "invalid"
> simulcount = 0
> mpp = no
> }
> # Loading module "userlock" from file
> /usr/local/etc2/freeradius/etc/raddb/mods-enabled/always
> always userlock {
> rcode = "userlock"
> simulcount = 0
> mpp = no
> }
> # Loading module "notfound" from file
> /usr/local/etc2/freeradius/etc/raddb/mods-enabled/always
> always notfound {
> rcode = "notfound"
> simulcount = 0
> mpp = no
> }
> # Loading module "noop" from file
> /usr/local/etc2/freeradius/etc/raddb/mods-enabled/always
> always noop {
> rcode = "noop"
> simulcount = 0
> mpp = no
> }
> # Loading module "updated" from file
> /usr/local/etc2/freeradius/etc/raddb/mods-enabled/always
> always updated {
> rcode = "updated"
> simulcount = 0
> mpp = no
> }
> # Loaded module rlm_attr_filter
> # Loading module "attr_filter.post-proxy" from file
> /usr/local/etc2/freeradius/etc/raddb/mods-enabled/attr_filter
> attr_filter attr_filter.post-proxy {
> filename =
> "/usr/local/etc2/freeradius/etc/raddb/mods-config/attr_filter/post-proxy"
> key = "%{Realm}"
> relaxed = no
> }
> # Loading module "attr_filter.pre-proxy" from file
> /usr/local/etc2/freeradius/etc/raddb/mods-enabled/attr_filter
> attr_filter attr_filter.pre-proxy {
> filename =
> "/usr/local/etc2/freeradius/etc/raddb/mods-config/attr_filter/pre-proxy"
> key = "%{Realm}"
> relaxed = no
> }
> # Loading module "attr_filter.access_reject" from file
> /usr/local/etc2/freeradius/etc/raddb/mods-enabled/attr_filter
> attr_filter attr_filter.access_reject {
> filename =
> "/usr/local/etc2/freeradius/etc/raddb/mods-config/attr_filter/access_reject"
> key = "%{User-Name}"
> relaxed = no
> }
> # Loading module "attr_filter.access_challenge" from file
> /usr/local/etc2/freeradius/etc/raddb/mods-enabled/attr_filter
> attr_filter attr_filter.access_challenge {
> filename =
> "/usr/local/etc2/freeradius/etc/raddb/mods-config/attr_filter/access_challenge"
> key = "%{User-Name}"
> relaxed = no
> }
> # Loading module "attr_filter.accounting_response" from file
> /usr/local/etc2/freeradius/etc/raddb/mods-enabled/attr_filter
> attr_filter attr_filter.accounting_response {
> filename =
> "/usr/local/etc2/freeradius/etc/raddb/mods-config/attr_filter/accounting_response"
> key = "%{User-Name}"
> relaxed = no
> }
> # Loaded module rlm_cache
> # Loading module "cache_eap" from file
> /usr/local/etc2/freeradius/etc/raddb/mods-enabled/cache_eap
> cache cache_eap {
> driver = "rlm_cache_rbtree"
> key = "%{%{control:State}:-%{%{reply:State}:-%{State}}}"
> ttl = 15
> max_entries = 0
> epoch = 0
> add_stats = no
> }
> # Loaded module rlm_chap
> # Loading module "chap" from file
> /usr/local/etc2/freeradius/etc/raddb/mods-enabled/chap
> # Loaded module rlm_detail
> # Loading module "detail" from file
> /usr/local/etc2/freeradius/etc/raddb/mods-enabled/detail
> detail {
> filename =
> "/usr/local/etc2/freeradius/var/log/radius/radacct/%{%{Packet-Src-IP-Address}:-%{Packet-Src-IPv6-Address}}/detail-%Y%m%d"
> header = "%t"
> permissions = 384
> locking = no
> escape_filenames = no
> log_packet_header = no
> }
> # Loading module "auth_log" from file
> /usr/local/etc2/freeradius/etc/raddb/mods-enabled/detail.log
> detail auth_log {
> filename =
> "/usr/local/etc2/freeradius/var/log/radius/radacct/%{%{Packet-Src-IP-Address}:-%{Packet-Src-IPv6-Address}}/auth-detail-%Y%m%d"
> header = "%t"
> permissions = 384
> locking = no
> escape_filenames = no
> log_packet_header = no
> }
> # Loading module "reply_log" from file
> /usr/local/etc2/freeradius/etc/raddb/mods-enabled/detail.log
> detail reply_log {
> filename =
> "/usr/local/etc2/freeradius/var/log/radius/radacct/%{%{Packet-Src-IP-Address}:-%{Packet-Src-IPv6-Address}}/reply-detail-%Y%m%d"
> header = "%t"
> permissions = 384
> locking = no
> escape_filenames = no
> log_packet_header = no
> }
> # Loading module "pre_proxy_log" from file
> /usr/local/etc2/freeradius/etc/raddb/mods-enabled/detail.log
> detail pre_proxy_log {
> filename =
> "/usr/local/etc2/freeradius/var/log/radius/radacct/%{%{Packet-Src-IP-Address}:-%{Packet-Src-IPv6-Address}}/pre-proxy-detail-%Y%m%d"
> header = "%t"
> permissions = 384
> locking = no
> escape_filenames = no
> log_packet_header = no
> }
> # Loading module "post_proxy_log" from file
> /usr/local/etc2/freeradius/etc/raddb/mods-enabled/detail.log
> detail post_proxy_log {
> filename =
> "/usr/local/etc2/freeradius/var/log/radius/radacct/%{%{Packet-Src-IP-Address}:-%{Packet-Src-IPv6-Address}}/post-proxy-detail-%Y%m%d"
> header = "%t"
> permissions = 384
> locking = no
> escape_filenames = no
> log_packet_header = no
> }
> # Loaded module rlm_digest
> # Loading module "digest" from file
> /usr/local/etc2/freeradius/etc/raddb/mods-enabled/digest
> # Loaded module rlm_dhcp
> # Loading module "dhcp" from file
> /usr/local/etc2/freeradius/etc/raddb/mods-enabled/dhcp
> # Loaded module rlm_dynamic_clients
> # Loading module "dynamic_clients" from file
> /usr/local/etc2/freeradius/etc/raddb/mods-enabled/dynamic_clients
> # Loaded module rlm_eap
> # Loading module "eap" from file
> /usr/local/etc2/freeradius/etc/raddb/mods-enabled/eap
> eap {
> default_eap_type = "md5"
> timer_expire = 60
> ignore_unknown_eap_types = no
> cisco_accounting_username_bug = no
> max_sessions = 16384
> }
> # Loaded module rlm_exec
> # Loading module "echo" from file
> /usr/local/etc2/freeradius/etc/raddb/mods-enabled/echo
> exec echo {
> wait = yes
> program = "/bin/echo %{User-Name}"
> input_pairs = "request"
> output_pairs = "reply"
> shell_escape = yes
> }
> # Loading module "exec" from file
> /usr/local/etc2/freeradius/etc/raddb/mods-enabled/exec
> exec {
> wait = no
> input_pairs = "request"
> shell_escape = yes
> timeout = 10
> }
> # Loaded module rlm_expiration
> # Loading module "expiration" from file
> /usr/local/etc2/freeradius/etc/raddb/mods-enabled/expiration
> # Loaded module rlm_expr
> # Loading module "expr" from file
> /usr/local/etc2/freeradius/etc/raddb/mods-enabled/expr
> expr {
> safe_characters =
> "@abcdefghijklmnopqrstuvwxyzABCDEFGHIJKLMNOPQRSTUVWXYZ0123456789.-_:
> /äéöüàâæçèéêëîïôœùûüaÿÄÉÖÜßÀÂÆÇÈÉÊËÎÏÔŒÙÛÜŸ"
> }
> # Loaded module rlm_files
> # Loading module "files" from file
> /usr/local/etc2/freeradius/etc/raddb/mods-enabled/files
> files {
> filename =
> "/usr/local/etc2/freeradius/etc/raddb/mods-config/files/authorize"
> acctusersfile =
> "/usr/local/etc2/freeradius/etc/raddb/mods-config/files/accounting"
> preproxy_usersfile =
> "/usr/local/etc2/freeradius/etc/raddb/mods-config/files/pre-proxy"
> }
> # Loaded module rlm_linelog
> # Loading module "linelog" from file
> /usr/local/etc2/freeradius/etc/raddb/mods-enabled/linelog
> linelog {
> filename = "/usr/local/etc2/freeradius/var/log/radius/linelog"
> escape_filenames = no
> syslog_severity = "info"
> permissions = 384
> format = "This is a log message for %{User-Name}"
> reference = "messages.%{%{reply:Packet-Type}:-default}"
> }
> # Loading module "log_accounting" from file
> /usr/local/etc2/freeradius/etc/raddb/mods-enabled/linelog
> linelog log_accounting {
> filename =
> "/usr/local/etc2/freeradius/var/log/radius/linelog-accounting"
> escape_filenames = no
> syslog_severity = "info"
> permissions = 384
> format = ""
> reference = "Accounting-Request.%{%{Acct-Status-Type}:-unknown}"
> }
> # Loaded module rlm_logintime
> # Loading module "logintime" from file
> /usr/local/etc2/freeradius/etc/raddb/mods-enabled/logintime
> logintime {
> minimum_timeout = 60
> }
> # Loaded module rlm_mschap
> # Loading module "mschap" from file
> /usr/local/etc2/freeradius/etc/raddb/mods-enabled/mschap
> mschap {
> use_mppe = yes
> require_encryption = no
> require_strong = no
> with_ntdomain_hack = yes
> ntlm_auth = "/usr/bin/ntlm_auth --request-nt-key
> --username=%{%{Stripped-User-Name}:-%{%{User-Name}:-None}}
> --challenge=%{%{mschap:Challenge}:-00}
> --nt-response=%{%{mschap:NT-Response}:-00}"
> passchange {
> }
> allow_retry = yes
> }
> # Loading module "ntlm_auth" from file
> /usr/local/etc2/freeradius/etc/raddb/mods-enabled/ntlm_auth
> exec ntlm_auth {
> wait = yes
> program = "/path/to/ntlm_auth --request-nt-key --domain=MYDOMAIN
> --username=%{mschap:User-Name} --password=%{User-Password}"
> shell_escape = yes
> }
> # Loaded module rlm_pap
> # Loading module "pap" from file
> /usr/local/etc2/freeradius/etc/raddb/mods-enabled/pap
> pap {
> normalise = yes
> }
> # Loaded module rlm_passwd
> # Loading module "etc_passwd" from file
> /usr/local/etc2/freeradius/etc/raddb/mods-enabled/passwd
> passwd etc_passwd {
> filename = "/etc/passwd"
> format = "*User-Name:Crypt-Password:"
> delimiter = ":"
> ignore_nislike = no
> ignore_empty = yes
> allow_multiple_keys = no
> hash_size = 100
> }
> # Loaded module rlm_preprocess
> # Loading module "preprocess" from file
> /usr/local/etc2/freeradius/etc/raddb/mods-enabled/preprocess
> preprocess {
> huntgroups =
> "/usr/local/etc2/freeradius/etc/raddb/mods-config/preprocess/huntgroups"
> hints =
> "/usr/local/etc2/freeradius/etc/raddb/mods-config/preprocess/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
> }
> # Loaded module rlm_radutmp
> # Loading module "radutmp" from file
> /usr/local/etc2/freeradius/etc/raddb/mods-enabled/radutmp
> radutmp {
> filename = "/usr/local/etc2/freeradius/var/log/radius/radutmp"
> username = "%{User-Name}"
> case_sensitive = yes
> check_with_nas = yes
> permissions = 384
> caller_id = yes
> }
> # Loaded module rlm_realm
> # Loading module "IPASS" from file
> /usr/local/etc2/freeradius/etc/raddb/mods-enabled/realm
> realm IPASS {
> format = "prefix"
> delimiter = "/"
> ignore_default = no
> ignore_null = no
> }
> # Loading module "suffix" from file
> /usr/local/etc2/freeradius/etc/raddb/mods-enabled/realm
> realm suffix {
> format = "suffix"
> delimiter = "@"
> ignore_default = no
> ignore_null = yes
> }
> # Loading module "realmpercent" from file
> /usr/local/etc2/freeradius/etc/raddb/mods-enabled/realm
> realm realmpercent {
> format = "suffix"
> delimiter = "%"
> ignore_default = no
> ignore_null = no
> }
> # Loading module "ntdomain" from file
> /usr/local/etc2/freeradius/etc/raddb/mods-enabled/realm
> realm ntdomain {
> format = "prefix"
> delimiter = "\\"
> ignore_default = no
> ignore_null = no
> }
> # Loaded module rlm_replicate
> # Loading module "replicate" from file
> /usr/local/etc2/freeradius/etc/raddb/mods-enabled/replicate
> # Loaded module rlm_soh
> # Loading module "soh" from file
> /usr/local/etc2/freeradius/etc/raddb/mods-enabled/soh
> soh {
> dhcp = yes
> }
> # Loading module "sradutmp" from file
> /usr/local/etc2/freeradius/etc/raddb/mods-enabled/sradutmp
> radutmp sradutmp {
> filename = "/usr/local/etc2/freeradius/var/log/radius/sradutmp"
> username = "%{User-Name}"
> case_sensitive = yes
> check_with_nas = yes
> permissions = 420
> caller_id = no
> }
> # Loaded module rlm_unix
> # Loading module "unix" from file
> /usr/local/etc2/freeradius/etc/raddb/mods-enabled/unix
> unix {
> radwtmp = "/usr/local/etc2/freeradius/var/log/radius/radwtmp"
> }
> Creating attribute Unix-Group
> # Loaded module rlm_unpack
> # Loading module "unpack" from file
> /usr/local/etc2/freeradius/etc/raddb/mods-enabled/unpack
> # Loaded module rlm_utf8
> # Loading module "utf8" from file
> /usr/local/etc2/freeradius/etc/raddb/mods-enabled/utf8
> # Loaded module rlm_ldap
> # Loading module "ldap" from file
> /usr/local/etc2/freeradius/etc/raddb/mods-enabled/ldap
> ldap {
> server = "ldap.unav.es"
> identity = "cn=radiusOp,dc=unav,dc=es"
> password = <<< secret >>>
> sasl {
> }
> user {
> scope = "sub"
> access_positive = yes
> sasl {
> }
> }
> group {
> filter = "(objectClass=posixGroup)"
> scope = "sub"
> name_attribute = "cn"
> membership_attribute = "member"
> cacheable_name = no
> cacheable_dn = no
> }
> client {
> filter = "(objectClass=radiusClient)"
> scope = "sub"
> base_dn = "ou=radius,o=accounts,dc=unav,dc=es"
> }
> profile {
> }
> options {
> ldap_debug = 40
> chase_referrals = yes
> rebind = yes
> net_timeout = 1
> res_timeout = 10
> srv_timelimit = 3
> idle = 60
> probes = 3
> interval = 3
> }
> tls {
> start_tls = yes
> }
> }
> Creating attribute LDAP-Group
> # Loaded module rlm_ippool
> # Loading module "VPN_IPSEC_CUN" from file
> /usr/local/etc2/freeradius/etc/raddb/mods-enabled/ippool
> ippool VPN_IPSEC_CUN {
> filename =
> "/usr/local/etc2/freeradius/etc/raddb/db.ippool.VPN.IPSEC.CUN"
> ip_index =
> "/usr/local/etc2/freeradius/etc/raddb/db.ipindex.VPN.IPSEC.CUN"
> key = "%{Acct-Session-Id}"
> range_start = xxx
> range_stop = xxx
> netmask = 255.255.255.0
> cache_size = 255
> override = no
> maximum_timeout = 0
> }
> instantiate {
> }
> modules {
> # Instantiating module "reject" from file
> /usr/local/etc2/freeradius/etc/raddb/mods-enabled/always
> # Instantiating module "fail" from file
> /usr/local/etc2/freeradius/etc/raddb/mods-enabled/always
> # Instantiating module "ok" from file
> /usr/local/etc2/freeradius/etc/raddb/mods-enabled/always
> # Instantiating module "handled" from file
> /usr/local/etc2/freeradius/etc/raddb/mods-enabled/always
> # Instantiating module "invalid" from file
> /usr/local/etc2/freeradius/etc/raddb/mods-enabled/always
> # Instantiating module "userlock" from file
> /usr/local/etc2/freeradius/etc/raddb/mods-enabled/always
> # Instantiating module "notfound" from file
> /usr/local/etc2/freeradius/etc/raddb/mods-enabled/always
> # Instantiating module "noop" from file
> /usr/local/etc2/freeradius/etc/raddb/mods-enabled/always
> # Instantiating module "updated" from file
> /usr/local/etc2/freeradius/etc/raddb/mods-enabled/always
> # Instantiating module "attr_filter.post-proxy" from file
> /usr/local/etc2/freeradius/etc/raddb/mods-enabled/attr_filter
> reading pairlist file
> /usr/local/etc2/freeradius/etc/raddb/mods-config/attr_filter/post-proxy
> # Instantiating module "attr_filter.pre-proxy" from file
> /usr/local/etc2/freeradius/etc/raddb/mods-enabled/attr_filter
> reading pairlist file
> /usr/local/etc2/freeradius/etc/raddb/mods-config/attr_filter/pre-proxy
> # Instantiating module "attr_filter.access_reject" from file
> /usr/local/etc2/freeradius/etc/raddb/mods-enabled/attr_filter
> reading pairlist file
> /usr/local/etc2/freeradius/etc/raddb/mods-config/attr_filter/access_reject
> # Instantiating module "attr_filter.access_challenge" from file
> /usr/local/etc2/freeradius/etc/raddb/mods-enabled/attr_filter
> reading pairlist file
> /usr/local/etc2/freeradius/etc/raddb/mods-config/attr_filter/access_challenge
> # Instantiating module "attr_filter.accounting_response" from file
> /usr/local/etc2/freeradius/etc/raddb/mods-enabled/attr_filter
> reading pairlist file
> /usr/local/etc2/freeradius/etc/raddb/mods-config/attr_filter/accounting_response
> # Instantiating module "cache_eap" from file
> /usr/local/etc2/freeradius/etc/raddb/mods-enabled/cache_eap
> rlm_cache (cache_eap): Driver rlm_cache_rbtree (module rlm_cache_rbtree)
> loaded and linked
> # Instantiating module "detail" from file
> /usr/local/etc2/freeradius/etc/raddb/mods-enabled/detail
> # Instantiating module "auth_log" from file
> /usr/local/etc2/freeradius/etc/raddb/mods-enabled/detail.log
> rlm_detail (auth_log): 'User-Password' suppressed, will not appear in
> detail output
> # Instantiating module "reply_log" from file
> /usr/local/etc2/freeradius/etc/raddb/mods-enabled/detail.log
> # Instantiating module "pre_proxy_log" from file
> /usr/local/etc2/freeradius/etc/raddb/mods-enabled/detail.log
> # Instantiating module "post_proxy_log" from file
> /usr/local/etc2/freeradius/etc/raddb/mods-enabled/detail.log
> # Instantiating module "eap" from file
> /usr/local/etc2/freeradius/etc/raddb/mods-enabled/eap
> # Linked to sub-module rlm_eap_md5
> # Linked to sub-module rlm_eap_leap
> # Linked to sub-module rlm_eap_gtc
> gtc {
> challenge = "Password: "
> auth_type = "PAP"
> }
> # Linked to sub-module rlm_eap_tls
> tls {
> tls = "tls-common"
> }
> tls-config tls-common {
> rsa_key_exchange = no
> dh_key_exchange = yes
> rsa_key_length = 512
> dh_key_length = 512
> verify_depth = 0
> ca_path = "/usr/local/etc2/freeradius/etc/raddb/certs"
> pem_file_type = yes
> private_key_file =
> "/usr/local/etc2/freeradius/etc/raddb/certs/radius.unav.es_privatekey.pem"
> certificate_file =
> "/usr/local/etc2/freeradius/etc/raddb/certs/radius.unav.es_cert.pem"
> ca_file =
> "/usr/local/etc2/freeradius/etc/raddb/certs/TERENASSL_PATH.pem"
> dh_file = "/usr/local/etc2/freeradius/etc/raddb/certs/dh"
> fragment_size = 1024
> include_length = yes
> check_crl = no
> check_all_crl = no
> cipher_list = "DEFAULT"
> ecdh_curve = "prime256v1"
> cache {
> enable = yes
> lifetime = 24
> max_entries = 255
> }
> verify {
> }
> ocsp {
> enable = no
> override_cert_url = yes
> url = "http://127.0.0.1/ocsp/"
> use_nonce = yes
> timeout = 0
> softfail = no
> }
> }
> # Linked to sub-module rlm_eap_ttls
> ttls {
> tls = "tls-common"
> default_eap_type = "md5"
> copy_request_to_tunnel = yes
> use_tunneled_reply = no
> virtual_server = "inner-tunnel"
> include_length = yes
> require_client_cert = no
> }
> tls: Using cached TLS configuration from previous invocation
> # Linked to sub-module rlm_eap_peap
> peap {
> tls = "tls-common"
> default_eap_type = "mschapv2"
> copy_request_to_tunnel = yes
> use_tunneled_reply = no
> proxy_tunneled_request_as_eap = yes
> virtual_server = "inner-tunnel"
> soh = no
> require_client_cert = no
> }
> tls: Using cached TLS configuration from previous invocation
> # Linked to sub-module rlm_eap_mschapv2
> mschapv2 {
> with_ntdomain_hack = no
> send_error = no
> }
> # Instantiating module "expiration" from file
> /usr/local/etc2/freeradius/etc/raddb/mods-enabled/expiration
> # Instantiating module "files" from file
> /usr/local/etc2/freeradius/etc/raddb/mods-enabled/files
> reading pairlist file
> /usr/local/etc2/freeradius/etc/raddb/mods-config/files/authorize
> reading pairlist file
> /usr/local/etc2/freeradius/etc/raddb/mods-config/files/users.vpn
> reading pairlist file
> /usr/local/etc2/freeradius/etc/raddb/mods-config/files/accounting
> reading pairlist file
> /usr/local/etc2/freeradius/etc/raddb/mods-config/files/pre-proxy
> # Instantiating module "linelog" from file
> /usr/local/etc2/freeradius/etc/raddb/mods-enabled/linelog
> # Instantiating module "log_accounting" from file
> /usr/local/etc2/freeradius/etc/raddb/mods-enabled/linelog
> # Instantiating module "logintime" from file
> /usr/local/etc2/freeradius/etc/raddb/mods-enabled/logintime
> # Instantiating module "mschap" from file
> /usr/local/etc2/freeradius/etc/raddb/mods-enabled/mschap
> rlm_mschap (mschap): authenticating by calling 'ntlm_auth'
> # Instantiating module "pap" from file
> /usr/local/etc2/freeradius/etc/raddb/mods-enabled/pap
> # Instantiating module "etc_passwd" from file
> /usr/local/etc2/freeradius/etc/raddb/mods-enabled/passwd
> rlm_passwd: nfields: 3 keyfield 0(User-Name) listable: no
> # Instantiating module "preprocess" from file
> /usr/local/etc2/freeradius/etc/raddb/mods-enabled/preprocess
> reading pairlist file
> /usr/local/etc2/freeradius/etc/raddb/mods-config/preprocess/huntgroups
> reading pairlist file
> /usr/local/etc2/freeradius/etc/raddb/mods-config/preprocess/hints
> # Instantiating module "IPASS" from file
> /usr/local/etc2/freeradius/etc/raddb/mods-enabled/realm
> # Instantiating module "suffix" from file
> /usr/local/etc2/freeradius/etc/raddb/mods-enabled/realm
> # Instantiating module "realmpercent" from file
> /usr/local/etc2/freeradius/etc/raddb/mods-enabled/realm
> # Instantiating module "ntdomain" from file
> /usr/local/etc2/freeradius/etc/raddb/mods-enabled/realm
> # Instantiating module "ldap" from file
> /usr/local/etc2/freeradius/etc/raddb/mods-enabled/ldap
> rlm_ldap: libldap vendor: OpenLDAP, version: 20439
> accounting {
> reference = "%{tolower:type.%{Acct-Status-Type}}"
> }
> post-auth {
> reference = "."
> }
> rlm_ldap (ldap): Initialising connection pool
> pool {
> start = 5
> min = 3
> max = 32
> spare = 10
> uses = 0
> lifetime = 0
> cleanup_interval = 30
> idle_timeout = 60
> retry_delay = 30
> spread = no
> }
> rlm_ldap (ldap): Opening additional connection (0), 1 of 32 pending slots
> used
> rlm_ldap (ldap): Connecting to ldap://ldap.unav.es:389
> rlm_ldap (ldap): Waiting for bind result...
> rlm_ldap (ldap): Bind successful
> rlm_ldap (ldap): Opening additional connection (1), 1 of 31 pending slots
> used
> rlm_ldap (ldap): Connecting to ldap://ldap.unav.es:389
> rlm_ldap (ldap): Waiting for bind result...
> rlm_ldap (ldap): Bind successful
> rlm_ldap (ldap): Opening additional connection (2), 1 of 30 pending slots
> used
> rlm_ldap (ldap): Connecting to ldap://ldap.unav.es:389
> rlm_ldap (ldap): Waiting for bind result...
> rlm_ldap (ldap): Bind successful
> rlm_ldap (ldap): Opening additional connection (3), 1 of 29 pending slots
> used
> rlm_ldap (ldap): Connecting to ldap://ldap.unav.es:389
> rlm_ldap (ldap): Waiting for bind result...
> rlm_ldap (ldap): Bind successful
> rlm_ldap (ldap): Opening additional connection (4), 1 of 28 pending slots
> used
> rlm_ldap (ldap): Connecting to ldap://ldap.unav.es:389
> rlm_ldap (ldap): Waiting for bind result...
> rlm_ldap (ldap): Bind successful
> # Instantiating module "VPN_IPSEC_CUN" from file
> /usr/local/etc2/freeradius/etc/raddb/mods-enabled/ippool
> } # modules
> radiusd: #### Loading Virtual Servers ####
> server { # from file /usr/local/etc2/freeradius/etc/raddb/radiusd.conf
> } # server
> server default { # from file
> /usr/local/etc2/freeradius/etc/raddb/sites-enabled/default
> # Loading authenticate {...}
> # Loading authorize {...}
> # Loading preacct {...}
> # Loading accounting {...}
> # Loading session {...}
> # Loading pre-proxy {...}
> # Loading post-proxy {...}
> # Loading post-auth {...}
> } # server default
> server inner-tunnel { # from file
> /usr/local/etc2/freeradius/etc/raddb/sites-enabled/inner-tunnel
> # Loading authenticate {...}
> # Loading authorize {...}
> # Loading session {...}
> # Loading post-proxy {...}
> # Loading post-auth {...}
> } # server inner-tunnel
> server status { # from file
> /usr/local/etc2/freeradius/etc/raddb/sites-enabled/status
> # Loading authorize {...}
> } # server status
> radiusd: #### Opening IP addresses and Ports ####
> listen {
> type = "auth"
> ipaddr = *
> port = 0
> limit {
> max_connections = 16
> lifetime = 0
> idle_timeout = 30
> }
> }
> listen {
> type = "acct"
> ipaddr = *
> port = 0
> limit {
> max_connections = 16
> lifetime = 0
> idle_timeout = 30
> }
> }
> listen {
> type = "auth"
> ipv6addr = ::
> port = 0
> limit {
> max_connections = 16
> lifetime = 0
> idle_timeout = 30
> }
> }
> listen {
> type = "acct"
> ipv6addr = ::
> port = 0
> limit {
> max_connections = 16
> lifetime = 0
> idle_timeout = 30
> }
> }
> listen {
> type = "auth"
> ipaddr = 127.0.0.1
> port = 18120
> }
> listen {
> type = "status"
> ipaddr = 127.0.0.1
> port = 18121
> client admin {
> ipaddr = 127.0.0.1
> require_message_authenticator = no
> secret = <<< secret >>>
> limit {
> max_connections = 16
> lifetime = 0
> idle_timeout = 30
> }
> }
> }
> Listening on auth address * port 1812 bound to server default
> Listening on acct address * port 1813 bound to server default
> Listening on auth address :: port 1812 bound to server default
> Listening on acct address :: port 1813 bound to server default
> Listening on auth address 127.0.0.1 port 18120 bound to server inner-tunnel
> Listening on status address 127.0.0.1 port 18121 bound to server status
> Listening on proxy address * port 48633
> Listening on proxy address :: port 36571
> Ready to process requests
> (0) Received Access-Request Id 32 from xxxxxx:45903 to xxx12.225:1812
> length 215
> (0) User-Name = "oscarrdg at unav.es"
> (0) NAS-IP-Address = xxx
> (0) NAS-Port = 0
> (0) NAS-Identifier = "xxx
> (0) NAS-Port-Type = Wireless-802.11
> (0) Calling-Station-Id = "344DF73C9C98"
> (0) Called-Station-Id = "001A1E003250"
> (0) Service-Type = Framed-User
> (0) Framed-MTU = 1100
> (0) EAP-Message = 0x02010015016f7363617272646740756e61762e6573
> (0) Aruba-Essid-Name = "eduroam-pre"
> (0) Aruba-Location-Id = "10.9.1"
> (0) Aruba-AP-Group = "Amigos"
> (0) Aruba-Device-Type = "Android"
> (0) Message-Authenticator = 0xaf370dcdcf5551f50dbe03c00a1b1a67
> (0) # Executing section authorize from file
> /usr/local/etc2/freeradius/etc/raddb/sites-enabled/default
> (0) authorize {
> (0) policy filter_username {
> (0) if (!&User-Name) {
> (0) if (!&User-Name) -> FALSE
> (0) if (&User-Name =~ / /) {
> (0) if (&User-Name =~ / /) -> FALSE
> (0) if (&User-Name =~ /@.*@/ ) {
> (0) if (&User-Name =~ /@.*@/ ) -> FALSE
> (0) if (&User-Name =~ /\.\./ ) {
> (0) if (&User-Name =~ /\.\./ ) -> FALSE
> (0) if ((&User-Name =~ /@/) && (&User-Name !~ /@(.+)\.(.+)$/)) {
> (0) if ((&User-Name =~ /@/) && (&User-Name !~ /@(.+)\.(.+)$/)) ->
> FALSE
> (0) if (&User-Name =~ /\.$/) {
> (0) if (&User-Name =~ /\.$/) -> FALSE
> (0) if (&User-Name =~ /@\./) {
> (0) if (&User-Name =~ /@\./) -> FALSE
> (0) } # policy filter_username = notfound
> (0) [preprocess] = ok
> (0) auth_log: EXPAND
> /usr/local/etc2/freeradius/var/log/radius/radacct/%{%{Packet-Src-IP-Address}:-%{Packet-Src-IPv6-Address}}/auth-detail-%Y%m%d
> (0) auth_log: -->
> /usr/local/etc2/freeradius/var/log/radius/radacct/xxx/auth-detail-20151119
> (0) auth_log:
> /usr/local/etc2/freeradius/var/log/radius/radacct/%{%{Packet-Src-IP-Address}:-%{Packet-Src-IPv6-Address}}/auth-detail-%Y%m%d
> expands to
> /usr/local/etc2/freeradius/var/log/radius/radacct/xxx/auth-detail-20151119
> (0) auth_log: EXPAND %t
> (0) auth_log: --> Thu Nov 19 16:13:11 2015
> (0) [auth_log] = ok
> (0) [chap] = noop
> (0) [mschap] = noop
> (0) [digest] = noop
> (0) suffix: Checking for suffix after "@"
> (0) suffix: Looking up realm "unav.es" for User-Name = "oscarrdg at unav.es"
> (0) suffix: Found realm "~^(.*\.)?unav\.es$"
> (0) suffix: Adding Stripped-User-Name = "oscarrdg"
> (0) suffix: Adding Realm = "unav.es"
> (0) suffix: Authentication realm is LOCAL
> (0) [suffix] = ok
> (0) ntdomain: Request already has destination realm set. Ignoring
> (0) [ntdomain] = noop
> (0) eap: Peer sent EAP Response (code 2) ID 1 length 21
> (0) eap: EAP-Identity reply, returning 'ok' so we can short-circuit the
> rest of authorize
> (0) [eap] = ok
> (0) } # authorize = ok
> (0) Found Auth-Type = EAP
> (0) # Executing group from file
> /usr/local/etc2/freeradius/etc/raddb/sites-enabled/default
> (0) authenticate {
> (0) eap: Peer sent packet with method EAP Identity (1)
> (0) eap: Calling submodule eap_md5 to process data
> (0) eap_md5: Issuing MD5 Challenge
> (0) eap: Sending EAP Request (code 1) ID 2 length 22
> (0) eap: EAP session adding &reply:State = 0x4a7c50d94a7e547d
> (0) [eap] = handled
> (0) } # authenticate = handled
> (0) Using Post-Auth-Type Challenge
> (0) Post-Auth-Type sub-section not found. Ignoring.
> (0) # Executing group from file
> /usr/local/etc2/freeradius/etc/raddb/sites-enabled/default
> (0) Sent Access-Challenge Id 32 from xxx:1812 to xxx:45903 length 0
> (0) EAP-Message = 0x0102001604106a56e58dbbd858bd44f49a49b03bb1d7
> (0) Message-Authenticator = 0x00000000000000000000000000000000
> (0) State = 0x4a7c50d94a7e547df1395bb8ee5037b2
> (0) Finished request
> Waking up in 4.9 seconds.
> (1) Received Access-Request Id 237 from xxxxxx:45903 to xx.225:1812 length
> 218
> (1) User-Name = "oscarrdg at unav.es"
> (1) NAS-IP-Address = xxxxxx
> (1) NAS-Port = 0
> (1) NAS-Identifier = "xxxxxx"
> (1) NAS-Port-Type = Wireless-802.11
> (1) Calling-Station-Id = "344DF73C9C98"
> (1) Called-Station-Id = "001A1E003250"
> (1) Service-Type = Framed-User
> (1) Framed-MTU = 1100
> (1) EAP-Message = 0x020200060319
> (1) State = 0x4a7c50d94a7e547df1395bb8ee5037b2
> (1) Aruba-Essid-Name = "eduroam-pre"
> (1) Aruba-Location-Id = "10.9.1"
> (1) Aruba-AP-Group = "Amigos"
> (1) Aruba-Device-Type = "Android"
> (1) Message-Authenticator = 0x84aefd176e8b40d09dbe4a527366c8b7
> (1) session-state: No cached attributes
> (1) # Executing section authorize from file
> /usr/local/etc2/freeradius/etc/raddb/sites-enabled/default
> (1) authorize {
> (1) policy filter_username {
> (1) if (!&User-Name) {
> (1) if (!&User-Name) -> FALSE
> (1) if (&User-Name =~ / /) {
> (1) if (&User-Name =~ / /) -> FALSE
> (1) if (&User-Name =~ /@.*@/ ) {
> (1) if (&User-Name =~ /@.*@/ ) -> FALSE
> (1) if (&User-Name =~ /\.\./ ) {
> (1) if (&User-Name =~ /\.\./ ) -> FALSE
> (1) if ((&User-Name =~ /@/) && (&User-Name !~ /@(.+)\.(.+)$/)) {
> (1) if ((&User-Name =~ /@/) && (&User-Name !~ /@(.+)\.(.+)$/)) ->
> FALSE
> (1) if (&User-Name =~ /\.$/) {
> (1) if (&User-Name =~ /\.$/) -> FALSE
> (1) if (&User-Name =~ /@\./) {
> (1) if (&User-Name =~ /@\./) -> FALSE
> (1) } # policy filter_username = notfound
> (1) [preprocess] = ok
> (1) auth_log: EXPAND
> /usr/local/etc2/freeradius/var/log/radius/radacct/%{%{Packet-Src-IP-Address}:-%{Packet-Src-IPv6-Address}}/auth-detail-%Y%m%d
> (1) auth_log: -->
> /usr/local/etc2/freeradius/var/log/radius/radacct/xxxxxx/auth-detail-20151119
> (1) auth_log:
> /usr/local/etc2/freeradius/var/log/radius/radacct/%{%{Packet-Src-IP-Address}:-%{Packet-Src-IPv6-Address}}/auth-detail-%Y%m%d
> expands to
> /usr/local/etc2/freeradius/var/log/radius/radacct/xxxxxx/auth-detail-20151119
> (1) auth_log: EXPAND %t
> (1) auth_log: --> Thu Nov 19 16:13:11 2015
> (1) [auth_log] = ok
> (1) [chap] = noop
> (1) [mschap] = noop
> (1) [digest] = noop
> (1) suffix: Checking for suffix after "@"
> (1) suffix: Looking up realm "unav.es" for User-Name = "oscarrdg at unav.es"
> (1) suffix: Found realm "~^(.*\.)?unav\.es$"
> (1) suffix: Adding Stripped-User-Name = "oscarrdg"
> (1) suffix: Adding Realm = "unav.es"
> (1) suffix: Authentication realm is LOCAL
> (1) [suffix] = ok
> (1) ntdomain: Request already has destination realm set. Ignoring
> (1) [ntdomain] = noop
> (1) eap: Peer sent EAP Response (code 2) ID 2 length 6
> (1) eap: No EAP Start, assuming it's an on-going EAP conversation
> (1) [eap] = updated
> (1) policy unav.authorize.default {
> (1) if ( "%{client:group}" == "wireless" ) {
> (1) EXPAND %{client:group}
> (1) --> wireless
> (1) if ( "%{client:group}" == "wireless" ) -> TRUE
> (1) if ( "%{client:group}" == "wireless" ) {
> (1) if ( Aruba-Essid-Name == "eduroam" || Aruba-Essid-Name ==
> "eduroam-pre" ) {
> (1) if ( Aruba-Essid-Name == "eduroam" || Aruba-Essid-Name ==
> "eduroam-pre" ) -> TRUE
> (1) if ( Aruba-Essid-Name == "eduroam" || Aruba-Essid-Name ==
> "eduroam-pre" ) {
> (1) policy unav.reject.eduroam.baddomain {
> (1) if ( Realm =~ /myabc\.com$/i ) {
> (1) if ( Realm =~ /myabc\.com$/i ) -> FALSE
> (1) if ( Realm =~
> /wlan\.[[:alnum:]]+\.[[:alnum:]]+\.3gppnetwork\.org$/i ) {
> (1) if ( Realm =~
> /wlan\.[[:alnum:]]+\.[[:alnum:]]+\.3gppnetwork\.org$/i ) -> FALSE
> (1) if ( Realm =~ /gmail\.co(m|\.[[:alnum:]][[:alnum:]])$/i ) {
> (1) if ( Realm =~ /gmail\.co(m|\.[[:alnum:]][[:alnum:]])$/i )
> -> FALSE
> (1) if ( Realm =~ /yahoo\.co(m|\.[[:alnum:]][[:alnum:]])$/i ) {
> (1) if ( Realm =~ /yahoo\.co(m|\.[[:alnum:]][[:alnum:]])$/i )
> -> FALSE
> (1) if ( Realm =~ /hotmail\.co(m|\.[[:alnum:]][[:alnum:]])$/i
> ) {
> (1) if ( Realm =~ /hotmail\.co(m|\.[[:alnum:]][[:alnum:]])$/i
> ) -> FALSE
> (1) } # policy unav.reject.eduroam.baddomain = updated
> (1) if ( Service-Type == "Login-User" ) {
> (1) if ( Service-Type == "Login-User" ) -> FALSE
> (1) } # if ( Aruba-Essid-Name == "eduroam" || Aruba-Essid-Name ==
> "eduroam-pre" ) = updated
> (1) ... skipping elsif for request 1: Preceding "if" was taken
> (1) ... skipping else for request 1: Preceding "if" was taken
> (1) } # if ( "%{client:group}" == "wireless" ) = updated
> (1) ... skipping elsif for request 1: Preceding "if" was taken
> (1) ... skipping elsif for request 1: Preceding "if" was taken
> (1) ... skipping elsif for request 1: Preceding "if" was taken
> (1) ... skipping elsif for request 1: Preceding "if" was taken
> (1) ... skipping elsif for request 1: Preceding "if" was taken
> (1) ... skipping else for request 1: Preceding "if" was taken
> (1) } # policy unav.authorize.default = updated
> (1) [expiration] = noop
> (1) [logintime] = noop
> (1) pap: WARNING: No "known good" password found for the user. Not
> setting Auth-Type
> (1) pap: WARNING: Authentication will fail unless a "known good" password
> is available
> (1) [pap] = noop
> (1) if (control:Cleartext-Password) {
> (1) if (control:Cleartext-Password) -> FALSE
> (1) } # authorize = updated
> (1) Found Auth-Type = EAP
> (1) # Executing group from file
> /usr/local/etc2/freeradius/etc/raddb/sites-enabled/default
> (1) authenticate {
> (1) eap: Expiring EAP session with state 0x4a7c50d94a7e547d
> (1) eap: Finished EAP session with state 0x4a7c50d94a7e547d
> (1) eap: Previous EAP request found for state 0x4a7c50d94a7e547d, released
> from the list
> (1) eap: Peer sent packet with method EAP NAK (3)
> (1) eap: Found mutually acceptable type PEAP (25)
> (1) eap: Calling submodule eap_peap to process data
> (1) eap_peap: Initiating new EAP-TLS session
> (1) eap_peap: Flushing SSL sessions (of #0)
> (1) eap_peap: [eaptls start] = request
> (1) eap: Sending EAP Request (code 1) ID 3 length 6
> (1) eap: EAP session adding &reply:State = 0x4a7c50d94b7f497d
> (1) [eap] = handled
> (1) } # authenticate = handled
> (1) Using Post-Auth-Type Challenge
> (1) Post-Auth-Type sub-section not found. Ignoring.
> (1) # Executing group from file
> /usr/local/etc2/freeradius/etc/raddb/sites-enabled/default
> (1) Sent Access-Challenge Id 237 from xxx12.225:1812 to xxxxxx:45903
> length 0
> (1) EAP-Message = 0x010300061920
> (1) Message-Authenticator = 0x00000000000000000000000000000000
> (1) State = 0x4a7c50d94b7f497df1395bb8ee5037b2
> (1) Finished request
> Waking up in 4.9 seconds.
> (2) Received Access-Request Id 126 from xxxxxx:45903 to xxx12.225:1812
> length 380
> (2) User-Name = "oscarrdg at unav.es"
> (2) NAS-IP-Address = xxxxxx
> (2) NAS-Port = 0
> (2) NAS-Identifier = "xxxxxx"
> (2) NAS-Port-Type = Wireless-802.11
> (2) Calling-Station-Id = "344DF73C9C98"
> (2) Called-Station-Id = "001A1E003250"
> (2) Service-Type = Framed-User
> (2) Framed-MTU = 1100
> (2) EAP-Message =
> 0x020300a819800000009e160301009901000095030389bc40fcda2b3a01d0bd76bc2cd77cc2a31e6d59aa10c82aba3cd714a628ceca00003cc02cc030009fc02bc02f009ec00ac024c014c0280039006bc009c023c013c02700330067c007c011009d009c0035003d002f003c00050004000a00ff010000
> (2) State = 0x4a7c50d94b7f497df1395bb8ee5037b2
> (2) Aruba-Essid-Name = "eduroam-pre"
> (2) Aruba-Location-Id = "10.9.1"
> (2) Aruba-AP-Group = "Amigos"
> (2) Aruba-Device-Type = "Android"
> (2) Message-Authenticator = 0x5a70fd8f3ee58367fba8226efb8fca04
> (2) session-state: No cached attributes
> (2) # Executing section authorize from file
> /usr/local/etc2/freeradius/etc/raddb/sites-enabled/default
> (2) authorize {
> (2) policy filter_username {
> (2) if (!&User-Name) {
> (2) if (!&User-Name) -> FALSE
> (2) if (&User-Name =~ / /) {
> (2) if (&User-Name =~ / /) -> FALSE
> (2) if (&User-Name =~ /@.*@/ ) {
> (2) if (&User-Name =~ /@.*@/ ) -> FALSE
> (2) if (&User-Name =~ /\.\./ ) {
> (2) if (&User-Name =~ /\.\./ ) -> FALSE
> (2) if ((&User-Name =~ /@/) && (&User-Name !~ /@(.+)\.(.+)$/)) {
> (2) if ((&User-Name =~ /@/) && (&User-Name !~ /@(.+)\.(.+)$/)) ->
> FALSE
> (2) if (&User-Name =~ /\.$/) {
> (2) if (&User-Name =~ /\.$/) -> FALSE
> (2) if (&User-Name =~ /@\./) {
> (2) if (&User-Name =~ /@\./) -> FALSE
> (2) } # policy filter_username = notfound
> (2) [preprocess] = ok
> (2) auth_log: EXPAND
> /usr/local/etc2/freeradius/var/log/radius/radacct/%{%{Packet-Src-IP-Address}:-%{Packet-Src-IPv6-Address}}/auth-detail-%Y%m%d
> (2) auth_log: -->
> /usr/local/etc2/freeradius/var/log/radius/radacct/xxxxxx/auth-detail-20151119
> (2) auth_log:
> /usr/local/etc2/freeradius/var/log/radius/radacct/%{%{Packet-Src-IP-Address}:-%{Packet-Src-IPv6-Address}}/auth-detail-%Y%m%d
> expands to
> /usr/local/etc2/freeradius/var/log/radius/radacct/xxxxxx/auth-detail-20151119
> (2) auth_log: EXPAND %t
> (2) auth_log: --> Thu Nov 19 16:13:11 2015
> (2) [auth_log] = ok
> (2) [chap] = noop
> (2) [mschap] = noop
> (2) [digest] = noop
> (2) suffix: Checking for suffix after "@"
> (2) suffix: Looking up realm "unav.es" for User-Name = "oscarrdg at unav.es"
> (2) suffix: Found realm "~^(.*\.)?unav\.es$"
> (2) suffix: Adding Stripped-User-Name = "oscarrdg"
> (2) suffix: Adding Realm = "unav.es"
> (2) suffix: Authentication realm is LOCAL
> (2) [suffix] = ok
> (2) ntdomain: Request already has destination realm set. Ignoring
> (2) [ntdomain] = noop
> (2) eap: Peer sent EAP Response (code 2) ID 3 length 168
> (2) eap: Continuing tunnel setup
> (2) [eap] = ok
> (2) } # authorize = ok
> (2) Found Auth-Type = EAP
> (2) # Executing group from file
> /usr/local/etc2/freeradius/etc/raddb/sites-enabled/default
> (2) authenticate {
> (2) eap: Expiring EAP session with state 0x4a7c50d94b7f497d
> (2) eap: Finished EAP session with state 0x4a7c50d94b7f497d
> (2) eap: Previous EAP request found for state 0x4a7c50d94b7f497d, released
> from the list
> (2) eap: Peer sent packet with method EAP PEAP (25)
> (2) eap: Calling submodule eap_peap to process data
> (2) eap_peap: Continuing EAP-TLS
> (2) eap_peap: Peer indicated complete TLS record size will be 158 bytes
> (2) eap_peap: Got complete TLS record (158 bytes)
> (2) eap_peap: [eaptls verify] = length included
> (2) eap_peap: (other): before/accept initialization
> (2) eap_peap: TLS_accept: before/accept initialization
> (2) eap_peap: <<< TLS 1.2 [length 0099]
> (2) eap_peap: TLS_accept: SSLv3 read client hello A
> (2) eap_peap: >>> TLS 1.2 [length 0059]
> (2) eap_peap: TLS_accept: SSLv3 write server hello A
> (2) eap_peap: >>> TLS 1.2 [length 11ce]
> (2) eap_peap: TLS_accept: SSLv3 write certificate A
> (2) eap_peap: >>> TLS 1.2 [length 014d]
> (2) eap_peap: TLS_accept: SSLv3 write key exchange A
> (2) eap_peap: >>> TLS 1.2 [length 0004]
> (2) eap_peap: TLS_accept: SSLv3 write server done A
> (2) eap_peap: TLS_accept: SSLv3 flush data
> (2) eap_peap: TLS_accept: Need to read more data: SSLv3 read client
> certificate A
> (2) eap_peap: TLS_accept: Need to read more data: SSLv3 read client
> certificate A
> (2) eap_peap: In SSL Handshake Phase
> (2) eap_peap: In SSL Accept mode
> (2) eap_peap: [eaptls process] = handled
> (2) eap: Sending EAP Request (code 1) ID 4 length 1004
> (2) eap: EAP session adding &reply:State = 0x4a7c50d94878497d
> (2) [eap] = handled
> (2) } # authenticate = handled
> (2) Using Post-Auth-Type Challenge
> (2) Post-Auth-Type sub-section not found. Ignoring.
> (2) # Executing group from file
> /usr/local/etc2/freeradius/etc/raddb/sites-enabled/default
> (2) Sent Access-Challenge Id 126 from xxx12.225:1812 to xxxxxx:45903
> length 0
> (2) EAP-Message =
> 0x010403ec19c00000138c1603030059020000550303564de7077094b72f12c56237fbc9affbe100f088a0685fec0f9239b56ae77d0620e7b0567766cb019801cfbfed0facaa4f74a4e4e1bf48c6e2807b179ab3eab127c03000000dff01000100000b00040300010216030311ce0b0011ca0011c70004a5
> (2) Message-Authenticator = 0x00000000000000000000000000000000
> (2) State = 0x4a7c50d94878497df1395bb8ee5037b2
> (2) Finished request
> Waking up in 4.9 seconds.
> (3) Received Access-Request Id 64 from xxxxxx:45903 to xxx12.225:1812
> length 218
> (3) User-Name = "oscarrdg at unav.es"
> (3) NAS-IP-Address = xxxxxx
> (3) NAS-Port = 0
> (3) NAS-Identifier = "xxxxxx"
> (3) NAS-Port-Type = Wireless-802.11
> (3) Calling-Station-Id = "344DF73C9C98"
> (3) Called-Station-Id = "001A1E003250"
> (3) Service-Type = Framed-User
> (3) Framed-MTU = 1100
> (3) EAP-Message = 0x020400061900
> (3) State = 0x4a7c50d94878497df1395bb8ee5037b2
> (3) Aruba-Essid-Name = "eduroam-pre"
> (3) Aruba-Location-Id = "10.9.1"
> (3) Aruba-AP-Group = "Amigos"
> (3) Aruba-Device-Type = "Android"
> (3) Message-Authenticator = 0x3aec9ff6dcbdf02f48d43f32e48157e4
> (3) session-state: No cached attributes
> (3) # Executing section authorize from file
> /usr/local/etc2/freeradius/etc/raddb/sites-enabled/default
> (3) authorize {
> (3) policy filter_username {
> (3) if (!&User-Name) {
> (3) if (!&User-Name) -> FALSE
> (3) if (&User-Name =~ / /) {
> (3) if (&User-Name =~ / /) -> FALSE
> (3) if (&User-Name =~ /@.*@/ ) {
> (3) if (&User-Name =~ /@.*@/ ) -> FALSE
> (3) if (&User-Name =~ /\.\./ ) {
> (3) if (&User-Name =~ /\.\./ ) -> FALSE
> (3) if ((&User-Name =~ /@/) && (&User-Name !~ /@(.+)\.(.+)$/)) {
> (3) if ((&User-Name =~ /@/) && (&User-Name !~ /@(.+)\.(.+)$/)) ->
> FALSE
> (3) if (&User-Name =~ /\.$/) {
> (3) if (&User-Name =~ /\.$/) -> FALSE
> (3) if (&User-Name =~ /@\./) {
> (3) if (&User-Name =~ /@\./) -> FALSE
> (3) } # policy filter_username = notfound
> (3) [preprocess] = ok
> (3) auth_log: EXPAND
> /usr/local/etc2/freeradius/var/log/radius/radacct/%{%{Packet-Src-IP-Address}:-%{Packet-Src-IPv6-Address}}/auth-detail-%Y%m%d
> (3) auth_log: -->
> /usr/local/etc2/freeradius/var/log/radius/radacct/xxxxxx/auth-detail-20151119
> (3) auth_log:
> /usr/local/etc2/freeradius/var/log/radius/radacct/%{%{Packet-Src-IP-Address}:-%{Packet-Src-IPv6-Address}}/auth-detail-%Y%m%d
> expands to
> /usr/local/etc2/freeradius/var/log/radius/radacct/xxxxxx/auth-detail-20151119
> (3) auth_log: EXPAND %t
> (3) auth_log: --> Thu Nov 19 16:13:11 2015
> (3) [auth_log] = ok
> (3) [chap] = noop
> (3) [mschap] = noop
> (3) [digest] = noop
> (3) suffix: Checking for suffix after "@"
> (3) suffix: Looking up realm "unav.es" for User-Name = "oscarrdg at unav.es"
> (3) suffix: Found realm "~^(.*\.)?unav\.es$"
> (3) suffix: Adding Stripped-User-Name = "oscarrdg"
> (3) suffix: Adding Realm = "unav.es"
> (3) suffix: Authentication realm is LOCAL
> (3) [suffix] = ok
> (3) ntdomain: Request already has destination realm set. Ignoring
> (3) [ntdomain] = noop
> (3) eap: Peer sent EAP Response (code 2) ID 4 length 6
> (3) eap: Continuing tunnel setup
> (3) [eap] = ok
> (3) } # authorize = ok
> (3) Found Auth-Type = EAP
> (3) # Executing group from file
> /usr/local/etc2/freeradius/etc/raddb/sites-enabled/default
> (3) authenticate {
> (3) eap: Expiring EAP session with state 0x4a7c50d94878497d
> (3) eap: Finished EAP session with state 0x4a7c50d94878497d
> (3) eap: Previous EAP request found for state 0x4a7c50d94878497d, released
> from the list
> (3) eap: Peer sent packet with method EAP PEAP (25)
> (3) eap: Calling submodule eap_peap to process data
> (3) eap_peap: Continuing EAP-TLS
> (3) eap_peap: Peer ACKed our handshake fragment
> (3) eap_peap: [eaptls verify] = request
> (3) eap_peap: [eaptls process] = handled
> (3) eap: Sending EAP Request (code 1) ID 5 length 1000
> (3) eap: EAP session adding &reply:State = 0x4a7c50d94979497d
> (3) [eap] = handled
> (3) } # authenticate = handled
> (3) Using Post-Auth-Type Challenge
> (3) Post-Auth-Type sub-section not found. Ignoring.
> (3) # Executing group from file
> /usr/local/etc2/freeradius/etc/raddb/sites-enabled/default
> (3) Sent Access-Challenge Id 64 from xxx12.225:1812 to xxxxxx:45903 length
> 0
> (3) EAP-Message =
> 0x010503e819402e73692e756e61762e6573820f7261646975732e756e61762e656475300d06092a864886f70d010105050003820101008d5a00339dca417d4b5b7c98c5d05763925d58ea76ff6431c64313da556a5d759f867846b256881352385407721c3b81539755438573a805ecb0acdf0a94a9f874
> (3) Message-Authenticator = 0x00000000000000000000000000000000
> (3) State = 0x4a7c50d94979497df1395bb8ee5037b2
> (3) Finished request
> Waking up in 4.9 seconds.
> (4) Received Access-Request Id 234 from xxxxxx:45903 to xxx12.225:1812
> length 218
> (4) User-Name = "oscarrdg at unav.es"
> (4) NAS-IP-Address = xxxxxx
> (4) NAS-Port = 0
> (4) NAS-Identifier = "xxxxxx"
> (4) NAS-Port-Type = Wireless-802.11
> (4) Calling-Station-Id = "344DF73C9C98"
> (4) Called-Station-Id = "001A1E003250"
> (4) Service-Type = Framed-User
> (4) Framed-MTU = 1100
> (4) EAP-Message = 0x020500061900
> (4) State = 0x4a7c50d94979497df1395bb8ee5037b2
> (4) Aruba-Essid-Name = "eduroam-pre"
> (4) Aruba-Location-Id = "10.9.1"
> (4) Aruba-AP-Group = "Amigos"
> (4) Aruba-Device-Type = "Android"
> (4) Message-Authenticator = 0x8a034f3911b75ff877975ad4bec02ff4
> (4) session-state: No cached attributes
> (4) # Executing section authorize from file
> /usr/local/etc2/freeradius/etc/raddb/sites-enabled/default
> (4) authorize {
> (4) policy filter_username {
> (4) if (!&User-Name) {
> (4) if (!&User-Name) -> FALSE
> (4) if (&User-Name =~ / /) {
> (4) if (&User-Name =~ / /) -> FALSE
> (4) if (&User-Name =~ /@.*@/ ) {
> (4) if (&User-Name =~ /@.*@/ ) -> FALSE
> (4) if (&User-Name =~ /\.\./ ) {
> (4) if (&User-Name =~ /\.\./ ) -> FALSE
> (4) if ((&User-Name =~ /@/) && (&User-Name !~ /@(.+)\.(.+)$/)) {
> (4) if ((&User-Name =~ /@/) && (&User-Name !~ /@(.+)\.(.+)$/)) ->
> FALSE
> (4) if (&User-Name =~ /\.$/) {
> (4) if (&User-Name =~ /\.$/) -> FALSE
> (4) if (&User-Name =~ /@\./) {
> (4) if (&User-Name =~ /@\./) -> FALSE
> (4) } # policy filter_username = notfound
> (4) [preprocess] = ok
> (4) auth_log: EXPAND
> /usr/local/etc2/freeradius/var/log/radius/radacct/%{%{Packet-Src-IP-Address}:-%{Packet-Src-IPv6-Address}}/auth-detail-%Y%m%d
> (4) auth_log: -->
> /usr/local/etc2/freeradius/var/log/radius/radacct/xxxxxx/auth-detail-20151119
> (4) auth_log:
> /usr/local/etc2/freeradius/var/log/radius/radacct/%{%{Packet-Src-IP-Address}:-%{Packet-Src-IPv6-Address}}/auth-detail-%Y%m%d
> expands to
> /usr/local/etc2/freeradius/var/log/radius/radacct/xxxxxx/auth-detail-20151119
> (4) auth_log: EXPAND %t
> (4) auth_log: --> Thu Nov 19 16:13:11 2015
> (4) [auth_log] = ok
> (4) [chap] = noop
> (4) [mschap] = noop
> (4) [digest] = noop
> (4) suffix: Checking for suffix after "@"
> (4) suffix: Looking up realm "unav.es" for User-Name = "oscarrdg at unav.es"
> (4) suffix: Found realm "~^(.*\.)?unav\.es$"
> (4) suffix: Adding Stripped-User-Name = "oscarrdg"
> (4) suffix: Adding Realm = "unav.es"
> (4) suffix: Authentication realm is LOCAL
> (4) [suffix] = ok
> (4) ntdomain: Request already has destination realm set. Ignoring
> (4) [ntdomain] = noop
> (4) eap: Peer sent EAP Response (code 2) ID 5 length 6
> (4) eap: Continuing tunnel setup
> (4) [eap] = ok
> (4) } # authorize = ok
> (4) Found Auth-Type = EAP
> (4) # Executing group from file
> /usr/local/etc2/freeradius/etc/raddb/sites-enabled/default
> (4) authenticate {
> (4) eap: Expiring EAP session with state 0x4a7c50d94979497d
> (4) eap: Finished EAP session with state 0x4a7c50d94979497d
> (4) eap: Previous EAP request found for state 0x4a7c50d94979497d, released
> from the list
> (4) eap: Peer sent packet with method EAP PEAP (25)
> (4) eap: Calling submodule eap_peap to process data
> (4) eap_peap: Continuing EAP-TLS
> (4) eap_peap: Peer ACKed our handshake fragment
> (4) eap_peap: [eaptls verify] = request
> (4) eap_peap: [eaptls process] = handled
> (4) eap: Sending EAP Request (code 1) ID 6 length 1000
> (4) eap: EAP session adding &reply:State = 0x4a7c50d94e7a497d
> (4) [eap] = handled
> (4) } # authenticate = handled
> (4) Using Post-Auth-Type Challenge
> (4) Post-Auth-Type sub-section not found. Ignoring.
> (4) # Executing group from file
> /usr/local/etc2/freeradius/etc/raddb/sites-enabled/default
> (4) Sent Access-Challenge Id 234 from xxx12.225:1812 to xxxxxx:45903
> length 0
> (4) EAP-Message =
> 0x010603e8194002010030180603551d200411300f300d060b2b06010401b2310102021d30440603551d1f043d303b3039a037a0358633687474703a2f2f63726c2e7573657274727573742e636f6d2f55544e2d5553455246697273742d48617264776172652e63726c307406082b060105050701010468
> (4) Message-Authenticator = 0x00000000000000000000000000000000
> (4) State = 0x4a7c50d94e7a497df1395bb8ee5037b2
> (4) Finished request
> Waking up in 4.9 seconds.
> (5) Received Access-Request Id 230 from xxxxxx:45903 to xxx12.225:1812
> length 218
> (5) User-Name = "oscarrdg at unav.es"
> (5) NAS-IP-Address = xxxxxx
> (5) NAS-Port = 0
> (5) NAS-Identifier = "xxxxxx"
> (5) NAS-Port-Type = Wireless-802.11
> (5) Calling-Station-Id = "344DF73C9C98"
> (5) Called-Station-Id = "001A1E003250"
> (5) Service-Type = Framed-User
> (5) Framed-MTU = 1100
> (5) EAP-Message = 0x020600061900
> (5) State = 0x4a7c50d94e7a497df1395bb8ee5037b2
> (5) Aruba-Essid-Name = "eduroam-pre"
> (5) Aruba-Location-Id = "10.9.1"
> (5) Aruba-AP-Group = "Amigos"
> (5) Aruba-Device-Type = "Android"
> (5) Message-Authenticator = 0x27a324ae82db56460d95f8e34748e3a8
> (5) session-state: No cached attributes
> (5) # Executing section authorize from file
> /usr/local/etc2/freeradius/etc/raddb/sites-enabled/default
> (5) authorize {
> (5) policy filter_username {
> (5) if (!&User-Name) {
> (5) if (!&User-Name) -> FALSE
> (5) if (&User-Name =~ / /) {
> (5) if (&User-Name =~ / /) -> FALSE
> (5) if (&User-Name =~ /@.*@/ ) {
> (5) if (&User-Name =~ /@.*@/ ) -> FALSE
> (5) if (&User-Name =~ /\.\./ ) {
> (5) if (&User-Name =~ /\.\./ ) -> FALSE
> (5) if ((&User-Name =~ /@/) && (&User-Name !~ /@(.+)\.(.+)$/)) {
> (5) if ((&User-Name =~ /@/) && (&User-Name !~ /@(.+)\.(.+)$/)) ->
> FALSE
> (5) if (&User-Name =~ /\.$/) {
> (5) if (&User-Name =~ /\.$/) -> FALSE
> (5) if (&User-Name =~ /@\./) {
> (5) if (&User-Name =~ /@\./) -> FALSE
> (5) } # policy filter_username = notfound
> (5) [preprocess] = ok
> (5) auth_log: EXPAND
> /usr/local/etc2/freeradius/var/log/radius/radacct/%{%{Packet-Src-IP-Address}:-%{Packet-Src-IPv6-Address}}/auth-detail-%Y%m%d
> (5) auth_log: -->
> /usr/local/etc2/freeradius/var/log/radius/radacct/xxxxxx/auth-detail-20151119
> (5) auth_log:
> /usr/local/etc2/freeradius/var/log/radius/radacct/%{%{Packet-Src-IP-Address}:-%{Packet-Src-IPv6-Address}}/auth-detail-%Y%m%d
> expands to
> /usr/local/etc2/freeradius/var/log/radius/radacct/xxxxxx/auth-detail-20151119
> (5) auth_log: EXPAND %t
> (5) auth_log: --> Thu Nov 19 16:13:11 2015
> (5) [auth_log] = ok
> (5) [chap] = noop
> (5) [mschap] = noop
> (5) [digest] = noop
> (5) suffix: Checking for suffix after "@"
> (5) suffix: Looking up realm "unav.es" for User-Name = "oscarrdg at unav.es"
> (5) suffix: Found realm "~^(.*\.)?unav\.es$"
> (5) suffix: Adding Stripped-User-Name = "oscarrdg"
> (5) suffix: Adding Realm = "unav.es"
> (5) suffix: Authentication realm is LOCAL
> (5) [suffix] = ok
> (5) ntdomain: Request already has destination realm set. Ignoring
> (5) [ntdomain] = noop
> (5) eap: Peer sent EAP Response (code 2) ID 6 length 6
> (5) eap: Continuing tunnel setup
> (5) [eap] = ok
> (5) } # authorize = ok
> (5) Found Auth-Type = EAP
> (5) # Executing group from file
> /usr/local/etc2/freeradius/etc/raddb/sites-enabled/default
> (5) authenticate {
> (5) eap: Expiring EAP session with state 0x4a7c50d94e7a497d
> (5) eap: Finished EAP session with state 0x4a7c50d94e7a497d
> (5) eap: Previous EAP request found for state 0x4a7c50d94e7a497d, released
> from the list
> (5) eap: Peer sent packet with method EAP PEAP (25)
> (5) eap: Calling submodule eap_peap to process data
> (5) eap_peap: Continuing EAP-TLS
> (5) eap_peap: Peer ACKed our handshake fragment
> (5) eap_peap: [eaptls verify] = request
> (5) eap_peap: [eaptls process] = handled
> (5) eap: Sending EAP Request (code 1) ID 7 length 1000
> (5) eap: EAP session adding &reply:State = 0x4a7c50d94f7b497d
> (5) [eap] = handled
> (5) } # authenticate = handled
> (5) Using Post-Auth-Type Challenge
> (5) Post-Auth-Type sub-section not found. Ignoring.
> (5) # Executing group from file
> /usr/local/etc2/freeradius/etc/raddb/sites-enabled/default
> (5) Sent Access-Challenge Id 230 from xxx12.225:1812 to xxxxxx:45903
> length 0
> (5) EAP-Message =
> 0x010703e8194007386ec3a55e23bc459b7b50c1c9308fdbe52b7ad35bfb33401ea0d59817bc8b87c389d35da08eb2aaaaf68e698806c5fa8921f3089d692e09339b290d460f8ccc4934b06951bdf906cd68ad664cbc3eac61bd0a880ec8df3dee7c044c9d0a5e6b91d6eec7ed288dab4d878973d06ea4d0
> (5) Message-Authenticator = 0x00000000000000000000000000000000
> (5) State = 0x4a7c50d94f7b497df1395bb8ee5037b2
> (5) Finished request
> Waking up in 4.9 seconds.
> (6) Received Access-Request Id 168 from xxxxxx:45903 to xxx12.225:1812
> length 218
> (6) User-Name = "oscarrdg at unav.es"
> (6) NAS-IP-Address = xxxxxx
> (6) NAS-Port = 0
> (6) NAS-Identifier = "xxxxxx"
> (6) NAS-Port-Type = Wireless-802.11
> (6) Calling-Station-Id = "344DF73C9C98"
> (6) Called-Station-Id = "001A1E003250"
> (6) Service-Type = Framed-User
> (6) Framed-MTU = 1100
> (6) EAP-Message = 0x020700061900
> (6) State = 0x4a7c50d94f7b497df1395bb8ee5037b2
> (6) Aruba-Essid-Name = "eduroam-pre"
> (6) Aruba-Location-Id = "10.9.1"
> (6) Aruba-AP-Group = "Amigos"
> (6) Aruba-Device-Type = "Android"
> (6) Message-Authenticator = 0x4cf19771edbbc663364c4e61d84ea4ca
> (6) session-state: No cached attributes
> (6) # Executing section authorize from file
> /usr/local/etc2/freeradius/etc/raddb/sites-enabled/default
> (6) authorize {
> (6) policy filter_username {
> (6) if (!&User-Name) {
> (6) if (!&User-Name) -> FALSE
> (6) if (&User-Name =~ / /) {
> (6) if (&User-Name =~ / /) -> FALSE
> (6) if (&User-Name =~ /@.*@/ ) {
> (6) if (&User-Name =~ /@.*@/ ) -> FALSE
> (6) if (&User-Name =~ /\.\./ ) {
> (6) if (&User-Name =~ /\.\./ ) -> FALSE
> (6) if ((&User-Name =~ /@/) && (&User-Name !~ /@(.+)\.(.+)$/)) {
> (6) if ((&User-Name =~ /@/) && (&User-Name !~ /@(.+)\.(.+)$/)) ->
> FALSE
> (6) if (&User-Name =~ /\.$/) {
> (6) if (&User-Name =~ /\.$/) -> FALSE
> (6) if (&User-Name =~ /@\./) {
> (6) if (&User-Name =~ /@\./) -> FALSE
> (6) } # policy filter_username = notfound
> (6) [preprocess] = ok
> (6) auth_log: EXPAND
> /usr/local/etc2/freeradius/var/log/radius/radacct/%{%{Packet-Src-IP-Address}:-%{Packet-Src-IPv6-Address}}/auth-detail-%Y%m%d
> (6) auth_log: -->
> /usr/local/etc2/freeradius/var/log/radius/radacct/xxxxxx/auth-detail-20151119
> (6) auth_log:
> /usr/local/etc2/freeradius/var/log/radius/radacct/%{%{Packet-Src-IP-Address}:-%{Packet-Src-IPv6-Address}}/auth-detail-%Y%m%d
> expands to
> /usr/local/etc2/freeradius/var/log/radius/radacct/xxxxxx/auth-detail-20151119
> (6) auth_log: EXPAND %t
> (6) auth_log: --> Thu Nov 19 16:13:11 2015
> (6) [auth_log] = ok
> (6) [chap] = noop
> (6) [mschap] = noop
> (6) [digest] = noop
> (6) suffix: Checking for suffix after "@"
> (6) suffix: Looking up realm "unav.es" for User-Name = "oscarrdg at unav.es"
> (6) suffix: Found realm "~^(.*\.)?unav\.es$"
> (6) suffix: Adding Stripped-User-Name = "oscarrdg"
> (6) suffix: Adding Realm = "unav.es"
> (6) suffix: Authentication realm is LOCAL
> (6) [suffix] = ok
> (6) ntdomain: Request already has destination realm set. Ignoring
> (6) [ntdomain] = noop
> (6) eap: Peer sent EAP Response (code 2) ID 7 length 6
> (6) eap: Continuing tunnel setup
> (6) [eap] = ok
> (6) } # authorize = ok
> (6) Found Auth-Type = EAP
> (6) # Executing group from file
> /usr/local/etc2/freeradius/etc/raddb/sites-enabled/default
> (6) authenticate {
> (6) eap: Expiring EAP session with state 0x4a7c50d94f7b497d
> (6) eap: Finished EAP session with state 0x4a7c50d94f7b497d
> (6) eap: Previous EAP request found for state 0x4a7c50d94f7b497d, released
> from the list
> (6) eap: Peer sent packet with method EAP PEAP (25)
> (6) eap: Calling submodule eap_peap to process data
> (6) eap_peap: Continuing EAP-TLS
> (6) eap_peap: Peer ACKed our handshake fragment
> (6) eap_peap: [eaptls verify] = request
> (6) eap_peap: [eaptls process] = handled
> (6) eap: Sending EAP Request (code 1) ID 8 length 1000
> (6) eap: EAP session adding &reply:State = 0x4a7c50d94c74497d
> (6) [eap] = handled
> (6) } # authenticate = handled
> (6) Using Post-Auth-Type Challenge
> (6) Post-Auth-Type sub-section not found. Ignoring.
> (6) # Executing group from file
> /usr/local/etc2/freeradius/etc/raddb/sites-enabled/default
> (6) Sent Access-Challenge Id 168 from xxx12.225:1812 to xxxxxx:45903
> length 0
> (6) EAP-Message =
> 0x010803e81940e8329e74cac89054e9c65f0f789d9a403c0eac61aa5e148f9e87a16a50dcd79a4eaf05b3a671949c71b350600ac7139d38078602a8e9a869261890ab4cb04f23ab3a4f84d8dfce9fe1696fbbd742d76b44e4c7adee6d415f725a710837b37965a459a09437f7002f0dc29272dad03872db
> (6) Message-Authenticator = 0x00000000000000000000000000000000
> (6) State = 0x4a7c50d94c74497df1395bb8ee5037b2
> (6) Finished request
> Waking up in 4.8 seconds.
> (7) Received Access-Request Id 112 from xxxxxx:45903 to xxx12.225:1812
> length 218
> (7) User-Name = "oscarrdg at unav.es"
> (7) NAS-IP-Address = xxxxxx
> (7) NAS-Port = 0
> (7) NAS-Identifier = "xxxxxx"
> (7) NAS-Port-Type = Wireless-802.11
> (7) Calling-Station-Id = "344DF73C9C98"
> (7) Called-Station-Id = "001A1E003250"
> (7) Service-Type = Framed-User
> (7) Framed-MTU = 1100
> (7) EAP-Message = 0x020800061900
> (7) State = 0x4a7c50d94c74497df1395bb8ee5037b2
> (7) Aruba-Essid-Name = "eduroam-pre"
> (7) Aruba-Location-Id = "10.9.1"
> (7) Aruba-AP-Group = "Amigos"
> (7) Aruba-Device-Type = "Android"
> (7) Message-Authenticator = 0x15bf70b018be20dac76d5bdc4532dc08
> (7) session-state: No cached attributes
> (7) # Executing section authorize from file
> /usr/local/etc2/freeradius/etc/raddb/sites-enabled/default
> (7) authorize {
> (7) policy filter_username {
> (7) if (!&User-Name) {
> (7) if (!&User-Name) -> FALSE
> (7) if (&User-Name =~ / /) {
> (7) if (&User-Name =~ / /) -> FALSE
> (7) if (&User-Name =~ /@.*@/ ) {
> (7) if (&User-Name =~ /@.*@/ ) -> FALSE
> (7) if (&User-Name =~ /\.\./ ) {
> (7) if (&User-Name =~ /\.\./ ) -> FALSE
> (7) if ((&User-Name =~ /@/) && (&User-Name !~ /@(.+)\.(.+)$/)) {
> (7) if ((&User-Name =~ /@/) && (&User-Name !~ /@(.+)\.(.+)$/)) ->
> FALSE
> (7) if (&User-Name =~ /\.$/) {
> (7) if (&User-Name =~ /\.$/) -> FALSE
> (7) if (&User-Name =~ /@\./) {
> (7) if (&User-Name =~ /@\./) -> FALSE
> (7) } # policy filter_username = notfound
> (7) [preprocess] = ok
> (7) auth_log: EXPAND
> /usr/local/etc2/freeradius/var/log/radius/radacct/%{%{Packet-Src-IP-Address}:-%{Packet-Src-IPv6-Address}}/auth-detail-%Y%m%d
> (7) auth_log: -->
> /usr/local/etc2/freeradius/var/log/radius/radacct/xxxxxx/auth-detail-20151119
> (7) auth_log:
> /usr/local/etc2/freeradius/var/log/radius/radacct/%{%{Packet-Src-IP-Address}:-%{Packet-Src-IPv6-Address}}/auth-detail-%Y%m%d
> expands to
> /usr/local/etc2/freeradius/var/log/radius/radacct/xxxxxx/auth-detail-20151119
> (7) auth_log: EXPAND %t
> (7) auth_log: --> Thu Nov 19 16:13:11 2015
> (7) [auth_log] = ok
> (7) [chap] = noop
> (7) [mschap] = noop
> (7) [digest] = noop
> (7) suffix: Checking for suffix after "@"
> (7) suffix: Looking up realm "unav.es" for User-Name = "oscarrdg at unav.es"
> (7) suffix: Found realm "~^(.*\.)?unav\.es$"
> (7) suffix: Adding Stripped-User-Name = "oscarrdg"
> (7) suffix: Adding Realm = "unav.es"
> (7) suffix: Authentication realm is LOCAL
> (7) [suffix] = ok
> (7) ntdomain: Request already has destination realm set. Ignoring
> (7) [ntdomain] = noop
> (7) eap: Peer sent EAP Response (code 2) ID 8 length 6
> (7) eap: Continuing tunnel setup
> (7) [eap] = ok
> (7) } # authorize = ok
> (7) Found Auth-Type = EAP
> (7) # Executing group from file
> /usr/local/etc2/freeradius/etc/raddb/sites-enabled/default
> (7) authenticate {
> (7) eap: Expiring EAP session with state 0x4a7c50d94c74497d
> (7) eap: Finished EAP session with state 0x4a7c50d94c74497d
> (7) eap: Previous EAP request found for state 0x4a7c50d94c74497d, released
> from the list
> (7) eap: Peer sent packet with method EAP PEAP (25)
> (7) eap: Calling submodule eap_peap to process data
> (7) eap_peap: Continuing EAP-TLS
> (7) eap_peap: Peer ACKed our handshake fragment
> (7) eap_peap: [eaptls verify] = request
> (7) eap_peap: [eaptls process] = handled
> (7) eap: Sending EAP Request (code 1) ID 9 length 40
> (7) eap: EAP session adding &reply:State = 0x4a7c50d94d75497d
> (7) [eap] = handled
> (7) } # authenticate = handled
> (7) Using Post-Auth-Type Challenge
> (7) Post-Auth-Type sub-section not found. Ignoring.
> (7) # Executing group from file
> /usr/local/etc2/freeradius/etc/raddb/sites-enabled/default
> (7) Sent Access-Challenge Id 112 from xxx12.225:1812 to xxxxxx:45903
> length 0
> (7) EAP-Message =
> 0x0109002819007b286bccc4f4c141f4ea5ef8a1b16dd15183d01b5b81d5a4c616030300040e000000
> (7) Message-Authenticator = 0x00000000000000000000000000000000
> (7) State = 0x4a7c50d94d75497df1395bb8ee5037b2
> (7) Finished request
> Waking up in 4.8 seconds.
> (8) Received Access-Request Id 251 from xxxxxx:45903 to xxx12.225:1812
> length 348
> (8) User-Name = "oscarrdg at unav.es"
> (8) NAS-IP-Address = xxxxxx
> (8) NAS-Port = 0
> (8) NAS-Identifier = "xxxxxx"
> (8) NAS-Port-Type = Wireless-802.11
> (8) Calling-Station-Id = "344DF73C9C98"
> (8) Called-Station-Id = "001A1E003250"
> (8) Service-Type = Framed-User
> (8) Framed-MTU = 1100
> (8) EAP-Message =
> 0x0209008819800000007e160303004610000042410497d6d49495961db556fda8b469384d890ed741e0f137449e864c9a78bac1d3300980cf8556274e7270cfd6d411d7dee9cd216a49a794311cb559d577fdbeb832140303000101160303002800000000000000001e3ac64ea847ecf6941ba645884a54
> (8) State = 0x4a7c50d94d75497df1395bb8ee5037b2
> (8) Aruba-Essid-Name = "eduroam-pre"
> (8) Aruba-Location-Id = "10.9.1"
> (8) Aruba-AP-Group = "Amigos"
> (8) Aruba-Device-Type = "Android"
> (8) Message-Authenticator = 0x863b805103353c3f87d71a7ead7cb041
> (8) session-state: No cached attributes
> (8) # Executing section authorize from file
> /usr/local/etc2/freeradius/etc/raddb/sites-enabled/default
> (8) authorize {
> (8) policy filter_username {
> (8) if (!&User-Name) {
> (8) if (!&User-Name) -> FALSE
> (8) if (&User-Name =~ / /) {
> (8) if (&User-Name =~ / /) -> FALSE
> (8) if (&User-Name =~ /@.*@/ ) {
> (8) if (&User-Name =~ /@.*@/ ) -> FALSE
> (8) if (&User-Name =~ /\.\./ ) {
> (8) if (&User-Name =~ /\.\./ ) -> FALSE
> (8) if ((&User-Name =~ /@/) && (&User-Name !~ /@(.+)\.(.+)$/)) {
> (8) if ((&User-Name =~ /@/) && (&User-Name !~ /@(.+)\.(.+)$/)) ->
> FALSE
> (8) if (&User-Name =~ /\.$/) {
> (8) if (&User-Name =~ /\.$/) -> FALSE
> (8) if (&User-Name =~ /@\./) {
> (8) if (&User-Name =~ /@\./) -> FALSE
> (8) } # policy filter_username = notfound
> (8) [preprocess] = ok
> (8) auth_log: EXPAND
> /usr/local/etc2/freeradius/var/log/radius/radacct/%{%{Packet-Src-IP-Address}:-%{Packet-Src-IPv6-Address}}/auth-detail-%Y%m%d
> (8) auth_log: -->
> /usr/local/etc2/freeradius/var/log/radius/radacct/xxxxxx/auth-detail-20151119
> (8) auth_log:
> /usr/local/etc2/freeradius/var/log/radius/radacct/%{%{Packet-Src-IP-Address}:-%{Packet-Src-IPv6-Address}}/auth-detail-%Y%m%d
> expands to
> /usr/local/etc2/freeradius/var/log/radius/radacct/xxxxxx/auth-detail-20151119
> (8) auth_log: EXPAND %t
> (8) auth_log: --> Thu Nov 19 16:13:11 2015
> (8) [auth_log] = ok
> (8) [chap] = noop
> (8) [mschap] = noop
> (8) [digest] = noop
> (8) suffix: Checking for suffix after "@"
> (8) suffix: Looking up realm "unav.es" for User-Name = "oscarrdg at unav.es"
> (8) suffix: Found realm "~^(.*\.)?unav\.es$"
> (8) suffix: Adding Stripped-User-Name = "oscarrdg"
> (8) suffix: Adding Realm = "unav.es"
> (8) suffix: Authentication realm is LOCAL
> (8) [suffix] = ok
> (8) ntdomain: Request already has destination realm set. Ignoring
> (8) [ntdomain] = noop
> (8) eap: Peer sent EAP Response (code 2) ID 9 length 136
> (8) eap: Continuing tunnel setup
> (8) [eap] = ok
> (8) } # authorize = ok
> (8) Found Auth-Type = EAP
> (8) # Executing group from file
> /usr/local/etc2/freeradius/etc/raddb/sites-enabled/default
> (8) authenticate {
> (8) eap: Expiring EAP session with state 0x4a7c50d94d75497d
> (8) eap: Finished EAP session with state 0x4a7c50d94d75497d
> (8) eap: Previous EAP request found for state 0x4a7c50d94d75497d, released
> from the list
> (8) eap: Peer sent packet with method EAP PEAP (25)
> (8) eap: Calling submodule eap_peap to process data
> (8) eap_peap: Continuing EAP-TLS
> (8) eap_peap: Peer indicated complete TLS record size will be 126 bytes
> (8) eap_peap: Got complete TLS record (126 bytes)
> (8) eap_peap: [eaptls verify] = length included
> (8) eap_peap: <<< TLS 1.2 [length 0046]
> (8) eap_peap: TLS_accept: SSLv3 read client key exchange A
> (8) eap_peap: <<< TLS 1.2 [length 0001]
> (8) eap_peap: <<< TLS 1.2 [length 0010]
> (8) eap_peap: TLS_accept: SSLv3 read finished A
> (8) eap_peap: >>> TLS 1.2 [length 0001]
> (8) eap_peap: TLS_accept: SSLv3 write change cipher spec A
> (8) eap_peap: >>> TLS 1.2 [length 0010]
> (8) eap_peap: TLS_accept: SSLv3 write finished A
> (8) eap_peap: TLS_accept: SSLv3 flush data
> (8) eap_peap: (other): SSL negotiation finished successfully
> (8) eap_peap: SSL Connection Established
> (8) eap_peap: [eaptls process] = handled
> (8) eap: Sending EAP Request (code 1) ID 10 length 57
> (8) eap: EAP session adding &reply:State = 0x4a7c50d94276497d
> (8) [eap] = handled
> (8) } # authenticate = handled
> (8) Using Post-Auth-Type Challenge
> (8) Post-Auth-Type sub-section not found. Ignoring.
> (8) # Executing group from file
> /usr/local/etc2/freeradius/etc/raddb/sites-enabled/default
> (8) Sent Access-Challenge Id 251 from xxx12.225:1812 to xxxxxx:45903
> length 0
> (8) EAP-Message =
> 0x010a0039190014030300010116030300286a2a84ab3ae80e62498198297caa9815c5334160580029e175eff17a7ecb2046472a0c0a01428bea
> (8) Message-Authenticator = 0x00000000000000000000000000000000
> (8) State = 0x4a7c50d94276497df1395bb8ee5037b2
> (8) Finished request
> Waking up in 4.8 seconds.
> (9) Received Access-Request Id 182 from xxxxxx:45903 to xxx12.225:1812
> length 218
> (9) User-Name = "oscarrdg at unav.es"
> (9) NAS-IP-Address = xxxxxx
> (9) NAS-Port = 0
> (9) NAS-Identifier = "xxxxxx"
> (9) NAS-Port-Type = Wireless-802.11
> (9) Calling-Station-Id = "344DF73C9C98"
> (9) Called-Station-Id = "001A1E003250"
> (9) Service-Type = Framed-User
> (9) Framed-MTU = 1100
> (9) EAP-Message = 0x020a00061900
> (9) State = 0x4a7c50d94276497df1395bb8ee5037b2
> (9) Aruba-Essid-Name = "eduroam-pre"
> (9) Aruba-Location-Id = "10.9.1"
> (9) Aruba-AP-Group = "Amigos"
> (9) Aruba-Device-Type = "Android"
> (9) Message-Authenticator = 0x87e40768b0a6aedf20a4315cfe75d952
> (9) session-state: No cached attributes
> (9) # Executing section authorize from file
> /usr/local/etc2/freeradius/etc/raddb/sites-enabled/default
> (9) authorize {
> (9) policy filter_username {
> (9) if (!&User-Name) {
> (9) if (!&User-Name) -> FALSE
> (9) if (&User-Name =~ / /) {
> (9) if (&User-Name =~ / /) -> FALSE
> (9) if (&User-Name =~ /@.*@/ ) {
> (9) if (&User-Name =~ /@.*@/ ) -> FALSE
> (9) if (&User-Name =~ /\.\./ ) {
> (9) if (&User-Name =~ /\.\./ ) -> FALSE
> (9) if ((&User-Name =~ /@/) && (&User-Name !~ /@(.+)\.(.+)$/)) {
> (9) if ((&User-Name =~ /@/) && (&User-Name !~ /@(.+)\.(.+)$/)) ->
> FALSE
> (9) if (&User-Name =~ /\.$/) {
> (9) if (&User-Name =~ /\.$/) -> FALSE
> (9) if (&User-Name =~ /@\./) {
> (9) if (&User-Name =~ /@\./) -> FALSE
> (9) } # policy filter_username = notfound
> (9) [preprocess] = ok
> (9) auth_log: EXPAND
> /usr/local/etc2/freeradius/var/log/radius/radacct/%{%{Packet-Src-IP-Address}:-%{Packet-Src-IPv6-Address}}/auth-detail-%Y%m%d
> (9) auth_log: -->
> /usr/local/etc2/freeradius/var/log/radius/radacct/xxxxxx/auth-detail-20151119
> (9) auth_log:
> /usr/local/etc2/freeradius/var/log/radius/radacct/%{%{Packet-Src-IP-Address}:-%{Packet-Src-IPv6-Address}}/auth-detail-%Y%m%d
> expands to
> /usr/local/etc2/freeradius/var/log/radius/radacct/xxxxxx/auth-detail-20151119
> (9) auth_log: EXPAND %t
> (9) auth_log: --> Thu Nov 19 16:13:11 2015
> (9) [auth_log] = ok
> (9) [chap] = noop
> (9) [mschap] = noop
> (9) [digest] = noop
> (9) suffix: Checking for suffix after "@"
> (9) suffix: Looking up realm "unav.es" for User-Name = "oscarrdg at unav.es"
> (9) suffix: Found realm "~^(.*\.)?unav\.es$"
> (9) suffix: Adding Stripped-User-Name = "oscarrdg"
> (9) suffix: Adding Realm = "unav.es"
> (9) suffix: Authentication realm is LOCAL
> (9) [suffix] = ok
> (9) ntdomain: Request already has destination realm set. Ignoring
> (9) [ntdomain] = noop
> (9) eap: Peer sent EAP Response (code 2) ID 10 length 6
> (9) eap: Continuing tunnel setup
> (9) [eap] = ok
> (9) } # authorize = ok
> (9) Found Auth-Type = EAP
> (9) # Executing group from file
> /usr/local/etc2/freeradius/etc/raddb/sites-enabled/default
> (9) authenticate {
> (9) eap: Expiring EAP session with state 0x4a7c50d94276497d
> (9) eap: Finished EAP session with state 0x4a7c50d94276497d
> (9) eap: Previous EAP request found for state 0x4a7c50d94276497d, released
> from the list
> (9) eap: Peer sent packet with method EAP PEAP (25)
> (9) eap: Calling submodule eap_peap to process data
> (9) eap_peap: Continuing EAP-TLS
> (9) eap_peap: Peer ACKed our handshake fragment. handshake is finished
> (9) eap_peap: [eaptls verify] = success
> (9) eap_peap: [eaptls process] = success
> (9) eap_peap: Session established. Decoding tunneled attributes
> (9) eap_peap: PEAP state TUNNEL ESTABLISHED
> (9) eap: Sending EAP Request (code 1) ID 11 length 40
> (9) eap: EAP session adding &reply:State = 0x4a7c50d94377497d
> (9) [eap] = handled
> (9) } # authenticate = handled
> (9) Using Post-Auth-Type Challenge
> (9) Post-Auth-Type sub-section not found. Ignoring.
> (9) # Executing group from file
> /usr/local/etc2/freeradius/etc/raddb/sites-enabled/default
> (9) Sent Access-Challenge Id 182 from xxx12.225:1812 to xxxxxx:45903
> length 0
> (9) EAP-Message =
> 0x010b00281900170303001d6a2a84ab3ae80e6307de0ca3236f93adbf36e1a25d41545a9a71de0be3
> (9) Message-Authenticator = 0x00000000000000000000000000000000
> (9) State = 0x4a7c50d94377497df1395bb8ee5037b2
> (9) Finished request
> Waking up in 4.8 seconds.
> (10) Received Access-Request Id 92 from xxxxxx:45903 to xxx12.225:1812
> length 264
> (10) User-Name = "oscarrdg at unav.es"
> (10) NAS-IP-Address = xxxxxx
> (10) NAS-Port = 0
> (10) NAS-Identifier = "xxxxxx"
> (10) NAS-Port-Type = Wireless-802.11
> (10) Calling-Station-Id = "344DF73C9C98"
> (10) Called-Station-Id = "001A1E003250"
> (10) Service-Type = Framed-User
> (10) Framed-MTU = 1100
> (10) EAP-Message =
> 0x020b00341900170303002900000000000000019b4ab8036a75b9c14b9fbef72722cf152e7eae150e66cd2df891b0db7b49041513
> (10) State = 0x4a7c50d94377497df1395bb8ee5037b2
> (10) Aruba-Essid-Name = "eduroam-pre"
> (10) Aruba-Location-Id = "10.9.1"
> (10) Aruba-AP-Group = "Amigos"
> (10) Aruba-Device-Type = "Android"
> (10) Message-Authenticator = 0x3ed798db1779514513dd6cf8a43755bc
> (10) session-state: No cached attributes
> (10) # Executing section authorize from file
> /usr/local/etc2/freeradius/etc/raddb/sites-enabled/default
> (10) authorize {
> (10) policy filter_username {
> (10) if (!&User-Name) {
> (10) if (!&User-Name) -> FALSE
> (10) if (&User-Name =~ / /) {
> (10) if (&User-Name =~ / /) -> FALSE
> (10) if (&User-Name =~ /@.*@/ ) {
> (10) if (&User-Name =~ /@.*@/ ) -> FALSE
> (10) if (&User-Name =~ /\.\./ ) {
> (10) if (&User-Name =~ /\.\./ ) -> FALSE
> (10) if ((&User-Name =~ /@/) && (&User-Name !~ /@(.+)\.(.+)$/)) {
> (10) if ((&User-Name =~ /@/) && (&User-Name !~ /@(.+)\.(.+)$/)) ->
> FALSE
> (10) if (&User-Name =~ /\.$/) {
> (10) if (&User-Name =~ /\.$/) -> FALSE
> (10) if (&User-Name =~ /@\./) {
> (10) if (&User-Name =~ /@\./) -> FALSE
> (10) } # policy filter_username = notfound
> (10) [preprocess] = ok
> (10) auth_log: EXPAND
> /usr/local/etc2/freeradius/var/log/radius/radacct/%{%{Packet-Src-IP-Address}:-%{Packet-Src-IPv6-Address}}/auth-detail-%Y%m%d
> (10) auth_log: -->
> /usr/local/etc2/freeradius/var/log/radius/radacct/xxxxxx/auth-detail-20151119
> (10) auth_log:
> /usr/local/etc2/freeradius/var/log/radius/radacct/%{%{Packet-Src-IP-Address}:-%{Packet-Src-IPv6-Address}}/auth-detail-%Y%m%d
> expands to
> /usr/local/etc2/freeradius/var/log/radius/radacct/xxxxxx/auth-detail-20151119
> (10) auth_log: EXPAND %t
> (10) auth_log: --> Thu Nov 19 16:13:11 2015
> (10) [auth_log] = ok
> (10) [chap] = noop
> (10) [mschap] = noop
> (10) [digest] = noop
> (10) suffix: Checking for suffix after "@"
> (10) suffix: Looking up realm "unav.es" for User-Name = "oscarrdg at unav.es"
> (10) suffix: Found realm "~^(.*\.)?unav\.es$"
> (10) suffix: Adding Stripped-User-Name = "oscarrdg"
> (10) suffix: Adding Realm = "unav.es"
> (10) suffix: Authentication realm is LOCAL
> (10) [suffix] = ok
> (10) ntdomain: Request already has destination realm set. Ignoring
> (10) [ntdomain] = noop
> (10) eap: Peer sent EAP Response (code 2) ID 11 length 52
> (10) eap: Continuing tunnel setup
> (10) [eap] = ok
> (10) } # authorize = ok
> (10) Found Auth-Type = EAP
> (10) # Executing group from file
> /usr/local/etc2/freeradius/etc/raddb/sites-enabled/default
> (10) authenticate {
> (10) eap: Expiring EAP session with state 0x4a7c50d94377497d
> (10) eap: Finished EAP session with state 0x4a7c50d94377497d
> (10) eap: Previous EAP request found for state 0x4a7c50d94377497d,
> released from the list
> (10) eap: Peer sent packet with method EAP PEAP (25)
> (10) eap: Calling submodule eap_peap to process data
> (10) eap_peap: Continuing EAP-TLS
> (10) eap_peap: [eaptls verify] = ok
> (10) eap_peap: Done initial handshake
> (10) eap_peap: [eaptls process] = ok
> (10) eap_peap: Session established. Decoding tunneled attributes
> (10) eap_peap: PEAP state WAITING FOR INNER IDENTITY
> (10) eap_peap: Identity - oscarrdg at unav.es
> (10) eap_peap: Got inner identity 'oscarrdg at unav.es'
> (10) eap_peap: Setting default EAP type for tunneled EAP session
> (10) eap_peap: Got tunneled request
> (10) eap_peap: EAP-Message = 0x020b0015016f7363617272646740756e61762e6573
> (10) eap_peap: Setting User-Name to oscarrdg at unav.es
> (10) eap_peap: Sending tunneled request to inner-tunnel
> (10) eap_peap: EAP-Message = 0x020b0015016f7363617272646740756e61762e6573
> (10) eap_peap: FreeRADIUS-Proxied-To = 127.0.0.1
> (10) eap_peap: User-Name = "oscarrdg at unav.es"
> (10) eap_peap: NAS-IP-Address = xxxxxx
> (10) eap_peap: NAS-Port = 0
> (10) eap_peap: NAS-Identifier = "xxxxxx"
> (10) eap_peap: NAS-Port-Type = Wireless-802.11
> (10) eap_peap: Calling-Station-Id = "344DF73C9C98"
> (10) eap_peap: Called-Station-Id = "001A1E003250"
> (10) eap_peap: Service-Type = Framed-User
> (10) eap_peap: Framed-MTU = 1100
> (10) eap_peap: Aruba-Essid-Name = "eduroam-pre"
> (10) eap_peap: Aruba-Location-Id = "10.9.1"
> (10) eap_peap: Aruba-AP-Group = "Amigos"
> (10) eap_peap: Aruba-Device-Type = "Android"
> (10) eap_peap: Event-Timestamp = "Nov 19 2015 16:13:11 CET"
> (10) Virtual server inner-tunnel received request
> (10) EAP-Message = 0x020b0015016f7363617272646740756e61762e6573
> (10) FreeRADIUS-Proxied-To = 127.0.0.1
> (10) User-Name = "oscarrdg at unav.es"
> (10) NAS-IP-Address = xxxxxx
> (10) NAS-Port = 0
> (10) NAS-Identifier = "xxxxxx"
> (10) NAS-Port-Type = Wireless-802.11
> (10) Calling-Station-Id = "344DF73C9C98"
> (10) Called-Station-Id = "001A1E003250"
> (10) Service-Type = Framed-User
> (10) Framed-MTU = 1100
> (10) Aruba-Essid-Name = "eduroam-pre"
> (10) Aruba-Location-Id = "10.9.1"
> (10) Aruba-AP-Group = "Amigos"
> (10) Aruba-Device-Type = "Android"
> (10) Event-Timestamp = "Nov 19 2015 16:13:11 CET"
> (10) server inner-tunnel {
> (10) # Executing section authorize from file
> /usr/local/etc2/freeradius/etc/raddb/sites-enabled/inner-tunnel
> (10) authorize {
> (10) [chap] = noop
> (10) [mschap] = noop
> (10) suffix: Checking for suffix after "@"
> (10) suffix: Looking up realm "unav.es" for User-Name = "oscarrdg at unav.es"
> (10) suffix: Found realm "~^(.*\.)?unav\.es$"
> (10) suffix: Adding Stripped-User-Name = "oscarrdg"
> (10) suffix: Adding Realm = "unav.es"
> (10) suffix: Authentication realm is LOCAL
> (10) [suffix] = ok
> (10) ntdomain: Request already has destination realm set. Ignoring
> (10) [ntdomain] = noop
> (10) update control {
> (10) &Proxy-To-Realm := LOCAL
> (10) } # update control = noop
> (10) eap: Peer sent EAP Response (code 2) ID 11 length 21
> (10) eap: EAP-Identity reply, returning 'ok' so we can short-circuit the
> rest of authorize
> (10) [eap] = ok
> (10) } # authorize = ok
> (10) Found Auth-Type = EAP
> (10) # Executing group from file
> /usr/local/etc2/freeradius/etc/raddb/sites-enabled/inner-tunnel
> (10) authenticate {
> (10) eap: Peer sent packet with method EAP Identity (1)
> (10) eap: Calling submodule eap_mschapv2 to process data
> (10) eap_mschapv2: Issuing Challenge
> (10) eap: Sending EAP Request (code 1) ID 12 length 43
> (10) eap: EAP session adding &reply:State = 0x739669f1739a7348
> (10) [eap] = handled
> (10) } # authenticate = handled
> (10) } # server inner-tunnel
> (10) Virtual server sending reply
> (10) EAP-Message =
> 0x010c002b1a010c0026109be6bd2966f7837a669e8c6ec412fec8667265657261646975732d332e302e3130
> (10) Message-Authenticator = 0x00000000000000000000000000000000
> (10) State = 0x739669f1739a7348a02455fb687f2caa
> (10) eap_peap: Got tunneled reply code 11
> (10) eap_peap: EAP-Message =
> 0x010c002b1a010c0026109be6bd2966f7837a669e8c6ec412fec8667265657261646975732d332e302e3130
> (10) eap_peap: Message-Authenticator = 0x00000000000000000000000000000000
> (10) eap_peap: State = 0x739669f1739a7348a02455fb687f2caa
> (10) eap_peap: Got tunneled reply RADIUS code 11
> (10) eap_peap: EAP-Message =
> 0x010c002b1a010c0026109be6bd2966f7837a669e8c6ec412fec8667265657261646975732d332e302e3130
> (10) eap_peap: Message-Authenticator = 0x00000000000000000000000000000000
> (10) eap_peap: State = 0x739669f1739a7348a02455fb687f2caa
> (10) eap_peap: Got tunneled Access-Challenge
> (10) eap: Sending EAP Request (code 1) ID 12 length 74
> (10) eap: EAP session adding &reply:State = 0x4a7c50d94070497d
> (10) [eap] = handled
> (10) } # authenticate = handled
> (10) Using Post-Auth-Type Challenge
> (10) Post-Auth-Type sub-section not found. Ignoring.
> (10) # Executing group from file
> /usr/local/etc2/freeradius/etc/raddb/sites-enabled/default
> (10) Sent Access-Challenge Id 92 from xxx12.225:1812 to xxxxxx:45903
> length 0
> (10) EAP-Message =
> 0x010c004a1900170303003f6a2a84ab3ae80e6445376747acac3a67092800521bd121ed59a9f1d8a3e4558a30aea29eae313c5e6b4befec0d80e2fbdd0f7c8ce5d3d791f671f36e56facd
> (10) Message-Authenticator = 0x00000000000000000000000000000000
> (10) State = 0x4a7c50d94070497df1395bb8ee5037b2
> (10) Finished request
> Waking up in 4.8 seconds.
> (11) Received Access-Request Id 240 from xxxxxx:45903 to xxx12.225:1812
> length 318
> (11) User-Name = "oscarrdg at unav.es"
> (11) NAS-IP-Address = xxxxxx
> (11) NAS-Port = 0
> (11) NAS-Identifier = "xxxxxx"
> (11) NAS-Port-Type = Wireless-802.11
> (11) Calling-Station-Id = "344DF73C9C98"
> (11) Called-Station-Id = "001A1E003250"
> (11) Service-Type = Framed-User
> (11) Framed-MTU = 1100
> (11) EAP-Message =
> 0x020c006a1900170303005f000000000000000253f426d0e803b2f101d786b3751058056be43652b9dfc3ef648ed4fa31005509bd18cfeea0fae8d7c1e20a69507c7355e0f78b6d034f70f812ce1d73e78815d519b082725844b86344c1ae97ccd9d6232d64a6c67831e3
> (11) State = 0x4a7c50d94070497df1395bb8ee5037b2
> (11) Aruba-Essid-Name = "eduroam-pre"
> (11) Aruba-Location-Id = "10.9.1"
> (11) Aruba-AP-Group = "Amigos"
> (11) Aruba-Device-Type = "Android"
> (11) Message-Authenticator = 0xfc041f435db6453937530e6ad7ad9998
> (11) session-state: No cached attributes
> (11) # Executing section authorize from file
> /usr/local/etc2/freeradius/etc/raddb/sites-enabled/default
> (11) authorize {
> (11) policy filter_username {
> (11) if (!&User-Name) {
> (11) if (!&User-Name) -> FALSE
> (11) if (&User-Name =~ / /) {
> (11) if (&User-Name =~ / /) -> FALSE
> (11) if (&User-Name =~ /@.*@/ ) {
> (11) if (&User-Name =~ /@.*@/ ) -> FALSE
> (11) if (&User-Name =~ /\.\./ ) {
> (11) if (&User-Name =~ /\.\./ ) -> FALSE
> (11) if ((&User-Name =~ /@/) && (&User-Name !~ /@(.+)\.(.+)$/)) {
> (11) if ((&User-Name =~ /@/) && (&User-Name !~ /@(.+)\.(.+)$/)) ->
> FALSE
> (11) if (&User-Name =~ /\.$/) {
> (11) if (&User-Name =~ /\.$/) -> FALSE
> (11) if (&User-Name =~ /@\./) {
> (11) if (&User-Name =~ /@\./) -> FALSE
> (11) } # policy filter_username = notfound
> (11) [preprocess] = ok
> (11) auth_log: EXPAND
> /usr/local/etc2/freeradius/var/log/radius/radacct/%{%{Packet-Src-IP-Address}:-%{Packet-Src-IPv6-Address}}/auth-detail-%Y%m%d
> (11) auth_log: -->
> /usr/local/etc2/freeradius/var/log/radius/radacct/xxxxxx/auth-detail-20151119
> (11) auth_log:
> /usr/local/etc2/freeradius/var/log/radius/radacct/%{%{Packet-Src-IP-Address}:-%{Packet-Src-IPv6-Address}}/auth-detail-%Y%m%d
> expands to
> /usr/local/etc2/freeradius/var/log/radius/radacct/xxxxxx/auth-detail-20151119
> (11) auth_log: EXPAND %t
> (11) auth_log: --> Thu Nov 19 16:13:11 2015
> (11) [auth_log] = ok
> (11) [chap] = noop
> (11) [mschap] = noop
> (11) [digest] = noop
> (11) suffix: Checking for suffix after "@"
> (11) suffix: Looking up realm "unav.es" for User-Name = "oscarrdg at unav.es"
> (11) suffix: Found realm "~^(.*\.)?unav\.es$"
> (11) suffix: Adding Stripped-User-Name = "oscarrdg"
> (11) suffix: Adding Realm = "unav.es"
> (11) suffix: Authentication realm is LOCAL
> (11) [suffix] = ok
> (11) ntdomain: Request already has destination realm set. Ignoring
> (11) [ntdomain] = noop
> (11) eap: Peer sent EAP Response (code 2) ID 12 length 106
> (11) eap: Continuing tunnel setup
> (11) [eap] = ok
> (11) } # authorize = ok
> (11) Found Auth-Type = EAP
> (11) # Executing group from file
> /usr/local/etc2/freeradius/etc/raddb/sites-enabled/default
> (11) authenticate {
> (11) eap: Expiring EAP session with state 0x739669f1739a7348
> (11) eap: Finished EAP session with state 0x4a7c50d94070497d
> (11) eap: Previous EAP request found for state 0x4a7c50d94070497d,
> released from the list
> (11) eap: Peer sent packet with method EAP PEAP (25)
> (11) eap: Calling submodule eap_peap to process data
> (11) eap_peap: Continuing EAP-TLS
> (11) eap_peap: [eaptls verify] = ok
> (11) eap_peap: Done initial handshake
> (11) eap_peap: [eaptls process] = ok
> (11) eap_peap: Session established. Decoding tunneled attributes
> (11) eap_peap: PEAP state phase2
> (11) eap_peap: EAP method MSCHAPv2 (26)
> (11) eap_peap: Got tunneled request
> (11) eap_peap: EAP-Message =
> 0x020c004b1a020c00463116ba4ea3b0d512edfb61cc1111d4f2310000000000000000d4ced6b15b809861069531ec2cb89e3001db98c94f9018e8006f7363617272646740756e61762e6573
> (11) eap_peap: Setting User-Name to oscarrdg at unav.es
> (11) eap_peap: Sending tunneled request to inner-tunnel
> (11) eap_peap: EAP-Message =
> 0x020c004b1a020c00463116ba4ea3b0d512edfb61cc1111d4f2310000000000000000d4ced6b15b809861069531ec2cb89e3001db98c94f9018e8006f7363617272646740756e61762e6573
> (11) eap_peap: FreeRADIUS-Proxied-To = 127.0.0.1
> (11) eap_peap: User-Name = "oscarrdg at unav.es"
> (11) eap_peap: State = 0x739669f1739a7348a02455fb687f2caa
> (11) eap_peap: NAS-IP-Address = xxxxxx
> (11) eap_peap: NAS-Port = 0
> (11) eap_peap: NAS-Identifier = "xxxxxx"
> (11) eap_peap: NAS-Port-Type = Wireless-802.11
> (11) eap_peap: Calling-Station-Id = "344DF73C9C98"
> (11) eap_peap: Called-Station-Id = "001A1E003250"
> (11) eap_peap: Service-Type = Framed-User
> (11) eap_peap: Framed-MTU = 1100
> (11) eap_peap: Aruba-Essid-Name = "eduroam-pre"
> (11) eap_peap: Aruba-Location-Id = "10.9.1"
> (11) eap_peap: Aruba-AP-Group = "Amigos"
> (11) eap_peap: Aruba-Device-Type = "Android"
> (11) eap_peap: Event-Timestamp = "Nov 19 2015 16:13:11 CET"
> (11) Virtual server inner-tunnel received request
> (11) EAP-Message =
> 0x020c004b1a020c00463116ba4ea3b0d512edfb61cc1111d4f2310000000000000000d4ced6b15b809861069531ec2cb89e3001db98c94f9018e8006f7363617272646740756e61762e6573
> (11) FreeRADIUS-Proxied-To = 127.0.0.1
> (11) User-Name = "oscarrdg at unav.es"
> (11) State = 0x739669f1739a7348a02455fb687f2caa
> (11) NAS-IP-Address = xxxxxx
> (11) NAS-Port = 0
> (11) NAS-Identifier = "xxxxxx"
> (11) NAS-Port-Type = Wireless-802.11
> (11) Calling-Station-Id = "344DF73C9C98"
> (11) Called-Station-Id = "001A1E003250"
> (11) Service-Type = Framed-User
> (11) Framed-MTU = 1100
> (11) Aruba-Essid-Name = "eduroam-pre"
> (11) Aruba-Location-Id = "10.9.1"
> (11) Aruba-AP-Group = "Amigos"
> (11) Aruba-Device-Type = "Android"
> (11) Event-Timestamp = "Nov 19 2015 16:13:11 CET"
> (11) server inner-tunnel {
> (11) session-state: No cached attributes
> (11) # Executing section authorize from file
> /usr/local/etc2/freeradius/etc/raddb/sites-enabled/inner-tunnel
> (11) authorize {
> (11) [chap] = noop
> (11) [mschap] = noop
> (11) suffix: Checking for suffix after "@"
> (11) suffix: Looking up realm "unav.es" for User-Name = "oscarrdg at unav.es"
> (11) suffix: Found realm "~^(.*\.)?unav\.es$"
> (11) suffix: Adding Stripped-User-Name = "oscarrdg"
> (11) suffix: Adding Realm = "unav.es"
> (11) suffix: Authentication realm is LOCAL
> (11) [suffix] = ok
> (11) ntdomain: Request already has destination realm set. Ignoring
> (11) [ntdomain] = noop
> (11) update control {
> (11) &Proxy-To-Realm := LOCAL
> (11) } # update control = noop
> (11) eap: Peer sent EAP Response (code 2) ID 12 length 75
> (11) eap: No EAP Start, assuming it's an on-going EAP conversation
> (11) [eap] = updated
> (11) policy unav.authorize.inner {
> (11) if ( "%{client:group}" == 'wireless' ) {
> (11) EXPAND %{client:group}
> (11) --> wireless
> (11) if ( "%{client:group}" == 'wireless' ) -> TRUE
> (11) if ( "%{client:group}" == 'wireless' ) {
> (11) policy unav.reject.otherdomain {
> (11) if ( Realm == "NULL" || Realm =~ /^(.*\.)?unav\.es$/ ||
> Realm == "UNAV-PDC-01" ) {
> (11) if ( Realm == "NULL" || Realm =~ /^(.*\.)?unav\.es$/ ||
> Realm == "UNAV-PDC-01" ) -> TRUE
> (11) ( Realm == "NULL" || Realm =~ /^(.*\.)?unav\.es$/ ||
> Realm == "UNAV-PDC-01" ) { ... } # empty sub-section is ignored
> (11) ... skipping else for request 11: Preceding "if" was taken
> (11) } # policy unav.reject.otherdomain = updated
> (11) policy unav.reject.bloqueado {
> (11) if ( Ldap-Group == "unav.radius.bloqueado" ) {
> (11) Searching for user in group "unav.radius.bloqueado"
> rlm_ldap (ldap): Reserved connection (0)
> (11) EXPAND (uid=%{%{Stripped-User-Name}:-%{User-Name}})
> (11) --> (uid=oscarrdg)
> (11) Performing search in "ou=radius,o=accounts,dc=unav,dc=es"
> with filter "(uid=oscarrdg)", scope "sub"
> (11) Waiting for search result...
> (11) User object found at DN
> "uid=oscarrdg,ou=radius,o=accounts,dc=unav,dc=es"
> (11) Checking user object's member attributes
> (11) Performing unfiltered search in
> "uid=oscarrdg,ou=radius,o=accounts,dc=unav,dc=es", scope "base"
> (11) Waiting for search result...
> (11) Processing member value
> "uid=unav.radius.vpn.ssl,ou=groups,ou=radius,o=accounts,dc=unav,dc=es" as a
> DN
> (11) Resolving group DN
> "uid=unav.radius.vpn.ssl,ou=groups,ou=radius,o=accounts,dc=unav,dc=es" to
> group name
> (11) Performing unfiltered search in
> "uid=unav.radius.vpn.ssl,ou=groups,ou=radius,o=accounts,dc=unav,dc=es",
> scope "base"
> (11) Waiting for search result...
> (11) Group DN
> "uid=unav.radius.vpn.ssl,ou=groups,ou=radius,o=accounts,dc=unav,dc=es"
> resolves to name "unav.radius.vpn.ssl"
> (11) Processing member value
> "uid=unav.radius.eapol.n1,ou=groups,ou=radius,o=accounts,dc=unav,dc=es" as
> a DN
> (11) Resolving group DN
> "uid=unav.radius.eapol.n1,ou=groups,ou=radius,o=accounts,dc=unav,dc=es" to
> group name
> (11) Performing unfiltered search in
> "uid=unav.radius.eapol.n1,ou=groups,ou=radius,o=accounts,dc=unav,dc=es",
> scope "base"
> (11) Waiting for search result...
> (11) Group DN
> "uid=unav.radius.eapol.n1,ou=groups,ou=radius,o=accounts,dc=unav,dc=es"
> resolves to name "unav.radius.eapol.n1"
> (11) Processing member value
> "uid=unav.radius.wifi.n1,ou=groups,ou=radius,o=accounts,dc=unav,dc=es" as a
> DN
> (11) Resolving group DN
> "uid=unav.radius.wifi.n1,ou=groups,ou=radius,o=accounts,dc=unav,dc=es" to
> group name
> (11) Performing unfiltered search in
> "uid=unav.radius.wifi.n1,ou=groups,ou=radius,o=accounts,dc=unav,dc=es",
> scope "base"
> (11) Waiting for search result...
> (11) Group DN
> "uid=unav.radius.wifi.n1,ou=groups,ou=radius,o=accounts,dc=unav,dc=es"
> resolves to name "unav.radius.wifi.n1"
> (11) Processing member value "uid=unav.radius.vpn.ssl.si,ou=groups,ou=radius,o=accounts,dc=unav,dc=es"
> as a DN
> (11) Resolving group DN "uid=unav.radius.vpn.ssl.si,ou=groups,ou=radius,o=accounts,dc=unav,dc=es"
> to group name
> (11) Performing unfiltered search in "uid=
> unav.radius.vpn.ssl.si,ou=groups,ou=radius,o=accounts,dc=unav,dc=es",
> scope "base"
> (11) Waiting for search result...
> (11) Group DN "uid=unav.radius.vpn.ssl.si,ou=groups,ou=radius,o=accounts,dc=unav,dc=es"
> resolves to name "unav.radius.vpn.ssl.si"
> (11) Processing member value
> "uid=unav.radius.vpn.ipsec,ou=groups,ou=radius,o=accounts,dc=unav,dc=es" as
> a DN
> (11) Resolving group DN
> "uid=unav.radius.vpn.ipsec,ou=groups,ou=radius,o=accounts,dc=unav,dc=es" to
> group name
> (11) Performing unfiltered search in
> "uid=unav.radius.vpn.ipsec,ou=groups,ou=radius,o=accounts,dc=unav,dc=es",
> scope "base"
> (11) Waiting for search result...
> (11) Group DN
> "uid=unav.radius.vpn.ipsec,ou=groups,ou=radius,o=accounts,dc=unav,dc=es"
> resolves to name "unav.radius.vpn.ipsec"
> rlm_ldap (ldap): Released connection (0)
> rlm_ldap (ldap): Need 5 more connections to reach 10 spares
> rlm_ldap (ldap): Opening additional connection (5), 1 of 27 pending slots
> used
> rlm_ldap (ldap): Connecting to ldap://ldap.unav.es:389
> TLS: certificate [CN=AddTrust External CA Root,OU=AddTrust External TTP
> Network,O=AddTrust AB,C=SE] is not valid - error -8172:Peer's certificate
> issuer has been marked as not trusted by the user..
> rlm_ldap (ldap): Waiting for bind result...
> rlm_ldap (ldap): Bind successful
> (11) User is not a member of "unav.radius.bloqueado"
> (11) if ( Ldap-Group == "unav.radius.bloqueado" ) -> FALSE
> (11) } # policy unav.reject.bloqueado = updated
> rlm_ldap (ldap): Reserved connection (1)
> (11) ldap: EXPAND (uid=%{%{Stripped-User-Name}:-%{User-Name}})
> (11) ldap: --> (uid=oscarrdg)
> (11) ldap: Performing search in "ou=radius,o=accounts,dc=unav,dc=es" with
> filter "(uid=oscarrdg)", scope "sub"
> (11) ldap: Waiting for search result...
> (11) ldap: User object found at DN
> "uid=oscarrdg,ou=radius,o=accounts,dc=unav,dc=es"
> (11) ldap: Processing user attributes
> (11) ldap: control:Password-With-Header +=
> '{sha}0sURRyN1nxp/BMx+Q5nBqwR7CB0='
> rlm_ldap (ldap): Released connection (1)
> (11) [ldap] = updated
> (11) update reply {
> (11) EXPAND %{request:User-Name}
> (11) --> oscarrdg at unav.es
> (11) &User-Name = oscarrdg at unav.es
> (11) } # update reply = noop
> (11) if ( Ldap-Group == "unav.radius.wifi.all" ) {
> (11) Searching for user in group "unav.radius.wifi.all"
> rlm_ldap (ldap): Reserved connection (2)
> (11) Using user DN from request
> "uid=oscarrdg,ou=radius,o=accounts,dc=unav,dc=es"
> (11) Checking user object's member attributes
> (11) Performing unfiltered search in
> "uid=oscarrdg,ou=radius,o=accounts,dc=unav,dc=es", scope "base"
> (11) Waiting for search result...
> (11) Processing member value
> "uid=unav.radius.vpn.ssl,ou=groups,ou=radius,o=accounts,dc=unav,dc=es" as a
> DN
> (11) Resolving group DN
> "uid=unav.radius.vpn.ssl,ou=groups,ou=radius,o=accounts,dc=unav,dc=es" to
> group name
> (11) Performing unfiltered search in
> "uid=unav.radius.vpn.ssl,ou=groups,ou=radius,o=accounts,dc=unav,dc=es",
> scope "base"
> (11) Waiting for search result...
> (11) Group DN
> "uid=unav.radius.vpn.ssl,ou=groups,ou=radius,o=accounts,dc=unav,dc=es"
> resolves to name "unav.radius.vpn.ssl"
> (11) Processing member value
> "uid=unav.radius.eapol.n1,ou=groups,ou=radius,o=accounts,dc=unav,dc=es" as
> a DN
> (11) Resolving group DN
> "uid=unav.radius.eapol.n1,ou=groups,ou=radius,o=accounts,dc=unav,dc=es" to
> group name
> (11) Performing unfiltered search in
> "uid=unav.radius.eapol.n1,ou=groups,ou=radius,o=accounts,dc=unav,dc=es",
> scope "base"
> (11) Waiting for search result...
> (11) Group DN
> "uid=unav.radius.eapol.n1,ou=groups,ou=radius,o=accounts,dc=unav,dc=es"
> resolves to name "unav.radius.eapol.n1"
> (11) Processing member value
> "uid=unav.radius.wifi.n1,ou=groups,ou=radius,o=accounts,dc=unav,dc=es" as a
> DN
> (11) Resolving group DN
> "uid=unav.radius.wifi.n1,ou=groups,ou=radius,o=accounts,dc=unav,dc=es" to
> group name
> (11) Performing unfiltered search in
> "uid=unav.radius.wifi.n1,ou=groups,ou=radius,o=accounts,dc=unav,dc=es",
> scope "base"
> (11) Waiting for search result...
> (11) Group DN
> "uid=unav.radius.wifi.n1,ou=groups,ou=radius,o=accounts,dc=unav,dc=es"
> resolves to name "unav.radius.wifi.n1"
> (11) Processing member value "uid=unav.radius.vpn.ssl.si,ou=groups,ou=radius,o=accounts,dc=unav,dc=es"
> as a DN
> (11) Resolving group DN "uid=unav.radius.vpn.ssl.si,ou=groups,ou=radius,o=accounts,dc=unav,dc=es"
> to group name
> (11) Performing unfiltered search in "uid=
> unav.radius.vpn.ssl.si,ou=groups,ou=radius,o=accounts,dc=unav,dc=es",
> scope "base"
> (11) Waiting for search result...
> (11) Group DN "uid=unav.radius.vpn.ssl.si,ou=groups,ou=radius,o=accounts,dc=unav,dc=es"
> resolves to name "unav.radius.vpn.ssl.si"
> (11) Processing member value
> "uid=unav.radius.vpn.ipsec,ou=groups,ou=radius,o=accounts,dc=unav,dc=es" as
> a DN
> (11) Resolving group DN
> "uid=unav.radius.vpn.ipsec,ou=groups,ou=radius,o=accounts,dc=unav,dc=es" to
> group name
> (11) Performing unfiltered search in
> "uid=unav.radius.vpn.ipsec,ou=groups,ou=radius,o=accounts,dc=unav,dc=es",
> scope "base"
> (11) Waiting for search result...
> (11) Group DN
> "uid=unav.radius.vpn.ipsec,ou=groups,ou=radius,o=accounts,dc=unav,dc=es"
> resolves to name "unav.radius.vpn.ipsec"
> rlm_ldap (ldap): Released connection (2)
> (11) User is not a member of "unav.radius.wifi.all"
> (11) if ( Ldap-Group == "unav.radius.wifi.all" ) -> FALSE
> (11) elsif ( Ldap-Group == "unav.radius.wifi.n1" ) {
> (11) Searching for user in group "unav.radius.wifi.n1"
> rlm_ldap (ldap): Reserved connection (3)
> (11) Using user DN from request
> "uid=oscarrdg,ou=radius,o=accounts,dc=unav,dc=es"
> (11) Checking user object's member attributes
> (11) Performing unfiltered search in
> "uid=oscarrdg,ou=radius,o=accounts,dc=unav,dc=es", scope "base"
> (11) Waiting for search result...
> (11) Processing member value
> "uid=unav.radius.vpn.ssl,ou=groups,ou=radius,o=accounts,dc=unav,dc=es" as a
> DN
> (11) Resolving group DN
> "uid=unav.radius.vpn.ssl,ou=groups,ou=radius,o=accounts,dc=unav,dc=es" to
> group name
> (11) Performing unfiltered search in
> "uid=unav.radius.vpn.ssl,ou=groups,ou=radius,o=accounts,dc=unav,dc=es",
> scope "base"
> (11) Waiting for search result...
> (11) Group DN
> "uid=unav.radius.vpn.ssl,ou=groups,ou=radius,o=accounts,dc=unav,dc=es"
> resolves to name "unav.radius.vpn.ssl"
> (11) Processing member value
> "uid=unav.radius.eapol.n1,ou=groups,ou=radius,o=accounts,dc=unav,dc=es" as
> a DN
> (11) Resolving group DN
> "uid=unav.radius.eapol.n1,ou=groups,ou=radius,o=accounts,dc=unav,dc=es" to
> group name
> (11) Performing unfiltered search in
> "uid=unav.radius.eapol.n1,ou=groups,ou=radius,o=accounts,dc=unav,dc=es",
> scope "base"
> (11) Waiting for search result...
> (11) Group DN
> "uid=unav.radius.eapol.n1,ou=groups,ou=radius,o=accounts,dc=unav,dc=es"
> resolves to name "unav.radius.eapol.n1"
> (11) Processing member value
> "uid=unav.radius.wifi.n1,ou=groups,ou=radius,o=accounts,dc=unav,dc=es" as a
> DN
> (11) Resolving group DN
> "uid=unav.radius.wifi.n1,ou=groups,ou=radius,o=accounts,dc=unav,dc=es" to
> group name
> (11) Performing unfiltered search in
> "uid=unav.radius.wifi.n1,ou=groups,ou=radius,o=accounts,dc=unav,dc=es",
> scope "base"
> (11) Waiting for search result...
> (11) Group DN
> "uid=unav.radius.wifi.n1,ou=groups,ou=radius,o=accounts,dc=unav,dc=es"
> resolves to name "unav.radius.wifi.n1"
> (11) User found in group "unav.radius.wifi.n1". Comparison
> between membership: name (resolved from DN
> "uid=unav.radius.wifi.n1,ou=groups,ou=radius,o=accounts,dc=unav,d?"),
> check: name
> rlm_ldap (ldap): Released connection (3)
> (11) elsif ( Ldap-Group == "unav.radius.wifi.n1" ) -> TRUE
> (11) elsif ( Ldap-Group == "unav.radius.wifi.n1" ) {
> (11) update reply {
> (11) &Reply-Message += 'role.n1'
> (11) &Aruba-User-Role := 'role.n1'
> (11) } # update reply = noop
> (11) } # elsif ( Ldap-Group == "unav.radius.wifi.n1" ) = noop
> (11) ... skipping elsif for request 11: Preceding "if" was taken
> (11) ... skipping elsif for request 11: Preceding "if" was taken
> (11) ... skipping elsif for request 11: Preceding "if" was taken
> (11) ... skipping elsif for request 11: Preceding "if" was taken
> (11) ... skipping elsif for request 11: Preceding "if" was taken
> (11) ... skipping elsif for request 11: Preceding "if" was taken
> (11) ... skipping elsif for request 11: Preceding "if" was taken
> (11) ... skipping else for request 11: Preceding "if" was taken
> (11) } # if ( "%{client:group}" == 'wireless' ) = updated
> (11) ... skipping elsif for request 11: Preceding "if" was taken
> (11) ... skipping elsif for request 11: Preceding "if" was taken
> (11) ... skipping else for request 11: Preceding "if" was taken
> (11) } # policy unav.authorize.inner = updated
> (11) [expiration] = noop
> (11) [logintime] = noop
> (11) pap: Converted: Password-With-Header -> SHA1-Password
> (11) pap: Removing &control:Password-With-Header
> (11) pap: Normalizing SHA1-Password from base64 encoding, 28 bytes -> 20
> bytes
> (11) pap: WARNING: Auth-Type already set. Not setting to PAP
> (11) [pap] = noop
> (11) if (control:Cleartext-Password) {
> (11) if (control:Cleartext-Password) -> FALSE
> (11) } # authorize = updated
> (11) Found Auth-Type = EAP
> (11) # Executing group from file
> /usr/local/etc2/freeradius/etc/raddb/sites-enabled/inner-tunnel
> (11) authenticate {
> (11) eap: Expiring EAP session with state 0x739669f1739a7348
> (11) eap: Finished EAP session with state 0x739669f1739a7348
> (11) eap: Previous EAP request found for state 0x739669f1739a7348,
> released from the list
> (11) eap: Peer sent packet with method EAP MSCHAPv2 (26)
> (11) eap: Calling submodule eap_mschapv2 to process data
> (11) eap_mschapv2: # Executing group from file
> /usr/local/etc2/freeradius/etc/raddb/sites-enabled/inner-tunnel
> (11) eap_mschapv2: Auth-Type MS-CHAP {
> (11) mschap: Creating challenge hash with username: oscarrdg at unav.es
> (11) mschap: Client is using MS-CHAPv2
> (11) mschap: Executing: /usr/bin/ntlm_auth --request-nt-key
> --username=%{%{Stripped-User-Name}:-%{%{User-Name}:-None}}
> --challenge=%{%{mschap:Challenge}:-00}
> --nt-response=%{%{mschap:NT-Response}:-00}:
> (11) mschap: EXPAND
> --username=%{%{Stripped-User-Name}:-%{%{User-Name}:-None}}
> (11) mschap: --> --username=oscarrdg
> (11) mschap: Creating challenge hash with username: oscarrdg at unav.es
> (11) mschap: EXPAND --challenge=%{%{mschap:Challenge}:-00}
> (11) mschap: --> --challenge=c159f634076ecce6
> (11) mschap: EXPAND --nt-response=%{%{mschap:NT-Response}:-00}
> (11) mschap: -->
> --nt-response=d4ced6b15b809861069531ec2cb89e3001db98c94f9018e8
> (11) mschap: Program returned code (0) and output 'NT_KEY:
> 751E91FBC94E37990A2A5B973C29E4D3'
> (11) mschap: Adding MS-CHAPv2 MPPE keys
> (11) [mschap] = ok
> (11) } # Auth-Type MS-CHAP = ok
> (11) MSCHAP Success
> (11) eap: Sending EAP Request (code 1) ID 13 length 51
> (11) eap: EAP session adding &reply:State = 0x739669f1729b7348
> (11) [eap] = handled
> (11) } # authenticate = handled
> (11) } # server inner-tunnel
> (11) Virtual server sending reply
> (11) User-Name = "oscarrdg at unav.es"
> (11) Reply-Message += "role.n1"
> (11) Aruba-User-Role := "role.n1"
> (11) EAP-Message =
> 0x010d00331a030c002e533d38443639364430423633413735314239363137343538304636313145354531323335434636443942
> (11) Message-Authenticator = 0x00000000000000000000000000000000
> (11) State = 0x739669f1729b7348a02455fb687f2caa
> (11) eap_peap: Got tunneled reply code 11
> (11) eap_peap: User-Name = "oscarrdg at unav.es"
> (11) eap_peap: Reply-Message += "role.n1"
> (11) eap_peap: Aruba-User-Role := "role.n1"
> (11) eap_peap: EAP-Message =
> 0x010d00331a030c002e533d38443639364430423633413735314239363137343538304636313145354531323335434636443942
> (11) eap_peap: Message-Authenticator = 0x00000000000000000000000000000000
> (11) eap_peap: State = 0x739669f1729b7348a02455fb687f2caa
> (11) eap_peap: Got tunneled reply RADIUS code 11
> (11) eap_peap: User-Name = "oscarrdg at unav.es"
> (11) eap_peap: Reply-Message += "role.n1"
> (11) eap_peap: Aruba-User-Role := "role.n1"
> (11) eap_peap: EAP-Message =
> 0x010d00331a030c002e533d38443639364430423633413735314239363137343538304636313145354531323335434636443942
> (11) eap_peap: Message-Authenticator = 0x00000000000000000000000000000000
> (11) eap_peap: State = 0x739669f1729b7348a02455fb687f2caa
> (11) eap_peap: Got tunneled Access-Challenge
> (11) eap: Sending EAP Request (code 1) ID 13 length 82
> (11) eap: EAP session adding &reply:State = 0x4a7c50d94171497d
> (11) [eap] = handled
> (11) } # authenticate = handled
> (11) Using Post-Auth-Type Challenge
> (11) Post-Auth-Type sub-section not found. Ignoring.
> (11) # Executing group from file
> /usr/local/etc2/freeradius/etc/raddb/sites-enabled/default
> (11) Sent Access-Challenge Id 240 from xxx:1812 to xxxxxx:45903 length 0
> (11) EAP-Message =
> 0x010d0052190017030300476a2a84ab3ae80e65df331667562db833be49b2c3281f498c160a1da57850e4c4db22bfebfcec126265d589bbfe90d31b5ded9e845dd71e0e30a7911af58f1d022b04703a397886
> (11) Message-Authenticator = 0x00000000000000000000000000000000
> (11) State = 0x4a7c50d94171497df1395bb8ee5037b2
> (11) Finished request
> Waking up in 4.7 seconds.
>
>
>
> *Oscar Remírez de Ganuza Satrústegui*
> IT Services
> Universidad de Navarra
> Tel. +34 948425600 x803130
> http://www.unav.edu/web/it/
>
More information about the Freeradius-Users
mailing list