Sophos AP55 support

Thanks! That looks good. Was doing it manually at the moment (without -p1 it will ask for the file path) but I stopped that now.

I can't commit of course but at least I'm running "make -j12 V=s" now. We'll see how that goes.

You can commit to your local branches -- which is why I suggested that you make your own and commit to it. That way you can later "rebase" your changes on top of an updated master from OpenWrt. You can even have a "last good" and "devel" branch, or the like.

I see. I did follow your advice

cd ~/dev/openwrt
git checkout -b sophos-ap55-devel
patch < ~/temp/sof-t-os-ap55-support.patch
git add -u
git commit -m 'With wulfy23 sof-t-os-ap55-support.patch applied'

all commands up to "git commit" completed successfully. Unfortunately I can't get back to the console output as I startet the build in the same shell.

If it works, I might just redo all steps to get the output you need.

EDIT:
First build finished with errors, will try again with "-j1" as advised by make. "git commit" didn't work because I forgot to provide an identity.

EDIT2:
Building with "-j1" is awefully slow and still hasn't finished. Realized the build process involves a lot of downloading and the machine was offline during the first run.

Thanks to everyone. Expect some (days?) delay on further updates.

About an hour for that first build on a two-core VM running on a MacBook Pro.

It helps if you let it fail a couple of times at high build concurrency, before falling back to -j1 V=s. Each time the 'unrelated' parts of the build will get a bit further, leaving less for the final -serialized- single-threaded build to do.

2 Likes

As it turned out, everything was ok-ish before and building only failed because there was no internet connection after like 10 minutes into the build. So the second try produced the initramfs and squashfs just fine.

I finally found some time to boot the initramfs and it turns out somewhat different than yesterday's openwrt-ath79-generic-devolo_dvl1750e-initramfs-kernel.bin.

Here's all the "not ok" log output:

[    1.493680] ath79-wdt 18060008.wdt: unable to register misc device, err=-16
[    1.500762] ath79-wdt: probe of 18060008.wdt failed with error -16
[    6.854219] ath10k_pci 0000:00:00.0: enabling device (0000 -> 0002)
[    6.860748] ath10k_pci 0000:00:00.0: pci irq legacy oper_irq_mode 1 irq_mode 0 reset_mode 0
[    7.226993] firmware ath10k!fwcfg-pci-0000:00:00.0.txt: firmware_loading_store: map pages failed
[    7.417460] firmware ath10k!pre-cal-pci-0000:00:00.0.bin: firmware_loading_store: map pages failed
[    7.767384] firmware ath10k!QCA988X!hw2.0!ct-firmware-5.bin: firmware_loading_store: map pages failed
[    7.958413] firmware ath10k!QCA988X!hw2.0!ct-firmware-2.bin: firmware_loading_store: map pages failed
[    8.149690] firmware ath10k!QCA988X!hw2.0!firmware-6.bin: firmware_loading_store: map pages failed
[    8.340112] firmware ath10k!QCA988X!hw2.0!firmware-5.bin: firmware_loading_store: map pages failed
[    8.533432] firmware ath10k!QCA988X!hw2.0!firmware-4.bin: firmware_loading_store: map pages failed
[    8.725708] firmware ath10k!QCA988X!hw2.0!firmware-3.bin: firmware_loading_store: map pages failed
[    8.736795] ath10k_pci 0000:00:00.0: qca988x hw2.0 target 0x4100016c chip_id 0x043202ff sub 0000:0000
[    8.746191] ath10k_pci 0000:00:00.0: kconfig debug 0 debugfs 1 tracing 0 dfs 1 testmode 0
[    8.758599] ath10k_pci 0000:00:00.0: firmware ver 10.1-ct-8x-__fW-022-8f2afb9e 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 f90f1a48
[    8.988345] firmware ath10k!QCA988X!hw2.0!board-2.bin: firmware_loading_store: map pages failed

ifconfig has only br-lan and eth0 (same MAC) plus "lo" of course, but no eth1 like with the devolo image.

On the upside, USB seems to be working:

[    1.628138] usbcore: registered new interface driver usbfs
[    1.633829] usbcore: registered new interface driver hub
[    1.639294] usbcore: registered new device driver usb
[    1.649862] ehci_hcd: USB 2.0 'Enhanced' Host Controller (EHCI) Driver
[    1.657942] ehci-platform: EHCI generic platform driver
[    1.663510] ehci-platform 1b000000.usb: EHCI Host Controller
[    1.669304] ehci-platform 1b000000.usb: new USB bus registered, assigned bus number 1
[    1.677352] ehci-platform 1b000000.usb: irq 14, io mem 0x1b000000
[    1.712819] ehci-platform 1b000000.usb: USB 2.0 started, EHCI 1.00
[    1.719850] hub 1-0:1.0: USB hub found
[    1.724041] hub 1-0:1.0: 1 port detected

connecting some USB drive will generate a detection message on the console but i couldn't find it in /dev and the commands I know (lsblk, etc.) don't work in OpenWrt.

EDIT:
Upon reading Expression of thanks to Dev Team/18.06.2 --> 18.06.4 update was smooth (R7800) I realized there might be modules missing for USB storage to work? No worries then.

1 Like

A concurrent build is more likely to succeed if you precede it with make download.

1 Like

Thank you all for the tips about the build, I'm sure it will be faster next time, returning to -j12.

Now that I finally got around to looking at the logs and configs again, from my understanding the wifi drivers/firmware should be the same as "openwrt-ath79-generic-devolo_dvl1750e-initramfs-kernel.bin" as the dvl1750e config was the base for this. Yet they fail to load in my build.

Looking at "make menuconfig" again, I can't really tell what else to chose in the firmware menu, other than the already selected "ath10k-firmware-qca988x-ct".

The "target/linux/ath79/dts/qca9558_sophos_ap55.dts" file doesn't seem to contain anything related either. There's just the hardware buttons and speaker that will eventually be removed.

So what's next?

Based on boot log you posted, check that the firmware files are being created by the hotplug scripts.

It probably should look something like

jeff@office:~$ find /lib/firmware/ath10k/
/lib/firmware/ath10k/
/lib/firmware/ath10k/QCA988X
/lib/firmware/ath10k/QCA988X/hw2.0
/lib/firmware/ath10k/QCA988X/hw2.0/board.bin
/lib/firmware/ath10k/QCA988X/hw2.0/firmware-5.bin
/lib/firmware/ath10k/cal-pci-0000:00:00.0.bin

besides it being "firmware-2.bin" for me, it looks exactly the same when I boot the initramfs. Just checked.

Sounds like you'll need to modify the hotplug script for your board. Likely installed as

/etc/hotplug.d/firmware/11-ath10k-caldata

