igt@kms_flip@flip-vs-expired-vblank-interruptible@a-hdmi-a3 on shard-dg2@Patchwork

Detail	Value
Duration	6.39 seconds
Hostname	shard-dg2-8
Igt-Version	IGT-Version: 2.4-ge68d82b44 (x86_64) (Linux: 7.1.0-rc3-Patchwork_165436v2-g896e027423be+ x86_64)
Out	Using IGT_SRANDOM=1778722082 for randomisation Opened device: /dev/dri/card0 Using monotonic timestamps Starting subtest: flip-vs-expired-vblank-interruptible Starting dynamic subtest: A-HDMI-A3 1920x1080: 60 148500 1920 2008 2052 2200 1080 1084 1089 1125 0x48 0x5 Stack trace: #0 ../lib/igt_core.c:2074 __igt_fail_assert() #1 ../tests/kms_flip.c:926 run_test_on_crtc_set() #2 ../tests/kms_flip.c:1920 run_test() #3 ../tests/kms_flip.c:2220 __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 A-HDMI-A3: FAIL (6.390s)
Err	Starting subtest: flip-vs-expired-vblank-interruptible Starting dynamic subtest: A-HDMI-A3 [201.074745] (kms_flip:2155) CRITICAL: Test assertion failure function run_test_step, file ../tests/kms_flip.c:931: [201.074814] (kms_flip:2155) CRITICAL: Failed assertion: end - start < 500 [201.074868] (kms_flip:2155) CRITICAL: Last errno: 4, Interrupted system call Dynamic subtest A-HDMI-A3 failed. ** DEBUG [199.057350] (kms_flip:2155) DEBUG: Vblank took 48us [199.073953] (kms_flip:2155) DEBUG: name = flip last_ts = 199.145599 last_received_ts = 199.145203 last_seq = 6263 current_ts = 199.162262 current_received_ts = 199.161865 current_seq = 6264 count = 244 seq_step = 1 [199.074011] (kms_flip:2155) DEBUG: Vblank took 49us [199.090617] (kms_flip:2155) DEBUG: name = flip last_ts = 199.162262 last_received_ts = 199.161865 last_seq = 6264 current_ts = 199.178940 current_received_ts = 199.178528 current_seq = 6265 count = 245 seq_step = 1 [199.090674] (kms_flip:2155) DEBUG: Vblank took 48us [199.107293] (kms_flip:2155) DEBUG: name = flip last_ts = 199.178940 last_received_ts = 199.178528 last_seq = 6265 current_ts = 199.195602 current_received_ts = 199.195206 current_seq = 6266 count = 246 seq_step = 1 [199.107350] (kms_flip:2155) DEBUG: Vblank took 48us [199.123955] (kms_flip:2155) DEBUG: name = flip last_ts = 199.195602 last_received_ts = 199.195206 last_seq = 6266 current_ts = 199.212265 current_received_ts = 199.211868 current_seq = 6267 count = 247 seq_step = 1 [199.124013] (kms_flip:2155) DEBUG: Vblank took 48us [199.140617] (kms_flip:2155) DEBUG: name = flip last_ts = 199.212265 last_received_ts = 199.211868 last_seq = 6267 current_ts = 199.228943 current_received_ts = 199.228531 current_seq = 6268 count = 248 seq_step = 1 [199.140674] (kms_flip:2155) DEBUG: Vblank took 47us [199.157293] (kms_flip:2155) DEBUG: name = flip last_ts = 199.228943 last_received_ts = 199.228531 last_seq = 6268 current_ts = 199.245605 current_received_ts = 199.245209 current_seq = 6269 count = 249 seq_step = 1 [199.157351] (kms_flip:2155) DEBUG: Vblank took 48us [199.173960] (kms_flip:2155) DEBUG: name = flip last_ts = 199.245605 last_received_ts = 199.245209 last_seq = 6269 current_ts = 199.262268 current_received_ts = 199.261871 current_seq = 6270 count = 250 seq_step = 1 [199.174017] (kms_flip:2155) DEBUG: Vblank took 48us [199.190553] (kms_flip:2155) DEBUG: name = flip last_ts = 199.262268 last_received_ts = 199.261871 last_seq = 6270 current_ts = 199.278946 current_received_ts = 199.278458 current_seq = 6271 count = 251 seq_step = 1 [199.190610] (kms_flip:2155) DEBUG: Vblank took 48us [199.207343] (kms_flip:2155) DEBUG: name = flip last_ts = 199.278946 last_received_ts = 199.278458 last_seq = 6271 current_ts = 199.295609 current_received_ts = 199.295242 current_seq = 6272 count = 252 seq_step = 1 [199.207409] (kms_flip:2155) DEBUG: Vblank took 53us [199.223979] (kms_flip:2155) DEBUG: name = flip last_ts = 199.295609 last_received_ts = 199.295242 last_seq = 6272 current_ts = 199.312271 current_received_ts = 199.311890 current_seq = 6273 count = 253 seq_step = 1 [199.224041] (kms_flip:2155) DEBUG: Vblank took 51us [199.240587] (kms_flip:2155) DEBUG: name = flip last_ts = 199.312271 last_received_ts = 199.311890 last_seq = 6273 current_ts = 199.328949 current_received_ts = 199.328491 current_seq = 6274 count = 254 seq_step = 1 [199.240648] (kms_flip:2155) DEBUG: Vblank took 51us [199.257318] (kms_flip:2155) DEBUG: name = flip last_ts = 199.328949 last_received_ts = 199.328491 last_seq = 6274 current_ts = 199.345612 current_received_ts = 199.345230 current_seq = 6275 count = 255 seq_step = 1 [199.257379] (kms_flip:2155) DEBUG: Vblank took 50us [199.273982] (kms_flip:2155) DEBUG: name = flip last_ts = 199.345612 last_received_ts = 199.345230 last_seq = 6275 current_ts = 199.362274 current_received_ts = 199.361893 current_seq = 6276 count = 256 seq_step = 1 [199.274043] (kms_flip:2155) DEBUG: Vblank took 50us [199.290614] (kms_flip:2155) DEBUG: name = flip last_ts = 199.362274 last_received_ts = 199.361893 last_seq = 6276 current_ts = 199.378937 current_received_ts = 199.378525 current_seq = 6277 count = 257 seq_step = 1 [199.290675] (kms_flip:2155) DEBUG: Vblank took 50us [199.307322] (kms_flip:2155) DEBUG: name = flip last_ts = 199.378937 last_received_ts = 199.378525 last_seq = 6277 current_ts = 199.395615 current_received_ts = 199.395233 current_seq = 6278 count = 258 seq_step = 1 [199.307383] (kms_flip:2155) DEBUG: Vblank took 50us [199.323977] (kms_flip:2155) DEBUG: name = flip last_ts = 199.395615 last_received_ts = 199.395233 last_seq = 6278 current_ts = 199.412277 current_received_ts = 199.411880 current_seq = 6279 count = 259 seq_step = 1 [199.324038] (kms_flip:2155) DEBUG: Vblank took 51us [199.340526] (kms_flip:2155) DEBUG: name = flip last_ts = 199.412277 last_received_ts = 199.411880 last_seq = 6279 current_ts = 199.428940 current_received_ts = 199.428436 current_seq = 6280 count = 260 seq_step = 1 [199.340586] (kms_flip:2155) DEBUG: Vblank took 50us [199.357334] (kms_flip:2155) DEBUG: name = flip last_ts = 199.428940 last_received_ts = 199.428436 last_seq = 6280 current_ts = 199.445618 current_received_ts = 199.445251 current_seq = 6281 count = 261 seq_step = 1 [199.357395] (kms_flip:2155) DEBUG: Vblank took 50us [199.373983] (kms_flip:2155) DEBUG: name = flip last_ts = 199.445618 last_received_ts = 199.445251 last_seq = 6281 current_ts = 199.462280 current_received_ts = 199.461899 current_seq = 6282 count = 262 seq_step = 1 [199.374044] (kms_flip:2155) DEBUG: Vblank took 51us [199.390677] (kms_flip:2155) DEBUG: name = flip last_ts = 199.462280 last_received_ts = 199.461899 last_seq = 6282 current_ts = 199.478943 current_received_ts = 199.478592 current_seq = 6283 count = 263 seq_step = 1 [199.390738] (kms_flip:2155) DEBUG: Vblank took 51us [199.407308] (kms_flip:2155) DEBUG: name = flip last_ts = 199.478943 last_received_ts = 199.478592 last_seq = 6283 current_ts = 199.495621 current_received_ts = 199.495224 current_seq = 6284 count = 264 seq_step = 1 [199.407366] (kms_flip:2155) DEBUG: Vblank took 49us [199.423983] (kms_flip:2155) DEBUG: name = flip last_ts = 199.495621 last_received_ts = 199.495224 last_seq = 6284 current_ts = 199.512283 current_received_ts = 199.511902 current_seq = 6285 count = 265 seq_step = 1 [199.424045] (kms_flip:2155) DEBUG: Vblank took 51us [199.440633] (kms_flip:2155) DEBUG: name = flip last_ts = 199.512283 last_received_ts = 199.511902 last_seq = 6285 current_ts = 199.528946 current_received_ts = 199.528549 current_seq = 6286 count = 266 seq_step = 1 [199.440690] (kms_flip:2155) DEBUG: Vblank took 47us [199.457339] (kms_flip:2155) DEBUG: name = flip last_ts = 199.528946 last_received_ts = 199.528549 last_seq = 6286 current_ts = 199.545609 current_received_ts = 199.545258 current_seq = 6287 count = 267 seq_step = 1 [199.457400] (kms_flip:2155) DEBUG: Vblank took 50us [199.473964] (kms_flip:2155) DEBUG: name = flip last_ts = 199.545609 last_received_ts = 199.545258 last_seq = 6287 current_ts = 199.562286 current_received_ts = 199.561874 current_seq = 6288 count = 268 seq_step = 1 [199.474022] (kms_flip:2155) DEBUG: Vblank took 48us [199.490588] (kms_flip:2155) DEBUG: name = flip last_ts = 199.562286 last_received_ts = 199.561874 last_seq = 6288 current_ts = 199.578949 current_received_ts = 199.578506 current_seq = 6289 count = 269 seq_step = 1 [199.490646] (kms_flip:2155) DEBUG: Vblank took 48us [199.507271] (kms_flip:2155) DEBUG: name = flip last_ts = 199.578949 last_received_ts = 199.578506 last_seq = 6289 current_ts = 199.595627 current_received_ts = 199.595184 current_seq = 6290 count = 270 seq_step = 1 [199.507332] (kms_flip:2155) DEBUG: Vblank took 50us [199.523886] (kms_flip:2155) DEBUG: name = flip last_ts = 199.595627 last_received_ts = 199.595184 last_seq = 6290 current_ts = 199.612289 current_received_ts = 199.611801 current_seq = 6291 count = 271 seq_step = 1 [199.523937] (kms_flip:2155) DEBUG: Vblank took 42us [199.540507] (kms_flip:2155) DEBUG: name = flip last_ts = 199.612289 last_received_ts = 199.611801 last_seq = 6291 current_ts = 199.628967 current_received_ts = 199.628433 current_seq = 6292 count = 272 seq_step = 1 [199.540547] (kms_flip:2155) DEBUG: Vblank took 35us [199.557150] (kms_flip:2155) DEBUG: name = flip last_ts = 199.628967 last_received_ts = 199.628433 last_seq = 6292 current_ts = 199.645630 current_received_ts = 199.645081 current_seq = 6293 count = 273 seq_step = 1 [199.557187] (kms_flip:2155) DEBUG: Vblank took 32us [199.573834] (kms_flip:2155) DEBUG: name = flip last_ts = 199.645630 last_received_ts = 199.645081 last_seq = 6293 current_ts = 199.662292 current_received_ts = 199.661758 current_seq = 6294 count = 274 seq_step = 1 [199.573870] (kms_flip:2155) DEBUG: Vblank took 32us [199.590501] (kms_flip:2155) DEBUG: name = flip last_ts = 199.662292 last_received_ts = 199.661758 last_seq = 6294 current_ts = 199.678955 current_received_ts = 199.678421 current_seq = 6295 count = 275 seq_step = 1 [199.590539] (kms_flip:2155) DEBUG: Vblank took 34us [199.607217] (kms_flip:2155) DEBUG: name = flip last_ts = 199.678955 last_received_ts = 199.678421 last_seq = 6295 current_ts = 199.695633 current_received_ts = 199.695145 current_seq = 6296 count = 276 seq_step = 1 [199.607257] (kms_flip:2155) DEBUG: Vblank took 35us [199.623837] (kms_flip:2155) DEBUG: name = flip last_ts = 199.695633 last_received_ts = 199.695145 last_seq = 6296 current_ts = 199.712296 current_received_ts = 199.711761 current_seq = 6297 count = 277 seq_step = 1 [199.623874] (kms_flip:2155) DEBUG: Vblank took 33us [199.640505] (kms_flip:2155) DEBUG: name = flip last_ts = 199.712296 last_received_ts = 199.711761 last_seq = 6297 current_ts = 199.728958 current_received_ts = 199.728424 current_seq = 6298 count = 278 seq_step = 1 [199.640543] (kms_flip:2155) DEBUG: Vblank took 33us [199.657173] (kms_flip:2155) DEBUG: name = flip last_ts = 199.728958 last_received_ts = 199.728424 last_seq = 6298 current_ts = 199.745636 current_received_ts = 199.745102 current_seq = 6299 count = 279 seq_step = 1 [199.657212] (kms_flip:2155) DEBUG: Vblank took 34us [199.673839] (kms_flip:2155) DEBUG: name = flip last_ts = 199.745636 last_received_ts = 199.745102 last_seq = 6299 current_ts = 199.762299 current_received_ts = 199.761765 current_seq = 6300 count = 280 seq_step = 1 [199.673879] (kms_flip:2155) DEBUG: Vblank took 33us [199.690489] (kms_flip:2155) DEBUG: name = flip last_ts = 199.762299 last_received_ts = 199.761765 last_seq = 6300 current_ts = 199.778961 current_received_ts = 199.778412 current_seq = 6301 count = 281 seq_step = 1 [199.690526] (kms_flip:2155) DEBUG: Vblank took 33us [199.707198] (kms_flip:2155) DEBUG: name = flip last_ts = 199.778961 last_received_ts = 199.778412 last_seq = 6301 current_ts = 199.795639 current_received_ts = 199.795120 current_seq = 6302 count = 282 seq_step = 1 [199.707243] (kms_flip:2155) DEBUG: Vblank took 40us [199.723839] (kms_flip:2155) DEBUG: name = flip last_ts = 199.795639 last_received_ts = 199.795120 last_seq = 6302 current_ts = 199.812302 current_received_ts = 199.811768 current_seq = 6303 count = 283 seq_step = 1 [199.723878] (kms_flip:2155) DEBUG: Vblank took 34us [199.740598] (kms_flip:2155) DEBUG: name = flip last_ts = 199.812302 last_received_ts = 199.811768 last_seq = 6303 current_ts = 199.828964 current_received_ts = 199.828522 current_seq = 6304 count = 284 seq_step = 1 [199.740635] (kms_flip:2155) DEBUG: Vblank took 33us [199.757284] (kms_flip:2155) DEBUG: name = flip last_ts = 199.828964 last_received_ts = 199.828522 last_seq = 6304 current_ts = 199.845627 current_received_ts = 199.845215 current_seq = 6305 count = 285 seq_step = 1 [199.757317] (kms_flip:2155) DEBUG: Vblank took 32us [199.773910] (kms_flip:2155) DEBUG: name = flip last_ts = 199.845627 last_received_ts = 199.845215 last_seq = 6305 current_ts = 199.862305 current_received_ts = 199.861847 current_seq = 6306 count = 286 seq_step = 1 [199.773944] (kms_flip:2155) DEBUG: Vblank took 32us [199.790579] (kms_flip:2155) DEBUG: name = flip last_ts = 199.862305 last_received_ts = 199.861847 last_seq = 6306 current_ts = 199.878967 current_received_ts = 199.878510 current_seq = 6307 count = 287 seq_step = 1 [199.790617] (kms_flip:2155) DEBUG: Vblank took 35us [199.807221] (kms_flip:2155) DEBUG: name = flip last_ts = 199.878967 last_received_ts = 199.878510 last_seq = 6307 current_ts = 199.895630 current_received_ts = 199.895157 current_seq = 6308 count = 288 seq_step = 1 [199.807266] (kms_flip:2155) DEBUG: Vblank took 40us [199.823995] (kms_flip:2155) DEBUG: name = flip last_ts = 199.895630 last_received_ts = 199.895157 last_seq = 6308 current_ts = 199.912292 current_received_ts = 199.911911 current_seq = 6309 count = 289 seq_step = 1 [199.824056] (kms_flip:2155) DEBUG: Vblank took 51us [199.840664] (kms_flip:2155) DEBUG: name = flip last_ts = 199.912292 last_received_ts = 199.911911 last_seq = 6309 current_ts = 199.928970 current_received_ts = 199.928589 current_seq = 6310 count = 290 seq_step = 1 [199.840725] (kms_flip:2155) DEBUG: Vblank took 50us [199.857374] (kms_flip:2155) DEBUG: name = flip last_ts = 199.928970 last_received_ts = 199.928589 last_seq = 6310 current_ts = 199.945648 current_received_ts = 199.945297 current_seq = 6311 count = 291 seq_step = 1 [199.857434] (kms_flip:2155) DEBUG: Vblank took 50us [199.873999] (kms_flip:2155) DEBUG: name = flip last_ts = 199.945648 last_received_ts = 199.945297 last_seq = 6311 current_ts = 199.962296 current_received_ts = 199.961929 current_seq = 6312 count = 292 seq_step = 1 [199.874081] (kms_flip:2155) DEBUG: Vblank took 71us [199.890664] (kms_flip:2155) DEBUG: name = flip last_ts = 199.962296 last_received_ts = 199.961929 last_seq = 6312 current_ts = 199.978973 current_received_ts = 199.978592 current_seq = 6313 count = 293 seq_step = 1 [199.890724] (kms_flip:2155) DEBUG: Vblank took 51us [199.907356] (kms_flip:2155) DEBUG: name = flip last_ts = 199.978973 last_received_ts = 199.978592 last_seq = 6313 current_ts = 199.995651 current_received_ts = 199.995285 current_seq = 6314 count = 294 seq_step = 1 [199.907417] (kms_flip:2155) DEBUG: Vblank took 51us [199.923936] (kms_flip:2155) DEBUG: name = flip last_ts = 199.995651 last_received_ts = 199.995285 last_seq = 6314 current_ts = 200.012314 current_received_ts = 200.011856 current_seq = 6315 count = 295 seq_step = 1 [199.923996] (kms_flip:2155) DEBUG: Vblank took 50us [199.940600] (kms_flip:2155) DEBUG: name = flip last_ts = 200.012314 last_received_ts = 200.011856 last_seq = 6315 current_ts = 200.028976 current_received_ts = 200.028519 current_seq = 6316 count = 296 seq_step = 1 [199.940661] (kms_flip:2155) DEBUG: Vblank took 50us [199.957284] (kms_flip:2155) DEBUG: name = flip last_ts = 200.028976 last_received_ts = 200.028519 last_seq = 6316 current_ts = 200.045639 current_received_ts = 200.045212 current_seq = 6317 count = 297 seq_step = 1 [199.957344] (kms_flip:2155) DEBUG: Vblank took 50us [199.973996] (kms_flip:2155) DEBUG: name = flip last_ts = 200.045639 last_received_ts = 200.045212 last_seq = 6317 current_ts = 200.062317 current_received_ts = 200.061920 current_seq = 6318 count = 298 seq_step = 1 [199.974080] (kms_flip:2155) DEBUG: Vblank took 73us [199.990615] (kms_flip:2155) DEBUG: name = flip last_ts = 200.062317 last_received_ts = 200.061920 last_seq = 6318 current_ts = 200.078979 current_received_ts = 200.078537 current_seq = 6319 count = 299 seq_step = 1 [199.990676] (kms_flip:2155) DEBUG: Vblank took 50us [200.007374] (kms_flip:2155) DEBUG: name = flip last_ts = 200.078979 last_received_ts = 200.078537 last_seq = 6319 current_ts = 200.095657 current_received_ts = 200.095306 current_seq = 6320 count = 300 seq_step = 1 [200.007435] (kms_flip:2155) DEBUG: Vblank took 51us [200.023978] (kms_flip:2155) DEBUG: name = flip last_ts = 200.095657 last_received_ts = 200.095306 last_seq = 6320 current_ts = 200.112305 current_received_ts = 200.111908 current_seq = 6321 count = 301 seq_step = 1 [200.024036] (kms_flip:2155) DEBUG: Vblank took 48us [200.040564] (kms_flip:2155) DEBUG: name = flip last_ts = 200.112305 last_received_ts = 200.111908 last_seq = 6321 current_ts = 200.128983 current_received_ts = 200.128494 current_seq = 6322 count = 302 seq_step = 1 [200.040624] (kms_flip:2155) DEBUG: Vblank took 50us [200.057355] (kms_flip:2155) DEBUG: name = flip last_ts = 200.128983 last_received_ts = 200.128494 last_seq = 6322 current_ts = 200.145645 current_received_ts = 200.145279 current_seq = 6323 count = 303 seq_step = 1 [200.057416] (kms_flip:2155) DEBUG: Vblank took 50us [200.073996] (kms_flip:2155) DEBUG: name = flip last_ts = 200.145645 last_received_ts = 200.145279 last_seq = 6323 current_ts = 200.162323 current_received_ts = 200.161926 current_seq = 6324 count = 304 seq_step = 1 [200.074083] (kms_flip:2155) DEBUG: Vblank took 76us [200.090628] (kms_flip:2155) DEBUG: name = flip last_ts = 200.162323 last_received_ts = 200.161926 last_seq = 6324 current_ts = 200.178986 current_received_ts = 200.178558 current_seq = 6325 count = 305 seq_step = 1 [200.090685] (kms_flip:2155) DEBUG: Vblank took 47us [200.107371] (kms_flip:2155) DEBUG: name = flip last_ts = 200.178986 last_received_ts = 200.178558 last_seq = 6325 current_ts = 200.195648 current_received_ts = 200.195297 current_seq = 6326 count = 306 seq_step = 1 [200.107431] (kms_flip:2155) DEBUG: Vblank took 51us [200.123981] (kms_flip:2155) DEBUG: name = flip last_ts = 200.195648 last_received_ts = 200.195297 last_seq = 6326 current_ts = 200.212311 current_received_ts = 200.211914 current_seq = 6327 count = 307 seq_step = 1 [200.124039] (kms_flip:2155) DEBUG: Vblank took 49us [200.140682] (kms_flip:2155) DEBUG: name = flip last_ts = 200.212311 last_received_ts = 200.211914 last_seq = 6327 current_ts = 200.228989 current_received_ts = 200.228607 current_seq = 6328 count = 308 seq_step = 1 [200.140742] (kms_flip:2155) DEBUG: Vblank took 50us [200.157341] (kms_flip:2155) DEBUG: name = flip last_ts = 200.228989 last_received_ts = 200.228607 last_seq = 6328 current_ts = 200.245651 current_received_ts = 200.245270 current_seq = 6329 count = 309 seq_step = 1 [200.157398] (kms_flip:2155) DEBUG: Vblank took 48us [200.173982] (kms_flip:2155) DEBUG: name = flip last_ts = 200.245651 last_received_ts = 200.245270 last_seq = 6329 current_ts = 200.262314 current_received_ts = 200.261917 current_seq = 6330 count = 310 seq_step = 1 [200.174040] (kms_flip:2155) DEBUG: Vblank took 48us [200.190648] (kms_flip:2155) DEBUG: name = flip last_ts = 200.262314 last_received_ts = 200.261917 last_seq = 6330 current_ts = 200.278976 current_received_ts = 200.278580 current_seq = 6331 count = 311 seq_step = 1 [200.190704] (kms_flip:2155) DEBUG: Vblank took 48us [200.207356] (kms_flip:2155) DEBUG: name = flip last_ts = 200.278976 last_received_ts = 200.278580 last_seq = 6331 current_ts = 200.295654 current_received_ts = 200.295288 current_seq = 6332 count = 312 seq_step = 1 [200.207413] (kms_flip:2155) DEBUG: Vblank took 47us [200.223942] (kms_flip:2155) DEBUG: name = flip last_ts = 200.295654 last_received_ts = 200.295288 last_seq = 6332 current_ts = 200.312332 current_received_ts = 200.311874 current_seq = 6333 count = 313 seq_step = 1 [200.224003] (kms_flip:2155) DEBUG: Vblank took 50us [200.240659] (kms_flip:2155) DEBUG: name = flip last_ts = 200.312332 last_received_ts = 200.311874 last_seq = 6333 current_ts = 200.328995 current_received_ts = 200.328598 current_seq = 6334 count = 314 seq_step = 1 [200.240715] (kms_flip:2155) DEBUG: Vblank took 47us [200.257360] (kms_flip:2155) DEBUG: name = flip last_ts = 200.328995 last_received_ts = 200.328598 last_seq = 6334 current_ts = 200.345657 current_received_ts = 200.345291 current_seq = 6335 count = 315 seq_step = 1 [200.257420] (kms_flip:2155) DEBUG: Vblank took 50us [200.273984] (kms_flip:2155) DEBUG: name = flip last_ts = 200.345657 last_received_ts = 200.345291 last_seq = 6335 current_ts = 200.362320 current_received_ts = 200.361923 current_seq = 6336 count = 316 seq_step = 1 [200.274042] (kms_flip:2155) DEBUG: Vblank took 48us [200.290657] (kms_flip:2155) DEBUG: name = flip last_ts = 200.362320 last_received_ts = 200.361923 last_seq = 6336 current_ts = 200.378983 current_received_ts = 200.378586 current_seq = 6337 count = 317 seq_step = 1 [200.290713] (kms_flip:2155) DEBUG: Vblank took 47us [200.307338] (kms_flip:2155) DEBUG: name = flip last_ts = 200.378983 last_received_ts = 200.378586 last_seq = 6337 current_ts = 200.395660 current_received_ts = 200.395279 current_seq = 6338 count = 318 seq_step = 1 [200.307395] (kms_flip:2155) DEBUG: Vblank took 48us [200.323985] (kms_flip:2155) DEBUG: name = flip last_ts = 200.395660 last_received_ts = 200.395279 last_seq = 6338 current_ts = 200.412323 current_received_ts = 200.411926 current_seq = 6339 count = 319 seq_step = 1 [200.324043] (kms_flip:2155) DEBUG: Vblank took 48us [200.340554] (kms_flip:2155) DEBUG: name = flip last_ts = 200.412323 last_received_ts = 200.411926 last_seq = 6339 current_ts = 200.428986 current_received_ts = 200.428497 current_seq = 6340 count = 320 seq_step = 1 [200.340612] (kms_flip:2155) DEBUG: Vblank took 48us [200.357343] (kms_flip:2155) DEBUG: name = flip last_ts = 200.428986 last_received_ts = 200.428497 last_seq = 6340 current_ts = 200.445663 current_received_ts = 200.445282 current_seq = 6341 count = 321 seq_step = 1 [200.357400] (kms_flip:2155) DEBUG: Vblank took 48us [200.373987] (kms_flip:2155) DEBUG: name = flip last_ts = 200.445663 last_received_ts = 200.445282 last_seq = 6341 current_ts = 200.462326 current_received_ts = 200.461929 current_seq = 6342 count = 322 seq_step = 1 [200.374045] (kms_flip:2155) DEBUG: Vblank took 48us [200.390570] (kms_flip:2155) DEBUG: name = flip last_ts = 200.462326 last_received_ts = 200.461929 last_seq = 6342 current_ts = 200.478989 current_received_ts = 200.478500 current_seq = 6343 count = 323 seq_step = 1 [200.390627] (kms_flip:2155) DEBUG: Vblank took 47us [200.407333] (kms_flip:2155) DEBUG: name = flip last_ts = 200.478989 last_received_ts = 200.478500 last_seq = 6343 current_ts = 200.495651 current_received_ts = 200.495270 current_seq = 6344 count = 324 seq_step = 1 [200.407390] (kms_flip:2155) DEBUG: Vblank took 48us [200.424007] (kms_flip:2155) DEBUG: name = flip last_ts = 200.495651 last_received_ts = 200.495270 last_seq = 6344 current_ts = 200.512344 current_received_ts = 200.511948 current_seq = 6345 count = 325 seq_step = 1 [200.424104] (kms_flip:2155) DEBUG: Vblank took 86us [200.440600] (kms_flip:2155) DEBUG: name = flip last_ts = 200.512344 last_received_ts = 200.511948 last_seq = 6345 current_ts = 200.529007 current_received_ts = 200.528534 current_seq = 6346 count = 326 seq_step = 1 [200.440658] (kms_flip:2155) DEBUG: Vblank took 49us [200.457339] (kms_flip:2155) DEBUG: name = flip last_ts = 200.529007 last_received_ts = 200.528534 last_seq = 6346 current_ts = 200.545670 current_received_ts = 200.545273 current_seq = 6347 count = 327 seq_step = 1 [200.457396] (kms_flip:2155) DEBUG: Vblank took 48us [200.474011] (kms_flip:2155) DEBUG: name = flip last_ts = 200.545670 last_received_ts = 200.545273 last_seq = 6347 current_ts = 200.562332 current_received_ts = 200.561951 current_seq = 6348 count = 328 seq_step = 1 [200.474096] (kms_flip:2155) DEBUG: Vblank took 74us [200.490603] (kms_flip:2155) DEBUG: name = flip last_ts = 200.562332 last_received_ts = 200.561951 last_seq = 6348 current_ts = 200.579010 current_received_ts = 200.578537 current_seq = 6349 count = 329 seq_step = 1 [200.490660] (kms_flip:2155) DEBUG: Vblank took 48us [200.507333] (kms_flip:2155) DEBUG: name = flip last_ts = 200.579010 last_received_ts = 200.578537 last_seq = 6349 current_ts = 200.595673 current_received_ts = 200.595276 current_seq = 6350 count = 330 seq_step = 1 [200.507390] (kms_flip:2155) DEBUG: Vblank took 48us [200.523991] (kms_flip:2155) DEBUG: name = flip last_ts = 200.595673 last_received_ts = 200.595276 last_seq = 6350 current_ts = 200.612335 current_received_ts = 200.611938 current_seq = 6351 count = 331 seq_step = 1 [200.524079] (kms_flip:2155) DEBUG: Vblank took 78us [200.540603] (kms_flip:2155) DEBUG: name = flip last_ts = 200.612335 last_received_ts = 200.611938 last_seq = 6351 current_ts = 200.628998 current_received_ts = 200.628540 current_seq = 6352 count = 332 seq_step = 1 [200.540661] (kms_flip:2155) DEBUG: Vblank took 48us [200.557337] (kms_flip:2155) DEBUG: name = flip last_ts = 200.628998 last_received_ts = 200.628540 last_seq = 6352 current_ts = 200.645660 current_received_ts = 200.645279 current_seq = 6353 count = 333 seq_step = 1 [200.557394] (kms_flip:2155) DEBUG: Vblank took 48us [200.573991] (kms_flip:2155) DEBUG: name = flip last_ts = 200.645660 last_received_ts = 200.645279 last_seq = 6353 current_ts = 200.662338 current_received_ts = 200.661926 current_seq = 6354 count = 334 seq_step = 1 [200.574073] (kms_flip:2155) DEBUG: Vblank took 71us [200.590606] (kms_flip:2155) DEBUG: name = flip last_ts = 200.662338 last_received_ts = 200.661926 last_seq = 6354 current_ts = 200.679016 current_received_ts = 200.678543 current_seq = 6355 count = 335 seq_step = 1 [200.590664] (kms_flip:2155) DEBUG: Vblank took 48us [200.607328] (kms_flip:2155) DEBUG: name = flip last_ts = 200.679016 last_received_ts = 200.678543 last_seq = 6355 current_ts = 200.695663 current_received_ts = 200.695267 current_seq = 6356 count = 336 seq_step = 1 [200.607385] (kms_flip:2155) DEBUG: Vblank took 48us [200.623998] (kms_flip:2155) DEBUG: name = flip last_ts = 200.695663 last_received_ts = 200.695267 last_seq = 6356 current_ts = 200.712341 current_received_ts = 200.711945 current_seq = 6357 count = 337 seq_step = 1 [200.624076] (kms_flip:2155) DEBUG: Vblank took 67us [200.640614] (kms_flip:2155) DEBUG: name = flip last_ts = 200.712341 last_received_ts = 200.711945 last_seq = 6357 current_ts = 200.729004 current_received_ts = 200.728561 current_seq = 6358 count = 338 seq_step = 1 [200.640672] (kms_flip:2155) DEBUG: Vblank took 48us [200.657341] (kms_flip:2155) DEBUG: name = flip last_ts = 200.729004 last_received_ts = 200.728561 last_seq = 6358 current_ts = 200.745667 current_received_ts = 200.745285 current_seq = 6359 count = 339 seq_step = 1 [200.657399] (kms_flip:2155) DEBUG: Vblank took 48us [200.673996] (kms_flip:2155) DEBUG: name = flip last_ts = 200.745667 last_received_ts = 200.745285 last_seq = 6359 current_ts = 200.762344 current_received_ts = 200.761932 current_seq = 6360 count = 340 seq_step = 1 [200.674087] (kms_flip:2155) DEBUG: Vblank took 81us [200.690614] (kms_flip:2155) DEBUG: name = flip last_ts = 200.762344 last_received_ts = 200.761932 last_seq = 6360 current_ts = 200.779007 current_received_ts = 200.778564 current_seq = 6361 count = 341 seq_step = 1 [200.690671] (kms_flip:2155) DEBUG: Vblank took 48us [200.707333] (kms_flip:2155) DEBUG: name = flip last_ts = 200.779007 last_received_ts = 200.778564 last_seq = 6361 current_ts = 200.795685 current_received_ts = 200.795273 current_seq = 6362 count = 342 seq_step = 1 [200.707390] (kms_flip:2155) DEBUG: Vblank took 47us [200.724002] (kms_flip:2155) DEBUG: name = flip last_ts = 200.795685 last_received_ts = 200.795273 last_seq = 6362 current_ts = 200.812347 current_received_ts = 200.811951 current_seq = 6363 count = 343 seq_step = 1 [200.724083] (kms_flip:2155) DEBUG: Vblank took 72us [200.740602] (kms_flip:2155) DEBUG: name = flip last_ts = 200.812347 last_received_ts = 200.811951 last_seq = 6363 current_ts = 200.829010 current_received_ts = 200.828552 current_seq = 6364 count = 344 seq_step = 1 [200.740659] (kms_flip:2155) DEBUG: Vblank took 48us [200.757323] (kms_flip:2155) DEBUG: name = flip last_ts = 200.829010 last_received_ts = 200.828552 last_seq = 6364 current_ts = 200.845688 current_received_ts = 200.845276 current_seq = 6365 count = 345 seq_step = 1 [200.757381] (kms_flip:2155) DEBUG: Vblank took 48us [200.774002] (kms_flip:2155) DEBUG: name = flip last_ts = 200.845688 last_received_ts = 200.845276 last_seq = 6365 current_ts = 200.862350 current_received_ts = 200.861954 current_seq = 6366 count = 346 seq_step = 1 [200.774096] (kms_flip:2155) DEBUG: Vblank took 85us [200.790605] (kms_flip:2155) DEBUG: name = flip last_ts = 200.862350 last_received_ts = 200.861954 last_seq = 6366 current_ts = 200.879013 current_received_ts = 200.878555 current_seq = 6367 count = 347 seq_step = 1 [200.790662] (kms_flip:2155) DEBUG: Vblank took 48us [200.807330] (kms_flip:2155) DEBUG: name = flip last_ts = 200.879013 last_received_ts = 200.878555 last_seq = 6367 current_ts = 200.895676 current_received_ts = 200.895279 current_seq = 6368 count = 348 seq_step = 1 [200.807387] (kms_flip:2155) DEBUG: Vblank took 47us [200.823996] (kms_flip:2155) DEBUG: name = flip last_ts = 200.895676 last_received_ts = 200.895279 last_seq = 6368 current_ts = 200.912338 current_received_ts = 200.911942 current_seq = 6369 count = 349 seq_step = 1 [200.824095] (kms_flip:2155) DEBUG: Vblank took 88us [200.840665] (kms_flip:2155) DEBUG: name = flip last_ts = 200.912338 last_received_ts = 200.911942 last_seq = 6369 current_ts = 200.929016 current_received_ts = 200.928619 current_seq = 6370 count = 350 seq_step = 1 [200.840721] (kms_flip:2155) DEBUG: Vblank took 47us [200.857330] (kms_flip:2155) DEBUG: name = flip last_ts = 200.929016 last_received_ts = 200.928619 last_seq = 6370 current_ts = 200.945679 current_received_ts = 200.945282 current_seq = 6371 count = 351 seq_step = 1 [200.857387] (kms_flip:2155) DEBUG: Vblank took 47us [200.873996] (kms_flip:2155) DEBUG: name = flip last_ts = 200.945679 last_received_ts = 200.945282 last_seq = 6371 current_ts = 200.962357 current_received_ts = 200.961945 current_seq = 6372 count = 352 seq_step = 1 [200.874087] (kms_flip:2155) DEBUG: Vblank took 81us [200.890695] (kms_flip:2155) DEBUG: name = flip last_ts = 200.962357 last_received_ts = 200.961945 last_seq = 6372 current_ts = 200.979019 current_received_ts = 200.978638 current_seq = 6373 count = 353 seq_step = 1 [200.890753] (kms_flip:2155) DEBUG: Vblank took 49us [200.907324] (kms_flip:2155) DEBUG: name = flip last_ts = 200.979019 last_received_ts = 200.978638 last_seq = 6373 current_ts = 200.995682 current_received_ts = 200.995270 current_seq = 6374 count = 354 seq_step = 1 [200.907381] (kms_flip:2155) DEBUG: Vblank took 48us [200.924008] (kms_flip:2155) DEBUG: name = flip last_ts = 200.995682 last_received_ts = 200.995270 last_seq = 6374 current_ts = 201.012360 current_received_ts = 201.011963 current_seq = 6375 count = 355 seq_step = 1 [200.924101] (kms_flip:2155) DEBUG: Vblank took 83us [200.940675] (kms_flip:2155) DEBUG: name = flip last_ts = 201.012360 last_received_ts = 201.011963 last_seq = 6375 current_ts = 201.029022 current_received_ts = 201.028625 current_seq = 6376 count = 356 seq_step = 1 [200.940762] (kms_flip:2155) DEBUG: Vblank took 77us [200.957323] (kms_flip:2155) DEBUG: name = flip last_ts = 201.029022 last_received_ts = 201.028625 last_seq = 6376 current_ts = 201.045685 current_received_ts = 201.045273 current_seq = 6377 count = 357 seq_step = 1 [200.957381] (kms_flip:2155) DEBUG: Vblank took 49us [200.974015] (kms_flip:2155) DEBUG: name = flip last_ts = 201.045685 last_received_ts = 201.045273 last_seq = 6377 current_ts = 201.062363 current_received_ts = 201.061966 current_seq = 6378 count = 358 seq_step = 1 [200.974110] (kms_flip:2155) DEBUG: Vblank took 84us [200.990671] (kms_flip:2155) DEBUG: name = flip last_ts = 201.062363 last_received_ts = 201.061966 last_seq = 6378 current_ts = 201.079025 current_received_ts = 201.078629 current_seq = 6379 count = 359 seq_step = 1 [200.990757] (kms_flip:2155) DEBUG: Vblank took 75us [201.007328] (kms_flip:2155) DEBUG: name = flip last_ts = 201.079025 last_received_ts = 201.078629 last_seq = 6379 current_ts = 201.095703 current_received_ts = 201.095276 current_seq = 6380 count = 360 seq_step = 1 [201.007386] (kms_flip:2155) DEBUG: Vblank took 48us [201.024010] (kms_flip:2155) DEBUG: name = flip last_ts = 201.095703 last_received_ts = 201.095276 last_seq = 6380 current_ts = 201.112366 current_received_ts = 201.111954 current_seq = 6381 count = 361 seq_step = 1 [201.024102] (kms_flip:2155) DEBUG: Vblank took 83us [201.040675] (kms_flip:2155) DEBUG: name = flip last_ts = 201.112366 last_received_ts = 201.111954 last_seq = 6381 current_ts = 201.129028 current_received_ts = 201.128632 current_seq = 6382 count = 362 seq_step = 1 [201.040762] (kms_flip:2155) DEBUG: Vblank took 76us [201.057322] (kms_flip:2155) DEBUG: name = flip last_ts = 201.129028 last_received_ts = 201.128632 last_seq = 6382 current_ts = 201.145691 current_received_ts = 201.145279 current_seq = 6383 count = 363 seq_step = 1 [201.057380] (kms_flip:2155) DEBUG: Vblank took 47us [201.074017] (kms_flip:2155) DEBUG: name = flip last_ts = 201.145691 last_received_ts = 201.145279 last_seq = 6383 current_ts = 201.162369 current_received_ts = 201.161972 current_seq = 6384 count = 364 seq_step = 1 [201.074737] (kms_flip:2155) DEBUG: Vblank took 710us [201.074745] (kms_flip:2155) CRITICAL: Test assertion failure function run_test_step, file ../tests/kms_flip.c:931: [201.074814] (kms_flip:2155) CRITICAL: Failed assertion: end - start < 500 [201.074868] (kms_flip:2155) CRITICAL: Last errno: 4, Interrupted system call [201.079983] (kms_flip:2155) igt_core-INFO: Stack trace: [201.097359] (kms_flip:2155) igt_core-INFO: #0 ../lib/igt_core.c:2074 __igt_fail_assert() [201.099582] (kms_flip:2155) igt_core-INFO: #1 ../tests/kms_flip.c:926 run_test_on_crtc_set() [201.099741] (kms_flip:2155) igt_core-INFO: #2 ../tests/kms_flip.c:1920 run_test() [201.099819] (kms_flip:2155) igt_core-INFO: #3 ../tests/kms_flip.c:2220 __igt_unique____real_main2105() [201.099904] (kms_flip:2155) igt_core-INFO: #4 ../tests/kms_flip.c:2105 main() [201.110754] (kms_flip:2155) igt_core-INFO: #5 [__libc_init_first+0x8a] [201.113431] (kms_flip:2155) igt_core-INFO: #6 [__libc_start_main+0x8b] [201.114001] (kms_flip:2155) igt_core-INFO: #7 [_start+0x25] END ** Dynamic subtest A-HDMI-A3: FAIL (6.390s)
Dmesg	<6> [193.412037] Console: switching to colour dummy device 80x25 <6> [193.412440] [IGT] kms_flip: executing <7> [193.435258] i915 0000:03:00.0: [drm:i915_gem_open [i915]] <7> [193.438345] i915 0000:03:00.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7> [193.452910] i915 0000:03:00.0: [drm:i915_gem_open [i915]] <7> [193.466572] i915 0000:03:00.0: [drm:drm_helper_probe_single_connector_modes] [CONNECTOR:508:DP-1] <7> [193.466583] i915 0000:03:00.0: [drm:intel_dp_detect [i915]] [CONNECTOR:508:DP-1] <7> [193.471148] i915 0000:03:00.0: [drm:drm_helper_probe_single_connector_modes] [CONNECTOR:508:DP-1] disconnected <7> [193.471603] i915 0000:03:00.0: [drm:drm_helper_probe_single_connector_modes] [CONNECTOR:521:DP-2] <7> [193.471620] i915 0000:03:00.0: [drm:intel_dp_detect [i915]] [CONNECTOR:521:DP-2] <7> [193.475896] i915 0000:03:00.0: [drm:drm_helper_probe_single_connector_modes] [CONNECTOR:521:DP-2] disconnected <7> [193.476344] i915 0000:03:00.0: [drm:drm_helper_probe_single_connector_modes] [CONNECTOR:530:HDMI-A-1] <7> [193.476350] i915 0000:03:00.0: [drm:intel_hdmi_detect [i915]] [CONNECTOR:530:HDMI-A-1] <7> [193.480627] i915 0000:03:00.0: [drm:drm_helper_probe_single_connector_modes] [CONNECTOR:530:HDMI-A-1] disconnected <7> [193.481076] i915 0000:03:00.0: [drm:drm_helper_probe_single_connector_modes] [CONNECTOR:536:DP-3] <7> [193.481082] i915 0000:03:00.0: [drm:intel_dp_detect [i915]] [CONNECTOR:536:DP-3] <7> [193.485341] i915 0000:03:00.0: [drm:drm_helper_probe_single_connector_modes] [CONNECTOR:536:DP-3] disconnected <7> [193.485801] i915 0000:03:00.0: [drm:drm_helper_probe_single_connector_modes] [CONNECTOR:544:HDMI-A-2] <7> [193.485807] i915 0000:03:00.0: [drm:intel_hdmi_detect [i915]] [CONNECTOR:544:HDMI-A-2] <7> [193.490108] i915 0000:03:00.0: [drm:drm_helper_probe_single_connector_modes] [CONNECTOR:544:HDMI-A-2] disconnected <7> [193.490564] i915 0000:03:00.0: [drm:drm_helper_probe_single_connector_modes] [CONNECTOR:548:DP-4] <7> [193.490570] i915 0000:03:00.0: [drm:intel_dp_detect [i915]] [CONNECTOR:548:DP-4] <7> [193.490878] i915 0000:03:00.0: [drm:intel_power_well_enable [i915]] enabling AUX_D <7> [193.513198] i915 0000:03:00.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DDI D/PHY D: timeout (status 0x7d40023f) <7> [193.534358] i915 0000:03:00.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DDI D/PHY D: timeout (status 0x7d40023f) <7> [193.555531] i915 0000:03:00.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DDI D/PHY D: timeout (status 0x7d40023f) <7> [193.576690] i915 0000:03:00.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DDI D/PHY D: timeout (status 0x7d40023f) <7> [193.597785] i915 0000:03:00.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DDI D/PHY D: timeout (status 0x7d40023f) <7> [193.618893] i915 0000:03:00.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DDI D/PHY D: timeout (status 0x7d40023f) <7> [193.640000] i915 0000:03:00.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DDI D/PHY D: timeout (status 0x7d40023f) <7> [193.661115] i915 0000:03:00.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DDI D/PHY D: timeout (status 0x7d40023f) <7> [193.682253] i915 0000:03:00.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DDI D/PHY D: timeout (status 0x7d40023f) <7> [193.703371] i915 0000:03:00.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DDI D/PHY D: timeout (status 0x7d40023f) <7> [193.724535] i915 0000:03:00.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DDI D/PHY D: timeout (status 0x7d40023f) <7> [193.745674] i915 0000:03:00.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DDI D/PHY D: timeout (status 0x7d40023f) <7> [193.766808] i915 0000:03:00.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DDI D/PHY D: timeout (status 0x7d40023f) <7> [193.787946] i915 0000:03:00.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DDI D/PHY D: timeout (status 0x7d40023f) <7> [193.809078] i915 0000:03:00.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DDI D/PHY D: timeout (status 0x7d40023f) <7> [193.830207] i915 0000:03:00.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DDI D/PHY D: timeout (status 0x7d40023f) <7> [193.851338] i915 0000:03:00.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DDI D/PHY D: timeout (status 0x7d40023f) <7> [193.872514] i915 0000:03:00.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DDI D/PHY D: timeout (status 0x7d40023f) <7> [193.893655] i915 0000:03:00.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DDI D/PHY D: timeout (status 0x7d40023f) <7> [193.914778] i915 0000:03:00.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DDI D/PHY D: timeout (status 0x7d40023f) <7> [193.935897] i915 0000:03:00.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DDI D/PHY D: timeout (status 0x7d40023f) <7> [193.957039] i915 0000:03:00.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DDI D/PHY D: timeout (status 0x7d40023f) <7> [193.978174] i915 0000:03:00.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DDI D/PHY D: timeout (status 0x7d40023f) <7> [193.999306] i915 0000:03:00.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DDI D/PHY D: timeout (status 0x7d40023f) <7> [194.020440] i915 0000:03:00.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DDI D/PHY D: timeout (status 0x7d40023f) <7> [194.041581] i915 0000:03:00.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DDI D/PHY D: timeout (status 0x7d40023f) <7> [194.062716] i915 0000:03:00.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DDI D/PHY D: timeout (status 0x7d40023f) <7> [194.083851] i915 0000:03:00.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DDI D/PHY D: timeout (status 0x7d40023f) <7> [194.104984] i915 0000:03:00.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DDI D/PHY D: timeout (status 0x7d40023f) <7> [194.126118] i915 0000:03:00.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DDI D/PHY D: timeout (status 0x7d40023f) <7> [194.147249] i915 0000:03:00.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DDI D/PHY D: timeout (status 0x7d40023f) <7> [194.168383] i915 0000:03:00.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DDI D/PHY D: timeout (status 0x7d40023f) <7> [194.168574] i915 0000:03:00.0: [drm:drm_dp_dpcd_access [drm_display_helper]] AUX D/DDI D/PHY D: Too many retries, giving up. First error: -110 <7> [194.168644] i915 0000:03:00.0: [drm:drm_helper_probe_single_connector_modes] [CONNECTOR:548:DP-4] disconnected <7> [194.169292] i915 0000:03:00.0: [drm:drm_helper_probe_single_connector_modes] [CONNECTOR:508:DP-1] <7> [194.169297] i915 0000:03:00.0: [drm:intel_dp_detect [i915]] [CONNECTOR:508:DP-1] <7> [194.173528] i915 0000:03:00.0: [drm:drm_helper_probe_single_connector_modes] [CONNECTOR:508:DP-1] disconnected <7> [194.173545] i915 0000:03:00.0: [drm:drm_helper_probe_single_connector_modes] [CONNECTOR:521:DP-2] <7> [194.173549] i915 0000:03:00.0: [drm:intel_dp_detect [i915]] [CONNECTOR:521:DP-2] <7> [194.177855] i915 0000:03:00.0: [drm:drm_helper_probe_single_connector_modes] [CONNECTOR:521:DP-2] disconnected <7> [194.177870] i915 0000:03:00.0: [drm:drm_helper_probe_single_connector_modes] [CONNECTOR:530:HDMI-A-1] <7> [194.177875] i915 0000:03:00.0: [drm:intel_hdmi_detect [i915]] [CONNECTOR:530:HDMI-A-1] <7> [194.182074] i915 0000:03:00.0: [drm:drm_helper_probe_single_connector_modes] [CONNECTOR:530:HDMI-A-1] disconnected <7> [194.182089] i915 0000:03:00.0: [drm:drm_helper_probe_single_connector_modes] [CONNECTOR:536:DP-3] <7> [194.182093] i915 0000:03:00.0: [drm:intel_dp_detect [i915]] [CONNECTOR:536:DP-3] <7> [194.186310] i915 0000:03:00.0: [drm:drm_helper_probe_single_connector_modes] [CONNECTOR:536:DP-3] disconnected <7> [194.186324] i915 0000:03:00.0: [drm:drm_helper_probe_single_connector_modes] [CONNECTOR:544:HDMI-A-2] <7> [194.186328] i915 0000:03:00.0: [drm:intel_hdmi_detect [i915]] [CONNECTOR:544:HDMI-A-2] <7> [194.190533] i915 0000:03:00.0: [drm:drm_helper_probe_single_connector_modes] [CONNECTOR:544:HDMI-A-2] disconnected <7> [194.190548] i915 0000:03:00.0: [drm:drm_helper_probe_single_connector_modes] [CONNECTOR:548:DP-4] <7> [194.190552] i915 0000:03:00.0: [drm:intel_dp_detect [i915]] [CONNECTOR:548:DP-4] <7> [194.211732] i915 0000:03:00.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DDI D/PHY D: timeout (status 0x7d40023f) <7> [194.232831] i915 0000:03:00.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DDI D/PHY D: timeout (status 0x7d40023f) <7> [194.253957] i915 0000:03:00.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DDI D/PHY D: timeout (status 0x7d40023f) <7> [194.275078] i915 0000:03:00.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DDI D/PHY D: timeout (status 0x7d40023f) <7> [194.296198] i915 0000:03:00.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DDI D/PHY D: timeout (status 0x7d40023f) <7> [194.317317] i915 0000:03:00.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DDI D/PHY D: timeout (status 0x7d40023f) <7> [194.338447] i915 0000:03:00.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DDI D/PHY D: timeout (status 0x7d40023f) <7> [194.359572] i915 0000:03:00.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DDI D/PHY D: timeout (status 0x7d40023f) <7> [194.380698] i915 0000:03:00.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DDI D/PHY D: timeout (status 0x7d40023f) <7> [194.401838] i915 0000:03:00.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DDI D/PHY D: timeout (status 0x7d40023f) <7> [194.422975] i915 0000:03:00.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DDI D/PHY D: timeout (status 0x7d40023f) <7> [194.444114] i915 0000:03:00.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DDI D/PHY D: timeout (status 0x7d40023f) <7> [194.465250] i915 0000:03:00.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DDI D/PHY D: timeout (status 0x7d40023f) <7> [194.486369] i915 0000:03:00.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DDI D/PHY D: timeout (status 0x7d40023f) <7> [194.507519] i915 0000:03:00.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DDI D/PHY D: timeout (status 0x7d40023f) <7> [194.528658] i915 0000:03:00.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DDI D/PHY D: timeout (status 0x7d40023f) <7> [194.549783] i915 0000:03:00.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DDI D/PHY D: timeout (status 0x7d40023f) <7> [194.570925] i915 0000:03:00.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DDI D/PHY D: timeout (status 0x7d40023f) <7> [194.592061] i915 0000:03:00.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DDI D/PHY D: timeout (status 0x7d40023f) <7> [194.613196] i915 0000:03:00.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DDI D/PHY D: timeout (status 0x7d40023f) <7> [194.634332] i915 0000:03:00.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DDI D/PHY D: timeout (status 0x7d40023f) <7> [194.655515] i915 0000:03:00.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DDI D/PHY D: timeout (status 0x7d40023f) <7> [194.676655] i915 0000:03:00.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DDI D/PHY D: timeout (status 0x7d40023f) <7> [194.697804] i915 0000:03:00.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DDI D/PHY D: timeout (status 0x7d40023f) <7> [194.718944] i915 0000:03:00.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DDI D/PHY D: timeout (status 0x7d40023f) <7> [194.740080] i915 0000:03:00.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DDI D/PHY D: timeout (status 0x7d40023f) <7> [194.761200] i915 0000:03:00.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DDI D/PHY D: timeout (status 0x7d40023f) <7> [194.782322] i915 0000:03:00.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DDI D/PHY D: timeout (status 0x7d40023f) <7> [194.803505] i915 0000:03:00.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DDI D/PHY D: timeout (status 0x7d40023f) <7> [194.824646] i915 0000:03:00.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DDI D/PHY D: timeout (status 0x7d40023f) <7> [194.845776] i915 0000:03:00.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DDI D/PHY D: timeout (status 0x7d40023f) <7> [194.866915] i915 0000:03:00.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DDI D/PHY D: timeout (status 0x7d40023f) <7> [194.867112] i915 0000:03:00.0: [drm:drm_dp_dpcd_access [drm_display_helper]] AUX D/DDI D/PHY D: Too many retries, giving up. First error: -110 <7> [194.867160] i915 0000:03:00.0: [drm:drm_helper_probe_single_connector_modes] [CONNECTOR:548:DP-4] disconnected <7> [194.867182] i915 0000:03:00.0: [drm:drm_helper_probe_single_connector_modes] [CONNECTOR:556:HDMI-A-3] <7> [194.867188] i915 0000:03:00.0: [drm:intel_hdmi_detect [i915]] [CONNECTOR:556:HDMI-A-3] <7> [194.891485] i915 0000:03:00.0: [drm:update_display_info.part.0] [CONNECTOR:556:HDMI-A-3] ELD monitor FH-DP4K <7> [194.891491] i915 0000:03:00.0: [drm:update_display_info.part.0] [CONNECTOR:556:HDMI-A-3] ELD size 36, SAD count 2 <7> [194.891676] i915 0000:03:00.0: [drm:do_gmbus_xfer [i915]] GMBUS [i915 gmbus dpd] NAK for addr: 0040 w(1) <7> [194.891867] i915 0000:03:00.0: [drm:do_gmbus_xfer [i915]] GMBUS [i915 gmbus dpd] NAK on first message, retry <7> [194.892186] i915 0000:03:00.0: [drm:do_gmbus_xfer [i915]] GMBUS [i915 gmbus dpd] NAK for addr: 0040 w(1) <7> [194.892396] i915 0000:03:00.0: [drm:drm_dp_dual_mode_detect [drm_display_helper]] DP dual mode HDMI ID: (err -6) <7> [194.892412] i915 0000:03:00.0: [drm:intel_hdmi_set_edid [i915]] Assuming DP dual mode adaptor presence based on VBT <7> [194.892605] i915 0000:03:00.0: [drm:intel_hdmi_set_edid [i915]] DP dual mode adaptor (type 1 DVI) detected (max TMDS clock: 165000 kHz) <7> [194.893314] i915 0000:03:00.0: [drm:drm_mode_prune_invalid] Rejected mode: "2560x1440": 60 241700 2560 2608 2640 2720 1440 1443 1448 1481 0x40 0x9 (CLOCK_HIGH) <7> [194.893322] i915 0000:03:00.0: [drm:drm_mode_prune_invalid] Rejected mode: "2560x1600": 60 267820 2560 2608 2640 2720 1600 1603 1608 1641 0x40 0x9 (CLOCK_HIGH) <7> [194.893327] i915 0000:03:00.0: [drm:drm_mode_prune_invalid] Rejected mode: "1920x1080": 120 297000 1920 2008 2052 2200 1080 1084 1089 1125 0x40 0x5 (CLOCK_HIGH) <7> [194.893333] i915 0000:03:00.0: [drm:drm_mode_prune_invalid] Rejected mode: "3840x2160": 30 266640 3840 3888 3920 4000 2160 2163 2168 2222 0x40 0x9 (CLOCK_HIGH) <7> [194.893338] i915 0000:03:00.0: [drm:drm_mode_prune_invalid] Rejected mode: "1920x1080": 120 296703 1920 2008 2052 2200 1080 1084 1089 1125 0x40 0x5 (CLOCK_HIGH) <7> [194.893344] i915 0000:03:00.0: [drm:drm_helper_probe_single_connector_modes] [CONNECTOR:556:HDMI-A-3] probed modes: <7> [194.893348] i915 0000:03:00.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "1920x1080": 60 148500 1920 2008 2052 2200 1080 1084 1089 1125 0x48 0x5 <7> [194.893352] i915 0000:03:00.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "3840x2160": 17 151100 3840 3888 3920 4000 2160 2163 2168 2222 0x40 0x9 <7> [194.893356] i915 0000:03:00.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "2560x1600": 30 133910 2560 2608 2640 2720 1600 1603 1608 1641 0x40 0x9 <7> [194.893359] i915 0000:03:00.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "2560x1440": 30 120850 2560 2608 2640 2720 1440 1443 1448 1481 0x40 0x9 <7> [194.893363] i915 0000:03:00.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "1920x1200": 60 154000 1920 1968 2000 2080 1200 1203 1209 1235 0x40 0x9 <7> [194.893366] i915 0000:03:00.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "1920x1080": 60 148352 1920 2008 2052 2200 1080 1084 1089 1125 0x40 0x5 <7> [194.893370] i915 0000:03:00.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "1680x1050": 60 119000 1680 1728 1760 1840 1050 1053 1059 1080 0x40 0x9 <7> [194.893374] i915 0000:03:00.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "1600x900": 60 108000 1600 1624 1704 1800 900 901 904 1000 0x40 0x5 <7> [194.893377] i915 0000:03:00.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "1280x1024": 75 135000 1280 1296 1440 1688 1024 1025 1028 1066 0x40 0x5 <7> [194.893381] i915 0000:03:00.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "1280x1024": 60 108000 1280 1328 1440 1688 1024 1025 1028 1066 0x40 0x5 <7> [194.893384] i915 0000:03:00.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "1440x900": 60 88750 1440 1488 1520 1600 900 903 909 926 0x40 0x9 <7> [194.893388] i915 0000:03:00.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "1280x800": 60 71000 1280 1328 1360 1440 800 803 809 823 0x40 0x9 <7> [194.893391] i915 0000:03:00.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "1152x864": 75 108000 1152 1216 1344 1600 864 865 868 900 0x40 0x5 <7> [194.893395] i915 0000:03:00.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "1280x720": 60 74250 1280 1390 1430 1650 720 725 730 750 0x40 0x5 <7> [194.893399] i915 0000:03:00.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "1280x720": 60 74176 1280 1390 1430 1650 720 725 730 750 0x40 0x5 <7> [194.893402] i915 0000:03:00.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "1024x768": 75 78750 1024 1040 1136 1312 768 769 772 800 0x40 0x5 <7> [194.893406] i915 0000:03:00.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "1024x768": 70 75000 1024 1048 1184 1328 768 771 777 806 0x40 0xa <7> [194.893409] i915 0000:03:00.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "1024x768": 60 65000 1024 1048 1184 1344 768 771 777 806 0x40 0xa <7> [194.893413] i915 0000:03:00.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "800x600": 75 49500 800 816 896 1056 600 601 604 625 0x40 0x5 <7> [194.893416] i915 0000:03:00.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "800x600": 72 50000 800 856 976 1040 600 637 643 666 0x40 0x5 <7> [194.893420] i915 0000:03:00.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "800x600": 60 40000 800 840 968 1056 600 601 605 628 0x40 0x5 <7> [194.893423] i915 0000:03:00.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "800x600": 56 36000 800 824 896 1024 600 601 603 625 0x40 0x5 <7> [194.893427] i915 0000:03:00.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "640x480": 75 31500 640 656 720 840 480 481 484 500 0x40 0xa <7> [194.893430] i915 0000:03:00.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "640x480": 73 31500 640 664 704 832 480 489 492 520 0x40 0xa <7> [194.893434] i915 0000:03:00.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "640x480": 60 25200 640 656 752 800 480 490 492 525 0x40 0xa <7> [194.893453] i915 0000:03:00.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "640x480": 60 25175 640 656 752 800 480 490 492 525 0x40 0xa <6> [194.898807] [IGT] kms_flip: starting subtest flip-vs-expired-vblank-interruptible <6> [194.905422] [IGT] kms_flip: starting dynamic subtest A-HDMI-A3 <7> [194.905929] i915 0000:03:00.0: [drm:drm_mode_addfb2] [FB:562] <7> [194.906115] i915 0000:03:00.0: [drm:drm_mode_addfb2] [FB:563] <7> [194.906660] [drm:eb_validate_vma [i915]] EINVAL at eb_validate_vma:509 <7> [194.907082] [drm:eb_validate_vma [i915]] EINVAL at eb_validate_vma:509 <7> [194.932669] i915 0000:03:00.0: [drm:intel_power_well_disable [i915]] disabling AUX_D <7> [194.965178] [drm:eb_validate_vma [i915]] EINVAL at eb_validate_vma:509 <7> [194.965531] [drm:eb_validate_vma [i915]] EINVAL at eb_validate_vma:509 <7> [194.972658] [drm:eb_validate_vma [i915]] EINVAL at eb_validate_vma:509 <7> [194.972980] [drm:eb_validate_vma [i915]] EINVAL at eb_validate_vma:509 <7> [194.993818] [drm:eb_validate_vma [i915]] EINVAL at eb_validate_vma:509 <7> [194.994156] [drm:eb_validate_vma [i915]] EINVAL at eb_validate_vma:509 <7> [194.999341] i915 0000:03:00.0: [drm:drm_mode_setcrtc] [CRTC:151:pipe A] <7> [194.999442] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:151:pipe A] fastset requirement not met in hw.enable (expected yes, found no) <7> [194.999690] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:151:pipe A] fastset requirement not met in hw.active (expected yes, found no) <7> [194.999906] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:151:pipe A] fastset requirement not met in cpu_transcoder (expected 0, found -1) <7> [195.000088] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:151:pipe A] fastset requirement not met in lane_count (expected 4, found 0) <7> [195.000273] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:151:pipe A] fastset requirement not met in output_types (expected 0x00000040, found 0x00000000) <7> [195.000456] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:151:pipe A] fastset requirement not met in framestart_delay (expected 1, found 0) <7> [195.000688] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:151:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hdisplay (expected 1920, found 0) <7> [195.000870] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:151:pipe A] fastset requirement not met in hw.pipe_mode.crtc_htotal (expected 2200, found 0) <7> [195.001051] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:151:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hblank_start (expected 1920, found 0) <7> [195.001232] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:151:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hblank_end (expected 2200, found 0) <7> [195.001411] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:151:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hsync_start (expected 2008, found 0) <7> [195.001617] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:151:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hsync_end (expected 2052, found 0) <7> [195.001816] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:151:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vdisplay (expected 1080, found 0) <7> [195.001998] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:151:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vblank_start (expected 1080, found 0) <7> [195.002178] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:151:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vsync_start (expected 1084, found 0) <7> [195.002359] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:151:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vsync_end (expected 1089, found 0) <7> [195.002539] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:151:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vtotal (expected 1125, found 0) <7> [195.002877] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:151:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vblank_end (expected 1125, found 0) <7> [195.003064] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:151:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hdisplay (expected 1920, found 0) <7> [195.003246] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:151:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_htotal (expected 2200, found 0) <7> [195.003427] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:151:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hblank_start (expected 1920, found 0) <7> [195.003788] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:151:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hblank_end (expected 2200, found 0) <7> [195.003973] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:151:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hsync_start (expected 2008, found 0) <7> [195.004155] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:151:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hsync_end (expected 2052, found 0) <7> [195.004336] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:151:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vdisplay (expected 1080, found 0) <7> [195.004517] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:151:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vblank_start (expected 1080, found 0) <7> [195.004738] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:151:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vsync_start (expected 1084, found 0) <7> [195.004920] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:151:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vsync_end (expected 1089, found 0) <7> [195.005101] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:151:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vtotal (expected 1125, found 0) <7> [195.005282] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:151:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vblank_end (expected 1125, found 0) <7> [195.005462] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:151:pipe A] fastset requirement not met in pixel_multiplier (expected 1, found 0) <7> [195.005683] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:151:pipe A] fastset requirement not met in hw.adjusted_mode.flags (1) (expected 1, found 0) <7> [195.005869] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:151:pipe A] fastset requirement not met in hw.adjusted_mode.flags (4) (expected 4, found 0) <7> [195.006052] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:151:pipe A] fastset requirement not met in pipe_bpp (expected 24, found 0) <7> [195.006232] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:151:pipe A] fastset requirement not met in hw.pipe_mode.crtc_clock (expected 148500, found 0) <7> [195.006412] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:151:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_clock (expected 148500, found 0) <7> [195.006618] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:151:pipe A] fastset requirement not met in port_clock (expected 148500, found 0) <7> [195.006814] i915 0000:03:00.0: [drm:intel_atomic_check [i915]] [CRTC:151:pipe A] fastset requirement not met, forcing full modeset <7> [195.007022] i915 0000:03:00.0: [drm:skl_compute_wm [i915]] Enabled dbuf slices 0x3 -> 0x1 (total dbuf slices 0xf), mbus joined? no->no <7> [195.007196] i915 0000:03:00.0: [drm:skl_compute_wm [i915]] [CRTC:151:pipe A] dbuf slices 0x3 -> 0x0, ddb (0 - 2048) -> (0 - 0), active pipes 0x1 -> 0x0 <7> [195.007394] i915 0000:03:00.0: [drm:skl_print_plane_ddb_changes [i915]] [PLANE:35:plane 1A] ddb ( 0 - 1963) -> ( 0 - 0), size 1963 -> 0 <7> [195.007566] i915 0000:03:00.0: [drm:skl_print_plane_ddb_changes [i915]] [PLANE:145:cursor A] ddb (1963 - 2048) -> ( 0 - 0), size 85 -> 0 <7> [195.007787] i915 0000:03:00.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> [195.007959] i915 0000:03:00.0: [drm:skl_print_plane_wm_changes [i915]] [PLANE:35:plane 1A] lines 1, 3, 4, 5, 9, 11, 17, 25, 0, 0, 0 -> 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0 <7> [195.008130] i915 0000:03:00.0: [drm:skl_print_plane_wm_changes [i915]] [PLANE:35:plane 1A] blocks 16, 49, 65, 81, 145, 177, 273, 401, 30, 0, 0 -> 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0 <7> [195.008302] i915 0000:03:00.0: [drm:skl_print_plane_wm_changes [i915]] [PLANE:35:plane 1A] min_ddb 19, 55, 73, 91, 161, 196, 302, 443, 31, 0, 0 -> 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0 <7> [195.008490] i915 0000:03:00.0: [drm:intel_bw_atomic_check [i915]] [CRTC:151:pipe A] data rate 0 num active planes 0 <7> [195.008677] i915 0000:03:00.0: [drm:intel_bw_atomic_check [i915]] QGV point 0: max bw 50000 required 0 <7> [195.008857] i915 0000:03:00.0: [drm:intel_bw_atomic_check [i915]] No SAGV, using single QGV point mask 0x1 <7> [195.009050] i915 0000:03:00.0: [drm:intel_cdclk_atomic_check [i915]] [CRTC:151:pipe A] min cdclk: 74250 kHz -> 0 kHz <7> [195.009243] i915 0000:03:00.0: [drm:intel_cdclk_update_dbuf_bw_min_cdclk [i915]] dbuf bandwidth min cdclk: 9282 kHz -> 0 kHz <7> [195.009421] i915 0000:03:00.0: [drm:intel_cdclk_atomic_check [i915]] New cdclk calculated to be logical 163200 kHz, actual 163200 kHz <7> [195.009606] i915 0000:03:00.0: [drm:intel_cdclk_atomic_check [i915]] New voltage level calculated to be logical 0, actual 0 <7> [195.009787] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] [CRTC:151:pipe A] enable: no [modeset] <7> [195.009969] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] [PLANE:35:plane 1A] fb: [NOFB], visible: no <7> [195.010149] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] [PLANE:65:plane 2A] fb: [NOFB], visible: no <7> [195.010329] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] [PLANE:95:plane 3A] fb: [NOFB], visible: no <7> [195.010508] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] [PLANE:125:plane 4A] fb: [NOFB], visible: no <7> [195.010730] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] [PLANE:135:plane 5A] fb: [NOFB], visible: no <7> [195.010910] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] [PLANE:145:cursor A] fb: [NOFB], visible: no <7> [195.019984] i915 0000:03:00.0: [drm:intel_disable_transcoder [i915]] disabling pipe A <7> [195.036781] i915 0000:03:00.0: [drm:intel_power_well_disable [i915]] disabling DDI_IO_D <7> [195.037036] i915 0000:03:00.0: [drm:__intel_fbc_disable [i915]] Disabling FBC on [PLANE:35:plane 1A] <7> [195.037233] i915 0000:03:00.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:507:DDI A/PHY A] <7> [195.037411] i915 0000:03:00.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:509:DP-MST A] <7> [195.037599] i915 0000:03:00.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:510:DP-MST B] <7> [195.037817] i915 0000:03:00.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:511:DP-MST C] <7> [195.037996] i915 0000:03:00.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:512:DP-MST D] <7> [195.038173] i915 0000:03:00.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:520:DDI B/PHY B] <7> [195.038348] i915 0000:03:00.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:522:DP-MST A] <7> [195.038525] i915 0000:03:00.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:523:DP-MST B] <7> [195.038744] i915 0000:03:00.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:524:DP-MST C] <7> [195.038920] i915 0000:03:00.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:525:DP-MST D] <7> [195.039096] i915 0000:03:00.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:535:DDI C/PHY C] <7> [195.039274] i915 0000:03:00.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:537:DP-MST A] <7> [195.039451] i915 0000:03:00.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:538:DP-MST B] <7> [195.039664] i915 0000:03:00.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:539:DP-MST C] <7> [195.039841] i915 0000:03:00.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:540:DP-MST D] <7> [195.040017] i915 0000:03:00.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:547:DDI D/PHY D] <7> [195.040213] i915 0000:03:00.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:549:DP-MST A] <7> [195.040390] i915 0000:03:00.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:550:DP-MST B] <7> [195.040576] i915 0000:03:00.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:551:DP-MST C] <7> [195.040788] i915 0000:03:00.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:552:DP-MST D] <7> [195.040965] i915 0000:03:00.0: [drm:verify_connector_state [i915]] [CONNECTOR:556:HDMI-A-3] <7> [195.041179] i915 0000:03:00.0: [drm:gen9_dbuf_slices_update [i915]] Updating dbuf slices to 0x1 <7> [195.041465] i915 0000:03:00.0: [drm:intel_power_well_disable [i915]] disabling PW_A <7> [195.041754] i915 0000:03:00.0: [drm:intel_power_well_disable [i915]] disabling PW_2 <7> [195.041982] i915 0000:03:00.0: [drm:intel_modeset_verify_crtc [i915]] [CRTC:151:pipe A] <7> [195.042379] i915 0000:03:00.0: [drm:drm_mode_setcrtc] [CRTC:269:pipe C] <7> [195.042542] i915 0000:03:00.0: [drm:drm_mode_setcrtc] [CRTC:387:pipe B] <7> [195.042742] i915 0000:03:00.0: [drm:drm_mode_setcrtc] [CRTC:505:pipe D] <7> [195.042894] i915 0000:03:00.0: [drm:drm_mode_setcrtc] [CRTC:151:pipe A] <7> [195.042925] i915 0000:03:00.0: [drm:drm_mode_setcrtc] [CONNECTOR:556:HDMI-A-3] <7> [195.042998] i915 0000:03:00.0: [drm:compute_baseline_pipe_bpp [i915]] [CONNECTOR:556:HDMI-A-3] Limiting target display pipe bpp to 24 (EDID bpp 0, max requested bpp 36, max platform bpp 36) <7> [195.043195] i915 0000:03:00.0: [drm:intel_hdmi_compute_output_format [i915]] picking 8 bpc for HDMI output (pipe bpp: 24) <7> [195.043363] i915 0000:03:00.0: [drm:intel_atomic_check [i915]] [CRTC:151:pipe A] hw max bpp: 24, pipe bpp: 24, dithering: 0 <7> [195.043545] i915 0000:03:00.0: [drm:intel_ddi_compute_config_late [i915]] [ENCODER:547:DDI D/PHY D] [CRTC:151:pipe A] <7> [195.043753] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:151:pipe A] fastset requirement not met in hw.enable (expected no, found yes) <7> [195.043936] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:151:pipe A] fastset requirement not met in hw.active (expected no, found yes) <7> [195.044117] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:151:pipe A] fastset requirement not met in cpu_transcoder (expected -1, found 0) <7> [195.044299] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:151:pipe A] fastset requirement not met in lane_count (expected 0, found 4) <7> [195.044480] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:151:pipe A] fastset requirement not met in output_types (expected 0x00000000, found 0x00000040) <7> [195.044703] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:151:pipe A] fastset requirement not met in framestart_delay (expected 0, found 1) <7> [195.044885] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:151:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hdisplay (expected 0, found 1920) <7> [195.045070] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:151:pipe A] fastset requirement not met in hw.pipe_mode.crtc_htotal (expected 0, found 2200) <7> [195.045250] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:151:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hblank_start (expected 0, found 1920) <7> [195.045430] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:151:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hblank_end (expected 0, found 2200) <7> [195.045654] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:151:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hsync_start (expected 0, found 2008) <7> [195.045836] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:151:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hsync_end (expected 0, found 2052) <7> [195.046016] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:151:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vdisplay (expected 0, found 1080) <7> [195.046196] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:151:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vblank_start (expected 0, found 1080) <7> [195.046377] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:151:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vsync_start (expected 0, found 1084) <7> [195.046557] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:151:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vsync_end (expected 0, found 1089) <7> [195.046816] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:151:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vtotal (expected 0, found 1125) <7> [195.046998] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:151:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vblank_end (expected 0, found 1125) <7> [195.047179] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:151:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hdisplay (expected 0, found 1920) <7> [195.047360] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:151:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_htotal (expected 0, found 2200) <7> [195.047540] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:151:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hblank_start (expected 0, found 1920) <7> [195.047761] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:151:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hblank_end (expected 0, found 2200) <7> [195.047941] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:151:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hsync_start (expected 0, found 2008) <7> [195.048121] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:151:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hsync_end (expected 0, found 2052) <7> [195.048303] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:151:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vdisplay (expected 0, found 1080) <7> [195.048484] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:151:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vblank_start (expected 0, found 1080) <7> [195.048704] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:151:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vsync_start (expected 0, found 1084) <7> [195.048885] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:151:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vsync_end (expected 0, found 1089) <7> [195.049065] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:151:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vtotal (expected 0, found 1125) <7> [195.049244] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:151:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vblank_end (expected 0, found 1125) <7> [195.049424] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:151:pipe A] fastset requirement not met in pixel_multiplier (expected 0, found 1) <7> [195.049644] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:151:pipe A] fastset requirement not met in hw.adjusted_mode.flags (1) (expected 0, found 1) <7> [195.049824] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:151:pipe A] fastset requirement not met in hw.adjusted_mode.flags (4) (expected 0, found 4) <7> [195.050005] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:151:pipe A] fastset requirement not met in pipe_bpp (expected 0, found 24) <7> [195.050185] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:151:pipe A] fastset requirement not met in hw.pipe_mode.crtc_clock (expected 0, found 148500) <7> [195.050365] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:151:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_clock (expected 0, found 148500) <7> [195.050546] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:151:pipe A] fastset requirement not met in port_clock (expected 0, found 148500) <7> [195.050820] i915 0000:03:00.0: [drm:intel_atomic_check [i915]] [CRTC:151:pipe A] fastset requirement not met, forcing full modeset <7> [195.051028] i915 0000:03:00.0: [drm:skl_compute_wm [i915]] Enabled dbuf slices 0x1 -> 0x3 (total dbuf slices 0xf), mbus joined? no->no <7> [195.051203] i915 0000:03:00.0: [drm:skl_compute_wm [i915]] [CRTC:151:pipe A] dbuf slices 0x0 -> 0x3, ddb (0 - 0) -> (0 - 2048), active pipes 0x0 -> 0x1 <7> [195.051402] i915 0000:03:00.0: [drm:skl_print_plane_ddb_changes [i915]] [PLANE:35:plane 1A] ddb ( 0 - 0) -> ( 0 - 1963), size 0 -> 1963 <7> [195.051581] i915 0000:03:00.0: [drm:skl_print_plane_ddb_changes [i915]] [PLANE:145:cursor A] ddb ( 0 - 0) -> (1963 - 2048), size 0 -> 85 <7> [195.051786] i915 0000:03:00.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> [195.051957] i915 0000:03:00.0: [drm:skl_print_plane_wm_changes [i915]] [PLANE:35:plane 1A] lines 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0 -> 4, 4, 4, 5, 9, 11, 17, 25, 0, 0, 0 <7> [195.052129] i915 0000:03:00.0: [drm:skl_print_plane_wm_changes [i915]] [PLANE:35:plane 1A] blocks 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0 -> 62, 62, 62, 78, 139, 169, 261, 383, 137, 0, 0 <7> [195.052303] i915 0000:03:00.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 -> 123, 123, 123, 184, 245, 245, 367, 489, 138, 0, 0 <7> [195.052490] i915 0000:03:00.0: [drm:intel_bw_atomic_check [i915]] [CRTC:151:pipe A] data rate 594000 num active planes 1 <7> [195.052710] i915 0000:03:00.0: [drm:intel_bw_atomic_check [i915]] QGV point 0: max bw 50000 required 624 <7> [195.052887] i915 0000:03:00.0: [drm:intel_bw_atomic_check [i915]] No SAGV, using single QGV point mask 0x1 <7> [195.053078] i915 0000:03:00.0: [drm:intel_cdclk_atomic_check [i915]] [CRTC:151:pipe A] min cdclk: 0 kHz -> 74250 kHz <7> [195.053270] i915 0000:03:00.0: [drm:intel_cdclk_update_dbuf_bw_min_cdclk [i915]] dbuf bandwidth min cdclk: 0 kHz -> 9282 kHz <7> [195.053450] i915 0000:03:00.0: [drm:intel_cdclk_atomic_check [i915]] New cdclk calculated to be logical 163200 kHz, actual 163200 kHz <7> [195.053669] i915 0000:03:00.0: [drm:intel_cdclk_atomic_check [i915]] New voltage level calculated to be logical 0, actual 0 <7> [195.053850] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] [CRTC:151:pipe A] enable: yes [modeset] <7> [195.054029] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] active: yes, output_types: HDMI (0x40), output format: RGB, sink format: RGB <7> [195.054209] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] cpu_transcoder: A, pipe bpp: 24, dithering: 0 <7> [195.054388] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] MST master transcoder: <invalid> <7> [195.054574] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] port sync: master transcoder: <invalid>, slave transcoder bitmask = 0x0 <7> [195.054788] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] joiner: no, pipes: 0x0 <7> [195.054967] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] splitter: disabled, link count 0, overlap 0 <7> [195.055147] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] audio: 0, infoframes: 0, infoframes enabled: 0x0 <7> [195.055327] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] scanline offset: 2 <7> [195.055505] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] framestart delay: 1, MSA timing delay: 0, set context latency: 0 <7> [195.055724] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] vrr: no, fixed rr: yes, vmin: 1125, vmax: 1125, flipline: 1125, pipeline full: 0, guardband: 45 vsync start: 41, vsync end: 36 <7> [195.055904] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] vrr: vmin vblank: 1080, vmax vblank: 1080, vmin vtotal: 1125, vmax vtotal: 1125 <7> [195.056084] i915 0000:03:00.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> [195.056264] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] requested mode: "1920x1080": 60 148500 1920 2008 2052 2200 1080 1084 1089 1125 0x48 0x5 <7> [195.056445] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] adjusted mode: "1920x1080": 60 148500 1920 2008 2052 2200 1080 1084 1089 1125 0x48 0x5 <7> [195.056666] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] crtc timings: clock=148500, hd=1920 hb=1920-2200 hs=2008-2052 ht=2200, vd=1080 vb=1080-1125 vs=1084-1089 vt=1125, flags=0x5 <7> [195.056845] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] pipe mode: "1920x1080": 60 148500 1920 2008 2052 2200 1080 1084 1089 1125 0x40 0x5 <7> [195.057025] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] crtc timings: clock=148500, hd=1920 hb=1920-2200 hs=2008-2052 ht=2200, vd=1080 vb=1080-1125 vs=1084-1089 vt=1125, flags=0x5 <7> [195.057204] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] port clock: 148500, pixel rate 148500, min cdclk 74250, min voltage level 0 <7> [195.057383] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] linetime: 119, ips linetime: 0 <7> [195.057562] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] num_scalers: 2, scaler_users: 0x0, scaler_id: -1, scaling_filter: 0, sharpness_strength: 0 <7> [195.057783] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] pipe src: 1920x1080+0+0 <7> [195.057964] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] pch pfit: 0x0+0+0, disabled, force thru: no <7> [195.058143] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] sharpness strength: 0, sharpness tap size: 0, sharpness enable: 0 <7> [195.058323] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] ips: 0, double wide: 0, drrs: 0 <7> [195.058501] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] dpll_hw_state: dpll: 0x24414, dpll_md: 0x18000000, fp0: 0x8801ef8, fp1: 0x2b000440 <7> [195.058718] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] csc_mode: 0x0 gamma_mode: 0x0 gamma_enable: 0 csc_enable: 0 <7> [195.058899] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] pre csc lut: 0 entries, post csc lut: 0 entries <7> [195.059079] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] output csc: pre offsets: 0x0000 0x0000 0x0000 <7> [195.059258] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] output csc: coefficients: 0x0000 0x0000 0x0000 <7> [195.059437] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] output csc: coefficients: 0x0000 0x0000 0x0000 <7> [195.059656] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] output csc: coefficients: 0x0000 0x0000 0x0000 <7> [195.059835] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] output csc: post offsets: 0x0000 0x0000 0x0000 <7> [195.060013] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] pipe csc: pre offsets: 0x0000 0x0000 0x0000 <7> [195.060194] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] pipe csc: coefficients: 0x0000 0x0000 0x0000 <7> [195.060373] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] pipe csc: coefficients: 0x0000 0x0000 0x0000 <7> [195.060552] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] pipe csc: coefficients: 0x0000 0x0000 0x0000 <7> [195.060775] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] pipe csc: post offsets: 0x0000 0x0000 0x0000 <7> [195.060826] i915 0000:03:00.0: [drm:intel_power_well_disable [i915]] disabling DC_off <7> [195.060956] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] [PLANE:35:plane 1A] fb: [FB:562] 1920x1080 format = XR24 little-endian (0x34325258) modifier = 0x100000000000009, visible: yes <7> [195.061061] i915 0000:03:00.0: [drm:gen9_enable_dc5 [i915]] Enabling DC5 <7> [195.061137] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] rotation: 0x1, scaler: -1, scaling_filter: 1 <7> [195.061248] i915 0000:03:00.0: [drm:gen9_set_dc_state.part.0 [i915]] Setting DC state from 00 to 01 <7> [195.061315] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] src: 1920.000000x1080.000000+0.000000+0.000000 dst: 1920x1080+0+0 <7> [195.061495] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] [PLANE:65:plane 2A] fb: [NOFB], visible: no <7> [195.061942] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] [PLANE:95:plane 3A] fb: [NOFB], visible: no <7> [195.062151] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] [PLANE:125:plane 4A] fb: [NOFB], visible: no <7> [195.062331] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] [PLANE:135:plane 5A] fb: [NOFB], visible: no <7> [195.062511] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] [PLANE:145:cursor A] fb: [NOFB], visible: no <7> [195.063107] i915 0000:03:00.0: [drm:intel_power_well_enable [i915]] enabling DC_off <7> [195.063417] i915 0000:03:00.0: [drm:gen9_set_dc_state.part.0 [i915]] Setting DC state from 01 to 00 <7> [195.063825] i915 0000:03:00.0: [drm:intel_power_well_enable [i915]] enabling PW_A <7> [195.064058] i915 0000:03:00.0: [drm:intel_power_well_enable [i915]] enabling PW_2 <7> [195.064264] i915 0000:03:00.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:507:DDI A/PHY A] <7> [195.064443] i915 0000:03:00.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:509:DP-MST A] <7> [195.064655] i915 0000:03:00.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:510:DP-MST B] <7> [195.064832] i915 0000:03:00.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:511:DP-MST C] <7> [195.065007] i915 0000:03:00.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:512:DP-MST D] <7> [195.065183] i915 0000:03:00.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:520:DDI B/PHY B] <7> [195.065358] i915 0000:03:00.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:522:DP-MST A] <7> [195.065534] i915 0000:03:00.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:523:DP-MST B] <7> [195.065750] i915 0000:03:00.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:524:DP-MST C] <7> [195.065926] i915 0000:03:00.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:525:DP-MST D] <7> [195.066102] i915 0000:03:00.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:535:DDI C/PHY C] <7> [195.066277] i915 0000:03:00.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:537:DP-MST A] <7> [195.066453] i915 0000:03:00.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:538:DP-MST B] <7> [195.066666] i915 0000:03:00.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:539:DP-MST C] <7> [195.066843] i915 0000:03:00.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:540:DP-MST D] <7> [195.067018] i915 0000:03:00.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:547:DDI D/PHY D] <7> [195.067195] i915 0000:03:00.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:549:DP-MST A] <7> [195.067370] i915 0000:03:00.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:550:DP-MST B] <7> [195.067545] i915 0000:03:00.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:551:DP-MST C] <7> [195.067787] i915 0000:03:00.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:552:DP-MST D] <7> [195.067964] i915 0000:03:00.0: [drm:gen9_dbuf_slices_update [i915]] Updating dbuf slices to 0x3 <7> [195.068352] i915 0000:03:00.0: [drm:intel_power_well_enable [i915]] enabling DDI_IO_D <7> [195.068702] i915 0000:03:00.0: [drm:intel_enable_transcoder [i915]] enabling pipe A <7> [195.087484] i915 0000:03:00.0: [drm:intel_fbc_update [i915]] reserved 17694720 bytes of contiguous stolen space for FBC, limit: 1 <7> [195.087717] i915 0000:03:00.0: [drm:intel_fbc_update [i915]] Enabling FBC on [PLANE:35:plane 1A] <7> [195.104501] i915 0000:03:00.0: [drm:verify_connector_state [i915]] [CONNECTOR:556:HDMI-A-3] <7> [195.104866] i915 0000:03:00.0: [drm:intel_modeset_verify_crtc [i915]] [CRTC:151:pipe A] <6> [201.298586] [IGT] kms_flip: finished subtest A-HDMI-A3, FAIL

