igt@kms_flip@2x-flip-vs-expired-vblank@ac-hdmi-a1-hdmi-a2 on shard-glk@CI_DRM

Detail	Value
Duration	4.62 seconds
Hostname	shard-glk4
Igt-Version	IGT-Version: 2.4-g0c1d7a873 (x86_64) (Linux: 7.1.0-rc2-CI_DRM_18416-g1dac77f19ea5+ x86_64)
Out	Starting dynamic subtest: AC-HDMI-A1-HDMI-A2 1920x1080: 60 148500 1920 2008 2052 2200 1080 1083 1088 1125 0x48 0x9 1920x1080: 60 148500 1920 2008 2052 2200 1080 1083 1088 1125 0x48 0x9 Stack trace: #0 ../lib/igt_core.c:2075 __igt_fail_assert() #1 ../tests/kms_flip.c:926 run_test_on_crtc_set() #2 ../tests/kms_flip.c:2029 run_pair() #3 ../tests/kms_flip.c:2193 __igt_unique____real_main2105() #4 ../tests/kms_flip.c:2105 main() #5 [__libc_init_first+0x8a] #6 [__libc_start_main+0x8b] #7 [_start+0x25] Dynamic subtest AC-HDMI-A1-HDMI-A2: FAIL (4.622s)
Err	Starting dynamic subtest: AC-HDMI-A1-HDMI-A2 (kms_flip:2323) CRITICAL: Test assertion failure function run_test_step, file ../tests/kms_flip.c:931: (kms_flip:2323) CRITICAL: Failed assertion: end - start < 500 Dynamic subtest AC-HDMI-A1-HDMI-A2 failed. ** DEBUG (kms_flip:2323) DEBUG: name = flip last_ts = 187.271484 last_received_ts = 187.271255 last_seq = 3599 current_ts = 187.288147 current_received_ts = 187.287994 current_seq = 3600 count = 94 seq_step = 1 (kms_flip:2323) DEBUG: Vblank took 25us (kms_flip:2323) DEBUG: name = flip last_ts = 187.288147 last_received_ts = 187.287994 last_seq = 3600 current_ts = 187.304810 current_received_ts = 187.304932 current_seq = 3601 count = 95 seq_step = 1 (kms_flip:2323) DEBUG: Vblank took 73us (kms_flip:2323) DEBUG: name = flip last_ts = 187.304810 last_received_ts = 187.304932 last_seq = 3601 current_ts = 187.321487 current_received_ts = 187.321289 current_seq = 3602 count = 96 seq_step = 1 (kms_flip:2323) DEBUG: Vblank took 25us (kms_flip:2323) DEBUG: name = flip last_ts = 187.321487 last_received_ts = 187.321289 last_seq = 3602 current_ts = 187.338150 current_received_ts = 187.338181 current_seq = 3603 count = 97 seq_step = 1 (kms_flip:2323) DEBUG: Vblank took 24us (kms_flip:2323) DEBUG: name = flip last_ts = 187.338150 last_received_ts = 187.338181 last_seq = 3603 current_ts = 187.354813 current_received_ts = 187.354538 current_seq = 3604 count = 98 seq_step = 1 (kms_flip:2323) DEBUG: Vblank took 21us (kms_flip:2323) DEBUG: name = flip last_ts = 187.354813 last_received_ts = 187.354538 last_seq = 3604 current_ts = 187.371475 current_received_ts = 187.371262 current_seq = 3605 count = 99 seq_step = 1 (kms_flip:2323) DEBUG: Vblank took 20us (kms_flip:2323) DEBUG: name = flip last_ts = 187.371475 last_received_ts = 187.371262 last_seq = 3605 current_ts = 187.388138 current_received_ts = 187.387787 current_seq = 3606 count = 100 seq_step = 1 (kms_flip:2323) DEBUG: Vblank took 20us (kms_flip:2323) DEBUG: name = flip last_ts = 187.388138 last_received_ts = 187.387787 last_seq = 3606 current_ts = 187.404816 current_received_ts = 187.404510 current_seq = 3607 count = 101 seq_step = 1 (kms_flip:2323) DEBUG: Vblank took 19us (kms_flip:2323) DEBUG: name = flip last_ts = 187.404816 last_received_ts = 187.404510 last_seq = 3607 current_ts = 187.421478 current_received_ts = 187.421295 current_seq = 3608 count = 102 seq_step = 1 (kms_flip:2323) DEBUG: Vblank took 20us (kms_flip:2323) DEBUG: name = flip last_ts = 187.421478 last_received_ts = 187.421295 last_seq = 3608 current_ts = 187.438141 current_received_ts = 187.437973 current_seq = 3609 count = 103 seq_step = 1 (kms_flip:2323) DEBUG: Vblank took 24us (kms_flip:2323) DEBUG: name = flip last_ts = 187.438141 last_received_ts = 187.437973 last_seq = 3609 current_ts = 187.454819 current_received_ts = 187.454544 current_seq = 3610 count = 104 seq_step = 1 (kms_flip:2323) DEBUG: Vblank took 22us (kms_flip:2323) DEBUG: name = flip last_ts = 187.454819 last_received_ts = 187.454544 last_seq = 3610 current_ts = 187.471481 current_received_ts = 187.471313 current_seq = 3611 count = 105 seq_step = 1 (kms_flip:2323) DEBUG: Vblank took 23us (kms_flip:2323) DEBUG: name = flip last_ts = 187.471481 last_received_ts = 187.471313 last_seq = 3611 current_ts = 187.488144 current_received_ts = 187.487839 current_seq = 3612 count = 106 seq_step = 1 (kms_flip:2323) DEBUG: Vblank took 22us (kms_flip:2323) DEBUG: name = flip last_ts = 187.488144 last_received_ts = 187.487839 last_seq = 3612 current_ts = 187.504822 current_received_ts = 187.504837 current_seq = 3613 count = 107 seq_step = 1 (kms_flip:2323) DEBUG: Vblank took 23us (kms_flip:2323) DEBUG: name = flip last_ts = 187.504822 last_received_ts = 187.504837 last_seq = 3613 current_ts = 187.521484 current_received_ts = 187.521301 current_seq = 3614 count = 108 seq_step = 1 (kms_flip:2323) DEBUG: Vblank took 21us (kms_flip:2323) DEBUG: name = flip last_ts = 187.521484 last_received_ts = 187.521301 last_seq = 3614 current_ts = 187.538147 current_received_ts = 187.538116 current_seq = 3615 count = 109 seq_step = 1 (kms_flip:2323) DEBUG: Vblank took 25us (kms_flip:2323) DEBUG: name = flip last_ts = 187.538147 last_received_ts = 187.538116 last_seq = 3615 current_ts = 187.554810 current_received_ts = 187.554535 current_seq = 3616 count = 110 seq_step = 1 (kms_flip:2323) DEBUG: Vblank took 25us (kms_flip:2323) DEBUG: name = flip last_ts = 187.554810 last_received_ts = 187.554535 last_seq = 3616 current_ts = 187.571487 current_received_ts = 187.571289 current_seq = 3617 count = 111 seq_step = 1 (kms_flip:2323) DEBUG: Vblank took 21us (kms_flip:2323) DEBUG: name = flip last_ts = 187.571487 last_received_ts = 187.571289 last_seq = 3617 current_ts = 187.588135 current_received_ts = 187.587921 current_seq = 3618 count = 112 seq_step = 1 (kms_flip:2323) DEBUG: Vblank took 23us (kms_flip:2323) DEBUG: name = flip last_ts = 187.588135 last_received_ts = 187.587921 last_seq = 3618 current_ts = 187.604797 current_received_ts = 187.604523 current_seq = 3619 count = 113 seq_step = 1 (kms_flip:2323) DEBUG: Vblank took 21us (kms_flip:2323) DEBUG: name = flip last_ts = 187.604797 last_received_ts = 187.604523 last_seq = 3619 current_ts = 187.621475 current_received_ts = 187.621262 current_seq = 3620 count = 114 seq_step = 1 (kms_flip:2323) DEBUG: Vblank took 24us (kms_flip:2323) DEBUG: name = flip last_ts = 187.621475 last_received_ts = 187.621262 last_seq = 3620 current_ts = 187.638138 current_received_ts = 187.638184 current_seq = 3621 count = 115 seq_step = 1 (kms_flip:2323) DEBUG: Vblank took 24us (kms_flip:2323) DEBUG: name = flip last_ts = 187.638138 last_received_ts = 187.638184 last_seq = 3621 current_ts = 187.654816 current_received_ts = 187.654556 current_seq = 3622 count = 116 seq_step = 1 (kms_flip:2323) DEBUG: Vblank took 22us (kms_flip:2323) DEBUG: name = flip last_ts = 187.654816 last_received_ts = 187.654556 last_seq = 3622 current_ts = 187.671478 current_received_ts = 187.671310 current_seq = 3623 count = 117 seq_step = 1 (kms_flip:2323) DEBUG: Vblank took 24us (kms_flip:2323) DEBUG: name = flip last_ts = 187.671478 last_received_ts = 187.671310 last_seq = 3623 current_ts = 187.688141 current_received_ts = 187.688004 current_seq = 3624 count = 118 seq_step = 1 (kms_flip:2323) DEBUG: Vblank took 21us (kms_flip:2323) DEBUG: name = flip last_ts = 187.688141 last_received_ts = 187.688004 last_seq = 3624 current_ts = 187.704803 current_received_ts = 187.704849 current_seq = 3625 count = 119 seq_step = 1 (kms_flip:2323) DEBUG: Vblank took 23us (kms_flip:2323) DEBUG: name = flip last_ts = 187.704803 last_received_ts = 187.704849 last_seq = 3625 current_ts = 187.721481 current_received_ts = 187.721344 current_seq = 3626 count = 120 seq_step = 1 (kms_flip:2323) DEBUG: Vblank took 25us (kms_flip:2323) DEBUG: name = flip last_ts = 187.721481 last_received_ts = 187.721344 last_seq = 3626 current_ts = 187.738129 current_received_ts = 187.738205 current_seq = 3627 count = 121 seq_step = 1 (kms_flip:2323) DEBUG: Vblank took 25us (kms_flip:2323) DEBUG: name = flip last_ts = 187.738129 last_received_ts = 187.738205 last_seq = 3627 current_ts = 187.754791 current_received_ts = 187.754532 current_seq = 3628 count = 122 seq_step = 1 (kms_flip:2323) DEBUG: Vblank took 23us (kms_flip:2323) DEBUG: name = flip last_ts = 187.754791 last_received_ts = 187.754532 last_seq = 3628 current_ts = 187.771469 current_received_ts = 187.771301 current_seq = 3629 count = 123 seq_step = 1 (kms_flip:2323) DEBUG: Vblank took 23us (kms_flip:2323) DEBUG: name = flip last_ts = 187.771469 last_received_ts = 187.771301 last_seq = 3629 current_ts = 187.788147 current_received_ts = 187.788101 current_seq = 3630 count = 124 seq_step = 1 (kms_flip:2323) DEBUG: Vblank took 25us (kms_flip:2323) DEBUG: name = flip last_ts = 187.788147 last_received_ts = 187.788101 last_seq = 3630 current_ts = 187.804810 current_received_ts = 187.804504 current_seq = 3631 count = 125 seq_step = 1 (kms_flip:2323) DEBUG: Vblank took 25us (kms_flip:2323) DEBUG: name = flip last_ts = 187.804810 last_received_ts = 187.804504 last_seq = 3631 current_ts = 187.821472 current_received_ts = 187.821289 current_seq = 3632 count = 126 seq_step = 1 (kms_flip:2323) DEBUG: Vblank took 19us (kms_flip:2323) DEBUG: name = flip last_ts = 187.821472 last_received_ts = 187.821289 last_seq = 3632 current_ts = 187.838135 current_received_ts = 187.838074 current_seq = 3633 count = 127 seq_step = 1 (kms_flip:2323) DEBUG: Vblank took 26us (kms_flip:2323) DEBUG: name = flip last_ts = 187.838135 last_received_ts = 187.838074 last_seq = 3633 current_ts = 187.854797 current_received_ts = 187.854553 current_seq = 3634 count = 128 seq_step = 1 (kms_flip:2323) DEBUG: Vblank took 25us (kms_flip:2323) DEBUG: name = flip last_ts = 187.854797 last_received_ts = 187.854553 last_seq = 3634 current_ts = 187.871460 current_received_ts = 187.871307 current_seq = 3635 count = 129 seq_step = 1 (kms_flip:2323) DEBUG: Vblank took 23us (kms_flip:2323) DEBUG: name = flip last_ts = 187.871460 last_received_ts = 187.871307 last_seq = 3635 current_ts = 187.888123 current_received_ts = 187.887772 current_seq = 3636 count = 130 seq_step = 1 (kms_flip:2323) DEBUG: Vblank took 25us (kms_flip:2323) DEBUG: name = flip last_ts = 187.888123 last_received_ts = 187.887772 last_seq = 3636 current_ts = 187.904800 current_received_ts = 187.905045 current_seq = 3637 count = 131 seq_step = 1 (kms_flip:2323) DEBUG: Vblank took 21us (kms_flip:2323) DEBUG: name = flip last_ts = 187.904800 last_received_ts = 187.905045 last_seq = 3637 current_ts = 187.921463 current_received_ts = 187.921249 current_seq = 3638 count = 132 seq_step = 1 (kms_flip:2323) DEBUG: Vblank took 24us (kms_flip:2323) DEBUG: name = flip last_ts = 187.921463 last_received_ts = 187.921249 last_seq = 3638 current_ts = 187.938126 current_received_ts = 187.938217 current_seq = 3639 count = 133 seq_step = 1 (kms_flip:2323) DEBUG: Vblank took 26us (kms_flip:2323) DEBUG: name = flip last_ts = 187.938126 last_received_ts = 187.938217 last_seq = 3639 current_ts = 187.954788 current_received_ts = 187.954529 current_seq = 3640 count = 134 seq_step = 1 (kms_flip:2323) DEBUG: Vblank took 21us (kms_flip:2323) DEBUG: name = flip last_ts = 187.954788 last_received_ts = 187.954529 last_seq = 3640 current_ts = 187.971466 current_received_ts = 187.971237 current_seq = 3641 count = 135 seq_step = 1 (kms_flip:2323) DEBUG: Vblank took 26us (kms_flip:2323) DEBUG: name = flip last_ts = 187.971466 last_received_ts = 187.971237 last_seq = 3641 current_ts = 187.988129 current_received_ts = 187.988098 current_seq = 3642 count = 136 seq_step = 1 (kms_flip:2323) DEBUG: Vblank took 26us (kms_flip:2323) DEBUG: name = flip last_ts = 187.988129 last_received_ts = 187.988098 last_seq = 3642 current_ts = 188.004807 current_received_ts = 188.004532 current_seq = 3643 count = 137 seq_step = 1 (kms_flip:2323) DEBUG: Vblank took 23us (kms_flip:2323) DEBUG: name = flip last_ts = 188.004807 last_received_ts = 188.004532 last_seq = 3643 current_ts = 188.021469 current_received_ts = 188.021271 current_seq = 3644 count = 138 seq_step = 1 (kms_flip:2323) DEBUG: Vblank took 23us (kms_flip:2323) DEBUG: name = flip last_ts = 188.021469 last_received_ts = 188.021271 last_seq = 3644 current_ts = 188.038132 current_received_ts = 188.037842 current_seq = 3645 count = 139 seq_step = 1 (kms_flip:2323) DEBUG: Vblank took 24us (kms_flip:2323) DEBUG: name = flip last_ts = 188.038132 last_received_ts = 188.037842 last_seq = 3645 current_ts = 188.054810 current_received_ts = 188.054504 current_seq = 3646 count = 140 seq_step = 1 (kms_flip:2323) DEBUG: Vblank took 20us (kms_flip:2323) DEBUG: name = flip last_ts = 188.054810 last_received_ts = 188.054504 last_seq = 3646 current_ts = 188.071457 current_received_ts = 188.071289 current_seq = 3647 count = 141 seq_step = 1 (kms_flip:2323) DEBUG: Vblank took 21us (kms_flip:2323) DEBUG: name = flip last_ts = 188.071457 last_received_ts = 188.071289 last_seq = 3647 current_ts = 188.088135 current_received_ts = 188.087921 current_seq = 3648 count = 142 seq_step = 1 (kms_flip:2323) DEBUG: Vblank took 86us (kms_flip:2323) DEBUG: name = flip last_ts = 188.088135 last_received_ts = 188.087921 last_seq = 3648 current_ts = 188.104797 current_received_ts = 188.104996 current_seq = 3649 count = 143 seq_step = 1 (kms_flip:2323) DEBUG: Vblank took 23us (kms_flip:2323) DEBUG: name = flip last_ts = 188.104797 last_received_ts = 188.104996 last_seq = 3649 current_ts = 188.121460 current_received_ts = 188.121262 current_seq = 3650 count = 144 seq_step = 1 (kms_flip:2323) DEBUG: Vblank took 20us (kms_flip:2323) DEBUG: name = flip last_ts = 188.121460 last_received_ts = 188.121262 last_seq = 3650 current_ts = 188.138123 current_received_ts = 188.138077 current_seq = 3651 count = 145 seq_step = 1 (kms_flip:2323) DEBUG: Vblank took 25us (kms_flip:2323) DEBUG: name = flip last_ts = 188.138123 last_received_ts = 188.138077 last_seq = 3651 current_ts = 188.154800 current_received_ts = 188.154480 current_seq = 3652 count = 146 seq_step = 1 (kms_flip:2323) DEBUG: Vblank took 25us (kms_flip:2323) DEBUG: name = flip last_ts = 188.154800 last_received_ts = 188.154480 last_seq = 3652 current_ts = 188.171463 current_received_ts = 188.171280 current_seq = 3653 count = 147 seq_step = 1 (kms_flip:2323) DEBUG: Vblank took 24us (kms_flip:2323) DEBUG: name = flip last_ts = 188.171463 last_received_ts = 188.171280 last_seq = 3653 current_ts = 188.188126 current_received_ts = 188.187973 current_seq = 3654 count = 148 seq_step = 1 (kms_flip:2323) DEBUG: Vblank took 22us (kms_flip:2323) DEBUG: name = flip last_ts = 188.188126 last_received_ts = 188.187973 last_seq = 3654 current_ts = 188.204803 current_received_ts = 188.204529 current_seq = 3655 count = 149 seq_step = 1 (kms_flip:2323) DEBUG: Vblank took 23us (kms_flip:2323) DEBUG: name = flip last_ts = 188.204803 last_received_ts = 188.204529 last_seq = 3655 current_ts = 188.221466 current_received_ts = 188.221268 current_seq = 3656 count = 150 seq_step = 1 (kms_flip:2323) DEBUG: Vblank took 23us (kms_flip:2323) DEBUG: name = flip last_ts = 188.221466 last_received_ts = 188.221268 last_seq = 3656 current_ts = 188.238129 current_received_ts = 188.237778 current_seq = 3657 count = 151 seq_step = 1 (kms_flip:2323) DEBUG: Vblank took 24us (kms_flip:2323) DEBUG: name = flip last_ts = 188.238129 last_received_ts = 188.237778 last_seq = 3657 current_ts = 188.254791 current_received_ts = 188.254486 current_seq = 3658 count = 152 seq_step = 1 (kms_flip:2323) DEBUG: Vblank took 23us (kms_flip:2323) DEBUG: name = flip last_ts = 188.254791 last_received_ts = 188.254486 last_seq = 3658 current_ts = 188.271469 current_received_ts = 188.271301 current_seq = 3659 count = 153 seq_step = 1 (kms_flip:2323) DEBUG: Vblank took 21us (kms_flip:2323) DEBUG: name = flip last_ts = 188.271469 last_received_ts = 188.271301 last_seq = 3659 current_ts = 188.288116 current_received_ts = 188.287979 current_seq = 3660 count = 154 seq_step = 1 (kms_flip:2323) DEBUG: Vblank took 23us (kms_flip:2323) DEBUG: name = flip last_ts = 188.288116 last_received_ts = 188.287979 last_seq = 3660 current_ts = 188.304794 current_received_ts = 188.304932 current_seq = 3661 count = 155 seq_step = 1 (kms_flip:2323) DEBUG: Vblank took 69us (kms_flip:2323) DEBUG: name = flip last_ts = 188.304794 last_received_ts = 188.304932 last_seq = 3661 current_ts = 188.321457 current_received_ts = 188.321320 current_seq = 3662 count = 156 seq_step = 1 (kms_flip:2323) DEBUG: Vblank took 20us (kms_flip:2323) DEBUG: name = flip last_ts = 188.321457 last_received_ts = 188.321320 last_seq = 3662 current_ts = 188.338135 current_received_ts = 188.337997 current_seq = 3663 count = 157 seq_step = 1 (kms_flip:2323) DEBUG: Vblank took 22us (kms_flip:2323) DEBUG: name = flip last_ts = 188.338135 last_received_ts = 188.337997 last_seq = 3663 current_ts = 188.354797 current_received_ts = 188.354538 current_seq = 3664 count = 158 seq_step = 1 (kms_flip:2323) DEBUG: Vblank took 21us (kms_flip:2323) DEBUG: name = flip last_ts = 188.354797 last_received_ts = 188.354538 last_seq = 3664 current_ts = 188.371445 current_received_ts = 188.371323 current_seq = 3665 count = 159 seq_step = 1 (kms_flip:2323) DEBUG: Vblank took 24us (kms_flip:2323) DEBUG: name = flip last_ts = 188.371445 last_received_ts = 188.371323 last_seq = 3665 current_ts = 188.388123 current_received_ts = 188.388046 current_seq = 3666 count = 160 seq_step = 1 (kms_flip:2323) DEBUG: Vblank took 19us (kms_flip:2323) DEBUG: name = flip last_ts = 188.388123 last_received_ts = 188.388046 last_seq = 3666 current_ts = 188.404800 current_received_ts = 188.404907 current_seq = 3667 count = 161 seq_step = 1 (kms_flip:2323) DEBUG: Vblank took 25us (kms_flip:2323) DEBUG: name = flip last_ts = 188.404800 last_received_ts = 188.404907 last_seq = 3667 current_ts = 188.421448 current_received_ts = 188.421265 current_seq = 3668 count = 162 seq_step = 1 (kms_flip:2323) DEBUG: Vblank took 23us (kms_flip:2323) DEBUG: name = flip last_ts = 188.421448 last_received_ts = 188.421265 last_seq = 3668 current_ts = 188.438126 current_received_ts = 188.437836 current_seq = 3669 count = 163 seq_step = 1 (kms_flip:2323) DEBUG: Vblank took 24us (kms_flip:2323) DEBUG: name = flip last_ts = 188.438126 last_received_ts = 188.437836 last_seq = 3669 current_ts = 188.454788 current_received_ts = 188.454514 current_seq = 3670 count = 164 seq_step = 1 (kms_flip:2323) DEBUG: Vblank took 24us (kms_flip:2323) DEBUG: name = flip last_ts = 188.454788 last_received_ts = 188.454514 last_seq = 3670 current_ts = 188.471466 current_received_ts = 188.471313 current_seq = 3671 count = 165 seq_step = 1 (kms_flip:2323) DEBUG: Vblank took 25us (kms_flip:2323) DEBUG: name = flip last_ts = 188.471466 last_received_ts = 188.471313 last_seq = 3671 current_ts = 188.488129 current_received_ts = 188.487976 current_seq = 3672 count = 166 seq_step = 1 (kms_flip:2323) DEBUG: Vblank took 24us (kms_flip:2323) DEBUG: name = flip last_ts = 188.488129 last_received_ts = 188.487976 last_seq = 3672 current_ts = 188.504791 current_received_ts = 188.504990 current_seq = 3673 count = 167 seq_step = 1 (kms_flip:2323) DEBUG: Vblank took 23us (kms_flip:2323) DEBUG: name = flip last_ts = 188.504791 last_received_ts = 188.504990 last_seq = 3673 current_ts = 188.521469 current_received_ts = 188.521301 current_seq = 3674 count = 168 seq_step = 1 (kms_flip:2323) DEBUG: Vblank took 23us (kms_flip:2323) DEBUG: name = flip last_ts = 188.521469 last_received_ts = 188.521301 last_seq = 3674 current_ts = 188.538132 current_received_ts = 188.537994 current_seq = 3675 count = 169 seq_step = 1 (kms_flip:2323) DEBUG: Vblank took 23us (kms_flip:2323) DEBUG: name = flip last_ts = 188.538132 last_received_ts = 188.537994 last_seq = 3675 current_ts = 188.554779 current_received_ts = 188.554504 current_seq = 3676 count = 170 seq_step = 1 (kms_flip:2323) DEBUG: Vblank took 23us (kms_flip:2323) DEBUG: name = flip last_ts = 188.554779 last_received_ts = 188.554504 last_seq = 3676 current_ts = 188.571457 current_received_ts = 188.571304 current_seq = 3677 count = 171 seq_step = 1 (kms_flip:2323) DEBUG: Vblank took 23us (kms_flip:2323) DEBUG: name = flip last_ts = 188.571457 last_received_ts = 188.571304 last_seq = 3677 current_ts = 188.588120 current_received_ts = 188.587814 current_seq = 3678 count = 172 seq_step = 1 (kms_flip:2323) DEBUG: Vblank took 24us (kms_flip:2323) DEBUG: name = flip last_ts = 188.588120 last_received_ts = 188.587814 last_seq = 3678 current_ts = 188.604782 current_received_ts = 188.604538 current_seq = 3679 count = 173 seq_step = 1 (kms_flip:2323) DEBUG: Vblank took 24us (kms_flip:2323) DEBUG: name = flip last_ts = 188.604782 last_received_ts = 188.604538 last_seq = 3679 current_ts = 188.621445 current_received_ts = 188.621307 current_seq = 3680 count = 174 seq_step = 1 (kms_flip:2323) DEBUG: Vblank took 23us (kms_flip:2323) DEBUG: name = flip last_ts = 188.621445 last_received_ts = 188.621307 last_seq = 3680 current_ts = 188.638123 current_received_ts = 188.638153 current_seq = 3681 count = 175 seq_step = 1 (kms_flip:2323) DEBUG: Vblank took 25us (kms_flip:2323) DEBUG: name = flip last_ts = 188.638123 last_received_ts = 188.638153 last_seq = 3681 current_ts = 188.654785 current_received_ts = 188.654526 current_seq = 3682 count = 176 seq_step = 1 (kms_flip:2323) DEBUG: Vblank took 23us (kms_flip:2323) DEBUG: name = flip last_ts = 188.654785 last_received_ts = 188.654526 last_seq = 3682 current_ts = 188.671448 current_received_ts = 188.671310 current_seq = 3683 count = 177 seq_step = 1 (kms_flip:2323) DEBUG: Vblank took 23us (kms_flip:2323) DEBUG: name = flip last_ts = 188.671448 last_received_ts = 188.671310 last_seq = 3683 current_ts = 188.688110 current_received_ts = 188.687973 current_seq = 3684 count = 178 seq_step = 1 (kms_flip:2323) DEBUG: Vblank took 26us (kms_flip:2323) DEBUG: name = flip last_ts = 188.688110 last_received_ts = 188.687973 last_seq = 3684 current_ts = 188.704773 current_received_ts = 188.704910 current_seq = 3685 count = 179 seq_step = 1 (kms_flip:2323) DEBUG: Vblank took 76us (kms_flip:2323) DEBUG: name = flip last_ts = 188.704773 last_received_ts = 188.704910 last_seq = 3685 current_ts = 188.721436 current_received_ts = 188.721298 current_seq = 3686 count = 180 seq_step = 1 (kms_flip:2323) DEBUG: Vblank took 24us (kms_flip:2323) DEBUG: name = flip last_ts = 188.721436 last_received_ts = 188.721298 last_seq = 3686 current_ts = 188.738113 current_received_ts = 188.737885 current_seq = 3687 count = 181 seq_step = 1 (kms_flip:2323) DEBUG: Vblank took 23us (kms_flip:2323) DEBUG: name = flip last_ts = 188.738113 last_received_ts = 188.737885 last_seq = 3687 current_ts = 188.754791 current_received_ts = 188.754547 current_seq = 3688 count = 182 seq_step = 1 (kms_flip:2323) DEBUG: Vblank took 21us (kms_flip:2323) DEBUG: name = flip last_ts = 188.754791 last_received_ts = 188.754547 last_seq = 3688 current_ts = 188.771454 current_received_ts = 188.771286 current_seq = 3689 count = 183 seq_step = 1 (kms_flip:2323) DEBUG: Vblank took 21us (kms_flip:2323) DEBUG: name = flip last_ts = 188.771454 last_received_ts = 188.771286 last_seq = 3689 current_ts = 188.788101 current_received_ts = 188.788071 current_seq = 3690 count = 184 seq_step = 1 (kms_flip:2323) DEBUG: Vblank took 25us (kms_flip:2323) DEBUG: name = flip last_ts = 188.788101 last_received_ts = 188.788071 last_seq = 3690 current_ts = 188.804779 current_received_ts = 188.804550 current_seq = 3691 count = 185 seq_step = 1 (kms_flip:2323) DEBUG: Vblank took 21us (kms_flip:2323) DEBUG: name = flip last_ts = 188.804779 last_received_ts = 188.804550 last_seq = 3691 current_ts = 188.821457 current_received_ts = 188.821335 current_seq = 3692 count = 186 seq_step = 1 (kms_flip:2323) DEBUG: Vblank took 24us (kms_flip:2323) DEBUG: name = flip last_ts = 188.821457 last_received_ts = 188.821335 last_seq = 3692 current_ts = 188.838104 current_received_ts = 188.837830 current_seq = 3693 count = 187 seq_step = 1 (kms_flip:2323) DEBUG: Vblank took 23us (kms_flip:2323) DEBUG: name = flip last_ts = 188.838104 last_received_ts = 188.837830 last_seq = 3693 current_ts = 188.854782 current_received_ts = 188.854553 current_seq = 3694 count = 188 seq_step = 1 (kms_flip:2323) DEBUG: Vblank took 22us (kms_flip:2323) DEBUG: name = flip last_ts = 188.854782 last_received_ts = 188.854553 last_seq = 3694 current_ts = 188.871445 current_received_ts = 188.871246 current_seq = 3695 count = 189 seq_step = 1 (kms_flip:2323) DEBUG: Vblank took 23us (kms_flip:2323) DEBUG: name = flip last_ts = 188.871445 last_received_ts = 188.871246 last_seq = 3695 current_ts = 188.888107 current_received_ts = 188.887772 current_seq = 3696 count = 190 seq_step = 1 (kms_flip:2323) DEBUG: Vblank took 25us (kms_flip:2323) DEBUG: name = flip last_ts = 188.888107 last_received_ts = 188.887772 last_seq = 3696 current_ts = 188.904770 current_received_ts = 188.904938 current_seq = 3697 count = 191 seq_step = 1 (kms_flip:2323) DEBUG: Vblank took 25us (kms_flip:2323) DEBUG: name = flip last_ts = 188.904770 last_received_ts = 188.904938 last_seq = 3697 current_ts = 188.921448 current_received_ts = 188.921310 current_seq = 3698 count = 192 seq_step = 1 (kms_flip:2323) DEBUG: Vblank took 19us (kms_flip:2323) DEBUG: name = flip last_ts = 188.921448 last_received_ts = 188.921310 last_seq = 3698 current_ts = 188.938110 current_received_ts = 188.937866 current_seq = 3699 count = 193 seq_step = 1 (kms_flip:2323) DEBUG: Vblank took 22us (kms_flip:2323) DEBUG: name = flip last_ts = 188.938110 last_received_ts = 188.937866 last_seq = 3699 current_ts = 188.954773 current_received_ts = 188.954636 current_seq = 3700 count = 194 seq_step = 1 (kms_flip:2323) DEBUG: Vblank took 24us (kms_flip:2323) DEBUG: name = flip last_ts = 188.954773 last_received_ts = 188.954636 last_seq = 3700 current_ts = 188.971451 current_received_ts = 188.971451 current_seq = 3701 count = 195 seq_step = 1 (kms_flip:2323) DEBUG: Vblank took 24us (kms_flip:2323) DEBUG: name = flip last_ts = 188.971451 last_received_ts = 188.971451 last_seq = 3701 current_ts = 188.988113 current_received_ts = 188.987823 current_seq = 3702 count = 196 seq_step = 1 (kms_flip:2323) DEBUG: Vblank took 24us (kms_flip:2323) DEBUG: name = flip last_ts = 188.988113 last_received_ts = 188.987823 last_seq = 3702 current_ts = 189.004776 current_received_ts = 189.004822 current_seq = 3703 count = 197 seq_step = 1 (kms_flip:2323) DEBUG: Vblank took 20us (kms_flip:2323) DEBUG: name = flip last_ts = 189.004776 last_received_ts = 189.004822 last_seq = 3703 current_ts = 189.021439 current_received_ts = 189.021255 current_seq = 3704 count = 198 seq_step = 1 (kms_flip:2323) DEBUG: Vblank took 20us (kms_flip:2323) DEBUG: name = flip last_ts = 189.021439 last_received_ts = 189.021255 last_seq = 3704 current_ts = 189.038116 current_received_ts = 189.037994 current_seq = 3705 count = 199 seq_step = 1 (kms_flip:2323) DEBUG: Vblank took 20us (kms_flip:2323) DEBUG: name = flip last_ts = 189.038116 last_received_ts = 189.037994 last_seq = 3705 current_ts = 189.054779 current_received_ts = 189.054535 current_seq = 3706 count = 200 seq_step = 1 (kms_flip:2323) DEBUG: Vblank took 23us (kms_flip:2323) DEBUG: name = flip last_ts = 189.054779 last_received_ts = 189.054535 last_seq = 3706 current_ts = 189.071442 current_received_ts = 189.071274 current_seq = 3707 count = 201 seq_step = 1 (kms_flip:2323) DEBUG: Vblank took 22us (kms_flip:2323) DEBUG: name = flip last_ts = 189.071442 last_received_ts = 189.071274 last_seq = 3707 current_ts = 189.088104 current_received_ts = 189.087982 current_seq = 3708 count = 202 seq_step = 1 (kms_flip:2323) DEBUG: Vblank took 20us (kms_flip:2323) DEBUG: name = flip last_ts = 189.088104 last_received_ts = 189.087982 last_seq = 3708 current_ts = 189.104767 current_received_ts = 189.104950 current_seq = 3709 count = 203 seq_step = 1 (kms_flip:2323) DEBUG: Vblank took 25us (kms_flip:2323) DEBUG: name = flip last_ts = 189.104767 last_received_ts = 189.104950 last_seq = 3709 current_ts = 189.121445 current_received_ts = 189.121277 current_seq = 3710 count = 204 seq_step = 1 (kms_flip:2323) DEBUG: Vblank took 20us (kms_flip:2323) DEBUG: name = flip last_ts = 189.121445 last_received_ts = 189.121277 last_seq = 3710 current_ts = 189.138107 current_received_ts = 189.137970 current_seq = 3711 count = 205 seq_step = 1 (kms_flip:2323) DEBUG: Vblank took 70us (kms_flip:2323) DEBUG: name = flip last_ts = 189.138107 last_received_ts = 189.137970 last_seq = 3711 current_ts = 189.154770 current_received_ts = 189.154526 current_seq = 3712 count = 206 seq_step = 1 (kms_flip:2323) DEBUG: Vblank took 20us (kms_flip:2323) DEBUG: name = flip last_ts = 189.154770 last_received_ts = 189.154526 last_seq = 3712 current_ts = 189.171432 current_received_ts = 189.171249 current_seq = 3713 count = 207 seq_step = 1 (kms_flip:2323) DEBUG: Vblank took 22us (kms_flip:2323) DEBUG: name = flip last_ts = 189.171432 last_received_ts = 189.171249 last_seq = 3713 current_ts = 189.188110 current_received_ts = 189.187775 current_seq = 3714 count = 208 seq_step = 1 (kms_flip:2323) DEBUG: Vblank took 21us (kms_flip:2323) DEBUG: name = flip last_ts = 189.188110 last_received_ts = 189.187775 last_seq = 3714 current_ts = 189.204773 current_received_ts = 189.204559 current_seq = 3715 count = 209 seq_step = 1 (kms_flip:2323) DEBUG: Vblank took 23us (kms_flip:2323) DEBUG: name = flip last_ts = 189.204773 last_received_ts = 189.204559 last_seq = 3715 current_ts = 189.221436 current_received_ts = 189.221115 current_seq = 3716 count = 210 seq_step = 1 (kms_flip:2323) DEBUG: Vblank took 20us (kms_flip:2323) DEBUG: name = flip last_ts = 189.221436 last_received_ts = 189.221115 last_seq = 3716 current_ts = 189.238098 current_received_ts = 189.237808 current_seq = 3717 count = 211 seq_step = 1 (kms_flip:2323) DEBUG: Vblank took 24us (kms_flip:2323) DEBUG: name = flip last_ts = 189.238098 last_received_ts = 189.237808 last_seq = 3717 current_ts = 189.254776 current_received_ts = 189.254517 current_seq = 3718 count = 212 seq_step = 1 (kms_flip:2323) DEBUG: Vblank took 22us (kms_flip:2323) DEBUG: name = flip last_ts = 189.254776 last_received_ts = 189.254517 last_seq = 3718 current_ts = 189.271439 current_received_ts = 189.271286 current_seq = 3719 count = 213 seq_step = 1 (kms_flip:2323) DEBUG: Vblank took 20us (kms_flip:2323) DEBUG: name = flip last_ts = 189.271439 last_received_ts = 189.271286 last_seq = 3719 current_ts = 189.288101 current_received_ts = 189.287827 current_seq = 3720 count = 214 seq_step = 1 (kms_flip:2323) DEBUG: Vblank took 24us (kms_flip:2323) DEBUG: name = flip last_ts = 189.288101 last_received_ts = 189.287827 last_seq = 3720 current_ts = 189.304764 current_received_ts = 189.304932 current_seq = 3721 count = 215 seq_step = 1 (kms_flip:2323) DEBUG: Vblank took 1445us (kms_flip:2323) CRITICAL: Test assertion failure function run_test_step, file ../tests/kms_flip.c:931: (kms_flip:2323) CRITICAL: Failed assertion: end - start < 500 (kms_flip:2323) igt_core-INFO: Stack trace: (kms_flip:2323) igt_core-INFO: #0 ../lib/igt_core.c:2075 __igt_fail_assert() (kms_flip:2323) igt_core-INFO: #1 ../tests/kms_flip.c:926 run_test_on_crtc_set() (kms_flip:2323) igt_core-INFO: #2 ../tests/kms_flip.c:2029 run_pair() (kms_flip:2323) igt_core-INFO: #3 ../tests/kms_flip.c:2193 __igt_unique____real_main2105() (kms_flip:2323) igt_core-INFO: #4 ../tests/kms_flip.c:2105 main() (kms_flip:2323) igt_core-INFO: #5 [__libc_init_first+0x8a] (kms_flip:2323) igt_core-INFO: #6 [__libc_start_main+0x8b] (kms_flip:2323) igt_core-INFO: #7 [_start+0x25] END ** Dynamic subtest AC-HDMI-A1-HDMI-A2: FAIL (4.622s)
Dmesg	<6> [184.987035] [IGT] kms_flip: starting dynamic subtest AC-HDMI-A1-HDMI-A2 <7> [184.988878] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:182] <7> [184.989911] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:184] <7> [185.046505] i915 0000:00:02.0: [drm:drm_mode_setcrtc] [CRTC:78:pipe A] <7> [185.047008] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:78:pipe A] fastset requirement not met in hw.enable (expected yes, found no) <7> [185.049753] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:78:pipe A] fastset requirement not met in hw.active (expected yes, found no) <7> [185.050726] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:78:pipe A] fastset requirement not met in cpu_transcoder (expected 0, found -1) <7> [185.051133] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:78:pipe A] fastset requirement not met in lane_count (expected 4, found 0) <7> [185.051580] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:78:pipe A] fastset requirement not met in lane_lat_optim_mask (expected 0x0000000d, found 0x00000000) <7> [185.051985] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:78:pipe A] fastset requirement not met in output_types (expected 0x00000040, found 0x00000000) <7> [185.052452] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:78:pipe A] fastset requirement not met in framestart_delay (expected 1, found 0) <7> [185.052833] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:78:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hdisplay (expected 1920, found 0) <7> [185.053254] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:78:pipe A] fastset requirement not met in hw.pipe_mode.crtc_htotal (expected 2200, found 0) <7> [185.053636] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:78:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hblank_start (expected 1920, found 0) <7> [185.054014] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:78:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hblank_end (expected 2200, found 0) <7> [185.054438] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:78:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hsync_start (expected 2008, found 0) <7> [185.054988] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:78:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hsync_end (expected 2052, found 0) <7> [185.055464] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:78:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vdisplay (expected 1080, found 0) <7> [185.055906] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:78:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vblank_start (expected 1080, found 0) <7> [185.056327] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:78:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vsync_start (expected 1083, found 0) <7> [185.056706] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:78:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vsync_end (expected 1088, found 0) <7> [185.057142] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:78:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vtotal (expected 1125, found 0) <7> [185.057566] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:78:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vblank_end (expected 1125, found 0) <7> [185.057944] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:78:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hdisplay (expected 1920, found 0) <7> [185.058366] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:78:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_htotal (expected 2200, found 0) <7> [185.058776] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:78:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hblank_start (expected 1920, found 0) <7> [185.059154] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:78:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hblank_end (expected 2200, found 0) <7> [185.059556] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:78:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hsync_start (expected 2008, found 0) <7> [185.059958] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:78:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hsync_end (expected 2052, found 0) <7> [185.060375] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:78:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vdisplay (expected 1080, found 0) <7> [185.060753] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:78:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vblank_start (expected 1080, found 0) <7> [185.061129] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:78:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vsync_start (expected 1083, found 0) <7> [185.061539] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:78:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vsync_end (expected 1088, found 0) <7> [185.061921] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:78:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vtotal (expected 1125, found 0) <7> [185.062385] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:78:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vblank_end (expected 1125, found 0) <7> [185.062772] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:78:pipe A] fastset requirement not met in pixel_multiplier (expected 1, found 0) <7> [185.063274] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:78:pipe A] fastset requirement not met in hw.adjusted_mode.flags (1) (expected 1, found 0) <7> [185.063752] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:78:pipe A] fastset requirement not met in hw.adjusted_mode.flags (8) (expected 8, found 0) <7> [185.064154] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:78:pipe A] fastset requirement not met in has_hdmi_sink (expected yes, found no) <7> [185.064599] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:78:pipe A] fastset requirement not met in has_infoframe (expected yes, found no) <7> [185.065006] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:78:pipe A] fastset requirement not met in pipe_bpp (expected 36, found 0) <7> [185.065421] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:78:pipe A] fastset requirement not met in hw.pipe_mode.crtc_clock (expected 148500, found 0) <7> [185.065827] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:78:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_clock (expected 148500, found 0) <7> [185.066238] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:78:pipe A] fastset requirement not met in port_clock (expected 222750, found 0) <7> [185.066619] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:78:pipe A] fastset requirement not met in infoframes.enable (expected 0x00000071, found 0x00000000) <7> [185.067032] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:78:pipe A] fastset requirement not met in infoframes.gcp (expected 0x00000006, found 0x00000000) <7> [185.067501] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:78:pipe A] fastset requirement not met in avi infoframe <7> [185.067882] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] expected: <7> [185.068285] i915 0000:00:02.0: HDMI infoframe: Auxiliary Video Information (AVI), version 2, length 13 <7> [185.068290] i915 0000:00:02.0: colorspace: RGB <7> [185.068294] i915 0000:00:02.0: scan mode: Underscan <7> [185.068297] i915 0000:00:02.0: colorimetry: No Data <7> [185.068300] i915 0000:00:02.0: picture aspect: No Data <7> [185.068303] i915 0000:00:02.0: active aspect: Same as Picture <7> [185.068307] i915 0000:00:02.0: itc: No Data <7> [185.068310] i915 0000:00:02.0: extended colorimetry: xvYCC 601 <7> [185.068313] i915 0000:00:02.0: quantization range: Full <7> [185.068316] i915 0000:00:02.0: nups: Unknown Non-uniform Scaling <7> [185.068319] i915 0000:00:02.0: video code: 0 <7> [185.068322] i915 0000:00:02.0: ycc quantization range: Full <7> [185.068325] i915 0000:00:02.0: hdmi content type: Graphics <7> [185.068329] i915 0000:00:02.0: pixel repeat: 0 <7> [185.068332] i915 0000:00:02.0: bar top 0, bottom 0, left 0, right 0 <7> [185.068335] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] found: <7> [185.068723] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:78:pipe A] fastset requirement not met in spd infoframe <7> [185.069152] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] expected: <7> [185.069566] i915 0000:00:02.0: HDMI infoframe: Source Product Description (SPD), version 1, length 25 <7> [185.069571] i915 0000:00:02.0: vendor: Intel <7> [185.069574] i915 0000:00:02.0: product: Integrated gfx <7> [185.069578] i915 0000:00:02.0: source device information: PC General (0x9) <7> [185.069581] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] found: <7> [185.069961] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:78:pipe A] fastset requirement not met in hdmi infoframe <7> [185.070404] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] expected: <7> [185.070803] i915 0000:00:02.0: HDMI infoframe: Vendor, version 1, length 4 <7> [185.070808] i915 0000:00:02.0: empty frame <7> [185.070811] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] found: <7> [185.071190] i915 0000:00:02.0: [drm:intel_atomic_check [i915]] [CRTC:78:pipe A] fastset requirement not met, forcing full modeset <7> [185.071617] i915 0000:00:02.0: [drm:intel_dpll_crtc_put [i915]] [CRTC:78:pipe A] releasing PORT PLL B <7> [185.072088] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] [CRTC:78:pipe A] dbuf slices 0x1 -> 0x0, ddb (0 - 510) -> (0 - 0), active pipes 0x3 -> 0x2 <7> [185.072525] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] [CRTC:121:pipe B] dbuf slices 0x1 -> 0x1, ddb (510 - 1020) -> (0 - 1020), active pipes 0x3 -> 0x2 <7> [185.072981] i915 0000:00:02.0: [drm:skl_print_plane_ddb_changes [i915]] [PLANE:72:cursor A] ddb ( 497 - 510) -> ( 0 - 0), size 13 -> 0 <7> [185.073414] i915 0000:00:02.0: [drm:skl_print_plane_ddb_changes [i915]] [PLANE:115:cursor B] ddb (1007 - 1020) -> ( 988 - 1020), size 13 -> 32 <7> [185.073834] i915 0000:00:02.0: [drm:intel_cdclk_atomic_check [i915]] [CRTC:78:pipe A] min cdclk: 192000 kHz -> 0 kHz <7> [185.074250] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [CRTC:78:pipe A] enable: no [modeset] <7> [185.074632] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:36:plane 1A] fb: [NOFB], visible: no <7> [185.075017] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:45:plane 2A] fb: [NOFB], visible: no <7> [185.075419] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:54:plane 3A] fb: [NOFB], visible: no <7> [185.075816] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:63:plane 4A] fb: [NOFB], visible: no <7> [185.076292] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:72:cursor A] fb: [NOFB], visible: no <7> [185.077002] i915 0000:00:02.0: [drm:intel_audio_codec_disable [i915]] [CONNECTOR:166:HDMI-A-1][ENCODER:165:DDI B/PHY B] Disable audio codec on [CRTC:78:pipe A] <7> [185.098049] i915 0000:00:02.0: [drm:intel_audio_component_get_eld [i915]] Not valid for port B <7> [185.100040] i915 0000:00:02.0: [drm:intel_disable_transcoder [i915]] disabling pipe A <7> [185.115288] i915 0000:00:02.0: [drm:intel_ddi_disable_transcoder_func [i915]] Quirk Increase DDI disabled time <7> [185.216678] i915 0000:00:02.0: [drm:intel_power_well_disable [i915]] disabling DDI_IO_B <7> [185.217798] i915 0000:00:02.0: [drm:intel_dpll_disable [i915]] disable PORT PLL B (active 0x1, on? 1) for [CRTC:78:pipe A] <7> [185.219751] i915 0000:00:02.0: [drm:intel_dpll_disable [i915]] disabling PORT PLL B <7> [185.220162] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:165:DDI B/PHY B] <7> [185.220801] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:175:DDI C/PHY C] <7> [185.221390] i915 0000:00:02.0: [drm:verify_connector_state [i915]] [CONNECTOR:166:HDMI-A-1] <7> [185.228018] i915 0000:00:02.0: [drm:intel_power_well_disable [i915]] disabling dpio-common-b <7> [185.228639] i915 0000:00:02.0: [drm:intel_modeset_verify_crtc [i915]] [CRTC:78:pipe A] <7> [185.230644] i915 0000:00:02.0: [drm:drm_mode_setcrtc] [CRTC:121:pipe B] <7> [185.230857] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:121:pipe B] fastset requirement not met in hw.enable (expected yes, found no) <7> [185.231736] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:121:pipe B] fastset requirement not met in hw.active (expected yes, found no) <7> [185.232139] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:121:pipe B] fastset requirement not met in cpu_transcoder (expected 1, found -1) <7> [185.232702] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:121:pipe B] fastset requirement not met in lane_count (expected 4, found 0) <7> [185.233085] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:121:pipe B] fastset requirement not met in lane_lat_optim_mask (expected 0x0000000d, found 0x00000000) <7> [185.233790] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:121:pipe B] fastset requirement not met in output_types (expected 0x00000040, found 0x00000000) <7> [185.234186] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:121:pipe B] fastset requirement not met in framestart_delay (expected 1, found 0) <7> [185.234987] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:121:pipe B] fastset requirement not met in hw.pipe_mode.crtc_hdisplay (expected 1920, found 0) <7> [185.235537] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:121:pipe B] fastset requirement not met in hw.pipe_mode.crtc_htotal (expected 2200, found 0) <7> [185.235998] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:121:pipe B] fastset requirement not met in hw.pipe_mode.crtc_hblank_start (expected 1920, found 0) <7> [185.236731] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:121:pipe B] fastset requirement not met in hw.pipe_mode.crtc_hblank_end (expected 2200, found 0) <7> [185.237135] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:121:pipe B] fastset requirement not met in hw.pipe_mode.crtc_hsync_start (expected 2008, found 0) <7> [185.237758] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:121:pipe B] fastset requirement not met in hw.pipe_mode.crtc_hsync_end (expected 2052, found 0) <7> [185.238155] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:121:pipe B] fastset requirement not met in hw.pipe_mode.crtc_vdisplay (expected 1080, found 0) <7> [185.238658] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:121:pipe B] fastset requirement not met in hw.pipe_mode.crtc_vblank_start (expected 1080, found 0) <7> [185.239073] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:121:pipe B] fastset requirement not met in hw.pipe_mode.crtc_vsync_start (expected 1083, found 0) <7> [185.239499] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:121:pipe B] fastset requirement not met in hw.pipe_mode.crtc_vsync_end (expected 1088, found 0) <7> [185.239906] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:121:pipe B] fastset requirement not met in hw.pipe_mode.crtc_vtotal (expected 1125, found 0) <7> [185.240382] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:121:pipe B] fastset requirement not met in hw.pipe_mode.crtc_vblank_end (expected 1125, found 0) <7> [185.240762] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:121:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_hdisplay (expected 1920, found 0) <7> [185.241147] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:121:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_htotal (expected 2200, found 0) <7> [185.241577] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:121:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_hblank_start (expected 1920, found 0) <7> [185.241983] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:121:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_hblank_end (expected 2200, found 0) <7> [185.242387] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:121:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_hsync_start (expected 2008, found 0) <7> [185.242815] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:121:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_hsync_end (expected 2052, found 0) <7> [185.243264] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:121:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_vdisplay (expected 1080, found 0) <7> [185.243692] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:121:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_vblank_start (expected 1080, found 0) <7> [185.244105] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:121:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_vsync_start (expected 1083, found 0) <7> [185.244549] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:121:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_vsync_end (expected 1088, found 0) <7> [185.244960] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:121:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_vtotal (expected 1125, found 0) <7> [185.245365] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:121:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_vblank_end (expected 1125, found 0) <7> [185.245745] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:121:pipe B] fastset requirement not met in pixel_multiplier (expected 1, found 0) <7> [185.246159] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:121:pipe B] fastset requirement not met in hw.adjusted_mode.flags (1) (expected 1, found 0) <7> [185.246562] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:121:pipe B] fastset requirement not met in hw.adjusted_mode.flags (8) (expected 8, found 0) <7> [185.246942] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:121:pipe B] fastset requirement not met in has_hdmi_sink (expected yes, found no) <7> [185.247783] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:121:pipe B] fastset requirement not met in has_infoframe (expected yes, found no) <7> [185.248238] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:121:pipe B] fastset requirement not met in pipe_bpp (expected 36, found 0) <7> [185.248620] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:121:pipe B] fastset requirement not met in hw.pipe_mode.crtc_clock (expected 148500, found 0) <7> [185.248996] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:121:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_clock (expected 148500, found 0) <7> [185.249410] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:121:pipe B] fastset requirement not met in port_clock (expected 222750, found 0) <7> [185.249790] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:121:pipe B] fastset requirement not met in infoframes.enable (expected 0x00000071, found 0x00000000) <7> [185.250380] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:121:pipe B] fastset requirement not met in infoframes.gcp (expected 0x00000006, found 0x00000000) <7> [185.250896] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:121:pipe B] fastset requirement not met in avi infoframe <7> [185.251322] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] expected: <7> [185.251750] i915 0000:00:02.0: HDMI infoframe: Auxiliary Video Information (AVI), version 2, length 13 <7> [185.251755] i915 0000:00:02.0: colorspace: RGB <7> [185.251759] i915 0000:00:02.0: scan mode: Underscan <7> [185.251762] i915 0000:00:02.0: colorimetry: No Data <7> [185.251765] i915 0000:00:02.0: picture aspect: No Data <7> [185.251768] i915 0000:00:02.0: active aspect: Same as Picture <7> [185.251772] i915 0000:00:02.0: itc: No Data <7> [185.251775] i915 0000:00:02.0: extended colorimetry: xvYCC 601 <7> [185.251778] i915 0000:00:02.0: quantization range: Full <7> [185.251781] i915 0000:00:02.0: nups: Unknown Non-uniform Scaling <7> [185.251784] i915 0000:00:02.0: video code: 0 <7> [185.251807] i915 0000:00:02.0: ycc quantization range: Full <7> [185.251811] i915 0000:00:02.0: hdmi content type: Graphics <7> [185.251814] i915 0000:00:02.0: pixel repeat: 0 <7> [185.251817] i915 0000:00:02.0: bar top 0, bottom 0, left 0, right 0 <7> [185.251821] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] found: <7> [185.252243] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:121:pipe B] fastset requirement not met in spd infoframe <7> [185.252648] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] expected: <7> [185.253025] i915 0000:00:02.0: HDMI infoframe: Source Product Description (SPD), version 1, length 25 <7> [185.253029] i915 0000:00:02.0: vendor: Intel <7> [185.253033] i915 0000:00:02.0: product: Integrated gfx <7> [185.253036] i915 0000:00:02.0: source device information: PC General (0x9) <7> [185.253039] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] found: <7> [185.253448] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:121:pipe B] fastset requirement not met in hdmi infoframe <7> [185.253922] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] expected: <7> [185.254360] i915 0000:00:02.0: HDMI infoframe: Vendor, version 1, length 4 <7> [185.254365] i915 0000:00:02.0: empty frame <7> [185.254368] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] found: <7> [185.254747] i915 0000:00:02.0: [drm:intel_atomic_check [i915]] [CRTC:121:pipe B] fastset requirement not met, forcing full modeset <7> [185.255129] i915 0000:00:02.0: [drm:intel_dpll_crtc_put [i915]] [CRTC:121:pipe B] releasing PORT PLL C <7> [185.255603] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] [CRTC:121:pipe B] dbuf slices 0x1 -> 0x0, ddb (0 - 1020) -> (0 - 0), active pipes 0x2 -> 0x0 <7> [185.256041] i915 0000:00:02.0: [drm:skl_print_plane_ddb_changes [i915]] [PLANE:115:cursor B] ddb ( 988 - 1020) -> ( 0 - 0), size 32 -> 0 <7> [185.256494] i915 0000:00:02.0: [drm:intel_cdclk_atomic_check [i915]] [CRTC:121:pipe B] min cdclk: 192000 kHz -> 0 kHz <7> [185.256926] i915 0000:00:02.0: [drm:intel_cdclk_atomic_check [i915]] Modeset required for cdclk change <7> [185.257511] i915 0000:00:02.0: [drm:intel_cdclk_atomic_check [i915]] New cdclk calculated to be logical 79200 kHz, actual 79200 kHz <7> [185.257895] i915 0000:00:02.0: [drm:intel_cdclk_atomic_check [i915]] New voltage level calculated to be logical 4, actual 4 <7> [185.258301] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [CRTC:121:pipe B] enable: no [modeset] <7> [185.258783] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:79:plane 1B] fb: [NOFB], visible: no <7> [185.259251] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:88:plane 2B] fb: [NOFB], visible: no <7> [185.259653] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:97:plane 3B] fb: [NOFB], visible: no <7> [185.260031] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:106:plane 4B] fb: [NOFB], visible: no <7> [185.260468] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:115:cursor B] fb: [NOFB], visible: no <7> [185.261036] i915 0000:00:02.0: [drm:intel_audio_codec_disable [i915]] [CONNECTOR:176:HDMI-A-2][ENCODER:175:DDI C/PHY C] Disable audio codec on [CRTC:121:pipe B] <7> [185.294394] i915 0000:00:02.0: [drm:intel_audio_component_get_eld [i915]] Not valid for port C <7> [185.294978] i915 0000:00:02.0: [drm:intel_disable_transcoder [i915]] disabling pipe B <7> [185.312302] i915 0000:00:02.0: [drm:intel_ddi_disable_transcoder_func [i915]] Quirk Increase DDI disabled time <7> [185.416714] i915 0000:00:02.0: [drm:intel_power_well_disable [i915]] disabling DDI_IO_C <7> [185.418113] i915 0000:00:02.0: [drm:intel_dpll_disable [i915]] disable PORT PLL C (active 0x2, on? 1) for [CRTC:121:pipe B] <7> [185.420431] i915 0000:00:02.0: [drm:intel_dpll_disable [i915]] disabling PORT PLL C <7> [185.420872] i915 0000:00:02.0: [drm:intel_set_cdclk [i915]] Pre changing CDCLK to 79200 kHz, VCO 633600 kHz, ref 19200 kHz, bypass 19200 kHz, voltage level 4 <7> [185.421350] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:165:DDI B/PHY B] <7> [185.421818] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:175:DDI C/PHY C] <7> [185.422499] i915 0000:00:02.0: [drm:verify_connector_state [i915]] [CONNECTOR:176:HDMI-A-2] <7> [185.423369] i915 0000:00:02.0: [drm:intel_power_well_disable [i915]] disabling dpio-common-c <7> [185.423792] i915 0000:00:02.0: [drm:intel_power_well_disable [i915]] disabling PW_2 <7> [185.424472] i915 0000:00:02.0: [drm:intel_modeset_verify_crtc [i915]] [CRTC:121:pipe B] <7> [185.426639] i915 0000:00:02.0: [drm:drm_mode_setcrtc] [CRTC:164:pipe C] <7> [185.427199] i915 0000:00:02.0: [drm:drm_mode_setcrtc] [CRTC:164:pipe C] <7> [185.427312] i915 0000:00:02.0: [drm:drm_mode_setcrtc] [CONNECTOR:176:HDMI-A-2] <7> [185.427504] i915 0000:00:02.0: [drm:intel_hdmi_compute_output_format [i915]] picking 12 bpc for HDMI output (pipe bpp: 36) <7> [185.428017] i915 0000:00:02.0: [drm:intel_atomic_check [i915]] [CRTC:164:pipe C] hw max bpp: 36, pipe bpp: 36, dithering: 0 <7> [185.428493] i915 0000:00:02.0: [drm:intel_ddi_compute_config_late [i915]] [ENCODER:175:DDI C/PHY C] [CRTC:164:pipe C] <7> [185.428870] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:164:pipe C] fastset requirement not met in hw.enable (expected no, found yes) <7> [185.429531] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:164:pipe C] fastset requirement not met in hw.active (expected no, found yes) <7> [185.430004] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:164:pipe C] fastset requirement not met in cpu_transcoder (expected -1, found 2) <7> [185.430571] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:164:pipe C] fastset requirement not met in lane_count (expected 0, found 4) <7> [185.430973] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:164:pipe C] fastset requirement not met in lane_lat_optim_mask (expected 0x00000000, found 0x0000000d) <7> [185.431416] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:164:pipe C] fastset requirement not met in output_types (expected 0x00000000, found 0x00000040) <7> [185.431818] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:164:pipe C] fastset requirement not met in framestart_delay (expected 0, found 1) <7> [185.432279] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:164:pipe C] fastset requirement not met in hw.pipe_mode.crtc_hdisplay (expected 0, found 1920) <7> [185.432688] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:164:pipe C] fastset requirement not met in hw.pipe_mode.crtc_htotal (expected 0, found 2200) <7> [185.433069] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:164:pipe C] fastset requirement not met in hw.pipe_mode.crtc_hblank_start (expected 0, found 1920) <7> [185.434713] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:164:pipe C] fastset requirement not met in hw.pipe_mode.crtc_hblank_end (expected 0, found 2200) <7> [185.435437] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:164:pipe C] fastset requirement not met in hw.pipe_mode.crtc_hsync_start (expected 0, found 2008) <7> [185.435887] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:164:pipe C] fastset requirement not met in hw.pipe_mode.crtc_hsync_end (expected 0, found 2052) <7> [185.436391] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:164:pipe C] fastset requirement not met in hw.pipe_mode.crtc_vdisplay (expected 0, found 1080) <7> [185.436804] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:164:pipe C] fastset requirement not met in hw.pipe_mode.crtc_vblank_start (expected 0, found 1080) <7> [185.437185] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:164:pipe C] fastset requirement not met in hw.pipe_mode.crtc_vsync_start (expected 0, found 1083) <7> [185.437633] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:164:pipe C] fastset requirement not met in hw.pipe_mode.crtc_vsync_end (expected 0, found 1088) <7> [185.438038] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:164:pipe C] fastset requirement not met in hw.pipe_mode.crtc_vtotal (expected 0, found 1125) <7> [185.439546] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:164:pipe C] fastset requirement not met in hw.pipe_mode.crtc_vblank_end (expected 0, found 1125) <7> [185.440001] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:164:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_hdisplay (expected 0, found 1920) <7> [185.440691] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:164:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_htotal (expected 0, found 2200) <7> [185.441164] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:164:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_hblank_start (expected 0, found 1920) <7> [185.441744] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:164:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_hblank_end (expected 0, found 2200) <7> [185.442169] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:164:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_hsync_start (expected 0, found 2008) <7> [185.442656] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:164:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_hsync_end (expected 0, found 2052) <7> [185.443037] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:164:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_vdisplay (expected 0, found 1080) <7> [185.444387] i915 0000:00:02.0: [drm:intel_power_well_disable [i915]] disabling DC_off <7> [185.444848] i915 0000:00:02.0: [drm:gen9_enable_dc5 [i915]] Enabling DC5 <7> [185.445266] i915 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [i915]] Setting DC state from 00 to 01 <7> [185.446684] i915 0000:00:02.0: [drm:intel_power_well_disable [i915]] disabling always-on <7> [185.447118] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:164:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_vblank_start (expected 0, found 1080) <7> [185.447546] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:164:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_vsync_start (expected 0, found 1083) <7> [185.447926] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:164:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_vsync_end (expected 0, found 1088) <7> [185.448513] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:164:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_vtotal (expected 0, found 1125) <7> [185.448963] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:164:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_vblank_end (expected 0, found 1125) <7> [185.449488] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:164:pipe C] fastset requirement not met in pixel_multiplier (expected 0, found 1) <7> [185.449910] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:164:pipe C] fastset requirement not met in hw.adjusted_mode.flags (1) (expected 0, found 1) <7> [185.450350] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:164:pipe C] fastset requirement not met in hw.adjusted_mode.flags (8) (expected 0, found 8) <7> [185.450753] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:164:pipe C] fastset requirement not met in has_hdmi_sink (expected no, found yes) <7> [185.451138] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:164:pipe C] fastset requirement not met in has_infoframe (expected no, found yes) <7> [185.451566] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:164:pipe C] fastset requirement not met in pipe_bpp (expected 0, found 36) <7> [185.451981] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:164:pipe C] fastset requirement not met in hw.pipe_mode.crtc_clock (expected 0, found 148500) <7> [185.453589] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:164:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_clock (expected 0, found 148500) <7> [185.454097] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:164:pipe C] fastset requirement not met in port_clock (expected 0, found 222750) <7> [185.454809] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:164:pipe C] fastset requirement not met in infoframes.enable (expected 0x00000000, found 0x00000071) <7> [185.455282] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:164:pipe C] fastset requirement not met in infoframes.gcp (expected 0x00000000, found 0x00000006) <7> [185.455665] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:164:pipe C] fastset requirement not met in avi infoframe <7> [185.456163] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] expected: <7> [185.456621] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] found: <7> [185.457022] i915 0000:00:02.0: HDMI infoframe: Auxiliary Video Information (AVI), version 2, length 13 <7> [185.457028] i915 0000:00:02.0: colorspace: RGB <7> [185.457031] i915 0000:00:02.0: scan mode: Underscan <7> [185.457035] i915 0000:00:02.0: colorimetry: No Data <7> [185.457038] i915 0000:00:02.0: picture aspect: No Data <7> [185.457041] i915 0000:00:02.0: active aspect: Same as Picture <7> [185.457044] i915 0000:00:02.0: itc: No Data <7> [185.457047] i915 0000:00:02.0: extended colorimetry: xvYCC 601 <7> [185.457050] i915 0000:00:02.0: quantization range: Full <7> [185.457053] i915 0000:00:02.0: nups: Unknown Non-uniform Scaling <7> [185.457056] i915 0000:00:02.0: video code: 0 <7> [185.457059] i915 0000:00:02.0: ycc quantization range: Full <7> [185.457063] i915 0000:00:02.0: hdmi content type: Graphics <7> [185.457066] i915 0000:00:02.0: pixel repeat: 0 <7> [185.457069] i915 0000:00:02.0: bar top 0, bottom 0, left 0, right 0 <7> [185.457073] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:164:pipe C] fastset requirement not met in spd infoframe <7> [185.459008] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] expected: <7> [185.459675] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] found: <7> [185.460065] i915 0000:00:02.0: HDMI infoframe: Source Product Description (SPD), version 1, length 25 <7> [185.460069] i915 0000:00:02.0: vendor: Intel <7> [185.460073] i915 0000:00:02.0: product: Integrated gfx <7> [185.460076] i915 0000:00:02.0: source device information: PC General (0x9) <7> [185.460080] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:164:pipe C] fastset requirement not met in hdmi infoframe <7> [185.460704] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] expected: <7> [185.461158] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] found: <7> [185.461698] i915 0000:00:02.0: HDMI infoframe: Vendor, version 1, length 4 <7> [185.461703] i915 0000:00:02.0: empty frame <7> [185.461708] i915 0000:00:02.0: [drm:intel_atomic_check [i915]] [CRTC:164:pipe C] fastset requirement not met, forcing full modeset <7> [185.462191] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] [CRTC:164:pipe C] dbuf slices 0x0 -> 0x1, ddb (0 - 0) -> (0 - 1020), active pipes 0x0 -> 0x4 <7> [185.462719] i915 0000:00:02.0: [drm:skl_print_plane_ddb_changes [i915]] [PLANE:122:plane 1C] ddb ( 0 - 0) -> ( 0 - 988), size 0 -> 988 <7> [185.463105] i915 0000:00:02.0: [drm:skl_print_plane_ddb_changes [i915]] [PLANE:158:cursor C] ddb ( 0 - 0) -> ( 988 - 1020), size 0 -> 32 <7> [185.464740] i915 0000:00:02.0: [drm:skl_print_plane_wm_changes [i915]] [PLANE:122:plane 1C] level wm0, wm1, wm2, wm3, wm4, wm5, wm6, wm7, twm, swm, stwm -> wm0,wm1,wm2,wm3,wm4,wm5,wm6,wm7,twm, swm, stwm <7> [185.465428] i915 0000:00:02.0: [drm:skl_print_plane_wm_changes [i915]] [PLANE:122:plane 1C] lines 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0 -> 1, 1, 1, 2, 2, 2, 2, 2, 0, 0, 0 <7> [185.465965] i915 0000:00:02.0: [drm:skl_print_plane_wm_changes [i915]] [PLANE:122:plane 1C] blocks 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0 -> 16, 16, 16, 33, 33, 33, 33, 33, 30, 0, 0 <7> [185.466414] i915 0000:00:02.0: [drm:skl_print_plane_wm_changes [i915]] [PLANE:122:plane 1C] min_ddb 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0 -> 17, 17, 17, 34, 34, 34, 34, 34, 31, 0, 0 <7> [185.466817] i915 0000:00:02.0: [drm:skl_print_plane_wm_changes [i915]] [PLANE:122:plane 1C] min_ddb_uv 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0 -> 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0 <7> [185.467343] i915 0000:00:02.0: [drm:intel_cdclk_atomic_check [i915]] [CRTC:164:pipe C] min cdclk: 0 kHz -> 192000 kHz <7> [185.467771] i915 0000:00:02.0: [drm:intel_cdclk_update_dbuf_bw_min_cdclk [i915]] dbuf bandwidth min cdclk: 18563 kHz -> 9282 kHz <7> [185.468202] i915 0000:00:02.0: [drm:intel_cdclk_atomic_check [i915]] Modeset required for cdclk change <7> [185.468783] i915 0000:00:02.0: [drm:intel_cdclk_atomic_check [i915]] New cdclk calculated to be logical 316800 kHz, actual 316800 kHz <7> [185.469166] i915 0000:00:02.0: [drm:intel_cdclk_atomic_check [i915]] New voltage level calculated to be logical 13, actual 13 <7> [185.469604] i915 0000:00:02.0: [drm:bxt_get_dpll [i915]] [CRTC:164:pipe C] using pre-allocated PORT PLL C <7> [185.470059] i915 0000:00:02.0: [drm:intel_dpll_crtc_get [i915]] [CRTC:164:pipe C] reserving PORT PLL C <7> [185.470539] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [CRTC:164:pipe C] enable: yes [modeset] <7> [185.470960] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] active: yes, output_types: HDMI (0x40), output format: RGB, sink format: RGB <7> [185.471504] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] cpu_transcoder: C, pipe bpp: 36, dithering: 0 <7> [185.471889] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] MST master transcoder: <invalid> <7> [185.472299] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] port sync: master transcoder: <invalid>, slave transcoder bitmask = 0x0 <7> [185.472675] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] joiner: no, pipes: 0x0 <7> [185.473049] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] splitter: disabled, link count 0, overlap 0 <7> [185.473462] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] audio: 1, infoframes: 1, infoframes enabled: 0x71 <7> [185.473868] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] GCP: 0x6 <7> [185.474282] i915 0000:00:02.0: HDMI infoframe: Auxiliary Video Information (AVI), version 2, length 13 <7> [185.474287] i915 0000:00:02.0: colorspace: RGB <7> [185.474290] i915 0000:00:02.0: scan mode: Underscan <7> [185.474293] i915 0000:00:02.0: colorimetry: No Data <7> [185.474297] i915 0000:00:02.0: picture aspect: No Data <7> [185.474300] i915 0000:00:02.0: active aspect: Same as Picture <7> [185.474304] i915 0000:00:02.0: itc: No Data <7> [185.474307] i915 0000:00:02.0: extended colorimetry: xvYCC 601 <7> [185.474310] i915 0000:00:02.0: quantization range: Full <7> [185.474313] i915 0000:00:02.0: nups: Unknown Non-uniform Scaling <7> [185.474316] i915 0000:00:02.0: video code: 0 <7> [185.474320] i915 0000:00:02.0: ycc quantization range: Full <7> [185.474323] i915 0000:00:02.0: hdmi content type: Graphics <7> [185.474326] i915 0000:00:02.0: pixel repeat: 0 <7> [185.474329] i915 0000:00:02.0: bar top 0, bottom 0, left 0, right 0 <7> [185.474333] i915 0000:00:02.0: HDMI infoframe: Source Product Description (SPD), version 1, length 25 <7> [185.474336] i915 0000:00:02.0: vendor: Intel <7> [185.474339] i915 0000:00:02.0: product: Integrated gfx <7> [185.474342] i915 0000:00:02.0: source device information: PC General (0x9) <7> [185.474345] i915 0000:00:02.0: HDMI infoframe: Vendor, version 1, length 4 <7> [185.474349] i915 0000:00:02.0: empty frame <7> [185.474353] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] ELD: 10 00 07 00 66 10 00 01 00 00 00 00 00 00 00 00 <7> [185.474732] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] ELD: 05 e3 cd 0c 32 38 45 38 35 30 09 07 07 00 00 00 <7> [185.475157] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] scanline offset: 2 <7> [185.475623] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] framestart delay: 1, MSA timing delay: 0, set context latency: 0 <7> [185.476059] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] vrr: no, fixed rr: no, vmin: 0, vmax: 0, flipline: 0, pipeline full: 0, guardband: 0 vsync start: 0, vsync end: 0 <7> [185.476552] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] vrr: vmin vblank: 0, vmax vblank: 0, vmin vtotal: 0, vmax vtotal: 0 <7> [185.476933] 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> [185.477329] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] requested mode: "1920x1080": 60 148500 1920 2008 2052 2200 1080 1083 1088 1125 0x48 0x9 <7> [185.477708] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] adjusted mode: "1920x1080": 60 148500 1920 2008 2052 2200 1080 1083 1088 1125 0x48 0x9 <7> [185.478123] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] crtc timings: clock=148500, hd=1920 hb=1920-2200 hs=2008-2052 ht=2200, vd=1080 vb=1080-1125 vs=1083-1088 vt=1125, flags=0x9 <7> [185.478533] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pipe mode: "1920x1080": 60 148500 1920 2008 2052 2200 1080 1083 1088 1125 0x40 0x9 <7> [185.478913] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] crtc timings: clock=148500, hd=1920 hb=1920-2200 hs=2008-2052 ht=2200, vd=1080 vb=1080-1125 vs=1083-1088 vt=1125, flags=0x9 <7> [185.479326] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] port clock: 222750, pixel rate 148500, min cdclk 192000, min voltage level 0 <7> [185.479703] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] linetime: 59, ips linetime: 0 <7> [185.480088] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] num_scalers: 1, scaler_users: 0x0, scaler_id: -1, scaling_filter: 0, sharpness_strength: 0 <7> [185.480508] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pipe src: 1920x1080+0+0 <7> [185.480945] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pch pfit: 0x0+0+0, disabled, force thru: no <7> [185.481454] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] sharpness strength: 0, sharpness tap size: 0, sharpness enable: 0 <7> [185.481900] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] ips: 0, double wide: 0, drrs: 0 <7> [185.482362] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] dpll_hw_state: ebb0: 0x6200, ebb4: 0x2000,pll0: 0x21, pll1: 0x100, pll2: 0x1a6666, pll3: 0x10000, pll6: 0x30904, pll8: 0x8, pll9: 0xa, pll10: 0x8003c00, pcsdw12: 0x4d <7> [185.482771] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] csc_mode: 0x0 gamma_mode: 0x0 gamma_enable: 0 csc_enable: 0 <7> [185.483147] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pre csc lut: 0 entries, post csc lut: 0 entries <7> [185.483590] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pipe csc: pre offsets: 0x0000 0x0000 0x0000 <7> [185.483998] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pipe csc: coefficients: 0x0000 0x0000 0x0000 <7> [185.484415] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pipe csc: coefficients: 0x0000 0x0000 0x0000 <7> [185.484792] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pipe csc: coefficients: 0x0000 0x0000 0x0000 <7> [185.485169] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pipe csc: post offsets: 0x0000 0x0000 0x0000 <7> [185.485606] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:122:plane 1C] fb: [FB:182] 1920x1080 format = XR24 little-endian (0x34325258) modifier = 0x100000000000001, visible: yes <7> [185.486015] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] rotation: 0x1, scaler: -1, scaling_filter: 0 <7> [185.486428] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] src: 1920.000000x1080.000000+0.000000+0.000000 dst: 1920x1080+0+0 <7> [185.486807] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:131:plane 2C] fb: [NOFB], visible: no <7> [185.487428] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:140:plane 3C] fb: [NOFB], visible: no <7> [185.487826] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:149:plane 4C] fb: [NOFB], visible: no <7> [185.488205] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:158:cursor C] fb: [NOFB], visible: no <7> [185.489422] i915 0000:00:02.0: [drm:intel_power_well_enable [i915]] enabling always-on <7> [185.489857] i915 0000:00:02.0: [drm:intel_power_well_enable [i915]] enabling DC_off <7> [185.490818] i915 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [i915]] Setting DC state from 01 to 00 <7> [185.492005] i915 0000:00:02.0: [drm:intel_power_well_enable [i915]] enabling PW_2 <7> [185.492529] i915 0000:00:02.0: [drm:intel_power_well_enable [i915]] enabling dpio-common-c <7> [185.493368] i915 0000:00:02.0: [drm:intel_set_cdclk [i915]] Pre changing CDCLK to 316800 kHz, VCO 633600 kHz, ref 19200 kHz, bypass 19200 kHz, voltage level 13 <7> [185.493834] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:165:DDI B/PHY B] <7> [185.494302] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:175:DDI C/PHY C] <7> [185.494873] i915 0000:00:02.0: [drm:intel_dpll_enable [i915]] enable PORT PLL C (active 0x4, on? 0) for [CRTC:164:pipe C] <7> [185.495321] i915 0000:00:02.0: [drm:intel_dpll_enable [i915]] enabling PORT PLL C <7> [185.495889] i915 0000:00:02.0: [drm:intel_power_well_enable [i915]] enabling DDI_IO_C <7> [185.496408] i915 0000:00:02.0: [drm:intel_enable_transcoder [i915]] enabling pipe C <7> [185.531171] i915 0000:00:02.0: [drm:intel_audio_codec_enable [i915]] [CONNECTOR:176:HDMI-A-2][ENCODER:175:DDI C/PHY C] Enable audio codec on [CRTC:164:pipe C], 32 bytes ELD <7> [185.544734] i915 0000:00:02.0: [drm:intel_audio_component_get_power [i915]] restored AUD_FREQ_CNTRL to 0x10 <7> [185.547819] i915 0000:00:02.0: [drm:audio_config_hdmi_pixel_clock [i915]] Configuring HDMI audio for pixel clock 148500 (0x00090000) <7> [185.548335] i915 0000:00:02.0: [drm:hsw_audio_config_update [i915]] using automatic N <7> [185.548899] i915 0000:00:02.0: [drm:verify_connector_state [i915]] [CONNECTOR:176:HDMI-A-2] <7> [185.550163] i915 0000:00:02.0: [drm:intel_modeset_verify_crtc [i915]] [CRTC:164:pipe C] <7> [185.553429] i915 0000:00:02.0: [drm:drm_mode_setcrtc] [CRTC:78:pipe A] <7> [185.553496] i915 0000:00:02.0: [drm:drm_mode_setcrtc] [CONNECTOR:166:HDMI-A-1] <7> [185.553688] i915 0000:00:02.0: [drm:intel_hdmi_compute_output_format [i915]] picking 12 bpc for HDMI output (pipe bpp: 36) <7> [185.554196] i915 0000:00:02.0: [drm:intel_atomic_check [i915]] [CRTC:78:pipe A] hw max bpp: 36, pipe bpp: 36, dithering: 0 <7> [185.555057] i915 0000:00:02.0: [drm:intel_ddi_compute_config_late [i915]] [ENCODER:165:DDI B/PHY B] [CRTC:78:pipe A] <7> [185.555692] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:78:pipe A] fastset requirement not met in hw.enable (expected no, found yes) <7> [185.556079] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:78:pipe A] fastset requirement not met in hw.active (expected no, found yes) <7> [185.557643] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:78:pipe A] fastset requirement not met in cpu_transcoder (expected -1, found 0) <7> [185.558073] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:78:pipe A] fastset requirement not met in lane_count (expected 0, found 4) <7> [185.558549] azx_init_pci: snd_hda_intel 0000:00:0e.0: Clearing TCSEL <7> [185.558565] azx_init_pci: snd_hda_intel 0000:00:0e.0: SCH snoop: Enabled <7> [185.558923] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:78:pipe A] fastset requirement not met in lane_lat_optim_mask (expected 0x00000000, found 0x0000000d) <7> [185.559643] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:78:pipe A] fastset requirement not met in output_types (expected 0x00000000, found 0x00000040) <7> [185.560045] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:78:pipe A] fastset requirement not met in framestart_delay (expected 0, found 1) <7> [185.561685] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:78:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hdisplay (expected 0, found 1920) <7> [185.562129] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:78:pipe A] fastset requirement not met in hw.pipe_mode.crtc_htotal (expected 0, found 2200) <7> [185.562960] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:78:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hblank_start (expected 0, found 1920) <7> [185.563618] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:78:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hblank_end (expected 0, found 2200) <7> [185.564002] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:78:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hsync_start (expected 0, found 2008) <7> [185.565433] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:78:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hsync_end (expected 0, found 2052) <7> [185.565859] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:78:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vdisplay (expected 0, found 1080) <7> [185.566640] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:78:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vblank_start (expected 0, found 1080) <7> [185.567025] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:78:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vsync_start (expected 0, found 1083) <7> [185.567706] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:78:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vsync_end (expected 0, found 1088) <7> [185.568100] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:78:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vtotal (expected 0, found 1125) <7> [185.569505] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:78:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vblank_end (expected 0, found 1125) <7> [185.569924] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:78:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hdisplay (expected 0, found 1920) <7> [185.570651] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:78:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_htotal (expected 0, found 2200) <7> [185.571039] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:78:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hblank_start (expected 0, found 1920) <7> [185.571706] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:78:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hblank_end (expected 0, found 2200) <7> [185.572095] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:78:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hsync_start (expected 0, found 2008) <7> [185.573693] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:78:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hsync_end (expected 0, found 2052) <7> [185.574125] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:78:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vdisplay (expected 0, found 1080) <7> [185.574904] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:78:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vblank_start (expected 0, found 1080) <7> [185.575552] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:78:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vsync_start (expected 0, found 1083) <7> [185.575938] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:78:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vsync_end (expected 0, found 1088) <7> [185.577184] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:78:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vtotal (expected 0, found 1125) <7> [185.577965] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:78:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vblank_end (expected 0, found 1125) <7> [185.578661] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:78:pipe A] fastset requirement not met in pixel_multiplier (expected 0, found 1) <7> [185.579047] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:78:pipe A] fastset requirement not met in hw.adjusted_mode.flags (1) (expected 0, found 1) <7> [185.580276] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:78:pipe A] fastset requirement not met in hw.adjusted_mode.flags (8) (expected 0, found 8) <7> [185.580867] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:78:pipe A] fastset requirement not met in has_hdmi_sink (expected no, found yes) <7> [185.581563] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:78:pipe A] fastset requirement not met in has_infoframe (expected no, found yes) <7> [185.581954] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:78:pipe A] fastset requirement not met in pipe_bpp (expected 0, found 36) <7> [185.583127] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:78:pipe A] fastset requirement not met in hw.pipe_mode.crtc_clock (expected 0, found 148500) <7> [185.583895] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:78:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_clock (expected 0, found 148500) <7> [185.584531] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:78:pipe A] fastset requirement not met in port_clock (expected 0, found 222750) <7> [185.584916] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:78:pipe A] fastset requirement not met in infoframes.enable (expected 0x00000000, found 0x00000071) <7> [185.586094] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:78:pipe A] fastset requirement not met in infoframes.gcp (expected 0x00000000, found 0x00000006) <7> [185.586846] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:78:pipe A] fastset requirement not met in avi infoframe <7> [185.587505] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] expected: <7> [185.587889] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] found: <7> [185.589317] i915 0000:00:02.0: HDMI infoframe: Auxiliary Video Information (AVI), version 2, length 13 <7> [185.589323] i915 0000:00:02.0: colorspace: RGB <7> [185.589327] i915 0000:00:02.0: scan mode: Underscan <7> [185.589330] i915 0000:00:02.0: colorimetry: No Data <7> [185.589333] i915 0000:00:02.0: picture aspect: No Data <7> [185.589336] i915 0000:00:02.0: active aspect: Same as Picture <7> [185.589340] i915 0000:00:02.0: itc: No Data <7> [185.589342] i915 0000:00:02.0: extended colorimetry: xvYCC 601 <7> [185.589346] i915 0000:00:02.0: quantization range: Full <7> [185.589349] i915 0000:00:02.0: nups: Unknown Non-uniform Scaling <7> [185.589352] i915 0000:00:02.0: video code: 0 <7> [185.589355] i915 0000:00:02.0: ycc quantization range: Full <7> [185.589358] i915 0000:00:02.0: hdmi content type: Graphics <7> [185.589361] i915 0000:00:02.0: pixel repeat: 0 <7> [185.589364] i915 0000:00:02.0: bar top 0, bottom 0, left 0, right 0 <7> [185.589368] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:78:pipe A] fastset requirement not met in spd infoframe <7> [185.589809] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] expected: <7> [185.590188] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] found: <7> [185.591037] i915 0000:00:02.0: HDMI infoframe: Source Product Description (SPD), version 1, length 25 <7> [185.591041] i915 0000:00:02.0: vendor: Intel <7> [185.591045] i915 0000:00:02.0: product: Integrated gfx <7> [185.591048] i915 0000:00:02.0: source device information: PC General (0x9) <7> [185.591052] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:78:pipe A] fastset requirement not met in hdmi infoframe <7> [185.591708] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] expected: <7> [185.592091] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] found: <7> [185.593297] i915 0000:00:02.0: HDMI infoframe: Vendor, version 1, length 4 <7> [185.593302] i915 0000:00:02.0: empty frame <7> [185.593308] i915 0000:00:02.0: [drm:intel_atomic_check [i915]] [CRTC:78:pipe A] fastset requirement not met, forcing full modeset <7> [185.593784] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] [CRTC:78:pipe A] dbuf slices 0x0 -> 0x1, ddb (0 - 0) -> (0 - 510), active pipes 0x4 -> 0x5 <7> [185.594189] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] [CRTC:164:pipe C] dbuf slices 0x1 -> 0x1, ddb (0 - 1020) -> (510 - 1020), active pipes 0x4 -> 0x5 <7> [185.595764] i915 0000:00:02.0: [drm:skl_print_plane_ddb_changes [i915]] [PLANE:36:plane 1A] ddb ( 0 - 0) -> ( 0 - 497), size 0 -> 497 <7> [185.596515] i915 0000:00:02.0: [drm:skl_print_plane_ddb_changes [i915]] [PLANE:72:cursor A] ddb ( 0 - 0) -> ( 497 - 510), size 0 -> 13 <7> [185.596894] i915 0000:00:02.0: [drm:skl_print_plane_wm_changes [i915]] [PLANE:36: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> [185.597614] i915 0000:00:02.0: [drm:skl_print_plane_wm_changes [i915]] [PLANE:36:plane 1A] lines 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0 -> 1, 1, 1, 2, 2, 2, 2, 2, 0, 0, 0 <7> [185.597997] i915 0000:00:02.0: [drm:skl_print_plane_wm_changes [i915]] [PLANE:36:plane 1A] blocks 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0 -> 16, 16, 16, 33, 33, 33, 33, 33, 30, 0, 0 <7> [185.599566] i915 0000:00:02.0: [drm:skl_print_plane_wm_changes [i915]] [PLANE:36:plane 1A] min_ddb 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0 -> 17, 17, 17, 34, 34, 34, 34, 34, 31, 0, 0 <7> [185.599989] i915 0000:00:02.0: [drm:skl_print_plane_wm_changes [i915]] [PLANE:36:plane 1A] min_ddb_uv 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0 -> 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0 <7> [185.600754] i915 0000:00:02.0: [drm:skl_print_plane_ddb_changes [i915]] [PLANE:122:plane 1C] ddb ( 0 - 988) -> ( 510 - 1007), size 988 -> 497 <7> [185.601136] i915 0000:00:02.0: [drm:skl_print_plane_ddb_changes [i915]] [PLANE:158:cursor C] ddb ( 988 - 1020) -> (1007 - 1020), size 32 -> 13 <7> [185.601857] i915 0000:00:02.0: [drm:intel_cdclk_atomic_check [i915]] [CRTC:78:pipe A] min cdclk: 0 kHz -> 192000 kHz <7> [185.603156] i915 0000:00:02.0: [drm:intel_cdclk_update_dbuf_bw_min_cdclk [i915]] dbuf bandwidth min cdclk: 9282 kHz -> 18563 kHz <7> [185.603960] i915 0000:00:02.0: [drm:bxt_get_dpll [i915]] [CRTC:78:pipe A] using pre-allocated PORT PLL B <7> [185.604611] i915 0000:00:02.0: [drm:intel_dpll_crtc_get [i915]] [CRTC:78:pipe A] reserving PORT PLL B <7> [185.605008] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [CRTC:78:pipe A] enable: yes [modeset] <7> [185.606233] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] active: yes, output_types: HDMI (0x40), output format: RGB, sink format: RGB <7> [185.606634] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] cpu_transcoder: A, pipe bpp: 36, dithering: 0 <7> [185.607184] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] MST master transcoder: <invalid> <7> [185.607841] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] port sync: master transcoder: <invalid>, slave transcoder bitmask = 0x0 <7> [185.609079] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] joiner: no, pipes: 0x0 <7> [185.609805] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] splitter: disabled, link count 0, overlap 0 <7> [185.610186] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] audio: 1, infoframes: 1, infoframes enabled: 0x71 <7> [185.610860] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] GCP: 0x6 <7> [185.611815] i915 0000:00:02.0: HDMI infoframe: Auxiliary Video Information (AVI), version 2, length 13 <7> [185.611820] i915 0000:00:02.0: colorspace: RGB <7> [185.611823] i915 0000:00:02.0: scan mode: Underscan <7> [185.611827] i915 0000:00:02.0: colorimetry: No Data <7> [185.611830] i915 0000:00:02.0: picture aspect: No Data <7> [185.611833] i915 0000:00:02.0: active aspect: Same as Picture <7> [185.611836] i915 0000:00:02.0: itc: No Data <7> [185.611839] i915 0000:00:02.0: extended colorimetry: xvYCC 601 <7> [185.611842] i915 0000:00:02.0: quantization range: Full <7> [185.611845] i915 0000:00:02.0: nups: Unknown Non-uniform Scaling <7> [185.611848] i915 0000:00:02.0: video code: 0 <7> [185.611851] i915 0000:00:02.0: ycc quantization range: Full <7> [185.611854] i915 0000:00:02.0: hdmi content type: Graphics <7> [185.611857] i915 0000:00:02.0: pixel repeat: 0 <7> [185.611860] i915 0000:00:02.0: bar top 0, bottom 0, left 0, right 0 <7> [185.611864] i915 0000:00:02.0: HDMI infoframe: Source Product Description (SPD), version 1, length 25 <7> [185.611868] i915 0000:00:02.0: vendor: Intel <7> [185.611871] i915 0000:00:02.0: product: Integrated gfx <7> [185.611874] i915 0000:00:02.0: source device information: PC General (0x9) <7> [185.611877] i915 0000:00:02.0: HDMI infoframe: Vendor, version 1, length 4 <7> [185.611881] i915 0000:00:02.0: empty frame <7> [185.611884] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] ELD: 10 00 07 00 66 10 00 01 00 00 00 00 00 00 00 00 <7> [185.613270] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] ELD: 05 e3 cd 0c 32 38 45 38 35 30 09 07 07 00 00 00 <7> [185.613671] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] scanline offset: 2 <7> [185.614492] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] framestart delay: 1, MSA timing delay: 0, set context latency: 0 <7> [185.615098] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] vrr: no, fixed rr: no, vmin: 0, vmax: 0, flipline: 0, pipeline full: 0, guardband: 0 vsync start: 0, vsync end: 0 <7> [185.615746] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] vrr: vmin vblank: 0, vmax vblank: 0, vmin vtotal: 0, vmax vtotal: 0 <7> [185.616128] 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> [185.617498] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] requested mode: "1920x1080": 60 148500 1920 2008 2052 2200 1080 1083 1088 1125 0x48 0x9 <7> [185.617907] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] adjusted mode: "1920x1080": 60 148500 1920 2008 2052 2200 1080 1083 1088 1125 0x48 0x9 <7> [185.618625] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] crtc timings: clock=148500, hd=1920 hb=1920-2200 hs=2008-2052 ht=2200, vd=1080 vb=1080-1125 vs=1083-1088 vt=1125, flags=0x9 <7> [185.619013] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pipe mode: "1920x1080": 60 148500 1920 2008 2052 2200 1080 1083 1088 1125 0x40 0x9 <7> [185.619642] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] crtc timings: clock=148500, hd=1920 hb=1920-2200 hs=2008-2052 ht=2200, vd=1080 vb=1080-1125 vs=1083-1088 vt=1125, flags=0x9 <7> [185.620029] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] port clock: 222750, pixel rate 148500, min cdclk 192000, min voltage level 0 <7> [185.621428] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] linetime: 59, ips linetime: 0 <7> [185.621843] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] num_scalers: 2, scaler_users: 0x0, scaler_id: -1, scaling_filter: 0, sharpness_strength: 0 <7> [185.622655] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pipe src: 1920x1080+0+0 <7> [185.623039] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pch pfit: 0x0+0+0, disabled, force thru: no <7> [185.623696] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] sharpness strength: 0, sharpness tap size: 0, sharpness enable: 0 <7> [185.624080] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] ips: 0, double wide: 0, drrs: 0 <7> [185.625425] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] dpll_hw_state: ebb0: 0x6200, ebb4: 0x2000,pll0: 0x21, pll1: 0x100, pll2: 0x1a6666, pll3: 0x10000, pll6: 0x30904, pll8: 0x8, pll9: 0xa, pll10: 0x8003c00, pcsdw12: 0x4d <7> [185.625831] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] csc_mode: 0x0 gamma_mode: 0x0 gamma_enable: 0 csc_enable: 0 <7> [185.626558] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pre csc lut: 0 entries, post csc lut: 0 entries <7> [185.626940] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pipe csc: pre offsets: 0x0000 0x0000 0x0000 <7> [185.627620] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pipe csc: coefficients: 0x0000 0x0000 0x0000 <7> [185.628001] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pipe csc: coefficients: 0x0000 0x0000 0x0000 <7> [185.629291] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pipe csc: coefficients: 0x0000 0x0000 0x0000 <7> [185.629690] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pipe csc: post offsets: 0x0000 0x0000 0x0000 <7> [185.630445] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:36:plane 1A] fb: [FB:182] 1920x1080 format = XR24 little-endian (0x34325258) modifier = 0x100000000000001, visible: yes <7> [185.630841] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] rotation: 0x1, scaler: -1, scaling_filter: 0 <7> [185.631480] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] src: 1920.000000x1080.000000+0.000000+0.000000 dst: 1920x1080+0+0 <7> [185.631869] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:45:plane 2A] fb: [NOFB], visible: no <7> [185.633122] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:54:plane 3A] fb: [NOFB], visible: no <7> [185.633897] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:63:plane 4A] fb: [NOFB], visible: no <7> [185.634525] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:72:cursor A] fb: [NOFB], visible: no <7> [185.636133] i915 0000:00:02.0: [drm:intel_power_well_enable [i915]] enabling dpio-common-b <7> [185.637482] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:165:DDI B/PHY B] <7> [185.637878] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:175:DDI C/PHY C] <7> [185.647842] i915 0000:00:02.0: [drm:intel_dpll_enable [i915]] enable PORT PLL B (active 0x1, on? 0) for [CRTC:78:pipe A] <7> [185.648337] i915 0000:00:02.0: [drm:intel_dpll_enable [i915]] enabling PORT PLL B <7> [185.649504] i915 0000:00:02.0: [drm:intel_power_well_enable [i915]] enabling DDI_IO_B <7> [185.650011] i915 0000:00:02.0: [drm:intel_enable_transcoder [i915]] enabling pipe A <7> [185.668468] i915 0000:00:02.0: [drm:intel_fbc_update [i915]] reserved 16588800 bytes of contiguous stolen space for FBC, limit: 1 <7> [185.668939] i915 0000:00:02.0: [drm:intel_fbc_update [i915]] Enabling FBC on [PLANE:36:plane 1A] <7> [185.685162] i915 0000:00:02.0: [drm:intel_audio_codec_enable [i915]] [CONNECTOR:166:HDMI-A-1][ENCODER:165:DDI B/PHY B] Enable audio codec on [CRTC:78:pipe A], 32 bytes ELD <7> [185.701820] i915 0000:00:02.0: [drm:audio_config_hdmi_pixel_clock [i915]] Configuring HDMI audio for pixel clock 148500 (0x00090000) <7> [185.702296] i915 0000:00:02.0: [drm:hsw_audio_config_update [i915]] using automatic N <7> [185.702847] i915 0000:00:02.0: [drm:verify_connector_state [i915]] [CONNECTOR:166:HDMI-A-1] <7> [185.704081] i915 0000:00:02.0: [drm:intel_modeset_verify_crtc [i915]] [CRTC:78:pipe A] <6> [189.609780] [IGT] kms_flip: finished subtest AC-HDMI-A1-HDMI-A2, FAIL

