syzbot


INFO: task hung in addrconf_verify_work (5)

Status: auto-obsoleted due to no activity on 2022/11/10 09:18
Reported-by: syzbot+e553715c62ec65fe83f9@syzkaller.appspotmail.com
First crash: 691d, last: 652d
Similar bugs (20)
Kernel Title Repro Cause bisect Fix bisect Count Last Reported Patched Status
android-49 INFO: task hung in addrconf_verify_work 18 1666d 1838d 0/3 auto-closed as invalid on 2020/01/31 12:44
linux-6.1 INFO: task hung in addrconf_verify_work (2) 3 41d 86d 0/3 upstream: reported on 2024/01/29 22:05
linux-4.19 INFO: task hung in addrconf_verify_work (6) C error 4 433d 493d 0/1 upstream: reported C repro on 2022/12/19 15:22
linux-4.19 INFO: task hung in addrconf_verify_work (3) 1 1139d 1139d 0/1 auto-closed as invalid on 2021/07/11 07:19
linux-4.19 INFO: task hung in addrconf_verify_work (4) 6 833d 920d 0/1 auto-closed as invalid on 2022/05/13 00:19
linux-4.14 INFO: task hung in addrconf_verify_work (2) C error 7 431d 1275d 0/1 upstream: reported C repro on 2020/10/28 05:47
upstream INFO: task hung in addrconf_verify_work (2) net C 22 1655d 1655d 13/26 fixed on 2019/11/04 14:50
linux-4.19 INFO: task hung in addrconf_verify_work (2) 2 1279d 1368d 0/1 auto-closed as invalid on 2021/02/21 08:05
android-414 INFO: task hung in addrconf_verify_work C 6 1655d 1840d 0/1 public: reported C repro on 2019/04/12 00:01
upstream INFO: task hung in addrconf_verify_work (8) net C error 64 17d 129d 0/26 upstream: reported C repro on 2023/12/18 14:44
android-44 INFO: task hung in addrconf_verify_work 3 2172d 2201d 0/2 auto-closed as invalid on 2019/02/22 14:29
linux-4.19 INFO: task hung in addrconf_verify_work 1 1498d 1498d 0/1 auto-closed as invalid on 2020/07/16 23:17
upstream INFO: task hung in addrconf_verify_work (3) C done 75 1269d 1303d 15/26 fixed on 2020/11/16 12:12
upstream INFO: task hung in addrconf_verify_work (5) net C done done 68 847d 939d 0/26 closed as invalid on 2022/02/01 17:39
upstream INFO: task hung in addrconf_verify_work (7) netfilter C error 64 147d 294d 0/26 closed as invalid on 2023/12/01 14:19
linux-6.1 INFO: task hung in addrconf_verify_work 2 356d 407d 0/3 auto-obsoleted due to no activity on 2023/08/23 09:09
linux-4.14 INFO: task hung in addrconf_verify_work 4 1424d 1496d 0/1 auto-closed as invalid on 2020/09/29 04:19
upstream INFO: task hung in addrconf_verify_work net C 2 2221d 2221d 0/26 closed as invalid on 2018/03/27 11:14
upstream INFO: task hung in addrconf_verify_work (4) C done 132 1160d 1247d 20/26 fixed on 2021/04/09 19:46
upstream INFO: task hung in addrconf_verify_work (6) C done 86 429d 666d 22/26 fixed on 2023/02/24 13:51

Sample crash report:
ieee802154 phy1 wpan1: encryption failed: -22
ieee802154 phy0 wpan0: encryption failed: -22
ieee802154 phy1 wpan1: encryption failed: -22
ieee802154 phy0 wpan0: encryption failed: -22
ieee802154 phy1 wpan1: encryption failed: -22
INFO: task kworker/1:5:16032 blocked for more than 140 seconds.
      Not tainted 4.19.211-syzkaller #0
"echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message.
kworker/1:5     D27568 16032      2 0x80000000
Workqueue: ipv6_addrconf addrconf_verify_work
Call Trace:
 context_switch kernel/sched/core.c:2828 [inline]
 __schedule+0x887/0x2040 kernel/sched/core.c:3517
 schedule+0x8d/0x1b0 kernel/sched/core.c:3561
 schedule_preempt_disabled+0xf/0x20 kernel/sched/core.c:3619
 __mutex_lock_common kernel/locking/mutex.c:1016 [inline]
 __mutex_lock+0x5f0/0x1190 kernel/locking/mutex.c:1078
 addrconf_verify_work+0xa/0x20 net/ipv6/addrconf.c:4476
 process_one_work+0x864/0x1570 kernel/workqueue.c:2153
 worker_thread+0x64c/0x1130 kernel/workqueue.c:2296
 kthread+0x33f/0x460 kernel/kthread.c:259
 ret_from_fork+0x24/0x30 arch/x86/entry/entry_64.S:415
INFO: task kworker/1:3:31713 blocked for more than 140 seconds.
      Not tainted 4.19.211-syzkaller #0
"echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message.
kworker/1:3     D28440 31713      2 0x80000000
Workqueue: events switchdev_deferred_process_work
Call Trace:
 context_switch kernel/sched/core.c:2828 [inline]
 __schedule+0x887/0x2040 kernel/sched/core.c:3517
 schedule+0x8d/0x1b0 kernel/sched/core.c:3561
 schedule_preempt_disabled+0xf/0x20 kernel/sched/core.c:3619
 __mutex_lock_common kernel/locking/mutex.c:1016 [inline]
 __mutex_lock+0x5f0/0x1190 kernel/locking/mutex.c:1078
 switchdev_deferred_process_work+0xa/0x20 net/switchdev/switchdev.c:150
 process_one_work+0x864/0x1570 kernel/workqueue.c:2153
 worker_thread+0x64c/0x1130 kernel/workqueue.c:2296
 kthread+0x33f/0x460 kernel/kthread.c:259
 ret_from_fork+0x24/0x30 arch/x86/entry/entry_64.S:415

Showing all locks held in the system:
3 locks held by kworker/1:0/19:
2 locks held by kworker/u4:3/56:
1 lock held by khungtaskd/1570:
 #0: 00000000b629f074 (rcu_read_lock){....}, at: debug_show_all_locks+0x53/0x265 kernel/locking/lockdep.c:4441
1 lock held by systemd-journal/4687:
1 lock held by systemd-udevd/4701:
1 lock held by in:imklog/7775:
2 locks held by agetty/7830:
 #0: 000000000e59035b (&tty->ldisc_sem){++++}, at: tty_ldisc_ref_wait+0x22/0x80 drivers/tty/tty_ldisc.c:272
 #1: 000000009354af7e (&ldata->atomic_read_lock){+.+.}, at: n_tty_read+0x217/0x1950 drivers/tty/n_tty.c:2154
3 locks held by syz-fuzzer/8116:
3 locks held by kworker/1:5/16032:
 #0: 000000003c28d7bb ((wq_completion)"%s"("ipv6_addrconf")){+.+.}, at: process_one_work+0x767/0x1570 kernel/workqueue.c:2124
 #1: 000000008352262e ((addr_chk_work).work){+.+.}, at: process_one_work+0x79c/0x1570 kernel/workqueue.c:2128
 #2: 00000000766e19f1 (rtnl_mutex){+.+.}, at: addrconf_verify_work+0xa/0x20 net/ipv6/addrconf.c:4476
2 locks held by syz-executor.2/17880:
1 lock held by syz-executor.1/21785:
1 lock held by syz-executor.0/28786:
 #0: 000000008cd81b3f (uevent_sock_mutex){+.+.}, at: kobject_uevent_env+0x85d/0x1480 lib/kobject_uevent.c:584
