ci starts bisection 2023-06-22 18:50:43.6723711 +0000 UTC m=+216509.333857492
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: 09821b412aab194697e695f4dd55d29f547e2077dda805c917b7700a48b9be05
all runs: crashed: INFO: task hung in walk_component
testing current HEAD dad9774deaf1cf8e8f7483310dfb2690310193d2
testing commit dad9774deaf1cf8e8f7483310dfb2690310193d2 gcc
compiler: gcc (Debian 10.2.1-6) 10.2.1 20210110, GNU ld (GNU Binutils for Debian) 2.35.2
kernel signature: 64954308b4f8ca17251d794fa354452acd4c175b9b6099710566550cc29409e0
all runs: crashed: INFO: task hung in walk_component
crash still not fixed/happens on the oldest tested release
revisions tested: 2, total time: 37m3.14194465s (build: 22m11.965675801s, test: 12m53.712753405s)
crash still not fixed on HEAD or HEAD had kernel test errors
commit msg: Merge tag 'timers-urgent-2023-06-21' of git://git.kernel.org/pub/scm/linux/kernel/git/tip/tip
crash: INFO: task hung in walk_component
INFO: task syz-executor.0:5333 blocked for more than 143 seconds.
Not tainted 6.4.0-rc7-syzkaller #0
"echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message.
task:syz-executor.0 state:D stack:24368 pid:5333 ppid:1 flags:0x00000004
Call Trace:
context_switch kernel/sched/core.c:5343 [inline]
__schedule+0xc25/0x57f0 kernel/sched/core.c:6669
schedule+0xde/0x1a0 kernel/sched/core.c:6745
schedule_preempt_disabled+0x13/0x20 kernel/sched/core.c:6804
rwsem_down_read_slowpath+0x57c/0xae0 kernel/locking/rwsem.c:1086
__down_read_common kernel/locking/rwsem.c:1250 [inline]
__down_read kernel/locking/rwsem.c:1263 [inline]
down_read+0xf0/0x480 kernel/locking/rwsem.c:1522
inode_lock_shared include/linux/fs.h:785 [inline]
lookup_slow fs/namei.c:1706 [inline]
walk_component+0x296/0x4e0 fs/namei.c:1998
link_path_walk.part.0+0x568/0xac0 fs/namei.c:2325
link_path_walk fs/namei.c:2250 [inline]
path_openat+0x1f8/0x2280 fs/namei.c:3787
do_filp_open+0x1a9/0x3e0 fs/namei.c:3818
do_sys_openat2+0x11e/0x3f0 fs/open.c:1356
do_sys_open fs/open.c:1372 [inline]
__do_sys_openat fs/open.c:1388 [inline]
__se_sys_openat fs/open.c:1383 [inline]
__x64_sys_openat+0x11f/0x1d0 fs/open.c:1383
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:0x7f1499a8bc48
RSP: 002b:00007ffc363ef6e0 EFLAGS: 00000287 ORIG_RAX: 0000000000000101
RAX: ffffffffffffffda RBX: 0000000000000003 RCX: 00007f1499a8bc48
RDX: 0000000000090800 RSI: 00007f1499ae6bc8 RDI: 00000000ffffff9c
RBP: 00007ffc363ef7ac R08: 0000000000090800 R09: 00007f1499ae6bc8
R10: 0000000000000000 R11: 0000000000000287 R12: 0000000000000000
R13: 0000000000012752 R14: 0000000000000009 R15: 00007ffc363ef810
INFO: task syz-executor.0:5417 blocked for more than 143 seconds.
Not tainted 6.4.0-rc7-syzkaller #0
"echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message.
task:syz-executor.0 state:D stack:26792 pid:5417 ppid:5333 flags:0x00004004
Call Trace:
context_switch kernel/sched/core.c:5343 [inline]
__schedule+0xc25/0x57f0 kernel/sched/core.c:6669
schedule+0xde/0x1a0 kernel/sched/core.c:6745
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:1690
lookup_slow fs/namei.c:1707 [inline]
walk_component+0x2a3/0x4e0 fs/namei.c:1998
link_path_walk.part.0+0x568/0xac0 fs/namei.c:2325
link_path_walk fs/namei.c:2250 [inline]
path_openat+0x1f8/0x2280 fs/namei.c:3787
do_filp_open+0x1a9/0x3e0 fs/namei.c:3818
do_sys_openat2+0x11e/0x3f0 fs/open.c:1356
do_sys_open fs/open.c:1372 [inline]
__do_sys_openat fs/open.c:1388 [inline]
__se_sys_openat fs/open.c:1383 [inline]
__x64_sys_openat+0x11f/0x1d0 fs/open.c:1383
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:0x7f1499a8c0d9
RSP: 002b:00007f149a72c168 EFLAGS: 00000246 ORIG_RAX: 0000000000000101
RAX: ffffffffffffffda RBX: 00007f1499babf80 RCX: 00007f1499a8c0d9
RDX: 0000000000000042 RSI: 0000000020002080 RDI: ffffffffffffff9c
RBP: 00007f1499ae7ae9 R08: 0000000000000000 R09: 0000000000000000
R10: 0000000000000000 R11: 0000000000000246 R12: 0000000000000000
R13: 00007ffc363ef4ef R14: 00007f149a72c300 R15: 0000000000022000
INFO: task syz-executor.0:5424 blocked for more than 144 seconds.
Not tainted 6.4.0-rc7-syzkaller #0
"echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message.
task:syz-executor.0 state:D stack:28440 pid:5424 ppid:5333 flags:0x00000004
Call Trace:
context_switch kernel/sched/core.c:5343 [inline]
__schedule+0xc25/0x57f0 kernel/sched/core.c:6669
schedule+0xde/0x1a0 kernel/sched/core.c:6745
schedule_preempt_disabled+0x13/0x20 kernel/sched/core.c:6804
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:810 [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:1868 [inline]
new_sync_write fs/read_write.c:491 [inline]
vfs_write+0x7c5/0xd10 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:0x7f1499a8c0d9
RSP: 002b:00007f149a70b168 EFLAGS: 00000246 ORIG_RAX: 0000000000000001
RAX: ffffffffffffffda RBX: 00007f1499bac050 RCX: 00007f1499a8c0d9
RDX: 000000000000002c RSI: 00000000200000c0 RDI: 0000000000000003
RBP: 00007f1499ae7ae9 R08: 0000000000000000 R09: 0000000000000000
R10: 0000000000000000 R11: 0000000000000246 R12: 0000000000000000
R13: 00007ffc363ef4ef R14: 00007f149a70b300 R15: 0000000000022000
Showing all locks held in the system:
1 lock held by rcu_tasks_kthre/12:
#0: ffffffff8b78c1b0 (rcu_tasks.tasks_gp_mutex){+.+.}-{3:3}, at: rcu_tasks_one_gp+0x31/0xd80 kernel/rcu/tasks.h:518
1 lock held by rcu_tasks_trace/13:
#0: ffffffff8b78beb0 (rcu_tasks_trace.tasks_gp_mutex){+.+.}-{3:3}, at: rcu_tasks_one_gp+0x31/0xd80 kernel/rcu/tasks.h:518
1 lock held by khungtaskd/27:
#0: ffffffff8b78cdc0 (rcu_read_lock){....}-{1:2}, at: debug_show_all_locks+0x55/0x340 kernel/locking/lockdep.c:6559
2 locks held by getty/4728:
#0: ffff88814afca098 (&tty->ldisc_sem){++++}-{0:0}, at: tty_ldisc_ref_wait+0x23/0x80 drivers/tty/tty_ldisc.c:243
#1: ffffc900020282f0 (&ldata->atomic_read_lock){+.+.}-{3:3}, at: n_tty_read+0xb73/0x1040 drivers/tty/n_tty.c:2176
1 lock held by syz-executor.0/5333:
#0: ffff88806bdaf850 (&type->i_mutex_dir_key#8){++++}-{3:3}, at: inode_lock_shared include/linux/fs.h:785 [inline]
#0: ffff88806bdaf850 (&type->i_mutex_dir_key#8){++++}-{3:3}, at: lookup_slow fs/namei.c:1706 [inline]
#0: ffff88806bdaf850 (&type->i_mutex_dir_key#8){++++}-{3:3}, at: walk_component+0x296/0x4e0 fs/namei.c:1998
2 locks held by syz-executor.0/5417:
#0: ffff88806bdaf850 (&type->i_mutex_dir_key#8){++++}-{3:3}, at: inode_lock_shared include/linux/fs.h:785 [inline]
#0: ffff88806bdaf850 (&type->i_mutex_dir_key#8){++++}-{3:3}, at: lookup_slow fs/namei.c:1706 [inline]
#0: ffff88806bdaf850 (&type->i_mutex_dir_key#8){++++}-{3:3}, at: walk_component+0x296/0x4e0 fs/namei.c:1998
#1: ffff88806bdafcb8 (&fi->mutex){+.+.}-{3:3}, at: fuse_lock_inode+0xaf/0xe0 fs/fuse/inode.c:475
2 locks held by syz-executor.0/5424:
#0: ffff88807a884b38 (&fc->killsb){.+.+}-{3:3}, at: fuse_notify_delete fs/fuse/dev.c:1551 [inline]
#0: ffff88807a884b38 (&fc->killsb){.+.+}-{3:3}, at: fuse_notify fs/fuse/dev.c:1801 [inline]
#0: ffff88807a884b38 (&fc->killsb){.+.+}-{3:3}, at: fuse_dev_do_write+0x1dbb/0x2580 fs/fuse/dev.c:1876
#1: ffff88806bdaf850 (&type->i_mutex_dir_key#8/1){+.+.}-{3:3}, at: inode_lock_nested include/linux/fs.h:810 [inline]
#1: ffff88806bdaf850 (&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.4.0-rc7-syzkaller #0
Hardware name: Google Google Compute Engine/Google Compute Engine, BIOS Google 05/27/2023
Call Trace:
__dump_stack lib/dump_stack.c:88 [inline]
dump_stack_lvl+0x64/0xb0 lib/dump_stack.c:106
nmi_cpu_backtrace+0x175/0x200 lib/nmi_backtrace.c:113
nmi_trigger_cpumask_backtrace+0x1bc/0x200 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+0x9f9/0xcf0 kernel/hung_task.c:379
kthread+0x2ea/0x3c0 kernel/kthread.c:379
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 skipped: idling at native_safe_halt arch/x86/include/asm/irqflags.h:48 [inline]
NMI backtrace for cpu 1 skipped: idling at arch_safe_halt arch/x86/include/asm/irqflags.h:86 [inline]
NMI backtrace for cpu 1 skipped: idling at acpi_safe_halt+0x1b/0x20 drivers/acpi/processor_idle.c:112