Results for igt@kms_flip@flip-vs-expired-vblank-interruptible@a-hdmi-a1

Result: Fail

i915_display_info8 igt_runner8 results8.json results8-xe-load.json i915_display_info_post_exec8 boot8 dmesg8

DetailValue
Duration 1.00 seconds
Hostname
shard-adlp-2
Igt-Version
IGT-Version: 2.2-g72d5c74eb (x86_64) (Linux: 6.18.0-rc7-lgci-xe-xe-4150-a945aa869cd59483d+ x86_64)
Out
Using IGT_SRANDOM=1764162529 for randomisation
Opened device: /dev/dri/card2
Using monotonic timestamps
Starting subtest: flip-vs-expired-vblank-interruptible
Starting dynamic subtest: A-HDMI-A1
  1920x1080: 60 148500 1920 2008 2052 2200 1080 1084 1089 1125 0x48 0x5 
Stack trace:
  #0 ../lib/igt_core.c:2075 __igt_fail_assert()
  #1 ../tests/kms_flip.c:923 run_test_on_crtc_set.constprop.0()
  #2 ../tests/kms_flip.c:1889 run_test()
  #3 ../tests/kms_flip.c:2158 __igt_unique____real_main2045()
  #4 ../tests/kms_flip.c:2045 main()
  #5 [__libc_init_first+0x8a]
  #6 [__libc_start_main+0x8b]
  #7 [_start+0x25]
