can't get simultaneous login to work Part 2

J Brandon Polley POLLEYJB at nsac.ca
Fri Feb 19 21:04:35 CET 2010


Here is my login output:
 
rad_recv: Accounting-Request packet from host 172.16.33.2 port 32768, id=142, length=216
        User-Name = "STUDENTBRANDON"
        NAS-Port = 29
        NAS-IP-Address = 172.16.33.2
        Framed-IP-Address = 172.16.19.110
        NAS-Identifier = "wlc-nsac-exteng-4404-6"
        Airespace-Wlan-Id = 6
        Acct-Session-Id = "4b7c3963/00:1b:77:94:eb:74/6105"
        Acct-Authentic = RADIUS
        Tunnel-Type:0 = VLAN
        Tunnel-Medium-Type:0 = IEEE-802
        Tunnel-Private-Group-Id:0 = "240"
        Acct-Status-Type = Interim-Update
        Acct-Input-Octets = 13681
        Acct-Output-Octets = 5808
        Acct-Input-Packets = 114
        Acct-Output-Packets = 22
        Acct-Session-Time = 314
        Acct-Delay-Time = 0
        Calling-Station-Id = "172.16.19.110"
        Called-Station-Id = "172.16.33.2"
+- entering group preacct {...}
++[preprocess] returns ok
[acct_unique] Hashing 'NAS-Port = 29,Client-IP-Address = 172.16.33.2,NAS-IP-Address = 172.16.33.2,Acct-Session-Id = 
 
"4b7c3963/00:1b:77:94:eb:74/6105",User-Name = "STUDENTBRANDON"'
[acct_unique] Acct-Unique-Session-ID = "51ddcb827685cf72".
++[acct_unique] returns ok
[suffix] No '@' in User-Name = "STUDENTBRANDON", looking up realm NULL
[suffix] No such realm "NULL"
++[suffix] returns noop
++[files] returns noop
+- entering group accounting {...}
[detail]        expand: /var/log/radius/radacct/%{Client-IP-Address}/detail-%Y%m%d -> /var/log/radius/radacct/172.16.33.2/detail-20100217
[detail] /var/log/radius/radacct/%{Client-IP-Address}/detail-%Y%m%d expands to /var/log/radius/radacct/172.16.33.2/detail-20100217
[detail]        expand: %t -> Wed Feb 17 17:25:13 2010
++[detail] returns ok
[radutmp]       expand: /var/log/radius/radutmp -> /var/log/radius/radutmp
[radutmp]       expand: %{User-Name} -> STUDENTBRANDON
++[radutmp] returns ok
[attr_filter.accounting_response]       expand: %{User-Name} -> STUDENTBRANDON
 attr_filter: Matched entry DEFAULT at line 12
++[attr_filter.accounting_response] returns updated
Sending Accounting-Response of id 142 to 172.16.33.2 port 32768
Finished request 10.
Cleaning up request 10 ID 142 with timestamp +1121b
 
Going to the next request
Ready to process requests.
 
 
 
Here is the second simultaneous login output:
2nd login info
 
rad_recv: Access-Request packet from host 172.16.33.2 port 32768, id=28, length=207
        User-Name = "STUDENTBRANDON"
        Calling-Station-Id = "00-1d-e0-51-c2-6d"
        Called-Station-Id = "00-22-55-e0-7d-d0:cryptadmin"
        NAS-Port = 29
        NAS-IP-Address = 172.16.33.2
        NAS-Identifier = "wlc-nsac-exteng-4404-6"
        Airespace-Wlan-Id = 6
        Service-Type = Framed-User
        Framed-MTU = 1300
        NAS-Port-Type = Wireless-802.11
        Tunnel-Type:0 = VLAN
        Tunnel-Medium-Type:0 = IEEE-802
        Tunnel-Private-Group-Id:0 = "240"
        EAP-Message = 0x020200130153545544454e544252414e444f4e
        Message-Authenticator = 0x2b9e3f7830cca848e4dd9e16e6ddecab
Thu Feb 18 11:47:09 2010 : Info: +- entering group authorize {...}
Thu Feb 18 11:47:09 2010 : Info: ++[preprocess] returns ok
Thu Feb 18 11:47:09 2010 : Info: [suffix] No '@' in User-Name = "STUDENTBRANDON", looking up realm NULL
Thu Feb 18 11:47:09 2010 : Info: [suffix] No such realm "NULL"
Thu Feb 18 11:47:09 2010 : Info: ++[suffix] returns noop
Thu Feb 18 11:47:09 2010 : Info: [eap] EAP packet type response id 2 length 19
Thu Feb 18 11:47:09 2010 : Info: [eap] No EAP Start, assuming it's an on-going EAP conversation
Thu Feb 18 11:47:09 2010 : Info: ++[eap] returns updated
Thu Feb 18 11:47:09 2010 : Info: [ldap] performing user authorization for STUDENTBRANDON
Thu Feb 18 11:47:09 2010 : Info: [ldap]         expand: %{Stripped-User-Name} ->
Thu Feb 18 11:47:09 2010 : Info: [ldap]         ... expanding second conditional
Thu Feb 18 11:47:09 2010 : Info: [ldap]         expand: %{User-Name} -> STUDENTBRANDON
Thu Feb 18 11:47:09 2010 : Info: [ldap]         expand: (&(uid=%{%{Stripped-User-Name}:-%{User-Name}})(!(THELDAPBIND=1))) -> 
 
(&(uid=STUDENTBRANDON)(!(THELDAPBIND=1)))
Thu Feb 18 11:47:09 2010 : Info: [ldap]         expand: o=NSAC -> o=NSAC
Thu Feb 18 11:47:09 2010 : Debug:   [ldap] ldap_get_conn: Checking Id: 0
Thu Feb 18 11:47:09 2010 : Debug:   [ldap] ldap_get_conn: Got Id: 0
Thu Feb 18 11:47:09 2010 : Debug:   [ldap] performing search in o=NSAC, with filter (&(uid=STUDENTBRANDON)(!(THELDAPBIND=1)))
Thu Feb 18 11:47:09 2010 : Info: [ldap] Added the eDirectory password 1234567 in check items as Cleartext-Password
Thu Feb 18 11:47:09 2010 : Info: [ldap] looking for check items in directory...
Thu Feb 18 11:47:09 2010 : Info: [ldap] looking for reply items in directory...
Thu Feb 18 11:47:09 2010 : Info: [ldap] user STUDENTBRANDON authorized to use remote access
Thu Feb 18 11:47:09 2010 : Debug:   [ldap] ldap_release_conn: Release Id: 0
Thu Feb 18 11:47:09 2010 : Info: ++[ldap] returns ok
Thu Feb 18 11:47:09 2010 : Info: ++[expiration] returns noop
Thu Feb 18 11:47:09 2010 : Info: ++[logintime] returns noop
Thu Feb 18 11:47:09 2010 : Info: [pap] Found existing Auth-Type, not changing it.
Thu Feb 18 11:47:09 2010 : Info: ++[pap] returns noop
Thu Feb 18 11:47:09 2010 : Info: Found Auth-Type = EAP
Thu Feb 18 11:47:09 2010 : Info: +- entering group authenticate {...}
Thu Feb 18 11:47:09 2010 : Info: [eap] EAP Identity
Thu Feb 18 11:47:09 2010 : Info: [eap] processing type md5
Thu Feb 18 11:47:09 2010 : Debug: rlm_eap_md5: Issuing Challenge
Thu Feb 18 11:47:09 2010 : Info: ++[eap] returns handled
Sending Access-Challenge of id 28 to 172.16.33.2 port 32768
        EAP-Message = 0x010300160410acef14eeddcbae87045ccd15fcc5ca21
        Message-Authenticator = 0x00000000000000000000000000000000
        State = 0xf184d7d8f187d3129f9578c3572f17ab
