[ 25.279741][ T233] [ 25.279840][ T233] ===================================== [ 25.280010][ T233] WARNING: bad unlock balance detected! [ 25.280160][ T233] 6.12.0-rc5-virtme #1 Not tainted [ 25.280309][ T233] ------------------------------------- [ 25.280469][ T233] restore_ipv4/233 is trying to release lock (rtnl_mutex) at: [ 25.280699][ T233] [] __rtnl_unlock+0x69/0xf0 [ 25.280894][ T233] but there are no more locks to release! [ 25.281049][ T233] [ 25.281049][ T233] other info that might help us debug this: [ 25.281282][ T233] no locks held by restore_ipv4/233. [ 25.281427][ T233] [ 25.281427][ T233] stack backtrace: [ 25.281615][ T233] CPU: 0 UID: 0 PID: 233 Comm: restore_ipv4 Not tainted 6.12.0-rc5-virtme #1 [ 25.281890][ T233] Hardware name: QEMU Standard PC (i440FX + PIIX, 1996), BIOS rel-1.16.3-0-ga6ed6b701f0a-prebuilt.qemu.org 04/01/2014 [ 25.282216][ T233] Call Trace: [ 25.282333][ T233] [ 25.282406][ T233] dump_stack_lvl+0x82/0xd0 [ 25.282551][ T233] ? __rtnl_unlock+0x69/0xf0 [ 25.282714][ T233] print_unlock_imbalance_bug+0x1aa/0x1f0 [ 25.282867][ T233] __lock_release+0x2f7/0x460 [ 25.283014][ T233] ? __pfx___lock_release+0x10/0x10 [ 25.283178][ T233] ? __rtnl_unlock+0x69/0xf0 [ 25.283325][ T233] lock_release+0xd7/0x140 [ 25.283480][ T233] __mutex_unlock_slowpath+0x8f/0x3b0 [ 25.283620][ T233] ? __pfx_lock_acquire.part.0+0x10/0x10 [ 25.283764][ T233] ? __pfx___mutex_unlock_slowpath+0x10/0x10 [ 25.283940][ T233] ? rtnl_link_ops_get+0x187/0x220 [ 25.284104][ T233] __rtnl_unlock+0x69/0xf0 [ 25.284244][ T233] rtnl_newlink+0x7fd/0xa30 [ 25.284403][ T233] ? __pfx_rtnl_newlink+0x10/0x10 [ 25.284542][ T233] ? find_held_lock+0x2c/0x110 [ 25.284689][ T233] ? __lock_release+0x103/0x460 [ 25.284842][ T233] ? rtnetlink_rcv_msg+0x6ef/0xc10 [ 25.284982][ T233] ? __pfx___lock_release+0x10/0x10 [ 25.285131][ T233] ? rtnetlink_rcv_msg+0x6ef/0xc10 [ 25.285272][ T233] ? __pfx_rtnl_newlink+0x10/0x10 [ 25.285409][ T233] rtnetlink_rcv_msg+0x712/0xc10 [ 25.285557][ T233] ? __pfx_rtnetlink_rcv_msg+0x10/0x10 [ 25.285703][ T233] ? hlock_class+0x4e/0x130 [ 25.285845][ T233] ? mark_lock+0x38/0x3e0 [ 25.285966][ T233] ? __lock_acquire+0xb3f/0x1580 [ 25.286130][ T233] netlink_rcv_skb+0x130/0x360 [ 25.286271][ T233] ? __pfx_rtnetlink_rcv_msg+0x10/0x10 [ 25.286430][ T233] ? __pfx_netlink_rcv_skb+0x10/0x10 [ 25.286575][ T233] ? netlink_deliver_tap+0x13e/0x340 [ 25.286725][ T233] ? netlink_deliver_tap+0xc3/0x340 [ 25.286870][ T233] netlink_unicast+0x44b/0x710 [ 25.287016][ T233] ? __pfx_netlink_unicast+0x10/0x10 [ 25.287156][ T233] ? netlink_autobind.isra.0+0xa5/0x270 [ 25.287305][ T233] ? netlink_autobind.isra.0+0x18a/0x270 [ 25.287456][ T233] netlink_sendmsg+0x723/0xbe0 [ 25.287598][ T233] ? __pfx_netlink_sendmsg+0x10/0x10 [ 25.287764][ T233] ? fdget+0x52/0x1e0 [ 25.287876][ T233] __sys_sendto+0x377/0x400 [ 25.288031][ T233] ? __pfx___sys_sendto+0x10/0x10 [ 25.288169][ T233] ? find_held_lock+0x2c/0x110 [ 25.288326][ T233] ? __might_fault+0xc3/0x170 [ 25.288470][ T233] ? lock_acquire+0x32/0xc0 [ 25.288619][ T233] ? trace_rseq_update+0xe2/0x140 [ 25.288770][ T233] ? rseq_update_cpu_node_id+0xe6/0x140 [ 25.288913][ T233] ? __rseq_handle_notify_resume+0x288/0x3e0 [ 25.289114][ T233] ? do_user_addr_fault+0x374/0xe30 [ 25.289258][ T233] ? __pfx___rseq_handle_notify_resume+0x10/0x10 [ 25.289455][ T233] __x64_sys_sendto+0xe0/0x1c0 [ 25.289604][ T233] ? lockdep_hardirqs_on_prepare+0x275/0x410 [ 25.289777][ T233] do_syscall_64+0xc1/0x1d0 [ 25.289924][ T233] entry_SYSCALL_64_after_hwframe+0x77/0x7f [ 25.290110][ T233] RIP: 0033:0x7fcf3308c700 [ 25.290265][ T233] Code: ff ff 64 89 02 eb bd 0f 1f 00 f3 0f 1e fa 41 89 ca 64 8b 04 25 18 00 00 00 85 c0 75 1d 45 31 c9 45 31 c0 b8 2c 00 00 00 0f 05 <48> 3d 00 f0 ff ff 77 68 c3 0f 1f 80 00 00 00 00 41 54 48 83 ec 20 [ 25.290781][ T233] RSP: 002b:00007fff53ccd5a8 EFLAGS: 00000246 ORIG_RAX: 000000000000002c [ 25.291004][ T233] RAX: ffffffffffffffda RBX: 00007fff53ccd628 RCX: 00007fcf3308c700 [ 25.291222][ T233] RDX: 0000000000000078 RSI: 00007fff53ccd5f0 RDI: 0000000000000008 [ 25.291443][ T233] RBP: 00007fff53ccd5f0 R08: 0000000000000000 R09: 0000000000000000 [ 25.291664][ T233] R10: 0000000000000000 R11: 0000000000000246 R12: 000000000040edf8 [ 25.291882][ T233] R13: 0000000000000048 R14: 000000000000004c R15: 0000000000000008 [ 25.292102][ T233] [ 247.089510][ T43] INFO: task restore_ipv4:233 blocked for more than 122 seconds. [ 247.090332][ T43] Not tainted 6.12.0-rc5-virtme #1 [ 247.090471][ T43] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. [ 247.090673][ T43] task:restore_ipv4 state:D stack:25712 pid:233 tgid:233 ppid:232 flags:0x00004002 [ 247.090941][ T43] Call Trace: [ 247.091038][ T43] [ 247.091107][ T43] __schedule+0xa19/0x1dc0 [ 247.091271][ T43] ? __pfx___schedule+0x10/0x10 [ 247.091407][ T43] ? trace_lock_acquire+0x14d/0x1f0 [ 247.091540][ T43] ? trace_lock_release+0x10e/0x180 [ 247.091670][ T43] schedule+0xdf/0x210 [ 247.091759][ T43] schedule_preempt_disabled+0x15/0x30 [ 247.091877][ T43] __mutex_lock+0x634/0xac0 [ 247.091998][ T43] ? rtnl_newlink+0x64b/0xa30 [ 247.092125][ T43] ? __pfx___mutex_lock+0x10/0x10 [ 247.092260][ T43] ? trace_lock_acquire+0x14d/0x1f0 [ 247.092382][ T43] ? rtnl_newlink+0x64b/0xa30 [ 247.092499][ T43] rtnl_newlink+0x64b/0xa30 [ 247.092640][ T43] ? __pfx_rtnl_newlink+0x10/0x10 [ 247.092759][ T43] ? find_held_lock+0x2c/0x110 [ 247.092876][ T43] ? __pfx___lock_release+0x10/0x10 [ 247.093017][ T43] ? rtnetlink_rcv_msg+0x6ef/0xc10 [ 247.093177][ T43] ? __pfx_rtnl_newlink+0x10/0x10 [ 247.093303][ T43] rtnetlink_rcv_msg+0x712/0xc10 [ 247.093437][ T43] ? __pfx_rtnetlink_rcv_msg+0x10/0x10 [ 247.093560][ T43] ? hlock_class+0x4e/0x130 [ 247.093701][ T43] ? mark_lock+0x38/0x3e0 [ 247.093797][ T43] ? __lock_acquire+0xb3f/0x1580 [ 247.093922][ T43] netlink_rcv_skb+0x130/0x360 [ 247.094048][ T43] ? __pfx_rtnetlink_rcv_msg+0x10/0x10 [ 247.094191][ T43] ? __pfx_netlink_rcv_skb+0x10/0x10 [ 247.094329][ T43] ? netlink_deliver_tap+0x13e/0x340 [ 247.094450][ T43] ? netlink_deliver_tap+0xc3/0x340 [ 247.094566][ T43] netlink_unicast+0x44b/0x710 [ 247.094688][ T43] ? __pfx_netlink_unicast+0x10/0x10 [ 247.094805][ T43] ? netlink_autobind.isra.0+0xa5/0x270 [ 247.094920][ T43] ? netlink_autobind.isra.0+0x18a/0x270 [ 247.095062][ T43] netlink_sendmsg+0x723/0xbe0 [ 247.095191][ T43] ? __pfx_netlink_sendmsg+0x10/0x10 [ 247.095333][ T43] ? fdget+0x52/0x1e0 [ 247.095431][ T43] __sys_sendto+0x377/0x400 [ 247.095565][ T43] ? __pfx___sys_sendto+0x10/0x10 [ 247.095698][ T43] ? find_held_lock+0x2c/0x110 [ 247.095827][ T43] ? __might_fault+0xc3/0x170 [ 247.095964][ T43] ? lock_acquire+0x32/0xc0 [ 247.096097][ T43] ? trace_rseq_update+0xe2/0x140 [ 247.096222][ T43] ? rseq_update_cpu_node_id+0xe6/0x140 [ 247.096342][ T43] ? __rseq_handle_notify_resume+0x288/0x3e0 [ 247.096486][ T43] ? do_user_addr_fault+0x374/0xe30 [ 247.096612][ T43] ? __pfx___rseq_handle_notify_resume+0x10/0x10 [ 247.096763][ T43] __x64_sys_sendto+0xe0/0x1c0 [ 247.096880][ T43] ? lockdep_hardirqs_on_prepare+0x275/0x410 [ 247.097035][ T43] do_syscall_64+0xc1/0x1d0 [ 247.097161][ T43] entry_SYSCALL_64_after_hwframe+0x77/0x7f [ 247.097321][ T43] RIP: 0033:0x7fcf3308c700 [ 247.097444][ T43] RSP: 002b:00007fff53ccd5a8 EFLAGS: 00000246 ORIG_RAX: 000000000000002c [ 247.097621][ T43] RAX: ffffffffffffffda RBX: 00007fff53ccd628 RCX: 00007fcf3308c700 [ 247.097803][ T43] RDX: 0000000000000078 RSI: 00007fff53ccd5f0 RDI: 0000000000000008 [ 247.097974][ T43] RBP: 00007fff53ccd5f0 R08: 0000000000000000 R09: 0000000000000000 [ 247.098148][ T43] R10: 0000000000000000 R11: 0000000000000246 R12: 000000000040edf8 [ 247.098340][ T43] R13: 0000000000000048 R14: 000000000000004c R15: 0000000000000008 [ 247.098520][ T43] [ 247.098613][ T43] INFO: lockdep is turned off. HARD STOP (343.010699) WAIT TIMEOUT stderr Ctrl-C stderr Ctrl-C stderr [ 369.969378][ T43] INFO: task kworker/u16:0:11 blocked for more than 122 seconds. [ 369.970025][ T43] Not tainted 6.12.0-rc5-virtme #1 [ 369.970142][ T43] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. [ 369.970362][ T43] task:kworker/u16:0 state:D stack:29080 pid:11 tgid:11 ppid:2 flags:0x00004000 [ 369.970635][ T43] Workqueue: ipv6_addrconf addrconf_verify_work [ 369.970809][ T43] Call Trace: [ 369.970903][ T43] [ 369.970971][ T43] __schedule+0xa19/0x1dc0 [ 369.971111][ T43] ? __pfx___schedule+0x10/0x10 [ 369.971241][ T43] ? __lock_release+0x103/0x460 [ 369.971363][ T43] ? trace_lock_acquire+0x14d/0x1f0 [ 369.971483][ T43] ? trace_lock_release+0x10e/0x180 [ 369.971599][ T43] schedule+0xdf/0x210 [ 369.971691][ T43] schedule_preempt_disabled+0x15/0x30 [ 369.971812][ T43] __mutex_lock+0x634/0xac0 [ 369.971928][ T43] ? do_raw_spin_unlock+0x58/0x220 [ 369.972044][ T43] ? addrconf_verify_work+0x12/0x30 [ 369.972158][ T43] ? __pfx___mutex_lock+0x10/0x10 [ 369.972283][ T43] ? trace_lock_acquire+0x14d/0x1f0 [ 369.972397][ T43] ? trace_lock_acquire+0x14d/0x1f0 [ 369.972512][ T43] ? addrconf_verify_work+0x12/0x30 [ 369.972630][ T43] addrconf_verify_work+0x12/0x30 [ 369.972750][ T43] process_one_work+0xe55/0x16d0 [ 369.972869][ T43] ? __pfx___lock_release+0x10/0x10 [ 369.972982][ T43] ? __pfx_process_one_work+0x10/0x10 [ 369.973095][ T43] ? assign_work+0x16c/0x240 [ 369.973218][ T43] worker_thread+0x58c/0xce0 [ 369.973335][ T43] ? __pfx_worker_thread+0x10/0x10 [ 369.973449][ T43] kthread+0x28a/0x350 [ 369.973537][ T43] ? __pfx_kthread+0x10/0x10 [ 369.973658][ T43] ret_from_fork+0x31/0x70 [ 369.973776][ T43] ? __pfx_kthread+0x10/0x10 [ 369.973887][ T43] ret_from_fork_asm+0x1a/0x30 [ 369.974007][ T43] [ 369.974113][ T43] INFO: task restore_ipv4:233 blocked for more than 245 seconds. [ 369.974292][ T43] Not tainted 6.12.0-rc5-virtme #1 [ 369.974422][ T43] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. [ 369.974613][ T43] task:restore_ipv4 state:D stack:25712 pid:233 tgid:233 ppid:232 flags:0x00004006 [ 369.974854][ T43] Call Trace: [ 369.974956][ T43] [ 369.975016][ T43] __schedule+0xa19/0x1dc0 [ 369.975130][ T43] ? __pfx___schedule+0x10/0x10 [ 369.975253][ T43] ? trace_lock_acquire+0x14d/0x1f0 [ 369.975368][ T43] ? trace_lock_release+0x10e/0x180 [ 369.975482][ T43] schedule+0xdf/0x210 [ 369.975567][ T43] schedule_preempt_disabled+0x15/0x30 [ 369.975687][ T43] __mutex_lock+0x634/0xac0 [ 369.975801][ T43] ? rtnl_newlink+0x64b/0xa30 [ 369.975924][ T43] ? __pfx___mutex_lock+0x10/0x10 [ 369.976038][ T43] ? trace_lock_acquire+0x14d/0x1f0 [ 369.976155][ T43] ? rtnl_newlink+0x64b/0xa30 [ 369.976317][ T43] rtnl_newlink+0x64b/0xa30 [ 369.976439][ T43] ? __pfx_rtnl_newlink+0x10/0x10 [ 369.976557][ T43] ? find_held_lock+0x2c/0x110 [ 369.976677][ T43] ? __pfx___lock_release+0x10/0x10 [ 369.976815][ T43] ? rtnetlink_rcv_msg+0x6ef/0xc10 [ 369.976931][ T43] ? __pfx_rtnl_newlink+0x10/0x10 [ 369.977046][ T43] rtnetlink_rcv_msg+0x712/0xc10 [ 369.977159][ T43] ? __pfx_rtnetlink_rcv_msg+0x10/0x10 [ 369.977282][ T43] ? hlock_class+0x4e/0x130 [ 369.977397][ T43] ? mark_lock+0x38/0x3e0 [ 369.977485][ T43] ? __lock_acquire+0xb3f/0x1580 [ 369.977598][ T43] netlink_rcv_skb+0x130/0x360 [ 369.977722][ T43] ? __pfx_rtnetlink_rcv_msg+0x10/0x10 [ 369.977836][ T43] ? __pfx_netlink_rcv_skb+0x10/0x10 [ 369.977952][ T43] ? netlink_deliver_tap+0x13e/0x340 [ 369.978066][ T43] ? netlink_deliver_tap+0xc3/0x340 [ 369.978191][ T43] netlink_unicast+0x44b/0x710 [ 369.978329][ T43] ? __pfx_netlink_unicast+0x10/0x10 [ 369.978468][ T43] ? netlink_autobind.isra.0+0xa5/0x270 [ 369.978605][ T43] ? netlink_autobind.isra.0+0x18a/0x270 [ 369.978745][ T43] netlink_sendmsg+0x723/0xbe0 [ 369.978870][ T43] ? __pfx_netlink_sendmsg+0x10/0x10 [ 369.978990][ T43] ? fdget+0x52/0x1e0 [ 369.979088][ T43] __sys_sendto+0x377/0x400 [ 369.979220][ T43] ? __pfx___sys_sendto+0x10/0x10 [ 369.979370][ T43] ? find_held_lock+0x2c/0x110 [ 369.979504][ T43] ? __might_fault+0xc3/0x170 [ 369.979634][ T43] ? lock_acquire+0x32/0xc0 [ 369.979759][ T43] ? trace_rseq_update+0xe2/0x140 [ 369.979884][ T43] ? rseq_update_cpu_node_id+0xe6/0x140 [ 369.980024][ T43] ? __rseq_handle_notify_resume+0x288/0x3e0 [ 369.980179][ T43] ? do_user_addr_fault+0x374/0xe30 [ 369.980304][ T43] ? __pfx___rseq_handle_notify_resume+0x10/0x10 [ 369.980479][ T43] __x64_sys_sendto+0xe0/0x1c0 [ 369.980601][ T43] ? lockdep_hardirqs_on_prepare+0x275/0x410 [ 369.980751][ T43] do_syscall_64+0xc1/0x1d0 [ 369.980879][ T43] entry_SYSCALL_64_after_hwframe+0x77/0x7f [ 369.981037][ T43] RIP: 0033:0x7fcf3308c700 [ 369.981166][ T43] RSP: 002b:00007fff53ccd5a8 EFLAGS: 00000246 ORIG_RAX: 000000000000002c [ 369.981356][ T43] RAX: ffffffffffffffda RBX: 00007fff53ccd628 RCX: 00007fcf3308c700 [ 369.981538][ T43] RDX: 0000000000000078 RSI: 00007fff53ccd5f0 RDI: 0000000000000008 [ 369.981726][ T43] RBP: 00007fff53ccd5f0 R08: 0000000000000000 R09: 0000000000000000 [ 369.981922][ T43] R10: 0000000000000000 R11: 0000000000000246 R12: 000000000040edf8 [ 369.982092][ T43] R13: 0000000000000048 R14: 000000000000004c R15: 0000000000000008 [ 369.982273][ T43] [ 369.982390][ T43] INFO: lockdep is turned off. WAIT TIMEOUT stderr