Results for igt@kms_flip@flip-vs-blocking-wf-vblank

Machine description: shard-rkl-2

Result: Fail

git-log-oneline i915_display_info8 igt_runner8 run8 runtimes8 results8.json i915_display_info_post_exec8 boot8 dmesg8

DetailValue
Duration 15.88 seconds
Hostname 
shard-rkl-2
Igt-Version 
IGT-Version: 1.29-NO-GIT (x86_64) (Linux: 6.12.0-rc6-CI_DRM_15627-g0a6cc4357ae4+ x86_64)
Out 
Using IGT_SRANDOM=1730780462 for randomisation
Opened device: /dev/dri/card0
Using monotonic timestamps
Starting subtest: flip-vs-blocking-wf-vblank
Starting dynamic subtest: A-HDMI-A1
  1920x1080: 53 139930 1920 2008 2096 2360 1080 1084 1089 1125 0x48 0x5 
Expected frametime: 18974us; measured 18973.4us +- 6.541us accuracy 0.10%
Stack trace:
  #0 ../lib/igt_core.c:2051 __igt_fail_assert()
  #1 ../tests/kms_flip.c:791 run_test_on_crtc_set.constprop.0()
  #2 ../tests/kms_flip.c:1845 run_test()
  #3 ../tests/kms_flip.c:2078 __igt_unique____real_main2001()
  #4 ../tests/kms_flip.c:2001 main()
  #5 [__libc_init_first+0x8a]
  #6 [__libc_start_main+0x8b]
  #7 [_start+0x25]
Dynamic subtest A-HDMI-A1: FAIL (7.840s)
Starting dynamic subtest: B-HDMI-A1
  1920x1080: 53 139930 1920 2008 2096 2360 1080 1084 1089 1125 0x48 0x5 
Expected frametime: 18974us; measured 19178.0us +- 2.556us accuracy 0.04%
vblank interval differs from modeline! expected 18973.8us, measured 19178us +- 2.556us, difference 204.2us (79.9 sigma)
Stack trace:
  #0 ../lib/igt_core.c:2051 __igt_fail_assert()
  #1 ../tests/kms_flip.c:791 run_test_on_crtc_set.constprop.0()
  #2 ../tests/kms_flip.c:1845 run_test()
  #3 ../tests/kms_flip.c:2078 __igt_unique____real_main2001()
  #4 ../tests/kms_flip.c:2001 main()
  #5 [__libc_init_first+0x8a]
  #6 [__libc_start_main+0x8b]
  #7 [_start+0x25]
Dynamic subtest B-HDMI-A1: FAIL (8.032s)
Subtest flip-vs-blocking-wf-vblank: FAIL (15.875s)
Stack trace:
  #0 ../lib/igt_core.c:2051 __igt_fail_assert()
  #1 ../lib/igt_kms.c:2234 kmstest_set_connector_dpms()
  #2 ../lib/igt_core.c:2930 igt_atexit_handler()
  #3 [erand48_r+0x1d6]
  #4 [exit+0x1e]
  #5 ../lib/igt_core.c:2386 igt_exit()
  #6 [main+0x3f]
  #7 [__libc_init_first+0x8a]
  #8 [__libc_start_main+0x8b]
  #9 [_start+0x25]
