One cpu core always 100% - rk3399

[denni_isl]

Hi folks,

This is a bit strange.   One core is constantly at 100% on a  firefly-rk3399 board.

It seems to be because of some emmc issues according to this output.

 

Quote

$ ps aux --sort=-pcpu | head
USER       PID %CPU %MEM    VSZ   RSS TTY      STAT START   TIME COMMAND
root       226 91.9  0.0      0     0 ?        R    09:23   5:41 [kworker/u12:1+brcmf_wq/mmc0:0001:1]

 

Quote

uname -a
Linux firefly-rk3399 5.8.17-rockchip64 #20.08.21 SMP PREEMPT Sat Oct 31 08:22:59 CET 2020 aarch64 GNU/Linux

 

journalctl -f

 

Spoiler

journalctl -f
-- Logs begin at Sun 2020-11-22 09:23:31 UTC. --
Nov 22 09:24:55 firefly-rk3399 systemd[1]: Reached target Graphical Interface.
Nov 22 09:24:55 firefly-rk3399 systemd[1]: Starting Update UTMP about System Runlevel Changes...
Nov 22 09:24:55 firefly-rk3399 systemd[1]: systemd-update-utmp-runlevel.service: Succeeded.
Nov 22 09:24:55 firefly-rk3399 systemd[1]: Started Update UTMP about System Runlevel Changes.
Nov 22 09:24:55 firefly-rk3399 systemd[1]: Startup finished in 16.550s (kernel) + 1min 31.073s (userspace) = 1min 47.623s.
Nov 22 09:25:01 firefly-rk3399 CRON[2474]: pam_unix(cron:session): session opened for user root by (uid=0)
Nov 22 09:25:01 firefly-rk3399 CRON[2475]: (root) CMD (command -v debian-sa1 > /dev/null && debian-sa1 1 1)
Nov 22 09:25:01 firefly-rk3399 CRON[2474]: pam_unix(cron:session): session closed for user root
Nov 22 09:26:44 firefly-rk3399 su[2751]: (to root) steini on pts/1
Nov 22 09:26:44 firefly-rk3399 su[2751]: pam_unix(su:session): session opened for user root by (uid=1000)
Nov 22 09:28:04 firefly-rk3399 sudo[2815]:   steini : TTY=pts/2 ; PWD=/home/steini ; USER=root ; COMMAND=/usr/bin/apt install px
Nov 22 09:28:04 firefly-rk3399 sudo[2815]: pam_unix(sudo:session): session opened for user root by (uid=0)
Nov 22 09:28:25 firefly-rk3399 sudo[2815]: pam_unix(sudo:session): session closed for user root
Nov 22 09:30:01 firefly-rk3399 CRON[3075]: pam_unix(cron:session): session opened for user root by (uid=0)
Nov 22 09:30:01 firefly-rk3399 CRON[3076]: (root) CMD (/usr/lib/armbian/armbian-truncate-logs)
Nov 22 09:30:01 firefly-rk3399 CRON[3075]: pam_unix(cron:session): session closed for user root
Nov 22 09:34:50 firefly-rk3399 dbus-daemon[741]: [system] Activating via systemd: service name='org.freedesktop.hostname1' unit='dbus-org.freedesktop.hostname1.service' requested by ':1.70' (uid=1000 pid=2518 comm="/usr/lib/firefox-esr/firefox-esr ")
Nov 22 09:34:50 firefly-rk3399 systemd[1]: Starting Hostname Service...
Nov 22 09:34:50 firefly-rk3399 dbus-daemon[741]: [system] Successfully activated service 'org.freedesktop.hostname1'
Nov 22 09:34:50 firefly-rk3399 systemd[1]: Started Hostname Service.
Nov 22 09:34:50 firefly-rk3399 org.gtk.vfs.Daemon[1527]: mkdir failed on directory /var/cache/samba: Permission denied
Nov 22 09:34:50 firefly-rk3399 org.gtk.vfs.Daemon[1527]: mkdir failed on directory /var/cache/samba: Permission denied
Nov 22 09:34:51 firefly-rk3399 org.gtk.vfs.Daemon[1527]: mkdir failed on directory /var/cache/samba: Permission denied
Nov 22 09:34:51 firefly-rk3399 org.gtk.vfs.Daemon[1527]: mkdir failed on directory /var/cache/samba: Permission denied
Nov 22 09:34:51 firefly-rk3399 org.gtk.vfs.Daemon[1527]: mkdir failed on directory /var/cache/samba: Permission denied
Nov 22 09:34:52 firefly-rk3399 org.gtk.vfs.Daemon[1527]: mkdir failed on directory /var/cache/samba: Permission denied
Nov 22 09:34:52 firefly-rk3399 org.gtk.vfs.Daemon[1527]: mkdir failed on directory /var/cache/samba: Permission denied
Nov 22 09:34:52 firefly-rk3399 org.gtk.vfs.Daemon[1527]: mkdir failed on directory /var/cache/samba: Permission denied
Nov 22 09:34:52 firefly-rk3399 org.gtk.vfs.Daemon[1527]: mkdir failed on directory /var/cache/samba: Permission denied
Nov 22 09:34:52 firefly-rk3399 org.gtk.vfs.Daemon[1527]: mkdir failed on directory /var/cache/samba: Permission denied
Nov 22 09:34:52 firefly-rk3399 org.gtk.vfs.Daemon[1527]: mkdir failed on directory /var/cache/samba: Permission denied
Nov 22 09:35:01 firefly-rk3399 CRON[3447]: pam_unix(cron:session): session opened for user root by (uid=0)
Nov 22 09:35:01 firefly-rk3399 CRON[3448]: (root) CMD (command -v debian-sa1 > /dev/null && debian-sa1 1 1)
Nov 22 09:35:01 firefly-rk3399 CRON[3447]: pam_unix(cron:session): session closed for user root
Nov 22 09:35:20 firefly-rk3399 systemd[1]: systemd-hostnamed.service: Succeeded.
Nov 22 09:38:39 firefly-rk3399 systemd[1]: Starting Cleanup of Temporary Directories...
Nov 22 09:38:39 firefly-rk3399 systemd-tmpfiles[3625]: [/usr/lib/tmpfiles.d/speech-dispatcher.conf:1] Line references path below legacy directory /var/run/, updating /var/run/speech-dispatcher → /run/speech-dispatcher; please update the tmpfiles.d/ drop-in file accordingly.
Nov 22 09:38:39 firefly-rk3399 systemd-tmpfiles[3625]: [/usr/lib/tmpfiles.d/speech-dispatcher.conf:2] Line references path below legacy directory /var/run/, updating /var/run/speech-dispatcher/.cache → /run/speech-dispatcher/.cache; please update the tmpfiles.d/ drop-in file accordingly.
Nov 22 09:38:39 firefly-rk3399 systemd-tmpfiles[3625]: [/usr/lib/tmpfiles.d/speech-dispatcher.conf:3] Line references path below legacy directory /var/run/, updating /var/run/speech-dispatcher/.speech-dispatcher → /run/speech-dispatcher/.speech-dispatcher; please update the tmpfiles.d/ drop-in file accordingly.
Nov 22 09:38:39 firefly-rk3399 systemd-tmpfiles[3625]: [/usr/lib/tmpfiles.d/speech-dispatcher.conf:4] Line references path below legacy directory /var/run/, updating /var/run/speech-dispatcher/.cache/speech-dispatcher → /run/speech-dispatcher/.cache/speech-dispatcher; please update the tmpfiles.d/ drop-in file accordingly.
Nov 22 09:38:39 firefly-rk3399 systemd-tmpfiles[3625]: [/usr/lib/tmpfiles.d/speech-dispatcher.conf:5] Line references path below legacy directory /var/run/, updating /var/run/speech-dispatcher/log → /run/speech-dispatcher/log; please update the tmpfiles.d/ drop-in file accordingly.
Nov 22 09:38:39 firefly-rk3399 systemd[1]: systemd-tmpfiles-clean.service: Succeeded.
Nov 22 09:38:39 firefly-rk3399 systemd[1]: Started Cleanup of Temporary Directories.

 