<6> [193.412037] Console: switching to colour dummy device 80x25

<7> [193.435258] i915 0000:03:00.0: [drm:i915_gem_open [i915]]

<7> [193.438345] i915 0000:03:00.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc]

<7> [193.452910] i915 0000:03:00.0: [drm:i915_gem_open [i915]]

<7> [193.466572] i915 0000:03:00.0: [drm:drm_helper_probe_single_connector_modes] [CONNECTOR:508:DP-1]

<7> [193.466583] i915 0000:03:00.0: [drm:intel_dp_detect [i915]] [CONNECTOR:508:DP-1]

<7> [193.471148] i915 0000:03:00.0: [drm:drm_helper_probe_single_connector_modes] [CONNECTOR:508:DP-1] disconnected

<7> [193.471603] i915 0000:03:00.0: [drm:drm_helper_probe_single_connector_modes] [CONNECTOR:521:DP-2]

<7> [193.471620] i915 0000:03:00.0: [drm:intel_dp_detect [i915]] [CONNECTOR:521:DP-2]

<7> [193.475896] i915 0000:03:00.0: [drm:drm_helper_probe_single_connector_modes] [CONNECTOR:521:DP-2] disconnected

<7> [193.476344] i915 0000:03:00.0: [drm:drm_helper_probe_single_connector_modes] [CONNECTOR:530:HDMI-A-1]

