Results for igt@kms_flip@plain-flip-ts-check

Machine description: shard-rkl-8

Result: Fail

git-log-oneline i915_display_info11 igt_runner11 runtimes11 results11.json results11-i915-load.json i915_display_info_post_exec11 boot11 dmesg11

DetailValue
Duration 34.68 seconds
Hostname 
shard-rkl-8
Igt-Version 
IGT-Version: 1.30-gbf8a8a073 (x86_64) (Linux: 6.14.0-rc5-CI_DRM_16222-gff2d693d8872+ x86_64)
Out 
Using IGT_SRANDOM=1741134893 for randomisation
Opened device: /dev/dri/card0
Using monotonic timestamps
Starting subtest: plain-flip-ts-check
Starting dynamic subtest: A-HDMI-A2
  1920x1080: 53 139930 1920 2008 2096 2360 1080 1084 1089 1125 0x48 0x5 
Expected frametime: 18974us; measured 18871.0us +- 8.656us accuracy 0.14%
vblank interval differs from modeline! expected 18973.8us, measured 18871us +- 8.656us, difference 102.8us (11.9 sigma)
Stack trace:
  #0 ../lib/igt_core.c:2055 __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-A2: FAIL (13.691s)
Starting dynamic subtest: B-HDMI-A2
  1920x1080: 53 139930 1920 2008 2096 2360 1080 1084 1089 1125 0x48 0x5 
Expected frametime: 18974us; measured 18957.7us +- 7.472us accuracy 0.12%
vblank interval differs from modeline! expected 18973.8us, measured 18958us +- 7.472us, difference 16.1us (2.2 sigma)
Dynamic subtest B-HDMI-A2: SUCCESS (10.502s)
Starting dynamic subtest: C-HDMI-A2
  1920x1080: 53 139930 1920 2008 2096 2360 1080 1084 1089 1125 0x48 0x5 
