bisecting fixing commit since c98875d930e915d01e8c40c7d3c16f00b3c8abe1 building syzkaller on 53199d6e8aee5f0ebd3775d2b1c674f4e6e64e2b testing commit c98875d930e915d01e8c40c7d3c16f00b3c8abe1 with gcc (GCC) 8.1.0 kernel signature: 38261602554f4cc6f123f4e7ddcf573226d1413eef043bdc8b9ced4c76be9500 all runs: crashed: INFO: task hung in aead_recvmsg testing current HEAD dda0e2920330128e0dbdeb11c8f25031aa40b11c testing commit dda0e2920330128e0dbdeb11c8f25031aa40b11c with gcc (GCC) 8.1.0 kernel signature: f3d90413ed0c37555635b1a4a571d444bd3fc0bdf953f1048914ced06f5b5c3b all runs: crashed: INFO: task hung in aead_recvmsg revisions tested: 2, total time: 28m50.71199751s (build: 16m49.310926538s, test: 11m26.42032755s) the crash still happens on HEAD commit msg: Linux 4.19.114 crash: INFO: task hung in aead_recvmsg 8021q: adding VLAN 0 to HW filter on device batadv0 IPv6: ADDRCONF(NETDEV_UP): vxcan1: link is not ready 8021q: adding VLAN 0 to HW filter on device batadv0 8021q: adding VLAN 0 to HW filter on device batadv0 INFO: task syz-executor.1:7219 blocked for more than 140 seconds. Not tainted 4.19.114-syzkaller #0 "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. syz-executor.1 D28584 7219 6242 0x00000004 Call Trace: context_switch kernel/sched/core.c:2826 [inline] __schedule+0x792/0x1c20 kernel/sched/core.c:3515 schedule+0x7f/0x1b0 kernel/sched/core.c:3559 schedule_timeout+0x6d7/0xda0 kernel/time/timer.c:1782 do_wait_for_common kernel/sched/completion.c:83 [inline] __wait_for_common kernel/sched/completion.c:104 [inline] wait_for_common kernel/sched/completion.c:115 [inline] wait_for_completion+0x282/0x460 kernel/sched/completion.c:136 crypto_wait_req include/linux/crypto.h:517 [inline] _aead_recvmsg crypto/algif_aead.c:313 [inline] aead_recvmsg+0x1182/0x1fb0 crypto/algif_aead.c:334 sock_recvmsg_nosec net/socket.c:795 [inline] sock_recvmsg+0xb9/0xf0 net/socket.c:802 sock_read_iter+0x252/0x430 net/socket.c:879 call_read_iter include/linux/fs.h:1815 [inline] do_iter_readv_writev+0x3f2/0x960 fs/read_write.c:679 do_iter_read+0x1db/0x580 fs/read_write.c:923 vfs_readv+0xc9/0x130 fs/read_write.c:987 do_readv+0x110/0x330 fs/read_write.c:1020 __do_sys_readv fs/read_write.c:1107 [inline] __se_sys_readv fs/read_write.c:1104 [inline] __x64_sys_readv+0x70/0xb0 fs/read_write.c:1104 do_syscall_64+0xd6/0x4e0 arch/x86/entry/common.c:293 entry_SYSCALL_64_after_hwframe+0x49/0xbe RIP: 0033:0x458c29 Code: 08 48 c7 44 24 10 04 00 00 00 e8 62 d8 fa ff 48 8b 44 24 18 48 8b 4c 24 30 48 83 c1 08 48 89 0c 24 48 89 44 24 08 48 c7 44 24 <10> 10 00 00 00 e8 3d d8 fa ff 48 8b 44 24 18 48 89 44 24 40 48 8b RSP: 002b:00007efca86fdc78 EFLAGS: 00000246 ORIG_RAX: 0000000000000013 RAX: ffffffffffffffda RBX: 0000000000000003 RCX: 0000000000458c29 RDX: 0000000000000001 RSI: 00000000200007c0 RDI: 0000000000000004 RBP: 000000000073bf00 R08: 0000000000000000 R09: 0000000000000000 R10: 0000000000000000 R11: 0000000000000246 R12: 00007efca86fe6d4 R13: 00000000004c5985 R14: 00000000004d9fe0 R15: 00000000ffffffff INFO: task syz-executor.1:7239 blocked for more than 140 seconds. Not tainted 4.19.114-syzkaller #0 "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. syz-executor.1 D28344 7239 6242 0x00000004 Call Trace: context_switch kernel/sched/core.c:2826 [inline] __schedule+0x792/0x1c20 kernel/sched/core.c:3515 schedule+0x7f/0x1b0 kernel/sched/core.c:3559 schedule_timeout+0x6d7/0xda0 kernel/time/timer.c:1782 do_wait_for_common kernel/sched/completion.c:83 [inline] __wait_for_common kernel/sched/completion.c:104 [inline] wait_for_common kernel/sched/completion.c:115 [inline] wait_for_completion+0x282/0x460 kernel/sched/completion.c:136 crypto_wait_req include/linux/crypto.h:517 [inline] _aead_recvmsg crypto/algif_aead.c:313 [inline] aead_recvmsg+0x1182/0x1fb0 crypto/algif_aead.c:334 sock_recvmsg_nosec net/socket.c:795 [inline] sock_recvmsg+0xb9/0xf0 net/socket.c:802 sock_read_iter+0x252/0x430 net/socket.c:879 call_read_iter include/linux/fs.h:1815 [inline] do_iter_readv_writev+0x3f2/0x960 fs/read_write.c:679 do_iter_read+0x1db/0x580 fs/read_write.c:923 vfs_readv+0xc9/0x130 fs/read_write.c:987 do_readv+0x110/0x330 fs/read_write.c:1020 __do_sys_readv fs/read_write.c:1107 [inline] __se_sys_readv fs/read_write.c:1104 [inline] __x64_sys_readv+0x70/0xb0 fs/read_write.c:1104 do_syscall_64+0xd6/0x4e0 arch/x86/entry/common.c:293 entry_SYSCALL_64_after_hwframe+0x49/0xbe RIP: 0033:0x458c29 Code: 08 48 c7 44 24 10 04 00 00 00 e8 62 d8 fa ff 48 8b 44 24 18 48 8b 4c 24 30 48 83 c1 08 48 89 0c 24 48 89 44 24 08 48 c7 44 24 <10> 10 00 00 00 e8 3d d8 fa ff 48 8b 44 24 18 48 89 44 24 40 48 8b RSP: 002b:00007efca86dcc78 EFLAGS: 00000246 ORIG_RAX: 0000000000000013 RAX: ffffffffffffffda RBX: 0000000000000003 RCX: 0000000000458c29 RDX: 0000000000000001 RSI: 00000000200007c0 RDI: 0000000000000004 RBP: 000000000073bfa0 R08: 0000000000000000 R09: 0000000000000000 R10: 0000000000000000 R11: 0000000000000246 R12: 00007efca86dd6d4 R13: 00000000004c5985 R14: 00000000004d9fe0 R15: 00000000ffffffff INFO: task syz-executor.3:7237 blocked for more than 140 seconds. Not tainted 4.19.114-syzkaller #0 "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. syz-executor.3 D28584 7237 6237 0x00000004 Call Trace: context_switch kernel/sched/core.c:2826 [inline] __schedule+0x792/0x1c20 kernel/sched/core.c:3515 schedule+0x7f/0x1b0 kernel/sched/core.c:3559 schedule_timeout+0x6d7/0xda0 kernel/time/timer.c:1782 do_wait_for_common kernel/sched/completion.c:83 [inline] __wait_for_common kernel/sched/completion.c:104 [inline] wait_for_common kernel/sched/completion.c:115 [inline] wait_for_completion+0x282/0x460 kernel/sched/completion.c:136 crypto_wait_req include/linux/crypto.h:517 [inline] _aead_recvmsg crypto/algif_aead.c:313 [inline] aead_recvmsg+0x1182/0x1fb0 crypto/algif_aead.c:334 sock_recvmsg_nosec net/socket.c:795 [inline] sock_recvmsg+0xb9/0xf0 net/socket.c:802 sock_read_iter+0x252/0x430 net/socket.c:879 call_read_iter include/linux/fs.h:1815 [inline] do_iter_readv_writev+0x3f2/0x960 fs/read_write.c:679 do_iter_read+0x1db/0x580 fs/read_write.c:923 vfs_readv+0xc9/0x130 fs/read_write.c:987 do_readv+0x110/0x330 fs/read_write.c:1020 __do_sys_readv fs/read_write.c:1107 [inline] __se_sys_readv fs/read_write.c:1104 [inline] __x64_sys_readv+0x70/0xb0 fs/read_write.c:1104 do_syscall_64+0xd6/0x4e0 arch/x86/entry/common.c:293 entry_SYSCALL_64_after_hwframe+0x49/0xbe RIP: 0033:0x458c29 Code: 08 48 c7 44 24 10 04 00 00 00 e8 62 d8 fa ff 48 8b 44 24 18 48 8b 4c 24 30 48 83 c1 08 48 89 0c 24 48 89 44 24 08 48 c7 44 24 <10> 10 00 00 00 e8 3d d8 fa ff 48 8b 44 24 18 48 89 44 24 40 48 8b RSP: 002b:00007f84686f0c78 EFLAGS: 00000246 ORIG_RAX: 0000000000000013 RAX: ffffffffffffffda RBX: 0000000000000003 RCX: 0000000000458c29 RDX: 0000000000000001 RSI: 00000000200007c0 RDI: 0000000000000004 RBP: 000000000073bf00 R08: 0000000000000000 R09: 0000000000000000 R10: 0000000000000000 R11: 0000000000000246 R12: 00007f84686f16d4 R13: 00000000004c5985 R14: 00000000004d9fe0 R15: 00000000ffffffff INFO: task syz-executor.3:7250 blocked for more than 140 seconds. Not tainted 4.19.114-syzkaller #0 "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. syz-executor.3 D28344 7250 6237 0x00000004 Call Trace: context_switch kernel/sched/core.c:2826 [inline] __schedule+0x792/0x1c20 kernel/sched/core.c:3515 schedule+0x7f/0x1b0 kernel/sched/core.c:3559 schedule_timeout+0x6d7/0xda0 kernel/time/timer.c:1782 do_wait_for_common kernel/sched/completion.c:83 [inline] __wait_for_common kernel/sched/completion.c:104 [inline] wait_for_common kernel/sched/completion.c:115 [inline] wait_for_completion+0x282/0x460 kernel/sched/completion.c:136 crypto_wait_req include/linux/crypto.h:517 [inline] _aead_recvmsg crypto/algif_aead.c:313 [inline] aead_recvmsg+0x1182/0x1fb0 crypto/algif_aead.c:334 sock_recvmsg_nosec net/socket.c:795 [inline] sock_recvmsg+0xb9/0xf0 net/socket.c:802 sock_read_iter+0x252/0x430 net/socket.c:879 call_read_iter include/linux/fs.h:1815 [inline] do_iter_readv_writev+0x3f2/0x960 fs/read_write.c:679 do_iter_read+0x1db/0x580 fs/read_write.c:923 vfs_readv+0xc9/0x130 fs/read_write.c:987 do_readv+0x110/0x330 fs/read_write.c:1020 __do_sys_readv fs/read_write.c:1107 [inline] __se_sys_readv fs/read_write.c:1104 [inline] __x64_sys_readv+0x70/0xb0 fs/read_write.c:1104 do_syscall_64+0xd6/0x4e0 arch/x86/entry/common.c:293 entry_SYSCALL_64_after_hwframe+0x49/0xbe RIP: 0033:0x458c29 Code: 08 48 c7 44 24 10 04 00 00 00 e8 62 d8 fa ff 48 8b 44 24 18 48 8b 4c 24 30 48 83 c1 08 48 89 0c 24 48 89 44 24 08 48 c7 44 24 <10> 10 00 00 00 e8 3d d8 fa ff 48 8b 44 24 18 48 89 44 24 40 48 8b RSP: 002b:00007f84686cfc78 EFLAGS: 00000246 ORIG_RAX: 0000000000000013 RAX: ffffffffffffffda RBX: 0000000000000003 RCX: 0000000000458c29 RDX: 0000000000000001 RSI: 00000000200007c0 RDI: 0000000000000004 RBP: 000000000073bfa0 R08: 0000000000000000 R09: 0000000000000000 R10: 0000000000000000 R11: 0000000000000246 R12: 00007f84686d06d4 R13: 00000000004c5985 R14: 00000000004d9fe0 R15: 00000000ffffffff INFO: task syz-executor.0:7232 blocked for more than 140 seconds. Not tainted 4.19.114-syzkaller #0 "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. syz-executor.0 D28088 7232 6239 0x00000004 Call Trace: context_switch kernel/sched/core.c:2826 [inline] __schedule+0x792/0x1c20 kernel/sched/core.c:3515 schedule+0x7f/0x1b0 kernel/sched/core.c:3559 schedule_timeout+0x6d7/0xda0 kernel/time/timer.c:1782 do_wait_for_common kernel/sched/completion.c:83 [inline] __wait_for_common kernel/sched/completion.c:104 [inline] wait_for_common kernel/sched/completion.c:115 [inline] wait_for_completion+0x282/0x460 kernel/sched/completion.c:136 crypto_wait_req include/linux/crypto.h:517 [inline] _aead_recvmsg crypto/algif_aead.c:313 [inline] aead_recvmsg+0x1182/0x1fb0 crypto/algif_aead.c:334 sock_recvmsg_nosec net/socket.c:795 [inline] sock_recvmsg+0xb9/0xf0 net/socket.c:802 sock_read_iter+0x252/0x430 net/socket.c:879 call_read_iter include/linux/fs.h:1815 [inline] do_iter_readv_writev+0x3f2/0x960 fs/read_write.c:679 do_iter_read+0x1db/0x580 fs/read_write.c:923 vfs_readv+0xc9/0x130 fs/read_write.c:987 do_readv+0x110/0x330 fs/read_write.c:1020 __do_sys_readv fs/read_write.c:1107 [inline] __se_sys_readv fs/read_write.c:1104 [inline] __x64_sys_readv+0x70/0xb0 fs/read_write.c:1104 do_syscall_64+0xd6/0x4e0 arch/x86/entry/common.c:293 entry_SYSCALL_64_after_hwframe+0x49/0xbe RIP: 0033:0x458c29 Code: 08 48 c7 44 24 10 04 00 00 00 e8 62 d8 fa ff 48 8b 44 24 18 48 8b 4c 24 30 48 83 c1 08 48 89 0c 24 48 89 44 24 08 48 c7 44 24 <10> 10 00 00 00 e8 3d d8 fa ff 48 8b 44 24 18 48 89 44 24 40 48 8b RSP: 002b:00007ff58f659c78 EFLAGS: 00000246 ORIG_RAX: 0000000000000013 RAX: ffffffffffffffda RBX: 0000000000000003 RCX: 0000000000458c29 RDX: 0000000000000001 RSI: 00000000200007c0 RDI: 0000000000000004 RBP: 000000000073bf00 R08: 0000000000000000 R09: 0000000000000000 R10: 0000000000000000 R11: 0000000000000246 R12: 00007ff58f65a6d4 R13: 00000000004c5985 R14: 00000000004d9fe0 R15: 00000000ffffffff INFO: task syz-executor.0:7247 blocked for more than 140 seconds. Not tainted 4.19.114-syzkaller #0 "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. syz-executor.0 D28344 7247 6239 0x00000004 Call Trace: context_switch kernel/sched/core.c:2826 [inline] __schedule+0x792/0x1c20 kernel/sched/core.c:3515 schedule+0x7f/0x1b0 kernel/sched/core.c:3559 schedule_timeout+0x6d7/0xda0 kernel/time/timer.c:1782 do_wait_for_common kernel/sched/completion.c:83 [inline] __wait_for_common kernel/sched/completion.c:104 [inline] wait_for_common kernel/sched/completion.c:115 [inline] wait_for_completion+0x282/0x460 kernel/sched/completion.c:136 crypto_wait_req include/linux/crypto.h:517 [inline] _aead_recvmsg crypto/algif_aead.c:313 [inline] aead_recvmsg+0x1182/0x1fb0 crypto/algif_aead.c:334 sock_recvmsg_nosec net/socket.c:795 [inline] sock_recvmsg+0xb9/0xf0 net/socket.c:802 sock_read_iter+0x252/0x430 net/socket.c:879 call_read_iter include/linux/fs.h:1815 [inline] do_iter_readv_writev+0x3f2/0x960 fs/read_write.c:679 do_iter_read+0x1db/0x580 fs/read_write.c:923 vfs_readv+0xc9/0x130 fs/read_write.c:987 do_readv+0x110/0x330 fs/read_write.c:1020 __do_sys_readv fs/read_write.c:1107 [inline] __se_sys_readv fs/read_write.c:1104 [inline] __x64_sys_readv+0x70/0xb0 fs/read_write.c:1104 do_syscall_64+0xd6/0x4e0 arch/x86/entry/common.c:293 entry_SYSCALL_64_after_hwframe+0x49/0xbe RIP: 0033:0x458c29 Code: 08 48 c7 44 24 10 04 00 00 00 e8 62 d8 fa ff 48 8b 44 24 18 48 8b 4c 24 30 48 83 c1 08 48 89 0c 24 48 89 44 24 08 48 c7 44 24 <10> 10 00 00 00 e8 3d d8 fa ff 48 8b 44 24 18 48 89 44 24 40 48 8b RSP: 002b:00007ff58f638c78 EFLAGS: 00000246 ORIG_RAX: 0000000000000013 RAX: ffffffffffffffda RBX: 0000000000000003 RCX: 0000000000458c29 RDX: 0000000000000001 RSI: 00000000200007c0 RDI: 0000000000000004 RBP: 000000000073bfa0 R08: 0000000000000000 R09: 0000000000000000 R10: 0000000000000000 R11: 0000000000000246 R12: 00007ff58f6396d4 R13: 00000000004c5985 R14: 00000000004d9fe0 R15: 00000000ffffffff INFO: task syz-executor.2:7233 blocked for more than 140 seconds. Not tainted 4.19.114-syzkaller #0 "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. syz-executor.2 D28184 7233 6235 0x00000004 Call Trace: context_switch kernel/sched/core.c:2826 [inline] __schedule+0x792/0x1c20 kernel/sched/core.c:3515 schedule+0x7f/0x1b0 kernel/sched/core.c:3559 schedule_timeout+0x6d7/0xda0 kernel/time/timer.c:1782 do_wait_for_common kernel/sched/completion.c:83 [inline] __wait_for_common kernel/sched/completion.c:104 [inline] wait_for_common kernel/sched/completion.c:115 [inline] wait_for_completion+0x282/0x460 kernel/sched/completion.c:136 crypto_wait_req include/linux/crypto.h:517 [inline] _aead_recvmsg crypto/algif_aead.c:313 [inline] aead_recvmsg+0x1182/0x1fb0 crypto/algif_aead.c:334 sock_recvmsg_nosec net/socket.c:795 [inline] sock_recvmsg+0xb9/0xf0 net/socket.c:802 sock_read_iter+0x252/0x430 net/socket.c:879 call_read_iter include/linux/fs.h:1815 [inline] do_iter_readv_writev+0x3f2/0x960 fs/read_write.c:679 do_iter_read+0x1db/0x580 fs/read_write.c:923 vfs_readv+0xc9/0x130 fs/read_write.c:987 do_readv+0x110/0x330 fs/read_write.c:1020 __do_sys_readv fs/read_write.c:1107 [inline] __se_sys_readv fs/read_write.c:1104 [inline] __x64_sys_readv+0x70/0xb0 fs/read_write.c:1104 do_syscall_64+0xd6/0x4e0 arch/x86/entry/common.c:293 entry_SYSCALL_64_after_hwframe+0x49/0xbe RIP: 0033:0x458c29 Code: 08 48 c7 44 24 10 04 00 00 00 e8 62 d8 fa ff 48 8b 44 24 18 48 8b 4c 24 30 48 83 c1 08 48 89 0c 24 48 89 44 24 08 48 c7 44 24 <10> 10 00 00 00 e8 3d d8 fa ff 48 8b 44 24 18 48 89 44 24 40 48 8b RSP: 002b:00007f7e24c8cc78 EFLAGS: 00000246 ORIG_RAX: 0000000000000013 RAX: ffffffffffffffda RBX: 0000000000000003 RCX: 0000000000458c29 RDX: 0000000000000001 RSI: 00000000200007c0 RDI: 0000000000000004 RBP: 000000000073bf00 R08: 0000000000000000 R09: 0000000000000000 R10: 0000000000000000 R11: 0000000000000246 R12: 00007f7e24c8d6d4 R13: 00000000004c5985 R14: 00000000004d9fe0 R15: 00000000ffffffff INFO: task syz-executor.2:7246 blocked for more than 140 seconds. Not tainted 4.19.114-syzkaller #0 "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. syz-executor.2 D28344 7246 6235 0x00000004 Call Trace: context_switch kernel/sched/core.c:2826 [inline] __schedule+0x792/0x1c20 kernel/sched/core.c:3515 schedule+0x7f/0x1b0 kernel/sched/core.c:3559 schedule_timeout+0x6d7/0xda0 kernel/time/timer.c:1782 do_wait_for_common kernel/sched/completion.c:83 [inline] __wait_for_common kernel/sched/completion.c:104 [inline] wait_for_common kernel/sched/completion.c:115 [inline] wait_for_completion+0x282/0x460 kernel/sched/completion.c:136 crypto_wait_req include/linux/crypto.h:517 [inline] _aead_recvmsg crypto/algif_aead.c:313 [inline] aead_recvmsg+0x1182/0x1fb0 crypto/algif_aead.c:334 sock_recvmsg_nosec net/socket.c:795 [inline] sock_recvmsg+0xb9/0xf0 net/socket.c:802 sock_read_iter+0x252/0x430 net/socket.c:879 call_read_iter include/linux/fs.h:1815 [inline] do_iter_readv_writev+0x3f2/0x960 fs/read_write.c:679 do_iter_read+0x1db/0x580 fs/read_write.c:923 vfs_readv+0xc9/0x130 fs/read_write.c:987 do_readv+0x110/0x330 fs/read_write.c:1020 __do_sys_readv fs/read_write.c:1107 [inline] __se_sys_readv fs/read_write.c:1104 [inline] __x64_sys_readv+0x70/0xb0 fs/read_write.c:1104 do_syscall_64+0xd6/0x4e0 arch/x86/entry/common.c:293 entry_SYSCALL_64_after_hwframe+0x49/0xbe RIP: 0033:0x458c29 Code: 08 48 c7 44 24 10 04 00 00 00 e8 62 d8 fa ff 48 8b 44 24 18 48 8b 4c 24 30 48 83 c1 08 48 89 0c 24 48 89 44 24 08 48 c7 44 24 <10> 10 00 00 00 e8 3d d8 fa ff 48 8b 44 24 18 48 89 44 24 40 48 8b RSP: 002b:00007f7e24c6bc78 EFLAGS: 00000246 ORIG_RAX: 0000000000000013 RAX: ffffffffffffffda RBX: 0000000000000003 RCX: 0000000000458c29 RDX: 0000000000000001 RSI: 00000000200007c0 RDI: 0000000000000004 RBP: 000000000073bfa0 R08: 0000000000000000 R09: 0000000000000000 R10: 0000000000000000 R11: 0000000000000246 R12: 00007f7e24c6c6d4 R13: 00000000004c5985 R14: 00000000004d9fe0 R15: 00000000ffffffff INFO: task syz-executor.5:7235 blocked for more than 140 seconds. Not tainted 4.19.114-syzkaller #0 "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. syz-executor.5 D28584 7235 6243 0x00000004 Call Trace: context_switch kernel/sched/core.c:2826 [inline] __schedule+0x792/0x1c20 kernel/sched/core.c:3515 schedule+0x7f/0x1b0 kernel/sched/core.c:3559 schedule_timeout+0x6d7/0xda0 kernel/time/timer.c:1782 do_wait_for_common kernel/sched/completion.c:83 [inline] __wait_for_common kernel/sched/completion.c:104 [inline] wait_for_common kernel/sched/completion.c:115 [inline] wait_for_completion+0x282/0x460 kernel/sched/completion.c:136 crypto_wait_req include/linux/crypto.h:517 [inline] _aead_recvmsg crypto/algif_aead.c:313 [inline] aead_recvmsg+0x1182/0x1fb0 crypto/algif_aead.c:334 sock_recvmsg_nosec net/socket.c:795 [inline] sock_recvmsg+0xb9/0xf0 net/socket.c:802 sock_read_iter+0x252/0x430 net/socket.c:879 call_read_iter include/linux/fs.h:1815 [inline] do_iter_readv_writev+0x3f2/0x960 fs/read_write.c:679 do_iter_read+0x1db/0x580 fs/read_write.c:923 vfs_readv+0xc9/0x130 fs/read_write.c:987 do_readv+0x110/0x330 fs/read_write.c:1020 __do_sys_readv fs/read_write.c:1107 [inline] __se_sys_readv fs/read_write.c:1104 [inline] __x64_sys_readv+0x70/0xb0 fs/read_write.c:1104 do_syscall_64+0xd6/0x4e0 arch/x86/entry/common.c:293 entry_SYSCALL_64_after_hwframe+0x49/0xbe RIP: 0033:0x458c29 Code: 08 48 c7 44 24 10 04 00 00 00 e8 62 d8 fa ff 48 8b 44 24 18 48 8b 4c 24 30 48 83 c1 08 48 89 0c 24 48 89 44 24 08 48 c7 44 24 <10> 10 00 00 00 e8 3d d8 fa ff 48 8b 44 24 18 48 89 44 24 40 48 8b RSP: 002b:00007f731a522c78 EFLAGS: 00000246 ORIG_RAX: 0000000000000013 RAX: ffffffffffffffda RBX: 0000000000000003 RCX: 0000000000458c29 RDX: 0000000000000001 RSI: 00000000200007c0 RDI: 0000000000000004 RBP: 000000000073bf00 R08: 0000000000000000 R09: 0000000000000000 R10: 0000000000000000 R11: 0000000000000246 R12: 00007f731a5236d4 R13: 00000000004c5985 R14: 00000000004d9fe0 R15: 00000000ffffffff INFO: task syz-executor.5:7249 blocked for more than 140 seconds. Not tainted 4.19.114-syzkaller #0 "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. syz-executor.5 D28344 7249 6243 0x00000004 Call Trace: context_switch kernel/sched/core.c:2826 [inline] __schedule+0x792/0x1c20 kernel/sched/core.c:3515 schedule+0x7f/0x1b0 kernel/sched/core.c:3559 schedule_timeout+0x6d7/0xda0 kernel/time/timer.c:1782 do_wait_for_common kernel/sched/completion.c:83 [inline] __wait_for_common kernel/sched/completion.c:104 [inline] wait_for_common kernel/sched/completion.c:115 [inline] wait_for_completion+0x282/0x460 kernel/sched/completion.c:136 crypto_wait_req include/linux/crypto.h:517 [inline] _aead_recvmsg crypto/algif_aead.c:313 [inline] aead_recvmsg+0x1182/0x1fb0 crypto/algif_aead.c:334 sock_recvmsg_nosec net/socket.c:795 [inline] sock_recvmsg+0xb9/0xf0 net/socket.c:802 sock_read_iter+0x252/0x430 net/socket.c:879 call_read_iter include/linux/fs.h:1815 [inline] do_iter_readv_writev+0x3f2/0x960 fs/read_write.c:679 do_iter_read+0x1db/0x580 fs/read_write.c:923 vfs_readv+0xc9/0x130 fs/read_write.c:987 do_readv+0x110/0x330 fs/read_write.c:1020 __do_sys_readv fs/read_write.c:1107 [inline] __se_sys_readv fs/read_write.c:1104 [inline] __x64_sys_readv+0x70/0xb0 fs/read_write.c:1104 do_syscall_64+0xd6/0x4e0 arch/x86/entry/common.c:293 entry_SYSCALL_64_after_hwframe+0x49/0xbe RIP: 0033:0x458c29 Code: 08 48 c7 44 24 10 04 00 00 00 e8 62 d8 fa ff 48 8b 44 24 18 48 8b 4c 24 30 48 83 c1 08 48 89 0c 24 48 89 44 24 08 48 c7 44 24 <10> 10 00 00 00 e8 3d d8 fa ff 48 8b 44 24 18 48 89 44 24 40 48 8b RSP: 002b:00007f731a501c78 EFLAGS: 00000246 ORIG_RAX: 0000000000000013 RAX: ffffffffffffffda RBX: 0000000000000003 RCX: 0000000000458c29 RDX: 0000000000000001 RSI: 00000000200007c0 RDI: 0000000000000004 RBP: 000000000073bfa0 R08: 0000000000000000 R09: 0000000000000000 R10: 0000000000000000 R11: 0000000000000246 R12: 00007f731a5026d4 R13: 00000000004c5985 R14: 00000000004d9fe0 R15: 00000000ffffffff Showing all locks held in the system: 1 lock held by khungtaskd/1028: #0: 000000005db89754 (rcu_read_lock){....}, at: debug_show_all_locks+0x5b/0x27a kernel/locking/lockdep.c:4438 1 lock held by in:imklog/5740: #0: 00000000dce9c750 (&f->f_pos_lock){+.+.}, at: __fdget_pos+0xa7/0xd0 fs/file.c:767 1 lock held by syz-executor.1/7219: #0: 00000000cf85b987 (sk_lock-AF_ALG){+.+.}, at: lock_sock include/net/sock.h:1506 [inline] #0: 00000000cf85b987 (sk_lock-AF_ALG){+.+.}, at: af_alg_wait_for_data+0x1b3/0x440 crypto/af_alg.c:774 1 lock held by syz-executor.1/7239: #0: 000000004f198d88 (sk_lock-AF_ALG){+.+.}, at: lock_sock include/net/sock.h:1506 [inline] #0: 000000004f198d88 (sk_lock-AF_ALG){+.+.}, at: af_alg_wait_for_data+0x1b3/0x440 crypto/af_alg.c:774 1 lock held by syz-executor.3/7237: #0: 00000000953b727c (sk_lock-AF_ALG){+.+.}, at: lock_sock include/net/sock.h:1506 [inline] #0: 00000000953b727c (sk_lock-AF_ALG){+.+.}, at: af_alg_wait_for_data+0x1b3/0x440 crypto/af_alg.c:774 1 lock held by syz-executor.3/7250: #0: 000000007dc7604a (sk_lock-AF_ALG){+.+.}, at: lock_sock include/net/sock.h:1506 [inline] #0: 000000007dc7604a (sk_lock-AF_ALG){+.+.}, at: af_alg_wait_for_data+0x1b3/0x440 crypto/af_alg.c:774 1 lock held by syz-executor.0/7232: #0: 000000002ecbd4ba (sk_lock-AF_ALG){+.+.}, at: lock_sock include/net/sock.h:1506 [inline] #0: 000000002ecbd4ba (sk_lock-AF_ALG){+.+.}, at: af_alg_wait_for_data+0x1b3/0x440 crypto/af_alg.c:774 1 lock held by syz-executor.0/7247: #0: 00000000ed3faecc (sk_lock-AF_ALG){+.+.}, at: lock_sock include/net/sock.h:1506 [inline] #0: 00000000ed3faecc (sk_lock-AF_ALG){+.+.}, at: af_alg_wait_for_data+0x1b3/0x440 crypto/af_alg.c:774 1 lock held by syz-executor.2/7233: #0: 00000000d760df97 (sk_lock-AF_ALG){+.+.}, at: lock_sock include/net/sock.h:1506 [inline] #0: 00000000d760df97 (sk_lock-AF_ALG){+.+.}, at: af_alg_wait_for_data+0x1b3/0x440 crypto/af_alg.c:774 1 lock held by syz-executor.2/7246: #0: 00000000bed209e8 (sk_lock-AF_ALG){+.+.}, at: lock_sock include/net/sock.h:1506 [inline] #0: 00000000bed209e8 (sk_lock-AF_ALG){+.+.}, at: af_alg_wait_for_data+0x1b3/0x440 crypto/af_alg.c:774 1 lock held by syz-executor.5/7235: #0: 00000000bc467cc5 (sk_lock-AF_ALG){+.+.}, at: lock_sock include/net/sock.h:1506 [inline] #0: 00000000bc467cc5 (sk_lock-AF_ALG){+.+.}, at: af_alg_wait_for_data+0x1b3/0x440 crypto/af_alg.c:774 1 lock held by syz-executor.5/7249: #0: 000000009503a268 (sk_lock-AF_ALG){+.+.}, at: lock_sock include/net/sock.h:1506 [inline] #0: 000000009503a268 (sk_lock-AF_ALG){+.+.}, at: af_alg_wait_for_data+0x1b3/0x440 crypto/af_alg.c:774 1 lock held by syz-executor.4/7236: #0: 000000001cc51ec7 (sk_lock-AF_ALG){+.+.}, at: lock_sock include/net/sock.h:1506 [inline] #0: 000000001cc51ec7 (sk_lock-AF_ALG){+.+.}, at: af_alg_wait_for_data+0x1b3/0x440 crypto/af_alg.c:774 1 lock held by syz-executor.4/7251: #0: 00000000b667ae59 (sk_lock-AF_ALG){+.+.}, at: lock_sock include/net/sock.h:1506 [inline] #0: 00000000b667ae59 (sk_lock-AF_ALG){+.+.}, at: af_alg_wait_for_data+0x1b3/0x440 crypto/af_alg.c:774 ============================================= NMI backtrace for cpu 1 CPU: 1 PID: 1028 Comm: khungtaskd Not tainted 4.19.114-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+0x123/0x177 lib/dump_stack.c:118 nmi_cpu_backtrace.cold.4+0x3e/0x76 lib/nmi_backtrace.c:101 nmi_trigger_cpumask_backtrace+0xe6/0x11a lib/nmi_backtrace.c:62 arch_trigger_cpumask_backtrace+0x14/0x20 arch/x86/kernel/apic/hw_nmi.c:38 trigger_all_cpu_backtrace include/linux/nmi.h:146 [inline] check_hung_uninterruptible_tasks kernel/hung_task.c:203 [inline] watchdog+0x5c3/0xb40 kernel/hung_task.c:287 kthread+0x327/0x3f0 kernel/kthread.c:246 ret_from_fork+0x3a/0x50 arch/x86/entry/entry_64.S:415 Sending NMI from CPU 1 to CPUs 0: NMI backtrace for cpu 0 CPU: 0 PID: 5743 Comm: rs:main Q:Reg Not tainted 4.19.114-syzkaller #0 Hardware name: Google Google Compute Engine/Google Compute Engine, BIOS Google 01/01/2011 RIP: 0010:__lock_is_held+0x84/0x140 kernel/locking/lockdep.c:3720 Code: 00 00 fc ff df 4d 8d b4 24 80 08 00 00 49 c1 ed 03 49 01 c5 41 8b 84 24 78 08 00 00 85 c0 7f 24 e9 85 00 00 00 41 0f b6 45 00 <41> 83 c7 01 84 c0 74 08 3c 03 0f 8e 8f 00 00 00 45 39 bc 24 78 08 RSP: 0018:ffff88808bb877b8 EFLAGS: 00000046 RAX: 0000000000000000 RBX: ffff8880944a0990 RCX: 0000000000000000 RDX: 0000000000000000 RSI: ffffffff8819a220 RDI: ffff8880944a09b2 RBP: ffff88808bb877f8 R08: ffffed1015d44733 R09: ffffed1015d44732 R10: ffffed1015d44732 R11: ffff8880aea23993 R12: ffff8880944a00c0 R13: ffffed1012894127 R14: ffff8880944a0940 R15: 0000000000000002 FS: 00007fafe56bd700(0000) GS:ffff8880aea00000(0000) knlGS:0000000000000000 CS: 0010 DS: 0000 ES: 0000 CR0: 0000000080050033 CR2: 00007f836434f008 CR3: 0000000092af4000 CR4: 00000000001406f0 DR0: 0000000000000000 DR1: 0000000000000000 DR2: 0000000000000000 DR3: 0000000000000000 DR6: 00000000fffe0ff0 DR7: 0000000000000400 Call Trace: lock_is_held_type+0x118/0x210 kernel/locking/lockdep.c:3941 lock_is_held include/linux/lockdep.h:344 [inline] rcu_read_lock_sched_held+0x108/0x120 kernel/rcu/update.c:118 trace_block_dirty_buffer include/trace/events/block.h:58 [inline] mark_buffer_dirty+0x31f/0x430 fs/buffer.c:1089 __block_commit_write.isra.38+0xdf/0x200 fs/buffer.c:2040 block_write_end+0x2e/0xf0 fs/buffer.c:2152 generic_write_end+0x1e/0x70 fs/buffer.c:2162 ext4_da_write_end+0x2ba/0xa10 fs/ext4/inode.c:3193 generic_perform_write+0x349/0x490 mm/filemap.c:3173 __generic_file_write_iter+0x201/0x580 mm/filemap.c:3287 ext4_file_write_iter+0x282/0xe60 fs/ext4/file.c:272 call_write_iter include/linux/fs.h:1821 [inline] new_sync_write fs/read_write.c:474 [inline] __vfs_write+0x44b/0x890 fs/read_write.c:487 vfs_write+0x150/0x4d0 fs/read_write.c:549 ksys_write+0x103/0x260 fs/read_write.c:599 __do_sys_write fs/read_write.c:611 [inline] __se_sys_write fs/read_write.c:608 [inline] __x64_sys_write+0x6e/0xb0 fs/read_write.c:608 do_syscall_64+0xd6/0x4e0 arch/x86/entry/common.c:293 entry_SYSCALL_64_after_hwframe+0x49/0xbe RIP: 0033:0x7fafe81011cd Code: c2 20 00 00 75 10 b8 01 00 00 00 0f 05 48 3d 01 f0 ff ff 73 31 c3 48 83 ec 08 e8 ae fc ff ff 48 89 04 24 b8 01 00 00 00 0f 05 <48> 8b 3c 24 48 89 c2 e8 f7 fc ff ff 48 89 d0 48 83 c4 08 48 3d 01 RSP: 002b:00007fafe56bc590 EFLAGS: 00000293 ORIG_RAX: 0000000000000001 RAX: ffffffffffffffda RBX: 00007fafdc021f80 RCX: 00007fafe81011cd RDX: 00000000000004c6 RSI: 00007fafdc021f80 RDI: 0000000000000006 RBP: 0000000000000000 R08: 0000000000000000 R09: 0000000000000000 R10: 0000000000000000 R11: 0000000000000293 R12: 00007fafdc021d00 R13: 00007fafe56bc5b0 R14: 000055a81cbbb360 R15: 00000000000004c6