syzbot


INFO: task hung in do_read_cache_page (3)

Status: upstream: reported C repro on 2020/01/27 06:32
Reported-by: syzbot+518c54e255b5031adde4@syzkaller.appspotmail.com
First crash: 1045d, last: 147d

Cause bisection: introduced by (bisect log) :
commit 2da22da573481cc4837e246d0eee4d518b3f715e
Author: Mike Christie <mchristi@redhat.com>
Date: Tue Aug 13 16:39:52 2019 +0000

  nbd: fix zero cmd timeout handling v2

Crash: INFO: task hung in do_read_cache_page (log)
Repro: C syz .config

Fix bisection: the fix commit could be any of (bisect log):
  a1b8638ba132 Linux 5.9-rc7
  568035b01cfb Linux 6.0-rc1
similar bugs (7):
Kernel Title Repro Cause bisect Fix bisect Count Last Reported Patched Status
linux-4.19 INFO: task hung in do_read_cache_page (2) C error 24 14d 665d 0/1 upstream: reported C repro on 2021/02/09 08:22
upstream INFO: task hung in do_read_cache_page 10 1611d 1714d 0/24 auto-closed as invalid on 2019/02/22 10:09
linux-4.14 INFO: task hung in do_read_cache_page 2 143d 180d 0/1 auto-obsoleted due to no activity on 2022/11/13 17:53
android-49 INFO: task hung in do_read_cache_page 1 1655d 1655d 0/3 auto-closed as invalid on 2019/02/22 13:59
upstream INFO: task hung in do_read_cache_page (2) 1 1181d 1181d 0/24 auto-closed as invalid on 2019/11/11 08:43
linux-4.19 INFO: task hung in do_read_cache_page C done 2 723d 783d 1/1 fixed on 2021/01/13 11:08
upstream INFO: task can't die in wait_on_page_bit_common C done 5 477d 830d 0/24 upstream: reported C repro on 2020/08/28 22:28
Patch testing requests:
Created Duration User Patch Repo Result
2022/10/21 11:30 16m retest repro upstream report log
2022/10/21 11:30 18m retest repro upstream OK log
2022/10/21 09:30 16m retest repro upstream report log
2022/10/21 09:30 19m retest repro upstream OK log
2022/10/21 07:30 16m retest repro upstream report log
2022/10/21 06:30 16m retest repro upstream report log
2022/10/21 00:30 18m retest repro upstream OK log

Sample crash report:
INFO: task syz-executor453:6836 blocked for more than 143 seconds.
      Not tainted 5.9.0-rc3-syzkaller #0
"echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message.
task:syz-executor453 state:D stack:27632 pid: 6836 ppid:  6825 flags:0x00004004
Call Trace:
 context_switch kernel/sched/core.c:3778 [inline]
 __schedule+0xea9/0x2230 kernel/sched/core.c:4527
 schedule+0xd0/0x2a0 kernel/sched/core.c:4602
 io_schedule+0xb5/0x120 kernel/sched/core.c:6296
 wait_on_page_bit_common+0x52c/0xca0 mm/filemap.c:1191
 wait_on_page_bit mm/filemap.c:1216 [inline]
 wait_on_page_locked include/linux/pagemap.h:611 [inline]
 do_read_cache_page+0x257/0x1390 mm/filemap.c:2915
 read_mapping_page include/linux/pagemap.h:437 [inline]
 read_part_sector+0xf6/0x5af block/partitions/core.c:770
 adfspart_check_ICS+0x9d/0xc90 block/partitions/acorn.c:360
 check_partition block/partitions/core.c:140 [inline]
 blk_add_partitions+0x44b/0xe10 block/partitions/core.c:698
 bdev_disk_changed+0x1ea/0x370 fs/block_dev.c:1416
 __blkdev_get+0xee4/0x1aa0 fs/block_dev.c:1559
 blkdev_get fs/block_dev.c:1639 [inline]
 blkdev_open+0x227/0x300 fs/block_dev.c:1753
 do_dentry_open+0x4b9/0x11b0 fs/open.c:817
 do_open fs/namei.c:3251 [inline]
 path_openat+0x1b9a/0x2730 fs/namei.c:3368
 do_filp_open+0x17e/0x3c0 fs/namei.c:3395
 do_sys_openat2+0x16d/0x420 fs/open.c:1168
 do_sys_open fs/open.c:1184 [inline]
 __do_sys_open fs/open.c:1192 [inline]
 __se_sys_open fs/open.c:1188 [inline]
 __x64_sys_open+0x119/0x1c0 fs/open.c:1188
 do_syscall_64+0x2d/0x70 arch/x86/entry/common.c:46
 entry_SYSCALL_64_after_hwframe+0x44/0xa9
