[ 10.188186][ T212] gre: GRE over IPv4 demultiplexer driver [ 10.188201][ T212] BUG: sleeping function called from invalid context at ./include/linux/sched/mm.h:322 [ 10.188203][ T212] in_atomic(): 1, irqs_disabled(): 1, non_block: 0, pid: 212, name: modprobe [ 10.188204][ T212] preempt_count: 1, expected: 0 [ 10.188205][ T212] RCU nest depth: 0, expected: 0 [ 10.188206][ T212] locks held by modprobe/212: 4, last CPU#0: [ 10.188208][ T212] #0: ffffffffb497ddc0 (console_lock){+.+.}-{0:0}, at: vprintk_emit+0x320/0x3e0 [ 10.188219][ T212] #1: ffffffffb497de38 (console_srcu){....}-{0:0}, at: console_flush_one_record+0x106/0x710 [ 10.188224][ T212] #2: ffffffffb489d760 (console_owner){....}-{0:0}, at: console_lock_spinning_enable+0x40/0x60 [ 10.188229][ T212] #3: ffffffffb489d660 (printk_legacy_map-wait-type-override){....}-{3:3}, at: console_emit_next_record+0x1df/0x4c0 [ 10.188233][ T212] irq event stamp: 18024 [ 10.188234][ T212] hardirqs last enabled at (18023): [] __down_trylock_console_sem+0x86/0xa0 [ 10.188236][ T212] hardirqs last disabled at (18024): [] console_emit_next_record+0x3d4/0x4c0 [ 10.188238][ T212] softirqs last enabled at (16818): [] handle_softirqs+0x67c/0x900 [ 10.188242][ T212] softirqs last disabled at (15965): [] __irq_exit_rcu+0x145/0x1c0 [ 10.188244][ T212] Preemption disabled at: [ 10.188245][ T212] [] vprintk_emit+0x31b/0x3e0 [ 10.188250][ T212] CPU: 0 UID: 0 PID: 212 Comm: modprobe Tainted: G W 7.2.0-virtme #1 PREEMPT(full) [ 10.188253][ T212] Tainted: [W]=WARN [ 10.188254][ T212] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 10.188256][ T212] Call Trace: [ 10.188258][ T212] [ 10.188259][ T212] dump_stack_lvl+0x6f/0xa0 [ 10.188265][ T212] ? vprintk_emit+0x31b/0x3e0 [ 10.188266][ T212] __might_resched.cold+0x1fe/0x2c1 [ 10.188271][ T212] ? perf_trace_sched_switch+0x7c0/0x7c0 [ 10.188275][ T212] ? __kmalloc_noprof+0xdb/0x760 [ 10.188279][ T212] __kmalloc_noprof+0x443/0x760 [ 10.188281][ T212] ? alloc_buf.isra.0+0x4b/0x260 [ 10.188288][ T212] ? do_raw_spin_unlock+0x59/0x250 [ 10.188291][ T212] alloc_buf.isra.0+0x4b/0x260 [ 10.188294][ T212] put_chars+0x1e1/0x2f0 [ 10.188296][ T212] ? desc_read_finalized_seq+0x79/0x120 [ 10.188298][ T212] ? __send_to_port+0x420/0x420 [ 10.188301][ T212] ? rcu_read_lock_any_held+0x3c/0x90 [ 10.188304][ T212] ? validate_chain+0x38b/0xc20 [ 10.188309][ T212] hvc_console_print+0x292/0x780 [ 10.188313][ T212] ? __lock_acquire+0x518/0xc20 [ 10.188315][ T212] ? __lock_acquire+0x518/0xc20 [ 10.188320][ T212] ? hvc_write+0x3a0/0x3a0 [ 10.188321][ T212] ? console_emit_next_record+0x1df/0x4c0 [ 10.188325][ T212] ? rcu_is_watching+0x16/0xd0 [ 10.188327][ T212] ? lock_acquire+0x13c/0x160 [ 10.188331][ T212] console_emit_next_record+0x22f/0x4c0 [ 10.188335][ T212] ? devkmsg_read+0x4b0/0x4b0 [ 10.188337][ T212] ? console_flush_one_record+0x106/0x710 [ 10.188340][ T212] ? rcu_is_watching+0x16/0xd0 [ 10.188342][ T212] ? lock_acquire+0x13c/0x160 [ 10.188346][ T212] console_flush_one_record+0x46f/0x710 [ 10.188350][ T212] ? console_emit_next_record+0x4c0/0x4c0 [ 10.188352][ T212] ? __lock_acquire+0x518/0xc20 [ 10.188357][ T212] console_unlock+0xee/0x1f0 [ 10.188360][ T212] ? console_flush_one_record+0x710/0x710 [ 10.188362][ T212] ? rcu_is_watching+0x16/0xd0 [ 10.188364][ T212] ? lock_acquire+0xe0/0x160 [ 10.188368][ T212] ? __down_trylock_console_sem+0x5e/0xa0 [ 10.188369][ T212] ? vprintk_emit+0x320/0x3e0 [ 10.188372][ T212] vprintk_emit+0x37c/0x3e0 [ 10.188375][ T212] ? wake_up_klogd_work_func+0x90/0x90 [ 10.188380][ T212] ? gre_exit+0x3f0/0x3f0 [gre] [ 10.188383][ T212] _printk+0xc7/0x100 [ 10.188387][ T212] ? snapshot_read.cold+0x21/0x21 [ 10.188393][ T212] ? do_one_initcall+0x113/0x4f0 [ 10.188396][ T212] gre_init+0x15/0x1000 [gre] [ 10.188398][ T212] do_one_initcall+0x124/0x4f0 [ 10.188401][ T212] ? trace_event_raw_event_initcall_level+0x280/0x280 [ 10.188406][ T212] ? do_init_module+0xae/0x8a0 [ 10.188408][ T212] ? kasan_unpoison+0x44/0x70 [ 10.188414][ T212] do_init_module+0x2ad/0x8a0 [ 10.188417][ T212] ? lockdep_hardirqs_on+0x91/0x130 [ 10.188421][ T212] ? free_module+0x470/0x470 [ 10.188423][ T212] ? kfree+0x123/0x590 [ 10.188427][ T212] load_module+0x1424/0x1bb0 [ 10.188432][ T212] ? security_kernel_post_read_file+0x2f/0x60 [ 10.188437][ T212] ? layout_and_allocate.isra.0+0x680/0x680 [ 10.188441][ T212] ? backing_file_read_iter+0x541/0x790 [ 10.188445][ T212] ? rcu_lockdep_current_cpu_online+0x3f/0x1b0 [ 10.188449][ T212] init_module_from_file+0x11f/0x1a0 [ 10.188451][ T212] ? __do_sys_init_module+0x270/0x270 [ 10.188458][ T212] ? __rwlock_init+0x150/0x150 [ 10.188462][ T212] ? do_raw_spin_unlock+0x59/0x250 [ 10.188465][ T212] idempotent_init_module+0x37b/0x7c0 [ 10.188468][ T212] ? init_module_from_file+0x1a0/0x1a0 [ 10.188473][ T212] ? cap_capable+0x1d7/0x3d0 [ 10.188476][ T212] ? __x64_sys_pread64+0x18d/0x250 [ 10.188481][ T212] __x64_sys_finit_module+0xdf/0x190 [ 10.188482][ T212] ? trace_irq_enable.constprop.0+0x9b/0x160 [ 10.188486][ T212] do_syscall_64+0xff/0x530 [ 10.188489][ T212] ? exc_page_fault+0xee/0x100 [ 10.188492][ T212] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 10.188494][ T212] RIP: 0033:0x7fc2ab45037d [ 10.188497][ T212] Code: ff c3 66 2e 0f 1f 84 00 00 00 00 00 90 f3 0f 1e fa 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 73 01 c3 48 8b 0d 4b aa 0f 00 f7 d8 64 89 01 48 [ 10.188498][ T212] RSP: 002b:00007ffe975d73d8 EFLAGS: 00000246 ORIG_RAX: 0000000000000139 [ 10.188501][ T212] RAX: ffffffffffffffda RBX: 000056052e2d1a20 RCX: 00007fc2ab45037d [ 10.188502][ T212] RDX: 0000000000000000 RSI: 000056050912fffd RDI: 0000000000000000 [ 10.188503][ T212] RBP: 00007ffe975d7470 R08: 0000000000000000 R09: 0000000000000000 [ 10.188504][ T212] R10: 0000000000000000 R11: 0000000000000246 R12: 000056050912fffd [ 10.188505][ T212] R13: 000056052e2d19e0 R14: 0000000000040000 R15: 0000000000000000 [ 10.188511][ T212] [ 10.220114][ T212] ip6_gre: GRE over IPv6 tunneling driver [ 10.285984][ T9] ip6_tunnel: er6 xmit: Local address not yet configured! [ 10.286046][ T9] [ 10.286047][ T9] ============================= [ 10.286048][ T9] WARNING: suspicious RCU usage [ 10.286050][ T9] 7.2.0-virtme #1 Tainted: G W [ 10.286051][ T9] ----------------------------- [ 10.286052][ T9] kernel/sched/core.c:9196 Illegal context switch in RCU-bh read-side critical section! [ 10.286054][ T9] [ 10.286054][ T9] other info that might help us debug this: [ 10.286054][ T9] [ 10.286054][ T9] [ 10.286054][ T9] rcu_scheduler_active = 2, debug_locks = 1 [ 10.286055][ T9] locks held by kworker/0:0/9: 13, last CPU#0: [ 10.286057][ T9] #0: ff11000009398940 ((wq_completion)mld){+.+.}-{0:0}, at: process_one_work+0xd9a/0x1560 [ 10.286070][ T9] #1: ffa0000000097d10 ((work_completion)(&(&idev->mc_ifc_work)->work)){+.+.}-{0:0}, at: process_one_work+0xdfc/0x1560 [ 10.286074][ T9] #2: ff1100000ada8d30 (&idev->mc_lock){+.+.}-{4:4}, at: mld_ifc_work+0x2e/0x190 [ 10.286079][ T9] #3: ffffffffb4994c00 (rcu_read_lock){....}-{1:3}, at: mld_sendpack+0x1c9/0xec0 [ 10.286082][ T9] #4: ffffffffb4994c00 (rcu_read_lock){....}-{1:3}, at: ip6_output+0x11d/0x7f0 [ 10.286087][ T9] #5: ffffffffb4994ba0 (rcu_read_lock_bh){....}-{1:3}, at: __dev_queue_xmit+0x204/0x1b90 [ 10.286092][ T9] #6: ff11000009f1d228 (dev->qdisc_tx_busylock ?: &qdisc_tx_busylock){+...}-{3:3}, at: __dev_xmit_skb+0xcb8/0x1be0 [ 10.286096][ T9] #7: ff1100000dd86918 (&qdisc_xmit_lock_key#2){+...}-{3:3}, at: sch_direct_xmit+0x2e5/0x1100 [ 10.286101][ T9] #8: ffffffffb4994c00 (rcu_read_lock){....}-{1:3}, at: ip6_tnl_xmit_ctl+0xfd/0x390 [ 10.286106][ T9] #9: ffffffffb497ddc0 (console_lock){+.+.}-{0:0}, at: vprintk_emit+0x320/0x3e0 [ 10.286110][ T9] #10: ffffffffb497de38 (console_srcu){....}-{0:0}, at: console_flush_one_record+0x106/0x710 [ 10.286114][ T9] #11: ffffffffb489d760 (console_owner){....}-{0:0}, at: console_lock_spinning_enable+0x40/0x60 [ 10.286118][ T9] #12: ffffffffb489d660 (printk_legacy_map-wait-type-override){....}-{3:3}, at: console_emit_next_record+0x1df/0x4c0 [ 10.286121][ T9] [ 10.286121][ T9] stack backtrace: [ 10.286124][ T9] CPU: 0 UID: 0 PID: 9 Comm: kworker/0:0 Tainted: G W 7.2.0-virtme #1 PREEMPT(full) [ 10.286127][ T9] Tainted: [W]=WARN [ 10.286128][ T9] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 10.286130][ T9] Workqueue: mld mld_ifc_work [ 10.286133][ T9] Call Trace: [ 10.286134][ T9] [ 10.286136][ T9] dump_stack_lvl+0x6f/0xa0 [ 10.286142][ T9] lockdep_rcu_suspicious.cold+0x37/0x8a [ 10.286148][ T9] __might_resched+0x2ac/0x390 [ 10.286152][ T9] ? perf_trace_sched_switch+0x7c0/0x7c0 [ 10.286155][ T9] ? __kmalloc_noprof+0xdb/0x760 [ 10.286160][ T9] __kmalloc_noprof+0x443/0x760 [ 10.286162][ T9] ? alloc_buf.isra.0+0x4b/0x260 [ 10.286169][ T9] ? do_raw_spin_unlock+0x59/0x250 [ 10.286172][ T9] alloc_buf.isra.0+0x4b/0x260 [ 10.286176][ T9] put_chars+0x1e1/0x2f0 [ 10.286178][ T9] ? __send_to_port+0x420/0x420 [ 10.286182][ T9] ? validate_chain+0x34a/0xc20 [ 10.286187][ T9] hvc_console_print+0x292/0x780 [ 10.286192][ T9] ? __lock_acquire+0x518/0xc20 [ 10.286197][ T9] ? hvc_write+0x3a0/0x3a0 [ 10.286200][ T9] ? rcu_is_watching+0x16/0xd0 [ 10.286206][ T9] console_emit_next_record+0x22f/0x4c0 [ 10.286210][ T9] ? devkmsg_read+0x4b0/0x4b0 [ 10.286212][ T9] ? console_flush_one_record+0x106/0x710 [ 10.286216][ T9] ? rcu_is_watching+0x16/0xd0 [ 10.286218][ T9] ? lock_acquire+0x13c/0x160 [ 10.286222][ T9] console_flush_one_record+0x46f/0x710 [ 10.286226][ T9] ? console_emit_next_record+0x4c0/0x4c0 [ 10.286228][ T9] ? __lock_acquire+0x518/0xc20 [ 10.286234][ T9] console_unlock+0xee/0x1f0 [ 10.286237][ T9] ? console_flush_one_record+0x710/0x710 [ 10.286239][ T9] ? rcu_is_watching+0x16/0xd0 [ 10.286241][ T9] ? lock_acquire+0xe0/0x160 [ 10.286245][ T9] ? __down_trylock_console_sem+0x5e/0xa0 [ 10.286247][ T9] ? vprintk_emit+0x320/0x3e0 [ 10.286250][ T9] vprintk_emit+0x37c/0x3e0 [ 10.286253][ T9] ? wake_up_klogd_work_func+0x90/0x90 [ 10.286256][ T9] ? __lock_release.isra.0+0x69/0x1a0 [ 10.286261][ T9] _printk+0xc7/0x100 [ 10.286264][ T9] ? snapshot_read.cold+0x21/0x21 [ 10.286266][ T9] ? ___ratelimit+0x4e7/0xa00 [ 10.286272][ T9] ? idr_get_free+0x830/0x830 [ 10.286277][ T9] ip6_tnl_xmit_ctl.cold+0x75/0x7a [ 10.286282][ T9] ip6erspan_tunnel_xmit+0x2cf/0x2db4 [ip6_gre] [ 10.286291][ T9] ? ip6gre_tunnel_siocdevprivate+0x1a70/0x1a70 [ip6_gre] [ 10.286295][ T9] ? validate_chain+0x34a/0xc20 [ 10.286306][ T9] dev_hard_start_xmit+0xf4/0x620 [ 10.286312][ T9] sch_direct_xmit+0x25b/0x1100 [ 10.286315][ T9] ? lock_acquire.part.0+0xd4/0x280 [ 10.286318][ T9] ? dequeue_skb+0x1db0/0x1db0 [ 10.286320][ T9] ? __rcu_read_lock+0x70/0x70 [ 10.286321][ T9] ? rcu_lockdep_current_cpu_online+0x3f/0x1b0 [ 10.286323][ T9] ? lock_acquire+0x13c/0x160 [ 10.286328][ T9] __dev_xmit_skb+0xecc/0x1be0 [ 10.286333][ T9] ? alloc_netdev_dummy+0x30/0x30 [ 10.286335][ T9] ? __dev_queue_xmit+0x204/0x1b90 [ 10.286338][ T9] ? rcu_is_watching+0x16/0xd0 [ 10.286340][ T9] ? lock_acquire+0x13c/0x160 [ 10.286344][ T9] __dev_queue_xmit+0x952/0x1b90 [ 10.286347][ T9] ? __lock_acquire+0x518/0xc20 [ 10.286352][ T9] ? lock_acquire.part.0+0xd4/0x280 [ 10.286354][ T9] ? find_held_lock+0x2b/0x80 [ 10.286356][ T9] ? netdev_core_pick_tx+0x2c0/0x2c0 [ 10.286368][ T9] ip6_finish_output2+0x48d/0x13f0 [ 10.286374][ T9] ? ip6_dst_lookup+0x80/0x80 [ 10.286376][ T9] ? find_held_lock+0x2b/0x80 [ 10.286378][ T9] ? __lock_release.isra.0+0x69/0x1a0 [ 10.286382][ T9] ? ip6_mtu+0x174/0x410 [ 10.286387][ T9] ip6_finish_output+0x701/0xe80 [ 10.286392][ T9] ip6_output+0x23f/0x7f0 [ 10.286395][ T9] ? ip6_finish_output+0xe80/0xe80 [ 10.286397][ T9] ? __lock_release.isra.0+0x69/0x1a0 [ 10.286399][ T9] ? xfrm_bundle_lookup.constprop.0+0xba0/0xba0 [ 10.286402][ T9] ? mark_held_locks+0x40/0x70 [ 10.286405][ T9] ? __local_bh_enable_ip+0xaa/0x150 [ 10.286408][ T9] ? __local_bh_enable_ip+0xaa/0x150 [ 10.286410][ T9] ? icmp6_dst_alloc+0x317/0x4d0 [ 10.286414][ T9] mld_sendpack+0x9d6/0xec0 [ 10.286419][ T9] ? mld_dad_start_work+0x240/0x240 [ 10.286425][ T9] ? mld_send_cr+0x50f/0x820 [ 10.286429][ T9] mld_ifc_work+0x36/0x190 [ 10.286431][ T9] ? process_one_work+0xdfc/0x1560 [ 10.286433][ T9] process_one_work+0xe3e/0x1560 [ 10.286440][ T9] ? __queue_delayed_work+0x470/0x470 [ 10.286443][ T9] ? lock_acquire.part.0+0xd4/0x280 [ 10.286451][ T9] worker_thread+0x4f1/0xd60 [ 10.286459][ T9] ? rescuer_thread+0x1340/0x1340 [ 10.286461][ T9] kthread+0x367/0x460 [ 10.286463][ T9] ? trace_irq_enable.constprop.0+0x9b/0x160 [ 10.286467][ T9] ? kthread_affine_preferred+0x4c0/0x4c0 [ 10.286470][ T9] ret_from_fork+0x474/0x6b0 [ 10.286474][ T9] ? arch_exit_to_user_mode_prepare.isra.0+0x120/0x120 [ 10.286478][ T9] ? __switch_to+0x5a3/0xe00 [ 10.286481][ T9] ? kthread_affine_preferred+0x4c0/0x4c0 [ 10.286484][ T9] ret_from_fork_asm+0x11/0x20 [ 10.286493][ T9] [ 10.368873][ T217] ip6_tunnel: gt6 xmit: Local address not yet configured! [ 10.397820][ T217] ip6_tunnel: er6 xmit: Local address not yet configured! [ 10.901914][ T12] ip6_tunnel: er6 xmit: Local address not yet configured! [ 11.029815][ T217] ip6_tunnel: gt6 xmit: Local address not yet configured! [ 11.476814][ T224] Mirror/redirect action on [ 11.476824][ T224] BUG: sleeping function called from invalid context at ./include/linux/sched/mm.h:322 [ 11.476827][ T224] in_atomic(): 1, irqs_disabled(): 1, non_block: 0, pid: 224, name: modprobe [ 11.476828][ T224] preempt_count: 1, expected: 0 [ 11.476829][ T224] RCU nest depth: 0, expected: 0 [ 11.476830][ T224] locks held by modprobe/224: 4, last CPU#3: [ 11.476832][ T224] #0: ffffffffb497ddc0 (console_lock){+.+.}-{0:0}, at: vprintk_emit+0x320/0x3e0 [ 11.476844][ T224] #1: ffffffffb497de38 (console_srcu){....}-{0:0}, at: console_flush_one_record+0x106/0x710 [ 11.476849][ T224] #2: ffffffffb489d760 (console_owner){....}-{0:0}, at: console_lock_spinning_enable+0x40/0x60 [ 11.476854][ T224] #3: ffffffffb489d660 (printk_legacy_map-wait-type-override){....}-{3:3}, at: console_emit_next_record+0x1df/0x4c0 [ 11.476860][ T224] irq event stamp: 28148 [ 11.476861][ T224] hardirqs last enabled at (28147): [] __down_trylock_console_sem+0x86/0xa0 [ 11.476864][ T224] hardirqs last disabled at (28148): [] console_emit_next_record+0x3d4/0x4c0 [ 11.476866][ T224] softirqs last enabled at (26880): [] handle_softirqs+0x67c/0x900 [ 11.476870][ T224] softirqs last disabled at (26875): [] __irq_exit_rcu+0x145/0x1c0 [ 11.476872][ T224] Preemption disabled at: [ 11.476873][ T224] [] vprintk_emit+0x31b/0x3e0 [ 11.476878][ T224] CPU: 3 UID: 0 PID: 224 Comm: modprobe Tainted: G W 7.2.0-virtme #1 PREEMPT(full) [ 11.476881][ T224] Tainted: [W]=WARN [ 11.476882][ T224] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 11.476884][ T224] Call Trace: [ 11.476886][ T224] [ 11.476887][ T224] dump_stack_lvl+0x6f/0xa0 [ 11.476893][ T224] ? vprintk_emit+0x31b/0x3e0 [ 11.476895][ T224] __might_resched.cold+0x1fe/0x2c1 [ 11.476899][ T224] ? perf_trace_sched_switch+0x7c0/0x7c0 [ 11.476904][ T224] ? __kmalloc_noprof+0xdb/0x760 [ 11.476908][ T224] __kmalloc_noprof+0x443/0x760 [ 11.476910][ T224] ? alloc_buf.isra.0+0x4b/0x260 [ 11.476917][ T224] ? do_raw_spin_unlock+0x59/0x250 [ 11.476919][ T224] alloc_buf.isra.0+0x4b/0x260 [ 11.476923][ T224] put_chars+0x1e1/0x2f0 [ 11.476925][ T224] ? __send_to_port+0x420/0x420 [ 11.476927][ T224] ? rcu_lockdep_current_cpu_online+0x3f/0x1b0 [ 11.476930][ T224] ? rcu_read_lock_any_held+0x3c/0x90 [ 11.476933][ T224] ? validate_chain+0x38b/0xc20 [ 11.476938][ T224] hvc_console_print+0x292/0x780 [ 11.476942][ T224] ? __lock_acquire+0x518/0xc20 [ 11.476947][ T224] ? hvc_write+0x3a0/0x3a0 [ 11.476950][ T224] ? rcu_is_watching+0x16/0xd0 [ 11.476955][ T224] console_emit_next_record+0x22f/0x4c0 [ 11.476958][ T224] ? devkmsg_read+0x4b0/0x4b0 [ 11.476960][ T224] ? console_flush_one_record+0x106/0x710 [ 11.476963][ T224] ? rcu_is_watching+0x16/0xd0 [ 11.476965][ T224] ? lock_acquire+0x13c/0x160 [ 11.476969][ T224] console_flush_one_record+0x46f/0x710 [ 11.476973][ T224] ? console_emit_next_record+0x4c0/0x4c0 [ 11.476975][ T224] ? __lock_acquire+0x518/0xc20 [ 11.476980][ T224] console_unlock+0xee/0x1f0 [ 11.476983][ T224] ? console_flush_one_record+0x710/0x710 [ 11.476985][ T224] ? rcu_is_watching+0x16/0xd0 [ 11.476986][ T224] ? lock_acquire+0xe0/0x160 [ 11.476990][ T224] ? __down_trylock_console_sem+0x5e/0xa0 [ 11.476992][ T224] ? vprintk_emit+0x320/0x3e0 [ 11.476994][ T224] vprintk_emit+0x37c/0x3e0 [ 11.476998][ T224] ? wake_up_klogd_work_func+0x90/0x90 [ 11.477000][ T224] ? netdev_run_todo+0x2a8/0xfd0 [ 11.477008][ T224] ? mirred_device_event+0x3d/0x1d0 [act_mirred] [ 11.477013][ T224] ? mirred_cleanup_module+0x7f0/0x7f0 [act_mirred] [ 11.477015][ T224] _printk+0xc7/0x100 [ 11.477019][ T224] ? snapshot_read.cold+0x21/0x21 [ 11.477021][ T224] ? __lock_release.isra.0+0x69/0x1a0 [ 11.477024][ T224] ? mirred_cleanup_module+0x7f0/0x7f0 [act_mirred] [ 11.477025][ T224] ? __up_write+0x23d/0x5f0 [ 11.477027][ T224] ? __up_write+0x2e5/0x5f0 [ 11.477031][ T224] ? __up_write+0x2c7/0x5f0 [ 11.477033][ T224] mirred_init_module+0x28/0x1000 [act_mirred] [ 11.477036][ T224] do_one_initcall+0x124/0x4f0 [ 11.477039][ T224] ? trace_event_raw_event_initcall_level+0x280/0x280 [ 11.477044][ T224] ? do_init_module+0xae/0x8a0 [ 11.477046][ T224] ? kasan_unpoison+0x44/0x70 [ 11.477052][ T224] do_init_module+0x2ad/0x8a0 [ 11.477055][ T224] ? lockdep_hardirqs_on+0x91/0x130 [ 11.477059][ T224] ? free_module+0x470/0x470 [ 11.477061][ T224] ? kfree+0x123/0x590 [ 11.477065][ T224] load_module+0x1424/0x1bb0 [ 11.477070][ T224] ? security_kernel_post_read_file+0x2f/0x60 [ 11.477075][ T224] ? layout_and_allocate.isra.0+0x680/0x680 [ 11.477078][ T224] ? __ia32_sys_fsconfig+0x180/0x180 [ 11.477082][ T224] ? find_held_lock+0x2b/0x80 [ 11.477085][ T224] ? rcu_lockdep_current_cpu_online+0x3f/0x1b0 [ 11.477088][ T224] init_module_from_file+0x11f/0x1a0 [ 11.477091][ T224] ? __do_sys_init_module+0x270/0x270 [ 11.477098][ T224] ? __rwlock_init+0x150/0x150 [ 11.477102][ T224] ? do_raw_spin_unlock+0x59/0x250 [ 11.477105][ T224] idempotent_init_module+0x37b/0x7c0 [ 11.477108][ T224] ? init_module_from_file+0x1a0/0x1a0 [ 11.477113][ T224] ? cap_capable+0x1d7/0x3d0 [ 11.477115][ T224] ? exc_page_fault+0x87/0x100 [ 11.477120][ T224] __x64_sys_finit_module+0xdf/0x190 [ 11.477122][ T224] ? trace_irq_enable.constprop.0+0x9b/0x160 [ 11.477125][ T224] do_syscall_64+0xff/0x530 [ 11.477128][ T224] ? exc_page_fault+0xee/0x100 [ 11.477131][ T224] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 11.477133][ T224] RIP: 0033:0x7f7ed4eba37d [ 11.477137][ T224] Code: ff c3 66 2e 0f 1f 84 00 00 00 00 00 90 f3 0f 1e fa 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 73 01 c3 48 8b 0d 4b aa 0f 00 f7 d8 64 89 01 48 [ 11.477138][ T224] RSP: 002b:00007ffffcb3ac58 EFLAGS: 00000246 ORIG_RAX: 0000000000000139 [ 11.477141][ T224] RAX: ffffffffffffffda RBX: 00005586e644d810 RCX: 00007f7ed4eba37d [ 11.477142][ T224] RDX: 0000000000000000 RSI: 00005586c2148ffd RDI: 0000000000000000 [ 11.477143][ T224] RBP: 00007ffffcb3acf0 R08: 0000000000000000 R09: 0000000000000000 [ 11.477144][ T224] R10: 0000000000000000 R11: 0000000000000246 R12: 00005586c2148ffd [ 11.477145][ T224] R13: 00005586e644d960 R14: 0000000000040000 R15: 0000000000000000 [ 11.477152][ T224] [ 14.627296][ C3] [ 14.627311][ C3] BUG: sleeping function called from invalid context at ./include/linux/sched/mm.h:322 [ 14.627314][ C3] in_atomic(): 1, irqs_disabled(): 1, non_block: 0, pid: 228, name: ping [ 14.627315][ C3] preempt_count: 305, expected: 0 [ 14.627316][ C3] RCU nest depth: 3, expected: 0 [ 14.627317][ C3] INFO: lockdep is turned off. [ 14.627318][ C3] irq event stamp: 21410 [ 14.627319][ C3] hardirqs last enabled at (21410): [] _raw_spin_unlock_irqrestore+0x53/0x80 [ 14.627328][ C3] hardirqs last disabled at (21409): [] _raw_spin_lock_irqsave+0x50/0x60 [ 14.627330][ C3] softirqs last enabled at (21398): [] __neigh_event_send+0x305/0x1070 [ 14.627334][ C3] softirqs last disabled at (21399): [] do_softirq+0xac/0xe0 [ 14.627338][ C3] Preemption disabled at: [ 14.627339][ C3] [<0000000000000000>] 0x0 [ 14.627345][ C3] CPU: 3 UID: 0 PID: 228 Comm: ping Tainted: G W 7.2.0-virtme #1 PREEMPT(full) [ 14.627349][ C3] Tainted: [W]=WARN [ 14.627350][ C3] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 14.627352][ C3] Call Trace: [ 14.627353][ C3] [ 14.627355][ C3] dump_stack_lvl+0x6f/0xa0 [ 14.627361][ C3] __might_resched.cold+0x1fe/0x2c1 [ 14.627365][ C3] ? perf_trace_sched_switch+0x7c0/0x7c0 [ 14.627369][ C3] ? rcu_is_watching+0x16/0xd0 [ 14.627372][ C3] __kmalloc_noprof+0x443/0x760 [ 14.627374][ C3] ? __rwlock_init+0x150/0x150 [ 14.627377][ C3] ? alloc_buf.isra.0+0x4b/0x260 [ 14.627382][ C3] ? do_raw_spin_unlock+0x59/0x250 [ 14.627384][ C3] alloc_buf.isra.0+0x4b/0x260 [ 14.627386][ C3] put_chars+0x1e1/0x2f0 [ 14.627388][ C3] ? __send_to_port+0x420/0x420 [ 14.627389][ C3] ? printk_get_next_message+0x240/0x650 [ 14.627392][ C3] ? console_prepend_replay+0x20/0x20 [ 14.627394][ C3] hvc_console_print+0x292/0x780 [ 14.627399][ C3] ? hvc_write+0x3a0/0x3a0 [ 14.627401][ C3] ? __rwlock_init+0x150/0x150 [ 14.627403][ C3] ? rcu_is_watching+0x16/0xd0 [ 14.627404][ C3] ? rcu_is_watching+0x16/0xd0 [ 14.627405][ C3] ? lock_acquire+0x13c/0x160 [ 14.627408][ C3] console_emit_next_record+0x22f/0x4c0 [ 14.627410][ C3] ? devkmsg_read+0x4b0/0x4b0 [ 14.627413][ C3] ? rcu_is_watching+0x16/0xd0 [ 14.627414][ C3] ? rcu_is_watching+0x16/0xd0 [ 14.627415][ C3] ? lock_acquire+0x13c/0x160 [ 14.627417][ C3] ? console_flush_one_record+0x111/0x710 [ 14.627418][ C3] console_flush_one_record+0x46f/0x710 [ 14.627421][ C3] ? console_emit_next_record+0x4c0/0x4c0 [ 14.627424][ C3] console_unlock+0xee/0x1f0 [ 14.627425][ C3] ? lock_acquire+0x13c/0x160 [ 14.627427][ C3] ? console_flush_one_record+0x710/0x710 [ 14.627429][ C3] ? rcu_is_watching+0x16/0xd0 [ 14.627430][ C3] ? lock_release+0x184/0x1f0 [ 14.627431][ C3] ? lock_acquire+0xe0/0x160 [ 14.627433][ C3] ? __down_trylock_console_sem+0x5e/0xa0 [ 14.627435][ C3] ? vprintk_emit+0x320/0x3e0 [ 14.627437][ C3] vprintk_emit+0x37c/0x3e0 [ 14.627439][ C3] ? wake_up_klogd_work_func+0x90/0x90 [ 14.627440][ C3] ? rcu_is_watching+0x16/0xd0 [ 14.627441][ C3] ? lock_release+0x184/0x1f0 [ 14.627443][ C3] _printk+0xc7/0x100 [ 14.627446][ C3] ? snapshot_read.cold+0x21/0x21 [ 14.627448][ C3] ? arch_stack_walk+0xed/0x130 [ 14.627451][ C3] ? rcu_lockdep_current_cpu_online+0x3f/0x1b0 [ 14.627453][ C3] ? nbcon_cpu_emergency_enter+0x28/0x80 [ 14.627455][ C3] print_irq_inversion_bug.part.0+0x32/0xc0 [ 14.627457][ C3] mark_lock_irq+0x989/0x9c0 [ 14.627460][ C3] mark_lock+0x1d7/0xa00 [ 14.627462][ C3] mark_usage+0x42/0x170 [ 14.627464][ C3] __lock_acquire+0x388/0xc20 [ 14.627465][ C3] ? skb_network_protocol+0x3b0/0x3b0 [ 14.627468][ C3] ? lock_pin_lock+0x87/0x180 [ 14.627470][ C3] lock_acquire.part.0+0xd4/0x280 [ 14.627472][ C3] ? sch_direct_xmit+0x2e5/0x1100 [ 14.627475][ C3] ? rcu_is_watching+0x16/0xd0 [ 14.627476][ C3] ? lock_acquire+0x13c/0x160 [ 14.627478][ C3] _raw_spin_lock+0x33/0x40 [ 14.627479][ C3] ? sch_direct_xmit+0x2e5/0x1100 [ 14.627480][ C3] sch_direct_xmit+0x2e5/0x1100 [ 14.627482][ C3] ? lock_acquire.part.0+0xd4/0x280 [ 14.627484][ C3] ? dequeue_skb+0x1db0/0x1db0 [ 14.627485][ C3] ? __rcu_read_lock+0x70/0x70 [ 14.627486][ C3] ? tcf_mirred_act+0x618/0xe10 [act_mirred] [ 14.627489][ C3] ? lock_acquire+0x13c/0x160 [ 14.627492][ C3] __dev_xmit_skb+0xecc/0x1be0 [ 14.627494][ C3] ? alloc_netdev_dummy+0x30/0x30 [ 14.627496][ C3] ? __dev_queue_xmit+0x204/0x1b90 [ 14.627498][ C3] ? rcu_is_watching+0x16/0xd0 [ 14.627499][ C3] ? lock_acquire+0x13c/0x160 [ 14.627501][ C3] __dev_queue_xmit+0x952/0x1b90 [ 14.627503][ C3] ? find_held_lock+0x2b/0x80 [ 14.627505][ C3] ? __lock_release.isra.0+0x69/0x1a0 [ 14.627506][ C3] ? tcf_classify+0x67/0x90 [ 14.627509][ C3] ? netdev_core_pick_tx+0x2c0/0x2c0 [ 14.627511][ C3] ? lockdep_hardirqs_on+0x91/0x130 [ 14.627513][ C3] ? _raw_spin_unlock_irqrestore+0x40/0x80 [ 14.627515][ C3] ? __copy_skb_header+0xb7/0x510 [ 14.627518][ C3] ? __asan_memcpy+0x3c/0x60 [ 14.627521][ C3] ? __skb_clone+0x55e/0x760 [ 14.627523][ C3] tcf_mirred_to_dev+0x941/0x1500 [act_mirred] [ 14.627525][ C3] ? __lock_acquire+0x518/0xc20 [ 14.627528][ C3] tcf_mirred_act+0x618/0xe10 [act_mirred] [ 14.627529][ C3] ? __lock_acquire+0x518/0xc20 [ 14.627531][ C3] ? lock_pin_lock+0x87/0x180 [ 14.627533][ C3] tcf_action_exec.part.0+0xca/0x3c0 [ 14.627535][ C3] __tcf_classify.constprop.0+0xcf/0x3a0 [ 14.627538][ C3] tcf_classify+0x67/0x90 [ 14.627540][ C3] ? tcf_qevent_handle+0x3d0/0x3d0 [ 14.627542][ C3] ? __lock_release.isra.0+0x69/0x1a0 [ 14.627543][ C3] ? rcu_lockdep_current_cpu_online+0x3f/0x1b0 [ 14.627545][ C3] tc_run+0x3d0/0x7e0 [ 14.627547][ C3] ? rcu_do_batch+0x2b6/0x1000 [ 14.627549][ C3] ? netdev_offload_xstats_push_delta+0x430/0x430 [ 14.627550][ C3] ? unwind_get_return_address+0x67/0xd0 [ 14.627554][ C3] __netif_receive_skb_core.constprop.0+0xdb7/0x2bb0 [ 14.627557][ C3] ? rcu_read_lock_any_held+0x66/0x90 [ 14.627560][ C3] ? do_xdp_generic+0x4a0/0x4a0 [ 14.627561][ C3] ? rcu_do_batch+0x2b6/0x1000 [ 14.627563][ C3] ? kasan_save_stack+0x3d/0x50 [ 14.627564][ C3] ? kasan_save_stack+0x2f/0x50 [ 14.627565][ C3] ? kasan_save_free_info+0x3b/0x60 [ 14.627567][ C3] ? kmem_cache_free+0xf8/0x550 [ 14.627568][ C3] ? rcu_core+0x34e/0x8e0 [ 14.627570][ C3] ? handle_softirqs+0x1d3/0x900 [ 14.627571][ C3] ? __irq_exit_rcu+0x145/0x1c0 [ 14.627573][ C3] ? sysvec_apic_timer_interrupt+0x9d/0xe0 [ 14.627574][ C3] ? rcu_lockdep_current_cpu_online+0x3f/0x1b0 [ 14.627576][ C3] ? mark_usage+0x61/0x170 [ 14.627578][ C3] ? __lock_acquire+0x518/0xc20 [ 14.627580][ C3] ? irq_matrix_free+0x487/0x600 [ 14.627583][ C3] ? process_backlog+0x3f1/0x14c0 [ 14.627584][ C3] __netif_receive_skb_one_core+0xa2/0x180 [ 14.627586][ C3] ? lock_acquire.part.0+0xd4/0x280 [ 14.627588][ C3] ? process_backlog+0x3f1/0x14c0 [ 14.627590][ C3] ? __netif_receive_skb_list_core+0x9e0/0x9e0 [ 14.627591][ C3] ? rcu_is_watching+0x16/0xd0 [ 14.627593][ C3] process_backlog+0x431/0x14c0 [ 14.627596][ C3] __napi_poll+0xa7/0x3b0 [ 14.627598][ C3] net_rx_action+0x513/0xf50 [ 14.627601][ C3] ? __napi_poll+0x3b0/0x3b0 [ 14.627603][ C3] ? __lock_release.isra.0+0x69/0x1a0 [ 14.627604][ C3] ? mark_held_locks+0x40/0x70 [ 14.627607][ C3] ? clockevents_program_event+0x307/0x7e0 [ 14.627611][ C3] ? mark_held_locks+0x40/0x70 [ 14.627612][ C3] ? rcu_is_watching+0x16/0xd0 [ 14.627613][ C3] ? mark_held_locks+0x40/0x70 [ 14.627615][ C3] handle_softirqs+0x1d3/0x900 [ 14.627617][ C3] ? _local_bh_enable+0xc0/0xc0 [ 14.627619][ C3] ? _local_bh_enable+0xc0/0xc0 [ 14.627621][ C3] do_softirq+0xac/0xe0 [ 14.627622][ C3] [ 14.627623][ C3] [ 14.627624][ C3] __local_bh_enable_ip+0x118/0x150 [ 14.627625][ C3] __neigh_event_send+0x30a/0x1070 [ 14.627627][ C3] ? ip_finish_output2+0x1d1/0x1c60 [ 14.627630][ C3] ? rcu_is_watching+0x16/0xd0 [ 14.627631][ C3] neigh_resolve_output+0xbe/0x140 [ 14.627633][ C3] ip_finish_output2+0x684/0x1c60 [ 14.627635][ C3] ? ip_dst_mtu_maybe_forward+0x2c7/0x720 [ 14.627636][ C3] ? lock_acquire.part.0+0xd4/0x280 [ 14.627638][ C3] ? ip_fragment.constprop.0+0x2c0/0x2c0 [ 14.627640][ C3] ? rcu_is_watching+0x16/0xd0 [ 14.627641][ C3] ip_output+0x1ca/0x660 [ 14.627643][ C3] ? ip_finish_output+0x460/0x460 [ 14.627644][ C3] ? __ip_make_skb+0x106a/0x2300 [ 14.627647][ C3] ip_push_pending_frames+0xf6/0x250 [ 14.627649][ C3] raw_sendmsg+0x1179/0x1cd0 [ 14.627652][ C3] ? raw_send_hdrinc+0x1740/0x1740 [ 14.627654][ C3] ? __might_fault+0x97/0x140 [ 14.627656][ C3] ? _copy_to_user+0x4b/0x70 [ 14.627660][ C3] ? validate_chain+0x38b/0xc20 [ 14.627662][ C3] ? import_iovec+0x4e/0xa0 [ 14.627664][ C3] ? __lock_acquire+0x518/0xc20 [ 14.627666][ C3] ? lock_acquire.part.0+0xd4/0x280 [ 14.627669][ C3] ? __lock_release.isra.0+0x69/0x1a0 [ 14.627671][ C3] __sock_sendmsg+0xce/0x190 [ 14.627673][ C3] ? fdget+0x4f/0x1e0 [ 14.627676][ C3] __sys_sendto+0x260/0x320 [ 14.627678][ C3] ? __ia32_sys_getpeername+0xd0/0xd0 [ 14.627683][ C3] __x64_sys_sendto+0xe4/0x1f0 [ 14.627685][ C3] ? trace_irq_enable.constprop.0+0x9b/0x160 [ 14.627688][ C3] ? lockdep_hardirqs_on+0x91/0x130 [ 14.627689][ C3] ? do_syscall_64+0xa6/0x530 [ 14.627692][ C3] do_syscall_64+0xff/0x530 [ 14.627693][ C3] ? exc_page_fault+0xee/0x100 [ 14.627695][ C3] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 14.627697][ C3] RIP: 0033:0x7feeac08c54e [ 14.627699][ C3] Code: 4d 89 d8 e8 b4 bd 00 00 4c 8b 5d f8 41 8b 93 08 03 00 00 59 5e 48 83 f8 fc 74 11 c9 c3 0f 1f 80 00 00 00 00 48 8b 45 10 0f 05 c3 83 e2 39 83 fa 08 75 e7 e8 03 ff ff ff 0f 1f 00 f3 0f 1e fa [ 14.627701][ C3] RSP: 002b:00007fff06c22580 EFLAGS: 00000202 ORIG_RAX: 000000000000002c [ 14.627705][ C3] RAX: ffffffffffffffda RBX: 0000000000000040 RCX: 00007feeac08c54e [ 14.627706][ C3] RDX: 0000000000000040 RSI: 00005573ab0790a4 RDI: 0000000000000005 [ 14.627707][ C3] RBP: 00007fff06c22590 R08: 00005573ab08b320 R09: 0000000000000010 [ 14.627708][ C3] R10: 0000000000000000 R11: 0000000000000202 R12: 431bde82d7b634db [ 14.627709][ C3] R13: 0000000000000000 R14: 00005573ab08c3e0 R15: 00005573ab0790a0 [ 14.627711][ C3] [ 14.666054][ C3] ======================================================== [ 14.666353][ C3] WARNING: possible irq lock inversion dependency detected [ 14.666597][ C3] 7.2.0-virtme #1 Tainted: G W [ 14.666859][ C3] -------------------------------------------------------- [ 14.667166][ C3] ping/228 just changed the state of lock: [ 14.667365][ C3] ff1100000dd86918 (&qdisc_xmit_lock_key#2){+.-.}-{3:3}, at: sch_direct_xmit+0x2e5/0x1100 [ 14.667713][ C3] but this lock took another, SOFTIRQ-unsafe lock in the past: [ 14.668021][ C3] (fs_reclaim){+.+.}-{0:0} [ 14.668023][ C3] [ 14.668023][ C3] [ 14.668023][ C3] and interrupts could create inverse lock ordering between them. [ 14.668023][ C3] [ 14.668736][ C3] [ 14.668736][ C3] other info that might help us debug this: [ 14.669043][ C3] Chain exists of: [ 14.669043][ C3] &qdisc_xmit_lock_key#2 --> console_owner --> fs_reclaim [ 14.669043][ C3] [ 14.669521][ C3] Possible interrupt unsafe locking scenario: [ 14.669521][ C3] [ 14.669761][ C3] CPU0 CPU1 [ 14.669926][ C3] ---- ---- [ 14.670157][ C3] lock(fs_reclaim); [ 14.670281][ C3] local_irq_disable(); [ 14.670544][ C3] lock(&qdisc_xmit_lock_key#2); [ 14.670790][ C3] lock(console_owner); [ 14.671059][ C3] [ 14.671184][ C3] lock(&qdisc_xmit_lock_key#2); [ 14.671408][ C3] [ 14.671408][ C3] *** DEADLOCK *** [ 14.671408][ C3] [ 14.671705][ C3] locks held by ping/228: 6, last CPU#3: [ 14.671870][ C3] #0: ff11000005baea90 (sk_lock-AF_INET){+.+.}-{0:0}, at: raw_sendmsg+0xbb5/0x1cd0 [ 14.672219][ C3] #1: ffffffffb4994c00 (rcu_read_lock){....}-{1:3}, at: ip_output+0xa9/0x660 [ 14.672561][ C3] #2: ffffffffb4994c00 (rcu_read_lock){....}-{1:3}, at: ip_finish_output2+0x2c6/0x1c60 [ 14.672839][ C3] #3: ffffffffb4994c00 (rcu_read_lock){....}-{1:3}, at: process_backlog+0x3f1/0x14c0 [ 14.673190][ C3] #4: ffffffffb4994ba0 (rcu_read_lock_bh){....}-{1:3}, at: __dev_queue_xmit+0x204/0x1b90 [ 14.673470][ C3] #5: ff11000009f1d228 (dev->qdisc_tx_busylock ?: &qdisc_tx_busylock){+...}-{3:3}, at: __dev_xmit_skb+0xcb8/0x1be0 [ 14.673956][ C3] [ 14.673956][ C3] the shortest dependencies between 2nd lock and 1st lock: [ 14.674244][ C3] -> (fs_reclaim){+.+.}-{0:0} { [ 14.674473][ C3] HARDIRQ-ON-W at: [ 14.674601][ C3] __lock_acquire+0x388/0xc20 [ 14.674874][ C3] lock_acquire.part.0+0xd4/0x280 [ 14.675142][ C3] fs_reclaim_acquire+0xd5/0x120 [ 14.675350][ C3] __kmalloc_cache_noprof+0x6e/0x620 [ 14.675663][ C3] kthread_create_worker_on_node+0xea/0x210 [ 14.675968][ C3] workqueue_init+0x2a/0x680 [ 14.676183][ C3] kernel_init_freeable+0x2fe/0x630 [ 14.676486][ C3] kernel_init+0x21/0x150 [ 14.676749][ C3] ret_from_fork+0x474/0x6b0 [ 14.676962][ C3] ret_from_fork_asm+0x11/0x20 [ 14.677231][ C3] SOFTIRQ-ON-W at: [ 14.677350][ C3] __lock_acquire+0x388/0xc20 [ 14.677611][ C3] lock_acquire.part.0+0xd4/0x280 [ 14.677885][ C3] fs_reclaim_acquire+0xd5/0x120 [ 14.678100][ C3] __kmalloc_cache_noprof+0x6e/0x620 [ 14.678405][ C3] kthread_create_worker_on_node+0xea/0x210 [ 14.678708][ C3] workqueue_init+0x2a/0x680 [ 14.678908][ C3] kernel_init_freeable+0x2fe/0x630 [ 14.679217][ C3] kernel_init+0x21/0x150 [ 14.679483][ C3] ret_from_fork+0x474/0x6b0 [ 14.679685][ C3] ret_from_fork_asm+0x11/0x20 [ 14.679891][ C3] INITIAL USE at: [ 14.680019][ C3] __lock_acquire+0x388/0xc20 [ 14.680281][ C3] lock_acquire.part.0+0xd4/0x280 [ 14.680540][ C3] fs_reclaim_acquire+0xd5/0x120 [ 14.680749][ C3] __kmalloc_cache_noprof+0x6e/0x620 [ 14.681059][ C3] kthread_create_worker_on_node+0xea/0x210 [ 14.681362][ C3] workqueue_init+0x2a/0x680 [ 14.681564][ C3] kernel_init_freeable+0x2fe/0x630 [ 14.681827][ C3] kernel_init+0x21/0x150 [ 14.682099][ C3] ret_from_fork+0x474/0x6b0 [ 14.682303][ C3] ret_from_fork_asm+0x11/0x20 [ 14.682565][ C3] } [ 14.682647][ C3] ... key at: [] __fs_reclaim_map+0x0/0xbe0 [ 14.682951][ C3] ... acquired at: [ 14.683078][ C3] __lock_acquire+0x518/0xc20 [ 14.683304][ C3] lock_acquire.part.0+0xd4/0x280 [ 14.683465][ C3] fs_reclaim_acquire+0xd5/0x120 [ 14.683683][ C3] __kmalloc_noprof+0xd3/0x760 [ 14.683843][ C3] alloc_buf.isra.0+0x4b/0x260 [ 14.684074][ C3] put_chars+0x1e1/0x2f0 [ 14.684234][ C3] hvc_console_print+0x292/0x780 [ 14.684458][ C3] console_emit_next_record+0x22f/0x4c0 [ 14.684619][ C3] console_flush_one_record+0x46f/0x710 [ 14.684781][ C3] console_unlock+0xee/0x1f0 [ 14.684947][ C3] vprintk_emit+0x37c/0x3e0 [ 14.685177][ C3] _printk+0xc7/0x100 [ 14.685299][ C3] tun_init+0x24/0xb0 [ 14.685422][ C3] do_one_initcall+0x124/0x4f0 [ 14.685645][ C3] kernel_init_freeable+0x596/0x630 [ 14.685808][ C3] kernel_init+0x21/0x150 [ 14.686036][ C3] ret_from_fork+0x474/0x6b0 [ 14.686201][ C3] ret_from_fork_asm+0x11/0x20 [ 14.686420][ C3] [ 14.686503][ C3] -> (console_owner){....}-{0:0} { [ 14.686722][ C3] INITIAL USE at: [ 14.686842][ C3] } [ 14.686926][ C3] ... key at: [] console_owner_dep_map+0x0/0x60 [ 14.687229][ C3] ... acquired at: [ 14.687347][ C3] __lock_acquire+0x518/0xc20 [ 14.687571][ C3] lock_acquire.part.0+0xd4/0x280 [ 14.687731][ C3] console_lock_spinning_enable+0x5c/0x60 [ 14.687934][ C3] console_emit_next_record+0x1d1/0x4c0 [ 14.688161][ C3] console_flush_one_record+0x46f/0x710 [ 14.688322][ C3] console_unlock+0xee/0x1f0 [ 14.688547][ C3] vprintk_emit+0x37c/0x3e0 [ 14.688708][ C3] _printk+0xc7/0x100 [ 14.688829][ C3] ip6_tnl_xmit_ctl.cold+0x75/0x7a [ 14.689060][ C3] ip6erspan_tunnel_xmit+0x2cf/0x2db4 [ip6_gre] [ 14.689325][ C3] dev_hard_start_xmit+0xf4/0x620 [ 14.689485][ C3] sch_direct_xmit+0x25b/0x1100 [ 14.689704][ C3] __dev_xmit_skb+0xecc/0x1be0 [ 14.689868][ C3] __dev_queue_xmit+0x952/0x1b90 [ 14.690097][ C3] ip6_finish_output2+0x48d/0x13f0 [ 14.690260][ C3] ip6_finish_output+0x701/0xe80 [ 14.690482][ C3] ip6_output+0x23f/0x7f0 [ 14.690642][ C3] mld_sendpack+0x9d6/0xec0 [ 14.690866][ C3] mld_ifc_work+0x36/0x190 [ 14.691034][ C3] process_one_work+0xe3e/0x1560 [ 14.691257][ C3] worker_thread+0x4f1/0xd60 [ 14.691420][ C3] kthread+0x367/0x460 [ 14.691542][ C3] ret_from_fork+0x474/0x6b0 [ 14.691764][ C3] ret_from_fork_asm+0x11/0x20 [ 14.691929][ C3] [ 14.692076][ C3] -> (&qdisc_xmit_lock_key#2){+.-.}-{3:3} { [ 14.692277][ C3] HARDIRQ-ON-W at: [ 14.692459][ C3] __lock_acquire+0x388/0xc20 [ 14.692662][ C3] lock_acquire.part.0+0xd4/0x280 [ 14.692865][ C3] _raw_spin_lock+0x33/0x40 [ 14.693134][ C3] sch_direct_xmit+0x2e5/0x1100 [ 14.693336][ C3] __dev_xmit_skb+0xecc/0x1be0 [ 14.693601][ C3] __dev_queue_xmit+0x952/0x1b90 [ 14.693803][ C3] ip6_finish_output2+0x48d/0x13f0 [ 14.694076][ C3] ip6_finish_output+0x701/0xe80 [ 14.694338][ C3] ip6_output+0x23f/0x7f0 [ 14.694541][ C3] mld_sendpack+0x9d6/0xec0 [ 14.694804][ C3] mld_ifc_work+0x36/0x190 [ 14.695073][ C3] process_one_work+0xe3e/0x1560 [ 14.695276][ C3] worker_thread+0x4f1/0xd60 [ 14.695538][ C3] kthread+0x367/0x460 [ 14.695698][ C3] ret_from_fork+0x474/0x6b0 [ 14.695964][ C3] ret_from_fork_asm+0x11/0x20 [ 14.696234][ C3] IN-SOFTIRQ-W at: [ 14.696355][ C3] __lock_acquire+0x388/0xc20 [ 14.696618][ C3] lock_acquire.part.0+0xd4/0x280 [ 14.696821][ C3] _raw_spin_lock+0x33/0x40 [ 14.697092][ C3] sch_direct_xmit+0x2e5/0x1100 [ 14.697294][ C3] __dev_xmit_skb+0xecc/0x1be0 [ 14.697556][ C3] __dev_queue_xmit+0x952/0x1b90 [ 14.697821][ C3] tcf_mirred_to_dev+0x941/0x1500 [act_mirred] [ 14.698072][ C3] tcf_mirred_act+0x618/0xe10 [act_mirred] [ 14.698378][ C3] tcf_action_exec.part.0+0xca/0x3c0 [ 14.698639][ C3] __tcf_classify.constprop.0+0xcf/0x3a0 [ 14.698946][ C3] tcf_classify+0x67/0x90 [ 14.699153][ C3] tc_run+0x3d0/0x7e0 [ 14.699377][ C3] __netif_receive_skb_core.constprop.0+0xdb7/0x2bb0 [ 14.699622][ C3] __netif_receive_skb_one_core+0xa2/0x180 [ 14.699930][ C3] process_backlog+0x431/0x14c0 [ 14.700204][ C3] __napi_poll+0xa7/0x3b0 [ 14.700408][ C3] net_rx_action+0x513/0xf50 [ 14.700673][ C3] handle_softirqs+0x1d3/0x900 [ 14.700944][ C3] do_softirq+0xac/0xe0 [ 14.701154][ C3] __local_bh_enable_ip+0x118/0x150 [ 14.701415][ C3] __neigh_event_send+0x30a/0x1070 [ 14.701678][ C3] neigh_resolve_output+0xbe/0x140 [ 14.701883][ C3] ip_finish_output2+0x684/0x1c60 [ 14.702155][ C3] ip_output+0x1ca/0x660 [ 14.702358][ C3] ip_push_pending_frames+0xf6/0x250 [ 14.702621][ C3] raw_sendmsg+0x1179/0x1cd0 [ 14.702890][ C3] __sock_sendmsg+0xce/0x190 [ 14.703099][ C3] __sys_sendto+0x260/0x320 [ 14.703363][ C3] __x64_sys_sendto+0xe4/0x1f0 [ 14.703627][ C3] do_syscall_64+0xff/0x530 [ 14.703830][ C3] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 14.704139][ C3] INITIAL USE at: [ 14.704259][ C3] __lock_acquire+0x388/0xc20 [ 14.704522][ C3] lock_acquire.part.0+0xd4/0x280 [ 14.704787][ C3] _raw_spin_lock+0x33/0x40 [ 14.704995][ C3] sch_direct_xmit+0x2e5/0x1100 [ 14.705268][ C3] __dev_xmit_skb+0xecc/0x1be0 [ 14.705473][ C3] __dev_queue_xmit+0x952/0x1b90 [ 14.705736][ C3] ip6_finish_output2+0x48d/0x13f0 [ 14.706006][ C3] ip6_finish_output+0x701/0xe80 [ 14.706219][ C3] ip6_output+0x23f/0x7f0 [ 14.706493][ C3] mld_sendpack+0x9d6/0xec0 [ 14.706754][ C3] mld_ifc_work+0x36/0x190 [ 14.706958][ C3] process_one_work+0xe3e/0x1560 [ 14.707226][ C3] worker_thread+0x4f1/0xd60 [ 14.707428][ C3] kthread+0x367/0x460 [ 14.707650][ C3] ret_from_fork+0x474/0x6b0 [ 14.707914][ C3] ret_from_fork_asm+0x11/0x20 [ 14.708123][ C3] } [ 14.708204][ C3] ... key at: [] qdisc_xmit_lock_key.158+0x0/0x40 [ip6_gre] [ 14.708537][ C3] ... acquired at: [ 14.708714][ C3] mark_lock+0x1d7/0xa00 [ 14.708879][ C3] mark_usage+0x42/0x170 [ 14.709106][ C3] __lock_acquire+0x388/0xc20 [ 14.709267][ C3] lock_acquire.part.0+0xd4/0x280 [ 14.709486][ C3] _raw_spin_lock+0x33/0x40 [ 14.709646][ C3] sch_direct_xmit+0x2e5/0x1100 [ 14.709805][ C3] __dev_xmit_skb+0xecc/0x1be0 [ 14.709969][ C3] __dev_queue_xmit+0x952/0x1b90 [ 14.710195][ C3] tcf_mirred_to_dev+0x941/0x1500 [act_mirred] [ 14.710395][ C3] tcf_mirred_act+0x618/0xe10 [act_mirred] [ 14.710654][ C3] tcf_action_exec.part.0+0xca/0x3c0 [ 14.710815][ C3] __tcf_classify.constprop.0+0xcf/0x3a0 [ 14.711084][ C3] tcf_classify+0x67/0x90 [ 14.711304][ C3] tc_run+0x3d0/0x7e0 [ 14.711426][ C3] __netif_receive_skb_core.constprop.0+0xdb7/0x2bb0 [ 14.711685][ C3] __netif_receive_skb_one_core+0xa2/0x180 [ 14.711889][ C3] process_backlog+0x431/0x14c0 [ 14.712116][ C3] __napi_poll+0xa7/0x3b0 [ 14.712278][ C3] net_rx_action+0x513/0xf50 [ 14.712497][ C3] handle_softirqs+0x1d3/0x900 [ 14.712657][ C3] do_softirq+0xac/0xe0 [ 14.712776][ C3] __local_bh_enable_ip+0x118/0x150 [ 14.712938][ C3] __neigh_event_send+0x30a/0x1070 [ 14.713162][ C3] neigh_resolve_output+0xbe/0x140 [ 14.713323][ C3] ip_finish_output2+0x684/0x1c60 [ 14.713541][ C3] ip_output+0x1ca/0x660 [ 14.713700][ C3] ip_push_pending_frames+0xf6/0x250 [ 14.713923][ C3] raw_sendmsg+0x1179/0x1cd0 [ 14.714090][ C3] __sock_sendmsg+0xce/0x190 [ 14.714308][ C3] __sys_sendto+0x260/0x320 [ 14.714471][ C3] __x64_sys_sendto+0xe4/0x1f0 [ 14.714691][ C3] do_syscall_64+0xff/0x530 [ 14.714851][ C3] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 14.715121][ C3] [ 14.715200][ C3] [ 14.715200][ C3] stack backtrace: [ 14.715459][ C3] CPU: 3 UID: 0 PID: 228 Comm: ping Tainted: G W 7.2.0-virtme #1 PREEMPT(full) [ 14.715463][ C3] Tainted: [W]=WARN [ 14.715464][ C3] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 14.715465][ C3] Call Trace: [ 14.715466][ C3] [ 14.715466][ C3] dump_stack_lvl+0x6f/0xa0 [ 14.715471][ C3] print_irq_inversion_bug.part.0.cold+0xe6/0x143 [ 14.715474][ C3] mark_lock_irq+0x989/0x9c0 [ 14.715477][ C3] mark_lock+0x1d7/0xa00 [ 14.715479][ C3] mark_usage+0x42/0x170 [ 14.715480][ C3] __lock_acquire+0x388/0xc20 [ 14.715482][ C3] ? skb_network_protocol+0x3b0/0x3b0 [ 14.715484][ C3] ? lock_pin_lock+0x87/0x180 [ 14.715486][ C3] lock_acquire.part.0+0xd4/0x280 [ 14.715488][ C3] ? sch_direct_xmit+0x2e5/0x1100 [ 14.715489][ C3] ? rcu_is_watching+0x16/0xd0 [ 14.715491][ C3] ? lock_acquire+0x13c/0x160 [ 14.715493][ C3] _raw_spin_lock+0x33/0x40 [ 14.715495][ C3] ? sch_direct_xmit+0x2e5/0x1100 [ 14.715496][ C3] sch_direct_xmit+0x2e5/0x1100 [ 14.715498][ C3] ? lock_acquire.part.0+0xd4/0x280 [ 14.715500][ C3] ? dequeue_skb+0x1db0/0x1db0 [ 14.715501][ C3] ? __rcu_read_lock+0x70/0x70 [ 14.715503][ C3] ? tcf_mirred_act+0x618/0xe10 [act_mirred] [ 14.715504][ C3] ? lock_acquire+0x13c/0x160 [ 14.715506][ C3] __dev_xmit_skb+0xecc/0x1be0 [ 14.715509][ C3] ? alloc_netdev_dummy+0x30/0x30 [ 14.715510][ C3] ? __dev_queue_xmit+0x204/0x1b90 [ 14.715512][ C3] ? rcu_is_watching+0x16/0xd0 [ 14.715513][ C3] ? lock_acquire+0x13c/0x160 [ 14.715515][ C3] __dev_queue_xmit+0x952/0x1b90 [ 14.715517][ C3] ? find_held_lock+0x2b/0x80 [ 14.715519][ C3] ? __lock_release.isra.0+0x69/0x1a0 [ 14.715521][ C3] ? tcf_classify+0x67/0x90 [ 14.715523][ C3] ? netdev_core_pick_tx+0x2c0/0x2c0 [ 14.715524][ C3] ? lockdep_hardirqs_on+0x91/0x130 [ 14.715526][ C3] ? _raw_spin_unlock_irqrestore+0x40/0x80 [ 14.715528][ C3] ? __copy_skb_header+0xb7/0x510 [ 14.715531][ C3] ? __asan_memcpy+0x3c/0x60 [ 14.715534][ C3] ? __skb_clone+0x55e/0x760 [ 14.715536][ C3] tcf_mirred_to_dev+0x941/0x1500 [act_mirred] [ 14.715538][ C3] ? __lock_acquire+0x518/0xc20 [ 14.715540][ C3] tcf_mirred_act+0x618/0xe10 [act_mirred] [ 14.715541][ C3] ? __lock_acquire+0x518/0xc20 [ 14.715543][ C3] ? lock_pin_lock+0x87/0x180 [ 14.715545][ C3] tcf_action_exec.part.0+0xca/0x3c0 [ 14.715547][ C3] __tcf_classify.constprop.0+0xcf/0x3a0 [ 14.715550][ C3] tcf_classify+0x67/0x90 [ 14.715551][ C3] ? tcf_qevent_handle+0x3d0/0x3d0 [ 14.715553][ C3] ? __lock_release.isra.0+0x69/0x1a0 [ 14.715555][ C3] ? rcu_lockdep_current_cpu_online+0x3f/0x1b0 [ 14.715556][ C3] tc_run+0x3d0/0x7e0 [ 14.715558][ C3] ? rcu_do_batch+0x2b6/0x1000 [ 14.715560][ C3] ? netdev_offload_xstats_push_delta+0x430/0x430 [ 14.715561][ C3] ? unwind_get_return_address+0x67/0xd0 [ 14.715564][ C3] __netif_receive_skb_core.constprop.0+0xdb7/0x2bb0 [ 14.715567][ C3] ? rcu_read_lock_any_held+0x66/0x90 [ 14.715570][ C3] ? do_xdp_generic+0x4a0/0x4a0 [ 14.715571][ C3] ? rcu_do_batch+0x2b6/0x1000 [ 14.715573][ C3] ? kasan_save_stack+0x3d/0x50 [ 14.715574][ C3] ? kasan_save_stack+0x2f/0x50 [ 14.715575][ C3] ? kasan_save_free_info+0x3b/0x60 [ 14.715577][ C3] ? kmem_cache_free+0xf8/0x550 [ 14.715578][ C3] ? rcu_core+0x34e/0x8e0 [ 14.715580][ C3] ? handle_softirqs+0x1d3/0x900 [ 14.715582][ C3] ? __irq_exit_rcu+0x145/0x1c0 [ 14.715583][ C3] ? sysvec_apic_timer_interrupt+0x9d/0xe0 [ 14.715585][ C3] ? rcu_lockdep_current_cpu_online+0x3f/0x1b0 [ 14.715587][ C3] ? mark_usage+0x61/0x170 [ 14.715588][ C3] ? __lock_acquire+0x518/0xc20 [ 14.715590][ C3] ? irq_matrix_free+0x487/0x600 [ 14.715593][ C3] ? process_backlog+0x3f1/0x14c0 [ 14.715595][ C3] __netif_receive_skb_one_core+0xa2/0x180 [ 14.715597][ C3] ? lock_acquire.part.0+0xd4/0x280 [ 14.715598][ C3] ? process_backlog+0x3f1/0x14c0 [ 14.715600][ C3] ? __netif_receive_skb_list_core+0x9e0/0x9e0 [ 14.715602][ C3] ? rcu_is_watching+0x16/0xd0 [ 14.715604][ C3] process_backlog+0x431/0x14c0 [ 14.715607][ C3] __napi_poll+0xa7/0x3b0 [ 14.715609][ C3] net_rx_action+0x513/0xf50 [ 14.715611][ C3] ? __napi_poll+0x3b0/0x3b0 [ 14.715613][ C3] ? __lock_release.isra.0+0x69/0x1a0 [ 14.715615][ C3] ? mark_held_locks+0x40/0x70 [ 14.715618][ C3] ? clockevents_program_event+0x307/0x7e0 [ 14.715621][ C3] ? mark_held_locks+0x40/0x70 [ 14.715623][ C3] ? rcu_is_watching+0x16/0xd0 [ 14.715624][ C3] ? mark_held_locks+0x40/0x70 [ 14.715626][ C3] handle_softirqs+0x1d3/0x900 [ 14.715628][ C3] ? _local_bh_enable+0xc0/0xc0 [ 14.715629][ C3] ? _local_bh_enable+0xc0/0xc0 [ 14.715631][ C3] do_softirq+0xac/0xe0 [ 14.715633][ C3] [ 14.715634][ C3] [ 14.715634][ C3] __local_bh_enable_ip+0x118/0x150 [ 14.715636][ C3] __neigh_event_send+0x30a/0x1070 [ 14.715638][ C3] ? ip_finish_output2+0x1d1/0x1c60 [ 14.715639][ C3] ? rcu_is_watching+0x16/0xd0 [ 14.715641][ C3] neigh_resolve_output+0xbe/0x140 [ 14.715643][ C3] ip_finish_output2+0x684/0x1c60 [ 14.715644][ C3] ? ip_dst_mtu_maybe_forward+0x2c7/0x720 [ 14.715646][ C3] ? lock_acquire.part.0+0xd4/0x280 [ 14.715647][ C3] ? ip_fragment.constprop.0+0x2c0/0x2c0 [ 14.715649][ C3] ? rcu_is_watching+0x16/0xd0 [ 14.715651][ C3] ip_output+0x1ca/0x660 [ 14.715652][ C3] ? ip_finish_output+0x460/0x460 [ 14.715654][ C3] ? __ip_make_skb+0x106a/0x2300 [ 14.715656][ C3] ip_push_pending_frames+0xf6/0x250 [ 14.715658][ C3] raw_sendmsg+0x1179/0x1cd0 [ 14.715660][ C3] ? raw_send_hdrinc+0x1740/0x1740 [ 14.715662][ C3] ? __might_fault+0x97/0x140 [ 14.715664][ C3] ? _copy_to_user+0x4b/0x70 [ 14.715668][ C3] ? validate_chain+0x38b/0xc20 [ 14.715670][ C3] ? import_iovec+0x4e/0xa0 [ 14.715672][ C3] ? __lock_acquire+0x518/0xc20 [ 14.715674][ C3] ? lock_acquire.part.0+0xd4/0x280 [ 14.715676][ C3] ? __lock_release.isra.0+0x69/0x1a0 [ 14.715678][ C3] __sock_sendmsg+0xce/0x190 [ 14.715680][ C3] ? fdget+0x4f/0x1e0 [ 14.715683][ C3] __sys_sendto+0x260/0x320 [ 14.715684][ C3] ? __ia32_sys_getpeername+0xd0/0xd0 [ 14.715689][ C3] __x64_sys_sendto+0xe4/0x1f0 [ 14.715691][ C3] ? trace_irq_enable.constprop.0+0x9b/0x160 [ 14.715693][ C3] ? lockdep_hardirqs_on+0x91/0x130 [ 14.715695][ C3] ? do_syscall_64+0xa6/0x530 [ 14.715697][ C3] do_syscall_64+0xff/0x530 [ 14.715698][ C3] ? exc_page_fault+0xee/0x100 [ 14.715700][ C3] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 14.715701][ C3] RIP: 0033:0x7feeac08c54e [ 14.715703][ C3] Code: 4d 89 d8 e8 b4 bd 00 00 4c 8b 5d f8 41 8b 93 08 03 00 00 59 5e 48 83 f8 fc 74 11 c9 c3 0f 1f 80 00 00 00 00 48 8b 45 10 0f 05 c3 83 e2 39 83 fa 08 75 e7 e8 03 ff ff ff 0f 1f 00 f3 0f 1e fa [ 14.715704][ C3] RSP: 002b:00007fff06c22580 EFLAGS: 00000202 ORIG_RAX: 000000000000002c [ 14.715706][ C3] RAX: ffffffffffffffda RBX: 0000000000000040 RCX: 00007feeac08c54e [ 14.715707][ C3] RDX: 0000000000000040 RSI: 00005573ab0790a4 RDI: 0000000000000005 [ 14.715708][ C3] RBP: 00007fff06c22590 R08: 00005573ab08b320 R09: 0000000000000010 [ 14.715709][ C3] R10: 0000000000000000 R11: 0000000000000202 R12: 431bde82d7b634db [ 14.715710][ C3] R13: 0000000000000000 R14: 00005573ab08c3e0 R15: 00005573ab0790a0 [ 14.715712][ C3]