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.13k stars 4.99k forks source link

"bcm2835_codec_buf_prepare data will not fit into plane" messages from bcm2835-codec #4482

Closed pelwell closed 3 years ago

pelwell commented 3 years ago

Recently I've started seeing some new error messages from the bcm2835-codec driver (a V4L2 wrapper around the VPU-based codecs). The messages are of the following form:

bcm2835-codec bcm2835-codec: bcm2835_codec_buf_prepare data will not fit into plane (1536 < 792576)

I'll add more details (kernel versions, circumstances) as I find them, but until then this is here as a placeholder and early warning.

pelwell commented 3 years ago

@jc-kynesim You may want to keep one eye on this thread.

randomMesh commented 3 years ago

I'll add more details (kernel versions, circumstances) as I find them

I see a lot of these on my Raspberry Pi 400 and here's the output of raspinfo. Hope this helps.

System Information
------------------

Raspberry Pi 400 Rev 1.0
PRETTY_NAME="Raspbian GNU/Linux 10 (buster)"
NAME="Raspbian GNU/Linux"
VERSION_ID="10"
VERSION="10 (buster)"

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

Linux alix 5.10.17-v7l+ #1421 SMP Thu May 27 14:00:13 BST 2021 armv7l GNU/Linux
Revision    : c03130
Serial      : 1000000000b1dcd0
Model       : Raspberry Pi 400 Rev 1.0
Throttled flag  : throttled=0x0
Camera          : supported=0 detected=0

Videocore information
---------------------

May 27 2021 14:02:15 
Copyright (c) 2012 Broadcom
version 7d9a298cda813f747b51fe17e1e417e7bf5ca94d (clean) (release) (start)

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

Filesystem information
----------------------
Dateisystem    1K-Bl\u00f6cke Benutzt Verf\u00fcgbar Verw% Eingeh\u00e4ngt auf
/dev/root       14987608 9350632   4928724   66% /
devtmpfs         1736388       0   1736388    0% /dev
tmpfs            1868484   20652   1847832    2% /dev/shm
tmpfs            1868484    8736   1859748    1% /run
tmpfs               5120       4      5116    1% /run/lock
tmpfs            1868484       0   1868484    0% /sys/fs/cgroup
/dev/mmcblk0p1    258095   48788    209307   19% /boot
tmpfs             373696       4    373692    1% /run/user/1001

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

Package version information
---------------------------
raspberrypi-ui-mods:
  Installiert:           1.20210706
raspberrypi-sys-mods:
  Installiert:           20210706
openbox:
  Installiert:           3.6.1-8+rpt5
lxpanel:
  Installiert:           0.10.0-2+rpt15
pcmanfm:
  Installiert:           1.3.1-1+rpt27
rpd-plym-splash:
  Installiert:           0.26

Networking Information
----------------------

eth0: 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

lo: flags=73<UP,LOOPBACK,RUNNING>  mtu 65536
        inet x.x.x.x  netmask x.x.x.x
        inet6 ::1  prefixlen 128  scopeid 0x10<host>
        loop  txqueuelen 1000  (Lokale Schleife)
        RX packets 438818  bytes 54946589 (52.4 MiB)
        RX errors 0  dropped 0  overruns 0  frame 0
        TX packets 438818  bytes 54946589 (52.4 MiB)
        TX errors 0  dropped 0 overruns 0  carrier 0  collisions 0

