Users not getting IP only on 1 SSID

Pranav Mhatre · ‎02-07-2020

Hello Experts,

Issue - Users not getting IP only on 1 SSID for particular period of time. Time is fix. Not specific to Peak hours.

SSID Details - Guest SSID - Corp.guest

Authentication Type - 1st PSK (Locally configured on WLC) then 2nd Web Auth (on RADIUS server)

DHCP Scope - On Dedicated Windows DHCP server

WLC IOS - 8.0.140.0

WLC Model - vWLC

Troubleshooting -

1. If Wired user is connected to switch port with VLAN 625 (impacted VLAN), User gets IP however at the same time wireless users connected to same VLAN won't get IP.

2. If we shift DHCP Scope on L3 device it works fine.

3. If I reinitiate user request from WLC by removing DHCP Helper address (IP of DHCP server) and then re configuring users gets IP address immediately.

4. However if I only restart DHCP services of DHCP server Users wont get IP address

5. Also if I remove DHCP Helper address (IP of DHCP server) and then re configure DHCP Helper address on L3 device then Users wont get IP address.

Please find below logs -

(Corp-vWLC) >
(Corp-vWLC) >

(Corp-vWLC) >
(Corp-vWLC) >debug client 0c:c5:57:db:cb:0e

(Corp-vWLC) >*pemReceiveTask: Feb 07 13:27:57.641: 04:92:26:2b:85:c8 0.0.0.0 Removed NPU entry.
*apfMsConnTask_5: Feb 07 13:40:09.795: 0c:c5:57:db:cb:0e Client stats update: Time now in sec 1581057609, Last Acct Msg Sent at 0 sec
*apfMsConnTask_5: Feb 07 13:40:09.795: 0c:c5:57:db:cb:0e Requested to send acct interim update request msg to APF task for client c:b5:27:cb:cb:e

*apfMsConnTask_6: Feb 07 13:40:31.442: 0c:c5:57:db:cb:0e Processing assoc-req station:0c:c5:57:db:cb:0e AP:d0:c7:89:b4:2c:f0-00 thread:5518470
*apfMsConnTask_6: Feb 07 13:40:31.442: 0c:c5:57:db:cb:0e Reassociation received from mobile on BSSID d0:c7:89:b4:2c:84 AP Corp-AP06
*apfMsConnTask_6: Feb 07 13:40:31.442: 0c:c5:57:db:cb:0e Global 200 Clients are allowed to AP radio

*apfMsConnTask_6: Feb 07 13:40:31.442: 0c:c5:57:db:cb:0e Max Client Trap Threshold: 0 cur: 2

*apfMsConnTask_6: Feb 07 13:40:31.442: 0c:c5:57:db:cb:0e Rf profile 600 Clients are allowed to AP wlan

*apfMsConnTask_6: Feb 07 13:40:31.442: 0c:c5:57:db:cb:0e override for default ap group, marking intgrp NULL
*apfMsConnTask_6: Feb 07 13:40:31.442: 0c:c5:57:db:cb:0e Applying Interface(Corp.guest) policy on Mobile, role Local. Ms NAC State 2 Quarantine Vlan 0 Access Vlan 625

*apfMsConnTask_6: Feb 07 13:40:31.442: 0c:c5:57:db:cb:0e Re-applying interface policy for client

*apfMsConnTask_6: Feb 07 13:40:31.442: 0c:c5:57:db:cb:0e 0.0.0.0 DHCP_REQD (7) Changing IPv4 ACL 'none' (ACL ID 255) ===> 'none' (ACL ID 255) --- (caller apf_policy.c:2485)
*apfMsConnTask_6: Feb 07 13:40:31.442: 0c:c5:57:db:cb:0e 0.0.0.0 DHCP_REQD (7) Changing IPv6 ACL 'none' (ACL ID 255) ===> 'none' (ACL ID 255) --- (caller apf_policy.c:2506)
*apfMsConnTask_6: Feb 07 13:40:31.442: 0c:c5:57:db:cb:0e Values before applying NASID - interfacetype:3, ovrd:0, mscb nasid:Corp-vWLC, interface nasid:, APgrpset:0
*apfMsConnTask_6: Feb 07 13:40:31.442: 0c:c5:57:db:cb:0e apfApplyWlanPolicy: Apply WLAN Policy over PMIPv6 Client Mobility Type
*apfMsConnTask_6: Feb 07 13:40:31.442: 0c:c5:57:db:cb:0e Check before Setting the NAS Id to WLAN specific Id 'Corp.guest'
*apfMsConnTask_6: Feb 07 13:40:31.442: 0c:c5:57:db:cb:0e Setting the NAS Id to WLAN specific Id 'Corp.guest'
*apfMsConnTask_6: Feb 07 13:40:31.442: 0c:c5:57:db:cb:0e In processSsidIE:5756 setting Central switched to TRUE
*apfMsConnTask_6: Feb 07 13:40:31.442: 0c:c5:57:db:cb:0e In processSsidIE:5759 apVapId = 2 and Split Acl Id = 65535
*apfMsConnTask_6: Feb 07 13:40:31.442: 0c:c5:57:db:cb:0e Applying site-specific Local Bridging override for station 0c:c5:57:db:cb:0e - vapId 625, site 'All_SSID', interface 'Corp.guest'
*apfMsConnTask_6: Feb 07 13:40:31.442: 0c:c5:57:db:cb:0e Applying Local Bridging Interface Policy for station 0c:c5:57:db:cb:0e - vlan 625, interface id 7, interface 'Corp.guest', nasId:'Corp.guest'
*apfMsConnTask_6: Feb 07 13:40:31.442: 0c:c5:57:db:cb:0e override from ap group, removing intf group from mscb
*apfMsConnTask_6: Feb 07 13:40:31.442: 0c:c5:57:db:cb:0e Applying site-specific override for station 0c:c5:57:db:cb:0e - vapId 625, site 'All_SSID', interface 'Corp.guest'
*apfMsConnTask_6: Feb 07 13:40:31.442: 0c:c5:57:db:cb:0e Applying Interface(Corp.guest) policy on Mobile, role Local. Ms NAC State 2 Quarantine Vlan 0 Access Vlan 625

*apfMsConnTask_6: Feb 07 13:40:31.442: 0c:c5:57:db:cb:0e Re-applying interface policy for client

*apfMsConnTask_6: Feb 07 13:40:31.442: 0c:c5:57:db:cb:0e 0.0.0.0 DHCP_REQD (7) Changing IPv4 ACL 'none' (ACL ID 255) ===> 'none' (ACL ID 255) --- (caller apf_policy.c:2485)
*apfMsConnTask_6: Feb 07 13:40:31.442: 0c:c5:57:db:cb:0e 0.0.0.0 DHCP_REQD (7) Changing IPv6 ACL 'none' (ACL ID 255) ===> 'none' (ACL ID 255) --- (caller apf_policy.c:2506)
*apfMsConnTask_6: Feb 07 13:40:31.442: 0c:c5:57:db:cb:0e Values before applying NASID - interfacetype:3, ovrd:0, mscb nasid:Corp.guest, interface nasid:, APgrpset:0
*apfMsConnTask_6: Feb 07 13:40:31.442: 0c:c5:57:db:cb:0e Setting the NAS Id to AP group specific Id 'Corp-vWLC'
*apfMsConnTask_6: Feb 07 13:40:31.442: 0c:c5:57:db:cb:0e processSsidIE statusCode is 0 and status is 0
*apfMsConnTask_6: Feb 07 13:40:31.442: 0c:c5:57:db:cb:0e processSsidIE ssid_done_flag is 0 finish_flag is 0
*apfMsConnTask_6: Feb 07 13:40:31.442: 0c:c5:57:db:cb:0e STA - rates (8): 130 132 139 12 18 150 24 36 48 72 96 108 0 0 0 0
*apfMsConnTask_6: Feb 07 13:40:31.442: 0c:c5:57:db:cb:0e suppRates statusCode is 0 and gotSuppRatesElement is 1
*apfMsConnTask_6: Feb 07 13:40:31.442: 0c:c5:57:db:cb:0e STA - rates (12): 130 132 139 12 18 150 24 36 48 72 96 108 0 0 0 0
*apfMsConnTask_6: Feb 07 13:40:31.442: 0c:c5:57:db:cb:0e extSuppRates statusCode is 0 and gotExtSuppRatesElement is 1
*apfMsConnTask_6: Feb 07 13:40:31.442: RSNIE in Assoc. Req.: (20)

*apfMsConnTask_6: Feb 07 13:40:31.442: [0000] 01 00 00 0f ac 04 01 00 00 0f ac 04 01 00 00 0f

*apfMsConnTask_6: Feb 07 13:40:31.442: [0016] ac 02 00 00

*apfMsConnTask_6: Feb 07 13:40:31.442: 0c:c5:57:db:cb:0e Processing RSN IE type 48, length 20 for mobile 0c:c5:57:db:cb:0e
*apfMsConnTask_6: Feb 07 13:40:31.442: 0c:c5:57:db:cb:0e Received 802.11i PSK key management suite, enabling Authentication
*apfMsConnTask_6: Feb 07 13:40:31.442: 0c:c5:57:db:cb:0e RSN Capabilities: 0
*apfMsConnTask_6: Feb 07 13:40:31.442: 0c:c5:57:db:cb:0e Marking Mobile as non-11w Capable
*apfMsConnTask_6: Feb 07 13:40:31.442: 0c:c5:57:db:cb:0e pemApfDeleteMobileStation2: APF_MS_PEM_WAIT_L2_AUTH_COMPLETE = 0.
*apfMsConnTask_6: Feb 07 13:40:31.442: 0c:c5:57:db:cb:0e 0.0.0.0 DHCP_REQD (7) Deleted mobile LWAPP rule on AP [d0:c7:89:a0:8b:30]
*apfMsConnTask_6: Feb 07 13:40:31.442: 0c:c5:57:db:cb:0e Updated location for station old AP d0:c7:89:a0:8b:30-0, new AP d0:c7:89:b4:2c:f0-0
*apfMsConnTask_6: Feb 07 13:40:31.442: 0c:c5:57:db:cb:0e apfMsAssoStateDec
*apfMsConnTask_6: Feb 07 13:40:31.442: 0c:c5:57:db:cb:0e apfMsWepPskStateDec
*apfMsConnTask_6: Feb 07 13:40:31.442: 0c:c5:57:db:cb:0e apfProcessAssocReq (apf_80211.c:9472) Changing state for mobile 0c:c5:57:db:cb:0e on AP d0:c7:89:b4:2c:f0 from Associated to AAA Pending

*apfMsConnTask_6: Feb 07 13:40:31.442: 0c:c5:57:db:cb:0e Scheduling deletion of Mobile Station: (callerId: 20) in 10 seconds
*apfMsConnTask_6: Feb 07 13:40:31.442: 0c:c5:57:db:cb:0e Updating the Aid in case of flex mac-filtering

*apfMsConnTask_6: Feb 07 13:40:31.442: 0c:c5:57:db:cb:0e Updating AID for REAP AP Client d0:c7:89:b4:2c:f0 - AID ===> 4
*pemReceiveTask: Feb 07 13:40:31.442: 0c:c5:57:db:cb:0e 0.0.0.0 Removed NPU entry.
*spamApTask6: Feb 07 13:40:31.442: 0c:c5:57:db:cb:0e Delete Mobile request sent to the AP 10.216.13.172:15168

*apfMsConnTask_5: Feb 07 13:40:31.443: 0c:c5:57:db:cb:0e Client stats update: Time now in sec 1581057631, Last Acct Msg Sent at 0 sec
*apfMsConnTask_5: Feb 07 13:40:31.443: 0c:c5:57:db:cb:0e Requested to send acct interim update request msg to APF task for client c:b5:27:cb:cb:e

*apfReceiveTask: Feb 07 13:40:31.445: 0c:c5:57:db:cb:0e Received SGT for this Client.
*apfReceiveTask: Feb 07 13:40:31.445: 0c:c5:57:db:cb:0e override for default ap group, marking intgrp NULL
*apfReceiveTask: Feb 07 13:40:31.445: 0c:c5:57:db:cb:0e Applying Interface(Corp.guest) policy on Mobile, role Local. Ms NAC State 2 Quarantine Vlan 0 Access Vlan 625

*apfReceiveTask: Feb 07 13:40:31.445: 0c:c5:57:db:cb:0e Re-applying interface policy for client

*apfReceiveTask: Feb 07 13:40:31.445: 0c:c5:57:db:cb:0e 0.0.0.0 DHCP_REQD (7) Changing IPv4 ACL 'none' (ACL ID 255) ===> 'none' (ACL ID 255) --- (caller apf_policy.c:2485)
*apfReceiveTask: Feb 07 13:40:31.445: 0c:c5:57:db:cb:0e 0.0.0.0 DHCP_REQD (7) Changing IPv6 ACL 'none' (ACL ID 255) ===> 'none' (ACL ID 255) --- (caller apf_policy.c:2506)
*apfReceiveTask: Feb 07 13:40:31.445: 0c:c5:57:db:cb:0e Values before applying NASID - interfacetype:3, ovrd:0, mscb nasid:Corp-vWLC, interface nasid:, APgrpset:1
*apfReceiveTask: Feb 07 13:40:31.445: 0c:c5:57:db:cb:0e apfApplyWlanPolicy: Apply WLAN Policy over PMIPv6 Client Mobility Type
*apfReceiveTask: Feb 07 13:40:31.445: 0c:c5:57:db:cb:0e Check before Setting the NAS Id to WLAN specific Id 'Corp.guest'
*apfReceiveTask: Feb 07 13:40:31.445: 0c:c5:57:db:cb:0e Setting the NAS Id to WLAN specific Id 'Corp.guest'
*apfReceiveTask: Feb 07 13:40:31.445: 0c:c5:57:db:cb:0e override from ap group, removing intf group from mscb
*apfReceiveTask: Feb 07 13:40:31.445: 0c:c5:57:db:cb:0e Applying site-specific override for station 0c:c5:57:db:cb:0e - vapId 625, site 'All_SSID', interface 'Corp.guest'
*apfReceiveTask: Feb 07 13:40:31.445: 0c:c5:57:db:cb:0e Applying Interface(Corp.guest) policy on Mobile, role Local. Ms NAC State 2 Quarantine Vlan 0 Access Vlan 625

*apfReceiveTask: Feb 07 13:40:31.445: 0c:c5:57:db:cb:0e Re-applying interface policy for client

*apfReceiveTask: Feb 07 13:40:31.445: 0c:c5:57:db:cb:0e 0.0.0.0 DHCP_REQD (7) Changing IPv4 ACL 'none' (ACL ID 255) ===> 'none' (ACL ID 255) --- (caller apf_policy.c:2485)
*apfReceiveTask: Feb 07 13:40:31.445: 0c:c5:57:db:cb:0e 0.0.0.0 DHCP_REQD (7) Changing IPv6 ACL 'none' (ACL ID 255) ===> 'none' (ACL ID 255) --- (caller apf_policy.c:2506)
*apfReceiveTask: Feb 07 13:40:31.445: 0c:c5:57:db:cb:0e Values before applying NASID - interfacetype:3, ovrd:0, mscb nasid:Corp.guest, interface nasid:, APgrpset:1
*apfReceiveTask: Feb 07 13:40:31.445: 0c:c5:57:db:cb:0e Applying AP group specific NAS Id 'Corp-vWLC'
*apfReceiveTask: Feb 07 13:40:31.445: 0c:c5:57:db:cb:0e Inserting AAA Override struct for mobile
MAC: 0c:c5:57:db:cb:0e, source 2

*apfReceiveTask: Feb 07 13:40:31.445: 0c:c5:57:db:cb:0e apfMs1xStateDec
*apfReceiveTask: Feb 07 13:40:31.445: 0c:c5:57:db:cb:0e 0.0.0.0 DHCP_REQD (7) Change state to START (0) last state DHCP_REQD (7)

*apfReceiveTask: Feb 07 13:40:31.445: 0c:c5:57:db:cb:0e pemApfAddMobileStation2: APF_MS_PEM_WAIT_L2_AUTH_COMPLETE = 0.
*apfReceiveTask: Feb 07 13:40:31.445: 0c:c5:57:db:cb:0e 0.0.0.0 START (0) Initializing policy
*apfReceiveTask: Feb 07 13:40:31.445: 0c:c5:57:db:cb:0e 0.0.0.0 START (0) Change state to AUTHCHECK (2) last state START (0)

*apfReceiveTask: Feb 07 13:40:31.445: 0c:c5:57:db:cb:0e 0.0.0.0 AUTHCHECK (2) Change state to 8021X_REQD (3) last state AUTHCHECK (2)

