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

Problem when trying to connect from an iphone, ipad, samsung.

Hi eveybody.

I'm having a problem when i try to connect to a WLAN with any gadget. There's no problem when i try to connect from my laptop. Problem only exists when i try to use any of the devices mentioned.

This is a guest WLAN, which it has been hidden, now i enbaled the broadcast SSID. i already tried to create another one, but still having the same problem when i try to connect from the gadgets.

I thought that maybe it was a problem with the encryption (WPA2-PSK), but gadgets can connect to another WLAN in the same WLC 5508

without a problem.

I already changed the encryption type, even i let it opened, but nothing worked for me.

I don't know if i'm missing something, i really hope you can help me.

Thanks in advance!

Regards.

14 Replies 14

Scott Fella
Hall of Fame
Hall of Fame

Post your show wlan

Thanks,


Scott

*****Help out other by using the rating system and marking answered questions as "Answered"*****

-Scott
*** Please rate helpful posts ***

Hi Scott!

Mmhh, idk if i'm doing something wrong. this is the output i get of show wlan

(Cisco Controller) >show wlan

HELP:

Special keys:

  DEL, BS .... delete previous character

  Ctrl-A  .... go to beginning of line

  Ctrl-E  .... go to end of line

  Ctrl-F  .... go forward one character

  Ctrl-B  .... go backward one character

  Ctrl-D  .... delete current character

  Ctrl-U, X .. delete to beginning of line

  Ctrl-K  .... delete to end of line

  Ctrl-W  .... delete previous word

  Ctrl-T  .... transpose previous character

  Ctrl-P  .... go to previous line in history buffer

  Ctrl-N  .... go to next line in history buffer

  Ctrl-Z  .... return to root command prompt

  Tab, command-line completion

  Exit    .... go to next lower command prompt

  ?       .... list choices

Enrique,

Also, get us the client debug from the WLC, when the device is not able to join ..

1) Enable "debug client

2) Try to associate the client..

Get the complete debug output..

Regards
Victor V

*****Help out other by using the rating system and marking answered questions as *****Answered"*****

Regards Victor V *****Help out other by using the rating system and marking answered questions as *****Answered"*****

(Cisco Controller) >debug client DC:9B:9C:3E:06:6F

(Cisco Controller) >*DHCP Socket Task: Feb 12 13:25:19.428: a8:bb:cf:18:28:50 DHCP dropping looped REQUEST from DS

(encap type 0xec00)

*apfMsConnTask_5: Feb 12 13:27:05.533: dc:9b:9c:3e:06:6f Association received from mobile on AP f4:7f:35:05:e6:10

*apfMsConnTask_5: Feb 12 13:27:05.533: dc:9b:9c:3e:06:6f Deleting client immediately since WLAN has changed

*apfMsConnTask_5: Feb 12 13:27:05.533: dc:9b:9c:3e:06:6f Scheduling deletion of Mobile Station:  (callerId: 50) in 1

seconds

*apfMsConnTask_5: Feb 12 13:27:05.845: dc:9b:9c:3e:06:6f Ignoring 802.11 assoc request from mobile pending deletion

*apfMsConnTask_5: Feb 12 13:27:05.845: dc:9b:9c:3e:06:6f Sending Assoc Response to station on BSSID f4:7f:35:05:e6:10

(status 12) ApVapId 2 Slot 1

*apfMsConnTask_6: Feb 12 13:27:05.894: dc:9b:9c:3e:06:6f Ignoring 802.11 assoc request from mobile pending deletion

*apfMsConnTask_6: Feb 12 13:27:05.894: dc:9b:9c:3e:06:6f Sending Assoc Response to station on BSSID f4:7f:35:05:e5:b0

(status 12) ApVapId 2 Slot 0

*apfMsConnTask_6: Feb 12 13:27:05.956: dc:9b:9c:3e:06:6f Ignoring 802.11 assoc request from mobile pending deletion

*apfMsConnTask_6: Feb 12 13:27:05.956: dc:9b:9c:3e:06:6f Sending Assoc Response to station on BSSID f4:7f:35:05:e5:b0

(status 12) ApVapId 2 Slot 1

*apfMsConnTask_5: Feb 12 13:27:06.411: dc:9b:9c:3e:06:6f Ignoring 802.11 assoc request from mobile pending deletion

*apfMsConnTask_5: Feb 12 13:27:06.411: dc:9b:9c:3e:06:6f Sending Assoc Response to station on BSSID f4:7f:35:05:e6:10

(status 12) ApVapId 4 Slot 1

*apfMsConnTask_5: Feb 12 13:27:06.437: dc:9b:9c:3e:06:6f Ignoring 802.11 assoc request from mobile pending deletion

*apfMsConnTask_5: Feb 12 13:27:06.437: dc:9b:9c:3e:06:6f Sending Assoc Response to station on BSSID f4:7f:35:05:e6:10

(status 12) ApVapId 4 Slot 0

*apfMsConnTask_6: Feb 12 13:27:06.471: dc:9b:9c:3e:06:6f Ignoring 802.11 assoc request from mobile pending deletion

*apfMsConnTask_6: Feb 12 13:27:06.471: dc:9b:9c:3e:06:6f Sending Assoc Response to station on BSSID f4:7f:35:05:e5:b0

(status 12) ApVapId 4 Slot 0

*osapiBsnTimer: Feb 12 13:27:06.527: dc:9b:9c:3e:06:6f apfMsExpireCallback (apf_ms.c:589) Expiring Mobile!

*apfReceiveTask: Feb 12 13:27:06.528: dc:9b:9c:3e:06:6f apfMsExpireMobileStation (apf_ms.c:5584) Changing state for

mobile dc:9b:9c:3e:06:6f on AP f4:7f:35:05:e6:10 from Associated to Disassociated

*apfReceiveTask: Feb 12 13:27:06.529: dc:9b:9c:3e:06:6f Sent Deauthenticate to mobile on BSSID f4:7f:35:05:e6:10 slot

1(caller apf_ms.c:5678)

*apfReceiveTask: Feb 12 13:27:06.529: dc:9b:9c:3e:06:6f apfMsAssoStateDec

*apfReceiveTask: Feb 12 13:27:06.529: dc:9b:9c:3e:06:6f apfMsExpireMobileStation (apf_ms.c:5716) Changing state for

mobile dc:9b:9c:3e:06:6f on AP f4:7f:35:05:e6:10 from Disassociated to Idle

*apfReceiveTask: Feb 12 13:27:06.529: dc:9b:9c:3e:06:6f pemApfDeleteMobileStation2: APF_MS_PEM_WAIT_L2_AUTH_COMPLETE =

0.

*apfReceiveTask: Feb 12 13:27:06.529: dc:9b:9c:3e:06:6f 172.16.9.163 RUN (20) Deleted mobile LWAPP rule on AP

[f4:7f:35:05:e6:10]

*apfReceiveTask: Feb 12 13:27:06.529: dc:9b:9c:3e:06:6f apfMsRunStateDec

*apfReceiveTask: Feb 12 13:27:06.529: dc:9b:9c:3e:06:6f apfMs1xStateDec

*apfReceiveTask: Feb 12 13:27:06.529: dc:9b:9c:3e:06:6f Deleting mobile on AP f4:7f:35:05:e6:10(1)

*pemReceiveTask: Feb 12 13:27:06.531: dc:9b:9c:3e:06:6f 172.16.9.163 Removed NPU entry.

*apfMsConnTask_6: Feb 12 13:27:07.026: dc:9b:9c:3e:06:6f Adding mobile on LWAPP AP f4:7f:35:05:e5:b0(0)

*apfMsConnTask_6: Feb 12 13:27:07.026: dc:9b:9c:3e:06:6f Association received from mobile on AP f4:7f:35:05:e5:b0

*apfMsConnTask_6: Feb 12 13:27:07.026: dc:9b:9c:3e:06:6f 0.0.0.0 START (0) Changing IPv4 ACL 'none' (ACL ID 255) ===>

'none' (ACL ID 255) --- (caller apf_policy.c:1697)

*apfMsConnTask_6: Feb 12 13:27:07.026: dc:9b:9c:3e:06:6f 0.0.0.0 START (0) Changing IPv6 ACL 'none' (ACL ID 255) ===>

'none' (ACL ID 255) --- (caller apf_policy.c:1864)

*apfMsConnTask_6: Feb 12 13:27:07.026: dc:9b:9c:3e:06:6f Applying site-specific Local Bridging override for station

dc:9b:9c:3e:06:6f - vapId 4, site 'default-group', interface 'treswts'

*apfMsConnTask_6: Feb 12 13:27:07.026: dc:9b:9c:3e:06:6f Applying Local Bridging Interface Policy for station

dc:9b:9c:3e:06:6f - vlan 9, interface id 14, interface 'treswts'

*apfMsConnTask_6: Feb 12 13:27:07.026: dc:9b:9c:3e:06:6f processSsidIE  statusCode is 0 and status is 0

