Results for igt@kms_flip@wf_vblank-ts-check@a-hdmi-a1

Result: Fail

integration-manifest git-log-oneline i915_display_info16 igt_runner16 runtimes16 results16.json results16-i915-load.json i915_display_info_post_exec16 boot16 dmesg16

DetailValue
Duration 19.79 seconds
Hostname 
shard-tglu-1
Igt-Version 
IGT-Version: 2.2-gc91ce8c09 (x86_64) (Linux: 6.18.0-rc3-Patchwork_155067v5-ga8f3783a2ccf+ x86_64)
Out 
Using IGT_SRANDOM=1761641131 for randomisation
Opened device: /dev/dri/card0
Using monotonic timestamps
Starting subtest: wf_vblank-ts-check
Starting dynamic subtest: A-HDMI-A1
  1920x1080: 53 139930 1920 2008 2096 2360 1080 1084 1089 1125 0x48 0x5 
Expected frametime: 18974us; measured 18960.7us +- 6.258us accuracy 0.10%
vblank interval differs from modeline! expected 18973.8us, measured 18961us +- 6.258us, difference 13.1us (2.1 sigma)
Event vblank: expected 404, counted 410, passrate = 65.85%, encoder type 2
Expected frametime: 18974us; measured 18556.6us +- 6.366us accuracy 0.10%
vblank interval differs from modeline! expected 18973.8us, measured 18557us +- 6.366us, difference 417.2us (65.5 sigma)
Event vblank: expected 413, counted 410, passrate = 14.63%, encoder type 2
Stack trace:
  #0 ../lib/igt_core.c:2075 __igt_fail_assert()
  #1 ../tests/kms_flip.c:428 run_test_on_crtc_set.constprop.0()
  #2 ../tests/kms_flip.c:1889 run_test()
  #3 ../tests/kms_flip.c:2122 __igt_unique____real_main2045()
  #4 ../tests/kms_flip.c:2045 main()
  #5 [__libc_init_first+0x8a]
  #6 [__libc_start_main+0x8b]
  #7 [_start+0x25]
