syzbot


INFO: task hung in bpf_prog_pack_free

Status: auto-obsoleted due to no activity on 2024/10/22 06:44
Subsystems: bpf
[Documentation on labels]
First crash: 207d, last: 188d

Sample crash report:
INFO: task kworker/0:3:5090 blocked for more than 143 seconds.
      Not tainted 6.10.0-syzkaller-12084-g28bbe4ea686a #0
"echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message.
task:kworker/0:3     state:D stack:19920 pid:5090  tgid:5090  ppid:2      flags:0x00004000
Workqueue: events bpf_prog_free_deferred

Call Trace:
 <TASK>
 context_switch kernel/sched/core.c:5188 [inline]
 __schedule+0x17ae/0x4a10 kernel/sched/core.c:6529
 __schedule_loop kernel/sched/core.c:6606 [inline]
 schedule+0x14b/0x320 kernel/sched/core.c:6621
 schedule_preempt_disabled+0x13/0x30 kernel/sched/core.c:6678
 __mutex_lock_common kernel/locking/mutex.c:684 [inline]
 __mutex_lock+0x6a4/0xd70 kernel/locking/mutex.c:752
 bpf_prog_pack_free+0x27/0x410 kernel/bpf/core.c:990
 bpf_jit_binary_pack_free+0x3b/0x80 kernel/bpf/core.c:1207
 bpf_jit_free+0x119/0x1d0 arch/x86/net/bpf_jit_comp.c:3445
 process_one_work kernel/workqueue.c:3231 [inline]
 process_scheduled_works+0xa2c/0x1830 kernel/workqueue.c:3312
 worker_thread+0x86d/0xd40 kernel/workqueue.c:3390
 kthread+0x2f0/0x390 kernel/kthread.c:389
 ret_from_fork+0x4b/0x80 arch/x86/kernel/process.c:147
 ret_from_fork_asm+0x1a/0x30 arch/x86/entry/entry_64.S:244
 </TASK>
INFO: task kworker/0:4:5141 blocked for more than 144 seconds.
      Not tainted 6.10.0-syzkaller-12084-g28bbe4ea686a #0
"echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message.
task:kworker/0:4     state:D
 stack:14352 pid:5141  tgid:5141  ppid:2      flags:0x00004000
Workqueue: events bpf_prog_free_deferred
Call Trace:
 <TASK>
 context_switch kernel/sched/core.c:5188 [inline]
 __schedule+0x17ae/0x4a10 kernel/sched/core.c:6529
 __schedule_loop kernel/sched/core.c:6606 [inline]
 schedule+0x14b/0x320 kernel/sched/core.c:6621
 schedule_preempt_disabled+0x13/0x30 kernel/sched/core.c:6678
 __mutex_lock_common kernel/locking/mutex.c:684 [inline]
 __mutex_lock+0x6a4/0xd70 kernel/locking/mutex.c:752
 bpf_prog_pack_free+0x27/0x410 kernel/bpf/core.c:990
 bpf_jit_binary_pack_free+0x3b/0x80 kernel/bpf/core.c:1207
 bpf_jit_free+0x119/0x1d0 arch/x86/net/bpf_jit_comp.c:3445
 process_one_work kernel/workqueue.c:3231 [inline]
 process_scheduled_works+0xa2c/0x1830 kernel/workqueue.c:3312
 worker_thread+0x86d/0xd40 kernel/workqueue.c:3390
 kthread+0x2f0/0x390 kernel/kthread.c:389
 ret_from_fork+0x4b/0x80 arch/x86/kernel/process.c:147
 ret_from_fork_asm+0x1a/0x30 arch/x86/entry/entry_64.S:244
 </TASK>
INFO: task kworker/0:5:5142 blocked for more than 144 seconds.
      Not tainted 6.10.0-syzkaller-12084-g28bbe4ea686a #0
"echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message.
task:kworker/0:5     state:D
 stack:19024 pid:5142  tgid:5142  ppid:2      flags:0x00004000
