Cisco Support Community
cancel
Showing results for 
Search instead for 
Did you mean: 
Announcements

Welcome to Cisco Support Community. We would love to have your feedback.

For an introduction to the new site, click here. If you'd prefer to explore, try our test area to get started. And see here for current known issues.

New Member

Clients disconnecting randoming..

So as for the network layout we are using two 5508 controllers running 7.1.19 code currently with 3502i and 3602i radios. Until yesterday, I had issues with a wireless vendor that wouldn't stay connected on 7.2 code. That vendor is no longer here since yesterday.

Here is a debug client log. I show the client being connected to an AP and then about 10 dropped pings while the client is off the network and then reassociated back to the same AP. I have a constant ping going at the same time and getting subsecond pings when it disconnects with a RSSI of -60 and SNR of 50+. This is a laptop device sitting on a desk and not moving throught the floors.

At 11:29 pings were going just fine, then at 11:44 the client reassociates and then again at 11:46..

*apfReceiveTask: May 02 11:29:29.700: 00:27:10:95:59:a4 10.200.xxx.69 RUN (20) Fast Path rule (contd...) 802.1P = 3, DSCP = 0, TokenID = 7006  IPv6 Vlan = 7, IPv6 intf id = 11
*apfReceiveTask: May 02 11:29:29.700: 00:27:10:95:59:a4 10.200.xxx.69 RUN (20) Successfully plumbed mobile rule (ACL ID 255)
*apfReceiveTask: May 02 11:29:29.700: 00:27:10:95:59:a4 Assigning Address 10.200.xxx.69 to mobile
*apfReceiveTask: May 02 11:29:29.700: 00:27:10:95:59:a4 Successfully installed IP address 10.200.xxx.69 for station
*pemReceiveTask: May 02 11:29:29.700: 00:27:10:95:59:a4 0.0.0.0 Added NPU entry of type 9, dtlFlags 0x0
*pemReceiveTask: May 02 11:29:29.700: 00:27:10:95:59:a4 Sent an XID frame
*pemReceiveTask: May 02 11:29:29.701: 00:27:10:95:59:a4 10.200.xxx.69 Added NPU entry of type 1, dtlFlags 0x0
*pemReceiveTask: May 02 11:29:29.701: 00:27:10:95:59:a4 Sending a gratuitous ARP for 10.200.xxx.69, VLAN Id 28679
*apfLbsTask: May 02 11:29:35.900: 00:27:10:95:59:a4 Copy AP LOCP - mode:0 slotId:1, apMac 0x2c:36:f8:c:c3:90
*apfLbsTask: May 02 11:29:35.900: 00:27:10:95:59:a4 Copy WLAN LOCP EssIndex:7 aid:11 ssid:  bpwlan
*apfLbsTask: May 02 11:29:35.900: 00:27:10:95:59:a4 Copy Security LOCP ecypher:0x1 ptype:0x1, p:0x0, eaptype:0x1 w:0x1 aalg:0x0, PMState:        RUN
*apfLbsTask: May 02 11:29:35.900: 00:27:10:95:59:a4 Copy 802.11 LOCP a:0x0 b:0x0 c:0x0 d:0x0 e:0x0 protocol2:0x1 statuscode 0, reasoncode 99, status 3
*apfLbsTask: May 02 11:29:35.900: 00:27:10:95:59:a4 Copy Username LOCP : xxxxxx\xxxxxx
*apfLbsTask: May 02 11:29:35.900: 00:27:10:95:59:a4 Copy IP LOCP: 0xac87045
*apfLbsTask: May 02 11:29:35.900: 00:27:10:95:59:a4 Copy CCX LOCP 4
*apfLbsTask: May 02 11:29:35.900: 00:27:10:95:59:a4 Copy e2e LOCP 0x1
*apfLbsTask: May 02 11:29:35.900: 00:27:10:95:59:a4 Copy MobilityData LOCP status:1, anchorip:0x0
*apfMsConnTask_5: May 02 11:44:04.820: 00:27:10:95:59:a4 Association received from mobile on AP 2c:36:f8:0c:c3:90
*apfMsConnTask_5: May 02 11:44:04.820: 00:27:10:95:59:a4 10.200.xxx.69 RUN (20) Changing ACL 'none' (ACL ID 255) ===> 'none' (ACL ID 255) --- (caller apf_policy.c:1626)
*apfMsConnTask_5: May 02 11:44:04.820: 00:27:10:95:59:a4 Applying site-specific IPv6 override for station 00:27:10:95:59:a4 - vapId 7, site 'default-group', interface 'corporate wireless'
*apfMsConnTask_5: May 02 11:44:04.820: 00:27:10:95:59:a4 Applying IPv6 Interface Policy for station 00:27:10:95:59:a4 - vlan 7, interface id 11, interface 'corporate wireless'
*apfMsConnTask_5: May 02 11:44:04.820: 00:27:10:95:59:a4 STA - rates (6): 152 36 48 72 96 108 0 0 0 0 0 0 0 0 0 0
*apfMsConnTask_5: May 02 11:44:04.820: 00:27:10:95:59:a4 Processing WPA IE type 221, length 24 for mobile 00:27:10:95:59:a4
*apfMsConnTask_5: May 02 11:44:04.820: 00:27:10:95:59:a4 apfMsRunStateDec
*apfMsConnTask_5: May 02 11:44:04.820: 00:27:10:95:59:a4 apfMs1xStateDec
*apfMsConnTask_5: May 02 11:44:04.820: 00:27:10:95:59:a4 10.200.xxx.69 RUN (20) Change state to START (0) last state RUN (20)

