raspberrypi / linux

Kernel source tree for Raspberry Pi-provided kernel builds. Issues unrelated to the linux kernel should be posted on the community forum at https://forums.raspberrypi.com/
Other
11.22k stars 5.03k forks source link

Hardware playback devices randomly change positions with reboot, sometimes #5592

Closed JimZipCode closed 1 year ago

JimZipCode commented 1 year ago

Describe the bug

I have a Hifiberry soundcard installed on a Raspberry Pi 4 Model B Rev 1.4 running Raspbian GNU/Linux 11 (bullseye).

Today, the output of aplay -l shows this:

root@raspberrypi4:/# 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: sndrpihifiberry [snd_rpi_hifiberry_digi], device 0: HiFiBerry Digi+ Pro HiFi wm8804-spdif-0 [HiFiBerry Digi+ Pro HiFi wm8804-spdif-0]
  Subdevices: 1/1
  Subdevice #0: subdevice #0
card 2: vc4hdmi1 [vc4-hdmi-1], device 0: MAI PCM i2s-hifi-0 [MAI PCM i2s-hifi-0]
  Subdevices: 1/1
  Subdevice #0: subdevice #0

So the Hifiberry is card 1, today. But we had a power failure two days ago; before the power failure, the Hifiberry was card 2. For some reason it was reassigned on reboot.

That "breaks" mpd when it happens. My mpd.conf audio_output.device was set to "hw:2,0", and that worked. Today no music was coming out. I looked at the aplay -l output and compared it to mpd.conf, and changed the setting from "hw:2,0", to "hw:1,0", and that fixed the issue.

This is not the first time I've had to do this. In June of 2022 the Hifiberry was card 0 (so my mpd.conf audio_output.device was set to "hw:2,0"), and then on one reboot it randomly moved to card 2. That time it took me days (and some high-power help) to troubleshoot why I was getting no sound. At least this time I knew what to look for.

It does NOT happen every reboot. I've rebooted plenty of times from June 2022 til this week (including some power failures); it only just happened. And then before that it was solid (at position 0) from Jan of 2021 until June of 2022. It's like an every-sixteen-month timebomb.

I guess I want to know this:

uname -a output shows this:

root@raspberrypi4:/# uname -a
Linux raspberrypi4 6.1.21-v8+ #1642 SMP PREEMPT Mon Apr  3 17:24:16 BST 2023 aarch64 GNU/Linux

Steps to reproduce the behaviour

Inconsistent. Randomly after ~16 months the aplay -l output shows that my Hifiberry soundcard has "moved" from position 0 to position 2 to position 1.

Device (s)

Raspberry Pi 4 Mod. B

System

root@raspberrypi4:/# raspinfo System Information

Raspberry Pi 4 Model B Rev 1.4 PRETTY_NAME="Raspbian GNU/Linux 11 (bullseye)" NAME="Raspbian GNU/Linux" VERSION_ID="11" VERSION="11 (bullseye)"

Raspberry Pi reference 2022-04-04 Generated using pi-gen, https://github.com/RPi-Distro/pi-gen, 226b479f8d32919c9fe36dd5b4c20c02682f8180, stage5

Linux raspberrypi4 6.1.21-v8+ #1642 SMP PREEMPT Mon Apr 3 17:24:16 BST 2023 aarch64 GNU/Linux Revision : c03114 Serial : 100000005bb5753d Model : Raspberry Pi 4 Model B Rev 1.4 Throttled flag : throttled=0x0 Camera : supported=0 detected=0, libcamera interfaces=0

Videocore information

Mar 17 2023 10:50:39 Copyright (c) 2012 Broadcom version 82f3750a65fadae9a38077e3c2e217ad158c8d54 (clean) (release) (start)

alloc failures: 0 compactions: 0 legacy block fails: 0

Filesystem information

Filesystem 1K-blocks Used Available Use% Mounted on /dev/root 58806652 14313316 41480320 26% / devtmpfs 1678472 0 1678472 0% /dev tmpfs 1942696 0 1942696 0% /dev/shm tmpfs 777080 1224 775856 1% /run tmpfs 5120 4 5116 1% /run/lock /dev/mmcblk0p6 258094 51410 206684 20% /boot /dev/sda2 3844461608 926820956 2722279988 26% /media/jim/piserv tmpfs 388536 28 388508 1% /run/user/1000

Filename Type Size Used Priority /var/swap file 102396 0 -2

Package version information

raspberrypi-ui-mods: Installed: 1.20220302 raspberrypi-sys-mods: Installed: 20230510~bullseye openbox: Installed: 3.6.1-9+rpt1+deb11u1 lxpanel: Installed: 0.10.1-2+rpt19 pcmanfm: Installed: 1.3.2-1+rpt9 rpd-plym-splash: Installed: 0.32

Networking Information

eth0: flags=4163<UP,BROADCAST,RUNNING,MULTICAST> mtu 1500 inet x.x.x.x netmask x.x.x.x broadcast x.x.x.x inet6 y::y.y.y.y prefixlen 64 scopeid 0x20 inet6 y.y.y.y.y.y.y.y prefixlen 64 scopeid 0x0 ether m.m.m.m txqueuelen 1000 (Ethernet) RX packets 41630 bytes 18189548 (17.3 MiB) RX errors 0 dropped 0 overruns 0 frame 0 TX packets 30084 bytes 20371544 (19.4 MiB) TX errors 0 dropped 0 overruns 0 carrier 0 collisions 0

lo: flags=73<UP,LOOPBACK,RUNNING> mtu 65536 inet x.x.x.x netmask x.x.x.x inet6 ::1 prefixlen 128 scopeid 0x10 loop txqueuelen 1000 (Local Loopback) RX packets 7388 bytes 166665413 (158.9 MiB) RX errors 0 dropped 0 overruns 0 frame 0 TX packets 7388 bytes 166665413 (158.9 MiB) TX errors 0 dropped 0 overruns 0 carrier 0 collisions 0

USB Information

/: Bus 02.Port 1: Dev 1, Class=root_hub, Driver=xhci_hcd/4p, 5000M | Port 2: Dev 2, If 0, Class=Mass Storage, Driver=uas, 5000M /: Bus 01.Port 1: Dev 1, Class=root_hub, Driver=xhci_hcd/1p, 480M | Port 1: Dev 2, If 0, Class=Hub, Driver=hub/4p, 480M

config.txt

