[ 30.235579][ T261] ip (261) used greatest stack depth: 24064 bytes left
[ 32.621030][ T271] ip (271) used greatest stack depth: 23888 bytes left
[ 455.489019][ T2851] netem: version 1.3
[ 658.795282][ C0]
[ 658.795491][ C0] ======================================================
[ 658.795727][ C0] WARNING: possible circular locking dependency detected
[ 658.795973][ C0] 6.11.0-rc5-virtme #1 Not tainted
[ 658.796184][ C0] ------------------------------------------------------
[ 658.796419][ C0] swapper/0/0 is trying to acquire lock:
[ 658.796607][ C0] ffff888007e4b120 (&msk->pm.lock){+.-.}-{2:2}, at: mptcp_pm_add_timer+0x136/0x420
[ 658.796951][ C0]
[ 658.796951][ C0] but task is already holding lock:
[ 658.797296][ C0] ffffc90000007b30 ((&add_entry->add_timer)){+.-.}-{0:0}, at: call_timer_fn+0xe8/0x230
[ 658.797640][ C0]
[ 658.797640][ C0] which lock already depends on the new lock.
[ 658.797640][ C0]
[ 658.798013][ C0]
[ 658.798013][ C0] the existing dependency chain (in reverse order) is:
[ 658.798353][ C0]
[ 658.798353][ C0] -> #1 ((&add_entry->add_timer)){+.-.}-{0:0}:
[ 658.798632][ C0] __lock_acquire+0xb35/0x1560
[ 658.798819][ C0] lock_acquire.part.0+0xeb/0x330
[ 658.799002][ C0] __timer_delete_sync+0xe1/0x110
[ 658.799201][ C0] sk_stop_timer_sync+0x16/0x60
[ 658.799385][ C0] mptcp_pm_del_add_timer+0x11e/0x150
[ 658.799612][ C0] mptcp_incoming_options+0xf39/0x16d0
[ 658.799844][ C0] tcp_data_queue+0x7e7/0x23e0
[ 658.800027][ C0] tcp_rcv_established+0x6be/0x1f30
[ 658.800220][ C0] tcp_v4_do_rcv+0x4cc/0x8d0
[ 658.800406][ C0] __release_sock+0x27a/0x390
[ 658.800596][ C0] release_sock+0x53/0x1d0
[ 658.800786][ C0] __mptcp_push_pending+0x322/0x440
[ 658.800968][ C0] mptcp_sendmsg+0xcf1/0x19c0
[ 658.801158][ C0] sock_write_iter+0x287/0x520
[ 658.801340][ C0] vfs_write+0xad8/0x10b0
[ 658.801527][ C0] ksys_write+0x17a/0x1e0
[ 658.801710][ C0] do_syscall_64+0xc1/0x1d0
[ 658.801897][ C0] entry_SYSCALL_64_after_hwframe+0x77/0x7f
[ 658.802147][ C0]
[ 658.802147][ C0] -> #0 (&msk->pm.lock){+.-.}-{2:2}:
[ 658.802435][ C0] check_prev_add+0x182/0xce0
[ 658.802641][ C0] validate_chain+0x71d/0x9b0
[ 658.802834][ C0] __lock_acquire+0xb35/0x1560
[ 658.803017][ C0] lock_acquire.part.0+0xeb/0x330
[ 658.803210][ C0] _raw_spin_lock_bh+0x38/0x50
[ 658.803394][ C0] mptcp_pm_add_timer+0x136/0x420
[ 658.803584][ C0] call_timer_fn+0x13b/0x230
[ 658.803766][ C0] __run_timers+0x545/0x810
[ 658.803981][ C0] timer_expire_remote+0x9b/0xe0
[ 658.804183][ C0] tmigr_handle_remote_cpu+0x278/0x440
[ 658.804426][ C0] tmigr_handle_remote_up+0x1a2/0x260
[ 658.804654][ C0] tmigr_handle_remote+0x226/0x3f0
[ 658.804842][ C0] handle_softirqs+0x1f9/0x5c0
[ 658.805034][ C0] irq_exit_rcu+0x99/0xc0
[ 658.805290][ C0] sysvec_apic_timer_interrupt+0x75/0x80
[ 658.805557][ C0] asm_sysvec_apic_timer_interrupt+0x1a/0x20
[ 658.805811][ C0] default_idle+0xf/0x20
[ 658.805994][ C0] default_idle_call+0x6d/0xb0
[ 658.806194][ C0] cpuidle_idle_call+0x1f4/0x280
[ 658.806380][ C0] do_idle+0xf9/0x160
[ 658.806568][ C0] cpu_startup_entry+0x54/0x60
[ 658.806755][ C0] rest_init+0x14f/0x260
[ 658.806941][ C0] start_kernel+0x346/0x400
[ 658.807137][ C0] x86_64_start_reservations+0x18/0x30
[ 658.807380][ C0] x86_64_start_kernel+0xba/0x110
[ 658.807564][ C0] common_startup_64+0x12c/0x138
[ 658.807749][ C0]
[ 658.807749][ C0] other info that might help us debug this:
[ 658.807749][ C0]
[ 658.808122][ C0] Possible unsafe locking scenario:
[ 658.808122][ C0]
[ 658.808401][ C0] CPU0 CPU1
[ 658.808584][ C0] ---- ----
[ 658.808768][ C0] lock((&add_entry->add_timer));
[ 658.808962][ C0] lock(&msk->pm.lock);
[ 658.809199][ C0] lock((&add_entry->add_timer));
[ 658.809481][ C0] lock(&msk->pm.lock);
[ 658.809628][ C0]
[ 658.809628][ C0] *** DEADLOCK ***
[ 658.809628][ C0]
[ 658.809897][ C0] 1 lock held by swapper/0/0:
[ 658.810099][ C0] #0: ffffc90000007b30 ((&add_entry->add_timer)){+.-.}-{0:0}, at: call_timer_fn+0xe8/0x230
[ 658.810481][ C0]
[ 658.810481][ C0] stack backtrace:
[ 658.810712][ C0] CPU: 0 UID: 0 PID: 0 Comm: swapper/0 Not tainted 6.11.0-rc5-virtme #1
[ 658.810993][ C0] Hardware name: QEMU Standard PC (i440FX + PIIX, 1996), BIOS rel-1.16.3-0-ga6ed6b701f0a-prebuilt.qemu.org 04/01/2014
[ 658.811435][ C0] Call Trace:
[ 658.811580][ C0]
[ 658.811674][ C0] dump_stack_lvl+0x82/0xd0
[ 658.811862][ C0] check_noncircular+0x2f9/0x3e0
[ 658.812046][ C0] ? __pfx_check_noncircular+0x10/0x10
[ 658.812243][ C0] ? alloc_chain_hlocks+0x4e0/0x720
[ 658.812438][ C0] check_prev_add+0x182/0xce0
[ 658.812647][ C0] validate_chain+0x71d/0x9b0
[ 658.812833][ C0] ? __pfx_validate_chain+0x10/0x10
[ 658.813025][ C0] ? hlock_class+0x4e/0x130
[ 658.813275][ C0] ? mark_lock+0x38/0x3e0
[ 658.813426][ C0] __lock_acquire+0xb35/0x1560
[ 658.813611][ C0] lock_acquire.part.0+0xeb/0x330
[ 658.813795][ C0] ? mptcp_pm_add_timer+0x136/0x420
[ 658.813981][ C0] ? __pfx_lock_acquire.part.0+0x10/0x10
[ 658.814166][ C0] ? trace_lock_acquire+0x14d/0x1f0
[ 658.814347][ C0] ? __pfx_mptcp_pm_add_timer+0x10/0x10
[ 658.814530][ C0] ? mptcp_pm_add_timer+0x136/0x420
[ 658.814715][ C0] ? lock_acquire+0x32/0xc0
[ 658.814902][ C0] ? mptcp_pm_add_timer+0x136/0x420
[ 658.815090][ C0] _raw_spin_lock_bh+0x38/0x50
[ 658.815271][ C0] ? mptcp_pm_add_timer+0x136/0x420
[ 658.815455][ C0] mptcp_pm_add_timer+0x136/0x420
[ 658.815643][ C0] ? __pfx_mptcp_pm_add_timer+0x10/0x10
[ 658.815820][ C0] ? __pfx_call_timer_fn+0x1/0x10
[ 658.816004][ C0] ? lock_acquire+0x32/0xc0
[ 658.816200][ C0] ? __pfx_mptcp_pm_add_timer+0x10/0x10
[ 658.816385][ C0] call_timer_fn+0x13b/0x230
[ 658.816569][ C0] ? call_timer_fn+0xe8/0x230
[ 658.816775][ C0] ? call_timer_fn+0xe8/0x230
[ 658.816959][ C0] ? __pfx_call_timer_fn+0x10/0x10
[ 658.817167][ C0] ? __pfx_do_raw_spin_lock+0x10/0x10
[ 658.817366][ C0] __run_timers+0x545/0x810
[ 658.817560][ C0] ? __pfx_mptcp_pm_add_timer+0x10/0x10
[ 658.817747][ C0] ? __pfx___run_timers+0x10/0x10
[ 658.817927][ C0] ? __lock_release+0x103/0x460
[ 658.818111][ C0] ? do_raw_spin_lock+0x131/0x270
[ 658.818316][ C0] ? __pfx_do_raw_spin_lock+0x10/0x10
[ 658.818500][ C0] ? lock_acquire+0x32/0xc0
[ 658.818712][ C0] ? timer_expire_remote+0x93/0xe0
[ 658.818913][ C0] timer_expire_remote+0x9b/0xe0
[ 658.819109][ C0] tmigr_handle_remote_cpu+0x278/0x440
[ 658.819300][ C0] ? __pfx_tmigr_handle_remote_cpu+0x10/0x10
[ 658.819541][ C0] ? __pfx___lock_release+0x10/0x10
[ 658.819735][ C0] ? __pfx_lock_acquire.part.0+0x10/0x10
[ 658.819919][ C0] tmigr_handle_remote_up+0x1a2/0x260
[ 658.820127][ C0] tmigr_handle_remote+0x226/0x3f0
[ 658.820329][ C0] ? __pfx_tmigr_handle_remote+0x10/0x10
[ 658.820511][ C0] ? do_raw_spin_lock+0x131/0x270
[ 658.820702][ C0] ? spin_bug+0x191/0x1d0
[ 658.820840][ C0] ? lockdep_hardirqs_on_prepare+0x12b/0x410
[ 658.821090][ C0] handle_softirqs+0x1f9/0x5c0
[ 658.821295][ C0] irq_exit_rcu+0x99/0xc0
[ 658.821437][ C0] sysvec_apic_timer_interrupt+0x75/0x80
[ 658.821632][ C0]
[ 658.821730][ C0]
[ 658.821823][ C0] asm_sysvec_apic_timer_interrupt+0x1a/0x20
[ 658.822067][ C0] RIP: 0010:default_idle+0xf/0x20
[ 658.822282][ 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 c3 37 3c 00 fb f4 c3 cc cc cc cc 66 66 2e 0f 1f 84 00 00 00 00 00 90 90 90 90 90
[ 658.822974][ C0] RSP: 0018:ffffffffb4e07e00 EFLAGS: 00000246
[ 658.823204][ C0] RAX: 0000000000b225e7 RBX: 1ffffffff69c0fc2 RCX: ffffffffb3e9d975
[ 658.823491][ C0] RDX: 0000000000000000 RSI: 0000000000000000 RDI: ffffffffb16a6b94
[ 658.823799][ C0] RBP: 0000000000000000 R08: 0000000000000001 R09: ffffed1006c07098
[ 658.824093][ C0] R10: ffff8880360384c3 R11: ffff88803603de80 R12: 0000000000000000
[ 658.824381][ C0] R13: ffffffffb4e41080 R14: dffffc0000000000 R15: 0000000000014770
[ 658.824672][ C0] ? ct_kernel_exit.constprop.0+0xc5/0xf0
[ 658.824880][ C0] ? cpuidle_idle_call+0x1f4/0x280
[ 658.825064][ C0] default_idle_call+0x6d/0xb0
[ 658.825271][ C0] cpuidle_idle_call+0x1f4/0x280
[ 658.825453][ C0] ? __pfx_cpuidle_idle_call+0x10/0x10
[ 658.825658][ C0] ? tsc_verify_tsc_adjust+0x5e/0x2b0
[ 658.825853][ C0] do_idle+0xf9/0x160
[ 658.825992][ C0] cpu_startup_entry+0x54/0x60
[ 658.826200][ C0] rest_init+0x14f/0x260
[ 658.826341][ C0] start_kernel+0x346/0x400
[ 658.826557][ C0] x86_64_start_reservations+0x18/0x30
[ 658.826747][ C0] x86_64_start_kernel+0xba/0x110
[ 658.826944][ C0] common_startup_64+0x12c/0x138
[ 658.827142][ C0]
[ 2531.918267][T18795] pm_nl_ctl (18795) used greatest stack depth: 22752 bytes left