*apfMsConnTask_5: May 02 11:44:04.820: 00:27:10:95:59:a4 10.200.xxx.69 START (0) Initializing policy
*apfMsConnTask_5: May 02 11:44:04.820: 00:27:10:95:59:a4 10.200.xxx.69 START (0) Change state to AUTHCHECK (2) last state RUN (20)

*apfMsConnTask_5: May 02 11:44:04.820: 00:27:10:95:59:a4 10.200.xxx.69 AUTHCHECK (2) Change state to 8021X_REQD (3) last state RUN (20)

*pemReceiveTask: May 02 11:44:04.820: 00:27:10:95:59:a4 10.200.xxx.69 Removed NPU entry.
*apfMsConnTask_5: May 02 11:44:04.820: 00:27:10:95:59:a4 10.200.xxx.69 8021X_REQD (3) DHCP required on AP 2c:36:f8:0c:c3:90 vapId 7 apVapId 7for this client
*apfMsConnTask_5: May 02 11:44:04.820: 00:27:10:95:59:a4 Not Using WMM Compliance code qosCap 00
*apfMsConnTask_5: May 02 11:44:04.820: 00:27:10:95:59:a4 10.200.xxx.69 8021X_REQD (3) Plumbed mobile LWAPP rule on AP 2c:36:f8:0c:c3:90 vapId 7 apVapId 7
*apfMsConnTask_5: May 02 11:44:04.821: 00:27:10:95:59:a4 apfPemAddUser2 (apf_policy.c:223) Changing state for mobile 00:27:10:95:59:a4 on AP 2c:36:f8:0c:c3:90 from Associated to Associated

*apfMsConnTask_5: May 02 11:44:04.821: 00:27:10:95:59:a4 Stopping deletion of Mobile Station: (callerId: 48)
*apfMsConnTask_5: May 02 11:44:04.821: 00:27:10:95:59:a4 Sending Assoc Response to station on BSSID 2c:36:f8:0c:c3:90 (status 0) ApVapId 7 Slot 1
*apfMsConnTask_5: May 02 11:44:04.821: 00:27:10:95:59:a4 apfProcessAssocReq (apf_80211.c:5237) Changing state for mobile 00:27:10:95:59:a4 on AP 2c:36:f8:0c:c3:90 from Associated to Associated