*apfReceiveTask: Feb 07 13:40:31.445: 0c:c5:57:db:cb:0e Encryption policy is set to 0x80000001
*apfReceiveTask: Feb 07 13:40:31.445: 0c:c5:57:db:cb:0e Not Using WMM Compliance code qosCap 00
*apfReceiveTask: Feb 07 13:40:31.445: 0c:c5:57:db:cb:0e 0.0.0.0 8021X_REQD (3) Plumbed mobile LWAPP rule on AP d0:c7:89:b4:2c:f0 vapId 625 apVapId 2 flex-acl-name:
*apfReceiveTask: Feb 07 13:40:31.445: 0c:c5:57:db:cb:0e apfMsAssoStateInc
*apfReceiveTask: Feb 07 13:40:31.445: 0c:c5:57:db:cb:0e apfMsWepPskStateInc
*apfReceiveTask: Feb 07 13:40:31.445: 0c:c5:57:db:cb:0e apfPemAddUser2 (apf_policy.c:381) Changing state for mobile 0c:c5:57:db:cb:0e on AP d0:c7:89:b4:2c:f0 from AAA Pending to Associated

*apfReceiveTask: Feb 07 13:40:31.445: 0c:c5:57:db:cb:0e apfPemAddUser2:session timeout forstation 0c:c5:57:db:cb:0e - Session Tout 14400, apfMsTimeOut '14400' and sessionTimerRunning flag is 0
*apfReceiveTask: Feb 07 13:40:31.445: 0c:c5:57:db:cb:0e Scheduling deletion of Mobile Station: (callerId: 49) in 14400 seconds
*apfReceiveTask: Feb 07 13:40:31.445: 0c:c5:57:db:cb:0e Func: apfPemAddUser2, Ms Timeout = 14400, Session Timeout = 14400

*apfReceiveTask: Feb 07 13:40:31.445: 0c:c5:57:db:cb:0e Sending assoc-resp with status 0 station:0c:c5:57:db:cb:0e AP:d0:c7:89:b4:2c:f0-00 on apVapId 2
*apfReceiveTask: Feb 07 13:40:31.445: 0c:c5:57:db:cb:0e Sending Assoc Response to station on BSSID d0:c7:89:b4:2c:f1 (status 0) ApVapId 2 Slot 0
*apfReceiveTask: Feb 07 13:40:31.445: 0c:c5:57:db:cb:0e apfProcessRadiusAssocResp (apf_80211.c:4008) Changing state for mobile 0c:c5:57:db:cb:0e on AP d0:c7:89:b4:2c:f0 from Associated to Associated

*spamApTask0: Feb 07 13:40:31.446: 0c:c5:57:db:cb:0e Successful transmission of LWAPP Add-Mobile to AP d0:c7:89:b4:2c:f0
*spamApTask0: Feb 07 13:40:31.447: 0c:c5:57:db:cb:0e Received ADD_MOBILE ack - Initiating 1x to STA 0c:c5:57:db:cb:0e (idx 45)
*spamApTask0: Feb 07 13:40:31.447: 0c:c5:57:db:cb:0e Sent 1x initiate message to multi thread task for mobile 0c:c5:57:db:cb:0e
*Dot1x_NW_MsgTask_6: Feb 07 13:40:31.447: 0c:c5:57:db:cb:0e reauth_sm state transition 0 ---> 0 for mobile 0c:c5:57:db:cb:0e at 1x_reauth_sm.c:53
*Dot1x_NW_MsgTask_6: Feb 07 13:40:31.447: 0c:c5:57:db:cb:0e Creating a PKC PMKID Cache entry for station 0c:c5:57:db:cb:0e (RSN 2)
*Dot1x_NW_MsgTask_6: Feb 07 13:40:31.447: 0c:c5:57:db:cb:0e Resetting MSCB PMK Cache Entry 0 for station 0c:c5:57:db:cb:0e
*Dot1x_NW_MsgTask_6: Feb 07 13:40:31.447: 0c:c5:57:db:cb:0e Removing BSSID d0:c7:89:a0:8b:31 from PMKID cache of station 0c:c5:57:db:cb:0e
*Dot1x_NW_MsgTask_6: Feb 07 13:40:31.447: 0c:c5:57:db:cb:0e Setting active key cache index 0 ---> 8
*Dot1x_NW_MsgTask_6: Feb 07 13:40:31.447: 0c:c5:57:db:cb:0e Setting active key cache index 8 ---> 0
*Dot1x_NW_MsgTask_6: Feb 07 13:40:31.447: 0c:c5:57:db:cb:0e Adding BSSID d0:c7:89:b4:2c:f1 to PMKID cache at index 0 for station 0c:c5:57:db:cb:0e
*Dot1x_NW_MsgTask_6: Feb 07 13:40:31.447: New PMKID: (16)

*Dot1x_NW_MsgTask_6: Feb 07 13:40:31.447: [0000] 2e 58 99 b8 46 26 40 d5 94 02 8c 8e 21 ad 74 6b

*Dot1x_NW_MsgTask_6: Feb 07 13:40:31.447: 0c:c5:57:db:cb:0e Initiating RSN PSK to mobile 0c:c5:57:db:cb:0e
*Dot1x_NW_MsgTask_6: Feb 07 13:40:31.447: 0c:c5:57:db:cb:0e EAP-PARAM Debug - eap-params for Wlan-Id :625 is disabled - applying Global eap timers and retries
*Dot1x_NW_MsgTask_6: Feb 07 13:40:31.447: 0c:c5:57:db:cb:0e Disable re-auth, use PMK lifetime.
*Dot1x_NW_MsgTask_6: Feb 07 13:40:31.447: 0c:c5:57:db:cb:0e dot1x - moving mobile 0c:c5:57:db:cb:0e into Force Auth state
*Dot1x_NW_MsgTask_6: Feb 07 13:40:31.447: 0c:c5:57:db:cb:0e Skipping EAP-Success to mobile 0c:c5:57:db:cb:0e
*Dot1x_NW_MsgTask_6: Feb 07 13:40:31.447: 0c:c5:57:db:cb:0e Found an cache entry for BSSID d0:c7:89:b4:2c:f1 in PMKID cache at index 0 of station 0c:c5:57:db:cb:0e
*Dot1x_NW_MsgTask_6: Feb 07 13:40:31.447: 0c:c5:57:db:cb:0e Found an cache entry for BSSID d0:c7:89:b4:2c:f1 in PMKID cache at index 0 of station 0c:c5:57:db:cb:0e
*Dot1x_NW_MsgTask_6: Feb 07 13:40:31.447: Including PMKID in M1 (16)

*Dot1x_NW_MsgTask_6: Feb 07 13:40:31.447: [0000] 2e 58 99 b8 46 26 40 d5 94 02 8c 8e 21 ad 74 6b

*Dot1x_NW_MsgTask_6: Feb 07 13:40:31.447: 0c:c5:57:db:cb:0e Starting key exchange to mobile 0c:c5:57:db:cb:0e, data packets will be dropped
*Dot1x_NW_MsgTask_6: Feb 07 13:40:31.447: 0c:c5:57:db:cb:0e Sending EAPOL-Key Message to mobile 0c:c5:57:db:cb:0e
state INITPMK (message 1), replay counter 00.00.00.00.00.00.00.00
*Dot1x_NW_MsgTask_6: Feb 07 13:40:31.447: 0c:c5:57:db:cb:0e Allocating EAP Pkt for retransmission to mobile 0c:c5:57:db:cb:0e
*Dot1x_NW_MsgTask_6: Feb 07 13:40:31.462: 0c:c5:57:db:cb:0e Received EAPOL-Key from mobile 0c:c5:57:db:cb:0e
*Dot1x_NW_MsgTask_6: Feb 07 13:40:31.462: 0c:c5:57:db:cb:0e Ignoring invalid EAPOL version (1) in EAPOL-key message from mobile 0c:c5:57:db:cb:0e
*Dot1x_NW_MsgTask_6: Feb 07 13:40:31.462: 0c:c5:57:db:cb:0e Received EAPOL-key in PTK_START state (message 2) from mobile 0c:c5:57:db:cb:0e
*Dot1x_NW_MsgTask_6: Feb 07 13:40:31.462: 0c:c5:57:db:cb:0e Dumping RSNIE received in Association request:
*Dot1x_NW_MsgTask_6: Feb 07 13:40:31.462: 00000000: 30 14 01 00 00 0f ac 04 01 00 00 0f ac 04 01 00 0...............
*Dot1x_NW_MsgTask_6: Feb 07 13:40:31.462: 00000010: 00 0f ac 02 00 00 ......
*Dot1x_NW_MsgTask_6: Feb 07 13:40:31.462: 0c:c5:57:db:cb:0e Dumping RSNIE received in EAPOL M2 :
*Dot1x_NW_MsgTask_6: Feb 07 13:40:31.462: 00000000: 01 00 00 0f ac 04 01 00 00 0f ac 04 01 00 00 0f ................
*Dot1x_NW_MsgTask_6: Feb 07 13:40:31.462: 00000010: ac 02 00 00 ....
*Dot1x_NW_MsgTask_6: Feb 07 13:40:31.462: 0c:c5:57:db:cb:0e Stopping retransmission timer for mobile 0c:c5:57:db:cb:0e
*Dot1x_NW_MsgTask_6: Feb 07 13:40:31.462: 0c:c5:57:db:cb:0e Sending EAPOL-Key Message to mobile 0c:c5:57:db:cb:0e
state PTKINITNEGOTIATING (message 3), replay counter 00.00.00.00.00.00.00.01
*Dot1x_NW_MsgTask_6: Feb 07 13:40:31.462: 0c:c5:57:db:cb:0e Reusing allocated memory for EAP Pkt for retransmission to mobile 0c:c5:57:db:cb:0e
*Dot1x_NW_MsgTask_6: Feb 07 13:40:31.469: 0c:c5:57:db:cb:0e Received EAPOL-Key from mobile 0c:c5:57:db:cb:0e
*Dot1x_NW_MsgTask_6: Feb 07 13:40:31.469: 0c:c5:57:db:cb:0e Ignoring invalid EAPOL version (1) in EAPOL-key message from mobile 0c:c5:57:db:cb:0e
*Dot1x_NW_MsgTask_6: Feb 07 13:40:31.469: 0c:c5:57:db:cb:0e Received EAPOL-key in PTKINITNEGOTIATING state (message 4) from mobile 0c:c5:57:db:cb:0e
*Dot1x_NW_MsgTask_6: Feb 07 13:40:31.469: 0c:c5:57:db:cb:0e Stopping retransmission timer for mobile 0c:c5:57:db:cb:0e
*Dot1x_NW_MsgTask_6: Feb 07 13:40:31.469: 0c:c5:57:db:cb:0e Freeing EAP Retransmit Bufer for mobile 0c:c5:57:db:cb:0e
*Dot1x_NW_MsgTask_6: Feb 07 13:40:31.469: 0c:c5:57:db:cb:0e apfMs1xStateInc
*Dot1x_NW_MsgTask_6: Feb 07 13:40:31.470: 0c:c5:57:db:cb:0e 0.0.0.0 8021X_REQD (3) Change state to L2AUTHCOMPLETE (4) last state 8021X_REQD (3)

*Dot1x_NW_MsgTask_6: Feb 07 13:40:31.470: 0c:c5:57:db:cb:0e Not Using WMM Compliance code qosCap 00
*Dot1x_NW_MsgTask_6: Feb 07 13:40:31.470: 0c:c5:57:db:cb:0e 0.0.0.0 L2AUTHCOMPLETE (4) Plumbed mobile LWAPP rule on AP d0:c7:89:b4:2c:f0 vapId 625 apVapId 2 flex-acl-name:
*Dot1x_NW_MsgTask_6: Feb 07 13:40:31.470: 0c:c5:57:db:cb:0e 0.0.0.0 L2AUTHCOMPLETE (4) pemAdvanceState2 6554, Adding TMP rule
*Dot1x_NW_MsgTask_6: Feb 07 13:40:31.470: 0c:c5:57:db:cb:0e 0.0.0.0 L2AUTHCOMPLETE (4) Adding Fast Path rule
type = Airespace AP - Learn IP address
on AP d0:c7:89:b4:2c:f0, slot 0, interface = 1, QOS = 0
IPv4 ACL ID = 255
*Dot1x_NW_MsgTask_6: Feb 07 13:40:31.470: 0c:c5:57:db:cb:0e 0.0.0.0 L2AUTHCOMPLETE (4) Fast Path rule (contd...) 802.1P = 0, DSCP = 0, TokenID = 64206, IntfId = 7 Local Bridging Vlan = 625, Local Bridging intf id = 7
*Dot1x_NW_MsgTask_6: Feb 07 13:40:31.470: 0c:c5:57:db:cb:0e 0.0.0.0 L2AUTHCOMPLETE (4) Fast Path rule (contd...) AVC Ratelimit: AppID = 0 ,AppAction = 0, AppToken = 64206 AverageRate = 0, BurstRate = 0

*Dot1x_NW_MsgTask_6: Feb 07 13:40:31.470: 0c:c5:57:db:cb:0e 0.0.0.0 L2AUTHCOMPLETE (4) Fast Path rule (contd...) AVC Ratelimit: AppID = 0 ,AppAction = 0, AppToken = 64206 AverageRate = 0, BurstRate = 0

*Dot1x_NW_MsgTask_6: Feb 07 13:40:31.470: 0c:c5:57:db:cb:0e 0.0.0.0 L2AUTHCOMPLETE (4) Successfully plumbed mobile rule (IPv4 ACL ID 255, IPv6 ACL ID 255, L2 ACL ID 255)
*Dot1x_NW_MsgTask_6: Feb 07 13:40:31.470: 0c:c5:57:db:cb:0e 0.0.0.0 L2AUTHCOMPLETE (4) Change state to DHCP_REQD (7) last state L2AUTHCOMPLETE (4)

*Dot1x_NW_MsgTask_6: Feb 07 13:40:31.470: 0c:c5:57:db:cb:0e 0.0.0.0 DHCP_REQD (7) pemAdvanceState2 6583, Adding TMP rule
*Dot1x_NW_MsgTask_6: Feb 07 13:40:31.470: 0c:c5:57:db:cb:0e 0.0.0.0 DHCP_REQD (7) Replacing Fast Path rule
type = Airespace AP - Learn IP address
on AP d0:c7:89:b4:2c:f0, slot 0, interface = 1, QOS = 0
IPv4 ACL ID = 255,
*Dot1x_NW_MsgTask_6: Feb 07 13:40:31.470: 0c:c5:57:db:cb:0e 0.0.0.0 DHCP_REQD (7) Fast Path rule (contd...) 802.1P = 0, DSCP = 0, TokenID = 64206, IntfId = 7 Local Bridging Vlan = 625, Local Bridging intf id = 7
*Dot1x_NW_MsgTask_6: Feb 07 13:40:31.470: 0c:c5:57:db:cb:0e 0.0.0.0 DHCP_REQD (7) Fast Path rule (contd...) AVC Ratelimit: AppID = 0 ,AppAction = 0, AppToken = 64206 AverageRate = 0, BurstRate = 0

*Dot1x_NW_MsgTask_6: Feb 07 13:40:31.470: 0c:c5:57:db:cb:0e 0.0.0.0 DHCP_REQD (7) Fast Path rule (contd...) AVC Ratelimit: AppID = 0 ,AppAction = 0, AppToken = 64206 AverageRate = 0, BurstRate = 0

*Dot1x_NW_MsgTask_6: Feb 07 13:40:31.470: 0c:c5:57:db:cb:0e 0.0.0.0 DHCP_REQD (7) Successfully plumbed mobile rule (IPv4 ACL ID 255, IPv6 ACL ID 255, L2 ACL ID 255)
*spamApTask0: Feb 07 13:40:31.470: 0c:c5:57:db:cb:0e Successful transmission of LWAPP Add-Mobile to AP d0:c7:89:b4:2c:f0
*pemReceiveTask: Feb 07 13:40:31.470: 0c:c5:57:db:cb:0e 0.0.0.0 Added NPU entry of type 9, dtlFlags 0x0
*pemReceiveTask: Feb 07 13:40:31.470: 0c:c5:57:db:cb:0e 0.0.0.0 Added NPU entry of type 9, dtlFlags 0x0
*apfMsConnTask_6: Feb 07 13:40:58.598: 0c:c5:57:db:cb:0e Client stats update: Time now in sec 1581057658, Last Acct Msg Sent at 0 sec
*apfMsConnTask_6: Feb 07 13:40:58.598: 0c:c5:57:db:cb:0e Requested to send acct interim update request msg to APF task for client c:b5:27:cb:cb:e

*apfMsConnTask_6: Feb 07 13:42:24.298: 0c:c5:57:db:cb:0e Client stats update: Time now in sec 1581057744, Last Acct Msg Sent at 0 sec
*apfMsConnTask_6: Feb 07 13:42:24.298: 0c:c5:57:db:cb:0e Requested to send acct interim update request msg to APF task for client c:b5:27:cb:cb:e

