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

Machine description: shard-tglu-4

Result: Fail

integration-manifest git-log-oneline i915_display_info9 igt_runner9 run9 runtimes9 results9.json i915_display_info_post_exec9 boot9 dmesg9

DetailValue
Duration 10.89 seconds
Hostname 
shard-tglu-4
Igt-Version 
IGT-Version: 1.29-NO-GIT (x86_64) (Linux: 6.12.0-rc2-CI_DRM_15487-gd6a4624817a4+ x86_64)
Out 
Using IGT_SRANDOM=1728421269 for randomisation
Opened device: /dev/dri/card0
Using monotonic timestamps
Starting subtest: blocking-wf_vblank
Starting dynamic subtest: A-HDMI-A1
  1920x1080: 120 285500 1920 1968 2000 2080 1080 1083 1088 1144 0x48 0x5 
Expected frametime: 8335us; measured 8300.9us +- 3.793us accuracy 0.14%
vblank interval differs from modeline! expected 8334.6us, measured 8301us +- 3.793us, difference 33.7us (8.9 sigma)
Stack trace:
  #0 ../lib/igt_core.c:2051 __igt_fail_assert()
  #1 ../tests/kms_flip.c:791 run_test_on_crtc_set.constprop.0()
  #2 ../tests/kms_flip.c:1845 run_test()
  #3 ../tests/kms_flip.c:2078 __igt_unique____real_main2001()
  #4 ../tests/kms_flip.c:2001 main()
  #5 [__libc_init_first+0x8a]
  #6 [__libc_start_main+0x8b]
  #7 [_start+0x25]