<6> [184.987035] [IGT] kms_flip: starting dynamic subtest AC-HDMI-A1-HDMI-A2

<7> [184.988878] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:182]

<7> [184.989911] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:184]

<7> [185.046505] i915 0000:00:02.0: [drm:drm_mode_setcrtc] [CRTC:78:pipe A]

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

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

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

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

<7> [185.051580] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:78:pipe A] fastset requirement not met in lane_lat_optim_mask (expected 0x0000000d, found 0x00000000)

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

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

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

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

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

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

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

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

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

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

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

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

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

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

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

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

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

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

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

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

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

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

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

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

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

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

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

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

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

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

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

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

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

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

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

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

<7> [185.067032] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:78:pipe A] fastset requirement not met in infoframes.gcp (expected 0x00000006, found 0x00000000)

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

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

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

<7> [185.068290] i915 0000:00:02.0: colorspace: RGB

<7> [185.068294] i915 0000:00:02.0: scan mode: Underscan

<7> [185.068297] i915 0000:00:02.0: colorimetry: No Data

<7> [185.068300] i915 0000:00:02.0: picture aspect: No Data

<7> [185.068303] i915 0000:00:02.0: active aspect: Same as Picture

<7> [185.068307] i915 0000:00:02.0: itc: No Data

<7> [185.068310] i915 0000:00:02.0: extended colorimetry: xvYCC 601