Expected frametime: 18974us; measured 18976.4us +- 8.718us accuracy 0.14%
Dynamic subtest C-HDMI-A2: SUCCESS (10.481s)
Subtest plain-flip-ts-check: FAIL (34.680s)
Err 
Starting subtest: plain-flip-ts-check
Starting dynamic subtest: A-HDMI-A2
(kms_flip:2110) CRITICAL: Test assertion failure function __run_test_on_crtc_set, file ../tests/kms_flip.c:1674:
(kms_flip:2110) CRITICAL: Failed assertion: !retried && needs_retry_after_link_reset(mon)
Dynamic subtest A-HDMI-A2 failed.
**** DEBUG ****
(kms_flip:2110) DEBUG: name = flip
last_ts = 82.024788
last_received_ts = 82.024094
last_seq = 1287
current_ts = 82.043732
current_received_ts = 82.043060
current_seq = 1288
count = 408
seq_step = 1
(kms_flip:2110) DEBUG: flip ts/seq: last 82.024788/1287, current 82.043732/1288: elapsed=18938.0us expected=18871.0us +- 94.4us, error 0.4%
(kms_flip:2110) DEBUG: name = flip
last_ts = 82.043732
last_received_ts = 82.043060
last_seq = 1288
current_ts = 82.062653
current_received_ts = 82.061974
current_seq = 1289
count = 409
seq_step = 1
(kms_flip:2110) DEBUG: flip ts/seq: last 82.043732/1288, current 82.062653/1289: elapsed=18922.0us expected=18871.0us +- 94.4us, error 0.3%
(kms_flip:2110) DEBUG: name = flip
last_ts = 82.062653
last_received_ts = 82.061974
last_seq = 1289
current_ts = 82.081589
current_received_ts = 82.080910
current_seq = 1290
count = 410
seq_step = 1
(kms_flip:2110) DEBUG: flip ts/seq: last 82.062653/1289, current 82.081589/1290: elapsed=18939.0us expected=18871.0us +- 94.4us, error 0.4%
(kms_flip:2110) DEBUG: name = flip
last_ts = 82.081589
last_received_ts = 82.080910
last_seq = 1290
current_ts = 82.100548
current_received_ts = 82.099854
current_seq = 1291
count = 411
seq_step = 1
(kms_flip:2110) DEBUG: flip ts/seq: last 82.081589/1290, current 82.100548/1291: elapsed=18954.0us expected=18871.0us +- 94.4us, error 0.4%
(kms_flip:2110) DEBUG: name = flip
last_ts = 82.100548
last_received_ts = 82.099854
last_seq = 1291
current_ts = 82.119484
current_received_ts = 82.118782
current_seq = 1292
count = 412
seq_step = 1
(kms_flip:2110) DEBUG: flip ts/seq: last 82.100548/1291, current 82.119484/1292: elapsed=18939.0us expected=18871.0us +- 94.4us, error 0.4%
(kms_flip:2110) DEBUG: name = flip
last_ts = 82.119484
last_received_ts = 82.118782
last_seq = 1292
current_ts = 82.138420
current_received_ts = 82.137718
current_seq = 1293
count = 413
seq_step = 1
(kms_flip:2110) DEBUG: flip ts/seq: last 82.119484/1292, current 82.138420/1293: elapsed=18938.0us expected=18871.0us +- 94.4us, error 0.4%
(kms_flip:2110) DEBUG: name = flip
last_ts = 82.138420
last_received_ts = 82.137718
last_seq = 1293
current_ts = 82.157356
current_received_ts = 82.156662
current_seq = 1294
count = 414
seq_step = 1
(kms_flip:2110) DEBUG: flip ts/seq: last 82.138420/1293, current 82.157356/1294: elapsed=18939.0us expected=18871.0us +- 94.4us, error 0.4%
(kms_flip:2110) DEBUG: name = flip
last_ts = 82.157356
last_received_ts = 82.156662
last_seq = 1294
current_ts = 82.176300
current_received_ts = 82.175613
current_seq = 1295
count = 415
seq_step = 1
(kms_flip:2110) DEBUG: flip ts/seq: last 82.157356/1294, current 82.176300/1295: elapsed=18938.0us expected=18871.0us +- 94.4us, error 0.4%
(kms_flip:2110) DEBUG: name = flip
last_ts = 82.176300
last_received_ts = 82.175613
last_seq = 1295
current_ts = 82.195221
current_received_ts = 82.194550
current_seq = 1296
count = 416
seq_step = 1
(kms_flip:2110) DEBUG: flip ts/seq: last 82.176300/1295, current 82.195221/1296: elapsed=18922.0us expected=18871.0us +- 94.4us, error 0.3%
(kms_flip:2110) DEBUG: name = flip
last_ts = 82.195221
last_received_ts = 82.194550
last_seq = 1296
current_ts = 82.214157
current_received_ts = 82.213486
current_seq = 1297
count = 417
seq_step = 1
(kms_flip:2110) DEBUG: flip ts/seq: last 82.195221/1296, current 82.214157/1297: elapsed=18939.0us expected=18871.0us +- 94.4us, error 0.4%
(kms_flip:2110) DEBUG: name = flip
last_ts = 82.214157
last_received_ts = 82.213486
last_seq = 1297
current_ts = 82.233093
current_received_ts = 82.232422
current_seq = 1298
count = 418
seq_step = 1
(kms_flip:2110) DEBUG: flip ts/seq: last 82.214157/1297, current 82.233093/1298: elapsed=18938.0us expected=18871.0us +- 94.4us, error 0.4%
(kms_flip:2110) DEBUG: name = flip
last_ts = 82.233093
last_received_ts = 82.232422
last_seq = 1298
current_ts = 82.252052
current_received_ts = 82.251350
current_seq = 1299
count = 419
seq_step = 1
(kms_flip:2110) DEBUG: flip ts/seq: last 82.233093/1298, current 82.252052/1299: elapsed=18954.0us expected=18871.0us +- 94.4us, error 0.4%
(kms_flip:2110) DEBUG: name = flip
last_ts = 82.252052
last_received_ts = 82.251350
last_seq = 1299
current_ts = 82.270988
current_received_ts = 82.270294
current_seq = 1300
count = 420
seq_step = 1
(kms_flip:2110) DEBUG: flip ts/seq: last 82.252052/1299, current 82.270988/1300: elapsed=18939.0us expected=18871.0us +- 94.4us, error 0.4%
(kms_flip:2110) DEBUG: name = flip
last_ts = 82.270988
last_received_ts = 82.270294
last_seq = 1300
current_ts = 82.289909
current_received_ts = 82.289238
current_seq = 1301
count = 421
seq_step = 1
(kms_flip:2110) DEBUG: flip ts/seq: last 82.270988/1300, current 82.289909/1301: elapsed=18922.0us expected=18871.0us +- 94.4us, error 0.3%
(kms_flip:2110) DEBUG: name = flip
last_ts = 82.289909
last_received_ts = 82.289238
last_seq = 1301
current_ts = 82.308853
current_received_ts = 82.308174
current_seq = 1302
count = 422
seq_step = 1
(kms_flip:2110) DEBUG: flip ts/seq: last 82.289909/1301, current 82.308853/1302: elapsed=18940.0us expected=18871.0us +- 94.4us, error 0.4%
(kms_flip:2110) DEBUG: name = flip
last_ts = 82.308853
last_received_ts = 82.308174
last_seq = 1302
current_ts = 82.327789
current_received_ts = 82.327110
current_seq = 1303
count = 423
seq_step = 1
(kms_flip:2110) DEBUG: flip ts/seq: last 82.308853/1302, current 82.327789/1303: elapsed=18937.0us expected=18871.0us +- 94.4us, error 0.3%
(kms_flip:2110) DEBUG: name = flip
last_ts = 82.327789
last_received_ts = 82.327110
last_seq = 1303
current_ts = 82.346741
current_received_ts = 82.346054
current_seq = 1304
count = 424
seq_step = 1
(kms_flip:2110) DEBUG: flip ts/seq: last 82.327789/1303, current 82.346741/1304: elapsed=18955.0us expected=18871.0us +- 94.4us, error 0.4%
(kms_flip:2110) DEBUG: name = flip
last_ts = 82.346741
last_received_ts = 82.346054
last_seq = 1304
current_ts = 82.365685
current_received_ts = 82.364990
current_seq = 1305
count = 425
seq_step = 1
(kms_flip:2110) DEBUG: flip ts/seq: last 82.346741/1304, current 82.365685/1305: elapsed=18939.0us expected=18871.0us +- 94.4us, error 0.4%
(kms_flip:2110) DEBUG: name = flip
last_ts = 82.365685
last_received_ts = 82.364990
last_seq = 1305
current_ts = 82.384605
current_received_ts = 82.383926
current_seq = 1306
count = 426
seq_step = 1
(kms_flip:2110) DEBUG: flip ts/seq: last 82.365685/1305, current 82.384605/1306: elapsed=18922.0us expected=18871.0us +- 94.4us, error 0.3%
(kms_flip:2110) DEBUG: name = flip
last_ts = 82.384605
last_received_ts = 82.383926
last_seq = 1306
current_ts = 82.403542
current_received_ts = 82.402863
current_seq = 1307
count = 427
seq_step = 1
(kms_flip:2110) DEBUG: flip ts/seq: last 82.384605/1306, current 82.403542/1307: elapsed=18938.0us expected=18871.0us +- 94.4us, error 0.4%
(kms_flip:2110) DEBUG: name = flip
last_ts = 82.403542
last_received_ts = 82.402863
last_seq = 1307
current_ts = 82.422485
current_received_ts = 82.421806
current_seq = 1308
count = 428
seq_step = 1
(kms_flip:2110) DEBUG: flip ts/seq: last 82.403542/1307, current 82.422485/1308: elapsed=18939.0us expected=18871.0us +- 94.4us, error 0.4%
(kms_flip:2110) DEBUG: name = flip
last_ts = 82.422485
last_received_ts = 82.421806
last_seq = 1308
current_ts = 82.441437
current_received_ts = 82.440735
current_seq = 1309
count = 429
seq_step = 1
(kms_flip:2110) DEBUG: flip ts/seq: last 82.422485/1308, current 82.441437/1309: elapsed=18954.0us expected=18871.0us +- 94.4us, error 0.4%
(kms_flip:2110) DEBUG: name = flip
last_ts = 82.441437
last_received_ts = 82.440735
last_seq = 1309
current_ts = 82.460358
current_received_ts = 82.459686
current_seq = 1310
count = 430
seq_step = 1
(kms_flip:2110) DEBUG: flip ts/seq: last 82.441437/1309, current 82.460358/1310: elapsed=18922.0us expected=18871.0us +- 94.4us, error 0.3%
(kms_flip:2110) DEBUG: name = flip
last_ts = 82.460358
last_received_ts = 82.459686
last_seq = 1310
current_ts = 82.479301
current_received_ts = 82.478607
current_seq = 1311
count = 431
seq_step = 1
(kms_flip:2110) DEBUG: flip ts/seq: last 82.460358/1310, current 82.479301/1311: elapsed=18941.0us expected=18871.0us +- 94.4us, error 0.4%
(kms_flip:2110) DEBUG: name = flip
last_ts = 82.479301
last_received_ts = 82.478607
last_seq = 1311
current_ts = 82.498238
current_received_ts = 82.497566
current_seq = 1312
count = 432
seq_step = 1
(kms_flip:2110) DEBUG: flip ts/seq: last 82.479301/1311, current 82.498238/1312: elapsed=18939.0us expected=18871.0us +- 94.4us, error 0.4%
(kms_flip:2110) DEBUG: name = flip
last_ts = 82.498238
last_received_ts = 82.497566
last_seq = 1312
current_ts = 82.517189
current_received_ts = 82.516495
current_seq = 1313
count = 433
seq_step = 1
(kms_flip:2110) DEBUG: flip ts/seq: last 82.498238/1312, current 82.517189/1313: elapsed=18952.0us expected=18871.0us +- 94.4us, error 0.4%
(kms_flip:2110) DEBUG: name = flip
last_ts = 82.517189
last_received_ts = 82.516495
last_seq = 1313
current_ts = 82.536133
current_received_ts = 82.535439
current_seq = 1314
count = 434
seq_step = 1
(kms_flip:2110) DEBUG: flip ts/seq: last 82.517189/1313, current 82.536133/1314: elapsed=18939.0us expected=18871.0us +- 94.4us, error 0.4%
(kms_flip:2110) DEBUG: name = flip
last_ts = 82.536133
last_received_ts = 82.535439
last_seq = 1314
current_ts = 82.555069
current_received_ts = 82.554375
current_seq = 1315
count = 435
seq_step = 1
(kms_flip:2110) DEBUG: flip ts/seq: last 82.536133/1314, current 82.555069/1315: elapsed=18938.0us expected=18871.0us +- 94.4us, error 0.4%
(kms_flip:2110) DEBUG: name = flip
last_ts = 82.555069
last_received_ts = 82.554375
last_seq = 1315
current_ts = 82.573990
current_received_ts = 82.573311
current_seq = 1316
count = 436
seq_step = 1
(kms_flip:2110) DEBUG: flip ts/seq: last 82.555069/1315, current 82.573990/1316: elapsed=18922.0us expected=18871.0us +- 94.4us, error 0.3%
(kms_flip:2110) DEBUG: name = flip
last_ts = 82.573990
last_received_ts = 82.573311
last_seq = 1316
current_ts = 82.592941
current_received_ts = 82.592247
current_seq = 1317
count = 437
seq_step = 1
(kms_flip:2110) DEBUG: flip ts/seq: last 82.573990/1316, current 82.592941/1317: elapsed=18955.0us expected=18871.0us +- 94.4us, error 0.4%
(kms_flip:2110) DEBUG: name = flip
last_ts = 82.592941
last_received_ts = 82.592247
last_seq = 1317
current_ts = 82.611885
current_received_ts = 82.611191
current_seq = 1318
count = 438
seq_step = 1
(kms_flip:2110) DEBUG: flip ts/seq: last 82.592941/1317, current 82.611885/1318: elapsed=18938.0us expected=18871.0us +- 94.4us, error 0.4%
(kms_flip:2110) DEBUG: name = flip
last_ts = 82.611885
last_received_ts = 82.611191
last_seq = 1318
current_ts = 82.630821
current_received_ts = 82.630127
current_seq = 1319
count = 439
seq_step = 1
(kms_flip:2110) DEBUG: flip ts/seq: last 82.611885/1318, current 82.630821/1319: elapsed=18939.0us expected=18871.0us +- 94.4us, error 0.4%
(kms_flip:2110) DEBUG: name = flip
last_ts = 82.630821
last_received_ts = 82.630127
last_seq = 1319
current_ts = 82.649742
current_received_ts = 82.649071
current_seq = 1320
count = 440
seq_step = 1
(kms_flip:2110) DEBUG: flip ts/seq: last 82.630821/1319, current 82.649742/1320: elapsed=18922.0us expected=18871.0us +- 94.4us, error 0.3%
(kms_flip:2110) DEBUG: name = flip
last_ts = 82.649742
last_received_ts = 82.649071
last_seq = 1320
current_ts = 82.668694
current_received_ts = 82.668037
current_seq = 1321
count = 441
seq_step = 1
(kms_flip:2110) DEBUG: flip ts/seq: last 82.649742/1320, current 82.668694/1321: elapsed=18954.0us expected=18871.0us +- 94.4us, error 0.4%
(kms_flip:2110) DEBUG: name = flip
last_ts = 82.668694
last_received_ts = 82.668037
last_seq = 1321
current_ts = 82.687637
current_received_ts = 82.686943
current_seq = 1322
count = 442
seq_step = 1
(kms_flip:2110) DEBUG: flip ts/seq: last 82.668694/1321, current 82.687637/1322: elapsed=18942.0us expected=18871.0us +- 94.4us, error 0.4%
(kms_flip:2110) DEBUG: name = flip
last_ts = 82.687637
last_received_ts = 82.686943
last_seq = 1322
current_ts = 82.706581
current_received_ts = 82.705887
current_seq = 1323
count = 443
seq_step = 1
(kms_flip:2110) DEBUG: flip ts/seq: last 82.687637/1322, current 82.706581/1323: elapsed=18944.0us expected=18871.0us +- 94.4us, error 0.4%
(kms_flip:2110) DEBUG: name = flip
last_ts = 82.706581
last_received_ts = 82.705887
last_seq = 1323
current_ts = 82.725525
current_received_ts = 82.724831
current_seq = 1324
count = 444
seq_step = 1
(kms_flip:2110) DEBUG: flip ts/seq: last 82.706581/1323, current 82.725525/1324: elapsed=18943.0us expected=18871.0us +- 94.4us, error 0.4%
(kms_flip:2110) DEBUG: name = flip
last_ts = 82.725525
last_received_ts = 82.724831
last_seq = 1324
current_ts = 82.744453
current_received_ts = 82.743774
current_seq = 1325
count = 445
seq_step = 1
(kms_flip:2110) DEBUG: flip ts/seq: last 82.725525/1324, current 82.744453/1325: elapsed=18926.0us expected=18871.0us +- 94.4us, error 0.3%
(kms_flip:2110) DEBUG: name = flip
last_ts = 82.744453
last_received_ts = 82.743774
last_seq = 1325
current_ts = 82.763412
current_received_ts = 82.762718
current_seq = 1326
count = 446
seq_step = 1
(kms_flip:2110) DEBUG: flip ts/seq: last 82.744453/1325, current 82.763412/1326: elapsed=18959.0us expected=18871.0us +- 94.4us, error 0.5%
(kms_flip:2110) DEBUG: name = flip
last_ts = 82.763412
last_received_ts = 82.762718
last_seq = 1326
current_ts = 82.782356
current_received_ts = 82.781654
current_seq = 1327
count = 447
seq_step = 1
(kms_flip:2110) DEBUG: flip ts/seq: last 82.763412/1326, current 82.782356/1327: elapsed=18943.0us expected=18871.0us +- 94.4us, error 0.4%
(kms_flip:2110) DEBUG: name = flip
last_ts = 82.782356
last_received_ts = 82.781654
last_seq = 1327
current_ts = 82.801285
current_received_ts = 82.800606
current_seq = 1328
count = 448
seq_step = 1
(kms_flip:2110) DEBUG: flip ts/seq: last 82.782356/1327, current 82.801285/1328: elapsed=18927.0us expected=18871.0us +- 94.4us, error 0.3%
(kms_flip:2110) DEBUG: name = flip
last_ts = 82.801285
last_received_ts = 82.800606
last_seq = 1328
current_ts = 82.820221
current_received_ts = 82.819550
current_seq = 1329
count = 449
seq_step = 1
(kms_flip:2110) DEBUG: flip ts/seq: last 82.801285/1328, current 82.820221/1329: elapsed=18942.0us expected=18871.0us +- 94.4us, error 0.4%
(kms_flip:2110) DEBUG: name = flip
last_ts = 82.820221
last_received_ts = 82.819550
last_seq = 1329
current_ts = 82.839180
current_received_ts = 82.838486
current_seq = 1330
count = 450
seq_step = 1
(kms_flip:2110) DEBUG: flip ts/seq: last 82.820221/1329, current 82.839180/1330: elapsed=18959.0us expected=18871.0us +- 94.4us, error 0.5%
(kms_flip:2110) DEBUG: name = flip
last_ts = 82.839180
last_received_ts = 82.838486
last_seq = 1330
current_ts = 82.858124
current_received_ts = 82.857430
current_seq = 1331
count = 451
seq_step = 1
(kms_flip:2110) DEBUG: flip ts/seq: last 82.839180/1330, current 82.858124/1331: elapsed=18943.0us expected=18871.0us +- 94.4us, error 0.4%
(kms_flip:2110) DEBUG: name = flip
last_ts = 82.858124
last_received_ts = 82.857430
last_seq = 1331
current_ts = 82.877068
current_received_ts = 82.876366
current_seq = 1332
count = 452
seq_step = 1
(kms_flip:2110) DEBUG: flip ts/seq: last 82.858124/1331, current 82.877068/1332: elapsed=18943.0us expected=18871.0us +- 94.4us, error 0.4%
(kms_flip:2110) DEBUG: name = flip
last_ts = 82.877068
last_received_ts = 82.876366
last_seq = 1332
current_ts = 82.895996
current_received_ts = 82.895317
current_seq = 1333
count = 453
seq_step = 1
(kms_flip:2110) DEBUG: flip ts/seq: last 82.877068/1332, current 82.895996/1333: elapsed=18927.0us expected=18871.0us +- 94.4us, error 0.3%
(kms_flip:2110) DEBUG: name = flip
last_ts = 82.895996
last_received_ts = 82.895317
last_seq = 1333
current_ts = 82.914940
current_received_ts = 82.914268
current_seq = 1334
count = 454
seq_step = 1
(kms_flip:2110) DEBUG: flip ts/seq: last 82.895996/1333, current 82.914940/1334: elapsed=18943.0us expected=18871.0us +- 94.4us, error 0.4%
(kms_flip:2110) DEBUG: name = flip
last_ts = 82.914940
last_received_ts = 82.914268
last_seq = 1334
current_ts = 82.933899
current_received_ts = 82.933205
current_seq = 1335
count = 455
seq_step = 1
(kms_flip:2110) DEBUG: flip ts/seq: last 82.914940/1334, current 82.933899/1335: elapsed=18959.0us expected=18871.0us +- 94.4us, error 0.5%
(kms_flip:2110) DEBUG: name = flip
last_ts = 82.933899
last_received_ts = 82.933205
last_seq = 1335
current_ts = 82.952843
current_received_ts = 82.952156
current_seq = 1336
count = 456
seq_step = 1
(kms_flip:2110) DEBUG: flip ts/seq: last 82.933899/1335, current 82.952843/1336: elapsed=18943.0us expected=18871.0us +- 94.4us, error 0.4%
(kms_flip:2110) DEBUG: name = flip
last_ts = 82.952843
last_received_ts = 82.952156
last_seq = 1336
current_ts = 82.971764
current_received_ts = 82.971085
current_seq = 1337
count = 457
seq_step = 1
(kms_flip:2110) DEBUG: flip ts/seq: last 82.952843/1336, current 82.971764/1337: elapsed=18926.0us expected=18871.0us +- 94.4us, error 0.3%
(kms_flip:2110) DEBUG: name = flip
last_ts = 82.971764
last_received_ts = 82.971085
last_seq = 1337
current_ts = 82.990707
current_received_ts = 82.990059
current_seq = 1338
count = 458
seq_step = 1
(kms_flip:2110) DEBUG: flip ts/seq: last 82.971764/1337, current 82.990707/1338: elapsed=18943.0us expected=18871.0us +- 94.4us, error 0.4%
(kms_flip:2110) DEBUG: name = flip
last_ts = 82.990707
last_received_ts = 82.990059
last_seq = 1338
current_ts = 83.009666
current_received_ts = 83.008972
current_seq = 1339
count = 459
seq_step = 1
(kms_flip:2110) DEBUG: flip ts/seq: last 82.990707/1338, current 83.009666/1339: elapsed=18959.0us expected=18871.0us +- 94.4us, error 0.5%
(kms_flip:2110) DEBUG: name = flip
last_ts = 83.009666
last_received_ts = 83.008972
last_seq = 1339
current_ts = 83.028610
current_received_ts = 83.027916
current_seq = 1340
count = 460
seq_step = 1
(kms_flip:2110) DEBUG: flip ts/seq: last 83.009666/1339, current 83.028610/1340: elapsed=18943.0us expected=18871.0us +- 94.4us, error 0.4%
(kms_flip:2110) DEBUG: name = flip
last_ts = 83.028610
last_received_ts = 83.027916
last_seq = 1340
current_ts = 83.047554
current_received_ts = 83.046860
current_seq = 1341
count = 461
seq_step = 1
(kms_flip:2110) DEBUG: flip ts/seq: last 83.028610/1340, current 83.047554/1341: elapsed=18943.0us expected=18871.0us +- 94.4us, error 0.4%
(kms_flip:2110) DEBUG: name = flip
last_ts = 83.047554
last_received_ts = 83.046860
last_seq = 1341
current_ts = 83.066483
current_received_ts = 83.065804
current_seq = 1342
count = 462
seq_step = 1
(kms_flip:2110) DEBUG: flip ts/seq: last 83.047554/1341, current 83.066483/1342: elapsed=18926.0us expected=18871.0us +- 94.4us, error 0.3%
(kms_flip:2110) DEBUG: name = flip
last_ts = 83.066483
last_received_ts = 83.065804
last_seq = 1342
current_ts = 83.085426
current_received_ts = 83.084747
current_seq = 1343
count = 463
seq_step = 1
(kms_flip:2110) DEBUG: flip ts/seq: last 83.066483/1342, current 83.085426/1343: elapsed=18943.0us expected=18871.0us +- 94.4us, error 0.4%
(kms_flip:2110) DEBUG: name = flip
last_ts = 83.085426
last_received_ts = 83.084747
last_seq = 1343
current_ts = 83.104385
current_received_ts = 83.103691
current_seq = 1344
count = 464
seq_step = 1
(kms_flip:2110) DEBUG: flip ts/seq: last 83.085426/1343, current 83.104385/1344: elapsed=18960.0us expected=18871.0us +- 94.4us, error 0.5%
(kms_flip:2110) DEBUG: name = flip
last_ts = 83.104385
last_received_ts = 83.103691
last_seq = 1344
current_ts = 83.123306
current_received_ts = 83.122635
current_seq = 1345
count = 465
seq_step = 1
(kms_flip:2110) DEBUG: flip ts/seq: last 83.104385/1344, current 83.123306/1345: elapsed=18926.0us expected=18871.0us +- 94.4us, error 0.3%
(kms_flip:2110) DEBUG: name = flip
last_ts = 83.123306
last_received_ts = 83.122635
last_seq = 1345
current_ts = 83.142265
current_received_ts = 83.141579
current_seq = 1346
count = 466
seq_step = 1
(kms_flip:2110) DEBUG: flip ts/seq: last 83.123306/1345, current 83.142265/1346: elapsed=18959.0us expected=18871.0us +- 94.4us, error 0.5%
(kms_flip:2110) DEBUG: name = flip
last_ts = 83.142265
last_received_ts = 83.141579
last_seq = 1346
current_ts = 83.161194
current_received_ts = 83.160522
current_seq = 1347
count = 467
seq_step = 1
(kms_flip:2110) DEBUG: flip ts/seq: last 83.142265/1346, current 83.161194/1347: elapsed=18927.0us expected=18871.0us +- 94.4us, error 0.3%
(kms_flip:2110) DEBUG: name = flip
last_ts = 83.161194
last_received_ts = 83.160522
last_seq = 1347
current_ts = 83.180153
current_received_ts = 83.179459
current_seq = 1348
count = 468
seq_step = 1
(kms_flip:2110) DEBUG: flip ts/seq: last 83.161194/1347, current 83.180153/1348: elapsed=18959.0us expected=18871.0us +- 94.4us, error 0.5%
(kms_flip:2110) DEBUG: name = flip
last_ts = 83.180153
last_received_ts = 83.179459
last_seq = 1348
current_ts = 83.199081
current_received_ts = 83.198402
current_seq = 1349
count = 469
seq_step = 1
(kms_flip:2110) DEBUG: flip ts/seq: last 83.180153/1348, current 83.199081/1349: elapsed=18926.0us expected=18871.0us +- 94.4us, error 0.3%
(kms_flip:2110) DEBUG: name = flip
last_ts = 83.199081
last_received_ts = 83.198402
last_seq = 1349
current_ts = 83.218025
current_received_ts = 83.217346
current_seq = 1350
count = 470
seq_step = 1
(kms_flip:2110) DEBUG: flip ts/seq: last 83.199081/1349, current 83.218025/1350: elapsed=18944.0us expected=18871.0us +- 94.4us, error 0.4%
(kms_flip:2110) DEBUG: name = flip
last_ts = 83.218025
last_received_ts = 83.217346
last_seq = 1350
current_ts = 83.236984
current_received_ts = 83.236298
current_seq = 1351
count = 471
seq_step = 1
(kms_flip:2110) DEBUG: flip ts/seq: last 83.218025/1350, current 83.236984/1351: elapsed=18959.0us expected=18871.0us +- 94.4us, error 0.5%
(kms_flip:2110) DEBUG: name = flip
last_ts = 83.236984
last_received_ts = 83.236298
last_seq = 1351
current_ts = 83.255928
current_received_ts = 83.255234
current_seq = 1352
count = 472
seq_step = 1
(kms_flip:2110) DEBUG: flip ts/seq: last 83.236984/1351, current 83.255928/1352: elapsed=18942.0us expected=18871.0us +- 94.4us, error 0.4%
(kms_flip:2110) DEBUG: name = flip
last_ts = 83.255928
last_received_ts = 83.255234
last_seq = 1352
current_ts = 83.274864
current_received_ts = 83.274170
current_seq = 1353
count = 473
seq_step = 1
(kms_flip:2110) DEBUG: flip ts/seq: last 83.255928/1352, current 83.274864/1353: elapsed=18942.0us expected=18871.0us +- 94.4us, error 0.4%
(kms_flip:2110) DEBUG: name = flip
last_ts = 83.274864
last_received_ts = 83.274170
last_seq = 1353
current_ts = 83.293808
current_received_ts = 83.293106
current_seq = 1354
count = 474
seq_step = 1
(kms_flip:2110) DEBUG: flip ts/seq: last 83.274864/1353, current 83.293808/1354: elapsed=18943.0us expected=18871.0us +- 94.4us, error 0.4%
(kms_flip:2110) DEBUG: name = flip
last_ts = 83.293808
last_received_ts = 83.293106
last_seq = 1354
current_ts = 83.312737
current_received_ts = 83.312065
current_seq = 1355
count = 475
seq_step = 1
(kms_flip:2110) DEBUG: flip ts/seq: last 83.293808/1354, current 83.312737/1355: elapsed=18930.0us expected=18871.0us +- 94.4us, error 0.3%
(kms_flip:2110) DEBUG: name = flip
last_ts = 83.312737
last_received_ts = 83.312065
last_seq = 1355
current_ts = 83.331680
current_received_ts = 83.331032
current_seq = 1356
count = 476
seq_step = 1
(kms_flip:2110) DEBUG: flip ts/seq: last 83.312737/1355, current 83.331680/1356: elapsed=18940.0us expected=18871.0us +- 94.4us, error 0.4%
(kms_flip:2110) DEBUG: name = flip
last_ts = 83.331680
last_received_ts = 83.331032
last_seq = 1356
current_ts = 83.350639
current_received_ts = 83.349945
current_seq = 1357
count = 477
seq_step = 1
(kms_flip:2110) DEBUG: flip ts/seq: last 83.331680/1356, current 83.350639/1357: elapsed=18959.0us expected=18871.0us +- 94.4us, error 0.5%
(kms_flip:2110) DEBUG: name = flip
last_ts = 83.350639
last_received_ts = 83.349945
last_seq = 1357
current_ts = 83.369583
current_received_ts = 83.368889
current_seq = 1358
count = 478
seq_step = 1
(kms_flip:2110) DEBUG: flip ts/seq: last 83.350639/1357, current 83.369583/1358: elapsed=18943.0us expected=18871.0us +- 94.4us, error 0.4%
(kms_flip:2110) DEBUG: name = flip
last_ts = 83.369583
last_received_ts = 83.368889
last_seq = 1358
current_ts = 83.388527
current_received_ts = 83.387825
current_seq = 1359
count = 479
seq_step = 1
(kms_flip:2110) DEBUG: flip ts/seq: last 83.369583/1358, current 83.388527/1359: elapsed=18943.0us expected=18871.0us +- 94.4us, error 0.4%
(kms_flip:2110) DEBUG: name = flip
last_ts = 83.388527
last_received_ts = 83.387825
last_seq = 1359
current_ts = 83.407471
current_received_ts = 83.406769
current_seq = 1360
count = 480
seq_step = 1
(kms_flip:2110) DEBUG: flip ts/seq: last 83.388527/1359, current 83.407471/1360: elapsed=18943.0us expected=18871.0us +- 94.4us, error 0.4%
(kms_flip:2110) DEBUG: name = flip
last_ts = 83.407471
last_received_ts = 83.406769
last_seq = 1360
current_ts = 83.426392
current_received_ts = 83.425720
current_seq = 1361
count = 481
seq_step = 1
(kms_flip:2110) DEBUG: flip ts/seq: last 83.407471/1360, current 83.426392/1361: elapsed=18927.0us expected=18871.0us +- 94.4us, error 0.3%
(kms_flip:2110) DEBUG: name = flip
last_ts = 83.426392
last_received_ts = 83.425720
last_seq = 1361
current_ts = 83.445351
current_received_ts = 83.444656
current_seq = 1362
count = 482
seq_step = 1
(kms_flip:2110) DEBUG: flip ts/seq: last 83.426392/1361, current 83.445351/1362: elapsed=18959.0us expected=18871.0us +- 94.4us, error 0.5%
(kms_flip:2110) DEBUG: name = flip
last_ts = 83.445351
last_received_ts = 83.444656
last_seq = 1362
current_ts = 83.464294
current_received_ts = 83.463600
current_seq = 1363
count = 483
seq_step = 1
(kms_flip:2110) DEBUG: flip ts/seq: last 83.445351/1362, current 83.464294/1363: elapsed=18943.0us expected=18871.0us +- 94.4us, error 0.4%
(kms_flip:2110) DEBUG: name = flip
last_ts = 83.464294
last_received_ts = 83.463600
last_seq = 1363
current_ts = 83.483223
current_received_ts = 83.482544
current_seq = 1364
count = 484
seq_step = 1
(kms_flip:2110) DEBUG: flip ts/seq: last 83.464294/1363, current 83.483223/1364: elapsed=18926.0us expected=18871.0us +- 94.4us, error 0.3%
(kms_flip:2110) DEBUG: name = flip
last_ts = 83.483223
last_received_ts = 83.482544
last_seq = 1364
current_ts = 83.502167
current_received_ts = 83.501488
current_seq = 1365
count = 485
seq_step = 1
(kms_flip:2110) DEBUG: flip ts/seq: last 83.483223/1364, current 83.502167/1365: elapsed=18943.0us expected=18871.0us +- 94.4us, error 0.4%
(kms_flip:2110) DEBUG: name = flip
last_ts = 83.502167
last_received_ts = 83.501488
last_seq = 1365
current_ts = 83.521126
current_received_ts = 83.520439
current_seq = 1366
count = 486
seq_step = 1
(kms_flip:2110) DEBUG: flip ts/seq: last 83.502167/1365, current 83.521126/1366: elapsed=18959.0us expected=18871.0us +- 94.4us, error 0.5%
(kms_flip:2110) DEBUG: name = flip
last_ts = 83.521126
last_received_ts = 83.520439
last_seq = 1366
current_ts = 83.540070
current_received_ts = 83.539375
current_seq = 1367
count = 487
seq_step = 1
(kms_flip:2110) DEBUG: flip ts/seq: last 83.521126/1366, current 83.540070/1367: elapsed=18943.0us expected=18871.0us +- 94.4us, error 0.4%
(kms_flip:2110) DEBUG: name = flip
last_ts = 83.540070
last_received_ts = 83.539375
last_seq = 1367
current_ts = 83.559013
current_received_ts = 83.558319
current_seq = 1368
count = 488
seq_step = 1
(kms_flip:2110) DEBUG: flip ts/seq: last 83.540070/1367, current 83.559013/1368: elapsed=18943.0us expected=18871.0us +- 94.4us, error 0.4%
(kms_flip:2110) DEBUG: name = flip
last_ts = 83.559013
last_received_ts = 83.558319
last_seq = 1368
current_ts = 83.577934
current_received_ts = 83.577263
current_seq = 1369
count = 489
seq_step = 1
(kms_flip:2110) DEBUG: flip ts/seq: last 83.559013/1368, current 83.577934/1369: elapsed=18926.0us expected=18871.0us +- 94.4us, error 0.3%
(kms_flip:2110) DEBUG: name = flip
last_ts = 83.577934
last_received_ts = 83.577263
last_seq = 1369
current_ts = 83.596893
current_received_ts = 83.596207
current_seq = 1370
count = 490
seq_step = 1
(kms_flip:2110) DEBUG: flip ts/seq: last 83.577934/1369, current 83.596893/1370: elapsed=18959.0us expected=18871.0us +- 94.4us, error 0.5%
(kms_flip:2110) DEBUG: name = flip
last_ts = 83.596893
last_received_ts = 83.596207
last_seq = 1370
current_ts = 83.615837
current_received_ts = 83.615150
current_seq = 1371
count = 491
seq_step = 1
(kms_flip:2110) DEBUG: flip ts/seq: last 83.596893/1370, current 83.615837/1371: elapsed=18943.0us expected=18871.0us +- 94.4us, error 0.4%
(kms_flip:2110) DEBUG: name = flip
last_ts = 83.615837
last_received_ts = 83.615150
last_seq = 1371
current_ts = 83.634781
current_received_ts = 83.634094
current_seq = 1372
count = 492
seq_step = 1
(kms_flip:2110) DEBUG: flip ts/seq: last 83.615837/1371, current 83.634781/1372: elapsed=18943.0us expected=18871.0us +- 94.4us, error 0.4%
(kms_flip:2110) DEBUG: name = flip
last_ts = 83.634781
last_received_ts = 83.634094
last_seq = 1372
current_ts = 83.653725
current_received_ts = 83.653061
current_seq = 1373
count = 493
seq_step = 1
(kms_flip:2110) DEBUG: flip ts/seq: last 83.634781/1372, current 83.653725/1373: elapsed=18943.0us expected=18871.0us +- 94.4us, error 0.4%
(kms_flip:2110) DEBUG: name = flip
last_ts = 83.653725
last_received_ts = 83.653061
last_seq = 1373
current_ts = 83.672668
current_received_ts = 83.671974
current_seq = 1374
count = 494
seq_step = 1
(kms_flip:2110) DEBUG: flip ts/seq: last 83.653725/1373, current 83.672668/1374: elapsed=18943.0us expected=18871.0us +- 94.4us, error 0.4%
(kms_flip:2110) DEBUG: name = flip
last_ts = 83.672668
last_received_ts = 83.671974
last_seq = 1374
current_ts = 83.691612
current_received_ts = 83.690918
current_seq = 1375
count = 495
seq_step = 1
(kms_flip:2110) DEBUG: flip ts/seq: last 83.672668/1374, current 83.691612/1375: elapsed=18947.0us expected=18871.0us +- 94.4us, error 0.4%
(kms_flip:2110) DEBUG: name = flip
last_ts = 83.691612
last_received_ts = 83.690918
last_seq = 1375
current_ts = 83.710564
current_received_ts = 83.709869
current_seq = 1376
count = 496
seq_step = 1
(kms_flip:2110) DEBUG: flip ts/seq: last 83.691612/1375, current 83.710564/1376: elapsed=18947.0us expected=18871.0us +- 94.4us, error 0.4%
(kms_flip:2110) DEBUG: name = flip
last_ts = 83.710564
last_received_ts = 83.709869
last_seq = 1376
current_ts = 83.729507
current_received_ts = 83.728813
current_seq = 1377
count = 497
seq_step = 1
(kms_flip:2110) DEBUG: flip ts/seq: last 83.710564/1376, current 83.729507/1377: elapsed=18947.0us expected=18871.0us +- 94.4us, error 0.4%
(kms_flip:2110) DEBUG: name = flip
last_ts = 83.729507
last_received_ts = 83.728813
last_seq = 1377
current_ts = 83.748436
current_received_ts = 83.747765
current_seq = 1378
count = 498
seq_step = 1
(kms_flip:2110) DEBUG: flip ts/seq: last 83.729507/1377, current 83.748436/1378: elapsed=18930.0us expected=18871.0us +- 94.4us, error 0.3%
(kms_flip:2110) DEBUG: name = flip
last_ts = 83.748436
last_received_ts = 83.747765
last_seq = 1378
current_ts = 83.767403
current_received_ts = 83.766708
current_seq = 1379
count = 499
seq_step = 1
(kms_flip:2110) DEBUG: flip ts/seq: last 83.748436/1378, current 83.767403/1379: elapsed=18963.0us expected=18871.0us +- 94.4us, error 0.5%
(kms_flip:2110) DEBUG: name = flip
last_ts = 83.767403
last_received_ts = 83.766708
last_seq = 1379
current_ts = 83.786346
current_received_ts = 83.785660
current_seq = 1380
count = 500
seq_step = 1
(kms_flip:2110) DEBUG: flip ts/seq: last 83.767403/1379, current 83.786346/1380: elapsed=18947.0us expected=18871.0us +- 94.4us, error 0.4%
(kms_flip:2110) DEBUG: name = flip
last_ts = 83.786346
last_received_ts = 83.785660
last_seq = 1380
current_ts = 83.805298
current_received_ts = 83.804604
current_seq = 1381
count = 501
seq_step = 1
(kms_flip:2110) DEBUG: flip ts/seq: last 83.786346/1380, current 83.805298/1381: elapsed=18946.0us expected=18871.0us +- 94.4us, error 0.4%
(kms_flip:2110) DEBUG: name = flip
last_ts = 83.805298
last_received_ts = 83.804604
last_seq = 1381
current_ts = 83.824242
current_received_ts = 83.823555
current_seq = 1382
count = 502
seq_step = 1
(kms_flip:2110) DEBUG: flip ts/seq: last 83.805298/1381, current 83.824242/1382: elapsed=18947.0us expected=18871.0us +- 94.4us, error 0.4%
(kms_flip:2110) DEBUG: name = flip
last_ts = 83.824242
last_received_ts = 83.823555
last_seq = 1382
current_ts = 83.843185
current_received_ts = 83.842499
current_seq = 1383
count = 503
seq_step = 1
(kms_flip:2110) DEBUG: flip ts/seq: last 83.824242/1382, current 83.843185/1383: elapsed=18946.0us expected=18871.0us +- 94.4us, error 0.4%
(kms_flip:2110) DEBUG: name = flip
last_ts = 83.843185
last_received_ts = 83.842499
last_seq = 1383
current_ts = 83.862137
current_received_ts = 83.861443
current_seq = 1384
count = 504
seq_step = 1
(kms_flip:2110) DEBUG: flip ts/seq: last 83.843185/1383, current 83.862137/1384: elapsed=18947.0us expected=18871.0us +- 94.4us, error 0.4%
(kms_flip:2110) DEBUG: name = flip
last_ts = 83.862137
last_received_ts = 83.861443
last_seq = 1384
current_ts = 83.881081
current_received_ts = 83.880386
current_seq = 1385
count = 505
seq_step = 1
(kms_flip:2110) DEBUG: flip ts/seq: last 83.862137/1384, current 83.881081/1385: elapsed=18947.0us expected=18871.0us +- 94.4us, error 0.4%
(kms_flip:2110) DEBUG: name = flip
last_ts = 83.881081
last_received_ts = 83.880386
last_seq = 1385
current_ts = 83.900009
current_received_ts = 83.899338
current_seq = 1386
count = 506
seq_step = 1
(kms_flip:2110) DEBUG: flip ts/seq: last 83.881081/1385, current 83.900009/1386: elapsed=18930.0us expected=18871.0us +- 94.4us, error 0.3%
(kms_flip:2110) DEBUG: name = flip
last_ts = 83.900009
last_received_ts = 83.899338
last_seq = 1386
current_ts = 83.918976
current_received_ts = 83.918274
current_seq = 1387
count = 507
seq_step = 1
(kms_flip:2110) DEBUG: flip ts/seq: last 83.900009/1386, current 83.918976/1387: elapsed=18963.0us expected=18871.0us +- 94.4us, error 0.5%
(kms_flip:2110) DEBUG: name = flip
last_ts = 83.918976
last_received_ts = 83.918274
last_seq = 1387
current_ts = 83.937920
current_received_ts = 83.937241
current_seq = 1388
count = 508
seq_step = 1
(kms_flip:2110) DEBUG: flip ts/seq: last 83.918976/1387, current 83.937920/1388: elapsed=18947.0us expected=18871.0us +- 94.4us, error 0.4%
(kms_flip:2110) DEBUG: name = flip
last_ts = 83.937920
last_received_ts = 83.937241
last_seq = 1388
current_ts = 83.956871
current_received_ts = 83.956177
current_seq = 1389
count = 509
seq_step = 1
(kms_flip:2110) DEBUG: flip ts/seq: last 83.937920/1388, current 83.956871/1389: elapsed=18947.0us expected=18871.0us +- 94.4us, error 0.4%
(kms_flip:2110) DEBUG: name = flip
last_ts = 83.956871
last_received_ts = 83.956177
last_seq = 1389
current_ts = 83.975815
current_received_ts = 83.975121
current_seq = 1390
count = 510
seq_step = 1
(kms_flip:2110) DEBUG: flip ts/seq: last 83.956871/1389, current 83.975815/1390: elapsed=18947.0us expected=18871.0us +- 94.4us, error 0.4%
(kms_flip:2110) DEBUG: name = flip
last_ts = 83.975815
last_received_ts = 83.975121
last_seq = 1390
current_ts = 83.994743
current_received_ts = 83.994072
current_seq = 1391
count = 511
seq_step = 1
(kms_flip:2110) DEBUG: flip ts/seq: last 83.975815/1390, current 83.994743/1391: elapsed=18931.0us expected=18871.0us +- 94.4us, error 0.3%
(kms_flip:2110) DEBUG: name = flip
last_ts = 83.994743
last_received_ts = 83.994072
last_seq = 1391
current_ts = 84.013710
current_received_ts = 84.013046
current_seq = 1392
count = 512
seq_step = 1
(kms_flip:2110) DEBUG: flip ts/seq: last 83.994743/1391, current 84.013710/1392: elapsed=18962.0us expected=18871.0us +- 94.4us, error 0.5%
(kms_flip:2110) DEBUG: name = flip
last_ts = 84.013710
last_received_ts = 84.013046
last_seq = 1392
current_ts = 84.032654
current_received_ts = 84.031967
current_seq = 1393
count = 513
seq_step = 1
(kms_flip:2110) DEBUG: flip ts/seq: last 84.013710/1392, current 84.032654/1393: elapsed=18946.0us expected=18871.0us +- 94.4us, error 0.4%
(kms_flip:2110) DEBUG: name = flip
last_ts = 84.032654
last_received_ts = 84.031967
last_seq = 1393
current_ts = 84.051605
current_received_ts = 84.050911
current_seq = 1394
count = 514
seq_step = 1
(kms_flip:2110) DEBUG: flip ts/seq: last 84.032654/1393, current 84.051605/1394: elapsed=18948.0us expected=18871.0us +- 94.4us, error 0.4%
(kms_flip:2110) DEBUG: name = flip
last_ts = 84.051605
last_received_ts = 84.050911
last_seq = 1394
current_ts = 84.070534
current_received_ts = 84.069855
current_seq = 1395
count = 515
seq_step = 1
(kms_flip:2110) DEBUG: flip ts/seq: last 84.051605/1394, current 84.070534/1395: elapsed=18930.0us expected=18871.0us +- 94.4us, error 0.3%
(kms_flip:2110) DEBUG: name = flip
last_ts = 84.070534
last_received_ts = 84.069855
last_seq = 1395
current_ts = 84.089478
current_received_ts = 84.088799
current_seq = 1396
count = 516
seq_step = 1
(kms_flip:2110) DEBUG: flip ts/seq: last 84.070534/1395, current 84.089478/1396: elapsed=18947.0us expected=18871.0us +- 94.4us, error 0.4%
(kms_flip:2110) DEBUG: name = flip
last_ts = 84.089478
last_received_ts = 84.088799
last_seq = 1396
current_ts = 84.108444
current_received_ts = 84.107750
current_seq = 1397
count = 517
seq_step = 1
(kms_flip:2110) DEBUG: flip ts/seq: last 84.089478/1396, current 84.108444/1397: elapsed=18963.0us expected=18871.0us +- 94.4us, error 0.5%
(kms_flip:2110) DEBUG: name = flip
last_ts = 84.108444
last_received_ts = 84.107750
last_seq = 1397
current_ts = 84.127388
current_received_ts = 84.126694
current_seq = 1398
count = 518
seq_step = 1
(kms_flip:2110) DEBUG: flip ts/seq: last 84.108444/1397, current 84.127388/1398: elapsed=18946.0us expected=18871.0us +- 94.4us, error 0.4%
(kms_flip:2110) DEBUG: name = flip
last_ts = 84.127388
last_received_ts = 84.126694
last_seq = 1398
current_ts = 84.146317
current_received_ts = 84.145645
current_seq = 1399
count = 519
seq_step = 1
(kms_flip:2110) DEBUG: flip ts/seq: last 84.127388/1398, current 84.146317/1399: elapsed=18931.0us expected=18871.0us +- 94.4us, error 0.3%
(kms_flip:2110) DEBUG: name = flip
last_ts = 84.146317
last_received_ts = 84.145645
last_seq = 1399
current_ts = 84.165268
current_received_ts = 84.164589
current_seq = 1400
count = 520
seq_step = 1
(kms_flip:2110) DEBUG: flip ts/seq: last 84.146317/1399, current 84.165268/1400: elapsed=18947.0us expected=18871.0us +- 94.4us, error 0.4%
(kms_flip:2110) DEBUG: name = flip
last_ts = 84.165268
last_received_ts = 84.164589
last_seq = 1400
current_ts = 84.184227
current_received_ts = 84.183533
current_seq = 1401
count = 521
seq_step = 1
(kms_flip:2110) DEBUG: flip ts/seq: last 84.165268/1400, current 84.184227/1401: elapsed=18963.0us expected=18871.0us +- 94.4us, error 0.5%
(kms_flip:2110) DEBUG: name = flip
last_ts = 84.184227
last_received_ts = 84.183533
last_seq = 1401
current_ts = 84.203178
current_received_ts = 84.202484
current_seq = 1402
count = 522
seq_step = 1
(kms_flip:2110) DEBUG: flip ts/seq: last 84.184227/1401, current 84.203178/1402: elapsed=18946.0us expected=18871.0us +- 94.4us, error 0.4%
(kms_flip:2110) DEBUG: name = flip
last_ts = 84.203178
last_received_ts = 84.202484
last_seq = 1402
current_ts = 84.222122
current_received_ts = 84.221428
current_seq = 1403
count = 523
seq_step = 1
(kms_flip:2110) DEBUG: flip ts/seq: last 84.203178/1402, current 84.222122/1403: elapsed=18947.0us expected=18871.0us +- 94.4us, error 0.4%
(kms_flip:2110) DEBUG: name = flip
last_ts = 84.222122
last_received_ts = 84.221428
last_seq = 1403
current_ts = 84.241066
current_received_ts = 84.240372
current_seq = 1404
count = 524
seq_step = 1
(kms_flip:2110) DEBUG: flip ts/seq: last 84.222122/1403, current 84.241066/1404: elapsed=18946.0us expected=18871.0us +- 94.4us, error 0.4%
(kms_flip:2110) DEBUG: name = flip
last_ts = 84.241066
last_received_ts = 84.240372
last_seq = 1404
current_ts = 84.260017
current_received_ts = 84.259323
current_seq = 1405
count = 525
seq_step = 1
(kms_flip:2110) DEBUG: flip ts/seq: last 84.241066/1404, current 84.260017/1405: elapsed=18947.0us expected=18871.0us +- 94.4us, error 0.4%
(kms_flip:2110) DEBUG: name = flip
last_ts = 84.260017
last_received_ts = 84.259323
last_seq = 1405
current_ts = 84.278961
current_received_ts = 84.278275
current_seq = 1406
count = 526
seq_step = 1
(kms_flip:2110) DEBUG: flip ts/seq: last 84.260017/1405, current 84.278961/1406: elapsed=18947.0us expected=18871.0us +- 94.4us, error 0.4%
(kms_flip:2110) DEBUG: name = flip
last_ts = 84.278961
last_received_ts = 84.278275
last_seq = 1406
current_ts = 84.297897
current_received_ts = 84.297218
current_seq = 1407
count = 527
seq_step = 1
(kms_flip:2110) DEBUG: flip ts/seq: last 84.278961/1406, current 84.297897/1407: elapsed=18931.0us expected=18871.0us +- 94.4us, error 0.3%
(kms_flip:2110) DEBUG: name = flip
last_ts = 84.297897
last_received_ts = 84.297218
last_seq = 1407
current_ts = 84.316841
current_received_ts = 84.316170
current_seq = 1408
count = 528
seq_step = 1
(kms_flip:2110) DEBUG: flip ts/seq: last 84.297897/1407, current 84.316841/1408: elapsed=18947.0us expected=18871.0us +- 94.4us, error 0.4%
(kms_flip:2110) DEBUG: expected 530, counted 529, encoder type 2
(kms_flip:2110) DEBUG: dropped frames, expected 530, counted 529, encoder type 2
(kms_flip:2110) CRITICAL: Test assertion failure function __run_test_on_crtc_set, file ../tests/kms_flip.c:1674:
(kms_flip:2110) CRITICAL: Failed assertion: !retried && needs_retry_after_link_reset(mon)
(kms_flip:2110) igt_core-INFO: Stack trace:
(kms_flip:2110) igt_core-INFO:   #0 ../lib/igt_core.c:2055 __igt_fail_assert()
(kms_flip:2110) igt_core-INFO:   #1 ../tests/kms_flip.c:791 run_test_on_crtc_set.constprop.0()
(kms_flip:2110) igt_core-INFO:   #2 ../tests/kms_flip.c:1845 run_test()
(kms_flip:2110) igt_core-INFO:   #3 ../tests/kms_flip.c:2078 __igt_unique____real_main2001()
(kms_flip:2110) igt_core-INFO:   #4 ../tests/kms_flip.c:2001 main()
(kms_flip:2110) igt_core-INFO:   #5 [__libc_init_first+0x8a]
(kms_flip:2110) igt_core-INFO:   #6 [__libc_start_main+0x8b]
(kms_flip:2110) igt_core-INFO:   #7 [_start+0x25]
****  END  ****
Dynamic subtest A-HDMI-A2: FAIL (13.691s)
Starting dynamic subtest: B-HDMI-A2
Dynamic subtest B-HDMI-A2: SUCCESS (10.502s)
Starting dynamic subtest: C-HDMI-A2
Dynamic subtest C-HDMI-A2: SUCCESS (10.481s)
Subtest plain-flip-ts-check: FAIL (34.680s)
Dmesg
<6> [74.104436] Console: switching to colour dummy device 80x25
<6> [74.104489] [IGT] kms_flip: executing
<7> [74.106323] i915 0000:00:02.0: [drm:i915_gem_open [i915]]
<7> [74.106806] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc]
<7> [74.106971] i915 0000:00:02.0: [drm:i915_gem_open [i915]]
<7> [74.111320] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] [CONNECTOR:189:DP-1]
<7> [74.111342] i915 0000:00:02.0: [drm:intel_dp_detect [i915]] [CONNECTOR:189:DP-1]
<7> [74.116409] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] [CONNECTOR:189:DP-1] disconnected
<7> [74.116679] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] [CONNECTOR:201:HDMI-A-1]
<7> [74.116688] i915 0000:00:02.0: [drm:intel_hdmi_detect [i915]] [CONNECTOR:201:HDMI-A-1]
<7> [74.121434] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] [CONNECTOR:201:HDMI-A-1] disconnected
<7> [74.121864] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] [CONNECTOR:211:DP-2]
<7> [74.121874] i915 0000:00:02.0: [drm:intel_dp_detect [i915]] [CONNECTOR:211:DP-2]
<7> [74.126435] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] [CONNECTOR:211:DP-2] disconnected
<7> [74.126691] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] [CONNECTOR:218:HDMI-A-3]
<7> [74.126700] i915 0000:00:02.0: [drm:intel_hdmi_detect [i915]] [CONNECTOR:218:HDMI-A-3]
<7> [74.131463] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] [CONNECTOR:218:HDMI-A-3] disconnected
<7> [74.131765] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] [CONNECTOR:189:DP-1]
<7> [74.131774] i915 0000:00:02.0: [drm:intel_dp_detect [i915]] [CONNECTOR:189:DP-1]
<7> [74.136498] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] [CONNECTOR:189:DP-1] disconnected
<7> [74.136517] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] [CONNECTOR:201:HDMI-A-1]
<7> [74.136526] i915 0000:00:02.0: [drm:intel_hdmi_detect [i915]] [CONNECTOR:201:HDMI-A-1]
<7> [74.141517] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] [CONNECTOR:201:HDMI-A-1] disconnected
<7> [74.141535] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] [CONNECTOR:207:HDMI-A-2]
<7> [74.141545] i915 0000:00:02.0: [drm:intel_hdmi_detect [i915]] [CONNECTOR:207:HDMI-A-2]
<7> [74.167804] i915 0000:00:02.0: [drm:update_display_info.part.0] [CONNECTOR:207:HDMI-A-2] Supported Monitor Refresh rate range is 0 Hz - 0 Hz
<7> [74.167819] i915 0000:00:02.0: [drm:update_display_info.part.0] [CONNECTOR:207:HDMI-A-2] Assigning EDID-1.4 digital sink color depth as 8 bpc.
<7> [74.167824] i915 0000:00:02.0: [drm:update_display_info.part.0] [CONNECTOR:207:HDMI-A-2] ELD monitor fitHeadless4k
<7> [74.167828] i915 0000:00:02.0: [drm:update_display_info.part.0] [CONNECTOR:207:HDMI-A-2] ELD size 36, SAD count 0
<7> [74.168057] i915 0000:00:02.0: [drm:do_gmbus_xfer [i915]] GMBUS [i915 gmbus tc1] NAK for addr: 0040 w(1)
<7> [74.168272] i915 0000:00:02.0: [drm:do_gmbus_xfer [i915]] GMBUS [i915 gmbus tc1] NAK on first message, retry
<7> [74.168706] i915 0000:00:02.0: [drm:do_gmbus_xfer [i915]] GMBUS [i915 gmbus tc1] NAK for addr: 0040 w(1)
<7> [74.168918] i915 0000:00:02.0: [drm:drm_dp_dual_mode_detect [drm_display_helper]] DP dual mode HDMI ID: (err -6)
<7> [74.169594] 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> [74.169606] 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> [74.169614] 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> [74.169623] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] [CONNECTOR:207:HDMI-A-2] probed modes:
<7> [74.169637] 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> [74.169673] 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> [74.169687] 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> [74.169700] 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> [74.169713] 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> [74.169725] 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> [74.169738] 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> [74.169750] 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> [74.169763] 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> [74.169775] 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> [74.169796] 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> [74.169818] 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> [74.169833] 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> [74.169845] 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> [74.169857] 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> [74.169869] 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> [74.169881] 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> [74.169893] 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> [74.169905] 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> [74.169916] 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> [74.169928] 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> [74.169940] 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> [74.169951] 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> [74.169963] 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> [74.169974] 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> [74.169986] 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> [74.169997] 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> [74.170009] 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> [74.170020] 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> [74.170032] 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> [74.170043] 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> [74.170079] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] [CONNECTOR:211:DP-2]
<7> [74.170092] i915 0000:00:02.0: [drm:intel_dp_detect [i915]] [CONNECTOR:211:DP-2]
<7> [74.174700] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] [CONNECTOR:211:DP-2] disconnected
<7> [74.174723] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] [CONNECTOR:218:HDMI-A-3]
<7> [74.174734] i915 0000:00:02.0: [drm:intel_hdmi_detect [i915]] [CONNECTOR:218:HDMI-A-3]
<7> [74.179754] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] [CONNECTOR:218:HDMI-A-3] disconnected
<6> [74.180191] [IGT] kms_flip: starting subtest plain-flip-ts-check
<6> [74.182296] [IGT] kms_flip: starting dynamic subtest A-HDMI-A2
<7> [74.182631] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:224]
<7> [74.182685] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:225]
<7> [74.226776] i915 0000:00:02.0: [drm:drm_mode_setcrtc] [CRTC:82:pipe A]
<7> [74.226877] 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> [74.227278] 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> [74.227572] 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> [74.227803] 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> [74.228048] 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> [74.228277] 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> [74.228558] 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> [74.228791] 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> [74.229038] 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> [74.229269] 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> [74.229545] 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> [74.229776] 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> [74.230024] 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> [74.230242] 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> [74.230501] 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> [74.230757] 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> [74.231001] 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> [74.231233] 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> [74.231424] 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> [74.231622] 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> [74.231797] 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> [74.231973] 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> [74.232174] 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> [74.232394] 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> [74.232570] 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> [74.232752] 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> [74.232927] 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> [74.233116] 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> [74.233328] 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> [74.233496] 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> [74.233674] 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> [74.233849] 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> [74.234033] 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> [74.234250] 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> [74.234413] 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> [74.234542] 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> [74.234677] 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> [74.234811] i915 0000:00:02.0: [drm:intel_atomic_check [i915]] [CRTC:82:pipe A] fastset requirement not met, forcing full modeset
<7> [74.234944] i915 0000:00:02.0: [drm:intel_unreference_shared_dpll_crtc [i915]] [CRTC:82:pipe A] releasing DPLL 0
<7> [74.235160] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] Enabled dbuf slices 0x3 -> 0x1 (total dbuf slices 0x3), mbus joined? no->no
<7> [74.235290] 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> [74.235456] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] [PLANE:32:plane 1A] ddb ( 0 - 2016) -> ( 0 - 0), size 2016 -> 0
<7> [74.235592] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] [PLANE:77:cursor A] ddb (2016 - 2048) -> ( 0 - 0), size 32 -> 0
<7> [74.235726] 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> [74.235897] 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> [74.236036] 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> [74.236172] 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> [74.236299] i915 0000:00:02.0: [drm:intel_bw_atomic_check [i915]] [CRTC:82:pipe A] data rate 0 num active planes 0
<7> [74.236441] i915 0000:00:02.0: [drm:intel_bw_atomic_check [i915]] QGV point 0: max bw 16761 required 0
<7> [74.236600] i915 0000:00:02.0: [drm:intel_modeset_calc_cdclk [i915]] New cdclk calculated to be logical 180000 kHz, actual 180000 kHz
<7> [74.236756] i915 0000:00:02.0: [drm:intel_modeset_calc_cdclk [i915]] New voltage level calculated to be logical 0, actual 0
<7> [74.236889] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [CRTC:82:pipe A] enable: no [modeset]
<7> [74.237040] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:32:plane 1A] fb: [NOFB], visible: no
<7> [74.237172] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:41:plane 2A] fb: [NOFB], visible: no
<7> [74.237309] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:50:plane 3A] fb: [NOFB], visible: no
<7> [74.237439] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:59:plane 4A] fb: [NOFB], visible: no
<7> [74.237613] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:68:plane 5A] fb: [NOFB], visible: no
<7> [74.237742] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:77:cursor A] fb: [NOFB], visible: no
<7> [74.245096] i915 0000:00:02.0: [drm:intel_disable_transcoder [i915]] disabling pipe A
<7> [74.261328] i915 0000:00:02.0: [drm:intel_power_well_disable [i915]] disabling DDI_IO_TC1
<7> [74.261807] i915 0000:00:02.0: [drm:intel_disable_shared_dpll [i915]] disable DPLL 0 (active 0x1, on? 1) for [CRTC:82:pipe A]
<7> [74.262336] i915 0000:00:02.0: [drm:intel_disable_shared_dpll [i915]] disabling DPLL 0
<7> [74.262886] i915 0000:00:02.0: [drm:__intel_fbc_disable [i915]] Disabling FBC on [PLANE:32:plane 1A]
<7> [74.263433] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:188:DDI B/PHY B]
<7> [74.263887] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:190:DP-MST A]
<7> [74.264458] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:191:DP-MST B]
<7> [74.264873] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:192:DP-MST C]
<7> [74.265326] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:206:DDI TC1/PHY C]
<7> [74.265875] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:210:DDI TC2/PHY D]
<7> [74.266344] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:212:DP-MST A]
<7> [74.266767] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:213:DP-MST B]
<7> [74.267269] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:214:DP-MST C]
<7> [74.267622] i915 0000:00:02.0: [drm:verify_connector_state [i915]] [CONNECTOR:207:HDMI-A-2]
<7> [74.268113] i915 0000:00:02.0: [drm:gen9_dbuf_slices_update [i915]] Updating dbuf slices to 0x1
<7> [74.268580] i915 0000:00:02.0: [drm:intel_power_well_disable [i915]] disabling PW_3
<7> [74.268966] i915 0000:00:02.0: [drm:intel_modeset_verify_crtc [i915]] [CRTC:82:pipe A]
<7> [74.269806] i915 0000:00:02.0: [drm:drm_mode_setcrtc] [CRTC:134:pipe B]
<7> [74.270098] i915 0000:00:02.0: [drm:drm_mode_setcrtc] [CRTC:186:pipe C]
<7> [74.270410] i915 0000:00:02.0: [drm:drm_mode_setcrtc] [CRTC:82:pipe A]
<7> [74.270458] i915 0000:00:02.0: [drm:drm_mode_setcrtc] [CONNECTOR:207:HDMI-A-2]
<7> [74.270587] i915 0000:00:02.0: [drm:intel_atomic_check [i915]] [CONNECTOR:207:HDMI-A-2] Limiting display bpp to 24 (EDID bpp 24, max requested bpp 36, max platform bpp 36)
<7> [74.270868] i915 0000:00:02.0: [drm:intel_hdmi_compute_clock [i915]] picking 8 bpc for HDMI output (pipe bpp: 24)
<7> [74.271125] i915 0000:00:02.0: [drm:intel_atomic_check [i915]] [CRTC:82:pipe A] hw max bpp: 24, pipe bpp: 24, dithering: 0
<7> [74.271406] i915 0000:00:02.0: [drm:intel_ddi_compute_config_late [i915]] [ENCODER:206:DDI TC1/PHY C] [CRTC:82:pipe A]
<7> [74.271720] 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> [74.271993] 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> [74.272277] 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> [74.272544] 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> [74.272876] 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> [74.273142] 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> [74.273400] 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> [74.273593] 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> [74.273816] 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> [74.274007] 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> [74.274195] 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> [74.274404] 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> [74.274639] 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> [74.274819] 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> [74.275013] 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> [74.275204] 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> [74.275405] 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> [74.275635] 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> [74.275824] 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> [74.276014] 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> [74.276201] 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> [74.276378] 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> [74.276536] 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> [74.276663] 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> [74.276798] 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> [74.276925] 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> [74.277058] 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> [74.277204] 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> [74.277394] 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> [74.277567] 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> [74.277724] 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> [74.277857] 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> [74.277992] 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> [74.278161] 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> [74.278302] 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> [74.278439] 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> [74.278567] 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> [74.278704] i915 0000:00:02.0: [drm:intel_atomic_check [i915]] [CRTC:82:pipe A] fastset requirement not met, forcing full modeset
<7> [74.278854] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] Enabled dbuf slices 0x1 -> 0x3 (total dbuf slices 0x3), mbus joined? no->no
<7> [74.279023] 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> [74.279185] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] [PLANE:32:plane 1A] ddb ( 0 - 0) -> ( 0 - 2016), size 0 -> 2016
<7> [74.279333] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] [PLANE:77:cursor A] ddb ( 0 - 0) -> (2016 - 2048), size 0 -> 32
<7> [74.279462] 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> [74.279597] 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> [74.279727] 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> [74.279890] 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> [74.280017] i915 0000:00:02.0: [drm:intel_bw_atomic_check [i915]] [CRTC:82:pipe A] data rate 559716 num active planes 1
<7> [74.280159] i915 0000:00:02.0: [drm:intel_bw_atomic_check [i915]] QGV point 0: max bw 16761 required 560
<7> [74.280300] i915 0000:00:02.0: [drm:intel_bw_atomic_check [i915]] No SAGV, using single QGV point mask 0x1
<7> [74.280449] 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> [74.280607] i915 0000:00:02.0: [drm:intel_bw_calc_min_cdclk [i915]] new bandwidth min cdclk (10932 kHz) > old min cdclk (0 kHz)
<7> [74.280754] i915 0000:00:02.0: [drm:intel_modeset_calc_cdclk [i915]] New cdclk calculated to be logical 180000 kHz, actual 180000 kHz
<7> [74.280885] i915 0000:00:02.0: [drm:intel_modeset_calc_cdclk [i915]] New voltage level calculated to be logical 0, actual 0
<7> [74.281024] i915 0000:00:02.0: [drm:intel_find_shared_dpll [i915]] [CRTC:82:pipe A] allocated DPLL 0
<7> [74.281159] i915 0000:00:02.0: [drm:intel_reference_shared_dpll_crtc [i915]] [CRTC:82:pipe A] reserving DPLL 0
<7> [74.281363] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [CRTC:82:pipe A] enable: yes [modeset]
<7> [74.281517] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] active: yes, output_types: HDMI (0x40), output format: RGB, sink format: RGB
<7> [74.281647] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] cpu_transcoder: A, pipe bpp: 24, dithering: 0
<7> [74.281783] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] MST master transcoder: <invalid>
<7> [74.281910] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] port sync: master transcoder: <invalid>, slave transcoder bitmask = 0x0
<7> [74.282044] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] joiner: no, pipes: 0x0
<7> [74.282178] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] splitter: disabled, link count 0, overlap 0
<7> [74.282365] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] audio: 0, infoframes: 0, infoframes enabled: 0x0
<7> [74.282496] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] scanline offset: 2
<7> [74.282634] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] vblank delay: 0, framestart delay: 1, MSA timing delay: 0
<7> [74.282764] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] vrr: no, vmin: 0, vmax: 0, flipline: 0, pipeline full: 0, guardband: 0 vsync start: 0, vsync end: 0
<7> [74.282901] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] vrr: vmin vblank: -1, vmax vblank: -2, vmin vtotal: 1, vmax vtotal: 0
<7> [74.283029] 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> [74.283200] 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> [74.283342] 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> [74.283481] 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> [74.283609] 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> [74.283750] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] port clock: 139929, pipe src: 1920x1080+0+0, pixel rate 139929
<7> [74.283893] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] linetime: 135, ips linetime: 0
<7> [74.284043] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] num_scalers: 2, scaler_users: 0x0, scaler_id: -1, scaling_filter: 0
<7> [74.284170] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pch pfit: 0x0+0+0, disabled, force thru: no
<7> [74.284314] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] ips: 0, double wide: 0, drrs: 0
<7> [74.284441] 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> [74.284576] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] csc_mode: 0x0 gamma_mode: 0x0 gamma_enable: 0 csc_enable: 0
<7> [74.284702] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pre csc lut: 0 entries, post csc lut: 0 entries
<7> [74.284872] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] output csc: pre offsets: 0x0000 0x0000 0x0000
<7> [74.284999] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] output csc: coefficients: 0x0000 0x0000 0x0000
<7> [74.285127] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] output csc: coefficients: 0x0000 0x0000 0x0000
<7> [74.285262] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] output csc: coefficients: 0x0000 0x0000 0x0000
<7> [74.285417] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] output csc: post offsets: 0x0000 0x0000 0x0000
<7> [74.285546] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pipe csc: pre offsets: 0x0000 0x0000 0x0000
<7> [74.285713] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pipe csc: coefficients: 0x0000 0x0000 0x0000
<7> [74.285839] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pipe csc: coefficients: 0x0000 0x0000 0x0000
<7> [74.285974] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pipe csc: coefficients: 0x0000 0x0000 0x0000
<7> [74.286102] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pipe csc: post offsets: 0x0000 0x0000 0x0000
<7> [74.286236] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:32:plane 1A] fb: [FB:224] 1920x1080 format = XR24 little-endian (0x34325258) modifier = 0x0, visible: yes
<7> [74.286383] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] rotation: 0x1, scaler: -1, scaling_filter: 0
<7> [74.286534] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] src: 1920.000000x1080.000000+0.000000+0.000000 dst: 1920x1080+0+0
<7> [74.286661] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:41:plane 2A] fb: [NOFB], visible: no
<7> [74.286796] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:50:plane 3A] fb: [NOFB], visible: no
<7> [74.286921] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:59:plane 4A] fb: [NOFB], visible: no
<7> [74.287054] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:68:plane 5A] fb: [NOFB], visible: no
<7> [74.287198] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:77:cursor A] fb: [NOFB], visible: no
<7> [74.287749] i915 0000:00:02.0: [drm:intel_power_well_enable [i915]] enabling PW_3
<7> [74.287908] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:188:DDI B/PHY B]
<7> [74.288078] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:190:DP-MST A]
<7> [74.288207] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:191:DP-MST B]
<7> [74.288358] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:192:DP-MST C]
<7> [74.288487] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:206:DDI TC1/PHY C]
<7> [74.288623] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:210:DDI TC2/PHY D]
<7> [74.288751] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:212:DP-MST A]
<7> [74.288910] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:213:DP-MST B]
<7> [74.289049] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:214:DP-MST C]
<7> [74.289213] i915 0000:00:02.0: [drm:gen9_dbuf_slices_update [i915]] Updating dbuf slices to 0x3
<7> [74.289395] i915 0000:00:02.0: [drm:intel_enable_shared_dpll [i915]] enable DPLL 0 (active 0x1, on? 0) for [CRTC:82:pipe A]
<7> [74.289536] i915 0000:00:02.0: [drm:intel_enable_shared_dpll [i915]] enabling DPLL 0
<7> [74.289748] i915 0000:00:02.0: [drm:intel_power_well_enable [i915]] enabling DDI_IO_TC1
<7> [74.289915] i915 0000:00:02.0: [drm:intel_enable_transcoder [i915]] enabling pipe A
<7> [74.294341] i915 0000:00:02.0: [drm:intel_fbc_update [i915]] reserved 17694720 bytes of contiguous stolen space for FBC, limit: 1
<7> [74.294553] i915 0000:00:02.0: [drm:intel_fbc_update [i915]] Enabling FBC on [PLANE:32:plane 1A]
<7> [74.309313] i915 0000:00:02.0: [drm:verify_connector_state [i915]] [CONNECTOR:207:HDMI-A-2]
<7> [74.309501] i915 0000:00:02.0: [drm:intel_modeset_verify_crtc [i915]] [CRTC:82:pipe A]
<6> [87.873820] [IGT] kms_flip: finished subtest A-HDMI-A2, FAIL
<6> [87.874756] [IGT] kms_flip: starting dynamic subtest B-HDMI-A2
<7> [87.875592] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:226]
<7> [87.875774] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:227]
<7> [87.914406] i915 0000:00:02.0: [drm:drm_mode_setcrtc] [CRTC:82:pipe A]
<7> [87.914609] 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> [87.915057] 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> [87.915484] 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> [87.915900] 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> [87.916310] 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> [87.916732] 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> [87.917132] 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> [87.917498] 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> [87.917826] 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> [87.918156] 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> [87.918496] 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> [87.918824] 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> [87.919151] 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> [87.919489] 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> [87.919815] 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> [87.920149] 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> [87.920425] 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> [87.920716] 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> [87.920987] 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> [87.921247] 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> [87.921374] 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> [87.921510] 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> [87.921641] 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> [87.921770] 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> [87.921898] 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> [87.922025] 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> [87.922152] 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> [87.922279] 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> [87.922407] 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> [87.922540] 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> [87.922672] 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> [87.922799] 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> [87.922926] 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> [87.923054] 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> [87.923180] 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> [87.923308] 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> [87.923434] 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> [87.923569] i915 0000:00:02.0: [drm:intel_atomic_check [i915]] [CRTC:82:pipe A] fastset requirement not met, forcing full modeset
<7> [87.923697] i915 0000:00:02.0: [drm:intel_unreference_shared_dpll_crtc [i915]] [CRTC:82:pipe A] releasing DPLL 0
<7> [87.923847] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] Enabled dbuf slices 0x3 -> 0x1 (total dbuf slices 0x3), mbus joined? no->no
<7> [87.923976] 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> [87.924135] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] [PLANE:32:plane 1A] ddb ( 0 - 2016) -> ( 0 - 0), size 2016 -> 0
<7> [87.924264] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] [PLANE:77:cursor A] ddb (2016 - 2048) -> ( 0 - 0), size 32 -> 0
<7> [87.924392] 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> [87.924526] 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> [87.924653] 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> [87.924779] 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> [87.924906] i915 0000:00:02.0: [drm:intel_bw_atomic_check [i915]] [CRTC:82:pipe A] data rate 0 num active planes 0
<7> [87.925040] i915 0000:00:02.0: [drm:intel_bw_atomic_check [i915]] QGV point 0: max bw 16761 required 0
<7> [87.925185] i915 0000:00:02.0: [drm:intel_modeset_calc_cdclk [i915]] New cdclk calculated to be logical 180000 kHz, actual 180000 kHz
<7> [87.925315] i915 0000:00:02.0: [drm:intel_modeset_calc_cdclk [i915]] New voltage level calculated to be logical 0, actual 0
<7> [87.925446] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [CRTC:82:pipe A] enable: no [modeset]
<7> [87.925585] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:32:plane 1A] fb: [NOFB], visible: no
<7> [87.925715] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:41:plane 2A] fb: [NOFB], visible: no
<7> [87.925845] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:50:plane 3A] fb: [NOFB], visible: no
<7> [87.925975] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:59:plane 4A] fb: [NOFB], visible: no
<7> [87.926103] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:68:plane 5A] fb: [NOFB], visible: no
<7> [87.926231] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:77:cursor A] fb: [NOFB], visible: no
<7> [87.936510] i915 0000:00:02.0: [drm:intel_disable_transcoder [i915]] disabling pipe A
<7> [87.952105] i915 0000:00:02.0: [drm:intel_power_well_disable [i915]] disabling DDI_IO_TC1
<7> [87.952457] i915 0000:00:02.0: [drm:intel_disable_shared_dpll [i915]] disable DPLL 0 (active 0x1, on? 1) for [CRTC:82:pipe A]
<7> [87.952847] i915 0000:00:02.0: [drm:intel_disable_shared_dpll [i915]] disabling DPLL 0
<7> [87.953181] i915 0000:00:02.0: [drm:__intel_fbc_disable [i915]] Disabling FBC on [PLANE:32:plane 1A]
<7> [87.953523] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:188:DDI B/PHY B]
<7> [87.953843] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:190:DP-MST A]
<7> [87.954151] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:191:DP-MST B]
<7> [87.954463] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:192:DP-MST C]
<7> [87.954802] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:206:DDI TC1/PHY C]
<7> [87.955134] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:210:DDI TC2/PHY D]
<7> [87.955442] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:212:DP-MST A]
<7> [87.955786] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:213:DP-MST B]
<7> [87.956092] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:214:DP-MST C]
<7> [87.956394] i915 0000:00:02.0: [drm:verify_connector_state [i915]] [CONNECTOR:207:HDMI-A-2]
<7> [87.956813] i915 0000:00:02.0: [drm:gen9_dbuf_slices_update [i915]] Updating dbuf slices to 0x1
<7> [87.957204] i915 0000:00:02.0: [drm:intel_power_well_disable [i915]] disabling PW_3
<7> [87.957606] i915 0000:00:02.0: [drm:intel_modeset_verify_crtc [i915]] [CRTC:82:pipe A]
<7> [87.958367] i915 0000:00:02.0: [drm:drm_mode_setcrtc] [CRTC:134:pipe B]
<7> [87.958673] i915 0000:00:02.0: [drm:drm_mode_setcrtc] [CRTC:186:pipe C]
<7> [87.958930] i915 0000:00:02.0: [drm:drm_mode_setcrtc] [CRTC:134:pipe B]
<7> [87.958975] i915 0000:00:02.0: [drm:drm_mode_setcrtc] [CONNECTOR:207:HDMI-A-2]
<7> [87.959088] i915 0000:00:02.0: [drm:intel_atomic_check [i915]] [CONNECTOR:207:HDMI-A-2] Limiting display bpp to 24 (EDID bpp 24, max requested bpp 36, max platform bpp 36)
<7> [87.959412] i915 0000:00:02.0: [drm:intel_hdmi_compute_clock [i915]] picking 8 bpc for HDMI output (pipe bpp: 24)
<7> [87.959715] i915 0000:00:02.0: [drm:intel_atomic_check [i915]] [CRTC:134:pipe B] hw max bpp: 24, pipe bpp: 24, dithering: 0
<7> [87.960004] i915 0000:00:02.0: [drm:intel_ddi_compute_config_late [i915]] [ENCODER:206:DDI TC1/PHY C] [CRTC:134:pipe B]
<7> [87.960287] 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> [87.960596] 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> [87.960885] 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> [87.961171] 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> [87.961456] 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> [87.961764] 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> [87.962044] 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> [87.962324] 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> [87.962547] 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> [87.962756] 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> [87.962966] 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> [87.963183] 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> [87.963397] 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> [87.963628] 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> [87.963838] 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> [87.964048] 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> [87.964257] 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> [87.964468] 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> [87.964691] 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> [87.964900] 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> [87.965107] 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> [87.965308] 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> [87.965461] 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> [87.965623] 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> [87.965777] 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> [87.965931] 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> [87.966084] 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> [87.966236] 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> [87.966390] 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> [87.966548] 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> [87.966702] 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> [87.966855] 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> [87.967008] 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> [87.967163] 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> [87.967316] 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> [87.967470] 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> [87.967633] 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> [87.967787] i915 0000:00:02.0: [drm:intel_atomic_check [i915]] [CRTC:134:pipe B] fastset requirement not met, forcing full modeset
<7> [87.967961] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] Enabled dbuf slices 0x1 -> 0x3 (total dbuf slices 0x3), mbus joined? no->no
<7> [87.968118] 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> [87.968306] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] [PLANE:84:plane 1B] ddb ( 0 - 0) -> ( 0 - 2016), size 0 -> 2016
<7> [87.968434] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] [PLANE:129:cursor B] ddb ( 0 - 0) -> (2016 - 2048), size 0 -> 32
<7> [87.968571] 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> [87.968702] 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> [87.968830] 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> [87.968958] 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> [87.969085] i915 0000:00:02.0: [drm:intel_bw_atomic_check [i915]] [CRTC:134:pipe B] data rate 559716 num active planes 1
<7> [87.969228] i915 0000:00:02.0: [drm:intel_bw_atomic_check [i915]] QGV point 0: max bw 16761 required 560
<7> [87.969359] i915 0000:00:02.0: [drm:intel_bw_atomic_check [i915]] No SAGV, using single QGV point mask 0x1
<7> [87.969499] 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> [87.969640] i915 0000:00:02.0: [drm:intel_bw_calc_min_cdclk [i915]] new bandwidth min cdclk (10932 kHz) > old min cdclk (0 kHz)
<7> [87.969771] i915 0000:00:02.0: [drm:intel_modeset_calc_cdclk [i915]] New cdclk calculated to be logical 180000 kHz, actual 180000 kHz
<7> [87.969899] i915 0000:00:02.0: [drm:intel_modeset_calc_cdclk [i915]] New voltage level calculated to be logical 0, actual 0
<7> [87.970030] i915 0000:00:02.0: [drm:intel_find_shared_dpll [i915]] [CRTC:134:pipe B] allocated DPLL 0
<7> [87.970164] i915 0000:00:02.0: [drm:intel_reference_shared_dpll_crtc [i915]] [CRTC:134:pipe B] reserving DPLL 0
<7> [87.970298] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [CRTC:134:pipe B] enable: yes [modeset]
<7> [87.970430] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] active: yes, output_types: HDMI (0x40), output format: RGB, sink format: RGB
<7> [87.970566] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] cpu_transcoder: B, pipe bpp: 24, dithering: 0
<7> [87.970696] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] MST master transcoder: <invalid>
<7> [87.970827] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] port sync: master transcoder: <invalid>, slave transcoder bitmask = 0x0
<7> [87.970955] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] joiner: no, pipes: 0x0
<7> [87.971084] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] splitter: disabled, link count 0, overlap 0
<7> [87.971212] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] audio: 0, infoframes: 0, infoframes enabled: 0x0
<7> [87.971339] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] scanline offset: 2
<7> [87.971467] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] vblank delay: 0, framestart delay: 1, MSA timing delay: 0
<7> [87.971601] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] vrr: no, vmin: 0, vmax: 0, flipline: 0, pipeline full: 0, guardband: 0 vsync start: 0, vsync end: 0
<7> [87.971730] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] vrr: vmin vblank: -1, vmax vblank: -2, vmin vtotal: 1, vmax vtotal: 0
<7> [87.971858] 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> [87.971986] 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> [87.972116] 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> [87.972248] 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> [87.972378] 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> [87.972507] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] port clock: 139929, pipe src: 1920x1080+0+0, pixel rate 139929
<7> [87.972649] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] linetime: 135, ips linetime: 0
<7> [87.972776] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] num_scalers: 2, scaler_users: 0x0, scaler_id: -1, scaling_filter: 0
<7> [87.972903] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pch pfit: 0x0+0+0, disabled, force thru: no
<7> [87.973030] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] ips: 0, double wide: 0, drrs: 0
<7> [87.973156] 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> [87.973285] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] csc_mode: 0x0 gamma_mode: 0x0 gamma_enable: 0 csc_enable: 0
<7> [87.973411] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pre csc lut: 0 entries, post csc lut: 0 entries
<7> [87.973541] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] output csc: pre offsets: 0x0000 0x0000 0x0000
<7> [87.973669] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] output csc: coefficients: 0x0000 0x0000 0x0000
<7> [87.973795] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] output csc: coefficients: 0x0000 0x0000 0x0000
<7> [87.973922] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] output csc: coefficients: 0x0000 0x0000 0x0000
<7> [87.974048] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] output csc: post offsets: 0x0000 0x0000 0x0000
<7> [87.974174] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pipe csc: pre offsets: 0x0000 0x0000 0x0000
<7> [87.974301] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pipe csc: coefficients: 0x0000 0x0000 0x0000
<7> [87.974427] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pipe csc: coefficients: 0x0000 0x0000 0x0000
<7> [87.974560] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pipe csc: coefficients: 0x0000 0x0000 0x0000
<7> [87.974687] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pipe csc: post offsets: 0x0000 0x0000 0x0000
<7> [87.974813] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:84:plane 1B] fb: [FB:226] 1920x1080 format = XR24 little-endian (0x34325258) modifier = 0x0, visible: yes
<7> [87.974941] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] rotation: 0x1, scaler: -1, scaling_filter: 0
<7> [87.975067] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] src: 1920.000000x1080.000000+0.000000+0.000000 dst: 1920x1080+0+0
<7> [87.975194] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:93:plane 2B] fb: [NOFB], visible: no
<7> [87.975319] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:102:plane 3B] fb: [NOFB], visible: no
<7> [87.975445] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:111:plane 4B] fb: [NOFB], visible: no
<7> [87.975577] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:120:plane 5B] fb: [NOFB], visible: no
<7> [87.975703] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:129:cursor B] fb: [NOFB], visible: no
<7> [87.976268] i915 0000:00:02.0: [drm:intel_power_well_enable [i915]] enabling PW_3
<7> [87.976438] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:188:DDI B/PHY B]
<7> [87.976587] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:190:DP-MST A]
<7> [87.976720] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:191:DP-MST B]
<7> [87.976851] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:192:DP-MST C]
<7> [87.976981] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:206:DDI TC1/PHY C]
<7> [87.977111] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:210:DDI TC2/PHY D]
<7> [87.977241] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:212:DP-MST A]
<7> [87.977370] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:213:DP-MST B]
<7> [87.977497] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:214:DP-MST C]
<7> [87.977659] i915 0000:00:02.0: [drm:gen9_dbuf_slices_update [i915]] Updating dbuf slices to 0x3
<7> [87.977825] i915 0000:00:02.0: [drm:intel_enable_shared_dpll [i915]] enable DPLL 0 (active 0x2, on? 0) for [CRTC:134:pipe B]
<7> [87.977959] i915 0000:00:02.0: [drm:intel_enable_shared_dpll [i915]] enabling DPLL 0
<7> [87.978144] i915 0000:00:02.0: [drm:intel_power_well_enable [i915]] enabling DDI_IO_TC1
<7> [87.978311] i915 0000:00:02.0: [drm:intel_enable_transcoder [i915]] enabling pipe B
<7> [87.998101] i915 0000:00:02.0: [drm:verify_connector_state [i915]] [CONNECTOR:207:HDMI-A-2]
<7> [87.998281] i915 0000:00:02.0: [drm:intel_modeset_verify_crtc [i915]] [CRTC:134:pipe B]
<7> [98.357817] i915 0000:00:02.0: [drm:drm_mode_rmfb_work_fn] Removing [FB:227] from all active usage due to RMFB ioctl
<7> [98.357911] i915 0000:00:02.0: [drm:atomic_remove_fb] Disabling [PLANE:84:plane 1B] because [FB:227] is removed
<7> [98.358029] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] [PLANE:84:plane 1B] ddb ( 0 - 2016) -> ( 0 - 0), size 2016 -> 0
<7> [98.358569] 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> [98.359126] 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> [98.359679] 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> [98.360211] 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> [98.360766] i915 0000:00:02.0: [drm:intel_bw_atomic_check [i915]] [CRTC:134:pipe B] data rate 0 num active planes 0
<7> [98.361321] i915 0000:00:02.0: [drm:intel_bw_atomic_check [i915]] QGV point 0: max bw 16761 required 0
<6> [98.377238] [IGT] kms_flip: finished subtest B-HDMI-A2, SUCCESS
<6> [98.378255] [IGT] kms_flip: starting dynamic subtest C-HDMI-A2
<7> [98.379143] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:226]
<7> [98.379319] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:227]
<7> [98.418303] i915 0000:00:02.0: [drm:drm_mode_setcrtc] [CRTC:82:pipe A]
<7> [98.418639] i915 0000:00:02.0: [drm:drm_mode_setcrtc] [CRTC:134:pipe B]
<7> [98.418790] 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> [98.419173] 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> [98.419635] 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> [98.420045] 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> [98.420448] 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> [98.420884] 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> [98.421279] 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> [98.421703] 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> [98.422097] 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> [98.422447] 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> [98.422784] 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> [98.423094] 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> [98.423401] 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> [98.423734] 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> [98.424053] 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> [98.424369] 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> [98.424701] 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> [98.425014] 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> [98.425325] 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> [98.425586] 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> [98.425835] 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> [98.426080] 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> [98.426325] 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> [98.426580] 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> [98.426825] 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> [98.427071] 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> [98.427315] 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> [98.427558] 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> [98.427827] 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> [98.428072] 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> [98.428315] 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> [98.428508] 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> [98.428697] 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> [98.428875] 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> [98.429052] 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> [98.429228] 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> [98.429404] 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> [98.429595] i915 0000:00:02.0: [drm:intel_atomic_check [i915]] [CRTC:134:pipe B] fastset requirement not met, forcing full modeset
<7> [98.429773] i915 0000:00:02.0: [drm:intel_unreference_shared_dpll_crtc [i915]] [CRTC:134:pipe B] releasing DPLL 0
<7> [98.430002] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] Enabled dbuf slices 0x3 -> 0x1 (total dbuf slices 0x3), mbus joined? no->no
<7> [98.430188] 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 -> 0x0
<7> [98.430406] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] [PLANE:129:cursor B] ddb (2016 - 2048) -> ( 0 - 0), size 32 -> 0
<7> [98.430630] i915 0000:00:02.0: [drm:intel_modeset_calc_cdclk [i915]] New cdclk calculated to be logical 180000 kHz, actual 180000 kHz
<7> [98.430817] i915 0000:00:02.0: [drm:intel_modeset_calc_cdclk [i915]] New voltage level calculated to be logical 0, actual 0
<7> [98.431003] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [CRTC:134:pipe B] enable: no [modeset]
<7> [98.431188] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:84:plane 1B] fb: [NOFB], visible: no
<7> [98.431339] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:93:plane 2B] fb: [NOFB], visible: no
<7> [98.431475] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:102:plane 3B] fb: [NOFB], visible: no
<7> [98.431628] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:111:plane 4B] fb: [NOFB], visible: no
<7> [98.431768] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:120:plane 5B] fb: [NOFB], visible: no
<7> [98.431906] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:129:cursor B] fb: [NOFB], visible: no
<7> [98.436585] i915 0000:00:02.0: [drm:intel_disable_transcoder [i915]] disabling pipe B
<7> [98.453887] i915 0000:00:02.0: [drm:intel_power_well_disable [i915]] disabling DDI_IO_TC1
<7> [98.454296] i915 0000:00:02.0: [drm:intel_disable_shared_dpll [i915]] disable DPLL 0 (active 0x2, on? 1) for [CRTC:134:pipe B]
<7> [98.454840] i915 0000:00:02.0: [drm:intel_disable_shared_dpll [i915]] disabling DPLL 0
<7> [98.455295] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:188:DDI B/PHY B]
<7> [98.455748] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:190:DP-MST A]
<7> [98.456171] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:191:DP-MST B]
<7> [98.456613] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:192:DP-MST C]
<7> [98.457034] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:206:DDI TC1/PHY C]
<7> [98.457449] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:210:DDI TC2/PHY D]
<7> [98.457835] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:212:DP-MST A]
<7> [98.458194] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:213:DP-MST B]
<7> [98.458554] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:214:DP-MST C]
<7> [98.458941] i915 0000:00:02.0: [drm:verify_connector_state [i915]] [CONNECTOR:207:HDMI-A-2]
<7> [98.459419] i915 0000:00:02.0: [drm:gen9_dbuf_slices_update [i915]] Updating dbuf slices to 0x1
<7> [98.459895] i915 0000:00:02.0: [drm:intel_power_well_disable [i915]] disabling PW_3
<7> [98.460311] i915 0000:00:02.0: [drm:intel_modeset_verify_crtc [i915]] [CRTC:134:pipe B]
<7> [98.460877] i915 0000:00:02.0: [drm:drm_mode_setcrtc] [CRTC:186:pipe C]
<7> [98.461129] i915 0000:00:02.0: [drm:drm_mode_setcrtc] [CRTC:186:pipe C]
<7> [98.461171] i915 0000:00:02.0: [drm:drm_mode_setcrtc] [CONNECTOR:207:HDMI-A-2]
<7> [98.461268] i915 0000:00:02.0: [drm:intel_atomic_check [i915]] [CONNECTOR:207:HDMI-A-2] Limiting display bpp to 24 (EDID bpp 24, max requested bpp 36, max platform bpp 36)
<7> [98.461607] i915 0000:00:02.0: [drm:intel_hdmi_compute_clock [i915]] picking 8 bpc for HDMI output (pipe bpp: 24)
<7> [98.461900] i915 0000:00:02.0: [drm:intel_atomic_check [i915]] [CRTC:186:pipe C] hw max bpp: 24, pipe bpp: 24, dithering: 0
<7> [98.462206] i915 0000:00:02.0: [drm:intel_ddi_compute_config_late [i915]] [ENCODER:206:DDI TC1/PHY C] [CRTC:186:pipe C]
<7> [98.462500] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:186:pipe C] fastset requirement not met in hw.enable (expected no, found yes)
<7> [98.462826] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:186:pipe C] fastset requirement not met in hw.active (expected no, found yes)
<7> [98.463132] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:186:pipe C] fastset requirement not met in cpu_transcoder (expected -1, found 2)
<7> [98.463396] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:186:pipe C] fastset requirement not met in lane_count (expected 0, found 4)
<7> [98.463635] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:186:pipe C] fastset requirement not met in output_types (expected 0x00000000, found 0x00000040)
<7> [98.463855] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:186:pipe C] fastset requirement not met in framestart_delay (expected 0, found 1)
<7> [98.464073] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:186:pipe C] fastset requirement not met in hw.pipe_mode.crtc_hdisplay (expected 0, found 1920)
<7> [98.464292] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:186:pipe C] fastset requirement not met in hw.pipe_mode.crtc_htotal (expected 0, found 2360)
<7> [98.464509] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:186:pipe C] fastset requirement not met in hw.pipe_mode.crtc_hblank_start (expected 0, found 1920)
<7> [98.464744] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:186:pipe C] fastset requirement not met in hw.pipe_mode.crtc_hblank_end (expected 0, found 2360)
<7> [98.464961] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:186:pipe C] fastset requirement not met in hw.pipe_mode.crtc_hsync_start (expected 0, found 2008)
<7> [98.465176] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:186:pipe C] fastset requirement not met in hw.pipe_mode.crtc_hsync_end (expected 0, found 2096)
<7> [98.465393] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:186:pipe C] fastset requirement not met in hw.pipe_mode.crtc_vdisplay (expected 0, found 1080)
<7> [98.465621] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:186:pipe C] fastset requirement not met in hw.pipe_mode.crtc_vblank_start (expected 0, found 1080)
<7> [98.465839] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:186:pipe C] fastset requirement not met in hw.pipe_mode.crtc_vsync_start (expected 0, found 1084)
<7> [98.466055] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:186:pipe C] fastset requirement not met in hw.pipe_mode.crtc_vsync_end (expected 0, found 1089)
<7> [98.466278] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:186:pipe C] fastset requirement not met in hw.pipe_mode.crtc_vtotal (expected 0, found 1125)
<7> [98.466440] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:186:pipe C] fastset requirement not met in hw.pipe_mode.crtc_vblank_end (expected 0, found 1125)
<7> [98.466612] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:186:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_hdisplay (expected 0, found 1920)
<7> [98.466775] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:186:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_htotal (expected 0, found 2360)
<7> [98.466942] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:186:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_hblank_start (expected 0, found 1920)
<7> [98.467109] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:186:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_hblank_end (expected 0, found 2360)
<7> [98.467282] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:186:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_hsync_start (expected 0, found 2008)
<7> [98.467443] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:186:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_hsync_end (expected 0, found 2096)
<7> [98.467621] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:186:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_vdisplay (expected 0, found 1080)
<7> [98.467780] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:186:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_vblank_start (expected 0, found 1080)
<7> [98.467939] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:186:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_vsync_start (expected 0, found 1084)
<7> [98.468098] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:186:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_vsync_end (expected 0, found 1089)
<7> [98.468256] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:186:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_vtotal (expected 0, found 1125)
<7> [98.468413] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:186:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_vblank_end (expected 0, found 1125)
<7> [98.468578] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:186:pipe C] fastset requirement not met in pixel_multiplier (expected 0, found 1)
<7> [98.468736] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:186:pipe C] fastset requirement not met in hw.adjusted_mode.flags (1) (expected 0, found 1)
<7> [98.468894] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:186:pipe C] fastset requirement not met in hw.adjusted_mode.flags (4) (expected 0, found 4)
<7> [98.469053] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:186:pipe C] fastset requirement not met in pipe_bpp (expected 0, found 24)
<7> [98.469217] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:186:pipe C] fastset requirement not met in hw.pipe_mode.crtc_clock (expected 0, found 139929)
<7> [98.469349] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:186:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_clock (expected 0, found 139929)
<7> [98.469478] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:186:pipe C] fastset requirement not met in port_clock (expected 0, found 139929)
<7> [98.469613] i915 0000:00:02.0: [drm:intel_atomic_check [i915]] [CRTC:186:pipe C] fastset requirement not met, forcing full modeset
<7> [98.469757] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] Enabled dbuf slices 0x1 -> 0x3 (total dbuf slices 0x3), mbus joined? no->no
<7> [98.469887] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] [CRTC:186:pipe C] dbuf slices 0x0 -> 0x3, ddb (0 - 0) -> (0 - 2048), active pipes 0x0 -> 0x4
<7> [98.470042] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] [PLANE:136:plane 1C] ddb ( 0 - 0) -> ( 0 - 2016), size 0 -> 2016
<7> [98.470169] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] [PLANE:181:cursor C] ddb ( 0 - 0) -> (2016 - 2048), size 0 -> 32
<7> [98.470296] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] [PLANE:136:plane 1C] level wm0, wm1, wm2, wm3, wm4, wm5, wm6, wm7, twm, swm, stwm -> *wm0,*wm1,*wm2,*wm3,*wm4,*wm5,*wm6,*wm7,*twm, swm, stwm
<7> [98.470425] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] [PLANE:136:plane 1C] lines 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0 -> 1, 2, 2, 2, 2, 5, 8, 9, 0, 0, 0
<7> [98.470555] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] [PLANE:136:plane 1C] blocks 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0 -> 16, 33, 33, 33, 33, 81, 129, 145, 30, 0, 0
<7> [98.470692] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] [PLANE:136:plane 1C] 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> [98.470819] i915 0000:00:02.0: [drm:intel_bw_atomic_check [i915]] [CRTC:186:pipe C] data rate 559716 num active planes 1
<7> [98.470951] i915 0000:00:02.0: [drm:intel_bw_atomic_check [i915]] QGV point 0: max bw 16761 required 560
<7> [98.471081] i915 0000:00:02.0: [drm:intel_bw_atomic_check [i915]] No SAGV, using single QGV point mask 0x1
<7> [98.471219] i915 0000:00:02.0: [drm:intel_plane_calc_min_cdclk [i915]] [PLANE:136:plane 1C] min cdclk (69965 kHz) > [CRTC:186:pipe C] min cdclk (0 kHz)
<7> [98.471349] i915 0000:00:02.0: [drm:intel_bw_calc_min_cdclk [i915]] new bandwidth min cdclk (10932 kHz) > old min cdclk (0 kHz)
<7> [98.471480] i915 0000:00:02.0: [drm:intel_modeset_calc_cdclk [i915]] New cdclk calculated to be logical 180000 kHz, actual 180000 kHz
<7> [98.471650] i915 0000:00:02.0: [drm:intel_modeset_calc_cdclk [i915]] New voltage level calculated to be logical 0, actual 0
<7> [98.471782] i915 0000:00:02.0: [drm:intel_find_shared_dpll [i915]] [CRTC:186:pipe C] allocated DPLL 0
<7> [98.471914] i915 0000:00:02.0: [drm:intel_reference_shared_dpll_crtc [i915]] [CRTC:186:pipe C] reserving DPLL 0
<7> [98.472047] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [CRTC:186:pipe C] enable: yes [modeset]
<7> [98.472178] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] active: yes, output_types: HDMI (0x40), output format: RGB, sink format: RGB
<7> [98.472308] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] cpu_transcoder: C, pipe bpp: 24, dithering: 0
<7> [98.472436] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] MST master transcoder: <invalid>
<7> [98.472570] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] port sync: master transcoder: <invalid>, slave transcoder bitmask = 0x0
<7> [98.472700] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] joiner: no, pipes: 0x0
<7> [98.472828] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] splitter: disabled, link count 0, overlap 0
<7> [98.472958] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] audio: 0, infoframes: 0, infoframes enabled: 0x0
<7> [98.473088] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] scanline offset: 2
<7> [98.473217] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] vblank delay: 0, framestart delay: 1, MSA timing delay: 0
<7> [98.473345] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] vrr: no, vmin: 0, vmax: 0, flipline: 0, pipeline full: 0, guardband: 0 vsync start: 0, vsync end: 0
<7> [98.473472] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] vrr: vmin vblank: -1, vmax vblank: -2, vmin vtotal: 1, vmax vtotal: 0
<7> [98.473607] 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> [98.473734] 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> [98.473865] 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> [98.473997] 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> [98.474126] 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> [98.474255] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] port clock: 139929, pipe src: 1920x1080+0+0, pixel rate 139929
<7> [98.474384] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] linetime: 135, ips linetime: 0
<7> [98.474512] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] num_scalers: 2, scaler_users: 0x0, scaler_id: -1, scaling_filter: 0
<7> [98.474648] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pch pfit: 0x0+0+0, disabled, force thru: no
<7> [98.474776] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] ips: 0, double wide: 0, drrs: 0
<7> [98.474902] 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> [98.475029] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] csc_mode: 0x0 gamma_mode: 0x0 gamma_enable: 0 csc_enable: 0
<7> [98.475156] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pre csc lut: 0 entries, post csc lut: 0 entries
<7> [98.475282] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] output csc: pre offsets: 0x0000 0x0000 0x0000
<7> [98.475411] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] output csc: coefficients: 0x0000 0x0000 0x0000
<7> [98.475542] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] output csc: coefficients: 0x0000 0x0000 0x0000
<7> [98.475682] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] output csc: coefficients: 0x0000 0x0000 0x0000
<7> [98.475810] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] output csc: post offsets: 0x0000 0x0000 0x0000
<7> [98.475937] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pipe csc: pre offsets: 0x0000 0x0000 0x0000
<7> [98.476064] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pipe csc: coefficients: 0x0000 0x0000 0x0000
<7> [98.476190] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pipe csc: coefficients: 0x0000 0x0000 0x0000
<7> [98.476315] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pipe csc: coefficients: 0x0000 0x0000 0x0000
<7> [98.476442] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pipe csc: post offsets: 0x0000 0x0000 0x0000
<7> [98.476573] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:136:plane 1C] fb: [FB:226] 1920x1080 format = XR24 little-endian (0x34325258) modifier = 0x0, visible: yes
<7> [98.476700] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] rotation: 0x1, scaler: -1, scaling_filter: 0
<7> [98.476827] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] src: 1920.000000x1080.000000+0.000000+0.000000 dst: 1920x1080+0+0
<7> [98.476953] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:145:plane 2C] fb: [NOFB], visible: no
<7> [98.477079] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:154:plane 3C] fb: [NOFB], visible: no
<7> [98.477205] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:163:plane 4C] fb: [NOFB], visible: no
<7> [98.477332] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:172:plane 5C] fb: [NOFB], visible: no
<7> [98.477463] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:181:cursor C] fb: [NOFB], visible: no
<7> [98.478021] i915 0000:00:02.0: [drm:intel_power_well_enable [i915]] enabling PW_3
<7> [98.478168] i915 0000:00:02.0: [drm:intel_power_well_enable [i915]] enabling PW_4
<7> [98.478319] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:188:DDI B/PHY B]
<7> [98.478450] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:190:DP-MST A]
<7> [98.478588] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:191:DP-MST B]
<7> [98.478718] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:192:DP-MST C]
<7> [98.478847] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:206:DDI TC1/PHY C]
<7> [98.478974] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:210:DDI TC2/PHY D]
<7> [98.479099] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:212:DP-MST A]
<7> [98.479224] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:213:DP-MST B]
<7> [98.479349] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:214:DP-MST C]
<7> [98.479501] i915 0000:00:02.0: [drm:gen9_dbuf_slices_update [i915]] Updating dbuf slices to 0x3
<7> [98.479677] i915 0000:00:02.0: [drm:intel_enable_shared_dpll [i915]] enable DPLL 0 (active 0x4, on? 0) for [CRTC:186:pipe C]
<7> [98.479811] i915 0000:00:02.0: [drm:intel_enable_shared_dpll [i915]] enabling DPLL 0
<7> [98.479995] i915 0000:00:02.0: [drm:intel_power_well_enable [i915]] enabling DDI_IO_TC1
<7> [98.480159] i915 0000:00:02.0: [drm:intel_enable_transcoder [i915]] enabling pipe C
<7> [98.499951] i915 0000:00:02.0: [drm:verify_connector_state [i915]] [CONNECTOR:207:HDMI-A-2]
<7> [98.500139] i915 0000:00:02.0: [drm:intel_modeset_verify_crtc [i915]] [CRTC:186:pipe C]
<7> [108.840684] i915 0000:00:02.0: [drm:drm_mode_rmfb_work_fn] Removing [FB:227] from all active usage due to RMFB ioctl
<7> [108.841306] i915 0000:00:02.0: [drm:drm_mode_rmfb_work_fn] Removing [FB:226] from all active usage due to RMFB ioctl
<7> [108.841419] i915 0000:00:02.0: [drm:atomic_remove_fb] Disabling [PLANE:136:plane 1C] because [FB:226] is removed
<7> [108.841536] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] [PLANE:136:plane 1C] ddb ( 0 - 2016) -> ( 0 - 0), size 2016 -> 0
<7> [108.842073] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] [PLANE:136:plane 1C] level *wm0,*wm1,*wm2,*wm3,*wm4,*wm5,*wm6,*wm7,*twm, swm, stwm -> wm0, wm1, wm2, wm3, wm4, wm5, wm6, wm7, twm, swm, stwm
<7> [108.842598] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] [PLANE:136:plane 1C] lines 1, 2, 2, 2, 2, 5, 8, 9, 0, 0, 0 -> 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0
<7> [108.843098] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] [PLANE:136:plane 1C] blocks 16, 33, 33, 33, 33, 81, 129, 145, 30, 0, 0 -> 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0
<7> [108.843617] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] [PLANE:136:plane 1C] 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> [108.844109] i915 0000:00:02.0: [drm:intel_bw_atomic_check [i915]] [CRTC:186:pipe C] data rate 0 num active planes 0
<7> [108.844656] i915 0000:00:02.0: [drm:intel_bw_atomic_check [i915]] QGV point 0: max bw 16761 required 0
<6> [108.859813] [IGT] kms_flip: finished subtest C-HDMI-A2, SUCCESS
<6> [108.860666] [IGT] kms_flip: finished subtest plain-flip-ts-check, FAIL
<6> [108.873246] [IGT] kms_flip: exiting, ret=98
<7> [108.873573] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc]
<7> [108.910514] i915 0000:00:02.0: [drm:intel_atomic_check [i915]] [CONNECTOR:207:HDMI-A-2] Limiting display bpp to 24 (EDID bpp 24, max requested bpp 36, max platform bpp 36)
<7> [108.911115] i915 0000:00:02.0: [drm:intel_hdmi_compute_clock [i915]] picking 8 bpc for HDMI output (pipe bpp: 24)
<7> [108.911691] i915 0000:00:02.0: [drm:intel_atomic_check [i915]] [CRTC:82:pipe A] hw max bpp: 24, pipe bpp: 24, dithering: 0
<7> [108.912302] i915 0000:00:02.0: [drm:intel_ddi_compute_config_late [i915]] [ENCODER:206:DDI TC1/PHY C] [CRTC:82:pipe A]
<7> [108.912885] 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> [108.913461] 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> [108.914013] 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> [108.914583] 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> [108.915136] 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> [108.915718] 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> [108.916266] 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> [108.916851] 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> [108.917430] 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> [108.917968] 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> [108.918533] 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> [108.919072] 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> [108.919639] 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> [108.920177] 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> [108.920743] 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> [108.921277] 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> [108.921864] 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> [108.922410] 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> [108.922836] 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> [108.923260] 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> [108.923714] 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> [108.924136] 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> [108.924580] 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> [108.925003] 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> [108.925431] 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> [108.925741] 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> [108.926050] 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> [108.926408] 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> [108.926728] 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> [108.927044] 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> [108.927383] 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> [108.927705] 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> [108.928020] 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> [108.928282] 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> [108.928519] 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> [108.928749] 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> [108.928967] 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> [108.929187] i915 0000:00:02.0: [drm:intel_atomic_check [i915]] [CRTC:82:pipe A] fastset requirement not met, forcing full modeset
<7> [108.929419] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:186:pipe C] fastset requirement not met in hw.enable (expected yes, found no)
<7> [108.929635] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:186:pipe C] fastset requirement not met in hw.active (expected yes, found no)
<7> [108.929855] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:186:pipe C] fastset requirement not met in cpu_transcoder (expected 2, found -1)
<7> [108.930075] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:186:pipe C] fastset requirement not met in lane_count (expected 4, found 0)
<7> [108.930304] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:186:pipe C] fastset requirement not met in output_types (expected 0x00000040, found 0x00000000)
<7> [108.930535] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:186:pipe C] fastset requirement not met in framestart_delay (expected 1, found 0)
<7> [108.930747] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:186:pipe C] fastset requirement not met in hw.pipe_mode.crtc_hdisplay (expected 1920, found 0)
<7> [108.930961] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:186:pipe C] fastset requirement not met in hw.pipe_mode.crtc_htotal (expected 2360, found 0)
<7> [108.931172] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:186:pipe C] fastset requirement not met in hw.pipe_mode.crtc_hblank_start (expected 1920, found 0)
<7> [108.931362] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:186:pipe C] fastset requirement not met in hw.pipe_mode.crtc_hblank_end (expected 2360, found 0)
<7> [108.931514] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:186:pipe C] fastset requirement not met in hw.pipe_mode.crtc_hsync_start (expected 2008, found 0)
<7> [108.931665] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:186:pipe C] fastset requirement not met in hw.pipe_mode.crtc_hsync_end (expected 2096, found 0)
<7> [108.931814] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:186:pipe C] fastset requirement not met in hw.pipe_mode.crtc_vdisplay (expected 1080, found 0)
<7> [108.931962] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:186:pipe C] fastset requirement not met in hw.pipe_mode.crtc_vblank_start (expected 1080, found 0)
<7> [108.932110] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:186:pipe C] fastset requirement not met in hw.pipe_mode.crtc_vsync_start (expected 1084, found 0)
<7> [108.932256] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:186:pipe C] fastset requirement not met in hw.pipe_mode.crtc_vsync_end (expected 1089, found 0)
<7> [108.932410] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:186:pipe C] fastset requirement not met in hw.pipe_mode.crtc_vtotal (expected 1125, found 0)
<7> [108.932557] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:186:pipe C] fastset requirement not met in hw.pipe_mode.crtc_vblank_end (expected 1125, found 0)
<7> [108.932703] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:186:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_hdisplay (expected 1920, found 0)
<7> [108.932850] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:186:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_htotal (expected 2360, found 0)
<7> [108.932997] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:186:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_hblank_start (expected 1920, found 0)
<7> [108.933143] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:186:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_hblank_end (expected 2360, found 0)
<7> [108.933294] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:186:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_hsync_start (expected 2008, found 0)
<7> [108.933434] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:186:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_hsync_end (expected 2096, found 0)
<7> [108.933564] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:186:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_vdisplay (expected 1080, found 0)
<7> [108.933694] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:186:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_vblank_start (expected 1080, found 0)
<7> [108.933824] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:186:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_vsync_start (expected 1084, found 0)
<7> [108.933954] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:186:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_vsync_end (expected 1089, found 0)
<7> [108.934085] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:186:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_vtotal (expected 1125, found 0)
<7> [108.934220] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:186:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_vblank_end (expected 1125, found 0)
<7> [108.934347] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:186:pipe C] fastset requirement not met in pixel_multiplier (expected 1, found 0)
<7> [108.934489] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:186:pipe C] fastset requirement not met in hw.adjusted_mode.flags (1) (expected 1, found 0)
<7> [108.934620] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:186:pipe C] fastset requirement not met in hw.adjusted_mode.flags (4) (expected 4, found 0)
<7> [108.934750] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:186:pipe C] fastset requirement not met in pipe_bpp (expected 24, found 0)
<7> [108.934885] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:186:pipe C] fastset requirement not met in hw.pipe_mode.crtc_clock (expected 139929, found 0)
<7> [108.935013] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:186:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_clock (expected 139929, found 0)
<7> [108.935141] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:186:pipe C] fastset requirement not met in port_clock (expected 139929, found 0)
<7> [108.935269] i915 0000:00:02.0: [drm:intel_atomic_check [i915]] [CRTC:186:pipe C] fastset requirement not met, forcing full modeset
<7> [108.935404] i915 0000:00:02.0: [drm:intel_unreference_shared_dpll_crtc [i915]] [CRTC:186:pipe C] releasing DPLL 0
<7> [108.935585] 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 0x4 -> 0x1
<7> [108.935719] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] [CRTC:186:pipe C] dbuf slices 0x3 -> 0x0, ddb (0 - 2048) -> (0 - 0), active pipes 0x4 -> 0x1
<7> [108.935870] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] [PLANE:32:plane 1A] ddb ( 0 - 0) -> ( 0 - 2016), size 0 -> 2016
<7> [108.936004] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] [PLANE:77:cursor A] ddb ( 0 - 0) -> (2016 - 2048), size 0 -> 32
<7> [108.936135] 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> [108.936264] 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> [108.936410] 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> [108.936539] 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> [108.936668] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] [PLANE:181:cursor C] ddb (2016 - 2048) -> ( 0 - 0), size 32 -> 0
<7> [108.936797] i915 0000:00:02.0: [drm:intel_bw_atomic_check [i915]] [CRTC:82:pipe A] data rate 559716 num active planes 1
<7> [108.936932] i915 0000:00:02.0: [drm:intel_bw_atomic_check [i915]] QGV point 0: max bw 16761 required 560
<7> [108.937064] i915 0000:00:02.0: [drm:intel_bw_atomic_check [i915]] No SAGV, using single QGV point mask 0x1
<7> [108.937209] 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> [108.937346] i915 0000:00:02.0: [drm:intel_modeset_calc_cdclk [i915]] New cdclk calculated to be logical 180000 kHz, actual 180000 kHz
<7> [108.937490] i915 0000:00:02.0: [drm:intel_modeset_calc_cdclk [i915]] New voltage level calculated to be logical 0, actual 0
<7> [108.937619] i915 0000:00:02.0: [drm:intel_find_shared_dpll [i915]] [CRTC:82:pipe A] allocated DPLL 0
<7> [108.937754] i915 0000:00:02.0: [drm:intel_reference_shared_dpll_crtc [i915]] [CRTC:82:pipe A] reserving DPLL 0
<7> [108.937890] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [CRTC:82:pipe A] enable: yes [modeset]
<7> [108.938021] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] active: yes, output_types: HDMI (0x40), output format: RGB, sink format: RGB
<7> [108.938151] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] cpu_transcoder: A, pipe bpp: 24, dithering: 0
<7> [108.938281] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] MST master transcoder: <invalid>
<7> [108.938425] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] port sync: master transcoder: <invalid>, slave transcoder bitmask = 0x0
<7> [108.938555] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] joiner: no, pipes: 0x0
<7> [108.938684] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] splitter: disabled, link count 0, overlap 0
<7> [108.938812] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] audio: 0, infoframes: 0, infoframes enabled: 0x0
<7> [108.938942] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] scanline offset: 2
<7> [108.939071] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] vblank delay: 0, framestart delay: 1, MSA timing delay: 0
<7> [108.939204] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] vrr: no, vmin: 0, vmax: 0, flipline: 0, pipeline full: 0, guardband: 0 vsync start: 0, vsync end: 0
<7> [108.939335] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] vrr: vmin vblank: -1, vmax vblank: -2, vmin vtotal: 1, vmax vtotal: 0
<7> [108.939477] 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> [108.939607] 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> [108.939736] 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> [108.939865] 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> [108.939994] 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> [108.940124] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] port clock: 139929, pipe src: 1920x1080+0+0, pixel rate 139929
<7> [108.940253] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] linetime: 135, ips linetime: 0
<7> [108.940390] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] num_scalers: 2, scaler_users: 0x0, scaler_id: -1, scaling_filter: 0
<7> [108.940517] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pch pfit: 0x0+0+0, disabled, force thru: no
<7> [108.940645] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] ips: 0, double wide: 0, drrs: 0
<7> [108.940773] 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> [108.940902] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] csc_mode: 0x0 gamma_mode: 0x0 gamma_enable: 0 csc_enable: 0
<7> [108.941030] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pre csc lut: 0 entries, post csc lut: 0 entries
<7> [108.941157] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] output csc: pre offsets: 0x0000 0x0000 0x0000
<7> [108.941285] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] output csc: coefficients: 0x0000 0x0000 0x0000
<7> [108.941422] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] output csc: coefficients: 0x0000 0x0000 0x0000
<7> [108.941549] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] output csc: coefficients: 0x0000 0x0000 0x0000
<7> [108.941677] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] output csc: post offsets: 0x0000 0x0000 0x0000
<7> [108.941804] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pipe csc: pre offsets: 0x0000 0x0000 0x0000
<7> [108.941932] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pipe csc: coefficients: 0x0000 0x0000 0x0000
<7> [108.942059] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pipe csc: coefficients: 0x0000 0x0000 0x0000
<7> [108.942186] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pipe csc: coefficients: 0x0000 0x0000 0x0000
<7> [108.942314] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pipe csc: post offsets: 0x0000 0x0000 0x0000
<7> [108.942451] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:32:plane 1A] fb: [FB:222] 1920x1080 format = XR24 little-endian (0x34325258) modifier = 0x0, visible: yes
<7> [108.942581] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] rotation: 0x1, scaler: -1, scaling_filter: 0
<7> [108.942708] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] src: 1920.000000x1080.000000+0.000000+0.000000 dst: 1920x1080+0+0
<7> [108.942840] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:41:plane 2A] fb: [NOFB], visible: no
<7> [108.942971] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:50:plane 3A] fb: [NOFB], visible: no
<7> [108.943101] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:59:plane 4A] fb: [NOFB], visible: no
<7> [108.943230] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:68:plane 5A] fb: [NOFB], visible: no
<7> [108.943365] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:77:cursor A] fb: [NOFB], visible: no
<7> [108.943494] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [CRTC:186:pipe C] enable: no [modeset]
<7> [108.943622] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:136:plane 1C] fb: [NOFB], visible: no
<7> [108.943749] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:145:plane 2C] fb: [NOFB], visible: no
<7> [108.943876] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:154:plane 3C] fb: [NOFB], visible: no
<7> [108.944004] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:163:plane 4C] fb: [NOFB], visible: no
<7> [108.944130] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:172:plane 5C] fb: [NOFB], visible: no
<7> [108.944257] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:181:cursor C] fb: [NOFB], visible: no
<7> [108.947114] i915 0000:00:02.0: [drm:intel_disable_transcoder [i915]] disabling pipe C
<7> [108.955945] i915 0000:00:02.0: [drm:intel_power_well_disable [i915]] disabling DDI_IO_TC1
<7> [108.956093] i915 0000:00:02.0: [drm:intel_disable_shared_dpll [i915]] disable DPLL 0 (active 0x4, on? 1) for [CRTC:186:pipe C]
<7> [108.956242] i915 0000:00:02.0: [drm:intel_disable_shared_dpll [i915]] disabling DPLL 0
<7> [108.956394] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:188:DDI B/PHY B]
<7> [108.956526] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:190:DP-MST A]
<7> [108.956656] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:191:DP-MST B]
<7> [108.956784] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:192:DP-MST C]
<7> [108.956912] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:206:DDI TC1/PHY C]
<7> [108.957039] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:210:DDI TC2/PHY D]
<7> [108.957165] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:212:DP-MST A]
<7> [108.957292] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:213:DP-MST B]
<7> [108.957429] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:214:DP-MST C]
<7> [108.957598] i915 0000:00:02.0: [drm:intel_enable_shared_dpll [i915]] enable DPLL 0 (active 0x1, on? 0) for [CRTC:82:pipe A]
<7> [108.957734] i915 0000:00:02.0: [drm:intel_enable_shared_dpll [i915]] enabling DPLL 0
<7> [108.957920] i915 0000:00:02.0: [drm:intel_power_well_enable [i915]] enabling DDI_IO_TC1
<7> [108.958088] i915 0000:00:02.0: [drm:intel_enable_transcoder [i915]] enabling pipe A
<7> [108.961034] i915 0000:00:02.0: [drm:intel_fbc_update [i915]] reserved 17694720 bytes of contiguous stolen space for FBC, limit: 1
<7> [108.961170] i915 0000:00:02.0: [drm:intel_fbc_update [i915]] Enabling FBC on [PLANE:32:plane 1A]
<7> [108.977496] i915 0000:00:02.0: [drm:verify_connector_state [i915]] [CONNECTOR:207:HDMI-A-2]
<7> [108.977681] i915 0000:00:02.0: [drm:intel_modeset_verify_crtc [i915]] [CRTC:82:pipe A]
<7> [108.978076] i915 0000:00:02.0: [drm:intel_power_well_disable [i915]] disabling PW_4
<7> [108.978249] i915 0000:00:02.0: [drm:intel_modeset_verify_crtc [i915]] [CRTC:186:pipe C]
<7> [108.978754] i915 0000:00:02.0: [drm:drm_client_dev_restore] intel-fbdev: ret=0
<6> [108.996688] Console: switching to colour frame buffer device 240x67
Created at 2025-03-05 11:01:55