Open zytegalaxy opened 2 months ago
zytegalaxy
commented
2 months ago @sassanh I made wrote the same image over another MicroSD card and this time, the audio worked after the first time boot. I suspect this might be a race condition or something of that nature can sometimes cause an issue...
sassanh
commented
2 months ago @zytegalaxy Thanks! I have a couple of guesses for the reason it behaves unstable, I will check them when I come to this issue. The thing is I really doubt if the issue is in our setup process or the first boot. So the issue should show itself for a normal device randomly after some restarts, otherwise we may consider hardware issues too.
mehrdadfeller
commented
2 months ago Okay, I will keep an eye on this and see if it reappears. It could indeed be a finicky hardware issue especially since this is the first time setup a new hardware device (I have three live devices so far). The hardware factory label tests have passed though.
Let's keep this issue open for now and I will also investigate possible hardware causes.
On Mon, May 6, 2024 at 1:37 PM Sassan Haradji @.***> wrote:
@zytegalaxy https://github.com/zytegalaxy Thanks! I have a couple of guesses for the reason it behaves unstable, I will check them when I come to this issue. The thing is I really doubt if the issue is in our setup process or the first boot. So the issue should show itself for a normal device randomly after some restarts, otherwise we may consider hardware issues too.
— Reply to this email directly, view it on GitHub https://github.com/ubopod/ubo_app/issues/83#issuecomment-2096869081, or unsubscribe https://github.com/notifications/unsubscribe-auth/AA4CVJVSXF32KPJR6ZQJYRDZA7SYRAVCNFSM6AAAAABHIAIX4WVHI2DSMVQWIX3LMV43OSLTON2WKQ3PNVWWK3TUHMZDAOJWHA3DSMBYGE . You are receiving this because you are subscribed to this thread.Message ID: @.***>
Mehrdad Majzoobi, PhD Phone: (415) 570-7571
zytegalaxy
commented
2 months ago @sassanh I saw this again yesterday on v0.14.2-lite a different hardware (this is the hardware I have been using for a long time and have not witnessed any hardware related issue on it so far). The problem went away after a restart. I think this is probably some sort of race condition either during build process or boot-up.
By the way, I have never seen this problem re-emerge after the restart. In other words, it always appears (IF appears) on the first boot-up.
sassanh
commented
2 months ago @zytegalaxy It can't be an issue in the build process, because you tried the same image again and it worked. Let's collect all logs of the system next time this issue happens.
mehrdadfeller
commented
1 month ago log is throwing a lot of [ERROR] No audio card found errors:
ubo@ubo-hn:~ $ tail -f /opt/ubo/ubo-app.log
StopIteration
1718336056.297971 [ERROR] No audio card found
Traceback (most recent call last):
File "/opt/ubo/env/lib/python3.11/site-packages/ubo_app/services/000-sound/audio_manager.py", line 59, in initialize_audio
next(card for card in cards if 'wm8960' in card),
^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
StopIteration
1718336056.300226 [ERROR] No audio card found
Traceback (most recent call last):
File "/opt/ubo/env/lib/python3.11/site-packages/ubo_app/services/000-sound/audio_manager.py", line 59, in initialize_audio
next(card for card in cards if 'wm8960' in card),
^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
StopIteration
1718336056.301678 [ERROR] No audio card found
Traceback (most recent call last):
File "/opt/ubo/env/lib/python3.11/site-packages/ubo_app/services/000-sound/audio_manager.py", line 59, in initialize_audio
next(card for card in cards if 'wm8960' in card),
^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
StopIteration
1718336056.303279 [ERROR] No audio card found
Traceback (most recent call last):
File "/opt/ubo/env/lib/python3.11/site-packages/ubo_app/services/000-sound/audio_manager.py", line 59, in initialize_audio
next(card for card in cards if 'wm8960' in card),
^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
StopIterationaplay is not listing the WM8960 as sound card.
ubo@ubo-hn:~ $ aplay -l
**** List of PLAYBACK Hardware Devices ****
card 0: vc4hdmi0 [vc4-hdmi-0], device 0: MAI PCM i2s-hifi-0 [MAI PCM i2s-hifi-0]
Subdevices: 1/1
Subdevice #0: subdevice #0
card 1: vc4hdmi1 [vc4-hdmi-1], device 0: MAI PCM i2s-hifi-0 [MAI PCM i2s-hifi-0]
Subdevices: 1/1
Subdevice #0: subdevice #0
ubo@ubo-hn:~ $ i2cdetect -y 1
0 1 2 3 4 5 6 7 8 9 a b c d e f
00: -- -- -- -- -- -- -- --
10: 10 -- -- -- -- -- -- -- -- -- 1a -- -- -- -- --
20: -- -- -- -- -- -- -- -- -- -- -- -- -- -- -- --
30: -- -- -- -- -- -- -- -- -- -- -- -- -- -- -- --
40: -- -- -- -- -- -- -- -- 48 -- -- -- -- -- -- --
50: -- -- -- -- -- -- -- -- 58 -- -- -- -- -- -- --
60: -- -- -- -- -- -- -- -- -- -- -- -- -- -- -- --
70: -- -- -- -- -- -- -- -- 1a means the driver is not loaded since if it is loaded, it would appear as UU.
In the dmesg log below [ 12.603707] wm8960 1-001a: Failed to issue reset error appears which means the audio chip failed to reset. I wonder if the reset message goes through I2C bus and there's some write-collision on the bus causing this.
ubo@ubo-hn:~ $ dmesg
[ 0.000000] Booting Linux on physical CPU 0x0000000000 [0x410fd083]
[ 0.000000] Linux version 6.6.28+rpt-rpi-v8 (debian-kernel@lists.debian.org) (gcc-12 (Debian 12.2.0-14) 12.2.0, GNU ld (GNU Binutils for Debian) 2.40) #1 SMP PREEMPT Debian 1:6.6.28-1+rpt1 (2024-04-22)
[ 0.000000] KASLR enabled
[ 0.000000] random: crng init done
[ 0.000000] Machine model: Raspberry Pi 4 Model B Rev 1.5
[ 0.000000] efi: UEFI not found.
[ 0.000000] Reserved memory: created CMA memory pool at 0x000000000e400000, size 512 MiB
[ 0.000000] OF: reserved mem: initialized node linux,cma, compatible id shared-dma-pool
[ 0.000000] OF: reserved mem: 0x000000000e400000..0x000000002e3fffff (524288 KiB) map reusable linux,cma
[ 0.000000] OF: reserved mem: 0x000000003ef64520..0x000000003ef6491f (1 KiB) nomap non-reusable nvram@1
[ 0.000000] OF: reserved mem: 0x000000003ef64960..0x000000003ef64995 (0 KiB) nomap non-reusable nvram@0
[ 0.000000] Zone ranges:
[ 0.000000] DMA [mem 0x0000000000000000-0x000000003fffffff]
[ 0.000000] DMA32 [mem 0x0000000040000000-0x00000000fbffffff]
[ 0.000000] Normal empty
[ 0.000000] Movable zone start for each node
[ 0.000000] Early memory node ranges
[ 0.000000] node 0: [mem 0x0000000000000000-0x000000003b3fffff]
[ 0.000000] node 0: [mem 0x0000000040000000-0x00000000fbffffff]
[ 0.000000] Initmem setup node 0 [mem 0x0000000000000000-0x00000000fbffffff]
[ 0.000000] On node 0, zone DMA32: 19456 pages in unavailable ranges
[ 0.000000] On node 0, zone DMA32: 16384 pages in unavailable ranges
[ 0.000000] percpu: Embedded 30 pages/cpu s85672 r8192 d29016 u122880
[ 0.000000] pcpu-alloc: s85672 r8192 d29016 u122880 alloc=30*4096
[ 0.000000] pcpu-alloc: [0] 0 [0] 1 [0] 2 [0] 3
[ 0.000000] Detected PIPT I-cache on CPU0
[ 0.000000] CPU features: detected: Spectre-v2
[ 0.000000] CPU features: detected: Spectre-v3a
[ 0.000000] CPU features: detected: Spectre-v4
[ 0.000000] CPU features: detected: Spectre-BHB
[ 0.000000] CPU features: kernel page table isolation forced ON by KASLR
[ 0.000000] CPU features: detected: Kernel page table isolation (KPTI)
[ 0.000000] CPU features: detected: ARM erratum 1742098
[ 0.000000] CPU features: detected: ARM errata 1165522, 1319367, or 1530923
[ 0.000000] alternatives: applying boot alternatives
[ 0.000000] Kernel command line: coherent_pool=1M 8250.nr_uarts=0 snd_bcm2835.enable_headphones=0 snd_bcm2835.enable_headphones=1 snd_bcm2835.enable_hdmi=1 snd_bcm2835.enable_hdmi=0 smsc95xx.macaddr=D8:3A:DD:14:C7:44 vc_mem.mem_base=0x3ec00000 vc_mem.mem_size=0x40000000 console=ttyS0,115200 console=tty1 root=PARTUUID=860dfba6-02 rootfstype=ext4 fsck.repair=yes rootwait
[ 0.000000] Dentry cache hash table entries: 524288 (order: 10, 4194304 bytes, linear)
[ 0.000000] Inode-cache hash table entries: 262144 (order: 9, 2097152 bytes, linear)
[ 0.000000] Built 1 zonelists, mobility grouping on. Total pages: 996912
[ 0.000000] mem auto-init: stack:all(zero), heap alloc:off, heap free:off
[ 0.000000] software IO TLB: area num 4.
[ 0.000000] software IO TLB: mapped [mem 0x0000000037400000-0x000000003b400000] (64MB)
[ 0.000000] Memory: 3342596K/4050944K available (13376K kernel code, 2210K rwdata, 4264K rodata, 4864K init, 1083K bss, 184060K reserved, 524288K cma-reserved)
[ 0.000000] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=4, Nodes=1
[ 0.000000] ftrace: allocating 43160 entries in 169 pages
[ 0.000000] ftrace: allocated 169 pages with 4 groups
[ 0.000000] trace event string verifier disabled
[ 0.000000] rcu: Preemptible hierarchical RCU implementation.
[ 0.000000] rcu: RCU event tracing is enabled.
[ 0.000000] rcu: RCU restricting CPUs from NR_CPUS=256 to nr_cpu_ids=4.
[ 0.000000] Trampoline variant of Tasks RCU enabled.
[ 0.000000] Rude variant of Tasks RCU enabled.
[ 0.000000] Tracing variant of Tasks RCU enabled.
[ 0.000000] rcu: RCU calculated value of scheduler-enlistment delay is 25 jiffies.
[ 0.000000] rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=4
[ 0.000000] NR_IRQS: 64, nr_irqs: 64, preallocated irqs: 0
[ 0.000000] Root IRQ handler: gic_handle_irq
[ 0.000000] GIC: Using split EOI/Deactivate mode
[ 0.000000] rcu: srcu_init: Setting srcu_struct sizes based on contention.
[ 0.000000] arch_timer: cp15 timer(s) running at 54.00MHz (phys).
[ 0.000000] clocksource: arch_sys_counter: mask: 0xffffffffffffff max_cycles: 0xc743ce346, max_idle_ns: 440795203123 ns
[ 0.000000] sched_clock: 56 bits at 54MHz, resolution 18ns, wraps every 4398046511102ns
[ 0.000322] Console: colour dummy device 80x25
[ 0.000337] printk: console [tty1] enabled
[ 0.000955] Calibrating delay loop (skipped), value calculated using timer frequency.. 108.00 BogoMIPS (lpj=216000)
[ 0.000987] pid_max: default: 32768 minimum: 301
[ 0.001069] LSM: initializing lsm=capability,integrity
[ 0.001293] Mount-cache hash table entries: 8192 (order: 4, 65536 bytes, linear)
[ 0.001373] Mountpoint-cache hash table entries: 8192 (order: 4, 65536 bytes, linear)
[ 0.002278] cgroup: Disabling memory control group subsystem
[ 0.002680] spectre-v4 mitigation disabled by command-line option
[ 0.003957] RCU Tasks: Setting shift to 2 and lim to 1 rcu_task_cb_adjust=1.
[ 0.004074] RCU Tasks Rude: Setting shift to 2 and lim to 1 rcu_task_cb_adjust=1.
[ 0.004217] RCU Tasks Trace: Setting shift to 2 and lim to 1 rcu_task_cb_adjust=1.
[ 0.004483] rcu: Hierarchical SRCU implementation.
[ 0.004502] rcu: Max phase no-delay instances is 1000.
[ 0.006450] EFI services will not be available.
[ 0.006774] smp: Bringing up secondary CPUs ...
[ 0.007395] Detected PIPT I-cache on CPU1
[ 0.007524] CPU1: Booted secondary processor 0x0000000001 [0x410fd083]
[ 0.008238] Detected PIPT I-cache on CPU2
[ 0.008331] CPU2: Booted secondary processor 0x0000000002 [0x410fd083]
[ 0.008979] Detected PIPT I-cache on CPU3
[ 0.009073] CPU3: Booted secondary processor 0x0000000003 [0x410fd083]
[ 0.009165] smp: Brought up 1 node, 4 CPUs
[ 0.009242] SMP: Total of 4 processors activated.
[ 0.009258] CPU features: detected: 32-bit EL0 Support
[ 0.009271] CPU features: detected: 32-bit EL1 Support
[ 0.009287] CPU features: detected: CRC32 instructions
[ 0.009403] CPU: All CPU(s) started at EL2
[ 0.009428] alternatives: applying system-wide alternatives
[ 0.011782] devtmpfs: initialized
[ 0.022043] Enabled cp15_barrier support
[ 0.022100] Enabled setend support
[ 0.022274] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 7645041785100000 ns
[ 0.022313] futex hash table entries: 1024 (order: 4, 65536 bytes, linear)
[ 0.035476] pinctrl core: initialized pinctrl subsystem
[ 0.036090] DMI not present or invalid.
[ 0.036653] NET: Registered PF_NETLINK/PF_ROUTE protocol family
[ 0.038188] DMA: preallocated 1024 KiB GFP_KERNEL pool for atomic allocations
[ 0.038457] DMA: preallocated 1024 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations
[ 0.038906] DMA: preallocated 1024 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations
[ 0.038990] audit: initializing netlink subsys (disabled)
[ 0.039176] audit: type=2000 audit(0.036:1): state=initialized audit_enabled=0 res=1
[ 0.039690] thermal_sys: Registered thermal governor 'step_wise'
[ 0.039739] cpuidle: using governor menu
[ 0.039953] hw-breakpoint: found 6 breakpoint and 4 watchpoint registers.
[ 0.040099] ASID allocator initialised with 32768 entries
[ 0.041080] Serial: AMBA PL011 UART driver
[ 0.049097] bcm2835-mbox fe00b880.mailbox: mailbox enabled
[ 0.054922] platform fe801000.csi: Fixed dependency cycle(s) with /soc/i2c0mux/i2c@1/ov5647@36
[ 0.060155] raspberrypi-firmware soc:firmware: Attached to firmware from 2024-04-17T17:27:09, variant start
[ 0.064175] raspberrypi-firmware soc:firmware: Firmware hash is 86ccc427f35fdc604edc511881cdf579df945fb4
[ 0.074927] Modules: 2G module region forced by RANDOMIZE_MODULE_REGION_FULL
[ 0.074961] Modules: 0 pages in range for non-PLT usage
[ 0.074967] Modules: 517792 pages in range for PLT usage
[ 0.081582] bcm2835-dma fe007000.dma-controller: DMA legacy API manager, dmachans=0x1
[ 0.083383] iommu: Default domain type: Translated
[ 0.083405] iommu: DMA domain TLB invalidation policy: strict mode
[ 0.084442] SCSI subsystem initialized
[ 0.084698] usbcore: registered new interface driver usbfs
[ 0.084749] usbcore: registered new interface driver hub
[ 0.084813] usbcore: registered new device driver usb
[ 0.085234] pps_core: LinuxPPS API ver. 1 registered
[ 0.085254] pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti <giometti@linux.it>
[ 0.085285] PTP clock support registered
[ 0.086333] vgaarb: loaded
[ 0.086778] clocksource: Switched to clocksource arch_sys_counter
[ 0.087178] VFS: Disk quotas dquot_6.6.0
[ 0.087230] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes)
[ 0.087346] FS-Cache: Loaded
[ 0.087830] CacheFiles: Loaded
[ 0.095251] NET: Registered PF_INET protocol family
[ 0.095789] IP idents hash table entries: 65536 (order: 7, 524288 bytes, linear)
[ 0.100310] tcp_listen_portaddr_hash hash table entries: 2048 (order: 3, 32768 bytes, linear)
[ 0.100382] Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear)
[ 0.100414] TCP established hash table entries: 32768 (order: 6, 262144 bytes, linear)
[ 0.100641] TCP bind hash table entries: 32768 (order: 8, 1048576 bytes, linear)
[ 0.101669] TCP: Hash tables configured (established 32768 bind 32768)
[ 0.102105] MPTCP token hash table entries: 4096 (order: 4, 98304 bytes, linear)
[ 0.102329] UDP hash table entries: 2048 (order: 4, 65536 bytes, linear)
[ 0.102405] UDP-Lite hash table entries: 2048 (order: 4, 65536 bytes, linear)
[ 0.102648] NET: Registered PF_UNIX/PF_LOCAL protocol family
[ 0.103297] RPC: Registered named UNIX socket transport module.
[ 0.103322] RPC: Registered udp transport module.
[ 0.103335] RPC: Registered tcp transport module.
[ 0.103348] RPC: Registered tcp-with-tls transport module.
[ 0.103362] RPC: Registered tcp NFSv4.1 backchannel transport module.
[ 0.103389] PCI: CLS 0 bytes, default 64
[ 0.103756] Trying to unpack rootfs image as initramfs...
[ 0.115017] kvm [1]: IPA Size Limit: 44 bits
[ 0.116344] kvm [1]: vgic interrupt IRQ9
[ 0.116408] kvm [1]: Hyp mode initialized successfully
[ 0.652461] Freeing initrd memory: 11296K
[ 1.116753] Initialise system trusted keyrings
[ 1.117083] workingset: timestamp_bits=46 max_order=20 bucket_order=0
[ 1.117175] zbud: loaded
[ 1.117896] NFS: Registering the id_resolver key type
[ 1.117934] Key type id_resolver registered
[ 1.117949] Key type id_legacy registered
[ 1.117980] nfs4filelayout_init: NFSv4 File Layout Driver Registering...
[ 1.117998] nfs4flexfilelayout_init: NFSv4 Flexfile Layout Driver Registering...
[ 1.118672] Key type asymmetric registered
[ 1.118695] Asymmetric key parser 'x509' registered
[ 1.118756] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 247)
[ 1.118966] io scheduler mq-deadline registered
[ 1.118987] io scheduler kyber registered
[ 1.119033] io scheduler bfq registered
[ 1.119956] irq_brcmstb_l2: registered L2 intc (/soc/interrupt-controller@7ef00100, parent irq: 23)
[ 1.125348] brcm-pcie fd500000.pcie: host bridge /scb/pcie@7d500000 ranges:
[ 1.125402] brcm-pcie fd500000.pcie: No bus range found for /scb/pcie@7d500000, using [bus 00-ff]
[ 1.125463] brcm-pcie fd500000.pcie: MEM 0x0600000000..0x063fffffff -> 0x00c0000000
[ 1.125514] brcm-pcie fd500000.pcie: IB MEM 0x0000000000..0x00ffffffff -> 0x0400000000
[ 1.126572] brcm-pcie fd500000.pcie: PCI host bridge to bus 0000:00
[ 1.126603] pci_bus 0000:00: root bus resource [bus 00-ff]
[ 1.126626] pci_bus 0000:00: root bus resource [mem 0x600000000-0x63fffffff] (bus address [0xc0000000-0xffffffff])
[ 1.126688] pci 0000:00:00.0: [14e4:2711] type 01 class 0x060400
[ 1.126835] pci 0000:00:00.0: PME# supported from D0 D3hot
[ 1.130523] pci 0000:00:00.0: bridge configuration invalid ([bus 00-00]), reconfiguring
[ 1.130689] pci_bus 0000:01: supply vpcie3v3 not found, using dummy regulator
[ 1.130853] pci_bus 0000:01: supply vpcie3v3aux not found, using dummy regulator
[ 1.130939] pci_bus 0000:01: supply vpcie12v not found, using dummy regulator
[ 1.240858] brcm-pcie fd500000.pcie: link up, 5.0 GT/s PCIe x1 (SSC)
[ 1.241007] pci 0000:01:00.0: [1106:3483] type 00 class 0x0c0330
[ 1.241111] pci 0000:01:00.0: reg 0x10: [mem 0x00000000-0x00000fff 64bit]
[ 1.241405] pci 0000:01:00.0: PME# supported from D0 D3hot
[ 1.250859] pci_bus 0000:01: busn_res: [bus 01-ff] end is updated to 01
[ 1.250907] pci 0000:00:00.0: BAR 8: assigned [mem 0x600000000-0x6000fffff]
[ 1.250935] pci 0000:01:00.0: BAR 0: assigned [mem 0x600000000-0x600000fff 64bit]
[ 1.251006] pci 0000:00:00.0: PCI bridge to [bus 01]
[ 1.251027] pci 0000:00:00.0: bridge window [mem 0x600000000-0x6000fffff]
[ 1.251277] pcieport 0000:00:00.0: enabling device (0000 -> 0002)
[ 1.251429] pcieport 0000:00:00.0: PME: Signaling with IRQ 27
[ 1.251774] pcieport 0000:00:00.0: AER: enabled with IRQ 27
[ 1.261592] iproc-rng200 fe104000.rng: hwrng registered
[ 1.261876] vc-mem: phys_addr:0x00000000 mem_base=0x3ec00000 mem_size:0x40000000(1024 MiB)
[ 1.272744] brd: module loaded
[ 1.279119] loop: module loaded
[ 1.279740] Loading iSCSI transport class v2.0-870.
[ 1.284057] bcmgenet fd580000.ethernet: GENET 5.0 EPHY: 0x0000
[ 1.490856] unimac-mdio unimac-mdio.-19: Broadcom UniMAC MDIO bus
[ 1.491981] usbcore: registered new device driver r8152-cfgselector
[ 1.492035] usbcore: registered new interface driver r8152
[ 1.492092] usbcore: registered new interface driver lan78xx
[ 1.492139] usbcore: registered new interface driver smsc95xx
[ 1.539631] xhci_hcd 0000:01:00.0: xHCI Host Controller
[ 1.539672] xhci_hcd 0000:01:00.0: new USB bus registered, assigned bus number 1
[ 1.541466] xhci_hcd 0000:01:00.0: hcc params 0x002841eb hci version 0x100 quirks 0x0300240000000890
[ 1.542218] xhci_hcd 0000:01:00.0: xHCI Host Controller
[ 1.542248] xhci_hcd 0000:01:00.0: new USB bus registered, assigned bus number 2
[ 1.542278] xhci_hcd 0000:01:00.0: Host supports USB 3.0 SuperSpeed
[ 1.542551] usb usb1: New USB device found, idVendor=1d6b, idProduct=0002, bcdDevice= 6.06
[ 1.542581] usb usb1: New USB device strings: Mfr=3, Product=2, SerialNumber=1
[ 1.542603] usb usb1: Product: xHCI Host Controller
[ 1.542621] usb usb1: Manufacturer: Linux 6.6.28+rpt-rpi-v8 xhci-hcd
[ 1.542638] usb usb1: SerialNumber: 0000:01:00.0
[ 1.543255] hub 1-0:1.0: USB hub found
[ 1.543306] hub 1-0:1.0: 1 port detected
[ 1.543889] usb usb2: New USB device found, idVendor=1d6b, idProduct=0003, bcdDevice= 6.06
[ 1.543920] usb usb2: New USB device strings: Mfr=3, Product=2, SerialNumber=1
[ 1.543942] usb usb2: Product: xHCI Host Controller
[ 1.543959] usb usb2: Manufacturer: Linux 6.6.28+rpt-rpi-v8 xhci-hcd
[ 1.543977] usb usb2: SerialNumber: 0000:01:00.0
[ 1.544430] hub 2-0:1.0: USB hub found
[ 1.544484] hub 2-0:1.0: 4 ports detected
[ 1.545435] dwc_otg: version 3.00a 10-AUG-2012 (platform bus)
[ 1.545567] dwc_otg: FIQ enabled
[ 1.545574] dwc_otg: NAK holdoff enabled
[ 1.545580] dwc_otg: FIQ split-transaction FSM enabled
[ 1.545590] Module dwc_common_port init
[ 1.546286] usbcore: registered new interface driver uas
[ 1.546357] usbcore: registered new interface driver usb-storage
[ 1.546905] mousedev: PS/2 mouse device common for all mice
[ 1.550502] sdhci: Secure Digital Host Controller Interface driver
[ 1.550535] sdhci: Copyright(c) Pierre Ossman
[ 1.550820] sdhci-pltfm: SDHCI platform and OF driver helper
[ 1.553538] ledtrig-cpu: registered to indicate activity on CPUs
[ 1.553826] hid: raw HID events driver (C) Jiri Kosina
[ 1.553962] usbcore: registered new interface driver usbhid
[ 1.553982] usbhid: USB HID core driver
[ 1.559433] hw perfevents: enabled with armv8_cortex_a72 PMU driver, 7 counters available
[ 1.560803] NET: Registered PF_PACKET protocol family
[ 1.560903] Key type dns_resolver registered
[ 1.587520] registered taskstats version 1
[ 1.587774] Loading compiled-in X.509 certificates
[ 1.597289] Key type .fscrypt registered
[ 1.597329] Key type fscrypt-provisioning registered
[ 1.605323] uart-pl011 fe201000.serial: there is not valid maps for state default
[ 1.605756] uart-pl011 fe201000.serial: cts_event_workaround enabled
[ 1.606136] fe201000.serial: ttyAMA1 at MMIO 0xfe201000 (irq = 36, base_baud = 0) is a PL011 rev2
[ 1.606397] serial serial0: tty port ttyAMA1 registered
[ 1.610232] bcm2835-wdt bcm2835-wdt: Broadcom BCM2835 watchdog timer
[ 1.610514] bcm2835-power bcm2835-power: Broadcom BCM2835 power domains driver
[ 1.611430] mmc-bcm2835 fe300000.mmcnr: mmc_debug:0 mmc_debug2:0
[ 1.611733] mmc-bcm2835 fe300000.mmcnr: DMA channel allocated
[ 1.638835] of_cfs_init
[ 1.638974] of_cfs_init: OK
[ 1.639198] clk: Disabling unused clocks
[ 1.677447] mmc0: SDHCI controller on fe340000.mmc [fe340000.mmc] using ADMA
[ 1.687982] Freeing unused kernel memory: 4864K
[ 1.688262] Run /init as init process
[ 1.688280] with arguments:
[ 1.688285] /init
[ 1.688291] with environment:
[ 1.688296] HOME=/
[ 1.688301] TERM=linux
[ 1.726049] mmc1: new high speed SDIO card at address 0001
[ 1.790920] mmc0: new ultra high speed DDR50 SDXC card at address 0001
[ 1.791953] mmcblk0: mmc0:0001 SD16G 58.6 GiB
[ 1.794644] mmcblk0: p1 p2
[ 1.795240] mmcblk0: mmc0:0001 SD16G 58.6 GiB
[ 1.798899] usb 1-1: new high-speed USB device number 2 using xhci_hcd
[ 1.949495] usb 1-1: New USB device found, idVendor=2109, idProduct=3431, bcdDevice= 4.21
[ 1.949560] usb 1-1: New USB device strings: Mfr=0, Product=1, SerialNumber=0
[ 1.949583] usb 1-1: Product: USB2.0 Hub
[ 1.951966] hub 1-1:1.0: USB hub found
[ 1.952307] hub 1-1:1.0: 4 ports detected
[ 2.241634] brcmstb-i2c fef04500.i2c: @97500hz registered in polling mode
[ 2.242197] brcmstb-i2c fef09500.i2c: @97500hz registered in polling mode
[ 2.325500] i2c i2c-22: Added multiplexed i2c bus 0
[ 2.325905] platform fe801000.csi: Fixed dependency cycle(s) with /soc/i2c0mux/i2c@1/ov5647@36
[ 2.326055] i2c 10-0036: Fixed dependency cycle(s) with /soc/csi@7e801000
[ 2.326354] i2c i2c-22: Added multiplexed i2c bus 10
[ 3.998344] EXT4-fs (mmcblk0p2): mounted filesystem 93c89e92-8f2e-4522-ad32-68faed883d2f ro with ordered data mode. Quota mode: none.
[ 6.497773] systemd[1]: System time before build time, advancing clock.
[ 7.125126] NET: Registered PF_INET6 protocol family
[ 7.126441] Segment Routing with IPv6
[ 7.126490] In-situ OAM (IOAM) with IPv6
[ 7.500417] systemd[1]: systemd 252.22-1~deb12u1 running in system mode (+PAM +AUDIT +SELINUX +APPARMOR +IMA +SMACK +SECCOMP +GCRYPT -GNUTLS +OPENSSL +ACL +BLKID +CURL +ELFUTILS +FIDO2 +IDN2 -IDN +IPTC +KMOD +LIBCRYPTSETUP +LIBFDISK +PCRE2 -PWQUALITY +P11KIT +QRENCODE +TPM2 +BZIP2 +LZ4 +XZ +ZLIB +ZSTD -BPF_FRAMEWORK -XKBCOMMON +UTMP +SYSVINIT default-hierarchy=unified)
[ 7.500505] systemd[1]: Detected architecture arm64.
[ 7.511613] systemd[1]: Hostname set to <ubo-hn>.
[ 9.755606] systemd[1]: Queued start job for default target graphical.target.
[ 9.775619] systemd[1]: Created slice system-modprobe.slice - Slice /system/modprobe.
[ 9.778121] systemd[1]: Created slice system-systemd\x2dfsck.slice - Slice /system/systemd-fsck.
[ 9.779819] systemd[1]: Created slice user.slice - User and Session Slice.
[ 9.780436] systemd[1]: Started systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch.
[ 9.780934] systemd[1]: Started systemd-ask-password-wall.path - Forward Password Requests to Wall Directory Watch.
[ 9.781964] systemd[1]: Set up automount proc-sys-fs-binfmt_misc.automount - Arbitrary Executable File Formats File System Automount Point.
[ 9.782311] systemd[1]: Expecting device dev-disk-by\x2dpartuuid-860dfba6\x2d01.device - /dev/disk/by-partuuid/860dfba6-01...
[ 9.782590] systemd[1]: Reached target cryptsetup.target - Local Encrypted Volumes.
[ 9.782959] systemd[1]: Reached target integritysetup.target - Local Integrity Protected Volumes.
[ 9.783373] systemd[1]: Reached target paths.target - Path Units.
[ 9.783749] systemd[1]: Reached target slices.target - Slice Units.
[ 9.784054] systemd[1]: Reached target swap.target - Swaps.
[ 9.784349] systemd[1]: Reached target veritysetup.target - Local Verity Protected Volumes.
[ 9.785265] systemd[1]: Listening on systemd-fsckd.socket - fsck to fsckd communication Socket.
[ 9.785805] systemd[1]: Listening on systemd-initctl.socket - initctl Compatibility Named Pipe.
[ 9.787252] systemd[1]: Listening on systemd-journald-audit.socket - Journal Audit Socket.
[ 9.788169] systemd[1]: Listening on systemd-journald-dev-log.socket - Journal Socket (/dev/log).
[ 9.789031] systemd[1]: Listening on systemd-journald.socket - Journal Socket.
[ 9.790948] systemd[1]: Listening on systemd-udevd-control.socket - udev Control Socket.
[ 9.791767] systemd[1]: Listening on systemd-udevd-kernel.socket - udev Kernel Socket.
[ 9.792691] systemd[1]: dev-hugepages.mount - Huge Pages File System was skipped because of an unmet condition check (ConditionPathExists=/sys/kernel/mm/hugepages).
[ 9.797071] systemd[1]: Mounting dev-mqueue.mount - POSIX Message Queue File System...
[ 9.802389] systemd[1]: Mounting sys-kernel-debug.mount - Kernel Debug File System...
[ 9.808317] systemd[1]: Mounting sys-kernel-tracing.mount - Kernel Trace File System...
[ 9.809397] systemd[1]: auth-rpcgss-module.service - Kernel Module supporting RPCSEC_GSS was skipped because of an unmet condition check (ConditionPathExists=/etc/krb5.keytab).
[ 9.816092] systemd[1]: Starting fake-hwclock.service - Restore / save the current clock...
[ 9.821818] systemd[1]: Starting keyboard-setup.service - Set the console keyboard layout...
[ 9.827732] systemd[1]: Starting kmod-static-nodes.service - Create List of Static Device Nodes...
[ 9.833200] systemd[1]: Starting modprobe@configfs.service - Load Kernel Module configfs...
[ 9.839457] systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod...
[ 9.845484] systemd[1]: Starting modprobe@drm.service - Load Kernel Module drm...
[ 9.851728] systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore...
[ 9.857769] systemd[1]: Starting modprobe@fuse.service - Load Kernel Module fuse...
[ 9.864160] systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop...
[ 9.865372] systemd[1]: systemd-fsck-root.service - File System Check on Root Device was skipped because of an unmet condition check (ConditionPathExists=!/run/initramfs/fsck-root).
[ 9.875258] systemd[1]: Starting systemd-journald.service - Journal Service...
[ 10.224610] fuse: init (API version 7.39)
[ 10.227556] systemd[1]: Starting systemd-modules-load.service - Load Kernel Modules...
[ 10.233068] systemd[1]: Starting systemd-remount-fs.service - Remount Root and Kernel File Systems...
[ 10.238621] systemd[1]: Starting systemd-udev-trigger.service - Coldplug All udev Devices...
[ 10.247133] systemd[1]: Mounted dev-mqueue.mount - POSIX Message Queue File System.
[ 10.248021] systemd[1]: Mounted sys-kernel-debug.mount - Kernel Debug File System.
[ 10.248661] systemd[1]: Mounted sys-kernel-tracing.mount - Kernel Trace File System.
[ 10.250896] systemd[1]: Finished kmod-static-nodes.service - Create List of Static Device Nodes.
[ 10.252809] systemd[1]: modprobe@configfs.service: Deactivated successfully.
[ 10.253548] systemd[1]: Finished modprobe@configfs.service - Load Kernel Module configfs.
[ 10.255187] systemd[1]: modprobe@efi_pstore.service: Deactivated successfully.
[ 10.258496] systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore.
[ 10.260392] systemd[1]: modprobe@fuse.service: Deactivated successfully.
[ 10.261768] systemd[1]: Finished modprobe@fuse.service - Load Kernel Module fuse.
[ 10.263917] systemd[1]: modprobe@loop.service: Deactivated successfully.
[ 10.264644] systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop.
[ 10.272204] systemd[1]: Mounting sys-fs-fuse-connections.mount - FUSE Control File System...
[ 10.277595] systemd[1]: Mounting sys-kernel-config.mount - Kernel Configuration File System...
[ 10.283718] systemd[1]: Mounted sys-fs-fuse-connections.mount - FUSE Control File System.
[ 10.288178] systemd[1]: Mounted sys-kernel-config.mount - Kernel Configuration File System.
[ 10.326640] device-mapper: ioctl: 4.48.0-ioctl (2023-03-01) initialised: dm-devel@redhat.com
[ 10.332533] systemd[1]: modprobe@dm_mod.service: Deactivated successfully.
[ 10.333337] systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod.
[ 10.334500] systemd[1]: systemd-repart.service - Repartition Root Disk was skipped because no trigger condition checks were met.
[ 10.462694] systemd[1]: Started systemd-journald.service - Journal Service.
[ 10.578934] i2c_dev: i2c /dev entries driver
[ 10.590108] EXT4-fs (mmcblk0p2): re-mounted 93c89e92-8f2e-4522-ad32-68faed883d2f r/w. Quota mode: none.
[ 11.143947] systemd-journald[235]: Oldest entry in /run/log/journal/1cac1cb88e0542189554c33d33dad653/system.journal is older than the configured file retention duration (1month), suggesting rotation.
[ 11.143980] systemd-journald[235]: /run/log/journal/1cac1cb88e0542189554c33d33dad653/system.journal: Journal header limits reached or header out-of-date, rotating.
[ 11.169097] systemd-journald[235]: Received client request to flush runtime journal.
[ 12.602266] snd_soc_wm8960: loading out-of-tree module taints kernel.
[ 12.603707] wm8960 1-001a: Failed to issue reset
[ 12.603825] wm8960: probe of 1-001a failed with error -5
[ 16.754496] gpio-fan gpio-fan@0: GPIO fan initialized
[ 16.915875] rpi-gpiomem fe200000.gpiomem: window base 0xfe200000 size 0x00001000
[ 16.919111] rpi-gpiomem fe200000.gpiomem: initialised 1 regions as /dev/gpiomem
[ 17.422022] vc_sm_cma: module is from the staging directory, the quality is unknown, you have been warned.
[ 17.422540] Error: Driver 'asoc-simple-card' is already registered, aborting...
[ 17.423967] bcm2835_vc_sm_cma_probe: Videocore shared memory driver
[ 17.423989] [vc_sm_connected_init]: start
[ 17.424843] [vc_sm_connected_init]: installed successfully
[ 17.753580] mc: Linux media interface: v0.10
[ 18.449451] [drm] Initialized v3d 1.0.0 20180419 for fec00000.v3d on minor 0
[ 18.531318] videodev: Linux video capture interface: v2.00
[ 18.920975] vc4-drm gpu: bound fe400000.hvs (ops vc4_hvs_ops [vc4])
[ 18.935418] Registered IR keymap rc-cec
[ 18.935614] rc rc0: vc4-hdmi-0 as /devices/platform/soc/fef00700.hdmi/rc/rc0
[ 18.935805] input: vc4-hdmi-0 as /devices/platform/soc/fef00700.hdmi/rc/rc0/input0
[ 18.950390] input: vc4-hdmi-0 HDMI Jack as /devices/platform/soc/fef00700.hdmi/sound/card0/input1
[ 18.951037] vc4-drm gpu: bound fef00700.hdmi (ops vc4_hdmi_ops [vc4])
[ 18.958123] Registered IR keymap rc-cec
[ 18.958343] rc rc1: vc4-hdmi-1 as /devices/platform/soc/fef05700.hdmi/rc/rc1
[ 18.958540] input: vc4-hdmi-1 as /devices/platform/soc/fef05700.hdmi/rc/rc1/input2
[ 18.968462] input: vc4-hdmi-1 HDMI Jack as /devices/platform/soc/fef05700.hdmi/sound/card1/input3
[ 18.968980] vc4-drm gpu: bound fef05700.hdmi (ops vc4_hdmi_ops [vc4])
[ 18.969649] vc4-drm gpu: bound fe004000.txp (ops vc4_txp_ops [vc4])
[ 18.970230] vc4-drm gpu: bound fe206000.pixelvalve (ops vc4_crtc_ops [vc4])
[ 18.996456] bcm2835_mmal_vchiq: module is from the staging directory, the quality is unknown, you have been warned.
[ 19.008392] vc4-drm gpu: bound fe207000.pixelvalve (ops vc4_crtc_ops [vc4])
[ 19.008938] vc4-drm gpu: bound fe20a000.pixelvalve (ops vc4_crtc_ops [vc4])
[ 19.009190] vc4-drm gpu: bound fe216000.pixelvalve (ops vc4_crtc_ops [vc4])
[ 19.009543] vc4-drm gpu: bound fec12000.pixelvalve (ops vc4_crtc_ops [vc4])
[ 19.047006] Bluetooth: Core ver 2.22
[ 19.047766] NET: Registered PF_BLUETOOTH protocol family
[ 19.047782] Bluetooth: HCI device and connection manager initialized
[ 19.047808] Bluetooth: HCI socket layer initialized
[ 19.047821] Bluetooth: L2CAP socket layer initialized
[ 19.047849] Bluetooth: SCO socket layer initialized
[ 19.071393] [drm] Initialized vc4 0.0.0 20140616 for gpu on minor 1
[ 19.071867] vc4-drm gpu: [drm] Cannot find any crtc or sizes
[ 19.078888] vc4-drm gpu: [drm] Cannot find any crtc or sizes
[ 19.079164] vc4-drm gpu: [drm] Cannot find any crtc or sizes
[ 19.250228] cfg80211: Loading compiled-in X.509 certificates for regulatory database
[ 19.273060] Loaded X.509 cert 'benh@debian.org: 577e021cb980e0e820821ba7b54b4961b8b4fadf'
[ 19.274005] Loaded X.509 cert 'romain.perier@gmail.com: 3abbc6ec146e09d1b6016ab9d6cf71dd233f0328'
[ 19.274986] Loaded X.509 cert 'sforshee: 00b28ddf47aef9cea7'
[ 19.275892] Loaded X.509 cert 'wens: 61c038651aabdcf94bd0ac7ff06c7248db18c600'
[ 19.363391] bcm2835_v4l2: module is from the staging directory, the quality is unknown, you have been warned.
[ 19.390293] bcm2835_isp: module is from the staging directory, the quality is unknown, you have been warned.
[ 19.398112] bcm2835-isp bcm2835-isp: Device node output[0] registered as /dev/video13
[ 19.398540] bcm2835-isp bcm2835-isp: Device node capture[0] registered as /dev/video14
[ 19.398956] bcm2835-isp bcm2835-isp: Device node capture[1] registered as /dev/video15
[ 19.399254] bcm2835-isp bcm2835-isp: Device node stats[2] registered as /dev/video16
[ 19.399282] bcm2835-isp bcm2835-isp: Register output node 0 with media controller
[ 19.399296] bcm2835-isp bcm2835-isp: Register capture node 1 with media controller
[ 19.399308] bcm2835-isp bcm2835-isp: Register capture node 2 with media controller
[ 19.399318] bcm2835-isp bcm2835-isp: Register capture node 3 with media controller
[ 19.403080] bcm2835-isp bcm2835-isp: Device node output[0] registered as /dev/video20
[ 19.403523] bcm2835-isp bcm2835-isp: Device node capture[0] registered as /dev/video21
[ 19.403878] bcm2835-isp bcm2835-isp: Device node capture[1] registered as /dev/video22
[ 19.404238] bcm2835-isp bcm2835-isp: Device node stats[2] registered as /dev/video23
[ 19.404261] bcm2835-isp bcm2835-isp: Register output node 0 with media controller
[ 19.404276] bcm2835-isp bcm2835-isp: Register capture node 1 with media controller
[ 19.404287] bcm2835-isp bcm2835-isp: Register capture node 2 with media controller
[ 19.404297] bcm2835-isp bcm2835-isp: Register capture node 3 with media controller
[ 19.404598] bcm2835-isp bcm2835-isp: Loaded V4L2 bcm2835-isp
[ 19.536906] Bluetooth: HCI UART driver ver 2.3
[ 19.536937] Bluetooth: HCI UART protocol H4 registered
[ 19.537052] Bluetooth: HCI UART protocol Three-wire (H5) registered
[ 19.538919] hci_uart_bcm serial0-0: supply vbat not found, using dummy regulator
[ 19.538931] Bluetooth: HCI UART protocol Broadcom registered
[ 19.539142] hci_uart_bcm serial0-0: supply vddio not found, using dummy regulator
[ 19.540934] bcm2835_codec: module is from the staging directory, the quality is unknown, you have been warned.
[ 19.549025] bcm2835-codec bcm2835-codec: Device registered as /dev/video10
[ 19.549697] bcm2835-codec bcm2835-codec: Loaded V4L2 decode
[ 19.556358] bcm2835-codec bcm2835-codec: Device registered as /dev/video11
[ 19.556414] bcm2835-codec bcm2835-codec: Loaded V4L2 encode
[ 19.560637] bcm2835-codec bcm2835-codec: Device registered as /dev/video12
[ 19.560680] bcm2835-codec bcm2835-codec: Loaded V4L2 isp
[ 19.563468] bcm2835-codec bcm2835-codec: Device registered as /dev/video18
[ 19.563516] bcm2835-codec bcm2835-codec: Loaded V4L2 image_fx
[ 19.566531] bcm2835-codec bcm2835-codec: Device registered as /dev/video31
[ 19.566572] bcm2835-codec bcm2835-codec: Loaded V4L2 encode_image
[ 19.647032] uart-pl011 fe201000.serial: no DMA platform data
[ 19.725447] rpivid_hevc: module is from the staging directory, the quality is unknown, you have been warned.
[ 19.739317] rpivid feb10000.codec: Device registered as /dev/video19
[ 19.874639] brcmfmac: F1 signature read @0x18000000=0x15264345
[ 19.889367] brcmfmac: brcmf_fw_alloc_request: using brcm/brcmfmac43455-sdio for chip BCM4345/6
[ 19.892042] usbcore: registered new interface driver brcmfmac
[ 19.893359] Bluetooth: hci0: BCM: chip id 107
[ 19.893820] Bluetooth: hci0: BCM: features 0x2f
[ 19.895101] Bluetooth: hci0: BCM4345C0
[ 19.895161] Bluetooth: hci0: BCM4345C0 (003.001.025) build 0000
[ 20.444478] Bluetooth: hci0: BCM4345C0 'brcm/BCM4345C0.raspberrypi,4-model-b.hcd' Patch
[ 21.135809] Bluetooth: hci0: BCM: features 0x2f
[ 21.137290] Bluetooth: hci0: BCM43455 37.4MHz Raspberry Pi 3+-0190
[ 21.137309] Bluetooth: hci0: BCM4345C0 (003.001.025) build 0382
[ 21.370059] brcmfmac: brcmf_c_process_txcap_blob: no txcap_blob available (err=-2)
[ 21.370604] brcmfmac: brcmf_c_preinit_dcmds: Firmware: BCM4345/6 wl0: Apr 15 2021 03:03:20 version 7.45.234 (4ca95bb CY) FWID 01-996384e2
[ 26.456770] Adding 102396k swap on /var/swap. Priority:-2 extents:1 across:102396k SS
[ 26.831993] Bluetooth: BNEP (Ethernet Emulation) ver 1.3
[ 26.832022] Bluetooth: BNEP filters: protocol multicast
[ 26.832046] Bluetooth: BNEP socket layer initialized
[ 26.849220] Bluetooth: MGMT ver 1.22
[ 26.877258] NET: Registered PF_ALG protocol family
[ 27.048313] OF: overlay: WARNING: memory leak will occur if overlay removed, property: /soc/i2c@7e804000/status
[ 28.337106] OF: overlay: WARNING: memory leak will occur if overlay removed, property: /soc/i2s@7e203000/status
[ 30.175126] platform soc:sound: deferred probe pending
[ 31.243198] systemd[785]: memfd_create() called without MFD_EXEC or MFD_NOEXEC_SEAL set
[ 31.347304] bcmgenet fd580000.ethernet: configuring instance for external RGMII (RX delay)
[ 31.349812] bcmgenet fd580000.ethernet eth0: Link is Down
[ 31.381501] brcmfmac: brcmf_cfg80211_set_power_mgmt: power save enabled
[ 32.129667] systemd-journald[235]: File /var/log/journal/1cac1cb88e0542189554c33d33dad653/user-1001.journal corrupted or uncleanly shut down, renaming and replacing.
[ 50.664708] bridge: filtering via arp/ip/ip6tables is no longer available by default. Update your scripts to load br_netfilter if you need this.
[ 50.679410] Bridge firewalling registered
[ 51.420606] Initializing XFRM netlink socket
[ 52.671849] docker0: port 1(veth8e51573) entered blocking state
[ 52.671873] docker0: port 1(veth8e51573) entered disabled state
[ 52.671916] veth8e51573: entered allmulticast mode
[ 52.672079] veth8e51573: entered promiscuous mode
[ 53.879901] eth0: renamed from veth0147243
[ 53.905929] docker0: port 1(veth8e51573) entered blocking state
[ 53.905949] docker0: port 1(veth8e51573) entered forwarding state
I wanted to report a strange behavior I observed during first time boot of version
0.13.5The audio was not working and I got the following errors after sshing and testing the audio. I then decided to restarted and audio started working after restart: