igt@kms_universal_plane@universal-plane-functional@pipe-c-dp-2 on shard-bmg@xe-4887-afe01cbdd453cb1b141b29ea6153f64ef0f151fb Test details

Results for igt@kms_universal_plane@universal-plane-functional@pipe-c-dp-2

Detail	Value
Duration	unknown
Hostname	shard-bmg-2
Igt-Version	IGT-Version: 2.4-g93abaf017 (x86_64) (Linux: 7.0.0-rc7-lgci-xe-xe-4887-afe01cbdd453cb1b1-debug+ x86_64)
Out	Starting dynamic subtest: pipe-C-DP-2 Stack trace: #0 ../lib/igt_core.c:2075 __igt_fail_assert() #1 [get_intel_driver+0x5c] #2 ../lib/intel_allocator.c:919 __intel_allocator_open_full() #3 ../lib/intel_allocator.c:1055 intel_allocator_open_full() #4 ../lib/igt_fb.c:3141 setup_context_and_memory_region.constprop.0() #5 ../lib/igt_fb.c:3236 blitcopy() #6 ../lib/igt_fb.c:3448 setup_linear_mapping() #7 ../lib/igt_fb.c:2565 create_cairo_surface__gpu() #8 ../lib/igt_fb.c:4817 igt_get_cairo_surface() #9 ../lib/igt_fb.c:4840 igt_get_cairo_ctx() #10 ../lib/igt_fb.c:2327 igt_create_color_fb() #11 ../tests/kms_universal_plane.c:111 run_tests() #12 ../tests/kms_universal_plane.c:934 __igt_unique____real_main916() #13 ../tests/kms_universal_plane.c:916 main() #14 [__libc_init_first+0x8a] #15 [__libc_start_main+0x8b] #16 [_start+0x25] Dynamic subtest pipe-C-DP-2: FAIL (20.616s) Stack trace: #0 ../lib/igt_core.c:2075 __igt_fail_assert() #1 ../lib/igt_kms.c:4308 igt_mode_object_get_prop_enum_value() #2 ../lib/igt_kms.c:4339 igt_plane_try_prop_enum() #3 ../lib/igt_kms.c:4360 igt_plane_set_prop_enum() #4 ../lib/igt_kms.c:2678 igt_display_reset() #5 ../tests/kms_universal_plane.c:829 run_tests() #6 ../tests/kms_universal_plane.c:934 __igt_unique____real_main916() #7 ../tests/kms_universal_plane.c:916 main() #8 [__libc_init_first+0x8a] #9 [__libc_start_main+0x8b] #10 [_start+0x25] Subtest universal-plane-functional: FAIL (24.884s) This test caused an abort condition: Kernel badly tainted (0x4244, 0x200) (check dmesg for details): TAINT_WARN: WARN_ON has happened.
Err	Starting dynamic subtest: pipe-C-DP-2 (kms_universal_plane:11230) drmtest-CRITICAL: Test assertion failure function get_intel_driver, file ../lib/drmtest.c:178: (kms_universal_plane:11230) drmtest-CRITICAL: Failed assertion: 0 (kms_universal_plane:11230) drmtest-CRITICAL: Last errno: 125, Operation canceled (kms_universal_plane:11230) drmtest-CRITICAL: Device is not handled by Intel driver Dynamic subtest pipe-C-DP-2 failed. ** DEBUG (kms_universal_plane:11230) igt_kms-DEBUG: display: DP-2: set_crtc(C) (kms_universal_plane:11230) igt_kms-DEBUG: display: DP-2: Selecting CRTC C (kms_universal_plane:11230) igt_fb-DEBUG: igt_create_fb_with_bo_size(width=1920, height=1080, format=XR24(0x34325258), modifier=0x0, size=0) (kms_universal_plane:11230) igt_fb-DEBUG: igt_create_fb_with_bo_size(handle=5, pitch=7680) (kms_universal_plane:11230) ioctl_wrappers-DEBUG: Test requirement passed: igt_has_fb_modifiers(fd) (kms_universal_plane:11230) intel_allocator_simple-DEBUG: Using simple allocator (kms_universal_plane:11230) drmtest-CRITICAL: Test assertion failure function get_intel_driver, file ../lib/drmtest.c:178: (kms_universal_plane:11230) drmtest-CRITICAL: Failed assertion: 0 (kms_universal_plane:11230) drmtest-CRITICAL: Last errno: 125, Operation canceled (kms_universal_plane:11230) drmtest-CRITICAL: Device is not handled by Intel driver (kms_universal_plane:11230) igt_core-INFO: Stack trace: (kms_universal_plane:11230) igt_core-INFO: #0 ../lib/igt_core.c:2075 __igt_fail_assert() (kms_universal_plane:11230) igt_core-INFO: #1 [get_intel_driver+0x5c] (kms_universal_plane:11230) igt_core-INFO: #2 ../lib/intel_allocator.c:919 __intel_allocator_open_full() (kms_universal_plane:11230) igt_core-INFO: #3 ../lib/intel_allocator.c:1055 intel_allocator_open_full() (kms_universal_plane:11230) igt_core-INFO: #4 ../lib/igt_fb.c:3141 setup_context_and_memory_region.constprop.0() (kms_universal_plane:11230) igt_core-INFO: #5 ../lib/igt_fb.c:3236 blitcopy() (kms_universal_plane:11230) igt_core-INFO: #6 ../lib/igt_fb.c:3448 setup_linear_mapping() (kms_universal_plane:11230) igt_core-INFO: #7 ../lib/igt_fb.c:2565 create_cairo_surface__gpu() (kms_universal_plane:11230) igt_core-INFO: #8 ../lib/igt_fb.c:4817 igt_get_cairo_surface() (kms_universal_plane:11230) igt_core-INFO: #9 ../lib/igt_fb.c:4840 igt_get_cairo_ctx() (kms_universal_plane:11230) igt_core-INFO: #10 ../lib/igt_fb.c:2327 igt_create_color_fb() (kms_universal_plane:11230) igt_core-INFO: #11 ../tests/kms_universal_plane.c:111 run_tests() (kms_universal_plane:11230) igt_core-INFO: #12 ../tests/kms_universal_plane.c:934 __igt_unique____real_main916() (kms_universal_plane:11230) igt_core-INFO: #13 ../tests/kms_universal_plane.c:916 main() (kms_universal_plane:11230) igt_core-INFO: #14 [__libc_init_first+0x8a] (kms_universal_plane:11230) igt_core-INFO: #15 [__libc_start_main+0x8b] (kms_universal_plane:11230) igt_core-INFO: #16 [_start+0x25] END ** Dynamic subtest pipe-C-DP-2: FAIL (20.616s) (kms_universal_plane:11230) igt_kms-CRITICAL: Test assertion failure function igt_mode_object_get_prop_enum_value, file ../lib/igt_kms.c:4309: (kms_universal_plane:11230) igt_kms-CRITICAL: Failed assertion: prop (kms_universal_plane:11230) igt_kms-CRITICAL: Last errno: 125, Operation canceled Subtest universal-plane-functional: FAIL (24.884s)
Dmesg Scroll to first warning	<6> [571.780513] [IGT] kms_universal_plane: starting dynamic subtest pipe-C-DP-2 <7> [571.781027] xe 0000:03:00.0: [drm:drm_mode_addfb2] [FB:564] <3> [574.039445] xe 0000:03:00.0: [drm] ERROR TLB invalidation fence timeout, seqno=52522 recv=52521 <3> [576.342283] xe 0000:03:00.0: [drm] ERROR TLB invalidation fence timeout, seqno=52522 recv=52521 <4> [576.853895] xe 0000:03:00.0: [drm] Tile0: GT0: Check job timeout: seqno=91031, lrc_seqno=91031, guc_id=0, not started <6> [576.966571] pcieport 0000:00:06.0: AER: Multiple Correctable error message received from 0000:05:00.0 <4> [576.966596] nvme 0000:05:00.0: PCIe Bus Error: severity=Correctable, type=Physical Layer, (Receiver ID) <4> [576.966606] nvme 0000:05:00.0: device [15b7:5017] error status/mask=00000001/0000e000 <4> [576.966616] nvme 0000:05:00.0: [ 0] RxErr (First) <3> [578.647333] xe 0000:03:00.0: [drm] ERROR TLB invalidation fence timeout, seqno=52523 recv=52521 <7> [580.387092] xe 0000:03:00.0: [drm:xe_hwmon_read [xe]] thermal data for group 0 val 0x2b2c2829 <7> [580.387448] xe 0000:03:00.0: [drm:xe_hwmon_read [xe]] thermal data for group 1 val 0x2b2c2b2c <3> [580.949794] xe 0000:03:00.0: [drm] ERROR TLB invalidation fence timeout, seqno=52523 recv=52521 <6> [581.065044] pcieport 0000:00:06.0: AER: Multiple Correctable error message received from 0000:05:00.0 <4> [581.065070] nvme 0000:05:00.0: PCIe Bus Error: severity=Correctable, type=Physical Layer, (Receiver ID) <4> [581.065080] nvme 0000:05:00.0: device [15b7:5017] error status/mask=00000001/0000e000 <4> [581.065089] nvme 0000:05:00.0: [ 0] RxErr (First) <4> [581.973759] xe 0000:03:00.0: [drm] Tile0: GT0: Check job timeout: seqno=91031, lrc_seqno=91031, guc_id=0, not started <3> [583.253685] xe 0000:03:00.0: [drm] ERROR TLB invalidation fence timeout, seqno=52524 recv=52521 <3> [585.557877] xe 0000:03:00.0: [drm] ERROR TLB invalidation fence timeout, seqno=52524 recv=52521 <6> [585.676721] pcieport 0000:00:06.0: AER: Multiple Correctable error message received from 0000:05:00.0 <4> [585.676747] nvme 0000:05:00.0: PCIe Bus Error: severity=Correctable, type=Physical Layer, (Receiver ID) <4> [585.676757] nvme 0000:05:00.0: device [15b7:5017] error status/mask=00000001/0000e000 <4> [585.676767] nvme 0000:05:00.0: [ 0] RxErr (First) <4> [587.093722] xe 0000:03:00.0: [drm] Tile0: GT0: Check job timeout: seqno=91031, lrc_seqno=91031, guc_id=0, not started <4> [592.213687] xe 0000:03:00.0: [drm] Tile0: GT0: Schedule disable failed to respond, guc_id=0 <7> [592.213712] xe 0000:03:00.0: [drm:xe_devcoredump [xe]] Multiple hangs are occurring, but only the first snapshot was taken <6> [592.214103] xe 0000:03:00.0: [drm] Tile0: GT0: trying reset from guc_exec_queue_timedout_job [xe] <6> [592.214614] xe 0000:03:00.0: [drm] Tile0: GT0: reset queued <3> [592.214699] xe 0000:03:00.0: [drm] ERROR TLB invalidation fence timeout, seqno=52525 recv=52521 <6> [592.223583] xe 0000:03:00.0: [drm] Tile0: GT0: reset started <7> [592.223645] xe 0000:03:00.0: [drm:guc_ct_change_state [xe]] Tile0: GT0: GuC CT communication channel stopped <7> [592.223856] xe 0000:03:00.0: [drm:xe_reg_sr_apply_mmio [xe]] Tile0: GT0: Applying GT save-restore MMIOs <7> [592.223946] xe 0000:03:00.0: [drm:xe_reg_sr_apply_mmio [xe]] Tile0: GT0: REG[0x4148] = 0x00000000 <7> [592.224035] xe 0000:03:00.0: [drm:xe_reg_sr_apply_mmio [xe]] Tile0: GT0: REG[0x8828] = 0x00800000 <7> [592.224121] xe 0000:03:00.0: [drm:xe_reg_sr_apply_mmio [xe]] Tile0: GT0: REG[0xb0c8] = 0x11111440 <7> [592.224205] xe 0000:03:00.0: [drm:xe_reg_sr_apply_mmio [xe]] Tile0: GT0: REG[0xb104] = 0x08104440 <7> [592.224287] xe 0000:03:00.0: [drm:xe_reg_sr_apply_mmio [xe]] Tile0: GT0: REG[0xb108] = 0x30200000 <7> [592.224370] xe 0000:03:00.0: [drm:xe_reg_sr_apply_mmio [xe]] Tile0: GT0: REG[0xb158] = 0x0000007f <7> [592.224470] xe 0000:03:00.0: [drm:xe_reg_sr_apply_mmio [xe]] Tile0: GT0: REG[0xe7cc] = 0x00000100 <7> [592.224557] xe 0000:03:00.0: [drm:xe_wopcm_init [xe]] WOPCM: 4096K <7> [592.224660] xe 0000:03:00.0: [drm:xe_wopcm_init [xe]] GuC WOPCM is already locked [6144K, 832K) <7> [592.224776] xe 0000:03:00.0: [drm:guc_ct_change_state [xe]] Tile0: GT0: GuC CT communication channel disabled <7> [592.225784] xe 0000:03:00.0: [drm:xe_guc_ads_populate [xe]] Tile0: GT0: Updated ADS capture size 20480 (was 49152) <3> [592.236646] xe 0000:03:00.0: [drm] ERROR Tile0: GT0: load failed: status = 0x400000A0, time = 10ms, freq = 2150MHz (req 2133MHz) <3> [592.248791] xe 0000:03:00.0: [drm] ERROR Tile0: GT0: load failed: status: Reset = 0, BootROM = 0x50, UKernel = 0x00, MIA = 0x00, Auth = 0x01 <3> [592.261537] xe 0000:03:00.0: [drm] ERROR Tile0: GT0: firmware signature verification failed <3> [592.270066] xe 0000:03:00.0: [drm] ERROR Tile0: GT0: reset failed (-EPROTO) <3> [592.277195] xe 0000:03:00.0: [drm] ERROR CRITICAL: Xe has declared device 0000:03:00.0 as wedged. IOCTLs and executions are blocked. For recovery procedure, refer to https://docs.kernel.org/gpu/drm-uapi.html#device-wedging Please file a _new_ bug report at https://gitlab.freedesktop.org/drm/xe/kernel/issues/new <7> [592.308973] xe 0000:03:00.0: [drm:guc_ct_change_state [xe]] Tile0: GT0: GuC CT communication channel stopped <7> [592.309071] xe 0000:03:00.0: [drm:guc_ct_change_state [xe]] Tile0: GT1: GuC CT communication channel stopped <3> [592.376982] xe 0000:03:00.0: [drm] ERROR Tile0: GT1: GuC mmio request 0x5507: no reply 0x5507 <6> [592.386720] xe 0000:03:00.0: [drm] device wedged, needs recovery <4> [592.387820] ------------[ cut here ]------------ <4> [592.387828] xe 0000:03:00.0: [drm] Tile0: GT0: Kernel-submitted job timed out <4> [592.387838] WARNING: drivers/gpu/drm/xe/xe_guc_submit.c:1626 at guc_exec_queue_timedout_job+0x1424/0x2400 [xe], CPU#2: kworker/u64:49/4517 <4> [592.388294] Modules linked in: snd_hda_codec_intelhdmi snd_hda_codec_hdmi pmt_crashlog mei_lb mei_gsc_proxy mtd_intel_dg mei_gsc xe drm_gpuvm drm_gpusvm_helper drm_buddy drm_ttm_helper ttm gpu_sched drm_suballoc_helper drm_exec drm_display_helper cec rc_core drm_kunit_helpers i2c_algo_bit kunit intel_rapl_msr intel_rapl_common intel_uncore_frequency intel_uncore_frequency_common binfmt_misc intel_tcc_cooling x86_pkg_temp_thermal intel_powerclamp hid_generic eeepc_wmi coretemp cmdlinepart asus_wmi sparse_keymap spi_nor platform_profile mei_pxp mei_hdcp mtd wmi_bmof kvm_intel kvm usbhid irqbypass video ghash_clmulni_intel hid aesni_intel snd_intel_dspcfg rapl snd_hda_codec r8169 snd_hda_core intel_cstate snd_hwdep nls_iso8859_1 snd_pcm realtek snd_timer i2c_i801 idma64 snd mei_me i2c_mux spi_intel_pci soundcore i2c_smbus spi_intel intel_pmc_core mei pmt_telemetry wmi pmt_discovery pmt_class intel_pmc_ssram_telemetry pinctrl_alderlake acpi_pad intel_vsec acpi_tad dm_multipath msr nvme_fabrics fuse efi_pstore nfnetlink <4> [592.388672] autofs4 [last unloaded: snd_hda_intel] <4> [592.388695] CPU: 2 UID: 0 PID: 4517 Comm: kworker/u64:49 Tainted: G S U L 7.0.0-rc7-lgci-xe-xe-4887-afe01cbdd453cb1b1-debug+ #1 PREEMPT(lazy) <4> [592.388711] Tainted: [S]=CPU_OUT_OF_SPEC, [U]=USER, [L]=SOFTLOCKUP <4> [592.388717] Hardware name: ASUS System Product Name/PRIME Z790-P WIFI, BIOS 1645 03/15/2024 <4> [592.388725] Workqueue: gt-ordered-wq drm_sched_job_timedout [gpu_sched] <4> [592.388754] RIP: 0010:guc_exec_queue_timedout_job+0x142d/0x2400 [xe] <4> [592.389147] Code: 74 04 48 8b 7f 08 4c 8b 6f 50 4d 85 ed 75 03 4c 8b 2f e8 36 d5 5e e1 48 89 c6 48 8d 3d 6c 95 39 00 41 89 d8 44 89 e1 4c 89 ea <67> 48 0f b9 3a 48 8b 45 90 48 8b 40 60 e9 c6 ee ff ff 8b 70 08 49 <4> [592.389156] RSP: 0018:ffffc9000c09fca0 EFLAGS: 00010246 <4> [592.389168] RAX: ffffffffa120304b RBX: 0000000000000000 RCX: 0000000000000000 <4> [592.389176] RDX: ffff888103e20910 RSI: ffffffffa120304b RDI: ffffffffa1003ee0 <4> [592.389182] RBP: ffffc9000c09fdb0 R08: 0000000000000000 R09: 0000000000000000 <4> [592.389189] R10: 0000000000000000 R11: 0000000000000000 R12: 0000000000000000 <4> [592.389195] R13: ffff888103e20910 R14: ffff888167f50818 R15: 00000000ffffffc2 <4> [592.389202] FS: 0000000000000000(0000) GS:ffff8888dad97000(0000) knlGS:0000000000000000 <4> [592.389210] CS: 0010 DS: 0000 ES: 0000 CR0: 0000000080050033 <4> [592.389217] CR2: 00007ec03ce08000 CR3: 000000000344c005 CR4: 0000000000f72ef0 <4> [592.389225] PKRU: 55555554 <4> [592.389231] Call Trace: <4> [592.389237] <TASK> <4> [592.389258] ? lock_sync+0x100/0x100 <4> [592.389283] ? lock_release+0xd0/0x2b0 <4> [592.389313] drm_sched_job_timedout+0x94/0x1a0 [gpu_sched] <4> [592.389342] process_one_work+0x239/0x760 <4> [592.389375] worker_thread+0x200/0x3f0 <4> [592.389389] ? __pfx_worker_thread+0x10/0x10 <4> [592.389419] kthread+0x10d/0x150 <4> [592.389435] ? __pfx_kthread+0x10/0x10 <4> [592.389454] ret_from_fork+0x3d4/0x480 <4> [592.389465] ? __pfx_kthread+0x10/0x10 <4> [592.389482] ret_from_fork_asm+0x1a/0x30 <4> [592.389521] </TASK> <4> [592.389527] irq event stamp: 421131 <4> [592.389534] hardirqs last enabled at (421137): [<ffffffff814aacd9>] __up_console_sem+0x79/0xa0 <4> [592.389550] hardirqs last disabled at (421142): [<ffffffff814aacbe>] __up_console_sem+0x5e/0xa0 <4> [592.389562] softirqs last enabled at (420520): [<ffffffff813d1e9f>] __irq_exit_rcu+0x13f/0x160 <4> [592.389576] softirqs last disabled at (420515): [<ffffffff813d1e9f>] __irq_exit_rcu+0x13f/0x160 <4> [592.389588] ---[ end trace 0000000000000000 ]--- <6> [592.397265] [IGT] kms_universal_plane: finished subtest pipe-C-DP-2, FAIL <6> [592.402484] [IGT] kms_universal_plane: finished subtest universal-plane-functional, FAIL <7> [592.402941] xe 0000:03:00.0: [drm:drm_mode_rmfb_work_fn] Removing [FB:561] from all active usage due to RMFB ioctl <7> [592.403314] xe 0000:03:00.0: [drm:atomic_remove_fb] Disabling [PLANE:183:plane 2B] because [FB:561] is removed <7> [592.403380] xe 0000:03:00.0: [drm:skl_print_plane_ddb_changes [xe]] [PLANE:153:plane 1B] ddb ( 0 - 3980) -> ( 0 - 4037), size 3980 -> 4037 <7> [592.403572] xe 0000:03:00.0: [drm:skl_print_plane_ddb_changes [xe]] [PLANE:183:plane 2B] ddb (3980 - 4037) -> ( 0 - 0), size 57 -> 0 <7> [592.403707] xe 0000:03:00.0: [drm:skl_print_plane_wm_changes [xe]] [PLANE:183:plane 2B] level wm0,wm1,wm2,wm3,wm4,wm5, wm6, wm7,twm,swm,stwm -> wm0, wm1, wm2, wm3, wm4, wm5, wm6, wm7, twm, swm, stwm <7> [592.403833] xe 0000:03:00.0: [drm:skl_print_plane_wm_changes [xe]] [PLANE:183:plane 2B] lines 7, 7, 9, 9, 17, 17, 17, 17, 0, 15, 0 -> 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0 <7> [592.403962] xe 0000:03:00.0: [drm:skl_print_plane_wm_changes [xe]] [PLANE:183:plane 2B] blocks 14, 14, 19, 19, 35, 35, 35, 35, 28, 31, 45 -> 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0 <7> [592.404091] xe 0000:03:00.0: [drm:skl_print_plane_wm_changes [xe]] [PLANE:183:plane 2B] min_ddb 17, 17, 22, 22, 40, 40, 0, 0, 29, 36, 46 -> 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0 <7> [592.404258] xe 0000:03:00.0: [drm:intel_bw_atomic_check [xe]] [CRTC:269:pipe B] data rate 594000 num active planes 1 <7> [592.404435] xe 0000:03:00.0: [drm:intel_bw_atomic_check [xe]] QGV point 0: max bw 33600 required 624 qgv_peak_bw: 48000 <7> [592.404600] xe 0000:03:00.0: [drm:intel_bw_atomic_check [xe]] QGV point 1: max bw 53000 required 624 qgv_peak_bw: 48000 <7> [592.404761] xe 0000:03:00.0: [drm:intel_bw_atomic_check [xe]] Matching peaks QGV bw: 48000 for required data rate: 624 <7> [592.417285] xe 0000:03:00.0: [drm:drm_mode_rmfb_work_fn] Removing [FB:559] from all active usage due to RMFB ioctl <7> [592.417369] xe 0000:03:00.0: [drm:atomic_remove_fb] Disabling [PLANE:153:plane 1B] because [FB:559] is removed <7> [592.417472] xe 0000:03:00.0: [drm:skl_print_plane_ddb_changes [xe]] [PLANE:153:plane 1B] ddb ( 0 - 4037) -> ( 0 - 0), size 4037 -> 0 <7> [592.417715] xe 0000:03:00.0: [drm:skl_print_plane_wm_changes [xe]] [PLANE:153:plane 1B] level wm0,wm1,wm2,wm3,wm4,wm5, wm6, wm7,twm,swm,stwm -> wm0, wm1, wm2, wm3, wm4, wm5, wm6, wm7, twm, swm, stwm <7> [592.417921] xe 0000:03:00.0: [drm:skl_print_plane_wm_changes [xe]] [PLANE:153:plane 1B] lines 1, 3, 9, 9, 17, 17, 17, 17, 0, 15, 0 -> 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0 <7> [592.418116] xe 0000:03:00.0: [drm:skl_print_plane_wm_changes [xe]] [PLANE:153:plane 1B] blocks 16, 49, 145, 145, 273, 273, 273, 273, 30, 241, 255 -> 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0 <7> [592.418302] xe 0000:03:00.0: [drm:skl_print_plane_wm_changes [xe]] [PLANE:153:plane 1B] min_ddb 19, 55, 161, 161, 302, 302, 0, 0, 31, 267, 267 -> 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0 <7> [592.418530] xe 0000:03:00.0: [drm:intel_bw_atomic_check [xe]] [CRTC:269:pipe B] data rate 0 num active planes 0 <7> [592.418767] xe 0000:03:00.0: [drm:intel_bw_atomic_check [xe]] QGV point 0: max bw 33600 required 0 qgv_peak_bw: 48000 <7> [592.419002] xe 0000:03:00.0: [drm:intel_bw_atomic_check [xe]] QGV point 1: max bw 53000 required 0 qgv_peak_bw: 48000 <7> [592.419218] xe 0000:03:00.0: [drm:intel_bw_atomic_check [xe]] Matching peaks QGV bw: 48000 for required data rate: 0 <7> [592.434869] xe 0000:03:00.0: [drm:intel_dp_compute_config_limits [xe]] [ENCODER:526:DDI TC2/PHY G][CRTC:151:pipe A] DP link limits: pixel clock 148500 kHz DSC off max lanes 4 max rate 540000 max pipe_bpp 36 min link_bpp 18.0000 max link_bpp 36.0000 <7> [592.435220] xe 0000:03:00.0: [drm:intel_dp_compute_link_config [xe]] DP lane count 4 clock 270000 bpp input 36 compressed 0.0000 HDR no link rate required 668250 available 1080000 <7> [592.435595] xe 0000:03:00.0: [drm:intel_atomic_check [xe]] [CRTC:151:pipe A] hw max bpp: 36, pipe bpp: 36, dithering: 0 <7> [592.435958] xe 0000:03:00.0: [drm:intel_ddi_compute_config_late [xe]] [ENCODER:526:DDI TC2/PHY G] [CRTC:151:pipe A] <7> [592.436315] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:151:pipe A] fastset requirement not met in hw.enable (expected no, found yes) <7> [592.436727] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:151:pipe A] fastset requirement not met in hw.active (expected no, found yes) <7> [592.437112] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:151:pipe A] fastset requirement not met in cpu_transcoder (expected -1, found 0) <7> [592.437531] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:151:pipe A] fastset requirement not met in lane_count (expected 0, found 4) <7> [592.437902] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:151:pipe A] fastset requirement not met in dp_m_n (expected tu 0 data 0/0 link 0/0, found tu 64, data 5190451/8388608 link 288358/524288) <7> [592.438303] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:151:pipe A] fastset requirement not met in output_types (expected 0x00000000, found 0x00000080) <7> [592.438776] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:151:pipe A] fastset requirement not met in framestart_delay (expected 0, found 1) <7> [592.439174] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:151:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hdisplay (expected 0, found 1920) <7> [592.439569] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:151:pipe A] fastset requirement not met in hw.pipe_mode.crtc_htotal (expected 0, found 2200) <7> [592.439930] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:151:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hblank_start (expected 0, found 1920) <7> [592.440274] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:151:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hblank_end (expected 0, found 2200) <7> [592.440628] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:151:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hsync_start (expected 0, found 2008) <7> [592.440955] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:151:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hsync_end (expected 0, found 2052) <7> [592.441264] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:151:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vdisplay (expected 0, found 1080) <7> [592.441614] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:151:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vblank_start (expected 0, found 1080) <7> [592.441932] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:151:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vsync_start (expected 0, found 1084) <7> [592.442221] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:151:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vsync_end (expected 0, found 1089) <7> [592.442526] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:151:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vtotal (expected 0, found 1125) <7> [592.442789] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:151:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vblank_end (expected 0, found 1125) <7> [592.443052] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:151:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hdisplay (expected 0, found 1920) <7> [592.443304] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:151:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_htotal (expected 0, found 2200) <7> [592.443568] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:151:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hblank_start (expected 0, found 1920) <7> [592.443810] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:151:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hblank_end (expected 0, found 2200) <7> [592.444037] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:151:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hsync_start (expected 0, found 2008) <7> [592.444264] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:151:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hsync_end (expected 0, found 2052) <7> [592.444498] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:151:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vdisplay (expected 0, found 1080) <7> [592.444710] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:151:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vblank_start (expected 0, found 1080) <7> [592.444919] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:151:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vsync_start (expected 0, found 1084) <7> [592.445134] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:151:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vsync_end (expected 0, found 1089) <7> [592.445332] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:151:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vtotal (expected 0, found 1125) <7> [592.445668] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:151:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vblank_end (expected 0, found 1125) <7> [592.445859] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:151:pipe A] fastset requirement not met in pixel_multiplier (expected 0, found 1) <7> [592.446049] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:151:pipe A] fastset requirement not met in hw.adjusted_mode.flags (1) (expected 0, found 1) <7> [592.446232] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:151:pipe A] fastset requirement not met in hw.adjusted_mode.flags (4) (expected 0, found 4) <7> [592.446418] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:151:pipe A] fastset requirement not met in enhanced_framing (expected no, found yes) <7> [592.446589] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:151:pipe A] fastset requirement not met in pipe_bpp (expected 0, found 36) <7> [592.446763] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:151:pipe A] fastset requirement not met in hw.pipe_mode.crtc_clock (expected 0, found 148500) <7> [592.446930] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:151:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_clock (expected 0, found 148500) <7> [592.447091] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:151:pipe A] fastset requirement not met in port_clock (expected 0, found 270000) <7> [592.447248] xe 0000:03:00.0: [drm:intel_atomic_check [xe]] [CRTC:151:pipe A] fastset requirement not met, forcing full modeset <7> [592.447465] xe 0000:03:00.0: [drm:skl_compute_wm [xe]] Enabled dbuf slices 0xf -> 0xf (total dbuf slices 0xf), mbus joined? yes->no <7> [592.447598] xe 0000:03:00.0: [drm:skl_compute_wm [xe]] [CRTC:151:pipe A] dbuf slices 0x0 -> 0x3, ddb (0 - 0) -> (0 - 2048), active pipes 0x2 -> 0x3 <7> [592.447727] xe 0000:03:00.0: [drm:skl_compute_wm [xe]] [CRTC:269:pipe B] dbuf slices 0xf -> 0xc, ddb (0 - 4096) -> (0 - 2048), active pipes 0x2 -> 0x3 <7> [592.447863] xe 0000:03:00.0: [drm:skl_print_plane_ddb_changes [xe]] [PLANE:35:plane 1A] ddb ( 0 - 0) -> ( 0 - 1989), size 0 -> 1989 <7> [592.447991] xe 0000:03:00.0: [drm:skl_print_plane_ddb_changes [xe]] [PLANE:145:cursor A] ddb ( 0 - 0) -> (1989 - 2048), size 0 -> 59 <7> [592.448105] xe 0000:03:00.0: [drm:skl_print_plane_wm_changes [xe]] [PLANE:35:plane 1A] level wm0, wm1, wm2, wm3, wm4, wm5, wm6, wm7, twm, swm, stwm -> wm0,wm1,wm2,wm3,wm4,wm5, wm6, wm7,twm,swm,stwm <7> [592.448222] xe 0000:03:00.0: [drm:skl_print_plane_wm_changes [xe]] [PLANE:35:plane 1A] lines 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0 -> 1, 3, 9, 9, 17, 17, 17, 17, 0, 15, 0 <7> [592.448329] xe 0000:03:00.0: [drm:skl_print_plane_wm_changes [xe]] [PLANE:35:plane 1A] blocks 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0 -> 16, 49, 145, 145, 273, 273, 273, 273, 30, 241, 255 <7> [592.448455] xe 0000:03:00.0: [drm:skl_print_plane_wm_changes [xe]] [PLANE:35:plane 1A] min_ddb 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0 -> 19, 55, 161, 161, 302, 302, 0, 0, 31, 267, 267 <7> [592.448562] xe 0000:03:00.0: [drm:skl_print_plane_ddb_changes [xe]] [PLANE:153:plane 1B] ddb ( 0 - 0) -> ( 0 - 1989), size 0 -> 1989 <7> [592.448666] xe 0000:03:00.0: [drm:skl_print_plane_ddb_changes [xe]] [PLANE:263:cursor B] ddb (4037 - 4096) -> (1989 - 2048), size 59 -> 59 <7> [592.448767] xe 0000:03:00.0: [drm:skl_print_plane_wm_changes [xe]] [PLANE:153:plane 1B] level wm0, wm1, wm2, wm3, wm4, wm5, wm6, wm7, twm, swm, stwm -> wm0,wm1,wm2,wm3,wm4,wm5, wm6, wm7,twm,swm,stwm <7> [592.448869] xe 0000:03:00.0: [drm:skl_print_plane_wm_changes [xe]] [PLANE:153:plane 1B] lines 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0 -> 1, 3, 9, 9, 17, 17, 17, 17, 0, 15, 0 <7> [592.448971] xe 0000:03:00.0: [drm:skl_print_plane_wm_changes [xe]] [PLANE:153:plane 1B] blocks 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0 -> 16, 49, 145, 145, 273, 273, 273, 273, 30, 241, 255 <7> [592.449067] xe 0000:03:00.0: [drm:skl_print_plane_wm_changes [xe]] [PLANE:153:plane 1B] min_ddb 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0 -> 19, 55, 161, 161, 302, 302, 0, 0, 31, 267, 267 <7> [592.449179] xe 0000:03:00.0: [drm:intel_bw_atomic_check [xe]] [CRTC:151:pipe A] data rate 594000 num active planes 1 <7> [592.449305] xe 0000:03:00.0: [drm:intel_bw_atomic_check [xe]] [CRTC:269:pipe B] data rate 594000 num active planes 1 <7> [592.449434] xe 0000:03:00.0: [drm:intel_bw_atomic_check [xe]] QGV point 0: max bw 33600 required 1248 qgv_peak_bw: 48000 <7> [592.449557] xe 0000:03:00.0: [drm:intel_bw_atomic_check [xe]] QGV point 1: max bw 53000 required 1248 qgv_peak_bw: 48000 <7> [592.449675] xe 0000:03:00.0: [drm:intel_bw_atomic_check [xe]] Matching peaks QGV bw: 48000 for required data rate: 1248 <7> [592.449789] xe 0000:03:00.0: [drm:intel_cdclk_atomic_check [xe]] [CRTC:151:pipe A] min cdclk: 0 kHz -> 192000 kHz <7> [592.449938] xe 0000:03:00.0: [drm:intel_find_dpll [xe]] [CRTC:151:pipe A] allocated TC PLL 2 <7> [592.450052] xe 0000:03:00.0: [drm:intel_dpll_crtc_get [xe]] [CRTC:151:pipe A] reserving TC PLL 2 <7> [592.450166] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] [CRTC:151:pipe A] enable: yes [modeset] <7> [592.450280] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] active: yes, output_types: DP (0x80), output format: RGB, sink format: RGB <7> [592.450399] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] cpu_transcoder: A, pipe bpp: 36, dithering: 0 <7> [592.450504] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] MST master transcoder: <invalid> <7> [592.450609] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] port sync: master transcoder: <invalid>, slave transcoder bitmask = 0x0 <7> [592.450712] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] joiner: no, pipes: 0x0 <7> [592.450807] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] splitter: disabled, link count 0, overlap 0 <7> [592.450902] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] dp m_n: lanes: 4; data_m: 5190451, data_n: 8388608, link_m: 288358, link_n: 524288, tu: 64 <7> [592.450995] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] dp m2_n2: lanes: 4; data_m: 0, data_n: 0, link_m: 0, link_n: 0, tu: 0 <7> [592.451089] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] fec: disabled, enhanced framing: enabled <7> [592.451182] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] sdp split: disabled <7> [592.451274] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] psr: disabled, selective update: disabled, panel replay: disabled, selective fetch: disabled <7> [592.451366] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] minimum hblank: 0 <7> [592.451472] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] audio: 1, infoframes: 0, infoframes enabled: 0x0 <7> [592.451569] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] ELD: 10 00 09 00 68 36 00 01 00 00 00 00 00 00 00 00 <7> [592.451663] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] ELD: 61 a4 9a 00 44 50 46 39 30 34 33 35 09 07 07 11 <7> [592.451759] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] ELD: 17 50 51 07 00 00 00 00 <7> [592.451857] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] scanline offset: 1 <7> [592.451952] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] framestart delay: 1, MSA timing delay: 0, set context latency: 0 <7> [592.452047] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] vrr: no, fixed rr: yes, vmin: 1125, vmax: 1125, flipline: 1125, pipeline full: 0, guardband: 42 vsync start: 41, vsync end: 36 <7> [592.452142] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] vrr: vmin vblank: 1083, vmax vblank: 1083, vmin vtotal: 1125, vmax vtotal: 1125 <7> [592.452236] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] vrr: dc balance: no, vmin: 0 vmax: 0 guardband: 0, slope: 0 max increase: 0 max decrease: 0 vblank target: 0 <7> [592.452333] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] requested mode: "1920x1080": 60 148500 1920 2008 2052 2200 1080 1084 1089 1125 0x48 0x5 <7> [592.452440] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] adjusted mode: "1920x1080": 60 148500 1920 2008 2052 2200 1080 1084 1089 1125 0x48 0x5 <7> [592.452538] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] crtc timings: clock=148500, hd=1920 hb=1920-2200 hs=2008-2052 ht=2200, vd=1080 vb=1080-1125 vs=1084-1089 vt=1125, flags=0x5 <7> [592.452636] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] pipe mode: "1920x1080": 60 148500 1920 2008 2052 2200 1080 1084 1089 1125 0x40 0x5 <7> [592.452733] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] crtc timings: clock=148500, hd=1920 hb=1920-2200 hs=2008-2052 ht=2200, vd=1080 vb=1080-1125 vs=1084-1089 vt=1125, flags=0x5 <7> [592.452827] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] port clock: 270000, pixel rate 148500, min cdclk 192000, min voltage level 0 <7> [592.452921] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] linetime: 119, ips linetime: 0 <7> [592.453013] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] num_scalers: 2, scaler_users: 0x0, scaler_id: -1, scaling_filter: 0, sharpness_strength: 0 <7> [592.453106] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] pipe src: 1920x1080+0+0 <7> [592.453198] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] pch pfit: 0x0+0+0, disabled, force thru: no <7> [592.453289] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] sharpness strength: 0, sharpness tap size: 0, sharpness enable: 0 <7> [592.453382] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] ips: 0, double wide: 0, drrs: 0 <7> [592.453490] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] cx0pll_hw_state: lane_count: 4, ssc_enabled: no, use_c10: no, tbt_mode: no <7> [592.453585] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] c20pll_hw_state: <7> [592.453676] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] tx[0] = 0xbe88, tx[1] = 0x4800, tx[2] = 0x0000 <7> [592.453769] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] cmn[0] = 0x0500, cmn[1] = 0x0005, cmn[2] = 0x0000, cmn[3] = 0x0000 <7> [592.453861] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] mpllb[0] = 0x308c <7> [592.453953] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] mpllb[1] = 0x2110 <7> [592.454044] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] mpllb[2] = 0xcc9c <7> [592.454136] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] mpllb[3] = 0xbfc1 <7> [592.454228] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] mpllb[4] = 0x4b9a <7> [592.454320] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] mpllb[5] = 0x3f81 <7> [592.454417] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] mpllb[6] = 0x2000 <7> [592.454509] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] mpllb[7] = 0x0001 <7> [592.454607] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] mpllb[8] = 0x5000 <7> [592.454704] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] mpllb[9] = 0x0000 <7> [592.454799] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] mpllb[10] = 0x0000 <7> [592.454893] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] vdr: custom width: 0x00, serdes rate: 0x42, hdmi rate: 0x00 <7> [592.454987] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] csc_mode: 0x0 gamma_mode: 0x0 gamma_enable: 0 csc_enable: 0 <7> [592.455080] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] pre csc lut: 0 entries, post csc lut: 0 entries <7> [592.455176] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] output csc: pre offsets: 0x0000 0x0000 0x0000 <7> [592.455270] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] output csc: coefficients: 0x0000 0x0000 0x0000 <7> [592.455368] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] output csc: coefficients: 0x0000 0x0000 0x0000 <7> [592.455477] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] output csc: coefficients: 0x0000 0x0000 0x0000 <7> [592.455574] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] output csc: post offsets: 0x0000 0x0000 0x0000 <7> [592.455671] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] pipe csc: pre offsets: 0x0000 0x0000 0x0000 <7> [592.455765] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] pipe csc: coefficients: 0x0000 0x0000 0x0000 <7> [592.455859] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] pipe csc: coefficients: 0x0000 0x0000 0x0000 <7> [592.455953] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] pipe csc: coefficients: 0x0000 0x0000 0x0000 <7> [592.456047] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] pipe csc: post offsets: 0x0000 0x0000 0x0000 <7> [592.456143] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] [PLANE:35:plane 1A] fb: [FB:556] 1920x1080 format = XR24 little-endian (0x34325258) modifier = 0x0, visible: yes <7> [592.456243] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] rotation: 0x1, scaler: -1, scaling_filter: 0 <7> [592.456340] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] src: 1920.000000x1080.000000+0.000000+0.000000 dst: 1920x1080+0+0 <7> [592.456446] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] [PLANE:65:plane 2A] fb: [NOFB], visible: no <7> [592.456542] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] [PLANE:95:plane 3A] fb: [NOFB], visible: no <7> [592.456637] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] [PLANE:125:plane 4A] fb: [NOFB], visible: no <7> [592.456731] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] [PLANE:135:plane 5A] fb: [NOFB], visible: no <7> [592.456825] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] [PLANE:145:cursor A] fb: [NOFB], visible: no <7> [592.457084] xe 0000:03:00.0: [drm:intel_power_well_enable [xe]] enabling PW_A <7> [592.457210] xe 0000:03:00.0: [drm:dss_pipe_gating_enable_disable [xe]] DSS clock gating enabled for pipe_mask=0x1 (CLKGATE_DIS_DSSDSC=0xa0000000) <7> [592.457323] xe 0000:03:00.0: [drm:intel_pmdemand_program_params [xe]] initiate pmdemand request values: (0x1e030b2 0x28d10e73) <7> [592.457615] xe 0000:03:00.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:507:DDI TC1/PHY F] <7> [592.457713] xe 0000:03:00.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:509:DP-MST A] <7> [592.457804] xe 0000:03:00.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:510:DP-MST B] <7> [592.457890] xe 0000:03:00.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:511:DP-MST C] <7> [592.457975] xe 0000:03:00.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:512:DP-MST D] <7> [592.458060] xe 0000:03:00.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:526:DDI TC2/PHY G] <7> [592.458146] xe 0000:03:00.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:528:DP-MST A] <7> [592.458231] xe 0000:03:00.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:529:DP-MST B] <7> [592.458316] xe 0000:03:00.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:530:DP-MST C] <7> [592.458424] xe 0000:03:00.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:531:DP-MST D] <7> [592.458513] xe 0000:03:00.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:538:DDI TC3/PHY H] <7> [592.458599] xe 0000:03:00.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:542:DDI TC4/PHY I] <7> [592.458685] xe 0000:03:00.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:544:DP-MST A] <7> [592.458770] xe 0000:03:00.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:545:DP-MST B] <7> [592.458855] xe 0000:03:00.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:546:DP-MST C] <7> [592.458938] xe 0000:03:00.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:547:DP-MST D] <7> [592.466435] xe 0000:03:00.0: [drm:intel_dbuf_mdclk_cdclk_ratio_update [xe]] Updating dbuf ratio to 2 (mbus joined: no) <7> [592.466556] xe 0000:03:00.0: [drm:intel_dbuf_mbus_join_update [xe]] Changing mbus joined: yes -> no (pipe: B) <7> [592.483103] xe 0000:03:00.0: [drm:intel_dpll_enable [xe]] enable TC PLL 2 (active 0x1, on? 0) for [CRTC:151:pipe A] <7> [592.483225] xe 0000:03:00.0: [drm:intel_dpll_enable [xe]] enabling TC PLL 2 <7> [592.485305] xe 0000:03:00.0: [drm:intel_power_well_enable [xe]] enabling AUX_TC2 <7> [592.488281] xe 0000:03:00.0: [drm:drm_dp_read_dpcd_caps [drm_display_helper]] AUX USBC2/DDI TC2/PHY G: DPCD: 12 14 c4 01 01 15 01 81 02 01 04 01 0f 00 01 <7> [592.491917] xe 0000:03:00.0: [drm:intel_dp_init_lttpr_and_dprx_caps [xe]] [CONNECTOR:527:DP-2][ENCODER:526:DDI TC2/PHY G][DPRX] LTTPR common capabilities: 00 00 00 00 00 00 00 00 <7> [592.492854] xe 0000:03:00.0: [drm:drm_dp_read_dpcd_caps [drm_display_helper]] AUX USBC2/DDI TC2/PHY G: DPCD: 12 14 c4 01 01 15 01 81 02 01 04 01 0f 00 01 <7> [592.493337] xe 0000:03:00.0: [drm:intel_dp_start_link_train [xe]] [CONNECTOR:527:DP-2][ENCODER:526:DDI TC2/PHY G][DPRX] Using LINK_BW_SET value 0a <7> [592.494309] xe 0000:03:00.0: [drm:intel_dp_set_signal_levels [xe]] [CONNECTOR:527:DP-2][ENCODER:526:DDI TC2/PHY G][DPRX] 8b/10b, lanes: 4, vswing levels: 0/0/0/0, pre-emphasis levels: 0/0/0/0 <7> [592.495017] xe 0000:03:00.0: [drm:intel_dp_program_link_training_pattern [xe]] [CONNECTOR:527:DP-2][ENCODER:526:DDI TC2/PHY G][DPRX] Using DP training pattern TPS1 <7> [592.500890] xe 0000:03:00.0: [drm:intel_dp_link_train_phy [xe]] [CONNECTOR:527:DP-2][ENCODER:526:DDI TC2/PHY G][DPRX] Clock recovery OK <7> [592.501380] xe 0000:03:00.0: [drm:intel_dp_program_link_training_pattern [xe]] [CONNECTOR:527:DP-2][ENCODER:526:DDI TC2/PHY G][DPRX] Using DP training pattern TPS3 <7> [592.506849] xe 0000:03:00.0: [drm:intel_dp_link_train_phy [xe]] [CONNECTOR:527:DP-2][ENCODER:526:DDI TC2/PHY G][DPRX] Channel EQ done. DP Training successful <7> [592.507192] xe 0000:03:00.0: [drm:intel_dp_link_train_phy [xe]] [CONNECTOR:527:DP-2][ENCODER:526:DDI TC2/PHY G][DPRX] Link Training passed at link rate = 270000, lane count = 4 <7> [592.508067] xe 0000:03:00.0: [drm:intel_enable_transcoder [xe]] enabling pipe A <7> [592.525345] xe 0000:03:00.0: [drm:intel_audio_codec_enable [xe]] [CONNECTOR:527:DP-2][ENCODER:526:DDI TC2/PHY G] Enable audio codec on [CRTC:151:pipe A], 40 bytes ELD <7> [592.542152] xe 0000:03:00.0: [drm:verify_connector_state [xe]] [CONNECTOR:527:DP-2] <7> [592.542797] xe 0000:03:00.0: [drm:intel_modeset_verify_crtc [xe]] [CRTC:151:pipe A] <7> [592.547737] xe 0000:03:00.0: [drm:drm_client_dev_restore] fbdev: ret=0 <6> [592.550051] [IGT] kms_universal_plane: exiting, ret=98 <6> [592.566818] Console: switching to colour frame buffer device 240x67

Detail

Value

Duration

unknown

Hostname

shard-bmg-2

Igt-Version

IGT-Version: 2.4-g93abaf017 (x86_64) (Linux: 7.0.0-rc7-lgci-xe-xe-4887-afe01cbdd453cb1b1-debug+ x86_64)

Out

Starting dynamic subtest: pipe-C-DP-2
Stack trace:
  #0 ../lib/igt_core.c:2075 __igt_fail_assert()
  #1 [get_intel_driver+0x5c]
  #2 ../lib/intel_allocator.c:919 __intel_allocator_open_full()
  #3 ../lib/intel_allocator.c:1055 intel_allocator_open_full()
  #4 ../lib/igt_fb.c:3141 setup_context_and_memory_region.constprop.0()
  #5 ../lib/igt_fb.c:3236 blitcopy()
  #6 ../lib/igt_fb.c:3448 setup_linear_mapping()
  #7 ../lib/igt_fb.c:2565 create_cairo_surface__gpu()
  #8 ../lib/igt_fb.c:4817 igt_get_cairo_surface()
  #9 ../lib/igt_fb.c:4840 igt_get_cairo_ctx()
  #10 ../lib/igt_fb.c:2327 igt_create_color_fb()
  #11 ../tests/kms_universal_plane.c:111 run_tests()
  #12 ../tests/kms_universal_plane.c:934 __igt_unique____real_main916()
  #13 ../tests/kms_universal_plane.c:916 main()
  #14 [__libc_init_first+0x8a]
  #15 [__libc_start_main+0x8b]
  #16 [_start+0x25]