Dynamic subtest A-HDMI-A1: FAIL (10.888s)
Err 
Starting subtest: blocking-wf_vblank
Starting dynamic subtest: A-HDMI-A1
(kms_flip:1159) CRITICAL: Test assertion failure function __run_test_on_crtc_set, file ../tests/kms_flip.c:1674:
(kms_flip:1159) CRITICAL: Failed assertion: !retried && needs_retry_after_link_reset(mon)
Dynamic subtest A-HDMI-A1 failed.
**** DEBUG ****
(kms_flip:1159) igt_fb-DEBUG: igt_create_fb_with_bo_size(width=1920, height=1080, format=XR24(0x34325258), modifier=0x0, size=0)
(kms_flip:1159) igt_fb-DEBUG: igt_create_fb_with_bo_size(handle=1, pitch=7680)
(kms_flip:1159) ioctl_wrappers-DEBUG: Test requirement passed: igt_has_fb_modifiers(fd)
(kms_flip:1159) igt_fb-DEBUG: igt_create_fb_with_bo_size(width=1920, height=1080, format=XR24(0x34325258), modifier=0x0, size=0)
(kms_flip:1159) igt_fb-DEBUG: igt_create_fb_with_bo_size(handle=2, pitch=7680)
(kms_flip:1159) ioctl_wrappers-DEBUG: Test requirement passed: igt_has_fb_modifiers(fd)
(kms_flip:1159) intel_blt-DEBUG: Test requirement passed: cmds_info
(kms_flip:1159) intel_blt-DEBUG: Test requirement passed: cmds_info
(kms_flip:1159) igt_fb-DEBUG: Test requirement passed: cairo_surface_status(fb->cairo_surface) == CAIRO_STATUS_SUCCESS
(kms_flip:1159) intel_blt-DEBUG: Test requirement passed: cmds_info
(kms_flip:1159) intel_blt-DEBUG: Test requirement passed: cmds_info
(kms_flip:1159) igt_fb-DEBUG: Test requirement passed: cairo_surface_status(fb->cairo_surface) == CAIRO_STATUS_SUCCESS
(kms_flip:1159) igt_kms-INFO:   1920x1080: 120 285500 1920 1968 2000 2080 1080 1083 1088 1144 0x48 0x5 
(kms_flip:1159) DEBUG: No stale events found
(kms_flip:1159) i915/intel_drrs-DEBUG: Manually disabling DRRS. 0
(kms_flip:1159) i915/intel_drrs-DEBUG: Test requirement passed: dir >= 0
(kms_flip:1159) INFO: Expected frametime: 8335us; measured 8300.9us +- 3.793us accuracy 0.14%
(kms_flip:1159) INFO: vblank interval differs from modeline! expected 8334.6us, measured 8301us +- 3.793us, difference 33.7us (8.9 sigma)
(kms_flip:1159) DEBUG: name = vblank
last_ts = 0.000000
last_received_ts = 0.000000
last_seq = 0
current_ts = 55.035645
current_received_ts = 55.035473
current_seq = 5211
count = 0
seq_step = 10
(kms_flip:1159) DEBUG: name = vblank
last_ts = 55.035645
last_received_ts = 55.035473
last_seq = 5211
current_ts = 55.118683
current_received_ts = 55.118465
current_seq = 5221
count = 1
seq_step = 10
(kms_flip:1159) DEBUG: vblank ts/seq: last 55.035645/5211, current 55.118683/5221: elapsed=83038.0us expected=83008.8us +- 415.0us, error 0.0%
(kms_flip:1159) DEBUG: name = vblank
last_ts = 55.118683
last_received_ts = 55.118465
last_seq = 5221
current_ts = 55.201725
current_received_ts = 55.201645
current_seq = 5231
count = 2
seq_step = 10
(kms_flip:1159) DEBUG: vblank ts/seq: last 55.118683/5221, current 55.201725/5231: elapsed=83043.0us expected=83008.8us +- 415.0us, error 0.0%
(kms_flip:1159) DEBUG: name = vblank
last_ts = 55.201725
last_received_ts = 55.201645
last_seq = 5231
current_ts = 55.284771
current_received_ts = 55.284714
current_seq = 5241
count = 3
seq_step = 10
(kms_flip:1159) DEBUG: vblank ts/seq: last 55.201725/5231, current 55.284771/5241: elapsed=83046.0us expected=83008.8us +- 415.0us, error 0.0%
(kms_flip:1159) DEBUG: name = vblank
last_ts = 55.284771
last_received_ts = 55.284714
last_seq = 5241
current_ts = 55.367813
current_received_ts = 55.367764
current_seq = 5251
count = 4
seq_step = 10
(kms_flip:1159) DEBUG: vblank ts/seq: last 55.284771/5241, current 55.367813/5251: elapsed=83041.0us expected=83008.8us +- 415.0us, error 0.0%
(kms_flip:1159) DEBUG: name = vblank
last_ts = 55.367813
last_received_ts = 55.367764
last_seq = 5251
current_ts = 55.450863
current_received_ts = 55.450779
current_seq = 5261
count = 5
seq_step = 10
(kms_flip:1159) DEBUG: vblank ts/seq: last 55.367813/5251, current 55.450863/5261: elapsed=83048.0us expected=83008.8us +- 415.0us, error 0.0%
(kms_flip:1159) DEBUG: name = vblank
last_ts = 55.450863
last_received_ts = 55.450779
last_seq = 5261
current_ts = 55.533901
current_received_ts = 55.533855
current_seq = 5271
count = 6
seq_step = 10
(kms_flip:1159) DEBUG: vblank ts/seq: last 55.450863/5261, current 55.533901/5271: elapsed=83040.0us expected=83008.8us +- 415.0us, error 0.0%
(kms_flip:1159) DEBUG: name = vblank
last_ts = 55.533901
last_received_ts = 55.533855
last_seq = 5271
current_ts = 55.616943
current_received_ts = 55.616886
current_seq = 5281
count = 7
seq_step = 10
(kms_flip:1159) DEBUG: vblank ts/seq: last 55.533901/5271, current 55.616943/5281: elapsed=83042.0us expected=83008.8us +- 415.0us, error 0.0%
(kms_flip:1159) DEBUG: name = vblank
last_ts = 55.616943
last_received_ts = 55.616886
last_seq = 5281
current_ts = 55.699989
current_received_ts = 55.699928
current_seq = 5291
count = 8
seq_step = 10
(kms_flip:1159) DEBUG: vblank ts/seq: last 55.616943/5281, current 55.699989/5291: elapsed=83046.0us expected=83008.8us +- 415.0us, error 0.0%
(kms_flip:1159) DEBUG: name = vblank
last_ts = 55.699989
last_received_ts = 55.699928
last_seq = 5291
current_ts = 55.783035
current_received_ts = 55.782825
current_seq = 5301
count = 9
seq_step = 10
(kms_flip:1159) DEBUG: vblank ts/seq: last 55.699989/5291, current 55.783035/5301: elapsed=83045.0us expected=83008.8us +- 415.0us, error 0.0%
(kms_flip:1159) DEBUG: name = vblank
last_ts = 55.783035
last_received_ts = 55.782825
last_seq = 5301
current_ts = 55.866074
current_received_ts = 55.865993
current_seq = 5311
count = 10
seq_step = 10
(kms_flip:1159) DEBUG: vblank ts/seq: last 55.783035/5301, current 55.866074/5311: elapsed=83040.0us expected=83008.8us +- 415.0us, error 0.0%
(kms_flip:1159) DEBUG: name = vblank
last_ts = 55.866074
last_received_ts = 55.865993
last_seq = 5311
current_ts = 55.949142
current_received_ts = 55.948914
current_seq = 5321
count = 11
seq_step = 10
(kms_flip:1159) DEBUG: vblank ts/seq: last 55.866074/5311, current 55.949142/5321: elapsed=83067.0us expected=83008.8us +- 415.0us, error 0.1%
(kms_flip:1159) DEBUG: name = vblank
last_ts = 55.949142
last_received_ts = 55.948914
last_seq = 5321
current_ts = 56.032215
current_received_ts = 56.032166
current_seq = 5331
count = 12
seq_step = 10
(kms_flip:1159) DEBUG: vblank ts/seq: last 55.949142/5321, current 56.032215/5331: elapsed=83074.0us expected=83008.8us +- 415.0us, error 0.1%
(kms_flip:1159) DEBUG: name = vblank
last_ts = 56.032215
last_received_ts = 56.032166
last_seq = 5331
current_ts = 56.115299
current_received_ts = 56.114861
current_seq = 5341
count = 13
seq_step = 10
(kms_flip:1159) DEBUG: vblank ts/seq: last 56.032215/5331, current 56.115299/5341: elapsed=83083.0us expected=83008.8us +- 415.0us, error 0.1%
(kms_flip:1159) DEBUG: name = vblank
last_ts = 56.115299
last_received_ts = 56.114861
last_seq = 5341
current_ts = 56.198383
current_received_ts = 56.198208
current_seq = 5351
count = 14
seq_step = 10
(kms_flip:1159) DEBUG: vblank ts/seq: last 56.115299/5341, current 56.198383/5351: elapsed=83084.0us expected=83008.8us +- 415.0us, error 0.1%
(kms_flip:1159) DEBUG: name = vblank
last_ts = 56.198383
last_received_ts = 56.198208
last_seq = 5351
current_ts = 56.281460
current_received_ts = 56.281300
current_seq = 5361
count = 15
seq_step = 10
(kms_flip:1159) DEBUG: vblank ts/seq: last 56.198383/5351, current 56.281460/5361: elapsed=83079.0us expected=83008.8us +- 415.0us, error 0.1%
(kms_flip:1159) DEBUG: name = vblank
last_ts = 56.281460
last_received_ts = 56.281300
last_seq = 5361
current_ts = 56.364540
current_received_ts = 56.364452
current_seq = 5371
count = 16
seq_step = 10
(kms_flip:1159) DEBUG: vblank ts/seq: last 56.281460/5361, current 56.364540/5371: elapsed=83079.0us expected=83008.8us +- 415.0us, error 0.1%
(kms_flip:1159) DEBUG: name = vblank
last_ts = 56.364540
last_received_ts = 56.364452
last_seq = 5371
current_ts = 56.447624
current_received_ts = 56.447559
current_seq = 5381
count = 17
seq_step = 10
(kms_flip:1159) DEBUG: vblank ts/seq: last 56.364540/5371, current 56.447624/5381: elapsed=83086.0us expected=83008.8us +- 415.0us, error 0.1%
(kms_flip:1159) DEBUG: name = vblank
last_ts = 56.447624
last_received_ts = 56.447559
last_seq = 5381
current_ts = 56.530704
current_received_ts = 56.530552
current_seq = 5391
count = 18
seq_step = 10
(kms_flip:1159) DEBUG: vblank ts/seq: last 56.447624/5381, current 56.530704/5391: elapsed=83078.0us expected=83008.8us +- 415.0us, error 0.1%
(kms_flip:1159) DEBUG: name = vblank
last_ts = 56.530704
last_received_ts = 56.530552
last_seq = 5391
current_ts = 56.613789
current_received_ts = 56.613716
current_seq = 5401
count = 19
seq_step = 10
(kms_flip:1159) DEBUG: vblank ts/seq: last 56.530704/5391, current 56.613789/5401: elapsed=83083.0us expected=83008.8us +- 415.0us, error 0.1%
(kms_flip:1159) DEBUG: name = vblank
last_ts = 56.613789
last_received_ts = 56.613716
last_seq = 5401
current_ts = 56.696865
current_received_ts = 56.696663
current_seq = 5411
count = 20
seq_step = 10
(kms_flip:1159) DEBUG: vblank ts/seq: last 56.613789/5401, current 56.696865/5411: elapsed=83078.0us expected=83008.8us +- 415.0us, error 0.1%
(kms_flip:1159) DEBUG: name = vblank
last_ts = 56.696865
last_received_ts = 56.696663
last_seq = 5411
current_ts = 56.779953
current_received_ts = 56.779755
current_seq = 5421
count = 21
seq_step = 10
(kms_flip:1159) DEBUG: vblank ts/seq: last 56.696865/5411, current 56.779953/5421: elapsed=83087.0us expected=83008.8us +- 415.0us, error 0.1%
(kms_flip:1159) DEBUG: name = vblank
last_ts = 56.779953
last_received_ts = 56.779755
last_seq = 5421
current_ts = 56.863029
current_received_ts = 56.862949
current_seq = 5431
count = 22
seq_step = 10
(kms_flip:1159) DEBUG: vblank ts/seq: last 56.779953/5421, current 56.863029/5431: elapsed=83076.0us expected=83008.8us +- 415.0us, error 0.1%
(kms_flip:1159) DEBUG: name = vblank
last_ts = 56.863029
last_received_ts = 56.862949
last_seq = 5431
current_ts = 56.946129
current_received_ts = 56.945904
current_seq = 5441
count = 23
seq_step = 10
(kms_flip:1159) DEBUG: vblank ts/seq: last 56.863029/5431, current 56.946129/5441: elapsed=83100.0us expected=83008.8us +- 415.0us, error 0.1%
(kms_flip:1159) DEBUG: name = vblank
last_ts = 56.946129
last_received_ts = 56.945904
last_seq = 5441
current_ts = 57.029240
current_received_ts = 57.029179
current_seq = 5451
count = 24
seq_step = 10
(kms_flip:1159) DEBUG: vblank ts/seq: last 56.946129/5441, current 57.029240/5451: elapsed=83110.0us expected=83008.8us +- 415.0us, error 0.1%
(kms_flip:1159) DEBUG: name = vblank
last_ts = 57.029240
last_received_ts = 57.029179
last_seq = 5451
current_ts = 57.112354
current_received_ts = 57.112274
current_seq = 5461
count = 25
seq_step = 10
(kms_flip:1159) DEBUG: vblank ts/seq: last 57.029240/5451, current 57.112354/5461: elapsed=83116.0us expected=83008.8us +- 415.0us, error 0.1%
(kms_flip:1159) DEBUG: name = vblank
last_ts = 57.112354
last_received_ts = 57.112274
last_seq = 5461
current_ts = 57.195465
current_received_ts = 57.195412
current_seq = 5471
count = 26
seq_step = 10
(kms_flip:1159) DEBUG: vblank ts/seq: last 57.112354/5461, current 57.195465/5471: elapsed=83113.0us expected=83008.8us +- 415.0us, error 0.1%
(kms_flip:1159) DEBUG: name = vblank
last_ts = 57.195465
last_received_ts = 57.195412
last_seq = 5471
current_ts = 57.278580
current_received_ts = 57.278519
current_seq = 5481
count = 27
seq_step = 10
(kms_flip:1159) DEBUG: vblank ts/seq: last 57.195465/5471, current 57.278580/5481: elapsed=83112.0us expected=83008.8us +- 415.0us, error 0.1%
(kms_flip:1159) DEBUG: name = vblank
last_ts = 57.278580
last_received_ts = 57.278519
last_seq = 5481
current_ts = 57.361694
current_received_ts = 57.361641
current_seq = 5491
count = 28
seq_step = 10
(kms_flip:1159) DEBUG: vblank ts/seq: last 57.278580/5481, current 57.361694/5491: elapsed=83117.0us expected=83008.8us +- 415.0us, error 0.1%
(kms_flip:1159) DEBUG: name = vblank
last_ts = 57.361694
last_received_ts = 57.361641
last_seq = 5491
current_ts = 57.444805
current_received_ts = 57.444752
current_seq = 5501
count = 29
seq_step = 10
(kms_flip:1159) DEBUG: vblank ts/seq: last 57.361694/5491, current 57.444805/5501: elapsed=83111.0us expected=83008.8us +- 415.0us, error 0.1%
(kms_flip:1159) DEBUG: name = vblank
last_ts = 57.444805
last_received_ts = 57.444752
last_seq = 5501
current_ts = 57.527924
current_received_ts = 57.527866
current_seq = 5511
count = 30
seq_step = 10
(kms_flip:1159) DEBUG: vblank ts/seq: last 57.444805/5501, current 57.527924/5511: elapsed=83117.0us expected=83008.8us +- 415.0us, error 0.1%
(kms_flip:1159) DEBUG: name = vblank
last_ts = 57.527924
last_received_ts = 57.527866
last_seq = 5511
current_ts = 57.611042
current_received_ts = 57.610962
current_seq = 5521
count = 31
seq_step = 10
(kms_flip:1159) DEBUG: vblank ts/seq: last 57.527924/5511, current 57.611042/5521: elapsed=83117.0us expected=83008.8us +- 415.0us, error 0.1%
(kms_flip:1159) DEBUG: name = vblank
last_ts = 57.611042
last_received_ts = 57.610962
last_seq = 5521
current_ts = 57.694153
current_received_ts = 57.694088
current_seq = 5531
count = 32
seq_step = 10
(kms_flip:1159) DEBUG: vblank ts/seq: last 57.611042/5521, current 57.694153/5531: elapsed=83113.0us expected=83008.8us +- 415.0us, error 0.1%
(kms_flip:1159) DEBUG: name = vblank
last_ts = 57.694153
last_received_ts = 57.694088
last_seq = 5531
current_ts = 57.777264
current_received_ts = 57.776985
current_seq = 5541
count = 33
seq_step = 10
(kms_flip:1159) DEBUG: vblank ts/seq: last 57.694153/5531, current 57.777264/5541: elapsed=83110.0us expected=83008.8us +- 415.0us, error 0.1%
(kms_flip:1159) DEBUG: name = vblank
last_ts = 57.777264
last_received_ts = 57.776985
last_seq = 5541
current_ts = 57.860378
current_received_ts = 57.860298
current_seq = 5551
count = 34
seq_step = 10
(kms_flip:1159) DEBUG: vblank ts/seq: last 57.777264/5541, current 57.860378/5551: elapsed=83114.0us expected=83008.8us +- 415.0us, error 0.1%
(kms_flip:1159) DEBUG: name = vblank
last_ts = 57.860378
last_received_ts = 57.860298
last_seq = 5551
current_ts = 57.943508
current_received_ts = 57.943451
current_seq = 5561
count = 35
seq_step = 10
(kms_flip:1159) DEBUG: vblank ts/seq: last 57.860378/5551, current 57.943508/5561: elapsed=83129.0us expected=83008.8us +- 415.0us, error 0.1%
(kms_flip:1159) DEBUG: name = vblank
last_ts = 57.943508
last_received_ts = 57.943451
last_seq = 5561
current_ts = 58.026649
current_received_ts = 58.026588
current_seq = 5571
count = 36
seq_step = 10
(kms_flip:1159) DEBUG: vblank ts/seq: last 57.943508/5561, current 58.026649/5571: elapsed=83141.0us expected=83008.8us +- 415.0us, error 0.2%
(kms_flip:1159) DEBUG: name = vblank
last_ts = 58.026649
last_received_ts = 58.026588
last_seq = 5571
current_ts = 58.109795
current_received_ts = 58.109737
current_seq = 5581
count = 37
seq_step = 10
(kms_flip:1159) DEBUG: vblank ts/seq: last 58.026649/5571, current 58.109795/5581: elapsed=83146.0us expected=83008.8us +- 415.0us, error 0.2%
(kms_flip:1159) DEBUG: name = vblank
last_ts = 58.109795
last_received_ts = 58.109737
last_seq = 5581
current_ts = 58.192932
current_received_ts = 58.192883
current_seq = 5591
count = 38
seq_step = 10
(kms_flip:1159) DEBUG: vblank ts/seq: last 58.109795/5581, current 58.192932/5591: elapsed=83139.0us expected=83008.8us +- 415.0us, error 0.2%
(kms_flip:1159) DEBUG: name = vblank
last_ts = 58.192932
last_received_ts = 58.192883
last_seq = 5591
current_ts = 58.276081
current_received_ts = 58.276058
current_seq = 5601
count = 39
seq_step = 10
(kms_flip:1159) DEBUG: vblank ts/seq: last 58.192932/5591, current 58.276081/5601: elapsed=83147.0us expected=83008.8us +- 415.0us, error 0.2%
(kms_flip:1159) DEBUG: name = vblank
last_ts = 58.276081
last_received_ts = 58.276058
last_seq = 5601
current_ts = 58.359222
current_received_ts = 58.359150
current_seq = 5611
count = 40
seq_step = 10
(kms_flip:1159) DEBUG: vblank ts/seq: last 58.276081/5601, current 58.359222/5611: elapsed=83144.0us expected=83008.8us +- 415.0us, error 0.2%
(kms_flip:1159) DEBUG: name = vblank
last_ts = 58.359222
last_received_ts = 58.359150
last_seq = 5611
current_ts = 58.442368
current_received_ts = 58.442310
current_seq = 5621
count = 41
seq_step = 10
(kms_flip:1159) DEBUG: vblank ts/seq: last 58.359222/5611, current 58.442368/5621: elapsed=83143.0us expected=83008.8us +- 415.0us, error 0.2%
(kms_flip:1159) DEBUG: name = vblank
last_ts = 58.442368
last_received_ts = 58.442310
last_seq = 5621
current_ts = 58.525509
current_received_ts = 58.525448
current_seq = 5631
count = 42
seq_step = 10
(kms_flip:1159) DEBUG: vblank ts/seq: last 58.442368/5621, current 58.525509/5631: elapsed=83142.0us expected=83008.8us +- 415.0us, error 0.2%
(kms_flip:1159) DEBUG: name = vblank
last_ts = 58.525509
last_received_ts = 58.525448
last_seq = 5631
current_ts = 58.608654
current_received_ts = 58.608589
current_seq = 5641
count = 43
seq_step = 10
(kms_flip:1159) DEBUG: vblank ts/seq: last 58.525509/5631, current 58.608654/5641: elapsed=83146.0us expected=83008.8us +- 415.0us, error 0.2%
(kms_flip:1159) DEBUG: name = vblank
last_ts = 58.608654
last_received_ts = 58.608589
last_seq = 5641
current_ts = 58.691795
current_received_ts = 58.691742
current_seq = 5651
count = 44
seq_step = 10
(kms_flip:1159) DEBUG: vblank ts/seq: last 58.608654/5641, current 58.691795/5651: elapsed=83141.0us expected=83008.8us +- 415.0us, error 0.2%
(kms_flip:1159) DEBUG: name = vblank
last_ts = 58.691795
last_received_ts = 58.691742
last_seq = 5651
current_ts = 58.774937
current_received_ts = 58.774879
current_seq = 5661
count = 45
seq_step = 10
(kms_flip:1159) DEBUG: vblank ts/seq: last 58.691795/5651, current 58.774937/5661: elapsed=83140.0us expected=83008.8us +- 415.0us, error 0.2%
(kms_flip:1159) DEBUG: name = vblank
last_ts = 58.774937
last_received_ts = 58.774879
last_seq = 5661
current_ts = 58.858082
current_received_ts = 58.857994
current_seq = 5671
count = 46
seq_step = 10
(kms_flip:1159) DEBUG: vblank ts/seq: last 58.774937/5661, current 58.858082/5671: elapsed=83146.0us expected=83008.8us +- 415.0us, error 0.2%
(kms_flip:1159) DEBUG: name = vblank
last_ts = 58.858082
last_received_ts = 58.857994
last_seq = 5671
current_ts = 58.941231
current_received_ts = 58.941193
current_seq = 5681
count = 47
seq_step = 10
(kms_flip:1159) DEBUG: vblank ts/seq: last 58.858082/5671, current 58.941231/5681: elapsed=83150.0us expected=83008.8us +- 415.0us, error 0.2%
(kms_flip:1159) DEBUG: name = vblank
last_ts = 58.941231
last_received_ts = 58.941193
last_seq = 5681
current_ts = 59.024403
current_received_ts = 59.024345
current_seq = 5691
count = 48
seq_step = 10
(kms_flip:1159) DEBUG: vblank ts/seq: last 58.941231/5681, current 59.024403/5691: elapsed=83171.0us expected=83008.8us +- 415.0us, error 0.2%
(kms_flip:1159) DEBUG: name = vblank
last_ts = 59.024403
last_received_ts = 59.024345
last_seq = 5691
current_ts = 59.107571
current_received_ts = 59.107517
current_seq = 5701
count = 49
seq_step = 10
(kms_flip:1159) DEBUG: vblank ts/seq: last 59.024403/5691, current 59.107571/5701: elapsed=83168.0us expected=83008.8us +- 415.0us, error 0.2%
(kms_flip:1159) DEBUG: name = vblank
last_ts = 59.107571
last_received_ts = 59.107517
last_seq = 5701
current_ts = 59.190739
current_received_ts = 59.190685
current_seq = 5711
count = 50
seq_step = 10
(kms_flip:1159) DEBUG: vblank ts/seq: last 59.107571/5701, current 59.190739/5711: elapsed=83169.0us expected=83008.8us +- 415.0us, error 0.2%
(kms_flip:1159) DEBUG: name = vblank
last_ts = 59.190739
last_received_ts = 59.190685
last_seq = 5711
current_ts = 59.273911
current_received_ts = 59.273842
current_seq = 5721
count = 51
seq_step = 10
(kms_flip:1159) DEBUG: vblank ts/seq: last 59.190739/5711, current 59.273911/5721: elapsed=83170.0us expected=83008.8us +- 415.0us, error 0.2%
(kms_flip:1159) DEBUG: name = vblank
last_ts = 59.273911
last_received_ts = 59.273842
last_seq = 5721
current_ts = 59.357075
current_received_ts = 59.357067
current_seq = 5731
count = 52
seq_step = 10
(kms_flip:1159) DEBUG: vblank ts/seq: last 59.273911/5721, current 59.357075/5731: elapsed=83164.0us expected=83008.8us +- 415.0us, error 0.2%
(kms_flip:1159) DEBUG: name = vblank
last_ts = 59.357075
last_received_ts = 59.357067
last_seq = 5731
current_ts = 59.440243
current_received_ts = 59.440166
current_seq = 5741
count = 53
seq_step = 10
(kms_flip:1159) DEBUG: vblank ts/seq: last 59.357075/5731, current 59.440243/5741: elapsed=83169.0us expected=83008.8us +- 415.0us, error 0.2%
(kms_flip:1159) DEBUG: name = vblank
last_ts = 59.440243
last_received_ts = 59.440166
last_seq = 5741
current_ts = 59.523411
current_received_ts = 59.523346
current_seq = 5751
count = 54
seq_step = 10
(kms_flip:1159) DEBUG: vblank ts/seq: last 59.440243/5741, current 59.523411/5751: elapsed=83169.0us expected=83008.8us +- 415.0us, error 0.2%
(kms_flip:1159) DEBUG: name = vblank
last_ts = 59.523411
last_received_ts = 59.523346
last_seq = 5751
current_ts = 59.606583
current_received_ts = 59.606525
current_seq = 5761
count = 55
seq_step = 10
(kms_flip:1159) DEBUG: vblank ts/seq: last 59.523411/5751, current 59.606583/5761: elapsed=83169.0us expected=83008.8us +- 415.0us, error 0.2%
(kms_flip:1159) DEBUG: name = vblank
last_ts = 59.606583
last_received_ts = 59.606525
last_seq = 5761
current_ts = 59.689751
current_received_ts = 59.689598
current_seq = 5771
count = 56
seq_step = 10
(kms_flip:1159) DEBUG: vblank ts/seq: last 59.606583/5761, current 59.689751/5771: elapsed=83170.0us expected=83008.8us +- 415.0us, error 0.2%
(kms_flip:1159) DEBUG: name = vblank
last_ts = 59.689751
last_received_ts = 59.689598
last_seq = 5771
current_ts = 59.772919
current_received_ts = 59.772835
current_seq = 5781
count = 57
seq_step = 10
(kms_flip:1159) DEBUG: vblank ts/seq: last 59.689751/5771, current 59.772919/5781: elapsed=83167.0us expected=83008.8us +- 415.0us, error 0.2%
(kms_flip:1159) DEBUG: name = vblank
last_ts = 59.772919
last_received_ts = 59.772835
last_seq = 5781
current_ts = 59.856087
current_received_ts = 59.856037
current_seq = 5791
count = 58
seq_step = 10
(kms_flip:1159) DEBUG: vblank ts/seq: last 59.772919/5781, current 59.856087/5791: elapsed=83170.0us expected=83008.8us +- 415.0us, error 0.2%
(kms_flip:1159) DEBUG: name = vblank
last_ts = 59.856087
last_received_ts = 59.856037
last_seq = 5791
current_ts = 59.939262
current_received_ts = 59.939209
current_seq = 5801
count = 59
seq_step = 10
(kms_flip:1159) DEBUG: vblank ts/seq: last 59.856087/5791, current 59.939262/5801: elapsed=83176.0us expected=83008.8us +- 415.0us, error 0.2%
(kms_flip:1159) DEBUG: name = vblank
last_ts = 59.939262
last_received_ts = 59.939209
last_seq = 5801
current_ts = 60.022453
current_received_ts = 60.022381
current_seq = 5811
count = 60
seq_step = 10
(kms_flip:1159) DEBUG: vblank ts/seq: last 59.939262/5801, current 60.022453/5811: elapsed=83189.0us expected=83008.8us +- 415.0us, error 0.2%
(kms_flip:1159) DEBUG: name = vblank
last_ts = 60.022453
last_received_ts = 60.022381
last_seq = 5811
current_ts = 60.105648
current_received_ts = 60.105583
current_seq = 5821
count = 61
seq_step = 10
(kms_flip:1159) DEBUG: vblank ts/seq: last 60.022453/5811, current 60.105648/5821: elapsed=83195.0us expected=83008.8us +- 415.0us, error 0.2%
(kms_flip:1159) DEBUG: name = vblank
last_ts = 60.105648
last_received_ts = 60.105583
last_seq = 5821
current_ts = 60.188835
current_received_ts = 60.188747
current_seq = 5831
count = 62
seq_step = 10
(kms_flip:1159) DEBUG: vblank ts/seq: last 60.105648/5821, current 60.188835/5831: elapsed=83186.0us expected=83008.8us +- 415.0us, error 0.2%
(kms_flip:1159) DEBUG: name = vblank
last_ts = 60.188835
last_received_ts = 60.188747
last_seq = 5831
current_ts = 60.272026
current_received_ts = 60.271957
current_seq = 5841
count = 63
seq_step = 10
(kms_flip:1159) DEBUG: vblank ts/seq: last 60.188835/5831, current 60.272026/5841: elapsed=83191.0us expected=83008.8us +- 415.0us, error 0.2%
(kms_flip:1159) DEBUG: name = vblank
last_ts = 60.272026
last_received_ts = 60.271957
last_seq = 5841
current_ts = 60.355213
current_received_ts = 60.355026
current_seq = 5851
count = 64
seq_step = 10
(kms_flip:1159) DEBUG: vblank ts/seq: last 60.272026/5841, current 60.355213/5851: elapsed=83190.0us expected=83008.8us +- 415.0us, error 0.2%
(kms_flip:1159) DEBUG: name = vblank
last_ts = 60.355213
last_received_ts = 60.355026
last_seq = 5851
current_ts = 60.438404
current_received_ts = 60.438358
current_seq = 5861
count = 65
seq_step = 10
(kms_flip:1159) DEBUG: vblank ts/seq: last 60.355213/5851, current 60.438404/5861: elapsed=83189.0us expected=83008.8us +- 415.0us, error 0.2%
(kms_flip:1159) DEBUG: name = vblank
last_ts = 60.438404
last_received_ts = 60.438358
last_seq = 5861
current_ts = 60.521599
current_received_ts = 60.521530
current_seq = 5871
count = 66
seq_step = 10
(kms_flip:1159) DEBUG: vblank ts/seq: last 60.438404/5861, current 60.521599/5871: elapsed=83193.0us expected=83008.8us +- 415.0us, error 0.2%
(kms_flip:1159) DEBUG: name = vblank
last_ts = 60.521599
last_received_ts = 60.521530
last_seq = 5871
current_ts = 60.604786
current_received_ts = 60.604568
current_seq = 5881
count = 67
seq_step = 10
(kms_flip:1159) DEBUG: vblank ts/seq: last 60.521599/5871, current 60.604786/5881: elapsed=83190.0us expected=83008.8us +- 415.0us, error 0.2%
(kms_flip:1159) DEBUG: name = vblank
last_ts = 60.604786
last_received_ts = 60.604568
last_seq = 5881
current_ts = 60.687981
current_received_ts = 60.687923
current_seq = 5891
count = 68
seq_step = 10
(kms_flip:1159) DEBUG: vblank ts/seq: last 60.604786/5881, current 60.687981/5891: elapsed=83193.0us expected=83008.8us +- 415.0us, error 0.2%
(kms_flip:1159) DEBUG: name = vblank
last_ts = 60.687981
last_received_ts = 60.687923
last_seq = 5891
current_ts = 60.771175
current_received_ts = 60.770798
current_seq = 5901
count = 69
seq_step = 10
(kms_flip:1159) DEBUG: vblank ts/seq: last 60.687981/5891, current 60.771175/5901: elapsed=83194.0us expected=83008.8us +- 415.0us, error 0.2%
(kms_flip:1159) DEBUG: name = vblank
last_ts = 60.771175
last_received_ts = 60.770798
last_seq = 5901
current_ts = 60.854359
current_received_ts = 60.854267
current_seq = 5911
count = 70
seq_step = 10
(kms_flip:1159) DEBUG: vblank ts/seq: last 60.771175/5901, current 60.854359/5911: elapsed=83185.0us expected=83008.8us +- 415.0us, error 0.2%
(kms_flip:1159) DEBUG: name = vblank
last_ts = 60.854359
last_received_ts = 60.854267
last_seq = 5911
current_ts = 60.937553
current_received_ts = 60.937473
current_seq = 5921
count = 71
seq_step = 10
(kms_flip:1159) DEBUG: vblank ts/seq: last 60.854359/5911, current 60.937553/5921: elapsed=83196.0us expected=83008.8us +- 415.0us, error 0.2%
(kms_flip:1159) DEBUG: name = vblank
last_ts = 60.937553
last_received_ts = 60.937473
last_seq = 5921
current_ts = 61.020767
current_received_ts = 61.020702
current_seq = 5931
count = 72
seq_step = 10
(kms_flip:1159) DEBUG: vblank ts/seq: last 60.937553/5921, current 61.020767/5931: elapsed=83213.0us expected=83008.8us +- 415.0us, error 0.2%
(kms_flip:1159) DEBUG: name = vblank
last_ts = 61.020767
last_received_ts = 61.020702
last_seq = 5931
current_ts = 61.103981
current_received_ts = 61.103909
current_seq = 5941
count = 73
seq_step = 10
(kms_flip:1159) DEBUG: vblank ts/seq: last 61.020767/5931, current 61.103981/5941: elapsed=83213.0us expected=83008.8us +- 415.0us, error 0.2%
(kms_flip:1159) DEBUG: name = vblank
last_ts = 61.103981
last_received_ts = 61.103909
last_seq = 5941
current_ts = 61.187191
current_received_ts = 61.187046
current_seq = 5951
count = 74
seq_step = 10
(kms_flip:1159) DEBUG: vblank ts/seq: last 61.103981/5941, current 61.187191/5951: elapsed=83209.0us expected=83008.8us +- 415.0us, error 0.2%
(kms_flip:1159) DEBUG: name = vblank
last_ts = 61.187191
last_received_ts = 61.187046
last_seq = 5951
current_ts = 61.270393
current_received_ts = 61.270264
current_seq = 5961
count = 75
seq_step = 10
(kms_flip:1159) DEBUG: vblank ts/seq: last 61.187191/5951, current 61.270393/5961: elapsed=83204.0us expected=83008.8us +- 415.0us, error 0.2%
(kms_flip:1159) DEBUG: name = vblank
last_ts = 61.270393
last_received_ts = 61.270264
last_seq = 5961
current_ts = 61.353607
current_received_ts = 61.353527
current_seq = 5971
count = 76
seq_step = 10
(kms_flip:1159) DEBUG: vblank ts/seq: last 61.270393/5961, current 61.353607/5971: elapsed=83214.0us expected=83008.8us +- 415.0us, error 0.2%
(kms_flip:1159) DEBUG: name = vblank
last_ts = 61.353607
last_received_ts = 61.353527
last_seq = 5971
current_ts = 61.436821
current_received_ts = 61.436741
current_seq = 5981
count = 77
seq_step = 10
(kms_flip:1159) DEBUG: vblank ts/seq: last 61.353607/5971, current 61.436821/5981: elapsed=83212.0us expected=83008.8us +- 415.0us, error 0.2%
(kms_flip:1159) DEBUG: name = vblank
last_ts = 61.436821
last_received_ts = 61.436741
last_seq = 5981
current_ts = 61.520027
current_received_ts = 61.519772
current_seq = 5991
count = 78
seq_step = 10
(kms_flip:1159) DEBUG: vblank ts/seq: last 61.436821/5981, current 61.520027/5991: elapsed=83209.0us expected=83008.8us +- 415.0us, error 0.2%
(kms_flip:1159) DEBUG: name = vblank
last_ts = 61.520027
last_received_ts = 61.519772
last_seq = 5991
current_ts = 61.603233
current_received_ts = 61.603180
current_seq = 6001
count = 79
seq_step = 10
(kms_flip:1159) DEBUG: vblank ts/seq: last 61.520027/5991, current 61.603233/6001: elapsed=83206.0us expected=83008.8us +- 415.0us, error 0.2%
(kms_flip:1159) DEBUG: name = vblank
last_ts = 61.603233
last_received_ts = 61.603180
last_seq = 6001
current_ts = 61.686443
current_received_ts = 61.686363
current_seq = 6011
count = 80
seq_step = 10
(kms_flip:1159) DEBUG: vblank ts/seq: last 61.603233/6001, current 61.686443/6011: elapsed=83210.0us expected=83008.8us +- 415.0us, error 0.2%
(kms_flip:1159) DEBUG: name = vblank
last_ts = 61.686443
last_received_ts = 61.686363
last_seq = 6011
current_ts = 61.769653
current_received_ts = 61.769604
current_seq = 6021
count = 81
seq_step = 10
(kms_flip:1159) DEBUG: vblank ts/seq: last 61.686443/6011, current 61.769653/6021: elapsed=83210.0us expected=83008.8us +- 415.0us, error 0.2%
(kms_flip:1159) DEBUG: name = vblank
last_ts = 61.769653
last_received_ts = 61.769604
last_seq = 6021
current_ts = 61.852867
current_received_ts = 61.852779
current_seq = 6031
count = 82
seq_step = 10
(kms_flip:1159) DEBUG: vblank ts/seq: last 61.769653/6021, current 61.852867/6031: elapsed=83213.0us expected=83008.8us +- 415.0us, error 0.2%
(kms_flip:1159) DEBUG: name = vblank
last_ts = 61.852867
last_received_ts = 61.852779
last_seq = 6031
current_ts = 61.936085
current_received_ts = 61.936054
current_seq = 6041
count = 83
seq_step = 10
(kms_flip:1159) DEBUG: vblank ts/seq: last 61.852867/6031, current 61.936085/6041: elapsed=83215.0us expected=83008.8us +- 415.0us, error 0.2%
(kms_flip:1159) DEBUG: name = vblank
last_ts = 61.936085
last_received_ts = 61.936054
last_seq = 6041
current_ts = 62.019306
current_received_ts = 62.019253
current_seq = 6051
count = 84
seq_step = 10
(kms_flip:1159) DEBUG: vblank ts/seq: last 61.936085/6041, current 62.019306/6051: elapsed=83223.0us expected=83008.8us +- 415.0us, error 0.3%
(kms_flip:1159) DEBUG: name = vblank
last_ts = 62.019306
last_received_ts = 62.019253
last_seq = 6051
current_ts = 62.102535
current_received_ts = 62.102482
current_seq = 6061
count = 85
seq_step = 10
(kms_flip:1159) DEBUG: vblank ts/seq: last 62.019306/6051, current 62.102535/6061: elapsed=83231.0us expected=83008.8us +- 415.0us, error 0.3%
(kms_flip:1159) DEBUG: name = vblank
last_ts = 62.102535
last_received_ts = 62.102482
last_seq = 6061
current_ts = 62.185764
current_received_ts = 62.185707
current_seq = 6071
count = 86
seq_step = 10
(kms_flip:1159) DEBUG: vblank ts/seq: last 62.102535/6061, current 62.185764/6071: elapsed=83227.0us expected=83008.8us +- 415.0us, error 0.3%
(kms_flip:1159) DEBUG: name = vblank
last_ts = 62.185764
last_received_ts = 62.185707
last_seq = 6071
current_ts = 62.268990
current_received_ts = 62.268921
current_seq = 6081
count = 87
seq_step = 10
(kms_flip:1159) DEBUG: vblank ts/seq: last 62.185764/6071, current 62.268990/6081: elapsed=83225.0us expected=83008.8us +- 415.0us, error 0.3%
(kms_flip:1159) DEBUG: name = vblank
last_ts = 62.268990
last_received_ts = 62.268921
last_seq = 6081
current_ts = 62.352219
current_received_ts = 62.352085
current_seq = 6091
count = 88
seq_step = 10
(kms_flip:1159) DEBUG: vblank ts/seq: last 62.268990/6081, current 62.352219/6091: elapsed=83230.0us expected=83008.8us +- 415.0us, error 0.3%
(kms_flip:1159) DEBUG: name = vblank
last_ts = 62.352219
last_received_ts = 62.352085
last_seq = 6091
current_ts = 62.435448
current_received_ts = 62.435276
current_seq = 6101
count = 89
seq_step = 10
(kms_flip:1159) DEBUG: vblank ts/seq: last 62.352219/6091, current 62.435448/6101: elapsed=83228.0us expected=83008.8us +- 415.0us, error 0.3%
(kms_flip:1159) DEBUG: name = vblank
last_ts = 62.435448
last_received_ts = 62.435276
last_seq = 6101
current_ts = 62.518673
current_received_ts = 62.518623
current_seq = 6111
count = 90
seq_step = 10
(kms_flip:1159) DEBUG: vblank ts/seq: last 62.435448/6101, current 62.518673/6111: elapsed=83225.0us expected=83008.8us +- 415.0us, error 0.3%
(kms_flip:1159) DEBUG: expected 911, counted 910, encoder type 2
(kms_flip:1159) DEBUG: dropped frames, expected 911, counted 910, encoder type 2
(kms_flip:1159) CRITICAL: Test assertion failure function __run_test_on_crtc_set, file ../tests/kms_flip.c:1674:
(kms_flip:1159) CRITICAL: Failed assertion: !retried && needs_retry_after_link_reset(mon)
(kms_flip:1159) igt_core-INFO: Stack trace:
(kms_flip:1159) igt_core-INFO:   #0 ../lib/igt_core.c:2051 __igt_fail_assert()
(kms_flip:1159) igt_core-INFO:   #1 ../tests/kms_flip.c:791 run_test_on_crtc_set.constprop.0()
(kms_flip:1159) igt_core-INFO:   #2 ../tests/kms_flip.c:1845 run_test()
(kms_flip:1159) igt_core-INFO:   #3 ../tests/kms_flip.c:2078 __igt_unique____real_main2001()
(kms_flip:1159) igt_core-INFO:   #4 ../tests/kms_flip.c:2001 main()
(kms_flip:1159) igt_core-INFO:   #5 [__libc_init_first+0x8a]
(kms_flip:1159) igt_core-INFO:   #6 [__libc_start_main+0x8b]
(kms_flip:1159) igt_core-INFO:   #7 [_start+0x25]
****  END  ****
Dynamic subtest A-HDMI-A1: FAIL (10.888s)
Dmesg
<6> [54.744091] Console: switching to colour dummy device 80x25
<6> [54.744140] [IGT] kms_flip: executing
<7> [54.746215] i915 0000:00:02.0: [drm:i915_gem_open [i915]]
<7> [54.746797] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc]
<7> [54.746977] i915 0000:00:02.0: [drm:i915_gem_open [i915]]
<7> [54.756546] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] [CONNECTOR:323:DP-1]
<7> [54.756553] i915 0000:00:02.0: [drm:intel_dp_detect [i915]] [CONNECTOR:323:DP-1]
<7> [54.761818] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] [CONNECTOR:323:DP-1] disconnected
<7> [54.762258] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] [CONNECTOR:333:DP-2]
<7> [54.762261] i915 0000:00:02.0: [drm:intel_dp_detect [i915]] [CONNECTOR:333:DP-2]
<7> [54.762632] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] [CONNECTOR:333:DP-2] disconnected
<7> [54.763135] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] [CONNECTOR:342:DP-3]
<7> [54.763139] i915 0000:00:02.0: [drm:intel_dp_detect [i915]] [CONNECTOR:342:DP-3]
<7> [54.763688] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] [CONNECTOR:342:DP-3] disconnected
<7> [54.764190] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] [CONNECTOR:351:DP-4]
<7> [54.764194] i915 0000:00:02.0: [drm:intel_dp_detect [i915]] [CONNECTOR:351:DP-4]
<7> [54.764645] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] [CONNECTOR:351:DP-4] disconnected
<7> [54.765340] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] [CONNECTOR:313:HDMI-A-1]
<7> [54.765350] i915 0000:00:02.0: [drm:intel_hdmi_detect [i915]] [CONNECTOR:313:HDMI-A-1]
<7> [54.792239] i915 0000:00:02.0: [drm:update_display_info.part.0] [CONNECTOR:313:HDMI-A-1] Supported Monitor Refresh rate range is 0 Hz - 0 Hz
<7> [54.792247] i915 0000:00:02.0: [drm:update_display_info.part.0] [CONNECTOR:313:HDMI-A-1] HDMI: DVI dual 0, max TMDS clock 300000 kHz
<7> [54.792249] i915 0000:00:02.0: [drm:update_display_info.part.0] [CONNECTOR:313:HDMI-A-1] No deep color support on this HDMI sink.
<7> [54.792251] i915 0000:00:02.0: [drm:update_display_info.part.0] [CONNECTOR:313:HDMI-A-1] HF-VSDB: max TMDS clock: 600000 KHz, HDMI 2.1 support: no, DSC 1.2 support: no
<7> [54.792253] i915 0000:00:02.0: [drm:update_display_info.part.0] [CONNECTOR:313:HDMI-A-1] Assigning EDID-1.4 digital sink color depth as 8 bpc.
<7> [54.792255] i915 0000:00:02.0: [drm:update_display_info.part.0] [CONNECTOR:313:HDMI-A-1] ELD monitor fitHeadlessGS
<7> [54.792257] i915 0000:00:02.0: [drm:update_display_info.part.0] [CONNECTOR:313:HDMI-A-1] HDMI: latency present 0 0, video latency 0 0, audio latency 0 0
<7> [54.792260] i915 0000:00:02.0: [drm:update_display_info.part.0] [CONNECTOR:313:HDMI-A-1] ELD size 64, SAD count 10
<7> [54.792669] i915 0000:00:02.0: [drm:do_gmbus_xfer [i915]] GMBUS [i915 gmbus dpb] NAK for addr: 0040 w(1)
<7> [54.792787] i915 0000:00:02.0: [drm:do_gmbus_xfer [i915]] GMBUS [i915 gmbus dpb] NAK on first message, retry
<7> [54.793362] i915 0000:00:02.0: [drm:do_gmbus_xfer [i915]] GMBUS [i915 gmbus dpb] NAK for addr: 0040 w(1)
<7> [54.793519] i915 0000:00:02.0: [drm:drm_dp_dual_mode_detect [drm_display_helper]] DP dual mode HDMI ID: (err -6)
<7> [54.794070] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] [CONNECTOR:313:HDMI-A-1] probed modes:
<7> [54.794074] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "1920x1080": 120 285500 1920 1968 2000 2080 1080 1083 1088 1144 0x48 0x5
<7> [54.794077] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "4096x2160": 60 594000 4096 4184 4272 4400 2160 2168 2178 2250 0x40 0x5
<7> [54.794080] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "4096x2160": 60 593407 4096 4184 4272 4400 2160 2168 2178 2250 0x40 0x5
<7> [54.794083] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "4096x2160": 30 297000 4096 4184 4272 4400 2160 2168 2178 2250 0x40 0x5
<7> [54.794086] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "4096x2160": 30 296703 4096 4184 4272 4400 2160 2168 2178 2250 0x40 0x5
<7> [54.794089] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "3840x2160": 60 594000 3840 4016 4104 4400 2160 2168 2178 2250 0x40 0x5
<7> [54.794091] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "3840x2160": 60 593407 3840 4016 4104 4400 2160 2168 2178 2250 0x40 0x5
<7> [54.794094] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "3840x2160": 30 297000 3840 4016 4104 4400 2160 2168 2178 2250 0x40 0x5
<7> [54.794097] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "3840x2160": 30 296703 3840 4016 4104 4400 2160 2168 2178 2250 0x40 0x5
<7> [54.794099] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "3840x2160": 25 297000 3840 4896 4984 5280 2160 2168 2178 2250 0x40 0x5
<7> [54.794102] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "3840x2160": 24 297000 3840 5116 5204 5500 2160 2168 2178 2250 0x40 0x5
<7> [54.794105] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "3840x2160": 24 296703 3840 5116 5204 5500 2160 2168 2178 2250 0x40 0x5
<7> [54.794108] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "3440x1440": 90 476140 3440 3448 3480 3520 1440 1441 1449 1503 0x40 0xa
<7> [54.794110] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "2560x1600": 75 443250 2560 2768 3048 3536 1600 1603 1609 1672 0x40 0x6
<7> [54.794113] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "2560x1600": 60 348500 2560 2752 3032 3504 1600 1603 1609 1658 0x40 0x6
<7> [54.794116] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "2560x1440": 120 497770 2560 2608 2640 2720 1440 1443 1448 1525 0x40 0xa
<7> [54.794118] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "2048x1536": 60 267027 2048 2200 2424 2800 1536 1537 1540 1589 0x0 0x6
<7> [54.794121] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "2560x1080": 120 495000 2560 3108 3152 3300 1080 1084 1089 1250 0x40 0x5
<7> [54.794124] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "2560x1080": 120 494505 2560 3108 3152 3300 1080 1084 1089 1250 0x40 0x5
<7> [54.794127] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "1920x1440": 75 297000 1920 2064 2288 2640 1440 1441 1444 1500 0x40 0x6
<7> [54.794129] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "1920x1440": 60 234000 1920 2048 2256 2600 1440 1441 1444 1500 0x40 0x6
<7> [54.794132] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "2160x1200": 90 261420 2160 2208 2240 2320 1200 1203 1208 1252 0x40 0xa
<7> [54.794135] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "1856x1392": 75 288000 1856 1984 2208 2560 1392 1393 1396 1500 0x40 0x6
<7> [54.794138] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "1856x1392": 60 218250 1856 1952 2176 2528 1392 1393 1396 1439 0x40 0x6
<7> [54.794140] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "1792x1344": 75 261000 1792 1888 2104 2456 1344 1345 1348 1417 0x40 0x6
<7> [54.794143] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "1792x1344": 60 204750 1792 1920 2120 2448 1344 1345 1348 1394 0x40 0x6
<7> [54.794146] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "2048x1152": 60 162000 2048 2074 2154 2250 1152 1153 1156 1200 0x40 0x5
<7> [54.794148] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "1920x1200": 120 317250 1920 1968 2000 2080 1200 1203 1209 1271 0x40 0xa
<7> [54.794151] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "1920x1200": 75 245250 1920 2056 2264 2608 1200 1203 1209 1255 0x40 0x6
<7> [54.794154] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "1920x1200": 60 193250 1920 2056 2256 2592 1200 1203 1209 1245 0x40 0x6
<7> [54.794156] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "1920x1080": 120 297000 1920 2008 2052 2200 1080 1084 1089 1125 0x40 0x5
<7> [54.794159] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "1920x1080": 120 296703 1920 2008 2052 2200 1080 1084 1089 1125 0x40 0x5
<7> [54.794162] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "1920x1080": 75 220597 1920 2056 2264 2608 1080 1081 1084 1128 0x0 0x6
<7> [54.794165] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "1920x1080": 60 148500 1920 2008 2052 2200 1080 1084 1089 1125 0x40 0x5
<7> [54.794167] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "1920x1080": 60 148352 1920 2008 2052 2200 1080 1084 1089 1125 0x40 0x5
<7> [54.794170] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "1600x1200": 75 202500 1600 1664 1856 2160 1200 1201 1204 1250 0x40 0x5
<7> [54.794173] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "1600x1200": 70 189000 1600 1664 1856 2160 1200 1201 1204 1250 0x40 0x5
<7> [54.794175] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "1600x1200": 65 175500 1600 1664 1856 2160 1200 1201 1204 1250 0x40 0x5
<7> [54.794178] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "1600x1200": 60 162000 1600 1664 1856 2160 1200 1201 1204 1250 0x40 0x5
<7> [54.794181] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "1680x1050": 75 187000 1680 1800 1976 2272 1050 1053 1059 1099 0x40 0x6
<7> [54.794184] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "1680x1050": 60 146250 1680 1784 1960 2240 1050 1053 1059 1089 0x40 0x6
<7> [54.794186] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "1680x945": 60 131481 1680 1784 1960 2240 945 946 949 978 0x0 0x6
<7> [54.794189] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "1400x1050": 75 156000 1400 1504 1648 1896 1050 1053 1057 1099 0x40 0x6
<7> [54.794192] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "1400x1050": 60 121750 1400 1488 1632 1864 1050 1053 1057 1089 0x40 0x6
<7> [54.794195] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "1600x900": 60 108000 1600 1624 1704 1800 900 901 904 1000 0x40 0x5
<7> [54.794197] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "1280x1024": 75 135000 1280 1296 1440 1688 1024 1025 1028 1066 0x40 0x5
<7> [54.794200] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "1280x1024": 60 108000 1280 1328 1440 1688 1024 1025 1028 1066 0x40 0x5
<7> [54.794203] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "1440x900": 75 136750 1440 1536 1688 1936 900 903 909 942 0x40 0x6
<7> [54.794206] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "1440x900": 60 106500 1440 1520 1672 1904 900 903 909 934 0x40 0x6
<7> [54.794208] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "1280x960": 60 108000 1280 1376 1488 1800 960 961 964 1000 0x40 0x5
<7> [54.794211] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "1360x768": 60 84963 1366 1431 1567 1776 768 771 781 798 0x0 0x6
<7> [54.794214] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "1360x768": 60 85500 1360 1424 1536 1792 768 771 777 795 0x40 0x5
<7> [54.794217] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "1280x800": 75 106500 1280 1360 1488 1696 800 803 809 838 0x40 0x6
<7> [54.794220] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "1280x800": 60 83500 1280 1352 1480 1680 800 803 809 831 0x40 0x6
<7> [54.794222] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "1152x864": 75 108000 1152 1216 1344 1600 864 865 868 900 0x40 0x5
<7> [54.794225] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "1280x768": 75 102250 1280 1360 1488 1696 768 771 778 805 0x40 0x6
<7> [54.794228] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "1280x768": 60 79500 1280 1344 1472 1664 768 771 778 798 0x40 0x6
<7> [54.794230] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "1280x720": 60 74250 1280 1390 1430 1650 720 725 730 750 0x40 0x5
<7> [54.794233] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "1024x768": 75 78750 1024 1040 1136 1312 768 769 772 800 0x40 0x5
<7> [54.794236] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "1024x768": 70 75000 1024 1048 1184 1328 768 771 777 806 0x40 0xa
<7> [54.794239] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "1024x768": 60 65000 1024 1048 1184 1344 768 771 777 806 0x40 0xa
<7> [54.794241] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "1024x576": 60 46970 1024 1064 1168 1312 576 577 580 597 0x0 0x6
<7> [54.794244] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "832x624": 75 57284 832 864 928 1152 624 625 628 667 0x40 0xa
<7> [54.794247] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "800x600": 75 49500 800 816 896 1056 600 601 604 625 0x40 0x5
<7> [54.794250] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "800x600": 72 50000 800 856 976 1040 600 637 643 666 0x40 0x5
<7> [54.794253] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "800x600": 60 40000 800 840 968 1056 600 601 605 628 0x40 0x5
<7> [54.794255] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "800x600": 56 36000 800 824 896 1024 600 601 603 625 0x40 0x5
<7> [54.794258] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "848x480": 60 33750 848 864 976 1088 480 486 494 517 0x40 0x5
<7> [54.794261] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "640x480": 75 31500 640 656 720 840 480 481 484 500 0x40 0xa
<7> [54.794264] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "640x480": 73 31500 640 664 704 832 480 489 492 520 0x40 0xa
<7> [54.794266] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "640x480": 60 25200 640 656 752 800 480 490 492 525 0x40 0xa
<7> [54.794269] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "640x480": 60 25175 640 656 752 800 480 490 492 525 0x40 0xa
<7> [54.794272] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "720x400": 70 28320 720 738 846 900 400 412 414 449 0x40 0x6
<7> [54.794311] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] [CONNECTOR:323:DP-1]
<7> [54.794315] i915 0000:00:02.0: [drm:intel_dp_detect [i915]] [CONNECTOR:323:DP-1]
<7> [54.798937] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] [CONNECTOR:323:DP-1] disconnected
<7> [54.798953] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] [CONNECTOR:333:DP-2]
<7> [54.798956] i915 0000:00:02.0: [drm:intel_dp_detect [i915]] [CONNECTOR:333:DP-2]
<7> [54.799320] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] [CONNECTOR:333:DP-2] disconnected
<7> [54.799333] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] [CONNECTOR:342:DP-3]
<7> [54.799335] i915 0000:00:02.0: [drm:intel_dp_detect [i915]] [CONNECTOR:342:DP-3]
<7> [54.799696] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] [CONNECTOR:342:DP-3] disconnected
<7> [54.799708] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] [CONNECTOR:351:DP-4]
<7> [54.799710] i915 0000:00:02.0: [drm:intel_dp_detect [i915]] [CONNECTOR:351:DP-4]
<7> [54.800171] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] [CONNECTOR:351:DP-4] disconnected
<6> [54.800479] [IGT] kms_flip: starting subtest blocking-wf_vblank
<6> [54.803399] [IGT] kms_flip: starting dynamic subtest A-HDMI-A1
<7> [54.803871] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:361]
<7> [54.803914] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:363]
<7> [54.843156] i915 0000:00:02.0: [drm:drm_mode_setcrtc] [CRTC:100:pipe A]
<7> [54.843261] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:100:pipe A] fastset requirement not met in hw.enable (expected yes, found no)
<7> [54.843446] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:100:pipe A] fastset requirement not met in hw.active (expected yes, found no)
<7> [54.843609] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:100:pipe A] fastset requirement not met in cpu_transcoder (expected 0, found -1)
<7> [54.843766] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:100:pipe A] fastset requirement not met in lane_count (expected 4, found 0)
<7> [54.843922] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:100:pipe A] fastset requirement not met in output_types (expected 0x00000040, found 0x00000000)
<7> [54.844117] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:100:pipe A] fastset requirement not met in framestart_delay (expected 1, found 0)
<7> [54.844329] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:100:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hdisplay (expected 1920, found 0)
<7> [54.844530] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:100:pipe A] fastset requirement not met in hw.pipe_mode.crtc_htotal (expected 2080, found 0)
<7> [54.844710] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:100:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hblank_start (expected 1920, found 0)
<7> [54.844888] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:100:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hblank_end (expected 2080, found 0)
<7> [54.845088] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:100:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hsync_start (expected 1968, found 0)
<7> [54.845297] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:100:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hsync_end (expected 2000, found 0)
<7> [54.845478] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:100:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vdisplay (expected 1080, found 0)
<7> [54.845654] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:100:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vblank_start (expected 1080, found 0)
<7> [54.845836] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:100:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vsync_start (expected 1083, found 0)
<7> [54.846039] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:100:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vsync_end (expected 1088, found 0)
<7> [54.846265] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:100:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vtotal (expected 1144, found 0)
<7> [54.846450] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:100:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vblank_end (expected 1144, found 0)
<7> [54.846630] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:100:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hdisplay (expected 1920, found 0)
<7> [54.846812] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:100:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_htotal (expected 2080, found 0)
<7> [54.846989] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:100:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hblank_start (expected 1920, found 0)
<7> [54.847178] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:100:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hblank_end (expected 2080, found 0)
<7> [54.847340] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:100:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hsync_start (expected 1968, found 0)
<7> [54.847481] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:100:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hsync_end (expected 2000, found 0)
<7> [54.847620] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:100:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vdisplay (expected 1080, found 0)
<7> [54.847758] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:100:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vblank_start (expected 1080, found 0)
<7> [54.847897] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:100:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vsync_start (expected 1083, found 0)
<7> [54.848042] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:100:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vsync_end (expected 1088, found 0)
<7> [54.848209] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:100:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vtotal (expected 1144, found 0)
<7> [54.848354] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:100:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vblank_end (expected 1144, found 0)
<7> [54.848496] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:100:pipe A] fastset requirement not met in pixel_multiplier (expected 1, found 0)
<7> [54.848638] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:100:pipe A] fastset requirement not met in hw.adjusted_mode.flags (1) (expected 1, found 0)
<7> [54.848778] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:100:pipe A] fastset requirement not met in hw.adjusted_mode.flags (4) (expected 4, found 0)
<7> [54.848918] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:100:pipe A] fastset requirement not met in has_hdmi_sink (expected yes, found no)
<7> [54.849072] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:100:pipe A] fastset requirement not met in has_infoframe (expected yes, found no)
<7> [54.849241] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:100:pipe A] fastset requirement not met in pipe_bpp (expected 24, found 0)
<7> [54.849381] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:100:pipe A] fastset requirement not met in hw.pipe_mode.crtc_clock (expected 285500, found 0)
<7> [54.849522] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:100:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_clock (expected 285500, found 0)
<7> [54.849661] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:100:pipe A] fastset requirement not met in port_clock (expected 285500, found 0)
<7> [54.849799] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:100:pipe A] fastset requirement not met in infoframes.enable (expected 0x00000071, found 0x00000000)
<7> [54.849940] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:100:pipe A] fastset requirement not met in avi infoframe
<7> [54.850093] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] expected:
<7> [54.850256] i915 0000:00:02.0: HDMI infoframe: Auxiliary Video Information (AVI), version 2, length 13
<7> [54.850258] i915 0000:00:02.0: colorspace: RGB
<7> [54.850260] i915 0000:00:02.0: scan mode: Underscan
<7> [54.850261] i915 0000:00:02.0: colorimetry: No Data
<7> [54.850263] i915 0000:00:02.0: picture aspect: No Data
<7> [54.850264] i915 0000:00:02.0: active aspect: Same as Picture
<7> [54.850266] i915 0000:00:02.0: itc: No Data
<7> [54.850267] i915 0000:00:02.0: extended colorimetry: xvYCC 601
<7> [54.850268] i915 0000:00:02.0: quantization range: Full
<7> [54.850270] i915 0000:00:02.0: nups: Unknown Non-uniform Scaling
<7> [54.850271] i915 0000:00:02.0: video code: 0
<7> [54.850272] i915 0000:00:02.0: ycc quantization range: Full
<7> [54.850274] i915 0000:00:02.0: hdmi content type: Graphics
<7> [54.850275] i915 0000:00:02.0: pixel repeat: 0
<7> [54.850276] i915 0000:00:02.0: bar top 0, bottom 0, left 0, right 0
<7> [54.850278] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] found:
<7> [54.850416] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:100:pipe A] fastset requirement not met in spd infoframe
<7> [54.850551] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] expected:
<7> [54.850681] i915 0000:00:02.0: HDMI infoframe: Source Product Description (SPD), version 1, length 25
<7> [54.850682] i915 0000:00:02.0: vendor: Intel
<7> [54.850683] i915 0000:00:02.0: product: Integrated gfx
<7> [54.850684] i915 0000:00:02.0: source device information: PC General (0x9)
<7> [54.850686] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] found:
<7> [54.850810] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:100:pipe A] fastset requirement not met in hdmi infoframe
<7> [54.850949] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] expected:
<7> [54.851101] i915 0000:00:02.0: HDMI infoframe: Vendor, version 1, length 4
<7> [54.851104] i915 0000:00:02.0: empty frame
<7> [54.851106] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] found:
<7> [54.851279] i915 0000:00:02.0: [drm:intel_atomic_check [i915]] [CRTC:100:pipe A] fastset requirement not met, forcing full modeset
<7> [54.851423] i915 0000:00:02.0: [drm:intel_unreference_shared_dpll_crtc [i915]] [CRTC:100:pipe A] releasing DPLL 0
<7> [54.851580] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] Enabled dbuf slices 0x3 -> 0x1 (total dbuf slices 0x3), mbus joined? no->no
<7> [54.851709] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] [CRTC:100:pipe A] dbuf slices 0x3 -> 0x0, ddb (0 - 2048) -> (0 - 0), active pipes 0x1 -> 0x0
<7> [54.851866] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] [PLANE:32:plane 1A] ddb ( 0 - 1993) -> ( 0 - 0), size 1993 -> 0
<7> [54.851992] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] [PLANE:95:cursor A] ddb (1993 - 2048) -> ( 0 - 0), size 55 -> 0
<7> [54.852153] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] [PLANE:32: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> [54.852310] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] [PLANE:32:plane 1A] lines 1, 8, 8, 8, 8, 11, 16, 16, 0, 0, 0 -> 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0
<7> [54.852440] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] [PLANE:32:plane 1A] blocks 16, 129, 129, 129, 129, 177, 257, 257, 30, 0, 0 -> 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0
<7> [54.852569] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] [PLANE:32:plane 1A] min_ddb 19, 143, 143, 143, 143, 196, 284, 284, 31, 0, 0 -> 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0
<7> [54.852697] i915 0000:00:02.0: [drm:intel_bw_atomic_check [i915]] [CRTC:100:pipe A] data rate 0 num active planes 0
<7> [54.852838] i915 0000:00:02.0: [drm:intel_bw_atomic_check [i915]] QGV point 0: max bw 14993 required 0
<7> [54.853009] i915 0000:00:02.0: [drm:intel_modeset_calc_cdclk [i915]] Modeset required for cdclk change
<7> [54.853163] i915 0000:00:02.0: [drm:intel_modeset_calc_cdclk [i915]] New cdclk calculated to be logical 172800 kHz, actual 172800 kHz
<7> [54.853324] i915 0000:00:02.0: [drm:intel_modeset_calc_cdclk [i915]] New voltage level calculated to be logical 0, actual 0
<7> [54.853465] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [CRTC:100:pipe A] enable: no [modeset]
<7> [54.853604] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:32:plane 1A] fb: [NOFB], visible: no
<7> [54.853741] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:41:plane 2A] fb: [NOFB], visible: no
<7> [54.853881] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:50:plane 3A] fb: [NOFB], visible: no
<7> [54.854022] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:59:plane 4A] fb: [NOFB], visible: no
<7> [54.854178] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:68:plane 5A] fb: [NOFB], visible: no
<7> [54.854345] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:77:plane 6A] fb: [NOFB], visible: no
<7> [54.854482] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:86:plane 7A] fb: [NOFB], visible: no
<7> [54.854617] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:95:cursor A] fb: [NOFB], visible: no
<7> [54.854806] i915 0000:00:02.0: [drm:intel_audio_codec_disable [i915]] [CONNECTOR:313:HDMI-A-1][ENCODER:312:DDI B/PHY B] Disable audio codec on [CRTC:100:pipe A]
<7> [54.864873] i915 0000:00:02.0: [drm:i915_audio_component_get_eld [i915]] Not valid for port B
<7> [54.874706] i915 0000:00:02.0: [drm:intel_hdmi_handle_sink_scrambling [i915]] [CONNECTOR:313:HDMI-A-1] scrambling=no, TMDS bit clock ratio=1/10
<7> [54.875392] i915 0000:00:02.0: [drm:do_gmbus_xfer [i915]] GMBUS [i915 gmbus dpb] NAK for addr: 0054 w(1)
<7> [54.875537] i915 0000:00:02.0: [drm:do_gmbus_xfer [i915]] GMBUS [i915 gmbus dpb] NAK on first message, retry
<7> [54.876162] i915 0000:00:02.0: [drm:do_gmbus_xfer [i915]] GMBUS [i915 gmbus dpb] NAK for addr: 0054 w(1)
<7> [54.876317] i915 0000:00:02.0: [drm:drm_scdc_set_high_tmds_clock_ratio [drm_display_helper]] [CONNECTOR:313:HDMI-A-1] Failed to read TMDS config: -6
<7> [54.876329] i915 0000:00:02.0: [drm:intel_encoders_disable [i915]] [CONNECTOR:313:HDMI-A-1] Failed to reset sink scrambling/TMDS bit clock ratio
<7> [54.876521] i915 0000:00:02.0: [drm:intel_disable_transcoder [i915]] disabling pipe A
<7> [54.883204] i915 0000:00:02.0: [drm:intel_power_well_disable [i915]] disabling DDI_IO_B
<7> [54.883463] i915 0000:00:02.0: [drm:intel_disable_shared_dpll [i915]] disable DPLL 0 (active 0x1, on? 1) for [CRTC:100:pipe A]
<7> [54.883683] i915 0000:00:02.0: [drm:intel_disable_shared_dpll [i915]] disabling DPLL 0
<7> [54.883894] i915 0000:00:02.0: [drm:__intel_fbc_disable [i915]] Disabling FBC on [PLANE:32:plane 1A]
<7> [54.884092] i915 0000:00:02.0: [drm:intel_set_cdclk [i915]] Pre changing CDCLK to 172800 kHz, VCO 345600 kHz, ref 38400 kHz, bypass 19200 kHz, voltage level 0
<7> [54.884435] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:312:DDI B/PHY B]
<7> [54.884675] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:322:DDI TC1/PHY TC1]
<7> [54.884874] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:324:DP-MST A]
<7> [54.885075] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:325:DP-MST B]
<7> [54.885274] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:326:DP-MST C]
<7> [54.885478] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:327:DP-MST D]
<7> [54.885668] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:332:DDI TC2/PHY TC2]
<7> [54.885851] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:334:DP-MST A]
<7> [54.886050] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:335:DP-MST B]
<7> [54.886254] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:336:DP-MST C]
<7> [54.886447] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:337:DP-MST D]
<7> [54.886650] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:341:DDI TC3/PHY TC3]
<7> [54.886849] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:343:DP-MST A]
<7> [54.887052] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:344:DP-MST B]
<7> [54.887245] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:345:DP-MST C]
<7> [54.887440] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:346:DP-MST D]
<7> [54.887649] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:350:DDI TC4/PHY TC4]
<7> [54.887842] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:352:DP-MST A]
<7> [54.888033] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:353:DP-MST B]
<7> [54.888212] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:354:DP-MST C]
<7> [54.888424] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:355:DP-MST D]
<7> [54.888610] i915 0000:00:02.0: [drm:verify_connector_state [i915]] [CONNECTOR:313:HDMI-A-1]
<7> [54.888995] i915 0000:00:02.0: [drm:gen9_dbuf_slices_update [i915]] Updating dbuf slices to 0x1
<7> [54.889282] i915 0000:00:02.0: [drm:intel_power_well_disable [i915]] disabling PW_3
<7> [54.889514] i915 0000:00:02.0: [drm:intel_power_well_disable [i915]] disabling PW_2
<7> [54.889741] i915 0000:00:02.0: [drm:intel_modeset_verify_crtc [i915]] [CRTC:100:pipe A]
<7> [54.890404] i915 0000:00:02.0: [drm:drm_mode_setcrtc] [CRTC:170:pipe B]
<7> [54.890607] i915 0000:00:02.0: [drm:drm_mode_setcrtc] [CRTC:240:pipe C]
<7> [54.890782] i915 0000:00:02.0: [drm:drm_mode_setcrtc] [CRTC:310:pipe D]
<7> [54.890958] i915 0000:00:02.0: [drm:drm_mode_setcrtc] [CRTC:100:pipe A]
<7> [54.890998] i915 0000:00:02.0: [drm:drm_mode_setcrtc] [CONNECTOR:313:HDMI-A-1]
<7> [54.891054] i915 0000:00:02.0: [drm:intel_atomic_check [i915]] [CONNECTOR:313:HDMI-A-1] Limiting display bpp to 24 (EDID bpp 24, max requested bpp 36, max platform bpp 36)
<7> [54.891320] i915 0000:00:02.0: [drm:intel_hdmi_compute_clock [i915]] picking 8 bpc for HDMI output (pipe bpp: 24)
<7> [54.891540] i915 0000:00:02.0: [drm:intel_atomic_check [i915]] [CRTC:100:pipe A] hw max bpp: 24, pipe bpp: 24, dithering: 0
<7> [54.891759] i915 0000:00:02.0: [drm:intel_ddi_compute_config_late [i915]] [ENCODER:312:DDI B/PHY B] [CRTC:100:pipe A]
<7> [54.891946] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:100:pipe A] fastset requirement not met in hw.enable (expected no, found yes)
<7> [54.892151] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:100:pipe A] fastset requirement not met in hw.active (expected no, found yes)
<7> [54.892371] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:100:pipe A] fastset requirement not met in cpu_transcoder (expected -1, found 0)
<7> [54.892598] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:100:pipe A] fastset requirement not met in lane_count (expected 0, found 4)
<7> [54.892810] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:100:pipe A] fastset requirement not met in output_types (expected 0x00000000, found 0x00000040)
<7> [54.893016] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:100:pipe A] fastset requirement not met in framestart_delay (expected 0, found 1)
<7> [54.893236] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:100:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hdisplay (expected 0, found 1920)
<7> [54.893433] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:100:pipe A] fastset requirement not met in hw.pipe_mode.crtc_htotal (expected 0, found 2080)
<7> [54.893625] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:100:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hblank_start (expected 0, found 1920)
<7> [54.893832] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:100:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hblank_end (expected 0, found 2080)
<7> [54.894059] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:100:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hsync_start (expected 0, found 1968)
<7> [54.894263] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:100:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hsync_end (expected 0, found 2000)
<7> [54.894463] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:100:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vdisplay (expected 0, found 1080)
<7> [54.894669] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:100:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vblank_start (expected 0, found 1080)
<7> [54.894870] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:100:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vsync_start (expected 0, found 1083)
<7> [54.895067] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:100:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vsync_end (expected 0, found 1088)
<7> [54.895283] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:100:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vtotal (expected 0, found 1144)
<7> [54.895488] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:100:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vblank_end (expected 0, found 1144)
<7> [54.895692] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:100:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hdisplay (expected 0, found 1920)
<7> [54.895891] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:100:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_htotal (expected 0, found 2080)
<7> [54.896101] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:100:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hblank_start (expected 0, found 1920)
<7> [54.896325] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:100:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hblank_end (expected 0, found 2080)
<7> [54.896521] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:100:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hsync_start (expected 0, found 1968)
<7> [54.896726] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:100:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hsync_end (expected 0, found 2000)
<7> [54.896930] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:100:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vdisplay (expected 0, found 1080)
<7> [54.897135] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:100:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vblank_start (expected 0, found 1080)
<7> [54.897354] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:100:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vsync_start (expected 0, found 1083)
<7> [54.897563] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:100:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vsync_end (expected 0, found 1088)
<7> [54.897773] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:100:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vtotal (expected 0, found 1144)
<7> [54.897966] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:100:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vblank_end (expected 0, found 1144)
<7> [54.898170] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:100:pipe A] fastset requirement not met in pixel_multiplier (expected 0, found 1)
<7> [54.898395] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:100:pipe A] fastset requirement not met in hw.adjusted_mode.flags (1) (expected 0, found 1)
<7> [54.898471] i915 0000:00:02.0: [drm:intel_power_well_enable [i915]] enabling PW_2
<7> [54.898624] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:100:pipe A] fastset requirement not met in hw.adjusted_mode.flags (4) (expected 0, found 4)
<7> [54.898699] i915 0000:00:02.0: [drm:intel_power_well_enable [i915]] enabling PW_3
<7> [54.898840] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:100:pipe A] fastset requirement not met in has_hdmi_sink (expected no, found yes)
<7> [54.898936] i915 0000:00:02.0: [drm:i915_audio_component_get_power [i915]] restored AUD_FREQ_CNTRL to 0x810
<7> [54.899051] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:100:pipe A] fastset requirement not met in has_infoframe (expected no, found yes)
<7> [54.899281] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:100:pipe A] fastset requirement not met in pipe_bpp (expected 0, found 24)
<7> [54.899495] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:100:pipe A] fastset requirement not met in hw.pipe_mode.crtc_clock (expected 0, found 285500)
<7> [54.899691] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:100:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_clock (expected 0, found 285500)
<7> [54.899887] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:100:pipe A] fastset requirement not met in port_clock (expected 0, found 285500)
<7> [54.900126] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:100:pipe A] fastset requirement not met in infoframes.enable (expected 0x00000000, found 0x00000071)
<7> [54.900308] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:100:pipe A] fastset requirement not met in avi infoframe
<7> [54.900507] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] expected:
<7> [54.900705] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] found:
<7> [54.900906] i915 0000:00:02.0: HDMI infoframe: Auxiliary Video Information (AVI), version 2, length 13
<7> [54.900910] i915 0000:00:02.0: colorspace: RGB
<7> [54.900912] i915 0000:00:02.0: scan mode: Underscan
<7> [54.900915] i915 0000:00:02.0: colorimetry: No Data
<7> [54.900917] i915 0000:00:02.0: picture aspect: No Data
<7> [54.900920] i915 0000:00:02.0: active aspect: Same as Picture
<7> [54.900923] i915 0000:00:02.0: itc: No Data
<7> [54.900925] i915 0000:00:02.0: extended colorimetry: xvYCC 601
<7> [54.900928] i915 0000:00:02.0: quantization range: Full
<7> [54.900930] i915 0000:00:02.0: nups: Unknown Non-uniform Scaling
<7> [54.900933] i915 0000:00:02.0: video code: 0
<7> [54.900935] i915 0000:00:02.0: ycc quantization range: Full
<7> [54.900938] i915 0000:00:02.0: hdmi content type: Graphics
<7> [54.900940] i915 0000:00:02.0: pixel repeat: 0
<7> [54.900943] i915 0000:00:02.0: bar top 0, bottom 0, left 0, right 0
<7> [54.900946] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:100:pipe A] fastset requirement not met in spd infoframe
<7> [54.901145] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] expected:
<7> [54.901371] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] found:
<7> [54.901572] i915 0000:00:02.0: HDMI infoframe: Source Product Description (SPD), version 1, length 25
<7> [54.901574] i915 0000:00:02.0: vendor: Intel
<7> [54.901576] i915 0000:00:02.0: product: Integrated gfx
<7> [54.901578] i915 0000:00:02.0: source device information: PC General (0x9)
<7> [54.901580] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:100:pipe A] fastset requirement not met in hdmi infoframe
<7> [54.901776] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] expected:
<7> [54.901976] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] found:
<7> [54.902184] i915 0000:00:02.0: HDMI infoframe: Vendor, version 1, length 4
<7> [54.902187] i915 0000:00:02.0: empty frame
<7> [54.902191] i915 0000:00:02.0: [drm:intel_atomic_check [i915]] [CRTC:100:pipe A] fastset requirement not met, forcing full modeset
<7> [54.902443] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] Enabled dbuf slices 0x1 -> 0x3 (total dbuf slices 0x3), mbus joined? no->no
<7> [54.902644] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] [CRTC:100:pipe A] dbuf slices 0x0 -> 0x3, ddb (0 - 0) -> (0 - 2048), active pipes 0x0 -> 0x1
<7> [54.902893] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] [PLANE:32:plane 1A] ddb ( 0 - 0) -> ( 0 - 1993), size 0 -> 1993
<7> [54.903074] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] [PLANE:95:cursor A] ddb ( 0 - 0) -> (1993 - 2048), size 0 -> 55
<7> [54.903272] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] [PLANE:32: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> [54.903469] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] [PLANE:32:plane 1A] lines 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0 -> 1, 8, 8, 8, 8, 11, 16, 16, 0, 0, 0
<7> [54.903662] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] [PLANE:32:plane 1A] blocks 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0 -> 16, 129, 129, 129, 129, 177, 257, 257, 30, 0, 0
<7> [54.903853] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] [PLANE:32:plane 1A] min_ddb 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0 -> 19, 143, 143, 143, 143, 196, 284, 284, 31, 0, 0
<7> [54.904054] i915 0000:00:02.0: [drm:intel_bw_atomic_check [i915]] [CRTC:100:pipe A] data rate 1142000 num active planes 1
<7> [54.904284] i915 0000:00:02.0: [drm:intel_bw_atomic_check [i915]] QGV point 0: max bw 14993 required 1142
<7> [54.904480] i915 0000:00:02.0: [drm:intel_bw_atomic_check [i915]] No SAGV, using single QGV point mask 0x1
<7> [54.904706] i915 0000:00:02.0: [drm:intel_plane_calc_min_cdclk [i915]] [PLANE:32:plane 1A] min cdclk (142750 kHz) > [CRTC:100:pipe A] min cdclk (0 kHz)
<7> [54.904919] i915 0000:00:02.0: [drm:intel_bw_calc_min_cdclk [i915]] new bandwidth min cdclk (22305 kHz) > old min cdclk (0 kHz)
<7> [54.905161] i915 0000:00:02.0: [drm:intel_modeset_calc_cdclk [i915]] Modeset required for cdclk change
<7> [54.905393] i915 0000:00:02.0: [drm:intel_modeset_calc_cdclk [i915]] New cdclk calculated to be logical 192000 kHz, actual 192000 kHz
<7> [54.905609] i915 0000:00:02.0: [drm:intel_modeset_calc_cdclk [i915]] New voltage level calculated to be logical 0, actual 0
<7> [54.905822] i915 0000:00:02.0: [drm:intel_find_shared_dpll [i915]] [CRTC:100:pipe A] allocated DPLL 0
<7> [54.906025] i915 0000:00:02.0: [drm:intel_reference_shared_dpll_crtc [i915]] [CRTC:100:pipe A] reserving DPLL 0
<7> [54.906235] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [CRTC:100:pipe A] enable: yes [modeset]
<7> [54.906483] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] active: yes, output_types: HDMI (0x40), output format: RGB, sink format: RGB
<7> [54.906704] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] cpu_transcoder: A, pipe bpp: 24, dithering: 0
<7> [54.906919] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] MST master transcoder: <invalid>
<7> [54.907127] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] port sync: master transcoder: <invalid>, slave transcoder bitmask = 0x0
<7> [54.907353] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] joiner: no, pipes: 0x0
<7> [54.907553] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] splitter: disabled, link count 0, overlap 0
<7> [54.907766] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] framestart delay: 1, MSA timing delay: 0
<7> [54.907964] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] audio: 1, infoframes: 1, infoframes enabled: 0x71
<7> [54.908161] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] GCP: 0x0
<7> [54.908378] i915 0000:00:02.0: HDMI infoframe: Auxiliary Video Information (AVI), version 2, length 13
<7> [54.908381] i915 0000:00:02.0: colorspace: RGB
<7> [54.908383] i915 0000:00:02.0: scan mode: Underscan
<7> [54.908386] i915 0000:00:02.0: colorimetry: No Data
<7> [54.908388] i915 0000:00:02.0: picture aspect: No Data
<7> [54.908391] i915 0000:00:02.0: active aspect: Same as Picture
<7> [54.908393] i915 0000:00:02.0: itc: No Data
<7> [54.908396] i915 0000:00:02.0: extended colorimetry: xvYCC 601
<7> [54.908398] i915 0000:00:02.0: quantization range: Full
<7> [54.908401] i915 0000:00:02.0: nups: Unknown Non-uniform Scaling
<7> [54.908403] i915 0000:00:02.0: video code: 0
<7> [54.908406] i915 0000:00:02.0: ycc quantization range: Full
<7> [54.908408] i915 0000:00:02.0: hdmi content type: Graphics
<7> [54.908411] i915 0000:00:02.0: pixel repeat: 0
<7> [54.908413] i915 0000:00:02.0: bar top 0, bottom 0, left 0, right 0
<7> [54.908416] i915 0000:00:02.0: HDMI infoframe: Source Product Description (SPD), version 1, length 25
<7> [54.908419] i915 0000:00:02.0: vendor: Intel
<7> [54.908422] i915 0000:00:02.0: product: Integrated gfx
<7> [54.908424] i915 0000:00:02.0: source device information: PC General (0x9)
<7> [54.908427] i915 0000:00:02.0: HDMI infoframe: Vendor, version 1, length 4
<7> [54.908430] i915 0000:00:02.0: empty frame
<7> [54.908432] ELD: 10 00 0f 00 6d a2 00 7f 00 00 00 00 00 00 00 00
<7> [54.908435] ELD: 0d 82 34 12 66 69 74 48 65 61 64 6c 65 73 73 47
<7> [54.908437] ELD: 53 7f 7f 28 0f 7f 07 17 7f ff 3f 7f ff 47 7f ff
<7> [54.908439] ELD: 5f 7f 82 7f 7f 00 7f 7f 51 7f 7f 30 77 7f 03 00
<7> [54.908442] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] vrr: no, vmin: 0, vmax: 0, pipeline full: 0, guardband: 0 flipline: 0, vmin vblank: -1, vmax vblank: -2
<7> [54.908642] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] requested mode: "1920x1080": 120 285500 1920 1968 2000 2080 1080 1083 1088 1144 0x48 0x5
<7> [54.908852] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] adjusted mode: "1920x1080": 120 285500 1920 1968 2000 2080 1080 1083 1088 1144 0x48 0x5
<7> [54.909060] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] crtc timings: clock=285500, hd=1920 hb=1920-2080 hs=1968-2000 ht=2080, vd=1080 vb=1080-1144 vs=1083-1088 vt=1144, flags=0x5
<7> [54.909279] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pipe mode: "1920x1080": 120 285500 1920 1968 2000 2080 1080 1083 1088 1144 0x40 0x5
<7> [54.909511] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] crtc timings: clock=285500, hd=1920 hb=1920-2080 hs=1968-2000 ht=2080, vd=1080 vb=1080-1144 vs=1083-1088 vt=1144, flags=0x5
<7> [54.909715] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] port clock: 285500, pipe src: 1920x1080+0+0, pixel rate 285500
<7> [54.909938] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] linetime: 59, ips linetime: 0
<7> [54.910150] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] num_scalers: 2, scaler_users: 0x0, scaler_id: -1, scaling_filter: 0
<7> [54.910380] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pch pfit: 0x0+0+0, disabled, force thru: no
<7> [54.910587] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] ips: 0, double wide: 0, drrs: 0
<7> [54.910800] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] dpll_hw_state: cfgcr0: 0x1801be, cfgcr1: 0x488, div0: 0x0, mg_refclkin_ctl: 0x0, hg_clktop2_coreclkctl1: 0x0, mg_clktop2_hsclkctl: 0x0, mg_pll_div0: 0x0, mg_pll_div2: 0x0, mg_pll_lf: 0x0, mg_pll_frac_lock: 0x0, mg_pll_ssc: 0x0, mg_pll_bias: 0x0, mg_pll_tdc_coldst_bias: 0x0
<7> [54.911001] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] csc_mode: 0x0 gamma_mode: 0x0 gamma_enable: 0 csc_enable: 0
<7> [54.911204] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pre csc lut: 0 entries, post csc lut: 0 entries
<7> [54.911474] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] output csc: pre offsets: 0x0000 0x0000 0x0000
<7> [54.911685] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] output csc: coefficients: 0x0000 0x0000 0x0000
<7> [54.911897] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] output csc: coefficients: 0x0000 0x0000 0x0000
<7> [54.912100] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] output csc: coefficients: 0x0000 0x0000 0x0000
<7> [54.912306] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] output csc: post offsets: 0x0000 0x0000 0x0000
<7> [54.912518] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pipe csc: pre offsets: 0x0000 0x0000 0x0000
<7> [54.912727] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pipe csc: coefficients: 0x0000 0x0000 0x0000
<7> [54.912923] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pipe csc: coefficients: 0x0000 0x0000 0x0000
<7> [54.913124] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pipe csc: coefficients: 0x0000 0x0000 0x0000
<7> [54.913396] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pipe csc: post offsets: 0x0000 0x0000 0x0000
<7> [54.913639] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:32:plane 1A] fb: [FB:361] 1920x1080 format = XR24 little-endian (0x34325258) modifier = 0x0, visible: yes
<7> [54.913844] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] rotation: 0x1, scaler: -1, scaling_filter: 0
<7> [54.914052] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] src: 1920.000000x1080.000000+0.000000+0.000000 dst: 1920x1080+0+0
<7> [54.914265] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:41:plane 2A] fb: [NOFB], visible: no
<7> [54.914475] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:50:plane 3A] fb: [NOFB], visible: no
<7> [54.914678] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:59:plane 4A] fb: [NOFB], visible: no
<7> [54.914888] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:68:plane 5A] fb: [NOFB], visible: no
<7> [54.915053] i915 0000:00:02.0: [drm:intel_power_well_disable [i915]] disabling PW_3
<7> [54.915112] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:77:plane 6A] fb: [NOFB], visible: no
<7> [54.915287] i915 0000:00:02.0: [drm:intel_power_well_disable [i915]] disabling PW_2
<7> [54.915329] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:86:plane 7A] fb: [NOFB], visible: no
<7> [54.915574] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:95:cursor A] fb: [NOFB], visible: no
<7> [54.916443] i915 0000:00:02.0: [drm:intel_power_well_enable [i915]] enabling PW_2
<7> [54.916667] i915 0000:00:02.0: [drm:intel_power_well_enable [i915]] enabling PW_3
<7> [54.916949] i915 0000:00:02.0: [drm:intel_set_cdclk [i915]] Pre changing CDCLK to 192000 kHz, VCO 384000 kHz, ref 38400 kHz, bypass 19200 kHz, voltage level 0
<7> [54.917253] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:312:DDI B/PHY B]
<7> [54.917471] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:322:DDI TC1/PHY TC1]
<7> [54.917672] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:324:DP-MST A]
<7> [54.917867] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:325:DP-MST B]
<7> [54.918075] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:326:DP-MST C]
<7> [54.918265] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:327:DP-MST D]
<7> [54.918470] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:332:DDI TC2/PHY TC2]
<7> [54.918666] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:334:DP-MST A]
<7> [54.918915] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:335:DP-MST B]
<7> [54.919114] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:336:DP-MST C]
<7> [54.919310] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:337:DP-MST D]
<7> [54.919522] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:341:DDI TC3/PHY TC3]
<7> [54.919718] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:343:DP-MST A]
<7> [54.919927] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:344:DP-MST B]
<7> [54.920122] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:345:DP-MST C]
<7> [54.920316] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:346:DP-MST D]
<7> [54.920542] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:350:DDI TC4/PHY TC4]
<7> [54.920733] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:352:DP-MST A]
<7> [54.920922] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:353:DP-MST B]
<7> [54.921118] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:354:DP-MST C]
<7> [54.921314] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:355:DP-MST D]
<7> [54.921667] i915 0000:00:02.0: [drm:gen9_dbuf_slices_update [i915]] Updating dbuf slices to 0x3
<7> [54.921925] i915 0000:00:02.0: [drm:intel_enable_shared_dpll [i915]] enable DPLL 0 (active 0x1, on? 0) for [CRTC:100:pipe A]
<7> [54.922189] i915 0000:00:02.0: [drm:intel_enable_shared_dpll [i915]] enabling DPLL 0
<7> [54.922475] i915 0000:00:02.0: [drm:intel_power_well_enable [i915]] enabling DDI_IO_B
<7> [54.922782] i915 0000:00:02.0: [drm:intel_enable_transcoder [i915]] enabling pipe A
<7> [54.923153] i915 0000:00:02.0: [drm:intel_hdmi_handle_sink_scrambling [i915]] [CONNECTOR:313:HDMI-A-1] scrambling=no, TMDS bit clock ratio=1/10
<7> [54.923939] i915 0000:00:02.0: [drm:do_gmbus_xfer [i915]] GMBUS [i915 gmbus dpb] NAK for addr: 0054 w(1)
<7> [54.924178] i915 0000:00:02.0: [drm:do_gmbus_xfer [i915]] GMBUS [i915 gmbus dpb] NAK on first message, retry
<7> [54.924932] i915 0000:00:02.0: [drm:do_gmbus_xfer [i915]] GMBUS [i915 gmbus dpb] NAK for addr: 0054 w(1)
<7> [54.925129] i915 0000:00:02.0: [drm:drm_scdc_set_high_tmds_clock_ratio [drm_display_helper]] [CONNECTOR:313:HDMI-A-1] Failed to read TMDS config: -6
<7> [54.925145] i915 0000:00:02.0: [drm:intel_enable_ddi [i915]] [CONNECTOR:313:HDMI-A-1] Failed to configure sink scrambling/TMDS bit clock ratio
<7> [54.926798] i915 0000:00:02.0: [drm:intel_fbc_update [i915]] reserved 17694720 bytes of contiguous stolen space for FBC, limit: 1
<7> [54.927013] i915 0000:00:02.0: [drm:intel_fbc_update [i915]] Enabling FBC on [PLANE:32:plane 1A]
<7> [54.933898] i915 0000:00:02.0: [drm:intel_audio_codec_enable [i915]] [CONNECTOR:313:HDMI-A-1][ENCODER:312:DDI B/PHY B] Enable audio codec on [CRTC:100:pipe A], 64 bytes ELD
<7> [54.942204] i915 0000:00:02.0: [drm:audio_config_hdmi_pixel_clock [i915]] HDMI audio pixel clock setting for 285500 not found, falling back to defaults
<7> [54.942367] i915 0000:00:02.0: [drm:audio_config_hdmi_pixel_clock [i915]] Configuring HDMI audio for pixel clock 25200 (0x00010000)
<7> [54.942522] i915 0000:00:02.0: [drm:hsw_hdmi_audio_config_update.isra.0 [i915]] using automatic N
<6> [54.942678] snd_hda_codec_hdmi hdaudioC0D2: HDMI: audio coding xtype 5 not expected
<6> [54.942680] snd_hda_codec_hdmi hdaudioC0D2: HDMI: audio coding xtype 0 not expected
<6> [54.942682] snd_hda_codec_hdmi hdaudioC0D2: HDMI: audio coding xtype 10 not expected
<6> [54.942683] snd_hda_codec_hdmi hdaudioC0D2: HDMI: audio coding xtype 6 not expected
<7> [54.942819] i915 0000:00:02.0: [drm:verify_connector_state [i915]] [CONNECTOR:313:HDMI-A-1]
<7> [54.943024] i915 0000:00:02.0: [drm:intel_modeset_verify_crtc [i915]] [CRTC:100:pipe A]
<7> [54.968966] i915 0000:00:02.0: [drm:i915_audio_component_get_power [i915]] restored AUD_FREQ_CNTRL to 0x810
<7> [55.857953] i915 0000:00:02.0: [drm:intel_tc_port_update_mode [i915]] Port G/TC#4: TC port mode reset (tbt-alt -> disconnected)
<7> [55.858021] i915 0000:00:02.0: [drm:intel_tc_port_update_mode [i915]] Port F/TC#3: TC port mode reset (tbt-alt -> disconnected)
<7> [55.858085] i915 0000:00:02.0: [drm:intel_tc_port_update_mode [i915]] Port E/TC#2: TC port mode reset (tbt-alt -> disconnected)
<7> [55.858148] i915 0000:00:02.0: [drm:intel_power_well_disable [i915]] disabling TC_cold_off
<7> [55.858576] i915 0000:00:02.0: [drm:__intel_display_power_put_domain [i915]] TC cold unblock succeeded
<7> [55.859075] i915 0000:00:02.0: [drm:intel_tc_port_update_mode [i915]] Port D/TC#1: TC port mode reset (legacy -> disconnected)
<6> [65.691029] [IGT] kms_flip: finished subtest A-HDMI-A1, FAIL
Created at 2024-10-08 22:00:13