igt@i915_selftest@live@hangcheck - incomplete - Wait for request .* failed: -62! igt_reset_active_engine failed with error -5
<6> [397.931885] rcs0: Completed 310 idle resets
<6> [398.434357] bcs0: Completed 291 idle resets
<6> [398.935717] vcs0: Completed 284 idle resets
<6> [399.437256] vecs0: Completed 291 idle resets
<6> [399.437540] i915: Running intel_hangcheck_live_selftests/igt_reset_active_engine
<3> [410.198817] [rcs0] Wait for request 55613:350 [0xFFFF] failed: -62!
<6> [410.198856] rcs0: Completed 175 active resets
<0> [416.683501] i915_sel-5504 0b.... 397395667us : execlists_reset_finish: 0000:00:02.0 vecs0: depth->0
<0> [416.683601] i915_sel-5504 0b.... 397395671us : __intel_engine_reset_bh: 0000:00:02.0 vecs0: flags=100000
<0> [416.683696] i915_sel-5504 0b.... 397395816us : execlists_reset_prepare: 0000:00:02.0 vecs0: depth<-0
<0> [416.683790] i915_sel-5504 0b.... 397395816us : intel_engine_stop_cs: 0000:00:02.0 vecs0:
<0> [416.683890] i915_sel-5504 0b.... 397395824us : __intel_gt_reset: 0000:00:02.0 engine_mask=40000
<0> [416.683986] i915_sel-5504 0b.... 397395842us : execlists_reset_rewind: 0000:00:02.0 vecs0:
<0> [416.684079] i915_sel-5504 0b.... 397396485us : active_context.part.38: 0000:00:02.0 vecs0: ccid:0 not found
<0> [416.684174] i915_sel-5504 0b.... 397397368us : intel_engine_cancel_stop_cs: 0000:00:02.0 vecs0:
<0> [416.684268] i915_sel-5504 0b.... 397397368us : execlists_reset_finish: 0000:00:02.0 vecs0: depth->00> [417.562037] <idle>-0 0..s1. 411541692us : rps_timer: 0000:00:02.0 busy:21002184 [99%], max:[21002184, 0, 0], interval:20
<0> [417.562137] <idle>-0 0..s1. 411562691us : rps_timer: 0000:00:02.0 busy:20999267 [100%], max:[20999267, 0, 0], interval:20
<0> [417.562348] i915_sel-5504 0..... 411572435us : igt_flush_test: __igt_reset_engine+0x13e/0x470 [i915] timed out.
<0> [417.562354] ---------------------------------
<7> [417.586699] intel_gt_set_wedged called from igt_flush_test+0xcb/0xd0 [i915]
<7> [417.587177] intel_gt_set_wedged rcs0
<7> [417.587181] intel_gt_set_wedged Awake? 3
<7> [417.587185] intel_gt_set_wedged Barriers?: no
<7> [417.587188] intel_gt_set_wedged Latency: 184us
<7> [417.587255] intel_gt_set_wedged Runtime: 18266ms
<7> [417.587259] intel_gt_set_wedged Forcewake: 0 domains, 0 active
<7> [417.587263] intel_gt_set_wedged Heartbeat: 7388 ms ago
<7> [417.587325] intel_gt_set_wedged Reset count: 874 (global 45)
<7> [417.587328] intel_gt_set_wedged Properties:
<7> [417.587331] intel_gt_set_wedged heartbeat_interval_ms: 2500 [default 2500]
<7> [417.587335] intel_gt_set_wedged max_busywait_duration_ns: 8000 [default 8000]
<7> [417.587338] intel_gt_set_wedged preempt_timeout_ms: 640 [default 640]
<7> [417.587342] intel_gt_set_wedged stop_timeout_ms: 100 [default 100]
<7> [417.587345] intel_gt_set_wedged timeslice_duration_ms: 1 [default 1]
<7> [417.587398] intel_gt_set_wedged Requests:
<7> [417.588826] intel_gt_set_wedged hungE d93d:350*- prio=0 @ 17670ms:
<7> [417.588832] intel_gt_set_wedged ring->start: 0x00085000
<7> [417.588836] intel_gt_set_wedged ring->head: 0x00001c40
<7> [417.588839] intel_gt_set_wedged ring->tail: 0x00001d00
<7> [417.588841] intel_gt_set_wedged ring->emit: 0x00001d08
<7> [417.588844] intel_gt_set_wedged ring->space: 0x000021b0
<7> [417.588846] intel_gt_set_wedged ring->hwsp: 0xfffe2000
<7> [417.588849] intel_gt_set_wedged [head 1c80, postfix 1cc8, tail 1d08, batch 0xffffffff_ffffffff]:
<7> [417.588939] intel_gt_set_wedged [0000] 7a000004 20344c1c 000000d0 00000000 00000000 00000000 10400002 fffe2000<3> [417.749620] i915/intel_hangcheck_live_selftests: igt_reset_active_engine failed with error -5
<7> [417.749646] i915 0000:00:02.0: [drm:intel_power_well_enable [i915]] enabling DC_off
<7> [417.750254] i915 0000:00:02.0: [drm:gen9_set_dc_state.part.15 [i915]] Setting DC state from 02 to 00
<7> [417.751167] i915 0000:00:02.0: [drm:icl_verify_procmon_ref_values [i915]] Combo PHY A Voltage/Process Info : 0.85V dot0 (low-voltage)
<7> [417.751383] i915 0000:00:02.0: [drm:icl_combo_phys_init [i915]] Combo PHY A already enabled, won't reprogram it.
<7> [417.751583] i915 0000:00:02.0: [drm:icl_verify_procmon_ref_values [i915]] Combo PHY B Voltage/Process Info : 0.85V dot0 (low-voltage)
<7> [417.751975] i915 0000:00:02.0: [drm:icl_combo_phys_init [i915]] Combo PHY B already enabled, won't reprogram it.
<7> [417.752176] i915 0000:00:02.0: [drm:icl_verify_procmon_ref_values [i915]] Combo PHY C Voltage/Process Info : 0.85V dot0 (low-voltage)
<7> [417.752377] i915 0000:00:02.0: [drm:icl_combo_phys_init [i915]] Combo PHY C already enabled, won't reprogram it.
<7> [417.752565] i915 0000:00:02.0: [drm:intel_power_well_enable [i915]] enabling PW_2
<7> [417.757634] i915 0000:00:02.0: [drm:intel_power_well_enable [i915]] enabling PW_3
<7> [417.757861] i915 0000:00:02.0: [drm:intel_power_well_enable [i915]] enabling PW_4
<7> [417.935325] i915 0000:00:02.0: [drm:drm_client_release] drm_fb_helper
<4> [418.003015] i915: probe of 0000:00:02.0 failed with error -5
<4> [418.014642] ------------[ cut here ]------------
<4> [418.014647] WARNING: CPU: 0 PID: 5504 at drivers/gpu/drm/i915/intel_memory_region.c:289 intel_memory_region_destroy+0x2e/0x60 [i915]
<4> [418.014836] Modules linked in: i915(+) drm_display_helper drm_kms_helper vgem drm_shmem_helper fuse snd_hda_codec_hdmi snd_hda_codec_realtek snd_hda_codec_generic ledtrig_audio x86_pkg_temp_thermal coretemp kvm_intel kvm snd_intel_dspcfg snd_hda_codec snd_hwdep irqbypass crct10dif_pclmul crc32_pclmul snd_hda_core ghash_clmulni_intel snd_pcm r8169 i2c_i801 realtek i2c_smbus intel_lpss_pci ttm drm_buddy syscopyarea sysfillrect sysimgblt fb_sys_fops prime_numbers [last unloaded: i915]
<4> [418.014907] CPU: 0 PID: 5504 Comm: i915_selftest Tainted: G U W 5.18.0-rc7-CI_DRM_11678-gc746ef6a479d+ #1
<4> [418.014911] Hardware name: Intel Corporation Jasper Lake Client Platform/Jasperlake DDR4 SODIMM RVP, BIOS JSLSFWI1.R00.2385.D02.2010160831 10/16/2020
<4> [418.014914] RIP: 0010:intel_memory_region_destroy+0x2e/0x60 [i915]
<4> [418.015067] Code: 48 8b 47 08 48 89 fb 48 8b 40 10 48 85 c0 74 07 ff d0 0f 1f 00 89 c5 48 8b 83 48 01 00 00 48 8d 93 48 01 00 00 48 39 d0 74 1f <0f> 0b 48 8d bb b8 00 00 00 e8 84 10 d8 e0 85 ed 74 03 5b 5d c3 48
<4> [418.015071] RSP: 0018:ffffc90000feba88 EFLAGS: 00010216
<4> [418.015075] RAX: ffff8881a681ce30 RBX: ffff88810a92a000 RCX: 0000000000000001
<4> [418.015078] RDX: ffff88810a92a148 RSI: ffffffff822e5b48 RDI: 00000000ffffffff
<4> [418.015081] RBP: 0000000000000000 R08: ffff88811ef509d0 R09: 00000000fffffffe
<4> [418.015083] R10: 000000001e291109 R11: 00000000ffb7d9ae R12: ffff8881072222d8
<4> [418.015086] R13: ffff8881072232c8 R14: ffffffff828745f8 R15: ffffffff822e0d58
<4> [418.015088] FS: 00007ff8c3ed6c00(0000) GS:ffff88885fc00000(0000) knlGS:0000000000000000
<4> [418.015092] CS: 0010 DS: 0000 ES: 0000 CR0: 0000000080050033
<4> [418.015094] CR2: 0000559132384130 CR3: 000000010fcca000 CR4: 0000000000350ef0
<4> [418.015097] Call Trace:
<4> [418.015101] <TASK>
<4> [418.015105] intel_memory_regions_driver_release+0x24/0x30 [i915]
<4> [418.015257] i915_driver_release+0x40/0xc0 [i915]
<4> [418.015408] drm_dev_release+0x1b/0x40
<4> [418.015415] release_nodes+0x41/0x130
<4> [418.015424] devres_release_all+0x83/0xb0
<4> [418.015433] device_unbind_cleanup+0x9/0x70
<4> [418.015437] really_probe+0xf6/0x330
<4> [418.015443] __driver_probe_device+0xf6/0x170
<4> [418.015448] driver_probe_device+0x1a/0x90
<4> [418.015453] __driver_attach+0x93/0x160
<4> [418.015456] ? __device_attach_driver+0xd0/0xd0
<4> [418.015460] ? __device_attach_driver+0xd0/0xd0
<4> [418.015463] bus_for_each_dev+0x72/0xc0
<4> [418.015472] bus_add_driver+0x14b/0x1f0
<4> [418.015478] driver_register+0x66/0xb0
<4> [418.015482] i915_init+0x1f/0x7e [i915]
<4> [418.015864] ? 0xffffffffa07b1000
<4> [418.015869] do_one_initcall+0x53/0x2e0
<4> [418.015874] ? do_init_module+0x1d/0x1e0
<4> [418.015881] ? rcu_read_lock_sched_held+0x4d/0x80
<4> [418.015887] ? kmem_cache_alloc_trace+0x1de/0x250
<4> [418.015896] do_init_module+0x45/0x1e0
<4> [418.015902] load_module+0x273c/0x29c0
<4> [418.015928] ? __do_sys_finit_module+0xaf/0x120
<4> [418.015932] __do_sys_finit_module+0xaf/0x120
<4> [418.015949] do_syscall_64+0x37/0x80
<4> [418.015955] entry_SYSCALL_64_after_hwframe+0x44/0xae
<4> [418.015959] RIP: 0033:0x7ff8c5d2989d
<4> [418.015963] Code: 00 c3 66 2e 0f 1f 84 00 00 00 00 00 90 f3 0f 1e fa 48 89 f8 48 89 f7 48 89 d6 48 89 ca 4d 89 c2 4d 89 c8 4c 8b 4c 24 08 0f 05 <48> 3d 01 f0 ff ff 73 01 c3 48 8b 0d c3 f5 0c 00 f7 d8 64 89 01 48
<4> [418.015967] RSP: 002b:00007ffd4c56e968 EFLAGS: 00000246 ORIG_RAX: 0000000000000139
<4> [418.015972] RAX: ffffffffffffffda RBX: 000055a04c4e8160 RCX: 00007ff8c5d2989d
<4> [418.015975] RDX: 0000000000000000 RSI: 000055a04c4f3d20 RDI: 0000000000000006
<4> [418.015977] RBP: 0000000000000020 R08: 6173696420312d3d R09: 000055a04c4dc5e0
<4> [418.015980] R10: 7374736574666c65 R11: 0000000000000246 R12: 000055a04c4f3d20
<4> [418.015982] R13: 0000000000000000 R14: 000055a04c4f2e80 R15: 000055a04c4e8160
<4> [418.015998] </TASK>
<4> [418.016000] irq event stamp: 66149621
<4> [418.016002] hardirqs last enabled at (66149627): [<ffffffff8112dbb2>] __up_console_sem+0x62/0x70
<4> [418.016008] hardirqs last disabled at (66149632): [<ffffffff8112db97>] __up_console_sem+0x47/0x70
<4> [418.016012] softirqs last enabled at (66149486): [<ffffffff81e0032d>] __do_softirq+0x32d/0x493
<4> [418.016016] softirqs last disabled at (66149477): [<ffffffff810b8c16>] irq_exit_rcu+0xa6/0xe0
<4> [418.016020] ---[ end trace 0000000000000000 ]---Edited by LAKSHMINARAYANA VUDUM