[ 11.918783][ T244] bond0: (slave veth0): Enslaving as a backup interface with a down link [ 11.918869][ T244] BUG: sleeping function called from invalid context at ./include/linux/sched/mm.h:322 [ 11.918873][ T244] in_atomic(): 1, irqs_disabled(): 1, non_block: 0, pid: 244, name: ip [ 11.918875][ T244] preempt_count: 1, expected: 0 [ 11.918876][ T244] RCU nest depth: 0, expected: 0 [ 11.918878][ T244] locks held by ip/244: 5, last CPU#0: [ 11.918881][ T244] #0: ffffffffa3b22700 (rtnl_mutex){+.+.}-{4:4}, at: rtnl_newlink+0x9a8/0x11b0 [ 11.918897][ T244] #1: ffffffffa3399cc0 (console_lock){+.+.}-{0:0}, at: vprintk_emit+0x320/0x3e0 [ 11.918905][ T244] #2: ffffffffa3399d38 (console_srcu){....}-{0:0}, at: console_flush_one_record+0x106/0x710 [ 11.918911][ T244] #3: ffffffffa3289660 (console_owner){....}-{0:0}, at: console_lock_spinning_enable+0x40/0x60 [ 11.918916][ T244] #4: ffffffffa3289560 (printk_legacy_map-wait-type-override){....}-{3:3}, at: console_emit_next_record+0x202/0x4f0 [ 11.918922][ T244] irq event stamp: 24546 [ 11.918923][ T244] hardirqs last enabled at (24545): [] __down_trylock_console_sem+0x86/0xa0 [ 11.918928][ T244] hardirqs last disabled at (24546): [] console_emit_next_record+0x3f8/0x4f0 [ 11.918930][ T244] softirqs last enabled at (24516): [] dev_mc_add+0xd2/0x110 [ 11.918935][ T244] softirqs last disabled at (24500): [] dev_mc_add+0x62/0x110 [ 11.918938][ T244] Preemption disabled at: [ 11.918939][ T244] [] vprintk_emit+0x31b/0x3e0 [ 11.918947][ T244] CPU: 0 UID: 0 PID: 244 Comm: ip Tainted: G W 7.2.0-virtme #1 PREEMPT(full) [ 11.918952][ T244] Tainted: [W]=WARN [ 11.918953][ T244] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 11.918955][ T244] Call Trace: [ 11.918957][ T244] [ 11.918960][ T244] dump_stack_lvl+0x6f/0xa0 [ 11.918967][ T244] ? vprintk_emit+0x31b/0x3e0 [ 11.918970][ T244] __might_resched.cold+0x1fe/0x2c1 [ 11.918976][ T244] ? perf_trace_sched_switch+0x7c0/0x7c0 [ 11.918981][ T244] ? __kmalloc_noprof+0xdb/0x760 [ 11.918989][ T244] __kmalloc_noprof+0x443/0x760 [ 11.918993][ T244] ? alloc_buf.isra.0+0x4b/0x260 [ 11.919003][ T244] ? do_raw_spin_unlock+0x59/0x250 [ 11.919006][ T244] alloc_buf.isra.0+0x4b/0x260 [ 11.919012][ T244] put_chars+0x1e1/0x2f0 [ 11.919017][ T244] ? __send_to_port+0x420/0x420 [ 11.919030][ T244] hvc_console_print+0x292/0x780 [ 11.919042][ T244] ? hvc_write+0x3a0/0x3a0 [ 11.919047][ T244] ? lock_acquire+0x13c/0x160 [ 11.919055][ T244] console_emit_next_record+0x252/0x4f0 [ 11.919060][ T244] ? devkmsg_read+0x4e0/0x4e0 [ 11.919070][ T244] ? rcu_is_watching+0x16/0xd0 [ 11.919075][ T244] ? lock_acquire+0x13c/0x160 [ 11.919083][ T244] console_flush_one_record+0x46f/0x710 [ 11.919089][ T244] ? console_emit_next_record+0x4f0/0x4f0 [ 11.919092][ T244] ? __lock_acquire+0x518/0xc20 [ 11.919102][ T244] console_unlock+0xee/0x1f0 [ 11.919106][ T244] ? console_flush_one_record+0x710/0x710 [ 11.919108][ T244] ? rcu_is_watching+0x16/0xd0 [ 11.919112][ T244] ? lock_acquire+0x60/0x160 [ 11.919118][ T244] ? __down_trylock_console_sem+0x5e/0xa0 [ 11.919121][ T244] ? vprintk_emit+0x320/0x3e0 [ 11.919127][ T244] vprintk_emit+0x37c/0x3e0 [ 11.919132][ T244] ? wake_up_klogd_work_func+0x90/0x90 [ 11.919141][ T244] ? packet_sendmsg_spkt+0x1350/0x1350 [ 11.919151][ T244] _printk+0xc7/0x100 [ 11.919156][ T244] ? snapshot_read.cold+0x21/0x21 [ 11.919163][ T244] ? __mutex_unlock_slowpath+0x9e/0x740 [ 11.919167][ T244] ? netdev_name+0x43/0x60 [ 11.919172][ T244] ? __netdev_printk+0x17f/0x1d0 [ 11.919179][ T244] netdev_info+0xe2/0x116 [ 11.919182][ T244] ? netdev_notice+0x120/0x120 [ 11.919190][ T244] ? bond_lower_state_changed+0x160/0x160 [ 11.919194][ T244] ? __lock_release.isra.0+0x69/0x1a0 [ 11.919204][ T244] bond_enslave.cold+0x156/0x4f7 [ 11.919218][ T244] ? find_held_lock+0x2b/0x80 [ 11.919222][ T244] ? bond_update_slave_arr+0xcf0/0xcf0 [ 11.919224][ T244] ? mark_usage+0x61/0x170 [ 11.919227][ T244] ? __lock_acquire+0x518/0xc20 [ 11.919230][ T244] ? __lock_acquire+0x500/0xc20 [ 11.919238][ T244] ? lock_acquire.part.0+0xd4/0x280 [ 11.919251][ T244] ? is_bpf_text_address+0x72/0x110 [ 11.919257][ T244] ? kernel_text_address+0x149/0x170 [ 11.919266][ T244] do_set_master+0x3b2/0x780 [ 11.919273][ T244] do_setlink.isra.0+0x9ec/0x2a60 [ 11.919280][ T244] ? stack_trace_save+0x93/0xc0 [ 11.919285][ T244] ? rtnl_link_get_size+0x350/0x350 [ 11.919287][ T244] ? rcu_read_lock_any_held+0x66/0x90 [ 11.919292][ T244] ? stack_depot_save_flags+0x38e/0x790 [ 11.919296][ T244] ? rcu_lockdep_current_cpu_online+0x3f/0x1b0 [ 11.919300][ T244] ? rcu_read_lock_any_held+0x3c/0x90 [ 11.919303][ T244] ? validate_chain+0x38b/0xc20 [ 11.919308][ T244] ? kasan_save_stack+0x3d/0x50 [ 11.919311][ T244] ? kasan_save_stack+0x2f/0x50 [ 11.919313][ T244] ? kasan_save_track+0x14/0x30 [ 11.919317][ T244] ? __lock_acquire+0x518/0xc20 [ 11.919320][ T244] ? netlink_seq_next+0x1e/0x60 [ 11.919325][ T244] ? ___sys_sendmsg+0xc0/0x1d0 [ 11.919332][ T244] ? lock_acquire.part.0+0xd4/0x280 [ 11.919335][ T244] ? rtnl_newlink+0x9a8/0x11b0 [ 11.919340][ T244] ? rcu_is_watching+0x16/0xd0 [ 11.919344][ T244] ? lock_acquire+0x13c/0x160 [ 11.919346][ T244] ? rcu_is_watching+0x16/0xd0 [ 11.919348][ T244] ? rcu_is_watching+0x16/0xd0 [ 11.919352][ T244] ? trace_contention_end+0xb3/0x180 [ 11.919356][ T244] ? __mutex_lock+0x1db/0x1ea0 [ 11.919359][ T244] ? __mutex_lock+0x9a3/0x1ea0 [ 11.919362][ T244] ? rtnl_newlink+0x9a8/0x11b0 [ 11.919369][ T244] ? ww_mutex_lock+0x160/0x160 [ 11.919372][ T244] ? nla_get_range_signed+0x3d0/0x3d0 [ 11.919383][ T244] ? __rtnl_newlink+0x3fa/0xa50 [ 11.919393][ T244] rtnl_newlink+0x9f1/0x11b0 [ 11.919404][ T244] ? rtnl_bridge_getlink+0x850/0x850 [ 11.919408][ T244] ? __lock_acquire+0x518/0xc20 [ 11.919416][ T244] ? lock_acquire.part.0+0xd4/0x280 [ 11.919419][ T244] ? find_held_lock+0x2b/0x80 [ 11.919423][ T244] ? rtnl_bridge_getlink+0x850/0x850 [ 11.919427][ T244] ? __lock_release.isra.0+0x69/0x1a0 [ 11.919433][ T244] ? rtnl_bridge_getlink+0x850/0x850 [ 11.919438][ T244] rtnetlink_rcv_msg+0x6fd/0xbd0 [ 11.919444][ T244] ? rtnl_link_fill+0x900/0x900 [ 11.919446][ T244] ? __lock_acquire+0x518/0xc20 [ 11.919455][ T244] ? lock_acquire.part.0+0xd4/0x280 [ 11.919458][ T244] ? find_held_lock+0x2b/0x80 [ 11.919464][ T244] netlink_rcv_skb+0x14e/0x3a0 [ 11.919467][ T244] ? rtnl_link_fill+0x900/0x900 [ 11.919473][ T244] ? netlink_ack+0xcd0/0xcd0 [ 11.919485][ T244] ? netlink_deliver_tap+0xc5/0x330 [ 11.919487][ T244] ? netlink_deliver_tap+0x13c/0x330 [ 11.919495][ T244] netlink_unicast+0x486/0x750 [ 11.919502][ T244] ? netlink_attachskb+0x810/0x810 [ 11.919506][ T244] ? __lock_acquire+0x518/0xc20 [ 11.919514][ T244] netlink_sendmsg+0x735/0xc60 [ 11.919521][ T244] ? netlink_unicast+0x750/0x750 [ 11.919528][ T244] ? __might_fault+0x97/0x140 [ 11.919537][ T244] ____sys_sendmsg+0x415/0x880 [ 11.919540][ T244] ? copy_msghdr_from_user+0x279/0x420 [ 11.919544][ T244] ? get_timestamp.constprop.0+0x3a0/0x3a0 [ 11.919546][ T244] ? move_addr_to_kernel+0x40/0x40 [ 11.919560][ T244] ___sys_sendmsg+0x14e/0x1d0 [ 11.919564][ T244] ? copy_msghdr_from_user+0x420/0x420 [ 11.919594][ T244] __sys_sendmsg+0x12c/0x1d0 [ 11.919599][ T244] ? __sys_sendmsg_sock+0x20/0x20 [ 11.919610][ T244] ? rcu_is_watching+0x16/0xd0 [ 11.919616][ T244] do_syscall_64+0xff/0x530 [ 11.919619][ T244] ? exc_page_fault+0xee/0x100 [ 11.919624][ T244] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 11.919627][ T244] RIP: 0033:0x7f450738654e [ 11.919634][ T244] 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.919636][ T244] RSP: 002b:00007ffe71756e90 EFLAGS: 00000202 ORIG_RAX: 000000000000002e [ 11.919639][ T244] RAX: ffffffffffffffda RBX: 0000000000000003 RCX: 00007f450738654e [ 11.919641][ T244] RDX: 0000000000000000 RSI: 00007ffe71756f40 RDI: 0000000000000005 [ 11.919643][ T244] RBP: 00007ffe71756ea0 R08: 0000000000000000 R09: 0000000000000000 [ 11.919644][ T244] R10: 0000000000000000 R11: 0000000000000202 R12: 000000006a91b582 [ 11.919645][ T244] R13: 00000000004a1620 R14: 0000000000000000 R15: 00007ffe71757610 [ 11.919659][ T244] [ 11.987209][ T244] ip (244) used greatest stack depth: 22824 bytes left [ 12.042498][ T245] bond0: (slave veth1): Enslaving as a backup interface with a down link [ 12.072260][ T246] br0: port 1(veth0) entered blocking state [ 12.072602][ T246] br0: port 1(veth0) entered disabled state [ 12.072946][ T246] veth0: entered allmulticast mode [ 12.074509][ T246] veth0: entered promiscuous mode [ 12.125455][ T247] br0: port 2(veth1) entered blocking state [ 12.125931][ T247] br0: port 2(veth1) entered disabled state [ 12.126417][ T247] veth1: entered allmulticast mode [ 12.128150][ T247] veth1: entered promiscuous mode [ 12.328013][ T37] br0: port 1(veth0) entered blocking state [ 12.328560][ T37] br0: port 1(veth0) entered forwarding state [ 12.329868][ T37] br0: port 2(veth1) entered blocking state [ 12.330236][ T37] br0: port 2(veth1) entered forwarding state [ 13.943354][ T72] bond0: (slave veth1): link status definitely up [ 13.943524][ T72] BUG: sleeping function called from invalid context at ./include/linux/sched/mm.h:322 [ 13.943526][ T72] in_atomic(): 1, irqs_disabled(): 1, non_block: 0, pid: 72, name: kworker/u16:1 [ 13.943528][ T72] preempt_count: 1, expected: 0 [ 13.943529][ T72] RCU nest depth: 0, expected: 0 [ 13.943530][ T72] locks held by kworker/u16:1/72: 7, last CPU#0: [ 13.943532][ T72] #0: ff1100000240c140 ((wq_completion)bond0){+.+.}-{0:0}, at: process_one_work+0xd9a/0x1560 [ 13.943543][ T72] #1: ffa00000004d7d10 ((work_completion)(&(&bond->arp_work)->work)){+.+.}-{0:0}, at: process_one_work+0xdfc/0x1560 [ 13.943547][ T72] #2: ffffffffa3b22700 (rtnl_mutex){+.+.}-{4:4}, at: bond_activebackup_arp_mon+0x3a2/0xb40 [ 13.943553][ T72] #3: ffffffffa3399cc0 (console_lock){+.+.}-{0:0}, at: vprintk_emit+0x320/0x3e0 [ 13.943558][ T72] #4: ffffffffa3399d38 (console_srcu){....}-{0:0}, at: console_flush_one_record+0x106/0x710 [ 13.943561][ T72] #5: ffffffffa3289660 (console_owner){....}-{0:0}, at: console_lock_spinning_enable+0x40/0x60 [ 13.943564][ T72] #6: ffffffffa3289560 (printk_legacy_map-wait-type-override){....}-{3:3}, at: console_emit_next_record+0x202/0x4f0 [ 13.943568][ T72] irq event stamp: 2818 [ 13.943568][ T72] hardirqs last enabled at (2817): [] __down_trylock_console_sem+0x86/0xa0 [ 13.943572][ T72] hardirqs last disabled at (2818): [] console_emit_next_record+0x3f8/0x4f0 [ 13.943573][ T72] softirqs last enabled at (2738): [] inet6_fill_ifla6_attrs+0x1ac2/0x2140 [ 13.943577][ T72] softirqs last disabled at (2736): [] inet6_fill_ifla6_attrs+0x1a72/0x2140 [ 13.943580][ T72] Preemption disabled at: [ 13.943580][ T72] [] vprintk_emit+0x31b/0x3e0 [ 13.943586][ T72] CPU: 0 UID: 0 PID: 72 Comm: kworker/u16:1 Tainted: G W 7.2.0-virtme #1 PREEMPT(full) [ 13.943589][ T72] Tainted: [W]=WARN [ 13.943590][ T72] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 13.943592][ T72] Workqueue: bond0 bond_arp_monitor [ 13.943595][ T72] Call Trace: [ 13.943597][ T72] [ 13.943598][ T72] dump_stack_lvl+0x6f/0xa0 [ 13.943604][ T72] ? vprintk_emit+0x31b/0x3e0 [ 13.943606][ T72] __might_resched.cold+0x1fe/0x2c1 [ 13.943611][ T72] ? perf_trace_sched_switch+0x7c0/0x7c0 [ 13.943614][ T72] ? __kmalloc_noprof+0xdb/0x760 [ 13.943619][ T72] __kmalloc_noprof+0x443/0x760 [ 13.943622][ T72] ? alloc_buf.isra.0+0x4b/0x260 [ 13.943628][ T72] ? do_raw_spin_unlock+0x59/0x250 [ 13.943630][ T72] alloc_buf.isra.0+0x4b/0x260 [ 13.943634][ T72] put_chars+0x1e1/0x2f0 [ 13.943637][ T72] ? __send_to_port+0x420/0x420 [ 13.943644][ T72] hvc_console_print+0x292/0x780 [ 13.943652][ T72] ? hvc_write+0x3a0/0x3a0 [ 13.943655][ T72] ? lock_acquire+0x13c/0x160 [ 13.943660][ T72] console_emit_next_record+0x252/0x4f0 [ 13.943664][ T72] ? devkmsg_read+0x4e0/0x4e0 [ 13.943668][ T72] ? rcu_is_watching+0x16/0xd0 [ 13.943671][ T72] ? lock_acquire+0x13c/0x160 [ 13.943676][ T72] console_flush_one_record+0x46f/0x710 [ 13.943680][ T72] ? console_emit_next_record+0x4f0/0x4f0 [ 13.943681][ T72] ? __lock_acquire+0x518/0xc20 [ 13.943687][ T72] console_unlock+0xee/0x1f0 [ 13.943689][ T72] ? console_flush_one_record+0x710/0x710 [ 13.943690][ T72] ? rcu_is_watching+0x16/0xd0 [ 13.943692][ T72] ? lock_acquire+0x60/0x160 [ 13.943696][ T72] ? __down_trylock_console_sem+0x5e/0xa0 [ 13.943698][ T72] ? vprintk_emit+0x320/0x3e0 [ 13.943701][ T72] vprintk_emit+0x37c/0x3e0 [ 13.943705][ T72] ? wake_up_klogd_work_func+0x90/0x90 [ 13.943708][ T72] ? packet_notifier+0x1bb/0xbd0 [ 13.943713][ T72] _printk+0xc7/0x100 [ 13.943717][ T72] ? snapshot_read.cold+0x21/0x21 [ 13.943721][ T72] ? netdev_name+0x43/0x60 [ 13.943724][ T72] ? __netdev_printk+0x17f/0x1d0 [ 13.943728][ T72] netdev_info+0xe2/0x116 [ 13.943730][ T72] ? netdev_notice+0x120/0x120 [ 13.943733][ T72] ? netdev_offload_xstats_get+0x1d0/0x1d0 [ 13.943738][ T72] ? mark_held_locks+0x40/0x70 [ 13.943741][ T72] ? lockdep_hardirqs_on+0x91/0x130 [ 13.943744][ T72] ? queue_delayed_work_on+0x95/0x100 [ 13.943747][ T72] bond_ab_arp_commit.cold+0x194/0x714 [ 13.943753][ T72] ? bond_select_active_slave+0x4f0/0x4f0 [ 13.943755][ T72] ? find_held_lock+0x2b/0x80 [ 13.943758][ T72] ? wait_for_completion_io+0x331/0x400 [ 13.943760][ T72] ? __lock_release.isra.0+0x69/0x1a0 [ 13.943765][ T72] ? bond_activebackup_arp_mon+0x390/0xb40 [ 13.943767][ T72] bond_activebackup_arp_mon+0x4f6/0xb40 [ 13.943771][ T72] ? bond_ab_arp_probe+0xae0/0xae0 [ 13.943775][ T72] ? rcu_is_watching+0x16/0xd0 [ 13.943776][ T72] ? rcu_is_watching+0x16/0xd0 [ 13.943778][ T72] ? lock_acquire+0x13c/0x160 [ 13.943780][ T72] ? rcu_is_watching+0x16/0xd0 [ 13.943783][ T72] process_one_work+0xe3e/0x1560 [ 13.943789][ T72] ? __queue_delayed_work+0x470/0x470 [ 13.943792][ T72] ? lock_acquire.part.0+0xd4/0x280 [ 13.943800][ T72] worker_thread+0x4f1/0xd60 [ 13.943804][ T72] ? rescuer_thread+0x1340/0x1340 [ 13.943805][ T72] ? __kthread_parkme+0xbd/0x210 [ 13.943809][ T72] ? rescuer_thread+0x1340/0x1340 [ 13.943811][ T72] ? rescuer_thread+0x1340/0x1340 [ 13.943813][ T72] kthread+0x367/0x460 [ 13.943815][ T72] ? trace_irq_enable.constprop.0+0x9b/0x160 [ 13.943818][ T72] ? kthread_affine_preferred+0x4c0/0x4c0 [ 13.943821][ T72] ret_from_fork+0x474/0x6b0 [ 13.943826][ T72] ? arch_exit_to_user_mode_prepare.isra.0+0x120/0x120 [ 13.943829][ T72] ? __switch_to+0x5a3/0xe00 [ 13.943833][ T72] ? kthread_affine_preferred+0x4c0/0x4c0 [ 13.943836][ T72] ret_from_fork_asm+0x11/0x20 [ 13.943845][ T72] [ 13.964783][ T72] bond0: (slave veth1): making interface the new active one [ 13.971296][ T72] bond0: active interface up! [ 14.143483][ T72] veth1: left allmulticast mode [ 14.143806][ T72] veth1: left promiscuous mode [ 14.144225][ T72] br0: port 2(veth1) entered disabled state [ 14.146009][ T72] veth0: left allmulticast mode [ 14.146848][ T72] veth0: left promiscuous mode [ 14.147134][ T72] br0: port 1(veth0) entered disabled state [ 14.163920][ T72] bond0: (slave veth1): Releasing backup interface [ 14.175912][ T72] bond0: (slave veth0): Releasing backup interface [ 14.218852][ T72] bond0 (unregistering): Released all slaves