Re: Wireless Roaming issue

Jinny · ‎11-06-2019

Hello everyone
Roaming problems continue to arise despite strong signals
I need help

Below is a debugging of a specific client.

Please tell us if you have any information

WLC5508 <> AP1142N

(Cisco Controller) >*spamApTask0: Oct 29 16:55:47.328: [PA] 5c:c5:d4:3b:71:94 apfUpdateDeleteAckInMscb (apf_api.c:51702) Expiring Mobile!
*apfOpenDtlSocket: Nov 07 13:26:59.997: [PA] e4:a7:a0:82:8f:c0 Recevied management frame REASSOCIATION REQUEST on BSSID 58:35:d9:c7:26:20 destination addr 58:35:d9:c7:26:20
*Dot1x_NW_MsgTask_0: Nov 07 13:27:00.097: [PA] e4:a7:a0:82:8f:c0 Received EAPOL EAPPKT from mobile e4:a7:a0:82:8f:c0
*Dot1x_NW_MsgTask_0: Nov 07 13:27:00.097: [PA] e4:a7:a0:82:8f:c0 Received Identity Response (count=1) from mobile e4:a7:a0:82:8f:c0
*Dot1x_NW_MsgTask_0: Nov 07 13:27:00.097: [PA] e4:a7:a0:82:8f:c0 Resetting reauth count 1 to 0 for mobile e4:a7:a0:82:8f:c0
*Dot1x_NW_MsgTask_0: Nov 07 13:27:00.097: [PA] e4:a7:a0:82:8f:c0 EAP State update from Connecting to Authenticating for mobile e4:a7:a0:82:8f:c0
*Dot1x_NW_MsgTask_0: Nov 07 13:27:00.097: [PA] e4:a7:a0:82:8f:c0 dot1x - moving mobile e4:a7:a0:82:8f:c0 into Authenticating state
*Dot1x_NW_MsgTask_0: Nov 07 13:27:00.097: [PA] e4:a7:a0:82:8f:c0 Entering Backend Auth Response state for mobile e4:a7:a0:82:8f:c0
*Dot1x_NW_MsgTask_0: Nov 07 13:27:00.099: [PA] e4:a7:a0:82:8f:c0 Processing Access-Challenge for mobile e4:a7:a0:82:8f:c0
*Dot1x_NW_MsgTask_0: Nov 07 13:27:00.099: [PA] e4:a7:a0:82:8f:c0 Entering Backend Auth Req state (id=37) for mobile e4:a7:a0:82:8f:c0
*Dot1x_NW_MsgTask_0: Nov 07 13:27:00.099: [PA] e4:a7:a0:82:8f:c0 WARNING: updated EAP-Identifier 1 ===> 37 for STA e4:a7:a0:82:8f:c0
*Dot1x_NW_MsgTask_0: Nov 07 13:27:00.099: [PA] e4:a7:a0:82:8f:c0 Sending EAP Request from AAA to mobile e4:a7:a0:82:8f:c0 (EAP Id 37)
*Dot1x_NW_MsgTask_0: Nov 07 13:27:00.099: [PA] e4:a7:a0:82:8f:c0 Allocating EAP Pkt for retransmission to mobile e4:a7:a0:82:8f:c0
*Dot1x_NW_MsgTask_0: Nov 07 13:27:00.104: [PA] e4:a7:a0:82:8f:c0 Received EAPOL EAPPKT from mobile e4:a7:a0:82:8f:c0
*Dot1x_NW_MsgTask_0: Nov 07 13:27:00.104: [PA] e4:a7:a0:82:8f:c0 Received EAP Response from mobile e4:a7:a0:82:8f:c0 (EAP Id 37, EAP Type 3)
*Dot1x_NW_MsgTask_0: Nov 07 13:27:00.104: [PA] e4:a7:a0:82:8f:c0 Resetting reauth count 0 to 0 for mobile e4:a7:a0:82:8f:c0
*Dot1x_NW_MsgTask_0: Nov 07 13:27:00.104: [PA] e4:a7:a0:82:8f:c0 Entering Backend Auth Response state for mobile e4:a7:a0:82:8f:c0
*Dot1x_NW_MsgTask_0: Nov 07 13:27:00.106: [PA] e4:a7:a0:82:8f:c0 Processing Access-Challenge for mobile e4:a7:a0:82:8f:c0
*Dot1x_NW_MsgTask_0: Nov 07 13:27:00.106: [PA] e4:a7:a0:82:8f:c0 Entering Backend Auth Req state (id=38) for mobile e4:a7:a0:82:8f:c0
*Dot1x_NW_MsgTask_0: Nov 07 13:27:00.106: [PA] e4:a7:a0:82:8f:c0 Sending EAP Request from AAA to mobile e4:a7:a0:82:8f:c0 (EAP Id 38)
*Dot1x_NW_MsgTask_0: Nov 07 13:27:00.106: [PA] e4:a7:a0:82:8f:c0 Reusing allocated memory for EAP Pkt for retransmission to mobile e4:a7:a0:82:8f:c0
*Dot1x_NW_MsgTask_0: Nov 07 13:27:00.114: [PA] e4:a7:a0:82:8f:c0 Received EAPOL EAPPKT from mobile e4:a7:a0:82:8f:c0
*Dot1x_NW_MsgTask_0: Nov 07 13:27:00.114: [PA] e4:a7:a0:82:8f:c0 Received EAP Response from mobile e4:a7:a0:82:8f:c0 (EAP Id 38, EAP Type 25)
*Dot1x_NW_MsgTask_0: Nov 07 13:27:00.114: [PA] e4:a7:a0:82:8f:c0 Resetting reauth count 0 to 0 for mobile e4:a7:a0:82:8f:c0
*Dot1x_NW_MsgTask_0: Nov 07 13:27:00.114: [PA] e4:a7:a0:82:8f:c0 Entering Backend Auth Response state for mobile e4:a7:a0:82:8f:c0
*Dot1x_NW_MsgTask_0: Nov 07 13:27:00.115: [PA] e4:a7:a0:82:8f:c0 Processing Access-Challenge for mobile e4:a7:a0:82:8f:c0
*Dot1x_NW_MsgTask_0: Nov 07 13:27:00.115: [PA] e4:a7:a0:82:8f:c0 Entering Backend Auth Req state (id=39) for mobile e4:a7:a0:82:8f:c0
*Dot1x_NW_MsgTask_0: Nov 07 13:27:00.115: [PA] e4:a7:a0:82:8f:c0 Sending EAP Request from AAA to mobile e4:a7:a0:82:8f:c0 (EAP Id 39)
*Dot1x_NW_MsgTask_0: Nov 07 13:27:00.115: [PA] e4:a7:a0:82:8f:c0 Reusing allocated memory for EAP Pkt for retransmission to mobile e4:a7:a0:82:8f:c0
*Dot1x_NW_MsgTask_0: Nov 07 13:27:00.127: [PA] e4:a7:a0:82:8f:c0 Received EAPOL EAPPKT from mobile e4:a7:a0:82:8f:c0
*Dot1x_NW_MsgTask_0: Nov 07 13:27:00.127: [PA] e4:a7:a0:82:8f:c0 Received EAP Response from mobile e4:a7:a0:82:8f:c0 (EAP Id 39, EAP Type 25)
*Dot1x_NW_MsgTask_0: Nov 07 13:27:00.127: [PA] e4:a7:a0:82:8f:c0 Resetting reauth count 0 to 0 for mobile e4:a7:a0:82:8f:c0
*Dot1x_NW_MsgTask_0: Nov 07 13:27:00.127: [PA] e4:a7:a0:82:8f:c0 Entering Backend Auth Response state for mobile e4:a7:a0:82:8f:c0
*Dot1x_NW_MsgTask_0: Nov 07 13:27:00.128: [PA] e4:a7:a0:82:8f:c0 Processing Access-Challenge for mobile e4:a7:a0:82:8f:c0
*Dot1x_NW_MsgTask_0: Nov 07 13:27:00.128: [PA] e4:a7:a0:82:8f:c0 Entering Backend Auth Req state (id=40) for mobile e4:a7:a0:82:8f:c0
*Dot1x_NW_MsgTask_0: Nov 07 13:27:00.128: [PA] e4:a7:a0:82:8f:c0 Sending EAP Request from AAA to mobile e4:a7:a0:82:8f:c0 (EAP Id 40)
*Dot1x_NW_MsgTask_0: Nov 07 13:27:00.128: [PA] e4:a7:a0:82:8f:c0 Reusing allocated memory for EAP Pkt for retransmission to mobile e4:a7:a0:82:8f:c0
*Dot1x_NW_MsgTask_0: Nov 07 13:27:00.137: [PA] e4:a7:a0:82:8f:c0 Received EAPOL EAPPKT from mobile e4:a7:a0:82:8f:c0
*Dot1x_NW_MsgTask_0: Nov 07 13:27:00.137: [PA] e4:a7:a0:82:8f:c0 Received EAP Response from mobile e4:a7:a0:82:8f:c0 (EAP Id 40, EAP Type 25)
*Dot1x_NW_MsgTask_0: Nov 07 13:27:00.137: [PA] e4:a7:a0:82:8f:c0 Resetting reauth count 0 to 0 for mobile e4:a7:a0:82:8f:c0
*Dot1x_NW_MsgTask_0: Nov 07 13:27:00.137: [PA] e4:a7:a0:82:8f:c0 Entering Backend Auth Response state for mobile e4:a7:a0:82:8f:c0
*Dot1x_NW_MsgTask_0: Nov 07 13:27:00.139: [PA] e4:a7:a0:82:8f:c0 Processing Access-Challenge for mobile e4:a7:a0:82:8f:c0
*Dot1x_NW_MsgTask_0: Nov 07 13:27:00.139: [PA] e4:a7:a0:82:8f:c0 Entering Backend Auth Req state (id=41) for mobile e4:a7:a0:82:8f:c0
*Dot1x_NW_MsgTask_0: Nov 07 13:27:00.139: [PA] e4:a7:a0:82:8f:c0 Sending EAP Request from AAA to mobile e4:a7:a0:82:8f:c0 (EAP Id 41)
*Dot1x_NW_MsgTask_0: Nov 07 13:27:00.139: [PA] e4:a7:a0:82:8f:c0 Reusing allocated memory for EAP Pkt for retransmission to mobile e4:a7:a0:82:8f:c0
*Dot1x_NW_MsgTask_0: Nov 07 13:27:00.155: [PA] e4:a7:a0:82:8f:c0 Received EAPOL EAPPKT from mobile e4:a7:a0:82:8f:c0
*Dot1x_NW_MsgTask_0: Nov 07 13:27:00.155: [PA] e4:a7:a0:82:8f:c0 Received EAP Response from mobile e4:a7:a0:82:8f:c0 (EAP Id 41, EAP Type 25)
*Dot1x_NW_MsgTask_0: Nov 07 13:27:00.155: [PA] e4:a7:a0:82:8f:c0 Resetting reauth count 0 to 0 for mobile e4:a7:a0:82:8f:c0
*Dot1x_NW_MsgTask_0: Nov 07 13:27:00.155: [PA] e4:a7:a0:82:8f:c0 Entering Backend Auth Response state for mobile e4:a7:a0:82:8f:c0
*Dot1x_NW_MsgTask_0: Nov 07 13:27:00.335: [PA] e4:a7:a0:82:8f:c0 Processing Access-Challenge for mobile e4:a7:a0:82:8f:c0
*Dot1x_NW_MsgTask_0: Nov 07 13:27:00.335: [PA] e4:a7:a0:82:8f:c0 Entering Backend Auth Req state (id=42) for mobile e4:a7:a0:82:8f:c0
*Dot1x_NW_MsgTask_0: Nov 07 13:27:00.335: [PA] e4:a7:a0:82:8f:c0 Sending EAP Request from AAA to mobile e4:a7:a0:82:8f:c0 (EAP Id 42)
*Dot1x_NW_MsgTask_0: Nov 07 13:27:00.335: [PA] e4:a7:a0:82:8f:c0 Reusing allocated memory for EAP Pkt for retransmission to mobile e4:a7:a0:82:8f:c0
*Dot1x_NW_MsgTask_0: Nov 07 13:27:00.342: [PA] e4:a7:a0:82:8f:c0 Received EAPOL EAPPKT from mobile e4:a7:a0:82:8f:c0
*Dot1x_NW_MsgTask_0: Nov 07 13:27:00.342: [PA] e4:a7:a0:82:8f:c0 Received EAP Response from mobile e4:a7:a0:82:8f:c0 (EAP Id 42, EAP Type 25)
*Dot1x_NW_MsgTask_0: Nov 07 13:27:00.342: [PA] e4:a7:a0:82:8f:c0 Resetting reauth count 0 to 0 for mobile e4:a7:a0:82:8f:c0
*Dot1x_NW_MsgTask_0: Nov 07 13:27:00.342: [PA] e4:a7:a0:82:8f:c0 Entering Backend Auth Response state for mobile e4:a7:a0:82:8f:c0
*Dot1x_NW_MsgTask_0: Nov 07 13:27:00.343: [PA] e4:a7:a0:82:8f:c0 Processing Access-Challenge for mobile e4:a7:a0:82:8f:c0
*Dot1x_NW_MsgTask_0: Nov 07 13:27:00.343: [PA] e4:a7:a0:82:8f:c0 Entering Backend Auth Req state (id=43) for mobile e4:a7:a0:82:8f:c0
*Dot1x_NW_MsgTask_0: Nov 07 13:27:00.343: [PA] e4:a7:a0:82:8f:c0 Sending EAP Request from AAA to mobile e4:a7:a0:82:8f:c0 (EAP Id 43)
*Dot1x_NW_MsgTask_0: Nov 07 13:27:00.343: [PA] e4:a7:a0:82:8f:c0 Reusing allocated memory for EAP Pkt for retransmission to mobile e4:a7:a0:82:8f:c0
*Dot1x_NW_MsgTask_0: Nov 07 13:27:00.349: [PA] e4:a7:a0:82:8f:c0 Received EAPOL EAPPKT from mobile e4:a7:a0:82:8f:c0
*Dot1x_NW_MsgTask_0: Nov 07 13:27:00.349: [PA] e4:a7:a0:82:8f:c0 Received EAP Response from mobile e4:a7:a0:82:8f:c0 (EAP Id 43, EAP Type 25)
*Dot1x_NW_MsgTask_0: Nov 07 13:27:00.349: [PA] e4:a7:a0:82:8f:c0 Resetting reauth count 0 to 0 for mobile e4:a7:a0:82:8f:c0
*Dot1x_NW_MsgTask_0: Nov 07 13:27:00.349: [PA] e4:a7:a0:82:8f:c0 Entering Backend Auth Response state for mobile e4:a7:a0:82:8f:c0
*Dot1x_NW_MsgTask_0: Nov 07 13:27:00.351: [PA] e4:a7:a0:82:8f:c0 Processing Access-Accept for mobile e4:a7:a0:82:8f:c0
*Dot1x_NW_MsgTask_0: Nov 07 13:27:00.351: [PA] e4:a7:a0:82:8f:c0 Resetting web IPv4 acl from 255 to 255

