Xorg and systemd-journal using a lot of cpu time

My system has been a bit slow for the last couple of days, and then checked the cpu usage and saw that Xorg was using one core constantly, and systemd-journal was also using basically one core. I then checked journalctl, and the log was flooded with kernel messages (I even had messages from systemd-journald that it was missing thousand of messages per second). This is an exerpt:

sep 09 13:31:35 carl-e14 kernel: FS:  00007f9d388f26c0(0000) GS:ffff8cd3ff800000(0000) knlGS:0000000000>
sep 09 13:31:35 carl-e14 systemd-journald[313]: Missed 2259 kernel messages
sep 09 13:31:35 carl-e14 kernel:  __x64_sys_ioctl+0x98/0xe0
sep 09 13:31:35 carl-e14 kernel:  do_syscall_64+0x5c/0x90
sep 09 13:31:35 carl-e14 kernel:  ? do_syscall_64+0x68/0x90
sep 09 13:31:35 carl-e14 kernel:  ? do_syscall_64+0x68/0x90
sep 09 13:31:35 carl-e14 kernel:  ? do_syscall_64+0x68/0x90
sep 09 13:31:35 carl-e14 kernel:  ? do_syscall_64+0x68/0x90
sep 09 13:31:35 carl-e14 kernel:  entry_SYSCALL_64_after_hwframe+0x62/0xcc
sep 09 13:31:35 carl-e14 kernel: RIP: 0033:0x7fc1dcdf09df
sep 09 13:31:35 carl-e14 kernel: Code: 00 48 89 44 24 18 31 c0 48 8d 44 24 60 c7 04 24 10 00 00 00 48 8>
sep 09 13:31:35 carl-e14 kernel: RSP: 002b:00007fc1b6efea30 EFLAGS: 00000246 ORIG_RAX: 0000000000000010
sep 09 13:31:35 carl-e14 kernel: RAX: ffffffffffffffda RBX: 00007fc1b6efebc8 RCX: 00007fc1dcdf09df
sep 09 13:31:35 carl-e14 kernel: RDX: 00007fc1b6efeaf0 RSI: 00000000c0186444 RDI: 000000000000002b
sep 09 13:31:35 carl-e14 kernel: RBP: 00007fc1b6efeaf0 R08: 00007fc1b6efec30 R09: 00007fc1b6efead0
sep 09 13:31:35 carl-e14 kernel: R10: 00007fc1c0f19f00 R11: 0000000000000246 R12: 00000000c0186444
sep 09 13:31:35 carl-e14 kernel: R13: 000000000000002b R14: 0000000000000003 R15: 00007fc1b6efebc8
sep 09 13:31:35 carl-e14 kernel:  </TASK>
sep 09 13:31:35 carl-e14 kernel: ---[ end trace c28bc65766e63f19 ]---
sep 09 13:31:35 carl-e14 kernel:  ? amdgpu_cs_find_mapping+0x110/0x110 [amdgpu 59bb2b54778d3125c1b153c1>
sep 09 13:31:35 carl-e14 kernel: ------------[ cut here ]------------
sep 09 13:31:35 carl-e14 kernel:  amdgpu_drm_ioctl+0x4a/0x90 [amdgpu 59bb2b54778d3125c1b153c1a01f9a8546>
sep 09 13:31:35 carl-e14 kernel: WARNING: CPU: 1 PID: 3829 at include/linux/dma-fence.h:478 amdgpu_sync>
sep 09 13:31:35 carl-e14 kernel:  __x64_sys_ioctl+0x98/0xe0
sep 09 13:31:35 carl-e14 kernel:  do_syscall_64+0x5c/0x90
sep 09 13:31:35 carl-e14 kernel:  ? syscall_exit_to_user_mode+0x31/0x50
sep 09 13:31:35 carl-e14 kernel:  ? do_syscall_64+0x68/0x90
sep 09 13:31:35 carl-e14 kernel:  ? syscall_exit_to_user_mode+0x31/0x50
sep 09 13:31:35 carl-e14 kernel:  ? do_syscall_64+0x68/0x90
sep 09 13:31:35 carl-e14 kernel:  ? syscall_exit_to_user_mode+0x31/0x50
sep 09 13:31:35 carl-e14 kernel:  ? do_syscall_64+0x68/0x90
sep 09 13:31:35 carl-e14 kernel:  ? do_syscall_64+0x68/0x90
sep 09 13:31:35 carl-e14 kernel: Modules linked in: btrfs
sep 09 13:31:35 carl-e14 kernel:  ? do_syscall_64+0x68/0x90
sep 09 13:31:35 carl-e14 kernel:  blake2b_generic xor raid6_pq
sep 09 13:31:35 carl-e14 kernel:  entry_SYSCALL_64_after_hwframe+0x62/0xcc
sep 09 13:31:35 carl-e14 kernel:  ufs hfsplus
sep 09 13:31:35 carl-e14 kernel: RIP: 0033:0x7f9d4566f9df
sep 09 13:31:35 carl-e14 kernel:  hfs cdrom minix
sep 09 13:31:35 carl-e14 kernel: Code: 00 48 89 44 24 18 31 c0 48 8d 44 24 60 c7 04 24 10 00 00 00 48 8>
sep 09 13:31:35 carl-e14 kernel:  msdos jfs xfs
sep 09 13:31:35 carl-e14 kernel: RSP: 002b:00007f9d388f18c0 EFLAGS: 00000246
sep 09 13:31:35 carl-e14 kernel:  libcrc32c rfcomm
sep 09 13:31:35 carl-e14 kernel:  ORIG_RAX: 0000000000000010
sep 09 13:31:35 carl-e14 kernel:  ccm
sep 09 13:31:35 carl-e14 kernel: RAX: ffffffffffffffda RBX: 00007f9d388f1a58 RCX: 00007f9d4566f9df
sep 09 13:31:35 carl-e14 kernel:  qrtr joydev
lines 1-47...skipping...
sep 09 13:31:35 carl-e14 kernel: FS:  00007f9d388f26c0(0000) GS:ffff8cd3ff800000(0000) knlGS:0000000000000000
sep 09 13:31:35 carl-e14 systemd-journald[313]: Missed 2259 kernel messages
sep 09 13:31:35 carl-e14 kernel:  __x64_sys_ioctl+0x98/0xe0
sep 09 13:31:35 carl-e14 kernel:  do_syscall_64+0x5c/0x90
sep 09 13:31:35 carl-e14 kernel:  ? do_syscall_64+0x68/0x90
sep 09 13:31:35 carl-e14 kernel:  ? do_syscall_64+0x68/0x90
sep 09 13:31:35 carl-e14 kernel:  ? do_syscall_64+0x68/0x90
sep 09 13:31:35 carl-e14 kernel:  ? do_syscall_64+0x68/0x90
sep 09 13:31:35 carl-e14 kernel:  entry_SYSCALL_64_after_hwframe+0x62/0xcc
sep 09 13:31:35 carl-e14 kernel: RIP: 0033:0x7fc1dcdf09df
sep 09 13:31:35 carl-e14 kernel: Code: 00 48 89 44 24 18 31 c0 48 8d 44 24 60 c7 04 24 10 00 00 00 48 89 44 24 08 48 8d 44 24 20 48 89 44 24 10 b8 10 00 00 00 0f 05 <89> c2 3d 00 f0 ff ff 77 18 48 8b 44 24 18 64 >
sep 09 13:31:35 carl-e14 kernel: RSP: 002b:00007fc1b6efea30 EFLAGS: 00000246 ORIG_RAX: 0000000000000010
sep 09 13:31:35 carl-e14 kernel: RAX: ffffffffffffffda RBX: 00007fc1b6efebc8 RCX: 00007fc1dcdf09df
sep 09 13:31:35 carl-e14 kernel: RDX: 00007fc1b6efeaf0 RSI: 00000000c0186444 RDI: 000000000000002b
sep 09 13:31:35 carl-e14 kernel: RBP: 00007fc1b6efeaf0 R08: 00007fc1b6efec30 R09: 00007fc1b6efead0
sep 09 13:31:35 carl-e14 kernel: R10: 00007fc1c0f19f00 R11: 0000000000000246 R12: 00000000c0186444
sep 09 13:31:35 carl-e14 kernel: R13: 000000000000002b R14: 0000000000000003 R15: 00007fc1b6efebc8
sep 09 13:31:35 carl-e14 kernel:  </TASK>
sep 09 13:31:35 carl-e14 kernel: ---[ end trace c28bc65766e63f19 ]---
sep 09 13:31:35 carl-e14 kernel:  ? amdgpu_cs_find_mapping+0x110/0x110 [amdgpu 59bb2b54778d3125c1b153c1a01f9a8546f99263]
sep 09 13:31:35 carl-e14 kernel: ------------[ cut here ]------------
sep 09 13:31:35 carl-e14 kernel:  amdgpu_drm_ioctl+0x4a/0x90 [amdgpu 59bb2b54778d3125c1b153c1a01f9a8546f99263]
sep 09 13:31:35 carl-e14 kernel: WARNING: CPU: 1 PID: 3829 at include/linux/dma-fence.h:478 amdgpu_sync_keep_later+0x80/0xc0 [amdgpu]
sep 09 13:31:35 carl-e14 kernel:  __x64_sys_ioctl+0x98/0xe0
sep 09 13:31:35 carl-e14 kernel:  do_syscall_64+0x5c/0x90
sep 09 13:31:35 carl-e14 kernel:  ? syscall_exit_to_user_mode+0x31/0x50
sep 09 13:31:35 carl-e14 kernel:  ? do_syscall_64+0x68/0x90
sep 09 13:31:35 carl-e14 kernel:  ? syscall_exit_to_user_mode+0x31/0x50
sep 09 13:31:35 carl-e14 kernel:  ? do_syscall_64+0x68/0x90
sep 09 13:31:35 carl-e14 kernel:  ? syscall_exit_to_user_mode+0x31/0x50
sep 09 13:31:35 carl-e14 kernel:  ? do_syscall_64+0x68/0x90
sep 09 13:31:35 carl-e14 kernel:  ? do_syscall_64+0x68/0x90
sep 09 13:31:35 carl-e14 kernel: Modules linked in: btrfs
sep 09 13:31:35 carl-e14 kernel:  ? do_syscall_64+0x68/0x90
sep 09 13:31:35 carl-e14 kernel:  blake2b_generic xor raid6_pq
sep 09 13:31:35 carl-e14 kernel:  entry_SYSCALL_64_after_hwframe+0x62/0xcc
sep 09 13:31:35 carl-e14 kernel:  ufs hfsplus
sep 09 13:31:35 carl-e14 kernel: RIP: 0033:0x7f9d4566f9df
sep 09 13:31:35 carl-e14 kernel:  hfs cdrom minix
sep 09 13:31:35 carl-e14 kernel: Code: 00 48 89 44 24 18 31 c0 48 8d 44 24 60 c7 04 24 10 00 00 00 48 89 44 24 08 48 8d 44 24 20 48 89 44 24 10 b8 10 00 00 00 0f 05 <89> c2 3d 00 f0 ff ff 77 18 48 8b 44 24 18 64 >
sep 09 13:31:35 carl-e14 kernel:  msdos jfs xfs
sep 09 13:31:35 carl-e14 kernel: RSP: 002b:00007f9d388f18c0 EFLAGS: 00000246
sep 09 13:31:35 carl-e14 kernel:  libcrc32c rfcomm
sep 09 13:31:35 carl-e14 kernel:  ORIG_RAX: 0000000000000010
sep 09 13:31:35 carl-e14 kernel:  ccm
sep 09 13:31:35 carl-e14 kernel: RAX: ffffffffffffffda RBX: 00007f9d388f1a58 RCX: 00007f9d4566f9df
sep 09 13:31:35 carl-e14 kernel:  qrtr joydev
sep 09 13:31:35 carl-e14 kernel: RDX: 00007f9d388f1980 RSI: 00000000c0186444 RDI: 0000000000000010
sep 09 13:31:35 carl-e14 kernel:  mousedev

I then upgraded the kernel from 5.15.128-1 to 6.1.49-1, which seemed to resolve the issue (both Xorg and systemd-journal are back at normal cpu loads and the kernel is no longer flooding the log with messages).

Does anyone know what’s going on?

Someone has reported what looks like the same issue with 5.15.128 here;

1 Like

Thank you, I’ll keep an eye on that