Converting raspian image for Rpi4 - cannot boot

I am trying to convert image from https://downloads.raspberrypi.org/raspios_lite_armhf_latest
to use with mender.io (Minimal image based on Debian Buster)

I provisioned original image to 2GB SD card, it is booting / working fine,
then copied from SD card (dd) to disk

I build mender-convert (2.1.0 )

Running mender-convert -v
Version: cc3f688

Created rootfs_overlay_demo, as per tutorial

Run mender-convert:

misha-asus/media/misha/LINUX_5T/RPi/mender-convert (2.1.0 $)$ MENDER_ARTIFACT_NAME=release-1 ./docker-mender-convert --disk-image input/rpi_2GB.img --config configs/raspberrypi4_config --overlay rootfs_overlay_demo/
Running mender-convert --disk-image input/rpi_2GB.img --config configs/raspberrypi4_config --overlay rootfs_overlay_demo/
Running mender-convert-extract: --disk-image input/rpi_2GB.img --config configs/raspberrypi4_config --overlay rootfs_overlay_demo/
2020-09-11 21:19:39 [INFO] [mender-convert-extract] Using configuration file: configs/mender_convert_config
2020-09-11 21:19:39 [INFO] [mender-convert-extract] Using configuration file: configs/raspberrypi4_config
2020-09-11 21:19:39 [INFO] [mender-convert-extract] Validating disk image
2020-09-11 21:19:39 [INFO] [mender-convert-extract] Disk parsed successfully
2020-09-11 21:19:39 [INFO] [mender-convert-extract] NUMBER OF PARTS: 2 TYPE: dos
2020-09-11 21:19:39 [INFO] [mender-convert-extract] PART 1: SIZE: 256M TYPE: 0xc
2020-09-11 21:19:39 [INFO] [mender-convert-extract] PART 1: extracting to work/part-1.fs
2020-09-11 21:19:47 [INFO] [mender-convert-extract] PART 2: SIZE: 1.6G TYPE: 0x83
2020-09-11 21:19:47 [INFO] [mender-convert-extract] PART 2: extracting to work/part-2.fs
mender-convert-extract has finished. Cleaning up...
Running mender-convert-modify: --disk-image input/rpi_2GB.img --config configs/raspberrypi4_config --overlay rootfs_overlay_demo/
2020-09-11 21:21:05 [INFO] [mender-convert-modify] Using configuration file: configs/mender_convert_config
2020-09-11 21:21:05 [INFO] [mender-convert-modify] Using configuration file: configs/raspberrypi4_config
2020-09-11 21:21:08 [INFO] [mender-convert-modify] Installing Mender client and related files
2020-09-11 21:21:10 [INFO] [mender-convert-modify] Using root device A in mender.conf: /dev/mmcblk0p2
2020-09-11 21:21:10 [INFO] [mender-convert-modify] Using root device B in mender.conf: /dev/mmcblk0p3
2020-09-11 21:21:10 [INFO] [mender-convert-modify] Creating state scripts version file.
2020-09-11 21:21:11 [INFO] [mender-convert-modify] Installing a custom /etc/fstab (see work/convert.log for more info)
2020-09-11 21:21:11 [INFO] [mender-convert-modify] Using boot partition device in fstab: /dev/mmcblk0p1
2020-09-11 21:21:11 [INFO] [mender-convert-modify] Using data partition device in fstab: /dev/mmcblk0p4
2020-09-11 21:21:11 [INFO] [mender-convert-modify] Performing platform specific modifications (if any)
2020-09-11 21:21:11 [INFO] [mender-convert-modify] Running hook: platform_modify
2020-09-11 21:21:13 [INFO] [mender-convert-modify] Performing user/local specific modifications (if any)
2020-09-11 21:21:13 [INFO] [mender-convert-modify] Running hook: user_local_modify
2020-09-11 21:21:13 [INFO] [mender-convert-modify] Applying rootfs overlay: rootfs_overlay_demo/
mender-convert-modify has finished. Cleaning up...
Running mender-convert-package: --disk-image input/rpi_2GB.img --config configs/raspberrypi4_config --overlay rootfs_overlay_demo/
2020-09-11 21:21:14 [INFO] [mender-convert-package] Using configuration file: configs/mender_convert_config
2020-09-11 21:21:14 [INFO] [mender-convert-package] Using configuration file: configs/raspberrypi4_config
2020-09-11 21:21:14 [WARN] [mender-convert-package] The allocated boot part size 40 MiB is too small.
2020-09-11 21:21:14 [WARN] [mender-convert-package] The actual boot part size is 256 MiB
2020-09-11 21:21:14 [WARN] [mender-convert-package] Will adjust MENDER_BOOT_PART_SIZE_MB automatically
2020-09-11 21:21:14 [WARN] [mender-convert-package] Consider adjusting the configuration file to avoid this message
2020-09-11 21:21:18 [INFO] [mender-convert-package] Rootfs filesystem size will be 1875 MiB
2020-09-11 21:21:18 [INFO] [mender-convert-package] Creating a file-system image from: work/rootfs/data/
2020-09-11 21:21:19 [INFO] [mender-convert-package] Creating a file-system image from: work/rootfs/
2020-09-11 21:22:58 [INFO] [mender-convert-package] Copying root filesystem image to deploy directory
2020-09-11 21:24:32 [INFO] [mender-convert-package] Writing Mender artifact to: deploy/rpi_2GB-raspberrypi4-mender.mender
2020-09-11 21:24:32 [INFO] [mender-convert-package] This can take up to 20 minutes depending on which compression method is used
2020-09-11 21:28:01 [INFO] [mender-convert-package] Creating Mender compatible disk-image
2020-09-11 21:28:01 [INFO] [mender-convert-package] Total disk size: 8192 MiB
2020-09-11 21:28:01 [INFO] [mender-convert-package]   Boot partition    256 MiB
2020-09-11 21:28:01 [INFO] [mender-convert-package]   RootFS partitions 3892 MiB x 2
2020-09-11 21:28:01 [INFO] [mender-convert-package]   Data partition    128 MiB
2020-09-11 21:28:01 [INFO] [mender-convert-package] Using input diskimage partition scheme (dos)
2020-09-11 21:28:01 [INFO] [mender-convert-package] Writing DOS (MBR) partition table
2020-09-11 21:28:03 [INFO] [mender-convert-package] Writing boot partition image
2020-09-11 21:28:14 [INFO] [mender-convert-package] Writing rootfsa partition image
2020-09-11 21:33:06 [INFO] [mender-convert-package] Writing rootfsb partition image
2020-09-11 21:37:59 [INFO] [mender-convert-package] Writing data partition image
2020-09-11 21:37:59 [INFO] [mender-convert-package] Performing platform specific package operations (if any)
2020-09-11 21:37:59 [INFO] [mender-convert-package] Running hook: platform_package
2020-09-11 21:37:59 [INFO] [mender-convert-package] Compressing deploy/rpi_2GB-raspberrypi4-mender.img.gz
2020-09-11 21:41:28 [INFO] [mender-convert-package] Conversion has completed! \o/
mender-convert-package has finished. Cleaning up...
Output Artifacts and images can be found in the deploy directory:
deploy/rpi32_small-raspberrypi4-mender.cfg
deploy/rpi32_small-raspberrypi4-mender.ext4
deploy/rpi32_small-raspberrypi4-mender.img
deploy/rpi32_small-raspberrypi4-mender.mender
deploy/rpi_2GB-raspberrypi4-mender.cfg
deploy/rpi_2GB-raspberrypi4-mender.ext4
deploy/rpi_2GB-raspberrypi4-mender.img.gz
deploy/rpi_2GB-raspberrypi4-mender.mender
deploy/rpi_2GB_3-raspberrypi3-mender.cfg
deploy/rpi_2GB_3-raspberrypi3-mender.ext4
deploy/rpi_2GB_3-raspberrypi3-mender.img
deploy/rpi_2GB_3-raspberrypi3-mender.mender
deploy/rpi_32-raspberrypi4-mender.cfg
deploy/rpi_32-raspberrypi4-mender.ext4
deploy/rpi_32-raspberrypi4-mender.img
deploy/rpi_32-raspberrypi4-mender.mender

