syzbot


INFO: task can't die in tls_sw_sendpage

Status: auto-closed as invalid on 2021/11/20 04:49
Subsystems: net
[Documentation on labels]
Reported-by: syzbot+a0d9194812a32ec7d41f@syzkaller.appspotmail.com
First crash: 994d, last: 949d
Similar bugs (3)
Kernel Title Repro Cause bisect Fix bisect Count Last Reported Patched Status
upstream INFO: task hung in tls_sw_sendpage net 1 1100d 1100d 0/26 auto-closed as invalid on 2021/06/21 18:51
upstream INFO: task hung in tls_sw_sendpage (2) net 10 746d 847d 0/26 auto-closed as invalid on 2022/06/11 00:00
upstream INFO: task hung in tls_sw_sendpage (3) net 30 398d 394d 22/26 fixed on 2023/06/08 14:41

Sample crash report:
INFO: task syz-executor.1:26804 can't die for more than 143 seconds.
task:syz-executor.1  state:D stack:22720 pid:26804 ppid:  6555 flags:0x00004004
Call Trace:
 context_switch kernel/sched/core.c:4756 [inline]
 __schedule+0x943/0x2700 kernel/sched/core.c:6029
 schedule+0xd7/0x280 kernel/sched/core.c:6108
 schedule_preempt_disabled+0x13/0x30 kernel/sched/core.c:6167
 __mutex_lock_common kernel/locking/mutex.c:669 [inline]
 __mutex_lock+0xa39/0x12f0 kernel/locking/mutex.c:729
 tls_sw_sendpage+0x81/0xe0 net/tls/tls_sw.c:1276
 inet_sendpage+0xd4/0x140 net/ipv4/af_inet.c:835
 kernel_sendpage.part.0+0x1a0/0x340 net/socket.c:3496
 kernel_sendpage net/socket.c:3493 [inline]
 sock_sendpage+0xe9/0x150 net/socket.c:1003
 pipe_to_sendpage+0x2b4/0x390 fs/splice.c:364
 splice_from_pipe_feed fs/splice.c:418 [inline]
 __splice_from_pipe+0x444/0x8a0 fs/splice.c:562
 splice_from_pipe fs/splice.c:597 [inline]
 generic_splice_sendpage+0xd6/0x140 fs/splice.c:746
 do_splice_from fs/splice.c:767 [inline]
 direct_splice_actor+0x114/0x190 fs/splice.c:936
 splice_direct_to_actor+0x34b/0x8c0 fs/splice.c:891
 do_splice_direct+0x1b3/0x280 fs/splice.c:979
 do_sendfile+0xae9/0x1250 fs/read_write.c:1260
 __do_sys_sendfile64 fs/read_write.c:1325 [inline]
 __se_sys_sendfile64 fs/read_write.c:1311 [inline]
 __x64_sys_sendfile64+0x1ce/0x210 fs/read_write.c:1311
 do_syscall_x64 arch/x86/entry/common.c:50 [inline]
 do_syscall_64+0x39/0xb0 arch/x86/entry/common.c:80
 entry_SYSCALL_64_after_hwframe+0x44/0xae
RIP: 0033:0x4665e9
RSP: 002b:00007f2f1ba80188 EFLAGS: 00000246 ORIG_RAX: 0000000000000028
RAX: ffffffffffffffda RBX: 000000000056c038 RCX: 00000000004665e9
RDX: 0000000000000000 RSI: 0000000000000007 RDI: 0000000000000009
RBP: 00000000004bfcc4 R08: 0000000000000000 R09: 0000000000000000
R10: 000080010002000e R11: 0000000000000246 R12: 000000000056c038
R13: 00007ffd606fd4ff R14: 00007f2f1ba80300 R15: 0000000000022000
INFO: task syz-executor.1:26804 blocked for more than 143 seconds.
      Not tainted 5.14.0-rc6-next-20210820-syzkaller #0
"echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message.
task:syz-executor.1  state:D stack:22720 pid:26804 ppid:  6555 flags:0x00004004
Call Trace:
 context_switch kernel/sched/core.c:4756 [inline]
 __schedule+0x943/0x2700 kernel/sched/core.c:6029
 schedule+0xd7/0x280 kernel/sched/core.c:6108
 schedule_preempt_disabled+0x13/0x30 kernel/sched/core.c:6167
 __mutex_lock_common kernel/locking/mutex.c:669 [inline]
 __mutex_lock+0xa39/0x12f0 kernel/locking/mutex.c:729
 tls_sw_sendpage+0x81/0xe0 net/tls/tls_sw.c:1276
 inet_sendpage+0xd4/0x140 net/ipv4/af_inet.c:835
 kernel_sendpage.part.0+0x1a0/0x340 net/socket.c:3496
 kernel_sendpage net/socket.c:3493 [inline]
 sock_sendpage+0xe9/0x150 net/socket.c:1003
 pipe_to_sendpage+0x2b4/0x390 fs/splice.c:364
 splice_from_pipe_feed fs/splice.c:418 [inline]
 __splice_from_pipe+0x444/0x8a0 fs/splice.c:562
 splice_from_pipe fs/splice.c:597 [inline]
 generic_splice_sendpage+0xd6/0x140 fs/splice.c:746
 do_splice_from fs/splice.c:767 [inline]
 direct_splice_actor+0x114/0x190 fs/splice.c:936
 splice_direct_to_actor+0x34b/0x8c0 fs/splice.c:891
 do_splice_direct+0x1b3/0x280 fs/splice.c:979
 do_sendfile+0xae9/0x1250 fs/read_write.c:1260
 __do_sys_sendfile64 fs/read_write.c:1325 [inline]
 __se_sys_sendfile64 fs/read_write.c:1311 [inline]
 __x64_sys_sendfile64+0x1ce/0x210 fs/read_write.c:1311
 do_syscall_x64 arch/x86/entry/common.c:50 [inline]
 do_syscall_64+0x39/0xb0 arch/x86/entry/common.c:80
 entry_SYSCALL_64_after_hwframe+0x44/0xae
RIP: 0033:0x4665e9
RSP: 002b:00007f2f1ba80188 EFLAGS: 00000246 ORIG_RAX: 0000000000000028
RAX: ffffffffffffffda RBX: 000000000056c038 RCX: 00000000004665e9
RDX: 0000000000000000 RSI: 0000000000000007 RDI: 0000000000000009
RBP: 00000000004bfcc4 R08: 0000000000000000 R09: 0000000000000000
R10: 000080010002000e R11: 0000000000000246 R12: 000000000056c038
R13: 00007ffd606fd4ff R14: 00007f2f1ba80300 R15: 0000000000022000
INFO: task syz-executor.3:26803 can't die for more than 144 seconds.
task:syz-executor.3  state:D stack:24632 pid:26803 ppid:  6559 flags:0x00004004
Call Trace:
 context_switch kernel/sched/core.c:4756 [inline]
 __schedule+0x943/0x2700 kernel/sched/core.c:6029
 schedule+0xd7/0x280 kernel/sched/core.c:6108
 schedule_preempt_disabled+0x13/0x30 kernel/sched/core.c:6167
 __mutex_lock_common kernel/locking/mutex.c:669 [inline]
 __mutex_lock+0xa39/0x12f0 kernel/locking/mutex.c:729
 tls_sw_sendpage+0x81/0xe0 net/tls/tls_sw.c:1276
 inet_sendpage+0xd4/0x140 net/ipv4/af_inet.c:835
 kernel_sendpage.part.0+0x1a0/0x340 net/socket.c:3496
 kernel_sendpage net/socket.c:3493 [inline]
 sock_sendpage+0xe9/0x150 net/socket.c:1003
 pipe_to_sendpage+0x2b4/0x390 fs/splice.c:364
 splice_from_pipe_feed fs/splice.c:418 [inline]
 __splice_from_pipe+0x444/0x8a0 fs/splice.c:562
 splice_from_pipe fs/splice.c:597 [inline]
 generic_splice_sendpage+0xd6/0x140 fs/splice.c:746
 do_splice_from fs/splice.c:767 [inline]
 direct_splice_actor+0x114/0x190 fs/splice.c:936
 splice_direct_to_actor+0x34b/0x8c0 fs/splice.c:891
 do_splice_direct+0x1b3/0x280 fs/splice.c:979
 do_sendfile+0xae9/0x1250 fs/read_write.c:1260
 __do_sys_sendfile64 fs/read_write.c:1325 [inline]
 __se_sys_sendfile64 fs/read_write.c:1311 [inline]
 __x64_sys_sendfile64+0x1ce/0x210 fs/read_write.c:1311
 do_syscall_x64 arch/x86/entry/common.c:50 [inline]
 do_syscall_64+0x39/0xb0 arch/x86/entry/common.c:80
 entry_SYSCALL_64_after_hwframe+0x44/0xae
RIP: 0033:0x4665e9
RSP: 002b:00007fac988ea188 EFLAGS: 00000246 ORIG_RAX: 0000000000000028
RAX: ffffffffffffffda RBX: 000000000056c038 RCX: 00000000004665e9
RDX: 0000000000000000 RSI: 0000000000000007 RDI: 0000000000000009
RBP: 00000000004bfcc4 R08: 0000000000000000 R09: 0000000000000000
R10: 000080010002000e R11: 0000000000000246 R12: 000000000056c038
R13: 00007fffc03d319f R14: 00007fac988ea300 R15: 0000000000022000
INFO: task syz-executor.3:26803 blocked for more than 144 seconds.
      Not tainted 5.14.0-rc6-next-20210820-syzkaller #0
"echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message.
task:syz-executor.3  state:D stack:24632 pid:26803 ppid:  6559 flags:0x00004004
Call Trace:
 context_switch kernel/sched/core.c:4756 [inline]
 __schedule+0x943/0x2700 kernel/sched/core.c:6029
 schedule+0xd7/0x280 kernel/sched/core.c:6108
 schedule_preempt_disabled+0x13/0x30 kernel/sched/core.c:6167
 __mutex_lock_common kernel/locking/mutex.c:669 [inline]
 __mutex_lock+0xa39/0x12f0 kernel/locking/mutex.c:729
 tls_sw_sendpage+0x81/0xe0 net/tls/tls_sw.c:1276
 inet_sendpage+0xd4/0x140 net/ipv4/af_inet.c:835
 kernel_sendpage.part.0+0x1a0/0x340 net/socket.c:3496
 kernel_sendpage net/socket.c:3493 [inline]
 sock_sendpage+0xe9/0x150 net/socket.c:1003
 pipe_to_sendpage+0x2b4/0x390 fs/splice.c:364
 splice_from_pipe_feed fs/splice.c:418 [inline]
 __splice_from_pipe+0x444/0x8a0 fs/splice.c:562
 splice_from_pipe fs/splice.c:597 [inline]
 generic_splice_sendpage+0xd6/0x140 fs/splice.c:746
 do_splice_from fs/splice.c:767 [inline]
 direct_splice_actor+0x114/0x190 fs/splice.c:936
 splice_direct_to_actor+0x34b/0x8c0 fs/splice.c:891
 do_splice_direct+0x1b3/0x280 fs/splice.c:979
 do_sendfile+0xae9/0x1250 fs/read_write.c:1260
 __do_sys_sendfile64 fs/read_write.c:1325 [inline]
 __se_sys_sendfile64 fs/read_write.c:1311 [inline]
 __x64_sys_sendfile64+0x1ce/0x210 fs/read_write.c:1311
 do_syscall_x64 arch/x86/entry/common.c:50 [inline]
 do_syscall_64+0x39/0xb0 arch/x86/entry/common.c:80
 entry_SYSCALL_64_after_hwframe+0x44/0xae
RIP: 0033:0x4665e9
RSP: 002b:00007fac988ea188 EFLAGS: 00000246 ORIG_RAX: 0000000000000028
RAX: ffffffffffffffda RBX: 000000000056c038 RCX: 00000000004665e9
RDX: 0000000000000000 RSI: 0000000000000007 RDI: 0000000000000009
RBP: 00000000004bfcc4 R08: 0000000000000000 R09: 0000000000000000
R10: 000080010002000e R11: 0000000000000246 R12: 000000000056c038
R13: 00007fffc03d319f R14: 00007fac988ea300 R15: 0000000000022000
INFO: lockdep is turned off.
NMI backtrace for cpu 1
CPU: 1 PID: 27 Comm: khungtaskd Not tainted 5.14.0-rc6-next-20210820-syzkaller #0
Hardware name: Google Google Compute Engine/Google Compute Engine, BIOS Google 01/01/2011
Call Trace:
 __dump_stack lib/dump_stack.c:88 [inline]
 dump_stack_lvl+0xcd/0x134 lib/dump_stack.c:106
 nmi_cpu_backtrace.cold+0x47/0x144 lib/nmi_backtrace.c:105
 nmi_trigger_cpumask_backtrace+0x1ae/0x220 lib/nmi_backtrace.c:62
 trigger_all_cpu_backtrace include/linux/nmi.h:146 [inline]
 check_hung_uninterruptible_tasks kernel/hung_task.c:254 [inline]
 watchdog+0xccb/0xef0 kernel/hung_task.c:339
 kthread+0x3e5/0x4d0 kernel/kthread.c:319
 ret_from_fork+0x1f/0x30 arch/x86/entry/entry_64.S:295