Workqueue: events bpf_prog_free_deferred

Call Trace:
 <TASK>
 context_switch kernel/sched/core.c:5188 [inline]
 __schedule+0x17ae/0x4a10 kernel/sched/core.c:6529
 __schedule_loop kernel/sched/core.c:6606 [inline]
 schedule+0x14b/0x320 kernel/sched/core.c:6621
 schedule_preempt_disabled+0x13/0x30 kernel/sched/core.c:6678
 __mutex_lock_common kernel/locking/mutex.c:684 [inline]
 __mutex_lock+0x6a4/0xd70 kernel/locking/mutex.c:752
 bpf_prog_pack_free+0x27/0x410 kernel/bpf/core.c:990
 bpf_jit_binary_pack_free+0x3b/0x80 kernel/bpf/core.c:1207
 bpf_jit_free+0x119/0x1d0 arch/x86/net/bpf_jit_comp.c:3445
 process_one_work kernel/workqueue.c:3231 [inline]
 process_scheduled_works+0xa2c/0x1830 kernel/workqueue.c:3312
 worker_thread+0x86d/0xd40 kernel/workqueue.c:3390
 kthread+0x2f0/0x390 kernel/kthread.c:389
 ret_from_fork+0x4b/0x80 arch/x86/kernel/process.c:147
 ret_from_fork_asm+0x1a/0x30 arch/x86/entry/entry_64.S:244
 </TASK>
INFO: task kworker/0:8:5659 blocked for more than 145 seconds.
      Not tainted 6.10.0-syzkaller-12084-g28bbe4ea686a #0
"echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message.
task:kworker/0:8     state:D
 stack:19344 pid:5659  tgid:5659  ppid:2      flags:0x00004000
Workqueue: events bpf_prog_free_deferred

Call Trace:
 <TASK>
 context_switch kernel/sched/core.c:5188 [inline]
 __schedule+0x17ae/0x4a10 kernel/sched/core.c:6529
 __schedule_loop kernel/sched/core.c:6606 [inline]
 schedule+0x14b/0x320 kernel/sched/core.c:6621
 schedule_preempt_disabled+0x13/0x30 kernel/sched/core.c:6678
 __mutex_lock_common kernel/locking/mutex.c:684 [inline]
 __mutex_lock+0x6a4/0xd70 kernel/locking/mutex.c:752
 bpf_prog_pack_free+0x27/0x410 kernel/bpf/core.c:990
 bpf_jit_binary_pack_free+0x3b/0x80 kernel/bpf/core.c:1207
 bpf_jit_free+0x119/0x1d0 arch/x86/net/bpf_jit_comp.c:3445
 process_one_work kernel/workqueue.c:3231 [inline]
 process_scheduled_works+0xa2c/0x1830 kernel/workqueue.c:3312
 worker_thread+0x86d/0xd40 kernel/workqueue.c:3390
 kthread+0x2f0/0x390 kernel/kthread.c:389
 ret_from_fork+0x4b/0x80 arch/x86/kernel/process.c:147
 ret_from_fork_asm+0x1a/0x30 arch/x86/entry/entry_64.S:244
 </TASK>
INFO: task kworker/0:0:13673 blocked for more than 146 seconds.
      Not tainted 6.10.0-syzkaller-12084-g28bbe4ea686a #0
"echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message.
task:kworker/0:0     state:D
 stack:20272 pid:13673 tgid:13673 ppid:2      flags:0x00004000
Workqueue: events bpf_prog_free_deferred