wlan0: 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<link>
        inet6 y.y.y.y.y.y.y.y  prefixlen 64  scopeid 0x0<global>
        ether m.m.m.m  txqueuelen 1000  (Ethernet)
        RX packets 144439  bytes 173238816 (165.2 MiB)
        RX errors 0  dropped 0  overruns 0  frame 0
        TX packets 57596  bytes 9524279 (9.0 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
/:  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
        |__ Port 3: Dev 3, If 0, Class=Human Interface Device, Driver=usbhid, 1.5M
        |__ Port 4: Dev 4, If 1, Class=Human Interface Device, Driver=usbhid, 1.5M
        |__ Port 4: Dev 4, If 0, Class=Human Interface Device, Driver=usbhid, 1.5M

config.txt
----------

arm_freq=1800
audio_pwm_mode=514
config_hdmi_boost=5
core_freq=500
core_freq_min=200
disable_commandline_tags=2
disable_l2cache=1
disable_overscan=1
display_hdmi_rotate=-1
display_lcd_rotate=-1
dvfs=2
enable_gic=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=1024
mask_gpu_interrupt1=0x10000
max_framebuffers=2
over_voltage=0x11170
over_voltage_avs=-20000
pause_burst_frames=1
program_serial_random=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=0 snd_bcm2835.enable_compat_alsa=0 snd_bcm2835.enable_hdmi=1 video=HDMI-A-1:1920x1080M@60 smsc95xx.macaddr=E4:5F:01:23:2B:FC vc_mem.mem_base=0x3ec00000 vc_mem.mem_size=0x40000000  console=ttyS0,115200 console=tty1 root=PARTUUID=9981d7c3-02 rootfstype=ext4 elevator=deadline fsck.repair=yes rootwait

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=0 func=INPUT pull=UP
GPIO 3: level=1 fsel=0 func=INPUT pull=UP
GPIO 4: level=1 fsel=0 func=INPUT pull=UP
GPIO 5: level=1 fsel=0 func=INPUT pull=UP
GPIO 6: level=1 fsel=0 func=INPUT 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=0 func=INPUT pull=NONE
GPIO 15: level=1 fsel=0 func=INPUT 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=0 func=INPUT pull=DOWN
GPIO 19: level=0 fsel=0 func=INPUT pull=DOWN
GPIO 20: level=0 fsel=0 func=INPUT pull=DOWN
GPIO 21: level=0 fsel=0 func=INPUT 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=7 alt=3 func=CTS0 pull=UP
GPIO 31: level=1 fsel=7 alt=3 func=RTS0 pull=NONE
GPIO 32: level=1 fsel=7 alt=3 func=TXD0 pull=NONE
GPIO 33: level=1 fsel=7 alt=3 func=RXD0 pull=UP
GPIO 34: level=0 fsel=7 alt=3 func=SD1_CLK pull=NONE
GPIO 35: level=1 fsel=7 alt=3 func=SD1_CMD pull=UP
GPIO 36: level=1 fsel=7 alt=3 func=SD1_DAT0 pull=UP
GPIO 37: level=1 fsel=7 alt=3 func=SD1_DAT1 pull=UP
GPIO 38: level=1 fsel=7 alt=3 func=SD1_DAT2 pull=UP
GPIO 39: level=1 fsel=7 alt=3 func=SD1_DAT3 pull=UP
GPIO 40: level=1 fsel=0 func=INPUT pull=NONE
GPIO 41: level=1 fsel=0 func=INPUT pull=NONE
GPIO 42: level=1 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
------------------

003935.118: arasan: arasan_emmc_open
004093.618: brfs: File read: /mfs/sd/config.txt
004094.441: brfs: File read: 1829 bytes
004188.776: brfs: File read: /mfs/sd/config.txt
004205.142: brfs: File read: 1829 bytes
004210.185: gpioman: gpioman_get_pin_num: pin FLASH_0_ENABLE not defined
004210.200: gpioman: gpioman_get_pin_num: pin FLASH_0_INDICATOR not defined
004210.230: gpioman: gpioman_get_pin_num: pin FLASH_0_ENABLE not defined
004210.248: gpioman: gpioman_get_pin_num: pin FLASH_0_INDICATOR not defined
004664.967: gpioman: gpioman_get_pin_num: pin DISPLAY_DSI_PORT not defined
004667.468: *** Restart logging
004708.983: hdmi: HDMI:hdmi_get_state is deprecated, use hdmi_get_display_state instead
004708.999: HDMI0: hdmi_pixel_encoding: 300000000
004709.011: HDMI1: hdmi_pixel_encoding: 300000000
004709.673: gpioman: gpioman_get_pin_num: pin CAMERA_0_I2C_PORT not defined
004713.950: dtb_file 'bcm2711-rpi-400.dtb'
004721.081: brfs: File read: /mfs/sd/bcm2711-rpi-400.dtb
004721.099: Loading 'bcm2711-rpi-400.dtb' to 0x100 size 0xbeaa
004733.570: brfs: File read: 48810 bytes
004747.551: brfs: File read: /mfs/sd/overlays/overlay_map.dtb
004813.989: brfs: File read: 1523 bytes
004818.257: brfs: File read: /mfs/sd/config.txt
004818.770: dtparam: audio=on
004828.699: brfs: File read: 1829 bytes
004843.640: brfs: File read: /mfs/sd/overlays/vc4-fkms-v3d.dtbo
004860.737: Loaded overlay 'vc4-fkms-v3d'
004894.929: brfs: File read: 1446 bytes
004897.667: brfs: File read: /mfs/sd/overlays/vc4-fkms-v3d.dtbo
004931.899: Loaded overlay 'vc4-fkms-v3d'
004931.966: dtparam: act_led_trigger=default-on
005064.131: brfs: File read: 1446 bytes
005068.474: brfs: File read: /mfs/sd/cmdline.txt
005068.557: Read command line from file 'cmdline.txt':
005068.584: 'console=serial0,115200 console=tty1 root=PARTUUID=9981d7c3-02 rootfstype=ext4 elevator=deadline fsck.repair=yes rootwait'
006114.567: brfs: File read: 121 bytes
007460.482: brfs: File read: /mfs/sd/kernel7l.img
007460.521: Loading 'kernel7l.img' to 0x8000 size 0x662680
007460.573: Device tree loaded to 0x2eff3b00 (size 0xc4cf)
007467.878: gpioman: gpioman_get_pin_num: pin SDCARD_CONTROL_POWER not defined
011009.860: vchiq_core: vchiq_init_state: slot_zero = 0xded80000, is_master = 1
011013.450: hdmi: HDMI:hdmi_get_state is deprecated, use hdmi_get_display_state instead
011021.649: TV service:host side not connected, dropping notification 0x00000002, 0x00000001, 0x00000010
015597.270: TV service:host side not connected, dropping notification 0x00000008, 0x00000004, 0x00000000

dmesg log
---------

[    0.000000] Booting Linux on physical CPU 0x0
[    0.000000] Linux version 5.10.17-v7l+ (dom@buildbot) (arm-linux-gnueabihf-gcc-8 (Ubuntu/Linaro 8.4.0-3ubuntu1) 8.4.0, GNU ld (GNU Binutils for Ubuntu) 2.34) #1421 SMP Thu May 27 14:00:13 BST 2021
[    0.000000] CPU: ARMv7 Processor [410fd083] revision 3 (ARMv7), cr=30c5383d
[    0.000000] CPU: div instructions available: patching division code
[    0.000000] CPU: PIPT / VIPT nonaliasing data cache, PIPT instruction cache
[    0.000000] OF: fdt: Machine model: Raspberry Pi 400 Rev 1.0
[    0.000000] Memory policy: Data cache writealloc
[    0.000000] Reserved memory: created CMA memory pool at 0x000000001ec00000, 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-0x000000002fffffff]
[    0.000000]   Normal   empty
[    0.000000]   HighMem  [mem 0x0000000030000000-0x00000000fbffffff]
[    0.000000] Movable zone start for each node
[    0.000000] Early memory node ranges
[    0.000000]   node   0: [mem 0x0000000000000000-0x000000002fffffff]
[    0.000000]   node   0: [mem 0x0000000040000000-0x00000000fbffffff]
[    0.000000] Initmem setup node 0 [mem 0x0000000000000000-0x00000000fbffffff]
[    0.000000] On node 0 totalpages: 966656
[    0.000000]   DMA zone: 2304 pages used for memmap
[    0.000000]   DMA zone: 0 pages reserved
[    0.000000]   DMA zone: 196608 pages, LIFO batch:63
[    0.000000]   HighMem zone: 770048 pages, LIFO batch:63
[    0.000000] percpu: Embedded 20 pages/cpu s50700 r8192 d23028 u81920
[    0.000000] pcpu-alloc: s50700 r8192 d23028 u81920 alloc=20*4096
[    0.000000] pcpu-alloc: [0] 0 [0] 1 [0] 2 [0] 3 
[    0.000000] Built 1 zonelists, mobility grouping on.  Total pages: 964352
[    0.000000] Kernel command line: coherent_pool=1M 8250.nr_uarts=0 snd_bcm2835.enable_compat_alsa=0 snd_bcm2835.enable_hdmi=1 video=HDMI-A-1:1920x1080M@60 smsc95xx.macaddr=m.m.m.m vc_mem.mem_base=0x3ec00000 vc_mem.mem_size=0x40000000  console=ttyS0,115200 console=tty1 root=PARTUUID=9981d7c3-02 rootfstype=ext4 elevator=deadline fsck.repair=yes rootwait
[    0.000000] Kernel parameter elevator= does not have any effect anymore.
               Please use sysfs to set IO scheduler for individual devices.