<7> [193.476350] i915 0000:03:00.0: [drm:intel_hdmi_detect [i915]] [CONNECTOR:530:HDMI-A-1]

<7> [193.480627] i915 0000:03:00.0: [drm:drm_helper_probe_single_connector_modes] [CONNECTOR:530:HDMI-A-1] disconnected

<7> [193.481076] i915 0000:03:00.0: [drm:drm_helper_probe_single_connector_modes] [CONNECTOR:536:DP-3]

<7> [193.481082] i915 0000:03:00.0: [drm:intel_dp_detect [i915]] [CONNECTOR:536:DP-3]

<7> [193.485341] i915 0000:03:00.0: [drm:drm_helper_probe_single_connector_modes] [CONNECTOR:536:DP-3] disconnected

<7> [193.485801] i915 0000:03:00.0: [drm:drm_helper_probe_single_connector_modes] [CONNECTOR:544:HDMI-A-2]

<7> [193.485807] i915 0000:03:00.0: [drm:intel_hdmi_detect [i915]] [CONNECTOR:544:HDMI-A-2]

<7> [193.490108] i915 0000:03:00.0: [drm:drm_helper_probe_single_connector_modes] [CONNECTOR:544:HDMI-A-2] disconnected

<7> [193.490564] i915 0000:03:00.0: [drm:drm_helper_probe_single_connector_modes] [CONNECTOR:548:DP-4]