RIP: 0033:0x4057a1
Code: Bad RIP value.
RSP: 002b:00007fc7fd2ee980 EFLAGS: 00000293 ORIG_RAX: 0000000000000002
RAX: ffffffffffffffda RBX: 0000000000000000 RCX: 00000000004057a1
RDX: 0000000000000000 RSI: 0000000000000000 RDI: 00007fc7fd2ee990
RBP: 6666666666666667 R08: 000000000000000f R09: 00007fc7fd2ef700
R10: 00007fc7fd2ef9d0 R11: 0000000000000293 R12: 00000000006dbc2c
R13: 00007ffe05d2c11f R14: 00007fc7fd2ef9c0 R15: 20c49ba5e353f7cf

Showing all locks held in the system:
1 lock held by khungtaskd/1172:
 #0: ffffffff89bd6a40 (rcu_read_lock){....}-{1:2}, at: debug_show_all_locks+0x53/0x260 kernel/locking/lockdep.c:5829
1 lock held by in:imklog/6627:
 #0: ffff8880a1db7670 (&f->f_pos_lock){+.+.}-{3:3}, at: __fdget_pos+0xe9/0x100 fs/file.c:930
1 lock held by syz-executor453/6836:
 #0: ffff88808aad0340 (&bdev->bd_mutex){+.+.}-{3:3}, at: __blkdev_get+0x4b8/0x1aa0 fs/block_dev.c:1492

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

NMI backtrace for cpu 1
CPU: 1 PID: 1172 Comm: khungtaskd Not tainted 5.9.0-rc3-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+0x198/0x1fd 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: 3900 Comm: systemd-journal Not tainted 5.9.0-rc3-syzkaller #0
Hardware name: Google Google Compute Engine/Google Compute Engine, BIOS Google 01/01/2011
RIP: 0010:cache_free_alien mm/slab.c:801 [inline]
RIP: 0010:___cache_free+0x3e5/0x730 mm/slab.c:3448
Code: c7 48 b8 00 00 00 00 00 ea ff ff 48 c1 e7 06 48 01 c7 48 8b 17 48 83 fa ff 0f 84 ef 01 00 00 48 c1 ea 3a 65 8b 05 fb 42 4f 7e <39> c2 0f 84 91 fe ff ff 4c 8d 6c 24 18 48 98 4c 89 64 24 10 48 63
RSP: 0018:ffffc900055f7cf8 EFLAGS: 00000046
RAX: 0000000000000000 RBX: ffff8880ae63fba8 RCX: ffffffff8134b990
RDX: 0000000000000000 RSI: ffffffff8134b99a RDI: ffffea00024b9280
RBP: ffff8880aa040900 R08: 0000000000000001 R09: 0000000000000001
R10: 0000000000000000 R11: 0000000000000000 R12: ffff888092e4a000
R13: ffffea00024b9280 R14: 0000000000000200 R15: dffffc0000000000
FS:  00007f7e855108c0(0000) GS:ffff8880ae600000(0000) knlGS:0000000000000000
CS:  0010 DS: 0000 ES: 0000 CR0: 0000000080050033
CR2: 00007f7e828b2020 CR3: 00000000932cd000 CR4: 00000000001506f0
DR0: 0000000000000000 DR1: 0000000000000000 DR2: 0000000000000000
DR3: 0000000000000000 DR6: 00000000fffe0ff0 DR7: 0000000000000400
Call Trace:
 qlink_free mm/kasan/quarantine.c:149 [inline]
 qlist_free_all+0x98/0x170 mm/kasan/quarantine.c:168
 quarantine_reduce+0x17e/0x200 mm/kasan/quarantine.c:261
 __kasan_kmalloc.constprop.0+0x9e/0xd0 mm/kasan/common.c:442
 slab_post_alloc_hook mm/slab.h:518 [inline]
 slab_alloc mm/slab.c:3312 [inline]
 kmem_cache_alloc+0x13a/0x3a0 mm/slab.c:3482
 prepare_creds+0x39/0x6c0 kernel/cred.c:258
 access_override_creds fs/open.c:353 [inline]
 do_faccessat+0x3d7/0x820 fs/open.c:417
 do_syscall_64+0x2d/0x70 arch/x86/entry/common.c:46
 entry_SYSCALL_64_after_hwframe+0x44/0xa9