<7> [185.068313] i915 0000:00:02.0: quantization range: Full

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

<7> [185.068319] i915 0000:00:02.0: video code: 0

<7> [185.068322] i915 0000:00:02.0: ycc quantization range: Full

<7> [185.068325] i915 0000:00:02.0: hdmi content type: Graphics

<7> [185.068329] i915 0000:00:02.0: pixel repeat: 0

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

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

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

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

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

<7> [185.069571] i915 0000:00:02.0: vendor: Intel

<7> [185.069574] i915 0000:00:02.0: product: Integrated gfx

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

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

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

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

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

<7> [185.070808] i915 0000:00:02.0: empty frame

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

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

<7> [185.071617] i915 0000:00:02.0: [drm:intel_dpll_crtc_put [i915]] [CRTC:78:pipe A] releasing PORT PLL B

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

<7> [185.072525] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] [CRTC:121:pipe B] dbuf slices 0x1 -> 0x1, ddb (510 - 1020) -> (0 - 1020), active pipes 0x3 -> 0x2

<7> [185.072981] i915 0000:00:02.0: [drm:skl_print_plane_ddb_changes [i915]] [PLANE:72:cursor A] ddb ( 497 - 510) -> ( 0 - 0), size 13 -> 0

<7> [185.073414] i915 0000:00:02.0: [drm:skl_print_plane_ddb_changes [i915]] [PLANE:115:cursor B] ddb (1007 - 1020) -> ( 988 - 1020), size 13 -> 32

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

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

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

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

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

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

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

