igt@kms_flip@blocking-wf_vblank@b-hdmi-a1 on shard-tglu@CI_DRM

Detail	Value
Duration	18.65 seconds
Hostname	shard-tglu-10
Igt-Version	IGT-Version: 2.2-g4ee2c54aa (x86_64) (Linux: 6.18.0-rc1-CI_DRM_17358-g2ee74c43df58+ x86_64)
Out	Starting dynamic subtest: B-HDMI-A1 1920x1080: 120 285500 1920 1968 2000 2080 1080 1083 1088 1144 0x48 0x5 Expected frametime: 8335us; measured 8334.5us +- 3.307us accuracy 0.12% Event vblank: expected 906, counted 900, passrate = 80.00%, encoder type 2 Expected frametime: 8335us; measured 8515.1us +- 2.986us accuracy 0.11% vblank interval differs from modeline! expected 8334.6us, measured 8515us +- 2.986us, difference 180.6us (60.5 sigma) Event vblank: expected 882, counted 890, passrate = 23.60%, encoder type 2 Stack trace: #0 ../lib/igt_core.c:2075 __igt_fail_assert() #1 ../tests/kms_flip.c:973 run_test_on_crtc_set.constprop.0() #2 ../tests/kms_flip.c:1884 run_test() #3 ../tests/kms_flip.c:2117 __igt_unique____real_main2040() #4 ../tests/kms_flip.c:2040 main() #5 ../sysdeps/nptl/libc_start_call_main.h:74 __libc_start_call_main() #6 ../csu/libc-start.c:128 __libc_start_main@@GLIBC_2.34() #7 [_start+0x25] Dynamic subtest B-HDMI-A1: FAIL (18.649s)
Err	Starting dynamic subtest: B-HDMI-A1 (kms_flip:2141) CRITICAL: Test assertion failure function __run_test_on_crtc_set, file ../tests/kms_flip.c:1704: (kms_flip:2141) CRITICAL: Failed assertion: !retried Dynamic subtest B-HDMI-A1 failed. ** DEBUG (kms_flip:2141) DEBUG: name = vblank last_ts = 106.669876 last_received_ts = 106.669708 last_seq = 1332 current_ts = 106.754890 current_received_ts = 106.754478 current_seq = 1342 count = 2 seq_step = 10 (kms_flip:2141) DEBUG: vblank ts/seq: last 106.669876/1332, current 106.754890/1342: elapsed=85011.0us expected=85151.2us +- 425.8us, error 0.2% (kms_flip:2141) DEBUG: name = vblank last_ts = 106.754890 last_received_ts = 106.754478 last_seq = 1342 current_ts = 106.839813 current_received_ts = 106.839531 current_seq = 1352 count = 3 seq_step = 10 (kms_flip:2141) DEBUG: vblank ts/seq: last 106.754890/1342, current 106.839813/1352: elapsed=84926.0us expected=85151.2us +- 425.8us, error 0.3% (kms_flip:2141) DEBUG: name = vblank last_ts = 106.839813 last_received_ts = 106.839531 last_seq = 1352 current_ts = 106.924736 current_received_ts = 106.924614 current_seq = 1362 count = 4 seq_step = 10 (kms_flip:2141) DEBUG: vblank ts/seq: last 106.839813/1352, current 106.924736/1362: elapsed=84920.0us expected=85151.2us +- 425.8us, error 0.3% (kms_flip:2141) DEBUG: name = vblank last_ts = 106.924736 last_received_ts = 106.924614 last_seq = 1362 current_ts = 107.009651 current_received_ts = 107.009354 current_seq = 1372 count = 5 seq_step = 10 (kms_flip:2141) DEBUG: vblank ts/seq: last 106.924736/1362, current 107.009651/1372: elapsed=84919.0us expected=85151.2us +- 425.8us, error 0.3% (kms_flip:2141) DEBUG: name = vblank last_ts = 107.009651 last_received_ts = 107.009354 last_seq = 1372 current_ts = 107.094582 current_received_ts = 107.094429 current_seq = 1382 count = 6 seq_step = 10 (kms_flip:2141) DEBUG: vblank ts/seq: last 107.009651/1372, current 107.094582/1382: elapsed=84932.0us expected=85151.2us +- 425.8us, error 0.3% (kms_flip:2141) DEBUG: name = vblank last_ts = 107.094582 last_received_ts = 107.094429 last_seq = 1382 current_ts = 107.179504 current_received_ts = 107.179375 current_seq = 1392 count = 7 seq_step = 10 (kms_flip:2141) DEBUG: vblank ts/seq: last 107.094582/1382, current 107.179504/1392: elapsed=84921.0us expected=85151.2us +- 425.8us, error 0.3% (kms_flip:2141) DEBUG: name = vblank last_ts = 107.179504 last_received_ts = 107.179375 last_seq = 1392 current_ts = 107.264427 current_received_ts = 107.264282 current_seq = 1402 count = 8 seq_step = 10 (kms_flip:2141) DEBUG: vblank ts/seq: last 107.179504/1392, current 107.264427/1402: elapsed=84921.0us expected=85151.2us +- 425.8us, error 0.3% (kms_flip:2141) DEBUG: name = vblank last_ts = 107.264427 last_received_ts = 107.264282 last_seq = 1402 current_ts = 107.349358 current_received_ts = 107.349289 current_seq = 1412 count = 9 seq_step = 10 (kms_flip:2141) DEBUG: vblank ts/seq: last 107.264427/1402, current 107.349358/1412: elapsed=84929.0us expected=85151.2us +- 425.8us, error 0.3% (kms_flip:2141) DEBUG: name = vblank last_ts = 107.349358 last_received_ts = 107.349289 last_seq = 1412 current_ts = 107.434273 current_received_ts = 107.434151 current_seq = 1422 count = 10 seq_step = 10 (kms_flip:2141) DEBUG: vblank ts/seq: last 107.349358/1412, current 107.434273/1422: elapsed=84917.0us expected=85151.2us +- 425.8us, error 0.3% (kms_flip:2141) DEBUG: name = vblank last_ts = 107.434273 last_received_ts = 107.434151 last_seq = 1422 current_ts = 107.519196 current_received_ts = 107.518944 current_seq = 1432 count = 11 seq_step = 10 (kms_flip:2141) DEBUG: vblank ts/seq: last 107.434273/1422, current 107.519196/1432: elapsed=84927.0us expected=85151.2us +- 425.8us, error 0.3% (kms_flip:2141) DEBUG: name = vblank last_ts = 107.519196 last_received_ts = 107.518944 last_seq = 1432 current_ts = 107.604126 current_received_ts = 107.603889 current_seq = 1442 count = 12 seq_step = 10 (kms_flip:2141) DEBUG: vblank ts/seq: last 107.519196/1432, current 107.604126/1442: elapsed=84924.0us expected=85151.2us +- 425.8us, error 0.3% (kms_flip:2141) DEBUG: name = vblank last_ts = 107.604126 last_received_ts = 107.603889 last_seq = 1442 current_ts = 107.689041 current_received_ts = 107.688789 current_seq = 1452 count = 13 seq_step = 10 (kms_flip:2141) DEBUG: vblank ts/seq: last 107.604126/1442, current 107.689041/1452: elapsed=84919.0us expected=85151.2us +- 425.8us, error 0.3% (kms_flip:2141) DEBUG: name = vblank last_ts = 107.689041 last_received_ts = 107.688789 last_seq = 1452 current_ts = 107.773796 current_received_ts = 107.773476 current_seq = 1462 count = 14 seq_step = 10 (kms_flip:2141) DEBUG: vblank ts/seq: last 107.689041/1452, current 107.773796/1462: elapsed=84754.0us expected=85151.2us +- 425.8us, error 0.5% (kms_flip:2141) DEBUG: name = vblank last_ts = 107.773796 last_received_ts = 107.773476 last_seq = 1462 current_ts = 107.858528 current_received_ts = 107.858292 current_seq = 1472 count = 15 seq_step = 10 (kms_flip:2141) DEBUG: vblank ts/seq: last 107.773796/1462, current 107.858528/1472: elapsed=84732.0us expected=85151.2us +- 425.8us, error 0.5% (kms_flip:2141) DEBUG: name = vblank last_ts = 107.858528 last_received_ts = 107.858292 last_seq = 1472 current_ts = 107.943253 current_received_ts = 107.943047 current_seq = 1482 count = 16 seq_step = 10 (kms_flip:2141) DEBUG: vblank ts/seq: last 107.858528/1472, current 107.943253/1482: elapsed=84724.0us expected=85151.2us +- 425.8us, error 0.5% (kms_flip:2141) DEBUG: inconsistent vblank ts/seq: last 107.858528/1472, current 107.943253/1482: elapsed=84724.0us expected=85151.2us (kms_flip:2141) DEBUG: name = vblank last_ts = 107.943253 last_received_ts = 107.943047 last_seq = 1482 current_ts = 108.027977 current_received_ts = 108.027824 current_seq = 1492 count = 17 seq_step = 10 (kms_flip:2141) DEBUG: vblank ts/seq: last 107.943253/1482, current 108.027977/1492: elapsed=84728.0us expected=85151.2us +- 425.8us, error 0.5% (kms_flip:2141) DEBUG: name = vblank last_ts = 108.027977 last_received_ts = 108.027824 last_seq = 1492 current_ts = 108.112701 current_received_ts = 108.112457 current_seq = 1502 count = 18 seq_step = 10 (kms_flip:2141) DEBUG: vblank ts/seq: last 108.027977/1492, current 108.112701/1502: elapsed=84724.0us expected=85151.2us +- 425.8us, error 0.5% (kms_flip:2141) DEBUG: inconsistent vblank ts/seq: last 108.027977/1492, current 108.112701/1502: elapsed=84724.0us expected=85151.2us (kms_flip:2141) DEBUG: name = vblank last_ts = 108.112701 last_received_ts = 108.112457 last_seq = 1502 current_ts = 108.197433 current_received_ts = 108.197281 current_seq = 1512 count = 19 seq_step = 10 (kms_flip:2141) DEBUG: vblank ts/seq: last 108.112701/1502, current 108.197433/1512: elapsed=84730.0us expected=85151.2us +- 425.8us, error 0.5% (kms_flip:2141) DEBUG: name = vblank last_ts = 108.197433 last_received_ts = 108.197281 last_seq = 1512 current_ts = 108.282158 current_received_ts = 108.281921 current_seq = 1522 count = 20 seq_step = 10 (kms_flip:2141) DEBUG: vblank ts/seq: last 108.197433/1512, current 108.282158/1522: elapsed=84725.0us expected=85151.2us +- 425.8us, error 0.5% (kms_flip:2141) DEBUG: inconsistent vblank ts/seq: last 108.197433/1512, current 108.282158/1522: elapsed=84725.0us expected=85151.2us (kms_flip:2141) DEBUG: name = vblank last_ts = 108.282158 last_received_ts = 108.281921 last_seq = 1522 current_ts = 108.366890 current_received_ts = 108.366707 current_seq = 1532 count = 21 seq_step = 10 (kms_flip:2141) DEBUG: vblank ts/seq: last 108.282158/1522, current 108.366890/1532: elapsed=84728.0us expected=85151.2us +- 425.8us, error 0.5% (kms_flip:2141) DEBUG: name = vblank last_ts = 108.366890 last_received_ts = 108.366707 last_seq = 1532 current_ts = 108.451607 current_received_ts = 108.451363 current_seq = 1542 count = 22 seq_step = 10 (kms_flip:2141) DEBUG: vblank ts/seq: last 108.366890/1532, current 108.451607/1542: elapsed=84718.0us expected=85151.2us +- 425.8us, error 0.5% (kms_flip:2141) DEBUG: inconsistent vblank ts/seq: last 108.366890/1532, current 108.451607/1542: elapsed=84718.0us expected=85151.2us (kms_flip:2141) DEBUG: name = vblank last_ts = 108.451607 last_received_ts = 108.451363 last_seq = 1542 current_ts = 108.536339 current_received_ts = 108.536186 current_seq = 1552 count = 23 seq_step = 10 (kms_flip:2141) DEBUG: vblank ts/seq: last 108.451607/1542, current 108.536339/1552: elapsed=84731.0us expected=85151.2us +- 425.8us, error 0.5% (kms_flip:2141) DEBUG: name = vblank last_ts = 108.536339 last_received_ts = 108.536186 last_seq = 1552 current_ts = 108.621056 current_received_ts = 108.620834 current_seq = 1562 count = 24 seq_step = 10 (kms_flip:2141) DEBUG: vblank ts/seq: last 108.536339/1552, current 108.621056/1562: elapsed=84723.0us expected=85151.2us +- 425.8us, error 0.5% (kms_flip:2141) DEBUG: inconsistent vblank ts/seq: last 108.536339/1552, current 108.621056/1562: elapsed=84723.0us expected=85151.2us (kms_flip:2141) DEBUG: name = vblank last_ts = 108.621056 last_received_ts = 108.620834 last_seq = 1562 current_ts = 108.705788 current_received_ts = 108.705544 current_seq = 1572 count = 25 seq_step = 10 (kms_flip:2141) DEBUG: vblank ts/seq: last 108.621056/1562, current 108.705788/1572: elapsed=84729.0us expected=85151.2us +- 425.8us, error 0.5% (kms_flip:2141) DEBUG: name = vblank last_ts = 108.705788 last_received_ts = 108.705544 last_seq = 1572 current_ts = 108.790344 current_received_ts = 108.790138 current_seq = 1582 count = 26 seq_step = 10 (kms_flip:2141) DEBUG: vblank ts/seq: last 108.705788/1572, current 108.790344/1582: elapsed=84553.0us expected=85151.2us +- 425.8us, error 0.7% (kms_flip:2141) DEBUG: inconsistent vblank ts/seq: last 108.705788/1572, current 108.790344/1582: elapsed=84553.0us expected=85151.2us (kms_flip:2141) DEBUG: name = vblank last_ts = 108.790344 last_received_ts = 108.790138 last_seq = 1582 current_ts = 108.874893 current_received_ts = 108.874756 current_seq = 1592 count = 27 seq_step = 10 (kms_flip:2141) DEBUG: vblank ts/seq: last 108.790344/1582, current 108.874893/1592: elapsed=84556.0us expected=85151.2us +- 425.8us, error 0.7% (kms_flip:2141) DEBUG: inconsistent vblank ts/seq: last 108.790344/1582, current 108.874893/1592: elapsed=84556.0us expected=85151.2us (kms_flip:2141) DEBUG: name = vblank last_ts = 108.874893 last_received_ts = 108.874756 last_seq = 1592 current_ts = 108.959450 current_received_ts = 108.959198 current_seq = 1602 count = 28 seq_step = 10 (kms_flip:2141) DEBUG: vblank ts/seq: last 108.874893/1592, current 108.959450/1602: elapsed=84549.0us expected=85151.2us +- 425.8us, error 0.7% (kms_flip:2141) DEBUG: inconsistent vblank ts/seq: last 108.874893/1592, current 108.959450/1602: elapsed=84549.0us expected=85151.2us (kms_flip:2141) DEBUG: name = vblank last_ts = 108.959450 last_received_ts = 108.959198 last_seq = 1602 current_ts = 109.043999 current_received_ts = 109.043846 current_seq = 1612 count = 29 seq_step = 10 (kms_flip:2141) DEBUG: vblank ts/seq: last 108.959450/1602, current 109.043999/1612: elapsed=84556.0us expected=85151.2us +- 425.8us, error 0.7% (kms_flip:2141) DEBUG: inconsistent vblank ts/seq: last 108.959450/1602, current 109.043999/1612: elapsed=84556.0us expected=85151.2us (kms_flip:2141) DEBUG: name = vblank last_ts = 109.043999 last_received_ts = 109.043846 last_seq = 1612 current_ts = 109.128555 current_received_ts = 109.128304 current_seq = 1622 count = 30 seq_step = 10 (kms_flip:2141) DEBUG: vblank ts/seq: last 109.043999/1612, current 109.128555/1622: elapsed=84551.0us expected=85151.2us +- 425.8us, error 0.7% (kms_flip:2141) DEBUG: inconsistent vblank ts/seq: last 109.043999/1612, current 109.128555/1622: elapsed=84551.0us expected=85151.2us (kms_flip:2141) DEBUG: name = vblank last_ts = 109.128555 last_received_ts = 109.128304 last_seq = 1622 current_ts = 109.213104 current_received_ts = 109.212975 current_seq = 1632 count = 31 seq_step = 10 (kms_flip:2141) DEBUG: vblank ts/seq: last 109.128555/1622, current 109.213104/1632: elapsed=84555.0us expected=85151.2us +- 425.8us, error 0.7% (kms_flip:2141) DEBUG: inconsistent vblank ts/seq: last 109.128555/1622, current 109.213104/1632: elapsed=84555.0us expected=85151.2us (kms_flip:2141) DEBUG: name = vblank last_ts = 109.213104 last_received_ts = 109.212975 last_seq = 1632 current_ts = 109.297661 current_received_ts = 109.297455 current_seq = 1642 count = 32 seq_step = 10 (kms_flip:2141) DEBUG: vblank ts/seq: last 109.213104/1632, current 109.297661/1642: elapsed=84552.0us expected=85151.2us +- 425.8us, error 0.7% (kms_flip:2141) DEBUG: inconsistent vblank ts/seq: last 109.213104/1632, current 109.297661/1642: elapsed=84552.0us expected=85151.2us (kms_flip:2141) DEBUG: name = vblank last_ts = 109.297661 last_received_ts = 109.297455 last_seq = 1642 current_ts = 109.382217 current_received_ts = 109.382072 current_seq = 1652 count = 33 seq_step = 10 (kms_flip:2141) DEBUG: vblank ts/seq: last 109.297661/1642, current 109.382217/1652: elapsed=84559.0us expected=85151.2us +- 425.8us, error 0.7% (kms_flip:2141) DEBUG: inconsistent vblank ts/seq: last 109.297661/1642, current 109.382217/1652: elapsed=84559.0us expected=85151.2us (kms_flip:2141) DEBUG: name = vblank last_ts = 109.382217 last_received_ts = 109.382072 last_seq = 1652 current_ts = 109.466774 current_received_ts = 109.466629 current_seq = 1662 count = 34 seq_step = 10 (kms_flip:2141) DEBUG: vblank ts/seq: last 109.382217/1652, current 109.466774/1662: elapsed=84553.0us expected=85151.2us +- 425.8us, error 0.7% (kms_flip:2141) DEBUG: inconsistent vblank ts/seq: last 109.382217/1652, current 109.466774/1662: elapsed=84553.0us expected=85151.2us (kms_flip:2141) DEBUG: name = vblank last_ts = 109.466774 last_received_ts = 109.466629 last_seq = 1662 current_ts = 109.551323 current_received_ts = 109.551086 current_seq = 1672 count = 35 seq_step = 10 (kms_flip:2141) DEBUG: vblank ts/seq: last 109.466774/1662, current 109.551323/1672: elapsed=84553.0us expected=85151.2us +- 425.8us, error 0.7% (kms_flip:2141) DEBUG: inconsistent vblank ts/seq: last 109.466774/1662, current 109.551323/1672: elapsed=84553.0us expected=85151.2us (kms_flip:2141) DEBUG: name = vblank last_ts = 109.551323 last_received_ts = 109.551086 last_seq = 1672 current_ts = 109.635872 current_received_ts = 109.635628 current_seq = 1682 count = 36 seq_step = 10 (kms_flip:2141) DEBUG: vblank ts/seq: last 109.551323/1672, current 109.635872/1682: elapsed=84549.0us expected=85151.2us +- 425.8us, error 0.7% (kms_flip:2141) DEBUG: inconsistent vblank ts/seq: last 109.551323/1672, current 109.635872/1682: elapsed=84549.0us expected=85151.2us (kms_flip:2141) DEBUG: name = vblank last_ts = 109.635872 last_received_ts = 109.635628 last_seq = 1682 current_ts = 109.720398 current_received_ts = 109.720161 current_seq = 1692 count = 37 seq_step = 10 (kms_flip:2141) DEBUG: vblank ts/seq: last 109.635872/1682, current 109.720398/1692: elapsed=84521.0us expected=85151.2us +- 425.8us, error 0.7% (kms_flip:2141) DEBUG: inconsistent vblank ts/seq: last 109.635872/1682, current 109.720398/1692: elapsed=84521.0us expected=85151.2us (kms_flip:2141) DEBUG: name = vblank last_ts = 109.720398 last_received_ts = 109.720161 last_seq = 1692 current_ts = 109.804794 current_received_ts = 109.804565 current_seq = 1702 count = 38 seq_step = 10 (kms_flip:2141) DEBUG: vblank ts/seq: last 109.720398/1692, current 109.804794/1702: elapsed=84403.0us expected=85151.2us +- 425.8us, error 0.9% (kms_flip:2141) DEBUG: inconsistent vblank ts/seq: last 109.720398/1692, current 109.804794/1702: elapsed=84403.0us expected=85151.2us (kms_flip:2141) DEBUG: name = vblank last_ts = 109.804794 last_received_ts = 109.804565 last_seq = 1702 current_ts = 109.889206 current_received_ts = 109.889053 current_seq = 1712 count = 39 seq_step = 10 (kms_flip:2141) DEBUG: vblank ts/seq: last 109.804794/1702, current 109.889206/1712: elapsed=84407.0us expected=85151.2us +- 425.8us, error 0.9% (kms_flip:2141) DEBUG: inconsistent vblank ts/seq: last 109.804794/1702, current 109.889206/1712: elapsed=84407.0us expected=85151.2us (kms_flip:2141) DEBUG: name = vblank last_ts = 109.889206 last_received_ts = 109.889053 last_seq = 1712 current_ts = 109.973610 current_received_ts = 109.973381 current_seq = 1722 count = 40 seq_step = 10 (kms_flip:2141) DEBUG: vblank ts/seq: last 109.889206/1712, current 109.973610/1722: elapsed=84403.0us expected=85151.2us +- 425.8us, error 0.9% (kms_flip:2141) DEBUG: inconsistent vblank ts/seq: last 109.889206/1712, current 109.973610/1722: elapsed=84403.0us expected=85151.2us (kms_flip:2141) DEBUG: name = vblank last_ts = 109.973610 last_received_ts = 109.973381 last_seq = 1722 current_ts = 110.058006 current_received_ts = 110.057869 current_seq = 1732 count = 41 seq_step = 10 (kms_flip:2141) DEBUG: vblank ts/seq: last 109.973610/1722, current 110.058006/1732: elapsed=84399.0us expected=85151.2us +- 425.8us, error 0.9% (kms_flip:2141) DEBUG: inconsistent vblank ts/seq: last 109.973610/1722, current 110.058006/1732: elapsed=84399.0us expected=85151.2us (kms_flip:2141) DEBUG: name = vblank last_ts = 110.058006 last_received_ts = 110.057869 last_seq = 1732 current_ts = 110.142410 current_received_ts = 110.142220 current_seq = 1742 count = 42 seq_step = 10 (kms_flip:2141) DEBUG: vblank ts/seq: last 110.058006/1732, current 110.142410/1742: elapsed=84402.0us expected=85151.2us +- 425.8us, error 0.9% (kms_flip:2141) DEBUG: inconsistent vblank ts/seq: last 110.058006/1732, current 110.142410/1742: elapsed=84402.0us expected=85151.2us (kms_flip:2141) DEBUG: name = vblank last_ts = 110.142410 last_received_ts = 110.142220 last_seq = 1742 current_ts = 110.226814 current_received_ts = 110.226677 current_seq = 1752 count = 43 seq_step = 10 (kms_flip:2141) DEBUG: vblank ts/seq: last 110.142410/1742, current 110.226814/1752: elapsed=84409.0us expected=85151.2us +- 425.8us, error 0.9% (kms_flip:2141) DEBUG: inconsistent vblank ts/seq: last 110.142410/1742, current 110.226814/1752: elapsed=84409.0us expected=85151.2us (kms_flip:2141) DEBUG: name = vblank last_ts = 110.226814 last_received_ts = 110.226677 last_seq = 1752 current_ts = 110.311218 current_received_ts = 110.310966 current_seq = 1762 count = 44 seq_step = 10 (kms_flip:2141) DEBUG: vblank ts/seq: last 110.226814/1752, current 110.311218/1762: elapsed=84399.0us expected=85151.2us +- 425.8us, error 0.9% (kms_flip:2141) DEBUG: inconsistent vblank ts/seq: last 110.226814/1752, current 110.311218/1762: elapsed=84399.0us expected=85151.2us (kms_flip:2141) DEBUG: name = vblank last_ts = 110.311218 last_received_ts = 110.310966 last_seq = 1762 current_ts = 110.395622 current_received_ts = 110.395363 current_seq = 1772 count = 45 seq_step = 10 (kms_flip:2141) DEBUG: vblank ts/seq: last 110.311218/1762, current 110.395622/1772: elapsed=84405.0us expected=85151.2us +- 425.8us, error 0.9% (kms_flip:2141) DEBUG: inconsistent vblank ts/seq: last 110.311218/1762, current 110.395622/1772: elapsed=84405.0us expected=85151.2us (kms_flip:2141) DEBUG: name = vblank last_ts = 110.395622 last_received_ts = 110.395363 last_seq = 1772 current_ts = 110.480019 current_received_ts = 110.479881 current_seq = 1782 count = 46 seq_step = 10 (kms_flip:2141) DEBUG: vblank ts/seq: last 110.395622/1772, current 110.480019/1782: elapsed=84399.0us expected=85151.2us +- 425.8us, error 0.9% (kms_flip:2141) DEBUG: inconsistent vblank ts/seq: last 110.395622/1772, current 110.480019/1782: elapsed=84399.0us expected=85151.2us (kms_flip:2141) DEBUG: name = vblank last_ts = 110.480019 last_received_ts = 110.479881 last_seq = 1782 current_ts = 110.564423 current_received_ts = 110.564186 current_seq = 1792 count = 47 seq_step = 10 (kms_flip:2141) DEBUG: vblank ts/seq: last 110.480019/1782, current 110.564423/1792: elapsed=84404.0us expected=85151.2us +- 425.8us, error 0.9% (kms_flip:2141) DEBUG: inconsistent vblank ts/seq: last 110.480019/1782, current 110.564423/1792: elapsed=84404.0us expected=85151.2us (kms_flip:2141) DEBUG: name = vblank last_ts = 110.564423 last_received_ts = 110.564186 last_seq = 1792 current_ts = 110.648827 current_received_ts = 110.648697 current_seq = 1802 count = 48 seq_step = 10 (kms_flip:2141) DEBUG: vblank ts/seq: last 110.564423/1792, current 110.648827/1802: elapsed=84402.0us expected=85151.2us +- 425.8us, error 0.9% (kms_flip:2141) DEBUG: inconsistent vblank ts/seq: last 110.564423/1792, current 110.648827/1802: elapsed=84402.0us expected=85151.2us (kms_flip:2141) DEBUG: name = vblank last_ts = 110.648827 last_received_ts = 110.648697 last_seq = 1802 current_ts = 110.733192 current_received_ts = 110.732941 current_seq = 1812 count = 49 seq_step = 10 (kms_flip:2141) DEBUG: vblank ts/seq: last 110.648827/1802, current 110.733192/1812: elapsed=84365.0us expected=85151.2us +- 425.8us, error 0.9% (kms_flip:2141) DEBUG: inconsistent vblank ts/seq: last 110.648827/1802, current 110.733192/1812: elapsed=84365.0us expected=85151.2us (kms_flip:2141) DEBUG: name = vblank last_ts = 110.733192 last_received_ts = 110.732941 last_seq = 1812 current_ts = 110.817459 current_received_ts = 110.817223 current_seq = 1822 count = 50 seq_step = 10 (kms_flip:2141) DEBUG: vblank ts/seq: last 110.733192/1812, current 110.817459/1822: elapsed=84269.0us expected=85151.2us +- 425.8us, error 1.0% (kms_flip:2141) DEBUG: inconsistent vblank ts/seq: last 110.733192/1812, current 110.817459/1822: elapsed=84269.0us expected=85151.2us (kms_flip:2141) DEBUG: name = vblank last_ts = 110.817459 last_received_ts = 110.817223 last_seq = 1822 current_ts = 110.901733 current_received_ts = 110.901482 current_seq = 1832 count = 51 seq_step = 10 (kms_flip:2141) DEBUG: vblank ts/seq: last 110.817459/1822, current 110.901733/1832: elapsed=84272.0us expected=85151.2us +- 425.8us, error 1.0% (kms_flip:2141) DEBUG: inconsistent vblank ts/seq: last 110.817459/1822, current 110.901733/1832: elapsed=84272.0us expected=85151.2us (kms_flip:2141) DEBUG: name = vblank last_ts = 110.901733 last_received_ts = 110.901482 last_seq = 1832 current_ts = 110.986008 current_received_ts = 110.985863 current_seq = 1842 count = 52 seq_step = 10 (kms_flip:2141) DEBUG: vblank ts/seq: last 110.901733/1832, current 110.986008/1842: elapsed=84272.0us expected=85151.2us +- 425.8us, error 1.0% (kms_flip:2141) DEBUG: inconsistent vblank ts/seq: last 110.901733/1832, current 110.986008/1842: elapsed=84272.0us expected=85151.2us (kms_flip:2141) DEBUG: name = vblank last_ts = 110.986008 last_received_ts = 110.985863 last_seq = 1842 current_ts = 111.070274 current_received_ts = 111.070068 current_seq = 1852 count = 53 seq_step = 10 (kms_flip:2141) DEBUG: vblank ts/seq: last 110.986008/1842, current 111.070274/1852: elapsed=84271.0us expected=85151.2us +- 425.8us, error 1.0% (kms_flip:2141) DEBUG: inconsistent vblank ts/seq: last 110.986008/1842, current 111.070274/1852: elapsed=84271.0us expected=85151.2us (kms_flip:2141) DEBUG: name = vblank last_ts = 111.070274 last_received_ts = 111.070068 last_seq = 1852 current_ts = 111.154541 current_received_ts = 111.154411 current_seq = 1862 count = 54 seq_step = 10 (kms_flip:2141) DEBUG: vblank ts/seq: last 111.070274/1852, current 111.154541/1862: elapsed=84266.0us expected=85151.2us +- 425.8us, error 1.0% (kms_flip:2141) DEBUG: inconsistent vblank ts/seq: last 111.070274/1852, current 111.154541/1862: elapsed=84266.0us expected=85151.2us (kms_flip:2141) DEBUG: name = vblank last_ts = 111.154541 last_received_ts = 111.154411 last_seq = 1862 current_ts = 111.238808 current_received_ts = 111.238579 current_seq = 1872 count = 55 seq_step = 10 (kms_flip:2141) DEBUG: vblank ts/seq: last 111.154541/1862, current 111.238808/1872: elapsed=84269.0us expected=85151.2us +- 425.8us, error 1.0% (kms_flip:2141) DEBUG: inconsistent vblank ts/seq: last 111.154541/1862, current 111.238808/1872: elapsed=84269.0us expected=85151.2us (kms_flip:2141) DEBUG: name = vblank last_ts = 111.238808 last_received_ts = 111.238579 last_seq = 1872 current_ts = 111.323082 current_received_ts = 111.322830 current_seq = 1882 count = 56 seq_step = 10 (kms_flip:2141) DEBUG: vblank ts/seq: last 111.238808/1872, current 111.323082/1882: elapsed=84274.0us expected=85151.2us +- 425.8us, error 1.0% (kms_flip:2141) DEBUG: inconsistent vblank ts/seq: last 111.238808/1872, current 111.323082/1882: elapsed=84274.0us expected=85151.2us (kms_flip:2141) DEBUG: name = vblank last_ts = 111.323082 last_received_ts = 111.322830 last_seq = 1882 current_ts = 111.407356 current_received_ts = 111.407173 current_seq = 1892 count = 57 seq_step = 10 (kms_flip:2141) DEBUG: vblank ts/seq: last 111.323082/1882, current 111.407356/1892: elapsed=84270.0us expected=85151.2us +- 425.8us, error 1.0% (kms_flip:2141) DEBUG: inconsistent vblank ts/seq: last 111.323082/1882, current 111.407356/1892: elapsed=84270.0us expected=85151.2us (kms_flip:2141) DEBUG: name = vblank last_ts = 111.407356 last_received_ts = 111.407173 last_seq = 1892 current_ts = 111.491631 current_received_ts = 111.491470 current_seq = 1902 count = 58 seq_step = 10 (kms_flip:2141) DEBUG: vblank ts/seq: last 111.407356/1892, current 111.491631/1902: elapsed=84272.0us expected=85151.2us +- 425.8us, error 1.0% (kms_flip:2141) DEBUG: inconsistent vblank ts/seq: last 111.407356/1892, current 111.491631/1902: elapsed=84272.0us expected=85151.2us (kms_flip:2141) DEBUG: name = vblank last_ts = 111.491631 last_received_ts = 111.491470 last_seq = 1902 current_ts = 111.575897 current_received_ts = 111.575676 current_seq = 1912 count = 59 seq_step = 10 (kms_flip:2141) DEBUG: vblank ts/seq: last 111.491631/1902, current 111.575897/1912: elapsed=84269.0us expected=85151.2us +- 425.8us, error 1.0% (kms_flip:2141) DEBUG: inconsistent vblank ts/seq: last 111.491631/1902, current 111.575897/1912: elapsed=84269.0us expected=85151.2us (kms_flip:2141) DEBUG: name = vblank last_ts = 111.575897 last_received_ts = 111.575676 last_seq = 1912 current_ts = 111.660164 current_received_ts = 111.659912 current_seq = 1922 count = 60 seq_step = 10 (kms_flip:2141) DEBUG: vblank ts/seq: last 111.575897/1912, current 111.660164/1922: elapsed=84268.0us expected=85151.2us +- 425.8us, error 1.0% (kms_flip:2141) DEBUG: inconsistent vblank ts/seq: last 111.575897/1912, current 111.660164/1922: elapsed=84268.0us expected=85151.2us (kms_flip:2141) DEBUG: name = vblank last_ts = 111.660164 last_received_ts = 111.659912 last_seq = 1922 current_ts = 111.744377 current_received_ts = 111.744240 current_seq = 1932 count = 61 seq_step = 10 (kms_flip:2141) DEBUG: vblank ts/seq: last 111.660164/1922, current 111.744377/1932: elapsed=84216.0us expected=85151.2us +- 425.8us, error 1.1% (kms_flip:2141) DEBUG: inconsistent vblank ts/seq: last 111.660164/1922, current 111.744377/1932: elapsed=84216.0us expected=85151.2us (kms_flip:2141) DEBUG: name = vblank last_ts = 111.744377 last_received_ts = 111.744240 last_seq = 1932 current_ts = 111.828537 current_received_ts = 111.828400 current_seq = 1942 count = 62 seq_step = 10 (kms_flip:2141) DEBUG: vblank ts/seq: last 111.744377/1932, current 111.828537/1942: elapsed=84154.0us expected=85151.2us +- 425.8us, error 1.2% (kms_flip:2141) DEBUG: inconsistent vblank ts/seq: last 111.744377/1932, current 111.828537/1942: elapsed=84154.0us expected=85151.2us (kms_flip:2141) DEBUG: name = vblank last_ts = 111.828537 last_received_ts = 111.828400 last_seq = 1942 current_ts = 111.912689 current_received_ts = 111.912430 current_seq = 1952 count = 63 seq_step = 10 (kms_flip:2141) DEBUG: vblank ts/seq: last 111.828537/1942, current 111.912689/1952: elapsed=84156.0us expected=85151.2us +- 425.8us, error 1.2% (kms_flip:2141) DEBUG: inconsistent vblank ts/seq: last 111.828537/1942, current 111.912689/1952: elapsed=84156.0us expected=85151.2us (kms_flip:2141) DEBUG: name = vblank last_ts = 111.912689 last_received_ts = 111.912430 last_seq = 1952 current_ts = 111.996849 current_received_ts = 111.996696 current_seq = 1962 count = 64 seq_step = 10 (kms_flip:2141) DEBUG: vblank ts/seq: last 111.912689/1952, current 111.996849/1962: elapsed=84156.0us expected=85151.2us +- 425.8us, error 1.2% (kms_flip:2141) DEBUG: inconsistent vblank ts/seq: last 111.912689/1952, current 111.996849/1962: elapsed=84156.0us expected=85151.2us (kms_flip:2141) DEBUG: name = vblank last_ts = 111.996849 last_received_ts = 111.996696 last_seq = 1962 current_ts = 112.081001 current_received_ts = 112.080864 current_seq = 1972 count = 65 seq_step = 10 (kms_flip:2141) DEBUG: vblank ts/seq: last 111.996849/1962, current 112.081001/1972: elapsed=84155.0us expected=85151.2us +- 425.8us, error 1.2% (kms_flip:2141) DEBUG: inconsistent vblank ts/seq: last 111.996849/1962, current 112.081001/1972: elapsed=84155.0us expected=85151.2us (kms_flip:2141) DEBUG: name = vblank last_ts = 112.081001 last_received_ts = 112.080864 last_seq = 1972 current_ts = 112.165154 current_received_ts = 112.164902 current_seq = 1982 count = 66 seq_step = 10 (kms_flip:2141) DEBUG: vblank ts/seq: last 112.081001/1972, current 112.165154/1982: elapsed=84152.0us expected=85151.2us +- 425.8us, error 1.2% (kms_flip:2141) DEBUG: inconsistent vblank ts/seq: last 112.081001/1972, current 112.165154/1982: elapsed=84152.0us expected=85151.2us (kms_flip:2141) DEBUG: name = vblank last_ts = 112.165154 last_received_ts = 112.164902 last_seq = 1982 current_ts = 112.249313 current_received_ts = 112.249161 current_seq = 1992 count = 67 seq_step = 10 (kms_flip:2141) DEBUG: vblank ts/seq: last 112.165154/1982, current 112.249313/1992: elapsed=84158.0us expected=85151.2us +- 425.8us, error 1.2% (kms_flip:2141) DEBUG: inconsistent vblank ts/seq: last 112.165154/1982, current 112.249313/1992: elapsed=84158.0us expected=85151.2us (kms_flip:2141) DEBUG: name = vblank last_ts = 112.249313 last_received_ts = 112.249161 last_seq = 1992 current_ts = 112.333466 current_received_ts = 112.333328 current_seq = 2002 count = 68 seq_step = 10 (kms_flip:2141) DEBUG: vblank ts/seq: last 112.249313/1992, current 112.333466/2002: elapsed=84151.0us expected=85151.2us +- 425.8us, error 1.2% (kms_flip:2141) DEBUG: inconsistent vblank ts/seq: last 112.249313/1992, current 112.333466/2002: elapsed=84151.0us expected=85151.2us (kms_flip:2141) DEBUG: name = vblank last_ts = 112.333466 last_received_ts = 112.333328 last_seq = 2002 current_ts = 112.417618 current_received_ts = 112.417366 current_seq = 2012 count = 69 seq_step = 10 (kms_flip:2141) DEBUG: vblank ts/seq: last 112.333466/2002, current 112.417618/2012: elapsed=84153.0us expected=85151.2us +- 425.8us, error 1.2% (kms_flip:2141) DEBUG: inconsistent vblank ts/seq: last 112.333466/2002, current 112.417618/2012: elapsed=84153.0us expected=85151.2us (kms_flip:2141) DEBUG: name = vblank last_ts = 112.417618 last_received_ts = 112.417366 last_seq = 2012 current_ts = 112.501770 current_received_ts = 112.501556 current_seq = 2022 count = 70 seq_step = 10 (kms_flip:2141) DEBUG: vblank ts/seq: last 112.417618/2012, current 112.501770/2022: elapsed=84158.0us expected=85151.2us +- 425.8us, error 1.2% (kms_flip:2141) DEBUG: inconsistent vblank ts/seq: last 112.417618/2012, current 112.501770/2022: elapsed=84158.0us expected=85151.2us (kms_flip:2141) DEBUG: name = vblank last_ts = 112.501770 last_received_ts = 112.501556 last_seq = 2022 current_ts = 112.585930 current_received_ts = 112.585785 current_seq = 2032 count = 71 seq_step = 10 (kms_flip:2141) DEBUG: vblank ts/seq: last 112.501770/2022, current 112.585930/2032: elapsed=84156.0us expected=85151.2us +- 425.8us, error 1.2% (kms_flip:2141) DEBUG: inconsistent vblank ts/seq: last 112.501770/2022, current 112.585930/2032: elapsed=84156.0us expected=85151.2us (kms_flip:2141) DEBUG: name = vblank last_ts = 112.585930 last_received_ts = 112.585785 last_seq = 2032 current_ts = 112.670082 current_received_ts = 112.669945 current_seq = 2042 count = 72 seq_step = 10 (kms_flip:2141) DEBUG: vblank ts/seq: last 112.585930/2032, current 112.670082/2042: elapsed=84155.0us expected=85151.2us +- 425.8us, error 1.2% (kms_flip:2141) DEBUG: inconsistent vblank ts/seq: last 112.585930/2032, current 112.670082/2042: elapsed=84155.0us expected=85151.2us (kms_flip:2141) DEBUG: name = vblank last_ts = 112.670082 last_received_ts = 112.669945 last_seq = 2042 current_ts = 112.754173 current_received_ts = 112.754074 current_seq = 2052 count = 73 seq_step = 10 (kms_flip:2141) DEBUG: vblank ts/seq: last 112.670082/2042, current 112.754173/2052: elapsed=84093.0us expected=85151.2us +- 425.8us, error 1.2% (kms_flip:2141) DEBUG: inconsistent vblank ts/seq: last 112.670082/2042, current 112.754173/2052: elapsed=84093.0us expected=85151.2us (kms_flip:2141) DEBUG: name = vblank last_ts = 112.754173 last_received_ts = 112.754074 last_seq = 2052 current_ts = 112.838234 current_received_ts = 112.838043 current_seq = 2062 count = 74 seq_step = 10 (kms_flip:2141) DEBUG: vblank ts/seq: last 112.754173/2052, current 112.838234/2062: elapsed=84056.0us expected=85151.2us +- 425.8us, error 1.3% (kms_flip:2141) DEBUG: inconsistent vblank ts/seq: last 112.754173/2052, current 112.838234/2062: elapsed=84056.0us expected=85151.2us (kms_flip:2141) DEBUG: name = vblank last_ts = 112.838234 last_received_ts = 112.838043 last_seq = 2062 current_ts = 112.922279 current_received_ts = 112.922150 current_seq = 2072 count = 75 seq_step = 10 (kms_flip:2141) DEBUG: vblank ts/seq: last 112.838234/2062, current 112.922279/2072: elapsed=84048.0us expected=85151.2us +- 425.8us, error 1.3% (kms_flip:2141) DEBUG: inconsistent vblank ts/seq: last 112.838234/2062, current 112.922279/2072: elapsed=84048.0us expected=85151.2us (kms_flip:2141) DEBUG: name = vblank last_ts = 112.922279 last_received_ts = 112.922150 last_seq = 2072 current_ts = 113.006332 current_received_ts = 113.005943 current_seq = 2082 count = 76 seq_step = 10 (kms_flip:2141) DEBUG: vblank ts/seq: last 112.922279/2072, current 113.006332/2082: elapsed=84054.0us expected=85151.2us +- 425.8us, error 1.3% (kms_flip:2141) DEBUG: inconsistent vblank ts/seq: last 112.922279/2072, current 113.006332/2082: elapsed=84054.0us expected=85151.2us (kms_flip:2141) DEBUG: name = vblank last_ts = 113.006332 last_received_ts = 113.005943 last_seq = 2082 current_ts = 113.090385 current_received_ts = 113.090263 current_seq = 2092 count = 77 seq_step = 10 (kms_flip:2141) DEBUG: vblank ts/seq: last 113.006332/2082, current 113.090385/2092: elapsed=84053.0us expected=85151.2us +- 425.8us, error 1.3% (kms_flip:2141) DEBUG: inconsistent vblank ts/seq: last 113.006332/2082, current 113.090385/2092: elapsed=84053.0us expected=85151.2us (kms_flip:2141) DEBUG: name = vblank last_ts = 113.090385 last_received_ts = 113.090263 last_seq = 2092 current_ts = 113.174446 current_received_ts = 113.174194 current_seq = 2102 count = 78 seq_step = 10 (kms_flip:2141) DEBUG: vblank ts/seq: last 113.090385/2092, current 113.174446/2102: elapsed=84058.0us expected=85151.2us +- 425.8us, error 1.3% (kms_flip:2141) DEBUG: inconsistent vblank ts/seq: last 113.090385/2092, current 113.174446/2102: elapsed=84058.0us expected=85151.2us (kms_flip:2141) DEBUG: name = vblank last_ts = 113.174446 last_received_ts = 113.174194 last_seq = 2102 current_ts = 113.258499 current_received_ts = 113.258217 current_seq = 2112 count = 79 seq_step = 10 (kms_flip:2141) DEBUG: vblank ts/seq: last 113.174446/2102, current 113.258499/2112: elapsed=84052.0us expected=85151.2us +- 425.8us, error 1.3% (kms_flip:2141) DEBUG: inconsistent vblank ts/seq: last 113.174446/2102, current 113.258499/2112: elapsed=84052.0us expected=85151.2us (kms_flip:2141) DEBUG: name = vblank last_ts = 113.258499 last_received_ts = 113.258217 last_seq = 2112 current_ts = 113.342552 current_received_ts = 113.342300 current_seq = 2122 count = 80 seq_step = 10 (kms_flip:2141) DEBUG: vblank ts/seq: last 113.258499/2112, current 113.342552/2122: elapsed=84056.0us expected=85151.2us +- 425.8us, error 1.3% (kms_flip:2141) DEBUG: inconsistent vblank ts/seq: last 113.258499/2112, current 113.342552/2122: elapsed=84056.0us expected=85151.2us (kms_flip:2141) DEBUG: name = vblank last_ts = 113.342552 last_received_ts = 113.342300 last_seq = 2122 current_ts = 113.426605 current_received_ts = 113.426468 current_seq = 2132 count = 81 seq_step = 10 (kms_flip:2141) DEBUG: vblank ts/seq: last 113.342552/2122, current 113.426605/2132: elapsed=84052.0us expected=85151.2us +- 425.8us, error 1.3% (kms_flip:2141) DEBUG: inconsistent vblank ts/seq: last 113.342552/2122, current 113.426605/2132: elapsed=84052.0us expected=85151.2us (kms_flip:2141) DEBUG: name = vblank last_ts = 113.426605 last_received_ts = 113.426468 last_seq = 2132 current_ts = 113.510658 current_received_ts = 113.510521 current_seq = 2142 count = 82 seq_step = 10 (kms_flip:2141) DEBUG: vblank ts/seq: last 113.426605/2132, current 113.510658/2142: elapsed=84056.0us expected=85151.2us +- 425.8us, error 1.3% (kms_flip:2141) DEBUG: inconsistent vblank ts/seq: last 113.426605/2132, current 113.510658/2142: elapsed=84056.0us expected=85151.2us (kms_flip:2141) DEBUG: name = vblank last_ts = 113.510658 last_received_ts = 113.510521 last_seq = 2142 current_ts = 113.594711 current_received_ts = 113.594460 current_seq = 2152 count = 83 seq_step = 10 (kms_flip:2141) DEBUG: vblank ts/seq: last 113.510658/2142, current 113.594711/2152: elapsed=84048.0us expected=85151.2us +- 425.8us, error 1.3% (kms_flip:2141) DEBUG: inconsistent vblank ts/seq: last 113.510658/2142, current 113.594711/2152: elapsed=84048.0us expected=85151.2us (kms_flip:2141) DEBUG: name = vblank last_ts = 113.594711 last_received_ts = 113.594460 last_seq = 2152 current_ts = 113.678764 current_received_ts = 113.678528 current_seq = 2162 count = 84 seq_step = 10 (kms_flip:2141) DEBUG: vblank ts/seq: last 113.594711/2152, current 113.678764/2162: elapsed=84058.0us expected=85151.2us +- 425.8us, error 1.3% (kms_flip:2141) DEBUG: inconsistent vblank ts/seq: last 113.594711/2152, current 113.678764/2162: elapsed=84058.0us expected=85151.2us (kms_flip:2141) DEBUG: name = vblank last_ts = 113.678764 last_received_ts = 113.678528 last_seq = 2162 current_ts = 113.762756 current_received_ts = 113.762619 current_seq = 2172 count = 85 seq_step = 10 (kms_flip:2141) DEBUG: vblank ts/seq: last 113.678764/2162, current 113.762756/2172: elapsed=83989.0us expected=85151.2us +- 425.8us, error 1.4% (kms_flip:2141) DEBUG: inconsistent vblank ts/seq: last 113.678764/2162, current 113.762756/2172: elapsed=83989.0us expected=85151.2us (kms_flip:2141) DEBUG: name = vblank last_ts = 113.762756 last_received_ts = 113.762619 last_seq = 2172 current_ts = 113.846725 current_received_ts = 113.846481 current_seq = 2182 count = 86 seq_step = 10 (kms_flip:2141) DEBUG: vblank ts/seq: last 113.762756/2172, current 113.846725/2182: elapsed=83966.0us expected=85151.2us +- 425.8us, error 1.4% (kms_flip:2141) DEBUG: inconsistent vblank ts/seq: last 113.762756/2172, current 113.846725/2182: elapsed=83966.0us expected=85151.2us (kms_flip:2141) DEBUG: name = vblank last_ts = 113.846725 last_received_ts = 113.846481 last_seq = 2182 current_ts = 113.930687 current_received_ts = 113.930450 current_seq = 2192 count = 87 seq_step = 10 (kms_flip:2141) DEBUG: vblank ts/seq: last 113.846725/2182, current 113.930687/2192: elapsed=83962.0us expected=85151.2us +- 425.8us, error 1.4% (kms_flip:2141) DEBUG: inconsistent vblank ts/seq: last 113.846725/2182, current 113.930687/2192: elapsed=83962.0us expected=85151.2us (kms_flip:2141) DEBUG: name = vblank last_ts = 113.930687 last_received_ts = 113.930450 last_seq = 2192 current_ts = 114.014656 current_received_ts = 114.014511 current_seq = 2202 count = 88 seq_step = 10 (kms_flip:2141) DEBUG: vblank ts/seq: last 113.930687/2192, current 114.014656/2202: elapsed=83968.0us expected=85151.2us +- 425.8us, error 1.4% (kms_flip:2141) DEBUG: inconsistent vblank ts/seq: last 113.930687/2192, current 114.014656/2202: elapsed=83968.0us expected=85151.2us (kms_flip:2141) INFO: Event vblank: expected 882, counted 890, passrate = 23.60%, encoder type 2 (kms_flip:2141) DEBUG: dropped frames, expected 882, counted 890, passrate = 23.60%, encoder type 2 (kms_flip:2141) CRITICAL: Test assertion failure function __run_test_on_crtc_set, file ../tests/kms_flip.c:1704: (kms_flip:2141) CRITICAL: Failed assertion: !retried (kms_flip:2141) igt_core-INFO: Stack trace: (kms_flip:2141) igt_core-INFO: #0 ../lib/igt_core.c:2075 __igt_fail_assert() (kms_flip:2141) igt_core-INFO: #1 ../tests/kms_flip.c:973 run_test_on_crtc_set.constprop.0() (kms_flip:2141) igt_core-INFO: #2 ../tests/kms_flip.c:1884 run_test() (kms_flip:2141) igt_core-INFO: #3 ../tests/kms_flip.c:2117 __igt_unique____real_main2040() (kms_flip:2141) igt_core-INFO: #4 ../tests/kms_flip.c:2040 main() (kms_flip:2141) igt_core-INFO: #5 ../sysdeps/nptl/libc_start_call_main.h:74 __libc_start_call_main() (kms_flip:2141) igt_core-INFO: #6 ../csu/libc-start.c:128 __libc_start_main@@GLIBC_2.34() (kms_flip:2141) igt_core-INFO: #7 [_start+0x25] END ** Dynamic subtest B-HDMI-A1: FAIL (18.649s)
Dmesg	<6> [155.390705] [IGT] kms_flip: starting dynamic subtest B-HDMI-A1 <7> [155.391787] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:391] <7> [155.392047] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:392] <7> [155.431317] i915 0000:00:02.0: [drm:drm_mode_setcrtc] [CRTC:108:pipe A] <7> [155.431526] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:108:pipe A] fastset requirement not met in hw.enable (expected yes, found no) <7> [155.431938] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:108:pipe A] fastset requirement not met in hw.active (expected yes, found no) <7> [155.432378] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:108:pipe A] fastset requirement not met in cpu_transcoder (expected 0, found -1) <7> [155.432787] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:108:pipe A] fastset requirement not met in lane_count (expected 4, found 0) <7> [155.433184] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:108:pipe A] fastset requirement not met in output_types (expected 0x00000040, found 0x00000000) <7> [155.433697] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:108:pipe A] fastset requirement not met in framestart_delay (expected 1, found 0) <7> [155.434085] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:108:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hdisplay (expected 1920, found 0) <7> [155.434494] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:108:pipe A] fastset requirement not met in hw.pipe_mode.crtc_htotal (expected 2080, found 0) <7> [155.434831] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:108:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hblank_start (expected 1920, found 0) <7> [155.435285] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:108:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hblank_end (expected 2080, found 0) <7> [155.435638] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:108:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hsync_start (expected 1968, found 0) <7> [155.435990] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:108:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hsync_end (expected 2000, found 0) <7> [155.436349] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:108:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vdisplay (expected 1080, found 0) <7> [155.436752] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:108:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vblank_start (expected 1080, found 0) <7> [155.437066] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:108:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vsync_start (expected 1083, found 0) <7> [155.437400] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:108:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vsync_end (expected 1088, found 0) <7> [155.437681] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:108:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vtotal (expected 1144, found 0) <7> [155.437957] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:108:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vblank_end (expected 1144, found 0) <7> [155.438314] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:108:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hdisplay (expected 1920, found 0) <7> [155.438634] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:108:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_htotal (expected 2080, found 0) <7> [155.438925] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:108:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hblank_start (expected 1920, found 0) <7> [155.439237] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:108:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hblank_end (expected 2080, found 0) <7> [155.439520] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:108:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hsync_start (expected 1968, found 0) <7> [155.439873] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:108:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hsync_end (expected 2000, found 0) <7> [155.440131] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:108:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vdisplay (expected 1080, found 0) <7> [155.440342] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:108:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vblank_start (expected 1080, found 0) <7> [155.440542] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:108:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vsync_start (expected 1083, found 0) <7> [155.440790] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:108:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vsync_end (expected 1088, found 0) <7> [155.441005] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:108:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vtotal (expected 1144, found 0) <7> [155.441236] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:108:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vblank_end (expected 1144, found 0) <7> [155.441449] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:108:pipe A] fastset requirement not met in pixel_multiplier (expected 1, found 0) <7> [155.441652] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:108:pipe A] fastset requirement not met in hw.adjusted_mode.flags (1) (expected 1, found 0) <7> [155.441912] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:108:pipe A] fastset requirement not met in hw.adjusted_mode.flags (4) (expected 4, found 0) <7> [155.442133] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:108:pipe A] fastset requirement not met in has_hdmi_sink (expected yes, found no) <7> [155.442340] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:108:pipe A] fastset requirement not met in has_infoframe (expected yes, found no) <7> [155.442558] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:108:pipe A] fastset requirement not met in pipe_bpp (expected 24, found 0) <7> [155.442759] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:108:pipe A] fastset requirement not met in hw.pipe_mode.crtc_clock (expected 285500, found 0) <7> [155.442970] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:108:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_clock (expected 285500, found 0) <7> [155.443163] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:108:pipe A] fastset requirement not met in port_clock (expected 285500, found 0) <7> [155.443330] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:108:pipe A] fastset requirement not met in infoframes.enable (expected 0x00000071, found 0x00000000) <7> [155.443487] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:108:pipe A] fastset requirement not met in avi infoframe <7> [155.443660] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] expected: <7> [155.443819] i915 0000:00:02.0: HDMI infoframe: Auxiliary Video Information (AVI), version 2, length 13 <7> [155.443821] i915 0000:00:02.0: colorspace: RGB <7> [155.443823] i915 0000:00:02.0: scan mode: Underscan <7> [155.443825] i915 0000:00:02.0: colorimetry: No Data <7> [155.443826] i915 0000:00:02.0: picture aspect: No Data <7> [155.443827] i915 0000:00:02.0: active aspect: Same as Picture <7> [155.443829] i915 0000:00:02.0: itc: No Data <7> [155.443830] i915 0000:00:02.0: extended colorimetry: xvYCC 601 <7> [155.443832] i915 0000:00:02.0: quantization range: Full <7> [155.443833] i915 0000:00:02.0: nups: Unknown Non-uniform Scaling <7> [155.443835] i915 0000:00:02.0: video code: 0 <7> [155.443836] i915 0000:00:02.0: ycc quantization range: Full <7> [155.443837] i915 0000:00:02.0: hdmi content type: Graphics <7> [155.443839] i915 0000:00:02.0: pixel repeat: 0 <7> [155.443840] i915 0000:00:02.0: bar top 0, bottom 0, left 0, right 0 <7> [155.443842] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] found: <7> [155.444044] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:108:pipe A] fastset requirement not met in spd infoframe <7> [155.444230] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] expected: <7> [155.444394] i915 0000:00:02.0: HDMI infoframe: Source Product Description (SPD), version 1, length 25 <7> [155.444396] i915 0000:00:02.0: vendor: Intel <7> [155.444397] i915 0000:00:02.0: product: Integrated gfx <7> [155.444399] i915 0000:00:02.0: source device information: PC General (0x9) <7> [155.444401] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] found: <7> [155.444566] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:108:pipe A] fastset requirement not met in hdmi infoframe <7> [155.444724] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] expected: <7> [155.444879] i915 0000:00:02.0: HDMI infoframe: Vendor, version 1, length 4 <7> [155.444881] i915 0000:00:02.0: empty frame <7> [155.444882] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] found: <7> [155.445038] i915 0000:00:02.0: [drm:intel_atomic_check [i915]] [CRTC:108:pipe A] fastset requirement not met, forcing full modeset <7> [155.445266] i915 0000:00:02.0: [drm:intel_dpll_crtc_put [i915]] [CRTC:108:pipe A] releasing DPLL 0 <7> [155.445454] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] Enabled dbuf slices 0x3 -> 0x1 (total dbuf slices 0x3), mbus joined? no->no <7> [155.445612] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] [CRTC:108:pipe A] dbuf slices 0x3 -> 0x0, ddb (0 - 2048) -> (0 - 0), active pipes 0x1 -> 0x0 <7> [155.445805] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] [PLANE:103:cursor A] ddb (1993 - 2048) -> ( 0 - 0), size 55 -> 0 <7> [155.445999] i915 0000:00:02.0: [drm:intel_cdclk_atomic_check [i915]] [CRTC:108:pipe A] min cdclk: 192000 kHz -> 0 kHz <7> [155.446203] i915 0000:00:02.0: [drm:intel_cdclk_atomic_check [i915]] Modeset required for cdclk change <7> [155.446363] i915 0000:00:02.0: [drm:intel_cdclk_atomic_check [i915]] New cdclk calculated to be logical 172800 kHz, actual 172800 kHz <7> [155.446522] i915 0000:00:02.0: [drm:intel_cdclk_atomic_check [i915]] New voltage level calculated to be logical 0, actual 0 <7> [155.446682] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [CRTC:108:pipe A] enable: no [modeset] <7> [155.446844] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:33:plane 1A] fb: [NOFB], visible: no <7> [155.447003] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:43:plane 2A] fb: [NOFB], visible: no <7> [155.447180] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:53:plane 3A] fb: [NOFB], visible: no <7> [155.447337] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:63:plane 4A] fb: [NOFB], visible: no <7> [155.447494] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:73:plane 5A] fb: [NOFB], visible: no <7> [155.447651] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:83:plane 6A] fb: [NOFB], visible: no <7> [155.447806] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:93:plane 7A] fb: [NOFB], visible: no <7> [155.447962] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:103:cursor A] fb: [NOFB], visible: no <7> [155.448211] i915 0000:00:02.0: [drm:intel_audio_codec_disable [i915]] [CONNECTOR:342:HDMI-A-1][ENCODER:341:DDI B/PHY B] Disable audio codec on [CRTC:108:pipe A] <7> [155.463258] i915 0000:00:02.0: [drm:intel_audio_component_get_eld [i915]] Not valid for port B <7> [155.465110] i915 0000:00:02.0: [drm:intel_hdmi_handle_sink_scrambling [i915]] [CONNECTOR:342:HDMI-A-1] scrambling=no, TMDS bit clock ratio=1/10 <7> [155.465741] i915 0000:00:02.0: [drm:do_gmbus_xfer [i915]] GMBUS [i915 gmbus dpb] NAK for addr: 0054 w(1) <7> [155.465893] i915 0000:00:02.0: [drm:do_gmbus_xfer [i915]] GMBUS [i915 gmbus dpb] NAK on first message, retry <7> [155.466490] i915 0000:00:02.0: [drm:do_gmbus_xfer [i915]] GMBUS [i915 gmbus dpb] NAK for addr: 0054 w(1) <7> [155.466693] i915 0000:00:02.0: [drm:drm_scdc_set_high_tmds_clock_ratio [drm_display_helper]] [CONNECTOR:342:HDMI-A-1] Failed to read TMDS config: -6 <7> [155.466708] i915 0000:00:02.0: [drm:intel_ddi_disable [i915]] [CONNECTOR:342:HDMI-A-1] Failed to reset sink scrambling/TMDS bit clock ratio <7> [155.466889] i915 0000:00:02.0: [drm:intel_disable_transcoder [i915]] disabling pipe A <7> [155.472129] i915 0000:00:02.0: [drm:intel_power_well_disable [i915]] disabling DDI_IO_B <7> [155.472327] i915 0000:00:02.0: [drm:intel_dpll_disable [i915]] disable DPLL 0 (active 0x1, on? 1) for [CRTC:108:pipe A] <7> [155.472521] i915 0000:00:02.0: [drm:intel_dpll_disable [i915]] disabling DPLL 0 <7> [155.472710] i915 0000:00:02.0: [drm:intel_set_cdclk [i915]] Pre changing CDCLK to 172800 kHz, VCO 345600 kHz, ref 38400 kHz, bypass 19200 kHz, voltage level 0 <7> [155.473046] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:341:DDI B/PHY B] <7> [155.473308] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:351:DDI TC1/PHY TC1] <7> [155.473519] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:353:DP-MST A] <7> [155.473740] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:354:DP-MST B] <7> [155.473995] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:355:DP-MST C] <7> [155.474230] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:356:DP-MST D] <7> [155.474448] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:361:DDI TC2/PHY TC2] <7> [155.474651] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:363:DP-MST A] <7> [155.474876] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:364:DP-MST B] <7> [155.475126] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:365:DP-MST C] <7> [155.475341] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:366:DP-MST D] <7> [155.475560] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:370:DDI TC3/PHY TC3] <7> [155.475768] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:372:DP-MST A] <7> [155.476005] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:373:DP-MST B] <7> [155.476240] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:374:DP-MST C] <7> [155.476432] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:375:DP-MST D] <7> [155.476629] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:379:DDI TC4/PHY TC4] <7> [155.476820] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:381:DP-MST A] <7> [155.477006] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:382:DP-MST B] <7> [155.477245] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:383:DP-MST C] <7> [155.477459] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:384:DP-MST D] <7> [155.477652] i915 0000:00:02.0: [drm:verify_connector_state [i915]] [CONNECTOR:342:HDMI-A-1] <7> [155.478023] i915 0000:00:02.0: [drm:gen9_dbuf_slices_update [i915]] Updating dbuf slices to 0x1 <7> [155.478313] i915 0000:00:02.0: [drm:intel_power_well_disable [i915]] disabling PW_3 <7> [155.478559] i915 0000:00:02.0: [drm:intel_power_well_disable [i915]] disabling PW_2 <7> [155.478786] i915 0000:00:02.0: [drm:intel_modeset_verify_crtc [i915]] [CRTC:108:pipe A] <7> [155.479428] i915 0000:00:02.0: [drm:drm_mode_setcrtc] [CRTC:185:pipe B] <7> [155.479585] i915 0000:00:02.0: [drm:drm_mode_setcrtc] [CRTC:262:pipe C] <7> [155.479728] i915 0000:00:02.0: [drm:drm_mode_setcrtc] [CRTC:339:pipe D] <7> [155.479860] i915 0000:00:02.0: [drm:drm_mode_setcrtc] [CRTC:185:pipe B] <7> [155.479896] i915 0000:00:02.0: [drm:drm_mode_setcrtc] [CONNECTOR:342:HDMI-A-1] <7> [155.479968] i915 0000:00:02.0: [drm:intel_atomic_check [i915]] [CONNECTOR:342:HDMI-A-1] Limiting display bpp to 24 (EDID bpp 24, max requested bpp 36, max platform bpp 36) <7> [155.480158] i915 0000:00:02.0: [drm:intel_hdmi_compute_clock [i915]] picking 8 bpc for HDMI output (pipe bpp: 24) <7> [155.480335] i915 0000:00:02.0: [drm:intel_atomic_check [i915]] [CRTC:185:pipe B] hw max bpp: 24, pipe bpp: 24, dithering: 0 <7> [155.480530] i915 0000:00:02.0: [drm:intel_ddi_compute_config_late [i915]] [ENCODER:341:DDI B/PHY B] [CRTC:185:pipe B] <7> [155.480690] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:185:pipe B] fastset requirement not met in hw.enable (expected no, found yes) <7> [155.480856] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:185:pipe B] fastset requirement not met in hw.active (expected no, found yes) <7> [155.481023] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:185:pipe B] fastset requirement not met in cpu_transcoder (expected -1, found 1) <7> [155.481205] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:185:pipe B] fastset requirement not met in lane_count (expected 0, found 4) <7> [155.481402] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:185:pipe B] fastset requirement not met in output_types (expected 0x00000000, found 0x00000040) <7> [155.481573] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:185:pipe B] fastset requirement not met in framestart_delay (expected 0, found 1) <7> [155.481742] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:185:pipe B] fastset requirement not met in hw.pipe_mode.crtc_hdisplay (expected 0, found 1920) <7> [155.481900] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:185:pipe B] fastset requirement not met in hw.pipe_mode.crtc_htotal (expected 0, found 2080) <7> [155.482067] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:185:pipe B] fastset requirement not met in hw.pipe_mode.crtc_hblank_start (expected 0, found 1920) <7> [155.482252] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:185:pipe B] fastset requirement not met in hw.pipe_mode.crtc_hblank_end (expected 0, found 2080) <7> [155.482422] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:185:pipe B] fastset requirement not met in hw.pipe_mode.crtc_hsync_start (expected 0, found 1968) <7> [155.482626] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:185:pipe B] fastset requirement not met in hw.pipe_mode.crtc_hsync_end (expected 0, found 2000) <7> [155.482783] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:185:pipe B] fastset requirement not met in hw.pipe_mode.crtc_vdisplay (expected 0, found 1080) <7> [155.482953] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:185:pipe B] fastset requirement not met in hw.pipe_mode.crtc_vblank_start (expected 0, found 1080) <7> [155.483127] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:185:pipe B] fastset requirement not met in hw.pipe_mode.crtc_vsync_start (expected 0, found 1083) <7> [155.483285] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:185:pipe B] fastset requirement not met in hw.pipe_mode.crtc_vsync_end (expected 0, found 1088) <7> [155.483441] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:185:pipe B] fastset requirement not met in hw.pipe_mode.crtc_vtotal (expected 0, found 1144) <7> [155.483647] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:185:pipe B] fastset requirement not met in hw.pipe_mode.crtc_vblank_end (expected 0, found 1144) <7> [155.483810] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:185:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_hdisplay (expected 0, found 1920) <7> [155.483979] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:185:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_htotal (expected 0, found 2080) <7> [155.484156] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:185:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_hblank_start (expected 0, found 1920) <7> [155.484315] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:185:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_hblank_end (expected 0, found 2080) <7> [155.484483] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:185:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_hsync_start (expected 0, found 1968) <7> [155.484678] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:185:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_hsync_end (expected 0, found 2000) <7> [155.484836] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:185:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_vdisplay (expected 0, found 1080) <7> [155.485002] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:185:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_vblank_start (expected 0, found 1080) <7> [155.485183] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:185:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_vsync_start (expected 0, found 1083) <7> [155.485344] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:185:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_vsync_end (expected 0, found 1088) <7> [155.485503] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:185:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_vtotal (expected 0, found 1144) <7> [155.485703] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:185:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_vblank_end (expected 0, found 1144) <7> [155.485871] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:185:pipe B] fastset requirement not met in pixel_multiplier (expected 0, found 1) <7> [155.486038] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:185:pipe B] fastset requirement not met in hw.adjusted_mode.flags (1) (expected 0, found 1) <7> [155.486208] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:185:pipe B] fastset requirement not met in hw.adjusted_mode.flags (4) (expected 0, found 4) <7> [155.486374] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:185:pipe B] fastset requirement not met in has_hdmi_sink (expected no, found yes) <7> [155.486530] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:185:pipe B] fastset requirement not met in has_infoframe (expected no, found yes) <7> [155.486730] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:185:pipe B] fastset requirement not met in dpll_hw_state <7> [155.486887] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] expected: <7> [155.487053] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] dpll_hw_state: cfgcr0: 0x0, cfgcr1: 0x0, 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> [155.487253] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] found: <7> [155.487414] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] dpll_hw_state: cfgcr0: 0x1801be, cfgcr1: 0x488, 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> [155.487573] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:185:pipe B] fastset requirement not met in pipe_bpp (expected 0, found 24) <7> [155.487775] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:185:pipe B] fastset requirement not met in hw.pipe_mode.crtc_clock (expected 0, found 285500) <7> [155.487933] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:185:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_clock (expected 0, found 285500) <7> [155.488108] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:185:pipe B] fastset requirement not met in port_clock (expected 0, found 285500) <7> [155.488278] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:185:pipe B] fastset requirement not met in infoframes.enable (expected 0x00000000, found 0x00000071) <7> [155.488437] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:185:pipe B] fastset requirement not met in avi infoframe <7> [155.488596] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] expected: <7> [155.488802] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] found: <7> [155.488961] i915 0000:00:02.0: HDMI infoframe: Auxiliary Video Information (AVI), version 2, length 13 <7> [155.488963] i915 0000:00:02.0: colorspace: RGB <7> [155.488965] i915 0000:00:02.0: scan mode: Underscan <7> [155.488967] i915 0000:00:02.0: colorimetry: No Data <7> [155.488968] i915 0000:00:02.0: picture aspect: No Data <7> [155.488969] i915 0000:00:02.0: active aspect: Same as Picture <7> [155.488971] i915 0000:00:02.0: itc: No Data <7> [155.488972] i915 0000:00:02.0: extended colorimetry: xvYCC 601 <7> [155.488974] i915 0000:00:02.0: quantization range: Full <7> [155.488975] i915 0000:00:02.0: nups: Unknown Non-uniform Scaling <7> [155.488977] i915 0000:00:02.0: video code: 0 <7> [155.488978] i915 0000:00:02.0: ycc quantization range: Full <7> [155.488979] i915 0000:00:02.0: hdmi content type: Graphics <7> [155.488981] i915 0000:00:02.0: pixel repeat: 0 <7> [155.488982] i915 0000:00:02.0: bar top 0, bottom 0, left 0, right 0 <7> [155.488984] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:185:pipe B] fastset requirement not met in spd infoframe <7> [155.489163] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] expected: <7> [155.489334] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] found: <7> [155.489491] i915 0000:00:02.0: HDMI infoframe: Source Product Description (SPD), version 1, length 25 <7> [155.489493] i915 0000:00:02.0: vendor: Intel <7> [155.489495] i915 0000:00:02.0: product: Integrated gfx <7> [155.489497] i915 0000:00:02.0: source device information: PC General (0x9) <7> [155.489499] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:185:pipe B] fastset requirement not met in hdmi infoframe <7> [155.489655] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] expected: <7> [155.489815] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] found: <7> [155.490016] i915 0000:00:02.0: HDMI infoframe: Vendor, version 1, length 4 <7> [155.490018] i915 0000:00:02.0: empty frame <7> [155.490020] i915 0000:00:02.0: [drm:intel_atomic_check [i915]] [CRTC:185:pipe B] fastset requirement not met, forcing full modeset <7> [155.490229] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] Enabled dbuf slices 0x1 -> 0x3 (total dbuf slices 0x3), mbus joined? no->no <7> [155.490389] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] [CRTC:185:pipe B] dbuf slices 0x0 -> 0x3, ddb (0 - 0) -> (0 - 2048), active pipes 0x0 -> 0x2 <7> [155.490593] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] [PLANE:110:plane 1B] ddb ( 0 - 0) -> ( 0 - 1993), size 0 -> 1993 <7> [155.490748] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] [PLANE:180:cursor B] ddb ( 0 - 0) -> (1993 - 2048), size 0 -> 55 <7> [155.490934] i915 0000:00:02.0: [drm:skl_print_plane_changes [i915]] [PLANE:110: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> [155.491183] i915 0000:00:02.0: [drm:skl_print_plane_changes [i915]] [PLANE:110:plane 1B] lines 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0 -> 1, 8, 8, 8, 8, 11, 16, 16, 0, 0, 0 <7> [155.491348] i915 0000:00:02.0: [drm:skl_print_plane_changes [i915]] [PLANE:110:plane 1B] blocks 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0 -> 16, 129, 129, 129, 129, 177, 257, 257, 30, 0, 0 <7> [155.491510] i915 0000:00:02.0: [drm:skl_print_plane_changes [i915]] [PLANE:110:plane 1B] min_ddb 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0 -> 19, 143, 143, 143, 143, 196, 284, 284, 31, 0, 0 <7> [155.491702] i915 0000:00:02.0: [drm:intel_bw_atomic_check [i915]] [CRTC:185:pipe B] data rate 1142000 num active planes 1 <7> [155.491878] i915 0000:00:02.0: [drm:intel_bw_atomic_check [i915]] QGV point 0: max bw 14993 required 1142 <7> [155.492071] i915 0000:00:02.0: [drm:intel_bw_atomic_check [i915]] No SAGV, using single QGV point mask 0x1 <7> [155.492270] i915 0000:00:02.0: [drm:intel_cdclk_atomic_check [i915]] [CRTC:185:pipe B] min cdclk: 0 kHz -> 192000 kHz <7> [155.492463] i915 0000:00:02.0: [drm:intel_cdclk_atomic_check [i915]] Modeset required for cdclk change <7> [155.492628] i915 0000:00:02.0: [drm:intel_cdclk_atomic_check [i915]] New cdclk calculated to be logical 192000 kHz, actual 192000 kHz <7> [155.492785] i915 0000:00:02.0: [drm:intel_cdclk_atomic_check [i915]] New voltage level calculated to be logical 0, actual 0 <7> [155.492990] i915 0000:00:02.0: [drm:intel_find_dpll [i915]] [CRTC:185:pipe B] allocated DPLL 0 <7> [155.493168] i915 0000:00:02.0: [drm:intel_dpll_crtc_get [i915]] [CRTC:185:pipe B] reserving DPLL 0 <7> [155.493343] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [CRTC:185:pipe B] enable: yes [modeset] <7> [155.493516] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] active: yes, output_types: HDMI (0x40), output format: RGB, sink format: RGB <7> [155.493675] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] cpu_transcoder: B, pipe bpp: 24, dithering: 0 <7> [155.493834] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] MST master transcoder: <invalid> <7> [155.494036] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] port sync: master transcoder: <invalid>, slave transcoder bitmask = 0x0 <7> [155.494213] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] joiner: no, pipes: 0x0 <7> [155.494377] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] splitter: disabled, link count 0, overlap 0 <7> [155.494539] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] audio: 1, infoframes: 1, infoframes enabled: 0x71 <7> [155.494701] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] GCP: 0x0 <7> [155.494856] i915 0000:00:02.0: HDMI infoframe: Auxiliary Video Information (AVI), version 2, length 13 <7> [155.494858] i915 0000:00:02.0: colorspace: RGB <7> [155.494859] i915 0000:00:02.0: scan mode: Underscan <7> [155.494861] i915 0000:00:02.0: colorimetry: No Data <7> [155.494862] i915 0000:00:02.0: picture aspect: No Data <7> [155.494864] i915 0000:00:02.0: active aspect: Same as Picture <7> [155.494865] i915 0000:00:02.0: itc: No Data <7> [155.494866] i915 0000:00:02.0: extended colorimetry: xvYCC 601 <7> [155.494868] i915 0000:00:02.0: quantization range: Full <7> [155.494869] i915 0000:00:02.0: nups: Unknown Non-uniform Scaling <7> [155.494871] i915 0000:00:02.0: video code: 0 <7> [155.494872] i915 0000:00:02.0: ycc quantization range: Full <7> [155.494873] i915 0000:00:02.0: hdmi content type: Graphics <7> [155.494875] i915 0000:00:02.0: pixel repeat: 0 <7> [155.494876] i915 0000:00:02.0: bar top 0, bottom 0, left 0, right 0 <7> [155.494879] i915 0000:00:02.0: HDMI infoframe: Source Product Description (SPD), version 1, length 25 <7> [155.494882] i915 0000:00:02.0: vendor: Intel <7> [155.494884] i915 0000:00:02.0: product: Integrated gfx <7> [155.494886] i915 0000:00:02.0: source device information: PC General (0x9) <7> [155.494889] i915 0000:00:02.0: HDMI infoframe: Vendor, version 1, length 4 <7> [155.494892] i915 0000:00:02.0: empty frame <7> [155.494894] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] ELD: 10 00 0f 00 6d a2 00 7f 00 00 00 00 00 00 00 00 <7> [155.495098] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] ELD: 0d 82 34 12 66 69 74 48 65 61 64 6c 65 73 73 47 <7> [155.495255] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] ELD: 53 7f 7f 28 0f 7f 07 17 7f ff 3f 7f ff 47 7f ff <7> [155.495423] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] ELD: 5f 7f 82 7f 7f 00 7f 7f 51 7f 7f 30 77 7f 03 00 <7> [155.495591] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] scanline offset: 2 <7> [155.495753] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] vblank delay: 0, framestart delay: 1, MSA timing delay: 0 set context latency: 0 <7> [155.495912] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] vrr: no, fixed rr: yes, vmin: 1144, vmax: 1144, flipline: 1144, pipeline full: 61, guardband: 63 vsync start: 0, vsync end: 0 <7> [155.496070] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] vrr: vmin vblank: 1081, vmax vblank: 1081, vmin vtotal: 1144, vmax vtotal: 1144 <7> [155.496261] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] requested mode: "1920x1080": 120 285500 1920 1968 2000 2080 1080 1083 1088 1144 0x48 0x5 <7> [155.496453] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] adjusted mode: "1920x1080": 120 285500 1920 1968 2000 2080 1080 1083 1088 1144 0x48 0x5 <7> [155.496612] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] crtc timings: clock=285500, hd=1920 hb=1920-2080 hs=1968-2000 ht=2080, vd=1080 vb=1080-1144 vs=1083-1088 vt=1144, flags=0x5 <7> [155.496776] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pipe mode: "1920x1080": 120 285500 1920 1968 2000 2080 1080 1083 1088 1144 0x40 0x5 <7> [155.496942] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] crtc timings: clock=285500, hd=1920 hb=1920-2080 hs=1968-2000 ht=2080, vd=1080 vb=1080-1144 vs=1083-1088 vt=1144, flags=0x5 <7> [155.497110] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] port clock: 285500, pipe src: 1920x1080+0+0, pixel rate 285500 <7> [155.497284] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] linetime: 59, ips linetime: 0 <7> [155.497485] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] num_scalers: 2, scaler_users: 0x0, scaler_id: -1, scaling_filter: 0 <7> [155.497640] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pch pfit: 0x0+0+0, disabled, force thru: no <7> [155.497804] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] ips: 0, double wide: 0, drrs: 0 <7> [155.497965] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] dpll_hw_state: cfgcr0: 0x1801be, cfgcr1: 0x488, 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> [155.498135] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] csc_mode: 0x0 gamma_mode: 0x0 gamma_enable: 0 csc_enable: 0 <7> [155.498290] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pre csc lut: 0 entries, post csc lut: 0 entries <7> [155.498489] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] output csc: pre offsets: 0x0000 0x0000 0x0000 <7> [155.498645] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] output csc: coefficients: 0x0000 0x0000 0x0000 <7> [155.498808] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] output csc: coefficients: 0x0000 0x0000 0x0000 <7> [155.498966] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] output csc: coefficients: 0x0000 0x0000 0x0000 <7> [155.499142] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] output csc: post offsets: 0x0000 0x0000 0x0000 <7> [155.499301] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pipe csc: pre offsets: 0x0000 0x0000 0x0000 <7> [155.499460] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pipe csc: coefficients: 0x0000 0x0000 0x0000 <7> [155.499669] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pipe csc: coefficients: 0x0000 0x0000 0x0000 <7> [155.499829] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pipe csc: coefficients: 0x0000 0x0000 0x0000 <7> [155.499997] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pipe csc: post offsets: 0x0000 0x0000 0x0000 <7> [155.500195] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:110:plane 1B] fb: [FB:391] 1920x1080 format = XR24 little-endian (0x34325258) modifier = 0x100000000000001, visible: yes <7> [155.500363] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] rotation: 0x1, scaler: -1, scaling_filter: 0 <7> [155.500522] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] src: 1920.000000x1080.000000+0.000000+0.000000 dst: 1920x1080+0+0 <7> [155.500727] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:120:plane 2B] fb: [NOFB], visible: no <7> [155.500885] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:130:plane 3B] fb: [NOFB], visible: no <7> [155.501051] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:140:plane 4B] fb: [NOFB], visible: no <7> [155.501227] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:150:plane 5B] fb: [NOFB], visible: no <7> [155.501383] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:160:plane 6B] fb: [NOFB], visible: no <7> [155.501537] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:170:plane 7B] fb: [NOFB], visible: no <7> [155.501736] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:180:cursor B] fb: [NOFB], visible: no <7> [155.502487] i915 0000:00:02.0: [drm:intel_power_well_enable [i915]] enabling PW_2 <7> [155.502705] i915 0000:00:02.0: [drm:intel_power_well_enable [i915]] enabling PW_3 <7> [155.502905] i915 0000:00:02.0: [drm:intel_set_cdclk [i915]] Pre changing CDCLK to 192000 kHz, VCO 384000 kHz, ref 38400 kHz, bypass 19200 kHz, voltage level 0 <7> [155.503201] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:341:DDI B/PHY B] <7> [155.503363] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:351:DDI TC1/PHY TC1] <7> [155.503545] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:353:DP-MST A] <7> [155.503728] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:354:DP-MST B] <7> [155.503892] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:355:DP-MST C] <7> [155.504050] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:356:DP-MST D] <7> [155.504247] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:361:DDI TC2/PHY TC2] <7> [155.504406] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:363:DP-MST A] <7> [155.504562] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:364:DP-MST B] <7> [155.504746] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:365:DP-MST C] <7> [155.504928] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:366:DP-MST D] <7> [155.505100] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:370:DDI TC3/PHY TC3] <7> [155.505259] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:372:DP-MST A] <7> [155.505425] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:373:DP-MST B] <7> [155.505581] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:374:DP-MST C] <7> [155.505767] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:375:DP-MST D] <7> [155.505940] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:379:DDI TC4/PHY TC4] <7> [155.506114] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:381:DP-MST A] <7> [155.506270] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:382:DP-MST B] <7> [155.506434] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:383:DP-MST C] <7> [155.506557] i915 0000:00:02.0: [drm:intel_audio_component_get_power [i915]] restored AUD_FREQ_CNTRL to 0x810 <7> [155.506588] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:384:DP-MST D] <7> [155.506910] i915 0000:00:02.0: [drm:gen9_dbuf_slices_update [i915]] Updating dbuf slices to 0x3 <7> [155.507129] i915 0000:00:02.0: [drm:intel_dpll_enable [i915]] enable DPLL 0 (active 0x2, on? 0) for [CRTC:185:pipe B] <7> [155.507304] i915 0000:00:02.0: [drm:intel_dpll_enable [i915]] enabling DPLL 0 <7> [155.507532] i915 0000:00:02.0: [drm:intel_power_well_enable [i915]] enabling DDI_IO_B <7> [155.507814] i915 0000:00:02.0: [drm:intel_enable_transcoder [i915]] enabling pipe B <7> [155.508541] i915 0000:00:02.0: [drm:intel_hdmi_handle_sink_scrambling [i915]] [CONNECTOR:342:HDMI-A-1] scrambling=no, TMDS bit clock ratio=1/10 <7> [155.509232] i915 0000:00:02.0: [drm:do_gmbus_xfer [i915]] GMBUS [i915 gmbus dpb] NAK for addr: 0054 w(1) <7> [155.509397] i915 0000:00:02.0: [drm:do_gmbus_xfer [i915]] GMBUS [i915 gmbus dpb] NAK on first message, retry <7> [155.510013] i915 0000:00:02.0: [drm:do_gmbus_xfer [i915]] GMBUS [i915 gmbus dpb] NAK for addr: 0054 w(1) <7> [155.510217] i915 0000:00:02.0: [drm:drm_scdc_set_high_tmds_clock_ratio [drm_display_helper]] [CONNECTOR:342:HDMI-A-1] Failed to read TMDS config: -6 <7> [155.510231] i915 0000:00:02.0: [drm:intel_ddi_enable [i915]] [CONNECTOR:342:HDMI-A-1] Failed to configure sink scrambling/TMDS bit clock ratio <7> [155.511136] azx_init_pci: snd_hda_intel 0000:00:1f.3: Clearing TCSEL <7> [155.511174] azx_init_pci: snd_hda_intel 0000:00:1f.3: SCH snoop: Enabled <7> [155.527246] i915 0000:00:02.0: [drm:intel_audio_codec_enable [i915]] [CONNECTOR:342:HDMI-A-1][ENCODER:341:DDI B/PHY B] Enable audio codec on [CRTC:185:pipe B], 64 bytes ELD <7> [155.535524] i915 0000:00:02.0: [drm:audio_config_hdmi_pixel_clock [i915]] HDMI audio pixel clock setting for 285500 not found, falling back to defaults <7> [155.535712] i915 0000:00:02.0: [drm:audio_config_hdmi_pixel_clock [i915]] Configuring HDMI audio for pixel clock 25200 (0x00010000) <7> [155.535873] i915 0000:00:02.0: [drm:hsw_audio_config_update [i915]] using automatic N <6> [155.536038] snd_hda_codec_intelhdmi hdaudioC0D2: HDMI: audio coding xtype 5 not expected <6> [155.536040] snd_hda_codec_intelhdmi hdaudioC0D2: HDMI: audio coding xtype 0 not expected <6> [155.536042] snd_hda_codec_intelhdmi hdaudioC0D2: HDMI: audio coding xtype 10 not expected <6> [155.536043] snd_hda_codec_intelhdmi hdaudioC0D2: HDMI: audio coding xtype 6 not expected <7> [155.536191] i915 0000:00:02.0: [drm:verify_connector_state [i915]] [CONNECTOR:342:HDMI-A-1] <7> [155.536441] i915 0000:00:02.0: [drm:intel_modeset_verify_crtc [i915]] [CRTC:185:pipe B] <7> [155.592261] i915 0000:00:02.0: [drm:intel_audio_component_get_power [i915]] restored AUD_FREQ_CNTRL to 0x810 <7> [155.596660] azx_init_pci: snd_hda_intel 0000:00:1f.3: Clearing TCSEL <7> [155.596692] azx_init_pci: snd_hda_intel 0000:00:1f.3: SCH snoop: Enabled <7> [166.148167] i915 0000:00:02.0: [drm:drm_mode_setcrtc] [CRTC:108:pipe A] <7> [166.148814] i915 0000:00:02.0: [drm:drm_mode_setcrtc] [CRTC:185:pipe B] <7> [166.149033] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:185:pipe B] fastset requirement not met in hw.enable (expected yes, found no) <7> [166.149604] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:185:pipe B] fastset requirement not met in hw.active (expected yes, found no) <7> [166.150123] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:185:pipe B] fastset requirement not met in cpu_transcoder (expected 1, found -1) <7> [166.150680] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:185:pipe B] fastset requirement not met in lane_count (expected 4, found 0) <7> [166.151149] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:185:pipe B] fastset requirement not met in output_types (expected 0x00000040, found 0x00000000) <7> [166.151662] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:185:pipe B] fastset requirement not met in framestart_delay (expected 1, found 0) <7> [166.152137] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:185:pipe B] fastset requirement not met in hw.pipe_mode.crtc_hdisplay (expected 1920, found 0) <7> [166.152653] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:185:pipe B] fastset requirement not met in hw.pipe_mode.crtc_htotal (expected 2080, found 0) <7> [166.152915] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:185:pipe B] fastset requirement not met in hw.pipe_mode.crtc_hblank_start (expected 1920, found 0) <7> [166.153073] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:185:pipe B] fastset requirement not met in hw.pipe_mode.crtc_hblank_end (expected 2080, found 0) <7> [166.153243] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:185:pipe B] fastset requirement not met in hw.pipe_mode.crtc_hsync_start (expected 1968, found 0) <7> [166.153400] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:185:pipe B] fastset requirement not met in hw.pipe_mode.crtc_hsync_end (expected 2000, found 0) <7> [166.153556] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:185:pipe B] fastset requirement not met in hw.pipe_mode.crtc_vdisplay (expected 1080, found 0) <7> [166.153713] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:185:pipe B] fastset requirement not met in hw.pipe_mode.crtc_vblank_start (expected 1080, found 0) <7> [166.153873] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:185:pipe B] fastset requirement not met in hw.pipe_mode.crtc_vsync_start (expected 1083, found 0) <7> [166.154034] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:185:pipe B] fastset requirement not met in hw.pipe_mode.crtc_vsync_end (expected 1088, found 0) <7> [166.154202] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:185:pipe B] fastset requirement not met in hw.pipe_mode.crtc_vtotal (expected 1144, found 0) <7> [166.154365] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:185:pipe B] fastset requirement not met in hw.pipe_mode.crtc_vblank_end (expected 1144, found 0) <7> [166.154522] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:185:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_hdisplay (expected 1920, found 0) <7> [166.154679] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:185:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_htotal (expected 2080, found 0) <7> [166.154835] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:185:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_hblank_start (expected 1920, found 0) <7> [166.154991] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:185:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_hblank_end (expected 2080, found 0) <7> [166.155146] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:185:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_hsync_start (expected 1968, found 0) <7> [166.155317] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:185:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_hsync_end (expected 2000, found 0) <7> [166.155475] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:185:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_vdisplay (expected 1080, found 0) <7> [166.155637] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:185:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_vblank_start (expected 1080, found 0) <7> [166.155797] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:185:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_vsync_start (expected 1083, found 0) <7> [166.155955] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:185:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_vsync_end (expected 1088, found 0) <7> [166.156113] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:185:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_vtotal (expected 1144, found 0) <7> [166.156286] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:185:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_vblank_end (expected 1144, found 0) <7> [166.156447] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:185:pipe B] fastset requirement not met in pixel_multiplier (expected 1, found 0) <7> [166.156606] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:185:pipe B] fastset requirement not met in hw.adjusted_mode.flags (1) (expected 1, found 0) <7> [166.156763] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:185:pipe B] fastset requirement not met in hw.adjusted_mode.flags (4) (expected 4, found 0) <7> [166.156920] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:185:pipe B] fastset requirement not met in has_hdmi_sink (expected yes, found no) <7> [166.157076] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:185:pipe B] fastset requirement not met in has_infoframe (expected yes, found no) <7> [166.157251] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:185:pipe B] fastset requirement not met in pipe_bpp (expected 24, found 0) <7> [166.157411] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:185:pipe B] fastset requirement not met in hw.pipe_mode.crtc_clock (expected 285500, found 0) <7> [166.157570] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:185:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_clock (expected 285500, found 0) <7> [166.157727] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:185:pipe B] fastset requirement not met in port_clock (expected 285500, found 0) <7> [166.157885] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:185:pipe B] fastset requirement not met in infoframes.enable (expected 0x00000071, found 0x00000000) <7> [166.158042] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:185:pipe B] fastset requirement not met in avi infoframe <7> [166.158212] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] expected: <7> [166.158380] i915 0000:00:02.0: HDMI infoframe: Auxiliary Video Information (AVI), version 2, length 13 <7> [166.158382] i915 0000:00:02.0: colorspace: RGB <7> [166.158384] i915 0000:00:02.0: scan mode: Underscan <7> [166.158385] i915 0000:00:02.0: colorimetry: No Data <7> [166.158387] i915 0000:00:02.0: picture aspect: No Data <7> [166.158388] i915 0000:00:02.0: active aspect: Same as Picture <7> [166.158389] i915 0000:00:02.0: itc: No Data <7> [166.158391] i915 0000:00:02.0: extended colorimetry: xvYCC 601 <7> [166.158392] i915 0000:00:02.0: quantization range: Full <7> [166.158394] i915 0000:00:02.0: nups: Unknown Non-uniform Scaling <7> [166.158395] i915 0000:00:02.0: video code: 0 <7> [166.158397] i915 0000:00:02.0: ycc quantization range: Full <7> [166.158398] i915 0000:00:02.0: hdmi content type: Graphics <7> [166.158399] i915 0000:00:02.0: pixel repeat: 0 <7> [166.158401] i915 0000:00:02.0: bar top 0, bottom 0, left 0, right 0 <7> [166.158402] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] found: <7> [166.158558] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:185:pipe B] fastset requirement not met in spd infoframe <7> [166.158715] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] expected: <7> [166.158870] i915 0000:00:02.0: HDMI infoframe: Source Product Description (SPD), version 1, length 25 <7> [166.158872] i915 0000:00:02.0: vendor: Intel <7> [166.158873] i915 0000:00:02.0: product: Integrated gfx <7> [166.158875] i915 0000:00:02.0: source device information: PC General (0x9) <7> [166.158876] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] found: <7> [166.159031] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:185:pipe B] fastset requirement not met in hdmi infoframe <7> [166.159198] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] expected: <7> [166.159353] i915 0000:00:02.0: HDMI infoframe: Vendor, version 1, length 4 <7> [166.159355] i915 0000:00:02.0: empty frame <7> [166.159356] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] found: <7> [166.159513] i915 0000:00:02.0: [drm:intel_atomic_check [i915]] [CRTC:185:pipe B] fastset requirement not met, forcing full modeset <7> [166.159670] i915 0000:00:02.0: [drm:intel_dpll_crtc_put [i915]] [CRTC:185:pipe B] releasing DPLL 0 <7> [166.159851] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] Enabled dbuf slices 0x3 -> 0x1 (total dbuf slices 0x3), mbus joined? no->no <7> [166.160007] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] [CRTC:185:pipe B] dbuf slices 0x3 -> 0x0, ddb (0 - 2048) -> (0 - 0), active pipes 0x2 -> 0x0 <7> [166.160205] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] [PLANE:110:plane 1B] ddb ( 0 - 1993) -> ( 0 - 0), size 1993 -> 0 <7> [166.160360] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] [PLANE:180:cursor B] ddb (1993 - 2048) -> ( 0 - 0), size 55 -> 0 <7> [166.160518] i915 0000:00:02.0: [drm:skl_print_plane_changes [i915]] [PLANE:110: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> [166.160674] i915 0000:00:02.0: [drm:skl_print_plane_changes [i915]] [PLANE:110:plane 1B] lines 1, 8, 8, 8, 8, 11, 16, 16, 0, 0, 0 -> 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0 <7> [166.160829] i915 0000:00:02.0: [drm:skl_print_plane_changes [i915]] [PLANE:110:plane 1B] blocks 16, 129, 129, 129, 129, 177, 257, 257, 30, 0, 0 -> 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0 <7> [166.160982] i915 0000:00:02.0: [drm:skl_print_plane_changes [i915]] [PLANE:110:plane 1B] min_ddb 19, 143, 143, 143, 143, 196, 284, 284, 31, 0, 0 -> 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0 <7> [166.161166] i915 0000:00:02.0: [drm:intel_bw_atomic_check [i915]] [CRTC:185:pipe B] data rate 0 num active planes 0 <7> [166.161327] i915 0000:00:02.0: [drm:intel_bw_atomic_check [i915]] QGV point 0: max bw 14993 required 0 <7> [166.161503] i915 0000:00:02.0: [drm:intel_cdclk_atomic_check [i915]] [CRTC:185:pipe B] min cdclk: 192000 kHz -> 0 kHz <7> [166.161665] i915 0000:00:02.0: [drm:intel_cdclk_update_bw_min_cdclk [i915]] bandwidth min cdclk: 17844 kHz -> 0 kHz <7> [166.161851] i915 0000:00:02.0: [drm:intel_cdclk_atomic_check [i915]] Modeset required for cdclk change <7> [166.162010] i915 0000:00:02.0: [drm:intel_cdclk_atomic_check [i915]] New cdclk calculated to be logical 172800 kHz, actual 172800 kHz <7> [166.162181] i915 0000:00:02.0: [drm:intel_cdclk_atomic_check [i915]] New voltage level calculated to be logical 0, actual 0 <7> [166.162341] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [CRTC:185:pipe B] enable: no [modeset] <7> [166.162504] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:110:plane 1B] fb: [NOFB], visible: no <7> [166.162664] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:120:plane 2B] fb: [NOFB], visible: no <7> [166.162822] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:130:plane 3B] fb: [NOFB], visible: no <7> [166.162979] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:140:plane 4B] fb: [NOFB], visible: no <7> [166.163148] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:150:plane 5B] fb: [NOFB], visible: no <7> [166.163304] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:160:plane 6B] fb: [NOFB], visible: no <7> [166.163459] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:170:plane 7B] fb: [NOFB], visible: no <7> [166.163615] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:180:cursor B] fb: [NOFB], visible: no <7> [166.163848] i915 0000:00:02.0: [drm:intel_audio_codec_disable [i915]] [CONNECTOR:342:HDMI-A-1][ENCODER:341:DDI B/PHY B] Disable audio codec on [CRTC:185:pipe B] <7> [166.178825] i915 0000:00:02.0: [drm:intel_audio_component_get_eld [i915]] Not valid for port B <7> [166.180628] i915 0000:00:02.0: [drm:intel_hdmi_handle_sink_scrambling [i915]] [CONNECTOR:342:HDMI-A-1] scrambling=no, TMDS bit clock ratio=1/10 <7> [166.181158] i915 0000:00:02.0: [drm:do_gmbus_xfer [i915]] GMBUS [i915 gmbus dpb] NAK for addr: 0054 w(1) <7> [166.181309] i915 0000:00:02.0: [drm:do_gmbus_xfer [i915]] GMBUS [i915 gmbus dpb] NAK on first message, retry <7> [166.181824] i915 0000:00:02.0: [drm:do_gmbus_xfer [i915]] GMBUS [i915 gmbus dpb] NAK for addr: 0054 w(1) <7> [166.181979] i915 0000:00:02.0: [drm:drm_scdc_set_high_tmds_clock_ratio [drm_display_helper]] [CONNECTOR:342:HDMI-A-1] Failed to read TMDS config: -6 <7> [166.181994] i915 0000:00:02.0: [drm:intel_ddi_disable [i915]] [CONNECTOR:342:HDMI-A-1] Failed to reset sink scrambling/TMDS bit clock ratio <7> [166.182170] i915 0000:00:02.0: [drm:intel_disable_transcoder [i915]] disabling pipe B <7> [166.188543] i915 0000:00:02.0: [drm:intel_power_well_disable [i915]] disabling DDI_IO_B <7> [166.188749] i915 0000:00:02.0: [drm:intel_dpll_disable [i915]] disable DPLL 0 (active 0x2, on? 1) for [CRTC:185:pipe B] <7> [166.188947] i915 0000:00:02.0: [drm:intel_dpll_disable [i915]] disabling DPLL 0 <7> [166.189128] i915 0000:00:02.0: [drm:intel_set_cdclk [i915]] Pre changing CDCLK to 172800 kHz, VCO 345600 kHz, ref 38400 kHz, bypass 19200 kHz, voltage level 0 <7> [166.189382] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:341:DDI B/PHY B] <7> [166.189587] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:351:DDI TC1/PHY TC1] <7> [166.189756] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:353:DP-MST A] <7> [166.189922] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:354:DP-MST B] <7> [166.190087] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:355:DP-MST C] <7> [166.190255] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:356:DP-MST D] <7> [166.190441] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:361:DDI TC2/PHY TC2] <7> [166.190608] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:363:DP-MST A] <7> [166.190772] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:364:DP-MST B] <7> [166.190935] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:365:DP-MST C] <7> [166.191099] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:366:DP-MST D] <7> [166.191262] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:370:DDI TC3/PHY TC3] <7> [166.191446] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:372:DP-MST A] <7> [166.191620] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:373:DP-MST B] <7> [166.191791] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:374:DP-MST C] <7> [166.191962] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:375:DP-MST D] <7> [166.192133] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:379:DDI TC4/PHY TC4] <7> [166.192303] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:381:DP-MST A] <7> [166.192485] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:382:DP-MST B] <7> [166.192664] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:383:DP-MST C] <7> [166.192838] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:384:DP-MST D] <7> [166.193014] i915 0000:00:02.0: [drm:verify_connector_state [i915]] [CONNECTOR:342:HDMI-A-1] <7> [166.193361] i915 0000:00:02.0: [drm:gen9_dbuf_slices_update [i915]] Updating dbuf slices to 0x1 <7> [166.193600] i915 0000:00:02.0: [drm:intel_power_well_disable [i915]] disabling PW_3 <7> [166.193801] i915 0000:00:02.0: [drm:intel_power_well_disable [i915]] disabling PW_2 <7> [166.194004] i915 0000:00:02.0: [drm:intel_modeset_verify_crtc [i915]] [CRTC:185:pipe B] <7> [166.194472] i915 0000:00:02.0: [drm:drm_mode_setcrtc] [CRTC:262:pipe C] <7> [166.194630] i915 0000:00:02.0: [drm:drm_mode_setcrtc] [CRTC:339:pipe D] <7> [166.194760] i915 0000:00:02.0: [drm:drm_mode_setcrtc] [CRTC:185:pipe B] <7> [166.194790] i915 0000:00:02.0: [drm:drm_mode_setcrtc] [CONNECTOR:342:HDMI-A-1] <7> [166.194851] i915 0000:00:02.0: [drm:intel_atomic_check [i915]] [CONNECTOR:342:HDMI-A-1] Limiting display bpp to 24 (EDID bpp 24, max requested bpp 36, max platform bpp 36) <7> [166.195027] i915 0000:00:02.0: [drm:intel_hdmi_compute_clock [i915]] picking 8 bpc for HDMI output (pipe bpp: 24) <7> [166.195188] i915 0000:00:02.0: [drm:intel_atomic_check [i915]] [CRTC:185:pipe B] hw max bpp: 24, pipe bpp: 24, dithering: 0 <7> [166.195366] i915 0000:00:02.0: [drm:intel_ddi_compute_config_late [i915]] [ENCODER:341:DDI B/PHY B] [CRTC:185:pipe B] <7> [166.195522] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:185:pipe B] fastset requirement not met in hw.enable (expected no, found yes) <7> [166.195688] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:185:pipe B] fastset requirement not met in hw.active (expected no, found yes) <7> [166.195850] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:185:pipe B] fastset requirement not met in cpu_transcoder (expected -1, found 1) <7> [166.196009] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:185:pipe B] fastset requirement not met in lane_count (expected 0, found 4) <7> [166.196169] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:185:pipe B] fastset requirement not met in output_types (expected 0x00000000, found 0x00000040) <7> [166.196340] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:185:pipe B] fastset requirement not met in framestart_delay (expected 0, found 1) <7> [166.196504] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:185:pipe B] fastset requirement not met in hw.pipe_mode.crtc_hdisplay (expected 0, found 1920) <7> [166.196664] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:185:pipe B] fastset requirement not met in hw.pipe_mode.crtc_htotal (expected 0, found 2080) <7> [166.196821] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:185:pipe B] fastset requirement not met in hw.pipe_mode.crtc_hblank_start (expected 0, found 1920) <7> [166.196979] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:185:pipe B] fastset requirement not met in hw.pipe_mode.crtc_hblank_end (expected 0, found 2080) <7> [166.197136] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:185:pipe B] fastset requirement not met in hw.pipe_mode.crtc_hsync_start (expected 0, found 1968) <7> [166.197306] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:185:pipe B] fastset requirement not met in hw.pipe_mode.crtc_hsync_end (expected 0, found 2000) <7> [166.197467] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:185:pipe B] fastset requirement not met in hw.pipe_mode.crtc_vdisplay (expected 0, found 1080) <7> [166.197628] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:185:pipe B] fastset requirement not met in hw.pipe_mode.crtc_vblank_start (expected 0, found 1080) <7> [166.197788] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:185:pipe B] fastset requirement not met in hw.pipe_mode.crtc_vsync_start (expected 0, found 1083) <7> [166.197945] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:185:pipe B] fastset requirement not met in hw.pipe_mode.crtc_vsync_end (expected 0, found 1088) <7> [166.198103] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:185:pipe B] fastset requirement not met in hw.pipe_mode.crtc_vtotal (expected 0, found 1144) <7> [166.198266] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:185:pipe B] fastset requirement not met in hw.pipe_mode.crtc_vblank_end (expected 0, found 1144) <7> [166.198423] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:185:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_hdisplay (expected 0, found 1920) <7> [166.198580] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:185:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_htotal (expected 0, found 2080) <7> [166.198735] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:185:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_hblank_start (expected 0, found 1920) <7> [166.198891] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:185:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_hblank_end (expected 0, found 2080) <7> [166.199047] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:185:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_hsync_start (expected 0, found 1968) <7> [166.199206] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:185:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_hsync_end (expected 0, found 2000) <7> [166.199377] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:185:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_vdisplay (expected 0, found 1080) <7> [166.199536] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:185:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_vblank_start (expected 0, found 1080) <7> [166.199694] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:185:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_vsync_start (expected 0, found 1083) <7> [166.199850] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:185:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_vsync_end (expected 0, found 1088) <7> [166.200006] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:185:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_vtotal (expected 0, found 1144) <7> [166.200163] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:185:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_vblank_end (expected 0, found 1144) <7> [166.200327] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:185:pipe B] fastset requirement not met in pixel_multiplier (expected 0, found 1) <7> [166.200484] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:185:pipe B] fastset requirement not met in hw.adjusted_mode.flags (1) (expected 0, found 1) <7> [166.200640] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:185:pipe B] fastset requirement not met in hw.adjusted_mode.flags (4) (expected 0, found 4) <7> [166.200796] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:185:pipe B] fastset requirement not met in has_hdmi_sink (expected no, found yes) <7> [166.200951] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:185:pipe B] fastset requirement not met in has_infoframe (expected no, found yes) <7> [166.201107] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:185:pipe B] fastset requirement not met in pipe_bpp (expected 0, found 24) <7> [166.201276] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:185:pipe B] fastset requirement not met in hw.pipe_mode.crtc_clock (expected 0, found 285500) <7> [166.201440] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:185:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_clock (expected 0, found 285500) <7> [166.201596] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:185:pipe B] fastset requirement not met in port_clock (expected 0, found 285500) <7> [166.201751] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:185:pipe B] fastset requirement not met in infoframes.enable (expected 0x00000000, found 0x00000071) <7> [166.201908] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:185:pipe B] fastset requirement not met in avi infoframe <7> [166.202063] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] expected: <7> [166.202229] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] found: <7> [166.202385] i915 0000:00:02.0: HDMI infoframe: Auxiliary Video Information (AVI), version 2, length 13 <7> [166.202388] i915 0000:00:02.0: colorspace: RGB <7> [166.202389] i915 0000:00:02.0: scan mode: Underscan <7> [166.202391] i915 0000:00:02.0: colorimetry: No Data <7> [166.202392] i915 0000:00:02.0: picture aspect: No Data <7> [166.202394] i915 0000:00:02.0: active aspect: Same as Picture <7> [166.202395] i915 0000:00:02.0: itc: No Data <7> [166.202397] i915 0000:00:02.0: extended colorimetry: xvYCC 601 <7> [166.202398] i915 0000:00:02.0: quantization range: Full <7> [166.202400] i915 0000:00:02.0: nups: Unknown Non-uniform Scaling <7> [166.202401] i915 0000:00:02.0: video code: 0 <7> [166.202403] i915 0000:00:02.0: ycc quantization range: Full <7> [166.202404] i915 0000:00:02.0: hdmi content type: Graphics <7> [166.202406] i915 0000:00:02.0: pixel repeat: 0 <7> [166.202407] i915 0000:00:02.0: bar top 0, bottom 0, left 0, right 0 <7> [166.202409] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:185:pipe B] fastset requirement not met in spd infoframe <7> [166.202564] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] expected: <7> [166.202721] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] found: <7> [166.202881] i915 0000:00:02.0: HDMI infoframe: Source Product Description (SPD), version 1, length 25 <7> [166.202883] i915 0000:00:02.0: vendor: Intel <7> [166.202885] i915 0000:00:02.0: product: Integrated gfx <7> [166.202886] i915 0000:00:02.0: source device information: PC General (0x9) <7> [166.202888] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:185:pipe B] fastset requirement not met in hdmi infoframe <7> [166.203047] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] expected: <7> [166.203216] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] found: <7> [166.203378] i915 0000:00:02.0: HDMI infoframe: Vendor, version 1, length 4 <7> [166.203380] i915 0000:00:02.0: empty frame <7> [166.203382] i915 0000:00:02.0: [drm:intel_atomic_check [i915]] [CRTC:185:pipe B] fastset requirement not met, forcing full modeset <7> [166.203568] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] Enabled dbuf slices 0x1 -> 0x3 (total dbuf slices 0x3), mbus joined? no->no <7> [166.203728] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] [CRTC:185:pipe B] dbuf slices 0x0 -> 0x3, ddb (0 - 0) -> (0 - 2048), active pipes 0x0 -> 0x2 <7> [166.203923] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] [PLANE:110:plane 1B] ddb ( 0 - 0) -> ( 0 - 1993), size 0 -> 1993 <7> [166.204078] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] [PLANE:180:cursor B] ddb ( 0 - 0) -> (1993 - 2048), size 0 -> 55 <7> [166.204247] i915 0000:00:02.0: [drm:skl_print_plane_changes [i915]] [PLANE:110: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> [166.204402] i915 0000:00:02.0: [drm:skl_print_plane_changes [i915]] [PLANE:110:plane 1B] lines 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0 -> 1, 8, 8, 8, 8, 11, 16, 16, 0, 0, 0 <7> [166.204558] i915 0000:00:02.0: [drm:skl_print_plane_changes [i915]] [PLANE:110:plane 1B] blocks 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0 -> 16, 129, 129, 129, 129, 177, 257, 257, 30, 0, 0 <7> [166.204713] i915 0000:00:02.0: [drm:skl_print_plane_changes [i915]] [PLANE:110:plane 1B] min_ddb 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0 -> 19, 143, 143, 143, 143, 196, 284, 284, 31, 0, 0 <7> [166.204887] i915 0000:00:02.0: [drm:intel_bw_atomic_check [i915]] [CRTC:185:pipe B] data rate 1142000 num active planes 1 <7> [166.205051] i915 0000:00:02.0: [drm:intel_bw_atomic_check [i915]] QGV point 0: max bw 14993 required 1142 <7> [166.205288] i915 0000:00:02.0: [drm:intel_bw_atomic_check [i915]] No SAGV, using single QGV point mask 0x1 <7> [166.205465] i915 0000:00:02.0: [drm:intel_cdclk_atomic_check [i915]] [CRTC:185:pipe B] min cdclk: 0 kHz -> 192000 kHz <7> [166.205625] i915 0000:00:02.0: [drm:intel_cdclk_update_bw_min_cdclk [i915]] bandwidth min cdclk: 0 kHz -> 17844 kHz <7> [166.205806] i915 0000:00:02.0: [drm:intel_cdclk_atomic_check [i915]] Modeset required for cdclk change <7> [166.205962] i915 0000:00:02.0: [drm:intel_cdclk_atomic_check [i915]] New cdclk calculated to be logical 192000 kHz, actual 192000 kHz <7> [166.206136] i915 0000:00:02.0: [drm:intel_cdclk_atomic_check [i915]] New voltage level calculated to be logical 0, actual 0 <7> [166.206296] i915 0000:00:02.0: [drm:intel_find_dpll [i915]] [CRTC:185:pipe B] allocated DPLL 0 <7> [166.206459] i915 0000:00:02.0: [drm:intel_dpll_crtc_get [i915]] [CRTC:185:pipe B] reserving DPLL 0 <7> [166.206622] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [CRTC:185:pipe B] enable: yes [modeset] <7> [166.206784] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] active: yes, output_types: HDMI (0x40), output format: RGB, sink format: RGB <7> [166.206943] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] cpu_transcoder: B, pipe bpp: 24, dithering: 0 <7> [166.207114] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] MST master transcoder: <invalid> <7> [166.207273] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] port sync: master transcoder: <invalid>, slave transcoder bitmask = 0x0 <7> [166.207441] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] joiner: no, pipes: 0x0 <7> [166.207602] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] splitter: disabled, link count 0, overlap 0 <7> [166.207761] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] audio: 1, infoframes: 1, infoframes enabled: 0x71 <7> [166.207920] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] GCP: 0x0 <7> [166.208090] i915 0000:00:02.0: HDMI infoframe: Auxiliary Video Information (AVI), version 2, length 13 <7> [166.208092] i915 0000:00:02.0: colorspace: RGB <7> [166.208093] i915 0000:00:02.0: scan mode: Underscan <7> [166.208095] i915 0000:00:02.0: colorimetry: No Data <7> [166.208096] i915 0000:00:02.0: picture aspect: No Data <7> [166.208098] i915 0000:00:02.0: active aspect: Same as Picture <7> [166.208099] i915 0000:00:02.0: itc: No Data <7> [166.208101] i915 0000:00:02.0: extended colorimetry: xvYCC 601 <7> [166.208102] i915 0000:00:02.0: quantization range: Full <7> [166.208104] i915 0000:00:02.0: nups: Unknown Non-uniform Scaling <7> [166.208105] i915 0000:00:02.0: video code: 0 <7> [166.208107] i915 0000:00:02.0: ycc quantization range: Full <7> [166.208108] i915 0000:00:02.0: hdmi content type: Graphics <7> [166.208110] i915 0000:00:02.0: pixel repeat: 0 <7> [166.208111] i915 0000:00:02.0: bar top 0, bottom 0, left 0, right 0 <7> [166.208113] i915 0000:00:02.0: HDMI infoframe: Source Product Description (SPD), version 1, length 25 <7> [166.208115] i915 0000:00:02.0: vendor: Intel <7> [166.208116] i915 0000:00:02.0: product: Integrated gfx <7> [166.208118] i915 0000:00:02.0: source device information: PC General (0x9) <7> [166.208120] i915 0000:00:02.0: HDMI infoframe: Vendor, version 1, length 4 <7> [166.208121] i915 0000:00:02.0: empty frame <7> [166.208123] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] ELD: 10 00 0f 00 6d a2 00 7f 00 00 00 00 00 00 00 00 <7> [166.208284] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] ELD: 0d 82 34 12 66 69 74 48 65 61 64 6c 65 73 73 47 <7> [166.208443] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] ELD: 53 7f 7f 28 0f 7f 07 17 7f ff 3f 7f ff 47 7f ff <7> [166.208600] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] ELD: 5f 7f 82 7f 7f 00 7f 7f 51 7f 7f 30 77 7f 03 00 <7> [166.208756] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] scanline offset: 2 <7> [166.208911] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] vblank delay: 0, framestart delay: 1, MSA timing delay: 0 set context latency: 0 <7> [166.209081] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] vrr: no, fixed rr: yes, vmin: 1144, vmax: 1144, flipline: 1144, pipeline full: 61, guardband: 63 vsync start: 0, vsync end: 0 <7> [166.209239] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] vrr: vmin vblank: 1081, vmax vblank: 1081, vmin vtotal: 1144, vmax vtotal: 1144 <7> [166.209394] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] requested mode: "1920x1080": 120 285500 1920 1968 2000 2080 1080 1083 1088 1144 0x48 0x5 <7> [166.209551] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] adjusted mode: "1920x1080": 120 285500 1920 1968 2000 2080 1080 1083 1088 1144 0x48 0x5 <7> [166.209708] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] crtc timings: clock=285500, hd=1920 hb=1920-2080 hs=1968-2000 ht=2080, vd=1080 vb=1080-1144 vs=1083-1088 vt=1144, flags=0x5 <7> [166.209864] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pipe mode: "1920x1080": 120 285500 1920 1968 2000 2080 1080 1083 1088 1144 0x40 0x5 <7> [166.210037] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] crtc timings: clock=285500, hd=1920 hb=1920-2080 hs=1968-2000 ht=2080, vd=1080 vb=1080-1144 vs=1083-1088 vt=1144, flags=0x5 <7> [166.210194] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] port clock: 285500, pipe src: 1920x1080+0+0, pixel rate 285500 <7> [166.210351] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] linetime: 59, ips linetime: 0 <7> [166.210506] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] num_scalers: 2, scaler_users: 0x0, scaler_id: -1, scaling_filter: 0 <7> [166.210662] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pch pfit: 0x0+0+0, disabled, force thru: no <7> [166.210822] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] ips: 0, double wide: 0, drrs: 0 <7> [166.210991] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] dpll_hw_state: cfgcr0: 0x1801be, cfgcr1: 0x488, 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> [166.211151] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] csc_mode: 0x0 gamma_mode: 0x0 gamma_enable: 0 csc_enable: 0 <7> [166.211309] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pre csc lut: 0 entries, post csc lut: 0 entries <7> [166.211466] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] output csc: pre offsets: 0x0000 0x0000 0x0000 <7> [166.211622] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] output csc: coefficients: 0x0000 0x0000 0x0000 <7> [166.211778] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] output csc: coefficients: 0x0000 0x0000 0x0000 <7> [166.211943] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] output csc: coefficients: 0x0000 0x0000 0x0000 <7> [166.212107] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] output csc: post offsets: 0x0000 0x0000 0x0000 <7> [166.212265] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pipe csc: pre offsets: 0x0000 0x0000 0x0000 <7> [166.212423] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pipe csc: coefficients: 0x0000 0x0000 0x0000 <7> [166.212581] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pipe csc: coefficients: 0x0000 0x0000 0x0000 <7> [166.212736] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pipe csc: coefficients: 0x0000 0x0000 0x0000 <7> [166.212893] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pipe csc: post offsets: 0x0000 0x0000 0x0000 <7> [166.213078] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:110:plane 1B] fb: [FB:391] 1920x1080 format = XR24 little-endian (0x34325258) modifier = 0x100000000000001, visible: yes <7> [166.213103] i915 0000:00:02.0: [drm:intel_power_well_disable [i915]] disabling DC_off <7> [166.213270] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] rotation: 0x1, scaler: -1, scaling_filter: 0 <7> [166.213374] i915 0000:00:02.0: [drm:skl_enable_dc6 [i915]] Enabling DC6 <7> [166.213430] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] src: 1920.000000x1080.000000+0.000000+0.000000 dst: 1920x1080+0+0 <7> [166.213595] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:120:plane 2B] fb: [NOFB], visible: no <7> [166.213616] i915 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [i915]] Setting DC state from 00 to 02 <7> [166.213756] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:130:plane 3B] fb: [NOFB], visible: no <7> [166.213928] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:140:plane 4B] fb: [NOFB], visible: no <7> [166.214106] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:150:plane 5B] fb: [NOFB], visible: no <7> [166.214266] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:160:plane 6B] fb: [NOFB], visible: no <7> [166.214424] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:170:plane 7B] fb: [NOFB], visible: no <7> [166.214582] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:180:cursor B] fb: [NOFB], visible: no <7> [166.214884] i915 0000:00:02.0: [drm:intel_power_well_disable [i915]] disabling always-on <7> [166.215136] i915 0000:00:02.0: [drm:intel_power_well_enable [i915]] enabling always-on <7> [166.215315] i915 0000:00:02.0: [drm:intel_power_well_enable [i915]] enabling DC_off <7> [166.216020] i915 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [i915]] Setting DC state from 02 to 00 <7> [166.217213] i915 0000:00:02.0: [drm:intel_power_well_enable [i915]] enabling PW_2 <7> [166.217391] i915 0000:00:02.0: [drm:intel_power_well_enable [i915]] enabling PW_3 <7> [166.217590] i915 0000:00:02.0: [drm:intel_set_cdclk [i915]] Pre changing CDCLK to 192000 kHz, VCO 384000 kHz, ref 38400 kHz, bypass 19200 kHz, voltage level 0 <7> [166.217883] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:341:DDI B/PHY B] <7> [166.218046] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:351:DDI TC1/PHY TC1] <7> [166.218215] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:353:DP-MST A] <7> [166.218385] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:354:DP-MST B] <7> [166.218544] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:355:DP-MST C] <7> [166.218734] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:356:DP-MST D] <7> [166.218905] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:361:DDI TC2/PHY TC2] <7> [166.219071] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:363:DP-MST A] <7> [166.219238] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:364:DP-MST B] <7> [166.219396] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:365:DP-MST C] <7> [166.219559] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:366:DP-MST D] <7> [166.219751] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:370:DDI TC3/PHY TC3] <7> [166.219920] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:372:DP-MST A] <7> [166.220082] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:373:DP-MST B] <7> [166.220251] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:374:DP-MST C] <7> [166.220411] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:375:DP-MST D] <7> [166.220571] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:379:DDI TC4/PHY TC4] <7> [166.220783] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:381:DP-MST A] <7> [166.220967] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:382:DP-MST B] <7> [166.221131] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:383:DP-MST C] <7> [166.221294] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:384:DP-MST D] <7> [166.221573] i915 0000:00:02.0: [drm:gen9_dbuf_slices_update [i915]] Updating dbuf slices to 0x3 <7> [166.221831] i915 0000:00:02.0: [drm:intel_dpll_enable [i915]] enable DPLL 0 (active 0x2, on? 0) for [CRTC:185:pipe B] <7> [166.222016] i915 0000:00:02.0: [drm:intel_dpll_enable [i915]] enabling DPLL 0 <7> [166.222252] i915 0000:00:02.0: [drm:intel_power_well_enable [i915]] enabling DDI_IO_B <7> [166.222493] i915 0000:00:02.0: [drm:intel_enable_transcoder [i915]] enabling pipe B <7> [166.223262] i915 0000:00:02.0: [drm:intel_hdmi_handle_sink_scrambling [i915]] [CONNECTOR:342:HDMI-A-1] scrambling=no, TMDS bit clock ratio=1/10 <7> [166.223260] i915 0000:00:02.0: [drm:intel_audio_component_get_power [i915]] restored AUD_FREQ_CNTRL to 0x810 <7> [166.223851] i915 0000:00:02.0: [drm:do_gmbus_xfer [i915]] GMBUS [i915 gmbus dpb] NAK for addr: 0054 w(1) <7> [166.224044] i915 0000:00:02.0: [drm:do_gmbus_xfer [i915]] GMBUS [i915 gmbus dpb] NAK on first message, retry <7> [166.224487] i915 0000:00:02.0: [drm:do_gmbus_xfer [i915]] GMBUS [i915 gmbus dpb] NAK for addr: 0054 w(1) <7> [166.224651] i915 0000:00:02.0: [drm:drm_scdc_set_high_tmds_clock_ratio [drm_display_helper]] [CONNECTOR:342:HDMI-A-1] Failed to read TMDS config: -6 <7> [166.224676] i915 0000:00:02.0: [drm:intel_ddi_enable [i915]] [CONNECTOR:342:HDMI-A-1] Failed to configure sink scrambling/TMDS bit clock ratio <7> [166.229382] azx_init_pci: snd_hda_intel 0000:00:1f.3: Clearing TCSEL <7> [166.229414] azx_init_pci: snd_hda_intel 0000:00:1f.3: SCH snoop: Enabled <7> [166.241662] i915 0000:00:02.0: [drm:intel_audio_codec_enable [i915]] [CONNECTOR:342:HDMI-A-1][ENCODER:341:DDI B/PHY B] Enable audio codec on [CRTC:185:pipe B], 64 bytes ELD <7> [166.249966] i915 0000:00:02.0: [drm:audio_config_hdmi_pixel_clock [i915]] HDMI audio pixel clock setting for 285500 not found, falling back to defaults <7> [166.250159] i915 0000:00:02.0: [drm:audio_config_hdmi_pixel_clock [i915]] Configuring HDMI audio for pixel clock 25200 (0x00010000) <7> [166.250318] i915 0000:00:02.0: [drm:hsw_audio_config_update [i915]] using automatic N <6> [166.250483] snd_hda_codec_intelhdmi hdaudioC0D2: HDMI: audio coding xtype 5 not expected <6> [166.250485] snd_hda_codec_intelhdmi hdaudioC0D2: HDMI: audio coding xtype 0 not expected <6> [166.250487] snd_hda_codec_intelhdmi hdaudioC0D2: HDMI: audio coding xtype 10 not expected <6> [166.250489] snd_hda_codec_intelhdmi hdaudioC0D2: HDMI: audio coding xtype 6 not expected <7> [166.250622] i915 0000:00:02.0: [drm:verify_connector_state [i915]] [CONNECTOR:342:HDMI-A-1] <7> [166.250866] i915 0000:00:02.0: [drm:intel_modeset_verify_crtc [i915]] [CRTC:185:pipe B] <7> [166.307411] i915 0000:00:02.0: [drm:intel_audio_component_get_power [i915]] restored AUD_FREQ_CNTRL to 0x810 <7> [166.311818] azx_init_pci: snd_hda_intel 0000:00:1f.3: Clearing TCSEL <7> [166.311864] azx_init_pci: snd_hda_intel 0000:00:1f.3: SCH snoop: Enabled <6> [174.039564] [IGT] kms_flip: finished subtest B-HDMI-A1, FAIL

<7> [155.431317] i915 0000:00:02.0: [drm:drm_mode_setcrtc] [CRTC:108:pipe A]

<7> [155.431526] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:108:pipe A] fastset requirement not met in hw.enable (expected yes, found no)

<7> [155.431938] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:108:pipe A] fastset requirement not met in hw.active (expected yes, found no)

<7> [155.432378] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:108:pipe A] fastset requirement not met in cpu_transcoder (expected 0, found -1)

<7> [155.432787] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:108:pipe A] fastset requirement not met in lane_count (expected 4, found 0)

<7> [155.433184] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:108:pipe A] fastset requirement not met in output_types (expected 0x00000040, found 0x00000000)

<7> [155.433697] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:108:pipe A] fastset requirement not met in framestart_delay (expected 1, found 0)

<7> [155.434085] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:108:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hdisplay (expected 1920, found 0)

<7> [155.434494] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:108:pipe A] fastset requirement not met in hw.pipe_mode.crtc_htotal (expected 2080, found 0)

<7> [155.434831] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:108:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hblank_start (expected 1920, found 0)

<7> [155.435285] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:108:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hblank_end (expected 2080, found 0)

<7> [155.435638] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:108:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hsync_start (expected 1968, found 0)

<7> [155.435990] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:108:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hsync_end (expected 2000, found 0)

