[ 31.417151][ T297] Initializing XFRM netlink socket [ 31.977772][ C2] [ 31.977870][ C2] ======================================================== [ 31.978067][ C2] WARNING: possible irq lock inversion dependency detected [ 31.978257][ C2] 6.9.0-rc1-virtme #1 Not tainted [ 31.978387][ C2] -------------------------------------------------------- [ 31.978579][ C2] swapper/2/0 just changed the state of lock: [ 31.978745][ C2] ffff888007d9ed80 (&ndev->lock){++-.}-{2:2}, at: addrconf_rs_timer+0xa9/0x730 [ 31.978979][ C2] but this lock took another, SOFTIRQ-unsafe lock in the past: [ 31.979166][ C2] (&p->alloc_lock){+.+.}-{2:2} [ 31.979171][ C2] [ 31.979171][ C2] [ 31.979171][ C2] and interrupts could create inverse lock ordering between them. [ 31.979171][ C2] [ 31.979639][ C2] [ 31.979639][ C2] other info that might help us debug this: [ 31.979828][ C2] Possible interrupt unsafe locking scenario: [ 31.979828][ C2] [ 31.980017][ C2] CPU0 CPU1 [ 31.980143][ C2] ---- ---- [ 31.980270][ C2] lock(&p->alloc_lock); [ 31.980368][ C2] local_irq_disable(); [ 31.980527][ C2] lock(&ndev->lock); [ 31.980689][ C2] lock(&p->alloc_lock); [ 31.980848][ C2] [ 31.980946][ C2] lock(&ndev->lock); [ 31.981044][ C2] [ 31.981044][ C2] *** DEADLOCK *** [ 31.981044][ C2] [ 31.981230][ C2] 1 lock held by swapper/2/0: [ 31.981359][ C2] #0: ffffc90000230d68 ((&ndev->rs_timer)){+.-.}-{0:0}, at: call_timer_fn+0xe8/0x230 [ 31.981599][ C2] [ 31.981599][ C2] the shortest dependencies between 2nd lock and 1st lock: [ 31.981816][ C2] -> (&p->alloc_lock){+.+.}-{2:2} { [ 31.981949][ C2] HARDIRQ-ON-W at: [ 31.982049][ C2] __lock_acquire+0x797/0x1570 [ 31.982216][ C2] lock_acquire.part.0+0xeb/0x330 [ 31.982378][ C2] _raw_spin_lock+0x30/0x40 [ 31.982546][ C2] set_mems_allowed+0x1d/0x210 [ 31.982710][ C2] kernel_init_freeable+0x72/0x310 [ 31.982874][ C2] kernel_init+0x20/0x200 [ 31.983036][ C2] ret_from_fork+0x31/0x70 [ 31.983200][ C2] ret_from_fork_asm+0x1a/0x30 [ 31.983363][ C2] SOFTIRQ-ON-W at: [ 31.983465][ C2] __lock_acquire+0x797/0x1570 [ 31.983627][ C2] lock_acquire.part.0+0xeb/0x330 [ 31.983791][ C2] _raw_spin_lock+0x30/0x40 [ 31.983953][ C2] set_mems_allowed+0x1d/0x210 [ 31.984114][ C2] kernel_init_freeable+0x72/0x310 [ 31.984276][ C2] kernel_init+0x20/0x200 [ 31.984441][ C2] ret_from_fork+0x31/0x70 [ 31.984604][ C2] ret_from_fork_asm+0x1a/0x30 [ 31.984766][ C2] INITIAL USE at: [ 31.984865][ C2] __lock_acquire+0x797/0x1570 [ 31.985027][ C2] lock_acquire.part.0+0xeb/0x330 [ 31.985190][ C2] _raw_spin_lock+0x30/0x40 [ 31.985351][ C2] set_mems_allowed+0x1d/0x210 [ 31.985519][ C2] kernel_init_freeable+0x72/0x310 [ 31.985681][ C2] kernel_init+0x20/0x200 [ 31.985853][ C2] ret_from_fork+0x31/0x70 [ 31.986019][ C2] ret_from_fork_asm+0x1a/0x30 [ 31.986179][ C2] } [ 31.986246][ C2] ... key at: [] __key.388+0x0/0x40 [ 31.986441][ C2] ... acquired at: [ 31.986539][ C2] __lock_acquire+0xaf0/0x1570 [ 31.986669][ C2] lock_acquire.part.0+0xeb/0x330 [ 31.986799][ C2] _raw_spin_lock+0x30/0x40 [ 31.986927][ C2] __get_task_comm+0x27/0x70 [ 31.987060][ C2] ref_tracker_alloc+0x2ee/0x490 [ 31.987191][ C2] netdev_get_by_index+0x5e/0x80 [ 31.987327][ C2] fib6_nh_init+0x3d8/0x1580 [ 31.987456][ C2] ip6_route_info_create+0xf18/0x17d0 [ 31.987587][ C2] addrconf_f6i_alloc+0x265/0x560 [ 31.987716][ C2] __ipv6_dev_ac_inc+0x25f/0xb10 [ 31.987846][ C2] addrconf_join_anycast+0x1c0/0x220 [ 31.987974][ C2] dev_forward_change+0x2a6/0x7b0 [ 31.988108][ C2] addrconf_fixup_forwarding+0x152/0x460 [ 31.988268][ C2] addrconf_sysctl_forward+0x212/0x2b0 [ 31.988396][ C2] proc_sys_call_handler+0x403/0x5e0 [ 31.988528][ C2] vfs_write+0x9e5/0x10a0 [ 31.988659][ C2] ksys_write+0xf5/0x1e0 [ 31.988790][ C2] do_syscall_64+0xc6/0x1e0 [ 31.988924][ C2] entry_SYSCALL_64_after_hwframe+0x6d/0x75 [ 31.989084][ C2] [ 31.989150][ C2] -> (&ndev->lock){++-.}-{2:2} { [ 31.989291][ C2] HARDIRQ-ON-W at: [ 31.989388][ C2] __lock_acquire+0x797/0x1570 [ 31.989552][ C2] lock_acquire.part.0+0xeb/0x330 [ 31.989719][ C2] _raw_write_lock_bh+0x38/0x50 [ 31.989882][ C2] addrconf_permanent_addr+0x6e/0x670 [ 31.990043][ C2] addrconf_notify+0x749/0xd60 [ 31.990202][ C2] notifier_call_chain+0xcd/0x150 [ 31.990363][ C2] __dev_notify_flags+0xe6/0x250 [ 31.990532][ C2] dev_change_flags+0xec/0x160 [ 31.990692][ C2] do_setlink+0x7d6/0x21e0 [ 31.990852][ C2] __rtnl_newlink+0xaa7/0xd80 [ 31.991014][ C2] rtnl_newlink+0x63/0xa0 [ 31.991173][ C2] rtnetlink_rcv_msg+0x2fb/0xbf0 [ 31.991335][ C2] netlink_rcv_skb+0x130/0x360 [ 31.991498][ C2] netlink_unicast+0x449/0x710 [ 31.991662][ C2] netlink_sendmsg+0x723/0xbe0 [ 31.991823][ C2] ____sys_sendmsg+0x7b2/0xa10 [ 31.991985][ C2] ___sys_sendmsg+0xee/0x170 [ 31.992152][ C2] __sys_sendmsg+0xcd/0x170 [ 31.992313][ C2] do_syscall_64+0xc6/0x1e0 [ 31.992472][ C2] entry_SYSCALL_64_after_hwframe+0x6d/0x75 [ 31.992664][ C2] HARDIRQ-ON-R at: [ 31.992764][ C2] __lock_acquire+0x797/0x1570 [ 31.992931][ C2] lock_acquire.part.0+0xeb/0x330 [ 31.993093][ C2] _raw_read_lock_bh+0x44/0x80 [ 31.993256][ C2] inet6_fill_ifla6_attrs+0x516/0x740 [ 31.993418][ C2] inet6_fill_link_af+0x5e/0xe0 [ 31.993579][ C2] rtnl_fill_ifinfo+0x1615/0x2a90 [ 31.993827][ C2] rtmsg_ifinfo_build_skb+0x13c/0x240 [ 31.993987][ C2] rtmsg_ifinfo_event.part.0+0x2d/0x120 [ 31.994180][ C2] rtmsg_ifinfo+0x5b/0xa0 [ 31.994341][ C2] register_netdevice+0x1177/0x1690 [ 31.994576][ C2] register_netdev+0x20/0x40 [ 31.994742][ C2] vti6_init_net+0x25d/0x380 [ 31.994907][ C2] ops_init+0x9b/0x560 [ 31.995112][ C2] register_pernet_operations+0x2db/0x710 [ 31.995305][ C2] register_pernet_device+0x2a/0x60 [ 31.995465][ C2] vti6_tunnel_init+0x18/0x110 [ 31.995704][ C2] do_one_initcall+0x8d/0x1e0 [ 31.995866][ C2] do_initcalls+0x1b2/0x3e0 [ 31.996026][ C2] kernel_init_freeable+0x232/0x310 [ 31.996191][ C2] kernel_init+0x20/0x200 [ 31.996425][ C2] ret_from_fork+0x31/0x70 [ 31.996588][ C2] ret_from_fork_asm+0x1a/0x30 [ 31.996749][ C2] IN-SOFTIRQ-W at: [ 31.996845][ C2] __lock_acquire+0x797/0x1570 [ 31.997083][ C2] lock_acquire.part.0+0xeb/0x330 [ 31.997248][ C2] _raw_write_lock+0x30/0x40 [ 31.997410][ C2] addrconf_rs_timer+0xa9/0x730 [ 31.997722][ C2] call_timer_fn+0x13b/0x230 [ 31.997884][ C2] __run_timers+0x545/0x810 [ 31.998044][ C2] run_timer_softirq+0xe8/0x1b0 [ 31.998281][ C2] __do_softirq+0x1f8/0x5df [ 31.998442][ C2] irq_exit_rcu+0x97/0xc0 [ 31.998608][ C2] sysvec_apic_timer_interrupt+0x75/0x80 [ 31.998801][ C2] asm_sysvec_apic_timer_interrupt+0x1a/0x20 [ 31.999069][ C2] default_idle+0xf/0x20 [ 31.999229][ C2] default_idle_call+0x6d/0xb0 [ 31.999400][ C2] cpuidle_idle_call+0x1f4/0x280 [ 31.999636][ C2] do_idle+0xf9/0x160 [ 31.999771][ C2] cpu_startup_entry+0x54/0x60 [ 31.999933][ C2] start_secondary+0x21c/0x2b0 [ 32.000171][ C2] common_startup_64+0x12c/0x138 [ 32.000339][ C2] INITIAL USE at: [ 32.000436][ C2] __lock_acquire+0x797/0x1570 [ 32.000597][ C2] lock_acquire.part.0+0xeb/0x330 [ 32.000837][ C2] _raw_write_lock_bh+0x38/0x50 [ 32.001001][ C2] addrconf_permanent_addr+0x6e/0x670 [ 32.001163][ C2] addrconf_notify+0x749/0xd60 [ 32.001329][ C2] notifier_call_chain+0xcd/0x150 [ 32.001490][ C2] __dev_notify_flags+0xe6/0x250 [ 32.001650][ C2] dev_change_flags+0xec/0x160 [ 32.001811][ C2] do_setlink+0x7d6/0x21e0 [ 32.002047][ C2] __rtnl_newlink+0xaa7/0xd80 [ 32.002212][ C2] rtnl_newlink+0x63/0xa0 [ 32.002372][ C2] rtnetlink_rcv_msg+0x2fb/0xbf0 [ 32.002607][ C2] netlink_rcv_skb+0x130/0x360 [ 32.002768][ C2] netlink_unicast+0x449/0x710 [ 32.002930][ C2] netlink_sendmsg+0x723/0xbe0 [ 32.003095][ C2] ____sys_sendmsg+0x7b2/0xa10 [ 32.003332][ C2] ___sys_sendmsg+0xee/0x170 [ 32.003492][ C2] __sys_sendmsg+0xcd/0x170 [ 32.003652][ C2] do_syscall_64+0xc6/0x1e0 [ 32.003889][ C2] entry_SYSCALL_64_after_hwframe+0x6d/0x75 [ 32.004087][ C2] INITIAL READ USE at: [ 32.004182][ C2] __lock_acquire+0x797/0x1570 [ 32.004343][ C2] lock_acquire.part.0+0xeb/0x330 [ 32.004584][ C2] _raw_read_lock_bh+0x44/0x80 [ 32.004745][ C2] inet6_fill_ifla6_attrs+0x516/0x740 [ 32.004943][ C2] inet6_fill_link_af+0x5e/0xe0 [ 32.005179][ C2] rtnl_fill_ifinfo+0x1615/0x2a90 [ 32.005339][ C2] rtmsg_ifinfo_build_skb+0x13c/0x240 [ 32.005535][ C2] rtmsg_ifinfo_event.part.0+0x2d/0x120 [ 32.005810][ C2] rtmsg_ifinfo+0x5b/0xa0 [ 32.005969][ C2] register_netdevice+0x1177/0x1690 [ 32.006160][ C2] register_netdev+0x20/0x40 [ 32.006321][ C2] vti6_init_net+0x25d/0x380 [ 32.006480][ C2] ops_init+0x9b/0x560 [ 32.006645][ C2] register_pernet_operations+0x2db/0x710 [ 32.006912][ C2] register_pernet_device+0x2a/0x60 [ 32.007104][ C2] vti6_tunnel_init+0x18/0x110 [ 32.007264][ C2] do_one_initcall+0x8d/0x1e0 [ 32.007425][ C2] do_initcalls+0x1b2/0x3e0 [ 32.007736][ C2] kernel_init_freeable+0x232/0x310 [ 32.007929][ C2] kernel_init+0x20/0x200 [ 32.008089][ C2] ret_from_fork+0x31/0x70 [ 32.008323][ C2] ret_from_fork_asm+0x1a/0x30 [ 32.008484][ C2] } [ 32.008550][ C2] ... key at: [] __key.37+0x0/0x40 [ 32.008742][ C2] ... acquired at: [ 32.008907][ C2] mark_lock+0x28d/0x3e0 [ 32.009038][ C2] mark_usage+0xd9/0x2a0 [ 32.009166][ C2] __lock_acquire+0x797/0x1570 [ 32.009298][ C2] lock_acquire.part.0+0xeb/0x330 [ 32.009502][ C2] _raw_write_lock+0x30/0x40 [ 32.009631][ C2] addrconf_rs_timer+0xa9/0x730 [ 32.009758][ C2] call_timer_fn+0x13b/0x230 [ 32.009886][ C2] __run_timers+0x545/0x810 [ 32.010086][ C2] run_timer_softirq+0xe8/0x1b0 [ 32.010214][ C2] __do_softirq+0x1f8/0x5df [ 32.010346][ C2] irq_exit_rcu+0x97/0xc0 [ 32.010473][ C2] sysvec_apic_timer_interrupt+0x75/0x80 [ 32.010706][ C2] asm_sysvec_apic_timer_interrupt+0x1a/0x20 [ 32.010865][ C2] default_idle+0xf/0x20 [ 32.010992][ C2] default_idle_call+0x6d/0xb0 [ 32.011119][ C2] cpuidle_idle_call+0x1f4/0x280 [ 32.011322][ C2] do_idle+0xf9/0x160 [ 32.011418][ C2] cpu_startup_entry+0x54/0x60 [ 32.011546][ C2] start_secondary+0x21c/0x2b0 [ 32.011673][ C2] common_startup_64+0x12c/0x138 [ 32.011800][ C2] [ 32.011936][ C2] [ 32.011936][ C2] stack backtrace: [ 32.012093][ C2] CPU: 2 PID: 0 Comm: swapper/2 Not tainted 6.9.0-rc1-virtme #1 [ 32.012289][ C2] Hardware name: QEMU Standard PC (i440FX + PIIX, 1996), BIOS rel-1.16.3-0-ga6ed6b701f0a-prebuilt.qemu.org 04/01/2014 [ 32.012649][ C2] Call Trace: [ 32.012751][ C2] [ 32.012821][ C2] dump_stack_lvl+0x82/0xd0 [ 32.012952][ C2] print_irq_inversion_bug.part.0+0x3d9/0x570 [ 32.013188][ C2] ? kernel_text_address+0x17/0xe0 [ 32.013318][ C2] ? __pfx_print_irq_inversion_bug.part.0+0x10/0x10 [ 32.013475][ C2] ? __pfx_usage_skip+0x10/0x10 [ 32.013602][ C2] ? __pfx_usage_match+0x10/0x10 [ 32.013807][ C2] ? arch_stack_walk+0x8c/0xf0 [ 32.013939][ C2] mark_lock_irq+0x4cd/0xa10 [ 32.014073][ C2] ? common_startup_64+0x12c/0x138 [ 32.014201][ C2] ? __pfx_mark_lock_irq+0x10/0x10 [ 32.014329][ C2] ? __pfx_stack_trace_save+0x10/0x10 [ 32.014458][ C2] ? save_trace+0x8f/0x5b0 [ 32.014585][ C2] mark_lock+0x28d/0x3e0 [ 32.014682][ C2] ? __pfx_stack_trace_save+0x10/0x10 [ 32.014812][ C2] mark_usage+0xd9/0x2a0 [ 32.014912][ C2] __lock_acquire+0x797/0x1570 [ 32.015040][ C2] ? __pfx_validate_chain+0x10/0x10 [ 32.015167][ C2] ? __pfx_addrconf_rs_timer+0x10/0x10 [ 32.015294][ C2] lock_acquire.part.0+0xeb/0x330 [ 32.015421][ C2] ? addrconf_rs_timer+0xa9/0x730 [ 32.015621][ C2] ? __pfx_lock_acquire.part.0+0x10/0x10 [ 32.015752][ C2] ? trace_lock_acquire+0x135/0x1c0 [ 32.015890][ C2] ? addrconf_rs_timer+0xa9/0x730 [ 32.016018][ C2] ? lock_acquire+0x32/0xc0 [ 32.016219][ C2] ? addrconf_rs_timer+0xa9/0x730 [ 32.016349][ C2] _raw_write_lock+0x30/0x40 [ 32.016476][ C2] ? addrconf_rs_timer+0xa9/0x730 [ 32.016604][ C2] addrconf_rs_timer+0xa9/0x730 [ 32.016807][ C2] ? __pfx_lock_acquire.part.0+0x10/0x10 [ 32.016936][ C2] ? __pfx_addrconf_rs_timer+0x10/0x10 [ 32.017062][ C2] ? call_timer_fn+0xe8/0x230 [ 32.017188][ C2] ? lock_acquire+0x32/0xc0 [ 32.017392][ C2] ? call_timer_fn+0xe8/0x230 [ 32.017521][ C2] ? __pfx_addrconf_rs_timer+0x10/0x10 [ 32.017647][ C2] call_timer_fn+0x13b/0x230 [ 32.017774][ C2] ? call_timer_fn+0xe8/0x230 [ 32.017901][ C2] ? call_timer_fn+0xe8/0x230 [ 32.018101][ C2] ? __pfx_call_timer_fn+0x10/0x10 [ 32.018227][ C2] ? mark_lock+0x38/0x3e0 [ 32.018326][ C2] __run_timers+0x545/0x810 [ 32.018454][ C2] ? __pfx_addrconf_rs_timer+0x10/0x10 [ 32.018662][ C2] ? __pfx___run_timers+0x10/0x10 [ 32.018790][ C2] ? do_raw_spin_lock+0x131/0x270 [ 32.018917][ C2] ? __pfx_do_raw_spin_lock+0x10/0x10 [ 32.019043][ C2] ? lock_acquire+0x32/0xc0 [ 32.019242][ C2] ? run_timer_softirq+0xe0/0x1b0 [ 32.019380][ C2] run_timer_softirq+0xe8/0x1b0 [ 32.019509][ C2] __do_softirq+0x1f8/0x5df [ 32.019638][ C2] irq_exit_rcu+0x97/0xc0 [ 32.019739][ C2] sysvec_apic_timer_interrupt+0x75/0x80 [ 32.019940][ C2] [ 32.020006][ C2] [ 32.020071][ C2] asm_sysvec_apic_timer_interrupt+0x1a/0x20 [ 32.020231][ C2] RIP: 0010:default_idle+0xf/0x20 [ 32.020367][ 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 d3 fb 32 00 fb f4 c3 cc cc cc cc 66 66 2e 0f 1f 84 00 00 00 00 00 90 90 90 90 90 [ 32.020898][ C2] RSP: 0018:ffffc9000015fdf8 EFLAGS: 00000242 [ 32.021136][ C2] RAX: 00000000000d8367 RBX: 1ffff9200002bfc1 RCX: ffffffff94b31ea5 [ 32.021330][ C2] RDX: 0000000000000000 RSI: 0000000000000000 RDI: ffffffff922ac1d4 [ 32.021521][ C2] RBP: 0000000000000000 R08: 0000000000000001 R09: ffffed1006c2709c [ 32.021788][ C2] R10: ffff8880361384e3 R11: ffff88803613de40 R12: 0000000000000000 [ 32.021981][ C2] R13: ffff888001b8c5c0 R14: dffffc0000000000 R15: 0000000000000000 [ 32.022175][ C2] ? ct_kernel_exit.constprop.0+0xc5/0xf0 [ 32.022303][ C2] ? cpuidle_idle_call+0x1f4/0x280 [ 32.022432][ C2] default_idle_call+0x6d/0xb0 [ 32.022559][ C2] cpuidle_idle_call+0x1f4/0x280 [ 32.022685][ C2] ? __pfx_cpuidle_idle_call+0x10/0x10 [ 32.022814][ C2] ? tsc_verify_tsc_adjust+0x5e/0x2b0 [ 32.023020][ C2] do_idle+0xf9/0x160 [ 32.023117][ C2] cpu_startup_entry+0x54/0x60 [ 32.023244][ C2] start_secondary+0x21c/0x2b0 [ 32.023371][ C2] ? __pfx_start_secondary+0x10/0x10 [ 32.023573][ C2] common_startup_64+0x12c/0x138 [ 32.023704][ C2] WAIT TIMEOUT stderr Ctrl-C stderr Ctrl-C stderr