*Dot1x_NW_MsgTask_0: Nov 07 13:27:00.351: [PA] e4:a7:a0:82:8f:c0 Resetting web IPv4 Flex acl from 65535 to 65535

*Dot1x_NW_MsgTask_0: Nov 07 13:27:00.351: [PA] e4:a7:a0:82:8f:c0 Received MPPE_SEND_KEY: KeyLen: 32

*Dot1x_NW_MsgTask_0: Nov 07 13:27:00.351: [PA] e4:a7:a0:82:8f:c0 Received MPPE_RECV_KEY: KeyLen: 32

*Dot1x_NW_MsgTask_0: Nov 07 13:27:00.351: [PA] e4:a7:a0:82:8f:c0 Setting re-auth timeout to 1800 seconds, got from WLAN config.
*Dot1x_NW_MsgTask_0: Nov 07 13:27:00.351: [PA] e4:a7:a0:82:8f:c0 Station e4:a7:a0:82:8f:c0 setting dot1x reauth timeout = 1800
*Dot1x_NW_MsgTask_0: Nov 07 13:27:00.351: [PA] e4:a7:a0:82:8f:c0 Creating a PKC PMKID Cache entry for station e4:a7:a0:82:8f:c0 (RSN 2)
*Dot1x_NW_MsgTask_0: Nov 07 13:27:00.352: [PA] e4:a7:a0:82:8f:c0 Resetting MSCB PMK Cache Entry @index 0 for station e4:a7:a0:82:8f:c0
*Dot1x_NW_MsgTask_0: Nov 07 13:27:00.352: [PA] e4:a7:a0:82:8f:c0 Removing BSSID 58:35:d9:c7:26:10 from PMKID cache of station e4:a7:a0:82:8f:c0
*Dot1x_NW_MsgTask_0: Nov 07 13:27:00.352: [PA] e4:a7:a0:82:8f:c0 Setting active key cache index 8 ---> 8
*Dot1x_NW_MsgTask_0: Nov 07 13:27:00.352: [PA] e4:a7:a0:82:8f:c0 Setting active key cache index 8 ---> 0
*Dot1x_NW_MsgTask_0: Nov 07 13:27:00.352: [PA] e4:a7:a0:82:8f:c0 Created PMKID PMK Cache for BSSID 58:35:d9:c7:26:20 at index 0 for station e4:a7:a0:82:8f:c0
*Dot1x_NW_MsgTask_0: Nov 07 13:27:00.352: [PA] New PMKID: (16)

