syzbot


INFO: task hung in blk_trace_setup (3)

Status: auto-obsoleted due to no activity on 2024/06/13 01:38
Subsystems: block trace
[Documentation on labels]
First crash: 499d, last: 499d
Similar bugs (3)
Kernel Title Rank 🛈 Repro Cause bisect Fix bisect Count Last Reported Patched Status
upstream INFO: task hung in blk_trace_setup (2) block trace 1 1 1955d 1955d 0/29 auto-closed as invalid on 2020/06/18 13:53
upstream INFO: task hung in blk_trace_setup (4) block trace 1 syz 7 9d23h 11d 0/29 upstream: reported syz repro on 2025/07/15 17:43
upstream INFO: task hung in blk_trace_setup trace block 1 1 2326d 2326d 0/29 auto-closed as invalid on 2019/09/10 19:17

Sample crash report:
INFO: task syz-executor.0:19167 blocked for more than 143 seconds.
      Not tainted 6.8.0-syzkaller-08951-gfe46a7dd189e #0
"echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message.
task:syz-executor.0  state:D stack:29840 pid:19167 tgid:19166 ppid:18940  flags:0x00000006
Call Trace:
 <TASK>
 context_switch kernel/sched/core.c:5409 [inline]
 __schedule+0xf15/0x5c70 kernel/sched/core.c:6736
 __schedule_loop kernel/sched/core.c:6813 [inline]
 schedule+0xe7/0x350 kernel/sched/core.c:6828
 schedule_preempt_disabled+0x13/0x30 kernel/sched/core.c:6885
 __mutex_lock_common kernel/locking/mutex.c:684 [inline]
 __mutex_lock+0x5b8/0x9c0 kernel/locking/mutex.c:752
 blk_trace_setup+0x33/0x70 kernel/trace/blktrace.c:648
 sg_ioctl_common drivers/scsi/sg.c:1118 [inline]
 sg_ioctl+0x66d/0x2760 drivers/scsi/sg.c:1160
 vfs_ioctl fs/ioctl.c:51 [inline]
 __do_sys_ioctl fs/ioctl.c:904 [inline]
 __se_sys_ioctl fs/ioctl.c:890 [inline]
 __x64_sys_ioctl+0x193/0x220 fs/ioctl.c:890
 do_syscall_x64 arch/x86/entry/common.c:52 [inline]
 do_syscall_64+0xd2/0x260 arch/x86/entry/common.c:83
 entry_SYSCALL_64_after_hwframe+0x6d/0x75
RIP: 0033:0x7f99b787dda9
RSP: 002b:00007f99b850f0c8 EFLAGS: 00000246 ORIG_RAX: 0000000000000010
RAX: ffffffffffffffda RBX: 00007f99b79abf80 RCX: 00007f99b787dda9
RDX: 0000000020000000 RSI: 00000000c0481273 RDI: 0000000000000003
RBP: 00007f99b78ca47a R08: 0000000000000000 R09: 0000000000000000
R10: 0000000000000000 R11: 0000000000000246 R12: 0000000000000000
R13: 000000000000000b R14: 00007f99b79abf80 R15: 00007fff487bec08
 </TASK>

Showing all locks held in the system:
1 lock held by kworker/u8:0/10:
 #0: ffff8880b943e698 (&rq->__lock){-.-.}-{2:2}, at: raw_spin_rq_lock_nested+0x29/0x130 kernel/sched/core.c:559
1 lock held by khungtaskd/29:
 #0: ffffffff8d7b08e0 (rcu_read_lock){....}-{1:2}, at: rcu_lock_acquire include/linux/rcupdate.h:298 [inline]
 #0: ffffffff8d7b08e0 (rcu_read_lock){....}-{1:2}, at: rcu_read_lock include/linux/rcupdate.h:750 [inline]
 #0: ffffffff8d7b08e0 (rcu_read_lock){....}-{1:2}, at: debug_show_all_locks+0x75/0x340 kernel/locking/lockdep.c:6614