arm_64bit=1 arm_boost=1 arm_freq=1800 audio_pwm_mode=514 camera_auto_detect=1 config_hdmi_boost=5 core_freq=500 core_freq_min=200 disable_commandline_tags=2 disable_l2cache=1 disable_overscan=1 disable_splash=1 display_auto_detect=1 display_hdmi_rotate=-1 display_lcd_rotate=-1 dvfs=3 enable_gic=1 enable_uart=1 force_eeprom_read=1 force_pwm_open=1 framebuffer_ignore_alpha=1 framebuffer_swap=1 gpu_freq=500 gpu_freq_min=250 init_uart_clock=0x2dc6c00 lcd_framerate=60 mask_gpu_interrupt0=3072 mask_gpu_interrupt1=25635 max_framebuffers=2 over_voltage_avs=-40000 pause_burst_frames=1 program_serial_random=1 second_boot=1 total_mem=4096 hdmi_force_cec_address:0=65535 hdmi_force_cec_address:1=65535 hdmi_pixel_freq_limit:0=0x11e1a300 hdmi_pixel_freq_limit:1=0x11e1a300 device_tree=- overlay_prefix=overlays/ hdmi_cvt:0= hdmi_cvt:1= hdmi_edid_filename:0= hdmi_edid_filename:1= hdmi_timings:0= hdmi_timings:1=

cmdline.txt

coherent_pool=1M 8250.nr_uarts=1 snd_bcm2835.enable_headphones=0 snd_bcm2835.enable_hdmi=0 smsc95xx.macaddr=E4:5F:01:76:F0:BC vc_mem.mem_base=0x3ec00000 vc_mem.mem_size=0x40000000 console=ttyAMA0,115200 console=tty1 root=/dev/mmcblk0p7 rootfstype=ext4 fsck.repair=yes rootwait quiet splash plymouth.ignore-serial-consoles

raspi-gpio settings

BANK0 (GPIO 0 to 27): GPIO 0: level=1 fsel=0 func=INPUT pull=UP GPIO 1: level=1 fsel=0 func=INPUT pull=UP GPIO 2: level=1 fsel=4 alt=0 func=SDA1 pull=UP GPIO 3: level=1 fsel=4 alt=0 func=SCL1 pull=UP GPIO 4: level=1 fsel=0 func=INPUT pull=UP GPIO 5: level=1 fsel=1 func=OUTPUT pull=UP GPIO 6: level=0 fsel=1 func=OUTPUT pull=UP GPIO 7: level=1 fsel=0 func=INPUT pull=UP GPIO 8: level=1 fsel=0 func=INPUT pull=UP GPIO 9: level=0 fsel=0 func=INPUT pull=DOWN GPIO 10: level=0 fsel=0 func=INPUT pull=DOWN GPIO 11: level=0 fsel=0 func=INPUT pull=DOWN GPIO 12: level=0 fsel=0 func=INPUT pull=DOWN GPIO 13: level=0 fsel=0 func=INPUT pull=DOWN GPIO 14: level=1 fsel=4 alt=0 func=TXD0 pull=NONE GPIO 15: level=1 fsel=4 alt=0 func=RXD0 pull=UP GPIO 16: level=0 fsel=0 func=INPUT pull=DOWN GPIO 17: level=0 fsel=0 func=INPUT pull=DOWN GPIO 18: level=0 fsel=4 alt=0 func=PCM_CLK pull=DOWN GPIO 19: level=0 fsel=4 alt=0 func=PCM_FS pull=DOWN GPIO 20: level=0 fsel=4 alt=0 func=PCM_DIN pull=DOWN GPIO 21: level=0 fsel=4 alt=0 func=PCM_DOUT pull=DOWN GPIO 22: level=0 fsel=0 func=INPUT pull=DOWN GPIO 23: level=0 fsel=0 func=INPUT pull=DOWN GPIO 24: level=0 fsel=0 func=INPUT pull=DOWN GPIO 25: level=0 fsel=0 func=INPUT pull=DOWN GPIO 26: level=0 fsel=0 func=INPUT pull=DOWN GPIO 27: level=0 fsel=0 func=INPUT pull=DOWN BANK1 (GPIO 28 to 45): GPIO 28: level=1 fsel=2 alt=5 func=RGMII_MDIO pull=UP GPIO 29: level=0 fsel=2 alt=5 func=RGMII_MDC pull=DOWN GPIO 30: level=1 fsel=0 func=INPUT pull=UP GPIO 31: level=1 fsel=0 func=INPUT pull=NONE GPIO 32: level=0 fsel=0 func=INPUT pull=DOWN GPIO 33: level=0 fsel=0 func=INPUT pull=DOWN GPIO 34: level=1 fsel=0 func=INPUT pull=UP GPIO 35: level=1 fsel=0 func=INPUT pull=UP GPIO 36: level=1 fsel=0 func=INPUT pull=UP GPIO 37: level=1 fsel=0 func=INPUT pull=UP GPIO 38: level=1 fsel=0 func=INPUT pull=UP GPIO 39: level=1 fsel=0 func=INPUT pull=UP GPIO 40: level=0 fsel=4 alt=0 func=PWM1_0 pull=NONE GPIO 41: level=0 fsel=4 alt=0 func=PWM1_1 pull=NONE GPIO 42: level=0 fsel=1 func=OUTPUT pull=UP GPIO 43: level=1 fsel=0 func=INPUT pull=UP GPIO 44: level=1 fsel=0 func=INPUT pull=UP GPIO 45: level=1 fsel=0 func=INPUT pull=UP BANK2 (GPIO 46 to 53): GPIO 46: level=0 fsel=0 func=INPUT pull=UP GPIO 47: level=0 fsel=0 func=INPUT pull=UP GPIO 48: level=0 fsel=0 func=INPUT pull=DOWN GPIO 49: level=0 fsel=0 func=INPUT pull=DOWN GPIO 50: level=0 fsel=0 func=INPUT pull=DOWN GPIO 51: level=0 fsel=0 func=INPUT pull=DOWN GPIO 52: level=0 fsel=0 func=INPUT pull=DOWN GPIO 53: level=0 fsel=0 func=INPUT pull=DOWN

vcdbg log messages

