syzbot


net-next boot error: INFO: task hung in add_early_randomness

Status: internal: reported on 2022/06/10 08:01
Reported-by: syzbot+@syzkaller.appspotmail.com
Fix commit: 228432551bd8 virtio-rng: make device ready before making request
Patched on: [ci-qemu-upstream ci-qemu-upstream-386 ci-qemu2-arm32 ci-qemu2-arm64 ci-qemu2-arm64-compat ci-qemu2-arm64-mte ci-upstream-bpf-kasan-gce ci-upstream-bpf-next-kasan-gce ci-upstream-gce-arm64 ci-upstream-gce-leak ci-upstream-kasan-gce ci-upstream-kasan-gce-386 ci-upstream-kasan-gce-root ci-upstream-kasan-gce-selinux-root ci-upstream-kasan-gce-smack-root ci-upstream-kmsan-gce ci-upstream-kmsan-gce-386 ci-upstream-linux-next-kasan-gce-root ci-upstream-net-kasan-gce ci-upstream-net-this-kasan-gce ci2-upstream-fs ci2-upstream-kcsan-gce ci2-upstream-usb], missing on: [ci-qemu2-riscv64]
First crash: 241d, last: 235d

Sample crash report:
INFO: task swapper/0:1 blocked for more than 143 seconds.
      Not tainted 5.19.0-rc1-syzkaller-00404-g5dcb50c009c9 #0
"echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message.
task:swapper/0       state:D stack:23640 pid:    1 ppid:     0 flags:0x00004000
Call Trace:
 <TASK>
 context_switch kernel/sched/core.c:5116 [inline]
 __schedule+0xa00/0x4b30 kernel/sched/core.c:6428
 schedule+0xd2/0x1f0 kernel/sched/core.c:6500
 schedule_preempt_disabled+0xf/0x20 kernel/sched/core.c:6559
 __mutex_lock_common kernel/locking/mutex.c:679 [inline]
 __mutex_lock+0xa70/0x1350 kernel/locking/mutex.c:747
 add_early_randomness+0x1a/0x170 drivers/char/hw_random/core.c:69
 hwrng_register+0x399/0x510 drivers/char/hw_random/core.c:599
 virtrng_scan+0x37/0x90 drivers/char/hw_random/virtio-rng.c:205
 virtio_dev_probe+0x639/0x910 drivers/virtio/virtio.c:312
 call_driver_probe drivers/base/dd.c:555 [inline]
 really_probe+0x23e/0xb90 drivers/base/dd.c:634
 __driver_probe_device+0x338/0x4d0 drivers/base/dd.c:764
 driver_probe_device+0x4c/0x1a0 drivers/base/dd.c:794
 __driver_attach+0x22d/0x550 drivers/base/dd.c:1163
 bus_for_each_dev+0x147/0x1d0 drivers/base/bus.c:301
 bus_for_each_dev+0x147/0x1d0 drivers/base/bus.c:301
 bus_add_driver+0x422/0x640 drivers/base/bus.c:618
 driver_register+0x220/0x3a0 drivers/base/driver.c:240
 do_one_initcall+0x103/0x650 init/main.c:1295
 do_initcall_level init/main.c:1368 [inline]
 do_initcalls init/main.c:1384 [inline]
 do_basic_setup init/main.c:1403 [inline]
 kernel_init_freeable+0x6b1/0x73a init/main.c:1610
 kernel_init+0x1a/0x1d0 init/main.c:1499
 ret_from_fork+0x1f/0x30 arch/x86/entry/entry_64.S:302
 </TASK>

Showing all locks held in the system:
2 locks held by swapper/0/1:
 #0: ffff88801bbc9170 (&dev->mutex){....}-{3:3}, at: device_lock include/linux/device.h:835 [inline]
 #0: ffff88801bbc9170 (&dev->mutex){....}-{3:3}, at: __device_driver_lock drivers/base/dd.c:1054 [inline]
 #0: ffff88801bbc9170 (&dev->mutex){....}-{3:3}, at: __driver_attach+0x222/0x550 drivers/base/dd.c:1162
 #1: ffffffff8c832c08 (reading_mutex){+.+.}-{3:3}, at: add_early_randomness+0x1a/0x170 drivers/char/hw_random/core.c:69
2 locks held by kworker/u4:0/8:
 #0: ffff888011869138 ((wq_completion)events_unbound){+.+.}-{0:0}, at: arch_atomic64_set arch/x86/include/asm/atomic64_64.h:34 [inline]
 #0: ffff888011869138 ((wq_completion)events_unbound){+.+.}-{0:0}, at: arch_atomic_long_set include/linux/atomic/atomic-long.h:41 [inline]
 #0: ffff888011869138 ((wq_completion)events_unbound){+.+.}-{0:0}, at: atomic_long_set include/linux/atomic/atomic-instrumented.h:1280 [inline]
 #0: ffff888011869138 ((wq_completion)events_unbound){+.+.}-{0:0}, at: set_work_data kernel/workqueue.c:636 [inline]
 #0: ffff888011869138 ((wq_completion)events_unbound){+.+.}-{0:0}, at: set_work_pool_and_clear_pending kernel/workqueue.c:663 [inline]
 #0: ffff888011869138 ((wq_completion)events_unbound){+.+.}-{0:0}, at: process_one_work+0x87a/0x1610 kernel/workqueue.c:2260
 #1: ffffc900000d7da8 ((work_completion)(&(&kfence_timer)->work)){+.+.}-{0:0}, at: process_one_work+0x8ae/0x1610 kernel/workqueue.c:2264
