Results for igt@kms_flip@2x-flip-vs-expired-vblank-interruptible@ad-hdmi-a6-dp4

Result: Fail

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

DetailValue
Duration 2.58 seconds
Hostname
shard-dg2-435
Igt-Version
IGT-Version: 2.2-g3f90f16d1 (x86_64) (Linux: 6.18.0-rc5-lgci-xe-xe-4093-901209e0bc8aff48c+ x86_64)
Out
Starting dynamic subtest: AD-HDMI-A6-DP4
  1920x1080: 60 148500 1920 2008 2052 2200 1080 1084 1089 1125 0x48 0x5 
  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:1974 run_pair()
  #3 ../tests/kms_flip.c:2165 __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 AD-HDMI-A6-DP4: FAIL (2.578s)
Err
Starting dynamic subtest: AD-HDMI-A6-DP4
(kms_flip:7561) CRITICAL: Test assertion failure function run_test_step, file ../tests/kms_flip.c:928:
(kms_flip:7561) CRITICAL: Failed assertion: end - start < 500
(kms_flip:7561) CRITICAL: Last errno: 4, Interrupted system call
Dynamic subtest AD-HDMI-A6-DP4 failed.
**** DEBUG ****
(kms_flip:7561) DEBUG: Vblank took 87us
(kms_flip:7561) DEBUG: name = flip
last_ts = 305.061615
last_received_ts = 305.060974
last_seq = 4255
current_ts = 305.078278
current_received_ts = 305.077667
current_seq = 4256
count = 4
seq_step = 1
(kms_flip:7561) DEBUG: Vblank took 19us
(kms_flip:7561) DEBUG: name = flip
last_ts = 305.078278
last_received_ts = 305.077667
last_seq = 4256
current_ts = 305.094940
current_received_ts = 305.094330
current_seq = 4257
count = 5
seq_step = 1
(kms_flip:7561) DEBUG: Vblank took 19us
(kms_flip:7561) DEBUG: name = flip
last_ts = 305.094940
last_received_ts = 305.094330
last_seq = 4257
current_ts = 305.111603
current_received_ts = 305.110992
current_seq = 4258
count = 6
seq_step = 1
(kms_flip:7561) DEBUG: Vblank took 19us
(kms_flip:7561) DEBUG: name = flip
last_ts = 305.111603
last_received_ts = 305.110992
last_seq = 4258
current_ts = 305.128265
current_received_ts = 305.127655
current_seq = 4259
count = 7
seq_step = 1
(kms_flip:7561) DEBUG: Vblank took 38us
(kms_flip:7561) DEBUG: name = flip
last_ts = 305.128265
last_received_ts = 305.127655
last_seq = 4259
current_ts = 305.144958
current_received_ts = 305.144318
current_seq = 4260
count = 8
seq_step = 1
(kms_flip:7561) DEBUG: Vblank took 19us
(kms_flip:7561) DEBUG: name = flip
last_ts = 305.144958
last_received_ts = 305.144318
last_seq = 4260
current_ts = 305.161621
current_received_ts = 305.160980
current_seq = 4261
count = 9
seq_step = 1
(kms_flip:7561) DEBUG: Vblank took 19us
(kms_flip:7561) DEBUG: name = flip
last_ts = 305.161621
last_received_ts = 305.160980
last_seq = 4261
current_ts = 305.178284
current_received_ts = 305.177673
current_seq = 4262
count = 10
seq_step = 1
(kms_flip:7561) DEBUG: Vblank took 19us
(kms_flip:7561) DEBUG: name = flip
last_ts = 305.178284
last_received_ts = 305.177673
last_seq = 4262
current_ts = 305.194946
current_received_ts = 305.194336
current_seq = 4263
count = 11
seq_step = 1
(kms_flip:7561) DEBUG: Vblank took 20us
(kms_flip:7561) DEBUG: name = flip
last_ts = 305.194946
last_received_ts = 305.194336
last_seq = 4263
current_ts = 305.211609
current_received_ts = 305.210999
current_seq = 4264
count = 12
seq_step = 1
(kms_flip:7561) DEBUG: Vblank took 18us
(kms_flip:7561) DEBUG: name = flip
last_ts = 305.211609
last_received_ts = 305.210999
last_seq = 4264
current_ts = 305.228271
current_received_ts = 305.227661
current_seq = 4265
count = 13
seq_step = 1
(kms_flip:7561) DEBUG: Vblank took 19us
(kms_flip:7561) DEBUG: name = flip
last_ts = 305.228271
last_received_ts = 305.227661
last_seq = 4265
current_ts = 305.244965
current_received_ts = 305.244324
current_seq = 4266
count = 14
seq_step = 1
(kms_flip:7561) DEBUG: Vblank took 19us
(kms_flip:7561) DEBUG: name = flip
last_ts = 305.244965
last_received_ts = 305.244324
last_seq = 4266
current_ts = 305.261627
current_received_ts = 305.261017
current_seq = 4267
count = 15
seq_step = 1
(kms_flip:7561) DEBUG: Vblank took 93us
(kms_flip:7561) DEBUG: name = flip
last_ts = 305.261627
last_received_ts = 305.261017
last_seq = 4267
current_ts = 305.278290
current_received_ts = 305.277679
current_seq = 4268
count = 16
seq_step = 1
(kms_flip:7561) DEBUG: Vblank took 19us
(kms_flip:7561) DEBUG: name = flip
last_ts = 305.278290
last_received_ts = 305.277679
last_seq = 4268
current_ts = 305.294952
current_received_ts = 305.294342
current_seq = 4269
count = 17
seq_step = 1
(kms_flip:7561) DEBUG: Vblank took 19us
(kms_flip:7561) DEBUG: name = flip
last_ts = 305.294952
last_received_ts = 305.294342
last_seq = 4269
current_ts = 305.311615
current_received_ts = 305.311035
current_seq = 4270
count = 18
seq_step = 1
(kms_flip:7561) DEBUG: Vblank took 20us
(kms_flip:7561) DEBUG: name = flip
last_ts = 305.311615
last_received_ts = 305.311035
last_seq = 4270
current_ts = 305.328278
current_received_ts = 305.327667
current_seq = 4271
count = 19
seq_step = 1
(kms_flip:7561) DEBUG: Vblank took 19us
(kms_flip:7561) DEBUG: name = flip
last_ts = 305.328278
last_received_ts = 305.327667
last_seq = 4271
current_ts = 305.344971
current_received_ts = 305.344330
current_seq = 4272
count = 20
seq_step = 1
(kms_flip:7561) DEBUG: Vblank took 19us
(kms_flip:7561) DEBUG: name = flip
last_ts = 305.344971
last_received_ts = 305.344330
last_seq = 4272
current_ts = 305.361633
current_received_ts = 305.361023
current_seq = 4273
count = 21
seq_step = 1
(kms_flip:7561) DEBUG: Vblank took 19us
(kms_flip:7561) DEBUG: name = flip
last_ts = 305.361633
last_received_ts = 305.361023
last_seq = 4273
current_ts = 305.378296
current_received_ts = 305.377686
current_seq = 4274
count = 22
seq_step = 1
(kms_flip:7561) DEBUG: Vblank took 18us
(kms_flip:7561) DEBUG: name = flip
last_ts = 305.378296
last_received_ts = 305.377686
last_seq = 4274
current_ts = 305.394958
current_received_ts = 305.394348
current_seq = 4275
count = 23
seq_step = 1
(kms_flip:7561) DEBUG: Vblank took 19us
(kms_flip:7561) DEBUG: name = flip
last_ts = 305.394958
last_received_ts = 305.394348
last_seq = 4275
current_ts = 305.411621
current_received_ts = 305.411011
current_seq = 4276
count = 24
seq_step = 1
(kms_flip:7561) DEBUG: Vblank took 19us
(kms_flip:7561) DEBUG: name = flip
last_ts = 305.411621
last_received_ts = 305.411011
last_seq = 4276
current_ts = 305.428284
current_received_ts = 305.427704
current_seq = 4277
count = 25
seq_step = 1
(kms_flip:7561) DEBUG: Vblank took 95us
(kms_flip:7561) DEBUG: name = flip
last_ts = 305.428284
last_received_ts = 305.427704
last_seq = 4277
current_ts = 305.444977
current_received_ts = 305.444366
current_seq = 4278
count = 26
seq_step = 1
(kms_flip:7561) DEBUG: Vblank took 19us
(kms_flip:7561) DEBUG: name = flip
last_ts = 305.444977
last_received_ts = 305.444366
last_seq = 4278
current_ts = 305.461639
current_received_ts = 305.461060
current_seq = 4279
count = 27
seq_step = 1
(kms_flip:7561) DEBUG: Vblank took 83us
(kms_flip:7561) DEBUG: name = flip
last_ts = 305.461639
last_received_ts = 305.461060
last_seq = 4279
current_ts = 305.478302
current_received_ts = 305.477692
current_seq = 4280
count = 28
seq_step = 1
(kms_flip:7561) DEBUG: Vblank took 18us
(kms_flip:7561) DEBUG: name = flip
last_ts = 305.478302
last_received_ts = 305.477692
last_seq = 4280
current_ts = 305.494965
current_received_ts = 305.494385
current_seq = 4281
count = 29
seq_step = 1
(kms_flip:7561) DEBUG: Vblank took 95us
(kms_flip:7561) DEBUG: name = flip
last_ts = 305.494965
last_received_ts = 305.494385
last_seq = 4281
current_ts = 305.511627
current_received_ts = 305.511078
current_seq = 4282
count = 30
seq_step = 1
(kms_flip:7561) DEBUG: Vblank took 20us
(kms_flip:7561) DEBUG: name = flip
last_ts = 305.511627
last_received_ts = 305.511078
last_seq = 4282
current_ts = 305.528320
current_received_ts = 305.527710
current_seq = 4283
count = 31
seq_step = 1
(kms_flip:7561) DEBUG: Vblank took 97us
(kms_flip:7561) DEBUG: name = flip
last_ts = 305.528320
last_received_ts = 305.527710
last_seq = 4283
current_ts = 305.544983
current_received_ts = 305.544342
current_seq = 4284
count = 32
seq_step = 1
(kms_flip:7561) DEBUG: Vblank took 39us
(kms_flip:7561) DEBUG: name = flip
last_ts = 305.544983
last_received_ts = 305.544342
last_seq = 4284
current_ts = 305.561646
current_received_ts = 305.561035
current_seq = 4285
count = 33
seq_step = 1
(kms_flip:7561) DEBUG: Vblank took 82us
(kms_flip:7561) DEBUG: name = flip
last_ts = 305.561646
last_received_ts = 305.561035
last_seq = 4285
current_ts = 305.578308
current_received_ts = 305.577698
current_seq = 4286
count = 34
seq_step = 1
(kms_flip:7561) DEBUG: Vblank took 19us
(kms_flip:7561) DEBUG: name = flip
last_ts = 305.578308
last_received_ts = 305.577698
last_seq = 4286
current_ts = 305.594971
current_received_ts = 305.594360
current_seq = 4287
count = 35
seq_step = 1
(kms_flip:7561) DEBUG: Vblank took 19us
(kms_flip:7561) DEBUG: name = flip
last_ts = 305.594971
last_received_ts = 305.594360
last_seq = 4287
current_ts = 305.611633
current_received_ts = 305.611023
current_seq = 4288
count = 36
seq_step = 1
(kms_flip:7561) DEBUG: Vblank took 19us
(kms_flip:7561) DEBUG: name = flip
last_ts = 305.611633
last_received_ts = 305.611023
last_seq = 4288
current_ts = 305.628326
current_received_ts = 305.627686
current_seq = 4289
count = 37
seq_step = 1
(kms_flip:7561) DEBUG: Vblank took 19us
(kms_flip:7561) DEBUG: name = flip
last_ts = 305.628326
last_received_ts = 305.627686
last_seq = 4289
current_ts = 305.644989
current_received_ts = 305.644348
current_seq = 4290
count = 38
seq_step = 1
(kms_flip:7561) DEBUG: Vblank took 19us
(kms_flip:7561) DEBUG: name = flip
last_ts = 305.644989
last_received_ts = 305.644348
last_seq = 4290
current_ts = 305.661652
current_received_ts = 305.661041
current_seq = 4291
count = 39
seq_step = 1
(kms_flip:7561) DEBUG: Vblank took 20us
(kms_flip:7561) DEBUG: name = flip
last_ts = 305.661652
last_received_ts = 305.661041
last_seq = 4291
current_ts = 305.678314
current_received_ts = 305.677704
current_seq = 4292
count = 40
seq_step = 1
(kms_flip:7561) DEBUG: Vblank took 19us
(kms_flip:7561) DEBUG: name = flip
last_ts = 305.678314
last_received_ts = 305.677704
last_seq = 4292
current_ts = 305.694977
current_received_ts = 305.694366
current_seq = 4293
count = 41
seq_step = 1
(kms_flip:7561) DEBUG: Vblank took 19us
(kms_flip:7561) DEBUG: name = flip
last_ts = 305.694977
last_received_ts = 305.694366
last_seq = 4293
current_ts = 305.711639
current_received_ts = 305.711060
current_seq = 4294
count = 42
seq_step = 1
(kms_flip:7561) DEBUG: Vblank took 20us
(kms_flip:7561) DEBUG: name = flip
last_ts = 305.711639
last_received_ts = 305.711060
last_seq = 4294
current_ts = 305.728333
current_received_ts = 305.727692
current_seq = 4295
count = 43
seq_step = 1
(kms_flip:7561) DEBUG: Vblank took 19us
(kms_flip:7561) DEBUG: name = flip
last_ts = 305.728333
last_received_ts = 305.727692
last_seq = 4295
current_ts = 305.744995
current_received_ts = 305.744385
current_seq = 4296
count = 44
seq_step = 1
(kms_flip:7561) DEBUG: Vblank took 19us
(kms_flip:7561) DEBUG: name = flip
last_ts = 305.744995
last_received_ts = 305.744385
last_seq = 4296
current_ts = 305.761658
current_received_ts = 305.761047
current_seq = 4297
count = 45
seq_step = 1
(kms_flip:7561) DEBUG: Vblank took 92us
(kms_flip:7561) DEBUG: name = flip
last_ts = 305.761658
last_received_ts = 305.761047
last_seq = 4297
current_ts = 305.778320
current_received_ts = 305.777710
current_seq = 4298
count = 46
seq_step = 1
(kms_flip:7561) DEBUG: Vblank took 19us
(kms_flip:7561) DEBUG: name = flip
last_ts = 305.778320
last_received_ts = 305.777710
last_seq = 4298
current_ts = 305.794983
current_received_ts = 305.794373
current_seq = 4299
count = 47
seq_step = 1
(kms_flip:7561) DEBUG: Vblank took 19us
(kms_flip:7561) DEBUG: name = flip
last_ts = 305.794983
last_received_ts = 305.794373
last_seq = 4299
current_ts = 305.811676
current_received_ts = 305.811066
current_seq = 4300
count = 48
seq_step = 1
(kms_flip:7561) DEBUG: Vblank took 19us
(kms_flip:7561) DEBUG: name = flip
last_ts = 305.811676
last_received_ts = 305.811066
last_seq = 4300
current_ts = 305.828339
current_received_ts = 305.827698
current_seq = 4301
count = 49
seq_step = 1
(kms_flip:7561) DEBUG: Vblank took 19us
(kms_flip:7561) DEBUG: name = flip
last_ts = 305.828339
last_received_ts = 305.827698
last_seq = 4301
current_ts = 305.845001
current_received_ts = 305.844391
current_seq = 4302
count = 50
seq_step = 1
(kms_flip:7561) DEBUG: Vblank took 19us
(kms_flip:7561) DEBUG: name = flip
last_ts = 305.845001
last_received_ts = 305.844391
last_seq = 4302
current_ts = 305.861664
current_received_ts = 305.861053
current_seq = 4303
count = 51
seq_step = 1
(kms_flip:7561) DEBUG: Vblank took 98us
(kms_flip:7561) DEBUG: name = flip
last_ts = 305.861664
last_received_ts = 305.861053
last_seq = 4303
current_ts = 305.878326
current_received_ts = 305.877716
current_seq = 4304
count = 52
seq_step = 1
(kms_flip:7561) DEBUG: Vblank took 19us
(kms_flip:7561) DEBUG: name = flip
last_ts = 305.878326
last_received_ts = 305.877716
last_seq = 4304
current_ts = 305.894989
current_received_ts = 305.894379
current_seq = 4305
count = 53
seq_step = 1
(kms_flip:7561) DEBUG: Vblank took 19us
(kms_flip:7561) DEBUG: name = flip
last_ts = 305.894989
last_received_ts = 305.894379
last_seq = 4305
current_ts = 305.911682
current_received_ts = 305.911072
current_seq = 4306
count = 54
seq_step = 1
(kms_flip:7561) DEBUG: Vblank took 19us
(kms_flip:7561) DEBUG: name = flip
last_ts = 305.911682
last_received_ts = 305.911072
last_seq = 4306
current_ts = 305.928345
current_received_ts = 305.927704
current_seq = 4307
count = 55
seq_step = 1
(kms_flip:7561) DEBUG: Vblank took 19us
(kms_flip:7561) DEBUG: name = flip
last_ts = 305.928345
last_received_ts = 305.927704
last_seq = 4307
current_ts = 305.945007
current_received_ts = 305.944397
current_seq = 4308
count = 56
seq_step = 1
(kms_flip:7561) DEBUG: Vblank took 19us
(kms_flip:7561) DEBUG: name = flip
last_ts = 305.945007
last_received_ts = 305.944397
last_seq = 4308
current_ts = 305.961670
current_received_ts = 305.961060
current_seq = 4309
count = 57
seq_step = 1
(kms_flip:7561) DEBUG: Vblank took 96us
(kms_flip:7561) DEBUG: name = flip
last_ts = 305.961670
last_received_ts = 305.961060
last_seq = 4309
current_ts = 305.978333
current_received_ts = 305.977722
current_seq = 4310
count = 58
seq_step = 1
(kms_flip:7561) DEBUG: Vblank took 19us
(kms_flip:7561) DEBUG: name = flip
last_ts = 305.978333
last_received_ts = 305.977722
last_seq = 4310
current_ts = 305.994995
current_received_ts = 305.994385
current_seq = 4311
count = 59
seq_step = 1
(kms_flip:7561) DEBUG: Vblank took 20us
(kms_flip:7561) DEBUG: name = flip
last_ts = 305.994995
last_received_ts = 305.994385
last_seq = 4311
current_ts = 306.011688
current_received_ts = 306.011078
current_seq = 4312
count = 60
seq_step = 1
(kms_flip:7561) DEBUG: Vblank took 19us
(kms_flip:7561) DEBUG: name = flip
last_ts = 306.011688
last_received_ts = 306.011078
last_seq = 4312
current_ts = 306.028351
current_received_ts = 306.027740
current_seq = 4313
count = 61
seq_step = 1
(kms_flip:7561) DEBUG: Vblank took 20us
(kms_flip:7561) DEBUG: name = flip
last_ts = 306.028351
last_received_ts = 306.027740
last_seq = 4313
current_ts = 306.045013
current_received_ts = 306.044403
current_seq = 4314
count = 62
seq_step = 1
(kms_flip:7561) DEBUG: Vblank took 19us
(kms_flip:7561) DEBUG: name = flip
last_ts = 306.045013
last_received_ts = 306.044403
last_seq = 4314
current_ts = 306.061676
current_received_ts = 306.061066
current_seq = 4315
count = 63
seq_step = 1
(kms_flip:7561) DEBUG: Vblank took 19us
(kms_flip:7561) DEBUG: name = flip
last_ts = 306.061676
last_received_ts = 306.061066
last_seq = 4315
current_ts = 306.078339
current_received_ts = 306.077728
current_seq = 4316
count = 64
seq_step = 1
(kms_flip:7561) DEBUG: Vblank took 19us
(kms_flip:7561) DEBUG: name = flip
last_ts = 306.078339
last_received_ts = 306.077728
last_seq = 4316
current_ts = 306.095001
current_received_ts = 306.094391
current_seq = 4317
count = 65
seq_step = 1
(kms_flip:7561) DEBUG: Vblank took 20us
(kms_flip:7561) DEBUG: name = flip
last_ts = 306.095001
last_received_ts = 306.094391
last_seq = 4317
current_ts = 306.111664
current_received_ts = 306.111084
current_seq = 4318
count = 66
seq_step = 1
(kms_flip:7561) DEBUG: Vblank took 19us
(kms_flip:7561) DEBUG: name = flip
last_ts = 306.111664
last_received_ts = 306.111084
last_seq = 4318
current_ts = 306.128357
current_received_ts = 306.127747
current_seq = 4319
count = 67
seq_step = 1
(kms_flip:7561) DEBUG: Vblank took 19us
(kms_flip:7561) DEBUG: name = flip
last_ts = 306.128357
last_received_ts = 306.127747
last_seq = 4319
current_ts = 306.145020
current_received_ts = 306.144409
current_seq = 4320
count = 68
seq_step = 1
(kms_flip:7561) DEBUG: Vblank took 18us
(kms_flip:7561) DEBUG: name = flip
last_ts = 306.145020
last_received_ts = 306.144409
last_seq = 4320
current_ts = 306.161682
current_received_ts = 306.161072
current_seq = 4321
count = 69
seq_step = 1
(kms_flip:7561) DEBUG: Vblank took 19us
(kms_flip:7561) DEBUG: name = flip
last_ts = 306.161682
last_received_ts = 306.161072
last_seq = 4321
current_ts = 306.178345
current_received_ts = 306.177734
current_seq = 4322
count = 70
seq_step = 1
(kms_flip:7561) DEBUG: Vblank took 19us
(kms_flip:7561) DEBUG: name = flip
last_ts = 306.178345
last_received_ts = 306.177734
last_seq = 4322
current_ts = 306.195038
current_received_ts = 306.194397
current_seq = 4323
count = 71
seq_step = 1
(kms_flip:7561) DEBUG: Vblank took 19us
(kms_flip:7561) DEBUG: name = flip
last_ts = 306.195038
last_received_ts = 306.194397
last_seq = 4323
current_ts = 306.211670
current_received_ts = 306.211090
current_seq = 4324
count = 72
seq_step = 1
(kms_flip:7561) DEBUG: Vblank took 19us
(kms_flip:7561) DEBUG: name = flip
last_ts = 306.211670
last_received_ts = 306.211090
last_seq = 4324
current_ts = 306.228363
current_received_ts = 306.227753
current_seq = 4325
count = 73
seq_step = 1
(kms_flip:7561) DEBUG: Vblank took 19us
(kms_flip:7561) DEBUG: name = flip
last_ts = 306.228363
last_received_ts = 306.227753
last_seq = 4325
current_ts = 306.245026
current_received_ts = 306.244415
current_seq = 4326
count = 74
seq_step = 1
(kms_flip:7561) DEBUG: Vblank took 19us
(kms_flip:7561) DEBUG: name = flip
last_ts = 306.245026
last_received_ts = 306.244415
last_seq = 4326
current_ts = 306.261688
current_received_ts = 306.261078
current_seq = 4327
count = 75
seq_step = 1
(kms_flip:7561) DEBUG: Vblank took 19us
(kms_flip:7561) DEBUG: name = flip
last_ts = 306.261688
last_received_ts = 306.261078
last_seq = 4327
current_ts = 306.278351
current_received_ts = 306.277740
current_seq = 4328
count = 76
seq_step = 1
(kms_flip:7561) DEBUG: Vblank took 19us
(kms_flip:7561) DEBUG: name = flip
last_ts = 306.278351
last_received_ts = 306.277740
last_seq = 4328
current_ts = 306.295044
current_received_ts = 306.294403
current_seq = 4329
count = 77
seq_step = 1
(kms_flip:7561) DEBUG: Vblank took 19us
(kms_flip:7561) DEBUG: name = flip
last_ts = 306.295044
last_received_ts = 306.294403
last_seq = 4329
current_ts = 306.311707
current_received_ts = 306.311096
current_seq = 4330
count = 78
seq_step = 1
(kms_flip:7561) DEBUG: Vblank took 19us
(kms_flip:7561) DEBUG: name = flip
last_ts = 306.311707
last_received_ts = 306.311096
last_seq = 4330
current_ts = 306.328369
current_received_ts = 306.327759
current_seq = 4331
count = 79
seq_step = 1
(kms_flip:7561) DEBUG: Vblank took 19us
(kms_flip:7561) DEBUG: name = flip
last_ts = 306.328369
last_received_ts = 306.327759
last_seq = 4331
current_ts = 306.345032
current_received_ts = 306.344421
current_seq = 4332
count = 80
seq_step = 1
(kms_flip:7561) DEBUG: Vblank took 18us
(kms_flip:7561) DEBUG: name = flip
last_ts = 306.345032
last_received_ts = 306.344421
last_seq = 4332
current_ts = 306.361694
current_received_ts = 306.361084
current_seq = 4333
count = 81
seq_step = 1
(kms_flip:7561) DEBUG: Vblank took 19us
(kms_flip:7561) DEBUG: name = flip
last_ts = 306.361694
last_received_ts = 306.361084
last_seq = 4333
current_ts = 306.378357
current_received_ts = 306.377747
current_seq = 4334
count = 82
seq_step = 1
(kms_flip:7561) DEBUG: Vblank took 18us
(kms_flip:7561) DEBUG: name = flip
last_ts = 306.378357
last_received_ts = 306.377747
last_seq = 4334
current_ts = 306.395050
current_received_ts = 306.394409
current_seq = 4335
count = 83
seq_step = 1
(kms_flip:7561) DEBUG: Vblank took 18us
(kms_flip:7561) DEBUG: name = flip
last_ts = 306.395050
last_received_ts = 306.394409
last_seq = 4335
current_ts = 306.411713
current_received_ts = 306.411072
current_seq = 4336
count = 84
seq_step = 1
(kms_flip:7561) DEBUG: Vblank took 19us
(kms_flip:7561) DEBUG: name = flip
last_ts = 306.411713
last_received_ts = 306.411072
last_seq = 4336
current_ts = 306.428375
current_received_ts = 306.427765
current_seq = 4337
count = 85
seq_step = 1
(kms_flip:7561) DEBUG: Vblank took 19us
(kms_flip:7561) DEBUG: name = flip
last_ts = 306.428375
last_received_ts = 306.427765
last_seq = 4337
current_ts = 306.445038
current_received_ts = 306.444427
current_seq = 4338
count = 86
seq_step = 1
(kms_flip:7561) DEBUG: Vblank took 19us
(kms_flip:7561) DEBUG: name = flip
last_ts = 306.445038
last_received_ts = 306.444427
last_seq = 4338
current_ts = 306.461700
current_received_ts = 306.461090
current_seq = 4339
count = 87
seq_step = 1
(kms_flip:7561) DEBUG: Vblank took 20us
(kms_flip:7561) DEBUG: name = flip
last_ts = 306.461700
last_received_ts = 306.461090
last_seq = 4339
current_ts = 306.478363
current_received_ts = 306.477753
current_seq = 4340
count = 88
seq_step = 1
(kms_flip:7561) DEBUG: Vblank took 19us
(kms_flip:7561) DEBUG: name = flip
last_ts = 306.478363
last_received_ts = 306.477753
last_seq = 4340
current_ts = 306.495056
current_received_ts = 306.494415
current_seq = 4341
count = 89
seq_step = 1
(kms_flip:7561) DEBUG: Vblank took 19us
(kms_flip:7561) DEBUG: name = flip
last_ts = 306.495056
last_received_ts = 306.494415
last_seq = 4341
current_ts = 306.511719
current_received_ts = 306.511108
current_seq = 4342
count = 90
seq_step = 1
(kms_flip:7561) DEBUG: Vblank took 20us
(kms_flip:7561) DEBUG: name = flip
last_ts = 306.511719
last_received_ts = 306.511108
last_seq = 4342
current_ts = 306.528381
current_received_ts = 306.527771
current_seq = 4343
count = 91
seq_step = 1
(kms_flip:7561) DEBUG: Vblank took 19us
(kms_flip:7561) DEBUG: name = flip
last_ts = 306.528381
last_received_ts = 306.527771
last_seq = 4343
current_ts = 306.545044
current_received_ts = 306.544434
current_seq = 4344
count = 92
seq_step = 1
(kms_flip:7561) DEBUG: Vblank took 19us
(kms_flip:7561) DEBUG: name = flip
last_ts = 306.545044
last_received_ts = 306.544434
last_seq = 4344
current_ts = 306.561707
current_received_ts = 306.561096
current_seq = 4345
count = 93
seq_step = 1
(kms_flip:7561) DEBUG: Vblank took 19us
(kms_flip:7561) DEBUG: name = flip
last_ts = 306.561707
last_received_ts = 306.561096
last_seq = 4345
current_ts = 306.578400
current_received_ts = 306.577759
current_seq = 4346
count = 94
seq_step = 1
(kms_flip:7561) DEBUG: Vblank took 20us
(kms_flip:7561) DEBUG: name = flip
last_ts = 306.578400
last_received_ts = 306.577759
last_seq = 4346
current_ts = 306.595062
current_received_ts = 306.594421
current_seq = 4347
count = 95
seq_step = 1
(kms_flip:7561) DEBUG: Vblank took 19us
(kms_flip:7561) DEBUG: name = flip
last_ts = 306.595062
last_received_ts = 306.594421
last_seq = 4347
current_ts = 306.611725
current_received_ts = 306.611115
current_seq = 4348
count = 96
seq_step = 1
(kms_flip:7561) DEBUG: Vblank took 19us
(kms_flip:7561) DEBUG: name = flip
last_ts = 306.611725
last_received_ts = 306.611115
last_seq = 4348
current_ts = 306.628387
current_received_ts = 306.627777
current_seq = 4349
count = 97
seq_step = 1
(kms_flip:7561) DEBUG: Vblank took 19us
(kms_flip:7561) DEBUG: name = flip
last_ts = 306.628387
last_received_ts = 306.627777
last_seq = 4349
current_ts = 306.645050
current_received_ts = 306.644440
current_seq = 4350
count = 98
seq_step = 1
(kms_flip:7561) DEBUG: Vblank took 19us
(kms_flip:7561) DEBUG: name = flip
last_ts = 306.645050
last_received_ts = 306.644440
last_seq = 4350
current_ts = 306.661713
current_received_ts = 306.661102
current_seq = 4351
count = 99
seq_step = 1
(kms_flip:7561) DEBUG: Vblank took 20us
(kms_flip:7561) DEBUG: name = flip
last_ts = 306.661713
last_received_ts = 306.661102
last_seq = 4351
current_ts = 306.678406
current_received_ts = 306.677765
current_seq = 4352
count = 100
seq_step = 1
(kms_flip:7561) DEBUG: Vblank took 19us
(kms_flip:7561) DEBUG: name = flip
last_ts = 306.678406
last_received_ts = 306.677765
last_seq = 4352
current_ts = 306.695068
current_received_ts = 306.694427
current_seq = 4353
count = 101
seq_step = 1
(kms_flip:7561) DEBUG: Vblank took 19us
(kms_flip:7561) DEBUG: name = flip
last_ts = 306.695068
last_received_ts = 306.694427
last_seq = 4353
current_ts = 306.711731
current_received_ts = 306.711121
current_seq = 4354
count = 102
seq_step = 1
(kms_flip:7561) DEBUG: Vblank took 19us
(kms_flip:7561) DEBUG: name = flip
last_ts = 306.711731
last_received_ts = 306.711121
last_seq = 4354
current_ts = 306.728394
current_received_ts = 306.727783
current_seq = 4355
count = 103
seq_step = 1
(kms_flip:7561) DEBUG: Vblank took 18us
(kms_flip:7561) DEBUG: name = flip
last_ts = 306.728394
last_received_ts = 306.727783
last_seq = 4355
current_ts = 306.745056
current_received_ts = 306.744446
current_seq = 4356
count = 104
seq_step = 1
(kms_flip:7561) DEBUG: Vblank took 19us
(kms_flip:7561) DEBUG: name = flip
last_ts = 306.745056
last_received_ts = 306.744446
last_seq = 4356
current_ts = 306.761719
current_received_ts = 306.761108
current_seq = 4357
count = 105
seq_step = 1
(kms_flip:7561) DEBUG: Vblank took 19us
(kms_flip:7561) DEBUG: name = flip
last_ts = 306.761719
last_received_ts = 306.761108
last_seq = 4357
current_ts = 306.778412
current_received_ts = 306.777771
current_seq = 4358
count = 106
seq_step = 1
(kms_flip:7561) DEBUG: Vblank took 20us
(kms_flip:7561) DEBUG: name = flip
last_ts = 306.778412
last_received_ts = 306.777771
last_seq = 4358
current_ts = 306.795074
current_received_ts = 306.794464
current_seq = 4359
count = 107
seq_step = 1
(kms_flip:7561) DEBUG: Vblank took 19us
(kms_flip:7561) DEBUG: name = flip
last_ts = 306.795074
last_received_ts = 306.794464
last_seq = 4359
current_ts = 306.811737
current_received_ts = 306.811127
current_seq = 4360
count = 108
seq_step = 1
(kms_flip:7561) DEBUG: Vblank took 19us
(kms_flip:7561) DEBUG: name = flip
last_ts = 306.811737
last_received_ts = 306.811127
last_seq = 4360
current_ts = 306.828400
current_received_ts = 306.827789
current_seq = 4361
count = 109
seq_step = 1
(kms_flip:7561) DEBUG: Vblank took 19us
(kms_flip:7561) DEBUG: name = flip
last_ts = 306.828400
last_received_ts = 306.827789
last_seq = 4361
current_ts = 306.845062
current_received_ts = 306.844452
current_seq = 4362
count = 110
seq_step = 1
(kms_flip:7561) DEBUG: Vblank took 19us
(kms_flip:7561) DEBUG: name = flip
last_ts = 306.845062
last_received_ts = 306.844452
last_seq = 4362
current_ts = 306.861755
current_received_ts = 306.861115
current_seq = 4363
count = 111
seq_step = 1
(kms_flip:7561) DEBUG: Vblank took 20us
(kms_flip:7561) DEBUG: name = flip
last_ts = 306.861755
last_received_ts = 306.861115
last_seq = 4363
current_ts = 306.878418
current_received_ts = 306.877777
current_seq = 4364
count = 112
seq_step = 1
(kms_flip:7561) DEBUG: Vblank took 19us
(kms_flip:7561) DEBUG: name = flip
last_ts = 306.878418
last_received_ts = 306.877777
last_seq = 4364
current_ts = 306.895081
current_received_ts = 306.894592
current_seq = 4365
count = 113
seq_step = 1
(kms_flip:7561) DEBUG: Vblank took 33us
(kms_flip:7561) DEBUG: name = flip
last_ts = 306.895081
last_received_ts = 306.894592
last_seq = 4365
current_ts = 306.911743
current_received_ts = 306.911194
current_seq = 4366
count = 114
seq_step = 1
(kms_flip:7561) DEBUG: Vblank took 34us
(kms_flip:7561) DEBUG: name = flip
last_ts = 306.911743
last_received_ts = 306.911194
last_seq = 4366
current_ts = 306.928406
current_received_ts = 306.927795
current_seq = 4367
count = 115
seq_step = 1
(kms_flip:7561) DEBUG: Vblank took 20us
(kms_flip:7561) DEBUG: name = flip
last_ts = 306.928406
last_received_ts = 306.927795
last_seq = 4367
current_ts = 306.945068
current_received_ts = 306.944427
current_seq = 4368
count = 116
seq_step = 1
(kms_flip:7561) DEBUG: Vblank took 193us
(kms_flip:7561) DEBUG: name = flip
last_ts = 306.945068
last_received_ts = 306.944427
last_seq = 4368
current_ts = 306.961731
current_received_ts = 306.961121
current_seq = 4369
count = 117
seq_step = 1
(kms_flip:7561) DEBUG: Vblank took 196us
(kms_flip:7561) DEBUG: name = flip
last_ts = 306.961731
last_received_ts = 306.961121
last_seq = 4369
current_ts = 306.978424
current_received_ts = 306.977783
current_seq = 4370
count = 118
seq_step = 1
(kms_flip:7561) DEBUG: Vblank took 12us
(kms_flip:7561) DEBUG: name = flip
last_ts = 306.978424
last_received_ts = 306.977783
last_seq = 4370
current_ts = 306.995087
current_received_ts = 306.994446
current_seq = 4371
count = 119
seq_step = 1
(kms_flip:7561) DEBUG: Vblank took 189us
(kms_flip:7561) DEBUG: name = flip
last_ts = 306.995087
last_received_ts = 306.994446
last_seq = 4371
current_ts = 307.011749
current_received_ts = 307.011108
current_seq = 4372
count = 120
seq_step = 1
(kms_flip:7561) DEBUG: Vblank took 11us
(kms_flip:7561) DEBUG: name = flip
last_ts = 307.011749
last_received_ts = 307.011108
last_seq = 4372
current_ts = 307.028412
current_received_ts = 307.027771
current_seq = 4373
count = 121
seq_step = 1
(kms_flip:7561) DEBUG: Vblank took 12us
(kms_flip:7561) DEBUG: name = flip
last_ts = 307.028412
last_received_ts = 307.027771
last_seq = 4373
current_ts = 307.045074
current_received_ts = 307.044434
current_seq = 4374
count = 122
seq_step = 1
(kms_flip:7561) DEBUG: Vblank took 198us
(kms_flip:7561) DEBUG: name = flip
last_ts = 307.045074
last_received_ts = 307.044434
last_seq = 4374
current_ts = 307.061737
current_received_ts = 307.061127
current_seq = 4375
count = 123
seq_step = 1
(kms_flip:7561) DEBUG: Vblank took 14us
(kms_flip:7561) DEBUG: name = flip
last_ts = 307.061737
last_received_ts = 307.061127
last_seq = 4375
current_ts = 307.078430
current_received_ts = 307.077820
current_seq = 4376
count = 124
seq_step = 1
(kms_flip:7561) DEBUG: Vblank took 547us
(kms_flip:7561) CRITICAL: Test assertion failure function run_test_step, file ../tests/kms_flip.c:928:
(kms_flip:7561) CRITICAL: Failed assertion: end - start < 500
(kms_flip:7561) CRITICAL: Last errno: 4, Interrupted system call
(kms_flip:7561) igt_core-INFO: Stack trace:
(kms_flip:7561) igt_core-INFO:   #0 ../lib/igt_core.c:2075 __igt_fail_assert()
(kms_flip:7561) igt_core-INFO:   #1 ../tests/kms_flip.c:923 run_test_on_crtc_set.constprop.0()
(kms_flip:7561) igt_core-INFO:   #2 ../tests/kms_flip.c:1974 run_pair()
(kms_flip:7561) igt_core-INFO:   #3 ../tests/kms_flip.c:2165 __igt_unique____real_main2045()
(kms_flip:7561) igt_core-INFO:   #4 ../tests/kms_flip.c:2045 main()
(kms_flip:7561) igt_core-INFO:   #5 [__libc_init_first+0x8a]
(kms_flip:7561) igt_core-INFO:   #6 [__libc_start_main+0x8b]
(kms_flip:7561) igt_core-INFO:   #7 [_start+0x25]
****  END  ****
Dynamic subtest AD-HDMI-A6-DP4: FAIL (2.578s)
Dmesg
<6> [304.515916] [IGT] kms_flip: starting dynamic subtest AD-HDMI-A6-DP4
<7> [304.517407] xe 0000:03:00.0: [drm:drm_mode_addfb2] [FB:312]
<7> [304.518025] xe 0000:03:00.0: [drm:drm_mode_addfb2] [FB:314]
<7> [304.555105] xe 0000:03:00.0: [drm:drm_mode_setcrtc] [CRTC:88:pipe A]
<7> [304.555161] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:88:pipe A] fastset requirement not met in hw.enable (expected yes, found no)
<7> [304.555279] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:88:pipe A] fastset requirement not met in hw.active (expected yes, found no)
<7> [304.555368] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:88:pipe A] fastset requirement not met in cpu_transcoder (expected 0, found -1)
<7> [304.555453] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:88:pipe A] fastset requirement not met in lane_count (expected 4, found 0)
<7> [304.555536] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:88:pipe A] fastset requirement not met in output_types (expected 0x00000040, found 0x00000000)
<7> [304.555618] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:88:pipe A] fastset requirement not met in framestart_delay (expected 1, found 0)
<7> [304.555699] xe 0000:03:00.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> [304.555780] xe 0000:03:00.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> [304.555860] xe 0000:03:00.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> [304.555940] xe 0000:03:00.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> [304.556028] xe 0000:03:00.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> [304.556112] xe 0000:03:00.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> [304.556195] xe 0000:03:00.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> [304.556275] xe 0000:03:00.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> [304.556354] xe 0000:03:00.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> [304.556433] xe 0000:03:00.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> [304.556513] xe 0000:03:00.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> [304.556592] xe 0000:03:00.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> [304.556673] xe 0000:03:00.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> [304.556750] xe 0000:03:00.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> [304.556827] xe 0000:03:00.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> [304.556905] xe 0000:03:00.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> [304.556987] xe 0000:03:00.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> [304.557064] xe 0000:03:00.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> [304.557141] xe 0000:03:00.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> [304.557223] xe 0000:03:00.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> [304.557301] xe 0000:03:00.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> [304.557380] xe 0000:03:00.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> [304.557457] xe 0000:03:00.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> [304.557535] xe 0000:03:00.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> [304.557613] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:88:pipe A] fastset requirement not met in pixel_multiplier (expected 1, found 0)
<7> [304.557691] xe 0000:03:00.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> [304.557770] xe 0000:03:00.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> [304.557848] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:88:pipe A] fastset requirement not met in has_hdmi_sink (expected yes, found no)
<7> [304.557927] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:88:pipe A] fastset requirement not met in has_infoframe (expected yes, found no)
<7> [304.558017] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:88:pipe A] fastset requirement not met in pipe_bpp (expected 24, found 0)
<7> [304.558100] xe 0000:03:00.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> [304.558178] xe 0000:03:00.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> [304.558257] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:88:pipe A] fastset requirement not met in port_clock (expected 148500, found 0)
<7> [304.558336] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:88:pipe A] fastset requirement not met in infoframes.enable (expected 0x00000071, found 0x00000000)
<7> [304.558414] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:88:pipe A] fastset requirement not met in avi infoframe
<7> [304.558493] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] expected:
<7> [304.558572] xe 0000:03:00.0: HDMI infoframe: Auxiliary Video Information (AVI), version 2, length 13
<7> [304.558573] xe 0000:03:00.0: colorspace: RGB
<7> [304.558574] xe 0000:03:00.0: scan mode: Underscan
<7> [304.558575] xe 0000:03:00.0: colorimetry: No Data
<7> [304.558576] xe 0000:03:00.0: picture aspect: 16:9
<7> [304.558577] xe 0000:03:00.0: active aspect: Same as Picture
<7> [304.558578] xe 0000:03:00.0: itc: No Data
<7> [304.558579] xe 0000:03:00.0: extended colorimetry: xvYCC 601
<7> [304.558580] xe 0000:03:00.0: quantization range: Default
<7> [304.558581] xe 0000:03:00.0: nups: Unknown Non-uniform Scaling
<7> [304.558582] xe 0000:03:00.0: video code: 16
<7> [304.558583] xe 0000:03:00.0: ycc quantization range: Full
<7> [304.558584] xe 0000:03:00.0: hdmi content type: Graphics
<7> [304.558585] xe 0000:03:00.0: pixel repeat: 0
<7> [304.558585] xe 0000:03:00.0: bar top 0, bottom 0, left 0, right 0
<7> [304.558587] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] found:
<7> [304.558667] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:88:pipe A] fastset requirement not met in spd infoframe
<7> [304.558746] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] expected:
<7> [304.558823] xe 0000:03:00.0: HDMI infoframe: Source Product Description (SPD), version 1, length 25
<7> [304.558824] xe 0000:03:00.0: vendor: Intel
<7> [304.558825] xe 0000:03:00.0: product: Discrete gfx
<7> [304.558826] xe 0000:03:00.0: source device information: PC General (0x9)
<7> [304.558828] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] found:
<7> [304.558906] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:88:pipe A] fastset requirement not met in hdmi infoframe
<7> [304.558987] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] expected:
<7> [304.559065] xe 0000:03:00.0: HDMI infoframe: Vendor, version 1, length 4
<7> [304.559067] xe 0000:03:00.0: empty frame
<7> [304.559068] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] found:
<7> [304.559147] xe 0000:03:00.0: [drm:intel_atomic_check [xe]] [CRTC:88:pipe A] fastset requirement not met, forcing full modeset
<7> [304.559239] xe 0000:03:00.0: [drm:skl_compute_wm [xe]] Enabled dbuf slices 0xf -> 0xd (total dbuf slices 0xf), mbus joined? no->no
<7> [304.559314] xe 0000:03:00.0: [drm:skl_compute_wm [xe]] [CRTC:88:pipe A] dbuf slices 0x3 -> 0x0, ddb (0 - 2048) -> (0 - 0), active pipes 0x5 -> 0x4
<7> [304.559402] xe 0000:03:00.0: [drm:skl_compute_wm [xe]] [PLANE:83:cursor A] ddb (1963 - 2048) -> ( 0 - 0), size 85 -> 0
<7> [304.559491] xe 0000:03:00.0: [drm:intel_cdclk_atomic_check [xe]] [CRTC:88:pipe A] min cdclk: 192000 kHz -> 0 kHz
<7> [304.559580] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] [CRTC:88:pipe A] enable: no [modeset]
<7> [304.559663] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] [PLANE:33:plane 1A] fb: [NOFB], visible: no
<7> [304.559745] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] [PLANE:43:plane 2A] fb: [NOFB], visible: no
<7> [304.559828] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] [PLANE:53:plane 3A] fb: [NOFB], visible: no
<7> [304.559908] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] [PLANE:63:plane 4A] fb: [NOFB], visible: no
<7> [304.559991] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] [PLANE:73:plane 5A] fb: [NOFB], visible: no
<7> [304.560074] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] [PLANE:83:cursor A] fb: [NOFB], visible: no
<7> [304.560175] xe 0000:03:00.0: [drm:intel_audio_codec_disable [xe]] [CONNECTOR:281:HDMI-A-6][ENCODER:280:DDI B/PHY B] Disable audio codec on [CRTC:88:pipe A]
<7> [304.593320] xe 0000:03:00.0: [drm:intel_audio_component_get_eld [xe]] Not valid for port B
<7> [304.593873] xe 0000:03:00.0: [drm:intel_disable_transcoder [xe]] disabling pipe A
<7> [304.614971] xe 0000:03:00.0: [drm:intel_power_well_disable [xe]] disabling DDI_IO_B
<7> [304.615580] xe 0000:03:00.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:261:DDI A/PHY A]
<7> [304.616042] xe 0000:03:00.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:263:DP-MST A]
<7> [304.616467] xe 0000:03:00.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:264:DP-MST B]
<7> [304.616879] xe 0000:03:00.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:265:DP-MST C]
<7> [304.617313] xe 0000:03:00.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:266:DP-MST D]
<7> [304.617714] xe 0000:03:00.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:280:DDI B/PHY B]
<7> [304.618140] xe 0000:03:00.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:284:DDI C/PHY C]
<7> [304.618540] xe 0000:03:00.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:286:DP-MST A]
<7> [304.618929] xe 0000:03:00.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:287:DP-MST B]
<7> [304.619346] xe 0000:03:00.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:288:DP-MST C]
<7> [304.619734] xe 0000:03:00.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:289:DP-MST D]
<7> [304.620143] xe 0000:03:00.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:296:DDI D/PHY D]
<7> [304.620546] xe 0000:03:00.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:298:DP-MST A]
<7> [304.620939] xe 0000:03:00.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:299:DP-MST B]
<7> [304.621357] xe 0000:03:00.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:300:DP-MST C]
<7> [304.621771] xe 0000:03:00.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:301:DP-MST D]
<7> [304.622195] xe 0000:03:00.0: [drm:verify_connector_state [xe]] [CONNECTOR:281:HDMI-A-6]
<7> [304.622624] xe 0000:03:00.0: [drm:gen9_dbuf_slices_update [xe]] Updating dbuf slices to 0xd
<7> [304.623164] xe 0000:03:00.0: [drm:intel_power_well_disable [xe]] disabling PW_A
<7> [304.623679] xe 0000:03:00.0: [drm:intel_modeset_verify_crtc [xe]] [CRTC:88:pipe A]
<7> [304.624209] xe 0000:03:00.0: [drm:drm_mode_setcrtc] [CRTC:145:pipe B]
<7> [304.624545] xe 0000:03:00.0: [drm:drm_mode_setcrtc] [CRTC:202:pipe C]
<7> [304.624780] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:202:pipe C] fastset requirement not met in hw.enable (expected yes, found no)
<7> [304.625243] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:202:pipe C] fastset requirement not met in hw.active (expected yes, found no)
<7> [304.625684] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:202:pipe C] fastset requirement not met in cpu_transcoder (expected 2, found -1)
<7> [304.626065] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:202:pipe C] fastset requirement not met in lane_count (expected 4, found 0)
<7> [304.626440] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:202:pipe C] fastset requirement not met in dp_m_n (expected tu 64 data 5767168/8388608 link 480597/524288, found tu 0, data 0/0 link 0/0)
<7> [304.626792] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:202:pipe C] fastset requirement not met in output_types (expected 0x00000080, found 0x00000000)
<7> [304.627141] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:202:pipe C] fastset requirement not met in framestart_delay (expected 1, found 0)
<7> [304.627465] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:202:pipe C] fastset requirement not met in hw.pipe_mode.crtc_hdisplay (expected 1920, found 0)
<7> [304.627756] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:202:pipe C] fastset requirement not met in hw.pipe_mode.crtc_htotal (expected 2200, found 0)
<7> [304.628053] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:202:pipe C] fastset requirement not met in hw.pipe_mode.crtc_hblank_start (expected 1920, found 0)
<7> [304.628332] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:202:pipe C] fastset requirement not met in hw.pipe_mode.crtc_hblank_end (expected 2200, found 0)
<7> [304.628599] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:202:pipe C] fastset requirement not met in hw.pipe_mode.crtc_hsync_start (expected 2008, found 0)
<7> [304.628856] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:202:pipe C] fastset requirement not met in hw.pipe_mode.crtc_hsync_end (expected 2052, found 0)
<7> [304.629134] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:202:pipe C] fastset requirement not met in hw.pipe_mode.crtc_vdisplay (expected 1080, found 0)
<7> [304.629393] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:202:pipe C] fastset requirement not met in hw.pipe_mode.crtc_vblank_start (expected 1080, found 0)
<7> [304.629633] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:202:pipe C] fastset requirement not met in hw.pipe_mode.crtc_vsync_start (expected 1084, found 0)
<7> [304.629862] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:202:pipe C] fastset requirement not met in hw.pipe_mode.crtc_vsync_end (expected 1089, found 0)
<7> [304.630098] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:202:pipe C] fastset requirement not met in hw.pipe_mode.crtc_vtotal (expected 1125, found 0)
<7> [304.630310] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:202:pipe C] fastset requirement not met in hw.pipe_mode.crtc_vblank_end (expected 1125, found 0)
<7> [304.630520] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:202:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_hdisplay (expected 1920, found 0)
<7> [304.630725] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:202:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_htotal (expected 2200, found 0)
<7> [304.630928] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:202:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_hblank_start (expected 1920, found 0)
<7> [304.631143] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:202:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_hblank_end (expected 2200, found 0)
<7> [304.631331] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:202:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_hsync_start (expected 2008, found 0)
<7> [304.631511] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:202:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_hsync_end (expected 2052, found 0)
<7> [304.631690] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:202:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_vdisplay (expected 1080, found 0)
<7> [304.631869] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:202:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_vblank_start (expected 1080, found 0)
<7> [304.632058] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:202:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_vsync_start (expected 1084, found 0)
<7> [304.632236] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:202:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_vsync_end (expected 1089, found 0)
<7> [304.632396] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:202:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_vtotal (expected 1125, found 0)
<7> [304.632553] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:202:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_vblank_end (expected 1125, found 0)
<7> [304.632705] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:202:pipe C] fastset requirement not met in pixel_multiplier (expected 1, found 0)
<7> [304.632859] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:202:pipe C] fastset requirement not met in hw.adjusted_mode.flags (1) (expected 1, found 0)
<7> [304.633019] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:202:pipe C] fastset requirement not met in hw.adjusted_mode.flags (4) (expected 4, found 0)
<7> [304.633174] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:202:pipe C] fastset requirement not met in enhanced_framing (expected yes, found no)
<7> [304.633326] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:202:pipe C] fastset requirement not met in pipe_bpp (expected 24, found 0)
<7> [304.633468] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:202:pipe C] fastset requirement not met in hw.pipe_mode.crtc_clock (expected 148500, found 0)
<7> [304.633607] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:202:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_clock (expected 148500, found 0)
<7> [304.633742] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:202:pipe C] fastset requirement not met in port_clock (expected 162000, found 0)
<7> [304.633879] xe 0000:03:00.0: [drm:intel_atomic_check [xe]] [CRTC:202:pipe C] fastset requirement not met, forcing full modeset
<7> [304.634088] xe 0000:03:00.0: [drm:skl_compute_wm [xe]] Enabled dbuf slices 0xd -> 0x1 (total dbuf slices 0xf), mbus joined? no->no
<7> [304.634280] xe 0000:03:00.0: [drm:skl_compute_wm [xe]] [CRTC:202:pipe C] dbuf slices 0xc -> 0x0, ddb (0 - 2048) -> (0 - 0), active pipes 0x4 -> 0x0
<7> [304.634430] xe 0000:03:00.0: [drm:skl_compute_wm [xe]] [PLANE:197:cursor C] ddb (1963 - 2048) -> ( 0 - 0), size 85 -> 0
<7> [304.634570] xe 0000:03:00.0: [drm:intel_cdclk_atomic_check [xe]] [CRTC:202:pipe C] min cdclk: 192000 kHz -> 0 kHz
<7> [304.634706] xe 0000:03:00.0: [drm:intel_cdclk_atomic_check [xe]] Can change cdclk via squashing
<7> [304.634837] xe 0000:03:00.0: [drm:intel_cdclk_atomic_check [xe]] New cdclk calculated to be logical 163200 kHz, actual 163200 kHz
<7> [304.634964] xe 0000:03:00.0: [drm:intel_cdclk_atomic_check [xe]] New voltage level calculated to be logical 0, actual 0
<7> [304.635121] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] [CRTC:202:pipe C] enable: no [modeset]
<7> [304.635249] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] [PLANE:147:plane 1C] fb: [NOFB], visible: no
<7> [304.635364] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] [PLANE:157:plane 2C] fb: [NOFB], visible: no
<7> [304.635476] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] [PLANE:167:plane 3C] fb: [NOFB], visible: no
<7> [304.635585] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] [PLANE:177:plane 4C] fb: [NOFB], visible: no
<7> [304.635692] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] [PLANE:187:plane 5C] fb: [NOFB], visible: no
<7> [304.635796] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] [PLANE:197:cursor C] fb: [NOFB], visible: no
<7> [304.635936] xe 0000:03:00.0: [drm:intel_audio_codec_disable [xe]] [CONNECTOR:285:DP-4][ENCODER:284:DDI C/PHY C] Disable audio codec on [CRTC:202:pipe C]
<7> [304.668476] xe 0000:03:00.0: [drm:intel_audio_component_get_eld [xe]] Not valid for port C
<7> [304.669344] xe 0000:03:00.0: [drm:intel_disable_transcoder [xe]] disabling pipe C
<7> [304.690786] xe 0000:03:00.0: [drm:intel_power_well_disable [xe]] disabling DDI_IO_C
<7> [304.691447] xe 0000:03:00.0: [drm:intel_power_well_disable [xe]] disabling AUX_C
<7> [304.692008] xe 0000:03:00.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:261:DDI A/PHY A]
<7> [304.692466] xe 0000:03:00.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:263:DP-MST A]
<7> [304.692901] xe 0000:03:00.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:264:DP-MST B]
<7> [304.693381] xe 0000:03:00.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:265:DP-MST C]
<7> [304.693813] xe 0000:03:00.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:266:DP-MST D]
<7> [304.694265] xe 0000:03:00.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:280:DDI B/PHY B]
<7> [304.694662] xe 0000:03:00.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:284:DDI C/PHY C]
<7> [304.695086] xe 0000:03:00.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:286:DP-MST A]
<7> [304.695484] xe 0000:03:00.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:287:DP-MST B]
<7> [304.695890] xe 0000:03:00.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:288:DP-MST C]
<7> [304.696316] xe 0000:03:00.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:289:DP-MST D]
<7> [304.696708] xe 0000:03:00.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:296:DDI D/PHY D]
<7> [304.697108] xe 0000:03:00.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:298:DP-MST A]
<7> [304.697492] xe 0000:03:00.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:299:DP-MST B]
<7> [304.697880] xe 0000:03:00.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:300:DP-MST C]
<7> [304.698283] xe 0000:03:00.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:301:DP-MST D]
<7> [304.698661] xe 0000:03:00.0: [drm:verify_connector_state [xe]] [CONNECTOR:285:DP-4]
<7> [304.699127] xe 0000:03:00.0: [drm:gen9_dbuf_slices_update [xe]] Updating dbuf slices to 0x1
<7> [304.699698] xe 0000:03:00.0: [drm:intel_power_well_disable [xe]] disabling PW_C
<7> [304.700206] xe 0000:03:00.0: [drm:intel_power_well_disable [xe]] disabling PW_2
<7> [304.700707] xe 0000:03:00.0: [drm:intel_modeset_verify_crtc [xe]] [CRTC:202:pipe C]
<7> [304.701225] xe 0000:03:00.0: [drm:intel_set_cdclk [xe]] Post changing CDCLK to 163200 kHz, VCO 1305600 kHz, ref 38400 kHz, bypass 19200 kHz, voltage level 0
<7> [304.701694] xe 0000:03:00.0: [drm:intel_audio_cdclk_change_post.part.0 [xe]] aud_ts_cdclk set to M=60, N=408
<7> [304.702227] xe 0000:03:00.0: [drm:drm_mode_setcrtc] [CRTC:259:pipe D]
<7> [304.702533] xe 0000:03:00.0: [drm:drm_mode_setcrtc] [CRTC:259:pipe D]
<7> [304.702597] xe 0000:03:00.0: [drm:drm_mode_setcrtc] [CONNECTOR:285:DP-4]
<7> [304.702807] xe 0000:03:00.0: [drm:intel_atomic_check [xe]] [CONNECTOR:285:DP-4] Limiting display bpp to 24 (EDID bpp 48, max requested bpp 24, max platform bpp 36)
<7> [304.703235] xe 0000:03:00.0: [drm:intel_dp_compute_config_limits [xe]] [ENCODER:284:DDI C/PHY C][CRTC:259:pipe D] DP link limits: pixel clock 148500 kHz DSC off max lanes 4 max rate 540000 max pipe_bpp 24 max link_bpp 24.0000
<7> [304.703586] xe 0000:03:00.0: [drm:intel_dp_compute_link_config [xe]] DP lane count 4 clock 162000 bpp input 24 compressed 0.0000 link rate required 445500 available 648000
<7> [304.703940] xe 0000:03:00.0: [drm:intel_atomic_check [xe]] [CRTC:259:pipe D] hw max bpp: 24, pipe bpp: 24, dithering: 0
<7> [304.704363] xe 0000:03:00.0: [drm:intel_ddi_compute_config_late [xe]] [ENCODER:284:DDI C/PHY C] [CRTC:259:pipe D]
<7> [304.704686] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:259:pipe D] fastset requirement not met in hw.enable (expected no, found yes)
<7> [304.705021] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:259:pipe D] fastset requirement not met in hw.active (expected no, found yes)
<7> [304.705313] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:259:pipe D] fastset requirement not met in cpu_transcoder (expected -1, found 3)
<7> [304.705592] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:259:pipe D] fastset requirement not met in lane_count (expected 0, found 4)
<7> [304.705855] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:259:pipe D] fastset requirement not met in dp_m_n (expected tu 0 data 0/0 link 0/0, found tu 64, data 5767168/8388608 link 480597/524288)
<7> [304.706127] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:259:pipe D] fastset requirement not met in output_types (expected 0x00000000, found 0x00000080)
<7> [304.706366] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:259:pipe D] fastset requirement not met in framestart_delay (expected 0, found 1)
<7> [304.706598] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:259:pipe D] fastset requirement not met in hw.pipe_mode.crtc_hdisplay (expected 0, found 1920)
<7> [304.706821] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:259:pipe D] fastset requirement not met in hw.pipe_mode.crtc_htotal (expected 0, found 2200)
<7> [304.707053] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:259:pipe D] fastset requirement not met in hw.pipe_mode.crtc_hblank_start (expected 0, found 1920)
<7> [304.707271] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:259:pipe D] fastset requirement not met in hw.pipe_mode.crtc_hblank_end (expected 0, found 2200)
<7> [304.707472] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:259:pipe D] fastset requirement not met in hw.pipe_mode.crtc_hsync_start (expected 0, found 2008)
<7> [304.707673] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:259:pipe D] fastset requirement not met in hw.pipe_mode.crtc_hsync_end (expected 0, found 2052)
<7> [304.707875] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:259:pipe D] fastset requirement not met in hw.pipe_mode.crtc_vdisplay (expected 0, found 1080)
<7> [304.708081] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:259:pipe D] fastset requirement not met in hw.pipe_mode.crtc_vblank_start (expected 0, found 1080)
<7> [304.708261] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:259:pipe D] fastset requirement not met in hw.pipe_mode.crtc_vsync_start (expected 0, found 1084)
<7> [304.708443] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:259:pipe D] fastset requirement not met in hw.pipe_mode.crtc_vsync_end (expected 0, found 1089)
<7> [304.708622] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:259:pipe D] fastset requirement not met in hw.pipe_mode.crtc_vtotal (expected 0, found 1125)
<7> [304.708796] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:259:pipe D] fastset requirement not met in hw.pipe_mode.crtc_vblank_end (expected 0, found 1125)
<7> [304.708977] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:259:pipe D] fastset requirement not met in hw.adjusted_mode.crtc_hdisplay (expected 0, found 1920)
<7> [304.709160] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:259:pipe D] fastset requirement not met in hw.adjusted_mode.crtc_htotal (expected 0, found 2200)
<7> [304.709324] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:259:pipe D] fastset requirement not met in hw.adjusted_mode.crtc_hblank_start (expected 0, found 1920)
<7> [304.709482] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:259:pipe D] fastset requirement not met in hw.adjusted_mode.crtc_hblank_end (expected 0, found 2200)
<7> [304.709638] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:259:pipe D] fastset requirement not met in hw.adjusted_mode.crtc_hsync_start (expected 0, found 2008)
<7> [304.709786] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:259:pipe D] fastset requirement not met in hw.adjusted_mode.crtc_hsync_end (expected 0, found 2052)
<7> [304.709932] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:259:pipe D] fastset requirement not met in hw.adjusted_mode.crtc_vdisplay (expected 0, found 1080)
<7> [304.710089] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:259:pipe D] fastset requirement not met in hw.adjusted_mode.crtc_vblank_start (expected 0, found 1080)
<7> [304.710232] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:259:pipe D] fastset requirement not met in hw.adjusted_mode.crtc_vsync_start (expected 0, found 1084)
<7> [304.710368] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:259:pipe D] fastset requirement not met in hw.adjusted_mode.crtc_vsync_end (expected 0, found 1089)
<7> [304.710505] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:259:pipe D] fastset requirement not met in hw.adjusted_mode.crtc_vtotal (expected 0, found 1125)
<7> [304.710636] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:259:pipe D] fastset requirement not met in hw.adjusted_mode.crtc_vblank_end (expected 0, found 1125)
<7> [304.710768] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:259:pipe D] fastset requirement not met in pixel_multiplier (expected 0, found 1)
<7> [304.710894] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:259:pipe D] fastset requirement not met in hw.adjusted_mode.flags (1) (expected 0, found 1)
<7> [304.711031] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:259:pipe D] fastset requirement not met in hw.adjusted_mode.flags (4) (expected 0, found 4)
<7> [304.711158] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:259:pipe D] fastset requirement not met in enhanced_framing (expected no, found yes)
<7> [304.711281] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:259:pipe D] fastset requirement not met in pipe_bpp (expected 0, found 24)
<7> [304.711395] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:259:pipe D] fastset requirement not met in hw.pipe_mode.crtc_clock (expected 0, found 148500)
<7> [304.711509] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:259:pipe D] fastset requirement not met in hw.adjusted_mode.crtc_clock (expected 0, found 148500)
<7> [304.711621] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:259:pipe D] fastset requirement not met in port_clock (expected 0, found 162000)
<7> [304.711733] xe 0000:03:00.0: [drm:intel_atomic_check [xe]] [CRTC:259:pipe D] fastset requirement not met, forcing full modeset
<7> [304.711887] xe 0000:03:00.0: [drm:skl_compute_wm [xe]] Enabled dbuf slices 0x1 -> 0xd (total dbuf slices 0xf), mbus joined? no->no
<7> [304.712080] xe 0000:03:00.0: [drm:skl_compute_wm [xe]] [CRTC:259:pipe D] dbuf slices 0x0 -> 0xc, ddb (0 - 0) -> (0 - 2048), active pipes 0x0 -> 0x8
<7> [304.712219] xe 0000:03:00.0: [drm:skl_compute_wm [xe]] [PLANE:204:plane 1D] ddb ( 0 - 0) -> ( 0 - 1963), size 0 -> 1963
<7> [304.712321] xe 0000:03:00.0: [drm:skl_compute_wm [xe]] [PLANE:254:cursor D] ddb ( 0 - 0) -> (1963 - 2048), size 0 -> 85
<7> [304.712415] xe 0000:03:00.0: [drm:skl_print_plane_changes [xe]] [PLANE:204:plane 1D] level wm0, wm1, wm2, wm3, wm4, wm5, wm6, wm7, twm, swm, stwm -> *wm0,*wm1,*wm2,*wm3,*wm4,*wm5,*wm6,*wm7,*twm, swm, stwm
<7> [304.712504] xe 0000:03:00.0: [drm:skl_print_plane_changes [xe]] [PLANE:204:plane 1D] lines 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0 -> 4, 4, 4, 5, 9, 11, 17, 25, 0, 0, 0
<7> [304.712591] xe 0000:03:00.0: [drm:skl_print_plane_changes [xe]] [PLANE:204:plane 1D] blocks 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0 -> 62, 62, 62, 78, 139, 169, 261, 383, 137, 0, 0
<7> [304.712673] xe 0000:03:00.0: [drm:skl_print_plane_changes [xe]] [PLANE:204:plane 1D] min_ddb 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0 -> 123, 123, 123, 184, 245, 245, 367, 489, 138, 0, 0
<7> [304.712763] xe 0000:03:00.0: [drm:intel_bw_atomic_check [xe]] [CRTC:259:pipe D] data rate 594000 num active planes 1
<7> [304.712866] xe 0000:03:00.0: [drm:intel_bw_atomic_check [xe]] QGV point 0: max bw 50000 required 624
<7> [304.712965] xe 0000:03:00.0: [drm:intel_bw_atomic_check [xe]] No SAGV, using single QGV point mask 0x1
<7> [304.713090] xe 0000:03:00.0: [drm:intel_cdclk_atomic_check [xe]] [CRTC:259:pipe D] min cdclk: 0 kHz -> 192000 kHz
<7> [304.713202] xe 0000:03:00.0: [drm:intel_cdclk_update_dbuf_bw_min_cdclk [xe]] dbuf bandwidth min cdclk: 18563 kHz -> 9282 kHz
<7> [304.713294] xe 0000:03:00.0: [drm:intel_cdclk_atomic_check [xe]] Can change cdclk via squashing
<7> [304.713385] xe 0000:03:00.0: [drm:intel_cdclk_atomic_check [xe]] New cdclk calculated to be logical 204000 kHz, actual 204000 kHz
<7> [304.713474] xe 0000:03:00.0: [drm:intel_cdclk_atomic_check [xe]] New voltage level calculated to be logical 0, actual 0
<7> [304.713561] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] [CRTC:259:pipe D] enable: yes [modeset]
<7> [304.713650] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] active: yes, output_types: DP (0x80), output format: RGB, sink format: RGB
<7> [304.713736] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] cpu_transcoder: D, pipe bpp: 24, dithering: 0
<7> [304.713817] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] MST master transcoder: <invalid>
<7> [304.713897] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] port sync: master transcoder: <invalid>, slave transcoder bitmask = 0x0
<7> [304.713984] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] joiner: no, pipes: 0x0
<7> [304.714064] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] splitter: disabled, link count 0, overlap 0
<7> [304.714145] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] dp m_n: lanes: 4; data_m: 5767168, data_n: 8388608, link_m: 480597, link_n: 524288, tu: 64
<7> [304.714225] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] dp m2_n2: lanes: 4; data_m: 0, data_n: 0, link_m: 0, link_n: 0, tu: 0
<7> [304.714301] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] fec: disabled, enhanced framing: enabled
<7> [304.714372] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] sdp split: disabled
<7> [304.714444] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] psr: disabled, selective update: disabled, panel replay: disabled, selective fetch: disabled
<7> [304.714515] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] minimum HBlank: 0
<7> [304.714586] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] audio: 1, infoframes: 0, infoframes enabled: 0x0
<7> [304.714658] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] ELD: 10 00 09 00 68 36 00 01 00 00 00 00 00 00 00 00
<7> [304.714732] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] ELD: 61 a4 9a 00 44 50 46 39 30 34 33 35 09 07 07 11
<7> [304.714804] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] ELD: 17 50 51 07 00 00 00 00
<7> [304.714875] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] scanline offset: 1
<7> [304.714946] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] framestart delay: 1, MSA timing delay: 0, set context latency: 0
<7> [304.715023] xe 0000:03:00.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> [304.715099] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] vrr: vmin vblank: 1080, vmax vblank: 1080, vmin vtotal: 1125, vmax vtotal: 1125
<7> [304.715169] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] requested mode: "1920x1080": 60 148500 1920 2008 2052 2200 1080 1084 1089 1125 0x48 0x5
<7> [304.715241] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] adjusted mode: "1920x1080": 60 148500 1920 2008 2052 2200 1080 1084 1089 1125 0x48 0x5
<7> [304.715313] xe 0000:03:00.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> [304.715385] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] pipe mode: "1920x1080": 60 148500 1920 2008 2052 2200 1080 1084 1089 1125 0x40 0x5
<7> [304.715457] xe 0000:03:00.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> [304.715528] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] port clock: 162000, pipe src: 1920x1080+0+0, pixel rate 148500, min cdclk 192000
<7> [304.715601] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] linetime: 119, ips linetime: 0
<7> [304.715672] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] num_scalers: 2, scaler_users: 0x0, scaler_id: -1, scaling_filter: 0
<7> [304.715744] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] pch pfit: 0x0+0+0, disabled, force thru: no
<7> [304.715814] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] ips: 0, double wide: 0, drrs: 0
<7> [304.715885] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] dpll_hw_state: dpll: 0x278d0, dpll_md: 0x18000000, fp0: 0x88228fe, fp1: 0x2a000440
<7> [304.715956] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] csc_mode: 0x0 gamma_mode: 0x0 gamma_enable: 0 csc_enable: 0
<7> [304.716036] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] pre csc lut: 0 entries, post csc lut: 0 entries
<7> [304.716109] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] output csc: pre offsets: 0x0000 0x0000 0x0000
<7> [304.716180] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] output csc: coefficients: 0x0000 0x0000 0x0000
<7> [304.716251] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] output csc: coefficients: 0x0000 0x0000 0x0000
<7> [304.716321] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] output csc: coefficients: 0x0000 0x0000 0x0000
<7> [304.716392] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] output csc: post offsets: 0x0000 0x0000 0x0000
<7> [304.716461] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] pipe csc: pre offsets: 0x0000 0x0000 0x0000
<7> [304.716531] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] pipe csc: coefficients: 0x0000 0x0000 0x0000
<7> [304.716604] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] pipe csc: coefficients: 0x0000 0x0000 0x0000
<7> [304.716675] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] pipe csc: coefficients: 0x0000 0x0000 0x0000
<7> [304.716745] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] pipe csc: post offsets: 0x0000 0x0000 0x0000
<7> [304.716816] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] sharpness strength: 0, sharpness tap size: 0, sharpness enable: 0
<7> [304.716887] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] [PLANE:204:plane 1D] fb: [FB:312] 1920x1080 format = XR24 little-endian (0x34325258) modifier = 0x100000000000009, visible: yes
<7> [304.716959] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] rotation: 0x1, scaler: -1, scaling_filter: 0
<7> [304.717044] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] src: 1920.000000x1080.000000+0.000000+0.000000 dst: 1920x1080+0+0
<7> [304.717115] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] [PLANE:214:plane 2D] fb: [NOFB], visible: no
<7> [304.717185] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] [PLANE:224:plane 3D] fb: [NOFB], visible: no
<7> [304.717255] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] [PLANE:234:plane 4D] fb: [NOFB], visible: no
<7> [304.717326] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] [PLANE:244:plane 5D] fb: [NOFB], visible: no
<7> [304.717395] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] [PLANE:254:cursor D] fb: [NOFB], visible: no
<7> [304.717556] xe 0000:03:00.0: [drm:intel_power_well_enable [xe]] enabling PW_2
<7> [304.717724] xe 0000:03:00.0: [drm:intel_power_well_enable [xe]] enabling PW_D
<7> [304.717866] xe 0000:03:00.0: [drm:intel_set_cdclk [xe]] Pre changing CDCLK to 204000 kHz, VCO 1305600 kHz, ref 38400 kHz, bypass 19200 kHz, voltage level 0
<7> [304.717950] xe 0000:03:00.0: [drm:intel_audio_cdclk_change_post.part.0 [xe]] aud_ts_cdclk set to M=60, N=510
<7> [304.718035] xe 0000:03:00.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:261:DDI A/PHY A]
<7> [304.718106] xe 0000:03:00.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:263:DP-MST A]
<7> [304.718174] xe 0000:03:00.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:264:DP-MST B]
<7> [304.718242] xe 0000:03:00.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:265:DP-MST C]
<7> [304.718308] xe 0000:03:00.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:266:DP-MST D]
<7> [304.718373] xe 0000:03:00.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:280:DDI B/PHY B]
<7> [304.718436] xe 0000:03:00.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:284:DDI C/PHY C]
<7> [304.718498] xe 0000:03:00.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:286:DP-MST A]
<7> [304.718560] xe 0000:03:00.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:287:DP-MST B]
<7> [304.718622] xe 0000:03:00.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:288:DP-MST C]
<7> [304.718684] xe 0000:03:00.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:289:DP-MST D]
<7> [304.718747] xe 0000:03:00.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:296:DDI D/PHY D]
<7> [304.718810] xe 0000:03:00.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:298:DP-MST A]
<7> [304.718872] xe 0000:03:00.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:299:DP-MST B]
<7> [304.718935] xe 0000:03:00.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:300:DP-MST C]
<7> [304.719016] xe 0000:03:00.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:301:DP-MST D]
<7> [304.719083] xe 0000:03:00.0: [drm:gen9_dbuf_slices_update [xe]] Updating dbuf slices to 0xd
<7> [304.719225] xe 0000:03:00.0: [drm:intel_power_well_enable [xe]] enabling AUX_C
<7> [304.720010] xe 0000:03:00.0: [drm:intel_power_well_enable [xe]] enabling DDI_IO_C
<7> [304.721806] xe 0000:03:00.0: [drm:drm_dp_read_dpcd_caps [drm_display_helper]] AUX C/DDI C/PHY C: DPCD: 12 14 c4 01 01 15 01 81 00 01 04 01 0f 00 01
<7> [304.726475] xe 0000:03:00.0: [drm:intel_dp_init_lttpr_and_dprx_caps [xe]] [CONNECTOR:285:DP-4][ENCODER:284:DDI C/PHY C][DPRX] LTTPR common capabilities: 00 00 00 00 00 00 00 00
<7> [304.727224] xe 0000:03:00.0: [drm:drm_dp_read_dpcd_caps [drm_display_helper]] AUX C/DDI C/PHY C: DPCD: 12 14 c4 01 01 15 01 81 00 01 04 01 0f 00 01
<7> [304.728522] xe 0000:03:00.0: [drm:intel_dp_start_link_train [xe]] [CONNECTOR:285:DP-4][ENCODER:284:DDI C/PHY C][DPRX] Using LINK_BW_SET value 06
<7> [304.729928] xe 0000:03:00.0: [drm:intel_dp_set_signal_levels [xe]] [CONNECTOR:285:DP-4][ENCODER:284:DDI C/PHY C][DPRX] 8b/10b, lanes: 4, vswing levels: 0/0/0/0, pre-emphasis levels: 0/0/0/0
<7> [304.730011] xe 0000:03:00.0: [drm:intel_dp_program_link_training_pattern [xe]] [CONNECTOR:285:DP-4][ENCODER:284:DDI C/PHY C][DPRX] Using DP training pattern TPS1
<7> [304.736642] xe 0000:03:00.0: [drm:intel_dp_link_train_phy [xe]] [CONNECTOR:285:DP-4][ENCODER:284:DDI C/PHY C][DPRX] Clock recovery OK
<7> [304.736719] xe 0000:03:00.0: [drm:intel_dp_program_link_training_pattern [xe]] [CONNECTOR:285:DP-4][ENCODER:284:DDI C/PHY C][DPRX] Using DP training pattern TPS3
<7> [304.743651] xe 0000:03:00.0: [drm:intel_dp_link_train_phy [xe]] [CONNECTOR:285:DP-4][ENCODER:284:DDI C/PHY C][DPRX] Channel EQ done. DP Training successful
<7> [304.743793] xe 0000:03:00.0: [drm:intel_dp_link_train_phy [xe]] [CONNECTOR:285:DP-4][ENCODER:284:DDI C/PHY C][DPRX] Link Training passed at link rate = 162000, lane count = 4
<7> [304.744668] xe 0000:03:00.0: [drm:intel_enable_transcoder [xe]] enabling pipe D
<7> [304.761620] xe 0000:03:00.0: [drm:intel_audio_codec_enable [xe]] [CONNECTOR:285:DP-4][ENCODER:284:DDI C/PHY C] Enable audio codec on [CRTC:259:pipe D], 40 bytes ELD
<7> [304.778612] xe 0000:03:00.0: [drm:verify_connector_state [xe]] [CONNECTOR:285:DP-4]
<7> [304.779459] xe 0000:03:00.0: [drm:intel_modeset_verify_crtc [xe]] [CRTC:259:pipe D]
<7> [304.780927] xe 0000:03:00.0: [drm:drm_mode_setcrtc] [CRTC:88:pipe A]
<7> [304.781043] xe 0000:03:00.0: [drm:drm_mode_setcrtc] [CONNECTOR:281:HDMI-A-6]
<7> [304.781290] xe 0000:03:00.0: [drm:intel_atomic_check [xe]] [CONNECTOR:281:HDMI-A-6] Limiting display bpp to 24 (EDID bpp 48, max requested bpp 24, max platform bpp 36)
<7> [304.781924] xe 0000:03:00.0: [drm:intel_hdmi_compute_clock [xe]] picking 8 bpc for HDMI output (pipe bpp: 24)
<7> [304.782493] xe 0000:03:00.0: [drm:intel_atomic_check [xe]] [CRTC:88:pipe A] hw max bpp: 24, pipe bpp: 24, dithering: 0
<7> [304.783038] xe 0000:03:00.0: [drm:intel_ddi_compute_config_late [xe]] [ENCODER:280:DDI B/PHY B] [CRTC:88:pipe A]
<7> [304.783548] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:88:pipe A] fastset requirement not met in hw.enable (expected no, found yes)
<7> [304.784067] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:88:pipe A] fastset requirement not met in hw.active (expected no, found yes)
<7> [304.784541] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:88:pipe A] fastset requirement not met in cpu_transcoder (expected -1, found 0)
<7> [304.785015] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:88:pipe A] fastset requirement not met in lane_count (expected 0, found 4)
<7> [304.785420] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:88:pipe A] fastset requirement not met in output_types (expected 0x00000000, found 0x00000040)
<7> [304.785820] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:88:pipe A] fastset requirement not met in framestart_delay (expected 0, found 1)
<7> [304.786241] xe 0000:03:00.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> [304.786613] xe 0000:03:00.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> [304.786962] xe 0000:03:00.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> [304.787375] xe 0000:03:00.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> [304.787702] xe 0000:03:00.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> [304.788030] xe 0000:03:00.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> [304.788351] xe 0000:03:00.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> [304.788655] xe 0000:03:00.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> [304.788940] xe 0000:03:00.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> [304.789252] xe 0000:03:00.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> [304.789523] xe 0000:03:00.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> [304.789790] xe 0000:03:00.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> [304.790080] xe 0000:03:00.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> [304.790334] xe 0000:03:00.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> [304.790581] xe 0000:03:00.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> [304.790832] xe 0000:03:00.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> [304.791106] xe 0000:03:00.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> [304.791346] xe 0000:03:00.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> [304.791579] xe 0000:03:00.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> [304.791802] xe 0000:03:00.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> [304.792041] xe 0000:03:00.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> [304.792261] xe 0000:03:00.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> [304.792468] xe 0000:03:00.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> [304.792667] xe 0000:03:00.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> [304.792859] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:88:pipe A] fastset requirement not met in pixel_multiplier (expected 0, found 1)
<7> [304.793065] xe 0000:03:00.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> [304.793252] xe 0000:03:00.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> [304.793433] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:88:pipe A] fastset requirement not met in has_hdmi_sink (expected no, found yes)
<7> [304.793606] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:88:pipe A] fastset requirement not met in has_infoframe (expected no, found yes)
<7> [304.793778] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:88:pipe A] fastset requirement not met in pipe_bpp (expected 0, found 24)
<7> [304.793954] xe 0000:03:00.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> [304.794148] xe 0000:03:00.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> [304.794314] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:88:pipe A] fastset requirement not met in port_clock (expected 0, found 148500)
<7> [304.794471] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:88:pipe A] fastset requirement not met in infoframes.enable (expected 0x00000000, found 0x00000071)
<7> [304.794630] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:88:pipe A] fastset requirement not met in avi infoframe
<7> [304.794787] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] expected:
<7> [304.794959] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] found:
<7> [304.795127] xe 0000:03:00.0: HDMI infoframe: Auxiliary Video Information (AVI), version 2, length 13
<7> [304.795130] xe 0000:03:00.0: colorspace: RGB
<7> [304.795133] xe 0000:03:00.0: scan mode: Underscan
<7> [304.795135] xe 0000:03:00.0: colorimetry: No Data
<7> [304.795137] xe 0000:03:00.0: picture aspect: 16:9
<7> [304.795139] xe 0000:03:00.0: active aspect: Same as Picture
<7> [304.795141] xe 0000:03:00.0: itc: No Data
<7> [304.795143] xe 0000:03:00.0: extended colorimetry: xvYCC 601
<7> [304.795145] xe 0000:03:00.0: quantization range: Default
<7> [304.795147] xe 0000:03:00.0: nups: Unknown Non-uniform Scaling
<7> [304.795148] xe 0000:03:00.0: video code: 16
<7> [304.795150] xe 0000:03:00.0: ycc quantization range: Full
<7> [304.795152] xe 0000:03:00.0: hdmi content type: Graphics
<7> [304.795154] xe 0000:03:00.0: pixel repeat: 0
<7> [304.795157] xe 0000:03:00.0: bar top 0, bottom 0, left 0, right 0
<7> [304.795159] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:88:pipe A] fastset requirement not met in spd infoframe
<7> [304.795311] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] expected:
<7> [304.795451] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] found:
<7> [304.795590] xe 0000:03:00.0: HDMI infoframe: Source Product Description (SPD), version 1, length 25
<7> [304.795592] xe 0000:03:00.0: vendor: Intel
<7> [304.795594] xe 0000:03:00.0: product: Discrete gfx
<7> [304.795596] xe 0000:03:00.0: source device information: PC General (0x9)
<7> [304.795598] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:88:pipe A] fastset requirement not met in hdmi infoframe
<7> [304.795731] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] expected:
<7> [304.795864] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] found:
<7> [304.796001] xe 0000:03:00.0: HDMI infoframe: Vendor, version 1, length 4
<7> [304.796003] xe 0000:03:00.0: empty frame
<7> [304.796006] xe 0000:03:00.0: [drm:intel_atomic_check [xe]] [CRTC:88:pipe A] fastset requirement not met, forcing full modeset
<7> [304.796170] xe 0000:03:00.0: [drm:skl_compute_wm [xe]] Enabled dbuf slices 0xd -> 0xf (total dbuf slices 0xf), mbus joined? no->no
<7> [304.796313] xe 0000:03:00.0: [drm:skl_compute_wm [xe]] [CRTC:88:pipe A] dbuf slices 0x0 -> 0x3, ddb (0 - 0) -> (0 - 2048), active pipes 0x8 -> 0x9
<7> [304.796461] xe 0000:03:00.0: [drm:skl_compute_wm [xe]] [PLANE:33:plane 1A] ddb ( 0 - 0) -> ( 0 - 1963), size 0 -> 1963
<7> [304.796566] xe 0000:03:00.0: [drm:skl_compute_wm [xe]] [PLANE:83:cursor A] ddb ( 0 - 0) -> (1963 - 2048), size 0 -> 85
<7> [304.796673] xe 0000:03:00.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> [304.796774] xe 0000:03:00.0: [drm:skl_print_plane_changes [xe]] [PLANE:33:plane 1A] lines 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0 -> 4, 4, 4, 5, 9, 11, 17, 25, 0, 0, 0
<7> [304.796876] xe 0000:03:00.0: [drm:skl_print_plane_changes [xe]] [PLANE:33:plane 1A] blocks 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0 -> 62, 62, 62, 78, 139, 169, 261, 383, 137, 0, 0
<7> [304.796981] xe 0000:03:00.0: [drm:skl_print_plane_changes [xe]] [PLANE:33:plane 1A] min_ddb 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0 -> 123, 123, 123, 184, 245, 245, 367, 489, 138, 0, 0
<7> [304.797101] xe 0000:03:00.0: [drm:intel_bw_atomic_check [xe]] [CRTC:88:pipe A] data rate 594000 num active planes 1
<7> [304.797228] xe 0000:03:00.0: [drm:intel_bw_atomic_check [xe]] QGV point 0: max bw 50000 required 1248
<7> [304.797340] xe 0000:03:00.0: [drm:intel_bw_atomic_check [xe]] No SAGV, using single QGV point mask 0x1
<7> [304.797460] xe 0000:03:00.0: [drm:intel_cdclk_atomic_check [xe]] [CRTC:88:pipe A] min cdclk: 0 kHz -> 192000 kHz
<7> [304.797582] xe 0000:03:00.0: [drm:intel_cdclk_update_dbuf_bw_min_cdclk [xe]] dbuf bandwidth min cdclk: 9282 kHz -> 18563 kHz
<7> [304.797690] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] [CRTC:88:pipe A] enable: yes [modeset]
<7> [304.797800] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] active: yes, output_types: HDMI (0x40), output format: RGB, sink format: RGB
<7> [304.797905] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] cpu_transcoder: A, pipe bpp: 24, dithering: 0
<7> [304.798019] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] MST master transcoder: <invalid>
<7> [304.798120] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] port sync: master transcoder: <invalid>, slave transcoder bitmask = 0x0
<7> [304.798221] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] joiner: no, pipes: 0x0
<7> [304.798324] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] splitter: disabled, link count 0, overlap 0
<7> [304.798417] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] audio: 1, infoframes: 1, infoframes enabled: 0x71
<7> [304.798508] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] GCP: 0x0
<7> [304.798599] xe 0000:03:00.0: HDMI infoframe: Auxiliary Video Information (AVI), version 2, length 13
<7> [304.798600] xe 0000:03:00.0: colorspace: RGB
<7> [304.798601] xe 0000:03:00.0: scan mode: Underscan
<7> [304.798603] xe 0000:03:00.0: colorimetry: No Data
<7> [304.798604] xe 0000:03:00.0: picture aspect: 16:9
<7> [304.798605] xe 0000:03:00.0: active aspect: Same as Picture
<7> [304.798606] xe 0000:03:00.0: itc: No Data
<7> [304.798607] xe 0000:03:00.0: extended colorimetry: xvYCC 601
<7> [304.798608] xe 0000:03:00.0: quantization range: Default
<7> [304.798609] xe 0000:03:00.0: nups: Unknown Non-uniform Scaling
<7> [304.798610] xe 0000:03:00.0: video code: 16
<7> [304.798611] xe 0000:03:00.0: ycc quantization range: Full
<7> [304.798612] xe 0000:03:00.0: hdmi content type: Graphics
<7> [304.798613] xe 0000:03:00.0: pixel repeat: 0
<7> [304.798614] xe 0000:03:00.0: bar top 0, bottom 0, left 0, right 0
<7> [304.798616] xe 0000:03:00.0: HDMI infoframe: Source Product Description (SPD), version 1, length 25
<7> [304.798617] xe 0000:03:00.0: vendor: Intel
<7> [304.798618] xe 0000:03:00.0: product: Discrete gfx
<7> [304.798619] xe 0000:03:00.0: source device information: PC General (0x9)
<7> [304.798620] xe 0000:03:00.0: HDMI infoframe: Vendor, version 1, length 4
<7> [304.798621] xe 0000:03:00.0: empty frame
<7> [304.798623] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] ELD: 10 00 08 00 65 32 00 01 00 00 00 00 00 00 00 00
<7> [304.798709] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] ELD: 61 a4 9a 00 4d 69 20 54 56 09 07 07 11 17 50 51
<7> [304.798795] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] ELD: 07 00 00 00
<7> [304.798880] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] scanline offset: 2
<7> [304.798966] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] framestart delay: 1, MSA timing delay: 0, set context latency: 0
<7> [304.799065] xe 0000:03:00.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> [304.799151] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] vrr: vmin vblank: 1080, vmax vblank: 1080, vmin vtotal: 1125, vmax vtotal: 1125
<7> [304.799230] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] requested mode: "1920x1080": 60 148500 1920 2008 2052 2200 1080 1084 1089 1125 0x48 0x5
<7> [304.799311] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] adjusted mode: "1920x1080": 60 148500 1920 2008 2052 2200 1080 1084 1089 1125 0x48 0x5
<7> [304.799391] xe 0000:03:00.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> [304.799470] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] pipe mode: "1920x1080": 60 148500 1920 2008 2052 2200 1080 1084 1089 1125 0x40 0x5
<7> [304.799548] xe 0000:03:00.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> [304.799625] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] port clock: 148500, pipe src: 1920x1080+0+0, pixel rate 148500, min cdclk 192000
<7> [304.799703] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] linetime: 119, ips linetime: 0
<7> [304.799777] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] num_scalers: 2, scaler_users: 0x0, scaler_id: -1, scaling_filter: 0
<7> [304.799851] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] pch pfit: 0x0+0+0, disabled, force thru: no
<7> [304.799923] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] ips: 0, double wide: 0, drrs: 0
<7> [304.800001] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] dpll_hw_state: dpll: 0x24414, dpll_md: 0x18000000, fp0: 0x8801ef8, fp1: 0x2b000440
<7> [304.800074] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] csc_mode: 0x0 gamma_mode: 0x0 gamma_enable: 0 csc_enable: 0
<7> [304.800147] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] pre csc lut: 0 entries, post csc lut: 0 entries
<7> [304.800220] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] output csc: pre offsets: 0x0000 0x0000 0x0000
<7> [304.800294] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] output csc: coefficients: 0x0000 0x0000 0x0000
<7> [304.800365] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] output csc: coefficients: 0x0000 0x0000 0x0000
<7> [304.800436] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] output csc: coefficients: 0x0000 0x0000 0x0000
<7> [304.800507] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] output csc: post offsets: 0x0000 0x0000 0x0000
<7> [304.800578] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] pipe csc: pre offsets: 0x0000 0x0000 0x0000
<7> [304.800648] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] pipe csc: coefficients: 0x0000 0x0000 0x0000
<7> [304.800719] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] pipe csc: coefficients: 0x0000 0x0000 0x0000
<7> [304.800791] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] pipe csc: coefficients: 0x0000 0x0000 0x0000
<7> [304.800862] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] pipe csc: post offsets: 0x0000 0x0000 0x0000
<7> [304.800932] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] sharpness strength: 0, sharpness tap size: 0, sharpness enable: 0
<7> [304.801011] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] [PLANE:33:plane 1A] fb: [FB:312] 1920x1080 format = XR24 little-endian (0x34325258) modifier = 0x100000000000009, visible: yes
<7> [304.801086] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] rotation: 0x1, scaler: -1, scaling_filter: 0
<7> [304.801158] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] src: 1920.000000x1080.000000+0.000000+0.000000 dst: 1920x1080+0+0
<7> [304.801230] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] [PLANE:43:plane 2A] fb: [NOFB], visible: no
<7> [304.801302] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] [PLANE:53:plane 3A] fb: [NOFB], visible: no
<7> [304.801373] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] [PLANE:63:plane 4A] fb: [NOFB], visible: no
<7> [304.801444] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] [PLANE:73:plane 5A] fb: [NOFB], visible: no
<7> [304.801515] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] [PLANE:83:cursor A] fb: [NOFB], visible: no
<7> [304.801711] xe 0000:03:00.0: [drm:intel_power_well_enable [xe]] enabling PW_A
<7> [304.801885] xe 0000:03:00.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:261:DDI A/PHY A]
<7> [304.801958] xe 0000:03:00.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:263:DP-MST A]
<7> [304.802037] xe 0000:03:00.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:264:DP-MST B]
<7> [304.802107] xe 0000:03:00.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:265:DP-MST C]
<7> [304.802176] xe 0000:03:00.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:266:DP-MST D]
<7> [304.802244] xe 0000:03:00.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:280:DDI B/PHY B]
<7> [304.802311] xe 0000:03:00.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:284:DDI C/PHY C]
<7> [304.802377] xe 0000:03:00.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:286:DP-MST A]
<7> [304.802444] xe 0000:03:00.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:287:DP-MST B]
<7> [304.802509] xe 0000:03:00.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:288:DP-MST C]
<7> [304.802574] xe 0000:03:00.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:289:DP-MST D]
<7> [304.802640] xe 0000:03:00.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:296:DDI D/PHY D]
<7> [304.802705] xe 0000:03:00.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:298:DP-MST A]
<7> [304.802769] xe 0000:03:00.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:299:DP-MST B]
<7> [304.802833] xe 0000:03:00.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:300:DP-MST C]
<7> [304.802895] xe 0000:03:00.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:301:DP-MST D]
<7> [304.802959] xe 0000:03:00.0: [drm:gen9_dbuf_slices_update [xe]] Updating dbuf slices to 0xf
<7> [304.803147] xe 0000:03:00.0: [drm:intel_power_well_enable [xe]] enabling DDI_IO_B
<7> [304.803271] xe 0000:03:00.0: [drm:intel_enable_transcoder [xe]] enabling pipe A
<7> [304.804798] xe 0000:03:00.0: [drm:intel_fbc_update [xe]] reserved 4456448 bytes of contiguous stolen space for FBC, limit: 2
<7> [304.804877] xe 0000:03:00.0: [drm:intel_fbc_update [xe]] Enabling FBC on [PLANE:33:plane 1A]
<7> [304.820954] xe 0000:03:00.0: [drm:intel_audio_codec_enable [xe]] [CONNECTOR:281:HDMI-A-6][ENCODER:280:DDI B/PHY B] Enable audio codec on [CRTC:88:pipe A], 36 bytes ELD
<7> [304.837638] xe 0000:03:00.0: [drm:audio_config_hdmi_pixel_clock [xe]] Configuring HDMI audio for pixel clock 148500 (0x00090000)
<7> [304.837870] xe 0000:03:00.0: [drm:hsw_audio_config_update [xe]] using automatic N
<7> [304.838233] xe 0000:03:00.0: [drm:verify_connector_state [xe]] [CONNECTOR:281:HDMI-A-6]
<7> [304.838459] xe 0000:03:00.0: [drm:intel_modeset_verify_crtc [xe]] [CRTC:88:pipe A]
<6> [307.097133] [IGT] kms_flip: finished subtest AD-HDMI-A6-DP4, FAIL
Created at 2025-11-13 02:48:37