802.11s meshpoint seems not to work on Turris Omnia with 22.03.0-rc6

ricsi · August 21, 2022, 8:18pm

I have a new install of OpenWrt 22.03.0-rc6 on Turris Omnia.
I remove wpad-basic-wolfssl and installed wpad-wolfssl and mesh11sd.
I created a mesh point on the 5G Wifi, called it mesh and have a WPA3 password set.

I do see this error:

root@OpenWrt:~# mesh11sd status
{
  "setup":{
    "version":"1.2.0",
    "enabled":"1",
    "service":"running",
    "checkinterval":"10",
    "interface_timeout":"10",
    "debuglevel":"1"
  }
  "interfaces":{
mesh11sd[4073
7067]: mesh0 is not up - giving up for now.
  }
}

The exact same config works perfectly fine on a pair of MTK routers.
Any ideas?

p.p · August 21, 2022, 9:18pm

Anything in the logs?

bluewavenet · August 21, 2022, 10:19pm

Please show the output of uci show wireless.

ricsi · August 22, 2022, 6:40am

wireless.radio0=wifi-device
wireless.radio0.type='mac80211'
wireless.radio0.path='soc/soc:pcie/pci0000:00/0000:00:02.0/0000:02:00.0'
wireless.radio0.channel='36'
wireless.radio0.band='5g'
wireless.radio0.htmode='VHT80'
wireless.radio0.country='AT'
wireless.radio0.cell_density='0'
wireless.default_radio0=wifi-iface
wireless.default_radio0.device='radio0'
wireless.default_radio0.network='lan'
wireless.default_radio0.mode='mesh'
wireless.default_radio0.mesh_id='mesh'
wireless.default_radio0.mesh_fwding='1'
wireless.default_radio0.mesh_rssi_threshold='0'
wireless.default_radio0.encryption='sae'
wireless.default_radio0.key='xxx'
wireless.default_radio0.ifname='mesh0'
wireless.radio1=wifi-device
wireless.radio1.type='mac80211'
wireless.radio1.path='soc/soc:pcie/pci0000:00/0000:00:01.0/0000:01:00.0'
wireless.radio1.channel='1'
wireless.radio1.band='2g'
wireless.radio1.htmode='HT20'
wireless.radio1.disabled='1'
wireless.default_radio1=wifi-iface
wireless.default_radio1.device='radio1'
wireless.default_radio1.network='lan'
wireless.default_radio1.mode='ap'
wireless.default_radio1.ssid='OpenWrt'
wireless.default_radio1.encryption='none'
wireless.wifinet2=wifi-iface
wireless.wifinet2.device='radio0'
wireless.wifinet2.mode='ap'
wireless.wifinet2.ssid='OpenWrt'
wireless.wifinet2.encryption='sae-mixed'
wireless.wifinet2.key='xxx'
wireless.wifinet2.network='lan'

ricsi · August 22, 2022, 6:42am

a lot og this

Mon Aug 22 06:38:18 2022 daemon.notice mesh11sd[4073]: mesh0 is not up - giving up for now.
Mon Aug 22 06:38:38 2022 daemon.notice mesh11sd[4073]: mesh0 is not up - giving up for now.
Mon Aug 22 06:38:58 2022 daemon.notice mesh11sd[4073]: mesh0 is not up - giving up for now.
Mon Aug 22 06:39:18 2022 daemon.notice mesh11sd[4073]: mesh0 is not up - giving up for now.
Mon Aug 22 06:39:38 2022 daemon.notice mesh11sd[4073]: mesh0 is not up - giving up for now.
Mon Aug 22 06:39:58 2022 daemon.notice mesh11sd[4073]: mesh0 is not up - giving up for now.
Mon Aug 22 06:40:18 2022 daemon.notice mesh11sd[4073]: mesh0 is not up - giving up for now.
Mon Aug 22 06:40:38 2022 daemon.notice mesh11sd[4073]: mesh0 is not up - giving up for now.
Mon Aug 22 06:40:58 2022 daemon.notice mesh11sd[4073]: mesh0 is not up - giving up for now.
Mon Aug 22 06:41:19 2022 daemon.notice mesh11sd[4073]: mesh0 is not up - giving up for now.

p.p · August 22, 2022, 6:53am

I meant log entries not related to mesh11sd, so the last few entries immediately before the first few lines of that.

ricsi · August 22, 2022, 8:42am