Dynamic subtest pipe-C-DP-2: FAIL (20.616s)
Stack trace:
  #0 ../lib/igt_core.c:2075 __igt_fail_assert()
  #1 ../lib/igt_kms.c:4308 igt_mode_object_get_prop_enum_value()
  #2 ../lib/igt_kms.c:4339 igt_plane_try_prop_enum()
  #3 ../lib/igt_kms.c:4360 igt_plane_set_prop_enum()
  #4 ../lib/igt_kms.c:2678 igt_display_reset()
  #5 ../tests/kms_universal_plane.c:829 run_tests()
  #6 ../tests/kms_universal_plane.c:934 __igt_unique____real_main916()
  #7 ../tests/kms_universal_plane.c:916 main()
  #8 [__libc_init_first+0x8a]
  #9 [__libc_start_main+0x8b]
  #10 [_start+0x25]
Subtest universal-plane-functional: FAIL (24.884s)

This test caused an abort condition: Kernel badly tainted (0x4244, 0x200) (check dmesg for details):
	TAINT_WARN: WARN_ON has happened.

Err

Starting dynamic subtest: pipe-C-DP-2
(kms_universal_plane:11230) drmtest-CRITICAL: Test assertion failure function get_intel_driver, file ../lib/drmtest.c:178:
(kms_universal_plane:11230) drmtest-CRITICAL: Failed assertion: 0
(kms_universal_plane:11230) drmtest-CRITICAL: Last errno: 125, Operation canceled
(kms_universal_plane:11230) drmtest-CRITICAL: Device is not handled by Intel driver
Dynamic subtest pipe-C-DP-2 failed.
**** DEBUG ****
(kms_universal_plane:11230) igt_kms-DEBUG: display: DP-2: set_crtc(C)
(kms_universal_plane:11230) igt_kms-DEBUG: display: DP-2: Selecting CRTC C
(kms_universal_plane:11230) igt_fb-DEBUG: igt_create_fb_with_bo_size(width=1920, height=1080, format=XR24(0x34325258), modifier=0x0, size=0)
(kms_universal_plane:11230) igt_fb-DEBUG: igt_create_fb_with_bo_size(handle=5, pitch=7680)
(kms_universal_plane:11230) ioctl_wrappers-DEBUG: Test requirement passed: igt_has_fb_modifiers(fd)
(kms_universal_plane:11230) intel_allocator_simple-DEBUG: Using simple allocator
(kms_universal_plane:11230) drmtest-CRITICAL: Test assertion failure function get_intel_driver, file ../lib/drmtest.c:178:
(kms_universal_plane:11230) drmtest-CRITICAL: Failed assertion: 0
(kms_universal_plane:11230) drmtest-CRITICAL: Last errno: 125, Operation canceled
(kms_universal_plane:11230) drmtest-CRITICAL: Device is not handled by Intel driver
(kms_universal_plane:11230) igt_core-INFO: Stack trace:
(kms_universal_plane:11230) igt_core-INFO:   #0 ../lib/igt_core.c:2075 __igt_fail_assert()
(kms_universal_plane:11230) igt_core-INFO:   #1 [get_intel_driver+0x5c]
(kms_universal_plane:11230) igt_core-INFO:   #2 ../lib/intel_allocator.c:919 __intel_allocator_open_full()
(kms_universal_plane:11230) igt_core-INFO:   #3 ../lib/intel_allocator.c:1055 intel_allocator_open_full()
(kms_universal_plane:11230) igt_core-INFO:   #4 ../lib/igt_fb.c:3141 setup_context_and_memory_region.constprop.0()
(kms_universal_plane:11230) igt_core-INFO:   #5 ../lib/igt_fb.c:3236 blitcopy()
(kms_universal_plane:11230) igt_core-INFO:   #6 ../lib/igt_fb.c:3448 setup_linear_mapping()
(kms_universal_plane:11230) igt_core-INFO:   #7 ../lib/igt_fb.c:2565 create_cairo_surface__gpu()
(kms_universal_plane:11230) igt_core-INFO:   #8 ../lib/igt_fb.c:4817 igt_get_cairo_surface()
(kms_universal_plane:11230) igt_core-INFO:   #9 ../lib/igt_fb.c:4840 igt_get_cairo_ctx()
(kms_universal_plane:11230) igt_core-INFO:   #10 ../lib/igt_fb.c:2327 igt_create_color_fb()
(kms_universal_plane:11230) igt_core-INFO:   #11 ../tests/kms_universal_plane.c:111 run_tests()
(kms_universal_plane:11230) igt_core-INFO:   #12 ../tests/kms_universal_plane.c:934 __igt_unique____real_main916()
(kms_universal_plane:11230) igt_core-INFO:   #13 ../tests/kms_universal_plane.c:916 main()
(kms_universal_plane:11230) igt_core-INFO:   #14 [__libc_init_first+0x8a]
(kms_universal_plane:11230) igt_core-INFO:   #15 [__libc_start_main+0x8b]
(kms_universal_plane:11230) igt_core-INFO:   #16 [_start+0x25]
****  END  ****
Dynamic subtest pipe-C-DP-2: FAIL (20.616s)
(kms_universal_plane:11230) igt_kms-CRITICAL: Test assertion failure function igt_mode_object_get_prop_enum_value, file ../lib/igt_kms.c:4309:
(kms_universal_plane:11230) igt_kms-CRITICAL: Failed assertion: prop
(kms_universal_plane:11230) igt_kms-CRITICAL: Last errno: 125, Operation canceled
Subtest universal-plane-functional: FAIL (24.884s)