<7> [193.490570] i915 0000:03:00.0: [drm:intel_dp_detect [i915]] [CONNECTOR:548:DP-4]

<7> [193.490878] i915 0000:03:00.0: [drm:intel_power_well_enable [i915]] enabling AUX_D

<7> [193.513198] i915 0000:03:00.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DDI D/PHY D: timeout (status 0x7d40023f)

<7> [193.534358] i915 0000:03:00.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DDI D/PHY D: timeout (status 0x7d40023f)

<7> [193.555531] i915 0000:03:00.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DDI D/PHY D: timeout (status 0x7d40023f)

<7> [193.576690] i915 0000:03:00.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DDI D/PHY D: timeout (status 0x7d40023f)

<7> [193.597785] i915 0000:03:00.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DDI D/PHY D: timeout (status 0x7d40023f)

<7> [193.618893] i915 0000:03:00.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DDI D/PHY D: timeout (status 0x7d40023f)

<7> [193.640000] i915 0000:03:00.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DDI D/PHY D: timeout (status 0x7d40023f)

<7> [193.661115] i915 0000:03:00.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DDI D/PHY D: timeout (status 0x7d40023f)

<7> [193.682253] i915 0000:03:00.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DDI D/PHY D: timeout (status 0x7d40023f)

<7> [193.703371] i915 0000:03:00.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DDI D/PHY D: timeout (status 0x7d40023f)

