cancel
Showing results for 
Search instead for 
Did you mean: 
cancel
3069
Views
0
Helpful
0
Replies

DHCP dropping packet due to ongoing mobility handshake exchange

jawadawawdeh
Level 1
Level 1
i need some help debugging this issue 
in my network we are using cisco wlc 2504 with image 8.0.133.0 ,and some android smartphones(smasung) are stuck at obtaining IP address , and the controllers on the network work as a bridge with DHCP proxy disable (external DHCP) ,all controllers are in the same domain and the same mobility group, while debugging the DHCP i got this:
 ((DHCP dropping packet due to ongoing mobility handshake exchange))    
the output of those commands are attached :
-debug client
-show exclusionlist
-debug mobility handoff enable
-debug dhcp packets
-debug dhcp messages
-debug mobility directory enable 
NOTE: i cant upgrade the image because this image is the last image supported by most of the network APs
debug client cc:3a:61:6d:05:2e

(Cisco Controller) >
(Cisco Controller) >*apfMsConnTask_0: Dec 10 12:20:08.774: cc:3a:61:6d:05:2e Processing assoc-req station:cc:3a:61:6d:05:2e AP:54:78:1a:d0:16:50-00 thread:15146c90
*apfMsConnTask_0: Dec 10 12:20:08.774: cc:3a:61:6d:05:2e Adding mobile on LWAPP AP 54:78:1a:d0:16:50(0)
*apfMsConnTask_0: Dec 10 12:20:08.774: cc:3a:61:6d:05:2e Association received from mobile on BSSID 54:78:1a:d0:16:51 AP AP-ITC007
*apfMsConnTask_0: Dec 10 12:20:08.774: cc:3a:61:6d:05:2e Global 200 Clients are allowed to AP radio

*apfMsConnTask_0: Dec 10 12:20:08.774: cc:3a:61:6d:05:2e Max Client Trap Threshold: 0 cur: 8

*apfMsConnTask_0: Dec 10 12:20:08.774: cc:3a:61:6d:05:2e Rf profile 600 Clients are allowed to AP wlan

*apfMsConnTask_0: Dec 10 12:20:08.774: cc:3a:61:6d:05:2e override for default ap group, marking intgrp NULL
*apfMsConnTask_0: Dec 10 12:20:08.774: cc:3a:61:6d:05:2e Applying Interface policy on Mobile, role Unassociated. Ms NAC State 0 Quarantine Vlan 0 Access Vlan 0

*apfMsConnTask_0: Dec 10 12:20:08.774: cc:3a:61:6d:05:2e Re-applying interface policy for client

*apfMsConnTask_0: Dec 10 12:20:08.774: cc:3a:61:6d:05:2e 0.0.0.0 START (0) Changing IPv4 ACL 'none' (ACL ID 255) ===> 'none' (ACL ID 255) --- (caller apf_policy.c:2435)
*apfMsConnTask_0: Dec 10 12:20:08.774: cc:3a:61:6d:05:2e 0.0.0.0 START (0) Changing IPv6 ACL 'none' (ACL ID 255) ===> 'none' (ACL ID 255) --- (caller apf_policy.c:2456)
*apfMsConnTask_0: Dec 10 12:20:08.775: cc:3a:61:6d:05:2e Values before applying NASID - interfacetype:0, ovrd:0, mscb nasid:, interface nasid:
*apfMsConnTask_0: Dec 10 12:20:08.775: cc:3a:61:6d:05:2e apfApplyWlanPolicy: Apply WLAN Policy over PMIPv6 Client Mobility Type
*apfMsConnTask_0: Dec 10 12:20:08.775: cc:3a:61:6d:05:2e Check before Setting the NAS Id to WLAN specific Id ''
*apfMsConnTask_0: Dec 10 12:20:08.775: cc:3a:61:6d:05:2e Applying site-specific Local Bridging override for station cc:3a:61:6d:05:2e - vapId 2, site 'default-group', interface 'management'
*apfMsConnTask_0: Dec 10 12:20:08.775: cc:3a:61:6d:05:2e Applying Local Bridging Interface Policy for station cc:3a:61:6d:05:2e - vlan 0, interface id 0, interface 'management', nasId:''
*apfMsConnTask_0: Dec 10 12:20:08.775: cc:3a:61:6d:05:2e processSsidIE statusCode is 0 and status is 0
*apfMsConnTask_0: Dec 10 12:20:08.775: cc:3a:61:6d:05:2e processSsidIE ssid_done_flag is 0 finish_flag is 0
*apfMsConnTask_0: Dec 10 12:20:08.775: cc:3a:61:6d:05:2e STA - rates (8): 130 132 139 150 36 48 72 108 0 0 0 0 0 0 0 0
*apfMsConnTask_0: Dec 10 12:20:08.775: cc:3a:61:6d:05:2e suppRates statusCode is 0 and gotSuppRatesElement is 1
*apfMsConnTask_0: Dec 10 12:20:08.775: cc:3a:61:6d:05:2e STA - rates (12): 130 132 139 150 36 48 72 108 12 18 24 96 0 0 0 0
*apfMsConnTask_0: Dec 10 12:20:08.775: cc:3a:61:6d:05:2e extSuppRates statusCode is 0 and gotExtSuppRatesElement is 1
*apfMsConnTask_0: Dec 10 12:20:08.775: cc:3a:61:6d:05:2e Process P2P IE And Update CB on BSSID 54:78:1a:d0:16:50 slot 0
*apfMsConnTask_0: Dec 10 12:20:08.775: cc:3a:61:6d:05:2e Parse P2P IE And Update CB on BSSID 54:78:1a:d0:16:50 slot 0
*apfMsConnTask_0: Dec 10 12:20:08.775: RSNIE in Assoc. Req.: (38)

*apfMsConnTask_0: Dec 10 12:20:08.775: [0000] 01 00 00 0f ac 02 01 00 00 0f ac 04 01 00 00 40

*apfMsConnTask_0: Dec 10 12:20:08.775: [0016] 96 00 00 00 01 00 e5 4f 97 2a 23 08 12 39 71 36

*apfMsConnTask_0: Dec 10 12:20:08.775: [0032] a6 38 e3 13 26 46

*apfMsConnTask_0: Dec 10 12:20:08.775: cc:3a:61:6d:05:2e Processing RSN IE type 48, length 38 for mobile cc:3a:61:6d:05:2e
*apfMsConnTask_0: Dec 10 12:20:08.775: cc:3a:61:6d:05:2e CCKM: Mobile is using CCKM
*apfMsConnTask_0: Dec 10 12:20:08.775: cc:3a:61:6d:05:2e RSN Capabilities: 0
*apfMsConnTask_0: Dec 10 12:20:08.775: cc:3a:61:6d:05:2e Marking Mobile as non-11w Capable
*apfMsConnTask_0: Dec 10 12:20:08.775: cc:3a:61:6d:05:2e Received RSN IE with 1 PMKIDs from mobile cc:3a:61:6d:05:2e
*apfMsConnTask_0: Dec 10 12:20:08.775: Received PMKID: (16)

*apfMsConnTask_0: Dec 10 12:20:08.775: [0000] e5 4f 97 2a 23 08 12 39 71 36 a6 38 e3 13 26 46

*apfMsConnTask_0: Dec 10 12:20:08.775: cc:3a:61:6d:05:2e Searching for PMKID in MSCB PMKID cache for mobile cc:3a:61:6d:05:2e
*apfMsConnTask_0: Dec 10 12:20:08.775: cc:3a:61:6d:05:2e No valid PMKID found in the MSCB PMKID cache for mobile cc:3a:61:6d:05:2e
*apfMsConnTask_0: Dec 10 12:20:08.775: cc:3a:61:6d:05:2e Trying to compute a PMKID from MSCB PMK cache for mobile cc:3a:61:6d:05:2e
*apfMsConnTask_0: Dec 10 12:20:08.775: CCKM: Find PMK in cache: BSSID = (6)

*apfMsConnTask_0: Dec 10 12:20:08.775: [0000] 54 78 1a d0 16 50

*apfMsConnTask_0: Dec 10 12:20:08.775: CCKM: Find PMK in cache: realAA = (6)

*apfMsConnTask_0: Dec 10 12:20:08.775: [0000] 54 78 1a d0 16 51

*apfMsConnTask_0: Dec 10 12:20:08.775: CCKM: Find PMK in cache: PMKID = (16)

*apfMsConnTask_0: Dec 10 12:20:08.775: [0000] e5 4f 97 2a 23 08 12 39 71 36 a6 38 e3 13 26 46

*apfMsConnTask_0: Dec 10 12:20:08.775: cc:3a:61:6d:05:2e Unable to compute a valid PMKID from MSCB PMK cache for mobile cc:3a:61:6d:05:2e
*apfMsConnTask_0: Dec 10 12:20:08.775: cc:3a:61:6d:05:2e Searching for PMK in global PMK cache for mobile cc:3a:61:6d:05:2e
*apfMsConnTask_0: Dec 10 12:20:08.776: cc:3a:61:6d:05:2e Found an entry in the global PMK cache for station cc:3a:61:6d:05:2e
*apfMsConnTask_0: Dec 10 12:20:08.776: CCKM: AA (6)

*apfMsConnTask_0: Dec 10 12:20:08.776: [0000] 54 78 1a d0 16 51

*apfMsConnTask_0: Dec 10 12:20:08.776: CCKM: SPA (6)

*apfMsConnTask_0: Dec 10 12:20:08.776: [0000] cc 3a 61 6d 05 2e

*apfMsConnTask_0: Dec 10 12:20:08.776: cc:3a:61:6d:05:2e computed a valid PMKID from global PMK cache for mobile cc:3a:61:6d:05:2e
*apfMsConnTask_0: Dec 10 12:20:08.776: cc:3a:61:6d:05:2e Username entry (f3783) created for mobile, length = 253
*apfMsConnTask_0: Dec 10 12:20:08.776: cc:3a:61:6d:05:2e Username entry (f3783) created in mscb for mobile, length = 253
*apfMsConnTask_0: Dec 10 12:20:08.776: cc:3a:61:6d:05:2e Setting active key cache index 8 ---> 8
*apfMsConnTask_0: Dec 10 12:20:08.776: cc:3a:61:6d:05:2e Setting active key cache index 8 ---> 0
*apfMsConnTask_0: Dec 10 12:20:08.776: cc:3a:61:6d:05:2e Creating a PKC PMKID Cache entry for station cc:3a:61:6d:05:2e (RSN 0) on BSSID 54:78:1a:d0:16:51
*apfMsConnTask_0: Dec 10 12:20:08.776: cc:3a:61:6d:05:2e Adding BSSID 54:78:1a:d0:16:51 to PMKID cache at index 0 for station cc:3a:61:6d:05:2e
*apfMsConnTask_0: Dec 10 12:20:08.776: New PMKID: (16)

*apfMsConnTask_0: Dec 10 12:20:08.776: [0000] e5 4f 97 2a 23 08 12 39 71 36 a6 38 e3 13 26 46

*apfMsConnTask_0: Dec 10 12:20:08.776: cc:3a:61:6d:05:2e 0.0.0.0 START (0) Initializing policy
*apfMsConnTask_0: Dec 10 12:20:08.776: cc:3a:61:6d:05:2e 0.0.0.0 START (0) Change state to AUTHCHECK (2) last state START (0)

*apfMsConnTask_0: Dec 10 12:20:08.776: cc:3a:61:6d:05:2e 0.0.0.0 AUTHCHECK (2) Change state to 8021X_REQD (3) last state AUTHCHECK (2)

*apfMsConnTask_0: Dec 10 12:20:08.776: cc:3a:61:6d:05:2e Encryption policy is set to 0x80000001
*apfMsConnTask_0: Dec 10 12:20:08.776: cc:3a:61:6d:05:2e Not Using WMM Compliance code qosCap 00
*apfMsConnTask_0: Dec 10 12:20:08.776: cc:3a:61:6d:05:2e 0.0.0.0 8021X_REQD (3) Plumbed mobile LWAPP rule on AP 54:78:1a:d0:16:50 vapId 2 apVapId 2 flex-acl-name:
*apfMsConnTask_0: Dec 10 12:20:08.776: cc:3a:61:6d:05:2e apfMsAssoStateInc
*apfMsConnTask_0: Dec 10 12:20:08.776: cc:3a:61:6d:05:2e apfPemAddUser2 (apf_policy.c:353) Changing state for mobile cc:3a:61:6d:05:2e on AP 54:78:1a:d0:16:50 from Idle to Associated

*apfMsConnTask_0: Dec 10 12:20:08.776: cc:3a:61:6d:05:2e apfPemAddUser2:session timeout forstation cc:3a:61:6d:05:2e - Session Tout 0, apfMsTimeOut '0' and sessionTimerRunning flag is 0
*apfMsConnTask_0: Dec 10 12:20:08.776: cc:3a:61:6d:05:2e Stopping deletion of Mobile Station: (callerId: 48)
*apfMsConnTask_0: Dec 10 12:20:08.776: cc:3a:61:6d:05:2e Func: apfPemAddUser2, Ms Timeout = 0, Session Timeout = 0

*apfMsConnTask_0: Dec 10 12:20:08.776: cc:3a:61:6d:05:2e Sending assoc-resp with status 0 station:cc:3a:61:6d:05:2e AP:54:78:1a:d0:16:50-00 on apVapId 2
*apfMsConnTask_0: Dec 10 12:20:08.777: cc:3a:61:6d:05:2e Send Assoc Resp Msg to WFD Client
*apfMsConnTask_0: Dec 10 12:20:08.777: cc:3a:61:6d:05:2e Send Assoc resp Msg to WFD ClientAdd P2P Ie hdr
*apfMsConnTask_0: Dec 10 12:20:08.777: cc:3a:61:6d:05:2e Send Assoc Msg to WFD ClientAdd Attribute to P2P Ie
*apfMsConnTask_0: Dec 10 12:20:08.780: cc:3a:61:6d:05:2e Sending Assoc Response to station on BSSID 54:78:1a:d0:16:51 (status 0) ApVapId 2 Slot 0
*apfMsConnTask_0: Dec 10 12:20:08.780: cc:3a:61:6d:05:2e apfProcessAssocReq (apf_80211.c:9582) Changing state for mobile cc:3a:61:6d:05:2e on AP 54:78:1a:d0:16:50 from Associated to Associated

*spamApTask1: Dec 10 12:20:08.783: cc:3a:61:6d:05:2e Sent 1x initiate message to multi thread task for mobile cc:3a:61:6d:05:2e
*Dot1x_NW_MsgTask_6: Dec 10 12:20:08.784: cc:3a:61:6d:05:2e reauth_sm state transition 0 ---> 1 for mobile cc:3a:61:6d:05:2e at 1x_reauth_sm.c:47
*Dot1x_NW_MsgTask_6: Dec 10 12:20:08.784: cc:3a:61:6d:05:2e Initiating RSN with existing PMK to mobile cc:3a:61:6d:05:2e
*Dot1x_NW_MsgTask_6: Dec 10 12:20:08.784: cc:3a:61:6d:05:2e EAP-PARAM Debug - eap-params for Wlan-Id :2 is disabled - applying Global eap timers and retries
*Dot1x_NW_MsgTask_6: Dec 10 12:20:08.784: cc:3a:61:6d:05:2e Disable re-auth, use PMK lifetime.
*Dot1x_NW_MsgTask_6: Dec 10 12:20:08.784: cc:3a:61:6d:05:2e Station cc:3a:61:6d:05:2e setting dot1x reauth timeout = 1800
*Dot1x_NW_MsgTask_6: Dec 10 12:20:08.784: cc:3a:61:6d:05:2e dot1x - moving mobile cc:3a:61:6d:05:2e into Force Auth state
*Dot1x_NW_MsgTask_6: Dec 10 12:20:08.784: cc:3a:61:6d:05:2e Skipping EAP-Success to mobile cc:3a:61:6d:05:2e
*Dot1x_NW_MsgTask_6: Dec 10 12:20:08.784: cc:3a:61:6d:05:2e Username entry (f3783) already exists in name table, length = 253
*Dot1x_NW_MsgTask_6: Dec 10 12:20:08.784: cc:3a:61:6d:05:2e Username entry (f3783) created in mscb for mobile, length = 253
*Dot1x_NW_MsgTask_6: Dec 10 12:20:08.784: cc:3a:61:6d:05:2e Applying cached RADIUS Override values for mobile cc:3a:61:6d:05:2e (caller 1x_auth_pae.c:780)
*Dot1x_NW_MsgTask_6: Dec 10 12:20:08.784: cc:3a:61:6d:05:2e Applying override policy from source Override Summation: with value 200

*Dot1x_NW_MsgTask_6: Dec 10 12:20:08.784: cc:3a:61:6d:05:2e Found an interface name:'vlan14' corresponds to interface name received: vlan14
*Dot1x_NW_MsgTask_6: Dec 10 12:20:08.784: cc:3a:61:6d:05:2e Applying Interface policy on Mobile, role Unassociated. Ms NAC State 2 Quarantine Vlan 0 Access Vlan 0

*Dot1x_NW_MsgTask_6: Dec 10 12:20:08.784: cc:3a:61:6d:05:2e Re-applying interface policy for client

*Dot1x_NW_MsgTask_6: Dec 10 12:20:08.784: cc:3a:61:6d:05:2e 0.0.0.0 8021X_REQD (3) Changing IPv4 ACL 'none' (ACL ID 255) ===> 'none' (ACL ID 255) --- (caller apf_policy.c:2435)
*Dot1x_NW_MsgTask_6: Dec 10 12:20:08.784: cc:3a:61:6d:05:2e 0.0.0.0 8021X_REQD (3) Changing IPv6 ACL 'none' (ACL ID 255) ===> 'none' (ACL ID 255) --- (caller apf_policy.c:2456)
*Dot1x_NW_MsgTask_6: Dec 10 12:20:08.784: cc:3a:61:6d:05:2e Values before applying NASID - interfacetype:3, ovrd:0, mscb nasid:, interface nasid:
*Dot1x_NW_MsgTask_6: Dec 10 12:20:08.784: cc:3a:61:6d:05:2e Found an cache entry for BSSID 54:78:1a:d0:16:51 in PMKID cache at index 0 of station cc:3a:61:6d:05:2e
*Dot1x_NW_MsgTask_6: Dec 10 12:20:08.784: cc:3a:61:6d:05:2e Found an cache entry for BSSID 54:78:1a:d0:16:51 in PMKID cache at index 0 of station cc:3a:61:6d:05:2e
*Dot1x_NW_MsgTask_6: Dec 10 12:20:08.784: Including PMKID in M1 (16)

*Dot1x_NW_MsgTask_6: Dec 10 12:20:08.784: [0000] e5 4f 97 2a 23 08 12 39 71 36 a6 38 e3 13 26 46

*Dot1x_NW_MsgTask_6: Dec 10 12:20:08.784: cc:3a:61:6d:05:2e Starting key exchange to mobile cc:3a:61:6d:05:2e, data packets will be dropped
*Dot1x_NW_MsgTask_6: Dec 10 12:20:08.784: cc:3a:61:6d:05:2e Sending EAPOL-Key Message to mobile cc:3a:61:6d:05:2e
state INITPMK (message 1), replay counter 00.00.00.00.00.00.00.00
*Dot1x_NW_MsgTask_6: Dec 10 12:20:08.784: cc:3a:61:6d:05:2e Allocating EAP Pkt for retransmission to mobile cc:3a:61:6d:05:2e
*Dot1x_NW_MsgTask_6: Dec 10 12:20:08.816: cc:3a:61:6d:05:2e Received EAPOL-Key from mobile cc:3a:61:6d:05:2e
*Dot1x_NW_MsgTask_6: Dec 10 12:20:08.816: cc:3a:61:6d:05:2e Ignoring invalid EAPOL version (1) in EAPOL-key message from mobile cc:3a:61:6d:05:2e
*Dot1x_NW_MsgTask_6: Dec 10 12:20:08.816: cc:3a:61:6d:05:2e Received EAPOL-key in PTK_START state (message 2) from mobile cc:3a:61:6d:05:2e
*Dot1x_NW_MsgTask_6: Dec 10 12:20:08.816: cc:3a:61:6d:05:2e Dumping RSNIE received in Association request:
*Dot1x_NW_MsgTask_6: Dec 10 12:20:08.816: 00000000: 30 26 01 00 00 0f ac 02 01 00 00 0f ac 04 01 00 0&..............
*Dot1x_NW_MsgTask_6: Dec 10 12:20:08.816: 00000010: 00 40 96 00 00 00 01 00 e5 4f 97 2a 23 08 12 39 .@.......O.*#..9
*Dot1x_NW_MsgTask_6: Dec 10 12:20:08.816: 00000020: 71 36 a6 38 e3 13 26 46 q6.8..&F
*Dot1x_NW_MsgTask_6: Dec 10 12:20:08.816: cc:3a:61:6d:05:2e Dumping RSNIE received in EAPOL M2 :
*Dot1x_NW_MsgTask_6: Dec 10 12:20:08.816: 00000000: 01 00 00 0f ac 02 01 00 00 0f ac 04 01 00 00 40 ...............@
*Dot1x_NW_MsgTask_6: Dec 10 12:20:08.816: 00000010: 96 00 00 00 01 00 e5 4f 97 2a 23 08 12 39 71 36 .......O.*#..9q6
*Dot1x_NW_MsgTask_6: Dec 10 12:20:08.816: 00000020: a6 38 e3 13 26 46 .8..&F
*Dot1x_NW_MsgTask_6: Dec 10 12:20:08.816: cc:3a:61:6d:05:2e Not Flex client. Do not distribute CCKM Key cache.
*Dot1x_NW_MsgTask_6: Dec 10 12:20:08.816: CCKM: Sending CCKM PMK (Version_2) information to mobility group
*Dot1x_NW_MsgTask_6: Dec 10 12:20:08.817: cc:3a:61:6d:05:2e 7 PMK-update groupcast messages sent
*Dot1x_NW_MsgTask_6: Dec 10 12:20:08.817: cc:3a:61:6d:05:2e Stopping retransmission timer for mobile cc:3a:61:6d:05:2e
*Dot1x_NW_MsgTask_6: Dec 10 12:20:08.817: cc:3a:61:6d:05:2e Sending EAPOL-Key Message to mobile cc:3a:61:6d:05:2e
state PTKINITNEGOTIATING (message 3), replay counter 00.00.00.00.00.00.00.01
*Dot1x_NW_MsgTask_6: Dec 10 12:20:08.817: cc:3a:61:6d:05:2e Reusing allocated memory for EAP Pkt for retransmission to mobile cc:3a:61:6d:05:2e
*Dot1x_NW_MsgTask_6: Dec 10 12:20:08.831: cc:3a:61:6d:05:2e Received EAPOL-Key from mobile cc:3a:61:6d:05:2e
*Dot1x_NW_MsgTask_6: Dec 10 12:20:08.831: cc:3a:61:6d:05:2e Ignoring invalid EAPOL version (1) in EAPOL-key message from mobile cc:3a:61:6d:05:2e
*Dot1x_NW_MsgTask_6: Dec 10 12:20:08.831: cc:3a:61:6d:05:2e Received EAPOL-key in PTKINITNEGOTIATING state (message 4) from mobile cc:3a:61:6d:05:2e
*Dot1x_NW_MsgTask_6: Dec 10 12:20:08.831: cc:3a:61:6d:05:2e Stopping retransmission timer for mobile cc:3a:61:6d:05:2e
*Dot1x_NW_MsgTask_6: Dec 10 12:20:08.832: cc:3a:61:6d:05:2e Freeing EAP Retransmit Bufer for mobile cc:3a:61:6d:05:2e
*Dot1x_NW_MsgTask_6: Dec 10 12:20:08.832: cc:3a:61:6d:05:2e apfMs1xStateInc
*Dot1x_NW_MsgTask_6: Dec 10 12:20:08.832: cc:3a:61:6d:05:2e 0.0.0.0 8021X_REQD (3) Change state to L2AUTHCOMPLETE (4) last state 8021X_REQD (3)

*Dot1x_NW_MsgTask_6: Dec 10 12:20:08.832: cc:3a:61:6d:05:2e Mobility query, PEM State: L2AUTHCOMPLETE

*Dot1x_NW_MsgTask_6: Dec 10 12:20:08.832: cc:3a:61:6d:05:2e Building Mobile Announce :

*Dot1x_NW_MsgTask_6: Dec 10 12:20:08.832: cc:3a:61:6d:05:2e Building Client Payload:

*Dot1x_NW_MsgTask_6: Dec 10 12:20:08.832: cc:3a:61:6d:05:2e Client Ip: 0.0.0.0

*Dot1x_NW_MsgTask_6: Dec 10 12:20:08.832: cc:3a:61:6d:05:2e Client Vlan Ip: 192.168.14.19, Vlan mask : 255.255.255.0

*Dot1x_NW_MsgTask_6: Dec 10 12:20:08.832: cc:3a:61:6d:05:2e Client Vap Security: 16384

*Dot1x_NW_MsgTask_6: Dec 10 12:20:08.832: cc:3a:61:6d:05:2e Virtual Ip: 1.1.1.1

*Dot1x_NW_MsgTask_6: Dec 10 12:20:08.832: cc:3a:61:6d:05:2e ssid: AL-QUDS-WLAN

*Dot1x_NW_MsgTask_6: Dec 10 12:20:08.832: cc:3a:61:6d:05:2e Building VlanIpPayload.

*Dot1x_NW_MsgTask_6: Dec 10 12:20:08.832: cc:3a:61:6d:05:2e Mobile Announce sent to 1 members of the local group.
*Dot1x_NW_MsgTask_6: Dec 10 12:20:08.832: cc:3a:61:6d:05:2e Not Using WMM Compliance code qosCap 00
*Dot1x_NW_MsgTask_6: Dec 10 12:20:08.832: cc:3a:61:6d:05:2e 0.0.0.0 L2AUTHCOMPLETE (4) Plumbed mobile LWAPP rule on AP 54:78:1a:d0:16:50 vapId 2 apVapId 2 flex-acl-name:
*Dot1x_NW_MsgTask_6: Dec 10 12:20:08.832: cc:3a:61:6d:05:2e 0.0.0.0 L2AUTHCOMPLETE (4) Change state to DHCP_REQD (7) last state L2AUTHCOMPLETE (4)

