Понимание ограничения скорости и лог-сообщений

Понимание ограничения скорости и лог-сообщений, UniFi Network

ksballen

Guest

26.12.2017 03:17:00

При устранении другой проблемы — постоянных перезапусков AP (Unifi AP-AC-Pro) — я заметил странные записи в логах и хотел понять, что именно вижу и как это влияет.

У меня настроено ограничение пропускной способности трафика

У меня есть кабельный канал на 110 Мбит/с, группа пользователей Guest применяется к Guest SSID и VLAN, Main LAN — к Main SSID и VLAN. SSID и VLAN для Point of Sale не имеют ограничений. Это моя попытка гарантировать, что трафик POS всегда будет иметь некоторую пропускную способность. (Если есть более правильные способы добиться этого — буду рад услышать, это просто моя догадка.)

В логах моего syslog-сервера (и на самих устройствах) я вижу такие сообщения:
Dec 25 08:54:53 10.0.10.8 kernel: [61038.720000] ieee80211_ioctl_set_ratelimit: node with aid 1 and mac 5c:aa:fd:50:4a:40 has been tagged for rate-limiting

Что меня заинтересовало:
1. Это устройство использует килобиты данных в день, когда я вижу это сообщение.
2. Main LAN в этот момент имеет около 500 Кбит трафика (был Рождественский день, место было закрыто), так зачем ему вообще ограничивать скорость?
3. Этот MAC-адрес принадлежит проводному устройству, так почему я вижу такие сообщения от своих AP (10.0.10.8 — в этом примере AP)? Почему им вообще не безразлично это устройство?

Меня больше всего беспокоит, что я создаю дополнительную нагрузку на учёт трафика сети и процессоры AP, и хотелось бы это понять. Заранее спасибо за идеи.

(Более полный пример ниже)
Dec 24 23:47:49 10.0.10.7 kernel: [28674.490000] ieee80211_ioctl_set_ratelimit: node with aid 3 and mac 5c:aa:fd:50:4a:40 has been tagged for rate-limiting
Dec 24 23:47:53 10.0.10.7 libubnt[7618]: wevent.ubnt_custom_event(): EVENT_STA_LEAVE ath2: 5c:aa:fd:50:4a:40 / 3
Dec 24 23:47:53 10.0.10.6 hostapd: ath1: STA 82:2a:a8:9a:3b:f5 DRIVER: Sead AUTH addr=5c:aa:fd:50:4a:40 status_code=0
Dec 24 23:47:53 10.0.10.6 hostapd: ath1: STA 5c:aa:fd:50:4a:40 IEEE 802.11: associated
Dec 24 23:47:53 10.0.10.6 libubnt[5429]: wevent.ubnt_custom_event(): EVENT_STA_JOIN ath1: 5c:aa:fd:50:4a:40 / 1
Dec 24 23:47:53 10.0.10.6 kernel: [32987.240000] ieee80211_ioctl_set_ratelimit: node with aid 1 and mac 5c:aa:fd:50:4a:40 has been tagged for rate-limiting
Dec 24 23:47:57 10.0.10.6 hostapd: ath1: STA 82:2a:a8:9a:3b:f5 DRIVER: Sead AUTH addr=5c:aa:fd:50:4a:40 status_code=0
Dec 24 23:47:57 10.0.10.6 hostapd: ath1: STA 5c:aa:fd:50:4a:40 IEEE 802.11: associated
Dec 24 23:47:57 10.0.10.6 libubnt[5429]: wevent.ubnt_custom_event(): EVENT_STA_LEAVE ath1: 5c:aa:fd:50:4a:40 / 1
Dec 24 23:47:57 10.0.10.6 libubnt[5429]: wevent.ubnt_custom_event(): EVENT_STA_JOIN ath1: 5c:aa:fd:50:4a:40 / 1
Dec 24 23:47:57 10.0.10.6 kernel: [32991.290000] ieee80211_ioctl_set_ratelimit: node with aid 1 and mac 5c:aa:fd:50:4a:40 has been tagged for rate-limiting
Dec 24 23:47:58 10.0.10.7 hostapd: ath2: STA 5c:aa:fd:50:4a:40 IEEE 802.11: deauthenticated due to local deauth request
Dec 24 23:48:01 10.0.10.6 hostapd: ath1: STA 82:2a:a8:9a:3b:f5 DRIVER: Sead AUTH addr=5c:aa:fd:50:4a:40 status_code=0
Dec 24 23:48:01 10.0.10.6 hostapd: ath1: STA 5c:aa:fd:50:4a:40 IEEE 802.11: associated
Dec 24 23:48:01 10.0.10.6 libubnt[5429]: wevent.ubnt_custom_event(): EVENT_STA_LEAVE ath1: 5c:aa:fd:50:4a:40 / 1
Dec 24 23:48:01 10.0.10.6 libubnt[5429]: wevent.ubnt_custom_event(): EVENT_STA_JOIN ath1: 5c:aa:fd:50:4a:40 / 1
Dec 24 23:48:01 10.0.10.6 kernel: [32995.340000] ieee80211_ioctl_set_ratelimit: node with aid 1 and mac 5c:aa:fd:50:4a:40 has been tagged for rate-limiting

