syzbot


INFO: task hung in smc_pnet_net_init

Status: closed as invalid on 2022/02/07 19:09
Reported-by: syzbot+@syzkaller.appspotmail.com
First crash: 447d, last: 301d
similar bugs (1):
Kernel Title Repro Cause bisect Fix bisect Count Last Reported Patched Status
upstream INFO: task hung in smc_pnet_net_init (2) 2 157d 199d 0/24 auto-closed as invalid on 2022/09/26 13:30

Sample crash report:
INFO: task syz-executor.3:18515 blocked for more than 143 seconds.
      Not tainted 5.17.0-rc2-syzkaller-00167-gdcb85f85fa6f #0
"echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message.
task:syz-executor.3  state:D stack:27088 pid:18515 ppid: 16182 flags:0x00004004
Call Trace:
 <TASK>
 context_switch kernel/sched/core.c:4986 [inline]
 __schedule+0x926/0x1080 kernel/sched/core.c:6295
 schedule+0x12b/0x1f0 kernel/sched/core.c:6368
 schedule_preempt_disabled+0xf/0x20 kernel/sched/core.c:6427
 __mutex_lock_common+0xe9f/0x2490 kernel/locking/mutex.c:673
 __mutex_lock kernel/locking/mutex.c:733 [inline]
 mutex_lock_nested+0x1a/0x20 kernel/locking/mutex.c:785
 smc_pnet_create_pnetids_list net/smc/smc_pnet.c:800 [inline]
 smc_pnet_net_init+0x14f/0x420 net/smc/smc_pnet.c:869
 ops_init+0x313/0x430 net/core/net_namespace.c:140
 setup_net+0x45b/0xb70 net/core/net_namespace.c:330
 copy_net_ns+0x359/0x5c0 net/core/net_namespace.c:474
 create_new_namespaces+0x4ce/0xa00 kernel/nsproxy.c:110
 unshare_nsproxy_namespaces+0x11e/0x180 kernel/nsproxy.c:226
 ksys_unshare+0x57d/0xb50 kernel/fork.c:3048
 __do_sys_unshare kernel/fork.c:3119 [inline]
 __se_sys_unshare kernel/fork.c:3117 [inline]
 __x64_sys_unshare+0x34/0x40 kernel/fork.c:3117
 do_syscall_x64 arch/x86/entry/common.c:50 [inline]
 do_syscall_64+0x44/0xd0 arch/x86/entry/common.c:80
 entry_SYSCALL_64_after_hwframe+0x44/0xae
RIP: 0033:0x7f2091ad3059
RSP: 002b:00007f20903e5168 EFLAGS: 00000246 ORIG_RAX: 0000000000000110
RAX: ffffffffffffffda RBX: 00007f2091be61d0 RCX: 00007f2091ad3059
RDX: 0000000000000000 RSI: 0000000000000000 RDI: 0000000048020200
RBP: 00007f2091b2d08d R08: 0000000000000000 R09: 0000000000000000
R10: 0000000000000000 R11: 0000000000000246 R12: 0000000000000000
R13: 00007ffef491b10f R14: 00007f20903e5300 R15: 0000000000022000
 </TASK>
INFO: task syz-executor.5:18526 blocked for more than 143 seconds.
      Not tainted 5.17.0-rc2-syzkaller-00167-gdcb85f85fa6f #0
"echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message.
task:syz-executor.5  state:D stack:26864 pid:18526 ppid:  3625 flags:0x00004004
Call Trace:
 <TASK>
 context_switch kernel/sched/core.c:4986 [inline]
 __schedule+0x926/0x1080 kernel/sched/core.c:6295
 schedule+0x12b/0x1f0 kernel/sched/core.c:6368
 schedule_preempt_disabled+0xf/0x20 kernel/sched/core.c:6427
 __mutex_lock_common+0xe9f/0x2490 kernel/locking/mutex.c:673
 __mutex_lock kernel/locking/mutex.c:733 [inline]
 mutex_lock_nested+0x1a/0x20 kernel/locking/mutex.c:785
 rtnl_lock net/core/rtnetlink.c:72 [inline]
 rtnetlink_rcv_msg+0x92d/0xec0 net/core/rtnetlink.c:5591
 netlink_rcv_skb+0x200/0x470 net/netlink/af_netlink.c:2494
 netlink_unicast_kernel net/netlink/af_netlink.c:1317 [inline]
 netlink_unicast+0x81a/0x9f0 net/netlink/af_netlink.c:1343
 netlink_sendmsg+0xaec/0xe60 net/netlink/af_netlink.c:1919
 sock_sendmsg_nosec net/socket.c:705 [inline]
 sock_sendmsg net/socket.c:725 [inline]
 ____sys_sendmsg+0x5b9/0x910 net/socket.c:2413
 ___sys_sendmsg net/socket.c:2467 [inline]
 __sys_sendmsg+0x280/0x370 net/socket.c:2496
 do_syscall_x64 arch/x86/entry/common.c:50 [inline]
 do_syscall_64+0x44/0xd0 arch/x86/entry/common.c:80
 entry_SYSCALL_64_after_hwframe+0x44/0xae
RIP: 0033:0x7f7a51f1a059
RSP: 002b:00007f7a5088f168 EFLAGS: 00000246 ORIG_RAX: 000000000000002e
RAX: ffffffffffffffda RBX: 00007f7a5202cf60 RCX: 00007f7a51f1a059
RDX: 0000000000000000 RSI: 0000000020000280 RDI: 0000000000000003
RBP: 00007f7a51f7408d R08: 0000000000000000 R09: 0000000000000000
R10: 0000000000000000 R11: 0000000000000246 R12: 0000000000000000
R13: 00007ffc0f2d1c9f R14: 00007f7a5088f300 R15: 0000000000022000
 </TASK>

Showing all locks held in the system:
1 lock held by khungtaskd/26:
 #0: ffffffff8cb1db60 (rcu_read_lock){....}-{1:2}, at: rcu_lock_acquire+0x0/0x30
2 locks held by getty/3275:
 #0: ffff8880249a4098 (&tty->ldisc_sem){++++}-{0:0}, at: tty_ldisc_ref_wait+0x21/0x70 drivers/tty/tty_ldisc.c:244
 #1: ffffc90002b662e8 (&ldata->atomic_read_lock){+.+.}-{3:3}, at: n_tty_read+0x6c5/0x1c60 drivers/tty/n_tty.c:2077
3 locks held by kworker/0:9/7591:
 #0: ffff88802441b538 ((wq_completion)ipv6_addrconf){+.+.}-{0:0}, at: process_one_work+0x7c7/0x1130
 #1: ffffc90005627d20 ((addr_chk_work).work){+.+.}-{0:0}, at: process_one_work+0x805/0x1130 kernel/workqueue.c:2282
 #2: ffffffff8db9d948 (rtnl_mutex){+.+.}-{3:3}, at: addrconf_verify_work+0xa/0x20 net/ipv6/addrconf.c:4608
3 locks held by kworker/1:4/18505:
 #0: ffff888011464d38 ((wq_completion)events){+.+.}-{0:0}, at: process_one_work+0x7c7/0x1130
 #1: ffffc9000359fd20 (deferred_process_work){+.+.}-{0:0}, at: process_one_work+0x805/0x1130 kernel/workqueue.c:2282
 #2: ffffffff8db9d948 (rtnl_mutex){+.+.}-{3:3}, at: switchdev_deferred_process_work+0xa/0x20 net/switchdev/switchdev.c:75
2 locks held by syz-executor.3/18515:
 #0: ffffffff8db919b0 (pernet_ops_rwsem){++++}-{3:3}, at: copy_net_ns+0x33d/0x5c0 net/core/net_namespace.c:470
 #1: ffffffff8db9d948 (rtnl_mutex){+.+.}-{3:3}, at: smc_pnet_create_pnetids_list net/smc/smc_pnet.c:800 [inline]
 #1: ffffffff8db9d948 (rtnl_mutex){+.+.}-{3:3}, at: smc_pnet_net_init+0x14f/0x420 net/smc/smc_pnet.c:869