*apfReceiveTask: Feb 07 13:42:32.794: 0c:c5:57:db:cb:0e 0.0.0.0 DHCP_REQD (7) DHCP Policy timeout. Number of DHCP Discover 4, DHCP Request 3 from client
*apfReceiveTask: Feb 07 13:42:32.794: 0c:c5:57:db:cb:0e Interface Group was NULL.Number of DHCP Discovery 4 from client
*apfReceiveTask: Feb 07 13:42:32.794: 0c:c5:57:db:cb:0e 0.0.0.0 DHCP_REQD (7) Pem timed out, Try to delete client in 10 secs.
*apfReceiveTask: Feb 07 13:42:32.794: 0c:c5:57:db:cb:0e Scheduling deletion of Mobile Station: (callerId: 12) in 10 seconds
*osapiBsnTimer: Feb 07 13:42:42.895: 0c:c5:57:db:cb:0e apfMsExpireCallback (apf_ms.c:637) Expiring Mobile!
*apfReceiveTask: Feb 07 13:42:42.896: 0c:c5:57:db:cb:0e apfMsExpireMobileStation (apf_ms.c:7098) Changing state for mobile 0c:c5:57:db:cb:0e on AP d0:c7:89:b4:2c:f0 from Associated to Disassociated

*apfReceiveTask: Feb 07 13:42:42.896: 0c:c5:57:db:cb:0e Scheduling deletion of Mobile Station: (callerId: 45) in 10 seconds
*osapiBsnTimer: Feb 07 13:42:52.953: 0c:c5:57:db:cb:0e apfMsExpireCallback (apf_ms.c:637) Expiring Mobile!
*apfReceiveTask: Feb 07 13:42:52.954: 0c:c5:57:db:cb:0e apfSendDisAssocMsgDebug (apf_80211.c:3208) Changing state for mobile 0c:c5:57:db:cb:0e on AP d0:c7:89:b4:2c:f0 from Disassociated to Disassociated

*apfReceiveTask: Feb 07 13:42:52.954: 0c:c5:57:db:cb:0e Sent Disassociate to mobile on AP d0:c7:89:b4:2c:f0-0 (reason 2, caller apf_ms.c:7192)
*apfReceiveTask: Feb 07 13:42:52.954: 0c:c5:57:db:cb:0e Sent Deauthenticate to mobile on BSSID d0:c7:89:b4:2c:f0 slot 0(caller apf_ms.c:7194)
*apfReceiveTask: Feb 07 13:42:52.954: 0c:c5:57:db:cb:0e Resetting MSCB PMK Cache Entry 0 for station 0c:c5:57:db:cb:0e
*apfReceiveTask: Feb 07 13:42:52.954: 0c:c5:57:db:cb:0e Removing BSSID d0:c7:89:b4:2c:f1 from PMKID cache of station 0c:c5:57:db:cb:0e
*apfReceiveTask: Feb 07 13:42:52.954: 0c:c5:57:db:cb:0e Setting active key cache index 0 ---> 8
*apfReceiveTask: Feb 07 13:42:52.954: 0c:c5:57:db:cb:0e Deleting the PMK cache when de-authenticating the client.
*apfReceiveTask: Feb 07 13:42:52.954: 0c:c5:57:db:cb:0e Global PMK Cache deletion failed.
*apfReceiveTask: Feb 07 13:42:52.954: 0c:c5:57:db:cb:0e apfMsAssoStateDec
*apfReceiveTask: Feb 07 13:42:52.954: 0c:c5:57:db:cb:0e apfMsWepPskStateDec
*apfReceiveTask: Feb 07 13:42:52.954: 0c:c5:57:db:cb:0e apfMsExpireMobileStation (apf_ms.c:7236) Changing state for mobile 0c:c5:57:db:cb:0e on AP d0:c7:89:b4:2c:f0 from Disassociated to Idle

*apfReceiveTask: Feb 07 13:42:52.954: 0c:c5:57:db:cb:0e pemApfDeleteMobileStation2: APF_MS_PEM_WAIT_L2_AUTH_COMPLETE = 0.
*apfReceiveTask: Feb 07 13:42:52.954: 0c:c5:57:db:cb:0e 0.0.0.0 START (0) Deleted mobile LWAPP rule on AP [d0:c7:89:b4:2c:f0]
*apfReceiveTask: Feb 07 13:42:52.954: 0c:c5:57:db:cb:0e Deleting mobile on AP d0:c7:89:b4:2c:f0(0)
*spamApTask0: Feb 07 13:42:52.954: 0c:c5:57:db:cb:0e Delete Mobile request sent to the AP 10.159.134.168:42552

*pemReceiveTask: Feb 07 13:42:52.954: 0c:c5:57:db:cb:0e 0.0.0.0 Removed NPU entry.
*apfMsConnTask_6: Feb 07 13:43:54.165: 0c:c5:57:db:cb:0e Processing assoc-req station:0c:c5:57:db:cb:0e AP:d0:c7:89:b4:2c:f0-00 thread:5518470
*apfMsConnTask_6: Feb 07 13:43:54.165: 0c:c5:57:db:cb:0e Adding mobile on LWAPP AP d0:c7:89:b4:2c:f0(0)
*apfMsConnTask_6: Feb 07 13:43:54.165: 0c:c5:57:db:cb:0e Association received from mobile on BSSID d0:c7:89:b4:2c:84 AP Corp-AP06
*apfMsConnTask_6: Feb 07 13:43:54.165: 0c:c5:57:db:cb:0e Global 200 Clients are allowed to AP radio

*apfMsConnTask_6: Feb 07 13:43:54.165: 0c:c5:57:db:cb:0e Max Client Trap Threshold: 0 cur: 2

*apfMsConnTask_6: Feb 07 13:43:54.165: 0c:c5:57:db:cb:0e Rf profile 600 Clients are allowed to AP wlan

*apfMsConnTask_6: Feb 07 13:43:54.165: 0c:c5:57:db:cb:0e override for default ap group, marking intgrp NULL
*apfMsConnTask_6: Feb 07 13:43:54.165: 0c:c5:57:db:cb:0e Applying Interface(Corp.guest) policy on Mobile, role Unassociated. Ms NAC State 0 Quarantine Vlan 0 Access Vlan 0

*apfMsConnTask_6: Feb 07 13:43:54.165: 0c:c5:57:db:cb:0e Re-applying interface policy for client

*apfMsConnTask_6: Feb 07 13:43:54.165: 0c:c5:57:db:cb:0e 0.0.0.0 START (0) Changing IPv4 ACL 'none' (ACL ID 255) ===> 'none' (ACL ID 255) --- (caller apf_policy.c:2485)
*apfMsConnTask_6: Feb 07 13:43:54.165: 0c:c5:57:db:cb:0e 0.0.0.0 START (0) Changing IPv6 ACL 'none' (ACL ID 255) ===> 'none' (ACL ID 255) --- (caller apf_policy.c:2506)
*apfMsConnTask_6: Feb 07 13:43:54.165: 0c:c5:57:db:cb:0e Values before applying NASID - interfacetype:3, ovrd:0, mscb nasid:, interface nasid:, APgrpset:0
*apfMsConnTask_6: Feb 07 13:43:54.165: 0c:c5:57:db:cb:0e apfApplyWlanPolicy: Apply WLAN Policy over PMIPv6 Client Mobility Type
*apfMsConnTask_6: Feb 07 13:43:54.165: 0c:c5:57:db:cb:0e Check before Setting the NAS Id to WLAN specific Id 'Corp.guest'
*apfMsConnTask_6: Feb 07 13:43:54.165: 0c:c5:57:db:cb:0e Setting the NAS Id to WLAN specific Id 'Corp.guest'
*apfMsConnTask_6: Feb 07 13:43:54.165: 0c:c5:57:db:cb:0e In processSsidIE:5756 setting Central switched to TRUE
*apfMsConnTask_6: Feb 07 13:43:54.165: 0c:c5:57:db:cb:0e In processSsidIE:5759 apVapId = 2 and Split Acl Id = 65535
*apfMsConnTask_6: Feb 07 13:43:54.165: 0c:c5:57:db:cb:0e Applying site-specific Local Bridging override for station 0c:c5:57:db:cb:0e - vapId 625, site 'All_SSID', interface 'Corp.guest'
*apfMsConnTask_6: Feb 07 13:43:54.165: 0c:c5:57:db:cb:0e Applying Local Bridging Interface Policy for station 0c:c5:57:db:cb:0e - vlan 625, interface id 7, interface 'Corp.guest', nasId:'Corp.guest'
*apfMsConnTask_6: Feb 07 13:43:54.165: 0c:c5:57:db:cb:0e override from ap group, removing intf group from mscb
*apfMsConnTask_6: Feb 07 13:43:54.165: 0c:c5:57:db:cb:0e Applying site-specific override for station 0c:c5:57:db:cb:0e - vapId 625, site 'All_SSID', interface 'Corp.guest'
*apfMsConnTask_6: Feb 07 13:43:54.165: 0c:c5:57:db:cb:0e Applying Interface(Corp.guest) policy on Mobile, role Unassociated. Ms NAC State 2 Quarantine Vlan 0 Access Vlan 625

*apfMsConnTask_6: Feb 07 13:43:54.165: 0c:c5:57:db:cb:0e Re-applying interface policy for client

*apfMsConnTask_6: Feb 07 13:43:54.165: 0c:c5:57:db:cb:0e 0.0.0.0 START (0) Changing IPv4 ACL 'none' (ACL ID 255) ===> 'none' (ACL ID 255) --- (caller apf_policy.c:2485)
*apfMsConnTask_6: Feb 07 13:43:54.165: 0c:c5:57:db:cb:0e 0.0.0.0 START (0) Changing IPv6 ACL 'none' (ACL ID 255) ===> 'none' (ACL ID 255) --- (caller apf_policy.c:2506)
*apfMsConnTask_6: Feb 07 13:43:54.165: 0c:c5:57:db:cb:0e Values before applying NASID - interfacetype:3, ovrd:0, mscb nasid:Corp.guest, interface nasid:, APgrpset:0
*apfMsConnTask_6: Feb 07 13:43:54.165: 0c:c5:57:db:cb:0e Setting the NAS Id to AP group specific Id 'Corp-vWLC'
*apfMsConnTask_6: Feb 07 13:43:54.165: 0c:c5:57:db:cb:0e processSsidIE statusCode is 0 and status is 0
*apfMsConnTask_6: Feb 07 13:43:54.165: 0c:c5:57:db:cb:0e processSsidIE ssid_done_flag is 0 finish_flag is 0
*apfMsConnTask_6: Feb 07 13:43:54.166: 0c:c5:57:db:cb:0e STA - rates (8): 130 132 139 12 18 150 24 36 0 0 0 0 0 0 0 0
*apfMsConnTask_6: Feb 07 13:43:54.166: 0c:c5:57:db:cb:0e suppRates statusCode is 0 and gotSuppRatesElement is 1
*apfMsConnTask_6: Feb 07 13:43:54.166: 0c:c5:57:db:cb:0e STA - rates (12): 130 132 139 12 18 150 24 36 48 72 96 108 0 0 0 0
*apfMsConnTask_6: Feb 07 13:43:54.166: 0c:c5:57:db:cb:0e extSuppRates statusCode is 0 and gotExtSuppRatesElement is 1
*apfMsConnTask_6: Feb 07 13:43:54.166: RSNIE in Assoc. Req.: (20)

*apfMsConnTask_6: Feb 07 13:43:54.166: [0000] 01 00 00 0f ac 04 01 00 00 0f ac 04 01 00 00 0f

*apfMsConnTask_6: Feb 07 13:43:54.166: [0016] ac 02 00 00

*apfMsConnTask_6: Feb 07 13:43:54.166: 0c:c5:57:db:cb:0e Processing RSN IE type 48, length 20 for mobile 0c:c5:57:db:cb:0e
*apfMsConnTask_6: Feb 07 13:43:54.166: 0c:c5:57:db:cb:0e Received 802.11i PSK key management suite, enabling Authentication
*apfMsConnTask_6: Feb 07 13:43:54.166: 0c:c5:57:db:cb:0e RSN Capabilities: 0
*apfMsConnTask_6: Feb 07 13:43:54.166: 0c:c5:57:db:cb:0e Marking Mobile as non-11w Capable
*apfMsConnTask_6: Feb 07 13:43:54.166: 0c:c5:57:db:cb:0e Created Acct-Session-ID (5e3d072a/0c:c5:57:db:cb:0e/349595) for the mobile
*apfMsConnTask_6: Feb 07 13:43:54.166: 0c:c5:57:db:cb:0e apfProcessAssocReq (apf_80211.c:9472) Changing state for mobile 0c:c5:57:db:cb:0e on AP d0:c7:89:b4:2c:f0 from Idle to AAA Pending

*apfMsConnTask_6: Feb 07 13:43:54.166: 0c:c5:57:db:cb:0e Scheduling deletion of Mobile Station: (callerId: 20) in 10 seconds
*apfMsConnTask_6: Feb 07 13:43:54.166: 0c:c5:57:db:cb:0e Updating the Aid in case of flex mac-filtering

*apfMsConnTask_6: Feb 07 13:43:54.166: 0c:c5:57:db:cb:0e Updating AID for REAP AP Client d0:c7:89:b4:2c:f0 - AID ===> 4
*apfReceiveTask: Feb 07 13:43:54.187: 0c:c5:57:db:cb:0e Received SGT for this Client.
*apfReceiveTask: Feb 07 13:43:54.187: 0c:c5:57:db:cb:0e override for default ap group, marking intgrp NULL
*apfReceiveTask: Feb 07 13:43:54.187: 0c:c5:57:db:cb:0e Applying Interface(Corp.guest) policy on Mobile, role Unassociated. Ms NAC State 2 Quarantine Vlan 0 Access Vlan 625

*apfReceiveTask: Feb 07 13:43:54.187: 0c:c5:57:db:cb:0e Re-applying interface policy for client

*apfReceiveTask: Feb 07 13:43:54.187: 0c:c5:57:db:cb:0e 0.0.0.0 START (0) Changing IPv4 ACL 'none' (ACL ID 255) ===> 'none' (ACL ID 255) --- (caller apf_policy.c:2485)
*apfReceiveTask: Feb 07 13:43:54.187: 0c:c5:57:db:cb:0e 0.0.0.0 START (0) Changing IPv6 ACL 'none' (ACL ID 255) ===> 'none' (ACL ID 255) --- (caller apf_policy.c:2506)
*apfReceiveTask: Feb 07 13:43:54.187: 0c:c5:57:db:cb:0e Values before applying NASID - interfacetype:3, ovrd:0, mscb nasid:Corp-vWLC, interface nasid:, APgrpset:1
*apfReceiveTask: Feb 07 13:43:54.187: 0c:c5:57:db:cb:0e apfApplyWlanPolicy: Apply WLAN Policy over PMIPv6 Client Mobility Type
*apfReceiveTask: Feb 07 13:43:54.187: 0c:c5:57:db:cb:0e Check before Setting the NAS Id to WLAN specific Id 'Corp.guest'
*apfReceiveTask: Feb 07 13:43:54.187: 0c:c5:57:db:cb:0e Setting the NAS Id to WLAN specific Id 'Corp.guest'
*apfReceiveTask: Feb 07 13:43:54.187: 0c:c5:57:db:cb:0e override from ap group, removing intf group from mscb
*apfReceiveTask: Feb 07 13:43:54.187: 0c:c5:57:db:cb:0e Applying site-specific override for station 0c:c5:57:db:cb:0e - vapId 625, site 'All_SSID', interface 'Corp.guest'
*apfReceiveTask: Feb 07 13:43:54.187: 0c:c5:57:db:cb:0e Applying Interface(Corp.guest) policy on Mobile, role Unassociated. Ms NAC State 2 Quarantine Vlan 0 Access Vlan 625

*apfReceiveTask: Feb 07 13:43:54.187: 0c:c5:57:db:cb:0e Re-applying interface policy for client

*apfReceiveTask: Feb 07 13:43:54.187: 0c:c5:57:db:cb:0e 0.0.0.0 START (0) Changing IPv4 ACL 'none' (ACL ID 255) ===> 'none' (ACL ID 255) --- (caller apf_policy.c:2485)
*apfReceiveTask: Feb 07 13:43:54.187: 0c:c5:57:db:cb:0e 0.0.0.0 START (0) Changing IPv6 ACL 'none' (ACL ID 255) ===> 'none' (ACL ID 255) --- (caller apf_policy.c:2506)
*apfReceiveTask: Feb 07 13:43:54.187: 0c:c5:57:db:cb:0e Values before applying NASID - interfacetype:3, ovrd:0, mscb nasid:Corp.guest, interface nasid:, APgrpset:1
*apfReceiveTask: Feb 07 13:43:54.187: 0c:c5:57:db:cb:0e Applying AP group specific NAS Id 'Corp-vWLC'
*apfReceiveTask: Feb 07 13:43:54.187: 0c:c5:57:db:cb:0e Inserting AAA Override struct for mobile
MAC: 0c:c5:57:db:cb:0e, source 2

*apfReceiveTask: Feb 07 13:43:54.187: 0c:c5:57:db:cb:0e 0.0.0.0 START (0) Initializing policy
*apfReceiveTask: Feb 07 13:43:54.187: 0c:c5:57:db:cb:0e 0.0.0.0 START (0) Change state to AUTHCHECK (2) last state START (0)

*apfReceiveTask: Feb 07 13:43:54.187: 0c:c5:57:db:cb:0e 0.0.0.0 AUTHCHECK (2) Change state to 8021X_REQD (3) last state AUTHCHECK (2)