5 locks held by kworker/1:2/56:
 #0: ffff888019a89948 ((wq_completion)usb_hub_wq){+.+.}-{0:0}, at: process_one_work+0x1296/0x1a60 kernel/workqueue.c:3229
 #1: ffffc9000121fd80 ((work_completion)(&hub->events)){+.+.}-{0:0}, at: process_one_work+0x906/0x1a60 kernel/workqueue.c:3230
 #2: ffff888023d96190 (&dev->mutex){....}-{3:3}, at: device_lock include/linux/device.h:990 [inline]
 #2: ffff888023d96190 (&dev->mutex){....}-{3:3}, at: hub_event+0x1c1/0x4e20 drivers/usb/core/hub.c:5811
 #3: ffff88807c32b190 (&dev->mutex){....}-{3:3}, at: device_lock include/linux/device.h:990 [inline]
 #3: ffff88807c32b190 (&dev->mutex){....}-{3:3}, at: usb_disconnect+0x10a/0x920 drivers/usb/core/hub.c:2258
 #4: ffff88802f82f160 (&dev->mutex){....}-{3:3}, at: device_lock include/linux/device.h:990 [inline]
 #4: ffff88802f82f160 (&dev->mutex){....}-{3:3}, at: __device_driver_lock drivers/base/dd.c:1095 [inline]
 #4: ffff88802f82f160 (&dev->mutex){....}-{3:3}, at: device_release_driver_internal+0xa4/0x610 drivers/base/dd.c:1292
2 locks held by getty/4814:
 #0: ffff88802a4ac0a0 (&tty->ldisc_sem){++++}-{0:0}, at: tty_ldisc_ref_wait+0x24/0x80 drivers/tty/tty_ldisc.c:243
 #1: ffffc900015d02f0 (&ldata->atomic_read_lock){+.+.}-{3:3}, at: n_tty_read+0xfc8/0x1490 drivers/tty/n_tty.c:2201
5 locks held by kworker/0:3/5146:
 #0: ffff888019a89948 ((wq_completion)usb_hub_wq){+.+.}-{0:0}, at: process_one_work+0x1296/0x1a60 kernel/workqueue.c:3229
 #1: ffffc9000448fd80 ((work_completion)(&hub->events)){+.+.}-{0:0}, at: process_one_work+0x906/0x1a60 kernel/workqueue.c:3230
 #2: ffff888023d44190 (&dev->mutex){....}-{3:3}, at: device_lock include/linux/device.h:990 [inline]
 #2: ffff888023d44190 (&dev->mutex){....}-{3:3}, at: hub_event+0x1c1/0x4e20 drivers/usb/core/hub.c:5811
 #3: ffff88807a4c0190 (&dev->mutex){....}-{3:3}, at: device_lock include/linux/device.h:990 [inline]
 #3: ffff88807a4c0190 (&dev->mutex){....}-{3:3}, at: usb_disconnect+0x10a/0x920 drivers/usb/core/hub.c:2258
 #4: ffff88807c32a160 (&dev->mutex){....}-{3:3}, at: device_lock include/linux/device.h:990 [inline]
 #4: ffff88807c32a160 (&dev->mutex){....}-{3:3}, at: __device_driver_lock drivers/base/dd.c:1095 [inline]
 #4: ffff88807c32a160 (&dev->mutex){....}-{3:3}, at: device_release_driver_internal+0xa4/0x610 drivers/base/dd.c:1292
3 locks held by kworker/1:7/5148:
 #0: ffff888015078948 ((wq_completion)events){+.+.}-{0:0}, at: process_one_work+0x1296/0x1a60 kernel/workqueue.c:3229
 #1: ffffc900044afd80 ((work_completion)(&fw_work->work)){+.+.}-{0:0}, at: process_one_work+0x906/0x1a60 kernel/workqueue.c:3230
 #2: ffff888023d96190 (&dev->mutex){....}-{3:3}, at: device_lock include/linux/device.h:990 [inline]
 #2: ffff888023d96190 (&dev->mutex){....}-{3:3}, at: ath9k_hif_usb_firmware_fail drivers/net/wireless/ath/ath9k/hif_usb.c:1163 [inline]
 #2: ffff888023d96190 (&dev->mutex){....}-{3:3}, at: ath9k_hif_usb_firmware_cb+0x3b1/0x620 drivers/net/wireless/ath/ath9k/hif_usb.c:1296
