HK1BOX刷入EMMC后卡住，用U盘能进入系统。5.4.176

[luoluo888]

SM1:BL:511f6b:81ca2f;FEAT:A0F83180:20282000;POC:F;RCY:0;EMMC:0;READ:0;0.0;CHK:0;
bl2_stage_init 0x01
bl2_stage_init 0x81
hw id: 0x0001 - pwm id 0x00
bl2_stage_init 0xc0
bl2_stage_init 0x02

L0:00000000
L1:00000703
L2:00008067
L3:15000020
S1:00000000
B2:20282000
B1:a0f83180

TE: 124002

BL2 Built : 19:17:49, Jul 31 2019. g12a ge9a9000 - zhiguang.ouyang@droid07-sz

Board ID = 1
Set cpu clk to 24M
Set clk81 to 24M
Use GP1_pll as DSU clk.
DSU clk: 1200 Mhz
CPU clk: 1200 MHz
Set clk81 to 166.6M
eMMC boot @ 0
sw8 s
DDR driver_vesion: LPDDR4_PHY_V_0_1_18 build time: Jul 31 2019 19:17:43
board id: 1
Load FIP HDR from eMMC, src: 0x00010200, des: 0xfffd0000, size: 0x00004000, part: 0
fw parse done
Load ddrfw from eMMC, src: 0x00060200, des: 0xfffd0000, size: 0x0000c000, part: 0
Load ddrfw from eMMC, src: 0x00038200, des: 0xfffd0000, size: 0x00004000, part: 0
PIEI prepare done
fastboot data load
00000000
emmc switch 1 ok
ddr saved addr:00016000
Load ddr parameter from eMMC, src: 0x02c00000, des: 0xfffd0000, size: 0x00001000, part: 0
00000000
emmc switch 0 ok
fastboot data verify
verify result: 264
Cfg max: 5, cur: 1. Board id: 255. Force loop cfg
DDR3 probe
ddr clk to 672MHz
Load ddrfw from eMMC, src: 0x0002c200, des: 0xfffd0000, size: 0x0000c000, part: 0

dmc_version 0001
Check phy result
INFO : End of initialization
INFO : ERROR : Training has failed!
1D training failed
Cfg max: 5, cur: 2. Board id: 255. Force loop cfg
DDR3 probe
ddr clk to 576MHz
Load ddrfw from eMMC, src: 0x0002c200, des: 0xfffd0000, size: 0x0000c000, part: 0

dmc_version 0001
Check phy result
INFO : End of initialization
INFO : End of read enable training
INFO : End of fine write leveling
INFO : End of read dq deskew training
INFO : End of MPR read delay center optimization
INFO : End of Write leveling coarse delay
INFO : End of write delay center optimization
INFO : End of read delay center optimization
INFO : End of max read latency training
INFO : Training has run successfully!
1D training succeed
aml_ddr_fw_vesion: LPDDR4_PHY_V_0_1_18 build time: Jul 31 2019 19:17:53
auto size-- 65535DDR cs0 size: 4096MB
DDR cs1 size: 0MB
DMC_DDR_CTRL: 0000002dDDR size: 3928MB
cs0 DataBus test pass
cs0 AddrBus test pass

100bdlr_step_size ps== 442
result report
boot times 0Enable ddr reg access
00000000
emmc switch 3 ok
BL2: rpmb counter: 0x000010fc
00000000
emmc switch 0 ok
Load FIP HDR from eMMC, src: 0x00010200, des: 0x01700000, size: 0x00004000, part: 0
Load BL3X from eMMC, src: 0x00078200, des: 0x01768000, size: 0x00097600, part: 0
0.0;M3 CHK:0;cm4_sp_mode 0
MVN_1=0x00000000
MVN_2=0x00000000
[Image: g12a_v1.1.3389-92241b5 2019-07-02 17:22:49 luan.yuan@droid15-sz]
OPS=0x10
ring efuse init
2b 0c 10 00 01 1d 00 00 00 02 32 39 31 41 46 50
[0.017354 Inits done]
secure task start!
high task start!
low task start!
run into bl31
NOTICE: BL31: v1.3(release):4fc40b1
NOTICE: BL31: Built : 15:57:33, May 22 2019
NOTICE: BL31: G12A normal boot!
NOTICE: BL31: BL33 decompress pass
ERROR: Error initializing runtime service opteed_fast

U-Boot 2021.10-rc1-00012-gdad3de6c79 (Aug 10 2021 - 22:53:50 +0800) hk1box/vontar-x3

Model: HK1 Box/Vontar X3
SoC: Amlogic Meson SM1 (S905X3) Revision 2b:c (10:2)
DRAM: 3.8 GiB
MMC: sd@ffe03000: 0, sd@ffe05000: 1, mmc@ffe07000: 2
Loading Environment from nowhere... OK
In: serial
Out: serial
Err: serial
Net: eth0: ethernet@ff3f0000
Hit any key to stop autoboot: 0
starting USB...
Bus usb@ff500000: Register 3000140 NbrPorts 3
Starting the controller
USB XHCI 1.10
scanning bus usb@ff500000 for devices... 1 USB Device(s) found
scanning usb for storage devices... 0 Storage Device(s) found

Device 0: unknown device
Card did not respond to voltage select! : -110
Card did not respond to voltage select! : -110
switch to partitions #0, OK
mmc2(part 0) is current device
Scanning mmc 2:1...
Found U-Boot script /boot.scr
1025 bytes read in 0 ms

Executing script at 08000000

Start AMLOGIC mainline U-boot

Error: "bootfromsd" not defined

350 bytes read in 1 ms (341.8 KiB/s)

Error: "mac" not defined

Error: "eth_mac" not defined

ethaddr=96:ba:51:bc:f6:6c
20685312 bytes read in 447 ms (44.1 MiB/s)
6187884 bytes read in 134 ms (44 MiB/s)
46138 bytes read in 4 ms (11 MiB/s)

Loading init Ramdisk from Legacy Image at 13000000 ...

Image Name: uInitrd
Image Type: AArch64 Linux RAMDisk Image (gzip compressed)
Data Size: 6187820 Bytes = 5.9 MiB
Load Address: 00000000
Entry Point: 00000000
Verifying Checksum ... OK

Flattened Device Tree blob at 08008000

Booting using the fdt blob at 0x8008000
Loading Ramdisk to 3fa19000, end 3ffffb2c ... OK
Loading Device Tree to 000000003fa0a000, end 000000003fa18439 ... OK

Starting kernel ...