<7> [185.077002] i915 0000:00:02.0: [drm:intel_audio_codec_disable [i915]] [CONNECTOR:166:HDMI-A-1][ENCODER:165:DDI B/PHY B] Disable audio codec on [CRTC:78:pipe A]

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

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

<7> [185.115288] i915 0000:00:02.0: [drm:intel_ddi_disable_transcoder_func [i915]] Quirk Increase DDI disabled time

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

<7> [185.217798] i915 0000:00:02.0: [drm:intel_dpll_disable [i915]] disable PORT PLL B (active 0x1, on? 1) for [CRTC:78:pipe A]

<7> [185.219751] i915 0000:00:02.0: [drm:intel_dpll_disable [i915]] disabling PORT PLL B

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

<7> [185.220801] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:175:DDI C/PHY C]

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

<7> [185.228018] i915 0000:00:02.0: [drm:intel_power_well_disable [i915]] disabling dpio-common-b

<7> [185.228639] i915 0000:00:02.0: [drm:intel_modeset_verify_crtc [i915]] [CRTC:78:pipe A]

<7> [185.230644] i915 0000:00:02.0: [drm:drm_mode_setcrtc] [CRTC:121:pipe B]

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

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

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

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

<7> [185.233085] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:121:pipe B] fastset requirement not met in lane_lat_optim_mask (expected 0x0000000d, found 0x00000000)

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

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

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

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

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

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

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

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

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

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

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

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

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

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

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

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

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

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

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

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

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

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

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

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

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

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

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

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

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

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

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

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

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

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

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

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

