syzbot


INFO: task hung in con_flush_chars (2)

Status: auto-closed as invalid on 2021/01/25 20:43
Subsystems: serial
[Documentation on labels]
First crash: 1346d, last: 1273d
Similar bugs (3)
Kernel Title Repro Cause bisect Fix bisect Count Last Reported Patched Status
upstream INFO: task hung in con_flush_chars (3) serial 1 947d 947d 0/26 auto-closed as invalid on 2021/12/18 10:46
upstream INFO: task hung in con_flush_chars serial 1 1469d 1469d 0/26 auto-closed as invalid on 2020/07/13 22:15
linux-4.14 INFO: task hung in con_flush_chars 2 1505d 1522d 0/1 auto-closed as invalid on 2020/07/08 07:44

Sample crash report:
INFO: task kworker/u4:3:115 blocked for more than 143 seconds.
      Not tainted 5.8.0-syzkaller #0
"echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message.
kworker/u4:3    D24936   115      2 0x00004000
Workqueue: events_unbound flush_to_ldisc
Call Trace:
 context_switch kernel/sched/core.c:3778 [inline]
 __schedule+0x8e5/0x21e0 kernel/sched/core.c:4527
 schedule+0xd0/0x2a0 kernel/sched/core.c:4602
 schedule_timeout+0x1d8/0x250 kernel/time/timer.c:1855
 __down_common kernel/locking/semaphore.c:220 [inline]
 __down+0x183/0x2a0 kernel/locking/semaphore.c:237
 down+0x57/0x80 kernel/locking/semaphore.c:61
 console_lock+0x25/0x80 kernel/printk/printk.c:2317
 con_flush_chars drivers/tty/vt/vt.c:3326 [inline]
 con_flush_chars+0x35/0x90 drivers/tty/vt/vt.c:3318
 __receive_buf drivers/tty/n_tty.c:1650 [inline]
 n_tty_receive_buf_common+0xbe1/0x2bc0 drivers/tty/n_tty.c:1742
 tty_ldisc_receive_buf+0xa9/0x190 drivers/tty/tty_buffer.c:461
 tty_port_default_receive_buf+0x6e/0xa0 drivers/tty/tty_port.c:38
 receive_buf drivers/tty/tty_buffer.c:481 [inline]
 flush_to_ldisc+0x20d/0x380 drivers/tty/tty_buffer.c:533
 process_one_work+0x94c/0x1670 kernel/workqueue.c:2269
 worker_thread+0x64c/0x1120 kernel/workqueue.c:2415
 kthread+0x3b5/0x4a0 kernel/kthread.c:292
 ret_from_fork+0x1f/0x30 arch/x86/entry/entry_64.S:294
INFO: task syz-executor.2:18887 blocked for more than 143 seconds.
      Not tainted 5.8.0-syzkaller #0
"echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message.
syz-executor.2  D28032 18887   6998 0x00000004
Call Trace:
 context_switch kernel/sched/core.c:3778 [inline]
 __schedule+0x8e5/0x21e0 kernel/sched/core.c:4527
 schedule+0xd0/0x2a0 kernel/sched/core.c:4602
 schedule_timeout+0x1d8/0x250 kernel/time/timer.c:1855
 __down_common kernel/locking/semaphore.c:220 [inline]
 __down+0x183/0x2a0 kernel/locking/semaphore.c:237
 down+0x57/0x80 kernel/locking/semaphore.c:61
 console_lock+0x25/0x80 kernel/printk/printk.c:2317
 do_fb_ioctl+0x2e4/0x690 drivers/video/fbdev/core/fbmem.c:1102
 fb_ioctl+0xdd/0x130 drivers/video/fbdev/core/fbmem.c:1181
 vfs_ioctl fs/ioctl.c:48 [inline]
 __do_sys_ioctl fs/ioctl.c:753 [inline]
 __se_sys_ioctl fs/ioctl.c:739 [inline]
 __x64_sys_ioctl+0x193/0x200 fs/ioctl.c:739
 do_syscall_64+0x2d/0x70 arch/x86/entry/common.c:46
 entry_SYSCALL_64_after_hwframe+0x44/0xa9
RIP: 0033:0x45d239
Code: Bad RIP value.
RSP: 002b:00007f88c4d51c78 EFLAGS: 00000246 ORIG_RAX: 0000000000000010
RAX: ffffffffffffffda RBX: 000000000000d580 RCX: 000000000045d239
RDX: 0000000020000200 RSI: 0000000000004601 RDI: 0000000000000003
RBP: 000000000118cf80 R08: 0000000000000000 R09: 0000000000000000
R10: 0000000000000000 R11: 0000000000000246 R12: 000000000118cf4c
R13: 000000000169fb6f R14: 00007f88c4d529c0 R15: 000000000118cf4c
INFO: task syz-executor.5:18884 blocked for more than 143 seconds.
      Not tainted 5.8.0-syzkaller #0
"echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message.
syz-executor.5  D28736 18884   7209 0x00000004
Call Trace:
 context_switch kernel/sched/core.c:3778 [inline]
 __schedule+0x8e5/0x21e0 kernel/sched/core.c:4527
 schedule+0xd0/0x2a0 kernel/sched/core.c:4602
 schedule_timeout+0x1d8/0x250 kernel/time/timer.c:1855
 __down_common kernel/locking/semaphore.c:220 [inline]
 __down+0x183/0x2a0 kernel/locking/semaphore.c:237
 down+0x57/0x80 kernel/locking/semaphore.c:61
 console_lock+0x25/0x80 kernel/printk/printk.c:2317
 do_fb_ioctl+0x2e4/0x690 drivers/video/fbdev/core/fbmem.c:1102
 fb_ioctl+0xdd/0x130 drivers/video/fbdev/core/fbmem.c:1181
 vfs_ioctl fs/ioctl.c:48 [inline]
 __do_sys_ioctl fs/ioctl.c:753 [inline]
 __se_sys_ioctl fs/ioctl.c:739 [inline]
 __x64_sys_ioctl+0x193/0x200 fs/ioctl.c:739
 do_syscall_64+0x2d/0x70 arch/x86/entry/common.c:46
 entry_SYSCALL_64_after_hwframe+0x44/0xa9
RIP: 0033:0x45d239
Code: Bad RIP value.
RSP: 002b:00007f1a00ce1c78 EFLAGS: 00000246 ORIG_RAX: 0000000000000010
RAX: ffffffffffffffda RBX: 000000000000d580 RCX: 000000000045d239
RDX: 0000000020000200 RSI: 0000000000004601 RDI: 0000000000000003
RBP: 000000000118cf80 R08: 0000000000000000 R09: 0000000000000000
R10: 0000000000000000 R11: 0000000000000246 R12: 000000000118cf4c
R13: 000000000169fb6f R14: 00007f1a00ce29c0 R15: 000000000118cf4c

Showing all locks held in the system:
5 locks held by kworker/u4:3/115:
 #0: ffff8880aa071138 ((wq_completion)events_unbound){+.+.}-{0:0}, at: arch_atomic64_set arch/x86/include/asm/atomic64_64.h:34 [inline]
 #0: ffff8880aa071138 ((wq_completion)events_unbound){+.+.}-{0:0}, at: atomic64_set include/asm-generic/atomic-instrumented.h:856 [inline]
 #0: ffff8880aa071138 ((wq_completion)events_unbound){+.+.}-{0:0}, at: atomic_long_set include/asm-generic/atomic-long.h:41 [inline]
 #0: ffff8880aa071138 ((wq_completion)events_unbound){+.+.}-{0:0}, at: set_work_data kernel/workqueue.c:616 [inline]
 #0: ffff8880aa071138 ((wq_completion)events_unbound){+.+.}-{0:0}, at: set_work_pool_and_clear_pending kernel/workqueue.c:643 [inline]
 #0: ffff8880aa071138 ((wq_completion)events_unbound){+.+.}-{0:0}, at: process_one_work+0x82b/0x1670 kernel/workqueue.c:2240
 #1: ffffc90001347da8 ((work_completion)(&buf->work)){+.+.}-{0:0}, at: process_one_work+0x85f/0x1670 kernel/workqueue.c:2244
 #2: ffff8880aa1ff0b8 (&buf->lock){+.+.}-{3:3}, at: flush_to_ldisc+0x3e/0x380 drivers/tty/tty_buffer.c:505
 #3: ffff8880a6b94098 (&tty->ldisc_sem){++++}-{0:0}, at: tty_ldisc_ref+0x1d/0x80 drivers/tty/tty_ldisc.c:288
 #4: ffff8880a6b942e8 (&tty->termios_rwsem){++++}-{3:3}, at: n_tty_receive_buf_common+0x89/0x2bc0 drivers/tty/n_tty.c:1705
1 lock held by khungtaskd/1169:
 #0: ffffffff89bd6380 (rcu_read_lock){....}-{1:2}, at: debug_show_all_locks+0x53/0x260 kernel/locking/lockdep.c:5825
1 lock held by in:imklog/6529:
 #0: ffff8880a7fca370 (&f->f_pos_lock){+.+.}-{3:3}, at: __fdget_pos+0xe9/0x100 fs/file.c:930
5 locks held by syz-executor.3/18883:

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

NMI backtrace for cpu 1
CPU: 1 PID: 1169 Comm: khungtaskd Not tainted 5.8.0-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+0x18f/0x20d lib/dump_stack.c:118
 nmi_cpu_backtrace.cold+0x70/0xb1 lib/nmi_backtrace.c:101
 nmi_trigger_cpumask_backtrace+0x1b3/0x223 lib/nmi_backtrace.c:62
 trigger_all_cpu_backtrace include/linux/nmi.h:146 [inline]
 check_hung_uninterruptible_tasks kernel/hung_task.c:209 [inline]
 watchdog+0xd7d/0x1000 kernel/hung_task.c:295
 kthread+0x3b5/0x4a0 kernel/kthread.c:292
 ret_from_fork+0x1f/0x30 arch/x86/entry/entry_64.S:294
