pgj / freebsd-wifibox

wifibox: Use Linux to drive your wireless card on FreeBSD
BSD 2-Clause "Simplified" License
176 stars 11 forks source link

Connection halts every few packets #131

Closed evergreenbear closed 2 weeks ago

evergreenbear commented 1 month ago

Description

Hi, I am using wifibox on FreeBSD 14,1-RELEASE on a 1st gen ThinkPad T14. I have installed wifibox and set it up by following the manual page. I get a connection on the host system, which is significantly faster than using wifi natively, but unfortunately I can only send about ten packets before the next 10 or so will never receive a response. This happens in a loop for as long as I am using wifibox for networking.

Host operating system

FreeBSD melursus 14.1-RELEASE FreeBSD 14.1-RELEASE releng/14.1-n267679-10e31f0946d8 GENERIC amd64

Wireless NIC

iwlwifi0@pci0:0:20:3:   class=0x028000 rev=0x00 hdr=0x00 vendor=0x8086 device=0x02f0 subvendor=0x8086 subdevice=0x0070
    vendor     = 'Intel Corporation'
    device     = 'Comet Lake PCH-LP CNVi WiFi'
    class      = network

Wifibox version

wifibox version 0.13.0
Disk image checksum: 64b81929291e3dd68024cf6ab19af0c91ff5a4d0adfea0ff9cbc2004b4b6326a

Disk image type and version

wifibox-alpine-iwlwifi-20240506

Changes to the default configuration files

bhyve.conf

cpus=1
memory=256M
console=yes
passthru=0/20/3

wpa_supplicant.conf

network={
        ssid="<ssid>"
        psk="<password>"
        key_mgmt=WPA-PSK
}

/etc/rc.conf

wifibox_enable="YES"
devmatch_enable="YES"
devmatch_blocklist="if_iwm if_iwlwifi"
#defaultrouter="10.0.0.1"
ifconfig_wifibox0="SYNCDHCP"  #"inet 10.0.0.2/24"
background_dhclient_wifibox0="YES"
defaultroute_delay="0"

Logs

/var/log/wifibox.log

2024-10-06T21:19:51-0600 WARN  Guest is not running, hence not stopped
2024-10-06T21:19:52-0600 WARN  No linked tap inteface found for wifibox0
2024-10-06T21:38:18-0600 WARN  PPT device pci0:20:3 could not be destroyed
2024-10-06T21:45:24-0600 ERROR No null-modem device is configured
2024-10-06T21:55:01-0600 ERROR No null-modem device is configured
2024-10-06T21:55:04-0600 WARN  Guest is already run by PID 3223, left intact
2024-10-06T21:55:04-0600 WARN  Unix Domain Sockets are already forwarded, skipping
2024-10-06T21:59:11-0600 WARN  PPT device pci0:20:3 could not be destroyed
2024-10-06T22:03:25-0600 WARN  PPT device pci0:20:3 could not be destroyed
2024-10-06T22:07:50-0600 WARN  PPT device pci0:20:3 could not be destroyed
2024-10-06T22:11:43-0600 ERROR No null-modem device is configured
2024-10-06T22:13:41-0600 WARN  PPT device pci0:20:3 could not be destroyed
2024-10-06T22:19:08-0600 WARN  PPT device pci0:20:3 could not be destroyed
2024-10-06T22:22:33-0600 WARN  PPT device pci0:20:3 could not be destroyed
2024-10-06T22:30:06-0600 WARN  PPT device pci0:20:3 could not be destroyed
2024-10-06T22:40:15-0600 WARN  Guest is not running, hence not stopped
2024-10-06T22:40:15-0600 WARN  No linked tap inteface found for wifibox0
2024-10-07T10:52:06-0600 WARN  Guest is not running, hence not stopped
2024-10-07T10:52:06-0600 WARN  No linked tap inteface found for wifibox0
2024-10-07T11:01:51-0600 DEBUG Program started as /usr/local/sbin/wifibox, with arguments: stop
2024-10-07T11:01:51-0600 INFO  Begin: wifibox stop
2024-10-07T11:01:51-0600 DEBUG stop=GN
2024-10-07T11:01:51-0600 INFO  Tearing down Unix Domain Socket pass-through
2024-10-07T11:01:51-0600 INFO  Daemonized socat processes found: [365
370]
2024-10-07T11:01:51-0600 DEBUG [socat] 2024/10/07 11:01:51 socat[371] W exiting on signal 15
2024-10-07T11:01:51-0600 DEBUG [socat] 2024/10/07 11:01:51 socat[366] W exiting on signal 15
2024-10-07T11:01:51-0600 INFO  Stopping guest wifibox, managed by PID 267
2024-10-07T11:01:51-0600 INFO  Waiting 3 seconds for the guest to stop
2024-10-07T11:01:54-0600 INFO  Forcing shutdown of guest wifibox
2024-10-07T11:01:54-0600 INFO  Destroying guest wifibox
2024-10-07T11:01:56-0600 INFO  Destroying bhyve PPT device: pci0:20:3
2024-10-07T11:01:56-0600 DEBUG [devctl] devctl: Failed to clear pci0:20:3 driver: Device not configured
2024-10-07T11:01:56-0600 WARN  PPT device pci0:20:3 could not be destroyed
2024-10-07T11:01:56-0600 INFO  Removing null-modem devices
2024-10-07T11:01:56-0600 INFO  Null-modem devices are removed
2024-10-07T11:01:56-0600 INFO  Destroying bridge interface: wifibox0
2024-10-07T11:01:56-0600 INFO  Destroying linked tap interface: tap0
2024-10-07T11:01:56-0600 INFO  End: wifibox stop
2024-10-07T11:02:27-0600 DEBUG Program started as /usr/local/sbin/wifibox, with arguments: start
2024-10-07T11:02:27-0600 INFO  Begin: wifibox start
2024-10-07T11:02:27-0600 DEBUG start=GN
2024-10-07T11:02:27-0600 INFO  Creating bridge interface: wifibox0
2024-10-07T11:02:27-0600 DEBUG [ifconfig] wifibox0
2024-10-07T11:02:27-0600 INFO  Linking tap interface to wifibox0: tap0
2024-10-07T11:02:27-0600 DEBUG assert loaded: kmod=vmm, kmod_file=/boot/kernel/vmm.ko
2024-10-07T11:02:27-0600 DEBUG Kernel module vmm is not loaded
2024-10-07T11:02:27-0600 DEBUG Kernel module vmm was loaded successfully
2024-10-07T11:02:27-0600 DEBUG assert hardware support present: iommu=1, amdvi=0
2024-10-07T11:02:27-0600 DEBUG Backends reported by bhyve:
2024-10-07T11:02:27-0600 DEBUG [bhyve] dummy
2024-10-07T11:02:27-0600 DEBUG [bhyve] amd_hostbridge
2024-10-07T11:02:27-0600 DEBUG [bhyve] hostbridge
2024-10-07T11:02:27-0600 DEBUG [bhyve] nvme
2024-10-07T11:02:27-0600 DEBUG [bhyve] passthru
2024-10-07T11:02:27-0600 DEBUG [bhyve] virtio-9p
2024-10-07T11:02:27-0600 DEBUG [bhyve] virtio-blk
2024-10-07T11:02:27-0600 DEBUG [bhyve] virtio-console
2024-10-07T11:02:27-0600 DEBUG [bhyve] virtio-input
2024-10-07T11:02:27-0600 DEBUG [bhyve] virtio-net
2024-10-07T11:02:27-0600 DEBUG [bhyve] virtio-rnd
2024-10-07T11:02:27-0600 DEBUG [bhyve] virtio-scsi
2024-10-07T11:02:27-0600 DEBUG [bhyve] ahci
2024-10-07T11:02:27-0600 DEBUG [bhyve] ahci-hd
2024-10-07T11:02:27-0600 DEBUG [bhyve] ahci-cd
2024-10-07T11:02:27-0600 DEBUG [bhyve] e1000
2024-10-07T11:02:27-0600 DEBUG [bhyve] fbuf
2024-10-07T11:02:27-0600 DEBUG [bhyve] hda
2024-10-07T11:02:27-0600 DEBUG [bhyve] lpc
2024-10-07T11:02:27-0600 DEBUG [bhyve] uart
2024-10-07T11:02:27-0600 DEBUG [bhyve] xhci
2024-10-07T11:02:27-0600 INFO  Bringing up null-modem devices for console connection
2024-10-07T11:02:27-0600 DEBUG assert loaded: kmod=nmdm, kmod_file=nmdm
2024-10-07T11:02:27-0600 DEBUG Kernel module nmdm is not loaded
2024-10-07T11:02:27-0600 DEBUG Kernel module nmdm was loaded successfully
2024-10-07T11:02:27-0600 INFO  Null-modem devices are available
2024-10-07T11:02:27-0600 INFO  Waiting for bhyve to start up
2024-10-07T11:02:27-0600 DEBUG Program started as /usr/local/sbin/wifibox, with arguments: _manage_vm
2024-10-07T11:02:27-0600 DEBUG assert daemonized: parent=daemon
2024-10-07T11:02:27-0600 INFO  VM manager launched
2024-10-07T11:02:27-0600 INFO  Gathering necessary configuration files for launching the guest
2024-10-07T11:02:27-0600 INFO  Pulling bhyve options from configuration file
2024-10-07T11:02:27-0600 DEBUG cpus=1
2024-10-07T11:02:27-0600 DEBUG memory=256M
2024-10-07T11:02:28-0600 DEBUG passthru=[0/20/3]
2024-10-07T11:02:28-0600 DEBUG console=yes
2024-10-07T11:02:28-0600 DEBUG priority=50
2024-10-07T11:02:28-0600 DEBUG bhyve max cpus=8
2024-10-07T11:02:28-0600 INFO  Guest console is configured to use
2024-10-07T11:02:28-0600 INFO  Passthru devices configured: [0/20/3]
2024-10-07T11:02:28-0600 INFO  PPT driver is configured for pci0:20:3 device
2024-10-07T11:02:28-0600 INFO  tap interface is configured: tap0
2024-10-07T11:02:28-0600 INFO  Launching guest wifibox from /usr/local/share/wifibox with grub-bhyve
2024-10-07T11:02:28-0600 INFO  Application config is found at /usr/local/etc/wifibox/wpa_supplicant
2024-10-07T11:02:28-0600 INFO  Application config will be mounted writeable
2024-10-07T11:02:28-0600 DEBUG Devices: virtio-blk,/usr/local/share/wifibox/disk.img virtio-9p,config=/usr/local/etc/wifibox/appliance,ro virtio-9p,var=/var/run/wifibox/appliance virtio-9p,app_config=/usr/local/etc/wifibox/wpa_supplicant
2024-10-07T11:02:28-0600 DEBUG Arguments:  -S -M 256M -r host -c /dev/nmdm-wifibox.1A -d /usr/local/share/wifibox wifibox
2024-10-07T11:02:28-0600 INFO  Launching guest wifibox from /usr/local/share/wifibox with bhyve
2024-10-07T11:02:28-0600 DEBUG Nice priority: 0
2024-10-07T11:02:28-0600 DEBUG Arguments:  -c 1 -m 256M -AHP -u -S -l com1,/dev/nmdm-wifibox.1A -s 0,hostbridge -s 31,lpc -s 4:0,virtio-blk,/usr/local/share/wifibox/disk.img -s 4:1,virtio-9p,config=/usr/local/etc/wifibox/appliance,ro -s 4:2,virtio-9p,var=/var/run/wifibox/appliance -s 4:3,virtio-9p,app_config=/usr/local/etc/wifibox/wpa_supplicant -s 5:0,e1000,tap0  -s 6:0,passthru,0/20/3 wifibox
2024-10-07T11:02:28-0600 DEBUG [bhyve] wrmsr to register 0x140(0) on vcpu 0
2024-10-07T11:02:28-0600 INFO  Guest wifibox has started up
2024-10-07T11:02:28-0600 INFO  Guest is managed by PID 419
2024-10-07T11:02:28-0600 INFO  Bringing up Unix Domain Socket pass-through
2024-10-07T11:02:28-0600 INFO  Found guest IP address: 10.0.0.1
2024-10-07T11:02:28-0600 INFO  Configured sockets: [path=/var/run/wpa_supplicant/wlan0,user=root,group=0,mode=770,port=1200
path=/var/run/wpa_supplicant/p2p-dev-wlan0,user=root,group=0,mode=770,port=1201]
2024-10-07T11:02:28-0600 INFO  Hooking up 10.0.0.1:1200 as /var/run/wpa_supplicant/wlan0 (root:0@770)
2024-10-07T11:02:28-0600 INFO  Hooking up 10.0.0.1:1201 as /var/run/wpa_supplicant/p2p-dev-wlan0 (root:0@770)
2024-10-07T11:02:28-0600 INFO  End: wifibox start
2024-10-07T11:02:29-0600 DEBUG [bhyve] rdmsr to register 0x64d on vcpu 0
2024-10-07T11:02:29-0600 DEBUG [bhyve] rdmsr to register 0x64e on vcpu 0
2024-10-07T11:02:29-0600 DEBUG [bhyve] rdmsr to register 0x34 on vcpu 0

