Logging display requested on 2024/04/08 14:14:44 (GMT) for Hostname: [WLC-9800-1], Model: [C9800-40-K9 ], Version: [17.09.04a], SN: [JAE271205BQ], MD_SN: [TTM2702016S] 2024/04/08 14:12:49.984678393 {wncd_x_R0-0}{1}: [client-orch-sm] [15195]: (note): MAC: 9cfc.e8dc.d41c Association received. BSSID c828.e5a4.ce4f, WLAN , Slot 1 AP c828.e5a4.ce40, 2024/04/08 14:12:49.984740487 {wncd_x_R0-0}{1}: [client-orch-sm] [15195]: (debug): MAC: 9cfc.e8dc.d41c Received Dot11 association request. Processing started,SSID: , Policy profile: FLEX, AP Name: , Ap Mac Address: c828.e5a4.ce40BSSID MAC0000.0000.0000wlan ID: 17RSSI: -42, SNR: 35 2024/04/08 14:12:49.984889854 {wncd_x_R0-0}{1}: [client-orch-state] [15195]: (note): MAC: 9cfc.e8dc.d41c Client state transition: S_CO_INIT -> S_CO_ASSOCIATING 2024/04/08 14:12:49.985108717 {wncd_x_R0-0}{1}: [dot11-validate] [15195]: (info): MAC: 9cfc.e8dc.d41c Dot11 ie validate ext/supp rates. Validation Passed for Supported rates radio_type 2 2024/04/08 14:12:49.985112607 {wncd_x_R0-0}{1}: [dot11-validate] [15195]: (info): MAC: 9cfc.e8dc.d41c WiFi direct: Dot11 validate P2P IE. P2P IE not present. 2024/04/08 14:12:49.985269245 {wncd_x_R0-0}{1}: [dot11] [15195]: (debug): MAC: 9cfc.e8dc.d41c dot11 send association response. Framing association response with resp_status_code: 0 2024/04/08 14:12:49.985270071 {wncd_x_R0-0}{1}: [dot11] [15195]: (info): MAC: 9cfc.e8dc.d41c Dot11 capability privacy bit set TRUE 2024/04/08 14:12:49.985274245 {wncd_x_R0-0}{1}: [dot11] [15195]: (debug): MAC: 9cfc.e8dc.d41c Dot11 Capability info byte1 11, byte2: 11 2024/04/08 14:12:49.985304677 {wncd_x_R0-0}{1}: [dot11-frame] [15195]: (info): MAC: 9cfc.e8dc.d41c WiFi direct: skip build Assoc Resp with P2P IE: Wifi direct policy disabled 2024/04/08 14:12:49.985424340 {wncd_x_R0-0}{1}: [dot11] [15195]: (info): MAC: 9cfc.e8dc.d41c dot11 send association response. Sending assoc response of length: 176 with resp_status_code: 0, DOT11_STATUS: DOT11_STATUS_SUCCESS 2024/04/08 14:12:49.985430820 {wncd_x_R0-0}{1}: [dot11] [15195]: (note): MAC: 9cfc.e8dc.d41c Association success. AID 1, Roaming = False, WGB = False, 11r = False, 11w = False Fast roam = False 2024/04/08 14:12:49.985455334 {wncd_x_R0-0}{1}: [dot11] [15195]: (info): MAC: 9cfc.e8dc.d41c DOT11 state transition: S_DOT11_INIT -> S_DOT11_ASSOCIATED 2024/04/08 14:12:49.985518830 {wncd_x_R0-0}{1}: [client-orch-sm] [15195]: (debug): MAC: 9cfc.e8dc.d41c Station Dot11 association is successful. 2024/04/08 14:12:49.985581466 {wncd_x_R0-0}{1}: [client-orch-sm] [15195]: (debug): MAC: 9cfc.e8dc.d41c Starting L2 authentication. Bssid in state machine:c828.e5a4.ce4f Bssid in request is:c828.e5a4.ce4f 2024/04/08 14:12:49.985604314 {wncd_x_R0-0}{1}: [client-orch-state] [15195]: (note): MAC: 9cfc.e8dc.d41c Client state transition: S_CO_ASSOCIATING -> S_CO_L2_AUTH_IN_PROGRESS 2024/04/08 14:12:49.985676591 {wncd_x_R0-0}{1}: [ewlc-qos-client] [15195]: (info): MAC: 9cfc.e8dc.d41c Client QoS add mobile cb 2024/04/08 14:12:49.985816745 {wncd_x_R0-0}{1}: [ewlc-qos-client] [15195]: (info): MAC: 9cfc.e8dc.d41c Failed to install QoS client policy in process add mobile callback: AP Mac: C8:28:E5:A4:CE:40 slotId=1, wlan_id=17 2024/04/08 14:12:49.985853855 {wncd_x_R0-0}{1}: [client-auth] [15195]: (note): MAC: 9cfc.e8dc.d41c ADD MOBILE sent. Client state flags: 0x1 BSSID: MAC: c828.e5a4.ce4f capwap IFID: 0x90000005, Add mobiles sent: 1 2024/04/08 14:12:49.985877703 {wncd_x_R0-0}{1}: [client-auth] [15195]: (info): MAC: 9cfc.e8dc.d41c Client auth-interface state transition: S_AUTHIF_INIT -> S_AUTHIF_ADD_MOBILE_ACK_WAIT_DOT1X 2024/04/08 14:12:49.990117126 {wncd_x_R0-0}{1}: [auth-mgr] [15195]: (info): [9cfc.e8dc.d41c:capwap_90000005] Session Start event called from SANET-SHIM, vlan: 0 2024/04/08 14:12:49.990132420 {wncd_x_R0-0}{1}: [auth-mgr] [15195]: (info): [9cfc.e8dc.d41c:capwap_90000005] Wireless session sequence, create context with method Dot1X 2024/04/08 14:12:49.990137744 {wncd_x_R0-0}{1}: [auth-mgr-feat_wireless] [15195]: (info): Wireless dot1x configs: EAPID req max retries = 2 EAP req max retries = 2 EAPID req timeout = 30 Supp Timeout = 30 2024/04/08 14:12:49.990170527 {wncd_x_R0-0}{1}: [auth-mgr-feat_wireless] [15195]: (info): [9cfc.e8dc.d41c:capwap_90000005] - authc_list: ISE-TST-Auth 2024/04/08 14:12:49.990172321 {wncd_x_R0-0}{1}: [auth-mgr-feat_wireless] [15195]: (info): [9cfc.e8dc.d41c:capwap_90000005] - authz_list: Not present under wlan configuration 2024/04/08 14:12:49.990200481 {wncd_x_R0-0}{1}: [client-auth] [15195]: (note): MAC: 9cfc.e8dc.d41c L2 Authentication initiated. method DOT1X, Policy VLAN 0, AAA override = 0 , NAC = 0 2024/04/08 14:12:49.990211479 {wncd_x_R0-0}{1}: [client-auth] [15195]: (info): MAC: 9cfc.e8dc.d41c Client auth-interface state transition: S_AUTHIF_ADD_MOBILE_ACK_WAIT_DOT1X -> S_AUTHIF_AWAIT_DOT1XAUTH_START_RESP 2024/04/08 14:12:49.990325143 {wncd_x_R0-0}{1}: [auth-mgr] [15195]: (info): [9cfc.e8dc.d41c:unknown] auth mgr attr add/change notification is received for attr iif-id(952) 2024/04/08 14:12:49.990377383 {wncd_x_R0-0}{1}: [auth-mgr] [15195]: (info): [9cfc.e8dc.d41c:capwap_90000005] auth mgr attr add/change notification is received for attr swbidb(1263) 2024/04/08 14:12:49.990403443 {wncd_x_R0-0}{1}: [auth-mgr] [15195]: (info): [9cfc.e8dc.d41c:capwap_90000005] auth mgr attr add/change notification is received for attr aaa-unique-id(220) 2024/04/08 14:12:49.990423934 {wncd_x_R0-0}{1}: [auth-mgr] [15195]: (info): [9cfc.e8dc.d41c:capwap_90000005] auth mgr attr add/change notification is received for attr iif-id(952) 2024/04/08 14:12:49.990441692 {wncd_x_R0-0}{1}: [auth-mgr] [15195]: (info): [9cfc.e8dc.d41c:capwap_90000005] Retrieved Client IIF ID 0x47000355 2024/04/08 14:12:49.990471894 {wncd_x_R0-0}{1}: [auth-mgr] [15195]: (info): [9cfc.e8dc.d41c:capwap_90000005] auth mgr attr add/change notification is received for attr audit-session-id(819) 2024/04/08 14:12:49.990480274 {wncd_x_R0-0}{1}: [auth-mgr] [15195]: (info): [9cfc.e8dc.d41c:capwap_90000005] Allocated audit session id 0A13620A00000018BF578DC7 2024/04/08 14:12:49.990782325 {wncd_x_R0-0}{1}: [auth-mgr] [15195]: (info): [9cfc.e8dc.d41c:capwap_90000005] Device type found in cache Intel-Device 2024/04/08 14:12:49.990791173 {wncd_x_R0-0}{1}: [auth-mgr] [15195]: (info): [9cfc.e8dc.d41c:capwap_90000005] Device type for the session is detected as Intel-Device and old device-type not classified earlier & Device name for the session is detected as INTEL CORPORATE and old device-name not classified earlier & Old protocol map 0 and new is 1 2024/04/08 14:12:49.990890517 {wncd_x_R0-0}{1}: [mm-client] [15195]: (debug): MAC: 0000.0000.0000 Sending device_cache_update of XID (0) to (MobilityD[0]) 2024/04/08 14:12:49.990973504 {wncd_x_R0-0}{1}: [svm] [15195]: (info): SVM_INFO: Applying Svc Templ wlan_svc_FLEX (ML:NONE) 2024/04/08 14:12:49.990981638 {mobilityd_R0-0}{1}: [mm-client] [16205]: (debug): MAC: 0000.0000.0000 Received device_cache_update, sub type: 0 of XID (0) from (WNCD[0]) 2024/04/08 14:12:49.991449930 {wncd_x_R0-0}{1}: [auth-mgr] [15195]: (info): [9cfc.e8dc.d41c:capwap_90000005] auth mgr attr add/change notification is received for attr vlan-id(965) 2024/04/08 14:12:49.991470696 {wncd_x_R0-0}{1}: [epm] [15195]: (info): [9cfc.e8dc.d41c:capwap_90000005] Vlan tag name is DATA, pref is 1048575 vlan num is 100 2024/04/08 14:12:49.991526318 {wncd_x_R0-0}{1}: [epm] [15195]: (info): [9cfc.e8dc.d41c:capwap_90000005] Feature (EPM Vlan PLUG-IN) has been started (status Success) 2024/04/08 14:12:49.991539272 {wncd_x_R0-0}{1}: [auth-mgr] [15195]: (info): [9cfc.e8dc.d41c:capwap_90000005] SM Reauth Plugin: Received valid timeout = 3600, effective timeout = 3600 2024/04/08 14:12:49.991561122 {wncd_x_R0-0}{1}: [epm] [15195]: (info): [9cfc.e8dc.d41c:capwap_90000005] Feature (SM Reauth PLUG-IN) has been started (status Success) 2024/04/08 14:12:49.991621076 {wncd_x_R0-0}{1}: [svm] [15195]: (info): SVM_INFO: Response of epm is SYNC with return code Success 2024/04/08 14:12:49.991675698 {wncd_x_R0-0}{1}: [auth-mgr] [15195]: (info): [9cfc.e8dc.d41c:capwap_90000005] Raising ext evt Template Activated (9) on this session, client (unknown) (0) 2024/04/08 14:12:49.991800885 {wncd_x_R0-0}{1}: [llbridge-main] [15195]: (debug): MAC: 9cfc.e8dc.d41c Link-local bridging not enabled for this client, not checking VLAN validity 2024/04/08 14:12:49.991842945 {wncd_x_R0-0}{1}: [svm] [15195]: (info): SVM_INFO: SVM Apply user profile 2024/04/08 14:12:49.991961794 {wncd_x_R0-0}{1}: [dot1x] [15195]: (info): [9cfc.e8dc.d41c:capwap_90000005] Initialising auth state 2024/04/08 14:12:49.991967824 {wncd_x_R0-0}{1}: [dot1x] [15195]: (info): [9cfc.e8dc.d41c:capwap_90000005] Setting Auth state to disconnected 2024/04/08 14:12:49.991971844 {wncd_x_R0-0}{1}: [dot1x] [15195]: (info): [9cfc.e8dc.d41c:capwap_90000005] Entering restart state 2024/04/08 14:12:49.991976176 {wncd_x_R0-0}{1}: [dot1x] [15195]: (info): [9cfc.e8dc.d41c:capwap_90000005] Override cfg - MAC 9cfc.e8dc.d41c - profile (none) 2024/04/08 14:12:49.991978566 {wncd_x_R0-0}{1}: [dot1x] [15195]: (info): [9cfc.e8dc.d41c:capwap_90000005] Override cfg - SuppTimeout 30s, ReAuthMax 2, MaxReq 2, TxPeriod 30s 2024/04/08 14:12:49.991982022 {wncd_x_R0-0}{1}: [dot1x] [15195]: (info): [9cfc.e8dc.d41c:capwap_90000005] Sending create new context event to EAP for 0x6D00000E (9cfc.e8dc.d41c) 2024/04/08 14:12:49.992029586 {wncd_x_R0-0}{1}: [dot1x] [15195]: (info): [9cfc.e8dc.d41c:capwap_90000005] Entering init state 2024/04/08 14:12:49.992034660 {wncd_x_R0-0}{1}: [dot1x] [15195]: (info): [9cfc.e8dc.d41c:capwap_90000005] Entering idle state 2024/04/08 14:12:49.992039902 {wncd_x_R0-0}{1}: [dot1x] [15195]: (info): [9cfc.e8dc.d41c:capwap_90000005] Dot1x authentication started for (9cfc.e8dc.d41c) 2024/04/08 14:12:49.992047596 {wncd_x_R0-0}{1}: [auth-mgr] [15195]: (info): [9cfc.e8dc.d41c:capwap_90000005] Context changing state from 'Idle' to 'Running' 2024/04/08 14:12:49.992051434 {wncd_x_R0-0}{1}: [auth-mgr] [15195]: (info): [9cfc.e8dc.d41c:capwap_90000005] Method dot1x changing state from 'Not run' to 'Running' 2024/04/08 14:12:49.992495648 {wncd_x_R0-0}{1}: [auth-mgr] [15195]: (info): [9cfc.e8dc.d41c:capwap_90000005] SM will not send event Template Activated to PRE for 0xB900000E 2024/04/08 14:12:49.992544582 {wncd_x_R0-0}{1}: [client-auth] [15195]: (info): MAC: 9cfc.e8dc.d41c Client auth-interface state transition: S_AUTHIF_AWAIT_DOT1XAUTH_START_RESP -> S_AUTHIF_DOT1XAUTH_PENDING 2024/04/08 14:12:49.992548224 {wncd_x_R0-0}{1}: [ewlc-infra-evq] [15195]: (note): Authentication Success. Resolved Policy bitmap:11 for client 9cfc.e8dc.d41c 2024/04/08 14:12:49.992553060 {wncd_x_R0-0}{1}: [client-auth] [15195]: (info): MAC: 9cfc.e8dc.d41c Client auth-interface state transition: S_AUTHIF_DOT1XAUTH_PENDING -> S_AUTHIF_DOT1XAUTH_PENDING 2024/04/08 14:12:49.992605014 {wncd_x_R0-0}{1}: [dot1x] [15195]: (info): [9cfc.e8dc.d41c:capwap_90000005] Posting !EAP_RESTART on Client 2024/04/08 14:12:49.992609756 {wncd_x_R0-0}{1}: [dot1x] [15195]: (info): [9cfc.e8dc.d41c:capwap_90000005] Enter connecting state 2024/04/08 14:12:49.992618668 {wncd_x_R0-0}{1}: [dot1x] [15195]: (info): [9cfc.e8dc.d41c:capwap_90000005] Restart connecting 2024/04/08 14:12:49.992636544 {wncd_x_R0-0}{1}: [auth-mgr] [15195]: (info): [9cfc.e8dc.d41c:capwap_90000005] Device type for the session is detected as Intel-Device and old Intel-Device & Device name for the session is detected as INTEL CORPORATE and old INTEL CORPORATE & Old protocol map 1 and new is 1 2024/04/08 14:12:49.992646080 {wncd_x_R0-0}{1}: [auth-mgr] [15195]: (info): [9cfc.e8dc.d41c:capwap_90000005] auth mgr attr add/change notification is received for attr dc-profile-name(1130) 2024/04/08 14:12:49.992668242 {wncd_x_R0-0}{1}: [dot1x] [15195]: (info): [9cfc.e8dc.d41c:capwap_90000005] Posting RX_REQ on Client 2024/04/08 14:12:49.992672462 {wncd_x_R0-0}{1}: [dot1x] [15195]: (info): [9cfc.e8dc.d41c:capwap_90000005] Authenticating state entered 2024/04/08 14:12:49.992682394 {wncd_x_R0-0}{1}: [dot1x] [15195]: (info): [9cfc.e8dc.d41c:capwap_90000005] Connecting authenticating action 2024/04/08 14:12:49.992692424 {wncd_x_R0-0}{1}: [dot1x] [15195]: (info): [9cfc.e8dc.d41c:capwap_90000005] Entering request state 2024/04/08 14:12:49.992722295 {wncd_x_R0-0}{1}: [dot1x] [15195]: (info): [0000.0000.0000:capwap_90000005] Setting EAPOL eth-type to 0x888e, destination mac to 9cfc.e8dc.d41c 2024/04/08 14:12:49.992724181 {wncd_x_R0-0}{1}: [dot1x] [15195]: (info): [0000.0000.0000:capwap_90000005] Sending out EAPOL packet 2024/04/08 14:12:49.992815349 {wncd_x_R0-0}{1}: [dot1x] [15195]: (info): [9cfc.e8dc.d41c:capwap_90000005] Sent EAPOL packet - Version : 3,EAPOL Type : EAP, Payload Length : 5, EAP-Type = Identity 2024/04/08 14:12:49.992817875 {wncd_x_R0-0}{1}: [dot1x] [15195]: (info): [9cfc.e8dc.d41c:capwap_90000005] EAP Packet - REQUEST, ID : 0x1 2024/04/08 14:12:49.992820629 {wncd_x_R0-0}{1}: [dot1x] [15195]: (info): [0000.0000.0000:unknown] Pkt body: 01 01 00 05 01 2024/04/08 14:12:49.992824481 {wncd_x_R0-0}{1}: [dot1x] [15195]: (info): [9cfc.e8dc.d41c:capwap_90000005] EAPOL packet sent to client 2024/04/08 14:13:19.993374263 {wncd_x_R0-0}{1}: [dot1x] [15195]: (info): [9cfc.e8dc.d41c:capwap_90000005] Entering request state 2024/04/08 14:13:19.993399387 {wncd_x_R0-0}{1}: [dot1x] [15195]: (info): [0000.0000.0000:capwap_90000005] Setting EAPOL eth-type to 0x888e, destination mac to 9cfc.e8dc.d41c 2024/04/08 14:13:19.993401433 {wncd_x_R0-0}{1}: [dot1x] [15195]: (info): [0000.0000.0000:capwap_90000005] Sending out EAPOL packet 2024/04/08 14:13:19.993512598 {wncd_x_R0-0}{1}: [dot1x] [15195]: (info): [9cfc.e8dc.d41c:capwap_90000005] Sent EAPOL packet - Version : 3,EAPOL Type : EAP, Payload Length : 5, EAP-Type = Identity 2024/04/08 14:13:19.993515378 {wncd_x_R0-0}{1}: [dot1x] [15195]: (info): [9cfc.e8dc.d41c:capwap_90000005] EAP Packet - REQUEST, ID : 0x1 2024/04/08 14:13:19.993518240 {wncd_x_R0-0}{1}: [dot1x] [15195]: (info): [0000.0000.0000:unknown] Pkt body: 01 01 00 05 01 2024/04/08 14:13:19.993522090 {wncd_x_R0-0}{1}: [dot1x] [15195]: (info): [9cfc.e8dc.d41c:capwap_90000005] EAPOL packet sent to client 2024/04/08 14:13:29.961249561 {wncd_x_R0-0}{1}: [dot1x] [15195]: (info): [9cfc.e8dc.d41c:capwap_90000005] Received EAPOL packet - Version : 3,EAPOL Type : START, Payload Length : 0 2024/04/08 14:13:29.961269625 {wncd_x_R0-0}{1}: [dot1x] [15195]: (info): [0000.0000.0000:capwap_90000005] Dequeued pkt: CODE = 0,TYPE = 0,LEN = 0 2024/04/08 14:13:29.961276207 {wncd_x_R0-0}{1}: [dot1x] [15195]: (info): [0000.0000.0000:capwap_90000005] Received pkt saddr = 9cfc.e8dc.d41c , daddr = c828.e5a4.ce40, pae-ether-type = 0x888E 2024/04/08 14:13:29.961312639 {wncd_x_R0-0}{1}: [dot1x] [15195]: (info): [9cfc.e8dc.d41c:capwap_90000005] Posting EAPOL_START on Client 2024/04/08 14:13:29.961460973 {wncd_x_R0-0}{1}: [dot1x] [15195]: (info): [9cfc.e8dc.d41c:capwap_90000005] Entering init state 2024/04/08 14:13:29.961472059 {wncd_x_R0-0}{1}: [dot1x] [15195]: (info): [9cfc.e8dc.d41c:capwap_90000005] Entering idle state 2024/04/08 14:13:29.961477340 {wncd_x_R0-0}{1}: [dot1x] [15195]: (info): [9cfc.e8dc.d41c:capwap_90000005] Posting !AUTH_ABORT on Client 2024/04/08 14:13:29.961489918 {wncd_x_R0-0}{1}: [dot1x] [15195]: (info): [9cfc.e8dc.d41c:capwap_90000005] Entering restart state 2024/04/08 14:13:29.961492014 {wncd_x_R0-0}{1}: [dot1x] [15195]: (info): [9cfc.e8dc.d41c:capwap_90000005] Resetting the client 0x6D00000E 2024/04/08 14:13:29.961506184 {wncd_x_R0-0}{1}: [dot1x] [15195]: (info): [9cfc.e8dc.d41c:capwap_90000005] Override cfg - MAC 9cfc.e8dc.d41c - profile (none) 2024/04/08 14:13:29.961508890 {wncd_x_R0-0}{1}: [dot1x] [15195]: (info): [9cfc.e8dc.d41c:capwap_90000005] Override cfg - SuppTimeout 30s, ReAuthMax 2, MaxReq 2, TxPeriod 30s 2024/04/08 14:13:29.961512468 {wncd_x_R0-0}{1}: [dot1x] [15195]: (info): [9cfc.e8dc.d41c:capwap_90000005] Sending create new context event to EAP for 0x6D00000E (9cfc.e8dc.d41c) 2024/04/08 14:13:29.961604244 {wncd_x_R0-0}{1}: [dot1x] [15195]: (info): [9cfc.e8dc.d41c:capwap_90000005] Posting !EAP_RESTART on Client 2024/04/08 14:13:29.961608466 {wncd_x_R0-0}{1}: [dot1x] [15195]: (info): [9cfc.e8dc.d41c:capwap_90000005] Enter connecting state 2024/04/08 14:13:29.961613416 {wncd_x_R0-0}{1}: [dot1x] [15195]: (info): [9cfc.e8dc.d41c:capwap_90000005] Restart connecting 2024/04/08 14:13:29.961617990 {wncd_x_R0-0}{1}: [dot1x] [15195]: (info): [9cfc.e8dc.d41c:capwap_90000005] Posting RX_REQ on Client 2024/04/08 14:13:29.961628068 {wncd_x_R0-0}{1}: [dot1x] [15195]: (info): [9cfc.e8dc.d41c:capwap_90000005] Authenticating state entered 2024/04/08 14:13:29.961635876 {wncd_x_R0-0}{1}: [dot1x] [15195]: (info): [9cfc.e8dc.d41c:capwap_90000005] Connecting authenticating action 2024/04/08 14:13:29.961645556 {wncd_x_R0-0}{1}: [dot1x] [15195]: (info): [9cfc.e8dc.d41c:capwap_90000005] Entering request state 2024/04/08 14:13:29.961661038 {wncd_x_R0-0}{1}: [dot1x] [15195]: (info): [0000.0000.0000:capwap_90000005] Setting EAPOL eth-type to 0x888e, destination mac to 9cfc.e8dc.d41c 2024/04/08 14:13:29.961662340 {wncd_x_R0-0}{1}: [dot1x] [15195]: (info): [0000.0000.0000:capwap_90000005] Sending out EAPOL packet 2024/04/08 14:13:29.961763603 {wncd_x_R0-0}{1}: [dot1x] [15195]: (info): [9cfc.e8dc.d41c:capwap_90000005] Sent EAPOL packet - Version : 3,EAPOL Type : EAP, Payload Length : 5, EAP-Type = Identity 2024/04/08 14:13:29.961771885 {wncd_x_R0-0}{1}: [dot1x] [15195]: (info): [9cfc.e8dc.d41c:capwap_90000005] EAP Packet - REQUEST, ID : 0x1 2024/04/08 14:13:29.961774635 {wncd_x_R0-0}{1}: [dot1x] [15195]: (info): [0000.0000.0000:unknown] Pkt body: 01 01 00 05 01 2024/04/08 14:13:29.961778373 {wncd_x_R0-0}{1}: [dot1x] [15195]: (info): [9cfc.e8dc.d41c:capwap_90000005] EAPOL packet sent to client 2024/04/08 14:13:59.961912541 {wncd_x_R0-0}{1}: [dot1x] [15195]: (info): [9cfc.e8dc.d41c:capwap_90000005] Entering request state 2024/04/08 14:13:59.961935145 {wncd_x_R0-0}{1}: [dot1x] [15195]: (info): [0000.0000.0000:capwap_90000005] Setting EAPOL eth-type to 0x888e, destination mac to 9cfc.e8dc.d41c 2024/04/08 14:13:59.961936769 {wncd_x_R0-0}{1}: [dot1x] [15195]: (info): [0000.0000.0000:capwap_90000005] Sending out EAPOL packet 2024/04/08 14:13:59.962036196 {wncd_x_R0-0}{1}: [dot1x] [15195]: (info): [9cfc.e8dc.d41c:capwap_90000005] Sent EAPOL packet - Version : 3,EAPOL Type : EAP, Payload Length : 5, EAP-Type = Identity 2024/04/08 14:13:59.962043666 {wncd_x_R0-0}{1}: [dot1x] [15195]: (info): [9cfc.e8dc.d41c:capwap_90000005] EAP Packet - REQUEST, ID : 0x1 2024/04/08 14:13:59.962046386 {wncd_x_R0-0}{1}: [dot1x] [15195]: (info): [0000.0000.0000:unknown] Pkt body: 01 01 00 05 01 2024/04/08 14:13:59.962050078 {wncd_x_R0-0}{1}: [dot1x] [15195]: (info): [9cfc.e8dc.d41c:capwap_90000005] EAPOL packet sent to client 2024/04/08 14:14:24.985256589 {wncd_x_R0-0}{1}: [client-orch-sm] [15195]: (note): MAC: 9cfc.e8dc.d41c Co client reap timer callback. Co client reap timer triggering E_CO_CLIENT_CONNECT_TIMEOUT event, client state: S_CO_L2_AUTH_IN_PROGRESSDelete ACK pending flag : 0 2024/04/08 14:14:24.985274199 {wncd_x_R0-0}{1}: [client-orch-sm] [15195]: (info): MAC: 9cfc.e8dc.d41c Client reap timer timeout occurred, reason: 8, CO_CLIENT_DELETE_REASON_CONNECT_TIMEOUT. Checking if RLAN MAB fallback is applicable. 2024/04/08 14:14:24.985313183 {wncd_x_R0-0}{1}: [ewlc-infra-evq] [15195]: (ERR): 9cfc.e8dc.d41cCLIENT_STAGE_TIMEOUT State = AUTHENTICATING, WLAN profile = , Policy profile = FLEX, AP name = 2024/04/08 14:14:24.985314387 {wncd_x_R0-0}{1}: [client-orch-sm] [15195]: (info): MAC: 9cfc.e8dc.d41c Deleting the client, reason: 167, CO_CLIENT_DELETE_REASON_L2AUTH_CONNECT_TIMEOUT, Client state S_CO_L2_AUTH_IN_PROGRESS 2024/04/08 14:14:24.985337141 {wncd_x_R0-0}{1}: [client-orch-sm] [15195]: (note): MAC: 9cfc.e8dc.d41c Client delete initiated. Reason: CO_CLIENT_DELETE_REASON_L2AUTH_CONNECT_TIMEOUT, details: , fsm-state transition 00|00|00|00|00|00|00|00|00|00|00|00|00|00|00|00|00|00|00|00|00|00|00|00|00|00|00|00|01|07|15|19| 2024/04/08 14:14:24.985531246 {wncd_x_R0-0}{1}: [client-orch-sm] [15195]: (note): MAC: 9cfc.e8dc.d41c Delete mobile payload sent for BSSID: c828.e5a4.ce4f WTP mac: c828.e5a4.ce40 slot id: 1 2024/04/08 14:14:24.985542884 {wncd_x_R0-0}{1}: [client-orch-state] [15195]: (note): MAC: 9cfc.e8dc.d41c Client state transition: S_CO_L2_AUTH_IN_PROGRESS -> S_CO_DELETE_IN_PROGRESS 2024/04/08 14:14:24.985604498 {wncd_x_R0-0}{1}: [ewlc-qos-voice] [15195]: (info): MAC: 9cfc.e8dc.d41c Successfully freed the bw for sip client 2024/04/08 14:14:24.985660241 {wncd_x_R0-0}{1}: [multicast-main] [15195]: (info): MAC: 9cfc.e8dc.d41c No Flex/Fabric main record exists for client 2024/04/08 14:14:24.985702293 {wncd_x_R0-0}{1}: [client-iplearn] [15195]: (info): MAC: 9cfc.e8dc.d41c IP-learn state transition: S_IPLEARN_INIT -> S_IPLEARN_DELETE_IN_PROGRESS 2024/04/08 14:14:24.985728135 {wncd_x_R0-0}{1}: [mm-transition] [15195]: (info): MAC: 9cfc.e8dc.d41c MMIF FSM transition: S_MA_INIT -> S_MA_LOCAL_DELETE_PROCESSED_TR on E_MA_CO_DELETE_RCVD 2024/04/08 14:14:24.985790563 {wncd_x_R0-0}{1}: [auth-mgr] [15195]: (info): [9cfc.e8dc.d41c:capwap_90000005] Raised event DELETE (19) 2024/04/08 14:14:24.985795953 {wncd_x_R0-0}{1}: [auth-mgr] [15195]: (info): [9cfc.e8dc.d41c:capwap_90000005] Disconnect request from SANET-SHIM (15) for 9cfc.e8dc.d41c / 0xb900000e - term: reauth-failure, abort: Unknown, disc: (default) 2024/04/08 14:14:24.985796929 {wncd_x_R0-0}{1}: [sanet-shim-translate] [15195]: (note): MAC: 9cfc.e8dc.d41c Session manager disconnect event called, session label: 0xb900000e 2024/04/08 14:14:24.985824975 {wncd_x_R0-0}{1}: [aaa-attr-inf] [15195]: (info): [ Applied attribute :bsn-vlan-interface-name 0 "DATA" ] 2024/04/08 14:14:24.985827407 {wncd_x_R0-0}{1}: [aaa-attr-inf] [15195]: (info): [ Applied attribute : timeout 0 3600 (0xe10) ] 2024/04/08 14:14:24.985839863 {wncd_x_R0-0}{1}: [client-auth] [15195]: (info): MAC: 9cfc.e8dc.d41c Client auth-interface state transition: S_AUTHIF_DOT1XAUTH_PENDING -> S_SANET_DELETE_IN_PROGRESS 2024/04/08 14:14:24.985856741 {wncd_x_R0-0}{1}: [dot11] [15195]: (info): MAC: 9cfc.e8dc.d41c Total length of Deauth/Disassoc: 2 2024/04/08 14:14:24.985944562 {wncd_x_R0-0}{1}: [dot11] [15195]: (info): MAC: 9cfc.e8dc.d41c Sent disassoc to client, disassoc reason: 252, CLIENT_DEAUTH_REASON_ADMIN_RESET delete reason: 167, CO_CLIENT_DELETE_REASON_L2AUTH_CONNECT_TIMEOUT. 2024/04/08 14:14:24.985946744 {wncd_x_R0-0}{1}: [dot11] [15195]: (info): MAC: 9cfc.e8dc.d41c Total length of Deauth/Disassoc: 2 2024/04/08 14:14:24.986004778 {wncd_x_R0-0}{1}: [dot11] [15195]: (info): MAC: 9cfc.e8dc.d41c Sent deauth to client, deauth reason: 252, CLIENT_DEAUTH_REASON_ADMIN_RESET delete reason: 167, CO_CLIENT_DELETE_REASON_L2AUTH_CONNECT_TIMEOUT. 2024/04/08 14:14:24.986095102 {wncd_x_R0-0}{1}: [dot11] [15195]: (info): MAC: 9cfc.e8dc.d41c DOT11 state transition: S_DOT11_ASSOCIATED -> S_DOT11_DELETED 2024/04/08 14:14:24.986553698 {wncd_x_R0-0}{1}: [caaa-acct] [15195]: (info): [CAAA:ACCT] Not a webauth call 2024/04/08 14:14:24.986770605 {wncd_x_R0-0}{1}: [dot1x] [15195]: (info): [0000.0000.0000:capwap_90000005] dot1x channel is not up for client 9cfc.e8dc.d41c 2024/04/08 14:14:24.986946844 {wncd_x_R0-0}{1}: [client-auth] [15195]: (info): MAC: 9cfc.e8dc.d41c Client auth-interface state transition: S_SANET_DELETE_IN_PROGRESS -> S_AUTHIF_DELETED 2024/04/08 14:14:24.987029288 {wncd_x_R0-0}{1}: [client-orch-state] [15195]: (note): MAC: 9cfc.e8dc.d41c Client state transition: S_CO_DELETE_IN_PROGRESS -> S_CO_DELETED