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

Machine description: shard-tglu-6

Result: Fail

integration-manifest git-log-oneline i915_display_info3 igt_runner3 run3 runtimes3 results3.json i915_display_info_post_exec3 boot3 dmesg3

DetailValue
Duration 10.89 seconds
Hostname
shard-tglu-6
Igt-Version
IGT-Version: 1.29-NO-GIT (x86_64) (Linux: 6.12.0-rc7-CI_DRM_15692-g52166ab72753+ x86_64)
Out
Using IGT_SRANDOM=1731558328 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 8296.2us +- 2.613us accuracy 0.09%
vblank interval differs from modeline! expected 8334.6us, measured 8296us +- 2.613us, difference 38.4us (14.7 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.891s)
Err
Starting subtest: blocking-wf_vblank
Starting dynamic subtest: A-HDMI-A1
(kms_flip:1520) CRITICAL: Test assertion failure function __run_test_on_crtc_set, file ../tests/kms_flip.c:1674:
(kms_flip:1520) CRITICAL: Failed assertion: !retried && needs_retry_after_link_reset(mon)
Dynamic subtest A-HDMI-A1 failed.
**** DEBUG ****
(kms_flip:1520) igt_fb-DEBUG: igt_create_fb_with_bo_size(width=1920, height=1080, format=XR24(0x34325258), modifier=0x0, size=0)
(kms_flip:1520) igt_fb-DEBUG: igt_create_fb_with_bo_size(handle=1, pitch=7680)
(kms_flip:1520) ioctl_wrappers-DEBUG: Test requirement passed: igt_has_fb_modifiers(fd)
(kms_flip:1520) igt_fb-DEBUG: igt_create_fb_with_bo_size(width=1920, height=1080, format=XR24(0x34325258), modifier=0x0, size=0)
(kms_flip:1520) igt_fb-DEBUG: igt_create_fb_with_bo_size(handle=2, pitch=7680)
(kms_flip:1520) ioctl_wrappers-DEBUG: Test requirement passed: igt_has_fb_modifiers(fd)
(kms_flip:1520) intel_blt-DEBUG: Test requirement passed: cmds_info
(kms_flip:1520) intel_blt-DEBUG: Test requirement passed: cmds_info
(kms_flip:1520) igt_fb-DEBUG: Test requirement passed: cairo_surface_status(fb->cairo_surface) == CAIRO_STATUS_SUCCESS
(kms_flip:1520) intel_blt-DEBUG: Test requirement passed: cmds_info
(kms_flip:1520) intel_blt-DEBUG: Test requirement passed: cmds_info
(kms_flip:1520) igt_fb-DEBUG: Test requirement passed: cairo_surface_status(fb->cairo_surface) == CAIRO_STATUS_SUCCESS
(kms_flip:1520) igt_kms-INFO:   1920x1080: 120 285500 1920 1968 2000 2080 1080 1083 1088 1144 0x48 0x5 
(kms_flip:1520) DEBUG: No stale events found
(kms_flip:1520) i915/intel_drrs-DEBUG: Manually disabling DRRS. 0
(kms_flip:1520) i915/intel_drrs-DEBUG: Test requirement passed: dir >= 0
(kms_flip:1520) INFO: Expected frametime: 8335us; measured 8296.2us +- 2.613us accuracy 0.09%
(kms_flip:1520) INFO: vblank interval differs from modeline! expected 8334.6us, measured 8296us +- 2.613us, difference 38.4us (14.7 sigma)
(kms_flip:1520) DEBUG: name = vblank
last_ts = 0.000000
last_received_ts = 0.000000
last_seq = 0
current_ts = 248.765976
current_received_ts = 248.765808
current_seq = 18406
count = 0
seq_step = 10
(kms_flip:1520) DEBUG: name = vblank
last_ts = 248.765976
last_received_ts = 248.765808
last_seq = 18406
current_ts = 248.848938
current_received_ts = 248.848770
current_seq = 18416
count = 1
seq_step = 10
(kms_flip:1520) DEBUG: vblank ts/seq: last 248.765976/18406, current 248.848938/18416: elapsed=82959.0us expected=82961.9us +- 414.8us, error 0.0%
(kms_flip:1520) DEBUG: name = vblank
last_ts = 248.848938
last_received_ts = 248.848770
last_seq = 18416
current_ts = 248.931900
current_received_ts = 248.931519
current_seq = 18426
count = 2
seq_step = 10
(kms_flip:1520) DEBUG: vblank ts/seq: last 248.848938/18416, current 248.931900/18426: elapsed=82965.0us expected=82961.9us +- 414.8us, error 0.0%
(kms_flip:1520) DEBUG: name = vblank
last_ts = 248.931900
last_received_ts = 248.931519
last_seq = 18426
current_ts = 249.014862
current_received_ts = 249.014679
current_seq = 18436
count = 3
seq_step = 10
(kms_flip:1520) DEBUG: vblank ts/seq: last 248.931900/18426, current 249.014862/18436: elapsed=82962.0us expected=82961.9us +- 414.8us, error 0.0%
(kms_flip:1520) DEBUG: name = vblank
last_ts = 249.014862
last_received_ts = 249.014679
last_seq = 18436
current_ts = 249.097855
current_received_ts = 249.097687
current_seq = 18446
count = 4
seq_step = 10
(kms_flip:1520) DEBUG: vblank ts/seq: last 249.014862/18436, current 249.097855/18446: elapsed=82986.0us expected=82961.9us +- 414.8us, error 0.0%
(kms_flip:1520) DEBUG: name = vblank
last_ts = 249.097855
last_received_ts = 249.097687
last_seq = 18446
current_ts = 249.180847
current_received_ts = 249.180664
current_seq = 18456
count = 5
seq_step = 10
(kms_flip:1520) DEBUG: vblank ts/seq: last 249.097855/18446, current 249.180847/18456: elapsed=83003.0us expected=82961.9us +- 414.8us, error 0.0%
(kms_flip:1520) DEBUG: name = vblank
last_ts = 249.180847
last_received_ts = 249.180664
last_seq = 18456
current_ts = 249.263855
current_received_ts = 249.263687
current_seq = 18466
count = 6
seq_step = 10
(kms_flip:1520) DEBUG: vblank ts/seq: last 249.180847/18456, current 249.263855/18466: elapsed=83007.0us expected=82961.9us +- 414.8us, error 0.1%
(kms_flip:1520) DEBUG: name = vblank
last_ts = 249.263855
last_received_ts = 249.263687
last_seq = 18466
current_ts = 249.346863
current_received_ts = 249.346695
current_seq = 18476
count = 7
seq_step = 10
(kms_flip:1520) DEBUG: vblank ts/seq: last 249.263855/18466, current 249.346863/18476: elapsed=83000.0us expected=82961.9us +- 414.8us, error 0.0%
(kms_flip:1520) DEBUG: name = vblank
last_ts = 249.346863
last_received_ts = 249.346695
last_seq = 18476
current_ts = 249.429871
current_received_ts = 249.429733
current_seq = 18486
count = 8
seq_step = 10
(kms_flip:1520) DEBUG: vblank ts/seq: last 249.346863/18476, current 249.429871/18486: elapsed=83006.0us expected=82961.9us +- 414.8us, error 0.1%
(kms_flip:1520) DEBUG: name = vblank
last_ts = 249.429871
last_received_ts = 249.429733
last_seq = 18486
current_ts = 249.512878
current_received_ts = 249.512711
current_seq = 18496
count = 9
seq_step = 10
(kms_flip:1520) DEBUG: vblank ts/seq: last 249.429871/18486, current 249.512878/18496: elapsed=83007.0us expected=82961.9us +- 414.8us, error 0.1%
(kms_flip:1520) DEBUG: name = vblank
last_ts = 249.512878
last_received_ts = 249.512711
last_seq = 18496
current_ts = 249.595871
current_received_ts = 249.595718
current_seq = 18506
count = 10
seq_step = 10
(kms_flip:1520) DEBUG: vblank ts/seq: last 249.512878/18496, current 249.595871/18506: elapsed=83000.0us expected=82961.9us +- 414.8us, error 0.0%
(kms_flip:1520) DEBUG: name = vblank
last_ts = 249.595871
last_received_ts = 249.595718
last_seq = 18506
current_ts = 249.678879
current_received_ts = 249.678696
current_seq = 18516
count = 11
seq_step = 10
(kms_flip:1520) DEBUG: vblank ts/seq: last 249.595871/18506, current 249.678879/18516: elapsed=83004.0us expected=82961.9us +- 414.8us, error 0.1%
(kms_flip:1520) DEBUG: name = vblank
last_ts = 249.678879
last_received_ts = 249.678696
last_seq = 18516
current_ts = 249.761887
current_received_ts = 249.761826
current_seq = 18526
count = 12
seq_step = 10
(kms_flip:1520) DEBUG: vblank ts/seq: last 249.678879/18516, current 249.761887/18526: elapsed=83005.0us expected=82961.9us +- 414.8us, error 0.1%
(kms_flip:1520) DEBUG: name = vblank
last_ts = 249.761887
last_received_ts = 249.761826
last_seq = 18526
current_ts = 249.844879
current_received_ts = 249.844727
current_seq = 18536
count = 13
seq_step = 10
(kms_flip:1520) DEBUG: vblank ts/seq: last 249.761887/18526, current 249.844879/18536: elapsed=83003.0us expected=82961.9us +- 414.8us, error 0.0%
(kms_flip:1520) DEBUG: name = vblank
last_ts = 249.844879
last_received_ts = 249.844727
last_seq = 18536
current_ts = 249.927887
current_received_ts = 249.927612
current_seq = 18546
count = 14
seq_step = 10
(kms_flip:1520) DEBUG: vblank ts/seq: last 249.844879/18536, current 249.927887/18546: elapsed=83003.0us expected=82961.9us +- 414.8us, error 0.0%
(kms_flip:1520) DEBUG: name = vblank
last_ts = 249.927887
last_received_ts = 249.927612
last_seq = 18546
current_ts = 250.010895
current_received_ts = 250.010834
current_seq = 18556
count = 15
seq_step = 10
(kms_flip:1520) DEBUG: vblank ts/seq: last 249.927887/18546, current 250.010895/18556: elapsed=83005.0us expected=82961.9us +- 414.8us, error 0.1%
(kms_flip:1520) DEBUG: name = vblank
last_ts = 250.010895
last_received_ts = 250.010834
last_seq = 18556
current_ts = 250.093918
current_received_ts = 250.093872
current_seq = 18566
count = 16
seq_step = 10
(kms_flip:1520) DEBUG: vblank ts/seq: last 250.010895/18556, current 250.093918/18566: elapsed=83031.0us expected=82961.9us +- 414.8us, error 0.1%
(kms_flip:1520) DEBUG: name = vblank
last_ts = 250.093918
last_received_ts = 250.093872
last_seq = 18566
current_ts = 250.176971
current_received_ts = 250.176910
current_seq = 18576
count = 17
seq_step = 10
(kms_flip:1520) DEBUG: vblank ts/seq: last 250.093918/18566, current 250.176971/18576: elapsed=83040.0us expected=82961.9us +- 414.8us, error 0.1%
(kms_flip:1520) DEBUG: name = vblank
last_ts = 250.176971
last_received_ts = 250.176910
last_seq = 18576
current_ts = 250.260010
current_received_ts = 250.259964
current_seq = 18586
count = 18
seq_step = 10
(kms_flip:1520) DEBUG: vblank ts/seq: last 250.176971/18576, current 250.260010/18586: elapsed=83043.0us expected=82961.9us +- 414.8us, error 0.1%
(kms_flip:1520) DEBUG: name = vblank
last_ts = 250.260010
last_received_ts = 250.259964
last_seq = 18586
current_ts = 250.343048
current_received_ts = 250.342987
current_seq = 18596
count = 19
seq_step = 10
(kms_flip:1520) DEBUG: vblank ts/seq: last 250.260010/18586, current 250.343048/18596: elapsed=83040.0us expected=82961.9us +- 414.8us, error 0.1%
(kms_flip:1520) DEBUG: name = vblank
last_ts = 250.343048
last_received_ts = 250.342987
last_seq = 18596
current_ts = 250.426086
current_received_ts = 250.426041
current_seq = 18606
count = 20
seq_step = 10
(kms_flip:1520) DEBUG: vblank ts/seq: last 250.343048/18596, current 250.426086/18606: elapsed=83044.0us expected=82961.9us +- 414.8us, error 0.1%
(kms_flip:1520) DEBUG: name = vblank
last_ts = 250.426086
last_received_ts = 250.426041
last_seq = 18606
current_ts = 250.509125
current_received_ts = 250.509079
current_seq = 18616
count = 21
seq_step = 10
(kms_flip:1520) DEBUG: vblank ts/seq: last 250.426086/18606, current 250.509125/18616: elapsed=83035.0us expected=82961.9us +- 414.8us, error 0.1%
(kms_flip:1520) DEBUG: name = vblank
last_ts = 250.509125
last_received_ts = 250.509079
last_seq = 18616
current_ts = 250.592178
current_received_ts = 250.592117
current_seq = 18626
count = 22
seq_step = 10
(kms_flip:1520) DEBUG: vblank ts/seq: last 250.509125/18616, current 250.592178/18626: elapsed=83047.0us expected=82961.9us +- 414.8us, error 0.1%
(kms_flip:1520) DEBUG: name = vblank
last_ts = 250.592178
last_received_ts = 250.592117
last_seq = 18626
current_ts = 250.675217
current_received_ts = 250.675140
current_seq = 18636
count = 23
seq_step = 10
(kms_flip:1520) DEBUG: vblank ts/seq: last 250.592178/18626, current 250.675217/18636: elapsed=83039.0us expected=82961.9us +- 414.8us, error 0.1%
(kms_flip:1520) DEBUG: name = vblank
last_ts = 250.675217
last_received_ts = 250.675140
last_seq = 18636
current_ts = 250.758255
current_received_ts = 250.758194
current_seq = 18646
count = 24
seq_step = 10
(kms_flip:1520) DEBUG: vblank ts/seq: last 250.675217/18636, current 250.758255/18646: elapsed=83041.0us expected=82961.9us +- 414.8us, error 0.1%
(kms_flip:1520) DEBUG: name = vblank
last_ts = 250.758255
last_received_ts = 250.758194
last_seq = 18646
current_ts = 250.841293
current_received_ts = 250.841248
current_seq = 18656
count = 25
seq_step = 10
(kms_flip:1520) DEBUG: vblank ts/seq: last 250.758255/18646, current 250.841293/18656: elapsed=83043.0us expected=82961.9us +- 414.8us, error 0.1%
(kms_flip:1520) DEBUG: name = vblank
last_ts = 250.841293
last_received_ts = 250.841248
last_seq = 18656
current_ts = 250.924332
current_received_ts = 250.924179
current_seq = 18666
count = 26
seq_step = 10
(kms_flip:1520) DEBUG: vblank ts/seq: last 250.841293/18656, current 250.924332/18666: elapsed=83037.0us expected=82961.9us +- 414.8us, error 0.1%
(kms_flip:1520) DEBUG: name = vblank
last_ts = 250.924332
last_received_ts = 250.924179
last_seq = 18666
current_ts = 251.007385
current_received_ts = 251.007324
current_seq = 18676
count = 27
seq_step = 10
(kms_flip:1520) DEBUG: vblank ts/seq: last 250.924332/18666, current 251.007385/18676: elapsed=83048.0us expected=82961.9us +- 414.8us, error 0.1%
(kms_flip:1520) DEBUG: name = vblank
last_ts = 251.007385
last_received_ts = 251.007324
last_seq = 18676
current_ts = 251.090439
current_received_ts = 251.090347
current_seq = 18686
count = 28
seq_step = 10
(kms_flip:1520) DEBUG: vblank ts/seq: last 251.007385/18676, current 251.090439/18686: elapsed=83054.0us expected=82961.9us +- 414.8us, error 0.1%
(kms_flip:1520) DEBUG: name = vblank
last_ts = 251.090439
last_received_ts = 251.090347
last_seq = 18686
current_ts = 251.173508
current_received_ts = 251.173431
current_seq = 18696
count = 29
seq_step = 10
(kms_flip:1520) DEBUG: vblank ts/seq: last 251.090439/18686, current 251.173508/18696: elapsed=83075.0us expected=82961.9us +- 414.8us, error 0.1%
(kms_flip:1520) DEBUG: name = vblank
last_ts = 251.173508
last_received_ts = 251.173431
last_seq = 18696
current_ts = 251.256592
current_received_ts = 251.256531
current_seq = 18706
count = 30
seq_step = 10
(kms_flip:1520) DEBUG: vblank ts/seq: last 251.173508/18696, current 251.256592/18706: elapsed=83079.0us expected=82961.9us +- 414.8us, error 0.1%
(kms_flip:1520) DEBUG: name = vblank
last_ts = 251.256592
last_received_ts = 251.256531
last_seq = 18706
current_ts = 251.339661
current_received_ts = 251.339355
current_seq = 18716
count = 31
seq_step = 10
(kms_flip:1520) DEBUG: vblank ts/seq: last 251.256592/18706, current 251.339661/18716: elapsed=83069.0us expected=82961.9us +- 414.8us, error 0.1%
(kms_flip:1520) DEBUG: name = vblank
last_ts = 251.339661
last_received_ts = 251.339355
last_seq = 18716
current_ts = 251.422729
current_received_ts = 251.422668
current_seq = 18726
count = 32
seq_step = 10
(kms_flip:1520) DEBUG: vblank ts/seq: last 251.339661/18716, current 251.422729/18726: elapsed=83078.0us expected=82961.9us +- 414.8us, error 0.1%
(kms_flip:1520) DEBUG: name = vblank
last_ts = 251.422729
last_received_ts = 251.422668
last_seq = 18726
current_ts = 251.505814
current_received_ts = 251.505753
current_seq = 18736
count = 33
seq_step = 10
(kms_flip:1520) DEBUG: vblank ts/seq: last 251.422729/18726, current 251.505814/18736: elapsed=83074.0us expected=82961.9us +- 414.8us, error 0.1%
(kms_flip:1520) DEBUG: name = vblank
last_ts = 251.505814
last_received_ts = 251.505753
last_seq = 18736
current_ts = 251.588882
current_received_ts = 251.588776
current_seq = 18746
count = 34
seq_step = 10
(kms_flip:1520) DEBUG: vblank ts/seq: last 251.505814/18736, current 251.588882/18746: elapsed=83075.0us expected=82961.9us +- 414.8us, error 0.1%
(kms_flip:1520) DEBUG: name = vblank
last_ts = 251.588882
last_received_ts = 251.588776
last_seq = 18746
current_ts = 251.671951
current_received_ts = 251.671661
current_seq = 18756
count = 35
seq_step = 10
(kms_flip:1520) DEBUG: vblank ts/seq: last 251.588882/18746, current 251.671951/18756: elapsed=83070.0us expected=82961.9us +- 414.8us, error 0.1%
(kms_flip:1520) DEBUG: name = vblank
last_ts = 251.671951
last_received_ts = 251.671661
last_seq = 18756
current_ts = 251.755035
current_received_ts = 251.754913
current_seq = 18766
count = 36
seq_step = 10
(kms_flip:1520) DEBUG: vblank ts/seq: last 251.671951/18756, current 251.755035/18766: elapsed=83078.0us expected=82961.9us +- 414.8us, error 0.1%
(kms_flip:1520) DEBUG: name = vblank
last_ts = 251.755035
last_received_ts = 251.754913
last_seq = 18766
current_ts = 251.838104
current_received_ts = 251.838043
current_seq = 18776
count = 37
seq_step = 10
(kms_flip:1520) DEBUG: vblank ts/seq: last 251.755035/18766, current 251.838104/18776: elapsed=83072.0us expected=82961.9us +- 414.8us, error 0.1%
(kms_flip:1520) DEBUG: name = vblank
last_ts = 251.838104
last_received_ts = 251.838043
last_seq = 18776
current_ts = 251.921173
current_received_ts = 251.921066
current_seq = 18786
count = 38
seq_step = 10
(kms_flip:1520) DEBUG: vblank ts/seq: last 251.838104/18776, current 251.921173/18786: elapsed=83073.0us expected=82961.9us +- 414.8us, error 0.1%
(kms_flip:1520) DEBUG: name = vblank
last_ts = 251.921173
last_received_ts = 251.921066
last_seq = 18786
current_ts = 252.004257
current_received_ts = 252.004150
current_seq = 18796
count = 39
seq_step = 10
(kms_flip:1520) DEBUG: vblank ts/seq: last 251.921173/18786, current 252.004257/18796: elapsed=83074.0us expected=82961.9us +- 414.8us, error 0.1%
(kms_flip:1520) DEBUG: name = vblank
last_ts = 252.004257
last_received_ts = 252.004150
last_seq = 18796
current_ts = 252.087341
current_received_ts = 252.087234
current_seq = 18806
count = 40
seq_step = 10
(kms_flip:1520) DEBUG: vblank ts/seq: last 252.004257/18796, current 252.087341/18806: elapsed=83091.0us expected=82961.9us +- 414.8us, error 0.2%
(kms_flip:1520) DEBUG: name = vblank
last_ts = 252.087341
last_received_ts = 252.087234
last_seq = 18806
current_ts = 252.170456
current_received_ts = 252.170349
current_seq = 18816
count = 41
seq_step = 10
(kms_flip:1520) DEBUG: vblank ts/seq: last 252.087341/18806, current 252.170456/18816: elapsed=83106.0us expected=82961.9us +- 414.8us, error 0.2%
(kms_flip:1520) DEBUG: name = vblank
last_ts = 252.170456
last_received_ts = 252.170349
last_seq = 18816
current_ts = 252.253555
current_received_ts = 252.253433
current_seq = 18826
count = 42
seq_step = 10
(kms_flip:1520) DEBUG: vblank ts/seq: last 252.170456/18816, current 252.253555/18826: elapsed=83104.0us expected=82961.9us +- 414.8us, error 0.2%
(kms_flip:1520) DEBUG: name = vblank
last_ts = 252.253555
last_received_ts = 252.253433
last_seq = 18826
current_ts = 252.336655
current_received_ts = 252.336533
current_seq = 18836
count = 43
seq_step = 10
(kms_flip:1520) DEBUG: vblank ts/seq: last 252.253555/18826, current 252.336655/18836: elapsed=83102.0us expected=82961.9us +- 414.8us, error 0.2%
(kms_flip:1520) DEBUG: name = vblank
last_ts = 252.336655
last_received_ts = 252.336533
last_seq = 18836
current_ts = 252.419754
current_received_ts = 252.419464
current_seq = 18846
count = 44
seq_step = 10
(kms_flip:1520) DEBUG: vblank ts/seq: last 252.336655/18836, current 252.419754/18846: elapsed=83100.0us expected=82961.9us +- 414.8us, error 0.2%
(kms_flip:1520) DEBUG: name = vblank
last_ts = 252.419754
last_received_ts = 252.419464
last_seq = 18846
current_ts = 252.502853
current_received_ts = 252.502747
current_seq = 18856
count = 45
seq_step = 10
(kms_flip:1520) DEBUG: vblank ts/seq: last 252.419754/18846, current 252.502853/18856: elapsed=83102.0us expected=82961.9us +- 414.8us, error 0.2%
(kms_flip:1520) DEBUG: name = vblank
last_ts = 252.502853
last_received_ts = 252.502747
last_seq = 18856
current_ts = 252.585968
current_received_ts = 252.585724
current_seq = 18866
count = 46
seq_step = 10
(kms_flip:1520) DEBUG: vblank ts/seq: last 252.502853/18856, current 252.585968/18866: elapsed=83107.0us expected=82961.9us +- 414.8us, error 0.2%
(kms_flip:1520) DEBUG: name = vblank
last_ts = 252.585968
last_received_ts = 252.585724
last_seq = 18866
current_ts = 252.669067
current_received_ts = 252.668961
current_seq = 18876
count = 47
seq_step = 10
(kms_flip:1520) DEBUG: vblank ts/seq: last 252.585968/18866, current 252.669067/18876: elapsed=83104.0us expected=82961.9us +- 414.8us, error 0.2%
(kms_flip:1520) DEBUG: name = vblank
last_ts = 252.669067
last_received_ts = 252.668961
last_seq = 18876
current_ts = 252.752167
current_received_ts = 252.752045
current_seq = 18886
count = 48
seq_step = 10
(kms_flip:1520) DEBUG: vblank ts/seq: last 252.669067/18876, current 252.752167/18886: elapsed=83099.0us expected=82961.9us +- 414.8us, error 0.2%
(kms_flip:1520) DEBUG: name = vblank
last_ts = 252.752167
last_received_ts = 252.752045
last_seq = 18886
current_ts = 252.835281
current_received_ts = 252.835068
current_seq = 18896
count = 49
seq_step = 10
(kms_flip:1520) DEBUG: vblank ts/seq: last 252.752167/18886, current 252.835281/18896: elapsed=83106.0us expected=82961.9us +- 414.8us, error 0.2%
(kms_flip:1520) DEBUG: name = vblank
last_ts = 252.835281
last_received_ts = 252.835068
last_seq = 18896
current_ts = 252.918365
current_received_ts = 252.918274
current_seq = 18906
count = 50
seq_step = 10
(kms_flip:1520) DEBUG: vblank ts/seq: last 252.835281/18896, current 252.918365/18906: elapsed=83099.0us expected=82961.9us +- 414.8us, error 0.2%
(kms_flip:1520) DEBUG: name = vblank
last_ts = 252.918365
last_received_ts = 252.918274
last_seq = 18906
current_ts = 253.001480
current_received_ts = 253.001373
current_seq = 18916
count = 51
seq_step = 10
(kms_flip:1520) DEBUG: vblank ts/seq: last 252.918365/18906, current 253.001480/18916: elapsed=83103.0us expected=82961.9us +- 414.8us, error 0.2%
(kms_flip:1520) DEBUG: name = vblank
last_ts = 253.001480
last_received_ts = 253.001373
last_seq = 18916
current_ts = 253.084595
current_received_ts = 253.084488
current_seq = 18926
count = 52
seq_step = 10
(kms_flip:1520) DEBUG: vblank ts/seq: last 253.001480/18916, current 253.084595/18926: elapsed=83119.0us expected=82961.9us +- 414.8us, error 0.2%
(kms_flip:1520) DEBUG: name = vblank
last_ts = 253.084595
last_received_ts = 253.084488
last_seq = 18926
current_ts = 253.167725
current_received_ts = 253.167618
current_seq = 18936
count = 53
seq_step = 10
(kms_flip:1520) DEBUG: vblank ts/seq: last 253.084595/18926, current 253.167725/18936: elapsed=83129.0us expected=82961.9us +- 414.8us, error 0.2%
(kms_flip:1520) DEBUG: name = vblank
last_ts = 253.167725
last_received_ts = 253.167618
last_seq = 18936
current_ts = 253.250854
current_received_ts = 253.250732
current_seq = 18946
count = 54
seq_step = 10
(kms_flip:1520) DEBUG: vblank ts/seq: last 253.167725/18936, current 253.250854/18946: elapsed=83129.0us expected=82961.9us +- 414.8us, error 0.2%
(kms_flip:1520) DEBUG: name = vblank
last_ts = 253.250854
last_received_ts = 253.250732
last_seq = 18946
current_ts = 253.333984
current_received_ts = 253.333893
current_seq = 18956
count = 55
seq_step = 10
(kms_flip:1520) DEBUG: vblank ts/seq: last 253.250854/18946, current 253.333984/18956: elapsed=83124.0us expected=82961.9us +- 414.8us, error 0.2%
(kms_flip:1520) DEBUG: name = vblank
last_ts = 253.333984
last_received_ts = 253.333893
last_seq = 18956
current_ts = 253.417114
current_received_ts = 253.416992
current_seq = 18966
count = 56
seq_step = 10
(kms_flip:1520) DEBUG: vblank ts/seq: last 253.333984/18956, current 253.417114/18966: elapsed=83132.0us expected=82961.9us +- 414.8us, error 0.2%
(kms_flip:1520) DEBUG: name = vblank
last_ts = 253.417114
last_received_ts = 253.416992
last_seq = 18966
current_ts = 253.500229
current_received_ts = 253.500137
current_seq = 18976
count = 57
seq_step = 10
(kms_flip:1520) DEBUG: vblank ts/seq: last 253.417114/18966, current 253.500229/18976: elapsed=83126.0us expected=82961.9us +- 414.8us, error 0.2%
(kms_flip:1520) DEBUG: name = vblank
last_ts = 253.500229
last_received_ts = 253.500137
last_seq = 18976
current_ts = 253.583359
current_received_ts = 253.583237
current_seq = 18986
count = 58
seq_step = 10
(kms_flip:1520) DEBUG: vblank ts/seq: last 253.500229/18976, current 253.583359/18986: elapsed=83127.0us expected=82961.9us +- 414.8us, error 0.2%
(kms_flip:1520) DEBUG: name = vblank
last_ts = 253.583359
last_received_ts = 253.583237
last_seq = 18986
current_ts = 253.666489
current_received_ts = 253.666290
current_seq = 18996
count = 59
seq_step = 10
(kms_flip:1520) DEBUG: vblank ts/seq: last 253.583359/18986, current 253.666489/18996: elapsed=83126.0us expected=82961.9us +- 414.8us, error 0.2%
(kms_flip:1520) DEBUG: name = vblank
last_ts = 253.666489
last_received_ts = 253.666290
last_seq = 18996
current_ts = 253.749619
current_received_ts = 253.749512
current_seq = 19006
count = 60
seq_step = 10
(kms_flip:1520) DEBUG: vblank ts/seq: last 253.666489/18996, current 253.749619/19006: elapsed=83129.0us expected=82961.9us +- 414.8us, error 0.2%
(kms_flip:1520) DEBUG: name = vblank
last_ts = 253.749619
last_received_ts = 253.749512
last_seq = 19006
current_ts = 253.832748
current_received_ts = 253.832626
current_seq = 19016
count = 61
seq_step = 10
(kms_flip:1520) DEBUG: vblank ts/seq: last 253.749619/19006, current 253.832748/19016: elapsed=83132.0us expected=82961.9us +- 414.8us, error 0.2%
(kms_flip:1520) DEBUG: name = vblank
last_ts = 253.832748
last_received_ts = 253.832626
last_seq = 19016
current_ts = 253.915878
current_received_ts = 253.915771
current_seq = 19026
count = 62
seq_step = 10
(kms_flip:1520) DEBUG: vblank ts/seq: last 253.832748/19016, current 253.915878/19026: elapsed=83123.0us expected=82961.9us +- 414.8us, error 0.2%
(kms_flip:1520) DEBUG: name = vblank
last_ts = 253.915878
last_received_ts = 253.915771
last_seq = 19026
current_ts = 253.998993
current_received_ts = 253.998886
current_seq = 19036
count = 63
seq_step = 10
(kms_flip:1520) DEBUG: vblank ts/seq: last 253.915878/19026, current 253.998993/19036: elapsed=83128.0us expected=82961.9us +- 414.8us, error 0.2%
(kms_flip:1520) DEBUG: name = vblank
last_ts = 253.998993
last_received_ts = 253.998886
last_seq = 19036
current_ts = 254.082138
current_received_ts = 254.082047
current_seq = 19046
count = 64
seq_step = 10
(kms_flip:1520) DEBUG: vblank ts/seq: last 253.998993/19036, current 254.082138/19046: elapsed=83145.0us expected=82961.9us +- 414.8us, error 0.2%
(kms_flip:1520) DEBUG: name = vblank
last_ts = 254.082138
last_received_ts = 254.082047
last_seq = 19046
current_ts = 254.165298
current_received_ts = 254.165207
current_seq = 19056
count = 65
seq_step = 10
(kms_flip:1520) DEBUG: vblank ts/seq: last 254.082138/19046, current 254.165298/19056: elapsed=83149.0us expected=82961.9us +- 414.8us, error 0.2%
(kms_flip:1520) DEBUG: name = vblank
last_ts = 254.165298
last_received_ts = 254.165207
last_seq = 19056
current_ts = 254.248444
current_received_ts = 254.248352
current_seq = 19066
count = 66
seq_step = 10
(kms_flip:1520) DEBUG: vblank ts/seq: last 254.165298/19056, current 254.248444/19066: elapsed=83147.0us expected=82961.9us +- 414.8us, error 0.2%
(kms_flip:1520) DEBUG: name = vblank
last_ts = 254.248444
last_received_ts = 254.248352
last_seq = 19066
current_ts = 254.331589
current_received_ts = 254.331528
current_seq = 19076
count = 67
seq_step = 10
(kms_flip:1520) DEBUG: vblank ts/seq: last 254.248444/19066, current 254.331589/19076: elapsed=83149.0us expected=82961.9us +- 414.8us, error 0.2%
(kms_flip:1520) DEBUG: name = vblank
last_ts = 254.331589
last_received_ts = 254.331528
last_seq = 19076
current_ts = 254.414749
current_received_ts = 254.414688
current_seq = 19086
count = 68
seq_step = 10
(kms_flip:1520) DEBUG: vblank ts/seq: last 254.331589/19076, current 254.414749/19086: elapsed=83156.0us expected=82961.9us +- 414.8us, error 0.2%
(kms_flip:1520) DEBUG: name = vblank
last_ts = 254.414749
last_received_ts = 254.414688
last_seq = 19086
current_ts = 254.497894
current_received_ts = 254.497833
current_seq = 19096
count = 69
seq_step = 10
(kms_flip:1520) DEBUG: vblank ts/seq: last 254.414749/19086, current 254.497894/19096: elapsed=83145.0us expected=82961.9us +- 414.8us, error 0.2%
(kms_flip:1520) DEBUG: name = vblank
last_ts = 254.497894
last_received_ts = 254.497833
last_seq = 19096
current_ts = 254.581039
current_received_ts = 254.580948
current_seq = 19106
count = 70
seq_step = 10
(kms_flip:1520) DEBUG: vblank ts/seq: last 254.497894/19096, current 254.581039/19106: elapsed=83154.0us expected=82961.9us +- 414.8us, error 0.2%
(kms_flip:1520) DEBUG: name = vblank
last_ts = 254.581039
last_received_ts = 254.580948
last_seq = 19106
current_ts = 254.664200
current_received_ts = 254.664139
current_seq = 19116
count = 71
seq_step = 10
(kms_flip:1520) DEBUG: vblank ts/seq: last 254.581039/19106, current 254.664200/19116: elapsed=83149.0us expected=82961.9us +- 414.8us, error 0.2%
(kms_flip:1520) DEBUG: name = vblank
last_ts = 254.664200
last_received_ts = 254.664139
last_seq = 19116
current_ts = 254.747345
current_received_ts = 254.747299
current_seq = 19126
count = 72
seq_step = 10
(kms_flip:1520) DEBUG: vblank ts/seq: last 254.664200/19116, current 254.747345/19126: elapsed=83151.0us expected=82961.9us +- 414.8us, error 0.2%
(kms_flip:1520) DEBUG: name = vblank
last_ts = 254.747345
last_received_ts = 254.747299
last_seq = 19126
current_ts = 254.830490
current_received_ts = 254.830429
current_seq = 19136
count = 73
seq_step = 10
(kms_flip:1520) DEBUG: vblank ts/seq: last 254.747345/19126, current 254.830490/19136: elapsed=83151.0us expected=82961.9us +- 414.8us, error 0.2%
(kms_flip:1520) DEBUG: name = vblank
last_ts = 254.830490
last_received_ts = 254.830429
last_seq = 19136
current_ts = 254.913635
current_received_ts = 254.913574
current_seq = 19146
count = 74
seq_step = 10
(kms_flip:1520) DEBUG: vblank ts/seq: last 254.830490/19136, current 254.913635/19146: elapsed=83144.0us expected=82961.9us +- 414.8us, error 0.2%
(kms_flip:1520) DEBUG: name = vblank
last_ts = 254.913635
last_received_ts = 254.913574
last_seq = 19146
current_ts = 254.996796
current_received_ts = 254.996735
current_seq = 19156
count = 75
seq_step = 10
(kms_flip:1520) DEBUG: vblank ts/seq: last 254.913635/19146, current 254.996796/19156: elapsed=83151.0us expected=82961.9us +- 414.8us, error 0.2%
(kms_flip:1520) DEBUG: name = vblank
last_ts = 254.996796
last_received_ts = 254.996735
last_seq = 19156
current_ts = 255.079956
current_received_ts = 255.079742
current_seq = 19166
count = 76
seq_step = 10
(kms_flip:1520) DEBUG: vblank ts/seq: last 254.996796/19156, current 255.079956/19166: elapsed=83162.0us expected=82961.9us +- 414.8us, error 0.2%
(kms_flip:1520) DEBUG: name = vblank
last_ts = 255.079956
last_received_ts = 255.079742
last_seq = 19166
current_ts = 255.163132
current_received_ts = 255.163071
current_seq = 19176
count = 77
seq_step = 10
(kms_flip:1520) DEBUG: vblank ts/seq: last 255.079956/19166, current 255.163132/19176: elapsed=83172.0us expected=82961.9us +- 414.8us, error 0.3%
(kms_flip:1520) DEBUG: name = vblank
last_ts = 255.163132
last_received_ts = 255.163071
last_seq = 19176
current_ts = 255.246292
current_received_ts = 255.246216
current_seq = 19186
count = 78
seq_step = 10
(kms_flip:1520) DEBUG: vblank ts/seq: last 255.163132/19176, current 255.246292/19186: elapsed=83165.0us expected=82961.9us +- 414.8us, error 0.2%
(kms_flip:1520) DEBUG: name = vblank
last_ts = 255.246292
last_received_ts = 255.246216
last_seq = 19186
current_ts = 255.329468
current_received_ts = 255.329407
current_seq = 19196
count = 79
seq_step = 10
(kms_flip:1520) DEBUG: vblank ts/seq: last 255.246292/19186, current 255.329468/19196: elapsed=83171.0us expected=82961.9us +- 414.8us, error 0.3%
(kms_flip:1520) DEBUG: name = vblank
last_ts = 255.329468
last_received_ts = 255.329407
last_seq = 19196
current_ts = 255.412628
current_received_ts = 255.412476
current_seq = 19206
count = 80
seq_step = 10
(kms_flip:1520) DEBUG: vblank ts/seq: last 255.329468/19196, current 255.412628/19206: elapsed=83173.0us expected=82961.9us +- 414.8us, error 0.3%
(kms_flip:1520) DEBUG: name = vblank
last_ts = 255.412628
last_received_ts = 255.412476
last_seq = 19206
current_ts = 255.495804
current_received_ts = 255.495743
current_seq = 19216
count = 81
seq_step = 10
(kms_flip:1520) DEBUG: vblank ts/seq: last 255.412628/19206, current 255.495804/19216: elapsed=83168.0us expected=82961.9us +- 414.8us, error 0.2%
(kms_flip:1520) DEBUG: name = vblank
last_ts = 255.495804
last_received_ts = 255.495743
last_seq = 19216
current_ts = 255.578964
current_received_ts = 255.578873
current_seq = 19226
count = 82
seq_step = 10
(kms_flip:1520) DEBUG: vblank ts/seq: last 255.495804/19216, current 255.578964/19226: elapsed=83164.0us expected=82961.9us +- 414.8us, error 0.2%
(kms_flip:1520) DEBUG: name = vblank
last_ts = 255.578964
last_received_ts = 255.578873
last_seq = 19226
current_ts = 255.662140
current_received_ts = 255.662079
current_seq = 19236
count = 83
seq_step = 10
(kms_flip:1520) DEBUG: vblank ts/seq: last 255.578964/19226, current 255.662140/19236: elapsed=83173.0us expected=82961.9us +- 414.8us, error 0.3%
(kms_flip:1520) DEBUG: name = vblank
last_ts = 255.662140
last_received_ts = 255.662079
last_seq = 19236
current_ts = 255.745300
current_received_ts = 255.745239
current_seq = 19246
count = 84
seq_step = 10
(kms_flip:1520) DEBUG: vblank ts/seq: last 255.662140/19236, current 255.745300/19246: elapsed=83168.0us expected=82961.9us +- 414.8us, error 0.2%
(kms_flip:1520) DEBUG: name = vblank
last_ts = 255.745300
last_received_ts = 255.745239
last_seq = 19246
current_ts = 255.828476
current_received_ts = 255.828415
current_seq = 19256
count = 85
seq_step = 10
(kms_flip:1520) DEBUG: vblank ts/seq: last 255.745300/19246, current 255.828476/19256: elapsed=83169.0us expected=82961.9us +- 414.8us, error 0.2%
(kms_flip:1520) DEBUG: name = vblank
last_ts = 255.828476
last_received_ts = 255.828415
last_seq = 19256
current_ts = 255.911652
current_received_ts = 255.911575
current_seq = 19266
count = 86
seq_step = 10
(kms_flip:1520) DEBUG: vblank ts/seq: last 255.828476/19256, current 255.911652/19266: elapsed=83172.0us expected=82961.9us +- 414.8us, error 0.3%
(kms_flip:1520) DEBUG: name = vblank
last_ts = 255.911652
last_received_ts = 255.911575
last_seq = 19266
current_ts = 255.994812
current_received_ts = 255.994614
current_seq = 19276
count = 87
seq_step = 10
(kms_flip:1520) DEBUG: vblank ts/seq: last 255.911652/19266, current 255.994812/19276: elapsed=83168.0us expected=82961.9us +- 414.8us, error 0.2%
(kms_flip:1520) DEBUG: name = vblank
last_ts = 255.994812
last_received_ts = 255.994614
last_seq = 19276
current_ts = 256.078003
current_received_ts = 256.077728
current_seq = 19286
count = 88
seq_step = 10
(kms_flip:1520) DEBUG: vblank ts/seq: last 255.994812/19276, current 256.078003/19286: elapsed=83174.0us expected=82961.9us +- 414.8us, error 0.3%
(kms_flip:1520) DEBUG: name = vblank
last_ts = 256.078003
last_received_ts = 256.077728
last_seq = 19286
current_ts = 256.161194
current_received_ts = 256.161102
current_seq = 19296
count = 89
seq_step = 10
(kms_flip:1520) DEBUG: vblank ts/seq: last 256.078003/19286, current 256.161194/19296: elapsed=83189.0us expected=82961.9us +- 414.8us, error 0.3%
(kms_flip:1520) DEBUG: name = vblank
last_ts = 256.161194
last_received_ts = 256.161102
last_seq = 19296
current_ts = 256.244354
current_received_ts = 256.244293
current_seq = 19306
count = 90
seq_step = 10
(kms_flip:1520) DEBUG: vblank ts/seq: last 256.161194/19296, current 256.244354/19306: elapsed=83187.0us expected=82961.9us +- 414.8us, error 0.3%
(kms_flip:1520) DEBUG: expected 911, counted 910, encoder type 2
(kms_flip:1520) DEBUG: dropped frames, expected 911, counted 910, encoder type 2
(kms_flip:1520) CRITICAL: Test assertion failure function __run_test_on_crtc_set, file ../tests/kms_flip.c:1674:
(kms_flip:1520) CRITICAL: Failed assertion: !retried && needs_retry_after_link_reset(mon)
(kms_flip:1520) igt_core-INFO: Stack trace:
(kms_flip:1520) igt_core-INFO:   #0 ../lib/igt_core.c:2051 __igt_fail_assert()
(kms_flip:1520) igt_core-INFO:   #1 ../tests/kms_flip.c:791 run_test_on_crtc_set.constprop.0()
(kms_flip:1520) igt_core-INFO:   #2 ../tests/kms_flip.c:1845 run_test()
(kms_flip:1520) igt_core-INFO:   #3 ../tests/kms_flip.c:2078 __igt_unique____real_main2001()
(kms_flip:1520) igt_core-INFO:   #4 ../tests/kms_flip.c:2001 main()
(kms_flip:1520) igt_core-INFO:   #5 [__libc_init_first+0x8a]
(kms_flip:1520) igt_core-INFO:   #6 [__libc_start_main+0x8b]
(kms_flip:1520) igt_core-INFO:   #7 [_start+0x25]
****  END  ****
Dynamic subtest A-HDMI-A1: FAIL (10.891s)
Dmesg
<6> [309.575301] Console: switching to colour dummy device 80x25
<6> [309.575598] [IGT] kms_flip: executing
<7> [309.597786] i915 0000:00:02.0: [drm:i915_gem_open [i915]]
<7> [309.598512] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc]
<7> [309.598785] i915 0000:00:02.0: [drm:i915_gem_open [i915]]
<7> [309.610735] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] [CONNECTOR:323:DP-1]
<7> [309.610749] i915 0000:00:02.0: [drm:intel_dp_detect [i915]] [CONNECTOR:323:DP-1]
<7> [309.610893] i915 0000:00:02.0: [drm:intel_power_well_enable [i915]] enabling TC_cold_off
<7> [309.611034] i915 0000:00:02.0: [drm:intel_power_well_enable [i915]] TC cold block succeeded
<7> [309.611275] i915 0000:00:02.0: [drm:intel_power_well_disable [i915]] disabling TC_cold_off
<7> [309.611410] i915 0000:00:02.0: [drm:__intel_display_power_put_domain [i915]] TC cold unblock succeeded
<7> [309.611553] i915 0000:00:02.0: [drm:intel_power_well_enable [i915]] enabling TC_cold_off
<7> [309.611705] i915 0000:00:02.0: [drm:intel_power_well_enable [i915]] TC cold block succeeded
<7> [309.612062] i915 0000:00:02.0: [drm:intel_tc_port_update_mode [i915]] Port D/TC#1: TC port mode reset (disconnected -> legacy)
<7> [309.616726] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] [CONNECTOR:323:DP-1] disconnected
<7> [309.617178] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] [CONNECTOR:333:DP-2]
<7> [309.617188] i915 0000:00:02.0: [drm:intel_dp_detect [i915]] [CONNECTOR:333:DP-2]
<7> [309.617553] i915 0000:00:02.0: [drm:intel_tc_port_update_mode [i915]] Port E/TC#2: TC port mode reset (disconnected -> tbt-alt)
<7> [309.617851] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] [CONNECTOR:333:DP-2] disconnected
<7> [309.618447] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] [CONNECTOR:342:DP-3]
<7> [309.618457] i915 0000:00:02.0: [drm:intel_dp_detect [i915]] [CONNECTOR:342:DP-3]
<7> [309.618820] i915 0000:00:02.0: [drm:intel_tc_port_update_mode [i915]] Port F/TC#3: TC port mode reset (disconnected -> tbt-alt)
<7> [309.619088] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] [CONNECTOR:342:DP-3] disconnected
<7> [309.619679] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] [CONNECTOR:351:DP-4]
<7> [309.619689] i915 0000:00:02.0: [drm:intel_dp_detect [i915]] [CONNECTOR:351:DP-4]
<7> [309.620144] i915 0000:00:02.0: [drm:intel_tc_port_update_mode [i915]] Port G/TC#4: TC port mode reset (disconnected -> tbt-alt)
<7> [309.620491] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] [CONNECTOR:351:DP-4] disconnected
<7> [309.621239] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] [CONNECTOR:313:HDMI-A-1]
<7> [309.621256] i915 0000:00:02.0: [drm:intel_hdmi_detect [i915]] [CONNECTOR:313:HDMI-A-1]
<7> [309.648454] 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> [309.648465] 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> [309.648468] 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> [309.648470] 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> [309.648473] 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> [309.648476] i915 0000:00:02.0: [drm:update_display_info.part.0] [CONNECTOR:313:HDMI-A-1] ELD monitor fitHeadlessGS
<7> [309.648478] 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> [309.648481] i915 0000:00:02.0: [drm:update_display_info.part.0] [CONNECTOR:313:HDMI-A-1] ELD size 64, SAD count 10
<7> [309.649161] i915 0000:00:02.0: [drm:do_gmbus_xfer [i915]] GMBUS [i915 gmbus dpb] NAK for addr: 0040 w(1)
<7> [309.649348] i915 0000:00:02.0: [drm:do_gmbus_xfer [i915]] GMBUS [i915 gmbus dpb] NAK on first message, retry
<7> [309.650157] i915 0000:00:02.0: [drm:do_gmbus_xfer [i915]] GMBUS [i915 gmbus dpb] NAK for addr: 0040 w(1)
<7> [309.650298] i915 0000:00:02.0: [drm:drm_dp_dual_mode_detect [drm_display_helper]] DP dual mode HDMI ID: (err -6)
<7> [309.650945] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] [CONNECTOR:313:HDMI-A-1] probed modes:
<7> [309.650957] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] Probed mode: "1920x1080": 120 285500 1920 1968 2000 2080 1080 1083 1088 1144 0x48 0x5
<7> [309.650967] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] Probed mode: "4096x2160": 60 594000 4096 4184 4272 4400 2160 2168 2178 2250 0x40 0x5
<7> [309.650976] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] Probed mode: "4096x2160": 60 593407 4096 4184 4272 4400 2160 2168 2178 2250 0x40 0x5
<7> [309.650984] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] Probed mode: "4096x2160": 30 297000 4096 4184 4272 4400 2160 2168 2178 2250 0x40 0x5
<7> [309.650992] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] Probed mode: "4096x2160": 30 296703 4096 4184 4272 4400 2160 2168 2178 2250 0x40 0x5
<7> [309.651001] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] Probed mode: "3840x2160": 60 594000 3840 4016 4104 4400 2160 2168 2178 2250 0x40 0x5
<7> [309.651009] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] Probed mode: "3840x2160": 60 593407 3840 4016 4104 4400 2160 2168 2178 2250 0x40 0x5
<7> [309.651017] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] Probed mode: "3840x2160": 30 297000 3840 4016 4104 4400 2160 2168 2178 2250 0x40 0x5
<7> [309.651025] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] Probed mode: "3840x2160": 30 296703 3840 4016 4104 4400 2160 2168 2178 2250 0x40 0x5
<7> [309.651033] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] Probed mode: "3840x2160": 25 297000 3840 4896 4984 5280 2160 2168 2178 2250 0x40 0x5
<7> [309.651041] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] Probed mode: "3840x2160": 24 297000 3840 5116 5204 5500 2160 2168 2178 2250 0x40 0x5
<7> [309.651048] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] Probed mode: "3840x2160": 24 296703 3840 5116 5204 5500 2160 2168 2178 2250 0x40 0x5
<7> [309.651056] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] Probed mode: "3440x1440": 90 476140 3440 3448 3480 3520 1440 1441 1449 1503 0x40 0xa
<7> [309.651064] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] Probed mode: "2560x1600": 75 443250 2560 2768 3048 3536 1600 1603 1609 1672 0x40 0x6
<7> [309.651072] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] Probed mode: "2560x1600": 60 348500 2560 2752 3032 3504 1600 1603 1609 1658 0x40 0x6
<7> [309.651080] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] Probed mode: "2560x1440": 120 497770 2560 2608 2640 2720 1440 1443 1448 1525 0x40 0xa
<7> [309.651087] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] Probed mode: "2048x1536": 60 267027 2048 2200 2424 2800 1536 1537 1540 1589 0x0 0x6
<7> [309.651097] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] Probed mode: "2560x1080": 120 495000 2560 3108 3152 3300 1080 1084 1089 1250 0x40 0x5
<7> [309.651111] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] Probed mode: "2560x1080": 120 494505 2560 3108 3152 3300 1080 1084 1089 1250 0x40 0x5
<7> [309.651124] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] Probed mode: "1920x1440": 75 297000 1920 2064 2288 2640 1440 1441 1444 1500 0x40 0x6
<7> [309.651132] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] Probed mode: "1920x1440": 60 234000 1920 2048 2256 2600 1440 1441 1444 1500 0x40 0x6
<7> [309.651139] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] Probed mode: "2160x1200": 90 261420 2160 2208 2240 2320 1200 1203 1208 1252 0x40 0xa
<7> [309.651146] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] Probed mode: "1856x1392": 75 288000 1856 1984 2208 2560 1392 1393 1396 1500 0x40 0x6
<7> [309.651154] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] Probed mode: "1856x1392": 60 218250 1856 1952 2176 2528 1392 1393 1396 1439 0x40 0x6
<7> [309.651161] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] Probed mode: "1792x1344": 75 261000 1792 1888 2104 2456 1344 1345 1348 1417 0x40 0x6
<7> [309.651169] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] Probed mode: "1792x1344": 60 204750 1792 1920 2120 2448 1344 1345 1348 1394 0x40 0x6
<7> [309.651177] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] Probed mode: "2048x1152": 60 162000 2048 2074 2154 2250 1152 1153 1156 1200 0x40 0x5
<7> [309.651184] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] Probed mode: "1920x1200": 120 317250 1920 1968 2000 2080 1200 1203 1209 1271 0x40 0xa
<7> [309.651191] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] Probed mode: "1920x1200": 75 245250 1920 2056 2264 2608 1200 1203 1209 1255 0x40 0x6
<7> [309.651199] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] Probed mode: "1920x1200": 60 193250 1920 2056 2256 2592 1200 1203 1209 1245 0x40 0x6
<7> [309.651207] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] Probed mode: "1920x1080": 120 297000 1920 2008 2052 2200 1080 1084 1089 1125 0x40 0x5
<7> [309.651214] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] Probed mode: "1920x1080": 120 296703 1920 2008 2052 2200 1080 1084 1089 1125 0x40 0x5
<7> [309.651222] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] Probed mode: "1920x1080": 75 220597 1920 2056 2264 2608 1080 1081 1084 1128 0x0 0x6
<7> [309.651229] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] Probed mode: "1920x1080": 60 148500 1920 2008 2052 2200 1080 1084 1089 1125 0x40 0x5
<7> [309.651237] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] Probed mode: "1920x1080": 60 148352 1920 2008 2052 2200 1080 1084 1089 1125 0x40 0x5
<7> [309.651244] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] Probed mode: "1600x1200": 75 202500 1600 1664 1856 2160 1200 1201 1204 1250 0x40 0x5
<7> [309.651252] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] Probed mode: "1600x1200": 70 189000 1600 1664 1856 2160 1200 1201 1204 1250 0x40 0x5
<7> [309.651259] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] Probed mode: "1600x1200": 65 175500 1600 1664 1856 2160 1200 1201 1204 1250 0x40 0x5
<7> [309.651267] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] Probed mode: "1600x1200": 60 162000 1600 1664 1856 2160 1200 1201 1204 1250 0x40 0x5
<7> [309.651275] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] Probed mode: "1680x1050": 75 187000 1680 1800 1976 2272 1050 1053 1059 1099 0x40 0x6
<7> [309.651282] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] Probed mode: "1680x1050": 60 146250 1680 1784 1960 2240 1050 1053 1059 1089 0x40 0x6
<7> [309.651290] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] Probed mode: "1680x945": 60 131481 1680 1784 1960 2240 945 946 949 978 0x0 0x6
<7> [309.651298] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] Probed mode: "1400x1050": 75 156000 1400 1504 1648 1896 1050 1053 1057 1099 0x40 0x6
<7> [309.651305] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] Probed mode: "1400x1050": 60 121750 1400 1488 1632 1864 1050 1053 1057 1089 0x40 0x6
<7> [309.651313] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] Probed mode: "1600x900": 60 108000 1600 1624 1704 1800 900 901 904 1000 0x40 0x5
<7> [309.651321] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] Probed mode: "1280x1024": 75 135000 1280 1296 1440 1688 1024 1025 1028 1066 0x40 0x5
<7> [309.651328] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] Probed mode: "1280x1024": 60 108000 1280 1328 1440 1688 1024 1025 1028 1066 0x40 0x5
<7> [309.651335] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] Probed mode: "1440x900": 75 136750 1440 1536 1688 1936 900 903 909 942 0x40 0x6
<7> [309.651343] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] Probed mode: "1440x900": 60 106500 1440 1520 1672 1904 900 903 909 934 0x40 0x6
<7> [309.651350] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] Probed mode: "1280x960": 60 108000 1280 1376 1488 1800 960 961 964 1000 0x40 0x5
<7> [309.651357] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] Probed mode: "1360x768": 60 84963 1366 1431 1567 1776 768 771 781 798 0x0 0x6
<7> [309.651365] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] Probed mode: "1360x768": 60 85500 1360 1424 1536 1792 768 771 777 795 0x40 0x5
<7> [309.651372] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] Probed mode: "1280x800": 75 106500 1280 1360 1488 1696 800 803 809 838 0x40 0x6
<7> [309.651380] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] Probed mode: "1280x800": 60 83500 1280 1352 1480 1680 800 803 809 831 0x40 0x6
<7> [309.651387] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] Probed mode: "1152x864": 75 108000 1152 1216 1344 1600 864 865 868 900 0x40 0x5
<7> [309.651395] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] Probed mode: "1280x768": 75 102250 1280 1360 1488 1696 768 771 778 805 0x40 0x6
<7> [309.651402] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] Probed mode: "1280x768": 60 79500 1280 1344 1472 1664 768 771 778 798 0x40 0x6
<7> [309.651409] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] Probed mode: "1280x720": 60 74250 1280 1390 1430 1650 720 725 730 750 0x40 0x5
<7> [309.651417] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] Probed mode: "1024x768": 75 78750 1024 1040 1136 1312 768 769 772 800 0x40 0x5
<7> [309.651424] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] Probed mode: "1024x768": 70 75000 1024 1048 1184 1328 768 771 777 806 0x40 0xa
<7> [309.651431] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] Probed mode: "1024x768": 60 65000 1024 1048 1184 1344 768 771 777 806 0x40 0xa
<7> [309.651439] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] Probed mode: "1024x576": 60 46970 1024 1064 1168 1312 576 577 580 597 0x0 0x6
<7> [309.651446] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] Probed mode: "832x624": 75 57284 832 864 928 1152 624 625 628 667 0x40 0xa
<7> [309.651454] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] Probed mode: "800x600": 75 49500 800 816 896 1056 600 601 604 625 0x40 0x5
<7> [309.651461] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] Probed mode: "800x600": 72 50000 800 856 976 1040 600 637 643 666 0x40 0x5
<7> [309.651469] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] Probed mode: "800x600": 60 40000 800 840 968 1056 600 601 605 628 0x40 0x5
<7> [309.651476] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] Probed mode: "800x600": 56 36000 800 824 896 1024 600 601 603 625 0x40 0x5
<7> [309.651483] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] Probed mode: "848x480": 60 33750 848 864 976 1088 480 486 494 517 0x40 0x5
<7> [309.651491] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] Probed mode: "640x480": 75 31500 640 656 720 840 480 481 484 500 0x40 0xa
<7> [309.651498] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] Probed mode: "640x480": 73 31500 640 664 704 832 480 489 492 520 0x40 0xa
<7> [309.651506] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] Probed mode: "640x480": 60 25200 640 656 752 800 480 490 492 525 0x40 0xa
<7> [309.651513] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] Probed mode: "640x480": 60 25175 640 656 752 800 480 490 492 525 0x40 0xa
<7> [309.651520] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] Probed mode: "720x400": 70 28320 720 738 846 900 400 412 414 449 0x40 0x6
<7> [309.651569] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] [CONNECTOR:323:DP-1]
<7> [309.651578] i915 0000:00:02.0: [drm:intel_dp_detect [i915]] [CONNECTOR:323:DP-1]
<7> [309.656838] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] [CONNECTOR:323:DP-1] disconnected
<7> [309.656872] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] [CONNECTOR:333:DP-2]
<7> [309.656880] i915 0000:00:02.0: [drm:intel_dp_detect [i915]] [CONNECTOR:333:DP-2]
<7> [309.657334] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] [CONNECTOR:333:DP-2] disconnected
<7> [309.657353] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] [CONNECTOR:342:DP-3]
<7> [309.657361] i915 0000:00:02.0: [drm:intel_dp_detect [i915]] [CONNECTOR:342:DP-3]
<7> [309.657900] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] [CONNECTOR:342:DP-3] disconnected
<7> [309.657939] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] [CONNECTOR:351:DP-4]
<7> [309.657947] i915 0000:00:02.0: [drm:intel_dp_detect [i915]] [CONNECTOR:351:DP-4]
<7> [309.658505] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] [CONNECTOR:351:DP-4] disconnected
<6> [309.659045] [IGT] kms_flip: starting subtest blocking-wf_vblank
<6> [309.662256] [IGT] kms_flip: starting dynamic subtest A-HDMI-A1
<7> [309.663222] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:361]
<7> [309.663264] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:363]
<7> [309.702529] i915 0000:00:02.0: [drm:drm_mode_setcrtc] [CRTC:100:pipe A]
<7> [309.702640] 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> [309.702847] 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> [309.703052] 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> [309.703234] 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> [309.703431] 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> [309.703654] 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> [309.703953] 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> [309.704199] 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> [309.704418] 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> [309.704636] 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> [309.704845] 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> [309.705128] 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> [309.705363] 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> [309.705586] 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> [309.705812] 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> [309.706031] 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> [309.706269] 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> [309.706437] 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> [309.706659] 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> [309.706821] 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> [309.706996] 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> [309.707215] 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> [309.707375] 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> [309.707533] 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> [309.707752] 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> [309.707911] 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> [309.708093] 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> [309.708261] 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> [309.708419] 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> [309.708573] 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> [309.708792] 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> [309.708948] 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> [309.709128] 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> [309.709297] 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> [309.709446] 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> [309.709587] 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> [309.709726] 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> [309.709911] 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> [309.710072] 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> [309.710212] 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> [309.710337] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:100:pipe A] fastset requirement not met in avi infoframe
<7> [309.710479] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] expected:
<7> [309.710615] i915 0000:00:02.0: HDMI infoframe: Auxiliary Video Information (AVI), version 2, length 13
<7> [309.710617] i915 0000:00:02.0: colorspace: RGB
<7> [309.710619] i915 0000:00:02.0: scan mode: Underscan
<7> [309.710620] i915 0000:00:02.0: colorimetry: No Data
<7> [309.710622] i915 0000:00:02.0: picture aspect: No Data
<7> [309.710623] i915 0000:00:02.0: active aspect: Same as Picture
<7> [309.710625] i915 0000:00:02.0: itc: No Data
<7> [309.710626] i915 0000:00:02.0: extended colorimetry: xvYCC 601
<7> [309.710628] i915 0000:00:02.0: quantization range: Full
<7> [309.710629] i915 0000:00:02.0: nups: Unknown Non-uniform Scaling
<7> [309.710631] i915 0000:00:02.0: video code: 0
<7> [309.710632] i915 0000:00:02.0: ycc quantization range: Full
<7> [309.710634] i915 0000:00:02.0: hdmi content type: Graphics
<7> [309.710635] i915 0000:00:02.0: pixel repeat: 0
<7> [309.710637] i915 0000:00:02.0: bar top 0, bottom 0, left 0, right 0
<7> [309.710639] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] found:
<7> [309.710771] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:100:pipe A] fastset requirement not met in spd infoframe
<7> [309.710905] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] expected:
<7> [309.711111] i915 0000:00:02.0: HDMI infoframe: Source Product Description (SPD), version 1, length 25
<7> [309.711112] i915 0000:00:02.0: vendor: Intel
<7> [309.711114] i915 0000:00:02.0: product: Integrated gfx
<7> [309.711115] i915 0000:00:02.0: source device information: PC General (0x9)
<7> [309.711117] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] found:
<7> [309.711257] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:100:pipe A] fastset requirement not met in hdmi infoframe
<7> [309.711392] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] expected:
<7> [309.711515] i915 0000:00:02.0: HDMI infoframe: Vendor, version 1, length 4
<7> [309.711517] i915 0000:00:02.0: empty frame
<7> [309.711518] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] found:
<7> [309.711661] i915 0000:00:02.0: [drm:intel_atomic_check [i915]] [CRTC:100:pipe A] fastset requirement not met, forcing full modeset
<7> [309.711796] i915 0000:00:02.0: [drm:intel_unreference_shared_dpll_crtc [i915]] [CRTC:100:pipe A] releasing DPLL 0
<7> [309.711953] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] Enabled dbuf slices 0x3 -> 0x1 (total dbuf slices 0x3), mbus joined? no->no
<7> [309.712093] 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> [309.712315] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] [PLANE:32:plane 1A] ddb ( 0 - 1993) -> ( 0 - 0), size 1993 -> 0
<7> [309.712435] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] [PLANE:95:cursor A] ddb (1993 - 2048) -> ( 0 - 0), size 55 -> 0
<7> [309.712554] 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> [309.712677] 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> [309.712799] 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> [309.712935] 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> [309.713071] i915 0000:00:02.0: [drm:intel_bw_atomic_check [i915]] [CRTC:100:pipe A] data rate 0 num active planes 0
<7> [309.713220] i915 0000:00:02.0: [drm:intel_bw_atomic_check [i915]] QGV point 0: max bw 14993 required 0
<7> [309.713438] i915 0000:00:02.0: [drm:intel_modeset_calc_cdclk [i915]] Modeset required for cdclk change
<7> [309.713578] i915 0000:00:02.0: [drm:intel_modeset_calc_cdclk [i915]] New cdclk calculated to be logical 172800 kHz, actual 172800 kHz
<7> [309.713729] i915 0000:00:02.0: [drm:intel_modeset_calc_cdclk [i915]] New voltage level calculated to be logical 0, actual 0
<7> [309.713885] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [CRTC:100:pipe A] enable: no [modeset]
<7> [309.714031] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:32:plane 1A] fb: [NOFB], visible: no
<7> [309.714188] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:41:plane 2A] fb: [NOFB], visible: no
<7> [309.714360] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:50:plane 3A] fb: [NOFB], visible: no
<7> [309.714528] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:59:plane 4A] fb: [NOFB], visible: no
<7> [309.714665] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:68:plane 5A] fb: [NOFB], visible: no
<7> [309.714813] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:77:plane 6A] fb: [NOFB], visible: no
<7> [309.714960] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:86:plane 7A] fb: [NOFB], visible: no
<7> [309.715107] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:95:cursor A] fb: [NOFB], visible: no
<7> [309.715333] 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> [309.729157] i915 0000:00:02.0: [drm:i915_audio_component_get_eld [i915]] Not valid for port B
<7> [309.738832] 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> [309.739504] i915 0000:00:02.0: [drm:do_gmbus_xfer [i915]] GMBUS [i915 gmbus dpb] NAK for addr: 0054 w(1)
<7> [309.739711] i915 0000:00:02.0: [drm:do_gmbus_xfer [i915]] GMBUS [i915 gmbus dpb] NAK on first message, retry
<7> [309.740569] i915 0000:00:02.0: [drm:do_gmbus_xfer [i915]] GMBUS [i915 gmbus dpb] NAK for addr: 0054 w(1)
<7> [309.740831] 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> [309.740851] 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> [309.741251] i915 0000:00:02.0: [drm:intel_disable_transcoder [i915]] disabling pipe A
<7> [309.746293] i915 0000:00:02.0: [drm:intel_power_well_disable [i915]] disabling DDI_IO_B
<7> [309.746600] i915 0000:00:02.0: [drm:intel_disable_shared_dpll [i915]] disable DPLL 0 (active 0x1, on? 1) for [CRTC:100:pipe A]
<7> [309.746896] i915 0000:00:02.0: [drm:intel_disable_shared_dpll [i915]] disabling DPLL 0
<7> [309.747163] i915 0000:00:02.0: [drm:__intel_fbc_disable [i915]] Disabling FBC on [PLANE:32:plane 1A]
<7> [309.747476] 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> [309.747960] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:312:DDI B/PHY B]
<7> [309.748387] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:322:DDI TC1/PHY TC1]
<7> [309.748628] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:324:DP-MST A]
<7> [309.748891] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:325:DP-MST B]
<7> [309.749163] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:326:DP-MST C]
<7> [309.749611] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:327:DP-MST D]
<7> [309.750020] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:332:DDI TC2/PHY TC2]
<7> [309.750424] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:334:DP-MST A]
<7> [309.751031] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:335:DP-MST B]
<7> [309.751493] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:336:DP-MST C]
<7> [309.751800] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:337:DP-MST D]
<7> [309.752087] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:341:DDI TC3/PHY TC3]
<7> [309.752333] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:343:DP-MST A]
<7> [309.752533] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:344:DP-MST B]
<7> [309.752729] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:345:DP-MST C]
<7> [309.752995] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:346:DP-MST D]
<7> [309.753304] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:350:DDI TC4/PHY TC4]
<7> [309.753588] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:352:DP-MST A]
<7> [309.753786] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:353:DP-MST B]
<7> [309.753983] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:354:DP-MST C]
<7> [309.754181] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:355:DP-MST D]
<7> [309.754452] i915 0000:00:02.0: [drm:verify_connector_state [i915]] [CONNECTOR:313:HDMI-A-1]
<7> [309.754988] i915 0000:00:02.0: [drm:gen9_dbuf_slices_update [i915]] Updating dbuf slices to 0x1
<7> [309.755200] i915 0000:00:02.0: [drm:intel_power_well_disable [i915]] disabling PW_3
<7> [309.755398] i915 0000:00:02.0: [drm:intel_power_well_disable [i915]] disabling PW_2
<7> [309.755571] i915 0000:00:02.0: [drm:intel_modeset_verify_crtc [i915]] [CRTC:100:pipe A]
<7> [309.756286] i915 0000:00:02.0: [drm:drm_mode_setcrtc] [CRTC:170:pipe B]
<7> [309.756440] i915 0000:00:02.0: [drm:drm_mode_setcrtc] [CRTC:240:pipe C]
<7> [309.756565] i915 0000:00:02.0: [drm:drm_mode_setcrtc] [CRTC:310:pipe D]
<7> [309.756697] i915 0000:00:02.0: [drm:drm_mode_setcrtc] [CRTC:100:pipe A]
<7> [309.756732] i915 0000:00:02.0: [drm:drm_mode_setcrtc] [CONNECTOR:313:HDMI-A-1]
<7> [309.756775] 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> [309.756997] i915 0000:00:02.0: [drm:intel_hdmi_compute_clock [i915]] picking 8 bpc for HDMI output (pipe bpp: 24)
<7> [309.757226] i915 0000:00:02.0: [drm:intel_atomic_check [i915]] [CRTC:100:pipe A] hw max bpp: 24, pipe bpp: 24, dithering: 0
<7> [309.757481] i915 0000:00:02.0: [drm:intel_ddi_compute_config_late [i915]] [ENCODER:312:DDI B/PHY B] [CRTC:100:pipe A]
<7> [309.757654] 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> [309.757811] 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> [309.757951] 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> [309.758090] 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> [309.758230] 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> [309.758445] 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> [309.758658] 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> [309.758856] 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> [309.758997] 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> [309.759134] 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> [309.759280] 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> [309.759418] 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> [309.759586] 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> [309.759797] 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> [309.760013] 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> [309.760157] 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> [309.760313] 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> [309.760452] 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> [309.760588] 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> [309.760766] 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> [309.760977] 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> [309.761179] 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> [309.761357] 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> [309.761494] 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> [309.761628] 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> [309.761764] 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> [309.761898] 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> [309.762079] 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> [309.762295] 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> [309.762495] 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> [309.762635] 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> [309.762772] 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> [309.762906] 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> [309.763040] 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> [309.763223] 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> [309.763459] 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> [309.763622] i915 0000:00:02.0: [drm:intel_power_well_enable [i915]] enabling PW_2
<7> [309.763665] 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> [309.763800] i915 0000:00:02.0: [drm:intel_power_well_enable [i915]] enabling PW_3
<7> [309.763829] 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> [309.763961] i915 0000:00:02.0: [drm:i915_audio_component_get_power [i915]] restored AUD_FREQ_CNTRL to 0x810
<7> [309.763970] 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> [309.764108] 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> [309.764245] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:100:pipe A] fastset requirement not met in avi infoframe
<7> [309.764414] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] expected:
<7> [309.764618] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] found:
<7> [309.764853] i915 0000:00:02.0: HDMI infoframe: Auxiliary Video Information (AVI), version 2, length 13
<7> [309.764856] i915 0000:00:02.0: colorspace: RGB
<7> [309.764859] i915 0000:00:02.0: scan mode: Underscan
<7> [309.764862] i915 0000:00:02.0: colorimetry: No Data
<7> [309.764864] i915 0000:00:02.0: picture aspect: No Data
<7> [309.764867] i915 0000:00:02.0: active aspect: Same as Picture
<7> [309.764870] i915 0000:00:02.0: itc: No Data
<7> [309.764872] i915 0000:00:02.0: extended colorimetry: xvYCC 601
<7> [309.764875] i915 0000:00:02.0: quantization range: Full
<7> [309.764877] i915 0000:00:02.0: nups: Unknown Non-uniform Scaling
<7> [309.764880] i915 0000:00:02.0: video code: 0
<7> [309.764882] i915 0000:00:02.0: ycc quantization range: Full
<7> [309.764885] i915 0000:00:02.0: hdmi content type: Graphics
<7> [309.764887] i915 0000:00:02.0: pixel repeat: 0
<7> [309.764890] i915 0000:00:02.0: bar top 0, bottom 0, left 0, right 0
<7> [309.764893] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:100:pipe A] fastset requirement not met in spd infoframe
<7> [309.765070] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] expected:
<7> [309.765204] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] found:
<7> [309.765354] i915 0000:00:02.0: HDMI infoframe: Source Product Description (SPD), version 1, length 25
<7> [309.765355] i915 0000:00:02.0: vendor: Intel
<7> [309.765357] i915 0000:00:02.0: product: Integrated gfx
<7> [309.765358] i915 0000:00:02.0: source device information: PC General (0x9)
<7> [309.765360] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:100:pipe A] fastset requirement not met in hdmi infoframe
<7> [309.765495] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] expected:
<7> [309.765629] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] found:
<7> [309.765792] i915 0000:00:02.0: HDMI infoframe: Vendor, version 1, length 4
<7> [309.765795] i915 0000:00:02.0: empty frame
<7> [309.765798] i915 0000:00:02.0: [drm:intel_atomic_check [i915]] [CRTC:100:pipe A] fastset requirement not met, forcing full modeset
<7> [309.766044] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] Enabled dbuf slices 0x1 -> 0x3 (total dbuf slices 0x3), mbus joined? no->no
<7> [309.766240] 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> [309.766507] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] [PLANE:32:plane 1A] ddb ( 0 - 0) -> ( 0 - 1993), size 0 -> 1993
<7> [309.766643] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] [PLANE:95:cursor A] ddb ( 0 - 0) -> (1993 - 2048), size 0 -> 55
<7> [309.766773] 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> [309.766900] 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> [309.767027] 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> [309.767152] 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> [309.767280] i915 0000:00:02.0: [drm:intel_bw_atomic_check [i915]] [CRTC:100:pipe A] data rate 1142000 num active planes 1
<7> [309.767513] i915 0000:00:02.0: [drm:intel_bw_atomic_check [i915]] QGV point 0: max bw 14993 required 1142
<7> [309.767727] i915 0000:00:02.0: [drm:intel_bw_atomic_check [i915]] No SAGV, using single QGV point mask 0x1
<7> [309.767922] 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> [309.768066] i915 0000:00:02.0: [drm:intel_bw_calc_min_cdclk [i915]] new bandwidth min cdclk (22305 kHz) > old min cdclk (0 kHz)
<7> [309.768229] i915 0000:00:02.0: [drm:intel_modeset_calc_cdclk [i915]] Modeset required for cdclk change
<7> [309.768384] i915 0000:00:02.0: [drm:intel_modeset_calc_cdclk [i915]] New cdclk calculated to be logical 192000 kHz, actual 192000 kHz
<7> [309.768525] i915 0000:00:02.0: [drm:intel_modeset_calc_cdclk [i915]] New voltage level calculated to be logical 0, actual 0
<7> [309.768738] i915 0000:00:02.0: [drm:intel_find_shared_dpll [i915]] [CRTC:100:pipe A] allocated DPLL 0
<7> [309.768944] i915 0000:00:02.0: [drm:intel_reference_shared_dpll_crtc [i915]] [CRTC:100:pipe A] reserving DPLL 0
<7> [309.769147] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [CRTC:100:pipe A] enable: yes [modeset]
<7> [309.769294] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] active: yes, output_types: HDMI (0x40), output format: RGB, sink format: RGB
<7> [309.769454] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] cpu_transcoder: A, pipe bpp: 24, dithering: 0
<7> [309.769590] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] MST master transcoder: <invalid>
<7> [309.769726] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] port sync: master transcoder: <invalid>, slave transcoder bitmask = 0x0
<7> [309.769875] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] joiner: no, pipes: 0x0
<7> [309.770085] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] splitter: disabled, link count 0, overlap 0
<7> [309.770291] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] framestart delay: 1, MSA timing delay: 0
<7> [309.770480] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] audio: 1, infoframes: 1, infoframes enabled: 0x71
<7> [309.770623] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] GCP: 0x0
<7> [309.770763] i915 0000:00:02.0: HDMI infoframe: Auxiliary Video Information (AVI), version 2, length 13
<7> [309.770765] i915 0000:00:02.0: colorspace: RGB
<7> [309.770766] i915 0000:00:02.0: scan mode: Underscan
<7> [309.770767] i915 0000:00:02.0: colorimetry: No Data
<7> [309.770768] i915 0000:00:02.0: picture aspect: No Data
<7> [309.770770] i915 0000:00:02.0: active aspect: Same as Picture
<7> [309.770771] i915 0000:00:02.0: itc: No Data
<7> [309.770772] i915 0000:00:02.0: extended colorimetry: xvYCC 601
<7> [309.770774] i915 0000:00:02.0: quantization range: Full
<7> [309.770775] i915 0000:00:02.0: nups: Unknown Non-uniform Scaling
<7> [309.770776] i915 0000:00:02.0: video code: 0
<7> [309.770778] i915 0000:00:02.0: ycc quantization range: Full
<7> [309.770779] i915 0000:00:02.0: hdmi content type: Graphics
<7> [309.770780] i915 0000:00:02.0: pixel repeat: 0
<7> [309.770781] i915 0000:00:02.0: bar top 0, bottom 0, left 0, right 0
<7> [309.770783] i915 0000:00:02.0: HDMI infoframe: Source Product Description (SPD), version 1, length 25
<7> [309.770785] i915 0000:00:02.0: vendor: Intel
<7> [309.770786] i915 0000:00:02.0: product: Integrated gfx
<7> [309.770787] i915 0000:00:02.0: source device information: PC General (0x9)
<7> [309.770789] i915 0000:00:02.0: HDMI infoframe: Vendor, version 1, length 4
<7> [309.770790] i915 0000:00:02.0: empty frame
<7> [309.770792] ELD: 10 00 0f 00 6d a2 00 7f 00 00 00 00 00 00 00 00
<7> [309.770793] ELD: 0d 82 34 12 66 69 74 48 65 61 64 6c 65 73 73 47
<7> [309.770795] ELD: 53 7f 7f 28 0f 7f 07 17 7f ff 3f 7f ff 47 7f ff
<7> [309.770796] ELD: 5f 7f 82 7f 7f 00 7f 7f 51 7f 7f 30 77 7f 03 00
<7> [309.770797] 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> [309.770935] 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> [309.771100] 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> [309.771323] 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> [309.771537] 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> [309.771743] 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> [309.771917] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] port clock: 285500, pipe src: 1920x1080+0+0, pixel rate 285500
<7> [309.772055] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] linetime: 59, ips linetime: 0
<7> [309.772190] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] num_scalers: 2, scaler_users: 0x0, scaler_id: -1, scaling_filter: 0
<7> [309.772332] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pch pfit: 0x0+0+0, disabled, force thru: no
<7> [309.772467] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] ips: 0, double wide: 0, drrs: 0
<7> [309.772600] 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> [309.772784] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] csc_mode: 0x0 gamma_mode: 0x0 gamma_enable: 0 csc_enable: 0
<7> [309.772994] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pre csc lut: 0 entries, post csc lut: 0 entries
<7> [309.773203] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] output csc: pre offsets: 0x0000 0x0000 0x0000
<7> [309.773358] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] output csc: coefficients: 0x0000 0x0000 0x0000
<7> [309.773498] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] output csc: coefficients: 0x0000 0x0000 0x0000
<7> [309.773635] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] output csc: coefficients: 0x0000 0x0000 0x0000
<7> [309.773773] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] output csc: post offsets: 0x0000 0x0000 0x0000
<7> [309.773959] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pipe csc: pre offsets: 0x0000 0x0000 0x0000
<7> [309.774169] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pipe csc: coefficients: 0x0000 0x0000 0x0000
<7> [309.774382] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pipe csc: coefficients: 0x0000 0x0000 0x0000
<7> [309.774540] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pipe csc: coefficients: 0x0000 0x0000 0x0000
<7> [309.774675] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pipe csc: post offsets: 0x0000 0x0000 0x0000
<7> [309.774833] 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> [309.774972] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] rotation: 0x1, scaler: -1, scaling_filter: 0
<7> [309.775111] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] src: 1920.000000x1080.000000+0.000000+0.000000 dst: 1920x1080+0+0
<7> [309.775291] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:41:plane 2A] fb: [NOFB], visible: no
<7> [309.775526] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:50:plane 3A] fb: [NOFB], visible: no
<7> [309.775733] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:59:plane 4A] fb: [NOFB], visible: no
<7> [309.775869] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:68:plane 5A] fb: [NOFB], visible: no
<7> [309.776004] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:77:plane 6A] fb: [NOFB], visible: no
<7> [309.776139] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:86:plane 7A] fb: [NOFB], visible: no
<7> [309.776273] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:95:cursor A] fb: [NOFB], visible: no
<7> [309.777028] 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> [309.777274] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:312:DDI B/PHY B]
<7> [309.777427] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:322:DDI TC1/PHY TC1]
<7> [309.777566] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:324:DP-MST A]
<7> [309.777772] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:325:DP-MST B]
<7> [309.777976] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:326:DP-MST C]
<7> [309.778148] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:327:DP-MST D]
<7> [309.778280] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:332:DDI TC2/PHY TC2]
<7> [309.778423] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:334:DP-MST A]
<7> [309.778554] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:335:DP-MST B]
<7> [309.778685] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:336:DP-MST C]
<7> [309.778823] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:337:DP-MST D]
<7> [309.779021] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:341:DDI TC3/PHY TC3]
<7> [309.779219] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:343:DP-MST A]
<7> [309.779422] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:344:DP-MST B]
<7> [309.779561] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:345:DP-MST C]
<7> [309.779695] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:346:DP-MST D]
<7> [309.779828] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:350:DDI TC4/PHY TC4]
<7> [309.779959] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:352:DP-MST A]
<7> [309.780096] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:353:DP-MST B]
<7> [309.780301] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:354:DP-MST C]
<7> [309.780515] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:355:DP-MST D]
<7> [309.780785] i915 0000:00:02.0: [drm:gen9_dbuf_slices_update [i915]] Updating dbuf slices to 0x3
<7> [309.780964] i915 0000:00:02.0: [drm:intel_enable_shared_dpll [i915]] enable DPLL 0 (active 0x1, on? 0) for [CRTC:100:pipe A]
<7> [309.781103] i915 0000:00:02.0: [drm:intel_enable_shared_dpll [i915]] enabling DPLL 0
<7> [309.781308] i915 0000:00:02.0: [drm:intel_power_well_enable [i915]] enabling DDI_IO_B
<7> [309.781635] i915 0000:00:02.0: [drm:intel_enable_transcoder [i915]] enabling pipe A
<7> [309.781931] 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> [309.782647] i915 0000:00:02.0: [drm:do_gmbus_xfer [i915]] GMBUS [i915 gmbus dpb] NAK for addr: 0054 w(1)
<7> [309.782836] i915 0000:00:02.0: [drm:do_gmbus_xfer [i915]] GMBUS [i915 gmbus dpb] NAK on first message, retry
<7> [309.783606] i915 0000:00:02.0: [drm:do_gmbus_xfer [i915]] GMBUS [i915 gmbus dpb] NAK for addr: 0054 w(1)
<7> [309.783768] 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> [309.783779] 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> [309.785335] i915 0000:00:02.0: [drm:intel_fbc_update [i915]] reserved 17694720 bytes of contiguous stolen space for FBC, limit: 1
<7> [309.785497] i915 0000:00:02.0: [drm:intel_fbc_update [i915]] Enabling FBC on [PLANE:32:plane 1A]
<7> [309.792467] 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> [309.800839] 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> [309.801002] i915 0000:00:02.0: [drm:audio_config_hdmi_pixel_clock [i915]] Configuring HDMI audio for pixel clock 25200 (0x00010000)
<7> [309.801134] i915 0000:00:02.0: [drm:hsw_hdmi_audio_config_update.isra.0 [i915]] using automatic N
<6> [309.801269] snd_hda_codec_hdmi hdaudioC0D2: HDMI: audio coding xtype 5 not expected
<6> [309.801271] snd_hda_codec_hdmi hdaudioC0D2: HDMI: audio coding xtype 0 not expected
<6> [309.801273] snd_hda_codec_hdmi hdaudioC0D2: HDMI: audio coding xtype 10 not expected
<6> [309.801274] snd_hda_codec_hdmi hdaudioC0D2: HDMI: audio coding xtype 6 not expected
<7> [309.801412] i915 0000:00:02.0: [drm:verify_connector_state [i915]] [CONNECTOR:313:HDMI-A-1]
<7> [309.801678] i915 0000:00:02.0: [drm:intel_modeset_verify_crtc [i915]] [CRTC:100:pipe A]
<7> [309.824096] i915 0000:00:02.0: [drm:i915_audio_component_get_power [i915]] restored AUD_FREQ_CNTRL to 0x810
<7> [310.714604] i915 0000:00:02.0: [drm:intel_tc_port_update_mode [i915]] Port G/TC#4: TC port mode reset (tbt-alt -> disconnected)
<7> [310.714724] i915 0000:00:02.0: [drm:intel_power_well_disable [i915]] disabling TC_cold_off
<7> [310.714694] i915 0000:00:02.0: [drm:intel_tc_port_update_mode [i915]] Port E/TC#2: TC port mode reset (tbt-alt -> disconnected)
<7> [310.714677] i915 0000:00:02.0: [drm:intel_tc_port_update_mode [i915]] Port F/TC#3: TC port mode reset (tbt-alt -> disconnected)
<7> [310.715196] i915 0000:00:02.0: [drm:__intel_display_power_put_domain [i915]] TC cold unblock succeeded
<7> [310.715776] i915 0000:00:02.0: [drm:intel_tc_port_update_mode [i915]] Port D/TC#1: TC port mode reset (legacy -> disconnected)
<6> [320.553190] [IGT] kms_flip: finished subtest A-HDMI-A1, FAIL
Created at 2024-11-14 05:15:56