Call Trace:
 <TASK>
 context_switch kernel/sched/core.c:5188 [inline]
 __schedule+0x17ae/0x4a10 kernel/sched/core.c:6529
 __schedule_loop kernel/sched/core.c:6606 [inline]
 schedule+0x14b/0x320 kernel/sched/core.c:6621
 schedule_preempt_disabled+0x13/0x30 kernel/sched/core.c:6678
 __mutex_lock_common kernel/locking/mutex.c:684 [inline]
 __mutex_lock+0x6a4/0xd70 kernel/locking/mutex.c:752
 bpf_prog_pack_free+0x27/0x410 kernel/bpf/core.c:990
 bpf_jit_binary_pack_free+0x3b/0x80 kernel/bpf/core.c:1207
 bpf_jit_free+0x119/0x1d0 arch/x86/net/bpf_jit_comp.c:3445
 process_one_work kernel/workqueue.c:3231 [inline]
 process_scheduled_works+0xa2c/0x1830 kernel/workqueue.c:3312
 worker_thread+0x86d/0xd40 kernel/workqueue.c:3390
 kthread+0x2f0/0x390 kernel/kthread.c:389
 ret_from_fork+0x4b/0x80 arch/x86/kernel/process.c:147
 ret_from_fork_asm+0x1a/0x30 arch/x86/entry/entry_64.S:244
 </TASK>
INFO: task kworker/0:1:19359 blocked for more than 147 seconds.
      Not tainted 6.10.0-syzkaller-12084-g28bbe4ea686a #0
"echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message.
task:kworker/0:1     state:D
 stack:20024 pid:19359 tgid:19359 ppid:2      flags:0x00004000
Workqueue: events bpf_prog_free_deferred

Call Trace:
 <TASK>
 context_switch kernel/sched/core.c:5188 [inline]
 __schedule+0x17ae/0x4a10 kernel/sched/core.c:6529
 __schedule_loop kernel/sched/core.c:6606 [inline]
 schedule+0x14b/0x320 kernel/sched/core.c:6621
 schedule_preempt_disabled+0x13/0x30 kernel/sched/core.c:6678
 __mutex_lock_common kernel/locking/mutex.c:684 [inline]
 __mutex_lock+0x6a4/0xd70 kernel/locking/mutex.c:752
 bpf_prog_pack_free+0x27/0x410 kernel/bpf/core.c:990
 bpf_jit_binary_pack_free+0x3b/0x80 kernel/bpf/core.c:1207
 bpf_jit_free+0x119/0x1d0 arch/x86/net/bpf_jit_comp.c:3445
 process_one_work kernel/workqueue.c:3231 [inline]
 process_scheduled_works+0xa2c/0x1830 kernel/workqueue.c:3312
 worker_thread+0x86d/0xd40 kernel/workqueue.c:3390
 kthread+0x2f0/0x390 kernel/kthread.c:389
 ret_from_fork+0x4b/0x80 arch/x86/kernel/process.c:147
 ret_from_fork_asm+0x1a/0x30 arch/x86/entry/entry_64.S:244
 </TASK>
INFO: task kworker/u8:2:30269 blocked for more than 148 seconds.
      Not tainted 6.10.0-syzkaller-12084-g28bbe4ea686a #0
"echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message.
task:kworker/u8:2    state:D
 stack:21040 pid:30269 tgid:30269 ppid:2      flags:0x00004000
Workqueue: events_unbound toggle_allocation_gate

Call Trace:
 <TASK>
 context_switch kernel/sched/core.c:5188 [inline]
 __schedule+0x17ae/0x4a10 kernel/sched/core.c:6529
 __schedule_loop kernel/sched/core.c:6606 [inline]
 schedule+0x14b/0x320 kernel/sched/core.c:6621
 schedule_preempt_disabled+0x13/0x30 kernel/sched/core.c:6678
 __mutex_lock_common kernel/locking/mutex.c:684 [inline]
 __mutex_lock+0x6a4/0xd70 kernel/locking/mutex.c:752
 arch_jump_label_transform_queue+0x5d/0x100 arch/x86/kernel/jump_label.c:136
 __jump_label_update+0x177/0x3a0 kernel/jump_label.c:493
 static_key_disable_cpuslocked+0xce/0x1c0 kernel/jump_label.c:240
 static_key_disable+0x1a/0x20 kernel/jump_label.c:248
 toggle_allocation_gate+0x1b8/0x250 mm/kfence/core.c:838
 process_one_work kernel/workqueue.c:3231 [inline]
 process_scheduled_works+0xa2c/0x1830 kernel/workqueue.c:3312
 worker_thread+0x86d/0xd40 kernel/workqueue.c:3390
 kthread+0x2f0/0x390 kernel/kthread.c:389
 ret_from_fork+0x4b/0x80 arch/x86/kernel/process.c:147
 ret_from_fork_asm+0x1a/0x30 arch/x86/entry/entry_64.S:244
 </TASK>