*Dot1x_NW_MsgTask_6: Dec 10 12:20:08.832: cc:3a:61:6d:05:2e 0.0.0.0 DHCP_REQD (7) pemAdvanceState2 6575, Adding TMP rule
*Dot1x_NW_MsgTask_6: Dec 10 12:20:08.832: cc:3a:61:6d:05:2e 0.0.0.0 DHCP_REQD (7) Adding Fast Path rule
type = Airespace AP - Learn IP address
on AP 54:78:1a:d0:16:50, slot 0, interface = 1, QOS = 0
IPv4 ACL ID = 255, IPv
*Dot1x_NW_MsgTask_6: Dec 10 12:20:08.832: cc:3a:61:6d:05:2e 0.0.0.0 DHCP_REQD (7) Fast Path rule (contd...) 802.1P = 0, DSCP = 0, TokenID = 15206, IntfId = 13 Local Bridging Vlan = 0, Local Bridging intf id = 0
*Dot1x_NW_MsgTask_6: Dec 10 12:20:08.832: cc:3a:61:6d:05:2e 0.0.0.0 DHCP_REQD (7) Fast Path rule (contd...) AVC Ratelimit: AppID = 0 ,AppAction = 0, AppToken = 15206 AverageRate = 0, BurstRate = 0

*Dot1x_NW_MsgTask_6: Dec 10 12:20:08.832: cc:3a:61:6d:05:2e 0.0.0.0 DHCP_REQD (7) Fast Path rule (contd...) AVC Ratelimit: AppID = 0 ,AppAction = 0, AppToken = 15206 AverageRate = 0, BurstRate = 0

*Dot1x_NW_MsgTask_6: Dec 10 12:20:08.832: cc:3a:61:6d:05:2e 0.0.0.0 DHCP_REQD (7) Fast Path rule (contd...) AVC Ratelimit: AppID = 0 ,AppAction = 0, AppToken = 15206 AverageRate = 0, BurstRate = 0

*Dot1x_NW_MsgTask_6: Dec 10 12:20:08.833: cc:3a:61:6d:05:2e 0.0.0.0 DHCP_REQD (7) Successfully plumbed mobile rule (IPv4 ACL ID 255, IPv6 ACL ID 255, L2 ACL ID 255)
*apfReceiveTask: Dec 10 12:20:08.833: cc:3a:61:6d:05:2e apfBlacklistMobileStationEntry2 (apf_ms.c:6268) Changing state for mobile cc:3a:61:6d:05:2e on AP 54:78:1a:d0:16:50 from Associated to Exclusion-list (1)