Dmesg

Scroll to first warning

<6> [571.780513] [IGT] kms_universal_plane: starting dynamic subtest pipe-C-DP-2

<7> [571.781027] xe 0000:03:00.0: [drm:drm_mode_addfb2] [FB:564]

<3> [574.039445] xe 0000:03:00.0: [drm] *ERROR* TLB invalidation fence timeout, seqno=52522 recv=52521

<3> [576.342283] xe 0000:03:00.0: [drm] *ERROR* TLB invalidation fence timeout, seqno=52522 recv=52521

<4> [576.853895] xe 0000:03:00.0: [drm] Tile0: GT0: Check job timeout: seqno=91031, lrc_seqno=91031, guc_id=0, not started

<6> [576.966571] pcieport 0000:00:06.0: AER: Multiple Correctable error message received from 0000:05:00.0

<4> [576.966596] nvme 0000:05:00.0: PCIe Bus Error: severity=Correctable, type=Physical Layer, (Receiver ID)

<4> [576.966606] nvme 0000:05:00.0: device [15b7:5017] error status/mask=00000001/0000e000

<4> [576.966616] nvme 0000:05:00.0: [ 0] RxErr (First)

<3> [578.647333] xe 0000:03:00.0: [drm] *ERROR* TLB invalidation fence timeout, seqno=52523 recv=52521