Dynamic subtest A-HDMI-A1: FAIL (19.791s)
Err 
Starting subtest: wf_vblank-ts-check
Starting dynamic subtest: A-HDMI-A1
(kms_flip:2288) CRITICAL: Test assertion failure function __run_test_on_crtc_set, file ../tests/kms_flip.c:1709:
(kms_flip:2288) CRITICAL: Failed assertion: !retried
Dynamic subtest A-HDMI-A1 failed.
**** DEBUG ****
(kms_flip:2288) igt_fb-DEBUG: igt_create_fb_with_bo_size(width=1920, height=1080, format=XR24(0x34325258), modifier=0x100000000000001, size=0)
(kms_flip:2288) drmtest-DEBUG: Test requirement passed: is_intel_device(fd)
(kms_flip:2288) drmtest-DEBUG: Test requirement passed: is_intel_device(fd)
(kms_flip:2288) igt_fb-DEBUG: igt_create_fb_with_bo_size(handle=1, pitch=7680)
(kms_flip:2288) ioctl_wrappers-DEBUG: Test requirement passed: igt_has_fb_modifiers(fd)
(kms_flip:2288) igt_fb-DEBUG: igt_create_fb_with_bo_size(width=1920, height=1080, format=XR24(0x34325258), modifier=0x100000000000001, size=0)
(kms_flip:2288) drmtest-DEBUG: Test requirement passed: is_intel_device(fd)
(kms_flip:2288) drmtest-DEBUG: Test requirement passed: is_intel_device(fd)
(kms_flip:2288) igt_fb-DEBUG: igt_create_fb_with_bo_size(handle=2, pitch=7680)
(kms_flip:2288) ioctl_wrappers-DEBUG: Test requirement passed: igt_has_fb_modifiers(fd)
(kms_flip:2288) intel_blt-DEBUG: Test requirement passed: cmds_info
(kms_flip:2288) intel_blt-DEBUG: Test requirement passed: cmds_info
(kms_flip:2288) igt_fb-DEBUG: Test requirement passed: cairo_surface_status(fb->cairo_surface) == CAIRO_STATUS_SUCCESS
(kms_flip:2288) intel_blt-DEBUG: Test requirement passed: cmds_info
(kms_flip:2288) intel_blt-DEBUG: Test requirement passed: cmds_info
(kms_flip:2288) igt_fb-DEBUG: Test requirement passed: cairo_surface_status(fb->cairo_surface) == CAIRO_STATUS_SUCCESS
(kms_flip:2288) igt_kms-INFO:   1920x1080: 53 139930 1920 2008 2096 2360 1080 1084 1089 1125 0x48 0x5 
(kms_flip:2288) DEBUG: No stale events found
(kms_flip:2288) i915/intel_drrs-DEBUG: Manually disabling DRRS. 0
(kms_flip:2288) i915/intel_drrs-DEBUG: Test requirement passed: dir >= 0
(kms_flip:2288) INFO: Expected frametime: 18974us; measured 18960.7us +- 6.258us accuracy 0.10%
(kms_flip:2288) INFO: vblank interval differs from modeline! expected 18973.8us, measured 18961us +- 6.258us, difference 13.1us (2.1 sigma)
(kms_flip:2288) DEBUG: name = vblank
last_ts = 0.000000
last_received_ts = 0.000000
last_seq = 0
current_ts = 388.637573
current_received_ts = 388.637146
current_seq = 16113
count = 0
seq_step = 10
(kms_flip:2288) DEBUG: name = vblank
last_ts = 388.637573
last_received_ts = 388.637146
last_seq = 16113
current_ts = 388.827179
current_received_ts = 388.826782
current_seq = 16123
count = 1
seq_step = 10
(kms_flip:2288) DEBUG: vblank ts/seq: last 388.637573/16113, current 388.827179/16123: elapsed=189605.0us expected=189606.9us +- 948.0us, error 0.0%
(kms_flip:2288) DEBUG: name = vblank
last_ts = 388.827179
last_received_ts = 388.826782
last_seq = 16123
current_ts = 389.016815
current_received_ts = 389.016205
current_seq = 16133
count = 2
seq_step = 10
(kms_flip:2288) DEBUG: vblank ts/seq: last 388.827179/16123, current 389.016815/16133: elapsed=189611.0us expected=189606.9us +- 948.0us, error 0.0%
(kms_flip:2288) DEBUG: name = vblank
last_ts = 389.016815
last_received_ts = 389.016205
last_seq = 16133
current_ts = 389.206421
current_received_ts = 389.205933
current_seq = 16143
count = 3
seq_step = 10
(kms_flip:2288) DEBUG: vblank ts/seq: last 389.016815/16133, current 389.206421/16143: elapsed=189620.0us expected=189606.9us +- 948.0us, error 0.0%
(kms_flip:2288) DEBUG: name = vblank
last_ts = 389.206421
last_received_ts = 389.205933
last_seq = 16143
current_ts = 389.396027
current_received_ts = 389.395630
current_seq = 16153
count = 4
seq_step = 10
(kms_flip:2288) DEBUG: vblank ts/seq: last 389.206421/16143, current 389.396027/16153: elapsed=189614.0us expected=189606.9us +- 948.0us, error 0.0%
(kms_flip:2288) DEBUG: name = vblank
last_ts = 389.396027
last_received_ts = 389.395630
last_seq = 16153
current_ts = 389.585663
current_received_ts = 389.585236
current_seq = 16163
count = 5
seq_step = 10
(kms_flip:2288) DEBUG: vblank ts/seq: last 389.396027/16153, current 389.585663/16163: elapsed=189619.0us expected=189606.9us +- 948.0us, error 0.0%
(kms_flip:2288) DEBUG: name = vblank
last_ts = 389.585663
last_received_ts = 389.585236
last_seq = 16163
current_ts = 389.775269
current_received_ts = 389.774841
current_seq = 16173
count = 6
seq_step = 10
(kms_flip:2288) DEBUG: vblank ts/seq: last 389.585663/16163, current 389.775269/16173: elapsed=189606.0us expected=189606.9us +- 948.0us, error 0.0%
(kms_flip:2288) DEBUG: name = vblank
last_ts = 389.775269
last_received_ts = 389.774841
last_seq = 16173
current_ts = 389.964874
current_received_ts = 389.964478
current_seq = 16183
count = 7
seq_step = 10
(kms_flip:2288) DEBUG: vblank ts/seq: last 389.775269/16173, current 389.964874/16183: elapsed=189621.0us expected=189606.9us +- 948.0us, error 0.0%
(kms_flip:2288) DEBUG: name = vblank
last_ts = 389.964874
last_received_ts = 389.964478
last_seq = 16183
current_ts = 390.154510
current_received_ts = 390.154114
current_seq = 16193
count = 8
seq_step = 10
(kms_flip:2288) DEBUG: vblank ts/seq: last 389.964874/16183, current 390.154510/16193: elapsed=189615.0us expected=189606.9us +- 948.0us, error 0.0%
(kms_flip:2288) DEBUG: name = vblank
last_ts = 390.154510
last_received_ts = 390.154114
last_seq = 16193
current_ts = 390.344116
current_received_ts = 390.343689
current_seq = 16203
count = 9
seq_step = 10
(kms_flip:2288) DEBUG: vblank ts/seq: last 390.154510/16193, current 390.344116/16203: elapsed=189632.0us expected=189606.9us +- 948.0us, error 0.0%
(kms_flip:2288) DEBUG: name = vblank
last_ts = 390.344116
last_received_ts = 390.343689
last_seq = 16203
current_ts = 390.533752
current_received_ts = 390.533173
current_seq = 16213
count = 10
seq_step = 10
(kms_flip:2288) DEBUG: vblank ts/seq: last 390.344116/16203, current 390.533752/16213: elapsed=189608.0us expected=189606.9us +- 948.0us, error 0.0%
(kms_flip:2288) DEBUG: name = vblank
last_ts = 390.533752
last_received_ts = 390.533173
last_seq = 16213
current_ts = 390.723358
current_received_ts = 390.722931
current_seq = 16223
count = 11
seq_step = 10
(kms_flip:2288) DEBUG: vblank ts/seq: last 390.533752/16213, current 390.723358/16223: elapsed=189629.0us expected=189606.9us +- 948.0us, error 0.0%
(kms_flip:2288) DEBUG: name = vblank
last_ts = 390.723358
last_received_ts = 390.722931
last_seq = 16223
current_ts = 390.912994
current_received_ts = 390.912292
current_seq = 16233
count = 12
seq_step = 10
(kms_flip:2288) DEBUG: vblank ts/seq: last 390.723358/16223, current 390.912994/16233: elapsed=189621.0us expected=189606.9us +- 948.0us, error 0.0%
(kms_flip:2288) DEBUG: name = vblank
last_ts = 390.912994
last_received_ts = 390.912292
last_seq = 16233
current_ts = 391.102600
current_received_ts = 391.102173
current_seq = 16243
count = 13
seq_step = 10
(kms_flip:2288) DEBUG: vblank ts/seq: last 390.912994/16233, current 391.102600/16243: elapsed=189609.0us expected=189606.9us +- 948.0us, error 0.0%
(kms_flip:2288) DEBUG: name = vblank
last_ts = 391.102600
last_received_ts = 391.102173
last_seq = 16243
current_ts = 391.292236
current_received_ts = 391.291779
current_seq = 16253
count = 14
seq_step = 10
(kms_flip:2288) DEBUG: vblank ts/seq: last 391.102600/16243, current 391.292236/16253: elapsed=189629.0us expected=189606.9us +- 948.0us, error 0.0%
(kms_flip:2288) DEBUG: name = vblank
last_ts = 391.292236
last_received_ts = 391.291779
last_seq = 16253
current_ts = 391.481842
current_received_ts = 391.481415
current_seq = 16263
count = 15
seq_step = 10
(kms_flip:2288) DEBUG: vblank ts/seq: last 391.292236/16253, current 391.481842/16263: elapsed=189611.0us expected=189606.9us +- 948.0us, error 0.0%
(kms_flip:2288) DEBUG: name = vblank
last_ts = 391.481842
last_received_ts = 391.481415
last_seq = 16263
current_ts = 391.671478
current_received_ts = 391.671082
current_seq = 16273
count = 16
seq_step = 10
(kms_flip:2288) DEBUG: vblank ts/seq: last 391.481842/16263, current 391.671478/16273: elapsed=189632.0us expected=189606.9us +- 948.0us, error 0.0%
(kms_flip:2288) DEBUG: name = vblank
last_ts = 391.671478
last_received_ts = 391.671082
last_seq = 16273
current_ts = 391.861084
current_received_ts = 391.860657
current_seq = 16283
count = 17
seq_step = 10
(kms_flip:2288) DEBUG: vblank ts/seq: last 391.671478/16273, current 391.861084/16283: elapsed=189613.0us expected=189606.9us +- 948.0us, error 0.0%
(kms_flip:2288) DEBUG: name = vblank
last_ts = 391.861084
last_received_ts = 391.860657
last_seq = 16283
current_ts = 392.050720
current_received_ts = 392.050293
current_seq = 16293
count = 18
seq_step = 10
(kms_flip:2288) DEBUG: vblank ts/seq: last 391.861084/16283, current 392.050720/16293: elapsed=189628.0us expected=189606.9us +- 948.0us, error 0.0%
(kms_flip:2288) DEBUG: name = vblank
last_ts = 392.050720
last_received_ts = 392.050293
last_seq = 16293
current_ts = 392.240326
current_received_ts = 392.239899
current_seq = 16303
count = 19
seq_step = 10
(kms_flip:2288) DEBUG: vblank ts/seq: last 392.050720/16293, current 392.240326/16303: elapsed=189630.0us expected=189606.9us +- 948.0us, error 0.0%
(kms_flip:2288) DEBUG: name = vblank
last_ts = 392.240326
last_received_ts = 392.239899
last_seq = 16303
current_ts = 392.429962
current_received_ts = 392.429535
current_seq = 16313
count = 20
seq_step = 10
(kms_flip:2288) DEBUG: vblank ts/seq: last 392.240326/16303, current 392.429962/16313: elapsed=189608.0us expected=189606.9us +- 948.0us, error 0.0%
(kms_flip:2288) DEBUG: name = vblank
last_ts = 392.429962
last_received_ts = 392.429535
last_seq = 16313
current_ts = 392.619568
current_received_ts = 392.619171
current_seq = 16323
count = 21
seq_step = 10
(kms_flip:2288) DEBUG: vblank ts/seq: last 392.429962/16313, current 392.619568/16323: elapsed=189628.0us expected=189606.9us +- 948.0us, error 0.0%
(kms_flip:2288) DEBUG: name = vblank
last_ts = 392.619568
last_received_ts = 392.619171
last_seq = 16323
current_ts = 392.809204
current_received_ts = 392.808655
current_seq = 16333
count = 22
seq_step = 10
(kms_flip:2288) DEBUG: vblank ts/seq: last 392.619568/16323, current 392.809204/16333: elapsed=189625.0us expected=189606.9us +- 948.0us, error 0.0%
(kms_flip:2288) DEBUG: name = vblank
last_ts = 392.809204
last_received_ts = 392.808655
last_seq = 16333
current_ts = 392.998840
current_received_ts = 392.998413
current_seq = 16343
count = 23
seq_step = 10
(kms_flip:2288) DEBUG: vblank ts/seq: last 392.809204/16333, current 392.998840/16343: elapsed=189636.0us expected=189606.9us +- 948.0us, error 0.0%
(kms_flip:2288) DEBUG: name = vblank
last_ts = 392.998840
last_received_ts = 392.998413
last_seq = 16343
current_ts = 393.188477
current_received_ts = 393.188080
current_seq = 16353
count = 24
seq_step = 10
(kms_flip:2288) DEBUG: vblank ts/seq: last 392.998840/16343, current 393.188477/16353: elapsed=189625.0us expected=189606.9us +- 948.0us, error 0.0%
(kms_flip:2288) DEBUG: name = vblank
last_ts = 393.188477
last_received_ts = 393.188080
last_seq = 16353
current_ts = 393.378082
current_received_ts = 393.377655
current_seq = 16363
count = 25
seq_step = 10
(kms_flip:2288) DEBUG: vblank ts/seq: last 393.188477/16353, current 393.378082/16363: elapsed=189617.0us expected=189606.9us +- 948.0us, error 0.0%
(kms_flip:2288) DEBUG: name = vblank
last_ts = 393.378082
last_received_ts = 393.377655
last_seq = 16363
current_ts = 393.567688
current_received_ts = 393.567291
current_seq = 16373
count = 26
seq_step = 10
(kms_flip:2288) DEBUG: vblank ts/seq: last 393.378082/16363, current 393.567688/16373: elapsed=189623.0us expected=189606.9us +- 948.0us, error 0.0%
(kms_flip:2288) DEBUG: name = vblank
last_ts = 393.567688
last_received_ts = 393.567291
last_seq = 16373
current_ts = 393.749542
current_received_ts = 393.749054
current_seq = 16383
count = 27
seq_step = 10
(kms_flip:2288) DEBUG: vblank ts/seq: last 393.567688/16373, current 393.749542/16383: elapsed=181830.0us expected=189606.9us +- 948.0us, error 4.1%
(kms_flip:2288) DEBUG: inconsistent vblank ts/seq: last 393.567688/16373, current 393.749542/16383: elapsed=181830.0us expected=189606.9us
(kms_flip:2288) DEBUG: name = vblank
last_ts = 393.749542
last_received_ts = 393.749054
last_seq = 16383
current_ts = 393.931244
current_received_ts = 393.930817
current_seq = 16393
count = 28
seq_step = 10
(kms_flip:2288) DEBUG: vblank ts/seq: last 393.749542/16383, current 393.931244/16393: elapsed=181701.0us expected=189606.9us +- 948.0us, error 4.2%
(kms_flip:2288) DEBUG: inconsistent vblank ts/seq: last 393.749542/16383, current 393.931244/16393: elapsed=181701.0us expected=189606.9us
(kms_flip:2288) DEBUG: name = vblank
last_ts = 393.931244
last_received_ts = 393.930817
last_seq = 16393
current_ts = 394.112946
current_received_ts = 394.112518
current_seq = 16403
count = 29
seq_step = 10
(kms_flip:2288) DEBUG: vblank ts/seq: last 393.931244/16393, current 394.112946/16403: elapsed=181716.0us expected=189606.9us +- 948.0us, error 4.2%
(kms_flip:2288) DEBUG: inconsistent vblank ts/seq: last 393.931244/16393, current 394.112946/16403: elapsed=181716.0us expected=189606.9us
(kms_flip:2288) DEBUG: name = vblank
last_ts = 394.112946
last_received_ts = 394.112518
last_seq = 16403
current_ts = 394.294647
current_received_ts = 394.294220
current_seq = 16413
count = 30
seq_step = 10
(kms_flip:2288) DEBUG: vblank ts/seq: last 394.112946/16403, current 394.294647/16413: elapsed=181695.0us expected=189606.9us +- 948.0us, error 4.2%
(kms_flip:2288) DEBUG: inconsistent vblank ts/seq: last 394.112946/16403, current 394.294647/16413: elapsed=181695.0us expected=189606.9us
(kms_flip:2288) DEBUG: name = vblank
last_ts = 394.294647
last_received_ts = 394.294220
last_seq = 16413
current_ts = 394.476349
current_received_ts = 394.475830
current_seq = 16423
count = 31
seq_step = 10
(kms_flip:2288) DEBUG: vblank ts/seq: last 394.294647/16413, current 394.476349/16423: elapsed=181711.0us expected=189606.9us +- 948.0us, error 4.2%
(kms_flip:2288) DEBUG: inconsistent vblank ts/seq: last 394.294647/16413, current 394.476349/16423: elapsed=181711.0us expected=189606.9us
(kms_flip:2288) DEBUG: name = vblank
last_ts = 394.476349
last_received_ts = 394.475830
last_seq = 16423
current_ts = 394.658447
current_received_ts = 394.658081
current_seq = 16433
count = 32
seq_step = 10
(kms_flip:2288) DEBUG: vblank ts/seq: last 394.476349/16423, current 394.658447/16433: elapsed=182103.0us expected=189606.9us +- 948.0us, error 4.0%
(kms_flip:2288) DEBUG: inconsistent vblank ts/seq: last 394.476349/16423, current 394.658447/16433: elapsed=182103.0us expected=189606.9us
(kms_flip:2288) DEBUG: name = vblank
last_ts = 394.658447
last_received_ts = 394.658081
last_seq = 16433
current_ts = 394.841156
current_received_ts = 394.840637
current_seq = 16443
count = 33
seq_step = 10
(kms_flip:2288) DEBUG: vblank ts/seq: last 394.658447/16433, current 394.841156/16443: elapsed=182702.0us expected=189606.9us +- 948.0us, error 3.6%
(kms_flip:2288) DEBUG: inconsistent vblank ts/seq: last 394.658447/16433, current 394.841156/16443: elapsed=182702.0us expected=189606.9us
(kms_flip:2288) DEBUG: name = vblank
last_ts = 394.841156
last_received_ts = 394.840637
last_seq = 16443
current_ts = 395.023865
current_received_ts = 395.023254
current_seq = 16453
count = 34
seq_step = 10
(kms_flip:2288) DEBUG: vblank ts/seq: last 394.841156/16443, current 395.023865/16453: elapsed=182691.0us expected=189606.9us +- 948.0us, error 3.6%
(kms_flip:2288) DEBUG: inconsistent vblank ts/seq: last 394.841156/16443, current 395.023865/16453: elapsed=182691.0us expected=189606.9us
(kms_flip:2288) DEBUG: name = vblank
last_ts = 395.023865
last_received_ts = 395.023254
last_seq = 16453
current_ts = 395.206543
current_received_ts = 395.206116
current_seq = 16463
count = 35
seq_step = 10
(kms_flip:2288) DEBUG: vblank ts/seq: last 395.023865/16453, current 395.206543/16463: elapsed=182691.0us expected=189606.9us +- 948.0us, error 3.6%
(kms_flip:2288) DEBUG: inconsistent vblank ts/seq: last 395.023865/16453, current 395.206543/16463: elapsed=182691.0us expected=189606.9us
(kms_flip:2288) DEBUG: name = vblank
last_ts = 395.206543
last_received_ts = 395.206116
last_seq = 16463
current_ts = 395.389252
current_received_ts = 395.388824
current_seq = 16473
count = 36
seq_step = 10
(kms_flip:2288) DEBUG: vblank ts/seq: last 395.206543/16463, current 395.389252/16473: elapsed=182696.0us expected=189606.9us +- 948.0us, error 3.6%
(kms_flip:2288) DEBUG: inconsistent vblank ts/seq: last 395.206543/16463, current 395.389252/16473: elapsed=182696.0us expected=189606.9us
(kms_flip:2288) DEBUG: name = vblank
last_ts = 395.389252
last_received_ts = 395.388824
last_seq = 16473
current_ts = 395.571930
current_received_ts = 395.571533
current_seq = 16483
count = 37
seq_step = 10
(kms_flip:2288) DEBUG: vblank ts/seq: last 395.389252/16473, current 395.571930/16483: elapsed=182697.0us expected=189606.9us +- 948.0us, error 3.6%
(kms_flip:2288) DEBUG: inconsistent vblank ts/seq: last 395.389252/16473, current 395.571930/16483: elapsed=182697.0us expected=189606.9us
(kms_flip:2288) DEBUG: name = vblank
last_ts = 395.571930
last_received_ts = 395.571533
last_seq = 16483
current_ts = 395.755493
current_received_ts = 395.755096
current_seq = 16493
count = 38
seq_step = 10
(kms_flip:2288) DEBUG: vblank ts/seq: last 395.571930/16483, current 395.755493/16493: elapsed=183565.0us expected=189606.9us +- 948.0us, error 3.2%
(kms_flip:2288) DEBUG: inconsistent vblank ts/seq: last 395.571930/16483, current 395.755493/16493: elapsed=183565.0us expected=189606.9us
(kms_flip:2288) DEBUG: name = vblank
last_ts = 395.755493
last_received_ts = 395.755096
last_seq = 16493
current_ts = 395.939087
current_received_ts = 395.938629
current_seq = 16503
count = 39
seq_step = 10
(kms_flip:2288) DEBUG: vblank ts/seq: last 395.755493/16493, current 395.939087/16503: elapsed=183574.0us expected=189606.9us +- 948.0us, error 3.2%
(kms_flip:2288) DEBUG: inconsistent vblank ts/seq: last 395.755493/16493, current 395.939087/16503: elapsed=183574.0us expected=189606.9us
(kms_flip:2288) DEBUG: name = vblank
last_ts = 395.939087
last_received_ts = 395.938629
last_seq = 16503
current_ts = 396.122620
current_received_ts = 396.122162
current_seq = 16513
count = 40
seq_step = 10
(kms_flip:2288) DEBUG: vblank ts/seq: last 395.939087/16503, current 396.122620/16513: elapsed=183557.0us expected=189606.9us +- 948.0us, error 3.2%
(kms_flip:2288) DEBUG: inconsistent vblank ts/seq: last 395.939087/16503, current 396.122620/16513: elapsed=183557.0us expected=189606.9us
(kms_flip:2288) INFO: Event vblank: expected 404, counted 410, passrate = 65.85%, encoder type 2
(kms_flip:2288) DEBUG: dropped frames, expected 404, counted 410, passrate = 65.85%, encoder type 2
(kms_flip:2288) DEBUG: Retrying without a hotplug event
(kms_flip:2288) DEBUG: No stale events found
(kms_flip:2288) i915/intel_drrs-DEBUG: Manually disabling DRRS. 0
(kms_flip:2288) i915/intel_drrs-DEBUG: Test requirement passed: dir >= 0
(kms_flip:2288) INFO: Expected frametime: 18974us; measured 18556.6us +- 6.366us accuracy 0.10%
(kms_flip:2288) INFO: vblank interval differs from modeline! expected 18973.8us, measured 18557us +- 6.366us, difference 417.2us (65.5 sigma)
(kms_flip:2288) DEBUG: name = vblank
last_ts = 0.000000
last_received_ts = 0.000000
last_seq = 0
current_ts = 399.762909
current_received_ts = 399.762512
current_seq = 16704
count = 0
seq_step = 10
(kms_flip:2288) DEBUG: name = vblank
last_ts = 399.762909
last_received_ts = 399.762512
last_seq = 16704
current_ts = 399.948975
current_received_ts = 399.948578
current_seq = 16714
count = 1
seq_step = 10
(kms_flip:2288) DEBUG: vblank ts/seq: last 399.762909/16704, current 399.948975/16714: elapsed=186077.0us expected=185565.6us +- 927.8us, error 0.3%
(kms_flip:2288) DEBUG: name = vblank
last_ts = 399.948975
last_received_ts = 399.948578
last_seq = 16714
current_ts = 400.135040
current_received_ts = 400.134674
current_seq = 16724
count = 2
seq_step = 10
(kms_flip:2288) DEBUG: vblank ts/seq: last 399.948975/16714, current 400.135040/16724: elapsed=186079.0us expected=185565.6us +- 927.8us, error 0.3%
(kms_flip:2288) DEBUG: name = vblank
last_ts = 400.135040
last_received_ts = 400.134674
last_seq = 16724
current_ts = 400.321136
current_received_ts = 400.320770
current_seq = 16734
count = 3
seq_step = 10
(kms_flip:2288) DEBUG: vblank ts/seq: last 400.135040/16724, current 400.321136/16734: elapsed=186079.0us expected=185565.6us +- 927.8us, error 0.3%
(kms_flip:2288) DEBUG: name = vblank
last_ts = 400.321136
last_received_ts = 400.320770
last_seq = 16734
current_ts = 400.507233
current_received_ts = 400.506836
current_seq = 16744
count = 4
seq_step = 10
(kms_flip:2288) DEBUG: vblank ts/seq: last 400.321136/16734, current 400.507233/16744: elapsed=186086.0us expected=185565.6us +- 927.8us, error 0.3%
(kms_flip:2288) DEBUG: name = vblank
last_ts = 400.507233
last_received_ts = 400.506836
last_seq = 16744
current_ts = 400.693573
current_received_ts = 400.693207
current_seq = 16754
count = 5
seq_step = 10
(kms_flip:2288) DEBUG: vblank ts/seq: last 400.507233/16744, current 400.693573/16754: elapsed=186342.0us expected=185565.6us +- 927.8us, error 0.4%
(kms_flip:2288) DEBUG: name = vblank
last_ts = 400.693573
last_received_ts = 400.693207
last_seq = 16754
current_ts = 400.880096
current_received_ts = 400.879730
current_seq = 16764
count = 6
seq_step = 10
(kms_flip:2288) DEBUG: vblank ts/seq: last 400.693573/16754, current 400.880096/16764: elapsed=186528.0us expected=185565.6us +- 927.8us, error 0.5%
(kms_flip:2288) DEBUG: inconsistent vblank ts/seq: last 400.693573/16754, current 400.880096/16764: elapsed=186528.0us expected=185565.6us
(kms_flip:2288) DEBUG: name = vblank
last_ts = 400.880096
last_received_ts = 400.879730
last_seq = 16764
current_ts = 401.066620
current_received_ts = 401.066254
current_seq = 16774
count = 7
seq_step = 10
(kms_flip:2288) DEBUG: vblank ts/seq: last 400.880096/16764, current 401.066620/16774: elapsed=186525.0us expected=185565.6us +- 927.8us, error 0.5%
(kms_flip:2288) DEBUG: inconsistent vblank ts/seq: last 400.880096/16764, current 401.066620/16774: elapsed=186525.0us expected=185565.6us
(kms_flip:2288) DEBUG: name = vblank
last_ts = 401.066620
last_received_ts = 401.066254
last_seq = 16774
current_ts = 401.253143
current_received_ts = 401.252747
current_seq = 16784
count = 8
seq_step = 10
(kms_flip:2288) DEBUG: vblank ts/seq: last 401.066620/16774, current 401.253143/16784: elapsed=186524.0us expected=185565.6us +- 927.8us, error 0.5%
(kms_flip:2288) DEBUG: inconsistent vblank ts/seq: last 401.066620/16774, current 401.253143/16784: elapsed=186524.0us expected=185565.6us
(kms_flip:2288) DEBUG: name = vblank
last_ts = 401.253143
last_received_ts = 401.252747
last_seq = 16784
current_ts = 401.439667
current_received_ts = 401.439301
current_seq = 16794
count = 9
seq_step = 10
(kms_flip:2288) DEBUG: vblank ts/seq: last 401.253143/16784, current 401.439667/16794: elapsed=186526.0us expected=185565.6us +- 927.8us, error 0.5%
(kms_flip:2288) DEBUG: inconsistent vblank ts/seq: last 401.253143/16784, current 401.439667/16794: elapsed=186526.0us expected=185565.6us
(kms_flip:2288) DEBUG: name = vblank
last_ts = 401.439667
last_received_ts = 401.439301
last_seq = 16794
current_ts = 401.626312
current_received_ts = 401.625946
current_seq = 16804
count = 10
seq_step = 10
(kms_flip:2288) DEBUG: vblank ts/seq: last 401.439667/16794, current 401.626312/16804: elapsed=186655.0us expected=185565.6us +- 927.8us, error 0.6%
(kms_flip:2288) DEBUG: inconsistent vblank ts/seq: last 401.439667/16794, current 401.626312/16804: elapsed=186655.0us expected=185565.6us
(kms_flip:2288) DEBUG: name = vblank
last_ts = 401.626312
last_received_ts = 401.625946
last_seq = 16804
current_ts = 401.813232
current_received_ts = 401.812714
current_seq = 16814
count = 11
seq_step = 10
(kms_flip:2288) DEBUG: vblank ts/seq: last 401.626312/16804, current 401.813232/16814: elapsed=186902.0us expected=185565.6us +- 927.8us, error 0.7%
(kms_flip:2288) DEBUG: inconsistent vblank ts/seq: last 401.626312/16804, current 401.813232/16814: elapsed=186902.0us expected=185565.6us
(kms_flip:2288) DEBUG: name = vblank
last_ts = 401.813232
last_received_ts = 401.812714
last_seq = 16814
current_ts = 402.000153
current_received_ts = 401.999786
current_seq = 16824
count = 12
seq_step = 10
(kms_flip:2288) DEBUG: vblank ts/seq: last 401.813232/16814, current 402.000153/16824: elapsed=186918.0us expected=185565.6us +- 927.8us, error 0.7%
(kms_flip:2288) DEBUG: inconsistent vblank ts/seq: last 401.813232/16814, current 402.000153/16824: elapsed=186918.0us expected=185565.6us
(kms_flip:2288) DEBUG: name = vblank
last_ts = 402.000153
last_received_ts = 401.999786
last_seq = 16824
current_ts = 402.187042
current_received_ts = 402.186707
current_seq = 16834
count = 13
seq_step = 10
(kms_flip:2288) DEBUG: vblank ts/seq: last 402.000153/16824, current 402.187042/16834: elapsed=186911.0us expected=185565.6us +- 927.8us, error 0.7%
(kms_flip:2288) DEBUG: inconsistent vblank ts/seq: last 402.000153/16824, current 402.187042/16834: elapsed=186911.0us expected=185565.6us
(kms_flip:2288) DEBUG: name = vblank
last_ts = 402.187042
last_received_ts = 402.186707
last_seq = 16834
current_ts = 402.373962
current_received_ts = 402.373596
current_seq = 16844
count = 14
seq_step = 10
(kms_flip:2288) DEBUG: vblank ts/seq: last 402.187042/16834, current 402.373962/16844: elapsed=186920.0us expected=185565.6us +- 927.8us, error 0.7%
(kms_flip:2288) DEBUG: inconsistent vblank ts/seq: last 402.187042/16834, current 402.373962/16844: elapsed=186920.0us expected=185565.6us
(kms_flip:2288) DEBUG: name = vblank
last_ts = 402.373962
last_received_ts = 402.373596
last_seq = 16844
current_ts = 402.560883
current_received_ts = 402.560516
current_seq = 16854
count = 15
seq_step = 10
(kms_flip:2288) DEBUG: vblank ts/seq: last 402.373962/16844, current 402.560883/16854: elapsed=186911.0us expected=185565.6us +- 927.8us, error 0.7%
(kms_flip:2288) DEBUG: inconsistent vblank ts/seq: last 402.373962/16844, current 402.560883/16854: elapsed=186911.0us expected=185565.6us
(kms_flip:2288) DEBUG: name = vblank
last_ts = 402.560883
last_received_ts = 402.560516
last_seq = 16854
current_ts = 402.748138
current_received_ts = 402.747589
current_seq = 16864
count = 16
seq_step = 10
(kms_flip:2288) DEBUG: vblank ts/seq: last 402.560883/16854, current 402.748138/16864: elapsed=187257.0us expected=185565.6us +- 927.8us, error 0.9%
(kms_flip:2288) DEBUG: inconsistent vblank ts/seq: last 402.560883/16854, current 402.748138/16864: elapsed=187257.0us expected=185565.6us
(kms_flip:2288) DEBUG: name = vblank
last_ts = 402.748138
last_received_ts = 402.747589
last_seq = 16864
current_ts = 402.935394
current_received_ts = 402.935059
current_seq = 16874
count = 17
seq_step = 10
(kms_flip:2288) DEBUG: vblank ts/seq: last 402.748138/16864, current 402.935394/16874: elapsed=187242.0us expected=185565.6us +- 927.8us, error 0.9%
(kms_flip:2288) DEBUG: inconsistent vblank ts/seq: last 402.748138/16864, current 402.935394/16874: elapsed=187242.0us expected=185565.6us
(kms_flip:2288) DEBUG: name = vblank
last_ts = 402.935394
last_received_ts = 402.935059
last_seq = 16874
current_ts = 403.122650
current_received_ts = 403.122284
current_seq = 16884
count = 18
seq_step = 10
(kms_flip:2288) DEBUG: vblank ts/seq: last 402.935394/16874, current 403.122650/16884: elapsed=187258.0us expected=185565.6us +- 927.8us, error 0.9%
(kms_flip:2288) DEBUG: inconsistent vblank ts/seq: last 402.935394/16874, current 403.122650/16884: elapsed=187258.0us expected=185565.6us
(kms_flip:2288) DEBUG: name = vblank
last_ts = 403.122650
last_received_ts = 403.122284
last_seq = 16884
current_ts = 403.309906
current_received_ts = 403.309540
current_seq = 16894
count = 19
seq_step = 10
(kms_flip:2288) DEBUG: vblank ts/seq: last 403.122650/16884, current 403.309906/16894: elapsed=187256.0us expected=185565.6us +- 927.8us, error 0.9%
(kms_flip:2288) DEBUG: inconsistent vblank ts/seq: last 403.122650/16884, current 403.309906/16894: elapsed=187256.0us expected=185565.6us
(kms_flip:2288) DEBUG: name = vblank
last_ts = 403.309906
last_received_ts = 403.309540
last_seq = 16894
current_ts = 403.497162
current_received_ts = 403.496765
current_seq = 16904
count = 20
seq_step = 10
(kms_flip:2288) DEBUG: vblank ts/seq: last 403.309906/16894, current 403.497162/16904: elapsed=187267.0us expected=185565.6us +- 927.8us, error 0.9%
(kms_flip:2288) DEBUG: inconsistent vblank ts/seq: last 403.309906/16894, current 403.497162/16904: elapsed=187267.0us expected=185565.6us
(kms_flip:2288) DEBUG: name = vblank
last_ts = 403.497162
last_received_ts = 403.496765
last_seq = 16904
current_ts = 403.684601
current_received_ts = 403.684204
current_seq = 16914
count = 21
seq_step = 10
(kms_flip:2288) DEBUG: vblank ts/seq: last 403.497162/16904, current 403.684601/16914: elapsed=187425.0us expected=185565.6us +- 927.8us, error 1.0%
(kms_flip:2288) DEBUG: inconsistent vblank ts/seq: last 403.497162/16904, current 403.684601/16914: elapsed=187425.0us expected=185565.6us
(kms_flip:2288) DEBUG: name = vblank
last_ts = 403.684601
last_received_ts = 403.684204
last_seq = 16914
current_ts = 403.872131
current_received_ts = 403.871765
current_seq = 16924
count = 22
seq_step = 10
(kms_flip:2288) DEBUG: vblank ts/seq: last 403.684601/16914, current 403.872131/16924: elapsed=187554.0us expected=185565.6us +- 927.8us, error 1.1%
(kms_flip:2288) DEBUG: inconsistent vblank ts/seq: last 403.684601/16914, current 403.872131/16924: elapsed=187554.0us expected=185565.6us
(kms_flip:2288) DEBUG: name = vblank
last_ts = 403.872131
last_received_ts = 403.871765
last_seq = 16924
current_ts = 404.059692
current_received_ts = 404.059326
current_seq = 16934
count = 23
seq_step = 10
(kms_flip:2288) DEBUG: vblank ts/seq: last 403.872131/16924, current 404.059692/16934: elapsed=187564.0us expected=185565.6us +- 927.8us, error 1.1%
(kms_flip:2288) DEBUG: inconsistent vblank ts/seq: last 403.872131/16924, current 404.059692/16934: elapsed=187564.0us expected=185565.6us
(kms_flip:2288) DEBUG: name = vblank
last_ts = 404.059692
last_received_ts = 404.059326
last_seq = 16934
current_ts = 404.247253
current_received_ts = 404.246857
current_seq = 16944
count = 24
seq_step = 10
(kms_flip:2288) DEBUG: vblank ts/seq: last 404.059692/16934, current 404.247253/16944: elapsed=187541.0us expected=185565.6us +- 927.8us, error 1.1%
(kms_flip:2288) DEBUG: inconsistent vblank ts/seq: last 404.059692/16934, current 404.247253/16944: elapsed=187541.0us expected=185565.6us
(kms_flip:2288) DEBUG: name = vblank
last_ts = 404.247253
last_received_ts = 404.246857
last_seq = 16944
current_ts = 404.434814
current_received_ts = 404.434418
current_seq = 16954
count = 25
seq_step = 10
(kms_flip:2288) DEBUG: vblank ts/seq: last 404.247253/16944, current 404.434814/16954: elapsed=187554.0us expected=185565.6us +- 927.8us, error 1.1%
(kms_flip:2288) DEBUG: inconsistent vblank ts/seq: last 404.247253/16944, current 404.434814/16954: elapsed=187554.0us expected=185565.6us
(kms_flip:2288) DEBUG: name = vblank
last_ts = 404.434814
last_received_ts = 404.434418
last_seq = 16954
current_ts = 404.622437
current_received_ts = 404.621979
current_seq = 16964
count = 26
seq_step = 10
(kms_flip:2288) DEBUG: vblank ts/seq: last 404.434814/16954, current 404.622437/16964: elapsed=187641.0us expected=185565.6us +- 927.8us, error 1.1%
(kms_flip:2288) DEBUG: inconsistent vblank ts/seq: last 404.434814/16954, current 404.622437/16964: elapsed=187641.0us expected=185565.6us
(kms_flip:2288) DEBUG: name = vblank
last_ts = 404.622437
last_received_ts = 404.621979
last_seq = 16964
current_ts = 404.810242
current_received_ts = 404.809875
current_seq = 16974
count = 27
seq_step = 10
(kms_flip:2288) DEBUG: vblank ts/seq: last 404.622437/16964, current 404.810242/16974: elapsed=187805.0us expected=185565.6us +- 927.8us, error 1.2%
(kms_flip:2288) DEBUG: inconsistent vblank ts/seq: last 404.622437/16964, current 404.810242/16974: elapsed=187805.0us expected=185565.6us
(kms_flip:2288) DEBUG: name = vblank
last_ts = 404.810242
last_received_ts = 404.809875
last_seq = 16974
current_ts = 404.998047
current_received_ts = 404.997681
current_seq = 16984
count = 28
seq_step = 10
(kms_flip:2288) DEBUG: vblank ts/seq: last 404.810242/16974, current 404.998047/16984: elapsed=187812.0us expected=185565.6us +- 927.8us, error 1.2%
(kms_flip:2288) DEBUG: inconsistent vblank ts/seq: last 404.810242/16974, current 404.998047/16984: elapsed=187812.0us expected=185565.6us
(kms_flip:2288) DEBUG: name = vblank
last_ts = 404.998047
last_received_ts = 404.997681
last_seq = 16984
current_ts = 405.185883
current_received_ts = 405.185516
current_seq = 16994
count = 29
seq_step = 10
(kms_flip:2288) DEBUG: vblank ts/seq: last 404.998047/16984, current 405.185883/16994: elapsed=187821.0us expected=185565.6us +- 927.8us, error 1.2%
(kms_flip:2288) DEBUG: inconsistent vblank ts/seq: last 404.998047/16984, current 405.185883/16994: elapsed=187821.0us expected=185565.6us
(kms_flip:2288) DEBUG: name = vblank
last_ts = 405.185883
last_received_ts = 405.185516
last_seq = 16994
current_ts = 405.373718
current_received_ts = 405.373169
current_seq = 17004
count = 30
seq_step = 10
(kms_flip:2288) DEBUG: vblank ts/seq: last 405.185883/16994, current 405.373718/17004: elapsed=187824.0us expected=185565.6us +- 927.8us, error 1.2%
(kms_flip:2288) DEBUG: inconsistent vblank ts/seq: last 405.185883/16994, current 405.373718/17004: elapsed=187824.0us expected=185565.6us
(kms_flip:2288) DEBUG: name = vblank
last_ts = 405.373718
last_received_ts = 405.373169
last_seq = 17004
current_ts = 405.561493
current_received_ts = 405.561157
current_seq = 17014
count = 31
seq_step = 10
(kms_flip:2288) DEBUG: vblank ts/seq: last 405.373718/17004, current 405.561493/17014: elapsed=187803.0us expected=185565.6us +- 927.8us, error 1.2%
(kms_flip:2288) DEBUG: inconsistent vblank ts/seq: last 405.373718/17004, current 405.561493/17014: elapsed=187803.0us expected=185565.6us
(kms_flip:2288) DEBUG: name = vblank
last_ts = 405.561493
last_received_ts = 405.561157
last_seq = 17014
current_ts = 405.749542
current_received_ts = 405.749054
current_seq = 17024
count = 32
seq_step = 10
(kms_flip:2288) DEBUG: vblank ts/seq: last 405.561493/17014, current 405.749542/17024: elapsed=188032.0us expected=185565.6us +- 927.8us, error 1.3%
(kms_flip:2288) DEBUG: inconsistent vblank ts/seq: last 405.561493/17014, current 405.749542/17024: elapsed=188032.0us expected=185565.6us
(kms_flip:2288) DEBUG: name = vblank
last_ts = 405.749542
last_received_ts = 405.749054
last_seq = 17024
current_ts = 405.937592
current_received_ts = 405.937195
current_seq = 17034
count = 33
seq_step = 10
(kms_flip:2288) DEBUG: vblank ts/seq: last 405.749542/17024, current 405.937592/17034: elapsed=188057.0us expected=185565.6us +- 927.8us, error 1.3%
(kms_flip:2288) DEBUG: inconsistent vblank ts/seq: last 405.749542/17024, current 405.937592/17034: elapsed=188057.0us expected=185565.6us
(kms_flip:2288) DEBUG: name = vblank
last_ts = 405.937592
last_received_ts = 405.937195
last_seq = 17034
current_ts = 406.125641
current_received_ts = 406.125092
current_seq = 17044
count = 34
seq_step = 10
(kms_flip:2288) DEBUG: vblank ts/seq: last 405.937592/17034, current 406.125641/17044: elapsed=188042.0us expected=185565.6us +- 927.8us, error 1.3%
(kms_flip:2288) DEBUG: inconsistent vblank ts/seq: last 405.937592/17034, current 406.125641/17044: elapsed=188042.0us expected=185565.6us
(kms_flip:2288) DEBUG: name = vblank
last_ts = 406.125641
last_received_ts = 406.125092
last_seq = 17044
current_ts = 406.313690
current_received_ts = 406.313324
current_seq = 17054
count = 35
seq_step = 10
(kms_flip:2288) DEBUG: vblank ts/seq: last 406.125641/17044, current 406.313690/17054: elapsed=188041.0us expected=185565.6us +- 927.8us, error 1.3%
(kms_flip:2288) DEBUG: inconsistent vblank ts/seq: last 406.125641/17044, current 406.313690/17054: elapsed=188041.0us expected=185565.6us
(kms_flip:2288) DEBUG: name = vblank
last_ts = 406.313690
last_received_ts = 406.313324
last_seq = 17054
current_ts = 406.501709
current_received_ts = 406.501343
current_seq = 17064
count = 36
seq_step = 10
(kms_flip:2288) DEBUG: vblank ts/seq: last 406.313690/17054, current 406.501709/17064: elapsed=188043.0us expected=185565.6us +- 927.8us, error 1.3%
(kms_flip:2288) DEBUG: inconsistent vblank ts/seq: last 406.313690/17054, current 406.501709/17064: elapsed=188043.0us expected=185565.6us
(kms_flip:2288) DEBUG: name = vblank
last_ts = 406.501709
last_received_ts = 406.501343
last_seq = 17064
current_ts = 406.689880
current_received_ts = 406.689514
current_seq = 17074
count = 37
seq_step = 10
(kms_flip:2288) DEBUG: vblank ts/seq: last 406.501709/17064, current 406.689880/17074: elapsed=188163.0us expected=185565.6us +- 927.8us, error 1.4%
(kms_flip:2288) DEBUG: inconsistent vblank ts/seq: last 406.501709/17064, current 406.689880/17074: elapsed=188163.0us expected=185565.6us
(kms_flip:2288) DEBUG: name = vblank
last_ts = 406.689880
last_received_ts = 406.689514
last_seq = 17074
current_ts = 406.878143
current_received_ts = 406.877777
current_seq = 17084
count = 38
seq_step = 10
(kms_flip:2288) DEBUG: vblank ts/seq: last 406.689880/17074, current 406.878143/17084: elapsed=188248.0us expected=185565.6us +- 927.8us, error 1.4%
(kms_flip:2288) DEBUG: inconsistent vblank ts/seq: last 406.689880/17074, current 406.878143/17084: elapsed=188248.0us expected=185565.6us
(kms_flip:2288) DEBUG: name = vblank
last_ts = 406.878143
last_received_ts = 406.877777
last_seq = 17084
current_ts = 407.066376
current_received_ts = 407.065979
current_seq = 17094
count = 39
seq_step = 10
(kms_flip:2288) DEBUG: vblank ts/seq: last 406.878143/17084, current 407.066376/17094: elapsed=188236.0us expected=185565.6us +- 927.8us, error 1.4%
(kms_flip:2288) DEBUG: inconsistent vblank ts/seq: last 406.878143/17084, current 407.066376/17094: elapsed=188236.0us expected=185565.6us
(kms_flip:2288) DEBUG: name = vblank
last_ts = 407.066376
last_received_ts = 407.065979
last_seq = 17094
current_ts = 407.254608
current_received_ts = 407.254242
current_seq = 17104
count = 40
seq_step = 10
(kms_flip:2288) DEBUG: vblank ts/seq: last 407.066376/17094, current 407.254608/17104: elapsed=188250.0us expected=185565.6us +- 927.8us, error 1.4%
(kms_flip:2288) DEBUG: inconsistent vblank ts/seq: last 407.066376/17094, current 407.254608/17104: elapsed=188250.0us expected=185565.6us
(kms_flip:2288) INFO: Event vblank: expected 413, counted 410, passrate = 14.63%, encoder type 2
(kms_flip:2288) DEBUG: dropped frames, expected 413, counted 410, passrate = 14.63%, encoder type 2
(kms_flip:2288) CRITICAL: Test assertion failure function __run_test_on_crtc_set, file ../tests/kms_flip.c:1709:
(kms_flip:2288) CRITICAL: Failed assertion: !retried
(kms_flip:2288) igt_core-INFO: Stack trace:
(kms_flip:2288) igt_core-INFO:   #0 ../lib/igt_core.c:2075 __igt_fail_assert()
(kms_flip:2288) igt_core-INFO:   #1 ../tests/kms_flip.c:428 run_test_on_crtc_set.constprop.0()
(kms_flip:2288) igt_core-INFO:   #2 ../tests/kms_flip.c:1889 run_test()
(kms_flip:2288) igt_core-INFO:   #3 ../tests/kms_flip.c:2122 __igt_unique____real_main2045()
(kms_flip:2288) igt_core-INFO:   #4 ../tests/kms_flip.c:2045 main()
(kms_flip:2288) igt_core-INFO:   #5 [__libc_init_first+0x8a]
(kms_flip:2288) igt_core-INFO:   #6 [__libc_start_main+0x8b]
(kms_flip:2288) igt_core-INFO:   #7 [_start+0x25]
****  END  ****
Dynamic subtest A-HDMI-A1: FAIL (19.791s)
Dmesg
<6> [494.327544] Console: switching to colour dummy device 80x25
<6> [494.327936] [IGT] kms_flip: executing
<7> [494.330230] i915 0000:00:02.0: [drm:i915_gem_open [i915]]
<7> [494.330919] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc]
<7> [494.331211] i915 0000:00:02.0: [drm:i915_gem_open [i915]]
<7> [494.340730] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] [CONNECTOR:352:DP-1]
<7> [494.340738] i915 0000:00:02.0: [drm:intel_dp_detect [i915]] [CONNECTOR:352:DP-1]
<7> [494.345158] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] [CONNECTOR:352:DP-1] disconnected
<7> [494.345569] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] [CONNECTOR:362:DP-2]
<7> [494.345573] i915 0000:00:02.0: [drm:intel_dp_detect [i915]] [CONNECTOR:362:DP-2]
<7> [494.345909] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] [CONNECTOR:362:DP-2] disconnected
<7> [494.346274] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] [CONNECTOR:371:DP-3]
<7> [494.346277] i915 0000:00:02.0: [drm:intel_dp_detect [i915]] [CONNECTOR:371:DP-3]
<7> [494.346609] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] [CONNECTOR:371:DP-3] disconnected
<7> [494.346979] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] [CONNECTOR:380:DP-4]
<7> [494.346982] i915 0000:00:02.0: [drm:intel_dp_detect [i915]] [CONNECTOR:380:DP-4]
<7> [494.347302] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] [CONNECTOR:380:DP-4] disconnected
<7> [494.347873] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] [CONNECTOR:342:HDMI-A-1]
<7> [494.347879] i915 0000:00:02.0: [drm:intel_hdmi_detect [i915]] [CONNECTOR:342:HDMI-A-1]
<7> [494.375011] i915 0000:00:02.0: [drm:update_display_info.part.0] [CONNECTOR:342:HDMI-A-1] Supported Monitor Refresh rate range is 0 Hz - 0 Hz
<7> [494.375022] i915 0000:00:02.0: [drm:update_display_info.part.0] [CONNECTOR:342:HDMI-A-1] Assigning EDID-1.4 digital sink color depth as 8 bpc.
<7> [494.375025] i915 0000:00:02.0: [drm:update_display_info.part.0] [CONNECTOR:342:HDMI-A-1] ELD monitor fitHeadless4k
<7> [494.375029] i915 0000:00:02.0: [drm:update_display_info.part.0] [CONNECTOR:342:HDMI-A-1] ELD size 36, SAD count 0
<7> [494.375503] i915 0000:00:02.0: [drm:do_gmbus_xfer [i915]] GMBUS [i915 gmbus dpb] NAK for addr: 0040 w(1)
<7> [494.375679] i915 0000:00:02.0: [drm:do_gmbus_xfer [i915]] GMBUS [i915 gmbus dpb] NAK on first message, retry
<7> [494.376281] i915 0000:00:02.0: [drm:do_gmbus_xfer [i915]] GMBUS [i915 gmbus dpb] NAK for addr: 0040 w(1)
<7> [494.376436] i915 0000:00:02.0: [drm:drm_dp_dual_mode_detect [drm_display_helper]] DP dual mode HDMI ID: (err -6)
<7> [494.376893] i915 0000:00:02.0: [drm:drm_mode_prune_invalid] Rejected mode: "1366x768": 216 268000 1366 1414 1446 1526 768 771 777 814 0x40 0x6 (CLOCK_HIGH)
<7> [494.376902] i915 0000:00:02.0: [drm:drm_mode_prune_invalid] Rejected mode: "1920x1080i": 60 74250 1920 2008 2052 2200 1080 1084 1094 1125 0x40 0x15 (NO_INTERLACE)
<7> [494.376909] i915 0000:00:02.0: [drm:drm_mode_prune_invalid] Rejected mode: "1920x1080i": 60 74176 1920 2008 2052 2200 1080 1084 1094 1125 0x40 0x15 (NO_INTERLACE)
<7> [494.376916] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] [CONNECTOR:342:HDMI-A-1] probed modes:
<7> [494.376921] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "1920x1080": 53 139930 1920 2008 2096 2360 1080 1084 1089 1125 0x48 0x5
<7> [494.376925] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "4088x2304": 10 108000 4088 4152 4280 4536 2304 2305 2308 2340 0x40 0x5
<7> [494.376928] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "3840x2160": 15 128430 3840 3889 3921 4000 2160 2163 2169 2195 0x40 0xa
<7> [494.376931] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "2880x1800": 11 60000 2880 2888 2984 3040 1800 1802 1820 1845 0x40 0xa
<7> [494.376934] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "2560x1600": 13 60000 2560 2568 2664 2720 1600 1602 1620 1645 0x40 0xa
<7> [494.376937] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "2560x1440": 15 60000 2560 2568 2664 2720 1440 1442 1460 1485 0x40 0xa
<7> [494.376941] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "2048x1536": 17 60000 2048 2056 2152 2208 1536 1538 1556 1581 0x40 0xa
<7> [494.376944] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "1600x1200": 60 162000 1600 1664 1856 2160 1200 1201 1204 1250 0x40 0x5
<7> [494.376947] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "1680x1050": 60 146250 1680 1784 1960 2240 1050 1053 1059 1089 0x40 0x6
<7> [494.376950] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "1600x900": 60 108000 1600 1624 1704 1800 900 901 904 1000 0x40 0x5
<7> [494.376953] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "1280x1024": 75 135000 1280 1296 1440 1688 1024 1025 1028 1066 0x40 0x5
<7> [494.376957] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "1360x768": 60 84963 1366 1431 1567 1776 768 771 781 798 0x0 0x6
<7> [494.376960] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "1360x768": 20 25190 1360 1368 1464 1520 768 770 788 813 0x40 0xa
<7> [494.376963] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "1280x800": 60 83500 1280 1352 1480 1680 800 803 809 831 0x40 0x6
<7> [494.376966] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "1152x864": 75 108000 1152 1216 1344 1600 864 865 868 900 0x40 0x5
<7> [494.376969] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "1280x720": 60 74250 1280 1390 1430 1650 720 725 730 750 0x40 0x5
<7> [494.376973] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "1280x720": 60 74250 1280 1390 1430 1650 720 725 730 750 0x40 0x5
<7> [494.376976] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "1280x720": 60 74176 1280 1390 1430 1650 720 725 730 750 0x40 0x5
<7> [494.376979] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "1024x768": 75 78750 1024 1040 1136 1312 768 769 772 800 0x40 0x5
<7> [494.376982] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "1024x768": 60 65000 1024 1048 1184 1344 768 771 777 806 0x40 0xa
<7> [494.376985] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "1440x480": 60 54054 1440 1472 1596 1716 480 489 495 525 0x40 0xa
<7> [494.376989] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "1440x480": 60 54000 1440 1472 1596 1716 480 489 495 525 0x40 0xa
<7> [494.376992] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "1024x576": 60 46560 1024 1064 1160 1296 576 579 584 599 0x0 0x6
<7> [494.376995] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "832x624": 75 57284 832 864 928 1152 624 625 628 667 0x40 0xa
<7> [494.376998] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "800x600": 75 49500 800 816 896 1056 600 601 604 625 0x40 0x5
<7> [494.377001] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "800x600": 60 40000 800 840 968 1056 600 601 605 628 0x40 0x5
<7> [494.377005] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "640x480": 75 31500 640 656 720 840 480 481 484 500 0x40 0xa
<7> [494.377008] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "640x480": 60 25200 640 656 752 800 480 490 492 525 0x40 0xa
<7> [494.377011] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "640x480": 60 25175 640 656 752 800 480 490 492 525 0x40 0xa
<7> [494.377014] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "640x480": 60 25175 640 656 752 800 480 490 492 525 0x40 0xa
<7> [494.377018] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "720x400": 70 28320 720 738 846 900 400 412 414 449 0x40 0x6
<7> [494.377053] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] [CONNECTOR:352:DP-1]
<7> [494.377058] i915 0000:00:02.0: [drm:intel_dp_detect [i915]] [CONNECTOR:352:DP-1]
<7> [494.381464] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] [CONNECTOR:352:DP-1] disconnected
<7> [494.381485] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] [CONNECTOR:362:DP-2]
<7> [494.381488] i915 0000:00:02.0: [drm:intel_dp_detect [i915]] [CONNECTOR:362:DP-2]
<7> [494.381847] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] [CONNECTOR:362:DP-2] disconnected
<7> [494.381862] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] [CONNECTOR:371:DP-3]
<7> [494.381865] i915 0000:00:02.0: [drm:intel_dp_detect [i915]] [CONNECTOR:371:DP-3]
<7> [494.382201] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] [CONNECTOR:371:DP-3] disconnected
<7> [494.382222] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] [CONNECTOR:380:DP-4]
<7> [494.382228] i915 0000:00:02.0: [drm:intel_dp_detect [i915]] [CONNECTOR:380:DP-4]
<7> [494.382606] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] [CONNECTOR:380:DP-4] disconnected
<6> [494.383483] [IGT] kms_flip: starting subtest wf_vblank-ts-check
<6> [494.386609] [IGT] kms_flip: starting dynamic subtest A-HDMI-A1
<7> [494.387075] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:390]
<7> [494.387187] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:392]
<7> [494.433337] i915 0000:00:02.0: [drm:drm_mode_setcrtc] [CRTC:108:pipe A]
<7> [494.433463] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:108:pipe A] fastset requirement not met in hw.enable (expected yes, found no)
<7> [494.433711] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:108:pipe A] fastset requirement not met in hw.active (expected yes, found no)
<7> [494.433915] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:108:pipe A] fastset requirement not met in cpu_transcoder (expected 0, found -1)
<7> [494.434108] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:108:pipe A] fastset requirement not met in lane_count (expected 4, found 0)
<7> [494.434297] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:108:pipe A] fastset requirement not met in output_types (expected 0x00000040, found 0x00000000)
<7> [494.434490] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:108:pipe A] fastset requirement not met in framestart_delay (expected 1, found 0)
<7> [494.434712] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:108:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hdisplay (expected 1920, found 0)
<7> [494.434918] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:108:pipe A] fastset requirement not met in hw.pipe_mode.crtc_htotal (expected 2360, found 0)
<7> [494.435122] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:108:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hblank_start (expected 1920, found 0)
<7> [494.435328] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:108:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hblank_end (expected 2360, found 0)
<7> [494.435539] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:108:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hsync_start (expected 2008, found 0)
<7> [494.435744] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:108:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hsync_end (expected 2096, found 0)
<7> [494.435946] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:108:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vdisplay (expected 1080, found 0)
<7> [494.436150] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:108:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vblank_start (expected 1080, found 0)
<7> [494.436354] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:108:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vsync_start (expected 1084, found 0)
<7> [494.436564] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:108:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vsync_end (expected 1089, found 0)
<7> [494.436769] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:108:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vtotal (expected 1125, found 0)
<7> [494.436972] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:108:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vblank_end (expected 1125, found 0)
<7> [494.437175] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:108:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hdisplay (expected 1920, found 0)
<7> [494.437366] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:108:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_htotal (expected 2360, found 0)
<7> [494.437520] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:108:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hblank_start (expected 1920, found 0)
<7> [494.437687] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:108:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hblank_end (expected 2360, found 0)
<7> [494.437842] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:108:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hsync_start (expected 2008, found 0)
<7> [494.437995] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:108:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hsync_end (expected 2096, found 0)
<7> [494.438149] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:108:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vdisplay (expected 1080, found 0)
<7> [494.438302] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:108:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vblank_start (expected 1080, found 0)
<7> [494.438455] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:108:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vsync_start (expected 1084, found 0)
<7> [494.438619] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:108:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vsync_end (expected 1089, found 0)
<7> [494.438772] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:108:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vtotal (expected 1125, found 0)
<7> [494.438925] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:108:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vblank_end (expected 1125, found 0)
<7> [494.439077] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:108:pipe A] fastset requirement not met in pixel_multiplier (expected 1, found 0)
<7> [494.439229] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:108:pipe A] fastset requirement not met in hw.adjusted_mode.flags (1) (expected 1, found 0)
<7> [494.439382] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:108:pipe A] fastset requirement not met in hw.adjusted_mode.flags (4) (expected 4, found 0)
<7> [494.439540] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:108:pipe A] fastset requirement not met in pipe_bpp (expected 24, found 0)
<7> [494.439693] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:108:pipe A] fastset requirement not met in hw.pipe_mode.crtc_clock (expected 139930, found 0)
<7> [494.439847] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:108:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_clock (expected 139930, found 0)
<7> [494.439999] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:108:pipe A] fastset requirement not met in port_clock (expected 139930, found 0)
<7> [494.440154] i915 0000:00:02.0: [drm:intel_atomic_check [i915]] [CRTC:108:pipe A] fastset requirement not met, forcing full modeset
<7> [494.440307] i915 0000:00:02.0: [drm:intel_dpll_crtc_put [i915]] [CRTC:108:pipe A] releasing DPLL 0
<7> [494.440494] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] Enabled dbuf slices 0x3 -> 0x1 (total dbuf slices 0x3), mbus joined? no->no
<7> [494.440667] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] [CRTC:108:pipe A] dbuf slices 0x3 -> 0x0, ddb (0 - 2048) -> (0 - 0), active pipes 0x1 -> 0x0
<7> [494.440858] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] [PLANE:33:plane 1A] ddb ( 0 - 2016) -> ( 0 - 0), size 2016 -> 0
<7> [494.441017] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] [PLANE:103:cursor A] ddb (2016 - 2048) -> ( 0 - 0), size 32 -> 0
<7> [494.441176] i915 0000:00:02.0: [drm:skl_print_plane_changes [i915]] [PLANE:33:plane 1A] level *wm0,*wm1,*wm2,*wm3,*wm4,*wm5,*wm6,*wm7,*twm, swm, stwm -> wm0, wm1, wm2, wm3, wm4, wm5, wm6, wm7, twm, swm, stwm
<7> [494.441334] i915 0000:00:02.0: [drm:skl_print_plane_changes [i915]] [PLANE:33:plane 1A] lines 1, 4, 4, 4, 4, 5, 7, 7, 0, 0, 0 -> 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0
<7> [494.441490] i915 0000:00:02.0: [drm:skl_print_plane_changes [i915]] [PLANE:33:plane 1A] blocks 16, 65, 65, 65, 65, 81, 113, 113, 30, 0, 0 -> 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0
<7> [494.441656] i915 0000:00:02.0: [drm:skl_print_plane_changes [i915]] [PLANE:33:plane 1A] min_ddb 19, 73, 73, 73, 73, 91, 126, 126, 31, 0, 0 -> 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0
<7> [494.441832] i915 0000:00:02.0: [drm:intel_bw_atomic_check [i915]] [CRTC:108:pipe A] data rate 0 num active planes 0
<7> [494.441993] i915 0000:00:02.0: [drm:intel_bw_atomic_check [i915]] QGV point 0: max bw 14993 required 0
<7> [494.442167] i915 0000:00:02.0: [drm:intel_cdclk_atomic_check [i915]] [CRTC:108:pipe A] min cdclk: 69965 kHz -> 0 kHz
<7> [494.442343] i915 0000:00:02.0: [drm:intel_cdclk_update_dbuf_bw_min_cdclk [i915]] dbuf bandwidth min cdclk: 8746 kHz -> 0 kHz
<7> [494.442504] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [CRTC:108:pipe A] enable: no [modeset]
<7> [494.442678] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:33:plane 1A] fb: [NOFB], visible: no
<7> [494.442838] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:43:plane 2A] fb: [NOFB], visible: no
<7> [494.442996] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:53:plane 3A] fb: [NOFB], visible: no
<7> [494.443153] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:63:plane 4A] fb: [NOFB], visible: no
<7> [494.443310] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:73:plane 5A] fb: [NOFB], visible: no
<7> [494.443466] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:83:plane 6A] fb: [NOFB], visible: no
<7> [494.443630] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:93:plane 7A] fb: [NOFB], visible: no
<7> [494.443786] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:103:cursor A] fb: [NOFB], visible: no
<7> [494.443999] i915 0000:00:02.0: [drm:intel_power_well_enable [i915]] enabling DC_off
<7> [494.444168] i915 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [i915]] Setting DC state from 02 to 00
<7> [494.460360] i915 0000:00:02.0: [drm:intel_disable_transcoder [i915]] disabling pipe A
<7> [494.477698] i915 0000:00:02.0: [drm:intel_power_well_disable [i915]] disabling DDI_IO_B
<7> [494.478086] i915 0000:00:02.0: [drm:intel_dpll_disable [i915]] disable DPLL 0 (active 0x1, on? 1) for [CRTC:108:pipe A]
<7> [494.478470] i915 0000:00:02.0: [drm:intel_dpll_disable [i915]] disabling DPLL 0
<7> [494.478858] i915 0000:00:02.0: [drm:__intel_fbc_disable [i915]] Disabling FBC on [PLANE:33:plane 1A]
<7> [494.479201] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:341:DDI B/PHY B]
<7> [494.479553] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:351:DDI TC1/PHY TC1]
<7> [494.479900] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:353:DP-MST A]
<7> [494.480317] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:354:DP-MST B]
<7> [494.480686] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:355:DP-MST C]
<7> [494.481020] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:356:DP-MST D]
<7> [494.481332] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:361:DDI TC2/PHY TC2]
<7> [494.481667] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:363:DP-MST A]
<7> [494.481992] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:364:DP-MST B]
<7> [494.482384] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:365:DP-MST C]
<7> [494.482763] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:366:DP-MST D]
<7> [494.483078] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:370:DDI TC3/PHY TC3]
<7> [494.483387] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:372:DP-MST A]
<7> [494.483725] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:373:DP-MST B]
<7> [494.484134] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:374:DP-MST C]
<7> [494.484474] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:375:DP-MST D]
<7> [494.484844] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:379:DDI TC4/PHY TC4]
<7> [494.485166] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:381:DP-MST A]
<7> [494.485480] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:382:DP-MST B]
<7> [494.485824] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:383:DP-MST C]
<7> [494.486252] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:384:DP-MST D]
<7> [494.486606] i915 0000:00:02.0: [drm:verify_connector_state [i915]] [CONNECTOR:342:HDMI-A-1]
<7> [494.487236] i915 0000:00:02.0: [drm:gen9_dbuf_slices_update [i915]] Updating dbuf slices to 0x1
<7> [494.487639] i915 0000:00:02.0: [drm:intel_modeset_verify_crtc [i915]] [CRTC:108:pipe A]
<7> [494.488587] i915 0000:00:02.0: [drm:drm_mode_setcrtc] [CRTC:185:pipe B]
<7> [494.488822] i915 0000:00:02.0: [drm:drm_mode_setcrtc] [CRTC:262:pipe C]
<7> [494.489022] i915 0000:00:02.0: [drm:drm_mode_setcrtc] [CRTC:339:pipe D]
<7> [494.489230] i915 0000:00:02.0: [drm:drm_mode_setcrtc] [CRTC:108:pipe A]
<7> [494.489306] i915 0000:00:02.0: [drm:drm_mode_setcrtc] [CONNECTOR:342:HDMI-A-1]
<7> [494.489463] i915 0000:00:02.0: [drm:intel_atomic_check [i915]] [CONNECTOR:342:HDMI-A-1] Limiting display bpp to 24 (EDID bpp 24, max requested bpp 36, max platform bpp 36)
<7> [494.489797] i915 0000:00:02.0: [drm:intel_hdmi_compute_clock [i915]] picking 8 bpc for HDMI output (pipe bpp: 24)
<7> [494.490075] i915 0000:00:02.0: [drm:intel_atomic_check [i915]] [CRTC:108:pipe A] hw max bpp: 24, pipe bpp: 24, dithering: 0
<7> [494.490321] i915 0000:00:02.0: [drm:intel_ddi_compute_config_late [i915]] [ENCODER:341:DDI B/PHY B] [CRTC:108:pipe A]
<7> [494.490526] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:108:pipe A] fastset requirement not met in hw.enable (expected no, found yes)
<7> [494.490798] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:108:pipe A] fastset requirement not met in hw.active (expected no, found yes)
<7> [494.491040] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:108:pipe A] fastset requirement not met in cpu_transcoder (expected -1, found 0)
<7> [494.491264] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:108:pipe A] fastset requirement not met in lane_count (expected 0, found 4)
<7> [494.491486] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:108:pipe A] fastset requirement not met in output_types (expected 0x00000000, found 0x00000040)
<7> [494.491714] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:108:pipe A] fastset requirement not met in framestart_delay (expected 0, found 1)
<7> [494.491923] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:108:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hdisplay (expected 0, found 1920)
<7> [494.492146] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:108:pipe A] fastset requirement not met in hw.pipe_mode.crtc_htotal (expected 0, found 2360)
<7> [494.492402] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:108:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hblank_start (expected 0, found 1920)
<7> [494.492641] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:108:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hblank_end (expected 0, found 2360)
<7> [494.492866] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:108:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hsync_start (expected 0, found 2008)
<7> [494.493074] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:108:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hsync_end (expected 0, found 2096)
<7> [494.493280] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:108:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vdisplay (expected 0, found 1080)
<7> [494.493453] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:108:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vblank_start (expected 0, found 1080)
<7> [494.493664] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:108:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vsync_start (expected 0, found 1084)
<7> [494.493830] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:108:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vsync_end (expected 0, found 1089)
<7> [494.493994] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:108:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vtotal (expected 0, found 1125)
<7> [494.494151] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:108:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vblank_end (expected 0, found 1125)
<7> [494.494316] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:108:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hdisplay (expected 0, found 1920)
<7> [494.494471] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:108:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_htotal (expected 0, found 2360)
<7> [494.494646] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:108:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hblank_start (expected 0, found 1920)
<7> [494.494833] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:108:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hblank_end (expected 0, found 2360)
<7> [494.495002] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:108:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hsync_start (expected 0, found 2008)
<7> [494.495166] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:108:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hsync_end (expected 0, found 2096)
<7> [494.495321] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:108:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vdisplay (expected 0, found 1080)
<7> [494.495484] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:108:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vblank_start (expected 0, found 1080)
<7> [494.495658] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:108:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vsync_start (expected 0, found 1084)
<7> [494.495815] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:108:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vsync_end (expected 0, found 1089)
<7> [494.495970] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:108:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vtotal (expected 0, found 1125)
<7> [494.496178] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:108:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vblank_end (expected 0, found 1125)
<7> [494.496332] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:108:pipe A] fastset requirement not met in pixel_multiplier (expected 0, found 1)
<7> [494.496495] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:108:pipe A] fastset requirement not met in hw.adjusted_mode.flags (1) (expected 0, found 1)
<7> [494.496678] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:108:pipe A] fastset requirement not met in hw.adjusted_mode.flags (4) (expected 0, found 4)
<7> [494.496835] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:108:pipe A] fastset requirement not met in pipe_bpp (expected 0, found 24)
<7> [494.496991] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:108:pipe A] fastset requirement not met in hw.pipe_mode.crtc_clock (expected 0, found 139930)
<7> [494.497145] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:108:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_clock (expected 0, found 139930)
<7> [494.497344] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:108:pipe A] fastset requirement not met in port_clock (expected 0, found 139930)
<7> [494.497500] i915 0000:00:02.0: [drm:intel_atomic_check [i915]] [CRTC:108:pipe A] fastset requirement not met, forcing full modeset
<7> [494.497706] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] Enabled dbuf slices 0x1 -> 0x3 (total dbuf slices 0x3), mbus joined? no->no
<7> [494.497875] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] [CRTC:108:pipe A] dbuf slices 0x0 -> 0x3, ddb (0 - 0) -> (0 - 2048), active pipes 0x0 -> 0x1
<7> [494.498064] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] [PLANE:33:plane 1A] ddb ( 0 - 0) -> ( 0 - 2016), size 0 -> 2016
<7> [494.498220] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] [PLANE:103:cursor A] ddb ( 0 - 0) -> (2016 - 2048), size 0 -> 32
<7> [494.498399] i915 0000:00:02.0: [drm:skl_print_plane_changes [i915]] [PLANE:33:plane 1A] level wm0, wm1, wm2, wm3, wm4, wm5, wm6, wm7, twm, swm, stwm -> *wm0,*wm1,*wm2,*wm3,*wm4,*wm5,*wm6,*wm7,*twm, swm, stwm
<7> [494.498588] i915 0000:00:02.0: [drm:skl_print_plane_changes [i915]] [PLANE:33:plane 1A] lines 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0 -> 1, 4, 4, 4, 4, 5, 7, 7, 0, 0, 0
<7> [494.498753] i915 0000:00:02.0: [drm:skl_print_plane_changes [i915]] [PLANE:33:plane 1A] blocks 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0 -> 16, 65, 65, 65, 65, 81, 113, 113, 30, 0, 0
<7> [494.498908] i915 0000:00:02.0: [drm:skl_print_plane_changes [i915]] [PLANE:33:plane 1A] min_ddb 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0 -> 19, 73, 73, 73, 73, 91, 126, 126, 31, 0, 0
<7> [494.499092] i915 0000:00:02.0: [drm:intel_bw_atomic_check [i915]] [CRTC:108:pipe A] data rate 559720 num active planes 1
<7> [494.499252] i915 0000:00:02.0: [drm:intel_bw_atomic_check [i915]] QGV point 0: max bw 14993 required 560
<7> [494.499411] i915 0000:00:02.0: [drm:intel_bw_atomic_check [i915]] No SAGV, using single QGV point mask 0x1
<7> [494.499615] i915 0000:00:02.0: [drm:intel_cdclk_atomic_check [i915]] [CRTC:108:pipe A] min cdclk: 0 kHz -> 69965 kHz
<7> [494.499823] i915 0000:00:02.0: [drm:intel_cdclk_update_dbuf_bw_min_cdclk [i915]] dbuf bandwidth min cdclk: 0 kHz -> 8746 kHz
<7> [494.499989] i915 0000:00:02.0: [drm:intel_find_dpll [i915]] [CRTC:108:pipe A] allocated DPLL 0
<7> [494.500153] i915 0000:00:02.0: [drm:intel_dpll_crtc_get [i915]] [CRTC:108:pipe A] reserving DPLL 0
<7> [494.500327] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [CRTC:108:pipe A] enable: yes [modeset]
<7> [494.500487] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] active: yes, output_types: HDMI (0x40), output format: RGB, sink format: RGB
<7> [494.500660] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] cpu_transcoder: A, pipe bpp: 24, dithering: 0
<7> [494.500841] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] MST master transcoder: <invalid>
<7> [494.501023] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] port sync: master transcoder: <invalid>, slave transcoder bitmask = 0x0
<7> [494.501187] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] joiner: no, pipes: 0x0
<7> [494.501343] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] splitter: disabled, link count 0, overlap 0
<7> [494.501507] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] audio: 0, infoframes: 0, infoframes enabled: 0x0
<7> [494.501677] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] scanline offset: 2
<7> [494.501833] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] framestart delay: 1, MSA timing delay: 0, set context latency: 0
<7> [494.502013] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] vrr: no, fixed rr: yes, vmin: 1125, vmax: 1125, flipline: 1125, pipeline full: 42, guardband: 44 vsync start: 0, vsync end: 0
<7> [494.502189] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] vrr: vmin vblank: 1081, vmax vblank: 1081, vmin vtotal: 1125, vmax vtotal: 1125
<7> [494.502353] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] requested mode: "1920x1080": 53 139930 1920 2008 2096 2360 1080 1084 1089 1125 0x48 0x5
<7> [494.502508] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] adjusted mode: "1920x1080": 53 139930 1920 2008 2096 2360 1080 1084 1089 1125 0x48 0x5
<7> [494.502691] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] crtc timings: clock=139930, hd=1920 hb=1920-2360 hs=2008-2096 ht=2360, vd=1080 vb=1080-1125 vs=1084-1089 vt=1125, flags=0x5
<7> [494.502847] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pipe mode: "1920x1080": 53 139930 1920 2008 2096 2360 1080 1084 1089 1125 0x40 0x5
<7> [494.503000] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] crtc timings: clock=139930, hd=1920 hb=1920-2360 hs=2008-2096 ht=2360, vd=1080 vb=1080-1125 vs=1084-1089 vt=1125, flags=0x5
<7> [494.503155] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] port clock: 139930, pipe src: 1920x1080+0+0, pixel rate 139930, min cdclk 69965
<7> [494.503353] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] linetime: 135, ips linetime: 0
<7> [494.503515] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] num_scalers: 2, scaler_users: 0x0, scaler_id: -1, scaling_filter: 0
<7> [494.503757] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pch pfit: 0x0+0+0, disabled, force thru: no
<7> [494.503921] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] ips: 0, double wide: 0, drrs: 0
<7> [494.504075] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] dpll_hw_state: cfgcr0: 0x4801b5, cfgcr1: 0xe84, div0: 0x0, mg_refclkin_ctl: 0x0, hg_clktop2_coreclkctl1: 0x0, mg_clktop2_hsclkctl: 0x0, mg_pll_div0: 0x0, mg_pll_div2: 0x0, mg_pll_lf: 0x0, mg_pll_frac_lock: 0x0, mg_pll_ssc: 0x0, mg_pll_bias: 0x0, mg_pll_tdc_coldst_bias: 0x0
<7> [494.504229] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] csc_mode: 0x0 gamma_mode: 0x0 gamma_enable: 0 csc_enable: 0
<7> [494.504383] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pre csc lut: 0 entries, post csc lut: 0 entries
<7> [494.504589] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] output csc: pre offsets: 0x0000 0x0000 0x0000
<7> [494.504742] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] output csc: coefficients: 0x0000 0x0000 0x0000
<7> [494.504905] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] output csc: coefficients: 0x0000 0x0000 0x0000
<7> [494.505067] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] output csc: coefficients: 0x0000 0x0000 0x0000
<7> [494.505219] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] output csc: post offsets: 0x0000 0x0000 0x0000
<7> [494.505372] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pipe csc: pre offsets: 0x0000 0x0000 0x0000
<7> [494.505525] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pipe csc: coefficients: 0x0000 0x0000 0x0000
<7> [494.505737] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pipe csc: coefficients: 0x0000 0x0000 0x0000
<7> [494.505896] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pipe csc: coefficients: 0x0000 0x0000 0x0000
<7> [494.506062] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pipe csc: post offsets: 0x0000 0x0000 0x0000
<7> [494.506229] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:33:plane 1A] fb: [FB:390] 1920x1080 format = XR24 little-endian (0x34325258) modifier = 0x100000000000001, visible: yes
<7> [494.506386] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] rotation: 0x1, scaler: -1, scaling_filter: 0
<7> [494.506541] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] src: 1920.000000x1080.000000+0.000000+0.000000 dst: 1920x1080+0+0
<7> [494.506718] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:43:plane 2A] fb: [NOFB], visible: no
<7> [494.506921] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:53:plane 3A] fb: [NOFB], visible: no
<7> [494.507082] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:63:plane 4A] fb: [NOFB], visible: no
<7> [494.507245] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:73:plane 5A] fb: [NOFB], visible: no
<7> [494.507399] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:83:plane 6A] fb: [NOFB], visible: no
<7> [494.507562] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:93:plane 7A] fb: [NOFB], visible: no
<7> [494.507755] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:103:cursor A] fb: [NOFB], visible: no
<7> [494.508527] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:341:DDI B/PHY B]
<7> [494.508742] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:351:DDI TC1/PHY TC1]
<7> [494.508905] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:353:DP-MST A]
<7> [494.509064] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:354:DP-MST B]
<7> [494.509239] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:355:DP-MST C]
<7> [494.509426] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:356:DP-MST D]
<7> [494.509598] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:361:DDI TC2/PHY TC2]
<7> [494.509756] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:363:DP-MST A]
<7> [494.509921] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:364:DP-MST B]
<7> [494.510076] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:365:DP-MST C]
<7> [494.510232] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:366:DP-MST D]
<7> [494.510409] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:370:DDI TC3/PHY TC3]
<7> [494.510599] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:372:DP-MST A]
<7> [494.510763] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:373:DP-MST B]
<7> [494.510915] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:374:DP-MST C]
<7> [494.511078] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:375:DP-MST D]
<7> [494.511232] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:379:DDI TC4/PHY TC4]
<7> [494.511389] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:381:DP-MST A]
<7> [494.511596] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:382:DP-MST B]
<7> [494.511763] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:383:DP-MST C]
<7> [494.511927] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:384:DP-MST D]
<7> [494.512218] i915 0000:00:02.0: [drm:gen9_dbuf_slices_update [i915]] Updating dbuf slices to 0x3
<7> [494.512473] i915 0000:00:02.0: [drm:intel_dpll_enable [i915]] enable DPLL 0 (active 0x1, on? 0) for [CRTC:108:pipe A]
<7> [494.512650] i915 0000:00:02.0: [drm:intel_dpll_enable [i915]] enabling DPLL 0
<7> [494.512921] i915 0000:00:02.0: [drm:intel_power_well_enable [i915]] enabling DDI_IO_B
<7> [494.513128] i915 0000:00:02.0: [drm:intel_enable_transcoder [i915]] enabling pipe A
<7> [494.515573] i915 0000:00:02.0: [drm:intel_fbc_update [i915]] reserved 17694720 bytes of contiguous stolen space for FBC, limit: 1
<7> [494.515783] i915 0000:00:02.0: [drm:intel_fbc_update [i915]] Enabling FBC on [PLANE:33:plane 1A]
<7> [494.532737] i915 0000:00:02.0: [drm:verify_connector_state [i915]] [CONNECTOR:342:HDMI-A-1]
<7> [494.533009] i915 0000:00:02.0: [drm:intel_modeset_verify_crtc [i915]] [CRTC:108:pipe A]
<7> [494.591818] i915 0000:00:02.0: [drm:intel_power_well_disable [i915]] disabling DC_off
<7> [494.592272] i915 0000:00:02.0: [drm:skl_enable_dc6 [i915]] Enabling DC6
<7> [494.592708] i915 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [i915]] Setting DC state from 00 to 02
<7> [494.857464] i915 0000:00:02.0: [drm:intel_power_well_enable [i915]] enabling DC_off
<7> [494.858004] i915 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [i915]] Setting DC state from 02 to 00
<7> [494.892040] i915 0000:00:02.0: [drm:intel_power_well_disable [i915]] disabling DC_off
<7> [494.892493] i915 0000:00:02.0: [drm:skl_enable_dc6 [i915]] Enabling DC6
<7> [494.892925] i915 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [i915]] Setting DC state from 00 to 02
<7> [495.440361] i915 0000:00:02.0: [drm:intel_tc_port_reset_mode [i915]] Port G/TC#4: TC port mode reset (tbt-alt -> disconnected) pin assignment: - max lanes: 4
<7> [495.440381] i915 0000:00:02.0: [drm:intel_tc_port_reset_mode [i915]] Port F/TC#3: TC port mode reset (tbt-alt -> disconnected) pin assignment: - max lanes: 4
<7> [495.440435] i915 0000:00:02.0: [drm:intel_tc_port_reset_mode [i915]] Port E/TC#2: TC port mode reset (tbt-alt -> disconnected) pin assignment: - max lanes: 4
<7> [495.440477] i915 0000:00:02.0: [drm:intel_power_well_disable [i915]] disabling TC_cold_off
<7> [495.440960] i915 0000:00:02.0: [drm:tgl_tc_cold_request [i915]] TC cold unblock succeeded
<7> [495.441519] i915 0000:00:02.0: [drm:intel_tc_port_reset_mode [i915]] Port D/TC#1: TC port mode reset (legacy -> disconnected) pin assignment: - max lanes: 4
<7> [505.760059] i915 0000:00:02.0: [drm:drm_mode_setcrtc] [CRTC:108:pipe A]
<7> [505.760312] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:108:pipe A] fastset requirement not met in hw.enable (expected yes, found no)
<7> [505.760863] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:108:pipe A] fastset requirement not met in hw.active (expected yes, found no)
<7> [505.761506] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:108:pipe A] fastset requirement not met in cpu_transcoder (expected 0, found -1)
<7> [505.762186] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:108:pipe A] fastset requirement not met in lane_count (expected 4, found 0)
<7> [505.762814] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:108:pipe A] fastset requirement not met in output_types (expected 0x00000040, found 0x00000000)
<7> [505.763479] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:108:pipe A] fastset requirement not met in framestart_delay (expected 1, found 0)
<7> [505.763974] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:108:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hdisplay (expected 1920, found 0)
<7> [505.764402] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:108:pipe A] fastset requirement not met in hw.pipe_mode.crtc_htotal (expected 2360, found 0)
<7> [505.764826] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:108:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hblank_start (expected 1920, found 0)
<7> [505.765311] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:108:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hblank_end (expected 2360, found 0)
<7> [505.765739] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:108:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hsync_start (expected 2008, found 0)
<7> [505.766196] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:108:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hsync_end (expected 2096, found 0)
<7> [505.766361] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:108:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vdisplay (expected 1080, found 0)
<7> [505.766516] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:108:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vblank_start (expected 1080, found 0)
<7> [505.766672] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:108:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vsync_start (expected 1084, found 0)
<7> [505.766828] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:108:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vsync_end (expected 1089, found 0)
<7> [505.766999] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:108:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vtotal (expected 1125, found 0)
<7> [505.767154] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:108:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vblank_end (expected 1125, found 0)
<7> [505.767310] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:108:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hdisplay (expected 1920, found 0)
<7> [505.767466] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:108:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_htotal (expected 2360, found 0)
<7> [505.767621] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:108:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hblank_start (expected 1920, found 0)
<7> [505.767775] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:108:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hblank_end (expected 2360, found 0)
<7> [505.767931] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:108:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hsync_start (expected 2008, found 0)
<7> [505.768103] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:108:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hsync_end (expected 2096, found 0)
<7> [505.768259] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:108:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vdisplay (expected 1080, found 0)
<7> [505.768413] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:108:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vblank_start (expected 1080, found 0)
<7> [505.768566] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:108:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vsync_start (expected 1084, found 0)
<7> [505.768720] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:108:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vsync_end (expected 1089, found 0)
<7> [505.768874] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:108:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vtotal (expected 1125, found 0)
<7> [505.769044] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:108:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vblank_end (expected 1125, found 0)
<7> [505.769198] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:108:pipe A] fastset requirement not met in pixel_multiplier (expected 1, found 0)
<7> [505.769352] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:108:pipe A] fastset requirement not met in hw.adjusted_mode.flags (1) (expected 1, found 0)
<7> [505.769506] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:108:pipe A] fastset requirement not met in hw.adjusted_mode.flags (4) (expected 4, found 0)
<7> [505.769662] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:108:pipe A] fastset requirement not met in pipe_bpp (expected 24, found 0)
<7> [505.769816] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:108:pipe A] fastset requirement not met in hw.pipe_mode.crtc_clock (expected 139930, found 0)
<7> [505.769971] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:108:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_clock (expected 139930, found 0)
<7> [505.770148] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:108:pipe A] fastset requirement not met in port_clock (expected 139930, found 0)
<7> [505.770304] i915 0000:00:02.0: [drm:intel_atomic_check [i915]] [CRTC:108:pipe A] fastset requirement not met, forcing full modeset
<7> [505.770460] i915 0000:00:02.0: [drm:intel_dpll_crtc_put [i915]] [CRTC:108:pipe A] releasing DPLL 0
<7> [505.770649] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] Enabled dbuf slices 0x3 -> 0x1 (total dbuf slices 0x3), mbus joined? no->no
<7> [505.770808] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] [CRTC:108:pipe A] dbuf slices 0x3 -> 0x0, ddb (0 - 2048) -> (0 - 0), active pipes 0x1 -> 0x0
<7> [505.771002] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] [PLANE:33:plane 1A] ddb ( 0 - 2016) -> ( 0 - 0), size 2016 -> 0
<7> [505.771176] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] [PLANE:103:cursor A] ddb (2016 - 2048) -> ( 0 - 0), size 32 -> 0
<7> [505.771333] i915 0000:00:02.0: [drm:skl_print_plane_changes [i915]] [PLANE:33:plane 1A] level *wm0,*wm1,*wm2,*wm3,*wm4,*wm5,*wm6,*wm7,*twm, swm, stwm -> wm0, wm1, wm2, wm3, wm4, wm5, wm6, wm7, twm, swm, stwm
<7> [505.771488] i915 0000:00:02.0: [drm:skl_print_plane_changes [i915]] [PLANE:33:plane 1A] lines 1, 4, 4, 4, 4, 5, 7, 7, 0, 0, 0 -> 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0
<7> [505.771643] i915 0000:00:02.0: [drm:skl_print_plane_changes [i915]] [PLANE:33:plane 1A] blocks 16, 65, 65, 65, 65, 81, 113, 113, 30, 0, 0 -> 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0
<7> [505.771801] i915 0000:00:02.0: [drm:skl_print_plane_changes [i915]] [PLANE:33:plane 1A] min_ddb 19, 73, 73, 73, 73, 91, 126, 126, 31, 0, 0 -> 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0
<7> [505.771980] i915 0000:00:02.0: [drm:intel_bw_atomic_check [i915]] [CRTC:108:pipe A] data rate 0 num active planes 0
<7> [505.772158] i915 0000:00:02.0: [drm:intel_bw_atomic_check [i915]] QGV point 0: max bw 14993 required 0
<7> [505.772334] i915 0000:00:02.0: [drm:intel_cdclk_atomic_check [i915]] [CRTC:108:pipe A] min cdclk: 69965 kHz -> 0 kHz
<7> [505.772510] i915 0000:00:02.0: [drm:intel_cdclk_update_dbuf_bw_min_cdclk [i915]] dbuf bandwidth min cdclk: 8746 kHz -> 0 kHz
<7> [505.772671] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [CRTC:108:pipe A] enable: no [modeset]
<7> [505.772831] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:33:plane 1A] fb: [NOFB], visible: no
<7> [505.772989] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:43:plane 2A] fb: [NOFB], visible: no
<7> [505.773165] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:53:plane 3A] fb: [NOFB], visible: no
<7> [505.773323] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:63:plane 4A] fb: [NOFB], visible: no
<7> [505.773480] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:73:plane 5A] fb: [NOFB], visible: no
<7> [505.773635] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:83:plane 6A] fb: [NOFB], visible: no
<7> [505.773790] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:93:plane 7A] fb: [NOFB], visible: no
<7> [505.773945] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:103:cursor A] fb: [NOFB], visible: no
<7> [505.774173] i915 0000:00:02.0: [drm:intel_power_well_enable [i915]] enabling DC_off
<7> [505.774339] i915 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [i915]] Setting DC state from 02 to 00
<7> [505.786201] i915 0000:00:02.0: [drm:intel_disable_transcoder [i915]] disabling pipe A
<7> [505.803829] i915 0000:00:02.0: [drm:intel_power_well_disable [i915]] disabling DDI_IO_B
<7> [505.804287] i915 0000:00:02.0: [drm:intel_dpll_disable [i915]] disable DPLL 0 (active 0x1, on? 1) for [CRTC:108:pipe A]
<7> [505.804706] i915 0000:00:02.0: [drm:intel_dpll_disable [i915]] disabling DPLL 0
<7> [505.805149] i915 0000:00:02.0: [drm:__intel_fbc_disable [i915]] Disabling FBC on [PLANE:33:plane 1A]
<7> [505.805700] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:341:DDI B/PHY B]
<7> [505.806358] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:351:DDI TC1/PHY TC1]
<7> [505.806904] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:353:DP-MST A]
<7> [505.807355] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:354:DP-MST B]
<7> [505.807706] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:355:DP-MST C]
<7> [505.808147] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:356:DP-MST D]
<7> [505.808662] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:361:DDI TC2/PHY TC2]
<7> [505.809219] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:363:DP-MST A]
<7> [505.809726] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:364:DP-MST B]
<7> [505.810260] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:365:DP-MST C]
<7> [505.810609] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:366:DP-MST D]
<7> [505.811014] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:370:DDI TC3/PHY TC3]
<7> [505.811499] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:372:DP-MST A]
<7> [505.811915] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:373:DP-MST B]
<7> [505.812377] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:374:DP-MST C]
<7> [505.812762] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:375:DP-MST D]
<7> [505.813068] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:379:DDI TC4/PHY TC4]
<7> [505.813350] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:381:DP-MST A]
<7> [505.813748] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:382:DP-MST B]
<7> [505.814190] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:383:DP-MST C]
<7> [505.814533] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:384:DP-MST D]
<7> [505.814856] i915 0000:00:02.0: [drm:verify_connector_state [i915]] [CONNECTOR:342:HDMI-A-1]
<7> [505.815360] i915 0000:00:02.0: [drm:gen9_dbuf_slices_update [i915]] Updating dbuf slices to 0x1
<7> [505.815753] i915 0000:00:02.0: [drm:intel_modeset_verify_crtc [i915]] [CRTC:108:pipe A]
<7> [505.816962] i915 0000:00:02.0: [drm:drm_mode_setcrtc] [CRTC:185:pipe B]
<7> [505.817242] i915 0000:00:02.0: [drm:drm_mode_setcrtc] [CRTC:262:pipe C]
<7> [505.817419] i915 0000:00:02.0: [drm:drm_mode_setcrtc] [CRTC:339:pipe D]
<7> [505.817558] i915 0000:00:02.0: [drm:drm_mode_setcrtc] [CRTC:108:pipe A]
<7> [505.817592] i915 0000:00:02.0: [drm:drm_mode_setcrtc] [CONNECTOR:342:HDMI-A-1]
<7> [505.817658] i915 0000:00:02.0: [drm:intel_atomic_check [i915]] [CONNECTOR:342:HDMI-A-1] Limiting display bpp to 24 (EDID bpp 24, max requested bpp 36, max platform bpp 36)
<7> [505.817843] i915 0000:00:02.0: [drm:intel_hdmi_compute_clock [i915]] picking 8 bpc for HDMI output (pipe bpp: 24)
<7> [505.818004] i915 0000:00:02.0: [drm:intel_atomic_check [i915]] [CRTC:108:pipe A] hw max bpp: 24, pipe bpp: 24, dithering: 0
<7> [505.818200] i915 0000:00:02.0: [drm:intel_ddi_compute_config_late [i915]] [ENCODER:341:DDI B/PHY B] [CRTC:108:pipe A]
<7> [505.818366] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:108:pipe A] fastset requirement not met in hw.enable (expected no, found yes)
<7> [505.818536] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:108:pipe A] fastset requirement not met in hw.active (expected no, found yes)
<7> [505.818705] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:108:pipe A] fastset requirement not met in cpu_transcoder (expected -1, found 0)
<7> [505.818876] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:108:pipe A] fastset requirement not met in lane_count (expected 0, found 4)
<7> [505.819047] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:108:pipe A] fastset requirement not met in output_types (expected 0x00000000, found 0x00000040)
<7> [505.819253] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:108:pipe A] fastset requirement not met in framestart_delay (expected 0, found 1)
<7> [505.819420] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:108:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hdisplay (expected 0, found 1920)
<7> [505.819587] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:108:pipe A] fastset requirement not met in hw.pipe_mode.crtc_htotal (expected 0, found 2360)
<7> [505.819752] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:108:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hblank_start (expected 0, found 1920)
<7> [505.819917] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:108:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hblank_end (expected 0, found 2360)
<7> [505.820084] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:108:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hsync_start (expected 0, found 2008)
<7> [505.820274] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:108:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hsync_end (expected 0, found 2096)
<7> [505.820438] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:108:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vdisplay (expected 0, found 1080)
<7> [505.820594] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:108:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vblank_start (expected 0, found 1080)
<7> [505.820751] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:108:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vsync_start (expected 0, found 1084)
<7> [505.820970] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:108:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vsync_end (expected 0, found 1089)
<7> [505.821141] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:108:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vtotal (expected 0, found 1125)
<7> [505.821306] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:108:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vblank_end (expected 0, found 1125)
<7> [505.821467] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:108:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hdisplay (expected 0, found 1920)
<7> [505.821629] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:108:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_htotal (expected 0, found 2360)
<7> [505.821784] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:108:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hblank_start (expected 0, found 1920)
<7> [505.821939] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:108:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hblank_end (expected 0, found 2360)
<7> [505.822137] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:108:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hsync_start (expected 0, found 2008)
<7> [505.822313] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:108:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hsync_end (expected 0, found 2096)
<7> [505.822478] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:108:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vdisplay (expected 0, found 1080)
<7> [505.822641] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:108:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vblank_start (expected 0, found 1080)
<7> [505.822797] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:108:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vsync_start (expected 0, found 1084)
<7> [505.822951] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:108:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vsync_end (expected 0, found 1089)
<7> [505.823105] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:108:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vtotal (expected 0, found 1125)
<7> [505.823327] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:108:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vblank_end (expected 0, found 1125)
<7> [505.823483] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:108:pipe A] fastset requirement not met in pixel_multiplier (expected 0, found 1)
<7> [505.823648] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:108:pipe A] fastset requirement not met in hw.adjusted_mode.flags (1) (expected 0, found 1)
<7> [505.823812] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:108:pipe A] fastset requirement not met in hw.adjusted_mode.flags (4) (expected 0, found 4)
<7> [505.823969] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:108:pipe A] fastset requirement not met in pipe_bpp (expected 0, found 24)
<7> [505.824124] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:108:pipe A] fastset requirement not met in hw.pipe_mode.crtc_clock (expected 0, found 139930)
<7> [505.824295] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:108:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_clock (expected 0, found 139930)
<7> [505.824459] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:108:pipe A] fastset requirement not met in port_clock (expected 0, found 139930)
<7> [505.824660] i915 0000:00:02.0: [drm:intel_atomic_check [i915]] [CRTC:108:pipe A] fastset requirement not met, forcing full modeset
<7> [505.824860] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] Enabled dbuf slices 0x1 -> 0x3 (total dbuf slices 0x3), mbus joined? no->no
<7> [505.825023] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] [CRTC:108:pipe A] dbuf slices 0x0 -> 0x3, ddb (0 - 0) -> (0 - 2048), active pipes 0x0 -> 0x1
<7> [505.825250] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] [PLANE:33:plane 1A] ddb ( 0 - 0) -> ( 0 - 2016), size 0 -> 2016
<7> [505.825408] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] [PLANE:103:cursor A] ddb ( 0 - 0) -> (2016 - 2048), size 0 -> 32
<7> [505.825564] i915 0000:00:02.0: [drm:skl_print_plane_changes [i915]] [PLANE:33:plane 1A] level wm0, wm1, wm2, wm3, wm4, wm5, wm6, wm7, twm, swm, stwm -> *wm0,*wm1,*wm2,*wm3,*wm4,*wm5,*wm6,*wm7,*twm, swm, stwm
<7> [505.825748] i915 0000:00:02.0: [drm:skl_print_plane_changes [i915]] [PLANE:33:plane 1A] lines 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0 -> 1, 4, 4, 4, 4, 5, 7, 7, 0, 0, 0
<7> [505.825919] i915 0000:00:02.0: [drm:skl_print_plane_changes [i915]] [PLANE:33:plane 1A] blocks 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0 -> 16, 65, 65, 65, 65, 81, 113, 113, 30, 0, 0
<7> [505.826084] i915 0000:00:02.0: [drm:skl_print_plane_changes [i915]] [PLANE:33:plane 1A] min_ddb 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0 -> 19, 73, 73, 73, 73, 91, 126, 126, 31, 0, 0
<7> [505.826275] i915 0000:00:02.0: [drm:intel_bw_atomic_check [i915]] [CRTC:108:pipe A] data rate 559720 num active planes 1
<7> [505.826442] i915 0000:00:02.0: [drm:intel_bw_atomic_check [i915]] QGV point 0: max bw 14993 required 560
<7> [505.826601] i915 0000:00:02.0: [drm:intel_bw_atomic_check [i915]] No SAGV, using single QGV point mask 0x1
<7> [505.826784] i915 0000:00:02.0: [drm:intel_cdclk_atomic_check [i915]] [CRTC:108:pipe A] min cdclk: 0 kHz -> 69965 kHz
<7> [505.827006] i915 0000:00:02.0: [drm:intel_cdclk_update_dbuf_bw_min_cdclk [i915]] dbuf bandwidth min cdclk: 0 kHz -> 8746 kHz
<7> [505.827166] i915 0000:00:02.0: [drm:intel_find_dpll [i915]] [CRTC:108:pipe A] allocated DPLL 0
<7> [505.827388] i915 0000:00:02.0: [drm:intel_dpll_crtc_get [i915]] [CRTC:108:pipe A] reserving DPLL 0
<7> [505.827563] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [CRTC:108:pipe A] enable: yes [modeset]
<7> [505.827723] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] active: yes, output_types: HDMI (0x40), output format: RGB, sink format: RGB
<7> [505.827882] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] cpu_transcoder: A, pipe bpp: 24, dithering: 0
<7> [505.828060] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] MST master transcoder: <invalid>
<7> [505.828250] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] port sync: master transcoder: <invalid>, slave transcoder bitmask = 0x0
<7> [505.828455] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] joiner: no, pipes: 0x0
<7> [505.828611] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] splitter: disabled, link count 0, overlap 0
<7> [505.828777] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] audio: 0, infoframes: 0, infoframes enabled: 0x0
<7> [505.828933] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] scanline offset: 2
<7> [505.829087] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] framestart delay: 1, MSA timing delay: 0, set context latency: 0
<7> [505.829268] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] vrr: no, fixed rr: yes, vmin: 1125, vmax: 1125, flipline: 1125, pipeline full: 42, guardband: 44 vsync start: 0, vsync end: 0
<7> [505.829461] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] vrr: vmin vblank: 1081, vmax vblank: 1081, vmin vtotal: 1125, vmax vtotal: 1125
<7> [505.829617] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] requested mode: "1920x1080": 53 139930 1920 2008 2096 2360 1080 1084 1089 1125 0x48 0x5
<7> [505.829772] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] adjusted mode: "1920x1080": 53 139930 1920 2008 2096 2360 1080 1084 1089 1125 0x48 0x5
<7> [505.829928] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] crtc timings: clock=139930, hd=1920 hb=1920-2360 hs=2008-2096 ht=2360, vd=1080 vb=1080-1125 vs=1084-1089 vt=1125, flags=0x5
<7> [505.830083] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pipe mode: "1920x1080": 53 139930 1920 2008 2096 2360 1080 1084 1089 1125 0x40 0x5
<7> [505.830237] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] crtc timings: clock=139930, hd=1920 hb=1920-2360 hs=2008-2096 ht=2360, vd=1080 vb=1080-1125 vs=1084-1089 vt=1125, flags=0x5
<7> [505.830407] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] port clock: 139930, pipe src: 1920x1080+0+0, pixel rate 139930, min cdclk 69965
<7> [505.830562] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] linetime: 135, ips linetime: 0
<7> [505.830716] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] num_scalers: 2, scaler_users: 0x0, scaler_id: -1, scaling_filter: 0
<7> [505.830870] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pch pfit: 0x0+0+0, disabled, force thru: no
<7> [505.831023] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] ips: 0, double wide: 0, drrs: 0
<7> [505.831177] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] dpll_hw_state: cfgcr0: 0x4801b5, cfgcr1: 0xe84, div0: 0x0, mg_refclkin_ctl: 0x0, hg_clktop2_coreclkctl1: 0x0, mg_clktop2_hsclkctl: 0x0, mg_pll_div0: 0x0, mg_pll_div2: 0x0, mg_pll_lf: 0x0, mg_pll_frac_lock: 0x0, mg_pll_ssc: 0x0, mg_pll_bias: 0x0, mg_pll_tdc_coldst_bias: 0x0
<7> [505.831334] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] csc_mode: 0x0 gamma_mode: 0x0 gamma_enable: 0 csc_enable: 0
<7> [505.831503] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pre csc lut: 0 entries, post csc lut: 0 entries
<7> [505.831658] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] output csc: pre offsets: 0x0000 0x0000 0x0000
<7> [505.831811] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] output csc: coefficients: 0x0000 0x0000 0x0000
<7> [505.831964] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] output csc: coefficients: 0x0000 0x0000 0x0000
<7> [505.832126] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] output csc: coefficients: 0x0000 0x0000 0x0000
<7> [505.832288] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] output csc: post offsets: 0x0000 0x0000 0x0000
<7> [505.832464] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pipe csc: pre offsets: 0x0000 0x0000 0x0000
<7> [505.832617] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pipe csc: coefficients: 0x0000 0x0000 0x0000
<7> [505.832770] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pipe csc: coefficients: 0x0000 0x0000 0x0000
<7> [505.832923] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pipe csc: coefficients: 0x0000 0x0000 0x0000
<7> [505.833105] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pipe csc: post offsets: 0x0000 0x0000 0x0000
<7> [505.833287] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:33:plane 1A] fb: [FB:390] 1920x1080 format = XR24 little-endian (0x34325258) modifier = 0x100000000000001, visible: yes
<7> [505.833459] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] rotation: 0x1, scaler: -1, scaling_filter: 0
<7> [505.833612] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] src: 1920.000000x1080.000000+0.000000+0.000000 dst: 1920x1080+0+0
<7> [505.833765] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:43:plane 2A] fb: [NOFB], visible: no
<7> [505.833918] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:53:plane 3A] fb: [NOFB], visible: no
<7> [505.834080] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:63:plane 4A] fb: [NOFB], visible: no
<7> [505.834232] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:73:plane 5A] fb: [NOFB], visible: no
<7> [505.834398] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:83:plane 6A] fb: [NOFB], visible: no
<7> [505.834567] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:93:plane 7A] fb: [NOFB], visible: no
<7> [505.834719] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:103:cursor A] fb: [NOFB], visible: no
<7> [505.834976] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:341:DDI B/PHY B]
<7> [505.835191] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:351:DDI TC1/PHY TC1]
<7> [505.835353] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:353:DP-MST A]
<7> [505.835531] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:354:DP-MST B]
<7> [505.835700] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:355:DP-MST C]
<7> [505.835857] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:356:DP-MST D]
<7> [505.836013] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:361:DDI TC2/PHY TC2]
<7> [505.836170] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:363:DP-MST A]
<7> [505.836367] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:364:DP-MST B]
<7> [505.836535] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:365:DP-MST C]
<7> [505.836699] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:366:DP-MST D]
<7> [505.836860] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:370:DDI TC3/PHY TC3]
<7> [505.837013] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:372:DP-MST A]
<7> [505.837168] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:373:DP-MST B]
<7> [505.837326] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:374:DP-MST C]
<7> [505.837528] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:375:DP-MST D]
<7> [505.837681] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:379:DDI TC4/PHY TC4]
<7> [505.837843] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:381:DP-MST A]
<7> [505.838005] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:382:DP-MST B]
<7> [505.838158] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:383:DP-MST C]
<7> [505.838318] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:384:DP-MST D]
<7> [505.838666] i915 0000:00:02.0: [drm:gen9_dbuf_slices_update [i915]] Updating dbuf slices to 0x3
<7> [505.838928] i915 0000:00:02.0: [drm:intel_dpll_enable [i915]] enable DPLL 0 (active 0x1, on? 0) for [CRTC:108:pipe A]
<7> [505.839095] i915 0000:00:02.0: [drm:intel_dpll_enable [i915]] enabling DPLL 0
<7> [505.839326] i915 0000:00:02.0: [drm:intel_power_well_enable [i915]] enabling DDI_IO_B
<7> [505.839539] i915 0000:00:02.0: [drm:intel_enable_transcoder [i915]] enabling pipe A
<7> [505.841583] i915 0000:00:02.0: [drm:intel_fbc_update [i915]] reserved 17694720 bytes of contiguous stolen space for FBC, limit: 1
<7> [505.841752] i915 0000:00:02.0: [drm:intel_fbc_update [i915]] Enabling FBC on [PLANE:33:plane 1A]
<7> [505.859260] i915 0000:00:02.0: [drm:verify_connector_state [i915]] [CONNECTOR:342:HDMI-A-1]
<7> [505.859526] i915 0000:00:02.0: [drm:intel_modeset_verify_crtc [i915]] [CRTC:108:pipe A]
<7> [505.919576] i915 0000:00:02.0: [drm:intel_power_well_disable [i915]] disabling DC_off
<7> [505.920027] i915 0000:00:02.0: [drm:skl_enable_dc6 [i915]] Enabling DC6
<7> [505.920476] i915 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [i915]] Setting DC state from 00 to 02
<7> [506.182688] i915 0000:00:02.0: [drm:intel_power_well_enable [i915]] enabling DC_off
<7> [506.183215] i915 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [i915]] Setting DC state from 02 to 00
<7> [506.218876] i915 0000:00:02.0: [drm:intel_power_well_disable [i915]] disabling DC_off
<7> [506.219329] i915 0000:00:02.0: [drm:skl_enable_dc6 [i915]] Enabling DC6
<7> [506.219741] i915 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [i915]] Setting DC state from 00 to 02
<6> [514.178239] [IGT] kms_flip: finished subtest A-HDMI-A1, FAIL
Created at 2025-10-28 09:51:28