<7> [193.724535] i915 0000:03:00.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DDI D/PHY D: timeout (status 0x7d40023f)

<7> [193.745674] i915 0000:03:00.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DDI D/PHY D: timeout (status 0x7d40023f)

<7> [193.766808] i915 0000:03:00.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DDI D/PHY D: timeout (status 0x7d40023f)

<7> [193.787946] i915 0000:03:00.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DDI D/PHY D: timeout (status 0x7d40023f)

<7> [193.809078] i915 0000:03:00.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DDI D/PHY D: timeout (status 0x7d40023f)

<7> [193.830207] i915 0000:03:00.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DDI D/PHY D: timeout (status 0x7d40023f)

<7> [193.851338] i915 0000:03:00.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DDI D/PHY D: timeout (status 0x7d40023f)

<7> [193.872514] i915 0000:03:00.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DDI D/PHY D: timeout (status 0x7d40023f)

<7> [193.893655] i915 0000:03:00.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DDI D/PHY D: timeout (status 0x7d40023f)

<7> [193.914778] i915 0000:03:00.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DDI D/PHY D: timeout (status 0x7d40023f)

<7> [193.935897] i915 0000:03:00.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DDI D/PHY D: timeout (status 0x7d40023f)

<7> [193.957039] i915 0000:03:00.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DDI D/PHY D: timeout (status 0x7d40023f)