<7> [155.436349] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:108:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vdisplay (expected 1080, found 0)

<7> [155.436752] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:108:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vblank_start (expected 1080, found 0)

<7> [155.437066] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:108:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vsync_start (expected 1083, found 0)

<7> [155.437400] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:108:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vsync_end (expected 1088, found 0)

<7> [155.437681] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:108:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vtotal (expected 1144, found 0)

<7> [155.437957] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:108:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vblank_end (expected 1144, found 0)

<7> [155.438314] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:108:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hdisplay (expected 1920, found 0)

<7> [155.438634] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:108:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_htotal (expected 2080, found 0)

<7> [155.438925] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:108:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hblank_start (expected 1920, found 0)

<7> [155.439237] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:108:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hblank_end (expected 2080, found 0)

<7> [155.439520] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:108:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hsync_start (expected 1968, found 0)

<7> [155.439873] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:108:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hsync_end (expected 2000, found 0)

<7> [155.440131] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:108:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vdisplay (expected 1080, found 0)

<7> [155.440342] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:108:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vblank_start (expected 1080, found 0)

<7> [155.440542] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:108:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vsync_start (expected 1083, found 0)

<7> [155.440790] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:108:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vsync_end (expected 1088, found 0)

<7> [155.441005] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:108:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vtotal (expected 1144, found 0)