<7> [580.387092] xe 0000:03:00.0: [drm:xe_hwmon_read [xe]] thermal data for group 0 val 0x2b2c2829

<7> [580.387448] xe 0000:03:00.0: [drm:xe_hwmon_read [xe]] thermal data for group 1 val 0x2b2c2b2c

<3> [580.949794] xe 0000:03:00.0: [drm] *ERROR* TLB invalidation fence timeout, seqno=52523 recv=52521

<6> [581.065044] pcieport 0000:00:06.0: AER: Multiple Correctable error message received from 0000:05:00.0

<4> [581.065070] nvme 0000:05:00.0: PCIe Bus Error: severity=Correctable, type=Physical Layer, (Receiver ID)

<4> [581.065080] nvme 0000:05:00.0: device [15b7:5017] error status/mask=00000001/0000e000

<4> [581.065089] nvme 0000:05:00.0: [ 0] RxErr (First)

<4> [581.973759] xe 0000:03:00.0: [drm] Tile0: GT0: Check job timeout: seqno=91031, lrc_seqno=91031, guc_id=0, not started

<3> [583.253685] xe 0000:03:00.0: [drm] *ERROR* TLB invalidation fence timeout, seqno=52524 recv=52521

<3> [585.557877] xe 0000:03:00.0: [drm] *ERROR* TLB invalidation fence timeout, seqno=52524 recv=52521

<6> [585.676721] pcieport 0000:00:06.0: AER: Multiple Correctable error message received from 0000:05:00.0

<4> [585.676747] nvme 0000:05:00.0: PCIe Bus Error: severity=Correctable, type=Physical Layer, (Receiver ID)

<4> [585.676757] nvme 0000:05:00.0: device [15b7:5017] error status/mask=00000001/0000e000

<4> [585.676767] nvme 0000:05:00.0: [ 0] RxErr (First)

<4> [587.093722] xe 0000:03:00.0: [drm] Tile0: GT0: Check job timeout: seqno=91031, lrc_seqno=91031, guc_id=0, not started

<4> [592.213687] xe 0000:03:00.0: [drm] Tile0: GT0: Schedule disable failed to respond, guc_id=0

<7> [592.213712] xe 0000:03:00.0: [drm:xe_devcoredump [xe]] Multiple hangs are occurring, but only the first snapshot was taken

<6> [592.214103] xe 0000:03:00.0: [drm] Tile0: GT0: trying reset from guc_exec_queue_timedout_job [xe]

<6> [592.214614] xe 0000:03:00.0: [drm] Tile0: GT0: reset queued

<3> [592.214699] xe 0000:03:00.0: [drm] *ERROR* TLB invalidation fence timeout, seqno=52525 recv=52521

<6> [592.223583] xe 0000:03:00.0: [drm] Tile0: GT0: reset started

<7> [592.223645] xe 0000:03:00.0: [drm:guc_ct_change_state [xe]] Tile0: GT0: GuC CT communication channel stopped

<7> [592.223856] xe 0000:03:00.0: [drm:xe_reg_sr_apply_mmio [xe]] Tile0: GT0: Applying GT save-restore MMIOs

<7> [592.223946] xe 0000:03:00.0: [drm:xe_reg_sr_apply_mmio [xe]] Tile0: GT0: REG[0x4148] = 0x00000000

<7> [592.224035] xe 0000:03:00.0: [drm:xe_reg_sr_apply_mmio [xe]] Tile0: GT0: REG[0x8828] = 0x00800000

<7> [592.224121] xe 0000:03:00.0: [drm:xe_reg_sr_apply_mmio [xe]] Tile0: GT0: REG[0xb0c8] = 0x11111440

<7> [592.224205] xe 0000:03:00.0: [drm:xe_reg_sr_apply_mmio [xe]] Tile0: GT0: REG[0xb104] = 0x08104440

<7> [592.224287] xe 0000:03:00.0: [drm:xe_reg_sr_apply_mmio [xe]] Tile0: GT0: REG[0xb108] = 0x30200000

<7> [592.224370] xe 0000:03:00.0: [drm:xe_reg_sr_apply_mmio [xe]] Tile0: GT0: REG[0xb158] = 0x0000007f

