[ 0.000000] Booting Linux on physical CPU 0x0000000000 [0x411fd070] [ 0.000000] Linux version 5.10.0-rc3-next-20201110-00001-gc07b306d7fa5-dirty (elver@elver.muc.corp.google.com) (aarch64-linux-gnu-gcc (Linaro GCC 7.4-2019.02) 7.4.1 20181213 [linaro-7.4-2019.02 revision 56ec6f6b99cc167ff0c2f8e1a2eed33b1edc85d4], GNU ld (Linaro_Binutils-2019.02) 2.28.2.20170706) #18 SMP PREEMPT Wed Nov 11 12:13:12 CET 2020 [ 0.000000] Machine model: linux,dummy-virt [ 0.000000] efi: UEFI not found. [ 0.000000] cma: Reserved 32 MiB at 0x00000000be000000 [ 0.000000] earlycon: pl11 at MMIO 0x0000000009000000 (options '') [ 0.000000] printk: bootconsole [pl11] enabled [ 0.000000] NUMA: No NUMA configuration found [ 0.000000] NUMA: Faking a node at [mem 0x0000000040000000-0x00000000bfffffff] [ 0.000000] NUMA: NODE_DATA [mem 0xbdbf8000-0xbdbf9fff] [ 0.000000] Zone ranges: [ 0.000000] DMA [mem 0x0000000040000000-0x00000000bfffffff] [ 0.000000] DMA32 empty [ 0.000000] Normal empty [ 0.000000] Movable zone start for each node [ 0.000000] Early memory node ranges [ 0.000000] node 0: [mem 0x0000000040000000-0x00000000bfffffff] [ 0.000000] Initmem setup node 0 [mem 0x0000000040000000-0x00000000bfffffff] [ 0.000000] On node 0 totalpages: 524288 [ 0.000000] DMA zone: 8192 pages used for memmap [ 0.000000] DMA zone: 0 pages reserved [ 0.000000] DMA zone: 524288 pages, LIFO batch:63 [ 0.000000] psci: probing for conduit method from DT. [ 0.000000] psci: PSCIv0.2 detected in firmware. [ 0.000000] psci: Using standard PSCI v0.2 function IDs [ 0.000000] psci: Trusted OS migration not required [ 0.000000] percpu: Embedded 49 pages/cpu s161936 r8192 d30576 u200704 [ 0.000000] pcpu-alloc: s161936 r8192 d30576 u200704 alloc=49*4096 [ 0.000000] pcpu-alloc: [0] 0 [ 0.000000] Detected PIPT I-cache on CPU0 [ 0.000000] CPU features: detected: ARM erratum 832075 [ 0.000000] CPU features: detected: ARM erratum 834220 [ 0.000000] CPU features: detected: EL2 vector hardening [ 0.000000] CPU features: kernel page table isolation forced ON by KASLR [ 0.000000] CPU features: detected: Kernel page table isolation (KPTI) [ 0.000000] CPU features: detected: Spectre-v2 [ 0.000000] CPU features: detected: Spectre-v4 [ 0.000000] CPU features: detected: ARM errata 1165522, 1319367, or 1530923 [ 0.000000] Built 1 zonelists, mobility grouping on. Total pages: 516096 [ 0.000000] Policy zone: DMA [ 0.000000] Kernel command line: console=ttyAMA0 root=/dev/sda debug earlycon earlyprintk=serial slub_debug=UZ slub_debug=- kfence.sample_interval=0 [ 0.000000] Dentry cache hash table entries: 262144 (order: 9, 2097152 bytes, linear) [ 0.000000] Inode-cache hash table entries: 131072 (order: 8, 1048576 bytes, linear) [ 0.000000] mem auto-init: stack:off, heap alloc:off, heap free:off [ 0.000000] Memory: 1969304K/2097152K available (20544K kernel code, 4020K rwdata, 8504K rodata, 8832K init, 11817K bss, 95080K reserved, 32768K cma-reserved) [ 0.000000] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=1, Nodes=1 [ 0.000000] ftrace: allocating 56112 entries in 220 pages [ 0.000000] ftrace: allocated 220 pages with 5 groups [ 0.000000] Running RCU self tests [ 0.000000] rcu: Preemptible hierarchical RCU implementation. [ 0.000000] rcu: RCU event tracing is enabled. [ 0.000000] rcu: RCU lockdep checking is enabled. [ 0.000000] rcu: RCU restricting CPUs from NR_CPUS=256 to nr_cpu_ids=1. [ 0.000000] Trampoline variant of Tasks RCU enabled. [ 0.000000] Rude 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=1 [ 0.000000] NR_IRQS: 64, nr_irqs: 64, preallocated irqs: 0 [ 0.000000] GICv2m: range[mem 0x08020000-0x08020fff], SPI[80:143] [ 0.000000] random: get_random_bytes called from start_kernel+0x428/0x5e8 with crng_init=0 [ 0.000000] arch_timer: cp15 timer(s) running at 62.50MHz (virt). [ 0.000000] clocksource: arch_sys_counter: mask: 0xffffffffffffff max_cycles: 0x1cd42e208c, max_idle_ns: 881590405314 ns [ 0.000233] sched_clock: 56 bits at 62MHz, resolution 16ns, wraps every 4398046511096ns [ 0.011426] Console: colour dummy device 80x25 [ 0.012862] Lock dependency validator: Copyright (c) 2006 Red Hat, Inc., Ingo Molnar [ 0.013209] ... MAX_LOCKDEP_SUBCLASSES: 8 [ 0.013469] ... MAX_LOCK_DEPTH: 48 [ 0.013728] ... MAX_LOCKDEP_KEYS: 8192 [ 0.013992] ... CLASSHASH_SIZE: 4096 [ 0.014251] ... MAX_LOCKDEP_ENTRIES: 32768 [ 0.014511] ... MAX_LOCKDEP_CHAINS: 65536 [ 0.014770] ... CHAINHASH_SIZE: 32768 [ 0.015031] memory used by lock dependency info: 6365 kB [ 0.015306] memory used for stack traces: 4224 kB [ 0.015573] per task-struct memory footprint: 1920 bytes [ 0.018216] Calibrating delay loop (skipped), value calculated using timer frequency.. 125.00 BogoMIPS (lpj=250000) [ 0.018900] pid_max: default: 32768 minimum: 301 [ 0.022123] LSM: Security Framework initializing [ 0.024372] Mount-cache hash table entries: 4096 (order: 3, 32768 bytes, linear) [ 0.025621] Mountpoint-cache hash table entries: 4096 (order: 3, 32768 bytes, linear) [ 0.113947] rcu: Hierarchical SRCU implementation. [ 0.133436] EFI services will not be available. [ 0.137866] smp: Bringing up secondary CPUs ... [ 0.138333] smp: Brought up 1 node, 1 CPU [ 0.138982] SMP: Total of 1 processors activated. [ 0.139442] CPU features: detected: 32-bit EL0 Support [ 0.139873] CPU features: detected: CRC32 instructions [ 0.140211] CPU features: detected: 32-bit EL1 Support [ 0.533739] CPU: All CPU(s) started at EL1 [ 0.534735] alternatives: patching kernel code [ 0.597327] devtmpfs: initialized [ 0.671951] KASLR enabled [ 0.702419] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 7645041785100000 ns [ 0.703467] futex hash table entries: 256 (order: 3, 32768 bytes, linear) [ 0.705355] Running postponed tracer tests: [ 0.709250] Testing tracer function: PASSED [ 8.480905] Testing dynamic ftrace: PASSED [ 9.425085] Testing dynamic ftrace ops #1: [ 12.011706] (1 0 1 0 0) [ 12.012472] (1 1 2 0 0) [ 19.421411] (2 1 3 0 1101335) [ 19.423966] (2 2 4 0 1101760) PASSED [ 23.382135] Testing dynamic ftrace ops #2: [ 32.872265] (1 0 1 1082126 0) [ 32.873599] (1 1 2 1082338 0) [ 32.924413] (2 1 3 1 2103) [ 32.925559] (2 2 4 200 2302) PASSED [ 36.124900] Testing ftrace recursion: PASSED [ 36.859157] Testing ftrace recursion safe: PASSED [ 37.594606] Testing ftrace regs(no arch support): PASSED [ 38.333537] Testing tracer nop: PASSED [ 38.337880] Testing tracer irqsoff: PASSED [ 46.271584] Testing tracer preemptoff: PASSED [ 54.135978] Testing tracer preemptirqsoff: PASSED [ 62.043008] Testing tracer wakeup: [ 67.158358] sched: DL replenish lagged too much [ 69.851230] PASSED [ 69.859014] Testing tracer wakeup_rt: PASSED [ 77.691853] Testing tracer wakeup_dl: PASSED [ 85.583156] Testing tracer function_graph: PASSED [ 93.250201] pinctrl core: initialized pinctrl subsystem [ 93.297588] DMI not present or invalid. [ 93.317875] NET: Registered protocol family 16 [ 93.384841] DMA: preallocated 256 KiB GFP_KERNEL pool for atomic allocations [ 93.385798] DMA: preallocated 256 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations [ 93.388668] DMA: preallocated 256 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations [ 93.390895] audit: initializing netlink subsys (disabled) [ 93.402708] audit: type=2000 audit(81.888:1): state=initialized audit_enabled=0 res=1 [ 93.438512] thermal_sys: Registered thermal governor 'step_wise' [ 93.438744] thermal_sys: Registered thermal governor 'power_allocator' [ 93.442047] cpuidle: using governor menu [ 93.447969] hw-breakpoint: found 6 breakpoint and 4 watchpoint registers. [ 93.449661] ASID allocator initialised with 32768 entries [ 93.485107] Serial: AMBA PL011 UART driver [ 94.434483] 9000000.pl011: ttyAMA0 at MMIO 0x9000000 (irq = 47, base_baud = 0) is a PL011 rev1 [ 94.438214] printk: console [ttyAMA0] enabled [ 94.438214] printk: console [ttyAMA0] enabled [ 94.439358] printk: bootconsole [pl11] disabled [ 94.439358] printk: bootconsole [pl11] disabled [ 94.922239] HugeTLB registered 1.00 GiB page size, pre-allocated 0 pages [ 94.922762] HugeTLB registered 32.0 MiB page size, pre-allocated 0 pages [ 94.923519] HugeTLB registered 2.00 MiB page size, pre-allocated 0 pages [ 94.923960] HugeTLB registered 64.0 KiB page size, pre-allocated 0 pages [ 94.995847] cryptd: max_cpu_qlen set to 1000 [ 95.132486] ACPI: Interpreter disabled. [ 95.198275] iommu: Default domain type: Translated [ 95.207497] vgaarb: loaded [ 95.219386] SCSI subsystem initialized [ 95.224642] libata version 3.00 loaded. [ 95.233901] usbcore: registered new interface driver usbfs [ 95.235586] usbcore: registered new interface driver hub [ 95.237847] usbcore: registered new device driver usb [ 95.262747] pps_core: LinuxPPS API ver. 1 registered [ 95.263152] pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti [ 95.263966] PTP clock support registered [ 95.269799] EDAC MC: Ver: 3.0.0 [ 95.324422] FPGA manager framework [ 95.328570] Advanced Linux Sound Architecture Driver Initialized. [ 95.361928] clocksource: Switched to clocksource arch_sys_counter [ 111.416735] VFS: Disk quotas dquot_6.6.0 [ 111.418925] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) [ 111.428393] pnp: PnP ACPI: disabled [ 111.666757] NET: Registered protocol family 2 [ 111.690777] tcp_listen_portaddr_hash hash table entries: 1024 (order: 4, 81920 bytes, linear) [ 111.691885] TCP established hash table entries: 16384 (order: 5, 131072 bytes, linear) [ 111.701171] TCP bind hash table entries: 16384 (order: 8, 1179648 bytes, linear) [ 111.708874] TCP: Hash tables configured (established 16384 bind 16384) [ 111.713132] UDP hash table entries: 1024 (order: 5, 163840 bytes, linear) [ 111.716578] UDP-Lite hash table entries: 1024 (order: 5, 163840 bytes, linear) [ 111.722527] NET: Registered protocol family 1 [ 111.740889] RPC: Registered named UNIX socket transport module. [ 111.741847] RPC: Registered udp transport module. [ 111.742250] RPC: Registered tcp transport module. [ 111.742627] RPC: Registered tcp NFSv4.1 backchannel transport module. [ 111.743235] PCI: CLS 0 bytes, default 64 [ 111.773814] hw perfevents: enabled with armv8_pmuv3 PMU driver, 5 counters available [ 111.775981] kvm [1]: HYP mode not available [ 112.002354] Initialise system trusted keyrings [ 112.008369] workingset: timestamp_bits=44 max_order=19 bucket_order=0 [ 112.315870] squashfs: version 4.0 (2009/01/31) Phillip Lougher [ 112.336509] NFS: Registering the id_resolver key type [ 112.337956] Key type id_resolver registered [ 112.338516] Key type id_legacy registered [ 112.342326] nfs4filelayout_init: NFSv4 File Layout Driver Registering... [ 112.350262] 9p: Installing v9fs 9p2000 file system support [ 112.445768] Key type asymmetric registered [ 112.446387] Asymmetric key parser 'x509' registered [ 112.447763] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 245) [ 112.448420] io scheduler mq-deadline registered [ 112.448928] io scheduler kyber registered [ 112.832673] pl061_gpio 9030000.pl061: PL061 GPIO chip registered [ 112.892911] pci-host-generic 4010000000.pcie: host bridge /pcie@10000000 ranges: [ 112.895334] pci-host-generic 4010000000.pcie: IO 0x003eff0000..0x003effffff -> 0x0000000000 [ 112.897242] pci-host-generic 4010000000.pcie: MEM 0x0010000000..0x003efeffff -> 0x0010000000 [ 112.898516] pci-host-generic 4010000000.pcie: MEM 0x8000000000..0xffffffffff -> 0x8000000000 [ 112.901413] pci-host-generic 4010000000.pcie: ECAM at [mem 0x4010000000-0x401fffffff] for [bus 00-ff] [ 112.906977] pci-host-generic 4010000000.pcie: PCI host bridge to bus 0000:00 [ 112.907704] pci_bus 0000:00: root bus resource [bus 00-ff] [ 112.908246] pci_bus 0000:00: root bus resource [io 0x0000-0xffff] [ 112.908735] pci_bus 0000:00: root bus resource [mem 0x10000000-0x3efeffff] [ 112.909295] pci_bus 0000:00: root bus resource [mem 0x8000000000-0xffffffffff] [ 112.912394] pci 0000:00:00.0: [1b36:0008] type 00 class 0x060000 [ 112.924053] pci 0000:00:01.0: [1af4:1009] type 00 class 0x000200 [ 112.925272] pci 0000:00:01.0: reg 0x10: [io 0x0000-0x003f] [ 112.926292] pci 0000:00:01.0: reg 0x14: [mem 0x00000000-0x00000fff] [ 112.927523] pci 0000:00:01.0: reg 0x20: [mem 0x00000000-0x00003fff 64bit pref] [ 112.935594] pci 0000:00:02.0: [1af4:1009] type 00 class 0x000200 [ 112.936480] pci 0000:00:02.0: reg 0x10: [io 0x0000-0x003f] [ 112.937116] pci 0000:00:02.0: reg 0x14: [mem 0x00000000-0x00000fff] [ 112.938606] pci 0000:00:02.0: reg 0x20: [mem 0x00000000-0x00003fff 64bit pref] [ 112.946673] pci 0000:00:03.0: [1af4:1000] type 00 class 0x020000 [ 112.947572] pci 0000:00:03.0: reg 0x10: [io 0x0000-0x001f] [ 112.948199] pci 0000:00:03.0: reg 0x14: [mem 0x00000000-0x00000fff] [ 112.949374] pci 0000:00:03.0: reg 0x20: [mem 0x00000000-0x00003fff 64bit pref] [ 112.950357] pci 0000:00:03.0: reg 0x30: [mem 0x00000000-0x0003ffff pref] [ 112.958217] pci 0000:00:04.0: [1af4:1004] type 00 class 0x010000 [ 112.959101] pci 0000:00:04.0: reg 0x10: [io 0x0000-0x003f] [ 112.959728] pci 0000:00:04.0: reg 0x14: [mem 0x00000000-0x00000fff] [ 112.960876] pci 0000:00:04.0: reg 0x20: [mem 0x00000000-0x00003fff 64bit pref] [ 112.974853] pci 0000:00:03.0: BAR 6: assigned [mem 0x10000000-0x1003ffff pref] [ 112.975676] pci 0000:00:01.0: BAR 4: assigned [mem 0x8000000000-0x8000003fff 64bit pref] [ 112.976651] pci 0000:00:02.0: BAR 4: assigned [mem 0x8000004000-0x8000007fff 64bit pref] [ 112.977889] pci 0000:00:03.0: BAR 4: assigned [mem 0x8000008000-0x800000bfff 64bit pref] [ 112.978725] pci 0000:00:04.0: BAR 4: assigned [mem 0x800000c000-0x800000ffff 64bit pref] [ 112.979501] pci 0000:00:01.0: BAR 1: assigned [mem 0x10040000-0x10040fff] [ 112.980096] pci 0000:00:02.0: BAR 1: assigned [mem 0x10041000-0x10041fff] [ 112.980678] pci 0000:00:03.0: BAR 1: assigned [mem 0x10042000-0x10042fff] [ 112.981246] pci 0000:00:04.0: BAR 1: assigned [mem 0x10043000-0x10043fff] [ 112.982177] pci 0000:00:01.0: BAR 0: assigned [io 0x1000-0x103f] [ 112.982760] pci 0000:00:02.0: BAR 0: assigned [io 0x1040-0x107f] [ 112.983316] pci 0000:00:04.0: BAR 0: assigned [io 0x1080-0x10bf] [ 112.983869] pci 0000:00:03.0: BAR 0: assigned [io 0x10c0-0x10df] [ 113.057252] EINJ: ACPI disabled. [ 113.556321] virtio-pci 0000:00:01.0: enabling device (0000 -> 0003) [ 113.571711] virtio-pci 0000:00:02.0: enabling device (0000 -> 0003) [ 113.584925] virtio-pci 0000:00:03.0: enabling device (0000 -> 0003) [ 113.596020] virtio-pci 0000:00:04.0: enabling device (0000 -> 0003) [ 113.787453] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled [ 113.882178] SuperH (H)SCI(F) driver initialized [ 113.901072] msm_serial: driver initialized [ 113.952925] cacheinfo: Unable to detect cache hierarchy for CPU 0 [ 114.230176] loop: module loaded [ 114.262318] megasas: 07.714.04.00-rc1 [ 114.302236] scsi host0: Virtio SCSI HBA [ 114.336019] scsi 0:0:0:0: Direct-Access QEMU QEMU HARDDISK 2.5+ PQ: 0 ANSI: 5 [ 117.142680] random: fast init done [ 117.213261] sd 0:0:0:0: Power-on or device reset occurred [ 117.238425] sd 0:0:0:0: [sda] 524288 512-byte logical blocks: (268 MB/256 MiB) [ 117.240745] sd 0:0:0:0: [sda] Write Protect is off [ 117.241797] sd 0:0:0:0: [sda] Mode Sense: 63 00 00 08 [ 117.245029] sd 0:0:0:0: [sda] Write cache: enabled, read cache: enabled, doesn't support DPO or FUA [ 117.363810] physmap-flash 0.flash: physmap platform flash device: [mem 0x00000000-0x03ffffff] [ 117.370560] 0.flash: Found 2 x16 devices at 0x0 in 32-bit bank. Manufacturer ID 0x000000 Chip ID 0x000000 [ 117.371615] Intel/Sharp Extended Query Table at 0x0031 [ 117.372904] Using buffer write method [ 117.378232] erase region 0: offset=0x0,size=0x40000,blocks=256 [ 117.379270] physmap-flash 0.flash: physmap platform flash device: [mem 0x04000000-0x07ffffff] [ 117.386159] 0.flash: Found 2 x16 devices at 0x0 in 32-bit bank. Manufacturer ID 0x000000 Chip ID 0x000000 [ 117.386764] Intel/Sharp Extended Query Table at 0x0031 [ 117.387780] Using buffer write method [ 117.388252] erase region 0: offset=0x0,size=0x40000,blocks=256 [ 117.388744] Concatenating MTD devices: [ 117.389145] (0): "0.flash" [ 117.394228] (1): "0.flash" [ 117.394599] into device "0.flash" [ 117.431485] sd 0:0:0:0: [sda] Attached SCSI disk [ 117.647630] libphy: Fixed MDIO Bus: probed [ 117.695782] tun: Universal TUN/TAP device driver, 1.6 [ 117.753377] thunder_xcv, ver 1.0 [ 117.755546] thunder_bgx, ver 1.0 [ 117.757381] nicpf, ver 1.0 [ 117.802859] hclge is initializing [ 117.804122] hns3: Hisilicon Ethernet Network Driver for Hip08 Family - version [ 117.804571] hns3: Copyright (c) 2017 Huawei Corporation. [ 117.807038] e1000: Intel(R) PRO/1000 Network Driver [ 117.807436] e1000: Copyright (c) 1999-2006 Intel Corporation. [ 117.809232] e1000e: Intel(R) PRO/1000 Network Driver [ 117.809943] e1000e: Copyright(c) 1999 - 2015 Intel Corporation. [ 117.811895] igb: Intel(R) Gigabit Ethernet Network Driver [ 117.812296] igb: Copyright (c) 2007-2014 Intel Corporation. [ 117.814130] igbvf: Intel(R) Gigabit Virtual Function Network Driver [ 117.814551] igbvf: Copyright (c) 2009 - 2012 Intel Corporation. [ 117.828957] sky2: driver version 1.30 [ 117.865333] VFIO - User Level meta-driver version: 0.3 [ 117.930121] ehci_hcd: USB 2.0 'Enhanced' Host Controller (EHCI) Driver [ 117.930624] ehci-pci: EHCI PCI platform driver [ 117.932133] ehci-platform: EHCI generic platform driver [ 117.936936] ehci-orion: EHCI orion driver [ 117.941876] ehci-exynos: EHCI Exynos driver [ 117.946441] ohci_hcd: USB 1.1 'Open' Host Controller (OHCI) Driver [ 117.947298] ohci-pci: OHCI PCI platform driver [ 117.948921] ohci-platform: OHCI generic platform driver [ 117.954091] ohci-exynos: OHCI Exynos driver [ 117.970958] usbcore: registered new interface driver usb-storage [ 118.086591] rtc-pl031 9010000.pl031: registered as rtc0 [ 118.088263] rtc-pl031 9010000.pl031: setting system clock to 2020-11-11T11:15:44 UTC (1605093344) [ 118.112352] i2c /dev entries driver [ 118.359637] sdhci: Secure Digital Host Controller Interface driver [ 118.360055] sdhci: Copyright(c) Pierre Ossman [ 118.376774] Synopsys Designware Multimedia Card Interface Driver [ 118.417048] sdhci-pltfm: SDHCI platform and OF driver helper [ 118.473048] ledtrig-cpu: registered to indicate activity on CPUs [ 118.541154] usbcore: registered new interface driver usbhid [ 118.541908] usbhid: USB HID core driver [ 118.726391] drop_monitor: Initializing network drop monitor service [ 118.729987] NET: Registered protocol family 17 [ 118.736719] 9pnet: Installing 9P2000 support [ 118.755745] Key type dns_resolver registered [ 118.763199] registered taskstats version 1 [ 118.764943] Running tests on all trace events: [ 118.765319] Testing all events: OK [ 154.077275] hrtimer: interrupt took 21125232 ns [ 176.049337] Running tests again, along with the function tracer [ 176.068194] Running tests on all trace events: [ 176.078196] Testing all events: [ 1320.629571] BUG: workqueue lockup - pool cpus=0 node=0 flags=0x0 nice=0 stuck for 32s! [ 1320.785660] Showing busy workqueues and worker pools: [ 1320.825476] workqueue events: flags=0x0 [ 1320.861955] pwq 0: cpus=0 node=0 flags=0x0 nice=0 active=1/256 refcnt=2 [ 1320.873397] pending: vmstat_shepherd [ 1320.885467] workqueue events_power_efficient: flags=0x82 [ 1320.921575] pwq 2: cpus=0 flags=0x5 nice=0 active=2/256 refcnt=4 [ 1320.931385] in-flight: 107:neigh_periodic_work [ 1320.938581] pending: do_cache_clean [ 1320.960212] pool 2: cpus=0 flags=0x5 nice=0 hung=3s workers=2 manager: 7 [ 2535.539509] rcu: INFO: rcu_preempt detected stalls on CPUs/tasks: [ 2535.545633] (detected by 0, t=6502 jiffies, g=2885, q=4) [ 2535.547634] rcu: All QSes seen, last rcu_preempt kthread activity 5174 (4295523265-4295518091), jiffies_till_next_fqs=1, root ->qsmask 0x0 [ 2535.558720] rcu: rcu_preempt kthread starved for 5174 jiffies! g2885 f0x2 RCU_GP_WAIT_FQS(5) ->state=0x0 ->cpu=0 [ 2535.564713] rcu: Unless rcu_preempt kthread gets sufficient CPU time, OOM is now expected behavior. [ 2535.570363] rcu: RCU grace-period kthread stack dump: [ 2535.574930] task:rcu_preempt state:R running task stack: 0 pid: 10 ppid: 2 flags:0x00000428 [ 2535.584170] Call trace: [ 2535.588004] __switch_to+0x100/0x1e0 [ 2535.592125] __schedule+0x2d0/0x890 [ 2535.596252] preempt_schedule_notrace+0x70/0x1c0 [ 2535.600745] ftrace_ops_no_ops+0x174/0x250 [ 2535.605047] ftrace_graph_call+0x0/0xc [ 2535.609205] preempt_count_add+0x1c/0x180 [ 2535.613451] schedule+0x44/0x108 [ 2535.617464] schedule_timeout+0x394/0x530 [ 2535.621741] rcu_gp_kthread+0x76c/0x19a8 [ 2535.625972] kthread+0x174/0x188 [ 2535.630006] ret_from_fork+0x10/0x18 [ 2535.643477] [ 2535.645825] ================================ [ 2535.648864] WARNING: inconsistent lock state [ 2535.652090] 5.10.0-rc3-next-20201110-00001-gc07b306d7fa5-dirty #18 Not tainted [ 2535.656024] -------------------------------- [ 2535.659086] inconsistent {IN-HARDIRQ-W} -> {HARDIRQ-ON-W} usage. [ 2535.662702] kcompactd0/26 [HC0[0]:SC0[0]:HE0:SE1] takes: [ 2535.666132] ffffae32e6bd4358 (rcu_node_0){?.-.}-{2:2}, at: rcu_sched_clock_irq+0x4a0/0xd18 [ 2535.674157] {IN-HARDIRQ-W} state was registered at: [ 2535.677571] __lock_acquire+0x7bc/0x15b8 [ 2535.680656] lock_acquire+0x244/0x498 [ 2535.683628] _raw_spin_lock_irqsave+0x78/0x144 [ 2535.686822] rcu_sched_clock_irq+0x4a0/0xd18 [ 2535.689963] update_process_times+0x68/0x98 [ 2535.693072] tick_sched_handle.isra.16+0x54/0x80 [ 2535.696314] tick_sched_timer+0x64/0xd8 [ 2535.699352] __hrtimer_run_queues+0x2a4/0x750 [ 2535.702522] hrtimer_interrupt+0xf4/0x2a0 [ 2535.705620] arch_timer_handler_virt+0x44/0x70 [ 2535.708845] handle_percpu_devid_irq+0xfc/0x4d0 [ 2535.712056] generic_handle_irq+0x50/0x70 [ 2535.715127] __handle_domain_irq+0x9c/0x120 [ 2535.718233] gic_handle_irq+0xcc/0x108 [ 2535.721261] el1_irq+0xbc/0x180 [ 2535.724080] _raw_spin_unlock_irq+0x50/0x90 [ 2535.727203] finish_task_switch+0xa4/0x2a8 [ 2535.730289] __schedule+0x2d4/0x890 [ 2535.733211] preempt_schedule_notrace+0x70/0x1c0 [ 2535.736450] ftrace_ops_no_ops+0x174/0x250 [ 2535.739535] ftrace_graph_call+0x0/0xc [ 2535.742555] preempt_count_add+0x1c/0x180 [ 2535.745621] schedule+0x44/0x108 [ 2535.748470] schedule_timeout+0x394/0x530 [ 2535.751548] kcompactd+0x340/0x498 [ 2535.754446] kthread+0x174/0x188 [ 2535.757308] ret_from_fork+0x10/0x18 [ 2535.760211] irq event stamp: 270278 [ 2535.763168] hardirqs last enabled at (270277): [] _raw_spin_unlock_irq+0x48/0x90 [ 2535.767704] hardirqs last disabled at (270278): [] el1_irq+0x7c/0x180 [ 2535.771957] softirqs last enabled at (268786): [] __do_softirq+0x650/0x6a4 [ 2535.776321] softirqs last disabled at (268783): [] irq_exit+0x1a8/0x1b0 [ 2535.780515] [ 2535.780515] other info that might help us debug this: [ 2535.784227] Possible unsafe locking scenario: [ 2535.784227] [ 2535.787754] CPU0 [ 2535.790268] ---- [ 2535.792772] lock(rcu_node_0); [ 2535.797232] [ 2535.799765] lock(rcu_node_0); [ 2535.804266] [ 2535.804266] *** DEADLOCK *** [ 2535.804266] [ 2535.807836] 1 lock held by kcompactd0/26: [ 2535.810840] #0: ffffae32e6bd4358 (rcu_node_0){?.-.}-{2:2}, at: rcu_sched_clock_irq+0x4a0/0xd18 [ 2535.819708] [ 2535.819708] stack backtrace: [ 2535.823059] CPU: 0 PID: 26 Comm: kcompactd0 Not tainted 5.10.0-rc3-next-20201110-00001-gc07b306d7fa5-dirty #18 [ 2535.827790] Hardware name: linux,dummy-virt (DT) [ 2535.831009] Call trace: [ 2535.833607] dump_backtrace+0x0/0x278 [ 2535.836537] show_stack+0x30/0x80 [ 2535.839386] dump_stack+0x138/0x1b0 [ 2535.842278] print_usage_bug+0x2d8/0x2f8 [ 2535.845301] mark_lock.part.46+0x370/0x480 [ 2535.848366] mark_held_locks+0x58/0x90 [ 2535.851340] lockdep_hardirqs_on_prepare+0xdc/0x298 [ 2535.854655] trace_hardirqs_on+0x90/0x388 [ 2535.857693] el1_irq+0xd8/0x180 [ 2535.860494] _raw_spin_unlock_irq+0x50/0x90 [ 2535.863583] finish_task_switch+0xa4/0x2a8 [ 2535.866656] __schedule+0x2d4/0x890 [ 2535.869575] preempt_schedule_notrace+0x70/0x1c0 [ 2535.872811] ftrace_ops_no_ops+0x174/0x250 [ 2535.875885] ftrace_graph_call+0x0/0xc [ 2535.878865] preempt_count_add+0x1c/0x180 [ 2535.881901] schedule+0x44/0x108 [ 2535.884719] schedule_timeout+0x394/0x530 [ 2535.887747] kcompactd+0x340/0x498 [ 2535.890630] kthread+0x174/0x188 [ 2535.893441] ret_from_fork+0x10/0x18 [ 2535.900455] BUG: scheduling while atomic: kcompactd0/26/0x00000002 [ 2535.908864] INFO: lockdep is turned off. [ 2535.917408] Modules linked in: [ 2535.930517] Preemption disabled at: [ 2535.932175] [] ftrace_ops_no_ops+0x174/0x250 [ 2535.945072] CPU: 0 PID: 26 Comm: kcompactd0 Not tainted 5.10.0-rc3-next-20201110-00001-gc07b306d7fa5-dirty #18 [ 2535.949821] Hardware name: linux,dummy-virt (DT) [ 2535.952991] Call trace: [ 2535.955591] dump_backtrace+0x0/0x278 [ 2535.958529] show_stack+0x30/0x80 [ 2535.961385] dump_stack+0x138/0x1b0 [ 2535.964320] __schedule_bug+0x8c/0xe8 [ 2535.967292] __schedule+0x7e8/0x890 [ 2535.970204] preempt_schedule_notrace+0x70/0x1c0 [ 2535.973465] ftrace_ops_no_ops+0x174/0x250 [ 2535.976547] ftrace_graph_call+0x0/0xc [ 2535.979553] preempt_count_add+0x1c/0x180 [ 2535.982597] schedule+0x44/0x108 [ 2535.985411] schedule_timeout+0x394/0x530 [ 2535.988445] kcompactd+0x340/0x498 [ 2535.991330] kthread+0x174/0x188 [ 2535.994150] ret_from_fork+0x10/0x18 qemu-system-aarch64: terminating on signal 15 from pid 4135918 ()