and from within base-files/ in the target's source directory.

1 Like

I see: the patch introduced a "#" at line 100, col. 18 which should be the difference between this one and the Devolo source. Let me build again...

EDIT: no, that wasn't it. Reviewing the file again...

I see

--- a/target/linux/ath79/base-files/etc/hotplug.d/firmware/11-ath10k-caldata
+++ b/target/linux/ath79/base-files/etc/hotplug.d/firmware/11-ath10k-caldata
@@ -95,6 +95,10 @@ case "$FIRMWARE" in
 		ath10kcal_extract "art" 20480 2116
 		ath10kcal_patch_mac_crc $(macaddr_add $(mtd_get_mac_binary art 0) -1)
 		;;
+	sophos,ap55)
+		ath10kcal_extract "art" 20480 2116
+		#ath10kcal_patch_mac_crc $(macaddr_add $(mtd_get_mac_binary art 0) -1)
+		;;

which looks like it should extract the cal data. Do you see it there once the system boots completely?

The commented-out line only modifies the extract once it is pulled from the ART partition and on the local file system.

If not, you may need to "debug" why it isn't being extracted.

It looks like the physical interface actually is there:

[   10.367902] ieee80211 phy1: Atheros AR9550 Rev:0 mem=0xb8100000, irq=13

Here's the full boot log + ifconfig with only mac addresses and related lines removed:

## Booting image at 81000000 ...
   Image Name:   MIPS OpenWrt Linux-4.19.56
   Created:      2019-07-02  21:07:12 UTC
   Image Type:   MIPS Linux Kernel Image (lzma compressed)
   Data Size:    4047675 Bytes =  3.9 MB
   Load Address: 80060000
   Entry Point:  80060000
   Verifying Checksum at 0x81000040 ...OK
   Uncompressing Kernel Image ... OK

Starting kernel ...

