[ 0.000000] OF: fdt: Ignoring memory range 0x80000000 - 0x80400000 [ 0.000000] Machine model: riscv-virtio,qemu [ 0.000000] SBI specification v2.0 detected [ 0.000000] SBI implementation ID=0x1 Version=0x10004 [ 0.000000] SBI TIME extension detected [ 0.000000] SBI IPI extension detected [ 0.000000] SBI RFENCE extension detected [ 0.000000] SBI SRST extension detected [ 0.000000] Memory limited to 512MB [ 0.000000] efi: UEFI not found. [ 0.000000] OF: reserved mem: 0x80000000..0x8003ffff (256 KiB) nomap non-reusable mmode_resv1@80000000 [ 0.000000] OF: reserved mem: 0x80040000..0x8005ffff (128 KiB) nomap non-reusable mmode_resv0@80040000 [ 0.000000] Zone ranges: [ 0.000000] Normal [mem 0x0000000080400000-0x000000009fffffff] [ 0.000000] Movable zone start for each node [ 0.000000] Early memory node ranges [ 0.000000] node 0: [mem 0x0000000080400000-0x000000009fffffff] [ 0.000000] Initmem setup node 0 [mem 0x0000000080400000-0x000000009fffffff] [ 0.000000] SBI HSM extension detected [ 0.000000] Falling back to deprecated "riscv,isa" [ 0.000000] riscv: base ISA extensions acdfhim [ 0.000000] riscv: ELF capabilities acdfim [ 0.000000] percpu: Embedded 19 pages/cpu s48596 r8192 d21036 u77824 [ 0.000000] Kernel command line: root=/dev/vda rw mem=512M ip=192.168.7.2::192.168.7.1:255.255.255.0::eth0:off:8.8.8.8 net.ifnames=0 console=ttyS0 console=hvc0 earlycon=sbi swiotlb=0 printk.time=1 [ 0.000000] Unknown kernel command line parameters "swiotlb=0", will be passed to user space. [ 0.000000] Dentry cache hash table entries: 65536 (order: 6, 262144 bytes, linear) [ 0.000000] Inode-cache hash table entries: 32768 (order: 5, 131072 bytes, linear) [ 0.000000] Built 1 zonelists, mobility grouping on. Total pages: 128905 [ 0.000000] mem auto-init: stack:all(zero), heap alloc:off, heap free:off [ 0.000000] Memory: 484424K/520192K available (9990K kernel code, 9500K rwdata, 4096K rodata, 4219K init, 368K bss, 35768K reserved, 0K cma-reserved) [ 0.000000] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=4, Nodes=1 [ 0.000000] trace event string verifier disabled [ 0.000000] rcu: Preemptible hierarchical RCU implementation. [ 0.000000] rcu: RCU event tracing is enabled. [ 0.000000] rcu: RCU restricting CPUs from NR_CPUS=8 to nr_cpu_ids=4. [ 0.000000] Trampoline variant of Tasks RCU enabled. [ 0.000000] Tracing variant of Tasks RCU enabled. [ 0.000000] rcu: RCU calculated value of scheduler-enlistment delay is 25 jiffies. [ 0.000000] rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=4 [ 0.000000] NR_IRQS: 64, nr_irqs: 64, preallocated irqs: 0 [ 0.000000] riscv-intc: 32 local interrupts mapped [ 0.000000] plic: plic@c000000: mapped 95 interrupts with 4 handlers for 8 contexts. [ 0.000000] riscv: providing IPIs using SBI IPI extension [ 0.000000] rcu: srcu_init: Setting srcu_struct sizes based on contention. [ 0.000000] clocksource: riscv_clocksource: mask: 0xffffffffffffffff max_cycles: 0x24e6a1710, max_idle_ns: 440795202120 ns [ 0.000234] sched_clock: 64 bits at 10MHz, resolution 100ns, wraps every 4398046511100ns [ 0.000474] riscv-timer: Timer interrupt in S-mode is available via sstc extension [ 0.014345] Console: colour dummy device 80x25 [ 0.016718] Calibrating delay loop (skipped), value calculated using timer frequency.. 20.00 BogoMIPS (lpj=40000) [ 0.016950] pid_max: default: 32768 minimum: 301 [ 0.019105] LSM: initializing lsm=capability,landlock,integrity [ 0.019864] landlock: Up and running. [ 0.023756] Mount-cache hash table entries: 1024 (order: 0, 4096 bytes, linear) [ 0.023826] Mountpoint-cache hash table entries: 1024 (order: 0, 4096 bytes, linear) [ 0.076832] RCU Tasks: Setting shift to 2 and lim to 1 rcu_task_cb_adjust=1. [ 0.077794] RCU Tasks Trace: Setting shift to 2 and lim to 1 rcu_task_cb_adjust=1. [ 0.078447] ASID allocator using 9 bits (512 entries) [ 0.080038] rcu: Hierarchical SRCU implementation. [ 0.080093] rcu: Max phase no-delay instances is 1000. [ 0.086275] EFI services will not be available. [ 0.088721] smp: Bringing up secondary CPUs ... [ 0.118339] cpu1: Ratio of byte access time to unaligned word access is 3.70, unaligned accesses are fast [ 0.150864] cpu2: Ratio of byte access time to unaligned word access is 3.65, unaligned accesses are fast [ 0.176840] cpu3: Ratio of byte access time to unaligned word access is 3.65, unaligned accesses are fast [ 0.177913] smp: Brought up 1 node, 4 CPUs [ 0.204069] devtmpfs: initialized [ 0.216950] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 7645041785100000 ns [ 0.217360] futex hash table entries: 1024 (order: 4, 65536 bytes, linear) [ 0.232225] NET: Registered PF_NETLINK/PF_ROUTE protocol family [ 0.237773] DMA: preallocated 128 KiB GFP_KERNEL pool for atomic allocations [ 0.266967] cpu0: Ratio of byte access time to unaligned word access is 3.62, unaligned accesses are fast [ 0.372692] raid6: int32x8 gen() 175 MB/s [ 0.441510] raid6: int32x4 gen() 600 MB/s [ 0.510542] raid6: int32x2 gen() 615 MB/s [ 0.579573] raid6: int32x1 gen() 474 MB/s [ 0.579658] raid6: using algorithm int32x2 gen() 615 MB/s [ 0.648672] raid6: .... xor() 367 MB/s, rmw enabled [ 0.648808] raid6: using intx1 recovery algorithm [ 0.652869] SCSI subsystem initialized [ 0.653543] pps_core: LinuxPPS API ver. 1 registered [ 0.653578] pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti [ 0.653709] PTP clock support registered [ 0.678186] vgaarb: loaded [ 0.682666] clocksource: Switched to clocksource riscv_clocksource [ 0.734778] NET: Registered PF_INET protocol family [ 0.736693] IP idents hash table entries: 8192 (order: 4, 65536 bytes, linear) [ 0.747264] tcp_listen_portaddr_hash hash table entries: 512 (order: 0, 4096 bytes, linear) [ 0.747399] Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear) [ 0.747513] TCP established hash table entries: 4096 (order: 2, 16384 bytes, linear) [ 0.747797] TCP bind hash table entries: 4096 (order: 4, 65536 bytes, linear) [ 0.748427] TCP: Hash tables configured (established 4096 bind 4096) [ 0.750414] UDP hash table entries: 256 (order: 1, 8192 bytes, linear) [ 0.750770] UDP-Lite hash table entries: 256 (order: 1, 8192 bytes, linear) [ 0.753269] NET: Registered PF_UNIX/PF_LOCAL protocol family [ 0.758052] RPC: Registered named UNIX socket transport module. [ 0.758132] RPC: Registered udp transport module. [ 0.758276] RPC: Registered tcp transport module. [ 0.758304] RPC: Registered tcp-with-tls transport module. [ 0.758324] RPC: Registered tcp NFSv4.1 backchannel transport module. [ 0.758583] PCI: CLS 0 bytes, default 64 [ 1.047591] workingset: timestamp_bits=14 max_order=17 bucket_order=3 [ 1.052882] NFS: Registering the id_resolver key type [ 1.054584] Key type id_resolver registered [ 1.054653] Key type id_legacy registered [ 1.058757] Key type cifs.idmap registered [ 1.422317] xor: measuring software checksum speed [ 1.433787] 8regs : 908 MB/sec [ 1.445035] 8regs_prefetch : 894 MB/sec [ 1.456324] 32regs : 891 MB/sec [ 1.467653] 32regs_prefetch : 888 MB/sec [ 1.467795] xor: using function: 8regs (908 MB/sec) [ 1.468362] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 250) [ 1.468622] io scheduler mq-deadline registered [ 1.468743] io scheduler kyber registered [ 1.477096] pci-host-generic 30000000.pci: host bridge /soc/pci@30000000 ranges: [ 1.478524] pci-host-generic 30000000.pci: IO 0x0003000000..0x000300ffff -> 0x0000000000 [ 1.479314] pci-host-generic 30000000.pci: MEM 0x0040000000..0x007fffffff -> 0x0040000000 [ 1.479438] pci-host-generic 30000000.pci: MEM 0x0300000000..0x03ffffffff -> 0x0300000000 [ 1.480684] pci-host-generic 30000000.pci: ECAM at [mem 0x30000000-0x3fffffff] for [bus 00-ff] [ 1.483320] pci-host-generic 30000000.pci: PCI host bridge to bus 0000:00 [ 1.483605] pci_bus 0000:00: root bus resource [bus 00-ff] [ 1.483732] pci_bus 0000:00: root bus resource [io 0x0000-0xffff] [ 1.483819] pci_bus 0000:00: root bus resource [mem 0x40000000-0x7fffffff] [ 1.485712] pci 0000:00:00.0: [1b36:0008] type 00 class 0x060000 [ 1.491063] pci 0000:00:01.0: [1af4:1005] type 00 class 0x00ff00 [ 1.491439] pci 0000:00:01.0: reg 0x10: [io 0x0000-0x001f] [ 1.491535] pci 0000:00:01.0: reg 0x14: [mem 0x00000000-0x00000fff] [ 1.491665] pci 0000:00:01.0: reg 0x20: [mem 0x00000000-0x00003fff 64bit pref] [ 1.492287] pci 0000:00:02.0: [1af4:1052] type 00 class 0x098000 [ 1.492352] pci 0000:00:02.0: reg 0x14: [mem 0x00000000-0x00000fff] [ 1.492405] pci 0000:00:02.0: reg 0x20: [mem 0x00000000-0x00003fff 64bit pref] [ 1.492858] pci 0000:00:03.0: [1af4:1052] type 00 class 0x090000 [ 1.492919] pci 0000:00:03.0: reg 0x14: [mem 0x00000000-0x00000fff] [ 1.492971] pci 0000:00:03.0: reg 0x20: [mem 0x00000000-0x00003fff 64bit pref] [ 1.493676] pci 0000:00:04.0: [1234:1111] type 00 class 0x038000 [ 1.493733] pci 0000:00:04.0: reg 0x10: [mem 0x00000000-0x00ffffff pref] [ 1.493777] pci 0000:00:04.0: reg 0x18: [mem 0x00000000-0x00000fff] [ 1.493825] pci 0000:00:04.0: reg 0x30: [mem 0x00000000-0x00007fff pref] [ 1.497436] pci 0000:00:04.0: BAR 0: assigned [mem 0x40000000-0x40ffffff pref] [ 1.497763] pci 0000:00:04.0: BAR 6: assigned [mem 0x41000000-0x41007fff pref] [ 1.497893] pci 0000:00:01.0: BAR 4: assigned [mem 0x41008000-0x4100bfff 64bit pref] [ 1.498023] pci 0000:00:02.0: BAR 4: assigned [mem 0x4100c000-0x4100ffff 64bit pref] [ 1.498072] pci 0000:00:03.0: BAR 4: assigned [mem 0x41010000-0x41013fff 64bit pref] [ 1.498114] pci 0000:00:01.0: BAR 1: assigned [mem 0x41014000-0x41014fff] [ 1.498290] pci 0000:00:02.0: BAR 1: assigned [mem 0x41015000-0x41015fff] [ 1.498329] pci 0000:00:03.0: BAR 1: assigned [mem 0x41016000-0x41016fff] [ 1.498360] pci 0000:00:04.0: BAR 2: assigned [mem 0x41017000-0x41017fff] [ 1.498417] pci 0000:00:01.0: BAR 0: assigned [io 0x0020-0x003f] [ 1.507996] virtio-pci 0000:00:01.0: enabling device (0000 -> 0003) [ 1.512145] virtio-pci 0000:00:02.0: enabling device (0000 -> 0002) [ 1.513650] virtio-pci 0000:00:03.0: enabling device (0000 -> 0002) [ 1.516801] Serial: 8250/16550 driver, 4 ports, IRQ sharing disabled [ 1.533854] printk: console [ttyS0] disabled [ 1.539564] 10000000.serial: ttyS0 at MMIO 0x10000000 (irq = 15, base_baud = 230400) is a 16550A [ 1.542274] printk: console [ttyS0] enabled [ 1.651519] printk: console [hvc0] enabled [ 1.651788] bochs-drm 0000:00:04.0: enabling device (0000 -> 0002) [ 1.671382] [drm] Found bochs VGA, ID 0xb0c5. [ 1.671920] [drm] Framebuffer size 16384 kB @ 0x40000000, mmio @ 0x41017000. [ 1.679167] [drm] Found EDID data blob. [ 1.691895] [drm] Initialized bochs-drm 1.0.0 20130925 for 0000:00:04.0 on minor 0 [ 1.772957] Console: switching to colour frame buffer device 160x50 [ 1.783406] bochs-drm 0000:00:04.0: [drm] fb0: bochs-drmdrmfb frame buffer device [ 1.832199] brd: module loaded [ 1.833690] virtio_blk virtio1: 1/0/0 default/read/poll queues [ 1.849483] virtio_blk virtio1: [vda] 1071942 512-byte logical blocks (549 MB/523 MiB) [ 1.887400] goldfish_rtc 101000.rtc: registered as rtc0 [ 1.889283] goldfish_rtc 101000.rtc: setting system clock to 2024-02-17T16:25:29 UTC (1708187129) [ 1.894312] device-mapper: ioctl: 4.48.0-ioctl (2023-03-01) initialised: dm-devel@redhat.com [ 1.899857] riscv-pmu-sbi: SBI PMU extension is available [ 1.901396] riscv-pmu-sbi: 16 firmware and 18 hardware counters [ 1.902470] riscv-pmu-sbi: Perf sampling/filtering is not supported as sscof extension is not available [ 1.906605] u32 classifier [ 1.907067] input device check on [ 1.907558] Actions configured [ 1.909853] NET: Registered PF_INET6 protocol family [ 1.922586] Segment Routing with IPv6 [ 1.923412] In-situ OAM (IOAM) with IPv6 [ 1.925029] sit: IPv6, IPv4 and MPLS over IPv4 tunneling driver [ 1.930911] NET: Registered PF_PACKET protocol family [ 1.932463] Bridge firewalling registered [ 1.934676] Key type dns_resolver registered [ 1.936331] NET: Registered PF_VSOCK protocol family [ 1.958970] registered taskstats version 1 [ 1.981104] Key type .fscrypt registered [ 1.981749] Key type fscrypt-provisioning registered [ 1.991747] Btrfs loaded, zoned=no, fsverity=no [ 2.019587] Key type encrypted registered [ 2.022825] printk: console [netcon0] enabled [ 2.023478] netconsole: network logging started [ 2.074918] IP-Config: Complete: [ 2.075515] device=eth0, hwaddr=52:54:00:12:34:02, ipaddr=192.168.7.2, mask=255.255.255.0, gw=192.168.7.1 [ 2.076693] host=192.168.7.2, domain=, nis-domain=(none) [ 2.077392] bootserver=255.255.255.255, rootserver=255.255.255.255, rootpath= [ 2.077469] nameserver0=8.8.8.8 [ 2.084479] clk: Disabling unused clocks [ 2.090912] md: Waiting for all devices to be available before autodetect [ 2.091755] md: If you don't use raid, use raid=noautodetect [ 2.092497] md: Autodetecting RAID arrays. [ 2.093032] md: autorun ... [ 2.093450] md: ... autorun DONE. [ 2.153316] EXT4-fs (vda): mounted filesystem d77a91b3-a8ae-43ee-9d3d-17d9755bcb56 r/w with ordered data mode. Quota mode: disabled. [ 2.158770] VFS: Mounted root (ext4 filesystem) on device 253:0. [ 2.163062] devtmpfs: mounted [ 2.338341] Freeing unused kernel image (initmem) memory: 4216K [ 2.342061] Run /sbin/init as init process INIT: version 3.04 booting warning: FBIOPUT_VSCREENINFO failed, double buffering disabled Starting udev [ 4.936240] udevd[135]: starting version 3.2.14 [ 5.063159] udevd[136]: starting eudev-3.2.14 [ 5.468425] input: QEMU Virtio Tablet as /devices/platform/soc/30000000.pci/pci0000:00/0000:00:02.0/virtio4/input/input0 [ 5.476448] input: QEMU Virtio Keyboard as /devices/platform/soc/30000000.pci/pci0000:00/0000:00:03.0/virtio5/input/input1 [ 7.939886] EXT4-fs (vda): re-mounted d77a91b3-a8ae-43ee-9d3d-17d9755bcb56 r/w. Quota mode: disabled. hwclock: settimeofday: Function not implemented ALSA: Restoring mixer settings... hwclock: settimeofday: Function not implemented INIT: Entering runlevel: 5 Configuring network interfaces... ip: RTNETLINK answers: File exists Starting system message bus: dbus. Starting Connection Manager Starting Xserver Starting Dropbear SSH server: dropbear. X.Org X Server 1.21.1.11 X Protocol Version 11, Revision 0 Current Operating System: Linux qemuriscv32 6.6.16-yocto-standard #1 SMP PREEMPT Wed Feb 14 15:32:08 UTC 2024 riscv32 Kernel command line: root=/dev/vda rw mem=512M ip=192.168.7.2::192.168.7.1:255.255.255.0::eth0:off:8.8.8.8 net.ifnames=0 console=ttyS0 console=hvc0 earlycon=sbi swiotlb=0 printk.time=1 Current version of pixman: 0.42.2 Before reporting problems, check http://wiki.x.org to make sure that you have the latest version. Markers: (--) probed, (**) from config file, (==) default setting, (++) from command line, (!!) notice, (II) informational, (WW) warning, (EE) error, (NI) not implemented, (??) unknown. (==) Log file: "/var/log/Xorg.0.log", Time: Sat Feb 17 16:25:42 2024 (==) Using system config directory "/usr/share/X11/xorg.conf.d" Starting rpcbind daemon...pci id for fd 10: 1234:1111, driver (null) done. MESA-LOADER: failed to open bochs-drm: /usr/lib/dri/bochs-drm_dri.so: cannot open shared object file: No such file or directory (search paths /usr/lib/dri, suffix _dri) Starting bluetooth: bluetoothd. Starting syslogd/klogd: done * Starting Avahi mDNS/DNS-SD Daemon: avahi-daemon ...done. Starting Telephony daemon Poky (Yocto Project Reference Distro) 4.3+snapshot-056dddfe5bf03c7987e03c55bae087511d2b12bb qemuriscv32 /dev/hvc0 qemuriscv32 login: The XKEYBOARD keymap compiler (xkbcomp) reports: > Warning: Could not resolve keysym XF86CameraAccessEnable > Warning: Could not resolve keysym XF86CameraAccessDisable > Warning: Could not resolve keysym XF86CameraAccessToggle > Warning: Could not resolve keysym XF86NextElement > Warning: Could not resolve keysym XF86PreviousElement > Warning: Could not resolve keysym XF86AutopilotEngageToggle > Warning: Could not resolve keysym XF86MarkWaypoint > Warning: Could not resolve keysym XF86Sos > Warning: Could not resolve keysym XF86NavChart > Warning: Could not resolve keysym XF86FishingChart > Warning: Could not resolve keysym XF86SingleRangeRadar > Warning: Could not resolve keysym XF86DualRangeRadar > Warning: Could not resolve keysym XF86RadarOverlay > Warning: Could not resolve keysym XF86TraditionalSonar > Warning: Could not resolve keysym XF86ClearvuSonar > Warning: Could not resolve keysym XF86SidevuSonar > Warning: Could not resolve keysym XF86NavInfo Errors from xkbcomp are not fatal to the X server [ 37.970474] rcu: INFO: rcu_preempt detected stalls on CPUs/tasks: [ 38.003140] rcu: 2-...0: (1 GPs behind) idle=f78c/1/0x40000000 softirq=2277/2279 fqs=2146 [ 38.004113] rcu: (detected by 0, t=5252 jiffies, g=3489, q=1947 ncpus=4) [ 38.004877] Task dump for CPU 2: [ 38.005367] task:init state:R running task stack:0 pid:509 ppid:1 flags:0x00000008 [ 38.006932] Call Trace: [ 38.007494] [] __schedule+0x2fc/0x988 [ 100.990241] rcu: INFO: rcu_preempt detected stalls on CPUs/tasks: [ 101.002042] rcu: 2-...0: (1 GPs behind) idle=f78c/1/0x40000000 softirq=2277/2279 fqs=8729 [ 101.003092] rcu: (detected by 0, t=21007 jiffies, g=3489, q=1959 ncpus=4) [ 101.003896] Task dump for CPU 2: [ 101.009996] task:init state:R running task stack:0 pid:509 ppid:1 flags:0x00000008 [ 101.011262] Call Trace: [ 101.011622] [] __schedule+0x2fc/0x988 [ 164.050243] rcu: INFO: rcu_preempt detected stalls on CPUs/tasks: [ 164.108025] rcu: 2-...0: (1 GPs behind) idle=f78c/1/0x40000000 softirq=2277/2279 fqs=15167 [ 164.109654] rcu: (detected by 0, t=36772 jiffies, g=3489, q=1960 ncpus=4) [ 164.111262] Task dump for CPU 2: [ 164.112309] task:init state:R running task stack:0 pid:509 ppid:1 flags:0x00000008 [ 164.126475] Call Trace: [ 164.129997] [] __schedule+0x2fc/0x988 [ 227.154262] rcu: INFO: rcu_preempt detected stalls on CPUs/tasks: [ 227.186305] rcu: 2-...0: (1 GPs behind) idle=f78c/1/0x40000000 softirq=2277/2279 fqs=21692 [ 227.187174] rcu: (detected by 0, t=52548 jiffies, g=3489, q=1961 ncpus=4) [ 227.187983] Task dump for CPU 2: [ 227.188445] task:init state:R running task stack:0 pid:509 ppid:1 flags:0x00000008 [ 227.189452] Call Trace: [ 227.189806] [] __schedule+0x2fc/0x988 [ 290.225630] rcu: INFO: rcu_preempt detected stalls on CPUs/tasks: [ 290.234575] rcu: 2-...0: (1 GPs behind) idle=f78c/1/0x40000000 softirq=2277/2279 fqs=28344 [ 290.235575] rcu: (detected by 0, t=68315 jiffies, g=3489, q=1961 ncpus=4) [ 290.236407] Task dump for CPU 2: [ 290.236871] task:init state:R running task stack:0 pid:509 ppid:1 flags:0x00000008 [ 290.237974] Call Trace: [ 290.238569] [] __schedule+0x2fc/0x988 [ 353.270231] rcu: INFO: rcu_preempt detected stalls on CPUs/tasks: [ 353.314826] rcu: 2-...0: (1 GPs behind) idle=f78c/1/0x40000000 softirq=2277/2279 fqs=34851 [ 353.316253] rcu: (detected by 0, t=84077 jiffies, g=3489, q=1998 ncpus=4) [ 353.322245] Task dump for CPU 2: [ 353.323187] task:init state:R running task stack:0 pid:509 ppid:1 flags:0x00000008 [ 353.324976] Call Trace: [ 353.329616] [] __schedule+0x2fc/0x988 [ 416.338203] rcu: INFO: rcu_preempt detected stalls on CPUs/tasks: [ 416.339066] rcu: 2-...0: (1 GPs behind) idle=f78c/1/0x40000000 softirq=2277/2279 fqs=41415 [ 416.340070] rcu: (detected by 0, t=99844 jiffies, g=3489, q=1998 ncpus=4) [ 416.340897] Task dump for CPU 2: [ 416.341355] task:init state:R running task stack:0 pid:509 ppid:1 flags:0x00000008 [ 416.342598] Call Trace: [ 416.342975] [] __schedule+0x2fc/0x988 [ 479.358275] rcu: INFO: rcu_preempt detected stalls on CPUs/tasks: [ 479.359237] rcu: 2-...0: (1 GPs behind) idle=f78c/1/0x40000000 softirq=2277/2279 fqs=47886 [ 479.360359] rcu: (detected by 3, t=115599 jiffies, g=3489, q=1999 ncpus=4) [ 479.361266] Task dump for CPU 2: [ 479.361773] task:init state:R running task stack:0 pid:509 ppid:1 flags:0x00000008 [ 479.363188] Call Trace: [ 479.363619] [] __schedule+0x2fc/0x988 [ 542.382275] rcu: INFO: rcu_preempt detected stalls on CPUs/tasks: [ 542.383222] rcu: 2-...0: (1 GPs behind) idle=f78c/1/0x40000000 softirq=2277/2279 fqs=54246 [ 542.384318] rcu: (detected by 3, t=131355 jiffies, g=3489, q=1999 ncpus=4) [ 542.385113] Task dump for CPU 2: [ 542.385625] task:init state:R running task stack:0 pid:509 ppid:1 flags:0x00000008 [ 542.387009] Call Trace: [ 542.387423] [] __schedule+0x2fc/0x988 [ 605.406267] rcu: INFO: rcu_preempt detected stalls on CPUs/tasks: [ 605.407220] rcu: 2-...0: (1 GPs behind) idle=f78c/1/0x40000000 softirq=2277/2279 fqs=60566 [ 605.408346] rcu: (detected by 1, t=147111 jiffies, g=3489, q=1999 ncpus=4) [ 605.409363] Task dump for CPU 2: [ 605.409951] task:init state:R running task stack:0 pid:509 ppid:1 flags:0x00000008 [ 605.411421] Call Trace: [ 605.411894] [] __schedule+0x2fc/0x988 [ 668.430197] rcu: INFO: rcu_preempt detected stalls on CPUs/tasks: [ 668.478791] rcu: 2-...0: (1 GPs behind) idle=f78c/1/0x40000000 softirq=2277/2279 fqs=66884 [ 668.479812] rcu: (detected by 0, t=162867 jiffies, g=3489, q=2021 ncpus=4) [ 668.482949] Task dump for CPU 2: [ 668.483397] task:init state:R running task stack:0 pid:509 ppid:1 flags:0x00000008 [ 668.484640] Call Trace: [ 668.501753] [] __schedule+0x2fc/0x988 [ 731.506219] rcu: INFO: rcu_preempt detected stalls on CPUs/tasks: [ 731.518289] rcu: 2-...0: (1 GPs behind) idle=f78c/1/0x40000000 softirq=2277/2279 fqs=73652 [ 731.519092] rcu: (detected by 0, t=178636 jiffies, g=3489, q=2021 ncpus=4) [ 731.519881] Task dump for CPU 2: [ 731.522802] task:init state:R running task stack:0 pid:509 ppid:1 flags:0x00000008 [ 731.523739] Call Trace: [ 731.524077] [] __schedule+0x2fc/0x988 [ 794.554249] rcu: INFO: rcu_preempt detected stalls on CPUs/tasks: [ 794.587343] rcu: 2-...0: (1 GPs behind) idle=f78c/1/0x40000000 softirq=2277/2279 fqs=80338 [ 794.589284] rcu: (detected by 0, t=194406 jiffies, g=3489, q=2021 ncpus=4) [ 794.590720] Task dump for CPU 2: [ 794.591726] task:init state:R running task stack:0 pid:509 ppid:1 flags:0x00000008 [ 794.595754] Call Trace: [ 794.596666] [] __schedule+0x2fc/0x988 [ 857.606222] rcu: INFO: rcu_preempt detected stalls on CPUs/tasks: [ 857.646517] rcu: 2-...0: (1 GPs behind) idle=f78c/1/0x40000000 softirq=2277/2279 fqs=87028 [ 857.647310] rcu: (detected by 0, t=210161 jiffies, g=3489, q=2021 ncpus=4) [ 857.648182] Task dump for CPU 2: [ 857.648608] task:init state:R running task stack:0 pid:509 ppid:1 flags:0x00000008 [ 857.649827] Call Trace: [ 857.650397] [] __schedule+0x2fc/0x988 [ 920.682301] rcu: INFO: rcu_preempt detected stalls on CPUs/tasks: [ 920.694442] rcu: 2-...0: (1 GPs behind) idle=f78c/1/0x40000000 softirq=2277/2279 fqs=93661 [ 920.695217] rcu: (detected by 0, t=225930 jiffies, g=3489, q=2022 ncpus=4) [ 920.698964] Task dump for CPU 2: [ 920.699434] task:init state:R running task stack:0 pid:509 ppid:1 flags:0x00000008 [ 920.700340] Call Trace: [ 920.700596] [] __schedule+0x2fc/0x988 [ 983.702267] rcu: INFO: rcu_preempt detected stalls on CPUs/tasks: [ 983.714593] rcu: 2-...0: (1 GPs behind) idle=f78c/1/0x40000000 softirq=2277/2279 fqs=100354 [ 983.715419] rcu: (detected by 0, t=241685 jiffies, g=3489, q=2044 ncpus=4) [ 983.718993] Task dump for CPU 2: [ 983.719411] task:init state:R running task stack:0 pid:509 ppid:1 flags:0x00000008 [ 983.720318] Call Trace: [ 983.749906] [] __schedule+0x2fc/0x988 [ 1046.774338] rcu: INFO: rcu_preempt detected stalls on CPUs/tasks: [ 1046.784823] rcu: 2-...0: (1 GPs behind) idle=f78c/1/0x40000000 softirq=2277/2279 fqs=107058 [ 1046.786704] rcu: (detected by 0, t=257453 jiffies, g=3489, q=2044 ncpus=4) [ 1046.799584] Task dump for CPU 2: [ 1046.810851] task:init state:R running task stack:0 pid:509 ppid:1 flags:0x00000008 [ 1046.812074] Call Trace: [ 1046.812444] [] __schedule+0x2fc/0x988 [ 1109.842515] rcu: INFO: rcu_preempt detected stalls on CPUs/tasks: [ 1109.867293] rcu: 2-...0: (1 GPs behind) idle=f78c/1/0x40000000 softirq=2277/2279 fqs=113779 [ 1109.873299] rcu: (detected by 0, t=273226 jiffies, g=3489, q=2044 ncpus=4) [ 1109.877068] Task dump for CPU 2: [ 1109.880139] task:init state:R running task stack:0 pid:509 ppid:1 flags:0x00000008 [ 1109.885211] Call Trace: [ 1109.902440] [] __schedule+0x2fc/0x988 [ 1172.906506] rcu: INFO: rcu_preempt detected stalls on CPUs/tasks: [ 1172.950421] rcu: 2-...0: (1 GPs behind) idle=f78c/1/0x40000000 softirq=2277/2279 fqs=120541 [ 1172.951277] rcu: (detected by 0, t=288986 jiffies, g=3489, q=2044 ncpus=4) [ 1172.952079] Task dump for CPU 2: [ 1172.952541] task:init state:R running task stack:0 pid:509 ppid:1 flags:0x00000008 [ 1172.953455] Call Trace: [ 1172.974570] [] __schedule+0x2fc/0x988 [ 1235.978242] rcu: INFO: rcu_preempt detected stalls on CPUs/tasks: [ 1235.988716] rcu: 2-...0: (1 GPs behind) idle=f78c/1/0x40000000 softirq=2277/2279 fqs=127270 [ 1235.989738] rcu: (detected by 0, t=304754 jiffies, g=3489, q=2044 ncpus=4) [ 1235.990727] Task dump for CPU 2: [ 1236.001001] task:init state:R running task stack:0 pid:509 ppid:1 flags:0x00000008 [ 1236.015788] Call Trace: [ 1236.024400] [] __schedule+0x2fc/0x988 [ 1299.062335] rcu: INFO: rcu_preempt detected stalls on CPUs/tasks: [ 1299.072547] rcu: 2-...0: (1 GPs behind) idle=f78c/1/0x40000000 softirq=2277/2279 fqs=134037 [ 1299.076458] rcu: (detected by 0, t=320525 jiffies, g=3489, q=2044 ncpus=4) [ 1299.077388] Task dump for CPU 2: [ 1299.077905] task:init state:R running task stack:0 pid:509 ppid:1 flags:0x00000008 [ 1299.082850] Call Trace: [ 1299.083276] [] __schedule+0x2fc/0x988 [ 1362.106376] rcu: INFO: rcu_preempt detected stalls on CPUs/tasks: [ 1362.122710] rcu: 2-...0: (1 GPs behind) idle=f78c/1/0x40000000 softirq=2277/2279 fqs=140682 [ 1362.123610] rcu: (detected by 0, t=336286 jiffies, g=3489, q=2044 ncpus=4) [ 1362.126418] Task dump for CPU 2: [ 1362.126929] task:init state:R running task stack:0 pid:509 ppid:1 flags:0x00000008 [ 1362.128120] Call Trace: [ 1362.141270] [] __schedule+0x2fc/0x988 [ 1425.150202] rcu: INFO: rcu_preempt detected stalls on CPUs/tasks: [ 1425.153070] rcu: 2-...0: (1 GPs behind) idle=f78c/1/0x40000000 softirq=2277/2279 fqs=147457 [ 1425.153904] rcu: (detected by 0, t=352047 jiffies, g=3489, q=2044 ncpus=4) [ 1425.154665] Task dump for CPU 2: [ 1425.155105] task:init state:R running task stack:0 pid:509 ppid:1 flags:0x00000008 [ 1425.156429] Call Trace: [ 1425.156798] [] __schedule+0x2fc/0x988 [ 1488.170309] rcu: INFO: rcu_preempt detected stalls on CPUs/tasks: [ 1488.186569] rcu: 2-...0: (1 GPs behind) idle=f78c/1/0x40000000 softirq=2277/2279 fqs=154083 [ 1488.205799] rcu: (detected by 0, t=367808 jiffies, g=3489, q=2044 ncpus=4) [ 1488.210837] Task dump for CPU 2: [ 1488.211392] task:init state:R running task stack:0 pid:509 ppid:1 flags:0x00000008 [ 1488.213006] Call Trace: [ 1488.213498] [] __schedule+0x2fc/0x988 [ 1551.214251] rcu: INFO: rcu_preempt detected stalls on CPUs/tasks: [ 1551.258366] rcu: 2-...0: (1 GPs behind) idle=f78c/1/0x40000000 softirq=2277/2279 fqs=160842 [ 1551.259175] rcu: (detected by 0, t=383563 jiffies, g=3489, q=2044 ncpus=4) [ 1551.259977] Task dump for CPU 2: [ 1551.260368] task:init state:R running task stack:0 pid:509 ppid:1 flags:0x00000008 [ 1551.261582] Call Trace: [ 1551.261926] [] __schedule+0x2fc/0x988 [ 1614.294262] rcu: INFO: rcu_preempt detected stalls on CPUs/tasks: [ 1614.310486] rcu: 2-...0: (1 GPs behind) idle=f78c/1/0x40000000 softirq=2277/2279 fqs=167548 [ 1614.311379] rcu: (detected by 0, t=399333 jiffies, g=3489, q=2044 ncpus=4) [ 1614.312244] Task dump for CPU 2: [ 1614.312715] task:init state:R running task stack:0 pid:509 ppid:1 flags:0x00000008 [ 1614.330347] Call Trace: [ 1614.334635] [] __schedule+0x2fc/0x988 [ 1677.362224] rcu: INFO: rcu_preempt detected stalls on CPUs/tasks: [ 1677.363174] rcu: 2-...0: (1 GPs behind) idle=f78c/1/0x40000000 softirq=2277/2279 fqs=174227 [ 1677.364326] rcu: (detected by 0, t=415100 jiffies, g=3489, q=2044 ncpus=4) [ 1677.365188] Task dump for CPU 2: [ 1677.365750] task:init state:R running task stack:0 pid:509 ppid:1 flags:0x00000008 [ 1677.367129] Call Trace: [ 1677.367542] [] __schedule+0x2fc/0x988 [ 1740.382351] rcu: INFO: rcu_preempt detected stalls on CPUs/tasks: [ 1740.397236] rcu: 2-...0: (1 GPs behind) idle=f78c/1/0x40000000 softirq=2277/2279 fqs=180716 [ 1740.399268] rcu: (detected by 0, t=430855 jiffies, g=3489, q=2045 ncpus=4) [ 1740.400958] Task dump for CPU 2: [ 1740.405200] task:init state:R running task stack:0 pid:509 ppid:1 flags:0x00000008 [ 1740.422618] Call Trace: [ 1740.423429] [] __schedule+0x2fc/0x988 [ 1803.426273] rcu: INFO: rcu_preempt detected stalls on CPUs/tasks: [ 1803.427125] rcu: 2-...0: (1 GPs behind) idle=f78c/1/0x40000000 softirq=2277/2279 fqs=187313 [ 1803.428232] rcu: (detected by 0, t=446616 jiffies, g=3489, q=2045 ncpus=4) [ 1803.429091] Task dump for CPU 2: [ 1803.429580] task:init state:R running task stack:0 pid:509 ppid:1 flags:0x00000008 [ 1803.430845] Call Trace: [ 1803.431258] [] __schedule+0x2fc/0x988 [ 1866.446290] rcu: INFO: rcu_preempt detected stalls on CPUs/tasks: [ 1866.447243] rcu: 2-...0: (1 GPs behind) idle=f78c/1/0x40000000 softirq=2277/2279 fqs=193821 [ 1866.448447] rcu: (detected by 3, t=462371 jiffies, g=3489, q=2045 ncpus=4) [ 1866.449363] Task dump for CPU 2: [ 1866.449856] task:init state:R running task stack:0 pid:509 ppid:1 flags:0x00000008 [ 1866.451239] Call Trace: [ 1866.451615] [] __schedule+0x2fc/0x988 [ 1929.470252] rcu: INFO: rcu_preempt detected stalls on CPUs/tasks: [ 1929.471189] rcu: 2-...0: (1 GPs behind) idle=f78c/1/0x40000000 softirq=2277/2279 fqs=200268 [ 1929.472483] rcu: (detected by 3, t=478127 jiffies, g=3489, q=2045 ncpus=4) [ 1929.473540] Task dump for CPU 2: [ 1929.474064] task:init state:R running task stack:0 pid:509 ppid:1 flags:0x00000008 [ 1929.475477] Call Trace: [ 1929.475918] [] __schedule+0x2fc/0x988 [ 1992.494263] rcu: INFO: rcu_preempt detected stalls on CPUs/tasks: [ 1992.495185] rcu: 2-...0: (1 GPs behind) idle=f78c/1/0x40000000 softirq=2277/2279 fqs=206590 [ 1992.496317] rcu: (detected by 1, t=493883 jiffies, g=3489, q=2045 ncpus=4) [ 1992.497194] Task dump for CPU 2: [ 1992.497706] task:init state:R running task stack:0 pid:509 ppid:1 flags:0x00000008 [ 1992.499042] Call Trace: [ 1992.499473] [] __schedule+0x2fc/0x988 [ 2055.518229] rcu: INFO: rcu_preempt detected stalls on CPUs/tasks: [ 2055.519098] rcu: 2-...0: (1 GPs behind) idle=f78c/1/0x40000000 softirq=2277/2279 fqs=212982 [ 2055.520161] rcu: (detected by 0, t=509639 jiffies, g=3489, q=2045 ncpus=4) [ 2055.521060] Task dump for CPU 2: [ 2055.521541] task:init state:R running task stack:0 pid:509 ppid:1 flags:0x00000008 [ 2055.522893] Call Trace: [ 2055.523283] [] __schedule+0x2fc/0x988 [ 2118.538239] rcu: INFO: rcu_preempt detected stalls on CPUs/tasks: [ 2118.539093] rcu: 2-...0: (1 GPs behind) idle=f78c/1/0x40000000 softirq=2277/2279 fqs=219345 [ 2118.540133] rcu: (detected by 0, t=525394 jiffies, g=3489, q=2045 ncpus=4) [ 2118.540960] Task dump for CPU 2: [ 2118.541404] task:init state:R running task stack:0 pid:509 ppid:1 flags:0x00000008 [ 2118.542656] Call Trace: [ 2118.543053] [] __schedule+0x2fc/0x988 [ 2181.558224] rcu: INFO: rcu_preempt detected stalls on CPUs/tasks: [ 2181.559114] rcu: 2-...0: (1 GPs behind) idle=f78c/1/0x40000000 softirq=2277/2279 fqs=225678 [ 2181.560246] rcu: (detected by 0, t=541149 jiffies, g=3489, q=2045 ncpus=4) [ 2181.561085] Task dump for CPU 2: [ 2181.561600] task:init state:R running task stack:0 pid:509 ppid:1 flags:0x00000008 [ 2181.563021] Call Trace: [ 2181.563409] [] __schedule+0x2fc/0x988 [ 2244.578260] rcu: INFO: rcu_preempt detected stalls on CPUs/tasks: [ 2244.579468] rcu: 2-...0: (1 GPs behind) idle=f78c/1/0x40000000 softirq=2277/2279 fqs=232112 [ 2244.580983] rcu: (detected by 3, t=556904 jiffies, g=3489, q=2045 ncpus=4) [ 2244.582008] Task dump for CPU 2: [ 2244.582662] task:init state:R running task stack:0 pid:509 ppid:1 flags:0x00000008 [ 2244.584031] Call Trace: [ 2244.584432] [] __schedule+0x2fc/0x988 [ 2307.602237] rcu: INFO: rcu_preempt detected stalls on CPUs/tasks: [ 2307.603164] rcu: 2-...0: (1 GPs behind) idle=f78c/1/0x40000000 softirq=2277/2279 fqs=238502 [ 2307.604260] rcu: (detected by 3, t=572660 jiffies, g=3489, q=2045 ncpus=4) [ 2307.605144] Task dump for CPU 2: [ 2307.605649] task:init state:R running task stack:0 pid:509 ppid:1 flags:0x00000008 [ 2307.606959] Call Trace: [ 2307.607364] [] __schedule+0x2fc/0x988 [ 2370.626278] rcu: INFO: rcu_preempt detected stalls on CPUs/tasks: [ 2370.627176] rcu: 2-...0: (1 GPs behind) idle=f78c/1/0x40000000 softirq=2277/2279 fqs=245057 [ 2370.628325] rcu: (detected by 1, t=588416 jiffies, g=3489, q=2045 ncpus=4) [ 2370.629218] Task dump for CPU 2: [ 2370.629692] task:init state:R running task stack:0 pid:509 ppid:1 flags:0x00000008 [ 2370.631002] Call Trace: [ 2370.631389] [] __schedule+0x2fc/0x988 [ 2433.650261] rcu: INFO: rcu_preempt detected stalls on CPUs/tasks: [ 2433.651101] rcu: 2-...0: (1 GPs behind) idle=f78c/1/0x40000000 softirq=2277/2279 fqs=251541 [ 2433.652180] rcu: (detected by 0, t=604172 jiffies, g=3489, q=2045 ncpus=4) [ 2433.653077] Task dump for CPU 2: [ 2433.653552] task:init state:R running task stack:0 pid:509 ppid:1 flags:0x00000008 [ 2433.654834] Call Trace: [ 2433.655233] [] __schedule+0x2fc/0x988 [ 2496.670260] rcu: INFO: rcu_preempt detected stalls on CPUs/tasks: [ 2496.671171] rcu: 2-...0: (1 GPs behind) idle=f78c/1/0x40000000 softirq=2277/2279 fqs=257850 [ 2496.672304] rcu: (detected by 3, t=619927 jiffies, g=3489, q=2067 ncpus=4) [ 2496.673206] Task dump for CPU 2: [ 2496.673684] task:init state:R running task stack:0 pid:509 ppid:1 flags:0x00000008 [ 2496.674999] Call Trace: [ 2496.675390] [] __schedule+0x2fc/0x988 [ 2559.694324] rcu: INFO: rcu_preempt detected stalls on CPUs/tasks: [ 2559.695324] rcu: 2-...0: (1 GPs behind) idle=f78c/1/0x40000000 softirq=2277/2279 fqs=264154 [ 2559.696568] rcu: (detected by 0, t=635683 jiffies, g=3489, q=2067 ncpus=4) [ 2559.697460] Task dump for CPU 2: [ 2559.697985] task:init state:R running task stack:0 pid:509 ppid:1 flags:0x00000008 [ 2559.699359] Call Trace: [ 2559.699748] [] __schedule+0x2fc/0x988 [ 2622.714283] rcu: INFO: rcu_preempt detected stalls on CPUs/tasks: [ 2622.719123] rcu: 2-...0: (1 GPs behind) idle=f78c/1/0x40000000 softirq=2277/2279 fqs=270679 [ 2622.726857] rcu: (detected by 0, t=651438 jiffies, g=3489, q=2067 ncpus=4) [ 2622.766972] Task dump for CPU 2: [ 2622.774722] task:init state:R running task stack:0 pid:509 ppid:1 flags:0x00000008 [ 2622.776842] Call Trace: [ 2622.778277] [] __schedule+0x2fc/0x988 [ 2685.802287] rcu: INFO: rcu_preempt detected stalls on CPUs/tasks: [ 2685.803161] rcu: 2-...0: (1 GPs behind) idle=f78c/1/0x40000000 softirq=2277/2279 fqs=277015 [ 2685.804222] rcu: (detected by 0, t=667210 jiffies, g=3489, q=2067 ncpus=4) [ 2685.805053] Task dump for CPU 2: [ 2685.805505] task:init state:R running task stack:0 pid:509 ppid:1 flags:0x00000008 [ 2685.806812] Call Trace: [ 2685.807169] [] __schedule+0x2fc/0x988 [ 2748.822327] rcu: INFO: rcu_preempt detected stalls on CPUs/tasks: [ 2748.824372] rcu: 2-...0: (1 GPs behind) idle=f78c/1/0x40000000 softirq=2277/2279 fqs=283441 [ 2748.826156] rcu: (detected by 0, t=682965 jiffies, g=3489, q=2067 ncpus=4) [ 2748.827514] Task dump for CPU 2: [ 2748.828234] task:init state:R running task stack:0 pid:509 ppid:1 flags:0x00000008 [ 2748.829670] Call Trace: [ 2748.830024] [] __schedule+0x2fc/0x988