3 locks held by kworker/1:3/31713:
 #0: 0000000031ce0b7a ((wq_completion)"events"){+.+.}, at: process_one_work+0x767/0x1570 kernel/workqueue.c:2124
 #1: 000000007665c54e (deferred_process_work){+.+.}, at: process_one_work+0x79c/0x1570 kernel/workqueue.c:2128
 #2: 00000000766e19f1 (rtnl_mutex){+.+.}, at: switchdev_deferred_process_work+0xa/0x20 net/switchdev/switchdev.c:150
2 locks held by syz-executor.3/31973:
1 lock held by syz-executor.4/31988:
4 locks held by syz-executor.5/31994:
1 lock held by systemd-udevd/32003:
2 locks held by systemd-tmpfile/32004:
2 locks held by cron/32008:
1 lock held by systemd-udevd/32009:

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

NMI backtrace for cpu 0
CPU: 0 PID: 1570 Comm: khungtaskd Not tainted 4.19.211-syzkaller #0
Hardware name: Google Google Compute Engine/Google Compute Engine, BIOS Google 06/29/2022
Call Trace:
 __dump_stack lib/dump_stack.c:77 [inline]
 dump_stack+0x1fc/0x2ef lib/dump_stack.c:118
 nmi_cpu_backtrace.cold+0x63/0xa2 lib/nmi_backtrace.c:101
 nmi_trigger_cpumask_backtrace+0x1a6/0x1f0 lib/nmi_backtrace.c:62
 trigger_all_cpu_backtrace include/linux/nmi.h:146 [inline]
 check_hung_uninterruptible_tasks kernel/hung_task.c:203 [inline]
 watchdog+0x991/0xe60 kernel/hung_task.c:287
 kthread+0x33f/0x460 kernel/kthread.c:259
 ret_from_fork+0x24/0x30 arch/x86/entry/entry_64.S:415
Sending NMI from CPU 0 to CPUs 1:
NMI backtrace for cpu 1
CPU: 1 PID: 21785 Comm: syz-executor.1 Not tainted 4.19.211-syzkaller #0
Hardware name: Google Google Compute Engine/Google Compute Engine, BIOS Google 06/29/2022
RIP: 0010:__pvclock_read_cycles arch/x86/include/asm/pvclock.h:85 [inline]
RIP: 0010:pvclock_clocksource_read+0x170/0x520 arch/x86/kernel/pvclock.c:87
Code: 0f b6 0c 29 0f b6 34 2e 40 38 f9 40 0f 9e c7 84 c9 0f 95 c1 40 84 cf 0f 85 5d 02 00 00 4c 89 d9 83 e1 07 40 38 ce 40 0f 9e c7 <40> 84 f6 0f 95 c1 40 84 cf 0f 85 41 02 00 00 89 d1 48 89 c6 f7 d9
RSP: 0018:ffff8880ba1075a8 EFLAGS: 00000093
RAX: 000001f58eee5a36 RBX: ffffffff8c665040 RCX: 0000000000000003
RDX: 00000000ffffffff RSI: 0000000000000000 RDI: 0000000000000001
RBP: dffffc0000000000 R08: ffffffff8c665058 R09: ffffffff8c66504f
R10: ffffffff8c665057 R11: ffffffff8c66505b R12: ffffffff8c665043
R13: fffffbfff18cca09 R14: ffffffff8c66505d R15: ffffffff8c665050
FS:  00007f8eaa025700(0000) GS:ffff8880ba100000(0000) knlGS:0000000000000000
CS:  0010 DS: 0000 ES: 0000 CR0: 0000000080050033
CR2: 0000000000ad7d10 CR3: 00000000a4743000 CR4: 00000000003406e0
DR0: 0000000000000000 DR1: 0000000000000000 DR2: 0000000000000000
DR3: 0000000000000000 DR6: 00000000fffe0ff0 DR7: 0000000000000400
Call Trace:
 <IRQ>
 kvm_clock_read arch/x86/kernel/kvmclock.c:94 [inline]
 kvm_clock_get_cycles+0x14/0x30 arch/x86/kernel/kvmclock.c:101
 tk_clock_read kernel/time/timekeeping.c:172 [inline]
 timekeeping_get_delta kernel/time/timekeeping.c:266 [inline]
 timekeeping_get_ns kernel/time/timekeeping.c:373 [inline]
 ktime_get_update_offsets_now+0x183/0x460 kernel/time/timekeeping.c:2228
 hrtimer_update_base kernel/time/hrtimer.c:621 [inline]
 hrtimer_interrupt+0x449/0x9e0 kernel/time/hrtimer.c:1617
 local_apic_timer_interrupt arch/x86/kernel/apic/apic.c:1071 [inline]
 smp_apic_timer_interrupt+0x10c/0x550 arch/x86/kernel/apic/apic.c:1096
 apic_timer_interrupt+0xf/0x20 arch/x86/entry/entry_64.S:894