Thu Feb 18 11:47:09 2010 : Info: Finished request 8.
Thu Feb 18 11:47:09 2010 : Debug: Going to the next request
Thu Feb 18 11:47:09 2010 : Debug: Waking up in 4.9 seconds.
rad_recv: Access-Request packet from host 172.16.33.2 port 32768, id=29, length=212
        User-Name = "STUDENTBRANDON"
        Calling-Station-Id = "00-1d-e0-51-c2-6d"
        Called-Station-Id = "00-22-55-e0-7d-d0:cryptadmin"
        NAS-Port = 29
        NAS-IP-Address = 172.16.33.2
        NAS-Identifier = "wlc-nsac-exteng-4404-6"
        Airespace-Wlan-Id = 6
        Service-Type = Framed-User
        Framed-MTU = 1300
        NAS-Port-Type = Wireless-802.11
        Tunnel-Type:0 = VLAN
        Tunnel-Medium-Type:0 = IEEE-802
        Tunnel-Private-Group-Id:0 = "240"
        EAP-Message = 0x020300060315
        State = 0xf184d7d8f187d3129f9578c3572f17ab
        Message-Authenticator = 0xee0cb9b1272a1be8ac8b864f58b49bd0
Thu Feb 18 11:47:09 2010 : Info: +- entering group authorize {...}
Thu Feb 18 11:47:09 2010 : Info: ++[preprocess] returns ok
Thu Feb 18 11:47:09 2010 : Info: [suffix] No '@' in User-Name = "STUDENTBRANDON", looking up realm NULL
Thu Feb 18 11:47:09 2010 : Info: [suffix] No such realm "NULL"
Thu Feb 18 11:47:09 2010 : Info: ++[suffix] returns noop
Thu Feb 18 11:47:09 2010 : Info: [eap] EAP packet type response id 3 length 6
Thu Feb 18 11:47:09 2010 : Info: [eap] No EAP Start, assuming it's an on-going EAP conversation
Thu Feb 18 11:47:09 2010 : Info: ++[eap] returns updated
Thu Feb 18 11:47:09 2010 : Info: [ldap] performing user authorization for STUDENTBRANDON
Thu Feb 18 11:47:09 2010 : Info: [ldap]         expand: %{Stripped-User-Name} ->
Thu Feb 18 11:47:09 2010 : Info: [ldap]         ... expanding second conditional
Thu Feb 18 11:47:09 2010 : Info: [ldap]         expand: %{User-Name} -> STUDENTBRANDON
Thu Feb 18 11:47:09 2010 : Info: [ldap]         expand: (&(uid=%{%{Stripped-User-Name}:-%{User-Name}})(!(THELDAPBIND=1))) -> 
 
(&(uid=STUDENTBRANDON)(!(THELDAPBIND=1)))
Thu Feb 18 11:47:09 2010 : Info: [ldap]         expand: o=NSAC -> o=NSAC
Thu Feb 18 11:47:09 2010 : Debug:   [ldap] ldap_get_conn: Checking Id: 0
Thu Feb 18 11:47:09 2010 : Debug:   [ldap] ldap_get_conn: Got Id: 0
Thu Feb 18 11:47:09 2010 : Debug:   [ldap] performing search in o=NSAC, with filter (&(uid=STUDENTBRANDON)(!(THELDAPBIND=1)))
Thu Feb 18 11:47:09 2010 : Info: [ldap] Added the eDirectory password 1234567 in check items as Cleartext-Password
Thu Feb 18 11:47:09 2010 : Info: [ldap] looking for check items in directory...
Thu Feb 18 11:47:09 2010 : Info: [ldap] looking for reply items in directory...
Thu Feb 18 11:47:09 2010 : Info: [ldap] user STUDENTBRANDON authorized to use remote access
Thu Feb 18 11:47:09 2010 : Debug:   [ldap] ldap_release_conn: Release Id: 0
Thu Feb 18 11:47:09 2010 : Info: ++[ldap] returns ok
Thu Feb 18 11:47:09 2010 : Info: ++[expiration] returns noop
Thu Feb 18 11:47:09 2010 : Info: ++[logintime] returns noop
Thu Feb 18 11:47:09 2010 : Info: [pap] Found existing Auth-Type, not changing it.
Thu Feb 18 11:47:09 2010 : Info: ++[pap] returns noop
Thu Feb 18 11:47:09 2010 : Info: Found Auth-Type = EAP
Thu Feb 18 11:47:09 2010 : Info: +- entering group authenticate {...}
Thu Feb 18 11:47:09 2010 : Info: [eap] Request found, released from the list
Thu Feb 18 11:47:09 2010 : Info: [eap] EAP NAK
Thu Feb 18 11:47:09 2010 : Info: [eap] EAP-NAK asked for EAP-Type/ttls
Thu Feb 18 11:47:09 2010 : Info: [eap] processing type tls
Thu Feb 18 11:47:09 2010 : Info: [tls] Initiate
Thu Feb 18 11:47:09 2010 : Info: [tls] Start returned 1
Thu Feb 18 11:47:09 2010 : Info: ++[eap] returns handled
Sending Access-Challenge of id 29 to 172.16.33.2 port 32768
        EAP-Message = 0x010400061520
        Message-Authenticator = 0x00000000000000000000000000000000
        State = 0xf184d7d8f080c2129f9578c3572f17ab
Thu Feb 18 11:47:09 2010 : Info: Finished request 9.
Thu Feb 18 11:47:09 2010 : Debug: Going to the next request
Thu Feb 18 11:47:09 2010 : Debug: Waking up in 4.9 seconds.
rad_recv: Access-Request packet from host 172.16.33.2 port 32768, id=30, length=262
        User-Name = "STUDENTBRANDON"
        Calling-Station-Id = "00-1d-e0-51-c2-6d"
        Called-Station-Id = "00-22-55-e0-7d-d0:cryptadmin"
        NAS-Port = 29
        NAS-IP-Address = 172.16.33.2
        NAS-Identifier = "wlc-nsac-exteng-4404-6"
        Airespace-Wlan-Id = 6
        Service-Type = Framed-User
        Framed-MTU = 1300
        NAS-Port-Type = Wireless-802.11
        Tunnel-Type:0 = VLAN
        Tunnel-Medium-Type:0 = IEEE-802
        Tunnel-Private-Group-Id:0 = "240"
        EAP-Message = 0x020400381500160301002d010000290301e2158675d00f7dbebf4d3e046fd16d636ba0d7d470d25ef7fb34a52b5c466adb000002000a0100
        State = 0xf184d7d8f080c2129f9578c3572f17ab
        Message-Authenticator = 0x1c89d60840ffd93ecdfb70e925c99ea7