<7> [155.441236] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:108:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vblank_end (expected 1144, found 0)

<7> [155.441449] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:108:pipe A] fastset requirement not met in pixel_multiplier (expected 1, found 0)

<7> [155.441652] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:108:pipe A] fastset requirement not met in hw.adjusted_mode.flags (1) (expected 1, found 0)

<7> [155.441912] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:108:pipe A] fastset requirement not met in hw.adjusted_mode.flags (4) (expected 4, found 0)

<7> [155.442133] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:108:pipe A] fastset requirement not met in has_hdmi_sink (expected yes, found no)

<7> [155.442340] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:108:pipe A] fastset requirement not met in has_infoframe (expected yes, found no)

<7> [155.442558] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:108:pipe A] fastset requirement not met in pipe_bpp (expected 24, found 0)

<7> [155.442759] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:108:pipe A] fastset requirement not met in hw.pipe_mode.crtc_clock (expected 285500, found 0)

<7> [155.442970] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:108:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_clock (expected 285500, found 0)

<7> [155.443163] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:108:pipe A] fastset requirement not met in port_clock (expected 285500, found 0)

<7> [155.443330] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:108:pipe A] fastset requirement not met in infoframes.enable (expected 0x00000071, found 0x00000000)

<7> [155.443487] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:108:pipe A] fastset requirement not met in avi infoframe

