Results for igt@kms_flip@2x-flip-vs-absolute-wf_vblank@cd-dp2-hdmi-a3

Result: Dmesg-Fail 68 Warning(s)

i915_display_info12 igt_runner12 results12.json results12-xe-load.json guc_logs12.tar boot12 dmesg12

DetailValue
Duration 5.87 seconds
Hostname 
shard-bmg-2
Igt-Version 
IGT-Version: 2.3-g4aff2e43c (x86_64) (Linux: 7.0.0-rc2-lgci-xe-xe-4660-d6f74d61a95e54f21-debug+ x86_64)
Out 
Starting dynamic subtest: CD-DP2-HDMI-A3
  1920x1080: 60 148500 1920 2008 2052 2200 1080 1084 1089 1125 0x48 0x5 
  1920x1080: 60 148500 1920 2008 2052 2200 1080 1084 1089 1125 0x48 0x5 
Expected frametime: 16667us; measured 16667.7us +- 7.735us accuracy 0.14%
Stack trace:
  #0 ../lib/igt_core.c:2075 __igt_fail_assert()
  #1 ../tests/kms_flip.c:1288 wait_for_events()
  #2 ../tests/kms_flip.c:1334 run_test_on_crtc_set.constprop.0()
  #3 ../tests/kms_flip.c:1972 run_pair()
  #4 ../tests/kms_flip.c:2129 __igt_unique____real_main2043()
  #5 ../tests/kms_flip.c:2043 main()
  #6 [__libc_init_first+0x8a]
  #7 [__libc_start_main+0x8b]
  #8 [_start+0x25]
Dynamic subtest CD-DP2-HDMI-A3: FAIL (5.869s)
Subtest 2x-flip-vs-absolute-wf_vblank: FAIL (34.624s)
Err 
Starting dynamic subtest: CD-DP2-HDMI-A3
(kms_flip:3693) CRITICAL: Test assertion failure function wait_for_events, file ../tests/kms_flip.c:1304:
(kms_flip:3693) CRITICAL: Failed assertion: ret > 0
(kms_flip:3693) CRITICAL: select timed out or error (ret 0)
Dynamic subtest CD-DP2-HDMI-A3 failed.
**** DEBUG ****
(kms_flip:3693) intel_pat-DEBUG: Parsed PAT entry 20: 0x0000004c
(kms_flip:3693) intel_pat-DEBUG: Parsed PAT entry 21: 0x0000024c
(kms_flip:3693) intel_pat-DEBUG: Parsed PAT entry 22: 0x0000004e
(kms_flip:3693) intel_pat-DEBUG: Parsed PAT entry 23: 0x0000004f
(kms_flip:3693) intel_pat-DEBUG: Parsed PAT entry 24: 0x0000008c
(kms_flip:3693) intel_pat-DEBUG: Parsed PAT entry 25: 0x0000028c
(kms_flip:3693) intel_pat-DEBUG: Parsed PAT entry 26: 0x0000008e
(kms_flip:3693) intel_pat-DEBUG: Parsed PAT entry 27: 0x0000008f
(kms_flip:3693) intel_allocator_simple-DEBUG: <ial: 0x5d4e2a65ca50, fd: 5> objects: 3, reserved_areas: 0
(kms_flip:3693) intel_allocator_simple-DEBUG: <ial: 0x5d4e2a65ca50, fd: 5> objects: 3, reserved_areas: 0
(kms_flip:3693) intel_allocator_simple-DEBUG: Using simple allocator
(kms_flip:3693) intel_pat-DEBUG: Parsed PAT entry 0: 0x0000000c
(kms_flip:3693) intel_pat-DEBUG: Parsed PAT entry 1: 0x0000000e
(kms_flip:3693) intel_pat-DEBUG: Parsed PAT entry 2: 0x0000000f
(kms_flip:3693) intel_pat-DEBUG: Parsed PAT entry 3: 0x0000003c
(kms_flip:3693) intel_pat-DEBUG: Parsed PAT entry 4: 0x00000032
(kms_flip:3693) intel_pat-DEBUG: Parsed PAT entry 5: 0x0000003e
(kms_flip:3693) intel_pat-DEBUG: Parsed PAT entry 6: 0x0000041c
(kms_flip:3693) intel_pat-DEBUG: Parsed PAT entry 7: 0x00000033
(kms_flip:3693) intel_pat-DEBUG: Parsed PAT entry 8: 0x00000030
(kms_flip:3693) intel_pat-DEBUG: Parsed PAT entry 9: 0x0000020c
(kms_flip:3693) intel_pat-DEBUG: Parsed PAT entry 10: 0x00000230
(kms_flip:3693) intel_pat-DEBUG: Parsed PAT entry 11: 0x0000061c
(kms_flip:3693) intel_pat-DEBUG: Parsed PAT entry 12: 0x0000023c
(kms_flip:3693) intel_pat-DEBUG: Parsed PAT entry 13: 0x00000000
(kms_flip:3693) intel_pat-DEBUG: Parsed PAT entry 14: 0x00000200
(kms_flip:3693) intel_pat-DEBUG: Parsed PAT entry 15: 0x00000614
(kms_flip:3693) intel_pat-DEBUG: Parsed PAT entry 16: 0x00000000 (reserved)
(kms_flip:3693) intel_pat-DEBUG: Parsed PAT entry 17: 0x00000000 (reserved)
(kms_flip:3693) intel_pat-DEBUG: Parsed PAT entry 18: 0x00000000 (reserved)
(kms_flip:3693) intel_pat-DEBUG: Parsed PAT entry 19: 0x00000000 (reserved)
(kms_flip:3693) intel_pat-DEBUG: Parsed PAT entry 20: 0x0000004c
(kms_flip:3693) intel_pat-DEBUG: Parsed PAT entry 21: 0x0000024c
(kms_flip:3693) intel_pat-DEBUG: Parsed PAT entry 22: 0x0000004e
(kms_flip:3693) intel_pat-DEBUG: Parsed PAT entry 23: 0x0000004f
(kms_flip:3693) intel_pat-DEBUG: Parsed PAT entry 24: 0x0000008c
(kms_flip:3693) intel_pat-DEBUG: Parsed PAT entry 25: 0x0000028c
(kms_flip:3693) intel_pat-DEBUG: Parsed PAT entry 26: 0x0000008e
(kms_flip:3693) intel_pat-DEBUG: Parsed PAT entry 27: 0x0000008f
(kms_flip:3693) intel_pat-DEBUG: Parsed PAT entry 0: 0x0000000c
(kms_flip:3693) intel_pat-DEBUG: Parsed PAT entry 1: 0x0000000e
(kms_flip:3693) intel_pat-DEBUG: Parsed PAT entry 2: 0x0000000f
(kms_flip:3693) intel_pat-DEBUG: Parsed PAT entry 3: 0x0000003c
(kms_flip:3693) intel_pat-DEBUG: Parsed PAT entry 4: 0x00000032
(kms_flip:3693) intel_pat-DEBUG: Parsed PAT entry 5: 0x0000003e
(kms_flip:3693) intel_pat-DEBUG: Parsed PAT entry 6: 0x0000041c
(kms_flip:3693) intel_pat-DEBUG: Parsed PAT entry 7: 0x00000033
(kms_flip:3693) intel_pat-DEBUG: Parsed PAT entry 8: 0x00000030
(kms_flip:3693) intel_pat-DEBUG: Parsed PAT entry 9: 0x0000020c
(kms_flip:3693) intel_pat-DEBUG: Parsed PAT entry 10: 0x00000230
(kms_flip:3693) intel_pat-DEBUG: Parsed PAT entry 11: 0x0000061c
(kms_flip:3693) intel_pat-DEBUG: Parsed PAT entry 12: 0x0000023c
(kms_flip:3693) intel_pat-DEBUG: Parsed PAT entry 13: 0x00000000
(kms_flip:3693) intel_pat-DEBUG: Parsed PAT entry 14: 0x00000200
(kms_flip:3693) intel_pat-DEBUG: Parsed PAT entry 15: 0x00000614
(kms_flip:3693) intel_pat-DEBUG: Parsed PAT entry 16: 0x00000000 (reserved)
(kms_flip:3693) intel_pat-DEBUG: Parsed PAT entry 17: 0x00000000 (reserved)
(kms_flip:3693) intel_pat-DEBUG: Parsed PAT entry 18: 0x00000000 (reserved)
(kms_flip:3693) intel_pat-DEBUG: Parsed PAT entry 19: 0x00000000 (reserved)
(kms_flip:3693) intel_pat-DEBUG: Parsed PAT entry 20: 0x0000004c
(kms_flip:3693) intel_pat-DEBUG: Parsed PAT entry 21: 0x0000024c
(kms_flip:3693) intel_pat-DEBUG: Parsed PAT entry 22: 0x0000004e
(kms_flip:3693) intel_pat-DEBUG: Parsed PAT entry 23: 0x0000004f
(kms_flip:3693) intel_pat-DEBUG: Parsed PAT entry 24: 0x0000008c
(kms_flip:3693) intel_pat-DEBUG: Parsed PAT entry 25: 0x0000028c
(kms_flip:3693) intel_pat-DEBUG: Parsed PAT entry 26: 0x0000008e
(kms_flip:3693) intel_pat-DEBUG: Parsed PAT entry 27: 0x0000008f
(kms_flip:3693) intel_pat-DEBUG: Parsed PAT entry 0: 0x0000000c
(kms_flip:3693) intel_pat-DEBUG: Parsed PAT entry 1: 0x0000000e
(kms_flip:3693) intel_pat-DEBUG: Parsed PAT entry 2: 0x0000000f
(kms_flip:3693) intel_pat-DEBUG: Parsed PAT entry 3: 0x0000003c
(kms_flip:3693) intel_pat-DEBUG: Parsed PAT entry 4: 0x00000032
(kms_flip:3693) intel_pat-DEBUG: Parsed PAT entry 5: 0x0000003e
(kms_flip:3693) intel_pat-DEBUG: Parsed PAT entry 6: 0x0000041c
(kms_flip:3693) intel_pat-DEBUG: Parsed PAT entry 7: 0x00000033
(kms_flip:3693) intel_pat-DEBUG: Parsed PAT entry 8: 0x00000030
(kms_flip:3693) intel_pat-DEBUG: Parsed PAT entry 9: 0x0000020c
(kms_flip:3693) intel_pat-DEBUG: Parsed PAT entry 10: 0x00000230
(kms_flip:3693) intel_pat-DEBUG: Parsed PAT entry 11: 0x0000061c
(kms_flip:3693) intel_pat-DEBUG: Parsed PAT entry 12: 0x0000023c
(kms_flip:3693) intel_pat-DEBUG: Parsed PAT entry 13: 0x00000000
(kms_flip:3693) intel_pat-DEBUG: Parsed PAT entry 14: 0x00000200
(kms_flip:3693) intel_pat-DEBUG: Parsed PAT entry 15: 0x00000614
(kms_flip:3693) intel_pat-DEBUG: Parsed PAT entry 16: 0x00000000 (reserved)
(kms_flip:3693) intel_pat-DEBUG: Parsed PAT entry 17: 0x00000000 (reserved)
(kms_flip:3693) intel_pat-DEBUG: Parsed PAT entry 18: 0x00000000 (reserved)
(kms_flip:3693) intel_pat-DEBUG: Parsed PAT entry 19: 0x00000000 (reserved)
(kms_flip:3693) intel_pat-DEBUG: Parsed PAT entry 20: 0x0000004c
(kms_flip:3693) intel_pat-DEBUG: Parsed PAT entry 21: 0x0000024c
(kms_flip:3693) intel_pat-DEBUG: Parsed PAT entry 22: 0x0000004e
(kms_flip:3693) intel_pat-DEBUG: Parsed PAT entry 23: 0x0000004f
(kms_flip:3693) intel_pat-DEBUG: Parsed PAT entry 24: 0x0000008c
(kms_flip:3693) intel_pat-DEBUG: Parsed PAT entry 25: 0x0000028c
(kms_flip:3693) intel_pat-DEBUG: Parsed PAT entry 26: 0x0000008e
(kms_flip:3693) intel_pat-DEBUG: Parsed PAT entry 27: 0x0000008f
(kms_flip:3693) intel_allocator_simple-DEBUG: <ial: 0x5d4e2a6195e0, fd: 5> objects: 3, reserved_areas: 0
(kms_flip:3693) intel_allocator_simple-DEBUG: <ial: 0x5d4e2a6195e0, fd: 5> objects: 3, reserved_areas: 0
(kms_flip:3693) intel_allocator_simple-DEBUG: Using simple allocator
(kms_flip:3693) intel_pat-DEBUG: Parsed PAT entry 0: 0x0000000c
(kms_flip:3693) intel_pat-DEBUG: Parsed PAT entry 1: 0x0000000e
(kms_flip:3693) intel_pat-DEBUG: Parsed PAT entry 2: 0x0000000f
(kms_flip:3693) intel_pat-DEBUG: Parsed PAT entry 3: 0x0000003c
(kms_flip:3693) intel_pat-DEBUG: Parsed PAT entry 4: 0x00000032
(kms_flip:3693) intel_pat-DEBUG: Parsed PAT entry 5: 0x0000003e
(kms_flip:3693) intel_pat-DEBUG: Parsed PAT entry 6: 0x0000041c
(kms_flip:3693) intel_pat-DEBUG: Parsed PAT entry 7: 0x00000033
(kms_flip:3693) intel_pat-DEBUG: Parsed PAT entry 8: 0x00000030
(kms_flip:3693) intel_pat-DEBUG: Parsed PAT entry 9: 0x0000020c
(kms_flip:3693) intel_pat-DEBUG: Parsed PAT entry 10: 0x00000230
(kms_flip:3693) intel_pat-DEBUG: Parsed PAT entry 11: 0x0000061c
(kms_flip:3693) intel_pat-DEBUG: Parsed PAT entry 12: 0x0000023c
(kms_flip:3693) intel_pat-DEBUG: Parsed PAT entry 13: 0x00000000
(kms_flip:3693) intel_pat-DEBUG: Parsed PAT entry 14: 0x00000200
(kms_flip:3693) intel_pat-DEBUG: Parsed PAT entry 15: 0x00000614
(kms_flip:3693) intel_pat-DEBUG: Parsed PAT entry 16: 0x00000000 (reserved)
(kms_flip:3693) intel_pat-DEBUG: Parsed PAT entry 17: 0x00000000 (reserved)
(kms_flip:3693) intel_pat-DEBUG: Parsed PAT entry 18: 0x00000000 (reserved)
(kms_flip:3693) intel_pat-DEBUG: Parsed PAT entry 19: 0x00000000 (reserved)
(kms_flip:3693) intel_pat-DEBUG: Parsed PAT entry 20: 0x0000004c
(kms_flip:3693) intel_pat-DEBUG: Parsed PAT entry 21: 0x0000024c
(kms_flip:3693) intel_pat-DEBUG: Parsed PAT entry 22: 0x0000004e
(kms_flip:3693) intel_pat-DEBUG: Parsed PAT entry 23: 0x0000004f
(kms_flip:3693) intel_pat-DEBUG: Parsed PAT entry 24: 0x0000008c
(kms_flip:3693) intel_pat-DEBUG: Parsed PAT entry 25: 0x0000028c
(kms_flip:3693) intel_pat-DEBUG: Parsed PAT entry 26: 0x0000008e
(kms_flip:3693) intel_pat-DEBUG: Parsed PAT entry 27: 0x0000008f
(kms_flip:3693) intel_pat-DEBUG: Parsed PAT entry 0: 0x0000000c
(kms_flip:3693) intel_pat-DEBUG: Parsed PAT entry 1: 0x0000000e
(kms_flip:3693) intel_pat-DEBUG: Parsed PAT entry 2: 0x0000000f
(kms_flip:3693) intel_pat-DEBUG: Parsed PAT entry 3: 0x0000003c
(kms_flip:3693) intel_pat-DEBUG: Parsed PAT entry 4: 0x00000032
(kms_flip:3693) intel_pat-DEBUG: Parsed PAT entry 5: 0x0000003e
(kms_flip:3693) intel_pat-DEBUG: Parsed PAT entry 6: 0x0000041c
(kms_flip:3693) intel_pat-DEBUG: Parsed PAT entry 7: 0x00000033
(kms_flip:3693) intel_pat-DEBUG: Parsed PAT entry 8: 0x00000030
(kms_flip:3693) intel_pat-DEBUG: Parsed PAT entry 9: 0x0000020c
(kms_flip:3693) intel_pat-DEBUG: Parsed PAT entry 10: 0x00000230
(kms_flip:3693) intel_pat-DEBUG: Parsed PAT entry 11: 0x0000061c
(kms_flip:3693) intel_pat-DEBUG: Parsed PAT entry 12: 0x0000023c
(kms_flip:3693) intel_pat-DEBUG: Parsed PAT entry 13: 0x00000000
(kms_flip:3693) intel_pat-DEBUG: Parsed PAT entry 14: 0x00000200
(kms_flip:3693) intel_pat-DEBUG: Parsed PAT entry 15: 0x00000614
(kms_flip:3693) intel_pat-DEBUG: Parsed PAT entry 16: 0x00000000 (reserved)
(kms_flip:3693) intel_pat-DEBUG: Parsed PAT entry 17: 0x00000000 (reserved)
(kms_flip:3693) intel_pat-DEBUG: Parsed PAT entry 18: 0x00000000 (reserved)
(kms_flip:3693) intel_pat-DEBUG: Parsed PAT entry 19: 0x00000000 (reserved)
(kms_flip:3693) intel_pat-DEBUG: Parsed PAT entry 20: 0x0000004c
(kms_flip:3693) intel_pat-DEBUG: Parsed PAT entry 21: 0x0000024c
(kms_flip:3693) intel_pat-DEBUG: Parsed PAT entry 22: 0x0000004e
(kms_flip:3693) intel_pat-DEBUG: Parsed PAT entry 23: 0x0000004f
(kms_flip:3693) intel_pat-DEBUG: Parsed PAT entry 24: 0x0000008c
(kms_flip:3693) intel_pat-DEBUG: Parsed PAT entry 25: 0x0000028c
(kms_flip:3693) intel_pat-DEBUG: Parsed PAT entry 26: 0x0000008e
(kms_flip:3693) intel_pat-DEBUG: Parsed PAT entry 27: 0x0000008f
(kms_flip:3693) intel_pat-DEBUG: Parsed PAT entry 0: 0x0000000c
(kms_flip:3693) intel_pat-DEBUG: Parsed PAT entry 1: 0x0000000e
(kms_flip:3693) intel_pat-DEBUG: Parsed PAT entry 2: 0x0000000f
(kms_flip:3693) intel_pat-DEBUG: Parsed PAT entry 3: 0x0000003c
(kms_flip:3693) intel_pat-DEBUG: Parsed PAT entry 4: 0x00000032
(kms_flip:3693) intel_pat-DEBUG: Parsed PAT entry 5: 0x0000003e
(kms_flip:3693) intel_pat-DEBUG: Parsed PAT entry 6: 0x0000041c
(kms_flip:3693) intel_pat-DEBUG: Parsed PAT entry 7: 0x00000033
(kms_flip:3693) intel_pat-DEBUG: Parsed PAT entry 8: 0x00000030
(kms_flip:3693) intel_pat-DEBUG: Parsed PAT entry 9: 0x0000020c
(kms_flip:3693) intel_pat-DEBUG: Parsed PAT entry 10: 0x00000230
(kms_flip:3693) intel_pat-DEBUG: Parsed PAT entry 11: 0x0000061c
(kms_flip:3693) intel_pat-DEBUG: Parsed PAT entry 12: 0x0000023c
(kms_flip:3693) intel_pat-DEBUG: Parsed PAT entry 13: 0x00000000
(kms_flip:3693) intel_pat-DEBUG: Parsed PAT entry 14: 0x00000200
(kms_flip:3693) intel_pat-DEBUG: Parsed PAT entry 15: 0x00000614
(kms_flip:3693) intel_pat-DEBUG: Parsed PAT entry 16: 0x00000000 (reserved)
(kms_flip:3693) intel_pat-DEBUG: Parsed PAT entry 17: 0x00000000 (reserved)
(kms_flip:3693) intel_pat-DEBUG: Parsed PAT entry 18: 0x00000000 (reserved)
(kms_flip:3693) intel_pat-DEBUG: Parsed PAT entry 19: 0x00000000 (reserved)
(kms_flip:3693) intel_pat-DEBUG: Parsed PAT entry 20: 0x0000004c
(kms_flip:3693) intel_pat-DEBUG: Parsed PAT entry 21: 0x0000024c
(kms_flip:3693) intel_pat-DEBUG: Parsed PAT entry 22: 0x0000004e
(kms_flip:3693) intel_pat-DEBUG: Parsed PAT entry 23: 0x0000004f
(kms_flip:3693) intel_pat-DEBUG: Parsed PAT entry 24: 0x0000008c
(kms_flip:3693) intel_pat-DEBUG: Parsed PAT entry 25: 0x0000028c
(kms_flip:3693) intel_pat-DEBUG: Parsed PAT entry 26: 0x0000008e
(kms_flip:3693) intel_pat-DEBUG: Parsed PAT entry 27: 0x0000008f
(kms_flip:3693) intel_allocator_simple-DEBUG: <ial: 0x5d4e2a66d290, fd: 5> objects: 3, reserved_areas: 0
(kms_flip:3693) intel_allocator_simple-DEBUG: <ial: 0x5d4e2a66d290, fd: 5> objects: 3, reserved_areas: 0
(kms_flip:3693) igt_kms-INFO:   1920x1080: 60 148500 1920 2008 2052 2200 1080 1084 1089 1125 0x48 0x5 
(kms_flip:3693) igt_kms-INFO:   1920x1080: 60 148500 1920 2008 2052 2200 1080 1084 1089 1125 0x48 0x5 
(kms_flip:3693) DEBUG: No stale events found
(kms_flip:3693) i915/intel_drrs-DEBUG: Manually disabling DRRS. 0
(kms_flip:3693) i915/intel_drrs-DEBUG: Test requirement passed: dir >= 0
(kms_flip:3693) i915/intel_drrs-DEBUG: Manually disabling DRRS. 0
(kms_flip:3693) i915/intel_drrs-DEBUG: Test requirement passed: dir >= 0
(kms_flip:3693) INFO: Expected frametime: 16667us; measured 16667.7us +- 7.735us accuracy 0.14%
(kms_flip:3693) DEBUG: name = flip
last_ts = 0.000000
last_received_ts = 0.000000
last_seq = 0
current_ts = 194.337845
current_received_ts = 194.337540
current_seq = 1841
count = 0
seq_step = 1
(kms_flip:3693) DEBUG: name = vblank
last_ts = 0.000000
last_received_ts = 0.000000
last_seq = 0
current_ts = 194.487869
current_received_ts = 194.487823
current_seq = 1850
count = 0
seq_step = 10
(kms_flip:3693) DEBUG: name = flip
last_ts = 194.337845
last_received_ts = 194.337540
last_seq = 1841
current_ts = 194.504532
current_received_ts = 194.504333
current_seq = 1851
count = 1
seq_step = 1
(kms_flip:3693) DEBUG: flip ts/seq: last 194.337845/1841, current 194.504532/1851: elapsed=166679.0us expected=166676.9us +- 833.4us, error 0.0%
(kms_flip:3693) DEBUG: name = vblank
last_ts = 194.487869
last_received_ts = 194.487823
last_seq = 1850
current_ts = 194.654526
current_received_ts = 194.654510
current_seq = 1860
count = 1
seq_step = 10
(kms_flip:3693) DEBUG: vblank ts/seq: last 194.487869/1850, current 194.654526/1860: elapsed=166663.0us expected=166676.9us +- 833.4us, error 0.0%
(kms_flip:3693) DEBUG: name = flip
last_ts = 194.504532
last_received_ts = 194.504333
last_seq = 1851
current_ts = 194.671204
current_received_ts = 194.671204
current_seq = 1861
count = 2
seq_step = 1
(kms_flip:3693) DEBUG: flip ts/seq: last 194.504532/1851, current 194.671204/1861: elapsed=166671.0us expected=166676.9us +- 833.4us, error 0.0%
(kms_flip:3693) DEBUG: name = vblank
last_ts = 194.654526
last_received_ts = 194.654510
last_seq = 1860
current_ts = 194.821213
current_received_ts = 194.821228
current_seq = 1870
count = 2
seq_step = 10
(kms_flip:3693) DEBUG: vblank ts/seq: last 194.654526/1860, current 194.821213/1870: elapsed=166687.0us expected=166676.9us +- 833.4us, error 0.0%
(kms_flip:3693) DEBUG: name = flip
last_ts = 194.671204
last_received_ts = 194.671204
last_seq = 1861
current_ts = 194.837875
current_received_ts = 194.837601
current_seq = 1871
count = 3
seq_step = 1
(kms_flip:3693) DEBUG: flip ts/seq: last 194.671204/1861, current 194.837875/1871: elapsed=166679.0us expected=166676.9us +- 833.4us, error 0.0%
(kms_flip:3693) DEBUG: name = vblank
last_ts = 194.821213
last_received_ts = 194.821228
last_seq = 1870
current_ts = 194.987900
current_received_ts = 194.987900
current_seq = 1880
count = 3
seq_step = 10
(kms_flip:3693) DEBUG: vblank ts/seq: last 194.821213/1870, current 194.987900/1880: elapsed=166675.0us expected=166676.9us +- 833.4us, error 0.0%
(kms_flip:3693) DEBUG: name = flip
last_ts = 194.837875
last_received_ts = 194.837601
last_seq = 1871
current_ts = 195.004562
current_received_ts = 195.004349
current_seq = 1881
count = 4
seq_step = 1
(kms_flip:3693) DEBUG: flip ts/seq: last 194.837875/1871, current 195.004562/1881: elapsed=166676.0us expected=166676.9us +- 833.4us, error 0.0%
(kms_flip:3693) DEBUG: name = vblank
last_ts = 194.987900
last_received_ts = 194.987900
last_seq = 1880
current_ts = 195.154572
current_received_ts = 195.154602
current_seq = 1890
count = 4
seq_step = 10
(kms_flip:3693) DEBUG: vblank ts/seq: last 194.987900/1880, current 195.154572/1890: elapsed=166669.0us expected=166676.9us +- 833.4us, error 0.0%
(kms_flip:3693) DEBUG: name = flip
last_ts = 195.004562
last_received_ts = 195.004349
last_seq = 1881
current_ts = 195.171234
current_received_ts = 195.171188
current_seq = 1891
count = 5
seq_step = 1
(kms_flip:3693) DEBUG: flip ts/seq: last 195.004562/1881, current 195.171234/1891: elapsed=166679.0us expected=166676.9us +- 833.4us, error 0.0%
(kms_flip:3693) DEBUG: name = vblank
last_ts = 195.154572
last_received_ts = 195.154602
last_seq = 1890
current_ts = 195.321243
current_received_ts = 195.321228
current_seq = 1900
count = 5
seq_step = 10
(kms_flip:3693) DEBUG: vblank ts/seq: last 195.154572/1890, current 195.321243/1900: elapsed=166683.0us expected=166676.9us +- 833.4us, error 0.0%
(kms_flip:3693) DEBUG: name = flip
last_ts = 195.171234
last_received_ts = 195.171188
last_seq = 1891
current_ts = 195.337906
current_received_ts = 195.337906
current_seq = 1901
count = 6
seq_step = 1
(kms_flip:3693) DEBUG: flip ts/seq: last 195.171234/1891, current 195.337906/1901: elapsed=166670.0us expected=166676.9us +- 833.4us, error 0.0%
(kms_flip:3693) DEBUG: name = vblank
last_ts = 195.321243
last_received_ts = 195.321228
last_seq = 1900
current_ts = 195.487930
current_received_ts = 195.487946
current_seq = 1910
count = 6
seq_step = 10
(kms_flip:3693) DEBUG: vblank ts/seq: last 195.321243/1900, current 195.487930/1910: elapsed=166677.0us expected=166676.9us +- 833.4us, error 0.0%
(kms_flip:3693) DEBUG: name = flip
last_ts = 195.337906
last_received_ts = 195.337906
last_seq = 1901
current_ts = 195.504593
current_received_ts = 195.504395
current_seq = 1911
count = 7
seq_step = 1
(kms_flip:3693) DEBUG: flip ts/seq: last 195.337906/1901, current 195.504593/1911: elapsed=166689.0us expected=166676.9us +- 833.4us, error 0.0%
(kms_flip:3693) DEBUG: name = vblank
last_ts = 195.487930
last_received_ts = 195.487946
last_seq = 1910
current_ts = 195.654602
current_received_ts = 195.654617
current_seq = 1920
count = 7
seq_step = 10
(kms_flip:3693) DEBUG: vblank ts/seq: last 195.487930/1910, current 195.654602/1920: elapsed=166679.0us expected=166676.9us +- 833.4us, error 0.0%
(kms_flip:3693) DEBUG: name = flip
last_ts = 195.504593
last_received_ts = 195.504395
last_seq = 1911
current_ts = 195.671265
current_received_ts = 195.671204
current_seq = 1921
count = 8
seq_step = 1
(kms_flip:3693) DEBUG: flip ts/seq: last 195.504593/1911, current 195.671265/1921: elapsed=166674.0us expected=166676.9us +- 833.4us, error 0.0%
(kms_flip:3693) DEBUG: name = vblank
last_ts = 195.654602
last_received_ts = 195.654617
last_seq = 1920
current_ts = 195.821259
current_received_ts = 195.821259
current_seq = 1930
count = 8
seq_step = 10
(kms_flip:3693) DEBUG: vblank ts/seq: last 195.654602/1920, current 195.821259/1930: elapsed=166663.0us expected=166676.9us +- 833.4us, error 0.0%
(kms_flip:3693) DEBUG: name = flip
last_ts = 195.671265
last_received_ts = 195.671204
last_seq = 1921
current_ts = 195.837936
current_received_ts = 195.837921
current_seq = 1931
count = 9
seq_step = 1
(kms_flip:3693) DEBUG: flip ts/seq: last 195.671265/1921, current 195.837936/1931: elapsed=166676.0us expected=166676.9us +- 833.4us, error 0.0%
(kms_flip:3693) DEBUG: name = vblank
last_ts = 195.821259
last_received_ts = 195.821259
last_seq = 1930
current_ts = 195.987946
current_received_ts = 195.987915
current_seq = 1940
count = 9
seq_step = 10
(kms_flip:3693) DEBUG: vblank ts/seq: last 195.821259/1930, current 195.987946/1940: elapsed=166677.0us expected=166676.9us +- 833.4us, error 0.0%
(kms_flip:3693) DEBUG: name = flip
last_ts = 195.837936
last_received_ts = 195.837921
last_seq = 1931
current_ts = 196.004623
current_received_ts = 196.004288
current_seq = 1941
count = 10
seq_step = 1
(kms_flip:3693) DEBUG: flip ts/seq: last 195.837936/1931, current 196.004623/1941: elapsed=166673.0us expected=166676.9us +- 833.4us, error 0.0%
(kms_flip:3693) DEBUG: name = vblank
last_ts = 195.987946
last_received_ts = 195.987915
last_seq = 1940
current_ts = 196.154633
current_received_ts = 196.154633
current_seq = 1950
count = 10
seq_step = 10
(kms_flip:3693) DEBUG: vblank ts/seq: last 195.987946/1940, current 196.154633/1950: elapsed=166684.0us expected=166676.9us +- 833.4us, error 0.0%
(kms_flip:3693) DEBUG: name = flip
last_ts = 196.004623
last_received_ts = 196.004288
last_seq = 1941
current_ts = 196.171295
current_received_ts = 196.171326
current_seq = 1951
count = 11
seq_step = 1
(kms_flip:3693) DEBUG: flip ts/seq: last 196.004623/1941, current 196.171295/1951: elapsed=166673.0us expected=166676.9us +- 833.4us, error 0.0%
(kms_flip:3693) DEBUG: name = vblank
last_ts = 196.154633
last_received_ts = 196.154633
last_seq = 1950
current_ts = 196.321304
current_received_ts = 196.321320
current_seq = 1960
count = 11
seq_step = 10
(kms_flip:3693) DEBUG: vblank ts/seq: last 196.154633/1950, current 196.321304/1960: elapsed=166675.0us expected=166676.9us +- 833.4us, error 0.0%
(kms_flip:3693) DEBUG: name = flip
last_ts = 196.171295
last_received_ts = 196.171326
last_seq = 1951
current_ts = 196.337982
current_received_ts = 196.337967
current_seq = 1961
count = 12
seq_step = 1
(kms_flip:3693) DEBUG: flip ts/seq: last 196.171295/1951, current 196.337982/1961: elapsed=166685.0us expected=166676.9us +- 833.4us, error 0.0%
(kms_flip:3693) DEBUG: name = vblank
last_ts = 196.321304
last_received_ts = 196.321320
last_seq = 1960
current_ts = 196.487976
current_received_ts = 196.487686
current_seq = 1970
count = 12
seq_step = 10
(kms_flip:3693) DEBUG: vblank ts/seq: last 196.321304/1960, current 196.487976/1970: elapsed=166671.0us expected=166676.9us +- 833.4us, error 0.0%
(kms_flip:3693) CRITICAL: Test assertion failure function wait_for_events, file ../tests/kms_flip.c:1304:
(kms_flip:3693) CRITICAL: Failed assertion: ret > 0
(kms_flip:3693) CRITICAL: select timed out or error (ret 0)
(kms_flip:3693) igt_core-INFO: Stack trace:
(kms_flip:3693) igt_core-INFO:   #0 ../lib/igt_core.c:2075 __igt_fail_assert()
(kms_flip:3693) igt_core-INFO:   #1 ../tests/kms_flip.c:1288 wait_for_events()
(kms_flip:3693) igt_core-INFO:   #2 ../tests/kms_flip.c:1334 run_test_on_crtc_set.constprop.0()
(kms_flip:3693) igt_core-INFO:   #3 ../tests/kms_flip.c:1972 run_pair()
(kms_flip:3693) igt_core-INFO:   #4 ../tests/kms_flip.c:2129 __igt_unique____real_main2043()
(kms_flip:3693) igt_core-INFO:   #5 ../tests/kms_flip.c:2043 main()
(kms_flip:3693) igt_core-INFO:   #6 [__libc_init_first+0x8a]
(kms_flip:3693) igt_core-INFO:   #7 [__libc_start_main+0x8b]
(kms_flip:3693) igt_core-INFO:   #8 [_start+0x25]
****  END  ****
Dynamic subtest CD-DP2-HDMI-A3: FAIL (5.869s)
Subtest 2x-flip-vs-absolute-wf_vblank: FAIL (34.624s)
Dmesg

