Result:
git-log-oneline i915_display_info4 igt_runner4 runtimes4 results4.json results4-i915-load.json guc_logs4.tar i915_display_info_post_exec4 boot4 dmesg4
| Detail | Value |
|---|---|
| Duration | 19.11 seconds |
| Hostname |
shard-tglu-3 |
| Igt-Version |
IGT-Version: 2.3-g889245228 (x86_64) (Linux: 7.0.0-rc1-CI_DRM_18056-g340c78371713+ x86_64) |
| Out |
Using IGT_SRANDOM=1772155740 for randomisation Opened device: /dev/dri/card0 Using monotonic timestamps Starting subtest: flip-vs-blocking-wf-vblank Starting dynamic subtest: A-HDMI-A1 1920x1080: 120 285500 1920 1968 2000 2080 1080 1083 1088 1144 0x48 0x5 Expected frametime: 8335us; measured 8334.9us +- 2.705us accuracy 0.10% Event flip: expected 906, counted 920, passrate = 57.61%, encoder type 2 Event vblank: expected 906, counted 920, passrate = 56.52%, encoder type 2 Expected frametime: 8335us; measured 8188.9us +- 3.775us accuracy 0.14% vblank interval differs from modeline! expected 8334.6us, measured 8189us +- 3.775us, difference 145.7us (38.6 sigma) Event flip: expected 915, counted 910, passrate = 35.16%, encoder type 2 Event vblank: expected 915, counted 910, passrate = 34.07%, encoder type 2 Stack trace: #0 ../lib/igt_core.c:2075 __igt_fail_assert() #1 ../tests/kms_flip.c:428 run_test_on_crtc_set.constprop.0() #2 ../tests/kms_flip.c:1887 run_test() #3 ../tests/kms_flip.c:2120 __igt_unique____real_main2043() #4 ../tests/kms_flip.c:2043 main() #5 [__libc_init_first+0x8a] #6 [__libc_start_main+0x8b] #7 [_start+0x25] Dynamic subtest A-HDMI-A1: FAIL (19.106s) |
| Err |
Starting subtest: flip-vs-blocking-wf-vblank Starting dynamic subtest: A-HDMI-A1 (kms_flip:2059) CRITICAL: Test assertion failure function __run_test_on_crtc_set, file ../tests/kms_flip.c:1707: (kms_flip:2059) CRITICAL: Failed assertion: !retried Dynamic subtest A-HDMI-A1 failed. **** DEBUG **** (kms_flip:2059) DEBUG: name = flip last_ts = 59.229321 last_received_ts = 59.303406 last_seq = 2694 current_ts = 59.311813 current_received_ts = 59.385979 current_seq = 2704 count = 51 seq_step = 1 (kms_flip:2059) DEBUG: flip ts/seq: last 59.229321/2694, current 59.311813/2704: elapsed=82491.0us expected=81888.8us +- 409.4us, error 0.7% (kms_flip:2059) DEBUG: inconsistent flip ts/seq: last 59.229321/2694, current 59.311813/2704: elapsed=82491.0us expected=81888.8us (kms_flip:2059) DEBUG: name = vblank last_ts = 59.303566 last_received_ts = 59.303352 last_seq = 2703 current_ts = 59.386055 current_received_ts = 59.385929 current_seq = 2713 count = 51 seq_step = 10 (kms_flip:2059) DEBUG: vblank ts/seq: last 59.303566/2703, current 59.386055/2713: elapsed=82490.0us expected=81888.8us +- 409.4us, error 0.7% (kms_flip:2059) DEBUG: inconsistent vblank ts/seq: last 59.303566/2703, current 59.386055/2713: elapsed=82490.0us expected=81888.8us (kms_flip:2059) DEBUG: name = flip last_ts = 59.311813 last_received_ts = 59.385979 last_seq = 2704 current_ts = 59.394302 current_received_ts = 59.468479 current_seq = 2714 count = 52 seq_step = 1 (kms_flip:2059) DEBUG: flip ts/seq: last 59.311813/2704, current 59.394302/2714: elapsed=82489.0us expected=81888.8us +- 409.4us, error 0.7% (kms_flip:2059) DEBUG: inconsistent flip ts/seq: last 59.311813/2704, current 59.394302/2714: elapsed=82489.0us expected=81888.8us (kms_flip:2059) DEBUG: name = vblank last_ts = 59.386055 last_received_ts = 59.385929 last_seq = 2713 current_ts = 59.468540 current_received_ts = 59.468430 current_seq = 2723 count = 52 seq_step = 10 (kms_flip:2059) DEBUG: vblank ts/seq: last 59.386055/2713, current 59.468540/2723: elapsed=82486.0us expected=81888.8us +- 409.4us, error 0.7% (kms_flip:2059) DEBUG: inconsistent vblank ts/seq: last 59.386055/2713, current 59.468540/2723: elapsed=82486.0us expected=81888.8us (kms_flip:2059) DEBUG: name = flip last_ts = 59.394302 last_received_ts = 59.468479 last_seq = 2714 current_ts = 59.476795 current_received_ts = 59.550964 current_seq = 2724 count = 53 seq_step = 1 (kms_flip:2059) DEBUG: flip ts/seq: last 59.394302/2714, current 59.476795/2724: elapsed=82493.0us expected=81888.8us +- 409.4us, error 0.7% (kms_flip:2059) DEBUG: inconsistent flip ts/seq: last 59.394302/2714, current 59.476795/2724: elapsed=82493.0us expected=81888.8us (kms_flip:2059) DEBUG: name = vblank last_ts = 59.468540 last_received_ts = 59.468430 last_seq = 2723 current_ts = 59.551037 current_received_ts = 59.550915 current_seq = 2733 count = 53 seq_step = 10 (kms_flip:2059) DEBUG: vblank ts/seq: last 59.468540/2723, current 59.551037/2733: elapsed=82494.0us expected=81888.8us +- 409.4us, error 0.7% (kms_flip:2059) DEBUG: inconsistent vblank ts/seq: last 59.468540/2723, current 59.551037/2733: elapsed=82494.0us expected=81888.8us (kms_flip:2059) DEBUG: name = flip last_ts = 59.476795 last_received_ts = 59.550964 last_seq = 2724 current_ts = 59.559280 current_received_ts = 59.633469 current_seq = 2734 count = 54 seq_step = 1 (kms_flip:2059) DEBUG: flip ts/seq: last 59.476795/2724, current 59.559280/2734: elapsed=82487.0us expected=81888.8us +- 409.4us, error 0.7% (kms_flip:2059) DEBUG: inconsistent flip ts/seq: last 59.476795/2724, current 59.559280/2734: elapsed=82487.0us expected=81888.8us (kms_flip:2059) DEBUG: name = vblank last_ts = 59.551037 last_received_ts = 59.550915 last_seq = 2733 current_ts = 59.633533 current_received_ts = 59.633415 current_seq = 2743 count = 54 seq_step = 10 (kms_flip:2059) DEBUG: vblank ts/seq: last 59.551037/2733, current 59.633533/2743: elapsed=82500.0us expected=81888.8us +- 409.4us, error 0.7% (kms_flip:2059) DEBUG: inconsistent vblank ts/seq: last 59.551037/2733, current 59.633533/2743: elapsed=82500.0us expected=81888.8us (kms_flip:2059) DEBUG: name = flip last_ts = 59.559280 last_received_ts = 59.633469 last_seq = 2734 current_ts = 59.641800 current_received_ts = 59.716049 current_seq = 2744 count = 55 seq_step = 1 (kms_flip:2059) DEBUG: flip ts/seq: last 59.559280/2734, current 59.641800/2744: elapsed=82518.0us expected=81888.8us +- 409.4us, error 0.8% (kms_flip:2059) DEBUG: inconsistent flip ts/seq: last 59.559280/2734, current 59.641800/2744: elapsed=82518.0us expected=81888.8us (kms_flip:2059) DEBUG: name = vblank last_ts = 59.633533 last_received_ts = 59.633415 last_seq = 2743 current_ts = 59.716133 current_received_ts = 59.715961 current_seq = 2753 count = 55 seq_step = 10 (kms_flip:2059) DEBUG: vblank ts/seq: last 59.633533/2743, current 59.716133/2753: elapsed=82600.0us expected=81888.8us +- 409.4us, error 0.9% (kms_flip:2059) DEBUG: inconsistent vblank ts/seq: last 59.633533/2743, current 59.716133/2753: elapsed=82600.0us expected=81888.8us (kms_flip:2059) DEBUG: name = flip last_ts = 59.641800 last_received_ts = 59.716049 last_seq = 2744 current_ts = 59.724396 current_received_ts = 59.798550 current_seq = 2754 count = 56 seq_step = 1 (kms_flip:2059) DEBUG: flip ts/seq: last 59.641800/2744, current 59.724396/2754: elapsed=82597.0us expected=81888.8us +- 409.4us, error 0.9% (kms_flip:2059) DEBUG: inconsistent flip ts/seq: last 59.641800/2744, current 59.724396/2754: elapsed=82597.0us expected=81888.8us (kms_flip:2059) DEBUG: name = vblank last_ts = 59.716133 last_received_ts = 59.715961 last_seq = 2753 current_ts = 59.798737 current_received_ts = 59.798496 current_seq = 2763 count = 56 seq_step = 10 (kms_flip:2059) DEBUG: vblank ts/seq: last 59.716133/2753, current 59.798737/2763: elapsed=82600.0us expected=81888.8us +- 409.4us, error 0.9% (kms_flip:2059) DEBUG: inconsistent vblank ts/seq: last 59.716133/2753, current 59.798737/2763: elapsed=82600.0us expected=81888.8us (kms_flip:2059) DEBUG: name = flip last_ts = 59.724396 last_received_ts = 59.798550 last_seq = 2754 current_ts = 59.806992 current_received_ts = 59.881287 current_seq = 2764 count = 57 seq_step = 1 (kms_flip:2059) DEBUG: flip ts/seq: last 59.724396/2754, current 59.806992/2764: elapsed=82594.0us expected=81888.8us +- 409.4us, error 0.9% (kms_flip:2059) DEBUG: inconsistent flip ts/seq: last 59.724396/2754, current 59.806992/2764: elapsed=82594.0us expected=81888.8us (kms_flip:2059) DEBUG: name = vblank last_ts = 59.798737 last_received_ts = 59.798496 last_seq = 2763 current_ts = 59.881332 current_received_ts = 59.881233 current_seq = 2773 count = 57 seq_step = 10 (kms_flip:2059) DEBUG: vblank ts/seq: last 59.798737/2763, current 59.881332/2773: elapsed=82596.0us expected=81888.8us +- 409.4us, error 0.9% (kms_flip:2059) DEBUG: inconsistent vblank ts/seq: last 59.798737/2763, current 59.881332/2773: elapsed=82596.0us expected=81888.8us (kms_flip:2059) DEBUG: name = flip last_ts = 59.806992 last_received_ts = 59.881287 last_seq = 2764 current_ts = 59.889591 current_received_ts = 59.963768 current_seq = 2774 count = 58 seq_step = 1 (kms_flip:2059) DEBUG: flip ts/seq: last 59.806992/2764, current 59.889591/2774: elapsed=82600.0us expected=81888.8us +- 409.4us, error 0.9% (kms_flip:2059) DEBUG: inconsistent flip ts/seq: last 59.806992/2764, current 59.889591/2774: elapsed=82600.0us expected=81888.8us (kms_flip:2059) DEBUG: name = vblank last_ts = 59.881332 last_received_ts = 59.881233 last_seq = 2773 current_ts = 59.963928 current_received_ts = 59.963718 current_seq = 2783 count = 58 seq_step = 10 (kms_flip:2059) DEBUG: vblank ts/seq: last 59.881332/2773, current 59.963928/2783: elapsed=82598.0us expected=81888.8us +- 409.4us, error 0.9% (kms_flip:2059) DEBUG: inconsistent vblank ts/seq: last 59.881332/2773, current 59.963928/2783: elapsed=82598.0us expected=81888.8us (kms_flip:2059) DEBUG: name = flip last_ts = 59.889591 last_received_ts = 59.963768 last_seq = 2774 current_ts = 59.972195 current_received_ts = 60.046459 current_seq = 2784 count = 59 seq_step = 1 (kms_flip:2059) DEBUG: flip ts/seq: last 59.889591/2774, current 59.972195/2784: elapsed=82602.0us expected=81888.8us +- 409.4us, error 0.9% (kms_flip:2059) DEBUG: inconsistent flip ts/seq: last 59.889591/2774, current 59.972195/2784: elapsed=82602.0us expected=81888.8us (kms_flip:2059) DEBUG: name = vblank last_ts = 59.963928 last_received_ts = 59.963718 last_seq = 2783 current_ts = 60.046528 current_received_ts = 60.046410 current_seq = 2793 count = 59 seq_step = 10 (kms_flip:2059) DEBUG: vblank ts/seq: last 59.963928/2783, current 60.046528/2793: elapsed=82597.0us expected=81888.8us +- 409.4us, error 0.9% (kms_flip:2059) DEBUG: inconsistent vblank ts/seq: last 59.963928/2783, current 60.046528/2793: elapsed=82597.0us expected=81888.8us (kms_flip:2059) DEBUG: name = flip last_ts = 59.972195 last_received_ts = 60.046459 last_seq = 2784 current_ts = 60.054790 current_received_ts = 60.128956 current_seq = 2794 count = 60 seq_step = 1 (kms_flip:2059) DEBUG: flip ts/seq: last 59.972195/2784, current 60.054790/2794: elapsed=82597.0us expected=81888.8us +- 409.4us, error 0.9% (kms_flip:2059) DEBUG: inconsistent flip ts/seq: last 59.972195/2784, current 60.054790/2794: elapsed=82597.0us expected=81888.8us (kms_flip:2059) DEBUG: name = vblank last_ts = 60.046528 last_received_ts = 60.046410 last_seq = 2793 current_ts = 60.129124 current_received_ts = 60.128902 current_seq = 2803 count = 60 seq_step = 10 (kms_flip:2059) DEBUG: vblank ts/seq: last 60.046528/2793, current 60.129124/2803: elapsed=82599.0us expected=81888.8us +- 409.4us, error 0.9% (kms_flip:2059) DEBUG: inconsistent vblank ts/seq: last 60.046528/2793, current 60.129124/2803: elapsed=82599.0us expected=81888.8us (kms_flip:2059) DEBUG: name = flip last_ts = 60.054790 last_received_ts = 60.128956 last_seq = 2794 current_ts = 60.137390 current_received_ts = 60.211639 current_seq = 2804 count = 61 seq_step = 1 (kms_flip:2059) DEBUG: flip ts/seq: last 60.054790/2794, current 60.137390/2804: elapsed=82600.0us expected=81888.8us +- 409.4us, error 0.9% (kms_flip:2059) DEBUG: inconsistent flip ts/seq: last 60.054790/2794, current 60.137390/2804: elapsed=82600.0us expected=81888.8us (kms_flip:2059) DEBUG: name = vblank last_ts = 60.129124 last_received_ts = 60.128902 last_seq = 2803 current_ts = 60.211723 current_received_ts = 60.211590 current_seq = 2813 count = 61 seq_step = 10 (kms_flip:2059) DEBUG: vblank ts/seq: last 60.129124/2803, current 60.211723/2813: elapsed=82599.0us expected=81888.8us +- 409.4us, error 0.9% (kms_flip:2059) DEBUG: inconsistent vblank ts/seq: last 60.129124/2803, current 60.211723/2813: elapsed=82599.0us expected=81888.8us (kms_flip:2059) DEBUG: name = flip last_ts = 60.137390 last_received_ts = 60.211639 last_seq = 2804 current_ts = 60.219986 current_received_ts = 60.294201 current_seq = 2814 count = 62 seq_step = 1 (kms_flip:2059) DEBUG: flip ts/seq: last 60.137390/2804, current 60.219986/2814: elapsed=82596.0us expected=81888.8us +- 409.4us, error 0.9% (kms_flip:2059) DEBUG: inconsistent flip ts/seq: last 60.137390/2804, current 60.219986/2814: elapsed=82596.0us expected=81888.8us (kms_flip:2059) DEBUG: name = vblank last_ts = 60.211723 last_received_ts = 60.211590 last_seq = 2813 current_ts = 60.294319 current_received_ts = 60.294147 current_seq = 2823 count = 62 seq_step = 10 (kms_flip:2059) DEBUG: vblank ts/seq: last 60.211723/2813, current 60.294319/2823: elapsed=82595.0us expected=81888.8us +- 409.4us, error 0.9% (kms_flip:2059) DEBUG: inconsistent vblank ts/seq: last 60.211723/2813, current 60.294319/2823: elapsed=82595.0us expected=81888.8us (kms_flip:2059) DEBUG: name = flip last_ts = 60.219986 last_received_ts = 60.294201 last_seq = 2814 current_ts = 60.302582 current_received_ts = 60.376881 current_seq = 2824 count = 63 seq_step = 1 (kms_flip:2059) DEBUG: flip ts/seq: last 60.219986/2814, current 60.302582/2824: elapsed=82596.0us expected=81888.8us +- 409.4us, error 0.9% (kms_flip:2059) DEBUG: inconsistent flip ts/seq: last 60.219986/2814, current 60.302582/2824: elapsed=82596.0us expected=81888.8us (kms_flip:2059) DEBUG: name = vblank last_ts = 60.294319 last_received_ts = 60.294147 last_seq = 2823 current_ts = 60.376919 current_received_ts = 60.376827 current_seq = 2833 count = 63 seq_step = 10 (kms_flip:2059) DEBUG: vblank ts/seq: last 60.294319/2823, current 60.376919/2833: elapsed=82599.0us expected=81888.8us +- 409.4us, error 0.9% (kms_flip:2059) DEBUG: inconsistent vblank ts/seq: last 60.294319/2823, current 60.376919/2833: elapsed=82599.0us expected=81888.8us (kms_flip:2059) DEBUG: name = flip last_ts = 60.302582 last_received_ts = 60.376881 last_seq = 2824 current_ts = 60.385178 current_received_ts = 60.459473 current_seq = 2834 count = 64 seq_step = 1 (kms_flip:2059) DEBUG: flip ts/seq: last 60.302582/2824, current 60.385178/2834: elapsed=82597.0us expected=81888.8us +- 409.4us, error 0.9% (kms_flip:2059) DEBUG: inconsistent flip ts/seq: last 60.302582/2824, current 60.385178/2834: elapsed=82597.0us expected=81888.8us (kms_flip:2059) DEBUG: name = vblank last_ts = 60.376919 last_received_ts = 60.376827 last_seq = 2833 current_ts = 60.459518 current_received_ts = 60.459419 current_seq = 2843 count = 64 seq_step = 10 (kms_flip:2059) DEBUG: vblank ts/seq: last 60.376919/2833, current 60.459518/2843: elapsed=82599.0us expected=81888.8us +- 409.4us, error 0.9% (kms_flip:2059) DEBUG: inconsistent vblank ts/seq: last 60.376919/2833, current 60.459518/2843: elapsed=82599.0us expected=81888.8us (kms_flip:2059) DEBUG: name = flip last_ts = 60.385178 last_received_ts = 60.459473 last_seq = 2834 current_ts = 60.467777 current_received_ts = 60.541901 current_seq = 2844 count = 65 seq_step = 1 (kms_flip:2059) DEBUG: flip ts/seq: last 60.385178/2834, current 60.467777/2844: elapsed=82600.0us expected=81888.8us +- 409.4us, error 0.9% (kms_flip:2059) DEBUG: inconsistent flip ts/seq: last 60.385178/2834, current 60.467777/2844: elapsed=82600.0us expected=81888.8us (kms_flip:2059) DEBUG: name = vblank last_ts = 60.459518 last_received_ts = 60.459419 last_seq = 2843 current_ts = 60.542118 current_received_ts = 60.541851 current_seq = 2853 count = 65 seq_step = 10 (kms_flip:2059) DEBUG: vblank ts/seq: last 60.459518/2843, current 60.542118/2853: elapsed=82602.0us expected=81888.8us +- 409.4us, error 0.9% (kms_flip:2059) DEBUG: inconsistent vblank ts/seq: last 60.459518/2843, current 60.542118/2853: elapsed=82602.0us expected=81888.8us (kms_flip:2059) DEBUG: name = flip last_ts = 60.467777 last_received_ts = 60.541901 last_seq = 2844 current_ts = 60.550377 current_received_ts = 60.624657 current_seq = 2854 count = 66 seq_step = 1 (kms_flip:2059) DEBUG: flip ts/seq: last 60.467777/2844, current 60.550377/2854: elapsed=82599.0us expected=81888.8us +- 409.4us, error 0.9% (kms_flip:2059) DEBUG: inconsistent flip ts/seq: last 60.467777/2844, current 60.550377/2854: elapsed=82599.0us expected=81888.8us (kms_flip:2059) DEBUG: name = vblank last_ts = 60.542118 last_received_ts = 60.541851 last_seq = 2853 current_ts = 60.624714 current_received_ts = 60.624607 current_seq = 2863 count = 66 seq_step = 10 (kms_flip:2059) DEBUG: vblank ts/seq: last 60.542118/2853, current 60.624714/2863: elapsed=82595.0us expected=81888.8us +- 409.4us, error 0.9% (kms_flip:2059) DEBUG: inconsistent vblank ts/seq: last 60.542118/2853, current 60.624714/2863: elapsed=82595.0us expected=81888.8us (kms_flip:2059) DEBUG: name = flip last_ts = 60.550377 last_received_ts = 60.624657 last_seq = 2854 current_ts = 60.632988 current_received_ts = 60.707359 current_seq = 2864 count = 67 seq_step = 1 (kms_flip:2059) DEBUG: flip ts/seq: last 60.550377/2854, current 60.632988/2864: elapsed=82609.0us expected=81888.8us +- 409.4us, error 0.9% (kms_flip:2059) DEBUG: inconsistent flip ts/seq: last 60.550377/2854, current 60.632988/2864: elapsed=82609.0us expected=81888.8us (kms_flip:2059) DEBUG: name = vblank last_ts = 60.624714 last_received_ts = 60.624607 last_seq = 2863 current_ts = 60.707409 current_received_ts = 60.707310 current_seq = 2873 count = 67 seq_step = 10 (kms_flip:2059) DEBUG: vblank ts/seq: last 60.624714/2863, current 60.707409/2873: elapsed=82694.0us expected=81888.8us +- 409.4us, error 1.0% (kms_flip:2059) DEBUG: inconsistent vblank ts/seq: last 60.624714/2863, current 60.707409/2873: elapsed=82694.0us expected=81888.8us (kms_flip:2059) DEBUG: name = flip last_ts = 60.632988 last_received_ts = 60.707359 last_seq = 2864 current_ts = 60.715679 current_received_ts = 60.790066 current_seq = 2874 count = 68 seq_step = 1 (kms_flip:2059) DEBUG: flip ts/seq: last 60.632988/2864, current 60.715679/2874: elapsed=82693.0us expected=81888.8us +- 409.4us, error 1.0% (kms_flip:2059) DEBUG: inconsistent flip ts/seq: last 60.632988/2864, current 60.715679/2874: elapsed=82693.0us expected=81888.8us (kms_flip:2059) DEBUG: name = vblank last_ts = 60.707409 last_received_ts = 60.707310 last_seq = 2873 current_ts = 60.790096 current_received_ts = 60.789970 current_seq = 2883 count = 68 seq_step = 10 (kms_flip:2059) DEBUG: vblank ts/seq: last 60.707409/2873, current 60.790096/2883: elapsed=82687.0us expected=81888.8us +- 409.4us, error 1.0% (kms_flip:2059) DEBUG: inconsistent vblank ts/seq: last 60.707409/2873, current 60.790096/2883: elapsed=82687.0us expected=81888.8us (kms_flip:2059) DEBUG: name = flip last_ts = 60.715679 last_received_ts = 60.790066 last_seq = 2874 current_ts = 60.798367 current_received_ts = 60.872669 current_seq = 2884 count = 69 seq_step = 1 (kms_flip:2059) DEBUG: flip ts/seq: last 60.715679/2874, current 60.798367/2884: elapsed=82688.0us expected=81888.8us +- 409.4us, error 1.0% (kms_flip:2059) DEBUG: inconsistent flip ts/seq: last 60.715679/2874, current 60.798367/2884: elapsed=82688.0us expected=81888.8us (kms_flip:2059) DEBUG: name = vblank last_ts = 60.790096 last_received_ts = 60.789970 last_seq = 2883 current_ts = 60.872787 current_received_ts = 60.872620 current_seq = 2893 count = 69 seq_step = 10 (kms_flip:2059) DEBUG: vblank ts/seq: last 60.790096/2883, current 60.872787/2893: elapsed=82693.0us expected=81888.8us +- 409.4us, error 1.0% (kms_flip:2059) DEBUG: inconsistent vblank ts/seq: last 60.790096/2883, current 60.872787/2893: elapsed=82693.0us expected=81888.8us (kms_flip:2059) DEBUG: name = flip last_ts = 60.798367 last_received_ts = 60.872669 last_seq = 2884 current_ts = 60.881062 current_received_ts = 60.955414 current_seq = 2894 count = 70 seq_step = 1 (kms_flip:2059) DEBUG: flip ts/seq: last 60.798367/2884, current 60.881062/2894: elapsed=82694.0us expected=81888.8us +- 409.4us, error 1.0% (kms_flip:2059) DEBUG: inconsistent flip ts/seq: last 60.798367/2884, current 60.881062/2894: elapsed=82694.0us expected=81888.8us (kms_flip:2059) DEBUG: name = vblank last_ts = 60.872787 last_received_ts = 60.872620 last_seq = 2893 current_ts = 60.955482 current_received_ts = 60.955360 current_seq = 2903 count = 70 seq_step = 10 (kms_flip:2059) DEBUG: vblank ts/seq: last 60.872787/2893, current 60.955482/2903: elapsed=82694.0us expected=81888.8us +- 409.4us, error 1.0% (kms_flip:2059) DEBUG: inconsistent vblank ts/seq: last 60.872787/2893, current 60.955482/2903: elapsed=82694.0us expected=81888.8us (kms_flip:2059) DEBUG: name = flip last_ts = 60.881062 last_received_ts = 60.955414 last_seq = 2894 current_ts = 60.963753 current_received_ts = 61.038128 current_seq = 2904 count = 71 seq_step = 1 (kms_flip:2059) DEBUG: flip ts/seq: last 60.881062/2894, current 60.963753/2904: elapsed=82692.0us expected=81888.8us +- 409.4us, error 1.0% (kms_flip:2059) DEBUG: inconsistent flip ts/seq: last 60.881062/2894, current 60.963753/2904: elapsed=82692.0us expected=81888.8us (kms_flip:2059) DEBUG: name = vblank last_ts = 60.955482 last_received_ts = 60.955360 last_seq = 2903 current_ts = 61.038174 current_received_ts = 61.038078 current_seq = 2913 count = 71 seq_step = 10 (kms_flip:2059) DEBUG: vblank ts/seq: last 60.955482/2903, current 61.038174/2913: elapsed=82690.0us expected=81888.8us +- 409.4us, error 1.0% (kms_flip:2059) DEBUG: inconsistent vblank ts/seq: last 60.955482/2903, current 61.038174/2913: elapsed=82690.0us expected=81888.8us (kms_flip:2059) DEBUG: name = flip last_ts = 60.963753 last_received_ts = 61.038128 last_seq = 2904 current_ts = 61.046448 current_received_ts = 61.120811 current_seq = 2914 count = 72 seq_step = 1 (kms_flip:2059) DEBUG: flip ts/seq: last 60.963753/2904, current 61.046448/2914: elapsed=82692.0us expected=81888.8us +- 409.4us, error 1.0% (kms_flip:2059) DEBUG: inconsistent flip ts/seq: last 60.963753/2904, current 61.046448/2914: elapsed=82692.0us expected=81888.8us (kms_flip:2059) DEBUG: name = vblank last_ts = 61.038174 last_received_ts = 61.038078 last_seq = 2913 current_ts = 61.120861 current_received_ts = 61.120762 current_seq = 2923 count = 72 seq_step = 10 (kms_flip:2059) DEBUG: vblank ts/seq: last 61.038174/2913, current 61.120861/2923: elapsed=82688.0us expected=81888.8us +- 409.4us, error 1.0% (kms_flip:2059) DEBUG: inconsistent vblank ts/seq: last 61.038174/2913, current 61.120861/2923: elapsed=82688.0us expected=81888.8us (kms_flip:2059) DEBUG: name = flip last_ts = 61.046448 last_received_ts = 61.120811 last_seq = 2914 current_ts = 61.129135 current_received_ts = 61.203518 current_seq = 2924 count = 73 seq_step = 1 (kms_flip:2059) DEBUG: flip ts/seq: last 61.046448/2914, current 61.129135/2924: elapsed=82688.0us expected=81888.8us +- 409.4us, error 1.0% (kms_flip:2059) DEBUG: inconsistent flip ts/seq: last 61.046448/2914, current 61.129135/2924: elapsed=82688.0us expected=81888.8us (kms_flip:2059) DEBUG: name = vblank last_ts = 61.120861 last_received_ts = 61.120762 last_seq = 2923 current_ts = 61.203552 current_received_ts = 61.203465 current_seq = 2933 count = 73 seq_step = 10 (kms_flip:2059) DEBUG: vblank ts/seq: last 61.120861/2923, current 61.203552/2933: elapsed=82693.0us expected=81888.8us +- 409.4us, error 1.0% (kms_flip:2059) DEBUG: inconsistent vblank ts/seq: last 61.120861/2923, current 61.203552/2933: elapsed=82693.0us expected=81888.8us (kms_flip:2059) DEBUG: name = flip last_ts = 61.129135 last_received_ts = 61.203518 last_seq = 2924 current_ts = 61.211826 current_received_ts = 61.286171 current_seq = 2934 count = 74 seq_step = 1 (kms_flip:2059) DEBUG: flip ts/seq: last 61.129135/2924, current 61.211826/2934: elapsed=82693.0us expected=81888.8us +- 409.4us, error 1.0% (kms_flip:2059) DEBUG: inconsistent flip ts/seq: last 61.129135/2924, current 61.211826/2934: elapsed=82693.0us expected=81888.8us (kms_flip:2059) DEBUG: name = vblank last_ts = 61.203552 last_received_ts = 61.203465 last_seq = 2933 current_ts = 61.286243 current_received_ts = 61.286118 current_seq = 2943 count = 74 seq_step = 10 (kms_flip:2059) DEBUG: vblank ts/seq: last 61.203552/2933, current 61.286243/2943: elapsed=82691.0us expected=81888.8us +- 409.4us, error 1.0% (kms_flip:2059) DEBUG: inconsistent vblank ts/seq: last 61.203552/2933, current 61.286243/2943: elapsed=82691.0us expected=81888.8us (kms_flip:2059) DEBUG: name = flip last_ts = 61.211826 last_received_ts = 61.286171 last_seq = 2934 current_ts = 61.294514 current_received_ts = 61.368774 current_seq = 2944 count = 75 seq_step = 1 (kms_flip:2059) DEBUG: flip ts/seq: last 61.211826/2934, current 61.294514/2944: elapsed=82687.0us expected=81888.8us +- 409.4us, error 1.0% (kms_flip:2059) DEBUG: inconsistent flip ts/seq: last 61.211826/2934, current 61.294514/2944: elapsed=82687.0us expected=81888.8us (kms_flip:2059) DEBUG: name = vblank last_ts = 61.286243 last_received_ts = 61.286118 last_seq = 2943 current_ts = 61.368938 current_received_ts = 61.368725 current_seq = 2953 count = 75 seq_step = 10 (kms_flip:2059) DEBUG: vblank ts/seq: last 61.286243/2943, current 61.368938/2953: elapsed=82695.0us expected=81888.8us +- 409.4us, error 1.0% (kms_flip:2059) DEBUG: inconsistent vblank ts/seq: last 61.286243/2943, current 61.368938/2953: elapsed=82695.0us expected=81888.8us (kms_flip:2059) DEBUG: name = flip last_ts = 61.294514 last_received_ts = 61.368774 last_seq = 2944 current_ts = 61.377213 current_received_ts = 61.451557 current_seq = 2954 count = 76 seq_step = 1 (kms_flip:2059) DEBUG: flip ts/seq: last 61.294514/2944, current 61.377213/2954: elapsed=82698.0us expected=81888.8us +- 409.4us, error 1.0% (kms_flip:2059) DEBUG: inconsistent flip ts/seq: last 61.294514/2944, current 61.377213/2954: elapsed=82698.0us expected=81888.8us (kms_flip:2059) DEBUG: name = vblank last_ts = 61.368938 last_received_ts = 61.368725 last_seq = 2953 current_ts = 61.451633 current_received_ts = 61.451508 current_seq = 2963 count = 76 seq_step = 10 (kms_flip:2059) DEBUG: vblank ts/seq: last 61.368938/2953, current 61.451633/2963: elapsed=82694.0us expected=81888.8us +- 409.4us, error 1.0% (kms_flip:2059) DEBUG: inconsistent vblank ts/seq: last 61.368938/2953, current 61.451633/2963: elapsed=82694.0us expected=81888.8us (kms_flip:2059) DEBUG: name = flip last_ts = 61.377213 last_received_ts = 61.451557 last_seq = 2954 current_ts = 61.459900 current_received_ts = 61.534275 current_seq = 2964 count = 77 seq_step = 1 (kms_flip:2059) DEBUG: flip ts/seq: last 61.377213/2954, current 61.459900/2964: elapsed=82687.0us expected=81888.8us +- 409.4us, error 1.0% (kms_flip:2059) DEBUG: inconsistent flip ts/seq: last 61.377213/2954, current 61.459900/2964: elapsed=82687.0us expected=81888.8us (kms_flip:2059) DEBUG: name = vblank last_ts = 61.451633 last_received_ts = 61.451508 last_seq = 2963 current_ts = 61.534321 current_received_ts = 61.534222 current_seq = 2973 count = 77 seq_step = 10 (kms_flip:2059) DEBUG: vblank ts/seq: last 61.451633/2963, current 61.534321/2973: elapsed=82688.0us expected=81888.8us +- 409.4us, error 1.0% (kms_flip:2059) DEBUG: inconsistent vblank ts/seq: last 61.451633/2963, current 61.534321/2973: elapsed=82688.0us expected=81888.8us (kms_flip:2059) DEBUG: name = flip last_ts = 61.459900 last_received_ts = 61.534275 last_seq = 2964 current_ts = 61.542595 current_received_ts = 61.616669 current_seq = 2974 count = 78 seq_step = 1 (kms_flip:2059) DEBUG: flip ts/seq: last 61.459900/2964, current 61.542595/2974: elapsed=82695.0us expected=81888.8us +- 409.4us, error 1.0% (kms_flip:2059) DEBUG: inconsistent flip ts/seq: last 61.459900/2964, current 61.542595/2974: elapsed=82695.0us expected=81888.8us (kms_flip:2059) DEBUG: name = vblank last_ts = 61.534321 last_received_ts = 61.534222 last_seq = 2973 current_ts = 61.617012 current_received_ts = 61.616646 current_seq = 2983 count = 78 seq_step = 10 (kms_flip:2059) DEBUG: vblank ts/seq: last 61.534321/2973, current 61.617012/2983: elapsed=82690.0us expected=81888.8us +- 409.4us, error 1.0% (kms_flip:2059) DEBUG: inconsistent vblank ts/seq: last 61.534321/2973, current 61.617012/2983: elapsed=82690.0us expected=81888.8us (kms_flip:2059) DEBUG: name = flip last_ts = 61.542595 last_received_ts = 61.616669 last_seq = 2974 current_ts = 61.625282 current_received_ts = 61.699692 current_seq = 2984 count = 79 seq_step = 1 (kms_flip:2059) DEBUG: flip ts/seq: last 61.542595/2974, current 61.625282/2984: elapsed=82689.0us expected=81888.8us +- 409.4us, error 1.0% (kms_flip:2059) DEBUG: inconsistent flip ts/seq: last 61.542595/2974, current 61.625282/2984: elapsed=82689.0us expected=81888.8us (kms_flip:2059) DEBUG: name = vblank last_ts = 61.617012 last_received_ts = 61.616646 last_seq = 2983 current_ts = 61.699780 current_received_ts = 61.699650 current_seq = 2993 count = 79 seq_step = 10 (kms_flip:2059) DEBUG: vblank ts/seq: last 61.617012/2983, current 61.699780/2993: elapsed=82767.0us expected=81888.8us +- 409.4us, error 1.1% (kms_flip:2059) DEBUG: inconsistent vblank ts/seq: last 61.617012/2983, current 61.699780/2993: elapsed=82767.0us expected=81888.8us (kms_flip:2059) DEBUG: name = flip last_ts = 61.625282 last_received_ts = 61.699692 last_seq = 2984 current_ts = 61.708061 current_received_ts = 61.782471 current_seq = 2994 count = 80 seq_step = 1 (kms_flip:2059) DEBUG: flip ts/seq: last 61.625282/2984, current 61.708061/2994: elapsed=82778.0us expected=81888.8us +- 409.4us, error 1.1% (kms_flip:2059) DEBUG: inconsistent flip ts/seq: last 61.625282/2984, current 61.708061/2994: elapsed=82778.0us expected=81888.8us (kms_flip:2059) DEBUG: name = vblank last_ts = 61.699780 last_received_ts = 61.699650 last_seq = 2993 current_ts = 61.782555 current_received_ts = 61.782421 current_seq = 3003 count = 80 seq_step = 10 (kms_flip:2059) DEBUG: vblank ts/seq: last 61.699780/2993, current 61.782555/3003: elapsed=82776.0us expected=81888.8us +- 409.4us, error 1.1% (kms_flip:2059) DEBUG: inconsistent vblank ts/seq: last 61.699780/2993, current 61.782555/3003: elapsed=82776.0us expected=81888.8us (kms_flip:2059) DEBUG: name = flip last_ts = 61.708061 last_received_ts = 61.782471 last_seq = 2994 current_ts = 61.790833 current_received_ts = 61.865246 current_seq = 3004 count = 81 seq_step = 1 (kms_flip:2059) DEBUG: flip ts/seq: last 61.708061/2994, current 61.790833/3004: elapsed=82773.0us expected=81888.8us +- 409.4us, error 1.1% (kms_flip:2059) DEBUG: inconsistent flip ts/seq: last 61.708061/2994, current 61.790833/3004: elapsed=82773.0us expected=81888.8us (kms_flip:2059) DEBUG: name = vblank last_ts = 61.782555 last_received_ts = 61.782421 last_seq = 3003 current_ts = 61.865326 current_received_ts = 61.865196 current_seq = 3013 count = 81 seq_step = 10 (kms_flip:2059) DEBUG: vblank ts/seq: last 61.782555/3003, current 61.865326/3013: elapsed=82770.0us expected=81888.8us +- 409.4us, error 1.1% (kms_flip:2059) DEBUG: inconsistent vblank ts/seq: last 61.782555/3003, current 61.865326/3013: elapsed=82770.0us expected=81888.8us (kms_flip:2059) DEBUG: name = flip last_ts = 61.790833 last_received_ts = 61.865246 last_seq = 3004 current_ts = 61.873608 current_received_ts = 61.948048 current_seq = 3014 count = 82 seq_step = 1 (kms_flip:2059) DEBUG: flip ts/seq: last 61.790833/3004, current 61.873608/3014: elapsed=82773.0us expected=81888.8us +- 409.4us, error 1.1% (kms_flip:2059) DEBUG: inconsistent flip ts/seq: last 61.790833/3004, current 61.873608/3014: elapsed=82773.0us expected=81888.8us (kms_flip:2059) DEBUG: name = vblank last_ts = 61.865326 last_received_ts = 61.865196 last_seq = 3013 current_ts = 61.948105 current_received_ts = 61.947968 current_seq = 3023 count = 82 seq_step = 10 (kms_flip:2059) DEBUG: vblank ts/seq: last 61.865326/3013, current 61.948105/3023: elapsed=82779.0us expected=81888.8us +- 409.4us, error 1.1% (kms_flip:2059) DEBUG: inconsistent vblank ts/seq: last 61.865326/3013, current 61.948105/3023: elapsed=82779.0us expected=81888.8us (kms_flip:2059) DEBUG: name = flip last_ts = 61.873608 last_received_ts = 61.948048 last_seq = 3014 current_ts = 61.956383 current_received_ts = 62.030792 current_seq = 3024 count = 83 seq_step = 1 (kms_flip:2059) DEBUG: flip ts/seq: last 61.873608/3014, current 61.956383/3024: elapsed=82775.0us expected=81888.8us +- 409.4us, error 1.1% (kms_flip:2059) DEBUG: inconsistent flip ts/seq: last 61.873608/3014, current 61.956383/3024: elapsed=82775.0us expected=81888.8us (kms_flip:2059) DEBUG: name = vblank last_ts = 61.948105 last_received_ts = 61.947968 last_seq = 3023 current_ts = 62.030872 current_received_ts = 62.030739 current_seq = 3033 count = 83 seq_step = 10 (kms_flip:2059) DEBUG: vblank ts/seq: last 61.948105/3023, current 62.030872/3033: elapsed=82771.0us expected=81888.8us +- 409.4us, error 1.1% (kms_flip:2059) DEBUG: inconsistent vblank ts/seq: last 61.948105/3023, current 62.030872/3033: elapsed=82771.0us expected=81888.8us (kms_flip:2059) DEBUG: name = flip last_ts = 61.956383 last_received_ts = 62.030792 last_seq = 3024 current_ts = 62.039150 current_received_ts = 62.113445 current_seq = 3034 count = 84 seq_step = 1 (kms_flip:2059) DEBUG: flip ts/seq: last 61.956383/3024, current 62.039150/3034: elapsed=82770.0us expected=81888.8us +- 409.4us, error 1.1% (kms_flip:2059) DEBUG: inconsistent flip ts/seq: last 61.956383/3024, current 62.039150/3034: elapsed=82770.0us expected=81888.8us (kms_flip:2059) DEBUG: name = vblank last_ts = 62.030872 last_received_ts = 62.030739 last_seq = 3033 current_ts = 62.113644 current_received_ts = 62.113396 current_seq = 3043 count = 84 seq_step = 10 (kms_flip:2059) DEBUG: vblank ts/seq: last 62.030872/3033, current 62.113644/3043: elapsed=82771.0us expected=81888.8us +- 409.4us, error 1.1% (kms_flip:2059) DEBUG: inconsistent vblank ts/seq: last 62.030872/3033, current 62.113644/3043: elapsed=82771.0us expected=81888.8us (kms_flip:2059) DEBUG: name = flip last_ts = 62.039150 last_received_ts = 62.113445 last_seq = 3034 current_ts = 62.121922 current_received_ts = 62.196339 current_seq = 3044 count = 85 seq_step = 1 (kms_flip:2059) DEBUG: flip ts/seq: last 62.039150/3034, current 62.121922/3044: elapsed=82771.0us expected=81888.8us +- 409.4us, error 1.1% (kms_flip:2059) DEBUG: inconsistent flip ts/seq: last 62.039150/3034, current 62.121922/3044: elapsed=82771.0us expected=81888.8us (kms_flip:2059) DEBUG: name = vblank last_ts = 62.113644 last_received_ts = 62.113396 last_seq = 3043 current_ts = 62.196423 current_received_ts = 62.196285 current_seq = 3053 count = 85 seq_step = 10 (kms_flip:2059) DEBUG: vblank ts/seq: last 62.113644/3043, current 62.196423/3053: elapsed=82776.0us expected=81888.8us +- 409.4us, error 1.1% (kms_flip:2059) DEBUG: inconsistent vblank ts/seq: last 62.113644/3043, current 62.196423/3053: elapsed=82776.0us expected=81888.8us (kms_flip:2059) DEBUG: name = flip last_ts = 62.121922 last_received_ts = 62.196339 last_seq = 3044 current_ts = 62.204700 current_received_ts = 62.279121 current_seq = 3054 count = 86 seq_step = 1 (kms_flip:2059) DEBUG: flip ts/seq: last 62.121922/3044, current 62.204700/3054: elapsed=82779.0us expected=81888.8us +- 409.4us, error 1.1% (kms_flip:2059) DEBUG: inconsistent flip ts/seq: last 62.121922/3044, current 62.204700/3054: elapsed=82779.0us expected=81888.8us (kms_flip:2059) DEBUG: name = vblank last_ts = 62.196423 last_received_ts = 62.196285 last_seq = 3053 current_ts = 62.279194 current_received_ts = 62.279072 current_seq = 3063 count = 86 seq_step = 10 (kms_flip:2059) DEBUG: vblank ts/seq: last 62.196423/3053, current 62.279194/3063: elapsed=82773.0us expected=81888.8us +- 409.4us, error 1.1% (kms_flip:2059) DEBUG: inconsistent vblank ts/seq: last 62.196423/3053, current 62.279194/3063: elapsed=82773.0us expected=81888.8us (kms_flip:2059) DEBUG: name = flip last_ts = 62.204700 last_received_ts = 62.279121 last_seq = 3054 current_ts = 62.287472 current_received_ts = 62.361885 current_seq = 3064 count = 87 seq_step = 1 (kms_flip:2059) DEBUG: flip ts/seq: last 62.204700/3054, current 62.287472/3064: elapsed=82771.0us expected=81888.8us +- 409.4us, error 1.1% (kms_flip:2059) DEBUG: inconsistent flip ts/seq: last 62.204700/3054, current 62.287472/3064: elapsed=82771.0us expected=81888.8us (kms_flip:2059) DEBUG: name = vblank last_ts = 62.279194 last_received_ts = 62.279072 last_seq = 3063 current_ts = 62.361965 current_received_ts = 62.361832 current_seq = 3073 count = 87 seq_step = 10 (kms_flip:2059) DEBUG: vblank ts/seq: last 62.279194/3063, current 62.361965/3073: elapsed=82773.0us expected=81888.8us +- 409.4us, error 1.1% (kms_flip:2059) DEBUG: inconsistent vblank ts/seq: last 62.279194/3063, current 62.361965/3073: elapsed=82773.0us expected=81888.8us (kms_flip:2059) DEBUG: name = flip last_ts = 62.287472 last_received_ts = 62.361885 last_seq = 3064 current_ts = 62.370247 current_received_ts = 62.444660 current_seq = 3074 count = 88 seq_step = 1 (kms_flip:2059) DEBUG: flip ts/seq: last 62.287472/3064, current 62.370247/3074: elapsed=82774.0us expected=81888.8us +- 409.4us, error 1.1% (kms_flip:2059) DEBUG: inconsistent flip ts/seq: last 62.287472/3064, current 62.370247/3074: elapsed=82774.0us expected=81888.8us (kms_flip:2059) DEBUG: name = vblank last_ts = 62.361965 last_received_ts = 62.361832 last_seq = 3073 current_ts = 62.444736 current_received_ts = 62.444607 current_seq = 3083 count = 88 seq_step = 10 (kms_flip:2059) DEBUG: vblank ts/seq: last 62.361965/3073, current 62.444736/3083: elapsed=82771.0us expected=81888.8us +- 409.4us, error 1.1% (kms_flip:2059) DEBUG: inconsistent vblank ts/seq: last 62.361965/3073, current 62.444736/3083: elapsed=82771.0us expected=81888.8us (kms_flip:2059) DEBUG: name = flip last_ts = 62.370247 last_received_ts = 62.444660 last_seq = 3074 current_ts = 62.453014 current_received_ts = 62.527435 current_seq = 3084 count = 89 seq_step = 1 (kms_flip:2059) DEBUG: flip ts/seq: last 62.370247/3074, current 62.453014/3084: elapsed=82769.0us expected=81888.8us +- 409.4us, error 1.1% (kms_flip:2059) DEBUG: inconsistent flip ts/seq: last 62.370247/3074, current 62.453014/3084: elapsed=82769.0us expected=81888.8us (kms_flip:2059) DEBUG: name = vblank last_ts = 62.444736 last_received_ts = 62.444607 last_seq = 3083 current_ts = 62.527512 current_received_ts = 62.527386 current_seq = 3093 count = 89 seq_step = 10 (kms_flip:2059) DEBUG: vblank ts/seq: last 62.444736/3083, current 62.527512/3093: elapsed=82774.0us expected=81888.8us +- 409.4us, error 1.1% (kms_flip:2059) DEBUG: inconsistent vblank ts/seq: last 62.444736/3083, current 62.527512/3093: elapsed=82774.0us expected=81888.8us (kms_flip:2059) DEBUG: name = flip last_ts = 62.453014 last_received_ts = 62.527435 last_seq = 3084 current_ts = 62.535789 current_received_ts = 62.610214 current_seq = 3094 count = 90 seq_step = 1 (kms_flip:2059) DEBUG: flip ts/seq: last 62.453014/3084, current 62.535789/3094: elapsed=82774.0us expected=81888.8us +- 409.4us, error 1.1% (kms_flip:2059) DEBUG: inconsistent flip ts/seq: last 62.453014/3084, current 62.535789/3094: elapsed=82774.0us expected=81888.8us (kms_flip:2059) DEBUG: name = vblank last_ts = 62.527512 last_received_ts = 62.527386 last_seq = 3093 current_ts = 62.610291 current_received_ts = 62.610165 current_seq = 3103 count = 90 seq_step = 10 (kms_flip:2059) DEBUG: vblank ts/seq: last 62.527512/3093, current 62.610291/3103: elapsed=82778.0us expected=81888.8us +- 409.4us, error 1.1% (kms_flip:2059) DEBUG: inconsistent vblank ts/seq: last 62.527512/3093, current 62.610291/3103: elapsed=82778.0us expected=81888.8us (kms_flip:2059) INFO: Event flip: expected 915, counted 910, passrate = 35.16%, encoder type 2 (kms_flip:2059) DEBUG: dropped frames, expected 915, counted 910, passrate = 35.16%, encoder type 2 (kms_flip:2059) INFO: Event vblank: expected 915, counted 910, passrate = 34.07%, encoder type 2 (kms_flip:2059) DEBUG: dropped frames, expected 915, counted 910, passrate = 34.07%, encoder type 2 (kms_flip:2059) CRITICAL: Test assertion failure function __run_test_on_crtc_set, file ../tests/kms_flip.c:1707: (kms_flip:2059) CRITICAL: Failed assertion: !retried (kms_flip:2059) igt_core-INFO: Stack trace: (kms_flip:2059) igt_core-INFO: #0 ../lib/igt_core.c:2075 __igt_fail_assert() (kms_flip:2059) igt_core-INFO: #1 ../tests/kms_flip.c:428 run_test_on_crtc_set.constprop.0() (kms_flip:2059) igt_core-INFO: #2 ../tests/kms_flip.c:1887 run_test() (kms_flip:2059) igt_core-INFO: #3 ../tests/kms_flip.c:2120 __igt_unique____real_main2043() (kms_flip:2059) igt_core-INFO: #4 ../tests/kms_flip.c:2043 main() (kms_flip:2059) igt_core-INFO: #5 [__libc_init_first+0x8a] (kms_flip:2059) igt_core-INFO: #6 [__libc_start_main+0x8b] (kms_flip:2059) igt_core-INFO: #7 [_start+0x25] **** END **** Dynamic subtest A-HDMI-A1: FAIL (19.106s) |
| Dmesg |
<6> [43.917156] Console: switching to colour dummy device 80x25
<6> [43.917223] [IGT] kms_flip: executing
<7> [43.919252] i915 0000:00:02.0: [drm:i915_gem_open [i915]]
<7> [43.920045] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc]
<7> [43.920332] i915 0000:00:02.0: [drm:i915_gem_open [i915]]
<7> [43.930323] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] [CONNECTOR:597:DP-1]
<7> [43.930333] i915 0000:00:02.0: [drm:intel_dp_detect [i915]] [CONNECTOR:597:DP-1]
<7> [43.934782] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] [CONNECTOR:597:DP-1] disconnected
<7> [43.935274] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] [CONNECTOR:607:DP-2]
<7> [43.935280] i915 0000:00:02.0: [drm:intel_dp_detect [i915]] [CONNECTOR:607:DP-2]
<7> [43.935619] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] [CONNECTOR:607:DP-2] disconnected
<7> [43.936116] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] [CONNECTOR:616:DP-3]
<7> [43.936121] i915 0000:00:02.0: [drm:intel_dp_detect [i915]] [CONNECTOR:616:DP-3]
<7> [43.936466] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] [CONNECTOR:616:DP-3] disconnected
<7> [43.936951] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] [CONNECTOR:625:DP-4]
<7> [43.936955] i915 0000:00:02.0: [drm:intel_dp_detect [i915]] [CONNECTOR:625:DP-4]
<7> [43.937322] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] [CONNECTOR:625:DP-4] disconnected
<7> [43.938000] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] [CONNECTOR:587:HDMI-A-1]
<7> [43.938022] i915 0000:00:02.0: [drm:intel_hdmi_detect [i915]] [CONNECTOR:587:HDMI-A-1]
<7> [43.965262] i915 0000:00:02.0: [drm:update_display_info.part.0] [CONNECTOR:587:HDMI-A-1] Supported Monitor Refresh rate range is 0 Hz - 0 Hz
<7> [43.965272] i915 0000:00:02.0: [drm:update_display_info.part.0] [CONNECTOR:587:HDMI-A-1] HDMI: DVI dual 0, max TMDS clock 300000 kHz
<7> [43.965275] i915 0000:00:02.0: [drm:update_display_info.part.0] [CONNECTOR:587:HDMI-A-1] No deep color support on this HDMI sink.
<7> [43.965278] i915 0000:00:02.0: [drm:update_display_info.part.0] [CONNECTOR:587:HDMI-A-1] HF-VSDB: max TMDS clock: 600000 KHz, HDMI 2.1 support: no, DSC 1.2 support: no
<7> [43.965281] i915 0000:00:02.0: [drm:update_display_info.part.0] [CONNECTOR:587:HDMI-A-1] Assigning EDID-1.4 digital sink color depth as 8 bpc.
<7> [43.965284] i915 0000:00:02.0: [drm:update_display_info.part.0] [CONNECTOR:587:HDMI-A-1] ELD monitor fitHeadlessGS
<7> [43.965286] i915 0000:00:02.0: [drm:update_display_info.part.0] [CONNECTOR:587:HDMI-A-1] HDMI: latency present 0 0, video latency 0 0, audio latency 0 0
<7> [43.965289] i915 0000:00:02.0: [drm:update_display_info.part.0] [CONNECTOR:587:HDMI-A-1] ELD size 64, SAD count 10
<7> [43.965760] i915 0000:00:02.0: [drm:do_gmbus_xfer [i915]] GMBUS [i915 gmbus dpb] NAK for addr: 0040 w(1)
<7> [43.965906] i915 0000:00:02.0: [drm:do_gmbus_xfer [i915]] GMBUS [i915 gmbus dpb] NAK on first message, retry
<7> [43.966522] i915 0000:00:02.0: [drm:do_gmbus_xfer [i915]] GMBUS [i915 gmbus dpb] NAK for addr: 0040 w(1)
<7> [43.966753] i915 0000:00:02.0: [drm:drm_dp_dual_mode_detect [drm_display_helper]] DP dual mode HDMI ID: (err -6)
<7> [43.967668] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] [CONNECTOR:587:HDMI-A-1] probed modes:
<7> [43.967674] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "1920x1080": 120 285500 1920 1968 2000 2080 1080 1083 1088 1144 0x48 0x5
<7> [43.967678] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "4096x2160": 60 594000 4096 4184 4272 4400 2160 2168 2178 2250 0x40 0x5
<7> [43.967683] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "4096x2160": 60 593407 4096 4184 4272 4400 2160 2168 2178 2250 0x40 0x5
<7> [43.967686] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "4096x2160": 30 297000 4096 4184 4272 4400 2160 2168 2178 2250 0x40 0x5
<7> [43.967690] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "4096x2160": 30 296703 4096 4184 4272 4400 2160 2168 2178 2250 0x40 0x5
<7> [43.967694] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "3840x2160": 60 594000 3840 4016 4104 4400 2160 2168 2178 2250 0x40 0x5
<7> [43.967698] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "3840x2160": 60 593407 3840 4016 4104 4400 2160 2168 2178 2250 0x40 0x5
<7> [43.967702] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "3840x2160": 30 297000 3840 4016 4104 4400 2160 2168 2178 2250 0x40 0x5
<7> [43.967705] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "3840x2160": 30 296703 3840 4016 4104 4400 2160 2168 2178 2250 0x40 0x5
<7> [43.967709] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "3840x2160": 25 297000 3840 4896 4984 5280 2160 2168 2178 2250 0x40 0x5
<7> [43.967713] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "3840x2160": 24 297000 3840 5116 5204 5500 2160 2168 2178 2250 0x40 0x5
<7> [43.967716] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "3840x2160": 24 296703 3840 5116 5204 5500 2160 2168 2178 2250 0x40 0x5
<7> [43.967720] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "3440x1440": 90 476140 3440 3448 3480 3520 1440 1441 1449 1503 0x40 0xa
<7> [43.967724] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "2560x1600": 75 443250 2560 2768 3048 3536 1600 1603 1609 1672 0x40 0x6
<7> [43.967727] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "2560x1600": 60 348500 2560 2752 3032 3504 1600 1603 1609 1658 0x40 0x6
<7> [43.967731] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "2560x1440": 120 497770 2560 2608 2640 2720 1440 1443 1448 1525 0x40 0xa
<7> [43.967735] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "2048x1536": 60 267027 2048 2200 2424 2800 1536 1537 1540 1589 0x0 0x6
<7> [43.967738] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "2560x1080": 120 495000 2560 3108 3152 3300 1080 1084 1089 1250 0x40 0x5
<7> [43.967742] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "2560x1080": 120 494505 2560 3108 3152 3300 1080 1084 1089 1250 0x40 0x5
<7> [43.967746] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "1920x1440": 75 297000 1920 2064 2288 2640 1440 1441 1444 1500 0x40 0x6
<7> [43.967750] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "1920x1440": 60 234000 1920 2048 2256 2600 1440 1441 1444 1500 0x40 0x6
<7> [43.967753] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "2160x1200": 90 261420 2160 2208 2240 2320 1200 1203 1208 1252 0x40 0xa
<7> [43.967757] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "1856x1392": 75 288000 1856 1984 2208 2560 1392 1393 1396 1500 0x40 0x6
<7> [43.967761] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "1856x1392": 60 218250 1856 1952 2176 2528 1392 1393 1396 1439 0x40 0x6
<7> [43.967764] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "1792x1344": 75 261000 1792 1888 2104 2456 1344 1345 1348 1417 0x40 0x6
<7> [43.967768] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "1792x1344": 60 204750 1792 1920 2120 2448 1344 1345 1348 1394 0x40 0x6
<7> [43.967772] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "2048x1152": 60 162000 2048 2074 2154 2250 1152 1153 1156 1200 0x40 0x5
<7> [43.967776] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "1920x1200": 120 317250 1920 1968 2000 2080 1200 1203 1209 1271 0x40 0xa
<7> [43.967779] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "1920x1200": 75 245250 1920 2056 2264 2608 1200 1203 1209 1255 0x40 0x6
<7> [43.967783] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "1920x1200": 60 193250 1920 2056 2256 2592 1200 1203 1209 1245 0x40 0x6
<7> [43.967787] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "1920x1080": 120 297000 1920 2008 2052 2200 1080 1084 1089 1125 0x40 0x5
<7> [43.967790] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "1920x1080": 120 296703 1920 2008 2052 2200 1080 1084 1089 1125 0x40 0x5
<7> [43.967794] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "1920x1080": 75 220597 1920 2056 2264 2608 1080 1081 1084 1128 0x0 0x6
<7> [43.967798] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "1920x1080": 60 148500 1920 2008 2052 2200 1080 1084 1089 1125 0x40 0x5
<7> [43.967801] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "1920x1080": 60 148352 1920 2008 2052 2200 1080 1084 1089 1125 0x40 0x5
<7> [43.967805] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "1600x1200": 75 202500 1600 1664 1856 2160 1200 1201 1204 1250 0x40 0x5
<7> [43.967809] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "1600x1200": 70 189000 1600 1664 1856 2160 1200 1201 1204 1250 0x40 0x5
<7> [43.967812] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "1600x1200": 65 175500 1600 1664 1856 2160 1200 1201 1204 1250 0x40 0x5
<7> [43.967816] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "1600x1200": 60 162000 1600 1664 1856 2160 1200 1201 1204 1250 0x40 0x5
<7> [43.967820] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "1680x1050": 75 187000 1680 1800 1976 2272 1050 1053 1059 1099 0x40 0x6
<7> [43.967823] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "1680x1050": 60 146250 1680 1784 1960 2240 1050 1053 1059 1089 0x40 0x6
<7> [43.967827] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "1680x945": 60 131481 1680 1784 1960 2240 945 946 949 978 0x0 0x6
<7> [43.967831] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "1400x1050": 75 156000 1400 1504 1648 1896 1050 1053 1057 1099 0x40 0x6
<7> [43.967835] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "1400x1050": 60 121750 1400 1488 1632 1864 1050 1053 1057 1089 0x40 0x6
<7> [43.967838] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "1600x900": 60 108000 1600 1624 1704 1800 900 901 904 1000 0x40 0x5
<7> [43.967842] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "1280x1024": 75 135000 1280 1296 1440 1688 1024 1025 1028 1066 0x40 0x5
<7> [43.967846] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "1280x1024": 60 108000 1280 1328 1440 1688 1024 1025 1028 1066 0x40 0x5
<7> [43.967849] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "1440x900": 75 136750 1440 1536 1688 1936 900 903 909 942 0x40 0x6
<7> [43.967853] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "1440x900": 60 106500 1440 1520 1672 1904 900 903 909 934 0x40 0x6
<7> [43.967857] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "1280x960": 60 108000 1280 1376 1488 1800 960 961 964 1000 0x40 0x5
<7> [43.967860] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "1360x768": 60 84963 1366 1431 1567 1776 768 771 781 798 0x0 0x6
<7> [43.967864] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "1360x768": 60 85500 1360 1424 1536 1792 768 771 777 795 0x40 0x5
<7> [43.967868] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "1280x800": 75 106500 1280 1360 1488 1696 800 803 809 838 0x40 0x6
<7> [43.967871] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "1280x800": 60 83500 1280 1352 1480 1680 800 803 809 831 0x40 0x6
<7> [43.967875] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "1152x864": 75 108000 1152 1216 1344 1600 864 865 868 900 0x40 0x5
<7> [43.967879] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "1280x768": 75 102250 1280 1360 1488 1696 768 771 778 805 0x40 0x6
<7> [43.967882] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "1280x768": 60 79500 1280 1344 1472 1664 768 771 778 798 0x40 0x6
<7> [43.967886] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "1280x720": 60 74250 1280 1390 1430 1650 720 725 730 750 0x40 0x5
<7> [43.967890] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "1024x768": 75 78750 1024 1040 1136 1312 768 769 772 800 0x40 0x5
<7> [43.967893] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "1024x768": 70 75000 1024 1048 1184 1328 768 771 777 806 0x40 0xa
<7> [43.967897] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "1024x768": 60 65000 1024 1048 1184 1344 768 771 777 806 0x40 0xa
<7> [43.967901] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "1024x576": 60 46970 1024 1064 1168 1312 576 577 580 597 0x0 0x6
<7> [43.967904] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "832x624": 75 57284 832 864 928 1152 624 625 628 667 0x40 0xa
<7> [43.967908] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "800x600": 75 49500 800 816 896 1056 600 601 604 625 0x40 0x5
<7> [43.967912] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "800x600": 72 50000 800 856 976 1040 600 637 643 666 0x40 0x5
<7> [43.967915] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "800x600": 60 40000 800 840 968 1056 600 601 605 628 0x40 0x5
<7> [43.967919] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "800x600": 56 36000 800 824 896 1024 600 601 603 625 0x40 0x5
<7> [43.967923] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "848x480": 60 33750 848 864 976 1088 480 486 494 517 0x40 0x5
<7> [43.967926] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "640x480": 75 31500 640 656 720 840 480 481 484 500 0x40 0xa
<7> [43.967930] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "640x480": 73 31500 640 664 704 832 480 489 492 520 0x40 0xa
<7> [43.967934] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "640x480": 60 25200 640 656 752 800 480 490 492 525 0x40 0xa
<7> [43.967938] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "640x480": 60 25175 640 656 752 800 480 490 492 525 0x40 0xa
<7> [43.967941] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "720x400": 70 28320 720 738 846 900 400 412 414 449 0x40 0x6
<7> [43.967985] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] [CONNECTOR:597:DP-1]
<7> [43.967990] i915 0000:00:02.0: [drm:intel_dp_detect [i915]] [CONNECTOR:597:DP-1]
<7> [43.972529] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] [CONNECTOR:597:DP-1] disconnected
<7> [43.972548] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] [CONNECTOR:607:DP-2]
<7> [43.972553] i915 0000:00:02.0: [drm:intel_dp_detect [i915]] [CONNECTOR:607:DP-2]
<7> [43.972873] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] [CONNECTOR:607:DP-2] disconnected
<7> [43.972886] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] [CONNECTOR:616:DP-3]
<7> [43.972890] i915 0000:00:02.0: [drm:intel_dp_detect [i915]] [CONNECTOR:616:DP-3]
<7> [43.973298] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] [CONNECTOR:616:DP-3] disconnected
<7> [43.973322] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] [CONNECTOR:625:DP-4]
<7> [43.973328] i915 0000:00:02.0: [drm:intel_dp_detect [i915]] [CONNECTOR:625:DP-4]
<7> [43.973695] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] [CONNECTOR:625:DP-4] disconnected
<6> [43.974345] [IGT] kms_flip: starting subtest flip-vs-blocking-wf-vblank
<6> [43.977099] [IGT] kms_flip: starting dynamic subtest A-HDMI-A1
<7> [43.977532] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:636]
<7> [43.977627] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:637]
<7> [44.043601] i915 0000:00:02.0: [drm:drm_mode_setcrtc] [CRTC:170:pipe A]
<7> [44.044171] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:170:pipe A] fastset requirement not met in hw.enable (expected yes, found no)
<7> [44.044538] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:170:pipe A] fastset requirement not met in hw.active (expected yes, found no)
<7> [44.044797] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:170:pipe A] fastset requirement not met in cpu_transcoder (expected 0, found -1)
<7> [44.045072] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:170:pipe A] fastset requirement not met in lane_count (expected 4, found 0)
<7> [44.045425] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:170:pipe A] fastset requirement not met in output_types (expected 0x00000040, found 0x00000000)
<7> [44.045755] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:170:pipe A] fastset requirement not met in framestart_delay (expected 1, found 0)
<7> [44.046040] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:170:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hdisplay (expected 1920, found 0)
<7> [44.046324] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:170:pipe A] fastset requirement not met in hw.pipe_mode.crtc_htotal (expected 2080, found 0)
<7> [44.046686] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:170:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hblank_start (expected 1920, found 0)
<7> [44.046947] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:170:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hblank_end (expected 2080, found 0)
<7> [44.047237] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:170:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hsync_start (expected 1968, found 0)
<7> [44.047603] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:170:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hsync_end (expected 2000, found 0)
<7> [44.047876] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:170:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vdisplay (expected 1080, found 0)
<7> [44.048159] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:170:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vblank_start (expected 1080, found 0)
<7> [44.048411] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:170:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vsync_start (expected 1083, found 0)
<7> [44.048701] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:170:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vsync_end (expected 1088, found 0)
<7> [44.048915] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:170:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vtotal (expected 1144, found 0)
<7> [44.049142] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:170:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vblank_end (expected 1144, found 0)
<7> [44.049343] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:170:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hdisplay (expected 1920, found 0)
<7> [44.049618] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:170:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_htotal (expected 2080, found 0)
<7> [44.049840] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:170:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hblank_start (expected 1920, found 0)
<7> [44.050055] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:170:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hblank_end (expected 2080, found 0)
<7> [44.050254] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:170:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hsync_start (expected 1968, found 0)
<7> [44.050540] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:170:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hsync_end (expected 2000, found 0)
<7> [44.050751] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:170:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vdisplay (expected 1080, found 0)
<7> [44.050949] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:170:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vblank_start (expected 1080, found 0)
<7> [44.051174] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:170:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vsync_start (expected 1083, found 0)
<7> [44.051397] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:170:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vsync_end (expected 1088, found 0)
<7> [44.051553] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:170:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vtotal (expected 1144, found 0)
<7> [44.051708] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:170:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vblank_end (expected 1144, found 0)
<7> [44.051865] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:170:pipe A] fastset requirement not met in pixel_multiplier (expected 1, found 0)
<7> [44.052062] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:170:pipe A] fastset requirement not met in hw.adjusted_mode.flags (1) (expected 1, found 0)
<7> [44.052292] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:170:pipe A] fastset requirement not met in hw.adjusted_mode.flags (4) (expected 4, found 0)
<7> [44.052464] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:170:pipe A] fastset requirement not met in has_hdmi_sink (expected yes, found no)
<7> [44.052621] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:170:pipe A] fastset requirement not met in has_infoframe (expected yes, found no)
<7> [44.052778] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:170:pipe A] fastset requirement not met in pipe_bpp (expected 24, found 0)
<7> [44.052933] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:170:pipe A] fastset requirement not met in hw.pipe_mode.crtc_clock (expected 285500, found 0)
<7> [44.053175] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:170:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_clock (expected 285500, found 0)
<7> [44.053348] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:170:pipe A] fastset requirement not met in port_clock (expected 285500, found 0)
<7> [44.053503] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:170:pipe A] fastset requirement not met in infoframes.enable (expected 0x00000071, found 0x00000000)
<7> [44.053659] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:170:pipe A] fastset requirement not met in avi infoframe
<7> [44.053823] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] expected:
<7> [44.054067] i915 0000:00:02.0: HDMI infoframe: Auxiliary Video Information (AVI), version 2, length 13
<7> [44.054071] i915 0000:00:02.0: colorspace: RGB
<7> [44.054073] i915 0000:00:02.0: scan mode: Underscan
<7> [44.054075] i915 0000:00:02.0: colorimetry: No Data
<7> [44.054076] i915 0000:00:02.0: picture aspect: No Data
<7> [44.054078] i915 0000:00:02.0: active aspect: Same as Picture
<7> [44.054079] i915 0000:00:02.0: itc: No Data
<7> [44.054080] i915 0000:00:02.0: extended colorimetry: xvYCC 601
<7> [44.054082] i915 0000:00:02.0: quantization range: Full
<7> [44.054083] i915 0000:00:02.0: nups: Unknown Non-uniform Scaling
<7> [44.054085] i915 0000:00:02.0: video code: 0
<7> [44.054086] i915 0000:00:02.0: ycc quantization range: Full
<7> [44.054087] i915 0000:00:02.0: hdmi content type: Graphics
<7> [44.054089] i915 0000:00:02.0: pixel repeat: 0
<7> [44.054090] i915 0000:00:02.0: bar top 0, bottom 0, left 0, right 0
<7> [44.054092] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] found:
<7> [44.054252] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:170:pipe A] fastset requirement not met in spd infoframe
<7> [44.054411] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] expected:
<7> [44.054567] i915 0000:00:02.0: HDMI infoframe: Source Product Description (SPD), version 1, length 25
<7> [44.054569] i915 0000:00:02.0: vendor: Intel
<7> [44.054570] i915 0000:00:02.0: product: Integrated gfx
<7> [44.054572] i915 0000:00:02.0: source device information: PC General (0x9)
<7> [44.054573] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] found:
<7> [44.054771] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:170:pipe A] fastset requirement not met in hdmi infoframe
<7> [44.055016] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] expected:
<7> [44.055243] i915 0000:00:02.0: HDMI infoframe: Vendor, version 1, length 4
<7> [44.055247] i915 0000:00:02.0: empty frame
<7> [44.055249] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] found:
<7> [44.055428] i915 0000:00:02.0: [drm:intel_atomic_check [i915]] [CRTC:170:pipe A] fastset requirement not met, forcing full modeset
<7> [44.055588] i915 0000:00:02.0: [drm:intel_dpll_crtc_put [i915]] [CRTC:170:pipe A] releasing DPLL 0
<7> [44.055781] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] Enabled dbuf slices 0x3 -> 0x1 (total dbuf slices 0x3), mbus joined? no->no
<7> [44.055948] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] [CRTC:170:pipe A] dbuf slices 0x3 -> 0x0, ddb (0 - 2048) -> (0 - 0), active pipes 0x1 -> 0x0
<7> [44.056255] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] [PLANE:34:plane 1A] ddb ( 0 - 1993) -> ( 0 - 0), size 1993 -> 0
<7> [44.056415] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] [PLANE:164:cursor A] ddb (1993 - 2048) -> ( 0 - 0), size 55 -> 0
<7> [44.056570] i915 0000:00:02.0: [drm:skl_print_plane_changes [i915]] [PLANE:34:plane 1A] level *wm0,*wm1,*wm2,*wm3,*wm4,*wm5,*wm6,*wm7,*twm, swm, stwm -> wm0, wm1, wm2, wm3, wm4, wm5, wm6, wm7, twm, swm, stwm
<7> [44.056725] i915 0000:00:02.0: [drm:skl_print_plane_changes [i915]] [PLANE:34:plane 1A] lines 1, 8, 8, 8, 8, 11, 16, 16, 0, 0, 0 -> 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0
<7> [44.056913] i915 0000:00:02.0: [drm:skl_print_plane_changes [i915]] [PLANE:34:plane 1A] blocks 16, 129, 129, 129, 129, 177, 257, 257, 30, 0, 0 -> 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0
<7> [44.057133] i915 0000:00:02.0: [drm:skl_print_plane_changes [i915]] [PLANE:34:plane 1A] 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> [44.057309] i915 0000:00:02.0: [drm:intel_bw_atomic_check [i915]] [CRTC:170:pipe A] data rate 0 num active planes 0
<7> [44.057473] i915 0000:00:02.0: [drm:intel_bw_atomic_check [i915]] QGV point 0: max bw 14993 required 0
<7> [44.057661] i915 0000:00:02.0: [drm:intel_cdclk_atomic_check [i915]] [CRTC:170:pipe A] min cdclk: 192000 kHz -> 0 kHz
<7> [44.057913] i915 0000:00:02.0: [drm:intel_cdclk_update_dbuf_bw_min_cdclk [i915]] dbuf bandwidth min cdclk: 17844 kHz -> 0 kHz
<7> [44.058122] i915 0000:00:02.0: [drm:intel_cdclk_atomic_check [i915]] Modeset required for cdclk change
<7> [44.058280] i915 0000:00:02.0: [drm:intel_cdclk_atomic_check [i915]] New cdclk calculated to be logical 172800 kHz, actual 172800 kHz
<7> [44.058436] i915 0000:00:02.0: [drm:intel_cdclk_atomic_check [i915]] New voltage level calculated to be logical 0, actual 0
<7> [44.058658] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [CRTC:170:pipe A] enable: no [modeset]
<7> [44.058867] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:34:plane 1A] fb: [NOFB], visible: no
<7> [44.059043] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:64:plane 2A] fb: [NOFB], visible: no
<7> [44.059219] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:94:plane 3A] fb: [NOFB], visible: no
<7> [44.059376] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:124:plane 4A] fb: [NOFB], visible: no
<7> [44.059592] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:134:plane 5A] fb: [NOFB], visible: no
<7> [44.059780] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:144:plane 6A] fb: [NOFB], visible: no
<7> [44.059936] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:154:plane 7A] fb: [NOFB], visible: no
<7> [44.060108] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:164:cursor A] fb: [NOFB], visible: no
<7> [44.060446] i915 0000:00:02.0: [drm:intel_audio_codec_disable [i915]] [CONNECTOR:587:HDMI-A-1][ENCODER:586:DDI B/PHY B] Disable audio codec on [CRTC:170:pipe A]
<7> [44.070623] i915 0000:00:02.0: [drm:intel_audio_component_get_eld [i915]] Not valid for port B
<7> [44.082032] i915 0000:00:02.0: [drm:intel_hdmi_handle_sink_scrambling [i915]] [CONNECTOR:587:HDMI-A-1] scrambling=no, TMDS bit clock ratio=1/10
<7> [44.082744] i915 0000:00:02.0: [drm:do_gmbus_xfer [i915]] GMBUS [i915 gmbus dpb] NAK for addr: 0054 w(1)
<7> [44.082914] i915 0000:00:02.0: [drm:do_gmbus_xfer [i915]] GMBUS [i915 gmbus dpb] NAK on first message, retry
<7> [44.083557] i915 0000:00:02.0: [drm:do_gmbus_xfer [i915]] GMBUS [i915 gmbus dpb] NAK for addr: 0054 w(1)
<7> [44.083800] i915 0000:00:02.0: [drm:drm_scdc_set_high_tmds_clock_ratio [drm_display_helper]] [CONNECTOR:587:HDMI-A-1] Failed to read TMDS config: -6
<7> [44.083815] i915 0000:00:02.0: [drm:intel_ddi_disable [i915]] [CONNECTOR:587:HDMI-A-1] Failed to reset sink scrambling/TMDS bit clock ratio
<7> [44.084429] i915 0000:00:02.0: [drm:intel_disable_transcoder [i915]] disabling pipe A
<7> [44.087300] i915 0000:00:02.0: [drm:intel_power_well_disable [i915]] disabling DDI_IO_B
<7> [44.087577] i915 0000:00:02.0: [drm:intel_dpll_disable [i915]] disable DPLL 0 (active 0x1, on? 1) for [CRTC:170:pipe A]
<7> [44.087810] i915 0000:00:02.0: [drm:intel_dpll_disable [i915]] disabling DPLL 0
<7> [44.087986] i915 0000:00:02.0: [drm:__intel_fbc_disable [i915]] Disabling FBC on [PLANE:34:plane 1A]
<7> [44.088227] 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> [44.088649] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:586:DDI B/PHY B]
<7> [44.088828] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:596:DDI TC1/PHY TC1]
<7> [44.088987] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:598:DP-MST A]
<7> [44.089160] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:599:DP-MST B]
<7> [44.089317] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:600:DP-MST C]
<7> [44.089472] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:601:DP-MST D]
<7> [44.089626] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:606:DDI TC2/PHY TC2]
<7> [44.089785] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:608:DP-MST A]
<7> [44.089968] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:609:DP-MST B]
<7> [44.090211] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:610:DP-MST C]
<7> [44.090434] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:611:DP-MST D]
<7> [44.090655] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:615:DDI TC3/PHY TC3]
<7> [44.090871] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:617:DP-MST A]
<7> [44.091117] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:618:DP-MST B]
<7> [44.091345] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:619:DP-MST C]
<7> [44.091559] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:620:DP-MST D]
<7> [44.091771] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:624:DDI TC4/PHY TC4]
<7> [44.091984] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:626:DP-MST A]
<7> [44.092224] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:627:DP-MST B]
<7> [44.092439] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:628:DP-MST C]
<7> [44.092639] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:629:DP-MST D]
<7> [44.092799] i915 0000:00:02.0: [drm:verify_connector_state [i915]] [CONNECTOR:587:HDMI-A-1]
<7> [44.093273] i915 0000:00:02.0: [drm:gen9_dbuf_slices_update [i915]] Updating dbuf slices to 0x1
<7> [44.093564] i915 0000:00:02.0: [drm:intel_power_well_disable [i915]] disabling PW_3
<7> [44.093808] i915 0000:00:02.0: [drm:intel_power_well_disable [i915]] disabling PW_2
<7> [44.093996] i915 0000:00:02.0: [drm:intel_modeset_verify_crtc [i915]] [CRTC:170:pipe A]
<7> [44.094826] i915 0000:00:02.0: [drm:drm_mode_setcrtc] [CRTC:308:pipe B]
<7> [44.094998] i915 0000:00:02.0: [drm:drm_mode_setcrtc] [CRTC:446:pipe C]
<7> [44.095219] i915 0000:00:02.0: [drm:drm_mode_setcrtc] [CRTC:584:pipe D]
<7> [44.095396] i915 0000:00:02.0: [drm:drm_mode_setcrtc] [CRTC:170:pipe A]
<7> [44.095437] i915 0000:00:02.0: [drm:drm_mode_setcrtc] [CONNECTOR:587:HDMI-A-1]
<7> [44.095530] i915 0000:00:02.0: [drm:intel_atomic_check [i915]] [CONNECTOR:587:HDMI-A-1] Limiting target display pipe bpp to 24 (EDID bpp 24, max requested bpp 36, max platform bpp 36)
<7> [44.095745] i915 0000:00:02.0: [drm:intel_hdmi_compute_clock [i915]] picking 8 bpc for HDMI output (pipe bpp: 24)
<7> [44.095933] i915 0000:00:02.0: [drm:intel_atomic_check [i915]] [CRTC:170:pipe A] hw max bpp: 24, pipe bpp: 24, dithering: 0
<7> [44.096163] i915 0000:00:02.0: [drm:intel_ddi_compute_config_late [i915]] [ENCODER:586:DDI B/PHY B] [CRTC:170:pipe A]
<7> [44.096336] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:170:pipe A] fastset requirement not met in hw.enable (expected no, found yes)
<7> [44.096534] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:170:pipe A] fastset requirement not met in hw.active (expected no, found yes)
<7> [44.096709] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:170:pipe A] fastset requirement not met in cpu_transcoder (expected -1, found 0)
<7> [44.096873] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:170:pipe A] fastset requirement not met in lane_count (expected 0, found 4)
<7> [44.097057] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:170:pipe A] fastset requirement not met in output_types (expected 0x00000000, found 0x00000040)
<7> [44.097281] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:170:pipe A] fastset requirement not met in framestart_delay (expected 0, found 1)
<7> [44.097446] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:170:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hdisplay (expected 0, found 1920)
<7> [44.097603] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:170:pipe A] fastset requirement not met in hw.pipe_mode.crtc_htotal (expected 0, found 2080)
<7> [44.097762] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:170:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hblank_start (expected 0, found 1920)
<7> [44.097917] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:170:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hblank_end (expected 0, found 2080)
<7> [44.098089] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:170:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hsync_start (expected 0, found 1968)
<7> [44.098247] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:170:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hsync_end (expected 0, found 2000)
<7> [44.098404] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:170:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vdisplay (expected 0, found 1080)
<7> [44.098560] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:170:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vblank_start (expected 0, found 1080)
<7> [44.098718] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:170:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vsync_start (expected 0, found 1083)
<7> [44.098873] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:170:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vsync_end (expected 0, found 1088)
<7> [44.099120] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:170:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vtotal (expected 0, found 1144)
<7> [44.099285] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:170:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vblank_end (expected 0, found 1144)
<7> [44.099441] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:170:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hdisplay (expected 0, found 1920)
<7> [44.099597] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:170:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_htotal (expected 0, found 2080)
<7> [44.099754] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:170:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hblank_start (expected 0, found 1920)
<7> [44.099910] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:170:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hblank_end (expected 0, found 2080)
<7> [44.100082] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:170:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hsync_start (expected 0, found 1968)
<7> [44.100268] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:170:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hsync_end (expected 0, found 2000)
<7> [44.100424] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:170:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vdisplay (expected 0, found 1080)
<7> [44.100580] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:170:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vblank_start (expected 0, found 1080)
<7> [44.100736] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:170:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vsync_start (expected 0, found 1083)
<7> [44.100891] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:170:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vsync_end (expected 0, found 1088)
<7> [44.101061] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:170:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vtotal (expected 0, found 1144)
<7> [44.101239] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:170:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vblank_end (expected 0, found 1144)
<7> [44.101394] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:170:pipe A] fastset requirement not met in pixel_multiplier (expected 0, found 1)
<7> [44.101548] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:170:pipe A] fastset requirement not met in hw.adjusted_mode.flags (1) (expected 0, found 1)
<7> [44.101703] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:170:pipe A] fastset requirement not met in hw.adjusted_mode.flags (4) (expected 0, found 4)
<7> [44.101857] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:170:pipe A] fastset requirement not met in has_hdmi_sink (expected no, found yes)
<7> [44.102021] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:170:pipe A] fastset requirement not met in has_infoframe (expected no, found yes)
<7> [44.102203] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:170:pipe A] fastset requirement not met in pipe_bpp (expected 0, found 24)
<7> [44.102358] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:170:pipe A] fastset requirement not met in hw.pipe_mode.crtc_clock (expected 0, found 285500)
<7> [44.102512] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:170:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_clock (expected 0, found 285500)
<7> [44.102667] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:170:pipe A] fastset requirement not met in port_clock (expected 0, found 285500)
<7> [44.102821] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:170:pipe A] fastset requirement not met in infoframes.enable (expected 0x00000000, found 0x00000071)
<7> [44.102976] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:170:pipe A] fastset requirement not met in avi infoframe
<7> [44.103149] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] expected:
<7> [44.103327] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] found:
<7> [44.103482] i915 0000:00:02.0: HDMI infoframe: Auxiliary Video Information (AVI), version 2, length 13
<7> [44.103484] i915 0000:00:02.0: colorspace: RGB
<7> [44.103486] i915 0000:00:02.0: scan mode: Underscan
<7> [44.103487] i915 0000:00:02.0: colorimetry: No Data
<7> [44.103489] i915 0000:00:02.0: picture aspect: No Data
<7> [44.103490] i915 0000:00:02.0: active aspect: Same as Picture
<7> [44.103492] i915 0000:00:02.0: itc: No Data
<7> [44.103493] i915 0000:00:02.0: extended colorimetry: xvYCC 601
<7> [44.103495] i915 0000:00:02.0: quantization range: Full
<7> [44.103496] i915 0000:00:02.0: nups: Unknown Non-uniform Scaling
<7> [44.103498] i915 0000:00:02.0: video code: 0
<7> [44.103499] i915 0000:00:02.0: ycc quantization range: Full
<7> [44.103500] i915 0000:00:02.0: hdmi content type: Graphics
<7> [44.103502] i915 0000:00:02.0: pixel repeat: 0
<7> [44.103503] i915 0000:00:02.0: bar top 0, bottom 0, left 0, right 0
<7> [44.103505] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:170:pipe A] fastset requirement not met in spd infoframe
<7> [44.103667] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] expected:
<7> [44.103826] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] found:
<7> [44.103983] i915 0000:00:02.0: HDMI infoframe: Source Product Description (SPD), version 1, length 25
<7> [44.103985] i915 0000:00:02.0: vendor: Intel
<7> [44.103986] i915 0000:00:02.0: product: Integrated gfx
<7> [44.103988] i915 0000:00:02.0: source device information: PC General (0x9)
<7> [44.103989] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:170:pipe A] fastset requirement not met in hdmi infoframe
<7> [44.104164] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] expected:
<7> [44.104357] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] found:
<7> [44.104514] i915 0000:00:02.0: HDMI infoframe: Vendor, version 1, length 4
<7> [44.104516] i915 0000:00:02.0: empty frame
<7> [44.104518] i915 0000:00:02.0: [drm:intel_atomic_check [i915]] [CRTC:170:pipe A] fastset requirement not met, forcing full modeset
<7> [44.104711] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] Enabled dbuf slices 0x1 -> 0x3 (total dbuf slices 0x3), mbus joined? no->no
<7> [44.104869] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] [CRTC:170:pipe A] dbuf slices 0x0 -> 0x3, ddb (0 - 0) -> (0 - 2048), active pipes 0x0 -> 0x1
<7> [44.105124] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] [PLANE:34:plane 1A] ddb ( 0 - 0) -> ( 0 - 1993), size 0 -> 1993
<7> [44.105282] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] [PLANE:164:cursor A] ddb ( 0 - 0) -> (1993 - 2048), size 0 -> 55
<7> [44.105435] i915 0000:00:02.0: [drm:skl_print_plane_changes [i915]] [PLANE:34:plane 1A] level wm0, wm1, wm2, wm3, wm4, wm5, wm6, wm7, twm, swm, stwm -> *wm0,*wm1,*wm2,*wm3,*wm4,*wm5,*wm6,*wm7,*twm, swm, stwm
<7> [44.105587] i915 0000:00:02.0: [drm:skl_print_plane_changes [i915]] [PLANE:34:plane 1A] lines 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0 -> 1, 8, 8, 8, 8, 11, 16, 16, 0, 0, 0
<7> [44.105743] i915 0000:00:02.0: [drm:skl_print_plane_changes [i915]] [PLANE:34:plane 1A] blocks 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0 -> 16, 129, 129, 129, 129, 177, 257, 257, 30, 0, 0
<7> [44.105897] i915 0000:00:02.0: [drm:skl_print_plane_changes [i915]] [PLANE:34:plane 1A] 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> [44.106097] i915 0000:00:02.0: [drm:intel_bw_atomic_check [i915]] [CRTC:170:pipe A] data rate 1142000 num active planes 1
<7> [44.106287] i915 0000:00:02.0: [drm:intel_bw_atomic_check [i915]] QGV point 0: max bw 14993 required 1142
<7> [44.106448] i915 0000:00:02.0: [drm:intel_bw_atomic_check [i915]] No SAGV, using single QGV point mask 0x1
<7> [44.106626] i915 0000:00:02.0: [drm:intel_cdclk_atomic_check [i915]] [CRTC:170:pipe A] min cdclk: 0 kHz -> 192000 kHz
<7> [44.106804] i915 0000:00:02.0: [drm:intel_cdclk_update_dbuf_bw_min_cdclk [i915]] dbuf bandwidth min cdclk: 0 kHz -> 17844 kHz
<7> [44.106992] i915 0000:00:02.0: [drm:intel_cdclk_atomic_check [i915]] Modeset required for cdclk change
<7> [44.107169] i915 0000:00:02.0: [drm:intel_cdclk_atomic_check [i915]] New cdclk calculated to be logical 192000 kHz, actual 192000 kHz
<7> [44.107353] i915 0000:00:02.0: [drm:intel_cdclk_atomic_check [i915]] New voltage level calculated to be logical 0, actual 0
<7> [44.107514] i915 0000:00:02.0: [drm:intel_find_dpll [i915]] [CRTC:170:pipe A] allocated DPLL 0
<7> [44.107701] i915 0000:00:02.0: [drm:intel_dpll_crtc_get [i915]] [CRTC:170:pipe A] reserving DPLL 0
<7> [44.107869] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [CRTC:170:pipe A] enable: yes [modeset]
<7> [44.108043] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] active: yes, output_types: HDMI (0x40), output format: RGB, sink format: RGB
<7> [44.108227] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] cpu_transcoder: A, pipe bpp: 24, dithering: 0
<7> [44.108387] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] MST master transcoder: <invalid>
<7> [44.108546] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] port sync: master transcoder: <invalid>, slave transcoder bitmask = 0x0
<7> [44.108704] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] joiner: no, pipes: 0x0
<7> [44.108861] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] splitter: disabled, link count 0, overlap 0
<7> [44.109027] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] audio: 1, infoframes: 1, infoframes enabled: 0x71
<7> [44.109205] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] GCP: 0x0
<7> [44.109361] i915 0000:00:02.0: HDMI infoframe: Auxiliary Video Information (AVI), version 2, length 13
<7> [44.109363] i915 0000:00:02.0: colorspace: RGB
<7> [44.109365] i915 0000:00:02.0: scan mode: Underscan
<7> [44.109366] i915 0000:00:02.0: colorimetry: No Data
<7> [44.109368] i915 0000:00:02.0: picture aspect: No Data
<7> [44.109369] i915 0000:00:02.0: active aspect: Same as Picture
<7> [44.109370] i915 0000:00:02.0: itc: No Data
<7> [44.109372] i915 0000:00:02.0: extended colorimetry: xvYCC 601
<7> [44.109373] i915 0000:00:02.0: quantization range: Full
<7> [44.109374] i915 0000:00:02.0: nups: Unknown Non-uniform Scaling
<7> [44.109376] i915 0000:00:02.0: video code: 0
<7> [44.109377] i915 0000:00:02.0: ycc quantization range: Full
<7> [44.109379] i915 0000:00:02.0: hdmi content type: Graphics
<7> [44.109380] i915 0000:00:02.0: pixel repeat: 0
<7> [44.109381] i915 0000:00:02.0: bar top 0, bottom 0, left 0, right 0
<7> [44.109383] i915 0000:00:02.0: HDMI infoframe: Source Product Description (SPD), version 1, length 25
<7> [44.109385] i915 0000:00:02.0: vendor: Intel
<7> [44.109386] i915 0000:00:02.0: product: Integrated gfx
<7> [44.109388] i915 0000:00:02.0: source device information: PC General (0x9)
<7> [44.109389] i915 0000:00:02.0: HDMI infoframe: Vendor, version 1, length 4
<7> [44.109391] i915 0000:00:02.0: empty frame
<7> [44.109393] 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> [44.109550] 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> [44.109705] 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> [44.109860] 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> [44.110027] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] scanline offset: 2
<7> [44.110219] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] framestart delay: 1, MSA timing delay: 0, set context latency: 0
<7> [44.110375] 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> [44.110531] 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> [44.110685] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] vrr: dc balance: no, vmin: 0 vmax: 0 guardband: 0, slope: 0 max increase: 0 max decrease: 0 vblank target: 0
<7> [44.110840] 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> [44.111003] 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> [44.111200] 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> [44.111386] 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> [44.111548] 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> [44.111709] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] port clock: 285500, pipe src: 1920x1080+0+0, pixel rate 285500, min cdclk 192000
<7> [44.111865] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] linetime: 59, ips linetime: 0
<7> [44.112031] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] num_scalers: 2, scaler_users: 0x0, scaler_id: -1, scaling_filter: 0
<7> [44.112208] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pch pfit: 0x0+0+0, disabled, force thru: no
<7> [44.112363] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] ips: 0, double wide: 0, drrs: 0
<7> [44.112518] 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> [44.112674] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] csc_mode: 0x0 gamma_mode: 0x0 gamma_enable: 0 csc_enable: 0
<7> [44.112830] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pre csc lut: 0 entries, post csc lut: 0 entries
<7> [44.112986] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] output csc: pre offsets: 0x0000 0x0000 0x0000
<7> [44.113178] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] output csc: coefficients: 0x0000 0x0000 0x0000
<7> [44.113361] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] output csc: coefficients: 0x0000 0x0000 0x0000
<7> [44.113515] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] output csc: coefficients: 0x0000 0x0000 0x0000
<7> [44.113670] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] output csc: post offsets: 0x0000 0x0000 0x0000
<7> [44.113825] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pipe csc: pre offsets: 0x0000 0x0000 0x0000
<7> [44.113980] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pipe csc: coefficients: 0x0000 0x0000 0x0000
<7> [44.114157] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pipe csc: coefficients: 0x0000 0x0000 0x0000
<7> [44.114332] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pipe csc: coefficients: 0x0000 0x0000 0x0000
<7> [44.114486] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pipe csc: post offsets: 0x0000 0x0000 0x0000
<7> [44.114641] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] sharpness strength: 0, sharpness tap size: 0, sharpness enable: 0
<7> [44.114795] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:34:plane 1A] fb: [FB:636] 1920x1080 format = XR24 little-endian (0x34325258) modifier = 0x100000000000001, visible: yes
<7> [44.114951] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] rotation: 0x1, scaler: -1, scaling_filter: 0
<7> [44.115119] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] src: 1920.000000x1080.000000+0.000000+0.000000 dst: 1920x1080+0+0
<7> [44.115295] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:64:plane 2A] fb: [NOFB], visible: no
<7> [44.115449] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:94:plane 3A] fb: [NOFB], visible: no
<7> [44.115603] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:124:plane 4A] fb: [NOFB], visible: no
<7> [44.115756] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:134:plane 5A] fb: [NOFB], visible: no
<7> [44.115910] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:144:plane 6A] fb: [NOFB], visible: no
<7> [44.116078] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:154:plane 7A] fb: [NOFB], visible: no
<7> [44.116256] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:164:cursor A] fb: [NOFB], visible: no
<7> [44.117807] i915 0000:00:02.0: [drm:intel_power_well_enable [i915]] enabling PW_2
<7> [44.117991] i915 0000:00:02.0: [drm:intel_power_well_enable [i915]] enabling PW_3
<7> [44.118219] 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> [44.118484] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:586:DDI B/PHY B]
<7> [44.118666] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:596:DDI TC1/PHY TC1]
<7> [44.118825] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:598:DP-MST A]
<7> [44.118983] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:599:DP-MST B]
<7> [44.119159] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:600:DP-MST C]
<7> [44.119343] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:601:DP-MST D]
<7> [44.119501] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:606:DDI TC2/PHY TC2]
<7> [44.119657] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:608:DP-MST A]
<7> [44.119813] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:609:DP-MST B]
<7> [44.119967] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:610:DP-MST C]
<7> [44.120141] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:611:DP-MST D]
<7> [44.120317] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:615:DDI TC3/PHY TC3]
<7> [44.120477] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:617:DP-MST A]
<7> [44.120634] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:618:DP-MST B]
<7> [44.120790] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:619:DP-MST C]
<7> [44.120944] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:620:DP-MST D]
<7> [44.121117] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:624:DDI TC4/PHY TC4]
<7> [44.121292] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:626:DP-MST A]
<7> [44.121446] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:627:DP-MST B]
<7> [44.121600] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:628:DP-MST C]
<7> [44.121754] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:629:DP-MST D]
<7> [44.122064] i915 0000:00:02.0: [drm:gen9_dbuf_slices_update [i915]] Updating dbuf slices to 0x3
<7> [44.122357] i915 0000:00:02.0: [drm:intel_dpll_enable [i915]] enable DPLL 0 (active 0x1, on? 0) for [CRTC:170:pipe A]
<7> [44.122544] i915 0000:00:02.0: [drm:intel_dpll_enable [i915]] enabling DPLL 0
<7> [44.122767] i915 0000:00:02.0: [drm:intel_power_well_enable [i915]] enabling DDI_IO_B
<7> [44.123042] i915 0000:00:02.0: [drm:intel_enable_transcoder [i915]] enabling pipe A
<7> [44.123547] i915 0000:00:02.0: [drm:intel_hdmi_handle_sink_scrambling [i915]] [CONNECTOR:587:HDMI-A-1] scrambling=no, TMDS bit clock ratio=1/10
<7> [44.124222] i915 0000:00:02.0: [drm:do_gmbus_xfer [i915]] GMBUS [i915 gmbus dpb] NAK for addr: 0054 w(1)
<7> [44.124370] i915 0000:00:02.0: [drm:do_gmbus_xfer [i915]] GMBUS [i915 gmbus dpb] NAK on first message, retry
<7> [44.125016] i915 0000:00:02.0: [drm:do_gmbus_xfer [i915]] GMBUS [i915 gmbus dpb] NAK for addr: 0054 w(1)
<7> [44.125170] i915 0000:00:02.0: [drm:drm_scdc_set_high_tmds_clock_ratio [drm_display_helper]] [CONNECTOR:587:HDMI-A-1] Failed to read TMDS config: -6
<7> [44.125186] i915 0000:00:02.0: [drm:intel_ddi_enable [i915]] [CONNECTOR:587:HDMI-A-1] Failed to configure sink scrambling/TMDS bit clock ratio
<7> [44.129044] i915 0000:00:02.0: [drm:intel_fbc_update [i915]] reserved 17694720 bytes of contiguous stolen space for FBC, limit: 1
<7> [44.129219] i915 0000:00:02.0: [drm:intel_fbc_update [i915]] Enabling FBC on [PLANE:34:plane 1A]
<7> [44.133819] i915 0000:00:02.0: [drm:intel_audio_codec_enable [i915]] [CONNECTOR:587:HDMI-A-1][ENCODER:586:DDI B/PHY B] Enable audio codec on [CRTC:170:pipe A], 64 bytes ELD
<7> [44.133941] i915 0000:00:02.0: [drm:intel_audio_component_get_power [i915]] restored AUD_FREQ_CNTRL to 0x810
<7> [44.138584] azx_init_pci: snd_hda_intel 0000:00:1f.3: Clearing TCSEL
<7> [44.138631] azx_init_pci: snd_hda_intel 0000:00:1f.3: SCH snoop: Enabled
<7> [44.142139] 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> [44.142520] i915 0000:00:02.0: [drm:audio_config_hdmi_pixel_clock [i915]] Configuring HDMI audio for pixel clock 25200 (0x00010000)
<7> [44.142775] i915 0000:00:02.0: [drm:hsw_audio_config_update [i915]] using automatic N
<6> [44.142998] snd_hda_codec_intelhdmi hdaudioC0D2: HDMI: audio coding xtype 5 not expected
<6> [44.143029] snd_hda_codec_intelhdmi hdaudioC0D2: HDMI: audio coding xtype 0 not expected
<6> [44.143033] snd_hda_codec_intelhdmi hdaudioC0D2: HDMI: audio coding xtype 10 not expected
<6> [44.143036] snd_hda_codec_intelhdmi hdaudioC0D2: HDMI: audio coding xtype 6 not expected
<7> [44.143251] i915 0000:00:02.0: [drm:verify_connector_state [i915]] [CONNECTOR:587:HDMI-A-1]
<7> [44.143607] i915 0000:00:02.0: [drm:intel_modeset_verify_crtc [i915]] [CRTC:170:pipe A]
<7> [44.974504] i915 0000:00:02.0: [drm:intel_power_well_disable [i915]] disabling TC_cold_off
<7> [44.974531] i915 0000:00:02.0: [drm:intel_tc_port_reset_mode [i915]] Port D/TC#1: TC port mode reset (legacy -> disconnected) pin assignment: - max lanes: 4
<7> [44.974530] i915 0000:00:02.0: [drm:intel_tc_port_reset_mode [i915]] Port E/TC#2: TC port mode reset (tbt-alt -> disconnected) pin assignment: - max lanes: 4
<7> [44.974530] i915 0000:00:02.0: [drm:intel_tc_port_reset_mode [i915]] Port F/TC#3: TC port mode reset (tbt-alt -> disconnected) pin assignment: - max lanes: 4
<7> [44.975368] i915 0000:00:02.0: [drm:tgl_tc_cold_request [i915]] TC cold unblock succeeded
<7> [44.975879] i915 0000:00:02.0: [drm:intel_tc_port_reset_mode [i915]] Port G/TC#4: TC port mode reset (tbt-alt -> disconnected) pin assignment: - max lanes: 4
<7> [55.052756] i915 0000:00:02.0: [drm:drm_mode_setcrtc] [CRTC:170:pipe A]
<7> [55.053039] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:170:pipe A] fastset requirement not met in hw.enable (expected yes, found no)
<7> [55.053622] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:170:pipe A] fastset requirement not met in hw.active (expected yes, found no)
<7> [55.054101] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:170:pipe A] fastset requirement not met in cpu_transcoder (expected 0, found -1)
<7> [55.054603] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:170:pipe A] fastset requirement not met in lane_count (expected 4, found 0)
<7> [55.055074] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:170:pipe A] fastset requirement not met in output_types (expected 0x00000040, found 0x00000000)
<7> [55.055568] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:170:pipe A] fastset requirement not met in framestart_delay (expected 1, found 0)
<7> [55.056033] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:170:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hdisplay (expected 1920, found 0)
<7> [55.056527] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:170:pipe A] fastset requirement not met in hw.pipe_mode.crtc_htotal (expected 2080, found 0)
<7> [55.056989] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:170:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hblank_start (expected 1920, found 0)
<7> [55.057449] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:170:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hblank_end (expected 2080, found 0)
<7> [55.057956] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:170:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hsync_start (expected 1968, found 0)
<7> [55.058413] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:170:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hsync_end (expected 2000, found 0)
<7> [55.058924] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:170:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vdisplay (expected 1080, found 0)
<7> [55.059393] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:170:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vblank_start (expected 1080, found 0)
<7> [55.059906] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:170:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vsync_start (expected 1083, found 0)
<7> [55.060248] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:170:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vsync_end (expected 1088, found 0)
<7> [55.060404] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:170:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vtotal (expected 1144, found 0)
<7> [55.060568] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:170:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vblank_end (expected 1144, found 0)
<7> [55.060724] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:170:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hdisplay (expected 1920, found 0)
<7> [55.060879] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:170:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_htotal (expected 2080, found 0)
<7> [55.061034] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:170:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hblank_start (expected 1920, found 0)
<7> [55.061189] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:170:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hblank_end (expected 2080, found 0)
<7> [55.061348] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:170:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hsync_start (expected 1968, found 0)
<7> [55.061503] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:170:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hsync_end (expected 2000, found 0)
<7> [55.061673] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:170:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vdisplay (expected 1080, found 0)
<7> [55.061828] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:170:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vblank_start (expected 1080, found 0)
<7> [55.061984] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:170:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vsync_start (expected 1083, found 0)
<7> [55.062138] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:170:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vsync_end (expected 1088, found 0)
<7> [55.062294] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:170:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vtotal (expected 1144, found 0)
<7> [55.062449] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:170:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vblank_end (expected 1144, found 0)
<7> [55.062616] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:170:pipe A] fastset requirement not met in pixel_multiplier (expected 1, found 0)
<7> [55.062772] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:170:pipe A] fastset requirement not met in hw.adjusted_mode.flags (1) (expected 1, found 0)
<7> [55.062928] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:170:pipe A] fastset requirement not met in hw.adjusted_mode.flags (4) (expected 4, found 0)
<7> [55.063083] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:170:pipe A] fastset requirement not met in has_hdmi_sink (expected yes, found no)
<7> [55.063237] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:170:pipe A] fastset requirement not met in has_infoframe (expected yes, found no)
<7> [55.063392] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:170:pipe A] fastset requirement not met in pipe_bpp (expected 24, found 0)
<7> [55.063548] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:170:pipe A] fastset requirement not met in hw.pipe_mode.crtc_clock (expected 285500, found 0)
<7> [55.063718] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:170:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_clock (expected 285500, found 0)
<7> [55.063874] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:170:pipe A] fastset requirement not met in port_clock (expected 285500, found 0)
<7> [55.064030] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:170:pipe A] fastset requirement not met in infoframes.enable (expected 0x00000071, found 0x00000000)
<7> [55.064186] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:170:pipe A] fastset requirement not met in avi infoframe
<7> [55.064341] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] expected:
<7> [55.064495] i915 0000:00:02.0: HDMI infoframe: Auxiliary Video Information (AVI), version 2, length 13
<7> [55.064498] i915 0000:00:02.0: colorspace: RGB
<7> [55.064499] i915 0000:00:02.0: scan mode: Underscan
<7> [55.064501] i915 0000:00:02.0: colorimetry: No Data
<7> [55.064502] i915 0000:00:02.0: picture aspect: No Data
<7> [55.064504] i915 0000:00:02.0: active aspect: Same as Picture
<7> [55.064505] i915 0000:00:02.0: itc: No Data
<7> [55.064506] i915 0000:00:02.0: extended colorimetry: xvYCC 601
<7> [55.064508] i915 0000:00:02.0: quantization range: Full
<7> [55.064509] i915 0000:00:02.0: nups: Unknown Non-uniform Scaling
<7> [55.064511] i915 0000:00:02.0: video code: 0
<7> [55.064512] i915 0000:00:02.0: ycc quantization range: Full
<7> [55.064513] i915 0000:00:02.0: hdmi content type: Graphics
<7> [55.064515] i915 0000:00:02.0: pixel repeat: 0
<7> [55.064516] i915 0000:00:02.0: bar top 0, bottom 0, left 0, right 0
<7> [55.064518] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] found:
<7> [55.064684] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:170:pipe A] fastset requirement not met in spd infoframe
<7> [55.064841] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] expected:
<7> [55.064996] i915 0000:00:02.0: HDMI infoframe: Source Product Description (SPD), version 1, length 25
<7> [55.064998] i915 0000:00:02.0: vendor: Intel
<7> [55.065000] i915 0000:00:02.0: product: Integrated gfx
<7> [55.065001] i915 0000:00:02.0: source device information: PC General (0x9)
<7> [55.065003] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] found:
<7> [55.065158] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:170:pipe A] fastset requirement not met in hdmi infoframe
<7> [55.065319] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] expected:
<7> [55.065478] i915 0000:00:02.0: HDMI infoframe: Vendor, version 1, length 4
<7> [55.065480] i915 0000:00:02.0: empty frame
<7> [55.065481] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] found:
<7> [55.065651] i915 0000:00:02.0: [drm:intel_atomic_check [i915]] [CRTC:170:pipe A] fastset requirement not met, forcing full modeset
<7> [55.065811] i915 0000:00:02.0: [drm:intel_dpll_crtc_put [i915]] [CRTC:170:pipe A] releasing DPLL 0
<7> [55.066001] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] Enabled dbuf slices 0x3 -> 0x1 (total dbuf slices 0x3), mbus joined? no->no
<7> [55.066157] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] [CRTC:170:pipe A] dbuf slices 0x3 -> 0x0, ddb (0 - 2048) -> (0 - 0), active pipes 0x1 -> 0x0
<7> [55.066347] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] [PLANE:34:plane 1A] ddb ( 0 - 1993) -> ( 0 - 0), size 1993 -> 0
<7> [55.066501] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] [PLANE:164:cursor A] ddb (1993 - 2048) -> ( 0 - 0), size 55 -> 0
<7> [55.066666] i915 0000:00:02.0: [drm:skl_print_plane_changes [i915]] [PLANE:34:plane 1A] level *wm0,*wm1,*wm2,*wm3,*wm4,*wm5,*wm6,*wm7,*twm, swm, stwm -> wm0, wm1, wm2, wm3, wm4, wm5, wm6, wm7, twm, swm, stwm
<7> [55.066821] i915 0000:00:02.0: [drm:skl_print_plane_changes [i915]] [PLANE:34:plane 1A] lines 1, 8, 8, 8, 8, 11, 16, 16, 0, 0, 0 -> 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0
<7> [55.066975] i915 0000:00:02.0: [drm:skl_print_plane_changes [i915]] [PLANE:34:plane 1A] blocks 16, 129, 129, 129, 129, 177, 257, 257, 30, 0, 0 -> 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0
<7> [55.067128] i915 0000:00:02.0: [drm:skl_print_plane_changes [i915]] [PLANE:34:plane 1A] 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> [55.067305] i915 0000:00:02.0: [drm:intel_bw_atomic_check [i915]] [CRTC:170:pipe A] data rate 0 num active planes 0
<7> [55.067469] i915 0000:00:02.0: [drm:intel_bw_atomic_check [i915]] QGV point 0: max bw 14993 required 0
<7> [55.067659] i915 0000:00:02.0: [drm:intel_cdclk_atomic_check [i915]] [CRTC:170:pipe A] min cdclk: 192000 kHz -> 0 kHz
<7> [55.067840] i915 0000:00:02.0: [drm:intel_cdclk_update_dbuf_bw_min_cdclk [i915]] dbuf bandwidth min cdclk: 17844 kHz -> 0 kHz
<7> [55.068025] i915 0000:00:02.0: [drm:intel_cdclk_atomic_check [i915]] Modeset required for cdclk change
<7> [55.068183] i915 0000:00:02.0: [drm:intel_cdclk_atomic_check [i915]] New cdclk calculated to be logical 172800 kHz, actual 172800 kHz
<7> [55.068340] i915 0000:00:02.0: [drm:intel_cdclk_atomic_check [i915]] New voltage level calculated to be logical 0, actual 0
<7> [55.068501] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [CRTC:170:pipe A] enable: no [modeset]
<7> [55.068668] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:34:plane 1A] fb: [NOFB], visible: no
<7> [55.068828] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:64:plane 2A] fb: [NOFB], visible: no
<7> [55.068985] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:94:plane 3A] fb: [NOFB], visible: no
<7> [55.069143] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:124:plane 4A] fb: [NOFB], visible: no
<7> [55.069300] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:134:plane 5A] fb: [NOFB], visible: no
<7> [55.069458] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:144:plane 6A] fb: [NOFB], visible: no
<7> [55.069615] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:154:plane 7A] fb: [NOFB], visible: no
<7> [55.069784] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:164:cursor A] fb: [NOFB], visible: no
<7> [55.070017] i915 0000:00:02.0: [drm:intel_audio_codec_disable [i915]] [CONNECTOR:587:HDMI-A-1][ENCODER:586:DDI B/PHY B] Disable audio codec on [CRTC:170:pipe A]
<7> [55.085574] i915 0000:00:02.0: [drm:intel_audio_component_get_eld [i915]] Not valid for port B
<7> [55.095891] i915 0000:00:02.0: [drm:intel_hdmi_handle_sink_scrambling [i915]] [CONNECTOR:587:HDMI-A-1] scrambling=no, TMDS bit clock ratio=1/10
<7> [55.096650] i915 0000:00:02.0: [drm:do_gmbus_xfer [i915]] GMBUS [i915 gmbus dpb] NAK for addr: 0054 w(1)
<7> [55.096902] i915 0000:00:02.0: [drm:do_gmbus_xfer [i915]] GMBUS [i915 gmbus dpb] NAK on first message, retry
<7> [55.097577] i915 0000:00:02.0: [drm:do_gmbus_xfer [i915]] GMBUS [i915 gmbus dpb] NAK for addr: 0054 w(1)
<7> [55.097864] i915 0000:00:02.0: [drm:drm_scdc_set_high_tmds_clock_ratio [drm_display_helper]] [CONNECTOR:587:HDMI-A-1] Failed to read TMDS config: -6
<7> [55.097883] i915 0000:00:02.0: [drm:intel_ddi_disable [i915]] [CONNECTOR:587:HDMI-A-1] Failed to reset sink scrambling/TMDS bit clock ratio
<7> [55.098113] i915 0000:00:02.0: [drm:intel_disable_transcoder [i915]] disabling pipe A
<7> [55.103292] i915 0000:00:02.0: [drm:intel_power_well_disable [i915]] disabling DDI_IO_B
<7> [55.103522] i915 0000:00:02.0: [drm:intel_dpll_disable [i915]] disable DPLL 0 (active 0x1, on? 1) for [CRTC:170:pipe A]
<7> [55.103756] i915 0000:00:02.0: [drm:intel_dpll_disable [i915]] disabling DPLL 0
<7> [55.103928] i915 0000:00:02.0: [drm:__intel_fbc_disable [i915]] Disabling FBC on [PLANE:34:plane 1A]
<7> [55.104099] 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> [55.104388] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:586:DDI B/PHY B]
<7> [55.104671] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:596:DDI TC1/PHY TC1]
<7> [55.104902] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:598:DP-MST A]
<7> [55.105133] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:599:DP-MST B]
<7> [55.105498] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:600:DP-MST C]
<7> [55.105723] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:601:DP-MST D]
<7> [55.105946] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:606:DDI TC2/PHY TC2]
<7> [55.106170] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:608:DP-MST A]
<7> [55.106520] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:609:DP-MST B]
<7> [55.106748] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:610:DP-MST C]
<7> [55.106973] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:611:DP-MST D]
<7> [55.107197] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:615:DDI TC3/PHY TC3]
<7> [55.107511] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:617:DP-MST A]
<7> [55.107737] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:618:DP-MST B]
<7> [55.107967] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:619:DP-MST C]
<7> [55.108200] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:620:DP-MST D]
<7> [55.108459] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:624:DDI TC4/PHY TC4]
<7> [55.108684] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:626:DP-MST A]
<7> [55.108909] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:627:DP-MST B]
<7> [55.109135] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:628:DP-MST C]
<7> [55.109375] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:629:DP-MST D]
<7> [55.109598] i915 0000:00:02.0: [drm:verify_connector_state [i915]] [CONNECTOR:587:HDMI-A-1]
<7> [55.110114] i915 0000:00:02.0: [drm:gen9_dbuf_slices_update [i915]] Updating dbuf slices to 0x1
<7> [55.110436] i915 0000:00:02.0: [drm:intel_power_well_disable [i915]] disabling PW_3
<7> [55.110697] i915 0000:00:02.0: [drm:intel_power_well_disable [i915]] disabling PW_2
<7> [55.110970] i915 0000:00:02.0: [drm:intel_modeset_verify_crtc [i915]] [CRTC:170:pipe A]
<7> [55.111946] i915 0000:00:02.0: [drm:drm_mode_setcrtc] [CRTC:308:pipe B]
<7> [55.112221] i915 0000:00:02.0: [drm:drm_mode_setcrtc] [CRTC:446:pipe C]
<7> [55.112475] i915 0000:00:02.0: [drm:drm_mode_setcrtc] [CRTC:584:pipe D]
<7> [55.112732] i915 0000:00:02.0: [drm:drm_mode_setcrtc] [CRTC:170:pipe A]
<7> [55.112784] i915 0000:00:02.0: [drm:drm_mode_setcrtc] [CONNECTOR:587:HDMI-A-1]
<7> [55.112900] i915 0000:00:02.0: [drm:intel_atomic_check [i915]] [CONNECTOR:587:HDMI-A-1] Limiting target display pipe bpp to 24 (EDID bpp 24, max requested bpp 36, max platform bpp 36)
<7> [55.113159] i915 0000:00:02.0: [drm:intel_hdmi_compute_clock [i915]] picking 8 bpc for HDMI output (pipe bpp: 24)
<7> [55.113401] i915 0000:00:02.0: [drm:intel_atomic_check [i915]] [CRTC:170:pipe A] hw max bpp: 24, pipe bpp: 24, dithering: 0
<7> [55.113668] i915 0000:00:02.0: [drm:intel_ddi_compute_config_late [i915]] [ENCODER:586:DDI B/PHY B] [CRTC:170:pipe A]
<7> [55.113890] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:170:pipe A] fastset requirement not met in hw.enable (expected no, found yes)
<7> [55.114126] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:170:pipe A] fastset requirement not met in hw.active (expected no, found yes)
<7> [55.114356] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:170:pipe A] fastset requirement not met in cpu_transcoder (expected -1, found 0)
<7> [55.114611] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:170:pipe A] fastset requirement not met in lane_count (expected 0, found 4)
<7> [55.114841] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:170:pipe A] fastset requirement not met in output_types (expected 0x00000000, found 0x00000040)
<7> [55.115074] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:170:pipe A] fastset requirement not met in framestart_delay (expected 0, found 1)
<7> [55.115302] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:170:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hdisplay (expected 0, found 1920)
<7> [55.115549] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:170:pipe A] fastset requirement not met in hw.pipe_mode.crtc_htotal (expected 0, found 2080)
<7> [55.115783] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:170:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hblank_start (expected 0, found 1920)
<7> [55.116011] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:170:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hblank_end (expected 0, found 2080)
<7> [55.116241] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:170:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hsync_start (expected 0, found 1968)
<7> [55.116472] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:170:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hsync_end (expected 0, found 2000)
<7> [55.116738] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:170:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vdisplay (expected 0, found 1080)
<7> [55.116966] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:170:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vblank_start (expected 0, found 1080)
<7> [55.117198] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:170:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vsync_start (expected 0, found 1083)
<7> [55.117424] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:170:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vsync_end (expected 0, found 1088)
<7> [55.117670] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:170:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vtotal (expected 0, found 1144)
<7> [55.117901] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:170:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vblank_end (expected 0, found 1144)
<7> [55.118128] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:170:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hdisplay (expected 0, found 1920)
<7> [55.118354] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:170:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_htotal (expected 0, found 2080)
<7> [55.118597] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:170:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hblank_start (expected 0, found 1920)
<7> [55.118829] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:170:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hblank_end (expected 0, found 2080)
<7> [55.119056] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:170:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hsync_start (expected 0, found 1968)
<7> [55.119285] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:170:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hsync_end (expected 0, found 2000)
<7> [55.119516] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:170:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vdisplay (expected 0, found 1080)
<7> [55.119780] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:170:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vblank_start (expected 0, found 1080)
<7> [55.120007] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:170:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vsync_start (expected 0, found 1083)
<7> [55.120236] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:170:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vsync_end (expected 0, found 1088)
<7> [55.120466] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:170:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vtotal (expected 0, found 1144)
<7> [55.120713] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:170:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vblank_end (expected 0, found 1144)
<7> [55.120952] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:170:pipe A] fastset requirement not met in pixel_multiplier (expected 0, found 1)
<7> [55.121184] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:170:pipe A] fastset requirement not met in hw.adjusted_mode.flags (1) (expected 0, found 1)
<7> [55.121414] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:170:pipe A] fastset requirement not met in hw.adjusted_mode.flags (4) (expected 0, found 4)
<7> [55.121658] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:170:pipe A] fastset requirement not met in has_hdmi_sink (expected no, found yes)
<7> [55.121884] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:170:pipe A] fastset requirement not met in has_infoframe (expected no, found yes)
<7> [55.122116] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:170:pipe A] fastset requirement not met in pipe_bpp (expected 0, found 24)
<7> [55.122346] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:170:pipe A] fastset requirement not met in hw.pipe_mode.crtc_clock (expected 0, found 285500)
<7> [55.122576] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:170:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_clock (expected 0, found 285500)
<7> [55.122835] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:170:pipe A] fastset requirement not met in port_clock (expected 0, found 285500)
<7> [55.123064] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:170:pipe A] fastset requirement not met in infoframes.enable (expected 0x00000000, found 0x00000071)
<7> [55.123293] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:170:pipe A] fastset requirement not met in avi infoframe
<7> [55.123524] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] expected:
<7> [55.123772] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] found:
<7> [55.123995] i915 0000:00:02.0: HDMI infoframe: Auxiliary Video Information (AVI), version 2, length 13
<7> [55.123999] i915 0000:00:02.0: colorspace: RGB
<7> [55.124002] i915 0000:00:02.0: scan mode: Underscan
<7> [55.124005] i915 0000:00:02.0: colorimetry: No Data
<7> [55.124008] i915 0000:00:02.0: picture aspect: No Data
<7> [55.124010] i915 0000:00:02.0: active aspect: Same as Picture
<7> [55.124013] i915 0000:00:02.0: itc: No Data
<7> [55.124016] i915 0000:00:02.0: extended colorimetry: xvYCC 601
<7> [55.124019] i915 0000:00:02.0: quantization range: Full
<7> [55.124022] i915 0000:00:02.0: nups: Unknown Non-uniform Scaling
<7> [55.124025] i915 0000:00:02.0: video code: 0
<7> [55.124028] i915 0000:00:02.0: ycc quantization range: Full
<7> [55.124030] i915 0000:00:02.0: hdmi content type: Graphics
<7> [55.124033] i915 0000:00:02.0: pixel repeat: 0
<7> [55.124036] i915 0000:00:02.0: bar top 0, bottom 0, left 0, right 0
<7> [55.124040] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:170:pipe A] fastset requirement not met in spd infoframe
<7> [55.124268] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] expected:
<7> [55.124493] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] found:
<7> [55.124736] i915 0000:00:02.0: HDMI infoframe: Source Product Description (SPD), version 1, length 25
<7> [55.124739] i915 0000:00:02.0: vendor: Intel
<7> [55.124742] i915 0000:00:02.0: product: Integrated gfx
<7> [55.124745] i915 0000:00:02.0: source device information: PC General (0x9)
<7> [55.124748] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:170:pipe A] fastset requirement not met in hdmi infoframe
<7> [55.124975] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] expected:
<7> [55.125201] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] found:
<7> [55.125426] i915 0000:00:02.0: HDMI infoframe: Vendor, version 1, length 4
<7> [55.125429] i915 0000:00:02.0: empty frame
<7> [55.125433] i915 0000:00:02.0: [drm:intel_atomic_check [i915]] [CRTC:170:pipe A] fastset requirement not met, forcing full modeset
<7> [55.125711] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] Enabled dbuf slices 0x1 -> 0x3 (total dbuf slices 0x3), mbus joined? no->no
<7> [55.125941] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] [CRTC:170:pipe A] dbuf slices 0x0 -> 0x3, ddb (0 - 0) -> (0 - 2048), active pipes 0x0 -> 0x1
<7> [55.126235] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] [PLANE:34:plane 1A] ddb ( 0 - 0) -> ( 0 - 1993), size 0 -> 1993
<7> [55.126462] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] [PLANE:164:cursor A] ddb ( 0 - 0) -> (1993 - 2048), size 0 -> 55
<7> [55.126696] i915 0000:00:02.0: [drm:skl_print_plane_changes [i915]] [PLANE:34:plane 1A] level wm0, wm1, wm2, wm3, wm4, wm5, wm6, wm7, twm, swm, stwm -> *wm0,*wm1,*wm2,*wm3,*wm4,*wm5,*wm6,*wm7,*twm, swm, stwm
<7> [55.126920] i915 0000:00:02.0: [drm:skl_print_plane_changes [i915]] [PLANE:34:plane 1A] lines 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0 -> 1, 8, 8, 8, 8, 11, 16, 16, 0, 0, 0
<7> [55.127145] i915 0000:00:02.0: [drm:skl_print_plane_changes [i915]] [PLANE:34:plane 1A] blocks 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0 -> 16, 129, 129, 129, 129, 177, 257, 257, 30, 0, 0
<7> [55.127368] i915 0000:00:02.0: [drm:skl_print_plane_changes [i915]] [PLANE:34:plane 1A] 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> [55.127625] i915 0000:00:02.0: [drm:intel_bw_atomic_check [i915]] [CRTC:170:pipe A] data rate 1142000 num active planes 1
<7> [55.127699] i915 0000:00:02.0: [drm:intel_power_well_enable [i915]] enabling PW_2
<7> [55.127896] i915 0000:00:02.0: [drm:intel_bw_atomic_check [i915]] QGV point 0: max bw 14993 required 1142
<7> [55.128130] i915 0000:00:02.0: [drm:intel_bw_atomic_check [i915]] No SAGV, using single QGV point mask 0x1
<7> [55.128182] i915 0000:00:02.0: [drm:intel_power_well_enable [i915]] enabling PW_3
<7> [55.128393] i915 0000:00:02.0: [drm:intel_cdclk_atomic_check [i915]] [CRTC:170:pipe A] min cdclk: 0 kHz -> 192000 kHz
<7> [55.128622] i915 0000:00:02.0: [drm:intel_audio_component_get_power [i915]] restored AUD_FREQ_CNTRL to 0x810
<7> [55.128656] i915 0000:00:02.0: [drm:intel_cdclk_update_dbuf_bw_min_cdclk [i915]] dbuf bandwidth min cdclk: 0 kHz -> 17844 kHz
<7> [55.128969] i915 0000:00:02.0: [drm:intel_cdclk_atomic_check [i915]] Modeset required for cdclk change
<7> [55.129221] i915 0000:00:02.0: [drm:intel_cdclk_atomic_check [i915]] New cdclk calculated to be logical 192000 kHz, actual 192000 kHz
<7> [55.129453] i915 0000:00:02.0: [drm:intel_cdclk_atomic_check [i915]] New voltage level calculated to be logical 0, actual 0
<7> [55.129683] i915 0000:00:02.0: [drm:intel_find_dpll [i915]] [CRTC:170:pipe A] allocated DPLL 0
<7> [55.129955] i915 0000:00:02.0: [drm:intel_dpll_crtc_get [i915]] [CRTC:170:pipe A] reserving DPLL 0
<7> [55.130196] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [CRTC:170:pipe A] enable: yes [modeset]
<7> [55.130429] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] active: yes, output_types: HDMI (0x40), output format: RGB, sink format: RGB
<7> [55.130660] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] cpu_transcoder: A, pipe bpp: 24, dithering: 0
<7> [55.130916] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] MST master transcoder: <invalid>
<7> [55.131150] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] port sync: master transcoder: <invalid>, slave transcoder bitmask = 0x0
<7> [55.131382] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] joiner: no, pipes: 0x0
<7> [55.131611] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] splitter: disabled, link count 0, overlap 0
<7> [55.131862] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] audio: 1, infoframes: 1, infoframes enabled: 0x71
<7> [55.132090] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] GCP: 0x0
<7> [55.132320] i915 0000:00:02.0: HDMI infoframe: Auxiliary Video Information (AVI), version 2, length 13
<7> [55.132323] i915 0000:00:02.0: colorspace: RGB
<7> [55.132326] i915 0000:00:02.0: scan mode: Underscan
<7> [55.132329] i915 0000:00:02.0: colorimetry: No Data
<7> [55.132332] i915 0000:00:02.0: picture aspect: No Data
<7> [55.132335] i915 0000:00:02.0: active aspect: Same as Picture
<7> [55.132337] i915 0000:00:02.0: itc: No Data
<7> [55.132340] i915 0000:00:02.0: extended colorimetry: xvYCC 601
<7> [55.132343] i915 0000:00:02.0: quantization range: Full
<7> [55.132346] i915 0000:00:02.0: nups: Unknown Non-uniform Scaling
<7> [55.132349] i915 0000:00:02.0: video code: 0
<7> [55.132351] i915 0000:00:02.0: ycc quantization range: Full
<7> [55.132354] i915 0000:00:02.0: hdmi content type: Graphics
<7> [55.132357] i915 0000:00:02.0: pixel repeat: 0
<7> [55.132360] i915 0000:00:02.0: bar top 0, bottom 0, left 0, right 0
<7> [55.132363] i915 0000:00:02.0: HDMI infoframe: Source Product Description (SPD), version 1, length 25
<7> [55.132366] i915 0000:00:02.0: vendor: Intel
<7> [55.132369] i915 0000:00:02.0: product: Integrated gfx
<7> [55.132372] i915 0000:00:02.0: source device information: PC General (0x9)
<7> [55.132375] i915 0000:00:02.0: HDMI infoframe: Vendor, version 1, length 4
<7> [55.132378] i915 0000:00:02.0: empty frame
<7> [55.132381] 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> [55.132609] 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> [55.132854] 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> [55.133083] 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> [55.133348] azx_init_pci: snd_hda_intel 0000:00:1f.3: Clearing TCSEL
<7> [55.133385] azx_init_pci: snd_hda_intel 0000:00:1f.3: SCH snoop: Enabled
<7> [55.133312] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] scanline offset: 2
<7> [55.133537] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] framestart delay: 1, MSA timing delay: 0, set context latency: 0
<7> [55.133769] 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> [55.134030] 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> [55.134262] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] vrr: dc balance: no, vmin: 0 vmax: 0 guardband: 0, slope: 0 max increase: 0 max decrease: 0 vblank target: 0
<7> [55.134492] 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> [55.134722] 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> [55.134974] 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> [55.135203] 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> [55.135433] 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> [55.135659] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] port clock: 285500, pipe src: 1920x1080+0+0, pixel rate 285500, min cdclk 192000
<7> [55.135901] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] linetime: 59, ips linetime: 0
<7> [55.136125] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] num_scalers: 2, scaler_users: 0x0, scaler_id: -1, scaling_filter: 0
<7> [55.136353] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pch pfit: 0x0+0+0, disabled, force thru: no
<7> [55.136579] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] ips: 0, double wide: 0, drrs: 0
<7> [55.136809] 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> [55.137197] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] csc_mode: 0x0 gamma_mode: 0x0 gamma_enable: 0 csc_enable: 0
<7> [55.137425] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pre csc lut: 0 entries, post csc lut: 0 entries
<7> [55.137651] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] output csc: pre offsets: 0x0000 0x0000 0x0000
<7> [55.137934] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] output csc: coefficients: 0x0000 0x0000 0x0000
<7> [55.138162] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] output csc: coefficients: 0x0000 0x0000 0x0000
<7> [55.138393] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] output csc: coefficients: 0x0000 0x0000 0x0000
<7> [55.138617] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] output csc: post offsets: 0x0000 0x0000 0x0000
<7> [55.138841] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pipe csc: pre offsets: 0x0000 0x0000 0x0000
<7> [55.139095] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pipe csc: coefficients: 0x0000 0x0000 0x0000
<7> [55.139321] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pipe csc: coefficients: 0x0000 0x0000 0x0000
<7> [55.139549] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pipe csc: coefficients: 0x0000 0x0000 0x0000
<7> [55.139777] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pipe csc: post offsets: 0x0000 0x0000 0x0000
<7> [55.140025] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] sharpness strength: 0, sharpness tap size: 0, sharpness enable: 0
<7> [55.140251] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:34:plane 1A] fb: [FB:636] 1920x1080 format = XR24 little-endian (0x34325258) modifier = 0x100000000000001, visible: yes
<7> [55.140482] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] rotation: 0x1, scaler: -1, scaling_filter: 0
<7> [55.140710] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] src: 1920.000000x1080.000000+0.000000+0.000000 dst: 1920x1080+0+0
<7> [55.140963] i915 0000:00:02.0: [drm:intel_power_well_disable [i915]] disabling PW_3
<7> [55.140945] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:64:plane 2A] fb: [NOFB], visible: no
<7> [55.141165] i915 0000:00:02.0: [drm:intel_power_well_disable [i915]] disabling PW_2
<7> [55.141175] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:94:plane 3A] fb: [NOFB], visible: no
<7> [55.141401] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:124:plane 4A] fb: [NOFB], visible: no
<7> [55.141631] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:134:plane 5A] fb: [NOFB], visible: no
<7> [55.141861] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:144:plane 6A] fb: [NOFB], visible: no
<7> [55.142122] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:154:plane 7A] fb: [NOFB], visible: no
<7> [55.142359] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:164:cursor A] fb: [NOFB], visible: no
<7> [55.142820] i915 0000:00:02.0: [drm:intel_power_well_enable [i915]] enabling PW_2
<7> [55.143097] i915 0000:00:02.0: [drm:intel_power_well_enable [i915]] enabling PW_3
<7> [55.143353] 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> [55.143676] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:586:DDI B/PHY B]
<7> [55.143911] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:596:DDI TC1/PHY TC1]
<7> [55.144175] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:598:DP-MST A]
<7> [55.144406] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:599:DP-MST B]
<7> [55.144638] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:600:DP-MST C]
<7> [55.144863] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:601:DP-MST D]
<7> [55.145115] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:606:DDI TC2/PHY TC2]
<7> [55.145338] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:608:DP-MST A]
<7> [55.145562] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:609:DP-MST B]
<7> [55.145789] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:610:DP-MST C]
<7> [55.146022] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:611:DP-MST D]
<7> [55.146248] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:615:DDI TC3/PHY TC3]
<7> [55.146474] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:617:DP-MST A]
<7> [55.146698] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:618:DP-MST B]
<7> [55.146927] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:619:DP-MST C]
<7> [55.147176] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:620:DP-MST D]
<7> [55.147404] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:624:DDI TC4/PHY TC4]
<7> [55.147628] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:626:DP-MST A]
<7> [55.147852] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:627:DP-MST B]
<7> [55.148089] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:628:DP-MST C]
<7> [55.148318] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:629:DP-MST D]
<7> [55.148794] i915 0000:00:02.0: [drm:gen9_dbuf_slices_update [i915]] Updating dbuf slices to 0x3
<7> [55.149141] i915 0000:00:02.0: [drm:intel_dpll_enable [i915]] enable DPLL 0 (active 0x1, on? 0) for [CRTC:170:pipe A]
<7> [55.149382] i915 0000:00:02.0: [drm:intel_dpll_enable [i915]] enabling DPLL 0
<7> [55.150030] i915 0000:00:02.0: [drm:intel_power_well_enable [i915]] enabling DDI_IO_B
<7> [55.150399] i915 0000:00:02.0: [drm:intel_enable_transcoder [i915]] enabling pipe A
<7> [55.150889] i915 0000:00:02.0: [drm:intel_hdmi_handle_sink_scrambling [i915]] [CONNECTOR:587:HDMI-A-1] scrambling=no, TMDS bit clock ratio=1/10
<7> [55.151548] i915 0000:00:02.0: [drm:do_gmbus_xfer [i915]] GMBUS [i915 gmbus dpb] NAK for addr: 0054 w(1)
<7> [55.151767] i915 0000:00:02.0: [drm:do_gmbus_xfer [i915]] GMBUS [i915 gmbus dpb] NAK on first message, retry
<7> [55.152397] i915 0000:00:02.0: [drm:do_gmbus_xfer [i915]] GMBUS [i915 gmbus dpb] NAK for addr: 0054 w(1)
<7> [55.152632] i915 0000:00:02.0: [drm:drm_scdc_set_high_tmds_clock_ratio [drm_display_helper]] [CONNECTOR:587:HDMI-A-1] Failed to read TMDS config: -6
<7> [55.152658] i915 0000:00:02.0: [drm:intel_ddi_enable [i915]] [CONNECTOR:587:HDMI-A-1] Failed to configure sink scrambling/TMDS bit clock ratio
<7> [55.157073] i915 0000:00:02.0: [drm:intel_fbc_update [i915]] reserved 17694720 bytes of contiguous stolen space for FBC, limit: 1
<7> [55.157262] i915 0000:00:02.0: [drm:intel_fbc_update [i915]] Enabling FBC on [PLANE:34:plane 1A]
<7> [55.161369] i915 0000:00:02.0: [drm:intel_audio_codec_enable [i915]] [CONNECTOR:587:HDMI-A-1][ENCODER:586:DDI B/PHY B] Enable audio codec on [CRTC:170:pipe A], 64 bytes ELD
<7> [55.169730] 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> [55.169919] i915 0000:00:02.0: [drm:audio_config_hdmi_pixel_clock [i915]] Configuring HDMI audio for pixel clock 25200 (0x00010000)
<7> [55.170081] i915 0000:00:02.0: [drm:hsw_audio_config_update [i915]] using automatic N
<6> [55.170249] snd_hda_codec_intelhdmi hdaudioC0D2: HDMI: audio coding xtype 5 not expected
<6> [55.170252] snd_hda_codec_intelhdmi hdaudioC0D2: HDMI: audio coding xtype 0 not expected
<6> [55.170253] snd_hda_codec_intelhdmi hdaudioC0D2: HDMI: audio coding xtype 10 not expected
<6> [55.170255] snd_hda_codec_intelhdmi hdaudioC0D2: HDMI: audio coding xtype 6 not expected
<7> [55.170393] i915 0000:00:02.0: [drm:verify_connector_state [i915]] [CONNECTOR:587:HDMI-A-1]
<7> [55.170716] i915 0000:00:02.0: [drm:intel_modeset_verify_crtc [i915]] [CRTC:170:pipe A]
<7> [55.215057] i915 0000:00:02.0: [drm:intel_audio_component_get_power [i915]] restored AUD_FREQ_CNTRL to 0x810
<7> [55.219331] azx_init_pci: snd_hda_intel 0000:00:1f.3: Clearing TCSEL
<7> [55.219367] azx_init_pci: snd_hda_intel 0000:00:1f.3: SCH snoop: Enabled
<6> [63.082908] [IGT] kms_flip: finished subtest A-HDMI-A1, FAIL
|