Thu Feb 18 11:47:09 2010 : Info: +- entering group authorize {...}
Thu Feb 18 11:47:09 2010 : Info: ++[preprocess] returns ok
Thu Feb 18 11:47:09 2010 : Info: [suffix] No '@' in User-Name = "STUDENTBRANDON", looking up realm NULL
Thu Feb 18 11:47:09 2010 : Info: [suffix] No such realm "NULL"
Thu Feb 18 11:47:09 2010 : Info: ++[suffix] returns noop
Thu Feb 18 11:47:09 2010 : Info: [eap] EAP packet type response id 4 length 56
Thu Feb 18 11:47:09 2010 : Info: [eap] Continuing tunnel setup.
Thu Feb 18 11:47:09 2010 : Info: ++[eap] returns ok
Thu Feb 18 11:47:09 2010 : Info: Found Auth-Type = EAP
Thu Feb 18 11:47:09 2010 : Info: +- entering group authenticate {...}
Thu Feb 18 11:47:09 2010 : Info: [eap] Request found, released from the list
Thu Feb 18 11:47:09 2010 : Info: [eap] EAP/ttls
Thu Feb 18 11:47:09 2010 : Info: [eap] processing type ttls
Thu Feb 18 11:47:09 2010 : Info: [ttls] Authenticate
Thu Feb 18 11:47:09 2010 : Info: [ttls] processing EAP-TLS
Thu Feb 18 11:47:09 2010 : Info: [ttls] eaptls_verify returned 7
Thu Feb 18 11:47:09 2010 : Info: [ttls] Done initial handshake
Thu Feb 18 11:47:09 2010 : Info: [ttls]     (other): before/accept initialization
Thu Feb 18 11:47:09 2010 : Info: [ttls]     TLS_accept: before/accept initialization
Thu Feb 18 11:47:09 2010 : Info: [ttls] <<< TLS 1.0 Handshake [length 002d], ClientHello
Thu Feb 18 11:47:09 2010 : Info: [ttls]     TLS_accept: SSLv3 read client hello A
Thu Feb 18 11:47:09 2010 : Info: [ttls] >>> TLS 1.0 Handshake [length 002a], ServerHello
Thu Feb 18 11:47:09 2010 : Info: [ttls]     TLS_accept: SSLv3 write server hello A
Thu Feb 18 11:47:09 2010 : Info: [ttls] >>> TLS 1.0 Handshake [length 085e], Certificate
Thu Feb 18 11:47:09 2010 : Info: [ttls]     TLS_accept: SSLv3 write certificate A
Thu Feb 18 11:47:09 2010 : Info: [ttls] >>> TLS 1.0 Handshake [length 0004], ServerHelloDone
Thu Feb 18 11:47:09 2010 : Info: [ttls]     TLS_accept: SSLv3 write server done A
Thu Feb 18 11:47:09 2010 : Info: [ttls]     TLS_accept: SSLv3 flush data
Thu Feb 18 11:47:09 2010 : Info: [ttls]     TLS_accept: Need to read more data: SSLv3 read client certificate A
Thu Feb 18 11:47:09 2010 : Debug: In SSL Handshake Phase
Thu Feb 18 11:47:09 2010 : Debug: In SSL Accept mode
Thu Feb 18 11:47:09 2010 : Info: [ttls] eaptls_process returned 13
Thu Feb 18 11:47:09 2010 : Info: ++[eap] returns handled
Sending Access-Challenge of id 30 to 172.16.33.2 port 32768
        EAP-Message = 
 
0x0105040015c00000089b160301002a0200002603014b7d60fdcba961d3d55384b73eaf88197907c2ced3c87e8eac942226f575917b00000a00160301085e0b00085a0008570
 
003a6308203a23082028aa003020102020101300d06092a864886f70d0101040500308193310b3009060355040613024652310f300d0603550408130652616469757331123010
 
06035504071309536f6d65776865726531153013060355040a130c4578616d706c6520496e632e3120301e06092a864886f70d010901161161646d696e406578616d706c652e6
 
36f6d312630240603550403131d4578616d706c6520436572746966696361746520417574686f72697479
        EAP-Message = 
 
0x301e170d3130303132333035353833325a170d3131303132333035353833325a307c310b3009060355040613024652310f300d0603550408130652616469757331153013060
 
355040a130c4578616d706c6520496e632e312330210603550403131a4578616d706c65205365727665722043657274696669636174653120301e06092a864886f70d01090116
 
1161646d696e406578616d706c652e636f6d30820122300d06092a864886f70d01010105000382010f003082010a0282010100d145e91c1b7bf93502e27b6455cbf030407ba92
 
cac7d45fd09cb737966e7b42975ad34a77afa0265de702a8753a33e08374e45f5b61a7c74fc21a48c5400
        EAP-Message = 
 
0xe952489111f44a9f29ccb7aad6dc38830f9a031b1678e94b27693ec204ec6c54388b6a82275ad652b3f32aec40080a555de5069688a2611ec31a1be1eb1a480903be4d3762a
 
86b2c7cd0e6b906cd57308ac851dc63266ba32c0a9b5869833ed8200f577be9d03cb819da2b7889817878bffa27a6b1238e971a2d3a0c801c8413920873ec273c355cfd02dddb
 
603fc24e4aade061fcb26bb2f79233a1b6f5e2695a3ce2b5ace2bffaf1c28a664ea373f91d604270b2249b8a1b5a51b3aa400c3153430203010001a317301530130603551d250
 
40c300a06082b06010505070301300d06092a864886f70d010104050003820101007bfc011048758a9131
        EAP-Message = 
 
0xc9780e6e2e466992b7e943d9dd6ee6b3d2c5be35857b6645c7eb414ab50deb1f9093df621553aec613246df6c2f593427a2eb14fb656a6105613b3dbff81f8ea21d0d7100a0
 
c988361c1b6f035c8507e9f0b2c8b6968dd3562b25e0135507c1ce698b8ffaf898519bd55f2698c1c611cb083eff0787c1ec70798d7ebf371df1b97e6f59281bae9671a8e49d3
 
098ed50f53d8f4dd08fc62271ea83c662dea50d287ff4fbb79b5921906fc55ee3aec24abdb3f9ab7d658918890e92e304e1c955e8e839990e25c18ceb293328c5c733c891bb18
 