4 locks held by kworker/u8:9/10676:
 #0: ffff88802087f148 ((wq_completion)nbd-del){+.+.}-{0:0}, at: process_one_work+0x1296/0x1a60 kernel/workqueue.c:3229
 #1: ffffc9000a397d80 ((work_completion)(&nbd->remove_work)){+.+.}-{0:0}, at: process_one_work+0x906/0x1a60 kernel/workqueue.c:3230
 #2: ffff888020813f68 (&q->debugfs_mutex){+.+.}-{3:3}, at: blk_debugfs_remove block/blk-sysfs.c:764 [inline]
 #2: ffff888020813f68 (&q->debugfs_mutex){+.+.}-{3:3}, at: blk_unregister_queue+0x19b/0x2e0 block/blk-sysfs.c:901
 #3: ffffffff8d8247e8 (relay_channels_mutex){+.+.}-{3:3}, at: relay_close kernel/relay.c:760 [inline]
 #3: ffffffff8d8247e8 (relay_channels_mutex){+.+.}-{3:3}, at: relay_close+0x36/0x5d0 kernel/relay.c:752
3 locks held by syz-executor.2/19126:
1 lock held by syz-executor.0/19167:
 #0: ffff8880203d7658 (&q->debugfs_mutex){+.+.}-{3:3}, at: blk_trace_setup+0x33/0x70 kernel/trace/blktrace.c:648
3 locks held by kworker/0:2/19857:
 #0: ffff888015078948 ((wq_completion)events){+.+.}-{0:0}, at: process_one_work+0x1296/0x1a60 kernel/workqueue.c:3229
 #1: ffffc90004c17d80 ((work_completion)(&fw_work->work)){+.+.}-{0:0}, at: process_one_work+0x906/0x1a60 kernel/workqueue.c:3230
 #2: ffffffff94831aa0 (&obj_hash[i].lock){-.-.}-{2:2}, at: __debug_check_no_obj_freed lib/debugobjects.c:978 [inline]
 #2: ffffffff94831aa0 (&obj_hash[i].lock){-.-.}-{2:2}, at: debug_check_no_obj_freed+0x1d0/0x600 lib/debugobjects.c:1019
2 locks held by kworker/u8:5/22314:
3 locks held by syz-executor.3/22443:
 #0: ffff888032478810 (&sb->s_type->i_mutex_key#10){+.+.}-{3:3}, at: inode_lock include/linux/fs.h:793 [inline]
 #0: ffff888032478810 (&sb->s_type->i_mutex_key#10){+.+.}-{3:3}, at: __sock_release+0x86/0x270 net/socket.c:658
 #1: ffff88801b2c9258 (sk_lock-AF_CAIF){+.+.}-{0:0}, at: lock_sock include/net/sock.h:1671 [inline]
 #1: ffff88801b2c9258 (sk_lock-AF_CAIF){+.+.}-{0:0}, at: caif_release+0x10b/0x400 net/caif/caif_socket.c:914
 #2: ffffffff8d7bc4b8 (rcu_state.exp_mutex){+.+.}-{3:3}, at: exp_funnel_lock kernel/rcu/tree_exp.h:291 [inline]
 #2: ffffffff8d7bc4b8 (rcu_state.exp_mutex){+.+.}-{3:3}, at: synchronize_rcu_expedited+0x682/0x7a0 kernel/rcu/tree_exp.h:939

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

NMI backtrace for cpu 1
CPU: 1 PID: 29 Comm: khungtaskd Not tainted 6.8.0-syzkaller-08951-gfe46a7dd189e #0
Hardware name: Google Google Compute Engine/Google Compute Engine, BIOS Google 02/29/2024
Call Trace:
 <TASK>
 __dump_stack lib/dump_stack.c:88 [inline]
 dump_stack_lvl+0x116/0x1f0 lib/dump_stack.c:114
 nmi_cpu_backtrace+0x27b/0x390 lib/nmi_backtrace.c:113
 nmi_trigger_cpumask_backtrace+0x29c/0x300 lib/nmi_backtrace.c:62
 trigger_all_cpu_backtrace include/linux/nmi.h:160 [inline]
 check_hung_uninterruptible_tasks kernel/hung_task.c:222 [inline]
 watchdog+0xf86/0x1210 kernel/hung_task.c:379
 kthread+0x2c1/0x3a0 kernel/kthread.c:388
 ret_from_fork+0x45/0x80 arch/x86/kernel/process.c:147
 ret_from_fork_asm+0x1a/0x30 arch/x86/entry/entry_64.S:243
 </TASK>