*apfReceiveTask: Feb 07 13:43:54.187: 0c:c5:57:db:cb:0e Encryption policy is set to 0x80000001
*apfReceiveTask: Feb 07 13:43:54.187: 0c:c5:57:db:cb:0e Not Using WMM Compliance code qosCap 00
*apfReceiveTask: Feb 07 13:43:54.187: 0c:c5:57:db:cb:0e 0.0.0.0 8021X_REQD (3) Plumbed mobile LWAPP rule on AP d0:c7:89:b4:2c:f0 vapId 625 apVapId 2 flex-acl-name:
*apfReceiveTask: Feb 07 13:43:54.187: 0c:c5:57:db:cb:0e apfMsAssoStateInc
*apfReceiveTask: Feb 07 13:43:54.187: 0c:c5:57:db:cb:0e apfMsWepPskStateInc
*apfReceiveTask: Feb 07 13:43:54.187: 0c:c5:57:db:cb:0e apfPemAddUser2 (apf_policy.c:381) Changing state for mobile 0c:c5:57:db:cb:0e on AP d0:c7:89:b4:2c:f0 from AAA Pending to Associated

*apfReceiveTask: Feb 07 13:43:54.187: 0c:c5:57:db:cb:0e apfPemAddUser2:session timeout forstation 0c:c5:57:db:cb:0e - Session Tout 14400, apfMsTimeOut '14400' and sessionTimerRunning flag is 0
*apfReceiveTask: Feb 07 13:43:54.187: 0c:c5:57:db:cb:0e Scheduling deletion of Mobile Station: (callerId: 49) in 14400 seconds
*apfReceiveTask: Feb 07 13:43:54.187: 0c:c5:57:db:cb:0e Func: apfPemAddUser2, Ms Timeout = 14400, Session Timeout = 14400

*apfReceiveTask: Feb 07 13:43:54.187: 0c:c5:57:db:cb:0e Sending assoc-resp with status 0 station:0c:c5:57:db:cb:0e AP:d0:c7:89:b4:2c:f0-00 on apVapId 2
*apfReceiveTask: Feb 07 13:43:54.187: 0c:c5:57:db:cb:0e Sending Assoc Response to station on BSSID d0:c7:89:b4:2c:f1 (status 0) ApVapId 2 Slot 0
*apfReceiveTask: Feb 07 13:43:54.187: 0c:c5:57:db:cb:0e apfProcessRadiusAssocResp (apf_80211.c:4008) Changing state for mobile 0c:c5:57:db:cb:0e on AP d0:c7:89:b4:2c:f0 from Associated to Associated

*spamApTask0: Feb 07 13:43:54.188: 0c:c5:57:db:cb:0e Successful transmission of LWAPP Add-Mobile to AP d0:c7:89:b4:2c:f0
*spamApTask0: Feb 07 13:43:54.189: 0c:c5:57:db:cb:0e Received ADD_MOBILE ack - Initiating 1x to STA 0c:c5:57:db:cb:0e (idx 63)
*spamApTask0: Feb 07 13:43:54.189: 0c:c5:57:db:cb:0e Sent 1x initiate message to multi thread task for mobile 0c:c5:57:db:cb:0e
*Dot1x_NW_MsgTask_6: Feb 07 13:43:54.189: 0c:c5:57:db:cb:0e reauth_sm state transition 0 ---> 1 for mobile 0c:c5:57:db:cb:0e at 1x_reauth_sm.c:47
*Dot1x_NW_MsgTask_6: Feb 07 13:43:54.190: 0c:c5:57:db:cb:0e Creating a PKC PMKID Cache entry for station 0c:c5:57:db:cb:0e (RSN 2)
*Dot1x_NW_MsgTask_6: Feb 07 13:43:54.190: 0c:c5:57:db:cb:0e Resetting MSCB PMK Cache Entry 0 for station 0c:c5:57:db:cb:0e
*Dot1x_NW_MsgTask_6: Feb 07 13:43:54.190: 0c:c5:57:db:cb:0e Setting active key cache index 8 ---> 8
*Dot1x_NW_MsgTask_6: Feb 07 13:43:54.190: 0c:c5:57:db:cb:0e Setting active key cache index 8 ---> 0
*Dot1x_NW_MsgTask_6: Feb 07 13:43:54.190: 0c:c5:57:db:cb:0e Adding BSSID d0:c7:89:b4:2c:f1 to PMKID cache at index 0 for station 0c:c5:57:db:cb:0e
*Dot1x_NW_MsgTask_6: Feb 07 13:43:54.190: New PMKID: (16)

*Dot1x_NW_MsgTask_6: Feb 07 13:43:54.190: [0000] 2e 58 99 b8 46 26 40 d5 94 02 8c 8e 21 ad 74 6b

*Dot1x_NW_MsgTask_6: Feb 07 13:43:54.190: 0c:c5:57:db:cb:0e Initiating RSN PSK to mobile 0c:c5:57:db:cb:0e
*Dot1x_NW_MsgTask_6: Feb 07 13:43:54.190: 0c:c5:57:db:cb:0e EAP-PARAM Debug - eap-params for Wlan-Id :625 is disabled - applying Global eap timers and retries
*Dot1x_NW_MsgTask_6: Feb 07 13:43:54.190: 0c:c5:57:db:cb:0e Disable re-auth, use PMK lifetime.
*Dot1x_NW_MsgTask_6: Feb 07 13:43:54.190: 0c:c5:57:db:cb:0e dot1x - moving mobile 0c:c5:57:db:cb:0e into Force Auth state
*Dot1x_NW_MsgTask_6: Feb 07 13:43:54.190: 0c:c5:57:db:cb:0e Skipping EAP-Success to mobile 0c:c5:57:db:cb:0e
*Dot1x_NW_MsgTask_6: Feb 07 13:43:54.190: 0c:c5:57:db:cb:0e Found an cache entry for BSSID d0:c7:89:b4:2c:f1 in PMKID cache at index 0 of station 0c:c5:57:db:cb:0e
*Dot1x_NW_MsgTask_6: Feb 07 13:43:54.190: 0c:c5:57:db:cb:0e Found an cache entry for BSSID d0:c7:89:b4:2c:f1 in PMKID cache at index 0 of station 0c:c5:57:db:cb:0e
*Dot1x_NW_MsgTask_6: Feb 07 13:43:54.190: Including PMKID in M1 (16)

*Dot1x_NW_MsgTask_6: Feb 07 13:43:54.190: [0000] 2e 58 99 b8 46 26 40 d5 94 02 8c 8e 21 ad 74 6b

*Dot1x_NW_MsgTask_6: Feb 07 13:43:54.190: 0c:c5:57:db:cb:0e Starting key exchange to mobile 0c:c5:57:db:cb:0e, data packets will be dropped
*Dot1x_NW_MsgTask_6: Feb 07 13:43:54.190: 0c:c5:57:db:cb:0e Sending EAPOL-Key Message to mobile 0c:c5:57:db:cb:0e
state INITPMK (message 1), replay counter 00.00.00.00.00.00.00.00
*Dot1x_NW_MsgTask_6: Feb 07 13:43:54.190: 0c:c5:57:db:cb:0e Allocating EAP Pkt for retransmission to mobile 0c:c5:57:db:cb:0e
*osapiBsnTimer: Feb 07 13:43:55.314: 0c:c5:57:db:cb:0e 802.1x 'timeoutEvt' Timer expired for station 0c:c5:57:db:cb:0e and for message = M2
*dot1xMsgTask: Feb 07 13:43:55.314: 0c:c5:57:db:cb:0e Retransmit 1 of EAPOL-Key M1 (length 121) for mobile 0c:c5:57:db:cb:0e
*Dot1x_NW_MsgTask_6: Feb 07 13:43:55.321: 0c:c5:57:db:cb:0e Received EAPOL-Key from mobile 0c:c5:57:db:cb:0e
*Dot1x_NW_MsgTask_6: Feb 07 13:43:55.321: 0c:c5:57:db:cb:0e Ignoring invalid EAPOL version (1) in EAPOL-key message from mobile 0c:c5:57:db:cb:0e
*Dot1x_NW_MsgTask_6: Feb 07 13:43:55.321: 0c:c5:57:db:cb:0e Received EAPOL-key in PTK_START state (message 2) from mobile 0c:c5:57:db:cb:0e
*Dot1x_NW_MsgTask_6: Feb 07 13:43:55.321: 0c:c5:57:db:cb:0e Dumping RSNIE received in Association request:
*Dot1x_NW_MsgTask_6: Feb 07 13:43:55.321: 00000000: 30 14 01 00 00 0f ac 04 01 00 00 0f ac 04 01 00 0...............
*Dot1x_NW_MsgTask_6: Feb 07 13:43:55.321: 00000010: 00 0f ac 02 00 00 ......
*Dot1x_NW_MsgTask_6: Feb 07 13:43:55.321: 0c:c5:57:db:cb:0e Dumping RSNIE received in EAPOL M2 :
*Dot1x_NW_MsgTask_6: Feb 07 13:43:55.321: 00000000: 01 00 00 0f ac 04 01 00 00 0f ac 04 01 00 00 0f ................
*Dot1x_NW_MsgTask_6: Feb 07 13:43:55.321: 00000010: ac 02 00 00 ....
*Dot1x_NW_MsgTask_6: Feb 07 13:43:55.321: 0c:c5:57:db:cb:0e Stopping retransmission timer for mobile 0c:c5:57:db:cb:0e
*Dot1x_NW_MsgTask_6: Feb 07 13:43:55.321: 0c:c5:57:db:cb:0e Sending EAPOL-Key Message to mobile 0c:c5:57:db:cb:0e
state PTKINITNEGOTIATING (message 3), replay counter 00.00.00.00.00.00.00.02
*Dot1x_NW_MsgTask_6: Feb 07 13:43:55.321: 0c:c5:57:db:cb:0e Reusing allocated memory for EAP Pkt for retransmission to mobile 0c:c5:57:db:cb:0e
*Dot1x_NW_MsgTask_6: Feb 07 13:43:55.332: 0c:c5:57:db:cb:0e Received EAPOL-Key from mobile 0c:c5:57:db:cb:0e
*Dot1x_NW_MsgTask_6: Feb 07 13:43:55.332: 0c:c5:57:db:cb:0e Ignoring invalid EAPOL version (1) in EAPOL-key message from mobile 0c:c5:57:db:cb:0e
*Dot1x_NW_MsgTask_6: Feb 07 13:43:55.332: 0c:c5:57:db:cb:0e Received EAPOL-key in PTKINITNEGOTIATING state (message 4) from mobile 0c:c5:57:db:cb:0e
*Dot1x_NW_MsgTask_6: Feb 07 13:43:55.332: 0c:c5:57:db:cb:0e Stopping retransmission timer for mobile 0c:c5:57:db:cb:0e
*Dot1x_NW_MsgTask_6: Feb 07 13:43:55.332: 0c:c5:57:db:cb:0e Freeing EAP Retransmit Bufer for mobile 0c:c5:57:db:cb:0e
*Dot1x_NW_MsgTask_6: Feb 07 13:43:55.332: 0c:c5:57:db:cb:0e apfMs1xStateInc
*Dot1x_NW_MsgTask_6: Feb 07 13:43:55.332: 0c:c5:57:db:cb:0e 0.0.0.0 8021X_REQD (3) Change state to L2AUTHCOMPLETE (4) last state 8021X_REQD (3)

*Dot1x_NW_MsgTask_6: Feb 07 13:43:55.332: 0c:c5:57:db:cb:0e Mobility query, PEM State: L2AUTHCOMPLETE

*Dot1x_NW_MsgTask_6: Feb 07 13:43:55.332: 0c:c5:57:db:cb:0e 0.0.0.0 L2AUTHCOMPLETE (4) mobility role update request from Unassociated to Local
Peer = 0.0.0.0, Old Anchor = 0.0.0.0, New Anchor = 10.159.134.162
*Dot1x_NW_MsgTask_6: Feb 07 13:43:55.332: 0c:c5:57:db:cb:0e 0.0.0.0 L2AUTHCOMPLETE (4) State Update from Mobility-Incomplete to Mobility-Complete, mobility role=Local, client state=APF_MS_STATE_ASSOCIATED
*Dot1x_NW_MsgTask_6: Feb 07 13:43:55.332: 0c:c5:57:db:cb:0e 0.0.0.0 L2AUTHCOMPLETE (4) pemAdvanceState2 6241, Adding TMP rule
*Dot1x_NW_MsgTask_6: Feb 07 13:43:55.332: 0c:c5:57:db:cb:0e 0.0.0.0 L2AUTHCOMPLETE (4) Adding Fast Path rule
type = Airespace AP - Learn IP address
on AP d0:c7:89:b4:2c:f0, slot 0, interface = 1, QOS = 0
IPv4 ACL ID = 255
*Dot1x_NW_MsgTask_6: Feb 07 13:43:55.332: 0c:c5:57:db:cb:0e 0.0.0.0 L2AUTHCOMPLETE (4) Fast Path rule (contd...) 802.1P = 0, DSCP = 0, TokenID = 64206, IntfId = 7 Local Bridging Vlan = 625, Local Bridging intf id = 7
*Dot1x_NW_MsgTask_6: Feb 07 13:43:55.332: 0c:c5:57:db:cb:0e 0.0.0.0 L2AUTHCOMPLETE (4) Fast Path rule (contd...) AVC Ratelimit: AppID = 0 ,AppAction = 0, AppToken = 64206 AverageRate = 0, BurstRate = 0

*Dot1x_NW_MsgTask_6: Feb 07 13:43:55.332: 0c:c5:57:db:cb:0e 0.0.0.0 L2AUTHCOMPLETE (4) Fast Path rule (contd...) AVC Ratelimit: AppID = 0 ,AppAction = 0, AppToken = 64206 AverageRate = 0, BurstRate = 0

*Dot1x_NW_MsgTask_6: Feb 07 13:43:55.332: 0c:c5:57:db:cb:0e 0.0.0.0 L2AUTHCOMPLETE (4) Successfully plumbed mobile rule (IPv4 ACL ID 255, IPv6 ACL ID 255, L2 ACL ID 255)
*Dot1x_NW_MsgTask_6: Feb 07 13:43:55.332: 0c:c5:57:db:cb:0e Not Using WMM Compliance code qosCap 00
*Dot1x_NW_MsgTask_6: Feb 07 13:43:55.332: 0c:c5:57:db:cb:0e 0.0.0.0 L2AUTHCOMPLETE (4) Plumbed mobile LWAPP rule on AP d0:c7:89:b4:2c:f0 vapId 625 apVapId 2 flex-acl-name:
*Dot1x_NW_MsgTask_6: Feb 07 13:43:55.332: 0c:c5:57:db:cb:0e 0.0.0.0 L2AUTHCOMPLETE (4) pemAdvanceState2 6554, Adding TMP rule
*Dot1x_NW_MsgTask_6: Feb 07 13:43:55.332: 0c:c5:57:db:cb:0e 0.0.0.0 L2AUTHCOMPLETE (4) Replacing Fast Path rule
type = Airespace AP - Learn IP address
on AP d0:c7:89:b4:2c:f0, slot 0, interface = 1, QOS = 0
IPv4 ACL ID =
*Dot1x_NW_MsgTask_6: Feb 07 13:43:55.332: 0c:c5:57:db:cb:0e 0.0.0.0 L2AUTHCOMPLETE (4) Fast Path rule (contd...) 802.1P = 0, DSCP = 0, TokenID = 64206, IntfId = 7 Local Bridging Vlan = 625, Local Bridging intf id = 7
*Dot1x_NW_MsgTask_6: Feb 07 13:43:55.332: 0c:c5:57:db:cb:0e 0.0.0.0 L2AUTHCOMPLETE (4) Fast Path rule (contd...) AVC Ratelimit: AppID = 0 ,AppAction = 0, AppToken = 64206 AverageRate = 0, BurstRate = 0

*Dot1x_NW_MsgTask_6: Feb 07 13:43:55.332: 0c:c5:57:db:cb:0e 0.0.0.0 L2AUTHCOMPLETE (4) Fast Path rule (contd...) AVC Ratelimit: AppID = 0 ,AppAction = 0, AppToken = 64206 AverageRate = 0, BurstRate = 0

*Dot1x_NW_MsgTask_6: Feb 07 13:43:55.332: 0c:c5:57:db:cb:0e 0.0.0.0 L2AUTHCOMPLETE (4) Successfully plumbed mobile rule (IPv4 ACL ID 255, IPv6 ACL ID 255, L2 ACL ID 255)
*Dot1x_NW_MsgTask_6: Feb 07 13:43:55.332: 0c:c5:57:db:cb:0e 0.0.0.0 L2AUTHCOMPLETE (4) Change state to DHCP_REQD (7) last state L2AUTHCOMPLETE (4)