*dot1xMsgTask: May 02 11:44:04.822: 00:27:10:95:59:a4 dot1x - moving mobile 00:27:10:95:59:a4 into Connecting state
*dot1xMsgTask: May 02 11:44:04.822: 00:27:10:95:59:a4 Sending EAP-Request/Identity to mobile 00:27:10:95:59:a4 (EAP Id 1)
*Dot1x_NW_MsgTask_4: May 02 11:44:04.826: 00:27:10:95:59:a4 Received EAPOL EAPPKT from mobile 00:27:10:95:59:a4
*Dot1x_NW_MsgTask_4: May 02 11:44:04.826: 00:27:10:95:59:a4 Received Identity Response (count=1) from mobile 00:27:10:95:59:a4
*Dot1x_NW_MsgTask_4: May 02 11:44:04.826: 00:27:10:95:59:a4 EAP State update from Connecting to Authenticating for mobile 00:27:10:95:59:a4
*Dot1x_NW_MsgTask_4: May 02 11:44:04.826: 00:27:10:95:59:a4 dot1x - moving mobile 00:27:10:95:59:a4 into Authenticating state
*Dot1x_NW_MsgTask_4: May 02 11:44:04.826: 00:27:10:95:59:a4 Entering Backend Auth Response state for mobile 00:27:10:95:59:a4
*Dot1x_NW_MsgTask_4: May 02 11:44:04.831: 00:27:10:95:59:a4 Processing Access-Challenge for mobile 00:27:10:95:59:a4
*Dot1x_NW_MsgTask_4: May 02 11:44:04.831: 00:27:10:95:59:a4 Entering Backend Auth Req state (id=2) for mobile 00:27:10:95:59:a4
*Dot1x_NW_MsgTask_4: May 02 11:44:04.831: 00:27:10:95:59:a4 Sending EAP Request from AAA to mobile 00:27:10:95:59:a4 (EAP Id 2)
*Dot1x_NW_MsgTask_4: May 02 11:44:04.834: 00:27:10:95:59:a4 Received EAPOL EAPPKT from mobile 00:27:10:95:59:a4
*Dot1x_NW_MsgTask_4: May 02 11:44:04.834: 00:27:10:95:59:a4 Received EAP Response from mobile 00:27:10:95:59:a4 (EAP Id 2, EAP Type 21)
*Dot1x_NW_MsgTask_4: May 02 11:44:04.834: 00:27:10:95:59:a4 Entering Backend Auth Response state for mobile 00:27:10:95:59:a4
*Dot1x_NW_MsgTask_4: May 02 11:44:04.849: 00:27:10:95:59:a4 Processing Access-Challenge for mobile 00:27:10:95:59:a4
*Dot1x_NW_MsgTask_4: May 02 11:44:04.849: 00:27:10:95:59:a4 Entering Backend Auth Req state (id=3) for mobile 00:27:10:95:59:a4
*Dot1x_NW_MsgTask_4: May 02 11:44:04.849: 00:27:10:95:59:a4 Sending EAP Request from AAA to mobile 00:27:10:95:59:a4 (EAP Id 3)
*Dot1x_NW_MsgTask_4: May 02 11:44:04.852: 00:27:10:95:59:a4 Received EAPOL EAPPKT from mobile 00:27:10:95:59:a4
*Dot1x_NW_MsgTask_4: May 02 11:44:04.852: 00:27:10:95:59:a4 Received EAP Response from mobile 00:27:10:95:59:a4 (EAP Id 3, EAP Type 21)
*Dot1x_NW_MsgTask_4: May 02 11:44:04.852: 00:27:10:95:59:a4 Entering Backend Auth Response state for mobile 00:27:10:95:59:a4
*Dot1x_NW_MsgTask_4: May 02 11:44:04.856: 00:27:10:95:59:a4 Processing Access-Challenge for mobile 00:27:10:95:59:a4
*Dot1x_NW_MsgTask_4: May 02 11:44:04.856: 00:27:10:95:59:a4 Entering Backend Auth Req state (id=4) for mobile 00:27:10:95:59:a4
*Dot1x_NW_MsgTask_4: May 02 11:44:04.856: 00:27:10:95:59:a4 Sending EAP Request from AAA to mobile 00:27:10:95:59:a4 (EAP Id 4)
*Dot1x_NW_MsgTask_4: May 02 11:44:04.861: 00:27:10:95:59:a4 Received EAPOL EAPPKT from mobile 00:27:10:95:59:a4
*Dot1x_NW_MsgTask_4: May 02 11:44:04.861: 00:27:10:95:59:a4 Received EAP Response from mobile 00:27:10:95:59:a4 (EAP Id 4, EAP Type 21)
*Dot1x_NW_MsgTask_4: May 02 11:44:04.861: 00:27:10:95:59:a4 Entering Backend Auth Response state for mobile 00:27:10:95:59:a4
*Dot1x_NW_MsgTask_4: May 02 11:44:04.870: 00:27:10:95:59:a4 Processing Access-Challenge for mobile 00:27:10:95:59:a4
*Dot1x_NW_MsgTask_4: May 02 11:44:04.870: 00:27:10:95:59:a4 Entering Backend Auth Req state (id=5) for mobile 00:27:10:95:59:a4
*Dot1x_NW_MsgTask_4: May 02 11:44:04.870: 00:27:10:95:59:a4 Sending EAP Request from AAA to mobile 00:27:10:95:59:a4 (EAP Id 5)
*Dot1x_NW_MsgTask_4: May 02 11:44:04.872: 00:27:10:95:59:a4 Received EAPOL EAPPKT from mobile 00:27:10:95:59:a4
*Dot1x_NW_MsgTask_4: May 02 11:44:04.872: 00:27:10:95:59:a4 Received EAP Response from mobile 00:27:10:95:59:a4 (EAP Id 5, EAP Type 21)
*Dot1x_NW_MsgTask_4: May 02 11:44:04.872: 00:27:10:95:59:a4 Entering Backend Auth Response state for mobile 00:27:10:95:59:a4
*Dot1x_NW_MsgTask_4: May 02 11:44:04.896: 00:27:10:95:59:a4 Processing Access-Challenge for mobile 00:27:10:95:59:a4
*Dot1x_NW_MsgTask_4: May 02 11:44:04.896: 00:27:10:95:59:a4 Entering Backend Auth Req state (id=6) for mobile 00:27:10:95:59:a4
*Dot1x_NW_MsgTask_4: May 02 11:44:04.896: 00:27:10:95:59:a4 Sending EAP Request from AAA to mobile 00:27:10:95:59:a4 (EAP Id 6)
*Dot1x_NW_MsgTask_4: May 02 11:44:04.898: 00:27:10:95:59:a4 Received EAPOL EAPPKT from mobile 00:27:10:95:59:a4
*Dot1x_NW_MsgTask_4: May 02 11:44:04.898: 00:27:10:95:59:a4 Received EAP Response from mobile 00:27:10:95:59:a4 (EAP Id 6, EAP Type 21)
*Dot1x_NW_MsgTask_4: May 02 11:44:04.898: 00:27:10:95:59:a4 Entering Backend Auth Response state for mobile 00:27:10:95:59:a4
*Dot1x_NW_MsgTask_4: May 02 11:44:04.904: 00:27:10:95:59:a4 Processing Access-Accept for mobile 00:27:10:95:59:a4
*Dot1x_NW_MsgTask_4: May 02 11:44:04.904: 00:27:10:95:59:a4 Resetting web acl from 255 to 255