*Dot1x_NW_MsgTask_0: Nov 07 13:27:00.352: [PA] [0000] 64 34 50 29 19 33 45 75 26 b6 43 80 5b 83 4e 02

*Dot1x_NW_MsgTask_0: Nov 07 13:27:00.352: [PA] e4:a7:a0:82:8f:c0 802.11i: Create a global PMK cache entry, AKM-type = 1
*Dot1x_NW_MsgTask_0: Nov 07 13:27:00.352: [PA] e4:a7:a0:82:8f:c0 PMK: Sending Flexconnect group cache delete message to spam task
*Dot1x_NW_MsgTask_0: Nov 07 13:27:00.352: [PA] e4:a7:a0:82:8f:c0 Updated existing pmk cache for client having username: HANDOK\KR2190076 and audit-session-id:ac100aaf00043f8b5dc39a71
*Dot1x_NW_MsgTask_0: Nov 07 13:27:00.352: [PA] e4:a7:a0:82:8f:c0 1x: Updated the audit-session-id to PMK-Cache from client mscb: ac100aaf00043f8b5dc39a71
*Dot1x_NW_MsgTask_0: Nov 07 13:27:00.352: [PA] e4:a7:a0:82:8f:c0 unsetting PmkIdValidatedByAp
*Dot1x_NW_MsgTask_0: Nov 07 13:27:00.352: [PA] e4:a7:a0:82:8f:c0 Zeroize AAA Overrides from local for station
*Dot1x_NW_MsgTask_0: Nov 07 13:27:00.352: [PA] e4:a7:a0:82:8f:c0 Adding Audit session ID payload in Mobility handoff

