second guest crashing with Linux 5.13
41 views
Skip to first unread message
vysakh pillai
Jul 6, 2021, 12:22:47 AM7/6/21
to xvisor...@googlegroups.com
Hi,
I am seeing a crash while bringing up the second guest on a RISCV (QEMU) platform using the latest linux 5.13 kernel. Keeping the rest of the system the system same, I am able to execute 2 guests with linux kernel 5.4.
Toolchain versions:
Compiler : riscv64-unknown-linux-gnu- (11.1.0 / tag 2021.06.26)
xvisor-next : 32153a147
Busybox : 1.33.1
Linux Kernel : 5.12 (works) / 5.13 (fails)
Failure log and full boot log as given below:
Failure log:
[guest1/uart0] [ 1.249155] Hardware name: Virt64 (DT)
[guest1/uart0] [ 1.280242] Call Trace:
[guest1/uart0] [ 1.283266] Unable to handle kernel NULL pointer dereference at virtual address 0000000000000888
[guest1/uart0] [ 1.326317] Oops [#1]
[guest1/uart0] [ 1.360259] Modules linked in:
[guest1/uart0] [ 1.364224] CPU: 0 PID: 0 Comm: swapper/0 Not tainted 5.13.0 #1
[guest1/uart0] [ 1.392297] Hardware name: Virt64 (DT)
[guest1/uart0] [ 1.411481] epc : walk_stackframe+0xb0/0xc6
[guest1/uart0] [ 1.416391] ra : dump_backtrace+0x1c/0x24
[guest1/uart0] [ 1.433860] epc : ffffffff800048b0 ra : ffffffff800048e2 sp : ffffffff81203a40
[guest1/uart0] [ 1.456880] gp : ffffffff812e43e0 tp : ffffffff8120bd80 t0 : ffffffff812f20df
[guest1/uart0] [ 1.483773] t1 : ffffffff812f20d0 t2 : 0000000000000000 s0 : ffffffff81203a90
[guest1/uart0] [ 1.490774] s1 : ffffffff80db2250 a0 : 0000000000001000 a1 : 0000000000000000
[guest1/uart0] [ 1.509931] a2 : ffffffff80707e06 a3 : ffffffff80db2250 a4 : 0000000000000000
[guest1/uart0] [ 1.529133] a5 : 0000000000001000 a6 : 0000000000000005 a7 : ffffffffffffffff
[guest1/uart0] [ 1.551181] s2 : 0000000000000000 s3 : 0000000000000000 s4 : 0000000000000000
[guest1/uart0] [ 1.558040] s5 : ffffffff80db2250 s6 : ffffffff80707e06 s7 : 0000000000000cc0
[guest1/uart0] [ 1.579884] s8 : ffffffff812cd5f2 s9 : ffffffe001770a80 s10: 0000000000000000
[guest1/uart0] [ 1.600790] s11: ffffffe002000000 t3 : 0000000000000043 t4 : ffffffffffffffff
[guest1/uart0] [ 1.624570] t5 : ffffffff81284010 t6 : ffffffff81203808
[guest1/uart0] [ 1.632697] status: 0000000000000100 badaddr: 0000000000000888 cause: 000000000000000d
[guest1/uart0] [ 1.668863] [<ffffffff800048b0>] walk_stackframe+0xb0/0xc6
[guest1/uart0] [ 1.675665] [<ffffffff800048e2>] dump_backtrace+0x1c/0x24
[guest1/uart0] [ 1.695263] [<ffffffff80707e56>] show_stack+0x2c/0x38
[guest1/uart0] [ 1.700019] [<ffffffff8070a8c2>] dump_stack+0x72/0x8c
[guest1/uart0] [ 1.739008] [<ffffffff8002afba>] ___might_sleep+0xde/0xee
[guest1/uart0] [ 1.744272] [<ffffffff8002b008>] __might_sleep+0x3e/0x6a
[guest1/uart0] [ 1.767160] [<ffffffff807147a2>] mutex_lock+0x22/0x4e
[guest1/uart0] [ 1.785848] [<ffffffff805c8e22>] rpmsg_recv_done+0x15a/0x26c
[guest1/uart0] [ 1.806548] [<ffffffff8032c7fc>] vring_interrupt+0x50/0x78
[guest1/uart0] [ 1.825028] [<ffffffff8032f0b0>] vm_interrupt+0x8e/0xcc
[guest1/uart0] [ 1.831433] [<ffffffff8005148e>] __handle_irq_event_percpu+0x46/0x112
[guest1/uart0] [ 1.850076] [<ffffffff80051612>] handle_irq_event+0x4a/0xae
[guest1/uart0] [ 1.869597] [<ffffffff80054d3e>] handle_fasteoi_irq+0x96/0x188
[guest1/uart0] [ 1.875966] [<ffffffff800505f6>] generic_handle_irq+0x28/0x36
[guest1/uart0] [ 1.895272] [<ffffffff802e69ec>] plic_handle_irq+0x96/0x108
[guest1/uart0] [ 1.914942] [<ffffffff80050dbe>] __handle_domain_irq+0x72/0xcc
[guest1/uart0] [ 1.922322] [<ffffffff802e67aa>] riscv_intc_irq+0x38/0x60
[guest1/uart0] [ 1.944575] [<ffffffff800032ca>] ret_from_exception+0x0/0xc
[guest1/uart0] [ 1.963709] [<ffffffff8005d39c>] rcu_idle_enter+0x10/0x18
[guest1/uart0] [ 1.984319] ---[ end trace 5ff0062d55835a41 ]---
[guest1/uart0] [ 1.989060] Kernel panic - not syncing: Fatal exception in interrupt
[guest1/uart0] [ 2.020105] SMP: stopping secondary CPUs
[guest1/uart0] [ 2.039065] ---[ end Kernel panic - not syncing: Fatal exception in interrupt ]---
[guest1/uart0] [ 1.280242] Call Trace:
[guest1/uart0] [ 1.283266] Unable to handle kernel NULL pointer dereference at virtual address 0000000000000888
[guest1/uart0] [ 1.326317] Oops [#1]
[guest1/uart0] [ 1.360259] Modules linked in:
[guest1/uart0] [ 1.364224] CPU: 0 PID: 0 Comm: swapper/0 Not tainted 5.13.0 #1
[guest1/uart0] [ 1.392297] Hardware name: Virt64 (DT)
[guest1/uart0] [ 1.411481] epc : walk_stackframe+0xb0/0xc6
[guest1/uart0] [ 1.416391] ra : dump_backtrace+0x1c/0x24
[guest1/uart0] [ 1.433860] epc : ffffffff800048b0 ra : ffffffff800048e2 sp : ffffffff81203a40
[guest1/uart0] [ 1.456880] gp : ffffffff812e43e0 tp : ffffffff8120bd80 t0 : ffffffff812f20df
[guest1/uart0] [ 1.483773] t1 : ffffffff812f20d0 t2 : 0000000000000000 s0 : ffffffff81203a90
[guest1/uart0] [ 1.490774] s1 : ffffffff80db2250 a0 : 0000000000001000 a1 : 0000000000000000
[guest1/uart0] [ 1.509931] a2 : ffffffff80707e06 a3 : ffffffff80db2250 a4 : 0000000000000000
[guest1/uart0] [ 1.529133] a5 : 0000000000001000 a6 : 0000000000000005 a7 : ffffffffffffffff
[guest1/uart0] [ 1.551181] s2 : 0000000000000000 s3 : 0000000000000000 s4 : 0000000000000000
[guest1/uart0] [ 1.558040] s5 : ffffffff80db2250 s6 : ffffffff80707e06 s7 : 0000000000000cc0
[guest1/uart0] [ 1.579884] s8 : ffffffff812cd5f2 s9 : ffffffe001770a80 s10: 0000000000000000
[guest1/uart0] [ 1.600790] s11: ffffffe002000000 t3 : 0000000000000043 t4 : ffffffffffffffff
[guest1/uart0] [ 1.624570] t5 : ffffffff81284010 t6 : ffffffff81203808
[guest1/uart0] [ 1.632697] status: 0000000000000100 badaddr: 0000000000000888 cause: 000000000000000d
[guest1/uart0] [ 1.668863] [<ffffffff800048b0>] walk_stackframe+0xb0/0xc6
[guest1/uart0] [ 1.675665] [<ffffffff800048e2>] dump_backtrace+0x1c/0x24
[guest1/uart0] [ 1.695263] [<ffffffff80707e56>] show_stack+0x2c/0x38
[guest1/uart0] [ 1.700019] [<ffffffff8070a8c2>] dump_stack+0x72/0x8c
[guest1/uart0] [ 1.739008] [<ffffffff8002afba>] ___might_sleep+0xde/0xee
[guest1/uart0] [ 1.744272] [<ffffffff8002b008>] __might_sleep+0x3e/0x6a
[guest1/uart0] [ 1.767160] [<ffffffff807147a2>] mutex_lock+0x22/0x4e
[guest1/uart0] [ 1.785848] [<ffffffff805c8e22>] rpmsg_recv_done+0x15a/0x26c
[guest1/uart0] [ 1.806548] [<ffffffff8032c7fc>] vring_interrupt+0x50/0x78
[guest1/uart0] [ 1.825028] [<ffffffff8032f0b0>] vm_interrupt+0x8e/0xcc
[guest1/uart0] [ 1.831433] [<ffffffff8005148e>] __handle_irq_event_percpu+0x46/0x112
[guest1/uart0] [ 1.850076] [<ffffffff80051612>] handle_irq_event+0x4a/0xae
[guest1/uart0] [ 1.869597] [<ffffffff80054d3e>] handle_fasteoi_irq+0x96/0x188
[guest1/uart0] [ 1.875966] [<ffffffff800505f6>] generic_handle_irq+0x28/0x36
[guest1/uart0] [ 1.895272] [<ffffffff802e69ec>] plic_handle_irq+0x96/0x108
[guest1/uart0] [ 1.914942] [<ffffffff80050dbe>] __handle_domain_irq+0x72/0xcc
[guest1/uart0] [ 1.922322] [<ffffffff802e67aa>] riscv_intc_irq+0x38/0x60
[guest1/uart0] [ 1.944575] [<ffffffff800032ca>] ret_from_exception+0x0/0xc
[guest1/uart0] [ 1.963709] [<ffffffff8005d39c>] rcu_idle_enter+0x10/0x18
[guest1/uart0] [ 1.984319] ---[ end trace 5ff0062d55835a41 ]---
[guest1/uart0] [ 1.989060] Kernel panic - not syncing: Fatal exception in interrupt
[guest1/uart0] [ 2.020105] SMP: stopping secondary CPUs
[guest1/uart0] [ 2.039065] ---[ end Kernel panic - not syncing: Fatal exception in interrupt ]---
Full bootlog
embeddedinn@embeddedinn:~/temp/xvisor-next$ qemu-system-riscv64 -cpu rv64,x-h=true -M virt -m 1G -nographic -bios ../opensbi/build/platform/generic/firmware/fw_jump.bin -kernel ./build/vmm.bin -initrd ./build/disk.img -append 'vmm.bootcmd="vfs mount initrd /;vfs run /boot.xscript;vfs cat /system/banner.txt"'
OpenSBI v0.9-81-ga731c7e
____ _____ ____ _____
/ __ \ / ____| _ \_ _|
| | | |_ __ ___ _ __ | (___ | |_) || |
| | | | '_ \ / _ \ '_ \ \___ \| _ < | |
| |__| | |_) | __/ | | |____) | |_) || |_
\____/| .__/ \___|_| |_|_____/|____/_____|
| |
|_|
Platform Name : riscv-virtio,qemu
Platform Features : mfdeleg
Platform HART Count : 1
Platform IPI Device : aclint-mswi
Platform Timer Device : aclint-mtimer
Platform Console Device : uart8250
Platform HSM Device : ---
Platform SysReset Device : sifive_test
Firmware Base : 0x80000000
Firmware Size : 112 KB
Runtime SBI Version : 0.3
Domain0 Name : root
Domain0 Boot HART : 0
Domain0 HARTs : 0*
Domain0 Region00 : 0x0000000002000000-0x000000000200ffff (I)
Domain0 Region01 : 0x0000000080000000-0x000000008001ffff ()
Domain0 Region02 : 0x0000000000000000-0xffffffffffffffff (R,W,X)
Domain0 Next Address : 0x0000000080200000
Domain0 Next Arg1 : 0x0000000082200000
Domain0 Next Mode : S-mode
Domain0 SysReset : yes
Boot HART ID : 0
Boot HART Domain : root
Boot HART ISA : rv64imafdcsuh
Boot HART Features : scounteren,mcounteren,time
Boot HART PMP Count : 16
Boot HART PMP Granularity : 4
Boot HART PMP Address Bits: 54
Boot HART MHPM Count : 0
Boot HART MHPM Count : 0
Boot HART MIDELEG : 0x0000000000000666
Boot HART MEDELEG : 0x0000000000f0b509
Xvisor v0.3.0-206-g32153a14 (Jul 6 2021 07:19:25)
INIT: host address space
INIT: vapool: base=0x0000000010000000 size=33554432
INIT: vapool: hkbase=0x000000001014D000 hksize=131072
INIT: ram: bank0 phys=0x0000000080000000 size=1073741824
INIT: ram: bank0 hkbase=0x000000001016D000 hksize=32768
INIT: ram_reserve: phys=0x0000000080200000 size=839680
INIT: ram_reserve: phys=0x000000008034D000 size=393216
INIT: ram_reserve: phys=0x00000000802CD000 size=524288
INIT: vapool_reserve: virt=0x0000000010000000 size=1757184
INIT: ram_reserve: phys=0x0000000082200000 size=8192
INIT: heap management
INIT: device tree
INIT: device tree reserved-memory
INIT: ram_reserve: phys=0x0000000080000000 size=131072
INIT: DMA heap management
INIT: CPU nascent
INIT: SBI specification v0.3 detected
INIT: SBI implementation ID=0x1 Version=0x9
INIT: SBI TIME extension detected
INIT: SBI IPI extension detected
INIT: SBI RFENCE extension detected
INIT: SBI SRST extension detected
INIT: board nascent
INIT: nascent funtions
INIT: page pool
INIT: exception table
INIT: discover secondary CPUs
INIT: using SBI SMP operations
INIT: per-CPU areas
INIT: CPU hotplug
INIT: host irq subsystem
INIT: plic: base=0x000000000C000000 size=2105344
INIT: plic: devices=54 contexts=1/2
INIT: CPU early
INIT: early_params: vmm.bootcmd="vfs mount initrd /;vfs run /boot.xscript;vfs cat /system/banner.txt"
INIT: board early
INIT: early funtions
INIT: standard I/O
INIT: clocksource manager
INIT: clockchip manager
INIT: hypervisor timer
INIT: hypervisor soft delay
INIT: hypervisor shared memory
INIT: hypervisor manager
INIT: synchronus inter-processor interrupts
INIT: hypervisor scheduler
INIT: asynchronus inter-processor interrupts
INIT: hypervisor threads
INIT: workqueue framework
INIT: wallclock subsystem
INIT: start secondary CPUs
INIT: command manager
INIT: device driver framework
INIT: device emulation framework
INIT: character device framework
INIT: iommu framework
INIT: hypervisor modules
INIT: block device framework
INIT: network switch framework
INIT: network port framework
initrd: RBD created at 0x88200000 - 0x8a200000
INIT: CPU final
INIT: board final
INIT: final functions
INIT: CPU0 online
INIT: brought-up 1 CPUs
INIT: freeing init memory 24K
INIT: change stdio device to uart@10000000
INIT: syncup wallclock using rtc@101000
INIT: bootcmd: vfs mount initrd /
Trying: cpio ext4
Mounted initrd using ext4 at /
INIT: bootcmd: vfs run /boot.xscript
Created default shared memory
guest0: Created
guest0: Parsing /images/riscv/virt64/nor_flash.list
guest0: Loading 0x0000000000000000 with file ./firmware.bin
guest0: Loaded 0x0000000000000000 with 73892 bytes
guest0: Loading 0x00000000000FF000 with file ./cmdlist
guest0: Loaded 0x00000000000FF000 with 167 bytes
guest0: Loading 0x0000000000100000 with file ./Image
guest0: Loaded 0x0000000000100000 with 19810816 bytes
guest0: Loading 0x0000000001F00000 with file ./virt64.dtb
guest0: Loaded 0x0000000001F00000 with 2122 bytes
guest0: Loading 0x0000000002000000 with file ./rootfs.img
guest0: Loaded 0x0000000002000000 with 1508352 bytes
guest1: Created
guest1: Parsing /images/riscv/virt64/nor_flash.list
guest1: Loading 0x0000000000000000 with file ./firmware.bin
guest1: Loaded 0x0000000000000000 with 73892 bytes
guest1: Loading 0x00000000000FF000 with file ./cmdlist
guest1: Loaded 0x00000000000FF000 with 167 bytes
guest1: Loading 0x0000000000100000 with file ./Image
guest1: Loaded 0x0000000000100000 with 19810816 bytes
guest1: Loading 0x0000000001F00000 with file ./virt64.dtb
guest1: Loaded 0x0000000001F00000 with 2122 bytes
guest1: Loading 0x0000000002000000 with file ./rootfs.img
guest1: Loaded 0x0000000002000000 with 1508352 bytes
INIT: bootcmd: vfs cat /system/banner.txt
ooooooo ooooo oooooo oooo ooooo .oooooo..o .oooooo. ooooooooo.
`8888 d8' `888. .8' `888' d8P' `Y8 d8P' `Y8b `888 `Y88.
Y888..8P `888. .8' 888 Y88bo. 888 888 888 .d88'
`8888' `888. .8' 888 `Y8888o. 888 888 888ooo88P'
.8PY888. `888.8' 888 `Y88b 888 888 888`88b.
d8' `888b `888' 888 oo .d8P `88b d88' 888 `88b.
o888o o88888o `8' o888o 8''88888P' `Y8bood8P' o888o o888o
XVisor# guest kick guest0
guest0: Kicked
XVisor# guest kick guest1
guest1: Kicked
XVisor# vserial bind guest0/uart0
[guest0/uart0] RISC-V Virt64 Basic Firmware
[guest0/uart0]
[guest0/uart0] autoboot: disabled
[guest0/uart0]
[guest0/uart0] basic# autoexec
[guest0/uart0] autoexec(copy 0x80200000 0x00100000 0x1E00000)
[guest0/uart0] copy took 86321 usecs for 0x1E00000 bytes
[guest0/uart0] autoexec(copy 0x83000000 0x01F00000 0x020000)
[guest0/uart0] copy took 432 usecs for 0x020000 bytes
[guest0/uart0] autoexec(copy 0x83100000 0x02000000 0x800000)
[guest0/uart0] copy took 22924 usecs for 0x800000 bytes
[guest0/uart0] autoexec(start_linux_fdt 0x80200000 0x83000000 0x83100000 0x800000)
[guest0/uart0] Trying to set new bootargs: root=/dev/ram rw console=ttyS0,115200 earlycon=uart8250,mmio,0x10000000 mem=256M
[guest0/uart0] Jumping into linux ...
[guest0/uart0] [ 0.000000] Linux version 5.13.0 (embeddedinn@embeddedinn) (riscv64-unknown-linux-gnu-gcc (GCC) 11.1.0, GNU ld (GNU Binutils) 2.36.1) #1 SMP Tue Jul 6 09:26:02 IST 2021
[guest0/uart0] [ 0.000000] OF: fdt: Ignoring memory range 0x80000000 - 0x80200000
[guest0/uart0] [ 0.000000] Machine model: Virt64
[guest0/uart0] [ 0.000000] earlycon: uart8250 at MMIO 0x0000000010000000 (options '')
[guest0/uart0] [ 0.000000] printk: bootconsole [uart8250] enabled
[guest0/uart0] [ 0.000000] efi: UEFI not found.
[guest0/uart0] [ 0.000000] Reserved memory: created DMA memory pool at 0x0000000058000000, size 16 MiB
[guest0/uart0] [ 0.000000] OF: reserved mem: initialized node shmem@58000000, compatible id shared-dma-pool
[guest0/uart0] [ 0.000000] Zone ranges:
[guest0/uart0] [ 0.000000] DMA32 [mem 0x0000000080200000-0x000000008fffffff]
[guest0/uart0] [ 0.000000] Normal empty
[guest0/uart0] [ 0.000000] Movable zone start for each node
[guest0/uart0] [ 0.000000] Early memory node ranges
[guest0/uart0] [ 0.000000] node 0: [mem 0x0000000080200000-0x000000008fffffff]
[guest0/uart0] [ 0.000000] Initmem setup node 0 [mem 0x0000000080200000-0x000000008fffffff]
[guest0/uart0] [ 0.000000] SBI specification v0.2 detected
[guest0/uart0] [ 0.000000] SBI implementation ID=0x2 Version=0x3000
[guest0/uart0] [ 0.000000] SBI TIME extension detected
[guest0/uart0] [ 0.000000] SBI IPI extension detected
[guest0/uart0] [ 0.000000] SBI RFENCE extension detected
[guest0/uart0] [ 0.000000] software IO TLB: mapped [mem 0x000000008bc79000-0x000000008fc79000] (64MB)
[guest0/uart0] [ 0.000000] SBI v0.2 HSM extension detected
[guest0/uart0] [ 0.000000] riscv: ISA extensions acdfim
[guest0/uart0] [ 0.000000] riscv: ELF capabilities acdfim
[guest0/uart0] [ 0.000000] percpu: Embedded 18 pages/cpu s34664 r8192 d30872 u73728
[guest0/uart0] [ 0.000000] Built 1 zonelists, mobility grouping on. Total pages: 64135
[guest0/uart0] [ 0.000000] Kernel command line: root=/dev/ram rw console=ttyS0,115200 earlycon=uart8250,mmio,0x10000000 mem=256M
[guest0/uart0] [ 0.000000] Dentry cache hash table entries: 32768 (order: 6, 262144 bytes, linear)
[guest0/uart0] [ 0.000000] Inode-cache hash table entries: 16384 (order: 5, 131072 bytes, linear)
[guest0/uart0] [ 0.000000] Sorting __ex_table...
[guest0/uart0] [ 0.000000] mem auto-init: stack:off, heap alloc:off, heap free:off
[guest0/uart0] [ 0.000000] Virtual kernel memory layout:
[guest0/uart0] [ 0.000000] fixmap : 0xffffffcefee00000 - 0xffffffceff000000 (2048 kB)
[guest0/uart0] [ 0.000000] pci io : 0xffffffceff000000 - 0xffffffcf00000000 ( 16 MB)
[guest0/uart0] [ 0.000000] vmemmap : 0xffffffcf00000000 - 0xffffffcfffffffff (4095 MB)
[guest0/uart0] [ 0.000000] vmalloc : 0xffffffd000000000 - 0xffffffdfffffffff (65535 MB)
[guest0/uart0] [ 0.000000] lowmem : 0xffffffe000000000 - 0xffffffe00fe00000 ( 254 MB)
[guest0/uart0] [ 0.000000] kernel : 0xffffffff80000000 - 0xffffffffffffffff (2047 MB)
[guest0/uart0] [ 0.000000] Memory: 160960K/260096K available (7263K kernel code, 4896K rwdata, 4096K rodata, 2162K init, 309K bss, 99136K reserved, 0K cma-reserved)
[guest0/uart0] [ 0.000000] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=2, Nodes=1
[guest0/uart0] [ 0.000000] rcu: Hierarchical RCU implementation.
[guest0/uart0] [ 0.000000] rcu: RCU restricting CPUs from NR_CPUS=8 to nr_cpu_ids=2.
[guest0/uart0] [ 0.000000] rcu: RCU debug extended QS entry/exit.
[guest0/uart0] [ 0.000000] Tracing variant of Tasks RCU enabled.
[guest0/uart0] [ 0.000000] rcu: RCU calculated value of scheduler-enlistment delay is 25 jiffies.
[guest0/uart0] [ 0.000000] rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=2
[guest0/uart0] [ 0.000000] NR_IRQS: 64, nr_irqs: 64, preallocated irqs: 0
[guest0/uart0] [ 0.000000] riscv-intc: 64 local interrupts mapped
[guest0/uart0] [ 0.000000] plic: interrupt-controller@c000000: mapped 32 interrupts with 2 handlers for 4 contexts.
[guest0/uart0] [ 0.000000] random: get_random_bytes called from start_kernel+0x3b6/0x598 with crng_init=0
[guest0/uart0] [ 0.000000] riscv_timer_init_dt: Registering clocksource cpuid [0] hartid [0]
[guest0/uart0] [ 0.000000] clocksource: riscv_clocksource: mask: 0xffffffffffffffff max_cycles: 0x24e6a1710, max_idle_ns: 440795202120 ns
[guest0/uart0] [ 0.000079] sched_clock: 64 bits at 10MHz, resolution 100ns, wraps every 4398046511100ns
[guest0/uart0] [ 0.041480] Console: colour dummy device 80x25
[guest0/uart0] [ 0.067655] Calibrating delay loop (skipped), value calculated using timer frequency.. 20.00 BogoMIPS (lpj=40000)
[guest0/uart0] [ 0.092883] pid_max: default: 32768 minimum: 301
[guest0/uart0] [ 0.114894] Mount-cache hash table entries: 512 (order: 0, 4096 bytes, linear)
[guest0/uart0] [ 0.136836] Mountpoint-cache hash table entries: 512 (order: 0, 4096 bytes, linear)
[guest0/uart0] [ 0.193317] ASID allocator using 16 bits (65536 entries)
[guest0/uart0] [ 0.220657] rcu: Hierarchical SRCU implementation.
[guest0/uart0] [ 0.250702] EFI services will not be available.
[guest0/uart0] [ 0.275648] smp: Bringing up secondary CPUs ...
[guest0/uart0] [ 0.332261] smp: Brought up 1 node, 2 CPUs
[guest0/uart0] [ 0.388795] devtmpfs: initialized
[guest0/uart0] [ 0.412107] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 7645041785100000 ns
[guest0/uart0] [ 0.438063] futex hash table entries: 512 (order: 3, 32768 bytes, linear)
[guest0/uart0] [ 0.466227] NET: Registered protocol family 16
[guest0/uart0] [ 0.566098] wait_for_initramfs() called before rootfs_initcalls
[guest0/uart0] [ 0.654250] vgaarb: loaded
[guest0/uart0] [ 0.660525] SCSI subsystem initialized
[guest0/uart0] [ 0.705956] usbcore: registered new interface driver usbfs
[guest0/uart0] [ 0.729156] usbcore: registered new interface driver hub
[guest0/uart0] [ 0.737071] usbcore: registered new device driver usb
[guest0/uart0] [ 0.849286] clocksource: Switched to clocksource riscv_clocksource
[guest0/uart0] [ 0.878861] simple-framebuffer 50000000.simplefb: framebuffer at 0x50000000, 0x1000000 bytes
[guest0/uart0] [ 0.905049] simple-framebuffer 50000000.simplefb: format=a8r8g8b8, mode=1600x900x32, linelength=6400
[guest0/uart0] [ 1.001415] Console: switching to colour frame buffer device 200x56
[guest0/uart0] [ 1.047985] simple-framebuffer 50000000.simplefb: fb0: simplefb registered!
[guest0/uart0] [ 3.860926] NET: Registered protocol family 2
[guest0/uart0] [ 3.868792] IP idents hash table entries: 4096 (order: 3, 32768 bytes, linear)
[guest0/uart0] [ 3.905496] tcp_listen_portaddr_hash hash table entries: 128 (order: 0, 5120 bytes, linear)
[guest0/uart0] [ 3.931317] TCP established hash table entries: 2048 (order: 2, 16384 bytes, linear)
[guest0/uart0] [ 3.954645] TCP bind hash table entries: 2048 (order: 4, 65536 bytes, linear)
[guest0/uart0] [ 3.977464] TCP: Hash tables configured (established 2048 bind 2048)
[guest0/uart0] [ 4.000822] UDP hash table entries: 256 (order: 2, 24576 bytes, linear)
[guest0/uart0] [ 4.025462] UDP-Lite hash table entries: 256 (order: 2, 24576 bytes, linear)
[guest0/uart0] [ 4.048511] NET: Registered protocol family 1
[guest0/uart0] [ 4.098268] RPC: Registered named UNIX socket transport module.
[guest0/uart0] [ 4.122492] RPC: Registered udp transport module.
[guest0/uart0] [ 4.142430] RPC: Registered tcp transport module.
[guest0/uart0] [ 4.148966] RPC: Registered tcp NFSv4.1 backchannel transport module.
[guest0/uart0] [ 4.173509] PCI: CLS 0 bytes, default 64
[guest0/uart0] [ 4.202131] Unpacking initramfs...
[guest0/uart0] [ 4.229689] workingset: timestamp_bits=62 max_order=16 bucket_order=0
[guest0/uart0] [ 4.308298] NFS: Registering the id_resolver key type
[guest0/uart0] [ 4.340852] Key type id_resolver registered
[guest0/uart0] [ 4.348013] Key type id_legacy registered
[guest0/uart0] [ 4.378393] nfs4filelayout_init: NFSv4 File Layout Driver Registering...
[guest0/uart0] [ 4.411756] nfs4flexfilelayout_init: NFSv4 Flexfile Layout Driver Registering...
[guest0/uart0] [ 4.480192] 9p: Installing v9fs 9p2000 file system support
[guest0/uart0] [ 4.514098] NET: Registered protocol family 38
[guest0/uart0] [ 4.520147] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 251)
[guest0/uart0] [ 4.561278] io scheduler mq-deadline registered
[guest0/uart0] [ 4.598958] io scheduler kyber registered
[guest0/uart0] [ 4.696378] Freeing initrd memory: 8192K
[guest0/uart0] [ 4.747241] virtio_rpmsg_bus virtio3: rpmsg host is online
[guest0/uart0] [ 4.802136] input: Xvisor VirtIO Input as /devices/platform/smb/20004000.virtio_input/virtio4/input/input0
[guest0/uart0] [ 5.011626] Serial: 8250/16550 driver, 4 ports, IRQ sharing disabled
[guest0/uart0] [ 5.064769] printk: console [ttyS0] disabled
[guest0/uart0] [ 5.073195] 10000000.uart: ttyS0 at MMIO 0x10000000 (irq = 1, base_baud = 230400) is a 16550A
[guest0/uart0] [ 5.113388] printk: console [ttyS0] enabled
[guest0/uart0] [ 5.113388] printk: console [ttyS0] enabled
[guest0/uart0] [ 5.140393] printk: bootconsole [uart8250] disabled
[guest0/uart0] [ 5.140393] printk: bootconsole [uart8250] disabled
[guest0/uart0] [ 5.186015] [drm] radeon kernel modesetting enabled.
[guest0/uart0] [ 5.234630] loop: module loaded
[guest0/uart0] [ 5.255138] virtio_blk virtio1: [vda] 0 512-byte logical blocks (0 B/0 B)
[guest0/uart0] [ 5.305124] libphy: Fixed MDIO Bus: probed
[guest0/uart0] [ 5.336692] e1000e: Intel(R) PRO/1000 Network Driver
[guest0/uart0] [ 5.362660] e1000e: Copyright(c) 1999 - 2015 Intel Corporation.
[guest0/uart0] [ 5.386706] ehci_hcd: USB 2.0 'Enhanced' Host Controller (EHCI) Driver
[guest0/uart0] [ 5.419198] ehci-pci: EHCI PCI platform driver
[guest0/uart0] [ 5.440468] ehci-platform: EHCI generic platform driver
[guest0/uart0] [ 5.460148] ohci_hcd: USB 1.1 'Open' Host Controller (OHCI) Driver
[guest0/uart0] [ 5.482725] ohci-pci: OHCI PCI platform driver
[guest0/uart0] [ 5.504685] ohci-platform: OHCI generic platform driver
[guest0/uart0] [ 5.525046] usbcore: registered new interface driver uas
[guest0/uart0] [ 5.532646] usbcore: registered new interface driver usb-storage
[guest0/uart0] [ 5.558478] mousedev: PS/2 mouse device common for all mice
[guest0/uart0] [ 5.613570] goldfish_rtc 10003000.rtc: registered as rtc0
[guest0/uart0] [ 5.641314] goldfish_rtc 10003000.rtc: setting system clock to 2021-07-06T04:01:21 UTC (1625544081)
[guest0/uart0] [ 5.669097] sdhci: Secure Digital Host Controller Interface driver
[guest0/uart0] [ 5.696423] sdhci: Copyright(c) Pierre Ossman
[guest0/uart0] [ 5.721510] sdhci-pltfm: SDHCI platform and OF driver helper
[guest0/uart0] [ 5.729000] usbcore: registered new interface driver usbhid
[guest0/uart0] [ 5.754799] usbhid: USB HID core driver
[guest0/uart0] [ 5.775851] NET: Registered protocol family 10
[guest0/uart0] [ 5.834293] Segment Routing with IPv6
[guest0/uart0] [ 5.854913] sit: IPv6, IPv4 and MPLS over IPv4 tunneling driver
[guest0/uart0] [ 5.877921] NET: Registered protocol family 17
[guest0/uart0] [ 5.884616] 9pnet: Installing 9P2000 support
[guest0/uart0] [ 5.906588] Key type dns_resolver registered
[guest0/uart0] [ 5.934379] debug_vm_pgtable: [debug_vm_pgtable ]: Validating architecture page table helpers
[guest0/uart0] [ 6.052561] Freeing unused kernel memory: 2160K
[guest0/uart0] [ 6.071168] Run /init as init process
[guest0/uart0] _ _
[guest0/uart0] | ||_|
[guest0/uart0] | | _ ____ _ _ _ _
[guest0/uart0] | || | _ \| | | |\ \/ /
[guest0/uart0] | || | | | | |_| |/ \
[guest0/uart0] |_||_|_| |_|\____|\_/\_/
[guest0/uart0]
[guest0/uart0] Busybox Rootfs
[guest0/uart0]
[guest0/uart0] Please press Enter to activate this console.
[guest0/uart0] / #
[guest0/uart0] / #
XVisor# vserial bind guest1/uart0
[guest1/uart0] RISC-V Virt64 Basic Firmware
[guest1/uart0]
[guest1/uart0] autoboot: disabled
[guest1/uart0]
[guest1/uart0] basic# autoexec
[guest1/uart0] autoexec(copy 0x80200000 0x00100000 0x1E00000)
[guest1/uart0] copy took 145140 usecs for 0x1E00000 bytes
[guest1/uart0] autoexec(copy 0x83000000 0x01F00000 0x020000)
[guest1/uart0] copy took 9250 usecs for 0x020000 bytes
[guest1/uart0] autoexec(copy 0x83100000 0x02000000 0x800000)
[guest1/uart0] copy took 39812 usecs for 0x800000 bytes
[guest1/uart0] autoexec(start_linux_fdt 0x80200000 0x83000000 0x83100000 0x800000)
[guest1/uart0] Trying to set new bootargs: root=/dev/ram rw console=ttyS0,115200 earlycon=uart8250,mmio,0x10000000 mem=256M
[guest1/uart0] Jumping into linux ...
[guest1/uart0] [ 0.000000] Linux version 5.13.0 (embeddedinn@embeddedinn) (riscv64-unknown-linux-gnu-gcc (GCC) 11.1.0, GNU ld (GNU Binutils) 2.36.1) #1 SMP Tue Jul 6 09:26:02 IST 2021
[guest1/uart0] [ 0.000000] OF: fdt: Ignoring memory range 0x80000000 - 0x80200000
[guest1/uart0] [ 0.000000] Machine model: Virt64
[guest1/uart0] [ 0.000000] earlycon: uart8250 at MMIO 0x0000000010000000 (options '')
[guest1/uart0] [ 0.000000] printk: bootconsole [uart8250] enabled
[guest1/uart0] [ 0.000000] efi: UEFI not found.
[guest1/uart0] [ 0.000000] Reserved memory: created DMA memory pool at 0x0000000058000000, size 16 MiB
[guest1/uart0] [ 0.000000] OF: reserved mem: initialized node shmem@58000000, compatible id shared-dma-pool
[guest1/uart0] [ 0.000000] Zone ranges:
[guest1/uart0] [ 0.000000] DMA32 [mem 0x0000000080200000-0x000000008fffffff]
[guest1/uart0] [ 0.000000] Normal empty
[guest1/uart0] [ 0.000000] Movable zone start for each node
[guest1/uart0] [ 0.000000] Early memory node ranges
[guest1/uart0] [ 0.000000] node 0: [mem 0x0000000080200000-0x000000008fffffff]
[guest1/uart0] [ 0.000000] Initmem setup node 0 [mem 0x0000000080200000-0x000000008fffffff]
[guest1/uart0] [ 0.000000] SBI specification v0.2 detected
[guest1/uart0] [ 0.000000] SBI implementation ID=0x2 Version=0x3000
[guest1/uart0] [ 0.000000] SBI TIME extension detected
[guest1/uart0] [ 0.000000] SBI IPI extension detected
[guest1/uart0] [ 0.000000] SBI RFENCE extension detected
[guest1/uart0] [ 0.000000] software IO TLB: mapped [mem 0x000000008bc79000-0x000000008fc79000] (64MB)
[guest1/uart0] [ 0.000000] SBI v0.2 HSM extension detected
[guest1/uart0] [ 0.000000] riscv: ISA extensions acdfim
[guest1/uart0] [ 0.000000] riscv: ELF capabilities acdfim
[guest1/uart0] [ 0.000000] percpu: Embedded 18 pages/cpu s34664 r8192 d30872 u73728
[guest1/uart0] [ 0.000000] Built 1 zonelists, mobility grouping on. Total pages: 64135
[guest1/uart0] [ 0.000000] Kernel command line: root=/dev/ram rw console=ttyS0,115200 earlycon=uart8250,mmio,0x10000000 mem=256M
[guest1/uart0] [ 0.000000] Dentry cache hash table entries: 32768 (order: 6, 262144 bytes, linear)
[guest1/uart0] [ 0.000000] Inode-cache hash table entries: 16384 (order: 5, 131072 bytes, linear)
[guest1/uart0] [ 0.000000] Sorting __ex_table...
[guest1/uart0] [ 0.000000] mem auto-init: stack:off, heap alloc:off, heap free:off
[guest1/uart0] [ 0.000000] Virtual kernel memory layout:
[guest1/uart0] [ 0.000000] fixmap : 0xffffffcefee00000 - 0xffffffceff000000 (2048 kB)
[guest1/uart0] [ 0.000000] pci io : 0xffffffceff000000 - 0xffffffcf00000000 ( 16 MB)
[guest1/uart0] [ 0.000000] vmemmap : 0xffffffcf00000000 - 0xffffffcfffffffff (4095 MB)
[guest1/uart0] [ 0.000000] vmalloc : 0xffffffd000000000 - 0xffffffdfffffffff (65535 MB)
[guest1/uart0] [ 0.000000] lowmem : 0xffffffe000000000 - 0xffffffe00fe00000 ( 254 MB)
[guest1/uart0] [ 0.000000] kernel : 0xffffffff80000000 - 0xffffffffffffffff (2047 MB)
[guest1/uart0] [ 0.000000] Memory: 160960K/260096K available (7263K kernel code, 4896K rwdata, 4096K rodata, 2162K init, 309K bss, 99136K reserved, 0K cma-reserved)
[guest1/uart0] [ 0.000000] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=2, Nodes=1
[guest1/uart0] [ 0.000000] rcu: Hierarchical RCU implementation.
[guest1/uart0] [ 0.000000] rcu: RCU restricting CPUs from NR_CPUS=8 to nr_cpu_ids=2.
[guest1/uart0] [ 0.000000] rcu: RCU debug extended QS entry/exit.
[guest1/uart0] [ 0.000000] Tracing variant of Tasks RCU enabled.
[guest1/uart0] [ 0.000000] rcu: RCU calculated value of scheduler-enlistment delay is 25 jiffies.
[guest1/uart0] [ 0.000000] rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=2
[guest1/uart0] [ 0.000000] NR_IRQS: 64, nr_irqs: 64, preallocated irqs: 0
[guest1/uart0] [ 0.000000] riscv-intc: 64 local interrupts mapped
[guest1/uart0] [ 0.000000] plic: interrupt-controller@c000000: mapped 32 interrupts with 2 handlers for 4 contexts.
[guest1/uart0] [ 0.000000] random: get_random_bytes called from start_kernel+0x3b6/0x598 with crng_init=0
[guest1/uart0] [ 0.000000] riscv_timer_init_dt: Registering clocksource cpuid [0] hartid [0]
[guest1/uart0] [ 0.000000] clocksource: riscv_clocksource: mask: 0xffffffffffffffff max_cycles: 0x24e6a1710, max_idle_ns: 440795202120 ns
[guest1/uart0] [ 0.000079] sched_clock: 64 bits at 10MHz, resolution 100ns, wraps every 4398046511100ns
[guest1/uart0] [ 0.010137] Console: colour dummy device 80x25
[guest1/uart0] [ 0.018561] Calibrating delay loop (skipped), value calculated using timer frequency.. 20.00 BogoMIPS (lpj=40000)
[guest1/uart0] [ 0.030090] pid_max: default: 32768 minimum: 301
[guest1/uart0] [ 0.035788] Mount-cache hash table entries: 512 (order: 0, 4096 bytes, linear)
[guest1/uart0] [ 0.043559] Mountpoint-cache hash table entries: 512 (order: 0, 4096 bytes, linear)
[guest1/uart0] [ 0.083700] ASID allocator using 16 bits (65536 entries)
[guest1/uart0] [ 0.090180] rcu: Hierarchical SRCU implementation.
[guest1/uart0] [ 0.097176] EFI services will not be available.
[guest1/uart0] [ 0.104513] smp: Bringing up secondary CPUs ...
[guest1/uart0] [ 0.117439] smp: Brought up 1 node, 2 CPUs
[guest1/uart0] [ 0.144896] devtmpfs: initialized
[guest1/uart0] [ 0.156678] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 7645041785100000 ns
[guest1/uart0] [ 0.169969] futex hash table entries: 512 (order: 3, 32768 bytes, linear)
[guest1/uart0] [ 0.182760] NET: Registered protocol family 16
[guest1/uart0] [ 0.236024] wait_for_initramfs() called before rootfs_initcalls
[guest1/uart0] [ 0.267788] vgaarb: loaded
[guest1/uart0] [ 0.271733] SCSI subsystem initialized
[guest1/uart0] [ 0.278854] usbcore: registered new interface driver usbfs
[guest1/uart0] [ 0.286367] usbcore: registered new interface driver hub
[guest1/uart0] [ 0.294809] usbcore: registered new device driver usb
[guest1/uart0] [ 0.352540] clocksource: Switched to clocksource riscv_clocksource
[guest1/uart0] [ 0.364381] simple-framebuffer 50000000.simplefb: framebuffer at 0x50000000, 0x1000000 bytes
[guest1/uart0] [ 0.378950] simple-framebuffer 50000000.simplefb: format=a8r8g8b8, mode=1600x900x32, linelength=6400
[guest1/uart0] [ 0.438243] Console: switching to colour frame buffer device 200x56
[guest1/uart0] [ 0.454131] simple-framebuffer 50000000.simplefb: fb0: simplefb registered!
[guest1/uart0] [ 0.596024] NET: Registered protocol family 2
[guest1/uart0] [ 0.602231] IP idents hash table entries: 4096 (order: 3, 32768 bytes, linear)
[guest1/uart0] [ 0.616107] tcp_listen_portaddr_hash hash table entries: 128 (order: 0, 5120 bytes, linear)
[guest1/uart0] [ 0.630042] TCP established hash table entries: 2048 (order: 2, 16384 bytes, linear)
[guest1/uart0] [ 0.641666] TCP bind hash table entries: 2048 (order: 4, 65536 bytes, linear)
[guest1/uart0] [ 0.650931] TCP: Hash tables configured (established 2048 bind 2048)
[guest1/uart0] [ 0.659276] UDP hash table entries: 256 (order: 2, 24576 bytes, linear)
[guest1/uart0] [ 0.667095] UDP-Lite hash table entries: 256 (order: 2, 24576 bytes, linear)
[guest1/uart0] [ 0.676484] NET: Registered protocol family 1
[guest1/uart0] [ 0.697683] RPC: Registered named UNIX socket transport module.
[guest1/uart0] [ 0.708759] RPC: Registered udp transport module.
[guest1/uart0] [ 0.715158] RPC: Registered tcp transport module.
[guest1/uart0] [ 0.721726] RPC: Registered tcp NFSv4.1 backchannel transport module.
[guest1/uart0] [ 0.732071] PCI: CLS 0 bytes, default 64
[guest1/uart0] [ 0.743498] Unpacking initramfs...
[guest1/uart0] [ 0.834900] workingset: timestamp_bits=62 max_order=16 bucket_order=0
[guest1/uart0] [ 0.863411] NFS: Registering the id_resolver key type
[guest1/uart0] [ 0.880227] Key type id_resolver registered
[guest1/uart0] [ 0.885219] Key type id_legacy registered
[guest1/uart0] [ 0.904947] nfs4filelayout_init: NFSv4 File Layout Driver Registering...
[guest1/uart0] [ 0.924646] nfs4flexfilelayout_init: NFSv4 Flexfile Layout Driver Registering...
[guest1/uart0] [ 0.944791] 9p: Installing v9fs 9p2000 file system support
[guest1/uart0] [ 0.964845] NET: Registered protocol family 38
[guest1/uart0] [ 0.970252] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 251)
[guest1/uart0] [ 0.991386] io scheduler mq-deadline registered
[guest1/uart0] [ 1.008144] io scheduler kyber registered
[guest1/uart0] [ 1.057153] Freeing initrd memory: 8192K
[guest1/uart0] [ 1.088812] virtio_rpmsg_bus virtio3: rpmsg host is online
[guest1/uart0] [ 1.105144] input: Xvisor VirtIO Input as /devices/platform/smb/20004000.virtio_input/virtio4/input/input0
[guest1/uart0] [ 1.125592] BUG: sleeping function called from invalid context at kernel/locking/mutex.c:281
[guest1/uart0] [ 1.171726] in_atomic(): 1, irqs_disabled(): 1, non_block: 0, pid: 0, name: swapper/0
[guest1/uart0] [ 1.239990] CPU: 0 PID: 0 Comm: swapper/0 Not tainted 5.13.0 #1
[guest1/uart0] [ 1.249155] Hardware name: Virt64 (DT)
[guest1/uart0] [ 1.280242] Call Trace:
[guest1/uart0] [ 1.283266] Unable to handle kernel NULL pointer dereference at virtual address 0000000000000888
[guest1/uart0] [ 1.326317] Oops [#1]
[guest1/uart0] [ 1.360259] Modules linked in:
[guest1/uart0] [ 1.364224] CPU: 0 PID: 0 Comm: swapper/0 Not tainted 5.13.0 #1
[guest1/uart0] [ 1.392297] Hardware name: Virt64 (DT)
[guest1/uart0] [ 1.411481] epc : walk_stackframe+0xb0/0xc6
[guest1/uart0] [ 1.416391] ra : dump_backtrace+0x1c/0x24
[guest1/uart0] [ 1.433860] epc : ffffffff800048b0 ra : ffffffff800048e2 sp : ffffffff81203a40
[guest1/uart0] [ 1.456880] gp : ffffffff812e43e0 tp : ffffffff8120bd80 t0 : ffffffff812f20df
[guest1/uart0] [ 1.483773] t1 : ffffffff812f20d0 t2 : 0000000000000000 s0 : ffffffff81203a90
[guest1/uart0] [ 1.490774] s1 : ffffffff80db2250 a0 : 0000000000001000 a1 : 0000000000000000
[guest1/uart0] [ 1.509931] a2 : ffffffff80707e06 a3 : ffffffff80db2250 a4 : 0000000000000000
[guest1/uart0] [ 1.529133] a5 : 0000000000001000 a6 : 0000000000000005 a7 : ffffffffffffffff
[guest1/uart0] [ 1.551181] s2 : 0000000000000000 s3 : 0000000000000000 s4 : 0000000000000000
[guest1/uart0] [ 1.558040] s5 : ffffffff80db2250 s6 : ffffffff80707e06 s7 : 0000000000000cc0
[guest1/uart0] [ 1.579884] s8 : ffffffff812cd5f2 s9 : ffffffe001770a80 s10: 0000000000000000
[guest1/uart0] [ 1.600790] s11: ffffffe002000000 t3 : 0000000000000043 t4 : ffffffffffffffff
[guest1/uart0] [ 1.624570] t5 : ffffffff81284010 t6 : ffffffff81203808
[guest1/uart0] [ 1.632697] status: 0000000000000100 badaddr: 0000000000000888 cause: 000000000000000d
[guest1/uart0] [ 1.668863] [<ffffffff800048b0>] walk_stackframe+0xb0/0xc6
[guest1/uart0] [ 1.675665] [<ffffffff800048e2>] dump_backtrace+0x1c/0x24
[guest1/uart0] [ 1.695263] [<ffffffff80707e56>] show_stack+0x2c/0x38
[guest1/uart0] [ 1.700019] [<ffffffff8070a8c2>] dump_stack+0x72/0x8c
[guest1/uart0] [ 1.739008] [<ffffffff8002afba>] ___might_sleep+0xde/0xee
[guest1/uart0] [ 1.744272] [<ffffffff8002b008>] __might_sleep+0x3e/0x6a
[guest1/uart0] [ 1.767160] [<ffffffff807147a2>] mutex_lock+0x22/0x4e
[guest1/uart0] [ 1.785848] [<ffffffff805c8e22>] rpmsg_recv_done+0x15a/0x26c
[guest1/uart0] [ 1.806548] [<ffffffff8032c7fc>] vring_interrupt+0x50/0x78
[guest1/uart0] [ 1.825028] [<ffffffff8032f0b0>] vm_interrupt+0x8e/0xcc
[guest1/uart0] [ 1.831433] [<ffffffff8005148e>] __handle_irq_event_percpu+0x46/0x112
[guest1/uart0] [ 1.850076] [<ffffffff80051612>] handle_irq_event+0x4a/0xae
[guest1/uart0] [ 1.869597] [<ffffffff80054d3e>] handle_fasteoi_irq+0x96/0x188
[guest1/uart0] [ 1.875966] [<ffffffff800505f6>] generic_handle_irq+0x28/0x36
[guest1/uart0] [ 1.895272] [<ffffffff802e69ec>] plic_handle_irq+0x96/0x108
[guest1/uart0] [ 1.914942] [<ffffffff80050dbe>] __handle_domain_irq+0x72/0xcc
[guest1/uart0] [ 1.922322] [<ffffffff802e67aa>] riscv_intc_irq+0x38/0x60
[guest1/uart0] [ 1.944575] [<ffffffff800032ca>] ret_from_exception+0x0/0xc
[guest1/uart0] [ 1.963709] [<ffffffff8005d39c>] rcu_idle_enter+0x10/0x18
[guest1/uart0] [ 1.984319] ---[ end trace 5ff0062d55835a41 ]---
[guest1/uart0] [ 1.989060] Kernel panic - not syncing: Fatal exception in interrupt
[guest1/uart0] [ 2.020105] SMP: stopping secondary CPUs
[guest1/uart0] [ 2.039065] ---[ end Kernel panic - not syncing: Fatal exception in interrupt ]---
[guest1/uart0]
OpenSBI v0.9-81-ga731c7e
____ _____ ____ _____
/ __ \ / ____| _ \_ _|
| | | |_ __ ___ _ __ | (___ | |_) || |
| | | | '_ \ / _ \ '_ \ \___ \| _ < | |
| |__| | |_) | __/ | | |____) | |_) || |_
\____/| .__/ \___|_| |_|_____/|____/_____|
| |
|_|
Platform Name : riscv-virtio,qemu
Platform Features : mfdeleg
Platform HART Count : 1
Platform IPI Device : aclint-mswi
Platform Timer Device : aclint-mtimer
Platform Console Device : uart8250
Platform HSM Device : ---
Platform SysReset Device : sifive_test
Firmware Base : 0x80000000
Firmware Size : 112 KB
Runtime SBI Version : 0.3
Domain0 Name : root
Domain0 Boot HART : 0
Domain0 HARTs : 0*
Domain0 Region00 : 0x0000000002000000-0x000000000200ffff (I)
Domain0 Region01 : 0x0000000080000000-0x000000008001ffff ()
Domain0 Region02 : 0x0000000000000000-0xffffffffffffffff (R,W,X)
Domain0 Next Address : 0x0000000080200000
Domain0 Next Arg1 : 0x0000000082200000
Domain0 Next Mode : S-mode
Domain0 SysReset : yes
Boot HART ID : 0
Boot HART Domain : root
Boot HART ISA : rv64imafdcsuh
Boot HART Features : scounteren,mcounteren,time
Boot HART PMP Count : 16
Boot HART PMP Granularity : 4
Boot HART PMP Address Bits: 54
Boot HART MHPM Count : 0
Boot HART MHPM Count : 0
Boot HART MIDELEG : 0x0000000000000666
Boot HART MEDELEG : 0x0000000000f0b509
Xvisor v0.3.0-206-g32153a14 (Jul 6 2021 07:19:25)
INIT: host address space
INIT: vapool: base=0x0000000010000000 size=33554432
INIT: vapool: hkbase=0x000000001014D000 hksize=131072
INIT: ram: bank0 phys=0x0000000080000000 size=1073741824
INIT: ram: bank0 hkbase=0x000000001016D000 hksize=32768
INIT: ram_reserve: phys=0x0000000080200000 size=839680
INIT: ram_reserve: phys=0x000000008034D000 size=393216
INIT: ram_reserve: phys=0x00000000802CD000 size=524288
INIT: vapool_reserve: virt=0x0000000010000000 size=1757184
INIT: ram_reserve: phys=0x0000000082200000 size=8192
INIT: heap management
INIT: device tree
INIT: device tree reserved-memory
INIT: ram_reserve: phys=0x0000000080000000 size=131072
INIT: DMA heap management
INIT: CPU nascent
INIT: SBI specification v0.3 detected
INIT: SBI implementation ID=0x1 Version=0x9
INIT: SBI TIME extension detected
INIT: SBI IPI extension detected
INIT: SBI RFENCE extension detected
INIT: SBI SRST extension detected
INIT: board nascent
INIT: nascent funtions
INIT: page pool
INIT: exception table
INIT: discover secondary CPUs
INIT: using SBI SMP operations
INIT: per-CPU areas
INIT: CPU hotplug
INIT: host irq subsystem
INIT: plic: base=0x000000000C000000 size=2105344
INIT: plic: devices=54 contexts=1/2
INIT: CPU early
INIT: early_params: vmm.bootcmd="vfs mount initrd /;vfs run /boot.xscript;vfs cat /system/banner.txt"
INIT: board early
INIT: early funtions
INIT: standard I/O
INIT: clocksource manager
INIT: clockchip manager
INIT: hypervisor timer
INIT: hypervisor soft delay
INIT: hypervisor shared memory
INIT: hypervisor manager
INIT: synchronus inter-processor interrupts
INIT: hypervisor scheduler
INIT: asynchronus inter-processor interrupts
INIT: hypervisor threads
INIT: workqueue framework
INIT: wallclock subsystem
INIT: start secondary CPUs
INIT: command manager
INIT: device driver framework
INIT: device emulation framework
INIT: character device framework
INIT: iommu framework
INIT: hypervisor modules
INIT: block device framework
INIT: network switch framework
INIT: network port framework
initrd: RBD created at 0x88200000 - 0x8a200000
INIT: CPU final
INIT: board final
INIT: final functions
INIT: CPU0 online
INIT: brought-up 1 CPUs
INIT: freeing init memory 24K
INIT: change stdio device to uart@10000000
INIT: syncup wallclock using rtc@101000
INIT: bootcmd: vfs mount initrd /
Trying: cpio ext4
Mounted initrd using ext4 at /
INIT: bootcmd: vfs run /boot.xscript
Created default shared memory
guest0: Created
guest0: Parsing /images/riscv/virt64/nor_flash.list
guest0: Loading 0x0000000000000000 with file ./firmware.bin
guest0: Loaded 0x0000000000000000 with 73892 bytes
guest0: Loading 0x00000000000FF000 with file ./cmdlist
guest0: Loaded 0x00000000000FF000 with 167 bytes
guest0: Loading 0x0000000000100000 with file ./Image
guest0: Loaded 0x0000000000100000 with 19810816 bytes
guest0: Loading 0x0000000001F00000 with file ./virt64.dtb
guest0: Loaded 0x0000000001F00000 with 2122 bytes
guest0: Loading 0x0000000002000000 with file ./rootfs.img
guest0: Loaded 0x0000000002000000 with 1508352 bytes
guest1: Created
guest1: Parsing /images/riscv/virt64/nor_flash.list
guest1: Loading 0x0000000000000000 with file ./firmware.bin
guest1: Loaded 0x0000000000000000 with 73892 bytes
guest1: Loading 0x00000000000FF000 with file ./cmdlist
guest1: Loaded 0x00000000000FF000 with 167 bytes
guest1: Loading 0x0000000000100000 with file ./Image
guest1: Loaded 0x0000000000100000 with 19810816 bytes
guest1: Loading 0x0000000001F00000 with file ./virt64.dtb
guest1: Loaded 0x0000000001F00000 with 2122 bytes
guest1: Loading 0x0000000002000000 with file ./rootfs.img
guest1: Loaded 0x0000000002000000 with 1508352 bytes
INIT: bootcmd: vfs cat /system/banner.txt
ooooooo ooooo oooooo oooo ooooo .oooooo..o .oooooo. ooooooooo.
`8888 d8' `888. .8' `888' d8P' `Y8 d8P' `Y8b `888 `Y88.
Y888..8P `888. .8' 888 Y88bo. 888 888 888 .d88'
`8888' `888. .8' 888 `Y8888o. 888 888 888ooo88P'
.8PY888. `888.8' 888 `Y88b 888 888 888`88b.
d8' `888b `888' 888 oo .d8P `88b d88' 888 `88b.
o888o o88888o `8' o888o 8''88888P' `Y8bood8P' o888o o888o
XVisor# guest kick guest0
guest0: Kicked
XVisor# guest kick guest1
guest1: Kicked
XVisor# vserial bind guest0/uart0
[guest0/uart0] RISC-V Virt64 Basic Firmware
[guest0/uart0]
[guest0/uart0] autoboot: disabled
[guest0/uart0]
[guest0/uart0] basic# autoexec
[guest0/uart0] autoexec(copy 0x80200000 0x00100000 0x1E00000)
[guest0/uart0] copy took 86321 usecs for 0x1E00000 bytes
[guest0/uart0] autoexec(copy 0x83000000 0x01F00000 0x020000)
[guest0/uart0] copy took 432 usecs for 0x020000 bytes
[guest0/uart0] autoexec(copy 0x83100000 0x02000000 0x800000)
[guest0/uart0] copy took 22924 usecs for 0x800000 bytes
[guest0/uart0] autoexec(start_linux_fdt 0x80200000 0x83000000 0x83100000 0x800000)
[guest0/uart0] Trying to set new bootargs: root=/dev/ram rw console=ttyS0,115200 earlycon=uart8250,mmio,0x10000000 mem=256M
[guest0/uart0] Jumping into linux ...
[guest0/uart0] [ 0.000000] Linux version 5.13.0 (embeddedinn@embeddedinn) (riscv64-unknown-linux-gnu-gcc (GCC) 11.1.0, GNU ld (GNU Binutils) 2.36.1) #1 SMP Tue Jul 6 09:26:02 IST 2021
[guest0/uart0] [ 0.000000] OF: fdt: Ignoring memory range 0x80000000 - 0x80200000
[guest0/uart0] [ 0.000000] Machine model: Virt64
[guest0/uart0] [ 0.000000] earlycon: uart8250 at MMIO 0x0000000010000000 (options '')
[guest0/uart0] [ 0.000000] printk: bootconsole [uart8250] enabled
[guest0/uart0] [ 0.000000] efi: UEFI not found.
[guest0/uart0] [ 0.000000] Reserved memory: created DMA memory pool at 0x0000000058000000, size 16 MiB
[guest0/uart0] [ 0.000000] OF: reserved mem: initialized node shmem@58000000, compatible id shared-dma-pool
[guest0/uart0] [ 0.000000] Zone ranges:
[guest0/uart0] [ 0.000000] DMA32 [mem 0x0000000080200000-0x000000008fffffff]
[guest0/uart0] [ 0.000000] Normal empty
[guest0/uart0] [ 0.000000] Movable zone start for each node
[guest0/uart0] [ 0.000000] Early memory node ranges
[guest0/uart0] [ 0.000000] node 0: [mem 0x0000000080200000-0x000000008fffffff]
[guest0/uart0] [ 0.000000] Initmem setup node 0 [mem 0x0000000080200000-0x000000008fffffff]
[guest0/uart0] [ 0.000000] SBI specification v0.2 detected
[guest0/uart0] [ 0.000000] SBI implementation ID=0x2 Version=0x3000
[guest0/uart0] [ 0.000000] SBI TIME extension detected
[guest0/uart0] [ 0.000000] SBI IPI extension detected
[guest0/uart0] [ 0.000000] SBI RFENCE extension detected
[guest0/uart0] [ 0.000000] software IO TLB: mapped [mem 0x000000008bc79000-0x000000008fc79000] (64MB)
[guest0/uart0] [ 0.000000] SBI v0.2 HSM extension detected
[guest0/uart0] [ 0.000000] riscv: ISA extensions acdfim
[guest0/uart0] [ 0.000000] riscv: ELF capabilities acdfim
[guest0/uart0] [ 0.000000] percpu: Embedded 18 pages/cpu s34664 r8192 d30872 u73728
[guest0/uart0] [ 0.000000] Built 1 zonelists, mobility grouping on. Total pages: 64135
[guest0/uart0] [ 0.000000] Kernel command line: root=/dev/ram rw console=ttyS0,115200 earlycon=uart8250,mmio,0x10000000 mem=256M
[guest0/uart0] [ 0.000000] Dentry cache hash table entries: 32768 (order: 6, 262144 bytes, linear)
[guest0/uart0] [ 0.000000] Inode-cache hash table entries: 16384 (order: 5, 131072 bytes, linear)
[guest0/uart0] [ 0.000000] Sorting __ex_table...
[guest0/uart0] [ 0.000000] mem auto-init: stack:off, heap alloc:off, heap free:off
[guest0/uart0] [ 0.000000] Virtual kernel memory layout:
[guest0/uart0] [ 0.000000] fixmap : 0xffffffcefee00000 - 0xffffffceff000000 (2048 kB)
[guest0/uart0] [ 0.000000] pci io : 0xffffffceff000000 - 0xffffffcf00000000 ( 16 MB)
[guest0/uart0] [ 0.000000] vmemmap : 0xffffffcf00000000 - 0xffffffcfffffffff (4095 MB)
[guest0/uart0] [ 0.000000] vmalloc : 0xffffffd000000000 - 0xffffffdfffffffff (65535 MB)
[guest0/uart0] [ 0.000000] lowmem : 0xffffffe000000000 - 0xffffffe00fe00000 ( 254 MB)
[guest0/uart0] [ 0.000000] kernel : 0xffffffff80000000 - 0xffffffffffffffff (2047 MB)
[guest0/uart0] [ 0.000000] Memory: 160960K/260096K available (7263K kernel code, 4896K rwdata, 4096K rodata, 2162K init, 309K bss, 99136K reserved, 0K cma-reserved)
[guest0/uart0] [ 0.000000] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=2, Nodes=1
[guest0/uart0] [ 0.000000] rcu: Hierarchical RCU implementation.
[guest0/uart0] [ 0.000000] rcu: RCU restricting CPUs from NR_CPUS=8 to nr_cpu_ids=2.
[guest0/uart0] [ 0.000000] rcu: RCU debug extended QS entry/exit.
[guest0/uart0] [ 0.000000] Tracing variant of Tasks RCU enabled.
[guest0/uart0] [ 0.000000] rcu: RCU calculated value of scheduler-enlistment delay is 25 jiffies.
[guest0/uart0] [ 0.000000] rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=2
[guest0/uart0] [ 0.000000] NR_IRQS: 64, nr_irqs: 64, preallocated irqs: 0
[guest0/uart0] [ 0.000000] riscv-intc: 64 local interrupts mapped
[guest0/uart0] [ 0.000000] plic: interrupt-controller@c000000: mapped 32 interrupts with 2 handlers for 4 contexts.
[guest0/uart0] [ 0.000000] random: get_random_bytes called from start_kernel+0x3b6/0x598 with crng_init=0
[guest0/uart0] [ 0.000000] riscv_timer_init_dt: Registering clocksource cpuid [0] hartid [0]
[guest0/uart0] [ 0.000000] clocksource: riscv_clocksource: mask: 0xffffffffffffffff max_cycles: 0x24e6a1710, max_idle_ns: 440795202120 ns
[guest0/uart0] [ 0.000079] sched_clock: 64 bits at 10MHz, resolution 100ns, wraps every 4398046511100ns
[guest0/uart0] [ 0.041480] Console: colour dummy device 80x25
[guest0/uart0] [ 0.067655] Calibrating delay loop (skipped), value calculated using timer frequency.. 20.00 BogoMIPS (lpj=40000)
[guest0/uart0] [ 0.092883] pid_max: default: 32768 minimum: 301
[guest0/uart0] [ 0.114894] Mount-cache hash table entries: 512 (order: 0, 4096 bytes, linear)
[guest0/uart0] [ 0.136836] Mountpoint-cache hash table entries: 512 (order: 0, 4096 bytes, linear)
[guest0/uart0] [ 0.193317] ASID allocator using 16 bits (65536 entries)
[guest0/uart0] [ 0.220657] rcu: Hierarchical SRCU implementation.
[guest0/uart0] [ 0.250702] EFI services will not be available.
[guest0/uart0] [ 0.275648] smp: Bringing up secondary CPUs ...
[guest0/uart0] [ 0.332261] smp: Brought up 1 node, 2 CPUs
[guest0/uart0] [ 0.388795] devtmpfs: initialized
[guest0/uart0] [ 0.412107] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 7645041785100000 ns
[guest0/uart0] [ 0.438063] futex hash table entries: 512 (order: 3, 32768 bytes, linear)
[guest0/uart0] [ 0.466227] NET: Registered protocol family 16
[guest0/uart0] [ 0.566098] wait_for_initramfs() called before rootfs_initcalls
[guest0/uart0] [ 0.654250] vgaarb: loaded
[guest0/uart0] [ 0.660525] SCSI subsystem initialized
[guest0/uart0] [ 0.705956] usbcore: registered new interface driver usbfs
[guest0/uart0] [ 0.729156] usbcore: registered new interface driver hub
[guest0/uart0] [ 0.737071] usbcore: registered new device driver usb
[guest0/uart0] [ 0.849286] clocksource: Switched to clocksource riscv_clocksource
[guest0/uart0] [ 0.878861] simple-framebuffer 50000000.simplefb: framebuffer at 0x50000000, 0x1000000 bytes
[guest0/uart0] [ 0.905049] simple-framebuffer 50000000.simplefb: format=a8r8g8b8, mode=1600x900x32, linelength=6400
[guest0/uart0] [ 1.001415] Console: switching to colour frame buffer device 200x56
[guest0/uart0] [ 1.047985] simple-framebuffer 50000000.simplefb: fb0: simplefb registered!
[guest0/uart0] [ 3.860926] NET: Registered protocol family 2
[guest0/uart0] [ 3.868792] IP idents hash table entries: 4096 (order: 3, 32768 bytes, linear)
[guest0/uart0] [ 3.905496] tcp_listen_portaddr_hash hash table entries: 128 (order: 0, 5120 bytes, linear)
[guest0/uart0] [ 3.931317] TCP established hash table entries: 2048 (order: 2, 16384 bytes, linear)
[guest0/uart0] [ 3.954645] TCP bind hash table entries: 2048 (order: 4, 65536 bytes, linear)
[guest0/uart0] [ 3.977464] TCP: Hash tables configured (established 2048 bind 2048)
[guest0/uart0] [ 4.000822] UDP hash table entries: 256 (order: 2, 24576 bytes, linear)
[guest0/uart0] [ 4.025462] UDP-Lite hash table entries: 256 (order: 2, 24576 bytes, linear)
[guest0/uart0] [ 4.048511] NET: Registered protocol family 1
[guest0/uart0] [ 4.098268] RPC: Registered named UNIX socket transport module.
[guest0/uart0] [ 4.122492] RPC: Registered udp transport module.
[guest0/uart0] [ 4.142430] RPC: Registered tcp transport module.
[guest0/uart0] [ 4.148966] RPC: Registered tcp NFSv4.1 backchannel transport module.
[guest0/uart0] [ 4.173509] PCI: CLS 0 bytes, default 64
[guest0/uart0] [ 4.202131] Unpacking initramfs...
[guest0/uart0] [ 4.229689] workingset: timestamp_bits=62 max_order=16 bucket_order=0
[guest0/uart0] [ 4.308298] NFS: Registering the id_resolver key type
[guest0/uart0] [ 4.340852] Key type id_resolver registered
[guest0/uart0] [ 4.348013] Key type id_legacy registered
[guest0/uart0] [ 4.378393] nfs4filelayout_init: NFSv4 File Layout Driver Registering...
[guest0/uart0] [ 4.411756] nfs4flexfilelayout_init: NFSv4 Flexfile Layout Driver Registering...
[guest0/uart0] [ 4.480192] 9p: Installing v9fs 9p2000 file system support
[guest0/uart0] [ 4.514098] NET: Registered protocol family 38
[guest0/uart0] [ 4.520147] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 251)
[guest0/uart0] [ 4.561278] io scheduler mq-deadline registered
[guest0/uart0] [ 4.598958] io scheduler kyber registered
[guest0/uart0] [ 4.696378] Freeing initrd memory: 8192K
[guest0/uart0] [ 4.747241] virtio_rpmsg_bus virtio3: rpmsg host is online
[guest0/uart0] [ 4.802136] input: Xvisor VirtIO Input as /devices/platform/smb/20004000.virtio_input/virtio4/input/input0
[guest0/uart0] [ 5.011626] Serial: 8250/16550 driver, 4 ports, IRQ sharing disabled
[guest0/uart0] [ 5.064769] printk: console [ttyS0] disabled
[guest0/uart0] [ 5.073195] 10000000.uart: ttyS0 at MMIO 0x10000000 (irq = 1, base_baud = 230400) is a 16550A
[guest0/uart0] [ 5.113388] printk: console [ttyS0] enabled
[guest0/uart0] [ 5.113388] printk: console [ttyS0] enabled
[guest0/uart0] [ 5.140393] printk: bootconsole [uart8250] disabled
[guest0/uart0] [ 5.140393] printk: bootconsole [uart8250] disabled
[guest0/uart0] [ 5.186015] [drm] radeon kernel modesetting enabled.
[guest0/uart0] [ 5.234630] loop: module loaded
[guest0/uart0] [ 5.255138] virtio_blk virtio1: [vda] 0 512-byte logical blocks (0 B/0 B)
[guest0/uart0] [ 5.305124] libphy: Fixed MDIO Bus: probed
[guest0/uart0] [ 5.336692] e1000e: Intel(R) PRO/1000 Network Driver
[guest0/uart0] [ 5.362660] e1000e: Copyright(c) 1999 - 2015 Intel Corporation.
[guest0/uart0] [ 5.386706] ehci_hcd: USB 2.0 'Enhanced' Host Controller (EHCI) Driver
[guest0/uart0] [ 5.419198] ehci-pci: EHCI PCI platform driver
[guest0/uart0] [ 5.440468] ehci-platform: EHCI generic platform driver
[guest0/uart0] [ 5.460148] ohci_hcd: USB 1.1 'Open' Host Controller (OHCI) Driver
[guest0/uart0] [ 5.482725] ohci-pci: OHCI PCI platform driver
[guest0/uart0] [ 5.504685] ohci-platform: OHCI generic platform driver
[guest0/uart0] [ 5.525046] usbcore: registered new interface driver uas
[guest0/uart0] [ 5.532646] usbcore: registered new interface driver usb-storage
[guest0/uart0] [ 5.558478] mousedev: PS/2 mouse device common for all mice
[guest0/uart0] [ 5.613570] goldfish_rtc 10003000.rtc: registered as rtc0
[guest0/uart0] [ 5.641314] goldfish_rtc 10003000.rtc: setting system clock to 2021-07-06T04:01:21 UTC (1625544081)
[guest0/uart0] [ 5.669097] sdhci: Secure Digital Host Controller Interface driver
[guest0/uart0] [ 5.696423] sdhci: Copyright(c) Pierre Ossman
[guest0/uart0] [ 5.721510] sdhci-pltfm: SDHCI platform and OF driver helper
[guest0/uart0] [ 5.729000] usbcore: registered new interface driver usbhid
[guest0/uart0] [ 5.754799] usbhid: USB HID core driver
[guest0/uart0] [ 5.775851] NET: Registered protocol family 10
[guest0/uart0] [ 5.834293] Segment Routing with IPv6
[guest0/uart0] [ 5.854913] sit: IPv6, IPv4 and MPLS over IPv4 tunneling driver
[guest0/uart0] [ 5.877921] NET: Registered protocol family 17
[guest0/uart0] [ 5.884616] 9pnet: Installing 9P2000 support
[guest0/uart0] [ 5.906588] Key type dns_resolver registered
[guest0/uart0] [ 5.934379] debug_vm_pgtable: [debug_vm_pgtable ]: Validating architecture page table helpers
[guest0/uart0] [ 6.052561] Freeing unused kernel memory: 2160K
[guest0/uart0] [ 6.071168] Run /init as init process
[guest0/uart0] _ _
[guest0/uart0] | ||_|
[guest0/uart0] | | _ ____ _ _ _ _
[guest0/uart0] | || | _ \| | | |\ \/ /
[guest0/uart0] | || | | | | |_| |/ \
[guest0/uart0] |_||_|_| |_|\____|\_/\_/
[guest0/uart0]
[guest0/uart0] Busybox Rootfs
[guest0/uart0]
[guest0/uart0] Please press Enter to activate this console.
[guest0/uart0] / #
[guest0/uart0] / #
XVisor# vserial bind guest1/uart0
[guest1/uart0] RISC-V Virt64 Basic Firmware
[guest1/uart0]
[guest1/uart0] autoboot: disabled
[guest1/uart0]
[guest1/uart0] basic# autoexec
[guest1/uart0] autoexec(copy 0x80200000 0x00100000 0x1E00000)
[guest1/uart0] copy took 145140 usecs for 0x1E00000 bytes
[guest1/uart0] autoexec(copy 0x83000000 0x01F00000 0x020000)
[guest1/uart0] copy took 9250 usecs for 0x020000 bytes
[guest1/uart0] autoexec(copy 0x83100000 0x02000000 0x800000)
[guest1/uart0] copy took 39812 usecs for 0x800000 bytes
[guest1/uart0] autoexec(start_linux_fdt 0x80200000 0x83000000 0x83100000 0x800000)
[guest1/uart0] Trying to set new bootargs: root=/dev/ram rw console=ttyS0,115200 earlycon=uart8250,mmio,0x10000000 mem=256M
[guest1/uart0] Jumping into linux ...
[guest1/uart0] [ 0.000000] Linux version 5.13.0 (embeddedinn@embeddedinn) (riscv64-unknown-linux-gnu-gcc (GCC) 11.1.0, GNU ld (GNU Binutils) 2.36.1) #1 SMP Tue Jul 6 09:26:02 IST 2021
[guest1/uart0] [ 0.000000] OF: fdt: Ignoring memory range 0x80000000 - 0x80200000
[guest1/uart0] [ 0.000000] Machine model: Virt64
[guest1/uart0] [ 0.000000] earlycon: uart8250 at MMIO 0x0000000010000000 (options '')
[guest1/uart0] [ 0.000000] printk: bootconsole [uart8250] enabled
[guest1/uart0] [ 0.000000] efi: UEFI not found.
[guest1/uart0] [ 0.000000] Reserved memory: created DMA memory pool at 0x0000000058000000, size 16 MiB
[guest1/uart0] [ 0.000000] OF: reserved mem: initialized node shmem@58000000, compatible id shared-dma-pool
[guest1/uart0] [ 0.000000] Zone ranges:
[guest1/uart0] [ 0.000000] DMA32 [mem 0x0000000080200000-0x000000008fffffff]
[guest1/uart0] [ 0.000000] Normal empty
[guest1/uart0] [ 0.000000] Movable zone start for each node
[guest1/uart0] [ 0.000000] Early memory node ranges
[guest1/uart0] [ 0.000000] node 0: [mem 0x0000000080200000-0x000000008fffffff]
[guest1/uart0] [ 0.000000] Initmem setup node 0 [mem 0x0000000080200000-0x000000008fffffff]
[guest1/uart0] [ 0.000000] SBI specification v0.2 detected
[guest1/uart0] [ 0.000000] SBI implementation ID=0x2 Version=0x3000
[guest1/uart0] [ 0.000000] SBI TIME extension detected
[guest1/uart0] [ 0.000000] SBI IPI extension detected
[guest1/uart0] [ 0.000000] SBI RFENCE extension detected
[guest1/uart0] [ 0.000000] software IO TLB: mapped [mem 0x000000008bc79000-0x000000008fc79000] (64MB)
[guest1/uart0] [ 0.000000] SBI v0.2 HSM extension detected
[guest1/uart0] [ 0.000000] riscv: ISA extensions acdfim
[guest1/uart0] [ 0.000000] riscv: ELF capabilities acdfim
[guest1/uart0] [ 0.000000] percpu: Embedded 18 pages/cpu s34664 r8192 d30872 u73728
[guest1/uart0] [ 0.000000] Built 1 zonelists, mobility grouping on. Total pages: 64135
[guest1/uart0] [ 0.000000] Kernel command line: root=/dev/ram rw console=ttyS0,115200 earlycon=uart8250,mmio,0x10000000 mem=256M
[guest1/uart0] [ 0.000000] Dentry cache hash table entries: 32768 (order: 6, 262144 bytes, linear)
[guest1/uart0] [ 0.000000] Inode-cache hash table entries: 16384 (order: 5, 131072 bytes, linear)
[guest1/uart0] [ 0.000000] Sorting __ex_table...
[guest1/uart0] [ 0.000000] mem auto-init: stack:off, heap alloc:off, heap free:off
[guest1/uart0] [ 0.000000] Virtual kernel memory layout:
[guest1/uart0] [ 0.000000] fixmap : 0xffffffcefee00000 - 0xffffffceff000000 (2048 kB)
[guest1/uart0] [ 0.000000] pci io : 0xffffffceff000000 - 0xffffffcf00000000 ( 16 MB)
[guest1/uart0] [ 0.000000] vmemmap : 0xffffffcf00000000 - 0xffffffcfffffffff (4095 MB)
[guest1/uart0] [ 0.000000] vmalloc : 0xffffffd000000000 - 0xffffffdfffffffff (65535 MB)
[guest1/uart0] [ 0.000000] lowmem : 0xffffffe000000000 - 0xffffffe00fe00000 ( 254 MB)
[guest1/uart0] [ 0.000000] kernel : 0xffffffff80000000 - 0xffffffffffffffff (2047 MB)
[guest1/uart0] [ 0.000000] Memory: 160960K/260096K available (7263K kernel code, 4896K rwdata, 4096K rodata, 2162K init, 309K bss, 99136K reserved, 0K cma-reserved)
[guest1/uart0] [ 0.000000] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=2, Nodes=1
[guest1/uart0] [ 0.000000] rcu: Hierarchical RCU implementation.
[guest1/uart0] [ 0.000000] rcu: RCU restricting CPUs from NR_CPUS=8 to nr_cpu_ids=2.
[guest1/uart0] [ 0.000000] rcu: RCU debug extended QS entry/exit.
[guest1/uart0] [ 0.000000] Tracing variant of Tasks RCU enabled.
[guest1/uart0] [ 0.000000] rcu: RCU calculated value of scheduler-enlistment delay is 25 jiffies.
[guest1/uart0] [ 0.000000] rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=2
[guest1/uart0] [ 0.000000] NR_IRQS: 64, nr_irqs: 64, preallocated irqs: 0
[guest1/uart0] [ 0.000000] riscv-intc: 64 local interrupts mapped
[guest1/uart0] [ 0.000000] plic: interrupt-controller@c000000: mapped 32 interrupts with 2 handlers for 4 contexts.
[guest1/uart0] [ 0.000000] random: get_random_bytes called from start_kernel+0x3b6/0x598 with crng_init=0
[guest1/uart0] [ 0.000000] riscv_timer_init_dt: Registering clocksource cpuid [0] hartid [0]
[guest1/uart0] [ 0.000000] clocksource: riscv_clocksource: mask: 0xffffffffffffffff max_cycles: 0x24e6a1710, max_idle_ns: 440795202120 ns
[guest1/uart0] [ 0.000079] sched_clock: 64 bits at 10MHz, resolution 100ns, wraps every 4398046511100ns
[guest1/uart0] [ 0.010137] Console: colour dummy device 80x25
[guest1/uart0] [ 0.018561] Calibrating delay loop (skipped), value calculated using timer frequency.. 20.00 BogoMIPS (lpj=40000)
[guest1/uart0] [ 0.030090] pid_max: default: 32768 minimum: 301
[guest1/uart0] [ 0.035788] Mount-cache hash table entries: 512 (order: 0, 4096 bytes, linear)
[guest1/uart0] [ 0.043559] Mountpoint-cache hash table entries: 512 (order: 0, 4096 bytes, linear)
[guest1/uart0] [ 0.083700] ASID allocator using 16 bits (65536 entries)
[guest1/uart0] [ 0.090180] rcu: Hierarchical SRCU implementation.
[guest1/uart0] [ 0.097176] EFI services will not be available.
[guest1/uart0] [ 0.104513] smp: Bringing up secondary CPUs ...
[guest1/uart0] [ 0.117439] smp: Brought up 1 node, 2 CPUs
[guest1/uart0] [ 0.144896] devtmpfs: initialized
[guest1/uart0] [ 0.156678] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 7645041785100000 ns
[guest1/uart0] [ 0.169969] futex hash table entries: 512 (order: 3, 32768 bytes, linear)
[guest1/uart0] [ 0.182760] NET: Registered protocol family 16
[guest1/uart0] [ 0.236024] wait_for_initramfs() called before rootfs_initcalls
[guest1/uart0] [ 0.267788] vgaarb: loaded
[guest1/uart0] [ 0.271733] SCSI subsystem initialized
[guest1/uart0] [ 0.278854] usbcore: registered new interface driver usbfs
[guest1/uart0] [ 0.286367] usbcore: registered new interface driver hub
[guest1/uart0] [ 0.294809] usbcore: registered new device driver usb
[guest1/uart0] [ 0.352540] clocksource: Switched to clocksource riscv_clocksource
[guest1/uart0] [ 0.364381] simple-framebuffer 50000000.simplefb: framebuffer at 0x50000000, 0x1000000 bytes
[guest1/uart0] [ 0.378950] simple-framebuffer 50000000.simplefb: format=a8r8g8b8, mode=1600x900x32, linelength=6400
[guest1/uart0] [ 0.438243] Console: switching to colour frame buffer device 200x56
[guest1/uart0] [ 0.454131] simple-framebuffer 50000000.simplefb: fb0: simplefb registered!
[guest1/uart0] [ 0.596024] NET: Registered protocol family 2
[guest1/uart0] [ 0.602231] IP idents hash table entries: 4096 (order: 3, 32768 bytes, linear)
[guest1/uart0] [ 0.616107] tcp_listen_portaddr_hash hash table entries: 128 (order: 0, 5120 bytes, linear)
[guest1/uart0] [ 0.630042] TCP established hash table entries: 2048 (order: 2, 16384 bytes, linear)
[guest1/uart0] [ 0.641666] TCP bind hash table entries: 2048 (order: 4, 65536 bytes, linear)
[guest1/uart0] [ 0.650931] TCP: Hash tables configured (established 2048 bind 2048)
[guest1/uart0] [ 0.659276] UDP hash table entries: 256 (order: 2, 24576 bytes, linear)
[guest1/uart0] [ 0.667095] UDP-Lite hash table entries: 256 (order: 2, 24576 bytes, linear)
[guest1/uart0] [ 0.676484] NET: Registered protocol family 1
[guest1/uart0] [ 0.697683] RPC: Registered named UNIX socket transport module.
[guest1/uart0] [ 0.708759] RPC: Registered udp transport module.
[guest1/uart0] [ 0.715158] RPC: Registered tcp transport module.
[guest1/uart0] [ 0.721726] RPC: Registered tcp NFSv4.1 backchannel transport module.
[guest1/uart0] [ 0.732071] PCI: CLS 0 bytes, default 64
[guest1/uart0] [ 0.743498] Unpacking initramfs...
[guest1/uart0] [ 0.834900] workingset: timestamp_bits=62 max_order=16 bucket_order=0
[guest1/uart0] [ 0.863411] NFS: Registering the id_resolver key type
[guest1/uart0] [ 0.880227] Key type id_resolver registered
[guest1/uart0] [ 0.885219] Key type id_legacy registered
[guest1/uart0] [ 0.904947] nfs4filelayout_init: NFSv4 File Layout Driver Registering...
[guest1/uart0] [ 0.924646] nfs4flexfilelayout_init: NFSv4 Flexfile Layout Driver Registering...
[guest1/uart0] [ 0.944791] 9p: Installing v9fs 9p2000 file system support
[guest1/uart0] [ 0.964845] NET: Registered protocol family 38
[guest1/uart0] [ 0.970252] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 251)
[guest1/uart0] [ 0.991386] io scheduler mq-deadline registered
[guest1/uart0] [ 1.008144] io scheduler kyber registered
[guest1/uart0] [ 1.057153] Freeing initrd memory: 8192K
[guest1/uart0] [ 1.088812] virtio_rpmsg_bus virtio3: rpmsg host is online
[guest1/uart0] [ 1.105144] input: Xvisor VirtIO Input as /devices/platform/smb/20004000.virtio_input/virtio4/input/input0
[guest1/uart0] [ 1.125592] BUG: sleeping function called from invalid context at kernel/locking/mutex.c:281
[guest1/uart0] [ 1.171726] in_atomic(): 1, irqs_disabled(): 1, non_block: 0, pid: 0, name: swapper/0
[guest1/uart0] [ 1.239990] CPU: 0 PID: 0 Comm: swapper/0 Not tainted 5.13.0 #1
[guest1/uart0] [ 1.249155] Hardware name: Virt64 (DT)
[guest1/uart0] [ 1.280242] Call Trace:
[guest1/uart0] [ 1.283266] Unable to handle kernel NULL pointer dereference at virtual address 0000000000000888
[guest1/uart0] [ 1.326317] Oops [#1]
[guest1/uart0] [ 1.360259] Modules linked in:
[guest1/uart0] [ 1.364224] CPU: 0 PID: 0 Comm: swapper/0 Not tainted 5.13.0 #1
[guest1/uart0] [ 1.392297] Hardware name: Virt64 (DT)
[guest1/uart0] [ 1.411481] epc : walk_stackframe+0xb0/0xc6
[guest1/uart0] [ 1.416391] ra : dump_backtrace+0x1c/0x24
[guest1/uart0] [ 1.433860] epc : ffffffff800048b0 ra : ffffffff800048e2 sp : ffffffff81203a40
[guest1/uart0] [ 1.456880] gp : ffffffff812e43e0 tp : ffffffff8120bd80 t0 : ffffffff812f20df
[guest1/uart0] [ 1.483773] t1 : ffffffff812f20d0 t2 : 0000000000000000 s0 : ffffffff81203a90
[guest1/uart0] [ 1.490774] s1 : ffffffff80db2250 a0 : 0000000000001000 a1 : 0000000000000000
[guest1/uart0] [ 1.509931] a2 : ffffffff80707e06 a3 : ffffffff80db2250 a4 : 0000000000000000
[guest1/uart0] [ 1.529133] a5 : 0000000000001000 a6 : 0000000000000005 a7 : ffffffffffffffff
[guest1/uart0] [ 1.551181] s2 : 0000000000000000 s3 : 0000000000000000 s4 : 0000000000000000
[guest1/uart0] [ 1.558040] s5 : ffffffff80db2250 s6 : ffffffff80707e06 s7 : 0000000000000cc0
[guest1/uart0] [ 1.579884] s8 : ffffffff812cd5f2 s9 : ffffffe001770a80 s10: 0000000000000000
[guest1/uart0] [ 1.600790] s11: ffffffe002000000 t3 : 0000000000000043 t4 : ffffffffffffffff
[guest1/uart0] [ 1.624570] t5 : ffffffff81284010 t6 : ffffffff81203808
[guest1/uart0] [ 1.632697] status: 0000000000000100 badaddr: 0000000000000888 cause: 000000000000000d
[guest1/uart0] [ 1.668863] [<ffffffff800048b0>] walk_stackframe+0xb0/0xc6
[guest1/uart0] [ 1.675665] [<ffffffff800048e2>] dump_backtrace+0x1c/0x24
[guest1/uart0] [ 1.695263] [<ffffffff80707e56>] show_stack+0x2c/0x38
[guest1/uart0] [ 1.700019] [<ffffffff8070a8c2>] dump_stack+0x72/0x8c
[guest1/uart0] [ 1.739008] [<ffffffff8002afba>] ___might_sleep+0xde/0xee
[guest1/uart0] [ 1.744272] [<ffffffff8002b008>] __might_sleep+0x3e/0x6a
[guest1/uart0] [ 1.767160] [<ffffffff807147a2>] mutex_lock+0x22/0x4e
[guest1/uart0] [ 1.785848] [<ffffffff805c8e22>] rpmsg_recv_done+0x15a/0x26c
[guest1/uart0] [ 1.806548] [<ffffffff8032c7fc>] vring_interrupt+0x50/0x78
[guest1/uart0] [ 1.825028] [<ffffffff8032f0b0>] vm_interrupt+0x8e/0xcc
[guest1/uart0] [ 1.831433] [<ffffffff8005148e>] __handle_irq_event_percpu+0x46/0x112
[guest1/uart0] [ 1.850076] [<ffffffff80051612>] handle_irq_event+0x4a/0xae
[guest1/uart0] [ 1.869597] [<ffffffff80054d3e>] handle_fasteoi_irq+0x96/0x188
[guest1/uart0] [ 1.875966] [<ffffffff800505f6>] generic_handle_irq+0x28/0x36
[guest1/uart0] [ 1.895272] [<ffffffff802e69ec>] plic_handle_irq+0x96/0x108
[guest1/uart0] [ 1.914942] [<ffffffff80050dbe>] __handle_domain_irq+0x72/0xcc
[guest1/uart0] [ 1.922322] [<ffffffff802e67aa>] riscv_intc_irq+0x38/0x60
[guest1/uart0] [ 1.944575] [<ffffffff800032ca>] ret_from_exception+0x0/0xc
[guest1/uart0] [ 1.963709] [<ffffffff8005d39c>] rcu_idle_enter+0x10/0x18
[guest1/uart0] [ 1.984319] ---[ end trace 5ff0062d55835a41 ]---
[guest1/uart0] [ 1.989060] Kernel panic - not syncing: Fatal exception in interrupt
[guest1/uart0] [ 2.020105] SMP: stopping secondary CPUs
[guest1/uart0] [ 2.039065] ---[ end Kernel panic - not syncing: Fatal exception in interrupt ]---
[guest1/uart0]
Cheers,
Vysakh P Pillai
Reply all
Reply to author
Forward
0 new messages