Sending NMI from CPU 1 to CPUs 0:
NMI backtrace for cpu 0
CPU: 0 PID: 18883 Comm: syz-executor.3 Not tainted 5.8.0-syzkaller #0
Hardware name: Google Google Compute Engine/Google Compute Engine, BIOS Google 01/01/2011
RIP: 0010:vga16fb_fillrect+0x9c4/0x193b drivers/video/fbdev/vga16fb.c:922
Code: 44 24 10 45 31 f6 48 89 04 24 e8 17 a7 aa fd 31 ff 89 de 31 ed e8 8c a3 aa fd 85 db 4d 89 ec 74 22 e8 00 a7 aa fd 45 88 34 24 <83> c5 01 89 df 49 83 c4 01 89 ee e8 ec a2 aa fd 39 eb 75 e3 89 d8
RSP: 0018:ffffc900086676b0 EFLAGS: 00000246
RAX: 0000000000040000 RBX: 0000000000000010 RCX: ffffc9000e7fd000
RDX: 0000000000040000 RSI: ffffffff83c9a710 RDI: 0000000000000004
RBP: 0000000000000005 R08: 0000000000000010 R09: 0000000000000080
R10: 0000000000000010 R11: 0000000000000001 R12: ffff8880000a0005
R13: ffff8880000a0000 R14: 0000000000000000 R15: 00000000c216c3f1
FS:  00007f63075cc700(0000) GS:ffff8880ae600000(0000) knlGS:0000000000000000
CS:  0010 DS: 0000 ES: 0000 CR0: 0000000080050033
CR2: 0000000000745918 CR3: 00000000a92b7000 CR4: 00000000001526f0
DR0: 0000000000000000 DR1: 0000000000000000 DR2: 0000000000000000
DR3: 0000000000000000 DR6: 00000000fffe0ff0 DR7: 0000000000000400
Call Trace:
 bit_clear+0x386/0x4d0 drivers/video/fbdev/core/bitblit.c:74
 fbcon_clear+0x519/0x5a0 drivers/video/fbdev/core/fbcon.c:1351
 fbcon_scroll+0x1e20/0x3600 drivers/video/fbdev/core/fbcon.c:1980
 con_scroll+0x5b9/0x6d0 drivers/tty/vt/vt.c:629
 csi_M drivers/tty/vt/vt.c:2035 [inline]
 do_con_trol+0x45fe/0x51e0 drivers/tty/vt/vt.c:2426
 do_con_write+0xb7f/0x1d70 drivers/tty/vt/vt.c:2905
 con_write+0x22/0xb0 drivers/tty/vt/vt.c:3249
 n_tty_write+0xa38/0xf80 drivers/tty/n_tty.c:2356
 do_tty_write drivers/tty/tty_io.c:962 [inline]
 tty_write+0x4d9/0x870 drivers/tty/tty_io.c:1046
 vfs_write+0x2b0/0x730 fs/read_write.c:576
 ksys_write+0x12d/0x250 fs/read_write.c:631
 do_syscall_64+0x2d/0x70 arch/x86/entry/common.c:46
 entry_SYSCALL_64_after_hwframe+0x44/0xa9
RIP: 0033:0x45d239
Code: 5d b4 fb ff c3 66 2e 0f 1f 84 00 00 00 00 00 66 90 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 0f 83 2b b4 fb ff c3 66 2e 0f 1f 84 00 00 00 00
RSP: 002b:00007f63075cbc78 EFLAGS: 00000246 ORIG_RAX: 0000000000000001
RAX: ffffffffffffffda RBX: 0000000000037ac0 RCX: 000000000045d239
RDX: 0000000000001006 RSI: 0000000020001440 RDI: 0000000000000005
RBP: 000000000118cf80 R08: 0000000000000000 R09: 0000000000000000
R10: 0000000000000000 R11: 0000000000000246 R12: 000000000118cf4c
R13: 000000000169fb6f R14: 00007f63075cc9c0 R15: 000000000118cf4c

Crashes (2):
Time Kernel Commit Syzkaller Config Log Report Syz repro C repro VM info Assets (help?) Manager Title
2020/08/15 22:44 upstream c9c9735c46f5 424dd8e7 .config console log report ci-upstream-kasan-gce
2020/10/27 20:38 https://git.kernel.org/pub/scm/linux/kernel/git/gregkh/usb.git usb-testing 3650b228f83a 94942294 .config console log report info ci2-upstream-usb
* Struck through repros no longer work on HEAD.