somehowunified

Guest

23.05.2018 00:19:00

Редактирование: Отключение USPSD на ВСЕХ беспроводных сетях наконец-то решило проблему. Ну, это было бы слишком просто. Умный счетчик снова перестал передавать данные спустя полтора часа. Сообщения о лимите скорости вернулись для некоторых устройств. Но у умного счетчика появлялись только события «без лимита скорости» (их было около 500 за последние 30 минут), и НИКАКИХ событий «про лимит скорости». Вот последние 20 событий для MAC-адреса умного счетчика:

May 23 02:08:56 192.168.156.5 May 23 02:08:56 ("U7PG2,802aa8c6ab11,v3.9.27.8537") kernel: [11276.690000] ieee80211_ioctl_set_ratelimit: узел с aid 1 и mac d0:5f:b8:4f:ab:12 помечен без ограничения скорости
May 23 02:08:56 192.168.156.5 May 23 02:08:56 ("U7PG2,802aa8c6ab11,v3.9.27.8537") libubnt[17043]: wevent.ubnt_custom_event(): EVENT_STA_JOIN ath2: d0:5f:b8:4f:ab:12 / 1
May 23 02:08:56 192.168.156.5 May 23 02:08:56 ("U7PG2,802aa8c6ab11,v3.9.27.8537") hostapd: ath2: STA d0:5f:b8:4f:ab:12 WPA: завершено установление парного ключа (RSN)
May 23 02:08:56 192.168.156.5 May 23 02:08:56 ("U7PG2,802aa8c6ab11,v3.9.27.8537") libubnt[17043]: wevent.ubnt_custom_event(): EVENT_STA_LEAVE ath2: d0:5f:b8:4f:ab:12 / 1
May 23 02:08:56 192.168.156.5 May 23 02:08:56 ("U7PG2,802aa8c6ab11,v3.9.27.8537") hostapd: ath2: STA d0:5f:b8:4f:ab:12 IEEE 802.11: подключено
May 23 02:08:56 192.168.156.5 May 23 02:08:56 ("U7PG2,802aa8c6ab11,v3.9.27.8537") hostapd: ath2: STA 92:2a:a8:c7:ab:13 DRIVER: Sead AUTH addr=d0:5f:b8:4f:ab:12 status_code=0
May 23 02:08:56 192.168.156.5 May 23 02:08:56 ("U7PG2,802aa8c6ab11,v3.9.27.8537") hostapd: ath2: STA d0:5f:b8:4f:ab:12 IEEE 802.11: отключено
May 23 02:08:56 192.168.156.5 May 23 02:08:56 ("U7PG2,802aa8c6ab11,v3.9.27.8537") hostapd: ath2: STA d0:5f:b8:4f:ab:12 IEEE 802.11: sta_stats
May 23 02:08:51 192.168.156.5 May 23 02:08:51 ("U7PG2,802aa8c6ab11,v3.9.27.8537") kernel: [11271.710000] ieee80211_ioctl_set_ratelimit: узел с aid 1 и mac d0:5f:b8:4f:ab:12 помечен без ограничения скорости
May 23 02:08:51 192.168.156.5 May 23 02:08:51 ("U7PG2,802aa8c6ab11,v3.9.27.8537") libubnt[17043]: wevent.ubnt_custom_event(): EVENT_STA_JOIN ath2: d0:5f:b8:4f:ab:12 / 1
May 23 02:08:51 192.168.156.5 May 23 02:08:51 ("U7PG2,802aa8c6ab11,v3.9.27.8537") libubnt[17043]: wevent.ubnt_custom_event(): EVENT_STA_LEAVE ath2: d0:5f:b8:4f:ab:12 / 1
May 23 02:08:51 192.168.156.5 May 23 02:08:51 ("U7PG2,802aa8c6ab11,v3.9.27.8537") hostapd: ath2: STA d0:5f:b8:4f:ab:12 WPA: завершено установление парного ключа (RSN)
May 23 02:08:51 192.168.156.5 May 23 02:08:51 ("U7PG2,802aa8c6ab11,v3.9.27.8537") hostapd: ath2: STA d0:5f:b8:4f:ab:12 IEEE 802.11: подключено
May 23 02:08:51 192.168.156.5 May 23 02:08:51 ("U7PG2,802aa8c6ab11,v3.9.27.8537") hostapd: ath2: STA 92:2a:a8:c7:ab:13 DRIVER: Sead AUTH addr=d0:5f:b8:4f:ab:12 status_code=0
May 23 02:08:51 192.168.156.5 May 23 02:08:51 ("U7PG2,802aa8c6ab11,v3.9.27.8537") hostapd: ath2: STA d0:5f:b8:4f:ab:12 IEEE 802.11: отключено
May 23 02:08:51 192.168.156.5 May 23 02:08:51 ("U7PG2,802aa8c6ab11,v3.9.27.8537") hostapd: ath2: STA d0:5f:b8:4f:ab:12 IEEE 802.11: sta_stats
May 23 02:08:46 192.168.156.5 May 23 02:08:46 ("U7PG2,802aa8c6ab11,v3.9.27.8537") kernel: [11266.640000] ieee80211_ioctl_set_ratelimit: узел с aid 1 и mac d0:5f:b8:4f:ab:12 помечен без ограничения скорости
May 23 02:08:46 192.168.156.5 May 23 02:08:46 ("U7PG2,802aa8c6ab11,v3.9.27.8537") libubnt[17043]: wevent.ubnt_custom_event(): EVENT_STA_JOIN ath2: d0:5f:b8:4f:ab:12 / 1
May 23 02:08:46 192.168.156.5 May 23 02:08:46 ("U7PG2,802aa8c6ab11,v3.9.27.8537") libubnt[17043]: wevent.ubnt_custom_event(): EVENT_STA_LEAVE ath2: d0:5f:b8:4f:ab:12 / 1
May 23 02:08:46 192.168.156.5 May 23 02:08:46 ("U7PG2,802aa8c6ab11,v3.9.27.8537") hostapd: ath2: STA d0:5f:b8:4f:ab:12 WPA: завершено установление парного ключа (RSN)