*Dot1x_NW_MsgTask_0: Nov 07 13:27:00.352: [PA] e4:a7:a0:82:8f:c0 1 PMK-update groupcast messages sent
*Dot1x_NW_MsgTask_0: Nov 07 13:27:00.352: [PA] e4:a7:a0:82:8f:c0 PMK sent to mobility group
*Dot1x_NW_MsgTask_0: Nov 07 13:27:00.352: [PA] e4:a7:a0:82:8f:c0 Disabling re-auth since PMK lifetime can take care of same.
*Dot1x_NW_MsgTask_0: Nov 07 13:27:00.352: [PA] e4:a7:a0:82:8f:c0 Sending EAP-Success to mobile e4:a7:a0:82:8f:c0 (EAP Id 43)
*Dot1x_NW_MsgTask_0: Nov 07 13:27:00.353: [PA] e4:a7:a0:82:8f:c0 Freeing AAACB from Dot1xCB as AAA auth is done for mobile e4:a7:a0:82:8f:c0
*Dot1x_NW_MsgTask_0: Nov 07 13:27:00.353: [PA] e4:a7:a0:82:8f:c0 key Desc Version FT - 0

*Dot1x_NW_MsgTask_0: Nov 07 13:27:00.353: [PA] e4:a7:a0:82:8f:c0 Found an cache entry for BSSID 58:35:d9:c7:26:20 in PMKID cache at index 0 of station e4:a7:a0:82:8f:c0
*Dot1x_NW_MsgTask_0: Nov 07 13:27:00.353: [PA] e4:a7:a0:82:8f:c0 Found an cache entry for BSSID 58:35:d9:c7:26:20 in PMKID cache at index 0 of station e4:a7:a0:82:8f:c0
*Dot1x_NW_MsgTask_0: Nov 07 13:27:00.353: [PA] Including PMKID in M1 (16)

