Bjørn Mork <bj...@mork.no> writes: > Note that I found that I had to remove the cma=xx option raspi-firmware > wants to put into the cmdline.txt. This messed up mailbox access to the > firmware, and took several drivers/devices with it in the fall. Don't > think the SD card was one one them. But still worth trying. Makes the > sound driver load at least, and allows vcgencmd to talk to the firmware.
Sorry about all the mails.. Should have tested this myself before sending the previous one. I do believe this is the problem. I just tested with 'cma=64M' on the command line, like raspi-firmware wants to put there, and it fails to load the mmc driver too: [ 0.000000] Booting Linux on physical CPU 0x0000000000 [0x410fd083] [ 0.000000] Linux version 5.6.0-1-arm64 (debian-kernel@lists.debian.org) (gcc version 9.3.0 (Debian 9.3.0-11)) #1 SMP Debian 5.6.7-1 (2020-04-29) [ 0.000000] Machine model: Raspberry Pi 4 Model B Rev 1.2 [ 0.000000] efi: Getting EFI parameters from FDT: [ 0.000000] efi: UEFI not found. [ 0.000000] Reserved memory: bypass linux,cma node, using cmdline CMA params instead [ 0.000000] OF: reserved mem: node linux,cma compatible matching fail [ 0.000000] cma: Reserved 64 MiB at 0x00000000f8000000 [ 0.000000] NUMA: No NUMA configuration found [ 0.000000] NUMA: Faking a node at [mem 0x0000000000000000-0x00000000fbffffff] [ 0.000000] NUMA: NODE_DATA [mem 0xf781d0c0-0xf781efff] [ 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] percpu: Embedded 32 pages/cpu s93976 r8192 d28904 u131072 [ 0.000000] Detected PIPT I-cache on CPU0 [ 0.000000] CPU features: detected: EL2 vector hardening [ 0.000000] CPU features: kernel page table isolation forced ON by KASLR [ 0.000000] CPU features: detected: Kernel page table isolation (KPTI) [ 0.000000] ARM_SMCCC_ARCH_WORKAROUND_1 missing from firmware [ 0.000000] CPU features: detected: ARM erratum 1319367 [ 0.000000] Built 1 zonelists, mobility grouping on. Total pages: 996912 [ 0.000000] Policy zone: DMA32 [ 0.000000] Kernel command line: dma.dmachans=0x71f5 bcm2709.boardrev=0xc03112 bcm2709.serial=0xf5ccdafc bcm2709.uart_clock=48000000 bcm2709.disk_led_gpio=42 bcm2709.disk_led_active_low=0 smsc95xx.macaddr=DC:A6:32:77:E5:5E vc_mem.mem_base=0x3ec00000 vc_mem.mem_size=0x40000000 console=tty0 console=ttyS1,115200 root=/dev/mmcblk1p3 ro net.ifnames=0 cma=64M apparmor=0 rootwait [ 0.000000] Dentry cache hash table entries: 524288 (order: 10, 4194304 bytes, linear) [ 0.000000] Inode-cache hash table entries: 262144 (order: 9, 2097152 bytes, linear) [ 0.000000] mem auto-init: stack:off, heap alloc:off, heap free:off [ 0.000000] software IO TLB: mapped [mem 0x37400000-0x3b400000] (64MB) [ 0.000000] Memory: 1925100K/4050944K available (10108K kernel code, 1836K rwdata, 3752K rodata, 5184K init, 557K bss, 174912K reserved, 65536K cma-reserved) [ 0.000000] random: get_random_u64 called from __kmem_cache_create+0x44/0x5c8 with crng_init=0 [ 0.000000] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=4, Nodes=1 [ 0.000000] ftrace: allocating 36361 entries in 143 pages [ 0.000000] ftrace: allocated 143 pages with 5 groups [ 0.000000] rcu: Hierarchical RCU implementation. [ 0.000000] rcu: RCU restricting CPUs from NR_CPUS=256 to nr_cpu_ids=4. [ 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] GIC: Using split EOI/Deactivate mode [ 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.000006] sched_clock: 56 bits at 54MHz, resolution 18ns, wraps every 4398046511102ns [ 0.000184] Console: colour dummy device 80x25 [ 0.000554] printk: console [tty0] enabled [ 0.000683] Calibrating delay loop (skipped), value calculated using timer frequency.. 108.00 BogoMIPS (lpj=216000) [ 0.000708] pid_max: default: 32768 minimum: 301 [ 0.000871] LSM: Security Framework initializing [ 0.000944] Yama: disabled by default; enable with sysctl kernel.yama.* [ 0.000983] SELinux: Initializing. [ 0.001067] TOMOYO Linux initialized [ 0.001202] Mount-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) [ 0.001273] Mountpoint-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) [ 0.003410] rcu: Hierarchical SRCU implementation. [ 0.005788] EFI services will not be available. [ 0.006331] smp: Bringing up secondary CPUs ... [ 0.006932] Detected PIPT I-cache on CPU1 [ 0.006996] CPU1: Booted secondary processor 0x0000000001 [0x410fd083] [ 0.007678] Detected PIPT I-cache on CPU2 [ 0.007717] CPU2: Booted secondary processor 0x0000000002 [0x410fd083] [ 0.008412] Detected PIPT I-cache on CPU3 [ 0.008451] CPU3: Booted secondary processor 0x0000000003 [0x410fd083] [ 0.008549] smp: Brought up 1 node, 4 CPUs [ 0.008606] SMP: Total of 4 processors activated. [ 0.008619] CPU features: detected: 32-bit EL0 Support [ 0.008632] CPU features: detected: CRC32 instructions [ 0.032327] CPU: All CPU(s) started at EL2 [ 0.032421] alternatives: patching kernel code [ 0.108886] node 0 initialised, 471349 pages in 76ms [ 0.110189] devtmpfs: initialized [ 0.115938] Registered cp15_barrier emulation handler [ 0.115969] Registered setend emulation handler [ 0.115990] KASLR enabled [ 0.116421] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 7645041785100000 ns [ 0.116452] futex hash table entries: 1024 (order: 4, 65536 bytes, linear) [ 0.118166] pinctrl core: initialized pinctrl subsystem [ 0.119077] thermal_sys: Registered thermal governor 'fair_share' [ 0.119081] thermal_sys: Registered thermal governor 'step_wise' [ 0.119333] DMI not present or invalid. [ 0.119953] NET: Registered protocol family 16 [ 0.122004] DMA: preallocated 256 KiB pool for atomic allocations [ 0.122031] audit: initializing netlink subsys (disabled) [ 0.122208] audit: type=2000 audit(0.120:1): state=initialized audit_enabled=0 res=1 [ 0.123406] cpuidle: using governor ladder [ 0.123440] cpuidle: using governor menu [ 0.123724] hw-breakpoint: found 6 breakpoint and 4 watchpoint registers. [ 0.123832] ASID allocator initialised with 32768 entries [ 0.124152] Serial: AMBA PL011 UART driver [ 0.139913] HugeTLB registered 1.00 GiB page size, pre-allocated 0 pages [ 0.139941] HugeTLB registered 32.0 MiB page size, pre-allocated 0 pages [ 0.139956] HugeTLB registered 2.00 MiB page size, pre-allocated 0 pages [ 0.139970] HugeTLB registered 64.0 KiB page size, pre-allocated 0 pages [ 0.791773] ACPI: Interpreter disabled. [ 0.792046] iommu: Default domain type: Translated [ 0.792310] vgaarb: loaded [ 0.792649] EDAC MC: Ver: 3.0.0 [ 0.793980] NetLabel: Initializing [ 0.793996] NetLabel: domain hash size = 128 [ 0.794006] NetLabel: protocols = UNLABELED CIPSOv4 CALIPSO [ 0.794081] NetLabel: unlabeled traffic allowed by default [ 0.794383] clocksource: Switched to clocksource arch_sys_counter [ 0.863654] VFS: Disk quotas dquot_6.6.0 [ 0.863753] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) [ 0.864682] simple-framebuffer: probe of 0.framebuffer failed with error -12 [ 0.864733] pnp: PnP ACPI: disabled [ 0.873262] NET: Registered protocol family 2 [ 0.873914] tcp_listen_portaddr_hash hash table entries: 2048 (order: 3, 32768 bytes, linear) [ 0.873979] TCP established hash table entries: 32768 (order: 6, 262144 bytes, linear) [ 0.874187] TCP bind hash table entries: 32768 (order: 7, 524288 bytes, linear) [ 0.874627] TCP: Hash tables configured (established 32768 bind 32768) [ 0.874847] UDP hash table entries: 2048 (order: 4, 65536 bytes, linear) [ 0.874914] UDP-Lite hash table entries: 2048 (order: 4, 65536 bytes, linear) [ 0.875166] NET: Registered protocol family 1 [ 0.875202] NET: Registered protocol family 44 [ 0.875222] PCI: CLS 0 bytes, default 64 [ 0.875465] Trying to unpack rootfs image as initramfs... [ 1.376652] Freeing initrd memory: 7192K [ 1.377829] hw perfevents: enabled with armv8_cortex_a72 PMU driver, 7 counters available [ 1.378075] kvm [1]: IPA Size Limit: 44bits [ 1.378827] kvm [1]: vgic interrupt IRQ1 [ 1.378997] kvm [1]: Hyp mode initialized successfully [ 1.380711] Initialise system trusted keyrings [ 1.380762] Key type blacklist registered [ 1.380998] workingset: timestamp_bits=44 max_order=20 bucket_order=0 [ 1.387847] zbud: loaded [ 1.388930] Platform Keyring initialized [ 1.388953] Key type asymmetric registered [ 1.388965] Asymmetric key parser 'x509' registered [ 1.389010] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 250) [ 1.389261] io scheduler mq-deadline registered [ 1.394711] shpchp: Standard Hot Plug PCI Controller Driver version: 0.4 [ 1.403359] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled [ 1.405182] printk: console [ttyS1] disabled [ 1.405276] fe215040.serial: ttyS1 at MMIO 0xfe215040 (irq = 19, base_baud = 25000000) is a 16550 [ 2.228797] printk: console [ttyS1] enabled [ 2.233817] Serial: AMBA driver [ 2.237300] msm_serial: driver initialized [ 2.242360] cacheinfo: Unable to detect cache hierarchy for CPU 0 [ 2.249264] bcm2835-power bcm2835-power: Broadcom BCM2835 power domains driver [ 2.257313] mousedev: PS/2 mouse device common for all mice [ 2.264821] ledtrig-cpu: registered to indicate activity on CPUs [ 2.271529] bcm2835-mbox fe00b880.mailbox: mailbox enabled [ 2.277916] drop_monitor: Initializing network drop monitor service [ 2.285176] NET: Registered protocol family 10 [ 2.341866] Segment Routing with IPv6 [ 2.345736] mip6: Mobile IPv6 [ 2.348771] NET: Registered protocol family 17 [ 2.353498] mpls_gso: MPLS GSO support [ 2.357979] registered taskstats version 1 [ 2.362173] Loading compiled-in X.509 certificates [ 2.522996] Loaded X.509 cert 'Debian Secure Boot CA: 6ccece7e4c6c0d1f6149f3dd27dfcc5cbb419ea1' [ 2.531968] Loaded X.509 cert 'Debian Secure Boot Signer: 00a7468def' [ 2.538682] zswap: loaded using pool lzo/zbud [ 2.543708] Key type ._fscrypt registered [ 2.547813] Key type .fscrypt registered [ 2.551811] Key type fscrypt-provisioning registered [ 2.562240] fe201000.serial: ttyAMA0 at MMIO 0xfe201000 (irq = 16, base_baud = 0) is a PL011 rev2 [ 2.571545] serial serial0: tty port ttyAMA0 registered [ 2.578732] raspberrypi-firmware soc:firmware: Request 0x00000001 returned status 0x00000000 [ 2.587430] raspberrypi-firmware soc:firmware: Request 0x00030046 returned status 0x00000000 [ 2.596384] raspberrypi-firmware soc:firmware: Request 0x00030007 returned status 0x00000000 [ 2.605000] raspberrypi-clk raspberrypi-clk: Failed to get pllb min freq: -22 [ 2.612267] raspberrypi-clk raspberrypi-clk: Failed to initialize pllb, -22 [ 2.619366] raspberrypi-clk: probe of raspberrypi-clk failed with error -22 [ 2.626862] raspberrypi-firmware soc:firmware: Request 0x00030043 returned status 0x00000000 [ 2.635468] raspberrypi-exp-gpio soc:firmware:gpio: Failed to get GPIO 0 config (-22 80) [ 2.643755] raspberrypi-firmware soc:firmware: Request 0x00030043 returned status 0x00000000 [ 2.652358] raspberrypi-exp-gpio soc:firmware:gpio: Failed to get GPIO 1 config (-22 81) [ 2.660638] raspberrypi-firmware soc:firmware: Request 0x00030043 returned status 0x00000000 [ 2.669240] raspberrypi-exp-gpio soc:firmware:gpio: Failed to get GPIO 2 config (-22 82) [ 2.677522] raspberrypi-firmware soc:firmware: Request 0x00030043 returned status 0x00000000 [ 2.686123] raspberrypi-exp-gpio soc:firmware:gpio: Failed to get GPIO 3 config (-22 83) [ 2.694404] raspberrypi-firmware soc:firmware: Request 0x00030043 returned status 0x00000000 [ 2.703005] raspberrypi-exp-gpio soc:firmware:gpio: Failed to get GPIO 4 config (-22 84) [ 2.711286] raspberrypi-firmware soc:firmware: Request 0x00030043 returned status 0x00000000 [ 2.719887] raspberrypi-exp-gpio soc:firmware:gpio: Failed to get GPIO 5 config (-22 85) [ 2.728167] raspberrypi-firmware soc:firmware: Request 0x00030043 returned status 0x00000000 [ 2.736768] raspberrypi-exp-gpio soc:firmware:gpio: Failed to get GPIO 6 config (-22 86) [ 2.745049] raspberrypi-firmware soc:firmware: Request 0x00030043 returned status 0x00000000 [ 2.753652] raspberrypi-exp-gpio soc:firmware:gpio: Failed to get GPIO 7 config (-22 87) [ 2.762581] raspberrypi-firmware soc:firmware: Request 0x00030030 returned status 0x00000000 [ 2.771635] raspberrypi-firmware soc:firmware: Request 0x00030043 returned status 0x00000000 [ 2.780241] raspberrypi-exp-gpio soc:firmware:gpio: Failed to get GPIO 1 config (-22 81) [ 2.788528] raspberrypi-firmware soc:firmware: Request 0x00030043 returned status 0x00000000 [ 2.797131] raspberrypi-exp-gpio soc:firmware:gpio: Failed to get GPIO 1 config (-22 81) [ 2.805384] pwrseq_simple: probe of wifi-pwrseq failed with error -22 [ 2.812685] hctosys: unable to open rtc device (rtc0) [ 2.826909] Freeing unused kernel memory: 5184K [ 2.876504] Checked W+X mappings: passed, no W+X pages found [ 2.882299] Run /init as init process Loading, please wait... Starting version 241 [ 3.197462] usb_phy_generic phy: phy supply vcc not found, using dummy regulator [ 3.197646] raspberrypi-firmware soc:firmware: Request 0x00030043 returned status 0x00000000 [ 3.197786] raspberrypi-firmware soc:firmware: Request 0x00030043 returned status 0x00000000 [ 3.197798] raspberrypi-exp-gpio soc:firmware:gpio: Failed to get GPIO 2 config (-22 82) [ 3.197887] raspberrypi-firmware soc:firmware: Request 0x00030041 returned status 0x00000000 [ 3.197897] raspberrypi-exp-gpio soc:firmware:gpio: Failed to get GPIO 2 state (-22 82) [ 3.198032] leds-gpio: probe of leds failed with error -22 [ 3.240247] libphy: Fixed MDIO Bus: probed [ 3.247263] raspberrypi-exp-gpio soc:firmware:gpio: Failed to get GPIO 4 config (-22 84) [ 3.265402] raspberrypi-firmware soc:firmware: Request 0x00030043 returned status 0x00000000 [ 3.274116] raspberrypi-exp-gpio soc:firmware:gpio: Failed to get GPIO 4 config (-22 84) [ 3.283573] bcmgenet fd580000.ethernet: GENET 5.0 EPHY: 0x0000 [ 3.283953] gpio-regulator: probe of sd_io_1v8_reg failed with error -22 [ 3.292635] vchiq: module is from the staging directory, the quality is unknown, you have been warned. [ 3.297306] bcm2835-wdt bcm2835-wdt: Broadcom BCM2835 watchdog timer [ 3.321517] sdhci: Secure Digital Host Controller Interface driver [ 3.327882] sdhci: Copyright(c) Pierre Ossman [ 3.336002] sdhci-pltfm: SDHCI platform and OF driver helper [ 3.348018] iproc-rng200 fe104000.rng: hwrng registered [ 3.374701] libphy: bcmgenet MII bus: probed [ 3.379394] raspberrypi-firmware soc:firmware: Request 0x00048010 returned status 0x00000000 [ 3.388052] bcm2835_vchiq fe00b840.mailbox: failed to set channelbase [ 3.394624] vchiq: could not load vchiq [ 3.398683] bcm2835_vchiq: probe of fe00b840.mailbox failed with error -22 [ 3.410424] usbcore: registered new interface driver usbfs [ 3.416151] usbcore: registered new interface driver hub [ 3.421731] usbcore: registered new device driver usb [ 3.454547] unimac-mdio unimac-mdio.-19: Broadcom UniMAC MDIO bus [ 3.472662] raspberrypi-firmware soc:firmware: Request 0x00028001 returned status 0x00000000 Begin: Loading essential drivers ... [ 3.535320] alg: No test for fips(ansi_cprng) (fips_ansi_cprng) [ 6.246424] random: crng init done [ 6.461168] FS-Cache: Loaded [ 6.549757] RPC: Registered named UNIX socket transport module. [ 6.555861] RPC: Registered udp transport module. [ 6.560656] RPC: Registered tcp transport module. [ 6.565443] RPC: Registered tcp NFSv4.1 backchannel transport module. [ 6.712652] FS-Cache: Netfs 'nfs' registered for caching done. Begin: Running /scripts/init-premount ... done. Begin: Mounting root file system ... Begin: Running /scripts/local-top ... done. Begin: Running /scripts/local-premount ... done. Begin: Waiting for root file system ... Begin: Running /scripts/local-block ... done. Begin: Running /scripts/local-block ... done. Begin: Running /scripts/local-block ... done. Begin: Running /scripts/local-block ... done. Begin: Running /scripts/local-block ... done. Begin: Running /scripts/local-block ... done. Begin: Running /scripts/local-block ... done. Begin: Running /scripts/local-block ... done. Begin: Running /scripts/local-block ... done. Begin: Running /scripts/local-block ... done. Begin: Running /scripts/local-block ... done. Begin: Running /scripts/local-block ... done. Begin: Running /scripts/local-block ... done. Begin: Running /scripts/local-block ... done. Begin: Running /scripts/local-block ... done. Begin: Running /scripts/local-block ... done. Begin: Running /scripts/local-block ... done. Begin: Running /scripts/local-block ... done. Begin: Running /scripts/local-block ... done. Begin: Running /scripts/local-block ... done. Begin: Running /scripts/local-block ... done. Begin: Running /scripts/local-block ... done. Begin: Running /scripts/local-block ... done. Begin: Running /scripts/local-block ... done. Begin: Running /scripts/local-block ... done. Begin: Running /scripts/local-block ... done. Begin: Running /scripts/local-block ... done. Begin: Running /scripts/local-block ... done. Begin: Running /scripts/local-block ... done. Begin: Running /scripts/local-block ... done. Begin: Running /scripts/local-block ... done. done. Gave up waiting for root file system device. Common problems: - Boot args (cat /proc/cmdline) - Check rootdelay= (did the system wait long enough?) - Missing modules (cat /proc/modules; ls /dev) ALERT! /dev/mmcblk1p3 does not exist. Dropping to a shell! BusyBox v1.30.1 (Debian 1:1.30.1-4) built-in shell (ash) Enter 'help' for a list of built-in commands. (initramfs) cat /proc/partitions (initramfs) I did add a comment about this problem in an existing raspi-firmware cmdline related bug: https://bugs.debian.org/951744 But I guess it might be severe enough to warrant some more noise. Bjørn