8a70c00474bafdfd5271b89587c9147c202e70c5a15d11936d05021cb9cbdf09ed3f4e5620004ab308204
        EAP-Message = 0xa73082038fa0030201020209
        Message-Authenticator = 0x00000000000000000000000000000000
        State = 0xf184d7d8f381c2129f9578c3572f17ab
Thu Feb 18 11:47:09 2010 : Info: Finished request 10.
Thu Feb 18 11:47:09 2010 : Debug: Going to the next request
Thu Feb 18 11:47:09 2010 : Debug: Waking up in 4.8 seconds.
rad_recv: Access-Request packet from host 172.16.33.2 port 32768, id=31, length=212
        User-Name = "STUDENTBRANDON"
        Calling-Station-Id = "00-1d-e0-51-c2-6d"
        Called-Station-Id = "00-22-55-e0-7d-d0:cryptadmin"
        NAS-Port = 29
        NAS-IP-Address = 172.16.33.2
        NAS-Identifier = "wlc-nsac-exteng-4404-6"
        Airespace-Wlan-Id = 6
        Service-Type = Framed-User
        Framed-MTU = 1300
        NAS-Port-Type = Wireless-802.11
        Tunnel-Type:0 = VLAN
        Tunnel-Medium-Type:0 = IEEE-802
        Tunnel-Private-Group-Id:0 = "240"
        EAP-Message = 0x020500061500
        State = 0xf184d7d8f381c2129f9578c3572f17ab
        Message-Authenticator = 0x8b1d7d879042d3b8b4be84fdb0f118be
 

Thu Feb 18 11:47:09 2010 : Info: +- entering group authorize {...}
Thu Feb 18 11:47:09 2010 : Info: ++[preprocess] returns ok
Thu Feb 18 11:47:09 2010 : Info: [suffix] No '@' in User-Name = "STUDENTBRANDON", looking up realm NULL
Thu Feb 18 11:47:09 2010 : Info: [suffix] No such realm "NULL"
Thu Feb 18 11:47:09 2010 : Info: ++[suffix] returns noop
Thu Feb 18 11:47:09 2010 : Info: [eap] EAP packet type response id 5 length 6
Thu Feb 18 11:47:09 2010 : Info: [eap] Continuing tunnel setup.
Thu Feb 18 11:47:09 2010 : Info: ++[eap] returns ok
Thu Feb 18 11:47:09 2010 : Info: Found Auth-Type = EAP
Thu Feb 18 11:47:09 2010 : Info: +- entering group authenticate {...}
Thu Feb 18 11:47:09 2010 : Info: [eap] Request found, released from the list
Thu Feb 18 11:47:09 2010 : Info: [eap] EAP/ttls
Thu Feb 18 11:47:09 2010 : Info: [eap] processing type ttls
Thu Feb 18 11:47:09 2010 : Info: [ttls] Authenticate
Thu Feb 18 11:47:09 2010 : Info: [ttls] processing EAP-TLS
Thu Feb 18 11:47:09 2010 : Info: [ttls] Received TLS ACK
Thu Feb 18 11:47:09 2010 : Info: [ttls] ACK handshake fragment handler
Thu Feb 18 11:47:09 2010 : Info: [ttls] eaptls_verify returned 1
Thu Feb 18 11:47:09 2010 : Info: [ttls] eaptls_process returned 13
Thu Feb 18 11:47:09 2010 : Info: ++[eap] returns handled
Sending Access-Challenge of id 31 to 172.16.33.2 port 32768
        EAP-Message = 
 
0x0106040015c00000089b00f2b0a7a02f36a6e7300d06092a864886f70d0101050500308193310b3009060355040613024652310f300d0603550408130652616469757331123
 
01006035504071309536f6d65776865726531153013060355040a130c4578616d706c6520496e632e3120301e06092a864886f70d010901161161646d696e406578616d706c65
 
2e636f6d312630240603550403131d4578616d706c6520436572746966696361746520417574686f72697479301e170d3130303132333035353833315a170d313130313233303
 
5353833315a308193310b3009060355040613024652310f300d0603550408130652616469757331123010
        EAP-Message = 
 
0x06035504071309536f6d65776865726531153013060355040a130c4578616d706c6520496e632e3120301e06092a864886f70d010901161161646d696e406578616d706c652
 
e636f6d312630240603550403131d4578616d706c6520436572746966696361746520417574686f7269747930820122300d06092a864886f70d01010105000382010f00308201
 
0a0282010100a096038485366885b9d666de402c00dc2f41e6117c9793b4211e2ca0c8097e5101fc92bf286e72ef224e7f2d010c4f2c096714fe5c912e80e3694a4139732c1a7
 
b3b7dab5ae48ef4366fd1070880544a55f81ffb3b866fb506f1618e71636f41bca54a50c9b1a5c0629b7b
        EAP-Message = 
 
0xf1f5f4655ca6467c3b56acad1ddd8017755c92f82aba8605955b702043ccb0d54f4e7cecfdea9a843a68b522f60e6378146a1fde27e35515732e31e82d22152ba97f5dbfe37
 
9b8b61ef292ec262a0ab0442a99d0cb321115dc71088e4f23645427e120aa4b076f627dca9db0ff60d5d9d3eba8290dbed25d0d0b7c62ec8e3577e314ef6f29069fd93462e595
 
d5e127765c2f2916530203010001a381fb3081f8301d0603551d0e0416041414bb9789767df723612d34db98d8b7f41b9e2b0f3081c80603551d230481c03081bd801414bb978
 
9767df723612d34db98d8b7f41b9e2b0fa18199a48196308193310b3009060355040613024652310f300d
        EAP-Message = 
 
0x060355040813065261646975733112301006035504071309536f6d65776865726531153013060355040a130c4578616d706c6520496e632e3120301e06092a864886f70d010
 
901161161646d696e406578616d706c652e636f6d312630240603550403131d4578616d706c6520436572746966696361746520417574686f72697479820900f2b0a7a02f36a6
 
e7300c0603551d13040530030101ff300d06092a864886f70d0101050500038201010036737ecd034a3c80c578a142e99436ccb48ccafcdbd6eb258795dc2d263e651699bd8cc
 
98f49361d23280041f432d389b96dacde21a01a0d71ad7906aeb0d990444199a41dcd06484019ea3a08df
        EAP-Message = 0xa9aceeebd4f7e37a378b97db
        Message-Authenticator = 0x00000000000000000000000000000000
        State = 0xf184d7d8f282c2129f9578c3572f17ab