RIP: 0010:orc_ip arch/x86/kernel/unwind_orc.c:26 [inline]
RIP: 0010:__orc_find+0x6f/0xf0 arch/x86/kernel/unwind_orc.c:48
Code: 72 4d 4c 89 e0 48 29 e8 48 89 c2 48 c1 e8 3f 48 c1 fa 02 48 01 d0 48 d1 f8 48 8d 5c 85 00 48 89 d8 48 c1 e8 03 42 0f b6 14 38 <48> 89 d8 83 e0 07 83 c0 03 38 d0 7c 04 84 d2 75 48 48 63 03 48 01
RSP: 0018:ffff8880ba107848 EFLAGS: 00000a03 ORIG_RAX: ffffffffffffff13
RAX: 1ffffffff1673264 RBX: ffffffff8b399324 RCX: ffffffff81a3239d
RDX: 0000000000000000 RSI: ffffffff8b9ab928 RDI: ffffffff8b399324
RBP: ffffffff8b399324 R08: 0000000000000000 R09: ffffffff8b9ab928
R10: ffff8880ba107a1f R11: 0000000000074071 R12: ffffffff8b399324
R13: ffffffff8b399324 R14: ffffffff8b399324 R15: dffffc0000000000
 orc_find arch/x86/kernel/unwind_orc.c:159 [inline]
 unwind_next_frame+0x339/0x1400 arch/x86/kernel/unwind_orc.c:422
 __save_stack_trace+0x9f/0x190 arch/x86/kernel/stacktrace.c:44
 save_stack mm/kasan/kasan.c:448 [inline]
 set_track mm/kasan/kasan.c:460 [inline]
 kasan_kmalloc+0xeb/0x160 mm/kasan/kasan.c:553
 slab_post_alloc_hook mm/slab.h:445 [inline]
 slab_alloc_node mm/slab.c:3340 [inline]
 kmem_cache_alloc_node+0x133/0x3b0 mm/slab.c:3647
 __alloc_skb+0x71/0x560 net/core/skbuff.c:193
 alloc_skb include/linux/skbuff.h:995 [inline]
 bcm_can_tx+0x259/0x800 net/can/bcm.c:287
 bcm_tx_timeout_tsklet+0x1f0/0x3a0 net/can/bcm.c:414
 tasklet_action_common.constprop.0+0x265/0x360 kernel/softirq.c:522
 __do_softirq+0x265/0x980 kernel/softirq.c:292
 invoke_softirq kernel/softirq.c:372 [inline]
 irq_exit+0x215/0x260 kernel/softirq.c:412
 exiting_irq arch/x86/include/asm/apic.h:536 [inline]
 smp_apic_timer_interrupt+0x136/0x550 arch/x86/kernel/apic/apic.c:1098
 apic_timer_interrupt+0xf/0x20 arch/x86/entry/entry_64.S:894
 </IRQ>
