[ 11.067590][ T245] bond0: (slave veth0): Enslaving as a backup interface with a down link [ 11.067649][ T245] BUG: sleeping function called from invalid context at ./include/linux/sched/mm.h:322 [ 11.067651][ T245] in_atomic(): 1, irqs_disabled(): 1, non_block: 0, pid: 245, name: ip [ 11.067653][ T245] preempt_count: 1, expected: 0 [ 11.067654][ T245] RCU nest depth: 0, expected: 0 [ 11.067655][ T245] locks held by ip/245: 5, last CPU#3: [ 11.067657][ T245] #0: ffffffff88322700 (rtnl_mutex){+.+.}-{4:4}, at: rtnl_newlink+0x9a8/0x11b0 [ 11.067669][ T245] #1: ffffffff87b99cc0 (console_lock){+.+.}-{0:0}, at: vprintk_emit+0x320/0x3e0 [ 11.067674][ T245] #2: ffffffff87b99d38 (console_srcu){....}-{0:0}, at: console_flush_one_record+0x106/0x710 [ 11.067678][ T245] #3: ffffffff87a89660 (console_owner){....}-{0:0}, at: console_lock_spinning_enable+0x40/0x60 [ 11.067681][ T245] #4: ffffffff87a89560 (printk_legacy_map-wait-type-override){....}-{3:3}, at: console_emit_next_record+0x202/0x4f0 [ 11.067684][ T245] irq event stamp: 17846 [ 11.067685][ T245] hardirqs last enabled at (17845): [] __down_trylock_console_sem+0x86/0xa0 [ 11.067689][ T245] hardirqs last disabled at (17846): [] console_emit_next_record+0x3f8/0x4f0 [ 11.067691][ T245] softirqs last enabled at (17816): [] dev_mc_add+0xd2/0x110 [ 11.067694][ T245] softirqs last disabled at (17800): [] dev_mc_add+0x62/0x110 [ 11.067697][ T245] Preemption disabled at: [ 11.067698][ T245] [] vprintk_emit+0x31b/0x3e0 [ 11.067703][ T245] CPU: 3 UID: 0 PID: 245 Comm: ip Tainted: G W 7.2.0-virtme #1 PREEMPT(full) [ 11.067706][ T245] Tainted: [W]=WARN [ 11.067707][ T245] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 11.067709][ T245] Call Trace: [ 11.067711][ T245] [ 11.067712][ T245] dump_stack_lvl+0x6f/0xa0 [ 11.067717][ T245] ? vprintk_emit+0x31b/0x3e0 [ 11.067719][ T245] __might_resched.cold+0x1fe/0x2c1 [ 11.067724][ T245] ? perf_trace_sched_switch+0x7c0/0x7c0 [ 11.067727][ T245] ? __kmalloc_noprof+0xdb/0x760 [ 11.067733][ T245] __kmalloc_noprof+0x443/0x760 [ 11.067735][ T245] ? alloc_buf.isra.0+0x4b/0x260 [ 11.067742][ T245] ? do_raw_spin_unlock+0x59/0x250 [ 11.067744][ T245] alloc_buf.isra.0+0x4b/0x260 [ 11.067748][ T245] put_chars+0x1e1/0x2f0 [ 11.067751][ T245] ? __send_to_port+0x420/0x420 [ 11.067758][ T245] hvc_console_print+0x292/0x780 [ 11.067765][ T245] ? hvc_write+0x3a0/0x3a0 [ 11.067769][ T245] ? lock_acquire+0x13c/0x160 [ 11.067773][ T245] console_emit_next_record+0x252/0x4f0 [ 11.067776][ T245] ? devkmsg_read+0x4e0/0x4e0 [ 11.067780][ T245] ? rcu_is_watching+0x16/0xd0 [ 11.067784][ T245] ? lock_acquire+0x13c/0x160 [ 11.067788][ T245] console_flush_one_record+0x46f/0x710 [ 11.067791][ T245] ? console_emit_next_record+0x4f0/0x4f0 [ 11.067793][ T245] ? __lock_acquire+0x518/0xc20 [ 11.067798][ T245] console_unlock+0xee/0x1f0 [ 11.067801][ T245] ? console_flush_one_record+0x710/0x710 [ 11.067802][ T245] ? rcu_is_watching+0x16/0xd0 [ 11.067804][ T245] ? lock_acquire+0x60/0x160 [ 11.067808][ T245] ? __down_trylock_console_sem+0x5e/0xa0 [ 11.067810][ T245] ? vprintk_emit+0x320/0x3e0 [ 11.067813][ T245] vprintk_emit+0x37c/0x3e0 [ 11.067816][ T245] ? wake_up_klogd_work_func+0x90/0x90 [ 11.067818][ T245] ? packet_sendmsg_spkt+0x1350/0x1350 [ 11.067825][ T245] _printk+0xc7/0x100 [ 11.067828][ T245] ? snapshot_read.cold+0x21/0x21 [ 11.067832][ T245] ? __mutex_unlock_slowpath+0x9e/0x740 [ 11.067835][ T245] ? netdev_name+0x43/0x60 [ 11.067838][ T245] ? __netdev_printk+0x17f/0x1d0 [ 11.067841][ T245] netdev_info+0xe2/0x116 [ 11.067843][ T245] ? netdev_notice+0x120/0x120 [ 11.067847][ T245] ? bond_lower_state_changed+0x160/0x160 [ 11.067851][ T245] ? __lock_release.isra.0+0x69/0x1a0 [ 11.067856][ T245] bond_enslave.cold+0x156/0x4f7 [ 11.067864][ T245] ? find_held_lock+0x2b/0x80 [ 11.067866][ T245] ? bond_update_slave_arr+0xcf0/0xcf0 [ 11.067867][ T245] ? mark_usage+0x61/0x170 [ 11.067869][ T245] ? __lock_acquire+0x518/0xc20 [ 11.067871][ T245] ? __lock_acquire+0x500/0xc20 [ 11.067876][ T245] ? lock_acquire.part.0+0xd4/0x280 [ 11.067883][ T245] ? is_bpf_text_address+0x72/0x110 [ 11.067886][ T245] ? kernel_text_address+0x149/0x170 [ 11.067892][ T245] do_set_master+0x3b2/0x780 [ 11.067896][ T245] do_setlink.isra.0+0x9ec/0x2a60 [ 11.067899][ T245] ? stack_trace_save+0x93/0xc0 [ 11.067903][ T245] ? rtnl_link_get_size+0x350/0x350 [ 11.067905][ T245] ? rcu_read_lock_any_held+0x66/0x90 [ 11.067908][ T245] ? stack_depot_save_flags+0x38e/0x790 [ 11.067911][ T245] ? rcu_lockdep_current_cpu_online+0x3f/0x1b0 [ 11.067913][ T245] ? rcu_read_lock_any_held+0x3c/0x90 [ 11.067915][ T245] ? validate_chain+0x38b/0xc20 [ 11.067918][ T245] ? kasan_save_stack+0x3d/0x50 [ 11.067920][ T245] ? kasan_save_stack+0x2f/0x50 [ 11.067921][ T245] ? kasan_save_track+0x14/0x30 [ 11.067923][ T245] ? __lock_acquire+0x518/0xc20 [ 11.067926][ T245] ? netlink_seq_next+0x5e/0x60 [ 11.067929][ T245] ? ___sys_sendmsg+0xc0/0x1d0 [ 11.067933][ T245] ? lock_acquire.part.0+0xd4/0x280 [ 11.067935][ T245] ? rtnl_newlink+0x9a8/0x11b0 [ 11.067938][ T245] ? rcu_is_watching+0x16/0xd0 [ 11.067940][ T245] ? lock_acquire+0x13c/0x160 [ 11.067942][ T245] ? rcu_is_watching+0x16/0xd0 [ 11.067943][ T245] ? rcu_is_watching+0x16/0xd0 [ 11.067945][ T245] ? trace_contention_end+0xb3/0x180 [ 11.067948][ T245] ? __mutex_lock+0x1db/0x1ea0 [ 11.067949][ T245] ? __mutex_lock+0x9a3/0x1ea0 [ 11.067951][ T245] ? rtnl_newlink+0x9a8/0x11b0 [ 11.067955][ T245] ? ww_mutex_lock+0x160/0x160 [ 11.067957][ T245] ? nla_get_range_signed+0x3d0/0x3d0 [ 11.067963][ T245] ? __rtnl_newlink+0x3fa/0xa50 [ 11.067968][ T245] rtnl_newlink+0x9f1/0x11b0 [ 11.067974][ T245] ? rtnl_bridge_getlink+0x850/0x850 [ 11.067976][ T245] ? __lock_acquire+0x518/0xc20 [ 11.067981][ T245] ? lock_acquire.part.0+0xd4/0x280 [ 11.067983][ T245] ? find_held_lock+0x2b/0x80 [ 11.067985][ T245] ? rtnl_bridge_getlink+0x850/0x850 [ 11.067987][ T245] ? __lock_release.isra.0+0x69/0x1a0 [ 11.067991][ T245] ? rtnl_bridge_getlink+0x850/0x850 [ 11.067993][ T245] rtnetlink_rcv_msg+0x6fd/0xbd0 [ 11.067997][ T245] ? rtnl_link_fill+0x900/0x900 [ 11.067999][ T245] ? __lock_acquire+0x518/0xc20 [ 11.068003][ T245] ? lock_acquire.part.0+0xd4/0x280 [ 11.068006][ T245] ? find_held_lock+0x2b/0x80 [ 11.068009][ T245] netlink_rcv_skb+0x14e/0x3a0 [ 11.068011][ T245] ? rtnl_link_fill+0x900/0x900 [ 11.068014][ T245] ? netlink_ack+0xcd0/0xcd0 [ 11.068020][ T245] ? netlink_deliver_tap+0xc5/0x330 [ 11.068022][ T245] ? netlink_deliver_tap+0x13c/0x330 [ 11.068026][ T245] netlink_unicast+0x486/0x750 [ 11.068030][ T245] ? netlink_attachskb+0x810/0x810 [ 11.068033][ T245] ? __lock_acquire+0x518/0xc20 [ 11.068037][ T245] netlink_sendmsg+0x735/0xc60 [ 11.068041][ T245] ? netlink_unicast+0x750/0x750 [ 11.068044][ T245] ? __might_fault+0x97/0x140 [ 11.068050][ T245] ____sys_sendmsg+0x415/0x880 [ 11.068052][ T245] ? copy_msghdr_from_user+0x279/0x420 [ 11.068054][ T245] ? get_timestamp.constprop.0+0x3a0/0x3a0 [ 11.068056][ T245] ? move_addr_to_kernel+0x40/0x40 [ 11.068063][ T245] ___sys_sendmsg+0x14e/0x1d0 [ 11.068065][ T245] ? copy_msghdr_from_user+0x420/0x420 [ 11.068080][ T245] __sys_sendmsg+0x12c/0x1d0 [ 11.068083][ T245] ? __sys_sendmsg_sock+0x20/0x20 [ 11.068089][ T245] ? rcu_is_watching+0x16/0xd0 [ 11.068092][ T245] do_syscall_64+0xff/0x530 [ 11.068094][ T245] ? exc_page_fault+0xee/0x100 [ 11.068097][ T245] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 11.068100][ T245] RIP: 0033:0x7f538762154e [ 11.068104][ T245] 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.068105][ T245] RSP: 002b:00007ffe195738d0 EFLAGS: 00000202 ORIG_RAX: 000000000000002e [ 11.068108][ T245] RAX: ffffffffffffffda RBX: 0000000000000003 RCX: 00007f538762154e [ 11.068109][ T245] RDX: 0000000000000000 RSI: 00007ffe19573980 RDI: 0000000000000005 [ 11.068110][ T245] RBP: 00007ffe195738e0 R08: 0000000000000000 R09: 0000000000000000 [ 11.068111][ T245] R10: 0000000000000000 R11: 0000000000000202 R12: 000000006a90e581 [ 11.068111][ T245] R13: 00000000004a1620 R14: 0000000000000000 R15: 00007ffe19574050 [ 11.068118][ T245] [ 11.111270][ T245] ip (245) used greatest stack depth: 22824 bytes left [ 11.141574][ T246] bond0: (slave veth1): Enslaving as a backup interface with a down link [ 11.172351][ T247] br0: port 1(veth0) entered blocking state [ 11.172697][ T247] br0: port 1(veth0) entered disabled state [ 11.173028][ T247] veth0: entered allmulticast mode [ 11.174411][ T247] veth0: entered promiscuous mode [ 11.214579][ T248] br0: port 2(veth1) entered blocking state [ 11.214924][ T248] br0: port 2(veth1) entered disabled state [ 11.215221][ T248] veth1: entered allmulticast mode [ 11.216253][ T248] veth1: entered promiscuous mode [ 11.694548][ T36] br0: port 1(veth0) entered blocking state [ 11.694983][ T36] br0: port 1(veth0) entered forwarding state [ 11.696093][ T36] br0: port 2(veth1) entered blocking state [ 11.696394][ T36] br0: port 2(veth1) entered forwarding state [ 13.118193][ T71] bond0: (slave veth1): link status definitely up [ 13.118324][ T71] BUG: sleeping function called from invalid context at ./include/linux/sched/mm.h:322 [ 13.118327][ T71] in_atomic(): 1, irqs_disabled(): 1, non_block: 0, pid: 71, name: kworker/u16:1 [ 13.118329][ T71] preempt_count: 1, expected: 0 [ 13.118330][ T71] RCU nest depth: 0, expected: 0 [ 13.118331][ T71] locks held by kworker/u16:1/71: 7, last CPU#1: [ 13.118333][ T71] #0: ff1100000d089140 ((wq_completion)bond0){+.+.}-{0:0}, at: process_one_work+0xd9a/0x1560 [ 13.118344][ T71] #1: ffa00000004c7d10 ((work_completion)(&(&bond->arp_work)->work)){+.+.}-{0:0}, at: process_one_work+0xdfc/0x1560 [ 13.118348][ T71] #2: ffffffff88322700 (rtnl_mutex){+.+.}-{4:4}, at: bond_activebackup_arp_mon+0x3a2/0xb40 [ 13.118354][ T71] #3: ffffffff87b99cc0 (console_lock){+.+.}-{0:0}, at: vprintk_emit+0x320/0x3e0 [ 13.118359][ T71] #4: ffffffff87b99d38 (console_srcu){....}-{0:0}, at: console_flush_one_record+0x106/0x710 [ 13.118361][ T71] #5: ffffffff87a89660 (console_owner){....}-{0:0}, at: console_lock_spinning_enable+0x40/0x60 [ 13.118365][ T71] #6: ffffffff87a89560 (printk_legacy_map-wait-type-override){....}-{3:3}, at: console_emit_next_record+0x202/0x4f0 [ 13.118368][ T71] irq event stamp: 8728 [ 13.118369][ T71] hardirqs last enabled at (8727): [] __down_trylock_console_sem+0x86/0xa0 [ 13.118372][ T71] hardirqs last disabled at (8728): [] console_emit_next_record+0x3f8/0x4f0 [ 13.118374][ T71] softirqs last enabled at (8646): [] inet6_fill_ifla6_attrs+0x1ac2/0x2140 [ 13.118378][ T71] softirqs last disabled at (8644): [] inet6_fill_ifla6_attrs+0x1a72/0x2140 [ 13.118381][ T71] Preemption disabled at: [ 13.118381][ T71] [] vprintk_emit+0x31b/0x3e0 [ 13.118387][ T71] CPU: 1 UID: 0 PID: 71 Comm: kworker/u16:1 Tainted: G W 7.2.0-virtme #1 PREEMPT(full) [ 13.118390][ T71] Tainted: [W]=WARN [ 13.118392][ T71] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 13.118393][ T71] Workqueue: bond0 bond_arp_monitor [ 13.118397][ T71] Call Trace: [ 13.118399][ T71] [ 13.118401][ T71] dump_stack_lvl+0x6f/0xa0 [ 13.118406][ T71] ? vprintk_emit+0x31b/0x3e0 [ 13.118408][ T71] __might_resched.cold+0x1fe/0x2c1 [ 13.118412][ T71] ? perf_trace_sched_switch+0x7c0/0x7c0 [ 13.118416][ T71] ? __kmalloc_noprof+0xdb/0x760 [ 13.118422][ T71] __kmalloc_noprof+0x443/0x760 [ 13.118424][ T71] ? alloc_buf.isra.0+0x4b/0x260 [ 13.118430][ T71] ? do_raw_spin_unlock+0x59/0x250 [ 13.118432][ T71] alloc_buf.isra.0+0x4b/0x260 [ 13.118436][ T71] put_chars+0x1e1/0x2f0 [ 13.118440][ T71] ? __send_to_port+0x420/0x420 [ 13.118447][ T71] hvc_console_print+0x292/0x780 [ 13.118454][ T71] ? hvc_write+0x3a0/0x3a0 [ 13.118457][ T71] ? lock_acquire+0x13c/0x160 [ 13.118462][ T71] console_emit_next_record+0x252/0x4f0 [ 13.118465][ T71] ? devkmsg_read+0x4e0/0x4e0 [ 13.118469][ T71] ? rcu_is_watching+0x16/0xd0 [ 13.118473][ T71] ? lock_acquire+0x13c/0x160 [ 13.118477][ T71] console_flush_one_record+0x46f/0x710 [ 13.118481][ T71] ? console_emit_next_record+0x4f0/0x4f0 [ 13.118482][ T71] ? __lock_acquire+0x518/0xc20 [ 13.118488][ T71] console_unlock+0xee/0x1f0 [ 13.118490][ T71] ? console_flush_one_record+0x710/0x710 [ 13.118491][ T71] ? rcu_is_watching+0x16/0xd0 [ 13.118493][ T71] ? lock_acquire+0x60/0x160 [ 13.118497][ T71] ? __down_trylock_console_sem+0x5e/0xa0 [ 13.118499][ T71] ? vprintk_emit+0x320/0x3e0 [ 13.118502][ T71] vprintk_emit+0x37c/0x3e0 [ 13.118505][ T71] ? wake_up_klogd_work_func+0x90/0x90 [ 13.118508][ T71] ? packet_notifier+0x1bb/0xbd0 [ 13.118513][ T71] _printk+0xc7/0x100 [ 13.118517][ T71] ? snapshot_read.cold+0x21/0x21 [ 13.118521][ T71] ? netdev_name+0x43/0x60 [ 13.118524][ T71] ? __netdev_printk+0x17f/0x1d0 [ 13.118528][ T71] netdev_info+0xe2/0x116 [ 13.118530][ T71] ? netdev_notice+0x120/0x120 [ 13.118533][ T71] ? netdev_offload_xstats_get+0x1d0/0x1d0 [ 13.118537][ T71] ? mark_held_locks+0x40/0x70 [ 13.118541][ T71] ? lockdep_hardirqs_on+0x91/0x130 [ 13.118544][ T71] ? queue_delayed_work_on+0x95/0x100 [ 13.118547][ T71] bond_ab_arp_commit.cold+0x194/0x714 [ 13.118553][ T71] ? bond_select_active_slave+0x4f0/0x4f0 [ 13.118555][ T71] ? find_held_lock+0x2b/0x80 [ 13.118558][ T71] ? wait_for_completion_io+0x331/0x400 [ 13.118560][ T71] ? __lock_release.isra.0+0x69/0x1a0 [ 13.118565][ T71] ? bond_activebackup_arp_mon+0x390/0xb40 [ 13.118567][ T71] bond_activebackup_arp_mon+0x4f6/0xb40 [ 13.118571][ T71] ? bond_ab_arp_probe+0xae0/0xae0 [ 13.118574][ T71] ? rcu_is_watching+0x16/0xd0 [ 13.118575][ T71] ? rcu_is_watching+0x16/0xd0 [ 13.118577][ T71] ? lock_acquire+0x13c/0x160 [ 13.118579][ T71] ? rcu_is_watching+0x16/0xd0 [ 13.118583][ T71] process_one_work+0xe3e/0x1560 [ 13.118589][ T71] ? __queue_delayed_work+0x470/0x470 [ 13.118591][ T71] ? lock_acquire.part.0+0xd4/0x280 [ 13.118599][ T71] worker_thread+0x4f1/0xd60 [ 13.118602][ T71] ? rescuer_thread+0x1340/0x1340 [ 13.118604][ T71] ? __kthread_parkme+0xbd/0x210 [ 13.118607][ T71] ? rescuer_thread+0x1340/0x1340 [ 13.118610][ T71] ? rescuer_thread+0x1340/0x1340 [ 13.118611][ T71] kthread+0x367/0x460 [ 13.118613][ T71] ? trace_irq_enable.constprop.0+0x9b/0x160 [ 13.118617][ T71] ? kthread_affine_preferred+0x4c0/0x4c0 [ 13.118620][ T71] ret_from_fork+0x474/0x6b0 [ 13.118624][ T71] ? arch_exit_to_user_mode_prepare.isra.0+0x120/0x120 [ 13.118628][ T71] ? __switch_to+0x5a3/0xe00 [ 13.118631][ T71] ? kthread_affine_preferred+0x4c0/0x4c0 [ 13.118638][ T71] ret_from_fork_asm+0x11/0x20 [ 13.118647][ T71] [ 13.138584][ T71] bond0: (slave veth1): making interface the new active one [ 13.139591][ T71] bond0: active interface up! [ 13.233061][ T71] veth1: left allmulticast mode [ 13.233407][ T71] veth1: left promiscuous mode [ 13.233791][ T71] br0: port 2(veth1) entered disabled state [ 13.236026][ T71] veth0: left allmulticast mode [ 13.236249][ T71] veth0: left promiscuous mode [ 13.236534][ T71] br0: port 1(veth0) entered disabled state [ 13.261152][ T71] bond0: (slave veth1): Releasing backup interface [ 13.271119][ T71] bond0: (slave veth0): Releasing backup interface [ 13.322067][ T71] bond0 (unregistering): Released all slaves