Result:
git-log-oneline i915_display_info5 igt_runner5 runtimes5 results5.json results5-i915-load.json guc_logs5.tar i915_display_info_post_exec5 boot5 dmesg5
| Detail | Value |
|---|---|
| Duration | 18.56 seconds |
| Hostname |
shard-tglu-7 |
| Igt-Version |
IGT-Version: 2.4-g8214859d2 (x86_64) (Linux: 7.1.0-rc2-CI_DRM_18409-g9160312bed53+ x86_64) |
| Out |
Starting dynamic subtest: D-HDMI-A1 1920x1080: 120 285500 1920 1968 2000 2080 1080 1083 1088 1144 0x48 0x5 Expected frametime: 8335us; measured 8334.5us +- 2.708us accuracy 0.10% Event flip: expected 900, counted 895, passrate = 81.90%, encoder type 2 Expected frametime: 8335us; measured 8492.4us +- 3.284us accuracy 0.12% vblank interval differs from modeline! expected 8334.6us, measured 8492us +- 3.284us, difference 157.8us (48.1 sigma) Event flip: expected 883, counted 890, passrate = 30.56%, encoder type 2 Stack trace: #0 ../lib/igt_core.c:2075 __igt_fail_assert() #1 ../tests/kms_flip.c:1071 run_test_on_crtc_set() #2 ../tests/kms_flip.c:1920 run_test() #3 ../tests/kms_flip.c:2184 __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 D-HDMI-A1: FAIL (18.562s) Subtest plain-flip-ts-check: FAIL (42.069s) Stack trace: #0 ../lib/igt_core.c:2075 __igt_fail_assert() #1 ../lib/igt_kms.c:2352 kmstest_set_connector_dpms() #2 ../lib/igt_core.c:2961 igt_atexit_handler() #3 [erand48_r+0x1d6] #4 [exit+0x1e] #5 ../lib/igt_core.c:2416 igt_exit() #6 [main+0x3f] #7 [__libc_init_first+0x8a] #8 [__libc_start_main+0x8b] #9 [_start+0x25] |
| Err |
Starting dynamic subtest: D-HDMI-A1 (kms_flip:2139) CRITICAL: Test assertion failure function __run_test_on_crtc_set, file ../tests/kms_flip.c:1722: (kms_flip:2139) CRITICAL: Failed assertion: !retried Dynamic subtest D-HDMI-A1 failed. **** DEBUG **** (kms_flip:2139) DEBUG: flip ts/seq: last 110.178268/2114, current 110.186668/2115: elapsed=8401.0us expected=8492.4us +- 42.5us, error 1.1% (kms_flip:2139) DEBUG: inconsistent flip ts/seq: last 110.178268/2114, current 110.186668/2115: elapsed=8401.0us expected=8492.4us (kms_flip:2139) DEBUG: name = flip last_ts = 110.186668 last_received_ts = 110.186394 last_seq = 2115 current_ts = 110.195061 current_received_ts = 110.194771 current_seq = 2116 count = 810 seq_step = 1 (kms_flip:2139) DEBUG: flip ts/seq: last 110.186668/2115, current 110.195061/2116: elapsed=8395.0us expected=8492.4us +- 42.5us, error 1.1% (kms_flip:2139) DEBUG: inconsistent flip ts/seq: last 110.186668/2115, current 110.195061/2116: elapsed=8395.0us expected=8492.4us (kms_flip:2139) DEBUG: name = flip last_ts = 110.195061 last_received_ts = 110.194771 last_seq = 2116 current_ts = 110.203461 current_received_ts = 110.203217 current_seq = 2117 count = 811 seq_step = 1 (kms_flip:2139) DEBUG: flip ts/seq: last 110.195061/2116, current 110.203461/2117: elapsed=8394.0us expected=8492.4us +- 42.5us, error 1.2% (kms_flip:2139) DEBUG: inconsistent flip ts/seq: last 110.195061/2116, current 110.203461/2117: elapsed=8394.0us expected=8492.4us (kms_flip:2139) DEBUG: name = flip last_ts = 110.203461 last_received_ts = 110.203217 last_seq = 2117 current_ts = 110.211861 current_received_ts = 110.211571 current_seq = 2118 count = 812 seq_step = 1 (kms_flip:2139) DEBUG: flip ts/seq: last 110.203461/2117, current 110.211861/2118: elapsed=8401.0us expected=8492.4us +- 42.5us, error 1.1% (kms_flip:2139) DEBUG: inconsistent flip ts/seq: last 110.203461/2117, current 110.211861/2118: elapsed=8401.0us expected=8492.4us (kms_flip:2139) DEBUG: name = flip last_ts = 110.211861 last_received_ts = 110.211571 last_seq = 2118 current_ts = 110.220253 current_received_ts = 110.220146 current_seq = 2119 count = 813 seq_step = 1 (kms_flip:2139) DEBUG: flip ts/seq: last 110.211861/2118, current 110.220253/2119: elapsed=8397.0us expected=8492.4us +- 42.5us, error 1.1% (kms_flip:2139) DEBUG: inconsistent flip ts/seq: last 110.211861/2118, current 110.220253/2119: elapsed=8397.0us expected=8492.4us (kms_flip:2139) DEBUG: name = flip last_ts = 110.220253 last_received_ts = 110.220146 last_seq = 2119 current_ts = 110.228645 current_received_ts = 110.228424 current_seq = 2120 count = 814 seq_step = 1 (kms_flip:2139) DEBUG: flip ts/seq: last 110.220253/2119, current 110.228645/2120: elapsed=8391.0us expected=8492.4us +- 42.5us, error 1.2% (kms_flip:2139) DEBUG: inconsistent flip ts/seq: last 110.220253/2119, current 110.228645/2120: elapsed=8391.0us expected=8492.4us (kms_flip:2139) DEBUG: name = flip last_ts = 110.228645 last_received_ts = 110.228424 last_seq = 2120 current_ts = 110.237038 current_received_ts = 110.236877 current_seq = 2121 count = 815 seq_step = 1 (kms_flip:2139) DEBUG: flip ts/seq: last 110.228645/2120, current 110.237038/2121: elapsed=8395.0us expected=8492.4us +- 42.5us, error 1.1% (kms_flip:2139) DEBUG: inconsistent flip ts/seq: last 110.228645/2120, current 110.237038/2121: elapsed=8395.0us expected=8492.4us (kms_flip:2139) DEBUG: name = flip last_ts = 110.237038 last_received_ts = 110.236877 last_seq = 2121 current_ts = 110.245438 current_received_ts = 110.245178 current_seq = 2122 count = 816 seq_step = 1 (kms_flip:2139) DEBUG: flip ts/seq: last 110.237038/2121, current 110.245438/2122: elapsed=8398.0us expected=8492.4us +- 42.5us, error 1.1% (kms_flip:2139) DEBUG: inconsistent flip ts/seq: last 110.237038/2121, current 110.245438/2122: elapsed=8398.0us expected=8492.4us (kms_flip:2139) DEBUG: name = flip last_ts = 110.245438 last_received_ts = 110.245178 last_seq = 2122 current_ts = 110.253838 current_received_ts = 110.253578 current_seq = 2123 count = 817 seq_step = 1 (kms_flip:2139) DEBUG: flip ts/seq: last 110.245438/2122, current 110.253838/2123: elapsed=8399.0us expected=8492.4us +- 42.5us, error 1.1% (kms_flip:2139) DEBUG: inconsistent flip ts/seq: last 110.245438/2122, current 110.253838/2123: elapsed=8399.0us expected=8492.4us (kms_flip:2139) DEBUG: name = flip last_ts = 110.253838 last_received_ts = 110.253578 last_seq = 2123 current_ts = 110.262238 current_received_ts = 110.262093 current_seq = 2124 count = 818 seq_step = 1 (kms_flip:2139) DEBUG: flip ts/seq: last 110.253838/2123, current 110.262238/2124: elapsed=8396.0us expected=8492.4us +- 42.5us, error 1.1% (kms_flip:2139) DEBUG: inconsistent flip ts/seq: last 110.253838/2123, current 110.262238/2124: elapsed=8396.0us expected=8492.4us (kms_flip:2139) DEBUG: name = flip last_ts = 110.262238 last_received_ts = 110.262093 last_seq = 2124 current_ts = 110.270630 current_received_ts = 110.270325 current_seq = 2125 count = 819 seq_step = 1 (kms_flip:2139) DEBUG: flip ts/seq: last 110.262238/2124, current 110.270630/2125: elapsed=8395.0us expected=8492.4us +- 42.5us, error 1.1% (kms_flip:2139) DEBUG: inconsistent flip ts/seq: last 110.262238/2124, current 110.270630/2125: elapsed=8395.0us expected=8492.4us (kms_flip:2139) DEBUG: name = flip last_ts = 110.270630 last_received_ts = 110.270325 last_seq = 2125 current_ts = 110.279022 current_received_ts = 110.278687 current_seq = 2126 count = 820 seq_step = 1 (kms_flip:2139) DEBUG: flip ts/seq: last 110.270630/2125, current 110.279022/2126: elapsed=8396.0us expected=8492.4us +- 42.5us, error 1.1% (kms_flip:2139) DEBUG: inconsistent flip ts/seq: last 110.270630/2125, current 110.279022/2126: elapsed=8396.0us expected=8492.4us (kms_flip:2139) DEBUG: name = flip last_ts = 110.279022 last_received_ts = 110.278687 last_seq = 2126 current_ts = 110.287430 current_received_ts = 110.287186 current_seq = 2127 count = 821 seq_step = 1 (kms_flip:2139) DEBUG: flip ts/seq: last 110.279022/2126, current 110.287430/2127: elapsed=8401.0us expected=8492.4us +- 42.5us, error 1.1% (kms_flip:2139) DEBUG: inconsistent flip ts/seq: last 110.279022/2126, current 110.287430/2127: elapsed=8401.0us expected=8492.4us (kms_flip:2139) DEBUG: name = flip last_ts = 110.287430 last_received_ts = 110.287186 last_seq = 2127 current_ts = 110.295815 current_received_ts = 110.295609 current_seq = 2128 count = 822 seq_step = 1 (kms_flip:2139) DEBUG: flip ts/seq: last 110.287430/2127, current 110.295815/2128: elapsed=8390.0us expected=8492.4us +- 42.5us, error 1.2% (kms_flip:2139) DEBUG: inconsistent flip ts/seq: last 110.287430/2127, current 110.295815/2128: elapsed=8390.0us expected=8492.4us (kms_flip:2139) DEBUG: name = flip last_ts = 110.295815 last_received_ts = 110.295609 last_seq = 2128 current_ts = 110.304214 current_received_ts = 110.304115 current_seq = 2129 count = 823 seq_step = 1 (kms_flip:2139) DEBUG: flip ts/seq: last 110.295815/2128, current 110.304214/2129: elapsed=8401.0us expected=8492.4us +- 42.5us, error 1.1% (kms_flip:2139) DEBUG: inconsistent flip ts/seq: last 110.295815/2128, current 110.304214/2129: elapsed=8401.0us expected=8492.4us (kms_flip:2139) DEBUG: name = flip last_ts = 110.304214 last_received_ts = 110.304115 last_seq = 2129 current_ts = 110.312614 current_received_ts = 110.312347 current_seq = 2130 count = 824 seq_step = 1 (kms_flip:2139) DEBUG: flip ts/seq: last 110.304214/2129, current 110.312614/2130: elapsed=8398.0us expected=8492.4us +- 42.5us, error 1.1% (kms_flip:2139) DEBUG: inconsistent flip ts/seq: last 110.304214/2129, current 110.312614/2130: elapsed=8398.0us expected=8492.4us (kms_flip:2139) DEBUG: name = flip last_ts = 110.312614 last_received_ts = 110.312347 last_seq = 2130 current_ts = 110.321014 current_received_ts = 110.320831 current_seq = 2131 count = 825 seq_step = 1 (kms_flip:2139) DEBUG: flip ts/seq: last 110.312614/2130, current 110.321014/2131: elapsed=8397.0us expected=8492.4us +- 42.5us, error 1.1% (kms_flip:2139) DEBUG: inconsistent flip ts/seq: last 110.312614/2130, current 110.321014/2131: elapsed=8397.0us expected=8492.4us (kms_flip:2139) DEBUG: name = flip last_ts = 110.321014 last_received_ts = 110.320831 last_seq = 2131 current_ts = 110.329407 current_received_ts = 110.329193 current_seq = 2132 count = 826 seq_step = 1 (kms_flip:2139) DEBUG: flip ts/seq: last 110.321014/2131, current 110.329407/2132: elapsed=8393.0us expected=8492.4us +- 42.5us, error 1.2% (kms_flip:2139) DEBUG: inconsistent flip ts/seq: last 110.321014/2131, current 110.329407/2132: elapsed=8393.0us expected=8492.4us (kms_flip:2139) DEBUG: name = flip last_ts = 110.329407 last_received_ts = 110.329193 last_seq = 2132 current_ts = 110.337807 current_received_ts = 110.337593 current_seq = 2133 count = 827 seq_step = 1 (kms_flip:2139) DEBUG: flip ts/seq: last 110.329407/2132, current 110.337807/2133: elapsed=8399.0us expected=8492.4us +- 42.5us, error 1.1% (kms_flip:2139) DEBUG: inconsistent flip ts/seq: last 110.329407/2132, current 110.337807/2133: elapsed=8399.0us expected=8492.4us (kms_flip:2139) DEBUG: name = flip last_ts = 110.337807 last_received_ts = 110.337593 last_seq = 2133 current_ts = 110.346199 current_received_ts = 110.346085 current_seq = 2134 count = 828 seq_step = 1 (kms_flip:2139) DEBUG: flip ts/seq: last 110.337807/2133, current 110.346199/2134: elapsed=8392.0us expected=8492.4us +- 42.5us, error 1.2% (kms_flip:2139) DEBUG: inconsistent flip ts/seq: last 110.337807/2133, current 110.346199/2134: elapsed=8392.0us expected=8492.4us (kms_flip:2139) DEBUG: name = flip last_ts = 110.346199 last_received_ts = 110.346085 last_seq = 2134 current_ts = 110.354591 current_received_ts = 110.354294 current_seq = 2135 count = 829 seq_step = 1 (kms_flip:2139) DEBUG: flip ts/seq: last 110.346199/2134, current 110.354591/2135: elapsed=8399.0us expected=8492.4us +- 42.5us, error 1.1% (kms_flip:2139) DEBUG: inconsistent flip ts/seq: last 110.346199/2134, current 110.354591/2135: elapsed=8399.0us expected=8492.4us (kms_flip:2139) DEBUG: name = flip last_ts = 110.354591 last_received_ts = 110.354294 last_seq = 2135 current_ts = 110.362991 current_received_ts = 110.362717 current_seq = 2136 count = 830 seq_step = 1 (kms_flip:2139) DEBUG: flip ts/seq: last 110.354591/2135, current 110.362991/2136: elapsed=8398.0us expected=8492.4us +- 42.5us, error 1.1% (kms_flip:2139) DEBUG: inconsistent flip ts/seq: last 110.354591/2135, current 110.362991/2136: elapsed=8398.0us expected=8492.4us (kms_flip:2139) DEBUG: name = flip last_ts = 110.362991 last_received_ts = 110.362717 last_seq = 2136 current_ts = 110.371384 current_received_ts = 110.371086 current_seq = 2137 count = 831 seq_step = 1 (kms_flip:2139) DEBUG: flip ts/seq: last 110.362991/2136, current 110.371384/2137: elapsed=8392.0us expected=8492.4us +- 42.5us, error 1.2% (kms_flip:2139) DEBUG: inconsistent flip ts/seq: last 110.362991/2136, current 110.371384/2137: elapsed=8392.0us expected=8492.4us (kms_flip:2139) DEBUG: name = flip last_ts = 110.371384 last_received_ts = 110.371086 last_seq = 2137 current_ts = 110.379784 current_received_ts = 110.379593 current_seq = 2138 count = 832 seq_step = 1 (kms_flip:2139) DEBUG: flip ts/seq: last 110.371384/2137, current 110.379784/2138: elapsed=8395.0us expected=8492.4us +- 42.5us, error 1.1% (kms_flip:2139) DEBUG: inconsistent flip ts/seq: last 110.371384/2137, current 110.379784/2138: elapsed=8395.0us expected=8492.4us (kms_flip:2139) DEBUG: name = flip last_ts = 110.379784 last_received_ts = 110.379593 last_seq = 2138 current_ts = 110.388184 current_received_ts = 110.387917 current_seq = 2139 count = 833 seq_step = 1 (kms_flip:2139) DEBUG: flip ts/seq: last 110.379784/2138, current 110.388184/2139: elapsed=8403.0us expected=8492.4us +- 42.5us, error 1.1% (kms_flip:2139) DEBUG: inconsistent flip ts/seq: last 110.379784/2138, current 110.388184/2139: elapsed=8403.0us expected=8492.4us (kms_flip:2139) DEBUG: name = flip last_ts = 110.388184 last_received_ts = 110.387917 last_seq = 2139 current_ts = 110.396576 current_received_ts = 110.396317 current_seq = 2140 count = 834 seq_step = 1 (kms_flip:2139) DEBUG: flip ts/seq: last 110.388184/2139, current 110.396576/2140: elapsed=8390.0us expected=8492.4us +- 42.5us, error 1.2% (kms_flip:2139) DEBUG: inconsistent flip ts/seq: last 110.388184/2139, current 110.396576/2140: elapsed=8390.0us expected=8492.4us (kms_flip:2139) DEBUG: name = flip last_ts = 110.396576 last_received_ts = 110.396317 last_seq = 2140 current_ts = 110.404968 current_received_ts = 110.404762 current_seq = 2141 count = 835 seq_step = 1 (kms_flip:2139) DEBUG: flip ts/seq: last 110.396576/2140, current 110.404968/2141: elapsed=8398.0us expected=8492.4us +- 42.5us, error 1.1% (kms_flip:2139) DEBUG: inconsistent flip ts/seq: last 110.396576/2140, current 110.404968/2141: elapsed=8398.0us expected=8492.4us (kms_flip:2139) DEBUG: name = flip last_ts = 110.404968 last_received_ts = 110.404762 last_seq = 2141 current_ts = 110.413376 current_received_ts = 110.413239 current_seq = 2142 count = 836 seq_step = 1 (kms_flip:2139) DEBUG: flip ts/seq: last 110.404968/2141, current 110.413376/2142: elapsed=8402.0us expected=8492.4us +- 42.5us, error 1.1% (kms_flip:2139) DEBUG: inconsistent flip ts/seq: last 110.404968/2141, current 110.413376/2142: elapsed=8402.0us expected=8492.4us (kms_flip:2139) DEBUG: name = flip last_ts = 110.413376 last_received_ts = 110.413239 last_seq = 2142 current_ts = 110.421768 current_received_ts = 110.421547 current_seq = 2143 count = 837 seq_step = 1 (kms_flip:2139) DEBUG: flip ts/seq: last 110.413376/2142, current 110.421768/2143: elapsed=8396.0us expected=8492.4us +- 42.5us, error 1.1% (kms_flip:2139) DEBUG: inconsistent flip ts/seq: last 110.413376/2142, current 110.421768/2143: elapsed=8396.0us expected=8492.4us (kms_flip:2139) DEBUG: name = flip last_ts = 110.421768 last_received_ts = 110.421547 last_seq = 2143 current_ts = 110.430161 current_received_ts = 110.429878 current_seq = 2144 count = 838 seq_step = 1 (kms_flip:2139) DEBUG: flip ts/seq: last 110.421768/2143, current 110.430161/2144: elapsed=8394.0us expected=8492.4us +- 42.5us, error 1.2% (kms_flip:2139) DEBUG: inconsistent flip ts/seq: last 110.421768/2143, current 110.430161/2144: elapsed=8394.0us expected=8492.4us (kms_flip:2139) DEBUG: name = flip last_ts = 110.430161 last_received_ts = 110.429878 last_seq = 2144 current_ts = 110.438553 current_received_ts = 110.438232 current_seq = 2145 count = 839 seq_step = 1 (kms_flip:2139) DEBUG: flip ts/seq: last 110.430161/2144, current 110.438553/2145: elapsed=8392.0us expected=8492.4us +- 42.5us, error 1.2% (kms_flip:2139) DEBUG: inconsistent flip ts/seq: last 110.430161/2144, current 110.438553/2145: elapsed=8392.0us expected=8492.4us (kms_flip:2139) DEBUG: name = flip last_ts = 110.438553 last_received_ts = 110.438232 last_seq = 2145 current_ts = 110.446960 current_received_ts = 110.446693 current_seq = 2146 count = 840 seq_step = 1 (kms_flip:2139) DEBUG: flip ts/seq: last 110.438553/2145, current 110.446960/2146: elapsed=8402.0us expected=8492.4us +- 42.5us, error 1.1% (kms_flip:2139) DEBUG: inconsistent flip ts/seq: last 110.438553/2145, current 110.446960/2146: elapsed=8402.0us expected=8492.4us (kms_flip:2139) DEBUG: name = flip last_ts = 110.446960 last_received_ts = 110.446693 last_seq = 2146 current_ts = 110.455353 current_received_ts = 110.455093 current_seq = 2147 count = 841 seq_step = 1 (kms_flip:2139) DEBUG: flip ts/seq: last 110.446960/2146, current 110.455353/2147: elapsed=8396.0us expected=8492.4us +- 42.5us, error 1.1% (kms_flip:2139) DEBUG: inconsistent flip ts/seq: last 110.446960/2146, current 110.455353/2147: elapsed=8396.0us expected=8492.4us (kms_flip:2139) DEBUG: name = flip last_ts = 110.455353 last_received_ts = 110.455093 last_seq = 2147 current_ts = 110.463753 current_received_ts = 110.463547 current_seq = 2148 count = 842 seq_step = 1 (kms_flip:2139) DEBUG: flip ts/seq: last 110.455353/2147, current 110.463753/2148: elapsed=8396.0us expected=8492.4us +- 42.5us, error 1.1% (kms_flip:2139) DEBUG: inconsistent flip ts/seq: last 110.455353/2147, current 110.463753/2148: elapsed=8396.0us expected=8492.4us (kms_flip:2139) DEBUG: name = flip last_ts = 110.463753 last_received_ts = 110.463547 last_seq = 2148 current_ts = 110.472145 current_received_ts = 110.471977 current_seq = 2149 count = 843 seq_step = 1 (kms_flip:2139) DEBUG: flip ts/seq: last 110.463753/2148, current 110.472145/2149: elapsed=8396.0us expected=8492.4us +- 42.5us, error 1.1% (kms_flip:2139) DEBUG: inconsistent flip ts/seq: last 110.463753/2148, current 110.472145/2149: elapsed=8396.0us expected=8492.4us (kms_flip:2139) DEBUG: name = flip last_ts = 110.472145 last_received_ts = 110.471977 last_seq = 2149 current_ts = 110.480537 current_received_ts = 110.480247 current_seq = 2150 count = 844 seq_step = 1 (kms_flip:2139) DEBUG: flip ts/seq: last 110.472145/2149, current 110.480537/2150: elapsed=8391.0us expected=8492.4us +- 42.5us, error 1.2% (kms_flip:2139) DEBUG: inconsistent flip ts/seq: last 110.472145/2149, current 110.480537/2150: elapsed=8391.0us expected=8492.4us (kms_flip:2139) DEBUG: name = flip last_ts = 110.480537 last_received_ts = 110.480247 last_seq = 2150 current_ts = 110.488937 current_received_ts = 110.488747 current_seq = 2151 count = 845 seq_step = 1 (kms_flip:2139) DEBUG: flip ts/seq: last 110.480537/2150, current 110.488937/2151: elapsed=8400.0us expected=8492.4us +- 42.5us, error 1.1% (kms_flip:2139) DEBUG: inconsistent flip ts/seq: last 110.480537/2150, current 110.488937/2151: elapsed=8400.0us expected=8492.4us (kms_flip:2139) DEBUG: name = flip last_ts = 110.488937 last_received_ts = 110.488747 last_seq = 2151 current_ts = 110.497337 current_received_ts = 110.497101 current_seq = 2152 count = 846 seq_step = 1 (kms_flip:2139) DEBUG: flip ts/seq: last 110.488937/2151, current 110.497337/2152: elapsed=8398.0us expected=8492.4us +- 42.5us, error 1.1% (kms_flip:2139) DEBUG: inconsistent flip ts/seq: last 110.488937/2151, current 110.497337/2152: elapsed=8398.0us expected=8492.4us (kms_flip:2139) DEBUG: name = flip last_ts = 110.497337 last_received_ts = 110.497101 last_seq = 2152 current_ts = 110.505730 current_received_ts = 110.505432 current_seq = 2153 count = 847 seq_step = 1 (kms_flip:2139) DEBUG: flip ts/seq: last 110.497337/2152, current 110.505730/2153: elapsed=8397.0us expected=8492.4us +- 42.5us, error 1.1% (kms_flip:2139) DEBUG: inconsistent flip ts/seq: last 110.497337/2152, current 110.505730/2153: elapsed=8397.0us expected=8492.4us (kms_flip:2139) DEBUG: name = flip last_ts = 110.505730 last_received_ts = 110.505432 last_seq = 2153 current_ts = 110.514130 current_received_ts = 110.513802 current_seq = 2154 count = 848 seq_step = 1 (kms_flip:2139) DEBUG: flip ts/seq: last 110.505730/2153, current 110.514130/2154: elapsed=8396.0us expected=8492.4us +- 42.5us, error 1.1% (kms_flip:2139) DEBUG: inconsistent flip ts/seq: last 110.505730/2153, current 110.514130/2154: elapsed=8396.0us expected=8492.4us (kms_flip:2139) DEBUG: name = flip last_ts = 110.514130 last_received_ts = 110.513802 last_seq = 2154 current_ts = 110.522522 current_received_ts = 110.522240 current_seq = 2155 count = 849 seq_step = 1 (kms_flip:2139) DEBUG: flip ts/seq: last 110.514130/2154, current 110.522522/2155: elapsed=8392.0us expected=8492.4us +- 42.5us, error 1.2% (kms_flip:2139) DEBUG: inconsistent flip ts/seq: last 110.514130/2154, current 110.522522/2155: elapsed=8392.0us expected=8492.4us (kms_flip:2139) DEBUG: name = flip last_ts = 110.522522 last_received_ts = 110.522240 last_seq = 2155 current_ts = 110.530914 current_received_ts = 110.530701 current_seq = 2156 count = 850 seq_step = 1 (kms_flip:2139) DEBUG: flip ts/seq: last 110.522522/2155, current 110.530914/2156: elapsed=8396.0us expected=8492.4us +- 42.5us, error 1.1% (kms_flip:2139) DEBUG: inconsistent flip ts/seq: last 110.522522/2155, current 110.530914/2156: elapsed=8396.0us expected=8492.4us (kms_flip:2139) DEBUG: name = flip last_ts = 110.530914 last_received_ts = 110.530701 last_seq = 2156 current_ts = 110.539314 current_received_ts = 110.539047 current_seq = 2157 count = 851 seq_step = 1 (kms_flip:2139) DEBUG: flip ts/seq: last 110.530914/2156, current 110.539314/2157: elapsed=8402.0us expected=8492.4us +- 42.5us, error 1.1% (kms_flip:2139) DEBUG: inconsistent flip ts/seq: last 110.530914/2156, current 110.539314/2157: elapsed=8402.0us expected=8492.4us (kms_flip:2139) DEBUG: name = flip last_ts = 110.539314 last_received_ts = 110.539047 last_seq = 2157 current_ts = 110.547714 current_received_ts = 110.547424 current_seq = 2158 count = 852 seq_step = 1 (kms_flip:2139) DEBUG: flip ts/seq: last 110.539314/2157, current 110.547714/2158: elapsed=8396.0us expected=8492.4us +- 42.5us, error 1.1% (kms_flip:2139) DEBUG: inconsistent flip ts/seq: last 110.539314/2157, current 110.547714/2158: elapsed=8396.0us expected=8492.4us (kms_flip:2139) DEBUG: name = flip last_ts = 110.547714 last_received_ts = 110.547424 last_seq = 2158 current_ts = 110.556107 current_received_ts = 110.555817 current_seq = 2159 count = 853 seq_step = 1 (kms_flip:2139) DEBUG: flip ts/seq: last 110.547714/2158, current 110.556107/2159: elapsed=8393.0us expected=8492.4us +- 42.5us, error 1.2% (kms_flip:2139) DEBUG: inconsistent flip ts/seq: last 110.547714/2158, current 110.556107/2159: elapsed=8393.0us expected=8492.4us (kms_flip:2139) DEBUG: name = flip last_ts = 110.556107 last_received_ts = 110.555817 last_seq = 2159 current_ts = 110.564499 current_received_ts = 110.564194 current_seq = 2160 count = 854 seq_step = 1 (kms_flip:2139) DEBUG: flip ts/seq: last 110.556107/2159, current 110.564499/2160: elapsed=8396.0us expected=8492.4us +- 42.5us, error 1.1% (kms_flip:2139) DEBUG: inconsistent flip ts/seq: last 110.556107/2159, current 110.564499/2160: elapsed=8396.0us expected=8492.4us (kms_flip:2139) DEBUG: name = flip last_ts = 110.564499 last_received_ts = 110.564194 last_seq = 2160 current_ts = 110.572899 current_received_ts = 110.572594 current_seq = 2161 count = 855 seq_step = 1 (kms_flip:2139) DEBUG: flip ts/seq: last 110.564499/2160, current 110.572899/2161: elapsed=8398.0us expected=8492.4us +- 42.5us, error 1.1% (kms_flip:2139) DEBUG: inconsistent flip ts/seq: last 110.564499/2160, current 110.572899/2161: elapsed=8398.0us expected=8492.4us (kms_flip:2139) DEBUG: name = flip last_ts = 110.572899 last_received_ts = 110.572594 last_seq = 2161 current_ts = 110.581299 current_received_ts = 110.581161 current_seq = 2162 count = 856 seq_step = 1 (kms_flip:2139) DEBUG: flip ts/seq: last 110.572899/2161, current 110.581299/2162: elapsed=8395.0us expected=8492.4us +- 42.5us, error 1.1% (kms_flip:2139) DEBUG: inconsistent flip ts/seq: last 110.572899/2161, current 110.581299/2162: elapsed=8395.0us expected=8492.4us (kms_flip:2139) DEBUG: name = flip last_ts = 110.581299 last_received_ts = 110.581161 last_seq = 2162 current_ts = 110.589691 current_received_ts = 110.589417 current_seq = 2163 count = 857 seq_step = 1 (kms_flip:2139) DEBUG: flip ts/seq: last 110.581299/2162, current 110.589691/2163: elapsed=8400.0us expected=8492.4us +- 42.5us, error 1.1% (kms_flip:2139) DEBUG: inconsistent flip ts/seq: last 110.581299/2162, current 110.589691/2163: elapsed=8400.0us expected=8492.4us (kms_flip:2139) DEBUG: name = flip last_ts = 110.589691 last_received_ts = 110.589417 last_seq = 2163 current_ts = 110.598091 current_received_ts = 110.597740 current_seq = 2164 count = 858 seq_step = 1 (kms_flip:2139) DEBUG: flip ts/seq: last 110.589691/2163, current 110.598091/2164: elapsed=8398.0us expected=8492.4us +- 42.5us, error 1.1% (kms_flip:2139) DEBUG: inconsistent flip ts/seq: last 110.589691/2163, current 110.598091/2164: elapsed=8398.0us expected=8492.4us (kms_flip:2139) DEBUG: name = flip last_ts = 110.598091 last_received_ts = 110.597740 last_seq = 2164 current_ts = 110.606491 current_received_ts = 110.606178 current_seq = 2165 count = 859 seq_step = 1 (kms_flip:2139) DEBUG: flip ts/seq: last 110.598091/2164, current 110.606491/2165: elapsed=8396.0us expected=8492.4us +- 42.5us, error 1.1% (kms_flip:2139) DEBUG: inconsistent flip ts/seq: last 110.598091/2164, current 110.606491/2165: elapsed=8396.0us expected=8492.4us (kms_flip:2139) DEBUG: name = flip last_ts = 110.606491 last_received_ts = 110.606178 last_seq = 2165 current_ts = 110.614883 current_received_ts = 110.614563 current_seq = 2166 count = 860 seq_step = 1 (kms_flip:2139) DEBUG: flip ts/seq: last 110.606491/2165, current 110.614883/2166: elapsed=8396.0us expected=8492.4us +- 42.5us, error 1.1% (kms_flip:2139) DEBUG: inconsistent flip ts/seq: last 110.606491/2165, current 110.614883/2166: elapsed=8396.0us expected=8492.4us (kms_flip:2139) DEBUG: name = flip last_ts = 110.614883 last_received_ts = 110.614563 last_seq = 2166 current_ts = 110.623276 current_received_ts = 110.623154 current_seq = 2167 count = 861 seq_step = 1 (kms_flip:2139) DEBUG: flip ts/seq: last 110.614883/2166, current 110.623276/2167: elapsed=8393.0us expected=8492.4us +- 42.5us, error 1.2% (kms_flip:2139) DEBUG: inconsistent flip ts/seq: last 110.614883/2166, current 110.623276/2167: elapsed=8393.0us expected=8492.4us (kms_flip:2139) DEBUG: name = flip last_ts = 110.623276 last_received_ts = 110.623154 last_seq = 2167 current_ts = 110.631676 current_received_ts = 110.631317 current_seq = 2168 count = 862 seq_step = 1 (kms_flip:2139) DEBUG: flip ts/seq: last 110.623276/2167, current 110.631676/2168: elapsed=8399.0us expected=8492.4us +- 42.5us, error 1.1% (kms_flip:2139) DEBUG: inconsistent flip ts/seq: last 110.623276/2167, current 110.631676/2168: elapsed=8399.0us expected=8492.4us (kms_flip:2139) DEBUG: name = flip last_ts = 110.631676 last_received_ts = 110.631317 last_seq = 2168 current_ts = 110.640076 current_received_ts = 110.639870 current_seq = 2169 count = 863 seq_step = 1 (kms_flip:2139) DEBUG: flip ts/seq: last 110.631676/2168, current 110.640076/2169: elapsed=8398.0us expected=8492.4us +- 42.5us, error 1.1% (kms_flip:2139) DEBUG: inconsistent flip ts/seq: last 110.631676/2168, current 110.640076/2169: elapsed=8398.0us expected=8492.4us (kms_flip:2139) DEBUG: name = flip last_ts = 110.640076 last_received_ts = 110.639870 last_seq = 2169 current_ts = 110.648468 current_received_ts = 110.648193 current_seq = 2170 count = 864 seq_step = 1 (kms_flip:2139) DEBUG: flip ts/seq: last 110.640076/2169, current 110.648468/2170: elapsed=8394.0us expected=8492.4us +- 42.5us, error 1.2% (kms_flip:2139) DEBUG: inconsistent flip ts/seq: last 110.640076/2169, current 110.648468/2170: elapsed=8394.0us expected=8492.4us (kms_flip:2139) DEBUG: name = flip last_ts = 110.648468 last_received_ts = 110.648193 last_seq = 2170 current_ts = 110.656860 current_received_ts = 110.656670 current_seq = 2171 count = 865 seq_step = 1 (kms_flip:2139) DEBUG: flip ts/seq: last 110.648468/2170, current 110.656860/2171: elapsed=8395.0us expected=8492.4us +- 42.5us, error 1.1% (kms_flip:2139) DEBUG: inconsistent flip ts/seq: last 110.648468/2170, current 110.656860/2171: elapsed=8395.0us expected=8492.4us (kms_flip:2139) DEBUG: name = flip last_ts = 110.656860 last_received_ts = 110.656670 last_seq = 2171 current_ts = 110.665260 current_received_ts = 110.665138 current_seq = 2172 count = 866 seq_step = 1 (kms_flip:2139) DEBUG: flip ts/seq: last 110.656860/2171, current 110.665260/2172: elapsed=8395.0us expected=8492.4us +- 42.5us, error 1.1% (kms_flip:2139) DEBUG: inconsistent flip ts/seq: last 110.656860/2171, current 110.665260/2172: elapsed=8395.0us expected=8492.4us (kms_flip:2139) DEBUG: name = flip last_ts = 110.665260 last_received_ts = 110.665138 last_seq = 2172 current_ts = 110.673660 current_received_ts = 110.673302 current_seq = 2173 count = 867 seq_step = 1 (kms_flip:2139) DEBUG: flip ts/seq: last 110.665260/2172, current 110.673660/2173: elapsed=8401.0us expected=8492.4us +- 42.5us, error 1.1% (kms_flip:2139) DEBUG: inconsistent flip ts/seq: last 110.665260/2172, current 110.673660/2173: elapsed=8401.0us expected=8492.4us (kms_flip:2139) DEBUG: name = flip last_ts = 110.673660 last_received_ts = 110.673302 last_seq = 2173 current_ts = 110.682053 current_received_ts = 110.681839 current_seq = 2174 count = 868 seq_step = 1 (kms_flip:2139) DEBUG: flip ts/seq: last 110.673660/2173, current 110.682053/2174: elapsed=8389.0us expected=8492.4us +- 42.5us, error 1.2% (kms_flip:2139) DEBUG: inconsistent flip ts/seq: last 110.673660/2173, current 110.682053/2174: elapsed=8389.0us expected=8492.4us (kms_flip:2139) DEBUG: name = flip last_ts = 110.682053 last_received_ts = 110.681839 last_seq = 2174 current_ts = 110.690437 current_received_ts = 110.690163 current_seq = 2175 count = 869 seq_step = 1 (kms_flip:2139) DEBUG: flip ts/seq: last 110.682053/2174, current 110.690437/2175: elapsed=8388.0us expected=8492.4us +- 42.5us, error 1.2% (kms_flip:2139) DEBUG: inconsistent flip ts/seq: last 110.682053/2174, current 110.690437/2175: elapsed=8388.0us expected=8492.4us (kms_flip:2139) DEBUG: name = flip last_ts = 110.690437 last_received_ts = 110.690163 last_seq = 2175 current_ts = 110.698830 current_received_ts = 110.698547 current_seq = 2176 count = 870 seq_step = 1 (kms_flip:2139) DEBUG: flip ts/seq: last 110.690437/2175, current 110.698830/2176: elapsed=8393.0us expected=8492.4us +- 42.5us, error 1.2% (kms_flip:2139) DEBUG: inconsistent flip ts/seq: last 110.690437/2175, current 110.698830/2176: elapsed=8393.0us expected=8492.4us (kms_flip:2139) DEBUG: name = flip last_ts = 110.698830 last_received_ts = 110.698547 last_seq = 2176 current_ts = 110.707214 current_received_ts = 110.707100 current_seq = 2177 count = 871 seq_step = 1 (kms_flip:2139) DEBUG: flip ts/seq: last 110.698830/2176, current 110.707214/2177: elapsed=8388.0us expected=8492.4us +- 42.5us, error 1.2% (kms_flip:2139) DEBUG: inconsistent flip ts/seq: last 110.698830/2176, current 110.707214/2177: elapsed=8388.0us expected=8492.4us (kms_flip:2139) DEBUG: name = flip last_ts = 110.707214 last_received_ts = 110.707100 last_seq = 2177 current_ts = 110.715607 current_received_ts = 110.715324 current_seq = 2178 count = 872 seq_step = 1 (kms_flip:2139) DEBUG: flip ts/seq: last 110.707214/2177, current 110.715607/2178: elapsed=8385.0us expected=8492.4us +- 42.5us, error 1.3% (kms_flip:2139) DEBUG: inconsistent flip ts/seq: last 110.707214/2177, current 110.715607/2178: elapsed=8385.0us expected=8492.4us (kms_flip:2139) DEBUG: name = flip last_ts = 110.715607 last_received_ts = 110.715324 last_seq = 2178 current_ts = 110.723991 current_received_ts = 110.723816 current_seq = 2179 count = 873 seq_step = 1 (kms_flip:2139) DEBUG: flip ts/seq: last 110.715607/2178, current 110.723991/2179: elapsed=8391.0us expected=8492.4us +- 42.5us, error 1.2% (kms_flip:2139) DEBUG: inconsistent flip ts/seq: last 110.715607/2178, current 110.723991/2179: elapsed=8391.0us expected=8492.4us (kms_flip:2139) DEBUG: name = flip last_ts = 110.723991 last_received_ts = 110.723816 last_seq = 2179 current_ts = 110.732384 current_received_ts = 110.732063 current_seq = 2180 count = 874 seq_step = 1 (kms_flip:2139) DEBUG: flip ts/seq: last 110.723991/2179, current 110.732384/2180: elapsed=8390.0us expected=8492.4us +- 42.5us, error 1.2% (kms_flip:2139) DEBUG: inconsistent flip ts/seq: last 110.723991/2179, current 110.732384/2180: elapsed=8390.0us expected=8492.4us (kms_flip:2139) DEBUG: name = flip last_ts = 110.732384 last_received_ts = 110.732063 last_seq = 2180 current_ts = 110.740768 current_received_ts = 110.740570 current_seq = 2181 count = 875 seq_step = 1 (kms_flip:2139) DEBUG: flip ts/seq: last 110.732384/2180, current 110.740768/2181: elapsed=8388.0us expected=8492.4us +- 42.5us, error 1.2% (kms_flip:2139) DEBUG: inconsistent flip ts/seq: last 110.732384/2180, current 110.740768/2181: elapsed=8388.0us expected=8492.4us (kms_flip:2139) DEBUG: name = flip last_ts = 110.740768 last_received_ts = 110.740570 last_seq = 2181 current_ts = 110.749161 current_received_ts = 110.748970 current_seq = 2182 count = 876 seq_step = 1 (kms_flip:2139) DEBUG: flip ts/seq: last 110.740768/2181, current 110.749161/2182: elapsed=8386.0us expected=8492.4us +- 42.5us, error 1.3% (kms_flip:2139) DEBUG: inconsistent flip ts/seq: last 110.740768/2181, current 110.749161/2182: elapsed=8386.0us expected=8492.4us (kms_flip:2139) DEBUG: name = flip last_ts = 110.749161 last_received_ts = 110.748970 last_seq = 2182 current_ts = 110.757553 current_received_ts = 110.757271 current_seq = 2183 count = 877 seq_step = 1 (kms_flip:2139) DEBUG: flip ts/seq: last 110.749161/2182, current 110.757553/2183: elapsed=8392.0us expected=8492.4us +- 42.5us, error 1.2% (kms_flip:2139) DEBUG: inconsistent flip ts/seq: last 110.749161/2182, current 110.757553/2183: elapsed=8392.0us expected=8492.4us (kms_flip:2139) DEBUG: name = flip last_ts = 110.757553 last_received_ts = 110.757271 last_seq = 2183 current_ts = 110.765938 current_received_ts = 110.765640 current_seq = 2184 count = 878 seq_step = 1 (kms_flip:2139) DEBUG: flip ts/seq: last 110.757553/2183, current 110.765938/2184: elapsed=8389.0us expected=8492.4us +- 42.5us, error 1.2% (kms_flip:2139) DEBUG: inconsistent flip ts/seq: last 110.757553/2183, current 110.765938/2184: elapsed=8389.0us expected=8492.4us (kms_flip:2139) DEBUG: name = flip last_ts = 110.765938 last_received_ts = 110.765640 last_seq = 2184 current_ts = 110.774323 current_received_ts = 110.774162 current_seq = 2185 count = 879 seq_step = 1 (kms_flip:2139) DEBUG: flip ts/seq: last 110.765938/2184, current 110.774323/2185: elapsed=8384.0us expected=8492.4us +- 42.5us, error 1.3% (kms_flip:2139) DEBUG: inconsistent flip ts/seq: last 110.765938/2184, current 110.774323/2185: elapsed=8384.0us expected=8492.4us (kms_flip:2139) DEBUG: name = flip last_ts = 110.774323 last_received_ts = 110.774162 last_seq = 2185 current_ts = 110.782715 current_received_ts = 110.782394 current_seq = 2186 count = 880 seq_step = 1 (kms_flip:2139) DEBUG: flip ts/seq: last 110.774323/2185, current 110.782715/2186: elapsed=8394.0us expected=8492.4us +- 42.5us, error 1.2% (kms_flip:2139) DEBUG: inconsistent flip ts/seq: last 110.774323/2185, current 110.782715/2186: elapsed=8394.0us expected=8492.4us (kms_flip:2139) DEBUG: name = flip last_ts = 110.782715 last_received_ts = 110.782394 last_seq = 2186 current_ts = 110.791107 current_received_ts = 110.790939 current_seq = 2187 count = 881 seq_step = 1 (kms_flip:2139) DEBUG: flip ts/seq: last 110.782715/2186, current 110.791107/2187: elapsed=8387.0us expected=8492.4us +- 42.5us, error 1.2% (kms_flip:2139) DEBUG: inconsistent flip ts/seq: last 110.782715/2186, current 110.791107/2187: elapsed=8387.0us expected=8492.4us (kms_flip:2139) DEBUG: name = flip last_ts = 110.791107 last_received_ts = 110.790939 last_seq = 2187 current_ts = 110.799492 current_received_ts = 110.799248 current_seq = 2188 count = 882 seq_step = 1 (kms_flip:2139) DEBUG: flip ts/seq: last 110.791107/2187, current 110.799492/2188: elapsed=8387.0us expected=8492.4us +- 42.5us, error 1.2% (kms_flip:2139) DEBUG: inconsistent flip ts/seq: last 110.791107/2187, current 110.799492/2188: elapsed=8387.0us expected=8492.4us (kms_flip:2139) DEBUG: name = flip last_ts = 110.799492 last_received_ts = 110.799248 last_seq = 2188 current_ts = 110.807877 current_received_ts = 110.807686 current_seq = 2189 count = 883 seq_step = 1 (kms_flip:2139) DEBUG: flip ts/seq: last 110.799492/2188, current 110.807877/2189: elapsed=8387.0us expected=8492.4us +- 42.5us, error 1.2% (kms_flip:2139) DEBUG: inconsistent flip ts/seq: last 110.799492/2188, current 110.807877/2189: elapsed=8387.0us expected=8492.4us (kms_flip:2139) DEBUG: name = flip last_ts = 110.807877 last_received_ts = 110.807686 last_seq = 2189 current_ts = 110.816269 current_received_ts = 110.815964 current_seq = 2190 count = 884 seq_step = 1 (kms_flip:2139) DEBUG: flip ts/seq: last 110.807877/2189, current 110.816269/2190: elapsed=8390.0us expected=8492.4us +- 42.5us, error 1.2% (kms_flip:2139) DEBUG: inconsistent flip ts/seq: last 110.807877/2189, current 110.816269/2190: elapsed=8390.0us expected=8492.4us (kms_flip:2139) DEBUG: name = flip last_ts = 110.816269 last_received_ts = 110.815964 last_seq = 2190 current_ts = 110.824654 current_received_ts = 110.824348 current_seq = 2191 count = 885 seq_step = 1 (kms_flip:2139) DEBUG: flip ts/seq: last 110.816269/2190, current 110.824654/2191: elapsed=8388.0us expected=8492.4us +- 42.5us, error 1.2% (kms_flip:2139) DEBUG: inconsistent flip ts/seq: last 110.816269/2190, current 110.824654/2191: elapsed=8388.0us expected=8492.4us (kms_flip:2139) DEBUG: name = flip last_ts = 110.824654 last_received_ts = 110.824348 last_seq = 2191 current_ts = 110.833046 current_received_ts = 110.832863 current_seq = 2192 count = 886 seq_step = 1 (kms_flip:2139) DEBUG: flip ts/seq: last 110.824654/2191, current 110.833046/2192: elapsed=8390.0us expected=8492.4us +- 42.5us, error 1.2% (kms_flip:2139) DEBUG: inconsistent flip ts/seq: last 110.824654/2191, current 110.833046/2192: elapsed=8390.0us expected=8492.4us (kms_flip:2139) DEBUG: name = flip last_ts = 110.833046 last_received_ts = 110.832863 last_seq = 2192 current_ts = 110.841431 current_received_ts = 110.841187 current_seq = 2193 count = 887 seq_step = 1 (kms_flip:2139) DEBUG: flip ts/seq: last 110.833046/2192, current 110.841431/2193: elapsed=8388.0us expected=8492.4us +- 42.5us, error 1.2% (kms_flip:2139) DEBUG: inconsistent flip ts/seq: last 110.833046/2192, current 110.841431/2193: elapsed=8388.0us expected=8492.4us (kms_flip:2139) DEBUG: name = flip last_ts = 110.841431 last_received_ts = 110.841187 last_seq = 2193 current_ts = 110.849831 current_received_ts = 110.849571 current_seq = 2194 count = 888 seq_step = 1 (kms_flip:2139) DEBUG: flip ts/seq: last 110.841431/2193, current 110.849831/2194: elapsed=8393.0us expected=8492.4us +- 42.5us, error 1.2% (kms_flip:2139) DEBUG: inconsistent flip ts/seq: last 110.841431/2193, current 110.849831/2194: elapsed=8393.0us expected=8492.4us (kms_flip:2139) DEBUG: name = flip last_ts = 110.849831 last_received_ts = 110.849571 last_seq = 2194 current_ts = 110.858215 current_received_ts = 110.858055 current_seq = 2195 count = 889 seq_step = 1 (kms_flip:2139) DEBUG: flip ts/seq: last 110.849831/2194, current 110.858215/2195: elapsed=8385.0us expected=8492.4us +- 42.5us, error 1.3% (kms_flip:2139) DEBUG: inconsistent flip ts/seq: last 110.849831/2194, current 110.858215/2195: elapsed=8385.0us expected=8492.4us (kms_flip:2139) INFO: Event flip: expected 883, counted 890, passrate = 30.56%, encoder type 2 (kms_flip:2139) DEBUG: dropped frames, expected 883, counted 890, passrate = 30.56%, encoder type 2 (kms_flip:2139) CRITICAL: Test assertion failure function __run_test_on_crtc_set, file ../tests/kms_flip.c:1722: (kms_flip:2139) CRITICAL: Failed assertion: !retried (kms_flip:2139) igt_core-INFO: Stack trace: (kms_flip:2139) igt_core-INFO: #0 ../lib/igt_core.c:2075 __igt_fail_assert() (kms_flip:2139) igt_core-INFO: #1 ../tests/kms_flip.c:1071 run_test_on_crtc_set() (kms_flip:2139) igt_core-INFO: #2 ../tests/kms_flip.c:1920 run_test() (kms_flip:2139) igt_core-INFO: #3 ../tests/kms_flip.c:2184 __igt_unique____real_main2105() (kms_flip:2139) igt_core-INFO: #4 ../tests/kms_flip.c:2105 main() (kms_flip:2139) igt_core-INFO: #5 [__libc_init_first+0x8a] (kms_flip:2139) igt_core-INFO: #6 [__libc_start_main+0x8b] (kms_flip:2139) igt_core-INFO: #7 [_start+0x25] **** END **** Dynamic subtest D-HDMI-A1: FAIL (18.562s) Subtest plain-flip-ts-check: FAIL (42.069s) (kms_flip:2139) igt_kms-CRITICAL: Test assertion failure function kmstest_set_connector_dpms, file ../lib/igt_kms.c:2352: (kms_flip:2139) igt_kms-CRITICAL: Failed assertion: found_it (kms_flip:2139) igt_kms-CRITICAL: Last errno: 9, Bad file descriptor (kms_flip:2139) igt_kms-CRITICAL: DPMS property not found on 588 |
| Dmesg |
<6> [92.295296] [IGT] kms_flip: starting dynamic subtest D-HDMI-A1
<7> [92.296153] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:637]
<7> [92.296576] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:638]
<7> [92.336430] i915 0000:00:02.0: [drm:drm_mode_setcrtc] [CRTC:171:pipe A]
<7> [92.336749] i915 0000:00:02.0: [drm:drm_mode_setcrtc] [CRTC:309:pipe B]
<7> [92.336970] i915 0000:00:02.0: [drm:drm_mode_setcrtc] [CRTC:447:pipe C]
<7> [92.337114] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:447:pipe C] fastset requirement not met in hw.enable (expected yes, found no)
<7> [92.337521] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:447:pipe C] fastset requirement not met in hw.active (expected yes, found no)
<7> [92.337875] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:447:pipe C] fastset requirement not met in cpu_transcoder (expected 2, found -1)
<7> [92.338239] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:447:pipe C] fastset requirement not met in lane_count (expected 4, found 0)
<7> [92.338645] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:447:pipe C] fastset requirement not met in output_types (expected 0x00000040, found 0x00000000)
<7> [92.339014] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:447:pipe C] fastset requirement not met in framestart_delay (expected 1, found 0)
<7> [92.339402] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:447:pipe C] fastset requirement not met in hw.pipe_mode.crtc_hdisplay (expected 1920, found 0)
<7> [92.339924] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:447:pipe C] fastset requirement not met in hw.pipe_mode.crtc_htotal (expected 2080, found 0)
<7> [92.340245] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:447:pipe C] fastset requirement not met in hw.pipe_mode.crtc_hblank_start (expected 1920, found 0)
<7> [92.340596] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:447:pipe C] fastset requirement not met in hw.pipe_mode.crtc_hblank_end (expected 2080, found 0)
<7> [92.340916] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:447:pipe C] fastset requirement not met in hw.pipe_mode.crtc_hsync_start (expected 1968, found 0)
<7> [92.341235] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:447:pipe C] fastset requirement not met in hw.pipe_mode.crtc_hsync_end (expected 2000, found 0)
<7> [92.341593] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:447:pipe C] fastset requirement not met in hw.pipe_mode.crtc_vdisplay (expected 1080, found 0)
<7> [92.341921] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:447:pipe C] fastset requirement not met in hw.pipe_mode.crtc_vblank_start (expected 1080, found 0)
<7> [92.342242] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:447:pipe C] fastset requirement not met in hw.pipe_mode.crtc_vsync_start (expected 1083, found 0)
<7> [92.342614] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:447:pipe C] fastset requirement not met in hw.pipe_mode.crtc_vsync_end (expected 1088, found 0)
<7> [92.342879] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:447:pipe C] fastset requirement not met in hw.pipe_mode.crtc_vtotal (expected 1144, found 0)
<7> [92.343141] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:447:pipe C] fastset requirement not met in hw.pipe_mode.crtc_vblank_end (expected 1144, found 0)
<7> [92.343416] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:447:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_hdisplay (expected 1920, found 0)
<7> [92.343673] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:447:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_htotal (expected 2080, found 0)
<7> [92.343927] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:447:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_hblank_start (expected 1920, found 0)
<7> [92.344182] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:447:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_hblank_end (expected 2080, found 0)
<7> [92.344453] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:447:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_hsync_start (expected 1968, found 0)
<7> [92.344706] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:447:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_hsync_end (expected 2000, found 0)
<7> [92.344957] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:447:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_vdisplay (expected 1080, found 0)
<7> [92.345213] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:447:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_vblank_start (expected 1080, found 0)
<7> [92.345491] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:447:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_vsync_start (expected 1083, found 0)
<7> [92.345752] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:447:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_vsync_end (expected 1088, found 0)
<7> [92.345949] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:447:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_vtotal (expected 1144, found 0)
<7> [92.346138] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:447:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_vblank_end (expected 1144, found 0)
<7> [92.346339] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:447:pipe C] fastset requirement not met in pixel_multiplier (expected 1, found 0)
<7> [92.346529] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:447:pipe C] fastset requirement not met in hw.adjusted_mode.flags (1) (expected 1, found 0)
<7> [92.346717] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:447:pipe C] fastset requirement not met in hw.adjusted_mode.flags (4) (expected 4, found 0)
<7> [92.346906] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:447:pipe C] fastset requirement not met in has_hdmi_sink (expected yes, found no)
<7> [92.347095] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:447:pipe C] fastset requirement not met in has_infoframe (expected yes, found no)
<7> [92.347294] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:447:pipe C] fastset requirement not met in pipe_bpp (expected 24, found 0)
<7> [92.347489] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:447:pipe C] fastset requirement not met in hw.pipe_mode.crtc_clock (expected 285500, found 0)
<7> [92.347681] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:447:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_clock (expected 285500, found 0)
<7> [92.347872] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:447:pipe C] fastset requirement not met in port_clock (expected 285500, found 0)
<7> [92.348062] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:447:pipe C] fastset requirement not met in infoframes.enable (expected 0x00000071, found 0x00000000)
<7> [92.348261] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:447:pipe C] fastset requirement not met in avi infoframe
<7> [92.348454] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] expected:
<7> [92.348642] i915 0000:00:02.0: HDMI infoframe: Auxiliary Video Information (AVI), version 2, length 13
<7> [92.348644] i915 0000:00:02.0: colorspace: RGB
<7> [92.348646] i915 0000:00:02.0: scan mode: Underscan
<7> [92.348647] i915 0000:00:02.0: colorimetry: No Data
<7> [92.348649] i915 0000:00:02.0: picture aspect: No Data
<7> [92.348650] i915 0000:00:02.0: active aspect: Same as Picture
<7> [92.348651] i915 0000:00:02.0: itc: No Data
<7> [92.348653] i915 0000:00:02.0: extended colorimetry: xvYCC 601
<7> [92.348654] i915 0000:00:02.0: quantization range: Full
<7> [92.348655] i915 0000:00:02.0: nups: Unknown Non-uniform Scaling
<7> [92.348657] i915 0000:00:02.0: video code: 0
<7> [92.348658] i915 0000:00:02.0: ycc quantization range: Full
<7> [92.348660] i915 0000:00:02.0: hdmi content type: Graphics
<7> [92.348661] i915 0000:00:02.0: pixel repeat: 0
<7> [92.348663] i915 0000:00:02.0: bar top 0, bottom 0, left 0, right 0
<7> [92.348664] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] found:
<7> [92.348823] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:447:pipe C] fastset requirement not met in spd infoframe
<7> [92.348982] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] expected:
<7> [92.349143] i915 0000:00:02.0: HDMI infoframe: Source Product Description (SPD), version 1, length 25
<7> [92.349145] i915 0000:00:02.0: vendor: Intel
<7> [92.349146] i915 0000:00:02.0: product: Integrated gfx
<7> [92.349147] i915 0000:00:02.0: source device information: PC General (0x9)
<7> [92.349149] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] found:
<7> [92.349327] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:447:pipe C] fastset requirement not met in hdmi infoframe
<7> [92.349494] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] expected:
<7> [92.349655] i915 0000:00:02.0: HDMI infoframe: Vendor, version 1, length 4
<7> [92.349656] i915 0000:00:02.0: empty frame
<7> [92.349658] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] found:
<7> [92.349821] i915 0000:00:02.0: [drm:intel_atomic_check [i915]] [CRTC:447:pipe C] fastset requirement not met, forcing full modeset
<7> [92.349984] i915 0000:00:02.0: [drm:intel_dpll_crtc_put [i915]] [CRTC:447:pipe C] releasing DPLL 0
<7> [92.350172] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] Enabled dbuf slices 0x3 -> 0x1 (total dbuf slices 0x3), mbus joined? no->no
<7> [92.350344] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] [CRTC:447:pipe C] dbuf slices 0x3 -> 0x0, ddb (0 - 2048) -> (0 - 0), active pipes 0x4 -> 0x0
<7> [92.350539] i915 0000:00:02.0: [drm:skl_print_plane_ddb_changes [i915]] [PLANE:441:cursor C] ddb (1993 - 2048) -> ( 0 - 0), size 55 -> 0
<7> [92.350716] i915 0000:00:02.0: [drm:intel_cdclk_atomic_check [i915]] [CRTC:447:pipe C] min cdclk: 192000 kHz -> 0 kHz
<7> [92.350904] i915 0000:00:02.0: [drm:intel_cdclk_atomic_check [i915]] Modeset required for cdclk change
<7> [92.351065] i915 0000:00:02.0: [drm:intel_cdclk_atomic_check [i915]] New cdclk calculated to be logical 172800 kHz, actual 172800 kHz
<7> [92.351228] i915 0000:00:02.0: [drm:intel_cdclk_atomic_check [i915]] New voltage level calculated to be logical 0, actual 0
<7> [92.351410] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [CRTC:447:pipe C] enable: no [modeset]
<7> [92.351577] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:311:plane 1C] fb: [NOFB], visible: no
<7> [92.351739] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:341:plane 2C] fb: [NOFB], visible: no
<7> [92.351901] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:371:plane 3C] fb: [NOFB], visible: no
<7> [92.352063] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:401:plane 4C] fb: [NOFB], visible: no
<7> [92.352224] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:411:plane 5C] fb: [NOFB], visible: no
<7> [92.352399] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:421:plane 6C] fb: [NOFB], visible: no
<7> [92.352561] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:431:plane 7C] fb: [NOFB], visible: no
<7> [92.352720] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:441:cursor C] fb: [NOFB], visible: no
<7> [92.352955] i915 0000:00:02.0: [drm:intel_audio_codec_disable [i915]] [CONNECTOR:588:HDMI-A-1][ENCODER:587:DDI B/PHY B] Disable audio codec on [CRTC:447:pipe C]
<7> [92.368364] i915 0000:00:02.0: [drm:intel_audio_component_get_eld [i915]] Not valid for port B
<7> [92.373274] i915 0000:00:02.0: [drm:intel_hdmi_handle_sink_scrambling [i915]] [CONNECTOR:588:HDMI-A-1] scrambling=no, TMDS bit clock ratio=1/10
<7> [92.373843] i915 0000:00:02.0: [drm:do_gmbus_xfer [i915]] GMBUS [i915 gmbus dpb] NAK for addr: 0054 w(1)
<7> [92.373995] i915 0000:00:02.0: [drm:do_gmbus_xfer [i915]] GMBUS [i915 gmbus dpb] NAK on first message, retry
<7> [92.374539] i915 0000:00:02.0: [drm:do_gmbus_xfer [i915]] GMBUS [i915 gmbus dpb] NAK for addr: 0054 w(1)
<7> [92.374765] i915 0000:00:02.0: [drm:drm_scdc_set_high_tmds_clock_ratio [drm_display_helper]] [CONNECTOR:588:HDMI-A-1] Failed to read TMDS config: -6
<7> [92.374782] i915 0000:00:02.0: [drm:intel_ddi_disable [i915]] [CONNECTOR:588:HDMI-A-1] Failed to reset sink scrambling/TMDS bit clock ratio
<7> [92.374958] i915 0000:00:02.0: [drm:intel_disable_transcoder [i915]] disabling pipe C
<7> [92.376615] i915 0000:00:02.0: [drm:intel_power_well_disable [i915]] disabling DDI_IO_B
<7> [92.376806] i915 0000:00:02.0: [drm:intel_dpll_disable [i915]] disable DPLL 0 (active 0x4, on? 1) for [CRTC:447:pipe C]
<7> [92.376998] i915 0000:00:02.0: [drm:intel_dpll_disable [i915]] disabling DPLL 0
<7> [92.377177] i915 0000:00:02.0: [drm:intel_set_cdclk [i915]] Pre changing CDCLK to 172800 kHz, VCO 345600 kHz, ref 38400 kHz, bypass 19200 kHz, voltage level 0
<7> [92.377499] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:587:DDI B/PHY B]
<7> [92.377696] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:597:DDI TC1/PHY TC1]
<7> [92.377866] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:599:DP-MST A]
<7> [92.378046] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:600:DP-MST B]
<7> [92.378277] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:601:DP-MST C]
<7> [92.378502] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:602:DP-MST D]
<7> [92.378733] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:607:DDI TC2/PHY TC2]
<7> [92.378961] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:609:DP-MST A]
<7> [92.379194] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:610:DP-MST B]
<7> [92.379445] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:611:DP-MST C]
<7> [92.379663] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:612:DP-MST D]
<7> [92.379876] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:616:DDI TC3/PHY TC3]
<7> [92.380099] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:618:DP-MST A]
<7> [92.380337] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:619:DP-MST B]
<7> [92.380616] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:620:DP-MST C]
<7> [92.380785] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:621:DP-MST D]
<7> [92.380981] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:625:DDI TC4/PHY TC4]
<7> [92.381190] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:627:DP-MST A]
<7> [92.381373] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:628:DP-MST B]
<7> [92.381532] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:629:DP-MST C]
<7> [92.381690] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:630:DP-MST D]
<7> [92.381882] i915 0000:00:02.0: [drm:verify_connector_state [i915]] [CONNECTOR:588:HDMI-A-1]
<7> [92.382263] i915 0000:00:02.0: [drm:gen9_dbuf_slices_update [i915]] Updating dbuf slices to 0x1
<7> [92.382476] i915 0000:00:02.0: [drm:intel_power_well_disable [i915]] disabling PW_4
<7> [92.382671] i915 0000:00:02.0: [drm:intel_power_well_disable [i915]] disabling PW_3
<7> [92.382913] i915 0000:00:02.0: [drm:intel_power_well_disable [i915]] disabling PW_2
<7> [92.383111] i915 0000:00:02.0: [drm:intel_modeset_verify_crtc [i915]] [CRTC:447:pipe C]
<7> [92.383555] i915 0000:00:02.0: [drm:drm_mode_setcrtc] [CRTC:585:pipe D]
<7> [92.383842] i915 0000:00:02.0: [drm:drm_mode_setcrtc] [CRTC:585:pipe D]
<7> [92.383874] i915 0000:00:02.0: [drm:drm_mode_setcrtc] [CONNECTOR:588:HDMI-A-1]
<7> [92.383945] i915 0000:00:02.0: [drm:compute_baseline_pipe_bpp [i915]] [CONNECTOR:588:HDMI-A-1] Limiting target display pipe bpp to 24 (EDID bpp 24, max requested bpp 36, max platform bpp 36)
<7> [92.384125] i915 0000:00:02.0: [drm:intel_hdmi_compute_output_format [i915]] picking 8 bpc for HDMI output (pipe bpp: 24)
<7> [92.384344] i915 0000:00:02.0: [drm:intel_atomic_check [i915]] [CRTC:585:pipe D] hw max bpp: 24, pipe bpp: 24, dithering: 0
<7> [92.384511] i915 0000:00:02.0: [drm:intel_ddi_compute_config_late [i915]] [ENCODER:587:DDI B/PHY B] [CRTC:585:pipe D]
<7> [92.384667] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:585:pipe D] fastset requirement not met in hw.enable (expected no, found yes)
<7> [92.384835] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:585:pipe D] fastset requirement not met in hw.active (expected no, found yes)
<7> [92.385000] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:585:pipe D] fastset requirement not met in cpu_transcoder (expected -1, found 3)
<7> [92.385163] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:585:pipe D] fastset requirement not met in lane_count (expected 0, found 4)
<7> [92.385340] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:585:pipe D] fastset requirement not met in output_types (expected 0x00000000, found 0x00000040)
<7> [92.385501] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:585:pipe D] fastset requirement not met in framestart_delay (expected 0, found 1)
<7> [92.385661] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:585:pipe D] fastset requirement not met in hw.pipe_mode.crtc_hdisplay (expected 0, found 1920)
<7> [92.385820] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:585:pipe D] fastset requirement not met in hw.pipe_mode.crtc_htotal (expected 0, found 2080)
<7> [92.385979] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:585:pipe D] fastset requirement not met in hw.pipe_mode.crtc_hblank_start (expected 0, found 1920)
<7> [92.386138] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:585:pipe D] fastset requirement not met in hw.pipe_mode.crtc_hblank_end (expected 0, found 2080)
<7> [92.386308] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:585:pipe D] fastset requirement not met in hw.pipe_mode.crtc_hsync_start (expected 0, found 1968)
<7> [92.386467] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:585:pipe D] fastset requirement not met in hw.pipe_mode.crtc_hsync_end (expected 0, found 2000)
<7> [92.386625] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:585:pipe D] fastset requirement not met in hw.pipe_mode.crtc_vdisplay (expected 0, found 1080)
<7> [92.386783] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:585:pipe D] fastset requirement not met in hw.pipe_mode.crtc_vblank_start (expected 0, found 1080)
<7> [92.386941] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:585:pipe D] fastset requirement not met in hw.pipe_mode.crtc_vsync_start (expected 0, found 1083)
<7> [92.387098] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:585:pipe D] fastset requirement not met in hw.pipe_mode.crtc_vsync_end (expected 0, found 1088)
<7> [92.387265] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:585:pipe D] fastset requirement not met in hw.pipe_mode.crtc_vtotal (expected 0, found 1144)
<7> [92.387427] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:585:pipe D] fastset requirement not met in hw.pipe_mode.crtc_vblank_end (expected 0, found 1144)
<7> [92.387590] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:585:pipe D] fastset requirement not met in hw.adjusted_mode.crtc_hdisplay (expected 0, found 1920)
<7> [92.387753] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:585:pipe D] fastset requirement not met in hw.adjusted_mode.crtc_htotal (expected 0, found 2080)
<7> [92.387913] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:585:pipe D] fastset requirement not met in hw.adjusted_mode.crtc_hblank_start (expected 0, found 1920)
<7> [92.388074] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:585:pipe D] fastset requirement not met in hw.adjusted_mode.crtc_hblank_end (expected 0, found 2080)
<7> [92.388233] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:585:pipe D] fastset requirement not met in hw.adjusted_mode.crtc_hsync_start (expected 0, found 1968)
<7> [92.388414] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:585:pipe D] fastset requirement not met in hw.adjusted_mode.crtc_hsync_end (expected 0, found 2000)
<7> [92.388573] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:585:pipe D] fastset requirement not met in hw.adjusted_mode.crtc_vdisplay (expected 0, found 1080)
<7> [92.388732] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:585:pipe D] fastset requirement not met in hw.adjusted_mode.crtc_vblank_start (expected 0, found 1080)
<7> [92.388891] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:585:pipe D] fastset requirement not met in hw.adjusted_mode.crtc_vsync_start (expected 0, found 1083)
<7> [92.389049] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:585:pipe D] fastset requirement not met in hw.adjusted_mode.crtc_vsync_end (expected 0, found 1088)
<7> [92.389207] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:585:pipe D] fastset requirement not met in hw.adjusted_mode.crtc_vtotal (expected 0, found 1144)
<7> [92.389456] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:585:pipe D] fastset requirement not met in hw.adjusted_mode.crtc_vblank_end (expected 0, found 1144)
<7> [92.389673] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:585:pipe D] fastset requirement not met in pixel_multiplier (expected 0, found 1)
<7> [92.389833] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:585:pipe D] fastset requirement not met in hw.adjusted_mode.flags (1) (expected 0, found 1)
<7> [92.390000] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:585:pipe D] fastset requirement not met in hw.adjusted_mode.flags (4) (expected 0, found 4)
<7> [92.390168] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:585:pipe D] fastset requirement not met in has_hdmi_sink (expected no, found yes)
<7> [92.390436] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:585:pipe D] fastset requirement not met in has_infoframe (expected no, found yes)
<7> [92.390648] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:585:pipe D] fastset requirement not met in dpll_hw_state
<7> [92.390811] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] expected:
<7> [92.390972] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] dpll_hw_state: cfgcr0: 0x0, cfgcr1: 0x0, div0: 0x0, mg_refclkin_ctl: 0x0, hg_clktop2_coreclkctl1: 0x0, mg_clktop2_hsclkctl: 0x0, mg_pll_div0: 0x0, mg_pll_div2: 0x0, mg_pll_lf: 0x0, mg_pll_frac_lock: 0x0, mg_pll_ssc: 0x0, mg_pll_bias: 0x0, mg_pll_tdc_coldst_bias: 0x0
<7> [92.391134] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] found:
<7> [92.391312] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] dpll_hw_state: cfgcr0: 0x1801be, cfgcr1: 0x488, div0: 0x0, mg_refclkin_ctl: 0x0, hg_clktop2_coreclkctl1: 0x0, mg_clktop2_hsclkctl: 0x0, mg_pll_div0: 0x0, mg_pll_div2: 0x0, mg_pll_lf: 0x0, mg_pll_frac_lock: 0x0, mg_pll_ssc: 0x0, mg_pll_bias: 0x0, mg_pll_tdc_coldst_bias: 0x0
<7> [92.391473] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:585:pipe D] fastset requirement not met in pipe_bpp (expected 0, found 24)
<7> [92.391632] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:585:pipe D] fastset requirement not met in hw.pipe_mode.crtc_clock (expected 0, found 285500)
<7> [92.391790] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:585:pipe D] fastset requirement not met in hw.adjusted_mode.crtc_clock (expected 0, found 285500)
<7> [92.391948] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:585:pipe D] fastset requirement not met in port_clock (expected 0, found 285500)
<7> [92.392106] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:585:pipe D] fastset requirement not met in infoframes.enable (expected 0x00000000, found 0x00000071)
<7> [92.392273] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:585:pipe D] fastset requirement not met in avi infoframe
<7> [92.392431] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] expected:
<7> [92.392592] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] found:
<7> [92.392758] i915 0000:00:02.0: HDMI infoframe: Auxiliary Video Information (AVI), version 2, length 13
<7> [92.392760] i915 0000:00:02.0: colorspace: RGB
<7> [92.392761] i915 0000:00:02.0: scan mode: Underscan
<7> [92.392763] i915 0000:00:02.0: colorimetry: No Data
<7> [92.392764] i915 0000:00:02.0: picture aspect: No Data
<7> [92.392766] i915 0000:00:02.0: active aspect: Same as Picture
<7> [92.392767] i915 0000:00:02.0: itc: No Data
<7> [92.392769] i915 0000:00:02.0: extended colorimetry: xvYCC 601
<7> [92.392770] i915 0000:00:02.0: quantization range: Full
<7> [92.392771] i915 0000:00:02.0: nups: Unknown Non-uniform Scaling
<7> [92.392773] i915 0000:00:02.0: video code: 0
<7> [92.392774] i915 0000:00:02.0: ycc quantization range: Full
<7> [92.392776] i915 0000:00:02.0: hdmi content type: Graphics
<7> [92.392777] i915 0000:00:02.0: pixel repeat: 0
<7> [92.392778] i915 0000:00:02.0: bar top 0, bottom 0, left 0, right 0
<7> [92.392780] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:585:pipe D] fastset requirement not met in spd infoframe
<7> [92.392938] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] expected:
<7> [92.393095] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] found:
<7> [92.393251] i915 0000:00:02.0: HDMI infoframe: Source Product Description (SPD), version 1, length 25
<7> [92.393422] i915 0000:00:02.0: vendor: Intel
<7> [92.393424] i915 0000:00:02.0: product: Integrated gfx
<7> [92.393425] i915 0000:00:02.0: source device information: PC General (0x9)
<7> [92.393427] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:585:pipe D] fastset requirement not met in hdmi infoframe
<7> [92.393586] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] expected:
<7> [92.393743] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] found:
<7> [92.393899] i915 0000:00:02.0: HDMI infoframe: Vendor, version 1, length 4
<7> [92.393901] i915 0000:00:02.0: empty frame
<7> [92.393903] i915 0000:00:02.0: [drm:intel_atomic_check [i915]] [CRTC:585:pipe D] fastset requirement not met, forcing full modeset
<7> [92.394102] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] Enabled dbuf slices 0x1 -> 0x3 (total dbuf slices 0x3), mbus joined? no->no
<7> [92.394280] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] [CRTC:585:pipe D] dbuf slices 0x0 -> 0x3, ddb (0 - 0) -> (0 - 2048), active pipes 0x0 -> 0x8
<7> [92.394483] i915 0000:00:02.0: [drm:skl_print_plane_ddb_changes [i915]] [PLANE:449:plane 1D] ddb ( 0 - 0) -> ( 0 - 1993), size 0 -> 1993
<7> [92.394640] i915 0000:00:02.0: [drm:skl_print_plane_ddb_changes [i915]] [PLANE:579:cursor D] ddb ( 0 - 0) -> (1993 - 2048), size 0 -> 55
<7> [92.394796] i915 0000:00:02.0: [drm:skl_print_plane_wm_changes [i915]] [PLANE:449:plane 1D] level wm0, wm1, wm2, wm3, wm4, wm5, wm6, wm7, twm, swm, stwm -> *wm0,*wm1,*wm2,*wm3,*wm4,*wm5,*wm6,*wm7,*twm, swm, stwm
<7> [92.394951] i915 0000:00:02.0: [drm:skl_print_plane_wm_changes [i915]] [PLANE:449:plane 1D] lines 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0 -> 1, 8, 8, 8, 8, 11, 16, 16, 0, 0, 0
<7> [92.395109] i915 0000:00:02.0: [drm:skl_print_plane_wm_changes [i915]] [PLANE:449:plane 1D] blocks 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0 -> 16, 129, 129, 129, 129, 177, 257, 257, 30, 0, 0
<7> [92.395275] i915 0000:00:02.0: [drm:skl_print_plane_wm_changes [i915]] [PLANE:449:plane 1D] min_ddb 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0 -> 19, 143, 143, 143, 143, 196, 284, 284, 31, 0, 0
<7> [92.395454] i915 0000:00:02.0: [drm:intel_bw_atomic_check [i915]] [CRTC:585:pipe D] data rate 1142000 num active planes 1
<7> [92.395618] i915 0000:00:02.0: [drm:intel_bw_atomic_check [i915]] QGV point 0: max bw 14993 required 1142
<7> [92.395779] i915 0000:00:02.0: [drm:intel_bw_atomic_check [i915]] No SAGV, using single QGV point mask 0x1
<7> [92.395959] i915 0000:00:02.0: [drm:intel_cdclk_atomic_check [i915]] [CRTC:585:pipe D] min cdclk: 0 kHz -> 192000 kHz
<7> [92.396164] i915 0000:00:02.0: [drm:intel_cdclk_atomic_check [i915]] Modeset required for cdclk change
<7> [92.396342] i915 0000:00:02.0: [drm:intel_cdclk_atomic_check [i915]] New cdclk calculated to be logical 192000 kHz, actual 192000 kHz
<7> [92.396505] i915 0000:00:02.0: [drm:intel_cdclk_atomic_check [i915]] New voltage level calculated to be logical 0, actual 0
<7> [92.396668] i915 0000:00:02.0: [drm:intel_find_dpll [i915]] [CRTC:585:pipe D] allocated DPLL 0
<7> [92.396835] i915 0000:00:02.0: [drm:intel_dpll_crtc_get [i915]] [CRTC:585:pipe D] reserving DPLL 0
<7> [92.397003] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [CRTC:585:pipe D] enable: yes [modeset]
<7> [92.397165] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] active: yes, output_types: HDMI (0x40), output format: RGB, sink format: RGB
<7> [92.397350] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] cpu_transcoder: D, pipe bpp: 24, dithering: 0
<7> [92.397511] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] MST master transcoder: <invalid>
<7> [92.397669] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] port sync: master transcoder: <invalid>, slave transcoder bitmask = 0x0
<7> [92.397827] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] joiner: no, pipes: 0x0
<7> [92.397987] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] splitter: disabled, link count 0, overlap 0
<7> [92.398145] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] audio: 1, infoframes: 1, infoframes enabled: 0x71
<7> [92.398316] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] GCP: 0x0
<7> [92.398474] i915 0000:00:02.0: HDMI infoframe: Auxiliary Video Information (AVI), version 2, length 13
<7> [92.398476] i915 0000:00:02.0: colorspace: RGB
<7> [92.398478] i915 0000:00:02.0: scan mode: Underscan
<7> [92.398479] i915 0000:00:02.0: colorimetry: No Data
<7> [92.398481] i915 0000:00:02.0: picture aspect: No Data
<7> [92.398482] i915 0000:00:02.0: active aspect: Same as Picture
<7> [92.398484] i915 0000:00:02.0: itc: No Data
<7> [92.398485] i915 0000:00:02.0: extended colorimetry: xvYCC 601
<7> [92.398486] i915 0000:00:02.0: quantization range: Full
<7> [92.398488] i915 0000:00:02.0: nups: Unknown Non-uniform Scaling
<7> [92.398489] i915 0000:00:02.0: video code: 0
<7> [92.398490] i915 0000:00:02.0: ycc quantization range: Full
<7> [92.398492] i915 0000:00:02.0: hdmi content type: Graphics
<7> [92.398493] i915 0000:00:02.0: pixel repeat: 0
<7> [92.398495] i915 0000:00:02.0: bar top 0, bottom 0, left 0, right 0
<7> [92.398496] i915 0000:00:02.0: HDMI infoframe: Source Product Description (SPD), version 1, length 25
<7> [92.398498] i915 0000:00:02.0: vendor: Intel
<7> [92.398499] i915 0000:00:02.0: product: Integrated gfx
<7> [92.398501] i915 0000:00:02.0: source device information: PC General (0x9)
<7> [92.398502] i915 0000:00:02.0: HDMI infoframe: Vendor, version 1, length 4
<7> [92.398504] i915 0000:00:02.0: empty frame
<7> [92.398506] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] ELD: 10 00 0f 00 6d a2 00 7f 00 00 00 00 00 00 00 00
<7> [92.398664] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] ELD: 0d 82 34 12 66 69 74 48 65 61 64 6c 65 73 73 47
<7> [92.398822] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] ELD: 53 7f 7f 28 0f 7f 07 17 7f ff 3f 7f ff 47 7f ff
<7> [92.398979] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] ELD: 5f 7f 82 7f 7f 00 7f 7f 51 7f 7f 30 77 7f 03 00
<7> [92.399162] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] scanline offset: 2
<7> [92.399334] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] framestart delay: 1, MSA timing delay: 0, set context latency: 0
<7> [92.399491] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] vrr: no, fixed rr: yes, vmin: 1144, vmax: 1144, flipline: 1144, pipeline full: 61, guardband: 63 vsync start: 0, vsync end: 0
<7> [92.399648] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] vrr: vmin vblank: 1081, vmax vblank: 1081, vmin vtotal: 1144, vmax vtotal: 1144
<7> [92.399805] 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> [92.399962] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] requested mode: "1920x1080": 120 285500 1920 1968 2000 2080 1080 1083 1088 1144 0x48 0x5
<7> [92.400120] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] adjusted mode: "1920x1080": 120 285500 1920 1968 2000 2080 1080 1083 1088 1144 0x48 0x5
<7> [92.400285] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] crtc timings: clock=285500, hd=1920 hb=1920-2080 hs=1968-2000 ht=2080, vd=1080 vb=1080-1144 vs=1083-1088 vt=1144, flags=0x5
<7> [92.400445] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pipe mode: "1920x1080": 120 285500 1920 1968 2000 2080 1080 1083 1088 1144 0x40 0x5
<7> [92.400602] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] crtc timings: clock=285500, hd=1920 hb=1920-2080 hs=1968-2000 ht=2080, vd=1080 vb=1080-1144 vs=1083-1088 vt=1144, flags=0x5
<7> [92.400759] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] port clock: 285500, pixel rate 285500, min cdclk 192000, min voltage level 0
<7> [92.400916] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] linetime: 59, ips linetime: 0
<7> [92.401074] 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> [92.401232] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pipe src: 1920x1080+0+0
<7> [92.401409] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pch pfit: 0x0+0+0, disabled, force thru: no
<7> [92.401439] i915 0000:00:02.0: [drm:intel_power_well_disable [i915]] disabling DC_off
<7> [92.401659] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] sharpness strength: 0, sharpness tap size: 0, sharpness enable: 0
<7> [92.401714] i915 0000:00:02.0: [drm:skl_enable_dc6 [i915]] Enabling DC6
<7> [92.401906] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] ips: 0, double wide: 0, drrs: 0
<7> [92.401974] i915 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [i915]] Setting DC state from 00 to 02
<7> [92.402154] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] dpll_hw_state: cfgcr0: 0x1801be, cfgcr1: 0x488, div0: 0x0, mg_refclkin_ctl: 0x0, hg_clktop2_coreclkctl1: 0x0, mg_clktop2_hsclkctl: 0x0, mg_pll_div0: 0x0, mg_pll_div2: 0x0, mg_pll_lf: 0x0, mg_pll_frac_lock: 0x0, mg_pll_ssc: 0x0, mg_pll_bias: 0x0, mg_pll_tdc_coldst_bias: 0x0
<7> [92.403240] i915 0000:00:02.0: [drm:intel_power_well_disable [i915]] disabling always-on
<7> [92.403405] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] csc_mode: 0x0 gamma_mode: 0x0 gamma_enable: 0 csc_enable: 0
<7> [92.403614] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pre csc lut: 0 entries, post csc lut: 0 entries
<7> [92.403776] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] output csc: pre offsets: 0x0000 0x0000 0x0000
<7> [92.403939] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] output csc: coefficients: 0x0000 0x0000 0x0000
<7> [92.404098] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] output csc: coefficients: 0x0000 0x0000 0x0000
<7> [92.404266] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] output csc: coefficients: 0x0000 0x0000 0x0000
<7> [92.404443] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] output csc: post offsets: 0x0000 0x0000 0x0000
<7> [92.404673] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pipe csc: pre offsets: 0x0000 0x0000 0x0000
<7> [92.404843] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pipe csc: coefficients: 0x0000 0x0000 0x0000
<7> [92.405000] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pipe csc: coefficients: 0x0000 0x0000 0x0000
<7> [92.405157] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pipe csc: coefficients: 0x0000 0x0000 0x0000
<7> [92.405341] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pipe csc: post offsets: 0x0000 0x0000 0x0000
<7> [92.405573] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:449:plane 1D] fb: [FB:637] 1920x1080 format = XR24 little-endian (0x34325258) modifier = 0x100000000000001, visible: yes
<7> [92.405737] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] rotation: 0x1, scaler: -1, scaling_filter: 0
<7> [92.405895] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] src: 1920.000000x1080.000000+0.000000+0.000000 dst: 1920x1080+0+0
<7> [92.406054] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:479:plane 2D] fb: [NOFB], visible: no
<7> [92.406222] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:509:plane 3D] fb: [NOFB], visible: no
<7> [92.406474] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:539:plane 4D] fb: [NOFB], visible: no
<7> [92.406660] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:549:plane 5D] fb: [NOFB], visible: no
<7> [92.406818] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:559:plane 6D] fb: [NOFB], visible: no
<7> [92.406975] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:569:plane 7D] fb: [NOFB], visible: no
<7> [92.407169] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:579:cursor D] fb: [NOFB], visible: no
<7> [92.408011] i915 0000:00:02.0: [drm:intel_power_well_enable [i915]] enabling always-on
<7> [92.408184] i915 0000:00:02.0: [drm:intel_power_well_enable [i915]] enabling DC_off
<7> [92.408890] i915 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [i915]] Setting DC state from 02 to 00
<7> [92.410094] i915 0000:00:02.0: [drm:intel_power_well_enable [i915]] enabling PW_2
<7> [92.410284] i915 0000:00:02.0: [drm:intel_power_well_enable [i915]] enabling PW_3
<7> [92.410461] i915 0000:00:02.0: [drm:intel_power_well_enable [i915]] enabling PW_4
<7> [92.410638] i915 0000:00:02.0: [drm:intel_power_well_enable [i915]] enabling PW_5
<7> [92.410917] i915 0000:00:02.0: [drm:intel_set_cdclk [i915]] Pre changing CDCLK to 192000 kHz, VCO 384000 kHz, ref 38400 kHz, bypass 19200 kHz, voltage level 0
<7> [92.411171] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:587:DDI B/PHY B]
<7> [92.411352] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:597:DDI TC1/PHY TC1]
<7> [92.411519] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:599:DP-MST A]
<7> [92.411754] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:600:DP-MST B]
<7> [92.411921] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:601:DP-MST C]
<7> [92.412082] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:602:DP-MST D]
<7> [92.412242] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:607:DDI TC2/PHY TC2]
<7> [92.412428] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:609:DP-MST A]
<7> [92.412658] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:610:DP-MST B]
<7> [92.412816] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:611:DP-MST C]
<7> [92.412974] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:612:DP-MST D]
<7> [92.413132] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:616:DDI TC3/PHY TC3]
<7> [92.413316] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:618:DP-MST A]
<7> [92.413484] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:619:DP-MST B]
<7> [92.413676] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:620:DP-MST C]
<7> [92.413890] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:621:DP-MST D]
<7> [92.414046] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:625:DDI TC4/PHY TC4]
<7> [92.414205] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:627:DP-MST A]
<7> [92.414385] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:628:DP-MST B]
<7> [92.414569] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:629:DP-MST C]
<7> [92.414799] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:630:DP-MST D]
<7> [92.415116] i915 0000:00:02.0: [drm:gen9_dbuf_slices_update [i915]] Updating dbuf slices to 0x3
<7> [92.415327] i915 0000:00:02.0: [drm:intel_dpll_enable [i915]] enable DPLL 0 (active 0x8, on? 0) for [CRTC:585:pipe D]
<7> [92.415494] i915 0000:00:02.0: [drm:intel_dpll_enable [i915]] enabling DPLL 0
<7> [92.415736] i915 0000:00:02.0: [drm:intel_power_well_enable [i915]] enabling DDI_IO_B
<7> [92.416019] i915 0000:00:02.0: [drm:intel_enable_transcoder [i915]] enabling pipe D
<7> [92.416742] i915 0000:00:02.0: [drm:intel_hdmi_handle_sink_scrambling [i915]] [CONNECTOR:588:HDMI-A-1] scrambling=no, TMDS bit clock ratio=1/10
<7> [92.417291] i915 0000:00:02.0: [drm:do_gmbus_xfer [i915]] GMBUS [i915 gmbus dpb] NAK for addr: 0054 w(1)
<7> [92.417500] i915 0000:00:02.0: [drm:do_gmbus_xfer [i915]] GMBUS [i915 gmbus dpb] NAK on first message, retry
<7> [92.418052] i915 0000:00:02.0: [drm:do_gmbus_xfer [i915]] GMBUS [i915 gmbus dpb] NAK for addr: 0054 w(1)
<7> [92.418232] i915 0000:00:02.0: [drm:drm_scdc_set_high_tmds_clock_ratio [drm_display_helper]] [CONNECTOR:588:HDMI-A-1] Failed to read TMDS config: -6
<7> [92.418266] i915 0000:00:02.0: [drm:intel_ddi_enable [i915]] [CONNECTOR:588:HDMI-A-1] Failed to configure sink scrambling/TMDS bit clock ratio
<7> [92.435351] i915 0000:00:02.0: [drm:intel_audio_codec_enable [i915]] [CONNECTOR:588:HDMI-A-1][ENCODER:587:DDI B/PHY B] Enable audio codec on [CRTC:585:pipe D], 64 bytes ELD
<7> [92.443633] i915 0000:00:02.0: [drm:audio_config_hdmi_pixel_clock [i915]] HDMI audio pixel clock setting for 285500 not found, falling back to defaults
<7> [92.443825] i915 0000:00:02.0: [drm:audio_config_hdmi_pixel_clock [i915]] Configuring HDMI audio for pixel clock 25200 (0x00010000)
<7> [92.443988] i915 0000:00:02.0: [drm:hsw_audio_config_update [i915]] using automatic N
<6> [92.444158] snd_hda_codec_intelhdmi hdaudioC0D2: HDMI: audio coding xtype 5 not expected
<6> [92.444160] snd_hda_codec_intelhdmi hdaudioC0D2: HDMI: audio coding xtype 0 not expected
<6> [92.444162] snd_hda_codec_intelhdmi hdaudioC0D2: HDMI: audio coding xtype 10 not expected
<6> [92.444163] snd_hda_codec_intelhdmi hdaudioC0D2: HDMI: audio coding xtype 6 not expected
<7> [92.444329] i915 0000:00:02.0: [drm:verify_connector_state [i915]] [CONNECTOR:588:HDMI-A-1]
<7> [92.444611] i915 0000:00:02.0: [drm:intel_modeset_verify_crtc [i915]] [CRTC:585:pipe D]
<7> [92.445393] i915 0000:00:02.0: [drm:intel_audio_component_get_power [i915]] restored AUD_FREQ_CNTRL to 0x810
<7> [92.449838] azx_init_pci: snd_hda_intel 0000:00:1f.3: Clearing TCSEL
<7> [92.449870] azx_init_pci: snd_hda_intel 0000:00:1f.3: SCH snoop: Enabled
<7> [103.006204] i915 0000:00:02.0: [drm:drm_mode_setcrtc] [CRTC:171:pipe A]
<7> [103.006739] i915 0000:00:02.0: [drm:drm_mode_setcrtc] [CRTC:309:pipe B]
<7> [103.007079] i915 0000:00:02.0: [drm:drm_mode_setcrtc] [CRTC:447:pipe C]
<7> [103.007386] i915 0000:00:02.0: [drm:drm_mode_setcrtc] [CRTC:585:pipe D]
<7> [103.008292] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:585:pipe D] fastset requirement not met in hw.enable (expected yes, found no)
<7> [103.008907] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:585:pipe D] fastset requirement not met in hw.active (expected yes, found no)
<7> [103.009672] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:585:pipe D] fastset requirement not met in cpu_transcoder (expected 3, found -1)
<7> [103.010156] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:585:pipe D] fastset requirement not met in lane_count (expected 4, found 0)
<7> [103.010661] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:585:pipe D] fastset requirement not met in output_types (expected 0x00000040, found 0x00000000)
<7> [103.011057] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:585:pipe D] fastset requirement not met in framestart_delay (expected 1, found 0)
<7> [103.011218] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:585:pipe D] fastset requirement not met in hw.pipe_mode.crtc_hdisplay (expected 1920, found 0)
<7> [103.011377] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:585:pipe D] fastset requirement not met in hw.pipe_mode.crtc_htotal (expected 2080, found 0)
<7> [103.011548] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:585:pipe D] fastset requirement not met in hw.pipe_mode.crtc_hblank_start (expected 1920, found 0)
<7> [103.011708] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:585:pipe D] fastset requirement not met in hw.pipe_mode.crtc_hblank_end (expected 2080, found 0)
<7> [103.011868] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:585:pipe D] fastset requirement not met in hw.pipe_mode.crtc_hsync_start (expected 1968, found 0)
<7> [103.012028] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:585:pipe D] fastset requirement not met in hw.pipe_mode.crtc_hsync_end (expected 2000, found 0)
<7> [103.012192] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:585:pipe D] fastset requirement not met in hw.pipe_mode.crtc_vdisplay (expected 1080, found 0)
<7> [103.012353] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:585:pipe D] fastset requirement not met in hw.pipe_mode.crtc_vblank_start (expected 1080, found 0)
<7> [103.012527] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:585:pipe D] fastset requirement not met in hw.pipe_mode.crtc_vsync_start (expected 1083, found 0)
<7> [103.012689] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:585:pipe D] fastset requirement not met in hw.pipe_mode.crtc_vsync_end (expected 1088, found 0)
<7> [103.012849] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:585:pipe D] fastset requirement not met in hw.pipe_mode.crtc_vtotal (expected 1144, found 0)
<7> [103.013007] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:585:pipe D] fastset requirement not met in hw.pipe_mode.crtc_vblank_end (expected 1144, found 0)
<7> [103.013167] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:585:pipe D] fastset requirement not met in hw.adjusted_mode.crtc_hdisplay (expected 1920, found 0)
<7> [103.013324] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:585:pipe D] fastset requirement not met in hw.adjusted_mode.crtc_htotal (expected 2080, found 0)
<7> [103.013492] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:585:pipe D] fastset requirement not met in hw.adjusted_mode.crtc_hblank_start (expected 1920, found 0)
<7> [103.013651] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:585:pipe D] fastset requirement not met in hw.adjusted_mode.crtc_hblank_end (expected 2080, found 0)
<7> [103.013811] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:585:pipe D] fastset requirement not met in hw.adjusted_mode.crtc_hsync_start (expected 1968, found 0)
<7> [103.013971] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:585:pipe D] fastset requirement not met in hw.adjusted_mode.crtc_hsync_end (expected 2000, found 0)
<7> [103.014130] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:585:pipe D] fastset requirement not met in hw.adjusted_mode.crtc_vdisplay (expected 1080, found 0)
<7> [103.014290] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:585:pipe D] fastset requirement not met in hw.adjusted_mode.crtc_vblank_start (expected 1080, found 0)
<7> [103.014466] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:585:pipe D] fastset requirement not met in hw.adjusted_mode.crtc_vsync_start (expected 1083, found 0)
<7> [103.014634] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:585:pipe D] fastset requirement not met in hw.adjusted_mode.crtc_vsync_end (expected 1088, found 0)
<7> [103.014800] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:585:pipe D] fastset requirement not met in hw.adjusted_mode.crtc_vtotal (expected 1144, found 0)
<7> [103.014962] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:585:pipe D] fastset requirement not met in hw.adjusted_mode.crtc_vblank_end (expected 1144, found 0)
<7> [103.015124] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:585:pipe D] fastset requirement not met in pixel_multiplier (expected 1, found 0)
<7> [103.015284] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:585:pipe D] fastset requirement not met in hw.adjusted_mode.flags (1) (expected 1, found 0)
<7> [103.015456] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:585:pipe D] fastset requirement not met in hw.adjusted_mode.flags (4) (expected 4, found 0)
<7> [103.015618] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:585:pipe D] fastset requirement not met in has_hdmi_sink (expected yes, found no)
<7> [103.015778] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:585:pipe D] fastset requirement not met in has_infoframe (expected yes, found no)
<7> [103.015939] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:585:pipe D] fastset requirement not met in pipe_bpp (expected 24, found 0)
<7> [103.016098] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:585:pipe D] fastset requirement not met in hw.pipe_mode.crtc_clock (expected 285500, found 0)
<7> [103.016258] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:585:pipe D] fastset requirement not met in hw.adjusted_mode.crtc_clock (expected 285500, found 0)
<7> [103.016425] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:585:pipe D] fastset requirement not met in port_clock (expected 285500, found 0)
<7> [103.016586] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:585:pipe D] fastset requirement not met in infoframes.enable (expected 0x00000071, found 0x00000000)
<7> [103.016745] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:585:pipe D] fastset requirement not met in avi infoframe
<7> [103.016905] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] expected:
<7> [103.017063] i915 0000:00:02.0: HDMI infoframe: Auxiliary Video Information (AVI), version 2, length 13
<7> [103.017065] i915 0000:00:02.0: colorspace: RGB
<7> [103.017067] i915 0000:00:02.0: scan mode: Underscan
<7> [103.017069] i915 0000:00:02.0: colorimetry: No Data
<7> [103.017070] i915 0000:00:02.0: picture aspect: No Data
<7> [103.017072] i915 0000:00:02.0: active aspect: Same as Picture
<7> [103.017073] i915 0000:00:02.0: itc: No Data
<7> [103.017074] i915 0000:00:02.0: extended colorimetry: xvYCC 601
<7> [103.017076] i915 0000:00:02.0: quantization range: Full
<7> [103.017077] i915 0000:00:02.0: nups: Unknown Non-uniform Scaling
<7> [103.017079] i915 0000:00:02.0: video code: 0
<7> [103.017080] i915 0000:00:02.0: ycc quantization range: Full
<7> [103.017081] i915 0000:00:02.0: hdmi content type: Graphics
<7> [103.017083] i915 0000:00:02.0: pixel repeat: 0
<7> [103.017084] i915 0000:00:02.0: bar top 0, bottom 0, left 0, right 0
<7> [103.017086] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] found:
<7> [103.017246] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:585:pipe D] fastset requirement not met in spd infoframe
<7> [103.017412] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] expected:
<7> [103.017579] i915 0000:00:02.0: HDMI infoframe: Source Product Description (SPD), version 1, length 25
<7> [103.017581] i915 0000:00:02.0: vendor: Intel
<7> [103.017582] i915 0000:00:02.0: product: Integrated gfx
<7> [103.017584] i915 0000:00:02.0: source device information: PC General (0x9)
<7> [103.017586] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] found:
<7> [103.017748] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:585:pipe D] fastset requirement not met in hdmi infoframe
<7> [103.017909] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] expected:
<7> [103.018067] i915 0000:00:02.0: HDMI infoframe: Vendor, version 1, length 4
<7> [103.018069] i915 0000:00:02.0: empty frame
<7> [103.018070] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] found:
<7> [103.018228] i915 0000:00:02.0: [drm:intel_atomic_check [i915]] [CRTC:585:pipe D] fastset requirement not met, forcing full modeset
<7> [103.018418] i915 0000:00:02.0: [drm:intel_dpll_crtc_put [i915]] [CRTC:585:pipe D] releasing DPLL 0
<7> [103.018606] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] Enabled dbuf slices 0x3 -> 0x1 (total dbuf slices 0x3), mbus joined? no->no
<7> [103.018766] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] [CRTC:585:pipe D] dbuf slices 0x3 -> 0x0, ddb (0 - 2048) -> (0 - 0), active pipes 0x8 -> 0x0
<7> [103.018956] i915 0000:00:02.0: [drm:skl_print_plane_ddb_changes [i915]] [PLANE:449:plane 1D] ddb ( 0 - 1993) -> ( 0 - 0), size 1993 -> 0
<7> [103.019112] i915 0000:00:02.0: [drm:skl_print_plane_ddb_changes [i915]] [PLANE:579:cursor D] ddb (1993 - 2048) -> ( 0 - 0), size 55 -> 0
<7> [103.019266] i915 0000:00:02.0: [drm:skl_print_plane_wm_changes [i915]] [PLANE:449:plane 1D] level *wm0,*wm1,*wm2,*wm3,*wm4,*wm5,*wm6,*wm7,*twm, swm, stwm -> wm0, wm1, wm2, wm3, wm4, wm5, wm6, wm7, twm, swm, stwm
<7> [103.019431] i915 0000:00:02.0: [drm:skl_print_plane_wm_changes [i915]] [PLANE:449:plane 1D] lines 1, 8, 8, 8, 8, 11, 16, 16, 0, 0, 0 -> 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0
<7> [103.019584] i915 0000:00:02.0: [drm:skl_print_plane_wm_changes [i915]] [PLANE:449:plane 1D] blocks 16, 129, 129, 129, 129, 177, 257, 257, 30, 0, 0 -> 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0
<7> [103.019740] i915 0000:00:02.0: [drm:skl_print_plane_wm_changes [i915]] [PLANE:449:plane 1D] min_ddb 19, 143, 143, 143, 143, 196, 284, 284, 31, 0, 0 -> 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0
<7> [103.019914] i915 0000:00:02.0: [drm:intel_bw_atomic_check [i915]] [CRTC:585:pipe D] data rate 0 num active planes 0
<7> [103.020080] i915 0000:00:02.0: [drm:intel_bw_atomic_check [i915]] QGV point 0: max bw 14993 required 0
<7> [103.020243] i915 0000:00:02.0: [drm:intel_bw_atomic_check [i915]] No SAGV, using single QGV point mask 0x1
<7> [103.020434] i915 0000:00:02.0: [drm:intel_cdclk_atomic_check [i915]] [CRTC:585:pipe D] min cdclk: 192000 kHz -> 0 kHz
<7> [103.020613] i915 0000:00:02.0: [drm:intel_cdclk_update_dbuf_bw_min_cdclk [i915]] dbuf bandwidth min cdclk: 17844 kHz -> 0 kHz
<7> [103.020801] i915 0000:00:02.0: [drm:intel_cdclk_atomic_check [i915]] Modeset required for cdclk change
<7> [103.020962] i915 0000:00:02.0: [drm:intel_cdclk_atomic_check [i915]] New cdclk calculated to be logical 172800 kHz, actual 172800 kHz
<7> [103.021120] i915 0000:00:02.0: [drm:intel_cdclk_atomic_check [i915]] New voltage level calculated to be logical 0, actual 0
<7> [103.021281] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [CRTC:585:pipe D] enable: no [modeset]
<7> [103.021458] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:449:plane 1D] fb: [NOFB], visible: no
<7> [103.021621] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:479:plane 2D] fb: [NOFB], visible: no
<7> [103.021782] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:509:plane 3D] fb: [NOFB], visible: no
<7> [103.021943] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:539:plane 4D] fb: [NOFB], visible: no
<7> [103.022103] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:549:plane 5D] fb: [NOFB], visible: no
<7> [103.022262] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:559:plane 6D] fb: [NOFB], visible: no
<7> [103.022462] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:569:plane 7D] fb: [NOFB], visible: no
<7> [103.022622] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:579:cursor D] fb: [NOFB], visible: no
<7> [103.022860] i915 0000:00:02.0: [drm:intel_audio_codec_disable [i915]] [CONNECTOR:588:HDMI-A-1][ENCODER:587:DDI B/PHY B] Disable audio codec on [CRTC:585:pipe D]
<7> [103.036866] i915 0000:00:02.0: [drm:intel_audio_component_get_eld [i915]] Not valid for port B
<7> [103.038974] i915 0000:00:02.0: [drm:intel_hdmi_handle_sink_scrambling [i915]] [CONNECTOR:588:HDMI-A-1] scrambling=no, TMDS bit clock ratio=1/10
<7> [103.039523] i915 0000:00:02.0: [drm:do_gmbus_xfer [i915]] GMBUS [i915 gmbus dpb] NAK for addr: 0054 w(1)
<7> [103.039672] i915 0000:00:02.0: [drm:do_gmbus_xfer [i915]] GMBUS [i915 gmbus dpb] NAK on first message, retry
<7> [103.040217] i915 0000:00:02.0: [drm:do_gmbus_xfer [i915]] GMBUS [i915 gmbus dpb] NAK for addr: 0054 w(1)
<7> [103.040374] i915 0000:00:02.0: [drm:drm_scdc_set_high_tmds_clock_ratio [drm_display_helper]] [CONNECTOR:588:HDMI-A-1] Failed to read TMDS config: -6
<7> [103.040392] i915 0000:00:02.0: [drm:intel_ddi_disable [i915]] [CONNECTOR:588:HDMI-A-1] Failed to reset sink scrambling/TMDS bit clock ratio
<7> [103.040581] i915 0000:00:02.0: [drm:intel_disable_transcoder [i915]] disabling pipe D
<7> [103.046838] i915 0000:00:02.0: [drm:intel_power_well_disable [i915]] disabling DDI_IO_B
<7> [103.047040] i915 0000:00:02.0: [drm:intel_dpll_disable [i915]] disable DPLL 0 (active 0x8, on? 1) for [CRTC:585:pipe D]
<7> [103.047237] i915 0000:00:02.0: [drm:intel_dpll_disable [i915]] disabling DPLL 0
<7> [103.047415] i915 0000:00:02.0: [drm:intel_set_cdclk [i915]] Pre changing CDCLK to 172800 kHz, VCO 345600 kHz, ref 38400 kHz, bypass 19200 kHz, voltage level 0
<7> [103.047643] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:587:DDI B/PHY B]
<7> [103.047838] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:597:DDI TC1/PHY TC1]
<7> [103.048013] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:599:DP-MST A]
<7> [103.048208] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:600:DP-MST B]
<7> [103.048373] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:601:DP-MST C]
<7> [103.048535] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:602:DP-MST D]
<7> [103.048701] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:607:DDI TC2/PHY TC2]
<7> [103.048885] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:609:DP-MST A]
<7> [103.049059] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:610:DP-MST B]
<7> [103.049222] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:611:DP-MST C]
<7> [103.049383] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:612:DP-MST D]
<7> [103.049542] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:616:DDI TC3/PHY TC3]
<7> [103.049700] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:618:DP-MST A]
<7> [103.049888] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:619:DP-MST B]
<7> [103.050046] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:620:DP-MST C]
<7> [103.050203] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:621:DP-MST D]
<7> [103.050361] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:625:DDI TC4/PHY TC4]
<7> [103.050519] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:627:DP-MST A]
<7> [103.050676] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:628:DP-MST B]
<7> [103.050853] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:629:DP-MST C]
<7> [103.051010] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:630:DP-MST D]
<7> [103.051169] i915 0000:00:02.0: [drm:verify_connector_state [i915]] [CONNECTOR:588:HDMI-A-1]
<7> [103.051482] i915 0000:00:02.0: [drm:gen9_dbuf_slices_update [i915]] Updating dbuf slices to 0x1
<7> [103.051698] i915 0000:00:02.0: [drm:intel_power_well_disable [i915]] disabling PW_5
<7> [103.051901] i915 0000:00:02.0: [drm:intel_power_well_disable [i915]] disabling PW_4
<7> [103.052116] i915 0000:00:02.0: [drm:intel_power_well_disable [i915]] disabling PW_3
<7> [103.052294] i915 0000:00:02.0: [drm:intel_power_well_disable [i915]] disabling PW_2
<7> [103.052479] i915 0000:00:02.0: [drm:intel_modeset_verify_crtc [i915]] [CRTC:585:pipe D]
<7> [103.052981] i915 0000:00:02.0: [drm:drm_mode_setcrtc] [CRTC:585:pipe D]
<7> [103.053016] i915 0000:00:02.0: [drm:drm_mode_setcrtc] [CONNECTOR:588:HDMI-A-1]
<7> [103.053090] i915 0000:00:02.0: [drm:compute_baseline_pipe_bpp [i915]] [CONNECTOR:588:HDMI-A-1] Limiting target display pipe bpp to 24 (EDID bpp 24, max requested bpp 36, max platform bpp 36)
<7> [103.053267] i915 0000:00:02.0: [drm:intel_hdmi_compute_output_format [i915]] picking 8 bpc for HDMI output (pipe bpp: 24)
<7> [103.053432] i915 0000:00:02.0: [drm:intel_atomic_check [i915]] [CRTC:585:pipe D] hw max bpp: 24, pipe bpp: 24, dithering: 0
<7> [103.053598] i915 0000:00:02.0: [drm:intel_ddi_compute_config_late [i915]] [ENCODER:587:DDI B/PHY B] [CRTC:585:pipe D]
<7> [103.053768] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:585:pipe D] fastset requirement not met in hw.enable (expected no, found yes)
<7> [103.053955] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:585:pipe D] fastset requirement not met in hw.active (expected no, found yes)
<7> [103.054119] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:585:pipe D] fastset requirement not met in cpu_transcoder (expected -1, found 3)
<7> [103.054285] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:585:pipe D] fastset requirement not met in lane_count (expected 0, found 4)
<7> [103.054465] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:585:pipe D] fastset requirement not met in output_types (expected 0x00000000, found 0x00000040)
<7> [103.054631] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:585:pipe D] fastset requirement not met in framestart_delay (expected 0, found 1)
<7> [103.054835] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:585:pipe D] fastset requirement not met in hw.pipe_mode.crtc_hdisplay (expected 0, found 1920)
<7> [103.055017] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:585:pipe D] fastset requirement not met in hw.pipe_mode.crtc_htotal (expected 0, found 2080)
<7> [103.055179] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:585:pipe D] fastset requirement not met in hw.pipe_mode.crtc_hblank_start (expected 0, found 1920)
<7> [103.055340] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:585:pipe D] fastset requirement not met in hw.pipe_mode.crtc_hblank_end (expected 0, found 2080)
<7> [103.055500] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:585:pipe D] fastset requirement not met in hw.pipe_mode.crtc_hsync_start (expected 0, found 1968)
<7> [103.055684] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:585:pipe D] fastset requirement not met in hw.pipe_mode.crtc_hsync_end (expected 0, found 2000)
<7> [103.055888] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:585:pipe D] fastset requirement not met in hw.pipe_mode.crtc_vdisplay (expected 0, found 1080)
<7> [103.056103] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:585:pipe D] fastset requirement not met in hw.pipe_mode.crtc_vblank_start (expected 0, found 1080)
<7> [103.056264] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:585:pipe D] fastset requirement not met in hw.pipe_mode.crtc_vsync_start (expected 0, found 1083)
<7> [103.056424] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:585:pipe D] fastset requirement not met in hw.pipe_mode.crtc_vsync_end (expected 0, found 1088)
<7> [103.056583] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:585:pipe D] fastset requirement not met in hw.pipe_mode.crtc_vtotal (expected 0, found 1144)
<7> [103.056762] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:585:pipe D] fastset requirement not met in hw.pipe_mode.crtc_vblank_end (expected 0, found 1144)
<7> [103.056920] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:585:pipe D] fastset requirement not met in hw.adjusted_mode.crtc_hdisplay (expected 0, found 1920)
<7> [103.057079] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:585:pipe D] fastset requirement not met in hw.adjusted_mode.crtc_htotal (expected 0, found 2080)
<7> [103.057303] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:585:pipe D] fastset requirement not met in hw.adjusted_mode.crtc_hblank_start (expected 0, found 1920)
<7> [103.057534] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:585:pipe D] fastset requirement not met in hw.adjusted_mode.crtc_hblank_end (expected 0, found 2080)
<7> [103.057715] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:585:pipe D] fastset requirement not met in hw.adjusted_mode.crtc_hsync_start (expected 0, found 1968)
<7> [103.057898] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:585:pipe D] fastset requirement not met in hw.adjusted_mode.crtc_hsync_end (expected 0, found 2000)
<7> [103.058061] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:585:pipe D] fastset requirement not met in hw.adjusted_mode.crtc_vdisplay (expected 0, found 1080)
<7> [103.058246] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:585:pipe D] fastset requirement not met in hw.adjusted_mode.crtc_vblank_start (expected 0, found 1080)
<7> [103.058458] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:585:pipe D] fastset requirement not met in hw.adjusted_mode.crtc_vsync_start (expected 0, found 1083)
<7> [103.058701] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:585:pipe D] fastset requirement not met in hw.adjusted_mode.crtc_vsync_end (expected 0, found 1088)
<7> [103.058905] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:585:pipe D] fastset requirement not met in hw.adjusted_mode.crtc_vtotal (expected 0, found 1144)
<7> [103.059066] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:585:pipe D] fastset requirement not met in hw.adjusted_mode.crtc_vblank_end (expected 0, found 1144)
<7> [103.059228] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:585:pipe D] fastset requirement not met in pixel_multiplier (expected 0, found 1)
<7> [103.059388] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:585:pipe D] fastset requirement not met in hw.adjusted_mode.flags (1) (expected 0, found 1)
<7> [103.059549] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:585:pipe D] fastset requirement not met in hw.adjusted_mode.flags (4) (expected 0, found 4)
<7> [103.059729] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:585:pipe D] fastset requirement not met in has_hdmi_sink (expected no, found yes)
<7> [103.059921] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:585:pipe D] fastset requirement not met in has_infoframe (expected no, found yes)
<7> [103.060080] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:585:pipe D] fastset requirement not met in pipe_bpp (expected 0, found 24)
<7> [103.060240] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:585:pipe D] fastset requirement not met in hw.pipe_mode.crtc_clock (expected 0, found 285500)
<7> [103.060399] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:585:pipe D] fastset requirement not met in hw.adjusted_mode.crtc_clock (expected 0, found 285500)
<7> [103.060567] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:585:pipe D] fastset requirement not met in port_clock (expected 0, found 285500)
<7> [103.060749] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:585:pipe D] fastset requirement not met in infoframes.enable (expected 0x00000000, found 0x00000071)
<7> [103.060909] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:585:pipe D] fastset requirement not met in avi infoframe
<7> [103.061069] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] expected:
<7> [103.061226] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] found:
<7> [103.061385] i915 0000:00:02.0: HDMI infoframe: Auxiliary Video Information (AVI), version 2, length 13
<7> [103.061387] i915 0000:00:02.0: colorspace: RGB
<7> [103.061388] i915 0000:00:02.0: scan mode: Underscan
<7> [103.061390] i915 0000:00:02.0: colorimetry: No Data
<7> [103.061391] i915 0000:00:02.0: picture aspect: No Data
<7> [103.061393] i915 0000:00:02.0: active aspect: Same as Picture
<7> [103.061394] i915 0000:00:02.0: itc: No Data
<7> [103.061395] i915 0000:00:02.0: extended colorimetry: xvYCC 601
<7> [103.061397] i915 0000:00:02.0: quantization range: Full
<7> [103.061398] i915 0000:00:02.0: nups: Unknown Non-uniform Scaling
<7> [103.061400] i915 0000:00:02.0: video code: 0
<7> [103.061401] i915 0000:00:02.0: ycc quantization range: Full
<7> [103.061402] i915 0000:00:02.0: hdmi content type: Graphics
<7> [103.061404] i915 0000:00:02.0: pixel repeat: 0
<7> [103.061405] i915 0000:00:02.0: bar top 0, bottom 0, left 0, right 0
<7> [103.061407] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:585:pipe D] fastset requirement not met in spd infoframe
<7> [103.061576] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] expected:
<7> [103.061761] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] found:
<7> [103.061920] i915 0000:00:02.0: HDMI infoframe: Source Product Description (SPD), version 1, length 25
<7> [103.061921] i915 0000:00:02.0: vendor: Intel
<7> [103.061923] i915 0000:00:02.0: product: Integrated gfx
<7> [103.061924] i915 0000:00:02.0: source device information: PC General (0x9)
<7> [103.061926] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:585:pipe D] fastset requirement not met in hdmi infoframe
<7> [103.062087] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] expected:
<7> [103.062245] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] found:
<7> [103.062404] i915 0000:00:02.0: HDMI infoframe: Vendor, version 1, length 4
<7> [103.062406] i915 0000:00:02.0: empty frame
<7> [103.062409] i915 0000:00:02.0: [drm:intel_atomic_check [i915]] [CRTC:585:pipe D] fastset requirement not met, forcing full modeset
<7> [103.062627] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] Enabled dbuf slices 0x1 -> 0x3 (total dbuf slices 0x3), mbus joined? no->no
<7> [103.062815] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] [CRTC:585:pipe D] dbuf slices 0x0 -> 0x3, ddb (0 - 0) -> (0 - 2048), active pipes 0x0 -> 0x8
<7> [103.063011] i915 0000:00:02.0: [drm:skl_print_plane_ddb_changes [i915]] [PLANE:449:plane 1D] ddb ( 0 - 0) -> ( 0 - 1993), size 0 -> 1993
<7> [103.063171] i915 0000:00:02.0: [drm:skl_print_plane_ddb_changes [i915]] [PLANE:579:cursor D] ddb ( 0 - 0) -> (1993 - 2048), size 0 -> 55
<7> [103.063330] i915 0000:00:02.0: [drm:skl_print_plane_wm_changes [i915]] [PLANE:449:plane 1D] level wm0, wm1, wm2, wm3, wm4, wm5, wm6, wm7, twm, swm, stwm -> *wm0,*wm1,*wm2,*wm3,*wm4,*wm5,*wm6,*wm7,*twm, swm, stwm
<7> [103.063487] i915 0000:00:02.0: [drm:skl_print_plane_wm_changes [i915]] [PLANE:449:plane 1D] lines 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0 -> 1, 8, 8, 8, 8, 11, 16, 16, 0, 0, 0
<7> [103.063733] i915 0000:00:02.0: [drm:skl_print_plane_wm_changes [i915]] [PLANE:449:plane 1D] blocks 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0 -> 16, 129, 129, 129, 129, 177, 257, 257, 30, 0, 0
<7> [103.063894] i915 0000:00:02.0: [drm:skl_print_plane_wm_changes [i915]] [PLANE:449:plane 1D] min_ddb 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0 -> 19, 143, 143, 143, 143, 196, 284, 284, 31, 0, 0
<7> [103.064069] i915 0000:00:02.0: [drm:intel_bw_atomic_check [i915]] [CRTC:585:pipe D] data rate 1142000 num active planes 1
<7> [103.064235] i915 0000:00:02.0: [drm:intel_bw_atomic_check [i915]] QGV point 0: max bw 14993 required 1142
<7> [103.064398] i915 0000:00:02.0: [drm:intel_bw_atomic_check [i915]] No SAGV, using single QGV point mask 0x1
<7> [103.064604] i915 0000:00:02.0: [drm:intel_cdclk_atomic_check [i915]] [CRTC:585:pipe D] min cdclk: 0 kHz -> 192000 kHz
<7> [103.064811] i915 0000:00:02.0: [drm:intel_cdclk_update_dbuf_bw_min_cdclk [i915]] dbuf bandwidth min cdclk: 0 kHz -> 17844 kHz
<7> [103.065002] i915 0000:00:02.0: [drm:intel_cdclk_atomic_check [i915]] Modeset required for cdclk change
<7> [103.065163] i915 0000:00:02.0: [drm:intel_cdclk_atomic_check [i915]] New cdclk calculated to be logical 192000 kHz, actual 192000 kHz
<7> [103.065323] i915 0000:00:02.0: [drm:intel_cdclk_atomic_check [i915]] New voltage level calculated to be logical 0, actual 0
<7> [103.065497] i915 0000:00:02.0: [drm:intel_find_dpll [i915]] [CRTC:585:pipe D] allocated DPLL 0
<7> [103.065687] i915 0000:00:02.0: [drm:intel_dpll_crtc_get [i915]] [CRTC:585:pipe D] reserving DPLL 0
<7> [103.065855] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [CRTC:585:pipe D] enable: yes [modeset]
<7> [103.066018] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] active: yes, output_types: HDMI (0x40), output format: RGB, sink format: RGB
<7> [103.066181] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] cpu_transcoder: D, pipe bpp: 24, dithering: 0
<7> [103.066343] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] MST master transcoder: <invalid>
<7> [103.066521] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] port sync: master transcoder: <invalid>, slave transcoder bitmask = 0x0
<7> [103.066709] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] joiner: no, pipes: 0x0
<7> [103.066874] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] splitter: disabled, link count 0, overlap 0
<7> [103.067035] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] audio: 1, infoframes: 1, infoframes enabled: 0x71
<7> [103.067196] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] GCP: 0x0
<7> [103.067357] i915 0000:00:02.0: HDMI infoframe: Auxiliary Video Information (AVI), version 2, length 13
<7> [103.067359] i915 0000:00:02.0: colorspace: RGB
<7> [103.067360] i915 0000:00:02.0: scan mode: Underscan
<7> [103.067362] i915 0000:00:02.0: colorimetry: No Data
<7> [103.067363] i915 0000:00:02.0: picture aspect: No Data
<7> [103.067364] i915 0000:00:02.0: active aspect: Same as Picture
<7> [103.067366] i915 0000:00:02.0: itc: No Data
<7> [103.067367] i915 0000:00:02.0: extended colorimetry: xvYCC 601
<7> [103.067369] i915 0000:00:02.0: quantization range: Full
<7> [103.067370] i915 0000:00:02.0: nups: Unknown Non-uniform Scaling
<7> [103.067371] i915 0000:00:02.0: video code: 0
<7> [103.067373] i915 0000:00:02.0: ycc quantization range: Full
<7> [103.067374] i915 0000:00:02.0: hdmi content type: Graphics
<7> [103.067375] i915 0000:00:02.0: pixel repeat: 0
<7> [103.067377] i915 0000:00:02.0: bar top 0, bottom 0, left 0, right 0
<7> [103.067379] i915 0000:00:02.0: HDMI infoframe: Source Product Description (SPD), version 1, length 25
<7> [103.067380] i915 0000:00:02.0: vendor: Intel
<7> [103.067382] i915 0000:00:02.0: product: Integrated gfx
<7> [103.067383] i915 0000:00:02.0: source device information: PC General (0x9)
<7> [103.067385] i915 0000:00:02.0: HDMI infoframe: Vendor, version 1, length 4
<7> [103.067386] i915 0000:00:02.0: empty frame
<7> [103.067388] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] ELD: 10 00 0f 00 6d a2 00 7f 00 00 00 00 00 00 00 00
<7> [103.067569] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] ELD: 0d 82 34 12 66 69 74 48 65 61 64 6c 65 73 73 47
<7> [103.067764] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] ELD: 53 7f 7f 28 0f 7f 07 17 7f ff 3f 7f ff 47 7f ff
<7> [103.067925] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] ELD: 5f 7f 82 7f 7f 00 7f 7f 51 7f 7f 30 77 7f 03 00
<7> [103.068084] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] scanline offset: 2
<7> [103.068242] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] framestart delay: 1, MSA timing delay: 0, set context latency: 0
<7> [103.068413] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] vrr: no, fixed rr: yes, vmin: 1144, vmax: 1144, flipline: 1144, pipeline full: 61, guardband: 63 vsync start: 0, vsync end: 0
<7> [103.068600] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] vrr: vmin vblank: 1081, vmax vblank: 1081, vmin vtotal: 1144, vmax vtotal: 1144
<7> [103.068759] 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> [103.068920] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] requested mode: "1920x1080": 120 285500 1920 1968 2000 2080 1080 1083 1088 1144 0x48 0x5
<7> [103.069086] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] adjusted mode: "1920x1080": 120 285500 1920 1968 2000 2080 1080 1083 1088 1144 0x48 0x5
<7> [103.069250] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] crtc timings: clock=285500, hd=1920 hb=1920-2080 hs=1968-2000 ht=2080, vd=1080 vb=1080-1144 vs=1083-1088 vt=1144, flags=0x5
<7> [103.069439] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pipe mode: "1920x1080": 120 285500 1920 1968 2000 2080 1080 1083 1088 1144 0x40 0x5
<7> [103.069633] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] crtc timings: clock=285500, hd=1920 hb=1920-2080 hs=1968-2000 ht=2080, vd=1080 vb=1080-1144 vs=1083-1088 vt=1144, flags=0x5
<7> [103.069794] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] port clock: 285500, pixel rate 285500, min cdclk 192000, min voltage level 0
<7> [103.069952] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] linetime: 59, ips linetime: 0
<7> [103.070110] 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> [103.070268] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pipe src: 1920x1080+0+0
<7> [103.070448] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pch pfit: 0x0+0+0, disabled, force thru: no
<7> [103.070475] i915 0000:00:02.0: [drm:intel_power_well_disable [i915]] disabling DC_off
<7> [103.070698] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] sharpness strength: 0, sharpness tap size: 0, sharpness enable: 0
<7> [103.070751] i915 0000:00:02.0: [drm:skl_enable_dc6 [i915]] Enabling DC6
<7> [103.070942] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] ips: 0, double wide: 0, drrs: 0
<7> [103.071005] i915 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [i915]] Setting DC state from 00 to 02
<7> [103.071196] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] dpll_hw_state: cfgcr0: 0x1801be, cfgcr1: 0x488, div0: 0x0, mg_refclkin_ctl: 0x0, hg_clktop2_coreclkctl1: 0x0, mg_clktop2_hsclkctl: 0x0, mg_pll_div0: 0x0, mg_pll_div2: 0x0, mg_pll_lf: 0x0, mg_pll_frac_lock: 0x0, mg_pll_ssc: 0x0, mg_pll_bias: 0x0, mg_pll_tdc_coldst_bias: 0x0
<7> [103.072275] i915 0000:00:02.0: [drm:intel_power_well_disable [i915]] disabling always-on
<7> [103.072450] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] csc_mode: 0x0 gamma_mode: 0x0 gamma_enable: 0 csc_enable: 0
<7> [103.072680] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pre csc lut: 0 entries, post csc lut: 0 entries
<7> [103.072842] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] output csc: pre offsets: 0x0000 0x0000 0x0000
<7> [103.073005] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] output csc: coefficients: 0x0000 0x0000 0x0000
<7> [103.073165] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] output csc: coefficients: 0x0000 0x0000 0x0000
<7> [103.073334] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] output csc: coefficients: 0x0000 0x0000 0x0000
<7> [103.073493] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] output csc: post offsets: 0x0000 0x0000 0x0000
<7> [103.073651] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pipe csc: pre offsets: 0x0000 0x0000 0x0000
<7> [103.073808] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pipe csc: coefficients: 0x0000 0x0000 0x0000
<7> [103.073965] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pipe csc: coefficients: 0x0000 0x0000 0x0000
<7> [103.074122] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pipe csc: coefficients: 0x0000 0x0000 0x0000
<7> [103.074279] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pipe csc: post offsets: 0x0000 0x0000 0x0000
<7> [103.074459] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:449:plane 1D] fb: [FB:637] 1920x1080 format = XR24 little-endian (0x34325258) modifier = 0x100000000000001, visible: yes
<7> [103.074619] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] rotation: 0x1, scaler: -1, scaling_filter: 0
<7> [103.074776] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] src: 1920.000000x1080.000000+0.000000+0.000000 dst: 1920x1080+0+0
<7> [103.074935] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:479:plane 2D] fb: [NOFB], visible: no
<7> [103.075092] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:509:plane 3D] fb: [NOFB], visible: no
<7> [103.075249] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:539:plane 4D] fb: [NOFB], visible: no
<7> [103.075429] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:549:plane 5D] fb: [NOFB], visible: no
<7> [103.075587] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:559:plane 6D] fb: [NOFB], visible: no
<7> [103.075745] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:569:plane 7D] fb: [NOFB], visible: no
<7> [103.075902] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:579:cursor D] fb: [NOFB], visible: no
<7> [103.076155] i915 0000:00:02.0: [drm:intel_power_well_enable [i915]] enabling always-on
<7> [103.076337] i915 0000:00:02.0: [drm:intel_power_well_enable [i915]] enabling DC_off
<7> [103.077023] i915 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [i915]] Setting DC state from 02 to 00
<7> [103.078230] i915 0000:00:02.0: [drm:intel_power_well_enable [i915]] enabling PW_2
<7> [103.078402] i915 0000:00:02.0: [drm:intel_power_well_enable [i915]] enabling PW_3
<7> [103.078577] i915 0000:00:02.0: [drm:intel_power_well_enable [i915]] enabling PW_4
<7> [103.078750] i915 0000:00:02.0: [drm:intel_power_well_enable [i915]] enabling PW_5
<7> [103.078945] i915 0000:00:02.0: [drm:intel_set_cdclk [i915]] Pre changing CDCLK to 192000 kHz, VCO 384000 kHz, ref 38400 kHz, bypass 19200 kHz, voltage level 0
<7> [103.079218] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:587:DDI B/PHY B]
<7> [103.079385] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:597:DDI TC1/PHY TC1]
<7> [103.079548] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:599:DP-MST A]
<7> [103.079710] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:600:DP-MST B]
<7> [103.079870] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:601:DP-MST C]
<7> [103.080029] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:602:DP-MST D]
<7> [103.080198] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:607:DDI TC2/PHY TC2]
<7> [103.080357] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:609:DP-MST A]
<7> [103.080516] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:610:DP-MST B]
<7> [103.080674] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:611:DP-MST C]
<7> [103.080832] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:612:DP-MST D]
<7> [103.080990] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:616:DDI TC3/PHY TC3]
<7> [103.081150] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:618:DP-MST A]
<7> [103.081330] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:619:DP-MST B]
<7> [103.081491] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:620:DP-MST C]
<7> [103.081651] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:621:DP-MST D]
<7> [103.081810] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:625:DDI TC4/PHY TC4]
<7> [103.081968] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:627:DP-MST A]
<7> [103.082127] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:628:DP-MST B]
<7> [103.082305] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:629:DP-MST C]
<7> [103.082464] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:630:DP-MST D]
<7> [103.082743] i915 0000:00:02.0: [drm:gen9_dbuf_slices_update [i915]] Updating dbuf slices to 0x3
<7> [103.082944] i915 0000:00:02.0: [drm:intel_dpll_enable [i915]] enable DPLL 0 (active 0x8, on? 0) for [CRTC:585:pipe D]
<7> [103.083112] i915 0000:00:02.0: [drm:intel_dpll_enable [i915]] enabling DPLL 0
<7> [103.083560] i915 0000:00:02.0: [drm:intel_power_well_enable [i915]] enabling DDI_IO_B
<7> [103.083807] i915 0000:00:02.0: [drm:intel_enable_transcoder [i915]] enabling pipe D
<7> [103.084526] i915 0000:00:02.0: [drm:intel_hdmi_handle_sink_scrambling [i915]] [CONNECTOR:588:HDMI-A-1] scrambling=no, TMDS bit clock ratio=1/10
<7> [103.085065] i915 0000:00:02.0: [drm:do_gmbus_xfer [i915]] GMBUS [i915 gmbus dpb] NAK for addr: 0054 w(1)
<7> [103.085238] i915 0000:00:02.0: [drm:do_gmbus_xfer [i915]] GMBUS [i915 gmbus dpb] NAK on first message, retry
<7> [103.085760] i915 0000:00:02.0: [drm:do_gmbus_xfer [i915]] GMBUS [i915 gmbus dpb] NAK for addr: 0054 w(1)
<7> [103.085912] i915 0000:00:02.0: [drm:drm_scdc_set_high_tmds_clock_ratio [drm_display_helper]] [CONNECTOR:588:HDMI-A-1] Failed to read TMDS config: -6
<7> [103.085930] i915 0000:00:02.0: [drm:intel_ddi_enable [i915]] [CONNECTOR:588:HDMI-A-1] Failed to configure sink scrambling/TMDS bit clock ratio
<7> [103.092658] i915 0000:00:02.0: [drm:intel_audio_component_get_power [i915]] restored AUD_FREQ_CNTRL to 0x810
<7> [103.096899] azx_init_pci: snd_hda_intel 0000:00:1f.3: Clearing TCSEL
<7> [103.096931] azx_init_pci: snd_hda_intel 0000:00:1f.3: SCH snoop: Enabled
<7> [103.102925] i915 0000:00:02.0: [drm:intel_audio_codec_enable [i915]] [CONNECTOR:588:HDMI-A-1][ENCODER:587:DDI B/PHY B] Enable audio codec on [CRTC:585:pipe D], 64 bytes ELD
<7> [103.111254] i915 0000:00:02.0: [drm:audio_config_hdmi_pixel_clock [i915]] HDMI audio pixel clock setting for 285500 not found, falling back to defaults
<7> [103.111432] i915 0000:00:02.0: [drm:audio_config_hdmi_pixel_clock [i915]] Configuring HDMI audio for pixel clock 25200 (0x00010000)
<7> [103.111611] i915 0000:00:02.0: [drm:hsw_audio_config_update [i915]] using automatic N
<6> [103.111778] snd_hda_codec_intelhdmi hdaudioC0D2: HDMI: audio coding xtype 5 not expected
<6> [103.111781] snd_hda_codec_intelhdmi hdaudioC0D2: HDMI: audio coding xtype 0 not expected
<6> [103.111783] snd_hda_codec_intelhdmi hdaudioC0D2: HDMI: audio coding xtype 10 not expected
<6> [103.111784] snd_hda_codec_intelhdmi hdaudioC0D2: HDMI: audio coding xtype 6 not expected
<7> [103.111921] i915 0000:00:02.0: [drm:verify_connector_state [i915]] [CONNECTOR:588:HDMI-A-1]
<7> [103.112180] i915 0000:00:02.0: [drm:intel_modeset_verify_crtc [i915]] [CRTC:585:pipe D]
<6> [110.857126] [IGT] kms_flip: finished subtest D-HDMI-A1, FAIL
<6> [110.859061] [IGT] kms_flip: finished subtest plain-flip-ts-check, FAIL
<7> [110.866715] i915 0000:00:02.0: [drm:drm_mode_rmfb_work_fn] Removing [FB:638] from all active usage due to RMFB ioctl
<7> [110.866975] i915 0000:00:02.0: [drm:atomic_remove_fb] Disabling [PLANE:449:plane 1D] because [FB:638] is removed
<7> [110.867068] i915 0000:00:02.0: [drm:skl_print_plane_ddb_changes [i915]] [PLANE:449:plane 1D] ddb ( 0 - 1993) -> ( 0 - 0), size 1993 -> 0
<7> [110.867282] i915 0000:00:02.0: [drm:skl_print_plane_wm_changes [i915]] [PLANE:449:plane 1D] level *wm0,*wm1,*wm2,*wm3,*wm4,*wm5,*wm6,*wm7,*twm, swm, stwm -> wm0, wm1, wm2, wm3, wm4, wm5, wm6, wm7, twm, swm, stwm
<7> [110.867443] i915 0000:00:02.0: [drm:skl_print_plane_wm_changes [i915]] [PLANE:449:plane 1D] lines 1, 8, 8, 8, 8, 11, 16, 16, 0, 0, 0 -> 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0
<7> [110.867600] i915 0000:00:02.0: [drm:skl_print_plane_wm_changes [i915]] [PLANE:449:plane 1D] blocks 16, 129, 129, 129, 129, 177, 257, 257, 30, 0, 0 -> 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0
<7> [110.867756] i915 0000:00:02.0: [drm:skl_print_plane_wm_changes [i915]] [PLANE:449:plane 1D] min_ddb 19, 143, 143, 143, 143, 196, 284, 284, 31, 0, 0 -> 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0
<7> [110.867953] i915 0000:00:02.0: [drm:intel_bw_atomic_check [i915]] [CRTC:585:pipe D] data rate 0 num active planes 0
<7> [110.868138] i915 0000:00:02.0: [drm:intel_bw_atomic_check [i915]] QGV point 0: max bw 14993 required 0
<7> [110.868345] i915 0000:00:02.0: [drm:intel_bw_atomic_check [i915]] No SAGV, using single QGV point mask 0x1
<6> [110.871464] [IGT] kms_flip: exiting, ret=98
<7> [110.884133] i915 0000:00:02.0: [drm:compute_baseline_pipe_bpp [i915]] [CONNECTOR:588:HDMI-A-1] Limiting target display pipe bpp to 24 (EDID bpp 24, max requested bpp 36, max platform bpp 36)
<7> [110.884360] i915 0000:00:02.0: [drm:intel_hdmi_compute_output_format [i915]] picking 8 bpc for HDMI output (pipe bpp: 24)
<7> [110.884535] i915 0000:00:02.0: [drm:intel_atomic_check [i915]] [CRTC:171:pipe A] hw max bpp: 24, pipe bpp: 24, dithering: 0
<7> [110.884720] i915 0000:00:02.0: [drm:intel_ddi_compute_config_late [i915]] [ENCODER:587:DDI B/PHY B] [CRTC:171:pipe A]
<7> [110.884878] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:171:pipe A] fastset requirement not met in hw.enable (expected no, found yes)
<7> [110.885221] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:171:pipe A] fastset requirement not met in hw.active (expected no, found yes)
<7> [110.885398] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:171:pipe A] fastset requirement not met in cpu_transcoder (expected -1, found 0)
<7> [110.885561] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:171:pipe A] fastset requirement not met in lane_count (expected 0, found 4)
<7> [110.885724] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:171:pipe A] fastset requirement not met in output_types (expected 0x00000000, found 0x00000040)
<7> [110.885995] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:171:pipe A] fastset requirement not met in framestart_delay (expected 0, found 1)
<7> [110.886169] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:171:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hdisplay (expected 0, found 1920)
<7> [110.886331] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:171:pipe A] fastset requirement not met in hw.pipe_mode.crtc_htotal (expected 0, found 2080)
<7> [110.886493] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:171:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hblank_start (expected 0, found 1920)
<7> [110.886653] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:171:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hblank_end (expected 0, found 2080)
<7> [110.886812] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:171:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hsync_start (expected 0, found 1968)
<7> [110.886991] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:171:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hsync_end (expected 0, found 2000)
<7> [110.887192] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:171:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vdisplay (expected 0, found 1080)
<7> [110.887352] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:171:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vblank_start (expected 0, found 1080)
<7> [110.887510] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:171:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vsync_start (expected 0, found 1083)
<7> [110.887667] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:171:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vsync_end (expected 0, found 1088)
<7> [110.887827] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:171:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vtotal (expected 0, found 1144)
<7> [110.888005] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:171:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vblank_end (expected 0, found 1144)
<7> [110.888191] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:171:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hdisplay (expected 0, found 1920)
<7> [110.888349] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:171:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_htotal (expected 0, found 2080)
<7> [110.888505] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:171:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hblank_start (expected 0, found 1920)
<7> [110.888663] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:171:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hblank_end (expected 0, found 2080)
<7> [110.888819] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:171:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hsync_start (expected 0, found 1968)
<7> [110.888996] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:171:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hsync_end (expected 0, found 2000)
<7> [110.889181] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:171:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vdisplay (expected 0, found 1080)
<7> [110.889344] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:171:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vblank_start (expected 0, found 1080)
<7> [110.889504] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:171:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vsync_start (expected 0, found 1083)
<7> [110.889665] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:171:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vsync_end (expected 0, found 1088)
<7> [110.889825] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:171:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vtotal (expected 0, found 1144)
<7> [110.890054] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:171:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vblank_end (expected 0, found 1144)
<7> [110.890278] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:171:pipe A] fastset requirement not met in pixel_multiplier (expected 0, found 1)
<7> [110.890466] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:171:pipe A] fastset requirement not met in hw.adjusted_mode.flags (1) (expected 0, found 1)
<7> [110.890628] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:171:pipe A] fastset requirement not met in hw.adjusted_mode.flags (4) (expected 0, found 4)
<7> [110.890789] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:171:pipe A] fastset requirement not met in has_hdmi_sink (expected no, found yes)
<7> [110.890963] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:171:pipe A] fastset requirement not met in has_infoframe (expected no, found yes)
<7> [110.891124] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:171:pipe A] fastset requirement not met in pipe_bpp (expected 0, found 24)
<7> [110.891284] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:171:pipe A] fastset requirement not met in hw.pipe_mode.crtc_clock (expected 0, found 285500)
<7> [110.891442] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:171:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_clock (expected 0, found 285500)
<7> [110.891601] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:171:pipe A] fastset requirement not met in port_clock (expected 0, found 285500)
<7> [110.891760] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:171:pipe A] fastset requirement not met in infoframes.enable (expected 0x00000000, found 0x00000071)
<7> [110.891931] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:171:pipe A] fastset requirement not met in avi infoframe
<7> [110.892090] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] expected:
<7> [110.892247] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] found:
<7> [110.892406] i915 0000:00:02.0: HDMI infoframe: Auxiliary Video Information (AVI), version 2, length 13
<7> [110.892408] i915 0000:00:02.0: colorspace: RGB
<7> [110.892410] i915 0000:00:02.0: scan mode: Underscan
<7> [110.892412] i915 0000:00:02.0: colorimetry: No Data
<7> [110.892414] i915 0000:00:02.0: picture aspect: No Data
<7> [110.892415] i915 0000:00:02.0: active aspect: Same as Picture
<7> [110.892417] i915 0000:00:02.0: itc: No Data
<7> [110.892418] i915 0000:00:02.0: extended colorimetry: xvYCC 601
<7> [110.892420] i915 0000:00:02.0: quantization range: Full
<7> [110.892422] i915 0000:00:02.0: nups: Unknown Non-uniform Scaling
<7> [110.892423] i915 0000:00:02.0: video code: 0
<7> [110.892425] i915 0000:00:02.0: ycc quantization range: Full
<7> [110.892427] i915 0000:00:02.0: hdmi content type: Graphics
<7> [110.892428] i915 0000:00:02.0: pixel repeat: 0
<7> [110.892430] i915 0000:00:02.0: bar top 0, bottom 0, left 0, right 0
<7> [110.892432] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:171:pipe A] fastset requirement not met in spd infoframe
<7> [110.892589] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] expected:
<7> [110.892764] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] found:
<7> [110.892937] i915 0000:00:02.0: HDMI infoframe: Source Product Description (SPD), version 1, length 25
<7> [110.892939] i915 0000:00:02.0: vendor: Intel
<7> [110.892941] i915 0000:00:02.0: product: Integrated gfx
<7> [110.892943] i915 0000:00:02.0: source device information: PC General (0x9)
<7> [110.892945] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:171:pipe A] fastset requirement not met in hdmi infoframe
<7> [110.893103] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] expected:
<7> [110.893260] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] found:
<7> [110.893416] i915 0000:00:02.0: HDMI infoframe: Vendor, version 1, length 4
<7> [110.893418] i915 0000:00:02.0: empty frame
<7> [110.893420] i915 0000:00:02.0: [drm:intel_atomic_check [i915]] [CRTC:171:pipe A] fastset requirement not met, forcing full modeset
<7> [110.893580] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:585:pipe D] fastset requirement not met in hw.enable (expected yes, found no)
<7> [110.893738] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:585:pipe D] fastset requirement not met in hw.active (expected yes, found no)
<7> [110.893937] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:585:pipe D] fastset requirement not met in cpu_transcoder (expected 3, found -1)
<7> [110.894159] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:585:pipe D] fastset requirement not met in lane_count (expected 4, found 0)
<7> [110.894376] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:585:pipe D] fastset requirement not met in output_types (expected 0x00000040, found 0x00000000)
<7> [110.894594] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:585:pipe D] fastset requirement not met in framestart_delay (expected 1, found 0)
<7> [110.894764] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:585:pipe D] fastset requirement not met in hw.pipe_mode.crtc_hdisplay (expected 1920, found 0)
<7> [110.894937] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:585:pipe D] fastset requirement not met in hw.pipe_mode.crtc_htotal (expected 2080, found 0)
<7> [110.895095] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:585:pipe D] fastset requirement not met in hw.pipe_mode.crtc_hblank_start (expected 1920, found 0)
<7> [110.895252] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:585:pipe D] fastset requirement not met in hw.pipe_mode.crtc_hblank_end (expected 2080, found 0)
<7> [110.895410] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:585:pipe D] fastset requirement not met in hw.pipe_mode.crtc_hsync_start (expected 1968, found 0)
<7> [110.895566] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:585:pipe D] fastset requirement not met in hw.pipe_mode.crtc_hsync_end (expected 2000, found 0)
<7> [110.895722] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:585:pipe D] fastset requirement not met in hw.pipe_mode.crtc_vdisplay (expected 1080, found 0)
<7> [110.895892] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:585:pipe D] fastset requirement not met in hw.pipe_mode.crtc_vblank_start (expected 1080, found 0)
<7> [110.896049] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:585:pipe D] fastset requirement not met in hw.pipe_mode.crtc_vsync_start (expected 1083, found 0)
<7> [110.896207] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:585:pipe D] fastset requirement not met in hw.pipe_mode.crtc_vsync_end (expected 1088, found 0)
<7> [110.896364] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:585:pipe D] fastset requirement not met in hw.pipe_mode.crtc_vtotal (expected 1144, found 0)
<7> [110.896521] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:585:pipe D] fastset requirement not met in hw.pipe_mode.crtc_vblank_end (expected 1144, found 0)
<7> [110.896678] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:585:pipe D] fastset requirement not met in hw.adjusted_mode.crtc_hdisplay (expected 1920, found 0)
<7> [110.896843] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:585:pipe D] fastset requirement not met in hw.adjusted_mode.crtc_htotal (expected 2080, found 0)
<7> [110.897002] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:585:pipe D] fastset requirement not met in hw.adjusted_mode.crtc_hblank_start (expected 1920, found 0)
<7> [110.897160] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:585:pipe D] fastset requirement not met in hw.adjusted_mode.crtc_hblank_end (expected 2080, found 0)
<7> [110.897317] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:585:pipe D] fastset requirement not met in hw.adjusted_mode.crtc_hsync_start (expected 1968, found 0)
<7> [110.897474] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:585:pipe D] fastset requirement not met in hw.adjusted_mode.crtc_hsync_end (expected 2000, found 0)
<7> [110.897631] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:585:pipe D] fastset requirement not met in hw.adjusted_mode.crtc_vdisplay (expected 1080, found 0)
<7> [110.897789] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:585:pipe D] fastset requirement not met in hw.adjusted_mode.crtc_vblank_start (expected 1080, found 0)
<7> [110.897970] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:585:pipe D] fastset requirement not met in hw.adjusted_mode.crtc_vsync_start (expected 1083, found 0)
<7> [110.898128] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:585:pipe D] fastset requirement not met in hw.adjusted_mode.crtc_vsync_end (expected 1088, found 0)
<7> [110.898286] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:585:pipe D] fastset requirement not met in hw.adjusted_mode.crtc_vtotal (expected 1144, found 0)
<7> [110.898442] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:585:pipe D] fastset requirement not met in hw.adjusted_mode.crtc_vblank_end (expected 1144, found 0)
<7> [110.898599] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:585:pipe D] fastset requirement not met in pixel_multiplier (expected 1, found 0)
<7> [110.898756] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:585:pipe D] fastset requirement not met in hw.adjusted_mode.flags (1) (expected 1, found 0)
<7> [110.898938] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:585:pipe D] fastset requirement not met in hw.adjusted_mode.flags (4) (expected 4, found 0)
<7> [110.899097] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:585:pipe D] fastset requirement not met in has_hdmi_sink (expected yes, found no)
<7> [110.899254] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:585:pipe D] fastset requirement not met in has_infoframe (expected yes, found no)
<7> [110.899411] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:585:pipe D] fastset requirement not met in pipe_bpp (expected 24, found 0)
<7> [110.899569] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:585:pipe D] fastset requirement not met in hw.pipe_mode.crtc_clock (expected 285500, found 0)
<7> [110.899727] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:585:pipe D] fastset requirement not met in hw.adjusted_mode.crtc_clock (expected 285500, found 0)
<7> [110.899897] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:585:pipe D] fastset requirement not met in port_clock (expected 285500, found 0)
<7> [110.900054] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:585:pipe D] fastset requirement not met in infoframes.enable (expected 0x00000071, found 0x00000000)
<7> [110.900212] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:585:pipe D] fastset requirement not met in avi infoframe
<7> [110.900369] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] expected:
<7> [110.900526] i915 0000:00:02.0: HDMI infoframe: Auxiliary Video Information (AVI), version 2, length 13
<7> [110.900528] i915 0000:00:02.0: colorspace: RGB
<7> [110.900529] i915 0000:00:02.0: scan mode: Underscan
<7> [110.900531] i915 0000:00:02.0: colorimetry: No Data
<7> [110.900533] i915 0000:00:02.0: picture aspect: No Data
<7> [110.900534] i915 0000:00:02.0: active aspect: Same as Picture
<7> [110.900536] i915 0000:00:02.0: itc: No Data
<7> [110.900537] i915 0000:00:02.0: extended colorimetry: xvYCC 601
<7> [110.900539] i915 0000:00:02.0: quantization range: Full
<7> [110.900541] i915 0000:00:02.0: nups: Unknown Non-uniform Scaling
<7> [110.900542] i915 0000:00:02.0: video code: 0
<7> [110.900544] i915 0000:00:02.0: ycc quantization range: Full
<7> [110.900545] i915 0000:00:02.0: hdmi content type: Graphics
<7> [110.900547] i915 0000:00:02.0: pixel repeat: 0
<7> [110.900549] i915 0000:00:02.0: bar top 0, bottom 0, left 0, right 0
<7> [110.900551] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] found:
<7> [110.900707] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:585:pipe D] fastset requirement not met in spd infoframe
<7> [110.900878] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] expected:
<7> [110.901035] i915 0000:00:02.0: HDMI infoframe: Source Product Description (SPD), version 1, length 25
<7> [110.901037] i915 0000:00:02.0: vendor: Intel
<7> [110.901039] i915 0000:00:02.0: product: Integrated gfx
<7> [110.901041] i915 0000:00:02.0: source device information: PC General (0x9)
<7> [110.901042] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] found:
<7> [110.901198] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:585:pipe D] fastset requirement not met in hdmi infoframe
<7> [110.901355] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] expected:
<7> [110.901511] i915 0000:00:02.0: HDMI infoframe: Vendor, version 1, length 4
<7> [110.901513] i915 0000:00:02.0: empty frame
<7> [110.901514] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] found:
<7> [110.901670] i915 0000:00:02.0: [drm:intel_atomic_check [i915]] [CRTC:585:pipe D] fastset requirement not met, forcing full modeset
<7> [110.901841] i915 0000:00:02.0: [drm:intel_dpll_crtc_put [i915]] [CRTC:585:pipe D] releasing DPLL 0
<7> [110.902057] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] [CRTC:171:pipe A] dbuf slices 0x0 -> 0x3, ddb (0 - 0) -> (0 - 2048), active pipes 0x8 -> 0x1
<7> [110.902217] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] [CRTC:585:pipe D] dbuf slices 0x3 -> 0x0, ddb (0 - 2048) -> (0 - 0), active pipes 0x8 -> 0x1
<7> [110.902379] i915 0000:00:02.0: [drm:skl_print_plane_ddb_changes [i915]] [PLANE:35:plane 1A] ddb ( 0 - 0) -> ( 0 - 1993), size 0 -> 1993
<7> [110.902537] i915 0000:00:02.0: [drm:skl_print_plane_ddb_changes [i915]] [PLANE:165:cursor A] ddb ( 0 - 0) -> (1993 - 2048), size 0 -> 55
<7> [110.902693] i915 0000:00:02.0: [drm:skl_print_plane_wm_changes [i915]] [PLANE:35: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> [110.902868] i915 0000:00:02.0: [drm:skl_print_plane_wm_changes [i915]] [PLANE:35:plane 1A] lines 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0 -> 1, 8, 8, 8, 8, 11, 16, 16, 0, 0, 0
<7> [110.903027] i915 0000:00:02.0: [drm:skl_print_plane_wm_changes [i915]] [PLANE:35:plane 1A] blocks 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0 -> 16, 129, 129, 129, 129, 177, 257, 257, 30, 0, 0
<7> [110.903183] i915 0000:00:02.0: [drm:skl_print_plane_wm_changes [i915]] [PLANE:35:plane 1A] min_ddb 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0 -> 19, 143, 143, 143, 143, 196, 284, 284, 31, 0, 0
<7> [110.903342] i915 0000:00:02.0: [drm:skl_print_plane_ddb_changes [i915]] [PLANE:579:cursor D] ddb (1993 - 2048) -> ( 0 - 0), size 55 -> 0
<7> [110.903519] i915 0000:00:02.0: [drm:intel_bw_atomic_check [i915]] [CRTC:171:pipe A] data rate 1142000 num active planes 1
<7> [110.903683] i915 0000:00:02.0: [drm:intel_bw_atomic_check [i915]] QGV point 0: max bw 14993 required 1142
<7> [110.903863] i915 0000:00:02.0: [drm:intel_bw_atomic_check [i915]] No SAGV, using single QGV point mask 0x1
<7> [110.904046] i915 0000:00:02.0: [drm:intel_cdclk_atomic_check [i915]] [CRTC:171:pipe A] min cdclk: 0 kHz -> 192000 kHz
<7> [110.904209] i915 0000:00:02.0: [drm:intel_cdclk_atomic_check [i915]] [CRTC:585:pipe D] min cdclk: 192000 kHz -> 0 kHz
<7> [110.904393] i915 0000:00:02.0: [drm:intel_find_dpll [i915]] [CRTC:171:pipe A] allocated DPLL 0
<7> [110.904562] i915 0000:00:02.0: [drm:intel_dpll_crtc_get [i915]] [CRTC:171:pipe A] reserving DPLL 0
<7> [110.904734] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [CRTC:171:pipe A] enable: yes [modeset]
<7> [110.904918] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] active: yes, output_types: HDMI (0x40), output format: RGB, sink format: RGB
<7> [110.905082] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] cpu_transcoder: A, pipe bpp: 24, dithering: 0
<7> [110.905242] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] MST master transcoder: <invalid>
<7> [110.905401] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] port sync: master transcoder: <invalid>, slave transcoder bitmask = 0x0
<7> [110.905562] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] joiner: no, pipes: 0x0
<7> [110.905720] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] splitter: disabled, link count 0, overlap 0
<7> [110.905896] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] audio: 1, infoframes: 1, infoframes enabled: 0x71
<7> [110.906055] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] GCP: 0x0
<7> [110.906213] i915 0000:00:02.0: HDMI infoframe: Auxiliary Video Information (AVI), version 2, length 13
<7> [110.906215] i915 0000:00:02.0: colorspace: RGB
<7> [110.906217] i915 0000:00:02.0: scan mode: Underscan
<7> [110.906219] i915 0000:00:02.0: colorimetry: No Data
<7> [110.906220] i915 0000:00:02.0: picture aspect: No Data
<7> [110.906222] i915 0000:00:02.0: active aspect: Same as Picture
<7> [110.906224] i915 0000:00:02.0: itc: No Data
<7> [110.906225] i915 0000:00:02.0: extended colorimetry: xvYCC 601
<7> [110.906227] i915 0000:00:02.0: quantization range: Full
<7> [110.906228] i915 0000:00:02.0: nups: Unknown Non-uniform Scaling
<7> [110.906230] i915 0000:00:02.0: video code: 0
<7> [110.906232] i915 0000:00:02.0: ycc quantization range: Full
<7> [110.906233] i915 0000:00:02.0: hdmi content type: Graphics
<7> [110.906235] i915 0000:00:02.0: pixel repeat: 0
<7> [110.906236] i915 0000:00:02.0: bar top 0, bottom 0, left 0, right 0
<7> [110.906238] i915 0000:00:02.0: HDMI infoframe: Source Product Description (SPD), version 1, length 25
<7> [110.906240] i915 0000:00:02.0: vendor: Intel
<7> [110.906242] i915 0000:00:02.0: product: Integrated gfx
<7> [110.906243] i915 0000:00:02.0: source device information: PC General (0x9)
<7> [110.906245] i915 0000:00:02.0: HDMI infoframe: Vendor, version 1, length 4
<7> [110.906247] i915 0000:00:02.0: empty frame
<7> [110.906249] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] ELD: 10 00 0f 00 6d a2 00 7f 00 00 00 00 00 00 00 00
<7> [110.906407] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] ELD: 0d 82 34 12 66 69 74 48 65 61 64 6c 65 73 73 47
<7> [110.906565] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] ELD: 53 7f 7f 28 0f 7f 07 17 7f ff 3f 7f ff 47 7f ff
<7> [110.906722] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] ELD: 5f 7f 82 7f 7f 00 7f 7f 51 7f 7f 30 77 7f 03 00
<7> [110.906898] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] scanline offset: 2
<7> [110.907057] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] framestart delay: 1, MSA timing delay: 0, set context latency: 0
<7> [110.907215] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] vrr: no, fixed rr: yes, vmin: 1144, vmax: 1144, flipline: 1144, pipeline full: 61, guardband: 63 vsync start: 0, vsync end: 0
<7> [110.907374] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] vrr: vmin vblank: 1081, vmax vblank: 1081, vmin vtotal: 1144, vmax vtotal: 1144
<7> [110.907532] 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> [110.907690] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] requested mode: "1920x1080": 120 285500 1920 1968 2000 2080 1080 1083 1088 1144 0x48 0x5
<7> [110.907862] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] adjusted mode: "1920x1080": 120 285500 1920 1968 2000 2080 1080 1083 1088 1144 0x48 0x5
<7> [110.908019] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] crtc timings: clock=285500, hd=1920 hb=1920-2080 hs=1968-2000 ht=2080, vd=1080 vb=1080-1144 vs=1083-1088 vt=1144, flags=0x5
<7> [110.908178] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pipe mode: "1920x1080": 120 285500 1920 1968 2000 2080 1080 1083 1088 1144 0x40 0x5
<7> [110.908336] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] crtc timings: clock=285500, hd=1920 hb=1920-2080 hs=1968-2000 ht=2080, vd=1080 vb=1080-1144 vs=1083-1088 vt=1144, flags=0x5
<7> [110.908494] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] port clock: 285500, pixel rate 285500, min cdclk 192000, min voltage level 0
<7> [110.908651] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] linetime: 59, ips linetime: 0
<7> [110.908822] 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> [110.908979] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pipe src: 1920x1080+0+0
<7> [110.909137] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pch pfit: 0x0+0+0, disabled, force thru: no
<7> [110.909294] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] sharpness strength: 0, sharpness tap size: 0, sharpness enable: 0
<7> [110.909472] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] ips: 0, double wide: 0, drrs: 0
<7> [110.909628] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] dpll_hw_state: cfgcr0: 0x1801be, cfgcr1: 0x488, div0: 0x0, mg_refclkin_ctl: 0x0, hg_clktop2_coreclkctl1: 0x0, mg_clktop2_hsclkctl: 0x0, mg_pll_div0: 0x0, mg_pll_div2: 0x0, mg_pll_lf: 0x0, mg_pll_frac_lock: 0x0, mg_pll_ssc: 0x0, mg_pll_bias: 0x0, mg_pll_tdc_coldst_bias: 0x0
<7> [110.909800] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] csc_mode: 0x0 gamma_mode: 0x0 gamma_enable: 0 csc_enable: 0
<7> [110.909957] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pre csc lut: 0 entries, post csc lut: 0 entries
<7> [110.910114] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] output csc: pre offsets: 0x0000 0x0000 0x0000
<7> [110.910271] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] output csc: coefficients: 0x0000 0x0000 0x0000
<7> [110.910427] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] output csc: coefficients: 0x0000 0x0000 0x0000
<7> [110.910583] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] output csc: coefficients: 0x0000 0x0000 0x0000
<7> [110.910748] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] output csc: post offsets: 0x0000 0x0000 0x0000
<7> [110.910905] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pipe csc: pre offsets: 0x0000 0x0000 0x0000
<7> [110.911061] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pipe csc: coefficients: 0x0000 0x0000 0x0000
<7> [110.911219] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pipe csc: coefficients: 0x0000 0x0000 0x0000
<7> [110.911376] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pipe csc: coefficients: 0x0000 0x0000 0x0000
<7> [110.911533] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pipe csc: post offsets: 0x0000 0x0000 0x0000
<7> [110.911690] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:35:plane 1A] fb: [FB:635] 1920x1080 format = XR24 little-endian (0x34325258) modifier = 0x0, visible: yes
<7> [110.911868] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] rotation: 0x1, scaler: -1, scaling_filter: 0
<7> [110.912025] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] src: 1920.000000x1080.000000+0.000000+0.000000 dst: 1920x1080+0+0
<7> [110.912183] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:65:plane 2A] fb: [NOFB], visible: no
<7> [110.912340] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:95:plane 3A] fb: [NOFB], visible: no
<7> [110.912497] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:125:plane 4A] fb: [NOFB], visible: no
<7> [110.912654] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:135:plane 5A] fb: [NOFB], visible: no
<7> [110.912864] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:145:plane 6A] fb: [NOFB], visible: no
<7> [110.913031] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:155:plane 7A] fb: [NOFB], visible: no
<7> [110.913188] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:165:cursor A] fb: [NOFB], visible: no
<7> [110.913345] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [CRTC:585:pipe D] enable: no [modeset]
<7> [110.913503] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:449:plane 1D] fb: [NOFB], visible: no
<7> [110.913661] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:479:plane 2D] fb: [NOFB], visible: no
<7> [110.913834] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:509:plane 3D] fb: [NOFB], visible: no
<7> [110.913992] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:539:plane 4D] fb: [NOFB], visible: no
<7> [110.914150] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:549:plane 5D] fb: [NOFB], visible: no
<7> [110.914306] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:559:plane 6D] fb: [NOFB], visible: no
<7> [110.914464] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:569:plane 7D] fb: [NOFB], visible: no
<7> [110.914621] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:579:cursor D] fb: [NOFB], visible: no
<7> [110.914975] i915 0000:00:02.0: [drm:intel_audio_codec_disable [i915]] [CONNECTOR:588:HDMI-A-1][ENCODER:587:DDI B/PHY B] Disable audio codec on [CRTC:585:pipe D]
<7> [110.929064] i915 0000:00:02.0: [drm:intel_audio_component_get_eld [i915]] Not valid for port B
<7> [110.933462] i915 0000:00:02.0: [drm:intel_hdmi_handle_sink_scrambling [i915]] [CONNECTOR:588:HDMI-A-1] scrambling=no, TMDS bit clock ratio=1/10
<7> [110.934268] i915 0000:00:02.0: [drm:do_gmbus_xfer [i915]] GMBUS [i915 gmbus dpb] NAK for addr: 0054 w(1)
<7> [110.934431] i915 0000:00:02.0: [drm:do_gmbus_xfer [i915]] GMBUS [i915 gmbus dpb] NAK on first message, retry
<7> [110.935380] i915 0000:00:02.0: [drm:do_gmbus_xfer [i915]] GMBUS [i915 gmbus dpb] NAK for addr: 0054 w(1)
<7> [110.935653] i915 0000:00:02.0: [drm:drm_scdc_set_high_tmds_clock_ratio [drm_display_helper]] [CONNECTOR:588:HDMI-A-1] Failed to read TMDS config: -6
<7> [110.935681] i915 0000:00:02.0: [drm:intel_ddi_disable [i915]] [CONNECTOR:588:HDMI-A-1] Failed to reset sink scrambling/TMDS bit clock ratio
<7> [110.936108] i915 0000:00:02.0: [drm:intel_disable_transcoder [i915]] disabling pipe D
<7> [110.937627] i915 0000:00:02.0: [drm:intel_power_well_disable [i915]] disabling DDI_IO_B
<7> [110.937921] i915 0000:00:02.0: [drm:intel_dpll_disable [i915]] disable DPLL 0 (active 0x8, on? 1) for [CRTC:585:pipe D]
<7> [110.938165] i915 0000:00:02.0: [drm:intel_dpll_disable [i915]] disabling DPLL 0
<7> [110.938352] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:587:DDI B/PHY B]
<7> [110.938518] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:597:DDI TC1/PHY TC1]
<7> [110.938703] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:599:DP-MST A]
<7> [110.938865] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:600:DP-MST B]
<7> [110.939024] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:601:DP-MST C]
<7> [110.939184] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:602:DP-MST D]
<7> [110.939342] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:607:DDI TC2/PHY TC2]
<7> [110.939502] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:609:DP-MST A]
<7> [110.939683] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:610:DP-MST B]
<7> [110.939845] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:611:DP-MST C]
<7> [110.940005] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:612:DP-MST D]
<7> [110.940163] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:616:DDI TC3/PHY TC3]
<7> [110.940321] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:618:DP-MST A]
<7> [110.940478] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:619:DP-MST B]
<7> [110.940651] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:620:DP-MST C]
<7> [110.940809] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:621:DP-MST D]
<7> [110.940966] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:625:DDI TC4/PHY TC4]
<7> [110.941122] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:627:DP-MST A]
<7> [110.941279] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:628:DP-MST B]
<7> [110.941434] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:629:DP-MST C]
<7> [110.941604] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:630:DP-MST D]
<7> [110.942014] i915 0000:00:02.0: [drm:intel_dpll_enable [i915]] enable DPLL 0 (active 0x1, on? 0) for [CRTC:171:pipe A]
<7> [110.942184] i915 0000:00:02.0: [drm:intel_dpll_enable [i915]] enabling DPLL 0
<7> [110.942655] i915 0000:00:02.0: [drm:intel_power_well_enable [i915]] enabling DDI_IO_B
<7> [110.942924] i915 0000:00:02.0: [drm:intel_enable_transcoder [i915]] enabling pipe A
<7> [110.943836] i915 0000:00:02.0: [drm:intel_hdmi_handle_sink_scrambling [i915]] [CONNECTOR:588:HDMI-A-1] scrambling=no, TMDS bit clock ratio=1/10
<7> [110.944493] i915 0000:00:02.0: [drm:do_gmbus_xfer [i915]] GMBUS [i915 gmbus dpb] NAK for addr: 0054 w(1)
<7> [110.944873] i915 0000:00:02.0: [drm:do_gmbus_xfer [i915]] GMBUS [i915 gmbus dpb] NAK on first message, retry
<7> [110.945490] i915 0000:00:02.0: [drm:do_gmbus_xfer [i915]] GMBUS [i915 gmbus dpb] NAK for addr: 0054 w(1)
<7> [110.945671] i915 0000:00:02.0: [drm:drm_scdc_set_high_tmds_clock_ratio [drm_display_helper]] [CONNECTOR:588:HDMI-A-1] Failed to read TMDS config: -6
<7> [110.945689] i915 0000:00:02.0: [drm:intel_ddi_enable [i915]] [CONNECTOR:588:HDMI-A-1] Failed to configure sink scrambling/TMDS bit clock ratio
<7> [110.954334] i915 0000:00:02.0: [drm:intel_fbc_update [i915]] reserved 17694720 bytes of contiguous stolen space for FBC, limit: 1
<7> [110.954546] i915 0000:00:02.0: [drm:intel_fbc_update [i915]] Enabling FBC on [PLANE:35:plane 1A]
<7> [110.962724] i915 0000:00:02.0: [drm:intel_audio_codec_enable [i915]] [CONNECTOR:588:HDMI-A-1][ENCODER:587:DDI B/PHY B] Enable audio codec on [CRTC:171:pipe A], 64 bytes ELD
<7> [110.971040] i915 0000:00:02.0: [drm:audio_config_hdmi_pixel_clock [i915]] HDMI audio pixel clock setting for 285500 not found, falling back to defaults
<7> [110.971245] i915 0000:00:02.0: [drm:audio_config_hdmi_pixel_clock [i915]] Configuring HDMI audio for pixel clock 25200 (0x00010000)
<7> [110.971432] i915 0000:00:02.0: [drm:hsw_audio_config_update [i915]] using automatic N
<6> [110.971605] snd_hda_codec_intelhdmi hdaudioC0D2: HDMI: audio coding xtype 5 not expected
<6> [110.971615] snd_hda_codec_intelhdmi hdaudioC0D2: HDMI: audio coding xtype 0 not expected
<6> [110.971617] snd_hda_codec_intelhdmi hdaudioC0D2: HDMI: audio coding xtype 10 not expected
<6> [110.971619] snd_hda_codec_intelhdmi hdaudioC0D2: HDMI: audio coding xtype 6 not expected
<7> [110.971770] i915 0000:00:02.0: [drm:verify_connector_state [i915]] [CONNECTOR:588:HDMI-A-1]
<7> [110.972041] i915 0000:00:02.0: [drm:intel_modeset_verify_crtc [i915]] [CRTC:171:pipe A]
<7> [110.972859] i915 0000:00:02.0: [drm:intel_power_well_disable [i915]] disabling PW_5
<7> [110.973205] i915 0000:00:02.0: [drm:intel_modeset_verify_crtc [i915]] [CRTC:585:pipe D]
<7> [110.973631] i915 0000:00:02.0: [drm:intel_power_well_disable [i915]] disabling PW_4
<7> [110.973943] i915 0000:00:02.0: [drm:intel_audio_component_get_power [i915]] restored AUD_FREQ_CNTRL to 0x810
<7> [110.974054] i915 0000:00:02.0: [drm:drm_client_dev_restore] fbdev: ret=0
|