| lists.openwall.net | lists / announce owl-users owl-dev john-users john-dev passwdqc-users yescrypt popa3d-users / oss-security kernel-hardening musl sabotage tlsify passwords / crypt-dev xvendor / Bugtraq Full-Disclosure linux-kernel linux-netdev linux-ext4 linux-hardening linux-cve-announce PHC | |
|
Open Source and information security mailing list archives
| ||
|
Message-ID: <CAH2r5mtHeuo609uom0QFFv_YJZteLgGnSZUr+7_87iKGxPhvQA@mail.gmail.com> Date: Tue, 5 Aug 2025 12:10:54 -0500 From: Steve French <smfrench@...il.com> To: LKML <linux-kernel@...r.kernel.org> Subject: RIP with collect_percpu-times() in 6.17-rc Anyone seeing this RIP in collect_percpu_times() with current mainline (6.17-rc) from a few days ago? Has it been fixed in the last couple days? I saw this running xfstest generic/007. [Tue Aug 5 11:31:54 2025] RIP: 0010:collect_percpu_times+0x4c7/0x540 [Tue Aug 5 11:31:54 2025] Code: 00 00 00 c7 40 0c 00 00 00 00 48 c7 40 14 00 00 00 00 48 81 c4 68 01 00 00 5b 5d 41 5c 41 5d 41 5e 41 5f c3 cc cc cc cc f3 90 <4c> 89 ef e8 91 3b 49 00 48 8b 44 24 08 4c 8b 74 24 20 e9 15 fd ff [Tue Aug 5 11:31:54 2025] RSP: 0018:ff1100010a8cfae8 EFLAGS: 00000202 [Tue Aug 5 11:31:54 2025] RAX: 0000000000000000 RBX: ffd1ffffffc1f0c0 RCX: dffffc0000000000 [Tue Aug 5 11:31:54 2025] RDX: 0000000000000003 RSI: 0000000000000000 RDI: ff110004cb22cec0 [Tue Aug 5 11:31:54 2025] RBP: ffffffffa3e09ec0 R08: ffffffffa03e5db3 R09: 0000000000000001 [Tue Aug 5 11:31:54 2025] R10: ffffffffa2fe80e7 R11: 0000000000000000 R12: 0000000000000004 [Tue Aug 5 11:31:54 2025] R13: ffffffffa2479040 R14: 0000000000015b31 R15: ff1100010a8cfbb0 [Tue Aug 5 11:31:54 2025] FS: 0000000000000000(0000) GS:ff11000527423000(0000) knlGS:0000000000000000 [Tue Aug 5 11:31:54 2025] CS: 0010 DS: 0000 ES: 0000 CR0: 0000000080050033 [Tue Aug 5 11:31:54 2025] CR2: 00007f667ca4d050 CR3: 000000013596e003 CR4: 0000000000373ef0 [Tue Aug 5 11:31:54 2025] Call Trace: [Tue Aug 5 11:31:54 2025] <TASK> [Tue Aug 5 11:31:54 2025] ? __pfx_collect_percpu_times+0x10/0x10 [Tue Aug 5 11:31:54 2025] psi_avgs_work+0x89/0x140 [Tue Aug 5 11:31:54 2025] ? __pfx_psi_avgs_work+0x10/0x10 [Tue Aug 5 11:31:54 2025] ? lock_release+0xc4/0x270 [Tue Aug 5 11:31:54 2025] ? rcu_is_watching+0x20/0x50 [Tue Aug 5 11:31:54 2025] process_one_work+0x4bf/0xb40 [Tue Aug 5 11:31:54 2025] ? __pfx_process_one_work+0x10/0x10 [Tue Aug 5 11:31:54 2025] ? assign_work+0xd6/0x110 [Tue Aug 5 11:31:54 2025] worker_thread+0x2c9/0x550 [Tue Aug 5 11:31:54 2025] ? __pfx_worker_thread+0x10/0x10 [Tue Aug 5 11:31:54 2025] kthread+0x216/0x3e0 [Tue Aug 5 11:31:54 2025] ? __pfx_kthread+0x10/0x10 [Tue Aug 5 11:31:54 2025] ? __pfx_kthread+0x10/0x10 [Tue Aug 5 11:31:54 2025] ? lock_release+0xc4/0x270 [Tue Aug 5 11:31:54 2025] ? rcu_is_watching+0x20/0x50 [Tue Aug 5 11:31:54 2025] ? __pfx_kthread+0x10/0x10 [Tue Aug 5 11:31:54 2025] ret_from_fork+0x23a/0x2e0 [Tue Aug 5 11:31:54 2025] ? __pfx_kthread+0x10/0x10 [Tue Aug 5 11:31:54 2025] ret_from_fork_asm+0x1a/0x30 [Tue Aug 5 11:31:54 2025] </TASK> [Tue Aug 5 11:33:14 2025] watchdog: BUG: soft lockup - CPU#4 stuck for 24s! [kworker/4:26:39273] [Tue Aug 5 11:33:14 2025] Modules linked in: cifs(E) ccm(E) cmac(E) nls_utf8(E) cifs_arc4(E) nls_ucs2_utils(E) cifs_md4(E) rpcsec_gss_krb5(E) auth_rpcgss(E) nfsv4(E) dns_resolver(E) nfs(E) lockd(E) grace(E) netfs(E) nf_conntrack_netbios_ns(E) nf_conntrack_broadcast(E) nft_fib_inet(E) nft_fib_ipv4(E) nft_fib_ipv6(E) nft_fib(E) nft_reject_inet(E) nf_reject_ipv4(E) nf_reject_ipv6(E) nft_reject(E) nft_ct(E) nft_chain_nat(E) nf_nat(E) nf_conntrack(E) nf_defrag_ipv6(E) nf_defrag_ipv4(E) nf_tables(E) ip_set(E) sunrpc(E) kvm_intel(E) kvm(E) irqbypass(E) virtio_net(E) virtio_balloon(E) net_failover(E) failover(E) dm_multipath(E) loop(E) fuse(E) nfnetlink(E) zram(E) xfs(E) bochs(E) drm_client_lib(E) drm_shmem_helper(E) drm_kms_helper(E) floppy(E) ghash_clmulni_intel(E) drm(E) virtio_blk(E) qemu_fw_cfg(E) virtio_console(E) [last unloaded: cifs(E)] [Tue Aug 5 11:33:14 2025] irq event stamp: 69288 [Tue Aug 5 11:33:14 2025] hardirqs last enabled at (69287): [<ffffffffa00015ca>] asm_sysvec_apic_timer_interrupt+0x1a/0x20 [Tue Aug 5 11:33:14 2025] hardirqs last disabled at (69288): [<ffffffffa19a7fef>] sysvec_apic_timer_interrupt+0xf/0x90 [Tue Aug 5 11:33:14 2025] softirqs last enabled at (69194): [<ffffffffa0325785>] __irq_exit_rcu+0x135/0x160 [Tue Aug 5 11:33:14 2025] softirqs last disabled at (69189): [<ffffffffa0325785>] __irq_exit_rcu+0x135/0x160 [Tue Aug 5 11:33:14 2025] CPU: 4 UID: 0 PID: 39273 Comm: kworker/4:26 Tainted: G EL 6.16.0 #1 PREEMPT(voluntary) [Tue Aug 5 11:33:14 2025] Tainted: [E]=UNSIGNED_MODULE, [L]=SOFTLOCKUP [Tue Aug 5 11:33:14 2025] Hardware name: Red Hat KVM, BIOS 1.16.3-4.el9 04/01/2014 [Tue Aug 5 11:33:14 2025] Workqueue: events psi_avgs_work [Tue Aug 5 11:33:14 2025] RIP: 0010:collect_percpu_times+0x4c7/0x540 [Tue Aug 5 11:33:14 2025] Code: 00 00 00 c7 40 0c 00 00 00 00 48 c7 40 14 00 00 00 00 48 81 c4 68 01 00 00 5b 5d 41 5c 41 5d 41 5e 41 5f c3 cc cc cc cc f3 90 <4c> 89 ef e8 91 3b 49 00 48 8b 44 24 08 4c 8b 74 24 20 e9 15 fd ff [Tue Aug 5 11:33:14 2025] RSP: 0018:ff1100012d167ae8 EFLAGS: 00000202 [Tue Aug 5 11:33:14 2025] RAX: 0000000000000000 RBX: ffd1ffffffc252c0 RCX: dffffc0000000000 [Tue Aug 5 11:33:14 2025] RDX: 0000000000000003 RSI: 0000000000000000 RDI: ff110004cb22cec0 [Tue Aug 5 11:33:14 2025] RBP: ffffffffa3e09ec0 R08: ffffffffa03e5db3 R09: 0000000000000001 [Tue Aug 5 11:33:14 2025] R10: ffffffffa2fe80e7 R11: 0000000000000000 R12: 0000000000000004 [Tue Aug 5 11:33:14 2025] R13: ffffffffa2479040 R14: 000000000003ccdf R15: ff1100012d167bb0 [Tue Aug 5 11:33:14 2025] FS: 0000000000000000(0000) GS:ff11000527423000(0000) knlGS:0000000000000000 [Tue Aug 5 11:33:14 2025] CS: 0010 DS: 0000 ES: 0000 CR0: 0000000080050033 [Tue Aug 5 11:33:14 2025] CR2: 00007f667ca4d050 CR3: 00000001ff668005 CR4: 0000000000373ef0 [Tue Aug 5 11:33:14 2025] Call Trace: [Tue Aug 5 11:33:14 2025] <TASK> [Tue Aug 5 11:33:14 2025] ? __pfx_collect_percpu_times+0x10/0x10 [Tue Aug 5 11:33:14 2025] psi_avgs_work+0x89/0x140 [Tue Aug 5 11:33:14 2025] ? __pfx_psi_avgs_work+0x10/0x10 [Tue Aug 5 11:33:14 2025] ? lock_release+0xc4/0x270 [Tue Aug 5 11:33:14 2025] ? rcu_is_watching+0x20/0x50 [Tue Aug 5 11:33:14 2025] process_one_work+0x4bf/0xb40 [Tue Aug 5 11:33:14 2025] ? __pfx_process_one_work+0x10/0x10 [Tue Aug 5 11:33:14 2025] ? assign_work+0xd6/0x110 [Tue Aug 5 11:33:14 2025] worker_thread+0x2c9/0x550 [Tue Aug 5 11:33:14 2025] ? __pfx_worker_thread+0x10/0x10 [Tue Aug 5 11:33:14 2025] kthread+0x216/0x3e0 [Tue Aug 5 11:33:14 2025] ? __pfx_kthread+0x10/0x10 [Tue Aug 5 11:33:14 2025] ? __pfx_kthread+0x10/0x10 [Tue Aug 5 11:33:14 2025] ? lock_release+0xc4/0x270 [Tue Aug 5 11:33:14 2025] ? rcu_is_watching+0x20/0x50 [Tue Aug 5 11:33:14 2025] ? __pfx_kthread+0x10/0x10 [Tue Aug 5 11:33:14 2025] ret_from_fork+0x23a/0x2e0 [Tue Aug 5 11:33:14 2025] ? __pfx_kthread+0x10/0x10 [Tue Aug 5 11:33:14 2025] ret_from_fork_asm+0x1a/0x30 [Tue Aug 5 11:33:14 2025] </TASK> [Tue Aug 5 11:34:34 2025] watchdog: BUG: soft lockup - CPU#4 stuck for 24s! [kworker/4:9:39164] [Tue Aug 5 11:34:34 2025] Modules linked in: cifs(E) ccm(E) cmac(E) nls_utf8(E) cifs_arc4(E) nls_ucs2_utils(E) cifs_md4(E) rpcsec_gss_krb5(E) auth_rpcgss(E) nfsv4(E) dns_resolver(E) nfs(E) lockd(E) grace(E) netfs(E) nf_conntrack_netbios_ns(E) nf_conntrack_broadcast(E) nft_fib_inet(E) nft_fib_ipv4(E) nft_fib_ipv6(E) nft_fib(E) nft_reject_inet(E) nf_reject_ipv4(E) nf_reject_ipv6(E) nft_reject(E) nft_ct(E) nft_chain_nat(E) nf_nat(E) nf_conntrack(E) nf_defrag_ipv6(E) nf_defrag_ipv4(E) nf_tables(E) ip_set(E) sunrpc(E) kvm_intel(E) kvm(E) irqbypass(E) virtio_net(E) virtio_balloon(E) net_failover(E) failover(E) dm_multipath(E) loop(E) fuse(E) nfnetlink(E) zram(E) xfs(E) bochs(E) drm_client_lib(E) drm_shmem_helper(E) drm_kms_helper(E) floppy(E) ghash_clmulni_intel(E) drm(E) virtio_blk(E) qemu_fw_cfg(E) virtio_console(E) [last unloaded: cifs(E)] [Tue Aug 5 11:34:34 2025] irq event stamp: 209596 [Tue Aug 5 11:34:34 2025] hardirqs last enabled at (209595): [<ffffffffa00015ca>] asm_sysvec_apic_timer_interrupt+0x1a/0x20 [Tue Aug 5 11:34:34 2025] hardirqs last disabled at (209596): [<ffffffffa19a7fef>] sysvec_apic_timer_interrupt+0xf/0x90 [Tue Aug 5 11:34:34 2025] softirqs last enabled at (209542): [<ffffffffa0325785>] __irq_exit_rcu+0x135/0x160 [Tue Aug 5 11:34:34 2025] softirqs last disabled at (209521): [<ffffffffa0325785>] __irq_exit_rcu+0x135/0x160 [Tue Aug 5 11:34:34 2025] CPU: 4 UID: 0 PID: 39164 Comm: kworker/4:9 Tainted: G EL 6.16.0 #1 PREEMPT(voluntary) [Tue Aug 5 11:34:34 2025] Tainted: [E]=UNSIGNED_MODULE, [L]=SOFTLOCKUP [Tue Aug 5 11:34:34 2025] Hardware name: Red Hat KVM, BIOS 1.16.3-4.el9 04/01/2014 [Tue Aug 5 11:34:34 2025] Workqueue: events psi_avgs_work [Tue Aug 5 11:34:34 2025] RIP: 0010:collect_percpu_times+0x4c7/0x540 [Tue Aug 5 11:34:34 2025] Code: 00 00 00 c7 40 0c 00 00 00 00 48 c7 40 14 00 00 00 00 48 81 c4 68 01 00 00 5b 5d 41 5c 41 5d 41 5e 41 5f c3 cc cc cc cc f3 90 <4c> 89 ef e8 91 3b 49 00 48 8b 44 24 08 4c 8b 74 24 20 e9 15 fd ff [Tue Aug 5 11:34:34 2025] RSP: 0018:ff1100012f61fae8 EFLAGS: 00000202 [Tue Aug 5 11:34:34 2025] RAX: 0000000000000000 RBX: ffd1ffffffc2da80 RCX: dffffc0000000000 [Tue Aug 5 11:34:34 2025] RDX: 0000000000000003 RSI: 0000000000000000 RDI: ff110004cb22cec0 [Tue Aug 5 11:34:34 2025] RBP: ffffffffa3e09ec0 R08: ffffffffa03e5db3 R09: 0000000000000001 [Tue Aug 5 11:34:34 2025] R10: ffffffffa2fe80e7 R11: 0000000000000000 R12: 0000000000000004 [Tue Aug 5 11:34:34 2025] R13: ffffffffa2479040 R14: 0000000000063e7d R15: ff1100012f61fbb0 [Tue Aug 5 11:34:34 2025] FS: 0000000000000000(0000) GS:ff11000527423000(0000) knlGS:0000000000000000 [Tue Aug 5 11:34:34 2025] CS: 0010 DS: 0000 ES: 0000 CR0: 0000000080050033 [Tue Aug 5 11:34:34 2025] CR2: 00007f667ca4d050 CR3: 00000001ff668005 CR4: 0000000000373ef0 [Tue Aug 5 11:34:34 2025] Call Trace: [Tue Aug 5 11:34:34 2025] <TASK> [Tue Aug 5 11:34:34 2025] ? __pfx_collect_percpu_times+0x10/0x10 [Tue Aug 5 11:34:34 2025] psi_avgs_work+0x89/0x140 [Tue Aug 5 11:34:34 2025] ? __pfx_psi_avgs_work+0x10/0x10 [Tue Aug 5 11:34:34 2025] ? lock_release+0xc4/0x270 [Tue Aug 5 11:34:34 2025] ? rcu_is_watching+0x20/0x50 [Tue Aug 5 11:34:34 2025] process_one_work+0x4bf/0xb40 [Tue Aug 5 11:34:34 2025] ? __pfx_process_one_work+0x10/0x10 [Tue Aug 5 11:34:34 2025] ? assign_work+0xd6/0x110 [Tue Aug 5 11:34:34 2025] worker_thread+0x2c9/0x550 [Tue Aug 5 11:34:34 2025] ? __pfx_worker_thread+0x10/0x10 [Tue Aug 5 11:34:34 2025] kthread+0x216/0x3e0 [Tue Aug 5 11:34:34 2025] ? __pfx_kthread+0x10/0x10 [Tue Aug 5 11:34:34 2025] ? __pfx_kthread+0x10/0x10 [Tue Aug 5 11:34:34 2025] ? lock_release+0xc4/0x270 [Tue Aug 5 11:34:34 2025] ? rcu_is_watching+0x20/0x50 [Tue Aug 5 11:34:34 2025] ? __pfx_kthread+0x10/0x10 [Tue Aug 5 11:34:34 2025] ret_from_fork+0x23a/0x2e0 [Tue Aug 5 11:34:34 2025] ? __pfx_kthread+0x10/0x10 [Tue Aug 5 11:34:34 2025] ret_from_fork_asm+0x1a/0x30 [Tue Aug 5 11:34:34 2025] </TASK> -- Thanks, Steve
Powered by blists - more mailing lists