Everything seem fine so far (fdisk -lu):

Disk rpi_2GB-raspberrypi4-mender.img: 8 GiB, 8589934592 bytes, 16777216 sectors
Units: sectors of 1 * 512 = 512 bytes
Sector size (logical/physical): 512 bytes / 512 bytes
I/O size (minimum/optimal): 512 bytes / 512 bytes
Disklabel type: dos
Disk identifier: 0x4efa4bd2

Device                           Boot    Start      End Sectors  Size Id Type
rpi_2GB-raspberrypi4-mender.img1 *       24576   548863  524288  256M  c W95 FAT32 (LBA)
rpi_2GB-raspberrypi4-mender.img2        548864  8519679 7970816  3.8G 83 Linux
rpi_2GB-raspberrypi4-mender.img3       8519680 16490495 7970816  3.8G 83 Linux
rpi_2GB-raspberrypi4-mender.img4      16490496 16752639  262144  128M 83 Linux

Wrote file to 32 GB SD card. Trying to boot. Monitor shows signal, but nothing on the screen
Ethernet light stays orange, no blinking

After fiddling around with RPI, I figured out how to enable serial output for boot
messages. It turns out I had to modify eeprom as per this doc

https://www.raspberrypi.org/documentation/hardware/raspberrypi/bcm2711_bootloader_config.md

In addition to this (very strange) messages only come out if after I turn power on
I also send some data (keystroke) on host computer. It seem it wakes up Rpi boot output
(this note not related to the topic).

The serial log is here:

