unreliable AP VLAN Interfaces 23.05

André Valentin a.valentin at ddimension.net
Sat Nov 25 04:26:02 PST 2023


Hi!

Currently I try to use AP VLAN interfaces, but it seems to be very unstable. Directly after reboot, only some interfaces are created. If I do wifi down and wifi up, the all come up.
It does not depend on hardware, I have these problemes with ath10k and ath11k (with AP VLAN patch), ipq806x, ipq807x and ath79.

  I also tested this patch because of the netlink erros:
https://patchwork.ozlabs.org/project/hostap/patch/1341593561-14090-5-git-send-email-greearb@candelatech.com/
But it does not help.
Another test I did was disabling wpad on system boot, start it later and run a wifi up. Same problem. Also in this case fixable with wifi down; wifi up.

This is a log:
Sat Nov 25 12:12:01 2023 kern.info kernel: [   25.936801] IPv6: ADDRCONF(NETDEV_CHANGE): switch1: link becomes ready
Sat Nov 25 12:12:01 2023 kern.info kernel: [   25.942203] IPv6: ADDRCONF(NETDEV_CHANGE): switch1.1: link becomes ready
Sat Nov 25 12:12:08 2023 kern.info kernel: [   33.126292] l11: disabling
Sat Nov 25 12:13:05 2023 daemon.notice hostapd: Set new config for phy phy1:
Sat Nov 25 12:13:05 2023 daemon.notice hostapd: Set new config for phy phy0:
Sat Nov 25 12:13:06 2023 daemon.notice hostapd: Set new config for phy phy1:
Sat Nov 25 12:13:07 2023 daemon.notice hostapd: Set new config for phy phy0:
Sat Nov 25 12:13:42 2023 daemon.notice hostapd: Set new config for phy phy1: /var/run/hostapd-phy1.conf
Sat Nov 25 12:13:42 2023 daemon.notice hostapd: Restart interface for phy phy1
Sat Nov 25 12:13:42 2023 daemon.notice hostapd: Configuration file: data: driver=nl80211 logger_syslog=127 logger_syslog_level=0 logger_stdout=127 logger_stdout_level=0 country_code=DE ieee80211d=1 hw_mode=g supported_rates=60 120 180 240 360 480 540 basic_rates=60 120 180 240 360 480 540 beacon_int=100 chanlist=1 tx_queue_data2_burst=2.0 #num_global_macaddr=1 ieee80211n=1 ht_coex=0 ht_capab=[LDPC][SHORT-GI-20][SHORT-GI-40][TX-STBC][RX-STBC1][DSSS_CCK-40] ieee80211ac=1 vht_oper_chwidth=0 vht_oper_centr_freq_seg0_idx= vht_capab=[MAX-A-MPDU-LEN-EXP0] ieee80211ax=1 he_su_beamformer=1 he_su_beamformee=1 he_mu_beamformer=1 he_bss_color=128 he_spr_sr_control=3 he_default_pe_duration=4 he_rts_threshold=1023 he_mu_edca_qos_info_param_count=0 he_mu_edca_qos_info_q_ack=0 he_mu_edca_qos_info_queue_request=0 he_mu_edca_qos_info_txop_request=0 he_mu_edca_ac_be_aifsn=8 he_mu_edca_ac_be_aci=0 he_mu_edca_ac_be_ecwmin=9 he_mu_edca_ac_be_ecwmax=10 he_mu_edca_ac_be_timer=255 he_mu_edca_ac_bk_aifsn=15 he_mu_edca_ac_bk_aci=1 he_mu_edca_ac_bk_ecwmi
Sat Nov 25 12:13:42 2023 kern.info kernel: [   92.529694] switch1: port 5(wap-onet2) entered blocking state
Sat Nov 25 12:13:42 2023 kern.info kernel: [   92.529740] switch1: port 5(wap-onet2) entered disabled state
Sat Nov 25 12:13:42 2023 kern.info kernel: [   92.534663] device wap-onet2 entered promiscuous mode
Sat Nov 25 12:13:42 2023 daemon.warn hostapd: nl80211: Failed to add interface wap-onet2 into bridge switch1: Resource busy
Sat Nov 25 12:13:42 2023 daemon.notice hostapd: wap-onet2: interface state UNINITIALIZED->COUNTRY_UPDATE
Sat Nov 25 12:13:42 2023 kern.info kernel: [   92.541794] device wap-onet2 left promiscuous mode
Sat Nov 25 12:13:42 2023 kern.info kernel: [   92.545287] switch1: port 5(wap-onet2) entered disabled state
Sat Nov 25 12:13:43 2023 kern.info kernel: [   92.628221] switch1: port 5(wap-onet2) entered blocking state
Sat Nov 25 12:13:43 2023 kern.info kernel: [   92.628269] switch1: port 5(wap-onet2) entered disabled state
Sat Nov 25 12:13:43 2023 kern.info kernel: [   92.633226] device wap-onet2 entered promiscuous mode
Sat Nov 25 12:13:43 2023 kern.info kernel: [   92.659012] switch1: port 6(wap-knet2) entered blocking state
Sat Nov 25 12:13:43 2023 kern.info kernel: [   92.659061] switch1: port 6(wap-knet2) entered disabled state
Sat Nov 25 12:13:43 2023 kern.info kernel: [   92.664018] device wap-knet2 entered promiscuous mode
Sat Nov 25 12:13:43 2023 kern.info kernel: [   92.671837] switch1: port 6(wap-knet2) entered blocking state
Sat Nov 25 12:13:43 2023 kern.info kernel: [   92.674521] switch1: port 6(wap-knet2) entered forwarding state
Sat Nov 25 12:13:43 2023 kern.info kernel: [   92.709805] device wap-knet2 left promiscuous mode
Sat Nov 25 12:13:43 2023 kern.info kernel: [   92.709914] switch1: port 6(wap-knet2) entered disabled state
Sat Nov 25 12:13:43 2023 kern.info kernel: [   92.827919] switch1: port 6(wap-knet2) entered blocking state
Sat Nov 25 12:13:43 2023 kern.info kernel: [   92.827968] switch1: port 6(wap-knet2) entered disabled state
Sat Nov 25 12:13:43 2023 kern.info kernel: [   92.832924] device wap-knet2 entered promiscuous mode
Sat Nov 25 12:13:43 2023 kern.info kernel: [   92.838597] switch1: port 6(wap-knet2) entered blocking state
Sat Nov 25 12:13:43 2023 kern.info kernel: [   92.843427] switch1: port 6(wap-knet2) entered forwarding state
Sat Nov 25 12:13:43 2023 kern.info kernel: [   93.238376] switch1: port 7(wap-fl2) entered blocking state
Sat Nov 25 12:13:43 2023 kern.info kernel: [   93.238426] switch1: port 7(wap-fl2) entered disabled state
Sat Nov 25 12:13:43 2023 kern.info kernel: [   93.243043] device wap-fl2 entered promiscuous mode
Sat Nov 25 12:13:43 2023 kern.info kernel: [   93.250028] switch1: port 7(wap-fl2) entered blocking state
Sat Nov 25 12:13:43 2023 kern.info kernel: [   93.253201] switch1: port 7(wap-fl2) entered forwarding state
Sat Nov 25 12:13:43 2023 daemon.info hostapd: wap-fl2: RADIUS Authentication server 192.168.203.5:1812
Sat Nov 25 12:13:43 2023 kern.info kernel: [   93.324126] device wap-fl2 left promiscuous mode
Sat Nov 25 12:13:43 2023 kern.info kernel: [   93.324243] switch1: port 7(wap-fl2) entered disabled state
Sat Nov 25 12:13:43 2023 kern.info kernel: [   93.388161] switch1: port 7(wap-fl2) entered blocking state
Sat Nov 25 12:13:43 2023 kern.info kernel: [   93.388204] switch1: port 7(wap-fl2) entered disabled state
Sat Nov 25 12:13:43 2023 kern.info kernel: [   93.392808] device wap-fl2 entered promiscuous mode
Sat Nov 25 12:13:43 2023 kern.info kernel: [   93.398241] switch1: port 7(wap-fl2) entered blocking state
Sat Nov 25 12:13:43 2023 kern.info kernel: [   93.402967] switch1: port 7(wap-fl2) entered forwarding state
Sat Nov 25 12:13:43 2023 kern.info kernel: [   93.498442] switch1: port 8(kinfra2) entered blocking state
Sat Nov 25 12:13:43 2023 kern.info kernel: [   93.498493] switch1: port 8(kinfra2) entered disabled state
Sat Nov 25 12:13:43 2023 kern.info kernel: [   93.503108] device kinfra2 entered promiscuous mode
Sat Nov 25 12:13:43 2023 kern.info kernel: [   93.509931] switch1: port 8(kinfra2) entered blocking state
Sat Nov 25 12:13:43 2023 kern.info kernel: [   93.513259] switch1: port 8(kinfra2) entered forwarding state
Sat Nov 25 12:13:43 2023 kern.info kernel: [   93.553292] device kinfra2 left promiscuous mode
Sat Nov 25 12:13:43 2023 kern.info kernel: [   93.553394] switch1: port 8(kinfra2) entered disabled state
Sat Nov 25 12:13:44 2023 kern.info kernel: [   93.588829] switch1: port 8(kinfra2) entered blocking state
Sat Nov 25 12:13:44 2023 kern.info kernel: [   93.588877] switch1: port 8(kinfra2) entered disabled state
Sat Nov 25 12:13:44 2023 kern.info kernel: [   93.593531] device kinfra2 entered promiscuous mode
Sat Nov 25 12:13:44 2023 kern.info kernel: [   93.598971] switch1: port 8(kinfra2) entered blocking state
Sat Nov 25 12:13:44 2023 kern.info kernel: [   93.603638] switch1: port 8(kinfra2) entered forwarding state
Sat Nov 25 12:13:44 2023 kern.info kernel: [   93.609492] switch1: port 6(wap-knet2) entered disabled state
Sat Nov 25 12:13:44 2023 kern.info kernel: [   93.615629] switch1: port 7(wap-fl2) entered disabled state
Sat Nov 25 12:13:44 2023 kern.info kernel: [   93.621099] switch1: port 8(kinfra2) entered disabled state
Sat Nov 25 12:13:44 2023 kern.info kernel: [   93.754678] IPv6: ADDRCONF(NETDEV_CHANGE): kinfra2: link becomes ready
Sat Nov 25 12:13:44 2023 kern.info kernel: [   93.754862] switch1: port 8(kinfra2) entered blocking state
Sat Nov 25 12:13:44 2023 kern.info kernel: [   93.760144] switch1: port 8(kinfra2) entered forwarding state
Sat Nov 25 12:13:44 2023 kern.info kernel: [   93.868525] switch1: port 9(wap-ops2) entered blocking state
Sat Nov 25 12:13:44 2023 kern.info kernel: [   93.868579] switch1: port 9(wap-ops2) entered disabled state
Sat Nov 25 12:13:44 2023 kern.info kernel: [   93.873551] device wap-ops2 entered promiscuous mode
Sat Nov 25 12:13:44 2023 kern.info kernel: [   93.880529] switch1: port 9(wap-ops2) entered blocking state
Sat Nov 25 12:13:44 2023 kern.info kernel: [   93.883865] switch1: port 9(wap-ops2) entered forwarding state
Sat Nov 25 12:13:44 2023 daemon.notice hostapd: wap-onet2: interface state COUNTRY_UPDATE->ENABLED
Sat Nov 25 12:13:44 2023 kern.info kernel: [   94.008275] device wap-ops2 left promiscuous mode
Sat Nov 25 12:13:44 2023 kern.info kernel: [   94.008418] switch1: port 9(wap-ops2) entered disabled state
Sat Nov 25 12:13:44 2023 kern.info kernel: [   94.066629] switch1: port 5(wap-onet2) entered blocking state
Sat Nov 25 12:13:44 2023 kern.info kernel: [   94.066681] switch1: port 5(wap-onet2) entered forwarding state
Sat Nov 25 12:13:44 2023 kern.info kernel: [   94.072278] switch1: port 9(wap-ops2) entered blocking state
Sat Nov 25 12:13:44 2023 kern.info kernel: [   94.077141] switch1: port 9(wap-ops2) entered disabled state
Sat Nov 25 12:13:44 2023 kern.info kernel: [   94.083297] device wap-ops2 entered promiscuous mode
Sat Nov 25 12:13:44 2023 kern.info kernel: [   94.088798] switch1: port 9(wap-ops2) entered blocking state
Sat Nov 25 12:13:44 2023 kern.info kernel: [   94.093594] switch1: port 9(wap-ops2) entered forwarding state
Sat Nov 25 12:13:44 2023 daemon.notice hostapd: wap-onet2: AP-ENABLED
Sat Nov 25 12:13:44 2023 daemon.notice hostapd: Set new config for phy phy0: /var/run/hostapd-phy0.conf
Sat Nov 25 12:13:44 2023 daemon.notice hostapd: Restart interface for phy phy0
Sat Nov 25 12:13:44 2023 daemon.notice hostapd: Configuration file: data: driver=nl80211 logger_syslog=127 logger_syslog_level=0 logger_stdout=127 logger_stdout_level=0 country_code=DE ieee80211d=1 ieee80211h=1 hw_mode=a supported_rates=120 180 240 360 480 540 basic_rates=120 180 240 360 480 540 beacon_int=100 chanlist=52 100 116 tx_queue_data2_burst=2.0 #num_global_macaddr=1 ieee80211n=1 ht_coex=0 ht_capab=[HT40+][LDPC][SHORT-GI-20][SHORT-GI-40][TX-STBC][RX-STBC1][MAX-AMSDU-7935][DSSS_CCK-40] ieee80211ac=1 vht_oper_chwidth=1 vht_oper_centr_freq_seg0_idx=106 vht_capab=[RXLDPC][SHORT-GI-80][SHORT-GI-160][TX-STBC-2BY1][SU-BEAMFORMER][SU-BEAMFORMEE][MU-BEAMFORMER][MU-BEAMFORMEE][RX-ANTENNA-PATTERN][TX-ANTENNA-PATTERN][RX-STBC-1][SOUNDING-DIMENSION-4][BF-ANTENNA-4][VHT160-80PLUS80][MAX-MPDU-11454][MAX-A-MPDU-LEN-EXP7] ieee80211ax=1 he_oper_chwidth=1 he_oper_centr_freq_seg0_idx=106 he_su_beamformer=1 he_su_beamformee=1 he_mu_beamformer=1 he_bss_color=128 he_spr_sr_control=3 he_default_pe_duration=4 he_rts_threshold=1023 he_mu_edca_
Sat Nov 25 12:13:44 2023 kern.info kernel: [   94.443836] switch1: port 10(wap-onet1) entered blocking state
Sat Nov 25 12:13:44 2023 kern.info kernel: [   94.443896] switch1: port 10(wap-onet1) entered disabled state
Sat Nov 25 12:13:44 2023 kern.info kernel: [   94.448981] device wap-onet1 entered promiscuous mode
Sat Nov 25 12:13:44 2023 kern.info kernel: [   94.454618] switch1: port 10(wap-onet1) entered blocking state
Sat Nov 25 12:13:44 2023 kern.info kernel: [   94.459610] switch1: port 10(wap-onet1) entered forwarding state
Sat Nov 25 12:13:44 2023 daemon.notice hostapd: wap-onet1: interface state UNINITIALIZED->COUNTRY_UPDATE
Sat Nov 25 12:13:44 2023 daemon.notice hostapd: wap-onet1: interface state COUNTRY_UPDATE->HT_SCAN
Sat Nov 25 12:13:44 2023 daemon.err hostapd: VLAN: vlan_event_receive: recvfrom failed: No buffer space available
Sat Nov 25 12:13:44 2023 daemon.err hostapd: VLAN: vlan_event_receive: recvfrom failed: No buffer space available
Sat Nov 25 12:13:45 2023 kern.info kernel: [   94.590687] device wap-onet1 left promiscuous mode
Sat Nov 25 12:13:45 2023 kern.info kernel: [   94.590817] switch1: port 10(wap-onet1) entered disabled state
Sat Nov 25 12:13:45 2023 daemon.err hostapd: VLAN: ifconfig_helper: ioctl(SIOCGIFFLAGS) failed for interface wap-knet2-ops: No such device
Sat Nov 25 12:13:45 2023 daemon.err hostapd: VLAN: ifconfig_helper: ioctl(SIOCGIFFLAGS) failed for interface wap-knet2-ops: No such device
Sat Nov 25 12:13:45 2023 kern.info kernel: [   94.659362] switch1: port 10(wap-onet1) entered blocking state
Sat Nov 25 12:13:45 2023 kern.info kernel: [   94.659420] switch1: port 10(wap-onet1) entered disabled state
Sat Nov 25 12:13:45 2023 kern.info kernel: [   94.664447] device wap-onet1 entered promiscuous mode
Sat Nov 25 12:13:45 2023 daemon.err hostapd: VLAN: ifconfig_helper: ioctl(SIOCGIFFLAGS) failed for interface wap-knet2-ops: No such device
Sat Nov 25 12:13:45 2023 daemon.err hostapd: VLAN: ifconfig_helper: ioctl(SIOCSIFFLAGS) failed for interface wap-knet2-prv (up=1): No such device
Sat Nov 25 12:13:45 2023 daemon.err hostapd: VLAN: ifconfig_helper: ioctl(SIOCGIFFLAGS) failed for interface wap-knet2-ops: No such device
Sat Nov 25 12:13:45 2023 daemon.notice hostapd: wap-onet1: interface state HT_SCAN->DFS
Sat Nov 25 12:13:45 2023 daemon.notice hostapd: wap-onet1: DFS-CAC-START freq=5500 chan=100 sec_chan=1, width=1, seg0=106, seg1=0, cac_time=60s
Sat Nov 25 12:13:51 2023 daemon.notice hostapd: handle_probe_req: send failed
Sat Nov 25 12:13:51 2023 daemon.notice hostapd: handle_probe_req: send failed
Sat Nov 25 12:13:52 2023 daemon.notice hostapd: handle_probe_req: send failed
Sat Nov 25 12:13:52 2023 daemon.notice hostapd: handle_probe_req: send failed
Sat Nov 25 12:13:52 2023 daemon.notice hostapd: handle_probe_req: send failed
Sat Nov 25 12:13:52 2023 daemon.notice hostapd: handle_probe_req: send failed
Sat Nov 25 12:13:53 2023 daemon.notice hostapd: handle_probe_req: send failed
Sat Nov 25 12:13:53 2023 daemon.notice hostapd: handle_probe_req: send failed
Sat Nov 25 12:13:54 2023 daemon.notice hostapd: handle_probe_req: send failed
Sat Nov 25 12:13:54 2023 daemon.notice hostapd: handle_probe_req: send failed
Sat Nov 25 12:13:54 2023 daemon.notice hostapd: handle_probe_req: send failed
Sat Nov 25 12:13:54 2023 daemon.notice hostapd: handle_probe_req: send failed
Sat Nov 25 12:13:54 2023 daemon.notice hostapd: handle_probe_req: send failed
Sat Nov 25 12:13:54 2023 daemon.notice hostapd: handle_probe_req: send failed
Sat Nov 25 12:13:54 2023 daemon.notice hostapd: handle_probe_req: send failed
Sat Nov 25 12:13:54 2023 daemon.notice hostapd: handle_probe_req: send failed
Sat Nov 25 12:14:09 2023 daemon.notice hostapd: handle_probe_req: send failed
Sat Nov 25 12:14:09 2023 daemon.notice hostapd: handle_probe_req: send failed
Sat Nov 25 12:14:10 2023 daemon.notice hostapd: handle_probe_req: send failed
Sat Nov 25 12:14:10 2023 daemon.notice hostapd: handle_probe_req: send failed
Sat Nov 25 12:14:17 2023 daemon.notice hostapd: handle_probe_req: send failed
Sat Nov 25 12:14:18 2023 daemon.notice hostapd: handle_probe_req: send failed
Sat Nov 25 12:14:18 2023 daemon.notice hostapd: handle_probe_req: send failed
Sat Nov 25 12:14:31 2023 daemon.notice hostapd: handle_probe_req: send failed
Sat Nov 25 12:14:31 2023 daemon.notice hostapd: handle_probe_req: send failed
Sat Nov 25 12:14:32 2023 daemon.notice hostapd: handle_probe_req: send failed
Sat Nov 25 12:14:32 2023 daemon.notice hostapd: handle_probe_req: send failed
Sat Nov 25 12:14:33 2023 daemon.notice hostapd: handle_probe_req: send failed
Sat Nov 25 12:14:33 2023 daemon.notice hostapd: handle_probe_req: send failed
Sat Nov 25 12:14:47 2023 daemon.notice hostapd: wap-onet1: DFS-CAC-COMPLETED success=1 freq=5500 ht_enabled=0 chan_offset=0 chan_width=3 cf1=5530 cf2=0
Sat Nov 25 12:14:47 2023 kern.info kernel: [  156.651392] switch1: port 11(wap-knet1) entered blocking state
Sat Nov 25 12:14:47 2023 kern.info kernel: [  156.651447] switch1: port 11(wap-knet1) entered disabled state
Sat Nov 25 12:14:47 2023 kern.info kernel: [  156.656480] device wap-knet1 entered promiscuous mode
Sat Nov 25 12:14:47 2023 kern.info kernel: [  156.663884] switch1: port 11(wap-knet1) entered blocking state
Sat Nov 25 12:14:47 2023 kern.info kernel: [  156.667118] switch1: port 11(wap-knet1) entered forwarding state
Sat Nov 25 12:14:47 2023 kern.info kernel: [  156.673214] switch1: port 11(wap-knet1) entered disabled state
Sat Nov 25 12:14:47 2023 kern.info kernel: [  156.711477] device wap-knet1 left promiscuous mode
Sat Nov 25 12:14:47 2023 kern.info kernel: [  156.711604] switch1: port 11(wap-knet1) entered disabled state
Sat Nov 25 12:14:47 2023 kern.info kernel: [  156.738449] switch1: port 11(wap-knet1) entered blocking state
Sat Nov 25 12:14:47 2023 kern.info kernel: [  156.738491] switch1: port 11(wap-knet1) entered disabled state
Sat Nov 25 12:14:47 2023 kern.info kernel: [  156.743455] device wap-knet1 entered promiscuous mode
Sat Nov 25 12:14:47 2023 kern.info kernel: [  156.865703] switch1: port 12(wap-knet1-prv) entered blocking state
Sat Nov 25 12:14:47 2023 kern.info kernel: [  156.865747] switch1: port 12(wap-knet1-prv) entered disabled state
Sat Nov 25 12:14:47 2023 kern.info kernel: [  156.871329] device wap-knet1-prv entered promiscuous mode
Sat Nov 25 12:14:47 2023 kern.info kernel: [  156.877190] switch1: port 12(wap-knet1-prv) entered blocking state
Sat Nov 25 12:14:47 2023 kern.info kernel: [  156.882420] switch1: port 12(wap-knet1-prv) entered forwarding state
Sat Nov 25 12:14:47 2023 kern.info kernel: [  156.892652] switch1: port 13(wap-knet1-ops) entered blocking state
Sat Nov 25 12:14:47 2023 kern.info kernel: [  156.895007] switch1: port 13(wap-knet1-ops) entered disabled state
Sat Nov 25 12:14:47 2023 kern.info kernel: [  156.901671] device wap-knet1-ops entered promiscuous mode
Sat Nov 25 12:14:47 2023 kern.info kernel: [  156.907327] switch1: port 13(wap-knet1-ops) entered blocking state
Sat Nov 25 12:14:47 2023 kern.info kernel: [  156.912627] switch1: port 13(wap-knet1-ops) entered forwarding state
Sat Nov 25 12:14:47 2023 kern.info kernel: [  156.920813] device wap-knet1-prv left promiscuous mode
Sat Nov 25 12:14:47 2023 kern.info kernel: [  156.925279] switch1: port 12(wap-knet1-prv) entered disabled state
Sat Nov 25 12:14:47 2023 kern.info kernel: [  156.998044] switch1: port 12(wap-knet1-prv) entered blocking state
Sat Nov 25 12:14:47 2023 kern.info kernel: [  156.998123] switch1: port 12(wap-knet1-prv) entered disabled state
Sat Nov 25 12:14:47 2023 kern.info kernel: [  157.003715] device wap-knet1-prv entered promiscuous mode
Sat Nov 25 12:14:47 2023 kern.info kernel: [  157.009498] switch1: port 12(wap-knet1-prv) entered blocking state
Sat Nov 25 12:14:47 2023 kern.info kernel: [  157.014805] switch1: port 12(wap-knet1-prv) entered forwarding state
Sat Nov 25 12:14:47 2023 kern.info kernel: [  157.149147] switch1: port 14(wap-fl1) entered blocking state
Sat Nov 25 12:14:47 2023 kern.info kernel: [  157.149194] switch1: port 14(wap-fl1) entered disabled state
Sat Nov 25 12:14:47 2023 kern.info kernel: [  157.154260] device wap-fl1 entered promiscuous mode
Sat Nov 25 12:14:47 2023 kern.info kernel: [  157.161223] switch1: port 14(wap-fl1) entered blocking state
Sat Nov 25 12:14:47 2023 kern.info kernel: [  157.164133] switch1: port 14(wap-fl1) entered forwarding state
Sat Nov 25 12:14:47 2023 daemon.info hostapd: wap-fl1: RADIUS Authentication server 192.168.203.5:1812
Sat Nov 25 12:14:47 2023 kern.info kernel: [  157.174143] device wap-knet1-ops left promiscuous mode
Sat Nov 25 12:14:47 2023 kern.info kernel: [  157.175788] switch1: port 13(wap-knet1-ops) entered disabled state
Sat Nov 25 12:14:47 2023 kern.info kernel: [  157.257892] switch1: port 13(wap-knet1-ops) entered blocking state
Sat Nov 25 12:14:47 2023 kern.info kernel: [  157.257943] switch1: port 13(wap-knet1-ops) entered disabled state
Sat Nov 25 12:14:47 2023 kern.info kernel: [  157.263280] device wap-knet1-ops entered promiscuous mode
Sat Nov 25 12:14:47 2023 kern.info kernel: [  157.269312] switch1: port 13(wap-knet1-ops) entered blocking state
Sat Nov 25 12:14:47 2023 kern.info kernel: [  157.274617] switch1: port 13(wap-knet1-ops) entered forwarding state
Sat Nov 25 12:14:47 2023 kern.info kernel: [  157.448560] device wap-fl1 left promiscuous mode
Sat Nov 25 12:14:47 2023 kern.info kernel: [  157.448679] switch1: port 14(wap-fl1) entered disabled state
Sat Nov 25 12:14:47 2023 kern.info kernel: [  157.518847] switch1: port 14(kinfra1) entered blocking state
Sat Nov 25 12:14:47 2023 kern.info kernel: [  157.518897] switch1: port 14(kinfra1) entered disabled state
Sat Nov 25 12:14:47 2023 kern.info kernel: [  157.523798] device kinfra1 entered promiscuous mode
Sat Nov 25 12:14:47 2023 kern.info kernel: [  157.529449] switch1: port 15(wap-fl1) entered blocking state
Sat Nov 25 12:14:47 2023 kern.info kernel: [  157.534099] switch1: port 15(wap-fl1) entered disabled state
Sat Nov 25 12:14:47 2023 kern.info kernel: [  157.540343] device wap-fl1 entered promiscuous mode
Sat Nov 25 12:14:47 2023 kern.info kernel: [  157.545486] switch1: port 15(wap-fl1) entered blocking state
Sat Nov 25 12:14:47 2023 kern.info kernel: [  157.550007] switch1: port 15(wap-fl1) entered forwarding state
Sat Nov 25 12:14:48 2023 kern.info kernel: [  157.557580] switch1: port 14(kinfra1) entered blocking state
Sat Nov 25 12:14:48 2023 kern.info kernel: [  157.561527] switch1: port 14(kinfra1) entered forwarding state
Sat Nov 25 12:14:48 2023 kern.info kernel: [  157.572770] device kinfra1 left promiscuous mode
Sat Nov 25 12:14:48 2023 kern.info kernel: [  157.573092] switch1: port 14(kinfra1) entered disabled state
Sat Nov 25 12:14:48 2023 kern.info kernel: [  157.628310] switch1: port 14(kinfra1) entered blocking state
Sat Nov 25 12:14:48 2023 kern.info kernel: [  157.628356] switch1: port 14(kinfra1) entered disabled state
Sat Nov 25 12:14:48 2023 kern.info kernel: [  157.633433] device kinfra1 entered promiscuous mode
Sat Nov 25 12:14:48 2023 kern.info kernel: [  157.638870] switch1: port 14(kinfra1) entered blocking state
Sat Nov 25 12:14:48 2023 kern.info kernel: [  157.643323] switch1: port 14(kinfra1) entered forwarding state
Sat Nov 25 12:14:48 2023 kern.info kernel: [  157.665980] IPv6: ADDRCONF(NETDEV_CHANGE): kinfra1: link becomes ready
Sat Nov 25 12:14:48 2023 kern.info kernel: [  157.666575] switch1: port 12(wap-knet1-prv) entered disabled state
Sat Nov 25 12:14:48 2023 kern.info kernel: [  157.671692] switch1: port 13(wap-knet1-ops) entered disabled state
Sat Nov 25 12:14:48 2023 kern.info kernel: [  157.677813] switch1: port 15(wap-fl1) entered disabled state
Sat Nov 25 12:14:48 2023 kern.info kernel: [  158.148477] switch1: port 16(wap-ops1) entered blocking state
Sat Nov 25 12:14:48 2023 kern.info kernel: [  158.148524] switch1: port 16(wap-ops1) entered disabled state
Sat Nov 25 12:14:48 2023 kern.info kernel: [  158.153435] device wap-ops1 entered promiscuous mode
Sat Nov 25 12:14:48 2023 kern.info kernel: [  158.160383] switch1: port 16(wap-ops1) entered blocking state
Sat Nov 25 12:14:48 2023 kern.info kernel: [  158.163979] switch1: port 16(wap-ops1) entered forwarding state
Sat Nov 25 12:14:48 2023 kern.info kernel: [  158.172247] device wap-ops1 left promiscuous mode
Sat Nov 25 12:14:48 2023 kern.info kernel: [  158.175443] switch1: port 16(wap-ops1) entered disabled state
Sat Nov 25 12:14:48 2023 kern.info kernel: [  158.227983] switch1: port 16(wap-ops1) entered blocking state
Sat Nov 25 12:14:48 2023 kern.info kernel: [  158.228024] switch1: port 16(wap-ops1) entered disabled state
Sat Nov 25 12:14:48 2023 kern.info kernel: [  158.233077] device wap-ops1 entered promiscuous mode
Sat Nov 25 12:14:48 2023 kern.info kernel: [  158.238642] switch1: port 16(wap-ops1) entered blocking state
Sat Nov 25 12:14:48 2023 kern.info kernel: [  158.243491] switch1: port 16(wap-ops1) entered forwarding state
Sat Nov 25 12:14:48 2023 daemon.notice hostapd: wap-onet1: interface state DFS->ENABLED
Sat Nov 25 12:14:48 2023 kern.info kernel: [  158.288842] switch1: port 10(wap-onet1) entered blocking state
Sat Nov 25 12:14:48 2023 kern.info kernel: [  158.288901] switch1: port 10(wap-onet1) entered forwarding state
Sat Nov 25 12:14:48 2023 kern.info kernel: [  158.295303] IPv6: ADDRCONF(NETDEV_CHANGE): wap-ops1: link becomes ready
Sat Nov 25 12:14:48 2023 daemon.notice hostapd: wap-onet1: AP-ENABLED
Sat Nov 25 12:14:48 2023 kern.info kernel: [  158.302151] IPv6: ADDRCONF(NETDEV_CHANGE): wap-knet1: link becomes ready
Sat Nov 25 12:14:48 2023 kern.info kernel: [  158.306544] switch1: port 11(wap-knet1) entered blocking state
Sat Nov 25 12:14:48 2023 kern.info kernel: [  158.313056] switch1: port 11(wap-knet1) entered forwarding state
Sat Nov 25 12:14:48 2023 kern.info kernel: [  158.319875] IPv6: ADDRCONF(NETDEV_CHANGE): wap-knet1-ops: link becomes ready
Sat Nov 25 12:14:48 2023 kern.info kernel: [  158.324984] switch1: port 13(wap-knet1-ops) entered blocking state
Sat Nov 25 12:14:48 2023 kern.info kernel: [  158.331944] switch1: port 13(wap-knet1-ops) entered forwarding state
Sat Nov 25 12:14:48 2023 kern.info kernel: [  158.338651] IPv6: ADDRCONF(NETDEV_CHANGE): wap-knet1-prv: link becomes ready
Sat Nov 25 12:14:48 2023 kern.info kernel: [  158.344487] switch1: port 12(wap-knet1-prv) entered blocking state
Sat Nov 25 12:14:48 2023 kern.info kernel: [  158.351446] switch1: port 12(wap-knet1-prv) entered forwarding state
Sat Nov 25 12:14:48 2023 kern.info kernel: [  158.360502] IPv6: ADDRCONF(NETDEV_CHANGE): wap-fl1: link becomes ready
Sat Nov 25 12:14:48 2023 kern.info kernel: [  158.364134] switch1: port 15(wap-fl1) entered blocking state
Sat Nov 25 12:14:48 2023 kern.info kernel: [  158.370296] switch1: port 15(wap-fl1) entered forwarding state
Sat Nov 25 12:14:48 2023 daemon.err hostapd: VLAN: vlan_event_receive: recvfrom failed: No buffer space available
Sat Nov 25 12:14:48 2023 daemon.err hostapd: VLAN: vlan_event_receive: recvfrom failed: No buffer space available
Sat Nov 25 12:14:48 2023 daemon.err hostapd: VLAN: vlan_event_receive: recvfrom failed: No buffer space available
Sat Nov 25 12:14:48 2023 daemon.err hostapd: VLAN: vlan_event_receive: recvfrom failed: No buffer space available
Sat Nov 25 12:14:48 2023 daemon.err hostapd: VLAN: vlan_event_receive: recvfrom failed: No buffer space available
Sat Nov 25 12:14:48 2023 daemon.err hostapd: VLAN: vlan_event_receive: recvfrom failed: No buffer space available
Sat Nov 25 12:14:48 2023 daemon.err hostapd: VLAN: vlan_event_receive: recvfrom failed: No buffer space available
Sat Nov 25 12:14:48 2023 daemon.err hostapd: VLAN: vlan_event_receive: recvfrom failed: No buffer space available
Sat Nov 25 12:14:51 2023 daemon.notice hostapd: handle_probe_req: send failed
Sat Nov 25 12:14:51 2023 daemon.notice hostapd: handle_probe_req: send failed
Sat Nov 25 12:14:51 2023 daemon.notice hostapd: handle_probe_req: send failed
Sat Nov 25 12:14:51 2023 daemon.notice hostapd: handle_probe_req: send failed
Sat Nov 25 12:14:55 2023 daemon.notice hostapd: handle_probe_req: send failed
Sat Nov 25 12:14:55 2023 daemon.notice hostapd: handle_probe_req: send failed
Sat Nov 25 12:14:59 2023 kern.info kernel: [  169.385986] switch1: port 6(wap-knet2) entered blocking state
Sat Nov 25 12:14:59 2023 kern.info kernel: [  169.386053] switch1: port 6(wap-knet2) entered forwarding state
Sat Nov 25 12:14:59 2023 kern.info kernel: [  169.414231] switch1: port 7(wap-fl2) entered blocking state
Sat Nov 25 12:14:59 2023 kern.info kernel: [  169.414289] switch1: port 7(wap-fl2) entered forwarding state