Dynamic subtest A-HDMI-A1: FAIL (1.003s)
Err
Starting subtest: flip-vs-expired-vblank-interruptible
Starting dynamic subtest: A-HDMI-A1
(kms_flip:10475) CRITICAL: Test assertion failure function run_test_step, file ../tests/kms_flip.c:928:
(kms_flip:10475) CRITICAL: Failed assertion: end - start < 500
(kms_flip:10475) CRITICAL: Last errno: 4, Interrupted system call
Dynamic subtest A-HDMI-A1 failed.
**** DEBUG ****
(kms_flip:10475) igt_fb-DEBUG: igt_create_fb_with_bo_size(width=1920, height=1080, format=XR24(0x34325258), modifier=0x100000000000001, size=0)
(kms_flip:10475) drmtest-DEBUG: Test requirement passed: is_intel_device(fd)
(kms_flip:10475) drmtest-DEBUG: Test requirement passed: is_intel_device(fd)
(kms_flip:10475) igt_fb-DEBUG: igt_create_fb_with_bo_size(handle=1, pitch=7680)
(kms_flip:10475) ioctl_wrappers-DEBUG: Test requirement passed: igt_has_fb_modifiers(fd)
(kms_flip:10475) igt_fb-DEBUG: igt_create_fb_with_bo_size(width=1920, height=1080, format=XR24(0x34325258), modifier=0x100000000000001, size=0)
(kms_flip:10475) drmtest-DEBUG: Test requirement passed: is_intel_device(fd)
(kms_flip:10475) drmtest-DEBUG: Test requirement passed: is_intel_device(fd)
(kms_flip:10475) igt_fb-DEBUG: igt_create_fb_with_bo_size(handle=2, pitch=7680)
(kms_flip:10475) ioctl_wrappers-DEBUG: Test requirement passed: igt_has_fb_modifiers(fd)
(kms_flip:10475) intel_bufops-DEBUG: generation: 12, supported tiles: 0x3f, driver: xe
(kms_flip:10475) intel_allocator_simple-DEBUG: Using simple allocator
(kms_flip:10475) igt_fb-DEBUG: Test requirement passed: vebox_copy || render_copy
(kms_flip:10475) intel_batchbuffer-DEBUG: Run on DRM_XE_ENGINE_CLASS_RENDER
(kms_flip:10475) intel_batchbuffer-DEBUG: bind_ops: MAP
(kms_flip:10475) intel_batchbuffer-DEBUG:   [0]: handle: 3, offset: ffffffffe000, size: 2000 pat_index: 0
(kms_flip:10475) intel_batchbuffer-DEBUG:   [1]: handle: 6, offset: ffffff815000, size: 7e9000 pat_index: 3
(kms_flip:10475) intel_batchbuffer-DEBUG:   [2]: handle: 5, offset: ffffff02c000, size: 7e9000 pat_index: 3
(kms_flip:10475) intel_batchbuffer-DEBUG: bind_ops: UNMAP
(kms_flip:10475) intel_batchbuffer-DEBUG:   [0]: handle: 0, offset: ffffffffe000, size: 2000 pat_index: 0
(kms_flip:10475) intel_batchbuffer-DEBUG:   [1]: handle: 0, offset: ffffff815000, size: 7e9000 pat_index: 0
(kms_flip:10475) intel_batchbuffer-DEBUG:   [2]: handle: 0, offset: ffffff02c000, size: 7e9000 pat_index: 0
(kms_flip:10475) igt_fb-DEBUG: Test requirement passed: vebox_copy || render_copy
(kms_flip:10475) intel_batchbuffer-DEBUG: bind_ops: MAP
(kms_flip:10475) intel_batchbuffer-DEBUG:   [0]: handle: 3, offset: ffffffffe000, size: 2000 pat_index: 0
(kms_flip:10475) intel_batchbuffer-DEBUG:   [1]: handle: 6, offset: ffffff815000, size: 7e9000 pat_index: 3
(kms_flip:10475) intel_batchbuffer-DEBUG:   [2]: handle: 5, offset: ffffff02c000, size: 7e9000 pat_index: 3
(kms_flip:10475) intel_batchbuffer-DEBUG: bind_ops: UNMAP
(kms_flip:10475) intel_batchbuffer-DEBUG:   [0]: handle: 0, offset: ffffffffe000, size: 2000 pat_index: 0
(kms_flip:10475) intel_batchbuffer-DEBUG:   [1]: handle: 0, offset: ffffff815000, size: 7e9000 pat_index: 0
(kms_flip:10475) intel_batchbuffer-DEBUG:   [2]: handle: 0, offset: ffffff02c000, size: 7e9000 pat_index: 0
(kms_flip:10475) intel_allocator_simple-DEBUG: <ial: 0x5837b17ff520, fd: 5> objects: 0, reserved_areas: 0
(kms_flip:10475) intel_allocator_simple-DEBUG: <ial: 0x5837b17ff520, fd: 5> objects: 0, reserved_areas: 0
(kms_flip:10475) intel_bufops-DEBUG: generation: 12, supported tiles: 0x3f, driver: xe
(kms_flip:10475) intel_allocator_simple-DEBUG: Using simple allocator
(kms_flip:10475) igt_fb-DEBUG: Test requirement passed: vebox_copy || render_copy
(kms_flip:10475) intel_batchbuffer-DEBUG: Run on DRM_XE_ENGINE_CLASS_RENDER
(kms_flip:10475) intel_batchbuffer-DEBUG: bind_ops: MAP
(kms_flip:10475) intel_batchbuffer-DEBUG:   [0]: handle: 3, offset: ffffffffe000, size: 2000 pat_index: 0
(kms_flip:10475) intel_batchbuffer-DEBUG:   [1]: handle: 6, offset: ffffff815000, size: 7e9000 pat_index: 3
(kms_flip:10475) intel_batchbuffer-DEBUG:   [2]: handle: 5, offset: ffffff02c000, size: 7e9000 pat_index: 3
(kms_flip:10475) intel_batchbuffer-DEBUG: bind_ops: UNMAP
(kms_flip:10475) intel_batchbuffer-DEBUG:   [0]: handle: 0, offset: ffffffffe000, size: 2000 pat_index: 0
(kms_flip:10475) intel_batchbuffer-DEBUG:   [1]: handle: 0, offset: ffffff815000, size: 7e9000 pat_index: 0
(kms_flip:10475) intel_batchbuffer-DEBUG:   [2]: handle: 0, offset: ffffff02c000, size: 7e9000 pat_index: 0
(kms_flip:10475) igt_fb-DEBUG: Test requirement passed: vebox_copy || render_copy
(kms_flip:10475) intel_batchbuffer-DEBUG: bind_ops: MAP
(kms_flip:10475) intel_batchbuffer-DEBUG:   [0]: handle: 3, offset: ffffffffe000, size: 2000 pat_index: 0
(kms_flip:10475) intel_batchbuffer-DEBUG:   [1]: handle: 6, offset: ffffff815000, size: 7e9000 pat_index: 3
(kms_flip:10475) intel_batchbuffer-DEBUG:   [2]: handle: 5, offset: ffffff02c000, size: 7e9000 pat_index: 3
(kms_flip:10475) intel_batchbuffer-DEBUG: bind_ops: UNMAP
(kms_flip:10475) intel_batchbuffer-DEBUG:   [0]: handle: 0, offset: ffffffffe000, size: 2000 pat_index: 0
(kms_flip:10475) intel_batchbuffer-DEBUG:   [1]: handle: 0, offset: ffffff815000, size: 7e9000 pat_index: 0
(kms_flip:10475) intel_batchbuffer-DEBUG:   [2]: handle: 0, offset: ffffff02c000, size: 7e9000 pat_index: 0
(kms_flip:10475) intel_allocator_simple-DEBUG: <ial: 0x5837b18089e0, fd: 5> objects: 0, reserved_areas: 0
(kms_flip:10475) intel_allocator_simple-DEBUG: <ial: 0x5837b18089e0, fd: 5> objects: 0, reserved_areas: 0
(kms_flip:10475) igt_kms-INFO:   1920x1080: 60 148500 1920 2008 2052 2200 1080 1084 1089 1125 0x48 0x5 
(kms_flip:10475) DEBUG: No stale events found
(kms_flip:10475) i915/intel_drrs-DEBUG: Manually disabling DRRS. 0
(kms_flip:10475) i915/intel_drrs-DEBUG: Test requirement passed: dir >= 0
(kms_flip:10475) DEBUG: name = flip
last_ts = 0.000000
last_received_ts = 0.000000
last_seq = 0
current_ts = 384.483856
current_received_ts = 384.483368
current_seq = 6859
count = 0
seq_step = 1
(kms_flip:10475) DEBUG: Vblank took 25us
(kms_flip:10475) DEBUG: name = flip
last_ts = 384.483856
last_received_ts = 384.483368
last_seq = 6859
current_ts = 384.500519
current_received_ts = 384.500275
current_seq = 6860
count = 1
seq_step = 1
(kms_flip:10475) DEBUG: Vblank took 49us
(kms_flip:10475) DEBUG: name = flip
last_ts = 384.500519
last_received_ts = 384.500275
last_seq = 6860
current_ts = 384.517181
current_received_ts = 384.516937
current_seq = 6861
count = 2
seq_step = 1
(kms_flip:10475) DEBUG: Vblank took 50us
(kms_flip:10475) DEBUG: name = flip
last_ts = 384.517181
last_received_ts = 384.516937
last_seq = 6861
current_ts = 384.533844
current_received_ts = 384.533600
current_seq = 6862
count = 3
seq_step = 1
(kms_flip:10475) DEBUG: Vblank took 46us
(kms_flip:10475) DEBUG: name = flip
last_ts = 384.533844
last_received_ts = 384.533600
last_seq = 6862
current_ts = 384.550507
current_received_ts = 384.550262
current_seq = 6863
count = 4
seq_step = 1
(kms_flip:10475) DEBUG: Vblank took 45us
(kms_flip:10475) DEBUG: name = flip
last_ts = 384.550507
last_received_ts = 384.550262
last_seq = 6863
current_ts = 384.567169
current_received_ts = 384.566956
current_seq = 6864
count = 5
seq_step = 1
(kms_flip:10475) DEBUG: Vblank took 62us
(kms_flip:10475) DEBUG: name = flip
last_ts = 384.567169
last_received_ts = 384.566956
last_seq = 6864
current_ts = 384.583862
current_received_ts = 384.583557
current_seq = 6865
count = 6
seq_step = 1
(kms_flip:10475) DEBUG: Vblank took 45us
(kms_flip:10475) DEBUG: name = flip
last_ts = 384.583862
last_received_ts = 384.583557
last_seq = 6865
current_ts = 384.600525
current_received_ts = 384.600372
current_seq = 6866
count = 7
seq_step = 1
(kms_flip:10475) DEBUG: Vblank took 37us
(kms_flip:10475) DEBUG: name = flip
last_ts = 384.600525
last_received_ts = 384.600372
last_seq = 6866
current_ts = 384.617188
current_received_ts = 384.617004
current_seq = 6867
count = 8
seq_step = 1
(kms_flip:10475) DEBUG: Vblank took 43us
(kms_flip:10475) DEBUG: name = flip
last_ts = 384.617188
last_received_ts = 384.617004
last_seq = 6867
current_ts = 384.633850
current_received_ts = 384.633484
current_seq = 6868
count = 9
seq_step = 1
(kms_flip:10475) DEBUG: Vblank took 47us
(kms_flip:10475) DEBUG: name = flip
last_ts = 384.633850
last_received_ts = 384.633484
last_seq = 6868
current_ts = 384.650513
current_received_ts = 384.650269
current_seq = 6869
count = 10
seq_step = 1
(kms_flip:10475) DEBUG: Vblank took 39us
(kms_flip:10475) DEBUG: name = flip
last_ts = 384.650513
last_received_ts = 384.650269
last_seq = 6869
current_ts = 384.667175
current_received_ts = 384.666901
current_seq = 6870
count = 11
seq_step = 1
(kms_flip:10475) DEBUG: Vblank took 49us
(kms_flip:10475) DEBUG: name = flip
last_ts = 384.667175
last_received_ts = 384.666901
last_seq = 6870
current_ts = 384.683838
current_received_ts = 384.683563
current_seq = 6871
count = 12
seq_step = 1
(kms_flip:10475) DEBUG: Vblank took 90us
(kms_flip:10475) DEBUG: name = flip
last_ts = 384.683838
last_received_ts = 384.683563
last_seq = 6871
current_ts = 384.700531
current_received_ts = 384.700287
current_seq = 6872
count = 13
seq_step = 1
(kms_flip:10475) DEBUG: Vblank took 45us
(kms_flip:10475) DEBUG: name = flip
last_ts = 384.700531
last_received_ts = 384.700287
last_seq = 6872
current_ts = 384.717194
current_received_ts = 384.716766
current_seq = 6873
count = 14
seq_step = 1
(kms_flip:10475) DEBUG: Vblank took 44us
(kms_flip:10475) DEBUG: name = flip
last_ts = 384.717194
last_received_ts = 384.716766
last_seq = 6873
current_ts = 384.733856
current_received_ts = 384.733582
current_seq = 6874
count = 15
seq_step = 1
(kms_flip:10475) DEBUG: Vblank took 48us
(kms_flip:10475) DEBUG: name = flip
last_ts = 384.733856
last_received_ts = 384.733582
last_seq = 6874
current_ts = 384.750519
current_received_ts = 384.750336
current_seq = 6875
count = 16
seq_step = 1
(kms_flip:10475) DEBUG: Vblank took 50us
(kms_flip:10475) DEBUG: name = flip
last_ts = 384.750519
last_received_ts = 384.750336
last_seq = 6875
current_ts = 384.767181
current_received_ts = 384.766907
current_seq = 6876
count = 17
seq_step = 1
(kms_flip:10475) DEBUG: Vblank took 37us
(kms_flip:10475) DEBUG: name = flip
last_ts = 384.767181
last_received_ts = 384.766907
last_seq = 6876
current_ts = 384.783844
current_received_ts = 384.783508
current_seq = 6877
count = 18
seq_step = 1
(kms_flip:10475) DEBUG: Vblank took 52us
(kms_flip:10475) DEBUG: name = flip
last_ts = 384.783844
last_received_ts = 384.783508
last_seq = 6877
current_ts = 384.800507
current_received_ts = 384.800140
current_seq = 6878
count = 19
seq_step = 1
(kms_flip:10475) DEBUG: Vblank took 60us
(kms_flip:10475) DEBUG: name = flip
last_ts = 384.800507
last_received_ts = 384.800140
last_seq = 6878
current_ts = 384.817200
current_received_ts = 384.817078
current_seq = 6879
count = 20
seq_step = 1
(kms_flip:10475) DEBUG: Vblank took 48us
(kms_flip:10475) DEBUG: name = flip
last_ts = 384.817200
last_received_ts = 384.817078
last_seq = 6879
current_ts = 384.833862
current_received_ts = 384.833527
current_seq = 6880
count = 21
seq_step = 1
(kms_flip:10475) DEBUG: Vblank took 38us
(kms_flip:10475) DEBUG: name = flip
last_ts = 384.833862
last_received_ts = 384.833527
last_seq = 6880
current_ts = 384.850525
current_received_ts = 384.850281
current_seq = 6881
count = 22
seq_step = 1
(kms_flip:10475) DEBUG: Vblank took 48us
(kms_flip:10475) DEBUG: name = flip
last_ts = 384.850525
last_received_ts = 384.850281
last_seq = 6881
current_ts = 384.867188
current_received_ts = 384.866943
current_seq = 6882
count = 23
seq_step = 1
(kms_flip:10475) DEBUG: Vblank took 48us
(kms_flip:10475) DEBUG: name = flip
last_ts = 384.867188
last_received_ts = 384.866943
last_seq = 6882
current_ts = 384.883850
current_received_ts = 384.883301
current_seq = 6883
count = 24
seq_step = 1
(kms_flip:10475) DEBUG: Vblank took 10us
(kms_flip:10475) DEBUG: name = flip
last_ts = 384.883850
last_received_ts = 384.883301
last_seq = 6883
current_ts = 384.900513
current_received_ts = 384.900238
current_seq = 6884
count = 25
seq_step = 1
(kms_flip:10475) DEBUG: Vblank took 23us
(kms_flip:10475) DEBUG: name = flip
last_ts = 384.900513
last_received_ts = 384.900238
last_seq = 6884
current_ts = 384.917206
current_received_ts = 384.916779
current_seq = 6885
count = 26
seq_step = 1
(kms_flip:10475) DEBUG: Vblank took 49us
(kms_flip:10475) DEBUG: name = flip
last_ts = 384.917206
last_received_ts = 384.916779
last_seq = 6885
current_ts = 384.933868
current_received_ts = 384.933533
current_seq = 6886
count = 27
seq_step = 1
(kms_flip:10475) DEBUG: Vblank took 36us
(kms_flip:10475) DEBUG: name = flip
last_ts = 384.933868
last_received_ts = 384.933533
last_seq = 6886
current_ts = 384.950531
current_received_ts = 384.950348
current_seq = 6887
count = 28
seq_step = 1
(kms_flip:10475) DEBUG: Vblank took 47us
(kms_flip:10475) DEBUG: name = flip
last_ts = 384.950531
last_received_ts = 384.950348
last_seq = 6887
current_ts = 384.967194
current_received_ts = 384.967072
current_seq = 6888
count = 29
seq_step = 1
(kms_flip:10475) DEBUG: Vblank took 59us
(kms_flip:10475) DEBUG: name = flip
last_ts = 384.967194
last_received_ts = 384.967072
last_seq = 6888
current_ts = 384.983856
current_received_ts = 384.983612
current_seq = 6889
count = 30
seq_step = 1
(kms_flip:10475) DEBUG: Vblank took 39us
(kms_flip:10475) DEBUG: name = flip
last_ts = 384.983856
last_received_ts = 384.983612
last_seq = 6889
current_ts = 385.000519
current_received_ts = 385.000214
current_seq = 6890
count = 31
seq_step = 1
(kms_flip:10475) DEBUG: Vblank took 61us
(kms_flip:10475) DEBUG: name = flip
last_ts = 385.000519
last_received_ts = 385.000214
last_seq = 6890
current_ts = 385.017212
current_received_ts = 385.017120
current_seq = 6891
count = 32
seq_step = 1
(kms_flip:10475) DEBUG: Vblank took 55us
(kms_flip:10475) DEBUG: name = flip
last_ts = 385.017212
last_received_ts = 385.017120
last_seq = 6891
current_ts = 385.033875
current_received_ts = 385.033569
current_seq = 6892
count = 33
seq_step = 1
(kms_flip:10475) DEBUG: Vblank took 38us
(kms_flip:10475) DEBUG: name = flip
last_ts = 385.033875
last_received_ts = 385.033569
last_seq = 6892
current_ts = 385.050537
current_received_ts = 385.050385
current_seq = 6893
count = 34
seq_step = 1
(kms_flip:10475) DEBUG: Vblank took 49us
(kms_flip:10475) DEBUG: name = flip
last_ts = 385.050537
last_received_ts = 385.050385
last_seq = 6893
current_ts = 385.067200
current_received_ts = 385.066986
current_seq = 6894
count = 35
seq_step = 1
(kms_flip:10475) DEBUG: Vblank took 47us
(kms_flip:10475) DEBUG: name = flip
last_ts = 385.067200
last_received_ts = 385.066986
last_seq = 6894
current_ts = 385.083862
current_received_ts = 385.083466
current_seq = 6895
count = 36
seq_step = 1
(kms_flip:10475) DEBUG: Vblank took 49us
(kms_flip:10475) DEBUG: name = flip
last_ts = 385.083862
last_received_ts = 385.083466
last_seq = 6895
current_ts = 385.100525
current_received_ts = 385.100128
current_seq = 6896
count = 37
seq_step = 1
(kms_flip:10475) DEBUG: Vblank took 59us
(kms_flip:10475) DEBUG: name = flip
last_ts = 385.100525
last_received_ts = 385.100128
last_seq = 6896
current_ts = 385.117188
current_received_ts = 385.117096
current_seq = 6897
count = 38
seq_step = 1
(kms_flip:10475) DEBUG: Vblank took 49us
(kms_flip:10475) DEBUG: name = flip
last_ts = 385.117188
last_received_ts = 385.117096
last_seq = 6897
current_ts = 385.133881
current_received_ts = 385.133606
current_seq = 6898
count = 39
seq_step = 1
(kms_flip:10475) DEBUG: Vblank took 50us
(kms_flip:10475) DEBUG: name = flip
last_ts = 385.133881
last_received_ts = 385.133606
last_seq = 6898
current_ts = 385.150543
current_received_ts = 385.150421
current_seq = 6899
count = 40
seq_step = 1
(kms_flip:10475) DEBUG: Vblank took 47us
(kms_flip:10475) DEBUG: name = flip
last_ts = 385.150543
last_received_ts = 385.150421
last_seq = 6899
current_ts = 385.167206
current_received_ts = 385.166901
current_seq = 6900
count = 41
seq_step = 1
(kms_flip:10475) DEBUG: Vblank took 118us
(kms_flip:10475) DEBUG: name = flip
last_ts = 385.167206
last_received_ts = 385.166901
last_seq = 6900
current_ts = 385.183868
current_received_ts = 385.183655
current_seq = 6901
count = 42
seq_step = 1
(kms_flip:10475) DEBUG: Vblank took 51us
(kms_flip:10475) DEBUG: name = flip
last_ts = 385.183868
last_received_ts = 385.183655
last_seq = 6901
current_ts = 385.200531
current_received_ts = 385.200165
current_seq = 6902
count = 43
seq_step = 1
(kms_flip:10475) DEBUG: Vblank took 47us
(kms_flip:10475) DEBUG: name = flip
last_ts = 385.200531
last_received_ts = 385.200165
last_seq = 6902
current_ts = 385.217194
current_received_ts = 385.217133
current_seq = 6903
count = 44
seq_step = 1
(kms_flip:10475) DEBUG: Vblank took 51us
(kms_flip:10475) DEBUG: name = flip
last_ts = 385.217194
last_received_ts = 385.217133
last_seq = 6903
current_ts = 385.233856
current_received_ts = 385.233582
current_seq = 6904
count = 45
seq_step = 1
(kms_flip:10475) DEBUG: Vblank took 38us
(kms_flip:10475) DEBUG: name = flip
last_ts = 385.233856
last_received_ts = 385.233582
last_seq = 6904
current_ts = 385.250549
current_received_ts = 385.250305
current_seq = 6905
count = 46
seq_step = 1
(kms_flip:10475) DEBUG: Vblank took 35us
(kms_flip:10475) DEBUG: name = flip
last_ts = 385.250549
last_received_ts = 385.250305
last_seq = 6905
current_ts = 385.267212
current_received_ts = 385.266815
current_seq = 6906
count = 47
seq_step = 1
(kms_flip:10475) DEBUG: Vblank took 49us
(kms_flip:10475) DEBUG: name = flip
last_ts = 385.267212
last_received_ts = 385.266815
last_seq = 6906
current_ts = 385.283875
current_received_ts = 385.283661
current_seq = 6907
count = 48
seq_step = 1
(kms_flip:10475) DEBUG: Vblank took 50us
(kms_flip:10475) DEBUG: name = flip
last_ts = 385.283875
last_received_ts = 385.283661
last_seq = 6907
current_ts = 385.300537
current_received_ts = 385.300262
current_seq = 6908
count = 49
seq_step = 1
(kms_flip:10475) DEBUG: Vblank took 53us
(kms_flip:10475) DEBUG: name = flip
last_ts = 385.300537
last_received_ts = 385.300262
last_seq = 6908
current_ts = 385.317200
current_received_ts = 385.317108
current_seq = 6909
count = 50
seq_step = 1
(kms_flip:10475) DEBUG: Vblank took 545us
(kms_flip:10475) CRITICAL: Test assertion failure function run_test_step, file ../tests/kms_flip.c:928:
(kms_flip:10475) CRITICAL: Failed assertion: end - start < 500
(kms_flip:10475) CRITICAL: Last errno: 4, Interrupted system call
(kms_flip:10475) igt_core-INFO: Stack trace:
(kms_flip:10475) igt_core-INFO:   #0 ../lib/igt_core.c:2075 __igt_fail_assert()
(kms_flip:10475) igt_core-INFO:   #1 ../tests/kms_flip.c:923 run_test_on_crtc_set.constprop.0()
(kms_flip:10475) igt_core-INFO:   #2 ../tests/kms_flip.c:1889 run_test()
(kms_flip:10475) igt_core-INFO:   #3 ../tests/kms_flip.c:2158 __igt_unique____real_main2045()
(kms_flip:10475) igt_core-INFO:   #4 ../tests/kms_flip.c:2045 main()
(kms_flip:10475) igt_core-INFO:   #5 [__libc_init_first+0x8a]
(kms_flip:10475) igt_core-INFO:   #6 [__libc_start_main+0x8b]
(kms_flip:10475) igt_core-INFO:   #7 [_start+0x25]
****  END  ****
Dynamic subtest A-HDMI-A1: FAIL (1.003s)
Dmesg
<6> [381.674138] Console: switching to colour dummy device 80x25
<6> [381.674412] [IGT] kms_flip: executing
<7> [381.682729] xe 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] [CONNECTOR:262:DP-1]
<7> [381.682738] xe 0000:00:02.0: [drm:intel_dp_detect [xe]] [CONNECTOR:262:DP-1]
<7> [381.682942] xe 0000:00:02.0: [drm:intel_power_well_enable [xe]] enabling DC_off
<7> [381.683040] xe 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [xe]] Setting DC state from 02 to 00
<7> [381.683181] xe 0000:00:02.0: [drm:intel_power_well_enable [xe]] enabling AUX_B
<7> [381.723621] xe 0000:00:02.0: [drm:intel_dp_aux_xfer [xe]] AUX B/DDI B/PHY B: timeout (status 0x7d40023f)
<7> [381.764618] xe 0000:00:02.0: [drm:intel_dp_aux_xfer [xe]] AUX B/DDI B/PHY B: timeout (status 0x7d40023f)
<7> [381.805616] xe 0000:00:02.0: [drm:intel_dp_aux_xfer [xe]] AUX B/DDI B/PHY B: timeout (status 0x7d40023f)
<7> [381.846615] xe 0000:00:02.0: [drm:intel_dp_aux_xfer [xe]] AUX B/DDI B/PHY B: timeout (status 0x7d40023f)
<7> [381.887614] xe 0000:00:02.0: [drm:intel_dp_aux_xfer [xe]] AUX B/DDI B/PHY B: timeout (status 0x7d40023f)
<7> [381.928611] xe 0000:00:02.0: [drm:intel_dp_aux_xfer [xe]] AUX B/DDI B/PHY B: timeout (status 0x7d40023f)
<7> [381.969609] xe 0000:00:02.0: [drm:intel_dp_aux_xfer [xe]] AUX B/DDI B/PHY B: timeout (status 0x7d40023f)
<7> [382.010608] xe 0000:00:02.0: [drm:intel_dp_aux_xfer [xe]] AUX B/DDI B/PHY B: timeout (status 0x7d40023f)
<7> [382.051608] xe 0000:00:02.0: [drm:intel_dp_aux_xfer [xe]] AUX B/DDI B/PHY B: timeout (status 0x7d40023f)
<7> [382.092606] xe 0000:00:02.0: [drm:intel_dp_aux_xfer [xe]] AUX B/DDI B/PHY B: timeout (status 0x7d40023f)
<7> [382.133603] xe 0000:00:02.0: [drm:intel_dp_aux_xfer [xe]] AUX B/DDI B/PHY B: timeout (status 0x7d40023f)
<7> [382.141615] xe 0000:00:02.0: [drm:intel_power_well_enable [xe]] enabling PW_2
<7> [382.141781] xe 0000:00:02.0: [drm:intel_power_well_disable [xe]] disabling PW_2
<7> [382.141904] xe 0000:00:02.0: [drm:intel_tc_port_reset_mode [xe]] Port G/TC#4: TC port mode reset (tbt-alt -> disconnected) pin assignment: - max lanes: 4
<7> [382.141910] xe 0000:00:02.0: [drm:intel_power_well_enable [xe]] enabling PW_2
<7> [382.142085] xe 0000:00:02.0: [drm:intel_tc_port_reset_mode [xe]] Port F/TC#3: TC port mode reset (tbt-alt -> disconnected) pin assignment: - max lanes: 4
<7> [382.142085] xe 0000:00:02.0: [drm:intel_power_well_disable [xe]] disabling PW_2
<7> [382.142083] xe 0000:00:02.0: [drm:intel_tc_port_reset_mode [xe]] Port E/TC#2: TC port mode reset (tbt-alt -> disconnected) pin assignment: - max lanes: 4
<7> [382.142206] xe 0000:00:02.0: [drm:intel_tc_port_reset_mode [xe]] Port D/TC#1: TC port mode reset (tbt-alt -> disconnected) pin assignment: - max lanes: 4
<7> [382.174601] xe 0000:00:02.0: [drm:intel_dp_aux_xfer [xe]] AUX B/DDI B/PHY B: timeout (status 0x7d40023f)
<7> [382.215601] xe 0000:00:02.0: [drm:intel_dp_aux_xfer [xe]] AUX B/DDI B/PHY B: timeout (status 0x7d40023f)
<7> [382.256598] xe 0000:00:02.0: [drm:intel_dp_aux_xfer [xe]] AUX B/DDI B/PHY B: timeout (status 0x7d40023f)
<7> [382.297596] xe 0000:00:02.0: [drm:intel_dp_aux_xfer [xe]] AUX B/DDI B/PHY B: timeout (status 0x7d40023f)
<7> [382.338595] xe 0000:00:02.0: [drm:intel_dp_aux_xfer [xe]] AUX B/DDI B/PHY B: timeout (status 0x7d40023f)
<7> [382.379595] xe 0000:00:02.0: [drm:intel_dp_aux_xfer [xe]] AUX B/DDI B/PHY B: timeout (status 0x7d40023f)
<7> [382.420592] xe 0000:00:02.0: [drm:intel_dp_aux_xfer [xe]] AUX B/DDI B/PHY B: timeout (status 0x7d40023f)
<7> [382.461590] xe 0000:00:02.0: [drm:intel_dp_aux_xfer [xe]] AUX B/DDI B/PHY B: timeout (status 0x7d40023f)
<7> [382.502589] xe 0000:00:02.0: [drm:intel_dp_aux_xfer [xe]] AUX B/DDI B/PHY B: timeout (status 0x7d40023f)
<7> [382.543589] xe 0000:00:02.0: [drm:intel_dp_aux_xfer [xe]] AUX B/DDI B/PHY B: timeout (status 0x7d40023f)
<7> [382.584585] xe 0000:00:02.0: [drm:intel_dp_aux_xfer [xe]] AUX B/DDI B/PHY B: timeout (status 0x7d40023f)
<7> [382.625584] xe 0000:00:02.0: [drm:intel_dp_aux_xfer [xe]] AUX B/DDI B/PHY B: timeout (status 0x7d40023f)
<7> [382.666582] xe 0000:00:02.0: [drm:intel_dp_aux_xfer [xe]] AUX B/DDI B/PHY B: timeout (status 0x7d40023f)
<7> [382.707582] xe 0000:00:02.0: [drm:intel_dp_aux_xfer [xe]] AUX B/DDI B/PHY B: timeout (status 0x7d40023f)
<7> [382.748579] xe 0000:00:02.0: [drm:intel_dp_aux_xfer [xe]] AUX B/DDI B/PHY B: timeout (status 0x7d40023f)
<7> [382.789578] xe 0000:00:02.0: [drm:intel_dp_aux_xfer [xe]] AUX B/DDI B/PHY B: timeout (status 0x7d40023f)
<7> [382.830576] xe 0000:00:02.0: [drm:intel_dp_aux_xfer [xe]] AUX B/DDI B/PHY B: timeout (status 0x7d40023f)
<7> [382.871576] xe 0000:00:02.0: [drm:intel_dp_aux_xfer [xe]] AUX B/DDI B/PHY B: timeout (status 0x7d40023f)
<7> [382.912573] xe 0000:00:02.0: [drm:intel_dp_aux_xfer [xe]] AUX B/DDI B/PHY B: timeout (status 0x7d40023f)
<7> [382.953571] xe 0000:00:02.0: [drm:intel_dp_aux_xfer [xe]] AUX B/DDI B/PHY B: timeout (status 0x7d40023f)
<7> [382.994569] xe 0000:00:02.0: [drm:intel_dp_aux_xfer [xe]] AUX B/DDI B/PHY B: timeout (status 0x7d40023f)
<7> [382.994694] xe 0000:00:02.0: [drm:drm_dp_dpcd_access [drm_display_helper]] AUX B/DDI B/PHY B: Too many retries, giving up. First error: -110
<7> [382.994717] xe 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] [CONNECTOR:262:DP-1] disconnected
<7> [382.995264] xe 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] [CONNECTOR:281:DP-2]
<7> [382.995267] xe 0000:00:02.0: [drm:intel_dp_detect [xe]] [CONNECTOR:281:DP-2]
<7> [382.995399] xe 0000:00:02.0: [drm:intel_power_well_disable [xe]] disabling AUX_B
<7> [382.995500] xe 0000:00:02.0: [drm:intel_power_well_disable [xe]] disabling DC_off
<7> [382.995611] xe 0000:00:02.0: [drm:skl_enable_dc6 [xe]] Enabling DC6
<7> [382.995720] xe 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [xe]] Setting DC state from 00 to 02
<7> [382.995859] xe 0000:00:02.0: [drm:intel_tc_port_reset_mode [xe]] Port D/TC#1: TC port mode reset (disconnected -> tbt-alt) pin assignment: - max lanes: 4
<7> [382.995976] xe 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] [CONNECTOR:281:DP-2] disconnected
<7> [382.996314] xe 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] [CONNECTOR:290:DP-3]
<7> [382.996317] xe 0000:00:02.0: [drm:intel_dp_detect [xe]] [CONNECTOR:290:DP-3]
<7> [382.996458] xe 0000:00:02.0: [drm:intel_tc_port_reset_mode [xe]] Port E/TC#2: TC port mode reset (disconnected -> tbt-alt) pin assignment: - max lanes: 4
<7> [382.996570] xe 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] [CONNECTOR:290:DP-3] disconnected
<7> [382.996912] xe 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] [CONNECTOR:299:DP-4]
<7> [382.996914] xe 0000:00:02.0: [drm:intel_dp_detect [xe]] [CONNECTOR:299:DP-4]
<7> [382.997054] xe 0000:00:02.0: [drm:intel_tc_port_reset_mode [xe]] Port F/TC#3: TC port mode reset (disconnected -> tbt-alt) pin assignment: - max lanes: 4
<7> [382.997165] xe 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] [CONNECTOR:299:DP-4] disconnected
<7> [382.997441] xe 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] [CONNECTOR:308:DP-5]
<7> [382.997444] xe 0000:00:02.0: [drm:intel_dp_detect [xe]] [CONNECTOR:308:DP-5]
<7> [382.997599] xe 0000:00:02.0: [drm:intel_tc_port_reset_mode [xe]] Port G/TC#4: TC port mode reset (disconnected -> tbt-alt) pin assignment: - max lanes: 4
<7> [382.997722] xe 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] [CONNECTOR:308:DP-5] disconnected
<7> [382.998125] xe 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] [CONNECTOR:262:DP-1]
<7> [382.998128] xe 0000:00:02.0: [drm:intel_dp_detect [xe]] [CONNECTOR:262:DP-1]
<7> [382.998276] xe 0000:00:02.0: [drm:intel_power_well_enable [xe]] enabling DC_off
<7> [382.998371] xe 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [xe]] Setting DC state from 02 to 00
<7> [382.998510] xe 0000:00:02.0: [drm:intel_power_well_enable [xe]] enabling AUX_B
<7> [383.039569] xe 0000:00:02.0: [drm:intel_dp_aux_xfer [xe]] AUX B/DDI B/PHY B: timeout (status 0x7d40023f)
<7> [383.080566] xe 0000:00:02.0: [drm:intel_dp_aux_xfer [xe]] AUX B/DDI B/PHY B: timeout (status 0x7d40023f)
<7> [383.121564] xe 0000:00:02.0: [drm:intel_dp_aux_xfer [xe]] AUX B/DDI B/PHY B: timeout (status 0x7d40023f)
<7> [383.162563] xe 0000:00:02.0: [drm:intel_dp_aux_xfer [xe]] AUX B/DDI B/PHY B: timeout (status 0x7d40023f)
<7> [383.203563] xe 0000:00:02.0: [drm:intel_dp_aux_xfer [xe]] AUX B/DDI B/PHY B: timeout (status 0x7d40023f)
<7> [383.244560] xe 0000:00:02.0: [drm:intel_dp_aux_xfer [xe]] AUX B/DDI B/PHY B: timeout (status 0x7d40023f)
<7> [383.285558] xe 0000:00:02.0: [drm:intel_dp_aux_xfer [xe]] AUX B/DDI B/PHY B: timeout (status 0x7d40023f)
<7> [383.326557] xe 0000:00:02.0: [drm:intel_dp_aux_xfer [xe]] AUX B/DDI B/PHY B: timeout (status 0x7d40023f)
<7> [383.367557] xe 0000:00:02.0: [drm:intel_dp_aux_xfer [xe]] AUX B/DDI B/PHY B: timeout (status 0x7d40023f)
<7> [383.408553] xe 0000:00:02.0: [drm:intel_dp_aux_xfer [xe]] AUX B/DDI B/PHY B: timeout (status 0x7d40023f)
<7> [383.449552] xe 0000:00:02.0: [drm:intel_dp_aux_xfer [xe]] AUX B/DDI B/PHY B: timeout (status 0x7d40023f)
<7> [383.490550] xe 0000:00:02.0: [drm:intel_dp_aux_xfer [xe]] AUX B/DDI B/PHY B: timeout (status 0x7d40023f)
<7> [383.531550] xe 0000:00:02.0: [drm:intel_dp_aux_xfer [xe]] AUX B/DDI B/PHY B: timeout (status 0x7d40023f)
<7> [383.572548] xe 0000:00:02.0: [drm:intel_dp_aux_xfer [xe]] AUX B/DDI B/PHY B: timeout (status 0x7d40023f)
<7> [383.613547] xe 0000:00:02.0: [drm:intel_dp_aux_xfer [xe]] AUX B/DDI B/PHY B: timeout (status 0x7d40023f)
<7> [383.654544] xe 0000:00:02.0: [drm:intel_dp_aux_xfer [xe]] AUX B/DDI B/PHY B: timeout (status 0x7d40023f)
<7> [383.695544] xe 0000:00:02.0: [drm:intel_dp_aux_xfer [xe]] AUX B/DDI B/PHY B: timeout (status 0x7d40023f)
<7> [383.736541] xe 0000:00:02.0: [drm:intel_dp_aux_xfer [xe]] AUX B/DDI B/PHY B: timeout (status 0x7d40023f)
<7> [383.777539] xe 0000:00:02.0: [drm:intel_dp_aux_xfer [xe]] AUX B/DDI B/PHY B: timeout (status 0x7d40023f)
<7> [383.809538] xe 0000:00:02.0: [drm:intel_dp_aux_xfer [xe]] AUX B/DDI B/PHY B: timeout (status 0x7d40023f)
<7> [383.850536] xe 0000:00:02.0: [drm:intel_dp_aux_xfer [xe]] AUX B/DDI B/PHY B: timeout (status 0x7d40023f)
<7> [383.891536] xe 0000:00:02.0: [drm:intel_dp_aux_xfer [xe]] AUX B/DDI B/PHY B: timeout (status 0x7d40023f)
<7> [383.932533] xe 0000:00:02.0: [drm:intel_dp_aux_xfer [xe]] AUX B/DDI B/PHY B: timeout (status 0x7d40023f)
<7> [383.973532] xe 0000:00:02.0: [drm:intel_dp_aux_xfer [xe]] AUX B/DDI B/PHY B: timeout (status 0x7d40023f)
<7> [383.996541] xe 0000:00:02.0: [drm:intel_power_well_enable [xe]] enabling PW_2
<7> [383.996747] xe 0000:00:02.0: [drm:intel_power_well_disable [xe]] disabling PW_2
<7> [383.996906] xe 0000:00:02.0: [drm:intel_tc_port_reset_mode [xe]] Port D/TC#1: TC port mode reset (tbt-alt -> disconnected) pin assignment: - max lanes: 4
<7> [384.014530] xe 0000:00:02.0: [drm:intel_dp_aux_xfer [xe]] AUX B/DDI B/PHY B: timeout (status 0x7d40023f)
<7> [384.055530] xe 0000:00:02.0: [drm:intel_dp_aux_xfer [xe]] AUX B/DDI B/PHY B: timeout (status 0x7d40023f)
<7> [384.060539] xe 0000:00:02.0: [drm:intel_power_well_enable [xe]] enabling PW_2
<7> [384.060746] xe 0000:00:02.0: [drm:intel_power_well_disable [xe]] disabling PW_2
<7> [384.060905] xe 0000:00:02.0: [drm:intel_tc_port_reset_mode [xe]] Port G/TC#4: TC port mode reset (tbt-alt -> disconnected) pin assignment: - max lanes: 4
<7> [384.060910] xe 0000:00:02.0: [drm:intel_power_well_enable [xe]] enabling PW_2
<7> [384.061128] xe 0000:00:02.0: [drm:intel_power_well_disable [xe]] disabling PW_2
<7> [384.061127] xe 0000:00:02.0: [drm:intel_tc_port_reset_mode [xe]] Port F/TC#3: TC port mode reset (tbt-alt -> disconnected) pin assignment: - max lanes: 4
<7> [384.061258] xe 0000:00:02.0: [drm:intel_tc_port_reset_mode [xe]] Port E/TC#2: TC port mode reset (tbt-alt -> disconnected) pin assignment: - max lanes: 4
<7> [384.096527] xe 0000:00:02.0: [drm:intel_dp_aux_xfer [xe]] AUX B/DDI B/PHY B: timeout (status 0x7d40023f)
<7> [384.137525] xe 0000:00:02.0: [drm:intel_dp_aux_xfer [xe]] AUX B/DDI B/PHY B: timeout (status 0x7d40023f)
<7> [384.178524] xe 0000:00:02.0: [drm:intel_dp_aux_xfer [xe]] AUX B/DDI B/PHY B: timeout (status 0x7d40023f)
<7> [384.219524] xe 0000:00:02.0: [drm:intel_dp_aux_xfer [xe]] AUX B/DDI B/PHY B: timeout (status 0x7d40023f)
<7> [384.260521] xe 0000:00:02.0: [drm:intel_dp_aux_xfer [xe]] AUX B/DDI B/PHY B: timeout (status 0x7d40023f)
<7> [384.301520] xe 0000:00:02.0: [drm:intel_dp_aux_xfer [xe]] AUX B/DDI B/PHY B: timeout (status 0x7d40023f)
<7> [384.301641] xe 0000:00:02.0: [drm:drm_dp_dpcd_access [drm_display_helper]] AUX B/DDI B/PHY B: Too many retries, giving up. First error: -110
<7> [384.301660] xe 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] [CONNECTOR:262:DP-1] disconnected
<7> [384.301687] xe 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] [CONNECTOR:275:HDMI-A-1]
<7> [384.301693] xe 0000:00:02.0: [drm:intel_hdmi_detect [xe]] [CONNECTOR:275:HDMI-A-1]
<7> [384.327997] xe 0000:00:02.0: [drm:update_display_info.part.0] [CONNECTOR:275:HDMI-A-1] ELD monitor FH-DP4K
<7> [384.328002] xe 0000:00:02.0: [drm:update_display_info.part.0] [CONNECTOR:275:HDMI-A-1] ELD size 36, SAD count 2
<7> [384.328334] xe 0000:00:02.0: [drm:do_gmbus_xfer [xe]] GMBUS [i915 gmbus dpb] NAK for addr: 0040 w(1)
<7> [384.328418] xe 0000:00:02.0: [drm:do_gmbus_xfer [xe]] GMBUS [i915 gmbus dpb] NAK on first message, retry
<7> [384.328777] xe 0000:00:02.0: [drm:do_gmbus_xfer [xe]] GMBUS [i915 gmbus dpb] NAK for addr: 0040 w(1)
<7> [384.328873] xe 0000:00:02.0: [drm:drm_dp_dual_mode_detect [drm_display_helper]] DP dual mode HDMI ID: (err -6)
<7> [384.328883] xe 0000:00:02.0: [drm:intel_hdmi_set_edid [xe]] Assuming DP dual mode adaptor presence based on VBT
<7> [384.328964] xe 0000:00:02.0: [drm:intel_hdmi_set_edid [xe]] DP dual mode adaptor (type 1 DVI) detected (max TMDS clock: 165000 kHz)
<7> [384.329337] xe 0000:00:02.0: [drm:drm_mode_prune_invalid] Rejected mode: "2560x1440": 60 241700 2560 2608 2640 2720 1440 1443 1448 1481 0x40 0x9 (CLOCK_HIGH)
<7> [384.329345] xe 0000:00:02.0: [drm:drm_mode_prune_invalid] Rejected mode: "2560x1600": 60 267820 2560 2608 2640 2720 1600 1603 1608 1641 0x40 0x9 (CLOCK_HIGH)
<7> [384.329350] xe 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> [384.329355] xe 0000:00:02.0: [drm:drm_mode_prune_invalid] Rejected mode: "3840x2160": 30 266640 3840 3888 3920 4000 2160 2163 2168 2222 0x40 0x9 (CLOCK_HIGH)
<7> [384.329359] xe 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> [384.329366] xe 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] [CONNECTOR:275:HDMI-A-1] probed modes:
<7> [384.329369] xe 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "1920x1080": 60 148500 1920 2008 2052 2200 1080 1084 1089 1125 0x48 0x5
<7> [384.329372] xe 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "3840x2160": 17 151100 3840 3888 3920 4000 2160 2163 2168 2222 0x40 0x9
<7> [384.329374] xe 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "2560x1600": 30 133910 2560 2608 2640 2720 1600 1603 1608 1641 0x40 0x9
<7> [384.329377] xe 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "2560x1440": 30 120850 2560 2608 2640 2720 1440 1443 1448 1481 0x40 0x9
<7> [384.329379] xe 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "1920x1200": 60 154000 1920 1968 2000 2080 1200 1203 1209 1235 0x40 0x9
<7> [384.329382] xe 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "1920x1080": 60 148352 1920 2008 2052 2200 1080 1084 1089 1125 0x40 0x5
<7> [384.329384] xe 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "1680x1050": 60 119000 1680 1728 1760 1840 1050 1053 1059 1080 0x40 0x9
<7> [384.329387] xe 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "1600x900": 60 108000 1600 1624 1704 1800 900 901 904 1000 0x40 0x5
<7> [384.329390] xe 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "1280x1024": 75 135000 1280 1296 1440 1688 1024 1025 1028 1066 0x40 0x5
<7> [384.329392] xe 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "1280x1024": 60 108000 1280 1328 1440 1688 1024 1025 1028 1066 0x40 0x5
<7> [384.329394] xe 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "1440x900": 60 88750 1440 1488 1520 1600 900 903 909 926 0x40 0x9
<7> [384.329397] xe 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "1280x800": 60 71000 1280 1328 1360 1440 800 803 809 823 0x40 0x9
<7> [384.329400] xe 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "1152x864": 75 108000 1152 1216 1344 1600 864 865 868 900 0x40 0x5
<7> [384.329402] xe 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "1280x720": 60 74250 1280 1390 1430 1650 720 725 730 750 0x40 0x5
<7> [384.329405] xe 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "1280x720": 60 74176 1280 1390 1430 1650 720 725 730 750 0x40 0x5
<7> [384.329407] xe 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "1024x768": 75 78750 1024 1040 1136 1312 768 769 772 800 0x40 0x5
<7> [384.329410] xe 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "1024x768": 70 75000 1024 1048 1184 1328 768 771 777 806 0x40 0xa
<7> [384.329412] xe 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "1024x768": 60 65000 1024 1048 1184 1344 768 771 777 806 0x40 0xa
<7> [384.329415] xe 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "800x600": 75 49500 800 816 896 1056 600 601 604 625 0x40 0x5
<7> [384.329417] xe 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "800x600": 72 50000 800 856 976 1040 600 637 643 666 0x40 0x5
<7> [384.329420] xe 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "800x600": 60 40000 800 840 968 1056 600 601 605 628 0x40 0x5
<7> [384.329422] xe 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "800x600": 56 36000 800 824 896 1024 600 601 603 625 0x40 0x5
<7> [384.329425] xe 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "640x480": 75 31500 640 656 720 840 480 481 484 500 0x40 0xa
<7> [384.329427] xe 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "640x480": 73 31500 640 664 704 832 480 489 492 520 0x40 0xa
<7> [384.329430] xe 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "640x480": 60 25200 640 656 752 800 480 490 492 525 0x40 0xa
<7> [384.329432] xe 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "640x480": 60 25175 640 656 752 800 480 490 492 525 0x40 0xa
<7> [384.329464] xe 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] [CONNECTOR:281:DP-2]
<7> [384.329468] xe 0000:00:02.0: [drm:intel_dp_detect [xe]] [CONNECTOR:281:DP-2]
<7> [384.329613] xe 0000:00:02.0: [drm:intel_power_well_disable [xe]] disabling AUX_B
<7> [384.329721] xe 0000:00:02.0: [drm:intel_power_well_disable [xe]] disabling DC_off
<7> [384.329830] xe 0000:00:02.0: [drm:skl_enable_dc6 [xe]] Enabling DC6
<7> [384.329921] xe 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [xe]] Setting DC state from 00 to 02
<7> [384.330055] xe 0000:00:02.0: [drm:intel_tc_port_reset_mode [xe]] Port D/TC#1: TC port mode reset (disconnected -> tbt-alt) pin assignment: - max lanes: 4
<7> [384.330178] xe 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] [CONNECTOR:281:DP-2] disconnected
<7> [384.330192] xe 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] [CONNECTOR:290:DP-3]
<7> [384.330195] xe 0000:00:02.0: [drm:intel_dp_detect [xe]] [CONNECTOR:290:DP-3]
<7> [384.330356] xe 0000:00:02.0: [drm:intel_tc_port_reset_mode [xe]] Port E/TC#2: TC port mode reset (disconnected -> tbt-alt) pin assignment: - max lanes: 4
<7> [384.330477] xe 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] [CONNECTOR:290:DP-3] disconnected
<7> [384.330487] xe 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] [CONNECTOR:299:DP-4]
<7> [384.330490] xe 0000:00:02.0: [drm:intel_dp_detect [xe]] [CONNECTOR:299:DP-4]
<7> [384.330664] xe 0000:00:02.0: [drm:intel_tc_port_reset_mode [xe]] Port F/TC#3: TC port mode reset (disconnected -> tbt-alt) pin assignment: - max lanes: 4
<7> [384.330778] xe 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] [CONNECTOR:299:DP-4] disconnected
<7> [384.330787] xe 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] [CONNECTOR:308:DP-5]
<7> [384.330789] xe 0000:00:02.0: [drm:intel_dp_detect [xe]] [CONNECTOR:308:DP-5]
<7> [384.330924] xe 0000:00:02.0: [drm:intel_tc_port_reset_mode [xe]] Port G/TC#4: TC port mode reset (disconnected -> tbt-alt) pin assignment: - max lanes: 4
<7> [384.331042] xe 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] [CONNECTOR:308:DP-5] disconnected
<6> [384.335029] [IGT] kms_flip: starting subtest flip-vs-expired-vblank-interruptible
<6> [384.338319] [IGT] kms_flip: starting dynamic subtest A-HDMI-A1
<7> [384.338768] xe 0000:00:02.0: [drm:drm_mode_addfb2] [FB:319]
<7> [384.338903] xe 0000:00:02.0: [drm:drm_mode_addfb2] [FB:320]
<7> [384.383892] xe 0000:00:02.0: [drm:drm_mode_setcrtc] [CRTC:88:pipe A]
<7> [384.383972] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:88:pipe A] fastset requirement not met in hw.enable (expected yes, found no)
<7> [384.384098] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:88:pipe A] fastset requirement not met in hw.active (expected yes, found no)
<7> [384.384200] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:88:pipe A] fastset requirement not met in cpu_transcoder (expected 0, found -1)
<7> [384.384298] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:88:pipe A] fastset requirement not met in lane_count (expected 4, found 0)
<7> [384.384396] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:88:pipe A] fastset requirement not met in output_types (expected 0x00000040, found 0x00000000)
<7> [384.384491] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:88:pipe A] fastset requirement not met in framestart_delay (expected 1, found 0)
<7> [384.384642] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:88:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hdisplay (expected 1920, found 0)
<7> [384.384768] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:88:pipe A] fastset requirement not met in hw.pipe_mode.crtc_htotal (expected 2200, found 0)
<7> [384.384879] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:88:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hblank_start (expected 1920, found 0)
<7> [384.384983] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:88:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hblank_end (expected 2200, found 0)
<7> [384.385089] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:88:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hsync_start (expected 2008, found 0)
<7> [384.385198] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:88:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hsync_end (expected 2052, found 0)
<7> [384.385301] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:88:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vdisplay (expected 1080, found 0)
<7> [384.385404] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:88:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vblank_start (expected 1080, found 0)
<7> [384.385503] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:88:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vsync_start (expected 1084, found 0)
<7> [384.385623] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:88:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vsync_end (expected 1089, found 0)
<7> [384.385753] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:88:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vtotal (expected 1125, found 0)
<7> [384.385846] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:88:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vblank_end (expected 1125, found 0)
<7> [384.385950] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:88:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hdisplay (expected 1920, found 0)
<7> [384.386051] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:88:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_htotal (expected 2200, found 0)
<7> [384.386149] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:88:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hblank_start (expected 1920, found 0)
<7> [384.386249] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:88:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hblank_end (expected 2200, found 0)
<7> [384.386346] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:88:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hsync_start (expected 2008, found 0)
<7> [384.386444] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:88:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hsync_end (expected 2052, found 0)
<7> [384.386584] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:88:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vdisplay (expected 1080, found 0)
<7> [384.386707] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:88:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vblank_start (expected 1080, found 0)
<7> [384.386805] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:88:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vsync_start (expected 1084, found 0)
<7> [384.386895] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:88:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vsync_end (expected 1089, found 0)
<7> [384.386985] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:88:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vtotal (expected 1125, found 0)
<7> [384.387076] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:88:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vblank_end (expected 1125, found 0)
<7> [384.387177] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:88:pipe A] fastset requirement not met in pixel_multiplier (expected 1, found 0)
<7> [384.387283] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:88:pipe A] fastset requirement not met in hw.adjusted_mode.flags (1) (expected 1, found 0)
<7> [384.387386] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:88:pipe A] fastset requirement not met in hw.adjusted_mode.flags (4) (expected 4, found 0)
<7> [384.387488] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:88:pipe A] fastset requirement not met in pipe_bpp (expected 24, found 0)
<7> [384.387625] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:88:pipe A] fastset requirement not met in hw.pipe_mode.crtc_clock (expected 148500, found 0)
<7> [384.387753] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:88:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_clock (expected 148500, found 0)
<7> [384.387857] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:88:pipe A] fastset requirement not met in port_clock (expected 148500, found 0)
<7> [384.387961] xe 0000:00:02.0: [drm:intel_atomic_check [xe]] [CRTC:88:pipe A] fastset requirement not met, forcing full modeset
<7> [384.388067] xe 0000:00:02.0: [drm:intel_dpll_crtc_put [xe]] [CRTC:88:pipe A] releasing DPLL 0
<7> [384.388200] xe 0000:00:02.0: [drm:skl_compute_wm [xe]] Enabled dbuf slices 0xf -> 0x1 (total dbuf slices 0xf), mbus joined? yes->no
<7> [384.388289] xe 0000:00:02.0: [drm:skl_compute_wm [xe]] [CRTC:88:pipe A] dbuf slices 0xf -> 0x0, ddb (0 - 4096) -> (0 - 0), active pipes 0x1 -> 0x0
<7> [384.388392] xe 0000:00:02.0: [drm:skl_compute_wm [xe]] [PLANE:33:plane 1A] ddb ( 0 - 4060) -> ( 0 - 0), size 4060 -> 0
<7> [384.388476] xe 0000:00:02.0: [drm:skl_compute_wm [xe]] [PLANE:83:cursor A] ddb (4060 - 4096) -> ( 0 - 0), size 36 -> 0
<7> [384.388576] xe 0000:00:02.0: [drm:skl_print_plane_changes [xe]] [PLANE:33:plane 1A] level *wm0,*wm1,*wm2,*wm3,*wm4,*wm5, wm6, wm7,*twm,*swm,*stwm -> wm0, wm1, wm2, wm3, wm4, wm5, wm6, wm7, twm, swm, stwm
<7> [384.388672] xe 0000:00:02.0: [drm:skl_print_plane_changes [xe]] [PLANE:33:plane 1A] lines 1, 4, 6, 7, 10, 10, 0, 0, 0, 3, 0 -> 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0
<7> [384.388759] xe 0000:00:02.0: [drm:skl_print_plane_changes [xe]] [PLANE:33:plane 1A] blocks 16, 65, 97, 113, 161, 161, 0, 0, 30, 49, 63 -> 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0
<7> [384.388843] xe 0000:00:02.0: [drm:skl_print_plane_changes [xe]] [PLANE:33:plane 1A] min_ddb 19, 73, 108, 126, 179, 179, 0, 0, 31, 55, 64 -> 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0
<7> [384.388937] xe 0000:00:02.0: [drm:intel_bw_atomic_check [xe]] [CRTC:88:pipe A] data rate 0 num active planes 0
<7> [384.389047] xe 0000:00:02.0: [drm:intel_bw_atomic_check [xe]] QGV point 0: max bw 10441 required 0
<7> [384.389155] xe 0000:00:02.0: [drm:intel_bw_atomic_check [xe]] QGV point 1: max bw 17848 required 0
<7> [384.389259] xe 0000:00:02.0: [drm:intel_bw_atomic_check [xe]] QGV point 2: max bw 18818 required 0
<7> [384.389363] xe 0000:00:02.0: [drm:intel_bw_atomic_check [xe]] QGV point 3: max bw 18818 required 0
<7> [384.389467] xe 0000:00:02.0: [drm:intel_bw_atomic_check [xe]] PSF GV point 0: max bw 34133 required 0
<7> [384.389581] xe 0000:00:02.0: [drm:intel_bw_atomic_check [xe]] PSF GV point 1: max bw 51200 required 0
<7> [384.389699] xe 0000:00:02.0: [drm:intel_bw_atomic_check [xe]] PSF GV point 2: max bw 51200 required 0
<7> [384.389810] xe 0000:00:02.0: [drm:intel_cdclk_atomic_check [xe]] [CRTC:88:pipe A] min cdclk: 74250 kHz -> 0 kHz
<7> [384.389927] xe 0000:00:02.0: [drm:intel_cdclk_update_dbuf_bw_min_cdclk [xe]] dbuf bandwidth min cdclk: 9282 kHz -> 0 kHz
<7> [384.390034] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [CRTC:88:pipe A] enable: no [modeset]
<7> [384.390152] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [PLANE:33:plane 1A] fb: [NOFB], visible: no
<7> [384.390310] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [PLANE:43:plane 2A] fb: [NOFB], visible: no
<7> [384.390454] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [PLANE:53:plane 3A] fb: [NOFB], visible: no
<7> [384.390625] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [PLANE:63:plane 4A] fb: [NOFB], visible: no
<7> [384.390731] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [PLANE:73:plane 5A] fb: [NOFB], visible: no
<7> [384.390842] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [PLANE:83:cursor A] fb: [NOFB], visible: no
<7> [384.390976] xe 0000:00:02.0: [drm:intel_power_well_enable [xe]] enabling DC_off
<7> [384.391086] xe 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [xe]] Setting DC state from 02 to 00
<7> [384.399947] xe 0000:00:02.0: [drm:intel_disable_transcoder [xe]] disabling pipe A
<7> [384.421012] xe 0000:00:02.0: [drm:intel_power_well_disable [xe]] disabling DDI_IO_B
<7> [384.421193] xe 0000:00:02.0: [drm:intel_dpll_disable [xe]] disable DPLL 0 (active 0x1, on? 1) for [CRTC:88:pipe A]
<7> [384.421354] xe 0000:00:02.0: [drm:intel_dpll_disable [xe]] disabling DPLL 0
<7> [384.421506] xe 0000:00:02.0: [drm:__intel_fbc_disable [xe]] Disabling FBC on [PLANE:33:plane 1A]
<7> [384.421800] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:261:DDI B/PHY B]
<7> [384.421929] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:263:DP-MST A]
<7> [384.422060] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:264:DP-MST B]
<7> [384.422186] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:265:DP-MST C]
<7> [384.422310] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:266:DP-MST D]
<7> [384.422426] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:280:DDI TC1/PHY TC1]
<7> [384.422558] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:282:DP-MST A]
<7> [384.422695] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:283:DP-MST B]
<7> [384.422814] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:284:DP-MST C]
<7> [384.422940] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:285:DP-MST D]
<7> [384.423052] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:289:DDI TC2/PHY TC2]
<7> [384.423164] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:291:DP-MST A]
<7> [384.423276] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:292:DP-MST B]
<7> [384.423383] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:293:DP-MST C]
<7> [384.423488] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:294:DP-MST D]
<7> [384.423603] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:298:DDI TC3/PHY TC3]
<7> [384.423714] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:300:DP-MST A]
<7> [384.423814] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:301:DP-MST B]
<7> [384.423918] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:302:DP-MST C]
<7> [384.424023] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:303:DP-MST D]
<7> [384.424126] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:307:DDI TC4/PHY TC4]
<7> [384.424220] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:309:DP-MST A]
<7> [384.424319] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:310:DP-MST B]
<7> [384.424415] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:311:DP-MST C]
<7> [384.424504] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:312:DP-MST D]
<7> [384.424606] xe 0000:00:02.0: [drm:verify_connector_state [xe]] [CONNECTOR:275:HDMI-A-1]
<7> [384.424731] xe 0000:00:02.0: [drm:intel_dbuf_mdclk_cdclk_ratio_update [xe]] Updating dbuf ratio to 2 (mbus joined: no)
<7> [384.424820] xe 0000:00:02.0: [drm:intel_dbuf_mbus_join_update [xe]] Changing mbus joined: yes -> no (pipe: *)
<7> [384.424906] xe 0000:00:02.0: [drm:gen9_dbuf_slices_update [xe]] Updating dbuf slices to 0x1
<7> [384.425060] xe 0000:00:02.0: [drm:intel_power_well_disable [xe]] disabling PW_A
<7> [384.425183] xe 0000:00:02.0: [drm:intel_modeset_verify_crtc [xe]] [CRTC:88:pipe A]
<7> [384.425404] xe 0000:00:02.0: [drm:drm_mode_setcrtc] [CRTC:145:pipe B]
<7> [384.425521] xe 0000:00:02.0: [drm:drm_mode_setcrtc] [CRTC:202:pipe C]
<7> [384.425637] xe 0000:00:02.0: [drm:drm_mode_setcrtc] [CRTC:259:pipe D]
<7> [384.425742] xe 0000:00:02.0: [drm:drm_mode_setcrtc] [CRTC:88:pipe A]
<7> [384.425769] xe 0000:00:02.0: [drm:drm_mode_setcrtc] [CONNECTOR:275:HDMI-A-1]
<7> [384.425826] xe 0000:00:02.0: [drm:intel_atomic_check [xe]] [CONNECTOR:275:HDMI-A-1] Limiting display bpp to 24 (EDID bpp 0, max requested bpp 36, max platform bpp 36)
<7> [384.425936] xe 0000:00:02.0: [drm:intel_hdmi_compute_clock [xe]] picking 8 bpc for HDMI output (pipe bpp: 24)
<7> [384.426038] xe 0000:00:02.0: [drm:intel_atomic_check [xe]] [CRTC:88:pipe A] hw max bpp: 24, pipe bpp: 24, dithering: 0
<7> [384.426145] xe 0000:00:02.0: [drm:intel_ddi_compute_config_late [xe]] [ENCODER:261:DDI B/PHY B] [CRTC:88:pipe A]
<7> [384.426252] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:88:pipe A] fastset requirement not met in hw.enable (expected no, found yes)
<7> [384.426361] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:88:pipe A] fastset requirement not met in hw.active (expected no, found yes)
<7> [384.426466] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:88:pipe A] fastset requirement not met in cpu_transcoder (expected -1, found 0)
<7> [384.426582] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:88:pipe A] fastset requirement not met in lane_count (expected 0, found 4)
<7> [384.426704] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:88:pipe A] fastset requirement not met in output_types (expected 0x00000000, found 0x00000040)
<7> [384.426810] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:88:pipe A] fastset requirement not met in framestart_delay (expected 0, found 1)
<7> [384.426915] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:88:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hdisplay (expected 0, found 1920)
<7> [384.427028] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:88:pipe A] fastset requirement not met in hw.pipe_mode.crtc_htotal (expected 0, found 2200)
<7> [384.427135] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:88:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hblank_start (expected 0, found 1920)
<7> [384.427239] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:88:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hblank_end (expected 0, found 2200)
<7> [384.427341] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:88:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hsync_start (expected 0, found 2008)
<7> [384.427442] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:88:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hsync_end (expected 0, found 2052)
<7> [384.427584] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:88:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vdisplay (expected 0, found 1080)
<7> [384.427697] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:88:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vblank_start (expected 0, found 1080)
<7> [384.427806] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:88:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vsync_start (expected 0, found 1084)
<7> [384.427908] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:88:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vsync_end (expected 0, found 1089)
<7> [384.428009] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:88:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vtotal (expected 0, found 1125)
<7> [384.428110] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:88:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vblank_end (expected 0, found 1125)
<7> [384.428208] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:88:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hdisplay (expected 0, found 1920)
<7> [384.428307] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:88:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_htotal (expected 0, found 2200)
<7> [384.428405] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:88:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hblank_start (expected 0, found 1920)
<7> [384.428506] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:88:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hblank_end (expected 0, found 2200)
<7> [384.428624] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:88:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hsync_start (expected 0, found 2008)
<7> [384.428749] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:88:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hsync_end (expected 0, found 2052)
<7> [384.428857] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:88:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vdisplay (expected 0, found 1080)
<7> [384.428959] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:88:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vblank_start (expected 0, found 1080)
<7> [384.429060] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:88:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vsync_start (expected 0, found 1084)
<7> [384.429159] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:88:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vsync_end (expected 0, found 1089)
<7> [384.429258] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:88:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vtotal (expected 0, found 1125)
<7> [384.429357] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:88:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vblank_end (expected 0, found 1125)
<7> [384.429457] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:88:pipe A] fastset requirement not met in pixel_multiplier (expected 0, found 1)
<7> [384.429575] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:88:pipe A] fastset requirement not met in hw.adjusted_mode.flags (1) (expected 0, found 1)
<7> [384.429688] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:88:pipe A] fastset requirement not met in hw.adjusted_mode.flags (4) (expected 0, found 4)
<7> [384.429790] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:88:pipe A] fastset requirement not met in pipe_bpp (expected 0, found 24)
<7> [384.429891] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:88:pipe A] fastset requirement not met in hw.pipe_mode.crtc_clock (expected 0, found 148500)
<7> [384.429992] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:88:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_clock (expected 0, found 148500)
<7> [384.430096] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:88:pipe A] fastset requirement not met in port_clock (expected 0, found 148500)
<7> [384.430200] xe 0000:00:02.0: [drm:intel_atomic_check [xe]] [CRTC:88:pipe A] fastset requirement not met, forcing full modeset
<7> [384.430336] xe 0000:00:02.0: [drm:skl_compute_wm [xe]] Enabled dbuf slices 0x1 -> 0xf (total dbuf slices 0xf), mbus joined? no->yes
<7> [384.430427] xe 0000:00:02.0: [drm:skl_compute_wm [xe]] [CRTC:88:pipe A] dbuf slices 0x0 -> 0xf, ddb (0 - 0) -> (0 - 4096), active pipes 0x0 -> 0x1
<7> [384.430574] xe 0000:00:02.0: [drm:skl_compute_wm [xe]] [PLANE:33:plane 1A] ddb ( 0 - 0) -> ( 0 - 4060), size 0 -> 4060
<7> [384.430667] xe 0000:00:02.0: [drm:skl_compute_wm [xe]] [PLANE:83:cursor A] ddb ( 0 - 0) -> (4060 - 4096), size 0 -> 36
<7> [384.430756] xe 0000:00:02.0: [drm:skl_print_plane_changes [xe]] [PLANE:33:plane 1A] level wm0, wm1, wm2, wm3, wm4, wm5, wm6, wm7, twm, swm, stwm -> *wm0,*wm1,*wm2,*wm3,*wm4,*wm5, wm6, wm7,*twm,*swm,*stwm
<7> [384.430840] xe 0000:00:02.0: [drm:skl_print_plane_changes [xe]] [PLANE:33:plane 1A] lines 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0 -> 1, 4, 6, 7, 10, 10, 0, 0, 0, 3, 0
<7> [384.430923] xe 0000:00:02.0: [drm:skl_print_plane_changes [xe]] [PLANE:33:plane 1A] blocks 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0 -> 16, 65, 97, 113, 161, 161, 0, 0, 30, 49, 63
<7> [384.431003] xe 0000:00:02.0: [drm:skl_print_plane_changes [xe]] [PLANE:33:plane 1A] min_ddb 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0 -> 19, 73, 108, 126, 179, 179, 0, 0, 31, 55, 64
<7> [384.431095] xe 0000:00:02.0: [drm:intel_bw_atomic_check [xe]] [CRTC:88:pipe A] data rate 594000 num active planes 1
<7> [384.431204] xe 0000:00:02.0: [drm:intel_bw_atomic_check [xe]] QGV point 0: max bw 10441 required 594
<7> [384.431312] xe 0000:00:02.0: [drm:intel_bw_atomic_check [xe]] QGV point 1: max bw 17848 required 594
<7> [384.431420] xe 0000:00:02.0: [drm:intel_bw_atomic_check [xe]] QGV point 2: max bw 18818 required 594
<7> [384.431536] xe 0000:00:02.0: [drm:intel_bw_atomic_check [xe]] QGV point 3: max bw 18818 required 594
<7> [384.431655] xe 0000:00:02.0: [drm:intel_bw_atomic_check [xe]] PSF GV point 0: max bw 34133 required 594
<7> [384.431760] xe 0000:00:02.0: [drm:intel_bw_atomic_check [xe]] PSF GV point 1: max bw 51200 required 594
<7> [384.431861] xe 0000:00:02.0: [drm:intel_bw_atomic_check [xe]] PSF GV point 2: max bw 51200 required 594
<7> [384.431964] xe 0000:00:02.0: [drm:intel_cdclk_atomic_check [xe]] [CRTC:88:pipe A] min cdclk: 0 kHz -> 74250 kHz
<7> [384.432081] xe 0000:00:02.0: [drm:intel_cdclk_update_dbuf_bw_min_cdclk [xe]] dbuf bandwidth min cdclk: 0 kHz -> 9282 kHz
<7> [384.432185] xe 0000:00:02.0: [drm:intel_find_dpll [xe]] [CRTC:88:pipe A] allocated DPLL 0
<7> [384.432288] xe 0000:00:02.0: [drm:intel_dpll_crtc_get [xe]] [CRTC:88:pipe A] reserving DPLL 0
<7> [384.432391] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [CRTC:88:pipe A] enable: yes [modeset]
<7> [384.432501] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] active: yes, output_types: HDMI (0x40), output format: RGB, sink format: RGB
<7> [384.432632] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] cpu_transcoder: A, pipe bpp: 24, dithering: 0
<7> [384.432756] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] MST master transcoder: <invalid>
<7> [384.432863] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] port sync: master transcoder: <invalid>, slave transcoder bitmask = 0x0
<7> [384.432970] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] joiner: no, pipes: 0x0
<7> [384.433073] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] splitter: disabled, link count 0, overlap 0
<7> [384.433174] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] audio: 0, infoframes: 0, infoframes enabled: 0x0
<7> [384.433274] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] scanline offset: 2
<7> [384.433373] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] framestart delay: 1, MSA timing delay: 0, set context latency: 0
<7> [384.433472] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] vrr: no, fixed rr: yes, vmin: 1125, vmax: 1125, flipline: 1125, pipeline full: 0, guardband: 45 vsync start: 41, vsync end: 36
<7> [384.433585] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] vrr: vmin vblank: 1080, vmax vblank: 1080, vmin vtotal: 1125, vmax vtotal: 1125
<7> [384.433698] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] requested mode: "1920x1080": 60 148500 1920 2008 2052 2200 1080 1084 1089 1125 0x48 0x5
<7> [384.433798] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] adjusted mode: "1920x1080": 60 148500 1920 2008 2052 2200 1080 1084 1089 1125 0x48 0x5
<7> [384.433896] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] crtc timings: clock=148500, hd=1920 hb=1920-2200 hs=2008-2052 ht=2200, vd=1080 vb=1080-1125 vs=1084-1089 vt=1125, flags=0x5
<7> [384.433995] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] pipe mode: "1920x1080": 60 148500 1920 2008 2052 2200 1080 1084 1089 1125 0x40 0x5
<7> [384.434102] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] crtc timings: clock=148500, hd=1920 hb=1920-2200 hs=2008-2052 ht=2200, vd=1080 vb=1080-1125 vs=1084-1089 vt=1125, flags=0x5
<7> [384.434207] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] port clock: 148500, pipe src: 1920x1080+0+0, pixel rate 148500, min cdclk 74250
<7> [384.434309] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] linetime: 119, ips linetime: 0
<7> [384.434410] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] num_scalers: 2, scaler_users: 0x0, scaler_id: -1, scaling_filter: 0
<7> [384.434515] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] pch pfit: 0x0+0+0, disabled, force thru: no
<7> [384.434632] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] ips: 0, double wide: 0, drrs: 0
<7> [384.434734] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] dpll_hw_state: cfgcr0: 0x1001d0, cfgcr1: 0xe84, div0: 0x0, mg_refclkin_ctl: 0x0, hg_clktop2_coreclkctl1: 0x0, mg_clktop2_hsclkctl: 0x0, mg_pll_div0: 0x0, mg_pll_div2: 0x0, mg_pll_lf: 0x0, mg_pll_frac_lock: 0x0, mg_pll_ssc: 0x0, mg_pll_bias: 0x0, mg_pll_tdc_coldst_bias: 0x0
<7> [384.434835] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] csc_mode: 0x0 gamma_mode: 0x0 gamma_enable: 0 csc_enable: 0
<7> [384.434934] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] pre csc lut: 0 entries, post csc lut: 0 entries
<7> [384.435031] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] output csc: pre offsets: 0x0000 0x0000 0x0000
<7> [384.435128] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] output csc: coefficients: 0x0000 0x0000 0x0000
<7> [384.435227] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] output csc: coefficients: 0x0000 0x0000 0x0000
<7> [384.435331] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] output csc: coefficients: 0x0000 0x0000 0x0000
<7> [384.435432] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] output csc: post offsets: 0x0000 0x0000 0x0000
<7> [384.435549] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] pipe csc: pre offsets: 0x0000 0x0000 0x0000
<7> [384.435664] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] pipe csc: coefficients: 0x0000 0x0000 0x0000
<7> [384.435767] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] pipe csc: coefficients: 0x0000 0x0000 0x0000
<7> [384.435870] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] pipe csc: coefficients: 0x0000 0x0000 0x0000
<7> [384.435973] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] pipe csc: post offsets: 0x0000 0x0000 0x0000
<7> [384.436073] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] sharpness strength: 0, sharpness tap size: 0, sharpness enable: 0
<7> [384.436172] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [PLANE:33:plane 1A] fb: [FB:319] 1920x1080 format = XR24 little-endian (0x34325258) modifier = 0x100000000000001, visible: yes
<7> [384.436273] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] rotation: 0x1, scaler: -1, scaling_filter: 0
<7> [384.436371] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] src: 1920.000000x1080.000000+0.000000+0.000000 dst: 1920x1080+0+0
<7> [384.436471] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [PLANE:43:plane 2A] fb: [NOFB], visible: no
<7> [384.436581] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [PLANE:53:plane 3A] fb: [NOFB], visible: no
<7> [384.436699] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [PLANE:63:plane 4A] fb: [NOFB], visible: no
<7> [384.436806] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [PLANE:73:plane 5A] fb: [NOFB], visible: no
<7> [384.436910] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [PLANE:83:cursor A] fb: [NOFB], visible: no
<7> [384.437194] xe 0000:00:02.0: [drm:intel_power_well_enable [xe]] enabling PW_A
<7> [384.437336] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:261:DDI B/PHY B]
<7> [384.437433] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:263:DP-MST A]
<7> [384.437549] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:264:DP-MST B]
<7> [384.437652] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:265:DP-MST C]
<7> [384.437748] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:266:DP-MST D]
<7> [384.437840] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:280:DDI TC1/PHY TC1]
<7> [384.437929] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:282:DP-MST A]
<7> [384.438015] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:283:DP-MST B]
<7> [384.438102] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:284:DP-MST C]
<7> [384.438192] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:285:DP-MST D]
<7> [384.438279] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:289:DDI TC2/PHY TC2]
<7> [384.438364] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:291:DP-MST A]
<7> [384.438449] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:292:DP-MST B]
<7> [384.438569] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:293:DP-MST C]
<7> [384.438678] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:294:DP-MST D]
<7> [384.438774] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:298:DDI TC3/PHY TC3]
<7> [384.438865] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:300:DP-MST A]
<7> [384.438954] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:301:DP-MST B]
<7> [384.439043] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:302:DP-MST C]
<7> [384.439131] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:303:DP-MST D]
<7> [384.439218] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:307:DDI TC4/PHY TC4]
<7> [384.439305] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:309:DP-MST A]
<7> [384.439398] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:310:DP-MST B]
<7> [384.439490] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:311:DP-MST C]
<7> [384.439651] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:312:DP-MST D]
<7> [384.439752] xe 0000:00:02.0: [drm:gen9_dbuf_slices_update [xe]] Updating dbuf slices to 0xf
<7> [384.439901] xe 0000:00:02.0: [drm:intel_dbuf_mbus_join_update [xe]] Changing mbus joined: no -> yes (pipe: *)
<7> [384.439985] xe 0000:00:02.0: [drm:intel_dbuf_mdclk_cdclk_ratio_update [xe]] Updating dbuf ratio to 4 (mbus joined: yes)
<7> [384.440076] xe 0000:00:02.0: [drm:intel_dpll_enable [xe]] enable DPLL 0 (active 0x1, on? 0) for [CRTC:88:pipe A]
<7> [384.440185] xe 0000:00:02.0: [drm:intel_dpll_enable [xe]] enabling DPLL 0
<7> [384.440313] xe 0000:00:02.0: [drm:intel_power_well_enable [xe]] enabling DDI_IO_B
<7> [384.440450] xe 0000:00:02.0: [drm:intel_enable_transcoder [xe]] enabling pipe A
<7> [384.440892] xe 0000:00:02.0: [drm:intel_fbc_update [xe]] reserved 8847360 bytes of contiguous stolen space for FBC, limit: 1
<7> [384.440995] xe 0000:00:02.0: [drm:intel_fbc_update [xe]] Enabling FBC on [PLANE:33:plane 1A]
<7> [384.457694] xe 0000:00:02.0: [drm:verify_connector_state [xe]] [CONNECTOR:275:HDMI-A-1]
<7> [384.457798] xe 0000:00:02.0: [drm:intel_modeset_verify_crtc [xe]] [CRTC:88:pipe A]
<6> [385.341493] [IGT] kms_flip: finished subtest A-HDMI-A1, FAIL
<7> [385.341551] xe 0000:00:02.0: [drm:intel_power_well_disable [xe]] disabling DC_off
<7> [385.341720] xe 0000:00:02.0: [drm:skl_enable_dc6 [xe]] Enabling DC6
<7> [385.341844] xe 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [xe]] Setting DC state from 00 to 02
<7> [385.341971] xe 0000:00:02.0: [drm:intel_power_well_enable [xe]] enabling DC_off
<7> [385.342098] xe 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [xe]] Setting DC state from 02 to 00
Created at 2025-11-26 13:34:21