[ 0.000000] Booting Linux on physical CPU 0x0000000000 [0x411fd050]
[ 0.000000] Linux version 5.4.176-flippy-69+o (root@univm25) (gcc version 11.2.0 (Ubuntu 11.2.0-5ubuntu1)) #379 SMP PREEMPT Wed Feb 2 10:44:57 CST 2022
[ 0.000000] Machine model: HK1 Box/Vontar X3 @ 2208Mhz
[ 0.000000] efi: Getting EFI parameters from FDT:
[ 0.000000] efi: UEFI not found.
[ 0.000000] Reserved memory: created CMA memory pool at 0x00000000e4c00000, size 256 MiB
[ 0.000000] OF: reserved mem: initialized node linux,cma, compatible id shared-dma-pool
[ 0.000000] psci: probing for conduit method from DT.
[ 0.000000] psci: PSCIv1.0 detected in firmware.
[ 0.000000] psci: Using standard PSCI v0.2 function IDs
[ 0.000000] psci: MIGRATE_INFO_TYPE not supported.
[ 0.000000] psci: SMC Calling Convention v1.1
[ 0.000000] percpu: Embedded 21 pages/cpu s47576 r8192 d30248 u86016
[ 0.000000] Detected VIPT I-cache on CPU0
[ 0.000000] CPU features: detected: Virtualization Host Extensions
[ 0.000000] alternatives: patching kernel code
[ 0.000000] Built 1 zonelists, mobility grouping on. Total pages: 977953
[ 0.000000] Kernel command line: root=UUID=023c4cbb-ed8e-45fd-90f4-92fc6c56bc7a rootflags=data=writeback rw console=ttyAML0,115200n8 console=tty0 no_console_suspend consoleblank=0 fsck.fix=yes fsck.repair=yes net.ifnames=0 cgroup_enable=cpuset cgroup_memory=1 cgroup_enable=memory swapaccount=1 mac=96:ba:51:bc:f6:6c
[ 0.000000] Dentry cache hash table entries: 524288 (order: 10, 4194304 bytes, linear)
[ 0.000000] Inode-cache hash table entries: 262144 (order: 9, 2097152 bytes, linear)
[ 0.000000] mem auto-init: stack:off, heap alloc:off, heap free:off
[ 0.000000] Memory: 3605108K/3974508K available (12476K kernel code, 1448K rwdata, 5184K rodata, 896K init, 853K bss, 107256K reserved, 262144K cma-reserved)
[ 0.000000] random: get_random_u64 called from __kmem_cache_create+0x38/0x590 with crng_init=0
[ 0.000000] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=4, Nodes=1
[ 0.000000] rcu: Preemptible hierarchical RCU implementation.
[ 0.000000] rcu: RCU restricting CPUs from NR_CPUS=8 to nr_cpu_ids=4.
[ 0.000000] Tasks RCU enabled.
[ 0.000000] rcu: RCU calculated value of scheduler-enlistment delay is 30 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] GIC: Using split EOI/Deactivate mode
[ 0.000000] irq_meson_gpio: 100 to 8 gpio interrupt mux initialized
[ 0.000000] arch_timer: cp15 timer(s) running at 24.00MHz (phys).
[ 0.000000] clocksource: arch_sys_counter: mask: 0xffffffffffffff max_cycles: 0x588fe9dc0, max_idle_ns: 440795202592 ns
[ 0.000005] sched_clock: 56 bits at 24MHz, resolution 41ns, wraps every 4398046511097ns
[ 0.000151] Console: colour dummy device 80x25
[ 0.000451] printk: console [tty0] enabled
[ 0.000492] Calibrating delay loop (skipped), value calculated using timer frequency.. 48.00 BogoMIPS (lpj=80000)
[ 0.000514] pid_max: default: 32768 minimum: 301
[ 0.000652] LSM: Security Framework initializing
[ 0.000706] SELinux: Initializing.
[ 0.000808] *** VALIDATE SELinux ***
[ 0.000880] Mount-cache hash table entries: 8192 (order: 4, 65536 bytes, linear)
[ 0.000909] Mountpoint-cache hash table entries: 8192 (order: 4, 65536 bytes, linear)
[ 0.000974] *** VALIDATE tmpfs ***
[ 0.001459] *** VALIDATE proc ***
[ 0.001703] *** VALIDATE cgroup1 ***
[ 0.001722] *** VALIDATE cgroup2 ***
[ 0.002495] ASID allocator initialised with 32768 entries
[ 0.002601] rcu: Hierarchical SRCU implementation.
[ 0.004928] EFI services will not be available.
[ 0.005303] smp: Bringing up secondary CPUs ...
[ 0.006183] Detected VIPT I-cache on CPU1
[ 0.006242] CPU1: Booted secondary processor 0x0000000100 [0x411fd050]
[ 0.007188] Detected VIPT I-cache on CPU2
[ 0.007220] CPU2: Booted secondary processor 0x0000000200 [0x411fd050]
[ 0.008073] Detected VIPT I-cache on CPU3
[ 0.008101] CPU3: Booted secondary processor 0x0000000300 [0x411fd050]
[ 0.008183] smp: Brought up 1 node, 4 CPUs
[ 0.008242] SMP: Total of 4 processors activated.
[ 0.008254] CPU features: detected: Privileged Access Never
[ 0.008264] CPU features: detected: User Access Override
[ 0.008276] CPU features: detected: 32-bit EL0 Support
[ 0.008286] CPU features: detected: Common not Private translations
[ 0.008297] CPU features: detected: RAS Extension Support
[ 0.008308] CPU features: detected: Data cache clean to the PoU not required for I/D coherence
[ 0.008325] CPU features: detected: CRC32 instructions
[ 0.009234] CPU: All CPU(s) started at EL2
[ 0.010651] devtmpfs: initialized
[ 0.022177] Registered cp15_barrier emulation handler
[ 0.022209] Registered setend emulation handler
[ 0.022452] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 6370867519511994 ns
[ 0.022483] futex hash table entries: 1024 (order: 4, 65536 bytes, linear)
[ 0.028955] xor: measuring software checksum speed
[ 0.060134] 8regs : 2244.000 MB/sec
[ 0.093507] 32regs : 2733.600 MB/sec
[ 0.126883] arm64_neon: 2274.000 MB/sec
[ 0.126894] xor: using function: 32regs (2733.600 MB/sec)
[ 0.126955] pinctrl core: initialized pinctrl subsystem
[ 0.127546] DMI not present or invalid.
[ 0.127869] NET: Registered protocol family 16
[ 0.129589] DMA: preallocated 256 KiB pool for atomic allocations
[ 0.129615] audit: initializing netlink subsys (disabled)
[ 0.129775] audit: type=2000 audit(0.126:1): state=initialized audit_enabled=0 res=1
[ 0.131182] cpuidle: using governor ladder
[ 0.131394] hw-breakpoint: found 6 breakpoint and 4 watchpoint registers.
[ 0.131583] Serial: AMBA PL011 UART driver
[ 0.150137] HugeTLB registered 1.00 GiB page size, pre-allocated 0 pages
[ 0.150168] HugeTLB registered 32.0 MiB page size, pre-allocated 0 pages
[ 0.150182] HugeTLB registered 2.00 MiB page size, pre-allocated 0 pages
[ 0.150196] HugeTLB registered 64.0 KiB page size, pre-allocated 0 pages
[ 0.152398] cryptd: max_cpu_qlen set to 1000
[ 0.214281] raid6: neonx8 gen() 1296 MB/s
[ 0.270966] raid6: neonx8 xor() 1380 MB/s
[ 0.327738] raid6: neonx4 gen() 1293 MB/s
[ 0.384446] raid6: neonx4 xor() 1391 MB/s
[ 0.441207] raid6: neonx2 gen() 921 MB/s
[ 0.497925] raid6: neonx2 xor() 1153 MB/s
[ 0.554646] raid6: neonx1 gen() 601 MB/s
[ 0.611408] raid6: neonx1 xor() 909 MB/s
[ 0.668162] raid6: int64x8 gen() 1001 MB/s
[ 0.724883] raid6: int64x8 xor() 761 MB/s
[ 0.781592] raid6: int64x4 gen() 813 MB/s
[ 0.838329] raid6: int64x4 xor() 748 MB/s
[ 0.895030] raid6: int64x2 gen() 544 MB/s
[ 0.951787] raid6: int64x2 xor() 623 MB/s
[ 1.008578] raid6: int64x1 gen() 351 MB/s
[ 1.065210] raid6: int64x1 xor() 352 MB/s
[ 1.065223] raid6: using algorithm neonx8 gen() 1296 MB/s
[ 1.065236] raid6: .... xor() 1380 MB/s, rmw enabled
[ 1.065249] raid6: using neon recovery algorithm
[ 1.065490] fbcon: Taking over console
[ 1.066095] reg-fixed-voltage regulator-ao_5v: Failed to register regulator: -517
[ 1.066496] reg-fixed-voltage regulator-emmc_1v8: Failed to register regulator: -517
[ 1.066606] VDDAO_3V3: supplied by DC_IN
[ 1.066930] VDDIO_AO1V8: supplied by VDDAO_3V3
[ 1.067252] reg-fixed-voltage regulator-vddgpu: Failed to register regulator: -517
[ 1.067477] iommu: Default domain type: Translated
[ 1.067793] vgaarb: loaded
[ 1.068296] SCSI subsystem initialized
[ 1.068574] usbcore: registered new interface driver usbfs
[ 1.068634] usbcore: registered new interface driver hub
[ 1.068682] usbcore: registered new device driver usb
[ 1.069101] mc: Linux media interface: v0.10
[ 1.069147] videodev: Linux video capture interface: v2.00
[ 1.069248] pps_core: LinuxPPS API ver. 1 registered
[ 1.069262] pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti [email protected]
[ 1.069288] PTP clock support registered
[ 1.069477] EDAC MC: Ver: 3.0.0
[ 1.070209] Advanced Linux Sound Architecture Driver Initialized.
[ 1.071320] clocksource: Switched to clocksource arch_sys_counter
[ 1.071344] *** VALIDATE bpf ***
[ 1.071611] VFS: Disk quotas dquot_6.6.0
[ 1.071685] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes)
[ 1.071826] FS-Cache: Loaded
[ 1.071838] *** VALIDATE ramfs ***
[ 1.071865] *** VALIDATE hugetlbfs ***
[ 1.079838] thermal_sys: Registered thermal governor 'step_wise'
[ 1.080325] NET: Registered protocol family 2
[ 1.080559] IP idents hash table entries: 65536 (order: 7, 524288 bytes, linear)
[ 1.082257] tcp_listen_portaddr_hash hash table entries: 2048 (order: 3, 32768 bytes, linear)
[ 1.082311] TCP established hash table entries: 32768 (order: 6, 262144 bytes, linear)
[ 1.082505] TCP bind hash table entries: 32768 (order: 7, 524288 bytes, linear)
[ 1.082946] TCP: Hash tables configured (established 32768 bind 32768)
[ 1.083095] UDP hash table entries: 2048 (order: 4, 65536 bytes, linear)
[ 1.083163] UDP-Lite hash table entries: 2048 (order: 4, 65536 bytes, linear)
[ 1.083409] NET: Registered protocol family 1
[ 1.083451] NET: Registered protocol family 44
[ 1.083470] PCI: CLS 0 bytes, default 64
[ 1.083712] Trying to unpack rootfs image as initramfs...
[ 3.086750] Freeing initrd memory: 6040K
[ 3.087573] kvm [1]: IPA Size Limit: 40 bits
[ 3.087712] kvm [1]: vgic interrupt IRQ1
[ 3.087850] kvm [1]: VHE mode initialized successfully
[ 3.093820] Initialise system trusted keyrings
[ 3.093999] workingset: timestamp_bits=46 max_order=20 bucket_order=0
[ 3.100919] zbud: loaded
[ 3.102774] squashfs: version 4.0 (2009/01/31) Phillip Lougher
[ 3.103148] fuse: init (API version 7.31)
[ 3.103253] *** VALIDATE fuse ***
[ 3.103271] *** VALIDATE fuse ***
[ 3.103696] SGI XFS with ACLs, security attributes, no debug enabled
[ 3.119456] Key type asymmetric registered
[ 3.119481] Asymmetric key parser 'x509' registered
[ 3.119537] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 243)
[ 3.119650] io scheduler mq-deadline registered
[ 3.119664] io scheduler kyber registered
[ 3.119852] io scheduler bfq registered
[ 3.141222] soc soc0: Amlogic Meson SM1 (Unknown) Revision 2b:c (10:2) Detected
[ 3.142640] VDDCPU: supplied by regulator-dummy
[ 3.144111] Serial: 8250/16550 driver, 5 ports, IRQ sharing enabled
[ 3.146062] Serial: AMBA driver
[ 3.146463] ff803000.serial: ttyAML0 at MMIO 0xff803000 (irq = 14, base_baud = 1500000) is a meson_uart
[ 4.088567] printk: console [ttyAML0] enabled
[ 4.093501] ffd24000.serial: ttyAML6 at MMIO 0xffd24000 (irq = 20, base_baud = 1500000) is a meson_uart
[ 4.102315] serial serial0: tty port ttyAML6 registered
[ 4.115509] brd: module loaded
[ 4.288024] loop: module loaded
[ 4.295971] ehci_hcd: USB 2.0 'Enhanced' Host Controller (EHCI) Driver
[ 4.296879] ehci-pci: EHCI PCI platform driver
[ 4.301354] ehci-platform: EHCI generic platform driver
[ 4.306643] ohci_hcd: USB 1.1 'Open' Host Controller (OHCI) Driver
[ 4.312588] ohci-pci: OHCI PCI platform driver
[ 4.317005] ohci-platform: OHCI generic platform driver
[ 4.322689] usbcore: registered new interface driver cdc_wdm
[ 4.327810] usbcore: registered new interface driver usb-storage
[ 4.334113] mousedev: PS/2 mouse device common for all mice
[ 4.340472] meson-vrtc ff8000a8.rtc: registered as rtc0
[ 4.344870] i2c /dev entries driver
[ 4.357328] Synopsys Designware Multimedia Card Interface Driver
[ 4.358449] meson-gx-mmc ffe03000.sd: allocated mmc-pwrseq
[ 4.387852] meson-gx-mmc ffe05000.sd: Got CD GPIO
[ 4.416056] meson-sm: secure-monitor enabled
[ 4.416554] hidraw: raw HID events driver (C) Jiri Kosina
[ 4.420217] usbcore: registered new interface driver usbhid
[ 4.425749] usbhid: USB HID core driver
[ 4.429505] exFAT: Version 1.3.0
[ 4.440290] Initializing XFRM netlink socket
[ 4.440776] NET: Registered protocol family 10
[ 4.445783] mmc0: queuing unknown CIS tuple 0x80 (2 bytes)
[ 4.452642] mmc0: queuing unknown CIS tuple 0x80 (7 bytes)
[ 4.456344] mmc0: queuing unknown CIS tuple 0x80 (3 bytes)
[ 4.476190] Segment Routing with IPv6
[ 4.476408] sit: IPv6, IPv4 and MPLS over IPv4 tunneling driver
[ 4.482413] bpfilter: Loaded bpfilter_umh pid 197
[ 4.486512] NET: Registered protocol family 17
[ 4.489205] NET: Registered protocol family 15
[ 4.493707] 8021q: 802.1Q VLAN Support v1.8
[ 4.499651] Key type dns_resolver registered
[ 4.502266] Loading compiled-in X.509 certificates
[ 4.508746] zswap: loaded using pool lzo/zbud
[ 4.511289] Key type ._fscrypt registered
[ 4.516550] Key type .fscrypt registered
[ 4.519674] Btrfs loaded, crc32c=crc32c-generic
[ 4.542110] random: fast init done
[ 4.543498] mmc0: new ultra high speed SDR50 SDIO card at address 0001
[ 4.547366] AO_5V: supplied by DC_IN
[ 4.552262] EMMC_1V8: supplied by VDDAO_3V3
[ 4.554278] mali: supplied by AO_5V
[ 4.662765] meson-drm ff900000.vpu: Queued 3 outputs on vpu
[ 4.663074] [drm] Supports vblank timestamp caching Rev 2 (21.10.2013).
[ 4.670938] [drm] No driver support for vblank timestamp query.
[ 4.701365] meson-dw-hdmi ff600000.hdmi-tx: Detected HDMI TX controller v2.01a with HDCP (meson_dw_hdmi_phy)
[ 4.705964] meson-dw-hdmi ff600000.hdmi-tx: registered DesignWare HDMI I2C bus driver
[ 4.716184] meson-drm ff900000.vpu: bound ff600000.hdmi-tx (ops meson_dw_hdmi_ops)
[ 4.721331] [drm] Initialized meson 1.0.0 20161109 for ff900000.vpu on minor 0
[ 4.730991] [drm] kms: can't enable cloning when we probably wanted to.
[ 4.904040] Console: switching to colour frame buffer device 128x48
[ 4.934974] meson-drm ff900000.vpu: fb0: mesondrmfb frame buffer device
[ 4.946137] meson8b-dwmac ff3f0000.ethernet: IRQ eth_wake_irq not found
[ 4.948082] meson8b-dwmac ff3f0000.ethernet: IRQ eth_lpi not found
[ 4.954392] meson8b-dwmac ff3f0000.ethernet: PTP uses main clock
[ 4.960540] meson8b-dwmac ff3f0000.ethernet: no reset control found
[ 4.967780] meson8b-dwmac ff3f0000.ethernet: User ID: 0x11, Synopsys ID: 0x37
[ 4.974243] meson8b-dwmac ff3f0000.ethernet: DWMAC1000
[ 4.978597] meson8b-dwmac ff3f0000.ethernet: DMA HW capability register supported
[ 4.986804] meson8b-dwmac ff3f0000.ethernet: RX Checksum Offload Engine supported
[ 4.993431] meson8b-dwmac ff3f0000.ethernet: COE Type 2
[ 4.998604] meson8b-dwmac ff3f0000.ethernet: TX Checksum insertion supported
[ 5.006372] meson8b-dwmac ff3f0000.ethernet: Wake-Up On Lan supported
[ 5.011973] meson8b-dwmac ff3f0000.ethernet: Normal descriptors
[ 5.018596] meson8b-dwmac ff3f0000.ethernet: Ring mode enabled
[ 5.023617] meson8b-dwmac ff3f0000.ethernet: Enable RX Mitigation via HW Watchdog Timer
[ 5.033797] dwc3-meson-g12a ffe09000.usb: USB2 ports: 2
[ 5.036735] dwc3-meson-g12a ffe09000.usb: USB3 ports: 1
[ 5.045728] dwc2 ff400000.usb: ff400000.usb supply vusb_d not found, using dummy regulator
[ 5.050939] dwc2 ff400000.usb: ff400000.usb supply vusb_a not found, using dummy regulator
[ 5.058507] dwc2 ff400000.usb: EPs: 7, dedicated fifos, 712 entries in SPRAM
[ 5.066987] dwc3 ff500000.usb: Failed to get clk 'ref': -2
[ 5.071127] xhci-hcd xhci-hcd.3.auto: xHCI Host Controller
[ 5.077075] xhci-hcd xhci-hcd.3.auto: new USB bus registered, assigned bus number 1
[ 5.083861] xhci-hcd xhci-hcd.3.auto: hcc params 0x0228fe6c hci version 0x110 quirks 0x0000000000010010
[ 5.093845] xhci-hcd xhci-hcd.3.auto: irq 29, io mem 0xff500000
[ 5.099204] usb usb1: New USB device found, idVendor=1d6b, idProduct=0002, bcdDevice= 5.04
[ 5.107106] usb usb1: New USB device strings: Mfr=3, Product=2, SerialNumber=1
[ 5.114264] usb usb1: Product: xHCI Host Controller
[ 5.119092] usb usb1: Manufacturer: Linux 5.4.176-flippy-69+o xhci-hcd
[ 5.125560] usb usb1: SerialNumber: xhci-hcd.3.auto
[ 5.130732] hub 1-0:1.0: USB hub found
[ 5.134138] hub 1-0:1.0: 2 ports detected
[ 5.138317] xhci-hcd xhci-hcd.3.auto: xHCI Host Controller
[ 5.143617] xhci-hcd xhci-hcd.3.auto: new USB bus registered, assigned bus number 2
[ 5.151104] xhci-hcd xhci-hcd.3.auto: Host supports USB 3.0 SuperSpeed
[ 5.157602] usb usb2: We don't know the algorithms for LPM for this host, disabling LPM.
[ 5.165655] usb usb2: New USB device found, idVendor=1d6b, idProduct=0003, bcdDevice= 5.04
[ 5.173776] usb usb2: New USB device strings: Mfr=3, Product=2, SerialNumber=1
[ 5.180938] usb usb2: Product: xHCI Host Controller
[ 5.185765] usb usb2: Manufacturer: Linux 5.4.176-flippy-69+o xhci-hcd
[ 5.192233] usb usb2: SerialNumber: xhci-hcd.3.auto
[ 5.197384] hub 2-0:1.0: USB hub found
[ 5.200790] hub 2-0:1.0: 1 port detected
[ 5.206116] meson-gx-mmc ffe07000.mmc: allocated mmc-pwrseq
[ 5.235608] simple-framebuffer f4e5b000.framebuffer: framebuffer at 0xf4e5b000, 0x195000 bytes, mapped to 0x(ptrval)
[ 5.243023] simple-framebuffer f4e5b000.framebuffer: format=x8r8g8b8, mode=720x576x32, linelength=2880
[ 5.252649] simple-framebuffer f4e5b000.framebuffer: fb1: simplefb registered!
[ 5.357996] mmc2: new HS200 MMC card at address 0001
[ 5.365351] mmcblk2: mmc2:0001 064G30 58.2 GiB
[ 5.368473] mmcblk2boot0: mmc2:0001 064G30 partition 1 4.00 MiB
[ 5.373544] mmcblk2boot1: mmc2:0001 064G30 partition 2 4.00 MiB
[ 5.380186] mmcblk2rpmb: mmc2:0001 064G30 partition 3 4.00 MiB, chardev (239:0)
[ 5.389362] mmcblk2: p1 p2
[ 5.395598] meson-vrtc ff8000a8.rtc: setting system clock to 1970-01-01T00:00:05 UTC (5)
[ 5.401044] ALSA device list:
[ 5.403462] No soundcards found.
[ 5.407180] Freeing unused kernel memory: 896K
[ 5.414711] Run /init as init process
[ 30.767973] rcu: INFO: rcu_preempt self-detected stall on CPU
[ 30.773703] rcu: 2-...0: (1 GPs behind) idle=9f6/0/0x1 softirq=440/441 fqs=2082
[ 30.781173] (t=6303 jiffies g=-251 q=600)
[ 30.787085] Task dump for CPU 2:
[ 30.792670] swapper/2 R running task 0 0 1 0x0000002a
[ 30.799688] Call trace:
[ 30.805650] dump_backtrace+0x0/0x160
[ 30.811562] show_stack+0x14/0x20
[ 30.817057] sched_show_task+0xe0/0x104
[ 30.822519] dump_cpu_task+0x40/0x4c
[ 30.827938] rcu_dump_cpu_stacks+0x94/0xd0
[ 30.833307] rcu_sched_clock_irq+0x6f8/0xa54
[ 30.838953] update_process_times+0x60/0x9c
[ 30.844144] tick_sched_timer+0x70/0x1d0
[ 30.849597] __hrtimer_run_queues+0x134/0x1d0
[ 30.854688] hrtimer_interrupt+0xf0/0x2ac
[ 30.860068] arch_timer_handler_phys+0x30/0x40
[ 30.865106] handle_percpu_devid_irq+0x98/0x150
[ 30.870120] __handle_domain_irq+0xa4/0x120
[ 30.875486] gic_handle_irq+0x50/0xb0
[ 30.880803] el1_irq+0xcc/0x180
[ 30.886072] arch_cpu_idle+0x18/0x30
[ 30.891306] do_idle+0x1d8/0x260
[ 30.896406] cpu_startup_entry+0x24/0x70
[ 30.901440] secondary_start_kernel+0x14c/0x1bc
[ 93.777956] rcu: INFO: rcu_preempt self-detected stall on CPU
[ 93.782755] rcu: 2-...0: (1 GPs behind) idle=9f6/0/0x1 softirq=440/441 fqs=8327
[ 93.790169] (t=25206 jiffies g=-251 q=600)
[ 93.794925] Task dump for CPU 2:
[ 93.799931] swapper/2 R running task 0 0 1 0x0000002a
[ 93.806174] Call trace:
[ 93.811207] dump_backtrace+0x0/0x160
[ 93.816090] show_stack+0x14/0x20
[ 93.820571] sched_show_task+0xe0/0x104
[ 93.825297] dump_cpu_task+0x40/0x4c
[ 93.829927] rcu_dump_cpu_stacks+0x94/0xd0
[ 93.834281] rcu_sched_clock_irq+0x6f8/0xa54
[ 93.838880] update_process_times+0x60/0x9c
[ 93.843253] tick_sched_timer+0x70/0x1d0
[ 93.847562] __hrtimer_run_queues+0x134/0x1d0
[ 93.852085] hrtimer_interrupt+0xf0/0x2ac
[ 93.856514] arch_timer_handler_phys+0x30/0x40
[ 93.860605] handle_percpu_devid_irq+0x98/0x150
[ 93.864705] __handle_domain_irq+0xa4/0x120
[ 93.869059] gic_handle_irq+0x50/0xb0
[ 93.873117] el1_irq+0xcc/0x180
[ 93.877147] arch_cpu_idle+0x18/0x30
[ 93.881196] do_idle+0x1d8/0x260
[ 93.885160] cpu_startup_entry+0x24/0x70
[ 93.889060] secondary_start_kernel+0x14c/0x1bc
[ 156.787945] rcu: INFO: rcu_preempt self-detected stall on CPU
[ 156.791962] rcu: 2-...0: (1 GPs behind) idle=9f6/0/0x1 softirq=440/441 fqs=14568
[ 156.799459] (t=44109 jiffies g=-251 q=600)
[ 156.803701] Task dump for CPU 2:
[ 156.807672] swapper/2 R running task 0 0 1 0x0000002a
[ 156.813773] Call trace:
[ 156.817792] dump_backtrace+0x0/0x160
[ 156.822103] show_stack+0x14/0x20
[ 156.826138] sched_show_task+0xe0/0x104
[ 156.830176] dump_cpu_task+0x40/0x4c
[ 156.834464] rcu_dump_cpu_stacks+0x94/0xd0
[ 156.838507] rcu_sched_clock_irq+0x6f8/0xa54
[ 156.842537] update_process_times+0x60/0x9c
[ 156.846544] tick_sched_timer+0x70/0x1d0
[ 156.850788] __hrtimer_run_queues+0x134/0x1d0
[ 156.854816] hrtimer_interrupt+0xf0/0x2ac
[ 156.858831] arch_timer_handler_phys+0x30/0x40
[ 156.863113] handle_percpu_devid_irq+0x98/0x150
[ 156.867409] __handle_domain_irq+0xa4/0x120
[ 156.871716] gic_handle_irq+0x50/0xb0
[ 156.875766] el1_irq+0xcc/0x180
[ 156.880052] arch_cpu_idle+0x18/0x30
[ 156.884334] do_idle+0x1d8/0x260
[ 156.888288] cpu_startup_entry+0x24/0x70
[ 156.892419] secondary_start_kernel+0x14c/0x1bc
[ 219.797929] rcu: INFO: rcu_preempt self-detected stall on CPU
[ 219.801930] rcu: 2-...0: (1 GPs behind) idle=9f6/0/0x1 softirq=440/441 fqs=20839
[ 219.809429] (t=63012 jiffies g=-251 q=600)
[ 219.813568] Task dump for CPU 2:
[ 219.817779] swapper/2 R running task 0 0 1 0x0000002a
[ 219.823744] Call trace:
[ 219.828017] dump_backtrace+0x0/0x160
[ 219.832064] show_stack+0x14/0x20
[ 219.836343] sched_show_task+0xe0/0x104
[ 219.840384] dump_cpu_task+0x40/0x4c
[ 219.844412] rcu_dump_cpu_stacks+0x94/0xd0
[ 219.848452] rcu_sched_clock_irq+0x6f8/0xa54
[ 219.852481] update_process_times+0x60/0x9c
[ 219.856493] tick_sched_timer+0x70/0x1d0
[ 219.860738] __hrtimer_run_queues+0x134/0x1d0
[ 219.864763] hrtimer_interrupt+0xf0/0x2ac
[ 219.868770] arch_timer_handler_phys+0x30/0x40
[ 219.873046] handle_percpu_devid_irq+0x98/0x150
[ 219.877088] __handle_domain_irq+0xa4/0x120
[ 219.881140] gic_handle_irq+0x50/0xb0
[ 219.885195] el1_irq+0xcc/0x180
[ 219.889220] arch_cpu_idle+0x18/0x30
[ 219.893254] do_idle+0x1d8/0x260
[ 219.897215] cpu_startup_entry+0x24/0x70
[ 219.901358] secondary_start_kernel+0x14c/0x1bc
[ 245.388020] INFO: task kworker/u8:1:188 blocked for more than 122 seconds.
[ 245.391615] Not tainted 5.4.176-flippy-69+o #379
[ 245.396694] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message.
[ 245.404460] kworker/u8:1 D 0 188 2 0x00000028
[ 245.409901] Workqueue: events_unbound fsnotify_mark_destroy_workfn
[ 245.416009] Call trace:
[ 245.418430] __switch_to+0x114/0x160
[ 245.421967] __schedule+0x210/0x4e0
[ 245.425414] schedule+0x3c/0xd0
[ 245.428520] schedule_timeout+0x174/0x1bc
[ 245.432487] wait_for_completion+0x90/0x120
[ 245.436629] __synchronize_srcu.part.0+0x70/0xe0
[ 245.441198] synchronize_srcu+0xf8/0x14c
[ 245.445088] fsnotify_mark_destroy_workfn+0x68/0xdc
[ 245.449909] process_one_work+0x1c8/0x324
[ 245.453874] worker_thread+0x244/0x450
[ 245.457591] kthread+0x13c/0x150
[ 245.460776] ret_from_fork+0x10/0x18
[ 245.464325] INFO: task udevadm:245 blocked for more than 122 seconds.
[ 245.470696] Not tainted 5.4.176-flippy-69+o #379
[ 245.475778] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message.
[ 245.483547] udevadm D 0 245 229 0x00000000
[ 245.488974] Call trace:
[ 245.491390] __switch_to+0x114/0x160
[ 245.494936] __schedule+0x210/0x4e0
[ 245.498375] schedule+0x3c/0xd0
[ 245.501482] schedule_timeout+0x174/0x1bc
[ 245.505450] wait_for_completion+0x90/0x120
[ 245.509591] __flush_work.isra.0+0x160/0x2d0
[ 245.513818] flush_delayed_work+0x38/0x60
[ 245.517785] fsnotify_wait_marks_destroyed+0x18/0x20
[ 245.522700] fsnotify_destroy_group+0x54/0xe0
[ 245.527011] inotify_release+0x1c/0x6c
[ 245.530724] __fput+0x88/0x210
[ 245.533738] ____fput+0xc/0x14
[ 245.536760] task_work_run+0x98/0xc0
[ 245.540295] do_notify_resume+0x534/0x900
[ 245.544264] work_pending+0x8/0x10
[ 282.807916] rcu: INFO: rcu_preempt self-detected stall on CPU
[ 282.812321] rcu: 2-...0: (1 GPs behind) idle=9f6/0/0x1 softirq=440/441 fqs=27093
[ 282.819818] (t=81915 jiffies g=-251 q=600)
[ 282.824227] Task dump for CPU 2:
[ 282.828894] swapper/2 R running task 0 0 1 0x0000002a
[ 282.834802] Call trace:
[ 282.839531] dump_backtrace+0x0/0x160
[ 282.844299] show_stack+0x14/0x20
[ 282.848760] sched_show_task+0xe0/0x104
[ 282.853222] dump_cpu_task+0x40/0x4c
[ 282.857879] rcu_dump_cpu_stacks+0x94/0xd0
[ 282.862206] rcu_sched_clock_irq+0x6f8/0xa54
[ 282.866709] update_process_times+0x60/0x9c
[ 282.871104] tick_sched_timer+0x70/0x1d0
[ 282.875177] __hrtimer_run_queues+0x134/0x1d0
[ 282.879473] hrtimer_interrupt+0xf0/0x2ac
[ 282.883774] arch_timer_handler_phys+0x30/0x40
[ 282.888118] handle_percpu_devid_irq+0x98/0x150
[ 282.892472] __handle_domain_irq+0xa4/0x120
[ 282.896592] gic_handle_irq+0x50/0xb0
[ 282.900952] el1_irq+0xcc/0x180
[ 282.905015] arch_cpu_idle+0x18/0x30
[ 282.909319] do_idle+0x1d8/0x260
[ 282.913575] cpu_startup_entry+0x24/0x70
[ 282.917576] secondary_start_kernel+0x14c/0x1bc
[ 345.817906] rcu: INFO: rcu_preempt self-detected stall on CPU
[ 345.822119] rcu: 2-...0: (1 GPs behind) idle=9f6/0/0x1 softirq=440/441 fqs=33342
[ 345.829615] (t=100818 jiffies g=-251 q=615)
[ 345.833840] Task dump for CPU 2:
[ 345.837946] swapper/2 R running task 0 0 1 0x0000002a
[ 345.844017] Call trace:
[ 345.848230] dump_backtrace+0x0/0x160
[ 345.852208] show_stack+0x14/0x20
[ 345.856420] sched_show_task+0xe0/0x104
[ 345.860662] dump_cpu_task+0x40/0x4c
[ 345.864655] rcu_dump_cpu_stacks+0x94/0xd0
[ 345.868934] rcu_sched_clock_irq+0x6f8/0xa54
[ 345.872962] update_process_times+0x60/0x9c
[ 345.876980] tick_sched_timer+0x70/0x1d0
[ 345.880981] __hrtimer_run_queues+0x134/0x1d0
[ 345.884983] hrtimer_interrupt+0xf0/0x2ac
[ 345.889232] arch_timer_handler_phys+0x30/0x40
[ 345.893492] handle_percpu_devid_irq+0x98/0x150
[ 345.897763] __handle_domain_irq+0xa4/0x120
[ 345.901813] gic_handle_irq+0x50/0xb0
[ 345.905863] el1_irq+0xcc/0x180
[ 345.910137] arch_cpu_idle+0x18/0x30
[ 345.914169] do_idle+0x1d8/0x260
[ 345.918125] cpu_startup_entry+0x24/0x70
[ 345.922251] secondary_start_kernel+0x14c/0x1bc
[ 368.268000] INFO: task kworker/u8:1:188 blocked for more than 245 seconds.
[ 368.270907] Not tainted 5.4.176-flippy-69+o #379
[ 368.276007] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message.
[ 368.283769] kworker/u8:1 D 0 188 2 0x00000028
[ 368.289206] Workqueue: events_unbound fsnotify_mark_destroy_workfn
[ 368.295321] Call trace:
[ 368.297731] __switch_to+0x114/0x160
[ 368.301278] __schedule+0x210/0x4e0
[ 368.304723] schedule+0x3c/0xd0
[ 368.307823] schedule_timeout+0x174/0x1bc
[ 368.311797] wait_for_completion+0x90/0x120
[ 368.315939] __synchronize_srcu.part.0+0x70/0xe0
[ 368.320507] synchronize_srcu+0xf8/0x14c
[ 368.324389] fsnotify_mark_destroy_workfn+0x68/0xdc
[ 368.329220] process_one_work+0x1c8/0x324
[ 368.333186] worker_thread+0x244/0x450
[ 368.336896] kthread+0x13c/0x150
[ 368.340087] ret_from_fork+0x10/0x18
[ 368.343635] INFO: task udevadm:245 blocked for more than 245 seconds.
[ 368.350004] Not tainted 5.4.176-flippy-69+o #379
[ 368.355090] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message.
[ 368.362854] udevadm D 0 245 229 0x00000000
[ 368.368288] Call trace:
[ 368.370696] __switch_to+0x114/0x160
[ 368.374242] __schedule+0x210/0x4e0
[ 368.377709] schedule+0x3c/0xd0
[ 368.380797] schedule_timeout+0x174/0x1bc
[ 368.384766] wait_for_completion+0x90/0x120
[ 368.388907] __flush_work.isra.0+0x160/0x2d0
[ 368.393131] flush_delayed_work+0x38/0x60
[ 368.397099] fsnotify_wait_marks_destroyed+0x18/0x20
[ 368.402014] fsnotify_destroy_group+0x54/0xe0
[ 368.406325] inotify_release+0x1c/0x6c
[ 368.410039] __fput+0x88/0x210
[ 368.413053] ____fput+0xc/0x14
[ 368.416073] task_work_run+0x98/0xc0
[ 368.419609] do_notify_resume+0x534/0x900
[ 368.423577] work_pending+0x8/0x10
[ 408.827891] rcu: INFO: rcu_preempt self-detected stall on CPU
[ 408.832282] rcu: 2-...0: (1 GPs behind) idle=9f6/0/0x1 softirq=440/441 fqs=39585
[ 408.839778] (t=119721 jiffies g=-251 q=615)
[ 408.844172] Task dump for CPU 2:
[ 408.848828] swapper/2 R running task 0 0 1 0x0000002a
[ 408.854729] Call trace:
[ 408.859150] dump_backtrace+0x0/0x160
[ 408.863609] show_stack+0x14/0x20
[ 408.868056] sched_show_task+0xe0/0x104
[ 408.872500] dump_cpu_task+0x40/0x4c
[ 408.876859] rcu_dump_cpu_stacks+0x94/0xd0
[ 408.881176] rcu_sched_clock_irq+0x6f8/0xa54
[ 408.885410] update_process_times+0x60/0x9c
[ 408.889805] tick_sched_timer+0x70/0x1d0
[ 408.894133] __hrtimer_run_queues+0x134/0x1d0
[ 408.898424] hrtimer_interrupt+0xf0/0x2ac
[ 408.902727] arch_timer_handler_phys+0x30/0x40
[ 408.906807] handle_percpu_devid_irq+0x98/0x150
[ 408.911162] __handle_domain_irq+0xa4/0x120
[ 408.915286] gic_handle_irq+0x50/0xb0
[ 408.919390] el1_irq+0xcc/0x180
[ 408.923719] arch_cpu_idle+0x18/0x30
[ 408.927772] do_idle+0x1d8/0x260
[ 408.932035] cpu_startup_entry+0x24/0x70
[ 408.936295] secondary_start_kernel+0x14c/0x1bc
[ 471.837879] rcu: INFO: rcu_preempt self-detected stall on CPU
[ 471.842088] rcu: 2-...0: (1 GPs behind) idle=9f6/0/0x1 softirq=440/441 fqs=45837
[ 471.849585] (t=138624 jiffies g=-251 q=615)
[ 471.854050] Task dump for CPU 2:
[ 471.858435] swapper/2 R running task 0 0 1 0x0000002a
[ 471.863985] Call trace:
[ 471.867951] dump_backtrace+0x0/0x160
[ 471.871938] show_stack+0x14/0x20
[ 471.876161] sched_show_task+0xe0/0x104
[ 471.880165] dump_cpu_task+0x40/0x4c
[ 471.884164] rcu_dump_cpu_stacks+0x94/0xd0
[ 471.888449] rcu_sched_clock_irq+0x6f8/0xa54
[ 471.892734] update_process_times+0x60/0x9c
[ 471.896767] tick_sched_timer+0x70/0x1d0
[ 471.900777] __hrtimer_run_queues+0x134/0x1d0
[ 471.904799] hrtimer_interrupt+0xf0/0x2ac
[ 471.908812] arch_timer_handler_phys+0x30/0x40
[ 471.913092] handle_percpu_devid_irq+0x98/0x150
[ 471.917375] __handle_domain_irq+0xa4/0x120
[ 471.921686] gic_handle_irq+0x50/0xb0
[ 471.925749] el1_irq+0xcc/0x180
[ 471.929787] arch_cpu_idle+0x18/0x30
[ 471.933830] do_idle+0x1d8/0x260
[ 471.937801] cpu_startup_entry+0x24/0x70
[ 471.941960] secondary_start_kernel+0x14c/0x1bc
[ 491.147966] INFO: task kworker/u8:1:188 blocked for more than 368 seconds.
[ 491.150866] Not tainted 5.4.176-flippy-69+o #379
[ 491.155967] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message.
[ 491.163728] kworker/u8:1 D 0 188 2 0x00000028
[ 491.169164] Workqueue: events_unbound fsnotify_mark_destroy_workfn
[ 491.175282] Call trace:
[ 491.177689] __switch_to+0x114/0x160
[ 491.181237] __schedule+0x210/0x4e0
[ 491.184684] schedule+0x3c/0xd0
[ 491.187781] schedule_timeout+0x174/0x1bc
[ 491.191757] wait_for_completion+0x90/0x120
[ 491.195897] __synchronize_srcu.part.0+0x70/0xe0
[ 491.200468] synchronize_srcu+0xf8/0x14c
[ 491.204351] fsnotify_mark_destroy_workfn+0x68/0xdc
[ 491.209180] process_one_work+0x1c8/0x324
[ 491.213146] worker_thread+0x244/0x450
[ 491.216857] kthread+0x13c/0x150
[ 491.220046] ret_from_fork+0x10/0x18
[ 491.223596] INFO: task udevadm:245 blocked for more than 368 seconds.
[ 491.229964] Not tainted 5.4.176-flippy-69+o #379
[ 491.235050] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message.
[ 491.242813] udevadm D 0 245 229 0x00000000
[ 491.248248] Call trace:
[ 491.250658] __switch_to+0x114/0x160
[ 491.254202] __schedule+0x210/0x4e0
[ 491.257651] schedule+0x3c/0xd0
[ 491.260756] schedule_timeout+0x174/0x1bc
[ 491.264726] wait_for_completion+0x90/0x120
[ 491.268865] __flush_work.isra.0+0x160/0x2d0
[ 491.273092] flush_delayed_work+0x38/0x60
[ 491.277058] fsnotify_wait_marks_destroyed+0x18/0x20
[ 491.281974] fsnotify_destroy_group+0x54/0xe0
[ 491.286285] inotify_release+0x1c/0x6c
[ 491.289998] __fput+0x88/0x210
[ 491.293012] ____fput+0xc/0x14
[ 491.296033] task_work_run+0x98/0xc0
[ 491.299568] do_notify_resume+0x534/0x900
[ 491.303538] work_pending+0x8/0x10
[ 534.847867] rcu: INFO: rcu_preempt self-detected stall on CPU
[ 534.852239] rcu: 2-...0: (1 GPs behind) idle=9f6/0/0x1 softirq=440/441 fqs=52088
[ 534.859738] (t=157527 jiffies g=-251 q=615)
[ 534.864411] Task dump for CPU 2:
[ 534.868777] swapper/2 R running task 0 0 1 0x0000002a
[ 534.874672] Call trace:
[ 534.879376] dump_backtrace+0x0/0x160
[ 534.884115] show_stack+0x14/0x20
[ 534.888554] sched_show_task+0xe0/0x104
[ 534.893277] dump_cpu_task+0x40/0x4c
[ 534.897918] rcu_dump_cpu_stacks+0x94/0xd0
[ 534.902236] rcu_sched_clock_irq+0x6f8/0xa54
[ 534.906470] update_process_times+0x60/0x9c
[ 534.910865] tick_sched_timer+0x70/0x1d0
[ 534.914934] __hrtimer_run_queues+0x134/0x1d0
[ 534.919225] hrtimer_interrupt+0xf0/0x2ac
[ 534.923271] arch_timer_handler_phys+0x30/0x40
[ 534.927349] handle_percpu_devid_irq+0x98/0x150
[ 534.931706] __handle_domain_irq+0xa4/0x120
[ 534.935822] gic_handle_irq+0x50/0xb0
[ 534.939927] el1_irq+0xcc/0x180
[ 534.944256] arch_cpu_idle+0x18/0x30
[ 534.948569] do_idle+0x1d8/0x260
[ 534.952575] cpu_startup_entry+0x24/0x70
[ 534.956582] secondary_start_kernel+0x14c/0x1bc
[ 597.857852] rcu: INFO: rcu_preempt self-detected stall on CPU
[ 597.862054] rcu: 2-...0: (1 GPs behind) idle=9f6/0/0x1 softirq=440/441 fqs=58339
[ 597.869554] (t=176430 jiffies g=-251 q=615)
[ 597.874005] Task dump for CPU 2:
[ 597.878117] swapper/2 R running task 0 0 1 0x0000002a
[ 597.883954] Call trace:
[ 597.887923] dump_backtrace+0x0/0x160
[ 597.892155] show_stack+0x14/0x20
[ 597.896383] sched_show_task+0xe0/0x104
[ 597.900630] dump_cpu_task+0x40/0x4c
[ 597.904880] rcu_dump_cpu_stacks+0x94/0xd0
[ 597.908918] rcu_sched_clock_irq+0x6f8/0xa54
[ 597.912959] update_process_times+0x60/0x9c
[ 597.917242] tick_sched_timer+0x70/0x1d0
[ 597.921266] __hrtimer_run_queues+0x134/0x1d0
[ 597.925297] hrtimer_interrupt+0xf0/0x2ac
[ 597.929575] arch_timer_handler_phys+0x30/0x40
[ 597.933866] handle_percpu_devid_irq+0x98/0x150
[ 597.938156] __handle_domain_irq+0xa4/0x120
[ 597.942224] gic_handle_irq+0x50/0xb0
[ 597.946543] el1_irq+0xcc/0x180
[ 597.950840] arch_cpu_idle+0x18/0x30
[ 597.954893] do_idle+0x1d8/0x260
[ 597.958867] cpu_startup_entry+0x24/0x70
[ 597.963027] secondary_start_kernel+0x14c/0x1bc
[ 614.027942] INFO: task kworker/u8:1:188 blocked for more than 491 seconds.
[ 614.030844] Not tainted 5.4.176-flippy-69+o #379
[ 614.035953] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message.
[ 614.043706] kworker/u8:1 D 0 188 2 0x00000028
[ 614.049142] Workqueue: events_unbound fsnotify_mark_destroy_workfn
[ 614.055259] Call trace:
[ 614.057669] __switch_to+0x114/0x160
[ 614.061214] __schedule+0x210/0x4e0
[ 614.064662] schedule+0x3c/0xd0
[ 614.067758] schedule_timeout+0x174/0x1bc
[ 614.071735] wait_for_completion+0x90/0x120
[ 614.075874] __synchronize_srcu.part.0+0x70/0xe0
[ 614.080446] synchronize_srcu+0xf8/0x14c
[ 614.084327] fsnotify_mark_destroy_workfn+0x68/0xdc
[ 614.089158] process_one_work+0x1c8/0x324
[ 614.093124] worker_thread+0x244/0x450
[ 614.096835] kthread+0x13c/0x150
[ 614.100026] ret_from_fork+0x10/0x18
[ 614.103572] INFO: task udevadm:245 blocked for more than 491 seconds.
[ 614.109942] Not tainted 5.4.176-flippy-69+o #379
[ 614.115028] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message.
[ 614.122791] udevadm D 0 245 229 0x00000000
[ 614.128226] Call trace:
[ 614.130634] __switch_to+0x114/0x160
[ 614.134180] __schedule+0x210/0x4e0
[ 614.137629] schedule+0x3c/0xd0
[ 614.140734] schedule_timeout+0x174/0x1bc
[ 614.144702] wait_for_completion+0x90/0x120
[ 614.148843] __flush_work.isra.0+0x160/0x2d0
[ 614.153068] flush_delayed_work+0x38/0x60
[ 614.157035] fsnotify_wait_marks_destroyed+0x18/0x20
[ 614.161951] fsnotify_destroy_group+0x54/0xe0
[ 614.166263] inotify_release+0x1c/0x6c
[ 614.169975] __fput+0x88/0x210
[ 614.172991] ____fput+0xc/0x14
[ 614.176010] task_work_run+0x98/0xc0
[ 614.179546] do_notify_resume+0x534/0x900
[ 614.183515] work_pending+0x8/0x10
[ 660.867840] rcu: INFO: rcu_preempt self-detected stall on CPU
[ 660.872227] rcu: 2-...0: (1 GPs behind) idle=9f6/0/0x1 softirq=440/441 fqs=64593
[ 660.879725] (t=195333 jiffies g=-251 q=615)
[ 660.884414] Task dump for CPU 2:
[ 660.889084] swapper/2 R running task 0 0 1 0x0000002a
[ 660.895271] Call trace:
[ 660.899697] dump_backtrace+0x0/0x160
[ 660.904458] show_stack+0x14/0x20
[ 660.909207] sched_show_task+0xe0/0x104
[ 660.913671] dump_cpu_task+0x40/0x4c
[ 660.918332] rcu_dump_cpu_stacks+0x94/0xd0
[ 660.922660] rcu_sched_clock_irq+0x6f8/0xa54
[ 660.926897] update_process_times+0x60/0x9c
[ 660.931302] tick_sched_timer+0x70/0x1d0
[ 660.935641] __hrtimer_run_queues+0x134/0x1d0
[ 660.939944] hrtimer_interrupt+0xf0/0x2ac
[ 660.944252] arch_timer_handler_phys+0x30/0x40
[ 660.948339] handle_percpu_devid_irq+0x98/0x150
[ 660.952703] __handle_domain_irq+0xa4/0x120
[ 660.957094] gic_handle_irq+0x50/0xb0
[ 660.961466] el1_irq+0xcc/0x180
[ 660.965543] arch_cpu_idle+0x18/0x30
[ 660.969857] do_idle+0x1d8/0x260
[ 660.973871] cpu_startup_entry+0x24/0x70
[ 660.977885] secondary_start_kernel+0x14c/0x1bc
[ 723.877827] rcu: INFO: rcu_preempt self-detected stall on CPU
[ 723.882042] rcu: 2-...0: (1 GPs behind) idle=9f6/0/0x1 softirq=440/441 fqs=70839
[ 723.889541] (t=214236 jiffies g=-251 q=615)
[ 723.893764] Task dump for CPU 2:
[ 723.897890] swapper/2 R running task 0 0 1 0x0000002a
[ 723.903941] Call trace:
[ 723.907913] dump_backtrace+0x0/0x160
[ 723.912159] show_stack+0x14/0x20
[ 723.916145] sched_show_task+0xe0/0x104
[ 723.920157] dump_cpu_task+0x40/0x4c
[ 723.924165] rcu_dump_cpu_stacks+0x94/0xd0
[ 723.928459] rcu_sched_clock_irq+0x6f8/0xa54
[ 723.932503] update_process_times+0x60/0x9c
[ 723.936798] tick_sched_timer+0x70/0x1d0
[ 723.941079] __hrtimer_run_queues+0x134/0x1d0
[ 723.945113] hrtimer_interrupt+0xf0/0x2ac
[ 723.949142] arch_timer_handler_phys+0x30/0x40
[ 723.953442] handle_percpu_devid_irq+0x98/0x150
[ 723.957743] __handle_domain_irq+0xa4/0x120
[ 723.961815] gic_handle_irq+0x50/0xb0
[ 723.965883] el1_irq+0xcc/0x180
[ 723.970185] arch_cpu_idle+0x18/0x30
[ 723.974240] do_idle+0x1d8/0x260
[ 723.978219] cpu_startup_entry+0x24/0x70
[ 723.982138] secondary_start_kernel+0x14c/0x1bc
[ 736.907907] INFO: task kworker/u8:1:188 blocked for more than 614 seconds.
[ 736.910814] Not tainted 5.4.176-flippy-69+o #379
[ 736.915909] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message.
[ 736.923677] kworker/u8:1 D 0 188 2 0x00000028
[ 736.929110] Workqueue: events_unbound fsnotify_mark_destroy_workfn
[ 736.935228] Call trace:
[ 736.937637] __switch_to+0x114/0x160
[ 736.941184] __schedule+0x210/0x4e0
[ 736.944629] schedule+0x3c/0xd0
[ 736.947727] schedule_timeout+0x174/0x1bc
[ 736.951703] wait_for_completion+0x90/0x120
[ 736.955845] __synchronize_srcu.part.0+0x70/0xe0
[ 736.960415] synchronize_srcu+0xf8/0x14c
[ 736.964296] fsnotify_mark_destroy_workfn+0x68/0xdc
[ 736.969127] process_one_work+0x1c8/0x324
[ 736.973093] worker_thread+0x244/0x450
[ 736.976803] kthread+0x13c/0x150
[ 736.979995] ret_from_fork+0x10/0x18
[ 736.983541] INFO: task udevadm:245 blocked for more than 614 seconds.
[ 736.989911] Not tainted 5.4.176-flippy-69+o #379
[ 736.994997] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message.
[ 737.002760] udevadm D 0 245 229 0x00000000
[ 737.008197] Call trace:
[ 737.010603] __switch_to+0x114/0x160
[ 737.014150] __schedule+0x210/0x4e0
[ 737.017597] schedule+0x3c/0xd0
[ 737.020703] schedule_timeout+0x174/0x1bc
[ 737.024671] wait_for_completion+0x90/0x120
[ 737.028813] __flush_work.isra.0+0x160/0x2d0
[ 737.033038] flush_delayed_work+0x38/0x60
[ 737.037005] fsnotify_wait_marks_destroyed+0x18/0x20
[ 737.041921] fsnotify_destroy_group+0x54/0xe0
[ 737.046232] inotify_release+0x1c/0x6c
[ 737.049945] __fput+0x88/0x210
[ 737.052960] ____fput+0xc/0x14
[ 737.055981] task_work_run+0x98/0xc0
[ 737.059516] do_notify_resume+0x534/0x900
[ 737.063484] work_pending+0x8/0x10

[ophub]

你测试下5.10的固件