Re: [Qemu-devel] Booting Raspbian on RPi emulation

[Guenter Roeck <linux@roeck-us.net>]

[-- Attachment #1: Type: text/plain, Size: 1557 bytes --]

On 11/29/18 4:43 PM, Philippe Mathieu-Daudé wrote:
> Hi Zoltan,
> 
> On 29/11/18 21:29, BALATON Zoltan wrote:
>> Hello,
>>
>> I could not boot Raspbian on QEMU's raspi emulation and I'm not sure why
>> it fails. So question is if this is supposed to work or am I doing
>> something wrong or any clues what may be missing? I'm trying with this
>> command line with v3.1.0-rc3:
>>
>> qemu-system-arm -M raspi2 -serial stdio \
>> -kernel rpi-kernel7.img -dtb bcm2709-rpi-2-b.dtb \
>> -append "rw earlyprintk loglevel=8 console=ttyAMA0,115200
>> dwc_otg.lpm_enable=0 root=/dev/mmcblk0p2" \
>> -drive file=2018-10-09-raspbian-stretch-lite.img,format=raw,if=sd
>>
>> Kernel starts to boot, I see raspberries on the guest screen and log
>> output to serial:
>>
>> Booting Linux on physical CPU 0xf00
>> Linux version 4.14.71-v7+ (dc4@dc4-XPS13-9333) (gcc version 4.9.3
>> (crosstool-NG crosstool-ng-1.22.0-88-g8460611)) #1145 SMP Fri Sep 21
>> 15:38:35 BST 2018
>> CPU: ARMv7 Processor [410fc075] revision 5 (ARMv7), cr=10c5387d
>> [...]
>>
>

My version (https://github.com/groeck/qemu) seems to work, using multi_v7_defconfig.
Logs from boots with qemu 3.0 and 3.1 attached.

Command line:

/opt/buildbot/qemu-install/v3.0/bin/qemu-system-arm \
	-M raspi2 -kernel arch/arm/boot/zImage -no-reboot \
	-snapshot -drive file=core-image-minimal-qemuarm.ext3,format=raw,if=sd \
	--append 'earlycon=pl011,0x3f201000 root=/dev/mmcblk0 rootwait rw console=ttyAMA0 noreboot' \
	-dtb arch/arm/boot/dts/bcm2836-rpi-2-b.dtb \
	-nographic -monitor null -serial stdio

Guenter

[-- Warning: decoded text below may be mangled, UTF-8 assumed --]
[-- Attachment #2: rasip2.30.log --]
[-- Type: text/x-log; name="rasip2.30.log", Size: 13768 bytes --]

SMC cmd 0x0 val 0x31
SMC cmd 0x0 val 0x31
SMC cmd 0x0 val 0x31
SMC cmd 0x0 val 0x31
[    0.000000] Booting Linux on physical CPU 0xf00
[    0.000000] Linux version 4.20.0-rc4-00149-gf92a2ebb3d55 (groeck@server.roeck-us.net) (gcc version 7.3.0 (GCC)) #1 SMP Thu Nov 29 17:18:19 PST 2018
[    0.000000] CPU: ARMv7 Processor [410fc075] revision 5 (ARMv7), cr=10c5387d
[    0.000000] CPU: PIPT / VIPT nonaliasing data cache, VIPT aliasing instruction cache
[    0.000000] OF: fdt: Machine model: Raspberry Pi 2 Model B
[    0.000000] earlycon: pl11 at MMIO 0x3f201000 (options '')
[    0.000000] printk: bootconsole [pl11] enabled
[    0.000000] Memory policy: Data cache writealloc
[    0.000000] efi: Getting EFI parameters from FDT:
[    0.000000] efi: UEFI not found.
[    0.000000] cma: Reserved 64 MiB at 0x38000000
[    0.000000] random: get_random_bytes called from start_kernel+0xa0/0x468 with crng_init=0
[    0.000000] percpu: Embedded 17 pages/cpu @(ptrval) s40140 r8192 d21300 u69632
[    0.000000] Built 1 zonelists, mobility grouping on.  Total pages: 244224
[    0.000000] Kernel command line: earlycon=pl011,0x3f201000 root=/dev/mmcblk0 rootwait rw console=ttyAMA0 noreboot
[    0.000000] Dentry cache hash table entries: 131072 (order: 7, 524288 bytes)
[    0.000000] Inode-cache hash table entries: 65536 (order: 6, 262144 bytes)
[    0.000000] Memory: 887180K/983040K available (12288K kernel code, 1612K rwdata, 4732K rodata, 2048K init, 396K bss, 30324K reserved, 65536K cma-reserved, 131072K highmem)
[    0.000000] Virtual kernel memory layout:
[    0.000000]     vector  : 0xffff0000 - 0xffff1000   (   4 kB)
[    0.000000]     fixmap  : 0xffc00000 - 0xfff00000   (3072 kB)
[    0.000000]     vmalloc : 0xf0800000 - 0xff800000   ( 240 MB)
[    0.000000]     lowmem  : 0xc0000000 - 0xf0000000   ( 768 MB)
[    0.000000]     pkmap   : 0xbfe00000 - 0xc0000000   (   2 MB)
[    0.000000]     modules : 0xbf000000 - 0xbfe00000   (  14 MB)
[    0.000000]       .text : 0x(ptrval) - 0x(ptrval)   (13280 kB)
[    0.000000]       .init : 0x(ptrval) - 0x(ptrval)   (2048 kB)
[    0.000000]       .data : 0x(ptrval) - 0x(ptrval)   (1613 kB)
[    0.000000]        .bss : 0x(ptrval) - 0x(ptrval)   ( 397 kB)
[    0.000000] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=4, Nodes=1
[    0.000000] rcu: Hierarchical RCU implementation.
[    0.000000] rcu: 	RCU event tracing is enabled.
[    0.000000] rcu: 	RCU restricting CPUs from NR_CPUS=16 to nr_cpu_ids=4.
[    0.000000] rcu: RCU calculated value of scheduler-enlistment delay is 10 jiffies.
[    0.000000] rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=4
[    0.000000] NR_IRQS: 16, nr_irqs: 16, preallocated irqs: 16
[    0.000000] sched_clock: 32 bits at 1000kHz, resolution 1000ns, wraps every 2147483647500ns
[    0.000000] clocksource: timer: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275 ns
[    0.000000] bcm2835: system timer (irq = 27)
[    0.000000] arch_timer: cp15 timer(s) running at 62.50MHz (virt).
[    0.000000] clocksource: arch_sys_counter: mask: 0xffffffffffffff max_cycles: 0x1cd42e208c, max_idle_ns: 881590405314 ns
[    0.000029] sched_clock: 56 bits at 62MHz, resolution 16ns, wraps every 4398046511096ns
[    0.000494] Switching to timer-based delay loop, resolution 16ns
[    0.004456] Console: colour dummy device 80x30
[    0.005906] Calibrating delay loop (skipped), value calculated using timer frequency.. 125.00 BogoMIPS (lpj=625000)
[    0.006475] pid_max: default: 32768 minimum: 301
[    0.007812] Mount-cache hash table entries: 2048 (order: 1, 8192 bytes)
[    0.008106] Mountpoint-cache hash table entries: 2048 (order: 1, 8192 bytes)
[    0.021948] CPU: Testing write buffer coherency: ok
[    0.032257] CPU0: update cpu_capacity 1024
[    0.032506] CPU0: thread -1, cpu 0, socket 15, mpidr 80000f00
[    0.037656] Setting up static identity map for 0x300000 - 0x3000a0
[    0.040639] rcu: Hierarchical SRCU implementation.
[    0.047695] EFI services will not be available.
[    0.049243] smp: Bringing up secondary CPUs ...
[    0.052497] CPU1: update cpu_capacity 1024
[    0.052532] CPU1: thread -1, cpu 1, socket 15, mpidr 80000f01
[    0.056708] CPU2: update cpu_capacity 1024
[    0.056728] CPU2: thread -1, cpu 2, socket 15, mpidr 80000f02
[    0.058471] CPU3: update cpu_capacity 1024
[    0.058486] CPU3: thread -1, cpu 3, socket 15, mpidr 80000f03
[    0.058918] smp: Brought up 1 node, 4 CPUs
[    0.059509] SMP: Total of 4 processors activated (500.00 BogoMIPS).
[    0.059658] CPU: All CPU(s) started in SVC mode.
[    0.101819] devtmpfs: initialized
[    0.120285] VFP support v0.3: implementor 41 architecture 2 part 30 variant 7 rev 5
[    0.132058] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 19112604462750000 ns
[    0.132860] futex hash table entries: 1024 (order: 4, 65536 bytes)
[    0.140543] pinctrl core: initialized pinctrl subsystem
[    0.152733] DMI not present or invalid.
[    0.158677] NET: Registered protocol family 16
[    0.177474] DMA: preallocated 256 KiB pool for atomic coherent allocations
[    0.187133] cpuidle: using governor menu
[    0.188084] No ATAGs?
[    0.190514] hw-breakpoint: found 5 (+1 reserved) breakpoint and 4 watchpoint registers.
[    0.190699] hw-breakpoint: maximum watchpoint size is 8 bytes.
[    0.195972] Serial: AMBA PL011 UART driver
[    0.259895] AT91: Could not find identification node
[    0.270416] vgaarb: loaded
[    0.272704] SCSI subsystem initialized
[    0.275759] usbcore: registered new interface driver usbfs
[    0.276268] usbcore: registered new interface driver hub
[    0.276622] usbcore: registered new device driver usb
[    0.280134] pps_core: LinuxPPS API ver. 1 registered
[    0.280324] pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti <giometti@linux.it>
[    0.280802] PTP clock support registered
[    0.281816] EDAC MC: Ver: 3.0.0
[    0.301689] clocksource: Switched to clocksource arch_sys_counter
[    0.447584] NET: Registered protocol family 2
[    0.453363] tcp_listen_portaddr_hash hash table entries: 512 (order: 0, 6144 bytes)
[    0.453585] TCP established hash table entries: 8192 (order: 3, 32768 bytes)
[    0.453893] TCP bind hash table entries: 8192 (order: 4, 65536 bytes)
[    0.454164] TCP: Hash tables configured (established 8192 bind 8192)
[    0.455644] UDP hash table entries: 512 (order: 2, 16384 bytes)
[    0.455857] UDP-Lite hash table entries: 512 (order: 2, 16384 bytes)
[    0.456844] NET: Registered protocol family 1
[    0.460303] RPC: Registered named UNIX socket transport module.
[    0.460600] RPC: Registered udp transport module.
[    0.460723] RPC: Registered tcp transport module.
[    0.460792] RPC: Registered tcp NFSv4.1 backchannel transport module.
[    0.469505] hw perfevents: enabled with armv7_cortex_a7 PMU driver, 1 counters available
[    0.472898] Initialise system trusted keyrings
[    0.474593] workingset: timestamp_bits=30 max_order=18 bucket_order=0
[    0.486333] squashfs: version 4.0 (2009/01/31) Phillip Lougher
[    0.488704] NFS: Registering the id_resolver key type
[    0.488970] Key type id_resolver registered
[    0.489059] Key type id_legacy registered
[    0.489445] ntfs: driver 2.1.32 [Flags: R/O].
[    0.521793] Key type asymmetric registered
[    0.521963] Asymmetric key parser 'x509' registered
[    0.522241] bounce: pool size: 64 pages
[    0.522576] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 247)
[    0.522867] io scheduler noop registered
[    0.522975] io scheduler deadline registered
[    0.523411] io scheduler cfq registered (default)
[    0.523541] io scheduler mq-deadline registered
[    0.523630] io scheduler kyber registered
[    0.851239] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled
[    0.860235] SuperH (H)SCI(F) driver initialized
[    0.862056] msm_serial: driver initialized
[    0.862422] STMicroelectronics ASC driver initialized
[    0.864107] STM32 USART driver initialized
[    0.867582] bcm2835-rng 3f104000.rng: hwrng registered
[    0.911308] brd: module loaded
[    0.930971] loop: module loaded
[    0.948186] libphy: Fixed MDIO Bus: probed
[    0.950236] CAN device driver interface
[    0.951796] bgmac_bcma: Broadcom 47xx GBit MAC driver loaded
[    0.953663] e1000e: Intel(R) PRO/1000 Network Driver - 3.2.6-k
[    0.953744] e1000e: Copyright(c) 1999 - 2015 Intel Corporation.
[    0.953926] igb: Intel(R) Gigabit Ethernet Network Driver - version 5.4.0-k
[    0.954023] igb: Copyright (c) 2007-2014 Intel Corporation.
[    0.960700] pegasus: v0.9.3 (2013/04/25), Pegasus/Pegasus II USB Ethernet driver
[    0.960897] usbcore: registered new interface driver pegasus
[    0.961076] usbcore: registered new interface driver asix
[    0.961218] usbcore: registered new interface driver ax88179_178a
[    0.961364] usbcore: registered new interface driver cdc_ether
[    0.961555] usbcore: registered new interface driver smsc75xx
[    0.961725] usbcore: registered new interface driver smsc95xx
[    0.961871] usbcore: registered new interface driver net1080
[    0.962014] usbcore: registered new interface driver cdc_subset
[    0.962157] usbcore: registered new interface driver zaurus
[    0.962354] usbcore: registered new interface driver cdc_ncm
[    0.966251] ehci_hcd: USB 2.0 'Enhanced' Host Controller (EHCI) Driver
[    0.966396] ehci-pci: EHCI PCI platform driver
[    0.966642] ehci-platform: EHCI generic platform driver
[    0.967040] ehci-orion: EHCI orion driver
[    0.967380] SPEAr-ehci: EHCI SPEAr driver
[    0.967701] ehci-st: EHCI STMicroelectronics driver
[    0.968031] ehci-exynos: EHCI EXYNOS driver
[    0.968375] ehci-atmel: EHCI Atmel driver
[    0.968698] tegra-ehci: Tegra EHCI driver
[    0.969046] ohci_hcd: USB 1.1 'Open' Host Controller (OHCI) Driver
[    0.969202] ohci-pci: OHCI PCI platform driver
[    0.969429] ohci-platform: OHCI generic platform driver
[    0.969808] SPEAr-ohci: OHCI SPEAr driver
[    0.970130] ohci-st: OHCI STMicroelectronics driver
[    0.970629] ohci-atmel: OHCI Atmel driver
[    0.972126] usbcore: registered new interface driver usb-storage
[    0.982521] i2c /dev entries driver
[    0.987617] i2c-bcm2835 3f805000.i2c: Could not read clock-frequency property
[    1.013664] bcm2835-wdt 3f100000.watchdog: Broadcom BCM2835 watchdog timer
[    1.020569] sdhci: Secure Digital Host Controller Interface driver
[    1.020660] sdhci: Copyright(c) Pierre Ossman
[    1.023916] Synopsys Designware Multimedia Card Interface Driver
[    1.129393] sdhost-bcm2835 3f202000.mmc: loaded - DMA enabled (>1)
[    1.130015] sdhci-pltfm: SDHCI platform and OF driver helper
[    1.146440] ledtrig-cpu: registered to indicate activity on CPUs
[    1.148332] usbcore: registered new interface driver usbhid
[    1.148423] usbhid: USB HID core driver
[    1.150810] bcm2835-mbox 3f00b880.mailbox: mailbox enabled
[    1.157622] NET: Registered protocol family 10
[    1.163802] Segment Routing with IPv6
[    1.164255] sit: IPv6, IPv4 and MPLS over IPv4 tunneling driver
[    1.166773] NET: Registered protocol family 17
[    1.166936] can: controller area network core (rev 20170425 abi 9)
[    1.167339] NET: Registered protocol family 29
[    1.167445] can: raw protocol (rev 20170425)
[    1.167578] can: broadcast manager protocol (rev 20170425 t)
[    1.167752] can: netlink gateway (rev 20170425) max_hops=1
[    1.168711] Key type dns_resolver registered
[    1.169271] ThumbEE CPU extension supported.
[    1.169383] Registering SWP/SWPB emulation handler
[    1.172598] Loading compiled-in X.509 certificates
[    1.190016] 3f201000.serial: ttyAMA0 at MMIO 0x3f201000 (irq = 81, base_baud = 0) is a PL011 rev2
[    1.191256] printk: console [ttyAMA0] enabled
[    1.191256] printk: console [ttyAMA0] enabled
[    1.191625] printk: bootconsole [pl11] disabled
[    1.191625] printk: bootconsole [pl11] disabled
[    1.205666] raspberrypi-firmware soc:firmware: Attached to firmware from 1970-01-05 00:12
[    1.212553] dwc2 3f980000.usb: 3f980000.usb supply vusb_d not found, using dummy regulator
[    1.213141] dwc2 3f980000.usb: Linked as a consumer to regulator.0
[    1.213276] dwc2 3f980000.usb: 3f980000.usb supply vusb_a not found, using dummy regulator
[    1.214345] dwc2 3f980000.usb: dwc2_core_reset: HANG! Soft Reset timeout GRSTCTL GRSTCTL_CSFTRST
[    1.216492] dwc2: probe of 3f980000.usb failed with error -16
[    1.218417] hctosys: unable to open rtc device (rtc0)
[    1.222984] uart-pl011 3f201000.serial: no DMA platform data
[    1.225904] Waiting for root device /dev/mmcblk0...
[    1.237574] mmc0: host does not support reading read-only switch, assuming write-enable
[    1.238291] mmc0: Problem switching card into high-speed mode!
[    1.238841] mmc0: new SD card at address 4567
[    1.242409] mmcblk0: mmc0:4567 QEMU! 8.00 MiB 
[    1.289167] EXT4-fs (mmcblk0): mounting ext3 file system using the ext4 subsystem
[    1.311524] EXT4-fs (mmcblk0): mounted filesystem with ordered data mode. Opts: (null)
[    1.312945] VFS: Mounted root (ext3 filesystem) on device 179:0.
[    1.321791] devtmpfs: mounted
[    1.437851] Freeing unused kernel memory: 2048K
[    1.565062] Run /sbin/init as init process
\rINIT: version 2.88 booting
mount: mounting devtmpfs on /dev failed: Device or resource busy
\rINIT: Entering runlevel: 5

Boot successful.
/ # reboot
\rINIT: Switching to runlevel: 6
/ # \rINIT: Sending processes the TERM signal
\rINIT: Sending processes the KILL signal
\rINIT: no more processes left in this runlevel

[-- Warning: decoded text below may be mangled, UTF-8 assumed --]
[-- Attachment #3: rasip2.31.log --]
[-- Type: text/x-log; name="rasip2.31.log", Size: 13790 bytes --]

SMC cmd 0x0 val 0x131
SMC cmd 0x0 val 0x131
SMC cmd 0x0 val 0x131
SMC cmd 0x0 val 0x131
[    0.000000] Booting Linux on physical CPU 0xf00
[    0.000000] Linux version 4.20.0-rc4-00149-gf92a2ebb3d55 (groeck@server.roeck-us.net) (gcc version 7.3.0 (GCC)) #1 SMP Thu Nov 29 17:18:19 PST 2018
[    0.000000] CPU: ARMv7 Processor [410fc075] revision 5 (ARMv7), cr=10c5387d
[    0.000000] CPU: div instructions available: patching division code
[    0.000000] CPU: PIPT / VIPT nonaliasing data cache, VIPT aliasing instruction cache
[    0.000000] OF: fdt: Machine model: Raspberry Pi 2 Model B
[    0.000000] earlycon: pl11 at MMIO 0x3f201000 (options '')
[    0.000000] printk: bootconsole [pl11] enabled
[    0.000000] Memory policy: Data cache writealloc
[    0.000000] efi: Getting EFI parameters from FDT:
[    0.000000] efi: UEFI not found.
[    0.000000] cma: Reserved 64 MiB at 0x38000000
[    0.000000] random: get_random_bytes called from start_kernel+0xa0/0x468 with crng_init=0
[    0.000000] percpu: Embedded 17 pages/cpu @(ptrval) s40140 r8192 d21300 u69632
[    0.000000] Built 1 zonelists, mobility grouping on.  Total pages: 244224
[    0.000000] Kernel command line: earlycon=pl011,0x3f201000 root=/dev/mmcblk0 rootwait rw console=ttyAMA0 noreboot
[    0.000000] Dentry cache hash table entries: 131072 (order: 7, 524288 bytes)
[    0.000000] Inode-cache hash table entries: 65536 (order: 6, 262144 bytes)
[    0.000000] Memory: 887180K/983040K available (12288K kernel code, 1612K rwdata, 4732K rodata, 2048K init, 396K bss, 30324K reserved, 65536K cma-reserved, 131072K highmem)
[    0.000000] Virtual kernel memory layout:
[    0.000000]     vector  : 0xffff0000 - 0xffff1000   (   4 kB)
[    0.000000]     fixmap  : 0xffc00000 - 0xfff00000   (3072 kB)
[    0.000000]     vmalloc : 0xf0800000 - 0xff800000   ( 240 MB)
[    0.000000]     lowmem  : 0xc0000000 - 0xf0000000   ( 768 MB)
[    0.000000]     pkmap   : 0xbfe00000 - 0xc0000000   (   2 MB)
[    0.000000]     modules : 0xbf000000 - 0xbfe00000   (  14 MB)
[    0.000000]       .text : 0x(ptrval) - 0x(ptrval)   (13280 kB)
[    0.000000]       .init : 0x(ptrval) - 0x(ptrval)   (2048 kB)
[    0.000000]       .data : 0x(ptrval) - 0x(ptrval)   (1613 kB)
[    0.000000]        .bss : 0x(ptrval) - 0x(ptrval)   ( 397 kB)
[    0.000000] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=4, Nodes=1
[    0.000000] rcu: Hierarchical RCU implementation.
[    0.000000] rcu: 	RCU event tracing is enabled.
[    0.000000] rcu: 	RCU restricting CPUs from NR_CPUS=16 to nr_cpu_ids=4.
[    0.000000] rcu: RCU calculated value of scheduler-enlistment delay is 10 jiffies.
[    0.000000] rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=4
[    0.000000] NR_IRQS: 16, nr_irqs: 16, preallocated irqs: 16
[    0.000000] sched_clock: 32 bits at 1000kHz, resolution 1000ns, wraps every 2147483647500ns
[    0.000000] clocksource: timer: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275 ns
[    0.000000] bcm2835: system timer (irq = 27)
[    0.000000] arch_timer: cp15 timer(s) running at 62.50MHz (virt).
[    0.000000] clocksource: arch_sys_counter: mask: 0xffffffffffffff max_cycles: 0x1cd42e208c, max_idle_ns: 881590405314 ns
[    0.000117] sched_clock: 56 bits at 62MHz, resolution 16ns, wraps every 4398046511096ns
[    0.001746] Switching to timer-based delay loop, resolution 16ns
[    0.027314] Console: colour dummy device 80x30
[    0.032701] Calibrating delay loop (skipped), value calculated using timer frequency.. 125.00 BogoMIPS (lpj=625000)
[    0.034670] pid_max: default: 32768 minimum: 301
[    0.040012] Mount-cache hash table entries: 2048 (order: 1, 8192 bytes)
[    0.041113] Mountpoint-cache hash table entries: 2048 (order: 1, 8192 bytes)
[    0.079101] CPU: Testing write buffer coherency: ok
[    0.117416] CPU0: update cpu_capacity 1024
[    0.118162] CPU0: thread -1, cpu 0, socket 15, mpidr 80000f00
[    0.137283] Setting up static identity map for 0x300000 - 0x3000a0
[    0.148873] rcu: Hierarchical SRCU implementation.
[    0.177043] EFI services will not be available.
[    0.182711] smp: Bringing up secondary CPUs ...
[    0.192922] CPU1: update cpu_capacity 1024
[    0.193038] CPU1: thread -1, cpu 1, socket 15, mpidr 80000f01
[    0.207649] CPU2: update cpu_capacity 1024
[    0.207720] CPU2: thread -1, cpu 2, socket 15, mpidr 80000f02
[    0.221110] CPU3: update cpu_capacity 1024
[    0.221171] CPU3: thread -1, cpu 3, socket 15, mpidr 80000f03
[    0.222531] smp: Brought up 1 node, 4 CPUs
[    0.224535] SMP: Total of 4 processors activated (500.00 BogoMIPS).
[    0.224955] CPU: All CPU(s) started in SVC mode.
[    0.369881] devtmpfs: initialized
[    0.423248] VFP support v0.3: implementor 41 architecture 2 part 30 variant 7 rev 5
[    0.471372] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 19112604462750000 ns
[    0.475540] futex hash table entries: 1024 (order: 4, 65536 bytes)
[    0.503827] pinctrl core: initialized pinctrl subsystem
[    0.550379] DMI not present or invalid.
[    0.583346] NET: Registered protocol family 16
[    0.651054] DMA: preallocated 256 KiB pool for atomic coherent allocations
[    0.691148] cpuidle: using governor menu
[    0.696782] No ATAGs?
[    0.705448] hw-breakpoint: found 5 (+1 reserved) breakpoint and 4 watchpoint registers.
[    0.706267] hw-breakpoint: maximum watchpoint size is 8 bytes.
[    0.735248] Serial: AMBA PL011 UART driver
[    0.991236] AT91: Could not find identification node
[    1.026916] vgaarb: loaded
[    1.039641] SCSI subsystem initialized
[    1.048466] usbcore: registered new interface driver usbfs
[    1.049549] usbcore: registered new interface driver hub
[    1.050485] usbcore: registered new device driver usb
[    1.061555] pps_core: LinuxPPS API ver. 1 registered
[    1.061800] pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti <giometti@linux.it>
[    1.062440] PTP clock support registered
[    1.064318] EDAC MC: Ver: 3.0.0
[    1.123678] clocksource: Switched to clocksource arch_sys_counter
[    1.717573] NET: Registered protocol family 2
[    1.734174] tcp_listen_portaddr_hash hash table entries: 512 (order: 0, 6144 bytes)
[    1.734722] TCP established hash table entries: 8192 (order: 3, 32768 bytes)
[    1.735470] TCP bind hash table entries: 8192 (order: 4, 65536 bytes)
[    1.736153] TCP: Hash tables configured (established 8192 bind 8192)
[    1.741918] UDP hash table entries: 512 (order: 2, 16384 bytes)
[    1.742691] UDP-Lite hash table entries: 512 (order: 2, 16384 bytes)
[    1.746525] NET: Registered protocol family 1
[    1.756903] RPC: Registered named UNIX socket transport module.
[    1.757265] RPC: Registered udp transport module.
[    1.757478] RPC: Registered tcp transport module.
[    1.757667] RPC: Registered tcp NFSv4.1 backchannel transport module.
[    1.795176] hw perfevents: enabled with armv7_cortex_a7 PMU driver, 1 counters available
[    1.810646] Initialise system trusted keyrings
[    1.814930] workingset: timestamp_bits=30 max_order=18 bucket_order=0
[    1.866016] squashfs: version 4.0 (2009/01/31) Phillip Lougher
[    1.874467] NFS: Registering the id_resolver key type
[    1.875362] Key type id_resolver registered
[    1.875622] Key type id_legacy registered
[    1.876942] ntfs: driver 2.1.32 [Flags: R/O].
[    1.987232] Key type asymmetric registered
[    1.987717] Asymmetric key parser 'x509' registered
[    1.989527] bounce: pool size: 64 pages
[    1.990750] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 247)
[    1.991686] io scheduler noop registered
[    1.992036] io scheduler deadline registered
[    1.993692] io scheduler cfq registered (default)
[    1.994094] io scheduler mq-deadline registered
[    1.994351] io scheduler kyber registered
[    3.282065] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled
[    3.321875] SuperH (H)SCI(F) driver initialized
[    3.329370] msm_serial: driver initialized
[    3.331017] STMicroelectronics ASC driver initialized
[    3.338302] STM32 USART driver initialized
[    3.353291] bcm2835-rng 3f104000.rng: hwrng registered
[    3.527899] brd: module loaded
[    3.593166] loop: module loaded
[    3.677326] libphy: Fixed MDIO Bus: probed
[    3.686731] CAN device driver interface
[    3.693415] bgmac_bcma: Broadcom 47xx GBit MAC driver loaded
[    3.702348] e1000e: Intel(R) PRO/1000 Network Driver - 3.2.6-k
[    3.702612] e1000e: Copyright(c) 1999 - 2015 Intel Corporation.
[    3.703250] igb: Intel(R) Gigabit Ethernet Network Driver - version 5.4.0-k
[    3.703508] igb: Copyright (c) 2007-2014 Intel Corporation.
[    3.734773] pegasus: v0.9.3 (2013/04/25), Pegasus/Pegasus II USB Ethernet driver
[    3.735408] usbcore: registered new interface driver pegasus
[    3.736019] usbcore: registered new interface driver asix
[    3.736502] usbcore: registered new interface driver ax88179_178a
[    3.736979] usbcore: registered new interface driver cdc_ether
[    3.737598] usbcore: registered new interface driver smsc75xx
[    3.738161] usbcore: registered new interface driver smsc95xx
[    3.739117] usbcore: registered new interface driver net1080
[    3.739731] usbcore: registered new interface driver cdc_subset
[    3.740209] usbcore: registered new interface driver zaurus
[    3.740939] usbcore: registered new interface driver cdc_ncm
[    3.758422] ehci_hcd: USB 2.0 'Enhanced' Host Controller (EHCI) Driver
[    3.759276] ehci-pci: EHCI PCI platform driver
[    3.760353] ehci-platform: EHCI generic platform driver
[    3.762047] ehci-orion: EHCI orion driver
[    3.763477] SPEAr-ehci: EHCI SPEAr driver
[    3.764831] ehci-st: EHCI STMicroelectronics driver
[    3.766243] ehci-exynos: EHCI EXYNOS driver
[    3.767604] ehci-atmel: EHCI Atmel driver
[    3.769465] tegra-ehci: Tegra EHCI driver
[    3.771060] ohci_hcd: USB 1.1 'Open' Host Controller (OHCI) Driver
[    3.771557] ohci-pci: OHCI PCI platform driver
[    3.772392] ohci-platform: OHCI generic platform driver
[    3.773961] SPEAr-ohci: OHCI SPEAr driver
[    3.775313] ohci-st: OHCI STMicroelectronics driver
[    3.776715] ohci-atmel: OHCI Atmel driver
[    3.783371] usbcore: registered new interface driver usb-storage
[    3.831089] i2c /dev entries driver
[    3.847005] i2c-bcm2835 3f805000.i2c: Could not read clock-frequency property
[    3.937999] bcm2835-wdt 3f100000.watchdog: Broadcom BCM2835 watchdog timer
[    3.972350] sdhci: Secure Digital Host Controller Interface driver
[    3.972635] sdhci: Copyright(c) Pierre Ossman
[    3.988019] Synopsys Designware Multimedia Card Interface Driver
[    4.129620] sdhost-bcm2835 3f202000.mmc: loaded - DMA enabled (>1)
[    4.132195] sdhci-pltfm: SDHCI platform and OF driver helper
[    4.180351] ledtrig-cpu: registered to indicate activity on CPUs
[    4.191921] usbcore: registered new interface driver usbhid
[    4.192203] usbhid: USB HID core driver
[    4.202516] bcm2835-mbox 3f00b880.mailbox: mailbox enabled
[    4.232828] NET: Registered protocol family 10
[    4.258002] Segment Routing with IPv6
[    4.260677] sit: IPv6, IPv4 and MPLS over IPv4 tunneling driver
[    4.271203] NET: Registered protocol family 17
[    4.271901] can: controller area network core (rev 20170425 abi 9)
[    4.273334] NET: Registered protocol family 29
[    4.273699] can: raw protocol (rev 20170425)
[    4.274156] can: broadcast manager protocol (rev 20170425 t)
[    4.274612] can: netlink gateway (rev 20170425) max_hops=1
[    4.278342] Key type dns_resolver registered
[    4.281451] ThumbEE CPU extension supported.
[    4.281927] Registering SWP/SWPB emulation handler
[    4.288864] mmc0: host does not support reading read-only switch, assuming write-enable
[    4.290586] mmc0: Problem switching card into high-speed mode!
[    4.292048] mmc0: new SD card at address 4567
[    4.292642] Loading compiled-in X.509 certificates
[    4.301384] mmcblk0: mmc0:4567 QEMU! 8.00 MiB 
[    4.341366] 3f201000.serial: ttyAMA0 at MMIO 0x3f201000 (irq = 81, base_baud = 0) is a PL011 rev2
[    4.346087] printk: console [ttyAMA0] enabled
[    4.346087] printk: console [ttyAMA0] enabled
[    4.347621] printk: bootconsole [pl11] disabled
[    4.347621] printk: bootconsole [pl11] disabled
[    4.407192] raspberrypi-firmware soc:firmware: Attached to firmware from 1970-01-05 00:12
[    4.437476] dwc2 3f980000.usb: 3f980000.usb supply vusb_d not found, using dummy regulator
[    4.440238] dwc2 3f980000.usb: Linked as a consumer to regulator.0
[    4.440815] dwc2 3f980000.usb: 3f980000.usb supply vusb_a not found, using dummy regulator
[    4.445041] dwc2 3f980000.usb: dwc2_core_reset: HANG! Soft Reset timeout GRSTCTL GRSTCTL_CSFTRST
[    4.454368] dwc2: probe of 3f980000.usb failed with error -16
[    4.463077] hctosys: unable to open rtc device (rtc0)
[    4.481120] uart-pl011 3f201000.serial: no DMA platform data
[    4.516413] EXT4-fs (mmcblk0): mounting ext3 file system using the ext4 subsystem
[    4.597971] EXT4-fs (mmcblk0): mounted filesystem with ordered data mode. Opts: (null)
[    4.604442] VFS: Mounted root (ext3 filesystem) on device 179:0.
[    4.631342] devtmpfs: mounted
[    4.872227] Freeing unused kernel memory: 2048K
[    5.077318] Run /sbin/init as init process
\rINIT: version 2.88 booting
mount: mounting devtmpfs on /dev failed: Device or resource busy
\rINIT: Entering runlevel: 5

Boot successful.
/ # poweroff
\rINIT: Switching to runlevel: 0
/ # \rINIT: Sending processes the TERM signal
\rINIT: Sending processes the KILL signal
\rINIT: no more processes left in this runlevel