Starting - reading configuration files ... reread_config: reading radiusd.conf Config: including file: /usr/local/radius105/etc/raddb/proxy.conf Config: including file: /usr/local/radius105/etc/raddb/clients.conf Config: including file: /usr/local/radius105/etc/raddb/snmp.conf Config: including file: /usr/local/radius105/etc/raddb/eap.conf Config: including file: /usr/local/radius105/etc/raddb/sql.conf main: prefix = "/usr/local/radius105" main: localstatedir = "/usr/local/radius105/var" main: logdir = "/usr/local/radius105/var/log/radius" main: libdir = "/usr/local/radius105/lib" main: radacctdir = "/usr/local/radius105/var/log/radius/radacct" main: hostname_lookups = no main: max_request_time = 30 main: cleanup_delay = 5 main: max_requests = 1024 main: delete_blocked_requests = 0 main: port = 0 main: allow_core_dumps = no main: log_stripped_names = no main: log_file = "/usr/local/radius105/var/log/radius/radius.log" main: log_auth = no main: log_auth_badpass = no main: log_auth_goodpass = no main: pidfile = "/usr/local/radius105/var/run/radiusd/radiusd.pid" main: user = "(null)" main: group = "(null)" main: usercollide = no main: lower_user = "no" main: lower_pass = "no" main: nospace_user = "no" main: nospace_pass = "no" main: checkrad = "/usr/local/radius105/sbin/checkrad" main: proxy_requests = yes proxy: retry_delay = 5 proxy: retry_count = 3 proxy: synchronous = no proxy: default_fallback = yes proxy: dead_time = 120 proxy: post_proxy_authorize = yes proxy: wake_all_if_all_dead = no security: max_attributes = 200 security: reject_delay = 1 security: status_server = no main: debug_level = 0 read_config_files: reading dictionary read_config_files: reading naslist Using deprecated naslist file. Support for this will go away soon. read_config_files: reading clients read_config_files: reading realms radiusd: entering modules setup Module: Library search path is /usr/local/radius105/lib Module: Loaded exec exec: wait = yes exec: program = "(null)" exec: input_pairs = "request" exec: output_pairs = "(null)" exec: packet_type = "(null)" rlm_exec: Wait=yes but no output defined. Did you mean output=none? Module: Instantiated exec (exec) Module: Loaded expr Module: Instantiated expr (expr) Module: Loaded PAP pap: encryption_scheme = "clear" Module: Instantiated pap (pap) Module: Loaded CHAP Module: Instantiated chap (chap) Module: Loaded MS-CHAP mschap: use_mppe = yes mschap: require_encryption = yes mschap: require_strong = yes mschap: with_ntdomain_hack = no mschap: passwd = "(null)" mschap: authtype = "MS-CHAP" mschap: ntlm_auth = "(null)" Module: Instantiated mschap (mschap) Module: Loaded System unix: cache = no unix: passwd = "(null)" unix: shadow = "(null)" unix: group = "(null)" unix: radwtmp = "/usr/local/radius105/var/log/radius/radwtmp" unix: usegroup = no unix: cache_reload = 600 Module: Instantiated unix (unix) Module: Loaded eap eap: default_eap_type = "ttls" eap: timer_expire = 60 eap: ignore_unknown_eap_types = no eap: cisco_accounting_username_bug = no rlm_eap: Loaded and initialized type md5 rlm_eap: Loaded and initialized type leap tls: rsa_key_exchange = no tls: dh_key_exchange = yes tls: rsa_key_length = 512 tls: dh_key_length = 512 tls: verify_depth = 0 tls: CA_path = "(null)" tls: pem_file_type = yes tls: private_key_file = "/usr/local/radius105/etc/1x/cert-srv.pem" tls: certificate_file = "/usr/local/radius105/etc/1x/cert-srv.pem" tls: CA_file = "/usr/local/radius105/etc/1x/demoCA/cacert.pem" tls: private_key_password = "whatever" tls: dh_file = "/usr/local/radius105/etc/1x/dh" tls: random_file = "/usr/local/radius105/etc/1x/random" tls: fragment_size = 1024 tls: include_length = yes tls: check_crl = no tls: check_cert_cn = "(null)" rlm_eap: Loaded and initialized type tls ttls: default_eap_type = "" ttls: copy_request_to_tunnel = no ttls: use_tunneled_reply = no rlm_eap: Loaded and initialized type ttls peap: default_eap_type = "mschapv2" peap: copy_request_to_tunnel = no peap: use_tunneled_reply = no peap: proxy_tunneled_request_as_eap = yes rlm_eap: Loaded and initialized type peap mschapv2: with_ntdomain_hack = no rlm_eap: Loaded and initialized type mschapv2 Module: Instantiated eap (eap) Module: Loaded preprocess preprocess: huntgroups = "/usr/local/radius105/etc/raddb/huntgroups" preprocess: hints = "/usr/local/radius105/etc/raddb/hints" preprocess: with_ascend_hack = no preprocess: ascend_channels_per_line = 23 preprocess: with_ntdomain_hack = no preprocess: with_specialix_jetstream_hack = no preprocess: with_cisco_vsa_hack = no Module: Instantiated preprocess (preprocess) Module: Loaded realm realm: format = "suffix" realm: delimiter = "@" realm: ignore_default = no realm: ignore_null = no Module: Instantiated realm (suffix) Module: Loaded files files: usersfile = "/usr/local/radius105/etc/raddb/users" files: acctusersfile = "/usr/local/radius105/etc/raddb/acct_users" files: preproxy_usersfile = "/usr/local/radius105/etc/raddb/preproxy_users" files: compat = "no" Module: Instantiated files (files) Module: Loaded Acct-Unique-Session-Id acct_unique: key = "User-Name, Acct-Session-Id, NAS-IP-Address, Client-IP-Address, NAS-Port" Module: Instantiated acct_unique (acct_unique) Module: Loaded detail detail: detailfile = "/usr/local/radius105/var/log/radius/radacct/%{Client-IP-Address}/detail-%Y%m%d" detail: detailperm = 384 detail: dirperm = 493 detail: locking = no Module: Instantiated detail (detail) Module: Loaded radutmp radutmp: filename = "/usr/local/radius105/var/log/radius/radutmp" radutmp: username = "%{User-Name}" radutmp: case_sensitive = yes radutmp: check_with_nas = yes radutmp: perm = 384 radutmp: callerid = yes Module: Instantiated radutmp (radutmp) Listening on authentication *:1812 Listening on accounting *:1813 Ready to process requests. rad_recv: Access-Request packet from host 192.168.5.199:1033, id=117, length=175 User-Name = "anonymous" NAS-IP-Address = 192.168.5.199 NAS-Identifier = "test.5gwireless.com" NAS-Port = 0 Called-Station-Id = "00-0B-6B-87-01-BD:test" Calling-Station-Id = "00-1C-F0-9B-64-E5" Framed-MTU = 1400 NAS-Port-Type = Wireless-802.11 Connect-Info = "CONNECT 0Mbps 802.11" EAP-Message = 0x0200000e01616e6f6e796d6f7573 Message-Authenticator = 0xaa689b7d8fa0e93e518e1c0de6237c50 Processing the authorize section of radiusd.conf modcall: entering group authorize for request 0 modcall[authorize]: module "preprocess" returns ok for request 0 modcall[authorize]: module "chap" returns noop for request 0 modcall[authorize]: module "mschap" returns noop for request 0 rlm_realm: No '@' in User-Name = "anonymous", looking up realm NULL rlm_realm: No such realm "NULL" modcall[authorize]: module "suffix" returns noop for request 0 rlm_eap: EAP packet type response id 0 length 14 rlm_eap: No EAP Start, assuming it's an on-going EAP conversation modcall[authorize]: module "eap" returns updated for request 0 modcall[authorize]: module "files" returns notfound for request 0 modcall: group authorize returns updated for request 0 rad_check_password: Found Auth-Type EAP auth: type "EAP" Processing the authenticate section of radiusd.conf modcall: entering group authenticate for request 0 rlm_eap: EAP Identity rlm_eap: processing type tls rlm_eap_tls: Initiate rlm_eap_tls: Start returned 1 modcall[authenticate]: module "eap" returns handled for request 0 modcall: group authenticate returns handled for request 0 Sending Access-Challenge of id 117 to 192.168.5.199:1033 EAP-Message = 0x010100061520 Message-Authenticator = 0x00000000000000000000000000000000 State = 0xecf28c246ebedea31aa49d649657e543 Finished request 0 Going to the next request --- Walking the entire request list --- Waking up in 6 seconds... rad_recv: Access-Request packet from host 192.168.5.199:1033, id=118, length=279 User-Name = "anonymous" NAS-IP-Address = 192.168.5.199 NAS-Identifier = "test.5gwireless.com" NAS-Port = 0 Called-Station-Id = "00-0B-6B-87-01-BD:test" Calling-Station-Id = "00-1C-F0-9B-64-E5" Framed-MTU = 1400 NAS-Port-Type = Wireless-802.11 Connect-Info = "CONNECT 0Mbps 802.11" EAP-Message = 0x0201006415800000005a160301005501000051030149102321ef1545efd9a35b477ebed0c6fed223e66aa9e560cb3a7b4a8e7ea90800002a00160013006600150012000a0005000400070009006300650060006200610064001400110003000600080100 State = 0xecf28c246ebedea31aa49d649657e543 Message-Authenticator = 0xd102c1e35fab2b2f38f7b8229a0d3e0c Processing the authorize section of radiusd.conf modcall: entering group authorize for request 1 modcall[authorize]: module "preprocess" returns ok for request 1 modcall[authorize]: module "chap" returns noop for request 1 modcall[authorize]: module "mschap" returns noop for request 1 rlm_realm: No '@' in User-Name = "anonymous", looking up realm NULL rlm_realm: No such realm "NULL" modcall[authorize]: module "suffix" returns noop for request 1 rlm_eap: EAP packet type response id 1 length 100 rlm_eap: No EAP Start, assuming it's an on-going EAP conversation modcall[authorize]: module "eap" returns updated for request 1 modcall[authorize]: module "files" returns notfound for request 1 modcall: group authorize returns updated for request 1 rad_check_password: Found Auth-Type EAP auth: type "EAP" Processing the authenticate section of radiusd.conf modcall: entering group authenticate for request 1 rlm_eap: Request found, released from the list rlm_eap: EAP/ttls rlm_eap: processing type ttls rlm_eap_ttls: Authenticate rlm_eap_tls: processing TLS rlm_eap_tls: Length Included eaptls_verify returned 11 (other): before/accept initialization TLS_accept: before/accept initialization rlm_eap_tls: <<< TLS 1.0 Handshake [length 0055], ClientHello TLS_accept: SSLv3 read client hello A rlm_eap_tls: >>> TLS 1.0 Handshake [length 004a], ServerHello TLS_accept: SSLv3 write server hello A rlm_eap_tls: >>> TLS 1.0 Handshake [length 061f], Certificate TLS_accept: SSLv3 write certificate A rlm_eap_tls: >>> TLS 1.0 Handshake [length 018d], ServerKeyExchange TLS_accept: SSLv3 write key exchange A rlm_eap_tls: >>> TLS 1.0 Handshake [length 0004], ServerHelloDone TLS_accept: SSLv3 write server done A TLS_accept: SSLv3 flush data TLS_accept:error in SSLv3 read client certificate A In SSL Handshake Phase In SSL Accept mode eaptls_process returned 13 modcall[authenticate]: module "eap" returns handled for request 1 modcall: group authenticate returns handled for request 1 Sending Access-Challenge of id 118 to 192.168.5.199:1033 EAP-Message = 0x0102040a15c00000080e160301004a0200004603014910233f1ee159980b69048aca96d0978db0913de51d3b5d985eb1fcf3f69f202094ae535bab6cf18cddce27725fe4763de3a48c2a12a46a79ae451fe0fc8630e6001600160301061f0b00061b00061800029c3082029830820201a003020102020900cf80303d0f4968bf300d06092a864886f70d0101040500308183310b300906035504061302494e310c300a06035504081303474f41310e300c060355040713055645524e4131143012060355040a130b444c494e4b20494e444941310c300a060355040b14035226443111300f060355040314085241445f524f4f54311f301d06092a8648 EAP-Message = 0x86f70d0109011610524f4f5440444c494e4b2e434f2e494e301e170d3038313031363036353635315a170d3039313031363036353635315a307f310b300906035504061302494e310c300a06035504081303474f41310e300c060355040713055645524e4131143012060355040a130b444c494e4b20494e444941310c300a060355040b14035226443110300e060355040314075241445f535256311c301a06092a864886f70d010901160d53525640444c494e4b2e434f4d30819f300d06092a864886f70d010101050003818d0030818902818100a42c3cd922ee28c0869bb8b3160a5969494f09203d1ba206645547ab99ab3ef46dbbb0b8038636 EAP-Message = 0x1e63d06e5d8f1f8fec4c2ad43ca48a8e459a22af913fe3777aa229805d41b1a6e992cb4a6b6220bd83bac7175e718edc454f2f33b80099d6890876a01301b3859d8a24895747fae1d2a649dce9b7a7c374371e32bde2f5a6f30203010001a317301530130603551d25040c300a06082b06010505070301300d06092a864886f70d0101040500038181009a909a01310b112f397aa706d0c52a2e000d2435befc0ef2eca0f2288ae0adeca6779c456061d141ef27192cc2c7c33bb87b2f837448069ccca631c219315bfa82aaf193ff144cbadf140fd2808495a2e0413db815ab6c7ac545a0dc7f75020787f3f96dc843b8db47150b49f23eac5d02d144 EAP-Message = 0x5b1c151c38b1d6fc7d2edfd0f500037630820372308202dba003020102020900cf80303d0f4968bd300d06092a864886f70d0101040500308183310b300906035504061302494e310c300a06035504081303474f41310e300c060355040713055645524e4131143012060355040a130b444c494e4b20494e444941310c300a060355040b14035226443111300f060355040314085241445f524f4f54311f301d06092a864886f70d0109011610524f4f5440444c494e4b2e434f2e494e301e170d3038313031363036353532385a170d3130313031363036353532385a308183310b300906035504061302494e310c300a06035504081303474f41310e EAP-Message = 0x300c060355040713055645524e413114301206035504 Message-Authenticator = 0x00000000000000000000000000000000 State = 0x402b71cac47205f2f557c9d88933efb3 Finished request 1 Going to the next request Waking up in 6 seconds... rad_recv: Access-Request packet from host 192.168.5.199:1033, id=119, length=185 User-Name = "anonymous" NAS-IP-Address = 192.168.5.199 NAS-Identifier = "test.5gwireless.com" NAS-Port = 0 Called-Station-Id = "00-0B-6B-87-01-BD:test" Calling-Station-Id = "00-1C-F0-9B-64-E5" Framed-MTU = 1400 NAS-Port-Type = Wireless-802.11 Connect-Info = "CONNECT 0Mbps 802.11" EAP-Message = 0x020200061500 State = 0x402b71cac47205f2f557c9d88933efb3 Message-Authenticator = 0x3764d8421e5573524c1c8952c8ce9401 Processing the authorize section of radiusd.conf modcall: entering group authorize for request 2 modcall[authorize]: module "preprocess" returns ok for request 2 modcall[authorize]: module "chap" returns noop for request 2 modcall[authorize]: module "mschap" returns noop for request 2 rlm_realm: No '@' in User-Name = "anonymous", looking up realm NULL rlm_realm: No such realm "NULL" modcall[authorize]: module "suffix" returns noop for request 2 rlm_eap: EAP packet type response id 2 length 6 rlm_eap: No EAP Start, assuming it's an on-going EAP conversation modcall[authorize]: module "eap" returns updated for request 2 modcall[authorize]: module "files" returns notfound for request 2 modcall: group authorize returns updated for request 2 rad_check_password: Found Auth-Type EAP auth: type "EAP" Processing the authenticate section of radiusd.conf modcall: entering group authenticate for request 2 rlm_eap: Request found, released from the list rlm_eap: EAP/ttls rlm_eap: processing type ttls rlm_eap_ttls: Authenticate rlm_eap_tls: processing TLS rlm_eap_tls: Received EAP-TLS ACK message rlm_eap_tls: ack handshake fragment handler eaptls_verify returned 1 eaptls_process returned 13 modcall[authenticate]: module "eap" returns handled for request 2 modcall: group authenticate returns handled for request 2 Sending Access-Challenge of id 119 to 192.168.5.199:1033 EAP-Message = 0x0103040a15c00000080e0a130b444c494e4b20494e444941310c300a060355040b14035226443111300f060355040314085241445f524f4f54311f301d06092a864886f70d0109011610524f4f5440444c494e4b2e434f2e494e30819f300d06092a864886f70d010101050003818d0030818902818100c7a47b5b2603a435ab59ba5025a5e2228fdab0d1598d4a818b188e0991876be04bd8d3aa03f7becdfa6914beb4da66d50b2af5b568e60b3741dd3bd6732cacf3f0e13db439cfbeb36635a03be6d398a0961088e331ab519e3f680ae24b1ab1f95026afbc1cc817a22d576ab5c7bfca92deed85cf8054a1dbf041c1c7c6d116bf0203010001a3 EAP-Message = 0x81eb3081e8301d0603551d0e04160414e82a29d7bf9f35a225f41b014e10684155d45de43081b80603551d230481b03081ad8014e82a29d7bf9f35a225f41b014e10684155d45de4a18189a48186308183310b300906035504061302494e310c300a06035504081303474f41310e300c060355040713055645524e4131143012060355040a130b444c494e4b20494e444941310c300a060355040b14035226443111300f060355040314085241445f524f4f54311f301d06092a864886f70d0109011610524f4f5440444c494e4b2e434f2e494e820900cf80303d0f4968bd300c0603551d13040530030101ff300d06092a864886f70d010104050003 EAP-Message = 0x8181004d863175b4cd34aef8e7aacd9b97edc1053ed724c4f33953c0b57ed1e1ee1d9af30bb3c61eb15c3dc0744eae537e0de3161f3b3f2c97aa95d8d250d40b14d6609aadf6a4a6204db4c4bd09ab5f9294051015b95e578583d365ce789f2871b3c4ea3f2d21eb6ea276656799fec52c57a14ecb374f5845478a7957bdae1f813782160301018d0c0001890080cce90a2d39fd76c0222648cf9e79db8680d46c371bd3fdc827efbc04f8f76b908615e2622404fe324fdc4ca458f6eed1c6fee585f745eb1b2098b107e2cb67a35d1d4e4dc72b293a4007cdcafc26dfeec2adbb93de7ce0df180128224adca89ace4ecff76ade06107e9475dabba84d EAP-Message = 0xb663d9755c971d23d7567942f64bf49f73000102008048b82ef9c2c1404894756b01467fc0114576b9ada32a0cb8459705a45f14638984d2bc171380629ada63df3cd392545ef4cf220d3a20b2d8382ba1c068b3fdec3509dda1acdb27d377a15a76d3c22c758ecfa374901b9900995e2ccab200eac49f654766ecac35fd871997ed4275ebb0a457c8ff1a4a8b4ad4706a14339b0a3800800895fd0938a821f1f70ed31100662f42670b25de96361d69e5f4ca5495c85ceb4f852a3a07c8a7c0c3485689a4818e1d110f26f7b478beec1ac646280fe65ac70b805812701de900039f3e012a45d8df76ca011aeeac7eac461296154084e2b4d18a576c0b EAP-Message = 0xad3933589e27c426f007556e36e5b1132a4ca3393ee1 Message-Authenticator = 0x00000000000000000000000000000000 State = 0xf2eb37ea604e264c8d3b9bca46a5edd8 Finished request 2 Going to the next request Waking up in 6 seconds... rad_recv: Access-Request packet from host 192.168.5.199:1033, id=120, length=185 User-Name = "anonymous" NAS-IP-Address = 192.168.5.199 NAS-Identifier = "test.5gwireless.com" NAS-Port = 0 Called-Station-Id = "00-0B-6B-87-01-BD:test" Calling-Station-Id = "00-1C-F0-9B-64-E5" Framed-MTU = 1400 NAS-Port-Type = Wireless-802.11 Connect-Info = "CONNECT 0Mbps 802.11" EAP-Message = 0x020300061500 State = 0xf2eb37ea604e264c8d3b9bca46a5edd8 Message-Authenticator = 0x0d4b3e911c450a98de6f2be2bc9a8d92 Processing the authorize section of radiusd.conf modcall: entering group authorize for request 3 modcall[authorize]: module "preprocess" returns ok for request 3 modcall[authorize]: module "chap" returns noop for request 3 modcall[authorize]: module "mschap" returns noop for request 3 rlm_realm: No '@' in User-Name = "anonymous", looking up realm NULL rlm_realm: No such realm "NULL" modcall[authorize]: module "suffix" returns noop for request 3 rlm_eap: EAP packet type response id 3 length 6 rlm_eap: No EAP Start, assuming it's an on-going EAP conversation modcall[authorize]: module "eap" returns updated for request 3 modcall[authorize]: module "files" returns notfound for request 3 modcall: group authorize returns updated for request 3 rad_check_password: Found Auth-Type EAP auth: type "EAP" Processing the authenticate section of radiusd.conf modcall: entering group authenticate for request 3 rlm_eap: Request found, released from the list rlm_eap: EAP/ttls rlm_eap: processing type ttls rlm_eap_ttls: Authenticate rlm_eap_tls: processing TLS rlm_eap_tls: Received EAP-TLS ACK message rlm_eap_tls: ack handshake fragment handler eaptls_verify returned 1 eaptls_process returned 13 modcall[authenticate]: module "eap" returns handled for request 3 modcall: group authenticate returns handled for request 3 Sending Access-Challenge of id 120 to 192.168.5.199:1033 EAP-Message = 0x0104001815800000080e27100b9ad016030100040e000000 Message-Authenticator = 0x00000000000000000000000000000000 State = 0x5483f2f0475569a2beacfe02855fb1f6 Finished request 3 Going to the next request Waking up in 6 seconds... rad_recv: Access-Request packet from host 192.168.5.199:1033, id=121, length=379 User-Name = "anonymous" NAS-IP-Address = 192.168.5.199 NAS-Identifier = "test.5gwireless.com" NAS-Port = 0 Called-Station-Id = "00-0B-6B-87-01-BD:test" Calling-Station-Id = "00-1C-F0-9B-64-E5" Framed-MTU = 1400 NAS-Port-Type = Wireless-802.11 Connect-Info = "CONNECT 0Mbps 802.11" EAP-Message = 0x020400c81580000000be16030100861000008200803f56f274bb83e02682c56eab37a66acb52aa2e4649feaf79aa450c68b2fb44eaadafd281238a02d82ef98f8a82af5fd912254e47259937102d926f1d1c57eda88bb31d8a847a62c7b7f79077121a59a803baf7cf6a5c5e7f965f0445b4368e828024aac0a7398aaed30a110d704355502948065f9f371d6cd9959a788f7da3121403010001011603010028fa6c001612e9fd3e702cab877723df8dcbce67589e28df065806d9652167e4daff5d36f319556fe6 State = 0x5483f2f0475569a2beacfe02855fb1f6 Message-Authenticator = 0x6af3735a67096686bff543b884f3b3ba Processing the authorize section of radiusd.conf modcall: entering group authorize for request 4 modcall[authorize]: module "preprocess" returns ok for request 4 modcall[authorize]: module "chap" returns noop for request 4 modcall[authorize]: module "mschap" returns noop for request 4 rlm_realm: No '@' in User-Name = "anonymous", looking up realm NULL rlm_realm: No such realm "NULL" modcall[authorize]: module "suffix" returns noop for request 4 rlm_eap: EAP packet type response id 4 length 200 rlm_eap: No EAP Start, assuming it's an on-going EAP conversation modcall[authorize]: module "eap" returns updated for request 4 modcall[authorize]: module "files" returns notfound for request 4 modcall: group authorize returns updated for request 4 rad_check_password: Found Auth-Type EAP auth: type "EAP" Processing the authenticate section of radiusd.conf modcall: entering group authenticate for request 4 rlm_eap: Request found, released from the list rlm_eap: EAP/ttls rlm_eap: processing type ttls rlm_eap_ttls: Authenticate rlm_eap_tls: processing TLS rlm_eap_tls: Length Included eaptls_verify returned 11 rlm_eap_tls: <<< TLS 1.0 Handshake [length 0086], ClientKeyExchange TLS_accept: SSLv3 read client key exchange A rlm_eap_tls: <<< TLS 1.0 ChangeCipherSpec [length 0001] rlm_eap_tls: <<< TLS 1.0 Handshake [length 0010], Finished TLS_accept: SSLv3 read finished A rlm_eap_tls: >>> TLS 1.0 ChangeCipherSpec [length 0001] TLS_accept: SSLv3 write change cipher spec A rlm_eap_tls: >>> TLS 1.0 Handshake [length 0010], Finished TLS_accept: SSLv3 write finished A TLS_accept: SSLv3 flush data (other): SSL negotiation finished successfully SSL Connection Established eaptls_process returned 13 modcall[authenticate]: module "eap" returns handled for request 4 modcall: group authenticate returns handled for request 4 Sending Access-Challenge of id 121 to 192.168.5.199:1033 EAP-Message = 0x0105003d15800000003314030100010116030100286aaf3f2be49219344bf2836115a872714e1335e65a6f7953aee09211f3b0d61963e5bbd387e44a44 Message-Authenticator = 0x00000000000000000000000000000000 State = 0x768aa18fc4673af5beb9b57cbdc44bba Finished request 4 Going to the next request Waking up in 6 seconds... rad_recv: Access-Request packet from host 192.168.5.199:1033, id=122, length=359 User-Name = "anonymous" NAS-IP-Address = 192.168.5.199 NAS-Identifier = "test.5gwireless.com" NAS-Port = 0 Called-Station-Id = "00-0B-6B-87-01-BD:test" Calling-Station-Id = "00-1C-F0-9B-64-E5" Framed-MTU = 1400 NAS-Port-Type = Wireless-802.11 Connect-Info = "CONNECT 0Mbps 802.11" EAP-Message = 0x020500b41580000000aa170301001893fb03acd1bbb447deb39447ea74c5d6991b107cd995bcdc170301008852f811eb0713719832195139bfe1e05a957be7bc679562a54b4b10e326fabb1a8f7877777bcdceb5e476abfe985ce37e8fe3924250c494bb36166463b1d4edd6ffbe967736497e3cbda2fcfa5701a8a40612895e678870ab705df3390366f150f312cad05c03ab3c1a463a1efc677d134381fb1810e96d7f84f8e934bee3d959f3827aea728affb3 State = 0x768aa18fc4673af5beb9b57cbdc44bba Message-Authenticator = 0xac1634ccbe15cac7fb06315d4ace2a26 Processing the authorize section of radiusd.conf modcall: entering group authorize for request 5 modcall[authorize]: module "preprocess" returns ok for request 5 modcall[authorize]: module "chap" returns noop for request 5 modcall[authorize]: module "mschap" returns noop for request 5 rlm_realm: No '@' in User-Name = "anonymous", looking up realm NULL rlm_realm: No such realm "NULL" modcall[authorize]: module "suffix" returns noop for request 5 rlm_eap: EAP packet type response id 5 length 180 rlm_eap: No EAP Start, assuming it's an on-going EAP conversation modcall[authorize]: module "eap" returns updated for request 5 modcall[authorize]: module "files" returns notfound for request 5 modcall: group authorize returns updated for request 5 rad_check_password: Found Auth-Type EAP auth: type "EAP" Processing the authenticate section of radiusd.conf modcall: entering group authenticate for request 5 rlm_eap: Request found, released from the list rlm_eap: EAP/ttls rlm_eap: processing type ttls rlm_eap_ttls: Authenticate rlm_eap_tls: processing TLS rlm_eap_tls: Length Included eaptls_verify returned 11 eaptls_process returned 7 rlm_eap_ttls: Session established. Proceeding to decode tunneled attributes. TTLS: Got tunneled request User-Name = "client" MS-CHAP-Challenge = 0x4383fec770cfcc8049a5f0b0fae3bb64 MS-CHAP2-Response = 0x09002050bac4fe31b6730fc8d15246b74f900000000000000000f18e94217458bf37e7be3f24b579e0dcf5448858c0a14e86 FreeRADIUS-Proxied-To = 127.0.0.1 TTLS: Sending tunneled request User-Name = "client" MS-CHAP-Challenge = 0x4383fec770cfcc8049a5f0b0fae3bb64 MS-CHAP2-Response = 0x09002050bac4fe31b6730fc8d15246b74f900000000000000000f18e94217458bf37e7be3f24b579e0dcf5448858c0a14e86 FreeRADIUS-Proxied-To = 127.0.0.1 Processing the authorize section of radiusd.conf modcall: entering group authorize for request 5 modcall[authorize]: module "preprocess" returns ok for request 5 modcall[authorize]: module "chap" returns noop for request 5 rlm_mschap: Found MS-CHAP attributes. Setting 'Auth-Type = MS-CHAP' modcall[authorize]: module "mschap" returns ok for request 5 rlm_realm: No '@' in User-Name = "client", looking up realm NULL rlm_realm: No such realm "NULL" modcall[authorize]: module "suffix" returns noop for request 5 rlm_eap: No EAP-Message, not doing EAP modcall[authorize]: module "eap" returns noop for request 5 users: Matched entry client at line 106 modcall[authorize]: module "files" returns ok for request 5 modcall: group authorize returns ok for request 5 rad_check_password: Found Auth-Type MS-CHAP auth: type "MS-CHAP" Processing the authenticate section of radiusd.conf modcall: entering group Auth-Type for request 5 rlm_mschap: Told to do MS-CHAPv2 for client with NT-Password rlm_mschap: adding MS-CHAPv2 MPPE keys modcall[authenticate]: module "mschap" returns ok for request 5 modcall: group Auth-Type returns ok for request 5 TTLS: Got tunneled reply RADIUS code 2 MS-CHAP2-Success = 0x09533d41423034464633353336323332453337374645383935334343463837453539453530394532464641 MS-MPPE-Recv-Key = 0xabad370a2cb787b62d7b09aa9dd0719e MS-MPPE-Send-Key = 0xedee75d120756a4aab4310492971d778 MS-MPPE-Encryption-Policy = 0x00000002 MS-MPPE-Encryption-Types = 0x00000004 TTLS: Got tunneled Access-Accept rlm_eap: Freeing handler modcall[authenticate]: module "eap" returns ok for request 5 modcall: group authenticate returns ok for request 5 Sending Access-Accept of id 122 to 192.168.5.199:1033 MS-MPPE-Recv-Key = 0xda41fa8f3edfd04f4dcc0cdd294195eac1927f8e67ea21304df1f5fdc8dd0cdf MS-MPPE-Send-Key = 0x45ab6422a451bb424a0bd9fb6345fcf22ea81337376d6d03f2bf5336c52836f6 EAP-Message = 0x03050004 Message-Authenticator = 0x00000000000000000000000000000000 User-Name = "anonymous" Finished request 5 Going to the next request Waking up in 6 seconds... --- Walking the entire request list --- Cleaning up request 0 ID 117 with timestamp 4910233f Cleaning up request 1 ID 118 with timestamp 4910233f Cleaning up request 2 ID 119 with timestamp 4910233f Cleaning up request 3 ID 120 with timestamp 4910233f Cleaning up request 4 ID 121 with timestamp 4910233f Cleaning up request 5 ID 122 with timestamp 4910233f Nothing to do. Sleeping until we see a request. rad_recv: Access-Request packet from host 192.168.5.199:1033, id=123, length=175 User-Name = "anonymous" NAS-IP-Address = 192.168.5.199 NAS-Identifier = "test.5gwireless.com" NAS-Port = 0 Called-Station-Id = "00-0B-6B-87-01-BD:test" Calling-Station-Id = "00-1C-F0-9B-64-E5" Framed-MTU = 1400 NAS-Port-Type = Wireless-802.11 Connect-Info = "CONNECT 0Mbps 802.11" EAP-Message = 0x0200000e01616e6f6e796d6f7573 Message-Authenticator = 0x6b65f3cdbf96f470c6a234fbbefe5e4c Processing the authorize section of radiusd.conf modcall: entering group authorize for request 6 modcall[authorize]: module "preprocess" returns ok for request 6 modcall[authorize]: module "chap" returns noop for request 6 modcall[authorize]: module "mschap" returns noop for request 6 rlm_realm: No '@' in User-Name = "anonymous", looking up realm NULL rlm_realm: No such realm "NULL" modcall[authorize]: module "suffix" returns noop for request 6 rlm_eap: EAP packet type response id 0 length 14 rlm_eap: No EAP Start, assuming it's an on-going EAP conversation modcall[authorize]: module "eap" returns updated for request 6 modcall[authorize]: module "files" returns notfound for request 6 modcall: group authorize returns updated for request 6 rad_check_password: Found Auth-Type EAP auth: type "EAP" Processing the authenticate section of radiusd.conf modcall: entering group authenticate for request 6 rlm_eap: EAP Identity rlm_eap: processing type tls rlm_eap_tls: Initiate rlm_eap_tls: Start returned 1 modcall[authenticate]: module "eap" returns handled for request 6 modcall: group authenticate returns handled for request 6 Sending Access-Challenge of id 123 to 192.168.5.199:1033 EAP-Message = 0x010100061520 Message-Authenticator = 0x00000000000000000000000000000000 State = 0x21153ea0621b62740cfa40ae2a9dc63b Finished request 6 Going to the next request --- Walking the entire request list --- Waking up in 6 seconds... rad_recv: Access-Request packet from host 192.168.5.199:1033, id=124, length=279 User-Name = "anonymous" NAS-IP-Address = 192.168.5.199 NAS-Identifier = "test.5gwireless.com" NAS-Port = 0 Called-Station-Id = "00-0B-6B-87-01-BD:test" Calling-Station-Id = "00-1C-F0-9B-64-E5" Framed-MTU = 1400 NAS-Port-Type = Wireless-802.11 Connect-Info = "CONNECT 0Mbps 802.11" EAP-Message = 0x0201006415800000005a1603010055010000510301491023291bd956938077b3e4a9d48ca1ecda235010ba9be9983bb6a620d4291e00002a00160013006600150012000a0005000400070009006300650060006200610064001400110003000600080100 State = 0x21153ea0621b62740cfa40ae2a9dc63b Message-Authenticator = 0x830c555caee2341988d850c7c261576a Processing the authorize section of radiusd.conf modcall: entering group authorize for request 7 modcall[authorize]: module "preprocess" returns ok for request 7 modcall[authorize]: module "chap" returns noop for request 7 modcall[authorize]: module "mschap" returns noop for request 7 rlm_realm: No '@' in User-Name = "anonymous", looking up realm NULL rlm_realm: No such realm "NULL" modcall[authorize]: module "suffix" returns noop for request 7 rlm_eap: EAP packet type response id 1 length 100 rlm_eap: No EAP Start, assuming it's an on-going EAP conversation modcall[authorize]: module "eap" returns updated for request 7 modcall[authorize]: module "files" returns notfound for request 7 modcall: group authorize returns updated for request 7 rad_check_password: Found Auth-Type EAP auth: type "EAP" Processing the authenticate section of radiusd.conf modcall: entering group authenticate for request 7 rlm_eap: Request found, released from the list rlm_eap: EAP/ttls rlm_eap: processing type ttls rlm_eap_ttls: Authenticate rlm_eap_tls: processing TLS rlm_eap_tls: Length Included eaptls_verify returned 11 (other): before/accept initialization TLS_accept: before/accept initialization rlm_eap_tls: <<< TLS 1.0 Handshake [length 0055], ClientHello TLS_accept: SSLv3 read client hello A rlm_eap_tls: >>> TLS 1.0 Handshake [length 004a], ServerHello TLS_accept: SSLv3 write server hello A rlm_eap_tls: >>> TLS 1.0 Handshake [length 061f], Certificate TLS_accept: SSLv3 write certificate A rlm_eap_tls: >>> TLS 1.0 Handshake [length 018d], ServerKeyExchange TLS_accept: SSLv3 write key exchange A rlm_eap_tls: >>> TLS 1.0 Handshake [length 0004], ServerHelloDone TLS_accept: SSLv3 write server done A TLS_accept: SSLv3 flush data TLS_accept:error in SSLv3 read client certificate A In SSL Handshake Phase In SSL Accept mode eaptls_process returned 13 modcall[authenticate]: module "eap" returns handled for request 7 modcall: group authenticate returns handled for request 7 Sending Access-Challenge of id 124 to 192.168.5.199:1033 EAP-Message = 0x0102040a15c00000080e160301004a02000046030149102347f8fa91cc0d68f9cbc06fdcce1129a89dd5f043dbe4bbeaa6c588b8b0208f6386fd931f18db4d60f7c69db016b124b9b015aee126c7dd231036428117ac001600160301061f0b00061b00061800029c3082029830820201a003020102020900cf80303d0f4968bf300d06092a864886f70d0101040500308183310b300906035504061302494e310c300a06035504081303474f41310e300c060355040713055645524e4131143012060355040a130b444c494e4b20494e444941310c300a060355040b14035226443111300f060355040314085241445f524f4f54311f301d06092a8648 EAP-Message = 0x86f70d0109011610524f4f5440444c494e4b2e434f2e494e301e170d3038313031363036353635315a170d3039313031363036353635315a307f310b300906035504061302494e310c300a06035504081303474f41310e300c060355040713055645524e4131143012060355040a130b444c494e4b20494e444941310c300a060355040b14035226443110300e060355040314075241445f535256311c301a06092a864886f70d010901160d53525640444c494e4b2e434f4d30819f300d06092a864886f70d010101050003818d0030818902818100a42c3cd922ee28c0869bb8b3160a5969494f09203d1ba206645547ab99ab3ef46dbbb0b8038636 EAP-Message = 0x1e63d06e5d8f1f8fec4c2ad43ca48a8e459a22af913fe3777aa229805d41b1a6e992cb4a6b6220bd83bac7175e718edc454f2f33b80099d6890876a01301b3859d8a24895747fae1d2a649dce9b7a7c374371e32bde2f5a6f30203010001a317301530130603551d25040c300a06082b06010505070301300d06092a864886f70d0101040500038181009a909a01310b112f397aa706d0c52a2e000d2435befc0ef2eca0f2288ae0adeca6779c456061d141ef27192cc2c7c33bb87b2f837448069ccca631c219315bfa82aaf193ff144cbadf140fd2808495a2e0413db815ab6c7ac545a0dc7f75020787f3f96dc843b8db47150b49f23eac5d02d144 EAP-Message = 0x5b1c151c38b1d6fc7d2edfd0f500037630820372308202dba003020102020900cf80303d0f4968bd300d06092a864886f70d0101040500308183310b300906035504061302494e310c300a06035504081303474f41310e300c060355040713055645524e4131143012060355040a130b444c494e4b20494e444941310c300a060355040b14035226443111300f060355040314085241445f524f4f54311f301d06092a864886f70d0109011610524f4f5440444c494e4b2e434f2e494e301e170d3038313031363036353532385a170d3130313031363036353532385a308183310b300906035504061302494e310c300a06035504081303474f41310e EAP-Message = 0x300c060355040713055645524e413114301206035504 Message-Authenticator = 0x00000000000000000000000000000000 State = 0x7340a0ad2a41a7bf70ca8d64795fe1b2 Finished request 7 Going to the next request Waking up in 6 seconds... rad_recv: Access-Request packet from host 192.168.5.199:1033, id=125, length=185 User-Name = "anonymous" NAS-IP-Address = 192.168.5.199 NAS-Identifier = "test.5gwireless.com" NAS-Port = 0 Called-Station-Id = "00-0B-6B-87-01-BD:test" Calling-Station-Id = "00-1C-F0-9B-64-E5" Framed-MTU = 1400 NAS-Port-Type = Wireless-802.11 Connect-Info = "CONNECT 0Mbps 802.11" EAP-Message = 0x020200061500 State = 0x7340a0ad2a41a7bf70ca8d64795fe1b2 Message-Authenticator = 0x08d6a344f78d420d406431f750ba9a57 Processing the authorize section of radiusd.conf modcall: entering group authorize for request 8 modcall[authorize]: module "preprocess" returns ok for request 8 modcall[authorize]: module "chap" returns noop for request 8 modcall[authorize]: module "mschap" returns noop for request 8 rlm_realm: No '@' in User-Name = "anonymous", looking up realm NULL rlm_realm: No such realm "NULL" modcall[authorize]: module "suffix" returns noop for request 8 rlm_eap: EAP packet type response id 2 length 6 rlm_eap: No EAP Start, assuming it's an on-going EAP conversation modcall[authorize]: module "eap" returns updated for request 8 modcall[authorize]: module "files" returns notfound for request 8 modcall: group authorize returns updated for request 8 rad_check_password: Found Auth-Type EAP auth: type "EAP" Processing the authenticate section of radiusd.conf modcall: entering group authenticate for request 8 rlm_eap: Request found, released from the list rlm_eap: EAP/ttls rlm_eap: processing type ttls rlm_eap_ttls: Authenticate rlm_eap_tls: processing TLS rlm_eap_tls: Received EAP-TLS ACK message rlm_eap_tls: ack handshake fragment handler eaptls_verify returned 1 eaptls_process returned 13 modcall[authenticate]: module "eap" returns handled for request 8 modcall: group authenticate returns handled for request 8 Sending Access-Challenge of id 125 to 192.168.5.199:1033 EAP-Message = 0x0103040a15c00000080e0a130b444c494e4b20494e444941310c300a060355040b14035226443111300f060355040314085241445f524f4f54311f301d06092a864886f70d0109011610524f4f5440444c494e4b2e434f2e494e30819f300d06092a864886f70d010101050003818d0030818902818100c7a47b5b2603a435ab59ba5025a5e2228fdab0d1598d4a818b188e0991876be04bd8d3aa03f7becdfa6914beb4da66d50b2af5b568e60b3741dd3bd6732cacf3f0e13db439cfbeb36635a03be6d398a0961088e331ab519e3f680ae24b1ab1f95026afbc1cc817a22d576ab5c7bfca92deed85cf8054a1dbf041c1c7c6d116bf0203010001a3 EAP-Message = 0x81eb3081e8301d0603551d0e04160414e82a29d7bf9f35a225f41b014e10684155d45de43081b80603551d230481b03081ad8014e82a29d7bf9f35a225f41b014e10684155d45de4a18189a48186308183310b300906035504061302494e310c300a06035504081303474f41310e300c060355040713055645524e4131143012060355040a130b444c494e4b20494e444941310c300a060355040b14035226443111300f060355040314085241445f524f4f54311f301d06092a864886f70d0109011610524f4f5440444c494e4b2e434f2e494e820900cf80303d0f4968bd300c0603551d13040530030101ff300d06092a864886f70d010104050003 EAP-Message = 0x8181004d863175b4cd34aef8e7aacd9b97edc1053ed724c4f33953c0b57ed1e1ee1d9af30bb3c61eb15c3dc0744eae537e0de3161f3b3f2c97aa95d8d250d40b14d6609aadf6a4a6204db4c4bd09ab5f9294051015b95e578583d365ce789f2871b3c4ea3f2d21eb6ea276656799fec52c57a14ecb374f5845478a7957bdae1f813782160301018d0c0001890080cce90a2d39fd76c0222648cf9e79db8680d46c371bd3fdc827efbc04f8f76b908615e2622404fe324fdc4ca458f6eed1c6fee585f745eb1b2098b107e2cb67a35d1d4e4dc72b293a4007cdcafc26dfeec2adbb93de7ce0df180128224adca89ace4ecff76ade06107e9475dabba84d EAP-Message = 0xb663d9755c971d23d7567942f64bf49f730001020080a87b678bcd251384ef65cffe65d9c67dc7367580110d0b7ca8da264d140fe0c5874dc6609f7949192ebe74de43ca3ea7103cbb4d536fbc472c583960d7b250a5320de2b8b2f37273e4bc55004993f217c1d2c89bc30bb7a9232cf92e71bd5ac6955ec0227f24e25416b55f78842f08a53d963935c40804212d0d0db7f2daba82008060eda549dc425ba93517fdf74b36f1245d96db60d6dfcbe8000493bb4f4d069dade53de2afcccc8b47f0d7e6d59cb10863ee058bcc7788bc4380c33f49ae538d18f8820046308bfeccafaf63b71ac9d5fcb4cbee6632f2ac5673c26a2fe3ccc2a3db2e64b7 EAP-Message = 0x9b6fa96a45457987896afd0cde0cb59061547581c200 Message-Authenticator = 0x00000000000000000000000000000000 State = 0x65817e7cdcb6996469c858ca6fec316c Finished request 8 Going to the next request Waking up in 6 seconds... rad_recv: Access-Request packet from host 192.168.5.199:1033, id=126, length=185 User-Name = "anonymous" NAS-IP-Address = 192.168.5.199 NAS-Identifier = "test.5gwireless.com" NAS-Port = 0 Called-Station-Id = "00-0B-6B-87-01-BD:test" Calling-Station-Id = "00-1C-F0-9B-64-E5" Framed-MTU = 1400 NAS-Port-Type = Wireless-802.11 Connect-Info = "CONNECT 0Mbps 802.11" EAP-Message = 0x020300061500 State = 0x65817e7cdcb6996469c858ca6fec316c Message-Authenticator = 0x0bde8b4e79a7bc4fbc23b862354a31c5 Processing the authorize section of radiusd.conf modcall: entering group authorize for request 9 modcall[authorize]: module "preprocess" returns ok for request 9 modcall[authorize]: module "chap" returns noop for request 9 modcall[authorize]: module "mschap" returns noop for request 9 rlm_realm: No '@' in User-Name = "anonymous", looking up realm NULL rlm_realm: No such realm "NULL" modcall[authorize]: module "suffix" returns noop for request 9 rlm_eap: EAP packet type response id 3 length 6 rlm_eap: No EAP Start, assuming it's an on-going EAP conversation modcall[authorize]: module "eap" returns updated for request 9 modcall[authorize]: module "files" returns notfound for request 9 modcall: group authorize returns updated for request 9 rad_check_password: Found Auth-Type EAP auth: type "EAP" Processing the authenticate section of radiusd.conf modcall: entering group authenticate for request 9 rlm_eap: Request found, released from the list rlm_eap: EAP/ttls rlm_eap: processing type ttls rlm_eap_ttls: Authenticate rlm_eap_tls: processing TLS rlm_eap_tls: Received EAP-TLS ACK message rlm_eap_tls: ack handshake fragment handler eaptls_verify returned 1 eaptls_process returned 13 modcall[authenticate]: module "eap" returns handled for request 9 modcall: group authenticate returns handled for request 9 Sending Access-Challenge of id 126 to 192.168.5.199:1033 EAP-Message = 0x0104001815800000080e08b86319a216030100040e000000 Message-Authenticator = 0x00000000000000000000000000000000 State = 0xa81208c637bb1e5f7055011a56d545fc Finished request 9 Going to the next request Waking up in 6 seconds... rad_recv: Access-Request packet from host 192.168.5.199:1033, id=127, length=379 User-Name = "anonymous" NAS-IP-Address = 192.168.5.199 NAS-Identifier = "test.5gwireless.com" NAS-Port = 0 Called-Station-Id = "00-0B-6B-87-01-BD:test" Calling-Station-Id = "00-1C-F0-9B-64-E5" Framed-MTU = 1400 NAS-Port-Type = Wireless-802.11 Connect-Info = "CONNECT 0Mbps 802.11" EAP-Message = 0x020400c81580000000be160301008610000082008056f9e44ef0c314185c64c78567969dbfc895c68826ef3ab0513fd8bb75a7e6f9773a8b697e630b9b124ce89fdd55e38882d76509979d33d4cad930145bd6929bd3b860dede6ba3adbfc4ec9297946b2360ddda4e3ca305a605844a62e94d72a3d7d5c8a5fdbd839e48586ef66a68587d187b1b4523c725085739812071f6bc5314030100010116030100282a77da10a848095bedb30c1f807e50a4216a5ceb452d9437db5888b5068dd9493f5aa7ef313a9a5b State = 0xa81208c637bb1e5f7055011a56d545fc Message-Authenticator = 0xe06dcc72f5d47addf1da5a13d9dcf4e2 Processing the authorize section of radiusd.conf modcall: entering group authorize for request 10 modcall[authorize]: module "preprocess" returns ok for request 10 modcall[authorize]: module "chap" returns noop for request 10 modcall[authorize]: module "mschap" returns noop for request 10 rlm_realm: No '@' in User-Name = "anonymous", looking up realm NULL rlm_realm: No such realm "NULL" modcall[authorize]: module "suffix" returns noop for request 10 rlm_eap: EAP packet type response id 4 length 200 rlm_eap: No EAP Start, assuming it's an on-going EAP conversation modcall[authorize]: module "eap" returns updated for request 10 modcall[authorize]: module "files" returns notfound for request 10 modcall: group authorize returns updated for request 10 rad_check_password: Found Auth-Type EAP auth: type "EAP" Processing the authenticate section of radiusd.conf modcall: entering group authenticate for request 10 rlm_eap: Request found, released from the list rlm_eap: EAP/ttls rlm_eap: processing type ttls rlm_eap_ttls: Authenticate rlm_eap_tls: processing TLS rlm_eap_tls: Length Included eaptls_verify returned 11 rlm_eap_tls: <<< TLS 1.0 Handshake [length 0086], ClientKeyExchange TLS_accept: SSLv3 read client key exchange A rlm_eap_tls: <<< TLS 1.0 ChangeCipherSpec [length 0001] rlm_eap_tls: <<< TLS 1.0 Handshake [length 0010], Finished TLS_accept: SSLv3 read finished A rlm_eap_tls: >>> TLS 1.0 ChangeCipherSpec [length 0001] TLS_accept: SSLv3 write change cipher spec A rlm_eap_tls: >>> TLS 1.0 Handshake [length 0010], Finished TLS_accept: SSLv3 write finished A TLS_accept: SSLv3 flush data (other): SSL negotiation finished successfully SSL Connection Established eaptls_process returned 13 modcall[authenticate]: module "eap" returns handled for request 10 modcall: group authenticate returns handled for request 10 Sending Access-Challenge of id 127 to 192.168.5.199:1033 EAP-Message = 0x0105003d158000000033140301000101160301002881e2ffe58f4d9a2827697c227a56b0f8c584467efb57896413235702273df69d25c9949064723c34 Message-Authenticator = 0x00000000000000000000000000000000 State = 0xdeff1648a8d637f4331b05383a2beec3 Finished request 10 Going to the next request Waking up in 6 seconds... rad_recv: Access-Request packet from host 192.168.5.199:1033, id=128, length=359 User-Name = "anonymous" NAS-IP-Address = 192.168.5.199 NAS-Identifier = "test.5gwireless.com" NAS-Port = 0 Called-Station-Id = "00-0B-6B-87-01-BD:test" Calling-Station-Id = "00-1C-F0-9B-64-E5" Framed-MTU = 1400 NAS-Port-Type = Wireless-802.11 Connect-Info = "CONNECT 0Mbps 802.11" EAP-Message = 0x020500b41580000000aa17030100187d86a2a8890c0767eac366081e4f9908e1deae6176df276017030100886a3459b5d043acea53b1355e831c46bb1b29f3c92ef76aca8243c1d257119d032b18b81eeacf189f970fbd062686a5665dd4d7588baecc6d11429a41a4fa117828c725d1753c65e3c1239cedb0505ac53c7902dc812fa7fbfde2bc3cddc8ecbea9acb1467997c90288a34c25a720f0563f35b7d614c9d5b56bfe1a6993ab5e836896bc21b788d8e3 State = 0xdeff1648a8d637f4331b05383a2beec3 Message-Authenticator = 0x6edceb94c58b51894dff871d7bed08fd Processing the authorize section of radiusd.conf modcall: entering group authorize for request 11 modcall[authorize]: module "preprocess" returns ok for request 11 modcall[authorize]: module "chap" returns noop for request 11 modcall[authorize]: module "mschap" returns noop for request 11 rlm_realm: No '@' in User-Name = "anonymous", looking up realm NULL rlm_realm: No such realm "NULL" modcall[authorize]: module "suffix" returns noop for request 11 rlm_eap: EAP packet type response id 5 length 180 rlm_eap: No EAP Start, assuming it's an on-going EAP conversation modcall[authorize]: module "eap" returns updated for request 11 modcall[authorize]: module "files" returns notfound for request 11 modcall: group authorize returns updated for request 11 rad_check_password: Found Auth-Type EAP auth: type "EAP" Processing the authenticate section of radiusd.conf modcall: entering group authenticate for request 11 rlm_eap: Request found, released from the list rlm_eap: EAP/ttls rlm_eap: processing type ttls rlm_eap_ttls: Authenticate rlm_eap_tls: processing TLS rlm_eap_tls: Length Included eaptls_verify returned 11 eaptls_process returned 7 rlm_eap_ttls: Session established. Proceeding to decode tunneled attributes. TTLS: Got tunneled request User-Name = "client" MS-CHAP-Challenge = 0xff5ba9e1e43f7f858645345f390c970b MS-CHAP2-Response = 0x520031969223125927260113fe607f92d8df00000000000000009ad43fee5de8e36c0268d5a9e5ab648443cc783e77626aed FreeRADIUS-Proxied-To = 127.0.0.1 TTLS: Sending tunneled request User-Name = "client" MS-CHAP-Challenge = 0xff5ba9e1e43f7f858645345f390c970b MS-CHAP2-Response = 0x520031969223125927260113fe607f92d8df00000000000000009ad43fee5de8e36c0268d5a9e5ab648443cc783e77626aed FreeRADIUS-Proxied-To = 127.0.0.1 Processing the authorize section of radiusd.conf modcall: entering group authorize for request 11 modcall[authorize]: module "preprocess" returns ok for request 11 modcall[authorize]: module "chap" returns noop for request 11 rlm_mschap: Found MS-CHAP attributes. Setting 'Auth-Type = MS-CHAP' modcall[authorize]: module "mschap" returns ok for request 11 rlm_realm: No '@' in User-Name = "client", looking up realm NULL rlm_realm: No such realm "NULL" modcall[authorize]: module "suffix" returns noop for request 11 rlm_eap: No EAP-Message, not doing EAP modcall[authorize]: module "eap" returns noop for request 11 users: Matched entry client at line 106 modcall[authorize]: module "files" returns ok for request 11 modcall: group authorize returns ok for request 11 rad_check_password: Found Auth-Type MS-CHAP auth: type "MS-CHAP" Processing the authenticate section of radiusd.conf modcall: entering group Auth-Type for request 11 rlm_mschap: Told to do MS-CHAPv2 for client with NT-Password rlm_mschap: adding MS-CHAPv2 MPPE keys modcall[authenticate]: module "mschap" returns ok for request 11 modcall: group Auth-Type returns ok for request 11 TTLS: Got tunneled reply RADIUS code 2 MS-CHAP2-Success = 0x52533d37303346353438463346443230323142364442443338453435343336384533444243393132393034 MS-MPPE-Recv-Key = 0x8574e98ba0416e4818a61c36b8c4e674 MS-MPPE-Send-Key = 0x6c90c312e4007bee0e18353678937c26 MS-MPPE-Encryption-Policy = 0x00000002 MS-MPPE-Encryption-Types = 0x00000004 TTLS: Got tunneled Access-Accept rlm_eap: Freeing handler modcall[authenticate]: module "eap" returns ok for request 11 modcall: group authenticate returns ok for request 11 Sending Access-Accept of id 128 to 192.168.5.199:1033 MS-MPPE-Recv-Key = 0x1c3166a5ac144184d06242bea756adbef7a696dc98522668d12084ca8d9d5a1d MS-MPPE-Send-Key = 0x0cd28527f22aae46443fe1458e1a67a430502cc3e566fffbbc53e0bfd4c3020b EAP-Message = 0x03050004 Message-Authenticator = 0x00000000000000000000000000000000 User-Name = "anonymous" Finished request 11 Going to the next request Waking up in 6 seconds... --- Walking the entire request list --- Cleaning up request 6 ID 123 with timestamp 49102347 Cleaning up request 7 ID 124 with timestamp 49102347 Cleaning up request 8 ID 125 with timestamp 49102347 Cleaning up request 9 ID 126 with timestamp 49102347 Cleaning up request 10 ID 127 with timestamp 49102347 Cleaning up request 11 ID 128 with timestamp 49102347 Nothing to do. Sleeping until we see a request. rad_recv: Access-Request packet from host 192.168.5.199:1033, id=129, length=175 User-Name = "anonymous" NAS-IP-Address = 192.168.5.199 NAS-Identifier = "test.5gwireless.com" NAS-Port = 0 Called-Station-Id = "00-0B-6B-87-01-BD:test" Calling-Station-Id = "00-1C-F0-9B-64-E5" Framed-MTU = 1400 NAS-Port-Type = Wireless-802.11 Connect-Info = "CONNECT 0Mbps 802.11" EAP-Message = 0x0200000e01616e6f6e796d6f7573 Message-Authenticator = 0xbbef2d8944f34c5f6d46f004c8f5b793 Processing the authorize section of radiusd.conf modcall: entering group authorize for request 12 modcall[authorize]: module "preprocess" returns ok for request 12 modcall[authorize]: module "chap" returns noop for request 12 modcall[authorize]: module "mschap" returns noop for request 12 rlm_realm: No '@' in User-Name = "anonymous", looking up realm NULL rlm_realm: No such realm "NULL" modcall[authorize]: module "suffix" returns noop for request 12 rlm_eap: EAP packet type response id 0 length 14 rlm_eap: No EAP Start, assuming it's an on-going EAP conversation modcall[authorize]: module "eap" returns updated for request 12 modcall[authorize]: module "files" returns notfound for request 12 modcall: group authorize returns updated for request 12 rad_check_password: Found Auth-Type EAP auth: type "EAP" Processing the authenticate section of radiusd.conf modcall: entering group authenticate for request 12 rlm_eap: EAP Identity rlm_eap: processing type tls rlm_eap_tls: Initiate rlm_eap_tls: Start returned 1 modcall[authenticate]: module "eap" returns handled for request 12 modcall: group authenticate returns handled for request 12 Sending Access-Challenge of id 129 to 192.168.5.199:1033 EAP-Message = 0x010100061520 Message-Authenticator = 0x00000000000000000000000000000000 State = 0xa973ca8f7be1ad5f571f17ea65d1d2aa Finished request 12