[ 22.952345][ T238] ip (238) used greatest stack depth: 23968 bytes left [ 27.335806][ T281] veth0: renamed from ioam-veth-alpha [ 27.473355][ T282] veth0: renamed from ioam-veth-betaL [ 27.593929][ T283] veth1: renamed from ioam-veth-betaR [ 27.719074][ T284] veth0: renamed from ioam-veth-gamma [ 34.336166][ C0] [ 34.336392][ C0] ======================================================== [ 34.336623][ C0] WARNING: possible irq lock inversion dependency detected [ 34.336847][ C0] 6.9.0-rc1-virtme #1 Not tainted [ 34.336996][ C0] -------------------------------------------------------- [ 34.337215][ C0] swapper/0/0 just changed the state of lock: [ 34.337417][ C0] ffff888006efd580 (&ndev->lock){++-.}-{2:2}, at: addrconf_rs_timer+0xa9/0x730 [ 34.337690][ C0] but this lock took another, SOFTIRQ-unsafe lock in the past: [ 34.337912][ C0] (&p->alloc_lock){+.+.}-{2:2} [ 34.337916][ C0] [ 34.337916][ C0] [ 34.337916][ C0] and interrupts could create inverse lock ordering between them. [ 34.337916][ C0] [ 34.338480][ C0] [ 34.338480][ C0] other info that might help us debug this: [ 34.338707][ C0] Possible interrupt unsafe locking scenario: [ 34.338707][ C0] [ 34.338928][ C0] CPU0 CPU1 [ 34.339085][ C0] ---- ---- [ 34.339233][ C0] lock(&p->alloc_lock); [ 34.339345][ C0] local_irq_disable(); [ 34.339528][ C0] lock(&ndev->lock); [ 34.339725][ C0] lock(&p->alloc_lock); [ 34.339907][ C0] [ 34.340021][ C0] lock(&ndev->lock); [ 34.340137][ C0] [ 34.340137][ C0] *** DEADLOCK *** [ 34.340137][ C0] [ 34.340358][ C0] 1 lock held by swapper/0/0: [ 34.340507][ C0] #0: ffffc90000007b68 ((&ndev->rs_timer)){+.-.}-{0:0}, at: call_timer_fn+0xe8/0x230 [ 34.340774][ C0] [ 34.340774][ C0] the shortest dependencies between 2nd lock and 1st lock: [ 34.341039][ C0] -> (&p->alloc_lock){+.+.}-{2:2} { [ 34.341196][ C0] HARDIRQ-ON-W at: [ 34.341311][ C0] __lock_acquire+0x797/0x1570 [ 34.341502][ C0] lock_acquire.part.0+0xeb/0x330 [ 34.341693][ C0] _raw_spin_lock+0x30/0x40 [ 34.341883][ C0] set_mems_allowed+0x1d/0x210 [ 34.342074][ C0] kernel_init_freeable+0x72/0x310 [ 34.342262][ C0] kernel_init+0x20/0x200 [ 34.342451][ C0] ret_from_fork+0x31/0x70 [ 34.342653][ C0] ret_from_fork_asm+0x1a/0x30 [ 34.342841][ C0] SOFTIRQ-ON-W at: [ 34.342957][ C0] __lock_acquire+0x797/0x1570 [ 34.343148][ C0] lock_acquire.part.0+0xeb/0x330 [ 34.343334][ C0] _raw_spin_lock+0x30/0x40 [ 34.343522][ C0] set_mems_allowed+0x1d/0x210 [ 34.343714][ C0] kernel_init_freeable+0x72/0x310 [ 34.343902][ C0] kernel_init+0x20/0x200 [ 34.344092][ C0] ret_from_fork+0x31/0x70 [ 34.344287][ C0] ret_from_fork_asm+0x1a/0x30 [ 34.344477][ C0] INITIAL USE at: [ 34.344590][ C0] __lock_acquire+0x797/0x1570 [ 34.344778][ C0] lock_acquire.part.0+0xeb/0x330 [ 34.344967][ C0] _raw_spin_lock+0x30/0x40 [ 34.345152][ C0] set_mems_allowed+0x1d/0x210 [ 34.345352][ C0] kernel_init_freeable+0x72/0x310 [ 34.345545][ C0] kernel_init+0x20/0x200 [ 34.345735][ C0] ret_from_fork+0x31/0x70 [ 34.345922][ C0] ret_from_fork_asm+0x1a/0x30 [ 34.346119][ C0] } [ 34.346199][ C0] ... key at: [] __key.388+0x0/0x40 [ 34.346424][ C0] ... acquired at: [ 34.346538][ C0] __lock_acquire+0xaf0/0x1570 [ 34.346693][ C0] lock_acquire.part.0+0xeb/0x330 [ 34.346845][ C0] _raw_spin_lock+0x30/0x40 [ 34.346998][ C0] __get_task_comm+0x27/0x70 [ 34.347153][ C0] ref_tracker_alloc+0x2ee/0x490 [ 34.347307][ C0] netdev_get_by_index+0x5e/0x80 [ 34.347456][ C0] fib6_nh_init+0x3d8/0x1580 [ 34.347612][ C0] ip6_route_info_create+0xf18/0x17d0 [ 34.347764][ C0] addrconf_f6i_alloc+0x315/0x560 [ 34.347914][ C0] addrconf_permanent_addr+0x1ed/0x670 [ 34.348067][ C0] addrconf_notify+0x749/0xd60 [ 34.348220][ C0] notifier_call_chain+0xcd/0x150 [ 34.348374][ C0] __dev_notify_flags+0xe6/0x250 [ 34.348524][ C0] dev_change_flags+0xec/0x160 [ 34.348673][ C0] do_setlink+0x7d6/0x21e0 [ 34.348827][ C0] __rtnl_newlink+0xaa7/0xd80 [ 34.348982][ C0] rtnl_newlink+0x63/0xa0 [ 34.349134][ C0] rtnetlink_rcv_msg+0x2fb/0xbf0 [ 34.349284][ C0] netlink_rcv_skb+0x130/0x360 [ 34.349438][ C0] netlink_unicast+0x449/0x710 [ 34.349587][ C0] netlink_sendmsg+0x723/0xbe0 [ 34.349735][ C0] ____sys_sendmsg+0x7b2/0xa10 [ 34.349885][ C0] ___sys_sendmsg+0xee/0x170 [ 34.350033][ C0] __sys_sendmsg+0xcd/0x170 [ 34.350185][ C0] do_syscall_64+0xc6/0x1e0 [ 34.350341][ C0] entry_SYSCALL_64_after_hwframe+0x6d/0x75 [ 34.350530][ C0] [ 34.350608][ C0] -> (&ndev->lock){++-.}-{2:2} { [ 34.350765][ C0] HARDIRQ-ON-W at: [ 34.350878][ C0] __lock_acquire+0x797/0x1570 [ 34.351070][ C0] lock_acquire.part.0+0xeb/0x330 [ 34.351259][ C0] _raw_write_lock_bh+0x38/0x50 [ 34.351452][ C0] addrconf_permanent_addr+0x6e/0x670 [ 34.351645][ C0] addrconf_notify+0x749/0xd60 [ 34.351832][ C0] notifier_call_chain+0xcd/0x150 [ 34.352022][ C0] __dev_notify_flags+0xe6/0x250 [ 34.352209][ C0] dev_change_flags+0xec/0x160 [ 34.352395][ C0] do_setlink+0x7d6/0x21e0 [ 34.352582][ C0] __rtnl_newlink+0xaa7/0xd80 [ 34.352776][ C0] rtnl_newlink+0x63/0xa0 [ 34.352969][ C0] rtnetlink_rcv_msg+0x2fb/0xbf0 [ 34.353156][ C0] netlink_rcv_skb+0x130/0x360 [ 34.353346][ C0] netlink_unicast+0x449/0x710 [ 34.353535][ C0] netlink_sendmsg+0x723/0xbe0 [ 34.353724][ C0] ____sys_sendmsg+0x7b2/0xa10 [ 34.353911][ C0] ___sys_sendmsg+0xee/0x170 [ 34.354107][ C0] __sys_sendmsg+0xcd/0x170 [ 34.354298][ C0] do_syscall_64+0xc6/0x1e0 [ 34.354493][ C0] entry_SYSCALL_64_after_hwframe+0x6d/0x75 [ 34.354721][ C0] HARDIRQ-ON-R at: [ 34.354836][ C0] __lock_acquire+0x797/0x1570 [ 34.355025][ C0] lock_acquire.part.0+0xeb/0x330 [ 34.355211][ C0] _raw_read_lock_bh+0x44/0x80 [ 34.355405][ C0] inet6_fill_ifla6_attrs+0x516/0x740 [ 34.355593][ C0] inet6_fill_link_af+0x5e/0xe0 [ 34.355780][ C0] rtnl_fill_ifinfo+0x1615/0x2a90 [ 34.355976][ C0] rtmsg_ifinfo_build_skb+0x13c/0x240 [ 34.356164][ C0] rtmsg_ifinfo_event.part.0+0x2d/0x120 [ 34.356394][ C0] rtmsg_ifinfo+0x5b/0xa0 [ 34.356585][ C0] register_netdevice+0x1177/0x1690 [ 34.356774][ C0] register_netdev+0x20/0x40 [ 34.356962][ C0] vti6_init_net+0x25d/0x380 [ 34.357149][ C0] ops_init+0x9b/0x560 [ 34.357301][ C0] register_pernet_operations+0x2db/0x710 [ 34.357525][ C0] register_pernet_device+0x2a/0x60 [ 34.357714][ C0] vti6_tunnel_init+0x18/0x110 [ 34.357905][ C0] do_one_initcall+0x8d/0x1e0 [ 34.358093][ C0] do_initcalls+0x1b2/0x3e0 [ 34.358279][ C0] kernel_init_freeable+0x232/0x310 [ 34.358471][ C0] kernel_init+0x20/0x200 [ 34.358661][ C0] ret_from_fork+0x31/0x70 [ 34.358855][ C0] ret_from_fork_asm+0x1a/0x30 [ 34.359040][ C0] IN-SOFTIRQ-W at: [ 34.359155][ C0] __lock_acquire+0x797/0x1570 [ 34.359343][ C0] lock_acquire.part.0+0xeb/0x330 [ 34.359530][ C0] _raw_write_lock+0x30/0x40 [ 34.359715][ C0] addrconf_rs_timer+0xa9/0x730 [ 34.359905][ C0] call_timer_fn+0x13b/0x230 [ 34.360097][ C0] __run_timers+0x545/0x810 [ 34.360284][ C0] timer_expire_remote+0x9b/0xe0 [ 34.360473][ C0] tmigr_handle_remote_cpu+0x270/0x430 [ 34.360663][ C0] tmigr_handle_remote_up+0x19f/0x2e0 [ 34.360850][ C0] tmigr_handle_remote+0x21d/0x3a0 [ 34.361037][ C0] __do_softirq+0x1f8/0x5df [ 34.361227][ C0] irq_exit_rcu+0x97/0xc0 [ 34.361414][ C0] sysvec_apic_timer_interrupt+0x75/0x80 [ 34.361638][ C0] asm_sysvec_apic_timer_interrupt+0x1a/0x20 [ 34.361863][ C0] default_idle+0xf/0x20 [ 34.362050][ C0] default_idle_call+0x6d/0xb0 [ 34.362237][ C0] cpuidle_idle_call+0x1f4/0x280 [ 34.362429][ C0] do_idle+0xf9/0x160 [ 34.362578][ C0] cpu_startup_entry+0x54/0x60 [ 34.362763][ C0] rest_init+0x14f/0x260 [ 34.362952][ C0] start_kernel+0x318/0x3d0 [ 34.363138][ C0] x86_64_start_reservations+0x18/0x30 [ 34.363323][ C0] x86_64_start_kernel+0xba/0x110 [ 34.363508][ C0] common_startup_64+0x12c/0x138 [ 34.363700][ C0] INITIAL USE at: [ 34.363812][ C0] __lock_acquire+0x797/0x1570 [ 34.364002][ C0] lock_acquire.part.0+0xeb/0x330 [ 34.364190][ C0] _raw_write_lock_bh+0x38/0x50 [ 34.364388][ C0] addrconf_permanent_addr+0x6e/0x670 [ 34.364576][ C0] addrconf_notify+0x749/0xd60 [ 34.364765][ C0] notifier_call_chain+0xcd/0x150 [ 34.364955][ C0] __dev_notify_flags+0xe6/0x250 [ 34.365145][ C0] dev_change_flags+0xec/0x160 [ 34.365331][ C0] do_setlink+0x7d6/0x21e0 [ 34.365518][ C0] __rtnl_newlink+0xaa7/0xd80 [ 34.365707][ C0] rtnl_newlink+0x63/0xa0 [ 34.365895][ C0] rtnetlink_rcv_msg+0x2fb/0xbf0 [ 34.366091][ C0] netlink_rcv_skb+0x130/0x360 [ 34.366282][ C0] netlink_unicast+0x449/0x710 [ 34.366474][ C0] netlink_sendmsg+0x723/0xbe0 [ 34.366663][ C0] ____sys_sendmsg+0x7b2/0xa10 [ 34.366857][ C0] ___sys_sendmsg+0xee/0x170 [ 34.367047][ C0] __sys_sendmsg+0xcd/0x170 [ 34.367235][ C0] do_syscall_64+0xc6/0x1e0 [ 34.367429][ C0] entry_SYSCALL_64_after_hwframe+0x6d/0x75 [ 34.367755][ C0] INITIAL READ USE at: [ 34.367868][ C0] __lock_acquire+0x797/0x1570 [ 34.368056][ C0] lock_acquire.part.0+0xeb/0x330 [ 34.368339][ C0] _raw_read_lock_bh+0x44/0x80 [ 34.368540][ C0] inet6_fill_ifla6_attrs+0x516/0x740 [ 34.368769][ C0] inet6_fill_link_af+0x5e/0xe0 [ 34.368957][ C0] rtnl_fill_ifinfo+0x1615/0x2a90 [ 34.369236][ C0] rtmsg_ifinfo_build_skb+0x13c/0x240 [ 34.369460][ C0] rtmsg_ifinfo_event.part.0+0x2d/0x120 [ 34.369684][ C0] rtmsg_ifinfo+0x5b/0xa0 [ 34.369962][ C0] register_netdevice+0x1177/0x1690 [ 34.370191][ C0] register_netdev+0x20/0x40 [ 34.370380][ C0] vti6_init_net+0x25d/0x380 [ 34.370778][ C0] ops_init+0x9b/0x560 [ 34.370965][ C0] register_pernet_operations+0x2db/0x710 [ 34.371189][ C0] register_pernet_device+0x2a/0x60 [ 34.371505][ C0] vti6_tunnel_init+0x18/0x110 [ 34.371692][ C0] do_one_initcall+0x8d/0x1e0 [ 34.371881][ C0] do_initcalls+0x1b2/0x3e0 [ 34.372162][ C0] kernel_init_freeable+0x232/0x310 [ 34.372393][ C0] kernel_init+0x20/0x200 [ 34.372590][ C0] ret_from_fork+0x31/0x70 [ 34.372872][ C0] ret_from_fork_asm+0x1a/0x30 [ 34.373060][ C0] } [ 34.373136][ C0] ... key at: [] __key.37+0x0/0x40 [ 34.373360][ C0] ... acquired at: [ 34.373471][ C0] mark_lock+0x28d/0x3e0 [ 34.373713][ C0] mark_usage+0xd9/0x2a0 [ 34.373870][ C0] __lock_acquire+0x797/0x1570 [ 34.374022][ C0] lock_acquire.part.0+0xeb/0x330 [ 34.374177][ C0] _raw_write_lock+0x30/0x40 [ 34.374420][ C0] addrconf_rs_timer+0xa9/0x730 [ 34.374568][ C0] call_timer_fn+0x13b/0x230 [ 34.374720][ C0] __run_timers+0x545/0x810 [ 34.374872][ C0] timer_expire_remote+0x9b/0xe0 [ 34.375116][ C0] tmigr_handle_remote_cpu+0x270/0x430 [ 34.375269][ C0] tmigr_handle_remote_up+0x19f/0x2e0 [ 34.375417][ C0] tmigr_handle_remote+0x21d/0x3a0 [ 34.375569][ C0] __do_softirq+0x1f8/0x5df [ 34.375816][ C0] irq_exit_rcu+0x97/0xc0 [ 34.375972][ C0] sysvec_apic_timer_interrupt+0x75/0x80 [ 34.376171][ C0] asm_sysvec_apic_timer_interrupt+0x1a/0x20 [ 34.376354][ C0] default_idle+0xf/0x20 [ 34.376593][ C0] default_idle_call+0x6d/0xb0 [ 34.376742][ C0] cpuidle_idle_call+0x1f4/0x280 [ 34.376892][ C0] do_idle+0xf9/0x160 [ 34.377005][ C0] cpu_startup_entry+0x54/0x60 [ 34.377157][ C0] rest_init+0x14f/0x260 [ 34.377404][ C0] start_kernel+0x318/0x3d0 [ 34.377553][ C0] x86_64_start_reservations+0x18/0x30 [ 34.377706][ C0] x86_64_start_kernel+0xba/0x110 [ 34.377857][ C0] common_startup_64+0x12c/0x138 [ 34.378009][ C0] [ 34.378085][ C0] [ 34.378085][ C0] stack backtrace: [ 34.378271][ C0] CPU: 0 PID: 0 Comm: swapper/0 Not tainted 6.9.0-rc1-virtme #1 [ 34.378501][ C0] Hardware name: QEMU Standard PC (i440FX + PIIX, 1996), BIOS rel-1.16.3-0-ga6ed6b701f0a-prebuilt.qemu.org 04/01/2014 [ 34.378919][ C0] Call Trace: [ 34.379036][ C0] [ 34.379112][ C0] dump_stack_lvl+0x82/0xd0 [ 34.379265][ C0] print_irq_inversion_bug.part.0+0x3d9/0x570 [ 34.379540][ C0] ? kernel_text_address+0x17/0xe0 [ 34.379690][ C0] ? __pfx_print_irq_inversion_bug.part.0+0x10/0x10 [ 34.379883][ C0] ? __pfx_usage_skip+0x10/0x10 [ 34.380120][ C0] ? __pfx_usage_match+0x10/0x10 [ 34.380267][ C0] ? arch_stack_walk+0x8c/0xf0 [ 34.380417][ C0] mark_lock_irq+0x4cd/0xa10 [ 34.380563][ C0] ? common_startup_64+0x12c/0x138 [ 34.380710][ C0] ? __pfx_mark_lock_irq+0x10/0x10 [ 34.380947][ C0] ? __pfx_stack_trace_save+0x10/0x10 [ 34.381099][ C0] ? save_trace+0x8f/0x5b0 [ 34.381246][ C0] mark_lock+0x28d/0x3e0 [ 34.381358][ C0] ? __pfx_stack_trace_save+0x10/0x10 [ 34.381598][ C0] mark_usage+0xd9/0x2a0 [ 34.381710][ C0] __lock_acquire+0x797/0x1570 [ 34.381858][ C0] ? __pfx_validate_chain+0x10/0x10 [ 34.382006][ C0] ? __pfx_addrconf_rs_timer+0x10/0x10 [ 34.382151][ C0] lock_acquire.part.0+0xeb/0x330 [ 34.382480][ C0] ? addrconf_rs_timer+0xa9/0x730 [ 34.382641][ C0] ? __pfx_lock_acquire.part.0+0x10/0x10 [ 34.382787][ C0] ? trace_lock_acquire+0x135/0x1c0 [ 34.382934][ C0] ? addrconf_rs_timer+0xa9/0x730 [ 34.383172][ C0] ? lock_acquire+0x32/0xc0 [ 34.383319][ C0] ? addrconf_rs_timer+0xa9/0x730 [ 34.383468][ C0] _raw_write_lock+0x30/0x40 [ 34.383617][ C0] ? addrconf_rs_timer+0xa9/0x730 [ 34.383855][ C0] addrconf_rs_timer+0xa9/0x730 [ 34.384005][ C0] ? __pfx_lock_acquire.part.0+0x10/0x10 [ 34.384153][ C0] ? __pfx_addrconf_rs_timer+0x10/0x10 [ 34.384299][ C0] ? call_timer_fn+0xe8/0x230 [ 34.384535][ C0] ? lock_acquire+0x32/0xc0 [ 34.384681][ C0] ? call_timer_fn+0xe8/0x230 [ 34.384831][ C0] ? __pfx_addrconf_rs_timer+0x10/0x10 [ 34.384976][ C0] call_timer_fn+0x13b/0x230 [ 34.385122][ C0] ? call_timer_fn+0xe8/0x230 [ 34.385360][ C0] ? call_timer_fn+0xe8/0x230 [ 34.385508][ C0] ? __pfx_call_timer_fn+0x10/0x10 [ 34.385653][ C0] ? mark_lock+0x38/0x3e0 [ 34.385770][ C0] __run_timers+0x545/0x810 [ 34.386012][ C0] ? __pfx_addrconf_rs_timer+0x10/0x10 [ 34.386160][ C0] ? __pfx___run_timers+0x10/0x10 [ 34.386306][ C0] ? __lock_release+0x103/0x460 [ 34.386454][ C0] ? do_raw_spin_lock+0x131/0x270 [ 34.386693][ C0] ? __pfx_do_raw_spin_lock+0x10/0x10 [ 34.386845][ C0] ? lock_acquire+0x32/0xc0 [ 34.386991][ C0] ? timer_expire_remote+0x93/0xe0 [ 34.387140][ C0] timer_expire_remote+0x9b/0xe0 [ 34.387287][ C0] tmigr_handle_remote_cpu+0x270/0x430 [ 34.387524][ C0] ? __pfx_tmigr_handle_remote_cpu+0x10/0x10 [ 34.387708][ C0] tmigr_handle_remote_up+0x19f/0x2e0 [ 34.387858][ C0] tmigr_handle_remote+0x21d/0x3a0 [ 34.388004][ C0] ? do_raw_spin_lock+0x131/0x270 [ 34.388244][ C0] ? __pfx_tmigr_handle_remote+0x10/0x10 [ 34.388390][ C0] ? __pfx_do_raw_spin_lock+0x10/0x10 [ 34.388537][ C0] ? lockdep_hardirqs_on_prepare.part.0+0x14f/0x370 [ 34.388721][ C0] __do_softirq+0x1f8/0x5df [ 34.388970][ C0] irq_exit_rcu+0x97/0xc0 [ 34.389080][ C0] sysvec_apic_timer_interrupt+0x75/0x80 [ 34.389228][ C0] [ 34.389303][ C0] [ 34.389380][ C0] asm_sysvec_apic_timer_interrupt+0x1a/0x20 [ 34.389655][ C0] RIP: 0010:default_idle+0xf/0x20 [ 34.389808][ 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 c3 cc cc cc cc 66 66 2e 0f 1f 84 00 00 00 00 00 90 90 90 90 90 [ 34.390425][ C0] RSP: 0018:ffffffff97e07e00 EFLAGS: 00000242 [ 34.390614][ C0] RAX: 0000000000092479 RBX: 1ffffffff2fc0fc2 RCX: ffffffff96f32ea5 [ 34.390837][ C0] RDX: 0000000000000000 RSI: 0000000000000000 RDI: ffffffff946ac1d4 [ 34.391158][ C0] RBP: 0000000000000000 R08: 0000000000000001 R09: ffffed1005ec709c [ 34.391377][ C0] R10: ffff88802f6384e3 R11: ffff88802f62d9b0 R12: 0000000000000000 [ 34.391597][ C0] R13: ffffffff97e31000 R14: dffffc0000000000 R15: 0000000000014770 [ 34.391912][ C0] ? ct_kernel_exit.constprop.0+0xc5/0xf0 [ 34.392060][ C0] ? cpuidle_idle_call+0x1f4/0x280 [ 34.392209][ C0] default_idle_call+0x6d/0xb0 [ 34.392355][ C0] cpuidle_idle_call+0x1f4/0x280 [ 34.392592][ C0] ? __pfx_cpuidle_idle_call+0x10/0x10 [ 34.392740][ C0] ? tsc_verify_tsc_adjust+0x5e/0x2b0 [ 34.392888][ C0] do_idle+0xf9/0x160 [ 34.392999][ C0] cpu_startup_entry+0x54/0x60 [ 34.393245][ C0] rest_init+0x14f/0x260 [ 34.393356][ C0] start_kernel+0x318/0x3d0 [ 34.393503][ C0] x86_64_start_reservations+0x18/0x30 [ 34.393649][ C0] x86_64_start_kernel+0xba/0x110 [ 34.393798][ C0] common_startup_64+0x12c/0x138 [ 34.394131][ C0]