<7> [155.443660] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] expected:

<7> [155.443819] i915 0000:00:02.0: HDMI infoframe: Auxiliary Video Information (AVI), version 2, length 13

<7> [155.443833] i915 0000:00:02.0: nups: Unknown Non-uniform Scaling

<7> [155.443840] i915 0000:00:02.0: bar top 0, bottom 0, left 0, right 0

<7> [155.443842] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] found:

<7> [155.444044] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:108:pipe A] fastset requirement not met in spd infoframe

<7> [155.444230] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] expected:

<7> [155.444394] i915 0000:00:02.0: HDMI infoframe: Source Product Description (SPD), version 1, length 25

<7> [155.444399] i915 0000:00:02.0: source device information: PC General (0x9)

<7> [155.444401] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] found:

<7> [155.444566] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:108:pipe A] fastset requirement not met in hdmi infoframe

<7> [155.444724] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] expected:

<7> [155.444879] i915 0000:00:02.0: HDMI infoframe: Vendor, version 1, length 4

<7> [155.444882] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] found:

<7> [155.445038] i915 0000:00:02.0: [drm:intel_atomic_check [i915]] [CRTC:108:pipe A] fastset requirement not met, forcing full modeset

<7> [155.445266] i915 0000:00:02.0: [drm:intel_dpll_crtc_put [i915]] [CRTC:108:pipe A] releasing DPLL 0