Here are the WiFi related entries after bootup:

Mon Aug 22 08:03:44 2022 kern.info kernel: [    9.263720] ath10k 5.15 driver, optimized for CT firmware, probing pci device: 0x3c.
Mon Aug 22 08:03:44 2022 kern.info kernel: [    9.271861] pci 0000:00:02.0: enabling device (0140 -> 0142)
Mon Aug 22 08:03:44 2022 kern.info kernel: [    9.277576] ath10k_pci 0000:02:00.0: enabling device (0140 -> 0142)
Mon Aug 22 08:03:44 2022 kern.info kernel: [    9.284070] ath10k_pci 0000:02:00.0: pci irq msi oper_irq_mode 2 irq_mode 0 reset_mode 0
Mon Aug 22 08:03:44 2022 kern.info kernel: [    9.582264] ath10k_pci 0000:02:00.0: qca988x hw2.0 target 0x4100016c chip_id 0x043202ff sub 0000:0000
Mon Aug 22 08:03:44 2022 kern.info kernel: [    9.591537] ath10k_pci 0000:02:00.0: kconfig debug 0 debugfs 1 tracing 0 dfs 1 testmode 0
Mon Aug 22 08:03:44 2022 kern.info kernel: [    9.600919] ath10k_pci 0000:02:00.0: firmware ver 10.1-ct-8x-__fW-022-ecad3248 api 2 features wmi-10.x,has-wmi-mgmt-tx,mfp,txstatus-noack,wmi-10.x-CT,ratemask-CT,txrate-CT,get-temp-CT,tx-rc-CT,cust-stats-CT,retry-gt2-CT,txrate2-CT,beacon-cb-CT,wmi-block-ack-CT crc32 3e4cf97f
Mon Aug 22 08:03:44 2022 kern.info kernel: [    9.650224] ath10k_pci 0000:02:00.0: Loading BDF type 0
Mon Aug 22 08:03:44 2022 kern.info kernel: [    9.666501] ath10k_pci 0000:02:00.0: board_file api 1 bmi_id N/A crc32 bebc7c08
Mon Aug 22 08:03:44 2022 kern.warn kernel: [   10.524911] ath10k_pci 0000:02:00.0: 10.1 wmi init: vdevs: 16  peers: 127  tid: 256
Mon Aug 22 08:03:44 2022 kern.info kernel: [   10.541464] ath10k_pci 0000:02:00.0: wmi print 'P 128 V 8 T 410'
Mon Aug 22 08:03:44 2022 kern.info kernel: [   10.547513] ath10k_pci 0000:02:00.0: wmi print 'msdu-desc: 1424  sw-crypt: 0 ct-sta: 0'
Mon Aug 22 08:03:44 2022 kern.info kernel: [   10.555541] ath10k_pci 0000:02:00.0: wmi print 'alloc rem: 24984 iram: 38672'
Mon Aug 22 08:03:44 2022 kern.info kernel: [   10.618052] ath10k_pci 0000:02:00.0: htt-ver 2.1 wmi-op 2 htt-op 2 cal otp max-sta 128 raw 0 hwcrypto 1
Mon Aug 22 08:03:44 2022 kern.info kernel: [   10.627747] ath10k_pci 0000:02:00.0: NOTE:  Firmware DBGLOG output disabled in debug_mask: 0x10000000
Mon Aug 22 08:03:44 2022 kern.debug kernel: [   10.746384] ath: EEPROM regdomain: 0x0
Mon Aug 22 08:03:44 2022 kern.debug kernel: [   10.746388] ath: EEPROM indicates default country code should be used
Mon Aug 22 08:03:44 2022 kern.debug kernel: [   10.746390] ath: doing EEPROM country->regdmn map search
Mon Aug 22 08:03:44 2022 kern.debug kernel: [   10.746395] ath: country maps to regdmn code: 0x3a
Mon Aug 22 08:03:44 2022 kern.debug kernel: [   10.746398] ath: Country alpha2 being used: US
Mon Aug 22 08:03:44 2022 kern.debug kernel: [   10.746400] ath: Regpair used: 0x3a
Mon Aug 22 08:03:44 2022 kern.info kernel: [   10.757101] pci 0000:00:01.0: enabling device (0140 -> 0142)
Mon Aug 22 08:03:44 2022 kern.info kernel: [   10.762813] ath9k 0000:01:00.0: enabling device (0140 -> 0142)
Mon Aug 22 08:03:44 2022 kern.debug kernel: [   10.855543] ath: EEPROM regdomain: 0x0
Mon Aug 22 08:03:44 2022 kern.debug kernel: [   10.855546] ath: EEPROM indicates default country code should be used
Mon Aug 22 08:03:44 2022 kern.debug kernel: [   10.855548] ath: doing EEPROM country->regdmn map search
Mon Aug 22 08:03:44 2022 kern.debug kernel: [   10.855552] ath: country maps to regdmn code: 0x3a
Mon Aug 22 08:03:44 2022 kern.debug kernel: [   10.855555] ath: Country alpha2 being used: US
Mon Aug 22 08:03:44 2022 kern.debug kernel: [   10.855557] ath: Regpair used: 0x3a
Mon Aug 22 08:03:44 2022 kern.debug kernel: [   10.867277] ieee80211 phy1: Selected rate control algorithm 'minstrel_ht'
Mon Aug 22 08:03:44 2022 kern.info kernel: [   10.868264] ieee80211 phy1: Atheros AR9287 Rev:2 mem=0xf0f90000, irq=89
Mon Aug 22 08:03:45 2022 daemon.notice wpa_supplicant[1882]: Successfully initialized wpa_supplicant
Mon Aug 22 08:03:46 2022 daemon.notice mesh11sd[2363]: mesh11sd is in startup
Mon Aug 22 08:03:47 2022 kern.debug kernel: [   14.318133] ath: EEPROM regdomain: 0x8028
Mon Aug 22 08:03:47 2022 kern.debug kernel: [   14.318140] ath: EEPROM indicates we should expect a country code
Mon Aug 22 08:03:47 2022 kern.debug kernel: [   14.318142] ath: doing EEPROM country->regdmn map search
Mon Aug 22 08:03:47 2022 kern.debug kernel: [   14.318145] ath: country maps to regdmn code: 0x37
Mon Aug 22 08:03:47 2022 kern.debug kernel: [   14.318148] ath: Country alpha2 being used: AT
Mon Aug 22 08:03:47 2022 kern.debug kernel: [   14.318150] ath: Regpair used: 0x37
Mon Aug 22 08:03:47 2022 kern.debug kernel: [   14.318153] ath: regdomain 0x8028 dynamically updated by user
Mon Aug 22 08:03:47 2022 kern.debug kernel: [   14.318209] ath: EEPROM regdomain: 0x8028
Mon Aug 22 08:03:47 2022 kern.debug kernel: [   14.318211] ath: EEPROM indicates we should expect a country code
Mon Aug 22 08:03:47 2022 kern.debug kernel: [   14.318213] ath: doing EEPROM country->regdmn map search
Mon Aug 22 08:03:47 2022 kern.debug kernel: [   14.318215] ath: country maps to regdmn code: 0x37
Mon Aug 22 08:03:47 2022 kern.debug kernel: [   14.318217] ath: Country alpha2 being used: AT
Mon Aug 22 08:03:47 2022 kern.debug kernel: [   14.318219] ath: Regpair used: 0x37
Mon Aug 22 08:03:47 2022 kern.debug kernel: [   14.318221] ath: regdomain 0x8028 dynamically updated by user
Mon Aug 22 08:03:48 2022 daemon.err odhcpd[1991]: Failed to send to ff02::1%lan@br-lan (Address not available)
Mon Aug 22 08:03:48 2022 daemon.notice hostapd: Configuration file: /var/run/hostapd-phy0.conf (phy wlan0-1) --> new PHY
Mon Aug 22 08:03:49 2022 kern.warn kernel: [   16.527611] ath10k_pci 0000:02:00.0: 10.1 wmi init: vdevs: 16  peers: 127  tid: 256
Mon Aug 22 08:03:49 2022 kern.info kernel: [   16.544154] ath10k_pci 0000:02:00.0: wmi print 'P 128 V 8 T 410'
Mon Aug 22 08:03:49 2022 kern.info kernel: [   16.550270] ath10k_pci 0000:02:00.0: wmi print 'msdu-desc: 1424  sw-crypt: 0 ct-sta: 0'
Mon Aug 22 08:03:49 2022 kern.info kernel: [   16.558340] ath10k_pci 0000:02:00.0: wmi print 'alloc rem: 24984 iram: 38672'
Mon Aug 22 08:03:49 2022 kern.warn kernel: [   16.620888] ath10k_pci 0000:02:00.0: pdev param 0 not supported by firmware
Mon Aug 22 08:03:49 2022 kern.info kernel: [   16.634770] ath10k_pci 0000:02:00.0: rts threshold -1
Mon Aug 22 08:03:49 2022 kern.info kernel: [   16.652781] device wlan0-1 entered promiscuous mode
Mon Aug 22 08:03:49 2022 daemon.notice hostapd: wlan0-1: interface state UNINITIALIZED->COUNTRY_UPDATE
Mon Aug 22 08:03:49 2022 kern.info kernel: [   16.700873] IPv6: ADDRCONF(NETDEV_CHANGE): wlan0-1: link becomes ready
Mon Aug 22 08:03:49 2022 daemon.notice hostapd: wlan0-1: interface state COUNTRY_UPDATE->ENABLED
Mon Aug 22 08:03:49 2022 daemon.notice hostapd: wlan0-1: AP-ENABLED
Mon Aug 22 08:03:51 2022 daemon.notice netifd: radio0 (2539): ip: SIOCSIFFLAGS: Resource busy
Mon Aug 22 08:03:51 2022 daemon.notice netifd: radio0 (2539): Interface 0 setup failed: IFUP_ERROR
Mon Aug 22 08:03:51 2022 daemon.notice netifd: Wireless device 'radio0' is now up
Mon Aug 22 08:03:51 2022 daemon.notice netifd: Network device 'wlan0-1' link is up
Mon Aug 22 08:03:56 2022 daemon.notice mesh11sd[2363]: mesh11sd v1.2.0 has started: mesh management mode 1
Mon Aug 22 08:03:56 2022 daemon.notice mesh11sd[2363]: Setting mesh interface name to [ mesh0 ]
Mon Aug 22 08:03:56 2022 daemon.notice hostapd: Remove interface 'wlan0-1'
Mon Aug 22 08:03:56 2022 daemon.notice hostapd: wlan0-1: interface state ENABLED->DISABLED
Mon Aug 22 08:03:56 2022 daemon.notice hostapd: wlan0-1: AP-DISABLED
Mon Aug 22 08:03:56 2022 daemon.notice hostapd: wlan0-1: CTRL-EVENT-TERMINATING
Mon Aug 22 08:03:56 2022 daemon.err hostapd: rmdir[ctrl_interface=/var/run/hostapd]: Permission denied
Mon Aug 22 08:03:56 2022 daemon.notice hostapd: nl80211: deinit ifname=wlan0-1 disabled_11b_rates=0
Mon Aug 22 08:03:56 2022 kern.info kernel: [   23.568662] device wlan0-1 left promiscuous mode
Mon Aug 22 08:03:56 2022 kern.info kernel: [   23.573413] br-lan: port 6(wlan0-1) entered disabled state
Mon Aug 22 08:03:56 2022 daemon.notice netifd: Network device 'wlan0-1' link is down
Mon Aug 22 08:03:56 2022 kern.info kernel: [   23.616152] ath10k_pci 0000:02:00.0: mac flush null vif, drop 0 queues 0xffff
Mon Aug 22 08:03:56 2022 daemon.notice netifd: Wireless device 'radio0' is now down
Mon Aug 22 08:03:57 2022 daemon.notice hostapd: Configuration file: /var/run/hostapd-phy0.conf (phy wlan0-1) --> new PHY
Mon Aug 22 08:03:58 2022 kern.warn kernel: [   25.174174] ath10k_pci 0000:02:00.0: 10.1 wmi init: vdevs: 16  peers: 127  tid: 256
Mon Aug 22 08:03:58 2022 kern.info kernel: [   25.190731] ath10k_pci 0000:02:00.0: wmi print 'P 128 V 8 T 410'
Mon Aug 22 08:03:58 2022 kern.info kernel: [   25.196864] ath10k_pci 0000:02:00.0: wmi print 'msdu-desc: 1424  sw-crypt: 0 ct-sta: 0'
Mon Aug 22 08:03:58 2022 kern.info kernel: [   25.204901] ath10k_pci 0000:02:00.0: wmi print 'alloc rem: 24984 iram: 38672'
Mon Aug 22 08:03:58 2022 kern.warn kernel: [   25.268056] ath10k_pci 0000:02:00.0: pdev param 0 not supported by firmware
Mon Aug 22 08:03:58 2022 kern.info kernel: [   25.282002] ath10k_pci 0000:02:00.0: rts threshold -1
Mon Aug 22 08:03:58 2022 kern.info kernel: [   25.288799] br-lan: port 6(wlan0-1) entered blocking state
Mon Aug 22 08:03:58 2022 kern.info kernel: [   25.294348] br-lan: port 6(wlan0-1) entered disabled state
Mon Aug 22 08:03:58 2022 kern.info kernel: [   25.300008] device wlan0-1 entered promiscuous mode
Mon Aug 22 08:03:58 2022 daemon.notice hostapd: wlan0-1: interface state UNINITIALIZED->COUNTRY_UPDATE
Mon Aug 22 08:03:58 2022 kern.info kernel: [   25.348220] IPv6: ADDRCONF(NETDEV_CHANGE): wlan0-1: link becomes ready
Mon Aug 22 08:03:58 2022 kern.info kernel: [   25.354878] br-lan: port 6(wlan0-1) entered blocking state
Mon Aug 22 08:03:58 2022 kern.info kernel: [   25.360380] br-lan: port 6(wlan0-1) entered forwarding state
Mon Aug 22 08:03:58 2022 daemon.notice hostapd: wlan0-1: interface state COUNTRY_UPDATE->ENABLED
Mon Aug 22 08:03:58 2022 daemon.notice hostapd: wlan0-1: AP-ENABLED
Mon Aug 22 08:03:59 2022 daemon.notice netifd: radio0 (3247): ip: SIOCSIFFLAGS: Resource busy
Mon Aug 22 08:03:59 2022 daemon.notice netifd: radio0 (3247): Interface 0 setup failed: IFUP_ERROR
Mon Aug 22 08:03:59 2022 daemon.notice netifd: Wireless device 'radio0' is now up
Mon Aug 22 08:03:59 2022 daemon.notice netifd: Network device 'wlan0-1' link is up
Mon Aug 22 08:04:07 2022 daemon.notice mesh11sd[2363]: wlan0 is not up - giving up for now.
Mon Aug 22 08:04:26 2022 daemon.info hostapd: wlan0-1: STA 38:de:ad:67:9f:58 IEEE 802.11: authenticated
Mon Aug 22 08:04:26 2022 daemon.info hostapd: wlan0-1: STA 38:de:ad:67:9f:58 IEEE 802.11: associated (aid 1)
Mon Aug 22 08:04:26 2022 daemon.notice hostapd: wlan0-1: STA-OPMODE-SMPS-MODE-CHANGED 38:de:ad:67:9f:58 off
Mon Aug 22 08:04:26 2022 daemon.notice hostapd: wlan0-1: AP-STA-CONNECTED 38:de:ad:67:9f:58
Mon Aug 22 08:04:26 2022 daemon.info hostapd: wlan0-1: STA 38:de:ad:67:9f:58 RADIUS: starting accounting session 0DF4341304A6CDED
Mon Aug 22 08:04:26 2022 daemon.info hostapd: wlan0-1: STA 38:de:ad:67:9f:58 WPA: pairwise key handshake completed (RSN)
Mon Aug 22 08:04:26 2022 daemon.notice hostapd: wlan0-1: EAPOL-4WAY-HS-COMPLETED 38:de:ad:67:9f:58
Mon Aug 22 08:04:27 2022 daemon.notice mesh11sd[2363]: mesh0 is not up - giving up for now.

bluewavenet · August 22, 2022, 12:58pm

You must uninstall the CT drivers and install the non-CT instead.
Do: opkg list-installed | grep "ath10k" to see a list.

Also see: https://openwrt.org/docs/guide-user/network/wifi/mesh/80211s#wireless_hardware_support

You should also remove mesh_forwarding and rssi_threshold entries from the /etc/config/wireless/ file as these are moved to the mesh11sd config.

See what happens once you have done all these things and rebooted.

ricsi · August 22, 2022, 2:56pm

100 points!!!
Thanx, that was exactly the issue.
With the non ct driver it works perfectly!!

opkg remove kmod-ath10k-ct
opkg remove ath10k-firmware-qca988x-ct
opkg install ath10k-firmware-qca988x
opkg install kmod-ath10k

system · September 1, 2022, 2:57pm

This topic was automatically closed 10 days after the last reply. New replies are no longer allowed.