search

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.15k stars 5k forks source link

DSI screen randomly failing on 6.1 kernel on Pi 3B+ #5801

Open lurch opened 10 months ago

lurch commented 10 months ago

Describe the bug

I'm running the latest version of Raspberry Pi OS Bookworm 32-bit (but the problem is also present in Bookworm 64-bit), fully up-to-date with apt. I've used raspi-config to configure it to boot directly to the console instead of to the desktop. I'm using a Raspberry Pi 3B+ with a Raspberry Pi Touch Display connected (powered according to https://www.raspberrypi.com/documentation/accessories/display.html#powering-the-touch-display ), I'm using an official Raspberry Pi Micro USB PSU, and I've got an Ethernet cable and USB mouse and keyboard connected.

Sometimes, when Linux has finished loading, if I type kmsprint it reports:

terminate called after throwing an instance of 'std::runtime_error'
  what():  failed to find DRM cards
Aborted

and if I then try running startx, it quickly fails with (EE) No devices detected.

Slightly frustratingly, this bug seems semi-random (possibly very timing-dependent) - sometimes after a reboot kmsprint will work successfully (and I can then run startx) and other times after a reboot kmsprint will display the error above. The problem only seems to manifest on a Pi 3B+, I wasn't able to reproduce the problem on a Pi5, a Pi4 or a Pi2. I was also unable to reproduce the problem after running rpi-update on my Pi 3B+.

@6by9 spent some time looking at the problem with me (after we reverted to the apt-installed kernel), and he says the fact that rpi-update fixes the problem is just a lucky coincidence (i.e. a quirk that affects the timing), he doesn't think there's any specific fix for the problem in the newer kernel. He says the underlying problem is that the Pi tries to read the Atmel firmware version over I2C, and gets the wrong value. In dmesg we have:

[    5.315265] rpi_touchscreen_attiny 10-0045: Unknown Atmel firmware revision: 0xe1

and Dave thinks this is 1-bit-shifted from the correct value.

If we have one of the "erroneous boots" and then run:

sudo rmmod rpi_panel_attiny_regulator
sudo modprobe rpi_panel_attiny_regulator

then this tries to re-read the Atmel firmware version again, and (in our limited testing) this seems to always work, and kmsprint then runs without error again.

