igt@gem_busy@close-race - incomplete - rcu: INFO: rcu_preempt detected stalls on CPUs/tasks, Received signal SIGQUIT
https://intel-gfx-ci.01.org/tree/drm-tip/CI_DRM_11735/shard-snb7/igt@gem_busy@close-race.html
Starting subtest: close-race
Received signal SIGQUITReceived signal .
SIGQUITStack trace:
.
Stack trace:
#0 [fatal_si g#_0h a[nfdaltearl+_0sxidg6_]h
andler+0xd6]
# 1# 1[ k[iklillplgp+g0+x04x04]0
]
#2 [__poll+0x4f]
#2 [wait4+0x5d]
#3 [igt_fork_hang_detector+0x148]
#4 [__igt_unique____real_main432+0x1ccb]
#5 [main+0x27]
#3 [__igt_waitchildren+0x59]
#6 [__libc_start_main+0xf3]
#7 [_start+0x2a]
#4 [igt_waitchildren+0x9]
#5 [__igt_unique____real_main432+0x15e2]
#6 [main+0x27]
#7 [__libc_start_main+0xf3]
#8 [_start+0x2a]<6> [28.888086] Console: switching to colour dummy device 80x25
<6> [28.888155] [IGT] gem_busy: executing
<7> [28.896667] i915 0000:00:02.0: [drm:i915_gem_context_create_ioctl [i915]] HW context 1 created
<7> [28.896845] i915 0000:00:02.0: [drm:i915_gem_context_create_ioctl [i915]] HW context 1 created
<6> [28.903577] [IGT] gem_busy: starting subtest close-race
<7> [28.903657] i915 0000:00:02.0: [drm:i915_gem_context_create_ioctl [i915]] HW context 2 created
<7> [28.903794] i915 0000:00:02.0: [drm:i915_gem_context_create_ioctl [i915]] HW context 2 created
<6> [28.918032] [drm] Initialized vgem 1.0.0 20120112 for vgem on minor 1
<6> [28.940772] gem_busy (1042): drop_caches: 4
<5> [30.517471] sched: RT throttling activated
<3> [99.661472] rcu: INFO: rcu_preempt detected stalls on CPUs/tasks:
<3> [99.661476] rcu: Tasks blocked on level-0 rcu_node (CPUs 0-7): P1050
<4> [99.661482] (detected by 7, t=65002 jiffies, g=9209, q=147654 ncpus=8)
<6> [99.661485] task:gem_busy state:R running task stack:13880 pid: 1050 ppid: 1042 flags:0x00004000
<6> [99.661498] Call Trace:
<6> [99.661499] <TASK>
<6> [99.661500] ? asm_sysvec_apic_timer_interrupt+0x1b/0x20
<6> [99.661506] ? lockdep_hardirqs_on+0xbf/0x130
<6> [99.661510] ? asm_sysvec_apic_timer_interrupt+0x1b/0x20
<6> [99.661523] ? rcu_read_lock_held+0x4d/0x60
<6> [99.661529] ? i915_gem_busy_ioctl+0x189/0x830 [i915]
<6> [99.661665] ? dma_resv_iter_walk_unlocked.part.12+0x174/0x1b0
<6> [99.661670] ? dma_resv_iter_first_unlocked+0x5f/0x200
<6> [99.661673] ? i915_gem_busy_ioctl+0xbc/0x830 [i915]
<6> [99.661781] ? intel_gt_gmch_gen5_enable_hw+0x20/0x20 [i915]
<6> [99.661885] ? drm_ioctl_kernel+0xae/0x140
<6> [99.661891] ? drm_ioctl+0x201/0x3d0
<6> [99.661895] ? intel_gt_gmch_gen5_enable_hw+0x20/0x20 [i915]
<6> [99.661997] ? lockdep_hardirqs_on+0xbf/0x130
<6> [99.662000] ? asm_sysvec_apic_timer_interrupt+0x1b/0x20
<6> [99.662010] ? __x64_sys_ioctl+0x6d/0xa0
<6> [99.662015] ? do_syscall_64+0x3a/0x80
<6> [99.662017] ? entry_SYSCALL_64_after_hwframe+0x46/0xb0
<6> [99.662028] </TASK>
<3> [124.260506] INFO: task kworker/u16:6:103 blocked for more than 61 seconds.
<3> [124.260565] Tainted: G W 5.19.0-rc1-CI_DRM_11735-g91c98907ae64+ #1
<3> [124.260596] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message.
<6> [124.260626] task:kworker/u16:6 state:D stack:12288 pid: 103 ppid: 2 flags:0x00004000
<6> [124.260633] Workqueue: netns cleanup_net
<6> [124.260640] Call Trace:
<6> [124.260642] <TASK>
<6> [124.260646] __schedule+0x483/0xb40
<6> [124.260656] ? wait_for_completion+0x7e/0x150
<6> [124.260661] schedule+0x3f/0xa0
<6> [124.260664] schedule_timeout+0x233/0x2e0
<6> [124.260670] ? mark_held_locks+0x48/0x70
<6> [124.260676] ? _raw_spin_unlock_irq+0x1f/0x40
<6> [124.260681] ? wait_for_completion+0x7e/0x150
<6> [124.260684] wait_for_completion+0xb0/0x150
<6> [124.260691] rcu_barrier+0x1ec/0x2c0