<7> [193.978174] i915 0000:03:00.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DDI D/PHY D: timeout (status 0x7d40023f)

<7> [193.999306] i915 0000:03:00.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DDI D/PHY D: timeout (status 0x7d40023f)

<7> [194.020440] i915 0000:03:00.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DDI D/PHY D: timeout (status 0x7d40023f)

<7> [194.041581] i915 0000:03:00.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DDI D/PHY D: timeout (status 0x7d40023f)

<7> [194.062716] i915 0000:03:00.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DDI D/PHY D: timeout (status 0x7d40023f)

<7> [194.083851] i915 0000:03:00.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DDI D/PHY D: timeout (status 0x7d40023f)

<7> [194.104984] i915 0000:03:00.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DDI D/PHY D: timeout (status 0x7d40023f)

<7> [194.126118] i915 0000:03:00.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DDI D/PHY D: timeout (status 0x7d40023f)

<7> [194.147249] i915 0000:03:00.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DDI D/PHY D: timeout (status 0x7d40023f)

<7> [194.168383] i915 0000:03:00.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DDI D/PHY D: timeout (status 0x7d40023f)

<7> [194.168574] i915 0000:03:00.0: [drm:drm_dp_dpcd_access [drm_display_helper]] AUX D/DDI D/PHY D: Too many retries, giving up. First error: -110

<7> [194.168644] i915 0000:03:00.0: [drm:drm_helper_probe_single_connector_modes] [CONNECTOR:548:DP-4] disconnected

<7> [194.169292] i915 0000:03:00.0: [drm:drm_helper_probe_single_connector_modes] [CONNECTOR:508:DP-1]

<7> [194.169297] i915 0000:03:00.0: [drm:intel_dp_detect [i915]] [CONNECTOR:508:DP-1]

<7> [194.173528] i915 0000:03:00.0: [drm:drm_helper_probe_single_connector_modes] [CONNECTOR:508:DP-1] disconnected

<7> [194.173545] i915 0000:03:00.0: [drm:drm_helper_probe_single_connector_modes] [CONNECTOR:521:DP-2]

<7> [194.173549] i915 0000:03:00.0: [drm:intel_dp_detect [i915]] [CONNECTOR:521:DP-2]

<7> [194.177855] i915 0000:03:00.0: [drm:drm_helper_probe_single_connector_modes] [CONNECTOR:521:DP-2] disconnected

<7> [194.177870] i915 0000:03:00.0: [drm:drm_helper_probe_single_connector_modes] [CONNECTOR:530:HDMI-A-1]

<7> [194.177875] i915 0000:03:00.0: [drm:intel_hdmi_detect [i915]] [CONNECTOR:530:HDMI-A-1]

<7> [194.182074] i915 0000:03:00.0: [drm:drm_helper_probe_single_connector_modes] [CONNECTOR:530:HDMI-A-1] disconnected

<7> [194.182089] i915 0000:03:00.0: [drm:drm_helper_probe_single_connector_modes] [CONNECTOR:536:DP-3]

<7> [194.182093] i915 0000:03:00.0: [drm:intel_dp_detect [i915]] [CONNECTOR:536:DP-3]

<7> [194.186310] i915 0000:03:00.0: [drm:drm_helper_probe_single_connector_modes] [CONNECTOR:536:DP-3] disconnected

<7> [194.186324] i915 0000:03:00.0: [drm:drm_helper_probe_single_connector_modes] [CONNECTOR:544:HDMI-A-2]

<7> [194.186328] i915 0000:03:00.0: [drm:intel_hdmi_detect [i915]] [CONNECTOR:544:HDMI-A-2]

<7> [194.190533] i915 0000:03:00.0: [drm:drm_helper_probe_single_connector_modes] [CONNECTOR:544:HDMI-A-2] disconnected

<7> [194.190548] i915 0000:03:00.0: [drm:drm_helper_probe_single_connector_modes] [CONNECTOR:548:DP-4]

<7> [194.190552] i915 0000:03:00.0: [drm:intel_dp_detect [i915]] [CONNECTOR:548:DP-4]

<7> [194.211732] i915 0000:03:00.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DDI D/PHY D: timeout (status 0x7d40023f)

<7> [194.232831] i915 0000:03:00.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DDI D/PHY D: timeout (status 0x7d40023f)

<7> [194.253957] i915 0000:03:00.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DDI D/PHY D: timeout (status 0x7d40023f)

<7> [194.275078] i915 0000:03:00.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DDI D/PHY D: timeout (status 0x7d40023f)

<7> [194.296198] i915 0000:03:00.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DDI D/PHY D: timeout (status 0x7d40023f)

<7> [194.317317] i915 0000:03:00.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DDI D/PHY D: timeout (status 0x7d40023f)

<7> [194.338447] i915 0000:03:00.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DDI D/PHY D: timeout (status 0x7d40023f)

<7> [194.359572] i915 0000:03:00.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DDI D/PHY D: timeout (status 0x7d40023f)

<7> [194.380698] i915 0000:03:00.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DDI D/PHY D: timeout (status 0x7d40023f)

<7> [194.401838] i915 0000:03:00.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DDI D/PHY D: timeout (status 0x7d40023f)

<7> [194.422975] i915 0000:03:00.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DDI D/PHY D: timeout (status 0x7d40023f)

<7> [194.444114] i915 0000:03:00.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DDI D/PHY D: timeout (status 0x7d40023f)

<7> [194.465250] i915 0000:03:00.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DDI D/PHY D: timeout (status 0x7d40023f)

<7> [194.486369] i915 0000:03:00.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DDI D/PHY D: timeout (status 0x7d40023f)

<7> [194.507519] i915 0000:03:00.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DDI D/PHY D: timeout (status 0x7d40023f)

<7> [194.528658] i915 0000:03:00.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DDI D/PHY D: timeout (status 0x7d40023f)

<7> [194.549783] i915 0000:03:00.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DDI D/PHY D: timeout (status 0x7d40023f)

<7> [194.570925] i915 0000:03:00.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DDI D/PHY D: timeout (status 0x7d40023f)

<7> [194.592061] i915 0000:03:00.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DDI D/PHY D: timeout (status 0x7d40023f)

<7> [194.613196] i915 0000:03:00.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DDI D/PHY D: timeout (status 0x7d40023f)

<7> [194.634332] i915 0000:03:00.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DDI D/PHY D: timeout (status 0x7d40023f)

<7> [194.655515] i915 0000:03:00.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DDI D/PHY D: timeout (status 0x7d40023f)

<7> [194.676655] i915 0000:03:00.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DDI D/PHY D: timeout (status 0x7d40023f)

<7> [194.697804] i915 0000:03:00.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DDI D/PHY D: timeout (status 0x7d40023f)

<7> [194.718944] i915 0000:03:00.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DDI D/PHY D: timeout (status 0x7d40023f)

<7> [194.740080] i915 0000:03:00.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DDI D/PHY D: timeout (status 0x7d40023f)

<7> [194.761200] i915 0000:03:00.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DDI D/PHY D: timeout (status 0x7d40023f)

<7> [194.782322] i915 0000:03:00.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DDI D/PHY D: timeout (status 0x7d40023f)

<7> [194.803505] i915 0000:03:00.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DDI D/PHY D: timeout (status 0x7d40023f)

<7> [194.824646] i915 0000:03:00.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DDI D/PHY D: timeout (status 0x7d40023f)

<7> [194.845776] i915 0000:03:00.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DDI D/PHY D: timeout (status 0x7d40023f)

<7> [194.866915] i915 0000:03:00.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DDI D/PHY D: timeout (status 0x7d40023f)

<7> [194.867112] i915 0000:03:00.0: [drm:drm_dp_dpcd_access [drm_display_helper]] AUX D/DDI D/PHY D: Too many retries, giving up. First error: -110