<7> [155.445454] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] Enabled dbuf slices 0x3 -> 0x1 (total dbuf slices 0x3), mbus joined? no->no

<7> [155.445612] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] [CRTC:108:pipe A] dbuf slices 0x3 -> 0x0, ddb (0 - 2048) -> (0 - 0), active pipes 0x1 -> 0x0

<7> [155.445805] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] [PLANE:103:cursor A] ddb (1993 - 2048) -> ( 0 - 0), size 55 -> 0

<7> [155.445999] i915 0000:00:02.0: [drm:intel_cdclk_atomic_check [i915]] [CRTC:108:pipe A] min cdclk: 192000 kHz -> 0 kHz

<7> [155.446203] i915 0000:00:02.0: [drm:intel_cdclk_atomic_check [i915]] Modeset required for cdclk change

<7> [155.446363] i915 0000:00:02.0: [drm:intel_cdclk_atomic_check [i915]] New cdclk calculated to be logical 172800 kHz, actual 172800 kHz

<7> [155.446522] i915 0000:00:02.0: [drm:intel_cdclk_atomic_check [i915]] New voltage level calculated to be logical 0, actual 0

<7> [155.446682] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [CRTC:108:pipe A] enable: no [modeset]

<7> [155.446844] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:33:plane 1A] fb: [NOFB], visible: no

<7> [155.447003] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:43:plane 2A] fb: [NOFB], visible: no

<7> [155.447180] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:53:plane 3A] fb: [NOFB], visible: no

<7> [155.447337] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:63:plane 4A] fb: [NOFB], visible: no

<7> [155.447494] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:73:plane 5A] fb: [NOFB], visible: no

<7> [155.447651] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:83:plane 6A] fb: [NOFB], visible: no

<7> [155.447806] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:93:plane 7A] fb: [NOFB], visible: no

<7> [155.447962] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:103:cursor A] fb: [NOFB], visible: no

<7> [155.448211] i915 0000:00:02.0: [drm:intel_audio_codec_disable [i915]] [CONNECTOR:342:HDMI-A-1][ENCODER:341:DDI B/PHY B] Disable audio codec on [CRTC:108:pipe A]

<7> [155.463258] i915 0000:00:02.0: [drm:intel_audio_component_get_eld [i915]] Not valid for port B

<7> [155.465110] i915 0000:00:02.0: [drm:intel_hdmi_handle_sink_scrambling [i915]] [CONNECTOR:342:HDMI-A-1] scrambling=no, TMDS bit clock ratio=1/10

<7> [155.465741] i915 0000:00:02.0: [drm:do_gmbus_xfer [i915]] GMBUS [i915 gmbus dpb] NAK for addr: 0054 w(1)

<7> [155.465893] i915 0000:00:02.0: [drm:do_gmbus_xfer [i915]] GMBUS [i915 gmbus dpb] NAK on first message, retry

<7> [155.466490] i915 0000:00:02.0: [drm:do_gmbus_xfer [i915]] GMBUS [i915 gmbus dpb] NAK for addr: 0054 w(1)

<7> [155.466693] i915 0000:00:02.0: [drm:drm_scdc_set_high_tmds_clock_ratio [drm_display_helper]] [CONNECTOR:342:HDMI-A-1] Failed to read TMDS config: -6

<7> [155.466708] i915 0000:00:02.0: [drm:intel_ddi_disable [i915]] [CONNECTOR:342:HDMI-A-1] Failed to reset sink scrambling/TMDS bit clock ratio

<7> [155.466889] i915 0000:00:02.0: [drm:intel_disable_transcoder [i915]] disabling pipe A

<7> [155.472129] i915 0000:00:02.0: [drm:intel_power_well_disable [i915]] disabling DDI_IO_B

<7> [155.472327] i915 0000:00:02.0: [drm:intel_dpll_disable [i915]] disable DPLL 0 (active 0x1, on? 1) for [CRTC:108:pipe A]

<7> [155.472521] i915 0000:00:02.0: [drm:intel_dpll_disable [i915]] disabling DPLL 0

<7> [155.472710] i915 0000:00:02.0: [drm:intel_set_cdclk [i915]] Pre changing CDCLK to 172800 kHz, VCO 345600 kHz, ref 38400 kHz, bypass 19200 kHz, voltage level 0

<7> [155.473046] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:341:DDI B/PHY B]

<7> [155.473308] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:351:DDI TC1/PHY TC1]

<7> [155.473519] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:353:DP-MST A]

<7> [155.473740] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:354:DP-MST B]

<7> [155.473995] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:355:DP-MST C]

<7> [155.474230] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:356:DP-MST D]

<7> [155.474448] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:361:DDI TC2/PHY TC2]

<7> [155.474651] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:363:DP-MST A]

<7> [155.474876] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:364:DP-MST B]

<7> [155.475126] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:365:DP-MST C]

<7> [155.475341] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:366:DP-MST D]

<7> [155.475560] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:370:DDI TC3/PHY TC3]

<7> [155.475768] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:372:DP-MST A]

<7> [155.476005] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:373:DP-MST B]

<7> [155.476240] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:374:DP-MST C]

<7> [155.476432] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:375:DP-MST D]

<7> [155.476629] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:379:DDI TC4/PHY TC4]

<7> [155.476820] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:381:DP-MST A]

<7> [155.477006] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:382:DP-MST B]

<7> [155.477245] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:383:DP-MST C]

<7> [155.477459] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:384:DP-MST D]

<7> [155.477652] i915 0000:00:02.0: [drm:verify_connector_state [i915]] [CONNECTOR:342:HDMI-A-1]

<7> [155.478023] i915 0000:00:02.0: [drm:gen9_dbuf_slices_update [i915]] Updating dbuf slices to 0x1

<7> [155.478313] i915 0000:00:02.0: [drm:intel_power_well_disable [i915]] disabling PW_3

<7> [155.478559] i915 0000:00:02.0: [drm:intel_power_well_disable [i915]] disabling PW_2

<7> [155.478786] i915 0000:00:02.0: [drm:intel_modeset_verify_crtc [i915]] [CRTC:108:pipe A]

<7> [155.479428] i915 0000:00:02.0: [drm:drm_mode_setcrtc] [CRTC:185:pipe B]

<7> [155.479585] i915 0000:00:02.0: [drm:drm_mode_setcrtc] [CRTC:262:pipe C]

<7> [155.479728] i915 0000:00:02.0: [drm:drm_mode_setcrtc] [CRTC:339:pipe D]

<7> [155.479860] i915 0000:00:02.0: [drm:drm_mode_setcrtc] [CRTC:185:pipe B]

<7> [155.479896] i915 0000:00:02.0: [drm:drm_mode_setcrtc] [CONNECTOR:342:HDMI-A-1]

<7> [155.479968] i915 0000:00:02.0: [drm:intel_atomic_check [i915]] [CONNECTOR:342:HDMI-A-1] Limiting display bpp to 24 (EDID bpp 24, max requested bpp 36, max platform bpp 36)

<7> [155.480158] i915 0000:00:02.0: [drm:intel_hdmi_compute_clock [i915]] picking 8 bpc for HDMI output (pipe bpp: 24)

<7> [155.480335] i915 0000:00:02.0: [drm:intel_atomic_check [i915]] [CRTC:185:pipe B] hw max bpp: 24, pipe bpp: 24, dithering: 0

<7> [155.480530] i915 0000:00:02.0: [drm:intel_ddi_compute_config_late [i915]] [ENCODER:341:DDI B/PHY B] [CRTC:185:pipe B]

<7> [155.480690] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:185:pipe B] fastset requirement not met in hw.enable (expected no, found yes)

<7> [155.480856] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:185:pipe B] fastset requirement not met in hw.active (expected no, found yes)

<7> [155.481023] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:185:pipe B] fastset requirement not met in cpu_transcoder (expected -1, found 1)

<7> [155.481205] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:185:pipe B] fastset requirement not met in lane_count (expected 0, found 4)

<7> [155.481402] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:185:pipe B] fastset requirement not met in output_types (expected 0x00000000, found 0x00000040)

<7> [155.481573] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:185:pipe B] fastset requirement not met in framestart_delay (expected 0, found 1)

<7> [155.481742] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:185:pipe B] fastset requirement not met in hw.pipe_mode.crtc_hdisplay (expected 0, found 1920)

<7> [155.481900] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:185:pipe B] fastset requirement not met in hw.pipe_mode.crtc_htotal (expected 0, found 2080)

<7> [155.482067] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:185:pipe B] fastset requirement not met in hw.pipe_mode.crtc_hblank_start (expected 0, found 1920)

<7> [155.482252] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:185:pipe B] fastset requirement not met in hw.pipe_mode.crtc_hblank_end (expected 0, found 2080)

<7> [155.482422] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:185:pipe B] fastset requirement not met in hw.pipe_mode.crtc_hsync_start (expected 0, found 1968)

<7> [155.482626] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:185:pipe B] fastset requirement not met in hw.pipe_mode.crtc_hsync_end (expected 0, found 2000)

<7> [155.482783] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:185:pipe B] fastset requirement not met in hw.pipe_mode.crtc_vdisplay (expected 0, found 1080)

<7> [155.482953] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:185:pipe B] fastset requirement not met in hw.pipe_mode.crtc_vblank_start (expected 0, found 1080)

<7> [155.483127] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:185:pipe B] fastset requirement not met in hw.pipe_mode.crtc_vsync_start (expected 0, found 1083)

<7> [155.483285] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:185:pipe B] fastset requirement not met in hw.pipe_mode.crtc_vsync_end (expected 0, found 1088)

<7> [155.483441] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:185:pipe B] fastset requirement not met in hw.pipe_mode.crtc_vtotal (expected 0, found 1144)

<7> [155.483647] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:185:pipe B] fastset requirement not met in hw.pipe_mode.crtc_vblank_end (expected 0, found 1144)

<7> [155.483810] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:185:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_hdisplay (expected 0, found 1920)

<7> [155.483979] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:185:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_htotal (expected 0, found 2080)

<7> [155.484156] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:185:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_hblank_start (expected 0, found 1920)

<7> [155.484315] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:185:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_hblank_end (expected 0, found 2080)

<7> [155.484483] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:185:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_hsync_start (expected 0, found 1968)

<7> [155.484678] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:185:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_hsync_end (expected 0, found 2000)

<7> [155.484836] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:185:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_vdisplay (expected 0, found 1080)

<7> [155.485002] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:185:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_vblank_start (expected 0, found 1080)

<7> [155.485183] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:185:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_vsync_start (expected 0, found 1083)

<7> [155.485344] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:185:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_vsync_end (expected 0, found 1088)

<7> [155.485503] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:185:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_vtotal (expected 0, found 1144)

<7> [155.485703] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:185:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_vblank_end (expected 0, found 1144)

<7> [155.485871] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:185:pipe B] fastset requirement not met in pixel_multiplier (expected 0, found 1)

<7> [155.486038] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:185:pipe B] fastset requirement not met in hw.adjusted_mode.flags (1) (expected 0, found 1)

<7> [155.486208] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:185:pipe B] fastset requirement not met in hw.adjusted_mode.flags (4) (expected 0, found 4)

<7> [155.486374] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:185:pipe B] fastset requirement not met in has_hdmi_sink (expected no, found yes)

<7> [155.486530] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:185:pipe B] fastset requirement not met in has_infoframe (expected no, found yes)

<7> [155.486730] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:185:pipe B] fastset requirement not met in dpll_hw_state

<7> [155.486887] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] expected:

<7> [155.487053] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] dpll_hw_state: cfgcr0: 0x0, cfgcr1: 0x0, 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> [155.487253] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] found:

<7> [155.487414] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] dpll_hw_state: cfgcr0: 0x1801be, cfgcr1: 0x488, 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> [155.487573] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:185:pipe B] fastset requirement not met in pipe_bpp (expected 0, found 24)

<7> [155.487775] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:185:pipe B] fastset requirement not met in hw.pipe_mode.crtc_clock (expected 0, found 285500)

<7> [155.487933] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:185:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_clock (expected 0, found 285500)

<7> [155.488108] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:185:pipe B] fastset requirement not met in port_clock (expected 0, found 285500)

<7> [155.488278] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:185:pipe B] fastset requirement not met in infoframes.enable (expected 0x00000000, found 0x00000071)

<7> [155.488437] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:185:pipe B] fastset requirement not met in avi infoframe

<7> [155.488596] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] expected:

<7> [155.488802] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] found:

<7> [155.488961] i915 0000:00:02.0: HDMI infoframe: Auxiliary Video Information (AVI), version 2, length 13

<7> [155.488975] i915 0000:00:02.0: nups: Unknown Non-uniform Scaling

<7> [155.488982] i915 0000:00:02.0: bar top 0, bottom 0, left 0, right 0

<7> [155.488984] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:185:pipe B] fastset requirement not met in spd infoframe

<7> [155.489163] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] expected:

<7> [155.489334] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] found:

<7> [155.489491] i915 0000:00:02.0: HDMI infoframe: Source Product Description (SPD), version 1, length 25

<7> [155.489497] i915 0000:00:02.0: source device information: PC General (0x9)

<7> [155.489499] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:185:pipe B] fastset requirement not met in hdmi infoframe

<7> [155.489655] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] expected:

<7> [155.489815] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] found:

<7> [155.490016] i915 0000:00:02.0: HDMI infoframe: Vendor, version 1, length 4

<7> [155.490020] i915 0000:00:02.0: [drm:intel_atomic_check [i915]] [CRTC:185:pipe B] fastset requirement not met, forcing full modeset

<7> [155.490229] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] Enabled dbuf slices 0x1 -> 0x3 (total dbuf slices 0x3), mbus joined? no->no

<7> [155.490389] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] [CRTC:185:pipe B] dbuf slices 0x0 -> 0x3, ddb (0 - 0) -> (0 - 2048), active pipes 0x0 -> 0x2

<7> [155.490593] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] [PLANE:110:plane 1B] ddb ( 0 - 0) -> ( 0 - 1993), size 0 -> 1993

<7> [155.490748] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] [PLANE:180:cursor B] ddb ( 0 - 0) -> (1993 - 2048), size 0 -> 55

