Results for igt@gem_busy@close-race

Result: Abort

git-log-oneline i915_display_info12 igt_runner12 runtimes12 results12.json results12-i915-load.json guc_logs12.tar i915_display_info_post_exec12 boot12 dmesg12

DetailValue
Duration unknown
Hostname 
shard-mtlp-6
Igt-Version 
IGT-Version: 2.4-g9c0a446d4 (x86_64) (Linux: 7.1.0-rc3-CI_DRM_18470-g767b83aa80c6+ x86_64)
Out 
Using IGT_SRANDOM=1778603925 for randomisation
Opened device: /dev/dri/card0
Starting subtest: close-race
Opened device: /dev/dri/card1
runner: This test was killed due to a kernel taint (0x4244).

This test caused an abort condition: Child refuses to die, tainted 0x4244.
Err 
Starting subtest: close-race
Received signal SIGQUIT.
Stack trace: 
Received signal SIGQUIT.
Stack trace: 
 #0 [fa t#al0_ s[igf_ahatnadlle_rs+i0gx1_7hba]
ndler+0x17b]
 #1 [__sigacti on#+0x150] 
[__sigaction+0x50]
 #2 [poll+0x4d]
 #3 [igt_fork_hang_detector+0x138]
 #2  [#w4ai t4[+0_x5_1]i
gt_unique____real_main472+0x158d]
 #5 [main+0x2d]
 #3  #6[ [____liibcg_tin_itw_fairistt+0cx8hai]l
dren+0x57]
 #7 [__libc_st a#r4t _[miagitn_+w0axi8tbc]h
ildren+0x2d]
 #8 [_start+0 x#255 ][
__igt_unique____real_main472+0x1d01]
 #6 [main+0x2d]
 #7 [__libc_init_first+0x8a]
 #8 [__libc_start_main+0x8b]
 #9 [_start+0x25]