Thu Feb 18 11:47:09 2010 : Info: Finished request 11.
Thu Feb 18 11:47:09 2010 : Debug: Going to the next request
Thu Feb 18 11:47:09 2010 : Debug: Waking up in 4.8 seconds.
rad_recv: Access-Request packet from host 172.16.33.2 port 32768, id=32, length=212
        User-Name = "STUDENTBRANDON"
        Calling-Station-Id = "00-1d-e0-51-c2-6d"
        Called-Station-Id = "00-22-55-e0-7d-d0:cryptadmin"
        NAS-Port = 29
        NAS-IP-Address = 172.16.33.2
        NAS-Identifier = "wlc-nsac-exteng-4404-6"
        Airespace-Wlan-Id = 6
        Service-Type = Framed-User
        Framed-MTU = 1300
        NAS-Port-Type = Wireless-802.11
        Tunnel-Type:0 = VLAN
        Tunnel-Medium-Type:0 = IEEE-802
        Tunnel-Private-Group-Id:0 = "240"
        EAP-Message = 0x020600061500
        State = 0xf184d7d8f282c2129f9578c3572f17ab
        Message-Authenticator = 0x4ab20b3997aa648ad7b138f4b8304293
Thu Feb 18 11:47:09 2010 : Info: +- entering group authorize {...}
Thu Feb 18 11:47:09 2010 : Info: ++[preprocess] returns ok
Thu Feb 18 11:47:09 2010 : Info: [suffix] No '@' in User-Name = "STUDENTBRANDON", looking up realm NULL
Thu Feb 18 11:47:09 2010 : Info: [suffix] No such realm "NULL"
Thu Feb 18 11:47:09 2010 : Info: ++[suffix] returns noop
Thu Feb 18 11:47:09 2010 : Info: [eap] EAP packet type response id 6 length 6
Thu Feb 18 11:47:09 2010 : Info: [eap] Continuing tunnel setup.
Thu Feb 18 11:47:09 2010 : Info: ++[eap] returns ok
Thu Feb 18 11:47:09 2010 : Info: Found Auth-Type = EAP
Thu Feb 18 11:47:09 2010 : Info: +- entering group authenticate {...}
Thu Feb 18 11:47:09 2010 : Info: [eap] Request found, released from the list
Thu Feb 18 11:47:09 2010 : Info: [eap] EAP/ttls
Thu Feb 18 11:47:09 2010 : Info: [eap] processing type ttls
Thu Feb 18 11:47:09 2010 : Info: [ttls] Authenticate
Thu Feb 18 11:47:09 2010 : Info: [ttls] processing EAP-TLS
Thu Feb 18 11:47:09 2010 : Info: [ttls] Received TLS ACK
Thu Feb 18 11:47:09 2010 : Info: [ttls] ACK handshake fragment handler
Thu Feb 18 11:47:09 2010 : Info: [ttls] eaptls_verify returned 1
Thu Feb 18 11:47:09 2010 : Info: [ttls] eaptls_process returned 13
Thu Feb 18 11:47:09 2010 : Info: ++[eap] returns handled
Sending Access-Challenge of id 32 to 172.16.33.2 port 32768
        EAP-Message = 
 
0x010700b915800000089b66db272fb6fb5fb066283fbed2ef931a20d9edbc1baf6dd0edd7a85c9810cca6ac5e349282c29e58f2e44f4ccd22da1a00f9e4062529305c6505974
 
ac6e257b92b3e473ee517b0eae68a8c01145136fabd1c948f23f417775f36e91389fc96672cef62061ba46aa0b5df7c739196e884da569536a46aedd959fdb6f127654cbd550e
 
c79af1c175fc9f6f428cdf8144d10d41e08a80624aa5e9b310f7a68d4dd4b7c97e457b9f16030100040e000000
        Message-Authenticator = 0x00000000000000000000000000000000
        State = 0xf184d7d8f583c2129f9578c3572f17ab
Thu Feb 18 11:47:09 2010 : Info: Finished request 12.
Thu Feb 18 11:47:09 2010 : Debug: Going to the next request
Thu Feb 18 11:47:09 2010 : Debug: Waking up in 4.8 seconds.
rad_recv: Access-Request packet from host 172.16.33.2 port 32768, id=33, length=532
        User-Name = "STUDENTBRANDON"
        Calling-Station-Id = "00-1d-e0-51-c2-6d"
        Called-Station-Id = "00-22-55-e0-7d-d0:cryptadmin"
        NAS-Port = 29
        NAS-IP-Address = 172.16.33.2
        NAS-Identifier = "wlc-nsac-exteng-4404-6"
        Airespace-Wlan-Id = 6
        Service-Type = Framed-User
        Framed-MTU = 1300
        NAS-Port-Type = Wireless-802.11
        Tunnel-Type:0 = VLAN
        Tunnel-Medium-Type:0 = IEEE-802
        Tunnel-Private-Group-Id:0 = "240"
        EAP-Message = 
 
0x020701441500160301010610000102010044d80f753446cab3fb4a950ecb23536835f48379ed6c6b63ed645f46bd4e8ec3c62d375bcc6d02a157f0bc43a9b89fa4a06987636
 
efb56ce2df15f64aa61e72250dbc49c640d39f1ecfadc5ac1547802c34a568039f5fc5d2e492b0171aad27049c1e950ad7ba60086d9c25fd6e31d11d83d15f0f3a7307965f89a
 
fc78c889ae4d5d03a507ea369362e90a5f467d1be4c3b2d34dcbf24b8df6adedc6c8e3608875bb82109163f582dd0ad9f52bbc942bbd6d5933dd7ddc9a12a234730b30602d23f
 
1e28f542fc6dc5e71733fc07eab9404477947e6d8e3cd5effc68e278002265e884adcd48af568d3c88e35
        EAP-Message = 
 
0x8d33480abf4ca82c9a7275028c74d3376c56f1f7140301000101160301002876c9c626818695c04ee04e58435bea1adb06026c8d1755a467f92f0744f4329599565c6f2148a
 
8ce
        State = 0xf184d7d8f583c2129f9578c3572f17ab
        Message-Authenticator = 0xd3ac6c79b1378b3917146b0b4b34c17d