We also tried setting force_turbo=1 in /boot/firmware/config.txt to see what impact that has on the problem, and that seems to always fix the problem. (So that's the temporary workaround for now)

Dave hooked up a logic-analyser to the I2C pins on the DSI display, and found that with force_turbo=1 then the I2C clock runs at 100KHz, but without that setting it runs at 66KHz.

Steps to reproduce the behaviour

  1. Flash 2023-12-05-raspios-bookworm-armhf.img.xz to an SD card.
  2. Don't connect the Raspberry Pi Touch Display yet! Connect a regular HDMI screen instead.
  3. Boot up the SD card in the Pi 3B+ and install all apt-updates (at the time of writing, uanme -a reports Linux bookworm32 6.1.0-rpi7-rpi-v7 #1 SMP Raspbian 1:6.1.63-1+rpt1 (2023-11-24) armv7l GNU/Linux)
  4. Use raspi-config to configure the Pi to "Console Autologin"
  5. Shut down the Pi 3B+, disconnect the HDMI display, connect the DSI Touch Display
  6. Power up the Pi, and run kmsprint at the console
  7. If it doesn't error, reboot and try step 6 again

EDIT: Step 3 above is optional, i.e. this problem also occurs on a freshly-flashed 2023-12-05-raspios-bookworm-armhf.img.xz before any apt-updates have been installed.

Device (s)

Raspberry Pi 3 Mod. B+

System

System Information

Raspberry Pi 3 Model B Plus Rev 1.3 PRETTY_NAME="Raspbian GNU/Linux 12 (bookworm)" NAME="Raspbian GNU/Linux" VERSION_ID="12" VERSION="12 (bookworm)"

Raspberry Pi reference 2023-12-05 Generated using pi-gen, https://github.com/RPi-Distro/pi-gen, 02b371de1a87bbe70cfcbd498527067a7d2ee6ca, stage5

Linux bookworm32 6.1.0-rpi7-rpi-v7 #1 SMP Raspbian 1:6.1.63-1+rpt1 (2023-11-24) armv7l GNU/Linux Revision : a020d3 Serial : 000000000c46a408 Model : Raspberry Pi 3 Model B Plus Rev 1.3 Throttled flag : throttled=0x0 Camera : supported=0 detected=0, libcamera interfaces=0

Videocore information

Oct 17 2023 15:42:39 Copyright (c) 2012 Broadcom version 30f0c5e4d076da3ab4f341d88e7d505760b93ad7 (clean) (release) (start)

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

Filesystem information

Filesystem 1K-blocks Used Available Use% Mounted on udev 332640 0 332640 0% /dev tmpfs 94412 1100 93312 2% /run /dev/mmcblk0p2 30063960 12298184 16412828 43% / tmpfs 472044 8 472036 1% /dev/shm tmpfs 5120 8 5112 1% /run/lock /dev/mmcblk0p1 522232 115696 406536 23% /boot/firmware tmpfs 94408 36 94372 1% /run/user/1000

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

Package version information

raspberrypi-ui-mods: Installed: 1.20231206 raspberrypi-sys-mods: Installed: 20231208 openbox: Installed: 3.6.1-10+rpt1 lxpanel: Installed: 0.10.1-2+rpt19 pcmanfm: Installed: 1.3.2-1+rpt18 rpd-plym-splash: Installed: 0.37

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 393 bytes 38342 (37.4 KiB) RX errors 0 dropped 0 overruns 0 frame 0 TX packets 330 bytes 47502 (46.3 KiB) 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 17 bytes 2075 (2.0 KiB) RX errors 0 dropped 0 overruns 0 frame 0 TX packets 17 bytes 2075 (2.0 KiB) TX errors 0 dropped 0 overruns 0 carrier 0 collisions 0

wlan0: flags=4099<UP,BROADCAST,MULTICAST> mtu 1500 ether m.m.m.m txqueuelen 1000 (Ethernet) RX packets 0 bytes 0 (0.0 B) RX errors 0 dropped 0 overruns 0 frame 0 TX packets 0 bytes 0 (0.0 B) TX errors 0 dropped 0 overruns 0 carrier 0 collisions 0

USB Information

/: Bus 01.Port 1: Dev 1, Class=root_hub, Driver=dwc_otg/1p, 480M | Port 1: Dev 2, If 0, Class=Hub, Driver=hub/4p, 480M | Port 1: Dev 3, If 0, Class=Hub, Driver=hub/3p, 480M | Port 1: Dev 6, If 0, Class=Vendor Specific Class, Driver=lan78xx, 480M | Port 2: Dev 4, If 0, Class=Hub, Driver=hub/4p, 480M | Port 1: Dev 5, If 1, Class=Human Interface Device, Driver=usbhid, 1.5M | Port 1: Dev 5, If 0, Class=Human Interface Device, Driver=usbhid, 1.5M |__ Port 2: Dev 7, If 0, Class=Human Interface Device, Driver=usbhid, 1.5M

Display Information

Running Legacy framebuffer

Framebuffer: /dev/fb0

mode "800x480" geometry 800 480 800 480 32 timings 0 0 0 0 0 0 0 rgba 8/16,8/8,8/0,8/24 endmode

/usr/bin/raspinfo: line 103: tvservice: command not found

config.txt

aphy_params_current=819 arm_boost=1 arm_freq=1400 arm_freq_min=600 audio_pwm_mode=514 auto_initramfs=1 camera_auto_detect=1 config_hdmi_boost=5 core_freq=400 desired_osc_freq=0x331df0 desired_osc_freq_boost=0x3c45b0 disable_commandline_tags=2 disable_fw_kms_setup=1 disable_l2cache=1 disable_overscan=1 display_auto_detect=1 display_default_lcd=1 display_hdmi_rotate=-1 display_lcd_rotate=-1 dphy_params_current=547 dvfs=3 enable_tvout=1 force_eeprom_read=1 force_pwm_open=1 framebuffer_ignore_alpha=1 framebuffer_swap=1 gpu_freq=300 hdmi_enable_4kp60=-1 init_uart_clock=0x2dc6c00 lcd_framerate=60 mask_gpu_interrupt0=3072 mask_gpu_interrupt1=30466 max_framebuffers=2 over_voltage_avs=43750 over_voltage_avs_boost=0x249f0 pause_burst_frames=1 pciex4_reset=1 program_serial_random=1 sdram_freq=450 total_mem=1024 hdmi_force_cec_address:0=65535 hdmi_force_cec_address:1=65535 hdmi_pixel_freq_limit:0=0x9a7ec80 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=0 snd_bcm2835.enable_headphones=0 snd_bcm2835.enable_headphones=1 snd_bcm2835.enable_hdmi=1 snd_bcm2835.enable_hdmi=0 vc_mem.mem_base=0x3ec00000 vc_mem.mem_size=0x40000000 console=ttyS0,115200 console=tty1 root=PARTUUID=a76e971f-02 rootfstype=ext4 fsck.repair=yes rootwait

pin configuration

0: ip -- | hi // ID_SDA/GPIO0 = input 1: ip -- | hi // ID_SCL/GPIO1 = input 2: ip -- | hi // SDA1/GPIO2 = input 3: ip -- | hi // SCL1/GPIO3 = input 4: ip -- | hi // GPIO_GCLK/GPIO4 = input 5: ip -- | hi // GPIO5 = input 6: ip -- | hi // GPIO6 = input 7: ip -- | hi // SPI_CE1_N/GPIO7 = input 8: ip -- | hi // SPI_CE0_N/GPIO8 = input 9: ip -- | lo // SPI_MISO/GPIO9 = input 10: ip -- | lo // SPI_MOSI/GPIO10 = input 11: ip -- | lo // SPI_SCLK/GPIO11 = input 12: ip -- | lo // GPIO12 = input 13: ip -- | lo // GPIO13 = input 14: ip -- | lo // TXD1/GPIO14 = input 15: ip -- | hi // RXD1/GPIO15 = input 16: ip -- | lo // GPIO16 = input 17: ip -- | lo // GPIO17 = input 18: ip -- | lo // GPIO18 = input 19: ip -- | lo // GPIO19 = input 20: ip -- | lo // GPIO20 = input 21: ip -- | lo // GPIO21 = input 22: ip -- | lo // GPIO22 = input 23: ip -- | lo // GPIO23 = input 24: ip -- | lo // GPIO24 = input 25: ip -- | lo // GPIO25 = input 26: ip -- | lo // GPIO26 = input 27: ip -- | lo // GPIO27 = input 28: ip -- | hi // HDMI_HPD_N/GPIO28 = input 29: op -- -- | lo // STATUS_LED_G/GPIO29 = output 30: a3 -- | lo // CTS0/GPIO30 = CTS0 31: a3 -- | lo // RTS0/GPIO31 = RTS0 32: a3 -- | hi // TXD0/GPIO32 = TXD0 33: a3 -- | hi // RXD0/GPIO33 = RXD0 34: a3 -- | lo // SD1_CLK/GPIO34 = SD1_CLK 35: a3 -- | hi // SD1_CMD/GPIO35 = SD1_CMD 36: a3 -- | hi // SD1_DATA0/GPIO36 = SD1_DAT0 37: a3 -- | hi // SD1_DATA1/GPIO37 = SD1_DAT1 38: a3 -- | hi // SD1_DATA2/GPIO38 = SD1_DAT2 39: a3 -- | hi // SD1_DATA3/GPIO39 = SD1_DAT3 40: a0 -- | lo // PWM0_OUT/GPIO40 = PWM0 41: a0 -- | lo // PWM1_OUT/GPIO41 = PWM1 42: a0 -- | lo // ETH_CLK/GPIO42 = GPCLK1 43: a0 -- | lo // WIFI_CLK/GPIO43 = GPCLK2 44: a1 -- | hi // SDA0/GPIO44 = SDA0 45: a1 -- | hi // SCL0/GPIO45 = SCL0 46: ip -- | hi // SMPS_SCL/GPIO46 = input 47: op -- -- | hi // SMPS_SDA/GPIO47 = output 48: a0 -- | lo // SD_CLK_R/GPIO48 = SD0_CLK 49: a0 -- | hi // SD_CMD_R/GPIO49 = SD0_CMD 50: a0 -- | hi // SD_DATA0_R/GPIO50 = SD0_DAT0 51: a0 -- | hi // SD_DATA1_R/GPIO51 = SD0_DAT1 52: a0 -- | hi // SD_DATA2_R/GPIO52 = SD0_DAT2 53: a0 -- | hi // SD_DATA3_R/GPIO53 = SD0_DAT3

vcdbg log messages

001109.202: brfs: File read: /mfs/sd/config.txt 001110.055: brfs: File read: 1194 bytes 001142.973: HDMI0:EDID error reading EDID block 0 attempt 0 001144.239: HDMI0:EDID error reading EDID block 0 attempt 1 001145.505: HDMI0:EDID error reading EDID block 0 attempt 2 001146.768: HDMI0:EDID error reading EDID block 0 attempt 3 001148.035: HDMI0:EDID error reading EDID block 0 attempt 4 001149.299: HDMI0:EDID error reading EDID block 0 attempt 5 001150.566: HDMI0:EDID error reading EDID block 0 attempt 6 001151.829: HDMI0:EDID error reading EDID block 0 attempt 7 001153.096: HDMI0:EDID error reading EDID block 0 attempt 8 001154.361: HDMI0:EDID error reading EDID block 0 attempt 9 001155.385: HDMI0:EDID giving up on reading EDID block 0 001159.934: brfs: File read: /mfs/sd/config.txt 001697.185: gpioman: gpioman_get_pin_num: pin DISPLAY_DSI_PORT not defined 001999.786: *** Restart logging 001999.814: brfs: File read: 1194 bytes 002001.125: hdmi: HDMI0:EDID error reading EDID block 0 attempt 0 002002.395: hdmi: HDMI0:EDID error reading EDID block 0 attempt 1 002003.662: hdmi: HDMI0:EDID error reading EDID block 0 attempt 2 002004.932: hdmi: HDMI0:EDID error reading EDID block 0 attempt 3 002006.202: hdmi: HDMI0:EDID error reading EDID block 0 attempt 4 002007.471: hdmi: HDMI0:EDID error reading EDID block 0 attempt 5 002008.739: hdmi: HDMI0:EDID error reading EDID block 0 attempt 6 002010.009: hdmi: HDMI0:EDID error reading EDID block 0 attempt 7 002011.278: hdmi: HDMI0:EDID error reading EDID block 0 attempt 8 002012.548: hdmi: HDMI0:EDID error reading EDID block 0 attempt 9 002013.574: hdmi: HDMI0:EDID giving up on reading EDID block 0 002013.904: hdmi: HDMI0:EDID error reading EDID block 0 attempt 0 002015.174: hdmi: HDMI0:EDID error reading EDID block 0 attempt 1 002016.442: hdmi: HDMI0:EDID error reading EDID block 0 attempt 2 002017.712: hdmi: HDMI0:EDID error reading EDID block 0 attempt 3 002018.981: hdmi: HDMI0:EDID error reading EDID block 0 attempt 4 002020.251: hdmi: HDMI0:EDID error reading EDID block 0 attempt 5 002021.519: hdmi: HDMI0:EDID error reading EDID block 0 attempt 6 002022.789: hdmi: HDMI0:EDID error reading EDID block 0 attempt 7 002024.058: hdmi: HDMI0:EDID error reading EDID block 0 attempt 8 002025.329: hdmi: HDMI0:EDID error reading EDID block 0 attempt 9 002026.354: hdmi: HDMI0:EDID giving up on reading EDID block 0 002026.398: hdmi: HDMI:hdmi_get_state is deprecated, use hdmi_get_display_state instead 002026.421: HDMI0: hdmi_pixel_encoding: 162000000 002026.682: vec: vec_middleware_power_on: vec_base: 0x7e806000 rev-id 0x00002708 @ vec: 0x7e806100 @ 0x00000420 enc: 0x7e806060 @ 0x00000220 cgmsae: 0x7e80605c @ 0x00000000 003001.851: brfs: File read: /mfs/sd/initramfs7 003001.876: Loaded 'initramfs7' to 0x0 size 0xf450f0 003019.921: initramfs loaded to 0x2e0ba000 (size 0xf450f0) 003024.176: dtb_file 'bcm2710-rpi-3-b-plus.dtb' 003024.204: brfs: File read: 16011504 bytes 003030.354: brfs: File read: /mfs/sd/bcm2710-rpi-3-b-plus.dtb 003030.378: Loaded 'bcm2710-rpi-3-b-plus.dtb' to 0x100 size 0x8586 003045.637: brfs: File read: 34182 bytes 003060.053: brfs: File read: /mfs/sd/overlays/overlay_map.dtb 003093.529: brfs: File read: 4871 bytes 003098.757: brfs: File read: /mfs/sd/config.txt 003098.919: dtparam: audio=on 003105.833: brfs: File read: 1194 bytes 003124.166: brfs: File read: /mfs/sd/overlays/vc4-kms-v3d.dtbo 003170.592: Loaded overlay 'vc4-kms-v3d' 003282.955: brfs: File read: 2760 bytes 003301.825: brfs: File read: /mfs/sd/overlays/vc4-kms-dsi-7inch.dtbo 003336.945: Loaded overlay 'vc4-kms-dsi-7inch' 003456.622: brfs: File read: 4336 bytes 003460.665: brfs: File read: /mfs/sd/cmdline.txt 003460.717: Read command line from file 'cmdline.txt': 003460.734: 'console=serial0,115200 console=tty1 root=PARTUUID=a76e971f-02 rootfstype=ext4 fsck.repair=yes rootwait' 003607.763: gpioman: gpioman_get_pin_num: pin EMMC_ENABLE not defined 003675.674: brfs: File read: 102 bytes 004095.863: brfs: File read: /mfs/sd/kernel7.img 004095.888: Loaded 'kernel7.img' to 0x8000 size 0x6b2af0 004095.924: Device tree loaded to 0x2e0b1000 (size 0x8f83) 004101.646: gpioman: gpioman_get_pin_num: pin SDCARD_CONTROL_POWER not defined 008011.018: vchiq_core: vchiq_init_state: slot_zero = 0xde180000, is_master = 1

dmesg log

[ 0.000000] Booting Linux on physical CPU 0x0 [ 0.000000] Linux version 6.1.0-rpi7-rpi-v7 (debian-kernel@lists.debian.org) (gcc-12 (Raspbian 12.2.0-14+rpi1) 12.2.0, GNU ld (GNU Binutils for Raspbian) 2.40) #1 SMP Raspbian 1:6.1.63-1+rpt1 (2023-11-24) [ 0.000000] CPU: ARMv7 Processor [410fd034] revision 4 (ARMv7), cr=10c5383d [ 0.000000] CPU: div instructions available: patching division code [ 0.000000] CPU: PIPT / VIPT nonaliasing data cache, VIPT aliasing instruction cache [ 0.000000] OF: fdt: Machine model: Raspberry Pi 3 Model B Plus Rev 1.3 [ 0.000000] random: crng init done [ 0.000000] Memory policy: Data cache writealloc [ 0.000000] Reserved memory: created CMA memory pool at 0x1e000000, size 256 MiB [ 0.000000] OF: reserved mem: initialized node linux,cma, compatible id shared-dma-pool [ 0.000000] Zone ranges: [ 0.000000] DMA [mem 0x0000000000000000-0x000000003b3fffff] [ 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] Initmem setup node 0 [mem 0x0000000000000000-0x000000003b3fffff] [ 0.000000] percpu: Embedded 17 pages/cpu s37012 r8192 d24428 u69632 [ 0.000000] pcpu-alloc: s37012 r8192 d24428 u69632 alloc=17*4096 [ 0.000000] pcpu-alloc: [0] 0 [0] 1 [0] 2 [0] 3 [ 0.000000] Built 1 zonelists, mobility grouping on. Total pages: 240555 [ 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 vc_mem.mem_base=0x3ec00000 vc_mem.mem_size=0x40000000 console=ttyS0,115200 console=tty1 root=PARTUUID=a76e971f-02 rootfstype=ext4 fsck.repair=yes rootwait [ 0.000000] Dentry cache hash table entries: 131072 (order: 7, 524288 bytes, linear) [ 0.000000] Inode-cache hash table entries: 65536 (order: 6, 262144 bytes, linear) [ 0.000000] mem auto-init: stack:all(zero), heap alloc:off, heap free:off [ 0.000000] Memory: 665280K/970752K available (10240K kernel code, 1455K rwdata, 3104K rodata, 1024K init, 611K bss, 43328K reserved, 262144K cma-reserved) [ 0.000000] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=4, Nodes=1 [ 0.000000] ftrace: allocating 33785 entries in 100 pages [ 0.000000] ftrace: allocated 99 pages with 4 groups [ 0.000000] trace event string verifier disabled [ 0.000000] rcu: Hierarchical RCU implementation. [ 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 10 jiffies. [ 0.000000] NR_IRQS: 16, nr_irqs: 16, preallocated irqs: 16 [ 0.000000] rcu: srcu_init: Setting srcu_struct sizes based on contention. [ 0.000000] arch_timer: cp15 timer(s) running at 19.20MHz (phys). [ 0.000000] clocksource: arch_sys_counter: mask: 0xffffffffffffff max_cycles: 0x46d987e47, max_idle_ns: 440795202767 ns [ 0.000001] sched_clock: 56 bits at 19MHz, resolution 52ns, wraps every 4398046511078ns [ 0.000018] Switching to timer-based delay loop, resolution 52ns [ 0.000393] Console: colour dummy device 80x30 [ 0.001013] printk: console [tty1] enabled [ 0.001074] Calibrating delay loop (skipped), value calculated using timer frequency.. 38.40 BogoMIPS (lpj=192000) [ 0.001120] CPU: Testing write buffer coherency: ok [ 0.001187] pid_max: default: 32768 minimum: 301 [ 0.001328] LSM: Security Framework initializing [ 0.001536] Mount-cache hash table entries: 2048 (order: 1, 8192 bytes, linear) [ 0.001581] Mountpoint-cache hash table entries: 2048 (order: 1, 8192 bytes, linear) [ 0.002740] cgroup: Disabling memory control group subsystem [ 0.003329] CPU0: thread -1, cpu 0, socket 0, mpidr 80000000 [ 0.004196] cblist_init_generic: Setting adjustable number of callback queues. [ 0.004229] cblist_init_generic: Setting shift to 2 and lim to 1. [ 0.004360] cblist_init_generic: Setting adjustable number of callback queues. [ 0.004392] cblist_init_generic: Setting shift to 2 and lim to 1. [ 0.004539] Setting up static identity map for 0x100000 - 0x10003c [ 0.004697] rcu: Hierarchical SRCU implementation. [ 0.004721] rcu: Max phase no-delay instances is 1000. [ 0.005503] smp: Bringing up secondary CPUs ... [ 0.006426] CPU1: thread -1, cpu 1, socket 0, mpidr 80000001 [ 0.007381] CPU2: thread -1, cpu 2, socket 0, mpidr 80000002 [ 0.008229] CPU3: thread -1, cpu 3, socket 0, mpidr 80000003 [ 0.008330] smp: Brought up 1 node, 4 CPUs [ 0.008413] SMP: Total of 4 processors activated (153.60 BogoMIPS). [ 0.008441] CPU: All CPU(s) started in HYP mode. [ 0.008460] CPU: Virtualization extensions available. [ 0.009227] devtmpfs: initialized [ 0.023381] VFP support v0.3: implementor 41 architecture 3 part 40 variant 3 rev 4 [ 0.023630] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 19112604462750000 ns [ 0.023684] futex hash table entries: 1024 (order: 4, 65536 bytes, linear) [ 0.033964] pinctrl core: initialized pinctrl subsystem [ 0.035148] NET: Registered PF_NETLINK/PF_ROUTE protocol family [ 0.037773] DMA: preallocated 1024 KiB pool for atomic coherent allocations [ 0.042751] audit: initializing netlink subsys (disabled) [ 0.042993] audit: type=2000 audit(0.040:1): state=initialized audit_enabled=0 res=1 [ 0.043589] thermal_sys: Registered thermal governor 'step_wise' [ 0.043958] hw-breakpoint: found 5 (+1 reserved) breakpoint and 4 watchpoint registers. [ 0.044011] hw-breakpoint: maximum watchpoint size is 8 bytes. [ 0.044288] Serial: AMBA PL011 UART driver [ 0.053310] platform 3f101000.cprman: Fixed dependency cycle(s) with /soc/dsi@7e700000 [ 0.053844] bcm2835-mbox 3f00b880.mailbox: mailbox enabled [ 0.055664] platform 3f700000.dsi: Fixed dependency cycle(s) with /soc/dsi@7e700000/bridge@0/ports/port@0/endpoint [ 0.070084] raspberrypi-firmware soc:firmware: Attached to firmware from 2023-10-17T15:42:39, variant start [ 0.080098] raspberrypi-firmware soc:firmware: Firmware hash is 30f0c5e4d076da3ab4f341d88e7d505760b93ad7 [ 0.121525] kprobes: kprobe jump-optimization is enabled. All kprobes are optimized if possible. [ 0.128424] bcm2835-dma 3f007000.dma: DMA legacy API manager, dmachans=0x1 [ 0.130120] SCSI subsystem initialized [ 0.130374] usbcore: registered new interface driver usbfs [ 0.130448] usbcore: registered new interface driver hub [ 0.130515] usbcore: registered new device driver usb [ 0.130762] usb_phy_generic phy: supply vcc not found, using dummy regulator [ 0.131176] pps_core: LinuxPPS API ver. 1 registered [ 0.131201] pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti giometti@linux.it [ 0.131250] PTP clock support registered [ 0.133043] clocksource: Switched to clocksource arch_sys_counter [ 0.133614] VFS: Disk quotas dquot_6.6.0 [ 0.133697] VFS: Dquot-cache hash table entries: 1024 (order 0, 4096 bytes) [ 0.133872] FS-Cache: Loaded [ 0.134098] CacheFiles: Loaded [ 0.145877] NET: Registered PF_INET protocol family [ 0.146242] IP idents hash table entries: 16384 (order: 5, 131072 bytes, linear) [ 0.148713] tcp_listen_portaddr_hash hash table entries: 512 (order: 0, 4096 bytes, linear) [ 0.148774] Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear) [ 0.148988] TCP established hash table entries: 8192 (order: 3, 32768 bytes, linear) [ 0.149129] TCP bind hash table entries: 8192 (order: 5, 131072 bytes, linear) [ 0.149478] TCP: Hash tables configured (established 8192 bind 8192) [ 0.149639] UDP hash table entries: 512 (order: 2, 16384 bytes, linear) [ 0.149713] UDP-Lite hash table entries: 512 (order: 2, 16384 bytes, linear) [ 0.149951] NET: Registered PF_UNIX/PF_LOCAL protocol family [ 0.150463] RPC: Registered named UNIX socket transport module. [ 0.150491] RPC: Registered udp transport module. [ 0.150512] RPC: Registered tcp transport module. [ 0.150533] RPC: Registered tcp NFSv4.1 backchannel transport module. [ 0.151019] Trying to unpack rootfs image as initramfs... [ 0.163194] hw perfevents: enabled with armv7_cortex_a7 PMU driver, 7 counters available [ 1.970073] Freeing initrd memory: 15640K [ 2.098648] Initialise system trusted keyrings [ 2.099087] workingset: timestamp_bits=14 max_order=18 bucket_order=4 [ 2.108269] zbud: loaded [ 2.110709] NFS: Registering the id_resolver key type [ 2.110774] Key type id_resolver registered [ 2.110797] Key type id_legacy registered [ 2.110934] nfs4filelayout_init: NFSv4 File Layout Driver Registering... [ 2.110963] nfs4flexfilelayout_init: NFSv4 Flexfile Layout Driver Registering... [ 2.112324] Key type asymmetric registered [ 2.112352] Asymmetric key parser 'x509' registered [ 2.112543] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 247) [ 2.112578] io scheduler mq-deadline registered [ 2.112602] io scheduler kyber registered [ 2.117208] simple-framebuffer 3ea81000.framebuffer: framebuffer at 0x3ea81000, 0x177000 bytes [ 2.117270] simple-framebuffer 3ea81000.framebuffer: format=a8r8g8b8, mode=800x480x32, linelength=3200 [ 2.122479] Console: switching to colour frame buffer device 100x30 [ 2.129462] simple-framebuffer 3ea81000.framebuffer: fb0: simplefb registered! [ 2.136822] bcm2835-rng 3f104000.rng: hwrng registered [ 2.139724] vc-mem: phys_addr:0x00000000 mem_base=0x3ec00000 mem_size:0x40000000(1024 MiB) [ 2.153740] brd: module loaded [ 2.163536] loop: module loaded [ 2.166724] Loading iSCSI transport class v2.0-870. [ 2.170657] usbcore: registered new interface driver lan78xx [ 2.173269] usbcore: registered new interface driver smsc95xx [ 2.175749] dwc_otg: version 3.00a 10-AUG-2012 (platform bus) [ 2.906361] Core Release: 2.80a [ 2.908849] Setting default values for core params [ 2.911340] Finished setting default values for core params [ 3.114081] Using Buffer DMA mode [ 3.116487] Periodic Transfer Interrupt Enhancement - disabled [ 3.118948] Multiprocessor Interrupt Enhancement - disabled [ 3.121424] OTG VER PARAM: 0, OTG VER FLAG: 0 [ 3.123905] Dedicated Tx FIFOs mode

[ 3.127248] WARN::dwc_otg_hcd_init:1072: FIQ DMA bounce buffers: virt = 9e104000 dma = 0xde104000 len=9024 [ 3.134504] FIQ FSM acceleration enabled for : Non-periodic Split Transactions Periodic Split Transactions High-Speed Isochronous Endpoints Interrupt/Control Split Transaction hack enabled [ 3.145983] dwc_otg: Microframe scheduler enabled

[ 3.146098] WARN::hcd_init_fiq:457: FIQ on core 1

[ 3.150326] WARN::hcd_init_fiq:458: FIQ ASM at 807f2b78 length 36

[ 3.154429] WARN::hcd_init_fiq:496: MPHI regs_base at bb810000 [ 3.158631] dwc_otg 3f980000.usb: DWC OTG Controller [ 3.160840] dwc_otg 3f980000.usb: new USB bus registered, assigned bus number 1 [ 3.163112] dwc_otg 3f980000.usb: irq 89, io mem 0x00000000 [ 3.165343] Init: Port Power? op_state=1 [ 3.167510] Init: Power Port (0) [ 3.169849] usb usb1: New USB device found, idVendor=1d6b, idProduct=0002, bcdDevice= 6.01 [ 3.172108] usb usb1: New USB device strings: Mfr=3, Product=2, SerialNumber=1 [ 3.174357] usb usb1: Product: DWC OTG Controller [ 3.176555] usb usb1: Manufacturer: Linux 6.1.0-rpi7-rpi-v7 dwc_otg_hcd [ 3.178789] usb usb1: SerialNumber: 3f980000.usb [ 3.181653] hub 1-0:1.0: USB hub found [ 3.183951] hub 1-0:1.0: 1 port detected [ 3.186699] dwc_otg: FIQ enabled [ 3.186709] dwc_otg: NAK holdoff enabled [ 3.186717] dwc_otg: FIQ split-transaction FSM enabled [ 3.186736] Module dwc_common_port init [ 3.187045] usbcore: registered new interface driver usb-storage [ 3.189359] mousedev: PS/2 mouse device common for all mice [ 3.194233] sdhci: Secure Digital Host Controller Interface driver [ 3.196396] sdhci: Copyright(c) Pierre Ossman [ 3.198804] sdhci-pltfm: SDHCI platform and OF driver helper [ 3.203239] ledtrig-cpu: registered to indicate activity on CPUs [ 3.205733] hid: raw HID events driver (C) Jiri Kosina [ 3.208072] usbcore: registered new interface driver usbhid [ 3.210304] usbhid: USB HID core driver [ 3.216840] Initializing XFRM netlink socket [ 3.219118] NET: Registered PF_PACKET protocol family [ 3.221411] Key type dns_resolver registered [ 3.223812] Registering SWP/SWPB emulation handler [ 3.226586] registered taskstats version 1 [ 3.228759] Loading compiled-in X.509 certificates [ 3.277715] Loaded X.509 cert 'Debian Secure Boot CA: 6ccece7e4c6c0d1f6149f3dd27dfcc5cbb419ea1' [ 3.313238] Indeed it is in host mode hprt0 = 00021501 [ 3.333174] Loaded X.509 cert 'Debian Secure Boot Signer 2022 - linux: 14011249c2675ea8e5148542202005810584b25f' [ 3.376246] Key type .fscrypt registered [ 3.378568] Key type fscrypt-provisioning registered [ 3.392347] uart-pl011 3f201000.serial: cts_event_workaround enabled [ 3.394943] 3f201000.serial: ttyAMA1 at MMIO 0x3f201000 (irq = 114, base_baud = 0) is a PL011 rev2 [ 3.399982] serial serial0: tty port ttyAMA1 registered [ 3.404384] bcm2835-wdt bcm2835-wdt: Broadcom BCM2835 watchdog timer [ 3.407204] bcm2835-power bcm2835-power: Broadcom BCM2835 power domains driver [ 3.411073] mmc-bcm2835 3f300000.mmcnr: mmc_debug:0 mmc_debug2:0 [ 3.413682] mmc-bcm2835 3f300000.mmcnr: DMA channel allocated [ 3.444090] sdhost: log_buf @ 8af02967 (de103000) [ 3.496991] mmc0: sdhost-bcm2835 loaded - DMA enabled (>1) [ 3.501780] of_cfs_init [ 3.504522] of_cfs_init: OK [ 3.514066] Freeing unused kernel image (initmem) memory: 1024K [ 3.523078] usb 1-1: new high-speed USB device number 2 using dwc_otg [ 3.525760] Indeed it is in host mode hprt0 = 00001101 [ 3.588798] Run /init as init process [ 3.591318] with arguments: [ 3.591327] /init [ 3.591335] with environment: [ 3.591341] HOME=/ [ 3.591348] TERM=linux [ 3.599398] mmc0: host does not support reading read-only switch, assuming write-enable [ 3.606787] mmc0: new high speed SDHC card at address aaaa [ 3.610460] mmcblk0: mmc0:aaaa SL32G 29.7 GiB [ 3.616818] mmc1: new high speed SDIO card at address 0001 [ 3.625819] mmcblk0: p1 p2 [ 3.629525] mmcblk0: mmc0:aaaa SL32G 29.7 GiB (quirks 0x00004000) [ 3.773451] usb 1-1: New USB device found, idVendor=0424, idProduct=2514, bcdDevice= b.b3 [ 3.776166] usb 1-1: New USB device strings: Mfr=0, Product=0, SerialNumber=0 [ 3.779448] hub 1-1:1.0: USB hub found [ 3.782229] hub 1-1:1.0: 4 ports detected [ 4.113127] usb 1-1.1: new high-speed USB device number 3 using dwc_otg [ 4.245717] usb 1-1.1: New USB device found, idVendor=0424, idProduct=2514, bcdDevice= b.b3 [ 4.248258] usb 1-1.1: New USB device strings: Mfr=0, Product=0, SerialNumber=0 [ 4.252102] hub 1-1.1:1.0: USB hub found [ 4.271129] hub 1-1.1:1.0: 3 ports detected [ 4.328554] i2c i2c-11: Added multiplexed i2c bus 0 [ 4.332020] i2c i2c-11: Added multiplexed i2c bus 10 [ 4.383182] usb 1-1.2: new high-speed USB device number 4 using dwc_otg [ 4.525635] usb 1-1.2: New USB device found, idVendor=05e3, idProduct=0610, bcdDevice=32.98 [ 4.528567] usb 1-1.2: New USB device strings: Mfr=0, Product=1, SerialNumber=0 [ 4.531381] usb 1-1.2: Product: USB2.0 Hub [ 4.543504] hub 1-1.2:1.0: USB hub found [ 4.546669] hub 1-1.2:1.0: 4 ports detected [ 4.573480] rpi_touchscreen_attiny 10-0045: Unknown Atmel firmware revision: 0xe1 [ 4.621260] mipi-dsi 3f700000.dsi.0: Fixed dependency cycle(s) with /soc/dsi@7e700000/port/endpoint [ 4.632248] mipi-dsi 3f700000.dsi.0: Fixed dependency cycle(s) with /panel_disp@1/port/endpoint [ 4.873080] usb 1-1.2.1: new low-speed USB device number 5 using dwc_otg [ 5.123092] usb 1-1.1.1: new high-speed USB device number 6 using dwc_otg [ 5.153555] usb 1-1.2.1: New USB device found, idVendor=04d9, idProduct=0006, bcdDevice= 1.10 [ 5.153755] usb 1-1.2.1: New USB device strings: Mfr=1, Product=2, SerialNumber=0 [ 5.153928] usb 1-1.2.1: Product: RPI Wired Keyboard 1 [ 5.154052] usb 1-1.2.1: Manufacturer:
[ 5.203521] EXT4-fs (mmcblk0p2): mounted filesystem with ordered data mode. Quota mode: none. [ 5.223638] input: RPI Wired Keyboard 1 as /devices/platform/soc/3f980000.usb/usb1/1-1/1-1.2/1-1.2.1/1-1.2.1:1.0/0003:04D9:0006.0001/input/input0 [ 5.253598] usb 1-1.1.1: New USB device found, idVendor=0424, idProduct=7800, bcdDevice= 3.00 [ 5.253832] usb 1-1.1.1: New USB device strings: Mfr=0, Product=0, SerialNumber=0 [ 5.295439] hid-generic 0003:04D9:0006.0001: input,hidraw0: USB HID v1.11 Keyboard [ RPI Wired Keyboard 1] on usb-3f980000.usb-1.2.1/input0 [ 5.350065] input: RPI Wired Keyboard 1 as /devices/platform/soc/3f980000.usb/usb1/1-1/1-1.2/1-1.2.1/1-1.2.1:1.1/0003:04D9:0006.0002/input/input1 [ 5.423476] hid-generic 0003:04D9:0006.0002: input,hidraw1: USB HID v1.11 Device [ RPI Wired Keyboard 1] on usb-3f980000.usb-1.2.1/input1 [ 5.519191] lan78xx 1-1.1.1:1.0 (unnamed net_device) (uninitialized): No External EEPROM. Setting MAC Speed [ 5.531634] lan78xx 1-1.1.1:1.0 (unnamed net_device) (uninitialized): int urb period 64 [ 5.533124] usb 1-1.2.2: new low-speed USB device number 7 using dwc_otg [ 5.689313] usb 1-1.2.2: New USB device found, idVendor=093a, idProduct=2510, bcdDevice= 1.00 [ 5.693397] usb 1-1.2.2: New USB device strings: Mfr=1, Product=2, SerialNumber=0 [ 5.697368] usb 1-1.2.2: Product: USB Optical Mouse [ 5.701268] usb 1-1.2.2: Manufacturer: PixArt [ 5.710170] input: PixArt USB Optical Mouse as /devices/platform/soc/3f980000.usb/usb1/1-1/1-1.2/1-1.2.2/1-1.2.2:1.0/0003:093A:2510.0003/input/input2 [ 5.718584] hid-generic 0003:093A:2510.0003: input,hidraw2: USB HID v1.11 Mouse [PixArt USB Optical Mouse] on usb-3f980000.usb-1.2.2/input0 [ 6.111579] systemd[1]: System time before build time, advancing clock. [ 6.369932] NET: Registered PF_INET6 protocol family [ 6.375595] Segment Routing with IPv6 [ 6.379681] In-situ OAM (IOAM) with IPv6 [ 6.502329] systemd[1]: systemd 252.17-1~deb12u1+rpi1 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) [ 6.520592] systemd[1]: Detected architecture arm. [ 6.535311] systemd[1]: Hostname set to . [ 8.016462] systemd[1]: Queued start job for default target multi-user.target. [ 8.067874] systemd[1]: Created slice system-getty.slice - Slice /system/getty. [ 8.075112] systemd[1]: Created slice system-modprobe.slice - Slice /system/modprobe. [ 8.082941] systemd[1]: Created slice system-systemd\x2dfsck.slice - Slice /system/systemd-fsck. [ 8.089330] systemd[1]: Created slice user.slice - User and Session Slice. [ 8.096522] systemd[1]: Started systemd-ask-password-wall.path - Forward Password Requests to Wall Directory Watch. [ 8.108878] systemd[1]: Set up automount proc-sys-fs-binfmt_misc.automount - Arbitrary Executable File Formats File System Automount Point. [ 8.120271] systemd[1]: Reached target integritysetup.target - Local Integrity Protected Volumes. [ 8.128897] systemd[1]: Reached target slices.target - Slice Units. [ 8.136609] systemd[1]: Reached target swap.target - Swaps. [ 8.144968] systemd[1]: Reached target veritysetup.target - Local Verity Protected Volumes. [ 8.154305] systemd[1]: Listening on systemd-fsckd.socket - fsck to fsckd communication Socket. [ 8.161938] systemd[1]: Listening on systemd-initctl.socket - initctl Compatibility Named Pipe. [ 8.171875] systemd[1]: Listening on systemd-journald-audit.socket - Journal Audit Socket. [ 8.180096] systemd[1]: Listening on systemd-journald-dev-log.socket - Journal Socket (/dev/log). [ 8.189255] systemd[1]: Listening on systemd-journald.socket - Journal Socket. [ 8.203608] systemd[1]: Listening on systemd-udevd-control.socket - udev Control Socket. [ 8.209522] systemd[1]: Listening on systemd-udevd-kernel.socket - udev Kernel Socket. [ 8.218862] systemd[1]: dev-hugepages.mount - Huge Pages File System was skipped because of an unmet condition check (ConditionPathExists=/sys/kernel/mm/hugepages). [ 8.303532] systemd[1]: Mounting dev-mqueue.mount - POSIX Message Queue File System... [ 8.314661] systemd[1]: Mounting sys-kernel-debug.mount - Kernel Debug File System... [ 8.326319] systemd[1]: Mounting sys-kernel-tracing.mount - Kernel Trace File System... [ 8.332917] systemd[1]: auth-rpcgss-module.service - Kernel Module supporting RPCSEC_GSS was skipped because of an unmet condition check (ConditionPathExists=/etc/krb5.keytab). [ 8.343104] systemd[1]: Starting fake-hwclock.service - Restore / save the current clock... [ 8.362486] systemd[1]: Starting keyboard-setup.service - Set the console keyboard layout... [ 8.375758] systemd[1]: Starting kmod-static-nodes.service - Create List of Static Device Nodes... [ 8.393895] systemd[1]: Starting modprobe@configfs.service - Load Kernel Module configfs... [ 8.408179] systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod... [ 8.423807] systemd[1]: Starting modprobe@drm.service - Load Kernel Module drm... [ 8.442097] systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore... [ 8.462868] systemd[1]: Starting modprobe@fuse.service - Load Kernel Module fuse... [ 8.486546] systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop... [ 8.496247] 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). [ 8.518493] systemd[1]: Starting systemd-journald.service - Journal Service... [ 8.540117] systemd[1]: Starting systemd-modules-load.service - Load Kernel Modules... [ 8.545981] device-mapper: ioctl: 4.47.0-ioctl (2022-07-28) initialised: dm-devel@redhat.com [ 8.565996] fuse: init (API version 7.37) [ 8.569897] systemd[1]: Starting systemd-remount-fs.service - Remount Root and Kernel File Systems... [ 8.592375] systemd[1]: Starting systemd-udev-trigger.service - Coldplug All udev Devices... [ 8.645032] systemd[1]: Mounted dev-mqueue.mount - POSIX Message Queue File System. [ 8.652695] i2c_dev: i2c /dev entries driver [ 8.687342] systemd[1]: Mounted sys-kernel-debug.mount - Kernel Debug File System. [ 8.693575] EXT4-fs (mmcblk0p2): re-mounted. Quota mode: none. [ 8.708505] systemd[1]: Mounted sys-kernel-tracing.mount - Kernel Trace File System. [ 8.715490] systemd[1]: Finished fake-hwclock.service - Restore / save the current clock. [ 8.732261] systemd[1]: Finished kmod-static-nodes.service - Create List of Static Device Nodes. [ 8.747530] systemd[1]: modprobe@configfs.service: Deactivated successfully. [ 8.748421] systemd[1]: Finished modprobe@configfs.service - Load Kernel Module configfs. [ 8.759917] systemd[1]: modprobe@dm_mod.service: Deactivated successfully. [ 8.760868] systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod. [ 8.773198] systemd[1]: modprobe@drm.service: Deactivated successfully. [ 8.774133] systemd[1]: Finished modprobe@drm.service - Load Kernel Module drm. [ 8.795549] systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. [ 8.796445] systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore. [ 8.815991] systemd[1]: modprobe@fuse.service: Deactivated successfully. [ 8.817020] systemd[1]: Finished modprobe@fuse.service - Load Kernel Module fuse. [ 8.828980] systemd[1]: modprobe@loop.service: Deactivated successfully. [ 8.829852] systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop. [ 8.841662] systemd[1]: Finished systemd-modules-load.service - Load Kernel Modules. [ 8.851084] systemd[1]: Finished systemd-remount-fs.service - Remount Root and Kernel File Systems. [ 9.023639] systemd[1]: Mounting sys-fs-fuse-connections.mount - FUSE Control File System... [ 9.035318] systemd[1]: Mounting sys-kernel-config.mount - Kernel Configuration File System... [ 9.049145] systemd[1]: systemd-firstboot.service - First Boot Wizard was skipped because of an unmet condition check (ConditionFirstBoot=yes). [ 9.049773] systemd[1]: systemd-pstore.service - Platform Persistent Storage Archival was skipped because of an unmet condition check (ConditionDirectoryNotEmpty=/sys/fs/pstore). [ 9.067996] systemd[1]: Starting systemd-random-seed.service - Load/Save Random Seed... [ 9.088559] systemd[1]: systemd-repart.service - Repartition Root Disk was skipped because no trigger condition checks were met. [ 9.109733] systemd[1]: Starting systemd-sysctl.service - Apply Kernel Variables... [ 9.129674] systemd[1]: Starting systemd-sysusers.service - Create System Users... [ 9.167153] systemd[1]: Started systemd-journald.service - Journal Service. [ 9.322631] systemd-journald[241]: Received client request to flush runtime journal. [ 9.351146] systemd-journald[241]: File /var/log/journal/ecb814f3ead44030b0ccd132adda21be/system.journal corrupted or uncleanly shut down, renaming and replacing. [ 11.065545] vc_sm_cma: module is from the staging directory, the quality is unknown, you have been warned. [ 11.067999] bcm2835_vc_sm_cma_probe: Videocore shared memory driver

