INFO: task hung in pipe_release

12 views
Skip to first unread message

syzbot

unread,
Mar 25, 2021, 7:59:19 AM3/25/21
to syzkaller...@googlegroups.com
Hello,

syzbot found the following issue on:

HEAD commit: 78fec161 Linux 4.19.183
git tree: linux-4.19.y
console output: https://syzkaller.appspot.com/x/log.txt?x=1213da1ad00000
kernel config: https://syzkaller.appspot.com/x/.config?x=8b2beec637df5f52
dashboard link: https://syzkaller.appspot.com/bug?extid=cab1072889f1fdd9b0de

Unfortunately, I don't have any reproducer for this issue yet.

IMPORTANT: if you fix the issue, please add the following tag to the commit:
Reported-by: syzbot+cab107...@syzkaller.appspotmail.com

INFO: task syz-executor.3:14887 blocked for more than 140 seconds.
Not tainted 4.19.183-syzkaller #0
"echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message.
syz-executor.3 D28752 14887 8137 0x80000002
Call Trace:
context_switch kernel/sched/core.c:2828 [inline]
__schedule+0x887/0x2040 kernel/sched/core.c:3517
schedule+0x8d/0x1b0 kernel/sched/core.c:3561
schedule_preempt_disabled+0xf/0x20 kernel/sched/core.c:3619
__mutex_lock_common kernel/locking/mutex.c:1002 [inline]
__mutex_lock+0x647/0x1260 kernel/locking/mutex.c:1072
squashfs: SQUASHFS error: unable to read xattr id index table
__pipe_lock fs/pipe.c:83 [inline]
pipe_release+0x49/0x340 fs/pipe.c:578
__fput+0x2ce/0x890 fs/file_table.c:278
squashfs: SQUASHFS error: unable to read xattr id index table
task_work_run+0x148/0x1c0 kernel/task_work.c:113
exit_task_work include/linux/task_work.h:22 [inline]
do_exit+0xbf3/0x2be0 kernel/exit.c:870
do_group_exit+0x125/0x310 kernel/exit.c:967
get_signal+0x3f2/0x1f70 kernel/signal.c:2589
do_signal+0x8f/0x1670 arch/x86/kernel/signal.c:799
exit_to_usermode_loop+0x204/0x2a0 arch/x86/entry/common.c:163
prepare_exit_to_usermode+0x277/0x2d0 arch/x86/entry/common.c:198
retint_user+0x8/0x18
RIP: 0033:0x466461
Code: 00 00 00 00 00 0f 1f 40 00 48 89 f8 48 89 f7 48 89 d6 48 89 ca 4d 89 c2 4d 89 c8 4c 8b 4c 24 08 0f 05 48 3d 01 f0 ff ff 73 01 <c3> 48 c7 c1 bc ff ff ff f7 d8 64 89 01 48 83 c8 ff c3 66 2e 0f 1f
RSP: 002b:0000000020000200 EFLAGS: 00010217
RAX: 0000000000000000 RBX: 000000000056c008 RCX: 0000000000466459
RDX: 0000000020000040 RSI: 0000000020000200 RDI: 00000000a6808000
RBP: 00000000004bf9fb R08: 0000000020000140 R09: 0000000000000000
R10: 0000000020000080 R11: 0000000000000246 R12: 000000000056c008
R13: 00007ffc1f4ba71f R14: 00007f8778bf6300 R15: 0000000000022000