*apfMsConnTask_6: Feb 12 13:27:07.026: dc:9b:9c:3e:06:6f processSsidIE  ssid_done_flag is 0 finish_flag is 0

*apfMsConnTask_6: Feb 12 13:27:07.026: dc:9b:9c:3e:06:6f STA - rates (8): 130 132 139 150 36 48 72 108 0 0 0 0 0 0 0 0

*apfMsConnTask_6: Feb 12 13:27:07.026: dc:9b:9c:3e:06:6f suppRates  statusCode is 0 and gotSuppRatesElement is 1

*apfMsConnTask_6: Feb 12 13:27:07.026: dc:9b:9c:3e:06:6f STA - rates (12): 130 132 139 150 36 48 72 108 12 18 24 96 0

0 0 0

*apfMsConnTask_6: Feb 12 13:27:07.026: dc:9b:9c:3e:06:6f extSuppRates  statusCode is 0 and gotExtSuppRatesElement is 1

*apfMsConnTask_6: Feb 12 13:27:07.026: dc:9b:9c:3e:06:6f Processing RSN IE type 48, length 20 for mobile

dc:9b:9c:3e:06:6f

*apfMsConnTask_6: Feb 12 13:27:07.026: dc:9b:9c:3e:06:6f 0.0.0.0 START (0) Initializing policy

*apfMsConnTask_6: Feb 12 13:27:07.026: dc:9b:9c:3e:06:6f 0.0.0.0 START (0) Change state to AUTHCHECK (2) last state

AUTHCHECK (2)

*apfMsConnTask_6: Feb 12 13:27:07.026: dc:9b:9c:3e:06:6f 0.0.0.0 AUTHCHECK (2) Change state to 8021X_REQD (3) last

state 8021X_REQD (3)

*apfMsConnTask_6: Feb 12 13:27:07.026: dc:9b:9c:3e:06:6f 0.0.0.0 8021X_REQD (3) DHCP Not required on AP

f4:7f:35:05:e5:b0 vapId 4 apVapId 4for this client

*apfMsConnTask_6: Feb 12 13:27:07.026: dc:9b:9c:3e:06:6f Not Using WMM Compliance code qosCap 00

*apfMsConnTask_6: Feb 12 13:27:07.026: dc:9b:9c:3e:06:6f 0.0.0.0 8021X_REQD (3) Plumbed mobile LWAPP rule on AP

f4:7f:35:05:e5:b0 vapId 4 apVapId 4

*apfMsConnTask_6: Feb 12 13:27:07.026: dc:9b:9c:3e:06:6f apfMsAssoStateInc

*apfMsConnTask_6: Feb 12 13:27:07.026: dc:9b:9c:3e:06:6f apfPemAddUser2 (apf_policy.c:268) Changing state for mobile

dc:9b:9c:3e:06:6f on AP f4:7f:35:05:e5:b0 from Idle to Associated

*apfMsConnTask_6: Feb 12 13:27:07.026: dc:9b:9c:3e:06:6f Scheduling deletion of Mobile Station:  (callerId: 49) in

1800 seconds

*apfMsConnTask_6: Feb 12 13:27:07.027: dc:9b:9c:3e:06:6f Sending Assoc Response to station on BSSID f4:7f:35:05:e5:b0

(status 0) ApVapId 4 Slot 0

*apfMsConnTask_6: Feb 12 13:27:07.027: dc:9b:9c:3e:06:6f apfProcessAssocReq (apf_80211.c:6290) Changing state for

mobile dc:9b:9c:3e:06:6f on AP f4:7f:35:05:e5:b0 from Associated to Associated

*dot1xMsgTask: Feb 12 13:27:07.031: dc:9b:9c:3e:06:6f Creating a PKC PMKID Cache entry for station dc:9b:9c:3e:06:6f

(RSN 2)

*dot1xMsgTask: Feb 12 13:27:07.031: dc:9b:9c:3e:06:6f Resetting MSCB PMK Cache Entry 0 for station dc:9b:9c:3e:06:6f

*dot1xMsgTask: Feb 12 13:27:07.031: dc:9b:9c:3e:06:6f Setting active key cache index 8 ---> 8

*dot1xMsgTask: Feb 12 13:27:07.031: dc:9b:9c:3e:06:6f Setting active key cache index 8 ---> 0

*dot1xMsgTask: Feb 12 13:27:07.031: dc:9b:9c:3e:06:6f Adding BSSID f4:7f:35:05:e5:b3 to PMKID cache at index 0 for

station dc:9b:9c:3e:06:6f

*dot1xMsgTask: Feb 12 13:27:07.031: New PMKID: (16)

*dot1xMsgTask: Feb 12 13:27:07.031:      [0000] 44 07 fe 3d d3 87 da 29 b8 e0 8a 43 d2 b5 0b f4

*dot1xMsgTask: Feb 12 13:27:07.031: dc:9b:9c:3e:06:6f Initiating RSN PSK to mobile dc:9b:9c:3e:06:6f

*dot1xMsgTask: Feb 12 13:27:07.031: dc:9b:9c:3e:06:6f dot1x - moving mobile dc:9b:9c:3e:06:6f into Force Auth state

*dot1xMsgTask: Feb 12 13:27:07.031: dc:9b:9c:3e:06:6f Skipping EAP-Success to mobile dc:9b:9c:3e:06:6f

*dot1xMsgTask: Feb 12 13:27:07.031: dc:9b:9c:3e:06:6f Found an cache entry for BSSID f4:7f:35:05:e5:b3 in PMKID cache

at index 0 of station dc:9b:9c:3e:06:6f

*dot1xMsgTask: Feb 12 13:27:07.031: dc:9b:9c:3e:06:6f Found an cache entry for BSSID f4:7f:35:05:e5:b3 in PMKID cache

at index 0 of station dc:9b:9c:3e:06:6f

*dot1xMsgTask: Feb 12 13:27:07.031: Including PMKID in M1  (16)

*dot1xMsgTask: Feb 12 13:27:07.031:      [0000] 44 07 fe 3d d3 87 da 29 b8 e0 8a 43 d2 b5 0b f4

*dot1xMsgTask: Feb 12 13:27:07.031: dc:9b:9c:3e:06:6f Starting key exchange to mobile dc:9b:9c:3e:06:6f, data packets

will be dropped

*dot1xMsgTask: Feb 12 13:27:07.031: dc:9b:9c:3e:06:6f Sending EAPOL-Key Message to mobile dc:9b:9c:3e:06:6f

                                                                                                              state

INITPMK (message 1), replay counter 00.00.00.00.00.00.00.00

*Dot1x_NW_MsgTask_7: Feb 12 13:27:07.037: dc:9b:9c:3e:06:6f Received EAPOL-Key from mobile dc:9b:9c:3e:06:6f

*Dot1x_NW_MsgTask_7: Feb 12 13:27:07.037: dc:9b:9c:3e:06:6f Received EAPOL-key in PTK_START state (message 2) from

mobile dc:9b:9c:3e:06:6f

*Dot1x_NW_MsgTask_7: Feb 12 13:27:07.037: dc:9b:9c:3e:06:6f Stopping retransmission timer for mobile dc:9b:9c:3e:06:6f

*Dot1x_NW_MsgTask_7: Feb 12 13:27:07.037: dc:9b:9c:3e:06:6f Sending EAPOL-Key Message to mobile dc:9b:9c:3e:06:6f

state PTKINITNEGOTIATING (message 3), replay counter 00.00.00.00.00.00.00.01

*Dot1x_NW_MsgTask_7: Feb 12 13:27:07.045: dc:9b:9c:3e:06:6f Received EAPOL-Key from mobile dc:9b:9c:3e:06:6f

*Dot1x_NW_MsgTask_7: Feb 12 13:27:07.045: dc:9b:9c:3e:06:6f Received EAPOL-key in PTKINITNEGOTIATING state (message 4)

from mobile dc:9b:9c:3e:06:6f

*Dot1x_NW_MsgTask_7: Feb 12 13:27:07.045: dc:9b:9c:3e:06:6f apfMs1xStateInc

*Dot1x_NW_MsgTask_7: Feb 12 13:27:07.045: dc:9b:9c:3e:06:6f 0.0.0.0 8021X_REQD (3) Change state to L2AUTHCOMPLETE (4)

last state L2AUTHCOMPLETE (4)

*Dot1x_NW_MsgTask_7: Feb 12 13:27:07.045: dc:9b:9c:3e:06:6f 0.0.0.0 L2AUTHCOMPLETE (4) DHCP Not required on AP

f4:7f:35:05:e5:b0 vapId 4 apVapId 4for this client

*Dot1x_NW_MsgTask_7: Feb 12 13:27:07.045: dc:9b:9c:3e:06:6f Not Using WMM Compliance code qosCap 00

