[ 64.213503][ T564] br1: port 1(veth1) entered blocking state [ 64.213899][ T564] br1: port 1(veth1) entered disabled state [ 64.215603][ T564] veth1: entered allmulticast mode [ 64.217662][ T564] veth1: entered promiscuous mode [ 64.350381][ T565] br1: port 2(veth2) entered blocking state [ 64.350708][ T565] br1: port 2(veth2) entered disabled state [ 64.350988][ T565] veth2: entered allmulticast mode [ 64.353287][ T565] veth2: entered promiscuous mode [ 64.481719][ T49] br1: port 1(veth1) entered blocking state [ 64.482112][ T49] br1: port 1(veth1) entered forwarding state [ 64.602490][ T49] br1: port 2(veth2) entered blocking state [ 64.602787][ T49] br1: port 2(veth2) entered forwarding state [ 69.630064][ C2] [ 69.630250][ C2] ======================================================== [ 69.630470][ C2] WARNING: possible irq lock inversion dependency detected [ 69.630694][ C2] 6.9.0-rc1-virtme #1 Not tainted [ 69.630836][ C2] -------------------------------------------------------- [ 69.631051][ C2] swapper/2/0 just changed the state of lock: [ 69.631228][ C2] ffff8880059c2580 (&ndev->lock){++-.}-{2:2}, at: addrconf_rs_timer+0xa9/0x730 [ 69.631508][ C2] but this lock took another, SOFTIRQ-unsafe lock in the past: [ 69.631721][ C2] (&p->alloc_lock){+.+.}-{2:2} [ 69.631726][ C2] [ 69.631726][ C2] [ 69.631726][ C2] and interrupts could create inverse lock ordering between them. [ 69.631726][ C2] [ 69.632253][ C2] [ 69.632253][ C2] other info that might help us debug this: [ 69.632461][ C2] Possible interrupt unsafe locking scenario: [ 69.632461][ C2] [ 69.632681][ C2] CPU0 CPU1 [ 69.632829][ C2] ---- ---- [ 69.632976][ C2] lock(&p->alloc_lock); [ 69.633089][ C2] local_irq_disable(); [ 69.633270][ C2] lock(&ndev->lock); [ 69.633449][ C2] lock(&p->alloc_lock); [ 69.633646][ C2] [ 69.633755][ C2] lock(&ndev->lock); [ 69.633868][ C2] [ 69.633868][ C2] *** DEADLOCK *** [ 69.633868][ C2] [ 69.634077][ C2] 1 lock held by swapper/2/0: [ 69.634221][ C2] #0: ffffc90000230d68 ((&ndev->rs_timer)){+.-.}-{0:0}, at: call_timer_fn+0xe8/0x230 [ 69.634505][ C2] [ 69.634505][ C2] the shortest dependencies between 2nd lock and 1st lock: [ 69.634752][ C2] -> (&p->alloc_lock){+.+.}-{2:2} { [ 69.634902][ C2] HARDIRQ-ON-W at: [ 69.635011][ C2] __lock_acquire+0x797/0x1570 [ 69.635197][ C2] lock_acquire.part.0+0xeb/0x330 [ 69.635382][ C2] _raw_spin_lock+0x30/0x40 [ 69.635566][ C2] set_mems_allowed+0x1d/0x210 [ 69.635748][ C2] kernel_init_freeable+0x72/0x310 [ 69.635930][ C2] kernel_init+0x20/0x200 [ 69.636111][ C2] ret_from_fork+0x31/0x70 [ 69.636294][ C2] ret_from_fork_asm+0x1a/0x30 [ 69.636473][ C2] SOFTIRQ-ON-W at: [ 69.636580][ C2] __lock_acquire+0x797/0x1570 [ 69.636764][ C2] lock_acquire.part.0+0xeb/0x330 [ 69.636944][ C2] _raw_spin_lock+0x30/0x40 [ 69.637119][ C2] set_mems_allowed+0x1d/0x210 [ 69.637316][ C2] kernel_init_freeable+0x72/0x310 [ 69.637495][ C2] kernel_init+0x20/0x200 [ 69.637678][ C2] ret_from_fork+0x31/0x70 [ 69.637858][ C2] ret_from_fork_asm+0x1a/0x30 [ 69.638040][ C2] INITIAL USE at: [ 69.638149][ C2] __lock_acquire+0x797/0x1570 [ 69.638329][ C2] lock_acquire.part.0+0xeb/0x330 [ 69.638509][ C2] _raw_spin_lock+0x30/0x40 [ 69.638693][ C2] set_mems_allowed+0x1d/0x210 [ 69.638873][ C2] kernel_init_freeable+0x72/0x310 [ 69.639050][ C2] kernel_init+0x20/0x200 [ 69.639234][ C2] ret_from_fork+0x31/0x70 [ 69.639414][ C2] ret_from_fork_asm+0x1a/0x30 [ 69.639592][ C2] } [ 69.639667][ C2] ... key at: [] __key.387+0x0/0x40 [ 69.639894][ C2] ... acquired at: [ 69.639999][ C2] __lock_acquire+0xaf0/0x1570 [ 69.640133][ C2] lock_acquire.part.0+0xeb/0x330 [ 69.640263][ C2] _raw_spin_lock+0x30/0x40 [ 69.640398][ C2] __get_task_comm+0x27/0x70 [ 69.640532][ C2] ref_tracker_alloc+0x2ee/0x490 [ 69.640668][ C2] netdev_get_by_index+0x5e/0x80 [ 69.640799][ C2] fib6_nh_init+0x3d8/0x15b0 [ 69.640933][ C2] ip6_route_info_create+0xf18/0x17d0 [ 69.641063][ C2] addrconf_f6i_alloc+0x265/0x560 [ 69.641194][ C2] __ipv6_dev_ac_inc+0x25f/0xb10 [ 69.641324][ C2] addrconf_join_anycast+0x1c0/0x220 [ 69.641455][ C2] __ipv6_ifa_notify+0x6b3/0xaf0 [ 69.641588][ C2] addrconf_dad_completed+0x12b/0xe20 [ 69.641721][ C2] addrconf_dad_begin+0x310/0x670 [ 69.641857][ C2] addrconf_dad_work+0x10b/0xab0 [ 69.641987][ C2] process_one_work+0xe2c/0x1730 [ 69.642121][ C2] worker_thread+0x587/0xd30 [ 69.642251][ C2] kthread+0x28a/0x350 [ 69.642350][ C2] ret_from_fork+0x31/0x70 [ 69.642483][ C2] ret_from_fork_asm+0x1a/0x30 [ 69.642615][ C2] [ 69.642690][ C2] -> (&ndev->lock){++-.}-{2:2} { [ 69.642837][ C2] HARDIRQ-ON-W at: [ 69.642951][ C2] __lock_acquire+0x797/0x1570 [ 69.643126][ C2] lock_acquire.part.0+0xeb/0x330 [ 69.643306][ C2] _raw_write_lock_bh+0x38/0x50 [ 69.643472][ C2] addrconf_permanent_addr+0x6e/0x670 [ 69.643640][ C2] addrconf_notify+0x749/0xd60 [ 69.643808][ C2] notifier_call_chain+0xcd/0x150 [ 69.643976][ C2] __dev_notify_flags+0xe6/0x250 [ 69.644140][ C2] dev_change_flags+0xec/0x160 [ 69.644302][ C2] do_setlink+0x7d6/0x21e0 [ 69.644519][ C2] __rtnl_newlink+0xaa7/0xd80 [ 69.644686][ C2] rtnl_newlink+0x63/0xa0 [ 69.644851][ C2] rtnetlink_rcv_msg+0x2fb/0xbf0 [ 69.645018][ C2] netlink_rcv_skb+0x130/0x360 [ 69.645183][ C2] netlink_unicast+0x449/0x710 [ 69.645352][ C2] netlink_sendmsg+0x723/0xbe0 [ 69.645515][ C2] ____sys_sendmsg+0x7b2/0xa10 [ 69.645695][ C2] ___sys_sendmsg+0xee/0x170 [ 69.645859][ C2] __sys_sendmsg+0xcd/0x170 [ 69.646023][ C2] do_syscall_64+0xc6/0x1e0 [ 69.646193][ C2] entry_SYSCALL_64_after_hwframe+0x6d/0x75 [ 69.646394][ C2] HARDIRQ-ON-R at: [ 69.646492][ C2] __lock_acquire+0x797/0x1570 [ 69.646660][ C2] lock_acquire.part.0+0xeb/0x330 [ 69.646830][ C2] _raw_read_lock_bh+0x44/0x80 [ 69.646993][ C2] inet6_fill_ifla6_attrs+0x516/0x740 [ 69.647156][ C2] inet6_fill_link_af+0x5e/0xe0 [ 69.647326][ C2] rtnl_fill_ifinfo+0x1612/0x29e0 [ 69.647488][ C2] rtmsg_ifinfo_build_skb+0x13c/0x240 [ 69.647654][ C2] rtmsg_ifinfo_event.part.0+0x2d/0x120 [ 69.647870][ C2] rtmsg_ifinfo+0x5b/0xa0 [ 69.648047][ C2] register_netdevice+0x1177/0x1690 [ 69.648226][ C2] register_netdev+0x20/0x40 [ 69.648417][ C2] sit_init_net+0x250/0x4f0 [ 69.648599][ C2] ops_init+0x9b/0x560 [ 69.648745][ C2] register_pernet_operations+0x2db/0x710 [ 69.648957][ C2] register_pernet_device+0x2a/0x60 [ 69.649149][ C2] sit_init+0x23/0xe0 [ 69.649293][ C2] do_one_initcall+0x8d/0x1e0 [ 69.649470][ C2] do_initcalls+0x1b2/0x3e0 [ 69.649638][ C2] kernel_init_freeable+0x232/0x310 [ 69.649801][ C2] kernel_init+0x20/0x200 [ 69.649964][ C2] ret_from_fork+0x31/0x70 [ 69.650129][ C2] ret_from_fork_asm+0x1a/0x30 [ 69.650295][ C2] IN-SOFTIRQ-W at: [ 69.650392][ C2] __lock_acquire+0x797/0x1570 [ 69.650558][ C2] lock_acquire.part.0+0xeb/0x330 [ 69.650727][ C2] _raw_write_lock+0x30/0x40 [ 69.650892][ C2] addrconf_rs_timer+0xa9/0x730 [ 69.651054][ C2] call_timer_fn+0x13b/0x230 [ 69.651217][ C2] __run_timers+0x545/0x810 [ 69.651382][ C2] run_timer_softirq+0xe8/0x1b0 [ 69.651550][ C2] __do_softirq+0x1f8/0x5df [ 69.651714][ C2] irq_exit_rcu+0x97/0xc0 [ 69.651876][ C2] sysvec_apic_timer_interrupt+0x75/0x80 [ 69.652072][ C2] asm_sysvec_apic_timer_interrupt+0x1a/0x20 [ 69.652269][ C2] default_idle+0xf/0x20 [ 69.652429][ C2] default_idle_call+0x6d/0xb0 [ 69.652598][ C2] cpuidle_idle_call+0x1f4/0x280 [ 69.652785][ C2] do_idle+0xf9/0x160 [ 69.652925][ C2] cpu_startup_entry+0x54/0x60 [ 69.653090][ C2] start_secondary+0x21c/0x2b0 [ 69.653254][ C2] common_startup_64+0x12c/0x138 [ 69.653418][ C2] INITIAL USE at: [ 69.653514][ C2] __lock_acquire+0x797/0x1570 [ 69.653681][ C2] lock_acquire.part.0+0xeb/0x330 [ 69.653852][ C2] _raw_write_lock_bh+0x38/0x50 [ 69.654014][ C2] addrconf_permanent_addr+0x6e/0x670 [ 69.654177][ C2] addrconf_notify+0x749/0xd60 [ 69.654340][ C2] notifier_call_chain+0xcd/0x150 [ 69.654514][ C2] __dev_notify_flags+0xe6/0x250 [ 69.654678][ C2] dev_change_flags+0xec/0x160 [ 69.654845][ C2] do_setlink+0x7d6/0x21e0 [ 69.655007][ C2] __rtnl_newlink+0xaa7/0xd80 [ 69.655169][ C2] rtnl_newlink+0x63/0xa0 [ 69.655335][ C2] rtnetlink_rcv_msg+0x2fb/0xbf0 [ 69.655499][ C2] netlink_rcv_skb+0x130/0x360 [ 69.655666][ C2] netlink_unicast+0x449/0x710 [ 69.655833][ C2] netlink_sendmsg+0x723/0xbe0 [ 69.655998][ C2] ____sys_sendmsg+0x7b2/0xa10 [ 69.656161][ C2] ___sys_sendmsg+0xee/0x170 [ 69.656333][ C2] __sys_sendmsg+0xcd/0x170 [ 69.656501][ C2] do_syscall_64+0xc6/0x1e0 [ 69.656668][ C2] entry_SYSCALL_64_after_hwframe+0x6d/0x75 [ 69.656864][ C2] INITIAL READ USE at: [ 69.656967][ C2] __lock_acquire+0x797/0x1570 [ 69.657131][ C2] lock_acquire.part.0+0xeb/0x330 [ 69.657296][ C2] _raw_read_lock_bh+0x44/0x80 [ 69.657461][ C2] inet6_fill_ifla6_attrs+0x516/0x740 [ 69.657667][ C2] inet6_fill_link_af+0x5e/0xe0 [ 69.657848][ C2] rtnl_fill_ifinfo+0x1612/0x29e0 [ 69.658032][ C2] rtmsg_ifinfo_build_skb+0x13c/0x240 [ 69.658231][ C2] rtmsg_ifinfo_event.part.0+0x2d/0x120 [ 69.658425][ C2] rtmsg_ifinfo+0x5b/0xa0 [ 69.658589][ C2] register_netdevice+0x1177/0x1690 [ 69.658869][ C2] register_netdev+0x20/0x40 [ 69.659033][ C2] sit_init_net+0x250/0x4f0 [ 69.659200][ C2] ops_init+0x9b/0x560 [ 69.659362][ C2] register_pernet_operations+0x2db/0x710 [ 69.659637][ C2] register_pernet_device+0x2a/0x60 [ 69.659832][ C2] sit_init+0x23/0xe0 [ 69.659995][ C2] do_one_initcall+0x8d/0x1e0 [ 69.660241][ C2] do_initcalls+0x1b2/0x3e0 [ 69.660408][ C2] kernel_init_freeable+0x232/0x310 [ 69.660604][ C2] kernel_init+0x20/0x200 [ 69.660851][ C2] ret_from_fork+0x31/0x70 [ 69.661015][ C2] ret_from_fork_asm+0x1a/0x30 [ 69.661192][ C2] } [ 69.661263][ C2] ... key at: [] __key.37+0x0/0x40 [ 69.661540][ C2] ... acquired at: [ 69.661641][ C2] mark_lock+0x28d/0x3e0 [ 69.661787][ C2] mark_usage+0xd9/0x2a0 [ 69.661916][ C2] __lock_acquire+0x797/0x1570 [ 69.662121][ C2] lock_acquire.part.0+0xeb/0x330 [ 69.662252][ C2] _raw_write_lock+0x30/0x40 [ 69.662382][ C2] addrconf_rs_timer+0xa9/0x730 [ 69.662510][ C2] call_timer_fn+0x13b/0x230 [ 69.662718][ C2] __run_timers+0x545/0x810 [ 69.662854][ C2] run_timer_softirq+0xe8/0x1b0 [ 69.662985][ C2] __do_softirq+0x1f8/0x5df [ 69.663115][ C2] irq_exit_rcu+0x97/0xc0 [ 69.663321][ C2] sysvec_apic_timer_interrupt+0x75/0x80 [ 69.663482][ C2] asm_sysvec_apic_timer_interrupt+0x1a/0x20 [ 69.663645][ C2] default_idle+0xf/0x20 [ 69.663776][ C2] default_idle_call+0x6d/0xb0 [ 69.663981][ C2] cpuidle_idle_call+0x1f4/0x280 [ 69.664112][ C2] do_idle+0xf9/0x160 [ 69.664212][ C2] cpu_startup_entry+0x54/0x60 [ 69.664342][ C2] start_secondary+0x21c/0x2b0 [ 69.664483][ C2] common_startup_64+0x12c/0x138 [ 69.664687][ C2] [ 69.664752][ C2] [ 69.664752][ C2] stack backtrace: [ 69.664910][ C2] CPU: 2 PID: 0 Comm: swapper/2 Not tainted 6.9.0-rc1-virtme #1 [ 69.665107][ C2] Hardware name: QEMU Standard PC (i440FX + PIIX, 1996), BIOS rel-1.16.3-0-ga6ed6b701f0a-prebuilt.qemu.org 04/01/2014 [ 69.665553][ C2] Call Trace: [ 69.665653][ C2] [ 69.665723][ C2] dump_stack_lvl+0x82/0xd0 [ 69.665931][ C2] print_irq_inversion_bug.part.0+0x3d9/0x570 [ 69.666092][ C2] ? kernel_text_address+0x17/0xe0 [ 69.666230][ C2] ? __pfx_print_irq_inversion_bug.part.0+0x10/0x10 [ 69.666393][ C2] ? __pfx_usage_skip+0x10/0x10 [ 69.666598][ C2] ? __pfx_usage_match+0x10/0x10 [ 69.666734][ C2] ? arch_stack_walk+0x8c/0xf0 [ 69.666867][ C2] mark_lock_irq+0x4cd/0xa10 [ 69.666997][ C2] ? common_startup_64+0x12c/0x138 [ 69.667203][ C2] ? __pfx_mark_lock_irq+0x10/0x10 [ 69.667334][ C2] ? __pfx_stack_trace_save+0x10/0x10 [ 69.667468][ C2] ? save_trace+0x8f/0x5b0 [ 69.667604][ C2] mark_lock+0x28d/0x3e0 [ 69.667702][ C2] ? __pfx_stack_trace_save+0x10/0x10 [ 69.667920][ C2] mark_usage+0xd9/0x2a0 [ 69.668020][ C2] __lock_acquire+0x797/0x1570 [ 69.668154][ C2] ? __pfx_validate_chain+0x10/0x10 [ 69.668285][ C2] ? __pfx_addrconf_rs_timer+0x10/0x10 [ 69.668495][ C2] lock_acquire.part.0+0xeb/0x330 [ 69.668624][ C2] ? addrconf_rs_timer+0xa9/0x730 [ 69.668756][ C2] ? __pfx_lock_acquire.part.0+0x10/0x10 [ 69.668887][ C2] ? trace_lock_acquire+0x135/0x1c0 [ 69.669022][ C2] ? addrconf_rs_timer+0xa9/0x730 [ 69.669222][ C2] ? lock_acquire+0x32/0xc0 [ 69.669352][ C2] ? addrconf_rs_timer+0xa9/0x730 [ 69.669483][ C2] _raw_write_lock+0x30/0x40 [ 69.669614][ C2] ? addrconf_rs_timer+0xa9/0x730 [ 69.669817][ C2] addrconf_rs_timer+0xa9/0x730 [ 69.669947][ C2] ? __pfx_lock_acquire.part.0+0x10/0x10 [ 69.670077][ C2] ? __pfx_addrconf_rs_timer+0x10/0x10 [ 69.670208][ C2] ? call_timer_fn+0xe8/0x230 [ 69.670410][ C2] ? lock_acquire+0x32/0xc0 [ 69.670542][ C2] ? call_timer_fn+0xe8/0x230 [ 69.670674][ C2] ? __pfx_addrconf_rs_timer+0x10/0x10 [ 69.670806][ C2] call_timer_fn+0x13b/0x230 [ 69.671020][ C2] ? call_timer_fn+0xe8/0x230 [ 69.671153][ C2] ? call_timer_fn+0xe8/0x230 [ 69.671301][ C2] ? __pfx_call_timer_fn+0x10/0x10 [ 69.671441][ C2] ? mark_lock+0x38/0x3e0 [ 69.671548][ C2] __run_timers+0x545/0x810 [ 69.671780][ C2] ? __pfx_addrconf_rs_timer+0x10/0x10 [ 69.671931][ C2] ? __pfx___run_timers+0x10/0x10 [ 69.672062][ C2] ? do_raw_spin_lock+0x131/0x270 [ 69.672193][ C2] ? __pfx_do_raw_spin_lock+0x10/0x10 [ 69.672412][ C2] ? lock_acquire+0x32/0xc0 [ 69.672548][ C2] ? run_timer_softirq+0xe0/0x1b0 [ 69.672684][ C2] run_timer_softirq+0xe8/0x1b0 [ 69.672813][ C2] __do_softirq+0x1f8/0x5df [ 69.673039][ C2] irq_exit_rcu+0x97/0xc0 [ 69.673145][ C2] sysvec_apic_timer_interrupt+0x75/0x80 [ 69.673276][ C2] [ 69.673351][ C2] [ 69.673427][ C2] asm_sysvec_apic_timer_interrupt+0x1a/0x20 [ 69.673590][ C2] RIP: 0010:default_idle+0xf/0x20 [ 69.673816][ C2] Code: 4c 01 c7 4c 29 c2 e9 72 ff ff ff 90 90 90 90 90 90 90 90 90 90 90 90 90 90 90 90 f3 0f 1e fa 66 90 0f 00 2d a3 30 35 00 fb f4 c3 cc cc cc cc 66 66 2e 0f 1f 84 00 00 00 00 00 90 90 90 90 90 [ 69.674422][ C2] RSP: 0018:ffffc9000015fdf8 EFLAGS: 00000242 [ 69.674607][ C2] RAX: 00000000001f69d9 RBX: 1ffff9200002bfc1 RCX: ffffffff9990e9d5 [ 69.674802][ C2] RDX: 0000000000000000 RSI: 0000000000000000 RDI: ffffffff972aa4a4 [ 69.675091][ C2] RBP: 0000000000000000 R08: 0000000000000001 R09: ffffed1006c2709c [ 69.675295][ C2] R10: ffff8880361384e3 R11: ffff88803612d9b0 R12: 0000000000000000 [ 69.675502][ C2] R13: ffff888001b7c5c0 R14: dffffc0000000000 R15: 0000000000000000 [ 69.675873][ C2] ? ct_kernel_exit.constprop.0+0xc5/0xf0 [ 69.676037][ C2] ? cpuidle_idle_call+0x1f4/0x280 [ 69.676168][ C2] default_idle_call+0x6d/0xb0 [ 69.676329][ C2] cpuidle_idle_call+0x1f4/0x280 [ 69.676533][ C2] ? __pfx_cpuidle_idle_call+0x10/0x10 [ 69.676686][ C2] ? tsc_verify_tsc_adjust+0x5e/0x2b0 [ 69.676837][ C2] do_idle+0xf9/0x160 [ 69.676944][ C2] cpu_startup_entry+0x54/0x60 [ 69.677100][ C2] start_secondary+0x21c/0x2b0 [ 69.677342][ C2] ? __pfx_start_secondary+0x10/0x10 [ 69.677472][ C2] common_startup_64+0x12c/0x138 [ 69.677639][ C2] [ 74.998005][ T609] veth2: left allmulticast mode [ 74.998269][ T609] veth2: left promiscuous mode [ 74.998522][ T609] br1: port 2(veth2) entered disabled state [ 75.109453][ T610] veth1: left allmulticast mode [ 75.109789][ T610] veth1: left promiscuous mode [ 75.110142][ T610] br1: port 1(veth1) entered disabled state [ 77.308855][ T612] br1: port 1(veth1) entered blocking state [ 77.309087][ T612] br1: port 1(veth1) entered disabled state [ 77.309304][ T612] veth1: entered allmulticast mode [ 77.310770][ T612] veth1: entered promiscuous mode [ 77.312414][ T612] br1: port 1(veth1) entered blocking state [ 77.312611][ T612] br1: port 1(veth1) entered forwarding state [ 77.418156][ T613] br1: port 2(veth2) entered blocking state [ 77.418362][ T613] br1: port 2(veth2) entered disabled state [ 77.418583][ T613] veth2: entered allmulticast mode [ 77.420201][ T613] veth2: entered promiscuous mode [ 77.420790][ T613] br1: port 2(veth2) entered blocking state [ 77.420975][ T613] br1: port 2(veth2) entered forwarding state [ 81.004422][ T636] br1: port 2(veth2) entered disabled state [ 81.004820][ T636] veth2: left allmulticast mode [ 81.004979][ T636] veth2: left promiscuous mode [ 81.005228][ T636] br1: port 2(veth2) entered disabled state [ 81.104844][ T637] br1: port 1(veth1) entered disabled state [ 81.105366][ T637] veth1: left allmulticast mode [ 81.105513][ T637] veth1: left promiscuous mode [ 81.105758][ T637] br1: port 1(veth1) entered disabled state