*Dot1x_NW_MsgTask_6: Feb 07 13:43:55.332: 0c:c5:57:db:cb:0e 0.0.0.0 DHCP_REQD (7) pemAdvanceState2 6583, Adding TMP rule
*Dot1x_NW_MsgTask_6: Feb 07 13:43:55.332: 0c:c5:57:db:cb:0e 0.0.0.0 DHCP_REQD (7) Replacing Fast Path rule
type = Airespace AP - Learn IP address
on AP d0:c7:89:b4:2c:f0, slot 0, interface = 1, QOS = 0
IPv4 ACL ID = 255,
*Dot1x_NW_MsgTask_6: Feb 07 13:43:55.332: 0c:c5:57:db:cb:0e 0.0.0.0 DHCP_REQD (7) Fast Path rule (contd...) 802.1P = 0, DSCP = 0, TokenID = 64206, IntfId = 7 Local Bridging Vlan = 625, Local Bridging intf id = 7
*Dot1x_NW_MsgTask_6: Feb 07 13:43:55.332: 0c:c5:57:db:cb:0e 0.0.0.0 DHCP_REQD (7) Fast Path rule (contd...) AVC Ratelimit: AppID = 0 ,AppAction = 0, AppToken = 64206 AverageRate = 0, BurstRate = 0

*Dot1x_NW_MsgTask_6: Feb 07 13:43:55.332: 0c:c5:57:db:cb:0e 0.0.0.0 DHCP_REQD (7) Fast Path rule (contd...) AVC Ratelimit: AppID = 0 ,AppAction = 0, AppToken = 64206 AverageRate = 0, BurstRate = 0

*Dot1x_NW_MsgTask_6: Feb 07 13:43:55.332: 0c:c5:57:db:cb:0e 0.0.0.0 DHCP_REQD (7) Successfully plumbed mobile rule (IPv4 ACL ID 255, IPv6 ACL ID 255, L2 ACL ID 255)
*pemReceiveTask: Feb 07 13:43:55.332: 0c:c5:57:db:cb:0e 0.0.0.0 Added NPU entry of type 9, dtlFlags 0x0
*pemReceiveTask: Feb 07 13:43:55.332: 0c:c5:57:db:cb:0e Sent an XID frame
*pemReceiveTask: Feb 07 13:43:55.332: 0c:c5:57:db:cb:0e 0.0.0.0 Added NPU entry of type 9, dtlFlags 0x0
*pemReceiveTask: Feb 07 13:43:55.332: 0c:c5:57:db:cb:0e 0.0.0.0 Added NPU entry of type 9, dtlFlags 0x0
*spamApTask0: Feb 07 13:43:55.333: 0c:c5:57:db:cb:0e Successful transmission of LWAPP Add-Mobile to AP d0:c7:89:b4:2c:f0
*DHCP Socket Task: Feb 07 13:43:55.449: 0c:c5:57:db:cb:0e DHCP received op BOOTREQUEST (1) (len 330,vlan 25, port 1, encap 0xec03)
*DHCP Socket Task: Feb 07 13:43:55.449: 0c:c5:57:db:cb:0e DHCP (encap type 0xec03) mstype 0ff:ff:ff:ff:ff:ff
*DHCP Socket Task: Feb 07 13:43:55.449: 0c:c5:57:db:cb:0e DHCP selecting relay 1 - control block settings:
dhcpServer: 0.0.0.0, dhcpNetmask: 0.0.0.0,
dhcpGateway: 0.0.0.0, dhcpRelay: 0.0.0.0 VLAN: 0
*DHCP Socket Task: Feb 07 13:43:55.449: 0c:c5:57:db:cb:0e DHCP selected relay 1 - 10.215.13.125 (local address 10.161.21.55, gateway 10.161.21.1, VLAN 625, port 1)
*DHCP Socket Task: Feb 07 13:43:55.449: 0c:c5:57:db:cb:0e DHCP transmitting DHCP REQUEST (3)
*DHCP Socket Task: Feb 07 13:43:55.449: 0c:c5:57:db:cb:0e DHCP op: BOOTREQUEST, htype: Ethernet, hlen: 6, hops: 1
*DHCP Socket Task: Feb 07 13:43:55.449: 0c:c5:57:db:cb:0e DHCP xid: 0x81983b87 (2174237575), secs: 0, flags: 0
*DHCP Socket Task: Feb 07 13:43:55.449: 0c:c5:57:db:cb:0e DHCP chaddr: 0c:c5:57:db:cb:0e
*DHCP Socket Task: Feb 07 13:43:55.449: 0c:c5:57:db:cb:0e DHCP ciaddr: 0.0.0.0, yiaddr: 0.0.0.0
*DHCP Socket Task: Feb 07 13:43:55.449: 0c:c5:57:db:cb:0e DHCP siaddr: 0.0.0.0, giaddr: 10.161.21.55
*DHCP Socket Task: Feb 07 13:43:55.449: 0c:c5:57:db:cb:0e DHCP requested ip: 10.155.72.49
*DHCP Socket Task: Feb 07 13:43:55.449: 0c:c5:57:db:cb:0e DHCP sending REQUEST to 10.161.21.1 (len 374, port 1, vlan 625)
*DHCP Socket Task: Feb 07 13:43:55.449: 0c:c5:57:db:cb:0e DHCP selecting relay 2 - control block settings:
dhcpServer: 0.0.0.0, dhcpNetmask: 0.0.0.0,
dhcpGateway: 0.0.0.0, dhcpRelay: 10.161.21.55 VLAN: 625
*DHCP Socket Task: Feb 07 13:43:55.449: 0c:c5:57:db:cb:0e DHCP selected relay 2 - NONE (server address 0.0.0.0,local address 0.0.0.0, gateway 10.161.21.1, VLAN 625, port 1)
*DHCP Socket Task: Feb 07 13:43:55.453: 0c:c5:57:db:cb:0e DHCP received op BOOTREQUEST (1) (len 330,vlan 25, port 1, encap 0xec03)
*DHCP Socket Task: Feb 07 13:43:55.453: 0c:c5:57:db:cb:0e DHCP (encap type 0xec03) mstype 0ff:ff:ff:ff:ff:ff
*DHCP Socket Task: Feb 07 13:43:55.453: 0c:c5:57:db:cb:0e DHCP selecting relay 1 - control block settings:
dhcpServer: 0.0.0.0, dhcpNetmask: 0.0.0.0,
dhcpGateway: 0.0.0.0, dhcpRelay: 10.161.21.55 VLAN: 625
*DHCP Socket Task: Feb 07 13:43:55.453: 0c:c5:57:db:cb:0e DHCP selected relay 1 - 10.215.13.125 (local address 10.161.21.55, gateway 10.161.21.1, VLAN 625, port 1)
*DHCP Socket Task: Feb 07 13:43:55.453: 0c:c5:57:db:cb:0e DHCP transmitting DHCP REQUEST (3)
*DHCP Socket Task: Feb 07 13:43:55.453: 0c:c5:57:db:cb:0e DHCP op: BOOTREQUEST, htype: Ethernet, hlen: 6, hops: 1
*DHCP Socket Task: Feb 07 13:43:55.453: 0c:c5:57:db:cb:0e DHCP xid: 0x81983b87 (2174237575), secs: 0, flags: 0
*DHCP Socket Task: Feb 07 13:43:55.453: 0c:c5:57:db:cb:0e DHCP chaddr: 0c:c5:57:db:cb:0e
*DHCP Socket Task: Feb 07 13:43:55.453: 0c:c5:57:db:cb:0e DHCP ciaddr: 0.0.0.0, yiaddr: 0.0.0.0
*DHCP Socket Task: Feb 07 13:43:55.453: 0c:c5:57:db:cb:0e DHCP siaddr: 0.0.0.0, giaddr: 10.161.21.55
*DHCP Socket Task: Feb 07 13:43:55.453: 0c:c5:57:db:cb:0e DHCP requested ip: 10.155.72.49
*DHCP Socket Task: Feb 07 13:43:55.453: 0c:c5:57:db:cb:0e DHCP sending REQUEST to 10.161.21.1 (len 374, port 1, vlan 625)
*DHCP Socket Task: Feb 07 13:43:55.453: 0c:c5:57:db:cb:0e DHCP selecting relay 2 - control block settings:
dhcpServer: 0.0.0.0, dhcpNetmask: 0.0.0.0,
dhcpGateway: 0.0.0.0, dhcpRelay: 10.161.21.55 VLAN: 625
*DHCP Socket Task: Feb 07 13:43:55.453: 0c:c5:57:db:cb:0e DHCP selected relay 2 - NONE (server address 0.0.0.0,local address 0.0.0.0, gateway 10.161.21.1, VLAN 625, port 1)
*DHCP Socket Task: Feb 07 13:44:00.467: 0c:c5:57:db:cb:0e DHCP received op BOOTREQUEST (1) (len 330,vlan 25, port 1, encap 0xec03)
*DHCP Socket Task: Feb 07 13:44:00.467: 0c:c5:57:db:cb:0e DHCP (encap type 0xec03) mstype 0ff:ff:ff:ff:ff:ff
*DHCP Socket Task: Feb 07 13:44:00.467: 0c:c5:57:db:cb:0e DHCP selecting relay 1 - control block settings:
dhcpServer: 0.0.0.0, dhcpNetmask: 0.0.0.0,
dhcpGateway: 0.0.0.0, dhcpRelay: 10.161.21.55 VLAN: 625
*DHCP Socket Task: Feb 07 13:44:00.467: 0c:c5:57:db:cb:0e DHCP selected relay 1 - 10.215.13.125 (local address 10.161.21.55, gateway 10.161.21.1, VLAN 625, port 1)
*DHCP Socket Task: Feb 07 13:44:00.467: 0c:c5:57:db:cb:0e DHCP transmitting DHCP REQUEST (3)
*DHCP Socket Task: Feb 07 13:44:00.467: 0c:c5:57:db:cb:0e DHCP op: BOOTREQUEST, htype: Ethernet, hlen: 6, hops: 1
*DHCP Socket Task: Feb 07 13:44:00.467: 0c:c5:57:db:cb:0e DHCP xid: 0x81983b87 (2174237575), secs: 1280, flags: 0
*DHCP Socket Task: Feb 07 13:44:00.467: 0c:c5:57:db:cb:0e DHCP chaddr: 0c:c5:57:db:cb:0e
*DHCP Socket Task: Feb 07 13:44:00.467: 0c:c5:57:db:cb:0e DHCP ciaddr: 0.0.0.0, yiaddr: 0.0.0.0
*DHCP Socket Task: Feb 07 13:44:00.467: 0c:c5:57:db:cb:0e DHCP siaddr: 0.0.0.0, giaddr: 10.161.21.55
*DHCP Socket Task: Feb 07 13:44:00.467: 0c:c5:57:db:cb:0e DHCP requested ip: 10.155.72.49
*DHCP Socket Task: Feb 07 13:44:00.467: 0c:c5:57:db:cb:0e DHCP sending REQUEST to 10.161.21.1 (len 374, port 1, vlan 625)
*DHCP Socket Task: Feb 07 13:44:00.467: 0c:c5:57:db:cb:0e DHCP selecting relay 2 - control block settings:
dhcpServer: 0.0.0.0, dhcpNetmask: 0.0.0.0,
dhcpGateway: 0.0.0.0, dhcpRelay: 10.161.21.55 VLAN: 625
*DHCP Socket Task: Feb 07 13:44:00.467: 0c:c5:57:db:cb:0e DHCP selected relay 2 - NONE (server address 0.0.0.0,local address 0.0.0.0, gateway 10.161.21.1, VLAN 625, port 1)
*DHCP Socket Task: Feb 07 13:44:04.458: 0c:c5:57:db:cb:0e DHCP received op BOOTREQUEST (1) (len 324,vlan 25, port 1, encap 0xec03)
*DHCP Socket Task: Feb 07 13:44:04.458: 0c:c5:57:db:cb:0e DHCP (encap type 0xec03) mstype 0ff:ff:ff:ff:ff:ff
*DHCP Socket Task: Feb 07 13:44:04.458: 0c:c5:57:db:cb:0e DHCP selecting relay 1 - control block settings:
dhcpServer: 0.0.0.0, dhcpNetmask: 0.0.0.0,
dhcpGateway: 0.0.0.0, dhcpRelay: 10.161.21.55 VLAN: 625
*DHCP Socket Task: Feb 07 13:44:04.458: 0c:c5:57:db:cb:0e DHCP selected relay 1 - 10.215.13.125 (local address 10.161.21.55, gateway 10.161.21.1, VLAN 625, port 1)
*DHCP Socket Task: Feb 07 13:44:04.458: 0c:c5:57:db:cb:0e DHCP selecting relay 2 - control block settings:
dhcpServer: 0.0.0.0, dhcpNetmask: 0.0.0.0,
dhcpGateway: 0.0.0.0, dhcpRelay: 10.161.21.55 VLAN: 625
*DHCP Socket Task: Feb 07 13:44:04.458: 0c:c5:57:db:cb:0e DHCP selected relay 2 - NONE (server address 0.0.0.0,local address 10.161.21.55, gateway 10.161.21.1, VLAN 625, port 1)
*DHCP Socket Task: Feb 07 13:44:04.458: 0c:c5:57:db:cb:0e DHCP selecting relay 1 - control block settings:
dhcpServer: 0.0.0.0, dhcpNetmask: 0.0.0.0,
dhcpGateway: 0.0.0.0, dhcpRelay: 10.161.21.55 VLAN: 625
*DHCP Socket Task: Feb 07 13:44:04.458: 0c:c5:57:db:cb:0e DHCP selected relay 1 - 10.215.13.125 (local address 10.161.21.55, gateway 10.161.21.1, VLAN 625, port 1)
*DHCP Socket Task: Feb 07 13:44:04.458: 0c:c5:57:db:cb:0e DHCP transmitting DHCP DISCOVER (1)
*DHCP Socket Task: Feb 07 13:44:04.458: 0c:c5:57:db:cb:0e DHCP op: BOOTREQUEST, htype: Ethernet, hlen: 6, hops: 1
*DHCP Socket Task: Feb 07 13:44:04.458: 0c:c5:57:db:cb:0e DHCP xid: 0x4137bb08 (1094171400), secs: 0, flags: 0
*DHCP Socket Task: Feb 07 13:44:04.458: 0c:c5:57:db:cb:0e DHCP chaddr: 0c:c5:57:db:cb:0e
*DHCP Socket Task: Feb 07 13:44:04.458: 0c:c5:57:db:cb:0e DHCP ciaddr: 0.0.0.0, yiaddr: 0.0.0.0
*DHCP Socket Task: Feb 07 13:44:04.458: 0c:c5:57:db:cb:0e DHCP siaddr: 0.0.0.0, giaddr: 10.161.21.55
*DHCP Socket Task: Feb 07 13:44:04.458: 0c:c5:57:db:cb:0e DHCP sending REQUEST to 10.161.21.1 (len 366, port 1, vlan 625)
*DHCP Socket Task: Feb 07 13:44:04.458: 0c:c5:57:db:cb:0e DHCP selecting relay 2 - control block settings:
dhcpServer: 0.0.0.0, dhcpNetmask: 0.0.0.0,
dhcpGateway: 0.0.0.0, dhcpRelay: 10.161.21.55 VLAN: 625
*DHCP Socket Task: Feb 07 13:44:04.458: 0c:c5:57:db:cb:0e DHCP selected relay 2 - NONE (server address 0.0.0.0,local address 0.0.0.0, gateway 10.161.21.1, VLAN 625, port 1)
*DHCP Socket Task: Feb 07 13:44:09.487: 0c:c5:57:db:cb:0e DHCP received op BOOTREQUEST (1) (len 324,vlan 25, port 1, encap 0xec03)
*DHCP Socket Task: Feb 07 13:44:09.487: 0c:c5:57:db:cb:0e DHCP (encap type 0xec03) mstype 0ff:ff:ff:ff:ff:ff
*DHCP Socket Task: Feb 07 13:44:09.487: 0c:c5:57:db:cb:0e DHCP selecting relay 1 - control block settings:
dhcpServer: 0.0.0.0, dhcpNetmask: 0.0.0.0,
dhcpGateway: 0.0.0.0, dhcpRelay: 10.161.21.55 VLAN: 625
*DHCP Socket Task: Feb 07 13:44:09.487: 0c:c5:57:db:cb:0e DHCP selected relay 1 - 10.215.13.125 (local address 10.161.21.55, gateway 10.161.21.1, VLAN 625, port 1)
*DHCP Socket Task: Feb 07 13:44:09.487: 0c:c5:57:db:cb:0e DHCP selecting relay 2 - control block settings:
dhcpServer: 0.0.0.0, dhcpNetmask: 0.0.0.0,
dhcpGateway: 0.0.0.0, dhcpRelay: 10.161.21.55 VLAN: 625
*DHCP Socket Task: Feb 07 13:44:09.487: 0c:c5:57:db:cb:0e DHCP selected relay 2 - NONE (server address 0.0.0.0,local address 10.161.21.55, gateway 10.161.21.1, VLAN 625, port 1)
*DHCP Socket Task: Feb 07 13:44:09.487: 0c:c5:57:db:cb:0e DHCP selecting relay 1 - control block settings:
dhcpServer: 0.0.0.0, dhcpNetmask: 0.0.0.0,
dhcpGateway: 0.0.0.0, dhcpRelay: 10.161.21.55 VLAN: 625
*DHCP Socket Task: Feb 07 13:44:09.487: 0c:c5:57:db:cb:0e DHCP selected relay 1 - 10.215.13.125 (local address 10.161.21.55, gateway 10.161.21.1, VLAN 625, port 1)
*DHCP Socket Task: Feb 07 13:44:09.487: 0c:c5:57:db:cb:0e DHCP transmitting DHCP DISCOVER (1)
*DHCP Socket Task: Feb 07 13:44:09.487: 0c:c5:57:db:cb:0e DHCP op: BOOTREQUEST, htype: Ethernet, hlen: 6, hops: 1
*DHCP Socket Task: Feb 07 13:44:09.487: 0c:c5:57:db:cb:0e DHCP xid: 0x4137bb08 (1094171400), secs: 1280, flags: 0
*DHCP Socket Task: Feb 07 13:44:09.487: 0c:c5:57:db:cb:0e DHCP chaddr: 0c:c5:57:db:cb:0e
*DHCP Socket Task: Feb 07 13:44:09.487: 0c:c5:57:db:cb:0e DHCP ciaddr: 0.0.0.0, yiaddr: 0.0.0.0
*DHCP Socket Task: Feb 07 13:44:09.487: 0c:c5:57:db:cb:0e DHCP siaddr: 0.0.0.0, giaddr: 10.161.21.55
*DHCP Socket Task: Feb 07 13:44:09.487: 0c:c5:57:db:cb:0e DHCP sending REQUEST to 10.161.21.1 (len 366, port 1, vlan 625)
*DHCP Socket Task: Feb 07 13:44:09.487: 0c:c5:57:db:cb:0e DHCP selecting relay 2 - control block settings:
dhcpServer: 0.0.0.0, dhcpNetmask: 0.0.0.0,
dhcpGateway: 0.0.0.0, dhcpRelay: 10.161.21.55 VLAN: 625
*DHCP Socket Task: Feb 07 13:44:09.487: 0c:c5:57:db:cb:0e DHCP selected relay 2 - NONE (server address 0.0.0.0,local address 0.0.0.0, gateway 10.161.21.1, VLAN 625, port 1)
*DHCP Socket Task: Feb 07 13:44:14.489: 0c:c5:57:db:cb:0e DHCP received op BOOTREQUEST (1) (len 324,vlan 25, port 1, encap 0xec03)
*DHCP Socket Task: Feb 07 13:44:14.489: 0c:c5:57:db:cb:0e DHCP (encap type 0xec03) mstype 0ff:ff:ff:ff:ff:ff
*DHCP Socket Task: Feb 07 13:44:14.489: 0c:c5:57:db:cb:0e DHCP selecting relay 1 - control block settings:
dhcpServer: 0.0.0.0, dhcpNetmask: 0.0.0.0,
dhcpGateway: 0.0.0.0, dhcpRelay: 10.161.21.55 VLAN: 625
*DHCP Socket Task: Feb 07 13:44:14.489: 0c:c5:57:db:cb:0e DHCP selected relay 1 - 10.215.13.125 (local address 10.161.21.55, gateway 10.161.21.1, VLAN 625, port 1)
*DHCP Socket Task: Feb 07 13:44:14.489: 0c:c5:57:db:cb:0e DHCP selecting relay 2 - control block settings:
dhcpServer: 0.0.0.0, dhcpNetmask: 0.0.0.0,
dhcpGateway: 0.0.0.0, dhcpRelay: 10.161.21.55 VLAN: 625
*DHCP Socket Task: Feb 07 13:44:14.489: 0c:c5:57:db:cb:0e DHCP selected relay 2 - NONE (server address 0.0.0.0,local address 10.161.21.55, gateway 10.161.21.1, VLAN 625, port 1)
*DHCP Socket Task: Feb 07 13:44:14.489: 0c:c5:57:db:cb:0e DHCP selecting relay 1 - control block settings:
dhcpServer: 0.0.0.0, dhcpNetmask: 0.0.0.0,
dhcpGateway: 0.0.0.0, dhcpRelay: 10.161.21.55 VLAN: 625
*DHCP Socket Task: Feb 07 13:44:14.489: 0c:c5:57:db:cb:0e DHCP selected relay 1 - 10.215.13.125 (local address 10.161.21.55, gateway 10.161.21.1, VLAN 625, port 1)
*DHCP Socket Task: Feb 07 13:44:14.489: 0c:c5:57:db:cb:0e DHCP transmitting DHCP DISCOVER (1)
*DHCP Socket Task: Feb 07 13:44:14.489: 0c:c5:57:db:cb:0e DHCP op: BOOTREQUEST, htype: Ethernet, hlen: 6, hops: 1
*DHCP Socket Task: Feb 07 13:44:14.489: 0c:c5:57:db:cb:0e DHCP xid: 0x4137bb08 (1094171400), secs: 2560, flags: 0
*DHCP Socket Task: Feb 07 13:44:14.489: 0c:c5:57:db:cb:0e DHCP chaddr: 0c:c5:57:db:cb:0e
*DHCP Socket Task: Feb 07 13:44:14.489: 0c:c5:57:db:cb:0e DHCP ciaddr: 0.0.0.0, yiaddr: 0.0.0.0
*DHCP Socket Task: Feb 07 13:44:14.489: 0c:c5:57:db:cb:0e DHCP siaddr: 0.0.0.0, giaddr: 10.161.21.55
*DHCP Socket Task: Feb 07 13:44:14.489: 0c:c5:57:db:cb:0e DHCP sending REQUEST to 10.161.21.1 (len 366, port 1, vlan 625)
*DHCP Socket Task: Feb 07 13:44:14.489: 0c:c5:57:db:cb:0e DHCP selecting relay 2 - control block settings:
dhcpServer: 0.0.0.0, dhcpNetmask: 0.0.0.0,
dhcpGateway: 0.0.0.0, dhcpRelay: 10.161.21.55 VLAN: 625
*DHCP Socket Task: Feb 07 13:44:14.489: 0c:c5:57:db:cb:0e DHCP selected relay 2 - NONE (server address 0.0.0.0,local address 0.0.0.0, gateway 10.161.21.1, VLAN 625, port 1)
*DHCP Socket Task: Feb 07 13:44:14.489: 0c:c5:57:db:cb:0e Interface Group was NULL.Number of DHCP Discovery 3 from client
*DHCP Socket Task: Feb 07 13:44:19.491: 0c:c5:57:db:cb:0e DHCP received op BOOTREQUEST (1) (len 324,vlan 25, port 1, encap 0xec03)
*DHCP Socket Task: Feb 07 13:44:19.491: 0c:c5:57:db:cb:0e DHCP (encap type 0xec03) mstype 0ff:ff:ff:ff:ff:ff
*DHCP Socket Task: Feb 07 13:44:19.491: 0c:c5:57:db:cb:0e DHCP selecting relay 1 - control block settings:
dhcpServer: 0.0.0.0, dhcpNetmask: 0.0.0.0,
dhcpGateway: 0.0.0.0, dhcpRelay: 10.161.21.55 VLAN: 625
*DHCP Socket Task: Feb 07 13:44:19.491: 0c:c5:57:db:cb:0e DHCP selected relay 1 - 10.215.13.125 (local address 10.161.21.55, gateway 10.161.21.1, VLAN 625, port 1)
*DHCP Socket Task: Feb 07 13:44:19.491: 0c:c5:57:db:cb:0e DHCP selecting relay 2 - control block settings:
dhcpServer: 0.0.0.0, dhcpNetmask: 0.0.0.0,
dhcpGateway: 0.0.0.0, dhcpRelay: 10.161.21.55 VLAN: 625
*DHCP Socket Task: Feb 07 13:44:19.491: 0c:c5:57:db:cb:0e DHCP selected relay 2 - NONE (server address 0.0.0.0,local address 10.161.21.55, gateway 10.161.21.1, VLAN 625, port 1)
*DHCP Socket Task: Feb 07 13:44:19.491: 0c:c5:57:db:cb:0e DHCP selecting relay 1 - control block settings:
dhcpServer: 0.0.0.0, dhcpNetmask: 0.0.0.0,
dhcpGateway: 0.0.0.0, dhcpRelay: 10.161.21.55 VLAN: 625
*DHCP Socket Task: Feb 07 13:44:19.491: 0c:c5:57:db:cb:0e DHCP selected relay 1 - 10.215.13.125 (local address 10.161.21.55, gateway 10.161.21.1, VLAN 625, port 1)
*DHCP Socket Task: Feb 07 13:44:19.491: 0c:c5:57:db:cb:0e DHCP transmitting DHCP DISCOVER (1)
*DHCP Socket Task: Feb 07 13:44:19.491: 0c:c5:57:db:cb:0e DHCP op: BOOTREQUEST, htype: Ethernet, hlen: 6, hops: 1
*DHCP Socket Task: Feb 07 13:44:19.491: 0c:c5:57:db:cb:0e DHCP xid: 0x4137bb08 (1094171400), secs: 3840, flags: 0
*DHCP Socket Task: Feb 07 13:44:19.491: 0c:c5:57:db:cb:0e DHCP chaddr: 0c:c5:57:db:cb:0e
*DHCP Socket Task: Feb 07 13:44:19.491: 0c:c5:57:db:cb:0e DHCP ciaddr: 0.0.0.0, yiaddr: 0.0.0.0
*DHCP Socket Task: Feb 07 13:44:19.491: 0c:c5:57:db:cb:0e DHCP siaddr: 0.0.0.0, giaddr: 10.161.21.55
*DHCP Socket Task: Feb 07 13:44:19.491: 0c:c5:57:db:cb:0e DHCP sending REQUEST to 10.161.21.1 (len 366, port 1, vlan 625)
*DHCP Socket Task: Feb 07 13:44:19.491: 0c:c5:57:db:cb:0e DHCP selecting relay 2 - control block settings:
dhcpServer: 0.0.0.0, dhcpNetmask: 0.0.0.0,
dhcpGateway: 0.0.0.0, dhcpRelay: 10.161.21.55 VLAN: 625
*DHCP Socket Task: Feb 07 13:44:19.491: 0c:c5:57:db:cb:0e DHCP selected relay 2 - NONE (server address 0.0.0.0,local address 0.0.0.0, gateway 10.161.21.1, VLAN 625, port 1)
*DHCP Socket Task: Feb 07 13:44:26.892: 0c:c5:57:db:cb:0e DHCP received op BOOTREQUEST (1) (len 324,vlan 25, port 1, encap 0xec03)
*DHCP Socket Task: Feb 07 13:44:26.892: 0c:c5:57:db:cb:0e DHCP (encap type 0xec03) mstype 0ff:ff:ff:ff:ff:ff
*DHCP Socket Task: Feb 07 13:44:26.892: 0c:c5:57:db:cb:0e DHCP selecting relay 1 - control block settings:
dhcpServer: 0.0.0.0, dhcpNetmask: 0.0.0.0,
dhcpGateway: 0.0.0.0, dhcpRelay: 10.161.21.55 VLAN: 625
*DHCP Socket Task: Feb 07 13:44:26.892: 0c:c5:57:db:cb:0e DHCP selected relay 1 - 10.215.13.125 (local address 10.161.21.55, gateway 10.161.21.1, VLAN 625, port 1)
*DHCP Socket Task: Feb 07 13:44:26.892: 0c:c5:57:db:cb:0e DHCP selecting relay 2 - control block settings:
dhcpServer: 0.0.0.0, dhcpNetmask: 0.0.0.0,
dhcpGateway: 0.0.0.0, dhcpRelay: 10.161.21.55 VLAN: 625
*DHCP Socket Task: Feb 07 13:44:26.892: 0c:c5:57:db:cb:0e DHCP selected relay 2 - NONE (server address 0.0.0.0,local address 10.161.21.55, gateway 10.161.21.1, VLAN 625, port 1)
*DHCP Socket Task: Feb 07 13:44:26.892: 0c:c5:57:db:cb:0e DHCP selecting relay 1 - control block settings:
dhcpServer: 0.0.0.0, dhcpNetmask: 0.0.0.0,
dhcpGateway: 0.0.0.0, dhcpRelay: 10.161.21.55 VLAN: 625
*DHCP Socket Task: Feb 07 13:44:26.892: 0c:c5:57:db:cb:0e DHCP selected relay 1 - 10.215.13.125 (local address 10.161.21.55, gateway 10.161.21.1, VLAN 625, port 1)
*DHCP Socket Task: Feb 07 13:44:26.892: 0c:c5:57:db:cb:0e DHCP transmitting DHCP DISCOVER (1)
*DHCP Socket Task: Feb 07 13:44:26.892: 0c:c5:57:db:cb:0e DHCP op: BOOTREQUEST, htype: Ethernet, hlen: 6, hops: 1
*DHCP Socket Task: Feb 07 13:44:26.892: 0c:c5:57:db:cb:0e DHCP xid: 0x4137bb08 (1094171400), secs: 5632, flags: 0
*DHCP Socket Task: Feb 07 13:44:26.892: 0c:c5:57:db:cb:0e DHCP chaddr: 0c:c5:57:db:cb:0e
*DHCP Socket Task: Feb 07 13:44:26.892: 0c:c5:57:db:cb:0e DHCP ciaddr: 0.0.0.0, yiaddr: 0.0.0.0
*DHCP Socket Task: Feb 07 13:44:26.892: 0c:c5:57:db:cb:0e DHCP siaddr: 0.0.0.0, giaddr: 10.161.21.55
*DHCP Socket Task: Feb 07 13:44:26.893: 0c:c5:57:db:cb:0e DHCP sending REQUEST to 10.161.21.1 (len 366, port 1, vlan 625)
*DHCP Socket Task: Feb 07 13:44:26.893: 0c:c5:57:db:cb:0e DHCP selecting relay 2 - control block settings:
dhcpServer: 0.0.0.0, dhcpNetmask: 0.0.0.0,
dhcpGateway: 0.0.0.0, dhcpRelay: 10.161.21.55 VLAN: 625
*DHCP Socket Task: Feb 07 13:44:26.893: 0c:c5:57:db:cb:0e DHCP selected relay 2 - NONE (server address 0.0.0.0,local address 0.0.0.0, gateway 10.161.21.1, VLAN 625, port 1)
*apfMsConnTask_5: Feb 07 13:45:09.367: 0c:c5:57:db:cb:0e Processing assoc-req station:0c:c5:57:db:cb:0e AP:d0:c7:89:a0:8b:30-00 thread:5517e18
*apfMsConnTask_5: Feb 07 13:45:09.369: 0c:c5:57:db:cb:0e Association received from mobile on BSSID d0:c7:89:a0:8b:c4 AP Corp-AP02
*apfMsConnTask_5: Feb 07 13:45:09.369: 0c:c5:57:db:cb:0e Global 200 Clients are allowed to AP radio