*Dot1x_NW_MsgTask_4: May 02 11:44:04.904: 00:27:10:95:59:a4 Setting re-auth timeout to 0 seconds, got from WLAN config.
*Dot1x_NW_MsgTask_4: May 02 11:44:04.904: 00:27:10:95:59:a4 Station 00:27:10:95:59:a4 setting dot1x reauth timeout = 0
*Dot1x_NW_MsgTask_4: May 02 11:44:04.904: 00:27:10:95:59:a4 Stopping reauth timeout for 00:27:10:95:59:a4
*Dot1x_NW_MsgTask_4: May 02 11:44:04.904: 00:27:10:95:59:a4 Creating a PKC PMKID Cache entry for station 00:27:10:95:59:a4 (RSN 0)
*Dot1x_NW_MsgTask_4: May 02 11:44:04.904: 00:27:10:95:59:a4 Sending EAP-Success to mobile 00:27:10:95:59:a4 (EAP Id 6)
*Dot1x_NW_MsgTask_4: May 02 11:44:04.904: 00:27:10:95:59:a4 Starting key exchange to mobile 00:27:10:95:59:a4, data packets will be dropped
*Dot1x_NW_MsgTask_4: May 02 11:44:04.904: 00:27:10:95:59:a4 Sending EAPOL-Key Message to mobile 00:27:10:95:59:a4
                                                                                                                    state INITPMK (message 1), replay counter 00.00.00.00.00.00.00.00
