ci2 starts bisection 2023-06-20 22:07:51.848408513 +0000 UTC m=+5056.077366765
bisecting fixing commit since fa74641fb6b93a19ccb50579886ecc98320230f9
building syzkaller on 4bce1a3e705a8b62de8194bdb28f5eef89c8feec
ensuring issue is reproducible on original commit fa74641fb6b93a19ccb50579886ecc98320230f9
testing commit fa74641fb6b93a19ccb50579886ecc98320230f9 gcc
compiler: Debian clang version 15.0.7, GNU ld (GNU Binutils for Debian) 2.35.2
kernel signature: 85bdc487f1cc5fb54a38c6fd0ecb60ca7a0b897f60b86e34d118c65f49c5c2af
all runs: crashed: INFO: task hung in blkdev_put
testing current HEAD ca87e77a2ef8b298aa9f69658d5898e72ee450fe
testing commit ca87e77a2ef8b298aa9f69658d5898e72ee450fe gcc
compiler: Debian clang version 15.0.7, GNU ld (GNU Binutils for Debian) 2.35.2
kernel signature: d6c88036b49b670db4883bae185091075269df12e6a1df7ad065b6e70521eb4f
all runs: crashed: INFO: task hung in blkdev_put
crash still not fixed/happens on the oldest tested release
revisions tested: 2, total time: 57m30.353389862s (build: 44m43.06945296s, test: 11m59.561622477s)
crash still not fixed on HEAD or HEAD had kernel test errors
commit msg: Linux 6.1.34
crash: INFO: task hung in blkdev_put
INFO: task syz-executor.0:4322 blocked for more than 143 seconds.
Not tainted 6.1.34-syzkaller #0
"echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message.
task:syz-executor.0 state:D stack:27520 pid:4322 ppid:3895 flags:0x00004006
Call Trace:
context_switch kernel/sched/core.c:5241 [inline]
__schedule+0x1308/0x42f0 kernel/sched/core.c:6554
schedule+0xbf/0x180 kernel/sched/core.c:6630
schedule_preempt_disabled+0xf/0x20 kernel/sched/core.c:6689
__mutex_lock_common+0xe2b/0x2520 kernel/locking/mutex.c:679
__mutex_lock kernel/locking/mutex.c:747 [inline]
mutex_lock_nested+0x17/0x20 kernel/locking/mutex.c:799
blkdev_put+0xe4/0x5c0 block/bdev.c:911
blkdev_close+0x51/0x70 block/fops.c:514
__fput+0x33f/0x720 fs/file_table.c:320
task_work_run+0x206/0x290 kernel/task_work.c:179
get_signal+0x1131/0x12c0 kernel/signal.c:2635
arch_do_signal_or_restart+0xb0/0x1a10 arch/x86/kernel/signal.c:869
exit_to_user_mode_loop+0x6a/0x100 kernel/entry/common.c:168
exit_to_user_mode_prepare+0xb1/0x140 kernel/entry/common.c:204
__syscall_exit_to_user_mode_work kernel/entry/common.c:286 [inline]
syscall_exit_to_user_mode+0x60/0x270 kernel/entry/common.c:297
do_syscall_64+0x49/0xb0 arch/x86/entry/common.c:86
entry_SYSCALL_64_after_hwframe+0x63/0xcd
RIP: 0033:0x7f8028a8c169
RSP: 002b:00007f8027ddd168 EFLAGS: 00000246 ORIG_RAX: 0000000000000010
RAX: 0000000000000000 RBX: 00007f8028bac050 RCX: 00007f8028a8c169
RDX: 0000000000000000 RSI: 000000000000ab03 RDI: 0000000000000003
RBP: 00007f8028ae7ca1 R08: 0000000000000000 R09: 0000000000000000
R10: 0000000000000000 R11: 0000000000000246 R12: 0000000000000000
R13: 00007fff6e958cff R14: 00007f8027ddd300 R15: 0000000000022000
Showing all locks held in the system:
1 lock held by rcu_tasks_kthre/12:
#0: ffffffff8bf19ef0 (rcu_tasks.tasks_gp_mutex){+.+.}-{3:3}, at: rcu_tasks_one_gp+0x29/0xd20 kernel/rcu/tasks.h:510
1 lock held by rcu_tasks_trace/13:
#0: ffffffff8bf1a6f0 (rcu_tasks_trace.tasks_gp_mutex){+.+.}-{3:3}, at: rcu_tasks_one_gp+0x29/0xd20 kernel/rcu/tasks.h:510
1 lock held by khungtaskd/28:
#0: ffffffff8bf19d20 (rcu_read_lock){....}-{1:2}, at: rcu_lock_acquire+0x0/0x30
5 locks held by kworker/u4:2/41:
2 locks held by kworker/u4:4/949:
#0: ffff8880b9d39d58 (&rq->__lock){-.-.}-{2:2}, at: raw_spin_rq_lock_nested+0x26/0x140 kernel/sched/core.c:537
#1: ffff8880b9d27788 (&per_cpu_ptr(group->pcpu, cpu)->seq){-.-.}-{0:0}, at: psi_task_switch+0x43d/0x770 kernel/sched/psi.c:952
2 locks held by getty/3298:
#0: ffff88814ba90098 (&tty->ldisc_sem){++++}-{0:0}, at: tty_ldisc_ref_wait+0x1c/0x60 drivers/tty/tty_ldisc.c:244
#1: ffffc90002d262f0 (&ldata->atomic_read_lock){+.+.}-{3:3}, at: n_tty_read+0x5e9/0x1880 drivers/tty/n_tty.c:2177
1 lock held by udevd/3889:
#0: ffff8881437b64c8 (&disk->open_mutex){+.+.}-{3:3}, at: blkdev_get_by_dev+0xd2/0x890 block/bdev.c:813
1 lock held by syz-executor.0/4322:
#0: ffff8881437b64c8 (&disk->open_mutex){+.+.}-{3:3}, at: blkdev_put+0xe4/0x5c0 block/bdev.c:911
1 lock held by syz-executor.0/4338:
#0: ffff8881437b64c8 (&disk->open_mutex){+.+.}-{3:3}, at: blkdev_get_by_dev+0xd2/0x890 block/bdev.c:813
1 lock held by syz-executor.0/4353:
#0: ffff8881437b64c8 (&disk->open_mutex){+.+.}-{3:3}, at: blkdev_get_by_dev+0xd2/0x890 block/bdev.c:813
=============================================
NMI backtrace for cpu 0
CPU: 0 PID: 28 Comm: khungtaskd Not tainted 6.1.34-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+0x163/0x213 lib/dump_stack.c:106
nmi_cpu_backtrace+0x37d/0x3f0 lib/nmi_backtrace.c:111
nmi_trigger_cpumask_backtrace+0x134/0x310 lib/nmi_backtrace.c:62
trigger_all_cpu_backtrace include/linux/nmi.h:148 [inline]
check_hung_uninterruptible_tasks kernel/hung_task.c:220 [inline]
watchdog+0xada/0xb20 kernel/hung_task.c:377
kthread+0x230/0x2b0 kernel/kthread.c:376
ret_from_fork+0x1f/0x30 arch/x86/entry/entry_64.S:306
Sending NMI from CPU 0 to CPUs 1:
NMI backtrace for cpu 1
CPU: 1 PID: 949 Comm: kworker/u4:4 Not tainted 6.1.34-syzkaller #0
Hardware name: Google Google Compute Engine/Google Compute Engine, BIOS Google 05/27/2023
Workqueue: bat_events batadv_nc_worker
RIP: 0010:__kasan_check_read+0x6/0x10 mm/kasan/shadow.c:31
Code: 41 5e 41 5f 5d c3 48 c7 c7 3e 8f 70 8b eb 0a 48 c7 c7 76 8f 70 8b 4c 89 fe e8 a2 53 be 07 31 db eb d7 cc cc 89 f6 48 8b 0c 24 <31> d2 e9 d3 ec ff ff 0f 1f 00 89 f6 48 8b 0c 24 ba 01 00 00 00 e9
RSP: 0018:ffffc9000456f998 EFLAGS: 00000002
RAX: 000000000000001a RBX: 000000000000069a RCX: ffffffff815f387c
RDX: dffffc0000000000 RSI: 0000000000000008 RDI: ffffffff8f00a2f0
RBP: ffff88801eb9a8e8 R08: dffffc0000000000 R09: fffffbfff1e0145f
R10: 0000000000000000 R11: dffffc0000000001 R12: 0000000000000001
R13: ffff88801eb9a8e8 R14: 0000000000000001 R15: 0000000000000004
FS: 0000000000000000(0000) GS:ffff8880b9d00000(0000) knlGS:0000000000000000
CS: 0010 DS: 0000 ES: 0000 CR0: 0000000080050033
CR2: 000055ad18a8b680 CR3: 000000001d9f5000 CR4: 00000000003506e0
DR0: 0000000000000000 DR1: 0000000000000000 DR2: 0000000000000000
DR3: 0000000000000000 DR6: 00000000fffe0ff0 DR7: 0000000000000400
Call Trace:
instrument_atomic_read include/linux/instrumented.h:72 [inline]
_test_bit include/asm-generic/bitops/instrumented-non-atomic.h:141 [inline]
hlock_class kernel/locking/lockdep.c:228 [inline]
check_wait_context kernel/locking/lockdep.c:4755 [inline]
__lock_acquire+0x78c/0x1f80 kernel/locking/lockdep.c:5006
lock_acquire+0x1f8/0x5a0 kernel/locking/lockdep.c:5669
rcu_lock_acquire+0x20/0x30 include/linux/rcupdate.h:306
rcu_read_lock include/linux/rcupdate.h:747 [inline]
batadv_nc_purge_orig_hash net/batman-adv/network-coding.c:408 [inline]
batadv_nc_worker+0xb0/0x4a0 net/batman-adv/network-coding.c:719
process_one_work+0x7be/0xf30 kernel/workqueue.c:2289
worker_thread+0x8c5/0xfc0 kernel/workqueue.c:2436
kthread+0x230/0x2b0 kernel/kthread.c:376
ret_from_fork+0x1f/0x30 arch/x86/entry/entry_64.S:306