[    0.000000] Linux version 4.19.56 (user@ubuntu-openwrt) (gcc version 7.4.0 (OpenWrt GCC 7.4.0 r10374+1-fdd0a8d491)) #0 Tue Jul 2 21:07:12 2019
[    0.000000] bootconsole [early0] enabled
[    0.000000] CPU0 revision is: 00019750 (MIPS 74Kc)
[    0.000000] MIPS: machine is Sophos AP55
[    0.000000] SoC: Qualcomm Atheros QCA9558 ver 1 rev 0
[    0.000000] Determined physical RAM map:
[    0.000000]  memory: 08000000 @ 00000000 (usable)
[    0.000000] Initrd not found or empty - disabling initrd
[    0.000000] Primary instruction cache 64kB, VIPT, 4-way, linesize 32 bytes.
[    0.000000] Primary data cache 32kB, 4-way, VIPT, cache aliases, linesize 32 bytes
[    0.000000] Zone ranges:
[    0.000000]   Normal   [mem 0x0000000000000000-0x0000000007ffffff]
[    0.000000] Movable zone start for each node
[    0.000000] Early memory node ranges
[    0.000000]   node   0: [mem 0x0000000000000000-0x0000000007ffffff]
[    0.000000] Initmem setup node 0 [mem 0x0000000000000000-0x0000000007ffffff]
[    0.000000] random: get_random_bytes called from start_kernel+0x98/0x4a8 with crng_init=0
[    0.000000] Built 1 zonelists, mobility grouping on.  Total pages: 32480
[    0.000000] Kernel command line: console=ttyS0,115200n8 rootfstype=squashfs,jffs2
[    0.000000] Dentry cache hash table entries: 16384 (order: 4, 65536 bytes)
[    0.000000] Inode-cache hash table entries: 8192 (order: 3, 32768 bytes)
[    0.000000] Writing ErrCtl register=00000000
[    0.000000] Readback ErrCtl register=00000000
[    0.000000] Memory: 115960K/131072K available (4264K kernel code, 172K rwdata, 1004K rodata, 7736K init, 207K bss, 15112K reserved, 0K cma-reserved)
[    0.000000] SLUB: HWalign=32, Order=0-3, MinObjects=0, CPUs=1, Nodes=1
[    0.000000] NR_IRQS: 51
[    0.000000] CPU clock: 720.000 MHz
[    0.000000] clocksource: MIPS: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 5309056796 ns
[    0.000007] sched_clock: 32 bits at 360MHz, resolution 2ns, wraps every 5965232126ns
[    0.008294] Calibrating delay loop... 358.80 BogoMIPS (lpj=1794048)
[    0.074984] pid_max: default: 32768 minimum: 301
[    0.080101] Mount-cache hash table entries: 1024 (order: 0, 4096 bytes)
[    0.087136] Mountpoint-cache hash table entries: 1024 (order: 0, 4096 bytes)
[    0.098784] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 19112604462750000 ns
[    0.109286] futex hash table entries: 256 (order: -1, 3072 bytes)
[    0.115885] pinctrl core: initialized pinctrl subsystem
[    0.122249] NET: Registered protocol family 16
[    0.133343] PCI host bridge /ahb/apb/pcie-controller@180c0000 ranges:
[    0.140208]  MEM 0x0000000010000000..0x0000000011ffffff
[    0.145797]   IO 0x0000000000000000..0x0000000000000000
[    0.169742] PCI host bridge to bus 0000:00
[    0.174106] pci_bus 0000:00: root bus resource [mem 0x10000000-0x11ffffff]
[    0.181464] pci_bus 0000:00: root bus resource [io  0x0000]
[    0.187390] pci_bus 0000:00: root bus resource [??? 0x00000000 flags 0x0]
[    0.194617] pci_bus 0000:00: No busn resource found for root bus, will use [bus 00-ff]
[    0.204318] pci 0000:00:00.0: BAR 0: assigned [mem 0x10000000-0x101fffff 64bit]
[    0.212146] pci 0000:00:00.0: BAR 6: assigned [mem 0x10200000-0x1020ffff pref]
[    0.222795] clocksource: Switched to clocksource MIPS
[    0.229140] NET: Registered protocol family 2
[    0.234520] tcp_listen_portaddr_hash hash table entries: 512 (order: 0, 4096 bytes)
[    0.242704] TCP established hash table entries: 1024 (order: 0, 4096 bytes)
[    0.250157] TCP bind hash table entries: 1024 (order: 0, 4096 bytes)
[    0.256938] TCP: Hash tables configured (established 1024 bind 1024)
[    0.263813] UDP hash table entries: 256 (order: 0, 4096 bytes)
[    0.270039] UDP-Lite hash table entries: 256 (order: 0, 4096 bytes)
[    0.277057] NET: Registered protocol family 1
[    0.403223] Crashlog allocated RAM at address 0x3f00000
[    0.409955] workingset: timestamp_bits=14 max_order=15 bucket_order=1
[    0.422496] squashfs: version 4.0 (2009/01/31) Phillip Lougher
[    0.428741] jffs2: version 2.2 (NAND) (SUMMARY) (LZMA) (RTIME) (CMODE_PRIORITY) (c) 2001-2006 Red Hat, Inc.
[    0.503580] io scheduler noop registered
[    0.507753] io scheduler deadline registered (default)
[    0.513497] ar7200-usb-phy 18030000.usb-phy0: phy reset is missing
[    0.521743] pinctrl-single 1804002c.pinmux: 544 pins, size 68
[    0.528381] gpio-export gpio_export: 1 gpio(s) exported
[    0.534733] Serial: 8250/16550 driver, 1 ports, IRQ sharing disabled
[    0.542078] console [ttyS0] disabled
[    0.545954] 18020000.uart: ttyS0 at MMIO 0x18020000 (irq = 9, base_baud = 2500000) is a 16550A
[    0.555147] console [ttyS0] enabled
[    0.555147] console [ttyS0] enabled
[    0.562555] bootconsole [early0] disabled
[    0.562555] bootconsole [early0] disabled
[    0.576947] m25p80 spi0.0: mx25l12805d (16384 Kbytes)
[    0.582112] 5 fixed-partitions partitions found on MTD device spi0.0
[    0.588594] Creating 5 MTD partitions on "spi0.0":
[    0.593497] 0x000000000000-0x000000040000 : "u-boot"
[    0.599215] 0x000000040000-0x000000050000 : "u-boot-env"
[    0.605312] 0x000000050000-0x000000060000 : "art"
[    0.610723] 0x000000060000-0x000000070000 : "art_bak"
[    0.616554] 0x000000070000-0x000001000000 : "firmware"
[    0.630010] libphy: Fixed MDIO Bus: probed
[    0.984556] libphy: ag71xx_mdio: probed
[    1.103411] ag71xx 19000000.eth: connected to PHY at mdio-bus.0:04 [uid=004dd072, driver=Atheros 8035 ethernet]
[    1.114222] eth0: Atheros AG71xx at 0xb9000000, irq 4, mode: rgmii-rxid
[    1.454565] libphy: ag71xx_mdio: probed
[    1.477062] ag71xx 1a000000.eth: connected to PHY at mdio-bus.1:01 [uid=00000000, driver=Generic PHY]
[    1.487020] eth1: Atheros AG71xx at 0xba000000, irq 5, mode: sgmii
[    1.493623] ath79-wdt 18060008.wdt: unable to register misc device, err=-16
[    1.500708] ath79-wdt: probe of 18060008.wdt failed with error -16
[    1.508525] NET: Registered protocol family 10
[    1.517116] Segment Routing with IPv6
[    1.520932] NET: Registered protocol family 17
[    1.525557] 8021q: 802.1Q VLAN Support v1.8
[    1.559740] Freeing unused kernel memory: 7736K
[    1.564363] This architecture does not have kernel memory protection.
[    1.570895] Run /init as init process
[    1.586720] init: Console is alive
[    1.590373] init: - watchdog -
[    1.611665] kmodloader: loading kernel modules from /etc/modules-boot.d/*
[    1.628186] usbcore: registered new interface driver usbfs
[    1.633881] usbcore: registered new interface driver hub
[    1.639348] usbcore: registered new device driver usb
[    1.649945] ehci_hcd: USB 2.0 'Enhanced' Host Controller (EHCI) Driver
[    1.658022] ehci-platform: EHCI generic platform driver
[    1.663587] ehci-platform 1b000000.usb: EHCI Host Controller
[    1.669382] ehci-platform 1b000000.usb: new USB bus registered, assigned bus number 1
[    1.677428] ehci-platform 1b000000.usb: irq 14, io mem 0x1b000000
[    1.712818] ehci-platform 1b000000.usb: USB 2.0 started, EHCI 1.00
[    1.719851] hub 1-0:1.0: USB hub found
[    1.724029] hub 1-0:1.0: 1 port detected
[    1.729020] kmodloader: done loading kernel modules from /etc/modules-boot.d/*
[    1.746781] init: - preinit -
[    1.943573] random: jshn: uninitialized urandom read (4 bytes read)
[    2.024267] random: jshn: uninitialized urandom read (4 bytes read)
[    2.200081] random: jshn: uninitialized urandom read (4 bytes read)
[    2.397347] IPv6: ADDRCONF(NETDEV_UP): eth0: link is not ready
Press the [f] key and hit [enter] to enter failsafe mode
Press the [1], [2], [3] or [4] key and hit [enter] to select the debug level
[    4.596838] random: fast init done
[    5.531282] procd: - early -
[    5.534877] procd: - watchdog -
[    6.080213] procd: - watchdog -
[    6.083678] procd: - ubus -
[    6.092316] urandom_read: 5 callbacks suppressed
[    6.092323] random: ubusd: uninitialized urandom read (4 bytes read)
[    6.136885] random: ubusd: uninitialized urandom read (4 bytes read)
[    6.144545] procd: - init -
Please press Enter to activate this console.
[    6.550221] kmodloader: loading kernel modules from /etc/modules.d/*
[    6.567176] urngd: v1.0.0 started.
[    6.584158] Loading modules backported from Linux version v4.19.32-0-g3a2156c839c7
[    6.591841] Backport generated by backports.git v4.19.32-1-0-g1c4f7569
[    6.647568] xt_time: kernel timezone is -0000
[    6.759653] PPP generic driver version 2.4.2
[    6.773640] NET: Registered protocol family 24
[    6.835756] ath10k 4.19 driver, optimized for CT firmware, probing pci device: 0x3c.
[    6.848775] random: crng init done
[    6.853160] ath10k_pci 0000:00:00.0: enabling device (0000 -> 0002)
[    6.859694] ath10k_pci 0000:00:00.0: pci irq legacy oper_irq_mode 1 irq_mode 0 reset_mode 0
[    7.227000] firmware ath10k!fwcfg-pci-0000:00:00.0.txt: firmware_loading_store: map pages failed
[    7.417202] firmware ath10k!pre-cal-pci-0000:00:00.0.bin: firmware_loading_store: map pages failed
[    7.842693] firmware ath10k!QCA988X!hw2.0!ct-firmware-5.bin: firmware_loading_store: map pages failed
[    8.033359] firmware ath10k!QCA988X!hw2.0!ct-firmware-2.bin: firmware_loading_store: map pages failed
[    8.224462] firmware ath10k!QCA988X!hw2.0!firmware-6.bin: firmware_loading_store: map pages failed
[    8.416283] firmware ath10k!QCA988X!hw2.0!firmware-5.bin: firmware_loading_store: map pages failed
[    8.606658] firmware ath10k!QCA988X!hw2.0!firmware-4.bin: firmware_loading_store: map pages failed
[    8.799995] firmware ath10k!QCA988X!hw2.0!firmware-3.bin: firmware_loading_store: map pages failed
[    8.811087] ath10k_pci 0000:00:00.0: qca988x hw2.0 target 0x4100016c chip_id 0x043202ff sub 0000:0000
[    8.820489] ath10k_pci 0000:00:00.0: kconfig debug 0 debugfs 1 tracing 0 dfs 1 testmode 0
[    8.832915] ath10k_pci 0000:00:00.0: firmware ver 10.1-ct-8x-__fW-022-8f2afb9e 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 f90f1a48
[    9.058912] firmware ath10k!QCA988X!hw2.0!board-2.bin: firmware_loading_store: map pages failed
[    9.068129] ath10k_pci 0000:00:00.0: board_file api 1 bmi_id N/A crc32 bebc7c08
[   10.019209] ath10k_pci 0000:00:00.0: 10.1 wmi init: vdevs: 16  peers: 127  tid: 256
[   10.036667] ath10k_pci 0000:00:00.0: wmi print 'P 128 V 8 T 410'
[   10.043006] ath10k_pci 0000:00:00.0: wmi print 'msdu-desc: 1424  sw-crypt: 0 ct-sta: 0'
[   10.051128] ath10k_pci 0000:00:00.0: wmi print 'alloc rem: 24616 iram: 26120'
[   10.119243] ath10k_pci 0000:00:00.0: htt-ver 2.1 wmi-op 2 htt-op 2 cal file max-sta 128 raw 0 hwcrypto 1
[   10.132088] ath10k_pci 0000:00:00.0: NOTE:  Firmware DBGLOG output disabled in debug_mask: 0x10000000
[   10.367902] ieee80211 phy1: Atheros AR9550 Rev:0 mem=0xb8100000, irq=13
[   10.406895] kmodloader: done loading kernel modules from /etc/modules.d/*
[   29.109754] eth0: link up (1000Mbps/Full duplex)
[   29.123064] br-lan: port 1(eth0) entered blocking state
[   29.128371] br-lan: port 1(eth0) entered disabled state
[   29.133964] device eth0 entered promiscuous mode
[   29.152204] br-lan: port 1(eth0) entered blocking state
[   29.157548] br-lan: port 1(eth0) entered forwarding state
[   29.163202] IPv6: ADDRCONF(NETDEV_UP): br-lan: link is not ready
[   30.112819] IPv6: ADDRCONF(NETDEV_CHANGE): br-lan: link becomes ready



BusyBox v1.31.0 () built-in shell (ash)

  _______                     ________        __
 |       |.-----.-----.-----.|  |  |  |.----.|  |_
 |   -   ||  _  |  -__|     ||  |  |  ||   _||   _|
 |_______||   __|_____|__|__||________||__|  |____|
          |__| W I R E L E S S   F R E E D O M
 -----------------------------------------------------
 OpenWrt SNAPSHOT, r10374+1-fdd0a8d491
 -----------------------------------------------------
=== WARNING! =====================================
There is no root password defined on this device!
Use the "passwd" command to set up a new password
in order to prevent unauthorized SSH logins.
--------------------------------------------------
root@OpenWrt:/# ifconfig
br-lan    Link encap:Ethernet  HWaddr ** REMOVED **
          inet addr:192.168.1.1  Bcast:192.168.1.255  Mask:255.255.255.0
          inet6 addr: ** REMOVED **
          inet6 addr: ** REMOVED **
          UP BROADCAST RUNNING MULTICAST  MTU:1500  Metric:1
          RX packets:6 errors:0 dropped:0 overruns:0 frame:0
          TX packets:12 errors:0 dropped:0 overruns:0 carrier:0
          collisions:0 txqueuelen:1000 
          RX bytes:468 (468.0 B)  TX bytes:1784 (1.7 KiB)

eth0      Link encap:Ethernet  HWaddr ** REMOVED **
          UP BROADCAST RUNNING MULTICAST  MTU:1500  Metric:1
          RX packets:6 errors:0 dropped:0 overruns:0 frame:0
          TX packets:12 errors:0 dropped:0 overruns:0 carrier:0
          collisions:0 txqueuelen:1000 
          RX bytes:552 (552.0 B)  TX bytes:1784 (1.7 KiB)
          Interrupt:4 

lo        Link encap:Local Loopback  
          inet addr:127.0.0.1  Mask:255.0.0.0
          inet6 addr: ::1/128 Scope:Host
          UP LOOPBACK RUNNING  MTU:65536  Metric:1
          RX packets:128 errors:0 dropped:0 overruns:0 frame:0
          TX packets:128 errors:0 dropped:0 overruns:0 carrier:0
          collisions:0 txqueuelen:1000 
          RX bytes:8704 (8.5 KiB)  TX bytes:8704 (8.5 KiB)

Debug: ah yeah, right... :cold_face:

set -vx

and/or

printf "%s: Doing something interesting with '%s'\n" "${SOMETHING}" >> /var/log/debug.log

Sorry, jeff, I think you lost me there. Okay, "set -vx" I understand but the other line wouldn't output anything useful, right?

I still executed both commands after booting with the expected result of "nothing useful" inside the debug.log. How I would "set -vx" earlier, during boot maybe, is beyond me.

Anyway: On the last boot, I set debug level to 4 at

Press the [1], [2], [3] or [4] key and hit [enter] to select the debug level

Yet the output didn't include anything new on the network part.

Like I said earlier, I'm no developer... so without some more details, I'm afraid I'm not going to be able to get this done.

Sorry for being such a pain here. Seeing so many similar devices supported already and the AP55 running OpenWRT ("from Sophos") already, I mistakenly thought this couldn't be too much of a challenge, even with very limited knowledge.

The other line is "printf debugging" -- print out what you need to "see" the script being executed and what it is being called with. I don't think it is the network part, but that the hotplug script isn't doing its job, at least from what I've seen here. If you're not seeing anything from those, then the next step would be figuring out why not.

I did some more reading on the hotplug/procd part and from what I understand I should see something "hotplug" after enabling debug via [4] (see above) as procd clearly runs afterwards. Can't identify anything useful here, though:

Press the [f] key and hit [enter] to enter failsafe mode
Press the [1], [2], [3] or [4] key and hit [enter] to select the debug level
4[    4.552799] random: fast init done

[    4.717442] procd: Change state 0 -> 1
[    4.721319] procd: - early -
[    4.724365] procd: Watchdog handover: fd=3
[    4.728586] procd: - watchdog -
[    4.731852] procd: Ping
[    4.734475] procd: Opened watchdog with timeout 30s
[    4.768147] procd: {{"ACTION":"add","DEVPATH":"/devices/virtual/mem/full","SUBSYSTEM":"mem","SYNTH_UUID":"0","MAJOR":"1","MINOR":"7","DEVNAME":"full","DEVMODE":"0666","SEQNUM":"391"}}
[    4.794656] procd: Command: makedev
[    4.798266] procd:  /dev/full
[    4.801340] procd:  0666
[    4.804103] procd: Message:
[    4.807001] procd:  ACTION=add
[    4.810169] procd:  DEVPATH=/devices/virtual/mem/full
[    4.815409] procd:  SUBSYSTEM=mem
[    4.818835] procd:  SYNTH_UUID=0
[    4.822170] procd:  MAJOR=1
[    4.825109] procd:  MINOR=7
[    4.828003] procd:  DEVNAME=full
[    4.831340] procd:  DEVMODE=0666
[    4.834719] procd:  SEQNUM=391
[    4.838025] procd: Finished udevtrigger
[    4.842132] procd: {{"ACTION":"add","DEVPATH":"/devices/virtual/mem/urandom","SUBSYSTEM":"mem","SYNTH_UUID":"0","MAJOR":"1","MINOR":"9","DEVNAME":"urandom","DEVMODE":"0666","SEQNUM":"392"}}
[    4.859416] procd: Command: makedev
[    4.863068] procd:  /dev/urandom
[    4.866410] procd:  0666
[    4.869046] procd: Message:
[    4.871945] procd:  ACTION=add
[    4.875149] procd:  DEVPATH=/devices/virtual/mem/urandom
[    4.880604] procd:  SUBSYSTEM=mem
[    4.884071] procd:  SYNTH_UUID=0
[    4.887516] procd:  MAJOR=1
[    4.890417] procd:  MINOR=9
[    4.893368] procd:  DEVNAME=urandom
[    4.896970] procd:  DEVMODE=0666
[    4.900306] procd:  SEQNUM=392
[    4.903741] procd: {{"ACTION":"add","DEVPATH":"/devices/virtual/mem/null","SUBSYSTEM":"mem","SYNTH_UUID":"0","MAJOR":"1","MINOR":"3","DEVNAME":"null","DEVMODE":"0666","SEQNUM":"393"}}
[    4.920499] procd: Command: makedev
[    4.924149] procd:  /dev/null
[    4.927222] procd:  0666
[    4.929853] procd: Message:
[    4.932751] procd:  ACTION=add
[    4.935957] procd:  DEVPATH=/devices/virtual/mem/null
[    4.941145] procd:  SUBSYSTEM=mem
[    4.944616] procd:  SYNTH_UUID=0
[    4.947957] procd:  MAJOR=1
[    4.950855] procd:  MINOR=3
[    4.953802] procd:  DEVNAME=null
[    4.957144] procd:  DEVMODE=0666
[    4.960480] procd:  SEQNUM=393
[    4.963887] procd: {{"ACTION":"add","DEVPATH":"/devices/virtual/mem/random","SUBSYSTEM":"mem","SYNTH_UUID":"0","MAJOR":"1","MINOR":"8","DEVNAME":"random","DEVMODE":"0666","SEQNUM":"394"}}
[    4.980993] procd: Command: makedev
[    4.984648] procd:  /dev/random
[    4.987900] procd:  0666
[    4.990529] procd: Message:
[    4.993473] procd:  ACTION=add
[    4.996642] procd:  DEVPATH=/devices/virtual/mem/random
[    5.002009] procd:  SUBSYSTEM=mem
[    5.005483] procd:  SYNTH_UUID=0
[    5.008827] procd:  MAJOR=1
[    5.011724] procd:  MINOR=8
[    5.014662] procd:  DEVNAME=random
[    5.018180] procd:  DEVMODE=0666
[    5.021517] procd:  SEQNUM=394
[    5.024945] procd: {{"ACTION":"add","DEVPATH":"/devices/virtual/misc/network_latency","SUBSYSTEM":"misc","SYNTH_UUID":"0","MAJOR":"10","MINOR":"62","DEVNAME":"network_latency","SEQNUM":"395"}}
[    5.042691] procd: Command: makedev
[    5.046354] procd:  /dev/network_latency
[    5.050399] procd:  0600
[    5.053071] procd: Message:
[    5.055969] procd:  ACTION=add
[    5.059131] procd:  DEVPATH=/devices/virtual/misc/network_latency
[    5.065423] procd:  SUBSYSTEM=misc
[    5.068940] procd:  SYNTH_UUID=0
[    5.072275] procd:  MAJOR=10
[    5.075303] procd:  MINOR=62
[    5.078295] procd:  DEVNAME=network_latency
[    5.082597] procd:  SEQNUM=395
[    5.086078] procd: {{"ACTION":"add","DEVPATH":"/devices/virtual/misc/memory_bandwidth","SUBSYSTEM":"misc","SYNTH_UUID":"0","MAJOR":"10","MINOR":"60","DEVNAME":"memory_bandwidth","SEQNUM":"396"}}
[    5.103929] procd: Command: makedev
[    5.107541] procd:  /dev/memory_bandwidth
[    5.111673] procd:  0600
[    5.114353] procd: Message:
[    5.117253] procd:  ACTION=add
[    5.120413] procd:  DEVPATH=/devices/virtual/misc/memory_bandwidth
[    5.126799] procd:  SUBSYSTEM=misc
[    5.130314] procd:  SYNTH_UUID=0
[    5.133701] procd:  MAJOR=10
[    5.136692] procd:  MINOR=60
[    5.139676] procd:  DEVNAME=memory_bandwidth
[    5.144126] procd:  SEQNUM=396
[    5.147562] procd: {{"ACTION":"add","DEVPATH":"/devices/virtual/misc/cpu_dma_latency","SUBSYSTEM":"misc","SYNTH_UUID":"0","MAJOR":"10","MINOR":"63","DEVNAME":"cpu_dma_latency","SEQNUM":"397"}}
[    5.165228] procd: Command: makedev
[    5.168833] procd:  /dev/cpu_dma_latency
[    5.172925] procd:  0600
[    5.175560] procd: Message:
[    5.178457] procd:  ACTION=add
[    5.181617] procd:  DEVPATH=/devices/virtual/misc/cpu_dma_latency
[    5.187909] procd:  SUBSYSTEM=misc
[    5.191427] procd:  SYNTH_UUID=0
[    5.194872] procd:  MAJOR=10
[    5.197861] procd:  MINOR=63
[    5.200844] procd:  DEVNAME=cpu_dma_latency
[    5.205195] procd:  SEQNUM=397
[    5.208635] procd: {{"ACTION":"add","DEVPATH":"/devices/platform/watchdog/misc/watchdog","SUBSYSTEM":"misc","SYNTH_UUID":"0","MAJOR":"10","MINOR":"130","DEVNAME":"watchdog","SEQNUM":"398"}}
[    5.226034] procd: Command: makedev
[    5.229640] procd:  /dev/watchdog
[    5.233120] procd:  0600
[    5.235750] procd: Message:
[    5.238649] procd:  ACTION=add
[    5.241811] procd:  DEVPATH=/devices/platform/watchdog/misc/watchdog
[    5.248365] procd:  SUBSYSTEM=misc
[    5.251883] procd:  SYNTH_UUID=0
[    5.255264] procd:  MAJOR=10
[    5.258255] procd:  MINOR=130
[    5.261326] procd:  DEVNAME=watchdog
[    5.265057] procd:  SEQNUM=398
[    5.268496] procd: {{"ACTION":"add","DEVPATH":"/devices/virtual/misc/network_throughput","SUBSYSTEM":"misc","SYNTH_UUID":"0","MAJOR":"10","MINOR":"61","DEVNAME":"network_throughput","SEQNUM":"399"}}
[    5.286693] procd: Command: makedev
[    5.290299] procd:  /dev/network_throughput
[    5.294657] procd:  0600
[    5.297289] procd: Message:
[    5.300188] procd:  ACTION=add
[    5.303403] procd:  DEVPATH=/devices/virtual/misc/network_throughput
[    5.309913] procd:  SUBSYSTEM=misc
[    5.313477] procd:  SYNTH_UUID=0
[    5.316819] procd:  MAJOR=10
[    5.319803] procd:  MINOR=61
[    5.322786] procd:  DEVNAME=network_throughput
[    5.327398] procd:  SEQNUM=399
[    5.330842] procd: {{"ACTION":"add","DEVPATH":"/devices/platform/watchdog/watchdog/watchdog0","SUBSYSTEM":"watchdog","SYNTH_UUID":"0","MAJOR":"253","MINOR":"0","DEVNAME":"watchdog0","SEQNUM":"400"}}
[    5.349109] procd: Command: makedev
[    5.352719] procd:  /dev/watchdog0
[    5.356285] procd:  0600
[    5.358917] procd: Message:
[    5.361814] procd:  ACTION=add
[    5.365018] procd:  DEVPATH=/devices/platform/watchdog/watchdog/watchdog0
[    5.371967] procd:  SUBSYSTEM=watchdog
[    5.375876] procd:  SYNTH_UUID=0
[    5.379220] procd:  MAJOR=253
[    5.382290] procd:  MINOR=0
[    5.385229] procd:  DEVNAME=watchdog0
[    5.389004] procd:  SEQNUM=400
[    5.392444] procd: {{"ACTION":"add","DEVPATH":"/devices/virtual/tty/ptmx","SUBSYSTEM":"tty","SYNTH_UUID":"0","MAJOR":"5","MINOR":"2","DEVNAME":"ptmx","DEVMODE":"0666","SEQNUM":"401"}}
[    5.409200] procd: Command: makedev
[    5.412848] procd:  /dev/ptmx
[    5.415931] procd:  0666
[    5.418561] procd: Message:
[    5.421460] procd:  ACTION=add
[    5.424664] procd:  DEVPATH=/devices/virtual/tty/ptmx
[    5.429853] procd:  SUBSYSTEM=tty
[    5.433323] procd:  SYNTH_UUID=0
[    5.436665] procd:  MAJOR=5
[    5.439561] procd:  MINOR=2
[    5.442455] procd:  DEVNAME=ptmx
[    5.445836] procd:  DEVMODE=0666
[    5.449180] procd:  SEQNUM=401
[    5.452539] procd: {{"ACTION":"add","DEVPATH":"/devices/virtual/tty/console","SUBSYSTEM":"tty","SYNTH_UUID":"0","MAJOR":"5","MINOR":"1","DEVNAME":"console","SEQNUM":"402"}}
[    5.468449] procd: Command: makedev
[    5.472064] procd:  /dev/console
[    5.475451] procd:  0600
[    5.478085] procd: Message:
[    5.480983] procd:  ACTION=add
[    5.484187] procd:  DEVPATH=/devices/virtual/tty/console
[    5.489642] procd:  SUBSYSTEM=tty
[    5.493110] procd:  SYNTH_UUID=0
[    5.496453] procd:  MAJOR=5
[    5.499437] procd:  MINOR=1
[    5.502340] procd:  DEVNAME=console
[    5.505988] procd:  SEQNUM=402
[    5.509432] procd: {{"ACTION":"add","DEVPATH":"/devices/platform/ahb/ahb:apb/18020000.uart/tty/ttyS0","SUBSYSTEM":"tty","SYNTH_UUID":"0","MAJOR":"4","MINOR":"64","DEVNAME":"ttyS0","SEQNUM":"403"}}
[    5.527453] procd: Command: makedev
[    5.531059] procd:  /dev/ttyS0
[    5.534272] procd:  0660
[    5.536906] procd:  dialout
[    5.539798] procd: Message:
[    5.542697] procd:  ACTION=add
[    5.545903] procd:  DEVPATH=/devices/platform/ahb/ahb:apb/18020000.uart/tty/ttyS0
[    5.553666] procd:  SUBSYSTEM=tty
[    5.557095] procd:  SYNTH_UUID=0
[    5.560428] procd:  MAJOR=4
[    5.563371] procd:  MINOR=64
[    5.566358] procd:  DEVNAME=ttyS0
[    5.569783] procd:  SEQNUM=403
[    5.573202] procd: Command: makedev
[    5.576810] procd:  /dev/ttyS0
[    5.579973] procd:  0600
[    5.582603] procd: Message:
[    5.585552] procd:  ACTION=add
[    5.588716] procd:  DEVPATH=/devices/platform/ahb/ahb:apb/18020000.uart/tty/ttyS0
[    5.596414] procd:  SUBSYSTEM=tty
[    5.599844] procd:  SYNTH_UUID=0
[    5.603223] procd:  MAJOR=4
[    5.606118] procd:  MINOR=64
[    5.609101] procd:  DEVNAME=ttyS0
[    5.612525] procd:  SEQNUM=403
[    5.615981] procd: {{"ACTION":"add","DEVPATH":"/devices/virtual/tty/tty","SUBSYSTEM":"tty","SYNTH_UUID":"0","MAJOR":"5","MINOR":"0","DEVNAME":"tty","DEVMODE":"0666","SEQNUM":"404"}}
[    5.632560] procd: Command: makedev
[    5.636267] procd:  /dev/tty
[    5.639260] procd:  0666
[    5.641888] procd: Message:
[    5.644834] procd:  ACTION=add
[    5.647998] procd:  DEVPATH=/devices/virtual/tty/tty
[    5.653186] procd:  SUBSYSTEM=tty
[    5.656615] procd:  SYNTH_UUID=0
[    5.659957] procd:  MAJOR=5
[    5.662899] procd:  MINOR=0
[    5.665800] procd:  DEVNAME=tty
[    5.669047] procd:  DEVMODE=0666
[    5.672381] procd:  SEQNUM=404
[    5.675822] procd: {{"ACTION":"add","DEVPATH":"/devices/platform/ahb/1f000000.spi/spi_master/spi0/spi0.0/mtd/mtd4/mtdblock4","SUBSYSTEM":"block","SYNTH_UUID":"0","MAJOR":"31","MINOR":"4","DEVNAME":"mtdblock4","DEVTYPE":"disk","SEQNUM":"405"}}
[    5.697898] procd: Command: makedev
[    5.701507] procd:  /dev/mtdblock4
[    5.705071] procd:  0600
[    5.707704] procd: Message:
[    5.710602] procd:  ACTION=add
[    5.713808] procd:  DEVPATH=/devices/platform/ahb/1f000000.spi/spi_master/spi0/spi0.0/mtd/mtd4/mtdblock4
[    5.723526] procd:  SUBSYSTEM=block
[    5.727126] procd:  SYNTH_UUID=0
[    5.730463] procd:  MAJOR=31
[    5.733490] procd:  MINOR=4
[    5.736392] procd:  DEVNAME=mtdblock4
[    5.740170] procd:  DEVTYPE=disk
[    5.743549] procd:  SEQNUM=405
[    5.746999] procd: {{"ACTION":"add","DEVPATH":"/devices/platform/ahb/1f000000.spi/spi_master/spi0/spi0.0/mtd/mtd2/mtdblock2","SUBSYSTEM":"block","SYNTH_UUID":"0","MAJOR":"31","MINOR":"2","DEVNAME":"mtdblock2","DEVTYPE":"disk","SEQNUM":"406"}}
[    5.769078] procd: Command: makedev
[    5.772691] procd:  /dev/mtdblock2
[    5.776255] procd:  0600
[    5.778887] procd: Message:
[    5.781785] procd:  ACTION=add
[    5.785000] procd:  DEVPATH=/devices/platform/ahb/1f000000.spi/spi_master/spi0/spi0.0/mtd/mtd2/mtdblock2
[    5.794719] procd:  SUBSYSTEM=block
[    5.798319] procd:  SYNTH_UUID=0
[    5.801654] procd:  MAJOR=31
[    5.804747] procd:  MINOR=2
[    5.807649] procd:  DEVNAME=mtdblock2
[    5.811432] procd:  DEVTYPE=disk
[    5.814817] procd:  SEQNUM=406
[    5.818267] procd: {{"ACTION":"add","DEVPATH":"/devices/platform/ahb/1f000000.spi/spi_master/spi0/spi0.0/mtd/mtd0/mtdblock0","SUBSYSTEM":"block","SYNTH_UUID":"0","MAJOR":"31","MINOR":"0","DEVNAME":"mtdblock0","DEVTYPE":"disk","SEQNUM":"407"}}
[    5.840338] procd: Command: makedev
[    5.844001] procd:  /dev/mtdblock0
[    5.847520] procd:  0600
[    5.850150] procd: Message:
[    5.853092] procd:  ACTION=add
[    5.856261] procd:  DEVPATH=/devices/platform/ahb/1f000000.spi/spi_master/spi0/spi0.0/mtd/mtd0/mtdblock0
[    5.865984] procd:  SUBSYSTEM=block
[    5.869591] procd:  SYNTH_UUID=0
[    5.872976] procd:  MAJOR=31
[    5.875962] procd:  MINOR=0
[    5.878857] procd:  DEVNAME=mtdblock0
[    5.882632] procd:  DEVTYPE=disk
[    5.886012] procd:  SEQNUM=407
[    5.889464] procd: {{"ACTION":"add","DEVPATH":"/devices/platform/ahb/1f000000.spi/spi_master/spi0/spi0.0/mtd/mtd3/mtdblock3","SUBSYSTEM":"block","SYNTH_UUID":"0","MAJOR":"31","MINOR":"3","DEVNAME":"mtdblock3","DEVTYPE":"disk","SEQNUM":"408"}}
[    5.911531] procd: Command: makedev
[    5.915193] procd:  /dev/mtdblock3
[    5.918713] procd:  0600
[    5.921342] procd: Message:
[    5.924284] procd:  ACTION=add
[    5.927452] procd:  DEVPATH=/devices/platform/ahb/1f000000.spi/spi_master/spi0/spi0.0/mtd/mtd3/mtdblock3
[    5.937176] procd:  SUBSYSTEM=block
[    5.940781] procd:  SYNTH_UUID=0
[    5.944163] procd:  MAJOR=31
[    5.947153] procd:  MINOR=3
[    5.950050] procd:  DEVNAME=mtdblock3
[    5.953879] procd:  DEVTYPE=disk
[    5.957305] procd:  SEQNUM=408
[    5.960760] procd: {{"ACTION":"add","DEVPATH":"/devices/platform/ahb/1f000000.spi/spi_master/spi0/spi0.0/mtd/mtd1/mtdblock1","SUBSYSTEM":"block","SYNTH_UUID":"0","MAJOR":"31","MINOR":"1","DEVNAME":"mtdblock1","DEVTYPE":"disk","SEQNUM":"409"}}
[    5.982873] procd: Command: makedev
[    5.986490] procd:  /dev/mtdblock1
[    5.990000] procd:  0600
[    5.992631] procd: Message:
[    5.995573] procd:  ACTION=add
[    5.998742] procd:  DEVPATH=/devices/platform/ahb/1f000000.spi/spi_master/spi0/spi0.0/mtd/mtd1/mtdblock1
[    6.008467] procd:  SUBSYSTEM=block
[    6.012070] procd:  SYNTH_UUID=0
[    6.015450] procd:  MAJOR=31
[    6.018434] procd:  MINOR=1
[    6.021329] procd:  DEVNAME=mtdblock1
[    6.025148] procd:  DEVTYPE=disk
[    6.028482] procd:  SEQNUM=409
[    6.532333] procd: Coldplug complete
[    6.536084] procd: Change state 1 -> 2
[    6.539961] procd: - watchdog -
[    6.543266] procd: Ping
[    6.545844] procd: Opened watchdog with timeout 30s
[    6.550988] procd: - ubus -
[    6.553986] procd: Create service ubus
[    6.557898] procd: Start instance ubus::instance1
[    6.563246] procd: Started instance ubus::instance1[525]
[    6.568841] procd: running /etc/init.d/ubus running
[    6.579017] urandom_read: 5 callbacks suppressed
[    6.579024] random: ubusd: uninitialized urandom read (4 bytes read)
[    6.590397] procd: glob failed on /etc/init.d/ubus
[    6.604034] random: ubusd: uninitialized urandom read (4 bytes read)
[    6.611765] procd: Connected to ubus, id=3589b46e
[    6.616732] procd: Change state 2 -> 3
[    6.620601] procd: - init -
[    6.623970] procd: Parsing inittab - ::sysinit:/etc/init.d/rcS S boot
[    6.630647] procd: Parsing inittab - ::shutdown:/etc/init.d/rcS K shutdown
[    6.637809] procd: Parsing inittab - ::askconsole:/usr/libexec/login.sh
[    6.645328] procd: Launched new askconsole action, pid=526
[    6.651073] procd: running /etc/rc.d/S* boot
Please press Enter to activate this console.
[    7.060314] kmodloader: loading kernel modules from /etc/modules.d/*
[    7.074297] urngd: v1.0.0 started.
[    7.101933] Loading modules backported from Linux version v4.19.32-0-g3a2156c839c7
[    7.109664] Backport generated by backports.git v4.19.32-1-0-g1c4f7569
[    7.168255] xt_time: kernel timezone is -0000
[    7.280195] PPP generic driver version 2.4.2
[    7.293641] NET: Registered protocol family 24
[    7.353434] random: crng init done
[    7.359742] ath10k 4.19 driver, optimized for CT firmware, probing pci device: 0x3c.
[    7.368996] ath10k_pci 0000:00:00.0: enabling device (0000 -> 0002)
[    7.375557] ath10k_pci 0000:00:00.0: pci irq legacy oper_irq_mode 1 irq_mode 0 reset_mode 0
[    7.749405] firmware ath10k!fwcfg-pci-0000:00:00.0.txt: firmware_loading_store: map pages failed
[    7.942779] firmware ath10k!pre-cal-pci-0000:00:00.0.bin: firmware_loading_store: map pages failed
1+0 records in
1+0 records out
2+0 records in
2+0 records out
[    8.374550] firmware ath10k!QCA988X!hw2.0!ct-firmware-5.bin: firmware_loading_store: map pages failed
[    8.568684] firmware ath10k!QCA988X!hw2.0!ct-firmware-2.bin: firmware_loading_store: map pages failed
[    8.762958] firmware ath10k!QCA988X!hw2.0!firmware-6.bin: firmware_loading_store: map pages failed
[    8.956876] firmware ath10k!QCA988X!hw2.0!firmware-5.bin: firmware_loading_store: map pages failed
[    9.149691] firmware ath10k!QCA988X!hw2.0!firmware-4.bin: firmware_loading_store: map pages failed
[    9.344037] firmware ath10k!QCA988X!hw2.0!firmware-3.bin: firmware_loading_store: map pages failed
[    9.355126] ath10k_pci 0000:00:00.0: qca988x hw2.0 target 0x4100016c chip_id 0x043202ff sub 0000:0000
[    9.364524] ath10k_pci 0000:00:00.0: kconfig debug 0 debugfs 1 tracing 0 dfs 1 testmode 0
[    9.376934] ath10k_pci 0000:00:00.0: firmware ver 10.1-ct-8x-__fW-022-8f2afb9e 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 f90f1a48
[    9.609754] firmware ath10k!QCA988X!hw2.0!board-2.bin: firmware_loading_store: map pages failed
[    9.618976] ath10k_pci 0000:00:00.0: board_file api 1 bmi_id N/A crc32 bebc7c08
[   10.562781] ath10k_pci 0000:00:00.0: 10.1 wmi init: vdevs: 16  peers: 127  tid: 256
[   10.580235] ath10k_pci 0000:00:00.0: wmi print 'P 128 V 8 T 410'
[   10.586573] ath10k_pci 0000:00:00.0: wmi print 'msdu-desc: 1424  sw-crypt: 0 ct-sta: 0'
[   10.594721] ath10k_pci 0000:00:00.0: wmi print 'alloc rem: 24616 iram: 26120'
[   10.662850] ath10k_pci 0000:00:00.0: htt-ver 2.1 wmi-op 2 htt-op 2 cal file max-sta 128 raw 0 hwcrypto 1
[   10.675644] ath10k_pci 0000:00:00.0: NOTE:  Firmware DBGLOG output disabled in debug_mask: 0x10000000
[   10.921910] ieee80211 phy1: Atheros AR9550 Rev:0 mem=0xb8100000, irq=13
[   10.964068] kmodloader: done loading kernel modules from /etc/modules.d/*
[   63.304325] eth0: link up (1000Mbps/Full duplex)
[   63.313310] br-lan: port 1(eth0) entered blocking state
[   63.318614] br-lan: port 1(eth0) entered disabled state
[   63.324214] device eth0 entered promiscuous mode
[   63.346526] br-lan: port 1(eth0) entered blocking state
[   63.351836] br-lan: port 1(eth0) entered forwarding state
[   63.357507] IPv6: ADDRCONF(NETDEV_UP): br-lan: link is not ready
[   64.352825] IPv6: ADDRCONF(NETDEV_CHANGE): br-lan: link becomes ready
udhcpc: started, v1.31.0
udhcpc: sending discover
udhcpc: no lease, failing

There's not much info for a "openwrt hotplug" search, the only remotely interesting thing I found is:

I solved my problem. After inspecting carefully the boot sequence , i created my script in /etc/init.d and made a symlink in /etc/rc.d after that my script ran at boot.

Might be a timing thing -- I'm not an expert on interpreting the boot logs, but

[    7.942779] firmware ath10k!pre-cal-pci-0000:00:00.0.bin: firmware_loading_store: map pages failed
1+0 records in
1+0 records out
2+0 records in
2+0 records out

looks like it's copying the cal data from the ART partition.

Before chunkeey made the reading of the ART data faster, when I was working with initramfs boot, it was always "too late" for driver load. I ended up copying the cal-data file from a booted system to my build so that it didn't need to be loaded.

1 Like

Questions, questions, questions....

  1. "/lib/firmware/ath10k/cal-pci-0000:00:00.0.bin"?
  2. Is the file somewhat generic so it works on any identical hardware?
  3. Should it be extracted from the official firmware instead?
  4. Where would I put it to have "make" include it?