<7> [185.250380] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:121:pipe B] fastset requirement not met in infoframes.gcp (expected 0x00000006, found 0x00000000)

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

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

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

<7> [185.251755] i915 0000:00:02.0: colorspace: RGB

<7> [185.251759] i915 0000:00:02.0: scan mode: Underscan

<7> [185.251762] i915 0000:00:02.0: colorimetry: No Data

<7> [185.251765] i915 0000:00:02.0: picture aspect: No Data

<7> [185.251768] i915 0000:00:02.0: active aspect: Same as Picture

<7> [185.251772] i915 0000:00:02.0: itc: No Data

<7> [185.251775] i915 0000:00:02.0: extended colorimetry: xvYCC 601

<7> [185.251778] i915 0000:00:02.0: quantization range: Full

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

<7> [185.251784] i915 0000:00:02.0: video code: 0

<7> [185.251807] i915 0000:00:02.0: ycc quantization range: Full

<7> [185.251811] i915 0000:00:02.0: hdmi content type: Graphics

<7> [185.251814] i915 0000:00:02.0: pixel repeat: 0

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

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

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

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

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

<7> [185.253029] i915 0000:00:02.0: vendor: Intel

<7> [185.253033] i915 0000:00:02.0: product: Integrated gfx

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

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

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

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

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