Showing all locks held in the system:
1 lock held by khungtaskd/1567:
#0: 000000009d92b859 (rcu_read_lock){....}, at: debug_show_all_locks+0x53/0x265 kernel/locking/lockdep.c:4440
1 lock held by in:imklog/7816:
#0: 00000000098f5256 (&f->f_pos_lock){+.+.}, at: __fdget_pos+0x26f/0x310 fs/file.c:767
hub 9-0:1.0: USB hub found
4 locks held by syz-executor.3/8137:
3 locks held by syz-executor.5/14177:
1 lock held by syz-executor.3/14878:
#0: 000000002f278bfd (&pipe->mutex/1){+.+.}, at: pipe_lock_nested fs/pipe.c:62 [inline]
#0: 000000002f278bfd (&pipe->mutex/1){+.+.}, at: pipe_lock+0x63/0x80 fs/pipe.c:70
hub 9-0:1.0: 8 ports detected
1 lock held by syz-executor.3/14887:
#0: 000000002f278bfd (&pipe->mutex/1){+.+.}, at: __pipe_lock fs/pipe.c:83 [inline]
#0: 000000002f278bfd (&pipe->mutex/1){+.+.}, at: pipe_release+0x49/0x340 fs/pipe.c:578
1 lock held by syz-executor.3/15078:
#0: 00000000b312097c (&pipe->mutex/1){+.+.}, at: pipe_lock_nested fs/pipe.c:62 [inline]
#0: 00000000b312097c (&pipe->mutex/1){+.+.}, at: pipe_lock+0x63/0x80 fs/pipe.c:70
squashfs: SQUASHFS error: unable to read xattr id index table
1 lock held by syz-executor.3/17191:
#0: 00000000986a95b8 (&pipe->mutex/1){+.+.}, at: pipe_lock_nested fs/pipe.c:62 [inline]
#0: 00000000986a95b8 (&pipe->mutex/1){+.+.}, at: pipe_lock+0x63/0x80 fs/pipe.c:70
3 locks held by syz-executor.0/23377:
1 lock held by syz-executor.0/23381:
#0: 00000000cb973994 (&dev->mutex){....}, at: device_lock include/linux/device.h:1173 [inline]
#0: 00000000cb973994 (&dev->mutex){....}, at: usbdev_do_ioctl+0x193/0x3030 drivers/usb/core/devio.c:2388
2 locks held by systemd-udevd/23394:
squashfs: SQUASHFS error: unable to read xattr id index table
#0: 000000002ab1b836 (&rq->lock){-.-.}, at: rq_lock kernel/sched/sched.h:1824 [inline]
#0: 000000002ab1b836 (&rq->lock){-.-.}, at: __schedule+0x1f9/0x2040 kernel/sched/core.c:3455
#1: 000000009d92b859 (rcu_read_lock){....}, at: trace_sched_stat_runtime include/trace/events/sched.h:428 [inline]
#1: 000000009d92b859 (rcu_read_lock){....}, at: update_curr+0x2c3/0x870 kernel/sched/fair.c:857

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

