[syzbot] WARNING in kfree_rcu_work

From: syzbot
Date: Mon Nov 21 2022 - 11:09:03 EST

Next message: Abel Vesa: "Re: [PATCH v5 0/2] clk: imx8mp: Add audio shared gate"
Previous message: syzbot: "[syzbot] WARNING: refcount bug in p9_client_walk"
Messages sorted by: [ date ] [ thread ] [ subject ] [ author ]

Hello,

syzbot found the following issue on:

HEAD commit: 9500fc6e9e60 Merge branch 'for-next/core' into for-kernelci
git tree: git://git.kernel.org/pub/scm/linux/kernel/git/arm64/linux.git for-kernelci
console output: https://syzkaller.appspot.com/x/log.txt?x=121adaf9880000
kernel config: https://syzkaller.appspot.com/x/.config?x=b25c9f218686dd5e
dashboard link: https://syzkaller.appspot.com/bug?extid=f6ec2d932b89616d83c7
compiler: Debian clang version 13.0.1-++20220126092033+75e33f71c2da-1~exp1~20220126212112.63, GNU ld (GNU Binutils for Debian) 2.35.2
userspace arch: arm64
syz repro: https://syzkaller.appspot.com/x/repro.syz?x=1538c909880000
C reproducer: https://syzkaller.appspot.com/x/repro.c?x=16e5ce19880000

Downloadable assets:
disk image: https://storage.googleapis.com/syzbot-assets/1363e60652f7/disk-9500fc6e.raw.xz
vmlinux: https://storage.googleapis.com/syzbot-assets/fcc4da811bb6/vmlinux-9500fc6e.xz
kernel image: https://storage.googleapis.com/syzbot-assets/0b554298f1fa/Image-9500fc6e.gz.xz

IMPORTANT: if you fix the issue, please add the following tag to the commit:
Reported-by: syzbot+f6ec2d932b89616d83c7@xxxxxxxxxxxxxxxxxxxxxxxxx