<7> [194.867160] i915 0000:03:00.0: [drm:drm_helper_probe_single_connector_modes] [CONNECTOR:548:DP-4] disconnected

<7> [194.867182] i915 0000:03:00.0: [drm:drm_helper_probe_single_connector_modes] [CONNECTOR:556:HDMI-A-3]

<7> [194.867188] i915 0000:03:00.0: [drm:intel_hdmi_detect [i915]] [CONNECTOR:556:HDMI-A-3]

<7> [194.891485] i915 0000:03:00.0: [drm:update_display_info.part.0] [CONNECTOR:556:HDMI-A-3] ELD monitor FH-DP4K

<7> [194.891491] i915 0000:03:00.0: [drm:update_display_info.part.0] [CONNECTOR:556:HDMI-A-3] ELD size 36, SAD count 2

<7> [194.891676] i915 0000:03:00.0: [drm:do_gmbus_xfer [i915]] GMBUS [i915 gmbus dpd] NAK for addr: 0040 w(1)

<7> [194.891867] i915 0000:03:00.0: [drm:do_gmbus_xfer [i915]] GMBUS [i915 gmbus dpd] NAK on first message, retry

<7> [194.892186] i915 0000:03:00.0: [drm:do_gmbus_xfer [i915]] GMBUS [i915 gmbus dpd] NAK for addr: 0040 w(1)

<7> [194.892396] i915 0000:03:00.0: [drm:drm_dp_dual_mode_detect [drm_display_helper]] DP dual mode HDMI ID: (err -6)

<7> [194.892412] i915 0000:03:00.0: [drm:intel_hdmi_set_edid [i915]] Assuming DP dual mode adaptor presence based on VBT

<7> [194.892605] i915 0000:03:00.0: [drm:intel_hdmi_set_edid [i915]] DP dual mode adaptor (type 1 DVI) detected (max TMDS clock: 165000 kHz)

<7> [194.893314] i915 0000:03:00.0: [drm:drm_mode_prune_invalid] Rejected mode: "2560x1440": 60 241700 2560 2608 2640 2720 1440 1443 1448 1481 0x40 0x9 (CLOCK_HIGH)

<7> [194.893322] i915 0000:03:00.0: [drm:drm_mode_prune_invalid] Rejected mode: "2560x1600": 60 267820 2560 2608 2640 2720 1600 1603 1608 1641 0x40 0x9 (CLOCK_HIGH)

<7> [194.893327] i915 0000:03:00.0: [drm:drm_mode_prune_invalid] Rejected mode: "1920x1080": 120 297000 1920 2008 2052 2200 1080 1084 1089 1125 0x40 0x5 (CLOCK_HIGH)

<7> [194.893333] i915 0000:03:00.0: [drm:drm_mode_prune_invalid] Rejected mode: "3840x2160": 30 266640 3840 3888 3920 4000 2160 2163 2168 2222 0x40 0x9 (CLOCK_HIGH)

<7> [194.893338] i915 0000:03:00.0: [drm:drm_mode_prune_invalid] Rejected mode: "1920x1080": 120 296703 1920 2008 2052 2200 1080 1084 1089 1125 0x40 0x5 (CLOCK_HIGH)

<7> [194.893344] i915 0000:03:00.0: [drm:drm_helper_probe_single_connector_modes] [CONNECTOR:556:HDMI-A-3] probed modes:

<7> [194.893348] i915 0000:03:00.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "1920x1080": 60 148500 1920 2008 2052 2200 1080 1084 1089 1125 0x48 0x5

<7> [194.893352] i915 0000:03:00.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "3840x2160": 17 151100 3840 3888 3920 4000 2160 2163 2168 2222 0x40 0x9

<7> [194.893356] i915 0000:03:00.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "2560x1600": 30 133910 2560 2608 2640 2720 1600 1603 1608 1641 0x40 0x9

<7> [194.893359] i915 0000:03:00.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "2560x1440": 30 120850 2560 2608 2640 2720 1440 1443 1448 1481 0x40 0x9

<7> [194.893363] i915 0000:03:00.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "1920x1200": 60 154000 1920 1968 2000 2080 1200 1203 1209 1235 0x40 0x9

<7> [194.893366] i915 0000:03:00.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "1920x1080": 60 148352 1920 2008 2052 2200 1080 1084 1089 1125 0x40 0x5

<7> [194.893370] i915 0000:03:00.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "1680x1050": 60 119000 1680 1728 1760 1840 1050 1053 1059 1080 0x40 0x9

<7> [194.893374] i915 0000:03:00.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "1600x900": 60 108000 1600 1624 1704 1800 900 901 904 1000 0x40 0x5

<7> [194.893377] i915 0000:03:00.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "1280x1024": 75 135000 1280 1296 1440 1688 1024 1025 1028 1066 0x40 0x5

<7> [194.893381] i915 0000:03:00.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "1280x1024": 60 108000 1280 1328 1440 1688 1024 1025 1028 1066 0x40 0x5

<7> [194.893384] i915 0000:03:00.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "1440x900": 60 88750 1440 1488 1520 1600 900 903 909 926 0x40 0x9

<7> [194.893388] i915 0000:03:00.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "1280x800": 60 71000 1280 1328 1360 1440 800 803 809 823 0x40 0x9

<7> [194.893391] i915 0000:03:00.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "1152x864": 75 108000 1152 1216 1344 1600 864 865 868 900 0x40 0x5

<7> [194.893395] i915 0000:03:00.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "1280x720": 60 74250 1280 1390 1430 1650 720 725 730 750 0x40 0x5

<7> [194.893399] i915 0000:03:00.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "1280x720": 60 74176 1280 1390 1430 1650 720 725 730 750 0x40 0x5

<7> [194.893402] i915 0000:03:00.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "1024x768": 75 78750 1024 1040 1136 1312 768 769 772 800 0x40 0x5

<7> [194.893406] i915 0000:03:00.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "1024x768": 70 75000 1024 1048 1184 1328 768 771 777 806 0x40 0xa

<7> [194.893409] i915 0000:03:00.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "1024x768": 60 65000 1024 1048 1184 1344 768 771 777 806 0x40 0xa

<7> [194.893413] i915 0000:03:00.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "800x600": 75 49500 800 816 896 1056 600 601 604 625 0x40 0x5

<7> [194.893416] i915 0000:03:00.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "800x600": 72 50000 800 856 976 1040 600 637 643 666 0x40 0x5

<7> [194.893420] i915 0000:03:00.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "800x600": 60 40000 800 840 968 1056 600 601 605 628 0x40 0x5

<7> [194.893423] i915 0000:03:00.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "800x600": 56 36000 800 824 896 1024 600 601 603 625 0x40 0x5

<7> [194.893427] i915 0000:03:00.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "640x480": 75 31500 640 656 720 840 480 481 484 500 0x40 0xa

<7> [194.893430] i915 0000:03:00.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "640x480": 73 31500 640 664 704 832 480 489 492 520 0x40 0xa

<7> [194.893434] i915 0000:03:00.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "640x480": 60 25200 640 656 752 800 480 490 492 525 0x40 0xa

<7> [194.893453] i915 0000:03:00.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "640x480": 60 25175 640 656 752 800 480 490 492 525 0x40 0xa

<6> [194.898807] [IGT] kms_flip: starting subtest flip-vs-expired-vblank-interruptible

<6> [194.905422] [IGT] kms_flip: starting dynamic subtest A-HDMI-A3

<7> [194.905929] i915 0000:03:00.0: [drm:drm_mode_addfb2] [FB:562]

<7> [194.906115] i915 0000:03:00.0: [drm:drm_mode_addfb2] [FB:563]

<7> [194.906660] [drm:eb_validate_vma [i915]] EINVAL at eb_validate_vma:509

<7> [194.907082] [drm:eb_validate_vma [i915]] EINVAL at eb_validate_vma:509

<7> [194.932669] i915 0000:03:00.0: [drm:intel_power_well_disable [i915]] disabling AUX_D

<7> [194.965178] [drm:eb_validate_vma [i915]] EINVAL at eb_validate_vma:509

<7> [194.965531] [drm:eb_validate_vma [i915]] EINVAL at eb_validate_vma:509

<7> [194.972658] [drm:eb_validate_vma [i915]] EINVAL at eb_validate_vma:509

<7> [194.972980] [drm:eb_validate_vma [i915]] EINVAL at eb_validate_vma:509

<7> [194.993818] [drm:eb_validate_vma [i915]] EINVAL at eb_validate_vma:509

<7> [194.994156] [drm:eb_validate_vma [i915]] EINVAL at eb_validate_vma:509

<7> [194.999341] i915 0000:03:00.0: [drm:drm_mode_setcrtc] [CRTC:151:pipe A]

<7> [194.999442] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:151:pipe A] fastset requirement not met in hw.enable (expected yes, found no)

<7> [194.999690] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:151:pipe A] fastset requirement not met in hw.active (expected yes, found no)

<7> [194.999906] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:151:pipe A] fastset requirement not met in cpu_transcoder (expected 0, found -1)

<7> [195.000088] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:151:pipe A] fastset requirement not met in lane_count (expected 4, found 0)

<7> [195.000273] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:151:pipe A] fastset requirement not met in output_types (expected 0x00000040, found 0x00000000)

<7> [195.000456] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:151:pipe A] fastset requirement not met in framestart_delay (expected 1, found 0)

<7> [195.000688] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:151:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hdisplay (expected 1920, found 0)

<7> [195.000870] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:151:pipe A] fastset requirement not met in hw.pipe_mode.crtc_htotal (expected 2200, found 0)

<7> [195.001051] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:151:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hblank_start (expected 1920, found 0)

<7> [195.001232] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:151:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hblank_end (expected 2200, found 0)

<7> [195.001411] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:151:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hsync_start (expected 2008, found 0)

<7> [195.001617] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:151:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hsync_end (expected 2052, found 0)

<7> [195.001816] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:151:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vdisplay (expected 1080, found 0)

<7> [195.001998] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:151:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vblank_start (expected 1080, found 0)

<7> [195.002178] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:151:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vsync_start (expected 1084, found 0)

<7> [195.002359] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:151:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vsync_end (expected 1089, found 0)

<7> [195.002539] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:151:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vtotal (expected 1125, found 0)

<7> [195.002877] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:151:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vblank_end (expected 1125, found 0)

<7> [195.003064] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:151:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hdisplay (expected 1920, found 0)

<7> [195.003246] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:151:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_htotal (expected 2200, found 0)

<7> [195.003427] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:151:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hblank_start (expected 1920, found 0)

<7> [195.003788] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:151:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hblank_end (expected 2200, found 0)

<7> [195.003973] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:151:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hsync_start (expected 2008, found 0)

<7> [195.004155] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:151:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hsync_end (expected 2052, found 0)

<7> [195.004336] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:151:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vdisplay (expected 1080, found 0)

<7> [195.004517] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:151:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vblank_start (expected 1080, found 0)

<7> [195.004738] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:151:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vsync_start (expected 1084, found 0)

<7> [195.004920] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:151:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vsync_end (expected 1089, found 0)

<7> [195.005101] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:151:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vtotal (expected 1125, found 0)

<7> [195.005282] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:151:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vblank_end (expected 1125, found 0)

<7> [195.005462] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:151:pipe A] fastset requirement not met in pixel_multiplier (expected 1, found 0)

<7> [195.005683] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:151:pipe A] fastset requirement not met in hw.adjusted_mode.flags (1) (expected 1, found 0)

<7> [195.005869] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:151:pipe A] fastset requirement not met in hw.adjusted_mode.flags (4) (expected 4, found 0)

<7> [195.006052] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:151:pipe A] fastset requirement not met in pipe_bpp (expected 24, found 0)

<7> [195.006232] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:151:pipe A] fastset requirement not met in hw.pipe_mode.crtc_clock (expected 148500, found 0)

<7> [195.006412] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:151:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_clock (expected 148500, found 0)

<7> [195.006618] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:151:pipe A] fastset requirement not met in port_clock (expected 148500, found 0)

<7> [195.006814] i915 0000:03:00.0: [drm:intel_atomic_check [i915]] [CRTC:151:pipe A] fastset requirement not met, forcing full modeset

<7> [195.007022] i915 0000:03:00.0: [drm:skl_compute_wm [i915]] Enabled dbuf slices 0x3 -> 0x1 (total dbuf slices 0xf), mbus joined? no->no

<7> [195.007196] i915 0000:03:00.0: [drm:skl_compute_wm [i915]] [CRTC:151:pipe A] dbuf slices 0x3 -> 0x0, ddb (0 - 2048) -> (0 - 0), active pipes 0x1 -> 0x0

<7> [195.007394] i915 0000:03:00.0: [drm:skl_print_plane_ddb_changes [i915]] [PLANE:35:plane 1A] ddb ( 0 - 1963) -> ( 0 - 0), size 1963 -> 0

<7> [195.007566] i915 0000:03:00.0: [drm:skl_print_plane_ddb_changes [i915]] [PLANE:145:cursor A] ddb (1963 - 2048) -> ( 0 - 0), size 85 -> 0

<7> [195.007787] i915 0000:03:00.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> [195.007959] i915 0000:03:00.0: [drm:skl_print_plane_wm_changes [i915]] [PLANE:35:plane 1A] lines 1, 3, 4, 5, 9, 11, 17, 25, 0, 0, 0 -> 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0

<7> [195.008130] i915 0000:03:00.0: [drm:skl_print_plane_wm_changes [i915]] [PLANE:35:plane 1A] blocks 16, 49, 65, 81, 145, 177, 273, 401, 30, 0, 0 -> 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0

<7> [195.008302] i915 0000:03:00.0: [drm:skl_print_plane_wm_changes [i915]] [PLANE:35:plane 1A] min_ddb 19, 55, 73, 91, 161, 196, 302, 443, 31, 0, 0 -> 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0

<7> [195.008490] i915 0000:03:00.0: [drm:intel_bw_atomic_check [i915]] [CRTC:151:pipe A] data rate 0 num active planes 0

<7> [195.008677] i915 0000:03:00.0: [drm:intel_bw_atomic_check [i915]] QGV point 0: max bw 50000 required 0

<7> [195.008857] i915 0000:03:00.0: [drm:intel_bw_atomic_check [i915]] No SAGV, using single QGV point mask 0x1

<7> [195.009050] i915 0000:03:00.0: [drm:intel_cdclk_atomic_check [i915]] [CRTC:151:pipe A] min cdclk: 74250 kHz -> 0 kHz

<7> [195.009243] i915 0000:03:00.0: [drm:intel_cdclk_update_dbuf_bw_min_cdclk [i915]] dbuf bandwidth min cdclk: 9282 kHz -> 0 kHz

<7> [195.009421] i915 0000:03:00.0: [drm:intel_cdclk_atomic_check [i915]] New cdclk calculated to be logical 163200 kHz, actual 163200 kHz

<7> [195.009606] i915 0000:03:00.0: [drm:intel_cdclk_atomic_check [i915]] New voltage level calculated to be logical 0, actual 0

<7> [195.009787] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] [CRTC:151:pipe A] enable: no [modeset]

<7> [195.009969] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] [PLANE:35:plane 1A] fb: [NOFB], visible: no

<7> [195.010149] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] [PLANE:65:plane 2A] fb: [NOFB], visible: no

<7> [195.010329] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] [PLANE:95:plane 3A] fb: [NOFB], visible: no

<7> [195.010508] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] [PLANE:125:plane 4A] fb: [NOFB], visible: no

<7> [195.010730] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] [PLANE:135:plane 5A] fb: [NOFB], visible: no

<7> [195.010910] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] [PLANE:145:cursor A] fb: [NOFB], visible: no

<7> [195.019984] i915 0000:03:00.0: [drm:intel_disable_transcoder [i915]] disabling pipe A

<7> [195.036781] i915 0000:03:00.0: [drm:intel_power_well_disable [i915]] disabling DDI_IO_D

<7> [195.037036] i915 0000:03:00.0: [drm:__intel_fbc_disable [i915]] Disabling FBC on [PLANE:35:plane 1A]

<7> [195.037233] i915 0000:03:00.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:507:DDI A/PHY A]

<7> [195.037411] i915 0000:03:00.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:509:DP-MST A]

<7> [195.037599] i915 0000:03:00.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:510:DP-MST B]

<7> [195.037817] i915 0000:03:00.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:511:DP-MST C]

<7> [195.037996] i915 0000:03:00.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:512:DP-MST D]

<7> [195.038173] i915 0000:03:00.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:520:DDI B/PHY B]

<7> [195.038348] i915 0000:03:00.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:522:DP-MST A]

<7> [195.038525] i915 0000:03:00.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:523:DP-MST B]

<7> [195.038744] i915 0000:03:00.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:524:DP-MST C]

<7> [195.038920] i915 0000:03:00.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:525:DP-MST D]

<7> [195.039096] i915 0000:03:00.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:535:DDI C/PHY C]

<7> [195.039274] i915 0000:03:00.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:537:DP-MST A]

<7> [195.039451] i915 0000:03:00.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:538:DP-MST B]

