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

Machine description: shard-snb4

Result: Fail

git-log-oneline i915_display_info23 igt_runner23 runtimes23 results23.json results23-i915-load.json i915_display_info_post_exec23 boot23 dmesg23

DetailValue
Duration 4.65 seconds
Hostname 
shard-snb4
Igt-Version 
IGT-Version: 1.30-ge229ae8ac (x86_64) (Linux: 6.14.0-rc4-CI_DRM_16210-g60b234fe25a4+ x86_64)
Out 
Using IGT_SRANDOM=1740993388 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 17182.3us +- 4.854us accuracy 0.08%
vblank interval differs from modeline! expected 16665.6us, measured 17182us +- 4.854us, difference 516.7us (106.4 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.646s)
Err 
Starting subtest: plain-flip-fb-recreate
Starting dynamic subtest: A-VGA1
(kms_flip:7003) CRITICAL: Test assertion failure function __run_test_on_crtc_set, file ../tests/kms_flip.c:1674:
(kms_flip:7003) CRITICAL: Failed assertion: !retried && needs_retry_after_link_reset(mon)
Dynamic subtest A-VGA1 failed.
**** DEBUG ****
(kms_flip:7003) igt_fb-DEBUG: igt_create_fb_with_bo_size(width=1024, height=768, format=XR24(0x34325258), modifier=0x0, size=0)
(kms_flip:7003) igt_fb-DEBUG: igt_create_fb_with_bo_size(handle=1, pitch=4096)
(kms_flip:7003) ioctl_wrappers-DEBUG: Test requirement passed: igt_has_fb_modifiers(fd)
(kms_flip:7003) igt_fb-DEBUG: igt_create_fb_with_bo_size(width=1024, height=768, format=XR24(0x34325258), modifier=0x0, size=0)
(kms_flip:7003) igt_fb-DEBUG: igt_create_fb_with_bo_size(handle=2, pitch=4096)
(kms_flip:7003) ioctl_wrappers-DEBUG: Test requirement passed: igt_has_fb_modifiers(fd)
(kms_flip:7003) intel_blt-DEBUG: Test requirement passed: cmds_info
(kms_flip:7003) intel_blt-DEBUG: Test requirement passed: cmds_info
(kms_flip:7003) igt_fb-DEBUG: Test requirement passed: cairo_surface_status(fb->cairo_surface) == CAIRO_STATUS_SUCCESS
(kms_flip:7003) intel_blt-DEBUG: Test requirement passed: cmds_info
(kms_flip:7003) intel_blt-DEBUG: Test requirement passed: cmds_info
(kms_flip:7003) igt_fb-DEBUG: Test requirement passed: cairo_surface_status(fb->cairo_surface) == CAIRO_STATUS_SUCCESS
(kms_flip:7003) igt_kms-INFO:   1024x768: 60 65000 1024 1048 1184 1344 768 771 777 806 0x40 0xa 
(kms_flip:7003) DEBUG: No stale events found
(kms_flip:7003) i915/intel_drrs-DEBUG: Manually disabling DRRS. 0
(kms_flip:7003) i915/intel_drrs-DEBUG: Test requirement passed: dir >= 0
(kms_flip:7003) INFO: Expected frametime: 16666us; measured 17182.3us +- 4.854us accuracy 0.08%
(kms_flip:7003) INFO: vblank interval differs from modeline! expected 16665.6us, measured 17182us +- 4.854us, difference 516.7us (106.4 sigma)
(kms_flip:7003) DEBUG: name = flip
last_ts = 0.000000
last_received_ts = 0.000000
last_seq = 0
current_ts = 304.880737
current_received_ts = 304.880157
current_seq = 12958
count = 0
seq_step = 1
(kms_flip:7003) DEBUG: name = flip
last_ts = 304.880737
last_received_ts = 304.880157
last_seq = 12958
current_ts = 304.897919
current_received_ts = 304.897308
current_seq = 12959
count = 1
seq_step = 1
(kms_flip:7003) DEBUG: flip ts/seq: last 304.880737/12958, current 304.897919/12959: elapsed=17197.0us expected=17182.3us +- 85.9us, error 0.1%
(kms_flip:7003) DEBUG: name = flip
last_ts = 304.897919
last_received_ts = 304.897308
last_seq = 12959
current_ts = 304.915100
current_received_ts = 304.914551
current_seq = 12960
count = 2
seq_step = 1
(kms_flip:7003) DEBUG: flip ts/seq: last 304.897919/12959, current 304.915100/12960: elapsed=17169.0us expected=17182.3us +- 85.9us, error 0.1%
(kms_flip:7003) DEBUG: name = flip
last_ts = 304.915100
last_received_ts = 304.914551
last_seq = 12960
current_ts = 304.932281
current_received_ts = 304.931702
current_seq = 12961
count = 3
seq_step = 1
(kms_flip:7003) DEBUG: flip ts/seq: last 304.915100/12960, current 304.932281/12961: elapsed=17178.0us expected=17182.3us +- 85.9us, error 0.0%
(kms_flip:7003) DEBUG: name = flip
last_ts = 304.932281
last_received_ts = 304.931702
last_seq = 12961
current_ts = 304.949463
current_received_ts = 304.948914
current_seq = 12962
count = 4
seq_step = 1
(kms_flip:7003) DEBUG: flip ts/seq: last 304.932281/12961, current 304.949463/12962: elapsed=17190.0us expected=17182.3us +- 85.9us, error 0.0%
(kms_flip:7003) DEBUG: name = flip
last_ts = 304.949463
last_received_ts = 304.948914
last_seq = 12962
current_ts = 304.966644
current_received_ts = 304.966095
current_seq = 12963
count = 5
seq_step = 1
(kms_flip:7003) DEBUG: flip ts/seq: last 304.949463/12962, current 304.966644/12963: elapsed=17193.0us expected=17182.3us +- 85.9us, error 0.1%
(kms_flip:7003) DEBUG: name = flip
last_ts = 304.966644
last_received_ts = 304.966095
last_seq = 12963
current_ts = 304.983826
current_received_ts = 304.983215
current_seq = 12964
count = 6
seq_step = 1
(kms_flip:7003) DEBUG: flip ts/seq: last 304.966644/12963, current 304.983826/12964: elapsed=17181.0us expected=17182.3us +- 85.9us, error 0.0%
(kms_flip:7003) DEBUG: name = flip
last_ts = 304.983826
last_received_ts = 304.983215
last_seq = 12964
current_ts = 305.001007
current_received_ts = 305.000397
current_seq = 12965
count = 7
seq_step = 1
(kms_flip:7003) DEBUG: flip ts/seq: last 304.983826/12964, current 305.001007/12965: elapsed=17171.0us expected=17182.3us +- 85.9us, error 0.1%
(kms_flip:7003) DEBUG: name = flip
last_ts = 305.001007
last_received_ts = 305.000397
last_seq = 12965
current_ts = 305.018188
current_received_ts = 305.017578
current_seq = 12966
count = 8
seq_step = 1
(kms_flip:7003) DEBUG: flip ts/seq: last 305.001007/12965, current 305.018188/12966: elapsed=17189.0us expected=17182.3us +- 85.9us, error 0.0%
(kms_flip:7003) DEBUG: name = flip
last_ts = 305.018188
last_received_ts = 305.017578
last_seq = 12966
current_ts = 305.035309
current_received_ts = 305.034760
current_seq = 12967
count = 9
seq_step = 1
(kms_flip:7003) DEBUG: flip ts/seq: last 305.018188/12966, current 305.035309/12967: elapsed=17125.0us expected=17182.3us +- 85.9us, error 0.3%
(kms_flip:7003) DEBUG: name = flip
last_ts = 305.035309
last_received_ts = 305.034760
last_seq = 12967
current_ts = 305.052460
current_received_ts = 305.051910
current_seq = 12968
count = 10
seq_step = 1
(kms_flip:7003) DEBUG: flip ts/seq: last 305.035309/12967, current 305.052460/12968: elapsed=17135.0us expected=17182.3us +- 85.9us, error 0.3%
(kms_flip:7003) DEBUG: name = flip
last_ts = 305.052460
last_received_ts = 305.051910
last_seq = 12968
current_ts = 305.069580
current_received_ts = 305.069061
current_seq = 12969
count = 11
seq_step = 1
(kms_flip:7003) DEBUG: flip ts/seq: last 305.052460/12968, current 305.069580/12969: elapsed=17114.0us expected=17182.3us +- 85.9us, error 0.4%
(kms_flip:7003) DEBUG: name = flip
last_ts = 305.069580
last_received_ts = 305.069061
last_seq = 12969
current_ts = 305.086700
current_received_ts = 305.086151
current_seq = 12970
count = 12
seq_step = 1
(kms_flip:7003) DEBUG: flip ts/seq: last 305.069580/12969, current 305.086700/12970: elapsed=17126.0us expected=17182.3us +- 85.9us, error 0.3%
(kms_flip:7003) DEBUG: name = flip
last_ts = 305.086700
last_received_ts = 305.086151
last_seq = 12970
current_ts = 305.103821
current_received_ts = 305.103271
current_seq = 12971
count = 13
seq_step = 1
(kms_flip:7003) DEBUG: flip ts/seq: last 305.086700/12970, current 305.103821/12971: elapsed=17129.0us expected=17182.3us +- 85.9us, error 0.3%
(kms_flip:7003) DEBUG: name = flip
last_ts = 305.103821
last_received_ts = 305.103271
last_seq = 12971
current_ts = 305.120972
current_received_ts = 305.120361
current_seq = 12972
count = 14
seq_step = 1
(kms_flip:7003) DEBUG: flip ts/seq: last 305.103821/12971, current 305.120972/12972: elapsed=17136.0us expected=17182.3us +- 85.9us, error 0.3%
(kms_flip:7003) DEBUG: name = flip
last_ts = 305.120972
last_received_ts = 305.120361
last_seq = 12972
current_ts = 305.138062
current_received_ts = 305.137512
current_seq = 12973
count = 15
seq_step = 1
(kms_flip:7003) DEBUG: flip ts/seq: last 305.120972/12972, current 305.138062/12973: elapsed=17108.0us expected=17182.3us +- 85.9us, error 0.4%
(kms_flip:7003) DEBUG: name = flip
last_ts = 305.138062
last_received_ts = 305.137512
last_seq = 12973
current_ts = 305.155182
current_received_ts = 305.154663
current_seq = 12974
count = 16
seq_step = 1
(kms_flip:7003) DEBUG: flip ts/seq: last 305.138062/12973, current 305.155182/12974: elapsed=17128.0us expected=17182.3us +- 85.9us, error 0.3%
(kms_flip:7003) DEBUG: name = flip
last_ts = 305.155182
last_received_ts = 305.154663
last_seq = 12974
current_ts = 305.172333
current_received_ts = 305.171753
current_seq = 12975
count = 17
seq_step = 1
(kms_flip:7003) DEBUG: flip ts/seq: last 305.155182/12974, current 305.172333/12975: elapsed=17136.0us expected=17182.3us +- 85.9us, error 0.3%
(kms_flip:7003) DEBUG: name = flip
last_ts = 305.172333
last_received_ts = 305.171753
last_seq = 12975
current_ts = 305.189453
current_received_ts = 305.188904
current_seq = 12976
count = 18
seq_step = 1
(kms_flip:7003) DEBUG: flip ts/seq: last 305.172333/12975, current 305.189453/12976: elapsed=17114.0us expected=17182.3us +- 85.9us, error 0.4%
(kms_flip:7003) DEBUG: name = flip
last_ts = 305.189453
last_received_ts = 305.188904
last_seq = 12976
current_ts = 305.206573
current_received_ts = 305.206024
current_seq = 12977
count = 19
seq_step = 1
(kms_flip:7003) DEBUG: flip ts/seq: last 305.189453/12976, current 305.206573/12977: elapsed=17126.0us expected=17182.3us +- 85.9us, error 0.3%
(kms_flip:7003) DEBUG: name = flip
last_ts = 305.206573
last_received_ts = 305.206024
last_seq = 12977
current_ts = 305.223694
current_received_ts = 305.223145
current_seq = 12978
count = 20
seq_step = 1
(kms_flip:7003) DEBUG: flip ts/seq: last 305.206573/12977, current 305.223694/12978: elapsed=17124.0us expected=17182.3us +- 85.9us, error 0.3%
(kms_flip:7003) DEBUG: name = flip
last_ts = 305.223694
last_received_ts = 305.223145
last_seq = 12978
current_ts = 305.240814
current_received_ts = 305.240265
current_seq = 12979
count = 21
seq_step = 1
(kms_flip:7003) DEBUG: flip ts/seq: last 305.223694/12978, current 305.240814/12979: elapsed=17129.0us expected=17182.3us +- 85.9us, error 0.3%
(kms_flip:7003) DEBUG: name = flip
last_ts = 305.240814
last_received_ts = 305.240265
last_seq = 12979
current_ts = 305.257935
current_received_ts = 305.257324
current_seq = 12980
count = 22
seq_step = 1
(kms_flip:7003) DEBUG: flip ts/seq: last 305.240814/12979, current 305.257935/12980: elapsed=17122.0us expected=17182.3us +- 85.9us, error 0.4%
(kms_flip:7003) DEBUG: name = flip
last_ts = 305.257935
last_received_ts = 305.257324
last_seq = 12980
current_ts = 305.275085
current_received_ts = 305.274414
current_seq = 12981
count = 23
seq_step = 1
(kms_flip:7003) DEBUG: flip ts/seq: last 305.257935/12980, current 305.275085/12981: elapsed=17128.0us expected=17182.3us +- 85.9us, error 0.3%
(kms_flip:7003) DEBUG: name = flip
last_ts = 305.275085
last_received_ts = 305.274414
last_seq = 12981
current_ts = 305.292206
current_received_ts = 305.291565
current_seq = 12982
count = 24
seq_step = 1
(kms_flip:7003) DEBUG: flip ts/seq: last 305.275085/12981, current 305.292206/12982: elapsed=17135.0us expected=17182.3us +- 85.9us, error 0.3%
(kms_flip:7003) DEBUG: name = flip
last_ts = 305.292206
last_received_ts = 305.291565
last_seq = 12982
current_ts = 305.309326
current_received_ts = 305.308716
current_seq = 12983
count = 25
seq_step = 1
(kms_flip:7003) DEBUG: flip ts/seq: last 305.292206/12982, current 305.309326/12983: elapsed=17118.0us expected=17182.3us +- 85.9us, error 0.4%
(kms_flip:7003) DEBUG: name = flip
last_ts = 305.309326
last_received_ts = 305.308716
last_seq = 12983
current_ts = 305.326447
current_received_ts = 305.325836
current_seq = 12984
count = 26
seq_step = 1
(kms_flip:7003) DEBUG: flip ts/seq: last 305.309326/12983, current 305.326447/12984: elapsed=17120.0us expected=17182.3us +- 85.9us, error 0.4%
(kms_flip:7003) DEBUG: name = flip
last_ts = 305.326447
last_received_ts = 305.325836
last_seq = 12984
current_ts = 305.343567
current_received_ts = 305.342987
current_seq = 12985
count = 27
seq_step = 1
(kms_flip:7003) DEBUG: flip ts/seq: last 305.326447/12984, current 305.343567/12985: elapsed=17125.0us expected=17182.3us +- 85.9us, error 0.3%
(kms_flip:7003) DEBUG: name = flip
last_ts = 305.343567
last_received_ts = 305.342987
last_seq = 12985
current_ts = 305.360687
current_received_ts = 305.360077
current_seq = 12986
count = 28
seq_step = 1
(kms_flip:7003) DEBUG: flip ts/seq: last 305.343567/12985, current 305.360687/12986: elapsed=17123.0us expected=17182.3us +- 85.9us, error 0.3%
(kms_flip:7003) DEBUG: name = flip
last_ts = 305.360687
last_received_ts = 305.360077
last_seq = 12986
current_ts = 305.377838
current_received_ts = 305.377197
current_seq = 12987
count = 29
seq_step = 1
(kms_flip:7003) DEBUG: flip ts/seq: last 305.360687/12986, current 305.377838/12987: elapsed=17142.0us expected=17182.3us +- 85.9us, error 0.2%
(kms_flip:7003) DEBUG: name = flip
last_ts = 305.377838
last_received_ts = 305.377197
last_seq = 12987
current_ts = 305.394958
current_received_ts = 305.394226
current_seq = 12988
count = 30
seq_step = 1
(kms_flip:7003) DEBUG: flip ts/seq: last 305.377838/12987, current 305.394958/12988: elapsed=17107.0us expected=17182.3us +- 85.9us, error 0.4%
(kms_flip:7003) DEBUG: name = flip
last_ts = 305.394958
last_received_ts = 305.394226
last_seq = 12988
current_ts = 305.412079
current_received_ts = 305.411469
current_seq = 12989
count = 31
seq_step = 1
(kms_flip:7003) DEBUG: flip ts/seq: last 305.394958/12988, current 305.412079/12989: elapsed=17128.0us expected=17182.3us +- 85.9us, error 0.3%
(kms_flip:7003) DEBUG: name = flip
last_ts = 305.412079
last_received_ts = 305.411469
last_seq = 12989
current_ts = 305.429199
current_received_ts = 305.428528
current_seq = 12990
count = 32
seq_step = 1
(kms_flip:7003) DEBUG: flip ts/seq: last 305.412079/12989, current 305.429199/12990: elapsed=17131.0us expected=17182.3us +- 85.9us, error 0.3%
(kms_flip:7003) DEBUG: name = flip
last_ts = 305.429199
last_received_ts = 305.428528
last_seq = 12990
current_ts = 305.446320
current_received_ts = 305.445709
current_seq = 12991
count = 33
seq_step = 1
(kms_flip:7003) DEBUG: flip ts/seq: last 305.429199/12990, current 305.446320/12991: elapsed=17119.0us expected=17182.3us +- 85.9us, error 0.4%
(kms_flip:7003) DEBUG: name = flip
last_ts = 305.446320
last_received_ts = 305.445709
last_seq = 12991
current_ts = 305.463440
current_received_ts = 305.462830
current_seq = 12992
count = 34
seq_step = 1
(kms_flip:7003) DEBUG: flip ts/seq: last 305.446320/12991, current 305.463440/12992: elapsed=17127.0us expected=17182.3us +- 85.9us, error 0.3%
(kms_flip:7003) DEBUG: name = flip
last_ts = 305.463440
last_received_ts = 305.462830
last_seq = 12992
current_ts = 305.480591
current_received_ts = 305.479980
current_seq = 12993
count = 35
seq_step = 1
(kms_flip:7003) DEBUG: flip ts/seq: last 305.463440/12992, current 305.480591/12993: elapsed=17128.0us expected=17182.3us +- 85.9us, error 0.3%
(kms_flip:7003) DEBUG: name = flip
last_ts = 305.480591
last_received_ts = 305.479980
last_seq = 12993
current_ts = 305.497711
current_received_ts = 305.497131
current_seq = 12994
count = 36
seq_step = 1
(kms_flip:7003) DEBUG: flip ts/seq: last 305.480591/12993, current 305.497711/12994: elapsed=17121.0us expected=17182.3us +- 85.9us, error 0.4%
(kms_flip:7003) DEBUG: name = flip
last_ts = 305.497711
last_received_ts = 305.497131
last_seq = 12994
current_ts = 305.514832
current_received_ts = 305.514160
current_seq = 12995
count = 37
seq_step = 1
(kms_flip:7003) DEBUG: flip ts/seq: last 305.497711/12994, current 305.514832/12995: elapsed=17140.0us expected=17182.3us +- 85.9us, error 0.2%
(kms_flip:7003) DEBUG: name = flip
last_ts = 305.514832
last_received_ts = 305.514160
last_seq = 12995
current_ts = 305.531952
current_received_ts = 305.531372
current_seq = 12996
count = 38
seq_step = 1
(kms_flip:7003) DEBUG: flip ts/seq: last 305.514832/12995, current 305.531952/12996: elapsed=17106.0us expected=17182.3us +- 85.9us, error 0.4%
(kms_flip:7003) DEBUG: name = flip
last_ts = 305.531952
last_received_ts = 305.531372
last_seq = 12996
current_ts = 305.549072
current_received_ts = 305.548462
current_seq = 12997
count = 39
seq_step = 1
(kms_flip:7003) DEBUG: flip ts/seq: last 305.531952/12996, current 305.549072/12997: elapsed=17142.0us expected=17182.3us +- 85.9us, error 0.2%
(kms_flip:7003) DEBUG: name = flip
last_ts = 305.549072
last_received_ts = 305.548462
last_seq = 12997
current_ts = 305.566193
current_received_ts = 305.565643
current_seq = 12998
count = 40
seq_step = 1
(kms_flip:7003) DEBUG: flip ts/seq: last 305.549072/12997, current 305.566193/12998: elapsed=17114.0us expected=17182.3us +- 85.9us, error 0.4%
(kms_flip:7003) DEBUG: name = flip
last_ts = 305.566193
last_received_ts = 305.565643
last_seq = 12998
current_ts = 305.583313
current_received_ts = 305.582764
current_seq = 12999
count = 41
seq_step = 1
(kms_flip:7003) DEBUG: flip ts/seq: last 305.566193/12998, current 305.583313/12999: elapsed=17125.0us expected=17182.3us +- 85.9us, error 0.3%
(kms_flip:7003) DEBUG: name = flip
last_ts = 305.583313
last_received_ts = 305.582764
last_seq = 12999
current_ts = 305.600464
current_received_ts = 305.599854
current_seq = 13000
count = 42
seq_step = 1
(kms_flip:7003) DEBUG: flip ts/seq: last 305.583313/12999, current 305.600464/13000: elapsed=17129.0us expected=17182.3us +- 85.9us, error 0.3%
(kms_flip:7003) DEBUG: name = flip
last_ts = 305.600464
last_received_ts = 305.599854
last_seq = 13000
current_ts = 305.617584
current_received_ts = 305.617065
current_seq = 13001
count = 43
seq_step = 1
(kms_flip:7003) DEBUG: flip ts/seq: last 305.600464/13000, current 305.617584/13001: elapsed=17121.0us expected=17182.3us +- 85.9us, error 0.4%
(kms_flip:7003) DEBUG: name = flip
last_ts = 305.617584
last_received_ts = 305.617065
last_seq = 13001
current_ts = 305.634705
current_received_ts = 305.634186
current_seq = 13002
count = 44
seq_step = 1
(kms_flip:7003) DEBUG: flip ts/seq: last 305.617584/13001, current 305.634705/13002: elapsed=17125.0us expected=17182.3us +- 85.9us, error 0.3%
(kms_flip:7003) DEBUG: name = flip
last_ts = 305.634705
last_received_ts = 305.634186
last_seq = 13002
current_ts = 305.651825
current_received_ts = 305.651215
current_seq = 13003
count = 45
seq_step = 1
(kms_flip:7003) DEBUG: flip ts/seq: last 305.634705/13002, current 305.651825/13003: elapsed=17129.0us expected=17182.3us +- 85.9us, error 0.3%
(kms_flip:7003) DEBUG: name = flip
last_ts = 305.651825
last_received_ts = 305.651215
last_seq = 13003
current_ts = 305.668945
current_received_ts = 305.668365
current_seq = 13004
count = 46
seq_step = 1
(kms_flip:7003) DEBUG: flip ts/seq: last 305.651825/13003, current 305.668945/13004: elapsed=17123.0us expected=17182.3us +- 85.9us, error 0.3%
(kms_flip:7003) DEBUG: name = flip
last_ts = 305.668945
last_received_ts = 305.668365
last_seq = 13004
current_ts = 305.686066
current_received_ts = 305.685486
current_seq = 13005
count = 47
seq_step = 1
(kms_flip:7003) DEBUG: flip ts/seq: last 305.668945/13004, current 305.686066/13005: elapsed=17126.0us expected=17182.3us +- 85.9us, error 0.3%
(kms_flip:7003) DEBUG: name = flip
last_ts = 305.686066
last_received_ts = 305.685486
last_seq = 13005
current_ts = 305.703217
current_received_ts = 305.702637
current_seq = 13006
count = 48
seq_step = 1
(kms_flip:7003) DEBUG: flip ts/seq: last 305.686066/13005, current 305.703217/13006: elapsed=17123.0us expected=17182.3us +- 85.9us, error 0.3%
(kms_flip:7003) DEBUG: name = flip
last_ts = 305.703217
last_received_ts = 305.702637
last_seq = 13006
current_ts = 305.720337
current_received_ts = 305.719757
current_seq = 13007
count = 49
seq_step = 1
(kms_flip:7003) DEBUG: flip ts/seq: last 305.703217/13006, current 305.720337/13007: elapsed=17138.0us expected=17182.3us +- 85.9us, error 0.3%
(kms_flip:7003) DEBUG: name = flip
last_ts = 305.720337
last_received_ts = 305.719757
last_seq = 13007
current_ts = 305.737457
current_received_ts = 305.736877
current_seq = 13008
count = 50
seq_step = 1
(kms_flip:7003) DEBUG: flip ts/seq: last 305.720337/13007, current 305.737457/13008: elapsed=17108.0us expected=17182.3us +- 85.9us, error 0.4%
(kms_flip:7003) DEBUG: name = flip
last_ts = 305.737457
last_received_ts = 305.736877
last_seq = 13008
current_ts = 305.754578
current_received_ts = 305.754028
current_seq = 13009
count = 51
seq_step = 1
(kms_flip:7003) DEBUG: flip ts/seq: last 305.737457/13008, current 305.754578/13009: elapsed=17129.0us expected=17182.3us +- 85.9us, error 0.3%
(kms_flip:7003) DEBUG: name = flip
last_ts = 305.754578
last_received_ts = 305.754028
last_seq = 13009
current_ts = 305.771698
current_received_ts = 305.771149
current_seq = 13010
count = 52
seq_step = 1
(kms_flip:7003) DEBUG: flip ts/seq: last 305.754578/13009, current 305.771698/13010: elapsed=17125.0us expected=17182.3us +- 85.9us, error 0.3%
(kms_flip:7003) DEBUG: name = flip
last_ts = 305.771698
last_received_ts = 305.771149
last_seq = 13010
current_ts = 305.788849
current_received_ts = 305.788239
current_seq = 13011
count = 53
seq_step = 1
(kms_flip:7003) DEBUG: flip ts/seq: last 305.771698/13010, current 305.788849/13011: elapsed=17138.0us expected=17182.3us +- 85.9us, error 0.3%
(kms_flip:7003) DEBUG: name = flip
last_ts = 305.788849
last_received_ts = 305.788239
last_seq = 13011
current_ts = 305.805969
current_received_ts = 305.805389
current_seq = 13012
count = 54
seq_step = 1
(kms_flip:7003) DEBUG: flip ts/seq: last 305.788849/13011, current 305.805969/13012: elapsed=17128.0us expected=17182.3us +- 85.9us, error 0.3%
(kms_flip:7003) DEBUG: name = flip
last_ts = 305.805969
last_received_ts = 305.805389
last_seq = 13012
current_ts = 305.823090
current_received_ts = 305.822510
current_seq = 13013
count = 55
seq_step = 1
(kms_flip:7003) DEBUG: flip ts/seq: last 305.805969/13012, current 305.823090/13013: elapsed=17123.0us expected=17182.3us +- 85.9us, error 0.3%
(kms_flip:7003) DEBUG: name = flip
last_ts = 305.823090
last_received_ts = 305.822510
last_seq = 13013
current_ts = 305.840210
current_received_ts = 305.839630
current_seq = 13014
count = 56
seq_step = 1
(kms_flip:7003) DEBUG: flip ts/seq: last 305.823090/13013, current 305.840210/13014: elapsed=17110.0us expected=17182.3us +- 85.9us, error 0.4%
(kms_flip:7003) DEBUG: name = flip
last_ts = 305.840210
last_received_ts = 305.839630
last_seq = 13014
current_ts = 305.857330
current_received_ts = 305.856720
current_seq = 13015
count = 57
seq_step = 1
(kms_flip:7003) DEBUG: flip ts/seq: last 305.840210/13014, current 305.857330/13015: elapsed=17128.0us expected=17182.3us +- 85.9us, error 0.3%
(kms_flip:7003) DEBUG: name = flip
last_ts = 305.857330
last_received_ts = 305.856720
last_seq = 13015
current_ts = 305.874451
current_received_ts = 305.873901
current_seq = 13016
count = 58
seq_step = 1
(kms_flip:7003) DEBUG: flip ts/seq: last 305.857330/13015, current 305.874451/13016: elapsed=17125.0us expected=17182.3us +- 85.9us, error 0.3%
(kms_flip:7003) DEBUG: name = flip
last_ts = 305.874451
last_received_ts = 305.873901
last_seq = 13016
current_ts = 305.891571
current_received_ts = 305.890991
current_seq = 13017
count = 59
seq_step = 1
(kms_flip:7003) DEBUG: flip ts/seq: last 305.874451/13016, current 305.891571/13017: elapsed=17125.0us expected=17182.3us +- 85.9us, error 0.3%
(kms_flip:7003) DEBUG: name = flip
last_ts = 305.891571
last_received_ts = 305.890991
last_seq = 13017
current_ts = 305.908691
current_received_ts = 305.908173
current_seq = 13018
count = 60
seq_step = 1
(kms_flip:7003) DEBUG: flip ts/seq: last 305.891571/13017, current 305.908691/13018: elapsed=17124.0us expected=17182.3us +- 85.9us, error 0.3%
(kms_flip:7003) DEBUG: name = flip
last_ts = 305.908691
last_received_ts = 305.908173
last_seq = 13018
current_ts = 305.925842
current_received_ts = 305.925232
current_seq = 13019
count = 61
seq_step = 1
(kms_flip:7003) DEBUG: flip ts/seq: last 305.908691/13018, current 305.925842/13019: elapsed=17124.0us expected=17182.3us +- 85.9us, error 0.3%
(kms_flip:7003) DEBUG: name = flip
last_ts = 305.925842
last_received_ts = 305.925232
last_seq = 13019
current_ts = 305.942963
current_received_ts = 305.942413
current_seq = 13020
count = 62
seq_step = 1
(kms_flip:7003) DEBUG: flip ts/seq: last 305.925842/13019, current 305.942963/13020: elapsed=17132.0us expected=17182.3us +- 85.9us, error 0.3%
(kms_flip:7003) DEBUG: name = flip
last_ts = 305.942963
last_received_ts = 305.942413
last_seq = 13020
current_ts = 305.960083
current_received_ts = 305.959534
current_seq = 13021
count = 63
seq_step = 1
(kms_flip:7003) DEBUG: flip ts/seq: last 305.942963/13020, current 305.960083/13021: elapsed=17127.0us expected=17182.3us +- 85.9us, error 0.3%
(kms_flip:7003) DEBUG: name = flip
last_ts = 305.960083
last_received_ts = 305.959534
last_seq = 13021
current_ts = 305.977203
current_received_ts = 305.976654
current_seq = 13022
count = 64
seq_step = 1
(kms_flip:7003) DEBUG: flip ts/seq: last 305.960083/13021, current 305.977203/13022: elapsed=17120.0us expected=17182.3us +- 85.9us, error 0.4%
(kms_flip:7003) DEBUG: name = flip
last_ts = 305.977203
last_received_ts = 305.976654
last_seq = 13022
current_ts = 305.994324
current_received_ts = 305.993805
current_seq = 13023
count = 65
seq_step = 1
(kms_flip:7003) DEBUG: flip ts/seq: last 305.977203/13022, current 305.994324/13023: elapsed=17128.0us expected=17182.3us +- 85.9us, error 0.3%
(kms_flip:7003) DEBUG: name = flip
last_ts = 305.994324
last_received_ts = 305.993805
last_seq = 13023
current_ts = 306.011444
current_received_ts = 306.010925
current_seq = 13024
count = 66
seq_step = 1
(kms_flip:7003) DEBUG: flip ts/seq: last 305.994324/13023, current 306.011444/13024: elapsed=17120.0us expected=17182.3us +- 85.9us, error 0.4%
(kms_flip:7003) DEBUG: name = flip
last_ts = 306.011444
last_received_ts = 306.010925
last_seq = 13024
current_ts = 306.028564
current_received_ts = 306.028046
current_seq = 13025
count = 67
seq_step = 1
(kms_flip:7003) DEBUG: flip ts/seq: last 306.011444/13024, current 306.028564/13025: elapsed=17118.0us expected=17182.3us +- 85.9us, error 0.4%
(kms_flip:7003) DEBUG: name = flip
last_ts = 306.028564
last_received_ts = 306.028046
last_seq = 13025
current_ts = 306.045624
current_received_ts = 306.045135
current_seq = 13026
count = 68
seq_step = 1
(kms_flip:7003) DEBUG: flip ts/seq: last 306.028564/13025, current 306.045624/13026: elapsed=17060.0us expected=17182.3us +- 85.9us, error 0.7%
(kms_flip:7003) DEBUG: inconsistent flip ts/seq: last 306.028564/13025, current 306.045624/13026: elapsed=17060.0us expected=17182.3us
(kms_flip:7003) DEBUG: expected 71503, counted 68, encoder type 1
(kms_flip:7003) DEBUG: dropped frames, expected 71503, counted 68, encoder type 1
(kms_flip:7003) CRITICAL: Test assertion failure function __run_test_on_crtc_set, file ../tests/kms_flip.c:1674:
(kms_flip:7003) CRITICAL: Failed assertion: !retried && needs_retry_after_link_reset(mon)
(kms_flip:7003) igt_core-INFO: Stack trace:
(kms_flip:7003) igt_core-INFO:   #0 ../lib/igt_core.c:2055 __igt_fail_assert()
(kms_flip:7003) igt_core-INFO:   #1 ../tests/kms_flip.c:791 run_test_on_crtc_set.constprop.0()
(kms_flip:7003) igt_core-INFO:   #2 ../tests/kms_flip.c:1845 run_test()
(kms_flip:7003) igt_core-INFO:   #3 ../tests/kms_flip.c:2078 __igt_unique____real_main2001()
(kms_flip:7003) igt_core-INFO:   #4 ../tests/kms_flip.c:2001 main()
(kms_flip:7003) igt_core-INFO:   #5 [__libc_init_first+0x8a]
(kms_flip:7003) igt_core-INFO:   #6 [__libc_start_main+0x8b]
(kms_flip:7003) igt_core-INFO:   #7 [_start+0x25]
****  END  ****
Dynamic subtest A-VGA1: FAIL (4.646s)
Dmesg
<6> [303.677900] Console: switching to colour dummy device 80x25
<6> [303.678680] [IGT] kms_flip: executing
<7> [303.683457] i915 0000:00:02.0: [drm:i915_gem_open [i915]]
<7> [303.684342] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc]
<7> [303.684738] i915 0000:00:02.0: [drm:i915_gem_open [i915]]
<7> [303.687950] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] [CONNECTOR:64:VGA-1]
<7> [303.687977] i915 0000:00:02.0: [drm:intel_crt_detect [i915]] [CONNECTOR:64:VGA-1] force=1
<7> [303.688217] i915 0000:00:02.0: [drm:intel_crt_detect [i915]] ironlake hotplug adpa=0xf40000, result 0
<7> [303.688426] i915 0000:00:02.0: [drm:intel_crt_detect [i915]] CRT not detected via hotplug
<7> [303.688873] i915 0000:00:02.0: [drm:do_gmbus_xfer [i915]] GMBUS [i915 gmbus vga] NAK for addr: 0050 w(1)
<7> [303.689183] i915 0000:00:02.0: [drm:do_gmbus_xfer [i915]] GMBUS [i915 gmbus vga] NAK on first message, retry
<7> [303.689562] i915 0000:00:02.0: [drm:do_gmbus_xfer [i915]] GMBUS [i915 gmbus vga] NAK for addr: 0050 w(1)
<7> [303.689763] [drm:drm_do_probe_ddc_edid] drm: skipping non-existent adapter i915 gmbus vga
<7> [303.689770] i915 0000:00:02.0: [drm:intel_crt_get_edid [i915]] CRT GMBUS EDID read failed, retry using GPIO bit-banging
<7> [303.690021] i915 0000:00:02.0: [drm:intel_gmbus_force_bit [i915]] enabling bit-banging on i915 gmbus vga. force bit now 1
<7> [303.691306] [drm:drm_do_probe_ddc_edid] drm: skipping non-existent adapter i915 gmbus vga
<7> [303.691313] i915 0000:00:02.0: [drm:intel_gmbus_force_bit [i915]] disabling bit-banging on i915 gmbus vga. force bit now 0
<7> [303.691529] i915 0000:00:02.0: [drm:intel_crt_detect_ddc [i915]] CRT not detected via DDC:0x50 [no valid EDID found]
<7> [303.691736] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] [CONNECTOR:64:VGA-1] disconnected
<7> [303.692268] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] [CONNECTOR:75:DP-1]
<7> [303.692286] i915 0000:00:02.0: [drm:intel_dp_detect [i915]] [CONNECTOR:75:DP-1]
<7> [303.696087] i915 0000:00:02.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DP D: timeout (status 0x7143003f)
<7> [303.699996] i915 0000:00:02.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DP D: timeout (status 0x7143003f)
<7> [303.703884] i915 0000:00:02.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DP D: timeout (status 0x7143003f)
<7> [303.707756] i915 0000:00:02.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DP D: timeout (status 0x7143003f)
<7> [303.711652] i915 0000:00:02.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DP D: timeout (status 0x7143003f)
<7> [303.715550] i915 0000:00:02.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DP D: timeout (status 0x7143003f)
<7> [303.719452] i915 0000:00:02.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DP D: timeout (status 0x7143003f)
<7> [303.723337] i915 0000:00:02.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DP D: timeout (status 0x7143003f)
<7> [303.727247] i915 0000:00:02.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DP D: timeout (status 0x7143003f)
<7> [303.731184] i915 0000:00:02.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DP D: timeout (status 0x7143003f)
<7> [303.735052] i915 0000:00:02.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DP D: timeout (status 0x7143003f)
<7> [303.739172] i915 0000:00:02.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DP D: timeout (status 0x7143003f)
<7> [303.743095] i915 0000:00:02.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DP D: timeout (status 0x7143003f)
<7> [303.747217] i915 0000:00:02.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DP D: timeout (status 0x7143003f)
<7> [303.751116] i915 0000:00:02.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DP D: timeout (status 0x7143003f)
<7> [303.755286] i915 0000:00:02.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DP D: timeout (status 0x7143003f)
<7> [303.759388] i915 0000:00:02.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DP D: timeout (status 0x7143003f)
<7> [303.763308] i915 0000:00:02.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DP D: timeout (status 0x7143003f)
<7> [303.767416] i915 0000:00:02.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DP D: timeout (status 0x7143003f)
<7> [303.771328] i915 0000:00:02.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DP D: timeout (status 0x7143003f)
<7> [303.775451] i915 0000:00:02.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DP D: timeout (status 0x7143003f)
<7> [303.779317] i915 0000:00:02.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DP D: timeout (status 0x7143003f)
<7> [303.783487] i915 0000:00:02.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DP D: timeout (status 0x7143003f)
<7> [303.787399] i915 0000:00:02.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DP D: timeout (status 0x7143003f)
<7> [303.791503] i915 0000:00:02.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DP D: timeout (status 0x7143003f)
<7> [303.795392] i915 0000:00:02.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DP D: timeout (status 0x7143003f)
<7> [303.799497] i915 0000:00:02.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DP D: timeout (status 0x7143003f)
<7> [303.803415] i915 0000:00:02.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DP D: timeout (status 0x7143003f)
<7> [303.807579] i915 0000:00:02.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DP D: timeout (status 0x7143003f)
<7> [303.811697] i915 0000:00:02.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DP D: timeout (status 0x7143003f)
<7> [303.815545] i915 0000:00:02.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DP D: timeout (status 0x7143003f)
<7> [303.819551] i915 0000:00:02.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DP D: timeout (status 0x7143003f)
<7> [303.819973] 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> [303.820009] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] [CONNECTOR:75:DP-1] disconnected
<7> [303.820477] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] [CONNECTOR:64:VGA-1]
<7> [303.820501] i915 0000:00:02.0: [drm:intel_crt_detect [i915]] [CONNECTOR:64:VGA-1] force=1
<7> [303.820780] i915 0000:00:02.0: [drm:intel_crt_detect [i915]] ironlake hotplug adpa=0xf40000, result 0
<7> [303.821048] i915 0000:00:02.0: [drm:intel_crt_detect [i915]] CRT not detected via hotplug
<7> [303.821540] i915 0000:00:02.0: [drm:do_gmbus_xfer [i915]] GMBUS [i915 gmbus vga] NAK for addr: 0050 w(1)
<7> [303.821964] i915 0000:00:02.0: [drm:do_gmbus_xfer [i915]] GMBUS [i915 gmbus vga] NAK on first message, retry
<7> [303.822607] i915 0000:00:02.0: [drm:do_gmbus_xfer [i915]] GMBUS [i915 gmbus vga] NAK for addr: 0050 w(1)
<7> [303.822894] [drm:drm_do_probe_ddc_edid] drm: skipping non-existent adapter i915 gmbus vga
<7> [303.822904] i915 0000:00:02.0: [drm:intel_crt_get_edid [i915]] CRT GMBUS EDID read failed, retry using GPIO bit-banging
<7> [303.823217] i915 0000:00:02.0: [drm:intel_gmbus_force_bit [i915]] enabling bit-banging on i915 gmbus vga. force bit now 1
<7> [303.824586] [drm:drm_do_probe_ddc_edid] drm: skipping non-existent adapter i915 gmbus vga
<7> [303.824593] i915 0000:00:02.0: [drm:intel_gmbus_force_bit [i915]] disabling bit-banging on i915 gmbus vga. force bit now 0
<7> [303.824801] i915 0000:00:02.0: [drm:intel_crt_detect_ddc [i915]] CRT not detected via DDC:0x50 [no valid EDID found]
<7> [303.825010] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] [CONNECTOR:64:VGA-1] disconnected
<7> [303.825315] i915 0000:00:02.0: [drm:status_store] [CONNECTOR:64:VGA-1] force updated from 0 to 2 or reprobing
<7> [303.825324] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] [CONNECTOR:64:VGA-1]
<7> [303.825341] 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> [303.825370] i915 0000:00:02.0: [drm:drm_sysfs_hotplug_event] generating hotplug event
<7> [303.825471] i915 0000:00:02.0: [drm:drm_client_dev_hotplug] intel-fbdev: ret=0
<7> [303.825711] i915 0000:00:02.0: [drm:do_gmbus_xfer [i915]] GMBUS [i915 gmbus vga] NAK for addr: 0050 w(1)
<7> [303.826028] i915 0000:00:02.0: [drm:do_gmbus_xfer [i915]] GMBUS [i915 gmbus vga] NAK on first message, retry
<7> [303.826459] i915 0000:00:02.0: [drm:do_gmbus_xfer [i915]] GMBUS [i915 gmbus vga] NAK for addr: 0050 w(1)
<7> [303.826682] [drm:drm_do_probe_ddc_edid] drm: skipping non-existent adapter i915 gmbus vga
<7> [303.826696] i915 0000:00:02.0: [drm:intel_crt_get_edid [i915]] CRT GMBUS EDID read failed, retry using GPIO bit-banging
<7> [303.826903] i915 0000:00:02.0: [drm:intel_gmbus_force_bit [i915]] enabling bit-banging on i915 gmbus vga. force bit now 1
<7> [303.828162] [drm:drm_do_probe_ddc_edid] drm: skipping non-existent adapter i915 gmbus vga
<7> [303.828175] i915 0000:00:02.0: [drm:intel_gmbus_force_bit [i915]] disabling bit-banging on i915 gmbus vga. force bit now 0
<7> [303.828497] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] [CONNECTOR:64:VGA-1] probed modes:
<7> [303.828517] 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> [303.828532] 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> [303.828547] 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> [303.828562] 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> [303.828576] 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> [303.828632] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] [CONNECTOR:64:VGA-1]
<7> [303.828829] i915 0000:00:02.0: [drm:do_gmbus_xfer [i915]] GMBUS [i915 gmbus vga] NAK for addr: 0050 w(1)
<7> [303.829065] i915 0000:00:02.0: [drm:do_gmbus_xfer [i915]] GMBUS [i915 gmbus vga] NAK on first message, retry
<7> [303.829451] i915 0000:00:02.0: [drm:do_gmbus_xfer [i915]] GMBUS [i915 gmbus vga] NAK for addr: 0050 w(1)
<7> [303.829658] [drm:drm_do_probe_ddc_edid] drm: skipping non-existent adapter i915 gmbus vga
<7> [303.829672] i915 0000:00:02.0: [drm:intel_crt_get_edid [i915]] CRT GMBUS EDID read failed, retry using GPIO bit-banging
<7> [303.829878] i915 0000:00:02.0: [drm:intel_gmbus_force_bit [i915]] enabling bit-banging on i915 gmbus vga. force bit now 1
<7> [303.831128] [drm:drm_do_probe_ddc_edid] drm: skipping non-existent adapter i915 gmbus vga
<7> [303.831141] i915 0000:00:02.0: [drm:intel_gmbus_force_bit [i915]] disabling bit-banging on i915 gmbus vga. force bit now 0
<7> [303.831423] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] [CONNECTOR:64:VGA-1] probed modes:
<7> [303.831441] 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> [303.831456] 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> [303.831470] 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> [303.831485] 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> [303.831498] 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> [303.831532] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] [CONNECTOR:67:HDMI-A-1]
<7> [303.831551] i915 0000:00:02.0: [drm:intel_hdmi_detect [i915]] [CONNECTOR:67:HDMI-A-1]
<7> [303.857425] 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> [303.857438] i915 0000:00:02.0: [drm:update_display_info.part.0] [CONNECTOR:67:HDMI-A-1] HDMI sink does deep color 30.
<7> [303.857445] i915 0000:00:02.0: [drm:update_display_info.part.0] [CONNECTOR:67:HDMI-A-1] HDMI sink does deep color 36.
<7> [303.857450] i915 0000:00:02.0: [drm:update_display_info.part.0] [CONNECTOR:67:HDMI-A-1] HDMI sink does deep color 48.
<7> [303.857456] 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> [303.857461] i915 0000:00:02.0: [drm:update_display_info.part.0] [CONNECTOR:67:HDMI-A-1] HDMI sink does YCRCB444 in deep color.
<7> [303.857469] i915 0000:00:02.0: [drm:update_display_info.part.0] [CONNECTOR:67:HDMI-A-1] ELD monitor Mi TV
<7> [303.857476] 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> [303.857483] i915 0000:00:02.0: [drm:update_display_info.part.0] [CONNECTOR:67:HDMI-A-1] ELD size 36, SAD count 3
<7> [303.857710] i915 0000:00:02.0: [drm:do_gmbus_xfer [i915]] GMBUS [i915 gmbus dpd] NAK for addr: 0040 w(1)
<7> [303.858037] i915 0000:00:02.0: [drm:do_gmbus_xfer [i915]] GMBUS [i915 gmbus dpd] NAK on first message, retry
<7> [303.858572] i915 0000:00:02.0: [drm:do_gmbus_xfer [i915]] GMBUS [i915 gmbus dpd] NAK for addr: 0040 w(1)
<7> [303.858927] i915 0000:00:02.0: [drm:drm_dp_dual_mode_detect [drm_display_helper]] DP dual mode HDMI ID: (err -6)
<7> [303.860914] 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> [303.860928] 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> [303.860937] 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> [303.860945] 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> [303.860953] 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> [303.860961] 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> [303.860969] 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> [303.860977] 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> [303.860985] 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> [303.860993] 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> [303.861000] 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> [303.861008] 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> [303.861016] 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> [303.861024] 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> [303.861031] 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> [303.861039] 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> [303.861068] 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> [303.861077] 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> [303.861085] 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> [303.861099] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] [CONNECTOR:67:HDMI-A-1] probed modes:
<7> [303.861129] 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> [303.861156] 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> [303.861182] 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> [303.861208] 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> [303.861234] 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> [303.861260] 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> [303.861287] 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> [303.861310] 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> [303.861324] 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> [303.861339] 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> [303.861353] 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> [303.861367] 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> [303.861381] 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> [303.861395] 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> [303.861409] 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> [303.861424] 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> [303.861438] 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> [303.861452] 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> [303.861466] 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> [303.861480] 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> [303.861494] 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> [303.861509] 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> [303.861523] 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> [303.861537] 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> [303.861551] 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> [303.861565] 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> [303.861579] 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> [303.861594] 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> [303.861608] 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> [303.861621] 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> [303.861635] 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> [303.861650] 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> [303.861663] 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> [303.861677] 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> [303.861691] 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> [303.861705] 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> [303.861719] 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> [303.861733] 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> [303.861746] 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> [303.861760] 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> [303.861774] 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> [303.861788] 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> [303.861802] 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> [303.861816] 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> [303.861830] 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> [303.861908] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] [CONNECTOR:75:DP-1]
<7> [303.861925] i915 0000:00:02.0: [drm:intel_dp_detect [i915]] [CONNECTOR:75:DP-1]
<7> [303.865833] i915 0000:00:02.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DP D: timeout (status 0x7143003f)
<7> [303.869796] i915 0000:00:02.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DP D: timeout (status 0x7143003f)
<7> [303.873683] i915 0000:00:02.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DP D: timeout (status 0x7143003f)
<7> [303.877579] i915 0000:00:02.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DP D: timeout (status 0x7143003f)
<7> [303.881427] i915 0000:00:02.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DP D: timeout (status 0x7143003f)
<7> [303.885339] i915 0000:00:02.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DP D: timeout (status 0x7143003f)
<7> [303.889271] i915 0000:00:02.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DP D: timeout (status 0x7143003f)
<7> [303.893149] i915 0000:00:02.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DP D: timeout (status 0x7143003f)
<7> [303.897007] i915 0000:00:02.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DP D: timeout (status 0x7143003f)
<7> [303.900895] i915 0000:00:02.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DP D: timeout (status 0x7143003f)
<7> [303.904740] i915 0000:00:02.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DP D: timeout (status 0x7143003f)
<7> [303.908627] i915 0000:00:02.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DP D: timeout (status 0x7143003f)
<7> [303.912576] i915 0000:00:02.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DP D: timeout (status 0x7143003f)
<7> [303.916499] i915 0000:00:02.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DP D: timeout (status 0x7143003f)
<7> [303.920380] i915 0000:00:02.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DP D: timeout (status 0x7143003f)
<7> [303.924270] i915 0000:00:02.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DP D: timeout (status 0x7143003f)
<7> [303.928783] i915 0000:00:02.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DP D: timeout (status 0x7143003f)
<7> [303.932680] i915 0000:00:02.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DP D: timeout (status 0x7143003f)
<7> [303.936642] i915 0000:00:02.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DP D: timeout (status 0x7143003f)
<7> [303.940613] i915 0000:00:02.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DP D: timeout (status 0x7143003f)
<7> [303.944513] i915 0000:00:02.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DP D: timeout (status 0x7143003f)
<7> [303.948616] i915 0000:00:02.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DP D: timeout (status 0x7143003f)
<7> [303.952502] i915 0000:00:02.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DP D: timeout (status 0x7143003f)
<7> [303.956658] i915 0000:00:02.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DP D: timeout (status 0x7143003f)
<7> [303.960616] i915 0000:00:02.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DP D: timeout (status 0x7143003f)
<7> [303.964507] i915 0000:00:02.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DP D: timeout (status 0x7143003f)
<7> [303.968508] i915 0000:00:02.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DP D: timeout (status 0x7143003f)
<7> [303.972476] i915 0000:00:02.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DP D: timeout (status 0x7143003f)
<7> [303.976560] i915 0000:00:02.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DP D: timeout (status 0x7143003f)
<7> [303.980486] i915 0000:00:02.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DP D: timeout (status 0x7143003f)
<7> [303.984400] i915 0000:00:02.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DP D: timeout (status 0x7143003f)
<7> [303.988503] i915 0000:00:02.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DP D: timeout (status 0x7143003f)
<7> [303.988853] 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> [303.988909] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] [CONNECTOR:75:DP-1] disconnected
<6> [303.991000] [IGT] kms_flip: starting subtest plain-flip-fb-recreate
<6> [303.993321] [IGT] kms_flip: starting dynamic subtest A-VGA1
<7> [303.993881] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:82]
<7> [303.994024] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:83]
<7> [304.041646] i915 0000:00:02.0: [drm:drm_mode_setcrtc] [CRTC:47:pipe A]
<7> [304.041840] 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> [304.042332] 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> [304.042747] 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> [304.043270] 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> [304.043685] 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> [304.044121] 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> [304.044549] 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> [304.044996] 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> [304.045416] 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> [304.045958] 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> [304.046365] 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> [304.046619] 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> [304.046831] 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> [304.047062] 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> [304.047273] 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> [304.047484] 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> [304.047711] 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> [304.048020] 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> [304.048502] 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> [304.048775] 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> [304.049058] 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> [304.049315] 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> [304.049570] 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> [304.050024] 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> [304.050532] 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> [304.050813] 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> [304.051060] 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> [304.051307] 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> [304.051562] 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> [304.051961] 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> [304.052234] 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> [304.052455] 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> [304.052665] 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> [304.052902] 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> [304.053113] 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> [304.053326] 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> [304.053593] 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> [304.053920] 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> [304.054230] 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> [304.054537] 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> [304.054803] 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> [304.055014] 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> [304.055235] 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> [304.055447] 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> [304.055708] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:47:pipe A] fastset requirement not met in avi infoframe
<7> [304.055937] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] expected:
<7> [304.056149] i915 0000:00:02.0: HDMI infoframe: Auxiliary Video Information (AVI), version 2, length 13
<7> [304.056152] i915 0000:00:02.0: colorspace: RGB
<7> [304.056155] i915 0000:00:02.0: scan mode: Underscan
<7> [304.056157] i915 0000:00:02.0: colorimetry: No Data
<7> [304.056159] i915 0000:00:02.0: picture aspect: 16:9
<7> [304.056162] i915 0000:00:02.0: active aspect: Same as Picture
<7> [304.056164] i915 0000:00:02.0: itc: No Data
<7> [304.056166] i915 0000:00:02.0: extended colorimetry: xvYCC 601
<7> [304.056169] i915 0000:00:02.0: quantization range: Default
<7> [304.056171] i915 0000:00:02.0: nups: Unknown Non-uniform Scaling
<7> [304.056173] i915 0000:00:02.0: video code: 16
<7> [304.056175] i915 0000:00:02.0: ycc quantization range: Full
<7> [304.056178] i915 0000:00:02.0: hdmi content type: Graphics
<7> [304.056180] i915 0000:00:02.0: pixel repeat: 0
<7> [304.056182] i915 0000:00:02.0: bar top 0, bottom 0, left 0, right 0
<7> [304.056185] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] found:
<7> [304.056389] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:47:pipe A] fastset requirement not met in spd infoframe
<7> [304.056619] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] expected:
<7> [304.056859] i915 0000:00:02.0: HDMI infoframe: Source Product Description (SPD), version 1, length 25
<7> [304.056862] i915 0000:00:02.0: vendor: Intel
<7> [304.056864] i915 0000:00:02.0: product: Integrated gfx
<7> [304.056866] i915 0000:00:02.0: source device information: PC General (0x9)
<7> [304.056869] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] found:
<7> [304.057095] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:47:pipe A] fastset requirement not met in hdmi infoframe
<7> [304.057309] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] expected:
<7> [304.057532] i915 0000:00:02.0: HDMI infoframe: Vendor, version 1, length 4
<7> [304.057535] i915 0000:00:02.0: empty frame
<7> [304.057537] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] found:
<7> [304.057809] i915 0000:00:02.0: [drm:intel_atomic_check [i915]] [CRTC:47:pipe A] fastset requirement not met, forcing full modeset
<7> [304.058037] i915 0000:00:02.0: [drm:intel_unreference_shared_dpll_crtc [i915]] [CRTC:47:pipe A] releasing PCH DPLL A
<7> [304.058298] i915 0000:00:02.0: [drm:intel_modeset_calc_cdclk [i915]] New cdclk calculated to be logical 400000 kHz, actual 400000 kHz
<7> [304.058533] i915 0000:00:02.0: [drm:intel_modeset_calc_cdclk [i915]] New voltage level calculated to be logical 0, actual 0
<7> [304.058796] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [CRTC:47:pipe A] enable: no [modeset]
<7> [304.059044] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:32:primary A] fb: [NOFB], visible: no
<7> [304.059332] 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> [304.085669] i915 0000:00:02.0: [drm:intel_audio_component_get_eld [i915]] Not valid for port D
<7> [304.086504] i915 0000:00:02.0: [drm:intel_disable_transcoder [i915]] disabling pipe A
<7> [304.103692] i915 0000:00:02.0: [drm:g4x_dp_port_enabled [i915]] No pipe for DP port B found
<7> [304.104141] i915 0000:00:02.0: [drm:g4x_dp_port_enabled [i915]] No pipe for DP port C found
<7> [304.104623] i915 0000:00:02.0: [drm:g4x_dp_port_enabled [i915]] No pipe for DP port D found
<7> [304.116424] 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> [304.116886] i915 0000:00:02.0: [drm:intel_disable_shared_dpll [i915]] disabling PCH DPLL A
<7> [304.117585] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:65:CRT]
<7> [304.118032] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:66:HDMI D]
<7> [304.118464] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:74:DP D]
<7> [304.118918] i915 0000:00:02.0: [drm:verify_connector_state [i915]] [CONNECTOR:67:HDMI-A-1]
<7> [304.119440] i915 0000:00:02.0: [drm:intel_modeset_verify_crtc [i915]] [CRTC:47:pipe A]
<7> [304.119757] i915 0000:00:02.0: [drm:drm_mode_setcrtc] [CRTC:63:pipe B]
<7> [304.119946] i915 0000:00:02.0: [drm:drm_mode_setcrtc] [CRTC:47:pipe A]
<7> [304.119975] i915 0000:00:02.0: [drm:drm_mode_setcrtc] [CONNECTOR:64:VGA-1]
<7> [304.120068] 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> [304.120290] i915 0000:00:02.0: [drm:intel_atomic_check [i915]] [CRTC:47:pipe A] hw max bpp: 24, pipe bpp: 24, dithering: 0
<7> [304.120496] i915 0000:00:02.0: [drm:intel_fdi_atomic_check_link [i915]] checking fdi config on pipe A, lanes 1
<7> [304.120697] 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> [304.120943] 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> [304.121167] 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> [304.121372] 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> [304.121576] 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> [304.121798] 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> [304.122018] 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> [304.122224] 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> [304.122428] 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> [304.122632] 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> [304.122862] 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> [304.123088] 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> [304.123292] 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> [304.123496] 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> [304.123700] 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> [304.123959] 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> [304.124174] 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> [304.124389] 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> [304.124599] 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> [304.124837] 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> [304.125048] 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> [304.125259] 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> [304.125469] 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> [304.125687] 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> [304.125897] 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> [304.126106] 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> [304.126316] 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> [304.126526] 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> [304.126745] 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> [304.126956] 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> [304.127167] 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> [304.127376] 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> [304.127586] 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> [304.127822] 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> [304.128034] 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> [304.128250] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:47:pipe A] fastset requirement not met in dpll_hw_state
<7> [304.128453] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] expected:
<7> [304.128688] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] dpll_hw_state: dpll: 0xc4010001, dpll_md: 0x0, fp0: 0x30f06, fp1: 0x30f06
<7> [304.128929] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] found:
<7> [304.129132] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] dpll_hw_state: dpll: 0x84100010, dpll_md: 0x0, fp0: 0x10c09, fp1: 0x10c09
<7> [304.129336] 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> [304.129540] 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> [304.129767] 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> [304.129992] 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> [304.130197] i915 0000:00:02.0: [drm:intel_atomic_check [i915]] [CRTC:47:pipe A] fastset requirement not met, forcing full modeset
<7> [304.130439] 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> [304.130687] i915 0000:00:02.0: [drm:intel_modeset_calc_cdclk [i915]] New cdclk calculated to be logical 400000 kHz, actual 400000 kHz
<7> [304.130912] i915 0000:00:02.0: [drm:intel_modeset_calc_cdclk [i915]] New voltage level calculated to be logical 0, actual 0
<7> [304.131119] i915 0000:00:02.0: [drm:intel_find_shared_dpll [i915]] [CRTC:47:pipe A] allocated PCH DPLL A
<7> [304.131320] i915 0000:00:02.0: [drm:intel_reference_shared_dpll_crtc [i915]] [CRTC:47:pipe A] reserving PCH DPLL A
<7> [304.131560] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [CRTC:47:pipe A] enable: yes [modeset]
<7> [304.131778] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] active: yes, output_types: ANALOG (0x2), output format: RGB, sink format: RGB
<7> [304.132015] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] cpu_transcoder: A, pipe bpp: 24, dithering: 0
<7> [304.132219] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] MST master transcoder: <invalid>
<7> [304.132422] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] port sync: master transcoder: <invalid>, slave transcoder bitmask = 0x0
<7> [304.132684] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] joiner: no, pipes: 0x0
<7> [304.132895] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] splitter: disabled, link count 0, overlap 0
<7> [304.133104] 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> [304.133314] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] audio: 0, infoframes: 0, infoframes enabled: 0x0
<7> [304.133541] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] scanline offset: 1
<7> [304.133750] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] vblank delay: 0, framestart delay: 1, MSA timing delay: 0
<7> [304.133959] 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> [304.134169] 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> [304.134379] 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> [304.134616] 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> [304.134828] 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> [304.135040] 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> [304.135250] 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> [304.135477] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] port clock: 64800, pipe src: 1024x768+0+0, pixel rate 64800
<7> [304.135688] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] linetime: 0, ips linetime: 0
<7> [304.135897] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pch pfit: 0x0+0+0, disabled, force thru: no
<7> [304.136107] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] ips: 0, double wide: 0, drrs: 0
<7> [304.136319] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] dpll_hw_state: dpll: 0x84100010, dpll_md: 0x0, fp0: 0x10c09, fp1: 0x10c09
<7> [304.136567] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] csc_mode: 0x3 gamma_mode: 0x0 gamma_enable: 0 csc_enable: 0
<7> [304.136818] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pre csc lut: 0 entries, post csc lut: 0 entries
<7> [304.137028] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pipe csc: pre offsets: 0x0000 0x0000 0x0000
<7> [304.137238] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pipe csc: coefficients: 0x0000 0x0000 0x0000
<7> [304.137476] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pipe csc: coefficients: 0x0000 0x0000 0x0000
<7> [304.137487] i915 0000:00:02.0: [drm:intel_power_well_disable [i915]] disabling always-on
<7> [304.137816] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pipe csc: coefficients: 0x0000 0x0000 0x0000
<7> [304.138040] 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> [304.138247] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] rotation: 0x1, scaler: -1, scaling_filter: 0
<7> [304.138504] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] src: 1024.000000x768.000000+0.000000+0.000000 dst: 1024x768+0+0
<7> [304.139855] i915 0000:00:02.0: [drm:intel_power_well_enable [i915]] enabling always-on
<7> [304.140087] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:65:CRT]
<7> [304.140318] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:66:HDMI D]
<7> [304.140529] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:74:DP D]
<7> [304.141288] i915 0000:00:02.0: [drm:intel_enable_transcoder [i915]] enabling pipe A
<7> [304.142328] i915 0000:00:02.0: [drm:gen6_fdi_link_train [i915]] FDI_RX_IIR 0x100
<7> [304.142639] i915 0000:00:02.0: [drm:gen6_fdi_link_train [i915]] FDI train 1 done.
<7> [304.143508] i915 0000:00:02.0: [drm:gen6_fdi_link_train [i915]] FDI_RX_IIR 0x200
<7> [304.143709] i915 0000:00:02.0: [drm:gen6_fdi_link_train [i915]] FDI train 2 done.
<7> [304.143908] i915 0000:00:02.0: [drm:gen6_fdi_link_train [i915]] FDI train done.
<7> [304.144124] 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> [304.144370] i915 0000:00:02.0: [drm:intel_enable_shared_dpll [i915]] enabling PCH DPLL A
<7> [304.196368] i915 0000:00:02.0: [drm:verify_connector_state [i915]] [CONNECTOR:64:VGA-1]
<7> [304.196874] i915 0000:00:02.0: [drm:intel_modeset_verify_crtc [i915]] [CRTC:47:pipe A]
<7> [304.497391] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:84]
<7> [304.514091] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:82]
<7> [304.530780] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:83]
<7> [304.547566] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:84]
<7> [304.564235] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:82]
<7> [304.581024] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:83]
<7> [304.597693] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:84]
<7> [304.614365] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:82]
<7> [304.631095] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:83]
<7> [304.647803] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:84]
<7> [304.664565] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:82]
<7> [304.681379] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:83]
<7> [304.698090] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:84]
<7> [304.714783] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:82]
<7> [304.731483] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:83]
<7> [304.748158] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:84]
<7> [304.764898] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:82]
<7> [304.781637] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:83]
<7> [304.798334] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:84]
<7> [304.815102] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:82]
<7> [304.831813] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:83]
<7> [304.848500] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:84]
<7> [304.865151] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:82]
<7> [304.881825] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:83]
<7> [304.898495] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:84]
<7> [304.915228] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:82]
<7> [304.931979] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:83]
<7> [304.948684] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:84]
<7> [304.965492] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:82]
<7> [304.982126] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:83]
<7> [304.998817] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:84]
<7> [305.015458] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:82]
<7> [305.032292] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:83]
<7> [305.048944] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:84]
<7> [305.065697] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:82]
<7> [305.082423] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:83]
<7> [305.099179] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:84]
<7> [305.115892] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:82]
<7> [305.132522] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:83]
<7> [305.149335] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:84]
<7> [305.166019] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:82]
<7> [305.182769] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:83]
<7> [305.199502] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:84]
<7> [305.216205] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:82]
<7> [305.233008] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:83]
<7> [305.249717] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:84]
<7> [305.266319] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:82]
<7> [305.283060] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:83]
<7> [305.299757] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:84]
<7> [305.316520] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:82]
<7> [305.333221] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:83]
<7> [305.349943] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:84]
<7> [305.366686] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:82]
<7> [305.383373] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:83]
<7> [305.400067] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:84]
<7> [305.416821] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:82]
<7> [305.433512] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:83]
<7> [305.450234] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:84]
<7> [305.466904] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:82]
<7> [305.483708] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:83]
<7> [305.500394] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:84]
<7> [305.517134] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:82]
<7> [305.533798] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:83]
<7> [305.550565] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:84]
<7> [305.567276] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:82]
<7> [305.583995] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:83]
<7> [305.600725] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:84]
<7> [305.617493] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:82]
<7> [305.634228] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:83]
<6> [308.639800] [IGT] kms_flip: finished subtest A-VGA1, FAIL
Created at 2025-03-03 10:01:04