<7> [155.490934] i915 0000:00:02.0: [drm:skl_print_plane_changes [i915]] [PLANE:110: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> [155.491183] i915 0000:00:02.0: [drm:skl_print_plane_changes [i915]] [PLANE:110:plane 1B] lines 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0 -> 1, 8, 8, 8, 8, 11, 16, 16, 0, 0, 0

<7> [155.491348] i915 0000:00:02.0: [drm:skl_print_plane_changes [i915]] [PLANE:110:plane 1B] blocks 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0 -> 16, 129, 129, 129, 129, 177, 257, 257, 30, 0, 0

<7> [155.491510] i915 0000:00:02.0: [drm:skl_print_plane_changes [i915]] [PLANE:110:plane 1B] min_ddb 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0 -> 19, 143, 143, 143, 143, 196, 284, 284, 31, 0, 0

<7> [155.491702] i915 0000:00:02.0: [drm:intel_bw_atomic_check [i915]] [CRTC:185:pipe B] data rate 1142000 num active planes 1

<7> [155.491878] i915 0000:00:02.0: [drm:intel_bw_atomic_check [i915]] QGV point 0: max bw 14993 required 1142

<7> [155.492071] i915 0000:00:02.0: [drm:intel_bw_atomic_check [i915]] No SAGV, using single QGV point mask 0x1

<7> [155.492270] i915 0000:00:02.0: [drm:intel_cdclk_atomic_check [i915]] [CRTC:185:pipe B] min cdclk: 0 kHz -> 192000 kHz

<7> [155.492463] i915 0000:00:02.0: [drm:intel_cdclk_atomic_check [i915]] Modeset required for cdclk change

<7> [155.492628] i915 0000:00:02.0: [drm:intel_cdclk_atomic_check [i915]] New cdclk calculated to be logical 192000 kHz, actual 192000 kHz

<7> [155.492785] i915 0000:00:02.0: [drm:intel_cdclk_atomic_check [i915]] New voltage level calculated to be logical 0, actual 0

<7> [155.492990] i915 0000:00:02.0: [drm:intel_find_dpll [i915]] [CRTC:185:pipe B] allocated DPLL 0

<7> [155.493168] i915 0000:00:02.0: [drm:intel_dpll_crtc_get [i915]] [CRTC:185:pipe B] reserving DPLL 0

<7> [155.493343] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [CRTC:185:pipe B] enable: yes [modeset]

<7> [155.493516] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] active: yes, output_types: HDMI (0x40), output format: RGB, sink format: RGB

<7> [155.493675] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] cpu_transcoder: B, pipe bpp: 24, dithering: 0

<7> [155.493834] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] MST master transcoder: <invalid>

<7> [155.494036] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] port sync: master transcoder: <invalid>, slave transcoder bitmask = 0x0

<7> [155.494213] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] joiner: no, pipes: 0x0

<7> [155.494377] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] splitter: disabled, link count 0, overlap 0

<7> [155.494539] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] audio: 1, infoframes: 1, infoframes enabled: 0x71

<7> [155.494701] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] GCP: 0x0

<7> [155.494856] i915 0000:00:02.0: HDMI infoframe: Auxiliary Video Information (AVI), version 2, length 13

<7> [155.494869] i915 0000:00:02.0: nups: Unknown Non-uniform Scaling

<7> [155.494876] i915 0000:00:02.0: bar top 0, bottom 0, left 0, right 0

<7> [155.494879] i915 0000:00:02.0: HDMI infoframe: Source Product Description (SPD), version 1, length 25

<7> [155.494886] i915 0000:00:02.0: source device information: PC General (0x9)

<7> [155.494889] i915 0000:00:02.0: HDMI infoframe: Vendor, version 1, length 4

<7> [155.494894] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] ELD: 10 00 0f 00 6d a2 00 7f 00 00 00 00 00 00 00 00

<7> [155.495098] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] ELD: 0d 82 34 12 66 69 74 48 65 61 64 6c 65 73 73 47

<7> [155.495255] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] ELD: 53 7f 7f 28 0f 7f 07 17 7f ff 3f 7f ff 47 7f ff

<7> [155.495423] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] ELD: 5f 7f 82 7f 7f 00 7f 7f 51 7f 7f 30 77 7f 03 00

<7> [155.495591] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] scanline offset: 2

<7> [155.495753] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] vblank delay: 0, framestart delay: 1, MSA timing delay: 0 set context latency: 0

<7> [155.495912] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] vrr: no, fixed rr: yes, vmin: 1144, vmax: 1144, flipline: 1144, pipeline full: 61, guardband: 63 vsync start: 0, vsync end: 0

<7> [155.496070] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] vrr: vmin vblank: 1081, vmax vblank: 1081, vmin vtotal: 1144, vmax vtotal: 1144

<7> [155.496261] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] requested mode: "1920x1080": 120 285500 1920 1968 2000 2080 1080 1083 1088 1144 0x48 0x5

<7> [155.496453] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] adjusted mode: "1920x1080": 120 285500 1920 1968 2000 2080 1080 1083 1088 1144 0x48 0x5

<7> [155.496612] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] crtc timings: clock=285500, hd=1920 hb=1920-2080 hs=1968-2000 ht=2080, vd=1080 vb=1080-1144 vs=1083-1088 vt=1144, flags=0x5

<7> [155.496776] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pipe mode: "1920x1080": 120 285500 1920 1968 2000 2080 1080 1083 1088 1144 0x40 0x5

<7> [155.496942] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] crtc timings: clock=285500, hd=1920 hb=1920-2080 hs=1968-2000 ht=2080, vd=1080 vb=1080-1144 vs=1083-1088 vt=1144, flags=0x5

<7> [155.497110] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] port clock: 285500, pipe src: 1920x1080+0+0, pixel rate 285500

<7> [155.497284] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] linetime: 59, ips linetime: 0

<7> [155.497485] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] num_scalers: 2, scaler_users: 0x0, scaler_id: -1, scaling_filter: 0

<7> [155.497640] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pch pfit: 0x0+0+0, disabled, force thru: no

<7> [155.497804] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] ips: 0, double wide: 0, drrs: 0

<7> [155.497965] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] dpll_hw_state: cfgcr0: 0x1801be, cfgcr1: 0x488, 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> [155.498135] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] csc_mode: 0x0 gamma_mode: 0x0 gamma_enable: 0 csc_enable: 0

<7> [155.498290] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pre csc lut: 0 entries, post csc lut: 0 entries

<7> [155.498489] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] output csc: pre offsets: 0x0000 0x0000 0x0000

<7> [155.498645] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] output csc: coefficients: 0x0000 0x0000 0x0000

<7> [155.498808] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] output csc: coefficients: 0x0000 0x0000 0x0000

<7> [155.498966] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] output csc: coefficients: 0x0000 0x0000 0x0000

<7> [155.499142] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] output csc: post offsets: 0x0000 0x0000 0x0000

<7> [155.499301] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pipe csc: pre offsets: 0x0000 0x0000 0x0000

<7> [155.499460] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pipe csc: coefficients: 0x0000 0x0000 0x0000

<7> [155.499669] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pipe csc: coefficients: 0x0000 0x0000 0x0000

<7> [155.499829] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pipe csc: coefficients: 0x0000 0x0000 0x0000

<7> [155.499997] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pipe csc: post offsets: 0x0000 0x0000 0x0000

<7> [155.500195] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:110:plane 1B] fb: [FB:391] 1920x1080 format = XR24 little-endian (0x34325258) modifier = 0x100000000000001, visible: yes

<7> [155.500363] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] rotation: 0x1, scaler: -1, scaling_filter: 0

<7> [155.500522] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] src: 1920.000000x1080.000000+0.000000+0.000000 dst: 1920x1080+0+0

<7> [155.500727] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:120:plane 2B] fb: [NOFB], visible: no

<7> [155.500885] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:130:plane 3B] fb: [NOFB], visible: no

<7> [155.501051] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:140:plane 4B] fb: [NOFB], visible: no

<7> [155.501227] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:150:plane 5B] fb: [NOFB], visible: no

<7> [155.501383] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:160:plane 6B] fb: [NOFB], visible: no

<7> [155.501537] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:170:plane 7B] fb: [NOFB], visible: no

<7> [155.501736] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:180:cursor B] fb: [NOFB], visible: no

<7> [155.502487] i915 0000:00:02.0: [drm:intel_power_well_enable [i915]] enabling PW_2

<7> [155.502705] i915 0000:00:02.0: [drm:intel_power_well_enable [i915]] enabling PW_3

<7> [155.502905] i915 0000:00:02.0: [drm:intel_set_cdclk [i915]] Pre changing CDCLK to 192000 kHz, VCO 384000 kHz, ref 38400 kHz, bypass 19200 kHz, voltage level 0

<7> [155.503201] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:341:DDI B/PHY B]

<7> [155.503363] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:351:DDI TC1/PHY TC1]

<7> [155.503545] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:353:DP-MST A]

<7> [155.503728] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:354:DP-MST B]

<7> [155.503892] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:355:DP-MST C]

<7> [155.504050] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:356:DP-MST D]

<7> [155.504247] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:361:DDI TC2/PHY TC2]

<7> [155.504406] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:363:DP-MST A]

<7> [155.504562] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:364:DP-MST B]

<7> [155.504746] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:365:DP-MST C]

<7> [155.504928] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:366:DP-MST D]

<7> [155.505100] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:370:DDI TC3/PHY TC3]

<7> [155.505259] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:372:DP-MST A]

<7> [155.505425] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:373:DP-MST B]

<7> [155.505581] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:374:DP-MST C]

<7> [155.505767] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:375:DP-MST D]

<7> [155.505940] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:379:DDI TC4/PHY TC4]

<7> [155.506114] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:381:DP-MST A]

<7> [155.506270] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:382:DP-MST B]

<7> [155.506434] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:383:DP-MST C]

<7> [155.506557] i915 0000:00:02.0: [drm:intel_audio_component_get_power [i915]] restored AUD_FREQ_CNTRL to 0x810

<7> [155.506588] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:384:DP-MST D]

<7> [155.506910] i915 0000:00:02.0: [drm:gen9_dbuf_slices_update [i915]] Updating dbuf slices to 0x3

<7> [155.507129] i915 0000:00:02.0: [drm:intel_dpll_enable [i915]] enable DPLL 0 (active 0x2, on? 0) for [CRTC:185:pipe B]

<7> [155.507304] i915 0000:00:02.0: [drm:intel_dpll_enable [i915]] enabling DPLL 0

<7> [155.507532] i915 0000:00:02.0: [drm:intel_power_well_enable [i915]] enabling DDI_IO_B

<7> [155.507814] i915 0000:00:02.0: [drm:intel_enable_transcoder [i915]] enabling pipe B

<7> [155.508541] i915 0000:00:02.0: [drm:intel_hdmi_handle_sink_scrambling [i915]] [CONNECTOR:342:HDMI-A-1] scrambling=no, TMDS bit clock ratio=1/10

<7> [155.509232] i915 0000:00:02.0: [drm:do_gmbus_xfer [i915]] GMBUS [i915 gmbus dpb] NAK for addr: 0054 w(1)

<7> [155.509397] i915 0000:00:02.0: [drm:do_gmbus_xfer [i915]] GMBUS [i915 gmbus dpb] NAK on first message, retry

<7> [155.510013] i915 0000:00:02.0: [drm:do_gmbus_xfer [i915]] GMBUS [i915 gmbus dpb] NAK for addr: 0054 w(1)

<7> [155.510217] i915 0000:00:02.0: [drm:drm_scdc_set_high_tmds_clock_ratio [drm_display_helper]] [CONNECTOR:342:HDMI-A-1] Failed to read TMDS config: -6

<7> [155.510231] i915 0000:00:02.0: [drm:intel_ddi_enable [i915]] [CONNECTOR:342:HDMI-A-1] Failed to configure sink scrambling/TMDS bit clock ratio

<7> [155.511136] azx_init_pci: snd_hda_intel 0000:00:1f.3: Clearing TCSEL

<7> [155.511174] azx_init_pci: snd_hda_intel 0000:00:1f.3: SCH snoop: Enabled

<7> [155.527246] i915 0000:00:02.0: [drm:intel_audio_codec_enable [i915]] [CONNECTOR:342:HDMI-A-1][ENCODER:341:DDI B/PHY B] Enable audio codec on [CRTC:185:pipe B], 64 bytes ELD

<7> [155.535524] i915 0000:00:02.0: [drm:audio_config_hdmi_pixel_clock [i915]] HDMI audio pixel clock setting for 285500 not found, falling back to defaults

<7> [155.535712] i915 0000:00:02.0: [drm:audio_config_hdmi_pixel_clock [i915]] Configuring HDMI audio for pixel clock 25200 (0x00010000)

<7> [155.535873] i915 0000:00:02.0: [drm:hsw_audio_config_update [i915]] using automatic N

<6> [155.536038] snd_hda_codec_intelhdmi hdaudioC0D2: HDMI: audio coding xtype 5 not expected

<6> [155.536040] snd_hda_codec_intelhdmi hdaudioC0D2: HDMI: audio coding xtype 0 not expected

<6> [155.536042] snd_hda_codec_intelhdmi hdaudioC0D2: HDMI: audio coding xtype 10 not expected

<6> [155.536043] snd_hda_codec_intelhdmi hdaudioC0D2: HDMI: audio coding xtype 6 not expected

<7> [155.536191] i915 0000:00:02.0: [drm:verify_connector_state [i915]] [CONNECTOR:342:HDMI-A-1]

<7> [155.536441] i915 0000:00:02.0: [drm:intel_modeset_verify_crtc [i915]] [CRTC:185:pipe B]

<7> [155.592261] i915 0000:00:02.0: [drm:intel_audio_component_get_power [i915]] restored AUD_FREQ_CNTRL to 0x810

<7> [155.596660] azx_init_pci: snd_hda_intel 0000:00:1f.3: Clearing TCSEL

<7> [155.596692] azx_init_pci: snd_hda_intel 0000:00:1f.3: SCH snoop: Enabled

<7> [166.148167] i915 0000:00:02.0: [drm:drm_mode_setcrtc] [CRTC:108:pipe A]

<7> [166.148814] i915 0000:00:02.0: [drm:drm_mode_setcrtc] [CRTC:185:pipe B]

<7> [166.149033] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:185:pipe B] fastset requirement not met in hw.enable (expected yes, found no)

<7> [166.149604] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:185:pipe B] fastset requirement not met in hw.active (expected yes, found no)

<7> [166.150123] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:185:pipe B] fastset requirement not met in cpu_transcoder (expected 1, found -1)

<7> [166.150680] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:185:pipe B] fastset requirement not met in lane_count (expected 4, found 0)

<7> [166.151149] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:185:pipe B] fastset requirement not met in output_types (expected 0x00000040, found 0x00000000)

<7> [166.151662] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:185:pipe B] fastset requirement not met in framestart_delay (expected 1, found 0)

<7> [166.152137] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:185:pipe B] fastset requirement not met in hw.pipe_mode.crtc_hdisplay (expected 1920, found 0)

<7> [166.152653] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:185:pipe B] fastset requirement not met in hw.pipe_mode.crtc_htotal (expected 2080, found 0)

<7> [166.152915] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:185:pipe B] fastset requirement not met in hw.pipe_mode.crtc_hblank_start (expected 1920, found 0)

<7> [166.153073] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:185:pipe B] fastset requirement not met in hw.pipe_mode.crtc_hblank_end (expected 2080, found 0)

<7> [166.153243] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:185:pipe B] fastset requirement not met in hw.pipe_mode.crtc_hsync_start (expected 1968, found 0)

<7> [166.153400] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:185:pipe B] fastset requirement not met in hw.pipe_mode.crtc_hsync_end (expected 2000, found 0)

<7> [166.153556] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:185:pipe B] fastset requirement not met in hw.pipe_mode.crtc_vdisplay (expected 1080, found 0)

<7> [166.153713] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:185:pipe B] fastset requirement not met in hw.pipe_mode.crtc_vblank_start (expected 1080, found 0)

<7> [166.153873] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:185:pipe B] fastset requirement not met in hw.pipe_mode.crtc_vsync_start (expected 1083, found 0)

<7> [166.154034] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:185:pipe B] fastset requirement not met in hw.pipe_mode.crtc_vsync_end (expected 1088, found 0)

<7> [166.154202] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:185:pipe B] fastset requirement not met in hw.pipe_mode.crtc_vtotal (expected 1144, found 0)

<7> [166.154365] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:185:pipe B] fastset requirement not met in hw.pipe_mode.crtc_vblank_end (expected 1144, found 0)

<7> [166.154522] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:185:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_hdisplay (expected 1920, found 0)

<7> [166.154679] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:185:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_htotal (expected 2080, found 0)

<7> [166.154835] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:185:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_hblank_start (expected 1920, found 0)

<7> [166.154991] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:185:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_hblank_end (expected 2080, found 0)

<7> [166.155146] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:185:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_hsync_start (expected 1968, found 0)

<7> [166.155317] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:185:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_hsync_end (expected 2000, found 0)

<7> [166.155475] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:185:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_vdisplay (expected 1080, found 0)

<7> [166.155637] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:185:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_vblank_start (expected 1080, found 0)

<7> [166.155797] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:185:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_vsync_start (expected 1083, found 0)

<7> [166.155955] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:185:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_vsync_end (expected 1088, found 0)

<7> [166.156113] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:185:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_vtotal (expected 1144, found 0)

<7> [166.156286] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:185:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_vblank_end (expected 1144, found 0)

<7> [166.156447] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:185:pipe B] fastset requirement not met in pixel_multiplier (expected 1, found 0)

<7> [166.156606] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:185:pipe B] fastset requirement not met in hw.adjusted_mode.flags (1) (expected 1, found 0)

<7> [166.156763] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:185:pipe B] fastset requirement not met in hw.adjusted_mode.flags (4) (expected 4, found 0)

<7> [166.156920] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:185:pipe B] fastset requirement not met in has_hdmi_sink (expected yes, found no)

<7> [166.157076] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:185:pipe B] fastset requirement not met in has_infoframe (expected yes, found no)

<7> [166.157251] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:185:pipe B] fastset requirement not met in pipe_bpp (expected 24, found 0)

<7> [166.157411] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:185:pipe B] fastset requirement not met in hw.pipe_mode.crtc_clock (expected 285500, found 0)

<7> [166.157570] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:185:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_clock (expected 285500, found 0)

<7> [166.157727] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:185:pipe B] fastset requirement not met in port_clock (expected 285500, found 0)

<7> [166.157885] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:185:pipe B] fastset requirement not met in infoframes.enable (expected 0x00000071, found 0x00000000)

<7> [166.158042] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:185:pipe B] fastset requirement not met in avi infoframe

<7> [166.158212] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] expected:

<7> [166.158380] i915 0000:00:02.0: HDMI infoframe: Auxiliary Video Information (AVI), version 2, length 13

<7> [166.158394] i915 0000:00:02.0: nups: Unknown Non-uniform Scaling

<7> [166.158401] i915 0000:00:02.0: bar top 0, bottom 0, left 0, right 0

<7> [166.158402] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] found:

<7> [166.158558] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:185:pipe B] fastset requirement not met in spd infoframe

<7> [166.158715] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] expected:

<7> [166.158870] i915 0000:00:02.0: HDMI infoframe: Source Product Description (SPD), version 1, length 25

<7> [166.158875] i915 0000:00:02.0: source device information: PC General (0x9)

<7> [166.158876] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] found:

<7> [166.159031] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:185:pipe B] fastset requirement not met in hdmi infoframe

<7> [166.159198] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] expected:

<7> [166.159353] i915 0000:00:02.0: HDMI infoframe: Vendor, version 1, length 4

<7> [166.159356] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] found:

<7> [166.159513] i915 0000:00:02.0: [drm:intel_atomic_check [i915]] [CRTC:185:pipe B] fastset requirement not met, forcing full modeset

<7> [166.159670] i915 0000:00:02.0: [drm:intel_dpll_crtc_put [i915]] [CRTC:185:pipe B] releasing DPLL 0

<7> [166.159851] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] Enabled dbuf slices 0x3 -> 0x1 (total dbuf slices 0x3), mbus joined? no->no

<7> [166.160007] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] [CRTC:185:pipe B] dbuf slices 0x3 -> 0x0, ddb (0 - 2048) -> (0 - 0), active pipes 0x2 -> 0x0

<7> [166.160205] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] [PLANE:110:plane 1B] ddb ( 0 - 1993) -> ( 0 - 0), size 1993 -> 0

<7> [166.160360] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] [PLANE:180:cursor B] ddb (1993 - 2048) -> ( 0 - 0), size 55 -> 0

<7> [166.160518] i915 0000:00:02.0: [drm:skl_print_plane_changes [i915]] [PLANE:110: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> [166.160674] i915 0000:00:02.0: [drm:skl_print_plane_changes [i915]] [PLANE:110:plane 1B] lines 1, 8, 8, 8, 8, 11, 16, 16, 0, 0, 0 -> 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0

<7> [166.160829] i915 0000:00:02.0: [drm:skl_print_plane_changes [i915]] [PLANE:110:plane 1B] blocks 16, 129, 129, 129, 129, 177, 257, 257, 30, 0, 0 -> 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0

<7> [166.160982] i915 0000:00:02.0: [drm:skl_print_plane_changes [i915]] [PLANE:110:plane 1B] min_ddb 19, 143, 143, 143, 143, 196, 284, 284, 31, 0, 0 -> 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0

<7> [166.161166] i915 0000:00:02.0: [drm:intel_bw_atomic_check [i915]] [CRTC:185:pipe B] data rate 0 num active planes 0

<7> [166.161327] i915 0000:00:02.0: [drm:intel_bw_atomic_check [i915]] QGV point 0: max bw 14993 required 0

<7> [166.161503] i915 0000:00:02.0: [drm:intel_cdclk_atomic_check [i915]] [CRTC:185:pipe B] min cdclk: 192000 kHz -> 0 kHz

<7> [166.161665] i915 0000:00:02.0: [drm:intel_cdclk_update_bw_min_cdclk [i915]] bandwidth min cdclk: 17844 kHz -> 0 kHz

<7> [166.161851] i915 0000:00:02.0: [drm:intel_cdclk_atomic_check [i915]] Modeset required for cdclk change

<7> [166.162010] i915 0000:00:02.0: [drm:intel_cdclk_atomic_check [i915]] New cdclk calculated to be logical 172800 kHz, actual 172800 kHz

<7> [166.162181] i915 0000:00:02.0: [drm:intel_cdclk_atomic_check [i915]] New voltage level calculated to be logical 0, actual 0

<7> [166.162341] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [CRTC:185:pipe B] enable: no [modeset]

<7> [166.162504] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:110:plane 1B] fb: [NOFB], visible: no

<7> [166.162664] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:120:plane 2B] fb: [NOFB], visible: no

<7> [166.162822] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:130:plane 3B] fb: [NOFB], visible: no

<7> [166.162979] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:140:plane 4B] fb: [NOFB], visible: no

<7> [166.163148] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:150:plane 5B] fb: [NOFB], visible: no

<7> [166.163304] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:160:plane 6B] fb: [NOFB], visible: no

<7> [166.163459] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:170:plane 7B] fb: [NOFB], visible: no

<7> [166.163615] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:180:cursor B] fb: [NOFB], visible: no

<7> [166.163848] i915 0000:00:02.0: [drm:intel_audio_codec_disable [i915]] [CONNECTOR:342:HDMI-A-1][ENCODER:341:DDI B/PHY B] Disable audio codec on [CRTC:185:pipe B]

<7> [166.178825] i915 0000:00:02.0: [drm:intel_audio_component_get_eld [i915]] Not valid for port B

<7> [166.180628] i915 0000:00:02.0: [drm:intel_hdmi_handle_sink_scrambling [i915]] [CONNECTOR:342:HDMI-A-1] scrambling=no, TMDS bit clock ratio=1/10

<7> [166.181158] i915 0000:00:02.0: [drm:do_gmbus_xfer [i915]] GMBUS [i915 gmbus dpb] NAK for addr: 0054 w(1)

<7> [166.181309] i915 0000:00:02.0: [drm:do_gmbus_xfer [i915]] GMBUS [i915 gmbus dpb] NAK on first message, retry

<7> [166.181824] i915 0000:00:02.0: [drm:do_gmbus_xfer [i915]] GMBUS [i915 gmbus dpb] NAK for addr: 0054 w(1)

<7> [166.181979] i915 0000:00:02.0: [drm:drm_scdc_set_high_tmds_clock_ratio [drm_display_helper]] [CONNECTOR:342:HDMI-A-1] Failed to read TMDS config: -6

<7> [166.181994] i915 0000:00:02.0: [drm:intel_ddi_disable [i915]] [CONNECTOR:342:HDMI-A-1] Failed to reset sink scrambling/TMDS bit clock ratio

<7> [166.182170] i915 0000:00:02.0: [drm:intel_disable_transcoder [i915]] disabling pipe B

<7> [166.188543] i915 0000:00:02.0: [drm:intel_power_well_disable [i915]] disabling DDI_IO_B

<7> [166.188749] i915 0000:00:02.0: [drm:intel_dpll_disable [i915]] disable DPLL 0 (active 0x2, on? 1) for [CRTC:185:pipe B]

<7> [166.188947] i915 0000:00:02.0: [drm:intel_dpll_disable [i915]] disabling DPLL 0

