Hi, [This is a follow on to the thread entitled Limit rate of BCM34348 on Raspberry PI-3 via brcmfmac, but since our understanding of the issue has changed we are starting a new thread.] We have been attempting to get a Raspberry PI-3 (RPI3) to operate concurrently as both a STA and an AP. When we associate a Nexus-6 with the RPI3's AP ing the Nexus-6 from the RPI3 we see no ping loss. We then connect the RPI3 as a station with a Cisco Linksys E1200. As soon as we do this the over 90% of the ping messages are dropped between the RPI3 and the Nexus-6. If we then kill the wpa_supplicant on the RPI-3, the pings again operate with loss. In debugging this problem we see: 1. The Nexus-6 lose it association with the RPI3. This generally recovers and does not seem to be the cause of the delay/loss of the pings. 2. A tcpdump taken on the RPI3 will shows the expected number of ICMP echo requests, but will not show the expected number of ICMP echo responses. 3. When captured "in the air" from a third device using a WiFi adapter (Aircrack-ng using monitor mode) we do not see the expected number of ICMP echo requests. A trace is attached. We noticed that not all devices when acting as clients of the RPI3's AP had this problem. After some investigation we discovered that if we disabled wifi power management on these devices that we not see the loss of the pings. We then disabled (Blacklisted the brcmfmac) and added an external dongle (TP-LINK TL-WN722N) and repeated the tests. When this dongle was used we did not see the associated packet loss on the RPI3's AP. Throughout the testing all communications have been in channel 1 to ensure that the AP and the STA can work together and Bluetooth was disabled. At this point we are a bit lost as what to do next. We need a solution that does not require us to configure the client device which is being used to connect to the AP. We are also not able to use an external Wifi dongle. We would appreciate guidance in terms of what we could try, as well as insight into the nature of the issue. Below are some configuration details: Components in the test system: 1. Cisco Linksys E1200 which is connected to the ethernet and provides the AP to which the RPI-3 connects 2. A RPI-3 (Raspian 8.0, with Kernel 4.4.10-v7+, brcfmac 7.45.41.23 firmware 01-cc4eda9c) 3. A Google Nexus-6 running Android 6.0.1, and JuiceSSH 2.1.2 Configuration of the RPI3: cat /etc/os-release PRETTY_NAME="Raspbian GNU/Linux 8 (jessie)" NAME="Raspbian GNU/Linux" VERSION_ID="8" VERSION="8 (jessie)" ID=raspbian ID_LIKE=debian HOME_URL="http://www.raspbian.org/"; SUPPORT_URL="http://www.raspbian.org/RaspbianForums"; BUG_REPORT_URL="http://www.raspbian.org/RaspbianBugs"; root@raspberrypi:/home/pi# uname -a Linux raspberrypi 4.4.10-v7+ #885 SMP Fri May 13 15:44:27 BST 2016 armv7l GNU/Linux host apd configuration root@raspberrypi:/home/pi# cat /etc/hostapd/hostapd.conf ctrl_interface=/var/run/hostapd interface=uap0 ssid=Health@Home Hub b827ebeb46b2 hw_mode=g channel=1 auth_algs=1 wpa=2 wpa_passphrase=juniperbranch wpa_key_mgmt=WPA-PSK wpa_pairwise=TKIP rsn_pairwise=CCMP wpa_supplicant configuration: root@raspberrypi:/home/pi# cat cisco.wpa network={ ssid="CISCO-Linksys-E1200" #psk="---------?" psk=2e06fdb031cfc0e0c58e56d61657bd9a7912769e1d7a6bead31f0db99455c071 } startup log: root@raspberrypi:/home/pi# May 16 22:02:58 raspberrypi hostapd[512]: uap0: STA 00:21:6a:67:b1:9a IEEE 802.11: associated May 16 22:02:58 raspberrypi hostapd[512]: uap0: STA 00:21:6a:67:b1:9a RADIUS: starting accounting session 573A40EE-00000000 May 16 22:02:58 raspberrypi hostapd[512]: uap0: STA 00:21:6a:67:b1:9a WPA: pairwise key handshake completed (RSN) May 16 22:03:01 raspberrypi dnsmasq-dhcp[446]: DHCPDISCOVER(uap0) 00:21:6a:67:b1:9a May 16 22:03:01 raspberrypi dnsmasq-dhcp[446]: DHCPOFFER(uap0) 192.168.2.78 00:21:6a:67:b1:9a May 16 22:03:01 raspberrypi dnsmasq-dhcp[446]: DHCPREQUEST(uap0) 192.168.2.78 00:21:6a:67:b1:9a May 16 22:03:01 raspberrypi dnsmasq-dhcp[446]: DHCPACK(uap0) 192.168.2.78 00:21:6a:67:b1:9a £[K root@raspberrypi:/home/pi# May 16 22:05:59 raspberrypi hostapd[512]: uap0: STA 9c:d9:17:6b:5e:20 IEEE 802.11: associated May 16 22:05:59 raspberrypi hostapd[512]: uap0: STA 9c:d9:17:6b:5e:20 RADIUS: starting accounting session 573A40EE-00000001 May 16 22:05:59 raspberrypi hostapd[512]: uap0: STA 9c:d9:17:6b:5e:20 WPA: pairwise key handshake completed (RSN) May 16 22:06:02 raspberrypi dnsmasq-dhcp[446]: DHCPDISCOVER(uap0) 9c:d9:17:6b:5e:20 May 16 22:06:02 raspberrypi dnsmasq-dhcp[446]: DHCPOFFER(uap0) 192.168.2.52 9c:d9:17:6b:5e:20 May 16 22:06:02 raspberrypi dnsmasq-dhcp[446]: DHCPREQUEST(uap0) 192.168.2.52 9c:d9:17:6b:5e:20 May 16 22:06:02 raspberrypi dnsmasq-dhcp[446]: DHCPACK(uap0) 192.168.2.52 9c:d9:17:6b:5e:20 android-72ac23268335f965 wpa_supplicant -i wlan0 -c cisco.wpa -d -t 1463436647.471216: wpa_supplicant v2.3 1463436647.478375: random: Trying to read entropy from /dev/random 1463436647.478484: Successfully initialized wpa_supplicant 1463436647.478524: Initializing interface 'wlan0' conf 'cisco.wpa' driver 'default' ctrl_interface 'N/A' bridge 'N/A' 1463436647.478590: Configuration file 'cisco.wpa' -> '/home/pi/cisco.wpa' 1463436647.478724: Reading configuration file '/home/pi/cisco.wpa' 1463436647.478921: Priority group 0 1463436647.478946: id=0 ssid='CISCO-Linksys-E1200' 1463436647.486093: rfkill: initial event: idx=0 type=1 op=0 soft=0 hard=0 1463436647.486139: rfkill: initial event: idx=1 type=2 op=0 soft=0 hard=0 1463436647.490290: nl80211: Using driver-based roaming 1463436647.490322: nl80211: TDLS supported 1463436647.490367: nl80211: Supported cipher 00-0f-ac:1 1463436647.490393: nl80211: Supported cipher 00-0f-ac:5 1463436647.490414: nl80211: Supported cipher 00-0f-ac:2 1463436647.490435: nl80211: Supported cipher 00-0f-ac:4 1463436647.490455: nl80211: Supported cipher 00-0f-ac:6 1463436647.490579: nl80211: Using driver-based off-channel TX 1463436647.490638: nl80211: Supported vendor command: vendor_id=0x1018 subcmd=1 1463436647.490687: nl80211: Use separate P2P group interface (driver advertised support) 1463436647.490709: nl80211: Enable multi-channel concurrent (driver advertised support) 1463436647.490730: nl80211: interface wlan0 in phy phy0 1463436647.491199: nl80211: Set mode ifindex 3 iftype 2 (STATION) 1463436647.491304: nl80211: Subscribe to mgmt frames with non-AP handle 0x564c5c08 1463436647.491347: nl80211: Register frame type=0xd0 (WLAN_FC_STYPE_ACTION) nl_handle=0x564c5c08 match=040a 1463436647.491427: nl80211: Register frame type=0xd0 (WLAN_FC_STYPE_ACTION) nl_handle=0x564c5c08 match=040b 1463436647.491503: nl80211: Register frame type=0xd0 (WLAN_FC_STYPE_ACTION) nl_handle=0x564c5c08 match=040c 1463436647.491578: nl80211: Register frame type=0xd0 (WLAN_FC_STYPE_ACTION) nl_handle=0x564c5c08 match=040d 1463436647.491651: nl80211: Register frame type=0xd0 (WLAN_FC_STYPE_ACTION) nl_handle=0x564c5c08 match=090a 1463436647.491725: nl80211: Register frame type=0xd0 (WLAN_FC_STYPE_ACTION) nl_handle=0x564c5c08 match=090b 1463436647.491799: nl80211: Register frame type=0xd0 (WLAN_FC_STYPE_ACTION) nl_handle=0x564c5c08 match=090c 1463436647.491872: nl80211: Register frame type=0xd0 (WLAN_FC_STYPE_ACTION) nl_handle=0x564c5c08 match=090d 1463436647.491951: nl80211: Register frame type=0xd0 (WLAN_FC_STYPE_ACTION) nl_handle=0x564c5c08 match=0409506f9a09 1463436647.492030: nl80211: Register frame type=0xd0 (WLAN_FC_STYPE_ACTION) nl_handle=0x564c5c08 match=7f506f9a09 1463436647.492234: nl80211: Register frame type=0xd0 (WLAN_FC_STYPE_ACTION) nl_handle=0x564c5c08 match=0801 1463436647.492313: nl80211: Register frame type=0xd0 (WLAN_FC_STYPE_ACTION) nl_handle=0x564c5c08 match=040e 1463436647.492403: nl80211: Register frame type=0xd0 (WLAN_FC_STYPE_ACTION) nl_handle=0x564c5c08 match=06 1463436647.492478: nl80211: Register frame type=0xd0 (WLAN_FC_STYPE_ACTION) nl_handle=0x564c5c08 match=0a07 1463436647.492552: nl80211: Register frame type=0xd0 (WLAN_FC_STYPE_ACTION) nl_handle=0x564c5c08 match=0a11 1463436647.493066: netlink: Operstate: ifindex=3 linkmode=1 (userspace-control), operstate=5 (IF_OPER_DORMANT) 1463436647.493610: nl80211: driver param='(null)' 1463436647.493644: Add interface wlan0 to a new radio phy0 1463436647.494422: nl80211: Regulatory information - country=00 1463436647.494458: nl80211: 2402-2472 @ 40 MHz 20 mBm 1463436647.494489: nl80211: 2457-2482 @ 40 MHz 20 mBm (no IR) 1463436647.494518: nl80211: 2474-2494 @ 20 MHz 20 mBm (no OFDM) (no IR) 1463436647.494547: nl80211: 5170-5250 @ 80 MHz 20 mBm (no IR) 1463436647.494574: nl80211: 5250-5330 @ 80 MHz 20 mBm (DFS) (no IR) 1463436647.494602: nl80211: 5490-5730 @ 160 MHz 20 mBm (DFS) (no IR) 1463436647.494631: nl80211: 5735-5835 @ 80 MHz 20 mBm (no IR) 1463436647.494658: nl80211: 57240-63720 @ 2160 MHz 0 mBm 1463436647.494737: nl80211: Added 802.11b mode based on 802.11g information 1463436647.494763: nl80211: Do not indicate P2P_DEVICE support (p2p_device=1 driver param not specified) 1463436647.602146: wlan0: Own MAC address: b8:27:eb:eb:46:b2 1463436647.602230: wpa_driver_nl80211_set_key: ifindex=3 (wlan0) alg=0 addr=(nil) key_idx=0 set_tx=0 seq_len=0 key_len=0 1463436647.602367: wpa_driver_nl80211_set_key: ifindex=3 (wlan0) alg=0 addr=(nil) key_idx=1 set_tx=0 seq_len=0 key_len=0 1463436647.602421: wpa_driver_nl80211_set_key: ifindex=3 (wlan0) alg=0 addr=(nil) key_idx=2 set_tx=0 seq_len=0 key_len=0 1463436647.602473: wpa_driver_nl80211_set_key: ifindex=3 (wlan0) alg=0 addr=(nil) key_idx=3 set_tx=0 seq_len=0 key_len=0 1463436647.602524: wpa_driver_nl80211_set_key: ifindex=3 (wlan0) alg=0 addr=(nil) key_idx=4 set_tx=0 seq_len=0 key_len=0 1463436647.602575: wpa_driver_nl80211_set_key: ifindex=3 (wlan0) alg=0 addr=(nil) key_idx=5 set_tx=0 seq_len=0 key_len=0 1463436647.602617: wlan0: RSN: flushing PMKID list in the driver 1463436647.602629: nl80211: Flush PMKIDs 1463436647.672105: TDLS: TDLS operation supported by driver 1463436647.672126: TDLS: Driver uses internal link setup 1463436647.672261: wlan0: WPS: UUID based on MAC address: f2d05241-a083-5270-873a-ee5fec1c466e 1463436647.679074: EAPOL: SUPP_PAE entering state DISCONNECTED 1463436647.679100: EAPOL: Supplicant port status: Unauthorized 1463436647.679111: nl80211: Skip set_supp_port(unauthorized) while not associated 1463436647.679123: EAPOL: KEY_RX entering state NO_KEY_RECEIVE 1463436647.679134: EAPOL: SUPP_BE entering state INITIALIZE 1463436647.679145: EAP: EAP entering state DISABLED 1463436647.679286: P2P: Add operating class 81 1463436647.679303: P2P: Channels - hexdump(len=11): 01 02 03 04 05 06 07 08 09 0a 0b 1463436647.680368: P2P: Own listen channel: 81:11 1463436647.681256: P2P: Random operating channel: 81:6 1463436647.682278: P2P: initialized 1463436647.682306: P2P: channels: 81:1,2,3,4,5,6,7,8,9,10,11 1463436647.682320: P2P: cli_channels: 1463436647.682362: wlan0: Added interface wlan0 1463436647.682380: wlan0: State: DISCONNECTED -> DISCONNECTED 1463436647.682392: nl80211: Set wlan0 operstate 0->0 (DORMANT) 1463436647.682405: netlink: Operstate: ifindex=3 linkmode=-1 (no change), operstate=5 (IF_OPER_DORMANT) 1463436647.682490: random: Got 20/20 bytes from /dev/random 1463436647.682550: RTM_NEWLINK: ifi_index=3 ifname=wlan0 operstate=2 linkmode=1 ifi_family=0 ifi_flags=0x1003 ([UP]) 1463436647.706342: wlan0: Starting delayed sched scan 1463436647.706369: wlan0: Use normal scan instead of sched_scan for initial scans (normal_scans=0) 1463436647.706387: wlan0: Setting scan request: 0.000000 sec 1463436647.706423: wlan0: State: DISCONNECTED -> SCANNING 1463436647.706443: wlan0: Starting AP scan for wildcard SSID 1463436647.706455: WPS: Building WPS IE for Probe Request 1463436647.706468: WPS: * Version (hardcoded 0x10) 1463436647.706478: WPS: * Request Type 1463436647.706487: WPS: * Config Methods (2148) 1463436647.706497: WPS: * UUID-E 1463436647.706506: WPS: * Primary Device Type 1463436647.706515: WPS: * RF Bands (1) 1463436647.706525: WPS: * Association State 1463436647.706534: WPS: * Configuration Error (0) 1463436647.706543: WPS: * Device Password ID (0) 1463436647.706555: WPS: * Manufacturer 1463436647.706563: WPS: * Model Name 1463436647.706573: WPS: * Model Number 1463436647.706581: WPS: * Device Name 1463436647.706592: WPS: * Version2 (0x20) 1463436647.706610: P2P: * P2P IE header 1463436647.706619: P2P: * Capability dev=25 group=00 1463436647.706630: P2P: * Listen Channel: Regulatory Class 81 Channel 11 1463436647.706649: wlan0: Add radio work 'scan'@0x564d5290 1463436647.706663: wlan0: First radio work item in the queue - schedule start immediately 1463436647.706692: wlan0: Starting radio work 'scan'@0x564d5290 after 0.000024 second wait 1463436647.706707: wlan0: nl80211: scan request 1463436647.711431: Scan requested (ret=0) - scan timeout 10 seconds 1463436647.711482: nl80211: Drv Event 33 (NL80211_CMD_TRIGGER_SCAN) received for wlan0 1463436647.711502: wlan0: nl80211: Scan trigger 1463436647.711539: wlan0: Event SCAN_STARTED (49) received 1463436647.711557: wlan0: Own scan request started a scan in 0.000099 seconds 1463436648.389070: nl80211: Drv Event 34 (NL80211_CMD_NEW_SCAN_RESULTS) received for wlan0 1463436648.389120: wlan0: nl80211: New scan results available 1463436648.389138: nl80211: Scan probed for SSID '' 1463436648.389158: nl80211: Scan included frequencies: 2412 2417 2422 2427 2432 2437 2442 2447 2452 2457 2462 1463436648.389175: wlan0: Event SCAN_RESULTS (3) received 1463436648.389191: wlan0: Scan completed in 0.677635 seconds 1463436648.389491: nl80211: Received scan results (18 BSSes) 1463436648.389587: wlan0: BSS: Start scan result update 1 1463436648.389614: wlan0: BSS: Add new id 0 BSSID 58:6d:8f:b3:b8:23 SSID 'CISCO-Linksys-E1200' 1463436648.389640: wlan0: BSS: Add new id 1 BSSID 60:02:92:cd:d9:30 SSID 'LNIWireless' 1463436648.389662: wlan0: BSS: Add new id 2 BSSID d8:97:ba:28:a2:40 SSID 'HOME-30CB-2.4' 1463436648.389685: wlan0: BSS: Add new id 3 BSSID 74:85:2a:db:22:68 SSID 'ThreeOhZoo-2.4' 1463436648.389706: wlan0: BSS: Add new id 4 BSSID d8:97:ba:28:a2:41 SSID '' 1463436648.389726: wlan0: BSS: Add new id 5 BSSID 6c:b0:ce:9f:d7:df SSID 'NETGEAR61' 1463436648.389748: wlan0: BSS: Add new id 6 BSSID 44:94:fc:80:40:73 SSID 'NETGEAR92' 1463436648.389768: wlan0: BSS: Add new id 7 BSSID 02:ac:e0:e8:11:20 SSID '' 1463436648.389789: wlan0: BSS: Add new id 8 BSSID 00:ac:e0:e8:11:20 SSID 'HOME-1122' 1463436648.389809: wlan0: BSS: Add new id 9 BSSID 5e:8f:e0:93:fb:ba SSID '' 1463436648.389830: wlan0: BSS: Add new id 10 BSSID 00:23:97:1c:51:3d SSID '09FX01020604' 1463436648.389852: wlan0: BSS: Add new id 11 BSSID 58:6d:8f:b3:b8:24 SSID 'CISCO-Linksys-E1200-guest' 1463436648.389874: wlan0: BSS: Add new id 12 BSSID 60:02:92:cd:d9:32 SSID 'xfinitywifi' 1463436648.389895: wlan0: BSS: Add new id 13 BSSID d8:97:ba:28:a2:42 SSID 'xfinitywifi' 1463436648.389917: wlan0: BSS: Add new id 14 BSSID 74:85:2a:db:22:6a SSID 'xfinitywifi' 1463436648.389939: wlan0: BSS: Add new id 15 BSSID 48:0f:cf:fa:ec:54 SSID 'HP-Print-54-Officejet Pro 8610' 1463436648.389961: wlan0: BSS: Add new id 16 BSSID 06:ac:e0:e8:11:20 SSID 'xfinitywifi' 1463436648.389983: wlan0: BSS: Add new id 17 BSSID e6:89:2c:fd:11:00 SSID 'xfinitywifi' 1463436648.389999: BSS: last_scan_res_used=18/32 1463436648.390027: wlan0: New scan results available (own=1 ext=0) 1463436648.390091: WPS: AP 58:6d:8f:b3:b8:23 type 0 added 1463436648.390108: WPS: AP 60:02:92:cd:d9:30 type 0 added 1463436648.390125: WPS: AP d8:97:ba:28:a2:40 type 0 added 1463436648.390141: WPS: AP 74:85:2a:db:22:68 type 0 added 1463436648.390157: WPS: AP 6c:b0:ce:9f:d7:df type 0 added 1463436648.390174: WPS: AP 44:94:fc:80:40:73 type 0 added 1463436648.390190: WPS: AP 00:ac:e0:e8:11:20 type 0 added 1463436648.390206: WPS: AP[0] 58:6d:8f:b3:b8:23 type=0 tries=0 last_attempt=-1 sec ago blacklist=0 1463436648.390221: WPS: AP[1] 60:02:92:cd:d9:30 type=0 tries=0 last_attempt=-1 sec ago blacklist=0 1463436648.390236: WPS: AP[2] d8:97:ba:28:a2:40 type=0 tries=0 last_attempt=-1 sec ago blacklist=0 1463436648.390250: WPS: AP[3] 74:85:2a:db:22:68 type=0 tries=0 last_attempt=-1 sec ago blacklist=0 1463436648.390265: WPS: AP[4] 6c:b0:ce:9f:d7:df type=0 tries=0 last_attempt=-1 sec ago blacklist=0 1463436648.390279: WPS: AP[5] 44:94:fc:80:40:73 type=0 tries=0 last_attempt=-1 sec ago blacklist=0 1463436648.390294: WPS: AP[6] 00:ac:e0:e8:11:20 type=0 tries=0 last_attempt=-1 sec ago blacklist=0 1463436648.390320: wlan0: Radio work 'scan'@0x564d5290 done in 0.683629 seconds 1463436648.390362: wlan0: Selecting BSS from priority group 0 1463436648.390390: wlan0: 0: 58:6d:8f:b3:b8:23 ssid='CISCO-Linksys-E1200' wpa_ie_len=28 rsn_ie_len=24 caps=0x411 level=-46 wps 1463436648.390411: wlan0: selected based on RSN IE 1463436648.390432: wlan0: selected BSS 58:6d:8f:b3:b8:23 ssid='CISCO-Linksys-E1200' 1463436648.390483: wlan0: Considering connect request: reassociate: 0 selected: 58:6d:8f:b3:b8:23 bssid: 00:00:00:00:00:00 pending: 00:00:00:00:00:00 wpa_state: SCANNING ssid=0x564c5548 current_ssid=(nil) 1463436648.390506: wlan0: Request association with 58:6d:8f:b3:b8:23 1463436648.390519: WPA: Unrecognized EAPOL-Key Key Data IE - hexdump(len=21): 00 13 43 49 53 43 4f 2d 4c 69 6e 6b 73 79 73 2d 45 31 32 30 30 1463436648.390549: WPA: Unrecognized EAPOL-Key Key Data IE - hexdump(len=3): 03 01 01 1463436648.390562: WPA: Unrecognized EAPOL-Key Key Data IE - hexdump(len=3): 2a 01 00 1463436648.390575: WPA: Unrecognized EAPOL-Key Key Data IE - hexdump(len=3): 2f 01 00 1463436648.390589: WPA: RSN IE in EAPOL-Key - hexdump(len=26): 30 18 01 00 00 0f ac 02 02 00 00 0f ac 04 00 0f ac 02 01 00 00 0f ac 02 0c 00 1463436648.390624: WPA: Unrecognized EAPOL-Key Key Data IE - hexdump(len=24): 3d 16 01 08 11 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 1463436648.390656: WPA: Unrecognized EAPOL-Key Key Data IE - hexdump(len=16): 4a 0e 14 00 0a 00 2c 01 c8 00 14 00 05 00 19 00 1463436648.390683: WPA: WPA IE in EAPOL-Key - hexdump(len=30): dd 1c 00 50 f2 01 01 00 00 50 f2 02 02 00 00 50 f2 04 00 50 f2 02 01 00 00 50 f2 02 0c 00 1463436648.390721: WPA: WMM Parameter Element - hexdump(len=24): 00 50 f2 02 01 01 80 00 03 a4 00 00 27 a4 00 00 42 43 5e 00 62 32 2f 00 1463436648.390752: TDLS: TDLS is allowed in the target BSS 1463436648.390768: wlan0: Add radio work 'connect'@0x564d5290 1463436648.390782: wlan0: First radio work item in the queue - schedule start immediately 1463436648.390822: wlan0: Starting radio work 'connect'@0x564d5290 after 0.000036 second wait 1463436648.390839: wlan0: Trying to associate with SSID 'CISCO-Linksys-E1200' 1463436648.390853: wlan0: Cancelling scan request 1463436648.390865: wlan0: WPA: clearing own WPA/RSN IE 1463436648.390878: wlan0: Automatic auth_alg selection: 0x1 1463436648.390888: RSN: PMKSA cache search - network_ctx=0x564c5548 try_opportunistic=0 1463436648.390900: RSN: Search for BSSID 58:6d:8f:b3:b8:23 1463436648.390912: RSN: No PMKSA cache entry found 1463436648.390925: wlan0: RSN: using IEEE 802.11i/D9.0 1463436648.390940: wlan0: WPA: Selected cipher suites: group 8 pairwise 24 key_mgmt 2 proto 2 1463436648.390954: wlan0: WPA: Selected mgmt group cipher 32 1463436648.390965: WPA: set AP WPA IE - hexdump(len=30): dd 1c 00 50 f2 01 01 00 00 50 f2 02 02 00 00 50 f2 04 00 50 f2 02 01 00 00 50 f2 02 0c 00 1463436648.391004: WPA: set AP RSN IE - hexdump(len=26): 30 18 01 00 00 0f ac 02 02 00 00 0f ac 04 00 0f ac 02 01 00 00 0f ac 02 0c 00 1463436648.391042: wlan0: WPA: using GTK TKIP 1463436648.391055: wlan0: WPA: using PTK CCMP 1463436648.391066: wlan0: WPA: using KEY_MGMT WPA-PSK 1463436648.391079: wlan0: WPA: not using MGMT group cipher 1463436648.391091: WPA: Set own WPA IE default - hexdump(len=22): 30 14 01 00 00 0f ac 02 01 00 00 0f ac 04 01 00 00 0f ac 02 00 00 1463436648.391134: wlan0: State: SCANNING -> ASSOCIATING 1463436648.391145: nl80211: Set wlan0 operstate 0->0 (DORMANT) 1463436648.391158: netlink: Operstate: ifindex=3 linkmode=-1 (no change), operstate=5 (IF_OPER_DORMANT) 1463436648.391191: wlan0: set_disable_max_amsdu: -1 1463436648.391204: wlan0: set_ampdu_factor: -1 1463436648.391216: wlan0: set_ampdu_density: -1 1463436648.391228: wlan0: set_disable_ht40: 0 1463436648.391241: wlan0: set_disable_sgi: 0 1463436648.391252: wlan0: set_disable_ldpc: 0 1463436648.391263: nl80211: Set mode ifindex 3 iftype 2 (STATION) 1463436648.391303: nl80211: Unsubscribe mgmt frames handle 0xdec4d481 (mode change) 1463436648.391431: nl80211: Subscribe to mgmt frames with non-AP handle 0x564c5c08 1463436648.391453: nl80211: Register frame type=0xd0 (WLAN_FC_STYPE_ACTION) nl_handle=0x564c5c08 match=040a 1463436648.391496: nl80211: Register frame type=0xd0 (WLAN_FC_STYPE_ACTION) nl_handle=0x564c5c08 match=040b 1463436648.391537: nl80211: Register frame type=0xd0 (WLAN_FC_STYPE_ACTION) nl_handle=0x564c5c08 match=040c 1463436648.391576: nl80211: Register frame type=0xd0 (WLAN_FC_STYPE_ACTION) nl_handle=0x564c5c08 match=040d 1463436648.391615: nl80211: Register frame type=0xd0 (WLAN_FC_STYPE_ACTION) nl_handle=0x564c5c08 match=090a 1463436648.391656: nl80211: Register frame type=0xd0 (WLAN_FC_STYPE_ACTION) nl_handle=0x564c5c08 match=090b 1463436648.391696: nl80211: Register frame type=0xd0 (WLAN_FC_STYPE_ACTION) nl_handle=0x564c5c08 match=090c 1463436648.391734: nl80211: Register frame type=0xd0 (WLAN_FC_STYPE_ACTION) nl_handle=0x564c5c08 match=090d 1463436648.391775: nl80211: Register frame type=0xd0 (WLAN_FC_STYPE_ACTION) nl_handle=0x564c5c08 match=0409506f9a09 1463436648.391815: nl80211: Register frame type=0xd0 (WLAN_FC_STYPE_ACTION) nl_handle=0x564c5c08 match=7f506f9a09 1463436648.391855: nl80211: Register frame type=0xd0 (WLAN_FC_STYPE_ACTION) nl_handle=0x564c5c08 match=0801 1463436648.391895: nl80211: Register frame type=0xd0 (WLAN_FC_STYPE_ACTION) nl_handle=0x564c5c08 match=040e 1463436648.391933: nl80211: Register frame type=0xd0 (WLAN_FC_STYPE_ACTION) nl_handle=0x564c5c08 match=06 1463436648.391971: nl80211: Register frame type=0xd0 (WLAN_FC_STYPE_ACTION) nl_handle=0x564c5c08 match=0a07 1463436648.392012: nl80211: Register frame type=0xd0 (WLAN_FC_STYPE_ACTION) nl_handle=0x564c5c08 match=0a11 1463436648.392122: nl80211: Connect (ifindex=3) 1463436648.392136: * bssid_hint=58:6d:8f:b3:b8:23 1463436648.392149: * freq_hint=2412 1463436648.392160: * SSID - hexdump_ascii(len=19): 43 49 53 43 4f 2d 4c 69 6e 6b 73 79 73 2d 45 31 CISCO-Linksys-E1 32 30 30 200 1463436648.392213: * IEs - hexdump(len=28): 30 14 01 00 00 0f ac 02 01 00 00 0f ac 04 01 00 00 0f ac 02 00 00 7f 04 00 00 0a 02 1463436648.392250: * WPA Versions 0x2 1463436648.392260: * pairwise=0xfac04 1463436648.392269: * group=0xfac02 1463436648.392279: * akm=0xfac02 1463436648.392289: * htcaps - hexdump(len=26): 63 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 1463436648.392336: * htcaps_mask - hexdump(len=26): 63 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 1463436648.392378: * vhtcaps - hexdump(len=12): 00 00 00 00 00 00 00 00 00 00 00 00 1463436648.392401: * vhtcaps_mask - hexdump(len=12): 00 00 00 00 00 00 00 00 00 00 00 00 1463436648.392423: * Auth Type 0 1463436648.396283: nl80211: Connect request send successfully 1463436648.396306: wlan0: Setting authentication timeout: 10 sec 0 usec 1463436648.396333: EAPOL: External notification - EAP success=0 1463436648.396351: EAPOL: External notification - EAP fail=0 1463436648.396362: EAPOL: External notification - portControl=Auto 1463436648.396386: RTM_NEWLINK: ifi_index=3 ifname=wlan0 wext ifi_family=0 ifi_flags=0x1003 ([UP]) 1463436648.679477: EAPOL: disable timer tick 1463436649.109776: wlan0: RX EAPOL from 58:6d:8f:b3:b8:23 1463436649.109822: wlan0: Not associated - Delay processing of received EAPOL frame (state=ASSOCIATING bssid=00:00:00:00:00:00) 1463436649.206958: RTM_NEWLINK: ifi_index=3 ifname=wlan0 operstate=5 linkmode=1 ifi_family=0 ifi_flags=0x11003 ([UP][LOWER_UP]) 1463436649.209634: nl80211: Drv Event 46 (NL80211_CMD_CONNECT) received for wlan0 1463436649.209678: nl80211: Connect event 1463436649.209837: nl80211: Associated on 2412 MHz 1463436649.209849: nl80211: Associated with 58:6d:8f:b3:b8:23 1463436649.209915: nl80211: Operating frequency for the associated BSS from scan results: 2412 MHz 1463436649.209935: wlan0: Event ASSOC (0) received 1463436649.209947: wlan0: Association info event 1463436649.209956: req_ies - hexdump(len=151): 00 13 43 49 53 43 4f 2d 4c 69 6e 6b 73 79 73 2d 45 31 32 30 30 01 08 82 84 8b 96 24 30 48 6c 32 04 0c 12 18 60 21 02 03 15 24 02 01 0b 30 14 01 00 00 0f ac 02 01 00 00 0f ac 04 01 00 00 0f ac 02 00 00 2d 1a 21 00 1f ff 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 dd 1e 00 90 4c 33 21 00 1f ff 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 dd 09 00 10 18 02 00 10 00 00 00 dd 07 00 50 f2 02 00 01 00 00 00 00 00 1463436649.210104: resp_ies - hexdump(len=130): 01 08 82 84 8b 96 24 30 48 6c 32 04 0c 12 18 60 2d 1a fc 18 1b ff 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 3d 16 01 08 15 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 7f 01 01 4a 0e 14 00 0a 00 2c 01 c8 00 14 00 05 00 19 00 dd 09 00 10 18 02 00 f0 04 00 00 dd 18 00 50 f2 02 01 01 80 00 03 a4 00 00 27 a4 00 00 42 43 5e 00 62 32 2f 00 00 00 00 00 00 00 1463436649.210232: WPA: Unrecognized EAPOL-Key Key Data IE - hexdump(len=24): 3d 16 01 08 15 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 1463436649.210264: WPA: Unrecognized EAPOL-Key Key Data IE - hexdump(len=16): 4a 0e 14 00 0a 00 2c 01 c8 00 14 00 05 00 19 00 1463436649.210288: WPA: WMM Parameter Element - hexdump(len=24): 00 50 f2 02 01 01 80 00 03 a4 00 00 27 a4 00 00 42 43 5e 00 62 32 2f 00 1463436649.210319: WPA: Unrecognized EAPOL-Key Key Data IE - hexdump(len=2): 00 00 1463436649.210330: WPA: Unrecognized EAPOL-Key Key Data IE - hexdump(len=2): 00 00 1463436649.210341: WPA: Unrecognized EAPOL-Key Key Data IE - hexdump(len=2): 00 00 1463436649.210358: wlan0: freq=2412 MHz 1463436649.210366: WPA: set own WPA/RSN IE - hexdump(len=22): 30 14 01 00 00 0f ac 02 01 00 00 0f ac 04 01 00 00 0f ac 02 00 00 1463436649.210403: FT: Stored MDIE and FTIE from (Re)Association Response - hexdump(len=0): 1463436649.210418: wlan0: State: ASSOCIATING -> ASSOCIATED 1463436649.210428: nl80211: Set wlan0 operstate 0->0 (DORMANT) 1463436649.210452: netlink: Operstate: ifindex=3 linkmode=-1 (no change), operstate=5 (IF_OPER_DORMANT) 1463436649.210491: wlan0: Associated to a new BSS: BSSID=58:6d:8f:b3:b8:23 1463436649.210509: WPA: set AP WPA IE - hexdump(len=30): dd 1c 00 50 f2 01 01 00 00 50 f2 02 02 00 00 50 f2 04 00 50 f2 02 01 00 00 50 f2 02 0c 00 1463436649.210547: WPA: set AP RSN IE - hexdump(len=26): 30 18 01 00 00 0f ac 02 02 00 00 0f ac 04 00 0f ac 02 01 00 00 0f ac 02 0c 00 1463436649.210596: wlan0: Associated with 58:6d:8f:b3:b8:23 1463436649.210607: wlan0: WPA: Association event - clear replay counter 1463436649.210618: wlan0: WPA: Clear old PTK 1463436649.210627: TDLS: Remove peers on association 1463436649.210636: EAPOL: External notification - portEnabled=0 1463436649.210652: EAPOL: External notification - portValid=0 1463436649.210661: EAPOL: External notification - EAP success=0 1463436649.210669: EAPOL: External notification - portEnabled=1 1463436649.210678: EAPOL: SUPP_PAE entering state CONNECTING 1463436649.210686: EAPOL: enable timer tick 1463436649.210695: EAPOL: SUPP_BE entering state IDLE 1463436649.210709: wlan0: Setting authentication timeout: 10 sec 0 usec 1463436649.210723: wlan0: Cancelling scan request 1463436649.210939: RTM_NEWLINK: ifi_index=3 ifname=wlan0 wext ifi_family=0 ifi_flags=0x11003 ([UP][LOWER_UP]) 1463436649.211025: RTM_NEWLINK: ifi_index=3 ifname=wlan0 wext ifi_family=0 ifi_flags=0x11003 ([UP][LOWER_UP]) 1463436649.211056: RTM_NEWLINK: ifi_index=3 ifname=wlan0 wext ifi_family=0 ifi_flags=0x11003 ([UP][LOWER_UP]) 1463436650.098273: wlan0: RX EAPOL from 58:6d:8f:b3:b8:23 1463436650.098335: wlan0: Setting authentication timeout: 10 sec 0 usec 1463436650.098380: wlan0: IEEE 802.1X RX: version=2 type=3 length=117 1463436650.098407: wlan0: EAPOL-Key type=2 1463436650.098442: wlan0: key_info 0x8a (ver=2 keyidx=0 rsvd=0 Pairwise Ack) 1463436650.098467: wlan0: key_length=16 key_data_length=22 1463436650.098484: replay_counter - hexdump(len=8): 00 00 00 00 00 00 00 01 1463436650.098517: key_nonce - hexdump(len=32): ce 97 b7 53 b5 61 0b 2b 21 76 55 16 91 28 33 23 ed cc fe 84 7e 01 2a 21 a9 22 fb e8 85 a7 c9 9b 1463436650.098607: key_iv - hexdump(len=16): 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 1463436650.098653: key_rsc - hexdump(len=8): 00 00 00 00 00 00 00 00 1463436650.098684: key_id (reserved) - hexdump(len=8): 00 00 00 00 00 00 00 00 1463436650.098729: key_mic - hexdump(len=16): 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 1463436650.098798: wlan0: State: ASSOCIATED -> 4WAY_HANDSHAKE 1463436650.098837: wlan0: WPA: RX message 1 of 4-Way Handshake from 58:6d:8f:b3:b8:23 (ver=2) 1463436650.098859: RSN: msg 1/4 key data - hexdump(len=22): dd 14 00 0f ac 04 c2 8d 52 51 c1 dd c2 2b 53 02 7a 7a 9e 74 77 e5 1463436650.098918: WPA: PMKID in EAPOL-Key - hexdump(len=22): dd 14 00 0f ac 04 c2 8d 52 51 c1 dd c2 2b 53 02 7a 7a 9e 74 77 e5 1463436650.098975: RSN: PMKID from Authenticator - hexdump(len=16): c2 8d 52 51 c1 dd c2 2b 53 02 7a 7a 9e 74 77 e5 1463436650.099025: wlan0: RSN: no matching PMKID found 1463436650.101071: WPA: Renewed SNonce - hexdump(len=32): 92 89 a8 f2 e7 75 4d 31 2e dc 86 98 3f d6 5d d3 ab be 42 7d 29 45 de 98 67 03 1c c5 73 48 7a d3 1463436650.101218: WPA: PTK derivation - A1=b8:27:eb:eb:46:b2 A2=58:6d:8f:b3:b8:23 1463436650.101247: WPA: Nonce1 - hexdump(len=32): 92 89 a8 f2 e7 75 4d 31 2e dc 86 98 3f d6 5d d3 ab be 42 7d 29 45 de 98 67 03 1c c5 73 48 7a d3 1463436650.101320: WPA: Nonce2 - hexdump(len=32): ce 97 b7 53 b5 61 0b 2b 21 76 55 16 91 28 33 23 ed cc fe 84 7e 01 2a 21 a9 22 fb e8 85 a7 c9 9b 1463436650.101393: WPA: PMK - hexdump(len=32): [REMOVED] 1463436650.101410: WPA: PTK - hexdump(len=48): [REMOVED] 1463436650.101428: WPA: WPA IE for msg 2/4 - hexdump(len=22): 30 14 01 00 00 0f ac 02 01 00 00 0f ac 04 01 00 00 0f ac 02 00 00 1463436650.101488: WPA: Replay Counter - hexdump(len=8): 00 00 00 00 00 00 00 01 1463436650.101525: wlan0: WPA: Sending EAPOL-Key 2/4 1463436650.101566: WPA: KCK - hexdump(len=16): [REMOVED] 1463436650.101584: WPA: Derived Key MIC - hexdump(len=16): 47 c2 9d 30 c4 f6 0f 11 5f e8 97 54 72 12 b3 62 1463436650.133710: wlan0: RX EAPOL from 58:6d:8f:b3:b8:23 1463436650.133789: wlan0: IEEE 802.1X RX: version=2 type=3 length=175 1463436650.133820: wlan0: EAPOL-Key type=2 1463436650.133858: wlan0: key_info 0x13ca (ver=2 keyidx=0 rsvd=0 Pairwise Install Ack MIC Secure Encr) 1463436650.133885: wlan0: key_length=16 key_data_length=80 1463436650.133901: replay_counter - hexdump(len=8): 00 00 00 00 00 00 00 02 1463436650.133934: key_nonce - hexdump(len=32): ce 97 b7 53 b5 61 0b 2b 21 76 55 16 91 28 33 23 ed cc fe 84 7e 01 2a 21 a9 22 fb e8 85 a7 c9 9b 1463436650.134006: key_iv - hexdump(len=16): ed cc fe 84 7e 01 2a 21 a9 22 fb e8 85 a7 c9 9c 1463436650.134049: key_rsc - hexdump(len=8): fb 0a 00 00 00 00 00 00 1463436650.134079: key_id (reserved) - hexdump(len=8): 00 00 00 00 00 00 00 00 1463436650.134110: key_mic - hexdump(len=16): 82 c3 ca ff 55 95 17 a4 9b cc ed b9 4a 3c 82 4e 1463436650.134197: RSN: encrypted key data - hexdump(len=80): 2b f1 3e 38 9a db d5 95 ad 72 01 7f 20 4b a3 d5 fd b1 79 39 5e ed db 5f e4 25 72 d0 dc 84 4f 49 08 8a 8d 1b f7 ec c1 14 1d 53 ea ac 44 78 c7 23 3a 74 53 be 68 30 be 21 b0 d4 f4 0e b3 87 b0 a9 29 73 a3 f9 11 33 19 da 3f 30 32 cf 9d 42 c5 fa 1463436650.134522: WPA: decrypted EAPOL-Key key data - hexdump(len=72): [REMOVED] 1463436650.134554: wlan0: State: 4WAY_HANDSHAKE -> 4WAY_HANDSHAKE 1463436650.134612: wlan0: WPA: RX message 3 of 4-Way Handshake from 58:6d:8f:b3:b8:23 (ver=2) 1463436650.134632: WPA: IE KeyData - hexdump(len=72): 30 18 01 00 00 0f ac 02 02 00 00 0f ac 04 00 0f ac 02 01 00 00 0f ac 02 0c 00 dd 26 00 0f ac 01 01 00 fe 53 ed 3d d3 ea ad 63 08 87 a2 80 3b 69 0f 47 ca 90 5d f4 e3 17 4d c5 b2 25 05 b8 81 2c b5 03 dd 00 00 00 00 00 1463436650.134801: WPA: RSN IE in EAPOL-Key - hexdump(len=26): 30 18 01 00 00 0f ac 02 02 00 00 0f ac 04 00 0f ac 02 01 00 00 0f ac 02 0c 00 1463436650.134869: WPA: GTK in EAPOL-Key - hexdump(len=40): [REMOVED] 1463436650.134898: wlan0: WPA: Sending EAPOL-Key 4/4 1463436650.134938: WPA: KCK - hexdump(len=16): [REMOVED] 1463436650.134957: WPA: Derived Key MIC - hexdump(len=16): 97 60 a8 59 27 89 c4 7d da a9 37 cf 04 8e 7b 95 1463436650.135034: wlan0: WPA: Installing PTK to the driver 1463436650.135134: wpa_driver_nl80211_set_key: ifindex=3 (wlan0) alg=3 addr=0x564c5e38 key_idx=0 set_tx=1 seq_len=6 key_len=16 1463436650.135187: nl80211: KEY_DATA - hexdump(len=16): [REMOVED] 1463436650.135210: nl80211: KEY_SEQ - hexdump(len=6): 00 00 00 00 00 00 1463436650.135239: addr=58:6d:8f:b3:b8:23 1463436650.136838: EAPOL: External notification - portValid=1 1463436650.136915: wlan0: State: 4WAY_HANDSHAKE -> GROUP_HANDSHAKE 1463436650.136973: RSN: received GTK in pairwise handshake - hexdump(len=34): [REMOVED] 1463436650.137030: WPA: Group Key - hexdump(len=32): [REMOVED] 1463436650.137094: wlan0: WPA: Installing GTK to the driver (keyidx=1 tx=0 len=32) 1463436650.137145: WPA: RSC - hexdump(len=6): fb 0a 00 00 00 00 1463436650.137255: wpa_driver_nl80211_set_key: ifindex=3 (wlan0) alg=2 addr=0x54bf3cc8 key_idx=1 set_tx=0 seq_len=6 key_len=32 1463436650.137332: nl80211: KEY_DATA - hexdump(len=32): [REMOVED] 1463436650.137388: nl80211: KEY_SEQ - hexdump(len=6): fb 0a 00 00 00 00 1463436650.137450: broadcast key 1463436650.139490: wlan0: WPA: Key negotiation completed with 58:6d:8f:b3:b8:23 [PTK=CCMP GTK=TKIP] 1463436650.139557: wlan0: Cancelling authentication timeout 1463436650.139618: wlan0: State: GROUP_HANDSHAKE -> COMPLETED 1463436650.139687: wlan0: Radio work 'connect'@0x564d5290 done in 1.748856 seconds 1463436650.139760: wlan0: CTRL-EVENT-CONNECTED - Connection to 58:6d:8f:b3:b8:23 completed [id=0 id_str=] 1463436650.139814: nl80211: Set wlan0 operstate 0->1 (UP) 1463436650.139868: netlink: Operstate: ifindex=3 linkmode=-1 (no change), operstate=6 (IF_OPER_UP) 1463436650.140165: EAPOL: External notification - portValid=1 1463436650.140228: EAPOL: External notification - EAP success=1 1463436650.140281: EAPOL: SUPP_PAE entering state AUTHENTICATING 1463436650.140331: EAPOL: SUPP_BE entering state SUCCESS 1463436650.140380: EAP: EAP entering state DISABLED 1463436650.140427: EAPOL: SUPP_PAE entering state AUTHENTICATED 1463436650.140475: EAPOL: Supplicant port status: Authorized 1463436650.140525: nl80211: Set supplicant port authorized for 58:6d:8f:b3:b8:23 1463436650.143065: EAPOL: SUPP_BE entering state IDLE 1463436650.143162: EAPOL authentication completed - result=SUCCESS 1463436650.143433: RTM_NEWLINK: ifi_index=3 ifname=wlan0 operstate=6 linkmode=1 ifi_family=0 ifi_flags=0x11043 ([UP][RUNNING][LOWER_UP]) May 16 22:10:50 raspberrypi systemd-networkd[411]: wlan0 : gained carrier 1463436651.210914: EAPOL: startWhen --> 0 1463436651.210951: EAPOL: disable timer tick May 16 22:10:52 raspberrypi systemd-networkd[411]: wlan0 : DHCPv4 address 192.168.1.102/24 via 192.168.1.1 May 16 22:10:52 raspberrypi systemd-networkd[411]: wlan0 : link configured Barry Reinhold
Attachment:
capture-07-rpi-and-android.cap
Description: capture-07-rpi-and-android.cap