<7> [185.254365] i915 0000:00:02.0: empty frame

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

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

<7> [185.255129] i915 0000:00:02.0: [drm:intel_dpll_crtc_put [i915]] [CRTC:121:pipe B] releasing PORT PLL C

<7> [185.255603] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] [CRTC:121:pipe B] dbuf slices 0x1 -> 0x0, ddb (0 - 1020) -> (0 - 0), active pipes 0x2 -> 0x0

<7> [185.256041] i915 0000:00:02.0: [drm:skl_print_plane_ddb_changes [i915]] [PLANE:115:cursor B] ddb ( 988 - 1020) -> ( 0 - 0), size 32 -> 0

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

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

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

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

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

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

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

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

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

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

<7> [185.261036] i915 0000:00:02.0: [drm:intel_audio_codec_disable [i915]] [CONNECTOR:176:HDMI-A-2][ENCODER:175:DDI C/PHY C] Disable audio codec on [CRTC:121:pipe B]

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

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

<7> [185.312302] i915 0000:00:02.0: [drm:intel_ddi_disable_transcoder_func [i915]] Quirk Increase DDI disabled time

<7> [185.416714] i915 0000:00:02.0: [drm:intel_power_well_disable [i915]] disabling DDI_IO_C

<7> [185.418113] i915 0000:00:02.0: [drm:intel_dpll_disable [i915]] disable PORT PLL C (active 0x2, on? 1) for [CRTC:121:pipe B]