*apfReceiveTask: Dec 10 12:20:08.833: cc:3a:61:6d:05:2e Scheduling deletion of Mobile Station: (callerId: 44) in 10 seconds
*apfReceiveTask: Dec 10 12:20:08.833: cc:3a:61:6d:05:2e HandOff denied as Client is Blacklisted at Peer 0.0.0.0. Adding mobile to exclusion-list due to mobility reporting
*pemReceiveTask: Dec 10 12:20:08.834: cc:3a:61:6d:05:2e 0.0.0.0 Added NPU entry of type 9, dtlFlags 0x0
*DHCP Socket Task: Dec 10 12:20:09.343: cc:3a:61:6d:05:2e DHCP received op BOOTREQUEST (1) (len 321,vlan 0, port 1, encap 0xec03)
*DHCP Socket Task: Dec 10 12:20:09.343: cc:3a:61:6d:05:2e DHCP (encap type 0xec03) mstype 0ff:ff:ff:ff:ff:ff
*DHCP Socket Task: Dec 10 12:20:09.343: cc:3a:61:6d:05:2e DHCP dropping packet due to ongoing mobility handshake exchange, (siaddr 0.0.0.0, mobility state = 'apfMsMmQueryRequested'
*DHCP Socket Task: Dec 10 12:20:11.751: cc:3a:61:6d:05:2e DHCP received op BOOTREQUEST (1) (len 321,vlan 0, port 1, encap 0xec03)
*DHCP Socket Task: Dec 10 12:20:11.751: cc:3a:61:6d:05:2e DHCP (encap type 0xec03) mstype 0ff:ff:ff:ff:ff:ff
*DHCP Socket Task: Dec 10 12:20:11.751: cc:3a:61:6d:05:2e DHCP dropping packet due to ongoing mobility handshake exchange, (siaddr 0.0.0.0, mobility state = 'apfMsMmQueryRequested'
*DHCP Socket Task: Dec 10 12:20:13.322: cc:3a:61:6d:05:2e DHCP received op BOOTREQUEST (1) (len 315,vlan 0, port 1, encap 0xec03)
*DHCP Socket Task: Dec 10 12:20:13.323: cc:3a:61:6d:05:2e DHCP (encap type 0xec03) mstype 0ff:ff:ff:ff:ff:ff
*DHCP Socket Task: Dec 10 12:20:13.323: cc:3a:61:6d:05:2e DHCP dropping packet due to ongoing mobility handshake exchange, (siaddr 0.0.0.0, mobility state = 'apfMsMmQueryRequested'
*IPv6_Msg_Task: Dec 10 12:20:14.463: cc:3a:61:6d:05:2e Not Advancing pem state, mscb in apfMsMmQueryRequested mobility state and client state APF_MS_STATE_BLACKLISTED
*DHCP Socket Task: Dec 10 12:20:16.987: cc:3a:61:6d:05:2e DHCP received op BOOTREQUEST (1) (len 315,vlan 0, port 1, encap 0xec03)
*DHCP Socket Task: Dec 10 12:20:16.987: cc:3a:61:6d:05:2e DHCP (encap type 0xec03) mstype 0ff:ff:ff:ff:ff:ff
*DHCP Socket Task: Dec 10 12:20:16.987: cc:3a:61:6d:05:2e DHCP dropping packet due to ongoing mobility handshake exchange, (siaddr 0.0.0.0, mobility state = 'apfMsMmQueryRequested'
*osapiBsnTimer: Dec 10 12:20:18.657: cc:3a:61:6d:05:2e apfMsExpireCallback (apf_ms.c:637) Expiring Mobile!
*apfReceiveTask: Dec 10 12:20:18.657: cc:3a:61:6d:05:2e Scheduling deletion of Mobile Station: (callerId: 46) in 60 seconds
*apfReceiveTask: Dec 10 12:20:18.657: cc:3a:61:6d:05:2e apfMsExpireMobileStation (apf_ms.c:7193) Changing state for mobile cc:3a:61:6d:05:2e on AP 54:78:1a:d0:16:50 from Exclusion-list (1) to Exclusion-list (2)

*apfReceiveTask: Dec 10 12:20:18.657: cc:3a:61:6d:05:2e pemApfDeleteMobileStation2: APF_MS_PEM_WAIT_L2_AUTH_COMPLETE = 0.
*apfReceiveTask: Dec 10 12:20:18.657: cc:3a:61:6d:05:2e 0.0.0.0 DHCP_REQD (7) Deleted mobile LWAPP rule on AP [54:78:1a:d0:16:50]
*pemReceiveTask: Dec 10 12:20:18.658: cc:3a:61:6d:05:2e 0.0.0.0 Removed NPU entry.
*apfMsConnTask_0: Dec 10 12:20:18.726: cc:3a:61:6d:05:2e Processing assoc-req station:cc:3a:61:6d:05:2e AP:54:78:1a:d0:16:50-00 thread:15146c90
*apfMsConnTask_0: Dec 10 12:20:18.727: cc:3a:61:6d:05:2e Ignoring assoc request due to mobile in exclusion list or marked for deletion
*apfMsConnTask_0: Dec 10 12:20:19.045: cc:3a:61:6d:05:2e Processing assoc-req station:cc:3a:61:6d:05:2e AP:54:78:1a:d0:16:50-00 thread:15146c90
*apfMsConnTask_0: Dec 10 12:20:19.045: cc:3a:61:6d:05:2e Ignoring assoc request due to mobile in exclusion list or marked for deletion
*apfMsConnTask_0: Dec 10 12:20:19.363: cc:3a:61:6d:05:2e Processing assoc-req station:cc:3a:61:6d:05:2e AP:54:78:1a:d0:16:50-00 thread:15146c90
*apfMsConnTask_0: Dec 10 12:20:19.363: cc:3a:61:6d:05:2e Ignoring assoc request due to mobile in exclusion list or marked for deletion
*apfMsConnTask_0: Dec 10 12:20:19.681: cc:3a:61:6d:05:2e Processing assoc-req station:cc:3a:61:6d:05:2e AP:54:78:1a:d0:16:50-00 thread:15146c90
*apfMsConnTask_0: Dec 10 12:20:19.681: cc:3a:61:6d:05:2e Ignoring assoc request due to mobile in exclusion list or marked for deletion
*apfMsConnTask_0: Dec 10 12:20:19.999: cc:3a:61:6d:05:2e Processing assoc-req station:cc:3a:61:6d:05:2e AP:54:78:1a:d0:16:50-00 thread:15146c90
*apfMsConnTask_0: Dec 10 12:20:19.999: cc:3a:61:6d:05:2e Ignoring assoc request due to mobile in exclusion list or marked for deletion
*apfMsConnTask_0: Dec 10 12:20:20.317: cc:3a:61:6d:05:2e Processing assoc-req station:cc:3a:61:6d:05:2e AP:54:78:1a:d0:16:50-00 thread:15146c90
*apfMsConnTask_0: Dec 10 12:20:20.317: cc:3a:61:6d:05:2e Ignoring assoc request due to mobile in exclusion list or marked for deletion
(Cisco Controller) >show exclusionlist


Dynamically Disabled Clients
----------------------------
MAC Address Exclusion Reason Time Remaining (in secs)
----------- ---------------- ------------------------

c0:bd:d1:74:52:e2 802.11 Assoc Failure 12



(Cisco Controller) >debug client cc:3a:61:6d:05:2e

(Cisco Controller) >*Dot1x_NW_MsgTask_2: Dec 10 13:32:01.202: CCKM: Sending CCKM PMK (Version_2) information to mobility group
*apfReceiveTask: Dec 10 13:32:01.210: Handoff 802.1x PEM state 0, client state 20, client 172.30.17.183

*Dot1x_NW_MsgTask_4: Dec 10 13:32:13.866: CCKM: Sending CCKM PMK (Version_2) information to mobility group
*Dot1x_NW_MsgTask_2: Dec 10 13:32:34.075: CCKM: Sending CCKM PMK (Version_2) information to mobility group

(Cisco Controller) >*Dot1x_NW_MsgTask_2: Dec 10 13:32:45.994: CCKM: Sending CCKM PMK (Version_2) information to mobility group
*Dot1x_NW_MsgTask_0: Dec 10 13:32:47.085: CCKM: Sending CCKM PMK (Version_2) information to mobility group

(Cisco Controller) >*Dot1x_NW_MsgTask_4: Dec 10 13:32:52.076: CCKM: Sending CCKM PMK (Version_2) information to mobility group
*apfReceiveTask: Dec 10 13:32:56.451: Handoff 802.1x PEM state 0, client state 20, client 172.30.34.244

*apfMsConnTask_0: Dec 10 13:33:06.125: cc:3a:61:6d:05:2e Processing assoc-req station:cc:3a:61:6d:05:2e AP:54:78:1a:d0:16:50-00 thread:15146c90
*apfMsConnTask_0: Dec 10 13:33:06.125: cc:3a:61:6d:05:2e Adding mobile on LWAPP AP 54:78:1a:d0:16:50(0)
*apfMsConnTask_0: Dec 10 13:33:06.125: cc:3a:61:6d:05:2e Association received from mobile on BSSID 54:78:1a:d0:16:51 AP AP-ITC007
*apfMsConnTask_0: Dec 10 13:33:06.125: cc:3a:61:6d:05:2e Global 200 Clients are allowed to AP radio

*apfMsConnTask_0: Dec 10 13:33:06.125: cc:3a:61:6d:05:2e Max Client Trap Threshold: 0 cur: 3

*apfMsConnTask_0: Dec 10 13:33:06.125: cc:3a:61:6d:05:2e Rf profile 600 Clients are allowed to AP wlan

*apfMsConnTask_0: Dec 10 13:33:06.126: cc:3a:61:6d:05:2e override for default ap group, marking intgrp NULL
*apfMsConnTask_0: Dec 10 13:33:06.126: cc:3a:61:6d:05:2e Applying Interface policy on Mobile, role Unassociated. Ms NAC State 0 Quarantine Vlan 0 Access Vlan 0

*apfMsConnTask_0: Dec 10 13:33:06.126: cc:3a:61:6d:05:2e Re-applying interface policy for client

*apfMsConnTask_0: Dec 10 13:33:06.126: cc:3a:61:6d:05:2e 0.0.0.0 START (0) Changing IPv4 ACL 'none' (ACL ID 255) ===> 'none' (ACL ID 255) --- (caller apf_policy.c:2435)
*apfMsConnTask_0: Dec 10 13:33:06.126: cc:3a:61:6d:05:2e 0.0.0.0 START (0) Changing IPv6 ACL 'none' (ACL ID 255) ===> 'none' (ACL ID 255) --- (caller apf_policy.c:2456)
*apfMsConnTask_0: Dec 10 13:33:06.126: cc:3a:61:6d:05:2e Values before applying NASID - interfacetype:0, ovrd:0, mscb nasid:, interface nasid:
*apfMsConnTask_0: Dec 10 13:33:06.126: cc:3a:61:6d:05:2e apfApplyWlanPolicy: Apply WLAN Policy over PMIPv6 Client Mobility Type
*apfMsConnTask_0: Dec 10 13:33:06.126: cc:3a:61:6d:05:2e Check before Setting the NAS Id to WLAN specific Id ''
*apfMsConnTask_0: Dec 10 13:33:06.126: cc:3a:61:6d:05:2e Applying site-specific Local Bridging override for station cc:3a:61:6d:05:2e - vapId 2, site 'default-group', interface 'management'
*apfMsConnTask_0: Dec 10 13:33:06.126: cc:3a:61:6d:05:2e Applying Local Bridging Interface Policy for station cc:3a:61:6d:05:2e - vlan 0, interface id 0, interface 'management', nasId:''
*apfMsConnTask_0: Dec 10 13:33:06.126: cc:3a:61:6d:05:2e processSsidIE statusCode is 0 and status is 0
*apfMsConnTask_0: Dec 10 13:33:06.126: cc:3a:61:6d:05:2e processSsidIE ssid_done_flag is 0 finish_flag is 0
*apfMsConnTask_0: Dec 10 13:33:06.126: cc:3a:61:6d:05:2e STA - rates (8): 130 132 139 150 36 48 72 108 0 0 0 0 0 0 0 0
*apfMsConnTask_0: Dec 10 13:33:06.126: cc:3a:61:6d:05:2e suppRates statusCode is 0 and gotSuppRatesElement is 1
*apfMsConnTask_0: Dec 10 13:33:06.126: cc:3a:61:6d:05:2e STA - rates (12): 130 132 139 150 36 48 72 108 12 18 24 96 0 0 0 0
*apfMsConnTask_0: Dec 10 13:33:06.126: cc:3a:61:6d:05:2e extSuppRates statusCode is 0 and gotExtSuppRatesElement is 1
*apfMsConnTask_0: Dec 10 13:33:06.126: cc:3a:61:6d:05:2e Process P2P IE And Update CB on BSSID 54:78:1a:d0:16:50 slot 0
*apfMsConnTask_0: Dec 10 13:33:06.126: cc:3a:61:6d:05:2e Parse P2P IE And Update CB on BSSID 54:78:1a:d0:16:50 slot 0
*apfMsConnTask_0: Dec 10 13:33:06.126: RSNIE in Assoc. Req.: (38)

*apfMsConnTask_0: Dec 10 13:33:06.126: [0000] 01 00 00 0f ac 02 01 00 00 0f ac 04 01 00 00 40

*apfMsConnTask_0: Dec 10 13:33:06.126: [0016] 96 00 00 00 01 00 92 0a 07 5a d2 55 b9 92 15 a0

*apfMsConnTask_0: Dec 10 13:33:06.126: [0032] 3e 58 67 d1 75 be

*apfMsConnTask_0: Dec 10 13:33:06.126: cc:3a:61:6d:05:2e Processing RSN IE type 48, length 38 for mobile cc:3a:61:6d:05:2e
*apfMsConnTask_0: Dec 10 13:33:06.126: cc:3a:61:6d:05:2e CCKM: Mobile is using CCKM
*apfMsConnTask_0: Dec 10 13:33:06.126: cc:3a:61:6d:05:2e RSN Capabilities: 0
*apfMsConnTask_0: Dec 10 13:33:06.126: cc:3a:61:6d:05:2e Marking Mobile as non-11w Capable
*apfMsConnTask_0: Dec 10 13:33:06.126: cc:3a:61:6d:05:2e Received RSN IE with 1 PMKIDs from mobile cc:3a:61:6d:05:2e
*apfMsConnTask_0: Dec 10 13:33:06.126: Received PMKID: (16)

*apfMsConnTask_0: Dec 10 13:33:06.126: [0000] 92 0a 07 5a d2 55 b9 92 15 a0 3e 58 67 d1 75 be

*apfMsConnTask_0: Dec 10 13:33:06.126: cc:3a:61:6d:05:2e Searching for PMKID in MSCB PMKID cache for mobile cc:3a:61:6d:05:2e
*apfMsConnTask_0: Dec 10 13:33:06.126: cc:3a:61:6d:05:2e No valid PMKID found in the MSCB PMKID cache for mobile cc:3a:61:6d:05:2e
*apfMsConnTask_0: Dec 10 13:33:06.127: cc:3a:61:6d:05:2e Trying to compute a PMKID from MSCB PMK cache for mobile cc:3a:61:6d:05:2e
*apfMsConnTask_0: Dec 10 13:33:06.127: CCKM: Find PMK in cache: BSSID = (6)

*apfMsConnTask_0: Dec 10 13:33:06.127: [0000] 54 78 1a d0 16 50

*apfMsConnTask_0: Dec 10 13:33:06.127: CCKM: Find PMK in cache: realAA = (6)

*apfMsConnTask_0: Dec 10 13:33:06.127: [0000] 54 78 1a d0 16 51

*apfMsConnTask_0: Dec 10 13:33:06.127: CCKM: Find PMK in cache: PMKID = (16)

*apfMsConnTask_0: Dec 10 13:33:06.127: [0000] 92 0a 07 5a d2 55 b9 92 15 a0 3e 58 67 d1 75 be

*apfMsConnTask_0: Dec 10 13:33:06.127: cc:3a:61:6d:05:2e Unable to compute a valid PMKID from MSCB PMK cache for mobile cc:3a:61:6d:05:2e
*apfMsConnTask_0: Dec 10 13:33:06.127: cc:3a:61:6d:05:2e Searching for PMK in global PMK cache for mobile cc:3a:61:6d:05:2e
*apfMsConnTask_0: Dec 10 13:33:06.127: cc:3a:61:6d:05:2e Unable to compute a valid PMKID from global PMK cache for mobile cc:3a:61:6d:05:2e
*apfMsConnTask_0: Dec 10 13:33:06.127: cc:3a:61:6d:05:2e Setting active key cache index 8 ---> 8
*apfMsConnTask_0: Dec 10 13:33:06.127: cc:3a:61:6d:05:2e unsetting PmkIdValidatedByAp
*apfMsConnTask_0: Dec 10 13:33:06.127: cc:3a:61:6d:05:2e 0.0.0.0 START (0) Initializing policy
*apfMsConnTask_0: Dec 10 13:33:06.127: cc:3a:61:6d:05:2e 0.0.0.0 START (0) Change state to AUTHCHECK (2) last state START (0)

*apfMsConnTask_0: Dec 10 13:33:06.127: cc:3a:61:6d:05:2e 0.0.0.0 AUTHCHECK (2) Change state to 8021X_REQD (3) last state AUTHCHECK (2)

*apfMsConnTask_0: Dec 10 13:33:06.127: cc:3a:61:6d:05:2e Encryption policy is set to 0x80000001
*apfMsConnTask_0: Dec 10 13:33:06.127: cc:3a:61:6d:05:2e Not Using WMM Compliance code qosCap 00
*apfMsConnTask_0: Dec 10 13:33:06.127: cc:3a:61:6d:05:2e 0.0.0.0 8021X_REQD (3) Plumbed mobile LWAPP rule on AP 54:78:1a:d0:16:50 vapId 2 apVapId 2 flex-acl-name:
*apfMsConnTask_0: Dec 10 13:33:06.127: cc:3a:61:6d:05:2e apfMsAssoStateInc
*apfMsConnTask_0: Dec 10 13:33:06.127: cc:3a:61:6d:05:2e apfPemAddUser2 (apf_policy.c:353) Changing state for mobile cc:3a:61:6d:05:2e on AP 54:78:1a:d0:16:50 from Idle to Associated

*apfMsConnTask_0: Dec 10 13:33:06.127: cc:3a:61:6d:05:2e apfPemAddUser2:session timeout forstation cc:3a:61:6d:05:2e - Session Tout 0, apfMsTimeOut '0' and sessionTimerRunning flag is 0
*apfMsConnTask_0: Dec 10 13:33:06.127: cc:3a:61:6d:05:2e Stopping deletion of Mobile Station: (callerId: 48)
*apfMsConnTask_0: Dec 10 13:33:06.127: cc:3a:61:6d:05:2e Func: apfPemAddUser2, Ms Timeout = 0, Session Timeout = 0

*apfMsConnTask_0: Dec 10 13:33:06.127: cc:3a:61:6d:05:2e Sending assoc-resp with status 0 station:cc:3a:61:6d:05:2e AP:54:78:1a:d0:16:50-00 on apVapId 2
*apfMsConnTask_0: Dec 10 13:33:06.127: cc:3a:61:6d:05:2e Send Assoc Resp Msg to WFD Client
*apfMsConnTask_0: Dec 10 13:33:06.127: cc:3a:61:6d:05:2e Send Assoc resp Msg to WFD ClientAdd P2P Ie hdr
*apfMsConnTask_0: Dec 10 13:33:06.127: cc:3a:61:6d:05:2e Send Assoc Msg to WFD ClientAdd Attribute to P2P Ie
*apfMsConnTask_0: Dec 10 13:33:06.128: cc:3a:61:6d:05:2e Sending Assoc Response to station on BSSID 54:78:1a:d0:16:51 (status 0) ApVapId 2 Slot 0
*apfMsConnTask_0: Dec 10 13:33:06.128: cc:3a:61:6d:05:2e apfProcessAssocReq (apf_80211.c:9582) Changing state for mobile cc:3a:61:6d:05:2e on AP 54:78:1a:d0:16:50 from Associated to Associated

*spamApTask1: Dec 10 13:33:06.134: cc:3a:61:6d:05:2e Sent 1x initiate message to multi thread task for mobile cc:3a:61:6d:05:2e
*Dot1x_NW_MsgTask_6: Dec 10 13:33:06.134: cc:3a:61:6d:05:2e reauth_sm state transition 0 ---> 1 for mobile cc:3a:61:6d:05:2e at 1x_reauth_sm.c:47
*Dot1x_NW_MsgTask_6: Dec 10 13:33:06.134: cc:3a:61:6d:05:2e EAP-PARAM Debug - eap-params for Wlan-Id :2 is disabled - applying Global eap timers and retries
*Dot1x_NW_MsgTask_6: Dec 10 13:33:06.134: cc:3a:61:6d:05:2e Disable re-auth, use PMK lifetime.
*Dot1x_NW_MsgTask_6: Dec 10 13:33:06.134: cc:3a:61:6d:05:2e Station cc:3a:61:6d:05:2e setting dot1x reauth timeout = 1800
*Dot1x_NW_MsgTask_6: Dec 10 13:33:06.134: cc:3a:61:6d:05:2e dot1x - moving mobile cc:3a:61:6d:05:2e into Connecting state
*Dot1x_NW_MsgTask_6: Dec 10 13:33:06.134: cc:3a:61:6d:05:2e Sending EAP-Request/Identity to mobile cc:3a:61:6d:05:2e (EAP Id 1)
*Dot1x_NW_MsgTask_6: Dec 10 13:33:06.143: cc:3a:61:6d:05:2e Received EAPOL EAPPKT from mobile cc:3a:61:6d:05:2e
*Dot1x_NW_MsgTask_6: Dec 10 13:33:06.143: cc:3a:61:6d:05:2e Received Identity Response (count=1) from mobile cc:3a:61:6d:05:2e
*Dot1x_NW_MsgTask_6: Dec 10 13:33:06.143: cc:3a:61:6d:05:2e Resetting reauth count 1 to 0 for mobile cc:3a:61:6d:05:2e
*Dot1x_NW_MsgTask_6: Dec 10 13:33:06.143: cc:3a:61:6d:05:2e EAP State update from Connecting to Authenticating for mobile cc:3a:61:6d:05:2e
*Dot1x_NW_MsgTask_6: Dec 10 13:33:06.143: cc:3a:61:6d:05:2e dot1x - moving mobile cc:3a:61:6d:05:2e into Authenticating state
*Dot1x_NW_MsgTask_6: Dec 10 13:33:06.143: cc:3a:61:6d:05:2e Entering Backend Auth Response state for mobile cc:3a:61:6d:05:2e
*Dot1x_NW_MsgTask_6: Dec 10 13:33:06.143: cc:3a:61:6d:05:2e Created Acct-Session-ID (584be7f2/cc:3a:61:6d:05:2e/1101658) for the mobile
*Dot1x_NW_MsgTask_6: Dec 10 13:33:06.145: cc:3a:61:6d:05:2e Processing Access-Challenge for mobile cc:3a:61:6d:05:2e
*Dot1x_NW_MsgTask_6: Dec 10 13:33:06.145: cc:3a:61:6d:05:2e Entering Backend Auth Req state (id=242) for mobile cc:3a:61:6d:05:2e
*Dot1x_NW_MsgTask_6: Dec 10 13:33:06.145: cc:3a:61:6d:05:2e WARNING: updated EAP-Identifier 1 ===> 242 for STA cc:3a:61:6d:05:2e
*Dot1x_NW_MsgTask_6: Dec 10 13:33:06.145: cc:3a:61:6d:05:2e Sending EAP Request from AAA to mobile cc:3a:61:6d:05:2e (EAP Id 242)
*Dot1x_NW_MsgTask_6: Dec 10 13:33:06.146: cc:3a:61:6d:05:2e Allocating EAP Pkt for retransmission to mobile cc:3a:61:6d:05:2e
*Dot1x_NW_MsgTask_6: Dec 10 13:33:06.150: cc:3a:61:6d:05:2e Received EAPOL EAPPKT from mobile cc:3a:61:6d:05:2e
*Dot1x_NW_MsgTask_6: Dec 10 13:33:06.150: cc:3a:61:6d:05:2e Received EAP Response from mobile cc:3a:61:6d:05:2e (EAP Id 242, EAP Type 25)
*Dot1x_NW_MsgTask_6: Dec 10 13:33:06.150: cc:3a:61:6d:05:2e Resetting reauth count 0 to 0 for mobile cc:3a:61:6d:05:2e
*Dot1x_NW_MsgTask_6: Dec 10 13:33:06.150: cc:3a:61:6d:05:2e Entering Backend Auth Response state for mobile cc:3a:61:6d:05:2e
*Dot1x_NW_MsgTask_6: Dec 10 13:33:06.153: cc:3a:61:6d:05:2e Processing Access-Challenge for mobile cc:3a:61:6d:05:2e
*Dot1x_NW_MsgTask_6: Dec 10 13:33:06.153: cc:3a:61:6d:05:2e Entering Backend Auth Req state (id=243) for mobile cc:3a:61:6d:05:2e
*Dot1x_NW_MsgTask_6: Dec 10 13:33:06.153: cc:3a:61:6d:05:2e Sending EAP Request from AAA to mobile cc:3a:61:6d:05:2e (EAP Id 243)
*Dot1x_NW_MsgTask_6: Dec 10 13:33:06.153: cc:3a:61:6d:05:2e Reusing allocated memory for EAP Pkt for retransmission to mobile cc:3a:61:6d:05:2e
*Dot1x_NW_MsgTask_6: Dec 10 13:33:06.164: cc:3a:61:6d:05:2e Received EAPOL EAPPKT from mobile cc:3a:61:6d:05:2e
*Dot1x_NW_MsgTask_6: Dec 10 13:33:06.164: cc:3a:61:6d:05:2e Received EAP Response from mobile cc:3a:61:6d:05:2e (EAP Id 243, EAP Type 25)
*Dot1x_NW_MsgTask_6: Dec 10 13:33:06.164: cc:3a:61:6d:05:2e Resetting reauth count 0 to 0 for mobile cc:3a:61:6d:05:2e
*Dot1x_NW_MsgTask_6: Dec 10 13:33:06.164: cc:3a:61:6d:05:2e Entering Backend Auth Response state for mobile cc:3a:61:6d:05:2e
*Dot1x_NW_MsgTask_6: Dec 10 13:33:06.166: cc:3a:61:6d:05:2e Processing Access-Challenge for mobile cc:3a:61:6d:05:2e
*Dot1x_NW_MsgTask_6: Dec 10 13:33:06.166: cc:3a:61:6d:05:2e Entering Backend Auth Req state (id=244) for mobile cc:3a:61:6d:05:2e
*Dot1x_NW_MsgTask_6: Dec 10 13:33:06.166: cc:3a:61:6d:05:2e Sending EAP Request from AAA to mobile cc:3a:61:6d:05:2e (EAP Id 244)

(Cisco Controller) >
(Cisco Controller) >*Dot1x_NW_MsgTask_6: Dec 10 13:33:06.166: cc:3a:61:6d:05:2e Reusing allocated memory for EAP Pkt for retransmission to mobile cc:3a:61:6d:05:2e
*Dot1x_NW_MsgTask_6: Dec 10 13:33:06.179: cc:3a:61:6d:05:2e Received EAPOL EAPPKT from mobile cc:3a:61:6d:05:2e
*Dot1x_NW_MsgTask_6: Dec 10 13:33:06.179: cc:3a:61:6d:05:2e Received EAP Response from mobile cc:3a:61:6d:05:2e (EAP Id 244, EAP Type 25)
*Dot1x_NW_MsgTask_6: Dec 10 13:33:06.179: cc:3a:61:6d:05:2e Resetting reauth count 0 to 0 for mobile cc:3a:61:6d:05:2e
*Dot1x_NW_MsgTask_6: Dec 10 13:33:06.179: cc:3a:61:6d:05:2e Entering Backend Auth Response state for mobile cc:3a:61:6d:05:2e
*Dot1x_NW_MsgTask_6: Dec 10 13:33:06.184: cc:3a:61:6d:05:2e Processing Access-Challenge for mobile cc:3a:61:6d:05:2e
*Dot1x_NW_MsgTask_6: Dec 10 13:33:06.184: cc:3a:61:6d:05:2e Entering Backend Auth Req state (id=245) for mobile cc:3a:61:6d:05:2e
*Dot1x_NW_MsgTask_6: Dec 10 13:33:06.184: cc:3a:61:6d:05:2e Sending EAP Request from AAA to mobile cc:3a:61:6d:05:2e (EAP Id 245)
*Dot1x_NW_MsgTask_6: Dec 10 13:33:06.184: cc:3a:61:6d:05:2e Reusing allocated memory for EAP Pkt for retransmission to mobile cc:3a:61:6d:05:2e
*Dot1x_NW_MsgTask_6: Dec 10 13:33:06.197: cc:3a:61:6d:05:2e Received EAPOL EAPPKT from mobile cc:3a:61:6d:05:2e
*Dot1x_NW_MsgTask_6: Dec 10 13:33:06.197: cc:3a:61:6d:05:2e Received EAP Response from mobile cc:3a:61:6d:05:2e (EAP Id 245, EAP Type 25)
*Dot1x_NW_MsgTask_6: Dec 10 13:33:06.197: cc:3a:61:6d:05:2e Resetting reauth count 0 to 0 for mobile cc:3a:61:6d:05:2e
*Dot1x_NW_MsgTask_6: Dec 10 13:33:06.197: cc:3a:61:6d:05:2e Entering Backend Auth Response state for mobile cc:3a:61:6d:05:2e
*Dot1x_NW_MsgTask_6: Dec 10 13:33:06.206: cc:3a:61:6d:05:2e Processing Access-Challenge for mobile cc:3a:61:6d:05:2e
*Dot1x_NW_MsgTask_6: Dec 10 13:33:06.206: cc:3a:61:6d:05:2e Entering Backend Auth Req state (id=246) for mobile cc:3a:61:6d:05:2e
*Dot1x_NW_MsgTask_6: Dec 10 13:33:06.206: cc:3a:61:6d:05:2e Sending EAP Request from AAA to mobile cc:3a:61:6d:05:2e (EAP Id 246)
*Dot1x_NW_MsgTask_6: Dec 10 13:33:06.206: cc:3a:61:6d:05:2e Reusing allocated memory for EAP Pkt for retransmission to mobile cc:3a:61:6d:05:2e
*Dot1x_NW_MsgTask_6: Dec 10 13:33:06.210: cc:3a:61:6d:05:2e Received EAPOL EAPPKT from mobile cc:3a:61:6d:05:2e
*Dot1x_NW_MsgTask_6: Dec 10 13:33:06.210: cc:3a:61:6d:05:2e Received EAP Response from mobile cc:3a:61:6d:05:2e (EAP Id 246, EAP Type 25)
*Dot1x_NW_MsgTask_6: Dec 10 13:33:06.210: cc:3a:61:6d:05:2e Resetting reauth count 0 to 0 for mobile cc:3a:61:6d:05:2e
*Dot1x_NW_MsgTask_6: Dec 10 13:33:06.210: cc:3a:61:6d:05:2e Entering Backend Auth Response state for mobile cc:3a:61:6d:05:2e
*Dot1x_NW_MsgTask_6: Dec 10 13:33:06.212: cc:3a:61:6d:05:2e Processing Access-Challenge for mobile cc:3a:61:6d:05:2e
*Dot1x_NW_MsgTask_6: Dec 10 13:33:06.212: cc:3a:61:6d:05:2e Entering Backend Auth Req state (id=247) for mobile cc:3a:61:6d:05:2e
*Dot1x_NW_MsgTask_6: Dec 10 13:33:06.212: cc:3a:61:6d:05:2e Sending EAP Request from AAA to mobile cc:3a:61:6d:05:2e (EAP Id 247)
*Dot1x_NW_MsgTask_6: Dec 10 13:33:06.212: cc:3a:61:6d:05:2e Reusing allocated memory for EAP Pkt for retransmission to mobile cc:3a:61:6d:05:2e
*Dot1x_NW_MsgTask_6: Dec 10 13:33:06.216: cc:3a:61:6d:05:2e Received EAPOL EAPPKT from mobile cc:3a:61:6d:05:2e
*Dot1x_NW_MsgTask_6: Dec 10 13:33:06.216: cc:3a:61:6d:05:2e Received EAP Response from mobile cc:3a:61:6d:05:2e (EAP Id 247, EAP Type 25)
*Dot1x_NW_MsgTask_6: Dec 10 13:33:06.216: cc:3a:61:6d:05:2e Resetting reauth count 0 to 0 for mobile cc:3a:61:6d:05:2e
*Dot1x_NW_MsgTask_6: Dec 10 13:33:06.216: cc:3a:61:6d:05:2e Entering Backend Auth Response state for mobile cc:3a:61:6d:05:2e
*Dot1x_NW_MsgTask_6: Dec 10 13:33:06.218: cc:3a:61:6d:05:2e Processing Access-Challenge for mobile cc:3a:61:6d:05:2e
*Dot1x_NW_MsgTask_6: Dec 10 13:33:06.218: cc:3a:61:6d:05:2e Entering Backend Auth Req state (id=248) for mobile cc:3a:61:6d:05:2e
*Dot1x_NW_MsgTask_6: Dec 10 13:33:06.218: cc:3a:61:6d:05:2e Sending EAP Request from AAA to mobile cc:3a:61:6d:05:2e (EAP Id 248)
*Dot1x_NW_MsgTask_6: Dec 10 13:33:06.218: cc:3a:61:6d:05:2e Reusing allocated memory for EAP Pkt for retransmission to mobile cc:3a:61:6d:05:2e
*Dot1x_NW_MsgTask_6: Dec 10 13:33:06.225: cc:3a:61:6d:05:2e Received EAPOL EAPPKT from mobile cc:3a:61:6d:05:2e
*Dot1x_NW_MsgTask_6: Dec 10 13:33:06.225: cc:3a:61:6d:05:2e Received EAP Response from mobile cc:3a:61:6d:05:2e (EAP Id 248, EAP Type 25)
*Dot1x_NW_MsgTask_6: Dec 10 13:33:06.225: cc:3a:61:6d:05:2e Resetting reauth count 0 to 0 for mobile cc:3a:61:6d:05:2e
*Dot1x_NW_MsgTask_6: Dec 10 13:33:06.225: cc:3a:61:6d:05:2e Entering Backend Auth Response state for mobile cc:3a:61:6d:05:2e
*Dot1x_NW_MsgTask_6: Dec 10 13:33:06.264: cc:3a:61:6d:05:2e Processing Access-Challenge for mobile cc:3a:61:6d:05:2e
*Dot1x_NW_MsgTask_6: Dec 10 13:33:06.264: cc:3a:61:6d:05:2e Entering Backend Auth Req state (id=249) for mobile cc:3a:61:6d:05:2e
*Dot1x_NW_MsgTask_6: Dec 10 13:33:06.264: cc:3a:61:6d:05:2e Sending EAP Request from AAA to mobile cc:3a:61:6d:05:2e (EAP Id 249)
*Dot1x_NW_MsgTask_6: Dec 10 13:33:06.264: cc:3a:61:6d:05:2e Reusing allocated memory for EAP Pkt for retransmission to mobile cc:3a:61:6d:05:2e
*Dot1x_NW_MsgTask_6: Dec 10 13:33:06.268: cc:3a:61:6d:05:2e Received EAPOL EAPPKT from mobile cc:3a:61:6d:05:2e
*Dot1x_NW_MsgTask_6: Dec 10 13:33:06.268: cc:3a:61:6d:05:2e Received EAP Response from mobile cc:3a:61:6d:05:2e (EAP Id 249, EAP Type 25)
*Dot1x_NW_MsgTask_6: Dec 10 13:33:06.269: cc:3a:61:6d:05:2e Resetting reauth count 0 to 0 for mobile cc:3a:61:6d:05:2e
*Dot1x_NW_MsgTask_6: Dec 10 13:33:06.269: cc:3a:61:6d:05:2e Entering Backend Auth Response state for mobile cc:3a:61:6d:05:2e
*Dot1x_NW_MsgTask_6: Dec 10 13:33:06.271: cc:3a:61:6d:05:2e Processing Access-Challenge for mobile cc:3a:61:6d:05:2e
*Dot1x_NW_MsgTask_6: Dec 10 13:33:06.271: cc:3a:61:6d:05:2e Entering Backend Auth Req state (id=250) for mobile cc:3a:61:6d:05:2e
*Dot1x_NW_MsgTask_6: Dec 10 13:33:06.271: cc:3a:61:6d:05:2e Sending EAP Request from AAA to mobile cc:3a:61:6d:05:2e (EAP Id 250)
*Dot1x_NW_MsgTask_6: Dec 10 13:33:06.271: cc:3a:61:6d:05:2e Reusing allocated memory for EAP Pkt for retransmission to mobile cc:3a:61:6d:05:2e
*Dot1x_NW_MsgTask_6: Dec 10 13:33:06.275: cc:3a:61:6d:05:2e Received EAPOL EAPPKT from mobile cc:3a:61:6d:05:2e
*Dot1x_NW_MsgTask_6: Dec 10 13:33:06.275: cc:3a:61:6d:05:2e Received EAP Response from mobile cc:3a:61:6d:05:2e (EAP Id 250, EAP Type 25)
*Dot1x_NW_MsgTask_6: Dec 10 13:33:06.275: cc:3a:61:6d:05:2e Resetting reauth count 0 to 0 for mobile cc:3a:61:6d:05:2e
*Dot1x_NW_MsgTask_6: Dec 10 13:33:06.275: cc:3a:61:6d:05:2e Entering Backend Auth Response state for mobile cc:3a:61:6d:05:2e
*Dot1x_NW_MsgTask_6: Dec 10 13:33:06.278: cc:3a:61:6d:05:2e Processing Access-Accept for mobile cc:3a:61:6d:05:2e
*Dot1x_NW_MsgTask_6: Dec 10 13:33:06.278: cc:3a:61:6d:05:2e Resetting web IPv4 acl from 255 to 255

*Dot1x_NW_MsgTask_6: Dec 10 13:33:06.278: cc:3a:61:6d:05:2e Resetting web IPv4 Flex acl from 65535 to 65535

*Dot1x_NW_MsgTask_6: Dec 10 13:33:06.278: cc:3a:61:6d:05:2e Username entry (f3783) created for mobile, length = 253
*Dot1x_NW_MsgTask_6: Dec 10 13:33:06.278: cc:3a:61:6d:05:2e Username entry (f3783) created in mscb for mobile, length = 253
*Dot1x_NW_MsgTask_6: Dec 10 13:33:06.278: cc:3a:61:6d:05:2e Found an interface name:'vlan14' corresponds to interface name received: vlan14
*Dot1x_NW_MsgTask_6: Dec 10 13:33:06.278: cc:3a:61:6d:05:2e override for default ap group, marking intgrp NULL
*Dot1x_NW_MsgTask_6: Dec 10 13:33:06.278: cc:3a:61:6d:05:2e Applying Interface policy on Mobile, role Unassociated. Ms NAC State 2 Quarantine Vlan 0 Access Vlan 0

*Dot1x_NW_MsgTask_6: Dec 10 13:33:06.278: cc:3a:61:6d:05:2e Re-applying interface policy for client

*Dot1x_NW_MsgTask_6: Dec 10 13:33:06.279: cc:3a:61:6d:05:2e 0.0.0.0 8021X_REQD (3) Changing IPv4 ACL 'none' (ACL ID 255) ===> 'none' (ACL ID 255) --- (caller apf_policy.c:2435)
*Dot1x_NW_MsgTask_6: Dec 10 13:33:06.279: cc:3a:61:6d:05:2e 0.0.0.0 8021X_REQD (3) Changing IPv6 ACL 'none' (ACL ID 255) ===> 'none' (ACL ID 255) --- (caller apf_policy.c:2456)
*Dot1x_NW_MsgTask_6: Dec 10 13:33:06.279: cc:3a:61:6d:05:2e Values before applying NASID - interfacetype:0, ovrd:0, mscb nasid:, interface nasid:
*Dot1x_NW_MsgTask_6: Dec 10 13:33:06.279: cc:3a:61:6d:05:2e apfApplyWlanPolicy: Apply WLAN Policy over PMIPv6 Client Mobility Type
*Dot1x_NW_MsgTask_6: Dec 10 13:33:06.279: cc:3a:61:6d:05:2e Check before Setting the NAS Id to WLAN specific Id ''
*Dot1x_NW_MsgTask_6: Dec 10 13:33:06.279: cc:3a:61:6d:05:2e Inserting AAA Override struct for mobile
MAC: cc:3a:61:6d:05:2e, source 4

*Dot1x_NW_MsgTask_6: Dec 10 13:33:06.279: cc:3a:61:6d:05:2e Applying override policy from source Override Summation: with value 201

*Dot1x_NW_MsgTask_6: Dec 10 13:33:06.279: cc:3a:61:6d:05:2e Found an interface name:'vlan14' corresponds to interface name received: vlan14
*Dot1x_NW_MsgTask_6: Dec 10 13:33:06.279: cc:3a:61:6d:05:2e Applying Interface policy on Mobile, role Unassociated. Ms NAC State 2 Quarantine Vlan 0 Access Vlan 0

*Dot1x_NW_MsgTask_6: Dec 10 13:33:06.279: cc:3a:61:6d:05:2e Re-applying interface policy for client

*Dot1x_NW_MsgTask_6: Dec 10 13:33:06.279: cc:3a:61:6d:05:2e 0.0.0.0 8021X_REQD (3) Changing IPv4 ACL 'none' (ACL ID 255) ===> 'none' (ACL ID 255) --- (caller apf_policy.c:2435)
*Dot1x_NW_MsgTask_6: Dec 10 13:33:06.279: cc:3a:61:6d:05:2e 0.0.0.0 8021X_REQD (3) Changing IPv6 ACL 'none' (ACL ID 255) ===> 'none' (ACL ID 255) --- (caller apf_policy.c:2456)
*Dot1x_NW_MsgTask_6: Dec 10 13:33:06.279: cc:3a:61:6d:05:2e Values before applying NASID - interfacetype:3, ovrd:1, mscb nasid:, interface nasid:
*Dot1x_NW_MsgTask_6: Dec 10 13:33:06.279: cc:3a:61:6d:05:2e AAA override is enabled and interface doesnot exist use the VLAN id in the nac payload 14 for cc:3a:61:6d:05:2e
*Dot1x_NW_MsgTask_6: Dec 10 13:33:06.279: cc:3a:61:6d:05:2e Setting re-auth timeout to 1800 seconds, got from WLAN config.
*Dot1x_NW_MsgTask_6: Dec 10 13:33:06.279: cc:3a:61:6d:05:2e Station cc:3a:61:6d:05:2e setting dot1x reauth timeout = 1800
*Dot1x_NW_MsgTask_6: Dec 10 13:33:06.279: cc:3a:61:6d:05:2e Creating a PKC PMKID Cache entry for station cc:3a:61:6d:05:2e (RSN 2)
*Dot1x_NW_MsgTask_6: Dec 10 13:33:06.279: cc:3a:61:6d:05:2e Resetting MSCB PMK Cache Entry 0 for station cc:3a:61:6d:05:2e
*Dot1x_NW_MsgTask_6: Dec 10 13:33:06.279: cc:3a:61:6d:05:2e Setting active key cache index 8 ---> 8
*Dot1x_NW_MsgTask_6: Dec 10 13:33:06.279: cc:3a:61:6d:05:2e Setting active key cache index 8 ---> 0
*Dot1x_NW_MsgTask_6: Dec 10 13:33:06.279: cc:3a:61:6d:05:2e Adding BSSID 54:78:1a:d0:16:51 to PMKID cache at index 0 for station cc:3a:61:6d:05:2e
*Dot1x_NW_MsgTask_6: Dec 10 13:33:06.279: New PMKID: (16)

*Dot1x_NW_MsgTask_6: Dec 10 13:33:06.279: [0000] 18 f2 6b de d7 1f 71 dd d3 c1 d9 1f 5d 3d d1 44

*Dot1x_NW_MsgTask_6: Dec 10 13:33:06.279: cc:3a:61:6d:05:2e Disabling re-auth since PMK lifetime can take care of same.
*Dot1x_NW_MsgTask_6: Dec 10 13:33:06.279: cc:3a:61:6d:05:2e CCKM: Create a global PMK cache entry
*Dot1x_NW_MsgTask_6: Dec 10 13:33:06.279: cc:3a:61:6d:05:2e unsetting PmkIdValidatedByAp
*Dot1x_NW_MsgTask_6: Dec 10 13:33:06.280: cc:3a:61:6d:05:2e Updating AAA Overrides from local for station
*Dot1x_NW_MsgTask_6: Dec 10 13:33:06.280: cc:3a:61:6d:05:2e Sending EAP-Success to mobile cc:3a:61:6d:05:2e (EAP Id 250)
*Dot1x_NW_MsgTask_6: Dec 10 13:33:06.280: cc:3a:61:6d:05:2e Freeing AAACB from Dot1xCB as AAA auth is done for mobile cc:3a:61:6d:05:2e
*Dot1x_NW_MsgTask_6: Dec 10 13:33:06.280: cc:3a:61:6d:05:2e Found an cache entry for BSSID 54:78:1a:d0:16:51 in PMKID cache at index 0 of station cc:3a:61:6d:05:2e
*Dot1x_NW_MsgTask_6: Dec 10 13:33:06.280: cc:3a:61:6d:05:2e Found an cache entry for BSSID 54:78:1a:d0:16:51 in PMKID cache at index 0 of station cc:3a:61:6d:05:2e
*Dot1x_NW_MsgTask_6: Dec 10 13:33:06.280: Including PMKID in M1 (16)

*Dot1x_NW_MsgTask_6: Dec 10 13:33:06.280: [0000] 18 f2 6b de d7 1f 71 dd d3 c1 d9 1f 5d 3d d1 44

*Dot1x_NW_MsgTask_6: Dec 10 13:33:06.280: cc:3a:61:6d:05:2e Starting key exchange to mobile cc:3a:61:6d:05:2e, data packets will be dropped
*Dot1x_NW_MsgTask_6: Dec 10 13:33:06.280: cc:3a:61:6d:05:2e Sending EAPOL-Key Message to mobile cc:3a:61:6d:05:2e
state INITPMK (message 1), replay counter 00.00.00.00.00.00.00.00
*Dot1x_NW_MsgTask_6: Dec 10 13:33:06.280: cc:3a:61:6d:05:2e Reusing allocated memory for EAP Pkt for retransmission to mobile cc:3a:61:6d:05:2e
*Dot1x_NW_MsgTask_6: Dec 10 13:33:06.280: cc:3a:61:6d:05:2e Entering Backend Auth Success state (id=250) for mobile cc:3a:61:6d:05:2e
*Dot1x_NW_MsgTask_6: Dec 10 13:33:06.280: cc:3a:61:6d:05:2e Received Auth Success while in Authenticating state for mobile cc:3a:61:6d:05:2e
*Dot1x_NW_MsgTask_6: Dec 10 13:33:06.280: cc:3a:61:6d:05:2e dot1x - moving mobile cc:3a:61:6d:05:2e into Authenticated state
*Dot1x_NW_MsgTask_6: Dec 10 13:33:06.291: cc:3a:61:6d:05:2e Received EAPOL-Key from mobile cc:3a:61:6d:05:2e
*Dot1x_NW_MsgTask_6: Dec 10 13:33:06.292: cc:3a:61:6d:05:2e Ignoring invalid EAPOL version (1) in EAPOL-key message from mobile cc:3a:61:6d:05:2e
*Dot1x_NW_MsgTask_6: Dec 10 13:33:06.292: cc:3a:61:6d:05:2e Received EAPOL-key in PTK_START state (message 2) from mobile cc:3a:61:6d:05:2e
*Dot1x_NW_MsgTask_6: Dec 10 13:33:06.292: cc:3a:61:6d:05:2e Dumping RSNIE received in Association request:
*Dot1x_NW_MsgTask_6: Dec 10 13:33:06.292: 00000000: 30 26 01 00 00 0f ac 02 01 00 00 0f ac 04 01 00 0&..............
*Dot1x_NW_MsgTask_6: Dec 10 13:33:06.292: 00000010: 00 40 96 00 00 00 01 00 92 0a 07 5a d2 55 b9 92 .@.........Z.U..
*Dot1x_NW_MsgTask_6: Dec 10 13:33:06.292: 00000020: 15 a0 3e 58 67 d1 75 be ..>Xg.u.
*Dot1x_NW_MsgTask_6: Dec 10 13:33:06.292: cc:3a:61:6d:05:2e Dumping RSNIE received in EAPOL M2 :
*Dot1x_NW_MsgTask_6: Dec 10 13:33:06.292: 00000000: 01 00 00 0f ac 02 01 00 00 0f ac 04 01 00 00 40 ...............@
*Dot1x_NW_MsgTask_6: Dec 10 13:33:06.292: 00000010: 96 00 00 00 01 00 92 0a 07 5a d2 55 b9 92 15 a0 .........Z.U....
*Dot1x_NW_MsgTask_6: Dec 10 13:33:06.292: 00000020: 3e 58 67 d1 75 be >Xg.u.
*Dot1x_NW_MsgTask_6: Dec 10 13:33:06.292: cc:3a:61:6d:05:2e Not Flex client. Do not distribute CCKM Key cache.
*Dot1x_NW_MsgTask_6: Dec 10 13:33:06.292: CCKM: Sending CCKM PMK (Version_2) information to mobility group
*Dot1x_NW_MsgTask_6: Dec 10 13:33:06.293: cc:3a:61:6d:05:2e 7 PMK-update groupcast messages sent
*Dot1x_NW_MsgTask_6: Dec 10 13:33:06.293: cc:3a:61:6d:05:2e Stopping retransmission timer for mobile cc:3a:61:6d:05:2e
*Dot1x_NW_MsgTask_6: Dec 10 13:33:06.293: cc:3a:61:6d:05:2e Sending EAPOL-Key Message to mobile cc:3a:61:6d:05:2e
state PTKINITNEGOTIATING (message 3), replay counter 00.00.00.00.00.00.00.01
*Dot1x_NW_MsgTask_6: Dec 10 13:33:06.293: cc:3a:61:6d:05:2e Reusing allocated memory for EAP Pkt for retransmission to mobile cc:3a:61:6d:05:2e
*Dot1x_NW_MsgTask_6: Dec 10 13:33:06.301: cc:3a:61:6d:05:2e Received EAPOL-Key from mobile cc:3a:61:6d:05:2e
*Dot1x_NW_MsgTask_6: Dec 10 13:33:06.301: cc:3a:61:6d:05:2e Ignoring invalid EAPOL version (1) in EAPOL-key message from mobile cc:3a:61:6d:05:2e
*Dot1x_NW_MsgTask_6: Dec 10 13:33:06.301: cc:3a:61:6d:05:2e Received EAPOL-key in PTKINITNEGOTIATING state (message 4) from mobile cc:3a:61:6d:05:2e
*Dot1x_NW_MsgTask_6: Dec 10 13:33:06.301: cc:3a:61:6d:05:2e Stopping retransmission timer for mobile cc:3a:61:6d:05:2e
*Dot1x_NW_MsgTask_6: Dec 10 13:33:06.301: cc:3a:61:6d:05:2e Freeing EAP Retransmit Bufer for mobile cc:3a:61:6d:05:2e
*Dot1x_NW_MsgTask_6: Dec 10 13:33:06.301: cc:3a:61:6d:05:2e apfMs1xStateInc
*Dot1x_NW_MsgTask_6: Dec 10 13:33:06.301: cc:3a:61:6d:05:2e apfMsPeapSimReqCntInc
*Dot1x_NW_MsgTask_6: Dec 10 13:33:06.301: cc:3a:61:6d:05:2e apfMsPeapSimReqSuccessCntInc
*Dot1x_NW_MsgTask_6: Dec 10 13:33:06.301: cc:3a:61:6d:05:2e 0.0.0.0 8021X_REQD (3) Change state to L2AUTHCOMPLETE (4) last state 8021X_REQD (3)

*Dot1x_NW_MsgTask_6: Dec 10 13:33:06.301: cc:3a:61:6d:05:2e Mobility query, PEM State: L2AUTHCOMPLETE

*Dot1x_NW_MsgTask_6: Dec 10 13:33:06.301: cc:3a:61:6d:05:2e Building Mobile Announce :

*Dot1x_NW_MsgTask_6: Dec 10 13:33:06.301: cc:3a:61:6d:05:2e Building Client Payload:

*Dot1x_NW_MsgTask_6: Dec 10 13:33:06.301: cc:3a:61:6d:05:2e Client Ip: 0.0.0.0

*Dot1x_NW_MsgTask_6: Dec 10 13:33:06.301: cc:3a:61:6d:05:2e Client Vlan Ip: 192.168.14.19, Vlan mask : 255.255.255.0

*Dot1x_NW_MsgTask_6: Dec 10 13:33:06.301: cc:3a:61:6d:05:2e Client Vap Security: 16384

*Dot1x_NW_MsgTask_6: Dec 10 13:33:06.301: cc:3a:61:6d:05:2e Virtual Ip: 1.1.1.1

*Dot1x_NW_MsgTask_6: Dec 10 13:33:06.301: cc:3a:61:6d:05:2e ssid: AL-QUDS-WLAN

*Dot1x_NW_MsgTask_6: Dec 10 13:33:06.301: cc:3a:61:6d:05:2e Building VlanIpPayload.

*Dot1x_NW_MsgTask_6: Dec 10 13:33:06.302: cc:3a:61:6d:05:2e Mobile Announce sent to 1 members of the local group.
*Dot1x_NW_MsgTask_6: Dec 10 13:33:06.302: cc:3a:61:6d:05:2e Not Using WMM Compliance code qosCap 00
*Dot1x_NW_MsgTask_6: Dec 10 13:33:06.302: cc:3a:61:6d:05:2e 0.0.0.0 L2AUTHCOMPLETE (4) Plumbed mobile LWAPP rule on AP 54:78:1a:d0:16:50 vapId 2 apVapId 2 flex-acl-name:
*Dot1x_NW_MsgTask_6: Dec 10 13:33:06.302: cc:3a:61:6d:05:2e 0.0.0.0 L2AUTHCOMPLETE (4) Change state to DHCP_REQD (7) last state L2AUTHCOMPLETE (4)

*Dot1x_NW_MsgTask_6: Dec 10 13:33:06.302: cc:3a:61:6d:05:2e 0.0.0.0 DHCP_REQD (7) pemAdvanceState2 6575, Adding TMP rule
*Dot1x_NW_MsgTask_6: Dec 10 13:33:06.302: cc:3a:61:6d:05:2e 0.0.0.0 DHCP_REQD (7) Adding Fast Path rule
type = Airespace AP - Learn IP address
on AP 54:78:1a:d0:16:50, slot 0, interface = 1, QOS = 0
IPv4 ACL ID = 255, IPv
*Dot1x_NW_MsgTask_6: Dec 10 13:33:06.302: cc:3a:61:6d:05:2e 0.0.0.0 DHCP_REQD (7) Fast Path rule (contd...) 802.1P = 0, DSCP = 0, TokenID = 15206, IntfId = 13 Local Bridging Vlan = 0, Local Bridging intf id = 0
*Dot1x_NW_MsgTask_6: Dec 10 13:33:06.302: cc:3a:61:6d:05:2e 0.0.0.0 DHCP_REQD (7) Fast Path rule (contd...) AVC Ratelimit: AppID = 0 ,AppAction = 0, AppToken = 15206 AverageRate = 0, BurstRate = 0

*Dot1x_NW_MsgTask_6: Dec 10 13:33:06.302: cc:3a:61:6d:05:2e 0.0.0.0 DHCP_REQD (7) Fast Path rule (contd...) AVC Ratelimit: AppID = 0 ,AppAction = 0, AppToken = 15206 AverageRate = 0, BurstRate = 0

*Dot1x_NW_MsgTask_6: Dec 10 13:33:06.302: cc:3a:61:6d:05:2e 0.0.0.0 DHCP_REQD (7) Fast Path rule (contd...) AVC Ratelimit: AppID = 0 ,AppAction = 0, AppToken = 15206 AverageRate = 0, BurstRate = 0

*Dot1x_NW_MsgTask_6: Dec 10 13:33:06.302: cc:3a:61:6d:05:2e 0.0.0.0 DHCP_REQD (7) Successfully plumbed mobile rule (IPv4 ACL ID 255, IPv6 ACL ID 255, L2 ACL ID 255)
*pemReceiveTask: Dec 10 13:33:06.302: cc:3a:61:6d:05:2e 0.0.0.0 Added NPU entry of type 9, dtlFlags 0x0
*apfReceiveTask: Dec 10 13:33:06.303: cc:3a:61:6d:05:2e apfBlacklistMobileStationEntry2 (apf_ms.c:6268) Changing state for mobile cc:3a:61:6d:05:2e on AP 54:78:1a:d0:16:50 from Associated to Exclusion-list (1)

*apfReceiveTask: Dec 10 13:33:06.303: cc:3a:61:6d:05:2e Scheduling deletion of Mobile Station: (callerId: 44) in 10 seconds
*apfReceiveTask: Dec 10 13:33:06.303: cc:3a:61:6d:05:2e HandOff denied as Client is Blacklisted at Peer 0.0.0.0. Adding mobile to exclusion-list due to mobility reporting
*DHCP Socket Task: Dec 10 13:33:06.826: cc:3a:61:6d:05:2e DHCP received op BOOTREQUEST (1) (len 321,vlan 0, port 1, encap 0xec03)
*DHCP Socket Task: Dec 10 13:33:06.826: cc:3a:61:6d:05:2e DHCP (encap type 0xec03) mstype 0ff:ff:ff:ff:ff:ff
*DHCP Socket Task: Dec 10 13:33:06.826: cc:3a:61:6d:05:2e DHCP dropping packet due to ongoing mobility handshake exchange, (siaddr 0.0.0.0, mobility state = 'apfMsMmQueryRequested'
*IPv6_Msg_Task: Dec 10 13:33:08.802: cc:3a:61:6d:05:2e Not Advancing pem state, mscb in apfMsMmQueryRequested mobility state and client state APF_MS_STATE_BLACKLISTED
*DHCP Socket Task: Dec 10 13:33:09.181: cc:3a:61:6d:05:2e DHCP received op BOOTREQUEST (1) (len 321,vlan 0, port 1, encap 0xec03)
*DHCP Socket Task: Dec 10 13:33:09.182: cc:3a:61:6d:05:2e DHCP (encap type 0xec03) mstype 0ff:ff:ff:ff:ff:ff
*DHCP Socket Task: Dec 10 13:33:09.182: cc:3a:61:6d:05:2e DHCP dropping packet due to ongoing mobility handshake exchange, (siaddr 0.0.0.0, mobility state = 'apfMsMmQueryRequested'
*Dot1x_NW_MsgTask_5: Dec 10 13:33:09.441: CCKM: Sending CCKM PMK (Version_2) information to mobility group
*DHCP Socket Task: Dec 10 13:33:10.790: cc:3a:61:6d:05:2e DHCP received op BOOTREQUEST (1) (len 315,vlan 0, port 1, encap 0xec03)
*DHCP Socket Task: Dec 10 13:33:10.791: cc:3a:61:6d:05:2e DHCP (encap type 0xec03) mstype 0ff:ff:ff:ff:ff:ff
*DHCP Socket Task: Dec 10 13:33:10.791: cc:3a:61:6d:05:2e DHCP dropping packet due to ongoing mobility handshake exchange, (siaddr 0.0.0.0, mobility state = 'apfMsMmQueryRequested'
*Apf Guest: Dec 10 13:33:12.449: Wired client head is NULL, no clients in the list. Number of clients = 0

*DHCP Socket Task: Dec 10 13:33:14.838: cc:3a:61:6d:05:2e DHCP received op BOOTREQUEST (1) (len 315,vlan 0, port 1, encap 0xec03)
*DHCP Socket Task: Dec 10 13:33:14.838: cc:3a:61:6d:05:2e DHCP (encap type 0xec03) mstype 0ff:ff:ff:ff:ff:ff
*DHCP Socket Task: Dec 10 13:33:14.838: cc:3a:61:6d:05:2e DHCP dropping packet due to ongoing mobility handshake exchange, (siaddr 0.0.0.0, mobility state = 'apfMsMmQueryRequested'
*Dot1x_NW_MsgTask_6: Dec 10 13:33:16.043: CCKM: Sending CCKM PMK (Version_2) information to mobility group
*osapiBsnTimer: Dec 10 13:33:16.249: cc:3a:61:6d:05:2e apfMsExpireCallback (apf_ms.c:637) Expiring Mobile!
*apfReceiveTask: Dec 10 13:33:16.249: cc:3a:61:6d:05:2e Scheduling deletion of Mobile Station: (callerId: 46) in 60 seconds
*apfReceiveTask: Dec 10 13:33:16.249: cc:3a:61:6d:05:2e apfMsExpireMobileStation (apf_ms.c:7193) Changing state for mobile cc:3a:61:6d:05:2e on AP 54:78:1a:d0:16:50 from Exclusion-list (1) to Exclusion-list (2)

*apfReceiveTask: Dec 10 13:33:16.249: cc:3a:61:6d:05:2e pemApfDeleteMobileStation2: APF_MS_PEM_WAIT_L2_AUTH_COMPLETE = 0.
*apfReceiveTask: Dec 10 13:33:16.249: cc:3a:61:6d:05:2e 0.0.0.0 DHCP_REQD (7) Deleted mobile LWAPP rule on AP [54:78:1a:d0:16:50]

(Cisco Controller) >
(Cisco Controller) >*pemReceiveTask: Dec 10 13:33:16.250: cc:3a:61:6d:05:2e 0.0.0.0 Removed NPU entry.
*apfMsConnTask_0: Dec 10 13:33:18.854: cc:3a:61:6d:05:2e Processing assoc-req station:cc:3a:61:6d:05:2e AP:54:78:1a:d0:16:50-00 thread:15146c90
*apfMsConnTask_0: Dec 10 13:33:18.854: cc:3a:61:6d:05:2e Ignoring assoc request due to mobile in exclusion list or marked for deletion
*apfMsConnTask_0: Dec 10 13:33:19.201: cc:3a:61:6d:05:2e Processing assoc-req station:cc:3a:61:6d:05:2e AP:54:78:1a:d0:16:50-00 thread:15146c90
*apfMsConnTask_0: Dec 10 13:33:19.201: cc:3a:61:6d:05:2e Ignoring assoc request due to mobile in exclusion list or marked for deletion
*apfMsConnTask_0: Dec 10 13:33:19.490: cc:3a:61:6d:05:2e Processing assoc-req station:cc:3a:61:6d:05:2e AP:54:78:1a:d0:16:50-00 thread:15146c90
debug dhcp packets
*DHCP Socket Task: Dec 10 12:09:43.040: cc:3a:61:6d:05:2e DHCP received op BOOTREQUEST (1) (len 321,vlan 0, port 1, encap 0xec03)
*DHCP Socket Task: Dec 10 12:09:43.040: cc:3a:61:6d:05:2e DHCP (encap type 0xec03) mstype 0ff:ff:ff:ff:ff:ff
*DHCP Socket Task: Dec 10 12:09:43.040: cc:3a:61:6d:05:2e DHCP dropping packet due to ongoing mobility handshake exchange, (siaddr 0.0.0.0, mobility state = 'apfMsMmQueryRequested'


*DHCP Socket Task: Dec 10 12:09:44.529: cc:3a:61:6d:05:2e DHCP received op BOOTREQUEST (1) (len 321,vlan 0, port 1, encap 0xec03)
*DHCP Socket Task: Dec 10 12:09:44.529: cc:3a:61:6d:05:2e DHCP (encap type 0xec03) mstype 0ff:ff:ff:ff:ff:ff
*DHCP Socket Task: Dec 10 12:09:44.529: cc:3a:61:6d:05:2e DHCP dropping packet due to ongoing mobility handshake exchange, (siaddr 0.0.0.0, mobility state = 'apfMsMmQueryRequested'
*DHCP Socket Task: Dec 10 12:09:47.015: cc:3a:61:6d:05:2e DHCP received op BOOTREQUEST (1) (len 315,vlan 0, port 1, encap 0xec03)
*DHCP Socket Task: Dec 10 12:09:47.015: cc:3a:61:6d:05:2e DHCP (encap type 0xec03) mstype 0ff:ff:ff:ff:ff:ff
*DHCP Socket Task: Dec 10 12:09:47.015: cc:3a:61:6d:05:2e DHCP dropping packet due to ongoing mobility handshake exchange, (siaddr 0.0.0.0, mobility state = 'apfMsMmQueryRequested'
debug dhcp messages
*Dot1x_NW_MsgTask_6: Dec 10 12:13:54.464: cc:3a:61:6d:05:2e In apfMsDhcpStateClear for station cc:3a:61:6d:05:2e to clear dhcp flag
*DHCP Socket Task: Dec 10 12:13:55.024: cc:3a:61:6d:05:2e DHCP received op BOOTREQUEST (1) (len 321,vlan 0, port 1, encap 0xec03)
*DHCP Socket Task: Dec 10 12:13:55.024: cc:3a:61:6d:05:2e DHCP option len (including the magic cookie) 85
*DHCP Socket Task: Dec 10 12:13:55.024: cc:3a:61:6d:05:2e DHCP option: message type = DHCP REQUEST
*DHCP Socket Task: Dec 10 12:13:55.024: cc:3a:61:6d:05:2e DHCP option: 61 (len 7) - skipping
*DHCP Socket Task: Dec 10 12:13:55.024: cc:3a:61:6d:05:2e DHCP option: requested ip = 192.168.14.134
*DHCP Socket Task: Dec 10 12:13:55.024: cc:3a:61:6d:05:2e DHCP option: 57 (len 2) - skipping
*DHCP Socket Task: Dec 10 12:13:55.024: cc:3a:61:6d:05:2e DHCP option: vendor class id = dhcpcd-5.5.6 (len 12)
*DHCP Socket Task: Dec 10 12:13:55.024: cc:3a:61:6d:05:2e DHCP option: hostname = android-1bd579c3e571106 (len 23)
*DHCP Socket Task: Dec 10 12:13:55.024: cc:3a:61:6d:05:2e DHCP option: 55 (len 9) - skipping
*DHCP Socket Task: Dec 10 12:13:55.024: cc:3a:61:6d:05:2e DHCP options end, len 85, actual 77
*DHCP Socket Task: Dec 10 12:13:55.024: cc:3a:61:6d:05:2e DHCP (encap type 0xec03) mstype 0ff:ff:ff:ff:ff:ff
*DHCP Socket Task: Dec 10 12:13:55.024: cc:3a:61:6d:05:2e DHCP dropping packet due to ongoing mobility handshake exchange, (siaddr 0.0.0.0, mobility state = 'apfMsMmQueryRequested'
debug mobility directory enable 


(Cisco Controller) >debug mobility directory enable

*apfReceiveTask: Dec 10 13:48:51.248: Mobility Response: Client IP 172.30.18.17 code Handoff (1), reason I(local) will be anchor (2), PEM State RUN, Role Local(1)
*apfMsConnTask_0: Dec 10 13:48:51.687: cc:3a:61:6d:05:2e Processing assoc-req station:cc:3a:61:6d:05:2e AP:54:78:1a:d0:16:50-00 thread:15146c90
*apfMsConnTask_0: Dec 10 13:48:51.688: cc:3a:61:6d:05:2e Adding mobile on LWAPP AP 54:78:1a:d0:16:50(0)
*apfMsConnTask_0: Dec 10 13:48:51.688: cc:3a:61:6d:05:2e Association received from mobile on BSSID 54:78:1a:d0:16:51 AP AP-ITC007
*apfMsConnTask_0: Dec 10 13:48:51.688: cc:3a:61:6d:05:2e Global 200 Clients are allowed to AP radio

*apfMsConnTask_0: Dec 10 13:48:51.688: cc:3a:61:6d:05:2e Max Client Trap Threshold: 0 cur: 5

*apfMsConnTask_0: Dec 10 13:48:51.688: cc:3a:61:6d:05:2e Rf profile 600 Clients are allowed to AP wlan

*apfMsConnTask_0: Dec 10 13:48:51.688: cc:3a:61:6d:05:2e override for default ap group, marking intgrp NULL
*apfMsConnTask_0: Dec 10 13:48:51.688: cc:3a:61:6d:05:2e Applying Interface policy on Mobile, role Unassociated. Ms NAC State 0 Quarantine Vlan 0 Access Vlan 0

*apfMsConnTask_0: Dec 10 13:48:51.688: cc:3a:61:6d:05:2e Re-applying interface policy for client

*apfMsConnTask_0: Dec 10 13:48:51.688: cc:3a:61:6d:05:2e 0.0.0.0 START (0) Changing IPv4 ACL 'none' (ACL ID 255) ===> 'none' (ACL ID 255) --- (caller apf_policy.c:2435)
*apfMsConnTask_0: Dec 10 13:48:51.688: cc:3a:61:6d:05:2e 0.0.0.0 START (0) Changing IPv6 ACL 'none' (ACL ID 255) ===> 'none' (ACL ID 255) --- (caller apf_policy.c:2456)
*apfMsConnTask_0: Dec 10 13:48:51.688: cc:3a:61:6d:05:2e Values before applying NASID - interfacetype:0, ovrd:0, mscb nasid:, interface nasid:
*apfMsConnTask_0: Dec 10 13:48:51.688: cc:3a:61:6d:05:2e apfApplyWlanPolicy: Apply WLAN Policy over PMIPv6 Client Mobility Type
*apfMsConnTask_0: Dec 10 13:48:51.688: cc:3a:61:6d:05:2e Check before Setting the NAS Id to WLAN specific Id ''
*apfMsConnTask_0: Dec 10 13:48:51.688: cc:3a:61:6d:05:2e Applying site-specific Local Bridging override for station cc:3a:61:6d:05:2e - vapId 2, site 'default-group', interface 'management'
*apfMsConnTask_0: Dec 10 13:48:51.688: cc:3a:61:6d:05:2e Applying Local Bridging Interface Policy for station cc:3a:61:6d:05:2e - vlan 0, interface id 0, interface 'management', nasId:''
*apfMsConnTask_0: Dec 10 13:48:51.688: cc:3a:61:6d:05:2e processSsidIE statusCode is 0 and status is 0
*apfMsConnTask_0: Dec 10 13:48:51.688: cc:3a:61:6d:05:2e processSsidIE ssid_done_flag is 0 finish_flag is 0
*apfMsConnTask_0: Dec 10 13:48:51.688: cc:3a:61:6d:05:2e STA - rates (8): 130 132 139 150 36 48 72 108 0 0 0 0 0 0 0 0
*apfMsConnTask_0: Dec 10 13:48:51.688: cc:3a:61:6d:05:2e suppRates statusCode is 0 and gotSuppRatesElement is 1
*apfMsConnTask_0: Dec 10 13:48:51.688: cc:3a:61:6d:05:2e STA - rates (12): 130 132 139 150 36 48 72 108 12 18 24 96 0 0 0 0
*apfMsConnTask_0: Dec 10 13:48:51.688: cc:3a:61:6d:05:2e extSuppRates statusCode is 0 and gotExtSuppRatesElement is 1
*apfMsConnTask_0: Dec 10 13:48:51.689: cc:3a:61:6d:05:2e Process P2P IE And Update CB on BSSID 54:78:1a:d0:16:50 slot 0
*apfMsConnTask_0: Dec 10 13:48:51.689: cc:3a:61:6d:05:2e Parse P2P IE And Update CB on BSSID 54:78:1a:d0:16:50 slot 0
*apfMsConnTask_0: Dec 10 13:48:51.689: RSNIE in Assoc. Req.: (38)

*apfMsConnTask_0: Dec 10 13:48:51.689: [0000] 01 00 00 0f ac 02 01 00 00 0f ac 04 01 00 00 40

*apfMsConnTask_0: Dec 10 13:48:51.689: [0016] 96 00 00 00 01 00 18 f2 6b de d7 1f 71 dd d3 c1

*apfMsConnTask_0: Dec 10 13:48:51.689: [0032] d9 1f 5d 3d d1 44

*apfMsConnTask_0: Dec 10 13:48:51.691: cc:3a:61:6d:05:2e Processing RSN IE type 48, length 38 for mobile cc:3a:61:6d:05:2e
*apfMsConnTask_0: Dec 10 13:48:51.691: cc:3a:61:6d:05:2e CCKM: Mobile is using CCKM
*apfMsConnTask_0: Dec 10 13:48:51.692: cc:3a:61:6d:05:2e RSN Capabilities: 0
*apfMsConnTask_0: Dec 10 13:48:51.692: cc:3a:61:6d:05:2e Marking Mobile as non-11w Capable
*apfMsConnTask_0: Dec 10 13:48:51.692: cc:3a:61:6d:05:2e Received RSN IE with 1 PMKIDs from mobile cc:3a:61:6d:05:2e
*apfMsConnTask_0: Dec 10 13:48:51.692: Received PMKID: (16)

*apfMsConnTask_0: Dec 10 13:48:51.692: [0000] 18 f2 6b de d7 1f 71 dd d3 c1 d9 1f 5d 3d d1 44

*apfMsConnTask_0: Dec 10 13:48:51.692: cc:3a:61:6d:05:2e Searching for PMKID in MSCB PMKID cache for mobile cc:3a:61:6d:05:2e
*apfMsConnTask_0: Dec 10 13:48:51.692: cc:3a:61:6d:05:2e No valid PMKID found in the MSCB PMKID cache for mobile cc:3a:61:6d:05:2e
*apfMsConnTask_0: Dec 10 13:48:51.692: cc:3a:61:6d:05:2e Trying to compute a PMKID from MSCB PMK cache for mobile cc:3a:61:6d:05:2e
*apfMsConnTask_0: Dec 10 13:48:51.692: CCKM: Find PMK in cache: BSSID = (6)

*apfMsConnTask_0: Dec 10 13:48:51.692: [0000] 54 78 1a d0 16 50

*apfMsConnTask_0: Dec 10 13:48:51.692: CCKM: Find PMK in cache: realAA = (6)

*apfMsConnTask_0: Dec 10 13:48:51.692: [0000] 54 78 1a d0 16 51

*apfMsConnTask_0: Dec 10 13:48:51.692: CCKM: Find PMK in cache: PMKID = (16)

*apfMsConnTask_0: Dec 10 13:48:51.692: [0000] 18 f2 6b de d7 1f 71 dd d3 c1 d9 1f 5d 3d d1 44

*apfMsConnTask_0: Dec 10 13:48:51.692: cc:3a:61:6d:05:2e Unable to compute a valid PMKID from MSCB PMK cache for mobile cc:3a:61:6d:05:2e
*apfMsConnTask_0: Dec 10 13:48:51.692: cc:3a:61:6d:05:2e Searching for PMK in global PMK cache for mobile cc:3a:61:6d:05:2e
*apfMsConnTask_0: Dec 10 13:48:51.692: cc:3a:61:6d:05:2e Found an entry in the global PMK cache for station cc:3a:61:6d:05:2e
*apfMsConnTask_0: Dec 10 13:48:51.692: CCKM: AA (6)

*apfMsConnTask_0: Dec 10 13:48:51.692: [0000] 54 78 1a d0 16 51

*apfMsConnTask_0: Dec 10 13:48:51.692: CCKM: SPA (6)

*apfMsConnTask_0: Dec 10 13:48:51.692: [0000] cc 3a 61 6d 05 2e

*apfMsConnTask_0: Dec 10 13:48:51.692: cc:3a:61:6d:05:2e computed a valid PMKID from global PMK cache for mobile cc:3a:61:6d:05:2e
*apfMsConnTask_0: Dec 10 13:48:51.692: cc:3a:61:6d:05:2e Username entry (f3783) created for mobile, length = 253
*apfMsConnTask_0: Dec 10 13:48:51.692: cc:3a:61:6d:05:2e Username entry (f3783) created in mscb for mobile, length = 253
*apfMsConnTask_0: Dec 10 13:48:51.692: cc:3a:61:6d:05:2e Setting active key cache index 8 ---> 8
*apfMsConnTask_0: Dec 10 13:48:51.692: cc:3a:61:6d:05:2e Setting active key cache index 8 ---> 0
*apfMsConnTask_0: Dec 10 13:48:51.692: cc:3a:61:6d:05:2e Creating a PKC PMKID Cache entry for station cc:3a:61:6d:05:2e (RSN 0) on BSSID 54:78:1a:d0:16:51
*apfMsConnTask_0: Dec 10 13:48:51.692: cc:3a:61:6d:05:2e Adding BSSID 54:78:1a:d0:16:51 to PMKID cache at index 0 for station cc:3a:61:6d:05:2e
*apfMsConnTask_0: Dec 10 13:48:51.692: New PMKID: (16)

*apfMsConnTask_0: Dec 10 13:48:51.692: [0000] 18 f2 6b de d7 1f 71 dd d3 c1 d9 1f 5d 3d d1 44

*apfMsConnTask_0: Dec 10 13:48:51.692: cc:3a:61:6d:05:2e 0.0.0.0 START (0) Initializing policy
*apfMsConnTask_0: Dec 10 13:48:51.692: cc:3a:61:6d:05:2e 0.0.0.0 START (0) Change state to AUTHCHECK (2) last state START (0)

*apfMsConnTask_0: Dec 10 13:48:51.692: cc:3a:61:6d:05:2e 0.0.0.0 AUTHCHECK (2) Change state to 8021X_REQD (3) last state AUTHCHECK (2)

*apfMsConnTask_0: Dec 10 13:48:51.692: cc:3a:61:6d:05:2e Encryption policy is set to 0x80000001
*apfMsConnTask_0: Dec 10 13:48:51.693: cc:3a:61:6d:05:2e Not Using WMM Compliance code qosCap 00
*apfMsConnTask_0: Dec 10 13:48:51.693: cc:3a:61:6d:05:2e 0.0.0.0 8021X_REQD (3) Plumbed mobile LWAPP rule on AP 54:78:1a:d0:16:50 vapId 2 apVapId 2 flex-acl-name:
*apfMsConnTask_0: Dec 10 13:48:51.693: cc:3a:61:6d:05:2e apfMsAssoStateInc
*apfMsConnTask_0: Dec 10 13:48:51.693: cc:3a:61:6d:05:2e apfPemAddUser2 (apf_policy.c:353) Changing state for mobile cc:3a:61:6d:05:2e on AP 54:78:1a:d0:16:50 from Idle to Associated

*apfMsConnTask_0: Dec 10 13:48:51.693: cc:3a:61:6d:05:2e apfPemAddUser2:session timeout forstation cc:3a:61:6d:05:2e - Session Tout 0, apfMsTimeOut '0' and sessionTimerRunning flag is 0
*apfMsConnTask_0: Dec 10 13:48:51.693: cc:3a:61:6d:05:2e Stopping deletion of Mobile Station: (callerId: 48)
*apfMsConnTask_0: Dec 10 13:48:51.693: cc:3a:61:6d:05:2e Func: apfPemAddUser2, Ms Timeout = 0, Session Timeout = 0

*apfMsConnTask_0: Dec 10 13:48:51.693: cc:3a:61:6d:05:2e Sending assoc-resp with status 0 station:cc:3a:61:6d:05:2e AP:54:78:1a:d0:16:50-00 on apVapId 2
*apfMsConnTask_0: Dec 10 13:48:51.693: cc:3a:61:6d:05:2e Send Assoc Resp Msg to WFD Client
*apfMsConnTask_0: Dec 10 13:48:51.693: cc:3a:61:6d:05:2e Send Assoc resp Msg to WFD ClientAdd P2P Ie hdr
*apfMsConnTask_0: Dec 10 13:48:51.693: cc:3a:61:6d:05:2e Send Assoc Msg to WFD ClientAdd Attribute to P2P Ie
*apfMsConnTask_0: Dec 10 13:48:51.693: cc:3a:61:6d:05:2e Sending Assoc Response to station on BSSID 54:78:1a:d0:16:51 (status 0) ApVapId 2 Slot 0
*apfMsConnTask_0: Dec 10 13:48:51.693: cc:3a:61:6d:05:2e apfProcessAssocReq (apf_80211.c:9582) Changing state for mobile cc:3a:61:6d:05:2e on AP 54:78:1a:d0:16:50 from Associated to Associated

*spamApTask1: Dec 10 13:48:51.699: cc:3a:61:6d:05:2e Sent 1x initiate message to multi thread task for mobile cc:3a:61:6d:05:2e
*Dot1x_NW_MsgTask_6: Dec 10 13:48:51.699: cc:3a:61:6d:05:2e reauth_sm state transition 0 ---> 1 for mobile cc:3a:61:6d:05:2e at 1x_reauth_sm.c:47
*Dot1x_NW_MsgTask_6: Dec 10 13:48:51.699: cc:3a:61:6d:05:2e Initiating RSN with existing PMK to mobile cc:3a:61:6d:05:2e
*Dot1x_NW_MsgTask_6: Dec 10 13:48:51.699: cc:3a:61:6d:05:2e EAP-PARAM Debug - eap-params for Wlan-Id :2 is disabled - applying Global eap timers and retries
*Dot1x_NW_MsgTask_6: Dec 10 13:48:51.699: cc:3a:61:6d:05:2e Disable re-auth, use PMK lifetime.
*Dot1x_NW_MsgTask_6: Dec 10 13:48:51.699: cc:3a:61:6d:05:2e Station cc:3a:61:6d:05:2e setting dot1x reauth timeout = 1800
*Dot1x_NW_MsgTask_6: Dec 10 13:48:51.699: cc:3a:61:6d:05:2e dot1x - moving mobile cc:3a:61:6d:05:2e into Force Auth state
*Dot1x_NW_MsgTask_6: Dec 10 13:48:51.699: cc:3a:61:6d:05:2e Skipping EAP-Success to mobile cc:3a:61:6d:05:2e
*Dot1x_NW_MsgTask_6: Dec 10 13:48:51.699: cc:3a:61:6d:05:2e Username entry (f3783) already exists in name table, length = 253
*Dot1x_NW_MsgTask_6: Dec 10 13:48:51.699: cc:3a:61:6d:05:2e Username entry (f3783) created in mscb for mobile, length = 253
*Dot1x_NW_MsgTask_6: Dec 10 13:48:51.699: cc:3a:61:6d:05:2e Applying cached RADIUS Override values for mobile cc:3a:61:6d:05:2e (caller 1x_auth_pae.c:780)
*Dot1x_NW_MsgTask_6: Dec 10 13:48:51.699: cc:3a:61:6d:05:2e Applying override policy from source Override Summation: with value 200

*Dot1x_NW_MsgTask_6: Dec 10 13:48:51.699: cc:3a:61:6d:05:2e Found an interface name:'vlan14' corresponds to interface name received: vlan14
*Dot1x_NW_MsgTask_6: Dec 10 13:48:51.699: cc:3a:61:6d:05:2e Applying Interface policy on Mobile, role Unassociated. Ms NAC State 2 Quarantine Vlan 0 Access Vlan 0

*Dot1x_NW_MsgTask_6: Dec 10 13:48:51.699: cc:3a:61:6d:05:2e Re-applying interface policy for client

*Dot1x_NW_MsgTask_6: Dec 10 13:48:51.700: cc:3a:61:6d:05:2e 0.0.0.0 8021X_REQD (3) Changing IPv4 ACL 'none' (ACL ID 255) ===> 'none' (ACL ID 255) --- (caller apf_policy.c:2435)
*Dot1x_NW_MsgTask_6: Dec 10 13:48:51.700: cc:3a:61:6d:05:2e 0.0.0.0 8021X_REQD (3) Changing IPv6 ACL 'none' (ACL ID 255) ===> 'none' (ACL ID 255) --- (caller apf_policy.c:2456)
*Dot1x_NW_MsgTask_6: Dec 10 13:48:51.700: cc:3a:61:6d:05:2e Values before applying NASID - interfacetype:3, ovrd:0, mscb nasid:, interface nasid:
*Dot1x_NW_MsgTask_6: Dec 10 13:48:51.700: cc:3a:61:6d:05:2e Found an cache entry for BSSID 54:78:1a:d0:16:51 in PMKID cache at index 0 of station cc:3a:61:6d:05:2e
*Dot1x_NW_MsgTask_6: Dec 10 13:48:51.700: cc:3a:61:6d:05:2e Found an cache entry for BSSID 54:78:1a:d0:16:51 in PMKID cache at index 0 of station cc:3a:61:6d:05:2e
*Dot1x_NW_MsgTask_6: Dec 10 13:48:51.700: Including PMKID in M1 (16)

*Dot1x_NW_MsgTask_6: Dec 10 13:48:51.700: [0000] 18 f2 6b de d7 1f 71 dd d3 c1 d9 1f 5d 3d d1 44

*Dot1x_NW_MsgTask_6: Dec 10 13:48:51.700: cc:3a:61:6d:05:2e Starting key exchange to mobile cc:3a:61:6d:05:2e, data packets will be dropped
*Dot1x_NW_MsgTask_6: Dec 10 13:48:51.700: cc:3a:61:6d:05:2e Sending EAPOL-Key Message to mobile cc:3a:61:6d:05:2e
state INITPMK (message 1), replay counter 00.00.00.00.00.00.00.00
*Dot1x_NW_MsgTask_6: Dec 10 13:48:51.700: cc:3a:61:6d:05:2e Allocating EAP Pkt for retransmission to mobile cc:3a:61:6d:05:2e
*Dot1x_NW_MsgTask_6: Dec 10 13:48:51.712: cc:3a:61:6d:05:2e Received EAPOL-Key from mobile cc:3a:61:6d:05:2e
*Dot1x_NW_MsgTask_6: Dec 10 13:48:51.712: cc:3a:61:6d:05:2e Ignoring invalid EAPOL version (1) in EAPOL-key message from mobile cc:3a:61:6d:05:2e
*Dot1x_NW_MsgTask_6: Dec 10 13:48:51.712: cc:3a:61:6d:05:2e Received EAPOL-key in PTK_START state (message 2) from mobile cc:3a:61:6d:05:2e
*Dot1x_NW_MsgTask_6: Dec 10 13:48:51.713: cc:3a:61:6d:05:2e Dumping RSNIE received in Association request:
*Dot1x_NW_MsgTask_6: Dec 10 13:48:51.713: 00000000: 30 26 01 00 00 0f ac 02 01 00 00 0f ac 04 01 00 0&..............
*Dot1x_NW_MsgTask_6: Dec 10 13:48:51.713: 00000010: 00 40 96 00 00 00 01 00 18 f2 6b de d7 1f 71 dd .@........k...q.
*Dot1x_NW_MsgTask_6: Dec 10 13:48:51.713: 00000020: d3 c1 d9 1f 5d 3d d1 44 ....]=.D
*Dot1x_NW_MsgTask_6: Dec 10 13:48:51.713: cc:3a:61:6d:05:2e Dumping RSNIE received in EAPOL M2 :
*Dot1x_NW_MsgTask_6: Dec 10 13:48:51.713: 00000000: 01 00 00 0f ac 02 01 00 00 0f ac 04 01 00 00 40 ...............@
*Dot1x_NW_MsgTask_6: Dec 10 13:48:51.713: 00000010: 96 00 00 00 01 00 18 f2 6b de d7 1f 71 dd d3 c1 ........k...q...
*Dot1x_NW_MsgTask_6: Dec 10 13:48:51.713: 00000020: d9 1f 5d 3d d1 44 ..]=.D
*Dot1x_NW_MsgTask_6: Dec 10 13:48:51.713: cc:3a:61:6d:05:2e Not Flex client. Do not distribute CCKM Key cache.
*Dot1x_NW_MsgTask_6: Dec 10 13:48:51.713: CCKM: Sending CCKM PMK (Version_2) information to mobility group
*Dot1x_NW_MsgTask_6: Dec 10 13:48:51.714: cc:3a:61:6d:05:2e 7 PMK-update groupcast messages sent
*Dot1x_NW_MsgTask_6: Dec 10 13:48:51.714: cc:3a:61:6d:05:2e Stopping retransmission timer for mobile cc:3a:61:6d:05:2e
*Dot1x_NW_MsgTask_6: Dec 10 13:48:51.714: cc:3a:61:6d:05:2e Sending EAPOL-Key Message to mobile cc:3a:61:6d:05:2e
state PTKINITNEGOTIATING (message 3), replay counter 00.00.00.00.00.00.00.01
*Dot1x_NW_MsgTask_6: Dec 10 13:48:51.714: cc:3a:61:6d:05:2e Reusing allocated memory for EAP Pkt for retransmission to mobile cc:3a:61:6d:05:2e
*Dot1x_NW_MsgTask_5: Dec 10 13:48:51.721: hdrType not mmNacStateUpdate,line 9793,freeing

*apfReceiveTask: Dec 10 13:48:51.722: Mobility Response: Client IP 172.30.38.45 code Handoff (1), reason I(local) will be anchor (2), PEM State RUN, Role Local(1)
*Dot1x_NW_MsgTask_6: Dec 10 13:48:51.723: cc:3a:61:6d:05:2e Received EAPOL-Key from mobile cc:3a:61:6d:05:2e
*Dot1x_NW_MsgTask_6: Dec 10 13:48:51.723: cc:3a:61:6d:05:2e Ignoring invalid EAPOL version (1) in EAPOL-key message from mobile cc:3a:61:6d:05:2e
*Dot1x_NW_MsgTask_6: Dec 10 13:48:51.723: cc:3a:61:6d:05:2e Received EAPOL-key in PTKINITNEGOTIATING state (message 4) from mobile cc:3a:61:6d:05:2e
*Dot1x_NW_MsgTask_6: Dec 10 13:48:51.723: cc:3a:61:6d:05:2e Stopping retransmission timer for mobile cc:3a:61:6d:05:2e
*Dot1x_NW_MsgTask_6: Dec 10 13:48:51.723: cc:3a:61:6d:05:2e Freeing EAP Retransmit Bufer for mobile cc:3a:61:6d:05:2e
*Dot1x_NW_MsgTask_6: Dec 10 13:48:51.723: cc:3a:61:6d:05:2e apfMs1xStateInc
*Dot1x_NW_MsgTask_6: Dec 10 13:48:51.723: cc:3a:61:6d:05:2e 0.0.0.0 8021X_REQD (3) Change state to L2AUTHCOMPLETE (4) last state 8021X_REQD (3)

*Dot1x_NW_MsgTask_6: Dec 10 13:48:51.723: cc:3a:61:6d:05:2e Mobility query, PEM State: L2AUTHCOMPLETE

*Dot1x_NW_MsgTask_6: Dec 10 13:48:51.723: cc:3a:61:6d:05:2e Building Mobile Announce :

*Dot1x_NW_MsgTask_6: Dec 10 13:48:51.723: cc:3a:61:6d:05:2e Building Client Payload:

*Dot1x_NW_MsgTask_6: Dec 10 13:48:51.723: cc:3a:61:6d:05:2e Client Ip: 0.0.0.0

*Dot1x_NW_MsgTask_6: Dec 10 13:48:51.723: cc:3a:61:6d:05:2e Client Vlan Ip: 192.168.14.19, Vlan mask : 255.255.255.0

*Dot1x_NW_MsgTask_6: Dec 10 13:48:51.723: cc:3a:61:6d:05:2e Client Vap Security: 16384

*Dot1x_NW_MsgTask_6: Dec 10 13:48:51.723: cc:3a:61:6d:05:2e Virtual Ip: 1.1.1.1

*Dot1x_NW_MsgTask_6: Dec 10 13:48:51.723: cc:3a:61:6d:05:2e ssid: AL-QUDS-WLAN

*Dot1x_NW_MsgTask_6: Dec 10 13:48:51.723: cc:3a:61:6d:05:2e Building VlanIpPayload.

*Dot1x_NW_MsgTask_6: Dec 10 13:48:51.723: cc:3a:61:6d:05:2e Mobile Announce sent to 1 members of the local group.
*Dot1x_NW_MsgTask_6: Dec 10 13:48:51.723: cc:3a:61:6d:05:2e Not Using WMM Compliance code qosCap 00
*Dot1x_NW_MsgTask_6: Dec 10 13:48:51.724: cc:3a:61:6d:05:2e 0.0.0.0 L2AUTHCOMPLETE (4) Plumbed mobile LWAPP rule on AP 54:78:1a:d0:16:50 vapId 2 apVapId 2 flex-acl-name:
*Dot1x_NW_MsgTask_6: Dec 10 13:48:51.724: cc:3a:61:6d:05:2e 0.0.0.0 L2AUTHCOMPLETE (4) Change state to DHCP_REQD (7) last state L2AUTHCOMPLETE (4)

*Dot1x_NW_MsgTask_6: Dec 10 13:48:51.724: cc:3a:61:6d:05:2e 0.0.0.0 DHCP_REQD (7) pemAdvanceState2 6575, Adding TMP rule
*Dot1x_NW_MsgTask_6: Dec 10 13:48:51.724: cc:3a:61:6d:05:2e 0.0.0.0 DHCP_REQD (7) Adding Fast Path rule
type = Airespace AP - Learn IP address
on AP 54:78:1a:d0:16:50, slot 0, interface = 1, QOS = 0
IPv4 ACL ID = 255, IPv
*Dot1x_NW_MsgTask_6: Dec 10 13:48:51.724: cc:3a:61:6d:05:2e 0.0.0.0 DHCP_REQD (7) Fast Path rule (contd...) 802.1P = 0, DSCP = 0, TokenID = 15206, IntfId = 13 Local Bridging Vlan = 0, Local Bridging intf id = 0
*Dot1x_NW_MsgTask_6: Dec 10 13:48:51.724: cc:3a:61:6d:05:2e 0.0.0.0 DHCP_REQD (7) Fast Path rule (contd...) AVC Ratelimit: AppID = 0 ,AppAction = 0, AppToken = 15206 AverageRate = 0, BurstRate = 0

*Dot1x_NW_MsgTask_6: Dec 10 13:48:51.724: cc:3a:61:6d:05:2e 0.0.0.0 DHCP_REQD (7) Fast Path rule (contd...) AVC Ratelimit: AppID = 0 ,AppAction = 0, AppToken = 15206 AverageRate = 0, BurstRate = 0

*Dot1x_NW_MsgTask_6: Dec 10 13:48:51.724: cc:3a:61:6d:05:2e 0.0.0.0 DHCP_REQD (7) Fast Path rule (contd...) AVC Ratelimit: AppID = 0 ,AppAction = 0, AppToken = 15206 AverageRate = 0, BurstRate = 0

*Dot1x_NW_MsgTask_6: Dec 10 13:48:51.724: cc:3a:61:6d:05:2e 0.0.0.0 DHCP_REQD (7) Successfully plumbed mobile rule (IPv4 ACL ID 255, IPv6 ACL ID 255, L2 ACL ID 255)
*mmListen: Dec 10 13:48:51.727: Client payload is not found in recvd mmlisten packe hashing based on zero mac address, for msg type 5
*apfReceiveTask: Dec 10 13:48:51.730: cc:3a:61:6d:05:2e apfBlacklistMobileStationEntry2 (apf_ms.c:6268) Changing state for mobile cc:3a:61:6d:05:2e on AP 54:78:1a:d0:16:50 from Associated to Exclusion-list (1)

*apfReceiveTask: Dec 10 13:48:51.730: cc:3a:61:6d:05:2e Scheduling deletion of Mobile Station: (callerId: 44) in 10 seconds
*apfReceiveTask: Dec 10 13:48:51.730: cc:3a:61:6d:05:2e HandOff denied as Client is Blacklisted at Peer 0.0.0.0. Adding mobile to exclusion-list due to mobility reporting
*apfReceiveTask: Dec 10 13:48:51.730: Mobility Response: Client IP 0.0.0.0 code Handoff (1), reason Client is blacklisted (6), PEM State DHCP_REQD, Role Unassociated(0)
*pemReceiveTask: Dec 10 13:48:51.733: cc:3a:61:6d:05:2e 0.0.0.0 Added NPU entry of type 9, dtlFlags 0x0
*Dot1x_NW_MsgTask_0: Dec 10 13:48:52.036: hdrType not mmNacStateUpdate,line 9793,freeing

*apfReceiveTask: Dec 10 13:48:52.037: Mobility Response: Client IP 172.30.10.196 code Handoff (1), reason I(local) will be anchor (2), PEM State RUN, Role Local(1)
*Dot1x_NW_MsgTask_6: Dec 10 13:48:52.069: Mobile Announce from 172.16.31.8 for Blacklisted Mobile f4:42:8f:09:90:ae Client Mobilty State = 8, Handoff Denied ...

*Dot1x_NW_MsgTask_1: Dec 10 13:48:52.201: hdrType not mmNacStateUpdate,line 9793,freeing

*apfReceiveTask: Dec 10 13:48:52.202: Mobility Response: Client IP 172.30.151.255 code Handoff (1), reason I(local) will be anchor (2), PEM State RUN, Role Local(1)
*DHCP Socket Task: Dec 10 13:48:52.230: cc:3a:61:6d:05:2e DHCP received op BOOTREQUEST (1) (len 321,vlan 0, port 1, encap 0xec03)
*DHCP Socket Task: Dec 10 13:48:52.230: cc:3a:61:6d:05:2e DHCP (encap type 0xec03) mstype 0ff:ff:ff:ff:ff:ff
*DHCP Socket Task: Dec 10 13:48:52.230: cc:3a:61:6d:05:2e DHCP dropping packet due to ongoing mobility handshake exchange, (siaddr 0.0.0.0, mobility state = 'apfMsMmQueryRequested'
*Dot1x_NW_MsgTask_6: Dec 10 13:48:52.430: hdrType not mmNacStateUpdate,line 9793,freeing

*apfReceiveTask: Dec 10 13:48:52.432: Mobility Response: Client IP 172.30.200.83 code Handoff (1), reason I(local) will be anchor (2), PEM State RUN, Role Local(1)
*apfReceiveTask: Dec 10 13:48:52.767: Mobility Response: Client IP 0.0.0.0 code Handoff Indication (2), reason Client handoff successful - anchor released (0), PEM State DHCP_REQD, Role Handoff(6)
*DHCP Socket Task: Dec 10 13:48:53.690: cc:3a:61:6d:05:2e DHCP received op BOOTREQUEST (1) (len 321,vlan 0, port 1, encap 0xec03)
*DHCP Socket Task: Dec 10 13:48:53.690: cc:3a:61:6d:05:2e DHCP (encap type 0xec03) mstype 0ff:ff:ff:ff:ff:ff
*DHCP Socket Task: Dec 10 13:48:53.690: cc:3a:61:6d:05:2e DHCP dropping packet due to ongoing mobility handshake exchange, (siaddr 0.0.0.0, mobility state = 'apfMsMmQueryRequested'
*apfReceiveTask: Dec 10 13:48:53.763: Mobility Response: Client IP 0.0.0.0 code Handoff Indication (2), reason Client handoff successful - anchor released (0), PEM State DHCP_REQD, Role Handoff(6)
*apfReceiveTask: Dec 10 13:48:54.227: Mobility Response: Client IP 192.168.141.154 code Handoff (1), reason I(local) will be anchor (2), PEM State RUN, Role Local(1)
*Dot1x_NW_MsgTask_0: Dec 10 13:48:54.230: hdrType not mmNacStateUpdate,line 9793,freeing

*Dot1x_NW_MsgTask_5: Dec 10 13:48:55.083: hdrType not mmNacStateUpdate,line 9793,freeing

*apfReceiveTask: Dec 10 13:48:55.087: Mobility Response: Client IP 172.30.22.255 code Handoff (1), reason I(local) will be anchor (2), PEM State RUN, Role Local(1)
*Dot1x_NW_MsgTask_0: Dec 10 13:48:55.176: CCKM: Sending CCKM PMK (Version_2) information to mobility group
*apfReceiveTask: Dec 10 13:48:55.183: Mobility Response: Client IP 172.30.166.248 code Handoff (1), reason I(local) will be anchor (2), PEM State RUN, Role Local(1)
*Dot1x_NW_MsgTask_0: Dec 10 13:48:55.186: hdrType not mmNacStateUpdate,line 9793,freeing

*apfReceiveTask: Dec 10 13:48:55.302: mmHandoffConfirm: Mobile Announce Mip not present, client mac 84:8e:0c:17:af:9d

*apfReceiveTask: Dec 10 13:48:55.302: Mobility Response: Client IP 0.0.0.0 code Handoff (1), reason Handoff request timed out (7), PEM State DHCP_REQD, Role Local(1)
*apfReceiveTask: Dec 10 13:48:55.395: Mobility Response: Client IP 172.30.61.208 code Handoff (1), reason I(local) will be anchor (2), PEM State RUN, Role Local(1)
*Dot1x_NW_MsgTask_7: Dec 10 13:48:55.397: hdrType not mmNacStateUpdate,line 9793,freeing

*Dot1x_NW_MsgTask_5: Dec 10 13:48:55.872: Ignoring Announce, role = 0, Client IP: 120.75.135.138 Client mac: ba:0d:00:00:00:00 Peer IP: 172.16.31.10

*Dot1x_NW_MsgTask_7: Dec 10 13:48:55.903: CCKM: Sending CCKM PMK (Version_2) information to mobility group
*Dot1x_NW_MsgTask_7: Dec 10 13:48:55.933: hdrType not mmNacStateUpdate,line 9793,freeing

*apfReceiveTask: Dec 10 13:48:55.937: Mobility Response: Client IP 172.30.33.146 code Handoff (1), reason I(local) will be anchor (2), PEM State RUN, Role Local(1)
*apfReceiveTask: Dec 10 13:48:56.093: Mobility Response: Client IP 0.0.0.0 code Handoff Indication (2), reason Client handoff successful - anchor released (0), PEM State DHCP_REQD, Role Handoff(6)
*DHCP Socket Task: Dec 10 13:48:56.198: cc:3a:61:6d:05:2e DHCP received op BOOTREQUEST (1) (len 315,vlan 0, port 1, encap 0xec03)
*DHCP Socket Task: Dec 10 13:48:56.198: cc:3a:61:6d:05:2e DHCP (encap type 0xec03) mstype 0ff:ff:ff:ff:ff:ff
*DHCP Socket Task: Dec 10 13:48:56.198: cc:3a:61:6d:05:2e DHCP dropping packet due to ongoing mobility handshake exchange, (siaddr 0.0.0.0, mobility state = 'apfMsMmQueryRequested'
*Dot1x_NW_MsgTask_1: Dec 10 13:48:56.359: Dropped Mobile Announce received from 172.16.31.6 for client 0c:b3:19:c1:07:c1 as it is marked for deletion. Client Mobilty State = 6.

*apfReceiveTask: Dec 10 13:48:56.679: Mobility Response: Client IP 0.0.0.0 code Handoff Indication (2), reason Client handoff successful - anchor released (0), PEM State DHCP_REQD, Role Handoff(6)
*Dot1x_NW_MsgTask_5: Dec 10 13:48:56.723: Ignoring Announce, role = 0, Client IP: 120.75.135.138 Client mac: ba:0d:00:00:00:00 Peer IP: 172.16.31.10

*apfReceiveTask: Dec 10 13:48:56.935: Mobility Response: Client IP 0.0.0.0 code Handoff Indication (2), reason Client handoff successful - anchor released (0), PEM State DHCP_REQD, Role Handoff(6)
*Dot1x_NW_MsgTask_2: Dec 10 13:48:57.464: Ignoring Announce, role = 0, Client IP: 104.219.202.125 Client mac: ca:82:00:00:00:00 Peer IP: 172.16.31.9

*Dot1x_NW_MsgTask_6: Dec 10 13:48:57.516: hdrType not mmNacStateUpdate,line 9793,freeing

*apfReceiveTask: Dec 10 13:48:57.517: Mobility Response: Client IP 172.30.44.97 code Handoff (1), reason I(local) will be anchor (2), PEM State RUN, Role Local(1)
*Dot1x_NW_MsgTask_5: Dec 10 13:48:57.723: Ignoring Announce, role = 0, Client IP: 120.75.135.138 Client mac: ba:0d:00:00:00:00 Peer IP: 172.16.31.10

*Dot1x_NW_MsgTask_5: Dec 10 13:48:57.822: hdrType not mmNacStateUpdate,line 9793,freeing

*apfReceiveTask: Dec 10 13:48:57.823: Mobility Response: Client IP 172.30.37.124 code Handoff (1), reason I(local) will be anchor (2), PEM State RUN, Role Local(1)
*Dot1x_NW_MsgTask_6: Dec 10 13:48:58.540: hdrType not mmNacStateUpdate,line 9793,freeing

*apfReceiveTask: Dec 10 13:48:58.541: Mobility Response: Client IP 172.30.32.174 code Handoff (1), reason I(local) will be anchor (2), PEM State RUN, Role Local(1)
*apfReceiveTask: Dec 10 13:48:58.701: Mobility Response: Client IP 0.0.0.0 code Handoff Indication (2), reason Client handoff successful - anchor released (0), PEM State DHCP_REQD, Role Handoff(6)
*apfReceiveTask: Dec 10 13:48:58.916: Mobility Response: Client IP 0.0.0.0 code Handoff Indication (2), reason Client handoff successful - anchor released (0), PEM State DHCP_REQD, Role Handoff(6)
*apfReceiveTask: Dec 10 13:48:59.391: Mobility Response: Client IP 172.30.194.126 code Handoff (1), reason I(local) will be anchor (2), PEM State RUN, Role Local(1)
*Dot1x_NW_MsgTask_1: Dec 10 13:48:59.394: hdrType not mmNacStateUpdate,line 9793,freeing

*Dot1x_NW_MsgTask_2: Dec 10 13:48:59.760: hdrType not mmNacStateUpdate,line 9793,freeing

*apfReceiveTask: Dec 10 13:48:59.761: Mobility Response: Client IP 172.30.19.80 code Handoff (1), reason I(local) will be anchor (2), PEM State RUN, Role Local(1)
*Dot1x_NW_MsgTask_3: Dec 10 13:49:00.041: hdrType not mmNacStateUpdate,line 9793,freeing

*apfReceiveTask: Dec 10 13:49:00.042: Mobility Response: Client IP 172.30.41.52 code Handoff (1), reason I(local) will be anchor (2), PEM State RUN, Role Local(1)
*apfReceiveTask: Dec 10 13:49:00.489: Mobility Response: Client IP 0.0.0.0 code Handoff Indication (2), reason Client handoff successful - anchor released (0), PEM State DHCP_REQD, Role Handoff(6)
*apfReceiveTask: Dec 10 13:49:00.511: Mobility Response: Client IP 0.0.0.0 code Handoff Indication (2), reason Client handoff successful - anchor released (0), PEM State DHCP_REQD, Role Handoff(6)
*Dot1x_NW_MsgTask_0: Dec 10 13:49:00.643: hdrType not mmNacStateUpdate,line 9793,freeing

*apfReceiveTask: Dec 10 13:49:00.644: Mobility Response: Client IP 172.30.153.99 code Handoff (1), reason I(local) will be anchor (2), PEM State RUN, Role Local(1)
*apfMsConnTask_0: Dec 10 13:49:01.464: cc:3a:61:6d:05:2e Processing assoc-req station:cc:3a:61:6d:05:2e AP:54:78:1a:d0:16:50-00 thread:15146c90
*apfMsConnTask_0: Dec 10 13:49:01.464: cc:3a:61:6d:05:2e Ignoring assoc request due to mobile in exclusion list or marked for deletion
*apfReceiveTask: Dec 10 13:49:01.501: mmHandoffConfirm: Mobile Announce Mip not present, client mac 5c:0a:5b:4a:01:a3

*apfReceiveTask: Dec 10 13:49:01.502: Mobility Response: Client IP 0.0.0.0 code Handoff (1), reason Handoff request timed out (7), PEM State DHCP_REQD, Role Local(1)
*apfReceiveTask: Dec 10 13:49:01.586: Mobility Response: Client IP 0.0.0.0 code Handoff Indication (2), reason Client handoff successful - anchor released (0), PEM State DHCP_REQD, Role Handoff(6)
*apfReceiveTask: Dec 10 13:49:01.681: Mobility Response: Client IP 0.0.0.0 code Handoff Indication (2), reason Client handoff successful - anchor released (0), PEM State DHCP_REQD, Role Handoff(6)
*osapiBsnTimer: Dec 10 13:49:01.701: cc:3a:61:6d:05:2e apfMsExpireCallback (apf_ms.c:637) Expiring Mobile!
*apfReceiveTask: Dec 10 13:49:01.701: cc:3a:61:6d:05:2e Scheduling deletion of Mobile Station: (callerId: 46) in 60 seconds
*apfReceiveTask: Dec 10 13:49:01.701: cc:3a:61:6d:05:2e apfMsExpireMobileStation (apf_ms.c:7193) Changing state for mobile cc:3a:61:6d:05:2e on AP 54:78:1a:d0:16:50 from Exclusion-list (1) to Exclusion-list (2)

*apfReceiveTask: Dec 10 13:49:01.701: cc:3a:61:6d:05:2e pemApfDeleteMobileStation2: APF_MS_PEM_WAIT_L2_AUTH_COMPLETE = 0.
*apfReceiveTask: Dec 10 13:49:01.701: cc:3a:61:6d:05:2e 0.0.0.0 DHCP_REQD (7) Deleted mobile LWAPP rule on AP [54:78:1a:d0:16:50]
*pemReceiveTask: Dec 10 13:49:01.702: cc:3a:61:6d:05:2e 0.0.0.0 Removed NPU entry.
*apfMsConnTask_0: Dec 10 13:49:01.782: cc:3a:61:6d:05:2e Processing assoc-req station:cc:3a:61:6d:05:2e AP:54:78:1a:d0:16:50-00 thread:15146c90
*apfMsConnTask_0: Dec 10 13:49:01.782: cc:3a:61:6d:05:2e Ignoring assoc request due to mobile in exclusion list or marked for deletion
*apfMsConnTask_0: Dec 10 13:49:02.101: cc:3a:61:6d:05:2e Processing assoc-req station:cc:3a:61:6d:05:2e AP:54:78:1a:d0:16:50-00 thread:15146c90
*apfMsConnTask_0: Dec 10 13:49:02.101: cc:3a:61:6d:05:2e Ignoring assoc request due to mobile in exclusion list or marked for deletion
*apfReceiveTask: Dec 10 13:49:02.301: mmHandoffConfirm: Mobile Announce Mip not present, client mac 5c:70:a3:8f:47:3b

*apfReceiveTask: Dec 10 13:49:02.302: Mobility Response: Client IP 0.0.0.0 code Handoff (1), reason Handoff request timed out (7), PEM State DHCP_REQD, Role Local(1)
*apfMsConnTask_0: Dec 10 13:49:02.419: cc:3a:61:6d:05:2e Processing assoc-req station:cc:3a:61:6d:05:2e AP:54:78:1a:d0:16:50-00 thread:15146c90
*apfMsConnTask_0: Dec 10 13:49:02.419: cc:3a:61:6d:05:2e Ignoring assoc request due to mobile in exclusion list or marked for deletion
*apfReceiveTask: Dec 10 13:49:02.513: Mobility Response: Client IP 0.0.0.0 code Handoff Indication (2), reason Client handoff successful - anchor released (0), PEM State DHCP_REQD, Role Handoff(6)
*apfMsConnTask_0: Dec 10 13:49:02.739: cc:3a:61:6d:05:2e Processing assoc-req station:cc:3a:61:6d:05:2e AP:54:78:1a:d0:16:50-00 thread:15146c90
*apfMsConnTask_0: Dec 10 13:49:02.739: cc:3a:61:6d:05:2e Ignoring assoc request due to mobile in exclusion list or marked for deletion
*Dot1x_NW_MsgTask_4: Dec 10 13:49:02.824: Ignoring Announce, role = 0, Client IP: 172.90.20.125 Client mac: 9a:34:00:00:00:00 Peer IP: 172.16.31.6

*apfMsConnTask_0: Dec 10 13:49:03.057: cc:3a:61:6d:05:2e Processing assoc-req station:cc:3a:61:6d:05:2e AP:54:78:1a:d0:16:50-00 thread:15146c90
*apfMsConnTask_0: Dec 10 13:49:03.057: cc:3a:61:6d:05:2e Ignoring assoc request due to mobile in exclusion list or marked for deletion
*apfMsConnTask_0: Dec 10 13:49:03.375: cc:3a:61:6d:05:2e Processing assoc-req station:cc:3a:61:6d:05:2e AP:54:78:1a:d0:16:50-00 thread:15146c90
*apfMsConnTask_0: Dec 10 13:49:03.375: cc:3a:61:6d:05:2e Ignoring assoc request due to mobile in exclusion list or marked for deletion
*Dot1x_NW_MsgTask_3: Dec 10 13:49:03.542: hdrType not mmNacStateUpdate,line 9793,freeing

*apfReceiveTask: Dec 10 13:49:03.543: Mobility Response: Client IP 172.30.122.54 code Handoff (1), reason I(local) will be anchor (2), PEM State RUN, Role Local(1)
*Dot1x_NW_MsgTask_3: Dec 10 13:49:04.297: Ignoring Announce, role = 0, Client IP: 224.219.16.95 Client mac: 73:d3:00:00:00:00 Peer IP: 172.16.31.6

*apfReceiveTask: Dec 10 13:49:04.324: Mobility Response: Client IP 0.0.0.0 code Handoff Indication (2), reason Client handoff successful - anchor released (0), PEM State DHCP_REQD, Role Handoff(6)
*Dot1x_NW_MsgTask_1: Dec 10 13:49:04.692: hdrType not mmNacStateUpdate,line 9793,freeing

*apfReceiveTask: Dec 10 13:49:04.693: Handoff 802.1x PEM state 0, client state 20, client 172.30.49.139

*apfReceiveTask: Dec 10 13:49:04.694: Mobility Response: Client IP 172.30.49.139 code Handoff (1), reason I(local) will be anchor (2), PEM State RUN, Role Local(1)
*Dot1x_NW_MsgTask_0: Dec 10 13:49:04.772: hdrType not mmNacStateUpdate,line 9793,freeing

*apfReceiveTask: Dec 10 13:49:04.773: Mobility Response: Client IP 172.30.38.111 code Handoff (1), reason I(local) will be anchor (2), PEM State RUN, Role Local(1)
*Dot1x_NW_MsgTask_0: Dec 10 13:49:04.933: hdrType not mmNacStateUpdate,line 9793,freeing

*apfReceiveTask: Dec 10 13:49:04.935: Mobility Response: Client IP 172.30.115.219 code Handoff (1), reason I(local) will be anchor (2), PEM State RUN, Role Local(1)
*Dot1x_NW_MsgTask_3: Dec 10 13:49:05.433: hdrType not mmNacStateUpdate,line 9793,freeing

*apfReceiveTask: Dec 10 13:49:05.434: Mobility Response: Client IP 192.168.138.245 code Handoff (1), reason I(local) will be anchor (2), PEM State RUN, Role Local(1)
*Dot1x_NW_MsgTask_6: Dec 10 13:49:06.613: CCKM: Sending CCKM PMK (Version_2) information to mobility group
*apfMsConnTask_2: Dec 10 13:49:06.619: cc:3a:61:6d:05:2e Processing assoc-req station:cc:3a:61:6d:05:2e AP:c0:25:5c:78:8b:40-00 thread:15147430
*apfMsConnTask_2: Dec 10 13:49:06.619: cc:3a:61:6d:05:2e Ignoring assoc request due to mobile in exclusion list or marked for deletion
*apfMsConnTask_2: Dec 10 13:49:06.619: cc:3a:61:6d:05:2e Sending client blacklist entry to roamed AP c0:25:5c:78:8b:40 with remaining time to be excluded 46sec
*Dot1x_NW_MsgTask_3: Dec 10 13:49:06.665: hdrType not mmNacStateUpdate,line 9793,freeing

*apfReceiveTask: Dec 10 13:49:06.666: Mobility Response: Client IP 192.168.136.3 code Handoff (1), reason I(local) will be anchor (2), PEM State RUN, Role Local(1)
*apfReceiveTask: Dec 10 13:49:06.812: Mobility Response: Client IP 0.0.0.0 code Handoff Indication (2), reason Client handoff successful - anchor released (0), PEM State DHCP_REQD, Role Handoff(6)
*apfMsConnTask_2: Dec 10 13:49:06.937: cc:3a:61:6d:05:2e Processing assoc-req station:cc:3a:61:6d:05:2e AP:c0:25:5c:78:8b:40-00 thread:15147430
*apfMsConnTask_2: Dec 10 13:49:06.937: cc:3a:61:6d:05:2e Ignoring assoc request due to mobile in exclusion list or marked for deletion
*apfMsConnTask_2: Dec 10 13:49:06.937: cc:3a:61:6d:05:2e Sending client blacklist entry to roamed AP c0:25:5c:78:8b:40 with remaining time to be excluded 45sec
*apfMsConnTask_2: Dec 10 13:49:07.257: cc:3a:61:6d:05:2e Processing assoc-req station:cc:3a:61:6d:05:2e AP:c0:25:5c:78:8b:40-00 thread:15147430
*apfMsConnTask_2: Dec 10 13:49:07.257: cc:3a:61:6d:05:2e Ignoring assoc request due to mobile in exclusion list or marked for deletion
*apfMsConnTask_2: Dec 10 13:49:07.257: cc:3a:61:6d:05:2e Sending client blacklist entry to roamed AP c0:25:5c:78:8b:40 with remaining time to be excluded 45sec
*Dot1x_NW_MsgTask_7: Dec 10 13:49:07.345: Ignoring Announce, role = 0, Client IP: 56.148.150.127 Client mac: 2d:c7:00:00:00:00 Peer IP: 172.16.31.10

*Dot1x_NW_MsgTask_4: Dec 10 13:49:07.377: hdrType not mmNacStateUpdate,line 9793,freeing

*apfReceiveTask: Dec 10 13:49:07.378: Mobility Response: Client IP 172.30.44.219 code Handoff (1), reason I(local) will be anchor (2), PEM State RUN, Role Local(1)
*Dot1x_NW_MsgTask_7: Dec 10 13:49:07.509: CCKM: Sending CCKM PMK (Version_2) information to mobility group
*apfReceiveTask: Dec 10 13:49:07.568: Mobility Response: Client IP 172.30.40.19 code Handoff (1), reason I(local) will be anchor (2), PEM State RUN, Role Local(1)
*Dot1x_NW_MsgTask_3: Dec 10 13:49:07.570: hdrType not mmNacStateUpdate,line 9793,freeing

*apfMsConnTask_2: Dec 10 13:49:07.577: cc:3a:61:6d:05:2e Processing assoc-req station:cc:3a:61:6d:05:2e AP:c0:25:5c:78:8b:40-00 thread:15147430
*apfMsConnTask_2: Dec 10 13:49:07.577: cc:3a:61:6d:05:2e Ignoring assoc request due to mobile in exclusion list or marked for deletion
*apfMsConnTask_2: Dec 10 13:49:07.577: cc:3a:61:6d:05:2e Sending client blacklist entry to roamed AP c0:25:5c:78:8b:40 with remaining time to be excluded 45sec
*Dot1x_NW_MsgTask_1: Dec 10 13:49:07.685: hdrType not mmNacStateUpdate,line 9793,freeing

*apfReceiveTask: Dec 10 13:49:07.686: Mobility Response: Client IP 172.30.94.78 code Handoff (1), reason I(local) will be anchor (2), PEM State RUN, Role Local(1)
*apfMsConnTask_2: Dec 10 13:49:07.895: cc:3a:61:6d:05:2e Processing assoc-req station:cc:3a:61:6d:05:2e AP:c0:25:5c:78:8b:40-00 thread:15147430
*apfMsConnTask_2: Dec 10 13:49:07.895: cc:3a:61:6d:05:2e Ignoring assoc request due to mobile in exclusion list or marked for deletion
*apfMsConnTask_2: Dec 10 13:49:07.896: cc:3a:61:6d:05:2e Sending client blacklist entry to roamed AP c0:25:5c:78:8b:40 with remaining time to be excluded 44sec
*Dot1x_NW_MsgTask_5: Dec 10 13:49:07.981: Ignoring Announce, role = 0, Client IP: 136.50.155.99 Client mac: 5c:85:00:00:00:00 Peer IP: 172.16.31.6

*apfMsConnTask_2: Dec 10 13:49:08.214: cc:3a:61:6d:05:2e Processing assoc-req station:cc:3a:61:6d:05:2e AP:c0:25:5c:78:8b:40-00 thread:15147430
*apfMsConnTask_2: Dec 10 13:49:08.214: cc:3a:61:6d:05:2e Ignoring assoc request due to mobile in exclusion list or marked for deletion
*apfMsConnTask_2: Dec 10 13:49:08.214: cc:3a:61:6d:05:2e Sending client blacklist entry to roamed AP c0:25:5c:78:8b:40 with remaining time to be excluded 44sec
*Dot1x_NW_MsgTask_7: Dec 10 13:49:08.324: Ignoring Announce, role = 0, Client IP: 56.148.150.127 Client mac: 2d:c7:00:00:00:00 Peer IP: 172.16.31.10

*apfMsConnTask_2: Dec 10 13:49:08.532: cc:3a:61:6d:05:2e Processing assoc-req station:cc:3a:61:6d:05:2e AP:c0:25:5c:78:8b:40-00 thread:15147430
*apfMsConnTask_2: Dec 10 13:49:08.532: cc:3a:61:6d:05:2e Ignoring assoc request due to mobile in exclusion list or marked for deletion
*apfMsConnTask_2: Dec 10 13:49:08.532: cc:3a:61:6d:05:2e Sending client blacklist entry to roamed AP c0:25:5c:78:8b:40 with remaining time to be excluded 44sec
*Dot1x_NW_MsgTask_7: Dec 10 13:49:09.324: Ignoring Announce, role = 0, Client IP: 56.148.150.127 Client mac: 2d:c7:00:00:00:00 Peer IP: 172.16.31.10

*apfReceiveTask: Dec 10 13:49:09.502: mmHandoffConfirm: Mobile Announce Mip not present, client mac e8:50:8b:ac:9c:de

*apfReceiveTask: Dec 10 13:49:09.502: Mobility Response: Client IP 0.0.0.0 code Handoff (1), reason Handoff request timed out (7), PEM State DHCP_REQD, Role Local(1)
*Dot1x_NW_MsgTask_4: Dec 10 13:49:09.775: hdrType not mmNacStateUpdate,line 9793,freeing

*apfReceiveTask: Dec 10 13:49:09.776: Mobility Response: Client IP 172.30.192.129 code Handoff (1), reason I(local) will be anchor (2), PEM State RUN, Role Local(1)
*apfReceiveTask: Dec 10 13:49:10.320: Mobility Response: Client IP 0.0.0.0 code Handoff Indication (2), reason Client handoff successful - anchor released (0), PEM State DHCP_REQD, Role Handoff(6)
*apfReceiveTask: Dec 10 13:49:10.502: mmHandoffConfirm: Mobile Announce Mip not present, client mac 4c:66:41:56:e6:b7

*apfReceiveTask: Dec 10 13:49:10.502: Mobility Response: Client IP 0.0.0.0 code Handoff (1), reason Handoff request timed out (7), PEM State DHCP_REQD, Role Local(1)
*Dot1x_NW_MsgTask_7: Dec 10 13:49:10.740: hdrType not mmNacStateUpdate,line 9793,freeing

*apfReceiveTask: Dec 10 13:49:10.741: Mobility Response: Client IP 172.30.25.173 code Handoff (1), reason I(local) will be anchor (2), PEM State RUN, Role Local(1)
*Dot1x_NW_MsgTask_1: Dec 10 13:49:10.764: Ignoring Announce, role = 0, Client IP: 88.127.87.240 Client mac: 18:b1:00:00:00:00 Peer IP: 172.16.31.6

*apfMsConnTask_2: Dec 10 13:49:10.977: cc:3a:61:6d:05:2e Processing assoc-req station:cc:3a:61:6d:05:2e AP:c0:25:5c:78:8b:40-00 thread:15147430
*apfMsConnTask_2: Dec 10 13:49:10.977: cc:3a:61:6d:05:2e Ignoring assoc request due to mobile in exclusion list or marked for deletion
*apfMsConnTask_2: Dec 10 13:49:10.978: cc:3a:61:6d:05:2e Sending client blacklist entry to roamed AP c0:25:5c:78:8b:40 with remaining time to be excluded 41sec
*apfMsConnTask_2: Dec 10 13:49:11.296: cc:3a:61:6d:05:2e Processing assoc-req station:cc:3a:61:6d:05:2e AP:c0:25:5c:78:8b:40-00 thread:15147430
*apfMsConnTask_2: Dec 10 13:49:11.296: cc:3a:61:6d:05:2e Ignoring assoc request due to mobile in exclusion list or marked for deletion
*apfMsConnTask_2: Dec 10 13:49:11.296: cc:3a:61:6d:05:2e Sending client blacklist entry to roamed AP c0:25:5c:78:8b:40 with remaining time to be excluded 41sec
*apfMsConnTask_2: Dec 10 13:49:11.614: cc:3a:61:6d:05:2e Processing assoc-req station:cc:3a:61:6d:05:2e AP:c0:25:5c:78:8b:40-00 thread:15147430
*apfMsConnTask_2: Dec 10 13:49:11.615: cc:3a:61:6d:05:2e Ignoring assoc request due to mobile in exclusion list or marked for deletion
*apfMsConnTask_2: Dec 10 13:49:11.615: cc:3a:61:6d:05:2e Sending client blacklist entry to roamed AP c0:25:5c:78:8b:40 with remaining time to be excluded 41sec
*Dot1x_NW_MsgTask_5: Dec 10 13:49:11.645: hdrType not mmNacStateUpdate,line 9793,freeing

*apfReceiveTask: Dec 10 13:49:11.646: Mobility Response: Client IP 172.30.1.203 code Handoff (1), reason I(local) will be anchor (2), PEM State RUN, Role Local(1)
*apfReceiveTask: Dec 10 13:49:11.851: Mobility Response: Client IP 0.0.0.0 code Handoff Indication (2), reason Client handoff successful - anchor released (0), PEM State DHCP_REQD, Role Handoff(6)
*apfMsConnTask_2: Dec 10 13:49:11.935: cc:3a:61:6d:05:2e Processing assoc-req station:cc:3a:61:6d:05:2e AP:c0:25:5c:78:8b:40-00 thread:15147430
*apfMsConnTask_2: Dec 10 13:49:11.935: cc:3a:61:6d:05:2e Ignoring assoc request due to mobile in exclusion list or marked for deletion
*apfMsConnTask_2: Dec 10 13:49:11.935: cc:3a:61:6d:05:2e Sending client blacklist entry to roamed AP c0:25:5c:78:8b:40 with remaining time to be excluded 40sec
*apfMsConnTask_2: Dec 10 13:49:12.254: cc:3a:61:6d:05:2e Processing assoc-req station:cc:3a:61:6d:05:2e AP:c0:25:5c:78:8b:40-00 thread:15147430
*apfMsConnTask_2: Dec 10 13:49:12.254: cc:3a:61:6d:05:2e Ignoring assoc request due to mobile in exclusion list or marked for deletion
*apfMsConnTask_2: Dec 10 13:49:12.254: cc:3a:61:6d:05:2e Sending client blacklist entry to roamed AP c0:25:5c:78:8b:40 with remaining time to be excluded 40sec
*apfReceiveTask: Dec 10 13:49:12.301: mmHandoffConfirm: Mobile Announce Mip not present, client mac 64:cc:2e:d5:c8:f5

*apfReceiveTask: Dec 10 13:49:12.301: Mobility Response: Client IP 0.0.0.0 code Handoff (1), reason Handoff request timed out (7), PEM State DHCP_REQD, Role Local(1)
*apfMsConnTask_2: Dec 10 13:49:12.575: cc:3a:61:6d:05:2e Processing assoc-req station:cc:3a:61:6d:05:2e AP:c0:25:5c:78:8b:40-00 thread:15147430
*apfMsConnTask_2: Dec 10 13:49:12.575: cc:3a:61:6d:05:2e Ignoring assoc request due to mobile in exclusion list or marked for deletion
*apfMsConnTask_2: Dec 10 13:49:12.576: cc:3a:61:6d:05:2e Sending client blacklist entry to roamed AP c0:25:5c:78:8b:40 with remaining time to be excluded 40sec
*apfReceiveTask: Dec 10 13:49:12.901: mmHandoffConfirm: Mobile Announce Mip not present, client mac b4:8b:19:7b:d2:97

*apfReceiveTask: Dec 10 13:49:12.902: Mobility Response: Client IP 0.0.0.0 code Handoff (1), reason Handoff request timed out (7), PEM State DHCP_REQD, Role Local(1)
*apfMsConnTask_2: Dec 10 13:49:12.906: cc:3a:61:6d:05:2e Processing assoc-req station:cc:3a:61:6d:05:2e AP:c0:25:5c:78:8b:40-00 thread:15147430
*apfMsConnTask_2: Dec 10 13:49:12.906: cc:3a:61:6d:05:2e Ignoring assoc request due to mobile in exclusion list or marked for deletion
*apfMsConnTask_2: Dec 10 13:49:12.906: cc:3a:61:6d:05:2e Sending client blacklist entry to roamed AP c0:25:5c:78:8b:40 with remaining time to be excluded 39sec
*Dot1x_NW_MsgTask_3: Dec 10 13:49:12.912: hdrType not mmNacStateUpdate,line 9793,freeing

*apfReceiveTask: Dec 10 13:49:12.913: Mobility Response: Client IP 192.168.134.193 code Handoff (1), reason I(local) will be anchor (2), PEM State RUN, Role Local(1)
*Dot1x_NW_MsgTask_1: Dec 10 13:49:13.156: hdrType not mmNacStateUpdate,line 9793,freeing

*apfReceiveTask: Dec 10 13:49:13.157: Mobility Response: Client IP 172.30.9.104 code Handoff (1), reason I(local) will be anchor (2), PEM State RUN, Role Local(1)
*apfReceiveTask: Dec 10 13:49:13.363: Mobility Response: Client IP 0.0.0.0 code Handoff Indication (2), reason Client handoff successful - anchor released (0), PEM State DHCP_REQD, Role Handoff(6)
*Dot1x_NW_MsgTask_3: Dec 10 13:49:13.490: hdrType not mmNacStateUpdate,line 9793,freeing

*apfReceiveTask: Dec 10 13:49:13.491: Mobility Response: Client IP 172.30.3.100 code Handoff (1), reason I(local) will be anchor (2), PEM State RUN, Role Local(1)
*apfReceiveTask: Dec 10 13:49:13.501: mmHandoffConfirm: Mobile Announce Mip not present, client mac 00:24:d2:cb:41:d5

*apfReceiveTask: Dec 10 13:49:13.502: Mobility Response: Client IP 0.0.0.0 code Handoff (1), reason Handoff request timed out (7), PEM State DHCP_REQD, Role Local(1)
*Dot1x_NW_MsgTask_7: Dec 10 13:49:14.603: CCKM: Sending CCKM PMK (Version_2) information to mobility group
*apfMsConnTask_0: Dec 10 13:49:14.639: cc:3a:61:6d:05:2e Processing assoc-req station:cc:3a:61:6d:05:2e AP:54:78:1a:d0:16:50-00 thread:15146c90
*apfMsConnTask_0: Dec 10 13:49:14.639: cc:3a:61:6d:05:2e Ignoring assoc request due to mobile in exclusion list or marked for deletion
*Dot1x_NW_MsgTask_7: Dec 10 13:49:14.739: hdrType not mmNacStateUpdate,line 9793,freeing

*apfReceiveTask: Dec 10 13:49:14.740: Mobility Response: Client IP 172.30.17.111 code Handoff (1), reason I(local) will be anchor (2), PEM State RUN, Role Local(1)
*apfReceiveTask: Dec 10 13:49:14.857: Mobility Response: Client IP 0.0.0.0 code Handoff Indication (2), reason Client handoff successful - anchor released (0), PEM State DHCP_REQD, Role Handoff(6)
*apfMsConnTask_0: Dec 10 13:49:14.963: cc:3a:61:6d:05:2e Processing assoc-req station:cc:3a:61:6d:05:2e AP:54:78:1a:d0:16:50-00 thread:15146c90
*apfMsConnTask_0: Dec 10 13:49:14.963: cc:3a:61:6d:05:2e Ignoring assoc request due to mobile in exclusion list or marked for deletion
*apfMsConnTask_0: Dec 10 13:49:15.281: cc:3a:61:6d:05:2e Processing assoc-req station:cc:3a:61:6d:05:2e AP:54:78:1a:d0:16:50-00 thread:15146c90
*apfMsConnTask_0: Dec 10 13:49:15.281: cc:3a:61:6d:05:2e Ignoring assoc request due to mobile in exclusion list or marked for deletion
*apfMsConnTask_0: Dec 10 13:49:15.599: cc:3a:61:6d:05:2e Processing assoc-req station:cc:3a:61:6d:05:2e AP:54:78:1a:d0:16:50-00 thread:15146c90
*apfMsConnTask_0: Dec 10 13:49:15.600: cc:3a:61:6d:05:2e Ignoring assoc request due to mobile in exclusion list or marked for deletion
*apfReceiveTask: Dec 10 13:49:15.904: Mobility Response: Client IP 0.0.0.0 code Handoff Indication (2), reason Client handoff successful - anchor released (0), PEM State DHCP_REQD, Role Handoff(6)
*apfReceiveTask: Dec 10 13:49:15.919: Mobility Response: Client IP 0.0.0.0 code Handoff Indication (2), reason Client handoff successful - anchor released (0), PEM State DHCP_REQD, Role Handoff(6)
*apfReceiveTask: Dec 10 13:49:15.926: Mobility Response: Client IP 0.0.0.0 code Handoff Indication (2), reason Client handoff successful - anchor released (0), PEM State DHCP_REQD, Role Handoff(6)
*apfMsConnTask_0: Dec 10 13:49:15.988: cc:3a:61:6d:05:2e Processing assoc-req station:cc:3a:61:6d:05:2e AP:54:78:1a:d0:16:50-00 thread:15146c90
*apfMsConnTask_0: Dec 10 13:49:15.988: cc:3a:61:6d:05:2e Ignoring assoc request due to mobile in exclusion list or marked for deletion
*Dot1x_NW_MsgTask_6: Dec 10 13:49:16.214: hdrType not mmNacStateUpdate,line 9793,freeing

*apfReceiveTask: Dec 10 13:49:16.215: Mobility Response: Client IP 172.30.110.74 code Handoff (1), reason I(local) will be anchor (2), PEM State RUN, Role Local(1)
*apfMsConnTask_0: Dec 10 13:49:16.307: cc:3a:61:6d:05:2e Processing assoc-req station:cc:3a:61:6d:05:2e AP:54:78:1a:d0:16:50-00 thread:15146c90
*apfMsConnTask_0: Dec 10 13:49:16.307: cc:3a:61:6d:05:2e Ignoring assoc request due to mobile in exclusion list or marked for deletion
*apfReceiveTask: Dec 10 13:49:16.368: Mobility Response: Client IP 0.0.0.0 code Handoff Indication (2), reason Client handoff successful - anchor released (0), PEM State DHCP_REQD, Role Handoff(6)
*apfMsConnTask_0: Dec 10 13:49:16.628: cc:3a:61:6d:05:2e Processing assoc-req station:cc:3a:61:6d:05:2e AP:54:78:1a:d0:16:50-00 thread:15146c90
*apfMsConnTask_0: Dec 10 13:49:16.628: cc:3a:61:6d:05:2e Ignoring assoc request due to mobile in exclusion list or marked for deletion
*apfReceiveTask: Dec 10 13:49:16.903: Mobility Response: Client IP 0.0.0.0 code Handoff Indication (2), reason Client handoff successful - anchor released (0), PEM State DHCP_REQD, Role Handoff(6)
*Dot1x_NW_MsgTask_0: Dec 10 13:49:16.935: hdrType not mmNacStateUpdate,line 9793,freeing

*apfReceiveTask: Dec 10 13:49:16.936: Mobility Response: Client IP 172.30.39.209 code Handoff (1), reason I(local) will be anchor (2), PEM State RUN, Role Local(1)
*Dot1x_NW_MsgTask_1: Dec 10 13:49:17.332: hdrType not mmNacStateUpdate,line 9793,freeing

*apfReceiveTask: Dec 10 13:49:17.333: Mobility Response: Client IP 172.30.62.148 code Handoff (1), reason I(local) will be anchor (2), PEM State RUN, Role Local(1)
*apfReceiveTask: Dec 10 13:49:17.459: Mobility Response: Client IP 0.0.0.0 code Handoff Indication (2), reason Client handoff successful - anchor released (0), PEM State DHCP_REQD, Role Handoff(6)
*apfReceiveTask: Dec 10 13:49:17.623: Mobility Response: Client IP 172.30.1.128 code Handoff (1), reason I(local) will be anchor (2), PEM State RUN, Role Local(1)
*Dot1x_NW_MsgTask_0: Dec 10 13:49:17.625: hdrType not mmNacStateUpdate,line 9793,freeing

*Dot1x_NW_MsgTask_0: Dec 10 13:49:17.877: hdrType not mmNacStateUpdate,line 9793,freeing

*apfReceiveTask: Dec 10 13:49:17.878: Mobility Response: Client IP 172.30.18.17 code Handoff (1), reason I(local) will be anchor (2), PEM State RUN, Role Local(1)
*apfReceiveTask: Dec 10 13:49:17.980: Mobility Response: Client IP 0.0.0.0 code Handoff Indication (2), reason Client handoff successful - anchor released (0), PEM State DHCP_REQD, Role Handoff(6)
*apfReceiveTask: Dec 10 13:49:18.501: mmHandoffConfirm: Mobile Announce Mip not present, client mac fc:3f:7c:af:ac:ff

*apfReceiveTask: Dec 10 13:49:18.501: Mobility Response: Client IP 0.0.0.0 code Handoff (1), reason Handoff request timed out (7), PEM State DHCP_REQD, Role Local(1)
*Dot1x_NW_MsgTask_3: Dec 10 13:49:19.471: hdrType not mmNacStateUpdate,line 9793,freeing

*apfReceiveTask: Dec 10 13:49:19.472: Mobility Response: Client IP 172.30.13.62 code Handoff (1), reason I(local) will be anchor (2), PEM State RUN, Role Local(1)
*apfReceiveTask: Dec 10 13:49:19.762: Mobility Response: Client IP 0.0.0.0 code Handoff Indication (2), reason Client handoff successful - anchor released (0), PEM State DHCP_REQD, Role Handoff(6)
*apfReceiveTask: Dec 10 13:49:19.839: Mobility Response: Client IP 0.0.0.0 code Handoff Indication (2), reason Client handoff successful - anchor released (0), PEM State DHCP_REQD, Role Handoff(6)
*apfReceiveTask: Dec 10 13:49:20.030: Mobility Response: Client IP 0.0.0.0 code Handoff Indication (2), reason Client handoff successful - anchor released (0), PEM State DHCP_REQD, Role Handoff(6)
*apfReceiveTask: Dec 10 13:49:20.101: mmHandoffConfirm: Mobile Announce Mip not present, client mac 64:89:9a:60:0d:31

*apfReceiveTask: Dec 10 13:49:20.101: Mobility Response: Client IP 0.0.0.0 code Handoff (1), reason Handoff request timed out (7), PEM State DHCP_REQD, Role Local(1)
*Dot1x_NW_MsgTask_7: Dec 10 13:49:20.147: Ignoring Announce, role = 0, Client IP: 156.4.235.174 Client mac: ab:a7:00:00:00:00 Peer IP: 172.16.31.9

*Dot1x_NW_MsgTask_6: Dec 10 13:49:20.556: hdrType not mmNacStateUpdate,line 9793,freeing

*apfReceiveTask: Dec 10 13:49:20.557: Mobility Response: Client IP 172.30.39.137 code Handoff (1), reason I(local) will be anchor (2), PEM State RUN, Role Local(1)
*Dot1x_NW_MsgTask_3: Dec 10 13:49:20.583: Ignoring Announce, role = 0, Client IP: 160.50.153.12 Client mac: 34:13:00:00:00:00 Peer IP: 172.16.31.9

*apfReceiveTask: Dec 10 13:49:21.102: mmHandoffConfirm: Mobile Announce Mip not present, client mac e0:db:10:5f:73:d3

*apfReceiveTask: Dec 10 13:49:21.102: Mobility Response: Client IP 0.0.0.0 code Handoff (1), reason Handoff request timed out (7), PEM State DHCP_REQD, Role Local(1)
*Dot1x_NW_MsgTask_7: Dec 10 13:49:21.331: hdrType not mmNacStateUpdate,line 9793,freeing

*apfReceiveTask: Dec 10 13:49:21.333: Mobility Response: Client IP 172.30.176.234 code Handoff (1), reason I(local) will be anchor (2), PEM State RUN, Role Local(1)
*spamApTask1: Dec 10 13:49:21.638: cc:3a:61:6d:05:2e Received DELETE mobile, reason MN_REASSOC_TIMEOUT, from AP 54:78:1a:d0:16:50, slot 0 ...cleaning up mscb
*spamApTask1: Dec 10 13:49:21.638: cc:3a:61:6d:05:2e Ignoring delete request from AP due to mobile in exclusion list or marked for deletion already
*apfReceiveTask: Dec 10 13:49:21.814: Mobility Response: Client IP 0.0.0.0 code Handoff Indication (2), reason Client handoff successful - anchor released (0), PEM State DHCP_REQD, Role Handoff(6)
*apfReceiveTask: Dec 10 13:49:21.894: Mobility Response: Client IP 0.0.0.0 code Handoff Indication (2), reason Client handoff successful - anchor released (0), PEM State DHCP_REQD, Role Handoff(6)
*apfReceiveTask: Dec 10 13:49:21.901: mmHandoffConfirm: Mobile Announce Mip not present, client mac d0:25:98:cb:ee:89

*apfReceiveTask: Dec 10 13:49:21.901: Mobility Response: Client IP 0.0.0.0 code Handoff (1), reason Handoff request timed out (7), PEM State DHCP_REQD, Role Local(1)
*apfMsConnTask_2: Dec 10 13:49:22.227: cc:3a:61:6d:05:2e Processing assoc-req station:cc:3a:61:6d:05:2e AP:c0:25:5c:78:8b:40-00 thread:15147430
*apfMsConnTask_2: Dec 10 13:49:22.227: cc:3a:61:6d:05:2e Ignoring assoc request due to mobile in exclusion list or marked for deletion
*apfMsConnTask_2: Dec 10 13:49:22.227: cc:3a:61:6d:05:2e Sending client blacklist entry to roamed AP c0:25:5c:78:8b:40 with remaining time to be excluded 30sec
*Dot1x_NW_MsgTask_6: Dec 10 13:49:22.306: hdrType not mmNacStateUpdate,line 9793,freeing

*apfReceiveTask: Dec 10 13:49:22.307: Mobility Response: Client IP 172.30.31.129 code Handoff (1), reason I(local) will be anchor (2), PEM State RUN, Role Local(1)
*apfReceiveTask: Dec 10 13:49:22.507: Mobility Response: Client IP 0.0.0.0 code Handoff Indication (2), reason Client handoff successful - anchor released (0), PEM State DHCP_REQD, Role Handoff(6)
*apfMsConnTask_2: Dec 10 13:49:22.545: cc:3a:61:6d:05:2e Processing assoc-req station:cc:3a:61:6d:05:2e AP:c0:25:5c:78:8b:40-00 thread:15147430
*apfMsConnTask_2: Dec 10 13:49:22.545: cc:3a:61:6d:05:2e Ignoring assoc request due to mobile in exclusion list or marked for deletion
*apfMsConnTask_2: Dec 10 13:49:22.545: cc:3a:61:6d:05:2e Sending client blacklist entry to roamed AP c0:25:5c:78:8b:40 with remaining time to be excluded 30sec
*Dot1x_NW_MsgTask_5: Dec 10 13:49:22.688: hdrType not mmNacStateUpdate,line 9793,freeing

*apfReceiveTask: Dec 10 13:49:22.689: Mobility Response: Client IP 172.30.127.136 code Handoff (1), reason I(local) will be anchor (2), PEM State RUN, Role Local(1)
*apfMsConnTask_2: Dec 10 13:49:22.867: cc:3a:61:6d:05:2e Processing assoc-req station:cc:3a:61:6d:05:2e AP:c0:25:5c:78:8b:40-00 thread:15147430
*apfMsConnTask_2: Dec 10 13:49:22.867: cc:3a:61:6d:05:2e Ignoring assoc request due to mobile in exclusion list or marked for deletion
*apfMsConnTask_2: Dec 10 13:49:22.867: cc:3a:61:6d:05:2e Sending client blacklist entry to roamed AP c0:25:5c:78:8b:40 with remaining time to be excluded 29sec
*apfReceiveTask: Dec 10 13:49:23.415: Mobility Response: Client IP 0.0.0.0 code Handoff Indication (2), reason Client handoff successful - anchor released (0), PEM State DHCP_REQD, Role Handoff(6)
*apfReceiveTask: Dec 10 13:49:24.003: Mobility Response: Client IP 0.0.0.0 code Handoff Indication (2), reason Client handoff successful - anchor released (0), PEM State DHCP_REQD, Role Handoff(6)
*Dot1x_NW_MsgTask_4: Dec 10 13:49:24.090: Ignoring Announce, role = 0, Client IP: 76.102.65.181 Client mac: d9:b4:00:00:00:00 Peer IP: 172.16.31.9

*Dot1x_NW_MsgTask_2: Dec 10 13:49:24.214: hdrType not mmNacStateUpdate,line 9793,freeing

*apfReceiveTask: Dec 10 13:49:24.215: Handoff 802.1x PEM state 0, client state 20, client 172.30.30.149

*apfReceiveTask: Dec 10 13:49:24.216: Mobility Response: Client IP 172.30.30.149 code Handoff (1), reason I(local) will be anchor (2), PEM State RUN, Role Local(1)
*apfReceiveTask: Dec 10 13:49:24.302: mmHandoffConfirm: Mobile Announce Mip not present, client mac 10:30:47:22:ee:c5

*apfReceiveTask: Dec 10 13:49:24.302: Mobility Response: Client IP 0.0.0.0 code Handoff (1), reason Handoff request timed out (7), PEM State DHCP_REQD, Role Local(1)
*apfReceiveTask: Dec 10 13:49:24.514: Mobility Response: Client IP 0.0.0.0 code Handoff Indication (2), reason Client handoff successful - anchor released (0), PEM State DHCP_REQD, Role Handoff(6)
*apfReceiveTask: Dec 10 13:49:24.808: Mobility Response: Client IP 0.0.0.0 code Handoff Indication (2), reason Client handoff successful - anchor released (0), PEM State DHCP_REQD, Role Handoff(6)
*apfReceiveTask: Dec 10 13:49:24.998: Mobility Response: Client IP 0.0.0.0 code Handoff Indication (2), reason Client handoff successful - anchor released (0), PEM State DHCP_REQD, Role Handoff(6)
*Dot1x_NW_MsgTask_4: Dec 10 13:49:25.034: Ignoring Announce, role = 0, Client IP: 76.102.65.181 Client mac: d9:b4:00:00:00:00 Peer IP: 172.16.31.9

*apfMsConnTask_2: Dec 10 13:49:25.106: cc:3a:61:6d:05:2e Processing assoc-req station:cc:3a:61:6d:05:2e AP:c0:25:5c:78:8b:40-00 thread:15147430
*apfMsConnTask_2: Dec 10 13:49:25.106: cc:3a:61:6d:05:2e Ignoring assoc request due to mobile in exclusion list or marked for deletion
*apfMsConnTask_2: Dec 10 13:49:25.106: cc:3a:61:6d:05:2e Sending client blacklist entry to roamed AP c0:25:5c:78:8b:40 with remaining time to be excluded 27sec
*apfMsConnTask_2: Dec 10 13:49:25.426: cc:3a:61:6d:05:2e Processing assoc-req station:cc:3a:61:6d:05:2e AP:c0:25:5c:78:8b:40-00 thread:15147430
*apfMsConnTask_2: Dec 10 13:49:25.426: cc:3a:61:6d:05:2e Ignoring assoc request due to mobile in exclusion list or marked for deletion
*apfMsConnTask_2: Dec 10 13:49:25.426: cc:3a:61:6d:05:2e Sending client blacklist entry to roamed AP c0:25:5c:78:8b:40 with remaining time to be excluded 27sec
*apfMsConnTask_2: Dec 10 13:49:25.745: cc:3a:61:6d:05:2e Processing assoc-req station:cc:3a:61:6d:05:2e AP:c0:25:5c:78:8b:40-00 thread:15147430
*apfMsConnTask_2: Dec 10 13:49:25.745: cc:3a:61:6d:05:2e Ignoring assoc request due to mobile in exclusion list or marked for deletion
*apfMsConnTask_2: Dec 10 13:49:25.745: cc:3a:61:6d:05:2e Sending client blacklist entry to roamed AP c0:25:5c:78:8b:40 with remaining time to be excluded 26sec
*Dot1x_NW_MsgTask_4: Dec 10 13:49:26.034: Ignoring Announce, role = 0, Client IP: 76.102.65.181 Client mac: d9:b4:00:00:00:00 Peer IP: 172.16.31.9

*apfMsConnTask_2: Dec 10 13:49:26.065: cc:3a:61:6d:05:2e Processing assoc-req station:cc:3a:61:6d:05:2e AP:c0:25:5c:78:8b:40-00 thread:15147430
*apfMsConnTask_2: Dec 10 13:49:26.065: cc:3a:61:6d:05:2e Ignoring assoc request due to mobile in exclusion list or marked for deletion
*apfMsConnTask_2: Dec 10 13:49:26.065: cc:3a:61:6d:05:2e Sending client blacklist entry to roamed AP c0:25:5c:78:8b:40 with remaining time to be excluded 26sec
*apfReceiveTask: Dec 10 13:49:26.294: Mobility Response: Client IP 0.0.0.0 code Handoff Indication (2), reason Client handoff successful - anchor released (0), PEM State DHCP_REQD, Role Handoff(6)
*Dot1x_NW_MsgTask_0: Dec 10 13:49:26.680: hdrType not mmNacStateUpdate,line 9793,freeing

*apfReceiveTask: Dec 10 13:49:26.682: Mobility Response: Client IP 172.30.39.209 code Handoff (1), reason I(local) will be anchor (2), PEM State RUN, Role Local(1)
*apfMsConnTask_2: Dec 10 13:49:26.708: cc:3a:61:6d:05:2e Processing assoc-req station:cc:3a:61:6d:05:2e AP:c0:25:5c:78:8b:40-00 thread:15147430
*apfMsConnTask_2: Dec 10 13:49:26.708: cc:3a:61:6d:05:2e Ignoring assoc request due to mobile in exclusion list or marked for deletion
*apfMsConnTask_2: Dec 10 13:49:26.708: cc:3a:61:6d:05:2e Sending client blacklist entry to roamed AP c0:25:5c:78:8b:40 with remaining time to be excluded 26sec
*apfReceiveTask: Dec 10 13:49:26.727: Mobility Response: Client IP 172.30.200.83 code Handoff (1), reason I(local) will be anchor (2), PEM State RUN, Role Local(1)
*Dot1x_NW_MsgTask_6: Dec 10 13:49:26.730: hdrType not mmNacStateUpdate,line 9793,freeing

*apfReceiveTask: Dec 10 13:49:26.763: Mobility Response: Client IP 172.30.134.211 code Handoff (1), reason I(local) will be anchor (2), PEM State RUN, Role Local(1)
*Dot1x_NW_MsgTask_6: Dec 10 13:49:26.766: hdrType not mmNacStateUpdate,line 9793,freeing

*apfReceiveTask: Dec 10 13:49:27.028: Mobility Response: Client IP 0.0.0.0 code Handoff Indication (2), reason Client handoff successful - anchor released (0), PEM State DHCP_REQD, Role Handoff(6)
*apfMsConnTask_2: Dec 10 13:49:27.032: cc:3a:61:6d:05:2e Processing assoc-req station:cc:3a:61:6d:05:2e AP:c0:25:5c:78:8b:40-00 thread:15147430
*apfMsConnTask_2: Dec 10 13:49:27.032: cc:3a:61:6d:05:2e Ignoring assoc request due to mobile in exclusion list or marked for deletion
*apfMsConnTask_2: Dec 10 13:49:27.032: cc:3a:61:6d:05:2e Sending client blacklist entry to roamed AP c0:25:5c:78:8b:40 with remaining time to be excluded 25sec
*apfReceiveTask: Dec 10 13:49:27.298: Mobility Response: Client IP 0.0.0.0 code Handoff Indication (2), reason Client handoff successful - anchor released (0), PEM State DHCP_REQD, Role Handoff(6)
*Dot1x_NW_MsgTask_3: Dec 10 13:49:27.309: hdrType not mmNacStateUpdate,line 9793,freeing

*apfReceiveTask: Dec 10 13:49:27.310: Mobility Response: Client IP 172.30.41.52 code Handoff (1), reason I(local) will be anchor (2), PEM State RUN, Role Local(1)
*apfReceiveTask: Dec 10 13:49:27.654: Mobility Response: Client IP 0.0.0.0 code Handoff Indication (2), reason Client handoff successful - anchor released (0), PEM State DHCP_REQD, Role Handoff(6)
*apfReceiveTask: Dec 10 13:49:27.941: Mobility Response: Client IP 0.0.0.0 code Handoff Indication (2), reason Client handoff successful - anchor released (0), PEM State DHCP_REQD, Role Handoff(6)
*Dot1x_NW_MsgTask_7: Dec 10 13:49:28.266: hdrType not mmNacStateUpdate,line 9793,freeing

*apfReceiveTask: Dec 10 13:49:28.268: Mobility Response: Client IP 172.30.77.143 code Handoff (1), reason I(local) will be anchor (2), PEM State RUN, Role Local(1)
*apfReceiveTask: Dec 10 13:49:28.366: Mobility Response: Client IP 0.0.0.0 code Handoff Indication (2), reason Client handoff successful - anchor released (0), PEM State DHCP_REQD, Role Handoff(6)
*apfReceiveTask: Dec 10 13:49:28.727: Mobility Response: Client IP 0.0.0.0 code Handoff Indication (2), reason Client handoff successful - anchor released (0), PEM State DHCP_REQD, Role Handoff(6)
*Dot1x_NW_MsgTask_5: Dec 10 13:49:28.996: hdrType not mmNacStateUpdate,line 9793,freeing

*apfReceiveTask: Dec 10 13:49:28.997: Mobility Response: Client IP 172.30.8.207 code Handoff (1), reason I(local) will be anchor (2), PEM State RUN, Role Local(1)
*Dot1x_NW_MsgTask_7: Dec 10 13:49:29.031: hdrType not mmNacStateUpdate,line 9793,freeing

*apfReceiveTask: Dec 10 13:49:29.033: Mobility Response: Client IP 172.30.188.161 code Handoff (1), reason I(local) will be anchor (2), PEM State RUN, Role Local(1)
*apfReceiveTask: Dec 10 13:49:29.057: Mobility Response: Client IP 0.0.0.0 code Handoff Indication (2), reason Client handoff successful - anchor released (0), PEM State DHCP_REQD, Role Handoff(6)
*Dot1x_NW_MsgTask_6: Dec 10 13:49:29.062: Dropped Mobile Announce received from 172.16.31.9 for client f4:42:8f:09:90:ae as it is marked for deletion. Client Mobilty State = 6.

*apfReceiveTask: Dec 10 13:49:29.253: Mobility Response: Client IP 0.0.0.0 code Handoff Indication (2), reason Client handoff successful - anchor released (0), PEM State DHCP_REQD, Role Handoff(6)
*Dot1x_NW_MsgTask_7: Dec 10 13:49:29.788: Ignoring Announce, role = 0, Client IP: 108.47.44.86 Client mac: f0:ef:00:00:00:00 Peer IP: 172.16.31.5

*apfReceiveTask: Dec 10 13:49:30.020: Mobility Response: Client IP 0.0.0.0 code Handoff Indication (2), reason Client handoff successful - anchor released (0), PEM State DHCP_REQD, Role Handoff(6)
*Dot1x_NW_MsgTask_4: Dec 10 13:49:30.109: hdrType not mmNacStateUpdate,line 9793,freeing

*apfReceiveTask: Dec 10 13:49:30.110: Mobility Response: Client IP 172.30.40.81 code Handoff (1), reason I(local) will be anchor (2), PEM State RUN, Role Local(1)
*apfReceiveTask: Dec 10 13:49:30.114: Mobility Response: Client IP 0.0.0.0 code Handoff Indication (2), reason Client handoff successful - anchor released (0), PEM State DHCP_REQD, Role Handoff(6)
*Dot1x_NW_MsgTask_0: Dec 10 13:49:30.131: CCKM: Sending CCKM PMK (Version_2) information to mobility group
*mmListen: Dec 10 13:49:30.142: Client payload is not found in recvd mmlisten packe hashing based on zero mac address, for msg type 5
*apfReceiveTask: Dec 10 13:49:30.143: Mobility Response: Client IP 0.0.0.0 code Handoff (1), reason Client is blacklisted (6), PEM State DHCP_REQD, Role Unassociated(0)
*Dot1x_NW_MsgTask_3: Dec 10 13:49:30.590: CCKM: Sending CCKM PMK (Version_2) information to mobility group
*Dot1x_NW_MsgTask_7: Dec 10 13:49:30.737: Ignoring Announce, role = 0, Client IP: 108.47.44.86 Client mac: f0:ef:00:00:00:00 Peer IP: 172.16.31.5

*Dot1x_NW_MsgTask_5: Dec 10 13:49:30.972: Ignoring Announce, role = 0, Client IP: 120.75.135.138 Client mac: ba:0d:00:00:00:00 Peer IP: 172.16.31.9

*apfReceiveTask: Dec 10 13:49:31.510: mmHandoffConfirm: Mobile Announce Mip not present, client mac 78:7e:61:07:c9:0b

*apfReceiveTask: Dec 10 13:49:31.510: Mobility Response: Client IP 0.0.0.0 code Handoff (1), reason Handoff request timed out (7), PEM State DHCP_REQD, Role Local(1)
*Dot1x_NW_MsgTask_7: Dec 10 13:49:31.738: Ignoring Announce, role = 0, Client IP: 108.47.44.86 Client mac: f0:ef:00:00:00:00 Peer IP: 172.16.31.5

*Dot1x_NW_MsgTask_5: Dec 10 13:49:31.834: Ignoring Announce, role = 0, Client IP: 120.75.135.138 Client mac: ba:0d:00:00:00:00 Peer IP: 172.16.31.9

*apfReceiveTask: Dec 10 13:49:32.119: Mobility Response: Client IP 0.0.0.0 code Handoff Indication (2), reason Client handoff successful - anchor released (0), PEM State DHCP_REQD, Role Handoff(6)
*apfReceiveTask: Dec 10 13:49:32.313: Mobility Response: Client IP 0.0.0.0 code Handoff Indication (2), reason Client handoff successful - anchor released (0), PEM State DHCP_REQD, Role Handoff(6)
*Dot1x_NW_MsgTask_5: Dec 10 13:49:32.834: Ignoring Announce, role = 0, Client IP: 120.75.135.138 Client mac: ba:0d:00:00:00:00 Peer IP: 172.16.31.9

*Dot1x_NW_MsgTask_4: Dec 10 13:49:32.947: hdrType not mmNacStateUpdate,line 9793,freeing

*apfReceiveTask: Dec 10 13:49:32.949: Mobility Response: Client IP 172.30.53.53 code Handoff (1), reason I(local) will be anchor (2), PEM State RUN, Role Local(1)
*apfReceiveTask: Dec 10 13:49:33.687: Mobility Response: Client IP 0.0.0.0 code Handoff Indication (2), reason Client handoff successful - anchor released (0), PEM State DHCP_REQD, Role Handoff(6)
*apfReceiveTask: Dec 10 13:49:33.927: Mobility Response: Client IP 0.0.0.0 code Handoff Indication (2), reason Client handoff successful - anchor released (0), PEM State DHCP_REQD, Role Handoff(6)
*apfReceiveTask: Dec 10 13:49:34.073: Mobility Response: Client IP 0.0.0.0 code Handoff Indication (2), reason Client handoff successful - anchor released (0), PEM State DHCP_REQD, Role Handoff(6)
*apfReceiveTask: Dec 10 13:49:34.360: Mobility Response: Client IP 0.0.0.0 code Handoff Indication (2), reason Client handoff successful - anchor released (0), PEM State DHCP_REQD, Role Handoff(6)
*Dot1x_NW_MsgTask_7: Dec 10 13:49:34.423: Ignoring Announce, role = 0, Client IP: 56.148.150.127 Client mac: 2d:c7:00:00:00:00 Peer IP: 172.16.31.5

*apfReceiveTask: Dec 10 13:49:34.558: Mobility Response: Client IP 0.0.0.0 code Handoff Indication (2), reason Client handoff successful - anchor released (0), PEM State DHCP_REQD, Role Handoff(6)
*apfReceiveTask: Dec 10 13:49:34.729: Mobility Response: Client IP 0.0.0.0 code Handoff Indication (2), reason Client handoff successful - anchor released (0), PEM State DHCP_REQD, Role Handoff(6)
*apfReceiveTask: Dec 10 13:49:35.472: Mobility Response: Client IP 0.0.0.0 code Handoff Indication (2), reason Client handoff successful - anchor released (0), PEM State DHCP_REQD, Role Handoff(6)
*apfReceiveTask: Dec 10 13:49:35.793: Mobility Response: Client IP 0.0.0.0 code Handoff Indication (2), reason Client handoff successful - anchor released (0), PEM State DHCP_REQD, Role Handoff(6)
*apfReceiveTask: Dec 10 13:49:35.909: mmHandoffConfirm: Mobile Announce Mip not present, client mac a8:fa:d8:1a:56:4e

*apfReceiveTask: Dec 10 13:49:35.909: Mobility Response: Client IP 0.0.0.0 code Handoff (1), reason Handoff request timed out (7), PEM State DHCP_REQD, Role Local(1)
*Dot1x_NW_MsgTask_1: Dec 10 13:49:35.994: Ignoring Announce, role = 0, Client IP: 196.154.2.67 Client mac: ec:49:00:00:00:00 Peer IP: 172.16.31.10

*apfReceiveTask: Dec 10 13:49:36.186: Mobility Response: Client IP 0.0.0.0 code Handoff Indication (2), reason Client handoff successful - anchor released (0), PEM State DHCP_REQD, Role Handoff(6)
*apfReceiveTask: Dec 10 13:49:36.389: Mobility Response: Client IP 0.0.0.0 code Handoff Indication (2), reason Client handoff successful - anchor released (0), PEM State DHCP_REQD, Role Handoff(6)
*Dot1x_NW_MsgTask_5: Dec 10 13:49:37.095: hdrType not mmNacStateUpdate,line 9793,freeing

*apfReceiveTask: Dec 10 13:49:37.097: Mobility Response: Client IP 172.30.43.143 code Handoff (1), reason I(local) will be anchor (2), PEM State RUN, Role Local(1)
*Dot1x_NW_MsgTask_3: Dec 10 13:49:37.191: CCKM: Sending CCKM PMK (Version_2) information to mobility group
*Dot1x_NW_MsgTask_3: Dec 10 13:49:37.203: hdrType not mmNacStateUpdate,line 9793,freeing

*apfReceiveTask: Dec 10 13:49:37.204: Mobility Response: Client IP 172.30.10.124 code Handoff (1), reason I(local) will be anchor (2), PEM State RUN, Role Local(1)
*apfReceiveTask: Dec 10 13:49:37.408: Mobility Response: Client IP 0.0.0.0 code Handoff Indication (2), reason Client handoff successful - anchor released (0), PEM State DHCP_REQD, Role Handoff(6)
*Dot1x_NW_MsgTask_1: Dec 10 13:49:37.534: hdrType not mmNacStateUpdate,line 9793,freeing

*apfReceiveTask: Dec 10 13:49:37.535: Mobility Response: Client IP 172.30.142.79 code Handoff (1), reason I(local) will be anchor (2), PEM State RUN, Role Local(1)
*apfReceiveTask: Dec 10 13:49:37.722: Mobility Response: Client IP 0.0.0.0 code Handoff Indication (2), reason Client handoff successful - anchor released (0), PEM State START, Role Handoff(6)
*Dot1x_NW_MsgTask_0: Dec 10 13:49:38.016: hdrType not mmNacStateUpdate,line 9793,freeing

*apfReceiveTask: Dec 10 13:49:38.017: Mobility Response: Client IP 172.30.122.29 code Handoff (1), reason I(local) will be anchor (2), PEM State RUN, Role Local(1)
*apfReceiveTask: Dec 10 13:49:38.185: Mobility Response: Client IP 0.0.0.0 code Handoff Indication (2), reason Client handoff successful - anchor released (0), PEM State DHCP_REQD, Role Handoff(6)
*apfReceiveTask: Dec 10 13:49:38.511: Mobility Response: Client IP 0.0.0.0 code Handoff Indication (2), reason Client handoff successful - anchor released (0), PEM State DHCP_REQD, Role Handoff(6)
*Dot1x_NW_MsgTask_2: Dec 10 13:49:38.629: hdrType not mmNacStateUpdate,line 9793,freeing

*apfReceiveTask: Dec 10 13:49:38.631: Mobility Response: Client IP 172.30.9.59 code Handoff (1), reason I(local) will be anchor (2), PEM State RUN, Role Local(1)
*apfReceiveTask: Dec 10 13:49:38.911: mmHandoffConfirm: Mobile Announce Mip not present, client mac 00:cd:fe:f2:d5:98

*apfReceiveTask: Dec 10 13:49:38.911: Mobility Response: Client IP 0.0.0.0 code Handoff (1), reason Handoff request timed out (7), PEM State DHCP_REQD, Role Local(1)
*Dot1x_NW_MsgTask_4: Dec 10 13:49:39.364: Ignoring Announce, role = 0, Client IP: 68.120.62.32 Client mac: 75:64:00:00:00:00 Peer IP: 172.16.31.10

*apfReceiveTask: Dec 10 13:49:39.372: Mobility Response: Client IP 172.30.147.24 code Handoff (1), reason I(local) will be anchor (2), PEM State RUN, Role Local(1)
*Dot1x_NW_MsgTask_0: Dec 10 13:49:39.375: hdrType not mmNacStateUpdate,line 9793,freeing

*apfReceiveTask: Dec 10 13:49:39.510: Mobility Response: Client IP 0.0.0.0 code Handoff Indication (2), reason Client handoff successful - anchor released (0), PEM State DHCP_REQD, Role Handoff(6)
*Dot1x_NW_MsgTask_6: Dec 10 13:49:39.699: CCKM: Sending CCKM PMK (Version_2) information to mobility group
*apfReceiveTask: Dec 10 13:49:39.947: Mobility Response: Client IP 0.0.0.0 code Handoff Indication (2), reason Client handoff successful - anchor released (0), PEM State DHCP_REQD, Role Handoff(6)
*Dot1x_NW_MsgTask_2: Dec 10 13:49:39.968: hdrType not mmNacStateUpdate,line 9793,freeing

*apfReceiveTask: Dec 10 13:49:39.969: Mobility Response: Client IP 172.30.51.70 code Handoff (1), reason I(local) will be anchor (2), PEM State RUN, Role Local(1)
*apfReceiveTask: Dec 10 13:49:40.509: mmHandoffConfirm: Mobile Announce Mip not present, client mac 90:fd:61:c5:54:d9

*apfReceiveTask: Dec 10 13:49:40.509: Mobility Response: Client IP 0.0.0.0 code Handoff (1), reason Handoff request timed out (7), PEM State DHCP_REQD, Role Local(1)
*apfReceiveTask: Dec 10 13:49:40.509: mmHandoffConfirm: Mobile Announce Mip not present, client mac 9c:fc:01:02:4b:52

*apfReceiveTask: Dec 10 13:49:40.510: Mobility Response: Client IP 0.0.0.0 code Handoff (1), reason Handoff request timed out (7), PEM State DHCP_REQD, Role Local(1)
*apfMsConnTask_0: Dec 10 13:49:41.050: cc:3a:61:6d:05:2e Processing assoc-req station:cc:3a:61:6d:05:2e AP:54:78:1a:d0:16:50-00 thread:15146c90
*apfMsConnTask_0: Dec 10 13:49:41.050: cc:3a:61:6d:05:2e Ignoring assoc request due to mobile in exclusion list or marked for deletion
*Dot1x_NW_MsgTask_7: Dec 10 13:49:41.314: hdrType not mmNacStateUpdate,line 9793,freeing

*apfReceiveTask: Dec 10 13:49:41.316: Mobility Response: Client IP 172.30.33.57 code Handoff (1), reason I(local) will be anchor (2), PEM State RUN, Role Local(1)
*apfReceiveTask: Dec 10 13:49:41.328: Mobility Response: Client IP 0.0.0.0 code Handoff Indication (2), reason Client handoff successful - anchor released (0), PEM State DHCP_REQD, Role Handoff(6)
*apfMsConnTask_0: Dec 10 13:49:41.368: cc:3a:61:6d:05:2e Processing assoc-req station:cc:3a:61:6d:05:2e AP:54:78:1a:d0:16:50-00 thread:15146c90
*apfMsConnTask_0: Dec 10 13:49:41.368: cc:3a:61:6d:05:2e Ignoring assoc request due to mobile in exclusion list or marked for deletion
*apfMsConnTask_0: Dec 10 13:49:41.686: cc:3a:61:6d:05:2e Processing assoc-req station:cc:3a:61:6d:05:2e AP:54:78:1a:d0:16:50-00 thread:15146c90
*apfMsConnTask_0: Dec 10 13:49:41.686: cc:3a:61:6d:05:2e Ignoring assoc request due to mobile in exclusion list or marked for deletion
*Dot1x_NW_MsgTask_2: Dec 10 13:49:41.687: CCKM: Sending CCKM PMK (Version_2) information to mobility group
*apfMsConnTask_0: Dec 10 13:49:42.007: cc:3a:61:6d:05:2e Processing assoc-req station:cc:3a:61:6d:05:2e AP:54:78:1a:d0:16:50-00 thread:15146c90
*apfMsConnTask_0: Dec 10 13:49:42.007: cc:3a:61:6d:05:2e Ignoring assoc request due to mobile in exclusion list or marked for deletion
*apfReceiveTask: Dec 10 13:49:42.084: Mobility Response: Client IP 0.0.0.0 code Handoff Indication (2), reason Client handoff successful - anchor released (0), PEM State DHCP_REQD, Role Handoff(6)
*apfMsConnTask_0: Dec 10 13:49:42.325: cc:3a:61:6d:05:2e Processing assoc-req station:cc:3a:61:6d:05:2e AP:54:78:1a:d0:16:50-00 thread:15146c90
*apfMsConnTask_0: Dec 10 13:49:42.325: cc:3a:61:6d:05:2e Ignoring assoc request due to mobile in exclusion list or marked for deletion
*Apf Guest: Dec 10 13:49:42.509: Wired client head is NULL, no clients in the list. Number of clients = 0

*Dot1x_NW_MsgTask_2: Dec 10 13:49:42.549: hdrType not mmNacStateUpdate,line 9793,freeing

*apfReceiveTask: Dec 10 13:49:42.551: Mobility Response: Client IP 172.30.33.140 code Handoff (1), reason I(local) will be anchor (2), PEM State RUN, Role Local(1)
*apfMsConnTask_0: Dec 10 13:49:42.643: cc:3a:61:6d:05:2e Processing assoc-req station:cc:3a:61:6d:05:2e AP:54:78:1a:d0:16:50-00 thread:15146c90
*apfMsConnTask_0: Dec 10 13:49:42.643: cc:3a:61:6d:05:2e Ignoring assoc request due to mobile in exclusion list or marked for deletion
*apfMsConnTask_0: Dec 10 13:49:42.962: cc:3a:61:6d:05:2e Processing assoc-req station:cc:3a:61:6d:05:2e AP:54:78:1a:d0:16:50-00 thread:15146c90
*apfMsConnTask_0: Dec 10 13:49:42.962: cc:3a:61:6d:05:2e Ignoring assoc request due to mobile in exclusion list or marked for deletion
*Dot1x_NW_MsgTask_7: Dec 10 13:49:43.175: hdrType not mmNacStateUpdate,line 9793,freeing

*apfReceiveTask: Dec 10 13:49:43.176: Mobility Response: Client IP 172.30.36.210 code Handoff (1), reason I(local) will be anchor (2), PEM State RUN, Role Local(1)
*Dot1x_NW_MsgTask_0: Dec 10 13:49:43.486: Ignoring Announce, role = 0, Client IP: 160.59.227.197 Client mac: c8:30:00:00:00:00 Peer IP: 172.16.31.6

*apfReceiveTask: Dec 10 13:49:43.655: Mobility Response: Client IP 0.0.0.0 code Handoff Indication (2), reason Client handoff successful - anchor released (0), PEM State DHCP_REQD, Role Handoff(6)
*apfReceiveTask: Dec 10 13:49:44.191: Mobility Response: Client IP 172.30.2.128 code Handoff (1), reason I(local) will be anchor (2), PEM State RUN, Role Local(1)
*Dot1x_NW_MsgTask_1: Dec 10 13:49:44.193: hdrType not mmNacStateUpdate,line 9793,freeing

*Dot1x_NW_MsgTask_0: Dec 10 13:49:44.469: Ignoring Announce, role = 0, Client IP: 160.59.227.197 Client mac: c8:30:00:00:00:00 Peer IP: 172.16.31.6

*apfReceiveTask: Dec 10 13:49:44.509: mmHandoffConfirm: Mobile Announce Mip not present, client mac 4c:66:41:51:75:ba

*apfReceiveTask: Dec 10 13:49:44.509: Mobility Response: Client IP 0.0.0.0 code Handoff (1), reason Handoff request timed out (7), PEM State DHCP_REQD, Role Local(1)
*apfReceiveTask: Dec 10 13:49:44.534: Mobility Response: Client IP 0.0.0.0 code Handoff Indication (2), reason Client handoff successful - anchor released (0), PEM State DHCP_REQD, Role Handoff(6)
*Dot1x_NW_MsgTask_4: Dec 10 13:49:44.752: hdrType not mmNacStateUpdate,line 9793,freeing

*apfReceiveTask: Dec 10 13:49:44.753: Mobility Response: Client IP 172.30.200.158 code Handoff (1), reason I(local) will be anchor (2), PEM State RUN, Role Local(1)
*Dot1x_NW_MsgTask_0: Dec 10 13:49:45.404: hdrType not mmNacStateUpdate,line 9793,freeing

*apfReceiveTask: Dec 10 13:49:45.405: Mobility Response: Client IP 172.30.3.32 code Handoff (1), reason I(local) will be anchor (2), PEM State RUN, Role Local(1)
*Dot1x_NW_MsgTask_0: Dec 10 13:49:45.468: Ignoring Announce, role = 0, Client IP: 160.59.227.197 Client mac: c8:30:00:00:00:00 Peer IP: 172.16.31.6

*apfReceiveTask: Dec 10 13:49:45.709: mmHandoffConfirm: Mobile Announce Mip not present, client mac 88:07:4b:b3:58:9f

*apfReceiveTask: Dec 10 13:49:45.709: Mobility Response: Client IP 0.0.0.0 code Handoff (1), reason Handoff request timed out (7), PEM State DHCP_REQD, Role Local(1)
*Dot1x_NW_MsgTask_0: Dec 10 13:49:46.293: CCKM: Sending CCKM PMK (Version_2) information to mobility group
*Dot1x_NW_MsgTask_3: Dec 10 13:49:46.319: hdrType not mmNacStateUpdate,line 9793,freeing

*apfReceiveTask: Dec 10 13:49:46.320: Mobility Response: Client IP 172.30.36.214 code Handoff (1), reason I(local) will be anchor (2), PEM State RUN, Role Local(1)
*Dot1x_NW_MsgTask_3: Dec 10 13:49:46.340: hdrType not mmNacStateUpdate,line 9793,freeing

*apfReceiveTask: Dec 10 13:49:46.341: Mobility Response: Client IP 172.30.45.230 code Handoff (1), reason I(local) will be anchor (2), PEM State RUN, Role Local(1)
*apfReceiveTask: Dec 10 13:49:46.413: Mobility Response: Client IP 0.0.0.0 code Handoff Indication (2), reason Client handoff successful - anchor released (0), PEM State START, Role Handoff(6)
*apfReceiveTask: Dec 10 13:49:46.576: Mobility Response: Client IP 0.0.0.0 code Handoff Indication (2), reason Client handoff successful - anchor released (0), PEM State DHCP_REQD, Role Handoff(6)
*Dot1x_NW_MsgTask_0: Dec 10 13:49:47.467: Mobile Announce Received for mobile 84:38:38:17:ca:90 from 172.16.31.8 during handoff request for client, dropping the announce.
Mobility State, 1, Coll. Cnt, 1

*apfReceiveTask: Dec 10 13:49:47.509: mmHandoffConfirm: Mobile Announce Mip not present, client mac a4:5e:60:a6:32:cb

*apfReceiveTask: Dec 10 13:49:47.509: Mobility Response: Client IP 0.0.0.0 code Handoff (1), reason Handoff request timed out (7), PEM State DHCP_REQD, Role Local(1)
*apfReceiveTask: Dec 10 13:49:47.994: Mobility Response: Client IP 0.0.0.0 code Handoff Indication (2), reason Client handoff successful - anchor released (0), PEM State DHCP_REQD, Role Handoff(6)
*apfReceiveTask: Dec 10 13:49:48.311: Mobility Response: Client IP 172.30.22.215 code Handoff (1), reason I(local) will be anchor (2), PEM State RUN, Role Local(1)
*Dot1x_NW_MsgTask_4: Dec 10 13:49:48.314: hdrType not mmNacStateUpdate,line 9793,freeing

*Dot1x_NW_MsgTask_0: Dec 10 13:49:48.418: Mobile Announce Received for mobile 84:38:38:17:ca:90 from 172.16.31.8 during handoff request for client, dropping the announce.
Mobility State, 1, Coll. Cnt, 2

*apfReceiveTask: Dec 10 13:49:49.010: Mobility Response: Client IP 0.0.0.0 code Handoff Indication (2), reason Client handoff successful - anchor released (0), PEM State DHCP_REQD, Role Handoff(6)
*Dot1x_NW_MsgTask_0: Dec 10 13:49:49.417: Mobile Announce Received for mobile 84:38:38:17:ca:90 from 172.16.31.8 during handoff request for client, dropping the announce.
Mobility State, 1, Coll. Cnt, 3

*apfReceiveTask: Dec 10 13:49:49.510: mmHandoffConfirm: Mobile Announce Mip not present, client mac 90:3c:92:ca:dd:14

*apfReceiveTask: Dec 10 13:49:49.510: Mobility Response: Client IP 0.0.0.0 code Handoff (1), reason Handoff request timed out (7), PEM State DHCP_REQD, Role Local(1)
*apfReceiveTask: Dec 10 13:49:50.312: Mobility Response: Client IP 192.168.136.181 code Handoff (1), reason I(local) will be anchor (2), PEM State RUN, Role Local(1)
*Dot1x_NW_MsgTask_7: Dec 10 13:49:50.315: hdrType not mmNacStateUpdate,line 9793,freeing

*apfReceiveTask: Dec 10 13:49:50.670: Mobility Response: Client IP 0.0.0.0 code Handoff Indication (2), reason Client handoff successful - anchor released (0), PEM State START, Role Handoff(6)
*apfReceiveTask: Dec 10 13:49:50.806: Mobility Response: Client IP 0.0.0.0 code Handoff Indication (2), reason Client handoff successful - anchor released (0), PEM State DHCP_REQD, Role Handoff(6)
*apfReceiveTask: Dec 10 13:49:51.110: mmHandoffConfirm: Mobile Announce Mip not present, client mac 00:9a:cd:66:3c:86

*apfReceiveTask: Dec 10 13:49:51.110: Mobility Response: Client IP 0.0.0.0 code Handoff (1), reason Handoff request timed out (7), PEM State DHCP_REQD, Role Local(1)
*Dot1x_NW_MsgTask_0: Dec 10 13:49:51.427: hdrType not mmNacStateUpdate,line 9793,freeing

*apfReceiveTask: Dec 10 13:49:51.428: Mobility Response: Client IP 172.30.46.37 code Handoff (1), reason I(local) will be anchor (2), PEM State RUN, Role Local(1)
*apfReceiveTask: Dec 10 13:49:51.755: Mobility Response: Client IP 0.0.0.0 code Handoff Indication (2), reason Client handoff successful - anchor released (0), PEM State DHCP_REQD, Role Handoff(6)
*apfReceiveTask: Dec 10 13:49:51.884: Mobility Response: Client IP 0.0.0.0 code Handoff Indication (2), reason Client handoff successful - anchor released (0), PEM State DHCP_REQD, Role Handoff(6)
*Dot1x_NW_MsgTask_0: Dec 10 13:49:51.898: hdrType not mmNacStateUpdate,line 9793,freeing

*apfReceiveTask: Dec 10 13:49:51.899: Mobility Response: Client IP 172.30.41.90 code Handoff (1), reason I(local) will be anchor (2), PEM State RUN, Role Local(1)
*Dot1x_NW_MsgTask_4: Dec 10 13:49:52.216: hdrType not mmNacStateUpdate,line 9793,freeing

*apfReceiveTask: Dec 10 13:49:52.217: Mobility Response: Client IP 172.30.119.37 code Handoff (1), reason I(local) will be anchor (2), PEM State RUN, Role Local(1)
*Dot1x_NW_MsgTask_6: Dec 10 13:49:53.423: hdrType not mmNacStateUpdate,line 9793,freeing

0 Replies 0
Review Cisco Networking for a $25 gift card