[ 28.276254][ T272] 8021q: 802.1Q VLAN Support v1.8 [ 32.494318][ T307] br1: port 1(veth1) entered blocking state [ 32.494699][ T307] br1: port 1(veth1) entered disabled state [ 32.495034][ T307] veth1: entered allmulticast mode [ 32.497068][ T307] veth1: entered promiscuous mode [ 32.636680][ T50] br1: port 1(veth1) entered blocking state [ 32.637003][ T50] br1: port 1(veth1) entered forwarding state [ 38.186833][ C0] [ 38.187015][ C0] ======================================================== [ 38.187271][ C0] WARNING: possible irq lock inversion dependency detected [ 38.187514][ C0] 6.9.0-rc1-virtme #1 Not tainted [ 38.187707][ C0] -------------------------------------------------------- [ 38.187988][ C0] swapper/0/0 just changed the state of lock: [ 38.188188][ C0] ffff88800558d580 (&ndev->lock){++-.}-{2:2}, at: addrconf_rs_timer+0xa9/0x730 [ 38.188486][ C0] but this lock took another, SOFTIRQ-unsafe lock in the past: [ 38.188724][ C0] (&p->alloc_lock){+.+.}-{2:2} [ 38.188728][ C0] [ 38.188728][ C0] [ 38.188728][ C0] and interrupts could create inverse lock ordering between them. [ 38.188728][ C0] [ 38.189340][ C0] [ 38.189340][ C0] other info that might help us debug this: [ 38.189588][ C0] Possible interrupt unsafe locking scenario: [ 38.189588][ C0] [ 38.189823][ C0] CPU0 CPU1 [ 38.189976][ C0] ---- ---- [ 38.190137][ C0] lock(&p->alloc_lock); [ 38.190262][ C0] local_irq_disable(); [ 38.190471][ C0] lock(&ndev->lock); [ 38.190675][ C0] lock(&p->alloc_lock); [ 38.190883][ C0] [ 38.191029][ C0] lock(&ndev->lock); [ 38.191159][ C0] [ 38.191159][ C0] *** DEADLOCK *** [ 38.191159][ C0] [ 38.191393][ C0] 1 lock held by swapper/0/0: [ 38.191558][ C0] #0: ffffc90000007b68 ((&ndev->rs_timer)){+.-.}-{0:0}, at: call_timer_fn+0xe8/0x230 [ 38.191855][ C0] [ 38.191855][ C0] the shortest dependencies between 2nd lock and 1st lock: [ 38.192154][ C0] -> (&p->alloc_lock){+.+.}-{2:2} { [ 38.192323][ C0] HARDIRQ-ON-W at: [ 38.192447][ C0] __lock_acquire+0x797/0x1570 [ 38.192655][ C0] lock_acquire.part.0+0xeb/0x330 [ 38.192859][ C0] _raw_spin_lock+0x30/0x40 [ 38.193073][ C0] set_mems_allowed+0x1d/0x210 [ 38.193281][ C0] kernel_init_freeable+0x72/0x310 [ 38.193489][ C0] kernel_init+0x20/0x200 [ 38.193697][ C0] ret_from_fork+0x31/0x70 [ 38.193911][ C0] ret_from_fork_asm+0x1a/0x30 [ 38.194120][ C0] SOFTIRQ-ON-W at: [ 38.194242][ C0] __lock_acquire+0x797/0x1570 [ 38.194447][ C0] lock_acquire.part.0+0xeb/0x330 [ 38.194655][ C0] _raw_spin_lock+0x30/0x40 [ 38.194858][ C0] set_mems_allowed+0x1d/0x210 [ 38.195060][ C0] kernel_init_freeable+0x72/0x310 [ 38.195272][ C0] kernel_init+0x20/0x200 [ 38.195491][ C0] ret_from_fork+0x31/0x70 [ 38.195728][ C0] ret_from_fork_asm+0x1a/0x30 [ 38.195943][ C0] INITIAL USE at: [ 38.196106][ C0] __lock_acquire+0x797/0x1570 [ 38.196315][ C0] lock_acquire.part.0+0xeb/0x330 [ 38.196519][ C0] _raw_spin_lock+0x30/0x40 [ 38.196732][ C0] set_mems_allowed+0x1d/0x210 [ 38.196937][ C0] kernel_init_freeable+0x72/0x310 [ 38.197130][ C0] kernel_init+0x20/0x200 [ 38.197342][ C0] ret_from_fork+0x31/0x70 [ 38.197534][ C0] ret_from_fork_asm+0x1a/0x30 [ 38.197724][ C0] } [ 38.197816][ C0] ... key at: [] __key.387+0x0/0x40 [ 38.198057][ C0] ... acquired at: [ 38.198169][ C0] __lock_acquire+0xaf0/0x1570 [ 38.198326][ C0] lock_acquire.part.0+0xeb/0x330 [ 38.198481][ C0] _raw_spin_lock+0x30/0x40 [ 38.198636][ C0] __get_task_comm+0x27/0x70 [ 38.198790][ C0] ref_tracker_alloc+0x2ee/0x490 [ 38.198941][ C0] netdev_get_by_index+0x5e/0x80 [ 38.199092][ C0] fib6_nh_init+0x3d8/0x15b0 [ 38.199246][ C0] ip6_route_info_create+0xf18/0x17d0 [ 38.199398][ C0] addrconf_f6i_alloc+0x265/0x560 [ 38.199557][ C0] __ipv6_dev_ac_inc+0x25f/0xb10 [ 38.199707][ C0] addrconf_join_anycast+0x1c0/0x220 [ 38.199863][ C0] dev_forward_change+0x2a6/0x7b0 [ 38.200018][ C0] addrconf_fixup_forwarding+0x23f/0x460 [ 38.200211][ C0] addrconf_sysctl_forward+0x212/0x2b0 [ 38.200361][ C0] proc_sys_call_handler+0x403/0x5e0 [ 38.200516][ C0] vfs_write+0x9e5/0x10a0 [ 38.200708][ C0] ksys_write+0xf5/0x1e0 [ 38.200873][ C0] do_syscall_64+0xc6/0x1e0 [ 38.201045][ C0] entry_SYSCALL_64_after_hwframe+0x6d/0x75 [ 38.201243][ C0] [ 38.201331][ C0] -> (&ndev->lock){++-.}-{2:2} { [ 38.201501][ C0] HARDIRQ-ON-W at: [ 38.201620][ C0] __lock_acquire+0x797/0x1570 [ 38.201826][ C0] lock_acquire.part.0+0xeb/0x330 [ 38.202026][ C0] _raw_write_lock_bh+0x38/0x50 [ 38.202231][ C0] addrconf_permanent_addr+0x6e/0x670 [ 38.202438][ C0] addrconf_notify+0x749/0xd60 [ 38.202638][ C0] notifier_call_chain+0xcd/0x150 [ 38.202840][ C0] __dev_notify_flags+0xe6/0x250 [ 38.203048][ C0] dev_change_flags+0xec/0x160 [ 38.203246][ C0] do_setlink+0x7d6/0x21e0 [ 38.203451][ C0] __rtnl_newlink+0xaa7/0xd80 [ 38.203651][ C0] rtnl_newlink+0x63/0xa0 [ 38.203850][ C0] rtnetlink_rcv_msg+0x2fb/0xbf0 [ 38.204056][ C0] netlink_rcv_skb+0x130/0x360 [ 38.204263][ C0] netlink_unicast+0x449/0x710 [ 38.204463][ C0] netlink_sendmsg+0x723/0xbe0 [ 38.204662][ C0] ____sys_sendmsg+0x7b2/0xa10 [ 38.204869][ C0] ___sys_sendmsg+0xee/0x170 [ 38.205072][ C0] __sys_sendmsg+0xcd/0x170 [ 38.205273][ C0] do_syscall_64+0xc6/0x1e0 [ 38.205488][ C0] entry_SYSCALL_64_after_hwframe+0x6d/0x75 [ 38.205731][ C0] HARDIRQ-ON-R at: [ 38.205851][ C0] __lock_acquire+0x797/0x1570 [ 38.206052][ C0] lock_acquire.part.0+0xeb/0x330 [ 38.206266][ C0] _raw_read_lock_bh+0x44/0x80 [ 38.206469][ C0] inet6_fill_ifla6_attrs+0x516/0x740 [ 38.206668][ C0] inet6_fill_link_af+0x5e/0xe0 [ 38.206879][ C0] rtnl_fill_ifinfo+0x1612/0x29e0 [ 38.207080][ C0] rtmsg_ifinfo_build_skb+0x13c/0x240 [ 38.207294][ C0] rtmsg_ifinfo_event.part.0+0x2d/0x120 [ 38.207543][ C0] rtmsg_ifinfo+0x5b/0xa0 [ 38.207746][ C0] register_netdevice+0x1177/0x1690 [ 38.207948][ C0] register_netdev+0x20/0x40 [ 38.208148][ C0] sit_init_net+0x250/0x4f0 [ 38.208352][ C0] ops_init+0x9b/0x560 [ 38.208519][ C0] register_pernet_operations+0x2db/0x710 [ 38.208776][ C0] register_pernet_device+0x2a/0x60 [ 38.208980][ C0] sit_init+0x23/0xe0 [ 38.209159][ C0] do_one_initcall+0x8d/0x1e0 [ 38.209383][ C0] do_initcalls+0x1b2/0x3e0 [ 38.209606][ C0] kernel_init_freeable+0x232/0x310 [ 38.209857][ C0] kernel_init+0x20/0x200 [ 38.210068][ C0] ret_from_fork+0x31/0x70 [ 38.210296][ C0] ret_from_fork_asm+0x1a/0x30 [ 38.210516][ C0] IN-SOFTIRQ-W at: [ 38.210649][ C0] __lock_acquire+0x797/0x1570 [ 38.210871][ C0] lock_acquire.part.0+0xeb/0x330 [ 38.211077][ C0] _raw_write_lock+0x30/0x40 [ 38.211289][ C0] addrconf_rs_timer+0xa9/0x730 [ 38.211500][ C0] call_timer_fn+0x13b/0x230 [ 38.211705][ C0] __run_timers+0x545/0x810 [ 38.211913][ C0] timer_expire_remote+0x9b/0xe0 [ 38.212126][ C0] tmigr_handle_remote_cpu+0x270/0x430 [ 38.212337][ C0] tmigr_handle_remote_up+0x19f/0x2e0 [ 38.212540][ C0] tmigr_handle_remote+0x21d/0x3a0 [ 38.212751][ C0] __do_softirq+0x1f8/0x5df [ 38.212954][ C0] irq_exit_rcu+0x97/0xc0 [ 38.213161][ C0] sysvec_apic_timer_interrupt+0x75/0x80 [ 38.213408][ C0] asm_sysvec_apic_timer_interrupt+0x1a/0x20 [ 38.213666][ C0] default_idle+0xf/0x20 [ 38.213871][ C0] default_idle_call+0x6d/0xb0 [ 38.214081][ C0] cpuidle_idle_call+0x1f4/0x280 [ 38.214286][ C0] do_idle+0xf9/0x160 [ 38.214462][ C0] cpu_startup_entry+0x54/0x60 [ 38.214681][ C0] rest_init+0x14f/0x260 [ 38.214907][ C0] start_kernel+0x318/0x3d0 [ 38.215139][ C0] x86_64_start_reservations+0x18/0x30 [ 38.215386][ C0] x86_64_start_kernel+0xba/0x110 [ 38.215604][ C0] common_startup_64+0x12c/0x138 [ 38.215825][ C0] INITIAL USE at: [ 38.215949][ C0] __lock_acquire+0x797/0x1570 [ 38.216170][ C0] lock_acquire.part.0+0xeb/0x330 [ 38.216387][ C0] _raw_write_lock_bh+0x38/0x50 [ 38.216613][ C0] addrconf_permanent_addr+0x6e/0x670 [ 38.216834][ C0] addrconf_notify+0x749/0xd60 [ 38.217057][ C0] notifier_call_chain+0xcd/0x150 [ 38.217271][ C0] __dev_notify_flags+0xe6/0x250 [ 38.217496][ C0] dev_change_flags+0xec/0x160 [ 38.217730][ C0] do_setlink+0x7d6/0x21e0 [ 38.217959][ C0] __rtnl_newlink+0xaa7/0xd80 [ 38.218180][ C0] rtnl_newlink+0x63/0xa0 [ 38.218415][ C0] rtnetlink_rcv_msg+0x2fb/0xbf0 [ 38.218625][ C0] netlink_rcv_skb+0x130/0x360 [ 38.218838][ C0] netlink_unicast+0x449/0x710 [ 38.219041][ C0] netlink_sendmsg+0x723/0xbe0 [ 38.219246][ C0] ____sys_sendmsg+0x7b2/0xa10 [ 38.219450][ C0] ___sys_sendmsg+0xee/0x170 [ 38.219698][ C0] __sys_sendmsg+0xcd/0x170 [ 38.219948][ C0] do_syscall_64+0xc6/0x1e0 [ 38.220171][ C0] entry_SYSCALL_64_after_hwframe+0x6d/0x75 [ 38.220440][ C0] INITIAL READ USE at: [ 38.220563][ C0] __lock_acquire+0x797/0x1570 [ 38.220790][ C0] lock_acquire.part.0+0xeb/0x330 [ 38.221006][ C0] _raw_read_lock_bh+0x44/0x80 [ 38.221224][ C0] inet6_fill_ifla6_attrs+0x516/0x740 [ 38.221480][ C0] inet6_fill_link_af+0x5e/0xe0 [ 38.221711][ C0] rtnl_fill_ifinfo+0x1612/0x29e0 [ 38.221942][ C0] rtmsg_ifinfo_build_skb+0x13c/0x240 [ 38.222223][ C0] rtmsg_ifinfo_event.part.0+0x2d/0x120 [ 38.222495][ C0] rtmsg_ifinfo+0x5b/0xa0 [ 38.222715][ C0] register_netdevice+0x1177/0x1690 [ 38.222976][ C0] register_netdev+0x20/0x40 [ 38.223200][ C0] sit_init_net+0x250/0x4f0 [ 38.223404][ C0] ops_init+0x9b/0x560 [ 38.223610][ C0] register_pernet_operations+0x2db/0x710 [ 38.223887][ C0] register_pernet_device+0x2a/0x60 [ 38.224155][ C0] sit_init+0x23/0xe0 [ 38.224368][ C0] do_one_initcall+0x8d/0x1e0 [ 38.224573][ C0] do_initcalls+0x1b2/0x3e0 [ 38.224800][ C0] kernel_init_freeable+0x232/0x310 [ 38.225065][ C0] kernel_init+0x20/0x200 [ 38.225313][ C0] ret_from_fork+0x31/0x70 [ 38.225539][ C0] ret_from_fork_asm+0x1a/0x30 [ 38.225760][ C0] } [ 38.225843][ C0] ... key at: [] __key.37+0x0/0x40 [ 38.226120][ C0] ... acquired at: [ 38.226242][ C0] mark_lock+0x28d/0x3e0 [ 38.226408][ C0] mark_usage+0xd9/0x2a0 [ 38.226580][ C0] __lock_acquire+0x797/0x1570 [ 38.226762][ C0] lock_acquire.part.0+0xeb/0x330 [ 38.226943][ C0] _raw_write_lock+0x30/0x40 [ 38.227107][ C0] addrconf_rs_timer+0xa9/0x730 [ 38.227277][ C0] call_timer_fn+0x13b/0x230 [ 38.227462][ C0] __run_timers+0x545/0x810 [ 38.227658][ C0] timer_expire_remote+0x9b/0xe0 [ 38.227832][ C0] tmigr_handle_remote_cpu+0x270/0x430 [ 38.228010][ C0] tmigr_handle_remote_up+0x19f/0x2e0 [ 38.228177][ C0] tmigr_handle_remote+0x21d/0x3a0 [ 38.228355][ C0] __do_softirq+0x1f8/0x5df [ 38.228520][ C0] irq_exit_rcu+0x97/0xc0 [ 38.228684][ C0] sysvec_apic_timer_interrupt+0x75/0x80 [ 38.228885][ C0] asm_sysvec_apic_timer_interrupt+0x1a/0x20 [ 38.229106][ C0] default_idle+0xf/0x20 [ 38.229278][ C0] default_idle_call+0x6d/0xb0 [ 38.229448][ C0] cpuidle_idle_call+0x1f4/0x280 [ 38.229660][ C0] do_idle+0xf9/0x160 [ 38.229778][ C0] cpu_startup_entry+0x54/0x60 [ 38.229929][ C0] rest_init+0x14f/0x260 [ 38.230078][ C0] start_kernel+0x318/0x3d0 [ 38.230234][ C0] x86_64_start_reservations+0x18/0x30 [ 38.230384][ C0] x86_64_start_kernel+0xba/0x110 [ 38.230543][ C0] common_startup_64+0x12c/0x138 [ 38.230693][ C0] [ 38.230769][ C0] [ 38.230769][ C0] stack backtrace: [ 38.230959][ C0] CPU: 0 PID: 0 Comm: swapper/0 Not tainted 6.9.0-rc1-virtme #1 [ 38.231184][ C0] Hardware name: QEMU Standard PC (i440FX + PIIX, 1996), BIOS rel-1.16.3-0-ga6ed6b701f0a-prebuilt.qemu.org 04/01/2014 [ 38.231514][ C0] Call Trace: [ 38.231633][ C0] [ 38.231711][ C0] dump_stack_lvl+0x82/0xd0 [ 38.231864][ C0] print_irq_inversion_bug.part.0+0x3d9/0x570 [ 38.232053][ C0] ? kernel_text_address+0x17/0xe0 [ 38.232207][ C0] ? __pfx_print_irq_inversion_bug.part.0+0x10/0x10 [ 38.232398][ C0] ? __pfx_usage_skip+0x10/0x10 [ 38.232547][ C0] ? __pfx_usage_match+0x10/0x10 [ 38.232696][ C0] ? arch_stack_walk+0x8c/0xf0 [ 38.232846][ C0] mark_lock_irq+0x4cd/0xa10 [ 38.232996][ C0] ? common_startup_64+0x12c/0x138 [ 38.233146][ C0] ? __pfx_mark_lock_irq+0x10/0x10 [ 38.233299][ C0] ? __pfx_stack_trace_save+0x10/0x10 [ 38.233455][ C0] ? save_trace+0x8f/0x5b0 [ 38.233605][ C0] mark_lock+0x28d/0x3e0 [ 38.233719][ C0] ? __pfx_stack_trace_save+0x10/0x10 [ 38.233866][ C0] mark_usage+0xd9/0x2a0 [ 38.233979][ C0] __lock_acquire+0x797/0x1570 [ 38.234130][ C0] ? __pfx_validate_chain+0x10/0x10 [ 38.234279][ C0] ? __pfx_addrconf_rs_timer+0x10/0x10 [ 38.234432][ C0] lock_acquire.part.0+0xeb/0x330 [ 38.234580][ C0] ? addrconf_rs_timer+0xa9/0x730 [ 38.234731][ C0] ? __pfx_lock_acquire.part.0+0x10/0x10 [ 38.234912][ C0] ? trace_lock_acquire+0x135/0x1c0 [ 38.235074][ C0] ? addrconf_rs_timer+0xa9/0x730 [ 38.235235][ C0] ? lock_acquire+0x32/0xc0 [ 38.235395][ C0] ? addrconf_rs_timer+0xa9/0x730 [ 38.235680][ C0] _raw_write_lock+0x30/0x40 [ 38.235865][ C0] ? addrconf_rs_timer+0xa9/0x730 [ 38.236028][ C0] addrconf_rs_timer+0xa9/0x730 [ 38.236190][ C0] ? __pfx_lock_acquire.part.0+0x10/0x10 [ 38.236360][ C0] ? __pfx_addrconf_rs_timer+0x10/0x10 [ 38.236522][ C0] ? call_timer_fn+0xe8/0x230 [ 38.236688][ C0] ? lock_acquire+0x32/0xc0 [ 38.236837][ C0] ? call_timer_fn+0xe8/0x230 [ 38.237013][ C0] ? __pfx_addrconf_rs_timer+0x10/0x10 [ 38.237162][ C0] call_timer_fn+0x13b/0x230 [ 38.237339][ C0] ? call_timer_fn+0xe8/0x230 [ 38.237486][ C0] ? call_timer_fn+0xe8/0x230 [ 38.237653][ C0] ? __pfx_call_timer_fn+0x10/0x10 [ 38.237822][ C0] ? mark_lock+0x38/0x3e0 [ 38.237945][ C0] __run_timers+0x545/0x810 [ 38.238110][ C0] ? __pfx_addrconf_rs_timer+0x10/0x10 [ 38.238280][ C0] ? __pfx___run_timers+0x10/0x10 [ 38.238455][ C0] ? __lock_release+0x103/0x460 [ 38.238630][ C0] ? do_raw_spin_lock+0x131/0x270 [ 38.238786][ C0] ? __pfx_do_raw_spin_lock+0x10/0x10 [ 38.238955][ C0] ? lock_acquire+0x32/0xc0 [ 38.239105][ C0] ? timer_expire_remote+0x93/0xe0 [ 38.239281][ C0] timer_expire_remote+0x9b/0xe0 [ 38.239436][ C0] tmigr_handle_remote_cpu+0x270/0x430 [ 38.239585][ C0] ? __pfx_tmigr_handle_remote_cpu+0x10/0x10 [ 38.239778][ C0] tmigr_handle_remote_up+0x19f/0x2e0 [ 38.239928][ C0] tmigr_handle_remote+0x21d/0x3a0 [ 38.240087][ C0] ? do_raw_spin_lock+0x131/0x270 [ 38.240235][ C0] ? __pfx_tmigr_handle_remote+0x10/0x10 [ 38.240384][ C0] ? __pfx_do_raw_spin_lock+0x10/0x10 [ 38.240545][ C0] ? lockdep_hardirqs_on_prepare.part.0+0x14f/0x370 [ 38.240734][ C0] __do_softirq+0x1f8/0x5df [ 38.240904][ C0] irq_exit_rcu+0x97/0xc0 [ 38.241018][ C0] sysvec_apic_timer_interrupt+0x75/0x80 [ 38.241176][ C0] [ 38.241260][ C0] [ 38.241349][ C0] asm_sysvec_apic_timer_interrupt+0x1a/0x20 [ 38.241544][ C0] RIP: 0010:default_idle+0xf/0x20 [ 38.241707][ C0] 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 [ 38.242286][ C0] RSP: 0018:ffffffffb6407e00 EFLAGS: 00000246 [ 38.242511][ C0] RAX: 000000000009855f RBX: 1ffffffff6c80fc2 RCX: ffffffffb550e9d5 [ 38.242748][ C0] RDX: 0000000000000000 RSI: 0000000000000000 RDI: ffffffffb2eaa4a4 [ 38.243026][ C0] RBP: 0000000000000000 R08: 0000000000000001 R09: ffffed1005f0709c [ 38.243275][ C0] R10: ffff88802f8384e3 R11: ffff88802f82d9b0 R12: 0000000000000000 [ 38.243519][ C0] R13: ffffffffb641d000 R14: dffffc0000000000 R15: 0000000000014770 [ 38.243782][ C0] ? ct_kernel_exit.constprop.0+0xc5/0xf0 [ 38.243964][ C0] ? cpuidle_idle_call+0x1f4/0x280 [ 38.244121][ C0] default_idle_call+0x6d/0xb0 [ 38.244293][ C0] cpuidle_idle_call+0x1f4/0x280 [ 38.244452][ C0] ? __pfx_cpuidle_idle_call+0x10/0x10 [ 38.244604][ C0] ? tsc_verify_tsc_adjust+0x5e/0x2b0 [ 38.244778][ C0] do_idle+0xf9/0x160 [ 38.244898][ C0] cpu_startup_entry+0x54/0x60 [ 38.245072][ C0] rest_init+0x14f/0x260 [ 38.245187][ C0] start_kernel+0x318/0x3d0 [ 38.245354][ C0] x86_64_start_reservations+0x18/0x30 [ 38.245534][ C0] x86_64_start_kernel+0xba/0x110 [ 38.245696][ C0] common_startup_64+0x12c/0x138 [ 38.245849][ C0] [ 64.365034][ T398] br1: port 1(veth1) entered disabled state [ 64.470554][ T399] veth1: left allmulticast mode [ 64.471475][ T399] veth1: left promiscuous mode [ 64.471913][ T399] br1: port 1(veth1) entered disabled state