<7> [185.420431] i915 0000:00:02.0: [drm:intel_dpll_disable [i915]] disabling PORT PLL C

<7> [185.420872] i915 0000:00:02.0: [drm:intel_set_cdclk [i915]] Pre changing CDCLK to 79200 kHz, VCO 633600 kHz, ref 19200 kHz, bypass 19200 kHz, voltage level 4

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

<7> [185.421818] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:175:DDI C/PHY C]

<7> [185.422499] i915 0000:00:02.0: [drm:verify_connector_state [i915]] [CONNECTOR:176:HDMI-A-2]

<7> [185.423369] i915 0000:00:02.0: [drm:intel_power_well_disable [i915]] disabling dpio-common-c

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

<7> [185.424472] i915 0000:00:02.0: [drm:intel_modeset_verify_crtc [i915]] [CRTC:121:pipe B]

<7> [185.426639] i915 0000:00:02.0: [drm:drm_mode_setcrtc] [CRTC:164:pipe C]

<7> [185.427199] i915 0000:00:02.0: [drm:drm_mode_setcrtc] [CRTC:164:pipe C]

<7> [185.427312] i915 0000:00:02.0: [drm:drm_mode_setcrtc] [CONNECTOR:176:HDMI-A-2]

<7> [185.427504] i915 0000:00:02.0: [drm:intel_hdmi_compute_output_format [i915]] picking 12 bpc for HDMI output (pipe bpp: 36)

<7> [185.428017] i915 0000:00:02.0: [drm:intel_atomic_check [i915]] [CRTC:164:pipe C] hw max bpp: 36, pipe bpp: 36, dithering: 0

<7> [185.428493] i915 0000:00:02.0: [drm:intel_ddi_compute_config_late [i915]] [ENCODER:175:DDI C/PHY C] [CRTC:164:pipe C]

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

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

<7> [185.430004] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:164:pipe C] fastset requirement not met in cpu_transcoder (expected -1, found 2)

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

<7> [185.430973] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:164:pipe C] fastset requirement not met in lane_lat_optim_mask (expected 0x00000000, found 0x0000000d)

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

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

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

<7> [185.432688] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:164:pipe C] fastset requirement not met in hw.pipe_mode.crtc_htotal (expected 0, found 2200)

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

<7> [185.434713] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:164:pipe C] fastset requirement not met in hw.pipe_mode.crtc_hblank_end (expected 0, found 2200)

<7> [185.435437] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:164:pipe C] fastset requirement not met in hw.pipe_mode.crtc_hsync_start (expected 0, found 2008)

<7> [185.435887] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:164:pipe C] fastset requirement not met in hw.pipe_mode.crtc_hsync_end (expected 0, found 2052)

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

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

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

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

<7> [185.438038] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:164:pipe C] fastset requirement not met in hw.pipe_mode.crtc_vtotal (expected 0, found 1125)

<7> [185.439546] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:164:pipe C] fastset requirement not met in hw.pipe_mode.crtc_vblank_end (expected 0, found 1125)

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

<7> [185.440691] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:164:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_htotal (expected 0, found 2200)

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

<7> [185.441744] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:164:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_hblank_end (expected 0, found 2200)

<7> [185.442169] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:164:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_hsync_start (expected 0, found 2008)

<7> [185.442656] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:164:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_hsync_end (expected 0, found 2052)

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

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

<7> [185.444848] i915 0000:00:02.0: [drm:gen9_enable_dc5 [i915]] Enabling DC5

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

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

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

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

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

<7> [185.448513] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:164:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_vtotal (expected 0, found 1125)

<7> [185.448963] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:164:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_vblank_end (expected 0, found 1125)

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

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

<7> [185.450350] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:164:pipe C] fastset requirement not met in hw.adjusted_mode.flags (8) (expected 0, found 8)

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

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

<7> [185.451566] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:164:pipe C] fastset requirement not met in pipe_bpp (expected 0, found 36)

<7> [185.451981] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:164:pipe C] fastset requirement not met in hw.pipe_mode.crtc_clock (expected 0, found 148500)

<7> [185.453589] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:164:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_clock (expected 0, found 148500)

<7> [185.454097] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:164:pipe C] fastset requirement not met in port_clock (expected 0, found 222750)

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

<7> [185.455282] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:164:pipe C] fastset requirement not met in infoframes.gcp (expected 0x00000000, found 0x00000006)

<7> [185.455665] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:164:pipe C] fastset requirement not met in avi infoframe

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

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

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

<7> [185.457028] i915 0000:00:02.0: colorspace: RGB

<7> [185.457031] i915 0000:00:02.0: scan mode: Underscan

<7> [185.457035] i915 0000:00:02.0: colorimetry: No Data

<7> [185.457038] i915 0000:00:02.0: picture aspect: No Data

<7> [185.457041] i915 0000:00:02.0: active aspect: Same as Picture

<7> [185.457044] i915 0000:00:02.0: itc: No Data

<7> [185.457047] i915 0000:00:02.0: extended colorimetry: xvYCC 601

<7> [185.457050] i915 0000:00:02.0: quantization range: Full

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

<7> [185.457056] i915 0000:00:02.0: video code: 0

<7> [185.457059] i915 0000:00:02.0: ycc quantization range: Full

<7> [185.457063] i915 0000:00:02.0: hdmi content type: Graphics

<7> [185.457066] i915 0000:00:02.0: pixel repeat: 0

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

<7> [185.457073] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:164:pipe C] fastset requirement not met in spd infoframe

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

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

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

<7> [185.460069] i915 0000:00:02.0: vendor: Intel

<7> [185.460073] i915 0000:00:02.0: product: Integrated gfx

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

<7> [185.460080] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:164:pipe C] fastset requirement not met in hdmi infoframe

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

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

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

<7> [185.461703] i915 0000:00:02.0: empty frame

<7> [185.461708] i915 0000:00:02.0: [drm:intel_atomic_check [i915]] [CRTC:164:pipe C] fastset requirement not met, forcing full modeset

<7> [185.462191] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] [CRTC:164:pipe C] dbuf slices 0x0 -> 0x1, ddb (0 - 0) -> (0 - 1020), active pipes 0x0 -> 0x4

<7> [185.462719] i915 0000:00:02.0: [drm:skl_print_plane_ddb_changes [i915]] [PLANE:122:plane 1C] ddb ( 0 - 0) -> ( 0 - 988), size 0 -> 988

<7> [185.463105] i915 0000:00:02.0: [drm:skl_print_plane_ddb_changes [i915]] [PLANE:158:cursor C] ddb ( 0 - 0) -> ( 988 - 1020), size 0 -> 32

<7> [185.464740] i915 0000:00:02.0: [drm:skl_print_plane_wm_changes [i915]] [PLANE:122:plane 1C] level wm0, wm1, wm2, wm3, wm4, wm5, wm6, wm7, twm, swm, stwm -> *wm0,*wm1,*wm2,*wm3,*wm4,*wm5,*wm6,*wm7,*twm, swm, stwm

<7> [185.465428] i915 0000:00:02.0: [drm:skl_print_plane_wm_changes [i915]] [PLANE:122:plane 1C] lines 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0 -> 1, 1, 1, 2, 2, 2, 2, 2, 0, 0, 0

<7> [185.465965] i915 0000:00:02.0: [drm:skl_print_plane_wm_changes [i915]] [PLANE:122:plane 1C] blocks 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0 -> 16, 16, 16, 33, 33, 33, 33, 33, 30, 0, 0

<7> [185.466414] i915 0000:00:02.0: [drm:skl_print_plane_wm_changes [i915]] [PLANE:122:plane 1C] min_ddb 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0 -> 17, 17, 17, 34, 34, 34, 34, 34, 31, 0, 0

<7> [185.466817] i915 0000:00:02.0: [drm:skl_print_plane_wm_changes [i915]] [PLANE:122:plane 1C] min_ddb_uv 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0 -> 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0

<7> [185.467343] i915 0000:00:02.0: [drm:intel_cdclk_atomic_check [i915]] [CRTC:164:pipe C] min cdclk: 0 kHz -> 192000 kHz

<7> [185.467771] i915 0000:00:02.0: [drm:intel_cdclk_update_dbuf_bw_min_cdclk [i915]] dbuf bandwidth min cdclk: 18563 kHz -> 9282 kHz

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

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

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

<7> [185.469604] i915 0000:00:02.0: [drm:bxt_get_dpll [i915]] [CRTC:164:pipe C] using pre-allocated PORT PLL C

<7> [185.470059] i915 0000:00:02.0: [drm:intel_dpll_crtc_get [i915]] [CRTC:164:pipe C] reserving PORT PLL C