*Dot1x_NW_MsgTask_4: May 02 11:44:04.904: 00:27:10:95:59:a4 Entering Backend Auth Success state (id=6) for mobile 00:27:10:95:59:a4
*Dot1x_NW_MsgTask_4: May 02 11:44:04.904: 00:27:10:95:59:a4 Received Auth Success while in Authenticating state for mobile 00:27:10:95:59:a4
*Dot1x_NW_MsgTask_4: May 02 11:44:04.904: 00:27:10:95:59:a4 dot1x - moving mobile 00:27:10:95:59:a4 into Authenticated state
*Dot1x_NW_MsgTask_4: May 02 11:44:04.906: 00:27:10:95:59:a4 Received EAPOL-Key from mobile 00:27:10:95:59:a4
*Dot1x_NW_MsgTask_4: May 02 11:44:04.906: 00:27:10:95:59:a4 Received EAPOL-key in PTK_START state (message 2) from mobile 00:27:10:95:59:a4
*Dot1x_NW_MsgTask_4: May 02 11:44:04.906: 00:27:10:95:59:a4 Stopping retransmission timer for mobile 00:27:10:95:59:a4
*Dot1x_NW_MsgTask_4: May 02 11:44:04.906: 00:27:10:95:59:a4 Sending EAPOL-Key Message to mobile 00:27:10:95:59:a4
                                                                                                                    state PTKINITNEGOTIATING (message 3), replay counter 00.00.00.00.00.00.00.01
*Dot1x_NW_MsgTask_4: May 02 11:44:04.908: 00:27:10:95:59:a4 Received EAPOL-Key from mobile 00:27:10:95:59:a4
*Dot1x_NW_MsgTask_4: May 02 11:44:04.908: 00:27:10:95:59:a4 Received EAPOL-key in PTKINITNEGOTIATING state (message 4) from mobile 00:27:10:95:59:a4
*Dot1x_NW_MsgTask_4: May 02 11:44:04.908: 00:27:10:95:59:a4 apfMs1xStateInc
*Dot1x_NW_MsgTask_4: May 02 11:44:04.908: 00:27:10:95:59:a4 10.200.xxx.69 8021X_REQD (3) Change state to L2AUTHCOMPLETE (4) last state RUN (20)

*Dot1x_NW_MsgTask_4: May 02 11:44:04.908: 00:27:10:95:59:a4 10.200.xxx.69 L2AUTHCOMPLETE (4) DHCP required on AP 2c:36:f8:0c:c3:90 vapId 7 apVapId 7for this client
*Dot1x_NW_MsgTask_4: May 02 11:44:04.908: 00:27:10:95:59:a4 Not Using WMM Compliance code qosCap 00
*Dot1x_NW_MsgTask_4: May 02 11:44:04.908: 00:27:10:95:59:a4 10.200.xxx.69 L2AUTHCOMPLETE (4) Plumbed mobile LWAPP rule on AP 2c:36:f8:0c:c3:90 vapId 7 apVapId 7
*Dot1x_NW_MsgTask_4: May 02 11:44:04.908: 00:27:10:95:59:a4 apfMsRunStateInc
*Dot1x_NW_MsgTask_4: May 02 11:44:04.908: 00:27:10:95:59:a4 10.200.xxx.69 L2AUTHCOMPLETE (4) Change state to RUN (20) last state RUN (20)

*Dot1x_NW_MsgTask_4: May 02 11:44:04.908: 00:27:10:95:59:a4 10.200.xxx.69 RUN (20) Reached PLUMBFASTPATH: from line 4918
*Dot1x_NW_MsgTask_4: May 02 11:44:04.908: 00:27:10:95:59:a4 10.200.xxx.69 RUN (20) Adding Fast Path rule
  type = Airespace AP Client
  on AP 2c:36:f8:0c:c3:90, slot 1, interface = 13, QOS = 0
  ACL Id = 255, Jumbo Frames = NO