INFO: task syz.0.8463:1212 blocked for more than 148 seconds.
      Not tainted 6.10.0-syzkaller-12084-g28bbe4ea686a #0
"echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message.
task:syz.0.8463      state:D
 stack:27248 pid:1212  tgid:1203  ppid:28230  flags:0x00004004
Call Trace:
 <TASK>
 context_switch kernel/sched/core.c:5188 [inline]
 __schedule+0x17ae/0x4a10 kernel/sched/core.c:6529
 __schedule_loop kernel/sched/core.c:6606 [inline]
 schedule+0x14b/0x320 kernel/sched/core.c:6621
 schedule_timeout+0xb0/0x310 kernel/time/timer.c:2557
 do_wait_for_common kernel/sched/completion.c:95 [inline]
 __wait_for_common kernel/sched/completion.c:116 [inline]
 wait_for_common kernel/sched/completion.c:127 [inline]
 wait_for_completion+0x355/0x620 kernel/sched/completion.c:148
 __flush_work+0xaa9/0xd00 kernel/workqueue.c:4208
 __lru_add_drain_all+0x4f6/0x560 mm/swap.c:920
 madvise_collapse+0x24b/0xcf0 mm/khugepaged.c:2728
 madvise_vma_behavior mm/madvise.c:1094 [inline]
 madvise_walk_vmas mm/madvise.c:1268 [inline]
 do_madvise+0xc5f/0x4590 mm/madvise.c:1464
 __do_sys_madvise mm/madvise.c:1481 [inline]
 __se_sys_madvise mm/madvise.c:1479 [inline]
 __x64_sys_madvise+0xa6/0xc0 mm/madvise.c:1479
 do_syscall_x64 arch/x86/entry/common.c:52 [inline]
 do_syscall_64+0xf3/0x230 arch/x86/entry/common.c:83
 entry_SYSCALL_64_after_hwframe+0x77/0x7f
RIP: 0033:0x7ff792d75f19
RSP: 002b:00007ff793bc9048 EFLAGS: 00000246
 ORIG_RAX: 000000000000001c
RAX: ffffffffffffffda RBX: 00007ff792f06110 RCX: 00007ff792d75f19
RDX: 0000000000000019 RSI: 0000000000400000 RDI: 0000000020000000
RBP: 00007ff792de4e68 R08: 0000000000000000 R09: 0000000000000000
R10: 0000000000000000 R11: 0000000000000246 R12: 0000000000000000
R13: 000000000000006e R14: 00007ff792f06110 R15: 00007fff85ec35f8
 </TASK>
INFO: task kworker/0:2:1213 blocked for more than 149 seconds.
      Not tainted 6.10.0-syzkaller-12084-g28bbe4ea686a #0
"echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message.
task:kworker/0:2     state:D
 stack:27040 pid:1213  tgid:1213  ppid:2      flags:0x00004000
Workqueue: events linkwatch_event

Call Trace:
 <TASK>
 context_switch kernel/sched/core.c:5188 [inline]
 __schedule+0x17ae/0x4a10 kernel/sched/core.c:6529
 __schedule_loop kernel/sched/core.c:6606 [inline]
 schedule+0x14b/0x320 kernel/sched/core.c:6621
 schedule_preempt_disabled+0x13/0x30 kernel/sched/core.c:6678
 __mutex_lock_common kernel/locking/mutex.c:684 [inline]
 __mutex_lock+0x6a4/0xd70 kernel/locking/mutex.c:752
 linkwatch_event+0xe/0x60 net/core/link_watch.c:276
 process_one_work kernel/workqueue.c:3231 [inline]
 process_scheduled_works+0xa2c/0x1830 kernel/workqueue.c:3312
 worker_thread+0x86d/0xd40 kernel/workqueue.c:3390
 kthread+0x2f0/0x390 kernel/kthread.c:389
 ret_from_fork+0x4b/0x80 arch/x86/kernel/process.c:147
 ret_from_fork_asm+0x1a/0x30 arch/x86/entry/entry_64.S:244
 </TASK>