*Dot1x_NW_MsgTask_0: Nov 07 13:27:00.353: [PA] [0000] 64 34 50 29 19 33 45 75 26 b6 43 80 5b 83 4e 02

*Dot1x_NW_MsgTask_0: Nov 07 13:27:00.353: [PA] M1 - Key Data: (22)

*Dot1x_NW_MsgTask_0: Nov 07 13:27:00.353: [PA] [0000] dd 14 00 0f ac 04 64 34 50 29 19 33 45 75 26 b6

*Dot1x_NW_MsgTask_0: Nov 07 13:27:00.353: [PA] [0016] 43 80 5b 83 4e 02

*Dot1x_NW_MsgTask_0: Nov 07 13:27:00.353: [PA] e4:a7:a0:82:8f:c0 Starting key exchange to mobile e4:a7:a0:82:8f:c0, data packets will be dropped
*Dot1x_NW_MsgTask_0: Nov 07 13:27:00.353: [PA] e4:a7:a0:82:8f:c0 Sending EAPOL-Key Message to mobile e4:a7:a0:82:8f:c0
state INITPMK (message 1), replay counter 00.00.00.00.00.00.00.00
*Dot1x_NW_MsgTask_0: Nov 07 13:27:00.353: [PA] e4:a7:a0:82:8f:c0 Reusing allocated memory for EAP Pkt for retransmission to mobile e4:a7:a0:82:8f:c0
*Dot1x_NW_MsgTask_0: Nov 07 13:27:00.353: [PA] e4:a7:a0:82:8f:c0 Entering Backend Auth Success state (id=43) for mobile e4:a7:a0:82:8f:c0
*Dot1x_NW_MsgTask_0: Nov 07 13:27:00.353: [PA] e4:a7:a0:82:8f:c0 Received Auth Success while in Authenticating state for mobile e4:a7:a0:82:8f:c0
*Dot1x_NW_MsgTask_0: Nov 07 13:27:00.353: [PA] e4:a7:a0:82:8f:c0 dot1x - moving mobile e4:a7:a0:82:8f:c0 into Authenticated state
*dot1xSocketTask: Nov 07 13:27:00.403: [PA] e4:a7:a0:82:8f:c0 validating eapol pkt: key version = 2
*Dot1x_NW_MsgTask_0: Nov 07 13:27:00.403: [PA] e4:a7:a0:82:8f:c0 Received EAPOL-Key from mobile e4:a7:a0:82:8f:c0
*Dot1x_NW_MsgTask_0: Nov 07 13:27:00.403: [PA] e4:a7:a0:82:8f:c0 Ignoring invalid EAPOL version (1) in EAPOL-key message from mobile e4:a7:a0:82:8f:c0
*Dot1x_NW_MsgTask_0: Nov 07 13:27:00.403: [PA] e4:a7:a0:82:8f:c0 key Desc Version FT - 0