[ 11.069162] [vc_sm_connected_init]: installed successfully [ 11.095364] mc: Linux media interface: v0.10 [ 11.095580] snd_bcm2835: module is from the staging directory, the quality is unknown, you have been warned. [ 11.143904] bcm2835_audio bcm2835_audio: card created with 8 channels [ 11.227426] videodev: Linux video capture interface: v2.00 [ 11.233270] rpi-gpiomem 3f200000.gpiomem: window base 0x3f200000 size 0x00001000 [ 11.233657] rpi-gpiomem 3f200000.gpiomem: initialised 1 regions as /dev/gpiomem [ 11.345039] bcm2835_mmal_vchiq: module is from the staging directory, the quality is unknown, you have been warned. [ 11.390434] bcm2835_v4l2: module is from the staging directory, the quality is unknown, you have been warned. [ 11.403704] bcm2835_isp: module is from the staging directory, the quality is unknown, you have been warned. [ 11.416630] bcm2835-isp bcm2835-isp: Device node output[0] registered as /dev/video13 [ 11.420398] bcm2835-isp bcm2835-isp: Device node capture[0] registered as /dev/video14 [ 11.420903] bcm2835-isp bcm2835-isp: Device node capture[1] registered as /dev/video15 [ 11.421235] bcm2835-isp bcm2835-isp: Device node stats[2] registered as /dev/video16 [ 11.421268] bcm2835-isp bcm2835-isp: Register output node 0 with media controller [ 11.421290] bcm2835-isp bcm2835-isp: Register capture node 1 with media controller [ 11.421307] bcm2835-isp bcm2835-isp: Register capture node 2 with media controller [ 11.421323] bcm2835-isp bcm2835-isp: Register capture node 3 with media controller [ 11.432247] bcm2835_codec: module is from the staging directory, the quality is unknown, you have been warned. [ 11.433470] bcm2835-isp bcm2835-isp: Device node output[0] registered as /dev/video20 [ 11.435868] bcm2835-isp bcm2835-isp: Device node capture[0] registered as /dev/video21 [ 11.436491] bcm2835-isp bcm2835-isp: Device node capture[1] registered as /dev/video22 [ 11.436922] bcm2835-isp bcm2835-isp: Device node stats[2] registered as /dev/video23 [ 11.436975] bcm2835-isp bcm2835-isp: Register output node 0 with media controller [ 11.436999] bcm2835-isp bcm2835-isp: Register capture node 1 with media controller [ 11.437015] bcm2835-isp bcm2835-isp: Register capture node 2 with media controller [ 11.437032] bcm2835-isp bcm2835-isp: Register capture node 3 with media controller [ 11.446551] bcm2835-isp bcm2835-isp: Loaded V4L2 bcm2835-isp [ 11.449391] bcm2835-codec bcm2835-codec: Device registered as /dev/video10 [ 11.449455] bcm2835-codec bcm2835-codec: Loaded V4L2 decode [ 11.564846] bcm2835-codec bcm2835-codec: Device registered as /dev/video11 [ 11.564913] bcm2835-codec bcm2835-codec: Loaded V4L2 encode [ 11.577451] bcm2835-codec bcm2835-codec: Device registered as /dev/video12 [ 11.577508] bcm2835-codec bcm2835-codec: Loaded V4L2 isp [ 11.584313] bcm2835-codec bcm2835-codec: Device registered as /dev/video18 [ 11.584371] bcm2835-codec bcm2835-codec: Loaded V4L2 image_fx [ 11.596487] bcm2835-codec bcm2835-codec: Device registered as /dev/video31 [ 11.596541] bcm2835-codec bcm2835-codec: Loaded V4L2 encode_image [ 12.275615] cfg80211: Loading compiled-in X.509 certificates for regulatory database [ 12.435985] cfg80211: Loaded X.509 cert 'benh@debian.org: 577e021cb980e0e820821ba7b54b4961b8b4fadf' [ 12.438633] cfg80211: Loaded X.509 cert 'romain.perier@gmail.com: 3abbc6ec146e09d1b6016ab9d6cf71dd233f0328' [ 12.441566] cfg80211: Loaded X.509 cert 'sforshee: 00b28ddf47aef9cea7' [ 12.668614] Bluetooth: Core ver 2.22 [ 12.668783] NET: Registered PF_BLUETOOTH protocol family [ 12.668795] Bluetooth: HCI device and connection manager initialized [ 12.676706] brcmfmac: F1 signature read @0x18000000=0x15264345 [ 12.683193] Bluetooth: HCI socket layer initialized [ 12.683257] Bluetooth: L2CAP socket layer initialized [ 12.683273] brcmfmac: brcmf_fw_alloc_request: using brcm/brcmfmac43455-sdio for chip BCM4345/6 [ 12.683313] Bluetooth: SCO socket layer initialized [ 12.684208] usbcore: registered new interface driver brcmfmac [ 12.849293] Bluetooth: HCI UART driver ver 2.3 [ 12.849323] Bluetooth: HCI UART protocol H4 registered [ 12.849430] Bluetooth: HCI UART protocol Three-wire (H5) registered [ 12.851842] hci_uart_bcm serial0-0: supply vbat not found, using dummy regulator [ 12.852112] hci_uart_bcm serial0-0: supply vddio not found, using dummy regulator [ 12.882767] Bluetooth: HCI UART protocol Broadcom registered [ 12.949858] brcmfmac: brcmf_c_preinit_dcmds: Firmware: BCM4345/6 wl0: Nov 1 2021 00:37:25 version 7.45.241 (1a2f2fa CY) FWID 01-703fd60 [ 12.963347] uart-pl011 3f201000.serial: no DMA platform data [ 13.229647] Bluetooth: hci0: BCM: chip id 107 [ 13.230032] Bluetooth: hci0: BCM: features 0x2f [ 13.231340] Bluetooth: hci0: BCM4345C0 [ 13.231377] Bluetooth: hci0: BCM4345C0 (003.001.025) build 0000 [ 13.243346] Bluetooth: hci0: BCM4345C0 'brcm/BCM4345C0.raspberrypi,3-model-b-plus.hcd' Patch [ 13.583676] Adding 102396k swap on /var/swap. Priority:-2 extents:1 across:102396k SSFS [ 14.094206] Bluetooth: hci0: BCM: features 0x2f [ 14.102679] Bluetooth: hci0: BCM43455 37.4MHz Raspberry Pi 3+-0190 [ 14.102705] Bluetooth: hci0: BCM4345C0 (003.001.025) build 0382 [ 14.103208] Bluetooth: hci0: BCM: Using default device address (m.m.m.m) [ 15.720632] lan78xx 1-1.1.1:1.0 eth0: Link is Up - 1Gbps/Full - flow control rx/tx [ 15.722839] IPv6: ADDRCONF(NETDEV_CHANGE): eth0: link becomes ready [ 15.722937] NOHZ tick-stop error: local softirq work is pending, handler #08!!! [ 15.857571] brcmfmac: brcmf_cfg80211_set_power_mgmt: power save enabled [ 16.124556] Bluetooth: BNEP (Ethernet Emulation) ver 1.3 [ 16.124578] Bluetooth: BNEP filters: protocol multicast [ 16.124595] Bluetooth: BNEP socket layer initialized [ 16.145465] Bluetooth: MGMT ver 1.22 [ 16.176131] NET: Registered PF_ALG protocol family [ 16.219181] cryptd: max_cpu_qlen set to 1000 [ 22.414452] Bluetooth: RFCOMM TTY layer initialized [ 22.414489] Bluetooth: RFCOMM socket layer initialized [ 22.414524] Bluetooth: RFCOMM ver 1.11 [ 23.513749] platform 1.reg_bridge: deferred probe pending [ 23.513777] platform 1.panel_disp: deferred probe pending [ 23.513789] mipi-dsi 3f700000.dsi.0: deferred probe pending

Logs

[ 5.315265] rpi_touchscreen_attiny 10-0045: Unknown Atmel firmware revision: 0xe1

Additional context

No response

b1c1l1 commented 2 months ago

Thank you for documenting this issue and workaround!

I am also experiencing this issue with a Raspberry Pi 3B+ and Raspberry Pi Touch Display running 2024-07-04-raspios-bookworm-armhf.img. The display would regularly fail to be initialized during boot, and dmesg would show the same Unknown Atmel firmware revision: 0xe1 message.

Enabling force_turbo=1 seems to have resolved the issue for me.