Поднимал вопрос с поддержкой (тикет 3035361), но решил выложить это здесь, чтобы помочь всем, у кого похожие проблемы с совместной работой устройств. Возможно, мы заметили то, что другим упустили. Симптомы такие:
Не могу выйти в интернет с iPhone — при проверке настроек Wi-Fi видно, что он постоянно подключается и отключается, или показывает, что подключён, но IP не получает. Происходит только на моём проводном ACLite. ACM, подключённый по беспроводной линии, всегда работает нормально (даже когда устройство с проблемой, оно всё равно подключается к ACM во всех случаях, которые были).
Если поковыряться с выключением и включением Wi-Fi или забыть сеть, телефон иногда сообщает, что пароль неверный (хотя на самом деле это не так, ведь если переключиться на ACM — сразу подключается без проблем).
Вот что, по моему опыту, решает проблему (до следующего раза), проверяно много раз:
- Перезагрузка ACLite.
- Смена MAC-адреса устройства (если проблема возникает при выключенном приватном MAC — включить его, если при включённом — выключить).
- Изменение параметра 2.4 ГГц DTIM в приложении Unifi. Это очень интересно: значение, на которое меняешь, не имеет значения. Я исправлял, меняя на 1, ждёшь, пока опять сломается, меняешь на 3 — снова исправляется. Похоже, само изменение запускает некий процесс, который временно решает проблему. Сначала думал, что помогает переподключение устройства, но принудительное provision не помогает. Кроме того, вручную менять DTIM через SSH с помощью iwpriv тоже не помогает. Значит, при изменении DTIM в приложении Unifi происходит что-то ещё, что и решает проблему.
Логи /var/log/messages с ошибками. В примере устройство с проблемой имеет MAC b4:fa:48:d0:83:93:
Sun Jan 30 16:18:37 2022 user.info libubnt[3240]: wevent[3240]: wevent.ubnt_custom_event(): EVENT_STA_JOIN ath5: b4:fa:48:d0:83:93 / 3
Sun Jan 30 16:18:38 2022 user.info : stahtd[2657]: [STA-TRACKER].stahtd_dump_event(): {"assoc_status":"0","message_type":"STA_ASSOC_TRACKER","event_type":"failure","mac":"b4:fa:48:d0:83:93","vap":"ath5","assoc_delta":"0","wpa_auth_failures":"2","auth_delta":"0","event_id":"18","auth_ts":"548294.485150"}
Sun Jan 30 16:18:41 2022 kern.warn kernel: [548306.891731] ol_txrx_ast_find_hash_remove ast entry delete failed
Sun Jan 30 16:18:41 2022 kern.warn kernel: [548306.891759] ol_rx_peer_unmap_handler:Peer map has not handled properly for this, peer 848af000,peer_id 32,peer_mac b4:fa:48:d0:83:93
Sun Jan 30 16:18:41 2022 kern.warn kernel: [548306.891784] Peer ID invalid!
Sun Jan 30 16:18:41 2022 kern.warn kernel: [548306.891792] Unable to process TX info
Sun Jan 30 16:18:41 2022 user.info libubnt[3240]: wevent[3240]: wevent.ubnt_custom_event(): EVENT_STA_LEAVE ath5: b4:fa:48:d0:83:93 / 3
Sun Jan 30 16:18:42 2022 kern.warn kernel: [548307.883094] [wifi1] FWLOG: [24606475] WAL_DBGID_SET_HW_FILTER ( 0x436004 )
Sun Jan 30 16:18:42 2022 kern.warn kernel: [548307.883123] [wifi1] FWLOG: [24606476] WLAN_DEBUG_DBGID_PEER ( 0xdead, 0xb4d08393, 0x1 )
Вот мои заметки по состоянию на сейчас. Для контекста: ACLite работал сам по себе несколько лет без проблем. Проблемы появились примерно в конце сентября прошлого года. За пару месяцев до этого я добавил ACM с беспроводным аплинком, не уверен, вызвала ли проблема сама эта связка или обновление прошивки. Кажется, что проблемы связаны с выходом из зоны покрытия и возвращением, или с роумингом между двумя точками доступа. Большинство случаев проявляется, когда я двигаюсь между двумя AP или покидаю участок и возвращаюсь. Проблема очень непостоянна: иногда могу обращаться недели без проблем, иногда валит пару раз в неделю. Думаю, что на iPhone эта проблема заметнее, потому что другие устройства не уходят и не возвращаются на участок.
08/11/21 — проблема возникла, откатил обе точки доступа с 5.43.46 на 5.43.43.
16/11/21 — снова проблема — заметил, что смена DTIM решает её. Удалил Wi-Fi сети в Unifi, забыл обе точки доступа, заново принял ACLite, потом ACM — создал новые сети.
20/11/21 — опять проблема — поменял DTIM в Unifi, помогло. Обновил AP до версии 5.43.52.12774.
21/11/21 — снова проблема — впервые заметил, что при проблеме ACM всё равно подключается нормально. Попытка принудительного provision не помогла, сменил DTIM — решило снова. Почитав форумы с похожими жалобами, откатил обе точки до 4.3.28. Разделил SSID для 2.4 и 5 ГГц, выключил uapsd, multicast enhancement, band steering, fast roaming и proxy arp.
27/11/21 — стало нормально, объединил SSID обратно, включил uapsd, multicast enhancement, fast roam, band steering (включён только на aclite).
08/12/21 — был отключен свет, но всё было нормально, обновил AP до 5.43.52.
17/12/21 — обновил до 5.43.56.
25/12/21 — снова проблема (не уверен, как решил — смена DTIM или перезагрузка AP).
27/12/21 — опять проблема — откатил ACM до 4.3.28.
04/01/22 — вновь проблема — обновил ACM обратно до 5.43.56. Также выставил DTIM 2.4 на 1 и отключил DHCP snooping по просьбе поддержки.
24/01/22 — проблема снова. Пробовал менять DTIM через iwpriv — без эффекта, отключал ampdu через iwpriv — без эффекта, отключал band steering — тоже без результата, в итоге перезагрузил AP — помогло.
30/01/22 — снова проблема. Перезагрузка ACM не помогла (ожидалось). Перезапуск hostapd на aclite тоже без изменений. Отключил bss transition, fast roam и uapsd — вроде решило. Не уверен, помогло ли что-то из этого на самом деле или просто вызвало тот же побочный эффект, как при смене DTIM в Unifi.
Не могу выйти в интернет с iPhone — при проверке настроек Wi-Fi видно, что он постоянно подключается и отключается, или показывает, что подключён, но IP не получает. Происходит только на моём проводном ACLite. ACM, подключённый по беспроводной линии, всегда работает нормально (даже когда устройство с проблемой, оно всё равно подключается к ACM во всех случаях, которые были).
Если поковыряться с выключением и включением Wi-Fi или забыть сеть, телефон иногда сообщает, что пароль неверный (хотя на самом деле это не так, ведь если переключиться на ACM — сразу подключается без проблем).
Вот что, по моему опыту, решает проблему (до следующего раза), проверяно много раз:
- Перезагрузка ACLite.
- Смена MAC-адреса устройства (если проблема возникает при выключенном приватном MAC — включить его, если при включённом — выключить).
- Изменение параметра 2.4 ГГц DTIM в приложении Unifi. Это очень интересно: значение, на которое меняешь, не имеет значения. Я исправлял, меняя на 1, ждёшь, пока опять сломается, меняешь на 3 — снова исправляется. Похоже, само изменение запускает некий процесс, который временно решает проблему. Сначала думал, что помогает переподключение устройства, но принудительное provision не помогает. Кроме того, вручную менять DTIM через SSH с помощью iwpriv тоже не помогает. Значит, при изменении DTIM в приложении Unifi происходит что-то ещё, что и решает проблему.
Логи /var/log/messages с ошибками. В примере устройство с проблемой имеет MAC b4:fa:48:d0:83:93:
Sun Jan 30 16:18:37 2022 user.info libubnt[3240]: wevent[3240]: wevent.ubnt_custom_event(): EVENT_STA_JOIN ath5: b4:fa:48:d0:83:93 / 3
Sun Jan 30 16:18:38 2022 user.info : stahtd[2657]: [STA-TRACKER].stahtd_dump_event(): {"assoc_status":"0","message_type":"STA_ASSOC_TRACKER","event_type":"failure","mac":"b4:fa:48:d0:83:93","vap":"ath5","assoc_delta":"0","wpa_auth_failures":"2","auth_delta":"0","event_id":"18","auth_ts":"548294.485150"}
Sun Jan 30 16:18:41 2022 kern.warn kernel: [548306.891731] ol_txrx_ast_find_hash_remove ast entry delete failed
Sun Jan 30 16:18:41 2022 kern.warn kernel: [548306.891759] ol_rx_peer_unmap_handler:Peer map has not handled properly for this, peer 848af000,peer_id 32,peer_mac b4:fa:48:d0:83:93
Sun Jan 30 16:18:41 2022 kern.warn kernel: [548306.891784] Peer ID invalid!
Sun Jan 30 16:18:41 2022 kern.warn kernel: [548306.891792] Unable to process TX info
Sun Jan 30 16:18:41 2022 user.info libubnt[3240]: wevent[3240]: wevent.ubnt_custom_event(): EVENT_STA_LEAVE ath5: b4:fa:48:d0:83:93 / 3
Sun Jan 30 16:18:42 2022 kern.warn kernel: [548307.883094] [wifi1] FWLOG: [24606475] WAL_DBGID_SET_HW_FILTER ( 0x436004 )
Sun Jan 30 16:18:42 2022 kern.warn kernel: [548307.883123] [wifi1] FWLOG: [24606476] WLAN_DEBUG_DBGID_PEER ( 0xdead, 0xb4d08393, 0x1 )
Вот мои заметки по состоянию на сейчас. Для контекста: ACLite работал сам по себе несколько лет без проблем. Проблемы появились примерно в конце сентября прошлого года. За пару месяцев до этого я добавил ACM с беспроводным аплинком, не уверен, вызвала ли проблема сама эта связка или обновление прошивки. Кажется, что проблемы связаны с выходом из зоны покрытия и возвращением, или с роумингом между двумя точками доступа. Большинство случаев проявляется, когда я двигаюсь между двумя AP или покидаю участок и возвращаюсь. Проблема очень непостоянна: иногда могу обращаться недели без проблем, иногда валит пару раз в неделю. Думаю, что на iPhone эта проблема заметнее, потому что другие устройства не уходят и не возвращаются на участок.
08/11/21 — проблема возникла, откатил обе точки доступа с 5.43.46 на 5.43.43.
16/11/21 — снова проблема — заметил, что смена DTIM решает её. Удалил Wi-Fi сети в Unifi, забыл обе точки доступа, заново принял ACLite, потом ACM — создал новые сети.
20/11/21 — опять проблема — поменял DTIM в Unifi, помогло. Обновил AP до версии 5.43.52.12774.
21/11/21 — снова проблема — впервые заметил, что при проблеме ACM всё равно подключается нормально. Попытка принудительного provision не помогла, сменил DTIM — решило снова. Почитав форумы с похожими жалобами, откатил обе точки до 4.3.28. Разделил SSID для 2.4 и 5 ГГц, выключил uapsd, multicast enhancement, band steering, fast roaming и proxy arp.
27/11/21 — стало нормально, объединил SSID обратно, включил uapsd, multicast enhancement, fast roam, band steering (включён только на aclite).
08/12/21 — был отключен свет, но всё было нормально, обновил AP до 5.43.52.
17/12/21 — обновил до 5.43.56.
25/12/21 — снова проблема (не уверен, как решил — смена DTIM или перезагрузка AP).
27/12/21 — опять проблема — откатил ACM до 4.3.28.
04/01/22 — вновь проблема — обновил ACM обратно до 5.43.56. Также выставил DTIM 2.4 на 1 и отключил DHCP snooping по просьбе поддержки.
24/01/22 — проблема снова. Пробовал менять DTIM через iwpriv — без эффекта, отключал ampdu через iwpriv — без эффекта, отключал band steering — тоже без результата, в итоге перезагрузил AP — помогло.
30/01/22 — снова проблема. Перезагрузка ACM не помогла (ожидалось). Перезапуск hostapd на aclite тоже без изменений. Отключил bss transition, fast roam и uapsd — вроде решило. Не уверен, помогло ли что-то из этого на самом деле или просто вызвало тот же побочный эффект, как при смене DTIM в Unifi.