004015.153: arasan: arasan_emmc_open 004015.322: arasan: arasan_emmc_set_clock C0: 0x00800000 C1: 0x000e0047 emmc: 200000000 actual: 390625 div: 0x00000100 target: 400000 min: 400000 max: 400000 delay: 5 004120.088: arasan: arasan_emmc_set_clock C0: 0x00800000 C1: 0x000e0047 emmc: 200000000 actual: 390625 div: 0x00000100 target: 400000 min: 400000 max: 400000 delay: 5 004120.174: arasan: arasan_emmc_set_clock C0: 0x00800f00 C1: 0x000e0047 emmc: 200000000 actual: 390625 div: 0x00000100 target: 400000 min: 390000 max: 400000 delay: 5 004146.285: arasan: arasan_emmc_set_clock C0: 0x00800f06 C1: 0x000e0207 emmc: 200000000 actual: 50000000 div: 0x00000002 target: 50000000 min: 0 max: 50000000 delay: 1 004153.551: brfs: File read: /mfs/sd/config.txt 004154.600: brfs: File read: 2308 bytes 004176.495: HDMI0:EDID error reading EDID block 0 attempt 0 004177.512: HDMI0:EDID giving up on reading EDID block 0 004189.486: HDMI1:EDID error reading EDID block 0 attempt 0 004190.500: HDMI1:EDID giving up on reading EDID block 0 004192.320: brfs: File read: /mfs/sd/config.txt 005000.729: gpioman: gpioman_get_pin_num: pin DISPLAY_DSI_PORT not defined 005003.247: *** Restart logging 005003.266: brfs: File read: 2308 bytes 005008.820: hdmi: HDMI0:EDID error reading EDID block 0 attempt 0 005009.836: hdmi: HDMI0:EDID giving up on reading EDID block 0 005014.880: hdmi: HDMI0:EDID error reading EDID block 0 attempt 0 005015.897: hdmi: HDMI0:EDID giving up on reading EDID block 0 005015.913: hdmi: HDMI:hdmi_get_state is deprecated, use hdmi_get_display_state instead 005020.954: hdmi: HDMI1:EDID error reading EDID block 0 attempt 0 005021.972: hdmi: HDMI1:EDID giving up on reading EDID block 0 005027.011: hdmi: HDMI1:EDID error reading EDID block 0 attempt 0 005028.026: hdmi: HDMI1:EDID giving up on reading EDID block 0 005028.043: hdmi: HDMI:hdmi_get_state is deprecated, use hdmi_get_display_state instead 005028.059: HDMI0: hdmi_pixel_encoding: 300000000 005028.071: HDMI1: hdmi_pixel_encoding: 300000000 005028.407: kernel= 005131.284: dtb_file 'bcm2711-rpi-4-b.dtb' 005138.011: brfs: File read: /mfs/sd/bcm2711-rpi-4-b.dtb 005138.028: Loaded 'bcm2711-rpi-4-b.dtb' to 0x100 size 0xcd71 005151.114: brfs: File read: 52593 bytes 005167.268: brfs: File read: /mfs/sd/overlays/overlay_map.dtb 005241.435: brfs: File read: 2347 bytes 005244.691: brfs: File read: /mfs/sd/config.txt 005256.973: Loaded HAT overlay 005282.914: brfs: File read: 2308 bytes 005302.080: brfs: File read: /mfs/sd/overlays/vc4-kms-v3d-pi4.dtbo 005363.426: Loaded overlay 'vc4-kms-v3d' 005513.366: brfs: File read: 3913 bytes 005519.248: brfs: File read: /mfs/sd/overlays/disable-bt.dtbo 005534.102: Loaded overlay 'disable-bt' 005567.870: brfs: File read: 1073 bytes 005572.860: brfs: File read: /mfs/sd/overlays/disable-wifi.dtbo 005581.404: Loaded overlay 'disable-wifi' 005595.120: brfs: File read: 387 bytes 005603.446: brfs: File read: /mfs/sd/overlays/hifiberry-digi-pro.dtbo 005619.056: Loaded overlay 'hifiberry-digi-pro' 005652.908: brfs: File read: 1125 bytes 005655.609: brfs: File read: /mfs/sd/cmdline.txt 005655.655: Read command line from file 'cmdline.txt': 005655.669: 'console=serial0,115200 console=tty1 root=/dev/mmcblk0p7 rootfstype=ext4 fsck.repair=yes rootwait quiet splash plymouth.ignore-serial-consoles' 005779.443: brfs: File read: 142 bytes 006585.046: brfs: File read: /mfs/sd/kernel8.img 006585.066: Loaded 'kernel8.img' to 0x80000 size 0x7d6bd0 007755.977: Kernel relocated to 0x200000 007755.991: Device tree loaded to 0x2eff2b00 (size 0xd4d2) 007761.224: gpioman: gpioman_get_pin_num: pin SDCARD_CONTROL_POWER not defined 009934.037: vchiq_core: vchiq_init_state: slot_zero = 0xcf000000, is_master = 1

dmesg log