RIP: 0010:pte_none arch/x86/include/asm/pgtable.h:709 [inline]
RIP: 0010:vunmap_pte_range mm/vmalloc.c:68 [inline]
RIP: 0010:vunmap_pmd_range mm/vmalloc.c:84 [inline]
RIP: 0010:vunmap_pud_range mm/vmalloc.c:100 [inline]
RIP: 0010:vunmap_p4d_range mm/vmalloc.c:116 [inline]
RIP: 0010:vunmap_page_range+0x643/0x770 mm/vmalloc.c:131
Code: c6 08 4c 89 ff e8 ed d5 d1 ff 49 39 ef 0f 84 69 fe ff ff e8 cf d4 d1 ff be 08 00 00 00 4c 89 f7 31 db e8 40 9e 07 00 49 87 1e <49> 89 dd 31 ff 49 83 e5 9f 4c 89 ee e8 3c d6 d1 ff 4d 85 ed 74 af
RSP: 0018:ffff88805c6178f0 EFLAGS: 00000246 ORIG_RAX: ffffffffffffff13
RAX: ffffed1013a9dc02 RBX: 800000009d1dc163 RCX: ffffffff8190b0b0
RDX: ffffed1013a9dc02 RSI: 0000000000000008 RDI: ffff88809d4ee008
RBP: ffffc90007cc6000 R08: 0000000000000001 R09: ffffed1013a9dc01
R10: ffff88809d4ee00f R11: 0000000000000000 R12: ffff88823b8311f0
R13: 800000009d117103 R14: ffff88809d4ee008 R15: ffffc90007c01000
 unmap_vmap_area mm/vmalloc.c:608 [inline]
 free_unmap_vmap_area mm/vmalloc.c:743 [inline]
 remove_vm_area+0x25b/0x2f0 mm/vmalloc.c:1495
 __vunmap+0x187/0x3f0 mm/vmalloc.c:1523
 vfree+0x65/0x100 mm/vmalloc.c:1598
 kcov_put kernel/kcov.c:237 [inline]
 kcov_put+0x1f/0x30 kernel/kcov.c:234
 kcov_close+0xc/0x10 kernel/kcov.c:323
 __fput+0x2ce/0x890 fs/file_table.c:278
 task_work_run+0x148/0x1c0 kernel/task_work.c:113
 exit_task_work include/linux/task_work.h:22 [inline]
 do_exit+0xbf3/0x2be0 kernel/exit.c:870
 do_group_exit+0x125/0x310 kernel/exit.c:967
 get_signal+0x3f2/0x1f70 kernel/signal.c:2589
 do_signal+0x8f/0x1670 arch/x86/kernel/signal.c:799
 exit_to_usermode_loop+0x204/0x2a0 arch/x86/entry/common.c:163
 prepare_exit_to_usermode arch/x86/entry/common.c:198 [inline]
 syscall_return_slowpath arch/x86/entry/common.c:271 [inline]
 do_syscall_64+0x538/0x620 arch/x86/entry/common.c:296
 entry_SYSCALL_64_after_hwframe+0x49/0xbe
RIP: 0033:0x7f8eab6d4e31
Code: Bad RIP value.
RSP: 002b:00007f8eaa0250b0 EFLAGS: 00000293 ORIG_RAX: 00000000000000e6
RAX: fffffffffffffdfc RBX: 00007f8eab7c2f60 RCX: 00007f8eab6d4e31
RDX: 00007f8eaa0250f0 RSI: 0000000000000000 RDI: 0000000000000000
RBP: 00007f8eab70a0ed R08: 0000000000000000 R09: 0000000000000000
R10: 0000000000000000 R11: 0000000000000293 R12: 0000000000000000
R13: 00007ffca382679f R14: 00007f8eaa025300 R15: 0000000000022000

Crashes (3):
Time Kernel Commit Syzkaller Config Log Report Syz repro C repro VM info Assets (help?) Manager Title
2022/07/13 09:17 linux-4.19.y 3f8a27f9e27b 5d921b08 .config console log report info ci2-linux-4-19 INFO: task hung in addrconf_verify_work
2022/06/27 17:59 linux-4.19.y 3f8a27f9e27b a371c43c .config console log report info ci2-linux-4-19 INFO: task hung in addrconf_verify_work
2022/06/03 23:38 linux-4.19.y 3f8a27f9e27b c8857892 .config console log report info ci2-linux-4-19 INFO: task hung in addrconf_verify_work
* Struck through repros no longer work on HEAD.