*apfMsConnTask_5: Feb 07 13:45:09.369: 0c:c5:57:db:cb:0e Max Client Trap Threshold: 0 cur: 2

*apfMsConnTask_5: Feb 07 13:45:09.369: 0c:c5:57:db:cb:0e Rf profile 600 Clients are allowed to AP wlan

*apfMsConnTask_5: Feb 07 13:45:09.369: 0c:c5:57:db:cb:0e override for default ap group, marking intgrp NULL
*apfMsConnTask_5: Feb 07 13:45:09.369: 0c:c5:57:db:cb:0e Applying Interface(Corp.guest) policy on Mobile, role Local. Ms NAC State 2 Quarantine Vlan 0 Access Vlan 625

*apfMsConnTask_5: Feb 07 13:45:09.369: 0c:c5:57:db:cb:0e Re-applying interface policy for client

*apfMsConnTask_5: Feb 07 13:45:09.369: 0c:c5:57:db:cb:0e 0.0.0.0 DHCP_REQD (7) Changing IPv4 ACL 'none' (ACL ID 255) ===> 'none' (ACL ID 255) --- (caller apf_policy.c:2485)
*apfMsConnTask_5: Feb 07 13:45:09.369: 0c:c5:57:db:cb:0e 0.0.0.0 DHCP_REQD (7) Changing IPv6 ACL 'none' (ACL ID 255) ===> 'none' (ACL ID 255) --- (caller apf_policy.c:2506)
*apfMsConnTask_5: Feb 07 13:45:09.369: 0c:c5:57:db:cb:0e Values before applying NASID - interfacetype:3, ovrd:0, mscb nasid:Corp-vWLC, interface nasid:, APgrpset:0
*apfMsConnTask_5: Feb 07 13:45:09.369: 0c:c5:57:db:cb:0e apfApplyWlanPolicy: Apply WLAN Policy over PMIPv6 Client Mobility Type
*apfMsConnTask_5: Feb 07 13:45:09.369: 0c:c5:57:db:cb:0e Check before Setting the NAS Id to WLAN specific Id 'Corp.guest'
*apfMsConnTask_5: Feb 07 13:45:09.369: 0c:c5:57:db:cb:0e Setting the NAS Id to WLAN specific Id 'Corp.guest'
*apfMsConnTask_5: Feb 07 13:45:09.369: 0c:c5:57:db:cb:0e In processSsidIE:5756 setting Central switched to TRUE
*apfMsConnTask_5: Feb 07 13:45:09.369: 0c:c5:57:db:cb:0e In processSsidIE:5759 apVapId = 2 and Split Acl Id = 65535
*apfMsConnTask_5: Feb 07 13:45:09.369: 0c:c5:57:db:cb:0e Applying site-specific Local Bridging override for station 0c:c5:57:db:cb:0e - vapId 625, site 'All_SSID', interface 'Corp.guest'
*apfMsConnTask_5: Feb 07 13:45:09.369: 0c:c5:57:db:cb:0e Applying Local Bridging Interface Policy for station 0c:c5:57:db:cb:0e - vlan 625, interface id 7, interface 'Corp.guest', nasId:'Corp.guest'
*apfMsConnTask_5: Feb 07 13:45:09.369: 0c:c5:57:db:cb:0e override from ap group, removing intf group from mscb
*apfMsConnTask_5: Feb 07 13:45:09.369: 0c:c5:57:db:cb:0e Applying site-specific override for station 0c:c5:57:db:cb:0e - vapId 625, site 'All_SSID', interface 'Corp.guest'
*apfMsConnTask_5: Feb 07 13:45:09.369: 0c:c5:57:db:cb:0e Applying Interface(Corp.guest) policy on Mobile, role Local. Ms NAC State 2 Quarantine Vlan 0 Access Vlan 625