NMI backtrace for cpu 0
CPU: 0 PID: 1567 Comm: khungtaskd Not tainted 4.19.183-syzkaller #0
Hardware name: Google Google Compute Engine/Google Compute Engine, BIOS Google 01/01/2011
Call Trace:
__dump_stack lib/dump_stack.c:77 [inline]
dump_stack+0x1fc/0x2ef lib/dump_stack.c:118
nmi_cpu_backtrace.cold+0x63/0xa2 lib/nmi_backtrace.c:101
nmi_trigger_cpumask_backtrace+0x1a6/0x1f0 lib/nmi_backtrace.c:62
trigger_all_cpu_backtrace include/linux/nmi.h:146 [inline]
check_hung_uninterruptible_tasks kernel/hung_task.c:203 [inline]
watchdog+0x991/0xe60 kernel/hung_task.c:287
hub 9-0:1.0: USB hub found
kthread+0x33f/0x460 kernel/kthread.c:259
ret_from_fork+0x24/0x30 arch/x86/entry/entry_64.S:415
hub 9-0:1.0: 8 ports detected
Sending NMI from CPU 0 to CPUs 1:
NMI backtrace for cpu 1
CPU: 1 PID: 23381 Comm: syz-executor.0 Not tainted 4.19.183-syzkaller #0
Hardware name: Google Google Compute Engine/Google Compute Engine, BIOS Google 01/01/2011
RIP: 0010:__read_once_size include/linux/compiler.h:261 [inline]
RIP: 0010:debug_spin_lock_before kernel/locking/spinlock_debug.c:85 [inline]
RIP: 0010:do_raw_spin_lock+0x9d/0x220 kernel/locking/spinlock_debug.c:112
Code: 01 00 48 39 c2 0f 84 26 01 00 00 4c 8d 65 08 48 b8 00 00 00 00 00 fc ff df 4c 89 e2 48 c1 ea 03 0f b6 14 02 4c 89 e0 83 e0 07 <83> c0 03 38 d0 7c 08 84 d2 0f 85 19 01 00 00 8b 55 08 65 8b 05 8a
RSP: 0018:ffff8880ba107ec0 EFLAGS: 00000046
RAX: 0000000000000000 RBX: 0000000000000000 RCX: 00000000000073ba
RDX: 0000000000000000 RSI: 0000000027a8b8bf RDI: ffff8880ba124c84
RBP: ffff8880ba124c80 R08: ffffffff8cd4b310 R09: 0000000000000003
R10: ffff88804681c9c0 R11: ffffffff8c65f05b R12: ffff8880ba124c88
R13: ffff8880ba124c90 R14: ffff8880ba124c80 R15: 0000000000000000
FS: 00007fb57a9aa700(0000) GS:ffff8880ba100000(0000) knlGS:0000000000000000
CS: 0010 DS: 0000 ES: 0000 CR0: 0000000080050033
CR2: 00007fb57a988d58 CR3: 000000009d0a7000 CR4: 00000000001406e0
DR0: 0000000000000000 DR1: 0000000000000000 DR2: 0000000000000000
DR3: 0000000000000000 DR6: 00000000fffe0ff0 DR7: 0000000000000400
Call Trace:
<IRQ>
__raw_spin_lock_irqsave include/linux/spinlock_api_smp.h:117 [inline]
_raw_spin_lock_irqsave+0x94/0xc0 kernel/locking/spinlock.c:152
hrtimer_interrupt+0xf9/0x9e0 kernel/time/hrtimer.c:1520
local_apic_timer_interrupt arch/x86/kernel/apic/apic.c:1071 [inline]
smp_apic_timer_interrupt+0x10c/0x550 arch/x86/kernel/apic/apic.c:1096
apic_timer_interrupt+0xf/0x20 arch/x86/entry/entry_64.S:894
</IRQ>
RIP: 0010:arch_local_save_flags arch/x86/include/asm/paravirt.h:784 [inline]
RIP: 0010:arch_local_irq_save arch/x86/include/asm/paravirt.h:806 [inline]
RIP: 0010:lock_is_held_type+0x64/0x210 kernel/locking/lockdep.c:3941
Code: d0 7c 08 84 d2 0f 85 5e 01 00 00 8b 83 84 08 00 00 85 c0 0f 85 38 01 00 00 48 c7 c0 40 82 f1 89 48 ba 00 00 00 00 00 fc ff df <48> c1 e8 03 80 3c 10 00 0f 85 6a 01 00 00 48 83 3d f6 ed a6 08 00
RSP: 0018:ffff8880497f7568 EFLAGS: 00000246 ORIG_RAX: ffffffffffffff13
RAX: ffffffff89f18240 RBX: ffff88804681c0c0 RCX: 0000000000000001
RDX: dffffc0000000000 RSI: 00000000ffffffff RDI: ffff88804681c944
RBP: ffffffff89f85e20 R08: ffffffff81c4470d R09: 0000000000000000
R10: 0000000000000003 R11: 0000000000000000 R12: 000000000000038c
R13: 0000000080000001 R14: ffffffff81c4470d R15: ffffffff8a070340
lock_is_held include/linux/lockdep.h:344 [inline]
___might_sleep+0x227/0x2b0 kernel/sched/core.c:6157
__mutex_lock_common kernel/locking/mutex.c:908 [inline]
__mutex_lock+0xab/0x1260 kernel/locking/mutex.c:1072
kernfs_drain fs/kernfs/dir.c:484 [inline]
__kernfs_remove+0x57d/0xa80 fs/kernfs/dir.c:1316
kernfs_remove+0x1f/0x30 fs/kernfs/dir.c:1351
sysfs_remove_dir+0xc1/0x100 fs/sysfs/dir.c:101
kobject_del lib/kobject.c:592 [inline]
kobject_del+0x43/0xf0 lib/kobject.c:584
device_del+0x6cb/0xaf0 drivers/base/core.c:2357
device_unregister+0x22/0xc0 drivers/base/core.c:2377
hub_disconnect+0x171/0x4b0 drivers/usb/core/hub.c:1696
usb_unbind_interface+0x1d9/0x910 drivers/usb/core/driver.c:423
__device_release_driver+0x394/0x6d0 drivers/base/dd.c:971
device_release_driver_internal drivers/base/dd.c:1004 [inline]
device_release_driver+0x23/0x30 drivers/base/dd.c:1029
usb_driver_release_interface+0x102/0x180 drivers/usb/core/driver.c:599
proc_ioctl+0x571/0x630 drivers/usb/core/devio.c:2179
proc_ioctl_default drivers/usb/core/devio.c:2222 [inline]
usbdev_do_ioctl+0x2773/0x3030 drivers/usb/core/devio.c:2536
usbdev_ioctl+0x21/0x30 drivers/usb/core/devio.c:2580
vfs_ioctl fs/ioctl.c:46 [inline]
file_ioctl fs/ioctl.c:501 [inline]
do_vfs_ioctl+0xcdb/0x12e0 fs/ioctl.c:688
ksys_ioctl+0x9b/0xc0 fs/ioctl.c:705
__do_sys_ioctl fs/ioctl.c:712 [inline]
__se_sys_ioctl fs/ioctl.c:710 [inline]
__x64_sys_ioctl+0x6f/0xb0 fs/ioctl.c:710
do_syscall_64+0xf9/0x620 arch/x86/entry/common.c:293
entry_SYSCALL_64_after_hwframe+0x49/0xbe
RIP: 0033:0x466459
Code: ff ff c3 66 2e 0f 1f 84 00 00 00 00 00 0f 1f 40 00 48 89 f8 48 89 f7 48 89 d6 48 89 ca 4d 89 c2 4d 89 c8 4c 8b 4c 24 08 0f 05 <48> 3d 01 f0 ff ff 73 01 c3 48 c7 c1 bc ff ff ff f7 d8 64 89 01 48
RSP: 002b:00007fb57a9aa188 EFLAGS: 00000246 ORIG_RAX: 0000000000000010
RAX: ffffffffffffffda RBX: 000000000056c008 RCX: 0000000000466459
RDX: 0000000020000380 RSI: 00000000c0105512 RDI: 0000000000000004
RBP: 00000000004bf9fb R08: 0000000000000000 R09: 0000000000000000
R10: 0000000000000000 R11: 0000000000000246 R12: 000000000056c008
R13: 00007fff27d01e9f R14: 00007fb57a9aa300 R15: 0000000000022000


---
This report is generated by a bot. It may contain errors.
See https://goo.gl/tpsmEJ for more information about syzbot.
syzbot engineers can be reached at syzk...@googlegroups.com.

syzbot will keep track of this issue. See:
https://goo.gl/tpsmEJ#status for how to communicate with syzbot.

syzbot

unread,
Jul 23, 2021, 7:59:18 AM7/23/21
to syzkaller...@googlegroups.com
Auto-closing this bug as obsolete.
Crashes did not happen for a while, no reproducer and no activity.
Reply all
Reply to author
Forward
0 new messages