------------[ cut here ]------------
ODEBUG: active_state not available (active state 0) object type: rcu_head hint: 0x0
WARNING: CPU: 1 PID: 21 at lib/debugobjects.c:505 debug_print_object lib/debugobjects.c:502 [inline]
WARNING: CPU: 1 PID: 21 at lib/debugobjects.c:505 debug_object_active_state+0x174/0x1dc lib/debugobjects.c:948
Modules linked in:
CPU: 1 PID: 21 Comm: kworker/1:0 Not tainted 6.1.0-rc5-syzkaller-32269-g9500fc6e9e60 #0
Hardware name: Google Google Compute Engine/Google Compute Engine, BIOS Google 09/30/2022
Workqueue: events kfree_rcu_work
pstate: 60400005 (nZCv daif +PAN -UAO -TCO -DIT -SSBS BTYPE=--)
pc : debug_print_object lib/debugobjects.c:502 [inline]
pc : debug_object_active_state+0x174/0x1dc lib/debugobjects.c:948
lr : debug_print_object lib/debugobjects.c:502 [inline]
lr : debug_object_active_state+0x174/0x1dc lib/debugobjects.c:948
sp : ffff80000f33bcc0
x29: ffff80000f33bcc0 x28: 0000000000000150 x27: 0000000000000000
x26: 0000000000000000 x25: ffff0001fefde3e8 x24: 0000000000000000
x23: 0000000000000001 x22: 0000000000000000 x21: ffff80000f175000
x20: ffff0000cc581000 x19: ffff80000c0eec40 x18: 0000000000000225
x17: ffff80000c0ed83c x16: ffff80000dc18158 x15: ffff0000c0331a40
x14: 0000000000000000 x13: 00000000ffffffff x12: ffff0000c0331a40
x11: ff808000081c6510 x10: 0000000000000000 x9 : e93e9ee3facb8300
x8 : e93e9ee3facb8300 x7 : ffff800008165f54 x6 : 0000000000000000
x5 : 0000000000000080 x4 : 0000000000000001 x3 : 0000000000000000
x2 : 0000000000000006 x1 : 0000000100000000 x0 : 0000000000000053
Call trace:
debug_print_object lib/debugobjects.c:502 [inline]
debug_object_active_state+0x174/0x1dc lib/debugobjects.c:948
debug_rcu_head_unqueue kernel/rcu/rcu.h:198 [inline]
debug_rcu_bhead_unqueue kernel/rcu/tree.c:2933 [inline]
kfree_rcu_work+0xa8/0x31c kernel/rcu/tree.c:3032
process_one_work+0x2d8/0x504 kernel/workqueue.c:2289
worker_thread+0x340/0x610 kernel/workqueue.c:2436
kthread+0x12c/0x158 kernel/kthread.c:376
ret_from_fork+0x10/0x20 arch/arm64/kernel/entry.S:863
irq event stamp: 109630
hardirqs last enabled at (109629): [<ffff800008165fe4>] raw_spin_rq_unlock_irq kernel/sched/sched.h:1366 [inline]
hardirqs last enabled at (109629): [<ffff800008165fe4>] finish_lock_switch+0x94/0xe8 kernel/sched/core.c:4950
hardirqs last disabled at (109630): [<ffff80000c0a4f34>] el1_dbg+0x24/0x80 arch/arm64/kernel/entry-common.c:405
softirqs last enabled at (97456): [<ffff8000080102e4>] _stext+0x2e4/0x37c
softirqs last disabled at (96913): [<ffff800008017c88>] ____do_softirq+0x14/0x20 arch/arm64/kernel/irq.c:79
---[ end trace 0000000000000000 ]---
------------[ cut here ]------------
ODEBUG: deactivate not available (active state 0) object type: rcu_head hint: 0x0
WARNING: CPU: 1 PID: 21 at lib/debugobjects.c:505 debug_print_object lib/debugobjects.c:502 [inline]
WARNING: CPU: 1 PID: 21 at lib/debugobjects.c:505 debug_object_deactivate+0x128/0x1dc lib/debugobjects.c:760
Modules linked in:
CPU: 1 PID: 21 Comm: kworker/1:0 Tainted: G W 6.1.0-rc5-syzkaller-32269-g9500fc6e9e60 #0
Hardware name: Google Google Compute Engine/Google Compute Engine, BIOS Google 09/30/2022
Workqueue: events kfree_rcu_work
pstate: 60400005 (nZCv daif +PAN -UAO -TCO -DIT -SSBS BTYPE=--)
pc : debug_print_object lib/debugobjects.c:502 [inline]
pc : debug_object_deactivate+0x128/0x1dc lib/debugobjects.c:760
lr : debug_print_object lib/debugobjects.c:502 [inline]
lr : debug_object_deactivate+0x128/0x1dc lib/debugobjects.c:760
sp : ffff80000f33bcd0
x29: ffff80000f33bcd0 x28: 0000000000000150 x27: 0000000000000000
x26: 0000000000000000 x25: ffff0001fefde3e8 x24: 0000000000000000
x23: ffff0000cc581000 x22: 0000000000000000 x21: ffff80000f175000
x20: ffff0000cc581000 x19: ffff80000c0eec40 x18: 0000000000000313
x17: 72203a6570797420 x16: ffff80000dc18158 x15: ffff0000c0331a40
x14: 0000000000000000 x13: 00000000ffffffff x12: ffff0000c0331a40
x11: ff808000081c6510 x10: 0000000000000000 x9 : e93e9ee3facb8300
x8 : e93e9ee3facb8300 x7 : ffff800008165f54 x6 : 0000000000000000
x5 : 0000000000000080 x4 : 0000000000000001 x3 : 0000000000000000
x2 : 0000000000000006 x1 : 0000000100000000 x0 : 0000000000000051
Call trace:
debug_print_object lib/debugobjects.c:502 [inline]
debug_object_deactivate+0x128/0x1dc lib/debugobjects.c:760
debug_rcu_head_unqueue kernel/rcu/rcu.h:201 [inline]
debug_rcu_bhead_unqueue kernel/rcu/tree.c:2933 [inline]
kfree_rcu_work+0xb4/0x31c kernel/rcu/tree.c:3032
process_one_work+0x2d8/0x504 kernel/workqueue.c:2289
worker_thread+0x340/0x610 kernel/workqueue.c:2436
kthread+0x12c/0x158 kernel/kthread.c:376
ret_from_fork+0x10/0x20 arch/arm64/kernel/entry.S:863
irq event stamp: 109762
hardirqs last enabled at (109761): [<ffff800008165fe4>] raw_spin_rq_unlock_irq kernel/sched/sched.h:1366 [inline]
hardirqs last enabled at (109761): [<ffff800008165fe4>] finish_lock_switch+0x94/0xe8 kernel/sched/core.c:4950
hardirqs last disabled at (109762): [<ffff80000c0a4f34>] el1_dbg+0x24/0x80 arch/arm64/kernel/entry-common.c:405
softirqs last enabled at (109754): [<ffff8000080102e4>] _stext+0x2e4/0x37c
softirqs last disabled at (109737): [<ffff800008017c88>] ____do_softirq+0x14/0x20 arch/arm64/kernel/irq.c:79
---[ end trace 0000000000000000 ]---
------------[ cut here ]------------
ODEBUG: active_state not available (active state 0) object type: rcu_head hint: 0x0
WARNING: CPU: 1 PID: 21 at lib/debugobjects.c:505 debug_print_object lib/debugobjects.c:502 [inline]
WARNING: CPU: 1 PID: 21 at lib/debugobjects.c:505 debug_object_active_state+0x174/0x1dc lib/debugobjects.c:948
Modules linked in:
CPU: 1 PID: 21 Comm: kworker/1:0 Tainted: G W 6.1.0-rc5-syzkaller-32269-g9500fc6e9e60 #0
Hardware name: Google Google Compute Engine/Google Compute Engine, BIOS Google 09/30/2022
Workqueue: events kfree_rcu_work