*apfMsConnTask_5: Feb 07 13:45:09.369: 0c:c5:57:db:cb:0e Re-applying interface policy for client

*apfMsConnTask_5: Feb 07 13:45:09.369: 0c:c5:57:db:cb:0e 0.0.0.0 DHCP_REQD (7) Changing IPv4 ACL 'none' (ACL ID 255) ===> 'none' (ACL ID 255) --- (caller apf_policy.c:2485)
*apfMsConnTask_5: Feb 07 13:45:09.369: 0c:c5:57:db:cb:0e 0.0.0.0 DHCP_REQD (7) Changing IPv6 ACL 'none' (ACL ID 255) ===> 'none' (ACL ID 255) --- (caller apf_policy.c:2506)
*apfMsConnTask_5: Feb 07 13:45:09.369: 0c:c5:57:db:cb:0e Values before applying NASID - interfacetype:3, ovrd:0, mscb nasid:Corp.guest, interface nasid:, APgrpset:0
*apfMsConnTask_5: Feb 07 13:45:09.369: 0c:c5:57:db:cb:0e Setting the NAS Id to AP group specific Id 'Corp-vWLC'
*apfMsConnTask_5: Feb 07 13:45:09.369: 0c:c5:57:db:cb:0e processSsidIE statusCode is 0 and status is 0
*apfMsConnTask_5: Feb 07 13:45:09.369: 0c:c5:57:db:cb:0e processSsidIE ssid_done_flag is 0 finish_flag is 0
*apfMsConnTask_5: Feb 07 13:45:09.369: 0c:c5:57:db:cb:0e STA - rates (8): 130 132 139 12 18 150 24 36 48 72 96 108 0 0 0 0
*apfMsConnTask_5: Feb 07 13:45:09.369: 0c:c5:57:db:cb:0e suppRates statusCode is 0 and gotSuppRatesElement is 1
*apfMsConnTask_5: Feb 07 13:45:09.369: 0c:c5:57:db:cb:0e STA - rates (12): 130 132 139 12 18 150 24 36 48 72 96 108 0 0 0 0
*apfMsConnTask_5: Feb 07 13:45:09.369: 0c:c5:57:db:cb:0e extSuppRates statusCode is 0 and gotExtSuppRatesElement is 1
*apfMsConnTask_5: Feb 07 13:45:09.369: RSNIE in Assoc. Req.: (20)

*apfMsConnTask_5: Feb 07 13:45:09.369: [0000] 01 00 00 0f ac 04 01 00 00 0f ac 04 01 00 00 0f

*apfMsConnTask_5: Feb 07 13:45:09.369: [0016] ac 02 00 00

*apfMsConnTask_5: Feb 07 13:45:09.369: 0c:c5:57:db:cb:0e Processing RSN IE type 48, length 20 for mobile 0c:c5:57:db:cb:0e
*apfMsConnTask_5: Feb 07 13:45:09.369: 0c:c5:57:db:cb:0e Received 802.11i PSK key management suite, enabling Authentication
*apfMsConnTask_5: Feb 07 13:45:09.369: 0c:c5:57:db:cb:0e RSN Capabilities: 0
*apfMsConnTask_5: Feb 07 13:45:09.369: 0c:c5:57:db:cb:0e Marking Mobile as non-11w Capable
*apfMsConnTask_5: Feb 07 13:45:09.369: 0c:c5:57:db:cb:0e pemApfDeleteMobileStation2: APF_MS_PEM_WAIT_L2_AUTH_COMPLETE = 0.
*apfMsConnTask_5: Feb 07 13:45:09.369: 0c:c5:57:db:cb:0e 0.0.0.0 DHCP_REQD (7) Deleted mobile LWAPP rule on AP [d0:c7:89:b4:2c:f0]
*apfMsConnTask_5: Feb 07 13:45:09.369: 0c:c5:57:db:cb:0e Updated location for station old AP d0:c7:89:b4:2c:f0-0, new AP d0:c7:89:a0:8b:30-0
*apfMsConnTask_5: Feb 07 13:45:09.369: 0c:c5:57:db:cb:0e apfMsAssoStateDec
*apfMsConnTask_5: Feb 07 13:45:09.369: 0c:c5:57:db:cb:0e apfMsWepPskStateDec
*apfMsConnTask_5: Feb 07 13:45:09.369: 0c:c5:57:db:cb:0e apfProcessAssocReq (apf_80211.c:9472) Changing state for mobile 0c:c5:57:db:cb:0e on AP d0:c7:89:a0:8b:30 from Associated to AAA Pending

*apfMsConnTask_5: Feb 07 13:45:09.369: 0c:c5:57:db:cb:0e Scheduling deletion of Mobile Station: (callerId: 20) in 10 seconds
*apfMsConnTask_5: Feb 07 13:45:09.369: 0c:c5:57:db:cb:0e Updating the Aid in case of flex mac-filtering

*apfMsConnTask_5: Feb 07 13:45:09.369: 0c:c5:57:db:cb:0e Updating AID for REAP AP Client d0:c7:89:a0:8b:30 - AID ===> 2
*pemReceiveTask: Feb 07 13:45:09.369: 0c:c5:57:db:cb:0e 0.0.0.0 Removed NPU entry.
*spamApTask0: Feb 07 13:45:09.370: 0c:c5:57:db:cb:0e Delete Mobile request sent to the AP 10.159.134.168:42552

*apfMsConnTask_6: Feb 07 13:45:09.370: 0c:c5:57:db:cb:0e Client stats update: Time now in sec 1581057909, Last Acct Msg Sent at 0 sec
*apfMsConnTask_6: Feb 07 13:45:09.370: 0c:c5:57:db:cb:0e Requested to send acct interim update request msg to APF task for client c:b5:27:cb:cb:e

*apfReceiveTask: Feb 07 13:45:09.373: 0c:c5:57:db:cb:0e Received SGT for this Client.
*apfReceiveTask: Feb 07 13:45:09.373: 0c:c5:57:db:cb:0e override for default ap group, marking intgrp NULL
*apfReceiveTask: Feb 07 13:45:09.373: 0c:c5:57:db:cb:0e Applying Interface(Corp.guest) policy on Mobile, role Local. Ms NAC State 2 Quarantine Vlan 0 Access Vlan 625

*apfReceiveTask: Feb 07 13:45:09.373: 0c:c5:57:db:cb:0e Re-applying interface policy for client

*apfReceiveTask: Feb 07 13:45:09.373: 0c:c5:57:db:cb:0e 0.0.0.0 DHCP_REQD (7) Changing IPv4 ACL 'none' (ACL ID 255) ===> 'none' (ACL ID 255) --- (caller apf_policy.c:2485)
*apfReceiveTask: Feb 07 13:45:09.373: 0c:c5:57:db:cb:0e 0.0.0.0 DHCP_REQD (7) Changing IPv6 ACL 'none' (ACL ID 255) ===> 'none' (ACL ID 255) --- (caller apf_policy.c:2506)
*apfReceiveTask: Feb 07 13:45:09.373: 0c:c5:57:db:cb:0e Values before applying NASID - interfacetype:3, ovrd:0, mscb nasid:Corp-vWLC, interface nasid:, APgrpset:1
*apfReceiveTask: Feb 07 13:45:09.373: 0c:c5:57:db:cb:0e apfApplyWlanPolicy: Apply WLAN Policy over PMIPv6 Client Mobility Type
*apfReceiveTask: Feb 07 13:45:09.373: 0c:c5:57:db:cb:0e Check before Setting the NAS Id to WLAN specific Id 'Corp.guest'
*apfReceiveTask: Feb 07 13:45:09.373: 0c:c5:57:db:cb:0e Setting the NAS Id to WLAN specific Id 'Corp.guest'
*apfReceiveTask: Feb 07 13:45:09.373: 0c:c5:57:db:cb:0e override from ap group, removing intf group from mscb
*apfReceiveTask: Feb 07 13:45:09.373: 0c:c5:57:db:cb:0e Applying site-specific override for station 0c:c5:57:db:cb:0e - vapId 625, site 'All_SSID', interface 'Corp.guest'
*apfReceiveTask: Feb 07 13:45:09.373: 0c:c5:57:db:cb:0e Applying Interface(Corp.guest) policy on Mobile, role Local. Ms NAC State 2 Quarantine Vlan 0 Access Vlan 625

*apfReceiveTask: Feb 07 13:45:09.373: 0c:c5:57:db:cb:0e Re-applying interface policy for client

*apfReceiveTask: Feb 07 13:45:09.373: 0c:c5:57:db:cb:0e 0.0.0.0 DHCP_REQD (7) Changing IPv4 ACL 'none' (ACL ID 255) ===> 'none' (ACL ID 255) --- (caller apf_policy.c:2485)
*apfReceiveTask: Feb 07 13:45:09.373: 0c:c5:57:db:cb:0e 0.0.0.0 DHCP_REQD (7) Changing IPv6 ACL 'none' (ACL ID 255) ===> 'none' (ACL ID 255) --- (caller apf_policy.c:2506)
*apfReceiveTask: Feb 07 13:45:09.373: 0c:c5:57:db:cb:0e Values before applying NASID - interfacetype:3, ovrd:0, mscb nasid:Corp.guest, interface nasid:, APgrpset:1
*apfReceiveTask: Feb 07 13:45:09.373: 0c:c5:57:db:cb:0e Applying AP group specific NAS Id 'Corp-vWLC'
*apfReceiveTask: Feb 07 13:45:09.373: 0c:c5:57:db:cb:0e Inserting AAA Override struct for mobile
MAC: 0c:c5:57:db:cb:0e, source 2

*apfReceiveTask: Feb 07 13:45:09.373: 0c:c5:57:db:cb:0e apfMs1xStateDec
*apfReceiveTask: Feb 07 13:45:09.373: 0c:c5:57:db:cb:0e 0.0.0.0 DHCP_REQD (7) Change state to START (0) last state DHCP_REQD (7)

*apfReceiveTask: Feb 07 13:45:09.373: 0c:c5:57:db:cb:0e pemApfAddMobileStation2: APF_MS_PEM_WAIT_L2_AUTH_COMPLETE = 0.
*apfReceiveTask: Feb 07 13:45:09.373: 0c:c5:57:db:cb:0e 0.0.0.0 START (0) Initializing policy
*apfReceiveTask: Feb 07 13:45:09.373: 0c:c5:57:db:cb:0e 0.0.0.0 START (0) Change state to AUTHCHECK (2) last state START (0)

*apfReceiveTask: Feb 07 13:45:09.373: 0c:c5:57:db:cb:0e 0.0.0.0 AUTHCHECK (2) Change state to 8021X_REQD (3) last state AUTHCHECK (2)

*apfReceiveTask: Feb 07 13:45:09.373: 0c:c5:57:db:cb:0e Encryption policy is set to 0x80000001
*apfReceiveTask: Feb 07 13:45:09.373: 0c:c5:57:db:cb:0e Not Using WMM Compliance code qosCap 00
*apfReceiveTask: Feb 07 13:45:09.373: 0c:c5:57:db:cb:0e 0.0.0.0 8021X_REQD (3) Plumbed mobile LWAPP rule on AP d0:c7:89:a0:8b:30 vapId 625 apVapId 2 flex-acl-name:
*apfReceiveTask: Feb 07 13:45:09.373: 0c:c5:57:db:cb:0e apfMsAssoStateInc
*apfReceiveTask: Feb 07 13:45:09.373: 0c:c5:57:db:cb:0e apfMsWepPskStateInc
*apfReceiveTask: Feb 07 13:45:09.373: 0c:c5:57:db:cb:0e apfPemAddUser2 (apf_policy.c:381) Changing state for mobile 0c:c5:57:db:cb:0e on AP d0:c7:89:a0:8b:30 from AAA Pending to Associated

*apfReceiveTask: Feb 07 13:45:09.373: 0c:c5:57:db:cb:0e apfPemAddUser2:session timeout forstation 0c:c5:57:db:cb:0e - Session Tout 14400, apfMsTimeOut '14400' and sessionTimerRunning flag is 0
*apfReceiveTask: Feb 07 13:45:09.373: 0c:c5:57:db:cb:0e Scheduling deletion of Mobile Station: (callerId: 49) in 14400 seconds
*apfReceiveTask: Feb 07 13:45:09.373: 0c:c5:57:db:cb:0e Func: apfPemAddUser2, Ms Timeout = 14400, Session Timeout = 14400

*apfReceiveTask: Feb 07 13:45:09.373: 0c:c5:57:db:cb:0e Sending assoc-resp with status 0 station:0c:c5:57:db:cb:0e AP:d0:c7:89:a0:8b:30-00 on apVapId 2
*apfReceiveTask: Feb 07 13:45:09.373: 0c:c5:57:db:cb:0e Sending Assoc Response to station on BSSID d0:c7:89:a0:8b:31 (status 0) ApVapId 2 Slot 0
*apfReceiveTask: Feb 07 13:45:09.373: 0c:c5:57:db:cb:0e apfProcessRadiusAssocResp (apf_80211.c:4008) Changing state for mobile 0c:c5:57:db:cb:0e on AP d0:c7:89:a0:8b:30 from Associated to Associated

*spamApTask6: Feb 07 13:45:09.373: 0c:c5:57:db:cb:0e Successful transmission of LWAPP Add-Mobile to AP d0:c7:89:a0:8b:30
*spamApTask6: Feb 07 13:45:09.375: 0c:c5:57:db:cb:0e Received ADD_MOBILE ack - Initiating 1x to STA 0c:c5:57:db:cb:0e (idx 53)
*spamApTask6: Feb 07 13:45:09.375: 0c:c5:57:db:cb:0e Sent 1x initiate message to multi thread task for mobile 0c:c5:57:db:cb:0e
*Dot1x_NW_MsgTask_6: Feb 07 13:45:09.375: 0c:c5:57:db:cb:0e reauth_sm state transition 1 ---> 0 for mobile 0c:c5:57:db:cb:0e at 1x_reauth_sm.c:53
*Dot1x_NW_MsgTask_6: Feb 07 13:45:09.375: 0c:c5:57:db:cb:0e Creating a PKC PMKID Cache entry for station 0c:c5:57:db:cb:0e (RSN 2)
*Dot1x_NW_MsgTask_6: Feb 07 13:45:09.375: 0c:c5:57:db:cb:0e Resetting MSCB PMK Cache Entry 0 for station 0c:c5:57:db:cb:0e
*Dot1x_NW_MsgTask_6: Feb 07 13:45:09.375: 0c:c5:57:db:cb:0e Removing BSSID d0:c7:89:b4:2c:f1 from PMKID cache of station 0c:c5:57:db:cb:0e
*Dot1x_NW_MsgTask_6: Feb 07 13:45:09.375: 0c:c5:57:db:cb:0e Setting active key cache index 0 ---> 8
*Dot1x_NW_MsgTask_6: Feb 07 13:45:09.375: 0c:c5:57:db:cb:0e Setting active key cache index 8 ---> 0
*Dot1x_NW_MsgTask_6: Feb 07 13:45:09.375: 0c:c5:57:db:cb:0e Adding BSSID d0:c7:89:a0:8b:31 to PMKID cache at index 0 for station 0c:c5:57:db:cb:0e
*Dot1x_NW_MsgTask_6: Feb 07 13:45:09.375: New PMKID: (16)

*Dot1x_NW_MsgTask_6: Feb 07 13:45:09.375: [0000] 6f f1 05 a8 08 9f 8e 8f ae bc ab 6e ff 5c 79 c0