*Dot1x_NW_MsgTask_7: Feb 12 13:27:07.045: dc:9b:9c:3e:06:6f 0.0.0.0 L2AUTHCOMPLETE (4) Plumbed mobile LWAPP rule on AP

f4:7f:35:05:e5:b0 vapId 4 apVapId 4

*Dot1x_NW_MsgTask_7: Feb 12 13:27:07.045: dc:9b:9c:3e:06:6f 0.0.0.0 L2AUTHCOMPLETE (4) Change state to DHCP_REQD (7)

last state DHCP_REQD (7)

*Dot1x_NW_MsgTask_7: Feb 12 13:27:07.045: dc:9b:9c:3e:06:6f 0.0.0.0 DHCP_REQD (7) pemAdvanceState2 5253, Adding TMP

rule

*Dot1x_NW_MsgTask_: Feb 12 13:27:07.045: dc:9b:9c:3e:06:6f 0.0.0.0 DHCP_REQD (7) Adding Fast Path rule

  type = Airespace AP - Learn IP address

  on AP f4:7f:35:05:e5:b0, slot 0, interface = 1, QOS = 0

  IPv4 ACL ID = 255, IPv

*Dot1x_NW_MsgTask_7: Feb 12 13:27:07.045: dc:9b:9c:3e:06:6f 0.0.0.0 DHCP_REQD (7) Fast Path rule (contd...) 802.1P =

0, DSCP = 0, TokenID = 7006  Local Bridging Vlan = 9, Local Bridging intf id = 14

*Dot1x_NW_MsgTask_7: Feb 12 13:27:07.045: dc:9b:9c:3e:06:6f 0.0.0.0 DHCP_REQD (7) Successfully plumbed mobile rule

(IPv4 ACL ID 255, IPv6 ACL ID 255)

*Dot1x_NW_MsgTask_7: Feb 12 13:27:07.045: dc:9b:9c:3e:06:6f Stopping retransmission timer for mobile dc:9b:9c:3e:06:6f

*pemReceiveTask: Feb 12 13:27:07.046: dc:9b:9c:3e:06:6f 0.0.0.0 Added NPU entry of type 9, dtlFlags 0x0

*pemReceiveTask: Feb 12 13:27:07.046: dc:9b:9c:3e:06:6f Sent an XID frame

*IPv6_Msg_Task: Feb 12 13:27:07.088: dc:9b:9c:3e:06:6f Pushing IPv6: fe80:0000:0000:0000: 1017:eb84:7c42:0b6a , and

MAC: DC:9B:9C:3E:06:6F , Binding to Data Plane. SUCCESS !!

*apfOrphanSocketTask: Feb 12 13:27:07.894: dc:9b:9c:3e:06:6f Orphan Packet from DS - IP 172.16.9.163

*pemReceiveTask: Feb 12 13:27:07.895: dc:9b:9c:3e:06:6f 0.0.0.0 Removed NPU entry.

*DHCP Socket Task: Feb 12 13:27:08.891: dc:9b:9c:3e:06:6f DHCP received op BOOTREQUEST (1) (len 308,vlan 5, port 1,

encap 0xec03)

*DHCP Socket Task: Feb 12 13:27:08.892: dc:9b:9c:3e:06:6f DHCP dropping packet due to ongoing mobility handshake