handle_probe_req: send failed is because the interface are started without beaconing (start_disabled=1).

My network setup:
###################

config interface 'loopback'
	option device 'lo'
	option proto 'static'
	option ipaddr '127.0.0.1'
	option netmask '255.0.0.0'

config device
	option type 'bridge'
	option name 'switch1'
	option multicast_to_unicast '0'

config bridge-vlan
	option device 'switch1'
	option vlan '1'
	list ports 'wan'

config bridge-vlan
	option device 'switch1'
	option vlan '22'
	list ports 'wan:t'

config bridge-vlan
	option device 'switch1'
	option vlan '26'
	list ports 'wan:t'

config bridge-vlan
	option device 'switch1'
	option vlan '27'
	list ports 'wan:t'
	list ports 'lan1'
	list ports 'lan2'
	list ports 'lan3'

config interface 'lan'
	option device 'switch1.1'
	option proto 'static'
	option ipaddr '192.168.203.240'
	option netmask '255.255.255.0'
	option gateway '192.168.203.254'
	option dns '192.168.203.5'
	option ip6assign '0'

config interface 'opennet'
	option device 'switch1.22'
	option proto 'none'
	option ip6assign '0'
	option ipv6 '0'

config interface 'clients'
	option device 'switch1.27'
	option proto 'none'
	option ip6assign '0'
	option ipv6 '0'