<7> [592.224470] xe 0000:03:00.0: [drm:xe_reg_sr_apply_mmio [xe]] Tile0: GT0: REG[0xe7cc] = 0x00000100

<7> [592.224557] xe 0000:03:00.0: [drm:xe_wopcm_init [xe]] WOPCM: 4096K

<7> [592.224660] xe 0000:03:00.0: [drm:xe_wopcm_init [xe]] GuC WOPCM is already locked [6144K, 832K)

<7> [592.224776] xe 0000:03:00.0: [drm:guc_ct_change_state [xe]] Tile0: GT0: GuC CT communication channel disabled

<7> [592.225784] xe 0000:03:00.0: [drm:xe_guc_ads_populate [xe]] Tile0: GT0: Updated ADS capture size 20480 (was 49152)

<3> [592.236646] xe 0000:03:00.0: [drm] *ERROR* Tile0: GT0: load failed: status = 0x400000A0, time = 10ms, freq = 2150MHz (req 2133MHz)

<3> [592.248791] xe 0000:03:00.0: [drm] *ERROR* Tile0: GT0: load failed: status: Reset = 0, BootROM = 0x50, UKernel = 0x00, MIA = 0x00, Auth = 0x01

<3> [592.261537] xe 0000:03:00.0: [drm] *ERROR* Tile0: GT0: firmware signature verification failed

<3> [592.270066] xe 0000:03:00.0: [drm] *ERROR* Tile0: GT0: reset failed (-EPROTO)

<3> [592.277195] xe 0000:03:00.0: [drm] *ERROR* CRITICAL: Xe has declared device 0000:03:00.0 as wedged.

IOCTLs and executions are blocked.

For recovery procedure, refer to https://docs.kernel.org/gpu/drm-uapi.html#device-wedging

Please file a _new_ bug report at https://gitlab.freedesktop.org/drm/xe/kernel/issues/new

<7> [592.308973] xe 0000:03:00.0: [drm:guc_ct_change_state [xe]] Tile0: GT0: GuC CT communication channel stopped

<7> [592.309071] xe 0000:03:00.0: [drm:guc_ct_change_state [xe]] Tile0: GT1: GuC CT communication channel stopped

<3> [592.376982] xe 0000:03:00.0: [drm] *ERROR* Tile0: GT1: GuC mmio request 0x5507: no reply 0x5507

<6> [592.386720] xe 0000:03:00.0: [drm] device wedged, needs recovery

<4> [592.387820] ------------[ cut here ]------------

<4> [592.387828] xe 0000:03:00.0: [drm] Tile0: GT0: Kernel-submitted job timed out

<4> [592.387838] WARNING: drivers/gpu/drm/xe/xe_guc_submit.c:1626 at guc_exec_queue_timedout_job+0x1424/0x2400 [xe], CPU#2: kworker/u64:49/4517

<4> [592.388294] Modules linked in: snd_hda_codec_intelhdmi snd_hda_codec_hdmi pmt_crashlog mei_lb mei_gsc_proxy mtd_intel_dg mei_gsc xe drm_gpuvm drm_gpusvm_helper drm_buddy drm_ttm_helper ttm gpu_sched drm_suballoc_helper drm_exec drm_display_helper cec rc_core drm_kunit_helpers i2c_algo_bit kunit intel_rapl_msr intel_rapl_common intel_uncore_frequency intel_uncore_frequency_common binfmt_misc intel_tcc_cooling x86_pkg_temp_thermal intel_powerclamp hid_generic eeepc_wmi coretemp cmdlinepart asus_wmi sparse_keymap spi_nor platform_profile mei_pxp mei_hdcp mtd wmi_bmof kvm_intel kvm usbhid irqbypass video ghash_clmulni_intel hid aesni_intel snd_intel_dspcfg rapl snd_hda_codec r8169 snd_hda_core intel_cstate snd_hwdep nls_iso8859_1 snd_pcm realtek snd_timer i2c_i801 idma64 snd mei_me i2c_mux spi_intel_pci soundcore i2c_smbus spi_intel intel_pmc_core mei pmt_telemetry wmi pmt_discovery pmt_class intel_pmc_ssram_telemetry pinctrl_alderlake acpi_pad intel_vsec acpi_tad dm_multipath msr nvme_fabrics fuse efi_pstore nfnetlink

<4> [592.388672] autofs4 [last unloaded: snd_hda_intel]

<4> [592.388695] CPU: 2 UID: 0 PID: 4517 Comm: kworker/u64:49 Tainted: G S U L 7.0.0-rc7-lgci-xe-xe-4887-afe01cbdd453cb1b1-debug+ #1 PREEMPT(lazy)

<4> [592.388711] Tainted: [S]=CPU_OUT_OF_SPEC, [U]=USER, [L]=SOFTLOCKUP

<4> [592.388717] Hardware name: ASUS System Product Name/PRIME Z790-P WIFI, BIOS 1645 03/15/2024

<4> [592.388725] Workqueue: gt-ordered-wq drm_sched_job_timedout [gpu_sched]

<4> [592.388754] RIP: 0010:guc_exec_queue_timedout_job+0x142d/0x2400 [xe]

<4> [592.389147] Code: 74 04 48 8b 7f 08 4c 8b 6f 50 4d 85 ed 75 03 4c 8b 2f e8 36 d5 5e e1 48 89 c6 48 8d 3d 6c 95 39 00 41 89 d8 44 89 e1 4c 89 ea <67> 48 0f b9 3a 48 8b 45 90 48 8b 40 60 e9 c6 ee ff ff 8b 70 08 49

<4> [592.389156] RSP: 0018:ffffc9000c09fca0 EFLAGS: 00010246

<4> [592.389168] RAX: ffffffffa120304b RBX: 0000000000000000 RCX: 0000000000000000

<4> [592.389176] RDX: ffff888103e20910 RSI: ffffffffa120304b RDI: ffffffffa1003ee0

<4> [592.389182] RBP: ffffc9000c09fdb0 R08: 0000000000000000 R09: 0000000000000000

<4> [592.389189] R10: 0000000000000000 R11: 0000000000000000 R12: 0000000000000000

<4> [592.389195] R13: ffff888103e20910 R14: ffff888167f50818 R15: 00000000ffffffc2

<4> [592.389202] FS: 0000000000000000(0000) GS:ffff8888dad97000(0000) knlGS:0000000000000000

<4> [592.389210] CS: 0010 DS: 0000 ES: 0000 CR0: 0000000080050033

<4> [592.389217] CR2: 00007ec03ce08000 CR3: 000000000344c005 CR4: 0000000000f72ef0

<4> [592.389225] PKRU: 55555554

<4> [592.389231] Call Trace:

<4> [592.389237] <TASK>

<4> [592.389258] ? lock_sync+0x100/0x100

<4> [592.389283] ? lock_release+0xd0/0x2b0

<4> [592.389313] drm_sched_job_timedout+0x94/0x1a0 [gpu_sched]

<4> [592.389342] process_one_work+0x239/0x760

<4> [592.389375] worker_thread+0x200/0x3f0

<4> [592.389389] ? __pfx_worker_thread+0x10/0x10

<4> [592.389419] kthread+0x10d/0x150

<4> [592.389435] ? __pfx_kthread+0x10/0x10

<4> [592.389454] ret_from_fork+0x3d4/0x480

<4> [592.389465] ? __pfx_kthread+0x10/0x10

<4> [592.389482] ret_from_fork_asm+0x1a/0x30

<4> [592.389521] </TASK>

<4> [592.389527] irq event stamp: 421131

<4> [592.389534] hardirqs last enabled at (421137): [<ffffffff814aacd9>] __up_console_sem+0x79/0xa0

<4> [592.389550] hardirqs last disabled at (421142): [<ffffffff814aacbe>] __up_console_sem+0x5e/0xa0

<4> [592.389562] softirqs last enabled at (420520): [<ffffffff813d1e9f>] __irq_exit_rcu+0x13f/0x160

<4> [592.389576] softirqs last disabled at (420515): [<ffffffff813d1e9f>] __irq_exit_rcu+0x13f/0x160

<4> [592.389588] ---[ end trace 0000000000000000 ]---

<6> [592.397265] [IGT] kms_universal_plane: finished subtest pipe-C-DP-2, FAIL

<6> [592.402484] [IGT] kms_universal_plane: finished subtest universal-plane-functional, FAIL

<7> [592.402941] xe 0000:03:00.0: [drm:drm_mode_rmfb_work_fn] Removing [FB:561] from all active usage due to RMFB ioctl

<7> [592.403314] xe 0000:03:00.0: [drm:atomic_remove_fb] Disabling [PLANE:183:plane 2B] because [FB:561] is removed

<7> [592.403380] xe 0000:03:00.0: [drm:skl_print_plane_ddb_changes [xe]] [PLANE:153:plane 1B] ddb ( 0 - 3980) -> ( 0 - 4037), size 3980 -> 4037

<7> [592.403572] xe 0000:03:00.0: [drm:skl_print_plane_ddb_changes [xe]] [PLANE:183:plane 2B] ddb (3980 - 4037) -> ( 0 - 0), size 57 -> 0

<7> [592.403707] xe 0000:03:00.0: [drm:skl_print_plane_wm_changes [xe]] [PLANE:183:plane 2B] level *wm0,*wm1,*wm2,*wm3,*wm4,*wm5, wm6, wm7,*twm,*swm,*stwm -> wm0, wm1, wm2, wm3, wm4, wm5, wm6, wm7, twm, swm, stwm

<7> [592.403833] xe 0000:03:00.0: [drm:skl_print_plane_wm_changes [xe]] [PLANE:183:plane 2B] lines 7, 7, 9, 9, 17, 17, 17, 17, 0, 15, 0 -> 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0

<7> [592.403962] xe 0000:03:00.0: [drm:skl_print_plane_wm_changes [xe]] [PLANE:183:plane 2B] blocks 14, 14, 19, 19, 35, 35, 35, 35, 28, 31, 45 -> 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0

<7> [592.404091] xe 0000:03:00.0: [drm:skl_print_plane_wm_changes [xe]] [PLANE:183:plane 2B] min_ddb 17, 17, 22, 22, 40, 40, 0, 0, 29, 36, 46 -> 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0

<7> [592.404258] xe 0000:03:00.0: [drm:intel_bw_atomic_check [xe]] [CRTC:269:pipe B] data rate 594000 num active planes 1

<7> [592.404435] xe 0000:03:00.0: [drm:intel_bw_atomic_check [xe]] QGV point 0: max bw 33600 required 624 qgv_peak_bw: 48000

<7> [592.404600] xe 0000:03:00.0: [drm:intel_bw_atomic_check [xe]] QGV point 1: max bw 53000 required 624 qgv_peak_bw: 48000

<7> [592.404761] xe 0000:03:00.0: [drm:intel_bw_atomic_check [xe]] Matching peaks QGV bw: 48000 for required data rate: 624

<7> [592.417285] xe 0000:03:00.0: [drm:drm_mode_rmfb_work_fn] Removing [FB:559] from all active usage due to RMFB ioctl

<7> [592.417369] xe 0000:03:00.0: [drm:atomic_remove_fb] Disabling [PLANE:153:plane 1B] because [FB:559] is removed

<7> [592.417472] xe 0000:03:00.0: [drm:skl_print_plane_ddb_changes [xe]] [PLANE:153:plane 1B] ddb ( 0 - 4037) -> ( 0 - 0), size 4037 -> 0

<7> [592.417715] xe 0000:03:00.0: [drm:skl_print_plane_wm_changes [xe]] [PLANE:153:plane 1B] level *wm0,*wm1,*wm2,*wm3,*wm4,*wm5, wm6, wm7,*twm,*swm,*stwm -> wm0, wm1, wm2, wm3, wm4, wm5, wm6, wm7, twm, swm, stwm

<7> [592.417921] xe 0000:03:00.0: [drm:skl_print_plane_wm_changes [xe]] [PLANE:153:plane 1B] lines 1, 3, 9, 9, 17, 17, 17, 17, 0, 15, 0 -> 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0

<7> [592.418116] xe 0000:03:00.0: [drm:skl_print_plane_wm_changes [xe]] [PLANE:153:plane 1B] blocks 16, 49, 145, 145, 273, 273, 273, 273, 30, 241, 255 -> 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0