<7> [195.039664] i915 0000:03:00.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:539:DP-MST C]

<7> [195.039841] i915 0000:03:00.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:540:DP-MST D]

<7> [195.040017] i915 0000:03:00.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:547:DDI D/PHY D]

<7> [195.040213] i915 0000:03:00.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:549:DP-MST A]

<7> [195.040390] i915 0000:03:00.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:550:DP-MST B]

<7> [195.040576] i915 0000:03:00.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:551:DP-MST C]

<7> [195.040788] i915 0000:03:00.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:552:DP-MST D]

<7> [195.040965] i915 0000:03:00.0: [drm:verify_connector_state [i915]] [CONNECTOR:556:HDMI-A-3]

<7> [195.041179] i915 0000:03:00.0: [drm:gen9_dbuf_slices_update [i915]] Updating dbuf slices to 0x1

<7> [195.041465] i915 0000:03:00.0: [drm:intel_power_well_disable [i915]] disabling PW_A

<7> [195.041754] i915 0000:03:00.0: [drm:intel_power_well_disable [i915]] disabling PW_2

<7> [195.041982] i915 0000:03:00.0: [drm:intel_modeset_verify_crtc [i915]] [CRTC:151:pipe A]

<7> [195.042379] i915 0000:03:00.0: [drm:drm_mode_setcrtc] [CRTC:269:pipe C]

<7> [195.042542] i915 0000:03:00.0: [drm:drm_mode_setcrtc] [CRTC:387:pipe B]

<7> [195.042742] i915 0000:03:00.0: [drm:drm_mode_setcrtc] [CRTC:505:pipe D]

<7> [195.042894] i915 0000:03:00.0: [drm:drm_mode_setcrtc] [CRTC:151:pipe A]

<7> [195.042925] i915 0000:03:00.0: [drm:drm_mode_setcrtc] [CONNECTOR:556:HDMI-A-3]

<7> [195.042998] i915 0000:03:00.0: [drm:compute_baseline_pipe_bpp [i915]] [CONNECTOR:556:HDMI-A-3] Limiting target display pipe bpp to 24 (EDID bpp 0, max requested bpp 36, max platform bpp 36)

<7> [195.043195] i915 0000:03:00.0: [drm:intel_hdmi_compute_output_format [i915]] picking 8 bpc for HDMI output (pipe bpp: 24)

<7> [195.043363] i915 0000:03:00.0: [drm:intel_atomic_check [i915]] [CRTC:151:pipe A] hw max bpp: 24, pipe bpp: 24, dithering: 0

<7> [195.043545] i915 0000:03:00.0: [drm:intel_ddi_compute_config_late [i915]] [ENCODER:547:DDI D/PHY D] [CRTC:151:pipe A]

<7> [195.043753] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:151:pipe A] fastset requirement not met in hw.enable (expected no, found yes)

<7> [195.043936] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:151:pipe A] fastset requirement not met in hw.active (expected no, found yes)

<7> [195.044117] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:151:pipe A] fastset requirement not met in cpu_transcoder (expected -1, found 0)

<7> [195.044299] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:151:pipe A] fastset requirement not met in lane_count (expected 0, found 4)

<7> [195.044480] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:151:pipe A] fastset requirement not met in output_types (expected 0x00000000, found 0x00000040)

<7> [195.044703] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:151:pipe A] fastset requirement not met in framestart_delay (expected 0, found 1)

<7> [195.044885] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:151:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hdisplay (expected 0, found 1920)

<7> [195.045070] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:151:pipe A] fastset requirement not met in hw.pipe_mode.crtc_htotal (expected 0, found 2200)

<7> [195.045250] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:151:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hblank_start (expected 0, found 1920)

<7> [195.045430] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:151:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hblank_end (expected 0, found 2200)

<7> [195.045654] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:151:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hsync_start (expected 0, found 2008)

<7> [195.045836] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:151:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hsync_end (expected 0, found 2052)

<7> [195.046016] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:151:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vdisplay (expected 0, found 1080)

<7> [195.046196] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:151:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vblank_start (expected 0, found 1080)

<7> [195.046377] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:151:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vsync_start (expected 0, found 1084)

<7> [195.046557] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:151:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vsync_end (expected 0, found 1089)

<7> [195.046816] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:151:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vtotal (expected 0, found 1125)

<7> [195.046998] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:151:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vblank_end (expected 0, found 1125)

<7> [195.047179] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:151:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hdisplay (expected 0, found 1920)

<7> [195.047360] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:151:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_htotal (expected 0, found 2200)

<7> [195.047540] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:151:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hblank_start (expected 0, found 1920)

<7> [195.047761] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:151:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hblank_end (expected 0, found 2200)

<7> [195.047941] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:151:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hsync_start (expected 0, found 2008)

<7> [195.048121] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:151:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hsync_end (expected 0, found 2052)

<7> [195.048303] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:151:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vdisplay (expected 0, found 1080)

<7> [195.048484] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:151:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vblank_start (expected 0, found 1080)

<7> [195.048704] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:151:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vsync_start (expected 0, found 1084)

<7> [195.048885] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:151:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vsync_end (expected 0, found 1089)

<7> [195.049065] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:151:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vtotal (expected 0, found 1125)

<7> [195.049244] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:151:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vblank_end (expected 0, found 1125)

<7> [195.049424] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:151:pipe A] fastset requirement not met in pixel_multiplier (expected 0, found 1)

<7> [195.049644] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:151:pipe A] fastset requirement not met in hw.adjusted_mode.flags (1) (expected 0, found 1)

<7> [195.049824] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:151:pipe A] fastset requirement not met in hw.adjusted_mode.flags (4) (expected 0, found 4)

<7> [195.050005] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:151:pipe A] fastset requirement not met in pipe_bpp (expected 0, found 24)

<7> [195.050185] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:151:pipe A] fastset requirement not met in hw.pipe_mode.crtc_clock (expected 0, found 148500)

<7> [195.050365] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:151:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_clock (expected 0, found 148500)

<7> [195.050546] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:151:pipe A] fastset requirement not met in port_clock (expected 0, found 148500)

<7> [195.050820] i915 0000:03:00.0: [drm:intel_atomic_check [i915]] [CRTC:151:pipe A] fastset requirement not met, forcing full modeset

<7> [195.051028] i915 0000:03:00.0: [drm:skl_compute_wm [i915]] Enabled dbuf slices 0x1 -> 0x3 (total dbuf slices 0xf), mbus joined? no->no

<7> [195.051203] i915 0000:03:00.0: [drm:skl_compute_wm [i915]] [CRTC:151:pipe A] dbuf slices 0x0 -> 0x3, ddb (0 - 0) -> (0 - 2048), active pipes 0x0 -> 0x1

<7> [195.051402] i915 0000:03:00.0: [drm:skl_print_plane_ddb_changes [i915]] [PLANE:35:plane 1A] ddb ( 0 - 0) -> ( 0 - 1963), size 0 -> 1963

<7> [195.051581] i915 0000:03:00.0: [drm:skl_print_plane_ddb_changes [i915]] [PLANE:145:cursor A] ddb ( 0 - 0) -> (1963 - 2048), size 0 -> 85

<7> [195.051786] i915 0000:03:00.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> [195.051957] i915 0000:03:00.0: [drm:skl_print_plane_wm_changes [i915]] [PLANE:35:plane 1A] lines 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0 -> 4, 4, 4, 5, 9, 11, 17, 25, 0, 0, 0

<7> [195.052129] i915 0000:03:00.0: [drm:skl_print_plane_wm_changes [i915]] [PLANE:35:plane 1A] blocks 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0 -> 62, 62, 62, 78, 139, 169, 261, 383, 137, 0, 0

<7> [195.052303] i915 0000:03:00.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 -> 123, 123, 123, 184, 245, 245, 367, 489, 138, 0, 0

<7> [195.052490] i915 0000:03:00.0: [drm:intel_bw_atomic_check [i915]] [CRTC:151:pipe A] data rate 594000 num active planes 1

<7> [195.052710] i915 0000:03:00.0: [drm:intel_bw_atomic_check [i915]] QGV point 0: max bw 50000 required 624

<7> [195.052887] i915 0000:03:00.0: [drm:intel_bw_atomic_check [i915]] No SAGV, using single QGV point mask 0x1

<7> [195.053078] i915 0000:03:00.0: [drm:intel_cdclk_atomic_check [i915]] [CRTC:151:pipe A] min cdclk: 0 kHz -> 74250 kHz

<7> [195.053270] i915 0000:03:00.0: [drm:intel_cdclk_update_dbuf_bw_min_cdclk [i915]] dbuf bandwidth min cdclk: 0 kHz -> 9282 kHz

<7> [195.053450] i915 0000:03:00.0: [drm:intel_cdclk_atomic_check [i915]] New cdclk calculated to be logical 163200 kHz, actual 163200 kHz

<7> [195.053669] i915 0000:03:00.0: [drm:intel_cdclk_atomic_check [i915]] New voltage level calculated to be logical 0, actual 0

<7> [195.053850] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] [CRTC:151:pipe A] enable: yes [modeset]

<7> [195.054029] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] active: yes, output_types: HDMI (0x40), output format: RGB, sink format: RGB

<7> [195.054209] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] cpu_transcoder: A, pipe bpp: 24, dithering: 0

<7> [195.054388] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] MST master transcoder: <invalid>

<7> [195.054574] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] port sync: master transcoder: <invalid>, slave transcoder bitmask = 0x0

<7> [195.054788] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] joiner: no, pipes: 0x0

<7> [195.054967] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] splitter: disabled, link count 0, overlap 0

<7> [195.055147] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] audio: 0, infoframes: 0, infoframes enabled: 0x0

<7> [195.055327] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] scanline offset: 2

<7> [195.055505] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] framestart delay: 1, MSA timing delay: 0, set context latency: 0

<7> [195.055724] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] vrr: no, fixed rr: yes, vmin: 1125, vmax: 1125, flipline: 1125, pipeline full: 0, guardband: 45 vsync start: 41, vsync end: 36

<7> [195.055904] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] vrr: vmin vblank: 1080, vmax vblank: 1080, vmin vtotal: 1125, vmax vtotal: 1125

<7> [195.056084] i915 0000:03:00.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> [195.056264] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] requested mode: "1920x1080": 60 148500 1920 2008 2052 2200 1080 1084 1089 1125 0x48 0x5

<7> [195.056445] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] adjusted mode: "1920x1080": 60 148500 1920 2008 2052 2200 1080 1084 1089 1125 0x48 0x5

<7> [195.056666] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] crtc timings: clock=148500, hd=1920 hb=1920-2200 hs=2008-2052 ht=2200, vd=1080 vb=1080-1125 vs=1084-1089 vt=1125, flags=0x5

<7> [195.056845] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] pipe mode: "1920x1080": 60 148500 1920 2008 2052 2200 1080 1084 1089 1125 0x40 0x5

<7> [195.057025] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] crtc timings: clock=148500, hd=1920 hb=1920-2200 hs=2008-2052 ht=2200, vd=1080 vb=1080-1125 vs=1084-1089 vt=1125, flags=0x5

<7> [195.057204] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] port clock: 148500, pixel rate 148500, min cdclk 74250, min voltage level 0

<7> [195.057383] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] linetime: 119, ips linetime: 0

<7> [195.057562] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] num_scalers: 2, scaler_users: 0x0, scaler_id: -1, scaling_filter: 0, sharpness_strength: 0

<7> [195.057783] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] pipe src: 1920x1080+0+0

<7> [195.057964] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] pch pfit: 0x0+0+0, disabled, force thru: no

<7> [195.058143] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] sharpness strength: 0, sharpness tap size: 0, sharpness enable: 0

<7> [195.058323] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] ips: 0, double wide: 0, drrs: 0

<7> [195.058501] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] dpll_hw_state: dpll: 0x24414, dpll_md: 0x18000000, fp0: 0x8801ef8, fp1: 0x2b000440

<7> [195.058718] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] csc_mode: 0x0 gamma_mode: 0x0 gamma_enable: 0 csc_enable: 0

<7> [195.058899] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] pre csc lut: 0 entries, post csc lut: 0 entries

<7> [195.059079] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] output csc: pre offsets: 0x0000 0x0000 0x0000

<7> [195.059258] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] output csc: coefficients: 0x0000 0x0000 0x0000

<7> [195.059437] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] output csc: coefficients: 0x0000 0x0000 0x0000

<7> [195.059656] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] output csc: coefficients: 0x0000 0x0000 0x0000

<7> [195.059835] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] output csc: post offsets: 0x0000 0x0000 0x0000

<7> [195.060013] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] pipe csc: pre offsets: 0x0000 0x0000 0x0000

<7> [195.060194] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] pipe csc: coefficients: 0x0000 0x0000 0x0000

<7> [195.060373] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] pipe csc: coefficients: 0x0000 0x0000 0x0000

<7> [195.060552] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] pipe csc: coefficients: 0x0000 0x0000 0x0000

<7> [195.060775] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] pipe csc: post offsets: 0x0000 0x0000 0x0000

<7> [195.060826] i915 0000:03:00.0: [drm:intel_power_well_disable [i915]] disabling DC_off

<7> [195.060956] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] [PLANE:35:plane 1A] fb: [FB:562] 1920x1080 format = XR24 little-endian (0x34325258) modifier = 0x100000000000009, visible: yes

<7> [195.061061] i915 0000:03:00.0: [drm:gen9_enable_dc5 [i915]] Enabling DC5

<7> [195.061137] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] rotation: 0x1, scaler: -1, scaling_filter: 1

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

<7> [195.061315] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] src: 1920.000000x1080.000000+0.000000+0.000000 dst: 1920x1080+0+0

<7> [195.061495] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] [PLANE:65:plane 2A] fb: [NOFB], visible: no

<7> [195.061942] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] [PLANE:95:plane 3A] fb: [NOFB], visible: no

<7> [195.062151] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] [PLANE:125:plane 4A] fb: [NOFB], visible: no

<7> [195.062331] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] [PLANE:135:plane 5A] fb: [NOFB], visible: no

<7> [195.062511] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] [PLANE:145:cursor A] fb: [NOFB], visible: no

<7> [195.063107] i915 0000:03:00.0: [drm:intel_power_well_enable [i915]] enabling DC_off

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

<7> [195.063825] i915 0000:03:00.0: [drm:intel_power_well_enable [i915]] enabling PW_A

<7> [195.064058] i915 0000:03:00.0: [drm:intel_power_well_enable [i915]] enabling PW_2

<7> [195.064264] i915 0000:03:00.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:507:DDI A/PHY A]

<7> [195.064443] i915 0000:03:00.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:509:DP-MST A]

<7> [195.064655] i915 0000:03:00.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:510:DP-MST B]

<7> [195.064832] i915 0000:03:00.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:511:DP-MST C]

<7> [195.065007] i915 0000:03:00.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:512:DP-MST D]

<7> [195.065183] i915 0000:03:00.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:520:DDI B/PHY B]

<7> [195.065358] i915 0000:03:00.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:522:DP-MST A]

<7> [195.065534] i915 0000:03:00.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:523:DP-MST B]

<7> [195.065750] i915 0000:03:00.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:524:DP-MST C]

<7> [195.065926] i915 0000:03:00.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:525:DP-MST D]

<7> [195.066102] i915 0000:03:00.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:535:DDI C/PHY C]

<7> [195.066277] i915 0000:03:00.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:537:DP-MST A]

<7> [195.066453] i915 0000:03:00.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:538:DP-MST B]

<7> [195.066666] i915 0000:03:00.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:539:DP-MST C]

<7> [195.066843] i915 0000:03:00.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:540:DP-MST D]

<7> [195.067018] i915 0000:03:00.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:547:DDI D/PHY D]

<7> [195.067195] i915 0000:03:00.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:549:DP-MST A]

<7> [195.067370] i915 0000:03:00.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:550:DP-MST B]

<7> [195.067545] i915 0000:03:00.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:551:DP-MST C]

<7> [195.067787] i915 0000:03:00.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:552:DP-MST D]

<7> [195.067964] i915 0000:03:00.0: [drm:gen9_dbuf_slices_update [i915]] Updating dbuf slices to 0x3

<7> [195.068352] i915 0000:03:00.0: [drm:intel_power_well_enable [i915]] enabling DDI_IO_D

<7> [195.068702] i915 0000:03:00.0: [drm:intel_enable_transcoder [i915]] enabling pipe A

<7> [195.087484] i915 0000:03:00.0: [drm:intel_fbc_update [i915]] reserved 17694720 bytes of contiguous stolen space for FBC, limit: 1

<7> [195.087717] i915 0000:03:00.0: [drm:intel_fbc_update [i915]] Enabling FBC on [PLANE:35:plane 1A]

<7> [195.104501] i915 0000:03:00.0: [drm:verify_connector_state [i915]] [CONNECTOR:556:HDMI-A-3]

<7> [195.104866] i915 0000:03:00.0: [drm:intel_modeset_verify_crtc [i915]] [CRTC:151:pipe A]

<6> [201.298586] [IGT] kms_flip: finished subtest A-HDMI-A3, FAIL

Results for igt@kms_flip@flip-vs-expired-vblank-interruptible@a-hdmi-a3