patriwag Guest	#3 16.05.2018 11:49:00 У меня такая же или похожая проблема, и я не могу использовать свои складские устройства: https://community.ui.com/questions/5bde6fa9-85cd-43af-915b-c47fcc4e3c04

tgix-msa

Guest

16.03.2018 05:46:00

Мы решили эту проблему, добавив простой таймер к блоку питания, который перезагружает точку доступа каждую ночь в 01:00. Это не самый блестящий технологический ход, но уже почти две недели всё нормально. Письма о неработающей точке доступа раздражают, и однажды мы точно пропустим важное сообщение о сбое.

heinerb

Guest

15.03.2018 19:36:00

У меня такая же проблема с AP AC Lite уже несколько дней. Одно устройство внезапно постоянно попадает под ограничение скорости, потом переключается на более удалённый AP (AP AC Pro), а затем возвращается к AP AC Lite, где снова становится жертвой ограничения скорости. Это повторяется бесконечно в течение нескольких часов. Странно то, что я не настраивал никаких ограничений скорости. Происходит это на прошивках 3.9.24, 3.9.21 и 3.9.19. Точно не скажу, с чего всё началось. А у вас за это время удалось решить проблему?

tgix-msa Guest	#6 01.03.2018 07:29:00 У меня точно такая же проблема — затронутые клиенты (в основном iPhone, насколько я знаю, один SE и один 7) не видят WiFi или постоянно теряют сеть. При включении WiFi на устройстве, где проблема, список SSID постоянно обновляется, и некоторые SSID пропадают на 10-15 секунд, а потом снова появляются. Сайт — это изолированная ферма, рядом нет других SSID кроме наших собственных. Feb 28 19:25:52 ap-vrum authpriv.info dropbear[12001]: Child connection from 192.168.xx.177:32774 Feb 28 19:25:55 ap-vrum authpriv.notice dropbear[12001]: Password auth succeeded for 'admin' from 192.168.xx.177:32774 Feb 28 19:27:17 ap-vrum daemon.info hostapd: ath3: STA 12:9f:c2:xx:xx:xx DRIVER: Sead AUTH addr=e0:5f:45:xx:xx:xx status_code=0 Feb 28 19:27:17 ap-vrum daemon.info hostapd: ath3: STA e0:5f:45:xx:xx:xx IEEE 802.11: associated Feb 28 19:27:17 ap-vrum user.info libubnt[2029]: wevent.ubnt_custom_event(): EVENT_STA_JOIN ath3: e0:5f:45:xx:xx:xx / 1 Feb 28 19:27:17 ap-vrum kern.warn kernel: [645341.270000] ieee80211_ioctl_set_ratelimit: node with aid 1 and mac e0:5f:45:xx:xx:xx has been tagged for rate-limiting Feb 28 19:27:21 ap-vrum user.info libubnt[2029]: wevent.ubnt_custom_event(): EVENT_STA_LEAVE ath3: e0:5f:45:xx:xx:xx / 1 Feb 28 19:27:26 ap-vrum daemon.info hostapd: ath3: STA e0:5f:45:xx:xx:xx IEEE 802.11: deauthenticated due to local deauth request Feb 28 19:28:42 ap-vrum daemon.info hostapd: ath3: STA 12:9f:c2:xx:xx:xx DRIVER: Sead AUTH addr=e0:5f:45:xx:xx:xx status_code=0 Feb 28 19:28:42 ap-vrum daemon.info hostapd: ath3: STA e0:5f:45:xx:xx:xx IEEE 802.11: associated Feb 28 19:28:42 ap-vrum user.info libubnt[2029]: wevent.ubnt_custom_event(): EVENT_STA_JOIN ath3: e0:5f:45:xx:xx:xx / 1 Feb 28 19:28:42 ap-vrum kern.warn kernel: [645426.280000] ieee80211_ioctl_set_ratelimit: node with aid 1 and mac e0:5f:45:xx:xx:xx has been tagged for rate-limiting Feb 28 19:28:42 ap-vrum daemon.info hostapd: ath3: STA e0:5f:45:xx:xx:xx WPA: pairwise key handshake completed (RSN) Feb 28 19:28:42 ap-vrum user.info libubnt[2029]: wevent.ubnt_custom_event(): EVENT_STA_IP ath3: e0:5f:45:xx:xx:xx / 192.168.xx.150 Feb 28 19:28:52 ap-vrum daemon.info hostapd: ath3: STA e0:5f:45:xx:xx:xx RADIUS: starting accounting session 00000012-000001B3 В группах и в настройках управления скоростью передачи данных для 2G/5G ограничения скорости не установлены. Наш способ решить эту проблему — перезагружать проблемную точку доступа, после чего неделя-две всё работает нормально. Случается это только с одной конкретной точкой — AP-AC-Mesh с версией прошивки 3.9.19.8123, которая использует беспроводную магистраль. Полная сеть состоит из 4 AP-AC-Mesh и одного AP-AC-Mesh-Pro. Около 50 клиентов постоянно перемещаются по зоне.

Читают тему (гостей: 1)