<7> [592.418302] xe 0000:03:00.0: [drm:skl_print_plane_wm_changes [xe]] [PLANE:153:plane 1B] min_ddb 19, 55, 161, 161, 302, 302, 0, 0, 31, 267, 267 -> 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0

<7> [592.418530] xe 0000:03:00.0: [drm:intel_bw_atomic_check [xe]] [CRTC:269:pipe B] data rate 0 num active planes 0

<7> [592.418767] xe 0000:03:00.0: [drm:intel_bw_atomic_check [xe]] QGV point 0: max bw 33600 required 0 qgv_peak_bw: 48000

<7> [592.419002] xe 0000:03:00.0: [drm:intel_bw_atomic_check [xe]] QGV point 1: max bw 53000 required 0 qgv_peak_bw: 48000

<7> [592.419218] xe 0000:03:00.0: [drm:intel_bw_atomic_check [xe]] Matching peaks QGV bw: 48000 for required data rate: 0

<7> [592.434869] xe 0000:03:00.0: [drm:intel_dp_compute_config_limits [xe]] [ENCODER:526:DDI TC2/PHY G][CRTC:151:pipe A] DP link limits: pixel clock 148500 kHz DSC off max lanes 4 max rate 540000 max pipe_bpp 36 min link_bpp 18.0000 max link_bpp 36.0000

<7> [592.435220] xe 0000:03:00.0: [drm:intel_dp_compute_link_config [xe]] DP lane count 4 clock 270000 bpp input 36 compressed 0.0000 HDR no link rate required 668250 available 1080000

<7> [592.435595] xe 0000:03:00.0: [drm:intel_atomic_check [xe]] [CRTC:151:pipe A] hw max bpp: 36, pipe bpp: 36, dithering: 0

<7> [592.435958] xe 0000:03:00.0: [drm:intel_ddi_compute_config_late [xe]] [ENCODER:526:DDI TC2/PHY G] [CRTC:151:pipe A]

<7> [592.436315] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:151:pipe A] fastset requirement not met in hw.enable (expected no, found yes)

<7> [592.436727] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:151:pipe A] fastset requirement not met in hw.active (expected no, found yes)

<7> [592.437112] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:151:pipe A] fastset requirement not met in cpu_transcoder (expected -1, found 0)

<7> [592.437531] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:151:pipe A] fastset requirement not met in lane_count (expected 0, found 4)

<7> [592.437902] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:151:pipe A] fastset requirement not met in dp_m_n (expected tu 0 data 0/0 link 0/0, found tu 64, data 5190451/8388608 link 288358/524288)

<7> [592.438303] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:151:pipe A] fastset requirement not met in output_types (expected 0x00000000, found 0x00000080)

<7> [592.438776] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:151:pipe A] fastset requirement not met in framestart_delay (expected 0, found 1)

<7> [592.439174] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:151:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hdisplay (expected 0, found 1920)

<7> [592.439569] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:151:pipe A] fastset requirement not met in hw.pipe_mode.crtc_htotal (expected 0, found 2200)

<7> [592.439930] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:151:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hblank_start (expected 0, found 1920)

<7> [592.440274] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:151:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hblank_end (expected 0, found 2200)

<7> [592.440628] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:151:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hsync_start (expected 0, found 2008)

<7> [592.440955] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:151:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hsync_end (expected 0, found 2052)

<7> [592.441264] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:151:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vdisplay (expected 0, found 1080)

<7> [592.441614] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:151:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vblank_start (expected 0, found 1080)

<7> [592.441932] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:151:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vsync_start (expected 0, found 1084)

<7> [592.442221] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:151:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vsync_end (expected 0, found 1089)

<7> [592.442526] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:151:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vtotal (expected 0, found 1125)

<7> [592.442789] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:151:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vblank_end (expected 0, found 1125)

<7> [592.443052] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:151:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hdisplay (expected 0, found 1920)

<7> [592.443304] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:151:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_htotal (expected 0, found 2200)

<7> [592.443568] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:151:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hblank_start (expected 0, found 1920)

<7> [592.443810] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:151:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hblank_end (expected 0, found 2200)

<7> [592.444037] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:151:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hsync_start (expected 0, found 2008)

<7> [592.444264] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:151:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hsync_end (expected 0, found 2052)

<7> [592.444498] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:151:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vdisplay (expected 0, found 1080)

<7> [592.444710] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:151:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vblank_start (expected 0, found 1080)

<7> [592.444919] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:151:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vsync_start (expected 0, found 1084)

<7> [592.445134] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:151:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vsync_end (expected 0, found 1089)

<7> [592.445332] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:151:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vtotal (expected 0, found 1125)

<7> [592.445668] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:151:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vblank_end (expected 0, found 1125)

<7> [592.445859] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:151:pipe A] fastset requirement not met in pixel_multiplier (expected 0, found 1)

<7> [592.446049] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:151:pipe A] fastset requirement not met in hw.adjusted_mode.flags (1) (expected 0, found 1)

<7> [592.446232] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:151:pipe A] fastset requirement not met in hw.adjusted_mode.flags (4) (expected 0, found 4)

<7> [592.446418] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:151:pipe A] fastset requirement not met in enhanced_framing (expected no, found yes)

<7> [592.446589] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:151:pipe A] fastset requirement not met in pipe_bpp (expected 0, found 36)

<7> [592.446763] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:151:pipe A] fastset requirement not met in hw.pipe_mode.crtc_clock (expected 0, found 148500)

<7> [592.446930] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:151:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_clock (expected 0, found 148500)

<7> [592.447091] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:151:pipe A] fastset requirement not met in port_clock (expected 0, found 270000)

<7> [592.447248] xe 0000:03:00.0: [drm:intel_atomic_check [xe]] [CRTC:151:pipe A] fastset requirement not met, forcing full modeset

<7> [592.447465] xe 0000:03:00.0: [drm:skl_compute_wm [xe]] Enabled dbuf slices 0xf -> 0xf (total dbuf slices 0xf), mbus joined? yes->no

<7> [592.447598] xe 0000:03:00.0: [drm:skl_compute_wm [xe]] [CRTC:151:pipe A] dbuf slices 0x0 -> 0x3, ddb (0 - 0) -> (0 - 2048), active pipes 0x2 -> 0x3

<7> [592.447727] xe 0000:03:00.0: [drm:skl_compute_wm [xe]] [CRTC:269:pipe B] dbuf slices 0xf -> 0xc, ddb (0 - 4096) -> (0 - 2048), active pipes 0x2 -> 0x3

<7> [592.447863] xe 0000:03:00.0: [drm:skl_print_plane_ddb_changes [xe]] [PLANE:35:plane 1A] ddb ( 0 - 0) -> ( 0 - 1989), size 0 -> 1989

<7> [592.447991] xe 0000:03:00.0: [drm:skl_print_plane_ddb_changes [xe]] [PLANE:145:cursor A] ddb ( 0 - 0) -> (1989 - 2048), size 0 -> 59

<7> [592.448105] xe 0000:03:00.0: [drm:skl_print_plane_wm_changes [xe]] [PLANE:35:plane 1A] level wm0, wm1, wm2, wm3, wm4, wm5, wm6, wm7, twm, swm, stwm -> *wm0,*wm1,*wm2,*wm3,*wm4,*wm5, wm6, wm7,*twm,*swm,*stwm

<7> [592.448222] xe 0000:03:00.0: [drm:skl_print_plane_wm_changes [xe]] [PLANE:35:plane 1A] lines 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0 -> 1, 3, 9, 9, 17, 17, 17, 17, 0, 15, 0

<7> [592.448329] xe 0000:03:00.0: [drm:skl_print_plane_wm_changes [xe]] [PLANE:35:plane 1A] blocks 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0 -> 16, 49, 145, 145, 273, 273, 273, 273, 30, 241, 255

<7> [592.448455] xe 0000:03:00.0: [drm:skl_print_plane_wm_changes [xe]] [PLANE:35:plane 1A] min_ddb 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0 -> 19, 55, 161, 161, 302, 302, 0, 0, 31, 267, 267

<7> [592.448562] xe 0000:03:00.0: [drm:skl_print_plane_ddb_changes [xe]] [PLANE:153:plane 1B] ddb ( 0 - 0) -> ( 0 - 1989), size 0 -> 1989

<7> [592.448666] xe 0000:03:00.0: [drm:skl_print_plane_ddb_changes [xe]] [PLANE:263:cursor B] ddb (4037 - 4096) -> (1989 - 2048), size 59 -> 59

<7> [592.448767] xe 0000:03:00.0: [drm:skl_print_plane_wm_changes [xe]] [PLANE:153:plane 1B] level wm0, wm1, wm2, wm3, wm4, wm5, wm6, wm7, twm, swm, stwm -> *wm0,*wm1,*wm2,*wm3,*wm4,*wm5, wm6, wm7,*twm,*swm,*stwm

<7> [592.448869] xe 0000:03:00.0: [drm:skl_print_plane_wm_changes [xe]] [PLANE:153:plane 1B] lines 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0 -> 1, 3, 9, 9, 17, 17, 17, 17, 0, 15, 0

<7> [592.448971] xe 0000:03:00.0: [drm:skl_print_plane_wm_changes [xe]] [PLANE:153:plane 1B] blocks 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0 -> 16, 49, 145, 145, 273, 273, 273, 273, 30, 241, 255

<7> [592.449067] xe 0000:03:00.0: [drm:skl_print_plane_wm_changes [xe]] [PLANE:153:plane 1B] min_ddb 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0 -> 19, 55, 161, 161, 302, 302, 0, 0, 31, 267, 267

<7> [592.449179] xe 0000:03:00.0: [drm:intel_bw_atomic_check [xe]] [CRTC:151:pipe A] data rate 594000 num active planes 1

<7> [592.449305] xe 0000:03:00.0: [drm:intel_bw_atomic_check [xe]] [CRTC:269:pipe B] data rate 594000 num active planes 1

<7> [592.449434] xe 0000:03:00.0: [drm:intel_bw_atomic_check [xe]] QGV point 0: max bw 33600 required 1248 qgv_peak_bw: 48000

<7> [592.449557] xe 0000:03:00.0: [drm:intel_bw_atomic_check [xe]] QGV point 1: max bw 53000 required 1248 qgv_peak_bw: 48000

<7> [592.449675] xe 0000:03:00.0: [drm:intel_bw_atomic_check [xe]] Matching peaks QGV bw: 48000 for required data rate: 1248

<7> [592.449789] xe 0000:03:00.0: [drm:intel_cdclk_atomic_check [xe]] [CRTC:151:pipe A] min cdclk: 0 kHz -> 192000 kHz

<7> [592.449938] xe 0000:03:00.0: [drm:intel_find_dpll [xe]] [CRTC:151:pipe A] allocated TC PLL 2

<7> [592.450052] xe 0000:03:00.0: [drm:intel_dpll_crtc_get [xe]] [CRTC:151:pipe A] reserving TC PLL 2

<7> [592.450166] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] [CRTC:151:pipe A] enable: yes [modeset]

<7> [592.450280] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] active: yes, output_types: DP (0x80), output format: RGB, sink format: RGB

<7> [592.450399] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] cpu_transcoder: A, pipe bpp: 36, dithering: 0

<7> [592.450504] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] MST master transcoder: <invalid>

<7> [592.450609] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] port sync: master transcoder: <invalid>, slave transcoder bitmask = 0x0

<7> [592.450712] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] joiner: no, pipes: 0x0

<7> [592.450807] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] splitter: disabled, link count 0, overlap 0

<7> [592.450902] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] dp m_n: lanes: 4; data_m: 5190451, data_n: 8388608, link_m: 288358, link_n: 524288, tu: 64

<7> [592.450995] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] dp m2_n2: lanes: 4; data_m: 0, data_n: 0, link_m: 0, link_n: 0, tu: 0

<7> [592.451089] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] fec: disabled, enhanced framing: enabled

<7> [592.451182] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] sdp split: disabled

<7> [592.451274] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] psr: disabled, selective update: disabled, panel replay: disabled, selective fetch: disabled