[ 0.000000] Booting Linux on physical CPU 0x0000000000 [0x410fd083] [ 0.000000] Linux version 6.1.21-v8+ (dom@buildbot) (aarch64-linux-gnu-gcc-8 (Ubuntu/Linaro 8.4.0-3ubuntu1) 8.4.0, GNU ld (GNU Binutils for Ubuntu) 2.34) #1642 SMP PREEMPT Mon Apr 3 17:24:16 BST 2023 [ 0.000000] random: crng init done [ 0.000000] Machine model: Raspberry Pi 4 Model B Rev 1.4 [ 0.000000] efi: UEFI not found. [ 0.000000] Reserved memory: created CMA memory pool at 0x000000000ec00000, size 512 MiB [ 0.000000] OF: reserved mem: initialized node linux,cma, compatible id shared-dma-pool [ 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 29 pages/cpu s78504 r8192 d32088 u118784 [ 0.000000] pcpu-alloc: s78504 r8192 d32088 u118784 alloc=29*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] Built 1 zonelists, mobility grouping on. Total pages: 996912 [ 0.000000] Kernel command line: coherent_pool=1M 8250.nr_uarts=1 snd_bcm2835.enable_headphones=0 snd_bcm2835.enable_hdmi=0 smsc95xx.macaddr=m.m.m.m vc_mem.mem_base=0x3ec00000 vc_mem.mem_size=0x40000000 console=ttyAMA0,115200 console=tty1 root=/dev/mmcblk0p7 rootfstype=ext4 fsck.repair=yes rootwait quiet splash plymouth.ignore-serial-consoles [ 0.000000] Unknown kernel command line parameters "splash", will be passed to user space. [ 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] mem auto-init: stack:off, 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: 3356948K/4050944K available (11776K kernel code, 2106K rwdata, 3688K rodata, 4160K init, 1077K bss, 169708K reserved, 524288K cma-reserved) [ 0.000000] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=4, Nodes=1 [ 0.000000] ftrace: allocating 39744 entries in 156 pages [ 0.000000] ftrace: allocated 156 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.000001] sched_clock: 56 bits at 54MHz, resolution 18ns, wraps every 4398046511102ns [ 0.000321] Console: colour dummy device 80x25 [ 0.000387] printk: console [tty1] enabled [ 0.000451] Calibrating delay loop (skipped), value calculated using timer frequency.. 108.00 BogoMIPS (lpj=216000) [ 0.000477] pid_max: default: 32768 minimum: 301 [ 0.000610] LSM: Security Framework initializing [ 0.000828] Mount-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) [ 0.000898] Mountpoint-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) [ 0.002196] cgroup: Disabling memory control group subsystem [ 0.004459] cblist_init_generic: Setting adjustable number of callback queues. [ 0.004478] cblist_init_generic: Setting shift to 2 and lim to 1. [ 0.004659] cblist_init_generic: Setting shift to 2 and lim to 1. [ 0.004836] cblist_init_generic: Setting shift to 2 and lim to 1. [ 0.005287] rcu: Hierarchical SRCU implementation. [ 0.005300] rcu: Max phase no-delay instances is 1000. [ 0.006619] EFI services will not be available. [ 0.007142] smp: Bringing up secondary CPUs ... [ 0.008308] Detected PIPT I-cache on CPU1 [ 0.008468] CPU1: Booted secondary processor 0x0000000001 [0x410fd083] [ 0.009634] Detected PIPT I-cache on CPU2 [ 0.009757] CPU2: Booted secondary processor 0x0000000002 [0x410fd083] [ 0.010880] Detected PIPT I-cache on CPU3 [ 0.011007] CPU3: Booted secondary processor 0x0000000003 [0x410fd083] [ 0.011154] smp: Brought up 1 node, 4 CPUs [ 0.011176] SMP: Total of 4 processors activated. [ 0.011188] CPU features: detected: 32-bit EL0 Support [ 0.011198] CPU features: detected: 32-bit EL1 Support [ 0.011211] CPU features: detected: CRC32 instructions [ 0.011350] CPU: All CPU(s) started at EL2 [ 0.011374] alternatives: applying system-wide alternatives [ 0.013281] devtmpfs: initialized [ 0.025363] Enabled cp15_barrier support [ 0.025405] Enabled setend support [ 0.025628] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 7645041785100000 ns [ 0.025663] futex hash table entries: 1024 (order: 4, 65536 bytes, linear) [ 0.039089] pinctrl core: initialized pinctrl subsystem [ 0.039969] DMI not present or invalid. [ 0.040727] NET: Registered PF_NETLINK/PF_ROUTE protocol family [ 0.044274] DMA: preallocated 1024 KiB GFP_KERNEL pool for atomic allocations [ 0.044610] DMA: preallocated 1024 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations [ 0.045569] DMA: preallocated 1024 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations [ 0.045666] audit: initializing netlink subsys (disabled) [ 0.045942] audit: type=2000 audit(0.044:1): state=initialized audit_enabled=0 res=1 [ 0.046547] thermal_sys: Registered thermal governor 'step_wise' [ 0.046640] cpuidle: using governor menu [ 0.047038] hw-breakpoint: found 6 breakpoint and 4 watchpoint registers. [ 0.047238] ASID allocator initialised with 32768 entries [ 0.047404] Serial: AMBA PL011 UART driver [ 0.060929] bcm2835-mbox fe00b880.mailbox: mailbox enabled [ 0.080697] raspberrypi-firmware soc:firmware: Attached to firmware from 2023-03-17T10:50:39, variant start [ 0.084700] raspberrypi-firmware soc:firmware: Firmware hash is 82f3750a65fadae9a38077e3c2e217ad158c8d54 [ 0.101066] KASLR enabled [ 0.133874] bcm2835-dma fe007000.dma: DMA legacy API manager, dmachans=0x1 [ 0.139694] SCSI subsystem initialized [ 0.139949] usbcore: registered new interface driver usbfs [ 0.140009] usbcore: registered new interface driver hub [ 0.140077] usbcore: registered new device driver usb [ 0.140470] usb_phy_generic phy: supply vcc not found, using dummy regulator [ 0.140698] usb_phy_generic phy: dummy supplies not allowed for exclusive requests [ 0.141062] pps_core: LinuxPPS API ver. 1 registered [ 0.141075] pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti giometti@linux.it [ 0.141102] PTP clock support registered [ 0.142254] vgaarb: loaded [ 0.142996] clocksource: Switched to clocksource arch_sys_counter [ 1.315167] VFS: Disk quotas dquot_6.6.0 [ 1.315267] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) [ 1.315459] FS-Cache: Loaded [ 1.315740] CacheFiles: Loaded [ 1.326823] NET: Registered PF_INET protocol family [ 1.327458] IP idents hash table entries: 65536 (order: 7, 524288 bytes, linear) [ 1.332422] tcp_listen_portaddr_hash hash table entries: 2048 (order: 3, 32768 bytes, linear) [ 1.332488] Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear) [ 1.332515] TCP established hash table entries: 32768 (order: 6, 262144 bytes, linear) [ 1.332745] TCP bind hash table entries: 32768 (order: 8, 1048576 bytes, linear) [ 1.333784] TCP: Hash tables configured (established 32768 bind 32768) [ 1.334036] UDP hash table entries: 2048 (order: 4, 65536 bytes, linear) [ 1.334126] UDP-Lite hash table entries: 2048 (order: 4, 65536 bytes, linear) [ 1.334450] NET: Registered PF_UNIX/PF_LOCAL protocol family [ 1.335414] RPC: Registered named UNIX socket transport module. [ 1.335433] RPC: Registered udp transport module. [ 1.335444] RPC: Registered tcp transport module. [ 1.335455] RPC: Registered tcp NFSv4.1 backchannel transport module. [ 1.335480] PCI: CLS 0 bytes, default 64 [ 1.338060] hw perfevents: enabled with armv8_cortex_a72 PMU driver, 7 counters available [ 1.338461] kvm [1]: IPA Size Limit: 44 bits [ 1.339859] kvm [1]: vgic interrupt IRQ9 [ 1.340098] kvm [1]: Hyp mode initialized successfully [ 1.342303] Initialise system trusted keyrings [ 1.342683] workingset: timestamp_bits=46 max_order=20 bucket_order=0 [ 1.350140] zbud: loaded [ 1.353064] NFS: Registering the id_resolver key type [ 1.353103] Key type id_resolver registered [ 1.353114] Key type id_legacy registered [ 1.353232] nfs4filelayout_init: NFSv4 File Layout Driver Registering... [ 1.353249] nfs4flexfilelayout_init: NFSv4 Flexfile Layout Driver Registering... [ 1.354666] Key type asymmetric registered [ 1.354684] Asymmetric key parser 'x509' registered [ 1.354767] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 247) [ 1.355102] io scheduler mq-deadline registered [ 1.355120] io scheduler kyber registered [ 1.357280] irq_brcmstb_l2: registered L2 intc (/soc/interrupt-controller@7ef00100, parent irq: 27) [ 1.365788] brcm-pcie fd500000.pcie: host bridge /scb/pcie@7d500000 ranges: [ 1.365831] brcm-pcie fd500000.pcie: No bus range found for /scb/pcie@7d500000, using [bus 00-ff] [ 1.365922] brcm-pcie fd500000.pcie: MEM 0x0600000000..0x063fffffff -> 0x00c0000000 [ 1.366007] brcm-pcie fd500000.pcie: IB MEM 0x0000000000..0x00ffffffff -> 0x0400000000 [ 1.367058] brcm-pcie fd500000.pcie: PCI host bridge to bus 0000:00 [ 1.367079] pci_bus 0000:00: root bus resource [bus 00-ff] [ 1.367098] pci_bus 0000:00: root bus resource [mem 0x600000000-0x63fffffff] (bus address [0xc0000000-0xffffffff]) [ 1.367177] pci 0000:00:00.0: [14e4:2711] type 01 class 0x060400 [ 1.367439] pci 0000:00:00.0: PME# supported from D0 D3hot [ 1.371663] pci_bus 0000:01: supply vpcie3v3 not found, using dummy regulator [ 1.371855] pci_bus 0000:01: supply vpcie3v3aux not found, using dummy regulator [ 1.371977] pci_bus 0000:01: supply vpcie12v not found, using dummy regulator [ 1.441087] brcm-pcie fd500000.pcie: link up, 5.0 GT/s PCIe x1 (SSC) [ 1.441254] pci 0000:01:00.0: [1106:3483] type 00 class 0x0c0330 [ 1.441382] pci 0000:01:00.0: reg 0x10: [mem 0x00000000-0x00000fff 64bit] [ 1.441866] pci 0000:01:00.0: PME# supported from D0 D3hot [ 1.442646] pci 0000:00:00.0: BAR 8: assigned [mem 0x600000000-0x6000fffff] [ 1.442673] pci 0000:01:00.0: BAR 0: assigned [mem 0x600000000-0x600000fff 64bit] [ 1.442716] pci 0000:00:00.0: PCI bridge to [bus 01] [ 1.442738] pci 0000:00:00.0: bridge window [mem 0x600000000-0x6000fffff] [ 1.453837] Serial: 8250/16550 driver, 1 ports, IRQ sharing enabled [ 1.457102] iproc-rng200 fe104000.rng: hwrng registered [ 1.457695] vc-mem: phys_addr:0x00000000 mem_base=0x3ec00000 mem_size:0x40000000(1024 MiB) [ 1.459286] gpiomem-bcm2835 fe200000.gpiomem: Initialised: Registers at 0xfe200000 [ 1.472507] brd: module loaded [ 1.481391] loop: module loaded [ 1.482264] Loading iSCSI transport class v2.0-870. [ 1.487788] bcmgenet fd580000.ethernet: GENET 5.0 EPHY: 0x0000 [ 1.547159] unimac-mdio unimac-mdio.-19: Broadcom UniMAC MDIO bus [ 1.548367] usbcore: registered new interface driver r8152 [ 1.548443] usbcore: registered new interface driver lan78xx [ 1.548504] usbcore: registered new interface driver smsc95xx [ 1.595943] pci 0000:00:00.0: enabling device (0000 -> 0002) [ 1.596125] xhci_hcd 0000:01:00.0: xHCI Host Controller [ 1.596158] xhci_hcd 0000:01:00.0: new USB bus registered, assigned bus number 1 [ 1.596925] xhci_hcd 0000:01:00.0: hcc params 0x002841eb hci version 0x100 quirks 0x0001e40000000890 [ 1.597950] xhci_hcd 0000:01:00.0: xHCI Host Controller [ 1.597973] xhci_hcd 0000:01:00.0: new USB bus registered, assigned bus number 2 [ 1.597996] xhci_hcd 0000:01:00.0: Host supports USB 3.0 SuperSpeed [ 1.598409] usb usb1: New USB device found, idVendor=1d6b, idProduct=0002, bcdDevice= 6.01 [ 1.598429] usb usb1: New USB device strings: Mfr=3, Product=2, SerialNumber=1 [ 1.598445] usb usb1: Product: xHCI Host Controller [ 1.598458] usb usb1: Manufacturer: Linux 6.1.21-v8+ xhci-hcd [ 1.598471] usb usb1: SerialNumber: 0000:01:00.0 [ 1.599260] hub 1-0:1.0: USB hub found [ 1.599331] hub 1-0:1.0: 1 port detected [ 1.600268] usb usb2: New USB device found, idVendor=1d6b, idProduct=0003, bcdDevice= 6.01 [ 1.600289] usb usb2: New USB device strings: Mfr=3, Product=2, SerialNumber=1 [ 1.600303] usb usb2: Product: xHCI Host Controller [ 1.600316] usb usb2: Manufacturer: Linux 6.1.21-v8+ xhci-hcd [ 1.600328] usb usb2: SerialNumber: 0000:01:00.0 [ 1.601046] hub 2-0:1.0: USB hub found [ 1.601142] hub 2-0:1.0: 4 ports detected [ 1.602944] dwc_otg: version 3.00a 10-AUG-2012 (platform bus) [ 1.603329] dwc_otg: FIQ enabled [ 1.603341] dwc_otg: NAK holdoff enabled [ 1.603351] dwc_otg: FIQ split-transaction FSM enabled [ 1.603371] Module dwc_common_port init [ 1.603950] usbcore: registered new interface driver uas [ 1.604068] usbcore: registered new interface driver usb-storage [ 1.604285] mousedev: PS/2 mouse device common for all mice [ 1.611011] sdhci: Secure Digital Host Controller Interface driver [ 1.611032] sdhci: Copyright(c) Pierre Ossman [ 1.611710] sdhci-pltfm: SDHCI platform and OF driver helper [ 1.615502] ledtrig-cpu: registered to indicate activity on CPUs [ 1.615874] hid: raw HID events driver (C) Jiri Kosina [ 1.616083] usbcore: registered new interface driver usbhid [ 1.616096] usbhid: USB HID core driver [ 1.625077] NET: Registered PF_PACKET protocol family [ 1.625205] Key type dns_resolver registered [ 1.626764] registered taskstats version 1 [ 1.626846] Loading compiled-in X.509 certificates [ 1.627790] Key type .fscrypt registered [ 1.627806] Key type fscrypt-provisioning registered [ 1.643869] uart-pl011 fe201000.serial: there is not valid maps for state default [ 1.644570] uart-pl011 fe201000.serial: cts_event_workaround enabled [ 1.644726] fe201000.serial: ttyAMA0 at MMIO 0xfe201000 (irq = 36, base_baud = 0) is a PL011 rev2 [ 1.644996] printk: console [ttyAMA0] enabled [ 1.654237] bcm2835-wdt bcm2835-wdt: Broadcom BCM2835 watchdog timer [ 1.654714] bcm2835-power bcm2835-power: Broadcom BCM2835 power domains driver [ 1.658003] of_cfs_init [ 1.658143] of_cfs_init: OK [ 1.691741] mmc0: SDHCI controller on fe340000.mmc [fe340000.mmc] using ADMA [ 1.692188] Waiting for root device /dev/mmcblk0p7... [ 1.789675] mmc0: new ultra high speed DDR50 SDXC card at address 59b4 [ 1.790781] mmcblk0: mmc0:59b4 EC1S5 59.7 GiB [ 1.795380] mmcblk0: p1 p2 < p5 p6 p7 > [ 1.796581] mmcblk0: mmc0:59b4 EC1S5 59.7 GiB [ 1.814281] EXT4-fs (mmcblk0p7): mounted filesystem with ordered data mode. Quota mode: none. [ 1.814379] VFS: Mounted root (ext4 filesystem) readonly on device 179:7. [ 1.819319] devtmpfs: mounted [ 1.828252] Freeing unused kernel memory: 4160K [ 1.828452] Run /sbin/init as init process [ 1.828465] with arguments: [ 1.828474] /sbin/init [ 1.828485] splash [ 1.828495] with environment: [ 1.828504] HOME=/ [ 1.828514] TERM=linux [ 1.855052] usb 1-1: new high-speed USB device number 2 using xhci_hcd [ 2.005812] usb 1-1: New USB device found, idVendor=2109, idProduct=3431, bcdDevice= 4.21 [ 2.005849] usb 1-1: New USB device strings: Mfr=0, Product=1, SerialNumber=0 [ 2.005865] usb 1-1: Product: USB2.0 Hub [ 2.007826] hub 1-1:1.0: USB hub found [ 2.008140] hub 1-1:1.0: 4 ports detected [ 2.131391] usb 2-2: new SuperSpeed USB device number 2 using xhci_hcd [ 2.152977] usb 2-2: New USB device found, idVendor=0bc2, idProduct=331a, bcdDevice= 9.15 [ 2.153007] usb 2-2: New USB device strings: Mfr=1, Product=2, SerialNumber=3 [ 2.153023] usb 2-2: Product: Expansion Desk [ 2.153037] usb 2-2: Manufacturer: Seagate [ 2.153050] usb 2-2: SerialNumber: NAABE1T6 [ 2.166500] systemd[1]: System time before build time, advancing clock. [ 2.166885] scsi host0: uas [ 2.168470] scsi 0:0:0:0: Direct-Access Seagate Expansion Desk 0915 PQ: 0 ANSI: 6 [ 2.172242] sd 0:0:0:0: [sda] 7814037167 512-byte logical blocks: (4.00 TB/3.64 TiB) [ 2.172268] sd 0:0:0:0: [sda] 4096-byte physical blocks [ 2.172613] sd 0:0:0:0: [sda] Write Protect is off [ 2.172632] sd 0:0:0:0: [sda] Mode Sense: 53 00 00 08 [ 2.173123] sd 0:0:0:0: [sda] Write cache: enabled, read cache: enabled, doesn't support DPO or FUA [ 2.173644] sd 0:0:0:0: [sda] Preferred minimum I/O size 4096 bytes [ 2.173665] sd 0:0:0:0: [sda] Optimal transfer size 33553920 bytes not a multiple of preferred minimum block size (4096 bytes) [ 2.329566] sda: sda1 sda2 [ 2.330428] sd 0:0:0:0: [sda] Attached SCSI disk [ 2.362837] NET: Registered PF_INET6 protocol family [ 2.364734] Segment Routing with IPv6 [ 2.364778] In-situ OAM (IOAM) with IPv6 [ 2.425208] systemd[1]: systemd 247.3-7+rpi1+deb11u2 running in system mode. (+PAM +AUDIT +SELINUX +IMA +APPARMOR +SMACK +SYSVINIT +UTMP +LIBCRYPTSETUP +GCRYPT +GNUTLS +ACL +XZ +LZ4 +ZSTD +SECCOMP +BLKID +ELFUTILS +KMOD +IDN2 -IDN +PCRE2 default-hierarchy=unified) [ 2.426245] systemd[1]: Detected architecture arm64. [ 2.427828] systemd[1]: Set hostname to . [ 2.569393] uart-pl011 fe201000.serial: no DMA platform data [ 3.184137] systemd[1]: /lib/systemd/system/plymouth-start.service:16: Unit configured to use KillMode=none. This is unsafe, as it disables systemd's process lifecycle management for the service. Please update your service to use a safer KillMode=, such as 'mixed' or 'control-group'. Support for KillMode=none is deprecated and will eventually be removed. [ 3.385458] systemd[1]: Queued start job for default target Graphical Interface. [ 3.406252] systemd[1]: Created slice system-getty.slice. [ 3.407845] systemd[1]: Created slice system-modprobe.slice. [ 3.408978] systemd[1]: Created slice system-serial\x2dgetty.slice. [ 3.410070] systemd[1]: Created slice system-systemd\x2dfsck.slice. [ 3.411050] systemd[1]: Created slice User and Session Slice. [ 3.411669] systemd[1]: Started Forward Password Requests to Wall Directory Watch. [ 3.412940] systemd[1]: Set up automount Arbitrary Executable File Formats File System Automount Point. [ 3.413871] systemd[1]: Reached target Slices. [ 3.414136] systemd[1]: Reached target Swap. [ 3.419738] systemd[1]: Listening on Syslog Socket. [ 3.420670] systemd[1]: Listening on fsck to fsckd communication Socket. [ 3.421225] systemd[1]: Listening on initctl Compatibility Named Pipe. [ 3.422636] systemd[1]: Listening on Journal Audit Socket. [ 3.423636] systemd[1]: Listening on Journal Socket (/dev/log). [ 3.424729] systemd[1]: Listening on Journal Socket. [ 3.428500] systemd[1]: Listening on udev Control Socket. [ 3.429472] systemd[1]: Listening on udev Kernel Socket. [ 3.430624] systemd[1]: Condition check resulted in Huge Pages File System being skipped. [ 3.451560] systemd[1]: Mounting POSIX Message Queue File System... [ 3.456489] systemd[1]: Mounting RPC Pipe File System... [ 3.462043] systemd[1]: Mounting Kernel Debug File System... [ 3.467896] systemd[1]: Mounting Kernel Trace File System... [ 3.468553] systemd[1]: Condition check resulted in Kernel Module supporting RPCSEC_GSS being skipped. [ 3.476255] systemd[1]: Starting Restore / save the current clock... [ 3.489081] systemd[1]: Starting Set the console keyboard layout... [ 3.495470] systemd[1]: Starting Create list of static device nodes for the current kernel... [ 3.503585] systemd[1]: Starting Load Kernel Module configfs... [ 3.509862] systemd[1]: Starting Load Kernel Module drm... [ 3.516088] systemd[1]: Starting Load Kernel Module fuse... [ 3.519460] systemd[1]: Condition check resulted in Set Up Additional Binary Formats being skipped. [ 3.524977] systemd[1]: Starting File System Check on Root Device... [ 3.535922] systemd[1]: Starting Journal Service... [ 3.557318] systemd[1]: Starting Load Kernel Modules... [ 3.563473] systemd[1]: Starting Coldplug All udev Devices... [ 3.596697] systemd[1]: Mounted POSIX Message Queue File System. [ 3.597703] systemd[1]: Mounted RPC Pipe File System. [ 3.598653] systemd[1]: Mounted Kernel Debug File System. [ 3.599666] systemd[1]: Mounted Kernel Trace File System. [ 3.602021] systemd[1]: Finished Create list of static device nodes for the current kernel. [ 3.604864] systemd[1]: modprobe@configfs.service: Succeeded. [ 3.619276] systemd[1]: Finished Load Kernel Module configfs. [ 3.622648] systemd[1]: Finished Restore / save the current clock. [ 3.635269] fuse: init (API version 7.37) [ 3.660593] i2c_dev: i2c /dev entries driver [ 3.671729] systemd[1]: Mounting Kernel Configuration File System... [ 3.674748] systemd[1]: modprobe@fuse.service: Succeeded. [ 3.677062] systemd[1]: Finished Load Kernel Module fuse. [ 3.691363] systemd[1]: Finished Load Kernel Modules. [ 3.696297] systemd[1]: Mounted Kernel Configuration File System. [ 3.739688] systemd[1]: Mounting FUSE Control File System... [ 3.757810] systemd[1]: Started File System Check Daemon to report status. [ 3.764383] systemd[1]: Starting Apply Kernel Variables... [ 3.770227] systemd[1]: Mounted FUSE Control File System. [ 3.776754] systemd[1]: modprobe@drm.service: Succeeded. [ 3.778415] systemd[1]: Finished Load Kernel Module drm. [ 3.821862] systemd[1]: Finished Apply Kernel Variables. [ 3.875299] systemd[1]: Finished File System Check on Root Device. [ 3.881162] systemd[1]: Starting Remount Root and Kernel File Systems... [ 3.912872] systemd[1]: Started Journal Service. [ 3.964223] EXT4-fs (mmcblk0p7): re-mounted. Quota mode: none. [ 4.043311] systemd-journald[146]: Received client request to flush runtime journal. [ 4.061057] systemd-journald[146]: File /var/log/journal/2b59a630e9f84883a45a24dfec1ccd4f/system.journal corrupted or uncleanly shut down, renaming and replacing. [ 5.317990] mc: Linux media interface: v0.10 [ 5.405138] videodev: Linux video capture interface: v2.00 [ 5.437532] vc_sm_cma: module is from the staging directory, the quality is unknown, you have been warned. [ 5.451092] vc_sm_cma: module is from the staging directory, the quality is unknown, you have been warned. [ 5.496873] bcm2835_vc_sm_cma_probe: Videocore shared memory driver