Dmesg
<6> [400.472591] Console: switching to colour dummy device 80x25
<6> [400.472797] [IGT] gem_busy: executing
<7> [400.479881] i915 0000:00:02.0: [drm:i915_gem_open [i915]]
<7> [400.482305] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc]
<7> [400.502298] i915 0000:00:02.0: [drm:i915_gem_open [i915]]
<7> [400.505050] i915 0000:00:02.0: [drm:i915_gem_open [i915]]
<6> [400.513289] [IGT] gem_busy: starting subtest close-race
<7> [400.516368] i915 0000:00:02.0: [drm:i915_gem_open [i915]]
<7> [400.527616] i915 0000:00:02.0: [drm:i915_gem_open [i915]]
<7> [400.539871] i915 0000:00:02.0: [drm:i915_gem_open [i915]]
<7> [400.553008] i915 0000:00:02.0: [drm:i915_gem_open [i915]]
<7> [400.565406] i915 0000:00:02.0: [drm:i915_gem_open [i915]]
<7> [400.577788] i915 0000:00:02.0: [drm:i915_gem_open [i915]]
<7> [400.631981] i915 0000:00:02.0: [drm:i915_gem_open [i915]]
<7> [400.632908] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x00000070 [0x00000070]
<7> [401.340464] i915 0000:00:02.0: [drm:intel_tc_port_reset_mode [i915]] Port F/TC#3: TC port mode reset (tbt-alt -> disconnected) pin assignment: - max lanes: 4
<7> [401.340416] i915 0000:00:02.0: [drm:intel_tc_port_reset_mode [i915]] Port G/TC#4: TC port mode reset (tbt-alt -> disconnected) pin assignment: - max lanes: 4
<7> [401.341333] i915 0000:00:02.0: [drm:intel_tc_port_reset_mode [i915]] Port D/TC#1: TC port mode reset (tbt-alt -> disconnected) pin assignment: - max lanes: 4
<7> [401.341380] i915 0000:00:02.0: [drm:intel_tc_port_reset_mode [i915]] Port E/TC#2: TC port mode reset (legacy -> disconnected) pin assignment: - max lanes: 4
<7> [402.262412] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x00000070 [0x00000070]
<7> [402.366028] [drm:eb_validate_vma [i915]] EINVAL at eb_validate_vma:509
<7> [402.877496] i915 0000:00:02.0: [drm:intel_pps_vdd_off_sync_unlocked [i915]] [ENCODER:507:DDI A/PHY A] PPS 0 turning VDD off
<7> [402.877856] i915 0000:00:02.0: [drm:intel_pps_vdd_off_sync_unlocked [i915]] [ENCODER:507:DDI A/PHY A] PPS 0 PP_STATUS: 0x80000008 PP_CONTROL: 0x00000067
<7> [402.878627] i915 0000:00:02.0: [drm:intel_power_well_disable [i915]] disabling DC_off
<7> [402.878901] i915 0000:00:02.0: [drm:skl_enable_dc6 [i915]] Enabling DC6
<7> [402.879618] i915 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [i915]] Setting DC state from 00 to 02
<3> [488.110499] rcu: INFO: rcu_preempt detected stalls on CPUs/tasks:
<3> [488.116636] rcu: Tasks blocked on level-1 rcu_node (CPUs 11-21): P2674
<3> [488.123498] rcu: (detected by 3, t=65014 jiffies, g=225957, q=103188 ncpus=22)
<6> [488.130782] task:gem_busy state:R running task stack:0 pid:2674 tgid:2674 ppid:2651 task_flags:0x400040 flags:0x00080800
<6> [488.130787] Call Trace:
<6> [488.130788] <TASK>
<6> [488.130790] ? find_held_lock+0x31/0x90
<6> [488.130799] __hrtimer_rearm_deferred+0xc5/0x1f0
<6> [488.130804] ? lock_release+0xd0/0x2b0
<6> [488.130807] ? sysvec_apic_timer_interrupt+0x57/0xc0
<6> [488.130813] ? irqentry_exit+0x2a2/0x870
<6> [488.130815] ? sysvec_apic_timer_interrupt+0x57/0xc0
<6> [488.130817] ? trace_hardirqs_on+0x22/0xf0
<6> [488.130822] ? irqentry_exit+0x2a2/0x870
<6> [488.130824] ? trace_hardirqs_off_finish+0xcf/0xf0
<6> [488.130827] ? sysvec_apic_timer_interrupt+0x57/0xc0
<6> [488.130830] ? asm_sysvec_apic_timer_interrupt+0x1b/0x20
<6> [488.130836] ? lock_is_held_type+0xa3/0x130
<6> [488.130838] ? rcu_read_lock_held+0x2e/0x60
<6> [488.130842] ? dma_resv_list_entry+0x7a/0xd0
<6> [488.130848] ? rcu_read_lock_held+0x2e/0x60
<6> [488.130849] ? dma_resv_iter_walk_unlocked.part.0+0x170/0x1d0
<6> [488.130852] ? dma_resv_iter_first_unlocked+0x69/0x290
<6> [488.130857] ? i915_gem_busy_ioctl+0xb8/0xb80 [i915]
<6> [488.131068] ? __pfx_i915_gem_busy_ioctl+0x10/0x10 [i915]
<6> [488.131190] ? drm_ioctl_kernel+0xb3/0x120
<6> [488.131195] ? drm_ioctl+0x2d4/0x5a0
<6> [488.131197] ? __pfx_i915_gem_busy_ioctl+0x10/0x10 [i915]
<6> [488.131315] ? drm_ioctl+0x30f/0x5a0
<6> [488.131317] ? __pfx_i915_gem_busy_ioctl+0x10/0x10 [i915]
<6> [488.131435] ? __x64_sys_ioctl+0xa5/0x100
<6> [488.131440] ? x64_sys_call+0x1250/0x26e0
<6> [488.131444] ? do_syscall_64+0x103/0x1410
<6> [488.131448] ? __x64_sys_ioctl+0xa5/0x100
<6> [488.131451] ? trace_hardirqs_on_prepare+0xd7/0xf0
<6> [488.131454] ? do_syscall_64+0x23d/0x1410
<6> [488.131458] ? __x64_sys_ioctl+0xa5/0x100
<6> [488.131460] ? trace_hardirqs_on_prepare+0xd7/0xf0
<6> [488.131463] ? do_syscall_64+0x23d/0x1410
<6> [488.131467] ? __x64_sys_ioctl+0xa5/0x100
<6> [488.131470] ? trace_hardirqs_on_prepare+0xd7/0xf0
<6> [488.131472] ? do_syscall_64+0x23d/0x1410
<6> [488.131477] ? __x64_sys_ioctl+0xa5/0x100
<6> [488.131479] ? do_syscall_64+0x34/0x1410
<6> [488.131481] ? entry_SYSCALL_64_after_hwframe+0x76/0x7e
<6> [488.131483] ? trace_hardirqs_on+0x22/0xf0
<6> [488.131486] ? do_syscall_64+0xb8/0x1410
<6> [488.131489] ? entry_SYSCALL_64_after_hwframe+0x76/0x7e
<6> [488.131502] </TASK>
<3> [555.382050] INFO: task systemd:1 blocked for more than 61 seconds.
<3> [555.388325] Tainted: G S U W L 7.1.0-rc3-CI_DRM_18470-g767b83aa80c6+ #1
<3> [555.396545] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message.
<6> [555.404387] task:systemd state:D stack:0 pid:1 tgid:1 ppid:0 task_flags:0x400100 flags:0x00080000
<6> [555.404402] Call Trace:
<6> [555.404406] <TASK>
<6> [555.404414] __schedule+0x5f0/0x1fa0
<6> [555.404427] ? lock_acquire+0xc4/0x300
<6> [555.404440] ? schedule+0x10e/0x180
<6> [555.404446] ? lock_release+0xd0/0x2b0
<6> [555.404457] schedule+0x3a/0x180
<6> [555.404462] schedule_timeout+0x117/0x130
<6> [555.404469] ? __wait_for_common+0xb4/0x1f0
<6> [555.404476] ? _raw_spin_unlock_irq+0x27/0x70
<6> [555.404480] ? __wait_for_common+0xb4/0x1f0
<6> [555.404486] ? trace_hardirqs_on+0x22/0xf0
<6> [555.404499] __wait_for_common+0xc0/0x1f0
<6> [555.404506] ? __pfx_schedule_timeout+0x10/0x10
<6> [555.404518] wait_for_completion_state+0x21/0x50
<6> [555.404524] __wait_rcu_gp+0x1a0/0x1b0
<6> [555.404536] ? cgroup_procs_write_start+0x5e/0x3f0
<6> [555.404545] synchronize_rcu_normal.part.0+0x45/0x70
<6> [555.404553] ? __pfx_call_rcu_hurry+0x10/0x10
<6> [555.404560] ? __pfx_wakeme_after_rcu+0x10/0x10
<6> [555.404577] synchronize_rcu_normal+0xe3/0xf0
<6> [555.404583] ? lock_is_held_type+0xa3/0x130
<6> [555.404593] ? cgroup_procs_write_start+0x5e/0x3f0
<6> [555.404603] ? __might_sleep+0x49/0x60
<6> [555.404615] synchronize_rcu+0x1c4/0x1d0
<6> [555.404622] rcu_sync_enter+0x58/0x110
<6> [555.404634] percpu_down_write+0x56/0x2e0
<6> [555.404640] ? cgroup_procs_write_start+0x233/0x3f0
<6> [555.404647] ? cgroup_procs_write_start+0x5e/0x3f0
<6> [555.404655] ? cgroup_procs_write_start+0x5e/0x3f0
<6> [555.404661] cgroup_procs_write_start+0x233/0x3f0
<6> [555.404668] ? mutex_lock_nested+0x1b/0x30
<6> [555.404678] __cgroup_procs_write+0x5c/0x2e0
<6> [555.404692] cgroup_procs_write+0x17/0x30
<6> [555.404700] cgroup_file_write+0xa6/0x360
<6> [555.404706] ? lock_is_held_type+0xa3/0x130
<6> [555.404715] kernfs_fop_write_iter+0x188/0x240
<6> [555.404729] vfs_write+0x283/0x540
<6> [555.404748] ksys_write+0x6f/0xf0
<6> [555.404757] __x64_sys_write+0x19/0x30
<6> [555.404763] x64_sys_call+0x259/0x26e0
<6> [555.404774] do_syscall_64+0x103/0x1410
<6> [555.404794] ? find_held_lock+0x31/0x90
<6> [555.404804] ? rcu_read_unlock+0x1c/0x80
<6> [555.404812] ? lock_release+0xd0/0x2b0
<6> [555.404824] ? find_held_lock+0x31/0x90
<6> [555.404830] ? exc_page_fault+0x96/0x2b0
<6> [555.404836] ? lock_release+0xd0/0x2b0
<6> [555.404845] ? trace_hardirqs_on_prepare+0xd7/0xf0
<6> [555.404853] ? do_syscall_64+0x34/0x1410
<6> [555.404859] ? entry_SYSCALL_64_after_hwframe+0x76/0x7e
<6> [555.404865] ? trace_hardirqs_on+0x22/0xf0
<6> [555.404873] ? do_syscall_64+0xb8/0x1410
<6> [555.404879] ? exc_page_fault+0xbd/0x2b0
<6> [555.404886] entry_SYSCALL_64_after_hwframe+0x76/0x7e
<6> [555.404890] RIP: 0033:0x74bd85d1c5a4
<6> [555.404897] RSP: 002b:00007fff18cb0d38 EFLAGS: 00000202 ORIG_RAX: 0000000000000001
<6> [555.404903] RAX: ffffffffffffffda RBX: 0000000000000005 RCX: 000074bd85d1c5a4
<6> [555.404907] RDX: 0000000000000005 RSI: 00007fff18cb0f0a RDI: 000000000000003f
<6> [555.404910] RBP: 00007fff18cb0d60 R08: 000074bd85e02228 R09: 0000000000000000
<6> [555.404913] R10: 0000000000000000 R11: 0000000000000202 R12: 0000000000000005
<6> [555.404916] R13: 00007fff18cb0f0a R14: 0000564f8de15a00 R15: 0000000000000005
<6> [555.404930] </TASK>
<3> [555.405051] INFO: task (sa1):2681 blocked for more than 61 seconds.
<3> [555.411373] Tainted: G S U W L 7.1.0-rc3-CI_DRM_18470-g767b83aa80c6+ #1
<3> [555.419485] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message.
<6> [555.427327] task:(sa1) state:D stack:0 pid:2681 tgid:2681 ppid:1 task_flags:0x400100 flags:0x00080000
<6> [555.427333] Call Trace:
<6> [555.427335] <TASK>
<6> [555.427338] __schedule+0x5f0/0x1fa0
<6> [555.427341] ? lock_acquire+0xc4/0x300
<6> [555.427345] ? schedule+0x10e/0x180
<6> [555.427347] ? lock_release+0xd0/0x2b0
<6> [555.427351] schedule+0x3a/0x180
<6> [555.427353] schedule_preempt_disabled+0x15/0x30
<6> [555.427355] __mutex_lock+0x777/0x10a0
<6> [555.427358] ? cgroup_kn_lock_live+0x4f/0x250
<6> [555.427364] mutex_lock_nested+0x1b/0x30
<6> [555.427366] ? kernfs_break_active_protection+0x4a/0x80
<6> [555.427369] ? mutex_lock_nested+0x1b/0x30
<6> [555.427372] cgroup_kn_lock_live+0x4f/0x250
<6> [555.427375] __cgroup_procs_write+0x3d/0x2e0
<6> [555.427378] ? kernfs_root+0x80/0x1b0
<6> [555.427383] cgroup_procs_write+0x17/0x30
<6> [555.427385] cgroup_file_write+0xa6/0x360
<6> [555.427387] ? lock_is_held_type+0xa3/0x130
<6> [555.427390] kernfs_fop_write_iter+0x188/0x240
<6> [555.427394] vfs_write+0x283/0x540
<6> [555.427396] ? trace_hardirqs_on_prepare+0xd7/0xf0
<6> [555.427402] ksys_write+0x6f/0xf0
<6> [555.427405] __x64_sys_write+0x19/0x30
<6> [555.427407] x64_sys_call+0x259/0x26e0
<6> [555.427409] do_syscall_64+0x103/0x1410
<6> [555.427412] ? find_held_lock+0x31/0x90
<6> [555.427415] ? rcu_read_unlock+0x1c/0x80
<6> [555.427418] ? lock_release+0xd0/0x2b0
<6> [555.427421] ? find_held_lock+0x31/0x90
<6> [555.427425] ? __x64_sys_fcntl+0x97/0x130
<6> [555.427429] ? trace_hardirqs_on_prepare+0xd7/0xf0
<6> [555.427432] ? do_syscall_64+0x34/0x1410
<6> [555.427434] ? entry_SYSCALL_64_after_hwframe+0x76/0x7e
<6> [555.427436] ? trace_hardirqs_on+0x22/0xf0
<6> [555.427439] ? do_syscall_64+0xb8/0x1410
<6> [555.427442] ? exc_page_fault+0xbd/0x2b0
<6> [555.427444] entry_SYSCALL_64_after_hwframe+0x76/0x7e
<6> [555.427446] RIP: 0033:0x749d6731c5a4
<6> [555.427448] RSP: 002b:00007ffe557eae08 EFLAGS: 00000202 ORIG_RAX: 0000000000000001
<6> [555.427450] RAX: ffffffffffffffda RBX: 0000000000000005 RCX: 0000749d6731c5a4
<6> [555.427452] RDX: 0000000000000005 RSI: 00007ffe557eafda RDI: 0000000000000003
<6> [555.427453] RBP: 00007ffe557eae30 R08: 0000000000000000 R09: 0000000000000000
<6> [555.427454] R10: 0000000000000000 R11: 0000000000000202 R12: 0000000000000005
<6> [555.427455] R13: 00007ffe557eafda R14: 000063afecb662d0 R15: 0000000000000005
<6> [555.427461] </TASK>
<3> [555.427462] INFO: task (sa1):2681 is blocked on a mutex likely owned by task systemd:1.
<4> [555.435460]
Showing all locks held in the system:
<4> [555.435463] 5 locks held by systemd/1:
<4> [555.435464] #0: ffff888112999410 (sb_writers#8){.+.+}-{0:0}, at: ksys_write+0x6f/0xf0
<4> [555.435471] #1: ffff888121b51a80 (&of->mutex#2){+.+.}-{3:3}, at: kernfs_fop_write_iter+0x127/0x240
<4> [555.435478] #2: ffffffff8369ad80 (cgroup_mutex){+.+.}-{3:3}, at: cgroup_kn_lock_live+0x4f/0x250
<4> [555.435483] #3: ffffffff83487cb0 (cpu_hotplug_lock){++++}-{0:0}, at: cgroup_procs_write_start+0x227/0x3f0
<4> [555.435489] #4: ffffffff8369ab90 (cgroup_threadgroup_rwsem){++++}-{0:0}, at: cgroup_procs_write_start+0x233/0x3f0
<4> [555.435503] 1 lock held by khungtaskd/157:
<4> [555.435504] #0: ffffffff835c40e0 (rcu_read_lock){....}-{1:2}, at: debug_show_all_locks+0x37/0x220
<4> [555.435521] 2 locks held by dmesg/2346:
<4> [555.435524] 2 locks held by gem_busy/2674:
<4> [555.435525] 3 locks held by (sa1)/2681:
<4> [555.435526] #0: ffff888112999410 (sb_writers#8){.+.+}-{0:0}, at: ksys_write+0x6f/0xf0
<4> [555.435531] #1: ffff888121b55680 (&of->mutex#2){+.+.}-{3:3}, at: kernfs_fop_write_iter+0x127/0x240
<4> [555.435536] #2: ffffffff8369ad80 (cgroup_mutex){+.+.}-{3:3}, at: cgroup_kn_lock_live+0x4f/0x250
<4> [555.435542]
<4> [555.435543] =============================================
<3> [616.821128] INFO: task systemd:1 blocked for more than 122 seconds.
<3> [616.827418] Tainted: G S U W L 7.1.0-rc3-CI_DRM_18470-g767b83aa80c6+ #1
<3> [616.835494] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message.
<6> [616.843314] task:systemd state:D stack:0 pid:1 tgid:1 ppid:0 task_flags:0x400100 flags:0x00080000
<6> [616.843330] Call Trace:
<6> [616.843334] <TASK>
<6> [616.843342] __schedule+0x5f0/0x1fa0
<6> [616.843355] ? lock_acquire+0xc4/0x300
<6> [616.843369] ? schedule+0x10e/0x180
<6> [616.843375] ? lock_release+0xd0/0x2b0
<6> [616.843387] schedule+0x3a/0x180
<6> [616.843393] schedule_timeout+0x117/0x130
<6> [616.843400] ? __wait_for_common+0xb4/0x1f0
<6> [616.843407] ? _raw_spin_unlock_irq+0x27/0x70
<6> [616.843412] ? __wait_for_common+0xb4/0x1f0
<6> [616.843418] ? trace_hardirqs_on+0x22/0xf0
<6> [616.843432] __wait_for_common+0xc0/0x1f0
<6> [616.843439] ? __pfx_schedule_timeout+0x10/0x10
<6> [616.843453] wait_for_completion_state+0x21/0x50
<6> [616.843459] __wait_rcu_gp+0x1a0/0x1b0
<6> [616.843472] ? cgroup_procs_write_start+0x5e/0x3f0
<6> [616.843481] synchronize_rcu_normal.part.0+0x45/0x70
<6> [616.843489] ? __pfx_call_rcu_hurry+0x10/0x10
<6> [616.843496] ? __pfx_wakeme_after_rcu+0x10/0x10
<6> [616.843515] synchronize_rcu_normal+0xe3/0xf0
<6> [616.843520] ? lock_is_held_type+0xa3/0x130
<6> [616.843530] ? cgroup_procs_write_start+0x5e/0x3f0
<6> [616.843540] ? __might_sleep+0x49/0x60
<6> [616.843551] synchronize_rcu+0x1c4/0x1d0
<6> [616.843559] rcu_sync_enter+0x58/0x110
<6> [616.843570] percpu_down_write+0x56/0x2e0
<6> [616.843577] ? cgroup_procs_write_start+0x233/0x3f0
<6> [616.843584] ? cgroup_procs_write_start+0x5e/0x3f0
<6> [616.843592] ? cgroup_procs_write_start+0x5e/0x3f0
<6> [616.843598] cgroup_procs_write_start+0x233/0x3f0
<6> [616.843603] ? mutex_lock_nested+0x1b/0x30
<6> [616.843614] __cgroup_procs_write+0x5c/0x2e0
<6> [616.843627] cgroup_procs_write+0x17/0x30
<6> [616.843635] cgroup_file_write+0xa6/0x360
<6> [616.843640] ? lock_is_held_type+0xa3/0x130
<6> [616.843649] kernfs_fop_write_iter+0x188/0x240
<6> [616.843664] vfs_write+0x283/0x540
<6> [616.843682] ksys_write+0x6f/0xf0
<6> [616.843691] __x64_sys_write+0x19/0x30
<6> [616.843697] x64_sys_call+0x259/0x26e0
<6> [616.843707] do_syscall_64+0x103/0x1410
<6> [616.843728] ? find_held_lock+0x31/0x90
<6> [616.843738] ? rcu_read_unlock+0x1c/0x80
<6> [616.843746] ? lock_release+0xd0/0x2b0
<6> [616.843757] ? find_held_lock+0x31/0x90
<6> [616.843766] ? exc_page_fault+0x96/0x2b0
<6> [616.843772] ? lock_release+0xd0/0x2b0
<6> [616.843782] ? trace_hardirqs_on_prepare+0xd7/0xf0
<6> [616.843791] ? do_syscall_64+0x34/0x1410
<6> [616.843799] ? entry_SYSCALL_64_after_hwframe+0x76/0x7e
<6> [616.843806] ? trace_hardirqs_on+0x22/0xf0
<6> [616.843815] ? do_syscall_64+0xb8/0x1410
<6> [616.843822] ? exc_page_fault+0xbd/0x2b0
<6> [616.843831] entry_SYSCALL_64_after_hwframe+0x76/0x7e
<6> [616.843835] RIP: 0033:0x74bd85d1c5a4
<6> [616.843843] RSP: 002b:00007fff18cb0d38 EFLAGS: 00000202 ORIG_RAX: 0000000000000001
<6> [616.843850] RAX: ffffffffffffffda RBX: 0000000000000005 RCX: 000074bd85d1c5a4
<6> [616.843854] RDX: 0000000000000005 RSI: 00007fff18cb0f0a RDI: 000000000000003f
<6> [616.843858] RBP: 00007fff18cb0d60 R08: 000074bd85e02228 R09: 0000000000000000
<6> [616.843861] R10: 0000000000000000 R11: 0000000000000202 R12: 0000000000000005
<6> [616.843865] R13: 00007fff18cb0f0a R14: 0000564f8de15a00 R15: 0000000000000005
<6> [616.843882] </TASK>
<3> [616.843987] INFO: task (sa1):2681 blocked for more than 122 seconds.
<3> [616.850354] Tainted: G S U W L 7.1.0-rc3-CI_DRM_18470-g767b83aa80c6+ #1
<3> [616.858442] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message.
<6> [616.866302] task:(sa1) state:D stack:0 pid:2681 tgid:2681 ppid:1 task_flags:0x400100 flags:0x00080000
<6> [616.866306] Call Trace:
<6> [616.866308] <TASK>
<6> [616.866311] __schedule+0x5f0/0x1fa0
<6> [616.866315] ? lock_acquire+0xc4/0x300
<6> [616.866319] ? schedule+0x10e/0x180
<6> [616.866321] ? lock_release+0xd0/0x2b0
<6> [616.866324] schedule+0x3a/0x180
<6> [616.866326] schedule_preempt_disabled+0x15/0x30
<6> [616.866328] __mutex_lock+0x777/0x10a0
<6> [616.866331] ? cgroup_kn_lock_live+0x4f/0x250
<6> [616.866336] mutex_lock_nested+0x1b/0x30
<6> [616.866338] ? kernfs_break_active_protection+0x4a/0x80
<6> [616.866341] ? mutex_lock_nested+0x1b/0x30
<6> [616.866343] cgroup_kn_lock_live+0x4f/0x250
<6> [616.866346] __cgroup_procs_write+0x3d/0x2e0
<6> [616.866349] ? kernfs_root+0x80/0x1b0
<6> [616.866354] cgroup_procs_write+0x17/0x30
<6> [616.866357] cgroup_file_write+0xa6/0x360
<6> [616.866359] ? lock_is_held_type+0xa3/0x130
<6> [616.866362] kernfs_fop_write_iter+0x188/0x240
<6> [616.866366] vfs_write+0x283/0x540
<6> [616.866368] ? trace_hardirqs_on_prepare+0xd7/0xf0
<6> [616.866375] ksys_write+0x6f/0xf0
<6> [616.866378] __x64_sys_write+0x19/0x30
<6> [616.866380] x64_sys_call+0x259/0x26e0
<6> [616.866383] do_syscall_64+0x103/0x1410
<6> [616.866386] ? find_held_lock+0x31/0x90
<6> [616.866389] ? rcu_read_unlock+0x1c/0x80
<6> [616.866392] ? lock_release+0xd0/0x2b0
<6> [616.866395] ? find_held_lock+0x31/0x90
<6> [616.866399] ? __x64_sys_fcntl+0x97/0x130
<6> [616.866403] ? trace_hardirqs_on_prepare+0xd7/0xf0
<6> [616.866407] ? do_syscall_64+0x34/0x1410
<6> [616.866409] ? entry_SYSCALL_64_after_hwframe+0x76/0x7e
<6> [616.866411] ? trace_hardirqs_on+0x22/0xf0
<6> [616.866414] ? do_syscall_64+0xb8/0x1410
<6> [616.866417] ? exc_page_fault+0xbd/0x2b0
<6> [616.866419] entry_SYSCALL_64_after_hwframe+0x76/0x7e
<6> [616.866421] RIP: 0033:0x749d6731c5a4
<6> [616.866423] RSP: 002b:00007ffe557eae08 EFLAGS: 00000202 ORIG_RAX: 0000000000000001
<6> [616.866426] RAX: ffffffffffffffda RBX: 0000000000000005 RCX: 0000749d6731c5a4
<6> [616.866427] RDX: 0000000000000005 RSI: 00007ffe557eafda RDI: 0000000000000003
<6> [616.866428] RBP: 00007ffe557eae30 R08: 0000000000000000 R09: 0000000000000000
<6> [616.866430] R10: 0000000000000000 R11: 0000000000000202 R12: 0000000000000005
<6> [616.866431] R13: 00007ffe557eafda R14: 000063afecb662d0 R15: 0000000000000005
<6> [616.866437] </TASK>
<3> [616.866438] INFO: task (sa1):2681 is blocked on a mutex likely owned by task systemd:1.
<4> [616.874440]
Showing all locks held in the system:
<4> [616.874442] 5 locks held by systemd/1:
<4> [616.874444] #0: ffff888112999410 (sb_writers#8){.+.+}-{0:0}, at: ksys_write+0x6f/0xf0
<4> [616.874451] #1: ffff888121b51a80 (&of->mutex#2){+.+.}-{3:3}, at: kernfs_fop_write_iter+0x127/0x240
<4> [616.874458] #2: ffffffff8369ad80 (cgroup_mutex){+.+.}-{3:3}, at: cgroup_kn_lock_live+0x4f/0x250
<4> [616.874464] #3: ffffffff83487cb0 (cpu_hotplug_lock){++++}-{0:0}, at: cgroup_procs_write_start+0x227/0x3f0
<4> [616.874469] #4: ffffffff8369ab90 (cgroup_threadgroup_rwsem){++++}-{0:0}, at: cgroup_procs_write_start+0x233/0x3f0
<4> [616.874503] 1 lock held by khungtaskd/157:
<4> [616.874505] #0: ffffffff835c40e0 (rcu_read_lock){....}-{1:2}, at: debug_show_all_locks+0x37/0x220
<4> [616.874532] 2 locks held by in:imklog/918:
<4> [616.874533] #0: ffff88812db6d730 (&f->f_pos_lock){+.+.}-{3:3}, at: fdget_pos+0x81/0xd0
<4> [616.874540] #1: ffff88885f5b5a20 (&rq->__lock){-.-.}-{2:2}, at: raw_spin_rq_lock_nested+0x28/0xc0
<4> [616.874547] 3 locks held by rs:main Q:Reg/919:
<4> [616.874551] 3 locks held by dmesg/2346:
<4> [616.874553] 2 locks held by gem_busy/2674:
<4> [616.874554] 3 locks held by (sa1)/2681:
<4> [616.874555] #0: ffff888112999410 (sb_writers#8){.+.+}-{0:0}, at: ksys_write+0x6f/0xf0
<4> [616.874560] #1: ffff888121b55680 (&of->mutex#2){+.+.}-{3:3}, at: kernfs_fop_write_iter+0x127/0x240
<4> [616.874566] #2: ffffffff8369ad80 (cgroup_mutex){+.+.}-{3:3}, at: cgroup_kn_lock_live+0x4f/0x250
<4> [616.874571]
<4> [616.874572] =============================================
Created at 2026-05-12 20:16:12