This is htop

 

[NicolasA]

Hi @denni_isl,

 

Did you find a solution to this problem ?

 

I believe this is coming from the Wifi driver brcmfmac. I noticed the same behavior on my RockPi 4 B when using a weird firmware from Broadcom instead of Cypress (brcmfmac43456-sdio.bin   version 7.84.17.1).

 

# strings /lib/firmware/brcm/brcmfmac43456-sdio.bin | tail -n 1
43455c5-roml/43455_sdio-pno-aoe-pktfilter-pktctx-lpc-pwropt-43455_ftrs-mfp-noclminc-clm_min Version: 7.84.17.1 (r871554) CRC: 72494685 Date: Thu 2020-05-14 17:41:11 KST Ucode Ver: 1043.20424 FWID: 01-3d9e1d87

 

Once reverted to the firmware provided with Armbian, this issue disappeared.

[whitefox]

I have a similar question. Did you find a solution to this problem?

One core is constantly at 50% on a  orangepi-rk3399 board.

 

I turned off the buggy module for now

modprobe -r brcmfmac
echo "blacklist brcmfmac" >> /etc/modprobe.d/blacklist.conf

 

more detal 

root@orangepi-rk3399:~# uname -a
Linux orangepi-rk3399 5.15.49-rockchip64 #trunk SMP PREEMPT Wed Jun 22 22:41:59 UTC 2022 aarch64 aarch64 aarch64 GNU/Linux

# strings /lib/firmware/brcm/brcmfmac43456-sdio.bin | tail -n 1
43455c5-roml/43455_sdio-pno-aoe-pktfilter-bcm_ftrs-ak-bcol-clm_4335_ss-sr-mchan-pktctx-lpc-pwropt-txbf-wl11u-wapi-txpwr-wepso-gscan-linkstat-pwrstats-proxd-ndoe-mfp-tdls-dhcpd-idauth-idsup-neeze-akiss-dfsctl-apcs-tka-wpf-gtr-noplmt-ak_disassoc-b5gctl-sdiorxenhance Version: 7.45.96.61 (be7af2d@shgit) (r745790) CRC: 279731d4 Date: Tue 2020-02-11 11:55:51 CST Ucode Ver: 1043.20721 FWID: 01-a41d86bd

 

I found solution 

 

Цитата

 

You need to switch firmware to another version :

 

 

Edited June 24, 2022 by whitefox