pstate: 60400005 (nZCv daif +PAN -UAO -TCO -DIT -SSBS BTYPE=--)
pc : debug_print_object lib/debugobjects.c:502 [inline]
pc : debug_object_active_state+0x174/0x1dc lib/debugobjects.c:948
lr : debug_print_object lib/debugobjects.c:502 [inline]
lr : debug_object_active_state+0x174/0x1dc lib/debugobjects.c:948
sp : ffff80000f33bcc0
x29: ffff80000f33bcc0
x28: 0000000000000151
x27: 0000000000000000

x26: 0000000000000000
x25: ffff0001fefde3e8
x24: 0000000000000000

x23: 0000000000000001
x22: 0000000000000000
x21: ffff80000f175000
x20: ffff0000cc581100
x19: ffff80000c0eec40 x18: 0000000000000313
x17: 2020202020205720 x16: 2020202020202047 x15: 203a6465746e6961
x14: 5420353331726f74 x13: 205d383734335420 x12: 5b5d373438373031
x11: ff808000081c6510 x10: 0000000000000000 x9 : e93e9ee3facb8300
x8 : e93e9ee3facb8300 x7 : 205b5d3734383730 x6 : ffff8000081c880c
x5 : 0000000000000000 x4 : 0000000000000001 x3 : 0000000000000000
x2 : ffff0000c0331a40 x1 : 0000000100000000 x0 : 0000000000000053
Call trace:
debug_print_object lib/debugobjects.c:502 [inline]
debug_object_active_state+0x174/0x1dc lib/debugobjects.c:948
debug_rcu_head_unqueue kernel/rcu/rcu.h:198 [inline]
debug_rcu_bhead_unqueue kernel/rcu/tree.c:2933 [inline]
kfree_rcu_work+0xa8/0x31c kernel/rcu/tree.c:3032
process_one_work+0x2d8/0x504 kernel/workqueue.c:2289
worker_thread+0x340/0x610 kernel/workqueue.c:2436
kthread+0x12c/0x158 kernel/kthread.c:376
ret_from_fork+0x10/0x20 arch/arm64/kernel/entry.S:863
irq event stamp: 109762
hardirqs last enabled at (109761): [<ffff800008165fe4>] raw_spin_rq_unlock_irq kernel/sched/sched.h:1366 [inline]
hardirqs last enabled at (109761): [<ffff800008165fe4>] finish_lock_switch+0x94/0xe8 kernel/sched/core.c:4950
hardirqs last disabled at (109762): [<ffff80000c0a4f34>] el1_dbg+0x24/0x80 arch/arm64/kernel/entry-common.c:405
softirqs last enabled at (109754): [<ffff8000080102e4>] _stext+0x2e4/0x37c
softirqs last disabled at (109737): [<ffff800008017c88>] ____do_softirq+0x14/0x20 arch/arm64/kernel/irq.c:79
---[ end trace 0000000000000000 ]---
------------[ cut here ]------------
ODEBUG: deactivate not available (active state 0) object type: rcu_head hint: 0x0
WARNING: CPU: 1 PID: 21 at lib/debugobjects.c:505 debug_print_object lib/debugobjects.c:502 [inline]
WARNING: CPU: 1 PID: 21 at lib/debugobjects.c:505 debug_object_deactivate+0x128/0x1dc lib/debugobjects.c:760
Modules linked in:
CPU: 1 PID: 21 Comm: kworker/1:0 Tainted: G W 6.1.0-rc5-syzkaller-32269-g9500fc6e9e60 #0
Hardware name: Google Google Compute Engine/Google Compute Engine, BIOS Google 09/30/2022
Workqueue: events kfree_rcu_work
pstate: 60400005 (nZCv daif +PAN -UAO -TCO -DIT -SSBS BTYPE=--)
pc : debug_print_object lib/debugobjects.c:502 [inline]
pc : debug_object_deactivate+0x128/0x1dc lib/debugobjects.c:760
lr : debug_print_object lib/debugobjects.c:502 [inline]
lr : debug_object_deactivate+0x128/0x1dc lib/debugobjects.c:760
sp : ffff80000f33bcd0
x29: ffff80000f33bcd0 x28: 0000000000000151 x27: 0000000000000000
x26: 0000000000000000 x25: ffff0001fefde3e8 x24: 0000000000000000
x23: ffff0000cc581100 x22: 0000000000000000 x21: ffff80000f175000
x20: ffff0000cc581100 x19: ffff80000c0eec40 x18: 00000000000000ff
x17: 0000000000000000 x16: 0000000000000117 x15: 0000000000000018
x14: 0000000002d879f3 x13: 0000000000000120 x12: 0000000000000000
x11: ff808000081c6510 x10: 0000000000000000 x9 : e93e9ee3facb8300
x8 : e93e9ee3facb8300 x7 : 00000000000f4240 x6 : ffff800008165f54
x5 : 0000000000000000 x4 : 0000000000000001 x3 : 0000000000000000
x2 : ffff0000c0331a40 x1 : 0000000100000000 x0 : 0000000000000051
Call trace:
debug_print_object lib/debugobjects.c:502 [inline]
debug_object_deactivate+0x128/0x1dc lib/debugobjects.c:760
debug_rcu_head_unqueue kernel/rcu/rcu.h:201 [inline]
debug_rcu_bhead_unqueue kernel/rcu/tree.c:2933 [inline]
kfree_rcu_work+0xb4/0x31c kernel/rcu/tree.c:3032
process_one_work+0x2d8/0x504 kernel/workqueue.c:2289
worker_thread+0x340/0x610 kernel/workqueue.c:2436
kthread+0x12c/0x158 kernel/kthread.c:376
ret_from_fork+0x10/0x20 arch/arm64/kernel/entry.S:863
irq event stamp: 109762
hardirqs last enabled at (109761): [<ffff800008165fe4>] raw_spin_rq_unlock_irq kernel/sched/sched.h:1366 [inline]
hardirqs last enabled at (109761): [<ffff800008165fe4>] finish_lock_switch+0x94/0xe8 kernel/sched/core.c:4950
hardirqs last disabled at (109762): [<ffff80000c0a4f34>] el1_dbg+0x24/0x80 arch/arm64/kernel/entry-common.c:405
softirqs last enabled at (109754): [<ffff8000080102e4>] _stext+0x2e4/0x37c
softirqs last disabled at (109737): [<ffff800008017c88>] ____do_softirq+0x14/0x20 arch/arm64/kernel/irq.c:79
---[ end trace 0000000000000000 ]---
------------[ cut here ]------------
ODEBUG: active_state not available (active state 0) object type: rcu_head hint: 0x0
WARNING: CPU: 1 PID: 21 at lib/debugobjects.c:505 debug_print_object lib/debugobjects.c:502 [inline]
WARNING: CPU: 1 PID: 21 at lib/debugobjects.c:505 debug_object_active_state+0x174/0x1dc lib/debugobjects.c:948
Modules linked in:
CPU: 1 PID: 21 Comm: kworker/1:0 Tainted: G W 6.1.0-rc5-syzkaller-32269-g9500fc6e9e60 #0
Hardware name: Google Google Compute Engine/Google Compute Engine, BIOS Google 09/30/2022
Workqueue: events kfree_rcu_work
pstate: 60400005 (nZCv daif +PAN -UAO -TCO -DIT -SSBS BTYPE=--)
pc : debug_print_object lib/debugobjects.c:502 [inline]
pc : debug_object_active_state+0x174/0x1dc lib/debugobjects.c:948
lr : debug_print_object lib/debugobjects.c:502 [inline]
lr : debug_object_active_state+0x174/0x1dc lib/debugobjects.c:948
sp : ffff80000f33bcc0
x29: ffff80000f33bcc0 x28: 0000000000000152 x27: 0000000000000000
x26: 0000000000000000 x25: ffff0001fefde3e8 x24: 0000000000000000
x23: 0000000000000001 x22: 0000000000000000 x21: ffff80000f175000
x20: ffff0000cc581280 x19: ffff80000c0eec40 x18: 00000000000000ff
x17: 3a65707974207463 x16: 656a626f20293020 x15: 6574617473206576
x14: 697463612820656c x13: 205d313254202020 x12: 5b5d373733313732
x11: ff808000081c6510 x10: 0000000000000000 x9 : e93e9ee3facb8300
x8 : e93e9ee3facb8300 x7 : 205b5d3737333137 x6 : ffff80000c0b2b74
x5 : 0000000000000000 x4 : 0000000000000001 x3 : 0000000000000000
x2 : 0000000000000000 x1 : 0000000100000000 x0 : 0000000000000053
Call trace:
debug_print_object lib/debugobjects.c:502 [inline]
debug_object_active_state+0x174/0x1dc lib/debugobjects.c:948
debug_rcu_head_unqueue kernel/rcu/rcu.h:198 [inline]
debug_rcu_bhead_unqueue kernel/rcu/tree.c:2933 [inline]
kfree_rcu_work+0xa8/0x31c kernel/rcu/tree.c:3032
process_one_work+0x2d8/0x504 kernel/workqueue.c:2289
worker_thread+0x340/0x610 kernel/workqueue.c:2436
kthread+0x12c/0x158 kernel/kthread.c:376
ret_from_fork+0x10/0x20 arch/arm64/kernel/entry.S:863
irq event stamp: 109762
hardirqs last enabled at (109761): [<ffff800008165fe4>] raw_spin_rq_unlock_irq kernel/sched/sched.h:1366 [inline]
hardirqs last enabled at (109761): [<ffff800008165fe4>] finish_lock_switch+0x94/0xe8 kernel/sched/core.c:4950
hardirqs last disabled at (109762): [<ffff80000c0a4f34>] el1_dbg+0x24/0x80 arch/arm64/kernel/entry-common.c:405
softirqs last enabled at (109754): [<ffff8000080102e4>] _stext+0x2e4/0x37c
softirqs last disabled at (109737): [<ffff800008017c88>] ____do_softirq+0x14/0x20 arch/arm64/kernel/irq.c:79
---[ end trace 0000000000000000 ]---

---
This report is generated by a bot. It may contain errors.
See https://goo.gl/tpsmEJ for more information about syzbot.
syzbot engineers can be reached at syzkaller@xxxxxxxxxxxxxxxx.

syzbot will keep track of this issue. See:
https://goo.gl/tpsmEJ#status for how to communicate with syzbot.
syzbot can test patches for this issue, for details see:
https://goo.gl/tpsmEJ#testing-patches

Next message: Abel Vesa: "Re: [PATCH v5 0/2] clk: imx8mp: Add audio shared gate"
Previous message: syzbot: "[syzbot] WARNING: refcount bug in p9_client_walk"
Messages sorted by: [ date ] [ thread ] [ subject ] [ author ]