1 lock held by syz-executor.1/18516:
1 lock held by syz-executor.5/18526:
 #0: ffffffff8db9d948 (rtnl_mutex){+.+.}-{3:3}, at: rtnl_lock net/core/rtnetlink.c:72 [inline]
 #0: ffffffff8db9d948 (rtnl_mutex){+.+.}-{3:3}, at: rtnetlink_rcv_msg+0x92d/0xec0 net/core/rtnetlink.c:5591

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

NMI backtrace for cpu 1
CPU: 1 PID: 26 Comm: khungtaskd Not tainted 5.17.0-rc2-syzkaller-00167-gdcb85f85fa6f #0
Hardware name: Google Google Compute Engine/Google Compute Engine, BIOS Google 01/01/2011
Call Trace:
 <TASK>
 __dump_stack lib/dump_stack.c:88 [inline]
 dump_stack_lvl+0x1dc/0x2d8 lib/dump_stack.c:106
 nmi_cpu_backtrace+0x45f/0x490 lib/nmi_backtrace.c:111
 nmi_trigger_cpumask_backtrace+0x16a/0x280 lib/nmi_backtrace.c:62
 trigger_all_cpu_backtrace include/linux/nmi.h:146 [inline]
 check_hung_uninterruptible_tasks kernel/hung_task.c:212 [inline]
 watchdog+0xc82/0xcd0 kernel/hung_task.c:369
 kthread+0x2a3/0x2d0 kernel/kthread.c:377
 ret_from_fork+0x1f/0x30
 </TASK>
Sending NMI from CPU 1 to CPUs 0:
NMI backtrace for cpu 0
CPU: 0 PID: 449 Comm: kworker/u4:3 Not tainted 5.17.0-rc2-syzkaller-00167-gdcb85f85fa6f #0
Hardware name: Google Google Compute Engine/Google Compute Engine, BIOS Google 01/01/2011
Workqueue:  0x0 (phy53)
RIP: 0010:arch_atomic_read arch/x86/include/asm/atomic.h:29 [inline]
RIP: 0010:atomic_read include/linux/atomic/atomic-instrumented.h:28 [inline]
RIP: 0010:__perf_event_task_sched_in+0xe6/0xd50 kernel/events/core.c:3978
Code: 48 c7 c3 70 46 03 00 49 03 1f 48 89 df be 04 00 00 00 e8 8d f5 28 00 48 89 d8 48 c1 e8 03 42 8a 04 30 84 c0 0f 85 23 0c 00 00 <8b> 1b 31 ff 89 de e8 ff 62 dd ff 85 db 74 21 e8 76 8b c8 ff 48 c7
RSP: 0018:ffffc900031dfb20 EFLAGS: 00000046
RAX: 1ffff11017346800 RBX: ffff8880b9a34670 RCX: ffffffff81a84e83
RDX: 0000000000000000 RSI: 0000000000000004 RDI: ffff8880b9a34670
RBP: ffffc900031dfc30 R08: dffffc0000000000 R09: ffffed10173468cf
R10: ffffed10173468cf R11: 0000000000000000 R12: ffff88801a445700
R13: ffff88801a445700 R14: dffffc0000000000 R15: ffffffff8c5f0830
FS:  0000000000000000(0000) GS:ffff8880b9a00000(0000) knlGS:0000000000000000
CS:  0010 DS: 0000 ES: 0000 CR0: 0000000080050033
CR2: 00007fdafa8d8310 CR3: 0000000024b94000 CR4: 00000000003506f0
DR0: 0000000000000000 DR1: 0000000000000000 DR2: 0000000000000000
DR3: 0000000000000000 DR6: 00000000fffe0ff0 DR7: 0000000000000400
Call Trace:
 <TASK>
 perf_event_task_sched_in include/linux/perf_event.h:1213 [inline]
 finish_task_switch+0x406/0x630 kernel/sched/core.c:4861
 context_switch kernel/sched/core.c:4989 [inline]
 __schedule+0x92e/0x1080 kernel/sched/core.c:6295
 schedule+0x12b/0x1f0 kernel/sched/core.c:6368
 worker_thread+0xfbf/0x1300 kernel/workqueue.c:2475
 kthread+0x2a3/0x2d0 kernel/kthread.c:377
 ret_from_fork+0x1f/0x30
 </TASK>