Scroll to first warning
<6> [193.669653] [IGT] kms_flip: starting dynamic subtest CD-DP2-HDMI-A3
<7> [193.670133] xe 0000:03:00.0: [drm:drm_mode_addfb2] [FB:557]
<7> [193.670406] xe 0000:03:00.0: [drm:drm_mode_addfb2] [FB:559]
<7> [193.733452] xe 0000:03:00.0: [drm:drm_mode_setcrtc] [CRTC:150:pipe A]
<7> [193.734198] xe 0000:03:00.0: [drm:drm_mode_setcrtc] [CRTC:268:pipe B]
<7> [193.734336] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:268:pipe B] fastset requirement not met in hw.enable (expected yes, found no)
<7> [193.734636] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:268:pipe B] fastset requirement not met in hw.active (expected yes, found no)
<7> [193.734874] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:268:pipe B] fastset requirement not met in cpu_transcoder (expected 1, found -1)
<7> [193.735107] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:268:pipe B] fastset requirement not met in lane_count (expected 4, found 0)
<7> [193.735316] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:268:pipe B] fastset requirement not met in dp_m_n (expected tu 64 data 5190451/8388608 link 288358/524288, found tu 0, data 0/0 link 0/0)
<7> [193.735553] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:268:pipe B] fastset requirement not met in output_types (expected 0x00000080, found 0x00000000)
<7> [193.735765] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:268:pipe B] fastset requirement not met in framestart_delay (expected 1, found 0)
<7> [193.735974] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:268:pipe B] fastset requirement not met in hw.pipe_mode.crtc_hdisplay (expected 1920, found 0)
<7> [193.736173] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:268:pipe B] fastset requirement not met in hw.pipe_mode.crtc_htotal (expected 2200, found 0)
<7> [193.736366] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:268:pipe B] fastset requirement not met in hw.pipe_mode.crtc_hblank_start (expected 1920, found 0)
<7> [193.736574] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:268:pipe B] fastset requirement not met in hw.pipe_mode.crtc_hblank_end (expected 2200, found 0)
<7> [193.736755] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:268:pipe B] fastset requirement not met in hw.pipe_mode.crtc_hsync_start (expected 2008, found 0)
<7> [193.736937] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:268:pipe B] fastset requirement not met in hw.pipe_mode.crtc_hsync_end (expected 2052, found 0)
<7> [193.737116] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:268:pipe B] fastset requirement not met in hw.pipe_mode.crtc_vdisplay (expected 1080, found 0)
<7> [193.737291] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:268:pipe B] fastset requirement not met in hw.pipe_mode.crtc_vblank_start (expected 1080, found 0)
<7> [193.737530] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:268:pipe B] fastset requirement not met in hw.pipe_mode.crtc_vsync_start (expected 1084, found 0)
<7> [193.737698] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:268:pipe B] fastset requirement not met in hw.pipe_mode.crtc_vsync_end (expected 1089, found 0)
<7> [193.737865] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:268:pipe B] fastset requirement not met in hw.pipe_mode.crtc_vtotal (expected 1125, found 0)
<7> [193.738030] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:268:pipe B] fastset requirement not met in hw.pipe_mode.crtc_vblank_end (expected 1125, found 0)
<7> [193.738190] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:268:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_hdisplay (expected 1920, found 0)
<7> [193.738346] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:268:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_htotal (expected 2200, found 0)
<7> [193.738513] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:268:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_hblank_start (expected 1920, found 0)
<7> [193.738665] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:268:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_hblank_end (expected 2200, found 0)
<7> [193.738811] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:268:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_hsync_start (expected 2008, found 0)
<7> [193.738963] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:268:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_hsync_end (expected 2052, found 0)
<7> [193.739113] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:268:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_vdisplay (expected 1080, found 0)
<7> [193.739261] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:268:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_vblank_start (expected 1080, found 0)
<7> [193.739406] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:268:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_vsync_start (expected 1084, found 0)
<7> [193.739557] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:268:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_vsync_end (expected 1089, found 0)
<7> [193.739690] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:268:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_vtotal (expected 1125, found 0)
<7> [193.739823] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:268:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_vblank_end (expected 1125, found 0)
<7> [193.739956] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:268:pipe B] fastset requirement not met in pixel_multiplier (expected 1, found 0)
<7> [193.740090] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:268:pipe B] fastset requirement not met in hw.adjusted_mode.flags (1) (expected 1, found 0)
<7> [193.740217] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:268:pipe B] fastset requirement not met in hw.adjusted_mode.flags (4) (expected 4, found 0)
<7> [193.740342] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:268:pipe B] fastset requirement not met in enhanced_framing (expected yes, found no)
<7> [193.740491] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:268:pipe B] fastset requirement not met in pipe_bpp (expected 36, found 0)
<7> [193.740622] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:268:pipe B] fastset requirement not met in hw.pipe_mode.crtc_clock (expected 148500, found 0)
<7> [193.740747] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:268:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_clock (expected 148500, found 0)
<7> [193.740872] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:268:pipe B] fastset requirement not met in port_clock (expected 270000, found 0)
<7> [193.740996] xe 0000:03:00.0: [drm:intel_atomic_check [xe]] [CRTC:268:pipe B] fastset requirement not met, forcing full modeset
<7> [193.741113] xe 0000:03:00.0: [drm:intel_dpll_crtc_put [xe]] [CRTC:268:pipe B] releasing TC PLL 2
<7> [193.741252] xe 0000:03:00.0: [drm:skl_compute_wm [xe]] Enabled dbuf slices 0xf -> 0x3 (total dbuf slices 0xf), mbus joined? no->no
<7> [193.741349] xe 0000:03:00.0: [drm:skl_compute_wm [xe]] [CRTC:268:pipe B] dbuf slices 0xc -> 0x0, ddb (0 - 2048) -> (0 - 0), active pipes 0xa -> 0x8
<7> [193.741479] xe 0000:03:00.0: [drm:skl_compute_wm [xe]] [PLANE:262:cursor B] ddb (1989 - 2048) -> ( 0 - 0), size 59 -> 0
<7> [193.741598] xe 0000:03:00.0: [drm:intel_cdclk_atomic_check [xe]] [CRTC:268:pipe B] min cdclk: 192000 kHz -> 0 kHz
<7> [193.741736] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] [CRTC:268:pipe B] enable: no [modeset]
<7> [193.741851] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] [PLANE:152:plane 1B] fb: [NOFB], visible: no
<7> [193.741961] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] [PLANE:182:plane 2B] fb: [NOFB], visible: no
<7> [193.742069] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] [PLANE:212:plane 3B] fb: [NOFB], visible: no
<7> [193.742174] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] [PLANE:242:plane 4B] fb: [NOFB], visible: no
<7> [193.742275] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] [PLANE:252:plane 5B] fb: [NOFB], visible: no
<7> [193.742374] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] [PLANE:262:cursor B] fb: [NOFB], visible: no
<7> [193.743062] xe 0000:03:00.0: [drm:intel_audio_codec_disable [xe]] [CONNECTOR:526:DP-2][ENCODER:525:DDI TC2/PHY G] Disable audio codec on [CRTC:268:pipe B]
<7> [193.763128] xe 0000:03:00.0: [drm:intel_audio_component_get_eld [xe]] Not valid for port E
<7> [193.763734] xe 0000:03:00.0: [drm:intel_disable_transcoder [xe]] disabling pipe B
<7> [193.785581] xe 0000:03:00.0: [drm:intel_power_well_enable [xe]] enabling AUX_TC2
<7> [193.787818] xe 0000:03:00.0: [drm:intel_audio_component_get_power [xe]] restored AUD_FREQ_CNTRL to 0x8010
<7> [193.788326] xe 0000:03:00.0: [drm:intel_dpll_disable [xe]] disable TC PLL 2 (active 0x2, on? 1) for [CRTC:268:pipe B]
<7> [193.791041] xe 0000:03:00.0: [drm:intel_dpll_disable [xe]] disabling TC PLL 2
<7> [193.792090] xe 0000:03:00.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:506:DDI TC1/PHY F]
<7> [193.792651] xe 0000:03:00.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:508:DP-MST A]
<7> [193.793354] xe 0000:03:00.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:509:DP-MST B]
<7> [193.794135] xe 0000:03:00.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:510:DP-MST C]
<7> [193.794866] xe 0000:03:00.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:511:DP-MST D]
<7> [193.795574] xe 0000:03:00.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:525:DDI TC2/PHY G]
<7> [193.796307] xe 0000:03:00.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:527:DP-MST A]
<7> [193.796892] xe 0000:03:00.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:528:DP-MST B]
<7> [193.797291] xe 0000:03:00.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:529:DP-MST C]
<7> [193.797800] xe 0000:03:00.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:530:DP-MST D]
<7> [193.798306] xe 0000:03:00.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:537:DDI TC3/PHY H]
<7> [193.798848] xe 0000:03:00.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:541:DDI TC4/PHY I]
<7> [193.799313] xe 0000:03:00.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:543:DP-MST A]
<7> [193.799803] xe 0000:03:00.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:544:DP-MST B]
<7> [193.800214] xe 0000:03:00.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:545:DP-MST C]
<7> [193.800514] xe 0000:03:00.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:546:DP-MST D]
<7> [193.800793] xe 0000:03:00.0: [drm:verify_connector_state [xe]] [CONNECTOR:526:DP-2]
<7> [193.803066] xe 0000:03:00.0: [drm:intel_dbuf_mdclk_cdclk_ratio_update [xe]] Updating dbuf ratio to 2 (mbus joined: no)
<7> [193.803380] xe 0000:03:00.0: [drm:gen9_dbuf_slices_update [xe]] Updating dbuf slices to 0x3
<7> [193.803793] xe 0000:03:00.0: [drm:intel_power_well_disable [xe]] disabling PW_B
<7> [193.804178] xe 0000:03:00.0: [drm:dss_pipe_gating_enable_disable [xe]] DSS clock gating disabled for pipe_mask=0x2 (CLKGATE_DIS_DSSDSC=0x2a000000)
<7> [193.804600] xe 0000:03:00.0: [drm:intel_modeset_verify_crtc [xe]] [CRTC:268:pipe B]
<7> [193.805160] xe 0000:03:00.0: [drm:drm_mode_setcrtc] [CRTC:386:pipe C]
<7> [193.805627] xe 0000:03:00.0: [drm:drm_mode_setcrtc] [CRTC:504:pipe D]
<7> [193.805751] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:504:pipe D] fastset requirement not met in hw.enable (expected yes, found no)
<7> [193.805970] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:504:pipe D] fastset requirement not met in hw.active (expected yes, found no)
<7> [193.806179] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:504:pipe D] fastset requirement not met in cpu_transcoder (expected 3, found -1)
<7> [193.806371] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:504:pipe D] fastset requirement not met in lane_count (expected 4, found 0)
<7> [193.806560] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:504:pipe D] fastset requirement not met in output_types (expected 0x00000040, found 0x00000000)
<7> [193.806685] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:504:pipe D] fastset requirement not met in framestart_delay (expected 1, found 0)
<7> [193.806805] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:504:pipe D] fastset requirement not met in hw.pipe_mode.crtc_hdisplay (expected 1920, found 0)
<7> [193.806937] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:504:pipe D] fastset requirement not met in hw.pipe_mode.crtc_htotal (expected 2200, found 0)
<7> [193.807106] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:504:pipe D] fastset requirement not met in hw.pipe_mode.crtc_hblank_start (expected 1920, found 0)
<7> [193.807261] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:504:pipe D] fastset requirement not met in hw.pipe_mode.crtc_hblank_end (expected 2200, found 0)
<7> [193.807419] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:504:pipe D] fastset requirement not met in hw.pipe_mode.crtc_hsync_start (expected 2008, found 0)
<7> [193.807603] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:504:pipe D] fastset requirement not met in hw.pipe_mode.crtc_hsync_end (expected 2052, found 0)
<7> [193.807757] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:504:pipe D] fastset requirement not met in hw.pipe_mode.crtc_vdisplay (expected 1080, found 0)
<7> [193.807877] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:504:pipe D] fastset requirement not met in hw.pipe_mode.crtc_vblank_start (expected 1080, found 0)
<7> [193.807985] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:504:pipe D] fastset requirement not met in hw.pipe_mode.crtc_vsync_start (expected 1084, found 0)
<7> [193.808084] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:504:pipe D] fastset requirement not met in hw.pipe_mode.crtc_vsync_end (expected 1089, found 0)
<7> [193.808178] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:504:pipe D] fastset requirement not met in hw.pipe_mode.crtc_vtotal (expected 1125, found 0)
<7> [193.808303] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:504:pipe D] fastset requirement not met in hw.pipe_mode.crtc_vblank_end (expected 1125, found 0)
<7> [193.808438] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:504:pipe D] fastset requirement not met in hw.adjusted_mode.crtc_hdisplay (expected 1920, found 0)
<7> [193.808574] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:504:pipe D] fastset requirement not met in hw.adjusted_mode.crtc_htotal (expected 2200, found 0)
<7> [193.808700] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:504:pipe D] fastset requirement not met in hw.adjusted_mode.crtc_hblank_start (expected 1920, found 0)
<7> [193.808827] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:504:pipe D] fastset requirement not met in hw.adjusted_mode.crtc_hblank_end (expected 2200, found 0)
<7> [193.808937] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:504:pipe D] fastset requirement not met in hw.adjusted_mode.crtc_hsync_start (expected 2008, found 0)
<7> [193.809027] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:504:pipe D] fastset requirement not met in hw.adjusted_mode.crtc_hsync_end (expected 2052, found 0)
<7> [193.809117] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:504:pipe D] fastset requirement not met in hw.adjusted_mode.crtc_vdisplay (expected 1080, found 0)
<7> [193.809204] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:504:pipe D] fastset requirement not met in hw.adjusted_mode.crtc_vblank_start (expected 1080, found 0)
<7> [193.809317] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:504:pipe D] fastset requirement not met in hw.adjusted_mode.crtc_vsync_start (expected 1084, found 0)
<7> [193.809450] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:504:pipe D] fastset requirement not met in hw.adjusted_mode.crtc_vsync_end (expected 1089, found 0)
<7> [193.809590] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:504:pipe D] fastset requirement not met in hw.adjusted_mode.crtc_vtotal (expected 1125, found 0)
<7> [193.809715] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:504:pipe D] fastset requirement not met in hw.adjusted_mode.crtc_vblank_end (expected 1125, found 0)
<7> [193.809843] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:504:pipe D] fastset requirement not met in pixel_multiplier (expected 1, found 0)
<7> [193.809970] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:504:pipe D] fastset requirement not met in hw.adjusted_mode.flags (1) (expected 1, found 0)
<7> [193.810072] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:504:pipe D] fastset requirement not met in hw.adjusted_mode.flags (4) (expected 4, found 0)
<7> [193.810161] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:504:pipe D] fastset requirement not met in has_hdmi_sink (expected yes, found no)
<7> [193.810249] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:504:pipe D] fastset requirement not met in has_infoframe (expected yes, found no)
<7> [193.810334] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:504:pipe D] fastset requirement not met in pipe_bpp (expected 36, found 0)
<7> [193.810437] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:504:pipe D] fastset requirement not met in hw.pipe_mode.crtc_clock (expected 148500, found 0)
<7> [193.810574] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:504:pipe D] fastset requirement not met in hw.adjusted_mode.crtc_clock (expected 148500, found 0)
<7> [193.810704] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:504:pipe D] fastset requirement not met in port_clock (expected 222750, found 0)
<7> [193.810832] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:504:pipe D] fastset requirement not met in infoframes.enable (expected 0x00000071, found 0x00000000)
<7> [193.810959] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:504:pipe D] fastset requirement not met in infoframes.gcp (expected 0x00000006, found 0x00000000)
<7> [193.811089] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:504:pipe D] fastset requirement not met in avi infoframe
<7> [193.811180] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] expected:
<7> [193.811266] xe 0000:03:00.0: HDMI infoframe: Auxiliary Video Information (AVI), version 2, length 13
<7> [193.811268] xe 0000:03:00.0: colorspace: RGB
<7> [193.811269] xe 0000:03:00.0: scan mode: Underscan
<7> [193.811270] xe 0000:03:00.0: colorimetry: No Data
<7> [193.811271] xe 0000:03:00.0: picture aspect: 16:9
<7> [193.811272] xe 0000:03:00.0: active aspect: Same as Picture
<7> [193.811273] xe 0000:03:00.0: itc: No Data
<7> [193.811274] xe 0000:03:00.0: extended colorimetry: xvYCC 601
<7> [193.811275] xe 0000:03:00.0: quantization range: Default
<7> [193.811276] xe 0000:03:00.0: nups: Unknown Non-uniform Scaling
<7> [193.811277] xe 0000:03:00.0: video code: 16
<7> [193.811278] xe 0000:03:00.0: ycc quantization range: Full
<7> [193.811279] xe 0000:03:00.0: hdmi content type: Graphics
<7> [193.811280] xe 0000:03:00.0: pixel repeat: 0
<7> [193.811281] xe 0000:03:00.0: bar top 0, bottom 0, left 0, right 0
<7> [193.811282] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] found:
<7> [193.811368] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:504:pipe D] fastset requirement not met in spd infoframe
<7> [193.811474] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] expected:
<7> [193.811610] xe 0000:03:00.0: HDMI infoframe: Source Product Description (SPD), version 1, length 25
<7> [193.811613] xe 0000:03:00.0: vendor: Intel
<7> [193.811615] xe 0000:03:00.0: product: Discrete gfx
<7> [193.811617] xe 0000:03:00.0: source device information: PC General (0x9)
<7> [193.811619] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] found:
<7> [193.811747] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:504:pipe D] fastset requirement not met in hdmi infoframe
<7> [193.811877] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] expected:
<7> [193.812007] xe 0000:03:00.0: HDMI infoframe: Vendor, version 1, length 4
<7> [193.812010] xe 0000:03:00.0: empty frame
<7> [193.812012] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] found:
<7> [193.812140] xe 0000:03:00.0: [drm:intel_atomic_check [xe]] [CRTC:504:pipe D] fastset requirement not met, forcing full modeset
<7> [193.812258] xe 0000:03:00.0: [drm:intel_dpll_crtc_put [xe]] [CRTC:504:pipe D] releasing TC PLL 3
<7> [193.812361] xe 0000:03:00.0: [drm:skl_compute_wm [xe]] Enabled dbuf slices 0x3 -> 0x1 (total dbuf slices 0xf), mbus joined? no->no
<7> [193.812443] xe 0000:03:00.0: [drm:skl_compute_wm [xe]] [CRTC:504:pipe D] dbuf slices 0x3 -> 0x0, ddb (0 - 2048) -> (0 - 0), active pipes 0x8 -> 0x0
<7> [193.812542] xe 0000:03:00.0: [drm:skl_compute_wm [xe]] [PLANE:498:cursor D] ddb (1989 - 2048) -> ( 0 - 0), size 59 -> 0
<7> [193.812662] xe 0000:03:00.0: [drm:intel_cdclk_atomic_check [xe]] [CRTC:504:pipe D] min cdclk: 192000 kHz -> 0 kHz
<7> [193.812818] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] [CRTC:504:pipe D] enable: no [modeset]
<7> [193.812954] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] [PLANE:388:plane 1D] fb: [NOFB], visible: no
<7> [193.813085] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] [PLANE:418:plane 2D] fb: [NOFB], visible: no
<7> [193.813216] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] [PLANE:448:plane 3D] fb: [NOFB], visible: no
<7> [193.813344] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] [PLANE:478:plane 4D] fb: [NOFB], visible: no
<7> [193.813480] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] [PLANE:488:plane 5D] fb: [NOFB], visible: no
<7> [193.813579] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] [PLANE:498:cursor D] fb: [NOFB], visible: no
<7> [193.814238] xe 0000:03:00.0: [drm:intel_audio_codec_disable [xe]] [CONNECTOR:538:HDMI-A-3][ENCODER:537:DDI TC3/PHY H] Disable audio codec on [CRTC:504:pipe D]
<7> [193.840618] xe 0000:03:00.0: [drm:intel_audio_component_get_eld [xe]] Not valid for port F
<7> [193.841227] xe 0000:03:00.0: [drm:intel_disable_transcoder [xe]] disabling pipe D
<7> [193.854134] xe 0000:03:00.0: [drm:intel_audio_component_get_power [xe]] restored AUD_FREQ_CNTRL to 0x8010
<7> [193.862859] xe 0000:03:00.0: [drm:intel_dpll_disable [xe]] disable TC PLL 3 (active 0x8, on? 1) for [CRTC:504:pipe D]
<7> [193.865774] xe 0000:03:00.0: [drm:intel_dpll_disable [xe]] disabling TC PLL 3
<7> [193.866798] xe 0000:03:00.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:506:DDI TC1/PHY F]
<7> [193.867566] xe 0000:03:00.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:508:DP-MST A]
<7> [193.868153] xe 0000:03:00.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:509:DP-MST B]
<7> [193.868800] xe 0000:03:00.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:510:DP-MST C]
<7> [193.869305] xe 0000:03:00.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:511:DP-MST D]
<7> [193.869897] xe 0000:03:00.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:525:DDI TC2/PHY G]
<7> [193.870276] xe 0000:03:00.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:527:DP-MST A]
<7> [193.870752] xe 0000:03:00.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:528:DP-MST B]
<7> [193.871182] xe 0000:03:00.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:529:DP-MST C]
<7> [193.871625] xe 0000:03:00.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:530:DP-MST D]
<7> [193.872024] xe 0000:03:00.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:537:DDI TC3/PHY H]
<7> [193.872619] xe 0000:03:00.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:541:DDI TC4/PHY I]
<7> [193.872969] xe 0000:03:00.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:543:DP-MST A]
<7> [193.873306] xe 0000:03:00.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:544:DP-MST B]
<7> [193.873585] xe 0000:03:00.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:545:DP-MST C]
<7> [193.873840] xe 0000:03:00.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:546:DP-MST D]
<7> [193.874089] xe 0000:03:00.0: [drm:verify_connector_state [xe]] [CONNECTOR:538:HDMI-A-3]
<7> [193.874632] xe 0000:03:00.0: [drm:intel_dbuf_mdclk_cdclk_ratio_update [xe]] Updating dbuf ratio to 2 (mbus joined: no)
<7> [193.875101] xe 0000:03:00.0: [drm:gen9_dbuf_slices_update [xe]] Updating dbuf slices to 0x1
<7> [193.875685] xe 0000:03:00.0: [drm:intel_power_well_disable [xe]] disabling PW_D
<7> [193.876168] xe 0000:03:00.0: [drm:dss_pipe_gating_enable_disable [xe]] DSS clock gating disabled for pipe_mask=0x8 (CLKGATE_DIS_DSSDSC=0xaa000000)
<7> [193.876416] xe 0000:03:00.0: [drm:intel_power_well_disable [xe]] disabling PW_2
<7> [193.876849] xe 0000:03:00.0: [drm:intel_modeset_verify_crtc [xe]] [CRTC:504:pipe D]
<7> [193.877819] xe 0000:03:00.0: [drm:drm_mode_setcrtc] [CRTC:504:pipe D]
<7> [193.877868] xe 0000:03:00.0: [drm:drm_mode_setcrtc] [CONNECTOR:538:HDMI-A-3]
<7> [193.877993] xe 0000:03:00.0: [drm:intel_hdmi_compute_clock [xe]] picking 12 bpc for HDMI output (pipe bpp: 36)
<7> [193.878137] xe 0000:03:00.0: [drm:intel_atomic_check [xe]] [CRTC:504:pipe D] hw max bpp: 36, pipe bpp: 36, dithering: 0
<7> [193.878275] xe 0000:03:00.0: [drm:intel_ddi_compute_config_late [xe]] [ENCODER:537:DDI TC3/PHY H] [CRTC:504:pipe D]
<7> [193.878424] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:504:pipe D] fastset requirement not met in hw.enable (expected no, found yes)
<7> [193.878645] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:504:pipe D] fastset requirement not met in hw.active (expected no, found yes)
<7> [193.878823] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:504:pipe D] fastset requirement not met in cpu_transcoder (expected -1, found 3)
<7> [193.878998] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:504:pipe D] fastset requirement not met in lane_count (expected 0, found 4)
<7> [193.879166] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:504:pipe D] fastset requirement not met in output_types (expected 0x00000000, found 0x00000040)
<7> [193.879317] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:504:pipe D] fastset requirement not met in framestart_delay (expected 0, found 1)
<7> [193.879439] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:504:pipe D] fastset requirement not met in hw.pipe_mode.crtc_hdisplay (expected 0, found 1920)
<7> [193.879546] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:504:pipe D] fastset requirement not met in hw.pipe_mode.crtc_htotal (expected 0, found 2200)
<7> [193.879646] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:504:pipe D] fastset requirement not met in hw.pipe_mode.crtc_hblank_start (expected 0, found 1920)
<7> [193.879789] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:504:pipe D] fastset requirement not met in hw.pipe_mode.crtc_hblank_end (expected 0, found 2200)
<7> [193.879937] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:504:pipe D] fastset requirement not met in hw.pipe_mode.crtc_hsync_start (expected 0, found 2008)
<7> [193.880085] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:504:pipe D] fastset requirement not met in hw.pipe_mode.crtc_hsync_end (expected 0, found 2052)
<7> [193.880225] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:504:pipe D] fastset requirement not met in hw.pipe_mode.crtc_vdisplay (expected 0, found 1080)
<7> [193.880368] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:504:pipe D] fastset requirement not met in hw.pipe_mode.crtc_vblank_start (expected 0, found 1080)
<7> [193.880531] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:504:pipe D] fastset requirement not met in hw.pipe_mode.crtc_vsync_start (expected 0, found 1084)
<7> [193.880633] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:504:pipe D] fastset requirement not met in hw.pipe_mode.crtc_vsync_end (expected 0, found 1089)
<7> [193.880730] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:504:pipe D] fastset requirement not met in hw.pipe_mode.crtc_vtotal (expected 0, found 1125)
<7> [193.880825] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:504:pipe D] fastset requirement not met in hw.pipe_mode.crtc_vblank_end (expected 0, found 1125)
<7> [193.880920] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:504:pipe D] fastset requirement not met in hw.adjusted_mode.crtc_hdisplay (expected 0, found 1920)
<7> [193.881040] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:504:pipe D] fastset requirement not met in hw.adjusted_mode.crtc_htotal (expected 0, found 2200)
<7> [193.881178] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:504:pipe D] fastset requirement not met in hw.adjusted_mode.crtc_hblank_start (expected 0, found 1920)
<7> [193.881313] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:504:pipe D] fastset requirement not met in hw.adjusted_mode.crtc_hblank_end (expected 0, found 2200)
<7> [193.881505] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:504:pipe D] fastset requirement not met in hw.adjusted_mode.crtc_hsync_start (expected 0, found 2008)
<7> [193.881621] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:504:pipe D] fastset requirement not met in hw.adjusted_mode.crtc_hsync_end (expected 0, found 2052)
<7> [193.881725] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:504:pipe D] fastset requirement not met in hw.adjusted_mode.crtc_vdisplay (expected 0, found 1080)
<7> [193.881828] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:504:pipe D] fastset requirement not met in hw.adjusted_mode.crtc_vblank_start (expected 0, found 1080)
<7> [193.881927] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:504:pipe D] fastset requirement not met in hw.adjusted_mode.crtc_vsync_start (expected 0, found 1084)
<7> [193.882022] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:504:pipe D] fastset requirement not met in hw.adjusted_mode.crtc_vsync_end (expected 0, found 1089)
<7> [193.882117] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:504:pipe D] fastset requirement not met in hw.adjusted_mode.crtc_vtotal (expected 0, found 1125)
<7> [193.882211] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:504:pipe D] fastset requirement not met in hw.adjusted_mode.crtc_vblank_end (expected 0, found 1125)
<7> [193.882305] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:504:pipe D] fastset requirement not met in pixel_multiplier (expected 0, found 1)
<7> [193.882400] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:504:pipe D] fastset requirement not met in hw.adjusted_mode.flags (1) (expected 0, found 1)
<7> [193.882509] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:504:pipe D] fastset requirement not met in hw.adjusted_mode.flags (4) (expected 0, found 4)
<7> [193.882612] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:504:pipe D] fastset requirement not met in has_hdmi_sink (expected no, found yes)
<7> [193.882712] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:504:pipe D] fastset requirement not met in has_infoframe (expected no, found yes)
<7> [193.882809] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:504:pipe D] fastset requirement not met in pipe_bpp (expected 0, found 36)
<7> [193.882903] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:504:pipe D] fastset requirement not met in hw.pipe_mode.crtc_clock (expected 0, found 148500)
<7> [193.882997] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:504:pipe D] fastset requirement not met in hw.adjusted_mode.crtc_clock (expected 0, found 148500)
<7> [193.883091] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:504:pipe D] fastset requirement not met in port_clock (expected 0, found 222750)
<7> [193.883184] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:504:pipe D] fastset requirement not met in infoframes.enable (expected 0x00000000, found 0x00000071)
<7> [193.883277] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:504:pipe D] fastset requirement not met in infoframes.gcp (expected 0x00000000, found 0x00000006)
<7> [193.883368] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:504:pipe D] fastset requirement not met in avi infoframe
<7> [193.883474] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] expected:
<7> [193.883566] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] found:
<7> [193.883658] xe 0000:03:00.0: HDMI infoframe: Auxiliary Video Information (AVI), version 2, length 13
<7> [193.883660] xe 0000:03:00.0: colorspace: RGB
<7> [193.883661] xe 0000:03:00.0: scan mode: Underscan
<7> [193.883662] xe 0000:03:00.0: colorimetry: No Data
<7> [193.883663] xe 0000:03:00.0: picture aspect: 16:9
<7> [193.883664] xe 0000:03:00.0: active aspect: Same as Picture
<7> [193.883666] xe 0000:03:00.0: itc: No Data
<7> [193.883667] xe 0000:03:00.0: extended colorimetry: xvYCC 601
<7> [193.883668] xe 0000:03:00.0: quantization range: Default
<7> [193.883669] xe 0000:03:00.0: nups: Unknown Non-uniform Scaling
<7> [193.883670] xe 0000:03:00.0: video code: 16
<7> [193.883671] xe 0000:03:00.0: ycc quantization range: Full
<7> [193.883672] xe 0000:03:00.0: hdmi content type: Graphics
<7> [193.883673] xe 0000:03:00.0: pixel repeat: 0
<7> [193.883675] xe 0000:03:00.0: bar top 0, bottom 0, left 0, right 0
<7> [193.883676] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:504:pipe D] fastset requirement not met in spd infoframe
<7> [193.883770] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] expected:
<7> [193.883862] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] found:
<7> [193.883955] xe 0000:03:00.0: HDMI infoframe: Source Product Description (SPD), version 1, length 25
<7> [193.883957] xe 0000:03:00.0: vendor: Intel
<7> [193.883958] xe 0000:03:00.0: product: Discrete gfx
<7> [193.883959] xe 0000:03:00.0: source device information: PC General (0x9)
<7> [193.883960] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:504:pipe D] fastset requirement not met in hdmi infoframe
<7> [193.884052] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] expected:
<7> [193.884145] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] found:
<7> [193.884242] xe 0000:03:00.0: HDMI infoframe: Vendor, version 1, length 4
<7> [193.884243] xe 0000:03:00.0: empty frame
<7> [193.884245] xe 0000:03:00.0: [drm:intel_atomic_check [xe]] [CRTC:504:pipe D] fastset requirement not met, forcing full modeset
<7> [193.884365] xe 0000:03:00.0: [drm:skl_compute_wm [xe]] Enabled dbuf slices 0x1 -> 0x3 (total dbuf slices 0xf), mbus joined? no->no
<7> [193.884464] xe 0000:03:00.0: [drm:skl_compute_wm [xe]] [CRTC:504:pipe D] dbuf slices 0x0 -> 0x3, ddb (0 - 0) -> (0 - 2048), active pipes 0x0 -> 0x8
<7> [193.884567] xe 0000:03:00.0: [drm:skl_compute_wm [xe]] [PLANE:388:plane 1D] ddb ( 0 - 0) -> ( 0 - 1989), size 0 -> 1989
<7> [193.884646] xe 0000:03:00.0: [drm:skl_compute_wm [xe]] [PLANE:498:cursor D] ddb ( 0 - 0) -> (1989 - 2048), size 0 -> 59
<7> [193.884725] xe 0000:03:00.0: [drm:skl_print_plane_changes [xe]] [PLANE:388:plane 1D] level wm0, wm1, wm2, wm3, wm4, wm5, wm6, wm7, twm, swm, stwm -> *wm0,*wm1,*wm2,*wm3,*wm4,*wm5, wm6, wm7,*twm,*swm,*stwm
<7> [193.884803] xe 0000:03:00.0: [drm:skl_print_plane_changes [xe]] [PLANE:388:plane 1D] lines 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0 -> 4, 4, 9, 9, 17, 17, 17, 17, 0, 15, 0
<7> [193.884879] xe 0000:03:00.0: [drm:skl_print_plane_changes [xe]] [PLANE:388:plane 1D] blocks 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0 -> 62, 62, 139, 139, 261, 261, 261, 261, 137, 230, 244
<7> [193.884954] xe 0000:03:00.0: [drm:skl_print_plane_changes [xe]] [PLANE:388:plane 1D] min_ddb 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0 -> 123, 123, 245, 245, 367, 367, 0, 0, 138, 306, 306
<7> [193.885043] xe 0000:03:00.0: [drm:intel_bw_atomic_check [xe]] [CRTC:504:pipe D] data rate 594000 num active planes 1
<7> [193.885145] xe 0000:03:00.0: [drm:intel_bw_atomic_check [xe]] QGV point 0: max bw 33600 required 624 qgv_peak_bw: 48000
<7> [193.885242] xe 0000:03:00.0: [drm:intel_bw_atomic_check [xe]] QGV point 1: max bw 53000 required 624 qgv_peak_bw: 48000
<7> [193.885336] xe 0000:03:00.0: [drm:intel_bw_atomic_check [xe]] Matching peaks QGV bw: 48000 for required data rate: 624
<7> [193.885483] xe 0000:03:00.0: [drm:intel_cdclk_atomic_check [xe]] [CRTC:504:pipe D] min cdclk: 0 kHz -> 192000 kHz
<7> [193.885593] xe 0000:03:00.0: [drm:intel_cdclk_update_dbuf_bw_min_cdclk [xe]] dbuf bandwidth min cdclk: 18563 kHz -> 9282 kHz
<7> [193.885701] xe 0000:03:00.0: [drm:intel_find_dpll [xe]] [CRTC:504:pipe D] allocated TC PLL 3
<7> [193.885800] xe 0000:03:00.0: [drm:intel_dpll_crtc_get [xe]] [CRTC:504:pipe D] reserving TC PLL 3
<7> [193.885897] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] [CRTC:504:pipe D] enable: yes [modeset]
<7> [193.885996] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] active: yes, output_types: HDMI (0x40), output format: RGB, sink format: RGB
<7> [193.886094] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] cpu_transcoder: D, pipe bpp: 36, dithering: 0
<7> [193.886189] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] MST master transcoder: <invalid>
<7> [193.886283] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] port sync: master transcoder: <invalid>, slave transcoder bitmask = 0x0
<7> [193.886377] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] joiner: no, pipes: 0x0
<7> [193.886487] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] splitter: disabled, link count 0, overlap 0
<7> [193.886580] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] audio: 1, infoframes: 1, infoframes enabled: 0x71
<7> [193.886672] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] GCP: 0x6
<7> [193.886764] xe 0000:03:00.0: HDMI infoframe: Auxiliary Video Information (AVI), version 2, length 13
<7> [193.886765] xe 0000:03:00.0: colorspace: RGB
<7> [193.886767] xe 0000:03:00.0: scan mode: Underscan
<7> [193.886768] xe 0000:03:00.0: colorimetry: No Data
<7> [193.886769] xe 0000:03:00.0: picture aspect: 16:9
<7> [193.886770] xe 0000:03:00.0: active aspect: Same as Picture
<7> [193.886771] xe 0000:03:00.0: itc: No Data
<7> [193.886772] xe 0000:03:00.0: extended colorimetry: xvYCC 601
<7> [193.886773] xe 0000:03:00.0: quantization range: Default
<7> [193.886774] xe 0000:03:00.0: nups: Unknown Non-uniform Scaling
<7> [193.886775] xe 0000:03:00.0: video code: 16
<7> [193.886776] xe 0000:03:00.0: ycc quantization range: Full
<7> [193.886777] xe 0000:03:00.0: hdmi content type: Graphics
<7> [193.886778] xe 0000:03:00.0: pixel repeat: 0
<7> [193.886779] xe 0000:03:00.0: bar top 0, bottom 0, left 0, right 0
<7> [193.886781] xe 0000:03:00.0: HDMI infoframe: Source Product Description (SPD), version 1, length 25
<7> [193.886782] xe 0000:03:00.0: vendor: Intel
<7> [193.886783] xe 0000:03:00.0: product: Discrete gfx
<7> [193.886784] xe 0000:03:00.0: source device information: PC General (0x9)
<7> [193.886786] xe 0000:03:00.0: HDMI infoframe: Vendor, version 1, length 4
<7> [193.886787] xe 0000:03:00.0: empty frame
<7> [193.886788] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] ELD: 10 00 08 00 65 32 00 01 00 00 00 00 00 00 00 00
<7> [193.886880] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] ELD: 61 a4 9a 00 4d 69 20 54 56 09 07 07 11 17 50 51
<7> [193.886972] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] ELD: 07 00 00 00
<7> [193.887065] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] scanline offset: 1
<7> [193.887162] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] framestart delay: 1, MSA timing delay: 0, set context latency: 0
<7> [193.887257] 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: 45 vsync start: 41, vsync end: 36
<7> [193.887351] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] vrr: vmin vblank: 1080, vmax vblank: 1080, vmin vtotal: 1125, vmax vtotal: 1125
<7> [193.887453] 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> [193.887546] 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> [193.887638] 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> [193.887731] 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> [193.887824] 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> [193.887916] 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> [193.888009] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] port clock: 222750, pipe src: 1920x1080+0+0, pixel rate 148500, min cdclk 192000
<7> [193.888106] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] linetime: 119, ips linetime: 0
<7> [193.888198] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] num_scalers: 2, scaler_users: 0x0, scaler_id: -1, scaling_filter: 0
<7> [193.888292] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] pch pfit: 0x0+0+0, disabled, force thru: no
<7> [193.888386] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] ips: 0, double wide: 0, drrs: 0
<7> [193.888488] 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> [193.888579] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] c20pll_hw_state:
<7> [193.888669] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] tx[0] = 0xbe88, tx[1] = 0x5800, tx[2] = 0x0000
<7> [193.888760] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] cmn[0] = 0x0500, cmn[1] = 0x0005, cmn[2] = 0x0000, cmn[3] = 0x0000
<7> [193.888851] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] mpllb[0] = 0x40e8
<7> [193.888942] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] mpllb[1] = 0x7d20
<7> [193.889033] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] mpllb[2] = 0x0a06
<7> [193.889126] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] mpllb[3] = 0x8f1c
<7> [193.889219] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] mpllb[4] = 0x0000
<7> [193.889310] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] mpllb[5] = 0x0000
<7> [193.889401] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] mpllb[6] = 0x2200
<7> [193.889502] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] mpllb[7] = 0xffff
<7> [193.889593] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] mpllb[8] = 0x0400
<7> [193.889686] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] mpllb[9] = 0x0000
<7> [193.889785] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] mpllb[10] = 0x0001
<7> [193.889881] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] vdr: custom width: 0x00, serdes rate: 0x00, hdmi rate: 0x00
<7> [193.889979] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] csc_mode: 0x0 gamma_mode: 0x0 gamma_enable: 0 csc_enable: 0
<7> [193.890073] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] pre csc lut: 0 entries, post csc lut: 0 entries
<7> [193.890166] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] output csc: pre offsets: 0x0000 0x0000 0x0000
<7> [193.890258] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] output csc: coefficients: 0x0000 0x0000 0x0000
<7> [193.890355] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] output csc: coefficients: 0x0000 0x0000 0x0000
<7> [193.890459] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] output csc: coefficients: 0x0000 0x0000 0x0000
<7> [193.890553] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] output csc: post offsets: 0x0000 0x0000 0x0000
<7> [193.890646] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] pipe csc: pre offsets: 0x0000 0x0000 0x0000
<7> [193.890739] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] pipe csc: coefficients: 0x0000 0x0000 0x0000
<7> [193.890831] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] pipe csc: coefficients: 0x0000 0x0000 0x0000
<7> [193.890923] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] pipe csc: coefficients: 0x0000 0x0000 0x0000
<7> [193.891014] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] pipe csc: post offsets: 0x0000 0x0000 0x0000
<7> [193.891104] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] sharpness strength: 0, sharpness tap size: 0, sharpness enable: 0
<7> [193.891194] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] [PLANE:388:plane 1D] fb: [FB:557] 1920x1080 format = XR24 little-endian (0x34325258) modifier = 0x100000000000009, visible: yes
<7> [193.891284] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] rotation: 0x1, scaler: -1, scaling_filter: 0
<7> [193.891375] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] src: 1920.000000x1080.000000+0.000000+0.000000 dst: 1920x1080+0+0
<7> [193.891478] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] [PLANE:418:plane 2D] fb: [NOFB], visible: no
<7> [193.891569] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] [PLANE:448:plane 3D] fb: [NOFB], visible: no
<7> [193.891661] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] [PLANE:478:plane 4D] fb: [NOFB], visible: no
<7> [193.891751] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] [PLANE:488:plane 5D] fb: [NOFB], visible: no
<7> [193.891840] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] [PLANE:498:cursor D] fb: [NOFB], visible: no
<7> [193.892450] xe 0000:03:00.0: [drm:intel_power_well_disable [xe]] disabling AUX_TC2
<7> [193.892665] xe 0000:03:00.0: [drm:intel_power_well_disable [xe]] disabling DC_off
<7> [193.892833] xe 0000:03:00.0: [drm:skl_enable_dc6 [xe]] Enabling DC6
<7> [193.892984] xe 0000:03:00.0: [drm:gen9_set_dc_state.part.0 [xe]] Setting DC state from 00 to 02
<7> [193.893152] xe 0000:03:00.0: [drm:intel_power_well_disable [xe]] disabling always-on
<7> [193.893301] xe 0000:03:00.0: [drm:intel_power_well_enable [xe]] enabling always-on
<7> [193.893402] xe 0000:03:00.0: [drm:intel_power_well_enable [xe]] enabling DC_off
<7> [193.893647] xe 0000:03:00.0: [drm:gen9_set_dc_state.part.0 [xe]] Setting DC state from 02 to 00
<7> [193.893772] xe 0000:03:00.0: [drm:intel_power_well_enable [xe]] enabling PW_2
<7> [193.893897] xe 0000:03:00.0: [drm:intel_power_well_enable [xe]] enabling PW_D
<7> [193.894031] xe 0000:03:00.0: [drm:dss_pipe_gating_enable_disable [xe]] DSS clock gating enabled for pipe_mask=0x8 (CLKGATE_DIS_DSSDSC=0x2a000000)
<7> [193.894134] xe 0000:03:00.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:506:DDI TC1/PHY F]
<7> [193.894224] xe 0000:03:00.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:508:DP-MST A]
<7> [193.894313] xe 0000:03:00.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:509:DP-MST B]
<7> [193.894400] xe 0000:03:00.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:510:DP-MST C]
<7> [193.894498] xe 0000:03:00.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:511:DP-MST D]
<7> [193.894582] xe 0000:03:00.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:525:DDI TC2/PHY G]
<7> [193.894667] xe 0000:03:00.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:527:DP-MST A]
<7> [193.894752] xe 0000:03:00.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:528:DP-MST B]
<7> [193.894840] xe 0000:03:00.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:529:DP-MST C]
<7> [193.894927] xe 0000:03:00.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:530:DP-MST D]
<7> [193.895011] xe 0000:03:00.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:537:DDI TC3/PHY H]
<7> [193.895095] xe 0000:03:00.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:541:DDI TC4/PHY I]
<7> [193.895177] xe 0000:03:00.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:543:DP-MST A]
<7> [193.895260] xe 0000:03:00.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:544:DP-MST B]
<7> [193.895341] xe 0000:03:00.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:545:DP-MST C]
<7> [193.895424] xe 0000:03:00.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:546:DP-MST D]
<7> [193.895533] xe 0000:03:00.0: [drm:gen9_dbuf_slices_update [xe]] Updating dbuf slices to 0x3
<7> [193.895700] xe 0000:03:00.0: [drm:intel_dbuf_mdclk_cdclk_ratio_update [xe]] Updating dbuf ratio to 2 (mbus joined: no)
<7> [193.895801] xe 0000:03:00.0: [drm:intel_dpll_enable [xe]] enable TC PLL 3 (active 0x8, on? 0) for [CRTC:504:pipe D]
<7> [193.895896] xe 0000:03:00.0: [drm:intel_dpll_enable [xe]] enabling TC PLL 3
<7> [193.898393] xe 0000:03:00.0: [drm:intel_enable_transcoder [xe]] enabling pipe D
<7> [193.916957] xe 0000:03:00.0: [drm:intel_audio_codec_enable [xe]] [CONNECTOR:538:HDMI-A-3][ENCODER:537:DDI TC3/PHY H] Enable audio codec on [CRTC:504:pipe D], 36 bytes ELD
<7> [193.933578] xe 0000:03:00.0: [drm:audio_config_hdmi_pixel_clock [xe]] Configuring HDMI audio for pixel clock 148500 (0x00090000)
<7> [193.933772] xe 0000:03:00.0: [drm:hsw_audio_config_update [xe]] using automatic N
<7> [193.934355] xe 0000:03:00.0: [drm:verify_connector_state [xe]] [CONNECTOR:538:HDMI-A-3]
<7> [193.934852] xe 0000:03:00.0: [drm:intel_modeset_verify_crtc [xe]] [CRTC:504:pipe D]
<7> [193.939119] xe 0000:03:00.0: [drm:drm_mode_setcrtc] [CRTC:386:pipe C]
<7> [193.939174] xe 0000:03:00.0: [drm:drm_mode_setcrtc] [CONNECTOR:526:DP-2]
<7> [193.939343] xe 0000:03:00.0: [drm:intel_dp_compute_config_limits [xe]] [ENCODER:525:DDI TC2/PHY G][CRTC:386:pipe C] 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> [193.939673] 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> [193.939963] xe 0000:03:00.0: [drm:intel_atomic_check [xe]] [CRTC:386:pipe C] hw max bpp: 36, pipe bpp: 36, dithering: 0
<7> [193.940248] xe 0000:03:00.0: [drm:intel_ddi_compute_config_late [xe]] [ENCODER:525:DDI TC2/PHY G] [CRTC:386:pipe C]
<7> [193.940548] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:386:pipe C] fastset requirement not met in hw.enable (expected no, found yes)
<7> [193.940817] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:386:pipe C] fastset requirement not met in hw.active (expected no, found yes)
<7> [193.940720] xe 0000:03:00.0: [drm:intel_audio_component_get_power [xe]] restored AUD_FREQ_CNTRL to 0x8010
<7> [193.941093] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:386:pipe C] fastset requirement not met in cpu_transcoder (expected -1, found 2)
<7> [193.941346] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:386:pipe C] fastset requirement not met in lane_count (expected 0, found 4)
<7> [193.941614] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:386:pipe C] 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> [193.941855] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:386:pipe C] fastset requirement not met in output_types (expected 0x00000000, found 0x00000080)
<7> [193.942087] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:386:pipe C] fastset requirement not met in framestart_delay (expected 0, found 1)
<7> [193.942314] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:386:pipe C] fastset requirement not met in hw.pipe_mode.crtc_hdisplay (expected 0, found 1920)
<7> [193.942554] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:386:pipe C] fastset requirement not met in hw.pipe_mode.crtc_htotal (expected 0, found 2200)
<7> [193.942766] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:386:pipe C] fastset requirement not met in hw.pipe_mode.crtc_hblank_start (expected 0, found 1920)
<7> [193.942979] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:386:pipe C] fastset requirement not met in hw.pipe_mode.crtc_hblank_end (expected 0, found 2200)
<7> [193.943189] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:386:pipe C] fastset requirement not met in hw.pipe_mode.crtc_hsync_start (expected 0, found 2008)
<7> [193.943388] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:386:pipe C] fastset requirement not met in hw.pipe_mode.crtc_hsync_end (expected 0, found 2052)
<7> [193.943620] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:386:pipe C] fastset requirement not met in hw.pipe_mode.crtc_vdisplay (expected 0, found 1080)
<7> [193.943811] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:386:pipe C] fastset requirement not met in hw.pipe_mode.crtc_vblank_start (expected 0, found 1080)
<7> [193.944000] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:386:pipe C] fastset requirement not met in hw.pipe_mode.crtc_vsync_start (expected 0, found 1084)
<7> [193.944189] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:386:pipe C] fastset requirement not met in hw.pipe_mode.crtc_vsync_end (expected 0, found 1089)
<7> [193.944372] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:386:pipe C] fastset requirement not met in hw.pipe_mode.crtc_vtotal (expected 0, found 1125)
<7> [193.944574] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:386:pipe C] fastset requirement not met in hw.pipe_mode.crtc_vblank_end (expected 0, found 1125)
<7> [193.944747] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:386:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_hdisplay (expected 0, found 1920)
<7> [193.944918] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:386:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_htotal (expected 0, found 2200)
<7> [193.945088] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:386:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_hblank_start (expected 0, found 1920)
<7> [193.945252] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:386:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_hblank_end (expected 0, found 2200)
<7> [193.945415] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:386:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_hsync_start (expected 0, found 2008)
<7> [193.945593] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:386:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_hsync_end (expected 0, found 2052)
<7> [193.945749] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:386:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_vdisplay (expected 0, found 1080)
<7> [193.945906] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:386:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_vblank_start (expected 0, found 1080)
<7> [193.946063] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:386:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_vsync_start (expected 0, found 1084)
<7> [193.946217] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:386:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_vsync_end (expected 0, found 1089)
<7> [193.946361] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:386:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_vtotal (expected 0, found 1125)
<7> [193.946553] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:386:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_vblank_end (expected 0, found 1125)
<7> [193.946699] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:386:pipe C] fastset requirement not met in pixel_multiplier (expected 0, found 1)
<7> [193.946840] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:386:pipe C] fastset requirement not met in hw.adjusted_mode.flags (1) (expected 0, found 1)
<7> [193.946981] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:386:pipe C] fastset requirement not met in hw.adjusted_mode.flags (4) (expected 0, found 4)
<7> [193.947121] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:386:pipe C] fastset requirement not met in enhanced_framing (expected no, found yes)
<7> [193.947259] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:386:pipe C] fastset requirement not met in dpll_hw_state
<7> [193.947396] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] expected:
<7> [193.947542] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] cx0pll_hw_state: lane_count: 4, ssc_enabled: no, use_c10: no, tbt_mode: no
<7> [193.947672] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] c20pll_hw_state:
<7> [193.947799] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] tx[0] = 0xbe88, tx[1] = 0x5800, tx[2] = 0x0000
<7> [193.947931] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] cmn[0] = 0x0500, cmn[1] = 0x0005, cmn[2] = 0x0000, cmn[3] = 0x0000
<7> [193.948061] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] mpllb[0] = 0x40e8
<7> [193.948181] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] mpllb[1] = 0x7d20
<7> [193.948302] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] mpllb[2] = 0x0a06
<7> [193.948418] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] mpllb[3] = 0x8f1c
<7> [193.948550] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] mpllb[4] = 0x0000
<7> [193.948663] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] mpllb[5] = 0x0000
<7> [193.948775] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] mpllb[6] = 0x2200
<7> [193.948887] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] mpllb[7] = 0xffff
<7> [193.949006] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] mpllb[8] = 0x0400
<7> [193.949120] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] mpllb[9] = 0x0000
<7> [193.949230] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] mpllb[10] = 0x0001
<7> [193.949334] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] vdr: custom width: 0x00, serdes rate: 0x00, hdmi rate: 0x00
<7> [193.949439] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] found:
<7> [193.949540] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] cx0pll_hw_state: lane_count: 4, ssc_enabled: no, use_c10: no, tbt_mode: no
<7> [193.949641] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] c20pll_hw_state:
<7> [193.949743] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] tx[0] = 0xbe88, tx[1] = 0x4800, tx[2] = 0x0000
<7> [193.949841] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] cmn[0] = 0x0500, cmn[1] = 0x0005, cmn[2] = 0x0000, cmn[3] = 0x0000
<7> [193.949945] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] mpllb[0] = 0x308c
<7> [193.950049] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] mpllb[1] = 0x2110
<7> [193.950150] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] mpllb[2] = 0xcc9c
<7> [193.950247] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] mpllb[3] = 0xbfc1
<7> [193.950341] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] mpllb[4] = 0x4b9a
<7> [193.950440] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] mpllb[5] = 0x3f81
<7> [193.950534] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] mpllb[6] = 0x2000
<7> [193.950629] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] mpllb[7] = 0x0001
<7> [193.950722] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] mpllb[8] = 0x5000
<7> [193.950816] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] mpllb[9] = 0x0000
<7> [193.950909] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] mpllb[10] = 0x0000
<7> [193.951002] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] vdr: custom width: 0x00, serdes rate: 0x42, hdmi rate: 0x00
<7> [193.951096] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:386:pipe C] fastset requirement not met in pipe_bpp (expected 0, found 36)
<7> [193.951190] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:386:pipe C] fastset requirement not met in hw.pipe_mode.crtc_clock (expected 0, found 148500)
<7> [193.951283] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:386:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_clock (expected 0, found 148500)
<7> [193.951376] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:386:pipe C] fastset requirement not met in port_clock (expected 0, found 270000)
<7> [193.951484] xe 0000:03:00.0: [drm:intel_atomic_check [xe]] [CRTC:386:pipe C] fastset requirement not met, forcing full modeset
<7> [193.951597] xe 0000:03:00.0: [drm:skl_compute_wm [xe]] Enabled dbuf slices 0x3 -> 0xf (total dbuf slices 0xf), mbus joined? no->no
<7> [193.951679] xe 0000:03:00.0: [drm:skl_compute_wm [xe]] [CRTC:386:pipe C] dbuf slices 0x0 -> 0xc, ddb (0 - 0) -> (0 - 2048), active pipes 0x8 -> 0xc
<7> [193.951780] xe 0000:03:00.0: [drm:skl_compute_wm [xe]] [PLANE:270:plane 1C] ddb ( 0 - 0) -> ( 0 - 1989), size 0 -> 1989
<7> [193.951862] xe 0000:03:00.0: [drm:skl_compute_wm [xe]] [PLANE:380:cursor C] ddb ( 0 - 0) -> (1989 - 2048), size 0 -> 59
<7> [193.951942] xe 0000:03:00.0: [drm:skl_print_plane_changes [xe]] [PLANE:270:plane 1C] level wm0, wm1, wm2, wm3, wm4, wm5, wm6, wm7, twm, swm, stwm -> *wm0,*wm1,*wm2,*wm3,*wm4,*wm5, wm6, wm7,*twm,*swm,*stwm
<7> [193.952016] xe 0000:03:00.0: [drm:skl_print_plane_changes [xe]] [PLANE:270:plane 1C] lines 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0 -> 4, 4, 9, 9, 17, 17, 17, 17, 0, 15, 0
<7> [193.952090] xe 0000:03:00.0: [drm:skl_print_plane_changes [xe]] [PLANE:270:plane 1C] blocks 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0 -> 62, 62, 139, 139, 261, 261, 261, 261, 137, 230, 244
<7> [193.952163] xe 0000:03:00.0: [drm:skl_print_plane_changes [xe]] [PLANE:270:plane 1C] min_ddb 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0 -> 123, 123, 245, 245, 367, 367, 0, 0, 138, 306, 306
<7> [193.952248] xe 0000:03:00.0: [drm:intel_bw_atomic_check [xe]] [CRTC:386:pipe C] data rate 594000 num active planes 1
<7> [193.952349] xe 0000:03:00.0: [drm:intel_bw_atomic_check [xe]] QGV point 0: max bw 33600 required 1248 qgv_peak_bw: 48000
<7> [193.952454] xe 0000:03:00.0: [drm:intel_bw_atomic_check [xe]] QGV point 1: max bw 53000 required 1248 qgv_peak_bw: 48000
<7> [193.952550] xe 0000:03:00.0: [drm:intel_bw_atomic_check [xe]] Matching peaks QGV bw: 48000 for required data rate: 1248
<7> [193.952655] xe 0000:03:00.0: [drm:intel_cdclk_atomic_check [xe]] [CRTC:386:pipe C] min cdclk: 0 kHz -> 192000 kHz
<7> [193.952765] xe 0000:03:00.0: [drm:intel_cdclk_update_dbuf_bw_min_cdclk [xe]] dbuf bandwidth min cdclk: 9282 kHz -> 18563 kHz
<7> [193.952878] xe 0000:03:00.0: [drm:intel_find_dpll [xe]] [CRTC:386:pipe C] allocated TC PLL 2
<7> [193.952978] xe 0000:03:00.0: [drm:intel_dpll_crtc_get [xe]] [CRTC:386:pipe C] reserving TC PLL 2
<7> [193.953073] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] [CRTC:386:pipe C] enable: yes [modeset]
<7> [193.953173] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] active: yes, output_types: DP (0x80), output format: RGB, sink format: RGB
<7> [193.953272] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] cpu_transcoder: C, pipe bpp: 36, dithering: 0
<7> [193.953370] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] MST master transcoder: <invalid>
<7> [193.953475] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] port sync: master transcoder: <invalid>, slave transcoder bitmask = 0x0
<7> [193.953571] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] joiner: no, pipes: 0x0
<7> [193.953667] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] splitter: disabled, link count 0, overlap 0
<7> [193.953761] 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> [193.953855] 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> [193.953948] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] fec: disabled, enhanced framing: enabled
<7> [193.954040] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] sdp split: disabled
<7> [193.954131] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] psr: disabled, selective update: disabled, panel replay: disabled, selective fetch: disabled
<7> [193.954223] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] minimum HBlank: 0
<7> [193.954314] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] audio: 1, infoframes: 0, infoframes enabled: 0x0
<7> [193.954406] 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> [193.954505] 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> [193.954598] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] ELD: 17 50 51 07 00 00 00 00
<7> [193.954689] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] scanline offset: 1
<7> [193.954780] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] framestart delay: 1, MSA timing delay: 0, set context latency: 0
<7> [193.954871] 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> [193.954962] 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> [193.955054] 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> [193.955146] 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> [193.955236] 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> [193.955328] 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> [193.955424] 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> [193.955532] 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> [193.955628] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] port clock: 270000, pipe src: 1920x1080+0+0, pixel rate 148500, min cdclk 192000
<7> [193.955721] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] linetime: 119, ips linetime: 0
<7> [193.955813] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] num_scalers: 2, scaler_users: 0x0, scaler_id: -1, scaling_filter: 0
<7> [193.955905] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] pch pfit: 0x0+0+0, disabled, force thru: no
<7> [193.955996] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] ips: 0, double wide: 0, drrs: 0
<7> [193.956086] 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> [193.956176] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] c20pll_hw_state:
<7> [193.956266] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] tx[0] = 0xbe88, tx[1] = 0x4800, tx[2] = 0x0000
<7> [193.956356] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] cmn[0] = 0x0500, cmn[1] = 0x0005, cmn[2] = 0x0000, cmn[3] = 0x0000
<7> [193.956456] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] mpllb[0] = 0x308c
<7> [193.956547] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] mpllb[1] = 0x2110
<7> [193.956638] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] mpllb[2] = 0xcc9c
<7> [193.956729] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] mpllb[3] = 0xbfc1
<7> [193.956819] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] mpllb[4] = 0x4b9a
<7> [193.956907] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] mpllb[5] = 0x3f81
<7> [193.956999] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] mpllb[6] = 0x2000
<7> [193.957089] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] mpllb[7] = 0x0001
<7> [193.957179] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] mpllb[8] = 0x5000
<7> [193.957268] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] mpllb[9] = 0x0000
<7> [193.957357] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] mpllb[10] = 0x0000
<7> [193.957450] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] vdr: custom width: 0x00, serdes rate: 0x42, hdmi rate: 0x00
<7> [193.957540] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] csc_mode: 0x0 gamma_mode: 0x0 gamma_enable: 0 csc_enable: 0
<7> [193.957630] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] pre csc lut: 0 entries, post csc lut: 0 entries
<7> [193.957719] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] output csc: pre offsets: 0x0000 0x0000 0x0000
<7> [193.957809] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] output csc: coefficients: 0x0000 0x0000 0x0000
<7> [193.957899] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] output csc: coefficients: 0x0000 0x0000 0x0000
<7> [193.957989] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] output csc: coefficients: 0x0000 0x0000 0x0000
<7> [193.958079] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] output csc: post offsets: 0x0000 0x0000 0x0000
<7> [193.958170] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] pipe csc: pre offsets: 0x0000 0x0000 0x0000
<7> [193.958260] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] pipe csc: coefficients: 0x0000 0x0000 0x0000
<7> [193.958353] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] pipe csc: coefficients: 0x0000 0x0000 0x0000
<7> [193.958452] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] pipe csc: coefficients: 0x0000 0x0000 0x0000
<7> [193.958545] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] pipe csc: post offsets: 0x0000 0x0000 0x0000
<7> [193.958638] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] sharpness strength: 0, sharpness tap size: 0, sharpness enable: 0
<7> [193.958731] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] [PLANE:270:plane 1C] fb: [FB:557] 1920x1080 format = XR24 little-endian (0x34325258) modifier = 0x100000000000009, visible: yes
<7> [193.958825] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] rotation: 0x1, scaler: -1, scaling_filter: 0
<7> [193.958915] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] src: 1920.000000x1080.000000+0.000000+0.000000 dst: 1920x1080+0+0
<7> [193.959007] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] [PLANE:300:plane 2C] fb: [NOFB], visible: no
<7> [193.959098] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] [PLANE:330:plane 3C] fb: [NOFB], visible: no
<7> [193.959189] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] [PLANE:360:plane 4C] fb: [NOFB], visible: no
<7> [193.959280] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] [PLANE:370:plane 5C] fb: [NOFB], visible: no
<7> [193.959372] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] [PLANE:380:cursor C] fb: [NOFB], visible: no
<7> [193.959998] xe 0000:03:00.0: [drm:intel_power_well_enable [xe]] enabling PW_C
<7> [193.960145] xe 0000:03:00.0: [drm:dss_pipe_gating_enable_disable [xe]] DSS clock gating enabled for pipe_mask=0x4 (CLKGATE_DIS_DSSDSC=0x0a000000)
<7> [193.960476] xe 0000:03:00.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:506:DDI TC1/PHY F]
<7> [193.960568] xe 0000:03:00.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:508:DP-MST A]
<7> [193.960658] xe 0000:03:00.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:509:DP-MST B]
<7> [193.960744] xe 0000:03:00.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:510:DP-MST C]
<7> [193.960828] xe 0000:03:00.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:511:DP-MST D]
<7> [193.960913] xe 0000:03:00.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:525:DDI TC2/PHY G]
<7> [193.960999] xe 0000:03:00.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:527:DP-MST A]
<7> [193.961087] xe 0000:03:00.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:528:DP-MST B]
<7> [193.961173] xe 0000:03:00.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:529:DP-MST C]
<7> [193.961256] xe 0000:03:00.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:530:DP-MST D]
<7> [193.961339] xe 0000:03:00.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:537:DDI TC3/PHY H]
<7> [193.961423] xe 0000:03:00.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:541:DDI TC4/PHY I]
<7> [193.961519] xe 0000:03:00.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:543:DP-MST A]
<7> [193.961603] xe 0000:03:00.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:544:DP-MST B]
<7> [193.961687] xe 0000:03:00.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:545:DP-MST C]
<7> [193.961775] xe 0000:03:00.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:546:DP-MST D]
<7> [193.963579] xe 0000:03:00.0: [drm:gen9_dbuf_slices_update [xe]] Updating dbuf slices to 0xf
<7> [193.963949] xe 0000:03:00.0: [drm:intel_dbuf_mdclk_cdclk_ratio_update [xe]] Updating dbuf ratio to 2 (mbus joined: no)
<7> [193.964050] xe 0000:03:00.0: [drm:intel_dpll_enable [xe]] enable TC PLL 2 (active 0x4, on? 0) for [CRTC:386:pipe C]
<7> [193.964147] xe 0000:03:00.0: [drm:intel_dpll_enable [xe]] enabling TC PLL 2
<7> [193.966760] xe 0000:03:00.0: [drm:intel_power_well_enable [xe]] enabling AUX_TC2
<7> [193.970967] 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> [193.975710] xe 0000:03:00.0: [drm:intel_dp_init_lttpr_and_dprx_caps [xe]] [CONNECTOR:526:DP-2][ENCODER:525:DDI TC2/PHY G][DPRX] LTTPR common capabilities: 00 00 00 00 00 00 00 00
<7> [193.976719] 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> [193.977153] xe 0000:03:00.0: [drm:intel_dp_start_link_train [xe]] [CONNECTOR:526:DP-2][ENCODER:525:DDI TC2/PHY G][DPRX] Using LINK_BW_SET value 0a
<7> [193.978661] xe 0000:03:00.0: [drm:intel_dp_set_signal_levels [xe]] [CONNECTOR:526:DP-2][ENCODER:525:DDI TC2/PHY G][DPRX] 8b/10b, lanes: 4, vswing levels: 0/0/0/0, pre-emphasis levels: 0/0/0/0
<7> [193.979220] xe 0000:03:00.0: [drm:intel_dp_program_link_training_pattern [xe]] [CONNECTOR:526:DP-2][ENCODER:525:DDI TC2/PHY G][DPRX] Using DP training pattern TPS1
<7> [193.985334] xe 0000:03:00.0: [drm:intel_dp_link_train_phy [xe]] [CONNECTOR:526:DP-2][ENCODER:525:DDI TC2/PHY G][DPRX] Clock recovery OK
<7> [193.985511] xe 0000:03:00.0: [drm:intel_dp_program_link_training_pattern [xe]] [CONNECTOR:526:DP-2][ENCODER:525:DDI TC2/PHY G][DPRX] Using DP training pattern TPS3
<7> [193.992376] xe 0000:03:00.0: [drm:intel_dp_link_train_phy [xe]] [CONNECTOR:526:DP-2][ENCODER:525:DDI TC2/PHY G][DPRX] Channel EQ done. DP Training successful
<7> [193.992707] xe 0000:03:00.0: [drm:intel_dp_link_train_phy [xe]] [CONNECTOR:526:DP-2][ENCODER:525:DDI TC2/PHY G][DPRX] Link Training passed at link rate = 270000, lane count = 4
<7> [193.994121] xe 0000:03:00.0: [drm:intel_enable_transcoder [xe]] enabling pipe C
<7> [194.012021] xe 0000:03:00.0: [drm:intel_audio_codec_enable [xe]] [CONNECTOR:526:DP-2][ENCODER:525:DDI TC2/PHY G] Enable audio codec on [CRTC:386:pipe C], 40 bytes ELD
<7> [194.026248] xe 0000:03:00.0: [drm:intel_audio_component_get_power [xe]] restored AUD_FREQ_CNTRL to 0x8010
<7> [194.028752] xe 0000:03:00.0: [drm:verify_connector_state [xe]] [CONNECTOR:526:DP-2]
<7> [194.029606] xe 0000:03:00.0: [drm:intel_modeset_verify_crtc [xe]] [CRTC:386:pipe C]
<7> [194.100544] xe 0000:03:00.0: [drm:intel_power_well_disable [xe]] disabling AUX_TC2
<6> [195.785323] pcieport 0000:00:06.0: AER: Multiple Correctable error message received from 0000:05:00.0
<4> [195.785348] nvme 0000:05:00.0: PCIe Bus Error: severity=Correctable, type=Physical Layer, (Receiver ID)
<4> [195.785357] nvme 0000:05:00.0: device [15b7:5017] error status/mask=00000001/0000e000
<4> [195.785366] nvme 0000:05:00.0: [ 0] RxErr (First)
<7> [195.997911] xe 0000:03:00.0: [drm:intel_power_well_enable [xe]] enabling AUX_TC2
<7> [196.100736] xe 0000:03:00.0: [drm:intel_power_well_disable [xe]] disabling AUX_TC2
<6> [196.207975] pcieport 0000:00:06.0: AER: Multiple Correctable error message received from 0000:05:00.0
<4> [196.208000] nvme 0000:05:00.0: PCIe Bus Error: severity=Correctable, type=Physical Layer, (Receiver ID)
<4> [196.208009] nvme 0000:05:00.0: device [15b7:5017] error status/mask=00000001/0000e000
<4> [196.208018] nvme 0000:05:00.0: [ 0] RxErr (First)
<7> [196.595106] xe 0000:03:00.0: [drm:dg1_irq_handler [xe]] Ignore this IRQ as device might be in DPC containment.
<6> [199.539159] [IGT] kms_flip: finished subtest CD-DP2-HDMI-A3, FAIL
<6> [199.543461] [IGT] kms_flip: finished subtest 2x-flip-vs-absolute-wf_vblank, FAIL
<7> [199.549849] xe 0000:03:00.0: [drm:drm_mode_rmfb_work_fn] Removing [FB:559] from all active usage due to RMFB ioctl
<7> [199.550121] xe 0000:03:00.0: [drm:atomic_remove_fb] Disabling [PLANE:270:plane 1C] because [FB:559] is removed
<7> [199.550141] xe 0000:03:00.0: [drm:atomic_remove_fb] Disabling [PLANE:388:plane 1D] because [FB:559] is removed
<7> [199.550178] xe 0000:03:00.0: [drm:skl_compute_wm [xe]] [PLANE:270:plane 1C] ddb ( 0 - 1989) -> ( 0 - 0), size 1989 -> 0
<7> [199.550294] xe 0000:03:00.0: [drm:skl_print_plane_changes [xe]] [PLANE:270:plane 1C] level *wm0,*wm1,*wm2,*wm3,*wm4,*wm5, wm6, wm7,*twm,*swm,*stwm -> wm0, wm1, wm2, wm3, wm4, wm5, wm6, wm7, twm, swm, stwm
<7> [199.550376] xe 0000:03:00.0: [drm:skl_print_plane_changes [xe]] [PLANE:270:plane 1C] lines 4, 4, 9, 9, 17, 17, 17, 17, 0, 15, 0 -> 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0
<7> [199.550487] xe 0000:03:00.0: [drm:skl_print_plane_changes [xe]] [PLANE:270:plane 1C] blocks 62, 62, 139, 139, 261, 261, 261, 261, 137, 230, 244 -> 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0
<7> [199.550567] xe 0000:03:00.0: [drm:skl_print_plane_changes [xe]] [PLANE:270:plane 1C] min_ddb 123, 123, 245, 245, 367, 367, 0, 0, 138, 306, 306 -> 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0
<7> [199.550637] xe 0000:03:00.0: [drm:skl_compute_wm [xe]] [PLANE:388:plane 1D] ddb ( 0 - 1989) -> ( 0 - 0), size 1989 -> 0
<7> [199.550705] xe 0000:03:00.0: [drm:skl_print_plane_changes [xe]] [PLANE:388:plane 1D] level *wm0,*wm1,*wm2,*wm3,*wm4,*wm5, wm6, wm7,*twm,*swm,*stwm -> wm0, wm1, wm2, wm3, wm4, wm5, wm6, wm7, twm, swm, stwm
<7> [199.550774] xe 0000:03:00.0: [drm:skl_print_plane_changes [xe]] [PLANE:388:plane 1D] lines 4, 4, 9, 9, 17, 17, 17, 17, 0, 15, 0 -> 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0
<7> [199.550845] xe 0000:03:00.0: [drm:skl_print_plane_changes [xe]] [PLANE:388:plane 1D] blocks 62, 62, 139, 139, 261, 261, 261, 261, 137, 230, 244 -> 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0
<7> [199.550912] xe 0000:03:00.0: [drm:skl_print_plane_changes [xe]] [PLANE:388:plane 1D] min_ddb 123, 123, 245, 245, 367, 367, 0, 0, 138, 306, 306 -> 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0
<7> [199.551014] xe 0000:03:00.0: [drm:intel_bw_atomic_check [xe]] [CRTC:386:pipe C] data rate 0 num active planes 0
<7> [199.551107] xe 0000:03:00.0: [drm:intel_bw_atomic_check [xe]] [CRTC:504:pipe D] data rate 0 num active planes 0
<7> [199.551196] xe 0000:03:00.0: [drm:intel_bw_atomic_check [xe]] QGV point 0: max bw 33600 required 0 qgv_peak_bw: 48000
<7> [199.551283] xe 0000:03:00.0: [drm:intel_bw_atomic_check [xe]] QGV point 1: max bw 53000 required 0 qgv_peak_bw: 48000
<7> [199.551368] xe 0000:03:00.0: [drm:intel_bw_atomic_check [xe]] Matching peaks QGV bw: 48000 for required data rate: 0
<4> [204.724038] xe 0000:03:00.0: [drm] energy read from pmt failed, ret -19
<4> [204.766063] xe 0000:03:00.0: [drm] energy read from pmt failed, ret -19
<7> [204.934368] xe 0000:03:00.0: [drm:xe_hwmon_pcode_read_power_limit [xe]] read failed ch 0 val0 0x00000000, val1 0x00000000, ret -11
<6> [204.934494] xe 0000:03:00.0: [drm] PL2 disabled for channel 0, val 0x00000000
<7> [204.976439] xe 0000:03:00.0: [drm:xe_hwmon_pcode_read_power_limit [xe]] read failed ch 0 val0 0x00000000, val1 0x00000000, ret -11
<3> [204.976591] xe 0000:03:00.0: [drm] *ERROR* power interval read fail, ch 0, attr 14, val 0x00000000, ret -11
<3> [206.940671] xe 0000:03:00.0: [drm] *ERROR* [CRTC:386:pipe C] flip_done timed out
<3> [207.150407] xe 0000:03:00.0: [drm] *ERROR* [CRTC:386:pipe C] DSB 0 timed out waiting for idle (current head=0xfddc8fff, head=0xfddc8fff, tail=0xfddc8fff)
<7> [207.150410] xe 0000:03:00.0: [drm:intel_dsb_wait [xe]] [CRTC:386:pipe C] DSB 0 commands {
<7> [207.318714] xe 0000:03:00.0: [drm:intel_dsb_wait [xe]] 0x00000000: 0xffffffff 0xffffffff 0xffffffff 0xffffffff
<6> [207.466871] pcieport 0000:00:06.0: AER: Multiple Correctable error message received from 0000:05:00.0
<4> [207.466876] nvme 0000:05:00.0: PCIe Bus Error: severity=Correctable, type=Physical Layer, (Receiver ID)
<4> [207.466878] nvme 0000:05:00.0: device [15b7:5017] error status/mask=00000001/0000e000
<4> [207.466879] nvme 0000:05:00.0: [ 0] RxErr (First)
<7> [207.487043] xe 0000:03:00.0: [drm:intel_dsb_wait [xe]] 0x00000010: 0xffffffff 0xffffffff 0xffffffff 0xffffffff
<6> [207.633090] pcieport 0000:00:06.0: AER: Multiple Correctable error message received from 0000:05:00.0
<4> [207.633093] nvme 0000:05:00.0: PCIe Bus Error: severity=Correctable, type=Physical Layer, (Receiver ID)
<4> [207.633095] nvme 0000:05:00.0: device [15b7:5017] error status/mask=00000001/0000e000
<4> [207.633096] nvme 0000:05:00.0: [ 0] RxErr (First)
<7> [207.655331] xe 0000:03:00.0: [drm:intel_dsb_wait [xe]] 0x00000020: 0xffffffff 0xffffffff 0xffffffff 0xffffffff
<7> [207.823636] xe 0000:03:00.0: [drm:intel_dsb_wait [xe]] 0x00000030: 0xffffffff 0xffffffff 0xffffffff 0xffffffff
<7> [207.991952] xe 0000:03:00.0: [drm:intel_dsb_wait [xe]] 0x00000040: 0xffffffff 0xffffffff 0xffffffff 0xffffffff
<7> [208.160342] xe 0000:03:00.0: [drm:intel_dsb_wait [xe]] 0x00000050: 0xffffffff 0xffffffff 0xffffffff 0xffffffff
<3> [208.412744] pcieport 0000:02:02.0: Unable to change power state from D3hot to D0, device inaccessible
<7> [208.454809] xe 0000:03:00.0: [drm:intel_dsb_wait [xe]] 0x00000060: 0xffffffff 0xffffffff 0xffffffff 0xffffffff
<7> [208.791420] xe 0000:03:00.0: [drm:intel_dsb_wait [xe]] 0x00000070: 0xffffffff 0xffffffff 0xffffffff 0xffffffff
<6> [208.981009] pcieport 0000:00:06.0: AER: Multiple Correctable error message received from 0000:05:00.0
<4> [208.981014] nvme 0000:05:00.0: PCIe Bus Error: severity=Correctable, type=Physical Layer, (Receiver ID)
<4> [208.981016] nvme 0000:05:00.0: device [15b7:5017] error status/mask=00000001/0000e000
<4> [208.981017] nvme 0000:05:00.0: [ 0] RxErr (First)
<6> [209.085726] pcieport 0000:00:06.0: AER: Multiple Correctable error message received from 0000:05:00.0
<4> [209.085729] nvme 0000:05:00.0: PCIe Bus Error: severity=Correctable, type=Physical Layer, (Receiver ID)
<4> [209.085730] nvme 0000:05:00.0: device [15b7:5017] error status/mask=00000001/0000e000
<4> [209.085731] nvme 0000:05:00.0: [ 0] RxErr (First)
<7> [209.128041] xe 0000:03:00.0: [drm:intel_dsb_wait [xe]] 0x00000080: 0xffffffff 0xffffffff 0xffffffff 0xffffffff
<6> [209.422591] pcieport 0000:00:06.0: AER: Multiple Correctable error message received from 0000:05:00.0
<4> [209.422750] nvme 0000:05:00.0: PCIe Bus Error: severity=Correctable, type=Physical Layer, (Receiver ID)
<4> [209.422753] nvme 0000:05:00.0: device [15b7:5017] error status/mask=00000001/0000e000
<4> [209.422756] nvme 0000:05:00.0: [ 0] RxErr (First)
<7> [209.464644] xe 0000:03:00.0: [drm:intel_dsb_wait [xe]] 0x00000090: 0xffffffff 0xffffffff 0xffffffff 0xffffffff
<6> [209.528189] pcieport 0000:00:06.0: AER: Multiple Correctable error message received from 0000:05:00.0
<4> [209.528194] nvme 0000:05:00.0: PCIe Bus Error: severity=Correctable, type=Physical Layer, (Receiver ID)
<4> [209.528195] nvme 0000:05:00.0: device [15b7:5017] error status/mask=00000001/0000e000
<4> [209.528197] nvme 0000:05:00.0: [ 0] RxErr (First)
<7> [209.759189] xe 0000:03:00.0: [drm:intel_dsb_wait [xe]] 0x000000a0: 0xffffffff 0xffffffff 0xffffffff 0xffffffff
<7> [210.095800] xe 0000:03:00.0: [drm:intel_dsb_wait [xe]] 0x000000b0: 0xffffffff 0xffffffff 0xffffffff 0xffffffff
<7> [210.432417] xe 0000:03:00.0: [drm:intel_dsb_wait [xe]] 0x000000c0: 0xffffffff 0xffffffff 0xffffffff 0xffffffff
<7> [210.769032] xe 0000:03:00.0: [drm:intel_dsb_wait [xe]] 0x000000d0: 0xffffffff 0xffffffff 0xffffffff 0xffffffff
<7> [211.147732] xe 0000:03:00.0: [drm:intel_dsb_wait [xe]] 0x000000e0: 0xffffffff 0xffffffff 0xffffffff 0xffffffff
<7> [211.484332] xe 0000:03:00.0: [drm:intel_dsb_wait [xe]] 0x000000f0: 0xffffffff 0xffffffff 0xffffffff 0xffffffff
<7> [211.484453] xe 0000:03:00.0: [drm:intel_dsb_wait [xe]] }
<3> [211.568480] xe 0000:03:00.0: [drm] *ERROR* Tile0: GT0: Force wake domain 0: wake. MMIO unreliable (forcewake register returns 0xFFFFFFFF)!
<4> [211.568631] ------------[ cut here ]------------
<4> [211.568633] xe 0000:03:00.0: [drm] Tile0: GT0: Forcewake domain 0x1 failed to acknowledge awake request
<4> [211.568635] WARNING: drivers/gpu/drm/xe/xe_force_wake.c:206 at xe_force_wake_get+0x7a2/0x940 [xe], CPU#8: kworker/u65:13/2833
<4> [211.568705] Modules linked in: snd_hda_codec_intelhdmi snd_hda_codec_hdmi pmt_crashlog mei_gsc_proxy mei_lb 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 intel_tcc_cooling x86_pkg_temp_thermal hid_generic cmdlinepart intel_powerclamp spi_nor eeepc_wmi asus_wmi mtd mei_pxp mei_hdcp sparse_keymap coretemp platform_profile wmi_bmof kvm_intel binfmt_misc snd_hda_intel kvm snd_intel_dspcfg irqbypass ghash_clmulni_intel snd_hda_codec r8169 aesni_intel rapl snd_hda_core usbhid snd_hwdep hid intel_cstate snd_pcm video realtek snd_timer i2c_i801 snd i2c_mux spi_intel_pci nls_iso8859_1 soundcore spi_intel i2c_smbus idma64 intel_pmc_core pmt_telemetry mei_me pmt_discovery pmt_class intel_pmc_ssram_telemetry mei intel_vsec pinctrl_alderlake wmi acpi_tad acpi_pad dm_multipath msr nvme_fabrics fuse
<4> [211.568791] efi_pstore nfnetlink autofs4
<4> [211.568796] CPU: 8 UID: 0 PID: 2833 Comm: kworker/u65:13 Tainted: G S U 7.0.0-rc2-lgci-xe-xe-4660-d6f74d61a95e54f21-debug+ #1 PREEMPT(lazy)
<4> [211.568799] Tainted: [S]=CPU_OUT_OF_SPEC, [U]=USER
<4> [211.568800] Hardware name: ASUS System Product Name/PRIME Z790-P WIFI, BIOS 1645 03/15/2024
<4> [211.568802] Workqueue: i915_flip intel_atomic_commit_work [xe]
<4> [211.568907] RIP: 0010:xe_force_wake_get+0x7b1/0x940 [xe]
<4> [211.568968] Code: 75 03 48 8b 17 48 89 55 a8 89 4d b8 e8 48 ac 62 e1 48 89 c6 48 8d 3d 8e e4 3d 00 41 57 8b 4d b8 4d 89 f1 45 89 e8 48 8b 55 a8 <67> 48 0f b9 3a 58 e9 fd fb ff ff 48 8b 45 b8 4c 8d 65 c6 4c 8b 30
<4> [211.568970] RSP: 0018:ffffc90004cd7a58 EFLAGS: 00010246
<4> [211.568972] RAX: ffffffffa11fb95a RBX: 0000000000000001 RCX: 0000000000000000
<4> [211.568973] RDX: ffff88810464a190 RSI: ffffffffa11fb95a RDI: ffffffffa1001f00
<4> [211.568974] RBP: ffffc90004cd7b38 R08: 0000000000000000 R09: ffffffffa11f7869
<4> [211.568975] R10: 0000000000000000 R11: 0000000000000000 R12: 0000000000000000
<4> [211.568976] R13: 0000000000000000 R14: ffffffffa11f7869 R15: 0000000000000001
<4> [211.568978] FS: 0000000000000000(0000) GS:ffff8888db099000(0000) knlGS:0000000000000000
<4> [211.568979] CS: 0010 DS: 0000 ES: 0000 CR0: 0000000080050033
<4> [211.568980] CR2: 0000704026b40000 CR3: 0000000126885005 CR4: 0000000000f72ef0
<4> [211.568981] PKRU: 55555554
<4> [211.568982] Call Trace:
<4> [211.568983] <TASK>
<4> [211.568985] ? __wake_up_klogd+0x75/0xa0
<4> [211.568990] ? vprintk_emit+0x3b3/0x470
<4> [211.568997] xe_device_l2_flush+0xab/0x2d0 [xe]
<4> [211.569051] ? __lock_acquire+0x43e/0x2790
<4> [211.569058] xe_device_td_flush+0x1e7/0x370 [xe]
<4> [211.569112] ? lock_is_held_type+0xa3/0x130
<4> [211.569118] intel_td_flush+0x11/0x20 [xe]
<4> [211.569215] frontbuffer_flush+0x91/0x170 [xe]
<4> [211.569309] intel_frontbuffer_flip+0x46/0x60 [xe]
<4> [211.569417] intel_atomic_commit_tail+0x107c/0x1c90 [xe]
<4> [211.569527] intel_atomic_commit_work+0x12/0x20 [xe]
<4> [211.569626] ? intel_atomic_commit_work+0x12/0x20 [xe]
<4> [211.569722] process_one_work+0x22e/0x740
<4> [211.569728] worker_thread+0x1e8/0x3d0
<4> [211.569730] ? __pfx_worker_thread+0x10/0x10
<4> [211.569732] kthread+0x10d/0x150
<4> [211.569735] ? __pfx_kthread+0x10/0x10
<4> [211.569738] ret_from_fork+0x3d4/0x480
<4> [211.569740] ? __pfx_kthread+0x10/0x10
<4> [211.569743] ret_from_fork_asm+0x1a/0x30
<4> [211.569750] </TASK>
<4> [211.569751] irq event stamp: 6163079
<4> [211.569752] hardirqs last enabled at (6163085): [<ffffffff814a9bb9>] __up_console_sem+0x79/0xa0
<4> [211.569754] hardirqs last disabled at (6163090): [<ffffffff814a9b9e>] __up_console_sem+0x5e/0xa0
<4> [211.569756] softirqs last enabled at (6162266): [<ffffffff813d0cbf>] __irq_exit_rcu+0x13f/0x160
<4> [211.569759] softirqs last disabled at (6162251): [<ffffffff813d0cbf>] __irq_exit_rcu+0x13f/0x160
<4> [211.569760] ---[ end trace 0000000000000000 ]---
<3> [211.652635] xe 0000:03:00.0: [drm] *ERROR* Tile0: GT0: Force wake domain 0: wake. MMIO unreliable (forcewake register returns 0xFFFFFFFF)!
<4> [211.652752] ------------[ cut here ]------------
<4> [211.652754] xe 0000:03:00.0: [drm] Tile0: GT0: Forcewake domain 0x1 failed to acknowledge awake request
<4> [211.652756] WARNING: drivers/gpu/drm/xe/xe_force_wake.c:206 at xe_force_wake_get+0x7a2/0x940 [xe], CPU#0: kworker/0:3/950
<4> [211.652823] Modules linked in: snd_hda_codec_intelhdmi snd_hda_codec_hdmi pmt_crashlog mei_gsc_proxy mei_lb 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 intel_tcc_cooling x86_pkg_temp_thermal hid_generic cmdlinepart intel_powerclamp spi_nor eeepc_wmi asus_wmi mtd mei_pxp mei_hdcp sparse_keymap coretemp platform_profile wmi_bmof kvm_intel binfmt_misc snd_hda_intel kvm snd_intel_dspcfg irqbypass ghash_clmulni_intel snd_hda_codec r8169 aesni_intel rapl snd_hda_core usbhid snd_hwdep hid intel_cstate snd_pcm video realtek snd_timer i2c_i801 snd i2c_mux spi_intel_pci nls_iso8859_1 soundcore spi_intel i2c_smbus idma64 intel_pmc_core pmt_telemetry mei_me pmt_discovery pmt_class intel_pmc_ssram_telemetry mei intel_vsec pinctrl_alderlake wmi acpi_tad acpi_pad dm_multipath msr nvme_fabrics fuse
<4> [211.652909] efi_pstore nfnetlink autofs4
<4> [211.652914] CPU: 0 UID: 0 PID: 950 Comm: kworker/0:3 Tainted: G S U W 7.0.0-rc2-lgci-xe-xe-4660-d6f74d61a95e54f21-debug+ #1 PREEMPT(lazy)
<4> [211.652917] Tainted: [S]=CPU_OUT_OF_SPEC, [U]=USER, [W]=WARN
<4> [211.652919] Hardware name: ASUS System Product Name/PRIME Z790-P WIFI, BIOS 1645 03/15/2024
<4> [211.652921] Workqueue: events drm_mode_rmfb_work_fn
<4> [211.652925] RIP: 0010:xe_force_wake_get+0x7b1/0x940 [xe]
<4> [211.652988] Code: 75 03 48 8b 17 48 89 55 a8 89 4d b8 e8 48 ac 62 e1 48 89 c6 48 8d 3d 8e e4 3d 00 41 57 8b 4d b8 4d 89 f1 45 89 e8 48 8b 55 a8 <67> 48 0f b9 3a 58 e9 fd fb ff ff 48 8b 45 b8 4c 8d 65 c6 4c 8b 30
<4> [211.652990] RSP: 0018:ffffc9000352f8a8 EFLAGS: 00010246
<4> [211.652993] RAX: ffffffffa11fb95a RBX: 0000000000000001 RCX: 0000000000000000
<4> [211.652994] RDX: ffff88810464a190 RSI: ffffffffa11fb95a RDI: ffffffffa1001f00
<4> [211.652996] RBP: ffffc9000352f988 R08: 0000000000000000 R09: ffffffffa11f7869
<4> [211.652998] R10: 0000000000000000 R11: 0000000000000000 R12: 0000000000000000
<4> [211.652999] R13: 0000000000000000 R14: ffffffffa11f7869 R15: 0000000000000001
<4> [211.653001] FS: 0000000000000000(0000) GS:ffff8888dac99000(0000) knlGS:0000000000000000
<4> [211.653003] CS: 0010 DS: 0000 ES: 0000 CR0: 0000000080050033
<4> [211.653004] CR2: 00005d4e2a5b0e08 CR3: 000000000344c001 CR4: 0000000000f72ef0
<4> [211.653006] PKRU: 55555554
<4> [211.653008] Call Trace:
<4> [211.653009] <TASK>
<4> [211.653015] ? trace_hardirqs_on+0x22/0x100
<4> [211.653021] xe_device_l2_flush+0xab/0x2d0 [xe]
<4> [211.653079] ? __schedule+0x12db/0x1dd0
<4> [211.653083] ? mark_held_locks+0x46/0x90
<4> [211.653089] xe_device_td_flush+0x1e7/0x370 [xe]
<4> [211.653145] ? lock_acquire+0xc4/0x2f0
<4> [211.653152] intel_td_flush+0x11/0x20 [xe]
<4> [211.653257] intel_atomic_commit_tail+0x1f9/0x1c90 [xe]
<4> [211.653375] ? find_held_lock+0x31/0x90
<4> [211.653378] ? is_module_address+0x6a/0x140
<4> [211.653381] ? lock_release+0xd0/0x2b0
<4> [211.653388] intel_atomic_commit+0x2e8/0x330 [xe]
<4> [211.653493] ? intel_atomic_commit+0x2e8/0x330 [xe]
<4> [211.653593] drm_atomic_commit+0xaf/0xf0
<4> [211.653596] ? __pfx___drm_printfn_info+0x10/0x10
<4> [211.653601] atomic_remove_fb+0x346/0x3d0
<4> [211.653610] drm_framebuffer_remove+0x71/0x240
<4> [211.653613] drm_mode_rmfb_work_fn+0x7c/0xa0
<4> [211.653616] process_one_work+0x22e/0x740
<4> [211.653623] worker_thread+0x1e8/0x3d0
<4> [211.653625] ? __pfx_worker_thread+0x10/0x10
<4> [211.653627] kthread+0x10d/0x150
<4> [211.653630] ? __pfx_kthread+0x10/0x10
<4> [211.653634] ret_from_fork+0x3d4/0x480
<4> [211.653636] ? __pfx_kthread+0x10/0x10
<4> [211.653639] ret_from_fork_asm+0x1a/0x30
<4> [211.653647] </TASK>
<4> [211.653648] irq event stamp: 33425
<4> [211.653649] hardirqs last enabled at (33431): [<ffffffff814a9bb9>] __up_console_sem+0x79/0xa0
<4> [211.653652] hardirqs last disabled at (33436): [<ffffffff814a9b9e>] __up_console_sem+0x5e/0xa0
<4> [211.653654] softirqs last enabled at (33306): [<ffffffff813d0cbf>] __irq_exit_rcu+0x13f/0x160
<4> [211.653656] softirqs last disabled at (33301): [<ffffffff813d0cbf>] __irq_exit_rcu+0x13f/0x160
<4> [211.653658] ---[ end trace 0000000000000000 ]---
<3> [211.736787] xe 0000:03:00.0: [drm] *ERROR* Tile0: GT0: Force wake domain 0: wake. MMIO unreliable (forcewake register returns 0xFFFFFFFF)!
<4> [211.736804] ------------[ cut here ]------------
<4> [211.736806] xe 0000:03:00.0: [drm] Tile0: GT0: Forcewake domain 0x1 failed to acknowledge awake request
<4> [211.736808] WARNING: drivers/gpu/drm/xe/xe_force_wake.c:206 at xe_force_wake_get+0x7a2/0x940 [xe], CPU#0: kworker/0:3/950
<4> [211.736872] Modules linked in: snd_hda_codec_intelhdmi snd_hda_codec_hdmi pmt_crashlog mei_gsc_proxy mei_lb 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 intel_tcc_cooling x86_pkg_temp_thermal hid_generic cmdlinepart intel_powerclamp spi_nor eeepc_wmi asus_wmi mtd mei_pxp mei_hdcp sparse_keymap coretemp platform_profile wmi_bmof kvm_intel binfmt_misc snd_hda_intel kvm snd_intel_dspcfg irqbypass ghash_clmulni_intel snd_hda_codec r8169 aesni_intel rapl snd_hda_core usbhid snd_hwdep hid intel_cstate snd_pcm video realtek snd_timer i2c_i801 snd i2c_mux spi_intel_pci nls_iso8859_1 soundcore spi_intel i2c_smbus idma64 intel_pmc_core pmt_telemetry mei_me pmt_discovery pmt_class intel_pmc_ssram_telemetry mei intel_vsec pinctrl_alderlake wmi acpi_tad acpi_pad dm_multipath msr nvme_fabrics fuse
<4> [211.736935] efi_pstore nfnetlink autofs4
<4> [211.736940] CPU: 0 UID: 0 PID: 950 Comm: kworker/0:3 Tainted: G S U W 7.0.0-rc2-lgci-xe-xe-4660-d6f74d61a95e54f21-debug+ #1 PREEMPT(lazy)
<4> [211.736943] Tainted: [S]=CPU_OUT_OF_SPEC, [U]=USER, [W]=WARN
<4> [211.736944] Hardware name: ASUS System Product Name/PRIME Z790-P WIFI, BIOS 1645 03/15/2024
<4> [211.736946] Workqueue: events drm_mode_rmfb_work_fn
<4> [211.736949] RIP: 0010:xe_force_wake_get+0x7b1/0x940 [xe]
<4> [211.737010] Code: 75 03 48 8b 17 48 89 55 a8 89 4d b8 e8 48 ac 62 e1 48 89 c6 48 8d 3d 8e e4 3d 00 41 57 8b 4d b8 4d 89 f1 45 89 e8 48 8b 55 a8 <67> 48 0f b9 3a 58 e9 fd fb ff ff 48 8b 45 b8 4c 8d 65 c6 4c 8b 30
<4> [211.737012] RSP: 0018:ffffc9000352f930 EFLAGS: 00010246
<4> [211.737015] RAX: ffffffffa11fb95a RBX: 0000000000000001 RCX: 0000000000000000
<4> [211.737016] RDX: ffff88810464a190 RSI: ffffffffa11fb95a RDI: ffffffffa1001f00
<4> [211.737018] RBP: ffffc9000352fa10 R08: 0000000000000000 R09: ffffffffa11f7869
<4> [211.737019] R10: 0000000000000000 R11: 0000000000000000 R12: 0000000000000000
<4> [211.737021] R13: 0000000000000000 R14: ffffffffa11f7869 R15: 0000000000000001
<4> [211.737022] FS: 0000000000000000(0000) GS:ffff8888dac99000(0000) knlGS:0000000000000000
<4> [211.737024] CS: 0010 DS: 0000 ES: 0000 CR0: 0000000080050033
<4> [211.737026] CR2: 00005d4e2a5b0e08 CR3: 000000000344c001 CR4: 0000000000f72ef0
<4> [211.737027] PKRU: 55555554
<4> [211.737029] Call Trace:
<4> [211.737030] <TASK>
<4> [211.737032] ? intel_dsb_reg_write+0x34/0x50 [xe]
<4> [211.737134] ? intel_dsb_emit.part.0+0xa2/0xc0 [xe]
<4> [211.737237] xe_device_l2_flush+0xab/0x2d0 [xe]
<4> [211.737296] ? xe_mmio_write32+0x168/0x2b0 [xe]
<4> [211.737385] ? intel_dsb_emit.part.0+0xa2/0xc0 [xe]
<4> [211.737483] ? intel_dsb_reg_write+0x34/0x50 [xe]
<4> [211.737577] xe_dsb_buffer_flush_map+0x28/0x40 [xe]
<4> [211.737677] intel_dsb_finish+0x3e/0x50 [xe]
<4> [211.737771] intel_atomic_commit_tail+0x564/0x1c90 [xe]
<4> [211.737873] ? find_held_lock+0x31/0x90
<4> [211.737876] ? is_module_address+0x6a/0x140
<4> [211.737879] ? lock_release+0xd0/0x2b0
<4> [211.737887] intel_atomic_commit+0x2e8/0x330 [xe]
<4> [211.737986] ? intel_atomic_commit+0x2e8/0x330 [xe]
<4> [211.738085] drm_atomic_commit+0xaf/0xf0
<4> [211.738088] ? __pfx___drm_printfn_info+0x10/0x10
<4> [211.738092] atomic_remove_fb+0x346/0x3d0
<4> [211.738102] drm_framebuffer_remove+0x71/0x240
<4> [211.738105] drm_mode_rmfb_work_fn+0x7c/0xa0
<4> [211.738108] process_one_work+0x22e/0x740
<4> [211.738113] worker_thread+0x1e8/0x3d0
<4> [211.738116] ? __pfx_worker_thread+0x10/0x10
<4> [211.738118] kthread+0x10d/0x150
<4> [211.738121] ? __pfx_kthread+0x10/0x10
<4> [211.738124] ret_from_fork+0x3d4/0x480
<4> [211.738126] ? __pfx_kthread+0x10/0x10
<4> [211.738130] ret_from_fork_asm+0x1a/0x30
<4> [211.738137] </TASK>
<4> [211.738138] irq event stamp: 34383
<4> [211.738139] hardirqs last enabled at (34389): [<ffffffff814a9bb9>] __up_console_sem+0x79/0xa0
<4> [211.738142] hardirqs last disabled at (34394): [<ffffffff814a9b9e>] __up_console_sem+0x5e/0xa0
<4> [211.738144] softirqs last enabled at (33528): [<ffffffff813d0cbf>] __irq_exit_rcu+0x13f/0x160
<4> [211.738146] softirqs last disabled at (33523): [<ffffffff813d0cbf>] __irq_exit_rcu+0x13f/0x160
<4> [211.738148] ---[ end trace 0000000000000000 ]---
<3> [211.820941] xe 0000:03:00.0: [drm] *ERROR* Tile0: GT0: Force wake domain 0: wake. MMIO unreliable (forcewake register returns 0xFFFFFFFF)!
<4> [211.820957] ------------[ cut here ]------------
<4> [211.820959] xe 0000:03:00.0: [drm] Tile0: GT0: Forcewake domain 0x1 failed to acknowledge awake request
<4> [211.820962] WARNING: drivers/gpu/drm/xe/xe_force_wake.c:206 at xe_force_wake_get+0x7a2/0x940 [xe], CPU#0: kworker/0:3/950
<4> [211.821026] Modules linked in: snd_hda_codec_intelhdmi snd_hda_codec_hdmi pmt_crashlog mei_gsc_proxy mei_lb 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 intel_tcc_cooling x86_pkg_temp_thermal hid_generic cmdlinepart intel_powerclamp spi_nor eeepc_wmi asus_wmi mtd mei_pxp mei_hdcp sparse_keymap coretemp platform_profile wmi_bmof kvm_intel binfmt_misc snd_hda_intel kvm snd_intel_dspcfg irqbypass ghash_clmulni_intel snd_hda_codec r8169 aesni_intel rapl snd_hda_core usbhid snd_hwdep hid intel_cstate snd_pcm video realtek snd_timer i2c_i801 snd i2c_mux spi_intel_pci nls_iso8859_1 soundcore spi_intel i2c_smbus idma64 intel_pmc_core pmt_telemetry mei_me pmt_discovery pmt_class intel_pmc_ssram_telemetry mei intel_vsec pinctrl_alderlake wmi acpi_tad acpi_pad dm_multipath msr nvme_fabrics fuse
<4> [211.821100] efi_pstore nfnetlink autofs4
<4> [211.821104] CPU: 0 UID: 0 PID: 950 Comm: kworker/0:3 Tainted: G S U W 7.0.0-rc2-lgci-xe-xe-4660-d6f74d61a95e54f21-debug+ #1 PREEMPT(lazy)
<4> [211.821107] Tainted: [S]=CPU_OUT_OF_SPEC, [U]=USER, [W]=WARN
<4> [211.821109] Hardware name: ASUS System Product Name/PRIME Z790-P WIFI, BIOS 1645 03/15/2024
<4> [211.821110] Workqueue: events drm_mode_rmfb_work_fn
<4> [211.821113] RIP: 0010:xe_force_wake_get+0x7b1/0x940 [xe]
<4> [211.821175] Code: 75 03 48 8b 17 48 89 55 a8 89 4d b8 e8 48 ac 62 e1 48 89 c6 48 8d 3d 8e e4 3d 00 41 57 8b 4d b8 4d 89 f1 45 89 e8 48 8b 55 a8 <67> 48 0f b9 3a 58 e9 fd fb ff ff 48 8b 45 b8 4c 8d 65 c6 4c 8b 30
<4> [211.821177] RSP: 0018:ffffc9000352f930 EFLAGS: 00010246
<4> [211.821180] RAX: ffffffffa11fb95a RBX: 0000000000000001 RCX: 0000000000000000
<4> [211.821181] RDX: ffff88810464a190 RSI: ffffffffa11fb95a RDI: ffffffffa1001f00
<4> [211.821183] RBP: ffffc9000352fa10 R08: 0000000000000000 R09: ffffffffa11f7869
<4> [211.821184] R10: 0000000000000000 R11: 0000000000000000 R12: 0000000000000000
<4> [211.821186] R13: 0000000000000000 R14: ffffffffa11f7869 R15: 0000000000000001
<4> [211.821187] FS: 0000000000000000(0000) GS:ffff8888dac99000(0000) knlGS:0000000000000000
<4> [211.821189] CS: 0010 DS: 0000 ES: 0000 CR0: 0000000080050033
<4> [211.821191] CR2: 00005d4e2a5b0e08 CR3: 000000000344c001 CR4: 0000000000f72ef0
<4> [211.821192] PKRU: 55555554
<4> [211.821194] Call Trace:
<4> [211.821195] <TASK>
<4> [211.821197] ? intel_dsb_reg_write+0x34/0x50 [xe]
<4> [211.821298] ? intel_dsb_emit.part.0+0xa2/0xc0 [xe]
<4> [211.821411] xe_device_l2_flush+0xab/0x2d0 [xe]
<4> [211.821469] ? xe_mmio_write32+0x168/0x2b0 [xe]
<4> [211.821545] ? intel_dsb_emit.part.0+0xa2/0xc0 [xe]
<4> [211.821640] ? intel_dsb_reg_write+0x34/0x50 [xe]
<4> [211.821736] xe_dsb_buffer_flush_map+0x28/0x40 [xe]
<4> [211.821836] intel_dsb_finish+0x3e/0x50 [xe]
<4> [211.821933] intel_atomic_commit_tail+0x564/0x1c90 [xe]
<4> [211.822034] ? find_held_lock+0x31/0x90
<4> [211.822037] ? is_module_address+0x6a/0x140
<4> [211.822040] ? lock_release+0xd0/0x2b0
<4> [211.822047] intel_atomic_commit+0x2e8/0x330 [xe]
<4> [211.822149] ? intel_atomic_commit+0x2e8/0x330 [xe]
<4> [211.822249] drm_atomic_commit+0xaf/0xf0
<4> [211.822251] ? __pfx___drm_printfn_info+0x10/0x10
<4> [211.822256] atomic_remove_fb+0x346/0x3d0
<4> [211.822265] drm_framebuffer_remove+0x71/0x240
<4> [211.822268] drm_mode_rmfb_work_fn+0x7c/0xa0
<4> [211.822271] process_one_work+0x22e/0x740
<4> [211.822277] worker_thread+0x1e8/0x3d0
<4> [211.822280] ? __pfx_worker_thread+0x10/0x10
<4> [211.822283] kthread+0x10d/0x150
<4> [211.822285] ? __pfx_kthread+0x10/0x10
<4> [211.822289] ret_from_fork+0x3d4/0x480
<4> [211.822291] ? __pfx_kthread+0x10/0x10
<4> [211.822294] ret_from_fork_asm+0x1a/0x30
<4> [211.822301] </TASK>
<4> [211.822302] irq event stamp: 35351
<4> [211.822303] hardirqs last enabled at (35357): [<ffffffff814a9bb9>] __up_console_sem+0x79/0xa0
<4> [211.822306] hardirqs last disabled at (35362): [<ffffffff814a9b9e>] __up_console_sem+0x5e/0xa0
<4> [211.822308] softirqs last enabled at (35190): [<ffffffff813d0cbf>] __irq_exit_rcu+0x13f/0x160
<4> [211.822313] softirqs last disabled at (35183): [<ffffffff813d0cbf>] __irq_exit_rcu+0x13f/0x160
<4> [211.822315] ---[ end trace 0000000000000000 ]---
<6> [211.927517] pcieport 0000:00:06.0: AER: Multiple Correctable error message received from 0000:05:00.0
<4> [211.927522] nvme 0000:05:00.0: PCIe Bus Error: severity=Correctable, type=Physical Layer, (Receiver ID)
<4> [211.927524] nvme 0000:05:00.0: device [15b7:5017] error status/mask=00000001/0000e000
<4> [211.927526] nvme 0000:05:00.0: [ 0] RxErr (First)
<6> [212.033375] pcieport 0000:00:06.0: AER: Multiple Correctable error message received from 0000:05:00.0
<4> [212.033378] nvme 0000:05:00.0: PCIe Bus Error: severity=Correctable, type=Physical Layer, (Receiver ID)
<4> [212.033380] nvme 0000:05:00.0: device [15b7:5017] error status/mask=00000001/0000e000
<4> [212.033381] nvme 0000:05:00.0: [ 0] RxErr (First)
<4> [219.941806] xe 0000:03:00.0: [drm] energy read from pmt failed, ret -19
<4> [220.025956] xe 0000:03:00.0: [drm] energy read from pmt failed, ret -19
<6> [220.135954] pcieport 0000:00:06.0: AER: Multiple Correctable error message received from 0000:05:00.0
<4> [220.135960] nvme 0000:05:00.0: PCIe Bus Error: severity=Correctable, type=Physical Layer, (Receiver ID)
<4> [220.135961] nvme 0000:05:00.0: device [15b7:5017] error status/mask=00000001/0000e000
<4> [220.135963] nvme 0000:05:00.0: [ 0] RxErr (First)
<7> [220.362569] xe 0000:03:00.0: [drm:xe_hwmon_pcode_read_power_limit [xe]] read failed ch 0 val0 0x00000000, val1 0x00000000, ret -11
<6> [220.362689] xe 0000:03:00.0: [drm] PL2 disabled for channel 0, val 0x00000000
<7> [220.446725] xe 0000:03:00.0: [drm:xe_hwmon_pcode_read_power_limit [xe]] read failed ch 0 val0 0x00000000, val1 0x00000000, ret -11
<3> [220.446851] xe 0000:03:00.0: [drm] *ERROR* power interval read fail, ch 0, attr 14, val 0x00000000, ret -11
<3> [222.300321] xe 0000:03:00.0: [drm] *ERROR* flip_done timed out
<3> [222.300391] xe 0000:03:00.0: [drm] *ERROR* [CRTC:386:pipe C] commit wait timed out
<6> [222.407500] pcieport 0000:00:06.0: AER: Multiple Correctable error message received from 0000:05:00.0
<4> [222.407506] nvme 0000:05:00.0: PCIe Bus Error: severity=Correctable, type=Physical Layer, (Receiver ID)
<4> [222.407508] nvme 0000:05:00.0: device [15b7:5017] error status/mask=00000001/0000e000
<4> [222.407509] nvme 0000:05:00.0: [ 0] RxErr (First)
<6> [222.512986] pcieport 0000:00:06.0: AER: Multiple Correctable error message received from 0000:05:00.0
<4> [222.512990] nvme 0000:05:00.0: PCIe Bus Error: severity=Correctable, type=Physical Layer, (Receiver ID)
<4> [222.512991] nvme 0000:05:00.0: device [15b7:5017] error status/mask=00000001/0000e000
<4> [222.512993] nvme 0000:05:00.0: [ 0] RxErr (First)
<3> [232.540255] xe 0000:03:00.0: [drm] *ERROR* flip_done timed out
<3> [232.540261] xe 0000:03:00.0: [drm] *ERROR* [PLANE:270:plane 1C] commit wait timed out
<3> [232.606965] xe 0000:03:00.0: [drm] *ERROR* [CRTC:504:pipe D] DSB 0 is busy
<3> [232.691103] xe 0000:03:00.0: [drm] *ERROR* [CRTC:386:pipe C] DSB 0 is busy
<6> [238.282074] pcieport 0000:00:06.0: AER: Multiple Correctable error message received from 0000:05:00.0
<4> [238.282080] nvme 0000:05:00.0: PCIe Bus Error: severity=Correctable, type=Physical Layer, (Receiver ID)
<4> [238.282082] nvme 0000:05:00.0: device [15b7:5017] error status/mask=00000001/0000e000
<4> [238.282084] nvme 0000:05:00.0: [ 0] RxErr (First)
<6> [238.285304] pcieport 0000:00:06.0: AER: Multiple Correctable error message received from 0000:05:00.0
<4> [238.285308] nvme 0000:05:00.0: PCIe Bus Error: severity=Correctable, type=Physical Layer, (Receiver ID)
<4> [238.285309] nvme 0000:05:00.0: device [15b7:5017] error status/mask=00000001/0000e000
<4> [238.285311] nvme 0000:05:00.0: [ 0] RxErr (First)
<3> [242.781176] xe 0000:03:00.0: [drm] *ERROR* [CRTC:386:pipe C] flip_done timed out
Created at 2026-03-06 03:05:26