Thu Feb 18 11:47:09 2010 : Info: +- entering group authorize {...}
Thu Feb 18 11:47:09 2010 : Info: ++[preprocess] returns ok
Thu Feb 18 11:47:09 2010 : Info: [suffix] No '@' in User-Name = "STUDENTBRANDON", looking up realm NULL
Thu Feb 18 11:47:09 2010 : Info: [suffix] No such realm "NULL"
Thu Feb 18 11:47:09 2010 : Info: ++[suffix] returns noop
Thu Feb 18 11:47:09 2010 : Info: [eap] EAP packet type response id 7 length 253
Thu Feb 18 11:47:09 2010 : Info: [eap] Continuing tunnel setup.
Thu Feb 18 11:47:09 2010 : Info: ++[eap] returns ok
Thu Feb 18 11:47:09 2010 : Info: Found Auth-Type = EAP
Thu Feb 18 11:47:09 2010 : Info: +- entering group authenticate {...}
Thu Feb 18 11:47:09 2010 : Info: [eap] Request found, released from the list
Thu Feb 18 11:47:09 2010 : Info: [eap] EAP/ttls
Thu Feb 18 11:47:09 2010 : Info: [eap] processing type ttls
Thu Feb 18 11:47:09 2010 : Info: [ttls] Authenticate
Thu Feb 18 11:47:09 2010 : Info: [ttls] processing EAP-TLS
Thu Feb 18 11:47:09 2010 : Info: [ttls] eaptls_verify returned 7
Thu Feb 18 11:47:09 2010 : Info: [ttls] Done initial handshake
Thu Feb 18 11:47:09 2010 : Info: [ttls] <<< TLS 1.0 Handshake [length 0106], ClientKeyExchange
Thu Feb 18 11:47:09 2010 : Info: [ttls]     TLS_accept: SSLv3 read client key exchange A
Thu Feb 18 11:47:09 2010 : Info: [ttls] <<< TLS 1.0 ChangeCipherSpec [length 0001]
Thu Feb 18 11:47:09 2010 : Info: [ttls] <<< TLS 1.0 Handshake [length 0010], Finished
Thu Feb 18 11:47:09 2010 : Info: [ttls]     TLS_accept: SSLv3 read finished A
Thu Feb 18 11:47:09 2010 : Info: [ttls] >>> TLS 1.0 ChangeCipherSpec [length 0001]
Thu Feb 18 11:47:09 2010 : Info: [ttls]     TLS_accept: SSLv3 write change cipher spec A
Thu Feb 18 11:47:09 2010 : Info: [ttls] >>> TLS 1.0 Handshake [length 0010], Finished
Thu Feb 18 11:47:09 2010 : Info: [ttls]     TLS_accept: SSLv3 write finished A
Thu Feb 18 11:47:09 2010 : Info: [ttls]     TLS_accept: SSLv3 flush data
Thu Feb 18 11:47:09 2010 : Info: [ttls]     (other): SSL negotiation finished successfully
Thu Feb 18 11:47:09 2010 : Debug: SSL Connection Established
Thu Feb 18 11:47:09 2010 : Info: [ttls] eaptls_process returned 13
Thu Feb 18 11:47:09 2010 : Info: ++[eap] returns handled
Sending Access-Challenge of id 33 to 172.16.33.2 port 32768
        EAP-Message = 
 
0x0108003d1580000000331403010001011603010028e9fc4a2a326f1783b766ac6b96a2e0fae0e32d9bdb2fca98edeb4def649c0a5a4eeace488ef3e445
        Message-Authenticator = 0x00000000000000000000000000000000
        State = 0xf184d7d8f48cc2129f9578c3572f17ab
Thu Feb 18 11:47:09 2010 : Info: Finished request 13.
Thu Feb 18 11:47:09 2010 : Debug: Going to the next request
Thu Feb 18 11:47:09 2010 : Debug: Waking up in 4.6 seconds.
rad_recv: Access-Request packet from host 172.16.33.2 port 32768, id=34, length=281
        User-Name = "STUDENTBRANDON"
        Calling-Station-Id = "00-1d-e0-51-c2-6d"
        Called-Station-Id = "00-22-55-e0-7d-d0:cryptadmin"
        NAS-Port = 29
        NAS-IP-Address = 172.16.33.2
        NAS-Identifier = "wlc-nsac-exteng-4404-6"
        Airespace-Wlan-Id = 6
        Service-Type = Framed-User
        Framed-MTU = 1300
        NAS-Port-Type = Wireless-802.11
        Tunnel-Type:0 = VLAN
        Tunnel-Medium-Type:0 = IEEE-802
        Tunnel-Private-Group-Id:0 = "240"
        EAP-Message = 
 
0x0208004b15001703010040242674092173e9f7f3209e69f50670d6f53f9c1d409767018f67a730a942a2eebfe1b817d2d648d7b993b20c390f07dc6b15a88fc8c61200821d2
 
a21354b18ee
        State = 0xf184d7d8f48cc2129f9578c3572f17ab
        Message-Authenticator = 0xd429653cd72df306994ae1761baac2c3
Thu Feb 18 11:47:09 2010 : Info: +- entering group authorize {...}
Thu Feb 18 11:47:09 2010 : Info: ++[preprocess] returns ok
Thu Feb 18 11:47:09 2010 : Info: [suffix] No '@' in User-Name = "STUDENTBRANDON", looking up realm NULL
Thu Feb 18 11:47:09 2010 : Info: [suffix] No such realm "NULL"
Thu Feb 18 11:47:09 2010 : Info: ++[suffix] returns noop
Thu Feb 18 11:47:09 2010 : Info: [eap] EAP packet type response id 8 length 75
Thu Feb 18 11:47:09 2010 : Info: [eap] Continuing tunnel setup.
Thu Feb 18 11:47:09 2010 : Info: ++[eap] returns ok
Thu Feb 18 11:47:09 2010 : Info: Found Auth-Type = EAP
Thu Feb 18 11:47:09 2010 : Info: +- entering group authenticate {...}
Thu Feb 18 11:47:09 2010 : Info: [eap] Request found, released from the list
Thu Feb 18 11:47:09 2010 : Info: [eap] EAP/ttls
Thu Feb 18 11:47:09 2010 : Info: [eap] processing type ttls
Thu Feb 18 11:47:09 2010 : Info: [ttls] Authenticate
Thu Feb 18 11:47:09 2010 : Info: [ttls] processing EAP-TLS
Thu Feb 18 11:47:09 2010 : Info: [ttls] eaptls_verify returned 7
Thu Feb 18 11:47:09 2010 : Info: [ttls] Done initial handshake
Thu Feb 18 11:47:09 2010 : Info: [ttls] eaptls_process returned 7
Thu Feb 18 11:47:09 2010 : Info: [ttls] Session established.  Proceeding to decode tunneled attributes.
  TTLS tunnel data in 0000: 00 00 00 01 40 00 00 16 53 54 55 44 45 4e 54 42
  TTLS tunnel data in 0010: 52 41 4e 44 4f 4e 00 00 00 00 00 02 40 00 00 0f
  TTLS tunnel data in 0020: 31 32 33 34 35 36 37 00
Thu Feb 18 11:47:09 2010 : Info: [ttls] Got tunneled request
        User-Name = "STUDENTBRANDON"
        User-Password = "1234567"
        FreeRADIUS-Proxied-To = 127.0.0.1
Thu Feb 18 11:47:09 2010 : Info: [ttls] Sending tunneled request
        User-Name = "STUDENTBRANDON"
        User-Password = "1234567"
        FreeRADIUS-Proxied-To = 127.0.0.1