exchange, (siaddr 0.0.0.0,  mobility state = 'apfMsMmQueryRequested'

*apfReceiveTask: Feb 12 13:27:09.928: dc:9b:9c:3e:06:6f 0.0.0.0 DHCP_REQD (7) State Update from Mobility-Incomplete to

Mobility-Complete, mobility role=Local, client state=APF_MS_STATE_ASSOCIATED

*apfReceiveTask: Feb 12 13:27:09.928: dc:9b:9c:3e:06:6f 0.0.0.0 DHCP_REQD (7) pemAdvanceState2 4891, Adding TMP rule

*apfReceiveTask: Feb 12 13:27:09.928: dc:9b:9c:3e:06:6f 0.0.0.0 DHCP_REQD (7) Adding Fast Path rule

  type = Airespace AP - Learn IP address

  on AP f4:7f:35:05:e5:b0, slot 0, interface = 1, QOS = 0

  IPv4 ACL ID = 255, IPv

*apfReceiveTask: Feb 12 13:27:09.928: dc:9b:9c:3e:06:6f 0.0.0.0 DHCP_REQD (7) Fast Path rule (contd...) 802.1P = 0,

DSCP = 0, TokenID = 7006  Local Bridging Vlan = 9, Local Bridging intf id = 14

*apfReceiveTask: Feb 12 13:27:09.928: dc:9b:9c:3e:06:6f 0.0.0.0 DHCP_REQD (7) Successfully plumbed mobile rule (IPv4

ACL ID 255, IPv6 ACL ID 255)

*apfReceiveTask: Feb 12 13:27:09.928: dc:9b:9c:3e:06:6f IPv6 client got an IPv6 addresses, continue the PEM process

*apfReceiveTask: Feb 12 13:27:09.928: dc:9b:9c:3e:06:6f apfMsRunStateInc

*apfReceiveTask: Feb 12 13:27:09.928: dc:9b:9c:3e:06:6f 0.0.0.0 DHCP_REQD (7) Change state to RUN (20) last state RUN

(20)

*apfReceiveTask: Feb 12 13:27:09.929: dc:9b:9c:3e:06:6f 0.0.0.0 RUN (20) Reached PLUMBFASTPATH: from line 5776

*apf: Feb 12 13:27:09.929: dc:9b:9c:3e:06:6f 0.0.0.0 RUN (20) Replacing Fast Path rule

  type = Airespace AP Client

  on AP f4:7f:35:05:e5:b0, slot 0, interface = 1, QOS = 0

  IPv4 ACL ID = 255, IPv6 ACL ID = 255

*apfReceiveTask: Feb 12 13:27:09.929: dc:9b:9c:3e:06:6f 0.0.0.0 RUN (20) Fast Path rule (contd...) 802.1P = 0, DSCP =

0, TokenID = 7006  Local Bridging Vlan = 9, Local Bridging intf id = 14

*apfReceiveTask: Feb 12 13:27:09.929: dc:9b:9c:3e:06:6f 0.0.0.0 RUN (20) Successfully plumbed mobile rule (IPv4 ACL ID

255, IPv6 ACL ID 255)

*pemReceiveTask: Feb 12 13:27:09.930: dc:9b:9c:3e:06:6f 0.0.0.0 Added NPU entry of type 9, dtlFlags 0x0

*pemReceiveTask: Feb 12 13:27:09.930: dc:9b:9c:3e:06:6f Sent an XID frame

*pemReceiveTask: Feb 12 13:27:09.930: dc:9b:9c:3e:06:6f 0.0.0.0 Added NPU entry of type 1, dtlFlags 0x0

*pemReceiveTask: Feb 12 13:27:09.931: dc:9b:9c:3e:06:6f Pushing IPv6: fe80:0000:0000:0000: 1017:eb84:7c42:0b6a , and

MAC: DC:9B:9C:3E:06:6F , Binding to Data Plane. SUCCESS !!

*pemReceiveTask: Feb 12 13:27:09.931: dc:9b:9c:3e:06:6f 0.0.0.0, VLAN Id 9 Not sending gratuitous ARP

*DHCP Socket Task: Feb 12 13:27:11.432: dc:9b:9c:3e:06:6f DHCP received op BOOTREQUEST (1) (len 308,vlan 5, port 1,

encap 0xec03)

*DHCP Socket Task: Feb 12 13:27:11.432: dc:9b:9c:3e:06:6f DHCP processing DHCP REQUEST (3)

*DHCP Socket Task: Feb 12 13:27:11.432: dc:9b:9c:3e:06:6f DHCP   op: BOOTREQUEST, htype: Ethernet, hlen: 6, hops: 0

*DHCP Socket Task: Feb 12 13:27:11.432: dc:9b:9c:3e:06:6f DHCP   xid: 0x3b5d3074 (995962996), secs: 5, flags: 0

*DHCP Socket Task: Feb 12 13:27:11.432: dc:9b:9c:3e:06:6f DHCP   chaddr: dc:9b:9c:3e:06:6f

*DHCP Socket Task: Feb 12 13:27:11.432: dc:9b:9c:3e:06:6f DHCP   ciaddr: 0.0.0.0,  yiaddr: 0.0.0.0

*DHCP Socket Task: Feb 12 13:27:11.433: dc:9b:9c:3e:06:6f DHCP   siaddr: 0.0.0.0,  giaddr: 0.0.0.0

*DHCP Socket Task: Feb 12 13:27:11.433: dc:9b:9c:3e:06:6f DHCP   requested ip: 172.16.9.163

*DHCP Socket Task: Feb 12 13:27:11.433: dc:9b:9c:3e:06:6f DHCP successfully bridged packet to DS

*DHCP Socket Task: Feb 12 13:27:11.434: dc:9b:9c:3e:06:6f DHCP received op BOOTREPLY (2) (len 308,vlan 9, port 1,

encap 0xec00)

*DHCP Socket Task: Feb 12 13:27:11.434: dc:9b:9c:3e:06:6f DHCP processing DHCP ACK (5)

*DHCP Socket Task: Feb 12 13:27:11.434: dc:9b:9c:3e:06:6f DHCP   op: BOOTREPLY, htype: Ethernet, hlen: 6, hops: 0

*DHCP Socket Task: Feb 12 13:27:11.434: dc:9b:9c:3e:06:6f DHCP   xid: 0x3b5d3074 (995962996), secs: 0, flags: 0

*DHCP Socket Task: Feb 12 13:27:11.434: dc:9b:9c:3e:06:6f DHCP   chaddr: dc:9b:9c:3e:06:6f

*DHCP Socket Task: Feb 12 13:27:11.434: dc:9b:9c:3e:06:6f DHCP   ciaddr: 0.0.0.0,  yiaddr: 172.16.9.163

*DHCP Socket Task: Feb 12 13:27:11.434: dc:9b:9c:3e:06:6f DHCP   siaddr: 0.0.0.0,  giaddr: 0.0.0.0

*DHCP Socket Task: Feb 12 13:27:11.434: dc:9b:9c:3e:06:6f DHCP   server id: 172.16.9.1  rcvd server id: 172.16.9.1

*DHCP Socket Task: Feb 12 13:27:11.434: dc:9b:9c:3e:06:6f 172.16.9.163 RUN (20) DHCP Address Re-established

*DHCP Socket Task: Feb 12 13:27:11.434: dc:9b:9c:3e:06:6f 172.16.9.163 RUN (20) Reached PLUMBFASTPATH: from line 6091

*DHCP Soc: Feb 12 13:27:11.434: dc:9b:9c:3e:06:6f 172.16.9.163 RUN (20) Replacing Fast Path rule

  type = Airespace AP Client

  on AP f4:7f:35:05:e5:b0, slot 0, interface = 1, QOS = 0

  IPv4 ACL ID = 255, IPv6 ACL ID

*DHCP Socket Task: Feb 12 13:27:11.434: dc:9b:9c:3e:06:6f 172.16.9.163 RUN (20) Fast Path rule (contd...) 802.1P = 0,

DSCP = 0, TokenID = 7006  Local Bridging Vlan = 9, Local Bridging intf id = 14

*DHCP Socket Task: Feb 12 13:27:11.434: dc:9b:9c:3e:06:6f 172.16.9.163 RUN (20) Successfully plumbed mobile rule (IPv4

ACL ID 255, IPv6 ACL ID 255)

*DHCP Socket Task: Feb 12 13:27:11.434: dc:9b:9c:3e:06:6f Assigning Address 172.16.9.163 to mobile

*DHCP Socket Task: Feb 12 13:27:11.434: dc:9b:9c:3e:06:6f DHCP success event for client. Clearing dhcp failure count

for interface treswts.

*DHCP Socket Task: Feb 12 13:27:11.434: dc:9b:9c:3e:06:6f DHCP successfully bridged packet to STA

*pemReceiveTask: Feb 12 13:27:11.436: dc:9b:9c:3e:06:6f 172.16.9.163 Added NPU entry of type 1, dtlFlags 0x0

*pemReceiveTask: Feb 12 13:27:11.436: dc:9b:9c:3e:06:6f Pushing IPv6: fe80:0000:0000:0000: 1017:eb84:7c42:0b6a , and

MAC: DC:9B:9C:3E:06:6F , Binding to Data Plane. SUCCESS !!

*apfMsConnTask_6: Feb 12 13:27:15.869: dc:9b:9c:3e:06:6f Reassociation received from mobile on AP f4:7f:35:05:e5:b0

*apfMsConnTask_6: Feb 12 13:27:15.869: dc:9b:9c:3e:06:6f 172.16.9.163 RUN (20) Changing IPv4 ACL 'none' (ACL ID 255)

===> 'none' (ACL ID 255) --- (caller apf_policy.c:1697)

*apfMsConnTask_6: Feb 12 13:27:15.869: dc:9b:9c:3e:06:6f 172.16.9.163 RUN (20) Changing IPv6 ACL 'none' (ACL ID 255)

===> 'none' (ACL ID 255) --- (caller apf_policy.c:1864)

*apfMsConnTask_6: Feb 12 13:27:15.869: dc:9b:9c:3e:06:6f Applying site-specific Local Bridging override for station

dc:9b:9c:3e:06:6f - vapId 4, site 'default-group', interface 'treswts'

*apfMsConnTask_6: Feb 12 13:27:15.869: dc:9b:9c:3e:06:6f Applying Local Bridging Interface Policy for station

dc:9b:9c:3e:06:6f - vlan 9, interface id 14, interface 'treswts'

*apfMsConnTask_6: Feb 12 13:27:15.869: dc:9b:9c:3e:06:6f processSsidIE  statusCode is 0 and status is 0

*apfMsConnTask_6: Feb 12 13:27:15.869: dc:9b:9c:3e:06:6f processSsidIE  ssid_done_flag is 0 finish_flag is 0

*apfMsConnTask_6: Feb 12 13:27:15.869: dc:9b:9c:3e:06:6f STA - rates (8): 140 18 152 36 176 72 96 108 12 18 24 96 0 0

0 0

*apfMsConnTask_6: Feb 12 13:27:15.869: dc:9b:9c:3e:06:6f suppRates  statusCode is 0 and gotSuppRatesElement is 1

*apfMsConnTask_6: Feb 12 13:27:15.870: dc:9b:9c:3e:06:6f Processing RSN IE type 48, length 20 for mobile

dc:9b:9c:3e:06:6f

*apfMsConnTask_6: Feb 12 13:27:15.870: dc:9b:9c:3e:06:6f pemApfDeleteMobileStation2: APF_MS_PEM_WAIT_L2_AUTH_COMPLETE

= 0.

*apfMsConnTask_6: Feb 12 13:27:15.870: dc:9b:9c:3e:06:6f 172.16.9.163 RUN (20) Deleted mobile LWAPP rule on AP

[f4:7f:35:05:e5:b0]

*apfMsConnTask_6: Feb 12 13:27:15.870: dc:9b:9c:3e:06:6f Updated location for station old AP f4:7f:35:05:e5:b0-0, new

AP f4:7f:35:05:e5:b0-1

*apfMsConnTask_6: Feb 12 13:27:15.870: dc:9b:9c:3e:06:6f apfMsRunStateDec

*apfMsConnTask_6: Feb 12 13:27:15.870: dc:9b:9c:3e:06:6f apfMs1xStateDec

*apfMsConnTask_6: Feb 12 13:27:15.870: dc:9b:9c:3e:06:6f 172.16.9.163 RUN (20) Change state to START (0) last state

RUN (20)

*apfMsConnTask_6: Feb 12 13:27:15.870: dc:9b:9c:3e:06:6f pemApfAddMobileStation2: APF_MS_PEM_WAIT_L2_AUTH_COMPLETE =

0.

*apfMsConnTask_6: Feb 12 13:27:15.870: dc:9b:9c:3e:06:6f 172.16.9.163 START (0) Initializing policy

*apfMsConnTask_6: Feb 12 13:27:15.870: dc:9b:9c:3e:06:6f 172.16.9.163 START (0) Change state to AUTHCHECK (2) last

state RUN (20)

*apfMsConnTask_6: Feb 12 13:27:15.870: dc:9b:9c:3e:06:6f 172.16.9.163 AUTHCHECK (2) Change state to 8021X_REQD (3)

last state RUN (20)

*apfMsConnTask_6: Feb 12 13:27:15.870: dc:9b:9c:3e:06:6f 172.16.9.163 8021X_REQD (3) DHCP required on AP

f4:7f:35:05:e5:b0 vapId 4 apVapId 4for this client

*apfMsConnTask_6: Feb 12 13:27:15.870: dc:9b:9c:3e:06:6f Not Using WMM Compliance code qosCap 00

*apfMsConnTask_6: Feb 12 13:27:15.870: dc:9b:9c:3e:06:6f 172.16.9.163 8021X_REQD (3) Plumbed mobile LWAPP rule on AP

f4:7f:35:05:e5:b0 vapId 4 apVapId 4

*apfMsConnTask_6: Feb 12 13:27:15.870: dc:9b:9c:3e:06:6f apfPemAddUser2 (apf_policy.c:268) Changing state for mobile

dc:9b:9c:3e:06:6f on AP f4:7f:35:05:e5:b0 from Associated to Associated

*apfMsConnTask_6: Feb 12 13:27:15.870: dc:9b:9c:3e:06:6f Scheduling deletion of Mobile Station:  (callerId: 49) in

1800 seconds

*apfMsConnTask_6: Feb 12 13:27:15.870: dc:9b:9c:3e:06:6f Sending Assoc Response to station on BSSID f4:7f:35:05:e5:b0

(status 0) ApVapId 4 Slot 1

*apfMsConnTask_6: Feb 12 13:27:15.870: dc:9b:9c:3e:06:6f apfProcessAssocReq (apf_80211.c:6290) Changing state for

mobile dc:9b:9c:3e:06:6f on AP f4:7f:35:05:e5:b0 from Associated to Associated

*pemReceiveTask: Feb 12 13:27:15.873: dc:9b:9c:3e:06:6f 172.16.9.163 Removed NPU entry.

*dot1xMsgTask: Feb 12 13:27:15.876: dc:9b:9c:3e:06:6f Creating a PKC PMKID Cache entry for station dc:9b:9c:3e:06:6f

(RSN 2)

*dot1xMsgTask: Feb 12 13:27:15.876: dc:9b:9c:3e:06:6f Resetting MSCB PMK Cache Entry 0 for station dc:9b:9c:3e:06:6f

*dot1xMsgTask: Feb 12 13:27:15.876: dc:9b:9c:3e:06:6f Removing BSSID f4:7f:35:05:e5:b3 from PMKID cache of station

dc:9b:9c:3e:06:6f

*dot1xMsgTask: Feb 12 13:27:15.876: dc:9b:9c:3e:06:6f Setting active key cache index 0 ---> 8

*dot1xMsgTask: Feb 12 13:27:15.876: dc:9b:9c:3e:06:6f Setting active key cache index 8 ---> 0

*dot1xMsgTask: Feb 12 13:27:15.876: dc:9b:9c:3e:06:6f Adding BSSID f4:7f:35:05:e5:bc to PMKID cache at index 0 for

station dc:9b:9c:3e:06:6f

*dot1xMsgTask: Feb 12 13:27:15.876: New PMKID: (16)

*dot1xMsgTask: Feb 12 13:27:15.876:      [0000] df b2 42 72 6b d8 3f ab 9e 72 94 54 72 24 fd 3d

*dot1xMsgTask: Feb 12 13:27:15.876: dc:9b:9c:3e:06:6f Initiating RSN PSK to mobile dc:9b:9c:3e:06:6f

*dot1xMsgTask: Feb 12 13:27:15.876: dc:9b:9c:3e:06:6f dot1x - moving mobile dc:9b:9c:3e:06:6f into Force Auth state

*dot1xMsgTask: Feb 12 13:27:15.876: dc:9b:9c:3e:06:6f Skipping EAP-Success to mobile dc:9b:9c:3e:06:6f

*dot1xMsgTask: Feb 12 13:27:15.876: dc:9b:9c:3e:06:6f Found an cache entry for BSSID f4:7f:35:05:e5:bc in PMKID cache

at index 0 of station dc:9b:9c:3e:06:6f

*dot1xMsgTask: Feb 12 13:27:15.876: dc:9b:9c:3e:06:6f Found an cache entry for BSSID f4:7f:35:05:e5:bc in PMKID cache

at index 0 of station dc:9b:9c:3e:06:6f

*dot1xMsgTask: Feb 12 13:27:15.876: Including PMKID in M1  (16)

*dot1xMsgTask: Feb 12 13:27:15.876:      [0000] df b2 42 72 6b d8 3f ab 9e 72 94 54 72 24 fd 3d

*dot1xMsgTask: Feb 12 13:27:15.876: dc:9b:9c:3e:06:6f Starting key exchange to mobile dc:9b:9c:3e:06:6f, data packets

will be dropped

*dot1xMsgTask: Feb 12 13:27:15.876: dc:9b:9c:3e:06:6f Sending EAPOL-Key Message to mobile dc:9b:9c:3e:06:6f

                                                                                                              state

INITPMK (message 1), replay counter 00.00.00.00.00.00.00.00

*Dot1x_NW_MsgTask_7: Feb 12 13:27:15.886: dc:9b:9c:3e:06:6f Received EAPOL-Key from mobile dc:9b:9c:3e:06:6f

*Dot1x_NW_MsgTask_7: Feb 12 13:27:15.886: dc:9b:9c:3e:06:6f Received EAPOL-key in PTK_START state (message 2) from

mobile dc:9b:9c:3e:06:6f

*Dot1x_NW_MsgTask_7: Feb 12 13:27:15.886: dc:9b:9c:3e:06:6f Stopping retransmission timer for mobile dc:9b:9c:3e:06:6f

*Dot1x_NW_MsgTask_7: Feb 12 13:27:15.886: dc:9b:9c:3e:06:6f Sending EAPOL-Key Message to mobile dc:9b:9c:3e:06:6f

state PTKINITNEGOTIATING (message 3), replay counter 00.00.00.00.00.00.00.01

*Dot1x_NW_MsgTask_7: Feb 12 13:27:15.888: dc:9b:9c:3e:06:6f Received EAPOL-Key from mobile dc:9b:9c:3e:06:6f

*Dot1x_NW_MsgTask_7: Feb 12 13:27:15.888: dc:9b:9c:3e:06:6f Received EAPOL-key in PTKINITNEGOTIATING state (message 4)

from mobile dc:9b:9c:3e:06:6f

*Dot1x_NW_MsgTask_7: Feb 12 13:27:15.888: dc:9b:9c:3e:06:6f apfMs1xStateInc

*Dot1x_NW_MsgTask_7: Feb 12 13:27:15.888: dc:9b:9c:3e:06:6f 172.16.9.163 8021X_REQD (3) Change state to L2AUTHCOMPLETE

(4) last state RUN (20)

*Dot1x_NW_MsgTask_7: Feb 12 13:27:15.888: dc:9b:9c:3e:06:6f 172.16.9.163 L2AUTHCOMPLETE (4) DHCP required on AP

f4:7f:35:05:e5:b0 vapId 4 apVapId 4for this client

*Dot1x_NW_MsgTask_7: Feb 12 13:27:15.888: dc:9b:9c:3e:06:6f Not Using WMM Compliance code qosCap 00

*Dot1x_NW_MsgTask_7: Feb 12 13:27:15.888: dc:9b:9c:3e:06:6f 172.16.9.163 L2AUTHCOMPLETE (4) Plumbed mobile LWAPP rule

on AP f4:7f:35:05:e5:b0 vapId 4 apVapId 4

*Dot1x_NW_MsgTask_7: Feb 12 13:27:15.888: dc:9b:9c:3e:06:6f apfMsRunStateInc

*Dot1x_NW_MsgTask_7: Feb 12 13:27:15.888: dc:9b:9c:3e:06:6f 172.16.9.163 L2AUTHCOMPLETE (4) Change state to RUN (20)

last state RUN (20)

*Dot1x_NW_MsgTask_7: Feb 12 13:27:15.889: dc:9b:9c:3e:06:6f 172.16.9.163 RUN (20) Reached PLUMBFASTPATH: from line

5362

*Dot1x: Feb 12 13:27:15.889: dc:9b:9c:3e:06:6f 172.16.9.163 RUN (20) Adding Fast Path rule

  type = Airespace AP Client

  on AP f4:7f:35:05:e5:b0, slot 1, interface = 1, QOS = 0

  IPv4 ACL ID = 255, IPv6 ACL ID = 2

*Dot1x_NW_MsgTask_7: Feb 12 13:27:15.889: dc:9b:9c:3e:06:6f 172.16.9.163 RUN (20) Fast Path rule (contd...) 802.1P =

0, DSCP = 0, TokenID = 7006  Local Bridging Vlan = 9, Local Bridging intf id = 14

*Dot1x_NW_MsgTask_7: Feb 12 13:27:15.889: dc:9b:9c:3e:06:6f 172.16.9.163 RUN (20) Successfully plumbed mobile rule

(IPv4 ACL ID 255, IPv6 ACL ID 255)

*Dot1x_NW_MsgTask_7: Feb 12 13:27:15.889: dc:9b:9c:3e:06:6f Stopping retransmission timer for mobile dc:9b:9c:3e:06:6f

*pemReceiveTask: Feb 12 13:27:15.890: dc:9b:9c:3e:06:6f 172.16.9.163 Added NPU entry of type 1, dtlFlags 0x0

*pemReceiveTask: Feb 12 13:27:15.890: dc:9b:9c:3e:06:6f Pushing IPv6: fe80:0000:0000:0000: 1017:eb84:7c42:0b6a , and

MAC: DC:9B:9C:3E:06:6F , Binding to Data Plane. SUCCESS !!

*apfMsConnTask_6: Feb 12 13:27:20.186: dc:9b:9c:3e:06:6f Association received from mobile on AP f4:7f:35:05:e5:b0

*apfMsConnTask_6: Feb 12 13:27:20.186: dc:9b:9c:3e:06:6f Deleting client immediately since WLAN has changed

*apfMsConnTask_6: Feb 12 13:27:20.186: dc:9b:9c:3e:06:6f Scheduling deletion of Mobile Station:  (callerId: 50) in 1

seconds

*apfMsConnTask_6: Feb 12 13:27:20.498: dc:9b:9c:3e:06:6f Ignoring 802.11 assoc request from mobile pending deletion

*apfMsConnTask_6: Feb 12 13:27:20.498: dc:9b:9c:3e:06:6f Sending Assoc Response to station on BSSID f4:7f:35:05:e5:b0

(status 12) ApVapId 2 Slot 1

*apfMsConnTask_5: Feb 12 13:27:20.511: dc:9b:9c:3e:06:6f Ignoring 802.11 assoc request from mobile pending deletion

*apfMsConnTask_5: Feb 12 13:27:20.512: dc:9b:9c:3e:06:6f Sending Assoc Response to station on BSSID f4:7f:35:05:e6:10

(status 12) ApVapId 2 Slot 1

*apfMsConnTask_5: Feb 12 13:27:20.569: dc:9b:9c:3e:06:6f Ignoring 802.11 assoc request from mobile pending deletion

*apfMsConnTask_5: Feb 12 13:27:20.569: dc:9b:9c:3e:06:6f Sending Assoc Response to station on BSSID f4:7f:35:05:e6:10

(status 12) ApVapId 2 Slot 0

*apfMsConnTask_6: Feb 12 13:27:20.881: dc:9b:9c:3e:06:6f Ignoring 802.11 assoc request from mobile pending deletion

*apfMsConnTask_6: Feb 12 13:27:20.881: dc:9b:9c:3e:06:6f Sending Assoc Response to station on BSSID f4:7f:35:05:e5:b0

(status 12) ApVapId 4 Slot 1

*apfMsConnTask_5: Feb 12 13:27:20.905: dc:9b:9c:3e:06:6f Ignoring 802.11 assoc request from mobile pending deletion

*apfMsConnTask_5: Feb 12 13:27:20.905: dc:9b:9c:3e:06:6f Sending Assoc Response to station on BSSID f4:7f:35:05:e6:10

(status 12) ApVapId 4 Slot 0

*apfMsConnTask_5: Feb 12 13:27:20.922: dc:9b:9c:3e:06:6f Ignoring 802.11 assoc request from mobile pending deletion

*apfMsConnTask_5: Feb 12 13:27:20.922: dc:9b:9c:3e:06:6f Sending Assoc Response to station on BSSID f4:7f:35:05:e6:10

(status 12) ApVapId 4 Slot 1

*osapiBsnTimer: Feb 12 13:27:21.127: dc:9b:9c:3e:06:6f apfMsExpireCallback (apf_ms.c:589) Expiring Mobile!

*apfReceiveTask: Feb 12 13:27:21.128: dc:9b:9c:3e:06:6f apfMsExpireMobileStation (apf_ms.c:5584) Changing state for

mobile dc:9b:9c:3e:06:6f on AP f4:7f:35:05:e5:b0 from Associated to Disassociated

*apfReceiveTask: Feb 12 13:27:21.129: dc:9b:9c:3e:06:6f Sent Deauthenticate to mobile on BSSID f4:7f:35:05:e5:b0 slot

1(caller apf_ms.c:5678)

*apfReceiveTask: Feb 12 13:27:21.129: dc:9b:9c:3e:06:6f apfMsAssoStateDec

*apfReceiveTask: Feb 12 13:27:21.129: dc:9b:9c:3e:06:6f apfMsExpireMobileStation (apf_ms.c:5716) Changing state for

mobile dc:9b:9c:3e:06:6f on AP f4:7f:35:05:e5:b0 from Disassociated to Idle

*apfReceiveTask: Feb 12 13:27:21.129: dc:9b:9c:3e:06:6f pemApfDeleteMobileStation2: APF_MS_PEM_WAIT_L2_AUTH_COMPLETE =

0.

*apfReceiveTask: Feb 12 13:27:21.129: dc:9b:9c:3e:06:6f 172.16.9.163 RUN (20) Deleted mobile LWAPP rule on AP

[f4:7f:35:05:e5:b0]

*apfReceiveTask: Feb 12 13:27:21.129: dc:9b:9c:3e:06:6f apfMsRunStateDec

*apfReceiveTask: Feb 12 13:27:21.129: dc:9b:9c:3e:06:6f apfMs1xStateDec

*apfReceiveTask: Feb 12 13:27:21.129: dc:9b:9c:3e:06:6f Deleting mobile on AP f4:7f:35:05:e5:b0(1)

*pemReceiveTask: Feb 12 13:27:21.131: dc:9b:9c:3e:06:6f 172.16.9.163 Removed NPU entry.

*apfMsConnTask_6: Feb 12 13:27:23.922: dc:9b:9c:3e:06:6f Adding mobile on LWAPP AP f4:7f:35:05:e5:b0(1)

*apfMsConnTask_6: Feb 12 13:27:23.922: dc:9b:9c:3e:06:6f Association received from mobile on AP f4:7f:35:05:e5:b0

*apfMsConnTask_6: Feb 12 13:27:23.922: dc:9b:9c:3e:06:6f 0.0.0.0 START (0) Changing IPv4 ACL 'none' (ACL ID 255) ===>

'none' (ACL ID 255) --- (caller apf_policy.c:1697)

*apfMsConnTask_6: Feb 12 13:27:23.922: dc:9b:9c:3e:06:6f 0.0.0.0 START (0) Changing IPv6 ACL 'none' (ACL ID 255) ===>

'none' (ACL ID 255) --- (caller apf_policy.c:1864)

*apfMsConnTask_6: Feb 12 13:27:23.922: dc:9b:9c:3e:06:6f Applying site-specific Local Bridging override for station

dc:9b:9c:3e:06:6f - vapId 4, site 'default-group', interface 'treswts'

*apfMsConnTask_6: Feb 12 13:27:23.922: dc:9b:9c:3e:06:6f Applying Local Bridging Interface Policy for station

dc:9b:9c:3e:06:6f - vlan 9, interface id 14, interface 'treswts'

*apfMsConnTask_6: Feb 12 13:27:23.922: dc:9b:9c:3e:06:6f processSsidIE  statusCode is 0 and status is 0

*apfMsConnTask_6: Feb 12 13:27:23.922: dc:9b:9c:3e:06:6f processSsidIE  ssid_done_flag is 0 finish_flag is 0

*apfMsConnTask_6: Feb 12 13:27:23.922: dc:9b:9c:3e:06:6f STA - rates (8): 140 18 152 36 176 72 96 108 0 0 0 0 0 0 0 0

*apfMsConnTask_6: Feb 12 13:27:23.922: dc:9b:9c:3e:06:6f suppRates  statusCode is 0 and gotSuppRatesElement is 1

*apfMsConnTask_6: Feb 12 13:27:23.922: dc:9b:9c:3e:06:6f Processing RSN IE type 48, length 20 for mobile

dc:9b:9c:3e:06:6f

*apfMsConnTask_6: Feb 12 13:27:23.922: dc:9b:9c:3e:06:6f 0.0.0.0 START (0) Initializing policy

*apfMsConnTask_6: Feb 12 13:27:23.922: dc:9b:9c:3e:06:6f 0.0.0.0 START (0) Change state to AUTHCHECK (2) last state

AUTHCHECK (2)

*apfMsConnTask_6: Feb 12 13:27:23.922: dc:9b:9c:3e:06:6f 0.0.0.0 AUTHCHECK (2) Change state to 8021X_REQD (3) last

state 8021X_REQD (3)

*apfMsConnTask_6: Feb 12 13:27:23.922: dc:9b:9c:3e:06:6f 0.0.0.0 8021X_REQD (3) DHCP Not required on AP

f4:7f:35:05:e5:b0 vapId 4 apVapId 4for this client

*apfMsConnTask_6: Feb 12 13:27:23.922: dc:9b:9c:3e:06:6f Not Using WMM Compliance code qosCap 00

*apfMsConnTask_6: Feb 12 13:27:23.922: dc:9b:9c:3e:06:6f 0.0.0.0 8021X_REQD (3) Plumbed mobile LWAPP rule on AP

f4:7f:35:05:e5:b0 vapId 4 apVapId 4

*apfMsConnTask_6: Feb 12 13:27:23.922: dc:9b:9c:3e:06:6f apfMsAssoStateInc

*apfMsConnTask_6: Feb 12 13:27:23.922: dc:9b:9c:3e:06:6f apfPemAddUser2 (apf_policy.c:268) Changing state for mobile

dc:9b:9c:3e:06:6f on AP f4:7f:35:05:e5:b0 from Idle to Associated

*apfMsConnTask_6: Feb 12 13:27:23.922: dc:9b:9c:3e:06:6f Scheduling deletion of Mobile Station:  (callerId: 49) in

1800 seconds

*apfMsConnTask_6: Feb 12 13:27:23.922: dc:9b:9c:3e:06:6f Sending Assoc Response to station on BSSID f4:7f:35:05:e5:b0

(status 0) ApVapId 4 Slot 1

*apfMsConnTask_6: Feb 12 13:27:23.922: dc:9b:9c:3e:06:6f apfProcessAssocReq (apf_80211.c:6290) Changing state for

mobile dc:9b:9c:3e:06:6f on AP f4:7f:35:05:e5:b0 from Associated to Associated

*dot1xMsgTask: Feb 12 13:27:23.926: dc:9b:9c:3e:06:6f Creating a PKC PMKID Cache entry for station dc:9b:9c:3e:06:6f

(RSN 2)

*dot1xMsgTask: Feb 12 13:27:23.926: dc:9b:9c:3e:06:6f Resetting MSCB PMK Cache Entry 0 for station dc:9b:9c:3e:06:6f

*dot1xMsgTask: Feb 12 13:27:23.926: dc:9b:9c:3e:06:6f Setting active key cache index 8 ---> 8

*dot1xMsgTask: Feb 12 13:27:23.926: dc:9b:9c:3e:06:6f Setting active key cache index 8 ---> 0

*dot1xMsgTask: Feb 12 13:27:23.926: dc:9b:9c:3e:06:6f Adding BSSID f4:7f:35:05:e5:bc to PMKID cache at index 0 for

station dc:9b:9c:3e:06:6f

*dot1xMsgTask: Feb 12 13:27:23.926: New PMKID: (16)

*dot1xMsgTask: Feb 12 13:27:23.926:      [0000] df b2 42 72 6b d8 3f ab 9e 72 94 54 72 24 fd 3d

*dot1xMsgTask: Feb 12 13:27:23.927: dc:9b:9c:3e:06:6f Initiating RSN PSK to mobile dc:9b:9c:3e:06:6f

*dot1xMsgTask: Feb 12 13:27:23.927: dc:9b:9c:3e:06:6f dot1x - moving mobile dc:9b:9c:3e:06:6f into Force Auth state

*dot1xMsgTask: Feb 12 13:27:23.927: dc:9b:9c:3e:06:6f Skipping EAP-Success to mobile dc:9b:9c:3e:06:6f

*dot1xMsgTask: Feb 12 13:27:23.927: dc:9b:9c:3e:06:6f Found an cache entry for BSSID f4:7f:35:05:e5:bc in PMKID cache

at index 0 of station dc:9b:9c:3e:06:6f

*dot1xMsgTask: Feb 12 13:27:23.927: dc:9b:9c:3e:06:6f Found an cache entry for BSSID f4:7f:35:05:e5:bc in PMKID cache

at index 0 of station dc:9b:9c:3e:06:6f

*dot1xMsgTask: Feb 12 13:27:23.927: Including PMKID in M1  (16)

*dot1xMsgTask: Feb 12 13:27:23.927:      [0000] df b2 42 72 6b d8 3f ab 9e 72 94 54 72 24 fd 3d

*dot1xMsgTask: Feb 12 13:27:23.927: dc:9b:9c:3e:06:6f Starting key exchange to mobile dc:9b:9c:3e:06:6f, data packets

will be dropped

*dot1xMsgTask: Feb 12 13:27:23.927: dc:9b:9c:3e:06:6f Sending EAPOL-Key Message to mobile dc:9b:9c:3e:06:6f

                                                                                                              state

INITPMK (message 1), replay counter 00.00.00.00.00.00.00.00

*Dot1x_NW_MsgTask_7: Feb 12 13:27:23.934: dc:9b:9c:3e:06:6f Received EAPOL-Key from mobile dc:9b:9c:3e:06:6f

*Dot1x_NW_MsgTask_7: Feb 12 13:27:23.934: dc:9b:9c:3e:06:6f Received EAPOL-key in PTK_START state (message 2) from

mobile dc:9b:9c:3e:06:6f

*Dot1x_NW_MsgTask_7: Feb 12 13:27:23.934: dc:9b:9c:3e:06:6f Stopping retransmission timer for mobile dc:9b:9c:3e:06:6f

*Dot1x_NW_MsgTask_7: Feb 12 13:27:23.934: dc:9b:9c:3e:06:6f Sending EAPOL-Key Message to mobile dc:9b:9c:3e:06:6f

state PTKINITNEGOTIATING (message 3), replay counter 00.00.00.00.00.00.00.01

*Dot1x_NW_MsgTask_7: Feb 12 13:27:23.943: dc:9b:9c:3e:06:6f Received EAPOL-Key from mobile dc:9b:9c:3e:06:6f

*Dot1x_NW_MsgTask_7: Feb 12 13:27:23.943: dc:9b:9c:3e:06:6f Received EAPOL-key in PTKINITNEGOTIATING state (message 4)

from mobile dc:9b:9c:3e:06:6f

*Dot1x_NW_MsgTask_7: Feb 12 13:27:23.943: dc:9b:9c:3e:06:6f apfMs1xStateInc

*Dot1x_NW_MsgTask_7: Feb 12 13:27:23.943: dc:9b:9c:3e:06:6f 0.0.0.0 8021X_REQD (3) Change state to L2AUTHCOMPLETE (4)

last state L2AUTHCOMPLETE (4)

*Dot1x_NW_MsgTask_7: Feb 12 13:27:23.943: dc:9b:9c:3e:06:6f 0.0.0.0 L2AUTHCOMPLETE (4) DHCP Not required on AP

f4:7f:35:05:e5:b0 vapId 4 apVapId 4for this client

*Dot1x_NW_MsgTask_7: Feb 12 13:27:23.943: dc:9b:9c:3e:06:6f Not Using WMM Compliance code qosCap 00

*Dot1x_NW_MsgTask_7: Feb 12 13:27:23.943: dc:9b:9c:3e:06:6f 0.0.0.0 L2AUTHCOMPLETE (4) Plumbed mobile LWAPP rule on AP

f4:7f:35:05:e5:b0 vapId 4 apVapId 4

*Dot1x_NW_MsgTask_7: Feb 12 13:27:23.943: dc:9b:9c:3e:06:6f 0.0.0.0 L2AUTHCOMPLETE (4) Change state to DHCP_REQD (7)

last state DHCP_REQD (7)

*Dot1x_NW_MsgTask_7: Feb 12 13:27:23.943: dc:9b:9c:3e:06:6f 0.0.0.0 DHCP_REQD (7) pemAdvanceState2 5253, Adding TMP

rule

*Dot1x_NW_MsgTask_: Feb 12 13:27:23.943: dc:9b:9c:3e:06:6f 0.0.0.0 DHCP_REQD (7) Adding Fast Path rule

  type = Airespace AP - Learn IP address

  on AP f4:7f:35:05:e5:b0, slot 1, interface = 1, QOS = 0

  IPv4 ACL ID = 255, IPv

*Dot1x_NW_MsgTask_7: Feb 12 13:27:23.943: dc:9b:9c:3e:06:6f 0.0.0.0 DHCP_REQD (7) Fast Path rule (contd...) 802.1P =

0, DSCP = 0, TokenID = 7006  Local Bridging Vlan = 9, Local Bridging intf id = 14

*Dot1x_NW_MsgTask_7: Feb 12 13:27:23.943: dc:9b:9c:3e:06:6f 0.0.0.0 DHCP_REQD (7) Successfully plumbed mobile rule

(IPv4 ACL ID 255, IPv6 ACL ID 255)

*Dot1x_NW_MsgTask_7: Feb 12 13:27:23.943: dc:9b:9c:3e:06:6f Stopping retransmission timer for mobile dc:9b:9c:3e:06:6f

*pemReceiveTask: Feb 12 13:27:23.944: dc:9b:9c:3e:06:6f 0.0.0.0 Added NPU entry of type 9, dtlFlags 0x0

*pemReceiveTask: Feb 12 13:27:23.944: dc:9b:9c:3e:06:6f Sent an XID frame

*IPv6_Msg_Task: Feb 12 13:27:24.008: dc:9b:9c:3e:06:6f Pushing IPv6: fe80:0000:0000:0000: 1017:eb84:7c42:0b6a , and

MAC: DC:9B:9C:3E:06:6F , Binding to Data Plane. SUCCESS !!

*DHCP Socket Task: Feb 12 13:27:25.929: dc:9b:9c:3e:06:6f DHCP received op BOOTREQUEST (1) (len 308,vlan 5, port 1,

encap 0xec03)

*DHCP Socket Task: Feb 12 13:27:25.929: dc:9b:9c:3e:06:6f DHCP dropping packet due to ongoing mobility handshake

exchange, (siaddr 0.0.0.0,  mobility state = 'apfMsMmQueryRequested'

*apfReceiveTask: Feb 12 13:27:26.928: dc:9b:9c:3e:06:6f 0.0.0.0 DHCP_REQD (7) State Update from Mobility-Incomplete to

Mobility-Complete, mobility role=Local, client state=APF_MS_STATE_ASSOCIATED

*apfReceiveTask: Feb 12 13:27:26.928: dc:9b:9c:3e:06:6f 0.0.0.0 DHCP_REQD (7) pemAdvanceState2 4891, Adding TMP rule

*apfReceiveTask: Feb 12 13:27:26.928: dc:9b:9c:3e:06:6f 0.0.0.0 DHCP_REQD (7) Replacing Fast Path rule

  type = Airespace AP - Learn IP address

  on AP f4:7f:35:05:e5:b0, slot 1, interface = 1, QOS = 0

  IPv4 ACL ID = 255,

*apfReceiveTask: Feb 12 13:27:26.928: dc:9b:9c:3e:06:6f 0.0.0.0 DHCP_REQD (7) Fast Path rule (contd...) 802.1P = 0,

DSCP = 0, TokenID = 7006  Local Bridging Vlan = 9, Local Bridging intf id = 14

*apfReceiveTask: Feb 12 13:27:26.928: dc:9b:9c:3e:06:6f 0.0.0.0 DHCP_REQD (7) Successfully plumbed mobile rule (IPv4

ACL ID 255, IPv6 ACL ID 255)

*apfReceiveTask: Feb 12 13:27:26.928: dc:9b:9c:3e:06:6f IPv6 client got an IPv6 addresses, continue the PEM process

*apfReceiveTask: Feb 12 13:27:26.928: dc:9b:9c:3e:06:6f apfMsRunStateInc

*apfReceiveTask: Feb 12 13:27:26.928: dc:9b:9c:3e:06:6f 0.0.0.0 DHCP_REQD (7) Change state to RUN (20) last state RUN

(20)

*apfReceiveTask: Feb 12 13:27:26.929: dc:9b:9c:3e:06:6f 0.0.0.0 RUN (20) Reached PLUMBFASTPATH: from line 5776

*apf: Feb 12 13:27:26.929: dc:9b:9c:3e:06:6f 0.0.0.0 RUN (20) Replacing Fast Path rule

  type = Airespace AP Client

  on AP f4:7f:35:05:e5:b0, slot 1, interface = 1, QOS = 0

  IPv4 ACL ID = 255, IPv6 ACL ID = 255

*apfReceiveTask: Feb 12 13:27:26.929: dc:9b:9c:3e:06:6f 0.0.0.0 RUN (20) Fast Path rule (contd...) 802.1P = 0, DSCP =

0, TokenID = 7006  Local Bridging Vlan = 9, Local Bridging intf id = 14

*apfReceiveTask: Feb 12 13:27:26.929: dc:9b:9c:3e:06:6f 0.0.0.0 RUN (20) Successfully plumbed mobile rule (IPv4 ACL ID

255, IPv6 ACL ID 255)

*pemReceiveTask: Feb 12 13:27:26.930: dc:9b:9c:3e:06:6f 0.0.0.0 Added NPU entry of type 9, dtlFlags 0x0

*pemReceiveTask: Feb 12 13:27:26.930: dc:9b:9c:3e:06:6f Sent an XID frame

*pemReceiveTask: Feb 12 13:27:26.930: dc:9b:9c:3e:06:6f 0.0.0.0 Added NPU entry of type 1, dtlFlags 0x0

*pemReceiveTask: Feb 12 13:27:26.930: dc:9b:9c:3e:06:6f Pushing IPv6: fe80:0000:0000:0000: 1017:eb84:7c42:0b6a , and

MAC: DC:9B:9C:3E:06:6F , Binding to Data Plane. SUCCESS !!

*pemReceiveTask: Feb 12 13:27:26.931: dc:9b:9c:3e:06:6f 0.0.0.0, VLAN Id 9 Not sending gratuitous ARP

*DHCP Socket Task: Feb 12 13:27:28.649: dc:9b:9c:3e:06:6f DHCP received op BOOTREQUEST (1) (len 308,vlan 5, port 1,

encap 0xec03)

*DHCP Socket Task: Feb 12 13:27:28.649: dc:9b:9c:3e:06:6f DHCP processing DHCP REQUEST (3)

*DHCP Socket Task: Feb 12 13:27:28.649: dc:9b:9c:3e:06:6f DHCP   op: BOOTREQUEST, htype: Ethernet, hlen: 6, hops: 0

*DHCP Socket Task: Feb 12 13:27:28.649: dc:9b:9c:3e:06:6f DHCP   xid: 0x3b5d3075 (995962997), secs: 5, flags: 0

*DHCP Socket Task: Feb 12 13:27:28.649: dc:9b:9c:3e:06:6f DHCP   chaddr: dc:9b:9c:3e:06:6f

*DHCP Socket Task: Feb 12 13:27:28.649: dc:9b:9c:3e:06:6f DHCP   ciaddr: 0.0.0.0,  yiaddr: 0.0.0.0

*DHCP Socket Task: Feb 12 13:27:28.649: dc:9b:9c:3e:06:6f DHCP   siaddr: 0.0.0.0,  giaddr: 0.0.0.0

*DHCP Socket Task: Feb 12 13:27:28.649: dc:9b:9c:3e:06:6f DHCP   requested ip: 172.16.9.163

*DHCP Socket Task: Feb 12 13:27:28.649: dc:9b:9c:3e:06:6f DHCP successfully bridged packet to DS

*DHCP Socket Task: Feb 12 13:27:28.651: dc:9b:9c:3e:06:6f DHCP received op BOOTREPLY (2) (len 308,vlan 9, port 1,

encap 0xec00)

*DHCP Socket Task: Feb 12 13:27:28.651: dc:9b:9c:3e:06:6f DHCP processing DHCP ACK (5)

*DHCP Socket Task: Feb 12 13:27:28.651: dc:9b:9c:3e:06:6f DHCP   op: BOOTREPLY, htype: Ethernet, hlen: 6, hops: 0

*DHCP Socket Task: Feb 12 13:27:28.651: dc:9b:9c:3e:06:6f DHCP   xid: 0x3b5d3075 (995962997), secs: 0, flags: 0

*DHCP Socket Task: Feb 12 13:27:28.651: dc:9b:9c:3e:06:6f DHCP   chaddr: dc:9b:9c:3e:06:6f

*DHCP Socket Task: Feb 12 13:27:28.651: dc:9b:9c:3e:06:6f DHCP   ciaddr: 0.0.0.0,  yiaddr: 172.16.9.163

*DHCP Socket Task: Feb 12 13:27:28.651: dc:9b:9c:3e:06:6f DHCP   siaddr: 0.0.0.0,  giaddr: 0.0.0.0

*DHCP Socket Task: Feb 12 13:27:28.651: dc:9b:9c:3e:06:6f DHCP   server id: 172.16.9.1  rcvd server id: 172.16.9.1

*DHCP Socket Task: Feb 12 13:27:28.651: dc:9b:9c:3e:06:6f 172.16.9.163 RUN (20) DHCP Address Re-established

*DHCP Socket Task: Feb 12 13:27:28.651: dc:9b:9c:3e:06:6f 172.16.9.163 RUN (20) Reached PLUMBFASTPATH: from line 6091

*DHCP Soc: Feb 12 13:27:28.651: dc:9b:9c:3e:06:6f 172.16.9.163 RUN (20) Replacing Fast Path rule

  type = Airespace AP Client

  on AP f4:7f:35:05:e5:b0, slot 1, interface = 1, QOS = 0

  IPv4 ACL ID = 255, IPv6 ACL ID

*DHCP Socket Task: Feb 12 13:27:28.651: dc:9b:9c:3e:06:6f 172.16.9.163 RUN (20) Fast Path rule (contd...) 802.1P = 0,

DSCP = 0, TokenID = 7006  Local Bridging Vlan = 9, Local Bridging intf id = 14

*DHCP Socket Task: Feb 12 13:27:28.651: dc:9b:9c:3e:06:6f 172.16.9.163 RUN (20) Successfully plumbed mobile rule (IPv4

ACL ID 255, IPv6 ACL ID 255)

*DHCP Socket Task: Feb 12 13:27:28.651: dc:9b:9c:3e:06:6f Assigning Address 172.16.9.163 to mobile

*DHCP Socket Task: Feb 12 13:27:28.651: dc:9b:9c:3e:06:6f DHCP success event for client. Clearing dhcp failure count

for interface treswts.

*DHCP Socket Task: Feb 12 13:27:28.651: dc:9b:9c:3e:06:6f DHCP successfully bridged packet to STA

*pemReceiveTask: Feb 12 13:27:28.653: dc:9b:9c:3e:06:6f 172.16.9.163 Added NPU entry of type 1, dtlFlags 0x0

*pemReceiveTask: Feb 12 13:27:28.653: dc:9b:9c:3e:06:6f Pushing IPv6: fe80:0000:0000:0000: 1017:eb84:7c42:0b6a , and

MAC: DC:9B:9C:3E:06:6F , Binding to Data Plane. SUCCESS !!