*Dot1x_NW_MsgTask_4: May 02 11:44:04.908: 00:27:10:95:59:a4 10.200.xxx.69 RUN (20) Fast Path rule (contd...) 802.1P = 3, DSCP = 0, TokenID = 7006  IPv6 Vlan = 7, IPv6 intf id = 11
*Dot1x_NW_MsgTask_4: May 02 11:44:04.908: 00:27:10:95:59:a4 10.200.xxx.69 RUN (20) Successfully plumbed mobile rule (ACL ID 255)
*Dot1x_NW_MsgTask_4: May 02 11:44:04.908: 00:27:10:95:59:a4 Stopping retransmission timer for mobile 00:27:10:95:59:a4
*Dot1x_NW_MsgTask_4: May 02 11:44:04.908: 00:27:10:95:59:a4 Key exchange done, data packets from mobile 00:27:10:95:59:a4 should be forwarded shortly
*Dot1x_NW_MsgTask_4: May 02 11:44:04.908: 00:27:10:95:59:a4 Sending EAPOL-Key Message to mobile 00:27:10:95:59:a4
                                                                                                                    state PTKINITDONE (message 5 - group), replay counter 00.00.00.00.00.00.00.02
*pemReceiveTask: May 02 11:44:04.909: 00:27:10:95:59:a4 10.200.xxx.69 Added NPU entry of type 1, dtlFlags 0x0
*spamApTask6: May 02 11:44:04.909: 00:27:10:95:59:a4 Sent EAPOL-Key M5 for mobile 00:27:10:95:59:a4
*Dot1x_NW_MsgTask_4: May 02 11:44:04.911: 00:27:10:95:59:a4 Received EAPOL-Key from mobile 00:27:10:95:59:a4
*Dot1x_NW_MsgTask_4: May 02 11:44:04.911: 00:27:10:95:59:a4 Received EAPOL-key in REKEYNEGOTIATING state (message 6) from mobile 00:27:10:95:59:a4
*Dot1x_NW_MsgTask_4: May 02 11:44:04.911: 00:27:10:95:59:a4 Stopping retransmission timer for mobile 00:27:10:95:59:a4
*apfLbsTask: May 02 11:44:08.032: 00:27:10:95:59:a4 Copy AP LOCP - mode:0 slotId:1, apMac 0x2c:36:f8:c:c3:90
*apfLbsTask: May 02 11:44:08.032: 00:27:10:95:59:a4 Copy WLAN LOCP EssIndex:7 aid:11 ssid:  bpwlan
*apfLbsTask: May 02 11:44:08.032: 00:27:10:95:59:a4 Copy Security LOCP ecypher:0x1 ptype:0x1, p:0x0, eaptype:0x1 w:0x1 aalg:0x0, PMState:        RUN
*apfLbsTask: May 02 11:44:08.032: 00:27:10:95:59:a4 Copy 802.11 LOCP a:0x0 b:0x0 c:0x0 d:0x0 e:0x0 protocol2:0x1 statuscode 0, reasoncode 1, status 3
*apfLbsTask: May 02 11:44:08.032: 00:27:10:95:59:a4 Copy Username LOCP : xxxxxx\xxxxxx
*apfLbsTask: May 02 11:44:08.032: 00:27:10:95:59:a4 Copy IP LOCP: 0xac87045
*apfLbsTask: May 02 11:44:08.032: 00:27:10:95:59:a4 Copy CCX LOCP 4
*apfLbsTask: May 02 11:44:08.032: 00:27:10:95:59:a4 Copy e2e LOCP 0x1
*apfLbsTask: May 02 11:44:08.032: 00:27:10:95:59:a4 Copy MobilityData LOCP status:1, anchorip:0x0
*DHCP Socket Task: May 02 11:44:14.737: 00:27:10:95:59:a4 DHCP received op BOOTREQUEST (1) (len 338,vlan 6, port 13, encap 0xec03)
*DHCP Socket Task: May 02 11:44:14.738: 00:27:10:95:59:a4 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: May 02 11:44:14.738: 00:27:10:95:59:a4 DHCP selected relay 1 - 10.200.xxx.10 (local address 10.200.xxx.10, gateway 10.200.xxx.1, VLAN 7, port 13)
*DHCP Socket Task: May 02 11:44:14.738: 00:27:10:95:59:a4 DHCP transmitting DHCP REQUEST (3)
*DHCP Socket Task: May 02 11:44:14.738: 00:27:10:95:59:a4 DHCP   op: BOOTREQUEST, htype: Ethernet, hlen: 6, hops: 1
*DHCP Socket Task: May 02 11:44:14.738: 00:27:10:95:59:a4 DHCP   xid: 0x7db89790 (2109249424), secs: 0, flags: 0
*DHCP Socket Task: May 02 11:44:14.738: 00:27:10:95:59:a4 DHCP   chaddr: 00:27:10:95:59:a4
*DHCP Socket Task: May 02 11:44:14.738: 00:27:10:95:59:a4 DHCP   ciaddr: 0.0.0.0,  yiaddr: 0.0.0.0
*DHCP Socket Task: May 02 11:44:14.738: 00:27:10:95:59:a4 DHCP   siaddr: 0.0.0.0,  giaddr: 10.200.xxx.10
*DHCP Socket Task: May 02 11:44:14.738: 00:27:10:95:59:a4 DHCP   requested ip: 10.200.xxx.69
*DHCP Socket Task: May 02 11:44:14.738: 00:27:10:95:59:a4 DHCP sending REQUEST to 10.200.xxx.1 (len 382, port 13, vlan 7)
*DHCP Socket Task: May 02 11:44:14.738: 00:27:10:95:59:a4 DHCP selecting relay 2 - control block settings:
                        dhcpServer: 0.0.0.0, dhcpNetmask: 0.0.0.0,
                        dhcpGateway: 0.0.0.0, dhcpRelay: 10.200.xxx.10  VLAN: 7
