[ 23.468915][ T245] ip (245) used greatest stack depth: 24032 bytes left [ 26.449436][ T263] ip (263) used greatest stack depth: 23968 bytes left [ 26.706395][ T265] eth0: renamed from r1h0 [ 27.577163][ T272] eth1: renamed from r1h1 [ 28.461843][ T280] eth2: renamed from r1h2 [ 29.329343][ T287] eth3: renamed from r1h3 [ 31.977205][ C0] [ 31.977437][ C0] ======================================================== [ 31.977669][ C0] WARNING: possible irq lock inversion dependency detected [ 31.977895][ C0] 6.9.0-rc1-virtme #1 Not tainted [ 31.978041][ C0] -------------------------------------------------------- [ 31.978264][ C0] swapper/0/0 just changed the state of lock: [ 31.978461][ C0] ffff888007f93d80 (&ndev->lock){++-.}-{2:2}, at: addrconf_rs_timer+0xa9/0x730 [ 31.978730][ C0] but this lock took another, SOFTIRQ-unsafe lock in the past: [ 31.978959][ C0] (&p->alloc_lock){+.+.}-{2:2} [ 31.978964][ C0] [ 31.978964][ C0] [ 31.978964][ C0] and interrupts could create inverse lock ordering between them. [ 31.978964][ C0] [ 31.979510][ C0] [ 31.979510][ C0] other info that might help us debug this: [ 31.979732][ C0] Possible interrupt unsafe locking scenario: [ 31.979732][ C0] [ 31.979955][ C0] CPU0 CPU1 [ 31.980101][ C0] ---- ---- [ 31.980246][ C0] lock(&p->alloc_lock); [ 31.980359][ C0] local_irq_disable(); [ 31.980541][ C0] lock(&ndev->lock); [ 31.980729][ C0] lock(&p->alloc_lock); [ 31.980914][ C0] <Interrupt> [ 31.981024][ C0] lock(&ndev->lock); [ 31.981136][ C0] [ 31.981136][ C0] *** DEADLOCK *** [ 31.981136][ C0] [ 31.981353][ C0] 1 lock held by swapper/0/0: [ 31.981505][ C0] #0: ffffc90000007b68 ((&ndev->rs_timer)){+.-.}-{0:0}, at: call_timer_fn+0xe8/0x230 [ 31.981772][ C0] [ 31.981772][ C0] the shortest dependencies between 2nd lock and 1st lock: [ 31.982031][ C0] -> (&p->alloc_lock){+.+.}-{2:2} { [ 31.982184][ C0] HARDIRQ-ON-W at: [ 31.982298][ C0] __lock_acquire+0x797/0x1570 [ 31.982489][ C0] lock_acquire.part.0+0xeb/0x330 [ 31.982678][ C0] _raw_spin_lock+0x30/0x40 [ 31.982865][ C0] set_mems_allowed+0x1d/0x210 [ 31.983060][ C0] kernel_init_freeable+0x72/0x310 [ 31.983250][ C0] kernel_init+0x20/0x200 [ 31.983437][ C0] ret_from_fork+0x31/0x70 [ 31.983624][ C0] ret_from_fork_asm+0x1a/0x30 [ 31.983810][ C0] SOFTIRQ-ON-W at: [ 31.983923][ C0] __lock_acquire+0x797/0x1570 [ 31.984110][ C0] lock_acquire.part.0+0xeb/0x330 [ 31.984298][ C0] _raw_spin_lock+0x30/0x40 [ 31.984486][ C0] set_mems_allowed+0x1d/0x210 [ 31.984674][ C0] kernel_init_freeable+0x72/0x310 [ 31.984862][ C0] kernel_init+0x20/0x200 [ 31.985049][ C0] ret_from_fork+0x31/0x70 [ 31.985241][ C0] ret_from_fork_asm+0x1a/0x30 [ 31.985426][ C0] INITIAL USE at: [ 31.985538][ C0] __lock_acquire+0x797/0x1570 [ 31.985724][ C0] lock_acquire.part.0+0xeb/0x330 [ 31.985912][ C0] _raw_spin_lock+0x30/0x40 [ 31.986098][ C0] set_mems_allowed+0x1d/0x210 [ 31.986283][ C0] kernel_init_freeable+0x72/0x310 [ 31.986473][ C0] kernel_init+0x20/0x200 [ 31.986659][ C0] ret_from_fork+0x31/0x70 [ 31.986846][ C0] ret_from_fork_asm+0x1a/0x30 [ 31.987033][ C0] } [ 31.987115][ C0] ... key at: [<ffffffff962fcd20>] __key.388+0x0/0x40 [ 31.987337][ C0] ... acquired at: [ 31.987461][ C0] __lock_acquire+0xaf0/0x1570 [ 31.987613][ C0] lock_acquire.part.0+0xeb/0x330 [ 31.987764][ C0] _raw_spin_lock+0x30/0x40 [ 31.987912][ C0] __get_task_comm+0x27/0x70 [ 31.988062][ C0] ref_tracker_alloc+0x2ee/0x490 [ 31.988212][ C0] netdev_get_by_index+0x5e/0x80 [ 31.988363][ C0] fib6_nh_init+0x3d8/0x1580 [ 31.988520][ C0] ip6_route_info_create+0xf18/0x17d0 [ 31.988667][ C0] addrconf_f6i_alloc+0x265/0x560 [ 31.988819][ C0] __ipv6_dev_ac_inc+0x25f/0xb10 [ 31.988969][ C0] addrconf_join_anycast+0x1c0/0x220 [ 31.989120][ C0] __ipv6_ifa_notify+0x6b3/0xaf0 [ 31.989269][ C0] addrconf_dad_completed+0x12b/0xe20 [ 31.989417][ C0] addrconf_dad_work+0x38c/0xab0 [ 31.989566][ C0] process_one_work+0xe2c/0x1730 [ 31.989717][ C0] worker_thread+0x587/0xd30 [ 31.989869][ C0] kthread+0x28a/0x350 [ 31.989982][ C0] ret_from_fork+0x31/0x70 [ 31.990130][ C0] ret_from_fork_asm+0x1a/0x30 [ 31.990281][ C0] [ 31.990356][ C0] -> (&ndev->lock){++-.}-{2:2} { [ 31.990508][ C0] HARDIRQ-ON-W at: [ 31.990620][ C0] __lock_acquire+0x797/0x1570 [ 31.990806][ C0] lock_acquire.part.0+0xeb/0x330 [ 31.990997][ C0] _raw_write_lock_bh+0x38/0x50 [ 31.991191][ C0] addrconf_permanent_addr+0x6e/0x670 [ 31.991376][ C0] addrconf_notify+0x749/0xd60 [ 31.991562][ C0] notifier_call_chain+0xcd/0x150 [ 31.991749][ C0] __dev_notify_flags+0xe6/0x250 [ 31.991937][ C0] dev_change_flags+0xec/0x160 [ 31.992126][ C0] do_setlink+0x7d6/0x21e0 [ 31.992313][ C0] __rtnl_newlink+0xaa7/0xd80 [ 31.992501][ C0] rtnl_newlink+0x63/0xa0 [ 31.992692][ C0] rtnetlink_rcv_msg+0x2fb/0xbf0 [ 31.992883][ C0] netlink_rcv_skb+0x130/0x360 [ 31.993071][ C0] netlink_unicast+0x449/0x710 [ 31.993256][ C0] netlink_sendmsg+0x723/0xbe0 [ 31.993446][ C0] ____sys_sendmsg+0x7b2/0xa10 [ 31.993634][ C0] ___sys_sendmsg+0xee/0x170 [ 31.993821][ C0] __sys_sendmsg+0xcd/0x170 [ 31.994007][ C0] do_syscall_64+0xc6/0x1e0 [ 31.994196][ C0] entry_SYSCALL_64_after_hwframe+0x6d/0x75 [ 31.994418][ C0] HARDIRQ-ON-R at: [ 31.994530][ C0] __lock_acquire+0x797/0x1570 [ 31.994719][ C0] lock_acquire.part.0+0xeb/0x330 [ 31.994909][ C0] _raw_read_lock_bh+0x44/0x80 [ 31.995095][ C0] inet6_fill_ifla6_attrs+0x516/0x740 [ 31.995282][ C0] inet6_fill_link_af+0x5e/0xe0 [ 31.995469][ C0] rtnl_fill_ifinfo+0x1615/0x2a90 [ 31.995654][ C0] rtmsg_ifinfo_build_skb+0x13c/0x240 [ 31.995844][ C0] rtmsg_ifinfo_event.part.0+0x2d/0x120 [ 31.996067][ C0] rtmsg_ifinfo+0x5b/0xa0 [ 31.996251][ C0] register_netdevice+0x1177/0x1690 [ 31.996435][ C0] register_netdev+0x20/0x40 [ 31.996622][ C0] vti6_init_net+0x25d/0x380 [ 31.996812][ C0] ops_init+0x9b/0x560 [ 31.996964][ C0] register_pernet_operations+0x2db/0x710 [ 31.997184][ C0] register_pernet_device+0x2a/0x60 [ 31.997371][ C0] vti6_tunnel_init+0x18/0x110 [ 31.997557][ C0] do_one_initcall+0x8d/0x1e0 [ 31.997744][ C0] do_initcalls+0x1b2/0x3e0 [ 31.997932][ C0] kernel_init_freeable+0x232/0x310 [ 31.998119][ C0] kernel_init+0x20/0x200 [ 31.998309][ C0] ret_from_fork+0x31/0x70 [ 31.998511][ C0] ret_from_fork_asm+0x1a/0x30 [ 31.998701][ C0] IN-SOFTIRQ-W at: [ 31.998814][ C0] __lock_acquire+0x797/0x1570 [ 31.999001][ C0] lock_acquire.part.0+0xeb/0x330 [ 31.999187][ C0] _raw_write_lock+0x30/0x40 [ 31.999378][ C0] addrconf_rs_timer+0xa9/0x730 [ 31.999572][ C0] call_timer_fn+0x13b/0x230 [ 31.999762][ C0] __run_timers+0x545/0x810 [ 31.999950][ C0] timer_expire_remote+0x9b/0xe0 [ 32.000135][ C0] tmigr_handle_remote_cpu+0x270/0x430 [ 32.000319][ C0] tmigr_handle_remote_up+0x19f/0x2e0 [ 32.000504][ C0] tmigr_handle_remote+0x21d/0x3a0 [ 32.000693][ C0] __do_softirq+0x1f8/0x5df [ 32.000880][ C0] irq_exit_rcu+0x97/0xc0 [ 32.001065][ C0] sysvec_apic_timer_interrupt+0x75/0x80 [ 32.001289][ C0] asm_sysvec_apic_timer_interrupt+0x1a/0x20 [ 32.001511][ C0] default_idle+0xf/0x20 [ 32.001696][ C0] default_idle_call+0x6d/0xb0 [ 32.001887][ C0] cpuidle_idle_call+0x1f4/0x280 [ 32.002073][ C0] do_idle+0xf9/0x160 [ 32.002224][ C0] cpu_startup_entry+0x54/0x60 [ 32.002410][ C0] rest_init+0x14f/0x260 [ 32.002594][ C0] start_kernel+0x318/0x3d0 [ 32.002780][ C0] x86_64_start_reservations+0x18/0x30 [ 32.002968][ C0] x86_64_start_kernel+0xba/0x110 [ 32.003154][ C0] common_startup_64+0x12c/0x138 [ 32.003340][ C0] INITIAL USE at: [ 32.003451][ C0] __lock_acquire+0x797/0x1570 [ 32.003637][ C0] lock_acquire.part.0+0xeb/0x330 [ 32.003825][ C0] _raw_write_lock_bh+0x38/0x50 [ 32.004011][ C0] addrconf_permanent_addr+0x6e/0x670 [ 32.004212][ C0] addrconf_notify+0x749/0xd60 [ 32.004399][ C0] notifier_call_chain+0xcd/0x150 [ 32.004586][ C0] __dev_notify_flags+0xe6/0x250 [ 32.004772][ C0] dev_change_flags+0xec/0x160 [ 32.004959][ C0] do_setlink+0x7d6/0x21e0 [ 32.005144][ C0] __rtnl_newlink+0xaa7/0xd80 [ 32.005332][ C0] rtnl_newlink+0x63/0xa0 [ 32.005517][ C0] rtnetlink_rcv_msg+0x2fb/0xbf0 [ 32.005703][ C0] netlink_rcv_skb+0x130/0x360 [ 32.005890][ C0] netlink_unicast+0x449/0x710 [ 32.006077][ C0] netlink_sendmsg+0x723/0xbe0 [ 32.006264][ C0] ____sys_sendmsg+0x7b2/0xa10 [ 32.006451][ C0] ___sys_sendmsg+0xee/0x170 [ 32.006641][ C0] __sys_sendmsg+0xcd/0x170 [ 32.006826][ C0] do_syscall_64+0xc6/0x1e0 [ 32.007109][ C0] entry_SYSCALL_64_after_hwframe+0x6d/0x75 [ 32.007330][ C0] INITIAL READ USE at: [ 32.007442][ C0] __lock_acquire+0x797/0x1570 [ 32.007721][ C0] lock_acquire.part.0+0xeb/0x330 [ 32.007911][ C0] _raw_read_lock_bh+0x44/0x80 [ 32.008098][ C0] inet6_fill_ifla6_attrs+0x516/0x740 [ 32.008321][ C0] inet6_fill_link_af+0x5e/0xe0 [ 32.008606][ C0] rtnl_fill_ifinfo+0x1615/0x2a90 [ 32.008791][ C0] rtmsg_ifinfo_build_skb+0x13c/0x240 [ 32.009014][ C0] rtmsg_ifinfo_event.part.0+0x2d/0x120 [ 32.009332][ C0] rtmsg_ifinfo+0x5b/0xa0 [ 32.009518][ C0] register_netdevice+0x1177/0x1690 [ 32.009740][ C0] register_netdev+0x20/0x40 [ 32.010019][ C0] vti6_init_net+0x25d/0x380 [ 32.010211][ C0] ops_init+0x9b/0x560 [ 32.010394][ C0] register_pernet_operations+0x2db/0x710 [ 32.010711][ C0] register_pernet_device+0x2a/0x60 [ 32.010930][ C0] vti6_tunnel_init+0x18/0x110 [ 32.011120][ C0] do_one_initcall+0x8d/0x1e0 [ 32.011397][ C0] do_initcalls+0x1b2/0x3e0 [ 32.011581][ C0] kernel_init_freeable+0x232/0x310 [ 32.011800][ C0] kernel_init+0x20/0x200 [ 32.012080][ C0] ret_from_fork+0x31/0x70 [ 32.012268][ C0] ret_from_fork_asm+0x1a/0x30 [ 32.012451][ C0] } [ 32.012526][ C0] ... key at: [<ffffffff97356f00>] __key.37+0x0/0x40 [ 32.012844][ C0] ... acquired at: [ 32.012953][ C0] mark_lock+0x28d/0x3e0 [ 32.013100][ C0] mark_usage+0xd9/0x2a0 [ 32.013250][ C0] __lock_acquire+0x797/0x1570 [ 32.013399][ C0] lock_acquire.part.0+0xeb/0x330 [ 32.013637][ C0] _raw_write_lock+0x30/0x40 [ 32.013784][ C0] addrconf_rs_timer+0xa9/0x730 [ 32.013930][ C0] call_timer_fn+0x13b/0x230 [ 32.014077][ C0] __run_timers+0x545/0x810 [ 32.014315][ C0] timer_expire_remote+0x9b/0xe0 [ 32.014465][ C0] tmigr_handle_remote_cpu+0x270/0x430 [ 32.014611][ C0] tmigr_handle_remote_up+0x19f/0x2e0 [ 32.014760][ C0] tmigr_handle_remote+0x21d/0x3a0 [ 32.014997][ C0] __do_softirq+0x1f8/0x5df [ 32.015144][ C0] irq_exit_rcu+0x97/0xc0 [ 32.015289][ C0] sysvec_apic_timer_interrupt+0x75/0x80 [ 32.015474][ C0] asm_sysvec_apic_timer_interrupt+0x1a/0x20 [ 32.015746][ C0] default_idle+0xf/0x20 [ 32.015891][ C0] default_idle_call+0x6d/0xb0 [ 32.016037][ C0] cpuidle_idle_call+0x1f4/0x280 [ 32.016186][ C0] do_idle+0xf9/0x160 [ 32.016478][ C0] cpu_startup_entry+0x54/0x60 [ 32.016627][ C0] rest_init+0x14f/0x260 [ 32.016773][ C0] start_kernel+0x318/0x3d0 [ 32.016919][ C0] x86_64_start_reservations+0x18/0x30 [ 32.017066][ C0] x86_64_start_kernel+0xba/0x110 [ 32.017302][ C0] common_startup_64+0x12c/0x138 [ 32.017448][ C0] [ 32.017524][ C0] [ 32.017524][ C0] stack backtrace: [ 32.017705][ C0] CPU: 0 PID: 0 Comm: swapper/0 Not tainted 6.9.0-rc1-virtme #1 [ 32.018016][ C0] Hardware name: QEMU Standard PC (i440FX + PIIX, 1996), BIOS rel-1.16.3-0-ga6ed6b701f0a-prebuilt.qemu.org 04/01/2014 [ 32.018340][ C0] Call Trace: [ 32.018484][ C0] <IRQ> [ 32.018560][ C0] dump_stack_lvl+0x82/0xd0 [ 32.018713][ C0] print_irq_inversion_bug.part.0+0x3d9/0x570 [ 32.018897][ C0] ? kernel_text_address+0x17/0xe0 [ 32.019045][ C0] ? __pfx_print_irq_inversion_bug.part.0+0x10/0x10 [ 32.019318][ C0] ? __pfx_usage_skip+0x10/0x10 [ 32.019464][ C0] ? __pfx_usage_match+0x10/0x10 [ 32.019617][ C0] ? arch_stack_walk+0x8c/0xf0 [ 32.019765][ C0] mark_lock_irq+0x4cd/0xa10 [ 32.020002][ C0] ? common_startup_64+0x12c/0x138 [ 32.020149][ C0] ? __pfx_mark_lock_irq+0x10/0x10 [ 32.020299][ C0] ? __pfx_stack_trace_save+0x10/0x10 [ 32.020448][ C0] ? save_trace+0x8f/0x5b0 [ 32.020596][ C0] mark_lock+0x28d/0x3e0 [ 32.020801][ C0] ? __pfx_stack_trace_save+0x10/0x10 [ 32.020948][ C0] mark_usage+0xd9/0x2a0 [ 32.021060][ C0] __lock_acquire+0x797/0x1570 [ 32.021209][ C0] ? __pfx_validate_chain+0x10/0x10 [ 32.021447][ C0] ? __pfx_addrconf_rs_timer+0x10/0x10 [ 32.021596][ C0] lock_acquire.part.0+0xeb/0x330 [ 32.021745][ C0] ? addrconf_rs_timer+0xa9/0x730 [ 32.021891][ C0] ? __pfx_lock_acquire.part.0+0x10/0x10 [ 32.022038][ C0] ? trace_lock_acquire+0x135/0x1c0 [ 32.022275][ C0] ? addrconf_rs_timer+0xa9/0x730 [ 32.022430][ C0] ? lock_acquire+0x32/0xc0 [ 32.022577][ C0] ? addrconf_rs_timer+0xa9/0x730 [ 32.022722][ C0] _raw_write_lock+0x30/0x40 [ 32.022964][ C0] ? addrconf_rs_timer+0xa9/0x730 [ 32.023109][ C0] addrconf_rs_timer+0xa9/0x730 [ 32.023254][ C0] ? __pfx_lock_acquire.part.0+0x10/0x10 [ 32.023402][ C0] ? __pfx_addrconf_rs_timer+0x10/0x10 [ 32.023639][ C0] ? call_timer_fn+0xe8/0x230 [ 32.023785][ C0] ? lock_acquire+0x32/0xc0 [ 32.023933][ C0] ? call_timer_fn+0xe8/0x230 [ 32.024079][ C0] ? __pfx_addrconf_rs_timer+0x10/0x10 [ 32.024317][ C0] call_timer_fn+0x13b/0x230 [ 32.024463][ C0] ? call_timer_fn+0xe8/0x230 [ 32.024607][ C0] ? call_timer_fn+0xe8/0x230 [ 32.024753][ C0] ? __pfx_call_timer_fn+0x10/0x10 [ 32.024900][ C0] ? mark_lock+0x38/0x3e0 [ 32.025104][ C0] __run_timers+0x545/0x810 [ 32.025257][ C0] ? __pfx_addrconf_rs_timer+0x10/0x10 [ 32.025403][ C0] ? __pfx___run_timers+0x10/0x10 [ 32.025549][ C0] ? __lock_release+0x103/0x460 [ 32.025790][ C0] ? do_raw_spin_lock+0x131/0x270 [ 32.025936][ C0] ? __pfx_do_raw_spin_lock+0x10/0x10 [ 32.026084][ C0] ? lock_acquire+0x32/0xc0 [ 32.026229][ C0] ? timer_expire_remote+0x93/0xe0 [ 32.026467][ C0] timer_expire_remote+0x9b/0xe0 [ 32.026614][ C0] tmigr_handle_remote_cpu+0x270/0x430 [ 32.026760][ C0] ? __pfx_tmigr_handle_remote_cpu+0x10/0x10 [ 32.026944][ C0] tmigr_handle_remote_up+0x19f/0x2e0 [ 32.027189][ C0] tmigr_handle_remote+0x21d/0x3a0 [ 32.027334][ C0] ? __pfx_tmigr_handle_remote+0x10/0x10 [ 32.027483][ C0] __do_softirq+0x1f8/0x5df [ 32.027630][ C0] irq_exit_rcu+0x97/0xc0 [ 32.027741][ C0] sysvec_apic_timer_interrupt+0x75/0x80 [ 32.028067][ C0] </IRQ> [ 32.028143][ C0] <TASK> [ 32.028219][ C0] asm_sysvec_apic_timer_interrupt+0x1a/0x20 [ 32.028408][ C0] RIP: 0010:default_idle+0xf/0x20 [ 32.028563][ 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 d3 eb 32 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 [ 32.029175][ C0] RSP: 0018:ffffffff94607e00 EFLAGS: 00000242 [ 32.029463][ C0] RAX: 000000000009d83d RBX: 1ffffffff28c0fc2 RCX: ffffffff93732ea5 [ 32.029683][ C0] RDX: 0000000000000000 RSI: 0000000000000000 RDI: ffffffff90eac1d4 [ 32.029904][ C0] RBP: 0000000000000000 R08: 0000000000000001 R09: ffffed1006c0709c [ 32.030216][ C0] R10: ffff8880360384e3 R11: ffff88803602d9b0 R12: 0000000000000000 [ 32.030437][ C0] R13: ffffffff94631000 R14: dffffc0000000000 R15: 0000000000014770 [ 32.030657][ C0] ? ct_kernel_exit.constprop.0+0xc5/0xf0 [ 32.030893][ C0] ? cpuidle_idle_call+0x1f4/0x280 [ 32.031043][ C0] default_idle_call+0x6d/0xb0 [ 32.031188][ C0] cpuidle_idle_call+0x1f4/0x280 [ 32.031336][ C0] ? __pfx_cpuidle_idle_call+0x10/0x10 [ 32.031483][ C0] ? tsc_verify_tsc_adjust+0x5e/0x2b0 [ 32.031723][ C0] do_idle+0xf9/0x160 [ 32.031833][ C0] cpu_startup_entry+0x54/0x60 [ 32.031978][ C0] rest_init+0x14f/0x260 [ 32.032089][ C0] start_kernel+0x318/0x3d0 [ 32.032327][ C0] x86_64_start_reservations+0x18/0x30 [ 32.032475][ C0] x86_64_start_kernel+0xba/0x110 [ 32.032620][ C0] common_startup_64+0x12c/0x138 [ 32.032768][ C0] </TASK>