*Dot1x_NW_MsgTask_0: Nov 07 13:27:00.403: [PA] e4:a7:a0:82:8f:c0 Received EAPOL-key in PTK_START state (message 2) from mobile e4:a7:a0:82:8f:c0
*Dot1x_NW_MsgTask_0: Nov 07 13:27:00.403: [PA] e4:a7:a0:82:8f:c0 Encryption Policy: 4, PTK Key Length: 48
*Dot1x_NW_MsgTask_0: Nov 07 13:27:00.403: [PA] e4:a7:a0:82:8f:c0 Successfully computed PTK from PMK!!!
*Dot1x_NW_MsgTask_0: Nov 07 13:27:00.403: [PA] e4:a7:a0:82:8f:c0 Received valid MIC in EAPOL Key Message M2!!!!!
*Dot1x_NW_MsgTask_0: Nov 07 13:27:00.403: [PA] e4:a7:a0:82:8f:c0 Compare RSN IE in association and EAPOL-M2 frame(Skip pmkIdLen:16,and grpMgmtCipherLen:0)
*Dot1x_NW_MsgTask_0: Nov 07 13:27:00.403: [PA] e4:a7:a0:82:8f:c0 Dumping RSNIE received in Association request:
*Dot1x_NW_MsgTask_0: Nov 07 13:27:00.403: [PA] 00000000: 30 26 01 00 00 0f ac 04 01 00 00 0f ac 04 01 00 0&..............
*Dot1x_NW_MsgTask_0: Nov 07 13:27:00.403: [PA] 00000010: 00 0f ac 01 3c 00 01 00 3e 4a 37 8e c7 12 70 a2 ....<...>J7...p.
*Dot1x_NW_MsgTask_0: Nov 07 13:27:00.403: [PA] 00000020: 91 c3 46 60 f7 26 a8 13 ..F`.&..
*Dot1x_NW_MsgTask_0: Nov 07 13:27:00.403: [PA] e4:a7:a0:82:8f:c0 Dumping RSNIE received in EAPOL M2 :
*Dot1x_NW_MsgTask_0: Nov 07 13:27:00.403: [PA] 00000000: 01 00 00 0f ac 04 01 00 00 0f ac 04 01 00 00 0f ................
*Dot1x_NW_MsgTask_0: Nov 07 13:27:00.403: [PA] 00000010: ac 01 3c 00 01 00 3e 4a 37 8e c7 12 70 a2 91 c3 ..<...>J7...p...
*Dot1x_NW_MsgTask_0: Nov 07 13:27:00.404: [PA] 00000020: 46 60 f7 26 a8 13 F`.&..
*Dot1x_NW_MsgTask_0: Nov 07 13:27:00.404: [PA] e4:a7:a0:82:8f:c0 PMK: Sending flexconnect group cache add message to spam task
*Dot1x_NW_MsgTask_0: Nov 07 13:27:00.404: [PA] e4:a7:a0:82:8f:c0 Stopping retransmission timer for mobile e4:a7:a0:82:8f:c0
*Dot1x_NW_MsgTask_0: Nov 07 13:27:00.404: [PA] e4:a7:a0:82:8f:c0 key Desc Version FT - 0