config interface 'privacy'
	option device 'switch1.26'
	option proto 'none'
	option ip6assign '0'
	option ipv6 '0'
###################

Wireless config
###################
config wifi-device 'radio0'
	option type 'mac80211'
	option disabled '1'
	option country 'DE'
	option txpower '27'
	option supported_rates '12000 18000 24000 36000 48000 54000'
	option channel '36'
	option path 'soc/20000000.pci/pci0000:00/0000:00:00.0/0000:01:00.0'
	option htmode 'VHT80'
	option basic_rate '12000 18000 24000 36000 48000 54000'

config wifi-device 'radio1'
	option band '5g'
	option path 'platform/soc/c000000.wifi'
	option disabled '0'
	option channels '52 100 116'
	option type 'mac80211'
	option hwmode '11a'
	option txpower '27'
	option supported_rates '12000 18000 24000 36000 48000 54000'
	option channel '100'
	option country 'DE'
	option log_level '0'
	option htmode 'HE80'
	option basic_rate '12000 18000 24000 36000 48000 54000'

config wifi-iface 'radio1_OpenNet'
	option ifname 'wap-onet1'
         ...

config wifi-iface 'radio1_kalnet'
	option ifname 'wap-knet1'
	option dynamic_vlan '1'
         ...

config wifi-vlan
	option vid '22'
	option network 'opennet'
	option name 'ops'
	option iface 'radio1_kalnet'