*DHCP Socket Task: May 02 11:44:14.738: 00:27:10:95:59:a4 DHCP selected relay 2 - NONE
*DHCP Socket Task: May 02 11:44:14.741: 00:27:10:95:59:a4 DHCP received op BOOTREPLY (2) (len 394,vlan 7, port 13, encap 0xec00)
*DHCP Socket Task: May 02 11:44:14.741: 00:27:10:95:59:a4 DHCP setting server from ACK (server 10.200.xxx.10, yiaddr 10.200.xxx.69)
*DHCP Socket Task: May 02 11:44:14.741: 00:27:10:95:59:a4 DHCP sending REPLY to STA (len 506, port 13, vlan 6)
*DHCP Socket Task: May 02 11:44:14.741: 00:27:10:95:59:a4 DHCP transmitting DHCP ACK (5)
*DHCP Socket Task: May 02 11:44:14.741: 00:27:10:95:59:a4 DHCP   op: BOOTREPLY, htype: Ethernet, hlen: 6, hops: 0
*DHCP Socket Task: May 02 11:44:14.741: 00:27:10:95:59:a4 DHCP   xid: 0x7db89790 (2109249424), secs: 0, flags: 0
*DHCP Socket Task: May 02 11:44:14.742: 00:27:10:95:59:a4 DHCP   chaddr: 00:27:10:95:59:a4
*DHCP Socket Task: May 02 11:44:14.742: 00:27:10:95:59:a4 DHCP   ciaddr: 0.0.0.0,  yiaddr: 10.200.xxx.69
*DHCP Socket Task: May 02 11:44:14.742: 00:27:10:95:59:a4 DHCP   siaddr: 0.0.0.0,  giaddr: 0.0.0.0
*DHCP Socket Task: May 02 11:44:14.742: 00:27:10:95:59:a4 DHCP   server id: 1.1.2.1  rcvd server id: 10.200.xxx.10
*apfMsConnTask_5: May 02 11:46:32.811: 00:27:10:95:59:a4 Association received from mobile on AP 2c:36:f8:0c:c3:90
*apfMsConnTask_5: May 02 11:46:32.811: 00:27:10:95:59:a4 10.200.xxx.69 RUN (20) Changing ACL 'none' (ACL ID 255) ===> 'none' (ACL ID 255) --- (caller apf_policy.c:1626)
*apfMsConnTask_5: May 02 11:46:32.811: 00:27:10:95:59:a4 Applying site-specific IPv6 override for station 00:27:10:95:59:a4 - vapId 7, site 'default-group', interface 'corporate wireless'
*apfMsConnTask_5: May 02 11:46:32.811: 00:27:10:95:59:a4 Applying IPv6 Interface Policy for station 00:27:10:95:59:a4 - vlan 7, interface id 11, interface 'corporate wireless'
*apfMsConnTask_5: May 02 11:46:32.811: 00:27:10:95:59:a4 STA - rates (6): 152 36 48 72 96 108 0 0 0 0 0 0 0 0 0 0
*apfMsConnTask_5: May 02 11:46:32.811: 00:27:10:95:59:a4 Processing WPA IE type 221, length 24 for mobile 00:27:10:95:59:a4
*apfMsConnTask_5: May 02 11:46:32.811: 00:27:10:95:59:a4 apfMsRunStateDec
*apfMsConnTask_5: May 02 11:46:32.811: 00:27:10:95:59:a4 apfMs1xStateDec
*apfMsConnTask_5: May 02 11:46:32.811: 00:27:10:95:59:a4 10.200.xxx.69 RUN (20) Change state to START (0) last state RUN (20)