Sending NMI from CPU 1 to CPUs 0:
NMI backtrace for cpu 0
CPU: 0 PID: 1043 Comm: kworker/u8:6 Not tainted 6.8.0-syzkaller-08951-gfe46a7dd189e #0
Hardware name: Google Google Compute Engine/Google Compute Engine, BIOS Google 02/29/2024
Workqueue: events_unbound cfg80211_wiphy_work
RIP: 0010:ieee80211_sta_get_rates+0x2c0/0x650 net/mac80211/util.c:1550
Code: 3d f7 89 de bf 7f 00 00 00 e8 1c b2 3d f7 80 fb 7f 0f 84 55 01 00 00 0f b6 db 8d 04 9b 89 44 24 20 e8 84 b7 3d f7 48 8b 1c 24 <31> ff 48 89 de e8 86 b2 3d f7 48 85 db 0f 84 2f 01 00 00 31 ed 31
RSP: 0018:ffffc90005177960 EFLAGS: 00000293
RAX: 0000000000000000 RBX: 000000000000000c RCX: ffffffff8a4f40fe
RDX: ffff8880225eda00 RSI: ffffffff8a4f412c RDI: 0000000000000001
RBP: 0000000000000060 R08: 0000000000000001 R09: 0000000000000000
R10: 0000000000000060 R11: 0000000000000004 R12: 0000000000000000
R13: dffffc0000000000 R14: 000000000000000c R15: 000000000000000a
FS:  0000000000000000(0000) GS:ffff8880b9400000(0000) knlGS:0000000000000000
CS:  0010 DS: 0000 ES: 0000 CR0: 0000000080050033
CR2: 00007fa6411ad988 CR3: 000000000d57a000 CR4: 00000000003506f0
DR0: 0000000000000000 DR1: 0000000000000000 DR2: 0000000000000000
DR3: 0000000000000000 DR6: 00000000fffe0ff0 DR7: 0000000000000400
Call Trace:
 <NMI>
 </NMI>
 <TASK>
 ieee80211_update_sta_info net/mac80211/ibss.c:988 [inline]
 ieee80211_rx_bss_info net/mac80211/ibss.c:1097 [inline]
 ieee80211_rx_mgmt_probe_beacon net/mac80211/ibss.c:1578 [inline]
 ieee80211_ibss_rx_queued_mgmt+0x10fd/0x30d0 net/mac80211/ibss.c:1605
 ieee80211_iface_process_skb net/mac80211/iface.c:1605 [inline]
 ieee80211_iface_work+0xc07/0xf00 net/mac80211/iface.c:1659
 cfg80211_wiphy_work+0x255/0x330 net/wireless/core.c:437
 process_one_work+0x9a9/0x1a60 kernel/workqueue.c:3254
 process_scheduled_works kernel/workqueue.c:3335 [inline]
 worker_thread+0x6c8/0xf70 kernel/workqueue.c:3416
 kthread+0x2c1/0x3a0 kernel/kthread.c:388
 ret_from_fork+0x45/0x80 arch/x86/kernel/process.c:147
 ret_from_fork_asm+0x1a/0x30 arch/x86/entry/entry_64.S:243
 </TASK>

Crashes (1):
Time Kernel Commit Syzkaller Config Log Report Syz repro C repro VM info Assets (help?) Manager Title
2024/03/15 01:35 upstream fe46a7dd189e d615901c .config console log report info [disk image] [vmlinux] [kernel image] ci-upstream-kasan-gce-selinux-root INFO: task hung in blk_trace_setup
* Struck through repros no longer work on HEAD.