BUG: workqueue lockup - pool cpus=0 node=0 flags=0x0 nice=0 stuck for 169s! INFO: task kworker/u4:2:35 blocked for more than 140 seconds. Showing busy workqueues and worker pools: workqueue events: flags=0x0 Not tainted 4.14.288-syzkaller #0 pwq 0: "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. kworker/u4:2 D26608 35 2 0x80000000 Workqueue: events_unbound fsnotify_connector_destroy_workfn cpus=0 node=0 flags=0x0 nice=0 active=26/256 refcnt=27 in-flight: 32282:rtc_timer_do_work pending: free_obj_work, sg_remove_sfp_usercontext, defense_work_handler, defense_work_handler, defense_work_handler, defense_work_handler, vmstat_shepherd , cache_reap, defense_work_handler, defense_work_handler, sg_remove_sfp_usercontext, sg_remove_sfp_usercontext, nfc_urelease_event_work, nfc_urelease_event_work Call Trace: , nfc_urelease_event_work context_switch kernel/sched/core.c:2811 [inline] __schedule+0x88b/0x1de0 kernel/sched/core.c:3387 , nfc_urelease_event_work, nfc_urelease_event_work, nfc_urelease_event_work, nfc_urelease_event_work, nfc_urelease_event_work, wait_rcu_exp_gp, macvlan_process_broadcast, macvlan_process_broadcast , macvlan_process_broadcast , macvlan_process_broadcast schedule+0x8d/0x1b0 kernel/sched/core.c:3431 workqueue events_long: flags=0x0 schedule_timeout+0x80a/0xe90 kernel/time/timer.c:1724 pwq 0: cpus=0 node=0 flags=0x0 nice=0 active=6/256 refcnt=7 pending: gc_worker, br_fdb_cleanup, br_fdb_cleanup, br_fdb_cleanup, br_fdb_cleanup, br_fdb_cleanup workqueue events_unbound: flags=0x2 pwq 4: do_wait_for_common kernel/sched/completion.c:91 [inline] __wait_for_common kernel/sched/completion.c:112 [inline] wait_for_common+0x272/0x430 kernel/sched/completion.c:123 cpus=0-1 flags=0x4 nice=0 active=4/512 refcnt=7 in-flight: 19148:fsnotify_mark_destroy_workfn fsnotify_mark_destroy_workfn, 35:fsnotify_connector_destroy_workfn fsnotify_connector_destroy_workfn workqueue events_freezable: flags=0x4 workqueue events_power_efficient: flags=0x80 pwq 2: cpus=1 node=0 flags=0x0 nice=0 active=1/256 refcnt=2 in-flight: 32431:sync_cmos_clock pwq 0: cpus=0 node=0 flags=0x0 nice=0 active=4/256 refcnt=5 pending: fb_flashcursor, process_srcu, neigh_periodic_work, neigh_periodic_work __synchronize_srcu+0x10a/0x1d0 kernel/rcu/srcutree.c:898 workqueue mm_percpu_wq: flags=0x8 pwq 0: cpus=0 node=0 flags=0x0 nice=0 active=1/256 refcnt=2 pending: vmstat_update pool 0: fsnotify_connector_destroy_workfn+0x49/0xa0 fs/notify/mark.c:156 cpus=0 node=0 flags=0x0 nice=0 hung=169s workers=3 idle: 3 25 pool 2: cpus=1 node=0 flags=0x0 nice=0 hung=0s workers=3 idle: 694 24 pool 4: cpus=0-1 flags=0x4 nice=0 hung=0s workers=7 idle: 23 19360 29630 9483 5 process_one_work+0x793/0x14a0 kernel/workqueue.c:2117 worker_thread+0x5cc/0xff0 kernel/workqueue.c:2251 kthread+0x30d/0x420 kernel/kthread.c:232 ret_from_fork+0x24/0x30 arch/x86/entry/entry_64.S:404 INFO: task kworker/u4:7:19148 blocked for more than 140 seconds. Not tainted 4.14.288-syzkaller #0 "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. kworker/u4:7 D27240 19148 2 0x80000000 Workqueue: events_unbound fsnotify_mark_destroy_workfn Call Trace: context_switch kernel/sched/core.c:2811 [inline] __schedule+0x88b/0x1de0 kernel/sched/core.c:3387 schedule+0x8d/0x1b0 kernel/sched/core.c:3431 schedule_timeout+0x80a/0xe90 kernel/time/timer.c:1724 do_wait_for_common kernel/sched/completion.c:91 [inline] __wait_for_common kernel/sched/completion.c:112 [inline] wait_for_common+0x272/0x430 kernel/sched/completion.c:123 __synchronize_srcu+0x10a/0x1d0 kernel/rcu/srcutree.c:898 fsnotify_mark_destroy_workfn+0xed/0x2e0 fs/notify/mark.c:757 process_one_work+0x793/0x14a0 kernel/workqueue.c:2117 worker_thread+0x5cc/0xff0 kernel/workqueue.c:2251 kthread+0x30d/0x420 kernel/kthread.c:232 ret_from_fork+0x24/0x30 arch/x86/entry/entry_64.S:404 INFO: task syz-executor.2:640 blocked for more than 140 seconds. Not tainted 4.14.288-syzkaller #0 "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. syz-executor.2 D28912 640 8009 0x00000004 Call Trace: context_switch kernel/sched/core.c:2811 [inline] __schedule+0x88b/0x1de0 kernel/sched/core.c:3387 schedule+0x8d/0x1b0 kernel/sched/core.c:3431 _synchronize_rcu_expedited+0x522/0x770 kernel/rcu/tree_exp.h:615 synchronize_rcu+0x98/0x130 kernel/rcu/tree_plugin.h:762 synchronize_net+0x3a/0x40 net/core/dev.c:8250 packet_release+0x740/0xa80 net/packet/af_packet.c:3117 __sock_release+0xcd/0x2b0 net/socket.c:602 sock_close+0x15/0x20 net/socket.c:1139 __fput+0x25f/0x7a0 fs/file_table.c:210 task_work_run+0x11f/0x190 kernel/task_work.c:113 tracehook_notify_resume include/linux/tracehook.h:191 [inline] exit_to_usermode_loop+0x1ad/0x200 arch/x86/entry/common.c:164 prepare_exit_to_usermode arch/x86/entry/common.c:199 [inline] syscall_return_slowpath arch/x86/entry/common.c:270 [inline] do_syscall_64+0x4a3/0x640 arch/x86/entry/common.c:297 entry_SYSCALL_64_after_hwframe+0x46/0xbb RIP: 0033:0x7f8e04ebfd4b RSP: 002b:00007ffd5531e400 EFLAGS: 00000293 ORIG_RAX: 0000000000000003 RAX: 0000000000000000 RBX: 0000000000000005 RCX: 00007f8e04ebfd4b RDX: 00007f8e05024870 RSI: ffffffffffffffff RDI: 0000000000000004 RBP: 00007f8e05021960 R08: 0000000000000000 R09: 00007f8e05024878 R10: 00007ffd5531e500 R11: 0000000000000293 R12: 00000000000871ce R13: 00007ffd5531e500 R14: 00007f8e0501ff60 R15: 0000000000000032 Showing all locks held in the system: 2 locks held by kworker/u4:2/35: #0: ("events_unbound"){+.+.}, at: [] process_one_work+0x6b0/0x14a0 kernel/workqueue.c:2088 #1: (connector_reaper_work){+.+.}, at: [] process_one_work+0x6e6/0x14a0 kernel/workqueue.c:2092 1 lock held by khungtaskd/1535: #0: (tasklist_lock){.+.+}, at: [] debug_show_all_locks+0x7c/0x21a kernel/locking/lockdep.c:4548 1 lock held by in:imklog/7655: #0: (&f->f_pos_lock){+.+.}, at: [] __fdget_pos+0x1fb/0x2b0 fs/file.c:819 2 locks held by kworker/u4:7/19148: #0: ("events_unbound"){+.+.}, at: [] process_one_work+0x6b0/0x14a0 kernel/workqueue.c:2088 #1: ((reaper_work).work){+.+.}, at: [] process_one_work+0x6e6/0x14a0 kernel/workqueue.c:2092 3 locks held by kworker/1:0/32431: #0: ("events_power_efficient"){+.+.}, at: [] process_one_work+0x6b0/0x14a0 kernel/workqueue.c:2088 #1: ((sync_cmos_work).work){+.+.}, at: [] process_one_work+0x6e6/0x14a0 kernel/workqueue.c:2092 #2: (&rtc->ops_lock){+.+.}, at: [] rtc_set_time drivers/rtc/interface.c:68 [inline] #2: (&rtc->ops_lock){+.+.}, at: [] rtc_set_time+0x55/0x380 drivers/rtc/interface.c:60 2 locks held by syz-executor.2/640: #0: (&sb->s_type->i_mutex_key#13){+.+.}, at: [] inode_lock include/linux/fs.h:719 [inline] #0: (&sb->s_type->i_mutex_key#13){+.+.}, at: [] __sock_release+0x86/0x2b0 net/socket.c:601 #1: (rcu_preempt_state.exp_mutex){+.+.}, at: [] exp_funnel_lock kernel/rcu/tree_exp.h:272 [inline] #1: (rcu_preempt_state.exp_mutex){+.+.}, at: [] _synchronize_rcu_expedited+0x2c2/0x770 kernel/rcu/tree_exp.h:596 ============================================= NMI backtrace for cpu 1 CPU: 1 PID: 1535 Comm: khungtaskd Not tainted 4.14.288-syzkaller #0 Hardware name: Google Google Compute Engine/Google Compute Engine, BIOS Google 06/29/2022 Call Trace: __dump_stack lib/dump_stack.c:17 [inline] dump_stack+0x1b2/0x281 lib/dump_stack.c:58 nmi_cpu_backtrace.cold+0x57/0x93 lib/nmi_backtrace.c:101 nmi_trigger_cpumask_backtrace+0x13a/0x180 lib/nmi_backtrace.c:62 trigger_all_cpu_backtrace include/linux/nmi.h:140 [inline] check_hung_uninterruptible_tasks kernel/hung_task.c:195 [inline] watchdog+0x5b9/0xb40 kernel/hung_task.c:274 kthread+0x30d/0x420 kernel/kthread.c:232 ret_from_fork+0x24/0x30 arch/x86/entry/entry_64.S:404 Sending NMI from CPU 1 to CPUs 0: NMI backtrace for cpu 0 CPU: 0 PID: 4621 Comm: systemd-journal Not tainted 4.14.288-syzkaller #0 Hardware name: Google Google Compute Engine/Google Compute Engine, BIOS Google 06/29/2022 task: ffff8880a1044080 task.stack: ffff8880a1048000 RIP: 0010:__get_fault_gfp_mask mm/memory.c:2464 [inline] RIP: 0010:__handle_mm_fault+0xe4/0x4620 mm/memory.c:4157 RSP: 0000:ffff8880a104fd20 EFLAGS: 00000246 RAX: dffffc0000000000 RBX: ffff8880a17bf568 RCX: 0000000000000000 RDX: 1ffff110142f6e47 RSI: 00007fd6f1df4000 RDI: ffff8880a17b7238 RBP: 1ffff11014209faa R08: ffff88823b328d10 R09: 0000000000000001 R10: 0000000000000000 R11: 0000000000000000 R12: 00007fd6f1df4000 R13: 00000000014000c0 R14: 0000000000000055 R15: ffff8880a17b7080 FS: 00007fd6f48ef8c0(0000) GS:ffff8880ba400000(0000) knlGS:0000000000000000 CS: 0010 DS: 0000 ES: 0000 CR0: 0000000080050033 CR2: 00007fd6f1df4000 CR3: 00000000a1786000 CR4: 00000000003406f0 DR0: 0000000000000000 DR1: 0000000000000000 DR2: 0000000000000000 DR3: 0000000000000000 DR6: 00000000fffe0ff0 DR7: 0000000000000400 Call Trace: handle_mm_fault+0x455/0x9c0 mm/memory.c:4266 __do_page_fault+0x549/0xad0 arch/x86/mm/fault.c:1442 page_fault+0x45/0x50 arch/x86/entry/entry_64.S:1123 RIP: 8e1911a0:0x7ffca1494e60 RSP: 0090:0000000000000000 EFLAGS: 55572d4dde80 Code: bd c0 00 40 01 4d 85 ff 74 61 e8 18 d4 df ff 49 8d bf b8 01 00 00 48 b8 00 00 00 00 00 fc ff df 48 89 fa 48 c1 ea 03 80 3c 02 00 <0f> 85 8e 2f 00 00 4d 8b af b8 01 00 00 48 b8 00 00 00 00 00 fc ---------------- Code disassembly (best guess): 0: bd c0 00 40 01 mov $0x14000c0,%ebp 5: 4d 85 ff test %r15,%r15 8: 74 61 je 0x6b a: e8 18 d4 df ff callq 0xffdfd427 f: 49 8d bf b8 01 00 00 lea 0x1b8(%r15),%rdi 16: 48 b8 00 00 00 00 00 movabs $0xdffffc0000000000,%rax 1d: fc ff df 20: 48 89 fa mov %rdi,%rdx 23: 48 c1 ea 03 shr $0x3,%rdx 27: 80 3c 02 00 cmpb $0x0,(%rdx,%rax,1) * 2b: 0f 85 8e 2f 00 00 jne 0x2fbf <-- trapping instruction 31: 4d 8b af b8 01 00 00 mov 0x1b8(%r15),%r13 38: 48 rex.W 39: b8 00 00 00 00 mov $0x0,%eax 3e: 00 fc add %bh,%ah