How can I figure out (and fix) constant dauth/disassociation?

[Wayne Werner]

Hi,

I'm running hostapd on a Raspberry Pi 2 B+ on Raspbian 8, installed from 
the default apt repo.

Most of the time the wifi works perfectly. The first day things went 
pretty swell, but I was getting `deauthenticated due to local deauth 
request` pretty consistently. I tried [installing havege][1], because 
`/proc/sys/kernel/random/entropy_avail` had < 500, but that didn't really 
seem to have an effect (aside from keeping my entropy_avail > 1000). Then 
I learned that TKIP was not very secure, so I changed my config to use 
CCMP. Yet I still get fairly frequent disassociation problems, like so:

Nov 25 05:20:23 raspberrypi hostapd: wlan0: STA cc:6d:a0:2c:00:b1 IEEE 
802.11: associated
Nov 25 05:20:23 raspberrypi hostapd: wlan0: STA cc:6d:a0:2c:00:b1 WPA: 
event 1 notification
Nov 25 05:20:23 raspberrypi hostapd: wlan0: STA cc:6d:a0:2c:00:b1 WPA: 
start authentication
Nov 25 05:20:23 raspberrypi hostapd: wlan0: STA cc:6d:a0:2c:00:b1 IEEE 
802.1X: unauthorizing port
Nov 25 05:20:23 raspberrypi hostapd: wlan0: STA cc:6d:a0:2c:00:b1 WPA: 
sending 1/4 msg of 4-Way Handshake
Nov 25 05:20:23 raspberrypi hostapd: wlan0: STA cc:6d:a0:2c:00:b1 WPA: 
EAPOL-Key timeout
Nov 25 05:20:23 raspberrypi hostapd: wlan0: STA cc:6d:a0:2c:00:b1 WPA: 
sending 1/4 msg of 4-Way Handshake
Nov 25 05:20:24 raspberrypi hostapd: wlan0: STA cc:6d:a0:2c:00:b1 WPA: 
EAPOL-Key timeout
Nov 25 05:20:24 raspberrypi hostapd: wlan0: STA cc:6d:a0:2c:00:b1 WPA: 
sending 1/4 msg of 4-Way Handshake
Nov 25 05:20:25 raspberrypi hostapd: wlan0: STA cc:6d:a0:2c:00:b1 WPA: 
EAPOL-Key timeout
Nov 25 05:20:25 raspberrypi hostapd: wlan0: STA cc:6d:a0:2c:00:b1 WPA: 
sending 1/4 msg of 4-Way Handshake
Nov 25 05:20:26 raspberrypi hostapd: wlan0: STA cc:6d:a0:2c:00:b1 WPA: 
EAPOL-Key timeout
Nov 25 05:20:26 raspberrypi hostapd: wlan0: STA cc:6d:a0:2c:00:b1 WPA: 
PTKSTART: Retry limit 4 reached
Nov 25 05:20:26 raspberrypi hostapd: wlan0: STA cc:6d:a0:2c:00:b1 WPA: 
event 3 notification
Nov 25 05:20:26 raspberrypi hostapd: wlan0: STA cc:6d:a0:2c:00:b1 IEEE 
802.1X: unauthorizing port
Nov 25 05:20:26 raspberrypi hostapd: wlan0: STA cc:6d:a0:2c:00:b1 MLME: 
MLME-DEAUTHENTICATE.indication(cc:6d:a0:2c:00:b1, 2)
Nov 25 05:20:26 raspberrypi hostapd: wlan0: STA cc:6d:a0:2c:00:b1 MLME: 
MLME-DELETEKEYS.request(cc:6d:a0:2c:00:b1)
Nov 25 05:20:31 raspberrypi hostapd: wlan0: STA cc:6d:a0:2c:00:b1 IEEE 
802.11: deauthenticated due to local deauth request
Nov 25 05:20:35 raspberrypi hostapd: wlan0: STA cc:6d:a0:2c:00:b1 IEEE 
802.11: disassociated
Nov 25 05:20:38 raspberrypi hostapd: wlan0: STA cc:6d:a0:2c:00:b1 IEEE 
802.11: associated
Nov 25 05:20:38 raspberrypi hostapd: wlan0: STA cc:6d:a0:2c:00:b1 WPA: 
event 1 notification
Nov 25 05:20:38 raspberrypi hostapd: wlan0: STA cc:6d:a0:2c:00:b1 WPA: 
start authentication
Nov 25 05:20:38 raspberrypi hostapd: wlan0: STA cc:6d:a0:2c:00:b1 IEEE 
802.1X: unauthorizing port
Nov 25 05:20:38 raspberrypi hostapd: wlan0: STA cc:6d:a0:2c:00:b1 WPA: 
sending 1/4 msg of 4-Way Handshake
Nov 25 05:20:38 raspberrypi hostapd: wlan0: STA cc:6d:a0:2c:00:b1 WPA: 
EAPOL-Key timeout
Nov 25 05:20:38 raspberrypi hostapd: wlan0: STA cc:6d:a0:2c:00:b1 WPA: 
sending 1/4 msg of 4-Way Handshake
Nov 25 05:20:39 raspberrypi hostapd: wlan0: STA cc:6d:a0:2c:00:b1 WPA: 
EAPOL-Key timeout
Nov 25 05:20:39 raspberrypi hostapd: wlan0: STA cc:6d:a0:2c:00:b1 WPA: 
sending 1/4 msg of 4-Way Handshake
Nov 25 05:20:40 raspberrypi hostapd: wlan0: STA cc:6d:a0:2c:00:b1 WPA: 
EAPOL-Key timeout
Nov 25 05:20:40 raspberrypi hostapd: wlan0: STA cc:6d:a0:2c:00:b1 WPA: 
sending 1/4 msg of 4-Way Handshake
Nov 25 05:20:41 raspberrypi hostapd: wlan0: STA cc:6d:a0:2c:00:b1 WPA: 
EAPOL-Key timeout
Nov 25 05:20:41 raspberrypi hostapd: wlan0: STA cc:6d:a0:2c:00:b1 WPA: 
PTKSTART: Retry limit 4 reached
Nov 25 05:20:41 raspberrypi hostapd: wlan0: STA cc:6d:a0:2c:00:b1 WPA: 
event 3 notification
Nov 25 05:20:41 raspberrypi hostapd: wlan0: STA cc:6d:a0:2c:00:b1 IEEE 
802.1X: unauthorizing port
Nov 25 05:20:41 raspberrypi hostapd: wlan0: STA cc:6d:a0:2c:00:b1 MLME: 
MLME-DEAUTHENTICATE.indication(cc:6d:a0:2c:00:b1, 2)
Nov 25 05:20:41 raspberrypi hostapd: wlan0: STA cc:6d:a0:2c:00:b1 MLME: 
MLME-DELETEKEYS.request(cc:6d:a0:2c:00:b1)

Typically it resolves itself after 3-5 minutes, but then the issue will 
resurface some time later - maybe 30-60 minutes.

My hostapd.conf looks like this:

# hostapd.conf
interface=wlan0
ssid=myssid
channel=1
macaddr_acl=0
auth_algs=1
ignore_broadcast_ssid=0
wpa=3
wpa_passphrase=mysecretpassphrase
wpa_key_mgmt=WPA-PSK
wpa_pairwise=CCMP
rsn_pairwise=CCMP
logger_syslog_level=1
driver=nl80211
ieee80211n=1
hw_mode=g
device_name=RTL8192CU
manufacturer=Realtek
ap_max_inactivity=1000
disassoc_low_ack=0
#####


Another interesting fact - when I restart hostapd then the wifi is usually 
just fine for at least a few minutes (maybe tens of minutes).

I've been searching Google for several days, but I haven't really been 
able to identify what's actually causing my issue (just a bunch of people 
who seem to have similar issues, though in most cases they can't connect 
at all).

Any clue what I could do to figure out the root cause of my problem?

Thanks!
Wayne

[1]: http://stackoverflow.com/a/38173266/344286