Results for igt@kms_flip@plain-flip-fb-recreate@a-vga1

Machine description: shard-snb5

Result: Fail

git-log-oneline i915_display_info11 igt_runner11 runtimes11 results11.json results11-i915-load.json i915_display_info_post_exec11 boot11 dmesg11

DetailValue
Duration 4.75 seconds
Hostname 
shard-snb5
Igt-Version 
IGT-Version: 1.30-g866138027 (x86_64) (Linux: 6.14.0-rc6-CI_DRM_16254-g0457c65354c6+ x86_64)
Out 
Using IGT_SRANDOM=1741613178 for randomisation
Opened device: /dev/dri/card0
Using monotonic timestamps
Starting subtest: plain-flip-fb-recreate
Starting dynamic subtest: A-VGA1
  1024x768: 60 65000 1024 1048 1184 1344 768 771 777 806 0x40 0xa 
Expected frametime: 16666us; measured 17194.9us +- 3.924us accuracy 0.07%
vblank interval differs from modeline! expected 16665.6us, measured 17195us +- 3.924us, difference 529.3us (134.9 sigma)
Stack trace:
  #0 ../lib/igt_core.c:2055 __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-VGA1: FAIL (4.749s)
Err 
Starting subtest: plain-flip-fb-recreate
Starting dynamic subtest: A-VGA1
(kms_flip:2656) CRITICAL: Test assertion failure function __run_test_on_crtc_set, file ../tests/kms_flip.c:1674:
(kms_flip:2656) CRITICAL: Failed assertion: !retried && needs_retry_after_link_reset(mon)
Dynamic subtest A-VGA1 failed.
**** DEBUG ****
(kms_flip:2656) igt_fb-DEBUG: igt_create_fb_with_bo_size(width=1024, height=768, format=XR24(0x34325258), modifier=0x0, size=0)
(kms_flip:2656) igt_fb-DEBUG: igt_create_fb_with_bo_size(handle=1, pitch=4096)
(kms_flip:2656) ioctl_wrappers-DEBUG: Test requirement passed: igt_has_fb_modifiers(fd)
(kms_flip:2656) igt_fb-DEBUG: igt_create_fb_with_bo_size(width=1024, height=768, format=XR24(0x34325258), modifier=0x0, size=0)
(kms_flip:2656) igt_fb-DEBUG: igt_create_fb_with_bo_size(handle=2, pitch=4096)
(kms_flip:2656) ioctl_wrappers-DEBUG: Test requirement passed: igt_has_fb_modifiers(fd)
(kms_flip:2656) intel_blt-DEBUG: Test requirement passed: cmds_info
(kms_flip:2656) intel_blt-DEBUG: Test requirement passed: cmds_info
(kms_flip:2656) igt_fb-DEBUG: Test requirement passed: cairo_surface_status(fb->cairo_surface) == CAIRO_STATUS_SUCCESS
(kms_flip:2656) intel_blt-DEBUG: Test requirement passed: cmds_info
(kms_flip:2656) intel_blt-DEBUG: Test requirement passed: cmds_info
(kms_flip:2656) igt_fb-DEBUG: Test requirement passed: cairo_surface_status(fb->cairo_surface) == CAIRO_STATUS_SUCCESS
(kms_flip:2656) igt_kms-INFO:   1024x768: 60 65000 1024 1048 1184 1344 768 771 777 806 0x40 0xa 
(kms_flip:2656) DEBUG: No stale events found
(kms_flip:2656) i915/intel_drrs-DEBUG: Manually disabling DRRS. 0
(kms_flip:2656) i915/intel_drrs-DEBUG: Test requirement passed: dir >= 0
(kms_flip:2656) INFO: Expected frametime: 16666us; measured 17194.9us +- 3.924us accuracy 0.07%
(kms_flip:2656) INFO: vblank interval differs from modeline! expected 16665.6us, measured 17195us +- 3.924us, difference 529.3us (134.9 sigma)
(kms_flip:2656) DEBUG: name = flip
last_ts = 0.000000
last_received_ts = 0.000000
last_seq = 0
current_ts = 171.218155
current_received_ts = 171.217606
current_seq = 5706
count = 0
seq_step = 1
(kms_flip:2656) DEBUG: name = flip
last_ts = 171.218155
last_received_ts = 171.217606
last_seq = 5706
current_ts = 171.235336
current_received_ts = 171.234802
current_seq = 5707
count = 1
seq_step = 1
(kms_flip:2656) DEBUG: flip ts/seq: last 171.218155/5706, current 171.235336/5707: elapsed=17185.0us expected=17194.9us +- 86.0us, error 0.1%
(kms_flip:2656) DEBUG: name = flip
last_ts = 171.235336
last_received_ts = 171.234802
last_seq = 5707
current_ts = 171.252533
current_received_ts = 171.251953
current_seq = 5708
count = 2
seq_step = 1
(kms_flip:2656) DEBUG: flip ts/seq: last 171.235336/5707, current 171.252533/5708: elapsed=17186.0us expected=17194.9us +- 86.0us, error 0.1%
(kms_flip:2656) DEBUG: name = flip
last_ts = 171.252533
last_received_ts = 171.251953
last_seq = 5708
current_ts = 171.269730
current_received_ts = 171.269165
current_seq = 5709
count = 3
seq_step = 1
(kms_flip:2656) DEBUG: flip ts/seq: last 171.252533/5708, current 171.269730/5709: elapsed=17201.0us expected=17194.9us +- 86.0us, error 0.0%
(kms_flip:2656) DEBUG: name = flip
last_ts = 171.269730
last_received_ts = 171.269165
last_seq = 5709
current_ts = 171.286926
current_received_ts = 171.286316
current_seq = 5710
count = 4
seq_step = 1
(kms_flip:2656) DEBUG: flip ts/seq: last 171.269730/5709, current 171.286926/5710: elapsed=17203.0us expected=17194.9us +- 86.0us, error 0.0%
(kms_flip:2656) DEBUG: name = flip
last_ts = 171.286926
last_received_ts = 171.286316
last_seq = 5710
current_ts = 171.304108
current_received_ts = 171.303574
current_seq = 5711
count = 5
seq_step = 1
(kms_flip:2656) DEBUG: flip ts/seq: last 171.286926/5710, current 171.304108/5711: elapsed=17182.0us expected=17194.9us +- 86.0us, error 0.1%
(kms_flip:2656) DEBUG: name = flip
last_ts = 171.304108
last_received_ts = 171.303574
last_seq = 5711
current_ts = 171.321320
current_received_ts = 171.320786
current_seq = 5712
count = 6
seq_step = 1
(kms_flip:2656) DEBUG: flip ts/seq: last 171.304108/5711, current 171.321320/5712: elapsed=17200.0us expected=17194.9us +- 86.0us, error 0.0%
(kms_flip:2656) DEBUG: name = flip
last_ts = 171.321320
last_received_ts = 171.320786
last_seq = 5712
current_ts = 171.338501
current_received_ts = 171.337952
current_seq = 5713
count = 7
seq_step = 1
(kms_flip:2656) DEBUG: flip ts/seq: last 171.321320/5712, current 171.338501/5713: elapsed=17184.0us expected=17194.9us +- 86.0us, error 0.1%
(kms_flip:2656) DEBUG: name = flip
last_ts = 171.338501
last_received_ts = 171.337952
last_seq = 5713
current_ts = 171.355698
current_received_ts = 171.355148
current_seq = 5714
count = 8
seq_step = 1
(kms_flip:2656) DEBUG: flip ts/seq: last 171.338501/5713, current 171.355698/5714: elapsed=17198.0us expected=17194.9us +- 86.0us, error 0.0%
(kms_flip:2656) DEBUG: name = flip
last_ts = 171.355698
last_received_ts = 171.355148
last_seq = 5714
current_ts = 171.372894
current_received_ts = 171.372284
current_seq = 5715
count = 9
seq_step = 1
(kms_flip:2656) DEBUG: flip ts/seq: last 171.355698/5714, current 171.372894/5715: elapsed=17204.0us expected=17194.9us +- 86.0us, error 0.1%
(kms_flip:2656) DEBUG: name = flip
last_ts = 171.372894
last_received_ts = 171.372284
last_seq = 5715
current_ts = 171.390091
current_received_ts = 171.389496
current_seq = 5716
count = 10
seq_step = 1
(kms_flip:2656) DEBUG: flip ts/seq: last 171.372894/5715, current 171.390091/5716: elapsed=17190.0us expected=17194.9us +- 86.0us, error 0.0%
(kms_flip:2656) DEBUG: name = flip
last_ts = 171.390091
last_received_ts = 171.389496
last_seq = 5716
current_ts = 171.407288
current_received_ts = 171.406738
current_seq = 5717
count = 11
seq_step = 1
(kms_flip:2656) DEBUG: flip ts/seq: last 171.390091/5716, current 171.407288/5717: elapsed=17192.0us expected=17194.9us +- 86.0us, error 0.0%
(kms_flip:2656) DEBUG: name = flip
last_ts = 171.407288
last_received_ts = 171.406738
last_seq = 5717
current_ts = 171.424469
current_received_ts = 171.423920
current_seq = 5718
count = 12
seq_step = 1
(kms_flip:2656) DEBUG: flip ts/seq: last 171.407288/5717, current 171.424469/5718: elapsed=17192.0us expected=17194.9us +- 86.0us, error 0.0%
(kms_flip:2656) DEBUG: name = flip
last_ts = 171.424469
last_received_ts = 171.423920
last_seq = 5718
current_ts = 171.441681
current_received_ts = 171.441116
current_seq = 5719
count = 13
seq_step = 1
(kms_flip:2656) DEBUG: flip ts/seq: last 171.424469/5718, current 171.441681/5719: elapsed=17200.0us expected=17194.9us +- 86.0us, error 0.0%
(kms_flip:2656) DEBUG: name = flip
last_ts = 171.441681
last_received_ts = 171.441116
last_seq = 5719
current_ts = 171.458862
current_received_ts = 171.458252
current_seq = 5720
count = 14
seq_step = 1
(kms_flip:2656) DEBUG: flip ts/seq: last 171.441681/5719, current 171.458862/5720: elapsed=17192.0us expected=17194.9us +- 86.0us, error 0.0%
(kms_flip:2656) DEBUG: name = flip
last_ts = 171.458862
last_received_ts = 171.458252
last_seq = 5720
current_ts = 171.476059
current_received_ts = 171.475525
current_seq = 5721
count = 15
seq_step = 1
(kms_flip:2656) DEBUG: flip ts/seq: last 171.458862/5720, current 171.476059/5721: elapsed=17193.0us expected=17194.9us +- 86.0us, error 0.0%
(kms_flip:2656) DEBUG: name = flip
last_ts = 171.476059
last_received_ts = 171.475525
last_seq = 5721
current_ts = 171.493256
current_received_ts = 171.492691
current_seq = 5722
count = 16
seq_step = 1
(kms_flip:2656) DEBUG: flip ts/seq: last 171.476059/5721, current 171.493256/5722: elapsed=17189.0us expected=17194.9us +- 86.0us, error 0.0%
(kms_flip:2656) DEBUG: name = flip
last_ts = 171.493256
last_received_ts = 171.492691
last_seq = 5722
current_ts = 171.510391
current_received_ts = 171.509766
current_seq = 5723
count = 17
seq_step = 1
(kms_flip:2656) DEBUG: flip ts/seq: last 171.493256/5722, current 171.510391/5723: elapsed=17143.0us expected=17194.9us +- 86.0us, error 0.3%
(kms_flip:2656) DEBUG: name = flip
last_ts = 171.510391
last_received_ts = 171.509766
last_seq = 5723
current_ts = 171.527512
current_received_ts = 171.526962
current_seq = 5724
count = 18
seq_step = 1
(kms_flip:2656) DEBUG: flip ts/seq: last 171.510391/5723, current 171.527512/5724: elapsed=17126.0us expected=17194.9us +- 86.0us, error 0.4%
(kms_flip:2656) DEBUG: name = flip
last_ts = 171.527512
last_received_ts = 171.526962
last_seq = 5724
current_ts = 171.544647
current_received_ts = 171.544113
current_seq = 5725
count = 19
seq_step = 1
(kms_flip:2656) DEBUG: flip ts/seq: last 171.527512/5724, current 171.544647/5725: elapsed=17134.0us expected=17194.9us +- 86.0us, error 0.4%
(kms_flip:2656) DEBUG: name = flip
last_ts = 171.544647
last_received_ts = 171.544113
last_seq = 5725
current_ts = 171.561798
current_received_ts = 171.561203
current_seq = 5726
count = 20
seq_step = 1
(kms_flip:2656) DEBUG: flip ts/seq: last 171.544647/5725, current 171.561798/5726: elapsed=17147.0us expected=17194.9us +- 86.0us, error 0.3%
(kms_flip:2656) DEBUG: name = flip
last_ts = 171.561798
last_received_ts = 171.561203
last_seq = 5726
current_ts = 171.578934
current_received_ts = 171.578384
current_seq = 5727
count = 21
seq_step = 1
(kms_flip:2656) DEBUG: flip ts/seq: last 171.561798/5726, current 171.578934/5727: elapsed=17131.0us expected=17194.9us +- 86.0us, error 0.4%
(kms_flip:2656) DEBUG: name = flip
last_ts = 171.578934
last_received_ts = 171.578384
last_seq = 5727
current_ts = 171.596069
current_received_ts = 171.595505
current_seq = 5728
count = 22
seq_step = 1
(kms_flip:2656) DEBUG: flip ts/seq: last 171.578934/5727, current 171.596069/5728: elapsed=17141.0us expected=17194.9us +- 86.0us, error 0.3%
(kms_flip:2656) DEBUG: name = flip
last_ts = 171.596069
last_received_ts = 171.595505
last_seq = 5728
current_ts = 171.613190
current_received_ts = 171.612625
current_seq = 5729
count = 23
seq_step = 1
(kms_flip:2656) DEBUG: flip ts/seq: last 171.596069/5728, current 171.613190/5729: elapsed=17123.0us expected=17194.9us +- 86.0us, error 0.4%
(kms_flip:2656) DEBUG: name = flip
last_ts = 171.613190
last_received_ts = 171.612625
last_seq = 5729
current_ts = 171.630325
current_received_ts = 171.629761
current_seq = 5730
count = 24
seq_step = 1
(kms_flip:2656) DEBUG: flip ts/seq: last 171.613190/5729, current 171.630325/5730: elapsed=17131.0us expected=17194.9us +- 86.0us, error 0.4%
(kms_flip:2656) DEBUG: name = flip
last_ts = 171.630325
last_received_ts = 171.629761
last_seq = 5730
current_ts = 171.647461
current_received_ts = 171.646912
current_seq = 5731
count = 25
seq_step = 1
(kms_flip:2656) DEBUG: flip ts/seq: last 171.630325/5730, current 171.647461/5731: elapsed=17140.0us expected=17194.9us +- 86.0us, error 0.3%
(kms_flip:2656) DEBUG: name = flip
last_ts = 171.647461
last_received_ts = 171.646912
last_seq = 5731
current_ts = 171.664597
current_received_ts = 171.664078
current_seq = 5732
count = 26
seq_step = 1
(kms_flip:2656) DEBUG: flip ts/seq: last 171.647461/5731, current 171.664597/5732: elapsed=17137.0us expected=17194.9us +- 86.0us, error 0.3%
(kms_flip:2656) DEBUG: name = flip
last_ts = 171.664597
last_received_ts = 171.664078
last_seq = 5732
current_ts = 171.681732
current_received_ts = 171.681152
current_seq = 5733
count = 27
seq_step = 1
(kms_flip:2656) DEBUG: flip ts/seq: last 171.664597/5732, current 171.681732/5733: elapsed=17135.0us expected=17194.9us +- 86.0us, error 0.3%
(kms_flip:2656) DEBUG: name = flip
last_ts = 171.681732
last_received_ts = 171.681152
last_seq = 5733
current_ts = 171.698883
current_received_ts = 171.698242
current_seq = 5734
count = 28
seq_step = 1
(kms_flip:2656) DEBUG: flip ts/seq: last 171.681732/5733, current 171.698883/5734: elapsed=17150.0us expected=17194.9us +- 86.0us, error 0.3%
(kms_flip:2656) DEBUG: name = flip
last_ts = 171.698883
last_received_ts = 171.698242
last_seq = 5734
current_ts = 171.716019
current_received_ts = 171.715424
current_seq = 5735
count = 29
seq_step = 1
(kms_flip:2656) DEBUG: flip ts/seq: last 171.698883/5734, current 171.716019/5735: elapsed=17136.0us expected=17194.9us +- 86.0us, error 0.3%
(kms_flip:2656) DEBUG: name = flip
last_ts = 171.716019
last_received_ts = 171.715424
last_seq = 5735
current_ts = 171.733139
current_received_ts = 171.732498
current_seq = 5736
count = 30
seq_step = 1
(kms_flip:2656) DEBUG: flip ts/seq: last 171.716019/5735, current 171.733139/5736: elapsed=17116.0us expected=17194.9us +- 86.0us, error 0.5%
(kms_flip:2656) DEBUG: name = flip
last_ts = 171.733139
last_received_ts = 171.732498
last_seq = 5736
current_ts = 171.750275
current_received_ts = 171.749649
current_seq = 5737
count = 31
seq_step = 1
(kms_flip:2656) DEBUG: flip ts/seq: last 171.733139/5736, current 171.750275/5737: elapsed=17142.0us expected=17194.9us +- 86.0us, error 0.3%
(kms_flip:2656) DEBUG: name = flip
last_ts = 171.750275
last_received_ts = 171.749649
last_seq = 5737
current_ts = 171.767426
current_received_ts = 171.766739
current_seq = 5738
count = 32
seq_step = 1
(kms_flip:2656) DEBUG: flip ts/seq: last 171.750275/5737, current 171.767426/5738: elapsed=17146.0us expected=17194.9us +- 86.0us, error 0.3%
(kms_flip:2656) DEBUG: name = flip
last_ts = 171.767426
last_received_ts = 171.766739
last_seq = 5738
current_ts = 171.784546
current_received_ts = 171.783966
current_seq = 5739
count = 33
seq_step = 1
(kms_flip:2656) DEBUG: flip ts/seq: last 171.767426/5738, current 171.784546/5739: elapsed=17125.0us expected=17194.9us +- 86.0us, error 0.4%
(kms_flip:2656) DEBUG: name = flip
last_ts = 171.784546
last_received_ts = 171.783966
last_seq = 5739
current_ts = 171.801682
current_received_ts = 171.801117
current_seq = 5740
count = 34
seq_step = 1
(kms_flip:2656) DEBUG: flip ts/seq: last 171.784546/5739, current 171.801682/5740: elapsed=17135.0us expected=17194.9us +- 86.0us, error 0.3%
(kms_flip:2656) DEBUG: name = flip
last_ts = 171.801682
last_received_ts = 171.801117
last_seq = 5740
current_ts = 171.818832
current_received_ts = 171.818192
current_seq = 5741
count = 35
seq_step = 1
(kms_flip:2656) DEBUG: flip ts/seq: last 171.801682/5740, current 171.818832/5741: elapsed=17149.0us expected=17194.9us +- 86.0us, error 0.3%
(kms_flip:2656) DEBUG: name = flip
last_ts = 171.818832
last_received_ts = 171.818192
last_seq = 5741
current_ts = 171.835968
current_received_ts = 171.835266
current_seq = 5742
count = 36
seq_step = 1
(kms_flip:2656) DEBUG: flip ts/seq: last 171.818832/5741, current 171.835968/5742: elapsed=17133.0us expected=17194.9us +- 86.0us, error 0.4%
(kms_flip:2656) DEBUG: name = flip
last_ts = 171.835968
last_received_ts = 171.835266
last_seq = 5742
current_ts = 171.853104
current_received_ts = 171.852432
current_seq = 5743
count = 37
seq_step = 1
(kms_flip:2656) DEBUG: flip ts/seq: last 171.835968/5742, current 171.853104/5743: elapsed=17136.0us expected=17194.9us +- 86.0us, error 0.3%
(kms_flip:2656) DEBUG: name = flip
last_ts = 171.853104
last_received_ts = 171.852432
last_seq = 5743
current_ts = 171.870239
current_received_ts = 171.869492
current_seq = 5744
count = 38
seq_step = 1
(kms_flip:2656) DEBUG: flip ts/seq: last 171.853104/5743, current 171.870239/5744: elapsed=17130.0us expected=17194.9us +- 86.0us, error 0.4%
(kms_flip:2656) DEBUG: name = flip
last_ts = 171.870239
last_received_ts = 171.869492
last_seq = 5744
current_ts = 171.887375
current_received_ts = 171.886658
current_seq = 5745
count = 39
seq_step = 1
(kms_flip:2656) DEBUG: flip ts/seq: last 171.870239/5744, current 171.887375/5745: elapsed=17139.0us expected=17194.9us +- 86.0us, error 0.3%
(kms_flip:2656) DEBUG: name = flip
last_ts = 171.887375
last_received_ts = 171.886658
last_seq = 5745
current_ts = 171.904510
current_received_ts = 171.903793
current_seq = 5746
count = 40
seq_step = 1
(kms_flip:2656) DEBUG: flip ts/seq: last 171.887375/5745, current 171.904510/5746: elapsed=17133.0us expected=17194.9us +- 86.0us, error 0.4%
(kms_flip:2656) DEBUG: name = flip
last_ts = 171.904510
last_received_ts = 171.903793
last_seq = 5746
current_ts = 171.921646
current_received_ts = 171.921082
current_seq = 5747
count = 41
seq_step = 1
(kms_flip:2656) DEBUG: flip ts/seq: last 171.904510/5746, current 171.921646/5747: elapsed=17146.0us expected=17194.9us +- 86.0us, error 0.3%
(kms_flip:2656) DEBUG: name = flip
last_ts = 171.921646
last_received_ts = 171.921082
last_seq = 5747
current_ts = 171.938782
current_received_ts = 171.938187
current_seq = 5748
count = 42
seq_step = 1
(kms_flip:2656) DEBUG: flip ts/seq: last 171.921646/5747, current 171.938782/5748: elapsed=17135.0us expected=17194.9us +- 86.0us, error 0.3%
(kms_flip:2656) DEBUG: name = flip
last_ts = 171.938782
last_received_ts = 171.938187
last_seq = 5748
current_ts = 171.955917
current_received_ts = 171.955276
current_seq = 5749
count = 43
seq_step = 1
(kms_flip:2656) DEBUG: flip ts/seq: last 171.938782/5748, current 171.955917/5749: elapsed=17127.0us expected=17194.9us +- 86.0us, error 0.4%
(kms_flip:2656) DEBUG: name = flip
last_ts = 171.955917
last_received_ts = 171.955276
last_seq = 5749
current_ts = 171.973038
current_received_ts = 171.972458
current_seq = 5750
count = 44
seq_step = 1
(kms_flip:2656) DEBUG: flip ts/seq: last 171.955917/5749, current 171.973038/5750: elapsed=17129.0us expected=17194.9us +- 86.0us, error 0.4%
(kms_flip:2656) DEBUG: name = flip
last_ts = 171.973038
last_received_ts = 171.972458
last_seq = 5750
current_ts = 171.990173
current_received_ts = 171.989578
current_seq = 5751
count = 45
seq_step = 1
(kms_flip:2656) DEBUG: flip ts/seq: last 171.973038/5750, current 171.990173/5751: elapsed=17136.0us expected=17194.9us +- 86.0us, error 0.3%
(kms_flip:2656) DEBUG: name = flip
last_ts = 171.990173
last_received_ts = 171.989578
last_seq = 5751
current_ts = 172.007309
current_received_ts = 172.006699
current_seq = 5752
count = 46
seq_step = 1
(kms_flip:2656) DEBUG: flip ts/seq: last 171.990173/5751, current 172.007309/5752: elapsed=17135.0us expected=17194.9us +- 86.0us, error 0.3%
(kms_flip:2656) DEBUG: name = flip
last_ts = 172.007309
last_received_ts = 172.006699
last_seq = 5752
current_ts = 172.024445
current_received_ts = 172.023849
current_seq = 5753
count = 47
seq_step = 1
(kms_flip:2656) DEBUG: flip ts/seq: last 172.007309/5752, current 172.024445/5753: elapsed=17134.0us expected=17194.9us +- 86.0us, error 0.4%
(kms_flip:2656) DEBUG: name = flip
last_ts = 172.024445
last_received_ts = 172.023849
last_seq = 5753
current_ts = 172.041595
current_received_ts = 172.040970
current_seq = 5754
count = 48
seq_step = 1
(kms_flip:2656) DEBUG: flip ts/seq: last 172.024445/5753, current 172.041595/5754: elapsed=17152.0us expected=17194.9us +- 86.0us, error 0.2%
(kms_flip:2656) DEBUG: name = flip
last_ts = 172.041595
last_received_ts = 172.040970
last_seq = 5754
current_ts = 172.058731
current_received_ts = 172.058136
current_seq = 5755
count = 49
seq_step = 1
(kms_flip:2656) DEBUG: flip ts/seq: last 172.041595/5754, current 172.058731/5755: elapsed=17128.0us expected=17194.9us +- 86.0us, error 0.4%
(kms_flip:2656) DEBUG: name = flip
last_ts = 172.058731
last_received_ts = 172.058136
last_seq = 5755
current_ts = 172.075867
current_received_ts = 172.075226
current_seq = 5756
count = 50
seq_step = 1
(kms_flip:2656) DEBUG: flip ts/seq: last 172.058731/5755, current 172.075867/5756: elapsed=17132.0us expected=17194.9us +- 86.0us, error 0.4%
(kms_flip:2656) DEBUG: name = flip
last_ts = 172.075867
last_received_ts = 172.075226
last_seq = 5756
current_ts = 172.092987
current_received_ts = 172.092331
current_seq = 5757
count = 51
seq_step = 1
(kms_flip:2656) DEBUG: flip ts/seq: last 172.075867/5756, current 172.092987/5757: elapsed=17132.0us expected=17194.9us +- 86.0us, error 0.4%
(kms_flip:2656) DEBUG: name = flip
last_ts = 172.092987
last_received_ts = 172.092331
last_seq = 5757
current_ts = 172.110123
current_received_ts = 172.109512
current_seq = 5758
count = 52
seq_step = 1
(kms_flip:2656) DEBUG: flip ts/seq: last 172.092987/5757, current 172.110123/5758: elapsed=17138.0us expected=17194.9us +- 86.0us, error 0.3%
(kms_flip:2656) DEBUG: name = flip
last_ts = 172.110123
last_received_ts = 172.109512
last_seq = 5758
current_ts = 172.127258
current_received_ts = 172.126678
current_seq = 5759
count = 53
seq_step = 1
(kms_flip:2656) DEBUG: flip ts/seq: last 172.110123/5758, current 172.127258/5759: elapsed=17135.0us expected=17194.9us +- 86.0us, error 0.3%
(kms_flip:2656) DEBUG: name = flip
last_ts = 172.127258
last_received_ts = 172.126678
last_seq = 5759
current_ts = 172.144394
current_received_ts = 172.143799
current_seq = 5760
count = 54
seq_step = 1
(kms_flip:2656) DEBUG: flip ts/seq: last 172.127258/5759, current 172.144394/5760: elapsed=17136.0us expected=17194.9us +- 86.0us, error 0.3%
(kms_flip:2656) DEBUG: name = flip
last_ts = 172.144394
last_received_ts = 172.143799
last_seq = 5760
current_ts = 172.161530
current_received_ts = 172.160889
current_seq = 5761
count = 55
seq_step = 1
(kms_flip:2656) DEBUG: flip ts/seq: last 172.144394/5760, current 172.161530/5761: elapsed=17131.0us expected=17194.9us +- 86.0us, error 0.4%
(kms_flip:2656) DEBUG: name = flip
last_ts = 172.161530
last_received_ts = 172.160889
last_seq = 5761
current_ts = 172.178665
current_received_ts = 172.178085
current_seq = 5762
count = 56
seq_step = 1
(kms_flip:2656) DEBUG: flip ts/seq: last 172.161530/5761, current 172.178665/5762: elapsed=17140.0us expected=17194.9us +- 86.0us, error 0.3%
(kms_flip:2656) DEBUG: name = flip
last_ts = 172.178665
last_received_ts = 172.178085
last_seq = 5762
current_ts = 172.195816
current_received_ts = 172.195190
current_seq = 5763
count = 57
seq_step = 1
(kms_flip:2656) DEBUG: flip ts/seq: last 172.178665/5762, current 172.195816/5763: elapsed=17149.0us expected=17194.9us +- 86.0us, error 0.3%
(kms_flip:2656) DEBUG: name = flip
last_ts = 172.195816
last_received_ts = 172.195190
last_seq = 5763
current_ts = 172.212952
current_received_ts = 172.212234
current_seq = 5764
count = 58
seq_step = 1
(kms_flip:2656) DEBUG: flip ts/seq: last 172.195816/5763, current 172.212952/5764: elapsed=17135.0us expected=17194.9us +- 86.0us, error 0.3%
(kms_flip:2656) DEBUG: name = flip
last_ts = 172.212952
last_received_ts = 172.212234
last_seq = 5764
current_ts = 172.230087
current_received_ts = 172.229446
current_seq = 5765
count = 59
seq_step = 1
(kms_flip:2656) DEBUG: flip ts/seq: last 172.212952/5764, current 172.230087/5765: elapsed=17125.0us expected=17194.9us +- 86.0us, error 0.4%
(kms_flip:2656) DEBUG: name = flip
last_ts = 172.230087
last_received_ts = 172.229446
last_seq = 5765
current_ts = 172.247223
current_received_ts = 172.246582
current_seq = 5766
count = 60
seq_step = 1
(kms_flip:2656) DEBUG: flip ts/seq: last 172.230087/5765, current 172.247223/5766: elapsed=17149.0us expected=17194.9us +- 86.0us, error 0.3%
(kms_flip:2656) DEBUG: name = flip
last_ts = 172.247223
last_received_ts = 172.246582
last_seq = 5766
current_ts = 172.264359
current_received_ts = 172.263763
current_seq = 5767
count = 61
seq_step = 1
(kms_flip:2656) DEBUG: flip ts/seq: last 172.247223/5766, current 172.264359/5767: elapsed=17126.0us expected=17194.9us +- 86.0us, error 0.4%
(kms_flip:2656) DEBUG: name = flip
last_ts = 172.264359
last_received_ts = 172.263763
last_seq = 5767
current_ts = 172.281479
current_received_ts = 172.280869
current_seq = 5768
count = 62
seq_step = 1
(kms_flip:2656) DEBUG: flip ts/seq: last 172.264359/5767, current 172.281479/5768: elapsed=17129.0us expected=17194.9us +- 86.0us, error 0.4%
(kms_flip:2656) DEBUG: name = flip
last_ts = 172.281479
last_received_ts = 172.280869
last_seq = 5768
current_ts = 172.298630
current_received_ts = 172.297974
current_seq = 5769
count = 63
seq_step = 1
(kms_flip:2656) DEBUG: flip ts/seq: last 172.281479/5768, current 172.298630/5769: elapsed=17150.0us expected=17194.9us +- 86.0us, error 0.3%
(kms_flip:2656) DEBUG: name = flip
last_ts = 172.298630
last_received_ts = 172.297974
last_seq = 5769
current_ts = 172.315765
current_received_ts = 172.315201
current_seq = 5770
count = 64
seq_step = 1
(kms_flip:2656) DEBUG: flip ts/seq: last 172.298630/5769, current 172.315765/5770: elapsed=17128.0us expected=17194.9us +- 86.0us, error 0.4%
(kms_flip:2656) DEBUG: name = flip
last_ts = 172.315765
last_received_ts = 172.315201
last_seq = 5770
current_ts = 172.332901
current_received_ts = 172.332214
current_seq = 5771
count = 65
seq_step = 1
(kms_flip:2656) DEBUG: flip ts/seq: last 172.315765/5770, current 172.332901/5771: elapsed=17139.0us expected=17194.9us +- 86.0us, error 0.3%
(kms_flip:2656) DEBUG: name = flip
last_ts = 172.332901
last_received_ts = 172.332214
last_seq = 5771
current_ts = 172.350021
current_received_ts = 172.349442
current_seq = 5772
count = 66
seq_step = 1
(kms_flip:2656) DEBUG: flip ts/seq: last 172.332901/5771, current 172.350021/5772: elapsed=17125.0us expected=17194.9us +- 86.0us, error 0.4%
(kms_flip:2656) DEBUG: name = flip
last_ts = 172.350021
last_received_ts = 172.349442
last_seq = 5772
current_ts = 172.367157
current_received_ts = 172.366577
current_seq = 5773
count = 67
seq_step = 1
(kms_flip:2656) DEBUG: flip ts/seq: last 172.350021/5772, current 172.367157/5773: elapsed=17134.0us expected=17194.9us +- 86.0us, error 0.4%
(kms_flip:2656) DEBUG: name = flip
last_ts = 172.367157
last_received_ts = 172.366577
last_seq = 5773
current_ts = 172.384308
current_received_ts = 172.383743
current_seq = 5774
count = 68
seq_step = 1
(kms_flip:2656) DEBUG: flip ts/seq: last 172.367157/5773, current 172.384308/5774: elapsed=17141.0us expected=17194.9us +- 86.0us, error 0.3%
(kms_flip:2656) DEBUG: name = flip
last_ts = 172.384308
last_received_ts = 172.383743
last_seq = 5774
current_ts = 172.401443
current_received_ts = 172.400833
current_seq = 5775
count = 69
seq_step = 1
(kms_flip:2656) DEBUG: flip ts/seq: last 172.384308/5774, current 172.401443/5775: elapsed=17135.0us expected=17194.9us +- 86.0us, error 0.3%
(kms_flip:2656) DEBUG: name = flip
last_ts = 172.401443
last_received_ts = 172.400833
last_seq = 5775
current_ts = 172.418579
current_received_ts = 172.417984
current_seq = 5776
count = 70
seq_step = 1
(kms_flip:2656) DEBUG: flip ts/seq: last 172.401443/5775, current 172.418579/5776: elapsed=17148.0us expected=17194.9us +- 86.0us, error 0.3%
(kms_flip:2656) DEBUG: name = flip
last_ts = 172.418579
last_received_ts = 172.417984
last_seq = 5776
current_ts = 172.435715
current_received_ts = 172.435120
current_seq = 5777
count = 71
seq_step = 1
(kms_flip:2656) DEBUG: flip ts/seq: last 172.418579/5776, current 172.435715/5777: elapsed=17124.0us expected=17194.9us +- 86.0us, error 0.4%
(kms_flip:2656) DEBUG: name = flip
last_ts = 172.435715
last_received_ts = 172.435120
last_seq = 5777
current_ts = 172.452850
current_received_ts = 172.452209
current_seq = 5778
count = 72
seq_step = 1
(kms_flip:2656) DEBUG: flip ts/seq: last 172.435715/5777, current 172.452850/5778: elapsed=17135.0us expected=17194.9us +- 86.0us, error 0.3%
(kms_flip:2656) DEBUG: name = flip
last_ts = 172.452850
last_received_ts = 172.452209
last_seq = 5778
current_ts = 172.469971
current_received_ts = 172.469437
current_seq = 5779
count = 73
seq_step = 1
(kms_flip:2656) DEBUG: flip ts/seq: last 172.452850/5778, current 172.469971/5779: elapsed=17134.0us expected=17194.9us +- 86.0us, error 0.4%
(kms_flip:2656) DEBUG: name = flip
last_ts = 172.469971
last_received_ts = 172.469437
last_seq = 5779
current_ts = 172.487122
current_received_ts = 172.486511
current_seq = 5780
count = 74
seq_step = 1
(kms_flip:2656) DEBUG: flip ts/seq: last 172.469971/5779, current 172.487122/5780: elapsed=17150.0us expected=17194.9us +- 86.0us, error 0.3%
(kms_flip:2656) DEBUG: name = flip
last_ts = 172.487122
last_received_ts = 172.486511
last_seq = 5780
current_ts = 172.504211
current_received_ts = 172.503632
current_seq = 5781
count = 75
seq_step = 1
(kms_flip:2656) DEBUG: flip ts/seq: last 172.487122/5780, current 172.504211/5781: elapsed=17091.0us expected=17194.9us +- 86.0us, error 0.6%
(kms_flip:2656) DEBUG: inconsistent flip ts/seq: last 172.487122/5780, current 172.504211/5781: elapsed=17091.0us expected=17194.9us
(kms_flip:2656) DEBUG: expected 65708, counted 75, encoder type 1
(kms_flip:2656) DEBUG: dropped frames, expected 65708, counted 75, encoder type 1
(kms_flip:2656) CRITICAL: Test assertion failure function __run_test_on_crtc_set, file ../tests/kms_flip.c:1674:
(kms_flip:2656) CRITICAL: Failed assertion: !retried && needs_retry_after_link_reset(mon)
(kms_flip:2656) igt_core-INFO: Stack trace:
(kms_flip:2656) igt_core-INFO:   #0 ../lib/igt_core.c:2055 __igt_fail_assert()
(kms_flip:2656) igt_core-INFO:   #1 ../tests/kms_flip.c:791 run_test_on_crtc_set.constprop.0()
(kms_flip:2656) igt_core-INFO:   #2 ../tests/kms_flip.c:1845 run_test()
(kms_flip:2656) igt_core-INFO:   #3 ../tests/kms_flip.c:2078 __igt_unique____real_main2001()
(kms_flip:2656) igt_core-INFO:   #4 ../tests/kms_flip.c:2001 main()
(kms_flip:2656) igt_core-INFO:   #5 [__libc_init_first+0x8a]
(kms_flip:2656) igt_core-INFO:   #6 [__libc_start_main+0x8b]
(kms_flip:2656) igt_core-INFO:   #7 [_start+0x25]
****  END  ****
Dynamic subtest A-VGA1: FAIL (4.749s)
Dmesg
<6> [170.306575] Console: switching to colour dummy device 80x25
<6> [170.307032] [IGT] kms_flip: executing
<7> [170.310807] i915 0000:00:02.0: [drm:i915_gem_open [i915]]
<7> [170.311586] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc]
<7> [170.312010] i915 0000:00:02.0: [drm:i915_gem_open [i915]]
<7> [170.316100] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] [CONNECTOR:64:VGA-1]
<7> [170.316132] i915 0000:00:02.0: [drm:intel_crt_detect [i915]] [CONNECTOR:64:VGA-1] force=1
<7> [170.316425] i915 0000:00:02.0: [drm:intel_crt_detect [i915]] ironlake hotplug adpa=0xf40000, result 0
<7> [170.316695] i915 0000:00:02.0: [drm:intel_crt_detect [i915]] CRT not detected via hotplug
<7> [170.317242] i915 0000:00:02.0: [drm:do_gmbus_xfer [i915]] GMBUS [i915 gmbus vga] NAK for addr: 0050 w(1)
<7> [170.317472] i915 0000:00:02.0: [drm:do_gmbus_xfer [i915]] GMBUS [i915 gmbus vga] NAK on first message, retry
<7> [170.317839] i915 0000:00:02.0: [drm:do_gmbus_xfer [i915]] GMBUS [i915 gmbus vga] NAK for addr: 0050 w(1)
<7> [170.318144] [drm:drm_do_probe_ddc_edid] drm: skipping non-existent adapter i915 gmbus vga
<7> [170.318152] i915 0000:00:02.0: [drm:intel_crt_get_edid [i915]] CRT GMBUS EDID read failed, retry using GPIO bit-banging
<7> [170.318451] i915 0000:00:02.0: [drm:intel_gmbus_force_bit [i915]] enabling bit-banging on i915 gmbus vga. force bit now 1
<7> [170.319714] [drm:drm_do_probe_ddc_edid] drm: skipping non-existent adapter i915 gmbus vga
<7> [170.319719] i915 0000:00:02.0: [drm:intel_gmbus_force_bit [i915]] disabling bit-banging on i915 gmbus vga. force bit now 0
<7> [170.319956] i915 0000:00:02.0: [drm:intel_crt_detect_ddc [i915]] CRT not detected via DDC:0x50 [no valid EDID found]
<7> [170.320178] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] [CONNECTOR:64:VGA-1] disconnected
<7> [170.320643] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] [CONNECTOR:75:DP-1]
<7> [170.320661] i915 0000:00:02.0: [drm:intel_dp_detect [i915]] [CONNECTOR:75:DP-1]
<7> [170.324377] i915 0000:00:02.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DP D: timeout (status 0x7143003f)
<7> [170.328245] i915 0000:00:02.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DP D: timeout (status 0x7143003f)
<7> [170.332123] i915 0000:00:02.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DP D: timeout (status 0x7143003f)
<7> [170.335978] i915 0000:00:02.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DP D: timeout (status 0x7143003f)
<7> [170.339865] i915 0000:00:02.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DP D: timeout (status 0x7143003f)
<7> [170.343743] i915 0000:00:02.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DP D: timeout (status 0x7143003f)
<7> [170.347600] i915 0000:00:02.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DP D: timeout (status 0x7143003f)
<7> [170.351475] i915 0000:00:02.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DP D: timeout (status 0x7143003f)
<7> [170.355361] i915 0000:00:02.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DP D: timeout (status 0x7143003f)
<7> [170.359211] i915 0000:00:02.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DP D: timeout (status 0x7143003f)
<7> [170.363109] i915 0000:00:02.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DP D: timeout (status 0x7143003f)
<7> [170.366984] i915 0000:00:02.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DP D: timeout (status 0x7143003f)
<7> [170.370845] i915 0000:00:02.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DP D: timeout (status 0x7143003f)
<7> [170.374718] i915 0000:00:02.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DP D: timeout (status 0x7143003f)
<7> [170.378606] i915 0000:00:02.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DP D: timeout (status 0x7143003f)
<7> [170.382500] i915 0000:00:02.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DP D: timeout (status 0x7143003f)
<7> [170.386341] i915 0000:00:02.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DP D: timeout (status 0x7143003f)
<7> [170.390216] i915 0000:00:02.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DP D: timeout (status 0x7143003f)
<7> [170.394090] i915 0000:00:02.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DP D: timeout (status 0x7143003f)
<7> [170.398011] i915 0000:00:02.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DP D: timeout (status 0x7143003f)
<7> [170.402099] i915 0000:00:02.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DP D: timeout (status 0x7143003f)
<7> [170.405996] i915 0000:00:02.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DP D: timeout (status 0x7143003f)
<7> [170.410184] i915 0000:00:02.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DP D: timeout (status 0x7143003f)
<7> [170.414222] i915 0000:00:02.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DP D: timeout (status 0x7143003f)
<7> [170.418117] i915 0000:00:02.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DP D: timeout (status 0x7143003f)
<7> [170.422223] i915 0000:00:02.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DP D: timeout (status 0x7143003f)
<7> [170.426311] i915 0000:00:02.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DP D: timeout (status 0x7143003f)
<7> [170.430493] i915 0000:00:02.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DP D: timeout (status 0x7143003f)
<7> [170.434532] i915 0000:00:02.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DP D: timeout (status 0x7143003f)
<7> [170.438702] i915 0000:00:02.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DP D: timeout (status 0x7143003f)
<7> [170.442791] i915 0000:00:02.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DP D: timeout (status 0x7143003f)
<7> [170.446969] i915 0000:00:02.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DP D: timeout (status 0x7143003f)
<7> [170.447356] i915 0000:00:02.0: [drm:drm_dp_dpcd_access [drm_display_helper]] AUX D/DP D: Too many retries, giving up. First error: -110
<7> [170.447404] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] [CONNECTOR:75:DP-1] disconnected
<7> [170.447847] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] [CONNECTOR:64:VGA-1]
<7> [170.447870] i915 0000:00:02.0: [drm:intel_crt_detect [i915]] [CONNECTOR:64:VGA-1] force=1
<7> [170.448150] i915 0000:00:02.0: [drm:intel_crt_detect [i915]] ironlake hotplug adpa=0xf40000, result 0
<7> [170.448419] i915 0000:00:02.0: [drm:intel_crt_detect [i915]] CRT not detected via hotplug
<7> [170.448976] i915 0000:00:02.0: [drm:do_gmbus_xfer [i915]] GMBUS [i915 gmbus vga] NAK for addr: 0050 w(1)
<7> [170.449234] i915 0000:00:02.0: [drm:do_gmbus_xfer [i915]] GMBUS [i915 gmbus vga] NAK on first message, retry
<7> [170.449669] i915 0000:00:02.0: [drm:do_gmbus_xfer [i915]] GMBUS [i915 gmbus vga] NAK for addr: 0050 w(1)
<7> [170.449904] [drm:drm_do_probe_ddc_edid] drm: skipping non-existent adapter i915 gmbus vga
<7> [170.449909] i915 0000:00:02.0: [drm:intel_crt_get_edid [i915]] CRT GMBUS EDID read failed, retry using GPIO bit-banging
<7> [170.450121] i915 0000:00:02.0: [drm:intel_gmbus_force_bit [i915]] enabling bit-banging on i915 gmbus vga. force bit now 1
<7> [170.451350] [drm:drm_do_probe_ddc_edid] drm: skipping non-existent adapter i915 gmbus vga
<7> [170.451356] i915 0000:00:02.0: [drm:intel_gmbus_force_bit [i915]] disabling bit-banging on i915 gmbus vga. force bit now 0
<7> [170.451585] i915 0000:00:02.0: [drm:intel_crt_detect_ddc [i915]] CRT not detected via DDC:0x50 [no valid EDID found]
<7> [170.451793] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] [CONNECTOR:64:VGA-1] disconnected
<7> [170.452073] i915 0000:00:02.0: [drm:status_store] [CONNECTOR:64:VGA-1] force updated from 0 to 2 or reprobing
<7> [170.452085] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] [CONNECTOR:64:VGA-1]
<7> [170.452113] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] [CONNECTOR:64:VGA-1] status updated from disconnected to connected
<7> [170.452183] i915 0000:00:02.0: [drm:drm_sysfs_hotplug_event] generating hotplug event
<7> [170.452271] i915 0000:00:02.0: [drm:drm_client_hotplug] fbdev: ret=0
<7> [170.452336] i915 0000:00:02.0: [drm:do_gmbus_xfer [i915]] GMBUS [i915 gmbus vga] NAK for addr: 0050 w(1)
<7> [170.452620] i915 0000:00:02.0: [drm:do_gmbus_xfer [i915]] GMBUS [i915 gmbus vga] NAK on first message, retry
<7> [170.453015] i915 0000:00:02.0: [drm:do_gmbus_xfer [i915]] GMBUS [i915 gmbus vga] NAK for addr: 0050 w(1)
<7> [170.453218] [drm:drm_do_probe_ddc_edid] drm: skipping non-existent adapter i915 gmbus vga
<7> [170.453230] i915 0000:00:02.0: [drm:intel_crt_get_edid [i915]] CRT GMBUS EDID read failed, retry using GPIO bit-banging
<7> [170.453432] i915 0000:00:02.0: [drm:intel_gmbus_force_bit [i915]] enabling bit-banging on i915 gmbus vga. force bit now 1
<7> [170.454834] [drm:drm_do_probe_ddc_edid] drm: skipping non-existent adapter i915 gmbus vga
<7> [170.454857] i915 0000:00:02.0: [drm:intel_gmbus_force_bit [i915]] disabling bit-banging on i915 gmbus vga. force bit now 0
<7> [170.455137] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] [CONNECTOR:64:VGA-1] probed modes:
<7> [170.455155] 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> [170.455170] 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> [170.455184] 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> [170.455222] 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> [170.455237] 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> [170.455295] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] [CONNECTOR:64:VGA-1]
<7> [170.455501] i915 0000:00:02.0: [drm:do_gmbus_xfer [i915]] GMBUS [i915 gmbus vga] NAK for addr: 0050 w(1)
<7> [170.455752] i915 0000:00:02.0: [drm:do_gmbus_xfer [i915]] GMBUS [i915 gmbus vga] NAK on first message, retry
<7> [170.456131] i915 0000:00:02.0: [drm:do_gmbus_xfer [i915]] GMBUS [i915 gmbus vga] NAK for addr: 0050 w(1)
<7> [170.456332] [drm:drm_do_probe_ddc_edid] drm: skipping non-existent adapter i915 gmbus vga
<7> [170.456343] i915 0000:00:02.0: [drm:intel_crt_get_edid [i915]] CRT GMBUS EDID read failed, retry using GPIO bit-banging
<7> [170.456600] i915 0000:00:02.0: [drm:intel_gmbus_force_bit [i915]] enabling bit-banging on i915 gmbus vga. force bit now 1
<7> [170.457986] [drm:drm_do_probe_ddc_edid] drm: skipping non-existent adapter i915 gmbus vga
<7> [170.457998] i915 0000:00:02.0: [drm:intel_gmbus_force_bit [i915]] disabling bit-banging on i915 gmbus vga. force bit now 0
<7> [170.458296] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] [CONNECTOR:64:VGA-1] probed modes:
<7> [170.458314] 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> [170.458329] 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> [170.458387] 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> [170.458417] 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> [170.458431] 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> [170.458474] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] [CONNECTOR:67:HDMI-A-1]
<7> [170.458492] i915 0000:00:02.0: [drm:intel_hdmi_detect [i915]] [CONNECTOR:67:HDMI-A-1]
<7> [170.484268] i915 0000:00:02.0: [drm:update_display_info.part.0] [CONNECTOR:67:HDMI-A-1] HDMI: DVI dual 0, max TMDS clock 590000 kHz
<7> [170.484281] i915 0000:00:02.0: [drm:update_display_info.part.0] [CONNECTOR:67:HDMI-A-1] HDMI sink does deep color 30.
<7> [170.484288] i915 0000:00:02.0: [drm:update_display_info.part.0] [CONNECTOR:67:HDMI-A-1] HDMI sink does deep color 36.
<7> [170.484294] i915 0000:00:02.0: [drm:update_display_info.part.0] [CONNECTOR:67:HDMI-A-1] HDMI sink does deep color 48.
<7> [170.484299] i915 0000:00:02.0: [drm:update_display_info.part.0] [CONNECTOR:67:HDMI-A-1] Assigning HDMI sink color depth as 16 bpc.
<7> [170.484305] i915 0000:00:02.0: [drm:update_display_info.part.0] [CONNECTOR:67:HDMI-A-1] HDMI sink does YCRCB444 in deep color.
<7> [170.484313] i915 0000:00:02.0: [drm:update_display_info.part.0] [CONNECTOR:67:HDMI-A-1] ELD monitor Mi TV
<7> [170.484319] i915 0000:00:02.0: [drm:update_display_info.part.0] [CONNECTOR:67:HDMI-A-1] HDMI: latency present 0 0, video latency 0 0, audio latency 0 0
<7> [170.484327] i915 0000:00:02.0: [drm:update_display_info.part.0] [CONNECTOR:67:HDMI-A-1] ELD size 36, SAD count 3
<7> [170.484598] i915 0000:00:02.0: [drm:do_gmbus_xfer [i915]] GMBUS [i915 gmbus dpd] NAK for addr: 0040 w(1)
<7> [170.484937] i915 0000:00:02.0: [drm:do_gmbus_xfer [i915]] GMBUS [i915 gmbus dpd] NAK on first message, retry
<7> [170.485457] i915 0000:00:02.0: [drm:do_gmbus_xfer [i915]] GMBUS [i915 gmbus dpd] NAK for addr: 0040 w(1)
<7> [170.485781] i915 0000:00:02.0: [drm:drm_dp_dual_mode_detect [drm_display_helper]] DP dual mode HDMI ID: (err -6)
<7> [170.487294] i915 0000:00:02.0: [drm:drm_mode_prune_invalid] Rejected mode: "2560x1600": 60 268500 2560 2608 2640 2720 1600 1603 1609 1646 0x40 0x5 (CLOCK_HIGH)
<7> [170.487306] i915 0000:00:02.0: [drm:drm_mode_prune_invalid] Rejected mode: "2560x1440": 60 241500 2560 2608 2640 2720 1440 1443 1449 1481 0x40 0x5 (CLOCK_HIGH)
<7> [170.487315] i915 0000:00:02.0: [drm:drm_mode_prune_invalid] Rejected mode: "3840x2160": 30 297000 3840 4016 4104 4400 2160 2168 2178 2250 0x40 0x5 (CLOCK_HIGH)
<7> [170.487323] i915 0000:00:02.0: [drm:drm_mode_prune_invalid] Rejected mode: "4096x2160": 30 297000 4096 4184 4272 4400 2160 2168 2178 2250 0x40 0x5 (CLOCK_HIGH)
<7> [170.487331] i915 0000:00:02.0: [drm:drm_mode_prune_invalid] Rejected mode: "1920x1080": 120 297000 1920 2008 2052 2200 1080 1084 1089 1125 0x40 0x5 (CLOCK_HIGH)
<7> [170.487339] i915 0000:00:02.0: [drm:drm_mode_prune_invalid] Rejected mode: "3840x2160": 25 297000 3840 4896 4984 5280 2160 2168 2178 2250 0x40 0x5 (CLOCK_HIGH)
<7> [170.487346] i915 0000:00:02.0: [drm:drm_mode_prune_invalid] Rejected mode: "3840x2160": 24 297000 3840 5116 5204 5500 2160 2168 2178 2250 0x40 0x5 (CLOCK_HIGH)
<7> [170.487354] i915 0000:00:02.0: [drm:drm_mode_prune_invalid] Rejected mode: "4096x2160": 24 297000 4096 5116 5204 5500 2160 2168 2178 2250 0x40 0x5 (CLOCK_HIGH)
<7> [170.487361] i915 0000:00:02.0: [drm:drm_mode_prune_invalid] Rejected mode: "3840x2160": 50 594000 3840 4896 4984 5280 2160 2168 2178 2250 0x40 0x5 (CLOCK_HIGH)
<7> [170.487369] i915 0000:00:02.0: [drm:drm_mode_prune_invalid] Rejected mode: "3840x2160": 60 594000 3840 4016 4104 4400 2160 2168 2178 2250 0x40 0x5 (CLOCK_HIGH)
<7> [170.487376] i915 0000:00:02.0: [drm:drm_mode_prune_invalid] Rejected mode: "4096x2160": 50 594000 4096 5064 5152 5280 2160 2168 2178 2250 0x40 0x5 (CLOCK_HIGH)
<7> [170.487383] i915 0000:00:02.0: [drm:drm_mode_prune_invalid] Rejected mode: "4096x2160": 60 594000 4096 4184 4272 4400 2160 2168 2178 2250 0x40 0x5 (CLOCK_HIGH)
<7> [170.487391] i915 0000:00:02.0: [drm:drm_mode_prune_invalid] Rejected mode: "3840x2160": 30 296703 3840 4016 4104 4400 2160 2168 2178 2250 0x40 0x5 (CLOCK_HIGH)
<7> [170.487398] i915 0000:00:02.0: [drm:drm_mode_prune_invalid] Rejected mode: "4096x2160": 30 296703 4096 4184 4272 4400 2160 2168 2178 2250 0x40 0x5 (CLOCK_HIGH)
<7> [170.487406] i915 0000:00:02.0: [drm:drm_mode_prune_invalid] Rejected mode: "1920x1080": 120 296703 1920 2008 2052 2200 1080 1084 1089 1125 0x40 0x5 (CLOCK_HIGH)
<7> [170.487413] i915 0000:00:02.0: [drm:drm_mode_prune_invalid] Rejected mode: "3840x2160": 24 296703 3840 5116 5204 5500 2160 2168 2178 2250 0x40 0x5 (CLOCK_HIGH)
<7> [170.487421] i915 0000:00:02.0: [drm:drm_mode_prune_invalid] Rejected mode: "4096x2160": 24 296703 4096 5116 5204 5500 2160 2168 2178 2250 0x40 0x5 (CLOCK_HIGH)
<7> [170.487428] i915 0000:00:02.0: [drm:drm_mode_prune_invalid] Rejected mode: "3840x2160": 60 593407 3840 4016 4104 4400 2160 2168 2178 2250 0x40 0x5 (CLOCK_HIGH)
<7> [170.487436] i915 0000:00:02.0: [drm:drm_mode_prune_invalid] Rejected mode: "4096x2160": 60 593407 4096 4184 4272 4400 2160 2168 2178 2250 0x40 0x5 (CLOCK_HIGH)
<7> [170.487449] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] [CONNECTOR:67:HDMI-A-1] probed modes:
<7> [170.487472] 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 0x48 0x5
<7> [170.487529] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] Probed mode: "2880x1800": 30 167000 2880 2910 2920 3030 1800 1820 1828 1836 0x40 0x5
<7> [170.487556] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] Probed mode: "1920x1200": 60 154000 1920 1968 2000 2080 1200 1203 1209 1235 0x40 0x9
<7> [170.487581] 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> [170.487606] 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> [170.487623] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] Probed mode: "1920x1080i": 60 74250 1920 2008 2052 2200 1080 1084 1094 1125 0x40 0x15
<7> [170.487637] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] Probed mode: "1920x1080i": 60 74250 1920 2008 2052 2200 1080 1084 1094 1125 0x40 0x20015
<7> [170.487651] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] Probed mode: "1920x1080i": 60 74176 1920 2008 2052 2200 1080 1084 1094 1125 0x40 0x15
<7> [170.487664] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] Probed mode: "1920x1080i": 60 74176 1920 2008 2052 2200 1080 1084 1094 1125 0x40 0x20015
<7> [170.487678] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] Probed mode: "1920x1080": 50 148500 1920 2448 2492 2640 1080 1084 1089 1125 0x40 0x5
<7> [170.487691] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] Probed mode: "1920x1080i": 50 74250 1920 2448 2492 2640 1080 1084 1094 1125 0x40 0x15
<7> [170.487704] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] Probed mode: "1920x1080i": 50 74250 1920 2448 2492 2640 1080 1084 1094 1125 0x40 0x20015
<7> [170.487718] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] Probed mode: "1920x1080": 30 74250 1920 2008 2052 2200 1080 1084 1089 1125 0x40 0x5
<7> [170.487734] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] Probed mode: "1920x1080": 30 74176 1920 2008 2052 2200 1080 1084 1089 1125 0x40 0x5
<7> [170.487759] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] Probed mode: "1920x1080": 25 74250 1920 2448 2492 2640 1080 1084 1089 1125 0x40 0x5
<7> [170.487784] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] Probed mode: "1920x1080": 24 74250 1920 2558 2602 2750 1080 1084 1089 1125 0x40 0x5
<7> [170.487809] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] Probed mode: "1920x1080": 24 74250 1920 2558 2602 2750 1080 1084 1089 1125 0x40 0x1c005
<7> [170.487825] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] Probed mode: "1920x1080": 24 74250 1920 2558 2602 2750 1080 1084 1089 1125 0x40 0x4005
<7> [170.487839] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] Probed mode: "1920x1080": 24 74176 1920 2558 2602 2750 1080 1084 1089 1125 0x40 0x5
<7> [170.487852] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] Probed mode: "1920x1080": 24 74176 1920 2558 2602 2750 1080 1084 1089 1125 0x40 0x1c005
<7> [170.487866] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] Probed mode: "1920x1080": 24 74176 1920 2558 2602 2750 1080 1084 1089 1125 0x40 0x4005
<7> [170.487879] 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> [170.487892] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] Probed mode: "1680x1050": 60 119000 1680 1728 1760 1840 1050 1053 1059 1080 0x40 0x9
<7> [170.487906] 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> [170.487919] 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> [170.487933] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] Probed mode: "1440x900": 60 88750 1440 1488 1520 1600 900 903 909 926 0x40 0x9
<7> [170.487947] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] Probed mode: "1366x768": 60 85500 1366 1436 1579 1792 768 771 774 798 0x40 0x5
<7> [170.487960] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] Probed mode: "1280x800": 60 71000 1280 1328 1360 1440 800 803 809 823 0x40 0x9
<7> [170.487974] 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> [170.487987] 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 0x1c005
<7> [170.488001] 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 0x4005
<7> [170.488014] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] Probed mode: "1280x720": 60 74176 1280 1390 1430 1650 720 725 730 750 0x40 0x5
<7> [170.488027] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] Probed mode: "1280x720": 60 74176 1280 1390 1430 1650 720 725 730 750 0x40 0x1c005
<7> [170.488041] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] Probed mode: "1280x720": 60 74176 1280 1390 1430 1650 720 725 730 750 0x40 0x4005
<7> [170.488054] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] Probed mode: "1280x720": 50 74250 1280 1720 1760 1980 720 725 730 750 0x40 0x5
<7> [170.488068] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] Probed mode: "1280x720": 50 74250 1280 1720 1760 1980 720 725 730 750 0x40 0x1c005
<7> [170.488100] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] Probed mode: "1280x720": 50 74250 1280 1720 1760 1980 720 725 730 750 0x40 0x4005
<7> [170.488117] 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> [170.488131] 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> [170.488145] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] Probed mode: "720x576": 50 27000 720 732 796 864 576 581 586 625 0x40 0xa
<7> [170.488159] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] Probed mode: "720x576i": 50 13500 720 732 795 864 576 580 586 625 0x40 0x101a
<7> [170.488172] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] Probed mode: "720x480": 60 27027 720 736 798 858 480 489 495 525 0x40 0xa
<7> [170.488186] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] Probed mode: "720x480": 60 27000 720 736 798 858 480 489 495 525 0x40 0xa
<7> [170.488200] 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> [170.488214] 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> [170.488275] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] [CONNECTOR:75:DP-1]
<7> [170.488292] i915 0000:00:02.0: [drm:intel_dp_detect [i915]] [CONNECTOR:75:DP-1]
<7> [170.492095] i915 0000:00:02.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DP D: timeout (status 0x7143003f)
<7> [170.496007] i915 0000:00:02.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DP D: timeout (status 0x7143003f)
<7> [170.499893] i915 0000:00:02.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DP D: timeout (status 0x7143003f)
<7> [170.503770] i915 0000:00:02.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DP D: timeout (status 0x7143003f)
<7> [170.507658] i915 0000:00:02.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DP D: timeout (status 0x7143003f)
<7> [170.511561] i915 0000:00:02.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DP D: timeout (status 0x7143003f)
<7> [170.515438] i915 0000:00:02.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DP D: timeout (status 0x7143003f)
<7> [170.519310] i915 0000:00:02.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DP D: timeout (status 0x7143003f)
<7> [170.523229] i915 0000:00:02.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DP D: timeout (status 0x7143003f)
<7> [170.527293] i915 0000:00:02.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DP D: timeout (status 0x7143003f)
<7> [170.531260] i915 0000:00:02.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DP D: timeout (status 0x7143003f)
<7> [170.535096] i915 0000:00:02.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DP D: timeout (status 0x7143003f)
<7> [170.539018] i915 0000:00:02.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DP D: timeout (status 0x7143003f)
<7> [170.542859] i915 0000:00:02.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DP D: timeout (status 0x7143003f)
<7> [170.546762] i915 0000:00:02.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DP D: timeout (status 0x7143003f)
<7> [170.550635] i915 0000:00:02.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DP D: timeout (status 0x7143003f)
<7> [170.554538] i915 0000:00:02.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DP D: timeout (status 0x7143003f)
<7> [170.558397] i915 0000:00:02.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DP D: timeout (status 0x7143003f)
<7> [170.562370] i915 0000:00:02.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DP D: timeout (status 0x7143003f)
<7> [170.566537] i915 0000:00:02.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DP D: timeout (status 0x7143003f)
<7> [170.570663] i915 0000:00:02.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DP D: timeout (status 0x7143003f)
<7> [170.574779] i915 0000:00:02.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DP D: timeout (status 0x7143003f)
<7> [170.578904] i915 0000:00:02.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DP D: timeout (status 0x7143003f)
<7> [170.583018] i915 0000:00:02.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DP D: timeout (status 0x7143003f)
<7> [170.586945] i915 0000:00:02.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DP D: timeout (status 0x7143003f)
<7> [170.590568] i915 0000:00:02.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DP D: timeout (status 0x7143003f)
<7> [170.594783] i915 0000:00:02.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DP D: timeout (status 0x7143003f)
<7> [170.598866] i915 0000:00:02.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DP D: timeout (status 0x7143003f)
<7> [170.602994] i915 0000:00:02.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DP D: timeout (status 0x7143003f)
<7> [170.607102] i915 0000:00:02.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DP D: timeout (status 0x7143003f)
<7> [170.611266] i915 0000:00:02.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DP D: timeout (status 0x7143003f)
<7> [170.615215] i915 0000:00:02.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DP D: timeout (status 0x7143003f)
<7> [170.615637] i915 0000:00:02.0: [drm:drm_dp_dpcd_access [drm_display_helper]] AUX D/DP D: Too many retries, giving up. First error: -110
<7> [170.615671] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] [CONNECTOR:75:DP-1] disconnected
<6> [170.617081] [IGT] kms_flip: starting subtest plain-flip-fb-recreate
<6> [170.619175] [IGT] kms_flip: starting dynamic subtest A-VGA1
<7> [170.619713] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:79]
<7> [170.619870] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:83]
<7> [170.669387] i915 0000:00:02.0: [drm:drm_mode_setcrtc] [CRTC:47:pipe A]
<7> [170.669587] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:47:pipe A] fastset requirement not met in hw.enable (expected yes, found no)
<7> [170.670068] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:47:pipe A] fastset requirement not met in hw.active (expected yes, found no)
<7> [170.670534] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:47:pipe A] fastset requirement not met in cpu_transcoder (expected 0, found -1)
<7> [170.670974] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:47:pipe A] fastset requirement not met in has_pch_encoder (expected yes, found no)
<7> [170.671430] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:47:pipe A] fastset requirement not met in fdi_lanes (expected 2, found 0)
<7> [170.671868] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:47:pipe A] fastset requirement not met in fdi_m_n (expected tu 64 data 6920601/8388608 link 288358/524288, found tu 0, data 0/0 link 0/0)
<7> [170.672350] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:47:pipe A] fastset requirement not met in lane_count (expected 4, found 0)
<7> [170.672789] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:47:pipe A] fastset requirement not met in output_types (expected 0x00000040, found 0x00000000)
<7> [170.673294] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:47:pipe A] fastset requirement not met in framestart_delay (expected 1, found 0)
<7> [170.673716] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:47:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hdisplay (expected 1920, found 0)
<7> [170.674226] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:47:pipe A] fastset requirement not met in hw.pipe_mode.crtc_htotal (expected 2200, found 0)
<7> [170.674490] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:47:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hblank_start (expected 1920, found 0)
<7> [170.674702] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:47:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hblank_end (expected 2200, found 0)
<7> [170.674912] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:47:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hsync_start (expected 2008, found 0)
<7> [170.675122] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:47:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hsync_end (expected 2052, found 0)
<7> [170.675347] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:47:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vdisplay (expected 1080, found 0)
<7> [170.675558] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:47:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vblank_start (expected 1080, found 0)
<7> [170.675769] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:47:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vsync_start (expected 1084, found 0)
<7> [170.675979] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:47:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vsync_end (expected 1089, found 0)
<7> [170.676199] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:47:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vtotal (expected 1125, found 0)
<7> [170.676410] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:47:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vblank_end (expected 1125, found 0)
<7> [170.676621] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:47:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hdisplay (expected 1920, found 0)
<7> [170.676831] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:47:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_htotal (expected 2200, found 0)
<7> [170.677047] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:47:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hblank_start (expected 1920, found 0)
<7> [170.677276] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:47:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hblank_end (expected 2200, found 0)
<7> [170.677499] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:47:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hsync_start (expected 2008, found 0)
<7> [170.677704] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:47:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hsync_end (expected 2052, found 0)
<7> [170.677909] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:47:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vdisplay (expected 1080, found 0)
<7> [170.678142] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:47:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vblank_start (expected 1080, found 0)
<7> [170.678382] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:47:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vsync_start (expected 1084, found 0)
<7> [170.678587] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:47:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vsync_end (expected 1089, found 0)
<7> [170.678792] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:47:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vtotal (expected 1125, found 0)
<7> [170.678997] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:47:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vblank_end (expected 1125, found 0)
<7> [170.679228] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:47:pipe A] fastset requirement not met in pixel_multiplier (expected 1, found 0)
<7> [170.679467] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:47:pipe A] fastset requirement not met in hw.adjusted_mode.flags (1) (expected 1, found 0)
<7> [170.679685] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:47:pipe A] fastset requirement not met in hw.adjusted_mode.flags (4) (expected 4, found 0)
<7> [170.679895] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:47:pipe A] fastset requirement not met in has_hdmi_sink (expected yes, found no)
<7> [170.680115] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:47:pipe A] fastset requirement not met in has_infoframe (expected yes, found no)
<7> [170.680327] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:47:pipe A] fastset requirement not met in pipe_bpp (expected 24, found 0)
<7> [170.680538] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:47:pipe A] fastset requirement not met in hw.pipe_mode.crtc_clock (expected 148500, found 0)
<7> [170.680749] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:47:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_clock (expected 148500, found 0)
<7> [170.680960] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:47:pipe A] fastset requirement not met in port_clock (expected 148500, found 0)
<7> [170.681184] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:47:pipe A] fastset requirement not met in infoframes.enable (expected 0x00000071, found 0x00000000)
<7> [170.681396] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:47:pipe A] fastset requirement not met in avi infoframe
<7> [170.681606] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] expected:
<7> [170.681816] i915 0000:00:02.0: HDMI infoframe: Auxiliary Video Information (AVI), version 2, length 13
<7> [170.681819] i915 0000:00:02.0: colorspace: RGB
<7> [170.681821] i915 0000:00:02.0: scan mode: Underscan
<7> [170.681824] i915 0000:00:02.0: colorimetry: No Data
<7> [170.681826] i915 0000:00:02.0: picture aspect: 16:9
<7> [170.681828] i915 0000:00:02.0: active aspect: Same as Picture
<7> [170.681830] i915 0000:00:02.0: itc: No Data
<7> [170.681832] i915 0000:00:02.0: extended colorimetry: xvYCC 601
<7> [170.681835] i915 0000:00:02.0: quantization range: Default
<7> [170.681837] i915 0000:00:02.0: nups: Unknown Non-uniform Scaling
<7> [170.681839] i915 0000:00:02.0: video code: 16
<7> [170.681841] i915 0000:00:02.0: ycc quantization range: Full
<7> [170.681843] i915 0000:00:02.0: hdmi content type: Graphics
<7> [170.681845] i915 0000:00:02.0: pixel repeat: 0
<7> [170.681847] i915 0000:00:02.0: bar top 0, bottom 0, left 0, right 0
<7> [170.681850] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] found:
<7> [170.682076] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:47:pipe A] fastset requirement not met in spd infoframe
<7> [170.682287] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] expected:
<7> [170.682496] i915 0000:00:02.0: HDMI infoframe: Source Product Description (SPD), version 1, length 25
<7> [170.682499] i915 0000:00:02.0: vendor: Intel
<7> [170.682501] i915 0000:00:02.0: product: Integrated gfx
<7> [170.682504] i915 0000:00:02.0: source device information: PC General (0x9)
<7> [170.682506] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] found:
<7> [170.682716] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:47:pipe A] fastset requirement not met in hdmi infoframe
<7> [170.682936] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] expected:
<7> [170.683146] i915 0000:00:02.0: HDMI infoframe: Vendor, version 1, length 4
<7> [170.683148] i915 0000:00:02.0: empty frame
<7> [170.683151] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] found:
<7> [170.683361] i915 0000:00:02.0: [drm:intel_atomic_check [i915]] [CRTC:47:pipe A] fastset requirement not met, forcing full modeset
<7> [170.683574] i915 0000:00:02.0: [drm:intel_unreference_shared_dpll_crtc [i915]] [CRTC:47:pipe A] releasing PCH DPLL A
<7> [170.683846] i915 0000:00:02.0: [drm:intel_modeset_calc_cdclk [i915]] New cdclk calculated to be logical 400000 kHz, actual 400000 kHz
<7> [170.684114] i915 0000:00:02.0: [drm:intel_modeset_calc_cdclk [i915]] New voltage level calculated to be logical 0, actual 0
<7> [170.684333] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [CRTC:47:pipe A] enable: no [modeset]
<7> [170.684545] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:32:primary A] fb: [NOFB], visible: no
<7> [170.684791] i915 0000:00:02.0: [drm:intel_audio_codec_disable [i915]] [CONNECTOR:67:HDMI-A-1][ENCODER:66:HDMI D] Disable audio codec on [CRTC:47:pipe A]
<7> [170.713951] i915 0000:00:02.0: [drm:intel_audio_component_get_eld [i915]] Not valid for port D
<7> [170.714807] i915 0000:00:02.0: [drm:intel_disable_transcoder [i915]] disabling pipe A
<7> [170.732562] i915 0000:00:02.0: [drm:g4x_dp_port_enabled [i915]] No pipe for DP port B found
<7> [170.733015] i915 0000:00:02.0: [drm:g4x_dp_port_enabled [i915]] No pipe for DP port C found
<7> [170.733448] i915 0000:00:02.0: [drm:g4x_dp_port_enabled [i915]] No pipe for DP port D found
<7> [170.748393] i915 0000:00:02.0: [drm:intel_disable_shared_dpll [i915]] disable PCH DPLL A (active 0x1, on? 1) for [CRTC:47:pipe A]
<7> [170.748859] i915 0000:00:02.0: [drm:intel_disable_shared_dpll [i915]] disabling PCH DPLL A
<7> [170.749582] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:65:CRT]
<7> [170.749875] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:66:HDMI D]
<7> [170.750175] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:74:DP D]
<7> [170.750451] i915 0000:00:02.0: [drm:verify_connector_state [i915]] [CONNECTOR:67:HDMI-A-1]
<7> [170.750780] i915 0000:00:02.0: [drm:intel_modeset_verify_crtc [i915]] [CRTC:47:pipe A]
<7> [170.751288] i915 0000:00:02.0: [drm:drm_mode_setcrtc] [CRTC:63:pipe B]
<7> [170.751435] i915 0000:00:02.0: [drm:drm_mode_setcrtc] [CRTC:47:pipe A]
<7> [170.751460] i915 0000:00:02.0: [drm:drm_mode_setcrtc] [CONNECTOR:64:VGA-1]
<7> [170.751541] i915 0000:00:02.0: [drm:intel_atomic_check [i915]] [CONNECTOR:64:VGA-1] Limiting display bpp to 24 (EDID bpp 0, max requested bpp 0, max platform bpp 36)
<7> [170.751775] i915 0000:00:02.0: [drm:intel_atomic_check [i915]] [CRTC:47:pipe A] hw max bpp: 24, pipe bpp: 24, dithering: 0
<7> [170.752001] i915 0000:00:02.0: [drm:intel_fdi_atomic_check_link [i915]] checking fdi config on pipe A, lanes 1
<7> [170.752208] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:47:pipe A] fastset requirement not met in hw.enable (expected no, found yes)
<7> [170.752421] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:47:pipe A] fastset requirement not met in hw.active (expected no, found yes)
<7> [170.752632] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:47:pipe A] fastset requirement not met in cpu_transcoder (expected -1, found 0)
<7> [170.752844] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:47:pipe A] fastset requirement not met in has_pch_encoder (expected no, found yes)
<7> [170.753062] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:47:pipe A] fastset requirement not met in fdi_lanes (expected 0, found 1)
<7> [170.753273] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:47:pipe A] fastset requirement not met in fdi_m_n (expected tu 0 data 0/0 link 0/0, found tu 64, data 6039797/8388608 link 125829/524288)
<7> [170.753486] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:47:pipe A] fastset requirement not met in output_types (expected 0x00000000, found 0x00000002)
<7> [170.753696] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:47:pipe A] fastset requirement not met in framestart_delay (expected 0, found 1)
<7> [170.753922] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:47:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hdisplay (expected 0, found 1024)
<7> [170.754191] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:47:pipe A] fastset requirement not met in hw.pipe_mode.crtc_htotal (expected 0, found 1344)
<7> [170.754413] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:47:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hblank_start (expected 0, found 1024)
<7> [170.754645] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:47:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hblank_end (expected 0, found 1344)
<7> [170.754855] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:47:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hsync_start (expected 0, found 1048)
<7> [170.755085] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:47:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hsync_end (expected 0, found 1184)
<7> [170.755336] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:47:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vdisplay (expected 0, found 768)
<7> [170.755541] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:47:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vblank_start (expected 0, found 768)
<7> [170.755754] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:47:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vsync_start (expected 0, found 771)
<7> [170.756030] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:47:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vsync_end (expected 0, found 777)
<7> [170.756313] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:47:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vtotal (expected 0, found 806)
<7> [170.756531] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:47:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vblank_end (expected 0, found 806)
<7> [170.756741] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:47:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hdisplay (expected 0, found 1024)
<7> [170.756980] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:47:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_htotal (expected 0, found 1344)
<7> [170.757252] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:47:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hblank_start (expected 0, found 1024)
<7> [170.757457] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:47:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hblank_end (expected 0, found 1344)
<7> [170.757662] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:47:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hsync_start (expected 0, found 1048)
<7> [170.757911] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:47:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hsync_end (expected 0, found 1184)
<7> [170.758168] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:47:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vdisplay (expected 0, found 768)
<7> [170.758383] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:47:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vblank_start (expected 0, found 768)
<7> [170.758593] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:47:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vsync_start (expected 0, found 771)
<7> [170.758831] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:47:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vsync_end (expected 0, found 777)
<7> [170.759094] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:47:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vtotal (expected 0, found 806)
<7> [170.759299] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:47:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vblank_end (expected 0, found 806)
<7> [170.759504] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:47:pipe A] fastset requirement not met in pixel_multiplier (expected 0, found 1)
<7> [170.759770] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:47:pipe A] fastset requirement not met in hw.adjusted_mode.flags (2) (expected 0, found 2)
<7> [170.760127] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:47:pipe A] fastset requirement not met in hw.adjusted_mode.flags (8) (expected 0, found 8)
<7> [170.760341] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:47:pipe A] fastset requirement not met in dpll_hw_state
<7> [170.760551] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] expected:
<7> [170.760786] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] dpll_hw_state: dpll: 0xc4020002, dpll_md: 0x0, fp0: 0x21007, fp1: 0x21007
<7> [170.761048] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] found:
<7> [170.761258] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] dpll_hw_state: dpll: 0x84100010, dpll_md: 0x0, fp0: 0x10c09, fp1: 0x10c09
<7> [170.761469] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:47:pipe A] fastset requirement not met in pipe_bpp (expected 0, found 24)
<7> [170.761698] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:47:pipe A] fastset requirement not met in hw.pipe_mode.crtc_clock (expected 0, found 64800)
<7> [170.761934] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:47:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_clock (expected 0, found 64800)
<7> [170.762139] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:47:pipe A] fastset requirement not met in port_clock (expected 0, found 64800)
<7> [170.762358] i915 0000:00:02.0: [drm:intel_atomic_check [i915]] [CRTC:47:pipe A] fastset requirement not met, forcing full modeset
<7> [170.762623] i915 0000:00:02.0: [drm:intel_plane_calc_min_cdclk [i915]] [PLANE:32:primary A] min cdclk (64800 kHz) > [CRTC:47:pipe A] min cdclk (0 kHz)
<7> [170.762903] i915 0000:00:02.0: [drm:intel_modeset_calc_cdclk [i915]] New cdclk calculated to be logical 400000 kHz, actual 400000 kHz
<7> [170.763109] i915 0000:00:02.0: [drm:intel_modeset_calc_cdclk [i915]] New voltage level calculated to be logical 0, actual 0
<7> [170.763315] i915 0000:00:02.0: [drm:intel_find_shared_dpll [i915]] [CRTC:47:pipe A] allocated PCH DPLL A
<7> [170.763528] i915 0000:00:02.0: [drm:intel_reference_shared_dpll_crtc [i915]] [CRTC:47:pipe A] reserving PCH DPLL A
<7> [170.763840] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [CRTC:47:pipe A] enable: yes [modeset]
<7> [170.764115] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] active: yes, output_types: ANALOG (0x2), output format: RGB, sink format: RGB
<7> [170.764331] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] cpu_transcoder: A, pipe bpp: 24, dithering: 0
<7> [170.764541] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] MST master transcoder: <invalid>
<7> [170.764782] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] port sync: master transcoder: <invalid>, slave transcoder bitmask = 0x0
<7> [170.765038] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] joiner: no, pipes: 0x0
<7> [170.765248] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] splitter: disabled, link count 0, overlap 0
<7> [170.765458] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] fdi: lanes: 1; data_m: 6039797, data_n: 8388608, link_m: 125829, link_n: 524288, tu: 64
<7> [170.765740] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] audio: 0, infoframes: 0, infoframes enabled: 0x0
<7> [170.765990] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] scanline offset: 1
<7> [170.766194] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] vblank delay: 0, framestart delay: 1, MSA timing delay: 0
<7> [170.766407] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] vrr: no, vmin: 0, vmax: 0, flipline: 0, pipeline full: 0, guardband: 0 vsync start: 0, vsync end: 0
<7> [170.766637] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] vrr: vmin vblank: -1, vmax vblank: -2, vmin vtotal: 1, vmax vtotal: 0
<7> [170.766892] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] requested mode: "1024x768": 60 65000 1024 1048 1184 1344 768 771 777 806 0x40 0xa
<7> [170.767104] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] adjusted mode: "1024x768": 60 65000 1024 1048 1184 1344 768 771 777 806 0x40 0xa
<7> [170.767315] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] crtc timings: clock=64800, hd=1024 hb=1024-1344 hs=1048-1184 ht=1344, vd=768 vb=768-806 vs=771-777 vt=806, flags=0xa
<7> [170.767540] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pipe mode: "1024x768": 60 64800 1024 1048 1184 1344 768 771 777 806 0x40 0xa
<7> [170.767776] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] crtc timings: clock=64800, hd=1024 hb=1024-1344 hs=1048-1184 ht=1344, vd=768 vb=768-806 vs=771-777 vt=806, flags=0xa
<7> [170.767981] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] port clock: 64800, pipe src: 1024x768+0+0, pixel rate 64800
<7> [170.768197] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] linetime: 0, ips linetime: 0
<7> [170.768407] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pch pfit: 0x0+0+0, disabled, force thru: no
<7> [170.768510] i915 0000:00:02.0: [drm:intel_power_well_disable [i915]] disabling always-on
<7> [170.768715] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] ips: 0, double wide: 0, drrs: 0
<7> [170.769054] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] dpll_hw_state: dpll: 0x84100010, dpll_md: 0x0, fp0: 0x10c09, fp1: 0x10c09
<7> [170.769260] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] csc_mode: 0x3 gamma_mode: 0x0 gamma_enable: 0 csc_enable: 0
<7> [170.769493] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pre csc lut: 0 entries, post csc lut: 0 entries
<7> [170.769726] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pipe csc: pre offsets: 0x0000 0x0000 0x0000
<7> [170.769936] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pipe csc: coefficients: 0x0000 0x0000 0x0000
<7> [170.770147] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pipe csc: coefficients: 0x0000 0x0000 0x0000
<7> [170.770356] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pipe csc: coefficients: 0x0000 0x0000 0x0000
<7> [170.770645] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:32:primary A] fb: [FB:79] 1024x768 format = XR24 little-endian (0x34325258) modifier = 0x0, visible: yes
<7> [170.770898] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] rotation: 0x1, scaler: -1, scaling_filter: 0
<7> [170.771109] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] src: 1024.000000x768.000000+0.000000+0.000000 dst: 1024x768+0+0
<7> [170.772173] i915 0000:00:02.0: [drm:intel_power_well_enable [i915]] enabling always-on
<7> [170.772419] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:65:CRT]
<7> [170.772626] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:66:HDMI D]
<7> [170.772830] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:74:DP D]
<7> [170.773592] i915 0000:00:02.0: [drm:intel_enable_transcoder [i915]] enabling pipe A
<7> [170.774639] i915 0000:00:02.0: [drm:gen6_fdi_link_train [i915]] FDI_RX_IIR 0x100
<7> [170.774847] i915 0000:00:02.0: [drm:gen6_fdi_link_train [i915]] FDI train 1 done.
<7> [170.775714] i915 0000:00:02.0: [drm:gen6_fdi_link_train [i915]] FDI_RX_IIR 0x200
<7> [170.775926] i915 0000:00:02.0: [drm:gen6_fdi_link_train [i915]] FDI train 2 done.
<7> [170.776131] i915 0000:00:02.0: [drm:gen6_fdi_link_train [i915]] FDI train done.
<7> [170.776374] i915 0000:00:02.0: [drm:intel_enable_shared_dpll [i915]] enable PCH DPLL A (active 0x1, on? 0) for [CRTC:47:pipe A]
<7> [170.776606] i915 0000:00:02.0: [drm:intel_enable_shared_dpll [i915]] enabling PCH DPLL A
<7> [170.828604] i915 0000:00:02.0: [drm:verify_connector_state [i915]] [CONNECTOR:64:VGA-1]
<7> [170.829141] i915 0000:00:02.0: [drm:intel_modeset_verify_crtc [i915]] [CRTC:47:pipe A]
<7> [171.129950] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:84]
<7> [171.146358] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:79]
<7> [171.163080] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:83]
<7> [171.179785] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:84]
<7> [171.196491] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:79]
<7> [171.213133] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:83]
<7> [171.229951] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:84]
<7> [171.246671] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:79]
<7> [171.263402] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:83]
<7> [171.280076] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:84]
<7> [171.296751] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:79]
<7> [171.313473] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:83]
<7> [171.330245] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:84]
<7> [171.346971] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:79]
<7> [171.363664] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:83]
<7> [171.380330] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:84]
<7> [171.397114] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:79]
<7> [171.413816] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:83]
<7> [171.430475] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:84]
<7> [171.447277] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:79]
<7> [171.463984] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:83]
<7> [171.480653] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:84]
<7> [171.497420] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:79]
<7> [171.514123] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:83]
<7> [171.530818] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:84]
<7> [171.547531] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:79]
<7> [171.564282] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:83]
<7> [171.581043] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:84]
<7> [171.597672] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:79]
<7> [171.614340] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:83]
<7> [171.631106] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:84]
<7> [171.647769] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:79]
<7> [171.664493] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:83]
<7> [171.681172] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:84]
<7> [171.697989] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:79]
<7> [171.714688] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:83]
<7> [171.731376] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:84]
<7> [171.748018] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:79]
<7> [171.764777] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:83]
<7> [171.781397] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:84]
<7> [171.798116] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:79]
<7> [171.814836] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:83]
<7> [171.831730] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:84]
<7> [171.848419] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:79]
<7> [171.865090] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:83]
<7> [171.881852] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:84]
<7> [171.898566] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:79]
<7> [171.915260] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:83]
<7> [171.931998] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:84]
<7> [171.948727] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:79]
<7> [171.965446] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:83]
<7> [171.982106] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:84]
<7> [171.998795] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:79]
<7> [172.015567] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:83]
<7> [172.032301] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:84]
<7> [172.049016] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:79]
<7> [172.065680] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:83]
<7> [172.082457] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:84]
<7> [172.099144] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:79]
<7> [172.115769] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:83]
<7> [172.132564] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:84]
<7> [172.149287] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:79]
<7> [172.166042] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:83]
<7> [172.182731] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:84]
<7> [172.199455] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:79]
<7> [172.216217] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:83]
<7> [172.232823] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:84]
<7> [172.249628] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:79]
<7> [172.266345] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:83]
<7> [172.283102] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:84]
<7> [172.299764] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:79]
<7> [172.316517] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:83]
<7> [172.333207] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:84]
<7> [172.349884] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:79]
<7> [172.366680] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:83]
<7> [172.383350] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:84]
<6> [175.368598] [IGT] kms_flip: finished subtest A-VGA1, FAIL
Created at 2025-03-10 14:28:02