[    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:off, heap alloc:off, heap free:off
[    0.000000] software IO TLB: mapped [mem 0x0000000017cc0000-0x000000001bcc0000] (64MB)
[    0.000000] Memory: 3472780K/3866624K available (10240K kernel code, 1358K rwdata, 3160K rodata, 2048K init, 890K bss, 131700K reserved, 262144K cma-reserved, 3080192K highmem)
[    0.000000] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=4, Nodes=1
[    0.000000] ftrace: allocating 33942 entries in 67 pages
[    0.000000] ftrace: allocated 67 pages with 3 groups
[    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] GIC: Using split EOI/Deactivate mode
[    0.000000] random: get_random_bytes called from start_kernel+0x3c8/0x59c with crng_init=0
[    0.000008] sched_clock: 32 bits at 1000kHz, resolution 1000ns, wraps every 2147483647500ns
[    0.000035] clocksource: timer: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275 ns
[    0.000104] bcm2835: system timer (irq = 25)
[    0.000758] arch_timer: cp15 timer(s) running at 54.00MHz (phys).
[    0.000780] clocksource: arch_sys_counter: mask: 0xffffffffffffff max_cycles: 0xc743ce346, max_idle_ns: 440795203123 ns
[    0.000802] sched_clock: 56 bits at 54MHz, resolution 18ns, wraps every 4398046511102ns
[    0.000820] Switching to timer-based delay loop, resolution 18ns
[    0.001088] Console: colour dummy device 80x30
[    0.001831] printk: console [tty1] enabled
[    0.001896] Calibrating delay loop (skipped), value calculated using timer frequency.. 108.00 BogoMIPS (lpj=540000)
[    0.001952] pid_max: default: 32768 minimum: 301
[    0.002133] LSM: Security Framework initializing
[    0.002334] Mount-cache hash table entries: 2048 (order: 1, 8192 bytes, linear)
[    0.002381] Mountpoint-cache hash table entries: 2048 (order: 1, 8192 bytes, linear)
[    0.004038] Disabling memory control group subsystem
[    0.004183] CPU: Testing write buffer coherency: ok
[    0.004692] CPU0: thread -1, cpu 0, socket 0, mpidr 80000000
[    0.005956] Setting up static identity map for 0x200000 - 0x20003c
[    0.006177] rcu: Hierarchical SRCU implementation.
[    0.007162] smp: Bringing up secondary CPUs ...
[    0.008471] CPU1: thread -1, cpu 1, socket 0, mpidr 80000001
[    0.009907] CPU2: thread -1, cpu 2, socket 0, mpidr 80000002
[    0.011394] CPU3: thread -1, cpu 3, socket 0, mpidr 80000003
[    0.011555] smp: Brought up 1 node, 4 CPUs
[    0.011602] SMP: Total of 4 processors activated (432.00 BogoMIPS).
[    0.011633] CPU: All CPU(s) started in HYP mode.
[    0.011659] CPU: Virtualization extensions available.
[    0.012543] devtmpfs: initialized
[    0.026730] VFP support v0.3: implementor 41 architecture 3 part 40 variant 8 rev 0
[    0.026991] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 19112604462750000 ns
[    0.027047] futex hash table entries: 1024 (order: 4, 65536 bytes, linear)
[    0.034503] pinctrl core: initialized pinctrl subsystem
[    0.035630] NET: Registered protocol family 16
[    0.040023] DMA: preallocated 1024 KiB pool for atomic coherent allocations
[    0.040875] audit: initializing netlink subsys (disabled)
[    0.041160] audit: type=2000 audit(0.040:1): state=initialized audit_enabled=0 res=1
[    0.041750] thermal_sys: Registered thermal governor 'step_wise'
[    0.042468] hw-breakpoint: found 5 (+1 reserved) breakpoint and 4 watchpoint registers.
[    0.042523] hw-breakpoint: maximum watchpoint size is 8 bytes.
[    0.042961] Serial: AMBA PL011 UART driver
[    0.075064] bcm2835-mbox fe00b880.mailbox: mailbox enabled
[    0.090933] raspberrypi-firmware soc:firmware: Attached to firmware from 2021-05-27T14:02:15, variant start
[    0.100944] raspberrypi-firmware soc:firmware: Firmware hash is 7d9a298cda813f747b51fe17e1e417e7bf5ca94d
[    0.145660] bcm2835-dma fe007000.dma: DMA legacy API manager, dmachans=0x1
[    0.149937] vgaarb: loaded
[    0.150405] SCSI subsystem initialized
[    0.150650] usbcore: registered new interface driver usbfs
[    0.150725] usbcore: registered new interface driver hub
[    0.150814] usbcore: registered new device driver usb
[    0.151551] usb_phy_generic phy: supply vcc not found, using dummy regulator
[    0.153538] clocksource: Switched to clocksource arch_sys_counter
[    1.154608] VFS: Disk quotas dquot_6.6.0
[    1.154751] VFS: Dquot-cache hash table entries: 1024 (order 0, 4096 bytes)
[    1.154958] FS-Cache: Loaded
[    1.155171] CacheFiles: Loaded
[    1.156292] simple-framebuffer 3e402000.framebuffer: framebuffer at 0x3e402000, 0x7f8000 bytes, mapped to 0x(ptrval)
[    1.156338] simple-framebuffer 3e402000.framebuffer: format=a8r8g8b8, mode=1920x1080x32, linelength=7680
[    1.167570] Console: switching to colour frame buffer device 240x67
[    1.177764] simple-framebuffer 3e402000.framebuffer: fb0: simplefb registered!
[    1.186642] NET: Registered protocol family 2
[    1.187648] tcp_listen_portaddr_hash hash table entries: 512 (order: 0, 6144 bytes, linear)
[    1.187879] TCP established hash table entries: 8192 (order: 3, 32768 bytes, linear)
[    1.188029] TCP bind hash table entries: 8192 (order: 4, 65536 bytes, linear)
[    1.188175] TCP: Hash tables configured (established 8192 bind 8192)
[    1.188415] UDP hash table entries: 512 (order: 2, 16384 bytes, linear)
[    1.188521] UDP-Lite hash table entries: 512 (order: 2, 16384 bytes, linear)
[    1.188854] NET: Registered protocol family 1
[    1.189682] RPC: Registered named UNIX socket transport module.
[    1.189763] RPC: Registered udp transport module.
[    1.189828] RPC: Registered tcp transport module.
[    1.189891] RPC: Registered tcp NFSv4.1 backchannel transport module.
[    1.189979] PCI: CLS 0 bytes, default 64
[    1.193049] Initialise system trusted keyrings
[    1.193375] workingset: timestamp_bits=14 max_order=20 bucket_order=6
[    1.202199] zbud: loaded
[    1.204273] FS-Cache: Netfs 'nfs' registered for caching
[    1.205127] NFS: Registering the id_resolver key type
[    1.205231] Key type id_resolver registered
[    1.205293] Key type id_legacy registered
[    1.205485] nfs4filelayout_init: NFSv4 File Layout Driver Registering...
[    1.206644] Key type asymmetric registered
[    1.206710] Asymmetric key parser 'x509' registered
[    1.206959] bounce: pool size: 64 pages
[    1.207057] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 249)
[    1.207362] io scheduler mq-deadline registered
[    1.207431] io scheduler kyber registered
[    1.212111] brcm-pcie fd500000.pcie: host bridge /scb/pcie@7d500000 ranges:
[    1.212225] brcm-pcie fd500000.pcie:   No bus range found for /scb/pcie@7d500000, using [bus 00-ff]
[    1.212393] brcm-pcie fd500000.pcie:      MEM 0x0600000000..0x063fffffff -> 0x00c0000000
[    1.212579] brcm-pcie fd500000.pcie:   IB MEM 0x0000000000..0x00ffffffff -> 0x0400000000
[    1.275642] brcm-pcie fd500000.pcie: link up, 5.0 GT/s PCIe x1 (SSC)
[    1.278981] brcm-pcie fd500000.pcie: PCI host bridge to bus 0000:00
[    1.281913] pci_bus 0000:00: root bus resource [bus 00-ff]
[    1.284892] pci_bus 0000:00: root bus resource [mem 0x600000000-0x63fffffff] (bus address [0xc0000000-0xffffffff])
[    1.287867] pci 0000:00:00.0: [14e4:2711] type 01 class 0x060400
[    1.291016] pci 0000:00:00.0: PME# supported from D0 D3hot
[    1.297453] PCI: bus0: Fast back to back transfers disabled
[    1.300722] pci 0000:01:00.0: [1106:3483] type 00 class 0x0c0330
[    1.303744] pci 0000:01:00.0: reg 0x10: [mem 0x00000000-0x00000fff 64bit]
[    1.307158] pci 0000:01:00.0: PME# supported from D0 D3hot
[    1.313449] PCI: bus1: Fast back to back transfers disabled
[    1.316391] pci 0000:00:00.0: BAR 8: assigned [mem 0x600000000-0x6000fffff]
[    1.319211] pci 0000:01:00.0: BAR 0: assigned [mem 0x600000000-0x600000fff 64bit]
[    1.322101] pci 0000:00:00.0: PCI bridge to [bus 01]
[    1.324915] pci 0000:00:00.0:   bridge window [mem 0x600000000-0x6000fffff]
[    1.328156] pcieport 0000:00:00.0: enabling device (0140 -> 0142)
[    1.331194] pcieport 0000:00:00.0: PME: Signaling with IRQ 62
[    1.342705] iproc-rng200 fe104000.rng: hwrng registered
[    1.345996] vc-mem: phys_addr:0x00000000 mem_base=0x3ec00000 mem_size:0x40000000(1024 MiB)
[    1.349732] gpiomem-bcm2835 fe200000.gpiomem: Initialised: Registers at 0xfe200000
[    1.365204] brd: module loaded
[    1.380754] loop: module loaded
[    1.385456] Loading iSCSI transport class v2.0-870.
[    1.390829] libphy: Fixed MDIO Bus: probed
[    1.395500] bcmgenet fd580000.ethernet: GENET 5.0 EPHY: 0x0000
[    1.413572] libphy: bcmgenet MII bus: probed
[    1.493722] unimac-mdio unimac-mdio.-19: Broadcom UniMAC MDIO bus
[    1.497787] usbcore: registered new interface driver r8152
[    1.500650] usbcore: registered new interface driver lan78xx
[    1.503419] usbcore: registered new interface driver smsc95xx
[    1.558215] xhci_hcd 0000:01:00.0: xHCI Host Controller
[    1.560960] xhci_hcd 0000:01:00.0: new USB bus registered, assigned bus number 1
[    1.566944] xhci_hcd 0000:01:00.0: hcc params 0x002841eb hci version 0x100 quirks 0x0000030000000890
[    1.570972] usb usb1: New USB device found, idVendor=1d6b, idProduct=0002, bcdDevice= 5.10
[    1.573745] usb usb1: New USB device strings: Mfr=3, Product=2, SerialNumber=1
[    1.576463] usb usb1: Product: xHCI Host Controller
[    1.579155] usb usb1: Manufacturer: Linux 5.10.17-v7l+ xhci-hcd
[    1.581839] usb usb1: SerialNumber: 0000:01:00.0
[    1.585270] hub 1-0:1.0: USB hub found
[    1.587994] hub 1-0:1.0: 1 port detected
[    1.591322] xhci_hcd 0000:01:00.0: xHCI Host Controller
[    1.594082] xhci_hcd 0000:01:00.0: new USB bus registered, assigned bus number 2
[    1.596808] xhci_hcd 0000:01:00.0: Host supports USB 3.0 SuperSpeed
[    1.599951] usb usb2: New USB device found, idVendor=1d6b, idProduct=0003, bcdDevice= 5.10
[    1.602641] usb usb2: New USB device strings: Mfr=3, Product=2, SerialNumber=1
[    1.605398] usb usb2: Product: xHCI Host Controller
[    1.608085] usb usb2: Manufacturer: Linux 5.10.17-v7l+ xhci-hcd
[    1.610799] usb usb2: SerialNumber: 0000:01:00.0
[    1.614272] hub 2-0:1.0: USB hub found
[    1.617028] hub 2-0:1.0: 4 ports detected
[    1.621539] dwc_otg: version 3.00a 10-AUG-2012 (platform bus)
[    1.624621] dwc_otg: FIQ enabled
[    1.624636] dwc_otg: NAK holdoff enabled
[    1.624650] dwc_otg: FIQ split-transaction FSM enabled
[    1.624668] Module dwc_common_port init
[    1.625156] usbcore: registered new interface driver uas
[    1.627941] usbcore: registered new interface driver usb-storage
[    1.630805] mousedev: PS/2 mouse device common for all mice
[    1.636829] bcm2835-wdt bcm2835-wdt: Broadcom BCM2835 watchdog timer
[    1.643660] sdhci: Secure Digital Host Controller Interface driver
[    1.646359] sdhci: Copyright(c) Pierre Ossman
[    1.649731] mmc-bcm2835 fe300000.mmcnr: could not get clk, deferring probe
[    1.652981] sdhci-pltfm: SDHCI platform and OF driver helper
[    1.658807] ledtrig-cpu: registered to indicate activity on CPUs
[    1.661902] hid: raw HID events driver (C) Jiri Kosina
[    1.664860] usbcore: registered new interface driver usbhid
[    1.667558] usbhid: USB HID core driver
[    1.676285] Initializing XFRM netlink socket
[    1.679101] NET: Registered protocol family 17
[    1.682078] Key type dns_resolver registered
[    1.685161] Registering SWP/SWPB emulation handler
[    1.687950] registered taskstats version 1
[    1.690568] Loading compiled-in X.509 certificates
[    1.694370] Key type ._fscrypt registered
[    1.696991] Key type .fscrypt registered
[    1.699587] Key type fscrypt-provisioning registered
[    1.713864] uart-pl011 fe201000.serial: there is not valid maps for state default
[    1.716825] uart-pl011 fe201000.serial: cts_event_workaround enabled
[    1.719477] fe201000.serial: ttyAMA0 at MMIO 0xfe201000 (irq = 36, base_baud = 0) is a PL011 rev2
[    1.729004] bcm2835-power bcm2835-power: Broadcom BCM2835 power domains driver
[    1.732776] mmc-bcm2835 fe300000.mmcnr: mmc_debug:0 mmc_debug2:0
[    1.735484] mmc-bcm2835 fe300000.mmcnr: DMA channel allocated
[    1.767320] of_cfs_init
[    1.770258] of_cfs_init: OK
[    1.783107] mmc1: queuing unknown CIS tuple 0x80 (2 bytes)
[    1.787435] mmc1: queuing unknown CIS tuple 0x80 (3 bytes)
[    1.791689] mmc1: queuing unknown CIS tuple 0x80 (3 bytes)
[    1.797331] mmc1: queuing unknown CIS tuple 0x80 (7 bytes)
[    1.801542] mmc1: queuing unknown CIS tuple 0x80 (3 bytes)
[    1.807383] mmc0: SDHCI controller on fe340000.emmc2 [fe340000.emmc2] using ADMA
[    1.810700] Waiting for root device PARTUUID=9981d7c3-02...
[    1.847537] random: fast init done
[    1.877100] mmc1: new high speed SDIO card at address 0001
[    1.912440] mmc0: new ultra high speed DDR50 SDHC card at address aaaa
[    1.916056] mmcblk0: mmc0:aaaa SC16G 14.8 GiB
[    1.924124]  mmcblk0: p1 p2
[    1.953594] usb 1-1: new high-speed USB device number 2 using xhci_hcd
[    1.966918] EXT4-fs (mmcblk0p2): mounted filesystem with ordered data mode. Opts: (null)
[    1.969569] VFS: Mounted root (ext4 filesystem) readonly on device 179:2.
[    1.980293] devtmpfs: mounted
[    1.992037] Freeing unused kernel memory: 2048K
[    2.023885] Run /sbin/init as init process
[    2.026431]   with arguments:
[    2.026446]     /sbin/init
[    2.026460]   with environment:
[    2.026475]     HOME=/
[    2.026489]     TERM=linux
[    2.136240] usb 1-1: New USB device found, idVendor=2109, idProduct=3431, bcdDevice= 4.21
[    2.138872] usb 1-1: New USB device strings: Mfr=0, Product=1, SerialNumber=0
[    2.141480] usb 1-1: Product: USB2.0 Hub
[    2.146463] hub 1-1:1.0: USB hub found
[    2.149362] hub 1-1:1.0: 4 ports detected
[    2.465670] systemd[1]: System time before build time, advancing clock.
[    2.473645] usb 1-1.3: new low-speed USB device number 3 using xhci_hcd
[    2.570285] NET: Registered protocol family 10
[    2.574451] Segment Routing with IPv6
[    2.633701] usb 1-1.3: New USB device found, idVendor=093a, idProduct=2510, bcdDevice= 1.00
[    2.636365] usb 1-1.3: New USB device strings: Mfr=1, Product=2, SerialNumber=0
[    2.639009] usb 1-1.3: Product: USB Optical Mouse
[    2.641611] usb 1-1.3: Manufacturer: PixArt
[    2.649811] systemd[1]: systemd 241 running in system mode. (+PAM +AUDIT +SELINUX +IMA +APPARMOR +SMACK +SYSVINIT +UTMP +LIBCRYPTSETUP +GCRYPT +GNUTLS +ACL +XZ +LZ4 +SECCOMP +BLKID +ELFUTILS +KMOD -IDN2 +IDN -PCRE2 default-hierarchy=hybrid)
[    2.656872] input: PixArt USB Optical Mouse as /devices/platform/scb/fd500000.pcie/pci0000:00/0000:00:00.0/0000:01:00.0/usb1/1-1/1-1.3/1-1.3:1.0/0003:093A:2510.0001/input/input0
[    2.657827] systemd[1]: Detected architecture arm.
[    2.660466] hid-generic 0003:093A:2510.0001: input,hidraw0: USB HID v1.11 Mouse [PixArt USB Optical Mouse] on usb-0000:01:00.0-1.3/input0
[    2.752528] systemd[1]: Set hostname to <alix>.
[    2.783601] usb 1-1.4: new low-speed USB device number 4 using xhci_hcd
[    2.965410] usb 1-1.4: New USB device found, idVendor=04d9, idProduct=0007, bcdDevice= 1.61
[    2.968995] usb 1-1.4: New USB device strings: Mfr=1, Product=2, SerialNumber=0
[    2.972381] usb 1-1.4: Product: Raspberry Pi Internal Keyboard
[    2.972396] usb 1-1.4: Manufacturer:  
[    3.009545] input:   Raspberry Pi Internal Keyboard as /devices/platform/scb/fd500000.pcie/pci0000:00/0000:00:00.0/0000:01:00.0/usb1/1-1/1-1.4/1-1.4:1.0/0003:04D9:0007.0002/input/input1
[    3.094340] hid-generic 0003:04D9:0007.0002: input,hidraw1: USB HID v1.11 Keyboard [  Raspberry Pi Internal Keyboard] on usb-0000:01:00.0-1.4/input0
[    3.119727] input:   Raspberry Pi Internal Keyboard as /devices/platform/scb/fd500000.pcie/pci0000:00/0000:00:00.0/0000:01:00.0/usb1/1-1/1-1.4/1-1.4:1.1/0003:04D9:0007.0003/input/input2
[    3.183991] hid-generic 0003:04D9:0007.0003: input,hidraw2: USB HID v1.11 Device [  Raspberry Pi Internal Keyboard] on usb-0000:01:00.0-1.4/input1
[    3.581650] random: systemd: uninitialized urandom read (16 bytes read)
[    3.603294] random: systemd: uninitialized urandom read (16 bytes read)
[    3.607862] systemd[1]: Listening on Journal Audit Socket.
[    3.616606] random: systemd: uninitialized urandom read (16 bytes read)
[    3.622385] systemd[1]: Created slice User and Session Slice.
[    3.631314] systemd[1]: Listening on initctl Compatibility Named Pipe.
[    3.641166] systemd[1]: Set up automount Arbitrary Executable File Formats File System Automount Point.
[    3.657065] systemd[1]: Listening on udev Kernel Socket.
[    3.666613] systemd[1]: Listening on Journal Socket.
[    3.682727] systemd[1]: Starting Create list of required static device nodes for the current kernel...
[    3.811376] i2c /dev entries driver
[    4.420079] EXT4-fs (mmcblk0p2): re-mounted. Opts: (null)
[    4.535575] systemd-journald[125]: Received request to flush runtime journal from PID 1
[    5.248848] rpivid-mem feb00000.hevc-decoder: rpivid-hevcmem initialised: Registers at 0xfeb00000 length 0x00010000
[    5.249819] rpivid-mem feb10000.rpivid-local-intc: rpivid-intcmem initialised: Registers at 0xfeb10000 length 0x00001000
[    5.250445] rpivid-mem feb20000.h264-decoder: rpivid-h264mem initialised: Registers at 0xfeb20000 length 0x00010000
[    5.250984] rpivid-mem feb30000.vp9-decoder: rpivid-vp9mem initialised: Registers at 0xfeb30000 length 0x00010000
[    5.348554] vc_sm_cma: module is from the staging directory, the quality is unknown, you have been warned.
[    5.350992] bcm2835_vc_sm_cma_probe: Videocore shared memory driver
[    5.351021] [vc_sm_connected_init]: start
[    5.352925] mc: Linux media interface: v0.10
[    5.361314] [vc_sm_connected_init]: installed successfully
[    5.382804] snd_bcm2835: module is from the staging directory, the quality is unknown, you have been warned.
[    5.385050] bcm2835_audio bcm2835_audio: there is not valid maps for state default
[    5.397449] videodev: Linux video capture interface: v2.00
[    5.403745] bcm2835_audio bcm2835_audio: card created with 8 channels
[    5.466167] bcm2835_mmal_vchiq: module is from the staging directory, the quality is unknown, you have been warned.
[    5.467381] bcm2835_mmal_vchiq: module is from the staging directory, the quality is unknown, you have been warned.
[    5.477242] bcm2835_isp: module is from the staging directory, the quality is unknown, you have been warned.
[    5.488597] bcm2835_v4l2: module is from the staging directory, the quality is unknown, you have been warned.
[    5.514132] bcm2835-isp bcm2835-isp: Device node output[0] registered as /dev/video13
[    5.515022] bcm2835-isp bcm2835-isp: Device node capture[0] registered as /dev/video14
[    5.515523] bcm2835-isp bcm2835-isp: Device node capture[1] registered as /dev/video15
[    5.516371] bcm2835-isp bcm2835-isp: Device node stats[2] registered as /dev/video16
[    5.516416] bcm2835-isp bcm2835-isp: Register output node 0 with media controller
[    5.516457] bcm2835-isp bcm2835-isp: Register capture node 1 with media controller
[    5.516480] bcm2835-isp bcm2835-isp: Register capture node 2 with media controller
[    5.516503] bcm2835-isp bcm2835-isp: Register capture node 3 with media controller
[    5.517078] bcm2835-isp bcm2835-isp: Loaded V4L2 bcm2835-isp
[    5.742302] cfg80211: Loading compiled-in X.509 certificates for regulatory database
[    5.867124] bcm2835_codec: module is from the staging directory, the quality is unknown, you have been warned.
[    5.885719] bcm2835-codec bcm2835-codec: Device registered as /dev/video10
[    5.885781] bcm2835-codec bcm2835-codec: Loaded V4L2 decode
[    5.893361] bcm2835-codec bcm2835-codec: Device registered as /dev/video11
[    5.893423] bcm2835-codec bcm2835-codec: Loaded V4L2 encode
[    5.915514] cfg80211: Loaded X.509 cert 'sforshee: 00b28ddf47aef9cea7'
[    5.919810] bcm2835-codec bcm2835-codec: Device registered as /dev/video12
[    5.919878] bcm2835-codec bcm2835-codec: Loaded V4L2 isp
[    5.929639] [drm] Initialized v3d 1.0.0 20180419 for fec00000.v3d on minor 0
[    6.033946] brcmfmac: F1 signature read @0x18000000=0x15294345
[    6.050347] brcmfmac: brcmf_fw_alloc_request: using brcm/brcmfmac43456-sdio for chip BCM4345/9
[    6.051557] vc4-drm gpu: bound fe600000.firmwarekms (ops vc4_fkms_ops [vc4])
[    6.051562] usbcore: registered new interface driver brcmfmac
[    6.051584] checking generic (3e402000 7f8000) vs hw (0 ffffffffffffffff)
[    6.051607] fb0: switching to vc4drmfb from simple
[    6.052238] Console: switching to colour dummy device 80x30
[    6.058554] [drm] Initialized vc4 0.0.0 20140616 for gpu on minor 1
[    6.074451] brcmfmac mmc1:0001:1: Direct firmware load for brcm/brcmfmac43456-sdio.raspberrypi,400.txt failed with error -2
[    6.277228] Console: switching to colour frame buffer device 240x67
[    6.286033] brcmfmac: brcmf_fw_alloc_request: using brcm/brcmfmac43456-sdio for chip BCM4345/9
[    6.298089] brcmfmac: brcmf_c_preinit_dcmds: Firmware: BCM4345/9 wl0: May 14 2020 17:26:08 version 7.84.17.1 (r871554) FWID 01-3d9e1d87
[    6.304012] vc4-drm gpu: [drm] fb0: vc4drmfb frame buffer device
[    8.026771] random: crng init done
[    8.026798] random: 7 urandom warning(s) missed due to ratelimiting
[    8.375111] 8021q: 802.1Q VLAN Support v1.8
[    8.533695] Adding 102396k swap on /var/swap.  Priority:-2 extents:1 across:102396k SSFS
[    8.734774] brcmfmac: brcmf_cfg80211_set_power_mgmt: power save enabled
[    9.053137] bcmgenet fd580000.ethernet: configuring instance for external RGMII (RX delay)
[    9.054064] bcmgenet fd580000.ethernet eth0: Link is Down
[   14.251586] IPv6: ADDRCONF(NETDEV_CHANGE): wlan0: link becomes ready
[   16.319706] ICMPv6: process `dhcpcd' is using deprecated sysctl (syscall) net.ipv6.neigh.wlan0.retrans_time - use net.ipv6.neigh.wlan0.retrans_time_ms instead
[   18.290510] broken atomic modeset userspace detected, disabling atomic
[   20.770849] fuse: init (API version 7.32)
[  163.926471] v3d fec00000.v3d: MMU error from client L2T (0) at 0x4d61000, pte invalid
[ 1047.049184] bcm2835-codec bcm2835-codec: bcm2835_codec_buf_prepare data will not fit into plane (1536 < 149760)
[ 1047.051310] bcm2835-codec bcm2835-codec: bcm2835_codec_buf_prepare data will not fit into plane (1536 < 149760)
[ 1047.051525] bcm2835-codec bcm2835-codec: bcm2835_codec_buf_prepare data will not fit into plane (1536 < 149760)
[ 1047.051696] bcm2835-codec bcm2835-codec: bcm2835_codec_buf_prepare data will not fit into plane (1536 < 149760)
[ 1047.055788] bcm2835-codec bcm2835-codec: bcm2835_codec_buf_prepare data will not fit into plane (1536 < 149760)
[ 1047.057400] bcm2835-codec bcm2835-codec: bcm2835_codec_buf_prepare data will not fit into plane (1536 < 149760)
[ 1052.033195] bcm2835-codec bcm2835-codec: bcm2835_codec_buf_prepare data will not fit into plane (1536 < 43008)
[ 1052.034292] bcm2835-codec bcm2835-codec: bcm2835_codec_buf_prepare data will not fit into plane (1536 < 43008)
[ 1052.036043] bcm2835-codec bcm2835-codec: bcm2835_codec_buf_prepare data will not fit into plane (1536 < 43008)
[ 1052.037995] bcm2835-codec bcm2835-codec: bcm2835_codec_buf_prepare data will not fit into plane (1536 < 43008)
[ 1052.244874] bcm2835-codec bcm2835-codec: bcm2835_codec_buf_prepare data will not fit into plane (1536 < 288000)
[ 1052.244938] bcm2835-codec bcm2835-codec: bcm2835_codec_buf_prepare data will not fit into plane (1536 < 288000)
[ 1052.245398] bcm2835-codec bcm2835-codec: bcm2835_codec_buf_prepare data will not fit into plane (1536 < 288000)
[ 1052.247635] bcm2835-codec bcm2835-codec: bcm2835_codec_buf_prepare data will not fit into plane (1536 < 288000)
[ 1052.248692] bcm2835-codec bcm2835-codec: bcm2835_codec_buf_prepare data will not fit into plane (1536 < 288000)
[ 1052.250395] bcm2835-codec bcm2835-codec: bcm2835_codec_buf_prepare data will not fit into plane (1536 < 288000)
[ 1052.250736] bcm2835-codec bcm2835-codec: bcm2835_codec_buf_prepare data will not fit into plane (1536 < 288000)
[ 1052.253011] bcm2835-codec bcm2835-codec: bcm2835_codec_buf_prepare data will not fit into plane (1536 < 288000)
[ 1052.253261] bcm2835-codec bcm2835-codec: bcm2835_codec_buf_prepare data will not fit into plane (1536 < 288000)
[ 1054.541061] bcm2835-codec bcm2835-codec: bcm2835_codec_buf_prepare data will not fit into plane (1536 < 353280)
[ 1054.541700] bcm2835-codec bcm2835-codec: bcm2835_codec_buf_prepare data will not fit into plane (1536 < 353280)
[ 1075.257407] bcm2835-codec bcm2835-codec: bcm2835_codec_buf_prepare data will not fit into plane (1536 < 288000)
[ 1075.258564] bcm2835-codec bcm2835-codec: bcm2835_codec_buf_prepare data will not fit into plane (1536 < 288000)
[ 1075.259052] bcm2835-codec bcm2835-codec: bcm2835_codec_buf_prepare data will not fit into plane (1536 < 288000)
[ 1075.259436] bcm2835-codec bcm2835-codec: bcm2835_codec_buf_prepare data will not fit into plane (1536 < 288000)
[ 1138.702228] bcm2835-codec bcm2835-codec: bcm2835_codec_buf_prepare data will not fit into plane (1536 < 299520)
[ 1138.704508] bcm2835-codec bcm2835-codec: bcm2835_codec_buf_prepare data will not fit into plane (1536 < 299520)
[ 1155.730425] bcm2835-codec bcm2835-codec: bcm2835_codec_buf_prepare data will not fit into plane (1536 < 276480)
[ 1155.732221] bcm2835-codec bcm2835-codec: bcm2835_codec_buf_prepare data will not fit into plane (1536 < 276480)
[ 1155.734107] bcm2835-codec bcm2835-codec: bcm2835_codec_buf_prepare data will not fit into plane (1536 < 276480)
[ 3427.998574] bcm2835-codec bcm2835-codec: bcm2835_codec_buf_prepare data will not fit into plane (1536 < 149760)
[ 3428.000107] bcm2835-codec bcm2835-codec: bcm2835_codec_buf_prepare data will not fit into plane (1536 < 149760)
[ 3428.005499] bcm2835-codec bcm2835-codec: bcm2835_codec_buf_prepare data will not fit into plane (1536 < 149760)
pelwell commented 3 years ago

I'm getting them from the latest rpi-update kernel (b986fda889737f6ce0a4acda89d447f78d0a1a73), viewing a video in YouTube on Chromium and changing the quality setting. No - reducing the quality setting.

Is this some pipelining effect where higher quality (resolution) video that has already been downloaded can't be decoded into buffers allocated for the new lower resolution?

pelwell commented 3 years ago

Is 1536 bytes the size of a frame of 32x32 video in 4:2:0?

JamesH65 commented 3 years ago

Yes (32 x 32 x 12bpp) / 8

pelwell commented 3 years ago

Obvs, but is that the significance of the 1536 in the logs above? Hmmm?

JamesH65 commented 3 years ago

I vaguely remember someone talking about a minimal size of video used somewhere in the system, for initialisation of the pipe perhaps? @jc-kynesim maybe?

6by9 commented 3 years ago

jc-kynesim is on holiday this week.

Yes the resolution is set to 32x32 by Chromium (I'm assuming this is Chromium we're looking at), and then relies on the codec producing a resolution changed event to set up the correct resolution. It sounds like we're being given buffers without the resolution having been set correctly. This may just be a race condition between having been given encoded buffers to decode which trigger the resolution changed, and getting the raw buffers to fill.

JC needs me to have a look at have a look at the driver to make it match the spec slightly more closely over resolution changes for the next version of Chromium, so I'll bump it up the priorities list.

jc-kynesim commented 3 years ago

Yeah this'll be part of the long standing Chrome V4L2 stateful startup problem. AFAIK it is a driver/firmware issue.

jc-kynesim commented 3 years ago

Its got worse with increasing chrome versions (probably timing / race as they've tuned their decode pipe)

pelwell commented 3 years ago

I'm closing this as a known glitch that will get fixed eventually but isn't causing any malfunctions at present.

Botspot commented 2 years ago

This error still seems to have resurfaced on Chromium 101.