[ 9.874019][ T213] fab-br0: port 1(fbond) entered blocking state [ 9.874085][ T213] BUG: sleeping function called from invalid context at ./include/linux/sched/mm.h:322 [ 9.874087][ T213] in_atomic(): 1, irqs_disabled(): 1, non_block: 0, pid: 213, name: ip [ 9.874089][ T213] preempt_count: 1, expected: 0 [ 9.874089][ T213] RCU nest depth: 0, expected: 0 [ 9.874090][ T213] locks held by ip/213: 5, last CPU#1: [ 9.874093][ T213] #0: ffffffffb3d22700 (rtnl_mutex){+.+.}-{4:4}, at: rtnl_newlink+0x9a8/0x11b0 [ 9.874105][ T213] #1: ffffffffb3599cc0 (console_lock){+.+.}-{0:0}, at: vprintk_emit+0x320/0x3e0 [ 9.874110][ T213] #2: ffffffffb3599d38 (console_srcu){....}-{0:0}, at: console_flush_one_record+0x106/0x710 [ 9.874114][ T213] #3: ffffffffb3489660 (console_owner){....}-{0:0}, at: console_lock_spinning_enable+0x40/0x60 [ 9.874117][ T213] #4: ffffffffb3489560 (printk_legacy_map-wait-type-override){....}-{3:3}, at: console_emit_next_record+0x202/0x4f0 [ 9.874120][ T213] irq event stamp: 18164 [ 9.874121][ T213] hardirqs last enabled at (18163): [] __down_trylock_console_sem+0x86/0xa0 [ 9.874125][ T213] hardirqs last disabled at (18164): [] console_emit_next_record+0x3f8/0x4f0 [ 9.874127][ T213] softirqs last enabled at (18074): [] __alloc_skb+0x4c5/0x5f0 [ 9.874130][ T213] softirqs last disabled at (18072): [] __alloc_skb+0x4c5/0x5f0 [ 9.874132][ T213] Preemption disabled at: [ 9.874133][ T213] [] vprintk_emit+0x31b/0x3e0 [ 9.874137][ T213] CPU: 1 UID: 0 PID: 213 Comm: ip Tainted: G W 7.2.0-virtme #1 PREEMPT(full) [ 9.874141][ T213] Tainted: [W]=WARN [ 9.874142][ T213] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 9.874143][ T213] Call Trace: [ 9.874145][ T213] [ 9.874146][ T213] dump_stack_lvl+0x6f/0xa0 [ 9.874151][ T213] ? vprintk_emit+0x31b/0x3e0 [ 9.874153][ T213] __might_resched.cold+0x1fe/0x2c1 [ 9.874157][ T213] ? perf_trace_sched_switch+0x7c0/0x7c0 [ 9.874161][ T213] ? __kmalloc_noprof+0xdb/0x760 [ 9.874167][ T213] __kmalloc_noprof+0x443/0x760 [ 9.874169][ T213] ? alloc_buf.isra.0+0x4b/0x260 [ 9.874176][ T213] ? do_raw_spin_unlock+0x59/0x250 [ 9.874178][ T213] alloc_buf.isra.0+0x4b/0x260 [ 9.874181][ T213] put_chars+0x1e1/0x2f0 [ 9.874184][ T213] ? printk_get_next_message+0x2fe/0x7d0 [ 9.874186][ T213] ? __send_to_port+0x420/0x420 [ 9.874189][ T213] ? validate_chain+0x34a/0xc20 [ 9.874195][ T213] hvc_console_print+0x292/0x780 [ 9.874202][ T213] ? hvc_write+0x3a0/0x3a0 [ 9.874205][ T213] ? rcu_is_watching+0x16/0xd0 [ 9.874208][ T213] ? lock_acquire+0x13c/0x160 [ 9.874212][ T213] console_emit_next_record+0x252/0x4f0 [ 9.874216][ T213] ? devkmsg_read+0x4e0/0x4e0 [ 9.874220][ T213] ? rcu_is_watching+0x16/0xd0 [ 9.874222][ T213] ? lock_acquire+0x13c/0x160 [ 9.874226][ T213] console_flush_one_record+0x46f/0x710 [ 9.874230][ T213] ? console_emit_next_record+0x4f0/0x4f0 [ 9.874231][ T213] ? __lock_acquire+0x518/0xc20 [ 9.874237][ T213] console_unlock+0xee/0x1f0 [ 9.874239][ T213] ? console_flush_one_record+0x710/0x710 [ 9.874240][ T213] ? rcu_is_watching+0x16/0xd0 [ 9.874242][ T213] ? lock_acquire+0x60/0x160 [ 9.874246][ T213] ? __down_trylock_console_sem+0x5e/0xa0 [ 9.874248][ T213] ? vprintk_emit+0x320/0x3e0 [ 9.874251][ T213] vprintk_emit+0x37c/0x3e0 [ 9.874254][ T213] ? wake_up_klogd_work_func+0x90/0x90 [ 9.874256][ T213] ? __lock_release.isra.0+0x69/0x1a0 [ 9.874258][ T213] ? _raw_spin_unlock_irqrestore+0x40/0x80 [ 9.874262][ T213] ? bond_poll_controller+0x480/0x480 [ 9.874265][ T213] ? mark_held_locks+0x40/0x70 [ 9.874269][ T213] _printk+0xc7/0x100 [ 9.874272][ T213] ? snapshot_read.cold+0x21/0x21 [ 9.874276][ T213] ? br_multicast_flood+0x960/0x960 [ 9.874280][ T213] ? do_setlink.isra.0+0x9ec/0x2a60 [ 9.874281][ T213] ? rtnl_newlink+0x9f1/0x11b0 [ 9.874283][ T213] ? rtnetlink_rcv_msg+0x6fd/0xbd0 [ 9.874288][ T213] br_set_state+0x22f/0x410 [ 9.874291][ T213] br_init_port+0xc4/0x200 [ 9.874294][ T213] new_nbp+0x3a0/0x650 [ 9.874298][ T213] br_add_if+0x212/0x1360 [ 9.874301][ T213] ? kernel_text_address+0x149/0x170 [ 9.874306][ T213] do_set_master+0x3b2/0x780 [ 9.874311][ T213] do_setlink.isra.0+0x9ec/0x2a60 [ 9.874314][ T213] ? stack_trace_save+0x93/0xc0 [ 9.874318][ T213] ? rtnl_link_get_size+0x350/0x350 [ 9.874320][ T213] ? rcu_read_lock_any_held+0x66/0x90 [ 9.874323][ T213] ? stack_depot_save_flags+0x38e/0x790 [ 9.874326][ T213] ? rcu_lockdep_current_cpu_online+0x3f/0x1b0 [ 9.874328][ T213] ? rcu_read_lock_any_held+0x3c/0x90 [ 9.874330][ T213] ? validate_chain+0x38b/0xc20 [ 9.874333][ T213] ? kasan_save_stack+0x3d/0x50 [ 9.874335][ T213] ? kasan_save_stack+0x2f/0x50 [ 9.874336][ T213] ? kasan_save_track+0x14/0x30 [ 9.874338][ T213] ? __lock_acquire+0x518/0xc20 [ 9.874340][ T213] ? netlink_seq_next+0x1e/0x60 [ 9.874343][ T213] ? ___sys_sendmsg+0xc0/0x1d0 [ 9.874347][ T213] ? lock_acquire.part.0+0xd4/0x280 [ 9.874349][ T213] ? rtnl_newlink+0x9a8/0x11b0 [ 9.874352][ T213] ? rcu_is_watching+0x16/0xd0 [ 9.874354][ T213] ? lock_acquire+0x13c/0x160 [ 9.874356][ T213] ? rcu_is_watching+0x16/0xd0 [ 9.874357][ T213] ? rcu_is_watching+0x16/0xd0 [ 9.874359][ T213] ? trace_contention_end+0xb3/0x180 [ 9.874362][ T213] ? __mutex_lock+0x1db/0x1ea0 [ 9.874363][ T213] ? __mutex_lock+0x9a3/0x1ea0 [ 9.874365][ T213] ? rtnl_newlink+0x9a8/0x11b0 [ 9.874369][ T213] ? ww_mutex_lock+0x160/0x160 [ 9.874371][ T213] ? nla_get_range_signed+0x3d0/0x3d0 [ 9.874377][ T213] ? __rtnl_newlink+0x3fa/0xa50 [ 9.874383][ T213] rtnl_newlink+0x9f1/0x11b0 [ 9.874389][ T213] ? rtnl_bridge_getlink+0x850/0x850 [ 9.874391][ T213] ? __lock_acquire+0x518/0xc20 [ 9.874396][ T213] ? lock_acquire.part.0+0xd4/0x280 [ 9.874398][ T213] ? find_held_lock+0x2b/0x80 [ 9.874401][ T213] ? rtnl_bridge_getlink+0x850/0x850 [ 9.874403][ T213] ? __lock_release.isra.0+0x69/0x1a0 [ 9.874407][ T213] ? rtnl_bridge_getlink+0x850/0x850 [ 9.874409][ T213] rtnetlink_rcv_msg+0x6fd/0xbd0 [ 9.874413][ T213] ? rtnl_link_fill+0x900/0x900 [ 9.874415][ T213] ? __lock_acquire+0x518/0xc20 [ 9.874420][ T213] ? lock_acquire.part.0+0xd4/0x280 [ 9.874422][ T213] ? find_held_lock+0x2b/0x80 [ 9.874425][ T213] netlink_rcv_skb+0x14e/0x3a0 [ 9.874427][ T213] ? rtnl_link_fill+0x900/0x900 [ 9.874431][ T213] ? netlink_ack+0xcd0/0xcd0 [ 9.874437][ T213] ? netlink_deliver_tap+0xc5/0x330 [ 9.874438][ T213] ? netlink_deliver_tap+0x13c/0x330 [ 9.874443][ T213] netlink_unicast+0x486/0x750 [ 9.874447][ T213] ? netlink_attachskb+0x810/0x810 [ 9.874449][ T213] ? __lock_acquire+0x518/0xc20 [ 9.874454][ T213] netlink_sendmsg+0x735/0xc60 [ 9.874458][ T213] ? netlink_unicast+0x750/0x750 [ 9.874462][ T213] ? __might_fault+0x97/0x140 [ 9.874468][ T213] ____sys_sendmsg+0x415/0x880 [ 9.874470][ T213] ? copy_msghdr_from_user+0x279/0x420 [ 9.874472][ T213] ? get_timestamp.constprop.0+0x3a0/0x3a0 [ 9.874473][ T213] ? move_addr_to_kernel+0x40/0x40 [ 9.874481][ T213] ___sys_sendmsg+0x14e/0x1d0 [ 9.874483][ T213] ? copy_msghdr_from_user+0x420/0x420 [ 9.874499][ T213] __sys_sendmsg+0x12c/0x1d0 [ 9.874502][ T213] ? __sys_sendmsg_sock+0x20/0x20 [ 9.874508][ T213] ? rcu_is_watching+0x16/0xd0 [ 9.874511][ T213] do_syscall_64+0xff/0x530 [ 9.874513][ T213] ? exc_page_fault+0xee/0x100 [ 9.874516][ T213] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 9.874518][ T213] RIP: 0033:0x7fe08659654e [ 9.874522][ T213] 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 [ 9.874524][ T213] RSP: 002b:00007fff65789e20 EFLAGS: 00000202 ORIG_RAX: 000000000000002e [ 9.874526][ T213] RAX: ffffffffffffffda RBX: 0000000000000003 RCX: 00007fe08659654e [ 9.874527][ T213] RDX: 0000000000000000 RSI: 00007fff65789ed0 RDI: 0000000000000005 [ 9.874528][ T213] RBP: 00007fff65789e30 R08: 0000000000000000 R09: 0000000000000000 [ 9.874529][ T213] R10: 0000000000000000 R11: 0000000000000202 R12: 000000006a91ba5b [ 9.874530][ T213] R13: 00000000004a1620 R14: 0000000000000000 R15: 00007fff6578a590 [ 9.874537][ T213] [ 9.905878][ T213] fab-br0: port 1(fbond) entered disabled state [ 9.906251][ T213] fbond: entered allmulticast mode [ 9.908125][ T213] fbond: entered promiscuous mode [ 9.917393][ T213] ip (213) used greatest stack depth: 23336 bytes left [ 9.956655][ T215] veth1-bond: entered promiscuous mode [ 9.957246][ T215] veth1-bond: entered allmulticast mode [ 9.958021][ T215] fbond: (slave veth1-bond): Enslaving as a backup interface with a down link [ 9.992240][ T216] veth2-bond: entered promiscuous mode [ 9.992732][ T216] veth2-bond: entered allmulticast mode [ 9.993295][ T216] fbond: (slave veth2-bond): Enslaving as a backup interface with a down link [ 10.115769][ T12] fbond: Warning: No 802.3ad response from the link partner for any adapters in the bond [ 10.116817][ T36] fab-br0: port 1(fbond) entered blocking state [ 10.117206][ T36] fab-br0: port 1(fbond) entered forwarding state [ 10.222115][ T12] fbond: (slave veth1-bond): link status definitely up, 10000 Mbps full duplex [ 10.222644][ T12] fbond: (slave veth2-bond): link status definitely up, 10000 Mbps full duplex [ 10.223341][ T12] fbond: active interface up! [ 10.267765][ C0] [ 10.267858][ C0] ======================================================== [ 10.268081][ C0] WARNING: possible irq lock inversion dependency detected [ 10.268299][ C0] 7.2.0-virtme #1 Tainted: G W [ 10.268479][ C0] -------------------------------------------------------- [ 10.268704][ C0] swapper/0/0 just changed the state of lock: [ 10.268888][ C0] ff1100000d1a2e58 (&br->lock){+.-.}-{3:3}, at: br_forward_delay_timer_expired+0x44/0x5d0 [ 10.269150][ C0] but this lock took another, SOFTIRQ-unsafe lock in the past: [ 10.269368][ C0] (fs_reclaim){+.+.}-{0:0} [ 10.269370][ C0] [ 10.269370][ C0] [ 10.269370][ C0] and interrupts could create inverse lock ordering between them. [ 10.269370][ C0] [ 10.269905][ C0] [ 10.269905][ C0] other info that might help us debug this: [ 10.270120][ C0] Chain exists of: [ 10.270120][ C0] &br->lock --> console_owner --> fs_reclaim [ 10.270120][ C0] [ 10.270450][ C0] Possible interrupt unsafe locking scenario: [ 10.270450][ C0] [ 10.270671][ C0] CPU0 CPU1 [ 10.270816][ C0] ---- ---- [ 10.270960][ C0] lock(fs_reclaim); [ 10.271072][ C0] local_irq_disable(); [ 10.271256][ C0] lock(&br->lock); [ 10.271440][ C0] lock(console_owner); [ 10.271622][ C0] [ 10.271740][ C0] lock(&br->lock); [ 10.271851][ C0] [ 10.271851][ C0] *** DEADLOCK *** [ 10.271851][ C0] [ 10.272063][ C0] locks held by swapper/0/0: 1, last CPU#0: [ 10.272246][ C0] #0: ffa0000000007c90 ((&p->forward_delay_timer)){+.-.}-{0:0}, at: call_timer_fn+0x110/0x4d0 [ 10.272545][ C0] [ 10.272545][ C0] the shortest dependencies between 2nd lock and 1st lock: [ 10.272798][ C0] -> (fs_reclaim){+.+.}-{0:0} { [ 10.272948][ C0] HARDIRQ-ON-W at: [ 10.273059][ C0] __lock_acquire+0x388/0xc20 [ 10.273248][ C0] lock_acquire.part.0+0xd4/0x280 [ 10.273428][ C0] fs_reclaim_acquire+0xd5/0x120 [ 10.273609][ C0] __kmalloc_cache_noprof+0x6e/0x620 [ 10.273829][ C0] kthread_create_worker_on_node+0xea/0x210 [ 10.274044][ C0] workqueue_init+0x2a/0x680 [ 10.274228][ C0] kernel_init_freeable+0x2fe/0x630 [ 10.274443][ C0] kernel_init+0x21/0x150 [ 10.274624][ C0] ret_from_fork+0x474/0x6b0 [ 10.274810][ C0] ret_from_fork_asm+0x11/0x20 [ 10.274992][ C0] SOFTIRQ-ON-W at: [ 10.275099][ C0] __lock_acquire+0x388/0xc20 [ 10.275279][ C0] lock_acquire.part.0+0xd4/0x280 [ 10.275458][ C0] fs_reclaim_acquire+0xd5/0x120 [ 10.275637][ C0] __kmalloc_cache_noprof+0x6e/0x620 [ 10.275858][ C0] kthread_create_worker_on_node+0xea/0x210 [ 10.276075][ C0] workqueue_init+0x2a/0x680 [ 10.276254][ C0] kernel_init_freeable+0x2fe/0x630 [ 10.276467][ C0] kernel_init+0x21/0x150 [ 10.276649][ C0] ret_from_fork+0x474/0x6b0 [ 10.276834][ C0] ret_from_fork_asm+0x11/0x20 [ 10.277013][ C0] INITIAL USE at: [ 10.277121][ C0] __lock_acquire+0x388/0xc20 [ 10.277300][ C0] lock_acquire.part.0+0xd4/0x280 [ 10.277484][ C0] fs_reclaim_acquire+0xd5/0x120 [ 10.277669][ C0] __kmalloc_cache_noprof+0x6e/0x620 [ 10.277886][ C0] kthread_create_worker_on_node+0xea/0x210 [ 10.278101][ C0] workqueue_init+0x2a/0x680 [ 10.278279][ C0] kernel_init_freeable+0x2fe/0x630 [ 10.278457][ C0] kernel_init+0x21/0x150 [ 10.278640][ C0] ret_from_fork+0x474/0x6b0 [ 10.278826][ C0] ret_from_fork_asm+0x11/0x20 [ 10.279005][ C0] } [ 10.279079][ C0] ... key at: [] __fs_reclaim_map+0x0/0xbe0 [ 10.279296][ C0] ... acquired at: [ 10.279404][ C0] __lock_acquire+0x518/0xc20 [ 10.279549][ C0] lock_acquire.part.0+0xd4/0x280 [ 10.279696][ C0] fs_reclaim_acquire+0xd5/0x120 [ 10.279839][ C0] __kmalloc_noprof+0xd3/0x760 [ 10.279985][ C0] alloc_buf.isra.0+0x4b/0x260 [ 10.280129][ C0] put_chars+0x1e1/0x2f0 [ 10.280272][ C0] hvc_console_print+0x292/0x780 [ 10.280417][ C0] console_emit_next_record+0x252/0x4f0 [ 10.280559][ C0] console_flush_one_record+0x46f/0x710 [ 10.280707][ C0] console_unlock+0xee/0x1f0 [ 10.280849][ C0] vprintk_emit+0x37c/0x3e0 [ 10.280994][ C0] _printk+0xc7/0x100 [ 10.281104][ C0] i8042_pnp_init+0xf7/0x3c0 [ 10.281248][ C0] i8042_platform_init+0x3f9/0x460 [ 10.281390][ C0] i8042_init+0x45/0x130 [ 10.281536][ C0] do_one_initcall+0x124/0x4f0 [ 10.281685][ C0] kernel_init_freeable+0x596/0x630 [ 10.281826][ C0] kernel_init+0x21/0x150 [ 10.281969][ C0] ret_from_fork+0x474/0x6b0 [ 10.282113][ C0] ret_from_fork_asm+0x11/0x20 [ 10.282255][ C0] [ 10.282329][ C0] -> (console_owner){....}-{0:0} { [ 10.282472][ C0] INITIAL USE at: [ 10.282579][ C0] } [ 10.282652][ C0] ... key at: [] console_owner_dep_map+0x0/0x60 [ 10.282869][ C0] ... acquired at: [ 10.282976][ C0] __lock_acquire+0x518/0xc20 [ 10.283120][ C0] lock_acquire.part.0+0xd4/0x280 [ 10.283263][ C0] console_lock_spinning_enable+0x5c/0x60 [ 10.283444][ C0] console_emit_next_record+0x1f4/0x4f0 [ 10.283586][ C0] console_flush_one_record+0x46f/0x710 [ 10.283733][ C0] console_unlock+0xee/0x1f0 [ 10.283877][ C0] vprintk_emit+0x37c/0x3e0 [ 10.284020][ C0] _printk+0xc7/0x100 [ 10.284128][ C0] br_set_state+0x22f/0x410 [ 10.284275][ C0] br_init_port+0xc4/0x200 [ 10.284416][ C0] br_stp_enable_port+0x12/0x50 [ 10.284559][ C0] br_port_carrier_check+0x220/0x430 [ 10.284708][ C0] br_device_event+0x538/0x930 [ 10.284854][ C0] notifier_call_chain+0xae/0x300 [ 10.284996][ C0] netif_state_change+0x139/0x3d0 [ 10.285141][ C0] __linkwatch_run_queue+0x350/0x850 [ 10.285284][ C0] linkwatch_event+0x7f/0xb0 [ 10.285428][ C0] process_one_work+0xe3e/0x1560 [ 10.285569][ C0] worker_thread+0x4f1/0xd60 [ 10.285714][ C0] kthread+0x367/0x460 [ 10.285822][ C0] ret_from_fork+0x474/0x6b0 [ 10.285966][ C0] ret_from_fork_asm+0x11/0x20 [ 10.286110][ C0] [ 10.286181][ C0] -> (&br->lock){+.-.}-{3:3} { [ 10.286327][ C0] HARDIRQ-ON-W at: [ 10.286435][ C0] __lock_acquire+0x388/0xc20 [ 10.286617][ C0] lock_acquire.part.0+0xd4/0x280 [ 10.286800][ C0] _raw_spin_lock_bh+0x38/0x50 [ 10.286981][ C0] br_dev_newlink+0xa6/0x160 [ 10.287162][ C0] rtnl_newlink_create+0x2d0/0x850 [ 10.287339][ C0] __rtnl_newlink+0x22b/0xa50 [ 10.287519][ C0] rtnl_newlink+0x9f1/0x11b0 [ 10.287702][ C0] rtnetlink_rcv_msg+0x6fd/0xbd0 [ 10.287880][ C0] netlink_rcv_skb+0x14e/0x3a0 [ 10.288060][ C0] netlink_unicast+0x486/0x750 [ 10.288241][ C0] netlink_sendmsg+0x735/0xc60 [ 10.288418][ C0] ____sys_sendmsg+0x415/0x880 [ 10.288598][ C0] ___sys_sendmsg+0x14e/0x1d0 [ 10.288780][ C0] __sys_sendmsg+0x12c/0x1d0 [ 10.288959][ C0] do_syscall_64+0xff/0x530 [ 10.289137][ C0] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 10.289354][ C0] IN-SOFTIRQ-W at: [ 10.289460][ C0] __lock_acquire+0x388/0xc20 [ 10.289639][ C0] lock_acquire.part.0+0xd4/0x280 [ 10.289822][ C0] _raw_spin_lock+0x33/0x40 [ 10.290001][ C0] br_forward_delay_timer_expired+0x44/0x5d0 [ 10.290212][ C0] call_timer_fn+0x160/0x4d0 [ 10.290399][ C0] __run_timers+0x68f/0xaa0 [ 10.290578][ C0] run_timer_softirq+0xf0/0x160 [ 10.290760][ C0] handle_softirqs+0x1d3/0x900 [ 10.290942][ C0] __irq_exit_rcu+0x145/0x1c0 [ 10.291125][ C0] irq_exit_rcu+0xe/0x30 [ 10.291304][ C0] sysvec_apic_timer_interrupt+0x9d/0xe0 [ 10.291524][ C0] asm_sysvec_apic_timer_interrupt+0x1a/0x20 [ 10.291741][ C0] pv_native_safe_halt+0xf/0x10 [ 10.291918][ C0] default_idle+0x9/0x10 [ 10.292098][ C0] default_idle_call+0x6e/0xb0 [ 10.292276][ C0] cpuidle_idle_call.constprop.0+0x237/0x410 [ 10.292493][ C0] do_idle+0xd8/0x190 [ 10.292638][ C0] cpu_startup_entry+0x53/0x70 [ 10.292821][ C0] rest_init+0x279/0x280 [ 10.292999][ C0] start_kernel+0x3af/0x3b0 [ 10.293181][ C0] x86_64_start_reservations+0x24/0x30 [ 10.293362][ C0] x86_64_start_kernel+0x12b/0x130 [ 10.293542][ C0] common_startup_64+0x13e/0x148 [ 10.293727][ C0] INITIAL USE at: [ 10.293834][ C0] __lock_acquire+0x388/0xc20 [ 10.294015][ C0] lock_acquire.part.0+0xd4/0x280 [ 10.294193][ C0] _raw_spin_lock_bh+0x38/0x50 [ 10.294373][ C0] br_dev_newlink+0xa6/0x160 [ 10.294552][ C0] rtnl_newlink_create+0x2d0/0x850 [ 10.294737][ C0] __rtnl_newlink+0x22b/0xa50 [ 10.294917][ C0] rtnl_newlink+0x9f1/0x11b0 [ 10.295097][ C0] rtnetlink_rcv_msg+0x6fd/0xbd0 [ 10.295329][ C0] netlink_rcv_skb+0x14e/0x3a0 [ 10.295510][ C0] netlink_unicast+0x486/0x750 [ 10.295744][ C0] netlink_sendmsg+0x735/0xc60 [ 10.295972][ C0] ____sys_sendmsg+0x415/0x880 [ 10.296152][ C0] ___sys_sendmsg+0x14e/0x1d0 [ 10.296381][ C0] __sys_sendmsg+0x12c/0x1d0 [ 10.296665][ C0] do_syscall_64+0xff/0x530 [ 10.296846][ C0] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 10.297111][ C0] } [ 10.297182][ C0] ... key at: [] __key.7+0x0/0x40 [ 10.297411][ C0] ... acquired at: [ 10.297516][ C0] mark_lock+0x1d7/0xa00 [ 10.297713][ C0] mark_usage+0x42/0x170 [ 10.297854][ C0] __lock_acquire+0x388/0xc20 [ 10.298048][ C0] lock_acquire.part.0+0xd4/0x280 [ 10.298240][ C0] _raw_spin_lock+0x33/0x40 [ 10.298432][ C0] br_forward_delay_timer_expired+0x44/0x5d0 [ 10.298609][ C0] call_timer_fn+0x160/0x4d0 [ 10.298803][ C0] __run_timers+0x68f/0xaa0 [ 10.298944][ C0] run_timer_softirq+0xf0/0x160 [ 10.299134][ C0] handle_softirqs+0x1d3/0x900 [ 10.299278][ C0] __irq_exit_rcu+0x145/0x1c0 [ 10.299518][ C0] irq_exit_rcu+0xe/0x30 [ 10.299666][ C0] sysvec_apic_timer_interrupt+0x9d/0xe0 [ 10.299894][ C0] asm_sysvec_apic_timer_interrupt+0x1a/0x20 [ 10.300117][ C0] pv_native_safe_halt+0xf/0x10 [ 10.300260][ C0] default_idle+0x9/0x10 [ 10.300452][ C0] default_idle_call+0x6e/0xb0 [ 10.300593][ C0] cpuidle_idle_call.constprop.0+0x237/0x410 [ 10.300825][ C0] do_idle+0xd8/0x190 [ 10.300932][ C0] cpu_startup_entry+0x53/0x70 [ 10.301124][ C0] rest_init+0x279/0x280 [ 10.301317][ C0] start_kernel+0x3af/0x3b0 [ 10.301508][ C0] x86_64_start_reservations+0x24/0x30 [ 10.301651][ C0] x86_64_start_kernel+0x12b/0x130 [ 10.301845][ C0] common_startup_64+0x13e/0x148 [ 10.301990][ C0] [ 10.302061][ C0] [ 10.302061][ C0] stack backtrace: [ 10.302289][ C0] CPU: 0 UID: 0 PID: 0 Comm: swapper/0 Tainted: G W 7.2.0-virtme #1 PREEMPT(full) [ 10.302292][ C0] Tainted: [W]=WARN [ 10.302293][ C0] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 10.302295][ C0] Call Trace: [ 10.302296][ C0] [ 10.302297][ C0] dump_stack_lvl+0x6f/0xa0 [ 10.302300][ C0] print_irq_inversion_bug.part.0.cold+0xe6/0x143 [ 10.302303][ C0] mark_lock_irq+0x989/0x9c0 [ 10.302306][ C0] mark_lock+0x1d7/0xa00 [ 10.302308][ C0] mark_usage+0x42/0x170 [ 10.302310][ C0] __lock_acquire+0x388/0xc20 [ 10.302313][ C0] lock_acquire.part.0+0xd4/0x280 [ 10.302315][ C0] ? br_forward_delay_timer_expired+0x44/0x5d0 [ 10.302316][ C0] ? rcu_is_watching+0x16/0xd0 [ 10.302319][ C0] ? lock_acquire+0x13c/0x160 [ 10.302321][ C0] ? br_message_age_timer_expired+0x70/0x70 [ 10.302323][ C0] _raw_spin_lock+0x33/0x40 [ 10.302324][ C0] ? br_forward_delay_timer_expired+0x44/0x5d0 [ 10.302325][ C0] br_forward_delay_timer_expired+0x44/0x5d0 [ 10.302327][ C0] ? br_message_age_timer_expired+0x70/0x70 [ 10.302329][ C0] call_timer_fn+0x160/0x4d0 [ 10.302330][ C0] ? detach_if_pending+0x1d0/0x1d0 [ 10.302331][ C0] ? debug_object_active_state+0x430/0x430 [ 10.302335][ C0] ? find_held_lock+0x2b/0x80 [ 10.302337][ C0] ? __lock_release.isra.0+0x69/0x1a0 [ 10.302339][ C0] ? rcu_is_watching+0x16/0xd0 [ 10.302341][ C0] __run_timers+0x68f/0xaa0 [ 10.302342][ C0] ? br_message_age_timer_expired+0x70/0x70 [ 10.302344][ C0] ? __bpf_trace_itimer_expire+0x10/0x10 [ 10.302345][ C0] ? __lock_acquire+0x518/0xc20 [ 10.302348][ C0] ? __rwlock_init+0x150/0x150 [ 10.302350][ C0] run_timer_softirq+0xf0/0x160 [ 10.302351][ C0] ? __run_timers+0xaa0/0xaa0 [ 10.302353][ C0] ? trace_irq_enable.constprop.0+0x9b/0x160 [ 10.302356][ C0] ? rcu_is_watching+0x16/0xd0 [ 10.302357][ C0] handle_softirqs+0x1d3/0x900 [ 10.302359][ C0] ? __lock_release.isra.0+0x69/0x1a0 [ 10.302361][ C0] ? _local_bh_enable+0xc0/0xc0 [ 10.302363][ C0] __irq_exit_rcu+0x145/0x1c0 [ 10.302365][ C0] irq_exit_rcu+0xe/0x30 [ 10.302367][ C0] sysvec_apic_timer_interrupt+0x9d/0xe0 [ 10.302369][ C0] [ 10.302369][ C0] [ 10.302370][ C0] ? lockdep_hardirqs_on_prepare.part.0+0x9a/0x160 [ 10.302372][ C0] asm_sysvec_apic_timer_interrupt+0x1a/0x20 [ 10.302373][ C0] RIP: 0010:pv_native_safe_halt+0xf/0x10 [ 10.302375][ C0] Code: 48 8b 3d 94 02 09 02 e8 1f 00 00 00 48 2b 05 58 93 a6 00 c3 0f 1f 80 00 00 00 00 f3 0f 1e fa eb 07 0f 00 2d 13 46 1b 00 fb f4 0f 1f 40 d6 48 83 ec 20 8b 17 49 89 f8 83 e2 fe 41 89 d2 0f 01 [ 10.302377][ C0] RSP: 0018:ffffffffb3207cf8 EFLAGS: 00000296 [ 10.302379][ C0] RAX: 0000000000054bbd RBX: ffffffffb321c600 RCX: ffffffffb00fa307 [ 10.302381][ C0] RDX: ffffffffb321c600 RSI: ffffffffb30a7f5f RDI: ffffffffb2a8f560 [ 10.302382][ C0] RBP: 0000000000000000 R08: 0000000000000000 R09: 0000000000000000 [ 10.302382][ C0] R10: 0000000000000000 R11: 0000000000000001 R12: 1ffffffff6640fa2 [ 10.302383][ C0] R13: 0000000000000000 R14: dffffc0000000000 R15: 0000000000014770 [ 10.302385][ C0] ? cpuidle_idle_call.constprop.0+0x237/0x410 [ 10.302387][ C0] ? lockdep_hardirqs_on+0x91/0x130 [ 10.302389][ C0] default_idle+0x9/0x10 [ 10.302390][ C0] default_idle_call+0x6e/0xb0 [ 10.302392][ C0] cpuidle_idle_call.constprop.0+0x237/0x410 [ 10.302394][ C0] ? arch_cpu_idle_exit+0x40/0x40 [ 10.302396][ C0] ? mark_tsc_async_resets+0x30/0x30 [ 10.302399][ C0] ? rcu_is_watching+0x16/0xd0 [ 10.302400][ C0] do_idle+0xd8/0x190 [ 10.302402][ C0] cpu_startup_entry+0x53/0x70 [ 10.302404][ C0] rest_init+0x279/0x280 [ 10.302405][ C0] ? __cpuidle_text_end+0x3b/0x3b [ 10.302408][ C0] ? rest_init+0x280/0x280 [ 10.302410][ C0] ? acpi_hw_set_mode+0x4a0/0x4a0 [ 10.302413][ C0] ? cpus_read_unlock+0x4f/0xc0 [ 10.302415][ C0] ? acpi_enable+0x1e4/0x330 [ 10.302417][ C0] start_kernel+0x3af/0x3b0 [ 10.302419][ C0] x86_64_start_reservations+0x24/0x30 [ 10.302421][ C0] x86_64_start_kernel+0x12b/0x130 [ 10.302423][ C0] common_startup_64+0x13e/0x148 [ 10.302426][ C0] [ 11.502158][ T292] fbond: left allmulticast mode [ 11.502174][ T292] BUG: sleeping function called from invalid context at ./include/linux/sched/mm.h:322 [ 11.502177][ T292] in_atomic(): 1, irqs_disabled(): 1, non_block: 0, pid: 292, name: ip [ 11.502179][ T292] preempt_count: 1, expected: 0 [ 11.502180][ T292] RCU nest depth: 0, expected: 0 [ 11.502180][ T292] INFO: lockdep is turned off. [ 11.502182][ T292] irq event stamp: 0 [ 11.502182][ T292] hardirqs last enabled at (0): [<0000000000000000>] 0x0 [ 11.502186][ T292] hardirqs last disabled at (0): [] copy_process+0x1ccd/0x6240 [ 11.502192][ T292] softirqs last enabled at (0): [] copy_process+0x1d21/0x6240 [ 11.502194][ T292] softirqs last disabled at (0): [<0000000000000000>] 0x0 [ 11.502196][ T292] Preemption disabled at: [ 11.502196][ T292] [] vprintk_emit+0x31b/0x3e0 [ 11.502204][ T292] CPU: 0 UID: 0 PID: 292 Comm: ip Tainted: G W 7.2.0-virtme #1 PREEMPT(full) [ 11.502207][ T292] Tainted: [W]=WARN [ 11.502208][ T292] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 11.502210][ T292] Call Trace: [ 11.502211][ T292] [ 11.502212][ T292] dump_stack_lvl+0x6f/0xa0 [ 11.502217][ T292] ? vprintk_emit+0x31b/0x3e0 [ 11.502219][ T292] __might_resched.cold+0x1fe/0x2c1 [ 11.502223][ T292] ? perf_trace_sched_switch+0x7c0/0x7c0 [ 11.502225][ T292] ? rcu_is_watching+0x16/0xd0 [ 11.502229][ T292] __kmalloc_noprof+0x443/0x760 [ 11.502233][ T292] ? __rwlock_init+0x150/0x150 [ 11.502235][ T292] ? alloc_buf.isra.0+0x4b/0x260 [ 11.502239][ T292] ? do_raw_spin_unlock+0x59/0x250 [ 11.502240][ T292] alloc_buf.isra.0+0x4b/0x260 [ 11.502242][ T292] put_chars+0x1e1/0x2f0 [ 11.502245][ T292] ? printk_get_next_message+0x2fe/0x7d0 [ 11.502246][ T292] ? __send_to_port+0x420/0x420 [ 11.502248][ T292] ? desc_read+0x2f0/0x2f0 [ 11.502250][ T292] ? desc_read+0x219/0x2f0 [ 11.502252][ T292] hvc_console_print+0x292/0x780 [ 11.502256][ T292] ? hvc_write+0x3a0/0x3a0 [ 11.502258][ T292] ? rcu_is_watching+0x16/0xd0 [ 11.502259][ T292] ? lock_acquire+0x13c/0x160 [ 11.502262][ T292] console_emit_next_record+0x252/0x4f0 [ 11.502264][ T292] ? devkmsg_read+0x4e0/0x4e0 [ 11.502265][ T292] ? _prb_read_valid+0x6e0/0x6e0 [ 11.502267][ T292] ? __asan_memmove+0x3c/0x60 [ 11.502270][ T292] ? rcu_is_watching+0x16/0xd0 [ 11.502271][ T292] ? rcu_is_watching+0x16/0xd0 [ 11.502272][ T292] ? rcu_is_watching+0x16/0xd0 [ 11.502273][ T292] ? lock_acquire+0x13c/0x160 [ 11.502275][ T292] ? console_flush_one_record+0x111/0x710 [ 11.502277][ T292] console_flush_one_record+0x46f/0x710 [ 11.502278][ T292] ? console_emit_next_record+0x4f0/0x4f0 [ 11.502281][ T292] console_unlock+0xee/0x1f0 [ 11.502282][ T292] ? lock_acquire+0x13c/0x160 [ 11.502284][ T292] ? console_flush_one_record+0x710/0x710 [ 11.502285][ T292] ? rcu_is_watching+0x16/0xd0 [ 11.502286][ T292] ? lock_release+0x184/0x1f0 [ 11.502288][ T292] ? lock_acquire+0x60/0x160 [ 11.502289][ T292] ? sync_exp_reset_tree_hotplug+0x3a0/0x3f0 [ 11.502291][ T292] ? __down_trylock_console_sem+0x5e/0xa0 [ 11.502293][ T292] ? vprintk_emit+0x320/0x3e0 [ 11.502295][ T292] vprintk_emit+0x37c/0x3e0 [ 11.502297][ T292] ? wake_up_klogd_work_func+0x90/0x90 [ 11.502298][ T292] ? netlink_rcv_skb+0x14e/0x3a0 [ 11.502301][ T292] ? netlink_sendmsg+0x735/0xc60 [ 11.502302][ T292] ? ____sys_sendmsg+0x415/0x880 [ 11.502305][ T292] ? ___sys_sendmsg+0x14e/0x1d0 [ 11.502306][ T292] ? __sys_sendmsg+0x12c/0x1d0 [ 11.502308][ T292] ? do_syscall_64+0xff/0x530 [ 11.502310][ T292] ? entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 11.502312][ T292] _printk+0xc7/0x100 [ 11.502315][ T292] ? snapshot_read.cold+0x21/0x21 [ 11.502317][ T292] ? netdev_name+0x43/0x60 [ 11.502320][ T292] ? __netdev_printk+0x17f/0x1d0 [ 11.502321][ T292] netdev_info+0xe2/0x116 [ 11.502323][ T292] ? netdev_notice+0x120/0x120 [ 11.502325][ T292] ? rcu_is_watching+0x16/0xd0 [ 11.502326][ T292] ? __up_read+0x355/0x9e0 [ 11.502327][ T292] ? trace_hardirqs_on+0x36/0x40 [ 11.502330][ T292] ? down_write_nested+0x200/0x200 [ 11.502332][ T292] ? mutex_is_locked+0x1c/0x50 [ 11.502333][ T292] netif_set_allmulti.cold+0x7c/0x166 [ 11.502336][ T292] dev_set_allmulti+0xa6/0x240 [ 11.502340][ T292] del_nbp+0xb7/0xc10 [ 11.502343][ T292] ? __asan_memset+0x27/0x50 [ 11.502345][ T292] br_dev_delete+0x9d/0x1d0 [ 11.502347][ T292] rtnl_dellink+0x48f/0xae0 [ 11.502349][ T292] ? lock_release+0x184/0x1f0 [ 11.502351][ T292] ? rcu_is_watching+0x16/0xd0 [ 11.502353][ T292] ? rtnl_link_get_net_capable.constprop.0+0x3d0/0x3d0 [ 11.502354][ T292] ? rcu_is_watching+0x16/0xd0 [ 11.502360][ T292] ? unwind_next_frame+0x69b/0x1ea0 [ 11.502363][ T292] ? entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 11.502364][ T292] ? rcu_is_watching+0x16/0xd0 [ 11.502365][ T292] ? rcu_is_watching+0x16/0xd0 [ 11.502367][ T292] ? lock_acquire+0x13c/0x160 [ 11.502368][ T292] ? rcu_is_watching+0x16/0xd0 [ 11.502370][ T292] ? lock_release+0x184/0x1f0 [ 11.502371][ T292] ? is_bpf_text_address+0x3e/0x110 [ 11.502374][ T292] ? is_bpf_text_address+0x72/0x110 [ 11.502375][ T292] ? kernel_text_address+0x149/0x170 [ 11.502378][ T292] ? __kernel_text_address+0x12/0x30 [ 11.502380][ T292] ? write_profile+0xf0/0xf0 [ 11.502382][ T292] ? unwind_get_return_address+0x67/0xd0 [ 11.502384][ T292] ? rcu_is_watching+0x16/0xd0 [ 11.502385][ T292] ? rcu_is_watching+0x16/0xd0 [ 11.502387][ T292] ? cap_capable+0x1d7/0x3d0 [ 11.502390][ T292] ? lock_acquire+0x13c/0x160 [ 11.502392][ T292] ? rcu_is_watching+0x16/0xd0 [ 11.502393][ T292] ? rtnl_link_get_net_capable.constprop.0+0x3d0/0x3d0 [ 11.502395][ T292] rtnetlink_rcv_msg+0x6fd/0xbd0 [ 11.502397][ T292] ? rtnl_link_fill+0x900/0x900 [ 11.502399][ T292] ? filter_irq_stacks+0xd0/0xd0 [ 11.502401][ T292] ? stack_depot_save_flags+0x1bc/0x790 [ 11.502404][ T292] netlink_rcv_skb+0x14e/0x3a0 [ 11.502406][ T292] ? rtnl_link_fill+0x900/0x900 [ 11.502407][ T292] ? lock_release+0x184/0x1f0 [ 11.502409][ T292] ? netlink_ack+0xcd0/0xcd0 [ 11.502411][ T292] ? __netlink_lookup+0xb9/0x6b0 [ 11.502413][ T292] ? rcu_is_watching+0x16/0xd0 [ 11.502414][ T292] ? lock_release+0x184/0x1f0 [ 11.502416][ T292] netlink_unicast+0x486/0x750 [ 11.502418][ T292] ? netlink_attachskb+0x810/0x810 [ 11.502420][ T292] ? rcu_is_watching+0x16/0xd0 [ 11.502421][ T292] ? rcu_is_watching+0x16/0xd0 [ 11.502422][ T292] ? lock_acquire+0x13c/0x160 [ 11.502424][ T292] netlink_sendmsg+0x735/0xc60 [ 11.502426][ T292] ? netlink_unicast+0x750/0x750 [ 11.502428][ T292] ? rcu_is_watching+0x16/0xd0 [ 11.502430][ T292] ? lock_release+0x184/0x1f0 [ 11.502432][ T292] ____sys_sendmsg+0x415/0x880 [ 11.502433][ T292] ? copy_msghdr_from_user+0x279/0x420 [ 11.502434][ T292] ? get_timestamp.constprop.0+0x3a0/0x3a0 [ 11.502435][ T292] ? move_addr_to_kernel+0x40/0x40 [ 11.502437][ T292] ? filter_irq_stacks+0xd0/0xd0 [ 11.502439][ T292] ___sys_sendmsg+0x14e/0x1d0 [ 11.502441][ T292] ? copy_msghdr_from_user+0x420/0x420 [ 11.502445][ T292] __sys_sendmsg+0x12c/0x1d0 [ 11.502447][ T292] ? __sys_sendmsg_sock+0x20/0x20 [ 11.502449][ T292] ? rcu_is_watching+0x16/0xd0 [ 11.502451][ T292] do_syscall_64+0xff/0x530 [ 11.502452][ T292] ? exc_page_fault+0xee/0x100 [ 11.502454][ T292] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 11.502456][ T292] RIP: 0033:0x7fe5d063354e [ 11.502458][ T292] 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 [ 11.502459][ T292] RSP: 002b:00007ffcf42a8bc0 EFLAGS: 00000202 ORIG_RAX: 000000000000002e [ 11.502463][ T292] RAX: ffffffffffffffda RBX: 0000000000000001 RCX: 00007fe5d063354e [ 11.502464][ T292] RDX: 0000000000000000 RSI: 00007ffcf42a8c70 RDI: 0000000000000005 [ 11.502465][ T292] RBP: 00007ffcf42a8bd0 R08: 0000000000000000 R09: 0000000000000000 [ 11.502466][ T292] R10: 0000000000000000 R11: 0000000000000202 R12: 000000006a91ba5c [ 11.502467][ T292] R13: 00000000004a1620 R14: 0000000000000000 R15: 00007ffcf42a9330 [ 11.502469][ T292] [ 11.521223][ T292] veth1-bond: left allmulticast mode [ 11.521356][ T292] veth2-bond: left allmulticast mode [ 11.521513][ T292] fbond: left promiscuous mode [ 11.521638][ T292] veth1-bond: left promiscuous mode [ 11.521856][ T292] veth2-bond: left promiscuous mode [ 11.522145][ T292] fab-br0: port 1(fbond) entered disabled state [ 11.565759][ T294] fbond (unregistering): (slave veth1-bond): Removing an active aggregator [ 11.566449][ T294] fbond (unregistering): (slave veth1-bond): Releasing backup interface [ 11.574193][ T294] fbond (unregistering): (slave veth2-bond): Removing an active aggregator [ 11.574549][ T294] fbond (unregistering): (slave veth2-bond): Releasing backup interface [ 11.587156][ T294] fbond (unregistering): Released all slaves