/var/run/wifibox/appliance/log/dmesg

[    0.000000] Linux version 6.6.22-1-lts (pgj@wifibox-dev) (gcc (Alpine 13.2.1_git20231014) 13.2.1 20231014, GNU ld (GNU Binutils) 2.41) #2-Alpine SMP Wed, 20 Mar 2024 09:03:11 +0000
[    0.000000] Command line: console=ttyS0 BOOT_IMAGE=(host)/usr/local/share/wifibox/vmlinuz modules=squashfs root=/dev/vda rootfstype=squashfs clocksource=hpet tsc=unstable
[    0.000000] BIOS-provided physical RAM map:
[    0.000000] BIOS-e820: [mem 0x0000000000000000-0x000000000009ffff] usable
[    0.000000] BIOS-e820: [mem 0x0000000000100000-0x000000000fffffff] usable
[    0.000000] NX (Execute Disable) protection: active
[    0.000000] APIC: Static calls initialized
[    0.000000] SMBIOS 2.6 present.
[    0.000000] DMI: FreeBSD BHYVE/BHYVE, BIOS 14.0 10/17/2021
[    0.000000] tsc: Detected 2300.000 MHz processor
[    0.000005] e820: update [mem 0x00000000-0x00000fff] usable ==> reserved
[    0.000007] e820: remove [mem 0x000a0000-0x000fffff] usable
[    0.000008] last_pfn = 0x10000 max_arch_pfn = 0x400000000
[    0.000059] MTRRs disabled by BIOS
[    0.000061] x86/PAT: Configuration [0-7]: WB  WC  UC- UC  WB  WP  UC- WT  
[    0.000086] Using GB pages for direct mapping
[    0.000141] ACPI: Early table checksum verification disabled
[    0.000143] ACPI: RSDP 0x00000000000F2490 000024 (v02 BHYVE )
[    0.000146] ACPI: XSDT 0x00000000000F2440 00004C (v01 BHYVE  BVXSDT   00000001 BASL 20220504)
[    0.000150] ACPI: FACP 0x00000000000F24C0 000114 (v05 BHYVE  BVFACP   00000001 BASL 20220504)
[    0.000154] ACPI: DSDT 0x00000000000F2750 000A5C (v02 BHYVE  BVDSDT   00000001 INTL 20221020)
[    0.000156] ACPI: FACS 0x00000000000F26C0 000040
[    0.000158] ACPI: FACS 0x00000000000F26C0 000040
[    0.000160] ACPI: APIC 0x00000000000F25E0 00005A (v01 BHYVE  BVAPIC   00000001 BASL 20220504)
[    0.000162] ACPI: HPET 0x00000000000F2640 000038 (v01 BHYVE  BVHPET   00000001 BASL 20220504)
[    0.000164] ACPI: MCFG 0x00000000000F2680 00003C (v01 BHYVE  BVMCFG   00000001 BASL 20220504)
[    0.000166] ACPI: SPCR 0x00000000000F2700 000050 (v01 BHYVE  BVSPCR   00000001 BASL 20220504)
[    0.000168] ACPI: Reserving FACP table memory at [mem 0xf24c0-0xf25d3]
[    0.000169] ACPI: Reserving DSDT table memory at [mem 0xf2750-0xf31ab]
[    0.000169] ACPI: Reserving FACS table memory at [mem 0xf26c0-0xf26ff]
[    0.000170] ACPI: Reserving FACS table memory at [mem 0xf26c0-0xf26ff]
[    0.000170] ACPI: Reserving APIC table memory at [mem 0xf25e0-0xf2639]
[    0.000171] ACPI: Reserving HPET table memory at [mem 0xf2640-0xf2677]
[    0.000171] ACPI: Reserving MCFG table memory at [mem 0xf2680-0xf26bb]
[    0.000172] ACPI: Reserving SPCR table memory at [mem 0xf2700-0xf274f]
[    0.000196] system APIC only can use physical flat
[    0.000199] APIC: Switched APIC routing to: physical flat
[    0.000216] Zone ranges:
[    0.000217]   DMA      [mem 0x0000000000001000-0x0000000000ffffff]
[    0.000218]   DMA32    [mem 0x0000000001000000-0x000000000fffffff]
[    0.000219]   Normal   empty
[    0.000220] Movable zone start for each node
[    0.000220] Early memory node ranges
[    0.000220]   node   0: [mem 0x0000000000001000-0x000000000009ffff]
[    0.000221]   node   0: [mem 0x0000000000100000-0x000000000fffffff]
[    0.000222] Initmem setup node 0 [mem 0x0000000000001000-0x000000000fffffff]
[    0.000225] On node 0, zone DMA: 1 pages in unavailable ranges
[    0.000255] On node 0, zone DMA: 96 pages in unavailable ranges
[    0.001180] ACPI: PM-Timer IO Port: 0x408
[    0.001182] system APIC only can use physical flat
[    0.001185] ACPI: LAPIC_NMI (acpi_id[0xff] high edge lint[0x1])
[    0.001231] IOAPIC[0]: apic_id 0, version 17, address 0xfec00000, GSI 0-31
[    0.001233] ACPI: INT_SRC_OVR (bus 0 bus_irq 0 global_irq 2 high edge)
[    0.001235] ACPI: INT_SRC_OVR (bus 0 bus_irq 9 global_irq 9 low level)
[    0.001238] ACPI: Using ACPI (MADT) for SMP configuration information
[    0.001239] ACPI: HPET id: 0x80860701 base: 0xfed00000
[    0.001240] smpboot: Allowing 1 CPUs, 0 hotplug CPUs
[    0.001243] [mem 0x10000000-0xffffffff] available for PCI devices
[    0.001245] clocksource: refined-jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1910969940391419 ns
[    0.003268] setup_percpu: NR_CPUS:64 nr_cpumask_bits:1 nr_cpu_ids:1 nr_node_ids:1
[    0.003553] percpu: Embedded 43 pages/cpu s139176 r8192 d28760 u2097152
[    0.003556] pcpu-alloc: s139176 r8192 d28760 u2097152 alloc=1*2097152
[    0.003558] pcpu-alloc: [0] 0 
[    0.003564] Kernel command line: console=ttyS0 BOOT_IMAGE=(host)/usr/local/share/wifibox/vmlinuz modules=squashfs root=/dev/vda rootfstype=squashfs clocksource=hpet tsc=unstable
[    0.003589] tsc: Marking TSC unstable due to boot parameter
[    0.003591] Unknown kernel command line parameters "BOOT_IMAGE=(host)/usr/local/share/wifibox/vmlinuz modules=squashfs", will be passed to user space.
[    0.003603] random: crng init done
[    0.003635] Dentry cache hash table entries: 32768 (order: 6, 262144 bytes, linear)
[    0.003652] Inode-cache hash table entries: 16384 (order: 5, 131072 bytes, linear)
[    0.003670] Built 1 zonelists, mobility grouping on.  Total pages: 64256
[    0.003672] mem auto-init: stack:all(zero), heap alloc:off, heap free:off
[    0.004326] Memory: 239752K/261756K available (8192K kernel code, 1342K rwdata, 1700K rodata, 944K init, 1544K bss, 21748K reserved, 0K cma-reserved)
[    0.004346] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=1, Nodes=1
[    0.004376] rcu: Hierarchical RCU implementation.
[    0.004376] rcu:     RCU restricting CPUs from NR_CPUS=64 to nr_cpu_ids=1.
[    0.004377] rcu: RCU calculated value of scheduler-enlistment delay is 100 jiffies.
[    0.004378] rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=1
[    0.004381] NR_IRQS: 4352, nr_irqs: 256, preallocated irqs: 16
[    0.004574] rcu: srcu_init: Setting srcu_struct sizes based on contention.
[    0.004763] Console: colour EGA 80x25
[    0.004794] printk: console [ttyS0] enabled
[    0.053796] ACPI: Core revision 20230628
[    0.054275] clocksource: hpet: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 113919999973 ns
[    0.055109] APIC: Switch to symmetric I/O mode setup
[    0.057234] ..TIMER: vector=0x30 apic1=0 pin1=2 apic2=-1 pin2=-1
[    0.062154] Calibrating delay loop (skipped), value calculated using timer frequency.. 4600.00 BogoMIPS (lpj=2300000)
[    0.063164] unchecked MSR access error: WRMSR to 0x140 (tried to write 0x0000000000000000) at rIP: 0xffffffff810339a6 (init_intel+0x196/0x280)
[    0.064153] Call Trace:
[    0.064362]  <TASK>
[    0.064541]  ? ex_handler_msr+0xc2/0x120
[    0.064900]  ? fixup_exception+0x165/0x240
[    0.065153]  ? exc_general_protection+0xd6/0x2a0
[    0.065534]  ? asm_exc_general_protection+0x22/0x30
[    0.066153]  ? init_intel+0x196/0x280
[    0.066464]  ? init_intel+0x7e/0x280
[    0.066758]  identify_cpu+0x265/0x5d0
[    0.067071]  arch_cpu_finalize_init+0xc/0xe0
[    0.067155]  start_kernel+0x3c5/0x490
[    0.067460]  x86_64_start_reservations+0x14/0x30
[    0.067839]  x86_64_start_kernel+0xa7/0xb0
[    0.068153]  secondary_startup_64_no_verify+0x165/0x16b
[    0.068587]  </TASK>
[    0.068821] Last level iTLB entries: 4KB 64, 2MB 8, 4MB 8
[    0.069153] Last level dTLB entries: 4KB 64, 2MB 0, 4MB 0, 1GB 4
[    0.069641] Spectre V1 : Mitigation: usercopy/swapgs barriers and __user pointer sanitization
[    0.070153] Spectre V2 : Kernel not compiled with retpoline; no mitigation available!
[    0.070154] Spectre V2 : Vulnerable
[    0.071436] Spectre V2 : Spectre v2 / SpectreRSB mitigation: Filling RSB on context switch
[    0.072152] RETBleed: WARNING: Spectre v2 mitigation leaves CPU vulnerable to RETBleed attacks, data leaks possible!
[    0.072997] RETBleed: Vulnerable
[    0.073153] Speculative Store Bypass: Vulnerable
[    0.073540] MDS: Mitigation: Clear CPU buffers
[    0.073904] TAA: Mitigation: Clear CPU buffers
[    0.074160] MMIO Stale Data: Vulnerable: Clear CPU buffers attempted, no microcode
[    0.074783] SRBDS: Unknown: Dependent on hypervisor status
[    0.075152] GDS: Unknown: Dependent on hypervisor status
[    0.075595] x86/fpu: Supporting XSAVE feature 0x001: 'x87 floating point registers'
[    0.076152] x86/fpu: Supporting XSAVE feature 0x002: 'SSE registers'
[    0.076667] x86/fpu: Supporting XSAVE feature 0x004: 'AVX registers'
[    0.077153] x86/fpu: xstate_offset[2]:  576, xstate_sizes[2]:  256
[    0.077666] x86/fpu: Enabled xstate features 0x7, context size is 832 bytes, using 'standard' format.
[    0.080407] Freeing SMP alternatives memory: 20K
[    0.080878] pid_max: default: 32768 minimum: 301
[    0.081182] Mount-cache hash table entries: 512 (order: 0, 4096 bytes, linear)
[    0.081840] Mountpoint-cache hash table entries: 512 (order: 0, 4096 bytes, linear)
[    0.178574] smpboot: CPU0: Intel(R) Core(TM) i7-10610U CPU @ 1.80GHz (family: 0x6, model: 0x8e, stepping: 0xc)
[    0.179152] Performance Events: unsupported p6 CPU model 142 no PMU driver, software events only.
[    0.179169] signal: max sigframe size: 1360
[    0.180172] rcu: Hierarchical SRCU implementation.
[    0.180562] rcu:     Max phase no-delay instances is 400.
[    0.181005] smp: Bringing up secondary CPUs ...
[    0.181158] smp: Brought up 1 node, 1 CPU
[    0.181485] smpboot: Max logical packages: 1
[    0.181832] smpboot: Total of 1 processors activated (4600.00 BogoMIPS)
[    0.182285] devtmpfs: initialized
[    0.182646] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns
[    0.183154] futex hash table entries: 256 (order: 2, 16384 bytes, linear)
[    0.184207] NET: Registered PF_NETLINK/PF_ROUTE protocol family
[    0.184741] thermal_sys: Registered thermal governor 'step_wise'
[    0.184742] thermal_sys: Registered thermal governor 'user_space'
[    0.185157] cpuidle: using governor menu
[    0.186196] ACPI FADT declares the system doesn't support PCIe ASPM, so disable it
[    0.186802] acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5
[    0.187190] PCI: Using configuration type 1 for base access
[    0.187716] HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages
[    0.188153] HugeTLB: 28 KiB vmemmap can be freed for a 2.00 MiB page
[    0.188702] ACPI: Added _OSI(Module Device)
[    0.189153] ACPI: Added _OSI(Processor Device)
[    0.189513] ACPI: Added _OSI(3.0 _SCP Extensions)
[    0.189896] ACPI: Added _OSI(Processor Aggregator Device)
[    0.190298] ACPI: 1 ACPI AML tables successfully acquired and loaded
[    0.191320] ACPI: _OSC evaluated successfully for all CPUs
[    0.191781] ACPI: Interpreter enabled
[    0.192083] ACPI: PM: (supports S0 S5)
[    0.192458] ACPI: Using IOAPIC for interrupt routing
[    0.192869] PCI: Using host bridge windows from ACPI; if necessary, use "pci=nocrs" and report a bug
[    0.193152] PCI: Using E820 reservations for host bridge windows
[    0.193665] ACPI: Enabled 1 GPEs in block 00 to 07
[    0.194786] ACPI: PCI Root Bridge [PC00] (domain 0000 [bus 00])
[    0.195155] acpi PNP0A03:00: _OSC: OS supports [ASPM ClockPM Segments MSI HPX-Type3]
[    0.196153] acpi PNP0A03:00: _OSC: not requesting OS control; OS requires [ExtendedConfig ASPM ClockPM MSI]
[    0.196962] PCI host bridge to bus 0000:00
[    0.197153] pci_bus 0000:00: root bus resource [io  0x0000-0x0cf7 window]
[    0.197698] pci_bus 0000:00: root bus resource [io  0x0d00-0x26bf window]
[    0.198152] pci_bus 0000:00: root bus resource [mem 0xc0000000-0xc01fffff window]
[    0.198751] pci_bus 0000:00: root bus resource [mem 0x800000000-0x81fffffff window]
[    0.199152] pci_bus 0000:00: root bus resource [bus 00]
[    0.199635] pci 0000:00:00.0: [1275:1275] type 00 class 0x060000
[    0.200622] pci 0000:00:04.0: [1af4:1001] type 00 class 0x010000
[    0.201236] pci 0000:00:04.0: reg 0x10: [io  0x2600-0x267f]
[    0.201726] pci 0000:00:04.0: reg 0x14: [mem 0xc0034000-0xc0035fff]
[    0.202643] pci 0000:00:04.1: [1af4:1009] type 00 class 0x010000
[    0.203233] pci 0000:00:04.1: reg 0x10: [io  0x2000-0x21ff]
[    0.203725] pci 0000:00:04.1: reg 0x14: [mem 0xc0036000-0xc0037fff]
[    0.204656] pci 0000:00:04.2: [1af4:1009] type 00 class 0x010000
[    0.205238] pci 0000:00:04.2: reg 0x10: [io  0x2200-0x23ff]
[    0.206177] pci 0000:00:04.2: reg 0x14: [mem 0xc0038000-0xc0039fff]
[    0.207176] pci 0000:00:04.3: [1af4:1009] type 00 class 0x010000
[    0.207738] pci 0000:00:04.3: reg 0x10: [io  0x2400-0x25ff]
[    0.208195] pci 0000:00:04.3: reg 0x14: [mem 0xc003a000-0xc003bfff]
[    0.209228] pci 0000:00:05.0: [8086:100f] type 00 class 0x020000
[    0.209787] pci 0000:00:05.0: reg 0x10: [mem 0xc0000000-0xc001ffff]
[    0.210194] pci 0000:00:05.0: reg 0x14: [mem 0xc0020000-0xc002ffff]
[    0.210738] pci 0000:00:05.0: reg 0x18: [io  0x2680-0x2687]
[    0.211521] pci 0000:00:06.0: [8086:02f0] type 00 class 0x028000
[    0.212308] pci 0000:00:06.0: reg 0x10: [mem 0xc0030000-0xc0033fff 64bit]
[    0.213800] pci 0000:00:06.0: PME# supported from D0 D3hot D3cold
[    0.214575] pci 0000:00:1f.0: [8086:7000] type 00 class 0x060100
[    0.215464] pci_bus 0000:00: on NUMA node 0
[    0.215510] ACPI: PCI: Interrupt link LNKA configured for IRQ 5
[    0.216027] ACPI: PCI: Interrupt link LNKB configured for IRQ 6
[    0.216193] ACPI: PCI: Interrupt link LNKC configured for IRQ 7
[    0.216706] ACPI: PCI: Interrupt link LNKD configured for IRQ 10
[    0.217191] ACPI: PCI: Interrupt link LNKE configured for IRQ 11
[    0.217706] ACPI: PCI: Interrupt link LNKF configured for IRQ 0
[    0.218152] ACPI: PCI: Interrupt link LNKF disabled
[    0.218580] ACPI: PCI: Interrupt link LNKG configured for IRQ 0
[    0.219152] ACPI: PCI: Interrupt link LNKG disabled
[    0.219580] ACPI: PCI: Interrupt link LNKH configured for IRQ 0
[    0.220152] ACPI: PCI: Interrupt link LNKH disabled
[    0.220617] pps_core: LinuxPPS API ver. 1 registered
[    0.221152] pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti <giometti@linux.it>
[    0.221881] PTP clock support registered
[    0.222263] PCI: Using ACPI for IRQ routing
[    0.222606] PCI: pci_cache_line_size set to 64 bytes
[    0.222713] vgaarb: loaded
[    0.222946] hpet0: at MMIO 0xfed00000, IRQs 2, 8, 0, 0, 0, 0, 0, 0
[    0.223152] hpet0: 8 comparators, 32-bit 16.777216 MHz counter
[    0.226174] clocksource: Switched to clocksource hpet
[    0.226617] pnp: PnP ACPI init
[    0.227001] system 00:02: [io  0x04d0-0x04d1] has been reserved
[    0.227479] system 00:02: [io  0x0400-0x0407] has been reserved
[    0.227961] system 00:02: [mem 0xe0000000-0xefffffff] has been reserved
[    0.228533] pnp: PnP ACPI: found 8 devices
[    0.233854] clocksource: acpi_pm: mask: 0xffffff max_cycles: 0xffffff, max_idle_ns: 2085701024 ns
[    0.234600] NET: Registered PF_INET protocol family
[    0.235010] IP idents hash table entries: 4096 (order: 3, 32768 bytes, linear)
[    0.235710] tcp_listen_portaddr_hash hash table entries: 256 (order: 0, 4096 bytes, linear)
[    0.236380] Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear)
[    0.237001] TCP established hash table entries: 2048 (order: 2, 16384 bytes, linear)
[    0.237643] TCP bind hash table entries: 2048 (order: 4, 65536 bytes, linear)
[    0.238227] TCP: Hash tables configured (established 2048 bind 2048)
[    0.238760] UDP hash table entries: 256 (order: 1, 8192 bytes, linear)
[    0.239287] UDP-Lite hash table entries: 256 (order: 1, 8192 bytes, linear)
[    0.239865] NET: Registered PF_UNIX/PF_LOCAL protocol family
[    0.240516] pci_bus 0000:00: resource 4 [io  0x0000-0x0cf7 window]
[    0.241017] pci_bus 0000:00: resource 5 [io  0x0d00-0x26bf window]
[    0.241514] pci_bus 0000:00: resource 6 [mem 0xc0000000-0xc01fffff window]
[    0.242065] pci_bus 0000:00: resource 7 [mem 0x800000000-0x81fffffff window]
[    0.242712] PCI: CLS 0 bytes, default 64
[    0.243079] RAPL PMU: API unit is 2^-32 Joules, 0 fixed counters, 163840 ms ovfl timer
[    0.243874] Initialise system trusted keyrings
[    0.244491] workingset: timestamp_bits=62 max_order=16 bucket_order=0
[    0.245025] squashfs: version 4.0 (2009/01/31) Phillip Lougher
[    0.245497] 9p: Installing v9fs 9p2000 file system support
[    0.250668] Key type asymmetric registered
[    0.250995] Asymmetric key parser 'x509' registered
[    0.251444] input: Power Button as /devices/LNXSYSTM:00/LNXPWRBN:00/input/input0
[    0.252046] ACPI: button: Power Button [PWRF]
[    0.252481] virtio-pci 0000:00:04.0: virtio_pci: leaving for legacy driver
[    0.253125] virtio-pci 0000:00:04.1: virtio_pci: leaving for legacy driver
[    0.253776] virtio-pci 0000:00:04.2: virtio_pci: leaving for legacy driver
[    0.254404] virtio-pci 0000:00:04.3: virtio_pci: leaving for legacy driver
[    0.255295] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled
[    0.255926] 00:03: ttyS0 at I/O 0x3f8 (irq = 4, base_baud = 115200) is a 16550A
[    0.256736] 00:04: ttyS1 at I/O 0x2f8 (irq = 3, base_baud = 115200) is a 16550A
[    0.257533] 00:05: ttyS2 at I/O 0x3e8 (irq = 4, base_baud = 115200) is a 16550A
[    0.258304] 00:06: ttyS3 at I/O 0x2e8 (irq = 3, base_baud = 115200) is a 16550A
[    0.259244] Non-volatile memory driver v1.3
[    0.260195] loop: module loaded
[    0.260502] virtio_blk virtio0: 1/0/0 default/read/poll queues
[    0.261352] virtio_blk virtio0: [vda] 143920 512-byte logical blocks (73.7 MB/70.3 MiB)
[    0.264954] e1000: Intel(R) PRO/1000 Network Driver
[    0.265362] e1000: Copyright (c) 1999-2006 Intel Corporation.
[    0.596527] e1000 0000:00:05.0 eth0: (PCI:33MHz:32-bit) 00:a0:98:8a:05:71
[    0.597077] e1000 0000:00:05.0 eth0: Intel(R) PRO/1000 Network Connection
[    0.597670] i8042: PNP: PS/2 Controller [PNP0303:KBD,PNP0f13:MOU] at 0x60,0x64 irq 1,12
[    0.598406] i8042: Warning: Keylock active
[    0.599269] serio: i8042 KBD port at 0x60,0x64 irq 1
[    0.599689] serio: i8042 AUX port at 0x60,0x64 irq 12
[    0.600673] rtc_cmos 00:07: registered as rtc0
[    0.601072] rtc_cmos 00:07: alarms up to one day, y3k, 114 bytes nvram
[    0.601633] intel_pstate: CPU model not supported
[    0.602091] Initializing XFRM netlink socket
[    0.602447] NET: Registered PF_PACKET protocol family
[    0.602872] 9pnet: Installing 9P2000 support
[    0.604106] IPI shorthand broadcast: enabled
[    0.607644] registered taskstats version 1
[    0.607985] Loading compiled-in X.509 certificates
[    0.608885] cfg80211: Loading compiled-in X.509 certificates for regulatory database
[    0.609963] Loaded X.509 cert 'sforshee: 00b28ddf47aef9cea7'
[    0.610532] Loaded X.509 cert 'wens: 61c038651aabdcf94bd0ac7ff06c7248db18c600'
[    0.611150] platform regulatory.0: Direct firmware load for regulatory.db failed with error -2
[    0.611852] cfg80211: failed to load regulatory.db
[    0.615705] VFS: Mounted root (squashfs filesystem) readonly on device 254:0.
[    0.616342] devtmpfs: mounted
[    0.616676] Freeing unused kernel image (initmem) memory: 944K
[    0.617687] Write protecting the kernel read-only data: 10240k
[    0.618034] Freeing unused kernel image (rodata/data gap) memory: 348K
[    0.618338] Run /sbin/init as init process
[    0.618529]   with arguments:
[    0.618529]     /sbin/init
[    0.618529]   with environment:
[    0.618530]     HOME=/
[    0.618530]     TERM=linux
[    0.618530]     BOOT_IMAGE=(host)/usr/local/share/wifibox/vmlinuz
[    0.618531]     modules=squashfs
[    0.821956] Intel(R) Wireless WiFi driver for Linux
[    0.822970] iwlwifi 0000:00:06.0: Detected crf-id 0x3617, cnv-id 0x20000302 wfpm id 0x80000000
[    0.822990] iwlwifi 0000:00:06.0: PCI dev 02f0/0070, rev=0x351, rfid=0x10a100
[    0.886125] iwlwifi 0000:00:06.0: api flags index 2 larger than supported by driver
[    0.886135] iwlwifi 0000:00:06.0: TLV_FW_FSEQ_VERSION: FSEQ Version: 89.3.35.37
[    0.886426] iwlwifi 0000:00:06.0: loaded firmware version 77.ad46c98b.0 QuZ-a0-hr-b0-77.ucode op_mode iwlmvm
[    0.921699] iwlwifi 0000:00:06.0: Detected Intel(R) Wi-Fi 6 AX201 160MHz, REV=0x351
[    0.921732] thermal thermal_zone0: failed to read out thermal zone (-61)
[    0.931086] NET: Registered PF_INET6 protocol family
[    1.044219] iwlwifi 0000:00:06.0: Detected RF HR B3, rfid=0x10a100
[    1.110342] iwlwifi 0000:00:06.0: base HW address: a4:42:3b:0a:82:5a
[    1.134223] Segment Routing with IPv6
[    1.134239] In-situ OAM (IOAM) with IPv6