INFO: task syz.3.8467:1220 blocked for more than 150 seconds.
      Not tainted 6.10.0-syzkaller-12084-g28bbe4ea686a #0
"echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message.
task:syz.3.8467      state:D
 stack:25272 pid:1220  tgid:1218  ppid:31197  flags:0x00004004
Call Trace:
 <TASK>
 context_switch kernel/sched/core.c:5188 [inline]
 __schedule+0x17ae/0x4a10 kernel/sched/core.c:6529
 __schedule_loop kernel/sched/core.c:6606 [inline]
 schedule+0x14b/0x320 kernel/sched/core.c:6621
 schedule_preempt_disabled+0x13/0x30 kernel/sched/core.c:6678
 __mutex_lock_common kernel/locking/mutex.c:684 [inline]
 __mutex_lock+0x6a4/0xd70 kernel/locking/mutex.c:752
 class_mutex_constructor include/linux/mutex.h:196 [inline]
 static_key_slow_inc_cpuslocked+0x39/0xf0 kernel/jump_label.c:165
 static_key_slow_inc+0x1a/0x30 kernel/jump_label.c:191
 taprio_init+0x9a5/0xc80 net/sched/sch_taprio.c:2109
 qdisc_create+0x9d4/0x11a0 net/sched/sch_api.c:1355
 tc_modify_qdisc+0xa26/0x1e40 net/sched/sch_api.c:1777
 rtnetlink_rcv_msg+0x73f/0xcf0 net/core/rtnetlink.c:6647
 netlink_rcv_skb+0x1e3/0x430 net/netlink/af_netlink.c:2550
 netlink_unicast_kernel net/netlink/af_netlink.c:1331 [inline]
 netlink_unicast+0x7f0/0x990 net/netlink/af_netlink.c:1357
 netlink_sendmsg+0x8e4/0xcb0 net/netlink/af_netlink.c:1901
 sock_sendmsg_nosec net/socket.c:730 [inline]
 __sock_sendmsg+0x221/0x270 net/socket.c:745
 ____sys_sendmsg+0x525/0x7d0 net/socket.c:2597
 ___sys_sendmsg net/socket.c:2651 [inline]
 __sys_sendmsg+0x2b0/0x3a0 net/socket.c:2680
 do_syscall_x64 arch/x86/entry/common.c:52 [inline]
 do_syscall_64+0xf3/0x230 arch/x86/entry/common.c:83
 entry_SYSCALL_64_after_hwframe+0x77/0x7f
RIP: 0033:0x7f4630b75f19
RSP: 002b:00007f4631a07048 EFLAGS: 00000246
 ORIG_RAX: 000000000000002e
RAX: ffffffffffffffda RBX: 00007f4630d06038 RCX: 00007f4630b75f19
RDX: 0000000000000000 RSI: 00000000200007c0 RDI: 0000000000000008
RBP: 00007f4630be4e68 R08: 0000000000000000 R09: 0000000000000000
R10: 0000000000000000 R11: 0000000000000246 R12: 0000000000000000
R13: 000000000000006e R14: 00007f4630d06038 R15: 00007ffd65d20e98
 </TASK>
Future hung task reports are suppressed, see sysctl kernel.hung_task_warnings
INFO: task syz.2.8469:1227 blocked for more than 151 seconds.
      Not tainted 6.10.0-syzkaller-12084-g28bbe4ea686a #0
"echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message.
task:syz.2.8469      state:D
 stack:23800 pid:1227  tgid:1226  ppid:31134  flags:0x00000004
Call Trace:
 <TASK>
 context_switch kernel/sched/core.c:5188 [inline]
 __schedule+0x17ae/0x4a10 kernel/sched/core.c:6529
 __schedule_loop kernel/sched/core.c:6606 [inline]
 schedule+0x14b/0x320 kernel/sched/core.c:6621
 schedule_preempt_disabled+0x13/0x30 kernel/sched/core.c:6678
 __mutex_lock_common kernel/locking/mutex.c:684 [inline]
 __mutex_lock+0x6a4/0xd70 kernel/locking/mutex.c:752
 bpf_prog_pack_alloc+0x2a/0x5a0 kernel/bpf/core.c:944
 bpf_jit_binary_pack_alloc+0x139/0x340 kernel/bpf/core.c:1148
 bpf_int_jit_compile+0x723/0x15e0 arch/x86/net/bpf_jit_comp.c:3334
 bpf_prog_select_runtime+0x8ff/0xc20 kernel/bpf/core.c:2408
 bpf_prog_load+0x16c6/0x20f0 kernel/bpf/syscall.c:2912
 __sys_bpf+0x4ee/0x810 kernel/bpf/syscall.c:5710
 __do_sys_bpf kernel/bpf/syscall.c:5817 [inline]
 __se_sys_bpf kernel/bpf/syscall.c:5815 [inline]
 __x64_sys_bpf+0x7c/0x90 kernel/bpf/syscall.c:5815
 do_syscall_x64 arch/x86/entry/common.c:52 [inline]
 do_syscall_64+0xf3/0x230 arch/x86/entry/common.c:83
 entry_SYSCALL_64_after_hwframe+0x77/0x7f
RIP: 0033:0x7f7e96175f19
RSP: 002b:00007f7e96f09048 EFLAGS: 00000246
 ORIG_RAX: 0000000000000141
RAX: ffffffffffffffda RBX: 00007f7e96305f60 RCX: 00007f7e96175f19
RDX: 0000000000000048 RSI: 0000000020000200 RDI: 0000000000000005
RBP: 00007f7e961e4e68 R08: 0000000000000000 R09: 0000000000000000
R10: 0000000000000000 R11: 0000000000000246 R12: 0000000000000000
R13: 000000000000000b R14: 00007f7e96305f60 R15: 00007ffdc7fa0ce8
 </TASK>
Future hung task reports are suppressed, see sysctl kernel.hung_task_warnings
INFO: task syz.2.8469:1228 blocked for more than 152 seconds.
      Not tainted 6.10.0-syzkaller-12084-g28bbe4ea686a #0
"echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message.
task:syz.2.8469      state:D
 stack:23800 pid:1228  tgid:1226  ppid:31134  flags:0x00000004
Call Trace:
 <TASK>
 context_switch kernel/sched/core.c:5188 [inline]
 __schedule+0x17ae/0x4a10 kernel/sched/core.c:6529
 __schedule_loop kernel/sched/core.c:6606 [inline]
 schedule+0x14b/0x320 kernel/sched/core.c:6621

Crashes (3):
Time Kernel Commit Syzkaller Config Log Report Syz repro C repro VM info Assets (help?) Manager Title
2024/07/24 06:40 upstream 28bbe4ea686a 57b2edb1 .config console log report info [disk image] [vmlinux] [kernel image] ci-upstream-kasan-gce-smack-root INFO: task hung in bpf_prog_pack_free
2024/07/23 20:56 net cc73bbab4b1f 708c10c4 .config console log report info [disk image] [vmlinux] [kernel image] ci-upstream-net-this-kasan-gce INFO: task hung in bpf_prog_pack_free
2024/07/05 01:54 net-next aa77b1128016 dc6bbff0 .config console log report info [disk image] [vmlinux] [kernel image] ci-upstream-net-kasan-gce INFO: task hung in bpf_prog_pack_free
* Struck through repros no longer work on HEAD.