<7> [185.470539] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [CRTC:164:pipe C] enable: yes [modeset]

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

<7> [185.471504] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] cpu_transcoder: C, pipe bpp: 36, dithering: 0

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

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

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

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

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

<7> [185.473868] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] GCP: 0x6

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

<7> [185.474287] i915 0000:00:02.0: colorspace: RGB

<7> [185.474290] i915 0000:00:02.0: scan mode: Underscan

<7> [185.474293] i915 0000:00:02.0: colorimetry: No Data

<7> [185.474297] i915 0000:00:02.0: picture aspect: No Data

<7> [185.474300] i915 0000:00:02.0: active aspect: Same as Picture

<7> [185.474304] i915 0000:00:02.0: itc: No Data

<7> [185.474307] i915 0000:00:02.0: extended colorimetry: xvYCC 601

<7> [185.474310] i915 0000:00:02.0: quantization range: Full

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

<7> [185.474316] i915 0000:00:02.0: video code: 0

<7> [185.474320] i915 0000:00:02.0: ycc quantization range: Full

<7> [185.474323] i915 0000:00:02.0: hdmi content type: Graphics

<7> [185.474326] i915 0000:00:02.0: pixel repeat: 0

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

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

<7> [185.474336] i915 0000:00:02.0: vendor: Intel

<7> [185.474339] i915 0000:00:02.0: product: Integrated gfx

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

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

<7> [185.474349] i915 0000:00:02.0: empty frame

<7> [185.474353] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] ELD: 10 00 07 00 66 10 00 01 00 00 00 00 00 00 00 00

<7> [185.474732] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] ELD: 05 e3 cd 0c 32 38 45 38 35 30 09 07 07 00 00 00

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

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

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

<7> [185.476552] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] vrr: vmin vblank: 0, vmax vblank: 0, vmin vtotal: 0, vmax vtotal: 0

<7> [185.476933] 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> [185.477329] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] requested mode: "1920x1080": 60 148500 1920 2008 2052 2200 1080 1083 1088 1125 0x48 0x9

<7> [185.477708] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] adjusted mode: "1920x1080": 60 148500 1920 2008 2052 2200 1080 1083 1088 1125 0x48 0x9

<7> [185.478123] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] crtc timings: clock=148500, hd=1920 hb=1920-2200 hs=2008-2052 ht=2200, vd=1080 vb=1080-1125 vs=1083-1088 vt=1125, flags=0x9

<7> [185.478533] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pipe mode: "1920x1080": 60 148500 1920 2008 2052 2200 1080 1083 1088 1125 0x40 0x9

<7> [185.478913] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] crtc timings: clock=148500, hd=1920 hb=1920-2200 hs=2008-2052 ht=2200, vd=1080 vb=1080-1125 vs=1083-1088 vt=1125, flags=0x9

<7> [185.479326] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] port clock: 222750, pixel rate 148500, min cdclk 192000, min voltage level 0

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

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

<7> [185.480508] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pipe src: 1920x1080+0+0

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

<7> [185.481454] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] sharpness strength: 0, sharpness tap size: 0, sharpness enable: 0

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

<7> [185.482362] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] dpll_hw_state: ebb0: 0x6200, ebb4: 0x2000,pll0: 0x21, pll1: 0x100, pll2: 0x1a6666, pll3: 0x10000, pll6: 0x30904, pll8: 0x8, pll9: 0xa, pll10: 0x8003c00, pcsdw12: 0x4d

<7> [185.482771] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] csc_mode: 0x0 gamma_mode: 0x0 gamma_enable: 0 csc_enable: 0

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

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

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

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

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

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

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

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

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

<7> [185.486807] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:131:plane 2C] fb: [NOFB], visible: no

<7> [185.487428] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:140:plane 3C] fb: [NOFB], visible: no

<7> [185.487826] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:149:plane 4C] fb: [NOFB], visible: no

<7> [185.488205] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:158:cursor C] fb: [NOFB], visible: no

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

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

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

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

<7> [185.492529] i915 0000:00:02.0: [drm:intel_power_well_enable [i915]] enabling dpio-common-c

<7> [185.493368] i915 0000:00:02.0: [drm:intel_set_cdclk [i915]] Pre changing CDCLK to 316800 kHz, VCO 633600 kHz, ref 19200 kHz, bypass 19200 kHz, voltage level 13

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

<7> [185.494302] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:175:DDI C/PHY C]

<7> [185.494873] i915 0000:00:02.0: [drm:intel_dpll_enable [i915]] enable PORT PLL C (active 0x4, on? 0) for [CRTC:164:pipe C]

<7> [185.495321] i915 0000:00:02.0: [drm:intel_dpll_enable [i915]] enabling PORT PLL C

<7> [185.495889] i915 0000:00:02.0: [drm:intel_power_well_enable [i915]] enabling DDI_IO_C

<7> [185.496408] i915 0000:00:02.0: [drm:intel_enable_transcoder [i915]] enabling pipe C

<7> [185.531171] i915 0000:00:02.0: [drm:intel_audio_codec_enable [i915]] [CONNECTOR:176:HDMI-A-2][ENCODER:175:DDI C/PHY C] Enable audio codec on [CRTC:164:pipe C], 32 bytes ELD

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

<7> [185.547819] i915 0000:00:02.0: [drm:audio_config_hdmi_pixel_clock [i915]] Configuring HDMI audio for pixel clock 148500 (0x00090000)

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

<7> [185.548899] i915 0000:00:02.0: [drm:verify_connector_state [i915]] [CONNECTOR:176:HDMI-A-2]

<7> [185.550163] i915 0000:00:02.0: [drm:intel_modeset_verify_crtc [i915]] [CRTC:164:pipe C]

<7> [185.553429] i915 0000:00:02.0: [drm:drm_mode_setcrtc] [CRTC:78:pipe A]

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

<7> [185.553688] i915 0000:00:02.0: [drm:intel_hdmi_compute_output_format [i915]] picking 12 bpc for HDMI output (pipe bpp: 36)

<7> [185.554196] i915 0000:00:02.0: [drm:intel_atomic_check [i915]] [CRTC:78:pipe A] hw max bpp: 36, pipe bpp: 36, dithering: 0

<7> [185.555057] i915 0000:00:02.0: [drm:intel_ddi_compute_config_late [i915]] [ENCODER:165:DDI B/PHY B] [CRTC:78:pipe A]

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

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

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

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

<7> [185.558549] azx_init_pci: snd_hda_intel 0000:00:0e.0: Clearing TCSEL

<7> [185.558565] azx_init_pci: snd_hda_intel 0000:00:0e.0: SCH snoop: Enabled

<7> [185.558923] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:78:pipe A] fastset requirement not met in lane_lat_optim_mask (expected 0x00000000, found 0x0000000d)

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

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

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

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

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

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

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

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

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

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

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

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

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

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

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

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

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

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

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

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

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

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

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

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

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

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

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

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

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

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

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

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

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

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

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

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

<7> [185.586094] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:78:pipe A] fastset requirement not met in infoframes.gcp (expected 0x00000000, found 0x00000006)

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

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

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

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

<7> [185.589323] i915 0000:00:02.0: colorspace: RGB

<7> [185.589327] i915 0000:00:02.0: scan mode: Underscan

<7> [185.589330] i915 0000:00:02.0: colorimetry: No Data

<7> [185.589333] i915 0000:00:02.0: picture aspect: No Data

<7> [185.589336] i915 0000:00:02.0: active aspect: Same as Picture

<7> [185.589340] i915 0000:00:02.0: itc: No Data

<7> [185.589342] i915 0000:00:02.0: extended colorimetry: xvYCC 601

<7> [185.589346] i915 0000:00:02.0: quantization range: Full

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

<7> [185.589352] i915 0000:00:02.0: video code: 0

<7> [185.589355] i915 0000:00:02.0: ycc quantization range: Full

<7> [185.589358] i915 0000:00:02.0: hdmi content type: Graphics

<7> [185.589361] i915 0000:00:02.0: pixel repeat: 0

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

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

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

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

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

<7> [185.591041] i915 0000:00:02.0: vendor: Intel

<7> [185.591045] i915 0000:00:02.0: product: Integrated gfx

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

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

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

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

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

<7> [185.593302] i915 0000:00:02.0: empty frame

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

<7> [185.593784] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] [CRTC:78:pipe A] dbuf slices 0x0 -> 0x1, ddb (0 - 0) -> (0 - 510), active pipes 0x4 -> 0x5

<7> [185.594189] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] [CRTC:164:pipe C] dbuf slices 0x1 -> 0x1, ddb (0 - 1020) -> (510 - 1020), active pipes 0x4 -> 0x5

<7> [185.595764] i915 0000:00:02.0: [drm:skl_print_plane_ddb_changes [i915]] [PLANE:36:plane 1A] ddb ( 0 - 0) -> ( 0 - 497), size 0 -> 497

<7> [185.596515] i915 0000:00:02.0: [drm:skl_print_plane_ddb_changes [i915]] [PLANE:72:cursor A] ddb ( 0 - 0) -> ( 497 - 510), size 0 -> 13

<7> [185.596894] i915 0000:00:02.0: [drm:skl_print_plane_wm_changes [i915]] [PLANE:36: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> [185.597614] i915 0000:00:02.0: [drm:skl_print_plane_wm_changes [i915]] [PLANE:36:plane 1A] lines 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0 -> 1, 1, 1, 2, 2, 2, 2, 2, 0, 0, 0

<7> [185.597997] i915 0000:00:02.0: [drm:skl_print_plane_wm_changes [i915]] [PLANE:36:plane 1A] blocks 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0 -> 16, 16, 16, 33, 33, 33, 33, 33, 30, 0, 0

<7> [185.599566] i915 0000:00:02.0: [drm:skl_print_plane_wm_changes [i915]] [PLANE:36:plane 1A] min_ddb 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0 -> 17, 17, 17, 34, 34, 34, 34, 34, 31, 0, 0

<7> [185.599989] i915 0000:00:02.0: [drm:skl_print_plane_wm_changes [i915]] [PLANE:36:plane 1A] min_ddb_uv 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0 -> 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0

<7> [185.600754] i915 0000:00:02.0: [drm:skl_print_plane_ddb_changes [i915]] [PLANE:122:plane 1C] ddb ( 0 - 988) -> ( 510 - 1007), size 988 -> 497

<7> [185.601136] i915 0000:00:02.0: [drm:skl_print_plane_ddb_changes [i915]] [PLANE:158:cursor C] ddb ( 988 - 1020) -> (1007 - 1020), size 32 -> 13

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

<7> [185.603156] i915 0000:00:02.0: [drm:intel_cdclk_update_dbuf_bw_min_cdclk [i915]] dbuf bandwidth min cdclk: 9282 kHz -> 18563 kHz

<7> [185.603960] i915 0000:00:02.0: [drm:bxt_get_dpll [i915]] [CRTC:78:pipe A] using pre-allocated PORT PLL B

<7> [185.604611] i915 0000:00:02.0: [drm:intel_dpll_crtc_get [i915]] [CRTC:78:pipe A] reserving PORT PLL B

<7> [185.605008] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [CRTC:78:pipe A] enable: yes [modeset]

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

<7> [185.606634] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] cpu_transcoder: A, pipe bpp: 36, dithering: 0

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

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

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

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

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

<7> [185.610860] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] GCP: 0x6

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

<7> [185.611820] i915 0000:00:02.0: colorspace: RGB

<7> [185.611823] i915 0000:00:02.0: scan mode: Underscan

<7> [185.611827] i915 0000:00:02.0: colorimetry: No Data

<7> [185.611830] i915 0000:00:02.0: picture aspect: No Data

<7> [185.611833] i915 0000:00:02.0: active aspect: Same as Picture

<7> [185.611836] i915 0000:00:02.0: itc: No Data

<7> [185.611839] i915 0000:00:02.0: extended colorimetry: xvYCC 601

<7> [185.611842] i915 0000:00:02.0: quantization range: Full

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

<7> [185.611848] i915 0000:00:02.0: video code: 0

<7> [185.611851] i915 0000:00:02.0: ycc quantization range: Full

<7> [185.611854] i915 0000:00:02.0: hdmi content type: Graphics

<7> [185.611857] i915 0000:00:02.0: pixel repeat: 0

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

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

<7> [185.611868] i915 0000:00:02.0: vendor: Intel

<7> [185.611871] i915 0000:00:02.0: product: Integrated gfx

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

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

<7> [185.611881] i915 0000:00:02.0: empty frame

<7> [185.611884] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] ELD: 10 00 07 00 66 10 00 01 00 00 00 00 00 00 00 00

<7> [185.613270] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] ELD: 05 e3 cd 0c 32 38 45 38 35 30 09 07 07 00 00 00

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

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

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

<7> [185.615746] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] vrr: vmin vblank: 0, vmax vblank: 0, vmin vtotal: 0, vmax vtotal: 0

<7> [185.616128] 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> [185.617498] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] requested mode: "1920x1080": 60 148500 1920 2008 2052 2200 1080 1083 1088 1125 0x48 0x9

<7> [185.617907] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] adjusted mode: "1920x1080": 60 148500 1920 2008 2052 2200 1080 1083 1088 1125 0x48 0x9

<7> [185.618625] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] crtc timings: clock=148500, hd=1920 hb=1920-2200 hs=2008-2052 ht=2200, vd=1080 vb=1080-1125 vs=1083-1088 vt=1125, flags=0x9

<7> [185.619013] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pipe mode: "1920x1080": 60 148500 1920 2008 2052 2200 1080 1083 1088 1125 0x40 0x9

<7> [185.619642] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] crtc timings: clock=148500, hd=1920 hb=1920-2200 hs=2008-2052 ht=2200, vd=1080 vb=1080-1125 vs=1083-1088 vt=1125, flags=0x9

<7> [185.620029] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] port clock: 222750, pixel rate 148500, min cdclk 192000, min voltage level 0

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

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

<7> [185.622655] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pipe src: 1920x1080+0+0

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

<7> [185.623696] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] sharpness strength: 0, sharpness tap size: 0, sharpness enable: 0

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

<7> [185.625425] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] dpll_hw_state: ebb0: 0x6200, ebb4: 0x2000,pll0: 0x21, pll1: 0x100, pll2: 0x1a6666, pll3: 0x10000, pll6: 0x30904, pll8: 0x8, pll9: 0xa, pll10: 0x8003c00, pcsdw12: 0x4d

<7> [185.625831] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] csc_mode: 0x0 gamma_mode: 0x0 gamma_enable: 0 csc_enable: 0

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

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

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

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

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

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

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

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

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

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

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

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

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

<7> [185.636133] i915 0000:00:02.0: [drm:intel_power_well_enable [i915]] enabling dpio-common-b

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

<7> [185.637878] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:175:DDI C/PHY C]

<7> [185.647842] i915 0000:00:02.0: [drm:intel_dpll_enable [i915]] enable PORT PLL B (active 0x1, on? 0) for [CRTC:78:pipe A]

<7> [185.648337] i915 0000:00:02.0: [drm:intel_dpll_enable [i915]] enabling PORT PLL B

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

<7> [185.650011] i915 0000:00:02.0: [drm:intel_enable_transcoder [i915]] enabling pipe A

<7> [185.668468] i915 0000:00:02.0: [drm:intel_fbc_update [i915]] reserved 16588800 bytes of contiguous stolen space for FBC, limit: 1

<7> [185.668939] i915 0000:00:02.0: [drm:intel_fbc_update [i915]] Enabling FBC on [PLANE:36:plane 1A]

<7> [185.685162] i915 0000:00:02.0: [drm:intel_audio_codec_enable [i915]] [CONNECTOR:166:HDMI-A-1][ENCODER:165:DDI B/PHY B] Enable audio codec on [CRTC:78:pipe A], 32 bytes ELD

<7> [185.701820] i915 0000:00:02.0: [drm:audio_config_hdmi_pixel_clock [i915]] Configuring HDMI audio for pixel clock 148500 (0x00090000)

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

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

<7> [185.704081] i915 0000:00:02.0: [drm:intel_modeset_verify_crtc [i915]] [CRTC:78:pipe A]

<6> [189.609780] [IGT] kms_flip: finished subtest AC-HDMI-A1-HDMI-A2, FAIL

Results for igt@kms_flip@2x-flip-vs-expired-vblank@ac-hdmi-a1-hdmi-a2