*apfMsConnTask_5: May 02 11:46:32.812: 00:27:10:95:59:a4 10.200.xxx.69 START (0) Initializing policy
*apfMsConnTask_5: May 02 11:46:32.812: 00:27:10:95:59:a4 10.200.xxx.69 START (0) Change state to AUTHCHECK (2) last state RUN (20)

*apfMsConnTask_5: May 02 11:46:32.812: 00:27:10:95:59:a4 10.200.xxx.69 AUTHCHECK (2) Change state to 8021X_REQD (3) last state RUN (20)

*apfMsConnTask_5: May 02 11:46:32.812: 00:27:10:95:59:a4 10.200.xxx.69 8021X_REQD (3) DHCP required on AP 2c:36:f8:0c:c3:90 vapId 7 apVapId 7for this client
*apfMsConnTask_5: May 02 11:46:32.812: 00:27:10:95:59:a4 Not Using WMM Compliance code qosCap 00
*apfMsConnTask_5: May 02 11:46:32.812: 00:27:10:95:59:a4 10.200.xxx.69 8021X_REQD (3) Plumbed mobile LWAPP rule on AP 2c:36:f8:0c:c3:90 vapId 7 apVapId 7
*apfMsConnTask_5: May 02 11:46:32.812: 00:27:10:95:59:a4 apfPemAddUser2 (apf_policy.c:223) Changing state for mobile 00:27:10:95:59:a4 on AP 2c:36:f8:0c:c3:90 from Associated to Associated

*apfMsConnTask_5: May 02 11:46:32.812: 00:27:10:95:59:a4 Stopping deletion of Mobile Station: (callerId: 48)
*apfMsConnTask_5: May 02 11:46:32.812: 00:27:10:95:59:a4 Sending Assoc Response to station on BSSID 2c:36:f8:0c:c3:90 (status 0) ApVapId 7 Slot 1
*apfMsConnTask_5: May 02 11:46:32.812: 00:27:10:95:59:a4 apfProcessAssocReq (apf_80211.c:5237) Changing state for mobile 00:27:10:95:59:a4 on AP 2c:36:f8:0c:c3:90 from Associated to Associated

Everyone's tags (2)
3 REPLIES
Silver

Clients disconnecting randoming..

What kind of client device is it? Is this seen on only one device type or multiple?

New Member

Re: Clients disconnecting randoming..

Seeing it on a few random clients (10 or less HP laptops), but the visibility is much more than normal, since we just went live with a new application that our entire hospital is reliant on. I'm not seeing anything in the debugs that are pointing to an issue though.

Clients disconnecting randoming..

from that debug, the cleint was in a run state, then there was an EAPOL Start message.

As Blake had asked, what type of device is it?  specifically what is the WNIC and driver versions?

Wireless drivers do not get updated with the standard windows update.

Steve

HTH, Steve ------------------------------------------------------------------------------------------------ Please remember to rate useful posts, and mark questions as answered
514
Views
0
Helpful
3
Replies