[ 11.288675][ T223] 8021q: 802.1Q VLAN Support v1.8 [ 11.288696][ T223] BUG: sleeping function called from invalid context at ./include/linux/sched/mm.h:322 [ 11.288698][ T223] in_atomic(): 1, irqs_disabled(): 1, non_block: 0, pid: 223, name: modprobe [ 11.288700][ T223] preempt_count: 1, expected: 0 [ 11.288701][ T223] RCU nest depth: 0, expected: 0 [ 11.288702][ T223] locks held by modprobe/223: 4, last CPU#2: [ 11.288704][ T223] #0: ffffffffb0169cc0 (console_lock){+.+.}-{0:0}, at: vprintk_emit+0x320/0x3e0 [ 11.288717][ T223] #1: ffffffffb0169d38 (console_srcu){....}-{0:0}, at: console_flush_one_record+0x106/0x710 [ 11.288721][ T223] #2: ffffffffb0089660 (console_owner){....}-{0:0}, at: console_lock_spinning_enable+0x40/0x60 [ 11.288725][ T223] #3: ffffffffb0089560 (printk_legacy_map-wait-type-override){....}-{3:3}, at: console_emit_next_record+0x1df/0x4c0 [ 11.288730][ T223] irq event stamp: 28700 [ 11.288730][ T223] hardirqs last enabled at (28699): [] __down_trylock_console_sem+0x86/0xa0 [ 11.288733][ T223] hardirqs last disabled at (28700): [] console_emit_next_record+0x3d4/0x4c0 [ 11.288735][ T223] softirqs last enabled at (25144): [] handle_softirqs+0x67c/0x900 [ 11.288739][ T223] softirqs last disabled at (24507): [] __irq_exit_rcu+0x145/0x1c0 [ 11.288741][ T223] Preemption disabled at: [ 11.288741][ T223] [] vprintk_emit+0x31b/0x3e0 [ 11.288747][ T223] CPU: 2 UID: 0 PID: 223 Comm: modprobe Tainted: G W 7.2.0-virtme #1 PREEMPT(full) [ 11.288751][ T223] Tainted: [W]=WARN [ 11.288752][ T223] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 11.288754][ T223] Call Trace: [ 11.288755][ T223] [ 11.288757][ T223] dump_stack_lvl+0x6f/0xa0 [ 11.288763][ T223] ? vprintk_emit+0x31b/0x3e0 [ 11.288765][ T223] __might_resched.cold+0x1fe/0x2c1 [ 11.288770][ T223] ? perf_trace_sched_switch+0x7c0/0x7c0 [ 11.288774][ T223] ? __kmalloc_noprof+0xdb/0x760 [ 11.288779][ T223] __kmalloc_noprof+0x443/0x760 [ 11.288781][ T223] ? alloc_buf.isra.0+0x4b/0x260 [ 11.288788][ T223] ? do_raw_spin_unlock+0x59/0x250 [ 11.288790][ T223] alloc_buf.isra.0+0x4b/0x260 [ 11.288794][ T223] put_chars+0x1e1/0x2f0 [ 11.288797][ T223] ? __send_to_port+0x420/0x420 [ 11.288798][ T223] ? rcu_lockdep_current_cpu_online+0x3f/0x1b0 [ 11.288803][ T223] ? rcu_read_lock_any_held+0x3c/0x90 [ 11.288806][ T223] ? validate_chain+0x38b/0xc20 [ 11.288810][ T223] hvc_console_print+0x292/0x780 [ 11.288813][ T223] ? __lock_acquire+0x518/0xc20 [ 11.288819][ T223] ? hvc_write+0x3a0/0x3a0 [ 11.288821][ T223] ? rcu_is_watching+0x16/0xd0 [ 11.288827][ T223] console_emit_next_record+0x22f/0x4c0 [ 11.288831][ T223] ? devkmsg_read+0x4b0/0x4b0 [ 11.288833][ T223] ? console_flush_one_record+0x106/0x710 [ 11.288836][ T223] ? rcu_is_watching+0x16/0xd0 [ 11.288839][ T223] ? lock_acquire+0x13c/0x160 [ 11.288843][ T223] console_flush_one_record+0x46f/0x710 [ 11.288847][ T223] ? console_emit_next_record+0x4c0/0x4c0 [ 11.288849][ T223] ? __lock_acquire+0x518/0xc20 [ 11.288855][ T223] console_unlock+0xee/0x1f0 [ 11.288858][ T223] ? console_flush_one_record+0x710/0x710 [ 11.288860][ T223] ? rcu_is_watching+0x16/0xd0 [ 11.288862][ T223] ? lock_acquire+0x60/0x160 [ 11.288866][ T223] ? __down_trylock_console_sem+0x5e/0xa0 [ 11.288868][ T223] ? vprintk_emit+0x320/0x3e0 [ 11.288872][ T223] vprintk_emit+0x37c/0x3e0 [ 11.288876][ T223] ? wake_up_klogd_work_func+0x90/0x90 [ 11.288882][ T223] ? vlan_netlink_fini+0x960/0x960 [8021q] [ 11.288886][ T223] _printk+0xc7/0x100 [ 11.288890][ T223] ? snapshot_read.cold+0x21/0x21 [ 11.288897][ T223] ? do_one_initcall+0x113/0x4f0 [ 11.288900][ T223] vlan_proto_init+0x24/0x90 [8021q] [ 11.288903][ T223] do_one_initcall+0x124/0x4f0 [ 11.288906][ T223] ? trace_event_raw_event_initcall_level+0x280/0x280 [ 11.288911][ T223] ? do_init_module+0xae/0x8a0 [ 11.288914][ T223] ? kasan_unpoison+0x44/0x70 [ 11.288919][ T223] do_init_module+0x2ad/0x8a0 [ 11.288923][ T223] ? lockdep_hardirqs_on+0x91/0x130 [ 11.288928][ T223] ? free_module+0x470/0x470 [ 11.288938][ T223] ? kfree+0x123/0x590 [ 11.288943][ T223] load_module+0x1424/0x1bb0 [ 11.288951][ T223] ? layout_and_allocate.isra.0+0x680/0x680 [ 11.288955][ T223] ? __ia32_sys_fsconfig+0x180/0x180 [ 11.288959][ T223] ? find_held_lock+0x2b/0x80 [ 11.288961][ T223] ? rcu_lockdep_current_cpu_online+0x3f/0x1b0 [ 11.288966][ T223] init_module_from_file+0x11f/0x1a0 [ 11.288969][ T223] ? __do_sys_init_module+0x220/0x220 [ 11.288978][ T223] ? __rwlock_init+0x150/0x150 [ 11.288982][ T223] ? do_raw_spin_unlock+0x59/0x250 [ 11.288985][ T223] idempotent_init_module+0x37b/0x7c0 [ 11.288989][ T223] ? init_module_from_file+0x1a0/0x1a0 [ 11.288996][ T223] ? rcu_is_watching+0x16/0xd0 [ 11.288998][ T223] ? cap_capable+0x1d7/0x3d0 [ 11.289005][ T223] __x64_sys_finit_module+0xdf/0x190 [ 11.289007][ T223] ? trace_irq_enable.constprop.0+0x9b/0x160 [ 11.289011][ T223] do_syscall_64+0xff/0x530 [ 11.289013][ T223] ? exc_page_fault+0xee/0x100 [ 11.289016][ T223] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 11.289018][ T223] RIP: 0033:0x7f4e667d937d [ 11.289021][ T223] 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.289023][ T223] RSP: 002b:00007ffca1804ab8 EFLAGS: 00000246 ORIG_RAX: 0000000000000139 [ 11.289026][ T223] RAX: ffffffffffffffda RBX: 0000557d6eb8e810 RCX: 00007f4e667d937d [ 11.289027][ T223] RDX: 0000000000000000 RSI: 0000557d34e4fffd RDI: 0000000000000000 [ 11.289028][ T223] RBP: 00007ffca1804b50 R08: 0000000000000000 R09: 0000000000000000 [ 11.289029][ T223] R10: 0000000000000000 R11: 0000000000000246 R12: 0000557d34e4fffd [ 11.289030][ T223] R13: 0000557d6eb8e960 R14: 0000000000040000 R15: 0000000000000000 [ 11.289038][ T223] [ 12.620896][ T259] br1: port 1(veth1) entered blocking state [ 12.621048][ T259] BUG: sleeping function called from invalid context at ./include/linux/sched/mm.h:322 [ 12.621050][ T259] in_atomic(): 1, irqs_disabled(): 1, non_block: 0, pid: 259, name: ip [ 12.621052][ T259] preempt_count: 1, expected: 0 [ 12.621053][ T259] RCU nest depth: 0, expected: 0 [ 12.621054][ T259] locks held by ip/259: 5, last CPU#2: [ 12.621056][ T259] #0: ffffffffb08d2c40 (rtnl_mutex){+.+.}-{4:4}, at: rtnl_newlink+0x9a8/0x11c0 [ 12.621068][ T259] #1: ffffffffb0169cc0 (console_lock){+.+.}-{0:0}, at: vprintk_emit+0x320/0x3e0 [ 12.621074][ T259] #2: ffffffffb0169d38 (console_srcu){....}-{0:0}, at: console_flush_one_record+0x106/0x710 [ 12.621078][ T259] #3: ffffffffb0089660 (console_owner){....}-{0:0}, at: console_lock_spinning_enable+0x40/0x60 [ 12.621082][ T259] #4: ffffffffb0089560 (printk_legacy_map-wait-type-override){....}-{3:3}, at: console_emit_next_record+0x1df/0x4c0 [ 12.621086][ T259] irq event stamp: 25316 [ 12.621087][ T259] hardirqs last enabled at (25315): [] __down_trylock_console_sem+0x86/0xa0 [ 12.621089][ T259] hardirqs last disabled at (25316): [] console_emit_next_record+0x3d4/0x4c0 [ 12.621092][ T259] softirqs last enabled at (25228): [] __alloc_skb+0x4c2/0x5f0 [ 12.621095][ T259] softirqs last disabled at (25226): [] __alloc_skb+0x4c2/0x5f0 [ 12.621097][ T259] Preemption disabled at: [ 12.621098][ T259] [] vprintk_emit+0x31b/0x3e0 [ 12.621104][ T259] CPU: 2 UID: 0 PID: 259 Comm: ip Tainted: G W 7.2.0-virtme #1 PREEMPT(full) [ 12.621108][ T259] Tainted: [W]=WARN [ 12.621109][ T259] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 12.621111][ T259] Call Trace: [ 12.621112][ T259] [ 12.621114][ T259] dump_stack_lvl+0x6f/0xa0 [ 12.621120][ T259] ? vprintk_emit+0x31b/0x3e0 [ 12.621122][ T259] __might_resched.cold+0x1fe/0x2c1 [ 12.621127][ T259] ? perf_trace_sched_switch+0x7c0/0x7c0 [ 12.621131][ T259] ? __kmalloc_noprof+0xdb/0x760 [ 12.621137][ T259] __kmalloc_noprof+0x443/0x760 [ 12.621143][ T259] ? alloc_buf.isra.0+0x4b/0x260 [ 12.621150][ T259] ? do_raw_spin_unlock+0x59/0x250 [ 12.621153][ T259] alloc_buf.isra.0+0x4b/0x260 [ 12.621156][ T259] put_chars+0x1e1/0x2f0 [ 12.621159][ T259] ? __send_to_port+0x420/0x420 [ 12.621164][ T259] ? validate_chain+0x34a/0xc20 [ 12.621168][ T259] hvc_console_print+0x292/0x780 [ 12.621171][ T259] ? mark_usage+0x61/0x170 [ 12.621173][ T259] ? __lock_acquire+0x518/0xc20 [ 12.621174][ T259] ? __lock_acquire+0x518/0xc20 [ 12.621179][ T259] ? hvc_write+0x3a0/0x3a0 [ 12.621181][ T259] ? console_emit_next_record+0x1df/0x4c0 [ 12.621184][ T259] ? rcu_is_watching+0x16/0xd0 [ 12.621189][ T259] ? lock_acquire+0x13c/0x160 [ 12.621193][ T259] console_emit_next_record+0x22f/0x4c0 [ 12.621197][ T259] ? devkmsg_read+0x4b0/0x4b0 [ 12.621199][ T259] ? console_flush_one_record+0x106/0x710 [ 12.621202][ T259] ? rcu_is_watching+0x16/0xd0 [ 12.621205][ T259] ? lock_acquire+0x13c/0x160 [ 12.621209][ T259] console_flush_one_record+0x46f/0x710 [ 12.621213][ T259] ? console_emit_next_record+0x4c0/0x4c0 [ 12.621215][ T259] ? __lock_acquire+0x518/0xc20 [ 12.621221][ T259] console_unlock+0xee/0x1f0 [ 12.621224][ T259] ? console_flush_one_record+0x710/0x710 [ 12.621226][ T259] ? rcu_is_watching+0x16/0xd0 [ 12.621229][ T259] ? lock_acquire+0x60/0x160 [ 12.621233][ T259] ? __down_trylock_console_sem+0x5e/0xa0 [ 12.621235][ T259] ? vprintk_emit+0x320/0x3e0 [ 12.621238][ T259] vprintk_emit+0x37c/0x3e0 [ 12.621242][ T259] ? wake_up_klogd_work_func+0x90/0x90 [ 12.621245][ T259] ? __lock_release.isra.0+0x69/0x1a0 [ 12.621247][ T259] ? _raw_spin_unlock_irqrestore+0x40/0x80 [ 12.621252][ T259] ? mark_held_locks+0x40/0x70 [ 12.621255][ T259] _printk+0xc7/0x100 [ 12.621259][ T259] ? snapshot_read.cold+0x21/0x21 [ 12.621264][ T259] ? br_multicast_flood+0xab0/0xab0 [bridge] [ 12.621278][ T259] ? do_setlink.isra.0+0xa31/0x2750 [ 12.621279][ T259] ? rtnl_newlink+0x9f1/0x11c0 [ 12.621280][ T259] ? rtnetlink_rcv_msg+0x6fd/0xbd0 [ 12.621285][ T259] br_set_state+0x22f/0x430 [bridge] [ 12.621296][ T259] br_init_port+0xc4/0x200 [bridge] [ 12.621305][ T259] new_nbp+0x39c/0x580 [bridge] [ 12.621316][ T259] br_add_if+0x212/0x1320 [bridge] [ 12.621323][ T259] ? is_bpf_text_address+0x72/0x110 [ 12.621328][ T259] ? kernel_text_address+0x149/0x170 [ 12.621331][ T259] ? __kernel_text_address+0x12/0x30 [ 12.621335][ T259] do_set_master+0x357/0x580 [ 12.621340][ T259] do_setlink.isra.0+0xa31/0x2750 [ 12.621344][ T259] ? stack_trace_save+0x93/0xc0 [ 12.621347][ T259] ? rtnl_link_get_size+0x350/0x350 [ 12.621348][ T259] ? rcu_read_lock_any_held+0x66/0x90 [ 12.621351][ T259] ? stack_depot_save_flags+0x38e/0x790 [ 12.621354][ T259] ? rcu_lockdep_current_cpu_online+0x3f/0x1b0 [ 12.621357][ T259] ? rcu_read_lock_any_held+0x3c/0x90 [ 12.621359][ T259] ? validate_chain+0x38b/0xc20 [ 12.621362][ T259] ? kasan_save_stack+0x3d/0x50 [ 12.621365][ T259] ? kasan_save_stack+0x2f/0x50 [ 12.621367][ T259] ? kasan_save_track+0x14/0x30 [ 12.621370][ T259] ? __lock_acquire+0x518/0xc20 [ 12.621372][ T259] ? netlink_seq_next+0xe/0x60 [ 12.621375][ T259] ? ___sys_sendmsg+0xb0/0x1d0 [ 12.621380][ T259] ? lock_acquire.part.0+0xd4/0x280 [ 12.621382][ T259] ? rtnl_newlink+0x9a8/0x11c0 [ 12.621385][ T259] ? rcu_is_watching+0x16/0xd0 [ 12.621387][ T259] ? lock_acquire+0x13c/0x160 [ 12.621389][ T259] ? rcu_is_watching+0x16/0xd0 [ 12.621391][ T259] ? rcu_is_watching+0x16/0xd0 [ 12.621394][ T259] ? trace_contention_end+0xb3/0x180 [ 12.621398][ T259] ? __mutex_lock+0x1db/0x1ea0 [ 12.621400][ T259] ? __mutex_lock+0x9a3/0x1ea0 [ 12.621402][ T259] ? rtnl_newlink+0x9a8/0x11c0 [ 12.621406][ T259] ? ww_mutex_lock+0x160/0x160 [ 12.621408][ T259] ? nla_get_range_signed+0x3d0/0x3d0 [ 12.621413][ T259] ? __rtnl_newlink+0x3fa/0xa50 [ 12.621419][ T259] rtnl_newlink+0x9f1/0x11c0 [ 12.621425][ T259] ? rtnl_bridge_getlink+0x850/0x850 [ 12.621427][ T259] ? __lock_acquire+0x518/0xc20 [ 12.621432][ T259] ? lock_acquire.part.0+0xd4/0x280 [ 12.621435][ T259] ? find_held_lock+0x2b/0x80 [ 12.621437][ T259] ? rtnl_bridge_getlink+0x850/0x850 [ 12.621439][ T259] ? __lock_release.isra.0+0x69/0x1a0 [ 12.621443][ T259] ? rtnl_bridge_getlink+0x850/0x850 [ 12.621445][ T259] rtnetlink_rcv_msg+0x6fd/0xbd0 [ 12.621448][ T259] ? rtnl_link_fill+0x920/0x920 [ 12.621450][ T259] ? __lock_acquire+0x518/0xc20 [ 12.621455][ T259] ? lock_acquire.part.0+0xd4/0x280 [ 12.621457][ T259] ? find_held_lock+0x2b/0x80 [ 12.621461][ T259] netlink_rcv_skb+0x14e/0x3a0 [ 12.621463][ T259] ? rtnl_link_fill+0x920/0x920 [ 12.621466][ T259] ? netlink_ack+0xcf0/0xcf0 [ 12.621473][ T259] ? netlink_deliver_tap+0xc5/0x330 [ 12.621475][ T259] ? netlink_deliver_tap+0x13c/0x330 [ 12.621479][ T259] netlink_unicast+0x486/0x750 [ 12.621484][ T259] ? netlink_attachskb+0x810/0x810 [ 12.621486][ T259] ? __lock_acquire+0x518/0xc20 [ 12.621491][ T259] netlink_sendmsg+0x735/0xc60 [ 12.621495][ T259] ? netlink_unicast+0x750/0x750 [ 12.621500][ T259] ? __might_fault+0x97/0x140 [ 12.621506][ T259] ____sys_sendmsg+0x415/0x880 [ 12.621508][ T259] ? copy_msghdr_from_user+0x279/0x420 [ 12.621511][ T259] ? get_timestamp.constprop.0+0x390/0x390 [ 12.621512][ T259] ? move_addr_to_kernel+0x40/0x40 [ 12.621521][ T259] ___sys_sendmsg+0x14e/0x1d0 [ 12.621524][ T259] ? copy_msghdr_from_user+0x420/0x420 [ 12.621543][ T259] __sys_sendmsg+0x12c/0x1d0 [ 12.621546][ T259] ? __sys_sendmsg_sock+0x20/0x20 [ 12.621553][ T259] ? rcu_is_watching+0x16/0xd0 [ 12.621557][ T259] do_syscall_64+0xff/0x530 [ 12.621559][ T259] ? exc_page_fault+0xee/0x100 [ 12.621563][ T259] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 12.621565][ T259] RIP: 0033:0x7ff3e478e54e [ 12.621569][ T259] 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 [ 12.621570][ T259] RSP: 002b:00007ffc5a9095d0 EFLAGS: 00000202 ORIG_RAX: 000000000000002e [ 12.621573][ T259] RAX: ffffffffffffffda RBX: 0000000000000004 RCX: 00007ff3e478e54e [ 12.621575][ T259] RDX: 0000000000000000 RSI: 00007ffc5a909680 RDI: 0000000000000005 [ 12.621575][ T259] RBP: 00007ffc5a9095e0 R08: 0000000000000000 R09: 0000000000000000 [ 12.621576][ T259] R10: 0000000000000000 R11: 0000000000000202 R12: 000000006a91b54b [ 12.621577][ T259] R13: 00000000004a1620 R14: 0000000000000000 R15: 00007ffc5a909d40 [ 12.621585][ T259] [ 12.669786][ T259] br1: port 1(veth1) entered disabled state [ 12.671348][ T259] veth1: entered allmulticast mode [ 12.674253][ T259] veth1: entered promiscuous mode [ 12.713435][ T259] ip (259) used greatest stack depth: 23336 bytes left [ 12.737932][ T36] br1: port 1(veth1) entered blocking state [ 12.738482][ T36] br1: port 1(veth1) entered forwarding state [ 28.047227][ C2] [ 28.047248][ C2] BUG: sleeping function called from invalid context at ./include/linux/sched/mm.h:322 [ 28.047251][ C2] in_atomic(): 1, irqs_disabled(): 1, non_block: 0, pid: 0, name: swapper/2 [ 28.047253][ C2] preempt_count: 104, expected: 0 [ 28.047255][ C2] RCU nest depth: 0, expected: 0 [ 28.047256][ C2] INFO: lockdep is turned off. [ 28.047257][ C2] irq event stamp: 665820 [ 28.047259][ C2] hardirqs last enabled at (665820): [] _raw_spin_unlock_irq+0x28/0x50 [ 28.047270][ C2] hardirqs last disabled at (665819): [] _raw_spin_lock_irq+0x4a/0x50 [ 28.047272][ C2] softirqs last enabled at (665780): [] handle_softirqs+0x67c/0x900 [ 28.047277][ C2] softirqs last disabled at (665817): [] __irq_exit_rcu+0x145/0x1c0 [ 28.047280][ C2] Preemption disabled at: [ 28.047281][ C2] [<0000000000000000>] 0x0 [ 28.047290][ C2] CPU: 2 UID: 0 PID: 0 Comm: swapper/2 Tainted: G W 7.2.0-virtme #1 PREEMPT(full) [ 28.047295][ C2] Tainted: [W]=WARN [ 28.047296][ C2] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 28.047299][ C2] Call Trace: [ 28.047301][ C2] [ 28.047304][ C2] dump_stack_lvl+0x6f/0xa0 [ 28.047311][ C2] __might_resched.cold+0x1fe/0x2c1 [ 28.047315][ C2] ? perf_trace_sched_switch+0x7c0/0x7c0 [ 28.047319][ C2] ? __asan_memcpy+0x3c/0x60 [ 28.047323][ C2] ? rcu_is_watching+0x16/0xd0 [ 28.047328][ C2] __kmalloc_noprof+0x443/0x760 [ 28.047332][ C2] ? __rwlock_init+0x150/0x150 [ 28.047335][ C2] ? alloc_buf.isra.0+0x4b/0x260 [ 28.047340][ C2] ? do_raw_spin_unlock+0x59/0x250 [ 28.047343][ C2] alloc_buf.isra.0+0x4b/0x260 [ 28.047346][ C2] put_chars+0x1e1/0x2f0 [ 28.047348][ C2] ? __send_to_port+0x420/0x420 [ 28.047351][ C2] ? console_prepend_replay+0x20/0x20 [ 28.047356][ C2] hvc_console_print+0x292/0x780 [ 28.047360][ C2] ? hvc_write+0x3a0/0x3a0 [ 28.047363][ C2] ? rcu_is_watching+0x16/0xd0 [ 28.047365][ C2] ? lock_acquire+0x13c/0x160 [ 28.047369][ C2] console_emit_next_record+0x22f/0x4c0 [ 28.047372][ C2] ? devkmsg_read+0x4b0/0x4b0 [ 28.047375][ C2] ? rcu_is_watching+0x16/0xd0 [ 28.047378][ C2] ? rcu_is_watching+0x16/0xd0 [ 28.047380][ C2] ? lock_acquire+0x13c/0x160 [ 28.047383][ C2] ? console_flush_one_record+0x111/0x710 [ 28.047386][ C2] console_flush_one_record+0x46f/0x710 [ 28.047389][ C2] ? console_emit_next_record+0x4c0/0x4c0 [ 28.047393][ C2] console_unlock+0xee/0x1f0 [ 28.047396][ C2] ? lock_acquire+0x13c/0x160 [ 28.047398][ C2] ? console_flush_one_record+0x710/0x710 [ 28.047401][ C2] ? rcu_is_watching+0x16/0xd0 [ 28.047403][ C2] ? lock_release+0x184/0x1f0 [ 28.047405][ C2] ? lock_acquire+0x60/0x160 [ 28.047408][ C2] ? __down_trylock_console_sem+0x5e/0xa0 [ 28.047411][ C2] ? vprintk_emit+0x320/0x3e0 [ 28.047414][ C2] vprintk_emit+0x37c/0x3e0 [ 28.047417][ C2] ? wake_up_klogd_work_func+0x90/0x90 [ 28.047420][ C2] ? br_forward_delay_timer_expired+0x44/0x5d0 [bridge] [ 28.047438][ C2] ? lock_release+0x184/0x1f0 [ 28.047440][ C2] ? br_forward_delay_timer_expired+0x44/0x5d0 [bridge] [ 28.047452][ C2] ? br_forward_delay_timer_expired+0x44/0x5d0 [bridge] [ 28.047463][ C2] ? is_module_text_address+0x154/0x250 [ 28.047468][ C2] _printk+0xc7/0x100 [ 28.047472][ C2] ? snapshot_read.cold+0x21/0x21 [ 28.047474][ C2] ? arch_stack_walk+0xd7/0x130 [ 28.047480][ C2] ? rcu_lockdep_current_cpu_online+0x3f/0x1b0 [ 28.047483][ C2] ? nbcon_cpu_emergency_enter+0x28/0x80 [ 28.047486][ C2] print_irq_inversion_bug.part.0+0x32/0xc0 [ 28.047490][ C2] mark_lock_irq+0x989/0x9c0 [ 28.047494][ C2] mark_lock+0x1d7/0xa00 [ 28.047497][ C2] mark_usage+0x42/0x170 [ 28.047500][ C2] __lock_acquire+0x388/0xc20 [ 28.047503][ C2] lock_acquire.part.0+0xd4/0x280 [ 28.047506][ C2] ? br_forward_delay_timer_expired+0x44/0x5d0 [bridge] [ 28.047517][ C2] ? rcu_is_watching+0x16/0xd0 [ 28.047520][ C2] ? lock_acquire+0x13c/0x160 [ 28.047523][ C2] ? br_message_age_timer_expired+0x70/0x70 [bridge] [ 28.047534][ C2] _raw_spin_lock+0x33/0x40 [ 28.047537][ C2] ? br_forward_delay_timer_expired+0x44/0x5d0 [bridge] [ 28.047548][ C2] br_forward_delay_timer_expired+0x44/0x5d0 [bridge] [ 28.047559][ C2] ? br_message_age_timer_expired+0x70/0x70 [bridge] [ 28.047570][ C2] call_timer_fn+0x160/0x4d0 [ 28.047574][ C2] ? detach_if_pending+0x1d0/0x1d0 [ 28.047577][ C2] ? debug_object_active_state+0x430/0x430 [ 28.047581][ C2] ? find_held_lock+0x2b/0x80 [ 28.047584][ C2] ? __lock_release.isra.0+0x69/0x1a0 [ 28.047587][ C2] ? rcu_is_watching+0x16/0xd0 [ 28.047590][ C2] __run_timers+0x68f/0xaa0 [ 28.047593][ C2] ? br_message_age_timer_expired+0x70/0x70 [bridge] [ 28.047605][ C2] ? __bpf_trace_itimer_expire+0x10/0x10 [ 28.047608][ C2] ? __lock_acquire+0x518/0xc20 [ 28.047612][ C2] ? __rwlock_init+0x150/0x150 [ 28.047616][ C2] run_timer_softirq+0xf0/0x160 [ 28.047619][ C2] ? __run_timers+0xaa0/0xaa0 [ 28.047621][ C2] ? trace_irq_enable.constprop.0+0x9b/0x160 [ 28.047625][ C2] ? rcu_is_watching+0x16/0xd0 [ 28.047627][ C2] handle_softirqs+0x1d3/0x900 [ 28.047631][ C2] ? __lock_release.isra.0+0x69/0x1a0 [ 28.047633][ C2] ? _local_bh_enable+0xc0/0xc0 [ 28.047636][ C2] __irq_exit_rcu+0x145/0x1c0 [ 28.047639][ C2] irq_exit_rcu+0xe/0x30 [ 28.047641][ C2] sysvec_apic_timer_interrupt+0x9d/0xe0 [ 28.047645][ C2] [ 28.047646][ C2] [ 28.047647][ C2] ? lockdep_hardirqs_on+0x91/0x130 [ 28.047649][ C2] asm_sysvec_apic_timer_interrupt+0x1a/0x20 [ 28.047653][ C2] RIP: 0010:pv_native_safe_halt+0xf/0x10 [ 28.047656][ C2] Code: 48 8b 3d 94 d2 f5 01 e8 1f 00 00 00 48 2b 05 58 93 95 00 c3 0f 1f 80 00 00 00 00 f3 0f 1e fa eb 07 0f 00 2d 13 86 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 [ 28.047659][ C2] RSP: 0018:ffa0000000157e00 EFLAGS: 00000282 [ 28.047662][ C2] RAX: 00000000000a28d7 RBX: ff11000001bec6c0 RCX: ffffffffacef0307 [ 28.047664][ C2] RDX: ff11000001bec6c0 RSI: ffffffffafc38af6 RDI: ffffffffaf68d8e0 [ 28.047666][ C2] RBP: 0000000000000000 R08: 0000000000000000 R09: 0000000000000000 [ 28.047667][ C2] R10: 0000000000000002 R11: 0000000000000001 R12: 1ff400000002afc3 [ 28.047669][ C2] R13: 0000000000000000 R14: dffffc0000000000 R15: 0000000000000000 [ 28.047672][ C2] ? cpuidle_idle_call.constprop.0+0x237/0x410 [ 28.047676][ C2] default_idle+0x9/0x10 [ 28.047679][ C2] default_idle_call+0x6e/0xb0 [ 28.047682][ C2] cpuidle_idle_call.constprop.0+0x237/0x410 [ 28.047684][ C2] ? arch_cpu_idle_exit+0x40/0x40 [ 28.047687][ C2] ? mark_tsc_async_resets+0x30/0x30 [ 28.047690][ C2] ? default_idle_call+0x98/0xb0 [ 28.047692][ C2] ? rcu_is_watching+0x16/0xd0 [ 28.047696][ C2] do_idle+0xd8/0x190 [ 28.047698][ C2] cpu_startup_entry+0x53/0x70 [ 28.047700][ C2] start_secondary+0x204/0x2b0 [ 28.047703][ C2] ? set_cpu_sibling_map+0x2130/0x2130 [ 28.047706][ C2] common_startup_64+0x13e/0x148 [ 28.047712][ C2] [ 28.075945][ C2] ======================================================== [ 28.076329][ C2] WARNING: possible irq lock inversion dependency detected [ 28.076634][ C2] 7.2.0-virtme #1 Tainted: G W [ 28.076965][ C2] -------------------------------------------------------- [ 28.077353][ C2] swapper/2/0 just changed the state of lock: [ 28.077614][ C2] ff11000005f0ae58 (&br->lock){+.-.}-{3:3}, at: br_forward_delay_timer_expired+0x44/0x5d0 [bridge] [ 28.078126][ C2] but this lock took another, SOFTIRQ-unsafe lock in the past: [ 28.078504][ C2] (fs_reclaim){+.+.}-{0:0} [ 28.078509][ C2] [ 28.078509][ C2] [ 28.078509][ C2] and interrupts could create inverse lock ordering between them. [ 28.078509][ C2] [ 28.079418][ C2] [ 28.079418][ C2] other info that might help us debug this: [ 28.079801][ C2] Chain exists of: [ 28.079801][ C2] &br->lock --> console_owner --> fs_reclaim [ 28.079801][ C2] [ 28.080348][ C2] Possible interrupt unsafe locking scenario: [ 28.080348][ C2] [ 28.080748][ C2] CPU0 CPU1 [ 28.080956][ C2] ---- ---- [ 28.081244][ C2] lock(fs_reclaim); [ 28.081403][ C2] local_irq_disable(); [ 28.081741][ C2] lock(&br->lock); [ 28.082010][ C2] lock(console_owner); [ 28.082356][ C2] [ 28.082520][ C2] lock(&br->lock); [ 28.082750][ C2] [ 28.082750][ C2] *** DEADLOCK *** [ 28.082750][ C2] [ 28.083049][ C2] locks held by swapper/2/0: 1, last CPU#2: [ 28.083380][ C2] #0: ffa0000000228c90 ((&p->forward_delay_timer)){+.-.}-{0:0}, at: call_timer_fn+0x110/0x4d0 [ 28.083883][ C2] [ 28.083883][ C2] the shortest dependencies between 2nd lock and 1st lock: [ 28.084323][ C2] -> (fs_reclaim){+.+.}-{0:0} { [ 28.084542][ C2] HARDIRQ-ON-W at: [ 28.084777][ C2] __lock_acquire+0x388/0xc20 [ 28.085052][ C2] lock_acquire.part.0+0xd4/0x280 [ 28.085387][ C2] fs_reclaim_acquire+0xd5/0x120 [ 28.085727][ C2] __kmalloc_cache_noprof+0x6e/0x620 [ 28.086048][ C2] kthread_create_worker_on_node+0xea/0x210 [ 28.086444][ C2] workqueue_init+0x2a/0x680 [ 28.086786][ C2] kernel_init_freeable+0x2fe/0x630 [ 28.087178][ C2] kernel_init+0x21/0x150 [ 28.087446][ C2] ret_from_fork+0x474/0x6b0 [ 28.087782][ C2] ret_from_fork_asm+0x11/0x20 [ 28.088044][ C2] SOFTIRQ-ON-W at: [ 28.088280][ C2] __lock_acquire+0x388/0xc20 [ 28.088546][ C2] lock_acquire.part.0+0xd4/0x280 [ 28.088885][ C2] fs_reclaim_acquire+0xd5/0x120 [ 28.089230][ C2] __kmalloc_cache_noprof+0x6e/0x620 [ 28.089544][ C2] kthread_create_worker_on_node+0xea/0x210 [ 28.089932][ C2] workqueue_init+0x2a/0x680 [ 28.090280][ C2] kernel_init_freeable+0x2fe/0x630 [ 28.090678][ C2] kernel_init+0x21/0x150 [ 28.090941][ C2] ret_from_fork+0x474/0x6b0 [ 28.091285][ C2] ret_from_fork_asm+0x11/0x20 [ 28.091560][ C2] INITIAL USE at: [ 28.091792][ C2] __lock_acquire+0x388/0xc20 [ 28.092059][ C2] lock_acquire.part.0+0xd4/0x280 [ 28.092399][ C2] fs_reclaim_acquire+0xd5/0x120 [ 28.092736][ C2] __kmalloc_cache_noprof+0x6e/0x620 [ 28.093048][ C2] kthread_create_worker_on_node+0xea/0x210 [ 28.093434][ C2] workqueue_init+0x2a/0x680 [ 28.093769][ C2] kernel_init_freeable+0x2fe/0x630 [ 28.094038][ C2] kernel_init+0x21/0x150 [ 28.094378][ C2] ret_from_fork+0x474/0x6b0 [ 28.094721][ C2] ret_from_fork_asm+0x11/0x20 [ 28.094980][ C2] } [ 28.095170][ C2] ... key at: [] __fs_reclaim_map+0x0/0xbe0 [ 28.095480][ C2] ... acquired at: [ 28.095712][ C2] __lock_acquire+0x518/0xc20 [ 28.095915][ C2] lock_acquire.part.0+0xd4/0x280 [ 28.096197][ C2] fs_reclaim_acquire+0xd5/0x120 [ 28.096400][ C2] __kmalloc_noprof+0xd3/0x760 [ 28.096683][ C2] alloc_buf.isra.0+0x4b/0x260 [ 28.096890][ C2] put_chars+0x1e1/0x2f0 [ 28.097176][ C2] hvc_console_print+0x292/0x780 [ 28.097388][ C2] console_emit_next_record+0x22f/0x4c0 [ 28.097671][ C2] console_flush_one_record+0x46f/0x710 [ 28.097876][ C2] console_unlock+0xee/0x1f0 [ 28.098163][ C2] vprintk_emit+0x37c/0x3e0 [ 28.098373][ C2] dev_vprintk_emit+0x27f/0x2c0 [ 28.098654][ C2] dev_printk_emit+0xb9/0xee [ 28.098856][ C2] _dev_info+0xe2/0x116 [ 28.099088][ C2] __devm_rtc_register_device.cold+0xc3/0x3a8 [ 28.099349][ C2] cmos_do_probe+0x73b/0x98a [ 28.099632][ C2] platform_probe+0xfe/0x1f0 [ 28.099839][ C2] call_driver_probe+0x61/0x1c0 [ 28.100129][ C2] really_probe+0x199/0x760 [ 28.100337][ C2] __driver_probe_device+0x24f/0x440 [ 28.100615][ C2] driver_probe_device+0x4a/0xf0 [ 28.100815][ C2] __driver_attach+0x1b8/0x540 [ 28.101103][ C2] bus_for_each_dev+0x130/0x1e0 [ 28.101314][ C2] bus_add_driver+0x2c8/0x530 [ 28.101599][ C2] driver_register+0x1a3/0x390 [ 28.101802][ C2] __platform_driver_probe+0x13f/0x270 [ 28.102086][ C2] cmos_init+0x31/0x40 [ 28.102243][ C2] do_one_initcall+0x124/0x4f0 [ 28.102529][ C2] kernel_init_freeable+0x596/0x630 [ 28.102732][ C2] kernel_init+0x21/0x150 [ 28.103020][ C2] ret_from_fork+0x474/0x6b0 [ 28.103226][ C2] ret_from_fork_asm+0x11/0x20 [ 28.103510][ C2] [ 28.103616][ C2] -> (console_owner){....}-{0:0} { [ 28.103827][ C2] INITIAL USE at: [ 28.104064][ C2] } [ 28.104169][ C2] ... key at: [] console_owner_dep_map+0x0/0x60 [ 28.104560][ C2] ... acquired at: [ 28.104712][ C2] __lock_acquire+0x518/0xc20 [ 28.105002][ C2] lock_acquire.part.0+0xd4/0x280 [ 28.105208][ C2] console_lock_spinning_enable+0x5c/0x60 [ 28.105564][ C2] console_emit_next_record+0x1d1/0x4c0 [ 28.105768][ C2] console_flush_one_record+0x46f/0x710 [ 28.106054][ C2] console_unlock+0xee/0x1f0 [ 28.106266][ C2] vprintk_emit+0x37c/0x3e0 [ 28.106547][ C2] _printk+0xc7/0x100 [ 28.106704][ C2] br_set_state+0x22f/0x430 [bridge] [ 28.106999][ C2] br_init_port+0xc4/0x200 [bridge] [ 28.107215][ C2] br_stp_enable_port+0x12/0x50 [bridge] [ 28.107565][ C2] br_port_carrier_check+0x220/0x430 [bridge] [ 28.107830][ C2] br_device_event+0x52d/0x8f0 [bridge] [ 28.108129][ C2] notifier_call_chain+0xae/0x300 [ 28.108341][ C2] netif_state_change+0x139/0x340 [ 28.108618][ C2] __linkwatch_run_queue+0x34c/0x750 [ 28.108792][ C2] linkwatch_event+0x7f/0xb0 [ 28.109069][ C2] process_one_work+0xe3e/0x1560 [ 28.109275][ C2] worker_thread+0x4f1/0xd60 [ 28.109555][ C2] kthread+0x367/0x460 [ 28.109712][ C2] ret_from_fork+0x474/0x6b0 [ 28.110000][ C2] ret_from_fork_asm+0x11/0x20 [ 28.110207][ C2] [ 28.110310][ C2] -> (&br->lock){+.-.}-{3:3} { [ 28.110595][ C2] HARDIRQ-ON-W at: [ 28.110751][ C2] __lock_acquire+0x388/0xc20 [ 28.111100][ C2] lock_acquire.part.0+0xd4/0x280 [ 28.111443][ C2] _raw_spin_lock_bh+0x38/0x50 [ 28.111707][ C2] recalculate_group_addr+0x51/0x120 [bridge] [ 28.112110][ C2] br_vlan_filter_toggle+0x85/0x110 [bridge] [ 28.112513][ C2] br_changelink+0x575/0x16e0 [bridge] [ 28.112781][ C2] br_dev_newlink+0xeb/0x160 [bridge] [ 28.113134][ C2] rtnl_newlink_create+0x2d0/0x750 [ 28.113480][ C2] __rtnl_newlink+0x22b/0xa50 [ 28.113740][ C2] rtnl_newlink+0x9f1/0x11c0 [ 28.114084][ C2] rtnetlink_rcv_msg+0x6fd/0xbd0 [ 28.114348][ C2] netlink_rcv_skb+0x14e/0x3a0 [ 28.114681][ C2] netlink_unicast+0x486/0x750 [ 28.115021][ C2] netlink_sendmsg+0x735/0xc60 [ 28.115286][ C2] ____sys_sendmsg+0x415/0x880 [ 28.115615][ C2] ___sys_sendmsg+0x14e/0x1d0 [ 28.115938][ C2] __sys_sendmsg+0x12c/0x1d0 [ 28.116202][ C2] do_syscall_64+0xff/0x530 [ 28.116540][ C2] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 28.116929][ C2] IN-SOFTIRQ-W at: [ 28.117095][ C2] __lock_acquire+0x388/0xc20 [ 28.117435][ C2] lock_acquire.part.0+0xd4/0x280 [ 28.117690][ C2] _raw_spin_lock+0x33/0x40 [ 28.118043][ C2] br_forward_delay_timer_expired+0x44/0x5d0 [bridge] [ 28.118450][ C2] call_timer_fn+0x160/0x4d0 [ 28.118716][ C2] __run_timers+0x68f/0xaa0 [ 28.119056][ C2] run_timer_softirq+0xf0/0x160 [ 28.119319][ C2] handle_softirqs+0x1d3/0x900 [ 28.119659][ C2] __irq_exit_rcu+0x145/0x1c0 [ 28.119999][ C2] irq_exit_rcu+0xe/0x30 [ 28.120261][ C2] sysvec_apic_timer_interrupt+0x9d/0xe0 [ 28.120655][ C2] asm_sysvec_apic_timer_interrupt+0x1a/0x20 [ 28.121042][ C2] pv_native_safe_halt+0xf/0x10 [ 28.121301][ C2] default_idle+0x9/0x10 [ 28.121635][ C2] default_idle_call+0x6e/0xb0 [ 28.121966][ C2] cpuidle_idle_call.constprop.0+0x237/0x410 [ 28.122311][ C2] do_idle+0xd8/0x190 [ 28.122600][ C2] cpu_startup_entry+0x53/0x70 [ 28.122956][ C2] start_secondary+0x204/0x2b0 [ 28.123240][ C2] common_startup_64+0x13e/0x148 [ 28.123576][ C2] INITIAL USE at: [ 28.123731][ C2] __lock_acquire+0x388/0xc20 [ 28.124073][ C2] lock_acquire.part.0+0xd4/0x280 [ 28.124341][ C2] _raw_spin_lock_bh+0x38/0x50 [ 28.124679][ C2] recalculate_group_addr+0x51/0x120 [bridge] [ 28.125087][ C2] br_vlan_filter_toggle+0x85/0x110 [bridge] [ 28.125485][ C2] br_changelink+0x575/0x16e0 [bridge] [ 28.125759][ C2] br_dev_newlink+0xeb/0x160 [bridge] [ 28.126117][ C2] rtnl_newlink_create+0x2d0/0x750 [ 28.126379][ C2] __rtnl_newlink+0x22b/0xa50 [ 28.126715][ C2] rtnl_newlink+0x9f1/0x11c0 [ 28.127054][ C2] rtnetlink_rcv_msg+0x6fd/0xbd0 [ 28.127313][ C2] netlink_rcv_skb+0x14e/0x3a0 [ 28.127647][ C2] netlink_unicast+0x486/0x750 [ 28.127995][ C2] netlink_sendmsg+0x735/0xc60 [ 28.128263][ C2] ____sys_sendmsg+0x415/0x880 [ 28.128601][ C2] ___sys_sendmsg+0x14e/0x1d0 [ 28.128857][ C2] __sys_sendmsg+0x12c/0x1d0 [ 28.129198][ C2] do_syscall_64+0xff/0x530 [ 28.129541][ C2] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 28.129850][ C2] } [ 28.130038][ C2] ... key at: [] __key.7+0x0/0x40 [bridge] [ 28.130352][ C2] ... acquired at: [ 28.130583][ C2] mark_lock+0x1d7/0xa00 [ 28.130788][ C2] mark_usage+0x42/0x170 [ 28.131078][ C2] __lock_acquire+0x388/0xc20 [ 28.131292][ C2] lock_acquire.part.0+0xd4/0x280 [ 28.131601][ C2] _raw_spin_lock+0x33/0x40 [ 28.131806][ C2] br_forward_delay_timer_expired+0x44/0x5d0 [bridge] [ 28.132158][ C2] call_timer_fn+0x160/0x4d0 [ 28.132363][ C2] __run_timers+0x68f/0xaa0 [ 28.132646][ C2] run_timer_softirq+0xf0/0x160 [ 28.132848][ C2] handle_softirqs+0x1d3/0x900 [ 28.133135][ C2] __irq_exit_rcu+0x145/0x1c0 [ 28.133343][ C2] irq_exit_rcu+0xe/0x30 [ 28.133619][ C2] sysvec_apic_timer_interrupt+0x9d/0xe0 [ 28.133950][ C2] asm_sysvec_apic_timer_interrupt+0x1a/0x20 [ 28.134215][ C2] pv_native_safe_halt+0xf/0x10 [ 28.134501][ C2] default_idle+0x9/0x10 [ 28.134708][ C2] default_idle_call+0x6e/0xb0 [ 28.134997][ C2] cpuidle_idle_call.constprop.0+0x237/0x410 [ 28.135256][ C2] do_idle+0xd8/0x190 [ 28.135495][ C2] cpu_startup_entry+0x53/0x70 [ 28.135696][ C2] start_secondary+0x204/0x2b0 [ 28.135977][ C2] common_startup_64+0x13e/0x148 [ 28.136195][ C2] [ 28.136299][ C2] [ 28.136299][ C2] stack backtrace: [ 28.136634][ C2] CPU: 2 UID: 0 PID: 0 Comm: swapper/2 Tainted: G W 7.2.0-virtme #1 PREEMPT(full) [ 28.136639][ C2] Tainted: [W]=WARN [ 28.136640][ C2] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 28.136642][ C2] Call Trace: [ 28.136644][ C2] [ 28.136647][ C2] dump_stack_lvl+0x6f/0xa0 [ 28.136652][ C2] print_irq_inversion_bug.part.0.cold+0xe6/0x143 [ 28.136657][ C2] mark_lock_irq+0x989/0x9c0 [ 28.136662][ C2] mark_lock+0x1d7/0xa00 [ 28.136665][ C2] mark_usage+0x42/0x170 [ 28.136667][ C2] __lock_acquire+0x388/0xc20 [ 28.136671][ C2] lock_acquire.part.0+0xd4/0x280 [ 28.136673][ C2] ? br_forward_delay_timer_expired+0x44/0x5d0 [bridge] [ 28.136689][ C2] ? rcu_is_watching+0x16/0xd0 [ 28.136693][ C2] ? lock_acquire+0x13c/0x160 [ 28.136696][ C2] ? br_message_age_timer_expired+0x70/0x70 [bridge] [ 28.136707][ C2] _raw_spin_lock+0x33/0x40 [ 28.136710][ C2] ? br_forward_delay_timer_expired+0x44/0x5d0 [bridge] [ 28.136722][ C2] br_forward_delay_timer_expired+0x44/0x5d0 [bridge] [ 28.136733][ C2] ? br_message_age_timer_expired+0x70/0x70 [bridge] [ 28.136744][ C2] call_timer_fn+0x160/0x4d0 [ 28.136748][ C2] ? detach_if_pending+0x1d0/0x1d0 [ 28.136750][ C2] ? debug_object_active_state+0x430/0x430 [ 28.136754][ C2] ? find_held_lock+0x2b/0x80 [ 28.136757][ C2] ? __lock_release.isra.0+0x69/0x1a0 [ 28.136760][ C2] ? rcu_is_watching+0x16/0xd0 [ 28.136764][ C2] __run_timers+0x68f/0xaa0 [ 28.136766][ C2] ? br_message_age_timer_expired+0x70/0x70 [bridge] [ 28.136779][ C2] ? __bpf_trace_itimer_expire+0x10/0x10 [ 28.136781][ C2] ? __lock_acquire+0x518/0xc20 [ 28.136786][ C2] ? __rwlock_init+0x150/0x150 [ 28.136790][ C2] run_timer_softirq+0xf0/0x160 [ 28.136793][ C2] ? __run_timers+0xaa0/0xaa0 [ 28.136795][ C2] ? trace_irq_enable.constprop.0+0x9b/0x160 [ 28.136799][ C2] ? rcu_is_watching+0x16/0xd0 [ 28.136801][ C2] handle_softirqs+0x1d3/0x900 [ 28.136804][ C2] ? __lock_release.isra.0+0x69/0x1a0 [ 28.136807][ C2] ? _local_bh_enable+0xc0/0xc0 [ 28.136810][ C2] __irq_exit_rcu+0x145/0x1c0 [ 28.136813][ C2] irq_exit_rcu+0xe/0x30 [ 28.136815][ C2] sysvec_apic_timer_interrupt+0x9d/0xe0 [ 28.136818][ C2] [ 28.136819][ C2] [ 28.136820][ C2] ? lockdep_hardirqs_on+0x91/0x130 [ 28.136822][ C2] asm_sysvec_apic_timer_interrupt+0x1a/0x20 [ 28.136825][ C2] RIP: 0010:pv_native_safe_halt+0xf/0x10 [ 28.136828][ C2] Code: 48 8b 3d 94 d2 f5 01 e8 1f 00 00 00 48 2b 05 58 93 95 00 c3 0f 1f 80 00 00 00 00 f3 0f 1e fa eb 07 0f 00 2d 13 86 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 [ 28.136830][ C2] RSP: 0018:ffa0000000157e00 EFLAGS: 00000282 [ 28.136833][ C2] RAX: 00000000000a28d7 RBX: ff11000001bec6c0 RCX: ffffffffacef0307 [ 28.136835][ C2] RDX: ff11000001bec6c0 RSI: ffffffffafc38af6 RDI: ffffffffaf68d8e0 [ 28.136837][ C2] RBP: 0000000000000000 R08: 0000000000000000 R09: 0000000000000000 [ 28.136838][ C2] R10: 0000000000000002 R11: 0000000000000001 R12: 1ff400000002afc3 [ 28.136840][ C2] R13: 0000000000000000 R14: dffffc0000000000 R15: 0000000000000000 [ 28.136842][ C2] ? cpuidle_idle_call.constprop.0+0x237/0x410 [ 28.136846][ C2] default_idle+0x9/0x10 [ 28.136848][ C2] default_idle_call+0x6e/0xb0 [ 28.136851][ C2] cpuidle_idle_call.constprop.0+0x237/0x410 [ 28.136853][ C2] ? arch_cpu_idle_exit+0x40/0x40 [ 28.136856][ C2] ? mark_tsc_async_resets+0x30/0x30 [ 28.136858][ C2] ? default_idle_call+0x98/0xb0 [ 28.136861][ C2] ? rcu_is_watching+0x16/0xd0 [ 28.136864][ C2] do_idle+0xd8/0x190 [ 28.136866][ C2] cpu_startup_entry+0x53/0x70 [ 28.136869][ C2] start_secondary+0x204/0x2b0 [ 28.136871][ C2] ? set_cpu_sibling_map+0x2130/0x2130 [ 28.136874][ C2] common_startup_64+0x13e/0x148 [ 28.136880][ C2] [ 39.756743][ T443] br1: port 1(veth1) entered disabled state [ 39.756760][ T443] BUG: sleeping function called from invalid context at ./include/linux/sched/mm.h:322 [ 39.756763][ T443] in_atomic(): 1, irqs_disabled(): 1, non_block: 0, pid: 443, name: ip [ 39.756764][ T443] preempt_count: 202, expected: 0 [ 39.756765][ T443] RCU nest depth: 0, expected: 0 [ 39.756766][ T443] INFO: lockdep is turned off. [ 39.756767][ T443] irq event stamp: 0 [ 39.756768][ T443] hardirqs last enabled at (0): [<0000000000000000>] 0x0 [ 39.756773][ T443] hardirqs last disabled at (0): [] copy_process+0x1ccd/0x6240 [ 39.756779][ T443] softirqs last enabled at (0): [] copy_process+0x1d21/0x6240 [ 39.756781][ T443] softirqs last disabled at (0): [<0000000000000000>] 0x0 [ 39.756783][ T443] Preemption disabled at: [ 39.756783][ T443] [<0000000000000000>] 0x0 [ 39.756788][ T443] CPU: 3 UID: 0 PID: 443 Comm: ip Tainted: G W 7.2.0-virtme #1 PREEMPT(full) [ 39.756792][ T443] Tainted: [W]=WARN [ 39.756793][ T443] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 39.756795][ T443] Call Trace: [ 39.756796][ T443] [ 39.756797][ T443] dump_stack_lvl+0x6f/0xa0 [ 39.756803][ T443] __might_resched.cold+0x1fe/0x2c1 [ 39.756807][ T443] ? perf_trace_sched_switch+0x7c0/0x7c0 [ 39.756810][ T443] ? rcu_is_watching+0x16/0xd0 [ 39.756814][ T443] __kmalloc_noprof+0x443/0x760 [ 39.756817][ T443] ? __rwlock_init+0x150/0x150 [ 39.756820][ T443] ? alloc_buf.isra.0+0x4b/0x260 [ 39.756824][ T443] ? do_raw_spin_unlock+0x59/0x250 [ 39.756826][ T443] alloc_buf.isra.0+0x4b/0x260 [ 39.756827][ T443] put_chars+0x1e1/0x2f0 [ 39.756829][ T443] ? __send_to_port+0x420/0x420 [ 39.756831][ T443] ? printk_get_next_message+0x240/0x650 [ 39.756835][ T443] hvc_console_print+0x292/0x780 [ 39.756838][ T443] ? hvc_write+0x3a0/0x3a0 [ 39.756840][ T443] ? __rwlock_init+0x150/0x150 [ 39.756842][ T443] ? rcu_is_watching+0x16/0xd0 [ 39.756843][ T443] ? lock_acquire+0x13c/0x160 [ 39.756845][ T443] console_emit_next_record+0x22f/0x4c0 [ 39.756848][ T443] ? devkmsg_read+0x4b0/0x4b0 [ 39.756850][ T443] ? rcu_is_watching+0x16/0xd0 [ 39.756851][ T443] ? rcu_is_watching+0x16/0xd0 [ 39.756853][ T443] ? rcu_is_watching+0x16/0xd0 [ 39.756855][ T443] ? lock_acquire+0x13c/0x160 [ 39.756856][ T443] ? console_flush_one_record+0x111/0x710 [ 39.756858][ T443] console_flush_one_record+0x46f/0x710 [ 39.756860][ T443] ? console_emit_next_record+0x4c0/0x4c0 [ 39.756863][ T443] console_unlock+0xee/0x1f0 [ 39.756864][ T443] ? lock_acquire+0x13c/0x160 [ 39.756866][ T443] ? console_flush_one_record+0x710/0x710 [ 39.756867][ T443] ? rcu_is_watching+0x16/0xd0 [ 39.756869][ T443] ? lock_release+0x184/0x1f0 [ 39.756870][ T443] ? lock_acquire+0x60/0x160 [ 39.756871][ T443] ? __rcu_read_lock+0x30/0x70 [ 39.756873][ T443] ? __down_trylock_console_sem+0x5e/0xa0 [ 39.756875][ T443] ? vprintk_emit+0x320/0x3e0 [ 39.756877][ T443] vprintk_emit+0x37c/0x3e0 [ 39.756879][ T443] ? wake_up_klogd_work_func+0x90/0x90 [ 39.756881][ T443] ? rcu_is_watching+0x16/0xd0 [ 39.756883][ T443] ? trace_irq_enable.constprop.0+0x9b/0x160 [ 39.756885][ T443] ? trace_hardirqs_on+0x36/0x40 [ 39.756887][ T443] _printk+0xc7/0x100 [ 39.756890][ T443] ? snapshot_read.cold+0x21/0x21 [ 39.756892][ T443] ? ipv6_mc_down+0x17e/0x2d0 [ 39.756896][ T443] br_set_state+0x22f/0x430 [bridge] [ 39.756909][ T443] br_stp_disable_port+0x11f/0x390 [bridge] [ 39.756917][ T443] br_device_event+0x7b5/0x8f0 [bridge] [ 39.756925][ T443] ? _raw_spin_unlock_irqrestore+0x40/0x80 [ 39.756928][ T443] ? _sub_I_65535_1+0x4d0/0x4d0 [stp] [ 39.756930][ T443] ? addrconf_notify+0x2c8/0xf30 [ 39.756934][ T443] notifier_call_chain+0xae/0x300 [ 39.756936][ T443] __dev_notify_flags+0x23c/0x3c0 [ 39.756940][ T443] ? trace_irq_enable.constprop.0+0x9b/0x160 [ 39.756941][ T443] ? netif_change_name+0x8c0/0x8c0 [ 39.756943][ T443] ? netif_set_allmulti+0x250/0x250 [ 39.756945][ T443] ? __kernel_text_address+0x12/0x30 [ 39.756947][ T443] ? write_profile+0xf0/0xf0 [ 39.756949][ T443] ? unwind_get_return_address+0x67/0xd0 [ 39.756952][ T443] netif_change_flags+0xfe/0x190 [ 39.756954][ T443] do_setlink.isra.0+0x1cc3/0x2750 [ 39.756957][ T443] ? stack_trace_save+0x93/0xc0 [ 39.756958][ T443] ? rtnl_link_get_size+0x350/0x350 [ 39.756959][ T443] ? rcu_is_watching+0x16/0xd0 [ 39.756961][ T443] ? stack_depot_save_flags+0x1bc/0x790 [ 39.756965][ T443] ? kasan_save_stack+0x3d/0x50 [ 39.756967][ T443] ? kasan_save_stack+0x2f/0x50 [ 39.756968][ T443] ? kasan_save_track+0x14/0x30 [ 39.756970][ T443] ? __kasan_kmalloc+0x7b/0x90 [ 39.756971][ T443] ? __kmalloc_cache_noprof+0x29a/0x620 [ 39.756973][ T443] ? rtnl_newlink+0x124/0x11c0 [ 39.756974][ T443] ? rtnetlink_rcv_msg+0x6fd/0xbd0 [ 39.756975][ T443] ? netlink_rcv_skb+0x14e/0x3a0 [ 39.756978][ T443] ? netlink_unicast+0x486/0x750 [ 39.756979][ T443] ? netlink_sendmsg+0x735/0xc60 [ 39.756980][ T443] ? ____sys_sendmsg+0x415/0x880 [ 39.756982][ T443] ? ___sys_sendmsg+0x14e/0x1d0 [ 39.756984][ T443] ? __sys_sendmsg+0x12c/0x1d0 [ 39.756985][ T443] ? do_syscall_64+0xff/0x530 [ 39.756987][ T443] ? entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 39.756990][ T443] ? rcu_is_watching+0x16/0xd0 [ 39.756991][ T443] ? lock_acquire+0x13c/0x160 [ 39.756993][ T443] ? rcu_is_watching+0x16/0xd0 [ 39.756994][ T443] ? rcu_is_watching+0x16/0xd0 [ 39.756996][ T443] ? trace_contention_end+0xb3/0x180 [ 39.756999][ T443] ? __mutex_lock+0x1db/0x1ea0 [ 39.757000][ T443] ? __mutex_lock+0x9a3/0x1ea0 [ 39.757002][ T443] ? rtnl_newlink+0x9a8/0x11c0 [ 39.757003][ T443] ? ww_mutex_lock+0x160/0x160 [ 39.757005][ T443] ? __rtnl_newlink+0x3fa/0xa50 [ 39.757007][ T443] rtnl_newlink+0x9f1/0x11c0 [ 39.757009][ T443] ? rcu_is_watching+0x16/0xd0 [ 39.757011][ T443] ? rtnl_bridge_getlink+0x850/0x850 [ 39.757012][ T443] ? lock_acquire+0x13c/0x160 [ 39.757013][ T443] ? rcu_is_watching+0x16/0xd0 [ 39.757015][ T443] ? is_bpf_text_address+0x3e/0x110 [ 39.757018][ T443] ? is_bpf_text_address+0x72/0x110 [ 39.757020][ T443] ? kernel_text_address+0x149/0x170 [ 39.757021][ T443] ? __kernel_text_address+0x12/0x30 [ 39.757029][ T443] ? write_profile+0xf0/0xf0 [ 39.757030][ T443] ? unwind_get_return_address+0x67/0xd0 [ 39.757031][ T443] ? rcu_is_watching+0x16/0xd0 [ 39.757033][ T443] ? rcu_is_watching+0x16/0xd0 [ 39.757034][ T443] ? cap_capable+0x1d7/0x3d0 [ 39.757038][ T443] ? lock_acquire+0x13c/0x160 [ 39.757039][ T443] ? rcu_is_watching+0x16/0xd0 [ 39.757041][ T443] ? rtnl_bridge_getlink+0x850/0x850 [ 39.757042][ T443] rtnetlink_rcv_msg+0x6fd/0xbd0 [ 39.757044][ T443] ? rtnl_link_fill+0x920/0x920 [ 39.757045][ T443] ? filter_irq_stacks+0xd0/0xd0 [ 39.757046][ T443] ? stack_depot_save_flags+0x1bc/0x790 [ 39.757049][ T443] netlink_rcv_skb+0x14e/0x3a0 [ 39.757050][ T443] ? rtnl_link_fill+0x920/0x920 [ 39.757051][ T443] ? lock_release+0x184/0x1f0 [ 39.757053][ T443] ? netlink_ack+0xcf0/0xcf0 [ 39.757054][ T443] ? __netlink_lookup+0xb9/0x6b0 [ 39.757056][ T443] ? rcu_is_watching+0x16/0xd0 [ 39.757058][ T443] ? lock_release+0x184/0x1f0 [ 39.757060][ T443] netlink_unicast+0x486/0x750 [ 39.757062][ T443] ? netlink_attachskb+0x810/0x810 [ 39.757063][ T443] ? rcu_is_watching+0x16/0xd0 [ 39.757065][ T443] ? rcu_is_watching+0x16/0xd0 [ 39.757067][ T443] ? lock_acquire+0x13c/0x160 [ 39.757068][ T443] netlink_sendmsg+0x735/0xc60 [ 39.757070][ T443] ? netlink_unicast+0x750/0x750 [ 39.757072][ T443] ? rcu_is_watching+0x16/0xd0 [ 39.757074][ T443] ? lock_release+0x184/0x1f0 [ 39.757075][ T443] ____sys_sendmsg+0x415/0x880 [ 39.757077][ T443] ? copy_msghdr_from_user+0x279/0x420 [ 39.757079][ T443] ? get_timestamp.constprop.0+0x390/0x390 [ 39.757080][ T443] ? move_addr_to_kernel+0x40/0x40 [ 39.757081][ T443] ? filter_irq_stacks+0xd0/0xd0 [ 39.757084][ T443] ___sys_sendmsg+0x14e/0x1d0 [ 39.757085][ T443] ? copy_msghdr_from_user+0x420/0x420 [ 39.757090][ T443] __sys_sendmsg+0x12c/0x1d0 [ 39.757092][ T443] ? __sys_sendmsg_sock+0x20/0x20 [ 39.757095][ T443] ? rcu_is_watching+0x16/0xd0 [ 39.757097][ T443] do_syscall_64+0xff/0x530 [ 39.757098][ T443] ? exc_page_fault+0xee/0x100 [ 39.757100][ T443] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 39.757102][ T443] RIP: 0033:0x7f79e841054e [ 39.757104][ T443] 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 [ 39.757106][ T443] RSP: 002b:00007ffcaa1f7890 EFLAGS: 00000202 ORIG_RAX: 000000000000002e [ 39.757109][ T443] RAX: ffffffffffffffda RBX: 0000000000000003 RCX: 00007f79e841054e [ 39.757110][ T443] RDX: 0000000000000000 RSI: 00007ffcaa1f7940 RDI: 0000000000000005 [ 39.757111][ T443] RBP: 00007ffcaa1f78a0 R08: 0000000000000000 R09: 0000000000000000 [ 39.757112][ T443] R10: 0000000000000000 R11: 0000000000000202 R12: 000000006a91b566 [ 39.757113][ T443] R13: 00000000004a1620 R14: 0000000000000000 R15: 00007ffcaa1f8000 [ 39.757115][ T443] [ 39.785888][ T443] ip (443) used greatest stack depth: 23016 bytes left [ 39.807098][ T444] veth1: left allmulticast mode [ 39.808070][ T444] veth1: left promiscuous mode [ 39.808474][ T444] br1: port 1(veth1) entered disabled state