config wifi-vlan
	option vid '26'
	option network 'privacy'
	option name 'prv'
	option iface 'radio1_kalnet'

config wifi-station
	option vid '22'
	option mac '00:00:00:00:00:00'
	option key 'freewifi'
	option iface 'radio1_kalnet'

config wifi-station
	option vid '26'
	option mac '00:00:00:00:00:00'
	option key 'privatewifi'
	option iface 'radio1_kalnet'

config wifi-iface 'radio1_kalnet6'
	option ifname 'wap-fl1'
         ....

config wifi-iface 'radio1_kalinfra'
	option wds '1'
	option ifname 'kinfra1'
         ...

config wifi-iface 'radio1_OpenNet_Secure'
	option ifname 'wap-ops1'
         ...

config wifi-device 'radio2'
	option band '2g'
	option path 'platform/soc/c000000.wifi+1'
	option disabled '0'
	option country 'DE'
	option hwmode '11g'
	option txpower '27'
	option supported_rates '6000 12000 18000 24000 36000 48000 54000'
	option channel '1'
	option type 'mac80211'
	option log_level '0'
	option htmode 'HE20'
	option basic_rate '6000 12000 18000 24000 36000 48000 54000'

config wifi-iface 'radio2_OpenNet'
	option ifname 'wap-onet2'
         ...

config wifi-iface 'radio2_kalnet'
	option ifname 'wap-knet2'
	option dynamic_vlan '1'
         ...

config wifi-vlan
	option vid '22'
	option network 'opennet'
	option name 'ops'
	option iface 'radio2_kalnet'

config wifi-vlan
	option vid '26'
	option network 'privacy'
	option name 'prv'
	option iface 'radio2_kalnet'

config wifi-station
	option vid '22'
	option mac '00:00:00:00:00:00'
	option key 'freewifi'
	option iface 'radio2_kalnet'

config wifi-station
	option vid '26'
	option mac '00:00:00:00:00:00'
	option key 'privatewifi'
	option iface 'radio2_kalnet'

config wifi-iface 'radio2_kalnet6'
	option ifname 'wap-fl2'
         ...

config wifi-iface 'radio2_kalinfra'
	option wds '1'
	option ifname 'kinfra2'
         ...

config wifi-iface 'radio2_OpenNet_Secure'
	option ifname 'wap-ops2'
         ...
###################

Does anybody have similiar problems with AP-VLAN usage?


More information about the openwrt-devel mailing list