Err 
Starting subtest: flip-vs-blocking-wf-vblank
Starting dynamic subtest: A-HDMI-A1
(kms_flip:1227) CRITICAL: Test assertion failure function __run_test_on_crtc_set, file ../tests/kms_flip.c:1674:
(kms_flip:1227) CRITICAL: Failed assertion: !retried && needs_retry_after_link_reset(mon)
Dynamic subtest A-HDMI-A1 failed.
**** DEBUG ****
(kms_flip:1227) igt_fb-DEBUG: igt_create_fb_with_bo_size(width=1920, height=1080, format=XR24(0x34325258), modifier=0x0, size=0)
(kms_flip:1227) igt_fb-DEBUG: igt_create_fb_with_bo_size(handle=1, pitch=7680)
(kms_flip:1227) ioctl_wrappers-DEBUG: Test requirement passed: igt_has_fb_modifiers(fd)
(kms_flip:1227) igt_fb-DEBUG: igt_create_fb_with_bo_size(width=1920, height=1080, format=XR24(0x34325258), modifier=0x0, size=0)
(kms_flip:1227) igt_fb-DEBUG: igt_create_fb_with_bo_size(handle=2, pitch=7680)
(kms_flip:1227) ioctl_wrappers-DEBUG: Test requirement passed: igt_has_fb_modifiers(fd)
(kms_flip:1227) intel_blt-DEBUG: Test requirement passed: cmds_info
(kms_flip:1227) intel_blt-DEBUG: Test requirement passed: cmds_info
(kms_flip:1227) igt_fb-DEBUG: Test requirement passed: cairo_surface_status(fb->cairo_surface) == CAIRO_STATUS_SUCCESS
(kms_flip:1227) intel_blt-DEBUG: Test requirement passed: cmds_info
(kms_flip:1227) intel_blt-DEBUG: Test requirement passed: cmds_info
(kms_flip:1227) igt_fb-DEBUG: Test requirement passed: cairo_surface_status(fb->cairo_surface) == CAIRO_STATUS_SUCCESS
(kms_flip:1227) igt_kms-INFO:   1920x1080: 53 139930 1920 2008 2096 2360 1080 1084 1089 1125 0x48 0x5 
(kms_flip:1227) DEBUG: No stale events found
(kms_flip:1227) i915/intel_drrs-DEBUG: Manually disabling DRRS. 0
(kms_flip:1227) i915/intel_drrs-DEBUG: Test requirement passed: dir >= 0
(kms_flip:1227) INFO: Expected frametime: 18974us; measured 18973.4us +- 6.541us accuracy 0.10%
(kms_flip:1227) DEBUG: name = flip
last_ts = 0.000000
last_received_ts = 0.000000
last_seq = 0
current_ts = 45.403927
current_received_ts = 45.574032
current_seq = 215
count = 0
seq_step = 1
(kms_flip:1227) DEBUG: name = vblank
last_ts = 0.000000
last_received_ts = 0.000000
last_seq = 0
current_ts = 45.574684
current_received_ts = 45.573990
current_seq = 224
count = 0
seq_step = 10
(kms_flip:1227) DEBUG: name = flip
last_ts = 45.403927
last_received_ts = 45.574032
last_seq = 215
current_ts = 45.593658
current_received_ts = 45.763748
current_seq = 225
count = 1
seq_step = 1
(kms_flip:1227) DEBUG: flip ts/seq: last 45.403927/215, current 45.593658/225: elapsed=189733.0us expected=189733.7us +- 948.7us, error 0.0%
(kms_flip:1227) DEBUG: name = vblank
last_ts = 45.574684
last_received_ts = 45.573990
last_seq = 224
current_ts = 45.764423
current_received_ts = 45.763721
current_seq = 234
count = 1
seq_step = 10
(kms_flip:1227) DEBUG: vblank ts/seq: last 45.574684/224, current 45.764423/234: elapsed=189737.0us expected=189733.7us +- 948.7us, error 0.0%
(kms_flip:1227) DEBUG: name = flip
last_ts = 45.593658
last_received_ts = 45.763748
last_seq = 225
current_ts = 45.783398
current_received_ts = 45.953484
current_seq = 235
count = 2
seq_step = 1
(kms_flip:1227) DEBUG: flip ts/seq: last 45.593658/225, current 45.783398/235: elapsed=189738.0us expected=189733.7us +- 948.7us, error 0.0%
(kms_flip:1227) DEBUG: name = vblank
last_ts = 45.764423
last_received_ts = 45.763721
last_seq = 234
current_ts = 45.954163
current_received_ts = 45.953457
current_seq = 244
count = 2
seq_step = 10
(kms_flip:1227) DEBUG: vblank ts/seq: last 45.764423/234, current 45.954163/244: elapsed=189738.0us expected=189733.7us +- 948.7us, error 0.0%
(kms_flip:1227) DEBUG: name = flip
last_ts = 45.783398
last_received_ts = 45.953484
last_seq = 235
current_ts = 45.973137
current_received_ts = 46.143223
current_seq = 245
count = 3
seq_step = 1
(kms_flip:1227) DEBUG: flip ts/seq: last 45.783398/235, current 45.973137/245: elapsed=189741.0us expected=189733.7us +- 948.7us, error 0.0%
(kms_flip:1227) DEBUG: name = vblank
last_ts = 45.954163
last_received_ts = 45.953457
last_seq = 244
current_ts = 46.143898
current_received_ts = 46.143196
current_seq = 254
count = 3
seq_step = 10
(kms_flip:1227) DEBUG: vblank ts/seq: last 45.954163/244, current 46.143898/254: elapsed=189738.0us expected=189733.7us +- 948.7us, error 0.0%
(kms_flip:1227) DEBUG: name = flip
last_ts = 45.973137
last_received_ts = 46.143223
last_seq = 245
current_ts = 46.162876
current_received_ts = 46.332966
current_seq = 255
count = 4
seq_step = 1
(kms_flip:1227) DEBUG: flip ts/seq: last 45.973137/245, current 46.162876/255: elapsed=189739.0us expected=189733.7us +- 948.7us, error 0.0%
(kms_flip:1227) DEBUG: name = vblank
last_ts = 46.143898
last_received_ts = 46.143196
last_seq = 254
current_ts = 46.333637
current_received_ts = 46.332939
current_seq = 264
count = 4
seq_step = 10
(kms_flip:1227) DEBUG: vblank ts/seq: last 46.143898/254, current 46.333637/264: elapsed=189738.0us expected=189733.7us +- 948.7us, error 0.0%
(kms_flip:1227) DEBUG: name = flip
last_ts = 46.162876
last_received_ts = 46.332966
last_seq = 255
current_ts = 46.352615
current_received_ts = 46.522694
current_seq = 265
count = 5
seq_step = 1
(kms_flip:1227) DEBUG: flip ts/seq: last 46.162876/255, current 46.352615/265: elapsed=189737.0us expected=189733.7us +- 948.7us, error 0.0%
(kms_flip:1227) DEBUG: name = vblank
last_ts = 46.333637
last_received_ts = 46.332939
last_seq = 264
current_ts = 46.523373
current_received_ts = 46.522667
current_seq = 274
count = 5
seq_step = 10
(kms_flip:1227) DEBUG: vblank ts/seq: last 46.333637/264, current 46.523373/274: elapsed=189736.0us expected=189733.7us +- 948.7us, error 0.0%
(kms_flip:1227) DEBUG: name = flip
last_ts = 46.352615
last_received_ts = 46.522694
last_seq = 265
current_ts = 46.542351
current_received_ts = 46.712383
current_seq = 275
count = 6
seq_step = 1
(kms_flip:1227) DEBUG: flip ts/seq: last 46.352615/265, current 46.542351/275: elapsed=189737.0us expected=189733.7us +- 948.7us, error 0.0%
(kms_flip:1227) DEBUG: name = vblank
last_ts = 46.523373
last_received_ts = 46.522667
last_seq = 274
current_ts = 46.713120
current_received_ts = 46.712372
current_seq = 284
count = 6
seq_step = 10
(kms_flip:1227) DEBUG: vblank ts/seq: last 46.523373/274, current 46.713120/284: elapsed=189746.0us expected=189733.7us +- 948.7us, error 0.0%
(kms_flip:1227) DEBUG: name = flip
last_ts = 46.542351
last_received_ts = 46.712383
last_seq = 275
current_ts = 46.732090
current_received_ts = 46.902164
current_seq = 285
count = 7
seq_step = 1
(kms_flip:1227) DEBUG: flip ts/seq: last 46.542351/275, current 46.732090/285: elapsed=189738.0us expected=189733.7us +- 948.7us, error 0.0%
(kms_flip:1227) DEBUG: name = vblank
last_ts = 46.713120
last_received_ts = 46.712372
last_seq = 284
current_ts = 46.902851
current_received_ts = 46.902142
current_seq = 294
count = 7
seq_step = 10
(kms_flip:1227) DEBUG: vblank ts/seq: last 46.713120/284, current 46.902851/294: elapsed=189731.0us expected=189733.7us +- 948.7us, error 0.0%
(kms_flip:1227) DEBUG: name = flip
last_ts = 46.732090
last_received_ts = 46.902164
last_seq = 285
current_ts = 46.921829
current_received_ts = 47.091915
current_seq = 295
count = 8
seq_step = 1
(kms_flip:1227) DEBUG: flip ts/seq: last 46.732090/285, current 46.921829/295: elapsed=189739.0us expected=189733.7us +- 948.7us, error 0.0%
(kms_flip:1227) DEBUG: name = vblank
last_ts = 46.902851
last_received_ts = 46.902142
last_seq = 294
current_ts = 47.092587
current_received_ts = 47.091888
current_seq = 304
count = 8
seq_step = 10
(kms_flip:1227) DEBUG: vblank ts/seq: last 46.902851/294, current 47.092587/304: elapsed=189737.0us expected=189733.7us +- 948.7us, error 0.0%
(kms_flip:1227) DEBUG: name = flip
last_ts = 46.921829
last_received_ts = 47.091915
last_seq = 295
current_ts = 47.111565
current_received_ts = 47.281639
current_seq = 305
count = 9
seq_step = 1
(kms_flip:1227) DEBUG: flip ts/seq: last 46.921829/295, current 47.111565/305: elapsed=189735.0us expected=189733.7us +- 948.7us, error 0.0%
(kms_flip:1227) DEBUG: name = vblank
last_ts = 47.092587
last_received_ts = 47.091888
last_seq = 304
current_ts = 47.282337
current_received_ts = 47.281612
current_seq = 314
count = 9
seq_step = 10
(kms_flip:1227) DEBUG: vblank ts/seq: last 47.092587/304, current 47.282337/314: elapsed=189752.0us expected=189733.7us +- 948.7us, error 0.0%
(kms_flip:1227) DEBUG: name = flip
last_ts = 47.111565
last_received_ts = 47.281639
last_seq = 305
current_ts = 47.301304
current_received_ts = 47.471378
current_seq = 315
count = 10
seq_step = 1
(kms_flip:1227) DEBUG: flip ts/seq: last 47.111565/305, current 47.301304/315: elapsed=189739.0us expected=189733.7us +- 948.7us, error 0.0%
(kms_flip:1227) DEBUG: name = vblank
last_ts = 47.282337
last_received_ts = 47.281612
last_seq = 314
current_ts = 47.472061
current_received_ts = 47.471352
current_seq = 324
count = 10
seq_step = 10
(kms_flip:1227) DEBUG: vblank ts/seq: last 47.282337/314, current 47.472061/324: elapsed=189723.0us expected=189733.7us +- 948.7us, error 0.0%
(kms_flip:1227) DEBUG: name = flip
last_ts = 47.301304
last_received_ts = 47.471378
last_seq = 315
current_ts = 47.491039
current_received_ts = 47.661118
current_seq = 325
count = 11
seq_step = 1
(kms_flip:1227) DEBUG: flip ts/seq: last 47.301304/315, current 47.491039/325: elapsed=189738.0us expected=189733.7us +- 948.7us, error 0.0%
(kms_flip:1227) DEBUG: name = vblank
last_ts = 47.472061
last_received_ts = 47.471352
last_seq = 324
current_ts = 47.661800
current_received_ts = 47.661095
current_seq = 334
count = 11
seq_step = 10
(kms_flip:1227) DEBUG: vblank ts/seq: last 47.472061/324, current 47.661800/334: elapsed=189739.0us expected=189733.7us +- 948.7us, error 0.0%
(kms_flip:1227) DEBUG: name = flip
last_ts = 47.491039
last_received_ts = 47.661118
last_seq = 325
current_ts = 47.680779
current_received_ts = 47.850857
current_seq = 335
count = 12
seq_step = 1
(kms_flip:1227) DEBUG: flip ts/seq: last 47.491039/325, current 47.680779/335: elapsed=189738.0us expected=189733.7us +- 948.7us, error 0.0%
(kms_flip:1227) DEBUG: name = vblank
last_ts = 47.661800
last_received_ts = 47.661095
last_seq = 334
current_ts = 47.851540
current_received_ts = 47.850830
current_seq = 344
count = 12
seq_step = 10
(kms_flip:1227) DEBUG: vblank ts/seq: last 47.661800/334, current 47.851540/344: elapsed=189737.0us expected=189733.7us +- 948.7us, error 0.0%
(kms_flip:1227) DEBUG: name = flip
last_ts = 47.680779
last_received_ts = 47.850857
last_seq = 335
current_ts = 47.870514
current_received_ts = 48.040615
current_seq = 345
count = 13
seq_step = 1
(kms_flip:1227) DEBUG: flip ts/seq: last 47.680779/335, current 47.870514/345: elapsed=189737.0us expected=189733.7us +- 948.7us, error 0.0%
(kms_flip:1227) DEBUG: name = vblank
last_ts = 47.851540
last_received_ts = 47.850830
last_seq = 344
current_ts = 48.041279
current_received_ts = 48.040585
current_seq = 354
count = 13
seq_step = 10
(kms_flip:1227) DEBUG: vblank ts/seq: last 47.851540/344, current 48.041279/354: elapsed=189739.0us expected=189733.7us +- 948.7us, error 0.0%
(kms_flip:1227) DEBUG: name = flip
last_ts = 47.870514
last_received_ts = 48.040615
last_seq = 345
current_ts = 48.060253
current_received_ts = 48.230339
current_seq = 355
count = 14
seq_step = 1
(kms_flip:1227) DEBUG: flip ts/seq: last 47.870514/345, current 48.060253/355: elapsed=189739.0us expected=189733.7us +- 948.7us, error 0.0%
(kms_flip:1227) DEBUG: name = vblank
last_ts = 48.041279
last_received_ts = 48.040585
last_seq = 354
current_ts = 48.231014
current_received_ts = 48.230309
current_seq = 364
count = 14
seq_step = 10
(kms_flip:1227) DEBUG: vblank ts/seq: last 48.041279/354, current 48.231014/364: elapsed=189736.0us expected=189733.7us +- 948.7us, error 0.0%
(kms_flip:1227) DEBUG: name = flip
last_ts = 48.060253
last_received_ts = 48.230339
last_seq = 355
current_ts = 48.249992
current_received_ts = 48.420067
current_seq = 365
count = 15
seq_step = 1
(kms_flip:1227) DEBUG: flip ts/seq: last 48.060253/355, current 48.249992/365: elapsed=189738.0us expected=189733.7us +- 948.7us, error 0.0%
(kms_flip:1227) DEBUG: name = vblank
last_ts = 48.231014
last_received_ts = 48.230309
last_seq = 364
current_ts = 48.420753
current_received_ts = 48.420044
current_seq = 374
count = 15
seq_step = 10
(kms_flip:1227) DEBUG: vblank ts/seq: last 48.231014/364, current 48.420753/374: elapsed=189739.0us expected=189733.7us +- 948.7us, error 0.0%
(kms_flip:1227) DEBUG: name = flip
last_ts = 48.249992
last_received_ts = 48.420067
last_seq = 365
current_ts = 48.439724
current_received_ts = 48.609802
current_seq = 375
count = 16
seq_step = 1
(kms_flip:1227) DEBUG: flip ts/seq: last 48.249992/365, current 48.439724/375: elapsed=189733.0us expected=189733.7us +- 948.7us, error 0.0%
(kms_flip:1227) DEBUG: name = vblank
last_ts = 48.420753
last_received_ts = 48.420044
last_seq = 374
current_ts = 48.610489
current_received_ts = 48.609779
current_seq = 384
count = 16
seq_step = 10
(kms_flip:1227) DEBUG: vblank ts/seq: last 48.420753/374, current 48.610489/384: elapsed=189737.0us expected=189733.7us +- 948.7us, error 0.0%
(kms_flip:1227) DEBUG: name = flip
last_ts = 48.439724
last_received_ts = 48.609802
last_seq = 375
current_ts = 48.629467
current_received_ts = 48.799541
current_seq = 385
count = 17
seq_step = 1
(kms_flip:1227) DEBUG: flip ts/seq: last 48.439724/375, current 48.629467/385: elapsed=189742.0us expected=189733.7us +- 948.7us, error 0.0%
(kms_flip:1227) DEBUG: name = vblank
last_ts = 48.610489
last_received_ts = 48.609779
last_seq = 384
current_ts = 48.800228
current_received_ts = 48.799519
current_seq = 394
count = 17
seq_step = 10
(kms_flip:1227) DEBUG: vblank ts/seq: last 48.610489/384, current 48.800228/394: elapsed=189738.0us expected=189733.7us +- 948.7us, error 0.0%
(kms_flip:1227) DEBUG: name = flip
last_ts = 48.629467
last_received_ts = 48.799541
last_seq = 385
current_ts = 48.819202
current_received_ts = 48.989277
current_seq = 395
count = 18
seq_step = 1
(kms_flip:1227) DEBUG: flip ts/seq: last 48.629467/385, current 48.819202/395: elapsed=189737.0us expected=189733.7us +- 948.7us, error 0.0%
(kms_flip:1227) DEBUG: name = vblank
last_ts = 48.800228
last_received_ts = 48.799519
last_seq = 394
current_ts = 48.989964
current_received_ts = 48.989258
current_seq = 404
count = 18
seq_step = 10
(kms_flip:1227) DEBUG: vblank ts/seq: last 48.800228/394, current 48.989964/404: elapsed=189738.0us expected=189733.7us +- 948.7us, error 0.0%
(kms_flip:1227) DEBUG: name = flip
last_ts = 48.819202
last_received_ts = 48.989277
last_seq = 395
current_ts = 49.008942
current_received_ts = 49.179047
current_seq = 405
count = 19
seq_step = 1
(kms_flip:1227) DEBUG: flip ts/seq: last 48.819202/395, current 49.008942/405: elapsed=189737.0us expected=189733.7us +- 948.7us, error 0.0%
(kms_flip:1227) DEBUG: name = vblank
last_ts = 48.989964
last_received_ts = 48.989258
last_seq = 404
current_ts = 49.179703
current_received_ts = 49.178989
current_seq = 414
count = 19
seq_step = 10
(kms_flip:1227) DEBUG: vblank ts/seq: last 48.989964/404, current 49.179703/414: elapsed=189736.0us expected=189733.7us +- 948.7us, error 0.0%
(kms_flip:1227) DEBUG: name = flip
last_ts = 49.008942
last_received_ts = 49.179047
last_seq = 405
current_ts = 49.198681
current_received_ts = 49.368748
current_seq = 415
count = 20
seq_step = 1
(kms_flip:1227) DEBUG: flip ts/seq: last 49.008942/405, current 49.198681/415: elapsed=189740.0us expected=189733.7us +- 948.7us, error 0.0%
(kms_flip:1227) DEBUG: name = vblank
last_ts = 49.179703
last_received_ts = 49.178989
last_seq = 414
current_ts = 49.369438
current_received_ts = 49.368729
current_seq = 424
count = 20
seq_step = 10
(kms_flip:1227) DEBUG: vblank ts/seq: last 49.179703/414, current 49.369438/424: elapsed=189738.0us expected=189733.7us +- 948.7us, error 0.0%
(kms_flip:1227) DEBUG: name = flip
last_ts = 49.198681
last_received_ts = 49.368748
last_seq = 415
current_ts = 49.388416
current_received_ts = 49.558498
current_seq = 425
count = 21
seq_step = 1
(kms_flip:1227) DEBUG: flip ts/seq: last 49.198681/415, current 49.388416/425: elapsed=189736.0us expected=189733.7us +- 948.7us, error 0.0%
(kms_flip:1227) DEBUG: name = vblank
last_ts = 49.369438
last_received_ts = 49.368729
last_seq = 424
current_ts = 49.559177
current_received_ts = 49.558472
current_seq = 434
count = 21
seq_step = 10
(kms_flip:1227) DEBUG: vblank ts/seq: last 49.369438/424, current 49.559177/434: elapsed=189739.0us expected=189733.7us +- 948.7us, error 0.0%
(kms_flip:1227) DEBUG: name = flip
last_ts = 49.388416
last_received_ts = 49.558498
last_seq = 425
current_ts = 49.578156
current_received_ts = 49.749451
current_seq = 435
count = 22
seq_step = 1
(kms_flip:1227) DEBUG: flip ts/seq: last 49.388416/425, current 49.578156/435: elapsed=189739.0us expected=189733.7us +- 948.7us, error 0.0%
(kms_flip:1227) DEBUG: name = vblank
last_ts = 49.559177
last_received_ts = 49.558472
last_seq = 434
current_ts = 49.750137
current_received_ts = 49.749428
current_seq = 444
count = 22
seq_step = 10
(kms_flip:1227) DEBUG: vblank ts/seq: last 49.559177/434, current 49.750137/444: elapsed=190959.0us expected=189733.7us +- 948.7us, error 0.6%
(kms_flip:1227) DEBUG: inconsistent vblank ts/seq: last 49.559177/434, current 49.750137/444: elapsed=190959.0us expected=189733.7us
(kms_flip:1227) DEBUG: expected 214012, counted 220, encoder type 2
(kms_flip:1227) DEBUG: dropped frames, expected 214012, counted 220, encoder type 2
(kms_flip:1227) DEBUG: expected 214012, counted 220, encoder type 2
(kms_flip:1227) DEBUG: dropped frames, expected 214012, counted 220, encoder type 2
(kms_flip:1227) CRITICAL: Test assertion failure function __run_test_on_crtc_set, file ../tests/kms_flip.c:1674:
(kms_flip:1227) CRITICAL: Failed assertion: !retried && needs_retry_after_link_reset(mon)
(kms_flip:1227) igt_core-INFO: Stack trace:
(kms_flip:1227) igt_core-INFO:   #0 ../lib/igt_core.c:2051 __igt_fail_assert()
(kms_flip:1227) igt_core-INFO:   #1 ../tests/kms_flip.c:791 run_test_on_crtc_set.constprop.0()
(kms_flip:1227) igt_core-INFO:   #2 ../tests/kms_flip.c:1845 run_test()
(kms_flip:1227) igt_core-INFO:   #3 ../tests/kms_flip.c:2078 __igt_unique____real_main2001()
(kms_flip:1227) igt_core-INFO:   #4 ../tests/kms_flip.c:2001 main()
(kms_flip:1227) igt_core-INFO:   #5 [__libc_init_first+0x8a]
(kms_flip:1227) igt_core-INFO:   #6 [__libc_start_main+0x8b]
(kms_flip:1227) igt_core-INFO:   #7 [_start+0x25]
****  END  ****
Dynamic subtest A-HDMI-A1: FAIL (7.840s)
Starting dynamic subtest: B-HDMI-A1
(kms_flip:1227) CRITICAL: Test assertion failure function __run_test_on_crtc_set, file ../tests/kms_flip.c:1674:
(kms_flip:1227) CRITICAL: Failed assertion: !retried && needs_retry_after_link_reset(mon)
Dynamic subtest B-HDMI-A1 failed.
**** DEBUG ****
(kms_flip:1227) igt_fb-DEBUG: igt_create_fb_with_bo_size(width=1920, height=1080, format=XR24(0x34325258), modifier=0x0, size=0)
(kms_flip:1227) igt_fb-DEBUG: igt_create_fb_with_bo_size(handle=3, pitch=7680)
(kms_flip:1227) ioctl_wrappers-DEBUG: Test requirement passed: igt_has_fb_modifiers(fd)
(kms_flip:1227) igt_fb-DEBUG: igt_create_fb_with_bo_size(width=1920, height=1080, format=XR24(0x34325258), modifier=0x0, size=0)
(kms_flip:1227) igt_fb-DEBUG: igt_create_fb_with_bo_size(handle=4, pitch=7680)
(kms_flip:1227) ioctl_wrappers-DEBUG: Test requirement passed: igt_has_fb_modifiers(fd)
(kms_flip:1227) intel_blt-DEBUG: Test requirement passed: cmds_info
(kms_flip:1227) intel_blt-DEBUG: Test requirement passed: cmds_info
(kms_flip:1227) igt_fb-DEBUG: Test requirement passed: cairo_surface_status(fb->cairo_surface) == CAIRO_STATUS_SUCCESS
(kms_flip:1227) intel_blt-DEBUG: Test requirement passed: cmds_info
(kms_flip:1227) intel_blt-DEBUG: Test requirement passed: cmds_info
(kms_flip:1227) igt_fb-DEBUG: Test requirement passed: cairo_surface_status(fb->cairo_surface) == CAIRO_STATUS_SUCCESS
(kms_flip:1227) igt_kms-INFO:   1920x1080: 53 139930 1920 2008 2096 2360 1080 1084 1089 1125 0x48 0x5 
(kms_flip:1227) DEBUG: No stale events found
(kms_flip:1227) i915/intel_drrs-DEBUG: Manually disabling DRRS. 0
(kms_flip:1227) i915/intel_drrs-DEBUG: Test requirement passed: dir >= 0
(kms_flip:1227) INFO: Expected frametime: 18974us; measured 19178.0us +- 2.556us accuracy 0.04%
(kms_flip:1227) INFO: vblank interval differs from modeline! expected 18973.8us, measured 19178us +- 2.556us, difference 204.2us (79.9 sigma)
(kms_flip:1227) DEBUG: name = flip
last_ts = 0.000000
last_received_ts = 0.000000
last_seq = 0
current_ts = 53.288448
current_received_ts = 53.460369
current_seq = 24
count = 0
seq_step = 1
(kms_flip:1227) DEBUG: name = vblank
last_ts = 0.000000
last_received_ts = 0.000000
last_seq = 0
current_ts = 53.461052
current_received_ts = 53.460346
current_seq = 33
count = 0
seq_step = 10
(kms_flip:1227) DEBUG: name = flip
last_ts = 53.288448
last_received_ts = 53.460369
last_seq = 24
current_ts = 53.480232
current_received_ts = 53.652149
current_seq = 34
count = 1
seq_step = 1
(kms_flip:1227) DEBUG: flip ts/seq: last 53.288448/24, current 53.480232/34: elapsed=191784.0us expected=191780.0us +- 958.9us, error 0.0%
(kms_flip:1227) DEBUG: name = vblank
last_ts = 53.461052
last_received_ts = 53.460346
last_seq = 33
current_ts = 53.652836
current_received_ts = 53.652126
current_seq = 43
count = 1
seq_step = 10
(kms_flip:1227) DEBUG: vblank ts/seq: last 53.461052/33, current 53.652836/43: elapsed=191782.0us expected=191780.0us +- 958.9us, error 0.0%
(kms_flip:1227) DEBUG: name = flip
last_ts = 53.480232
last_received_ts = 53.652149
last_seq = 34
current_ts = 53.672016
current_received_ts = 53.843700
current_seq = 44
count = 2
seq_step = 1
(kms_flip:1227) DEBUG: flip ts/seq: last 53.480232/34, current 53.672016/44: elapsed=191782.0us expected=191780.0us +- 958.9us, error 0.0%
(kms_flip:1227) DEBUG: name = vblank
last_ts = 53.652836
last_received_ts = 53.652126
last_seq = 43
current_ts = 53.844387
current_received_ts = 53.843678
current_seq = 53
count = 2
seq_step = 10
(kms_flip:1227) DEBUG: vblank ts/seq: last 53.652836/43, current 53.844387/53: elapsed=191553.0us expected=191780.0us +- 958.9us, error 0.1%
(kms_flip:1227) DEBUG: name = flip
last_ts = 53.672016
last_received_ts = 53.843700
last_seq = 44
current_ts = 53.863544
current_received_ts = 54.035225
current_seq = 54
count = 3
seq_step = 1
(kms_flip:1227) DEBUG: flip ts/seq: last 53.672016/44, current 53.863544/54: elapsed=191528.0us expected=191780.0us +- 958.9us, error 0.1%
(kms_flip:1227) DEBUG: name = vblank
last_ts = 53.844387
last_received_ts = 53.843678
last_seq = 53
current_ts = 54.035915
current_received_ts = 54.035202
current_seq = 63
count = 3
seq_step = 10
(kms_flip:1227) DEBUG: vblank ts/seq: last 53.844387/53, current 54.035915/63: elapsed=191527.0us expected=191780.0us +- 958.9us, error 0.1%
(kms_flip:1227) DEBUG: name = flip
last_ts = 53.863544
last_received_ts = 54.035225
last_seq = 54
current_ts = 54.055069
current_received_ts = 54.226749
current_seq = 64
count = 4
seq_step = 1
(kms_flip:1227) DEBUG: flip ts/seq: last 53.863544/54, current 54.055069/64: elapsed=191526.0us expected=191780.0us +- 958.9us, error 0.1%
(kms_flip:1227) DEBUG: name = vblank
last_ts = 54.035915
last_received_ts = 54.035202
last_seq = 63
current_ts = 54.227440
current_received_ts = 54.226727
current_seq = 73
count = 4
seq_step = 10
(kms_flip:1227) DEBUG: vblank ts/seq: last 54.035915/63, current 54.227440/73: elapsed=191525.0us expected=191780.0us +- 958.9us, error 0.1%
(kms_flip:1227) DEBUG: name = flip
last_ts = 54.055069
last_received_ts = 54.226749
last_seq = 64
current_ts = 54.246597
current_received_ts = 54.418282
current_seq = 74
count = 5
seq_step = 1
(kms_flip:1227) DEBUG: flip ts/seq: last 54.055069/64, current 54.246597/74: elapsed=191527.0us expected=191780.0us +- 958.9us, error 0.1%
(kms_flip:1227) DEBUG: name = vblank
last_ts = 54.227440
last_received_ts = 54.226727
last_seq = 73
current_ts = 54.418968
current_received_ts = 54.418259
current_seq = 83
count = 5
seq_step = 10
(kms_flip:1227) DEBUG: vblank ts/seq: last 54.227440/73, current 54.418968/83: elapsed=191529.0us expected=191780.0us +- 958.9us, error 0.1%
(kms_flip:1227) DEBUG: name = flip
last_ts = 54.246597
last_received_ts = 54.418282
last_seq = 74
current_ts = 54.438122
current_received_ts = 54.609810
current_seq = 84
count = 6
seq_step = 1
(kms_flip:1227) DEBUG: flip ts/seq: last 54.246597/74, current 54.438122/84: elapsed=191527.0us expected=191780.0us +- 958.9us, error 0.1%
(kms_flip:1227) DEBUG: name = vblank
last_ts = 54.418968
last_received_ts = 54.418259
last_seq = 83
current_ts = 54.610497
current_received_ts = 54.609787
current_seq = 93
count = 6
seq_step = 10
(kms_flip:1227) DEBUG: vblank ts/seq: last 54.418968/83, current 54.610497/93: elapsed=191527.0us expected=191780.0us +- 958.9us, error 0.1%
(kms_flip:1227) DEBUG: name = flip
last_ts = 54.438122
last_received_ts = 54.609810
last_seq = 84
current_ts = 54.629650
current_received_ts = 54.801174
current_seq = 94
count = 7
seq_step = 1
(kms_flip:1227) DEBUG: flip ts/seq: last 54.438122/84, current 54.629650/94: elapsed=191527.0us expected=191780.0us +- 958.9us, error 0.1%
(kms_flip:1227) DEBUG: name = vblank
last_ts = 54.610497
last_received_ts = 54.609787
last_seq = 93
current_ts = 54.801853
current_received_ts = 54.801151
current_seq = 103
count = 7
seq_step = 10
(kms_flip:1227) DEBUG: vblank ts/seq: last 54.610497/93, current 54.801853/103: elapsed=191357.0us expected=191780.0us +- 958.9us, error 0.2%
(kms_flip:1227) DEBUG: name = flip
last_ts = 54.629650
last_received_ts = 54.801174
last_seq = 94
current_ts = 54.820988
current_received_ts = 54.992474
current_seq = 104
count = 8
seq_step = 1
(kms_flip:1227) DEBUG: flip ts/seq: last 54.629650/94, current 54.820988/104: elapsed=191336.0us expected=191780.0us +- 958.9us, error 0.2%
(kms_flip:1227) DEBUG: name = vblank
last_ts = 54.801853
last_received_ts = 54.801151
last_seq = 103
current_ts = 54.993156
current_received_ts = 54.992451
current_seq = 113
count = 8
seq_step = 10
(kms_flip:1227) DEBUG: vblank ts/seq: last 54.801853/103, current 54.993156/113: elapsed=191306.0us expected=191780.0us +- 958.9us, error 0.2%
(kms_flip:1227) DEBUG: name = flip
last_ts = 54.820988
last_received_ts = 54.992474
last_seq = 104
current_ts = 55.012291
current_received_ts = 55.183773
current_seq = 114
count = 9
seq_step = 1
(kms_flip:1227) DEBUG: flip ts/seq: last 54.820988/104, current 55.012291/114: elapsed=191304.0us expected=191780.0us +- 958.9us, error 0.2%
(kms_flip:1227) DEBUG: name = vblank
last_ts = 54.993156
last_received_ts = 54.992451
last_seq = 113
current_ts = 55.184460
current_received_ts = 55.183746
current_seq = 123
count = 9
seq_step = 10
(kms_flip:1227) DEBUG: vblank ts/seq: last 54.993156/113, current 55.184460/123: elapsed=191301.0us expected=191780.0us +- 958.9us, error 0.2%
(kms_flip:1227) DEBUG: name = flip
last_ts = 55.012291
last_received_ts = 55.183773
last_seq = 114
current_ts = 55.203594
current_received_ts = 55.375076
current_seq = 124
count = 10
seq_step = 1
(kms_flip:1227) DEBUG: flip ts/seq: last 55.012291/114, current 55.203594/124: elapsed=191303.0us expected=191780.0us +- 958.9us, error 0.2%
(kms_flip:1227) DEBUG: name = vblank
last_ts = 55.184460
last_received_ts = 55.183746
last_seq = 123
current_ts = 55.375763
current_received_ts = 55.375057
current_seq = 133
count = 10
seq_step = 10
(kms_flip:1227) DEBUG: vblank ts/seq: last 55.184460/123, current 55.375763/133: elapsed=191305.0us expected=191780.0us +- 958.9us, error 0.2%
(kms_flip:1227) DEBUG: name = flip
last_ts = 55.203594
last_received_ts = 55.375076
last_seq = 124
current_ts = 55.394897
current_received_ts = 55.566383
current_seq = 134
count = 11
seq_step = 1
(kms_flip:1227) DEBUG: flip ts/seq: last 55.203594/124, current 55.394897/134: elapsed=191303.0us expected=191780.0us +- 958.9us, error 0.2%
(kms_flip:1227) DEBUG: name = vblank
last_ts = 55.375763
last_received_ts = 55.375057
last_seq = 133
current_ts = 55.567066
current_received_ts = 55.566360
current_seq = 143
count = 11
seq_step = 10
(kms_flip:1227) DEBUG: vblank ts/seq: last 55.375763/133, current 55.567066/143: elapsed=191303.0us expected=191780.0us +- 958.9us, error 0.2%
(kms_flip:1227) DEBUG: name = flip
last_ts = 55.394897
last_received_ts = 55.566383
last_seq = 134
current_ts = 55.586201
current_received_ts = 55.757587
current_seq = 144
count = 12
seq_step = 1
(kms_flip:1227) DEBUG: flip ts/seq: last 55.394897/134, current 55.586201/144: elapsed=191303.0us expected=191780.0us +- 958.9us, error 0.2%
(kms_flip:1227) DEBUG: name = vblank
last_ts = 55.567066
last_received_ts = 55.566360
last_seq = 143
current_ts = 55.758270
current_received_ts = 55.757568
current_seq = 153
count = 12
seq_step = 10
(kms_flip:1227) DEBUG: vblank ts/seq: last 55.567066/143, current 55.758270/153: elapsed=191204.0us expected=191780.0us +- 958.9us, error 0.3%
(kms_flip:1227) DEBUG: name = flip
last_ts = 55.586201
last_received_ts = 55.757587
last_seq = 144
current_ts = 55.777386
current_received_ts = 55.948689
current_seq = 154
count = 13
seq_step = 1
(kms_flip:1227) DEBUG: flip ts/seq: last 55.586201/144, current 55.777386/154: elapsed=191186.0us expected=191780.0us +- 958.9us, error 0.3%
(kms_flip:1227) DEBUG: name = vblank
last_ts = 55.758270
last_received_ts = 55.757568
last_seq = 153
current_ts = 55.949379
current_received_ts = 55.948666
current_seq = 163
count = 13
seq_step = 10
(kms_flip:1227) DEBUG: vblank ts/seq: last 55.758270/153, current 55.949379/163: elapsed=191108.0us expected=191780.0us +- 958.9us, error 0.4%
(kms_flip:1227) DEBUG: name = flip
last_ts = 55.777386
last_received_ts = 55.948689
last_seq = 154
current_ts = 55.968494
current_received_ts = 56.139805
current_seq = 164
count = 14
seq_step = 1
(kms_flip:1227) DEBUG: flip ts/seq: last 55.777386/154, current 55.968494/164: elapsed=191109.0us expected=191780.0us +- 958.9us, error 0.3%
(kms_flip:1227) DEBUG: name = vblank
last_ts = 55.949379
last_received_ts = 55.948666
last_seq = 163
current_ts = 56.140488
current_received_ts = 56.139782
current_seq = 173
count = 14
seq_step = 10
(kms_flip:1227) DEBUG: vblank ts/seq: last 55.949379/163, current 56.140488/173: elapsed=191108.0us expected=191780.0us +- 958.9us, error 0.4%
(kms_flip:1227) DEBUG: name = flip
last_ts = 55.968494
last_received_ts = 56.139805
last_seq = 164
current_ts = 56.159599
current_received_ts = 56.330910
current_seq = 174
count = 15
seq_step = 1
(kms_flip:1227) DEBUG: flip ts/seq: last 55.968494/164, current 56.159599/174: elapsed=191107.0us expected=191780.0us +- 958.9us, error 0.4%
(kms_flip:1227) DEBUG: name = vblank
last_ts = 56.140488
last_received_ts = 56.139782
last_seq = 173
current_ts = 56.331596
current_received_ts = 56.330887
current_seq = 183
count = 15
seq_step = 10
(kms_flip:1227) DEBUG: vblank ts/seq: last 56.140488/173, current 56.331596/183: elapsed=191108.0us expected=191780.0us +- 958.9us, error 0.4%
(kms_flip:1227) DEBUG: name = flip
last_ts = 56.159599
last_received_ts = 56.330910
last_seq = 174
current_ts = 56.350712
current_received_ts = 56.522045
current_seq = 184
count = 16
seq_step = 1
(kms_flip:1227) DEBUG: flip ts/seq: last 56.159599/174, current 56.350712/184: elapsed=191109.0us expected=191780.0us +- 958.9us, error 0.3%
(kms_flip:1227) DEBUG: name = vblank
last_ts = 56.331596
last_received_ts = 56.330887
last_seq = 183
current_ts = 56.522705
current_received_ts = 56.521992
current_seq = 193
count = 16
seq_step = 10
(kms_flip:1227) DEBUG: vblank ts/seq: last 56.331596/183, current 56.522705/193: elapsed=191109.0us expected=191780.0us +- 958.9us, error 0.3%
(kms_flip:1227) DEBUG: name = flip
last_ts = 56.350712
last_received_ts = 56.522045
last_seq = 184
current_ts = 56.541817
current_received_ts = 56.713070
current_seq = 194
count = 17
seq_step = 1
(kms_flip:1227) DEBUG: flip ts/seq: last 56.350712/184, current 56.541817/194: elapsed=191107.0us expected=191780.0us +- 958.9us, error 0.4%
(kms_flip:1227) DEBUG: name = vblank
last_ts = 56.522705
last_received_ts = 56.521992
last_seq = 193
current_ts = 56.713757
current_received_ts = 56.713047
current_seq = 203
count = 17
seq_step = 10
(kms_flip:1227) DEBUG: vblank ts/seq: last 56.522705/193, current 56.713757/203: elapsed=191054.0us expected=191780.0us +- 958.9us, error 0.4%
(kms_flip:1227) DEBUG: name = flip
last_ts = 56.541817
last_received_ts = 56.713070
last_seq = 194
current_ts = 56.732857
current_received_ts = 56.904037
current_seq = 204
count = 18
seq_step = 1
(kms_flip:1227) DEBUG: flip ts/seq: last 56.541817/194, current 56.732857/204: elapsed=191039.0us expected=191780.0us +- 958.9us, error 0.4%
(kms_flip:1227) DEBUG: name = vblank
last_ts = 56.713757
last_received_ts = 56.713047
last_seq = 203
current_ts = 56.904694
current_received_ts = 56.903984
current_seq = 213
count = 18
seq_step = 10
(kms_flip:1227) DEBUG: vblank ts/seq: last 56.713757/203, current 56.904694/213: elapsed=190937.0us expected=191780.0us +- 958.9us, error 0.4%
(kms_flip:1227) DEBUG: name = flip
last_ts = 56.732857
last_received_ts = 56.904037
last_seq = 204
current_ts = 56.923794
current_received_ts = 57.094948
current_seq = 214
count = 19
seq_step = 1
(kms_flip:1227) DEBUG: flip ts/seq: last 56.732857/204, current 56.923794/214: elapsed=190936.0us expected=191780.0us +- 958.9us, error 0.4%
(kms_flip:1227) DEBUG: name = vblank
last_ts = 56.904694
last_received_ts = 56.903984
last_seq = 213
current_ts = 57.095634
current_received_ts = 57.094925
current_seq = 223
count = 19
seq_step = 10
(kms_flip:1227) DEBUG: vblank ts/seq: last 56.904694/213, current 57.095634/223: elapsed=190939.0us expected=191780.0us +- 958.9us, error 0.4%
(kms_flip:1227) DEBUG: name = flip
last_ts = 56.923794
last_received_ts = 57.094948
last_seq = 214
current_ts = 57.114731
current_received_ts = 57.285881
current_seq = 224
count = 20
seq_step = 1
(kms_flip:1227) DEBUG: flip ts/seq: last 56.923794/214, current 57.114731/224: elapsed=190937.0us expected=191780.0us +- 958.9us, error 0.4%
(kms_flip:1227) DEBUG: name = vblank
last_ts = 57.095634
last_received_ts = 57.094925
last_seq = 223
current_ts = 57.286568
current_received_ts = 57.285858
current_seq = 233
count = 20
seq_step = 10
(kms_flip:1227) DEBUG: vblank ts/seq: last 57.095634/223, current 57.286568/233: elapsed=190935.0us expected=191780.0us +- 958.9us, error 0.4%
(kms_flip:1227) DEBUG: name = flip
last_ts = 57.114731
last_received_ts = 57.285881
last_seq = 224
current_ts = 57.305664
current_received_ts = 57.476814
current_seq = 234
count = 21
seq_step = 1
(kms_flip:1227) DEBUG: flip ts/seq: last 57.114731/224, current 57.305664/234: elapsed=190936.0us expected=191780.0us +- 958.9us, error 0.4%
(kms_flip:1227) DEBUG: name = vblank
last_ts = 57.286568
last_received_ts = 57.285858
last_seq = 233
current_ts = 57.477505
current_received_ts = 57.476795
current_seq = 243
count = 21
seq_step = 10
(kms_flip:1227) DEBUG: vblank ts/seq: last 57.286568/233, current 57.477505/243: elapsed=190937.0us expected=191780.0us +- 958.9us, error 0.4%
(kms_flip:1227) DEBUG: name = flip
last_ts = 57.305664
last_received_ts = 57.476814
last_seq = 234
current_ts = 57.496601
current_received_ts = 57.667751
current_seq = 244
count = 22
seq_step = 1
(kms_flip:1227) DEBUG: flip ts/seq: last 57.305664/234, current 57.496601/244: elapsed=190937.0us expected=191780.0us +- 958.9us, error 0.4%
(kms_flip:1227) DEBUG: name = vblank
last_ts = 57.477505
last_received_ts = 57.476795
last_seq = 243
current_ts = 57.668442
current_received_ts = 57.667728
current_seq = 253
count = 22
seq_step = 10
(kms_flip:1227) DEBUG: vblank ts/seq: last 57.477505/243, current 57.668442/253: elapsed=190935.0us expected=191780.0us +- 958.9us, error 0.4%
(kms_flip:1227) DEBUG: name = flip
last_ts = 57.496601
last_received_ts = 57.667751
last_seq = 244
current_ts = 57.687523
current_received_ts = 57.858547
current_seq = 254
count = 23
seq_step = 1
(kms_flip:1227) DEBUG: flip ts/seq: last 57.496601/244, current 57.687523/254: elapsed=190921.0us expected=191780.0us +- 958.9us, error 0.4%
(kms_flip:1227) DEBUG: name = vblank
last_ts = 57.668442
last_received_ts = 57.667728
last_seq = 253
current_ts = 57.859230
current_received_ts = 57.858524
current_seq = 263
count = 23
seq_step = 10
(kms_flip:1227) DEBUG: vblank ts/seq: last 57.668442/253, current 57.859230/263: elapsed=190788.0us expected=191780.0us +- 958.9us, error 0.5%
(kms_flip:1227) DEBUG: inconsistent vblank ts/seq: last 57.668442/253, current 57.859230/263: elapsed=190788.0us expected=191780.0us
(kms_flip:1227) DEBUG: expected 211728, counted 230, encoder type 2
(kms_flip:1227) DEBUG: dropped frames, expected 211728, counted 230, encoder type 2
(kms_flip:1227) DEBUG: expected 211728, counted 230, encoder type 2
(kms_flip:1227) DEBUG: dropped frames, expected 211728, counted 230, encoder type 2
(kms_flip:1227) CRITICAL: Test assertion failure function __run_test_on_crtc_set, file ../tests/kms_flip.c:1674:
(kms_flip:1227) CRITICAL: Failed assertion: !retried && needs_retry_after_link_reset(mon)
(kms_flip:1227) igt_core-INFO: Stack trace:
(kms_flip:1227) igt_core-INFO:   #0 ../lib/igt_core.c:2051 __igt_fail_assert()
(kms_flip:1227) igt_core-INFO:   #1 ../tests/kms_flip.c:791 run_test_on_crtc_set.constprop.0()
(kms_flip:1227) igt_core-INFO:   #2 ../tests/kms_flip.c:1845 run_test()
(kms_flip:1227) igt_core-INFO:   #3 ../tests/kms_flip.c:2078 __igt_unique____real_main2001()
(kms_flip:1227) igt_core-INFO:   #4 ../tests/kms_flip.c:2001 main()
(kms_flip:1227) igt_core-INFO:   #5 [__libc_init_first+0x8a]
(kms_flip:1227) igt_core-INFO:   #6 [__libc_start_main+0x8b]
(kms_flip:1227) igt_core-INFO:   #7 [_start+0x25]
****  END  ****
Dynamic subtest B-HDMI-A1: FAIL (8.032s)
Subtest flip-vs-blocking-wf-vblank: FAIL (15.875s)
(kms_flip:1227) igt_kms-CRITICAL: Test assertion failure function kmstest_set_connector_dpms, file ../lib/igt_kms.c:2234:
(kms_flip:1227) igt_kms-CRITICAL: Failed assertion: found_it
(kms_flip:1227) igt_kms-CRITICAL: Last errno: 9, Bad file descriptor
(kms_flip:1227) igt_kms-CRITICAL: DPMS property not found on 137
Dmesg
<7> [44.815524] i915 0000:00:02.0: [drm:intel_power_well_disable [i915]] disabling DC_off
<7> [44.815770] i915 0000:00:02.0: [drm:skl_enable_dc6 [i915]] Enabling DC6
<7> [44.816023] i915 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [i915]] Setting DC state from 00 to 02
<6> [44.826863] Console: switching to colour dummy device 80x25
<6> [44.826897] [IGT] kms_flip: executing
<7> [44.828568] i915 0000:00:02.0: [drm:i915_gem_open [i915]]
<7> [44.828995] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc]
<7> [44.829132] i915 0000:00:02.0: [drm:i915_gem_open [i915]]
<7> [44.832293] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] [CONNECTOR:147:HDMI-A-2]
<7> [44.832306] i915 0000:00:02.0: [drm:intel_hdmi_detect [i915]] [CONNECTOR:147:HDMI-A-2]
<7> [44.836542] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] [CONNECTOR:147:HDMI-A-2] disconnected
<7> [44.836990] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] [CONNECTOR:151:DP-1]
<7> [44.837002] i915 0000:00:02.0: [drm:intel_dp_detect [i915]] [CONNECTOR:151:DP-1]
<7> [44.841527] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] [CONNECTOR:151:DP-1] disconnected
<7> [44.841999] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] [CONNECTOR:158:HDMI-A-3]
<7> [44.842011] i915 0000:00:02.0: [drm:intel_hdmi_detect [i915]] [CONNECTOR:158:HDMI-A-3]
<7> [44.846530] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] [CONNECTOR:158:HDMI-A-3] disconnected
<7> [44.846935] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] [CONNECTOR:137:HDMI-A-1]
<7> [44.846946] i915 0000:00:02.0: [drm:intel_hdmi_detect [i915]] [CONNECTOR:137:HDMI-A-1]
<7> [44.876997] i915 0000:00:02.0: [drm:update_display_info.part.0] [CONNECTOR:137:HDMI-A-1] Supported Monitor Refresh rate range is 0 Hz - 0 Hz
<7> [44.877011] i915 0000:00:02.0: [drm:update_display_info.part.0] [CONNECTOR:137:HDMI-A-1] Assigning EDID-1.4 digital sink color depth as 8 bpc.
<7> [44.877017] i915 0000:00:02.0: [drm:update_display_info.part.0] [CONNECTOR:137:HDMI-A-1] ELD monitor fitHeadless4k
<7> [44.877022] i915 0000:00:02.0: [drm:update_display_info.part.0] [CONNECTOR:137:HDMI-A-1] ELD size 36, SAD count 0
<7> [44.879545] i915 0000:00:02.0: [drm:drm_dp_dual_mode_detect [drm_display_helper]] DP dual mode HDMI ID: DP-HDMI ADAPTOR\004 (err 0)
<7> [44.882145] i915 0000:00:02.0: [drm:drm_dp_dual_mode_detect [drm_display_helper]] DP dual mode adaptor ID: a0 (err 0)
<7> [44.886063] i915 0000:00:02.0: [drm:intel_hdmi_set_edid [i915]] DP dual mode adaptor (type 2 HDMI) detected (max TMDS clock: 600000 kHz)
<7> [44.886342] i915 0000:00:02.0: [drm:intel_hdmi_set_edid [i915]] Ignoring DP dual mode adaptor max TMDS clock for native HDMI port
<7> [44.887290] 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> [44.887304] 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> [44.887314] 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> [44.887332] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] [CONNECTOR:137:HDMI-A-1] probed modes:
<7> [44.887351] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] Probed mode: "1920x1080": 53 139930 1920 2008 2096 2360 1080 1084 1089 1125 0x48 0x5
<7> [44.887370] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] Probed mode: "4088x2304": 10 108000 4088 4152 4280 4536 2304 2305 2308 2340 0x40 0x5
<7> [44.887389] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] Probed mode: "3840x2160": 15 128430 3840 3889 3921 4000 2160 2163 2169 2195 0x40 0xa
<7> [44.887407] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] Probed mode: "2880x1800": 11 60000 2880 2888 2984 3040 1800 1802 1820 1845 0x40 0xa
<7> [44.887425] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] Probed mode: "2560x1600": 13 60000 2560 2568 2664 2720 1600 1602 1620 1645 0x40 0xa
<7> [44.887442] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] Probed mode: "2560x1440": 15 60000 2560 2568 2664 2720 1440 1442 1460 1485 0x40 0xa
<7> [44.887460] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] Probed mode: "2048x1536": 17 60000 2048 2056 2152 2208 1536 1538 1556 1581 0x40 0xa
<7> [44.887478] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] Probed mode: "1600x1200": 60 162000 1600 1664 1856 2160 1200 1201 1204 1250 0x40 0x5
<7> [44.887495] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] Probed mode: "1680x1050": 60 146250 1680 1784 1960 2240 1050 1053 1059 1089 0x40 0x6
<7> [44.887526] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] Probed mode: "1600x900": 60 108000 1600 1624 1704 1800 900 901 904 1000 0x40 0x5
<7> [44.887544] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] Probed mode: "1280x1024": 75 135000 1280 1296 1440 1688 1024 1025 1028 1066 0x40 0x5
<7> [44.887562] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] Probed mode: "1360x768": 60 84963 1366 1431 1567 1776 768 771 781 798 0x0 0x6
<7> [44.887580] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] Probed mode: "1360x768": 20 25190 1360 1368 1464 1520 768 770 788 813 0x40 0xa
<7> [44.887598] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] Probed mode: "1280x800": 60 83500 1280 1352 1480 1680 800 803 809 831 0x40 0x6
<7> [44.887616] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] Probed mode: "1152x864": 75 108000 1152 1216 1344 1600 864 865 868 900 0x40 0x5
<7> [44.887633] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] Probed mode: "1280x720": 60 74250 1280 1390 1430 1650 720 725 730 750 0x40 0x5
<7> [44.887650] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] Probed mode: "1280x720": 60 74250 1280 1390 1430 1650 720 725 730 750 0x40 0x5
<7> [44.887667] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] Probed mode: "1280x720": 60 74176 1280 1390 1430 1650 720 725 730 750 0x40 0x5
<7> [44.887683] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] Probed mode: "1024x768": 75 78750 1024 1040 1136 1312 768 769 772 800 0x40 0x5
<7> [44.887700] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] Probed mode: "1024x768": 60 65000 1024 1048 1184 1344 768 771 777 806 0x40 0xa
<7> [44.887716] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] Probed mode: "1440x480": 60 54054 1440 1472 1596 1716 480 489 495 525 0x40 0xa
<7> [44.887733] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] Probed mode: "1440x480": 60 54000 1440 1472 1596 1716 480 489 495 525 0x40 0xa
<7> [44.887750] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] Probed mode: "1024x576": 60 46560 1024 1064 1160 1296 576 579 584 599 0x0 0x6
<7> [44.887766] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] Probed mode: "832x624": 75 57284 832 864 928 1152 624 625 628 667 0x40 0xa
<7> [44.887783] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] Probed mode: "800x600": 75 49500 800 816 896 1056 600 601 604 625 0x40 0x5
<7> [44.887800] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] Probed mode: "800x600": 60 40000 800 840 968 1056 600 601 605 628 0x40 0x5
<7> [44.887816] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] Probed mode: "640x480": 75 31500 640 656 720 840 480 481 484 500 0x40 0xa
<7> [44.887833] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] Probed mode: "640x480": 60 25200 640 656 752 800 480 490 492 525 0x40 0xa
<7> [44.887849] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] Probed mode: "640x480": 60 25175 640 656 752 800 480 490 492 525 0x40 0xa
<7> [44.887865] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] Probed mode: "640x480": 60 25175 640 656 752 800 480 490 492 525 0x40 0xa
<7> [44.887882] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] Probed mode: "720x400": 70 28320 720 738 846 900 400 412 414 449 0x40 0x6
<7> [44.887949] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] [CONNECTOR:147:HDMI-A-2]
<7> [44.887967] i915 0000:00:02.0: [drm:intel_hdmi_detect [i915]] [CONNECTOR:147:HDMI-A-2]
<7> [44.892539] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] [CONNECTOR:147:HDMI-A-2] disconnected
<7> [44.892575] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] [CONNECTOR:151:DP-1]
<7> [44.892590] i915 0000:00:02.0: [drm:intel_dp_detect [i915]] [CONNECTOR:151:DP-1]
<7> [44.897525] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] [CONNECTOR:151:DP-1] disconnected
<7> [44.897552] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] [CONNECTOR:158:HDMI-A-3]
<7> [44.897563] i915 0000:00:02.0: [drm:intel_hdmi_detect [i915]] [CONNECTOR:158:HDMI-A-3]
<7> [44.902554] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] [CONNECTOR:158:HDMI-A-3] disconnected
<6> [44.902820] [IGT] kms_flip: starting subtest flip-vs-blocking-wf-vblank
<6> [44.903763] [IGT] kms_flip: starting dynamic subtest A-HDMI-A1
<7> [44.903963] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:163]
<7> [44.903999] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:165]
<7> [44.942448] i915 0000:00:02.0: [drm:drm_mode_setcrtc] [CRTC:82:pipe A]
<7> [44.942571] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:82:pipe A] fastset requirement not met in hw.enable (expected yes, found no)
<7> [44.942865] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:82:pipe A] fastset requirement not met in hw.active (expected yes, found no)
<7> [44.943141] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:82:pipe A] fastset requirement not met in cpu_transcoder (expected 0, found -1)
<7> [44.943410] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:82:pipe A] fastset requirement not met in lane_count (expected 4, found 0)
<7> [44.943699] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:82:pipe A] fastset requirement not met in output_types (expected 0x00000040, found 0x00000000)
<7> [44.943968] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:82:pipe A] fastset requirement not met in framestart_delay (expected 1, found 0)
<7> [44.944231] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:82:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hdisplay (expected 1920, found 0)
<7> [44.944491] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:82:pipe A] fastset requirement not met in hw.pipe_mode.crtc_htotal (expected 2360, found 0)
<7> [44.944778] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:82:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hblank_start (expected 1920, found 0)
<7> [44.945056] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:82:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hblank_end (expected 2360, found 0)
<7> [44.945302] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:82:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hsync_start (expected 2008, found 0)
<7> [44.945553] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:82:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hsync_end (expected 2096, found 0)
<7> [44.945795] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:82:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vdisplay (expected 1080, found 0)
<7> [44.946033] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:82:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vblank_start (expected 1080, found 0)
<7> [44.946272] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:82:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vsync_start (expected 1084, found 0)
<7> [44.946514] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:82:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vsync_end (expected 1089, found 0)
<7> [44.946750] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:82:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vtotal (expected 1125, found 0)
<7> [44.946984] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:82:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vblank_end (expected 1125, found 0)
<7> [44.947220] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:82:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hdisplay (expected 1920, found 0)
<7> [44.947452] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:82:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_htotal (expected 2360, found 0)
<7> [44.947707] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:82:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hblank_start (expected 1920, found 0)
<7> [44.947942] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:82:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hblank_end (expected 2360, found 0)
<7> [44.948157] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:82:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hsync_start (expected 2008, found 0)
<7> [44.948336] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:82:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hsync_end (expected 2096, found 0)
<7> [44.948520] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:82:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vdisplay (expected 1080, found 0)
<7> [44.948699] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:82:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vblank_start (expected 1080, found 0)
<7> [44.948882] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:82:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vsync_start (expected 1084, found 0)
<7> [44.949065] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:82:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vsync_end (expected 1089, found 0)
<7> [44.949248] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:82:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vtotal (expected 1125, found 0)
<7> [44.949428] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:82:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vblank_end (expected 1125, found 0)
<7> [44.949619] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:82:pipe A] fastset requirement not met in pixel_multiplier (expected 1, found 0)
<7> [44.949796] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:82:pipe A] fastset requirement not met in hw.adjusted_mode.flags (1) (expected 1, found 0)
<7> [44.949973] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:82:pipe A] fastset requirement not met in hw.adjusted_mode.flags (4) (expected 4, found 0)
<7> [44.950153] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:82:pipe A] fastset requirement not met in pipe_bpp (expected 24, found 0)
<7> [44.950332] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:82:pipe A] fastset requirement not met in hw.pipe_mode.crtc_clock (expected 139929, found 0)
<7> [44.950516] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:82:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_clock (expected 139929, found 0)
<7> [44.950696] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:82:pipe A] fastset requirement not met in port_clock (expected 139929, found 0)
<7> [44.950877] i915 0000:00:02.0: [drm:intel_atomic_check [i915]] [CRTC:82:pipe A] fastset requirement not met, forcing full modeset
<7> [44.951055] i915 0000:00:02.0: [drm:intel_unreference_shared_dpll_crtc [i915]] [CRTC:82:pipe A] releasing DPLL 0
<7> [44.951225] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] Enabled dbuf slices 0x3 -> 0x1 (total dbuf slices 0x3), mbus joined? no->no
<7> [44.951354] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] [CRTC:82:pipe A] dbuf slices 0x3 -> 0x0, ddb (0 - 2048) -> (0 - 0), active pipes 0x1 -> 0x0
<7> [44.951515] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] [PLANE:32:plane 1A] ddb ( 0 - 2016) -> ( 0 - 0), size 2016 -> 0
<7> [44.951644] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] [PLANE:77:cursor A] ddb (2016 - 2048) -> ( 0 - 0), size 32 -> 0
<7> [44.951777] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] [PLANE:32: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> [44.951905] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] [PLANE:32:plane 1A] lines 1, 2, 2, 2, 2, 5, 8, 9, 0, 0, 0 -> 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0
<7> [44.952034] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] [PLANE:32:plane 1A] blocks 16, 33, 33, 33, 33, 81, 129, 145, 30, 0, 0 -> 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0
<7> [44.952161] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] [PLANE:32:plane 1A] min_ddb 19, 38, 38, 38, 38, 91, 143, 161, 31, 0, 0 -> 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0
<7> [44.952289] i915 0000:00:02.0: [drm:intel_bw_atomic_check [i915]] [CRTC:82:pipe A] data rate 0 num active planes 0
<7> [44.952429] i915 0000:00:02.0: [drm:intel_bw_atomic_check [i915]] QGV point 0: max bw 16761 required 0
<7> [44.952593] i915 0000:00:02.0: [drm:intel_modeset_calc_cdclk [i915]] New cdclk calculated to be logical 180000 kHz, actual 180000 kHz
<7> [44.952734] i915 0000:00:02.0: [drm:intel_modeset_calc_cdclk [i915]] New voltage level calculated to be logical 0, actual 0
<7> [44.952876] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [CRTC:82:pipe A] enable: no [modeset]
<7> [44.953014] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:32:plane 1A] fb: [NOFB], visible: no
<7> [44.953150] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:41:plane 2A] fb: [NOFB], visible: no
<7> [44.953289] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:50:plane 3A] fb: [NOFB], visible: no
<7> [44.953426] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:59:plane 4A] fb: [NOFB], visible: no
<7> [44.953576] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:68:plane 5A] fb: [NOFB], visible: no
<7> [44.953713] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:77:cursor A] fb: [NOFB], visible: no
<7> [44.953887] i915 0000:00:02.0: [drm:intel_power_well_enable [i915]] enabling DC_off
<7> [44.954028] i915 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [i915]] Setting DC state from 02 to 00
<7> [44.969009] i915 0000:00:02.0: [drm:intel_disable_transcoder [i915]] disabling pipe A
<7> [44.989918] i915 0000:00:02.0: [drm:intel_power_well_disable [i915]] disabling DDI_IO_B
<7> [44.990575] i915 0000:00:02.0: [drm:intel_dp_dual_mode_set_tmds_output [i915]] Disabling DP dual mode adaptor TMDS output
<7> [44.996044] i915 0000:00:02.0: [drm:intel_disable_shared_dpll [i915]] disable DPLL 0 (active 0x1, on? 1) for [CRTC:82:pipe A]
<7> [44.996675] i915 0000:00:02.0: [drm:intel_disable_shared_dpll [i915]] disabling DPLL 0
<7> [44.997238] i915 0000:00:02.0: [drm:__intel_fbc_disable [i915]] Disabling FBC on [PLANE:32:plane 1A]
<7> [44.997826] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:136:DDI B/PHY B]
<7> [44.998394] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:146:DDI TC1/PHY C]
<7> [44.998953] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:150:DDI TC2/PHY D]
<7> [44.999466] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:152:DP-MST A]
<7> [45.000027] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:153:DP-MST B]
<7> [45.000571] i915 0000:00:02.0: [drm:verify_connector_state [i915]] [CONNECTOR:137:HDMI-A-1]
<7> [45.001296] i915 0000:00:02.0: [drm:gen9_dbuf_slices_update [i915]] Updating dbuf slices to 0x1
<7> [45.002003] i915 0000:00:02.0: [drm:intel_modeset_verify_crtc [i915]] [CRTC:82:pipe A]
<7> [45.003040] i915 0000:00:02.0: [drm:drm_mode_setcrtc] [CRTC:134:pipe B]
<7> [45.003387] i915 0000:00:02.0: [drm:drm_mode_setcrtc] [CRTC:82:pipe A]
<7> [45.003446] i915 0000:00:02.0: [drm:drm_mode_setcrtc] [CONNECTOR:137:HDMI-A-1]
<7> [45.003581] i915 0000:00:02.0: [drm:intel_atomic_check [i915]] [CONNECTOR:137:HDMI-A-1] Limiting display bpp to 24 (EDID bpp 24, max requested bpp 36, max platform bpp 36)
<7> [45.004048] i915 0000:00:02.0: [drm:intel_hdmi_compute_clock [i915]] picking 8 bpc for HDMI output (pipe bpp: 24)
<7> [45.004435] i915 0000:00:02.0: [drm:intel_atomic_check [i915]] [CRTC:82:pipe A] hw max bpp: 24, pipe bpp: 24, dithering: 0
<7> [45.004930] i915 0000:00:02.0: [drm:intel_ddi_compute_config_late [i915]] [ENCODER:136:DDI B/PHY B] [CRTC:82:pipe A]
<7> [45.005273] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:82:pipe A] fastset requirement not met in hw.enable (expected no, found yes)
<7> [45.005626] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:82:pipe A] fastset requirement not met in hw.active (expected no, found yes)
<7> [45.005957] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:82:pipe A] fastset requirement not met in cpu_transcoder (expected -1, found 0)
<7> [45.006288] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:82:pipe A] fastset requirement not met in lane_count (expected 0, found 4)
<7> [45.006637] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:82:pipe A] fastset requirement not met in output_types (expected 0x00000000, found 0x00000040)
<7> [45.006971] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:82:pipe A] fastset requirement not met in framestart_delay (expected 0, found 1)
<7> [45.007300] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:82:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hdisplay (expected 0, found 1920)
<7> [45.007646] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:82:pipe A] fastset requirement not met in hw.pipe_mode.crtc_htotal (expected 0, found 2360)
<7> [45.007976] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:82:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hblank_start (expected 0, found 1920)
<7> [45.008262] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:82:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hblank_end (expected 0, found 2360)
<7> [45.008526] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:82:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hsync_start (expected 0, found 2008)
<7> [45.008777] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:82:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hsync_end (expected 0, found 2096)
<7> [45.009024] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:82:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vdisplay (expected 0, found 1080)
<7> [45.009273] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:82:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vblank_start (expected 0, found 1080)
<7> [45.009532] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:82:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vsync_start (expected 0, found 1084)
<7> [45.009778] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:82:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vsync_end (expected 0, found 1089)
<7> [45.010022] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:82:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vtotal (expected 0, found 1125)
<7> [45.010266] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:82:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vblank_end (expected 0, found 1125)
<7> [45.010519] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:82:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hdisplay (expected 0, found 1920)
<7> [45.010763] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:82:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_htotal (expected 0, found 2360)
<7> [45.011011] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:82:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hblank_start (expected 0, found 1920)
<7> [45.011221] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:82:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hblank_end (expected 0, found 2360)
<7> [45.011392] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:82:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hsync_start (expected 0, found 2008)
<7> [45.011578] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:82:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hsync_end (expected 0, found 2096)
<7> [45.011748] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:82:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vdisplay (expected 0, found 1080)
<7> [45.011923] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:82:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vblank_start (expected 0, found 1080)
<7> [45.012102] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:82:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vsync_start (expected 0, found 1084)
<7> [45.012279] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:82:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vsync_end (expected 0, found 1089)
<7> [45.012455] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:82:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vtotal (expected 0, found 1125)
<7> [45.012643] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:82:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vblank_end (expected 0, found 1125)
<7> [45.012817] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:82:pipe A] fastset requirement not met in pixel_multiplier (expected 0, found 1)
<7> [45.012989] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:82:pipe A] fastset requirement not met in hw.adjusted_mode.flags (1) (expected 0, found 1)
<7> [45.013165] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:82:pipe A] fastset requirement not met in hw.adjusted_mode.flags (4) (expected 0, found 4)
<7> [45.013339] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:82:pipe A] fastset requirement not met in pipe_bpp (expected 0, found 24)
<7> [45.013521] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:82:pipe A] fastset requirement not met in hw.pipe_mode.crtc_clock (expected 0, found 139929)
<7> [45.013694] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:82:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_clock (expected 0, found 139929)
<7> [45.013866] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:82:pipe A] fastset requirement not met in port_clock (expected 0, found 139929)
<7> [45.014039] i915 0000:00:02.0: [drm:intel_atomic_check [i915]] [CRTC:82:pipe A] fastset requirement not met, forcing full modeset
<7> [45.014216] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] Enabled dbuf slices 0x1 -> 0x3 (total dbuf slices 0x3), mbus joined? no->no
<7> [45.014333] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] [CRTC:82:pipe A] dbuf slices 0x0 -> 0x3, ddb (0 - 0) -> (0 - 2048), active pipes 0x0 -> 0x1
<7> [45.014471] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] [PLANE:32:plane 1A] ddb ( 0 - 0) -> ( 0 - 2016), size 0 -> 2016
<7> [45.014603] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] [PLANE:77:cursor A] ddb ( 0 - 0) -> (2016 - 2048), size 0 -> 32
<7> [45.014723] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] [PLANE:32: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> [45.014839] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] [PLANE:32:plane 1A] lines 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0 -> 1, 2, 2, 2, 2, 5, 8, 9, 0, 0, 0
<7> [45.014958] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] [PLANE:32:plane 1A] blocks 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0 -> 16, 33, 33, 33, 33, 81, 129, 145, 30, 0, 0
<7> [45.015072] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] [PLANE:32:plane 1A] min_ddb 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0 -> 19, 38, 38, 38, 38, 91, 143, 161, 31, 0, 0
<7> [45.015188] i915 0000:00:02.0: [drm:intel_bw_atomic_check [i915]] [CRTC:82:pipe A] data rate 559716 num active planes 1
<7> [45.015317] i915 0000:00:02.0: [drm:intel_bw_atomic_check [i915]] QGV point 0: max bw 16761 required 560
<7> [45.015445] i915 0000:00:02.0: [drm:intel_bw_atomic_check [i915]] No SAGV, using single QGV point mask 0x1
<7> [45.015588] i915 0000:00:02.0: [drm:intel_plane_calc_min_cdclk [i915]] [PLANE:32:plane 1A] min cdclk (69965 kHz) > [CRTC:82:pipe A] min cdclk (0 kHz)
<7> [45.015723] i915 0000:00:02.0: [drm:intel_bw_calc_min_cdclk [i915]] new bandwidth min cdclk (10932 kHz) > old min cdclk (0 kHz)
<7> [45.015858] i915 0000:00:02.0: [drm:intel_modeset_calc_cdclk [i915]] New cdclk calculated to be logical 180000 kHz, actual 180000 kHz
<7> [45.015986] i915 0000:00:02.0: [drm:intel_modeset_calc_cdclk [i915]] New voltage level calculated to be logical 0, actual 0
<7> [45.016112] i915 0000:00:02.0: [drm:intel_find_shared_dpll [i915]] [CRTC:82:pipe A] allocated DPLL 0
<7> [45.016237] i915 0000:00:02.0: [drm:intel_reference_shared_dpll_crtc [i915]] [CRTC:82:pipe A] reserving DPLL 0
<7> [45.016361] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [CRTC:82:pipe A] enable: yes [modeset]
<7> [45.016487] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] active: yes, output_types: HDMI (0x40), output format: RGB, sink format: RGB
<7> [45.016626] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] cpu_transcoder: A, pipe bpp: 24, dithering: 0
<7> [45.016751] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] MST master transcoder: <invalid>
<7> [45.016876] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] port sync: master transcoder: <invalid>, slave transcoder bitmask = 0x0
<7> [45.017019] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] joiner: no, pipes: 0x0
<7> [45.017139] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] splitter: disabled, link count 0, overlap 0
<7> [45.017261] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] framestart delay: 1, MSA timing delay: 0
<7> [45.017385] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] audio: 0, infoframes: 0, infoframes enabled: 0x0
<7> [45.017520] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] vrr: no, vmin: 0, vmax: 0, pipeline full: 0, guardband: 0 flipline: 0, vmin vblank: -1, vmax vblank: -2
<7> [45.017648] 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> [45.017780] 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> [45.017906] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] crtc timings: clock=139929, hd=1920 hb=1920-2360 hs=2008-2096 ht=2360, vd=1080 vb=1080-1125 vs=1084-1089 vt=1125, flags=0x5
<7> [45.018031] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pipe mode: "1920x1080": 53 139929 1920 2008 2096 2360 1080 1084 1089 1125 0x40 0x5
<7> [45.018157] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] crtc timings: clock=139929, hd=1920 hb=1920-2360 hs=2008-2096 ht=2360, vd=1080 vb=1080-1125 vs=1084-1089 vt=1125, flags=0x5
<7> [45.018281] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] port clock: 139929, pipe src: 1920x1080+0+0, pixel rate 139929
<7> [45.018404] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] linetime: 135, ips linetime: 0
<7> [45.018534] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] num_scalers: 2, scaler_users: 0x0, scaler_id: -1, scaling_filter: 0
<7> [45.018658] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pch pfit: 0x0+0+0, disabled, force thru: no
<7> [45.018782] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] ips: 0, double wide: 0, drrs: 0
<7> [45.018905] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] dpll_hw_state: cfgcr0: 0x1a6655d, 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> [45.019028] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] csc_mode: 0x0 gamma_mode: 0x0 gamma_enable: 0 csc_enable: 0
<7> [45.019149] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pre csc lut: 0 entries, post csc lut: 0 entries
<7> [45.019271] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] output csc: pre offsets: 0x0000 0x0000 0x0000
<7> [45.019395] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] output csc: coefficients: 0x0000 0x0000 0x0000
<7> [45.019522] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] output csc: coefficients: 0x0000 0x0000 0x0000
<7> [45.019645] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] output csc: coefficients: 0x0000 0x0000 0x0000
<7> [45.019768] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] output csc: post offsets: 0x0000 0x0000 0x0000
<7> [45.019890] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pipe csc: pre offsets: 0x0000 0x0000 0x0000
<7> [45.020012] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pipe csc: coefficients: 0x0000 0x0000 0x0000
<7> [45.020134] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pipe csc: coefficients: 0x0000 0x0000 0x0000
<7> [45.020255] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pipe csc: coefficients: 0x0000 0x0000 0x0000
<7> [45.020378] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pipe csc: post offsets: 0x0000 0x0000 0x0000
<7> [45.020507] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:32:plane 1A] fb: [FB:163] 1920x1080 format = XR24 little-endian (0x34325258) modifier = 0x0, visible: yes
<7> [45.020637] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] rotation: 0x1, scaler: -1, scaling_filter: 0
<7> [45.020764] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] src: 1920.000000x1080.000000+0.000000+0.000000 dst: 1920x1080+0+0
<7> [45.020890] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:41:plane 2A] fb: [NOFB], visible: no
<7> [45.021020] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:50:plane 3A] fb: [NOFB], visible: no
<7> [45.021145] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:59:plane 4A] fb: [NOFB], visible: no
<7> [45.021269] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:68:plane 5A] fb: [NOFB], visible: no
<7> [45.021392] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:77:cursor A] fb: [NOFB], visible: no
<7> [45.022013] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:136:DDI B/PHY B]
<7> [45.022135] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:146:DDI TC1/PHY C]
<7> [45.022255] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:150:DDI TC2/PHY D]
<7> [45.022376] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:152:DP-MST A]
<7> [45.022496] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:153:DP-MST B]
<7> [45.022659] i915 0000:00:02.0: [drm:gen9_dbuf_slices_update [i915]] Updating dbuf slices to 0x3
<7> [45.022819] i915 0000:00:02.0: [drm:intel_enable_shared_dpll [i915]] enable DPLL 0 (active 0x1, on? 0) for [CRTC:82:pipe A]
<7> [45.022949] i915 0000:00:02.0: [drm:intel_enable_shared_dpll [i915]] enabling DPLL 0
<7> [45.023414] i915 0000:00:02.0: [drm:intel_dp_dual_mode_set_tmds_output [i915]] Enabling DP dual mode adaptor TMDS output
<7> [45.028699] i915 0000:00:02.0: [drm:intel_power_well_enable [i915]] enabling DDI_IO_B
<7> [45.028862] i915 0000:00:02.0: [drm:intel_enable_transcoder [i915]] enabling pipe A
<7> [45.029217] i915 0000:00:02.0: [drm:intel_fbc_update [i915]] reserved 17694720 bytes of contiguous stolen space for FBC, limit: 1
<7> [45.029345] i915 0000:00:02.0: [drm:intel_fbc_update [i915]] Enabling FBC on [PLANE:32:plane 1A]
<7> [45.048294] i915 0000:00:02.0: [drm:verify_connector_state [i915]] [CONNECTOR:137:HDMI-A-1]
<7> [45.048560] i915 0000:00:02.0: [drm:intel_modeset_verify_crtc [i915]] [CRTC:82:pipe A]
<7> [45.066571] i915 0000:00:02.0: [drm:intel_power_well_disable [i915]] disabling DC_off
<7> [45.067165] i915 0000:00:02.0: [drm:skl_enable_dc6 [i915]] Enabling DC6
<7> [45.067782] i915 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [i915]] Setting DC state from 00 to 02
<7> [45.376362] i915 0000:00:02.0: [drm:intel_power_well_enable [i915]] enabling DC_off
<7> [45.377131] i915 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [i915]] Setting DC state from 02 to 00
<7> [45.426566] i915 0000:00:02.0: [drm:intel_power_well_disable [i915]] disabling DC_off
<7> [45.427138] i915 0000:00:02.0: [drm:skl_enable_dc6 [i915]] Enabling DC6
<7> [45.427726] i915 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [i915]] Setting DC state from 00 to 02
<7> [45.580016] i915 0000:00:02.0: [drm:intel_power_well_enable [i915]] enabling DC_off
<7> [45.580631] i915 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [i915]] Setting DC state from 02 to 00
<7> [45.616572] i915 0000:00:02.0: [drm:intel_power_well_disable [i915]] disabling DC_off
<7> [45.617124] i915 0000:00:02.0: [drm:skl_enable_dc6 [i915]] Enabling DC6
<7> [45.617713] i915 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [i915]] Setting DC state from 00 to 02
<7> [45.769773] i915 0000:00:02.0: [drm:intel_power_well_enable [i915]] enabling DC_off
<7> [45.770324] i915 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [i915]] Setting DC state from 02 to 00
<7> [45.805571] i915 0000:00:02.0: [drm:intel_power_well_disable [i915]] disabling DC_off
<7> [45.806162] i915 0000:00:02.0: [drm:skl_enable_dc6 [i915]] Enabling DC6
<7> [45.806765] i915 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [i915]] Setting DC state from 00 to 02
<7> [45.959530] i915 0000:00:02.0: [drm:intel_power_well_enable [i915]] enabling DC_off
<7> [45.960092] i915 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [i915]] Setting DC state from 02 to 00
<7> [45.995633] i915 0000:00:02.0: [drm:intel_power_well_disable [i915]] disabling DC_off
<7> [45.996193] i915 0000:00:02.0: [drm:skl_enable_dc6 [i915]] Enabling DC6
<7> [45.996779] i915 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [i915]] Setting DC state from 00 to 02
<7> [46.149238] i915 0000:00:02.0: [drm:intel_power_well_enable [i915]] enabling DC_off
<7> [46.149852] i915 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [i915]] Setting DC state from 02 to 00
<7> [46.185572] i915 0000:00:02.0: [drm:intel_power_well_disable [i915]] disabling DC_off
<7> [46.186142] i915 0000:00:02.0: [drm:skl_enable_dc6 [i915]] Enabling DC6
<7> [46.186765] i915 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [i915]] Setting DC state from 00 to 02
<7> [46.339004] i915 0000:00:02.0: [drm:intel_power_well_enable [i915]] enabling DC_off
<7> [46.339580] i915 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [i915]] Setting DC state from 02 to 00
<7> [46.374570] i915 0000:00:02.0: [drm:intel_power_well_disable [i915]] disabling DC_off
<7> [46.375124] i915 0000:00:02.0: [drm:skl_enable_dc6 [i915]] Enabling DC6
<7> [46.375698] i915 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [i915]] Setting DC state from 00 to 02
<7> [46.528725] i915 0000:00:02.0: [drm:intel_power_well_enable [i915]] enabling DC_off
<7> [46.529290] i915 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [i915]] Setting DC state from 02 to 00
<7> [46.564572] i915 0000:00:02.0: [drm:intel_power_well_disable [i915]] disabling DC_off
<7> [46.565156] i915 0000:00:02.0: [drm:skl_enable_dc6 [i915]] Enabling DC6
<7> [46.565754] i915 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [i915]] Setting DC state from 00 to 02
<7> [46.718112] i915 0000:00:02.0: [drm:intel_power_well_enable [i915]] enabling DC_off
<7> [46.718268] i915 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [i915]] Setting DC state from 02 to 00
<7> [46.754572] i915 0000:00:02.0: [drm:intel_power_well_disable [i915]] disabling DC_off
<7> [46.755153] i915 0000:00:02.0: [drm:skl_enable_dc6 [i915]] Enabling DC6
<7> [46.755753] i915 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [i915]] Setting DC state from 00 to 02
<7> [46.908186] i915 0000:00:02.0: [drm:intel_power_well_enable [i915]] enabling DC_off
<7> [46.908795] i915 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [i915]] Setting DC state from 02 to 00
<7> [46.944562] i915 0000:00:02.0: [drm:intel_power_well_disable [i915]] disabling DC_off
<7> [46.945119] i915 0000:00:02.0: [drm:skl_enable_dc6 [i915]] Enabling DC6
<7> [46.945693] i915 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [i915]] Setting DC state from 00 to 02
<7> [47.098012] i915 0000:00:02.0: [drm:intel_power_well_enable [i915]] enabling DC_off
<7> [47.098605] i915 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [i915]] Setting DC state from 02 to 00
<7> [47.133571] i915 0000:00:02.0: [drm:intel_power_well_disable [i915]] disabling DC_off
<7> [47.134155] i915 0000:00:02.0: [drm:skl_enable_dc6 [i915]] Enabling DC6
<7> [47.134761] i915 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [i915]] Setting DC state from 00 to 02
<7> [47.287646] i915 0000:00:02.0: [drm:intel_power_well_enable [i915]] enabling DC_off
<7> [47.288196] i915 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [i915]] Setting DC state from 02 to 00
<7> [47.323570] i915 0000:00:02.0: [drm:intel_power_well_disable [i915]] disabling DC_off
<7> [47.324115] i915 0000:00:02.0: [drm:skl_enable_dc6 [i915]] Enabling DC6
<7> [47.324692] i915 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [i915]] Setting DC state from 00 to 02
<7> [47.477380] i915 0000:00:02.0: [drm:intel_power_well_enable [i915]] enabling DC_off
<7> [47.477982] i915 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [i915]] Setting DC state from 02 to 00
<7> [47.513565] i915 0000:00:02.0: [drm:intel_power_well_disable [i915]] disabling DC_off
<7> [47.514105] i915 0000:00:02.0: [drm:skl_enable_dc6 [i915]] Enabling DC6
<7> [47.514668] i915 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [i915]] Setting DC state from 00 to 02
<7> [47.667112] i915 0000:00:02.0: [drm:intel_power_well_enable [i915]] enabling DC_off
<7> [47.667681] i915 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [i915]] Setting DC state from 02 to 00
<7> [47.703570] i915 0000:00:02.0: [drm:intel_power_well_disable [i915]] disabling DC_off
<7> [47.704112] i915 0000:00:02.0: [drm:skl_enable_dc6 [i915]] Enabling DC6
<7> [47.704690] i915 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [i915]] Setting DC state from 00 to 02
<7> [47.856868] i915 0000:00:02.0: [drm:intel_power_well_enable [i915]] enabling DC_off
<7> [47.857391] i915 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [i915]] Setting DC state from 02 to 00
<7> [47.892575] i915 0000:00:02.0: [drm:intel_power_well_disable [i915]] disabling DC_off
<7> [47.893121] i915 0000:00:02.0: [drm:skl_enable_dc6 [i915]] Enabling DC6
<7> [47.893684] i915 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [i915]] Setting DC state from 00 to 02
<7> [48.046759] i915 0000:00:02.0: [drm:intel_power_well_enable [i915]] enabling DC_off
<7> [48.047345] i915 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [i915]] Setting DC state from 02 to 00
<7> [48.082576] i915 0000:00:02.0: [drm:intel_power_well_disable [i915]] disabling DC_off
<7> [48.083151] i915 0000:00:02.0: [drm:skl_enable_dc6 [i915]] Enabling DC6
<7> [48.083751] i915 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [i915]] Setting DC state from 00 to 02
<7> [48.236739] i915 0000:00:02.0: [drm:intel_power_well_enable [i915]] enabling DC_off
<7> [48.237319] i915 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [i915]] Setting DC state from 02 to 00
<7> [48.272568] i915 0000:00:02.0: [drm:intel_power_well_disable [i915]] disabling DC_off
<7> [48.273122] i915 0000:00:02.0: [drm:skl_enable_dc6 [i915]] Enabling DC6
<7> [48.273698] i915 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [i915]] Setting DC state from 00 to 02
<7> [48.426098] i915 0000:00:02.0: [drm:intel_power_well_enable [i915]] enabling DC_off
<7> [48.426708] i915 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [i915]] Setting DC state from 02 to 00
<7> [48.462561] i915 0000:00:02.0: [drm:intel_power_well_disable [i915]] disabling DC_off
<7> [48.463099] i915 0000:00:02.0: [drm:skl_enable_dc6 [i915]] Enabling DC6
<7> [48.463666] i915 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [i915]] Setting DC state from 00 to 02
<7> [48.615823] i915 0000:00:02.0: [drm:intel_power_well_enable [i915]] enabling DC_off
<7> [48.616367] i915 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [i915]] Setting DC state from 02 to 00
<7> [48.651564] i915 0000:00:02.0: [drm:intel_power_well_disable [i915]] disabling DC_off
<7> [48.652108] i915 0000:00:02.0: [drm:skl_enable_dc6 [i915]] Enabling DC6
<7> [48.652665] i915 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [i915]] Setting DC state from 00 to 02
<7> [48.805534] i915 0000:00:02.0: [drm:intel_power_well_enable [i915]] enabling DC_off
<7> [48.806087] i915 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [i915]] Setting DC state from 02 to 00
<7> [48.841565] i915 0000:00:02.0: [drm:intel_power_well_disable [i915]] disabling DC_off
<7> [48.842124] i915 0000:00:02.0: [drm:skl_enable_dc6 [i915]] Enabling DC6
<7> [48.842702] i915 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [i915]] Setting DC state from 00 to 02
<7> [48.995248] i915 0000:00:02.0: [drm:intel_power_well_enable [i915]] enabling DC_off
<7> [48.995842] i915 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [i915]] Setting DC state from 02 to 00
<7> [49.031565] i915 0000:00:02.0: [drm:intel_power_well_disable [i915]] disabling DC_off
<7> [49.032111] i915 0000:00:02.0: [drm:skl_enable_dc6 [i915]] Enabling DC6
<7> [49.032679] i915 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [i915]] Setting DC state from 00 to 02
<7> [49.185032] i915 0000:00:02.0: [drm:intel_power_well_enable [i915]] enabling DC_off
<7> [49.185692] i915 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [i915]] Setting DC state from 02 to 00
<7> [49.221564] i915 0000:00:02.0: [drm:intel_power_well_disable [i915]] disabling DC_off
<7> [49.222097] i915 0000:00:02.0: [drm:skl_enable_dc6 [i915]] Enabling DC6
<7> [49.222652] i915 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [i915]] Setting DC state from 00 to 02
<7> [49.374760] i915 0000:00:02.0: [drm:intel_power_well_enable [i915]] enabling DC_off
<7> [49.375332] i915 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [i915]] Setting DC state from 02 to 00
<7> [49.410574] i915 0000:00:02.0: [drm:intel_power_well_disable [i915]] disabling DC_off
<7> [49.411163] i915 0000:00:02.0: [drm:skl_enable_dc6 [i915]] Enabling DC6
<7> [49.411766] i915 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [i915]] Setting DC state from 00 to 02
<7> [49.564536] i915 0000:00:02.0: [drm:intel_power_well_enable [i915]] enabling DC_off
<7> [49.565094] i915 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [i915]] Setting DC state from 02 to 00
<7> [49.600571] i915 0000:00:02.0: [drm:intel_power_well_disable [i915]] disabling DC_off
<7> [49.601156] i915 0000:00:02.0: [drm:skl_enable_dc6 [i915]] Enabling DC6
<7> [49.601766] i915 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [i915]] Setting DC state from 00 to 02
<6> [52.744194] [IGT] kms_flip: finished subtest A-HDMI-A1, FAIL
<6> [52.744550] [IGT] kms_flip: starting dynamic subtest B-HDMI-A1
<7> [52.744875] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:166]
<7> [52.744941] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:167]
<7> [52.778117] i915 0000:00:02.0: [drm:drm_mode_setcrtc] [CRTC:82:pipe A]
<7> [52.778251] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:82:pipe A] fastset requirement not met in hw.enable (expected yes, found no)
<7> [52.778646] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:82:pipe A] fastset requirement not met in hw.active (expected yes, found no)
<7> [52.779022] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:82:pipe A] fastset requirement not met in cpu_transcoder (expected 0, found -1)
<7> [52.779428] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:82:pipe A] fastset requirement not met in lane_count (expected 4, found 0)
<7> [52.779786] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:82:pipe A] fastset requirement not met in output_types (expected 0x00000040, found 0x00000000)
<7> [52.780156] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:82:pipe A] fastset requirement not met in framestart_delay (expected 1, found 0)
<7> [52.780505] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:82:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hdisplay (expected 1920, found 0)
<7> [52.780855] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:82:pipe A] fastset requirement not met in hw.pipe_mode.crtc_htotal (expected 2360, found 0)
<7> [52.781202] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:82:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hblank_start (expected 1920, found 0)
<7> [52.781504] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:82:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hblank_end (expected 2360, found 0)
<7> [52.781802] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:82:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hsync_start (expected 2008, found 0)
<7> [52.782125] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:82:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hsync_end (expected 2096, found 0)
<7> [52.782431] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:82:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vdisplay (expected 1080, found 0)
<7> [52.782737] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:82:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vblank_start (expected 1080, found 0)
<7> [52.783050] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:82:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vsync_start (expected 1084, found 0)
<7> [52.783347] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:82:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vsync_end (expected 1089, found 0)
<7> [52.783646] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:82:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vtotal (expected 1125, found 0)
<7> [52.783940] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:82:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vblank_end (expected 1125, found 0)
<7> [52.784230] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:82:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hdisplay (expected 1920, found 0)
<7> [52.784467] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:82:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_htotal (expected 2360, found 0)
<7> [52.784700] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:82:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hblank_start (expected 1920, found 0)
<7> [52.784932] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:82:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hblank_end (expected 2360, found 0)
<7> [52.785139] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:82:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hsync_start (expected 2008, found 0)
<7> [52.785262] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:82:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hsync_end (expected 2096, found 0)
<7> [52.785384] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:82:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vdisplay (expected 1080, found 0)
<7> [52.785505] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:82:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vblank_start (expected 1080, found 0)
<7> [52.785626] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:82:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vsync_start (expected 1084, found 0)
<7> [52.785747] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:82:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vsync_end (expected 1089, found 0)
<7> [52.785867] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:82:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vtotal (expected 1125, found 0)
<7> [52.785990] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:82:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vblank_end (expected 1125, found 0)
<7> [52.786126] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:82:pipe A] fastset requirement not met in pixel_multiplier (expected 1, found 0)
<7> [52.786250] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:82:pipe A] fastset requirement not met in hw.adjusted_mode.flags (1) (expected 1, found 0)
<7> [52.786370] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:82:pipe A] fastset requirement not met in hw.adjusted_mode.flags (4) (expected 4, found 0)
<7> [52.786491] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:82:pipe A] fastset requirement not met in pipe_bpp (expected 24, found 0)
<7> [52.786612] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:82:pipe A] fastset requirement not met in hw.pipe_mode.crtc_clock (expected 139929, found 0)
<7> [52.786733] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:82:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_clock (expected 139929, found 0)
<7> [52.786859] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:82:pipe A] fastset requirement not met in port_clock (expected 139929, found 0)
<7> [52.786982] i915 0000:00:02.0: [drm:intel_atomic_check [i915]] [CRTC:82:pipe A] fastset requirement not met, forcing full modeset
<7> [52.787121] i915 0000:00:02.0: [drm:intel_unreference_shared_dpll_crtc [i915]] [CRTC:82:pipe A] releasing DPLL 0
<7> [52.787261] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] Enabled dbuf slices 0x3 -> 0x1 (total dbuf slices 0x3), mbus joined? no->no
<7> [52.787379] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] [CRTC:82:pipe A] dbuf slices 0x3 -> 0x0, ddb (0 - 2048) -> (0 - 0), active pipes 0x1 -> 0x0
<7> [52.787518] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] [PLANE:32:plane 1A] ddb ( 0 - 2016) -> ( 0 - 0), size 2016 -> 0
<7> [52.787636] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] [PLANE:77:cursor A] ddb (2016 - 2048) -> ( 0 - 0), size 32 -> 0
<7> [52.787754] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] [PLANE:32: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> [52.787869] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] [PLANE:32:plane 1A] lines 1, 2, 2, 2, 2, 5, 8, 9, 0, 0, 0 -> 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0
<7> [52.787992] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] [PLANE:32:plane 1A] blocks 16, 33, 33, 33, 33, 81, 129, 145, 30, 0, 0 -> 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0
<7> [52.788106] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] [PLANE:32:plane 1A] min_ddb 19, 38, 38, 38, 38, 91, 143, 161, 31, 0, 0 -> 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0
<7> [52.788222] i915 0000:00:02.0: [drm:intel_bw_atomic_check [i915]] [CRTC:82:pipe A] data rate 0 num active planes 0
<7> [52.788350] i915 0000:00:02.0: [drm:intel_bw_atomic_check [i915]] QGV point 0: max bw 16761 required 0
<7> [52.788485] i915 0000:00:02.0: [drm:intel_modeset_calc_cdclk [i915]] New cdclk calculated to be logical 180000 kHz, actual 180000 kHz
<7> [52.788612] i915 0000:00:02.0: [drm:intel_modeset_calc_cdclk [i915]] New voltage level calculated to be logical 0, actual 0
<7> [52.788742] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [CRTC:82:pipe A] enable: no [modeset]
<7> [52.788870] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:32:plane 1A] fb: [NOFB], visible: no
<7> [52.789004] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:41:plane 2A] fb: [NOFB], visible: no
<7> [52.789129] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:50:plane 3A] fb: [NOFB], visible: no
<7> [52.789252] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:59:plane 4A] fb: [NOFB], visible: no
<7> [52.789376] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:68:plane 5A] fb: [NOFB], visible: no
<7> [52.789499] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:77:cursor A] fb: [NOFB], visible: no
<7> [52.789658] i915 0000:00:02.0: [drm:intel_power_well_enable [i915]] enabling DC_off
<7> [52.789786] i915 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [i915]] Setting DC state from 02 to 00
<7> [52.809066] i915 0000:00:02.0: [drm:intel_disable_transcoder [i915]] disabling pipe A
<7> [52.827480] i915 0000:00:02.0: [drm:intel_power_well_disable [i915]] disabling DDI_IO_B
<7> [52.828024] i915 0000:00:02.0: [drm:intel_dp_dual_mode_set_tmds_output [i915]] Disabling DP dual mode adaptor TMDS output
<7> [52.833438] i915 0000:00:02.0: [drm:intel_disable_shared_dpll [i915]] disable DPLL 0 (active 0x1, on? 1) for [CRTC:82:pipe A]
<7> [52.834024] i915 0000:00:02.0: [drm:intel_disable_shared_dpll [i915]] disabling DPLL 0
<7> [52.834559] i915 0000:00:02.0: [drm:__intel_fbc_disable [i915]] Disabling FBC on [PLANE:32:plane 1A]
<7> [52.835054] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:136:DDI B/PHY B]
<7> [52.835663] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:146:DDI TC1/PHY C]
<7> [52.836249] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:150:DDI TC2/PHY D]
<7> [52.836806] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:152:DP-MST A]
<7> [52.837322] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:153:DP-MST B]
<7> [52.837880] i915 0000:00:02.0: [drm:verify_connector_state [i915]] [CONNECTOR:137:HDMI-A-1]
<7> [52.838503] i915 0000:00:02.0: [drm:gen9_dbuf_slices_update [i915]] Updating dbuf slices to 0x1
<7> [52.839022] i915 0000:00:02.0: [drm:intel_modeset_verify_crtc [i915]] [CRTC:82:pipe A]
<7> [52.839968] i915 0000:00:02.0: [drm:drm_mode_setcrtc] [CRTC:134:pipe B]
<7> [52.840287] i915 0000:00:02.0: [drm:drm_mode_setcrtc] [CRTC:134:pipe B]
<7> [52.840338] i915 0000:00:02.0: [drm:drm_mode_setcrtc] [CONNECTOR:137:HDMI-A-1]
<7> [52.840490] i915 0000:00:02.0: [drm:intel_atomic_check [i915]] [CONNECTOR:137:HDMI-A-1] Limiting display bpp to 24 (EDID bpp 24, max requested bpp 36, max platform bpp 36)
<7> [52.840924] i915 0000:00:02.0: [drm:intel_hdmi_compute_clock [i915]] picking 8 bpc for HDMI output (pipe bpp: 24)
<7> [52.841260] i915 0000:00:02.0: [drm:intel_atomic_check [i915]] [CRTC:134:pipe B] hw max bpp: 24, pipe bpp: 24, dithering: 0
<7> [52.841600] i915 0000:00:02.0: [drm:intel_ddi_compute_config_late [i915]] [ENCODER:136:DDI B/PHY B] [CRTC:134:pipe B]
<7> [52.841900] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:134:pipe B] fastset requirement not met in hw.enable (expected no, found yes)
<7> [52.842219] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:134:pipe B] fastset requirement not met in hw.active (expected no, found yes)
<7> [52.842554] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:134:pipe B] fastset requirement not met in cpu_transcoder (expected -1, found 1)
<7> [52.842869] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:134:pipe B] fastset requirement not met in lane_count (expected 0, found 4)
<7> [52.843175] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:134:pipe B] fastset requirement not met in output_types (expected 0x00000000, found 0x00000040)
<7> [52.843507] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:134:pipe B] fastset requirement not met in framestart_delay (expected 0, found 1)
<7> [52.843819] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:134:pipe B] fastset requirement not met in hw.pipe_mode.crtc_hdisplay (expected 0, found 1920)
<7> [52.844128] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:134:pipe B] fastset requirement not met in hw.pipe_mode.crtc_htotal (expected 0, found 2360)
<7> [52.844358] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:134:pipe B] fastset requirement not met in hw.pipe_mode.crtc_hblank_start (expected 0, found 1920)
<7> [52.844606] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:134:pipe B] fastset requirement not met in hw.pipe_mode.crtc_hblank_end (expected 0, found 2360)
<7> [52.844831] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:134:pipe B] fastset requirement not met in hw.pipe_mode.crtc_hsync_start (expected 0, found 2008)
<7> [52.845053] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:134:pipe B] fastset requirement not met in hw.pipe_mode.crtc_hsync_end (expected 0, found 2096)
<7> [52.845278] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:134:pipe B] fastset requirement not met in hw.pipe_mode.crtc_vdisplay (expected 0, found 1080)
<7> [52.845517] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:134:pipe B] fastset requirement not met in hw.pipe_mode.crtc_vblank_start (expected 0, found 1080)
<7> [52.845743] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:134:pipe B] fastset requirement not met in hw.pipe_mode.crtc_vsync_start (expected 0, found 1084)
<7> [52.845970] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:134:pipe B] fastset requirement not met in hw.pipe_mode.crtc_vsync_end (expected 0, found 1089)
<7> [52.846203] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:134:pipe B] fastset requirement not met in hw.pipe_mode.crtc_vtotal (expected 0, found 1125)
<7> [52.846448] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:134:pipe B] fastset requirement not met in hw.pipe_mode.crtc_vblank_end (expected 0, found 1125)
<7> [52.846673] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:134:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_hdisplay (expected 0, found 1920)
<7> [52.846899] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:134:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_htotal (expected 0, found 2360)
<7> [52.847116] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:134:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_hblank_start (expected 0, found 1920)
<7> [52.847278] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:134:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_hblank_end (expected 0, found 2360)
<7> [52.847453] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:134:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_hsync_start (expected 0, found 2008)
<7> [52.847615] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:134:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_hsync_end (expected 0, found 2096)
<7> [52.847775] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:134:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_vdisplay (expected 0, found 1080)
<7> [52.847935] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:134:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_vblank_start (expected 0, found 1080)
<7> [52.848093] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:134:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_vsync_start (expected 0, found 1084)
<7> [52.848253] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:134:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_vsync_end (expected 0, found 1089)
<7> [52.848424] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:134:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_vtotal (expected 0, found 1125)
<7> [52.848583] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:134:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_vblank_end (expected 0, found 1125)
<7> [52.848741] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:134:pipe B] fastset requirement not met in pixel_multiplier (expected 0, found 1)
<7> [52.848900] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:134:pipe B] fastset requirement not met in hw.adjusted_mode.flags (1) (expected 0, found 1)
<7> [52.849066] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:134:pipe B] fastset requirement not met in hw.adjusted_mode.flags (4) (expected 0, found 4)
<7> [52.849232] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:134:pipe B] fastset requirement not met in pipe_bpp (expected 0, found 24)
<7> [52.849409] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:134:pipe B] fastset requirement not met in hw.pipe_mode.crtc_clock (expected 0, found 139929)
<7> [52.849574] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:134:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_clock (expected 0, found 139929)
<7> [52.849738] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:134:pipe B] fastset requirement not met in port_clock (expected 0, found 139929)
<7> [52.849901] i915 0000:00:02.0: [drm:intel_atomic_check [i915]] [CRTC:134:pipe B] fastset requirement not met, forcing full modeset
<7> [52.850084] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] Enabled dbuf slices 0x1 -> 0x3 (total dbuf slices 0x3), mbus joined? no->no
<7> [52.850237] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] [CRTC:134:pipe B] dbuf slices 0x0 -> 0x3, ddb (0 - 0) -> (0 - 2048), active pipes 0x0 -> 0x2
<7> [52.850386] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] [PLANE:84:plane 1B] ddb ( 0 - 0) -> ( 0 - 2016), size 0 -> 2016
<7> [52.850503] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] [PLANE:129:cursor B] ddb ( 0 - 0) -> (2016 - 2048), size 0 -> 32
<7> [52.850632] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] [PLANE:84:plane 1B] level wm0, wm1, wm2, wm3, wm4, wm5, wm6, wm7, twm, swm, stwm -> *wm0,*wm1,*wm2,*wm3,*wm4,*wm5,*wm6,*wm7,*twm, swm, stwm
<7> [52.850749] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] [PLANE:84:plane 1B] lines 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0 -> 1, 2, 2, 2, 2, 5, 8, 9, 0, 0, 0
<7> [52.850872] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] [PLANE:84:plane 1B] blocks 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0 -> 16, 33, 33, 33, 33, 81, 129, 145, 30, 0, 0
<7> [52.850988] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] [PLANE:84:plane 1B] min_ddb 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0 -> 19, 38, 38, 38, 38, 91, 143, 161, 31, 0, 0
<7> [52.851108] i915 0000:00:02.0: [drm:intel_bw_atomic_check [i915]] [CRTC:134:pipe B] data rate 559716 num active planes 1
<7> [52.851241] i915 0000:00:02.0: [drm:intel_bw_atomic_check [i915]] QGV point 0: max bw 16761 required 560
<7> [52.851380] i915 0000:00:02.0: [drm:intel_bw_atomic_check [i915]] No SAGV, using single QGV point mask 0x1
<7> [52.851516] i915 0000:00:02.0: [drm:intel_plane_calc_min_cdclk [i915]] [PLANE:84:plane 1B] min cdclk (69965 kHz) > [CRTC:134:pipe B] min cdclk (0 kHz)
<7> [52.851645] i915 0000:00:02.0: [drm:intel_bw_calc_min_cdclk [i915]] new bandwidth min cdclk (10932 kHz) > old min cdclk (0 kHz)
<7> [52.851772] i915 0000:00:02.0: [drm:intel_modeset_calc_cdclk [i915]] New cdclk calculated to be logical 180000 kHz, actual 180000 kHz
<7> [52.851900] i915 0000:00:02.0: [drm:intel_modeset_calc_cdclk [i915]] New voltage level calculated to be logical 0, actual 0
<7> [52.852027] i915 0000:00:02.0: [drm:intel_find_shared_dpll [i915]] [CRTC:134:pipe B] allocated DPLL 0
<7> [52.852154] i915 0000:00:02.0: [drm:intel_reference_shared_dpll_crtc [i915]] [CRTC:134:pipe B] reserving DPLL 0
<7> [52.852279] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [CRTC:134:pipe B] enable: yes [modeset]
<7> [52.852418] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] active: yes, output_types: HDMI (0x40), output format: RGB, sink format: RGB
<7> [52.852543] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] cpu_transcoder: B, pipe bpp: 24, dithering: 0
<7> [52.852668] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] MST master transcoder: <invalid>
<7> [52.852792] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] port sync: master transcoder: <invalid>, slave transcoder bitmask = 0x0
<7> [52.852916] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] joiner: no, pipes: 0x0
<7> [52.853045] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] splitter: disabled, link count 0, overlap 0
<7> [52.853169] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] framestart delay: 1, MSA timing delay: 0
<7> [52.853298] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] audio: 0, infoframes: 0, infoframes enabled: 0x0
<7> [52.853423] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] vrr: no, vmin: 0, vmax: 0, pipeline full: 0, guardband: 0 flipline: 0, vmin vblank: -1, vmax vblank: -2
<7> [52.853549] 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> [52.853676] 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> [52.853803] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] crtc timings: clock=139929, hd=1920 hb=1920-2360 hs=2008-2096 ht=2360, vd=1080 vb=1080-1125 vs=1084-1089 vt=1125, flags=0x5
<7> [52.853935] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pipe mode: "1920x1080": 53 139929 1920 2008 2096 2360 1080 1084 1089 1125 0x40 0x5
<7> [52.854059] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] crtc timings: clock=139929, hd=1920 hb=1920-2360 hs=2008-2096 ht=2360, vd=1080 vb=1080-1125 vs=1084-1089 vt=1125, flags=0x5
<7> [52.854185] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] port clock: 139929, pipe src: 1920x1080+0+0, pixel rate 139929
<7> [52.854321] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] linetime: 135, ips linetime: 0
<7> [52.854445] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] num_scalers: 2, scaler_users: 0x0, scaler_id: -1, scaling_filter: 0
<7> [52.854569] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pch pfit: 0x0+0+0, disabled, force thru: no
<7> [52.854693] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] ips: 0, double wide: 0, drrs: 0
<7> [52.854816] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] dpll_hw_state: cfgcr0: 0x1a6655d, 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> [52.854945] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] csc_mode: 0x0 gamma_mode: 0x0 gamma_enable: 0 csc_enable: 0
<7> [52.855067] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pre csc lut: 0 entries, post csc lut: 0 entries
<7> [52.855189] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] output csc: pre offsets: 0x0000 0x0000 0x0000
<7> [52.855323] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] output csc: coefficients: 0x0000 0x0000 0x0000
<7> [52.855444] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] output csc: coefficients: 0x0000 0x0000 0x0000
<7> [52.855565] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] output csc: coefficients: 0x0000 0x0000 0x0000
<7> [52.855686] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] output csc: post offsets: 0x0000 0x0000 0x0000
<7> [52.855808] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pipe csc: pre offsets: 0x0000 0x0000 0x0000
<7> [52.855929] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pipe csc: coefficients: 0x0000 0x0000 0x0000
<7> [52.856056] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pipe csc: coefficients: 0x0000 0x0000 0x0000
<7> [52.856179] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pipe csc: coefficients: 0x0000 0x0000 0x0000
<7> [52.856311] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pipe csc: post offsets: 0x0000 0x0000 0x0000
<7> [52.856434] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:84:plane 1B] fb: [FB:166] 1920x1080 format = XR24 little-endian (0x34325258) modifier = 0x0, visible: yes
<7> [52.856557] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] rotation: 0x1, scaler: -1, scaling_filter: 0
<7> [52.856678] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] src: 1920.000000x1080.000000+0.000000+0.000000 dst: 1920x1080+0+0
<7> [52.856800] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:93:plane 2B] fb: [NOFB], visible: no
<7> [52.856919] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:102:plane 3B] fb: [NOFB], visible: no
<7> [52.857041] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:111:plane 4B] fb: [NOFB], visible: no
<7> [52.857161] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:120:plane 5B] fb: [NOFB], visible: no
<7> [52.857294] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:129:cursor B] fb: [NOFB], visible: no
<7> [52.857888] i915 0000:00:02.0: [drm:intel_power_well_enable [i915]] enabling PW_3
<7> [52.858040] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:136:DDI B/PHY B]
<7> [52.858164] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:146:DDI TC1/PHY C]
<7> [52.858299] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:150:DDI TC2/PHY D]
<7> [52.858420] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:152:DP-MST A]
<7> [52.858539] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:153:DP-MST B]
<7> [52.858688] i915 0000:00:02.0: [drm:gen9_dbuf_slices_update [i915]] Updating dbuf slices to 0x3
<7> [52.858846] i915 0000:00:02.0: [drm:intel_enable_shared_dpll [i915]] enable DPLL 0 (active 0x2, on? 0) for [CRTC:134:pipe B]
<7> [52.858970] i915 0000:00:02.0: [drm:intel_enable_shared_dpll [i915]] enabling DPLL 0
<7> [52.859137] i915 0000:00:02.0: [drm:intel_dp_dual_mode_set_tmds_output [i915]] Enabling DP dual mode adaptor TMDS output
<7> [52.864366] i915 0000:00:02.0: [drm:intel_power_well_enable [i915]] enabling DDI_IO_B
<7> [52.864528] i915 0000:00:02.0: [drm:intel_enable_transcoder [i915]] enabling pipe B
<7> [52.884339] i915 0000:00:02.0: [drm:verify_connector_state [i915]] [CONNECTOR:137:HDMI-A-1]
<7> [52.884539] i915 0000:00:02.0: [drm:intel_modeset_verify_crtc [i915]] [CRTC:134:pipe B]
<6> [60.776920] [IGT] kms_flip: finished subtest B-HDMI-A1, FAIL
<6> [60.777495] [IGT] kms_flip: finished subtest flip-vs-blocking-wf-vblank, FAIL
<7> [60.781887] i915 0000:00:02.0: [drm:drm_mode_rmfb_work_fn] Removing [FB:167] from all active usage due to RMFB ioctl
<7> [60.782044] i915 0000:00:02.0: [drm:atomic_remove_fb] Disabling [PLANE:84:plane 1B] because [FB:167] is removed
<7> [60.782125] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] [PLANE:84:plane 1B] ddb ( 0 - 2016) -> ( 0 - 0), size 2016 -> 0
<7> [60.782273] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] [PLANE:84:plane 1B] level *wm0,*wm1,*wm2,*wm3,*wm4,*wm5,*wm6,*wm7,*twm, swm, stwm -> wm0, wm1, wm2, wm3, wm4, wm5, wm6, wm7, twm, swm, stwm
<7> [60.782395] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] [PLANE:84:plane 1B] lines 1, 2, 2, 2, 2, 5, 8, 9, 0, 0, 0 -> 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0
<7> [60.782532] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] [PLANE:84:plane 1B] blocks 16, 33, 33, 33, 33, 81, 129, 145, 30, 0, 0 -> 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0
<7> [60.782650] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] [PLANE:84:plane 1B] min_ddb 19, 38, 38, 38, 38, 91, 143, 161, 31, 0, 0 -> 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0
<7> [60.782781] i915 0000:00:02.0: [drm:intel_bw_atomic_check [i915]] [CRTC:134:pipe B] data rate 0 num active planes 0
<7> [60.782911] i915 0000:00:02.0: [drm:intel_bw_atomic_check [i915]] QGV point 0: max bw 16761 required 0
<6> [60.800871] [IGT] kms_flip: exiting, ret=98
<7> [60.813683] i915 0000:00:02.0: [drm:intel_atomic_check [i915]] [CONNECTOR:137:HDMI-A-1] Limiting display bpp to 24 (EDID bpp 24, max requested bpp 36, max platform bpp 36)
<7> [60.813847] i915 0000:00:02.0: [drm:intel_hdmi_compute_clock [i915]] picking 8 bpc for HDMI output (pipe bpp: 24)
<7> [60.813966] i915 0000:00:02.0: [drm:intel_atomic_check [i915]] [CRTC:82:pipe A] hw max bpp: 24, pipe bpp: 24, dithering: 0
<7> [60.814107] i915 0000:00:02.0: [drm:intel_ddi_compute_config_late [i915]] [ENCODER:136:DDI B/PHY B] [CRTC:82:pipe A]
<7> [60.814226] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:82:pipe A] fastset requirement not met in hw.enable (expected no, found yes)
<7> [60.814356] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:82:pipe A] fastset requirement not met in hw.active (expected no, found yes)
<7> [60.814483] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:82:pipe A] fastset requirement not met in cpu_transcoder (expected -1, found 0)
<7> [60.814678] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:82:pipe A] fastset requirement not met in lane_count (expected 0, found 4)
<7> [60.814804] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:82:pipe A] fastset requirement not met in output_types (expected 0x00000000, found 0x00000040)
<7> [60.814930] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:82:pipe A] fastset requirement not met in framestart_delay (expected 0, found 1)
<7> [60.815056] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:82:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hdisplay (expected 0, found 1920)
<7> [60.815182] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:82:pipe A] fastset requirement not met in hw.pipe_mode.crtc_htotal (expected 0, found 2360)
<7> [60.815309] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:82:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hblank_start (expected 0, found 1920)
<7> [60.815434] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:82:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hblank_end (expected 0, found 2360)
<7> [60.815564] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:82:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hsync_start (expected 0, found 2008)
<7> [60.815705] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:82:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hsync_end (expected 0, found 2096)
<7> [60.815831] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:82:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vdisplay (expected 0, found 1080)
<7> [60.815957] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:82:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vblank_start (expected 0, found 1080)
<7> [60.816082] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:82:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vsync_start (expected 0, found 1084)
<7> [60.816206] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:82:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vsync_end (expected 0, found 1089)
<7> [60.816330] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:82:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vtotal (expected 0, found 1125)
<7> [60.816452] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:82:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vblank_end (expected 0, found 1125)
<7> [60.816574] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:82:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hdisplay (expected 0, found 1920)
<7> [60.816725] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:82:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_htotal (expected 0, found 2360)
<7> [60.816847] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:82:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hblank_start (expected 0, found 1920)
<7> [60.816970] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:82:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hblank_end (expected 0, found 2360)
<7> [60.817094] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:82:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hsync_start (expected 0, found 2008)
<7> [60.817215] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:82:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hsync_end (expected 0, found 2096)
<7> [60.817339] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:82:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vdisplay (expected 0, found 1080)
<7> [60.817460] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:82:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vblank_start (expected 0, found 1080)
<7> [60.817675] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:82:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vsync_start (expected 0, found 1084)
<7> [60.817802] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:82:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vsync_end (expected 0, found 1089)
<7> [60.817929] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:82:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vtotal (expected 0, found 1125)
<7> [60.818056] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:82:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vblank_end (expected 0, found 1125)
<7> [60.818181] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:82:pipe A] fastset requirement not met in pixel_multiplier (expected 0, found 1)
<7> [60.818306] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:82:pipe A] fastset requirement not met in hw.adjusted_mode.flags (1) (expected 0, found 1)
<7> [60.818432] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:82:pipe A] fastset requirement not met in hw.adjusted_mode.flags (4) (expected 0, found 4)
<7> [60.818556] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:82:pipe A] fastset requirement not met in pipe_bpp (expected 0, found 24)
<7> [60.818693] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:82:pipe A] fastset requirement not met in hw.pipe_mode.crtc_clock (expected 0, found 139929)
<7> [60.818813] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:82:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_clock (expected 0, found 139929)
<7> [60.818935] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:82:pipe A] fastset requirement not met in port_clock (expected 0, found 139929)
<7> [60.819058] i915 0000:00:02.0: [drm:intel_atomic_check [i915]] [CRTC:82:pipe A] fastset requirement not met, forcing full modeset
<7> [60.819181] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:134:pipe B] fastset requirement not met in hw.enable (expected yes, found no)
<7> [60.819302] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:134:pipe B] fastset requirement not met in hw.active (expected yes, found no)
<7> [60.819424] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:134:pipe B] fastset requirement not met in cpu_transcoder (expected 1, found -1)
<7> [60.819545] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:134:pipe B] fastset requirement not met in lane_count (expected 4, found 0)
<7> [60.819679] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:134:pipe B] fastset requirement not met in output_types (expected 0x00000040, found 0x00000000)
<7> [60.819803] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:134:pipe B] fastset requirement not met in framestart_delay (expected 1, found 0)
<7> [60.819924] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:134:pipe B] fastset requirement not met in hw.pipe_mode.crtc_hdisplay (expected 1920, found 0)
<7> [60.820046] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:134:pipe B] fastset requirement not met in hw.pipe_mode.crtc_htotal (expected 2360, found 0)
<7> [60.820170] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:134:pipe B] fastset requirement not met in hw.pipe_mode.crtc_hblank_start (expected 1920, found 0)
<7> [60.820298] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:134:pipe B] fastset requirement not met in hw.pipe_mode.crtc_hblank_end (expected 2360, found 0)
<7> [60.820427] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:134:pipe B] fastset requirement not met in hw.pipe_mode.crtc_hsync_start (expected 2008, found 0)
<7> [60.820553] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:134:pipe B] fastset requirement not met in hw.pipe_mode.crtc_hsync_end (expected 2096, found 0)
<7> [60.820692] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:134:pipe B] fastset requirement not met in hw.pipe_mode.crtc_vdisplay (expected 1080, found 0)
<7> [60.820816] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:134:pipe B] fastset requirement not met in hw.pipe_mode.crtc_vblank_start (expected 1080, found 0)
<7> [60.820941] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:134:pipe B] fastset requirement not met in hw.pipe_mode.crtc_vsync_start (expected 1084, found 0)
<7> [60.821066] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:134:pipe B] fastset requirement not met in hw.pipe_mode.crtc_vsync_end (expected 1089, found 0)
<7> [60.821190] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:134:pipe B] fastset requirement not met in hw.pipe_mode.crtc_vtotal (expected 1125, found 0)
<7> [60.821313] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:134:pipe B] fastset requirement not met in hw.pipe_mode.crtc_vblank_end (expected 1125, found 0)
<7> [60.821437] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:134:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_hdisplay (expected 1920, found 0)
<7> [60.821560] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:134:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_htotal (expected 2360, found 0)
<7> [60.821730] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:134:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_hblank_start (expected 1920, found 0)
<7> [60.821854] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:134:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_hblank_end (expected 2360, found 0)
<7> [60.821977] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:134:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_hsync_start (expected 2008, found 0)
<7> [60.822099] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:134:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_hsync_end (expected 2096, found 0)
<7> [60.822220] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:134:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_vdisplay (expected 1080, found 0)
<7> [60.822342] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:134:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_vblank_start (expected 1080, found 0)
<7> [60.822464] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:134:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_vsync_start (expected 1084, found 0)
<7> [60.822593] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:134:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_vsync_end (expected 1089, found 0)
<7> [60.822714] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:134:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_vtotal (expected 1125, found 0)
<7> [60.822836] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:134:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_vblank_end (expected 1125, found 0)
<7> [60.822960] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:134:pipe B] fastset requirement not met in pixel_multiplier (expected 1, found 0)
<7> [60.823087] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:134:pipe B] fastset requirement not met in hw.adjusted_mode.flags (1) (expected 1, found 0)
<7> [60.823212] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:134:pipe B] fastset requirement not met in hw.adjusted_mode.flags (4) (expected 4, found 0)
<7> [60.823336] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:134:pipe B] fastset requirement not met in pipe_bpp (expected 24, found 0)
<7> [60.823460] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:134:pipe B] fastset requirement not met in hw.pipe_mode.crtc_clock (expected 139929, found 0)
<7> [60.823591] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:134:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_clock (expected 139929, found 0)
<7> [60.823714] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:134:pipe B] fastset requirement not met in port_clock (expected 139929, found 0)
<7> [60.823840] i915 0000:00:02.0: [drm:intel_atomic_check [i915]] [CRTC:134:pipe B] fastset requirement not met, forcing full modeset
<7> [60.823963] i915 0000:00:02.0: [drm:intel_unreference_shared_dpll_crtc [i915]] [CRTC:134:pipe B] releasing DPLL 0
<7> [60.824106] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] [CRTC:82:pipe A] dbuf slices 0x0 -> 0x3, ddb (0 - 0) -> (0 - 2048), active pipes 0x2 -> 0x1
<7> [60.824223] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] [CRTC:134:pipe B] dbuf slices 0x3 -> 0x0, ddb (0 - 2048) -> (0 - 0), active pipes 0x2 -> 0x1
<7> [60.824351] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] [PLANE:32:plane 1A] ddb ( 0 - 0) -> ( 0 - 2016), size 0 -> 2016
<7> [60.824472] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] [PLANE:77:cursor A] ddb ( 0 - 0) -> (2016 - 2048), size 0 -> 32
<7> [60.824602] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] [PLANE:32: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> [60.824720] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] [PLANE:32:plane 1A] lines 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0 -> 1, 2, 2, 2, 2, 5, 8, 9, 0, 0, 0
<7> [60.824838] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] [PLANE:32:plane 1A] blocks 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0 -> 16, 33, 33, 33, 33, 81, 129, 145, 30, 0, 0
<7> [60.824954] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] [PLANE:32:plane 1A] min_ddb 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0 -> 19, 38, 38, 38, 38, 91, 143, 161, 31, 0, 0
<7> [60.825071] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] [PLANE:129:cursor B] ddb (2016 - 2048) -> ( 0 - 0), size 32 -> 0
<7> [60.825186] i915 0000:00:02.0: [drm:intel_bw_atomic_check [i915]] [CRTC:82:pipe A] data rate 559716 num active planes 1
<7> [60.825315] i915 0000:00:02.0: [drm:intel_bw_atomic_check [i915]] QGV point 0: max bw 16761 required 560
<7> [60.825443] i915 0000:00:02.0: [drm:intel_bw_atomic_check [i915]] No SAGV, using single QGV point mask 0x1
<7> [60.825586] i915 0000:00:02.0: [drm:intel_plane_calc_min_cdclk [i915]] [PLANE:32:plane 1A] min cdclk (69965 kHz) > [CRTC:82:pipe A] min cdclk (0 kHz)
<7> [60.825715] i915 0000:00:02.0: [drm:intel_modeset_calc_cdclk [i915]] New cdclk calculated to be logical 180000 kHz, actual 180000 kHz
<7> [60.825840] i915 0000:00:02.0: [drm:intel_modeset_calc_cdclk [i915]] New voltage level calculated to be logical 0, actual 0
<7> [60.825966] i915 0000:00:02.0: [drm:intel_find_shared_dpll [i915]] [CRTC:82:pipe A] allocated DPLL 0
<7> [60.826091] i915 0000:00:02.0: [drm:intel_reference_shared_dpll_crtc [i915]] [CRTC:82:pipe A] reserving DPLL 0
<7> [60.826217] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [CRTC:82:pipe A] enable: yes [modeset]
<7> [60.826343] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] active: yes, output_types: HDMI (0x40), output format: RGB, sink format: RGB
<7> [60.826467] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] cpu_transcoder: A, pipe bpp: 24, dithering: 0
<7> [60.826600] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] MST master transcoder: <invalid>
<7> [60.826724] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] port sync: master transcoder: <invalid>, slave transcoder bitmask = 0x0
<7> [60.826850] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] joiner: no, pipes: 0x0
<7> [60.826976] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] splitter: disabled, link count 0, overlap 0
<7> [60.827103] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] framestart delay: 1, MSA timing delay: 0
<7> [60.827227] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] audio: 0, infoframes: 0, infoframes enabled: 0x0
<7> [60.827351] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] vrr: no, vmin: 0, vmax: 0, pipeline full: 0, guardband: 0 flipline: 0, vmin vblank: -1, vmax vblank: -2
<7> [60.827475] 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> [60.827609] 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> [60.827735] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] crtc timings: clock=139929, hd=1920 hb=1920-2360 hs=2008-2096 ht=2360, vd=1080 vb=1080-1125 vs=1084-1089 vt=1125, flags=0x5
<7> [60.827860] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pipe mode: "1920x1080": 53 139929 1920 2008 2096 2360 1080 1084 1089 1125 0x40 0x5
<7> [60.827983] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] crtc timings: clock=139929, hd=1920 hb=1920-2360 hs=2008-2096 ht=2360, vd=1080 vb=1080-1125 vs=1084-1089 vt=1125, flags=0x5
<7> [60.828107] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] port clock: 139929, pipe src: 1920x1080+0+0, pixel rate 139929
<7> [60.828229] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] linetime: 135, ips linetime: 0
<7> [60.828351] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] num_scalers: 2, scaler_users: 0x0, scaler_id: -1, scaling_filter: 0
<7> [60.828473] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pch pfit: 0x0+0+0, disabled, force thru: no
<7> [60.828606] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] ips: 0, double wide: 0, drrs: 0
<7> [60.828731] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] dpll_hw_state: cfgcr0: 0x1a6655d, 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> [60.828855] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] csc_mode: 0x0 gamma_mode: 0x0 gamma_enable: 0 csc_enable: 0
<7> [60.828978] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pre csc lut: 0 entries, post csc lut: 0 entries
<7> [60.829099] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] output csc: pre offsets: 0x0000 0x0000 0x0000
<7> [60.829221] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] output csc: coefficients: 0x0000 0x0000 0x0000
<7> [60.829342] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] output csc: coefficients: 0x0000 0x0000 0x0000
<7> [60.829463] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] output csc: coefficients: 0x0000 0x0000 0x0000
<7> [60.829593] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] output csc: post offsets: 0x0000 0x0000 0x0000
<7> [60.829716] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pipe csc: pre offsets: 0x0000 0x0000 0x0000
<7> [60.829837] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pipe csc: coefficients: 0x0000 0x0000 0x0000
<7> [60.829958] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pipe csc: coefficients: 0x0000 0x0000 0x0000
<7> [60.830080] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pipe csc: coefficients: 0x0000 0x0000 0x0000
<7> [60.830202] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pipe csc: post offsets: 0x0000 0x0000 0x0000
<7> [60.830321] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:32:plane 1A] fb: [FB:162] 1920x1080 format = XR24 little-endian (0x34325258) modifier = 0x0, visible: yes
<7> [60.830443] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] rotation: 0x1, scaler: -1, scaling_filter: 0
<7> [60.830583] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] src: 1920.000000x1080.000000+0.000000+0.000000 dst: 1920x1080+0+0
<7> [60.830710] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:41:plane 2A] fb: [NOFB], visible: no
<7> [60.830836] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:50:plane 3A] fb: [NOFB], visible: no
<7> [60.830959] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:59:plane 4A] fb: [NOFB], visible: no
<7> [60.831117] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:68:plane 5A] fb: [NOFB], visible: no
<7> [60.831240] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:77:cursor A] fb: [NOFB], visible: no
<7> [60.831365] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [CRTC:134:pipe B] enable: no [modeset]
<7> [60.831488] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:84:plane 1B] fb: [NOFB], visible: no
<7> [60.831622] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:93:plane 2B] fb: [NOFB], visible: no
<7> [60.831744] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:102:plane 3B] fb: [NOFB], visible: no
<7> [60.831865] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:111:plane 4B] fb: [NOFB], visible: no
<7> [60.831989] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:120:plane 5B] fb: [NOFB], visible: no
<7> [60.832113] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:129:cursor B] fb: [NOFB], visible: no
<7> [60.832363] i915 0000:00:02.0: [drm:intel_disable_transcoder [i915]] disabling pipe B
<7> [60.834541] i915 0000:00:02.0: [drm:intel_power_well_disable [i915]] disabling DDI_IO_B
<7> [60.834681] i915 0000:00:02.0: [drm:intel_dp_dual_mode_set_tmds_output [i915]] Disabling DP dual mode adaptor TMDS output
<7> [60.840019] i915 0000:00:02.0: [drm:intel_disable_shared_dpll [i915]] disable DPLL 0 (active 0x2, on? 1) for [CRTC:134:pipe B]
<7> [60.840163] i915 0000:00:02.0: [drm:intel_disable_shared_dpll [i915]] disabling DPLL 0
<7> [60.840299] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:136:DDI B/PHY B]
<7> [60.840419] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:146:DDI TC1/PHY C]
<7> [60.840551] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:150:DDI TC2/PHY D]
<7> [60.840673] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:152:DP-MST A]
<7> [60.840794] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:153:DP-MST B]
<7> [60.840956] i915 0000:00:02.0: [drm:intel_enable_shared_dpll [i915]] enable DPLL 0 (active 0x1, on? 0) for [CRTC:82:pipe A]
<7> [60.841083] i915 0000:00:02.0: [drm:intel_enable_shared_dpll [i915]] enabling DPLL 0
<7> [60.841249] i915 0000:00:02.0: [drm:intel_dp_dual_mode_set_tmds_output [i915]] Enabling DP dual mode adaptor TMDS output
<7> [60.846377] i915 0000:00:02.0: [drm:intel_power_well_enable [i915]] enabling DDI_IO_B
<7> [60.846546] i915 0000:00:02.0: [drm:intel_enable_transcoder [i915]] enabling pipe A
<7> [60.846896] i915 0000:00:02.0: [drm:intel_fbc_update [i915]] reserved 17694720 bytes of contiguous stolen space for FBC, limit: 1
<7> [60.847022] i915 0000:00:02.0: [drm:intel_fbc_update [i915]] Enabling FBC on [PLANE:32:plane 1A]
<7> [60.865998] i915 0000:00:02.0: [drm:verify_connector_state [i915]] [CONNECTOR:137:HDMI-A-1]
<7> [60.866246] i915 0000:00:02.0: [drm:intel_modeset_verify_crtc [i915]] [CRTC:82:pipe A]
<7> [60.866789] i915 0000:00:02.0: [drm:intel_power_well_disable [i915]] disabling PW_3
<7> [60.867010] i915 0000:00:02.0: [drm:intel_modeset_verify_crtc [i915]] [CRTC:134:pipe B]
<7> [60.867436] i915 0000:00:02.0: [drm:drm_client_dev_restore] intel-fbdev: ret=0
Created at 2024-11-05 05:10:23