/var/run/wifibox/appliance/log/messages

Oct  7 17:02:29 wifibox syslog.info syslogd started: BusyBox v1.36.1
Oct  7 17:02:29 wifibox daemon.info supervise-daemon[983]: Supervisor command line: supervise-daemon wpa_supplicant --start --respawn-delay 2 --respawn-max 5 --respawn-period 1800 /sbin/wpa_supplicant -- -iwlan0 -c/etc/wpa_supplicant/wpa_supplicant.conf 
Oct  7 17:02:29 wifibox daemon.info supervise-daemon[986]: Child command line: /sbin/wpa_supplicant -iwlan0 -c/etc/wpa_supplicant/wpa_supplicant.conf 
Oct  7 17:02:29 wifibox daemon.info dhcpcd[1084]: dhcpcd-10.0.6 starting
Oct  7 17:02:29 wifibox daemon.info dhcpcd[1087]: wlan0: waiting for carrier
Oct  7 17:02:32 wifibox daemon.info dhcpcd[1087]: wlan0: carrier acquired
Oct  7 17:02:32 wifibox daemon.info dhcpcd[1087]: wlan0: connected to Access Point: Hatch Who?
Oct  7 17:02:32 wifibox daemon.info dhcpcd[1087]: DUID 00:01:00:01:2e:96:d0:a8:a4:42:3b:0a:82:5a
Oct  7 17:02:32 wifibox daemon.info dhcpcd[1087]: wlan0: IAID 3b:0a:82:5a
Oct  7 17:02:32 wifibox daemon.info dhcpcd[1087]: wlan0: adding address fe80::a642:3bff:fe0a:825a
Oct  7 17:02:33 wifibox daemon.info dhcpcd[1087]: wlan0: soliciting an IPv6 router
Oct  7 17:02:33 wifibox daemon.info dhcpcd[1087]: wlan0: soliciting a DHCP lease
Oct  7 17:02:34 wifibox daemon.info dhcpcd[1087]: wlan0: Router Advertisement from fe80::e2db:d1ff:fe42:f6d6
Oct  7 17:02:34 wifibox daemon.info dhcpcd[1087]: wlan0: adding address 2601:282:2001:fb0:a642:3bff:fe0a:825a/64
Oct  7 17:02:34 wifibox daemon.info dhcpcd[1087]: wlan0: adding route to 2601:282:2001:fb0::/64
Oct  7 17:02:34 wifibox daemon.info dhcpcd[1087]: wlan0: adding default route via fe80::e2db:d1ff:fe42:f6d6
Oct  7 17:02:34 wifibox daemon.info dhcpcd[1087]: wlan0: soliciting a DHCPv6 lease
Oct  7 17:02:35 wifibox daemon.info dhcpcd[1087]: wlan0: ADV 2601:282:2001:fb0::aa69/128 from fe80::e2db:d1ff:fe42:f6d6
Oct  7 17:02:35 wifibox daemon.info dhcpcd[1087]: wlan0: REPLY6 received from fe80::e2db:d1ff:fe42:f6d6
Oct  7 17:02:35 wifibox daemon.info dhcpcd[1087]: wlan0: adding address 2601:282:2001:fb0::aa69/128
Oct  7 17:02:35 wifibox daemon.info dhcpcd[1087]: wlan0: renew in 172800, rebind in 276480, expire in 345600 seconds
Oct  7 17:02:36 wifibox daemon.info radvd[1215]: version 2.19 started
Oct  7 17:02:36 wifibox daemon.err radvd[1215]: exiting, failed to read config file
Oct  7 17:02:36 wifibox daemon.err /etc/init.d/radvd[1214]: start-stop-daemon: failed to start `/usr/sbin/radvd'
Oct  7 17:02:36 wifibox daemon.err /etc/init.d/radvd[1196]: ERROR: radvd failed to start
Oct  7 17:02:36 wifibox daemon.info supervise-daemon[1234]: Supervisor command line: supervise-daemon uds_passthru --start --respawn-delay 2 --respawn-max 5 --respawn-period 1800 /sbin/uds_passthru -- 
Oct  7 17:02:36 wifibox daemon.info supervise-daemon[1236]: Child command line: /sbin/uds_passthru 
Oct  7 17:02:36 wifibox daemon.debug uds_passthru[1236]: Configuration: network=10.0.0.1:255.255.255.0, sockets=[path=/var/run/wpa_supplicant/wlan0,user=root,group=0,mode=770,port=1200 path=/var/run/wpa_supplicant/p2p-dev-wlan0,user=root,group=0,mode=770,port=1201]
Oct  7 17:02:36 wifibox daemon.info : starting pid 1242, tty '': '/sbin/openrc default'
Oct  7 17:02:36 wifibox daemon.warn uds_passthru[1236]: /var/run/wpa_supplicant/wlan0 is not available, skipping.
Oct  7 17:02:36 wifibox daemon.warn uds_passthru[1236]: /var/run/wpa_supplicant/p2p-dev-wlan0 is not available, skipping.
Oct  7 17:02:36 wifibox daemon.info uds_passthru[1236]: Waiting for PID 1246 to stop.
Oct  7 17:02:36 wifibox daemon.info radvd[1269]: version 2.19 started
Oct  7 17:02:36 wifibox daemon.err radvd[1269]: exiting, failed to read config file
Oct  7 17:02:36 wifibox daemon.err /etc/init.d/radvd[1268]: start-stop-daemon: failed to start `/usr/sbin/radvd'
Oct  7 17:02:36 wifibox daemon.err /etc/init.d/radvd[1250]: ERROR: radvd failed to start
Oct  7 17:02:36 wifibox cron.info crond[1314]: crond (busybox 1.36.1) started, log level 8
Oct  7 17:02:36 wifibox daemon.info udhcpd[1368]: started, v1.36.1
Oct  7 17:02:36 wifibox daemon.err udhcpd[1368]: can't open '/var/lib/misc/udhcpd.leases': No such file or directory
Oct  7 17:02:36 wifibox daemon.info : starting pid 1375, tty '/dev/ttyS0': '/sbin/getty -L ttyS0 115200 vt100'
Oct  7 17:02:36 wifibox user.debug : Will stop /usr/sbin/udhcpd
Oct  7 17:02:36 wifibox user.debug : Will stop PID 1368
Oct  7 17:02:36 wifibox user.debug : Sending signal 15 to PID 1368
Oct  7 17:02:36 wifibox daemon.info udhcpd[1368]: received SIGTERM
Oct  7 17:02:36 wifibox daemon.info udhcpd[1447]: started, v1.36.1
Oct  7 17:02:37 wifibox user.debug : Will stop /usr/sbin/udhcpd
Oct  7 17:02:37 wifibox user.debug : Will stop PID 1447
Oct  7 17:02:37 wifibox user.debug : Sending signal 15 to PID 1447
Oct  7 17:02:37 wifibox daemon.info udhcpd[1447]: received SIGTERM
Oct  7 17:02:37 wifibox daemon.info udhcpd[1526]: started, v1.36.1
Oct  7 17:02:37 wifibox daemon.info dhcpcd[1087]: wlan0: offered 10.0.0.63 from 10.0.0.1
Oct  7 17:02:37 wifibox daemon.warn dhcpcd[1087]: wlan0: ignoring offer of 10.0.0.63 from 10.0.0.1
Oct  7 17:02:37 wifibox daemon.info dhcpcd[1087]: wlan0: probing address 10.0.0.63/24
Oct  7 17:02:39 wifibox user.debug : Will stop /usr/sbin/udhcpd
Oct  7 17:02:39 wifibox user.debug : Will stop PID 1526
Oct  7 17:02:39 wifibox user.debug : Sending signal 15 to PID 1526
Oct  7 17:02:39 wifibox daemon.info udhcpd[1526]: received SIGTERM
Oct  7 17:02:39 wifibox daemon.info udhcpd[1606]: started, v1.36.1
Oct  7 17:02:41 wifibox daemon.info udhcpd[1606]: sending OFFER to 10.0.0.2
Oct  7 17:02:42 wifibox user.debug : Will stop /usr/sbin/udhcpd
Oct  7 17:02:42 wifibox user.debug : Will stop PID 1606
Oct  7 17:02:42 wifibox user.debug : Sending signal 15 to PID 1606
Oct  7 17:02:42 wifibox daemon.info udhcpd[1606]: received SIGTERM
Oct  7 17:02:42 wifibox daemon.info udhcpd[1685]: started, v1.36.1
Oct  7 17:02:43 wifibox daemon.info dhcpcd[1087]: wlan0: leased 10.0.0.63 for 172800 seconds
Oct  7 17:02:43 wifibox daemon.info dhcpcd[1087]: wlan0: adding route to 10.0.0.0/24
Oct  7 17:02:43 wifibox daemon.info dhcpcd[1087]: wlan0: adding default route via 10.0.0.1
Oct  7 17:02:43 wifibox daemon.info udhcpd[1685]: sending ACK to 10.0.0.2
Oct  7 17:02:43 wifibox user.debug : Will stop /usr/sbin/udhcpd
Oct  7 17:02:43 wifibox user.debug : Will stop PID 1685
Oct  7 17:02:43 wifibox user.debug : Sending signal 15 to PID 1685
Oct  7 17:02:43 wifibox daemon.info udhcpd[1685]: received SIGTERM
Oct  7 17:02:43 wifibox daemon.info udhcpd[1762]: started, v1.36.1
Oct  7 17:02:45 wifibox user.debug : Will stop /usr/sbin/udhcpd
Oct  7 17:02:45 wifibox user.debug : Will stop PID 1762
Oct  7 17:02:45 wifibox user.debug : Sending signal 15 to PID 1762
Oct  7 17:02:45 wifibox daemon.info udhcpd[1762]: received SIGTERM
Oct  7 17:02:45 wifibox daemon.info udhcpd[1842]: started, v1.36.1
Oct  7 17:02:48 wifibox user.debug : Will stop /usr/sbin/udhcpd
Oct  7 17:02:48 wifibox user.debug : Will stop PID 1842
Oct  7 17:02:48 wifibox user.debug : Sending signal 15 to PID 1842
Oct  7 17:02:48 wifibox daemon.info udhcpd[1842]: received SIGTERM
Oct  7 17:02:48 wifibox daemon.info udhcpd[1921]: started, v1.36.1
Oct  7 17:02:51 wifibox user.debug : Will stop /usr/sbin/udhcpd
Oct  7 17:02:51 wifibox user.debug : Will stop PID 1921
Oct  7 17:02:51 wifibox user.debug : Sending signal 15 to PID 1921
Oct  7 17:02:51 wifibox daemon.info udhcpd[1921]: received SIGTERM
Oct  7 17:02:51 wifibox daemon.info udhcpd[2000]: started, v1.36.1
Oct  7 17:02:54 wifibox user.debug : Will stop /usr/sbin/udhcpd
Oct  7 17:02:54 wifibox user.debug : Will stop PID 2000
Oct  7 17:02:54 wifibox user.debug : Sending signal 15 to PID 2000
Oct  7 17:02:54 wifibox daemon.info udhcpd[2000]: received SIGTERM
Oct  7 17:02:54 wifibox daemon.info udhcpd[2079]: started, v1.36.1
Oct  7 17:02:57 wifibox user.debug : Will stop /usr/sbin/udhcpd
Oct  7 17:02:57 wifibox user.debug : Will stop PID 2079
Oct  7 17:02:57 wifibox user.debug : Sending signal 15 to PID 2079
Oct  7 17:02:57 wifibox daemon.info udhcpd[2079]: received SIGTERM
Oct  7 17:02:57 wifibox daemon.info udhcpd[2158]: started, v1.36.1
Oct  7 17:03:00 wifibox user.debug : Will stop /usr/sbin/udhcpd
Oct  7 17:03:00 wifibox user.debug : Will stop PID 2158
Oct  7 17:03:00 wifibox user.debug : Sending signal 15 to PID 2158
Oct  7 17:03:00 wifibox daemon.info udhcpd[2158]: received SIGTERM
Oct  7 17:03:00 wifibox daemon.info udhcpd[2237]: started, v1.36.1
Oct  7 17:03:03 wifibox user.debug : Will stop /usr/sbin/udhcpd
Oct  7 17:03:03 wifibox user.debug : Will stop PID 2237
Oct  7 17:03:03 wifibox user.debug : Sending signal 15 to PID 2237
Oct  7 17:03:03 wifibox daemon.info udhcpd[2237]: received SIGTERM
Oct  7 17:03:03 wifibox daemon.info udhcpd[2315]: started, v1.36.1
Oct  7 17:03:06 wifibox user.debug : Will stop /usr/sbin/udhcpd
Oct  7 17:03:06 wifibox user.debug : Will stop PID 2315
Oct  7 17:03:06 wifibox user.debug : Sending signal 15 to PID 2315
Oct  7 17:03:06 wifibox daemon.info udhcpd[2315]: received SIGTERM
Oct  7 17:03:06 wifibox daemon.info udhcpd[2394]: started, v1.36.1
Oct  7 17:03:09 wifibox user.debug : Will stop /usr/sbin/udhcpd
Oct  7 17:03:09 wifibox user.debug : Will stop PID 2394
Oct  7 17:03:09 wifibox user.debug : Sending signal 15 to PID 2394
Oct  7 17:03:09 wifibox daemon.info udhcpd[2394]: received SIGTERM
Oct  7 17:03:09 wifibox daemon.info udhcpd[2472]: started, v1.36.1
Oct  7 17:03:12 wifibox user.debug : Will stop /usr/sbin/udhcpd
Oct  7 17:03:12 wifibox user.debug : Will stop PID 2472
Oct  7 17:03:12 wifibox user.debug : Sending signal 15 to PID 2472
Oct  7 17:03:12 wifibox daemon.info udhcpd[2472]: received SIGTERM
Oct  7 17:03:12 wifibox daemon.info udhcpd[2550]: started, v1.36.1
Oct  7 17:03:15 wifibox user.debug : Will stop /usr/sbin/udhcpd
Oct  7 17:03:15 wifibox user.debug : Will stop PID 2550
Oct  7 17:03:15 wifibox user.debug : Sending signal 15 to PID 2550
Oct  7 17:03:15 wifibox daemon.info udhcpd[2550]: received SIGTERM
Oct  7 17:03:15 wifibox daemon.info udhcpd[2628]: started, v1.36.1
Oct  7 17:03:18 wifibox user.debug : Will stop /usr/sbin/udhcpd
Oct  7 17:03:18 wifibox user.debug : Will stop PID 2628
Oct  7 17:03:18 wifibox user.debug : Sending signal 15 to PID 2628
Oct  7 17:03:18 wifibox daemon.info udhcpd[2628]: received SIGTERM
Oct  7 17:03:18 wifibox daemon.info udhcpd[2706]: started, v1.36.1
Oct  7 17:03:21 wifibox user.debug : Will stop /usr/sbin/udhcpd
Oct  7 17:03:21 wifibox user.debug : Will stop PID 2706
Oct  7 17:03:21 wifibox user.debug : Sending signal 15 to PID 2706
Oct  7 17:03:21 wifibox daemon.info udhcpd[2706]: received SIGTERM
Oct  7 17:03:21 wifibox daemon.info udhcpd[2784]: started, v1.36.1
Oct  7 17:03:24 wifibox user.debug : Will stop /usr/sbin/udhcpd
Oct  7 17:03:24 wifibox user.debug : Will stop PID 2784
Oct  7 17:03:24 wifibox user.debug : Sending signal 15 to PID 2784
Oct  7 17:03:24 wifibox daemon.info udhcpd[2784]: received SIGTERM
Oct  7 17:03:24 wifibox daemon.info udhcpd[2862]: started, v1.36.1
Oct  7 17:03:27 wifibox user.debug : Will stop /usr/sbin/udhcpd
Oct  7 17:03:27 wifibox user.debug : Will stop PID 2862
Oct  7 17:03:27 wifibox user.debug : Sending signal 15 to PID 2862
Oct  7 17:03:27 wifibox daemon.info udhcpd[2862]: received SIGTERM
Oct  7 17:03:27 wifibox daemon.info udhcpd[2940]: started, v1.36.1
Oct  7 17:03:30 wifibox user.debug : Will stop /usr/sbin/udhcpd
Oct  7 17:03:30 wifibox user.debug : Will stop PID 2940
Oct  7 17:03:30 wifibox user.debug : Sending signal 15 to PID 2940
Oct  7 17:03:30 wifibox daemon.info udhcpd[2940]: received SIGTERM
Oct  7 17:03:30 wifibox daemon.info udhcpd[3018]: started, v1.36.1
Oct  7 17:03:33 wifibox user.debug : Will stop /usr/sbin/udhcpd
Oct  7 17:03:33 wifibox user.debug : Will stop PID 3018
Oct  7 17:03:33 wifibox user.debug : Sending signal 15 to PID 3018
Oct  7 17:03:33 wifibox daemon.info udhcpd[3018]: received SIGTERM
Oct  7 17:03:33 wifibox daemon.info udhcpd[3096]: started, v1.36.1
Oct  7 17:03:36 wifibox user.debug : Will stop /usr/sbin/udhcpd
Oct  7 17:03:36 wifibox user.debug : Will stop PID 3096
Oct  7 17:03:36 wifibox user.debug : Sending signal 15 to PID 3096
Oct  7 17:03:36 wifibox daemon.info udhcpd[3096]: received SIGTERM
Oct  7 17:03:36 wifibox daemon.info udhcpd[3174]: started, v1.36.1
Oct  7 17:03:39 wifibox user.debug : Will stop /usr/sbin/udhcpd
Oct  7 17:03:39 wifibox user.debug : Will stop PID 3174
Oct  7 17:03:39 wifibox user.debug : Sending signal 15 to PID 3174
Oct  7 17:03:39 wifibox daemon.info udhcpd[3174]: received SIGTERM
Oct  7 17:03:39 wifibox daemon.info udhcpd[3252]: started, v1.36.1
Oct  7 17:03:42 wifibox user.debug : Will stop /usr/sbin/udhcpd
Oct  7 17:03:42 wifibox user.debug : Will stop PID 3252
Oct  7 17:03:42 wifibox user.debug : Sending signal 15 to PID 3252
Oct  7 17:03:42 wifibox daemon.info udhcpd[3252]: received SIGTERM
Oct  7 17:03:42 wifibox daemon.info udhcpd[3330]: started, v1.36.1
Oct  7 17:03:45 wifibox user.debug : Will stop /usr/sbin/udhcpd
Oct  7 17:03:45 wifibox user.debug : Will stop PID 3330
Oct  7 17:03:45 wifibox user.debug : Sending signal 15 to PID 3330
Oct  7 17:03:45 wifibox daemon.info udhcpd[3330]: received SIGTERM
Oct  7 17:03:45 wifibox daemon.info udhcpd[3408]: started, v1.36.1
Oct  7 17:03:48 wifibox user.debug : Will stop /usr/sbin/udhcpd
Oct  7 17:03:48 wifibox user.debug : Will stop PID 3408
Oct  7 17:03:48 wifibox user.debug : Sending signal 15 to PID 3408
Oct  7 17:03:48 wifibox daemon.info udhcpd[3408]: received SIGTERM
Oct  7 17:03:48 wifibox daemon.info udhcpd[3486]: started, v1.36.1
Oct  7 17:03:51 wifibox user.debug : Will stop /usr/sbin/udhcpd
Oct  7 17:03:51 wifibox user.debug : Will stop PID 3486
Oct  7 17:03:51 wifibox user.debug : Sending signal 15 to PID 3486
Oct  7 17:03:51 wifibox daemon.info udhcpd[3486]: received SIGTERM
Oct  7 17:03:51 wifibox daemon.info udhcpd[3564]: started, v1.36.1
Oct  7 17:03:54 wifibox user.debug : Will stop /usr/sbin/udhcpd
Oct  7 17:03:54 wifibox user.debug : Will stop PID 3564
Oct  7 17:03:54 wifibox user.debug : Sending signal 15 to PID 3564
Oct  7 17:03:54 wifibox daemon.info udhcpd[3564]: received SIGTERM
Oct  7 17:03:54 wifibox daemon.info udhcpd[3642]: started, v1.36.1
Oct  7 17:03:57 wifibox user.debug : Will stop /usr/sbin/udhcpd
Oct  7 17:03:57 wifibox user.debug : Will stop PID 3642
Oct  7 17:03:57 wifibox user.debug : Sending signal 15 to PID 3642
Oct  7 17:03:57 wifibox daemon.info udhcpd[3642]: received SIGTERM
Oct  7 17:03:57 wifibox daemon.info udhcpd[3720]: started, v1.36.1
Oct  7 17:04:00 wifibox user.debug : Will stop /usr/sbin/udhcpd
Oct  7 17:04:00 wifibox user.debug : Will stop PID 3720
Oct  7 17:04:00 wifibox user.debug : Sending signal 15 to PID 3720
Oct  7 17:04:00 wifibox daemon.info udhcpd[3720]: received SIGTERM
Oct  7 17:04:00 wifibox daemon.info udhcpd[3798]: started, v1.36.1
Oct  7 17:04:03 wifibox user.debug : Will stop /usr/sbin/udhcpd
Oct  7 17:04:03 wifibox user.debug : Will stop PID 3798
Oct  7 17:04:03 wifibox user.debug : Sending signal 15 to PID 3798
Oct  7 17:04:03 wifibox daemon.info udhcpd[3798]: received SIGTERM
Oct  7 17:04:03 wifibox daemon.info udhcpd[3876]: started, v1.36.1
Oct  7 17:04:06 wifibox user.debug : Will stop /usr/sbin/udhcpd
Oct  7 17:04:06 wifibox user.debug : Will stop PID 3876
Oct  7 17:04:06 wifibox user.debug : Sending signal 15 to PID 3876
Oct  7 17:04:06 wifibox daemon.info udhcpd[3876]: received SIGTERM
Oct  7 17:04:06 wifibox daemon.info udhcpd[3954]: started, v1.36.1
Oct  7 17:04:09 wifibox user.debug : Will stop /usr/sbin/udhcpd
Oct  7 17:04:09 wifibox user.debug : Will stop PID 3954
Oct  7 17:04:09 wifibox user.debug : Sending signal 15 to PID 3954
Oct  7 17:04:09 wifibox daemon.info udhcpd[3954]: received SIGTERM
Oct  7 17:04:09 wifibox daemon.info udhcpd[4032]: started, v1.36.1
Oct  7 17:04:12 wifibox user.debug : Will stop /usr/sbin/udhcpd
Oct  7 17:04:12 wifibox user.debug : Will stop PID 4032
Oct  7 17:04:12 wifibox user.debug : Sending signal 15 to PID 4032
Oct  7 17:04:12 wifibox daemon.info udhcpd[4032]: received SIGTERM
Oct  7 17:04:12 wifibox daemon.info udhcpd[4110]: started, v1.36.1
Oct  7 17:04:15 wifibox user.debug : Will stop /usr/sbin/udhcpd
Oct  7 17:04:15 wifibox user.debug : Will stop PID 4110
Oct  7 17:04:15 wifibox user.debug : Sending signal 15 to PID 4110
Oct  7 17:04:15 wifibox daemon.info udhcpd[4110]: received SIGTERM
Oct  7 17:04:15 wifibox daemon.info udhcpd[4188]: started, v1.36.1
Oct  7 17:04:18 wifibox user.debug : Will stop /usr/sbin/udhcpd
Oct  7 17:04:18 wifibox user.debug : Will stop PID 4188
Oct  7 17:04:18 wifibox user.debug : Sending signal 15 to PID 4188
Oct  7 17:04:18 wifibox daemon.info udhcpd[4188]: received SIGTERM
Oct  7 17:04:18 wifibox daemon.info udhcpd[4266]: started, v1.36.1
Oct  7 17:04:21 wifibox user.debug : Will stop /usr/sbin/udhcpd
Oct  7 17:04:21 wifibox user.debug : Will stop PID 4266
Oct  7 17:04:21 wifibox user.debug : Sending signal 15 to PID 4266
Oct  7 17:04:21 wifibox daemon.info udhcpd[4266]: received SIGTERM
Oct  7 17:04:21 wifibox daemon.info udhcpd[4344]: started, v1.36.1
Oct  7 17:04:24 wifibox user.debug : Will stop /usr/sbin/udhcpd
Oct  7 17:04:24 wifibox user.debug : Will stop PID 4344
Oct  7 17:04:24 wifibox user.debug : Sending signal 15 to PID 4344
Oct  7 17:04:24 wifibox daemon.info udhcpd[4344]: received SIGTERM
Oct  7 17:04:24 wifibox daemon.info udhcpd[4422]: started, v1.36.1
Oct  7 17:04:27 wifibox user.debug : Will stop /usr/sbin/udhcpd
Oct  7 17:04:27 wifibox user.debug : Will stop PID 4422
Oct  7 17:04:27 wifibox user.debug : Sending signal 15 to PID 4422
Oct  7 17:04:27 wifibox daemon.info udhcpd[4422]: received SIGTERM
Oct  7 17:04:27 wifibox daemon.info udhcpd[4500]: started, v1.36.1
Oct  7 17:04:30 wifibox user.debug : Will stop /usr/sbin/udhcpd
Oct  7 17:04:30 wifibox user.debug : Will stop PID 4500
Oct  7 17:04:30 wifibox user.debug : Sending signal 15 to PID 4500
Oct  7 17:04:30 wifibox daemon.info udhcpd[4500]: received SIGTERM
Oct  7 17:04:30 wifibox daemon.info udhcpd[4578]: started, v1.36.1
Oct  7 17:04:33 wifibox user.debug : Will stop /usr/sbin/udhcpd
Oct  7 17:04:33 wifibox user.debug : Will stop PID 4578
Oct  7 17:04:33 wifibox user.debug : Sending signal 15 to PID 4578
Oct  7 17:04:33 wifibox daemon.info udhcpd[4578]: received SIGTERM
Oct  7 17:04:33 wifibox daemon.info udhcpd[4656]: started, v1.36.1
Oct  7 17:04:36 wifibox user.debug : Will stop /usr/sbin/udhcpd
Oct  7 17:04:36 wifibox user.debug : Will stop PID 4656
Oct  7 17:04:36 wifibox user.debug : Sending signal 15 to PID 4656
Oct  7 17:04:36 wifibox daemon.info udhcpd[4656]: received SIGTERM
Oct  7 17:04:36 wifibox daemon.info udhcpd[4734]: started, v1.36.1
Oct  7 17:04:39 wifibox user.debug : Will stop /usr/sbin/udhcpd
Oct  7 17:04:39 wifibox user.debug : Will stop PID 4734
Oct  7 17:04:39 wifibox user.debug : Sending signal 15 to PID 4734
Oct  7 17:04:39 wifibox daemon.info udhcpd[4734]: received SIGTERM
Oct  7 17:04:39 wifibox daemon.info udhcpd[4812]: started, v1.36.1
Oct  7 17:04:42 wifibox user.debug : Will stop /usr/sbin/udhcpd
Oct  7 17:04:42 wifibox user.debug : Will stop PID 4812
Oct  7 17:04:42 wifibox user.debug : Sending signal 15 to PID 4812
Oct  7 17:04:42 wifibox daemon.info udhcpd[4812]: received SIGTERM
Oct  7 17:04:42 wifibox daemon.info udhcpd[4890]: started, v1.36.1
Oct  7 17:04:45 wifibox user.debug : Will stop /usr/sbin/udhcpd
Oct  7 17:04:45 wifibox user.debug : Will stop PID 4890
Oct  7 17:04:45 wifibox user.debug : Sending signal 15 to PID 4890
Oct  7 17:04:45 wifibox daemon.info udhcpd[4890]: received SIGTERM
Oct  7 17:04:45 wifibox daemon.info udhcpd[4968]: started, v1.36.1
Oct  7 17:04:48 wifibox user.debug : Will stop /usr/sbin/udhcpd
Oct  7 17:04:48 wifibox user.debug : Will stop PID 4968
Oct  7 17:04:48 wifibox user.debug : Sending signal 15 to PID 4968
Oct  7 17:04:48 wifibox daemon.info udhcpd[4968]: received SIGTERM
Oct  7 17:04:48 wifibox daemon.info udhcpd[5046]: started, v1.36.1
Oct  7 17:04:51 wifibox user.debug : Will stop /usr/sbin/udhcpd
Oct  7 17:04:51 wifibox user.debug : Will stop PID 5046
Oct  7 17:04:51 wifibox user.debug : Sending signal 15 to PID 5046
Oct  7 17:04:51 wifibox daemon.info udhcpd[5046]: received SIGTERM
Oct  7 17:04:51 wifibox daemon.info udhcpd[5124]: started, v1.36.1
Oct  7 17:04:54 wifibox user.debug : Will stop /usr/sbin/udhcpd
Oct  7 17:04:54 wifibox user.debug : Will stop PID 5124
Oct  7 17:04:54 wifibox user.debug : Sending signal 15 to PID 5124
Oct  7 17:04:54 wifibox daemon.info udhcpd[5124]: received SIGTERM
Oct  7 17:04:54 wifibox daemon.info udhcpd[5202]: started, v1.36.1
Oct  7 17:04:57 wifibox user.debug : Will stop /usr/sbin/udhcpd
Oct  7 17:04:57 wifibox user.debug : Will stop PID 5202
Oct  7 17:04:57 wifibox user.debug : Sending signal 15 to PID 5202
Oct  7 17:04:57 wifibox daemon.info udhcpd[5202]: received SIGTERM
Oct  7 17:04:57 wifibox daemon.info udhcpd[5280]: started, v1.36.1
Oct  7 17:05:00 wifibox user.debug : Will stop /usr/sbin/udhcpd
Oct  7 17:05:00 wifibox user.debug : Will stop PID 5280
Oct  7 17:05:00 wifibox user.debug : Sending signal 15 to PID 5280
Oct  7 17:05:00 wifibox daemon.info udhcpd[5280]: received SIGTERM
Oct  7 17:05:00 wifibox daemon.info udhcpd[5358]: started, v1.36.1
Oct  7 17:05:03 wifibox user.debug : Will stop /usr/sbin/udhcpd
Oct  7 17:05:03 wifibox user.debug : Will stop PID 5358
Oct  7 17:05:03 wifibox user.debug : Sending signal 15 to PID 5358
Oct  7 17:05:03 wifibox daemon.info udhcpd[5358]: received SIGTERM
Oct  7 17:05:03 wifibox daemon.info udhcpd[5436]: started, v1.36.1
Oct  7 17:05:06 wifibox user.debug : Will stop /usr/sbin/udhcpd
Oct  7 17:05:06 wifibox user.debug : Will stop PID 5436
Oct  7 17:05:06 wifibox user.debug : Sending signal 15 to PID 5436
Oct  7 17:05:06 wifibox daemon.info udhcpd[5436]: received SIGTERM
Oct  7 17:05:06 wifibox daemon.info udhcpd[5514]: started, v1.36.1
Oct  7 17:05:09 wifibox user.debug : Will stop /usr/sbin/udhcpd
Oct  7 17:05:09 wifibox user.debug : Will stop PID 5514
Oct  7 17:05:09 wifibox user.debug : Sending signal 15 to PID 5514
Oct  7 17:05:09 wifibox daemon.info udhcpd[5514]: received SIGTERM
Oct  7 17:05:09 wifibox daemon.info udhcpd[5592]: started, v1.36.1

Additional context

I have observed this issue using both a dynamic and static IP configuration

Have you tried to turn it on and off?

pgj commented 1 month ago

Thanks for the report! Please note that there is a new version available, could you please try that?

evergreenbear commented 1 month ago

Hi, I've installed wifibox 0.14.0 from ports and experience the same bug. I am also still seeing errors related to radvd in the logs, but I don't know if that is the cause or not

pgj commented 1 month ago

Could you please post the same set of logs for the newer version?

pgj commented 4 weeks ago

@evergreenbear ping

evergreenbear commented 2 weeks ago

Hi, sorry for such a late response. I ended up needing to switch back to Linux due to other hardware incompatibilities, thus I can't work on debugging this issue right now. If I become able to switch back and have the same issue I will reopen. Thank you for your patience, and your work on getting wifi working well on BSD.