INFO: task kworker/u4:2:38 blocked for more than 143 seconds. Not tainted 5.7.0-rc1-next-20200415-syzkaller #0 "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. kworker/u4:2 D24792 38 2 0x80004000 Workqueue: events_unbound fsnotify_mark_destroy_workfn Call Trace: schedule+0xd0/0x2a0 kernel/sched/core.c:4163 schedule_timeout+0x55b/0x850 kernel/time/timer.c:1874 do_wait_for_common kernel/sched/completion.c:85 [inline] __wait_for_common kernel/sched/completion.c:106 [inline] wait_for_common kernel/sched/completion.c:117 [inline] wait_for_completion+0x16a/0x270 kernel/sched/completion.c:138 __synchronize_srcu+0x1a7/0x260 kernel/rcu/srcutree.c:922 fsnotify_mark_destroy_workfn+0xfd/0x330 fs/notify/mark.c:832 process_one_work+0x965/0x16a0 kernel/workqueue.c:2268 worker_thread+0x96/0xe20 kernel/workqueue.c:2414 kthread+0x388/0x470 kernel/kthread.c:268 ret_from_fork+0x24/0x30 arch/x86/entry/entry_64.S:352 INFO: task kworker/u4:1:20301 blocked for more than 143 seconds. Not tainted 5.7.0-rc1-next-20200415-syzkaller #0 "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. kworker/u4:1 D24792 20301 2 0x80004000 Workqueue: events_unbound fsnotify_connector_destroy_workfn Call Trace: schedule+0xd0/0x2a0 kernel/sched/core.c:4163 schedule_timeout+0x55b/0x850 kernel/time/timer.c:1874 do_wait_for_common kernel/sched/completion.c:85 [inline] __wait_for_common kernel/sched/completion.c:106 [inline] wait_for_common kernel/sched/completion.c:117 [inline] wait_for_completion+0x16a/0x270 kernel/sched/completion.c:138 __synchronize_srcu+0x1a7/0x260 kernel/rcu/srcutree.c:922 fsnotify_connector_destroy_workfn+0x49/0xa0 fs/notify/mark.c:164 process_one_work+0x965/0x16a0 kernel/workqueue.c:2268 worker_thread+0x96/0xe20 kernel/workqueue.c:2414 kthread+0x388/0x470 kernel/kthread.c:268 ret_from_fork+0x24/0x30 arch/x86/entry/entry_64.S:352 INFO: task syz-executor.2:3447 can't die for more than 144 seconds. syz-executor.2 D26568 3447 7328 0x00004004 Call Trace: schedule+0xd0/0x2a0 kernel/sched/core.c:4163 schedule_timeout+0x55b/0x850 kernel/time/timer.c:1874 do_wait_for_common kernel/sched/completion.c:85 [inline] __wait_for_common kernel/sched/completion.c:106 [inline] wait_for_common kernel/sched/completion.c:117 [inline] wait_for_completion+0x16a/0x270 kernel/sched/completion.c:138 __flush_work+0x4fd/0xa80 kernel/workqueue.c:3045 __cancel_work_timer+0x3a2/0x500 kernel/workqueue.c:3132 p9_conn_destroy net/9p/trans_fd.c:863 [inline] p9_fd_close+0x29c/0x520 net/9p/trans_fd.c:898 p9_client_create+0x99b/0x1440 net/9p/client.c:1069 v9fs_session_init+0x1e7/0x18c0 fs/9p/v9fs.c:406 v9fs_mount+0x79/0x970 fs/9p/vfs_super.c:124 legacy_get_tree+0x105/0x220 fs/fs_context.c:622 vfs_get_tree+0x89/0x2f0 fs/super.c:1547 do_new_mount fs/namespace.c:2813 [inline] do_mount+0x1306/0x1b30 fs/namespace.c:3138 __do_sys_mount fs/namespace.c:3347 [inline] __se_sys_mount fs/namespace.c:3324 [inline] __x64_sys_mount+0x18f/0x230 fs/namespace.c:3324 do_syscall_64+0xf6/0x7d0 arch/x86/entry/common.c:295 entry_SYSCALL_64_after_hwframe+0x49/0xb3 RIP: 0033:0x45ca29 Code: Bad RIP value. RSP: 002b:00007f0f47922c78 EFLAGS: 00000246 ORIG_RAX: 00000000000000a5 RAX: ffffffffffffffda RBX: 00000000004f62c0 RCX: 000000000045ca29 RDX: 0000000020000080 RSI: 0000000020000140 RDI: 0000000000000000 RBP: 000000000078bf00 R08: 0000000020000100 R09: 0000000000000000 R10: 0000000000000000 R11: 0000000000000246 R12: 00000000ffffffff R13: 0000000000000752 R14: 00000000004ca315 R15: 00007f0f479236d4 INFO: task syz-executor.2:3447 blocked for more than 144 seconds. Not tainted 5.7.0-rc1-next-20200415-syzkaller #0 "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. syz-executor.2 D26568 3447 7328 0x00004004 Call Trace: schedule+0xd0/0x2a0 kernel/sched/core.c:4163 schedule_timeout+0x55b/0x850 kernel/time/timer.c:1874 do_wait_for_common kernel/sched/completion.c:85 [inline] __wait_for_common kernel/sched/completion.c:106 [inline] wait_for_common kernel/sched/completion.c:117 [inline] wait_for_completion+0x16a/0x270 kernel/sched/completion.c:138 __flush_work+0x4fd/0xa80 kernel/workqueue.c:3045 __cancel_work_timer+0x3a2/0x500 kernel/workqueue.c:3132 p9_conn_destroy net/9p/trans_fd.c:863 [inline] p9_fd_close+0x29c/0x520 net/9p/trans_fd.c:898 p9_client_create+0x99b/0x1440 net/9p/client.c:1069 v9fs_session_init+0x1e7/0x18c0 fs/9p/v9fs.c:406 v9fs_mount+0x79/0x970 fs/9p/vfs_super.c:124 legacy_get_tree+0x105/0x220 fs/fs_context.c:622 vfs_get_tree+0x89/0x2f0 fs/super.c:1547 do_new_mount fs/namespace.c:2813 [inline] do_mount+0x1306/0x1b30 fs/namespace.c:3138 __do_sys_mount fs/namespace.c:3347 [inline] __se_sys_mount fs/namespace.c:3324 [inline] __x64_sys_mount+0x18f/0x230 fs/namespace.c:3324 do_syscall_64+0xf6/0x7d0 arch/x86/entry/common.c:295 entry_SYSCALL_64_after_hwframe+0x49/0xb3 RIP: 0033:0x45ca29 Code: Bad RIP value. RSP: 002b:00007f0f47922c78 EFLAGS: 00000246 ORIG_RAX: 00000000000000a5 RAX: ffffffffffffffda RBX: 00000000004f62c0 RCX: 000000000045ca29 RDX: 0000000020000080 RSI: 0000000020000140 RDI: 0000000000000000 RBP: 000000000078bf00 R08: 0000000020000100 R09: 0000000000000000 R10: 0000000000000000 R11: 0000000000000246 R12: 00000000ffffffff R13: 0000000000000752 R14: 00000000004ca315 R15: 00007f0f479236d4 INFO: task syz-executor.3:3458 can't die for more than 145 seconds. syz-executor.3 D28128 3458 7476 0x00000004 Call Trace: schedule+0xd0/0x2a0 kernel/sched/core.c:4163 synchronize_rcu_expedited+0x45a/0x620 kernel/rcu/tree_exp.h:872 synchronize_net+0x37/0x50 net/core/dev.c:9943 packet_release+0xb30/0xdd0 net/packet/af_packet.c:3060 __sock_release+0xcd/0x280 net/socket.c:605 sock_close+0x18/0x20 net/socket.c:1283 __fput+0x33e/0x880 fs/file_table.c:280 task_work_run+0xf4/0x1b0 kernel/task_work.c:123 tracehook_notify_resume include/linux/tracehook.h:188 [inline] exit_to_usermode_loop+0x2fa/0x360 arch/x86/entry/common.c:165 prepare_exit_to_usermode arch/x86/entry/common.c:196 [inline] syscall_return_slowpath arch/x86/entry/common.c:279 [inline] do_syscall_64+0x6b1/0x7d0 arch/x86/entry/common.c:305 entry_SYSCALL_64_after_hwframe+0x49/0xb3 RIP: 0033:0x416621 Code: Bad RIP value. RSP: 002b:00007ffe6983f9d0 EFLAGS: 00000293 ORIG_RAX: 0000000000000003 RAX: 0000000000000000 RBX: 0000000000000006 RCX: 0000000000416621 RDX: 0000000000000000 RSI: 00000000000011a9 RDI: 0000000000000005 RBP: 0000000000000001 R08: 00000000313b51a9 R09: 00000000313b51ad R10: 00007ffe6983fac0 R11: 0000000000000293 R12: 0000000000790460 R13: 0000000000100590 R14: ffffffffffffffff R15: 000000000078bf0c INFO: task syz-executor.3:3458 blocked for more than 146 seconds. Not tainted 5.7.0-rc1-next-20200415-syzkaller #0 "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. syz-executor.3 D28128 3458 7476 0x00000004 Call Trace: schedule+0xd0/0x2a0 kernel/sched/core.c:4163 synchronize_rcu_expedited+0x45a/0x620 kernel/rcu/tree_exp.h:872 synchronize_net+0x37/0x50 net/core/dev.c:9943 packet_release+0xb30/0xdd0 net/packet/af_packet.c:3060 __sock_release+0xcd/0x280 net/socket.c:605 sock_close+0x18/0x20 net/socket.c:1283 __fput+0x33e/0x880 fs/file_table.c:280 task_work_run+0xf4/0x1b0 kernel/task_work.c:123 tracehook_notify_resume include/linux/tracehook.h:188 [inline] exit_to_usermode_loop+0x2fa/0x360 arch/x86/entry/common.c:165 prepare_exit_to_usermode arch/x86/entry/common.c:196 [inline] syscall_return_slowpath arch/x86/entry/common.c:279 [inline] do_syscall_64+0x6b1/0x7d0 arch/x86/entry/common.c:305 entry_SYSCALL_64_after_hwframe+0x49/0xb3 RIP: 0033:0x416621 Code: Bad RIP value. RSP: 002b:00007ffe6983f9d0 EFLAGS: 00000293 ORIG_RAX: 0000000000000003 RAX: 0000000000000000 RBX: 0000000000000006 RCX: 0000000000416621 RDX: 0000000000000000 RSI: 00000000000011a9 RDI: 0000000000000005 RBP: 0000000000000001 R08: 00000000313b51a9 R09: 00000000313b51ad R10: 00007ffe6983fac0 R11: 0000000000000293 R12: 0000000000790460 R13: 0000000000100590 R14: ffffffffffffffff R15: 000000000078bf0c Showing all locks held in the system: 2 locks held by kworker/0:0/5: 2 locks held by kworker/u4:2/38: #0: ffff8880aa034138 ((wq_completion)events_unbound){+.+.}-{0:0}, at: __write_once_size include/linux/compiler.h:250 [inline] #0: ffff8880aa034138 ((wq_completion)events_unbound){+.+.}-{0:0}, at: arch_atomic64_set arch/x86/include/asm/atomic64_64.h:34 [inline] #0: ffff8880aa034138 ((wq_completion)events_unbound){+.+.}-{0:0}, at: atomic64_set include/asm-generic/atomic-instrumented.h:856 [inline] #0: ffff8880aa034138 ((wq_completion)events_unbound){+.+.}-{0:0}, at: atomic_long_set include/asm-generic/atomic-long.h:41 [inline] #0: ffff8880aa034138 ((wq_completion)events_unbound){+.+.}-{0:0}, at: set_work_data kernel/workqueue.c:615 [inline] #0: ffff8880aa034138 ((wq_completion)events_unbound){+.+.}-{0:0}, at: set_work_pool_and_clear_pending kernel/workqueue.c:642 [inline] #0: ffff8880aa034138 ((wq_completion)events_unbound){+.+.}-{0:0}, at: process_one_work+0x844/0x16a0 kernel/workqueue.c:2239 #1: ffffc90000ea7dc0 ((reaper_work).work){+.+.}-{0:0}, at: process_one_work+0x878/0x16a0 kernel/workqueue.c:2243 4 locks held by kworker/u4:5/1080: 1 lock held by khungtaskd/1168: #0: ffffffff899befc0 (rcu_read_lock){....}-{1:2}, at: debug_show_all_locks+0x53/0x260 kernel/locking/lockdep.c:5754 1 lock held by in:imklog/6807: #0: ffff8880a2b54130 (&f->f_pos_lock){+.+.}-{3:3}, at: __fdget_pos+0xe9/0x100 fs/file.c:826 1 lock held by syz-executor.2/18017: #0: ffffffff899c3020 (rcu_state.exp_mutex){+.+.}-{3:3}, at: exp_funnel_lock kernel/rcu/tree_exp.h:322 [inline] #0: ffffffff899c3020 (rcu_state.exp_mutex){+.+.}-{3:3}, at: synchronize_rcu_expedited+0x28d/0x620 kernel/rcu/tree_exp.h:856 2 locks held by kworker/u4:1/20301: #0: ffff8880aa034138 ((wq_completion)events_unbound){+.+.}-{0:0}, at: __write_once_size include/linux/compiler.h:250 [inline] #0: ffff8880aa034138 ((wq_completion)events_unbound){+.+.}-{0:0}, at: arch_atomic64_set arch/x86/include/asm/atomic64_64.h:34 [inline] #0: ffff8880aa034138 ((wq_completion)events_unbound){+.+.}-{0:0}, at: atomic64_set include/asm-generic/atomic-instrumented.h:856 [inline] #0: ffff8880aa034138 ((wq_completion)events_unbound){+.+.}-{0:0}, at: atomic_long_set include/asm-generic/atomic-long.h:41 [inline] #0: ffff8880aa034138 ((wq_completion)events_unbound){+.+.}-{0:0}, at: set_work_data kernel/workqueue.c:615 [inline] #0: ffff8880aa034138 ((wq_completion)events_unbound){+.+.}-{0:0}, at: set_work_pool_and_clear_pending kernel/workqueue.c:642 [inline] #0: ffff8880aa034138 ((wq_completion)events_unbound){+.+.}-{0:0}, at: process_one_work+0x844/0x16a0 kernel/workqueue.c:2239 #1: ffffc90008de7dc0 (connector_reaper_work){+.+.}-{0:0}, at: process_one_work+0x878/0x16a0 kernel/workqueue.c:2243 4 locks held by kworker/u4:7/28382: 2 locks held by syz-executor.3/3458: #0: ffff8880366df750 (&sb->s_type->i_mutex_key#14){+.+.}-{3:3}, at: inode_lock include/linux/fs.h:797 [inline] #0: ffff8880366df750 (&sb->s_type->i_mutex_key#14){+.+.}-{3:3}, at: __sock_release+0x86/0x280 net/socket.c:604 #1: ffffffff899c3020 (rcu_state.exp_mutex){+.+.}-{3:3}, at: exp_funnel_lock kernel/rcu/tree_exp.h:290 [inline] #1: ffffffff899c3020 (rcu_state.exp_mutex){+.+.}-{3:3}, at: synchronize_rcu_expedited+0x501/0x620 kernel/rcu/tree_exp.h:856 ============================================= NMI backtrace for cpu 0 CPU: 0 PID: 1168 Comm: khungtaskd Not tainted 5.7.0-rc1-next-20200415-syzkaller #0 Hardware name: Google Google Compute Engine/Google Compute Engine, BIOS Google 01/01/2011 Call Trace: __dump_stack lib/dump_stack.c:77 [inline] dump_stack+0x188/0x20d lib/dump_stack.c:118 nmi_cpu_backtrace.cold+0x70/0xb1 lib/nmi_backtrace.c:101 nmi_trigger_cpumask_backtrace+0x231/0x27e lib/nmi_backtrace.c:62 trigger_all_cpu_backtrace include/linux/nmi.h:147 [inline] check_hung_uninterruptible_tasks kernel/hung_task.c:249 [inline] watchdog+0xde3/0x14e0 kernel/hung_task.c:333 kthread+0x388/0x470 kernel/kthread.c:268 ret_from_fork+0x24/0x30 arch/x86/entry/entry_64.S:352 Sending NMI from CPU 0 to CPUs 1: NMI backtrace for cpu 1 CPU: 1 PID: 4171 Comm: systemd-journal Not tainted 5.7.0-rc1-next-20200415-syzkaller #0 Hardware name: Google Google Compute Engine/Google Compute Engine, BIOS Google 01/01/2011 RIP: 0010:check_kcov_mode kernel/kcov.c:163 [inline] RIP: 0010:__sanitizer_cov_trace_pc+0x10/0x60 kernel/kcov.c:197 Code: 1f 02 00 48 8b 80 f8 13 00 00 c3 0f 1f 44 00 00 66 2e 0f 1f 84 00 00 00 00 00 65 48 8b 04 25 00 1f 02 00 65 8b 15 28 ea 8e 7e c2 00 01 1f 00 48 8b 34 24 74 0f 80 e6 01 74 35 8b 90 04 14 00 RSP: 0018:ffffc9000561feb0 EFLAGS: 00000282 RAX: ffff88809328c500 RBX: 0000000000038780 RCX: ffffffff814c8d20 RDX: 0000000080000001 RSI: ffffffff814c8f86 RDI: 0000000000000001 RBP: ffff88809394e710 R08: ffff88809328c500 R09: ffffed1015ce710c R10: ffff8880ae73885b R11: ffffed1015ce710b R12: 000000000000104b R13: ffffffff8998fc40 R14: 0000000000000000 R15: 0000000000000000 FS: 00007fb7d55a48c0(0000) GS:ffff8880ae700000(0000) knlGS:0000000000000000 CS: 0010 DS: 0000 ES: 0000 CR0: 0000000080050033 CR2: 00007fb7d2ac1000 CR3: 0000000093484000 CR4: 00000000001406e0 DR0: 0000000000000000 DR1: 0000000000000000 DR2: 0000000000000000 DR3: 0000000000000000 DR6: 00000000fffe0ff0 DR7: 0000000000000400 Call Trace: check_preemption_disabled lib/smp_processor_id.c:14 [inline] debug_smp_processor_id+0x8/0x185 lib/smp_processor_id.c:57 rcu_dynticks_curr_cpu_in_eqs+0x12/0xb0 kernel/rcu/tree.c:300 rcu_is_watching+0xc/0x20 kernel/rcu/tree.c:929 rcu_read_unlock include/linux/rcupdate.h:651 [inline] __task_pid_nr_ns+0x40b/0x520 kernel/pid.c:481 task_tgid_vnr include/linux/sched.h:1406 [inline] __do_sys_getpid+0x1a/0x20 kernel/sys.c:894 do_syscall_64+0xf6/0x7d0 arch/x86/entry/common.c:295 entry_SYSCALL_64_after_hwframe+0x49/0xb3 RIP: 0033:0x7fb7d483df17 Code: ff ff ff 48 8b 4d a0 0f b7 51 fe 48 8b 4d a8 66 89 54 08 fe e9 1a ff ff ff 66 2e 0f 1f 84 00 00 00 00 00 b8 27 00 00 00 0f 05 0f 1f 84 00 00 00 00 00 b8 6e 00 00 00 0f 05 c3 0f 1f 84 00 00 RSP: 002b:00007fff1708fbd8 EFLAGS: 00000202 ORIG_RAX: 0000000000000027 RAX: ffffffffffffffda RBX: 0000562638f271e0 RCX: 00007fb7d483df17 RDX: 0000000000000000 RSI: 00000000485d0649 RDI: 0000562638f271e0 RBP: 000000000000104b R08: 00007fff170ed080 R09: 00000000000004be R10: 0000000000000000 R11: 0000000000000202 R12: ffffffffffffffff R13: 00007fff1708fc88 R14: 0000562638549958 R15: 0005a602186b734c