[ 5.524732] [vc_sm_connected_init]: installed successfully [ 5.572673] bcm2835_mmal_vchiq: module is from the staging directory, the quality is unknown, you have been warned. [ 5.617738] snd_bcm2835: module is from the staging directory, the quality is unknown, you have been warned. [ 5.635355] bcm2835_v4l2: module is from the staging directory, the quality is unknown, you have been warned. [ 5.650708] rpivid_hevc: module is from the staging directory, the quality is unknown, you have been warned. [ 5.678676] bcm2835_isp: module is from the staging directory, the quality is unknown, you have been warned. [ 5.689906] bcm2835_codec: module is from the staging directory, the quality is unknown, you have been warned. [ 5.727123] rpivid feb10000.codec: Device registered as /dev/video19 [ 5.758248] bcm2835-codec bcm2835-codec: Device registered as /dev/video10 [ 5.758313] bcm2835-codec bcm2835-codec: Loaded V4L2 decode [ 5.770546] bcm2835-codec bcm2835-codec: Device registered as /dev/video11 [ 5.770628] bcm2835-codec bcm2835-codec: Loaded V4L2 encode [ 5.775859] brcmstb-i2c fef04500.i2c: @97500hz registered in polling mode [ 5.779052] bcm2835-codec bcm2835-codec: Device registered as /dev/video12 [ 5.779125] bcm2835-codec bcm2835-codec: Loaded V4L2 isp [ 5.779634] bcm2835-isp bcm2835-isp: Device node output[0] registered as /dev/video13 [ 5.785140] bcm2835-codec bcm2835-codec: Device registered as /dev/video18 [ 5.785218] bcm2835-codec bcm2835-codec: Loaded V4L2 image_fx [ 5.791956] bcm2835-codec bcm2835-codec: Device registered as /dev/video31 [ 5.792021] bcm2835-codec bcm2835-codec: Loaded V4L2 encode_image [ 5.855369] bcm2835-isp bcm2835-isp: Device node capture[0] registered as /dev/video14 [ 5.856070] bcm2835-isp bcm2835-isp: Device node capture[1] registered as /dev/video15 [ 5.856599] bcm2835-isp bcm2835-isp: Device node stats[2] registered as /dev/video16 [ 5.856641] bcm2835-isp bcm2835-isp: Register output node 0 with media controller [ 5.856676] bcm2835-isp bcm2835-isp: Register capture node 1 with media controller [ 5.856705] bcm2835-isp bcm2835-isp: Register capture node 2 with media controller [ 5.856723] bcm2835-isp bcm2835-isp: Register capture node 3 with media controller [ 5.857495] brcmstb-i2c fef09500.i2c: @97500hz registered in polling mode [ 5.927913] bcm2835-isp bcm2835-isp: Device node output[0] registered as /dev/video20 [ 5.928663] bcm2835-isp bcm2835-isp: Device node capture[0] registered as /dev/video21 [ 5.929262] bcm2835-isp bcm2835-isp: Device node capture[1] registered as /dev/video22 [ 5.929747] bcm2835-isp bcm2835-isp: Device node stats[2] registered as /dev/video23 [ 5.929783] bcm2835-isp bcm2835-isp: Register output node 0 with media controller [ 5.929805] bcm2835-isp bcm2835-isp: Register capture node 1 with media controller [ 5.929834] bcm2835-isp bcm2835-isp: Register capture node 2 with media controller [ 5.929852] bcm2835-isp bcm2835-isp: Register capture node 3 with media controller [ 5.930204] bcm2835-isp bcm2835-isp: Loaded V4L2 bcm2835-isp [ 6.686333] sd 0:0:0:0: Attached scsi generic sg0 type 0 [ 6.811616] [drm] Initialized v3d 1.0.0 20180419 for fec00000.v3d on minor 0 [ 7.234507] vc4-drm gpu: bound fe400000.hvs (ops vc4_hvs_ops [vc4]) [ 7.351758] Registered IR keymap rc-cec [ 7.352150] rc rc0: vc4-hdmi-0 as /devices/platform/soc/fef00700.hdmi/rc/rc0 [ 7.352704] input: vc4-hdmi-0 as /devices/platform/soc/fef00700.hdmi/rc/rc0/input0 [ 7.385202] wm8804 1-003b: revision E [ 7.397438] vc4-drm gpu: bound fef00700.hdmi (ops vc4_hdmi_ops [vc4]) [ 7.427172] Registered IR keymap rc-cec [ 7.427411] rc rc1: vc4-hdmi-1 as /devices/platform/soc/fef05700.hdmi/rc/rc1 [ 7.427678] input: vc4-hdmi-1 as /devices/platform/soc/fef05700.hdmi/rc/rc1/input1 [ 7.472793] vc4-drm gpu: bound fef05700.hdmi (ops vc4_hdmi_ops [vc4]) [ 7.473573] vc4-drm gpu: bound fe004000.txp (ops vc4_txp_ops [vc4]) [ 7.495847] vc4-drm gpu: bound fe206000.pixelvalve (ops vc4_crtc_ops [vc4]) [ 7.496446] vc4-drm gpu: bound fe207000.pixelvalve (ops vc4_crtc_ops [vc4]) [ 7.496891] vc4-drm gpu: bound fe20a000.pixelvalve (ops vc4_crtc_ops [vc4]) [ 7.497197] vc4-drm gpu: bound fe216000.pixelvalve (ops vc4_crtc_ops [vc4]) [ 7.497660] vc4-drm gpu: bound fec12000.pixelvalve (ops vc4_crtc_ops [vc4]) [ 7.537937] [drm] Initialized vc4 0.0.0 20140616 for gpu on minor 1 [ 7.544007] vc4-drm gpu: [drm] Cannot find any crtc or sizes [ 8.110859] 8021q: 802.1Q VLAN Support v1.8 [ 8.347995] Adding 102396k swap on /var/swap. Priority:-2 extents:1 across:102396k SSFS [ 8.424821] EXT4-fs (sda2): mounted filesystem with ordered data mode. Quota mode: none. [ 8.465021] cfg80211: Loading compiled-in X.509 certificates for regulatory database [ 8.521153] cfg80211: Loaded X.509 cert 'sforshee: 00b28ddf47aef9cea7' [ 8.554335] cfg80211: loaded regulatory.db is malformed or signature is missing/invalid [ 8.664979] bcmgenet fd580000.ethernet: configuring instance for external RGMII (RX delay) [ 8.671430] bcmgenet fd580000.ethernet eth0: Link is Down [ 12.767174] bcmgenet fd580000.ethernet eth0: Link is Up - 1Gbps/Full - flow control rx/tx [ 12.767218] IPv6: ADDRCONF(NETDEV_CHANGE): eth0: link becomes ready [ 14.264696] bcm2835-i2s fe203000.i2s: I2S SYNC error! [ 14.274464] bcm2835-i2s fe203000.i2s: I2S SYNC error! [ 18.402844] ICMPv6: process `dhcpcd' is using deprecated sysctl (syscall) net.ipv6.neigh.eth0.retrans_time - use net.ipv6.neigh.eth0.retrans_time_ms instead [ 7868.848009] bcm2835-i2s fe203000.i2s: I2S SYNC error! [ 8266.433643] bcm2835-i2s fe203000.i2s: I2S SYNC error!

Logs

No response

Additional context

root@raspberrypi4:/# 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: sndrpihifiberry [snd_rpi_hifiberry_digi], device 0: HiFiBerry Digi+ Pro HiFi wm8804-spdif-0 [HiFiBerry Digi+ Pro HiFi wm8804-spdif-0] Subdevices: 1/1 Subdevice #0: subdevice #0 card 2: vc4hdmi1 [vc4-hdmi-1], device 0: MAI PCM i2s-hifi-0 [MAI PCM i2s-hifi-0] Subdevices: 1/1 Subdevice #0: subdevice #0

HiassofT commented 1 year ago

Reference cards by name, not by number (which is not guaranteed to be stable as you already know).

look at the output of aplay -L and use the PCM device of your card (eg hdmi:CARD=vc4hdmi0,DEV=0 or likely hw:CARD=sndrpihifiberry,DEV=0 in your case)

JimZipCode commented 1 year ago

Thanks! Changed mpd.conf From:

audio_output {
        type            "alsa"
        name            "My ALSA Device"
        device          "hw:1,0"        # optional
        mixer_type      "software"      # optional
}

To:

audio_output {
        type            "alsa"
        name            "My ALSA Device"
        device          "hw:CARD=sndrpihifiberry,DEV=0" # optional
        mixer_type      "software"      # optional
}

And it works! Nice thing about this solution, is that I should never notice if it's working or not. 👍
Appreciate the help!