Hello,
I am experiencing odd "disconnections" with my router.
Model : D-Link DIR-615 rev. C1
Openwrt versions tested : 12.09, r38999, r39424 (bleeding edge of few
days ago)
Laptop used : macbookpro 13" mid2012 w/ osx 10.8.5 (AirPort Extreme
(0x14E4, 0xF5) firmware BCM43xx 1.0 (5.106.98.100.17)).
We only have macbooks here, and this issue is not limited to my laptop
nor this specific version.
I bridge the wifi interface with the lan. I don't use the wan. dhcpd on
openwrt is disabled.
Sometimes, the stations stop seeing their traffic forwarded to internet.
For instance, with my computer on the wireless network, I could not join
anything on internet, however :
- I was able to ssh the wifi router
- I could ping internet hosts from the wifi router
You'll find logs from my /var/log/wifi.log mac attached. This
'disconnection' started at 10:34:23 and stopped at 10:36:24.
42:42:42:42:42:42 is the bssid of the openwrt wifi router
Any pointer would be appreciated (I think especially of what component /
logs I should watch on the wifi router).
Thanks
disconnected Tue Feb 4 10:34:23 CST 2014
reconnected Tue Feb 4 10:36:24 CST 2014
Tue Feb 4 10:33:52.625 <configd[17]> _bsd_80211_event_callback: LINK_QUALITY
(en1)
Tue Feb 4 10:33:52.625 <configd[17]> __AirPortOpportunisticRoamTriggerRSSI:
<en1> Opportunistic Roam : Current RSSI <-50>, Last Opp Roam RSSI <-47>
Tue Feb 4 10:33:57.631 <configd[17]> _bsd_80211_event_callback: LINK_QUALITY
(en1)
Tue Feb 4 10:33:57.631 <configd[17]> __AirPortOpportunisticRoamTriggerRSSI:
<en1> Opportunistic Roam : Current RSSI <-49>, Last Opp Roam RSSI <-47>
Tue Feb 4 10:34:05.630 <configd[17]> _bsd_80211_event_callback: LINK_QUALITY
(en1)
Tue Feb 4 10:34:05.630 <configd[17]> __AirPortOpportunisticRoamTriggerRSSI:
<en1> Opportunistic Roam : Current RSSI <-47>, Last Opp Roam RSSI <-47>
Tue Feb 4 10:34:11.631 <configd[17]> _bsd_80211_event_callback: LINK_QUALITY
(en1)
Tue Feb 4 10:34:11.631 <configd[17]> __AirPortOpportunisticRoamTriggerRSSI:
<en1> Opportunistic Roam : Current RSSI <-50>, Last Opp Roam RSSI <-47>
Tue Feb 4 10:34:17.633 <configd[17]> _bsd_80211_event_callback: LINK_QUALITY
(en1)
Tue Feb 4 10:34:17.633 <configd[17]> __AirPortOpportunisticRoamTriggerRSSI:
<en1> Opportunistic Roam : Current RSSI <-34>, Last Opp Roam RSSI <-47>
Tue Feb 4 10:34:17.633 <configd[17]> __AirPortOpportunisticRoamTriggerRSSI:
<en1> Opportunistic Roam : Destination BSSID <FF:FF:FF:FF:FF:FF>
Tue Feb 4 10:34:17.633 <configd[17]> __AirPortOpportunisticRoamTriggerRSSI:
<en1> Opportunistic Roam : Next Attempt for this BSSID <-34>
Tue Feb 4 10:34:20.820 <kernel> en1: roam event, sending supplicant link down
message.
Tue Feb 4 10:34:20.859 <kernel> Successfully joined network with BSSID
42:42:42:42:42:42
Tue Feb 4 10:34:20.859 <configd[17]> _p2pSupEventCallback:
APPLE80211_M_BSSID_CHANGED
Tue Feb 4 10:34:20.859 <configd[17]> _bsd_80211_event_callback: BSSID_CHANGED
(en1)
Tue Feb 4 10:34:20.859 <kernel> en1: Received EAPOL packet (length = 113)
Tue Feb 4 10:34:20.859 <kernel> inputEAPOLFrame: 0 extra bytes present in
EAPOL frame.
Tue Feb 4 10:34:20.859 <kernel> inputEAPOLFrame: Received message 1 of 4
Tue Feb 4 10:34:20.859 <kernel> FULL RSN IE FOUND:
Tue Feb 4 10:34:20.859 [00000000] 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
Tue Feb 4 10:34:20.859 <kernel> storeFullRSNIE: getAP_IE_LIST returned 0
Tue Feb 4 10:34:20.859 <kernel> PMK:
Tue Feb 4 10:34:20.859 [00000000] 83 00 11 5C 06 D1 4E DF 51 A4 15 48 D7 65 22
82 A6 3E 8B 53 69 39 7E 72 08 83 16 2B 9B BA
Tue Feb 4 10:34:20.859 [0000001E] CB B3
Tue Feb 4 10:34:20.859 <kernel> TPTK:
Tue Feb 4 10:34:20.859 [00000000] 0F BA E5 A8 BE 7F EC CD 1C D7 56 E1 96 AF E1
4E EE 0D 10 86 2F D8 7E F4 89 EF D8 1F FD 60
Tue Feb 4 10:34:20.859 [0000001E] E6 98 91 F8 BE 92 8A AD 27 8C 13 63 31 6B 3F
49 02 C8 60 7B 88 51 7C EF 79 4D AC 90 25 49
Tue Feb 4 10:34:20.859 [0000003C] CB 64 04 9C
Tue Feb 4 10:34:20.859 <kernel> KEY MIC:
Tue Feb 4 10:34:20.859 [00000000] 90 4D 85 10 30 11 4D 99 23 24 0F 93 42 98 64
D1
Tue Feb 4 10:34:20.859 <kernel> process1of4: sending replyPacket 135 bytes
Tue Feb 4 10:34:20.859 <kernel> en1: Received EAPOL packet (length = 193)
Tue Feb 4 10:34:20.859 <kernel> inputEAPOLFrame: 0 extra bytes present in
EAPOL frame.
Tue Feb 4 10:34:20.859 <kernel> inputEAPOLFrame: decrypting key data
Tue Feb 4 10:34:20.859 <kernel> inputEAPOLFrame: Received message 3 of 4
Tue Feb 4 10:34:20.859 <kernel> process3of4: Performing IE check.
Tue Feb 4 10:34:20.859 <kernel> process3of4: sending replyPacket ( len = 113 ).
Tue Feb 4 10:34:20.859 <kernel> process3of4: received pairwise GTK
Tue Feb 4 10:34:20.859 <kernel> ptkThread: Sleeping!
Tue Feb 4 10:34:20.859 <kernel> ptkThread: Sleeping!
Tue Feb 4 10:34:20.859 <airportd[65059]> _handleNewMessage: Received XPC
message, event = DRIVER_EVENT, pid = 17
Tue Feb 4 10:34:20.859 <airportd[65059]> _processDriverEvent: BSSID changed
Tue Feb 4 10:34:20.859 <configd[17]> __AirPortOpportunisticRoamBSSIDChanged:
<en1> BSSID Change Event old <42:42:42:42:42:42>, new <42:42:42:42:42:42>reset
Opp Roam to <-70>
Tue Feb 4 10:34:20.859 <configd[17]> _bsd_80211_event_callback: Frequency Band
updated <1>
Tue Feb 4 10:34:20.859 <kernel> ptkThread: Installing PTK!
Tue Feb 4 10:34:20.859 <kernel> PTK:
Tue Feb 4 10:34:20.859 [00000000] 91 F8 BE 92 8A AD 27 8C 13 63 31 6B 3F 49 02
C8
Tue Feb 4 10:34:20.859 <configd[17]> BluetoothCoexHandleUpdateForNode: <en1>
Handle Bluetooth Coex: FrequencyBand <1>, Bluetooth Bandwidth Utilization <22>,
Clamshell Mode <0>
Tue Feb 4 10:34:20.859 <configd[17]> BluetoothCoexModeSet: <en1> already set
to BT Coex mode 'Hybrid', do not perform APPLE80211_IOC_BTCOEX_MODE
Tue Feb 4 10:34:20.859 <kernel> ptkThread: Installing GTK!
Tue Feb 4 10:34:20.859 <kernel> installGTK: setting cipher key (flags = 0x0)
Tue Feb 4 10:34:20.859 <kernel> RSC:
Tue Feb 4 10:34:20.859 [00000000] 73 04 00 00 00 00
Tue Feb 4 10:34:20.859 <kernel> GTK:
Tue Feb 4 10:34:20.859 [00000000] 7C 86 2A 54 4A 44 DE B7 4A B0 CF FA 1F A0 57
0E C5 66 74 DE 77 F8 0F 57 64 71 29 66 1E 61
Tue Feb 4 10:34:20.859 [0000001E] 10 31
Tue Feb 4 10:34:20.859 <configd[17]>
BluetoothCoexSettingPerChainTransmitPowerOffsets: Per TX Chain Power Offset
Control <CFArray 0x7fb38531a7d0 [0x7fff7d656110]>{type = mutable-small, count =
3, values = (
Tue Feb 4 10:34:20.859 0 : <CFNumber 0x87 [0x7fff7d656110]>{value =
+0, type = kCFNumberSInt32Type}
Tue Feb 4 10:34:20.859 1 : <CFNumber 0x87 [0x7fff7d656110]>{value =
+0, type = kCFNumberSInt32Type}
Tue Feb 4 10:34:20.859 2 : <CFNumber 0x87 [0x7fff7d656110]>{value =
+0, type = kCFNumberSInt32Type}
Tue Feb 4 10:34:20.859 )}
Tue Feb 4 10:34:20.859 <kernel> Inserting keys for algorithm 4
Tue Feb 4 10:34:20.859 <kernel> Inserting keys for algorithm 2
Tue Feb 4 10:34:21.633 <configd[17]> _bsd_80211_event_callback: LINK_QUALITY
(en1)
Tue Feb 4 10:34:21.633 <configd[17]> __AirPortOpportunisticRoamTriggerRSSI:
<en1> Opportunistic Roam : Current RSSI <-48>, Last Opp Roam RSSI <-70>
Tue Feb 4 10:34:21.633 <configd[17]> __AirPortOpportunisticRoamTriggerRSSI:
<en1> Opportunistic Roam : Destination BSSID <FF:FF:FF:FF:FF:FF>
Tue Feb 4 10:34:21.633 <configd[17]> __AirPortOpportunisticRoamTriggerRSSI:
<en1> Opportunistic Roam : Next Attempt for this BSSID <-48>
Tue Feb 4 10:34:26.631 <configd[17]> _bsd_80211_event_callback: LINK_QUALITY
(en1)
Tue Feb 4 10:34:26.631 <configd[17]> __AirPortOpportunisticRoamTriggerRSSI:
<en1> Opportunistic Roam : Current RSSI <-51>, Last Opp Roam RSSI <-48>
Tue Feb 4 10:34:31.637 <configd[17]> _bsd_80211_event_callback: LINK_QUALITY
(en1)
Tue Feb 4 10:34:31.637 <configd[17]> __AirPortOpportunisticRoamTriggerRSSI:
<en1> Opportunistic Roam : Current RSSI <-43>, Last Opp Roam RSSI <-48>
Tue Feb 4 10:34:50.857 <airportd[65059]>
___createTerminateTimer_block_invoke_0: ...exiting
Tue Feb 4 10:35:26.644 <configd[17]> _bsd_80211_event_callback: LINK_QUALITY
(en1)
Tue Feb 4 10:35:26.644 <configd[17]> __AirPortOpportunisticRoamTriggerRSSI:
<en1> Opportunistic Roam : Current RSSI <-52>, Last Opp Roam RSSI <-48>
Tue Feb 4 10:35:32.649 <configd[17]> _bsd_80211_event_callback: LINK_QUALITY
(en1)
Tue Feb 4 10:35:32.649 <configd[17]> __AirPortOpportunisticRoamTriggerRSSI:
<en1> Opportunistic Roam : Current RSSI <-48>, Last Opp Roam RSSI <-48>
Tue Feb 4 10:35:35.289 <kernel> en1: Received EAPOL packet (length = 161)
Tue Feb 4 10:35:35.289 <kernel> inputEAPOLFrame: 0 extra bytes present in
EAPOL frame.
Tue Feb 4 10:35:35.289 <kernel> inputEAPOLFrame: decrypting key data
Tue Feb 4 10:35:35.289 <kernel> inputEAPOLFrame: Received message 1 of 2
Tue Feb 4 10:35:35.289 <kernel> installGTK: setting cipher key (flags = 0x0)
Tue Feb 4 10:35:35.289 <kernel> RSC:
Tue Feb 4 10:35:35.289 [00000000] 00 00 00 00 00 00
Tue Feb 4 10:35:35.289 <kernel> GTK:
Tue Feb 4 10:35:35.289 [00000000] CD 58 94 DB 93 33 9F 41 24 E2 C6 29 B7 7D 8C
B8 77 43 D2 BD AE E9 F6 5B C0 CC 5E 0D 40 26
Tue Feb 4 10:35:35.289 [0000001E] 44 3D
Tue Feb 4 10:35:35.289 <kernel> Inserting keys for algorithm 2
Tue Feb 4 10:35:46.649 <configd[17]> _bsd_80211_event_callback: LINK_QUALITY
(en1)
Tue Feb 4 10:35:46.649 <configd[17]> __AirPortOpportunisticRoamTriggerRSSI:
<en1> Opportunistic Roam : Current RSSI <-50>, Last Opp Roam RSSI <-48>
Tue Feb 4 10:35:51.654 <configd[17]> _bsd_80211_event_callback: LINK_QUALITY
(en1)
Tue Feb 4 10:35:51.654 <configd[17]> __AirPortOpportunisticRoamTriggerRSSI:
<en1> Opportunistic Roam : Current RSSI <-45>, Last Opp Roam RSSI <-48>
Tue Feb 4 10:36:33.666 <configd[17]> _bsd_80211_event_callback: LINK_QUALITY
(en1)
Tue Feb 4 10:36:33.666 <configd[17]> __AirPortOpportunisticRoamTriggerRSSI:
<en1> Opportunistic Roam : Current RSSI <-50>, Last Opp Roam RSSI <-48>
Tue Feb 4 10:36:38.664 <configd[17]> _bsd_80211_event_callback: LINK_QUALITY
(en1)
Tue Feb 4 10:36:38.664 <configd[17]> __AirPortOpportunisticRoamTriggerRSSI:
<en1> Opportunistic Roam : Current RSSI <-23>, Last Opp Roam RSSI <-48>
Tue Feb 4 10:36:38.664 <configd[17]> __AirPortOpportunisticRoamTriggerRSSI:
<en1> Opportunistic Roam : Destination BSSID <FF:FF:FF:FF:FF:FF>
Tue Feb 4 10:36:38.664 <configd[17]> __AirPortOpportunisticRoamTriggerRSSI:
<en1> Opportunistic Roam : Next Attempt for this BSSID <-23>
Tue Feb 4 10:36:41.845 <kernel> en1: roam event, sending supplicant link down
message.
Tue Feb 4 10:36:41.845 <kernel> IO80211ScanManager::scanDone: Scheduling cache
purge timer in 30 seconds.
Tue Feb 4 10:36:41.859 <kernel> en1: Received EAPOL packet (length = 113)
Tue Feb 4 10:36:41.859 <kernel> inputEAPOLFrame: 0 extra bytes present in
EAPOL frame.
Tue Feb 4 10:36:41.859 <kernel> inputEAPOLFrame: Received message 1 of 4
Tue Feb 4 10:36:41.859 <kernel> FULL RSN IE FOUND:
Tue Feb 4 10:36:41.859 [00000000] 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
Tue Feb 4 10:36:41.859 <kernel> storeFullRSNIE: getAP_IE_LIST returned 0
Tue Feb 4 10:36:41.859 <kernel> PMK:
Tue Feb 4 10:36:41.859 [00000000] 83 00 11 5C 06 D1 4E DF 51 A4 15 48 D7 65 22
82 A6 3E 8B 53 69 39 7E 72 08 83 16 2B 9B BA
Tue Feb 4 10:36:41.859 [0000001E] CB B3
Tue Feb 4 10:36:41.859 <kernel> TPTK:
Tue Feb 4 10:36:41.859 [00000000] AB ED 40 E3 15 C9 93 FA 25 9F 52 C6 9C 20 E8
EE 12 55 38 F3 1D 0A BB E0 57 7E 93 A1 E4 6C
Tue Feb 4 10:36:41.859 [0000001E] E6 AC 2B 4E 95 97 97 DE 5E 5E 66 9D C8 EB 5F
81 10 C9 3F B2 10 AE E7 20 B7 8D 95 53 D8 36
Tue Feb 4 10:36:41.859 [0000003C] 8D 1B 57 3D
Tue Feb 4 10:36:41.859 <kernel> KEY MIC:
Tue Feb 4 10:36:41.860 [00000000] DB A3 5C 33 7C 36 D6 67 01 36 B2 42 55 4F 98
94
Tue Feb 4 10:36:41.860 <kernel> process1of4: sending replyPacket 135 bytes
Tue Feb 4 10:36:41.967 <kernel> Successfully joined network with BSSID
42:42:42:42:42:42
_______________________________________________
openwrt-users mailing list
[email protected]
https://lists.openwrt.org/cgi-bin/mailman/listinfo/openwrt-users