2 locks held by pr/ttyS0/16:
1 lock held by khungtaskd/29:
 #0: ffffffff8bd867e0 (rcu_read_lock){....}-{1:2}, at: debug_show_all_locks+0x53/0x260 kernel/locking/lockdep.c:6491
1 lock held by hwrng/755:
 #0: ffffffff8c832c08 (reading_mutex){+.+.}-{3:3}, at: hwrng_fillfn+0x141/0x370 drivers/char/hw_random/core.c:503

=============================================


Crashes (23):
Manager Time Kernel Commit Syzkaller Config Log Report Syz repro C repro VM info Assets Title
ci-upstream-net-kasan-gce 2022/06/16 22:56 net-next 5dcb50c009c9 1719ee24 .config console log report net-next boot error: INFO: task hung in add_early_randomness
ci-upstream-net-kasan-gce 2022/06/16 22:56 net-next 5dcb50c009c9 1719ee24 .config console log report net-next boot error: INFO: task hung in add_early_randomness
ci-upstream-net-kasan-gce 2022/06/16 15:57 net-next 5dcb50c009c9 1719ee24 .config console log report net-next boot error: INFO: task hung in add_early_randomness
ci-upstream-net-kasan-gce 2022/06/16 15:57 net-next 5dcb50c009c9 1719ee24 .config console log report net-next boot error: INFO: task hung in add_early_randomness
ci-upstream-net-kasan-gce 2022/06/16 05:57 net-next cfbc80e34e3a 1719ee24 .config console log report net-next boot error: INFO: task hung in add_early_randomness
ci-upstream-net-kasan-gce 2022/06/15 17:42 net-next fbb89d02e33a 1719ee24 .config console log report net-next boot error: INFO: task hung in add_early_randomness
ci-upstream-net-kasan-gce 2022/06/15 17:42 net-next fbb89d02e33a 1719ee24 .config console log report net-next boot error: INFO: task hung in add_early_randomness
ci-upstream-net-kasan-gce 2022/06/15 17:42 net-next fbb89d02e33a 1719ee24 .config console log report net-next boot error: INFO: task hung in add_early_randomness
ci-upstream-net-kasan-gce 2022/06/15 14:13 net-next fbb89d02e33a 1719ee24 .config console log report net-next boot error: INFO: task hung in add_early_randomness
ci-upstream-net-kasan-gce 2022/06/15 14:13 net-next fbb89d02e33a 1719ee24 .config console log report net-next boot error: INFO: task hung in add_early_randomness
ci-upstream-net-kasan-gce 2022/06/15 02:33 net-next 6ac6dc746d70 127d1faf .config console log report net-next boot error: INFO: task hung in add_early_randomness
ci-upstream-net-kasan-gce 2022/06/14 14:52 net-next 7e5e8ec7dbd8 127d1faf .config console log report net-next boot error: INFO: task hung in add_early_randomness
ci-upstream-net-kasan-gce 2022/06/13 23:24 net-next c04245328dd7 0f087040 .config console log report net-next boot error: INFO: task hung in add_early_randomness
ci-upstream-net-kasan-gce 2022/06/13 11:49 net-next 11a1585f26f7 0d5abf15 .config console log report net-next boot error: INFO: task hung in add_early_randomness
ci-upstream-net-kasan-gce 2022/06/12 17:33 net-next 27f2533bcc6e 0d5abf15 .config console log report net-next boot error: INFO: task hung in add_early_randomness
ci-upstream-net-kasan-gce 2022/06/11 14:22 net-next 27f2533bcc6e 0d5abf15 .config console log report net-next boot error: INFO: task hung in add_early_randomness
ci-upstream-net-kasan-gce 2022/06/11 14:22 net-next 27f2533bcc6e 0d5abf15 .config console log report net-next boot error: INFO: task hung in add_early_randomness
ci-upstream-net-kasan-gce 2022/06/11 01:02 net-next e10b02ee5b6c 0d5abf15 .config console log report net-next boot error: INFO: task hung in add_early_randomness
ci-upstream-net-kasan-gce 2022/06/10 11:31 net-next 6cbd05b2d07a 0d5abf15 .config console log report net-next boot error: INFO: task hung in add_early_randomness
ci-upstream-net-kasan-gce 2022/06/10 08:45 net-next 6cbd05b2d07a 0d5abf15 .config console log report net-next boot error: INFO: task hung in add_early_randomness
ci-upstream-net-kasan-gce 2022/06/10 08:45 net-next 6cbd05b2d07a 0d5abf15 .config console log report net-next boot error: INFO: task hung in add_early_randomness
ci-upstream-net-kasan-gce 2022/06/10 08:00 net-next a98a62e456e2 0d5abf15 .config console log report net-next boot error: INFO: task hung in add_early_randomness
ci-upstream-net-kasan-gce 2022/06/10 08:00 net-next a98a62e456e2 0d5abf15 .config console log report net-next boot error: INFO: task hung in add_early_randomness
* Struck through repros no longer work on HEAD.