ci starts bisection 2023-03-03 04:48:28.491001427 +0000 UTC m=+153234.862254273
bisecting fixing commit since a4412fdd49dc011bcc2c0d81ac4cab7457092650
building syzkaller on e080de16713b9dbf308cdd7bcb85b58293e46e33
ensuring issue is reproducible on original commit a4412fdd49dc011bcc2c0d81ac4cab7457092650
testing commit a4412fdd49dc011bcc2c0d81ac4cab7457092650 gcc
compiler: gcc (Debian 10.2.1-6) 10.2.1 20210110, GNU ld (GNU Binutils for Debian) 2.35.2
kernel signature: 967e2044b64818ad2ad29519316e3e5666a5d9cc3b063ccf159952db4ceafb08
all runs: crashed: INFO: task hung in walk_component
testing current HEAD 2eb29d59ddf02e39774abfb60b2030b0b7e27c1f
testing commit 2eb29d59ddf02e39774abfb60b2030b0b7e27c1f gcc
compiler: gcc (Debian 10.2.1-6) 10.2.1 20210110, GNU ld (GNU Binutils for Debian) 2.35.2
kernel signature: c1d03d5b522b4449d678169388cc442406daf568b6792b7534183c4c458a23b2
all runs: crashed: INFO: task hung in walk_component
revisions tested: 2, total time: 29m32.835052474s (build: 17m13.997139315s, test: 11m36.500000007s)
the crash still happens on HEAD
commit msg: Merge tag 'drm-next-2023-03-03-1' of git://anongit.freedesktop.org/drm/drm
crash: INFO: task hung in walk_component
INFO: task syz-executor.0:5472 blocked for more than 143 seconds.
Not tainted 6.2.0-syzkaller #0
"echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message.
task:syz-executor.0 state:D stack:24048 pid:5472 ppid:1 flags:0x00000004
Call Trace:
context_switch kernel/sched/core.c:5304 [inline]
__schedule+0xc3e/0x5a70 kernel/sched/core.c:6622
schedule+0xde/0x1a0 kernel/sched/core.c:6698
schedule_preempt_disabled+0x13/0x20 kernel/sched/core.c:6757
rwsem_down_read_slowpath kernel/locking/rwsem.c:1086 [inline]
__down_read_common+0x7df/0xf30 kernel/locking/rwsem.c:1250
inode_lock_shared include/linux/fs.h:768 [inline]
lookup_slow fs/namei.c:1702 [inline]
walk_component+0x296/0x4e0 fs/namei.c:1994
link_path_walk.part.0+0x568/0xac0 fs/namei.c:2321
link_path_walk fs/namei.c:2246 [inline]
path_openat+0x1f8/0x2280 fs/namei.c:3711
do_filp_open+0x1a9/0x3e0 fs/namei.c:3742
do_sys_openat2+0x11e/0x3f0 fs/open.c:1348
do_sys_open fs/open.c:1364 [inline]
__do_sys_openat fs/open.c:1380 [inline]
__se_sys_openat fs/open.c:1375 [inline]
__x64_sys_openat+0x11f/0x1d0 fs/open.c:1375
do_syscall_x64 arch/x86/entry/common.c:50 [inline]
do_syscall_64+0x39/0xb0 arch/x86/entry/common.c:80
entry_SYSCALL_64_after_hwframe+0x63/0xcd
RIP: 0033:0x7feba148bc48
RSP: 002b:00007ffdd3798440 EFLAGS: 00000287 ORIG_RAX: 0000000000000101
RAX: ffffffffffffffda RBX: 0000000000000003 RCX: 00007feba148bc48
RDX: 0000000000090800 RSI: 00007feba14e6bc8 RDI: 00000000ffffff9c
RBP: 00007ffdd379850c R08: 0000000000090800 R09: 00007feba14e6bc8
R10: 0000000000000000 R11: 0000000000000287 R12: 0000000000000000
R13: 0000000000011c99 R14: 0000000000000009 R15: 00007ffdd3798570
INFO: task syz-executor.0:5564 blocked for more than 143 seconds.
Not tainted 6.2.0-syzkaller #0
"echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message.
task:syz-executor.0 state:D stack:26016 pid:5564 ppid:5472 flags:0x00004004
Call Trace:
context_switch kernel/sched/core.c:5304 [inline]
__schedule+0xc3e/0x5a70 kernel/sched/core.c:6622
schedule+0xde/0x1a0 kernel/sched/core.c:6698
request_wait_answer+0x371/0x6b0 fs/fuse/dev.c:407
__fuse_request_send fs/fuse/dev.c:426 [inline]
fuse_simple_request+0x480/0xba0 fs/fuse/dev.c:513
fuse_lookup_name+0x259/0x5e0 fs/fuse/dir.c:392
fuse_lookup.part.0+0xd6/0x2c0 fs/fuse/dir.c:433
__lookup_slow+0x200/0x3f0 fs/namei.c:1686
lookup_slow fs/namei.c:1703 [inline]
walk_component+0x2a3/0x4e0 fs/namei.c:1994
link_path_walk.part.0+0x568/0xac0 fs/namei.c:2321
link_path_walk fs/namei.c:2246 [inline]
path_openat+0x1f8/0x2280 fs/namei.c:3711
do_filp_open+0x1a9/0x3e0 fs/namei.c:3742
do_sys_openat2+0x11e/0x3f0 fs/open.c:1348
do_sys_open fs/open.c:1364 [inline]
__do_sys_openat fs/open.c:1380 [inline]
__se_sys_openat fs/open.c:1375 [inline]
__x64_sys_openat+0x11f/0x1d0 fs/open.c:1375
do_syscall_x64 arch/x86/entry/common.c:50 [inline]
do_syscall_64+0x39/0xb0 arch/x86/entry/common.c:80
entry_SYSCALL_64_after_hwframe+0x63/0xcd
RIP: 0033:0x7feba148c0d9
RSP: 002b:00007feba22d6168 EFLAGS: 00000246 ORIG_RAX: 0000000000000101
RAX: ffffffffffffffda RBX: 00007feba15abf80 RCX: 00007feba148c0d9
RDX: 0000000000000042 RSI: 0000000020002080 RDI: ffffffffffffff9c
RBP: 00007feba14e7ae9 R08: 0000000000000000 R09: 0000000000000000
R10: 0000000000000000 R11: 0000000000000246 R12: 0000000000000000
R13: 00007ffdd379824f R14: 00007feba22d6300 R15: 0000000000022000
INFO: task syz-executor.0:5568 blocked for more than 143 seconds.
Not tainted 6.2.0-syzkaller #0
"echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message.
task:syz-executor.0 state:D stack:28736 pid:5568 ppid:5472 flags:0x00000004
Call Trace:
context_switch kernel/sched/core.c:5304 [inline]
__schedule+0xc3e/0x5a70 kernel/sched/core.c:6622
schedule+0xde/0x1a0 kernel/sched/core.c:6698
schedule_preempt_disabled+0x13/0x20 kernel/sched/core.c:6757
rwsem_down_write_slowpath+0x3e2/0x1220 kernel/locking/rwsem.c:1178
__down_write_common kernel/locking/rwsem.c:1306 [inline]
__down_write kernel/locking/rwsem.c:1315 [inline]
down_write_nested+0x1d6/0x200 kernel/locking/rwsem.c:1690
inode_lock_nested include/linux/fs.h:793 [inline]
fuse_reverse_inval_entry+0x42/0x4a0 fs/fuse/dir.c:1252
fuse_notify_delete fs/fuse/dev.c:1552 [inline]
fuse_notify fs/fuse/dev.c:1801 [inline]
fuse_dev_do_write+0x1dde/0x2580 fs/fuse/dev.c:1876
fuse_dev_write+0x133/0x1c0 fs/fuse/dev.c:1960
call_write_iter include/linux/fs.h:1851 [inline]
new_sync_write fs/read_write.c:491 [inline]
vfs_write+0x823/0xd80 fs/read_write.c:584
ksys_write+0xf2/0x1c0 fs/read_write.c:637
do_syscall_x64 arch/x86/entry/common.c:50 [inline]
do_syscall_64+0x39/0xb0 arch/x86/entry/common.c:80
entry_SYSCALL_64_after_hwframe+0x63/0xcd
RIP: 0033:0x7feba148c0d9
RSP: 002b:00007feba22b5168 EFLAGS: 00000246 ORIG_RAX: 0000000000000001
RAX: ffffffffffffffda RBX: 00007feba15ac050 RCX: 00007feba148c0d9
RDX: 000000000000002c RSI: 00000000200000c0 RDI: 0000000000000003
RBP: 00007feba14e7ae9 R08: 0000000000000000 R09: 0000000000000000
R10: 0000000000000000 R11: 0000000000000246 R12: 0000000000000000
R13: 00007ffdd379824f R14: 00007feba22b5300 R15: 0000000000022000
Showing all locks held in the system:
1 lock held by rcu_tasks_kthre/11:
#0: ffffffff8b789830 (rcu_tasks.tasks_gp_mutex){+.+.}-{3:3}, at: rcu_tasks_one_gp+0x31/0xd80 kernel/rcu/tasks.h:510
1 lock held by rcu_tasks_trace/12:
#0: ffffffff8b789530 (rcu_tasks_trace.tasks_gp_mutex){+.+.}-{3:3}, at: rcu_tasks_one_gp+0x31/0xd80 kernel/rcu/tasks.h:510
1 lock held by khungtaskd/27:
#0: ffffffff8b78a380 (rcu_read_lock){....}-{1:2}, at: debug_show_all_locks+0x55/0x340 kernel/locking/lockdep.c:6495
2 locks held by getty/4741:
#0: ffff88814a8ae098 (&tty->ldisc_sem){++++}-{0:0}, at: tty_ldisc_ref_wait+0x23/0x80 drivers/tty/tty_ldisc.c:244
#1: ffffc900020182f0 (&ldata->atomic_read_lock){+.+.}-{3:3}, at: n_tty_read+0xb73/0x1040 drivers/tty/n_tty.c:2177
1 lock held by syz-executor.0/5472:
#0: ffff88806e13e850 (&type->i_mutex_dir_key#8){++++}-{3:3}, at: inode_lock_shared include/linux/fs.h:768 [inline]
#0: ffff88806e13e850 (&type->i_mutex_dir_key#8){++++}-{3:3}, at: lookup_slow fs/namei.c:1702 [inline]
#0: ffff88806e13e850 (&type->i_mutex_dir_key#8){++++}-{3:3}, at: walk_component+0x296/0x4e0 fs/namei.c:1994
2 locks held by syz-executor.0/5564:
#0: ffff88806e13e850 (&type->i_mutex_dir_key#8){++++}-{3:3}, at: inode_lock_shared include/linux/fs.h:768 [inline]
#0: ffff88806e13e850 (&type->i_mutex_dir_key#8){++++}-{3:3}, at: lookup_slow fs/namei.c:1702 [inline]
#0: ffff88806e13e850 (&type->i_mutex_dir_key#8){++++}-{3:3}, at: walk_component+0x296/0x4e0 fs/namei.c:1994
#1: ffff88806e13ecb8 (&fi->mutex){+.+.}-{3:3}, at: fuse_lock_inode+0xaf/0xe0 fs/fuse/inode.c:475
2 locks held by syz-executor.0/5568:
#0: ffff88801fe01338 (&fc->killsb){.+.+}-{3:3}, at: fuse_notify_delete fs/fuse/dev.c:1551 [inline]
#0: ffff88801fe01338 (&fc->killsb){.+.+}-{3:3}, at: fuse_notify fs/fuse/dev.c:1801 [inline]
#0: ffff88801fe01338 (&fc->killsb){.+.+}-{3:3}, at: fuse_dev_do_write+0x1dbb/0x2580 fs/fuse/dev.c:1876
#1: ffff88806e13e850 (&type->i_mutex_dir_key#8/1){+.+.}-{3:3}, at: inode_lock_nested include/linux/fs.h:793 [inline]
#1: ffff88806e13e850 (&type->i_mutex_dir_key#8/1){+.+.}-{3:3}, at: fuse_reverse_inval_entry+0x42/0x4a0 fs/fuse/dir.c:1252
=============================================
NMI backtrace for cpu 0
CPU: 0 PID: 27 Comm: khungtaskd Not tainted 6.2.0-syzkaller #0
Hardware name: Google Google Compute Engine/Google Compute Engine, BIOS Google 02/16/2023
Call Trace:
__dump_stack lib/dump_stack.c:88 [inline]
dump_stack_lvl+0x64/0xb0 lib/dump_stack.c:106
nmi_cpu_backtrace+0x1db/0x290 lib/nmi_backtrace.c:113
nmi_trigger_cpumask_backtrace+0x25d/0x340 lib/nmi_backtrace.c:62
trigger_all_cpu_backtrace include/linux/nmi.h:148 [inline]
check_hung_uninterruptible_tasks kernel/hung_task.c:222 [inline]
watchdog+0xa5c/0xe20 kernel/hung_task.c:379
kthread+0x298/0x340 kernel/kthread.c:376
ret_from_fork+0x1f/0x30 arch/x86/entry/entry_64.S:308
Sending NMI from CPU 0 to CPUs 1:
NMI backtrace for cpu 1
CPU: 1 PID: 56 Comm: kworker/u4:4 Not tainted 6.2.0-syzkaller #0
Hardware name: Google Google Compute Engine/Google Compute Engine, BIOS Google 02/16/2023
Workqueue: events_unbound toggle_allocation_gate
RIP: 0010:__lock_is_held kernel/locking/lockdep.c:5410 [inline]
RIP: 0010:lock_is_held_type+0x97/0x140 kernel/locking/lockdep.c:5712
Code: 00 00 4d 8d ac 24 38 0a 00 00 65 ff 05 52 12 ca 76 85 c0 7f 12 e9 8a 00 00 00 83 c3 01 41 3b 9c 24 30 0a 00 00 7d 7d 48 63 c3 <48> 89 ee 48 8d 04 80 4d 8d 7c c5 00 4c 89 ff e8 95 fe ff ff 85 c0
RSP: 0018:ffffc9000202fa60 EFLAGS: 00000097
RAX: 0000000000000003 RBX: 0000000000000003 RCX: 0000000000000001
RDX: 0000000000000000 RSI: ffffffff8b78a320 RDI: ffff888017ac4c88
RBP: ffffffff8b78a320 R08: ffffffff812980b2 R09: ffffc9000202fb17
R10: fffff52000405f62 R11: 0000000000000000 R12: ffff888017ac4200
R13: ffff888017ac4c38 R14: 00000000ffffffff R15: ffff888017ac4c88
FS: 0000000000000000(0000) GS:ffff8880b9b00000(0000) knlGS:0000000000000000
CS: 0010 DS: 0000 ES: 0000 CR0: 0000000080050033
CR2: 000055bca2ba2600 CR3: 000000000b56c000 CR4: 00000000003506e0
DR0: 0000000000000000 DR1: 0000000000000000 DR2: 0000000000000000
DR3: 0000000000000000 DR6: 00000000fffe0ff0 DR7: 0000000000000400
Call Trace:
lock_is_held include/linux/lockdep.h:283 [inline]
__might_resched+0x414/0x580 kernel/sched/core.c:10020
__mutex_lock_common kernel/locking/mutex.c:580 [inline]
__mutex_lock+0x9f/0x1350 kernel/locking/mutex.c:747
arch_jump_label_transform_apply+0x12/0x30 arch/x86/kernel/jump_label.c:145
static_key_disable_cpuslocked+0x104/0x160 kernel/jump_label.c:235
static_key_disable+0x15/0x20 kernel/jump_label.c:243
toggle_allocation_gate mm/kfence/core.c:804 [inline]
toggle_allocation_gate+0x118/0x1e0 mm/kfence/core.c:791
process_one_work+0x8ba/0x15a0 kernel/workqueue.c:2390
worker_thread+0x59c/0xec0 kernel/workqueue.c:2537
kthread+0x298/0x340 kernel/kthread.c:376
ret_from_fork+0x1f/0x30 arch/x86/entry/entry_64.S:308