*Dot1x_NW_MsgTask_0: Nov 07 13:27:00.404: [PA] e4:a7:a0:82:8f:c0 key Desc Version FT - 0

*Dot1x_NW_MsgTask_0: Nov 07 13:27:00.404: [PA] e4:a7:a0:82:8f:c0 Sending EAPOL-Key Message to mobile e4:a7:a0:82:8f:c0
state PTKINITNEGOTIATING (message 3), replay counter 00.00.00.00.00.00.00.01
*Dot1x_NW_MsgTask_0: Nov 07 13:27:00.404: [PA] e4:a7:a0:82:8f:c0 Reusing allocated memory for EAP Pkt for retransmission to mobile e4:a7:a0:82:8f:c0
*dot1xSocketTask: Nov 07 13:27:00.412: [PA] e4:a7:a0:82:8f:c0 validating eapol pkt: key version = 2
*Dot1x_NW_MsgTask_0: Nov 07 13:27:00.412: [PA] e4:a7:a0:82:8f:c0 Received EAPOL-Key from mobile e4:a7:a0:82:8f:c0
*Dot1x_NW_MsgTask_0: Nov 07 13:27:00.412: [PA] e4:a7:a0:82:8f:c0 Ignoring invalid EAPOL version (1) in EAPOL-key message from mobile e4:a7:a0:82:8f:c0
*Dot1x_NW_MsgTask_0: Nov 07 13:27:00.412: [PA] e4:a7:a0:82:8f:c0 key Desc Version FT - 0

*Dot1x_NW_MsgTask_0: Nov 07 13:27:00.412: [PA] e4:a7:a0:82:8f:c0 Received EAPOL-key in PTKINITNEGOTIATING state (message 4) from mobile e4:a7:a0:82:8f:c0
*Dot1x_NW_MsgTask_0: Nov 07 13:27:00.412: [PA] e4:a7:a0:82:8f:c0 Stopping retransmission timer for mobile e4:a7:a0:82:8f:c0
*Dot1x_NW_MsgTask_0: Nov 07 13:27:00.412: [PA] e4:a7:a0:82:8f:c0 Freeing EAP Retransmit Bufer for mobile e4:a7:a0:82:8f:c0
*Dot1x_NW_MsgTask_0: Nov 07 13:27:00.412: [PA] e4:a7:a0:82:8f:c0 apfMs1xStateInc
*Dot1x_NW_MsgTask_0: Nov 07 13:27:00.412: [PA] e4:a7:a0:82:8f:c0 apfMsPeapSimReqCntInc
*Dot1x_NW_MsgTask_0: Nov 07 13:27:00.412: [PA] e4:a7:a0:82:8f:c0 apfMsPeapSimReqSuccessCntInc
*Dot1x_NW_MsgTask_0: Nov 07 13:27:00.413: [PA] e4:a7:a0:82:8f:c0 172.16.12.248 8021X_REQD (3) Change state to L2AUTHCOMPLETE (4) last state 8021X_REQD (3)