server  {
Thu Feb 18 11:47:09 2010 : Info: +- entering group authorize {...}
Thu Feb 18 11:47:09 2010 : Info: ++[preprocess] returns ok
Thu Feb 18 11:47:09 2010 : Info: [suffix] No '@' in User-Name = "STUDENTBRANDON", looking up realm NULL
Thu Feb 18 11:47:09 2010 : Info: [suffix] No such realm "NULL"
Thu Feb 18 11:47:09 2010 : Info: ++[suffix] returns noop
Thu Feb 18 11:47:09 2010 : Info: [eap] No EAP-Message, not doing EAP
Thu Feb 18 11:47:09 2010 : Info: ++[eap] returns noop
Thu Feb 18 11:47:09 2010 : Info: [ldap] performing user authorization for STUDENTBRANDON
Thu Feb 18 11:47:09 2010 : Info: [ldap]         expand: %{Stripped-User-Name} ->
Thu Feb 18 11:47:09 2010 : Info: [ldap]         ... expanding second conditional
Thu Feb 18 11:47:09 2010 : Info: [ldap]         expand: %{User-Name} -> STUDENTBRANDON
Thu Feb 18 11:47:09 2010 : Info: [ldap]         expand: (&(uid=%{%{Stripped-User-Name}:-%{User-Name}})(!(THELDAPBIND=1))) -> 
 
(&(uid=STUDENTBRANDON)(!(THELDAPBIND=1)))
Thu Feb 18 11:47:09 2010 : Info: [ldap]         expand: o=NSAC -> o=NSAC
Thu Feb 18 11:47:09 2010 : Debug:   [ldap] ldap_get_conn: Checking Id: 0
Thu Feb 18 11:47:09 2010 : Debug:   [ldap] ldap_get_conn: Got Id: 0
Thu Feb 18 11:47:09 2010 : Debug:   [ldap] performing search in o=NSAC, with filter (&(uid=STUDENTBRANDON)(!(THELDAPBIND=1)))
Thu Feb 18 11:47:09 2010 : Info: [ldap] Added the eDirectory password 1234567 in check items as Cleartext-Password
Thu Feb 18 11:47:09 2010 : Info: [ldap] looking for check items in directory...
Thu Feb 18 11:47:09 2010 : Info: [ldap] looking for reply items in directory...
Thu Feb 18 11:47:09 2010 : Info: [ldap] user STUDENTBRANDON authorized to use remote access
Thu Feb 18 11:47:09 2010 : Debug:   [ldap] ldap_release_conn: Release Id: 0
Thu Feb 18 11:47:09 2010 : Info: ++[ldap] returns ok
Thu Feb 18 11:47:09 2010 : Info: ++[expiration] returns noop
Thu Feb 18 11:47:09 2010 : Info: ++[logintime] returns noop
Thu Feb 18 11:47:09 2010 : Info: ++[pap] returns updated
Thu Feb 18 11:47:09 2010 : Info: Found Auth-Type = PAP
Thu Feb 18 11:47:09 2010 : Info: +- entering group PAP {...}
Thu Feb 18 11:47:09 2010 : Info: [pap] login attempt with password "1234567"
Thu Feb 18 11:47:09 2010 : Info: [pap] Using clear text password "1234567"
Thu Feb 18 11:47:09 2010 : Info: [pap] User authenticated successfully
Thu Feb 18 11:47:09 2010 : Info: ++[pap] returns ok
Thu Feb 18 11:47:09 2010 : Info: +- entering group post-auth {...}
Thu Feb 18 11:47:09 2010 : Info: ++[exec] returns noop
} # server
Thu Feb 18 11:47:09 2010 : Info: [ttls] Got tunneled reply code 2
Thu Feb 18 11:47:09 2010 : Info: [ttls] Got tunneled Access-Accept
Thu Feb 18 11:47:09 2010 : Info: [eap] Freeing handler
Thu Feb 18 11:47:09 2010 : Info: ++[eap] returns ok
Thu Feb 18 11:47:09 2010 : Info: +- entering group post-auth {...}
Thu Feb 18 11:47:09 2010 : Info: ++[exec] returns noop
Sending Access-Accept of id 34 to 172.16.33.2 port 32768
        MS-MPPE-Recv-Key = 0xd87c3954099dd119a9e8f5f5801c1ca00931b4d9ca8d07f5d378d9d247c5a078
        MS-MPPE-Send-Key = 0xb028531f13aee19e321551ff73d7fea829b1634807b36b171f8cdb3d409171b6
        EAP-Message = 0x03080004
        Message-Authenticator = 0x00000000000000000000000000000000
        User-Name = "STUDENTBRANDON"
Thu Feb 18 11:47:09 2010 : Info: Finished request 14.
Thu Feb 18 11:47:09 2010 : Debug: Going to the next request
Thu Feb 18 11:47:09 2010 : Debug: Waking up in 4.5 seconds.
rad_recv: Accounting-Request packet from host 172.16.33.2 port 32768, id=156, length=181
        User-Name = "STUDENTBRANDON"
        NAS-Port = 29
        NAS-IP-Address = 172.16.33.2
        Framed-IP-Address = 172.16.19.109
        NAS-Identifier = "wlc-nsac-exteng-4404-6"
        Airespace-Wlan-Id = 6
        Acct-Session-Id = "4b7d6125/00:1d:e0:51:c2:6d/19966"
        Acct-Authentic = RADIUS
        Tunnel-Type:0 = VLAN
        Tunnel-Medium-Type:0 = IEEE-802
        Tunnel-Private-Group-Id:0 = "240"
        Acct-Status-Type = Start
        Calling-Station-Id = "172.16.19.109"
        Called-Station-Id = "172.16.33.2"
Thu Feb 18 11:47:13 2010 : Info: +- entering group preacct {...}
Thu Feb 18 11:47:13 2010 : Info: ++[preprocess] returns ok
Thu Feb 18 11:47:13 2010 : Info: [acct_unique] Hashing 'NAS-Port = 29,Client-IP-Address = 172.16.33.2,NAS-IP-Address = 
 
172.16.33.2,Acct-Session-Id = "4b7d6125/00:1d:e0:51:c2:6d/19966",User-Name = "STUDENTBRANDON"'
Thu Feb 18 11:47:13 2010 : Info: [acct_unique] Acct-Unique-Session-ID = "fd5aca495820eabb".
Thu Feb 18 11:47:13 2010 : Info: ++[acct_unique] returns ok
Thu Feb 18 11:47:13 2010 : Info: [suffix] No '@' in User-Name = "STUDENTBRANDON", looking up realm NULL
Thu Feb 18 11:47:13 2010 : Info: [suffix] No such realm "NULL"
Thu Feb 18 11:47:13 2010 : Info: ++[suffix] returns noop
Thu Feb 18 11:47:13 2010 : Info: ++[files] returns noop
Thu Feb 18 11:47:13 2010 : Info: +- entering group accounting {...}
Thu Feb 18 11:47:13 2010 : Info: [detail]       expand: /var/log/radius/radacct/%{Client-IP-Address}/detail-%Y%m%d -> 
 
/var/log/radius/radacct/172.16.33.2/detail-20100218
Thu Feb 18 11:47:13 2010 : Info: [detail] /var/log/radius/radacct/%{Client-IP-Address}/detail-%Y%m%d expands to 
 
