[ 27.196887][ T275] 8021q: 802.1Q VLAN Support v1.8 [ 29.802178][ T301] br1: port 1(veth1) entered blocking state [ 29.803541][ T301] br1: port 1(veth1) entered disabled state [ 29.804028][ T301] veth1: entered allmulticast mode [ 29.805926][ T301] veth1: entered promiscuous mode [ 29.925511][ T226] br1: port 1(veth1) entered blocking state [ 29.925840][ T226] br1: port 1(veth1) entered forwarding state [ 34.863618][ C1] [ 34.863782][ C1] ======================================================== [ 34.864058][ C1] WARNING: possible irq lock inversion dependency detected [ 34.864390][ C1] 6.9.0-rc1-virtme #1 Not tainted [ 34.864610][ C1] -------------------------------------------------------- [ 34.864936][ C1] swapper/1/0 just changed the state of lock: [ 34.865209][ C1] ffff8880052aa580 (&ndev->lock){++-.}-{2:2}, at: addrconf_rs_timer+0xa9/0x730 [ 34.865617][ C1] but this lock took another, SOFTIRQ-unsafe lock in the past: [ 34.865941][ C1] (&p->alloc_lock){+.+.}-{2:2} [ 34.865949][ C1] [ 34.865949][ C1] [ 34.865949][ C1] and interrupts could create inverse lock ordering between them. [ 34.865949][ C1] [ 34.866756][ C1] [ 34.866756][ C1] other info that might help us debug this: [ 34.867080][ C1] Possible interrupt unsafe locking scenario: [ 34.867080][ C1] [ 34.867403][ C1] CPU0 CPU1 [ 34.867623][ C1] ---- ---- [ 34.867847][ C1] lock(&p->alloc_lock); [ 34.868016][ C1] local_irq_disable(); [ 34.868284][ C1] lock(&ndev->lock); [ 34.868568][ C1] lock(&p->alloc_lock); [ 34.868843][ C1] <Interrupt> [ 34.869009][ C1] lock(&ndev->lock); [ 34.869180][ C1] [ 34.869180][ C1] *** DEADLOCK *** [ 34.869180][ C1] [ 34.869505][ C1] 1 lock held by swapper/1/0: [ 34.869731][ C1] #0: ffffc900001d8b68 ((&ndev->rs_timer)){+.-.}-{0:0}, at: call_timer_fn+0xe8/0x230 [ 34.870131][ C1] [ 34.870131][ C1] the shortest dependencies between 2nd lock and 1st lock: [ 34.870529][ C1] -> (&p->alloc_lock){+.+.}-{2:2} { [ 34.870768][ C1] HARDIRQ-ON-W at: [ 34.870941][ C1] __lock_acquire+0x797/0x1570 [ 34.871235][ C1] lock_acquire.part.0+0xeb/0x330 [ 34.871517][ C1] _raw_spin_lock+0x30/0x40 [ 34.871800][ C1] set_mems_allowed+0x1d/0x210 [ 34.872083][ C1] kernel_init_freeable+0x72/0x310 [ 34.872372][ C1] kernel_init+0x20/0x200 [ 34.872653][ C1] ret_from_fork+0x31/0x70 [ 34.872938][ C1] ret_from_fork_asm+0x1a/0x30 [ 34.873218][ C1] SOFTIRQ-ON-W at: [ 34.873386][ C1] __lock_acquire+0x797/0x1570 [ 34.873665][ C1] lock_acquire.part.0+0xeb/0x330 [ 34.873945][ C1] _raw_spin_lock+0x30/0x40 [ 34.874232][ C1] set_mems_allowed+0x1d/0x210 [ 34.874509][ C1] kernel_init_freeable+0x72/0x310 [ 34.874784][ C1] kernel_init+0x20/0x200 [ 34.875065][ C1] ret_from_fork+0x31/0x70 [ 34.875348][ C1] ret_from_fork_asm+0x1a/0x30 [ 34.875624][ C1] INITIAL USE at: [ 34.875798][ C1] __lock_acquire+0x797/0x1570 [ 34.876079][ C1] lock_acquire.part.0+0xeb/0x330 [ 34.876356][ C1] _raw_spin_lock+0x30/0x40 [ 34.876638][ C1] set_mems_allowed+0x1d/0x210 [ 34.876916][ C1] kernel_init_freeable+0x72/0x310 [ 34.877195][ C1] kernel_init+0x20/0x200 [ 34.877481][ C1] ret_from_fork+0x31/0x70 [ 34.877760][ C1] ret_from_fork_asm+0x1a/0x30 [ 34.878043][ C1] } [ 34.878158][ C1] ... key at: [<ffffffffa7fffd20>] __key.387+0x0/0x40 [ 34.878491][ C1] ... acquired at: [ 34.878659][ C1] __lock_acquire+0xaf0/0x1570 [ 34.878884][ C1] lock_acquire.part.0+0xeb/0x330 [ 34.879107][ C1] _raw_spin_lock+0x30/0x40 [ 34.879336][ C1] __get_task_comm+0x27/0x70 [ 34.879561][ C1] ref_tracker_alloc+0x2ee/0x490 [ 34.879783][ C1] netdev_get_by_index+0x5e/0x80 [ 34.880008][ C1] fib6_nh_init+0x3d8/0x15b0 [ 34.880237][ C1] ip6_route_info_create+0xf18/0x17d0 [ 34.880458][ C1] addrconf_f6i_alloc+0x265/0x560 [ 34.880679][ C1] __ipv6_dev_ac_inc+0x25f/0xb10 [ 34.880902][ C1] addrconf_join_anycast+0x1c0/0x220 [ 34.881128][ C1] dev_forward_change+0x2a6/0x7b0 [ 34.881355][ C1] addrconf_fixup_forwarding+0x23f/0x460 [ 34.881629][ C1] addrconf_sysctl_forward+0x212/0x2b0 [ 34.881852][ C1] proc_sys_call_handler+0x403/0x5e0 [ 34.882074][ C1] vfs_write+0x9e5/0x10a0 [ 34.882297][ C1] ksys_write+0xf5/0x1e0 [ 34.882519][ C1] do_syscall_64+0xc6/0x1e0 [ 34.882748][ C1] entry_SYSCALL_64_after_hwframe+0x6d/0x75 [ 34.883023][ C1] [ 34.883142][ C1] -> (&ndev->lock){++-.}-{2:2} { [ 34.883372][ C1] HARDIRQ-ON-W at: [ 34.883539][ C1] __lock_acquire+0x797/0x1570 [ 34.883828][ C1] lock_acquire.part.0+0xeb/0x330 [ 34.884107][ C1] _raw_write_lock_bh+0x38/0x50 [ 34.884385][ C1] addrconf_permanent_addr+0x6e/0x670 [ 34.884671][ C1] addrconf_notify+0x749/0xd60 [ 34.884950][ C1] notifier_call_chain+0xcd/0x150 [ 34.885231][ C1] __dev_notify_flags+0xe6/0x250 [ 34.885509][ C1] dev_change_flags+0xec/0x160 [ 34.885788][ C1] do_setlink+0x7d6/0x21e0 [ 34.886068][ C1] __rtnl_newlink+0xaa7/0xd80 [ 34.886352][ C1] rtnl_newlink+0x63/0xa0 [ 34.886631][ C1] rtnetlink_rcv_msg+0x2fb/0xbf0 [ 34.886906][ C1] netlink_rcv_skb+0x130/0x360 [ 34.887189][ C1] netlink_unicast+0x449/0x710 [ 34.887470][ C1] netlink_sendmsg+0x723/0xbe0 [ 34.887752][ C1] ____sys_sendmsg+0x7b2/0xa10 [ 34.888029][ C1] ___sys_sendmsg+0xee/0x170 [ 34.888316][ C1] __sys_sendmsg+0xcd/0x170 [ 34.888594][ C1] do_syscall_64+0xc6/0x1e0 [ 34.888872][ C1] entry_SYSCALL_64_after_hwframe+0x6d/0x75 [ 34.889205][ C1] HARDIRQ-ON-R at: [ 34.889372][ C1] __lock_acquire+0x797/0x1570 [ 34.889655][ C1] lock_acquire.part.0+0xeb/0x330 [ 34.889930][ C1] _raw_read_lock_bh+0x44/0x80 [ 34.890218][ C1] inet6_fill_ifla6_attrs+0x516/0x740 [ 34.890501][ C1] inet6_fill_link_af+0x5e/0xe0 [ 34.890780][ C1] rtnl_fill_ifinfo+0x1612/0x29e0 [ 34.891062][ C1] rtmsg_ifinfo_build_skb+0x13c/0x240 [ 34.891342][ C1] rtmsg_ifinfo_event.part.0+0x2d/0x120 [ 34.891683][ C1] rtmsg_ifinfo+0x5b/0xa0 [ 34.891961][ C1] register_netdevice+0x1177/0x1690 [ 34.892238][ C1] register_netdev+0x20/0x40 [ 34.892522][ C1] sit_init_net+0x250/0x4f0 [ 34.892801][ C1] ops_init+0x9b/0x560 [ 34.893024][ C1] register_pernet_operations+0x2db/0x710 [ 34.893362][ C1] register_pernet_device+0x2a/0x60 [ 34.893645][ C1] sit_init+0x23/0xe0 [ 34.893871][ C1] do_one_initcall+0x8d/0x1e0 [ 34.894152][ C1] do_initcalls+0x1b2/0x3e0 [ 34.894431][ C1] kernel_init_freeable+0x232/0x310 [ 34.894709][ C1] kernel_init+0x20/0x200 [ 34.894988][ C1] ret_from_fork+0x31/0x70 [ 34.895275][ C1] ret_from_fork_asm+0x1a/0x30 [ 34.895558][ C1] IN-SOFTIRQ-W at: [ 34.895725][ C1] __lock_acquire+0x797/0x1570 [ 34.896008][ C1] lock_acquire.part.0+0xeb/0x330 [ 34.896291][ C1] _raw_write_lock+0x30/0x40 [ 34.896571][ C1] addrconf_rs_timer+0xa9/0x730 [ 34.896850][ C1] call_timer_fn+0x13b/0x230 [ 34.897138][ C1] __run_timers+0x545/0x810 [ 34.897420][ C1] timer_expire_remote+0x9b/0xe0 [ 34.897698][ C1] tmigr_handle_remote_cpu+0x270/0x430 [ 34.897978][ C1] tmigr_handle_remote_up+0x19f/0x2e0 [ 34.898257][ C1] tmigr_handle_remote+0x21d/0x3a0 [ 34.898536][ C1] __do_softirq+0x1f8/0x5df [ 34.898820][ C1] irq_exit_rcu+0x97/0xc0 [ 34.899099][ C1] sysvec_apic_timer_interrupt+0x75/0x80 [ 34.899432][ C1] asm_sysvec_apic_timer_interrupt+0x1a/0x20 [ 34.899765][ C1] default_idle+0xf/0x20 [ 34.900046][ C1] default_idle_call+0x6d/0xb0 [ 34.900335][ C1] cpuidle_idle_call+0x1f4/0x280 [ 34.900619][ C1] do_idle+0xf9/0x160 [ 34.900843][ C1] cpu_startup_entry+0x54/0x60 [ 34.901124][ C1] start_secondary+0x21c/0x2b0 [ 34.901405][ C1] common_startup_64+0x12c/0x138 [ 34.901684][ C1] INITIAL USE at: [ 34.901857][ C1] __lock_acquire+0x797/0x1570 [ 34.902138][ C1] lock_acquire.part.0+0xeb/0x330 [ 34.902421][ C1] _raw_write_lock_bh+0x38/0x50 [ 34.902701][ C1] addrconf_permanent_addr+0x6e/0x670 [ 34.902982][ C1] addrconf_notify+0x749/0xd60 [ 34.903260][ C1] notifier_call_chain+0xcd/0x150 [ 34.903536][ C1] __dev_notify_flags+0xe6/0x250 [ 34.903820][ C1] dev_change_flags+0xec/0x160 [ 34.904104][ C1] do_setlink+0x7d6/0x21e0 [ 34.904386][ C1] __rtnl_newlink+0xaa7/0xd80 [ 34.904663][ C1] rtnl_newlink+0x63/0xa0 [ 34.904945][ C1] rtnetlink_rcv_msg+0x2fb/0xbf0 [ 34.905223][ C1] netlink_rcv_skb+0x130/0x360 [ 34.905504][ C1] netlink_unicast+0x449/0x710 [ 34.905784][ C1] netlink_sendmsg+0x723/0xbe0 [ 34.906067][ C1] ____sys_sendmsg+0x7b2/0xa10 [ 34.906346][ C1] ___sys_sendmsg+0xee/0x170 [ 34.906625][ C1] __sys_sendmsg+0xcd/0x170 [ 34.906904][ C1] do_syscall_64+0xc6/0x1e0 [ 34.907188][ C1] entry_SYSCALL_64_after_hwframe+0x6d/0x75 [ 34.907517][ C1] INITIAL READ USE at: [ 34.907686][ C1] __lock_acquire+0x797/0x1570 [ 34.907970][ C1] lock_acquire.part.0+0xeb/0x330 [ 34.908247][ C1] _raw_read_lock_bh+0x44/0x80 [ 34.908527][ C1] inet6_fill_ifla6_attrs+0x516/0x740 [ 34.908859][ C1] inet6_fill_link_af+0x5e/0xe0 [ 34.909138][ C1] rtnl_fill_ifinfo+0x1612/0x29e0 [ 34.909415][ C1] rtmsg_ifinfo_build_skb+0x13c/0x240 [ 34.909754][ C1] rtmsg_ifinfo_event.part.0+0x2d/0x120 [ 34.910085][ C1] rtmsg_ifinfo+0x5b/0xa0 [ 34.910375][ C1] register_netdevice+0x1177/0x1690 [ 34.910710][ C1] register_netdev+0x20/0x40 [ 34.910987][ C1] sit_init_net+0x250/0x4f0 [ 34.911274][ C1] ops_init+0x9b/0x560 [ 34.911552][ C1] register_pernet_operations+0x2db/0x710 [ 34.911887][ C1] register_pernet_device+0x2a/0x60 [ 34.912219][ C1] sit_init+0x23/0xe0 [ 34.912499][ C1] do_one_initcall+0x8d/0x1e0 [ 34.912779][ C1] do_initcalls+0x1b2/0x3e0 [ 34.913067][ C1] kernel_init_freeable+0x232/0x310 [ 34.913401][ C1] kernel_init+0x20/0x200 [ 34.913687][ C1] ret_from_fork+0x31/0x70 [ 34.913967][ C1] ret_from_fork_asm+0x1a/0x30 [ 34.914255][ C1] } [ 34.914369][ C1] ... key at: [<ffffffffa9058300>] __key.37+0x0/0x40 [ 34.914697][ C1] ... acquired at: [ 34.914871][ C1] mark_lock+0x28d/0x3e0 [ 34.915123][ C1] mark_usage+0xd9/0x2a0 [ 34.915347][ C1] __lock_acquire+0x797/0x1570 [ 34.915569][ C1] lock_acquire.part.0+0xeb/0x330 [ 34.915791][ C1] _raw_write_lock+0x30/0x40 [ 34.916012][ C1] addrconf_rs_timer+0xa9/0x730 [ 34.916236][ C1] call_timer_fn+0x13b/0x230 [ 34.916461][ C1] __run_timers+0x545/0x810 [ 34.916691][ C1] timer_expire_remote+0x9b/0xe0 [ 34.916935][ C1] tmigr_handle_remote_cpu+0x270/0x430 [ 34.917176][ C1] tmigr_handle_remote_up+0x19f/0x2e0 [ 34.917398][ C1] tmigr_handle_remote+0x21d/0x3a0 [ 34.917635][ C1] __do_softirq+0x1f8/0x5df [ 34.917856][ C1] irq_exit_rcu+0x97/0xc0 [ 34.918081][ C1] sysvec_apic_timer_interrupt+0x75/0x80 [ 34.918362][ C1] asm_sysvec_apic_timer_interrupt+0x1a/0x20 [ 34.918640][ C1] default_idle+0xf/0x20 [ 34.918877][ C1] default_idle_call+0x6d/0xb0 [ 34.919102][ C1] cpuidle_idle_call+0x1f4/0x280 [ 34.919328][ C1] do_idle+0xf9/0x160 [ 34.919495][ C1] cpu_startup_entry+0x54/0x60 [ 34.919721][ C1] start_secondary+0x21c/0x2b0 [ 34.919946][ C1] common_startup_64+0x12c/0x138 [ 34.920174][ C1] [ 34.920301][ C1] [ 34.920301][ C1] stack backtrace: [ 34.920578][ C1] CPU: 1 PID: 0 Comm: swapper/1 Not tainted 6.9.0-rc1-virtme #1 [ 34.920912][ C1] Hardware name: QEMU Standard PC (i440FX + PIIX, 1996), BIOS rel-1.16.3-0-ga6ed6b701f0a-prebuilt.qemu.org 04/01/2014 [ 34.921402][ C1] Call Trace: [ 34.921569][ C1] <IRQ> [ 34.921685][ C1] dump_stack_lvl+0x82/0xd0 [ 34.921917][ C1] print_irq_inversion_bug.part.0+0x3d9/0x570 [ 34.922198][ C1] ? kernel_text_address+0x17/0xe0 [ 34.922427][ C1] ? __pfx_print_irq_inversion_bug.part.0+0x10/0x10 [ 34.922693][ C1] ? __pfx_usage_skip+0x10/0x10 [ 34.922916][ C1] ? __pfx_usage_match+0x10/0x10 [ 34.923143][ C1] ? arch_stack_walk+0x8c/0xf0 [ 34.923370][ C1] mark_lock_irq+0x4cd/0xa10 [ 34.923594][ C1] ? common_startup_64+0x12c/0x138 [ 34.923818][ C1] ? __pfx_mark_lock_irq+0x10/0x10 [ 34.924049][ C1] ? __pfx_stack_trace_save+0x10/0x10 [ 34.924285][ C1] ? save_trace+0x8f/0x5b0 [ 34.924509][ C1] mark_lock+0x28d/0x3e0 [ 34.924676][ C1] ? __pfx_stack_trace_save+0x10/0x10 [ 34.924902][ C1] mark_usage+0xd9/0x2a0 [ 34.925075][ C1] __lock_acquire+0x797/0x1570 [ 34.925299][ C1] ? __pfx_validate_chain+0x10/0x10 [ 34.925521][ C1] ? __pfx_addrconf_rs_timer+0x10/0x10 [ 34.925743][ C1] lock_acquire.part.0+0xeb/0x330 [ 34.925974][ C1] ? addrconf_rs_timer+0xa9/0x730 [ 34.926200][ C1] ? __pfx_lock_acquire.part.0+0x10/0x10 [ 34.926424][ C1] ? trace_lock_acquire+0x135/0x1c0 [ 34.926653][ C1] ? addrconf_rs_timer+0xa9/0x730 [ 34.926880][ C1] ? lock_acquire+0x32/0xc0 [ 34.927102][ C1] ? addrconf_rs_timer+0xa9/0x730 [ 34.927328][ C1] _raw_write_lock+0x30/0x40 [ 34.927550][ C1] ? addrconf_rs_timer+0xa9/0x730 [ 34.927774][ C1] addrconf_rs_timer+0xa9/0x730 [ 34.928005][ C1] ? __pfx_lock_acquire.part.0+0x10/0x10 [ 34.928234][ C1] ? __pfx_addrconf_rs_timer+0x10/0x10 [ 34.928456][ C1] ? call_timer_fn+0xe8/0x230 [ 34.928678][ C1] ? lock_acquire+0x32/0xc0 [ 34.928897][ C1] ? call_timer_fn+0xe8/0x230 [ 34.929123][ C1] ? __pfx_addrconf_rs_timer+0x10/0x10 [ 34.929345][ C1] call_timer_fn+0x13b/0x230 [ 34.929566][ C1] ? call_timer_fn+0xe8/0x230 [ 34.929795][ C1] ? call_timer_fn+0xe8/0x230 [ 34.930020][ C1] ? __pfx_call_timer_fn+0x10/0x10 [ 34.930252][ C1] ? mark_lock+0x38/0x3e0 [ 34.930429][ C1] __run_timers+0x545/0x810 [ 34.930652][ C1] ? __pfx_addrconf_rs_timer+0x10/0x10 [ 34.930876][ C1] ? __pfx___run_timers+0x10/0x10 [ 34.931103][ C1] ? __lock_release+0x103/0x460 [ 34.931328][ C1] ? do_raw_spin_lock+0x131/0x270 [ 34.931552][ C1] ? __pfx_do_raw_spin_lock+0x10/0x10 [ 34.931778][ C1] ? lock_acquire+0x32/0xc0 [ 34.932016][ C1] ? timer_expire_remote+0x93/0xe0 [ 34.932240][ C1] timer_expire_remote+0x9b/0xe0 [ 34.932461][ C1] tmigr_handle_remote_cpu+0x270/0x430 [ 34.932686][ C1] ? __pfx_tmigr_handle_remote_cpu+0x10/0x10 [ 34.932970][ C1] tmigr_handle_remote_up+0x19f/0x2e0 [ 34.933201][ C1] tmigr_handle_remote+0x21d/0x3a0 [ 34.933429][ C1] ? __pfx_tmigr_handle_remote+0x10/0x10 [ 34.933659][ C1] __do_softirq+0x1f8/0x5df [ 34.933882][ C1] irq_exit_rcu+0x97/0xc0 [ 34.934051][ C1] sysvec_apic_timer_interrupt+0x75/0x80 [ 34.934270][ C1] </IRQ> [ 34.934386][ C1] <TASK> [ 34.934501][ C1] asm_sysvec_apic_timer_interrupt+0x1a/0x20 [ 34.934776][ C1] RIP: 0010:default_idle+0xf/0x20 [ 34.935011][ C1] 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 <fa> c3 cc cc cc cc 66 66 2e 0f 1f 84 00 00 00 00 00 90 90 90 90 90 [ 34.935811][ C1] RSP: 0018:ffffc9000014fdf8 EFLAGS: 00000246 [ 34.936094][ C1] RAX: 000000000008034b RBX: 1ffff92000029fc1 RCX: ffffffffa550e9d5 [ 34.936429][ C1] RDX: 0000000000000000 RSI: 0000000000000000 RDI: ffffffffa2eaa4a4 [ 34.936766][ C1] RBP: 0000000000000000 R08: 0000000000000001 R09: ffffed1005ed709c [ 34.937097][ C1] R10: ffff88802f6b84e3 R11: ffff88802f6ad9b0 R12: 0000000000000000 [ 34.937430][ C1] R13: ffff888001b7a300 R14: dffffc0000000000 R15: 0000000000000000 [ 34.937767][ C1] ? ct_kernel_exit.constprop.0+0xc5/0xf0 [ 34.937989][ C1] ? cpuidle_idle_call+0x1f4/0x280 [ 34.938216][ C1] default_idle_call+0x6d/0xb0 [ 34.938444][ C1] cpuidle_idle_call+0x1f4/0x280 [ 34.938666][ C1] ? __pfx_cpuidle_idle_call+0x10/0x10 [ 34.938891][ C1] ? tsc_verify_tsc_adjust+0x5e/0x2b0 [ 34.939118][ C1] do_idle+0xf9/0x160 [ 34.939292][ C1] cpu_startup_entry+0x54/0x60 [ 34.939512][ C1] start_secondary+0x21c/0x2b0 [ 34.939733][ C1] ? __pfx_start_secondary+0x10/0x10 [ 34.939958][ C1] common_startup_64+0x12c/0x138 [ 34.940202][ C1] </TASK> [ 48.318956][ T376] br1: port 1(veth1) entered disabled state [ 48.417939][ T377] veth1: left allmulticast mode [ 48.418119][ T377] veth1: left promiscuous mode [ 48.418389][ T377] br1: port 1(veth1) entered disabled state