INFO: task kworker/u4:2:141 blocked for more than 143 seconds. Not tainted 5.4.0-rc7-next-20191115 #0 "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. kworker/u4:2 D24896 141 2 0x80004000 Workqueue: netns cleanup_net Call Trace: context_switch kernel/sched/core.c:3385 [inline] __schedule+0x8e1/0x1f30 kernel/sched/core.c:4081 schedule+0xdc/0x2b0 kernel/sched/core.c:4155 schedule_timeout+0x717/0xc50 kernel/time/timer.c:1871 do_wait_for_common kernel/sched/completion.c:83 [inline] __wait_for_common kernel/sched/completion.c:104 [inline] wait_for_common kernel/sched/completion.c:115 [inline] wait_for_completion+0x29c/0x440 kernel/sched/completion.c:136 __flush_work+0x4fe/0xa50 kernel/workqueue.c:3041 flush_work+0x18/0x20 kernel/workqueue.c:3062 flush_all_backlogs net/core/dev.c:5489 [inline] rollback_registered_many+0x60e/0x10d0 net/core/dev.c:8729 unregister_netdevice_many.part.0+0x1b/0x1f0 net/core/dev.c:9907 unregister_netdevice_many+0x3b/0x50 net/core/dev.c:9906 ip6gre_exit_batch_net+0x53c/0x760 net/ipv6/ip6_gre.c:1604 ops_exit_list.isra.0+0x10c/0x160 net/core/net_namespace.c:175 cleanup_net+0x538/0xaf0 net/core/net_namespace.c:597 process_one_work+0x9af/0x1740 kernel/workqueue.c:2264 worker_thread+0x98/0xe40 kernel/workqueue.c:2410 kthread+0x361/0x430 kernel/kthread.c:255 ret_from_fork+0x24/0x30 arch/x86/entry/entry_64.S:352 INFO: task syz-executor.1:9663 can't die for more than 143 seconds. syz-executor.1 D26008 9663 8805 0x00004004 Call Trace: context_switch kernel/sched/core.c:3385 [inline] __schedule+0x8e1/0x1f30 kernel/sched/core.c:4081 schedule+0xdc/0x2b0 kernel/sched/core.c:4155 schedule_preempt_disabled+0x13/0x20 kernel/sched/core.c:4214 __mutex_lock_common kernel/locking/mutex.c:1036 [inline] __mutex_lock+0x7ab/0x13c0 kernel/locking/mutex.c:1106 mutex_lock_nested+0x16/0x20 kernel/locking/mutex.c:1121 rtnl_lock+0x17/0x20 net/core/rtnetlink.c:72 ip_tunnel_init_net+0x35e/0x9e0 net/ipv4/ip_tunnel.c:1059 ipip_init_net+0x2a/0x30 net/ipv4/ipip.c:656 ops_init+0xb3/0x420 net/core/net_namespace.c:137 setup_net+0x2d5/0x8b0 net/core/net_namespace.c:335 copy_net_ns+0x29e/0x520 net/core/net_namespace.c:476 create_new_namespaces+0x400/0x7b0 kernel/nsproxy.c:103 unshare_nsproxy_namespaces+0xc2/0x200 kernel/nsproxy.c:202 ksys_unshare+0x444/0x980 kernel/fork.c:2945 __do_sys_unshare kernel/fork.c:3013 [inline] __se_sys_unshare kernel/fork.c:3011 [inline] __x64_sys_unshare+0x31/0x40 kernel/fork.c:3011 do_syscall_64+0xfa/0x790 arch/x86/entry/common.c:294 entry_SYSCALL_64_after_hwframe+0x49/0xbe RIP: 0033:0x45a639 Code: Bad RIP value. RSP: 002b:00007f202e8b7c78 EFLAGS: 00000246 ORIG_RAX: 0000000000000110 RAX: ffffffffffffffda RBX: 0000000000000001 RCX: 000000000045a639 RDX: 0000000000000000 RSI: 0000000000000000 RDI: 0000000040040400 RBP: 000000000075c268 R08: 0000000000000000 R09: 0000000000000000 R10: 0000000000000000 R11: 0000000000000246 R12: 00007f202e8b86d4 R13: 00000000004ca597 R14: 00000000004e2558 R15: 00000000ffffffff INFO: task syz-executor.1:9663 blocked for more than 144 seconds. Not tainted 5.4.0-rc7-next-20191115 #0 "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. syz-executor.1 D26008 9663 8805 0x00004004 Call Trace: context_switch kernel/sched/core.c:3385 [inline] __schedule+0x8e1/0x1f30 kernel/sched/core.c:4081 schedule+0xdc/0x2b0 kernel/sched/core.c:4155 schedule_preempt_disabled+0x13/0x20 kernel/sched/core.c:4214 __mutex_lock_common kernel/locking/mutex.c:1036 [inline] __mutex_lock+0x7ab/0x13c0 kernel/locking/mutex.c:1106 mutex_lock_nested+0x16/0x20 kernel/locking/mutex.c:1121 rtnl_lock+0x17/0x20 net/core/rtnetlink.c:72 ip_tunnel_init_net+0x35e/0x9e0 net/ipv4/ip_tunnel.c:1059 ipip_init_net+0x2a/0x30 net/ipv4/ipip.c:656 ops_init+0xb3/0x420 net/core/net_namespace.c:137 setup_net+0x2d5/0x8b0 net/core/net_namespace.c:335 copy_net_ns+0x29e/0x520 net/core/net_namespace.c:476 create_new_namespaces+0x400/0x7b0 kernel/nsproxy.c:103 unshare_nsproxy_namespaces+0xc2/0x200 kernel/nsproxy.c:202 ksys_unshare+0x444/0x980 kernel/fork.c:2945 __do_sys_unshare kernel/fork.c:3013 [inline] __se_sys_unshare kernel/fork.c:3011 [inline] __x64_sys_unshare+0x31/0x40 kernel/fork.c:3011 do_syscall_64+0xfa/0x790 arch/x86/entry/common.c:294 entry_SYSCALL_64_after_hwframe+0x49/0xbe RIP: 0033:0x45a639 Code: Bad RIP value. RSP: 002b:00007f202e8b7c78 EFLAGS: 00000246 ORIG_RAX: 0000000000000110 RAX: ffffffffffffffda RBX: 0000000000000001 RCX: 000000000045a639 RDX: 0000000000000000 RSI: 0000000000000000 RDI: 0000000040040400 RBP: 000000000075c268 R08: 0000000000000000 R09: 0000000000000000 R10: 0000000000000000 R11: 0000000000000246 R12: 00007f202e8b86d4 R13: 00000000004ca597 R14: 00000000004e2558 R15: 00000000ffffffff Showing all locks held in the system: 5 locks held by kworker/u4:2/141: #0: ffff8880a994ad28 ((wq_completion)netns){+.+.}, at: __write_once_size include/linux/compiler.h:226 [inline] #0: ffff8880a994ad28 ((wq_completion)netns){+.+.}, at: arch_atomic64_set arch/x86/include/asm/atomic64_64.h:34 [inline] #0: ffff8880a994ad28 ((wq_completion)netns){+.+.}, at: atomic64_set include/asm-generic/atomic-instrumented.h:855 [inline] #0: ffff8880a994ad28 ((wq_completion)netns){+.+.}, at: atomic_long_set include/asm-generic/atomic-long.h:40 [inline] #0: ffff8880a994ad28 ((wq_completion)netns){+.+.}, at: set_work_data kernel/workqueue.c:615 [inline] #0: ffff8880a994ad28 ((wq_completion)netns){+.+.}, at: set_work_pool_and_clear_pending kernel/workqueue.c:642 [inline] #0: ffff8880a994ad28 ((wq_completion)netns){+.+.}, at: process_one_work+0x88b/0x1740 kernel/workqueue.c:2235 #1: ffff8880a9017dc0 (net_cleanup_work){+.+.}, at: process_one_work+0x8c1/0x1740 kernel/workqueue.c:2239 #2: ffffffff899ae608 (pernet_ops_rwsem){++++}, at: cleanup_net+0xae/0xaf0 net/core/net_namespace.c:559 #3: ffffffff899ba940 (rtnl_mutex){+.+.}, at: rtnl_lock+0x17/0x20 net/core/rtnetlink.c:72 #4: ffffffff88f62f50 (cpu_hotplug_lock.rw_sem){++++}, at: get_online_cpus include/linux/cpu.h:137 [inline] #4: ffffffff88f62f50 (cpu_hotplug_lock.rw_sem){++++}, at: flush_all_backlogs net/core/dev.c:5482 [inline] #4: ffffffff88f62f50 (cpu_hotplug_lock.rw_sem){++++}, at: rollback_registered_many+0x4e3/0x10d0 net/core/dev.c:8729 1 lock held by khungtaskd/1083: #0: ffffffff88faccc0 (rcu_read_lock){....}, at: debug_show_all_locks+0x5f/0x279 kernel/locking/lockdep.c:5334 1 lock held by rsyslogd/8675: #0: ffff88809846dde0 (&f->f_pos_lock){+.+.}, at: __fdget_pos+0xee/0x110 fs/file.c:801 2 locks held by getty/8764: #0: ffff8880a80d4090 (&tty->ldisc_sem){++++}, at: ldsem_down_read+0x33/0x40 drivers/tty/tty_ldsem.c:340 #1: ffffc90005f192e0 (&ldata->atomic_read_lock){+.+.}, at: n_tty_read+0x220/0x1bf0 drivers/tty/n_tty.c:2156 2 locks held by getty/8765: #0: ffff8880a4e09090 (&tty->ldisc_sem){++++}, at: ldsem_down_read+0x33/0x40 drivers/tty/tty_ldsem.c:340 #1: ffffc90005f2d2e0 (&ldata->atomic_read_lock){+.+.}, at: n_tty_read+0x220/0x1bf0 drivers/tty/n_tty.c:2156 2 locks held by getty/8766: #0: ffff888097b07090 (&tty->ldisc_sem){++++}, at: ldsem_down_read+0x33/0x40 drivers/tty/tty_ldsem.c:340 #1: ffffc90005f252e0 (&ldata->atomic_read_lock){+.+.}, at: n_tty_read+0x220/0x1bf0 drivers/tty/n_tty.c:2156 2 locks held by getty/8767: #0: ffff8880a53ad090 (&tty->ldisc_sem){++++}, at: ldsem_down_read+0x33/0x40 drivers/tty/tty_ldsem.c:340 #1: ffffc90005f212e0 (&ldata->atomic_read_lock){+.+.}, at: n_tty_read+0x220/0x1bf0 drivers/tty/n_tty.c:2156 2 locks held by getty/8768: #0: ffff8880a3b88090 (&tty->ldisc_sem){++++}, at: ldsem_down_read+0x33/0x40 drivers/tty/tty_ldsem.c:340 #1: ffffc90005f292e0 (&ldata->atomic_read_lock){+.+.}, at: n_tty_read+0x220/0x1bf0 drivers/tty/n_tty.c:2156 2 locks held by getty/8769: #0: ffff88809a20e090 (&tty->ldisc_sem){++++}, at: ldsem_down_read+0x33/0x40 drivers/tty/tty_ldsem.c:340 #1: ffffc90005f312e0 (&ldata->atomic_read_lock){+.+.}, at: n_tty_read+0x220/0x1bf0 drivers/tty/n_tty.c:2156 2 locks held by getty/8770: #0: ffff8880a8cbe090 (&tty->ldisc_sem){++++}, at: ldsem_down_read+0x33/0x40 drivers/tty/tty_ldsem.c:340 #1: ffffc90005ef92e0 (&ldata->atomic_read_lock){+.+.}, at: n_tty_read+0x220/0x1bf0 drivers/tty/n_tty.c:2156 2 locks held by syz-executor.1/9663: #0: ffffffff899ae608 (pernet_ops_rwsem){++++}, at: copy_net_ns+0x27b/0x520 net/core/net_namespace.c:472 #1: ffffffff899ba940 (rtnl_mutex){+.+.}, at: rtnl_lock+0x17/0x20 net/core/rtnetlink.c:72 1 lock held by syz-executor.2/9674: #0: ffffffff899ba940 (rtnl_mutex){+.+.}, at: rtnl_lock+0x17/0x20 net/core/rtnetlink.c:72 1 lock held by syz-executor.2/9693: #0: ffffffff899ba940 (rtnl_mutex){+.+.}, at: rtnl_lock+0x17/0x20 net/core/rtnetlink.c:72 1 lock held by syz-executor.3/9689: #0: ffffffff899ba940 (rtnl_mutex){+.+.}, at: rtnl_lock+0x17/0x20 net/core/rtnetlink.c:72 1 lock held by syz-executor.0/9704: #0: ffffffff899ba940 (rtnl_mutex){+.+.}, at: rtnl_lock+0x17/0x20 net/core/rtnetlink.c:72 1 lock held by syz-executor.0/9705: #0: ffffffff899ae608 (pernet_ops_rwsem){++++}, at: register_netdevice_notifier+0x25/0x290 net/core/dev.c:1724 1 lock held by syz-executor.0/9707: #0: ffffffff899ae608 (pernet_ops_rwsem){++++}, at: register_netdevice_notifier+0x25/0x290 net/core/dev.c:1724 ============================================= NMI backtrace for cpu 0 CPU: 0 PID: 1083 Comm: khungtaskd Not tainted 5.4.0-rc7-next-20191115 #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+0x197/0x210 lib/dump_stack.c:118 nmi_cpu_backtrace.cold+0x70/0xb2 lib/nmi_backtrace.c:101 nmi_trigger_cpumask_backtrace+0x23b/0x28b lib/nmi_backtrace.c:62 arch_trigger_cpumask_backtrace+0x14/0x20 arch/x86/kernel/apic/hw_nmi.c:38 trigger_all_cpu_backtrace include/linux/nmi.h:146 [inline] check_hung_uninterruptible_tasks kernel/hung_task.c:269 [inline] watchdog+0xc8f/0x1350 kernel/hung_task.c:353 kthread+0x361/0x430 kernel/kthread.c:255 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: 9645 Comm: syz-executor.1 Not tainted 5.4.0-rc7-next-20191115 #0 Hardware name: Google Google Compute Engine/Google Compute Engine, BIOS Google 01/01/2011 RIP: 0010:__sanitizer_cov_trace_pc+0x0/0x50 kernel/kcov.c:180 Code: ff cc cc cc cc cc cc cc cc cc 65 48 8b 04 25 c0 1e 02 00 48 8b 80 18 13 00 00 c3 0f 1f 44 00 00 66 2e 0f 1f 84 00 00 00 00 00 <55> 48 89 e5 65 48 8b 04 25 c0 1e 02 00 65 8b 15 34 45 8e 7e 81 e2 RSP: 0018:ffff888056c9f850 EFLAGS: 00000293 RAX: ffff88805afa0240 RBX: 0000000000000002 RCX: ffffffff817e51f6 RDX: 0000000000000000 RSI: ffffffff817e51c1 RDI: 0000000000000005 RBP: ffff888056c9f878 R08: ffff88805afa0240 R09: ffffed1014848082 R10: ffffed1014848081 R11: ffff8880a424040b R12: ffff8880a4240408 R13: 0000000000000003 R14: ffffed1014848081 R15: ffff888056c9f918 FS: 00007f202e91b700(0000) GS:ffff8880ae900000(0000) knlGS:0000000000000000 CS: 0010 DS: 0000 ES: 0000 CR0: 0000000080050033 CR2: 0000000000000000 CR3: 00000000a8336000 CR4: 00000000001406e0 DR0: 0000000000000000 DR1: 0000000000000000 DR2: 0000000000000000 DR3: 0000000000000000 DR6: 00000000fffe0ff0 DR7: 0000000000000600 Call Trace: _free_event+0x89/0x13b0 kernel/events/core.c:4584 put_event+0x47/0x60 kernel/events/core.c:4709 perf_event_release_kernel+0x6d5/0xd70 kernel/events/core.c:4824 perf_release+0x37/0x50 kernel/events/core.c:4834 __fput+0x2ff/0x890 fs/file_table.c:280 ____fput+0x16/0x20 fs/file_table.c:313 task_work_run+0x145/0x1c0 kernel/task_work.c:113 exit_task_work include/linux/task_work.h:22 [inline] do_exit+0x904/0x2e60 kernel/exit.c:817 do_group_exit+0x135/0x360 kernel/exit.c:921 get_signal+0x47c/0x24f0 kernel/signal.c:2734 do_signal+0x87/0x1700 arch/x86/kernel/signal.c:815 exit_to_usermode_loop+0x286/0x380 arch/x86/entry/common.c:160 prepare_exit_to_usermode arch/x86/entry/common.c:195 [inline] syscall_return_slowpath arch/x86/entry/common.c:278 [inline] do_syscall_64+0x676/0x790 arch/x86/entry/common.c:304 entry_SYSCALL_64_after_hwframe+0x49/0xbe RIP: 0033:0x45a639 Code: ad b6 fb ff c3 66 2e 0f 1f 84 00 00 00 00 00 66 90 48 89 f8 48 89 f7 48 89 d6 48 89 ca 4d 89 c2 4d 89 c8 4c 8b 4c 24 08 0f 05 <48> 3d 01 f0 ff ff 0f 83 7b b6 fb ff c3 66 2e 0f 1f 84 00 00 00 00 RSP: 002b:00007f202e91acf8 EFLAGS: 00000246 ORIG_RAX: 00000000000000ca RAX: fffffffffffffe00 RBX: 000000000075c078 RCX: 000000000045a639 RDX: 0000000000000000 RSI: 0000000000000080 RDI: 000000000075c078 RBP: 000000000075c070 R08: 0000000000000000 R09: 0000000000000000 R10: 0000000000000000 R11: 0000000000000246 R12: 000000000075c07c R13: 00007fff6029153f R14: 00007f202e91b9c0 R15: 000000000075c07c