/var/log/radius/radacct/172.16.33.2/detail-20100218
Thu Feb 18 11:47:13 2010 : Info: [detail]       expand: %t -> Thu Feb 18 11:47:13 2010
Thu Feb 18 11:47:13 2010 : Info: ++[detail] returns ok
Thu Feb 18 11:47:13 2010 : Info: [radutmp]      expand: /var/log/radius/radutmp -> /var/log/radius/radutmp
Thu Feb 18 11:47:13 2010 : Info: [radutmp]      expand: %{User-Name} -> STUDENTBRANDON
Thu Feb 18 11:47:13 2010 : Info: ++[radutmp] returns ok
Thu Feb 18 11:47:13 2010 : Info: [attr_filter.accounting_response]      expand: %{User-Name} -> STUDENTBRANDON
Thu Feb 18 11:47:13 2010 : Debug:  attr_filter: Matched entry DEFAULT at line 12
Thu Feb 18 11:47:13 2010 : Info: ++[attr_filter.accounting_response] returns updated
Sending Accounting-Response of id 156 to 172.16.33.2 port 32768
Thu Feb 18 11:47:13 2010 : Info: Finished request 15.
Thu Feb 18 11:47:13 2010 : Info: Cleaning up request 15 ID 156 with timestamp +218
Thu Feb 18 11:47:13 2010 : Debug: Going to the next request
Thu Feb 18 11:47:13 2010 : Debug: Waking up in 1.4 seconds.
Thu Feb 18 11:47:14 2010 : Info: Cleaning up request 8 ID 28 with timestamp +214
Thu Feb 18 11:47:14 2010 : Info: Cleaning up request 9 ID 29 with timestamp +214
Thu Feb 18 11:47:14 2010 : Info: Cleaning up request 10 ID 30 with timestamp +214
Thu Feb 18 11:47:14 2010 : Info: Cleaning up request 11 ID 31 with timestamp +214
Thu Feb 18 11:47:14 2010 : Info: Cleaning up request 12 ID 32 with timestamp +214
Thu Feb 18 11:47:14 2010 : Debug: Waking up in 0.1 seconds.
Thu Feb 18 11:47:14 2010 : Info: Cleaning up request 13 ID 33 with timestamp +214
Thu Feb 18 11:47:14 2010 : Debug: Waking up in 0.1 seconds.
Thu Feb 18 11:47:14 2010 : Info: Cleaning up request 14 ID 34 with timestamp +214
Thu Feb 18 11:47:14 2010 : Info: Ready to process requests.
 
 
 
Here is some accounting output:
 
rad_recv: Accounting-Request packet from host 172.16.33.2 port 32768, id=157, length=223
        User-Name = "STUDENTBRANDON"
        NAS-Port = 29
        NAS-IP-Address = 172.16.33.2
        Framed-IP-Address = 172.16.19.109
        NAS-Identifier = "wlc-nsac-exteng-4404-6"
        Airespace-Wlan-Id = 6
        Acct-Session-Id = "4b7d6125/00:1d:e0:51:c2:6d/19966"
        Acct-Authentic = RADIUS
        Tunnel-Type:0 = VLAN
        Tunnel-Medium-Type:0 = IEEE-802
        Tunnel-Private-Group-Id:0 = "240"
        Acct-Status-Type = Stop
        Acct-Input-Octets = 10940
        Acct-Output-Octets = 5288
        Acct-Input-Packets = 90
        Acct-Output-Packets = 25
        Acct-Terminate-Cause = Idle-Timeout
        Acct-Session-Time = 362
        Acct-Delay-Time = 0
        Calling-Station-Id = "172.16.19.109"
        Called-Station-Id = "172.16.33.2"
Thu Feb 18 11:53:15 2010 : Info: +- entering group preacct {...}
Thu Feb 18 11:53:16 2010 : Info: ++[preprocess] returns ok
Thu Feb 18 11:53:16 2010 : Info: [acct_unique] Hashing 'NAS-Port = 29,Client-IP-Address = 172.16.33.2,NAS-IP-Address = 
 
172.16.33.2,Acct-Session-Id = "4b7d6125/00:1d:e0:51:c2:6d/19966",User-Name = "STUDENTBRANDON"'
Thu Feb 18 11:53:16 2010 : Info: [acct_unique] Acct-Unique-Session-ID = "fd5aca495820eabb".
Thu Feb 18 11:53:16 2010 : Info: ++[acct_unique] returns ok
Thu Feb 18 11:53:16 2010 : Info: [suffix] No '@' in User-Name = "STUDENTBRANDON", looking up realm NULL
Thu Feb 18 11:53:16 2010 : Info: [suffix] No such realm "NULL"
Thu Feb 18 11:53:16 2010 : Info: ++[suffix] returns noop
Thu Feb 18 11:53:16 2010 : Info: ++[files] returns noop
Thu Feb 18 11:53:16 2010 : Info: +- entering group accounting {...}
Thu Feb 18 11:53:16 2010 : Info: [detail]       expand: /var/log/radius/radacct/%{Client-IP-Address}/detail-%Y%m%d -> 
 
/var/log/radius/radacct/172.16.33.2/detail-20100218
Thu Feb 18 11:53:16 2010 : Info: [detail] /var/log/radius/radacct/%{Client-IP-Address}/detail-%Y%m%d expands to 
 
/var/log/radius/radacct/172.16.33.2/detail-20100218
Thu Feb 18 11:53:16 2010 : Info: [detail]       expand: %t -> Thu Feb 18 11:53:15 2010
Thu Feb 18 11:53:16 2010 : Info: ++[detail] returns ok
Thu Feb 18 11:53:16 2010 : Info: [radutmp]      expand: /var/log/radius/radutmp -> /var/log/radius/radutmp
Thu Feb 18 11:53:16 2010 : Info: [radutmp]      expand: %{User-Name} -> STUDENTBRANDON
Thu Feb 18 11:53:16 2010 : Info: ++[radutmp] returns ok
Thu Feb 18 11:53:16 2010 : Info: [attr_filter.accounting_response]      expand: %{User-Name} -> STUDENTBRANDON
Thu Feb 18 11:53:16 2010 : Debug:  attr_filter: Matched entry DEFAULT at line 12
Thu Feb 18 11:53:16 2010 : Info: ++[attr_filter.accounting_response] returns updated
Sending Accounting-Response of id 157 to 172.16.33.2 port 32768
Thu Feb 18 11:53:16 2010 : Info: Finished request 16.
Thu Feb 18 11:53:16 2010 : Info: Cleaning up request 16 ID 157 with timestamp +580
Thu Feb 18 11:53:16 2010 : Debug: Going to the next request
Thu Feb 18 11:53:16 2010 : Info: Ready to process requests.
-------------- next part --------------
An HTML attachment was scrubbed...
URL: <http://lists.freeradius.org/pipermail/freeradius-users/attachments/20100219/069f8198/attachment.html>


More information about the Freeradius-Users mailing list