RIP: 0033:0x7f7e847cc9c7
Code: 83 c4 08 48 3d 01 f0 ff ff 73 01 c3 48 8b 0d c8 d4 2b 00 f7 d8 64 89 01 48 83 c8 ff c3 66 0f 1f 44 00 00 b8 15 00 00 00 0f 05 <48> 3d 01 f0 ff ff 73 01 c3 48 8b 0d a1 d4 2b 00 f7 d8 64 89 01 48
RSP: 002b:00007ffd455eb1b8 EFLAGS: 00000246 ORIG_RAX: 0000000000000015
RAX: ffffffffffffffda RBX: 00007ffd455ee0d0 RCX: 00007f7e847cc9c7
RDX: 00007f7e8523da00 RSI: 0000000000000000 RDI: 0000557d3179b9a3
RBP: 00007ffd455eb1f0 R08: 0000000000000000 R09: 0000000000000000
R10: 0000000000000069 R11: 0000000000000246 R12: 0000000000000000
R13: 0000000000000000 R14: 00007ffd455ee0d0 R15: 00007ffd455eb6e0

Crashes (88):
Manager Time Kernel Commit Syzkaller Config Log Report Syz repro C repro VM info Title
ci-upstream-kasan-gce-root 2020/09/03 21:50 upstream fc3abb53250a abf9ba4f .config log report syz C
ci-upstream-kasan-gce-selinux-root 2020/09/02 12:44 upstream b765a32a2e91 abf9ba4f .config log report syz C
ci-upstream-kasan-gce-root 2020/09/02 04:25 upstream b765a32a2e91 abf9ba4f .config log report syz C
ci-upstream-kasan-gce-selinux-root 2020/05/11 05:57 upstream e99332e7b4cd 8742a2b9 .config log report syz C
ci-upstream-kasan-gce-root 2020/09/28 17:34 upstream a1b8638ba132 6bfdbe89 .config log report syz C
ci-upstream-kasan-gce-selinux-root 2020/08/24 06:18 upstream cb95712138ec cef5ae68 .config log report syz C
ci-upstream-kasan-gce-root 2020/08/24 04:38 upstream cb95712138ec cef5ae68 .config log report syz C
ci-upstream-kasan-gce-root 2022/01/12 08:55 upstream 6f38be8f2ccd 44d1319a .config log report info INFO: task hung in do_read_cache_page
ci-upstream-kasan-gce-root 2022/01/11 01:39 upstream df0cc57e057f ddb0ab8c .config log report info INFO: task hung in do_read_cache_page
ci-upstream-kasan-gce-smack-root 2022/01/10 13:30 upstream df0cc57e057f 2ca0d385 .config log report info INFO: task hung in do_read_cache_page
ci-upstream-kasan-gce-selinux-root 2021/12/27 06:04 upstream fc74e0a40e4f e4f103c4 .config log report info INFO: task hung in do_read_cache_page
ci-upstream-kasan-gce-selinux-root 2021/12/20 22:27 upstream 86085fe79e3c 62bd192b .config log report info INFO: task hung in do_read_cache_page
ci-upstream-kasan-gce-root 2021/12/20 14:32 upstream a7904a538933 021b36cb .config log report info INFO: task hung in do_read_cache_page
ci-upstream-kasan-gce-selinux-root 2021/12/17 08:29 upstream fa36bbe6d43f 44068e19 .config log report info INFO: task hung in do_read_cache_page
ci-upstream-kasan-gce-root 2021/12/15 14:24 upstream 5472f14a3742 f752fb53 .config log report info INFO: task hung in do_read_cache_page
ci-upstream-kasan-gce-selinux-root 2021/12/14 07:23 upstream 5472f14a3742 5d14b1ea .config log report info INFO: task hung in do_read_cache_page
ci-upstream-kasan-gce-root 2021/12/13 07:02 upstream 90d9fbc16b69 49ca1f59 .config log report info INFO: task hung in do_read_cache_page
ci-upstream-kasan-gce-smack-root 2021/12/10 04:55 upstream c741e49150db 4d4ce9bc .config log report info INFO: task hung in do_read_cache_page
ci-upstream-kasan-gce-selinux-root 2021/12/05 20:36 upstream 79a72162048e a617004c .config log report info INFO: task hung in do_read_cache_page
ci-upstream-kasan-gce-root 2021/11/29 07:27 upstream d06c942efea4 63eeac02 .config log report info INFO: task hung in do_read_cache_page
ci-upstream-kasan-gce-root 2021/11/18 21:27 upstream 42eb8fdac2fc 31a30fc0 .config log report info INFO: task hung in do_read_cache_page
ci-upstream-kasan-gce-root 2021/11/06 11:55 upstream d4439a1189f9 4c1be0be .config log report info INFO: task hung in do_read_cache_page
ci-upstream-kasan-gce-root 2021/10/22 16:53 upstream 2f111a6fd5b5 55f90bc6 .config log report info INFO: task hung in do_read_cache_page
ci-upstream-kasan-gce-selinux-root 2021/10/04 07:21 upstream 9e1ff307c779 db0f5787 .config log report info INFO: task hung in do_read_cache_page
ci-upstream-kasan-gce-root 2021/09/30 03:20 upstream 02d5e016800d be530f6c .config log report info INFO: task hung in do_read_cache_page
ci-upstream-kasan-gce-root 2021/09/25 08:40 upstream 4c4f0c2bf341 8cac236e .config log report info INFO: task hung in do_read_cache_page
ci-upstream-kasan-gce-smack-root 2021/09/16 05:37 upstream b7213ffa0e58 07e953c1 .config log report info INFO: task hung in do_read_cache_page
ci-upstream-kasan-gce-root 2021/09/12 01:32 upstream c605c39677b9 5ae8508a .config log report info INFO: task hung in do_read_cache_page
ci-upstream-kasan-gce-selinux-root 2021/09/10 18:38 upstream bf9f243f23e6 5ae8508a .config log report info INFO: task hung in do_read_cache_page
ci-upstream-kasan-gce-smack-root 2021/09/01 22:02 upstream 835d31d319d9 7eb7e152 .config log report info INFO: task hung in do_read_cache_page
ci-upstream-kasan-gce-smack-root 2021/08/30 04:31 upstream 90ac80dcd313 be2c130d .config log report info INFO: task hung in do_read_cache_page
ci-upstream-kasan-gce-selinux-root 2021/08/29 18:02 upstream 3f5ad13cb012 be2c130d .config log report info INFO: task hung in do_read_cache_page
ci-upstream-kasan-gce-root 2021/08/28 09:18 upstream 1a6436f37512 d5a29e53 .config log report info INFO: task hung in do_read_cache_page
ci-upstream-kasan-gce-root 2021/08/22 02:23 upstream fa54d366a6e4 b599f2fc .config log report info INFO: task hung in do_read_cache_page
ci-upstream-kasan-gce-root 2021/08/18 23:00 upstream 614cb2751d31 a2fe1cb5 .config log report info INFO: task hung in do_read_cache_page
ci-upstream-kasan-gce-smack-root 2021/08/17 23:59 upstream 794c7931a242 a2fe1cb5 .config log report info INFO: task hung in do_read_cache_page
ci-upstream-kasan-gce-selinux-root 2021/08/15 14:46 upstream 0aa78d17099b 2489ab88 .config log report info INFO: task hung in do_read_cache_page
ci-upstream-kasan-gce-root 2021/08/15 06:12 upstream ba31f97d43be 2489ab88 .config log report info INFO: task hung in do_read_cache_page
ci-upstream-kasan-gce-selinux-root 2021/08/09 03:35 upstream 66745863ecde 6972b106 .config log report info INFO: task hung in do_read_cache_page
ci-upstream-kasan-gce-root 2021/08/08 22:50 upstream 85a90500f9a1 6972b106 .config log report info INFO: task hung in do_read_cache_page
ci-upstream-kasan-gce-root 2021/08/07 13:02 upstream 894d6f401b21 6972b106 .config log report info INFO: task hung in do_read_cache_page
ci-upstream-kasan-gce-smack-root 2021/08/01 20:04 upstream f3438b4c4e69 6c236867 .config log report info INFO: task hung in do_read_cache_page
ci-upstream-kasan-gce-selinux-root 2021/07/27 06:25 upstream ff1176468d36 fd511809 .config log report info INFO: task hung in do_read_cache_page
ci-upstream-kasan-gce-root 2021/07/23 13:29 upstream 9bead1b58c4c bc5f1d88 .config log report info INFO: task hung in do_read_cache_page
ci-upstream-kasan-gce-smack-root 2021/07/21 08:51 upstream 8cae8cd89f05 1b201b48 .config log report info INFO: task hung in do_read_cache_page
ci-upstream-kasan-gce-smack-root 2021/07/13 10:51 upstream 7fef2edf7cc7 f415556d .config log report info INFO: task hung in do_read_cache_page
ci-upstream-kasan-gce-root 2021/06/29 13:42 upstream 233a806b00e3 9d2ab5df .config log report info INFO: task hung in do_read_cache_page
ci-upstream-kasan-gce-smack-root 2021/05/24 06:20 upstream 6ebb6814a1ef 3c7fef33 .config log report info INFO: task hung in do_read_cache_page
ci-upstream-kasan-gce-root 2021/05/22 23:42 upstream 23d729263037 3c7fef33 .config log report info INFO: task hung in do_read_cache_page
ci-upstream-kasan-gce-selinux-root 2021/05/22 15:46 upstream 45af60e7ced0 3c7fef33 .config log report info INFO: task hung in do_read_cache_page
ci-upstream-linux-next-kasan-gce-root 2021/11/15 18:37 linux-next 09bd48c4acfa 83f5c9b5 .config log report info INFO: task hung in do_read_cache_page
ci-upstream-linux-next-kasan-gce-root 2021/10/24 08:55 linux-next cf6c9d12750c 282f03fb .config log report info INFO: task hung in do_read_cache_page
ci-upstream-linux-next-kasan-gce-root 2021/09/03 10:06 linux-next c1b13fe76e95 f62a5829 .config log report info INFO: task hung in do_read_cache_page
ci-upstream-linux-next-kasan-gce-root 2021/08/16 12:47 linux-next b9011c7e671d 33c26cb7 .config log report info INFO: task hung in do_read_cache_page
ci-upstream-linux-next-kasan-gce-root 2021/08/15 12:30 linux-next 4b358aabb93a 2489ab88 .config log report info INFO: task hung in do_read_cache_page
ci-upstream-linux-next-kasan-gce-root 2021/08/05 02:15 linux-next 8d4b477da1a8 b97d64c9 .config log report info INFO: task hung in do_read_cache_page
ci-upstream-linux-next-kasan-gce-root 2021/08/04 15:00 linux-next 8d4b477da1a8 6c236867 .config log report info INFO: task hung in do_read_cache_page
ci-upstream-linux-next-kasan-gce-root 2021/08/02 14:28 linux-next 8d4b477da1a8 6c236867 .config log report info INFO: task hung in do_read_cache_page
ci-upstream-kasan-gce-selinux-root 2021/01/14 06:50 upstream 65f0d2414b70 269d24e8 .config log report info
ci-upstream-kasan-gce-selinux-root 2020/07/11 05:11 upstream a581387e415b 18d18b59 .config log report
ci-upstream-kasan-gce-selinux-root 2020/01/26 13:48 upstream 2821e26f3a0a f4e7270e .config log report
ci-upstream-linux-next-kasan-gce-root 2020/07/17 00:03 linux-next 4c43049f19a2 54b3c45e .config log report
ci-upstream-linux-next-kasan-gce-root 2020/07/16 14:23 linux-next ca0e494af5ed f3bec699 .config log report
ci-upstream-linux-next-kasan-gce-root 2020/07/12 09:07 linux-next d31958b30ea3 115e1930 .config log report
ci-upstream-linux-next-kasan-gce-root 2020/06/30 08:02 linux-next 36e3135df4d4 a2cdad9d .config log report
* Struck through repros no longer work on HEAD.