[ 11.658432][ T236] bond0: (slave veth0): Enslaving as a backup interface with a down link [ 11.658505][ T236] BUG: sleeping function called from invalid context at ./include/linux/sched/mm.h:322 [ 11.658508][ T236] in_atomic(): 1, irqs_disabled(): 1, non_block: 0, pid: 236, name: ip [ 11.658509][ T236] preempt_count: 1, expected: 0 [ 11.658510][ T236] RCU nest depth: 0, expected: 0 [ 11.658511][ T236] locks held by ip/236: 5, last CPU#0: [ 11.658513][ T236] #0: ffffffff99b22700 (rtnl_mutex){+.+.}-{4:4}, at: rtnl_newlink+0x9a8/0x11b0 [ 11.658525][ T236] #1: ffffffff99399cc0 (console_lock){+.+.}-{0:0}, at: vprintk_emit+0x320/0x3e0 [ 11.658531][ T236] #2: ffffffff99399d38 (console_srcu){....}-{0:0}, at: console_flush_one_record+0x106/0x710 [ 11.658534][ T236] #3: ffffffff99289660 (console_owner){....}-{0:0}, at: console_lock_spinning_enable+0x40/0x60 [ 11.658537][ T236] #4: ffffffff99289560 (printk_legacy_map-wait-type-override){....}-{3:3}, at: console_emit_next_record+0x202/0x4f0 [ 11.658540][ T236] irq event stamp: 18442 [ 11.658541][ T236] hardirqs last enabled at (18441): [] irqentry_exit+0x21c/0x790 [ 11.658545][ T236] hardirqs last disabled at (18442): [] console_emit_next_record+0x3f8/0x4f0 [ 11.658547][ T236] softirqs last enabled at (18440): [] handle_softirqs+0x67c/0x900 [ 11.658550][ T236] softirqs last disabled at (18435): [] __irq_exit_rcu+0x145/0x1c0 [ 11.658553][ T236] Preemption disabled at: [ 11.658553][ T236] [] vprintk_emit+0x31b/0x3e0 [ 11.658558][ T236] CPU: 0 UID: 0 PID: 236 Comm: ip Tainted: G W 7.2.0-virtme #1 PREEMPT(full) [ 11.658562][ T236] Tainted: [W]=WARN [ 11.658563][ T236] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 11.658565][ T236] Call Trace: [ 11.658566][ T236] [ 11.658568][ T236] dump_stack_lvl+0x6f/0xa0 [ 11.658573][ T236] ? vprintk_emit+0x31b/0x3e0 [ 11.658574][ T236] __might_resched.cold+0x1fe/0x2c1 [ 11.658579][ T236] ? perf_trace_sched_switch+0x7c0/0x7c0 [ 11.658582][ T236] ? __kmalloc_noprof+0xdb/0x760 [ 11.658588][ T236] __kmalloc_noprof+0x443/0x760 [ 11.658591][ T236] ? alloc_buf.isra.0+0x4b/0x260 [ 11.658597][ T236] ? do_raw_spin_unlock+0x59/0x250 [ 11.658599][ T236] alloc_buf.isra.0+0x4b/0x260 [ 11.658603][ T236] put_chars+0x1e1/0x2f0 [ 11.658606][ T236] ? __send_to_port+0x420/0x420 [ 11.658613][ T236] hvc_console_print+0x292/0x780 [ 11.658621][ T236] ? hvc_write+0x3a0/0x3a0 [ 11.658624][ T236] ? lock_acquire+0x13c/0x160 [ 11.658629][ T236] console_emit_next_record+0x252/0x4f0 [ 11.658632][ T236] ? devkmsg_read+0x4e0/0x4e0 [ 11.658636][ T236] ? rcu_is_watching+0x16/0xd0 [ 11.658639][ T236] ? lock_acquire+0x13c/0x160 [ 11.658643][ T236] console_flush_one_record+0x46f/0x710 [ 11.658647][ T236] ? console_emit_next_record+0x4f0/0x4f0 [ 11.658648][ T236] ? __lock_acquire+0x518/0xc20 [ 11.658651][ T236] ? BUG_func+0xb/0x10 [ 11.658656][ T236] console_unlock+0xee/0x1f0 [ 11.658658][ T236] ? console_flush_one_record+0x710/0x710 [ 11.658660][ T236] ? rcu_is_watching+0x16/0xd0 [ 11.658662][ T236] ? lock_acquire+0x60/0x160 [ 11.658665][ T236] ? __down_trylock_console_sem+0x5e/0xa0 [ 11.658668][ T236] ? vprintk_emit+0x320/0x3e0 [ 11.658671][ T236] vprintk_emit+0x37c/0x3e0 [ 11.658674][ T236] ? wake_up_klogd_work_func+0x90/0x90 [ 11.658676][ T236] ? packet_sendmsg_spkt+0x1350/0x1350 [ 11.658682][ T236] _printk+0xc7/0x100 [ 11.658685][ T236] ? snapshot_read.cold+0x21/0x21 [ 11.658689][ T236] ? __mutex_unlock_slowpath+0x9e/0x740 [ 11.658691][ T236] ? netdev_name+0x43/0x60 [ 11.658695][ T236] ? __netdev_printk+0x17f/0x1d0 [ 11.658698][ T236] netdev_info+0xe2/0x116 [ 11.658700][ T236] ? netdev_notice+0x120/0x120 [ 11.658704][ T236] ? bond_lower_state_changed+0x160/0x160 [ 11.658708][ T236] ? __lock_release.isra.0+0x69/0x1a0 [ 11.658713][ T236] bond_enslave.cold+0x156/0x4f7 [ 11.658722][ T236] ? find_held_lock+0x2b/0x80 [ 11.658724][ T236] ? bond_update_slave_arr+0xcf0/0xcf0 [ 11.658725][ T236] ? mark_usage+0x61/0x170 [ 11.658727][ T236] ? __lock_acquire+0x518/0xc20 [ 11.658729][ T236] ? __lock_acquire+0x500/0xc20 [ 11.658734][ T236] ? lock_acquire.part.0+0xd4/0x280 [ 11.658741][ T236] ? is_bpf_text_address+0x72/0x110 [ 11.658745][ T236] ? kernel_text_address+0x149/0x170 [ 11.658750][ T236] do_set_master+0x3b2/0x780 [ 11.658754][ T236] do_setlink.isra.0+0x9ec/0x2a60 [ 11.658758][ T236] ? stack_trace_save+0x93/0xc0 [ 11.658762][ T236] ? rtnl_link_get_size+0x350/0x350 [ 11.658763][ T236] ? rcu_read_lock_any_held+0x66/0x90 [ 11.658766][ T236] ? stack_depot_save_flags+0x38e/0x790 [ 11.658769][ T236] ? rcu_lockdep_current_cpu_online+0x3f/0x1b0 [ 11.658772][ T236] ? rcu_read_lock_any_held+0x3c/0x90 [ 11.658774][ T236] ? validate_chain+0x38b/0xc20 [ 11.658777][ T236] ? kasan_save_stack+0x3d/0x50 [ 11.658779][ T236] ? kasan_save_stack+0x2f/0x50 [ 11.658780][ T236] ? kasan_save_track+0x14/0x30 [ 11.658782][ T236] ? __lock_acquire+0x518/0xc20 [ 11.658784][ T236] ? netlink_seq_next+0x5e/0x60 [ 11.658787][ T236] ? ___sys_sendmsg+0xc0/0x1d0 [ 11.658792][ T236] ? lock_acquire.part.0+0xd4/0x280 [ 11.658794][ T236] ? rtnl_newlink+0x9a8/0x11b0 [ 11.658797][ T236] ? rcu_is_watching+0x16/0xd0 [ 11.658799][ T236] ? lock_acquire+0x13c/0x160 [ 11.658801][ T236] ? rcu_is_watching+0x16/0xd0 [ 11.658802][ T236] ? rcu_is_watching+0x16/0xd0 [ 11.658804][ T236] ? trace_contention_end+0xb3/0x180 [ 11.658806][ T236] ? __mutex_lock+0x1db/0x1ea0 [ 11.658807][ T236] ? __mutex_lock+0x9a3/0x1ea0 [ 11.658809][ T236] ? rtnl_newlink+0x9a8/0x11b0 [ 11.658813][ T236] ? ww_mutex_lock+0x160/0x160 [ 11.658815][ T236] ? nla_get_range_signed+0x3d0/0x3d0 [ 11.658821][ T236] ? __rtnl_newlink+0x3fa/0xa50 [ 11.658827][ T236] rtnl_newlink+0x9f1/0x11b0 [ 11.658832][ T236] ? rtnl_bridge_getlink+0x850/0x850 [ 11.658835][ T236] ? __lock_acquire+0x518/0xc20 [ 11.658839][ T236] ? lock_acquire.part.0+0xd4/0x280 [ 11.658841][ T236] ? find_held_lock+0x2b/0x80 [ 11.658844][ T236] ? rtnl_bridge_getlink+0x850/0x850 [ 11.658846][ T236] ? __lock_release.isra.0+0x69/0x1a0 [ 11.658850][ T236] ? rtnl_bridge_getlink+0x850/0x850 [ 11.658852][ T236] rtnetlink_rcv_msg+0x6fd/0xbd0 [ 11.658856][ T236] ? rtnl_link_fill+0x900/0x900 [ 11.658858][ T236] ? __lock_acquire+0x518/0xc20 [ 11.658862][ T236] ? lock_acquire.part.0+0xd4/0x280 [ 11.658864][ T236] ? find_held_lock+0x2b/0x80 [ 11.658868][ T236] netlink_rcv_skb+0x14e/0x3a0 [ 11.658870][ T236] ? rtnl_link_fill+0x900/0x900 [ 11.658873][ T236] ? netlink_ack+0xcd0/0xcd0 [ 11.658880][ T236] ? netlink_deliver_tap+0xc5/0x330 [ 11.658881][ T236] ? netlink_deliver_tap+0x13c/0x330 [ 11.658885][ T236] netlink_unicast+0x486/0x750 [ 11.658889][ T236] ? netlink_attachskb+0x810/0x810 [ 11.658892][ T236] ? __lock_acquire+0x518/0xc20 [ 11.658896][ T236] netlink_sendmsg+0x735/0xc60 [ 11.658900][ T236] ? netlink_unicast+0x750/0x750 [ 11.658904][ T236] ? __might_fault+0x97/0x140 [ 11.658910][ T236] ____sys_sendmsg+0x415/0x880 [ 11.658912][ T236] ? copy_msghdr_from_user+0x279/0x420 [ 11.658914][ T236] ? get_timestamp.constprop.0+0x3a0/0x3a0 [ 11.658915][ T236] ? move_addr_to_kernel+0x40/0x40 [ 11.658922][ T236] ___sys_sendmsg+0x14e/0x1d0 [ 11.658925][ T236] ? copy_msghdr_from_user+0x420/0x420 [ 11.658941][ T236] __sys_sendmsg+0x12c/0x1d0 [ 11.658943][ T236] ? __sys_sendmsg_sock+0x20/0x20 [ 11.658949][ T236] ? rcu_is_watching+0x16/0xd0 [ 11.658953][ T236] do_syscall_64+0xff/0x530 [ 11.658954][ T236] ? exc_page_fault+0xee/0x100 [ 11.658957][ T236] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 11.658959][ T236] RIP: 0033:0x7fbea2cbf54e [ 11.658963][ T236] 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.658965][ T236] RSP: 002b:00007fffb579c2a0 EFLAGS: 00000202 ORIG_RAX: 000000000000002e [ 11.658967][ T236] RAX: ffffffffffffffda RBX: 0000000000000003 RCX: 00007fbea2cbf54e [ 11.658969][ T236] RDX: 0000000000000000 RSI: 00007fffb579c350 RDI: 0000000000000005 [ 11.658970][ T236] RBP: 00007fffb579c2b0 R08: 0000000000000000 R09: 0000000000000000 [ 11.658970][ T236] R10: 0000000000000000 R11: 0000000000000202 R12: 000000006a913802 [ 11.658971][ T236] R13: 00000000004a1620 R14: 0000000000000000 R15: 00007fffb579ca20 [ 11.658978][ T236] [ 11.702782][ T236] ip (236) used greatest stack depth: 22824 bytes left [ 11.730729][ T237] bond0: (slave veth1): Enslaving as a backup interface with a down link [ 11.757060][ T238] br0: port 1(veth0) entered blocking state [ 11.757364][ T238] br0: port 1(veth0) entered disabled state [ 11.757659][ T238] veth0: entered allmulticast mode [ 11.758968][ T238] veth0: entered promiscuous mode [ 11.794812][ T239] br0: port 2(veth1) entered blocking state [ 11.795093][ T239] br0: port 2(veth1) entered disabled state [ 11.795361][ T239] veth1: entered allmulticast mode [ 11.796378][ T239] veth1: entered promiscuous mode [ 12.410122][ T36] br0: port 1(veth0) entered blocking state [ 12.410825][ T36] br0: port 1(veth0) entered forwarding state [ 12.412976][ T36] br0: port 2(veth1) entered blocking state [ 12.413431][ T36] br0: port 2(veth1) entered forwarding state [ 13.676739][ T12] bond0: (slave veth1): link status definitely up [ 13.676915][ T12] BUG: sleeping function called from invalid context at ./include/linux/sched/mm.h:322 [ 13.676918][ T12] in_atomic(): 1, irqs_disabled(): 1, non_block: 0, pid: 12, name: kworker/u16:0 [ 13.676919][ T12] preempt_count: 1, expected: 0 [ 13.676920][ T12] RCU nest depth: 0, expected: 0 [ 13.676921][ T12] locks held by kworker/u16:0/12: 7, last CPU#1: [ 13.676924][ T12] #0: ff1100000c46b540 ((wq_completion)bond0){+.+.}-{0:0}, at: process_one_work+0xd9a/0x1560 [ 13.676935][ T12] #1: ffa00000000c7d10 ((work_completion)(&(&bond->arp_work)->work)){+.+.}-{0:0}, at: process_one_work+0xdfc/0x1560 [ 13.676939][ T12] #2: ffffffff99b22700 (rtnl_mutex){+.+.}-{4:4}, at: bond_activebackup_arp_mon+0x3a2/0xb40 [ 13.676946][ T12] #3: ffffffff99399cc0 (console_lock){+.+.}-{0:0}, at: vprintk_emit+0x320/0x3e0 [ 13.676951][ T12] #4: ffffffff99399d38 (console_srcu){....}-{0:0}, at: console_flush_one_record+0x106/0x710 [ 13.676954][ T12] #5: ffffffff99289660 (console_owner){....}-{0:0}, at: console_lock_spinning_enable+0x40/0x60 [ 13.676957][ T12] #6: ffffffff99289560 (printk_legacy_map-wait-type-override){....}-{3:3}, at: console_emit_next_record+0x202/0x4f0 [ 13.676961][ T12] irq event stamp: 3650 [ 13.676962][ T12] hardirqs last enabled at (3649): [] __down_trylock_console_sem+0x86/0xa0 [ 13.676965][ T12] hardirqs last disabled at (3650): [] console_emit_next_record+0x3f8/0x4f0 [ 13.676967][ T12] softirqs last enabled at (3570): [] inet6_fill_ifla6_attrs+0x1ac2/0x2140 [ 13.676971][ T12] softirqs last disabled at (3568): [] inet6_fill_ifla6_attrs+0x1a72/0x2140 [ 13.676973][ T12] Preemption disabled at: [ 13.676974][ T12] [] vprintk_emit+0x31b/0x3e0 [ 13.676979][ T12] CPU: 1 UID: 0 PID: 12 Comm: kworker/u16:0 Tainted: G W 7.2.0-virtme #1 PREEMPT(full) [ 13.676983][ T12] Tainted: [W]=WARN [ 13.676984][ T12] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 13.676986][ T12] Workqueue: bond0 bond_arp_monitor [ 13.676989][ T12] Call Trace: [ 13.676991][ T12] [ 13.676993][ T12] dump_stack_lvl+0x6f/0xa0 [ 13.676998][ T12] ? vprintk_emit+0x31b/0x3e0 [ 13.677000][ T12] __might_resched.cold+0x1fe/0x2c1 [ 13.677005][ T12] ? perf_trace_sched_switch+0x7c0/0x7c0 [ 13.677009][ T12] ? __kmalloc_noprof+0xdb/0x760 [ 13.677014][ T12] __kmalloc_noprof+0x443/0x760 [ 13.677017][ T12] ? alloc_buf.isra.0+0x4b/0x260 [ 13.677023][ T12] ? do_raw_spin_unlock+0x59/0x250 [ 13.677025][ T12] alloc_buf.isra.0+0x4b/0x260 [ 13.677029][ T12] put_chars+0x1e1/0x2f0 [ 13.677032][ T12] ? __send_to_port+0x420/0x420 [ 13.677040][ T12] hvc_console_print+0x292/0x780 [ 13.677047][ T12] ? hvc_write+0x3a0/0x3a0 [ 13.677050][ T12] ? lock_acquire+0x13c/0x160 [ 13.677055][ T12] console_emit_next_record+0x252/0x4f0 [ 13.677059][ T12] ? devkmsg_read+0x4e0/0x4e0 [ 13.677063][ T12] ? rcu_is_watching+0x16/0xd0 [ 13.677066][ T12] ? lock_acquire+0x13c/0x160 [ 13.677070][ T12] console_flush_one_record+0x46f/0x710 [ 13.677074][ T12] ? console_emit_next_record+0x4f0/0x4f0 [ 13.677076][ T12] ? __lock_acquire+0x518/0xc20 [ 13.677082][ T12] console_unlock+0xee/0x1f0 [ 13.677084][ T12] ? console_flush_one_record+0x710/0x710 [ 13.677086][ T12] ? rcu_is_watching+0x16/0xd0 [ 13.677088][ T12] ? lock_acquire+0x60/0x160 [ 13.677092][ T12] ? __down_trylock_console_sem+0x5e/0xa0 [ 13.677094][ T12] ? vprintk_emit+0x320/0x3e0 [ 13.677097][ T12] vprintk_emit+0x37c/0x3e0 [ 13.677100][ T12] ? wake_up_klogd_work_func+0x90/0x90 [ 13.677103][ T12] ? packet_notifier+0x1bb/0xbd0 [ 13.677108][ T12] _printk+0xc7/0x100 [ 13.677112][ T12] ? snapshot_read.cold+0x21/0x21 [ 13.677116][ T12] ? netdev_name+0x43/0x60 [ 13.677119][ T12] ? __netdev_printk+0x17f/0x1d0 [ 13.677123][ T12] netdev_info+0xe2/0x116 [ 13.677125][ T12] ? netdev_notice+0x120/0x120 [ 13.677129][ T12] ? netdev_offload_xstats_get+0x1d0/0x1d0 [ 13.677133][ T12] ? mark_held_locks+0x40/0x70 [ 13.677136][ T12] ? lockdep_hardirqs_on+0x91/0x130 [ 13.677140][ T12] ? queue_delayed_work_on+0x95/0x100 [ 13.677143][ T12] bond_ab_arp_commit.cold+0x194/0x714 [ 13.677149][ T12] ? bond_select_active_slave+0x4f0/0x4f0 [ 13.677151][ T12] ? find_held_lock+0x2b/0x80 [ 13.677154][ T12] ? wait_for_completion_io+0x331/0x400 [ 13.677156][ T12] ? __lock_release.isra.0+0x69/0x1a0 [ 13.677161][ T12] ? bond_activebackup_arp_mon+0x390/0xb40 [ 13.677163][ T12] bond_activebackup_arp_mon+0x4f6/0xb40 [ 13.677167][ T12] ? bond_ab_arp_probe+0xae0/0xae0 [ 13.677171][ T12] ? rcu_is_watching+0x16/0xd0 [ 13.677172][ T12] ? rcu_is_watching+0x16/0xd0 [ 13.677174][ T12] ? lock_acquire+0x13c/0x160 [ 13.677176][ T12] ? rcu_is_watching+0x16/0xd0 [ 13.677180][ T12] process_one_work+0xe3e/0x1560 [ 13.677186][ T12] ? __queue_delayed_work+0x470/0x470 [ 13.677188][ T12] ? lock_acquire.part.0+0xd4/0x280 [ 13.677196][ T12] worker_thread+0x4f1/0xd60 [ 13.677203][ T12] ? rescuer_thread+0x1340/0x1340 [ 13.677204][ T12] kthread+0x367/0x460 [ 13.677207][ T12] ? trace_irq_enable.constprop.0+0x9b/0x160 [ 13.677211][ T12] ? kthread_affine_preferred+0x4c0/0x4c0 [ 13.677214][ T12] ret_from_fork+0x474/0x6b0 [ 13.677218][ T12] ? arch_exit_to_user_mode_prepare.isra.0+0x120/0x120 [ 13.677222][ T12] ? __switch_to+0x5a3/0xe00 [ 13.677226][ T12] ? kthread_affine_preferred+0x4c0/0x4c0 [ 13.677229][ T12] ret_from_fork_asm+0x11/0x20 [ 13.677237][ T12] [ 13.696516][ T12] bond0: (slave veth1): making interface the new active one [ 13.697699][ T12] bond0: active interface up! [ 13.840961][ T12] veth1: left allmulticast mode [ 13.841292][ T12] veth1: left promiscuous mode [ 13.841621][ T12] br0: port 2(veth1) entered disabled state [ 13.842975][ T12] veth0: left allmulticast mode [ 13.843179][ T12] veth0: left promiscuous mode [ 13.843798][ T12] br0: port 1(veth0) entered disabled state [ 13.864829][ T12] bond0: (slave veth1): Releasing backup interface [ 13.888963][ T12] bond0: (slave veth0): Releasing backup interface [ 13.926010][ T12] bond0 (unregistering): Released all slaves