*Dot1x_NW_MsgTask_6: Feb 07 13:45:09.375: 0c:c5:57:db:cb:0e Initiating RSN PSK to mobile 0c:c5:57:db:cb:0e
*Dot1x_NW_MsgTask_6: Feb 07 13:45:09.375: 0c:c5:57:db:cb:0e EAP-PARAM Debug - eap-params for Wlan-Id :625 is disabled - applying Global eap timers and retries
*Dot1x_NW_MsgTask_6: Feb 07 13:45:09.375: 0c:c5:57:db:cb:0e Disable re-auth, use PMK lifetime.
*Dot1x_NW_MsgTask_6: Feb 07 13:45:09.375: 0c:c5:57:db:cb:0e dot1x - moving mobile 0c:c5:57:db:cb:0e into Force Auth state
*Dot1x_NW_MsgTask_6: Feb 07 13:45:09.375: 0c:c5:57:db:cb:0e Skipping EAP-Success to mobile 0c:c5:57:db:cb:0e
*Dot1x_NW_MsgTask_6: Feb 07 13:45:09.375: 0c:c5:57:db:cb:0e Found an cache entry for BSSID d0:c7:89:a0:8b:31 in PMKID cache at index 0 of station 0c:c5:57:db:cb:0e
*Dot1x_NW_MsgTask_6: Feb 07 13:45:09.375: 0c:c5:57:db:cb:0e Found an cache entry for BSSID d0:c7:89:a0:8b:31 in PMKID cache at index 0 of station 0c:c5:57:db:cb:0e
*Dot1x_NW_MsgTask_6: Feb 07 13:45:09.375: Including PMKID in M1 (16)

*Dot1x_NW_MsgTask_6: Feb 07 13:45:09.375: [0000] 6f f1 05 a8 08 9f 8e 8f ae bc ab 6e ff 5c 79 c0

*Dot1x_NW_MsgTask_6: Feb 07 13:45:09.375: 0c:c5:57:db:cb:0e Starting key exchange to mobile 0c:c5:57:db:cb:0e, data packets will be dropped
*Dot1x_NW_MsgTask_6: Feb 07 13:45:09.375: 0c:c5:57:db:cb:0e Sending EAPOL-Key Message to mobile 0c:c5:57:db:cb:0e
state INITPMK (message 1), replay counter 00.00.00.00.00.00.00.00
*Dot1x_NW_MsgTask_6: Feb 07 13:45:09.375: 0c:c5:57:db:cb:0e Allocating EAP Pkt for retransmission to mobile 0c:c5:57:db:cb:0e
*Dot1x_NW_MsgTask_6: Feb 07 13:45:09.387: 0c:c5:57:db:cb:0e Received EAPOL-Key from mobile 0c:c5:57:db:cb:0e
*Dot1x_NW_MsgTask_6: Feb 07 13:45:09.387: 0c:c5:57:db:cb:0e Ignoring invalid EAPOL version (1) in EAPOL-key message from mobile 0c:c5:57:db:cb:0e
*Dot1x_NW_MsgTask_6: Feb 07 13:45:09.387: 0c:c5:57:db:cb:0e Received EAPOL-key in PTK_START state (message 2) from mobile 0c:c5:57:db:cb:0e
*Dot1x_NW_MsgTask_6: Feb 07 13:45:09.387: 0c:c5:57:db:cb:0e Dumping RSNIE received in Association request:
*Dot1x_NW_MsgTask_6: Feb 07 13:45:09.387: 00000000: 30 14 01 00 00 0f ac 04 01 00 00 0f ac 04 01 00 0...............
*Dot1x_NW_MsgTask_6: Feb 07 13:45:09.387: 00000010: 00 0f ac 02 00 00 ......
*Dot1x_NW_MsgTask_6: Feb 07 13:45:09.387: 0c:c5:57:db:cb:0e Dumping RSNIE received in EAPOL M2 :
*Dot1x_NW_MsgTask_6: Feb 07 13:45:09.387: 00000000: 01 00 00 0f ac 04 01 00 00 0f ac 04 01 00 00 0f ................
*Dot1x_NW_MsgTask_6: Feb 07 13:45:09.387: 00000010: ac 02 00 00 ....
*Dot1x_NW_MsgTask_6: Feb 07 13:45:09.387: 0c:c5:57:db:cb:0e Stopping retransmission timer for mobile 0c:c5:57:db:cb:0e
*Dot1x_NW_MsgTask_6: Feb 07 13:45:09.387: 0c:c5:57:db:cb:0e Sending EAPOL-Key Message to mobile 0c:c5:57:db:cb:0e
state PTKINITNEGOTIATING (message 3), replay counter 00.00.00.00.00.00.00.01
*Dot1x_NW_MsgTask_6: Feb 07 13:45:09.387: 0c:c5:57:db:cb:0e Reusing allocated memory for EAP Pkt for retransmission to mobile 0c:c5:57:db:cb:0e
*Dot1x_NW_MsgTask_6: Feb 07 13:45:09.400: 0c:c5:57:db:cb:0e Received EAPOL-Key from mobile 0c:c5:57:db:cb:0e
*Dot1x_NW_MsgTask_6: Feb 07 13:45:09.400: 0c:c5:57:db:cb:0e Ignoring invalid EAPOL version (1) in EAPOL-key message from mobile 0c:c5:57:db:cb:0e
*Dot1x_NW_MsgTask_6: Feb 07 13:45:09.400: 0c:c5:57:db:cb:0e Received EAPOL-key in PTKINITNEGOTIATING state (message 4) from mobile 0c:c5:57:db:cb:0e
*Dot1x_NW_MsgTask_6: Feb 07 13:45:09.401: 0c:c5:57:db:cb:0e Stopping retransmission timer for mobile 0c:c5:57:db:cb:0e
*Dot1x_NW_MsgTask_6: Feb 07 13:45:09.401: 0c:c5:57:db:cb:0e Freeing EAP Retransmit Bufer for mobile 0c:c5:57:db:cb:0e
*Dot1x_NW_MsgTask_6: Feb 07 13:45:09.401: 0c:c5:57:db:cb:0e apfMs1xStateInc
*Dot1x_NW_MsgTask_6: Feb 07 13:45:09.401: 0c:c5:57:db:cb:0e 0.0.0.0 8021X_REQD (3) Change state to L2AUTHCOMPLETE (4) last state 8021X_REQD (3)

*Dot1x_NW_MsgTask_6: Feb 07 13:45:09.401: 0c:c5:57:db:cb:0e Not Using WMM Compliance code qosCap 00
*Dot1x_NW_MsgTask_6: Feb 07 13:45:09.401: 0c:c5:57:db:cb:0e 0.0.0.0 L2AUTHCOMPLETE (4) Plumbed mobile LWAPP rule on AP d0:c7:89:a0:8b:30 vapId 625 apVapId 2 flex-acl-name:
*Dot1x_NW_MsgTask_6: Feb 07 13:45:09.401: 0c:c5:57:db:cb:0e 0.0.0.0 L2AUTHCOMPLETE (4) pemAdvanceState2 6554, Adding TMP rule
*Dot1x_NW_MsgTask_6: Feb 07 13:45:09.401: 0c:c5:57:db:cb:0e 0.0.0.0 L2AUTHCOMPLETE (4) Adding Fast Path rule
type = Airespace AP - Learn IP address
on AP d0:c7:89:a0:8b:30, slot 0, interface = 1, QOS = 0
IPv4 ACL ID = 255
*Dot1x_NW_MsgTask_6: Feb 07 13:45:09.401: 0c:c5:57:db:cb:0e 0.0.0.0 L2AUTHCOMPLETE (4) Fast Path rule (contd...) 802.1P = 0, DSCP = 0, TokenID = 64206, IntfId = 7 Local Bridging Vlan = 625, Local Bridging intf id = 7
*Dot1x_NW_MsgTask_6: Feb 07 13:45:09.401: 0c:c5:57:db:cb:0e 0.0.0.0 L2AUTHCOMPLETE (4) Fast Path rule (contd...) AVC Ratelimit: AppID = 0 ,AppAction = 0, AppToken = 64206 AverageRate = 0, BurstRate = 0

*Dot1x_NW_MsgTask_6: Feb 07 13:45:09.401: 0c:c5:57:db:cb:0e 0.0.0.0 L2AUTHCOMPLETE (4) Fast Path rule (contd...) AVC Ratelimit: AppID = 0 ,AppAction = 0, AppToken = 64206 AverageRate = 0, BurstRate = 0

*Dot1x_NW_MsgTask_6: Feb 07 13:45:09.401: 0c:c5:57:db:cb:0e 0.0.0.0 L2AUTHCOMPLETE (4) Successfully plumbed mobile rule (IPv4 ACL ID 255, IPv6 ACL ID 255, L2 ACL ID 255)
*Dot1x_NW_MsgTask_6: Feb 07 13:45:09.401: 0c:c5:57:db:cb:0e 0.0.0.0 L2AUTHCOMPLETE (4) Change state to DHCP_REQD (7) last state L2AUTHCOMPLETE (4)

*Dot1x_NW_MsgTask_6: Feb 07 13:45:09.401: 0c:c5:57:db:cb:0e 0.0.0.0 DHCP_REQD (7) pemAdvanceState2 6583, Adding TMP rule
*Dot1x_NW_MsgTask_6: Feb 07 13:45:09.401: 0c:c5:57:db:cb:0e 0.0.0.0 DHCP_REQD (7) Replacing Fast Path rule
type = Airespace AP - Learn IP address
on AP d0:c7:89:a0:8b:30, slot 0, interface = 1, QOS = 0
IPv4 ACL ID = 255,
*Dot1x_NW_MsgTask_6: Feb 07 13:45:09.401: 0c:c5:57:db:cb:0e 0.0.0.0 DHCP_REQD (7) Fast Path rule (contd...) 802.1P = 0, DSCP = 0, TokenID = 64206, IntfId = 7 Local Bridging Vlan = 625, Local Bridging intf id = 7
*Dot1x_NW_MsgTask_6: Feb 07 13:45:09.401: 0c:c5:57:db:cb:0e 0.0.0.0 DHCP_REQD (7) Fast Path rule (contd...) AVC Ratelimit: AppID = 0 ,AppAction = 0, AppToken = 64206 AverageRate = 0, BurstRate = 0

*Dot1x_NW_MsgTask_6: Feb 07 13:45:09.401: 0c:c5:57:db:cb:0e 0.0.0.0 DHCP_REQD (7) Fast Path rule (contd...) AVC Ratelimit: AppID = 0 ,AppAction = 0, AppToken = 64206 AverageRate = 0, BurstRate = 0

*Dot1x_NW_MsgTask_6: Feb 07 13:45:09.401: 0c:c5:57:db:cb:0e 0.0.0.0 DHCP_REQD (7) Successfully plumbed mobile rule (IPv4 ACL ID 255, IPv6 ACL ID 255, L2 ACL ID 255)
*spamApTask6: Feb 07 13:45:09.401: 0c:c5:57:db:cb:0e Successful transmission of LWAPP Add-Mobile to AP d0:c7:89:a0:8b:30
*pemReceiveTask: Feb 07 13:45:09.401: 0c:c5:57:db:cb:0e 0.0.0.0 Added NPU entry of type 9, dtlFlags 0x0
*pemReceiveTask: Feb 07 13:45:09.401: 0c:c5:57:db:cb:0e 0.0.0.0 Added NPU entry of type 9, dtlFlags 0x0
*DHCP Socket Task: Feb 07 13:45:09.494: 0c:c5:57:db:cb:0e DHCP received op BOOTREQUEST (1) (len 330,vlan 25, port 1, encap 0xec03)
*DHCP Socket Task: Feb 07 13:45:09.494: 0c:c5:57:db:cb:0e DHCP (encap type 0xec03) mstype 0ff:ff:ff:ff:ff:ff
*DHCP Socket Task: Feb 07 13:45:09.494: 0c:c5:57:db:cb:0e DHCP selecting relay 1 - control block settings:
dhcpServer: 0.0.0.0, dhcpNetmask: 0.0.0.0,
dhcpGateway: 0.0.0.0, dhcpRelay: 10.161.21.55 VLAN: 625
*DHCP Socket Task: Feb 07 13:45:09.494: 0c:c5:57:db:cb:0e DHCP selected relay 1 - 10.215.13.125 (local address 10.161.21.55, gateway 10.161.21.1, VLAN 625, port 1)
*DHCP Socket Task: Feb 07 13:45:09.494: 0c:c5:57:db:cb:0e DHCP transmitting DHCP REQUEST (3)
*DHCP Socket Task: Feb 07 13:45:09.494: 0c:c5:57:db:cb:0e DHCP op: BOOTREQUEST, htype: Ethernet, hlen: 6, hops: 1
*DHCP Socket Task: Feb 07 13:45:09.494: 0c:c5:57:db:cb:0e DHCP xid: 0xbd9cf1ed (3181179373), secs: 0, flags: 0
*DHCP Socket Task: Feb 07 13:45:09.494: 0c:c5:57:db:cb:0e DHCP chaddr: 0c:c5:57:db:cb:0e
*DHCP Socket Task: Feb 07 13:45:09.494: 0c:c5:57:db:cb:0e DHCP ciaddr: 0.0.0.0, yiaddr: 0.0.0.0
*DHCP Socket Task: Feb 07 13:45:09.494: 0c:c5:57:db:cb:0e DHCP siaddr: 0.0.0.0, giaddr: 10.161.21.55
*DHCP Socket Task: Feb 07 13:45:09.494: 0c:c5:57:db:cb:0e DHCP requested ip: 10.155.72.49
*DHCP Socket Task: Feb 07 13:45:09.494: 0c:c5:57:db:cb:0e DHCP sending REQUEST to 10.161.21.1 (len 374, port 1, vlan 625)
*DHCP Socket Task: Feb 07 13:45:09.494: 0c:c5:57:db:cb:0e DHCP selecting relay 2 - control block settings:
dhcpServer: 0.0.0.0, dhcpNetmask: 0.0.0.0,
dhcpGateway: 0.0.0.0, dhcpRelay: 10.161.21.55 VLAN: 625
*DHCP Socket Task: Feb 07 13:45:09.494: 0c:c5:57:db:cb:0e DHCP selected relay 2 - NONE (server address 0.0.0.0,local address 0.0.0.0, gateway 10.161.21.1, VLAN 625, port 1)
*DHCP Socket Task: Feb 07 13:45:09.498: 0c:c5:57:db:cb:0e DHCP received op BOOTREQUEST (1) (len 330,vlan 25, port 1, encap 0xec03)
*DHCP Socket Task: Feb 07 13:45:09.498: 0c:c5:57:db:cb:0e DHCP (encap type 0xec03) mstype 0ff:ff:ff:ff:ff:ff
*DHCP Socket Task: Feb 07 13:45:09.498: 0c:c5:57:db:cb:0e DHCP selecting relay 1 - control block settings:
dhcpServer: 0.0.0.0, dhcpNetmask: 0.0.0.0,
dhcpGateway: 0.0.0.0, dhcpRelay: 10.161.21.55 VLAN: 625
*DHCP Socket Task: Feb 07 13:45:09.498: 0c:c5:57:db:cb:0e DHCP selected relay 1 - 10.215.13.125 (local address 10.161.21.55, gateway 10.161.21.1, VLAN 625, port 1)
*DHCP Socket Task: Feb 07 13:45:09.498: 0c:c5:57:db:cb:0e DHCP transmitting DHCP REQUEST (3)
*DHCP Socket Task: Feb 07 13:45:09.498: 0c:c5:57:db:cb:0e DHCP op: BOOTREQUEST, htype: Ethernet, hlen: 6, hops: 1
*DHCP Socket Task: Feb 07 13:45:09.498: 0c:c5:57:db:cb:0e DHCP xid: 0xbd9cf1ed (3181179373), secs: 0, flags: 0
*DHCP Socket Task: Feb 07 13:45:09.498: 0c:c5:57:db:cb:0e DHCP chaddr: 0c:c5:57:db:cb:0e
*DHCP Socket Task: Feb 07 13:45:09.498: 0c:c5:57:db:cb:0e DHCP ciaddr: 0.0.0.0, yiaddr: 0.0.0.0
*DHCP Socket Task: Feb 07 13:45:09.498: 0c:c5:57:db:cb:0e DHCP siaddr: 0.0.0.0, giaddr: 10.161.21.55
*DHCP Socket Task: Feb 07 13:45:09.498: 0c:c5:57:db:cb:0e DHCP requested ip: 10.155.72.49
*DHCP Socket Task: Feb 07 13:45:09.498: 0c:c5:57:db:cb:0e DHCP sending REQUEST to 10.161.21.1 (len 374, port 1, vlan 625)
*DHCP Socket Task: Feb 07 13:45:09.498: 0c:c5:57:db:cb:0e DHCP selecting relay 2 - control block settings:
dhcpServer: 0.0.0.0, dhcpNetmask: 0.0.0.0,
dhcpGateway: 0.0.0.0, dhcpRelay: 10.161.21.55 VLAN: 625
*DHCP Socket Task: Feb 07 13:45:09.498: 0c:c5:57:db:cb:0e DHCP selected relay 2 - NONE (server address 0.0.0.0,local address 0.0.0.0, gateway 10.161.21.1, VLAN 625, port 1)