<7> [592.451366] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] minimum hblank: 0

<7> [592.451472] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] audio: 1, infoframes: 0, infoframes enabled: 0x0

<7> [592.451569] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] ELD: 10 00 09 00 68 36 00 01 00 00 00 00 00 00 00 00

<7> [592.451663] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] ELD: 61 a4 9a 00 44 50 46 39 30 34 33 35 09 07 07 11

<7> [592.451759] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] ELD: 17 50 51 07 00 00 00 00

<7> [592.451857] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] scanline offset: 1

<7> [592.451952] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] framestart delay: 1, MSA timing delay: 0, set context latency: 0

<7> [592.452047] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] vrr: no, fixed rr: yes, vmin: 1125, vmax: 1125, flipline: 1125, pipeline full: 0, guardband: 42 vsync start: 41, vsync end: 36

<7> [592.452142] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] vrr: vmin vblank: 1083, vmax vblank: 1083, vmin vtotal: 1125, vmax vtotal: 1125

<7> [592.452236] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] vrr: dc balance: no, vmin: 0 vmax: 0 guardband: 0, slope: 0 max increase: 0 max decrease: 0 vblank target: 0

<7> [592.452333] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] requested mode: "1920x1080": 60 148500 1920 2008 2052 2200 1080 1084 1089 1125 0x48 0x5

<7> [592.452440] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] adjusted mode: "1920x1080": 60 148500 1920 2008 2052 2200 1080 1084 1089 1125 0x48 0x5

<7> [592.452538] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] crtc timings: clock=148500, hd=1920 hb=1920-2200 hs=2008-2052 ht=2200, vd=1080 vb=1080-1125 vs=1084-1089 vt=1125, flags=0x5

<7> [592.452636] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] pipe mode: "1920x1080": 60 148500 1920 2008 2052 2200 1080 1084 1089 1125 0x40 0x5

<7> [592.452733] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] crtc timings: clock=148500, hd=1920 hb=1920-2200 hs=2008-2052 ht=2200, vd=1080 vb=1080-1125 vs=1084-1089 vt=1125, flags=0x5

<7> [592.452827] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] port clock: 270000, pixel rate 148500, min cdclk 192000, min voltage level 0

<7> [592.452921] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] linetime: 119, ips linetime: 0

<7> [592.453013] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] num_scalers: 2, scaler_users: 0x0, scaler_id: -1, scaling_filter: 0, sharpness_strength: 0

<7> [592.453106] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] pipe src: 1920x1080+0+0

<7> [592.453198] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] pch pfit: 0x0+0+0, disabled, force thru: no

<7> [592.453289] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] sharpness strength: 0, sharpness tap size: 0, sharpness enable: 0

<7> [592.453382] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] ips: 0, double wide: 0, drrs: 0

<7> [592.453490] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] cx0pll_hw_state: lane_count: 4, ssc_enabled: no, use_c10: no, tbt_mode: no

<7> [592.453585] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] c20pll_hw_state:

<7> [592.453676] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] tx[0] = 0xbe88, tx[1] = 0x4800, tx[2] = 0x0000

<7> [592.453769] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] cmn[0] = 0x0500, cmn[1] = 0x0005, cmn[2] = 0x0000, cmn[3] = 0x0000

<7> [592.453861] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] mpllb[0] = 0x308c

<7> [592.453953] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] mpllb[1] = 0x2110

<7> [592.454044] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] mpllb[2] = 0xcc9c

<7> [592.454136] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] mpllb[3] = 0xbfc1

<7> [592.454228] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] mpllb[4] = 0x4b9a

<7> [592.454320] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] mpllb[5] = 0x3f81

<7> [592.454417] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] mpllb[6] = 0x2000

<7> [592.454509] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] mpllb[7] = 0x0001

<7> [592.454607] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] mpllb[8] = 0x5000

<7> [592.454704] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] mpllb[9] = 0x0000

<7> [592.454799] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] mpllb[10] = 0x0000

<7> [592.454893] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] vdr: custom width: 0x00, serdes rate: 0x42, hdmi rate: 0x00

<7> [592.454987] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] csc_mode: 0x0 gamma_mode: 0x0 gamma_enable: 0 csc_enable: 0

<7> [592.455080] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] pre csc lut: 0 entries, post csc lut: 0 entries

<7> [592.455176] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] output csc: pre offsets: 0x0000 0x0000 0x0000

<7> [592.455270] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] output csc: coefficients: 0x0000 0x0000 0x0000

<7> [592.455368] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] output csc: coefficients: 0x0000 0x0000 0x0000

<7> [592.455477] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] output csc: coefficients: 0x0000 0x0000 0x0000

<7> [592.455574] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] output csc: post offsets: 0x0000 0x0000 0x0000

<7> [592.455671] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] pipe csc: pre offsets: 0x0000 0x0000 0x0000

<7> [592.455765] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] pipe csc: coefficients: 0x0000 0x0000 0x0000

<7> [592.455859] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] pipe csc: coefficients: 0x0000 0x0000 0x0000

<7> [592.455953] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] pipe csc: coefficients: 0x0000 0x0000 0x0000

<7> [592.456047] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] pipe csc: post offsets: 0x0000 0x0000 0x0000

<7> [592.456143] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] [PLANE:35:plane 1A] fb: [FB:556] 1920x1080 format = XR24 little-endian (0x34325258) modifier = 0x0, visible: yes

<7> [592.456243] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] rotation: 0x1, scaler: -1, scaling_filter: 0

<7> [592.456340] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] src: 1920.000000x1080.000000+0.000000+0.000000 dst: 1920x1080+0+0

<7> [592.456446] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] [PLANE:65:plane 2A] fb: [NOFB], visible: no

<7> [592.456542] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] [PLANE:95:plane 3A] fb: [NOFB], visible: no

<7> [592.456637] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] [PLANE:125:plane 4A] fb: [NOFB], visible: no

<7> [592.456731] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] [PLANE:135:plane 5A] fb: [NOFB], visible: no

<7> [592.456825] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] [PLANE:145:cursor A] fb: [NOFB], visible: no

<7> [592.457084] xe 0000:03:00.0: [drm:intel_power_well_enable [xe]] enabling PW_A

<7> [592.457210] xe 0000:03:00.0: [drm:dss_pipe_gating_enable_disable [xe]] DSS clock gating enabled for pipe_mask=0x1 (CLKGATE_DIS_DSSDSC=0xa0000000)

<7> [592.457323] xe 0000:03:00.0: [drm:intel_pmdemand_program_params [xe]] initiate pmdemand request values: (0x1e030b2 0x28d10e73)

<7> [592.457615] xe 0000:03:00.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:507:DDI TC1/PHY F]

<7> [592.457713] xe 0000:03:00.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:509:DP-MST A]

<7> [592.457804] xe 0000:03:00.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:510:DP-MST B]

<7> [592.457890] xe 0000:03:00.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:511:DP-MST C]

<7> [592.457975] xe 0000:03:00.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:512:DP-MST D]

<7> [592.458060] xe 0000:03:00.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:526:DDI TC2/PHY G]

<7> [592.458146] xe 0000:03:00.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:528:DP-MST A]

<7> [592.458231] xe 0000:03:00.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:529:DP-MST B]

<7> [592.458316] xe 0000:03:00.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:530:DP-MST C]

<7> [592.458424] xe 0000:03:00.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:531:DP-MST D]

<7> [592.458513] xe 0000:03:00.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:538:DDI TC3/PHY H]

<7> [592.458599] xe 0000:03:00.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:542:DDI TC4/PHY I]

<7> [592.458685] xe 0000:03:00.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:544:DP-MST A]

<7> [592.458770] xe 0000:03:00.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:545:DP-MST B]

<7> [592.458855] xe 0000:03:00.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:546:DP-MST C]

<7> [592.458938] xe 0000:03:00.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:547:DP-MST D]

<7> [592.466435] xe 0000:03:00.0: [drm:intel_dbuf_mdclk_cdclk_ratio_update [xe]] Updating dbuf ratio to 2 (mbus joined: no)

<7> [592.466556] xe 0000:03:00.0: [drm:intel_dbuf_mbus_join_update [xe]] Changing mbus joined: yes -> no (pipe: B)

<7> [592.483103] xe 0000:03:00.0: [drm:intel_dpll_enable [xe]] enable TC PLL 2 (active 0x1, on? 0) for [CRTC:151:pipe A]

<7> [592.483225] xe 0000:03:00.0: [drm:intel_dpll_enable [xe]] enabling TC PLL 2

<7> [592.485305] xe 0000:03:00.0: [drm:intel_power_well_enable [xe]] enabling AUX_TC2

<7> [592.488281] xe 0000:03:00.0: [drm:drm_dp_read_dpcd_caps [drm_display_helper]] AUX USBC2/DDI TC2/PHY G: DPCD: 12 14 c4 01 01 15 01 81 02 01 04 01 0f 00 01

<7> [592.491917] xe 0000:03:00.0: [drm:intel_dp_init_lttpr_and_dprx_caps [xe]] [CONNECTOR:527:DP-2][ENCODER:526:DDI TC2/PHY G][DPRX] LTTPR common capabilities: 00 00 00 00 00 00 00 00

<7> [592.492854] xe 0000:03:00.0: [drm:drm_dp_read_dpcd_caps [drm_display_helper]] AUX USBC2/DDI TC2/PHY G: DPCD: 12 14 c4 01 01 15 01 81 02 01 04 01 0f 00 01

<7> [592.493337] xe 0000:03:00.0: [drm:intel_dp_start_link_train [xe]] [CONNECTOR:527:DP-2][ENCODER:526:DDI TC2/PHY G][DPRX] Using LINK_BW_SET value 0a

<7> [592.494309] xe 0000:03:00.0: [drm:intel_dp_set_signal_levels [xe]] [CONNECTOR:527:DP-2][ENCODER:526:DDI TC2/PHY G][DPRX] 8b/10b, lanes: 4, vswing levels: 0/0/0/0, pre-emphasis levels: 0/0/0/0

<7> [592.495017] xe 0000:03:00.0: [drm:intel_dp_program_link_training_pattern [xe]] [CONNECTOR:527:DP-2][ENCODER:526:DDI TC2/PHY G][DPRX] Using DP training pattern TPS1

<7> [592.500890] xe 0000:03:00.0: [drm:intel_dp_link_train_phy [xe]] [CONNECTOR:527:DP-2][ENCODER:526:DDI TC2/PHY G][DPRX] Clock recovery OK

<7> [592.501380] xe 0000:03:00.0: [drm:intel_dp_program_link_training_pattern [xe]] [CONNECTOR:527:DP-2][ENCODER:526:DDI TC2/PHY G][DPRX] Using DP training pattern TPS3

<7> [592.506849] xe 0000:03:00.0: [drm:intel_dp_link_train_phy [xe]] [CONNECTOR:527:DP-2][ENCODER:526:DDI TC2/PHY G][DPRX] Channel EQ done. DP Training successful

<7> [592.507192] xe 0000:03:00.0: [drm:intel_dp_link_train_phy [xe]] [CONNECTOR:527:DP-2][ENCODER:526:DDI TC2/PHY G][DPRX] Link Training passed at link rate = 270000, lane count = 4

<7> [592.508067] xe 0000:03:00.0: [drm:intel_enable_transcoder [xe]] enabling pipe A

<7> [592.525345] xe 0000:03:00.0: [drm:intel_audio_codec_enable [xe]] [CONNECTOR:527:DP-2][ENCODER:526:DDI TC2/PHY G] Enable audio codec on [CRTC:151:pipe A], 40 bytes ELD

<7> [592.542152] xe 0000:03:00.0: [drm:verify_connector_state [xe]] [CONNECTOR:527:DP-2]

<7> [592.542797] xe 0000:03:00.0: [drm:intel_modeset_verify_crtc [xe]] [CRTC:151:pipe A]

<7> [592.547737] xe 0000:03:00.0: [drm:drm_client_dev_restore] fbdev: ret=0

<6> [592.550051] [IGT] kms_universal_plane: exiting, ret=98

<6> [592.566818] Console: switching to colour frame buffer device 240x67

Created at 2026-04-12 10:46:12