[ 10.674979][ T227] 8021q: 802.1Q VLAN Support v1.8 [ 10.675003][ T227] BUG: sleeping function called from invalid context at ./include/linux/sched/mm.h:322 [ 10.675006][ T227] in_atomic(): 1, irqs_disabled(): 1, non_block: 0, pid: 227, name: modprobe [ 10.675009][ T227] preempt_count: 1, expected: 0 [ 10.675010][ T227] RCU nest depth: 0, expected: 0 [ 10.675011][ T227] locks held by modprobe/227: 4, last CPU#2: [ 10.675014][ T227] #0: ffffffff9bd69cc0 (console_lock){+.+.}-{0:0}, at: vprintk_emit+0x320/0x3e0 [ 10.675030][ T227] #1: ffffffff9bd69d38 (console_srcu){....}-{0:0}, at: console_flush_one_record+0x106/0x710 [ 10.675036][ T227] #2: ffffffff9bc89660 (console_owner){....}-{0:0}, at: console_lock_spinning_enable+0x40/0x60 [ 10.675043][ T227] #3: ffffffff9bc89560 (printk_legacy_map-wait-type-override){....}-{3:3}, at: console_emit_next_record+0x1df/0x4c0 [ 10.675049][ T227] irq event stamp: 30376 [ 10.675050][ T227] hardirqs last enabled at (30375): [] __down_trylock_console_sem+0x86/0xa0 [ 10.675054][ T227] hardirqs last disabled at (30376): [] console_emit_next_record+0x3d4/0x4c0 [ 10.675058][ T227] softirqs last enabled at (27244): [] handle_softirqs+0x67c/0x900 [ 10.675062][ T227] softirqs last disabled at (27031): [] __irq_exit_rcu+0x145/0x1c0 [ 10.675065][ T227] Preemption disabled at: [ 10.675066][ T227] [] vprintk_emit+0x31b/0x3e0 [ 10.675073][ T227] CPU: 2 UID: 0 PID: 227 Comm: modprobe Tainted: G W 7.2.0-virtme #1 PREEMPT(full) [ 10.675078][ T227] Tainted: [W]=WARN [ 10.675079][ T227] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 10.675081][ T227] Call Trace: [ 10.675083][ T227] [ 10.675085][ T227] dump_stack_lvl+0x6f/0xa0 [ 10.675099][ T227] ? vprintk_emit+0x31b/0x3e0 [ 10.675102][ T227] __might_resched.cold+0x1fe/0x2c1 [ 10.675108][ T227] ? perf_trace_sched_switch+0x7c0/0x7c0 [ 10.675114][ T227] ? __kmalloc_noprof+0xdb/0x760 [ 10.675122][ T227] __kmalloc_noprof+0x443/0x760 [ 10.675126][ T227] ? alloc_buf.isra.0+0x4b/0x260 [ 10.675134][ T227] ? do_raw_spin_unlock+0x59/0x250 [ 10.675138][ T227] alloc_buf.isra.0+0x4b/0x260 [ 10.675143][ T227] put_chars+0x1e1/0x2f0 [ 10.675148][ T227] ? __send_to_port+0x420/0x420 [ 10.675150][ T227] ? rcu_lockdep_current_cpu_online+0x3f/0x1b0 [ 10.675157][ T227] ? rcu_read_lock_any_held+0x3c/0x90 [ 10.675160][ T227] ? validate_chain+0x38b/0xc20 [ 10.675168][ T227] hvc_console_print+0x292/0x780 [ 10.675172][ T227] ? __lock_acquire+0x518/0xc20 [ 10.675181][ T227] ? hvc_write+0x3a0/0x3a0 [ 10.675186][ T227] ? rcu_is_watching+0x16/0xd0 [ 10.675195][ T227] console_emit_next_record+0x22f/0x4c0 [ 10.675201][ T227] ? devkmsg_read+0x4b0/0x4b0 [ 10.675204][ T227] ? console_flush_one_record+0x106/0x710 [ 10.675209][ T227] ? rcu_is_watching+0x16/0xd0 [ 10.675213][ T227] ? lock_acquire+0x13c/0x160 [ 10.675220][ T227] console_flush_one_record+0x46f/0x710 [ 10.675227][ T227] ? console_emit_next_record+0x4c0/0x4c0 [ 10.675229][ T227] ? __lock_acquire+0x518/0xc20 [ 10.675239][ T227] console_unlock+0xee/0x1f0 [ 10.675243][ T227] ? console_flush_one_record+0x710/0x710 [ 10.675246][ T227] ? rcu_is_watching+0x16/0xd0 [ 10.675250][ T227] ? lock_acquire+0x60/0x160 [ 10.675256][ T227] ? __down_trylock_console_sem+0x5e/0xa0 [ 10.675258][ T227] ? vprintk_emit+0x320/0x3e0 [ 10.675264][ T227] vprintk_emit+0x37c/0x3e0 [ 10.675270][ T227] ? wake_up_klogd_work_func+0x90/0x90 [ 10.675280][ T227] ? vlan_netlink_fini+0x960/0x960 [8021q] [ 10.675286][ T227] _printk+0xc7/0x100 [ 10.675291][ T227] ? snapshot_read.cold+0x21/0x21 [ 10.675303][ T227] ? do_one_initcall+0x113/0x4f0 [ 10.675308][ T227] vlan_proto_init+0x24/0x90 [8021q] [ 10.675312][ T227] do_one_initcall+0x124/0x4f0 [ 10.675317][ T227] ? trace_event_raw_event_initcall_level+0x280/0x280 [ 10.675325][ T227] ? do_init_module+0xae/0x8a0 [ 10.675329][ T227] ? kasan_unpoison+0x44/0x70 [ 10.675337][ T227] do_init_module+0x2ad/0x8a0 [ 10.675343][ T227] ? lockdep_hardirqs_on+0x91/0x130 [ 10.675348][ T227] ? free_module+0x470/0x470 [ 10.675354][ T227] ? kfree+0x123/0x590 [ 10.675361][ T227] load_module+0x1424/0x1bb0 [ 10.675374][ T227] ? layout_and_allocate.isra.0+0x680/0x680 [ 10.675380][ T227] ? __ia32_sys_fsconfig+0x180/0x180 [ 10.675384][ T227] ? ovl_real_file+0x172/0x1e0 [ 10.675390][ T227] ? backing_file_read_iter+0x541/0x790 [ 10.675394][ T227] ? rcu_lockdep_current_cpu_online+0x3f/0x1b0 [ 10.675401][ T227] init_module_from_file+0x11f/0x1a0 [ 10.675406][ T227] ? __do_sys_init_module+0x220/0x220 [ 10.675421][ T227] ? __rwlock_init+0x150/0x150 [ 10.675427][ T227] ? do_raw_spin_unlock+0x59/0x250 [ 10.675432][ T227] idempotent_init_module+0x37b/0x7c0 [ 10.675438][ T227] ? init_module_from_file+0x1a0/0x1a0 [ 10.675449][ T227] ? rcu_is_watching+0x16/0xd0 [ 10.675453][ T227] ? cap_capable+0x1d7/0x3d0 [ 10.675462][ T227] __x64_sys_finit_module+0xdf/0x190 [ 10.675466][ T227] ? trace_irq_enable.constprop.0+0x9b/0x160 [ 10.675471][ T227] do_syscall_64+0xff/0x530 [ 10.675474][ T227] ? exc_page_fault+0xee/0x100 [ 10.675478][ T227] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 10.675481][ T227] RIP: 0033:0x7fc3448ae37d [ 10.675489][ T227] 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.675491][ T227] RSP: 002b:00007fffd99d66d8 EFLAGS: 00000246 ORIG_RAX: 0000000000000139 [ 10.675495][ T227] RAX: ffffffffffffffda RBX: 000055a1c3d71810 RCX: 00007fc3448ae37d [ 10.675497][ T227] RDX: 0000000000000000 RSI: 000055a1c3630ffd RDI: 0000000000000000 [ 10.675499][ T227] RBP: 00007fffd99d6770 R08: 0000000000000000 R09: 0000000000000000 [ 10.675500][ T227] R10: 0000000000000000 R11: 0000000000000246 R12: 000055a1c3630ffd [ 10.675501][ T227] R13: 000055a1c3d71960 R14: 0000000000040000 R15: 0000000000000000 [ 10.675515][ T227] [ 11.567230][ T248] br0: port 1(veth1) entered blocking state [ 11.570729][ T248] br0: port 1(veth1) entered disabled state [ 11.571328][ T248] veth1: entered allmulticast mode [ 11.574473][ T248] veth1: entered promiscuous mode [ 11.615570][ T250] br0: port 2(veth2) entered blocking state [ 11.615904][ T250] br0: port 2(veth2) entered disabled state [ 11.616254][ T250] veth2: entered allmulticast mode [ 11.617973][ T250] veth2: entered promiscuous mode [ 11.713184][ T46] br0: port 1(veth1) entered blocking state [ 11.713249][ T46] BUG: sleeping function called from invalid context at ./include/linux/sched/mm.h:322 [ 11.713251][ T46] in_atomic(): 1, irqs_disabled(): 1, non_block: 0, pid: 46, name: kworker/u17:1 [ 11.713253][ T46] preempt_count: 202, expected: 0 [ 11.713254][ T46] RCU nest depth: 0, expected: 0 [ 11.713255][ T46] locks held by kworker/u17:1/46: 8, last CPU#1: [ 11.713258][ T46] #0: ff1100000114a940 ((wq_completion)events_unbound){+.+.}-{0:0}, at: process_one_work+0xd9a/0x1560 [ 11.713270][ T46] #1: ffa000000032fd10 ((linkwatch_work).work){+.+.}-{0:0}, at: process_one_work+0xdfc/0x1560 [ 11.713274][ T46] #2: ffffffff9c4d2c40 (rtnl_mutex){+.+.}-{4:4}, at: linkwatch_event+0x4e/0xb0 [ 11.713280][ T46] #3: ff1100000f68ae58 (&br->lock){+...}-{3:3}, at: br_port_carrier_check+0x161/0x430 [bridge] [ 11.713295][ T46] #4: ffffffff9bd69cc0 (console_lock){+.+.}-{0:0}, at: vprintk_emit+0x320/0x3e0 [ 11.713300][ T46] #5: ffffffff9bd69d38 (console_srcu){....}-{0:0}, at: console_flush_one_record+0x106/0x710 [ 11.713304][ T46] #6: ffffffff9bc89660 (console_owner){....}-{0:0}, at: console_lock_spinning_enable+0x40/0x60 [ 11.713307][ T46] #7: ffffffff9bc89560 (printk_legacy_map-wait-type-override){....}-{3:3}, at: console_emit_next_record+0x1df/0x4c0 [ 11.713311][ T46] irq event stamp: 43761 [ 11.713312][ T46] hardirqs last enabled at (43760): [] __down_trylock_console_sem+0x86/0xa0 [ 11.713315][ T46] hardirqs last disabled at (43761): [] console_emit_next_record+0x3d4/0x4c0 [ 11.713317][ T46] softirqs last enabled at (43714): [] inet6_fill_ifla6_attrs+0x1b3e/0x21e0 [ 11.713321][ T46] softirqs last disabled at (43756): [] br_port_carrier_check+0x161/0x430 [bridge] [ 11.713329][ T46] Preemption disabled at: [ 11.713330][ T46] [<0000000000000000>] 0x0 [ 11.713337][ T46] CPU: 1 UID: 0 PID: 46 Comm: kworker/u17:1 Tainted: G W 7.2.0-virtme #1 PREEMPT(full) [ 11.713341][ T46] Tainted: [W]=WARN [ 11.713341][ T46] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 11.713343][ T46] Workqueue: events_unbound linkwatch_event [ 11.713346][ T46] Call Trace: [ 11.713348][ T46] [ 11.713350][ T46] dump_stack_lvl+0x6f/0xa0 [ 11.713357][ T46] __might_resched.cold+0x1fe/0x2c1 [ 11.713361][ T46] ? perf_trace_sched_switch+0x7c0/0x7c0 [ 11.713366][ T46] ? __kmalloc_noprof+0xdb/0x760 [ 11.713371][ T46] __kmalloc_noprof+0x443/0x760 [ 11.713373][ T46] ? alloc_buf.isra.0+0x4b/0x260 [ 11.713379][ T46] ? do_raw_spin_unlock+0x59/0x250 [ 11.713382][ T46] alloc_buf.isra.0+0x4b/0x260 [ 11.713386][ T46] put_chars+0x1e1/0x2f0 [ 11.713389][ T46] ? __send_to_port+0x420/0x420 [ 11.713390][ T46] ? check_prev_add+0x316/0xe90 [ 11.713395][ T46] ? validate_chain+0x34a/0xc20 [ 11.713399][ T46] hvc_console_print+0x292/0x780 [ 11.713401][ T46] ? mark_usage+0x61/0x170 [ 11.713403][ T46] ? __lock_acquire+0x518/0xc20 [ 11.713405][ T46] ? __lock_acquire+0x518/0xc20 [ 11.713409][ T46] ? hvc_write+0x3a0/0x3a0 [ 11.713411][ T46] ? lock_acquire.part.0+0xd4/0x280 [ 11.713415][ T46] ? lock_acquire+0x13c/0x160 [ 11.713419][ T46] console_emit_next_record+0x22f/0x4c0 [ 11.713423][ T46] ? devkmsg_read+0x4b0/0x4b0 [ 11.713425][ T46] ? console_flush_one_record+0x106/0x710 [ 11.713429][ T46] ? rcu_is_watching+0x16/0xd0 [ 11.713433][ T46] ? lock_acquire+0x13c/0x160 [ 11.713437][ T46] console_flush_one_record+0x46f/0x710 [ 11.713441][ T46] ? console_emit_next_record+0x4c0/0x4c0 [ 11.713443][ T46] ? __lock_acquire+0x518/0xc20 [ 11.713449][ T46] console_unlock+0xee/0x1f0 [ 11.713451][ T46] ? console_flush_one_record+0x710/0x710 [ 11.713453][ T46] ? rcu_is_watching+0x16/0xd0 [ 11.713456][ T46] ? lock_acquire+0x60/0x160 [ 11.713460][ T46] ? __down_trylock_console_sem+0x5e/0xa0 [ 11.713462][ T46] ? vprintk_emit+0x320/0x3e0 [ 11.713465][ T46] vprintk_emit+0x37c/0x3e0 [ 11.713469][ T46] ? wake_up_klogd_work_func+0x90/0x90 [ 11.713476][ T46] _printk+0xc7/0x100 [ 11.713479][ T46] ? snapshot_read.cold+0x21/0x21 [ 11.713485][ T46] ? lock_acquire.part.0+0xd4/0x280 [ 11.713492][ T46] br_set_state+0x22f/0x430 [bridge] [ 11.713502][ T46] br_init_port+0xc4/0x200 [bridge] [ 11.713511][ T46] br_stp_enable_port+0x12/0x50 [bridge] [ 11.713518][ T46] br_port_carrier_check+0x220/0x430 [bridge] [ 11.713527][ T46] br_device_event+0x52d/0x8f0 [bridge] [ 11.713536][ T46] ? _sub_I_65535_1+0x4d0/0x4d0 [stp] [ 11.713538][ T46] ? nlmsg_notify+0x62/0x250 [ 11.713545][ T46] notifier_call_chain+0xae/0x300 [ 11.713551][ T46] netif_state_change+0x139/0x340 [ 11.713556][ T46] ? call_netdevice_notifiers_info+0xd0/0xd0 [ 11.713561][ T46] ? linkwatch_do_dev+0xae/0xd0 [ 11.713563][ T46] __linkwatch_run_queue+0x34c/0x750 [ 11.713566][ T46] ? linkwatch_do_dev+0xd0/0xd0 [ 11.713569][ T46] ? lock_acquire.part.0+0xd4/0x280 [ 11.713574][ T46] linkwatch_event+0x7f/0xb0 [ 11.713576][ T46] ? __linkwatch_run_queue+0x750/0x750 [ 11.713580][ T46] process_one_work+0xe3e/0x1560 [ 11.713587][ T46] ? __queue_delayed_work+0x470/0x470 [ 11.713590][ T46] ? lock_acquire.part.0+0xd4/0x280 [ 11.713598][ T46] worker_thread+0x4f1/0xd60 [ 11.713605][ T46] ? rescuer_thread+0x1340/0x1340 [ 11.713607][ T46] kthread+0x367/0x460 [ 11.713610][ T46] ? trace_irq_enable.constprop.0+0x9b/0x160 [ 11.713613][ T46] ? kthread_affine_preferred+0x4c0/0x4c0 [ 11.713616][ T46] ret_from_fork+0x474/0x6b0 [ 11.713620][ T46] ? arch_exit_to_user_mode_prepare.isra.0+0x120/0x120 [ 11.713623][ T46] ? __switch_to+0x5a3/0xe00 [ 11.713626][ T46] ? kthread_affine_preferred+0x4c0/0x4c0 [ 11.713629][ T46] ret_from_fork_asm+0x11/0x20 [ 11.713638][ T46] [ 11.738679][ T46] br0: port 1(veth1) entered forwarding state [ 11.765591][ T38] br0: port 2(veth2) entered blocking state [ 11.772349][ T38] br0: port 2(veth2) entered forwarding state [ 27.010568][ C1] [ 27.010584][ C1] BUG: sleeping function called from invalid context at ./include/linux/sched/mm.h:322 [ 27.010587][ C1] in_atomic(): 1, irqs_disabled(): 1, non_block: 0, pid: 0, name: swapper/1 [ 27.010589][ C1] preempt_count: 104, expected: 0 [ 27.010590][ C1] RCU nest depth: 0, expected: 0 [ 27.010590][ C1] INFO: lockdep is turned off. [ 27.010591][ C1] irq event stamp: 596946 [ 27.010592][ C1] hardirqs last enabled at (596946): [] _raw_spin_unlock_irq+0x28/0x50 [ 27.010601][ C1] hardirqs last disabled at (596945): [] _raw_spin_lock_irq+0x4a/0x50 [ 27.010603][ C1] softirqs last enabled at (596894): [] handle_softirqs+0x67c/0x900 [ 27.010606][ C1] softirqs last disabled at (596943): [] __irq_exit_rcu+0x145/0x1c0 [ 27.010608][ C1] Preemption disabled at: [ 27.010609][ C1] [<0000000000000000>] 0x0 [ 27.010617][ C1] CPU: 1 UID: 0 PID: 0 Comm: swapper/1 Tainted: G W 7.2.0-virtme #1 PREEMPT(full) [ 27.010620][ C1] Tainted: [W]=WARN [ 27.010621][ C1] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 27.010623][ C1] Call Trace: [ 27.010625][ C1] [ 27.010627][ C1] dump_stack_lvl+0x6f/0xa0 [ 27.010632][ C1] __might_resched.cold+0x1fe/0x2c1 [ 27.010636][ C1] ? perf_trace_sched_switch+0x7c0/0x7c0 [ 27.010639][ C1] ? __asan_memcpy+0x3c/0x60 [ 27.010642][ C1] ? rcu_is_watching+0x16/0xd0 [ 27.010646][ C1] __kmalloc_noprof+0x443/0x760 [ 27.010649][ C1] ? __rwlock_init+0x150/0x150 [ 27.010651][ C1] ? alloc_buf.isra.0+0x4b/0x260 [ 27.010655][ C1] ? do_raw_spin_unlock+0x59/0x250 [ 27.010657][ C1] alloc_buf.isra.0+0x4b/0x260 [ 27.010659][ C1] put_chars+0x1e1/0x2f0 [ 27.010661][ C1] ? __send_to_port+0x420/0x420 [ 27.010663][ C1] ? console_prepend_replay+0x20/0x20 [ 27.010666][ C1] hvc_console_print+0x292/0x780 [ 27.010669][ C1] ? hvc_write+0x3a0/0x3a0 [ 27.010670][ C1] ? rcu_is_watching+0x16/0xd0 [ 27.010672][ C1] ? lock_acquire+0x13c/0x160 [ 27.010674][ C1] console_emit_next_record+0x22f/0x4c0 [ 27.010677][ C1] ? devkmsg_read+0x4b0/0x4b0 [ 27.010679][ C1] ? rcu_is_watching+0x16/0xd0 [ 27.010680][ C1] ? rcu_is_watching+0x16/0xd0 [ 27.010682][ C1] ? lock_acquire+0x13c/0x160 [ 27.010684][ C1] ? console_flush_one_record+0x111/0x710 [ 27.010686][ C1] console_flush_one_record+0x46f/0x710 [ 27.010688][ C1] ? console_emit_next_record+0x4c0/0x4c0 [ 27.010691][ C1] console_unlock+0xee/0x1f0 [ 27.010693][ C1] ? lock_acquire+0x13c/0x160 [ 27.010694][ C1] ? console_flush_one_record+0x710/0x710 [ 27.010696][ C1] ? rcu_is_watching+0x16/0xd0 [ 27.010697][ C1] ? lock_release+0x184/0x1f0 [ 27.010699][ C1] ? lock_acquire+0x60/0x160 [ 27.010701][ C1] ? __down_trylock_console_sem+0x5e/0xa0 [ 27.010703][ C1] ? vprintk_emit+0x320/0x3e0 [ 27.010705][ C1] vprintk_emit+0x37c/0x3e0 [ 27.010707][ C1] ? wake_up_klogd_work_func+0x90/0x90 [ 27.010709][ C1] ? br_forward_delay_timer_expired+0x44/0x5d0 [bridge] [ 27.010721][ C1] ? lock_release+0x184/0x1f0 [ 27.010722][ C1] ? br_forward_delay_timer_expired+0x44/0x5d0 [bridge] [ 27.010729][ C1] ? br_forward_delay_timer_expired+0x44/0x5d0 [bridge] [ 27.010735][ C1] ? is_module_text_address+0x154/0x250 [ 27.010739][ C1] _printk+0xc7/0x100 [ 27.010742][ C1] ? snapshot_read.cold+0x21/0x21 [ 27.010743][ C1] ? arch_stack_walk+0xd7/0x130 [ 27.010747][ C1] ? rcu_lockdep_current_cpu_online+0x3f/0x1b0 [ 27.010750][ C1] ? nbcon_cpu_emergency_enter+0x28/0x80 [ 27.010752][ C1] print_irq_inversion_bug.part.0+0x32/0xc0 [ 27.010754][ C1] mark_lock_irq+0x989/0x9c0 [ 27.010757][ C1] mark_lock+0x1d7/0xa00 [ 27.010759][ C1] mark_usage+0x42/0x170 [ 27.010760][ C1] __lock_acquire+0x388/0xc20 [ 27.010762][ C1] lock_acquire.part.0+0xd4/0x280 [ 27.010764][ C1] ? br_forward_delay_timer_expired+0x44/0x5d0 [bridge] [ 27.010770][ C1] ? rcu_is_watching+0x16/0xd0 [ 27.010772][ C1] ? lock_acquire+0x13c/0x160 [ 27.010774][ C1] ? br_message_age_timer_expired+0x70/0x70 [bridge] [ 27.010780][ C1] _raw_spin_lock+0x33/0x40 [ 27.010782][ C1] ? br_forward_delay_timer_expired+0x44/0x5d0 [bridge] [ 27.010788][ C1] br_forward_delay_timer_expired+0x44/0x5d0 [bridge] [ 27.010795][ C1] ? br_message_age_timer_expired+0x70/0x70 [bridge] [ 27.010801][ C1] call_timer_fn+0x160/0x4d0 [ 27.010804][ C1] ? detach_if_pending+0x1d0/0x1d0 [ 27.010805][ C1] ? debug_object_active_state+0x430/0x430 [ 27.010809][ C1] ? find_held_lock+0x2b/0x80 [ 27.010812][ C1] ? __lock_release.isra.0+0x69/0x1a0 [ 27.010813][ C1] ? rcu_is_watching+0x16/0xd0 [ 27.010816][ C1] __run_timers+0x68f/0xaa0 [ 27.010818][ C1] ? br_message_age_timer_expired+0x70/0x70 [bridge] [ 27.010824][ C1] ? __bpf_trace_itimer_expire+0x10/0x10 [ 27.010826][ C1] ? __lock_acquire+0x518/0xc20 [ 27.010829][ C1] ? __rwlock_init+0x150/0x150 [ 27.010831][ C1] run_timer_softirq+0xf0/0x160 [ 27.010833][ C1] ? __run_timers+0xaa0/0xaa0 [ 27.010835][ C1] ? trace_irq_enable.constprop.0+0x9b/0x160 [ 27.010837][ C1] ? rcu_is_watching+0x16/0xd0 [ 27.010839][ C1] handle_softirqs+0x1d3/0x900 [ 27.010841][ C1] ? __lock_release.isra.0+0x69/0x1a0 [ 27.010842][ C1] ? _local_bh_enable+0xc0/0xc0 [ 27.010844][ C1] __irq_exit_rcu+0x145/0x1c0 [ 27.010846][ C1] irq_exit_rcu+0xe/0x30 [ 27.010847][ C1] sysvec_apic_timer_interrupt+0x9d/0xe0 [ 27.010850][ C1] [ 27.010851][ C1] [ 27.010851][ C1] ? lockdep_hardirqs_on+0x91/0x130 [ 27.010853][ C1] asm_sysvec_apic_timer_interrupt+0x1a/0x20 [ 27.010856][ C1] RIP: 0010:pv_native_safe_halt+0xf/0x10 [ 27.010858][ C1] Code: 48 8b 3d 94 f2 f5 01 e8 1f 00 00 00 48 2b 05 58 b3 95 00 c3 0f 1f 80 00 00 00 00 f3 0f 1e fa eb 07 0f 00 2d 13 a6 11 00 fb f4 0f 1f 40 d6 48 83 ec 20 8b 17 49 89 f8 83 e2 fe 41 89 d2 0f 01 [ 27.010860][ C1] RSP: 0018:ffa0000000147e00 EFLAGS: 00000282 [ 27.010863][ C1] RAX: 0000000000091bcd RBX: ff11000001bea380 RCX: ffffffff98af0307 [ 27.010865][ C1] RDX: ff11000001bea380 RSI: ffffffff9b838b1c RDI: ffffffff9b28d8e0 [ 27.010866][ C1] RBP: 0000000000000000 R08: 0000000000000000 R09: 0000000000000000 [ 27.010866][ C1] R10: 0000000000000001 R11: 0000000000000001 R12: 1ff4000000028fc3 [ 27.010867][ C1] R13: 0000000000000000 R14: dffffc0000000000 R15: 0000000000000000 [ 27.010869][ C1] ? cpuidle_idle_call.constprop.0+0x237/0x410 [ 27.010872][ C1] default_idle+0x9/0x10 [ 27.010874][ C1] default_idle_call+0x6e/0xb0 [ 27.010876][ C1] cpuidle_idle_call.constprop.0+0x237/0x410 [ 27.010877][ C1] ? arch_cpu_idle_exit+0x40/0x40 [ 27.010879][ C1] ? mark_tsc_async_resets+0x30/0x30 [ 27.010881][ C1] ? default_idle_call+0x98/0xb0 [ 27.010882][ C1] ? rcu_is_watching+0x16/0xd0 [ 27.010885][ C1] do_idle+0xd8/0x190 [ 27.010886][ C1] cpu_startup_entry+0x53/0x70 [ 27.010887][ C1] start_secondary+0x204/0x2b0 [ 27.010889][ C1] ? set_cpu_sibling_map+0x2130/0x2130 [ 27.010891][ C1] common_startup_64+0x13e/0x148 [ 27.010895][ C1] [ 27.029321][ C1] ======================================================== [ 27.029567][ C1] WARNING: possible irq lock inversion dependency detected [ 27.029768][ C1] 7.2.0-virtme #1 Tainted: G W [ 27.029981][ C1] -------------------------------------------------------- [ 27.030223][ C1] swapper/1/0 just changed the state of lock: [ 27.030402][ C1] ff1100000f68ae58 (&br->lock){+.-.}-{3:3}, at: br_forward_delay_timer_expired+0x44/0x5d0 [bridge] [ 27.030731][ C1] but this lock took another, SOFTIRQ-unsafe lock in the past: [ 27.030981][ C1] (fs_reclaim){+.+.}-{0:0} [ 27.030983][ C1] [ 27.030983][ C1] [ 27.030983][ C1] and interrupts could create inverse lock ordering between them. [ 27.030983][ C1] [ 27.031581][ C1] [ 27.031581][ C1] other info that might help us debug this: [ 27.031830][ C1] Chain exists of: [ 27.031830][ C1] &br->lock --> console_owner --> fs_reclaim [ 27.031830][ C1] [ 27.032182][ C1] Possible interrupt unsafe locking scenario: [ 27.032182][ C1] [ 27.032442][ C1] CPU0 CPU1 [ 27.032581][ C1] ---- ---- [ 27.032760][ C1] lock(fs_reclaim); [ 27.032866][ C1] local_irq_disable(); [ 27.033086][ C1] lock(&br->lock); [ 27.033263][ C1] lock(console_owner); [ 27.033479][ C1] [ 27.033589][ C1] lock(&br->lock); [ 27.033740][ C1] [ 27.033740][ C1] *** DEADLOCK *** [ 27.033740][ C1] [ 27.033941][ C1] locks held by swapper/1/0: 1, last CPU#1: [ 27.034160][ C1] #0: ffa00000001d0c90 ((&p->forward_delay_timer)){+.-.}-{0:0}, at: call_timer_fn+0x110/0x4d0 [ 27.034489][ C1] [ 27.034489][ C1] the shortest dependencies between 2nd lock and 1st lock: [ 27.034772][ C1] -> (fs_reclaim){+.+.}-{0:0} { [ 27.034915][ C1] HARDIRQ-ON-W at: [ 27.035066][ C1] __lock_acquire+0x388/0xc20 [ 27.035246][ C1] lock_acquire.part.0+0xd4/0x280 [ 27.035462][ C1] fs_reclaim_acquire+0xd5/0x120 [ 27.035683][ C1] __kmalloc_cache_noprof+0x6e/0x620 [ 27.035888][ C1] kthread_create_worker_on_node+0xea/0x210 [ 27.036138][ C1] workqueue_init+0x2a/0x680 [ 27.036361][ C1] kernel_init_freeable+0x2fe/0x630 [ 27.036614][ C1] kernel_init+0x21/0x150 [ 27.036784][ C1] ret_from_fork+0x474/0x6b0 [ 27.037009][ C1] ret_from_fork_asm+0x11/0x20 [ 27.037181][ C1] SOFTIRQ-ON-W at: [ 27.037333][ C1] __lock_acquire+0x388/0xc20 [ 27.037507][ C1] lock_acquire.part.0+0xd4/0x280 [ 27.037725][ C1] fs_reclaim_acquire+0xd5/0x120 [ 27.037945][ C1] __kmalloc_cache_noprof+0x6e/0x620 [ 27.038151][ C1] kthread_create_worker_on_node+0xea/0x210 [ 27.038405][ C1] workqueue_init+0x2a/0x680 [ 27.038620][ C1] kernel_init_freeable+0x2fe/0x630 [ 27.038872][ C1] kernel_init+0x21/0x150 [ 27.039045][ C1] ret_from_fork+0x474/0x6b0 [ 27.039266][ C1] ret_from_fork_asm+0x11/0x20 [ 27.039438][ C1] INITIAL USE at: [ 27.039587][ C1] __lock_acquire+0x388/0xc20 [ 27.039758][ C1] lock_acquire.part.0+0xd4/0x280 [ 27.039979][ C1] fs_reclaim_acquire+0xd5/0x120 [ 27.040198][ C1] __kmalloc_cache_noprof+0x6e/0x620 [ 27.040406][ C1] kthread_create_worker_on_node+0xea/0x210 [ 27.040653][ C1] workqueue_init+0x2a/0x680 [ 27.040872][ C1] kernel_init_freeable+0x2fe/0x630 [ 27.041040][ C1] kernel_init+0x21/0x150 [ 27.041257][ C1] ret_from_fork+0x474/0x6b0 [ 27.041471][ C1] ret_from_fork_asm+0x11/0x20 [ 27.041644][ C1] } [ 27.041762][ C1] ... key at: [] __fs_reclaim_map+0x0/0xbe0 [ 27.041968][ C1] ... acquired at: [ 27.042120][ C1] __lock_acquire+0x518/0xc20 [ 27.042263][ C1] lock_acquire.part.0+0xd4/0x280 [ 27.042443][ C1] fs_reclaim_acquire+0xd5/0x120 [ 27.042577][ C1] __kmalloc_noprof+0xd3/0x760 [ 27.042760][ C1] alloc_buf.isra.0+0x4b/0x260 [ 27.042897][ C1] put_chars+0x1e1/0x2f0 [ 27.043078][ C1] hvc_console_print+0x292/0x780 [ 27.043212][ C1] console_emit_next_record+0x22f/0x4c0 [ 27.043402][ C1] console_flush_one_record+0x46f/0x710 [ 27.043536][ C1] console_unlock+0xee/0x1f0 [ 27.043716][ C1] vprintk_emit+0x37c/0x3e0 [ 27.043850][ C1] _printk+0xc7/0x100 [ 27.044000][ C1] sock_register+0x12d/0x290 [ 27.044137][ C1] inet6_init+0x1a6/0x3e0 [ 27.044324][ C1] do_one_initcall+0x124/0x4f0 [ 27.044459][ C1] kernel_init_freeable+0x596/0x630 [ 27.044641][ C1] kernel_init+0x21/0x150 [ 27.044777][ C1] ret_from_fork+0x474/0x6b0 [ 27.044957][ C1] ret_from_fork_asm+0x11/0x20 [ 27.045093][ C1] [ 27.045167][ C1] -> (console_owner){....}-{0:0} { [ 27.045357][ C1] INITIAL USE at: [ 27.045459][ C1] } [ 27.045529][ C1] ... key at: [] console_owner_dep_map+0x0/0x60 [ 27.045793][ C1] ... acquired at: [ 27.045941][ C1] __lock_acquire+0x518/0xc20 [ 27.046077][ C1] lock_acquire.part.0+0xd4/0x280 [ 27.046263][ C1] console_lock_spinning_enable+0x5c/0x60 [ 27.046432][ C1] console_emit_next_record+0x1d1/0x4c0 [ 27.046614][ C1] console_flush_one_record+0x46f/0x710 [ 27.046749][ C1] console_unlock+0xee/0x1f0 [ 27.046930][ C1] vprintk_emit+0x37c/0x3e0 [ 27.047065][ C1] _printk+0xc7/0x100 [ 27.047217][ C1] br_set_state+0x22f/0x430 [bridge] [ 27.047362][ C1] br_init_port+0xc4/0x200 [bridge] [ 27.047547][ C1] br_stp_enable_port+0x12/0x50 [bridge] [ 27.047719][ C1] br_port_carrier_check+0x220/0x430 [bridge] [ 27.047946][ C1] br_device_event+0x52d/0x8f0 [bridge] [ 27.048084][ C1] notifier_call_chain+0xae/0x300 [ 27.048271][ C1] netif_state_change+0x139/0x340 [ 27.048407][ C1] __linkwatch_run_queue+0x34c/0x750 [ 27.048588][ C1] linkwatch_event+0x7f/0xb0 [ 27.048721][ C1] process_one_work+0xe3e/0x1560 [ 27.048906][ C1] worker_thread+0x4f1/0xd60 [ 27.049041][ C1] kthread+0x367/0x460 [ 27.049188][ C1] ret_from_fork+0x474/0x6b0 [ 27.049327][ C1] ret_from_fork_asm+0x11/0x20 [ 27.049505][ C1] [ 27.049573][ C1] -> (&br->lock){+.-.}-{3:3} { [ 27.049712][ C1] HARDIRQ-ON-W at: [ 27.049863][ C1] __lock_acquire+0x388/0xc20 [ 27.050034][ C1] lock_acquire.part.0+0xd4/0x280 [ 27.050255][ C1] _raw_spin_lock_bh+0x38/0x50 [ 27.050476][ C1] recalculate_group_addr+0x51/0x120 [bridge] [ 27.050687][ C1] br_vlan_filter_toggle+0x85/0x110 [bridge] [ 27.050943][ C1] br_changelink+0x575/0x16e0 [bridge] [ 27.051166][ C1] br_dev_newlink+0xeb/0x160 [bridge] [ 27.051348][ C1] rtnl_newlink_create+0x2d0/0x750 [ 27.051574][ C1] __rtnl_newlink+0x22b/0xa50 [ 27.051793][ C1] rtnl_newlink+0x9f1/0x11c0 [ 27.051961][ C1] rtnetlink_rcv_msg+0x6fd/0xbd0 [ 27.052175][ C1] netlink_rcv_skb+0x14e/0x3a0 [ 27.052401][ C1] netlink_unicast+0x486/0x750 [ 27.052574][ C1] netlink_sendmsg+0x735/0xc60 [ 27.052794][ C1] ____sys_sendmsg+0x415/0x880 [ 27.052969][ C1] ___sys_sendmsg+0x14e/0x1d0 [ 27.053188][ C1] __sys_sendmsg+0x12c/0x1d0 [ 27.053411][ C1] do_syscall_64+0xff/0x530 [ 27.053583][ C1] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 27.053837][ C1] IN-SOFTIRQ-W at: [ 27.053939][ C1] __lock_acquire+0x388/0xc20 [ 27.054157][ C1] lock_acquire.part.0+0xd4/0x280 [ 27.054382][ C1] _raw_spin_lock+0x33/0x40 [ 27.054551][ C1] br_forward_delay_timer_expired+0x44/0x5d0 [bridge] [ 27.054814][ C1] call_timer_fn+0x160/0x4d0 [ 27.055037][ C1] __run_timers+0x68f/0xaa0 [ 27.055206][ C1] run_timer_softirq+0xf0/0x160 [ 27.055426][ C1] handle_softirqs+0x1d3/0x900 [ 27.055645][ C1] __irq_exit_rcu+0x145/0x1c0 [ 27.055816][ C1] irq_exit_rcu+0xe/0x30 [ 27.056035][ C1] sysvec_apic_timer_interrupt+0x9d/0xe0 [ 27.056291][ C1] asm_sysvec_apic_timer_interrupt+0x1a/0x20 [ 27.056494][ C1] pv_native_safe_halt+0xf/0x10 [ 27.056708][ C1] default_idle+0x9/0x10 [ 27.056931][ C1] default_idle_call+0x6e/0xb0 [ 27.057102][ C1] cpuidle_idle_call.constprop.0+0x237/0x410 [ 27.057358][ C1] do_idle+0xd8/0x190 [ 27.057497][ C1] cpu_startup_entry+0x53/0x70 [ 27.057713][ C1] start_secondary+0x204/0x2b0 [ 27.057931][ C1] common_startup_64+0x13e/0x148 [ 27.058102][ C1] INITIAL USE at: [ 27.058254][ C1] __lock_acquire+0x388/0xc20 [ 27.058425][ C1] lock_acquire.part.0+0xd4/0x280 [ 27.058599][ C1] _raw_spin_lock_bh+0x38/0x50 [ 27.058819][ C1] recalculate_group_addr+0x51/0x120 [bridge] [ 27.059028][ C1] br_vlan_filter_toggle+0x85/0x110 [bridge] [ 27.059285][ C1] br_changelink+0x575/0x16e0 [bridge] [ 27.059509][ C1] br_dev_newlink+0xeb/0x160 [bridge] [ 27.059682][ C1] rtnl_newlink_create+0x2d0/0x750 [ 27.059898][ C1] __rtnl_newlink+0x22b/0xa50 [ 27.060113][ C1] rtnl_newlink+0x9f1/0x11c0 [ 27.060287][ C1] rtnetlink_rcv_msg+0x6fd/0xbd0 [ 27.060504][ C1] netlink_rcv_skb+0x14e/0x3a0 [ 27.060678][ C1] netlink_unicast+0x486/0x750 [ 27.060898][ C1] netlink_sendmsg+0x735/0xc60 [ 27.061113][ C1] ____sys_sendmsg+0x415/0x880 [ 27.061289][ C1] ___sys_sendmsg+0x14e/0x1d0 [ 27.061504][ C1] __sys_sendmsg+0x12c/0x1d0 [ 27.061719][ C1] do_syscall_64+0xff/0x530 [ 27.061890][ C1] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 27.062141][ C1] } [ 27.062210][ C1] ... key at: [] __key.7+0x0/0x40 [bridge] [ 27.062465][ C1] ... acquired at: [ 27.062566][ C1] mark_lock+0x1d7/0xa00 [ 27.062748][ C1] mark_usage+0x42/0x170 [ 27.062885][ C1] __lock_acquire+0x388/0xc20 [ 27.063063][ C1] lock_acquire.part.0+0xd4/0x280 [ 27.063199][ C1] _raw_spin_lock+0x33/0x40 [ 27.063381][ C1] br_forward_delay_timer_expired+0x44/0x5d0 [bridge] [ 27.063553][ C1] call_timer_fn+0x160/0x4d0 [ 27.063733][ C1] __run_timers+0x68f/0xaa0 [ 27.063869][ C1] run_timer_softirq+0xf0/0x160 [ 27.064049][ C1] handle_softirqs+0x1d3/0x900 [ 27.064185][ C1] __irq_exit_rcu+0x145/0x1c0 [ 27.064371][ C1] irq_exit_rcu+0xe/0x30 [ 27.064506][ C1] sysvec_apic_timer_interrupt+0x9d/0xe0 [ 27.064721][ C1] asm_sysvec_apic_timer_interrupt+0x1a/0x20 [ 27.064933][ C1] pv_native_safe_halt+0xf/0x10 [ 27.069180][ C1] default_idle+0x9/0x10 [ 27.069376][ C1] default_idle_call+0x6e/0xb0 [ 27.069514][ C1] cpuidle_idle_call.constprop.0+0x237/0x410 [ 27.069729][ C1] do_idle+0xd8/0x190 [ 27.069831][ C1] cpu_startup_entry+0x53/0x70 [ 27.070013][ C1] start_secondary+0x204/0x2b0 [ 27.070151][ C1] common_startup_64+0x13e/0x148 [ 27.070335][ C1] [ 27.070405][ C1] [ 27.070405][ C1] stack backtrace: [ 27.070574][ C1] CPU: 1 UID: 0 PID: 0 Comm: swapper/1 Tainted: G W 7.2.0-virtme #1 PREEMPT(full) [ 27.070578][ C1] Tainted: [W]=WARN [ 27.070579][ C1] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 27.070580][ C1] Call Trace: [ 27.070581][ C1] [ 27.070583][ C1] dump_stack_lvl+0x6f/0xa0 [ 27.070587][ C1] print_irq_inversion_bug.part.0.cold+0xe6/0x143 [ 27.070591][ C1] mark_lock_irq+0x989/0x9c0 [ 27.070594][ C1] mark_lock+0x1d7/0xa00 [ 27.070596][ C1] mark_usage+0x42/0x170 [ 27.070598][ C1] __lock_acquire+0x388/0xc20 [ 27.070600][ C1] lock_acquire.part.0+0xd4/0x280 [ 27.070602][ C1] ? br_forward_delay_timer_expired+0x44/0x5d0 [bridge] [ 27.070610][ C1] ? rcu_is_watching+0x16/0xd0 [ 27.070613][ C1] ? lock_acquire+0x13c/0x160 [ 27.070615][ C1] ? br_message_age_timer_expired+0x70/0x70 [bridge] [ 27.070621][ C1] _raw_spin_lock+0x33/0x40 [ 27.070623][ C1] ? br_forward_delay_timer_expired+0x44/0x5d0 [bridge] [ 27.070630][ C1] br_forward_delay_timer_expired+0x44/0x5d0 [bridge] [ 27.070636][ C1] ? br_message_age_timer_expired+0x70/0x70 [bridge] [ 27.070642][ C1] call_timer_fn+0x160/0x4d0 [ 27.070645][ C1] ? detach_if_pending+0x1d0/0x1d0 [ 27.070647][ C1] ? debug_object_active_state+0x430/0x430 [ 27.070650][ C1] ? find_held_lock+0x2b/0x80 [ 27.070652][ C1] ? __lock_release.isra.0+0x69/0x1a0 [ 27.070654][ C1] ? rcu_is_watching+0x16/0xd0 [ 27.070656][ C1] __run_timers+0x68f/0xaa0 [ 27.070658][ C1] ? br_message_age_timer_expired+0x70/0x70 [bridge] [ 27.070665][ C1] ? __bpf_trace_itimer_expire+0x10/0x10 [ 27.070666][ C1] ? __lock_acquire+0x518/0xc20 [ 27.070669][ C1] ? __rwlock_init+0x150/0x150 [ 27.070671][ C1] run_timer_softirq+0xf0/0x160 [ 27.070673][ C1] ? __run_timers+0xaa0/0xaa0 [ 27.070675][ C1] ? trace_irq_enable.constprop.0+0x9b/0x160 [ 27.070677][ C1] ? rcu_is_watching+0x16/0xd0 [ 27.070679][ C1] handle_softirqs+0x1d3/0x900 [ 27.070682][ C1] ? __lock_release.isra.0+0x69/0x1a0 [ 27.070683][ C1] ? _local_bh_enable+0xc0/0xc0 [ 27.070685][ C1] __irq_exit_rcu+0x145/0x1c0 [ 27.070687][ C1] irq_exit_rcu+0xe/0x30 [ 27.070688][ C1] sysvec_apic_timer_interrupt+0x9d/0xe0 [ 27.070690][ C1] [ 27.070691][ C1] [ 27.070691][ C1] ? lockdep_hardirqs_on+0x91/0x130 [ 27.070693][ C1] asm_sysvec_apic_timer_interrupt+0x1a/0x20 [ 27.070695][ C1] RIP: 0010:pv_native_safe_halt+0xf/0x10 [ 27.070698][ C1] Code: 48 8b 3d 94 f2 f5 01 e8 1f 00 00 00 48 2b 05 58 b3 95 00 c3 0f 1f 80 00 00 00 00 f3 0f 1e fa eb 07 0f 00 2d 13 a6 11 00 fb f4 0f 1f 40 d6 48 83 ec 20 8b 17 49 89 f8 83 e2 fe 41 89 d2 0f 01 [ 27.070699][ C1] RSP: 0018:ffa0000000147e00 EFLAGS: 00000282 [ 27.070701][ C1] RAX: 0000000000091bcd RBX: ff11000001bea380 RCX: ffffffff98af0307 [ 27.070703][ C1] RDX: ff11000001bea380 RSI: ffffffff9b838b1c RDI: ffffffff9b28d8e0 [ 27.070703][ C1] RBP: 0000000000000000 R08: 0000000000000000 R09: 0000000000000000 [ 27.070704][ C1] R10: 0000000000000001 R11: 0000000000000001 R12: 1ff4000000028fc3 [ 27.070705][ C1] R13: 0000000000000000 R14: dffffc0000000000 R15: 0000000000000000 [ 27.070707][ C1] ? cpuidle_idle_call.constprop.0+0x237/0x410 [ 27.070709][ C1] default_idle+0x9/0x10 [ 27.070710][ C1] default_idle_call+0x6e/0xb0 [ 27.070712][ C1] cpuidle_idle_call.constprop.0+0x237/0x410 [ 27.070714][ C1] ? arch_cpu_idle_exit+0x40/0x40 [ 27.070715][ C1] ? mark_tsc_async_resets+0x30/0x30 [ 27.070717][ C1] ? default_idle_call+0x98/0xb0 [ 27.070719][ C1] ? rcu_is_watching+0x16/0xd0 [ 27.070721][ C1] do_idle+0xd8/0x190 [ 27.070722][ C1] cpu_startup_entry+0x53/0x70 [ 27.070724][ C1] start_secondary+0x204/0x2b0 [ 27.070725][ C1] ? set_cpu_sibling_map+0x2130/0x2130 [ 27.070727][ C1] common_startup_64+0x13e/0x148 [ 27.070730][ C1] [ 58.356719][ T535] Mirror/redirect action on [ 58.356732][ T535] BUG: sleeping function called from invalid context at ./include/linux/sched/mm.h:322 [ 58.356734][ T535] in_atomic(): 1, irqs_disabled(): 1, non_block: 0, pid: 535, name: modprobe [ 58.356736][ T535] preempt_count: 1, expected: 0 [ 58.356737][ T535] RCU nest depth: 0, expected: 0 [ 58.356738][ T535] INFO: lockdep is turned off. [ 58.356739][ T535] irq event stamp: 0 [ 58.356739][ T535] hardirqs last enabled at (0): [<0000000000000000>] 0x0 [ 58.356743][ T535] hardirqs last disabled at (0): [] copy_process+0x1ccd/0x6240 [ 58.356749][ T535] softirqs last enabled at (0): [] copy_process+0x1d21/0x6240 [ 58.356751][ T535] softirqs last disabled at (0): [<0000000000000000>] 0x0 [ 58.356752][ T535] Preemption disabled at: [ 58.356753][ T535] [] vprintk_emit+0x31b/0x3e0 [ 58.356760][ T535] CPU: 0 UID: 0 PID: 535 Comm: modprobe Tainted: G W 7.2.0-virtme #1 PREEMPT(full) [ 58.356764][ T535] Tainted: [W]=WARN [ 58.356765][ T535] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 58.356766][ T535] Call Trace: [ 58.356768][ T535] [ 58.356769][ T535] dump_stack_lvl+0x6f/0xa0 [ 58.356774][ T535] ? vprintk_emit+0x31b/0x3e0 [ 58.356776][ T535] __might_resched.cold+0x1fe/0x2c1 [ 58.356780][ T535] ? prb_next_reserve_seq+0x2d0/0x2d0 [ 58.356782][ T535] ? perf_trace_sched_switch+0x7c0/0x7c0 [ 58.356785][ T535] ? rcu_is_watching+0x16/0xd0 [ 58.356788][ T535] __kmalloc_noprof+0x443/0x760 [ 58.356792][ T535] ? __rwlock_init+0x150/0x150 [ 58.356794][ T535] ? alloc_buf.isra.0+0x4b/0x260 [ 58.356798][ T535] ? do_raw_spin_unlock+0x59/0x250 [ 58.356800][ T535] alloc_buf.isra.0+0x4b/0x260 [ 58.356802][ T535] put_chars+0x1e1/0x2f0 [ 58.356803][ T535] ? __send_to_port+0x420/0x420 [ 58.356805][ T535] ? console_prepend_replay+0x20/0x20 [ 58.356808][ T535] hvc_console_print+0x292/0x780 [ 58.356811][ T535] ? hvc_write+0x3a0/0x3a0 [ 58.356812][ T535] ? vsnprintf+0x668/0x1700 [ 58.356815][ T535] ? __rwlock_init+0x150/0x150 [ 58.356817][ T535] ? rcu_is_watching+0x16/0xd0 [ 58.356819][ T535] ? rcu_is_watching+0x16/0xd0 [ 58.356821][ T535] console_emit_next_record+0x22f/0x4c0 [ 58.356823][ T535] ? devkmsg_read+0x4b0/0x4b0 [ 58.356825][ T535] ? rcu_is_watching+0x16/0xd0 [ 58.356827][ T535] ? rcu_is_watching+0x16/0xd0 [ 58.356828][ T535] ? rcu_is_watching+0x16/0xd0 [ 58.356830][ T535] ? lock_acquire+0x13c/0x160 [ 58.356832][ T535] ? console_flush_one_record+0x111/0x710 [ 58.356834][ T535] console_flush_one_record+0x46f/0x710 [ 58.356836][ T535] ? console_emit_next_record+0x4c0/0x4c0 [ 58.356838][ T535] console_unlock+0xee/0x1f0 [ 58.356840][ T535] ? lock_acquire+0x13c/0x160 [ 58.356841][ T535] ? console_flush_one_record+0x710/0x710 [ 58.356843][ T535] ? rcu_is_watching+0x16/0xd0 [ 58.356845][ T535] ? lock_release+0x184/0x1f0 [ 58.356846][ T535] ? lock_acquire+0x60/0x160 [ 58.356847][ T535] ? __rcu_read_lock+0x30/0x70 [ 58.356849][ T535] ? __down_trylock_console_sem+0x5e/0xa0 [ 58.356851][ T535] ? vprintk_emit+0x320/0x3e0 [ 58.356853][ T535] vprintk_emit+0x37c/0x3e0 [ 58.356856][ T535] ? wake_up_klogd_work_func+0x90/0x90 [ 58.356858][ T535] ? netdev_run_todo+0x2a8/0xfd0 [ 58.356862][ T535] ? mirred_device_event+0x3d/0x1d0 [act_mirred] [ 58.356864][ T535] ? rcu_is_watching+0x16/0xd0 [ 58.356867][ T535] ? llc_exit+0x3e0/0x3e0 [llc] [ 58.356869][ T535] _printk+0xc7/0x100 [ 58.356872][ T535] ? snapshot_read.cold+0x21/0x21 [ 58.356873][ T535] ? rcu_is_watching+0x16/0xd0 [ 58.356875][ T535] ? llc_exit+0x3e0/0x3e0 [llc] [ 58.356876][ T535] ? __up_write+0x23d/0x5f0 [ 58.356878][ T535] ? __up_write+0x2e5/0x5f0 [ 58.356879][ T535] ? lock_release+0x184/0x1f0 [ 58.356881][ T535] ? __up_write+0x2c7/0x5f0 [ 58.356882][ T535] mirred_init_module+0x28/0x1000 [act_mirred] [ 58.356885][ T535] do_one_initcall+0x124/0x4f0 [ 58.356887][ T535] ? trace_event_raw_event_initcall_level+0x280/0x280 [ 58.356889][ T535] ? do_init_module+0xae/0x8a0 [ 58.356892][ T535] ? kasan_unpoison+0x44/0x70 [ 58.356895][ T535] do_init_module+0x2ad/0x8a0 [ 58.356897][ T535] ? free_module+0x470/0x470 [ 58.356899][ T535] ? kfree+0x123/0x590 [ 58.356901][ T535] load_module+0x1424/0x1bb0 [ 58.356904][ T535] ? layout_and_allocate.isra.0+0x680/0x680 [ 58.356907][ T535] ? __ia32_sys_fsconfig+0x180/0x180 [ 58.356909][ T535] ? ovl_real_file+0x172/0x1e0 [ 58.356912][ T535] ? backing_file_read_iter+0x541/0x790 [ 58.356915][ T535] init_module_from_file+0x11f/0x1a0 [ 58.356917][ T535] ? __do_sys_init_module+0x220/0x220 [ 58.356920][ T535] ? ovl_mmap+0x270/0x270 [ 58.356922][ T535] ? __rwlock_init+0x150/0x150 [ 58.356924][ T535] ? rcu_is_watching+0x16/0xd0 [ 58.356926][ T535] ? lock_release+0x184/0x1f0 [ 58.356927][ T535] ? do_raw_spin_unlock+0x59/0x250 [ 58.356929][ T535] idempotent_init_module+0x37b/0x7c0 [ 58.356931][ T535] ? init_module_from_file+0x1a0/0x1a0 [ 58.356933][ T535] ? rcu_is_watching+0x16/0xd0 [ 58.356935][ T535] ? cap_capable+0x1d7/0x3d0 [ 58.356939][ T535] __x64_sys_finit_module+0xdf/0x190 [ 58.356941][ T535] ? trace_irq_enable.constprop.0+0x9b/0x160 [ 58.356943][ T535] do_syscall_64+0xff/0x530 [ 58.356945][ T535] ? exc_page_fault+0xee/0x100 [ 58.356947][ T535] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 58.356949][ T535] RIP: 0033:0x7f341c9c237d [ 58.356951][ T535] 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 [ 58.356953][ T535] RSP: 002b:00007ffd181447e8 EFLAGS: 00000246 ORIG_RAX: 0000000000000139 [ 58.356956][ T535] RAX: ffffffffffffffda RBX: 000055fe0e651810 RCX: 00007f341c9c237d [ 58.356958][ T535] RDX: 0000000000000000 RSI: 000055fdfa72fffd RDI: 0000000000000000 [ 58.356958][ T535] RBP: 00007ffd18144880 R08: 0000000000000000 R09: 0000000000000000 [ 58.356959][ T535] R10: 0000000000000000 R11: 0000000000000246 R12: 000055fdfa72fffd [ 58.356960][ T535] R13: 000055fe0e651960 R14: 0000000000040000 R15: 0000000000000000 [ 58.356962][ T535] [ 64.701066][ T576] br0: port 2(veth2) entered disabled state [ 64.701086][ T576] BUG: sleeping function called from invalid context at ./include/linux/sched/mm.h:322 [ 64.701088][ T576] in_atomic(): 1, irqs_disabled(): 1, non_block: 0, pid: 576, name: ip [ 64.701090][ T576] preempt_count: 202, expected: 0 [ 64.701091][ T576] RCU nest depth: 0, expected: 0 [ 64.701093][ T576] INFO: lockdep is turned off. [ 64.701094][ T576] irq event stamp: 0 [ 64.701095][ T576] hardirqs last enabled at (0): [<0000000000000000>] 0x0 [ 64.701101][ T576] hardirqs last disabled at (0): [] copy_process+0x1ccd/0x6240 [ 64.701108][ T576] softirqs last enabled at (0): [] copy_process+0x1d21/0x6240 [ 64.701111][ T576] softirqs last disabled at (0): [<0000000000000000>] 0x0 [ 64.701113][ T576] Preemption disabled at: [ 64.701114][ T576] [<0000000000000000>] 0x0 [ 64.701120][ T576] CPU: 0 UID: 0 PID: 576 Comm: ip Tainted: G W 7.2.0-virtme #1 PREEMPT(full) [ 64.701125][ T576] Tainted: [W]=WARN [ 64.701126][ T576] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 64.701128][ T576] Call Trace: [ 64.701129][ T576] [ 64.701131][ T576] dump_stack_lvl+0x6f/0xa0 [ 64.701137][ T576] __might_resched.cold+0x1fe/0x2c1 [ 64.701142][ T576] ? perf_trace_sched_switch+0x7c0/0x7c0 [ 64.701146][ T576] ? rcu_is_watching+0x16/0xd0 [ 64.701151][ T576] __kmalloc_noprof+0x443/0x760 [ 64.701155][ T576] ? __rwlock_init+0x150/0x150 [ 64.701158][ T576] ? alloc_buf.isra.0+0x4b/0x260 [ 64.701162][ T576] ? do_raw_spin_unlock+0x59/0x250 [ 64.701164][ T576] alloc_buf.isra.0+0x4b/0x260 [ 64.701165][ T576] put_chars+0x1e1/0x2f0 [ 64.701167][ T576] ? __send_to_port+0x420/0x420 [ 64.701169][ T576] ? printk_get_next_message+0x240/0x650 [ 64.701173][ T576] hvc_console_print+0x292/0x780 [ 64.701176][ T576] ? hvc_write+0x3a0/0x3a0 [ 64.701178][ T576] ? __rwlock_init+0x150/0x150 [ 64.701179][ T576] ? rcu_is_watching+0x16/0xd0 [ 64.701181][ T576] ? lock_acquire+0x13c/0x160 [ 64.701183][ T576] console_emit_next_record+0x22f/0x4c0 [ 64.701186][ T576] ? devkmsg_read+0x4b0/0x4b0 [ 64.701187][ T576] ? rcu_is_watching+0x16/0xd0 [ 64.701189][ T576] ? rcu_is_watching+0x16/0xd0 [ 64.701191][ T576] ? rcu_is_watching+0x16/0xd0 [ 64.701192][ T576] ? lock_acquire+0x13c/0x160 [ 64.701194][ T576] ? console_flush_one_record+0x111/0x710 [ 64.701196][ T576] console_flush_one_record+0x46f/0x710 [ 64.701198][ T576] ? console_emit_next_record+0x4c0/0x4c0 [ 64.701201][ T576] console_unlock+0xee/0x1f0 [ 64.701202][ T576] ? lock_acquire+0x13c/0x160 [ 64.701204][ T576] ? console_flush_one_record+0x710/0x710 [ 64.701205][ T576] ? rcu_is_watching+0x16/0xd0 [ 64.701207][ T576] ? lock_release+0x184/0x1f0 [ 64.701208][ T576] ? lock_acquire+0x60/0x160 [ 64.701210][ T576] ? __rcu_read_lock+0x30/0x70 [ 64.701212][ T576] ? __down_trylock_console_sem+0x5e/0xa0 [ 64.701214][ T576] ? vprintk_emit+0x320/0x3e0 [ 64.701216][ T576] vprintk_emit+0x37c/0x3e0 [ 64.701218][ T576] ? wake_up_klogd_work_func+0x90/0x90 [ 64.701220][ T576] ? rcu_is_watching+0x16/0xd0 [ 64.701221][ T576] ? trace_irq_enable.constprop.0+0x9b/0x160 [ 64.701224][ T576] ? trace_hardirqs_on+0x36/0x40 [ 64.701225][ T576] _printk+0xc7/0x100 [ 64.701228][ T576] ? snapshot_read.cold+0x21/0x21 [ 64.701230][ T576] ? ipv6_mc_down+0x17e/0x2d0 [ 64.701235][ T576] br_set_state+0x22f/0x430 [bridge] [ 64.701248][ T576] br_stp_disable_port+0x11f/0x390 [bridge] [ 64.701256][ T576] br_device_event+0x7b5/0x8f0 [bridge] [ 64.701264][ T576] ? _raw_spin_unlock_irqrestore+0x40/0x80 [ 64.701267][ T576] ? _sub_I_65535_1+0x4d0/0x4d0 [stp] [ 64.701270][ T576] ? addrconf_notify+0x2c8/0xf30 [ 64.701273][ T576] notifier_call_chain+0xae/0x300 [ 64.701277][ T576] __dev_notify_flags+0x23c/0x3c0 [ 64.701281][ T576] ? trace_irq_enable.constprop.0+0x9b/0x160 [ 64.701282][ T576] ? netif_change_name+0x8c0/0x8c0 [ 64.701284][ T576] ? netif_set_allmulti+0x250/0x250 [ 64.701286][ T576] ? __kernel_text_address+0x12/0x30 [ 64.701288][ T576] ? write_profile+0xf0/0xf0 [ 64.701290][ T576] ? unwind_get_return_address+0x67/0xd0 [ 64.701293][ T576] netif_change_flags+0xfe/0x190 [ 64.701296][ T576] do_setlink.isra.0+0x1cc3/0x2750 [ 64.701299][ T576] ? stack_trace_save+0x93/0xc0 [ 64.701300][ T576] ? rtnl_link_get_size+0x350/0x350 [ 64.701301][ T576] ? rcu_is_watching+0x16/0xd0 [ 64.701303][ T576] ? stack_depot_save_flags+0x1bc/0x790 [ 64.701306][ T576] ? kasan_save_stack+0x3d/0x50 [ 64.701309][ T576] ? kasan_save_stack+0x2f/0x50 [ 64.701311][ T576] ? kasan_save_track+0x14/0x30 [ 64.701312][ T576] ? __kasan_kmalloc+0x7b/0x90 [ 64.701314][ T576] ? __kmalloc_cache_noprof+0x29a/0x620 [ 64.701316][ T576] ? rtnl_newlink+0x124/0x11c0 [ 64.701318][ T576] ? rtnetlink_rcv_msg+0x6fd/0xbd0 [ 64.701319][ T576] ? netlink_rcv_skb+0x14e/0x3a0 [ 64.701323][ T576] ? netlink_unicast+0x486/0x750 [ 64.701325][ T576] ? netlink_sendmsg+0x735/0xc60 [ 64.701327][ T576] ? ____sys_sendmsg+0x415/0x880 [ 64.701330][ T576] ? ___sys_sendmsg+0x14e/0x1d0 [ 64.701332][ T576] ? __sys_sendmsg+0x12c/0x1d0 [ 64.701334][ T576] ? do_syscall_64+0xff/0x530 [ 64.701337][ T576] ? entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 64.701340][ T576] ? rcu_is_watching+0x16/0xd0 [ 64.701343][ T576] ? lock_acquire+0x13c/0x160 [ 64.701344][ T576] ? rcu_is_watching+0x16/0xd0 [ 64.701346][ T576] ? rcu_is_watching+0x16/0xd0 [ 64.701348][ T576] ? trace_contention_end+0xb3/0x180 [ 64.701351][ T576] ? __mutex_lock+0x1db/0x1ea0 [ 64.701352][ T576] ? __mutex_lock+0x9a3/0x1ea0 [ 64.701354][ T576] ? rtnl_newlink+0x9a8/0x11c0 [ 64.701355][ T576] ? ww_mutex_lock+0x160/0x160 [ 64.701357][ T576] ? __rtnl_newlink+0x3fa/0xa50 [ 64.701359][ T576] rtnl_newlink+0x9f1/0x11c0 [ 64.701361][ T576] ? rcu_is_watching+0x16/0xd0 [ 64.701363][ T576] ? rtnl_bridge_getlink+0x850/0x850 [ 64.701364][ T576] ? lock_acquire+0x13c/0x160 [ 64.701366][ T576] ? rcu_is_watching+0x16/0xd0 [ 64.701368][ T576] ? is_bpf_text_address+0x3e/0x110 [ 64.701371][ T576] ? is_bpf_text_address+0x72/0x110 [ 64.701373][ T576] ? kernel_text_address+0x149/0x170 [ 64.701374][ T576] ? __kernel_text_address+0x12/0x30 [ 64.701375][ T576] ? write_profile+0xf0/0xf0 [ 64.701376][ T576] ? unwind_get_return_address+0x67/0xd0 [ 64.701377][ T576] ? rcu_is_watching+0x16/0xd0 [ 64.701379][ T576] ? rcu_is_watching+0x16/0xd0 [ 64.701381][ T576] ? cap_capable+0x1d7/0x3d0 [ 64.701384][ T576] ? lock_acquire+0x13c/0x160 [ 64.701386][ T576] ? rcu_is_watching+0x16/0xd0 [ 64.701387][ T576] ? rtnl_bridge_getlink+0x850/0x850 [ 64.701389][ T576] rtnetlink_rcv_msg+0x6fd/0xbd0 [ 64.701390][ T576] ? rtnl_link_fill+0x920/0x920 [ 64.701392][ T576] ? filter_irq_stacks+0xd0/0xd0 [ 64.701393][ T576] ? stack_depot_save_flags+0x1bc/0x790 [ 64.701395][ T576] netlink_rcv_skb+0x14e/0x3a0 [ 64.701397][ T576] ? rtnl_link_fill+0x920/0x920 [ 64.701398][ T576] ? lock_release+0x184/0x1f0 [ 64.701399][ T576] ? netlink_ack+0xcf0/0xcf0 [ 64.701401][ T576] ? __netlink_lookup+0xb9/0x6b0 [ 64.701403][ T576] ? rcu_is_watching+0x16/0xd0 [ 64.701405][ T576] ? lock_release+0x184/0x1f0 [ 64.701407][ T576] netlink_unicast+0x486/0x750 [ 64.701408][ T576] ? netlink_attachskb+0x810/0x810 [ 64.701410][ T576] ? rcu_is_watching+0x16/0xd0 [ 64.701412][ T576] ? rcu_is_watching+0x16/0xd0 [ 64.701413][ T576] ? lock_acquire+0x13c/0x160 [ 64.701415][ T576] netlink_sendmsg+0x735/0xc60 [ 64.701417][ T576] ? netlink_unicast+0x750/0x750 [ 64.701419][ T576] ? rcu_is_watching+0x16/0xd0 [ 64.701420][ T576] ? lock_release+0x184/0x1f0 [ 64.701422][ T576] ____sys_sendmsg+0x415/0x880 [ 64.701424][ T576] ? copy_msghdr_from_user+0x279/0x420 [ 64.701425][ T576] ? get_timestamp.constprop.0+0x390/0x390 [ 64.701427][ T576] ? move_addr_to_kernel+0x40/0x40 [ 64.701428][ T576] ? filter_irq_stacks+0xd0/0xd0 [ 64.701431][ T576] ___sys_sendmsg+0x14e/0x1d0 [ 64.701432][ T576] ? copy_msghdr_from_user+0x420/0x420 [ 64.701437][ T576] __sys_sendmsg+0x12c/0x1d0 [ 64.701439][ T576] ? __sys_sendmsg_sock+0x20/0x20 [ 64.701442][ T576] ? rcu_is_watching+0x16/0xd0 [ 64.701444][ T576] do_syscall_64+0xff/0x530 [ 64.701445][ T576] ? exc_page_fault+0xee/0x100 [ 64.701447][ T576] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 64.701448][ T576] RIP: 0033:0x7f288214e54e [ 64.701450][ T576] 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 [ 64.701452][ T576] RSP: 002b:00007ffcd0099860 EFLAGS: 00000202 ORIG_RAX: 000000000000002e [ 64.701456][ T576] RAX: ffffffffffffffda RBX: 0000000000000003 RCX: 00007f288214e54e [ 64.701457][ T576] RDX: 0000000000000000 RSI: 00007ffcd0099910 RDI: 0000000000000005 [ 64.701458][ T576] RBP: 00007ffcd0099870 R08: 0000000000000000 R09: 0000000000000000 [ 64.701459][ T576] R10: 0000000000000000 R11: 0000000000000202 R12: 000000006a90d942 [ 64.701460][ T576] R13: 00000000004a1620 R14: 0000000000000000 R15: 00007ffcd0099fd0 [ 64.701462][ T576] [ 64.733515][ T576] ip (576) used greatest stack depth: 23016 bytes left [ 64.751232][ T577] br0: port 1(veth1) entered disabled state [ 64.771828][ T578] veth2: left allmulticast mode [ 64.771997][ T578] veth2: left promiscuous mode [ 64.772209][ T578] br0: port 2(veth2) entered disabled state [ 64.772770][ T578] veth1: left allmulticast mode [ 64.772907][ T578] veth1: left promiscuous mode [ 64.773107][ T578] br0: port 1(veth1) entered disabled state