*Dot1x_NW_MsgTask_0: Nov 07 13:27:00.413: [PA] e4:a7:a0:82:8f:c0 172.16.12.248 L2AUTHCOMPLETE (4) Client already has IP 172.16.12.248, DHCP Not required on AP 58:35:d9:c7:26:20 vapId 2 apVapId 1
*Dot1x_NW_MsgTask_0: Nov 07 13:27:00.413: [PA] e4:a7:a0:82:8f:c0 Not Using WMM Compliance code qosCap 00
*Dot1x_NW_MsgTask_0: Nov 07 13:27:00.413: [PA] e4:a7:a0:82:8f:c0 Vlan while overriding the policy = -1
*Dot1x_NW_MsgTask_0: Nov 07 13:27:00.413: [PA] e4:a7:a0:82:8f:c0 sending to spamAddMobile vlanId -1 flex aclName = , flexAclId 65535

*Dot1x_NW_MsgTask_0: Nov 07 13:27:00.413: [PA] e4:a7:a0:82:8f:c0 172.16.12.248 L2AUTHCOMPLETE (4) Plumbed mobile LWAPP rule on AP 58:35:d9:c7:26:20 vapId 2 apVapId 1 flex-acl-name:
*Dot1x_NW_MsgTask_0: Nov 07 13:27:00.413: [PA] e4:a7:a0:82:8f:c0 apfMsRunStateInc
*Dot1x_NW_MsgTask_0: Nov 07 13:27:00.413: [PA] e4:a7:a0:82:8f:c0 172.16.12.248 L2AUTHCOMPLETE (4) Change state to RUN (20) last state L2AUTHCOMPLETE (4)

*Dot1x_NW_MsgTask_0: Nov 07 13:27:00.413: [PA] e4:a7:a0:82:8f:c0 172.16.12.248 RUN (20) Reached PLUMBFASTPATH: from line 6894, null
*spamApTask3: Nov 07 13:27:00.413: [PA] e4:a7:a0:82:8f:c0 Successful transmission of LWAPP Add-Mobile to AP 58:35:d9:c7:26:20
*Dot1x_NW_MsgTask_0: Nov 07 13:27:00.413: [PA] e4:a7:a0:82:8f:c0 Accounting NAI-Realm: HANDOK\KR2190076, from Mscb username : HANDOK\KR2190076
*Dot1x_NW_MsgTask_0: Nov 07 13:27:00.413: [PA] e4:a7:a0:82:8f:c0 172.16.12.248 RUN (20) NO release MSCB
*Dot1x_NW_MsgTask_0: Nov 07 13:27:00.413: [PA] e4:a7:a0:82:8f:c0 Successfully Plumbed PTK session Keysfor mobile e4:a7:a0:82:8f:c0

Thank you

Leo Laohoo · ‎11-06-2019

What is the client doing the roaming?
What firmware is WLC running on?

Jinny · ‎11-06-2019

Hello Leo Laohoo

I want to know why I'm roaming.
WLC, firmware is 8.3.143.0

Thank you for your response.

Leo Laohoo · ‎11-06-2019

@Jinny wrote:
I want to know why I'm roaming.

Why you are roaming or why you are NOT roaming?

Jinny · ‎11-06-2019

Even if the user does not have to move the terminal
It joins the AP, which is weaker than the AP of the stronger century.

Is my question wrong?

Leo Laohoo · ‎11-06-2019

Roaming is not the job of the AP.
The wireless clients make the final decision which AP to join.
Whenever someone complains of poor roaming the first question I will always ask is: Has the wireless NIC driver been updated yet?