Initialising SDRAM 'Micron' 32Gb x2 total-size: 64 Gbit 3200
VLI: HUB2: 0xfff00000 0x24e6 MCU: 0xfff20000 0x15218
VL805 0xfff00000 0xfff20000
XHCI-STOP
xHC ver: 256 HCS: 05000420 fc000031 00e70004 HCC: 002841eb
xHC ports 5 slots 32 intrs 4
Boot mode: SD (01) order f4
SD HOST: 250000000 CTL0: 0x00000000 BUS: 100000 Hz actual: 100000 HZ div: 2500 (1250) status: 0x1fff0000 delay: 1080
SD HOST: 250000000 CTL0: 0x00000f00 BUS: 100000 Hz actual: 100000 HZ div: 2500 (1250) status: 0x1fff0000 delay: 1080
CID: 000353444147474344805d7a40fc0111
CSD: 400e00325b590000edc87f800a404000
SD: bus-width: 4 spec: 2 SCR: 0x02358443 0x00000000
SD HOST: 250000000 CTL0: 0x00000f04 BUS: 50000000 Hz actual: 41666666 HZ div: 6 (3) status: 0x1fff0000 delay: 2
MBR: 0x00006000,  524288 type: 0x0c
MBR: 0x00086000, 7970816 type: 0x83
MBR: 0x00820000, 7970816 type: 0x83
MBR: 0x00fba000,  262144 type: 0x83
lba: 24576 oem: 'mkfs.fat' volume: ' boot       '
rsc 32 fat-sectors 4033 c-count 516190 c-size 1 r-dir 2 r-sec 0
PM_RSTS: 0x00001000
Partition: 0
lba: 24576 oem: 'mkfs.fat' volume: ' boot       '
rsc 32 fat-sectors 4033 c-count 516190 c-size 1 r-dir 2 r-sec 0
Read config.txt bytes     1856 hnd 0x00000386 hash 'fcb68e2872e9a1c2'
recover4.elf not found (6)
recovery.elf not found (6)
Read start4.elf bytes  2278336 hnd 0x0001128e hash '78e6729ebb0d2e84'
Read fixup4.dat bytes     5418 hnd 0x00000399 hash '6f078b9acde7f5e1'
0x00d03114 0x00000000 0x0000001f
MEM GPU: 76 ARM: 948 TOTAL: 1024
Starting start4.elf @ 0xfec00200 partition 0
MESS:00:00:05.352103:0: arasan: arasan_emmc_open
MESS:00:00:05.511771:0: brfs: File read: /mfs/sd/config.txt
MESS:00:00:05.515012:0: brfs: File read: 1856 bytes
MESS:00:00:05.544699:0: brfs: File read: /mfs/sd/config.txt
MESS:00:00:05.553921:0: brfs: File read: 1856 bytes
MESS:00:00:06.016100:0: gpioman: gpioman_get_pin_num: pin DISPLAY_DSI_PORT not defined
MESS:00:00:06.023350:0: *** Restart logging
MESS:00:00:06.038378:0: hdmi: HDMI:hdmi_get_state is deprecated, use hdmi_get_display_state instead
MESS:00:00:06.044318:0: HDMI0: hdmi_pixel_encoding: 300000000
MESS:00:00:06.049796:0: HDMI1: hdmi_pixel_encoding: 300000000
MESS:00:00:06.060219:0: dtb_file 'bcm2711-rpi-4-b.dtb'
MESS:00:00:06.069041:0: brfs: File read: /mfs/sd/bcm2711-rpi-4-b.dtb
MESS:00:00:06.072281:0: Loading 'bcm2711-rpi-4-b.dtb' to 0x100 size 0xb96f
MESS:00:00:06.091168:0: brfs: File read: 47471 bytes
MESS:00:00:06.103017:0: brfs: File read: /mfs/sd/overlays/overlay_map.dtb
MESS:00:00:06.162139:0: brfs: File read: 1423 bytes
MESS:00:00:06.167623:0: brfs: File read: /mfs/sd/config.txt
MESS:00:00:06.170544:0: dtparam: audio=on
MESS:00:00:06.183074:0: brfs: File read: 1856 bytes
MESS:00:00:06.195963:0: brfs: File read: /mfs/sd/overlays/vc4-fkms-v3d.dtbo
MESS:00:00:06.216277:0: Loaded overlay 'vc4-fkms-v3d'
MESS:00:00:06.284434:0: brfs: File read: 1238 bytes
MESS:00:00:06.291753:0: brfs: File read: /mfs/sd/overlays/disable-bt.dtbo
MESS:00:00:06.330035:0: Loaded overlay 'disable-bt'
MESS:00:00:06.427699:0: brfs: File read: 1073 bytes
MESS:00:00:06.433059:0: brfs: File read: /mfs/sd/cmdline.txt
MESS:00:00:06.435689:0: Read command line from file 'cmdline.txt':
MESS:00:00:06.441552:0: 'console=serial0,115200 console=tty1 root=${mender_kernel_root} rootfstype=ext4 elevator=deadline fsck.repair=yes rootwait'
MESS:00:00:07.716263:0: brfs: File read: 122 bytes
MESS:00:00:07.802590:0: brfs: File read: /mfs/sd/kernel7l.img
MESS:00:00:07.805277:0: Loading 'kernel7l.img' to 0x8000 size 0x5e390
MESS:00:00:07.811452:0: Device tree loaded to 0x2eff4100 (size 0xbe95)
MESS:00:00:07.817896:0: uart: Set PL011 baud rate to 103448.300000 Hz
MESS:00:00:07.826807:0: uart: Baud rate change done...
MESS:00:00:07.828859:0: uart: Baud rate change done...
MESS:00:00:07.838232:0: gpioman: gpioman_get_pin_num: pin SDCARD_CONTROL_POWER not defined
MMC:   mmcnr@7e300000: 1, emmc2@7e340000: 0
Loading Environment from MMC... OK
In:    serial
Out:   serial
Err:   serial
Net:   Net Initialization Skipped
No ethernet found.
Hit any key to stop autoboot:  0 
switch to partitions #0, OK
mmc0 is current device
Scanning mmc 0:1...
Found U-Boot script /boot.scr
568 bytes read in 13 ms (42 KiB/s)
\## Executing script at 02400000
switch to partitions #0, OK
mmc0 is current device
5996480 bytes read in 1224 ms (4.7 MiB/s)
Kernel image @ 0x080000 [ 0x000000 - 0x5b7fc0 ]
\## Flattened Device Tree blob at 2eff4100
   Booting using the fdt blob at 0x2eff4100
   reserving fdt memory region: addr=0 size=1000
   Using Device Tree in place at 2eff4100, end 2f002f94

Starting kernel ...

Here boot stops, apparently when kernel should start

After comparing boot partitions for original image and mender-converted one I found very
few differences, namely

kernel7l.img

Original file:
rw-r–r-- 1 misha misha 5996480 Aug 11 23:36 /media/misha/boot/kernel7l.img
file /media/misha/boot/kernel7l.img
/media/misha/boot/kernel7l.img: Linux kernel ARM boot executable zImage (little-endian)

The file on mender image is
-rw-r–r-- 1 misha misha 385936 Sep 11 14:21 /media/misha/boot1/kernel7l.img
file /media/misha/boot1/kernel7l.img
/media/misha/boot1/kernel7l.img: COM executable for DOS

Interesting, if I just replace kernel7l.img from mender-convert to original one.
system boots, but not all the way.

I think something went wrong, and new kernel7l.img does not work for RPi4.

Any help greatly appreciated.

Thank you!
Mikhail

This is a known problem, and is being worked on. In the meantime, the Raspbian image from May works.

You may see my notes to Raspberry Pi 4 Model B

In fact it seem it is the same issue.
I got into u-boot interactive prompt on this board.
Thank you

I was able to get past U-buut interactively. If one renames boot.scr UART drops into u-boot shell

Then if I try:

U-Boot> fdt addr ${fdt_addr} && fdt get value bootargs /chosen bootargs
U-Boot> run mender_setup
U-Boot> mmc dev ${mender_uboot_dev}
switch to partitions #0, OK
mmc0 is current device
U-Boot> load ${mender_uboot_root} ${kernel_addr_r} /boot/zImage
5996480 bytes read in 1388 ms (4.1 MiB/s)
U-Boot> bootz ${kernel_addr_r} - ${fdt_addr}
Kernel image @ 0x080000 [ 0x000000 - 0x5b7fc0 ]
## Flattened Device Tree blob at 2eff4100
   Booting using the fdt blob at 0x2eff4100
   reserving fdt memory region: addr=0 size=1000
   Using Device Tree in place at 2eff4100, end 2f002f94