<7> [166.189128] i915 0000:00:02.0: [drm:intel_set_cdclk [i915]] Pre changing CDCLK to 172800 kHz, VCO 345600 kHz, ref 38400 kHz, bypass 19200 kHz, voltage level 0

<7> [166.189382] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:341:DDI B/PHY B]

<7> [166.189587] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:351:DDI TC1/PHY TC1]

<7> [166.189756] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:353:DP-MST A]

<7> [166.189922] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:354:DP-MST B]

<7> [166.190087] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:355:DP-MST C]

<7> [166.190255] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:356:DP-MST D]

<7> [166.190441] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:361:DDI TC2/PHY TC2]

<7> [166.190608] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:363:DP-MST A]

<7> [166.190772] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:364:DP-MST B]

<7> [166.190935] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:365:DP-MST C]

<7> [166.191099] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:366:DP-MST D]

<7> [166.191262] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:370:DDI TC3/PHY TC3]

<7> [166.191446] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:372:DP-MST A]

<7> [166.191620] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:373:DP-MST B]

<7> [166.191791] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:374:DP-MST C]

<7> [166.191962] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:375:DP-MST D]

<7> [166.192133] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:379:DDI TC4/PHY TC4]

<7> [166.192303] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:381:DP-MST A]

<7> [166.192485] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:382:DP-MST B]

<7> [166.192664] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:383:DP-MST C]

<7> [166.192838] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:384:DP-MST D]

<7> [166.193014] i915 0000:00:02.0: [drm:verify_connector_state [i915]] [CONNECTOR:342:HDMI-A-1]

<7> [166.193361] i915 0000:00:02.0: [drm:gen9_dbuf_slices_update [i915]] Updating dbuf slices to 0x1

<7> [166.193600] i915 0000:00:02.0: [drm:intel_power_well_disable [i915]] disabling PW_3

<7> [166.193801] i915 0000:00:02.0: [drm:intel_power_well_disable [i915]] disabling PW_2

<7> [166.194004] i915 0000:00:02.0: [drm:intel_modeset_verify_crtc [i915]] [CRTC:185:pipe B]

<7> [166.194472] i915 0000:00:02.0: [drm:drm_mode_setcrtc] [CRTC:262:pipe C]

<7> [166.194630] i915 0000:00:02.0: [drm:drm_mode_setcrtc] [CRTC:339:pipe D]

<7> [166.194760] i915 0000:00:02.0: [drm:drm_mode_setcrtc] [CRTC:185:pipe B]

<7> [166.194790] i915 0000:00:02.0: [drm:drm_mode_setcrtc] [CONNECTOR:342:HDMI-A-1]

<7> [166.194851] i915 0000:00:02.0: [drm:intel_atomic_check [i915]] [CONNECTOR:342:HDMI-A-1] Limiting display bpp to 24 (EDID bpp 24, max requested bpp 36, max platform bpp 36)

<7> [166.195027] i915 0000:00:02.0: [drm:intel_hdmi_compute_clock [i915]] picking 8 bpc for HDMI output (pipe bpp: 24)

<7> [166.195188] i915 0000:00:02.0: [drm:intel_atomic_check [i915]] [CRTC:185:pipe B] hw max bpp: 24, pipe bpp: 24, dithering: 0

<7> [166.195366] i915 0000:00:02.0: [drm:intel_ddi_compute_config_late [i915]] [ENCODER:341:DDI B/PHY B] [CRTC:185:pipe B]

<7> [166.195522] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:185:pipe B] fastset requirement not met in hw.enable (expected no, found yes)

<7> [166.195688] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:185:pipe B] fastset requirement not met in hw.active (expected no, found yes)

<7> [166.195850] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:185:pipe B] fastset requirement not met in cpu_transcoder (expected -1, found 1)

<7> [166.196009] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:185:pipe B] fastset requirement not met in lane_count (expected 0, found 4)

<7> [166.196169] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:185:pipe B] fastset requirement not met in output_types (expected 0x00000000, found 0x00000040)

<7> [166.196340] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:185:pipe B] fastset requirement not met in framestart_delay (expected 0, found 1)

<7> [166.196504] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:185:pipe B] fastset requirement not met in hw.pipe_mode.crtc_hdisplay (expected 0, found 1920)

<7> [166.196664] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:185:pipe B] fastset requirement not met in hw.pipe_mode.crtc_htotal (expected 0, found 2080)

<7> [166.196821] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:185:pipe B] fastset requirement not met in hw.pipe_mode.crtc_hblank_start (expected 0, found 1920)

<7> [166.196979] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:185:pipe B] fastset requirement not met in hw.pipe_mode.crtc_hblank_end (expected 0, found 2080)

<7> [166.197136] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:185:pipe B] fastset requirement not met in hw.pipe_mode.crtc_hsync_start (expected 0, found 1968)

<7> [166.197306] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:185:pipe B] fastset requirement not met in hw.pipe_mode.crtc_hsync_end (expected 0, found 2000)

<7> [166.197467] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:185:pipe B] fastset requirement not met in hw.pipe_mode.crtc_vdisplay (expected 0, found 1080)

<7> [166.197628] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:185:pipe B] fastset requirement not met in hw.pipe_mode.crtc_vblank_start (expected 0, found 1080)

<7> [166.197788] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:185:pipe B] fastset requirement not met in hw.pipe_mode.crtc_vsync_start (expected 0, found 1083)

<7> [166.197945] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:185:pipe B] fastset requirement not met in hw.pipe_mode.crtc_vsync_end (expected 0, found 1088)

<7> [166.198103] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:185:pipe B] fastset requirement not met in hw.pipe_mode.crtc_vtotal (expected 0, found 1144)

<7> [166.198266] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:185:pipe B] fastset requirement not met in hw.pipe_mode.crtc_vblank_end (expected 0, found 1144)

<7> [166.198423] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:185:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_hdisplay (expected 0, found 1920)

<7> [166.198580] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:185:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_htotal (expected 0, found 2080)

<7> [166.198735] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:185:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_hblank_start (expected 0, found 1920)

<7> [166.198891] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:185:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_hblank_end (expected 0, found 2080)

<7> [166.199047] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:185:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_hsync_start (expected 0, found 1968)

<7> [166.199206] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:185:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_hsync_end (expected 0, found 2000)

<7> [166.199377] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:185:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_vdisplay (expected 0, found 1080)

<7> [166.199536] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:185:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_vblank_start (expected 0, found 1080)

<7> [166.199694] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:185:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_vsync_start (expected 0, found 1083)

<7> [166.199850] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:185:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_vsync_end (expected 0, found 1088)

<7> [166.200006] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:185:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_vtotal (expected 0, found 1144)

<7> [166.200163] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:185:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_vblank_end (expected 0, found 1144)

<7> [166.200327] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:185:pipe B] fastset requirement not met in pixel_multiplier (expected 0, found 1)

<7> [166.200484] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:185:pipe B] fastset requirement not met in hw.adjusted_mode.flags (1) (expected 0, found 1)

<7> [166.200640] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:185:pipe B] fastset requirement not met in hw.adjusted_mode.flags (4) (expected 0, found 4)

<7> [166.200796] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:185:pipe B] fastset requirement not met in has_hdmi_sink (expected no, found yes)

<7> [166.200951] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:185:pipe B] fastset requirement not met in has_infoframe (expected no, found yes)

<7> [166.201107] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:185:pipe B] fastset requirement not met in pipe_bpp (expected 0, found 24)

<7> [166.201276] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:185:pipe B] fastset requirement not met in hw.pipe_mode.crtc_clock (expected 0, found 285500)

<7> [166.201440] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:185:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_clock (expected 0, found 285500)

<7> [166.201596] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:185:pipe B] fastset requirement not met in port_clock (expected 0, found 285500)

<7> [166.201751] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:185:pipe B] fastset requirement not met in infoframes.enable (expected 0x00000000, found 0x00000071)

<7> [166.201908] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:185:pipe B] fastset requirement not met in avi infoframe

<7> [166.202063] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] expected:

<7> [166.202229] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] found:

<7> [166.202385] i915 0000:00:02.0: HDMI infoframe: Auxiliary Video Information (AVI), version 2, length 13

<7> [166.202400] i915 0000:00:02.0: nups: Unknown Non-uniform Scaling

<7> [166.202407] i915 0000:00:02.0: bar top 0, bottom 0, left 0, right 0

<7> [166.202409] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:185:pipe B] fastset requirement not met in spd infoframe

<7> [166.202564] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] expected:

<7> [166.202721] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] found:

<7> [166.202881] i915 0000:00:02.0: HDMI infoframe: Source Product Description (SPD), version 1, length 25

<7> [166.202886] i915 0000:00:02.0: source device information: PC General (0x9)

<7> [166.202888] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:185:pipe B] fastset requirement not met in hdmi infoframe

<7> [166.203047] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] expected:

<7> [166.203216] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] found:

<7> [166.203378] i915 0000:00:02.0: HDMI infoframe: Vendor, version 1, length 4

<7> [166.203382] i915 0000:00:02.0: [drm:intel_atomic_check [i915]] [CRTC:185:pipe B] fastset requirement not met, forcing full modeset

<7> [166.203568] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] Enabled dbuf slices 0x1 -> 0x3 (total dbuf slices 0x3), mbus joined? no->no

<7> [166.203728] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] [CRTC:185:pipe B] dbuf slices 0x0 -> 0x3, ddb (0 - 0) -> (0 - 2048), active pipes 0x0 -> 0x2

<7> [166.203923] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] [PLANE:110:plane 1B] ddb ( 0 - 0) -> ( 0 - 1993), size 0 -> 1993

<7> [166.204078] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] [PLANE:180:cursor B] ddb ( 0 - 0) -> (1993 - 2048), size 0 -> 55

<7> [166.204247] i915 0000:00:02.0: [drm:skl_print_plane_changes [i915]] [PLANE:110: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> [166.204402] i915 0000:00:02.0: [drm:skl_print_plane_changes [i915]] [PLANE:110:plane 1B] lines 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0 -> 1, 8, 8, 8, 8, 11, 16, 16, 0, 0, 0

<7> [166.204558] i915 0000:00:02.0: [drm:skl_print_plane_changes [i915]] [PLANE:110:plane 1B] blocks 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0 -> 16, 129, 129, 129, 129, 177, 257, 257, 30, 0, 0

<7> [166.204713] i915 0000:00:02.0: [drm:skl_print_plane_changes [i915]] [PLANE:110:plane 1B] min_ddb 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0 -> 19, 143, 143, 143, 143, 196, 284, 284, 31, 0, 0

<7> [166.204887] i915 0000:00:02.0: [drm:intel_bw_atomic_check [i915]] [CRTC:185:pipe B] data rate 1142000 num active planes 1

<7> [166.205051] i915 0000:00:02.0: [drm:intel_bw_atomic_check [i915]] QGV point 0: max bw 14993 required 1142

<7> [166.205288] i915 0000:00:02.0: [drm:intel_bw_atomic_check [i915]] No SAGV, using single QGV point mask 0x1

<7> [166.205465] i915 0000:00:02.0: [drm:intel_cdclk_atomic_check [i915]] [CRTC:185:pipe B] min cdclk: 0 kHz -> 192000 kHz

<7> [166.205625] i915 0000:00:02.0: [drm:intel_cdclk_update_bw_min_cdclk [i915]] bandwidth min cdclk: 0 kHz -> 17844 kHz

<7> [166.205806] i915 0000:00:02.0: [drm:intel_cdclk_atomic_check [i915]] Modeset required for cdclk change

<7> [166.205962] i915 0000:00:02.0: [drm:intel_cdclk_atomic_check [i915]] New cdclk calculated to be logical 192000 kHz, actual 192000 kHz

<7> [166.206136] i915 0000:00:02.0: [drm:intel_cdclk_atomic_check [i915]] New voltage level calculated to be logical 0, actual 0

<7> [166.206296] i915 0000:00:02.0: [drm:intel_find_dpll [i915]] [CRTC:185:pipe B] allocated DPLL 0

<7> [166.206459] i915 0000:00:02.0: [drm:intel_dpll_crtc_get [i915]] [CRTC:185:pipe B] reserving DPLL 0

<7> [166.206622] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [CRTC:185:pipe B] enable: yes [modeset]

<7> [166.206784] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] active: yes, output_types: HDMI (0x40), output format: RGB, sink format: RGB

<7> [166.206943] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] cpu_transcoder: B, pipe bpp: 24, dithering: 0

<7> [166.207114] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] MST master transcoder: <invalid>

<7> [166.207273] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] port sync: master transcoder: <invalid>, slave transcoder bitmask = 0x0

<7> [166.207441] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] joiner: no, pipes: 0x0

<7> [166.207602] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] splitter: disabled, link count 0, overlap 0

<7> [166.207761] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] audio: 1, infoframes: 1, infoframes enabled: 0x71

<7> [166.207920] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] GCP: 0x0

<7> [166.208090] i915 0000:00:02.0: HDMI infoframe: Auxiliary Video Information (AVI), version 2, length 13

<7> [166.208104] i915 0000:00:02.0: nups: Unknown Non-uniform Scaling

<7> [166.208111] i915 0000:00:02.0: bar top 0, bottom 0, left 0, right 0

<7> [166.208113] i915 0000:00:02.0: HDMI infoframe: Source Product Description (SPD), version 1, length 25

<7> [166.208118] i915 0000:00:02.0: source device information: PC General (0x9)

<7> [166.208120] i915 0000:00:02.0: HDMI infoframe: Vendor, version 1, length 4

<7> [166.208123] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] ELD: 10 00 0f 00 6d a2 00 7f 00 00 00 00 00 00 00 00

<7> [166.208284] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] ELD: 0d 82 34 12 66 69 74 48 65 61 64 6c 65 73 73 47

<7> [166.208443] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] ELD: 53 7f 7f 28 0f 7f 07 17 7f ff 3f 7f ff 47 7f ff

<7> [166.208600] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] ELD: 5f 7f 82 7f 7f 00 7f 7f 51 7f 7f 30 77 7f 03 00

<7> [166.208756] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] scanline offset: 2

<7> [166.208911] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] vblank delay: 0, framestart delay: 1, MSA timing delay: 0 set context latency: 0

<7> [166.209081] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] vrr: no, fixed rr: yes, vmin: 1144, vmax: 1144, flipline: 1144, pipeline full: 61, guardband: 63 vsync start: 0, vsync end: 0

<7> [166.209239] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] vrr: vmin vblank: 1081, vmax vblank: 1081, vmin vtotal: 1144, vmax vtotal: 1144

<7> [166.209394] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] requested mode: "1920x1080": 120 285500 1920 1968 2000 2080 1080 1083 1088 1144 0x48 0x5

<7> [166.209551] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] adjusted mode: "1920x1080": 120 285500 1920 1968 2000 2080 1080 1083 1088 1144 0x48 0x5

<7> [166.209708] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] crtc timings: clock=285500, hd=1920 hb=1920-2080 hs=1968-2000 ht=2080, vd=1080 vb=1080-1144 vs=1083-1088 vt=1144, flags=0x5

<7> [166.209864] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pipe mode: "1920x1080": 120 285500 1920 1968 2000 2080 1080 1083 1088 1144 0x40 0x5

<7> [166.210037] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] crtc timings: clock=285500, hd=1920 hb=1920-2080 hs=1968-2000 ht=2080, vd=1080 vb=1080-1144 vs=1083-1088 vt=1144, flags=0x5

<7> [166.210194] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] port clock: 285500, pipe src: 1920x1080+0+0, pixel rate 285500

<7> [166.210351] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] linetime: 59, ips linetime: 0

<7> [166.210506] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] num_scalers: 2, scaler_users: 0x0, scaler_id: -1, scaling_filter: 0

<7> [166.210662] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pch pfit: 0x0+0+0, disabled, force thru: no

<7> [166.210822] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] ips: 0, double wide: 0, drrs: 0

<7> [166.210991] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] dpll_hw_state: cfgcr0: 0x1801be, cfgcr1: 0x488, 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> [166.211151] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] csc_mode: 0x0 gamma_mode: 0x0 gamma_enable: 0 csc_enable: 0

<7> [166.211309] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pre csc lut: 0 entries, post csc lut: 0 entries

<7> [166.211466] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] output csc: pre offsets: 0x0000 0x0000 0x0000

<7> [166.211622] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] output csc: coefficients: 0x0000 0x0000 0x0000

<7> [166.211778] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] output csc: coefficients: 0x0000 0x0000 0x0000

<7> [166.211943] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] output csc: coefficients: 0x0000 0x0000 0x0000

<7> [166.212107] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] output csc: post offsets: 0x0000 0x0000 0x0000

<7> [166.212265] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pipe csc: pre offsets: 0x0000 0x0000 0x0000

<7> [166.212423] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pipe csc: coefficients: 0x0000 0x0000 0x0000

<7> [166.212581] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pipe csc: coefficients: 0x0000 0x0000 0x0000

<7> [166.212736] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pipe csc: coefficients: 0x0000 0x0000 0x0000

<7> [166.212893] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pipe csc: post offsets: 0x0000 0x0000 0x0000

<7> [166.213078] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:110:plane 1B] fb: [FB:391] 1920x1080 format = XR24 little-endian (0x34325258) modifier = 0x100000000000001, visible: yes

<7> [166.213103] i915 0000:00:02.0: [drm:intel_power_well_disable [i915]] disabling DC_off

<7> [166.213270] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] rotation: 0x1, scaler: -1, scaling_filter: 0

<7> [166.213374] i915 0000:00:02.0: [drm:skl_enable_dc6 [i915]] Enabling DC6

<7> [166.213430] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] src: 1920.000000x1080.000000+0.000000+0.000000 dst: 1920x1080+0+0

<7> [166.213595] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:120:plane 2B] fb: [NOFB], visible: no

<7> [166.213616] i915 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [i915]] Setting DC state from 00 to 02

<7> [166.213756] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:130:plane 3B] fb: [NOFB], visible: no

<7> [166.213928] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:140:plane 4B] fb: [NOFB], visible: no

<7> [166.214106] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:150:plane 5B] fb: [NOFB], visible: no

<7> [166.214266] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:160:plane 6B] fb: [NOFB], visible: no

<7> [166.214424] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:170:plane 7B] fb: [NOFB], visible: no

<7> [166.214582] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:180:cursor B] fb: [NOFB], visible: no

<7> [166.214884] i915 0000:00:02.0: [drm:intel_power_well_disable [i915]] disabling always-on

<7> [166.215136] i915 0000:00:02.0: [drm:intel_power_well_enable [i915]] enabling always-on

<7> [166.215315] i915 0000:00:02.0: [drm:intel_power_well_enable [i915]] enabling DC_off

<7> [166.216020] i915 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [i915]] Setting DC state from 02 to 00

<7> [166.217213] i915 0000:00:02.0: [drm:intel_power_well_enable [i915]] enabling PW_2

<7> [166.217391] i915 0000:00:02.0: [drm:intel_power_well_enable [i915]] enabling PW_3

<7> [166.217590] i915 0000:00:02.0: [drm:intel_set_cdclk [i915]] Pre changing CDCLK to 192000 kHz, VCO 384000 kHz, ref 38400 kHz, bypass 19200 kHz, voltage level 0

<7> [166.217883] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:341:DDI B/PHY B]

<7> [166.218046] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:351:DDI TC1/PHY TC1]

<7> [166.218215] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:353:DP-MST A]

<7> [166.218385] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:354:DP-MST B]

<7> [166.218544] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:355:DP-MST C]

<7> [166.218734] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:356:DP-MST D]

<7> [166.218905] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:361:DDI TC2/PHY TC2]

<7> [166.219071] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:363:DP-MST A]

<7> [166.219238] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:364:DP-MST B]

<7> [166.219396] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:365:DP-MST C]

<7> [166.219559] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:366:DP-MST D]

<7> [166.219751] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:370:DDI TC3/PHY TC3]

<7> [166.219920] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:372:DP-MST A]

<7> [166.220082] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:373:DP-MST B]

<7> [166.220251] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:374:DP-MST C]

<7> [166.220411] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:375:DP-MST D]

<7> [166.220571] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:379:DDI TC4/PHY TC4]

<7> [166.220783] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:381:DP-MST A]

<7> [166.220967] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:382:DP-MST B]

<7> [166.221131] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:383:DP-MST C]

<7> [166.221294] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:384:DP-MST D]

<7> [166.221573] i915 0000:00:02.0: [drm:gen9_dbuf_slices_update [i915]] Updating dbuf slices to 0x3

<7> [166.221831] i915 0000:00:02.0: [drm:intel_dpll_enable [i915]] enable DPLL 0 (active 0x2, on? 0) for [CRTC:185:pipe B]

<7> [166.222016] i915 0000:00:02.0: [drm:intel_dpll_enable [i915]] enabling DPLL 0

<7> [166.222252] i915 0000:00:02.0: [drm:intel_power_well_enable [i915]] enabling DDI_IO_B

<7> [166.222493] i915 0000:00:02.0: [drm:intel_enable_transcoder [i915]] enabling pipe B

<7> [166.223262] i915 0000:00:02.0: [drm:intel_hdmi_handle_sink_scrambling [i915]] [CONNECTOR:342:HDMI-A-1] scrambling=no, TMDS bit clock ratio=1/10

<7> [166.223260] i915 0000:00:02.0: [drm:intel_audio_component_get_power [i915]] restored AUD_FREQ_CNTRL to 0x810

<7> [166.223851] i915 0000:00:02.0: [drm:do_gmbus_xfer [i915]] GMBUS [i915 gmbus dpb] NAK for addr: 0054 w(1)

<7> [166.224044] i915 0000:00:02.0: [drm:do_gmbus_xfer [i915]] GMBUS [i915 gmbus dpb] NAK on first message, retry

<7> [166.224487] i915 0000:00:02.0: [drm:do_gmbus_xfer [i915]] GMBUS [i915 gmbus dpb] NAK for addr: 0054 w(1)

<7> [166.224651] i915 0000:00:02.0: [drm:drm_scdc_set_high_tmds_clock_ratio [drm_display_helper]] [CONNECTOR:342:HDMI-A-1] Failed to read TMDS config: -6

<7> [166.224676] i915 0000:00:02.0: [drm:intel_ddi_enable [i915]] [CONNECTOR:342:HDMI-A-1] Failed to configure sink scrambling/TMDS bit clock ratio

<7> [166.229382] azx_init_pci: snd_hda_intel 0000:00:1f.3: Clearing TCSEL

<7> [166.229414] azx_init_pci: snd_hda_intel 0000:00:1f.3: SCH snoop: Enabled

<7> [166.241662] i915 0000:00:02.0: [drm:intel_audio_codec_enable [i915]] [CONNECTOR:342:HDMI-A-1][ENCODER:341:DDI B/PHY B] Enable audio codec on [CRTC:185:pipe B], 64 bytes ELD

<7> [166.249966] i915 0000:00:02.0: [drm:audio_config_hdmi_pixel_clock [i915]] HDMI audio pixel clock setting for 285500 not found, falling back to defaults

<7> [166.250159] i915 0000:00:02.0: [drm:audio_config_hdmi_pixel_clock [i915]] Configuring HDMI audio for pixel clock 25200 (0x00010000)

<7> [166.250318] i915 0000:00:02.0: [drm:hsw_audio_config_update [i915]] using automatic N

<6> [166.250483] snd_hda_codec_intelhdmi hdaudioC0D2: HDMI: audio coding xtype 5 not expected

<6> [166.250485] snd_hda_codec_intelhdmi hdaudioC0D2: HDMI: audio coding xtype 0 not expected

<6> [166.250487] snd_hda_codec_intelhdmi hdaudioC0D2: HDMI: audio coding xtype 10 not expected

<6> [166.250489] snd_hda_codec_intelhdmi hdaudioC0D2: HDMI: audio coding xtype 6 not expected

<7> [166.250622] i915 0000:00:02.0: [drm:verify_connector_state [i915]] [CONNECTOR:342:HDMI-A-1]

<7> [166.250866] i915 0000:00:02.0: [drm:intel_modeset_verify_crtc [i915]] [CRTC:185:pipe B]

<7> [166.307411] i915 0000:00:02.0: [drm:intel_audio_component_get_power [i915]] restored AUD_FREQ_CNTRL to 0x810

<7> [166.311818] azx_init_pci: snd_hda_intel 0000:00:1f.3: Clearing TCSEL

<7> [166.311864] azx_init_pci: snd_hda_intel 0000:00:1f.3: SCH snoop: Enabled

Results for igt@kms_flip@blocking-wf_vblank@b-hdmi-a1