Sending NMI from CPU 1 to CPUs 0:
NMI backtrace for cpu 0
CPU: 0 PID: 2966 Comm: systemd-journal Not tainted 5.14.0-rc6-next-20210820-syzkaller #0
Hardware name: Google Google Compute Engine/Google Compute Engine, BIOS Google 01/01/2011
RIP: 0010:kmem_cache_free+0x2a0/0x5b0 mm/slub.c:3476
Code: 8b 74 24 08 48 89 04 0e 48 8b 7d 00 40 f6 c7 0f 0f 85 2f 02 00 00 48 8d 4a 08 65 48 0f c7 0f 0f 94 c0 84 c0 74 b9 48 8b 4d 60 <48> 8b b4 24 88 00 00 00 0f 1f 44 00 00 65 8b 05 54 93 45 7e 83 f8
RSP: 0018:ffffc900022cfce8 EFLAGS: 00000246
RAX: 00000000360b5500 RBX: ffff8880360b5520 RCX: ffffffff89999400
RDX: 0000000000000000 RSI: ffffffff817cac31 RDI: ffffffff81bc5145
RBP: ffff8881400073c0 R08: 0000000000000000 R09: 0000000000000000
R10: ffffffff817cac18 R11: 0000000000000000 R12: ffffea0000d82c00
R13: ffff8880360b5500 R14: 00000000ffffff9c R15: dffffc0000000000
FS:  00007f21dbcb78c0(0000) GS:ffff8880b9c00000(0000) knlGS:0000000000000000
CS:  0010 DS: 0000 ES: 0000 CR0: 0000000080050033
CR2: 00007f21d93cc000 CR3: 0000000025ee7000 CR4: 00000000001506f0
DR0: 0000000000000000 DR1: 0000000000000000 DR2: 0000000000000000
DR3: 0000000000000000 DR6: 00000000fffe0ff0 DR7: 0000000000000400
Call Trace:
 putname fs/namei.c:270 [inline]
 putname+0x118/0x160 fs/namei.c:256
 do_sys_openat2+0x153/0x4e0 fs/open.c:1213
 do_sys_open fs/open.c:1220 [inline]
 __do_sys_open fs/open.c:1228 [inline]
 __se_sys_open fs/open.c:1224 [inline]
 __x64_sys_open+0x119/0x1c0 fs/open.c:1224
 do_syscall_x64 arch/x86/entry/common.c:50 [inline]
 do_syscall_64+0x39/0xb0 arch/x86/entry/common.c:80
 entry_SYSCALL_64_after_hwframe+0x44/0xae
RIP: 0033:0x7f21db246840
Code: 73 01 c3 48 8b 0d 68 77 20 00 f7 d8 64 89 01 48 83 c8 ff c3 66 0f 1f 44 00 00 83 3d 89 bb 20 00 00 75 10 b8 02 00 00 00 0f 05 <48> 3d 01 f0 ff ff 73 31 c3 48 83 ec 08 e8 1e f6 ff ff 48 89 04 24
RSP: 002b:00007ffd6e32e148 EFLAGS: 00000246 ORIG_RAX: 0000000000000002
RAX: ffffffffffffffda RBX: 00007ffd6e32e450 RCX: 00007f21db246840
RDX: 00000000000001a0 RSI: 0000000000080042 RDI: 000056043bd9dfd0
RBP: 000000000000000d R08: 00000000000001e0 R09: 00000000ffffffff
R10: 0000000000000069 R11: 0000000000000246 R12: 00000000ffffffff
R13: 000056043bd91040 R14: 00007ffd6e32e410 R15: 000056043bd9ddf0
----------------
Code disassembly (best guess):
   0:	8b 74 24 08          	mov    0x8(%rsp),%esi
   4:	48 89 04 0e          	mov    %rax,(%rsi,%rcx,1)
   8:	48 8b 7d 00          	mov    0x0(%rbp),%rdi
   c:	40 f6 c7 0f          	test   $0xf,%dil
  10:	0f 85 2f 02 00 00    	jne    0x245
  16:	48 8d 4a 08          	lea    0x8(%rdx),%rcx
  1a:	65 48 0f c7 0f       	cmpxchg16b %gs:(%rdi)
  1f:	0f 94 c0             	sete   %al
  22:	84 c0                	test   %al,%al
  24:	74 b9                	je     0xffffffdf
  26:	48 8b 4d 60          	mov    0x60(%rbp),%rcx
* 2a:	48 8b b4 24 88 00 00 	mov    0x88(%rsp),%rsi <-- trapping instruction
  31:	00
  32:	0f 1f 44 00 00       	nopl   0x0(%rax,%rax,1)
  37:	65 8b 05 54 93 45 7e 	mov    %gs:0x7e459354(%rip),%eax        # 0x7e459392
  3e:	83                   	.byte 0x83
  3f:	f8                   	clc

Crashes (3):
Time Kernel Commit Syzkaller Config Log Report Syz repro C repro VM info Assets (help?) Manager Title
2021/08/22 04:48 linux-next 86ed57fd8c93 b599f2fc .config console log report info ci-upstream-linux-next-kasan-gce-root INFO: task can't die in tls_sw_sendpage
2021/07/08 10:00 linux-next e2f74b13dbe6 95793bce .config console log report info ci-upstream-linux-next-kasan-gce-root INFO: task can't die in tls_sw_sendpage
2021/07/09 10:06 upstream 3dbdb38e2869 281e815f .config console log report info ci-upstream-kasan-gce-selinux-root INFO: task hung in tls_sw_sendpage
* Struck through repros no longer work on HEAD.