Starting kernel ...

This stays forever.

I noted that /boot/zImage on the first rootfs partition has the same size as original kernel7l.img but it is binary different. If I replace zImage in /boot with original kernel7l.img board boots beyond this point,
but gives kernel panic

No ethernet found.
U-Boot> fdt addr {fdt_addr} && fdt get value bootargs /chosen bootargs U-Boot> run mender_setup U-Boot> mmc dev {mender_uboot_dev}
switch to partitions #0, OK
mmc0 is current device
U-Boot> load {mender_uboot_root} {kernel_addr_r} /boot/zImage
5996480 bytes read in 1355 ms (4.2 MiB/s)
U-Boot> bootz {kernel_addr_r} - {fdt_addr}
Kernel image @ 0x080000 [ 0x000000 - 0x5b7fc0 ]
## Flattened Device Tree blob at 2eff4100
Booting using the fdt blob at 0x2eff4100
reserving fdt memory region: addr=0 size=1000
Using Device Tree in place at 2eff4100, end 2f002f94

Starting kernel ...

[    0.000000] Booting Linux on physical CPU 0x0
[    0.000000] Linux version 5.4.51-v7l+ (dom@buildbot) (gcc version 4.9.3 (crosstool-NG crosstool-ng-1.22.0-88-g8460611)) #1333 SMP Mon Aug 10 16:51:40 BST 2020
[    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 4 Model B Rev 1.4
[    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] percpu: Embedded 20 pages/cpu s49856 r8192 d23872 u81920
[    0.000000] Built 1 zonelists, mobility grouping on.  Total pages: 2059008
[    0.000000] Kernel command line: coherent_pool=1M 8250.nr_uarts=1 snd_bcm2835.enable_compat_alsa=0 snd_bcm2835.enable_hdmi=1 snd_bcm2835.enable_headphones=1 video=HDMI-A-1:1440x900M@60 smsc95xx.macaddr=DC:A6:32:BA:E5:61 vc_mem.mem_base=0x3ec00000 vc_mem.mem_size=0x40000000  console=ttyAMA0,115200 console=tty1 root=/dev/mmcblk0p2 rootfstype=ext4 elevator=deadline 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:off, heap alloc:off, heap free:off
[    0.000000] software IO TLB: mapped [mem 0x14c00000-0x18c00000] (64MB)
[    0.000000] Memory: 7800772K/8245248K available (10240K kernel code, 725K rwdata, 2740K rodata, 2048K init, 853K bss, 182332K reserved, 262144K cma-reserved, 7458816K highmem)
[    0.000000] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=4, Nodes=1
[    0.000000] ftrace: allocating 30051 entries in 59 pages
[    0.000000] rcu: Hierarchical RCU implementation.
[    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+0x340/0x518 with crng_init=0
[    0.000007] sched_clock: 32 bits at 1000kHz, resolution 1000ns, wraps every 2147483647500ns
[    0.000030] clocksource: timer: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275 ns
[    0.000112] bcm2835: system timer (irq = 17)
[    0.000784] arch_timer: cp15 timer(s) running at 54.00MHz (phys).
[    0.000804] clocksource: arch_sys_counter: mask: 0xffffffffffffff max_cycles: 0xc743ce346, max_idle_ns: 440795203123 ns
[    0.000825] sched_clock: 56 bits at 54MHz, resolution 18ns, wraps every 4398046511102ns
[    0.000841] Switching to timer-based delay loop, resolution 18ns
[    0.001090] Console: colour dummy device 80x30
[    0.001582] printk: console [tty1] enabled
[    0.001646] Calibrating delay loop (skipped), value calculated using timer frequency.. 108.00 BogoMIPS (lpj=540000)
[    0.001687] pid_max: default: 32768 minimum: 301
[    0.002018] Mount-cache hash table entries: 2048 (order: 1, 8192 bytes, linear)
[    0.002059] Mountpoint-cache hash table entries: 2048 (order: 1, 8192 bytes, linear)
[    0.003264] Disabling memory control group subsystem
[    0.003384] CPU: Testing write buffer coherency: ok
[    0.003879] CPU0: thread -1, cpu 0, socket 0, mpidr 80000000
[    0.004732] Setting up static identity map for 0x200000 - 0x20003c
[    0.004934] rcu: Hierarchical SRCU implementation.
[    0.005589] smp: Bringing up secondary CPUs ...
[    0.006779] CPU1: thread -1, cpu 1, socket 0, mpidr 80000001
[    0.008082] CPU2: thread -1, cpu 2, socket 0, mpidr 80000002
[    0.009315] CPU3: thread -1, cpu 3, socket 0, mpidr 80000003
[    0.009458] smp: Brought up 1 node, 4 CPUs
[    0.009529] SMP: Total of 4 processors activated (432.00 BogoMIPS).
[    0.009555] CPU: All CPU(s) started in HYP mode.
[    0.009577] CPU: Virtualization extensions available.
[    0.010388] devtmpfs: initialized
[    0.023481] VFP support v0.3: implementor 41 architecture 3 part 40 variant 8 rev 0
[    0.023762] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 19112604462750000 ns
[    0.023811] futex hash table entries: 1024 (order: 4, 65536 bytes, linear)
[    0.031630] pinctrl core: initialized pinctrl subsystem
[    0.032715] NET: Registered protocol family 16
[    0.036387] DMA: preallocated 1024 KiB pool for atomic coherent allocations
[    0.038044] hw-breakpoint: found 5 (+1 reserved) breakpoint and 4 watchpoint registers.
[    0.038078] hw-breakpoint: maximum watchpoint size is 8 bytes.
[    0.038437] Serial: AMBA PL011 UART driver
[    0.041860] bcm2835-mbox fe00b880.mailbox: mailbox enabled
[    0.060903] raspberrypi-firmware soc:firmware: Attached to firmware from 2020-08-19 17:38, variant start
[    0.070885] raspberrypi-firmware soc:firmware: Firmware hash is e90cba19a98a0d1f2ef086b9cafcbca00778f094
[    0.123720] bcm2835-dma fe007000.dma: DMA legacy API manager, dmachans=0x1
[    0.128188] vgaarb: loaded
[    0.128666] SCSI subsystem initialized
[    0.128905] usbcore: registered new interface driver usbfs
[    0.128990] usbcore: registered new interface driver hub
[    0.129124] usbcore: registered new device driver usb
[    0.130619] clocksource: Switched to clocksource arch_sys_counter
[    0.881983] VFS: Disk quotas dquot_6.6.0
[    0.882109] VFS: Dquot-cache hash table entries: 1024 (order 0, 4096 bytes)
[    0.882281] FS-Cache: Loaded
[    0.882491] CacheFiles: Loaded
[    0.883384] simple-framebuffer 3e6f8000.framebuffer: framebuffer at 0x3e6f8000, 0x502800 bytes, mapped to 0x(ptrval)
[    0.883425] simple-framebuffer 3e6f8000.framebuffer: format=a8r8g8b8, mode=1440x900x32, linelength=5760
[    0.890429] Console: switching to colour frame buffer device 180x56
[    0.896728] simple-framebuffer 3e6f8000.framebuffer: fb0: simplefb registered!
[    0.906685] thermal_sys: Registered thermal governor 'step_wise'
[    0.907059] NET: Registered protocol family 2
[    0.907907] tcp_listen_portaddr_hash hash table entries: 512 (order: 0, 6144 bytes, linear)
[    0.908020] TCP established hash table entries: 8192 (order: 3, 32768 bytes, linear)
[    0.908169] TCP bind hash table entries: 8192 (order: 4, 65536 bytes, linear)
[    0.908311] TCP: Hash tables configured (established 8192 bind 8192)
[    0.908518] UDP hash table entries: 512 (order: 2, 16384 bytes, linear)
[    0.908618] UDP-Lite hash table entries: 512 (order: 2, 16384 bytes, linear)
[    0.908932] NET: Registered protocol family 1
[    0.909676] RPC: Registered named UNIX socket transport module.
[    0.909752] RPC: Registered udp transport module.
[    0.909811] RPC: Registered tcp transport module.
[    0.909870] RPC: Registered tcp NFSv4.1 backchannel transport module.
[    0.909952] PCI: CLS 0 bytes, default 64
[    0.911831] hw perfevents: enabled with armv7_cortex_a15 PMU driver, 7 counters available
[    0.914073] Initialise system trusted keyrings
[    0.914343] workingset: timestamp_bits=14 max_order=21 bucket_order=7
[    0.925032] FS-Cache: Netfs 'nfs' registered for caching
[    0.925809] NFS: Registering the id_resolver key type
[    0.925910] Key type id_resolver registered
[    0.928257] Key type id_legacy registered
[    0.930550] nfs4filelayout_init: NFSv4 File Layout Driver Registering...
[    0.933953] Key type asymmetric registered
[    0.936253] Asymmetric key parser 'x509' registered
[    0.938694] bounce: pool size: 64 pages
[    0.941050] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 249)
[    0.943579] io scheduler mq-deadline registered
[    0.945856] io scheduler kyber registered
[    0.951911] brcm-pcie fd500000.pcie: host bridge /scb/pcie@7d500000 ranges:
[    0.954219] brcm-pcie fd500000.pcie:   No bus range found for /scb/pcie@7d500000, using [bus 00-ff]
[    0.956563] brcm-pcie fd500000.pcie:      MEM 0x0600000000..0x0603ffffff -> 0x00f8000000
[    0.958892] brcm-pcie fd500000.pcie:   IB MEM 0x0000000000..0x00bfffffff -> 0x0000000000
[    1.022727] brcm-pcie fd500000.pcie: link up, 5 GT/s x1 (SSC)
[    1.025242] brcm-pcie fd500000.pcie: PCI host bridge to bus 0000:00
[    1.027440] pci_bus 0000:00: root bus resource [bus 00-ff]
[    1.029619] pci_bus 0000:00: root bus resource [mem 0x600000000-0x603ffffff] (bus address [0xf8000000-0xfbffffff])
[    1.031932] pci 0000:00:00.0: [14e4:2711] type 01 class 0x060400
[    1.034402] pci 0000:00:00.0: PME# supported from D0 D3hot
[    1.039992] PCI: bus0: Fast back to back transfers disabled
[    1.042501] pci 0000:01:00.0: [1106:3483] type 00 class 0x0c0330
[    1.044899] pci 0000:01:00.0: reg 0x10: [mem 0x00000000-0x00000fff 64bit]
[    1.047570] pci 0000:01:00.0: PME# supported from D0 D3hot
[    1.053144] PCI: bus1: Fast back to back transfers disabled
[    1.055427] pci 0000:00:00.0: BAR 8: assigned [mem 0x600000000-0x6000fffff]
[    1.057709] pci 0000:01:00.0: BAR 0: assigned [mem 0x600000000-0x600000fff 64bit]
[    1.060028] pci 0000:00:00.0: PCI bridge to [bus 01]
[    1.062281] pci 0000:00:00.0:   bridge window [mem 0x600000000-0x6000fffff]
[    1.064782] pcieport 0000:00:00.0: enabling device (0140 -> 0142)
[    1.067190] pcieport 0000:00:00.0: PME: Signaling with IRQ 55
[    1.069751] pcieport 0000:00:00.0: AER: enabled with IRQ 55
[    1.072244] pci 0000:01:00.0: enabling device (0140 -> 0142)
[    1.123500] pci 0000:01:00.0: quirk_usb_early_handoff+0x0/0x7b8 took 50073 usecs
[    1.133026] Serial: 8250/16550 driver, 1 ports, IRQ sharing enabled
[    1.137887] iproc-rng200 fe104000.rng: hwrng registered
[    1.140307] vc-mem: phys_addr:0x00000000 mem_base=0x3ec00000 mem_size:0x40000000(1024 MiB)
[    1.143122] vc-sm: Videocore shared memory driver
[    1.145783] gpiomem-bcm2835 fe200000.gpiomem: Initialised: Registers at 0xfe200000
[    1.159714] brd: module loaded
[    1.173987] loop: module loaded
[    1.177448] Loading iSCSI transport class v2.0-870.
[    1.181550] libphy: Fixed MDIO Bus: probed
[    1.184221] bcmgenet fd580000.ethernet: failed to get enet clock
[    1.186388] bcmgenet fd580000.ethernet: GENET 5.0 EPHY: 0x0000
[    1.188534] bcmgenet fd580000.ethernet: failed to get enet-wol clock
[    1.190706] bcmgenet fd580000.ethernet: failed to get enet-eee clock
[    1.192811] bcmgenet: Skipping UMAC reset
[    1.210692] libphy: bcmgenet MII bus: probed
[    1.290720] unimac-mdio unimac-mdio.-19: Broadcom UniMAC MDIO bus
[    1.293813] usbcore: registered new interface driver r8152
[    1.295944] usbcore: registered new interface driver lan78xx
[    1.298024] usbcore: registered new interface driver smsc95xx
[    1.300429] xhci_hcd 0000:01:00.0: xHCI Host Controller
[    1.302563] xhci_hcd 0000:01:00.0: new USB bus registered, assigned bus number 1
[    1.306699] xhci_hcd 0000:01:00.0: hcc params 0x002841eb hci version 0x100 quirks 0x0000001000000890
[    1.310049] usb usb1: New USB device found, idVendor=1d6b, idProduct=0002, bcdDevice= 5.04
[    1.312171] usb usb1: New USB device strings: Mfr=3, Product=2, SerialNumber=1
[    1.314237] usb usb1: Product: xHCI Host Controller
[    1.316254] usb usb1: Manufacturer: Linux 5.4.51-v7l+ xhci-hcd
[    1.318302] usb usb1: SerialNumber: 0000:01:00.0
[    1.320945] hub 1-0:1.0: USB hub found
[    1.323049] hub 1-0:1.0: 1 port detected
[    1.325543] xhci_hcd 0000:01:00.0: xHCI Host Controller
[    1.327579] xhci_hcd 0000:01:00.0: new USB bus registered, assigned bus number 2
[    1.329613] xhci_hcd 0000:01:00.0: Host supports USB 3.0 SuperSpeed
[    1.332103] usb usb2: New USB device found, idVendor=1d6b, idProduct=0003, bcdDevice= 5.04
[    1.334161] usb usb2: New USB device strings: Mfr=3, Product=2, SerialNumber=1
[    1.336199] usb usb2: Product: xHCI Host Controller
[    1.338181] usb usb2: Manufacturer: Linux 5.4.51-v7l+ xhci-hcd
[    1.340185] usb usb2: SerialNumber: 0000:01:00.0
[    1.342753] hub 2-0:1.0: USB hub found
[    1.344798] hub 2-0:1.0: 4 ports detected
[    1.348222] dwc_otg: version 3.00a 10-AUG-2012 (platform bus)
[    1.350957] usbcore: registered new interface driver uas
[    1.353024] usbcore: registered new interface driver usb-storage
[    1.355164] mousedev: PS/2 mouse device common for all mice
[    1.359202] bcm2835-wdt bcm2835-wdt: Broadcom BCM2835 watchdog timer
[    1.363699] sdhci: Secure Digital Host Controller Interface driver
[    1.365672] sdhci: Copyright(c) Pierre Ossman
[    1.368191] mmc-bcm2835 fe300000.mmcnr: could not get clk, deferring probe
[    1.370791] sdhci-pltfm: SDHCI platform and OF driver helper
[    1.376481] ledtrig-cpu: registered to indicate activity on CPUs
[    1.378811] hidraw: raw HID events driver (C) Jiri Kosina
[    1.381036] usbcore: registered new interface driver usbhid
[    1.383019] usbhid: USB HID core driver
[    1.385986] vchiq: vchiq_init_state: slot_zero = (ptrval)
[    1.389937] [vc_sm_connected_init]: start
[    1.399777] [vc_sm_connected_init]: end - returning 0
[    1.403794] Initializing XFRM netlink socket
[    1.405715] NET: Registered protocol family 17
[    1.407696] Key type dns_resolver registered
[    1.409966] Registering SWP/SWPB emulation handler
[    1.412230] registered taskstats version 1
[    1.414118] Loading compiled-in X.509 certificates
[    1.416470] Key type ._fscrypt registered
[    1.418356] Key type .fscrypt registered
[    1.430211] uart-pl011 fe201000.serial: cts_event_workaround enabled
[    1.432270] fe201000.serial: ttyAMA0 at MMIO 0xfe201000 (irq = 29, base_baud = 0) is a PL011 rev2
[    2.638806] printk: console [ttyAMA0] enabled
[    2.652300] bcm2835-power bcm2835-power: Broadcom BCM2835 power domains driver
[    2.662495] mmc-bcm2835 fe300000.mmcnr: mmc_debug:0 mmc_debug2:0
[    2.670516] mmc-bcm2835 fe300000.mmcnr: DMA channel allocated
[    2.729583] mmc1: queuing unknown CIS tuple 0x80 (2 bytes)
[    2.738773] mmc1: queuing unknown CIS tuple 0x80 (3 bytes)
[    2.747901] mmc1: queuing unknown CIS tuple 0x80 (3 bytes)
[    2.755403] mmc0: SDHCI controller on fe340000.emmc2 [fe340000.emmc2] using ADMA
[    2.767731] mmc1: queuing unknown CIS tuple 0x80 (7 bytes)
[    2.767755] of_cfs_init
[    2.776887] mmc1: queuing unknown CIS tuple 0x80 (3 bytes)
[    2.779823] of_cfs_init: OK
[    2.792920] Waiting for root device /dev/mmcblk0p2...
[    2.831493] random: fast init done
[    2.876151] mmc1: new high speed SDIO card at address 0001
[    2.907096] mmc0: new ultra high speed DDR50 SDHC card at address aaaa
[    2.915661] usb 1-1: new high-speed USB device number 2 using xhci_hcd
[    2.925308] mmcblk0: mmc0:aaaa AGGCD 29.7 GiB
[    2.935647]  mmcblk0: p1 p2 p3 p4
[    2.979797] EXT4-fs (mmcblk0p2): mounted filesystem with ordered data mode. Opts: (null)
[    2.990008] VFS: Mounted root (ext4 filesystem) readonly on device 179:2.
[    3.005551] devtmpfs: mounted
[    3.018548] Freeing unused kernel memory: 2048K
[    3.025390] Run /sbin/init as init process
[    3.064173] Kernel panic - not syncing: Attempted to kill init! exitcode=0x0000000b
[    3.073941] CPU: 2 PID: 1 Comm: init Not tainted 5.4.51-v7l+ #1333
[    3.082163] Hardware name: BCM2711
[    3.087617] Backtrace: 
[    3.092117] [<c020d46c>] (dump_backtrace) from [<c020d768>] (show_stack+0x20/0x24)
[    3.101771]  r6:ef8d8000 r5:00000000 r4:c129c8f8 r3:c6b20987
[    3.109499] [<c020d748>] (show_stack) from [<c0a39a44>] (dump_stack+0xe0/0x124)
[    3.113281] usb 1-1: New USB device found, idVendor=2109, idProduct=3431, bcdDevice= 4.21
[    3.118919] [<c0a39964>] (dump_stack) from [<c0221e74>] (panic+0x12c/0x34c)
[    3.118930]  r8:0000000b r7:c12b5ba8 r6:c0db90c8 r5:00000000 r4:c12b5bd3 r3:00000001
[    3.129232] usb 1-1: New USB device strings: Mfr=0, Product=1, SerialNumber=0
[    3.138283] [<c0221d48>] (panic) from [<c0226a2c>] (do_exit+0xa70/0xb28)
[    3.138292]  r3:ef8dc000 r2:00000000 r1:0000000b r0:c0db90c8
[    3.148171] usb 1-1: Product: USB2.0 Hub
[    3.157416]  r7:00000001
[    3.157432] [<c0225fbc>] (do_exit) from [<c0226b7c>] (do_group_exit+0x4c/0xc4)
[    3.157438]  r7:c1204f8c
[    3.198829] [<c0226b30>] (do_group_exit) from [<c0234154>] (get_signal+0x1a0/0xa74)
[    3.208703]  r6:ef8e00c8 r5:0000000b r4:0000000a r3:ef8d9f44
[    3.216598] [<c0233fb4>] (get_signal) from [<c020c9b4>] (do_work_pending+0x110/0x4fc)
[    3.226695]  r10:00000000 r9:00000000 r8:ef8d9f44 r7:c1204f8c r6:c1204f88 r5:ef8d9fb0
[    3.236811]  r4:ef8d8000
[    3.241622] [<c020c8a4>] (do_work_pending) from [<c0201034>] (slow_work_pending+0xc/0x20)
[    3.252148] Exception stack(0xef8d9fb0 to 0xef8d9ff8)
[    3.259543] 9fa0:                                     b6f69598 b6f68f8c 08080808 b6f68f9c
[    3.270112] 9fc0: 76f6929c b6f38000 6ffffdff 00000000 00000000 00000000 00030534 bed78eec
[    3.280676] 9fe0: b6f69664 bed78eb0 76f68e6c b6f39564 20000010 ffffffff
[    3.289657]  r10:00030534 r9:ef8d8000 r8:00000000 r7:30c5383d r6:ffffffff r5:20000010
[    3.299852]  r4:b6f39564
[    3.304729] CPU3: stopping
[    3.309780] CPU: 3 PID: 0 Comm: swapper/3 Not tainted 5.4.51-v7l+ #1333
[    3.318754] Hardware name: BCM2711
[    3.324527] Backtrace: 
[    3.329366] [<c020d46c>] (dump_backtrace) from [<c020d768>] (show_stack+0x20/0x24)
[    3.339372]  r6:ef906000 r5:00000000 r4:c129c8f8 r3:c6b20987
[    3.347456] [<c020d748>] (show_stack) from [<c0a39a44>] (dump_stack+0xe0/0x124)
[    3.357207] [<c0a39964>] (dump_stack) from [<c02110b8>] (handle_IPI+0x334/0x3bc)
[    3.367045]  r8:c12af840 r7:00000000 r6:00000003 r5:c10a82e4 r4:c12b5a40 r3:c6b20987
[    3.377234] [<c0210d84>] (handle_IPI) from [<c02022f0>] (gic_handle_irq+0x84/0x88)
[    3.387279]  r10:00000000 r9:ef906000 r8:f0815000 r7:f0814000 r6:ef907f38 r5:f081400c
[    3.397602]  r4:c1205a14
[    3.402593] [<c020226c>] (gic_handle_irq) from [<c0201a3c>] (__irq_svc+0x5c/0x7c)
[    3.412594] Exception stack(0xef907f38 to 0xef907f80)
[    3.420163] 7f20:                                                       c0209b94 00000000
[    3.430874] 7f40: 60000093 c021c160 c1204fb4 ef906000 c1204ffc 00000008 c12a32ed 410fd083
[    3.441608] 7f60: 00000000 ef907f94 c12053ac ef907f88 00000000 c0209b98 60000013 ffffffff
[    3.452342]  r8:c12a32ed r7:ef907f6c r6:ffffffff r5:60000013 r4:c0209b98 r3:c6b20987
[    3.462627] [<c0209b64>] (arch_cpu_idle) from [<c0a5aa6c>] (default_idle_call+0x34/0x48)
[    3.473289] [<c0a5aa38>] (default_idle_call) from [<c0255b20>] (do_idle+0xec/0x170)
[    3.483520] [<c0255a34>] (do_idle) from [<c0255e80>] (cpu_startup_entry+0x28/0x2c)
[    3.493682]  r8:00007000 r7:c12b5a50 r6:30c0387d r5:00000003 r4:0000008a r3:c6b20987
[    3.504018] [<c0255e58>] (cpu_startup_entry) from [<c0210b10>] (secondary_start_kernel+0x138/0x144)
[    3.515681] [<c02109d8>] (secondary_start_kernel) from [<002027ac>] (0x2027ac)
[    3.525512]  r5:00000000 r4:2f86dac0
[    3.531697] CPU1: stopping
[    3.537009] CPU: 1 PID: 0 Comm: swapper/1 Not tainted 5.4.51-v7l+ #1333
[    3.546225] Hardware name: BCM2711
[    3.552193] Backtrace: 
[    3.557169] [<c020d46c>] (dump_backtrace) from [<c020d768>] (show_stack+0x20/0x24)
[    3.567312]  r6:ef902000 r5:00000000 r4:c129c8f8 r3:c6b20987
[    3.575508] [<c020d748>] (show_stack) from [<c0a39a44>] (dump_stack+0xe0/0x124)
[    3.585387] [<c0a39964>] (dump_stack) from [<c02110b8>] (handle_IPI+0x334/0x3bc)
[    3.595319]  r8:c12af840 r7:00000000 r6:00000001 r5:c10a82e4 r4:c12b5a40 r3:c6b20987
[    3.605627] [<c0210d84>] (handle_IPI) from [<c02022f0>] (gic_handle_irq+0x84/0x88)
[    3.615776]  r10:00000000 r9:ef902000 r8:f0815000 r7:f0814000 r6:ef903f38 r5:f081400c
[    3.626206]  r4:c1205a14
[    3.631302] [<c020226c>] (gic_handle_irq) from [<c0201a3c>] (__irq_svc+0x5c/0x7c)
[    3.641394] Exception stack(0xef903f38 to 0xef903f80)
[    3.649026] 3f20:                                                       c0209b94 00000000
[    3.659815] 3f40: 60000093 c021c160 c1204fb4 ef902000 c1204ffc 00000002 c12a32ed 410fd083
[    3.670602] 3f60: 00000000 ef903f94 c12053ac ef903f88 00000000 c0209b98 60000013 ffffffff
[    3.681370]  r8:c12a32ed r7:ef903f6c r6:ffffffff r5:60000013 r4:c0209b98 r3:c6b20987
[    3.691708] [<c0209b64>] (arch_cpu_idle) from [<c0a5aa6c>] (default_idle_call+0x34/0x48)
[    3.702409] [<c0a5aa38>] (default_idle_call) from [<c0255b20>] (do_idle+0xec/0x170)
[    3.712643] [<c0255a34>] (do_idle) from [<c0255e80>] (cpu_startup_entry+0x28/0x2c)
[    3.722797]  r8:00007000 r7:c12b5a50 r6:30c0387d r5:00000001 r4:0000008a r3:c6b20987
[    3.733128] [<c0255e58>] (cpu_startup_entry) from [<c0210b10>] (secondary_start_kernel+0x138/0x144)
[    3.744785] [<c02109d8>] (secondary_start_kernel) from [<002027ac>] (0x2027ac)
[    3.754604]  r5:00000000 r4:2f86dac0
[    3.760742] CPU0: stopping
[    3.766026] CPU: 0 PID: 0 Comm: swapper/0 Not tainted 5.4.51-v7l+ #1333
[    3.775241] Hardware name: BCM2711
[    3.781210] Backtrace: 
[    3.786221] [<c020d46c>] (dump_backtrace) from [<c020d768>] (show_stack+0x20/0x24)
[    3.796381]  r6:c1200000 r5:00000000 r4:c129c8f8 r3:c6b20987
[    3.804633] [<c020d748>] (show_stack) from [<c0a39a44>] (dump_stack+0xe0/0x124)
[    3.814555] [<c0a39964>] (dump_stack) from [<c02110b8>] (handle_IPI+0x334/0x3bc)
[    3.824558]  r8:c12af840 r7:00000000 r6:00000000 r5:c10a82e4 r4:c12b5a40 r3:c6b20987
[    3.834905] [<c0210d84>] (handle_IPI) from [<c02022f0>] (gic_handle_irq+0x84/0x88)
[    3.845061]  r10:00000165 r9:c1200000 r8:f0815000 r7:f0814000 r6:c1201ed0 r5:f081400c
[    3.855490]  r4:c1205a14
[    3.860588] [<c020226c>] (gic_handle_irq) from [<c0201a3c>] (__irq_svc+0x5c/0x7c)
[    3.870673] Exception stack(0xc1201ed0 to 0xc1201f18)
[    3.878315] 1ec0:                                     c0209b94 00000000 60000093 c021c160
[    3.889115] 1ee0: c1204fb4 c1200000 c1204ffc 00000001 c12a32ed c106ca48 00000165 c1201f2c
[    3.899911] 1f00: c12053ac c1201f20 00000000 c0209b98 60000013 ffffffff
[    3.909139]  r8:c12a32ed r7:c1201f04 r6:ffffffff r5:60000013 r4:c0209b98 r3:c6b20987
[    3.919504] [<c0209b64>] (arch_cpu_idle) from [<c0a5aa6c>] (default_idle_call+0x34/0x48)
[    3.930204] [<c0a5aa38>] (default_idle_call) from [<c0255b20>] (do_idle+0xec/0x170)
[    3.940468] [<c0255a34>] (do_idle) from [<c0255e80>] (cpu_startup_entry+0x28/0x2c)
[    3.950659]  r8:ffffffff r7:c12b5680 r6:c106ca48 r5:c12b56d8 r4:000000ce r3:c1201f48
[    3.961020] [<c0255e58>] (cpu_startup_entry) from [<c0a53e74>] (rest_init+0xbc/0xc0)
[    3.971379] [<c0a53db8>] (rest_init) from [<c1000bec>] (arch_call_rest_init+0x18/0x1c)
[    3.981890]  r4:c1204f88 r3:c109d270
[    3.988030] [<c1000bd4>] (arch_call_rest_init) from [<c10010d4>] (start_kernel+0x4e4/0x518)
[    3.999023] [<c1000bf0>] (start_kernel) from [<00000000>] (0x0)
[    4.007592] ---[ end Kernel panic - not syncing: Attempted to kill init! exitcode=0x0000000b ]---

I hope it might be useful
Thank you
Mikhail

I think I am having the same issue. Is there a solution to this?