ci2 starts bisection 2023-06-22 11:05:06.544310886 +0000 UTC m=+138090.773269138
bisecting fixing commit since e8f60cd7db24f94f2dbed6bec30dd16a68fc0828
building syzkaller on 96166539c4c242fccd41c7316b7080377dca428b
ensuring issue is reproducible on original commit e8f60cd7db24f94f2dbed6bec30dd16a68fc0828
testing commit e8f60cd7db24f94f2dbed6bec30dd16a68fc0828 gcc
compiler: Debian clang version 15.0.7, GNU ld (GNU Binutils for Debian) 2.35.2
kernel signature: ffa2b1e41dfa9e06d72e3d127c4186f36e7b031422c9c475cad61509bf593129
all runs: crashed: INFO: task hung in hfs_mdb_commit
testing current HEAD dad9774deaf1cf8e8f7483310dfb2690310193d2
testing commit dad9774deaf1cf8e8f7483310dfb2690310193d2 gcc
compiler: Debian clang version 15.0.7, GNU ld (GNU Binutils for Debian) 2.35.2
kernel signature: b61ce413226d6650ca36c5b1d11e0dd44832f10699b46cd6142cd9e5cb110961
all runs: crashed: INFO: task hung in hfs_mdb_commit
crash still not fixed/happens on the oldest tested release
revisions tested: 2, total time: 1h16m55.553044982s (build: 1h3m26.826433281s, test: 11m56.130057104s)
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 hfs_mdb_commit
INFO: task kworker/0:4:5000 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:kworker/0:4 state:D stack:23744 pid:5000 ppid:2 flags:0x00004000
Workqueue: events_long flush_mdb
Call Trace:
__schedule+0x1819/0x48a0
schedule+0xc3/0x180
io_schedule+0x8c/0x100
bit_wait_io+0x12/0xc0
__wait_on_bit_lock+0xbd/0x1a0
out_of_line_wait_on_bit_lock+0x1d6/0x260
hfs_mdb_commit+0xd5/0xe40
process_one_work+0x7c4/0xe70
worker_thread+0x8c9/0xfd0
kthread+0x276/0x2f0
ret_from_fork+0x1f/0x30
INFO: task syz-executor.0:5340 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:21208 pid:5340 ppid:1 flags:0x00004004
Call Trace:
__schedule+0x1819/0x48a0
schedule+0xc3/0x180
io_schedule+0x8c/0x100
bit_wait_io+0x12/0xc0
__wait_on_bit_lock+0xbd/0x1a0
out_of_line_wait_on_bit_lock+0x1d6/0x260
hfs_mdb_commit+0x9f0/0xe40
hfs_sync_fs+0x9/0x10
sync_filesystem+0xc8/0x190
generic_shutdown_super+0x69/0x2d0
kill_block_super+0x7f/0xc0
deactivate_locked_super+0x75/0xd0
cleanup_mnt+0x358/0x3e0
task_work_run+0x20a/0x290
exit_to_user_mode_loop+0xd1/0xf0
exit_to_user_mode_prepare+0xb1/0x140
syscall_exit_to_user_mode+0x54/0x270
do_syscall_64+0x4d/0xc0
entry_SYSCALL_64_after_hwframe+0x63/0xcd
RIP: 0033:0x7efd9188d537
RSP: 002b:00007ffec04e2758 EFLAGS: 00000246 ORIG_RAX: 00000000000000a6
RAX: 0000000000000000 RBX: 0000000000000000 RCX: 00007efd9188d537
RDX: 00007ffec04e2827 RSI: 000000000000000a RDI: 00007ffec04e2820
RBP: 00007ffec04e2820 R08: 00000000ffffffff R09: 00007ffec04e25f0
R10: 00005555557b1873 R11: 0000000000000246 R12: 00007efd918e6b24
R13: 00007ffec04e38e0 R14: 00005555557b1810 R15: 00007ffec04e3920
Showing all locks held in the system:
1 lock held by rcu_tasks_kthre/13:
#0: ffffffff8bf1c050 (rcu_tasks.tasks_gp_mutex){+.+.}-{3:3}, at: rcu_tasks_one_gp+0x29/0xd20
1 lock held by rcu_tasks_trace/14:
#0: ffffffff8bf1c410 (rcu_tasks_trace.tasks_gp_mutex){+.+.}-{3:3}, at: rcu_tasks_one_gp+0x29/0xd20
1 lock held by khungtaskd/28:
#0: ffffffff8bf1be80 (rcu_read_lock){....}-{1:2}, at: rcu_lock_acquire+0x0/0x30
2 locks held by getty/4739:
#0: ffff88814a132098 (&tty->ldisc_sem){++++}-{0:0}, at: tty_ldisc_ref_wait+0x20/0x60
#1: ffffc900015802f0 (&ldata->atomic_read_lock){+.+.}-{3:3}, at: n_tty_read+0x3cf/0x11f0
2 locks held by kworker/0:4/5000:
#0: ffff888011071538 ((wq_completion)events_long){+.+.}-{0:0}, at: process_one_work+0x6eb/0xe70
#1: ffffc900038dfd20 ((work_completion)(&(&sbi->mdb_work)->work)){+.+.}-{0:0}, at: process_one_work+0x735/0xe70
1 lock held by syz-executor.0/5340:
#0: ffff8880206b40e0 (&type->s_umount_key#50){+.+.}-{3:3}, at: deactivate_super+0x54/0x80
=============================================
NMI backtrace for cpu 0
CPU: 0 PID: 28 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_lvl+0x12e/0x1d0
nmi_cpu_backtrace+0x2dd/0x310
nmi_trigger_cpumask_backtrace+0x103/0x1f0
watchdog+0xa7c/0xac0
kthread+0x276/0x2f0
ret_from_fork+0x1f/0x30
Sending NMI from CPU 0 to CPUs 1:
NMI backtrace for cpu 1
CPU: 1 PID: 41 Comm: kworker/u4:2 Not tainted 6.4.0-rc7-syzkaller #0
Hardware name: Google Google Compute Engine/Google Compute Engine, BIOS Google 05/27/2023
Workqueue: phy5 ieee80211_iface_work
RIP: 0010:unwind_next_frame+0x4a1/0x2200
Code: 00 00 fc ff df 0f b6 04 08 84 c0 75 27 48 63 03 48 01 d8 48 8d 4b 04 4c 39 f8 4c 0f 46 e9 48 8d 43 fc 48 0f 47 e8 4c 0f 46 e3 <49> 39 ed 76 a8 e9 aa fd ff ff 89 d9 80 e1 07 80 c1 03 38 c1 7c cd
RSP: 0018:ffffc90000b27610 EFLAGS: 00000202
RAX: ffffffff8d5acc1c RBX: ffffffff8d5acc20 RCX: ffffffff8d5acc24
RDX: ffffffff8dc5966e RSI: 000000000008e001 RDI: ffffffff81347850
RBP: ffffffff8d5acc1c R08: 000000000000000b R09: ffffc90000b277b0
R10: ffffc90000b27730 R11: dffffc0000000001 R12: ffffffff8d5acc14
R13: ffffffff8d5acc18 R14: ffffffff8d5acc00 R15: ffffffff81c2e5bf
FS: 0000000000000000(0000) GS:ffff8880b9d00000(0000) knlGS:0000000000000000
CS: 0010 DS: 0000 ES: 0000 CR0: 0000000080050033
CR2: 000055e3f27f9680 CR3: 000000000bd27000 CR4: 00000000003506e0
DR0: 0000000000000000 DR1: 0000000000000000 DR2: 0000000000000000
DR3: 0000000000000000 DR6: 00000000fffe0ff0 DR7: 0000000000000400
Call Trace:
arch_stack_walk+0xab/0xe0
stack_trace_save+0x10a/0x1e0
kasan_set_track+0x40/0x60
kasan_save_free_info+0x2b/0x40
____kasan_slab_free+0xd6/0x120
kmem_cache_free+0x296/0x520
skb_release_data+0x47a/0x6d0
kfree_skb_reason+0x103/0x240
ieee80211_iface_work+0x187/0x9c0
process_one_work+0x7c4/0xe70
worker_thread+0x8c9/0xfd0
kthread+0x276/0x2f0
ret_from_fork+0x1f/0x30