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

Machine description: shard-snb4

Result: Fail

integration-manifest git-log-oneline i915_display_info22 igt_runner22 run22 runtimes22 results22.json i915_display_info_post_exec22 boot22 dmesg22

DetailValue
Duration 4.63 seconds
Hostname
shard-snb4
Igt-Version
IGT-Version: 1.29-NO-GIT (x86_64) (Linux: 6.12.0-CI_DRM_15732-g2d0d734c211b+ x86_64)
Out
Using IGT_SRANDOM=1732307354 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 17174.5us +- 3.670us accuracy 0.06%
vblank interval differs from modeline! expected 16665.6us, measured 17175us +- 3.670us, difference 508.9us (138.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-VGA1: FAIL (4.632s)
Err
Starting subtest: plain-flip-fb-recreate
Starting dynamic subtest: A-VGA1
(kms_flip:2117) CRITICAL: Test assertion failure function __run_test_on_crtc_set, file ../tests/kms_flip.c:1674:
(kms_flip:2117) CRITICAL: Failed assertion: !retried && needs_retry_after_link_reset(mon)
Dynamic subtest A-VGA1 failed.
**** DEBUG ****
(kms_flip:2117) igt_fb-DEBUG: igt_create_fb_with_bo_size(width=1024, height=768, format=XR24(0x34325258), modifier=0x0, size=0)
(kms_flip:2117) igt_fb-DEBUG: igt_create_fb_with_bo_size(handle=1, pitch=4096)
(kms_flip:2117) ioctl_wrappers-DEBUG: Test requirement passed: igt_has_fb_modifiers(fd)
(kms_flip:2117) igt_fb-DEBUG: igt_create_fb_with_bo_size(width=1024, height=768, format=XR24(0x34325258), modifier=0x0, size=0)
(kms_flip:2117) igt_fb-DEBUG: igt_create_fb_with_bo_size(handle=2, pitch=4096)
(kms_flip:2117) ioctl_wrappers-DEBUG: Test requirement passed: igt_has_fb_modifiers(fd)
(kms_flip:2117) intel_blt-DEBUG: Test requirement passed: cmds_info
(kms_flip:2117) intel_blt-DEBUG: Test requirement passed: cmds_info
(kms_flip:2117) igt_fb-DEBUG: Test requirement passed: cairo_surface_status(fb->cairo_surface) == CAIRO_STATUS_SUCCESS
(kms_flip:2117) intel_blt-DEBUG: Test requirement passed: cmds_info
(kms_flip:2117) intel_blt-DEBUG: Test requirement passed: cmds_info
(kms_flip:2117) igt_fb-DEBUG: Test requirement passed: cairo_surface_status(fb->cairo_surface) == CAIRO_STATUS_SUCCESS
(kms_flip:2117) igt_kms-INFO:   1024x768: 60 65000 1024 1048 1184 1344 768 771 777 806 0x40 0xa 
(kms_flip:2117) DEBUG: No stale events found
(kms_flip:2117) i915/intel_drrs-DEBUG: Manually disabling DRRS. 0
(kms_flip:2117) i915/intel_drrs-DEBUG: Test requirement passed: dir >= 0
(kms_flip:2117) INFO: Expected frametime: 16666us; measured 17174.5us +- 3.670us accuracy 0.06%
(kms_flip:2117) INFO: vblank interval differs from modeline! expected 16665.6us, measured 17175us +- 3.670us, difference 508.9us (138.7 sigma)
(kms_flip:2117) DEBUG: name = flip
last_ts = 0.000000
last_received_ts = 0.000000
last_seq = 0
current_ts = 186.441086
current_received_ts = 186.440506
current_seq = 671
count = 0
seq_step = 1
(kms_flip:2117) DEBUG: name = flip
last_ts = 186.441086
last_received_ts = 186.440506
last_seq = 671
current_ts = 186.458267
current_received_ts = 186.457626
current_seq = 672
count = 1
seq_step = 1
(kms_flip:2117) DEBUG: flip ts/seq: last 186.441086/671, current 186.458267/672: elapsed=17180.0us expected=17174.5us +- 85.9us, error 0.0%
(kms_flip:2117) DEBUG: name = flip
last_ts = 186.458267
last_received_ts = 186.457626
last_seq = 672
current_ts = 186.475433
current_received_ts = 186.474854
current_seq = 673
count = 2
seq_step = 1
(kms_flip:2117) DEBUG: flip ts/seq: last 186.458267/672, current 186.475433/673: elapsed=17169.0us expected=17174.5us +- 85.9us, error 0.0%
(kms_flip:2117) DEBUG: name = flip
last_ts = 186.475433
last_received_ts = 186.474854
last_seq = 673
current_ts = 186.492615
current_received_ts = 186.492050
current_seq = 674
count = 3
seq_step = 1
(kms_flip:2117) DEBUG: flip ts/seq: last 186.475433/673, current 186.492615/674: elapsed=17175.0us expected=17174.5us +- 85.9us, error 0.0%
(kms_flip:2117) DEBUG: name = flip
last_ts = 186.492615
last_received_ts = 186.492050
last_seq = 674
current_ts = 186.509796
current_received_ts = 186.509186
current_seq = 675
count = 4
seq_step = 1
(kms_flip:2117) DEBUG: flip ts/seq: last 186.492615/674, current 186.509796/675: elapsed=17184.0us expected=17174.5us +- 85.9us, error 0.1%
(kms_flip:2117) DEBUG: name = flip
last_ts = 186.509796
last_received_ts = 186.509186
last_seq = 675
current_ts = 186.526978
current_received_ts = 186.526321
current_seq = 676
count = 5
seq_step = 1
(kms_flip:2117) DEBUG: flip ts/seq: last 186.509796/675, current 186.526978/676: elapsed=17178.0us expected=17174.5us +- 85.9us, error 0.0%
(kms_flip:2117) DEBUG: name = flip
last_ts = 186.526978
last_received_ts = 186.526321
last_seq = 676
current_ts = 186.544144
current_received_ts = 186.543533
current_seq = 677
count = 6
seq_step = 1
(kms_flip:2117) DEBUG: flip ts/seq: last 186.526978/676, current 186.544144/677: elapsed=17166.0us expected=17174.5us +- 85.9us, error 0.0%
(kms_flip:2117) DEBUG: name = flip
last_ts = 186.544144
last_received_ts = 186.543533
last_seq = 677
current_ts = 186.561310
current_received_ts = 186.560715
current_seq = 678
count = 7
seq_step = 1
(kms_flip:2117) DEBUG: flip ts/seq: last 186.544144/677, current 186.561310/678: elapsed=17172.0us expected=17174.5us +- 85.9us, error 0.0%
(kms_flip:2117) DEBUG: name = flip
last_ts = 186.561310
last_received_ts = 186.560715
last_seq = 678
current_ts = 186.578491
current_received_ts = 186.577866
current_seq = 679
count = 8
seq_step = 1
(kms_flip:2117) DEBUG: flip ts/seq: last 186.561310/678, current 186.578491/679: elapsed=17182.0us expected=17174.5us +- 85.9us, error 0.0%
(kms_flip:2117) DEBUG: name = flip
last_ts = 186.578491
last_received_ts = 186.577866
last_seq = 679
current_ts = 186.595642
current_received_ts = 186.595078
current_seq = 680
count = 9
seq_step = 1
(kms_flip:2117) DEBUG: flip ts/seq: last 186.578491/679, current 186.595642/680: elapsed=17151.0us expected=17174.5us +- 85.9us, error 0.1%
(kms_flip:2117) DEBUG: name = flip
last_ts = 186.595642
last_received_ts = 186.595078
last_seq = 680
current_ts = 186.612762
current_received_ts = 186.612167
current_seq = 681
count = 10
seq_step = 1
(kms_flip:2117) DEBUG: flip ts/seq: last 186.595642/680, current 186.612762/681: elapsed=17115.0us expected=17174.5us +- 85.9us, error 0.3%
(kms_flip:2117) DEBUG: name = flip
last_ts = 186.612762
last_received_ts = 186.612167
last_seq = 681
current_ts = 186.629898
current_received_ts = 186.629242
current_seq = 682
count = 11
seq_step = 1
(kms_flip:2117) DEBUG: flip ts/seq: last 186.612762/681, current 186.629898/682: elapsed=17137.0us expected=17174.5us +- 85.9us, error 0.2%
(kms_flip:2117) DEBUG: name = flip
last_ts = 186.629898
last_received_ts = 186.629242
last_seq = 682
current_ts = 186.647003
current_received_ts = 186.646378
current_seq = 683
count = 12
seq_step = 1
(kms_flip:2117) DEBUG: flip ts/seq: last 186.629898/682, current 186.647003/683: elapsed=17105.0us expected=17174.5us +- 85.9us, error 0.4%
(kms_flip:2117) DEBUG: name = flip
last_ts = 186.647003
last_received_ts = 186.646378
last_seq = 683
current_ts = 186.664124
current_received_ts = 186.663498
current_seq = 684
count = 13
seq_step = 1
(kms_flip:2117) DEBUG: flip ts/seq: last 186.647003/683, current 186.664124/684: elapsed=17124.0us expected=17174.5us +- 85.9us, error 0.3%
(kms_flip:2117) DEBUG: name = flip
last_ts = 186.664124
last_received_ts = 186.663498
last_seq = 684
current_ts = 186.681244
current_received_ts = 186.680618
current_seq = 685
count = 14
seq_step = 1
(kms_flip:2117) DEBUG: flip ts/seq: last 186.664124/684, current 186.681244/685: elapsed=17112.0us expected=17174.5us +- 85.9us, error 0.4%
(kms_flip:2117) DEBUG: name = flip
last_ts = 186.681244
last_received_ts = 186.680618
last_seq = 685
current_ts = 186.698364
current_received_ts = 186.697769
current_seq = 686
count = 15
seq_step = 1
(kms_flip:2117) DEBUG: flip ts/seq: last 186.681244/685, current 186.698364/686: elapsed=17121.0us expected=17174.5us +- 85.9us, error 0.3%
(kms_flip:2117) DEBUG: name = flip
last_ts = 186.698364
last_received_ts = 186.697769
last_seq = 686
current_ts = 186.715485
current_received_ts = 186.714874
current_seq = 687
count = 16
seq_step = 1
(kms_flip:2117) DEBUG: flip ts/seq: last 186.698364/686, current 186.715485/687: elapsed=17119.0us expected=17174.5us +- 85.9us, error 0.3%
(kms_flip:2117) DEBUG: name = flip
last_ts = 186.715485
last_received_ts = 186.714874
last_seq = 687
current_ts = 186.732590
current_received_ts = 186.731995
current_seq = 688
count = 17
seq_step = 1
(kms_flip:2117) DEBUG: flip ts/seq: last 186.715485/687, current 186.732590/688: elapsed=17114.0us expected=17174.5us +- 85.9us, error 0.4%
(kms_flip:2117) DEBUG: name = flip
last_ts = 186.732590
last_received_ts = 186.731995
last_seq = 688
current_ts = 186.749710
current_received_ts = 186.749130
current_seq = 689
count = 18
seq_step = 1
(kms_flip:2117) DEBUG: flip ts/seq: last 186.732590/688, current 186.749710/689: elapsed=17121.0us expected=17174.5us +- 85.9us, error 0.3%
(kms_flip:2117) DEBUG: name = flip
last_ts = 186.749710
last_received_ts = 186.749130
last_seq = 689
current_ts = 186.766830
current_received_ts = 186.766251
current_seq = 690
count = 19
seq_step = 1
(kms_flip:2117) DEBUG: flip ts/seq: last 186.749710/689, current 186.766830/690: elapsed=17122.0us expected=17174.5us +- 85.9us, error 0.3%
(kms_flip:2117) DEBUG: name = flip
last_ts = 186.766830
last_received_ts = 186.766251
last_seq = 690
current_ts = 186.783951
current_received_ts = 186.783356
current_seq = 691
count = 20
seq_step = 1
(kms_flip:2117) DEBUG: flip ts/seq: last 186.766830/690, current 186.783951/691: elapsed=17114.0us expected=17174.5us +- 85.9us, error 0.4%
(kms_flip:2117) DEBUG: name = flip
last_ts = 186.783951
last_received_ts = 186.783356
last_seq = 691
current_ts = 186.801071
current_received_ts = 186.800461
current_seq = 692
count = 21
seq_step = 1
(kms_flip:2117) DEBUG: flip ts/seq: last 186.783951/691, current 186.801071/692: elapsed=17119.0us expected=17174.5us +- 85.9us, error 0.3%
(kms_flip:2117) DEBUG: name = flip
last_ts = 186.801071
last_received_ts = 186.800461
last_seq = 692
current_ts = 186.818192
current_received_ts = 186.817566
current_seq = 693
count = 22
seq_step = 1
(kms_flip:2117) DEBUG: flip ts/seq: last 186.801071/692, current 186.818192/693: elapsed=17116.0us expected=17174.5us +- 85.9us, error 0.3%
(kms_flip:2117) DEBUG: name = flip
last_ts = 186.818192
last_received_ts = 186.817566
last_seq = 693
current_ts = 186.835312
current_received_ts = 186.834656
current_seq = 694
count = 23
seq_step = 1
(kms_flip:2117) DEBUG: flip ts/seq: last 186.818192/693, current 186.835312/694: elapsed=17124.0us expected=17174.5us +- 85.9us, error 0.3%
(kms_flip:2117) DEBUG: name = flip
last_ts = 186.835312
last_received_ts = 186.834656
last_seq = 694
current_ts = 186.852432
current_received_ts = 186.851761
current_seq = 695
count = 24
seq_step = 1
(kms_flip:2117) DEBUG: flip ts/seq: last 186.835312/694, current 186.852432/695: elapsed=17128.0us expected=17174.5us +- 85.9us, error 0.3%
(kms_flip:2117) DEBUG: name = flip
last_ts = 186.852432
last_received_ts = 186.851761
last_seq = 695
current_ts = 186.869537
current_received_ts = 186.868958
current_seq = 696
count = 25
seq_step = 1
(kms_flip:2117) DEBUG: flip ts/seq: last 186.852432/695, current 186.869537/696: elapsed=17108.0us expected=17174.5us +- 85.9us, error 0.4%
(kms_flip:2117) DEBUG: name = flip
last_ts = 186.869537
last_received_ts = 186.868958
last_seq = 696
current_ts = 186.886658
current_received_ts = 186.886078
current_seq = 697
count = 26
seq_step = 1
(kms_flip:2117) DEBUG: flip ts/seq: last 186.869537/696, current 186.886658/697: elapsed=17117.0us expected=17174.5us +- 85.9us, error 0.3%
(kms_flip:2117) DEBUG: name = flip
last_ts = 186.886658
last_received_ts = 186.886078
last_seq = 697
current_ts = 186.903793
current_received_ts = 186.903183
current_seq = 698
count = 27
seq_step = 1
(kms_flip:2117) DEBUG: flip ts/seq: last 186.886658/697, current 186.903793/698: elapsed=17134.0us expected=17174.5us +- 85.9us, error 0.2%
(kms_flip:2117) DEBUG: name = flip
last_ts = 186.903793
last_received_ts = 186.903183
last_seq = 698
current_ts = 186.920898
current_received_ts = 186.920197
current_seq = 699
count = 28
seq_step = 1
(kms_flip:2117) DEBUG: flip ts/seq: last 186.903793/698, current 186.920898/699: elapsed=17110.0us expected=17174.5us +- 85.9us, error 0.4%
(kms_flip:2117) DEBUG: name = flip
last_ts = 186.920898
last_received_ts = 186.920197
last_seq = 699
current_ts = 186.938034
current_received_ts = 186.937317
current_seq = 700
count = 29
seq_step = 1
(kms_flip:2117) DEBUG: flip ts/seq: last 186.920898/699, current 186.938034/700: elapsed=17125.0us expected=17174.5us +- 85.9us, error 0.3%
(kms_flip:2117) DEBUG: name = flip
last_ts = 186.938034
last_received_ts = 186.937317
last_seq = 700
current_ts = 186.955154
current_received_ts = 186.954453
current_seq = 701
count = 30
seq_step = 1
(kms_flip:2117) DEBUG: flip ts/seq: last 186.938034/700, current 186.955154/701: elapsed=17119.0us expected=17174.5us +- 85.9us, error 0.3%
(kms_flip:2117) DEBUG: name = flip
last_ts = 186.955154
last_received_ts = 186.954453
last_seq = 701
current_ts = 186.972260
current_received_ts = 186.971573
current_seq = 702
count = 31
seq_step = 1
(kms_flip:2117) DEBUG: flip ts/seq: last 186.955154/701, current 186.972260/702: elapsed=17118.0us expected=17174.5us +- 85.9us, error 0.3%
(kms_flip:2117) DEBUG: name = flip
last_ts = 186.972260
last_received_ts = 186.971573
last_seq = 702
current_ts = 186.989380
current_received_ts = 186.988693
current_seq = 703
count = 32
seq_step = 1
(kms_flip:2117) DEBUG: flip ts/seq: last 186.972260/702, current 186.989380/703: elapsed=17119.0us expected=17174.5us +- 85.9us, error 0.3%
(kms_flip:2117) DEBUG: name = flip
last_ts = 186.989380
last_received_ts = 186.988693
last_seq = 703
current_ts = 187.006500
current_received_ts = 187.005814
current_seq = 704
count = 33
seq_step = 1
(kms_flip:2117) DEBUG: flip ts/seq: last 186.989380/703, current 187.006500/704: elapsed=17118.0us expected=17174.5us +- 85.9us, error 0.3%
(kms_flip:2117) DEBUG: name = flip
last_ts = 187.006500
last_received_ts = 187.005814
last_seq = 704
current_ts = 187.023621
current_received_ts = 187.022949
current_seq = 705
count = 34
seq_step = 1
(kms_flip:2117) DEBUG: flip ts/seq: last 187.006500/704, current 187.023621/705: elapsed=17118.0us expected=17174.5us +- 85.9us, error 0.3%
(kms_flip:2117) DEBUG: name = flip
last_ts = 187.023621
last_received_ts = 187.022949
last_seq = 705
current_ts = 187.040741
current_received_ts = 187.040085
current_seq = 706
count = 35
seq_step = 1
(kms_flip:2117) DEBUG: flip ts/seq: last 187.023621/705, current 187.040741/706: elapsed=17120.0us expected=17174.5us +- 85.9us, error 0.3%
(kms_flip:2117) DEBUG: name = flip
last_ts = 187.040741
last_received_ts = 187.040085
last_seq = 706
current_ts = 187.057861
current_received_ts = 187.057159
current_seq = 707
count = 36
seq_step = 1
(kms_flip:2117) DEBUG: flip ts/seq: last 187.040741/706, current 187.057861/707: elapsed=17114.0us expected=17174.5us +- 85.9us, error 0.4%
(kms_flip:2117) DEBUG: name = flip
last_ts = 187.057861
last_received_ts = 187.057159
last_seq = 707
current_ts = 187.074982
current_received_ts = 187.074295
current_seq = 708
count = 37
seq_step = 1
(kms_flip:2117) DEBUG: flip ts/seq: last 187.057861/707, current 187.074982/708: elapsed=17124.0us expected=17174.5us +- 85.9us, error 0.3%
(kms_flip:2117) DEBUG: name = flip
last_ts = 187.074982
last_received_ts = 187.074295
last_seq = 708
current_ts = 187.092102
current_received_ts = 187.091415
current_seq = 709
count = 38
seq_step = 1
(kms_flip:2117) DEBUG: flip ts/seq: last 187.074982/708, current 187.092102/709: elapsed=17118.0us expected=17174.5us +- 85.9us, error 0.3%
(kms_flip:2117) DEBUG: name = flip
last_ts = 187.092102
last_received_ts = 187.091415
last_seq = 709
current_ts = 187.109222
current_received_ts = 187.108536
current_seq = 710
count = 39
seq_step = 1
(kms_flip:2117) DEBUG: flip ts/seq: last 187.092102/709, current 187.109222/710: elapsed=17119.0us expected=17174.5us +- 85.9us, error 0.3%
(kms_flip:2117) DEBUG: name = flip
last_ts = 187.109222
last_received_ts = 187.108536
last_seq = 710
current_ts = 187.126328
current_received_ts = 187.125641
current_seq = 711
count = 40
seq_step = 1
(kms_flip:2117) DEBUG: flip ts/seq: last 187.109222/710, current 187.126328/711: elapsed=17117.0us expected=17174.5us +- 85.9us, error 0.3%
(kms_flip:2117) DEBUG: name = flip
last_ts = 187.126328
last_received_ts = 187.125641
last_seq = 711
current_ts = 187.143448
current_received_ts = 187.142776
current_seq = 712
count = 41
seq_step = 1
(kms_flip:2117) DEBUG: flip ts/seq: last 187.126328/711, current 187.143448/712: elapsed=17120.0us expected=17174.5us +- 85.9us, error 0.3%
(kms_flip:2117) DEBUG: name = flip
last_ts = 187.143448
last_received_ts = 187.142776
last_seq = 712
current_ts = 187.160568
current_received_ts = 187.159897
current_seq = 713
count = 42
seq_step = 1
(kms_flip:2117) DEBUG: flip ts/seq: last 187.143448/712, current 187.160568/713: elapsed=17118.0us expected=17174.5us +- 85.9us, error 0.3%
(kms_flip:2117) DEBUG: name = flip
last_ts = 187.160568
last_received_ts = 187.159897
last_seq = 713
current_ts = 187.177689
current_received_ts = 187.177063
current_seq = 714
count = 43
seq_step = 1
(kms_flip:2117) DEBUG: flip ts/seq: last 187.160568/713, current 187.177689/714: elapsed=17121.0us expected=17174.5us +- 85.9us, error 0.3%
(kms_flip:2117) DEBUG: name = flip
last_ts = 187.177689
last_received_ts = 187.177063
last_seq = 714
current_ts = 187.194794
current_received_ts = 187.194168
current_seq = 715
count = 44
seq_step = 1
(kms_flip:2117) DEBUG: flip ts/seq: last 187.177689/714, current 187.194794/715: elapsed=17107.0us expected=17174.5us +- 85.9us, error 0.4%
(kms_flip:2117) DEBUG: name = flip
last_ts = 187.194794
last_received_ts = 187.194168
last_seq = 715
current_ts = 187.211929
current_received_ts = 187.211258
current_seq = 716
count = 45
seq_step = 1
(kms_flip:2117) DEBUG: flip ts/seq: last 187.194794/715, current 187.211929/716: elapsed=17129.0us expected=17174.5us +- 85.9us, error 0.3%
(kms_flip:2117) DEBUG: name = flip
last_ts = 187.211929
last_received_ts = 187.211258
last_seq = 716
current_ts = 187.229050
current_received_ts = 187.228394
current_seq = 717
count = 46
seq_step = 1
(kms_flip:2117) DEBUG: flip ts/seq: last 187.211929/716, current 187.229050/717: elapsed=17119.0us expected=17174.5us +- 85.9us, error 0.3%
(kms_flip:2117) DEBUG: name = flip
last_ts = 187.229050
last_received_ts = 187.228394
last_seq = 717
current_ts = 187.246170
current_received_ts = 187.245468
current_seq = 718
count = 47
seq_step = 1
(kms_flip:2117) DEBUG: flip ts/seq: last 187.229050/717, current 187.246170/718: elapsed=17118.0us expected=17174.5us +- 85.9us, error 0.3%
(kms_flip:2117) DEBUG: name = flip
last_ts = 187.246170
last_received_ts = 187.245468
last_seq = 718
current_ts = 187.263275
current_received_ts = 187.262741
current_seq = 719
count = 48
seq_step = 1
(kms_flip:2117) DEBUG: flip ts/seq: last 187.246170/718, current 187.263275/719: elapsed=17113.0us expected=17174.5us +- 85.9us, error 0.4%
(kms_flip:2117) DEBUG: name = flip
last_ts = 187.263275
last_received_ts = 187.262741
last_seq = 719
current_ts = 187.280396
current_received_ts = 187.279800
current_seq = 720
count = 49
seq_step = 1
(kms_flip:2117) DEBUG: flip ts/seq: last 187.263275/719, current 187.280396/720: elapsed=17115.0us expected=17174.5us +- 85.9us, error 0.3%
(kms_flip:2117) DEBUG: name = flip
last_ts = 187.280396
last_received_ts = 187.279800
last_seq = 720
current_ts = 187.297501
current_received_ts = 187.296890
current_seq = 721
count = 50
seq_step = 1
(kms_flip:2117) DEBUG: flip ts/seq: last 187.280396/720, current 187.297501/721: elapsed=17110.0us expected=17174.5us +- 85.9us, error 0.4%
(kms_flip:2117) DEBUG: name = flip
last_ts = 187.297501
last_received_ts = 187.296890
last_seq = 721
current_ts = 187.314636
current_received_ts = 187.314072
current_seq = 722
count = 51
seq_step = 1
(kms_flip:2117) DEBUG: flip ts/seq: last 187.297501/721, current 187.314636/722: elapsed=17128.0us expected=17174.5us +- 85.9us, error 0.3%
(kms_flip:2117) DEBUG: name = flip
last_ts = 187.314636
last_received_ts = 187.314072
last_seq = 722
current_ts = 187.331757
current_received_ts = 187.331161
current_seq = 723
count = 52
seq_step = 1
(kms_flip:2117) DEBUG: flip ts/seq: last 187.314636/722, current 187.331757/723: elapsed=17125.0us expected=17174.5us +- 85.9us, error 0.3%
(kms_flip:2117) DEBUG: name = flip
last_ts = 187.331757
last_received_ts = 187.331161
last_seq = 723
current_ts = 187.348877
current_received_ts = 187.348221
current_seq = 724
count = 53
seq_step = 1
(kms_flip:2117) DEBUG: flip ts/seq: last 187.331757/723, current 187.348877/724: elapsed=17121.0us expected=17174.5us +- 85.9us, error 0.3%
(kms_flip:2117) DEBUG: name = flip
last_ts = 187.348877
last_received_ts = 187.348221
last_seq = 724
current_ts = 187.365982
current_received_ts = 187.365402
current_seq = 725
count = 54
seq_step = 1
(kms_flip:2117) DEBUG: flip ts/seq: last 187.348877/724, current 187.365982/725: elapsed=17105.0us expected=17174.5us +- 85.9us, error 0.4%
(kms_flip:2117) DEBUG: name = flip
last_ts = 187.365982
last_received_ts = 187.365402
last_seq = 725
current_ts = 187.383102
current_received_ts = 187.382523
current_seq = 726
count = 55
seq_step = 1
(kms_flip:2117) DEBUG: flip ts/seq: last 187.365982/725, current 187.383102/726: elapsed=17124.0us expected=17174.5us +- 85.9us, error 0.3%
(kms_flip:2117) DEBUG: name = flip
last_ts = 187.383102
last_received_ts = 187.382523
last_seq = 726
current_ts = 187.400223
current_received_ts = 187.399628
current_seq = 727
count = 56
seq_step = 1
(kms_flip:2117) DEBUG: flip ts/seq: last 187.383102/726, current 187.400223/727: elapsed=17114.0us expected=17174.5us +- 85.9us, error 0.4%
(kms_flip:2117) DEBUG: name = flip
last_ts = 187.400223
last_received_ts = 187.399628
last_seq = 727
current_ts = 187.417343
current_received_ts = 187.416702
current_seq = 728
count = 57
seq_step = 1
(kms_flip:2117) DEBUG: flip ts/seq: last 187.400223/727, current 187.417343/728: elapsed=17119.0us expected=17174.5us +- 85.9us, error 0.3%
(kms_flip:2117) DEBUG: name = flip
last_ts = 187.417343
last_received_ts = 187.416702
last_seq = 728
current_ts = 187.434464
current_received_ts = 187.433823
current_seq = 729
count = 58
seq_step = 1
(kms_flip:2117) DEBUG: flip ts/seq: last 187.417343/728, current 187.434464/729: elapsed=17131.0us expected=17174.5us +- 85.9us, error 0.3%
(kms_flip:2117) DEBUG: name = flip
last_ts = 187.434464
last_received_ts = 187.433823
last_seq = 729
current_ts = 187.451569
current_received_ts = 187.450989
current_seq = 730
count = 59
seq_step = 1
(kms_flip:2117) DEBUG: flip ts/seq: last 187.434464/729, current 187.451569/730: elapsed=17105.0us expected=17174.5us +- 85.9us, error 0.4%
(kms_flip:2117) DEBUG: name = flip
last_ts = 187.451569
last_received_ts = 187.450989
last_seq = 730
current_ts = 187.468689
current_received_ts = 187.468109
current_seq = 731
count = 60
seq_step = 1
(kms_flip:2117) DEBUG: flip ts/seq: last 187.451569/730, current 187.468689/731: elapsed=17119.0us expected=17174.5us +- 85.9us, error 0.3%
(kms_flip:2117) DEBUG: name = flip
last_ts = 187.468689
last_received_ts = 187.468109
last_seq = 731
current_ts = 187.485825
current_received_ts = 187.485184
current_seq = 732
count = 61
seq_step = 1
(kms_flip:2117) DEBUG: flip ts/seq: last 187.468689/731, current 187.485825/732: elapsed=17124.0us expected=17174.5us +- 85.9us, error 0.3%
(kms_flip:2117) DEBUG: name = flip
last_ts = 187.485825
last_received_ts = 187.485184
last_seq = 732
current_ts = 187.502930
current_received_ts = 187.502350
current_seq = 733
count = 62
seq_step = 1
(kms_flip:2117) DEBUG: flip ts/seq: last 187.485825/732, current 187.502930/733: elapsed=17118.0us expected=17174.5us +- 85.9us, error 0.3%
(kms_flip:2117) DEBUG: name = flip
last_ts = 187.502930
last_received_ts = 187.502350
last_seq = 733
current_ts = 187.520065
current_received_ts = 187.519455
current_seq = 734
count = 63
seq_step = 1
(kms_flip:2117) DEBUG: flip ts/seq: last 187.502930/733, current 187.520065/734: elapsed=17123.0us expected=17174.5us +- 85.9us, error 0.3%
(kms_flip:2117) DEBUG: name = flip
last_ts = 187.520065
last_received_ts = 187.519455
last_seq = 734
current_ts = 187.537170
current_received_ts = 187.536560
current_seq = 735
count = 64
seq_step = 1
(kms_flip:2117) DEBUG: flip ts/seq: last 187.520065/734, current 187.537170/735: elapsed=17110.0us expected=17174.5us +- 85.9us, error 0.4%
(kms_flip:2117) DEBUG: name = flip
last_ts = 187.537170
last_received_ts = 187.536560
last_seq = 735
current_ts = 187.554291
current_received_ts = 187.553665
current_seq = 736
count = 65
seq_step = 1
(kms_flip:2117) DEBUG: flip ts/seq: last 187.537170/735, current 187.554291/736: elapsed=17120.0us expected=17174.5us +- 85.9us, error 0.3%
(kms_flip:2117) DEBUG: name = flip
last_ts = 187.554291
last_received_ts = 187.553665
last_seq = 736
current_ts = 187.571411
current_received_ts = 187.570770
current_seq = 737
count = 66
seq_step = 1
(kms_flip:2117) DEBUG: flip ts/seq: last 187.554291/736, current 187.571411/737: elapsed=17118.0us expected=17174.5us +- 85.9us, error 0.3%
(kms_flip:2117) DEBUG: name = flip
last_ts = 187.571411
last_received_ts = 187.570770
last_seq = 737
current_ts = 187.588531
current_received_ts = 187.587936
current_seq = 738
count = 67
seq_step = 1
(kms_flip:2117) DEBUG: flip ts/seq: last 187.571411/737, current 187.588531/738: elapsed=17119.0us expected=17174.5us +- 85.9us, error 0.3%
(kms_flip:2117) DEBUG: name = flip
last_ts = 187.588531
last_received_ts = 187.587936
last_seq = 738
current_ts = 187.605621
current_received_ts = 187.605026
current_seq = 739
count = 68
seq_step = 1
(kms_flip:2117) DEBUG: flip ts/seq: last 187.588531/738, current 187.605621/739: elapsed=17088.0us expected=17174.5us +- 85.9us, error 0.5%
(kms_flip:2117) DEBUG: inconsistent flip ts/seq: last 187.588531/738, current 187.605621/739: elapsed=17088.0us expected=17174.5us
(kms_flip:2117) DEBUG: expected 65281, counted 68, encoder type 1
(kms_flip:2117) DEBUG: dropped frames, expected 65281, counted 68, encoder type 1
(kms_flip:2117) CRITICAL: Test assertion failure function __run_test_on_crtc_set, file ../tests/kms_flip.c:1674:
(kms_flip:2117) CRITICAL: Failed assertion: !retried && needs_retry_after_link_reset(mon)
(kms_flip:2117) igt_core-INFO: Stack trace:
(kms_flip:2117) igt_core-INFO:   #0 ../lib/igt_core.c:2051 __igt_fail_assert()
(kms_flip:2117) igt_core-INFO:   #1 ../tests/kms_flip.c:791 run_test_on_crtc_set.constprop.0()
(kms_flip:2117) igt_core-INFO:   #2 ../tests/kms_flip.c:1845 run_test()
(kms_flip:2117) igt_core-INFO:   #3 ../tests/kms_flip.c:2078 __igt_unique____real_main2001()
(kms_flip:2117) igt_core-INFO:   #4 ../tests/kms_flip.c:2001 main()
(kms_flip:2117) igt_core-INFO:   #5 [__libc_init_first+0x8a]
(kms_flip:2117) igt_core-INFO:   #6 [__libc_start_main+0x8b]
(kms_flip:2117) igt_core-INFO:   #7 [_start+0x25]
****  END  ****
Dynamic subtest A-VGA1: FAIL (4.632s)
Dmesg
<6> [185.443289] Console: switching to colour dummy device 80x25
<6> [185.443987] [IGT] kms_flip: executing
<7> [185.449868] i915 0000:00:02.0: [drm:i915_gem_open [i915]]
<7> [185.450757] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc]
<7> [185.451244] i915 0000:00:02.0: [drm:i915_gem_open [i915]]
<7> [185.454630] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] [CONNECTOR:64:VGA-1]
<7> [185.454658] i915 0000:00:02.0: [drm:intel_crt_detect [i915]] [CONNECTOR:64:VGA-1] force=1
<7> [185.454894] i915 0000:00:02.0: [drm:intel_crt_detect [i915]] ironlake hotplug adpa=0xf40000, result 0
<7> [185.455135] i915 0000:00:02.0: [drm:intel_crt_detect [i915]] CRT not detected via hotplug
<7> [185.455549] i915 0000:00:02.0: [drm:do_gmbus_xfer [i915]] GMBUS [i915 gmbus vga] NAK for addr: 0050 w(1)
<7> [185.455760] i915 0000:00:02.0: [drm:do_gmbus_xfer [i915]] GMBUS [i915 gmbus vga] NAK on first message, retry
<7> [185.456121] i915 0000:00:02.0: [drm:do_gmbus_xfer [i915]] GMBUS [i915 gmbus vga] NAK for addr: 0050 w(1)
<7> [185.456330] [drm:drm_do_probe_ddc_edid] drm: skipping non-existent adapter i915 gmbus vga
<7> [185.456338] i915 0000:00:02.0: [drm:intel_crt_get_edid [i915]] CRT GMBUS EDID read failed, retry using GPIO bit-banging
<7> [185.456541] i915 0000:00:02.0: [drm:intel_gmbus_force_bit [i915]] enabling bit-banging on i915 gmbus vga. force bit now 1
<7> [185.457735] [drm:drm_do_probe_ddc_edid] drm: skipping non-existent adapter i915 gmbus vga
<7> [185.457742] i915 0000:00:02.0: [drm:intel_gmbus_force_bit [i915]] disabling bit-banging on i915 gmbus vga. force bit now 0
<7> [185.458002] i915 0000:00:02.0: [drm:intel_crt_detect_ddc [i915]] CRT not detected via DDC:0x50 [no valid EDID found]
<7> [185.458272] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] [CONNECTOR:64:VGA-1] disconnected
<7> [185.458720] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] [CONNECTOR:75:DP-1]
<7> [185.458739] i915 0000:00:02.0: [drm:intel_dp_detect [i915]] [CONNECTOR:75:DP-1]
<7> [185.462485] i915 0000:00:02.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DP D: timeout (status 0x7143003f)
<7> [185.466389] i915 0000:00:02.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DP D: timeout (status 0x7143003f)
<7> [185.470286] i915 0000:00:02.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DP D: timeout (status 0x7143003f)
<7> [185.474162] i915 0000:00:02.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DP D: timeout (status 0x7143003f)
<7> [185.478074] i915 0000:00:02.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DP D: timeout (status 0x7143003f)
<7> [185.481965] i915 0000:00:02.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DP D: timeout (status 0x7143003f)
<7> [185.485833] i915 0000:00:02.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DP D: timeout (status 0x7143003f)
<7> [185.490002] i915 0000:00:02.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DP D: timeout (status 0x7143003f)
<7> [185.493828] i915 0000:00:02.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DP D: timeout (status 0x7143003f)
<7> [185.497728] i915 0000:00:02.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DP D: timeout (status 0x7143003f)
<7> [185.501615] i915 0000:00:02.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DP D: timeout (status 0x7143003f)
<7> [185.505526] i915 0000:00:02.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DP D: timeout (status 0x7143003f)
<7> [185.509398] i915 0000:00:02.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DP D: timeout (status 0x7143003f)
<7> [185.513289] i915 0000:00:02.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DP D: timeout (status 0x7143003f)
<7> [185.517204] i915 0000:00:02.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DP D: timeout (status 0x7143003f)
<7> [185.521134] i915 0000:00:02.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DP D: timeout (status 0x7143003f)
<7> [185.525045] i915 0000:00:02.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DP D: timeout (status 0x7143003f)
<7> [185.528955] i915 0000:00:02.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DP D: timeout (status 0x7143003f)
<7> [185.532844] i915 0000:00:02.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DP D: timeout (status 0x7143003f)
<7> [185.536967] i915 0000:00:02.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DP D: timeout (status 0x7143003f)
<7> [185.540919] i915 0000:00:02.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DP D: timeout (status 0x7143003f)
<7> [185.544805] i915 0000:00:02.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DP D: timeout (status 0x7143003f)
<7> [185.548957] i915 0000:00:02.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DP D: timeout (status 0x7143003f)
<7> [185.553003] i915 0000:00:02.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DP D: timeout (status 0x7143003f)
<7> [185.557167] i915 0000:00:02.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DP D: timeout (status 0x7143003f)
<7> [185.561269] i915 0000:00:02.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DP D: timeout (status 0x7143003f)
<7> [185.565228] i915 0000:00:02.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DP D: timeout (status 0x7143003f)
<7> [185.569382] i915 0000:00:02.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DP D: timeout (status 0x7143003f)
<7> [185.573470] i915 0000:00:02.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DP D: timeout (status 0x7143003f)
<7> [185.577423] i915 0000:00:02.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DP D: timeout (status 0x7143003f)
<7> [185.581255] i915 0000:00:02.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DP D: timeout (status 0x7143003f)
<7> [185.585391] i915 0000:00:02.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DP D: timeout (status 0x7143003f)
<7> [185.585710] 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> [185.585756] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] [CONNECTOR:75:DP-1] disconnected
<7> [185.586171] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] [CONNECTOR:64:VGA-1]
<7> [185.586203] i915 0000:00:02.0: [drm:intel_crt_detect [i915]] [CONNECTOR:64:VGA-1] force=1
<7> [185.586635] i915 0000:00:02.0: [drm:intel_crt_detect [i915]] ironlake hotplug adpa=0xf40000, result 0
<7> [185.587039] i915 0000:00:02.0: [drm:intel_crt_detect [i915]] CRT not detected via hotplug
<7> [185.587619] i915 0000:00:02.0: [drm:do_gmbus_xfer [i915]] GMBUS [i915 gmbus vga] NAK for addr: 0050 w(1)
<7> [185.587829] i915 0000:00:02.0: [drm:do_gmbus_xfer [i915]] GMBUS [i915 gmbus vga] NAK on first message, retry
<7> [185.588239] i915 0000:00:02.0: [drm:do_gmbus_xfer [i915]] GMBUS [i915 gmbus vga] NAK for addr: 0050 w(1)
<7> [185.588510] [drm:drm_do_probe_ddc_edid] drm: skipping non-existent adapter i915 gmbus vga
<7> [185.588521] i915 0000:00:02.0: [drm:intel_crt_get_edid [i915]] CRT GMBUS EDID read failed, retry using GPIO bit-banging
<7> [185.588776] i915 0000:00:02.0: [drm:intel_gmbus_force_bit [i915]] enabling bit-banging on i915 gmbus vga. force bit now 1
<7> [185.590002] [drm:drm_do_probe_ddc_edid] drm: skipping non-existent adapter i915 gmbus vga
<7> [185.590018] i915 0000:00:02.0: [drm:intel_gmbus_force_bit [i915]] disabling bit-banging on i915 gmbus vga. force bit now 0
<7> [185.590233] i915 0000:00:02.0: [drm:intel_crt_detect_ddc [i915]] CRT not detected via DDC:0x50 [no valid EDID found]
<7> [185.590507] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] [CONNECTOR:64:VGA-1] disconnected
<7> [185.590754] i915 0000:00:02.0: [drm:status_store] [CONNECTOR:64:VGA-1] force updated from 0 to 2 or reprobing
<7> [185.590763] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] [CONNECTOR:64:VGA-1]
<7> [185.590780] 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> [185.590809] i915 0000:00:02.0: [drm:drm_sysfs_hotplug_event] generating hotplug event
<7> [185.590894] i915 0000:00:02.0: [drm:drm_client_dev_hotplug] intel-fbdev: ret=0
<7> [185.591103] i915 0000:00:02.0: [drm:do_gmbus_xfer [i915]] GMBUS [i915 gmbus vga] NAK for addr: 0050 w(1)
<7> [185.591399] i915 0000:00:02.0: [drm:do_gmbus_xfer [i915]] GMBUS [i915 gmbus vga] NAK on first message, retry
<7> [185.591825] i915 0000:00:02.0: [drm:do_gmbus_xfer [i915]] GMBUS [i915 gmbus vga] NAK for addr: 0050 w(1)
<7> [185.592031] [drm:drm_do_probe_ddc_edid] drm: skipping non-existent adapter i915 gmbus vga
<7> [185.592045] i915 0000:00:02.0: [drm:intel_crt_get_edid [i915]] CRT GMBUS EDID read failed, retry using GPIO bit-banging
<7> [185.592276] i915 0000:00:02.0: [drm:intel_gmbus_force_bit [i915]] enabling bit-banging on i915 gmbus vga. force bit now 1
<7> [185.593559] [drm:drm_do_probe_ddc_edid] drm: skipping non-existent adapter i915 gmbus vga
<7> [185.593571] i915 0000:00:02.0: [drm:intel_gmbus_force_bit [i915]] disabling bit-banging on i915 gmbus vga. force bit now 0
<7> [185.593837] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] [CONNECTOR:64:VGA-1] probed modes:
<7> [185.593856] 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> [185.593872] 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> [185.593888] 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> [185.593903] 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> [185.593918] 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> [185.593977] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] [CONNECTOR:64:VGA-1]
<7> [185.594194] i915 0000:00:02.0: [drm:do_gmbus_xfer [i915]] GMBUS [i915 gmbus vga] NAK for addr: 0050 w(1)
<7> [185.594416] i915 0000:00:02.0: [drm:do_gmbus_xfer [i915]] GMBUS [i915 gmbus vga] NAK on first message, retry
<7> [185.594797] i915 0000:00:02.0: [drm:do_gmbus_xfer [i915]] GMBUS [i915 gmbus vga] NAK for addr: 0050 w(1)
<7> [185.595003] [drm:drm_do_probe_ddc_edid] drm: skipping non-existent adapter i915 gmbus vga
<7> [185.595016] i915 0000:00:02.0: [drm:intel_crt_get_edid [i915]] CRT GMBUS EDID read failed, retry using GPIO bit-banging
<7> [185.595301] i915 0000:00:02.0: [drm:intel_gmbus_force_bit [i915]] enabling bit-banging on i915 gmbus vga. force bit now 1
<7> [185.596539] [drm:drm_do_probe_ddc_edid] drm: skipping non-existent adapter i915 gmbus vga
<7> [185.596552] i915 0000:00:02.0: [drm:intel_gmbus_force_bit [i915]] disabling bit-banging on i915 gmbus vga. force bit now 0
<7> [185.596855] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] [CONNECTOR:64:VGA-1] probed modes:
<7> [185.596875] 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> [185.596891] 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> [185.596906] 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> [185.596922] 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> [185.596937] 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> [185.596974] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] [CONNECTOR:67:HDMI-A-1]
<7> [185.596993] i915 0000:00:02.0: [drm:intel_hdmi_detect [i915]] [CONNECTOR:67:HDMI-A-1]
<7> [185.622487] 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> [185.622501] i915 0000:00:02.0: [drm:update_display_info.part.0] [CONNECTOR:67:HDMI-A-1] HDMI sink does deep color 30.
<7> [185.622508] i915 0000:00:02.0: [drm:update_display_info.part.0] [CONNECTOR:67:HDMI-A-1] HDMI sink does deep color 36.
<7> [185.622514] i915 0000:00:02.0: [drm:update_display_info.part.0] [CONNECTOR:67:HDMI-A-1] HDMI sink does deep color 48.
<7> [185.622519] 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> [185.622525] i915 0000:00:02.0: [drm:update_display_info.part.0] [CONNECTOR:67:HDMI-A-1] HDMI sink does YCRCB444 in deep color.
<7> [185.622532] i915 0000:00:02.0: [drm:update_display_info.part.0] [CONNECTOR:67:HDMI-A-1] ELD monitor Mi TV
<7> [185.622539] 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> [185.622546] i915 0000:00:02.0: [drm:update_display_info.part.0] [CONNECTOR:67:HDMI-A-1] ELD size 36, SAD count 3
<7> [185.622792] i915 0000:00:02.0: [drm:do_gmbus_xfer [i915]] GMBUS [i915 gmbus dpd] NAK for addr: 0040 w(1)
<7> [185.623112] i915 0000:00:02.0: [drm:do_gmbus_xfer [i915]] GMBUS [i915 gmbus dpd] NAK on first message, retry
<7> [185.623598] i915 0000:00:02.0: [drm:do_gmbus_xfer [i915]] GMBUS [i915 gmbus dpd] NAK for addr: 0040 w(1)
<7> [185.623907] i915 0000:00:02.0: [drm:drm_dp_dual_mode_detect [drm_display_helper]] DP dual mode HDMI ID: (err -6)
<7> [185.625737] 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> [185.625757] 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> [185.625778] 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> [185.625787] 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> [185.625794] 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> [185.625803] 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> [185.625811] 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> [185.625818] 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> [185.625826] 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> [185.625834] 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> [185.625842] 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> [185.625850] 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> [185.625858] 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> [185.625866] 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> [185.625874] 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> [185.625881] 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> [185.625889] 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> [185.625897] 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> [185.625904] 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> [185.625917] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] [CONNECTOR:67:HDMI-A-1] probed modes:
<7> [185.625937] 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> [185.625952] 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> [185.625967] 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> [185.625982] 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> [185.625997] 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> [185.626012] 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> [185.626027] 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> [185.626042] 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> [185.626057] 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> [185.626072] 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> [185.626086] 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> [185.626101] 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> [185.626116] 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> [185.626131] 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> [185.626145] 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> [185.626160] 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> [185.626175] 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> [185.626190] 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> [185.626204] 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> [185.626219] 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> [185.626234] 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> [185.626249] 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> [185.626263] 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> [185.626297] 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> [185.626333] 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> [185.626366] 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> [185.626392] 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> [185.626418] 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> [185.626445] 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> [185.626471] 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> [185.626498] 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> [185.626524] 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> [185.626550] 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> [185.626577] 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> [185.626603] 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> [185.626624] 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> [185.626639] 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> [185.626654] 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> [185.626668] 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> [185.626683] 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> [185.626697] 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> [185.626712] 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> [185.626726] 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> [185.626741] 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> [185.626755] 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> [185.626829] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] [CONNECTOR:75:DP-1]
<7> [185.626846] i915 0000:00:02.0: [drm:intel_dp_detect [i915]] [CONNECTOR:75:DP-1]
<7> [185.630627] i915 0000:00:02.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DP D: timeout (status 0x7143003f)
<7> [185.634562] i915 0000:00:02.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DP D: timeout (status 0x7143003f)
<7> [185.638411] i915 0000:00:02.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DP D: timeout (status 0x7143003f)
<7> [185.642312] i915 0000:00:02.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DP D: timeout (status 0x7143003f)
<7> [185.646207] i915 0000:00:02.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DP D: timeout (status 0x7143003f)
<7> [185.650083] i915 0000:00:02.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DP D: timeout (status 0x7143003f)
<7> [185.653958] i915 0000:00:02.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DP D: timeout (status 0x7143003f)
<7> [185.657863] i915 0000:00:02.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DP D: timeout (status 0x7143003f)
<7> [185.661743] i915 0000:00:02.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DP D: timeout (status 0x7143003f)
<7> [185.665638] i915 0000:00:02.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DP D: timeout (status 0x7143003f)
<7> [185.669507] i915 0000:00:02.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DP D: timeout (status 0x7143003f)
<7> [185.673324] i915 0000:00:02.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DP D: timeout (status 0x7143003f)
<7> [185.677060] i915 0000:00:02.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DP D: timeout (status 0x7143003f)
<7> [185.680964] i915 0000:00:02.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DP D: timeout (status 0x7143003f)
<7> [185.684860] i915 0000:00:02.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DP D: timeout (status 0x7143003f)
<7> [185.688764] i915 0000:00:02.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DP D: timeout (status 0x7143003f)
<7> [185.692663] i915 0000:00:02.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DP D: timeout (status 0x7143003f)
<7> [185.696541] i915 0000:00:02.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DP D: timeout (status 0x7143003f)
<7> [185.700437] i915 0000:00:02.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DP D: timeout (status 0x7143003f)
<7> [185.704315] i915 0000:00:02.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DP D: timeout (status 0x7143003f)
<7> [185.708281] i915 0000:00:02.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DP D: timeout (status 0x7143003f)
<7> [185.712212] i915 0000:00:02.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DP D: timeout (status 0x7143003f)
<7> [185.716111] i915 0000:00:02.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DP D: timeout (status 0x7143003f)
<7> [185.720209] i915 0000:00:02.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DP D: timeout (status 0x7143003f)
<7> [185.724073] i915 0000:00:02.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DP D: timeout (status 0x7143003f)
<7> [185.728024] i915 0000:00:02.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DP D: timeout (status 0x7143003f)
<7> [185.732151] i915 0000:00:02.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DP D: timeout (status 0x7143003f)
<7> [185.736028] i915 0000:00:02.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DP D: timeout (status 0x7143003f)
<7> [185.740150] i915 0000:00:02.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DP D: timeout (status 0x7143003f)
<7> [185.744071] i915 0000:00:02.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DP D: timeout (status 0x7143003f)
<7> [185.748269] i915 0000:00:02.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DP D: timeout (status 0x7143003f)
<7> [185.752168] i915 0000:00:02.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DP D: timeout (status 0x7143003f)
<7> [185.752557] 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> [185.752612] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] [CONNECTOR:75:DP-1] disconnected
<6> [185.754400] [IGT] kms_flip: starting subtest plain-flip-fb-recreate
<6> [185.756510] [IGT] kms_flip: starting dynamic subtest A-VGA1
<7> [185.757018] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:82]
<7> [185.757113] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:83]
<7> [185.804268] i915 0000:00:02.0: [drm:drm_mode_setcrtc] [CRTC:47:pipe A]
<7> [185.804502] 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> [185.804889] 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> [185.805226] 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> [185.805596] 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> [185.805978] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:47:pipe A] fastset requirement not met in fdi_lanes (expected 3, found 0)
<7> [185.806322] 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 6934582/8388608 link 288940/524288, found tu 0, data 0/0 link 0/0)
<7> [185.806729] 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> [185.807068] 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> [185.807425] 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> [185.807798] 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> [185.808186] 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> [185.808512] 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> [185.808725] 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> [185.808935] 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> [185.809144] 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> [185.809368] 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> [185.809623] 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> [185.809836] 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> [185.810069] 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> [185.810335] 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> [185.810547] 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> [185.810757] 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> [185.810965] 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> [185.811173] 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> [185.811404] 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> [185.811612] 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> [185.811838] 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> [185.812041] 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> [185.812285] 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> [185.812501] 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> [185.812728] 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> [185.812964] 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> [185.813224] 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> [185.813451] 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> [185.813655] 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> [185.813889] 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> [185.814093] 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> [185.814339] 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> [185.814564] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:47:pipe A] fastset requirement not met in pipe_bpp (expected 36, found 0)
<7> [185.814766] 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 148800, found 0)
<7> [185.814969] 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 148800, found 0)
<7> [185.815199] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:47:pipe A] fastset requirement not met in port_clock (expected 223200, found 0)
<7> [185.815415] 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> [185.815628] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:47:pipe A] fastset requirement not met in infoframes.gcp (expected 0x00000006, found 0x00000000)
<7> [185.815830] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:47:pipe A] fastset requirement not met in avi infoframe
<7> [185.816031] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] expected:
<7> [185.816273] i915 0000:00:02.0: HDMI infoframe: Auxiliary Video Information (AVI), version 2, length 13
<7> [185.816284] i915 0000:00:02.0: colorspace: RGB
<7> [185.816287] i915 0000:00:02.0: scan mode: Underscan
<7> [185.816289] i915 0000:00:02.0: colorimetry: No Data
<7> [185.816292] i915 0000:00:02.0: picture aspect: 16:9
<7> [185.816294] i915 0000:00:02.0: active aspect: Same as Picture
<7> [185.816296] i915 0000:00:02.0: itc: No Data
<7> [185.816299] i915 0000:00:02.0: extended colorimetry: xvYCC 601
<7> [185.816301] i915 0000:00:02.0: quantization range: Default
<7> [185.816303] i915 0000:00:02.0: nups: Unknown Non-uniform Scaling
<7> [185.816306] i915 0000:00:02.0: video code: 16
<7> [185.816308] i915 0000:00:02.0: ycc quantization range: Full
<7> [185.816310] i915 0000:00:02.0: hdmi content type: Graphics
<7> [185.816313] i915 0000:00:02.0: pixel repeat: 0
<7> [185.816315] i915 0000:00:02.0: bar top 0, bottom 0, left 0, right 0
<7> [185.816318] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] found:
<7> [185.816531] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:47:pipe A] fastset requirement not met in spd infoframe
<7> [185.816732] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] expected:
<7> [185.816962] i915 0000:00:02.0: HDMI infoframe: Source Product Description (SPD), version 1, length 25
<7> [185.816965] i915 0000:00:02.0: vendor: Intel
<7> [185.816967] i915 0000:00:02.0: product: Integrated gfx
<7> [185.816970] i915 0000:00:02.0: source device information: PC General (0x9)
<7> [185.816972] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] found:
<7> [185.817205] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:47:pipe A] fastset requirement not met in hdmi infoframe
<7> [185.817428] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] expected:
<7> [185.817629] i915 0000:00:02.0: HDMI infoframe: Vendor, version 1, length 4
<7> [185.817631] i915 0000:00:02.0: empty frame
<7> [185.817634] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] found:
<7> [185.817836] i915 0000:00:02.0: [drm:intel_atomic_check [i915]] [CRTC:47:pipe A] fastset requirement not met, forcing full modeset
<7> [185.818095] i915 0000:00:02.0: [drm:intel_unreference_shared_dpll_crtc [i915]] [CRTC:47:pipe A] releasing PCH DPLL A
<7> [185.818370] i915 0000:00:02.0: [drm:intel_modeset_calc_cdclk [i915]] New cdclk calculated to be logical 400000 kHz, actual 400000 kHz
<7> [185.818602] i915 0000:00:02.0: [drm:intel_modeset_calc_cdclk [i915]] New voltage level calculated to be logical 0, actual 0
<7> [185.818811] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [CRTC:47:pipe A] enable: no [modeset]
<7> [185.819067] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:32:primary A] fb: [NOFB], visible: no
<7> [185.819332] 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> [185.842791] i915 0000:00:02.0: [drm:i915_audio_component_get_eld [i915]] Not valid for port D
<7> [185.843617] i915 0000:00:02.0: [drm:intel_disable_transcoder [i915]] disabling pipe A
<7> [185.860777] i915 0000:00:02.0: [drm:g4x_dp_port_enabled [i915]] No pipe for DP port B found
<7> [185.861244] i915 0000:00:02.0: [drm:g4x_dp_port_enabled [i915]] No pipe for DP port C found
<7> [185.861674] i915 0000:00:02.0: [drm:g4x_dp_port_enabled [i915]] No pipe for DP port D found
<7> [185.873279] 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> [185.873789] i915 0000:00:02.0: [drm:intel_disable_shared_dpll [i915]] disabling PCH DPLL A
<7> [185.874456] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:65:CRT]
<7> [185.874912] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:66:HDMI D]
<7> [185.875676] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:74:DP D]
<7> [185.876024] i915 0000:00:02.0: [drm:verify_connector_state [i915]] [CONNECTOR:67:HDMI-A-1]
<7> [185.876432] i915 0000:00:02.0: [drm:intel_modeset_verify_crtc [i915]] [CRTC:47:pipe A]
<7> [185.876923] i915 0000:00:02.0: [drm:drm_mode_setcrtc] [CRTC:63:pipe B]
<7> [185.877135] i915 0000:00:02.0: [drm:drm_mode_setcrtc] [CRTC:47:pipe A]
<7> [185.877173] i915 0000:00:02.0: [drm:drm_mode_setcrtc] [CONNECTOR:64:VGA-1]
<7> [185.877310] 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> [185.877693] i915 0000:00:02.0: [drm:intel_atomic_check [i915]] [CRTC:47:pipe A] hw max bpp: 24, pipe bpp: 24, dithering: 0
<7> [185.878025] i915 0000:00:02.0: [drm:intel_fdi_atomic_check_link [i915]] checking fdi config on pipe A, lanes 1
<7> [185.878331] 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> [185.878677] 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> [185.878989] 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> [185.879302] 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> [185.879678] 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> [185.879989] 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> [185.880324] 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> [185.880662] 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> [185.880975] 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> [185.881314] 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> [185.881627] 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> [185.881939] 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> [185.882269] 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> [185.882589] 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> [185.882900] 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> [185.883219] 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> [185.883558] 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> [185.883887] 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> [185.884219] 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> [185.884541] 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> [185.884853] 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> [185.885171] 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> [185.885499] 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> [185.885827] 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> [185.886138] 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> [185.886479] 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> [185.886790] 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> [185.887101] 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> [185.887439] 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> [185.887750] 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> [185.888061] 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> [185.888430] 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> [185.888754] 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> [185.889113] 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> [185.889428] 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> [185.889741] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:47:pipe A] fastset requirement not met in dpll_hw_state
<7> [185.890072] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] expected:
<7> [185.890390] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] dpll_hw_state: dpll: 0xc4010001, dpll_md: 0x0, fp0: 0x30f06, fp1: 0x30f06
<7> [185.890702] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] found:
<7> [185.891030] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] dpll_hw_state: dpll: 0x84100010, dpll_md: 0x0, fp0: 0x10c09, fp1: 0x10c09
<7> [185.891347] 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> [185.891658] 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> [185.891969] 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> [185.892310] 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> [185.892624] i915 0000:00:02.0: [drm:intel_atomic_check [i915]] [CRTC:47:pipe A] fastset requirement not met, forcing full modeset
<7> [185.893025] 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> [185.893339] i915 0000:00:02.0: [drm:intel_modeset_calc_cdclk [i915]] New cdclk calculated to be logical 400000 kHz, actual 400000 kHz
<7> [185.893652] i915 0000:00:02.0: [drm:intel_modeset_calc_cdclk [i915]] New voltage level calculated to be logical 0, actual 0
<7> [185.894017] i915 0000:00:02.0: [drm:intel_find_shared_dpll [i915]] [CRTC:47:pipe A] allocated PCH DPLL A
<7> [185.894038] i915 0000:00:02.0: [drm:intel_power_well_disable [i915]] disabling always-on
<7> [185.894268] i915 0000:00:02.0: [drm:intel_reference_shared_dpll_crtc [i915]] [CRTC:47:pipe A] reserving PCH DPLL A
<7> [185.894582] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [CRTC:47:pipe A] enable: yes [modeset]
<7> [185.894894] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] active: yes, output_types: ANALOG (0x2), output format: RGB, sink format: RGB
<7> [185.895233] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] cpu_transcoder: A, pipe bpp: 24, dithering: 0
<7> [185.895544] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] MST master transcoder: <invalid>
<7> [185.895854] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] port sync: master transcoder: <invalid>, slave transcoder bitmask = 0x0
<7> [185.896195] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] joiner: no, pipes: 0x0
<7> [185.896507] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] splitter: disabled, link count 0, overlap 0
<7> [185.896816] 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> [185.897157] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] framestart delay: 1, MSA timing delay: 0
<7> [185.897469] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] audio: 0, infoframes: 0, infoframes enabled: 0x0
<7> [185.897779] 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> [185.898120] 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> [185.898435] 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> [185.898750] 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> [185.899091] 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> [185.899407] 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> [185.899721] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] port clock: 64800, pipe src: 1024x768+0+0, pixel rate 64800
<7> [185.900065] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] linetime: 0, ips linetime: 0
<7> [185.900377] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pch pfit: 0x0+0+0, disabled, force thru: no
<7> [185.900687] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] ips: 0, double wide: 0, drrs: 0
<7> [185.901028] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] dpll_hw_state: dpll: 0x84100010, dpll_md: 0x0, fp0: 0x10c09, fp1: 0x10c09
<7> [185.901354] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] csc_mode: 0x3 gamma_mode: 0x0 gamma_enable: 0 csc_enable: 0
<7> [185.901665] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pre csc lut: 0 entries, post csc lut: 0 entries
<7> [185.902003] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pipe csc: pre offsets: 0x0000 0x0000 0x0000
<7> [185.902331] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pipe csc: coefficients: 0x0000 0x0000 0x0000
<7> [185.902643] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pipe csc: coefficients: 0x0000 0x0000 0x0000
<7> [185.902983] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pipe csc: coefficients: 0x0000 0x0000 0x0000
<7> [185.903311] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:32:primary A] fb: [FB:82] 1024x768 format = XR24 little-endian (0x34325258) modifier = 0x0, visible: yes
<7> [185.903626] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] rotation: 0x1, scaler: -1, scaling_filter: 0
<7> [185.903968] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] src: 1024.000000x768.000000+0.000000+0.000000 dst: 1024x768+0+0
<7> [185.905397] i915 0000:00:02.0: [drm:intel_power_well_enable [i915]] enabling always-on
<7> [185.905773] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:65:CRT]
<7> [185.906079] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:66:HDMI D]
<7> [185.906384] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:74:DP D]
<7> [185.907322] i915 0000:00:02.0: [drm:intel_enable_transcoder [i915]] enabling pipe A
<7> [185.908500] i915 0000:00:02.0: [drm:gen6_fdi_link_train [i915]] FDI_RX_IIR 0x100
<7> [185.908847] i915 0000:00:02.0: [drm:gen6_fdi_link_train [i915]] FDI train 1 done.
<7> [185.909818] i915 0000:00:02.0: [drm:gen6_fdi_link_train [i915]] FDI_RX_IIR 0x200
<7> [185.910129] i915 0000:00:02.0: [drm:gen6_fdi_link_train [i915]] FDI train 2 done.
<7> [185.910433] i915 0000:00:02.0: [drm:gen6_fdi_link_train [i915]] FDI train done.
<7> [185.910791] 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> [185.911101] i915 0000:00:02.0: [drm:intel_enable_shared_dpll [i915]] enabling PCH DPLL A
<7> [185.963182] i915 0000:00:02.0: [drm:verify_connector_state [i915]] [CONNECTOR:64:VGA-1]
<7> [185.963682] i915 0000:00:02.0: [drm:intel_modeset_verify_crtc [i915]] [CRTC:47:pipe A]
<7> [186.264139] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:84]
<7> [186.264179] i915 0000:00:02.0: [drm:drm_mode_rmfb_work_fn] Removing [FB:82] from all active usage due to RMFB ioctl
<7> [186.280896] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:82]
<7> [186.297576] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:83]
<7> [186.314335] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:84]
<7> [186.331104] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:82]
<7> [186.347752] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:83]
<7> [186.364441] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:84]
<7> [186.381187] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:82]
<7> [186.397919] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:83]
<7> [186.414599] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:84]
<7> [186.431375] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:82]
<7> [186.448067] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:83]
<7> [186.464735] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:84]
<7> [186.481464] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:82]
<7> [186.498186] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:83]
<7> [186.514902] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:84]
<7> [186.531655] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:82]
<7> [186.548353] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:83]
<7> [186.565099] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:84]
<7> [186.581808] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:82]
<7> [186.598527] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:83]
<7> [186.615238] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:84]
<7> [186.631940] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:82]
<7> [186.648646] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:83]
<7> [186.665329] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:84]
<7> [186.682036] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:82]
<7> [186.698844] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:83]
<7> [186.715538] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:84]
<7> [186.732240] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:82]
<7> [186.748837] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:83]
<7> [186.765567] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:84]
<7> [186.782300] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:82]
<7> [186.799012] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:83]
<7> [186.815737] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:84]
<7> [186.832453] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:82]
<7> [186.849223] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:83]
<7> [186.865934] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:84]
<7> [186.882591] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:82]
<7> [186.899332] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:83]
<7> [186.916053] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:84]
<7> [186.932773] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:82]
<7> [186.949482] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:83]
<7> [186.966210] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:84]
<7> [186.982927] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:82]
<7> [186.999721] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:83]
<7> [187.016404] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:84]
<7> [187.033097] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:82]
<7> [187.049824] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:83]
<7> [187.066519] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:84]
<7> [187.083415] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:82]
<7> [187.083476] i915 0000:00:02.0: [drm:drm_mode_rmfb_work_fn] Removing [FB:83] from all active usage due to RMFB ioctl
<7> [187.100038] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:83]
<7> [187.116719] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:84]
<7> [187.133492] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:82]
<7> [187.150181] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:83]
<7> [187.166843] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:84]
<7> [187.183614] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:82]
<7> [187.200332] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:83]
<7> [187.217047] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:84]
<7> [187.233724] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:82]
<7> [187.250432] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:83]
<7> [187.267231] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:84]
<7> [187.283924] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:82]
<7> [187.300597] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:83]
<7> [187.317355] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:84]
<7> [187.334057] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:82]
<7> [187.350757] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:83]
<7> [187.367464] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:84]
<7> [187.384175] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:82]
<7> [187.400964] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:83]
<6> [190.388903] [IGT] kms_flip: finished subtest A-VGA1, FAIL
Created at 2024-11-24 19:12:04