----------------
Code disassembly (best guess):
   0:	48 c7 c3 70 46 03 00 	mov    $0x34670,%rbx
   7:	49 03 1f             	add    (%r15),%rbx
   a:	48 89 df             	mov    %rbx,%rdi
   d:	be 04 00 00 00       	mov    $0x4,%esi
  12:	e8 8d f5 28 00       	callq  0x28f5a4
  17:	48 89 d8             	mov    %rbx,%rax
  1a:	48 c1 e8 03          	shr    $0x3,%rax
  1e:	42 8a 04 30          	mov    (%rax,%r14,1),%al
  22:	84 c0                	test   %al,%al
  24:	0f 85 23 0c 00 00    	jne    0xc4d
* 2a:	8b 1b                	mov    (%rbx),%ebx <-- trapping instruction
  2c:	31 ff                	xor    %edi,%edi
  2e:	89 de                	mov    %ebx,%esi
  30:	e8 ff 62 dd ff       	callq  0xffdd6334
  35:	85 db                	test   %ebx,%ebx
  37:	74 21                	je     0x5a
  39:	e8 76 8b c8 ff       	callq  0xffc88bb4
  3e:	48                   	rex.W
  3f:	c7                   	.byte 0xc7

Crashes (12):
Manager Time Kernel Commit Syzkaller Config Log Report Syz repro C repro VM info Title
ci-upstream-kasan-gce-smack-root 2022/02/04 14:56 upstream dcb85f85fa6f a3e470b2 .config log report info INFO: task hung in smc_pnet_net_init
ci-upstream-kasan-gce-root 2021/12/30 01:54 upstream e7c124bd0463 6cc879d4 .config log report info INFO: task hung in smc_pnet_net_init
ci-upstream-kasan-gce 2021/09/29 05:43 upstream a4e6f95a891a d82cb927 .config log report info INFO: task hung in smc_pnet_net_init
ci-upstream-kasan-gce 2021/09/17 05:03 upstream bdb575f87217 5b989942 .config log report info INFO: task hung in smc_pnet_net_init
ci-upstream-kasan-gce-386 2021/09/29 14:41 upstream a4e6f95a891a be530f6c .config log report info INFO: task hung in smc_pnet_net_init
ci-upstream-kasan-gce-386 2021/09/11 19:43 upstream c605c39677b9 5ae8508a .config log report info INFO: task hung in smc_pnet_net_init
ci-upstream-kasan-gce-386 2021/09/11 19:18 upstream c605c39677b9 5ae8508a .config log report info INFO: task hung in smc_pnet_net_init
ci-upstream-net-kasan-gce 2021/10/18 14:08 net-next d40dfa0cebd8 0c5d9412 .config log report info INFO: task hung in smc_pnet_net_init
ci-upstream-net-kasan-gce 2021/10/18 12:46 net-next d40dfa0cebd8 0c5d9412 .config log report info INFO: task hung in smc_pnet_net_init
ci-upstream-net-kasan-gce 2021/09/27 17:49 net-next b69c99463d41 78494d16 .config log report info INFO: task hung in smc_pnet_net_init
ci-upstream-linux-next-kasan-gce-root 2021/11/06 10:40 linux-next 6a37ebbe07bf 4c1be0be .config log report info INFO: task hung in smc_pnet_net_init
ci-upstream-linux-next-kasan-gce-root 2021/10/20 12:23 linux-next 51dba6e335ff 418a00eb .config log report info INFO: task can't die in smc_pnet_net_init
* Struck through repros no longer work on HEAD.