Results for igt@kms_flip@2x-flip-vs-expired-vblank-interruptible@ab-hdmi-a1-hdmi-a2

Result: Fail

integration-manifest git-log-oneline i915_display_info23 igt_runner23 runtimes23 results23.json results23-i915-load.json guc_logs23.tar boot23 dmesg23

DetailValue
Duration 6.83 seconds
Hostname
shard-glk9
Igt-Version
IGT-Version: 2.4-g65d691069 (x86_64) (Linux: 7.1.0-rc3-CI_DRM_18499-gd47455904378+ x86_64)
Out
Using IGT_SRANDOM=1778935004 for randomisation
Opened device: /dev/dri/card0
Using monotonic timestamps
Starting subtest: 2x-flip-vs-expired-vblank-interruptible
Starting dynamic subtest: AB-HDMI-A1-HDMI-A2
  1920x1080: 60 148500 1920 2008 2052 2200 1080 1083 1088 1125 0x48 0x9 
  1920x1080: 60 148500 1920 2008 2052 2200 1080 1083 1088 1125 0x48 0x9 
Stack trace:
  #0 ../lib/igt_core.c:2074 __igt_fail_assert()
  #1 ../tests/kms_flip.c:926 run_test_on_crtc_set()
  #2 ../tests/kms_flip.c:2029 run_pair()
  #3 ../tests/kms_flip.c:2227 __igt_unique____real_main2105()
  #4 ../tests/kms_flip.c:2105 main()
  #5 [__libc_init_first+0x8a]
  #6 [__libc_start_main+0x8b]
  #7 [_start+0x25]
Dynamic subtest AB-HDMI-A1-HDMI-A2: FAIL (6.829s)
Err
Starting subtest: 2x-flip-vs-expired-vblank-interruptible
Starting dynamic subtest: AB-HDMI-A1-HDMI-A2
[101.908965] (kms_flip:2253) CRITICAL: Test assertion failure function run_test_step, file ../tests/kms_flip.c:931:
[101.909062] (kms_flip:2253) CRITICAL: Failed assertion: end - start < 500
[101.909182] (kms_flip:2253) CRITICAL: Last errno: 4, Interrupted system call
Dynamic subtest AB-HDMI-A1-HDMI-A2 failed.
**** DEBUG ****
[99.891258] (kms_flip:2253) DEBUG: Vblank took 19us
[99.908264] (kms_flip:2253) DEBUG: name = flip
last_ts = 100.031815
last_received_ts = 100.031456
last_seq = 988
current_ts = 100.048477
current_received_ts = 100.048508
current_seq = 989
count = 223
seq_step = 1
[99.908306] (kms_flip:2253) DEBUG: Vblank took 20us
[99.924818] (kms_flip:2253) DEBUG: name = flip
last_ts = 100.048477
last_received_ts = 100.048508
last_seq = 989
current_ts = 100.065140
current_received_ts = 100.065048
current_seq = 990
count = 224
seq_step = 1
[99.924861] (kms_flip:2253) DEBUG: Vblank took 20us
[99.941228] (kms_flip:2253) DEBUG: name = flip
last_ts = 100.065140
last_received_ts = 100.065048
last_seq = 990
current_ts = 100.081810
current_received_ts = 100.081467
current_seq = 991
count = 225
seq_step = 1
[99.941271] (kms_flip:2253) DEBUG: Vblank took 20us
[99.957712] (kms_flip:2253) DEBUG: name = flip
last_ts = 100.081810
last_received_ts = 100.081467
last_seq = 991
current_ts = 100.098480
current_received_ts = 100.097954
current_seq = 992
count = 226
seq_step = 1
[99.957785] (kms_flip:2253) DEBUG: Vblank took 49us
[99.974604] (kms_flip:2253) DEBUG: name = flip
last_ts = 100.098480
last_received_ts = 100.097954
last_seq = 992
current_ts = 100.115143
current_received_ts = 100.114845
current_seq = 993
count = 227
seq_step = 1
[99.974647] (kms_flip:2253) DEBUG: Vblank took 20us
[99.991334] (kms_flip:2253) DEBUG: name = flip
last_ts = 100.115143
last_received_ts = 100.114845
last_seq = 993
current_ts = 100.131805
current_received_ts = 100.131569
current_seq = 994
count = 228
seq_step = 1
[99.991379] (kms_flip:2253) DEBUG: Vblank took 20us
[100.008022] (kms_flip:2253) DEBUG: name = flip
last_ts = 100.131805
last_received_ts = 100.131569
last_seq = 994
current_ts = 100.148476
current_received_ts = 100.148262
current_seq = 995
count = 229
seq_step = 1
[100.008066] (kms_flip:2253) DEBUG: Vblank took 20us
[100.024419] (kms_flip:2253) DEBUG: name = flip
last_ts = 100.148476
last_received_ts = 100.148262
last_seq = 995
current_ts = 100.165138
current_received_ts = 100.164658
current_seq = 996
count = 230
seq_step = 1
[100.024460] (kms_flip:2253) DEBUG: Vblank took 18us
[100.041240] (kms_flip:2253) DEBUG: name = flip
last_ts = 100.165138
last_received_ts = 100.164658
last_seq = 996
current_ts = 100.181801
current_received_ts = 100.181480
current_seq = 997
count = 231
seq_step = 1
[100.041279] (kms_flip:2253) DEBUG: Vblank took 17us
[100.057836] (kms_flip:2253) DEBUG: name = flip
last_ts = 100.181801
last_received_ts = 100.181480
last_seq = 997
current_ts = 100.198479
current_received_ts = 100.198067
current_seq = 998
count = 232
seq_step = 1
[100.057885] (kms_flip:2253) DEBUG: Vblank took 22us
[100.074480] (kms_flip:2253) DEBUG: name = flip
last_ts = 100.198479
last_received_ts = 100.198067
last_seq = 998
current_ts = 100.215141
current_received_ts = 100.214714
current_seq = 999
count = 233
seq_step = 1
[100.074521] (kms_flip:2253) DEBUG: Vblank took 18us
[100.091271] (kms_flip:2253) DEBUG: name = flip
last_ts = 100.215141
last_received_ts = 100.214714
last_seq = 999
current_ts = 100.231812
current_received_ts = 100.231506
current_seq = 1000
count = 234
seq_step = 1
[100.091309] (kms_flip:2253) DEBUG: Vblank took 18us
[100.108026] (kms_flip:2253) DEBUG: name = flip
last_ts = 100.231812
last_received_ts = 100.231506
last_seq = 1000
current_ts = 100.248482
current_received_ts = 100.248260
current_seq = 1001
count = 235
seq_step = 1
[100.108068] (kms_flip:2253) DEBUG: Vblank took 19us
[100.124437] (kms_flip:2253) DEBUG: name = flip
last_ts = 100.248482
last_received_ts = 100.248260
last_seq = 1001
current_ts = 100.265137
current_received_ts = 100.264671
current_seq = 1002
count = 236
seq_step = 1
[100.124480] (kms_flip:2253) DEBUG: Vblank took 19us
[100.141234] (kms_flip:2253) DEBUG: name = flip
last_ts = 100.265137
last_received_ts = 100.264671
last_seq = 1002
current_ts = 100.281815
current_received_ts = 100.281471
current_seq = 1003
count = 237
seq_step = 1
[100.141275] (kms_flip:2253) DEBUG: Vblank took 18us
[100.157711] (kms_flip:2253) DEBUG: name = flip
last_ts = 100.281815
last_received_ts = 100.281471
last_seq = 1003
current_ts = 100.298477
current_received_ts = 100.297943
current_seq = 1004
count = 238
seq_step = 1
[100.157797] (kms_flip:2253) DEBUG: Vblank took 62us
[100.174819] (kms_flip:2253) DEBUG: name = flip
last_ts = 100.298477
last_received_ts = 100.297943
last_seq = 1004
current_ts = 100.315140
current_received_ts = 100.315048
current_seq = 1005
count = 239
seq_step = 1
[100.174869] (kms_flip:2253) DEBUG: Vblank took 23us
[100.191224] (kms_flip:2253) DEBUG: name = flip
last_ts = 100.315140
last_received_ts = 100.315048
last_seq = 1005
current_ts = 100.331802
current_received_ts = 100.331451
current_seq = 1006
count = 240
seq_step = 1
[100.191266] (kms_flip:2253) DEBUG: Vblank took 20us
[100.208021] (kms_flip:2253) DEBUG: name = flip
last_ts = 100.331802
last_received_ts = 100.331451
last_seq = 1006
current_ts = 100.348480
current_received_ts = 100.348251
current_seq = 1007
count = 241
seq_step = 1
[100.208064] (kms_flip:2253) DEBUG: Vblank took 19us
[100.224546] (kms_flip:2253) DEBUG: name = flip
last_ts = 100.348480
last_received_ts = 100.348251
last_seq = 1007
current_ts = 100.365128
current_received_ts = 100.364777
current_seq = 1008
count = 242
seq_step = 1
[100.224589] (kms_flip:2253) DEBUG: Vblank took 20us
[100.241247] (kms_flip:2253) DEBUG: name = flip
last_ts = 100.365128
last_received_ts = 100.364777
last_seq = 1008
current_ts = 100.381798
current_received_ts = 100.381477
current_seq = 1009
count = 243
seq_step = 1
[100.241291] (kms_flip:2253) DEBUG: Vblank took 20us
[100.258023] (kms_flip:2253) DEBUG: name = flip
last_ts = 100.381798
last_received_ts = 100.381477
last_seq = 1009
current_ts = 100.398476
current_received_ts = 100.398254
current_seq = 1010
count = 244
seq_step = 1
[100.258069] (kms_flip:2253) DEBUG: Vblank took 21us
[100.274420] (kms_flip:2253) DEBUG: name = flip
last_ts = 100.398476
last_received_ts = 100.398254
last_seq = 1010
current_ts = 100.415138
current_received_ts = 100.414650
current_seq = 1011
count = 245
seq_step = 1
[100.274463] (kms_flip:2253) DEBUG: Vblank took 20us
[100.291244] (kms_flip:2253) DEBUG: name = flip
last_ts = 100.415138
last_received_ts = 100.414650
last_seq = 1011
current_ts = 100.431808
current_received_ts = 100.431473
current_seq = 1012
count = 246
seq_step = 1
[100.291289] (kms_flip:2253) DEBUG: Vblank took 20us
[100.308035] (kms_flip:2253) DEBUG: name = flip
last_ts = 100.431808
last_received_ts = 100.431473
last_seq = 1012
current_ts = 100.448471
current_received_ts = 100.448257
current_seq = 1013
count = 247
seq_step = 1
[100.308081] (kms_flip:2253) DEBUG: Vblank took 20us
[100.324509] (kms_flip:2253) DEBUG: name = flip
last_ts = 100.448471
last_received_ts = 100.448257
last_seq = 1013
current_ts = 100.465126
current_received_ts = 100.464729
current_seq = 1014
count = 248
seq_step = 1
[100.324553] (kms_flip:2253) DEBUG: Vblank took 21us
[100.341180] (kms_flip:2253) DEBUG: name = flip
last_ts = 100.465126
last_received_ts = 100.464729
last_seq = 1014
current_ts = 100.481796
current_received_ts = 100.481407
current_seq = 1015
count = 249
seq_step = 1
[100.341221] (kms_flip:2253) DEBUG: Vblank took 20us
[100.358184] (kms_flip:2253) DEBUG: name = flip
last_ts = 100.481796
last_received_ts = 100.481407
last_seq = 1015
current_ts = 100.498466
current_received_ts = 100.498405
current_seq = 1016
count = 250
seq_step = 1
[100.358224] (kms_flip:2253) DEBUG: Vblank took 18us
[100.374433] (kms_flip:2253) DEBUG: name = flip
last_ts = 100.498466
last_received_ts = 100.498405
last_seq = 1016
current_ts = 100.515137
current_received_ts = 100.514656
current_seq = 1017
count = 251
seq_step = 1
[100.374476] (kms_flip:2253) DEBUG: Vblank took 20us
[100.391329] (kms_flip:2253) DEBUG: name = flip
last_ts = 100.515137
last_received_ts = 100.514656
last_seq = 1017
current_ts = 100.531792
current_received_ts = 100.531548
current_seq = 1018
count = 252
seq_step = 1
[100.391373] (kms_flip:2253) DEBUG: Vblank took 20us
[100.407786] (kms_flip:2253) DEBUG: name = flip
last_ts = 100.531792
last_received_ts = 100.531548
last_seq = 1018
current_ts = 100.548454
current_received_ts = 100.547974
current_seq = 1019
count = 253
seq_step = 1
[100.407838] (kms_flip:2253) DEBUG: Vblank took 20us
[100.424510] (kms_flip:2253) DEBUG: name = flip
last_ts = 100.548454
last_received_ts = 100.547974
last_seq = 1019
current_ts = 100.565132
current_received_ts = 100.564728
current_seq = 1020
count = 254
seq_step = 1
[100.424560] (kms_flip:2253) DEBUG: Vblank took 23us
[100.441654] (kms_flip:2253) DEBUG: name = flip
last_ts = 100.565132
last_received_ts = 100.564728
last_seq = 1020
current_ts = 100.581795
current_received_ts = 100.581871
current_seq = 1021
count = 255
seq_step = 1
[100.441697] (kms_flip:2253) DEBUG: Vblank took 21us
[100.458038] (kms_flip:2253) DEBUG: name = flip
last_ts = 100.581795
last_received_ts = 100.581871
last_seq = 1021
current_ts = 100.598465
current_received_ts = 100.598259
current_seq = 1022
count = 256
seq_step = 1
[100.458081] (kms_flip:2253) DEBUG: Vblank took 18us
[100.474411] (kms_flip:2253) DEBUG: name = flip
last_ts = 100.598465
last_received_ts = 100.598259
last_seq = 1022
current_ts = 100.615128
current_received_ts = 100.614632
current_seq = 1023
count = 257
seq_step = 1
[100.474454] (kms_flip:2253) DEBUG: Vblank took 19us
[100.491584] (kms_flip:2253) DEBUG: name = flip
last_ts = 100.615128
last_received_ts = 100.614632
last_seq = 1023
current_ts = 100.631790
current_received_ts = 100.631805
current_seq = 1024
count = 258
seq_step = 1
[100.491629] (kms_flip:2253) DEBUG: Vblank took 20us
[100.507815] (kms_flip:2253) DEBUG: name = flip
last_ts = 100.631790
last_received_ts = 100.631805
last_seq = 1024
current_ts = 100.648468
current_received_ts = 100.647980
current_seq = 1025
count = 259
seq_step = 1
[100.507863] (kms_flip:2253) DEBUG: Vblank took 22us
[100.524872] (kms_flip:2253) DEBUG: name = flip
last_ts = 100.648468
last_received_ts = 100.647980
last_seq = 1025
current_ts = 100.665131
current_received_ts = 100.665092
current_seq = 1026
count = 260
seq_step = 1
[100.524916] (kms_flip:2253) DEBUG: Vblank took 21us
[100.541220] (kms_flip:2253) DEBUG: name = flip
last_ts = 100.665131
last_received_ts = 100.665092
last_seq = 1026
current_ts = 100.681801
current_received_ts = 100.681435
current_seq = 1027
count = 261
seq_step = 1
[100.541262] (kms_flip:2253) DEBUG: Vblank took 19us
[100.558014] (kms_flip:2253) DEBUG: name = flip
last_ts = 100.681801
last_received_ts = 100.681435
last_seq = 1027
current_ts = 100.698463
current_received_ts = 100.698235
current_seq = 1028
count = 262
seq_step = 1
[100.558055] (kms_flip:2253) DEBUG: Vblank took 18us
[100.574405] (kms_flip:2253) DEBUG: name = flip
last_ts = 100.698463
last_received_ts = 100.698235
last_seq = 1028
current_ts = 100.715126
current_received_ts = 100.714622
current_seq = 1029
count = 263
seq_step = 1
[100.574448] (kms_flip:2253) DEBUG: Vblank took 19us
[100.591031] (kms_flip:2253) DEBUG: name = flip
last_ts = 100.715126
last_received_ts = 100.714622
last_seq = 1029
current_ts = 100.731789
current_received_ts = 100.731247
current_seq = 1030
count = 264
seq_step = 1
[100.591074] (kms_flip:2253) DEBUG: Vblank took 19us
[100.608476] (kms_flip:2253) DEBUG: name = flip
last_ts = 100.731789
last_received_ts = 100.731247
last_seq = 1030
current_ts = 100.748451
current_received_ts = 100.748688
current_seq = 1031
count = 265
seq_step = 1
[100.608520] (kms_flip:2253) DEBUG: Vblank took 20us
[100.624433] (kms_flip:2253) DEBUG: name = flip
last_ts = 100.748451
last_received_ts = 100.748688
last_seq = 1031
current_ts = 100.765129
current_received_ts = 100.764648
current_seq = 1032
count = 266
seq_step = 1
[100.624477] (kms_flip:2253) DEBUG: Vblank took 20us
[100.641226] (kms_flip:2253) DEBUG: name = flip
last_ts = 100.765129
last_received_ts = 100.764648
last_seq = 1032
current_ts = 100.781784
current_received_ts = 100.781441
current_seq = 1033
count = 267
seq_step = 1
[100.641270] (kms_flip:2253) DEBUG: Vblank took 20us
[100.658033] (kms_flip:2253) DEBUG: name = flip
last_ts = 100.781784
last_received_ts = 100.781441
last_seq = 1033
current_ts = 100.798454
current_received_ts = 100.798248
current_seq = 1034
count = 268
seq_step = 1
[100.658076] (kms_flip:2253) DEBUG: Vblank took 20us
[100.674490] (kms_flip:2253) DEBUG: name = flip
last_ts = 100.798454
last_received_ts = 100.798248
last_seq = 1034
current_ts = 100.815117
current_received_ts = 100.814705
current_seq = 1035
count = 269
seq_step = 1
[100.674534] (kms_flip:2253) DEBUG: Vblank took 20us
[100.691039] (kms_flip:2253) DEBUG: name = flip
last_ts = 100.815117
last_received_ts = 100.814705
last_seq = 1035
current_ts = 100.831787
current_received_ts = 100.831253
current_seq = 1036
count = 270
seq_step = 1
[100.691083] (kms_flip:2253) DEBUG: Vblank took 20us
[100.707712] (kms_flip:2253) DEBUG: name = flip
last_ts = 100.831787
last_received_ts = 100.831253
last_seq = 1036
current_ts = 100.848457
current_received_ts = 100.847923
current_seq = 1037
count = 271
seq_step = 1
[100.707755] (kms_flip:2253) DEBUG: Vblank took 20us
[100.724430] (kms_flip:2253) DEBUG: name = flip
last_ts = 100.848457
last_received_ts = 100.847923
last_seq = 1037
current_ts = 100.865112
current_received_ts = 100.864639
current_seq = 1038
count = 272
seq_step = 1
[100.724481] (kms_flip:2253) DEBUG: Vblank took 24us
[100.741288] (kms_flip:2253) DEBUG: name = flip
last_ts = 100.865112
last_received_ts = 100.864639
last_seq = 1038
current_ts = 100.881783
current_received_ts = 100.881500
current_seq = 1039
count = 273
seq_step = 1
[100.741330] (kms_flip:2253) DEBUG: Vblank took 19us
[100.758021] (kms_flip:2253) DEBUG: name = flip
last_ts = 100.881783
last_received_ts = 100.881500
last_seq = 1039
current_ts = 100.898445
current_received_ts = 100.898232
current_seq = 1040
count = 274
seq_step = 1
[100.758063] (kms_flip:2253) DEBUG: Vblank took 20us
[100.774412] (kms_flip:2253) DEBUG: name = flip
last_ts = 100.898445
last_received_ts = 100.898232
last_seq = 1040
current_ts = 100.915123
current_received_ts = 100.914619
current_seq = 1041
count = 275
seq_step = 1
[100.774454] (kms_flip:2253) DEBUG: Vblank took 19us
[100.791534] (kms_flip:2253) DEBUG: name = flip
last_ts = 100.915123
last_received_ts = 100.914619
last_seq = 1041
current_ts = 100.931786
current_received_ts = 100.931740
current_seq = 1042
count = 276
seq_step = 1
[100.791575] (kms_flip:2253) DEBUG: Vblank took 19us
[100.807745] (kms_flip:2253) DEBUG: name = flip
last_ts = 100.931786
last_received_ts = 100.931740
last_seq = 1042
current_ts = 100.948456
current_received_ts = 100.947952
current_seq = 1043
count = 277
seq_step = 1
[100.807838] (kms_flip:2253) DEBUG: Vblank took 21us
[100.824545] (kms_flip:2253) DEBUG: name = flip
last_ts = 100.948456
last_received_ts = 100.947952
last_seq = 1043
current_ts = 100.965118
current_received_ts = 100.964752
current_seq = 1044
count = 278
seq_step = 1
[100.824588] (kms_flip:2253) DEBUG: Vblank took 20us
[100.841328] (kms_flip:2253) DEBUG: name = flip
last_ts = 100.965118
last_received_ts = 100.964752
last_seq = 1044
current_ts = 100.981773
current_received_ts = 100.981529
current_seq = 1045
count = 279
seq_step = 1
[100.841377] (kms_flip:2253) DEBUG: Vblank took 23us
[100.857750] (kms_flip:2253) DEBUG: name = flip
last_ts = 100.981773
last_received_ts = 100.981529
last_seq = 1045
current_ts = 100.998451
current_received_ts = 100.997955
current_seq = 1046
count = 280
seq_step = 1
[100.857849] (kms_flip:2253) DEBUG: Vblank took 22us
[100.874495] (kms_flip:2253) DEBUG: name = flip
last_ts = 100.998451
last_received_ts = 100.997955
last_seq = 1046
current_ts = 101.015114
current_received_ts = 101.014694
current_seq = 1047
count = 281
seq_step = 1
[100.874542] (kms_flip:2253) DEBUG: Vblank took 21us
[100.891267] (kms_flip:2253) DEBUG: name = flip
last_ts = 101.015114
last_received_ts = 101.014694
last_seq = 1047
current_ts = 101.031776
current_received_ts = 101.031471
current_seq = 1048
count = 282
seq_step = 1
[100.891309] (kms_flip:2253) DEBUG: Vblank took 19us
[100.908028] (kms_flip:2253) DEBUG: name = flip
last_ts = 101.031776
last_received_ts = 101.031471
last_seq = 1048
current_ts = 101.048447
current_received_ts = 101.048233
current_seq = 1049
count = 283
seq_step = 1
[100.908067] (kms_flip:2253) DEBUG: Vblank took 18us
[100.924694] (kms_flip:2253) DEBUG: name = flip
last_ts = 101.048447
last_received_ts = 101.048233
last_seq = 1049
current_ts = 101.065109
current_received_ts = 101.064896
current_seq = 1050
count = 284
seq_step = 1
[100.924736] (kms_flip:2253) DEBUG: Vblank took 19us
[100.941532] (kms_flip:2253) DEBUG: name = flip
last_ts = 101.065109
last_received_ts = 101.064896
last_seq = 1050
current_ts = 101.081779
current_received_ts = 101.081734
current_seq = 1051
count = 285
seq_step = 1
[100.941574] (kms_flip:2253) DEBUG: Vblank took 20us
[100.957995] (kms_flip:2253) DEBUG: name = flip
last_ts = 101.081779
last_received_ts = 101.081734
last_seq = 1051
current_ts = 101.098450
current_received_ts = 101.098198
current_seq = 1052
count = 286
seq_step = 1
[100.958036] (kms_flip:2253) DEBUG: Vblank took 19us
[100.974443] (kms_flip:2253) DEBUG: name = flip
last_ts = 101.098450
last_received_ts = 101.098198
last_seq = 1052
current_ts = 101.115112
current_received_ts = 101.114647
current_seq = 1053
count = 287
seq_step = 1
[100.974488] (kms_flip:2253) DEBUG: Vblank took 21us
[100.991235] (kms_flip:2253) DEBUG: name = flip
last_ts = 101.115112
last_received_ts = 101.114647
last_seq = 1053
current_ts = 101.131767
current_received_ts = 101.131439
current_seq = 1054
count = 288
seq_step = 1
[100.991276] (kms_flip:2253) DEBUG: Vblank took 19us
[101.008088] (kms_flip:2253) DEBUG: name = flip
last_ts = 101.131767
last_received_ts = 101.131439
last_seq = 1054
current_ts = 101.148445
current_received_ts = 101.148285
current_seq = 1055
count = 289
seq_step = 1
[101.008133] (kms_flip:2253) DEBUG: Vblank took 20us
[101.024410] (kms_flip:2253) DEBUG: name = flip
last_ts = 101.148445
last_received_ts = 101.148285
last_seq = 1055
current_ts = 101.165108
current_received_ts = 101.164612
current_seq = 1056
count = 290
seq_step = 1
[101.024454] (kms_flip:2253) DEBUG: Vblank took 20us
[101.041222] (kms_flip:2253) DEBUG: name = flip
last_ts = 101.165108
last_received_ts = 101.164612
last_seq = 1056
current_ts = 101.181778
current_received_ts = 101.181419
current_seq = 1057
count = 291
seq_step = 1
[101.041264] (kms_flip:2253) DEBUG: Vblank took 20us
[101.058396] (kms_flip:2253) DEBUG: name = flip
last_ts = 101.181778
last_received_ts = 101.181419
last_seq = 1057
current_ts = 101.198433
current_received_ts = 101.198593
current_seq = 1058
count = 292
seq_step = 1
[101.058443] (kms_flip:2253) DEBUG: Vblank took 22us
[101.074415] (kms_flip:2253) DEBUG: name = flip
last_ts = 101.198433
last_received_ts = 101.198593
last_seq = 1058
current_ts = 101.215111
current_received_ts = 101.214615
current_seq = 1059
count = 293
seq_step = 1
[101.074460] (kms_flip:2253) DEBUG: Vblank took 21us
[101.091311] (kms_flip:2253) DEBUG: name = flip
last_ts = 101.215111
last_received_ts = 101.214615
last_seq = 1059
current_ts = 101.231766
current_received_ts = 101.231514
current_seq = 1060
count = 294
seq_step = 1
[101.091351] (kms_flip:2253) DEBUG: Vblank took 18us
[101.108028] (kms_flip:2253) DEBUG: name = flip
last_ts = 101.231766
last_received_ts = 101.231514
last_seq = 1060
current_ts = 101.248428
current_received_ts = 101.248230
current_seq = 1061
count = 295
seq_step = 1
[101.108069] (kms_flip:2253) DEBUG: Vblank took 18us
[101.124408] (kms_flip:2253) DEBUG: name = flip
last_ts = 101.248428
last_received_ts = 101.248230
last_seq = 1061
current_ts = 101.265106
current_received_ts = 101.264603
current_seq = 1062
count = 296
seq_step = 1
[101.124450] (kms_flip:2253) DEBUG: Vblank took 19us
[101.141282] (kms_flip:2253) DEBUG: name = flip
last_ts = 101.265106
last_received_ts = 101.264603
last_seq = 1062
current_ts = 101.281776
current_received_ts = 101.281479
current_seq = 1063
count = 297
seq_step = 1
[101.141324] (kms_flip:2253) DEBUG: Vblank took 19us
[101.157714] (kms_flip:2253) DEBUG: name = flip
last_ts = 101.281776
last_received_ts = 101.281479
last_seq = 1063
current_ts = 101.298439
current_received_ts = 101.297913
current_seq = 1064
count = 298
seq_step = 1
[101.157757] (kms_flip:2253) DEBUG: Vblank took 19us
[101.174887] (kms_flip:2253) DEBUG: name = flip
last_ts = 101.298439
last_received_ts = 101.297913
last_seq = 1064
current_ts = 101.315094
current_received_ts = 101.315079
current_seq = 1065
count = 299
seq_step = 1
[101.174978] (kms_flip:2253) DEBUG: Vblank took 19us
[101.191260] (kms_flip:2253) DEBUG: name = flip
last_ts = 101.315094
last_received_ts = 101.315079
last_seq = 1065
current_ts = 101.331772
current_received_ts = 101.331451
current_seq = 1066
count = 300
seq_step = 1
[101.191302] (kms_flip:2253) DEBUG: Vblank took 19us
[101.208031] (kms_flip:2253) DEBUG: name = flip
last_ts = 101.331772
last_received_ts = 101.331451
last_seq = 1066
current_ts = 101.348434
current_received_ts = 101.348228
current_seq = 1067
count = 301
seq_step = 1
[101.208073] (kms_flip:2253) DEBUG: Vblank took 19us
[101.224482] (kms_flip:2253) DEBUG: name = flip
last_ts = 101.348434
last_received_ts = 101.348228
last_seq = 1067
current_ts = 101.365097
current_received_ts = 101.364677
current_seq = 1068
count = 302
seq_step = 1
[101.224525] (kms_flip:2253) DEBUG: Vblank took 19us
[101.241281] (kms_flip:2253) DEBUG: name = flip
last_ts = 101.365097
last_received_ts = 101.364677
last_seq = 1068
current_ts = 101.381767
current_received_ts = 101.381477
current_seq = 1069
count = 303
seq_step = 1
[101.241325] (kms_flip:2253) DEBUG: Vblank took 20us
[101.257730] (kms_flip:2253) DEBUG: name = flip
last_ts = 101.381767
last_received_ts = 101.381477
last_seq = 1069
current_ts = 101.398430
current_received_ts = 101.397919
current_seq = 1070
count = 304
seq_step = 1
[101.257776] (kms_flip:2253) DEBUG: Vblank took 21us
[101.274532] (kms_flip:2253) DEBUG: name = flip
last_ts = 101.398430
last_received_ts = 101.397919
last_seq = 1070
current_ts = 101.415100
current_received_ts = 101.414726
current_seq = 1071
count = 305
seq_step = 1
[101.274574] (kms_flip:2253) DEBUG: Vblank took 19us
[101.291315] (kms_flip:2253) DEBUG: name = flip
last_ts = 101.415100
last_received_ts = 101.414726
last_seq = 1071
current_ts = 101.431763
current_received_ts = 101.431503
current_seq = 1072
count = 306
seq_step = 1
[101.291353] (kms_flip:2253) DEBUG: Vblank took 18us
[101.307711] (kms_flip:2253) DEBUG: name = flip
last_ts = 101.431763
last_received_ts = 101.431503
last_seq = 1072
current_ts = 101.448433
current_received_ts = 101.447899
current_seq = 1073
count = 307
seq_step = 1
[101.307755] (kms_flip:2253) DEBUG: Vblank took 20us
[101.324982] (kms_flip:2253) DEBUG: name = flip
last_ts = 101.448433
last_received_ts = 101.447899
last_seq = 1073
current_ts = 101.465088
current_received_ts = 101.465172
current_seq = 1074
count = 308
seq_step = 1
[101.325027] (kms_flip:2253) DEBUG: Vblank took 21us
[101.341248] (kms_flip:2253) DEBUG: name = flip
last_ts = 101.465088
last_received_ts = 101.465172
last_seq = 1074
current_ts = 101.481766
current_received_ts = 101.481438
current_seq = 1075
count = 309
seq_step = 1
[101.341290] (kms_flip:2253) DEBUG: Vblank took 18us
[101.358046] (kms_flip:2253) DEBUG: name = flip
last_ts = 101.481766
last_received_ts = 101.481438
last_seq = 1075
current_ts = 101.498436
current_received_ts = 101.498238
current_seq = 1076
count = 310
seq_step = 1
[101.358089] (kms_flip:2253) DEBUG: Vblank took 18us
[101.374411] (kms_flip:2253) DEBUG: name = flip
last_ts = 101.498436
last_received_ts = 101.498238
last_seq = 1076
current_ts = 101.515091
current_received_ts = 101.514603
current_seq = 1077
count = 311
seq_step = 1
[101.374454] (kms_flip:2253) DEBUG: Vblank took 19us
[101.391276] (kms_flip:2253) DEBUG: name = flip
last_ts = 101.515091
last_received_ts = 101.514603
last_seq = 1077
current_ts = 101.531761
current_received_ts = 101.531464
current_seq = 1078
count = 312
seq_step = 1
[101.391321] (kms_flip:2253) DEBUG: Vblank took 20us
[101.408089] (kms_flip:2253) DEBUG: name = flip
last_ts = 101.531761
last_received_ts = 101.531464
last_seq = 1078
current_ts = 101.548424
current_received_ts = 101.548271
current_seq = 1079
count = 313
seq_step = 1
[101.408138] (kms_flip:2253) DEBUG: Vblank took 22us
[101.424517] (kms_flip:2253) DEBUG: name = flip
last_ts = 101.548424
last_received_ts = 101.548271
last_seq = 1079
current_ts = 101.565094
current_received_ts = 101.564705
current_seq = 1080
count = 314
seq_step = 1
[101.424560] (kms_flip:2253) DEBUG: Vblank took 20us
[101.441319] (kms_flip:2253) DEBUG: name = flip
last_ts = 101.565094
last_received_ts = 101.564705
last_seq = 1080
current_ts = 101.581764
current_received_ts = 101.581505
current_seq = 1081
count = 315
seq_step = 1
[101.441362] (kms_flip:2253) DEBUG: Vblank took 20us
[101.457728] (kms_flip:2253) DEBUG: name = flip
last_ts = 101.581764
last_received_ts = 101.581505
last_seq = 1081
current_ts = 101.598427
current_received_ts = 101.597916
current_seq = 1082
count = 316
seq_step = 1
[101.457775] (kms_flip:2253) DEBUG: Vblank took 21us
[101.474864] (kms_flip:2253) DEBUG: name = flip
last_ts = 101.598427
last_received_ts = 101.597916
last_seq = 1082
current_ts = 101.615089
current_received_ts = 101.615051
current_seq = 1083
count = 317
seq_step = 1
[101.474910] (kms_flip:2253) DEBUG: Vblank took 21us
[101.491331] (kms_flip:2253) DEBUG: name = flip
last_ts = 101.615089
last_received_ts = 101.615051
last_seq = 1083
current_ts = 101.631752
current_received_ts = 101.631516
current_seq = 1084
count = 318
seq_step = 1
[101.491369] (kms_flip:2253) DEBUG: Vblank took 18us
[101.508029] (kms_flip:2253) DEBUG: name = flip
last_ts = 101.631752
last_received_ts = 101.631516
last_seq = 1084
current_ts = 101.648422
current_received_ts = 101.648216
current_seq = 1085
count = 319
seq_step = 1
[101.508068] (kms_flip:2253) DEBUG: Vblank took 18us
[101.524442] (kms_flip:2253) DEBUG: name = flip
last_ts = 101.648422
last_received_ts = 101.648216
last_seq = 1085
current_ts = 101.665092
current_received_ts = 101.664627
current_seq = 1086
count = 320
seq_step = 1
[101.524485] (kms_flip:2253) DEBUG: Vblank took 20us
[101.541339] (kms_flip:2253) DEBUG: name = flip
last_ts = 101.665092
last_received_ts = 101.664627
last_seq = 1086
current_ts = 101.681747
current_received_ts = 101.681519
current_seq = 1087
count = 321
seq_step = 1
[101.541392] (kms_flip:2253) DEBUG: Vblank took 25us
[101.557730] (kms_flip:2253) DEBUG: name = flip
last_ts = 101.681747
last_received_ts = 101.681519
last_seq = 1087
current_ts = 101.698425
current_received_ts = 101.697906
current_seq = 1088
count = 322
seq_step = 1
[101.557775] (kms_flip:2253) DEBUG: Vblank took 21us
[101.574553] (kms_flip:2253) DEBUG: name = flip
last_ts = 101.698425
last_received_ts = 101.697906
last_seq = 1088
current_ts = 101.715088
current_received_ts = 101.714729
current_seq = 1089
count = 323
seq_step = 1
[101.574596] (kms_flip:2253) DEBUG: Vblank took 20us
[101.591329] (kms_flip:2253) DEBUG: name = flip
last_ts = 101.715088
last_received_ts = 101.714729
last_seq = 1089
current_ts = 101.731758
current_received_ts = 101.731506
current_seq = 1090
count = 324
seq_step = 1
[101.591375] (kms_flip:2253) DEBUG: Vblank took 21us
[101.608113] (kms_flip:2253) DEBUG: name = flip
last_ts = 101.731758
last_received_ts = 101.731506
last_seq = 1090
current_ts = 101.748421
current_received_ts = 101.748291
current_seq = 1091
count = 325
seq_step = 1
[101.608160] (kms_flip:2253) DEBUG: Vblank took 21us
[101.624862] (kms_flip:2253) DEBUG: name = flip
last_ts = 101.748421
last_received_ts = 101.748291
last_seq = 1091
current_ts = 101.765083
current_received_ts = 101.764999
current_seq = 1092
count = 326
seq_step = 1
[101.624909] (kms_flip:2253) DEBUG: Vblank took 22us
[101.641361] (kms_flip:2253) DEBUG: name = flip
last_ts = 101.765083
last_received_ts = 101.764999
last_seq = 1092
current_ts = 101.781746
current_received_ts = 101.781540
current_seq = 1093
count = 327
seq_step = 1
[101.641409] (kms_flip:2253) DEBUG: Vblank took 22us
[101.658083] (kms_flip:2253) DEBUG: name = flip
last_ts = 101.781746
last_received_ts = 101.781540
last_seq = 1093
current_ts = 101.798416
current_received_ts = 101.798264
current_seq = 1094
count = 328
seq_step = 1
[101.658124] (kms_flip:2253) DEBUG: Vblank took 18us
[101.674420] (kms_flip:2253) DEBUG: name = flip
last_ts = 101.798416
last_received_ts = 101.798264
last_seq = 1094
current_ts = 101.815086
current_received_ts = 101.814598
current_seq = 1095
count = 329
seq_step = 1
[101.674460] (kms_flip:2253) DEBUG: Vblank took 18us
[101.691315] (kms_flip:2253) DEBUG: name = flip
last_ts = 101.815086
last_received_ts = 101.814598
last_seq = 1095
current_ts = 101.831749
current_received_ts = 101.831490
current_seq = 1096
count = 330
seq_step = 1
[101.691359] (kms_flip:2253) DEBUG: Vblank took 20us
[101.707762] (kms_flip:2253) DEBUG: name = flip
last_ts = 101.831749
last_received_ts = 101.831490
last_seq = 1096
current_ts = 101.848419
current_received_ts = 101.847939
current_seq = 1097
count = 331
seq_step = 1
[101.707830] (kms_flip:2253) DEBUG: Vblank took 43us
[101.724873] (kms_flip:2253) DEBUG: name = flip
last_ts = 101.848419
last_received_ts = 101.847939
last_seq = 1097
current_ts = 101.865089
current_received_ts = 101.865044
current_seq = 1098
count = 332
seq_step = 1
[101.724918] (kms_flip:2253) DEBUG: Vblank took 21us
[101.741273] (kms_flip:2253) DEBUG: name = flip
last_ts = 101.865089
last_received_ts = 101.865044
last_seq = 1098
current_ts = 101.881752
current_received_ts = 101.881447
current_seq = 1099
count = 333
seq_step = 1
[101.741315] (kms_flip:2253) DEBUG: Vblank took 19us
[101.758063] (kms_flip:2253) DEBUG: name = flip
last_ts = 101.881752
last_received_ts = 101.881447
last_seq = 1099
current_ts = 101.898422
current_received_ts = 101.898239
current_seq = 1100
count = 334
seq_step = 1
[101.758106] (kms_flip:2253) DEBUG: Vblank took 19us
[101.774400] (kms_flip:2253) DEBUG: name = flip
last_ts = 101.898422
last_received_ts = 101.898239
last_seq = 1100
current_ts = 101.915085
current_received_ts = 101.914574
current_seq = 1101
count = 335
seq_step = 1
[101.774443] (kms_flip:2253) DEBUG: Vblank took 20us
[101.791268] (kms_flip:2253) DEBUG: name = flip
last_ts = 101.915085
last_received_ts = 101.914574
last_seq = 1101
current_ts = 101.931740
current_received_ts = 101.931442
current_seq = 1102
count = 336
seq_step = 1
[101.791309] (kms_flip:2253) DEBUG: Vblank took 19us
[101.808121] (kms_flip:2253) DEBUG: name = flip
last_ts = 101.931740
last_received_ts = 101.931442
last_seq = 1102
current_ts = 101.948410
current_received_ts = 101.948296
current_seq = 1103
count = 337
seq_step = 1
[101.808163] (kms_flip:2253) DEBUG: Vblank took 18us
[101.824415] (kms_flip:2253) DEBUG: name = flip
last_ts = 101.948410
last_received_ts = 101.948296
last_seq = 1103
current_ts = 101.965080
current_received_ts = 101.964592
current_seq = 1104
count = 338
seq_step = 1
[101.824456] (kms_flip:2253) DEBUG: Vblank took 19us
[101.841288] (kms_flip:2253) DEBUG: name = flip
last_ts = 101.965080
last_received_ts = 101.964592
last_seq = 1104
current_ts = 101.981743
current_received_ts = 101.981461
current_seq = 1105
count = 339
seq_step = 1
[101.841330] (kms_flip:2253) DEBUG: Vblank took 20us
[101.858578] (kms_flip:2253) DEBUG: name = flip
last_ts = 101.981743
last_received_ts = 101.981461
last_seq = 1105
current_ts = 101.998405
current_received_ts = 101.998749
current_seq = 1106
count = 340
seq_step = 1
[101.858625] (kms_flip:2253) DEBUG: Vblank took 22us
[101.874690] (kms_flip:2253) DEBUG: name = flip
last_ts = 101.998405
last_received_ts = 101.998749
last_seq = 1106
current_ts = 102.015076
current_received_ts = 102.014862
current_seq = 1107
count = 341
seq_step = 1
[101.874732] (kms_flip:2253) DEBUG: Vblank took 19us
[101.891282] (kms_flip:2253) DEBUG: name = flip
last_ts = 102.015076
last_received_ts = 102.014862
last_seq = 1107
current_ts = 102.031738
current_received_ts = 102.031456
current_seq = 1108
count = 342
seq_step = 1
[101.891321] (kms_flip:2253) DEBUG: Vblank took 18us
[101.907771] (kms_flip:2253) DEBUG: name = flip
last_ts = 102.031738
last_received_ts = 102.031456
last_seq = 1108
current_ts = 102.048416
current_received_ts = 102.047935
current_seq = 1109
count = 343
seq_step = 1
[101.908951] (kms_flip:2253) DEBUG: Vblank took 1154us
[101.908965] (kms_flip:2253) CRITICAL: Test assertion failure function run_test_step, file ../tests/kms_flip.c:931:
[101.909062] (kms_flip:2253) CRITICAL: Failed assertion: end - start < 500
[101.909182] (kms_flip:2253) CRITICAL: Last errno: 4, Interrupted system call
[101.917162] (kms_flip:2253) igt_core-INFO: Stack trace:
[101.963190] (kms_flip:2253) igt_core-INFO:   #0 ../lib/igt_core.c:2074 __igt_fail_assert()
[101.965673] (kms_flip:2253) igt_core-INFO:   #1 ../tests/kms_flip.c:926 run_test_on_crtc_set()
[101.965942] (kms_flip:2253) igt_core-INFO:   #2 ../tests/kms_flip.c:2029 run_pair()
[101.966004] (kms_flip:2253) igt_core-INFO:   #3 ../tests/kms_flip.c:2227 __igt_unique____real_main2105()
[101.966094] (kms_flip:2253) igt_core-INFO:   #4 ../tests/kms_flip.c:2105 main()
[101.986771] (kms_flip:2253) igt_core-INFO:   #5 [__libc_init_first+0x8a]
[101.989259] (kms_flip:2253) igt_core-INFO:   #6 [__libc_start_main+0x8b]
[101.989801] (kms_flip:2253) igt_core-INFO:   #7 [_start+0x25]
****  END  ****
Dynamic subtest AB-HDMI-A1-HDMI-A2: FAIL (6.829s)
Dmesg
<6> [95.440093] Console: switching to colour dummy device 80x25
<6> [95.441047] [IGT] kms_flip: executing
<7> [95.453068] i915 0000:00:02.0: [drm:i915_gem_open [i915]]
<7> [95.454899] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc]
<7> [95.455656] i915 0000:00:02.0: [drm:i915_gem_open [i915]]
<7> [95.470758] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] [CONNECTOR:166:HDMI-A-1]
<7> [95.470780] i915 0000:00:02.0: [drm:intel_hdmi_detect [i915]] [CONNECTOR:166:HDMI-A-1]
<7> [95.496914] i915 0000:00:02.0: [drm:update_display_info.part.0] [CONNECTOR:166:HDMI-A-1] HDMI: DVI dual 0, max TMDS clock 340000 kHz
<7> [95.496933] i915 0000:00:02.0: [drm:update_display_info.part.0] [CONNECTOR:166:HDMI-A-1] HDMI sink does deep color 30.
<7> [95.496940] i915 0000:00:02.0: [drm:update_display_info.part.0] [CONNECTOR:166:HDMI-A-1] HDMI sink does deep color 36.
<7> [95.496946] i915 0000:00:02.0: [drm:update_display_info.part.0] [CONNECTOR:166:HDMI-A-1] Assigning HDMI sink color depth as 12 bpc.
<7> [95.496953] i915 0000:00:02.0: [drm:update_display_info.part.0] [CONNECTOR:166:HDMI-A-1] HDMI sink does YCRCB444 in deep color.
<7> [95.496959] i915 0000:00:02.0: [drm:update_display_info.part.0] [CONNECTOR:166:HDMI-A-1] HF-VSDB: max TMDS clock: 600000 KHz, HDMI 2.1 support: no, DSC 1.2 support: no
<7> [95.496968] i915 0000:00:02.0: [drm:update_display_info.part.0] [CONNECTOR:166:HDMI-A-1] ELD monitor 28E850
<7> [95.496976] i915 0000:00:02.0: [drm:update_display_info.part.0] [CONNECTOR:166:HDMI-A-1] HDMI: latency present 0 0, video latency 0 0, audio latency 0 0
<7> [95.496983] i915 0000:00:02.0: [drm:update_display_info.part.0] [CONNECTOR:166:HDMI-A-1] ELD size 32, SAD count 1
<7> [95.498117] i915 0000:00:02.0: [drm:do_gmbus_xfer [i915]] GMBUS [i915 gmbus dpb] NAK for addr: 0040 w(1)
<7> [95.498627] i915 0000:00:02.0: [drm:do_gmbus_xfer [i915]] GMBUS [i915 gmbus dpb] NAK on first message, retry
<7> [95.499158] i915 0000:00:02.0: [drm:do_gmbus_xfer [i915]] GMBUS [i915 gmbus dpb] NAK for addr: 0040 w(1)
<7> [95.499918] i915 0000:00:02.0: [drm:drm_dp_dual_mode_detect [drm_display_helper]] DP dual mode HDMI ID: (err -6)
<7> [95.502421] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] [CONNECTOR:166:HDMI-A-1] probed modes:
<7> [95.502435] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "1920x1080": 60 148500 1920 2008 2052 2200 1080 1083 1088 1125 0x48 0x9
<7> [95.502443] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "4096x2160": 60 594000 4096 4184 4272 4400 2160 2168 2178 2250 0x40 0x5
<7> [95.502451] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "4096x2160": 60 593407 4096 4184 4272 4400 2160 2168 2178 2250 0x40 0x5
<7> [95.502459] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "4096x2160": 50 594000 4096 5064 5152 5280 2160 2168 2178 2250 0x40 0x5
<7> [95.502466] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "4096x2160": 24 297000 4096 5116 5204 5500 2160 2168 2178 2250 0x40 0x5
<7> [95.502474] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "4096x2160": 24 296703 4096 5116 5204 5500 2160 2168 2178 2250 0x40 0x5
<7> [95.502481] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "3840x2160": 60 594000 3840 4016 4104 4400 2160 2162 2172 2250 0x40 0x5
<7> [95.502488] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "3840x2160": 60 594000 3840 4016 4104 4400 2160 2168 2178 2250 0x40 0x5
<7> [95.502495] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "3840x2160": 60 593407 3840 4016 4104 4400 2160 2168 2178 2250 0x40 0x5
<7> [95.502502] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "3840x2160": 50 594000 3840 4896 4984 5280 2160 2168 2178 2250 0x40 0x5
<7> [95.502509] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "3840x2160": 30 297000 3840 3888 3920 4400 2160 2164 2170 2250 0x40 0x9
<7> [95.502516] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "3840x2160": 30 297000 3840 4016 4104 4400 2160 2168 2178 2250 0x40 0x5
<7> [95.502523] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "3840x2160": 30 296703 3840 4016 4104 4400 2160 2168 2178 2250 0x40 0x5
<7> [95.502530] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "3840x2160": 25 297000 3840 4896 4984 5280 2160 2168 2178 2250 0x40 0x5
<7> [95.502537] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "3840x2160": 24 297000 3840 5116 5204 5500 2160 2168 2178 2250 0x40 0x5
<7> [95.502544] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "3840x2160": 24 296703 3840 5116 5204 5500 2160 2168 2178 2250 0x40 0x5
<7> [95.502552] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "2880x1800": 60 336720 2880 2928 2960 3040 1800 1803 1809 1846 0x40 0x9
<7> [95.502559] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "2560x1600": 60 268500 2560 2608 2640 2720 1600 1603 1609 1646 0x40 0x9
<7> [95.502566] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "2560x1440": 60 241500 2560 2608 2640 2720 1440 1443 1449 1481 0x40 0x9
<7> [95.502573] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "1920x1200": 60 154000 1920 1968 2000 2080 1200 1203 1209 1235 0x40 0x9
<7> [95.502580] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "1920x1080": 120 297000 1920 2008 2052 2200 1080 1084 1089 1125 0x40 0x5
<7> [95.502587] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "1920x1080": 120 296703 1920 2008 2052 2200 1080 1084 1089 1125 0x40 0x5
<7> [95.502594] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "1920x1080": 75 220597 1920 2056 2264 2608 1080 1081 1084 1128 0x0 0x6
<7> [95.502601] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "1920x1080i": 60 74250 1920 2008 2052 2200 1080 1084 1094 1125 0x40 0x15
<7> [95.502608] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "1920x1080i": 60 74176 1920 2008 2052 2200 1080 1084 1094 1125 0x40 0x15
<7> [95.502615] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "1920x1080": 50 148500 1920 2448 2492 2640 1080 1084 1089 1125 0x40 0x5
<7> [95.502622] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "1920x1080i": 50 74250 1920 2448 2492 2640 1080 1084 1094 1125 0x40 0x15
<7> [95.502629] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "1920x1080": 24 74250 1920 2558 2602 2750 1080 1084 1089 1125 0x40 0x5
<7> [95.502637] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "1920x1080": 24 74176 1920 2558 2602 2750 1080 1084 1089 1125 0x40 0x5
<7> [95.502644] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "1680x1050": 60 119000 1680 1728 1760 1840 1050 1053 1059 1080 0x40 0x9
<7> [95.502651] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "1600x900": 60 108000 1600 1624 1704 1800 900 901 904 1000 0x40 0x5
<7> [95.502658] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "1280x1024": 75 135000 1280 1296 1440 1688 1024 1025 1028 1066 0x40 0x5
<7> [95.502665] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "1280x1024": 61 110809 1280 1360 1496 1712 1024 1025 1028 1061 0x0 0x6
<7> [95.502672] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "1440x900": 60 88750 1440 1488 1520 1600 900 903 909 926 0x40 0x9
<7> [95.502679] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "1280x800": 60 71000 1280 1328 1360 1440 800 803 809 823 0x40 0x9
<7> [95.502686] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "1280x720": 60 74250 1280 1390 1430 1650 720 725 730 750 0x40 0x5
<7> [95.502693] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "1280x720": 60 74250 1280 1390 1430 1650 720 725 730 750 0x40 0x5
<7> [95.502700] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "1280x720": 60 74176 1280 1390 1430 1650 720 725 730 750 0x40 0x5
<7> [95.502708] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "1280x720": 50 74250 1280 1720 1760 1980 720 725 730 750 0x40 0x5
<7> [95.502715] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "1024x768": 75 78750 1024 1040 1136 1312 768 769 772 800 0x40 0x5
<7> [95.502722] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "1024x768": 70 75000 1024 1048 1184 1328 768 771 777 806 0x40 0xa
<7> [95.502729] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "1024x768": 60 65000 1024 1048 1184 1344 768 771 777 806 0x40 0xa
<7> [95.502736] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "800x600": 75 49500 800 816 896 1056 600 601 604 625 0x40 0x5
<7> [95.502743] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "800x600": 72 50000 800 856 976 1040 600 637 643 666 0x40 0x5
<7> [95.502750] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "800x600": 60 40000 800 840 968 1056 600 601 605 628 0x40 0x5
<7> [95.502757] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "800x600": 56 36000 800 824 896 1024 600 601 603 625 0x40 0x5
<7> [95.502764] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "720x576": 50 27000 720 732 796 864 576 581 586 625 0x40 0xa
<7> [95.502771] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "720x480": 60 27027 720 736 798 858 480 489 495 525 0x40 0xa
<7> [95.502778] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "720x480": 60 27000 720 736 798 858 480 489 495 525 0x40 0xa
<7> [95.502784] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "640x480": 75 31500 640 656 720 840 480 481 484 500 0x40 0xa
<7> [95.502791] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "640x480": 73 31500 640 664 704 832 480 489 492 520 0x40 0xa
<7> [95.502798] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "640x480": 60 25200 640 656 752 800 480 490 492 525 0x40 0xa
<7> [95.502805] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "640x480": 60 25175 640 656 752 800 480 490 492 525 0x40 0xa
<7> [95.502812] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "640x480": 60 25175 640 656 752 800 480 490 492 525 0x40 0xa
<7> [95.503179] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] [CONNECTOR:176:HDMI-A-2]
<7> [95.503195] i915 0000:00:02.0: [drm:intel_hdmi_detect [i915]] [CONNECTOR:176:HDMI-A-2]
<7> [95.529125] i915 0000:00:02.0: [drm:update_display_info.part.0] [CONNECTOR:176:HDMI-A-2] HDMI: DVI dual 0, max TMDS clock 340000 kHz
<7> [95.529142] i915 0000:00:02.0: [drm:update_display_info.part.0] [CONNECTOR:176:HDMI-A-2] HDMI sink does deep color 30.
<7> [95.529149] i915 0000:00:02.0: [drm:update_display_info.part.0] [CONNECTOR:176:HDMI-A-2] HDMI sink does deep color 36.
<7> [95.529156] i915 0000:00:02.0: [drm:update_display_info.part.0] [CONNECTOR:176:HDMI-A-2] Assigning HDMI sink color depth as 12 bpc.
<7> [95.529163] i915 0000:00:02.0: [drm:update_display_info.part.0] [CONNECTOR:176:HDMI-A-2] HDMI sink does YCRCB444 in deep color.
<7> [95.529169] i915 0000:00:02.0: [drm:update_display_info.part.0] [CONNECTOR:176:HDMI-A-2] HF-VSDB: max TMDS clock: 600000 KHz, HDMI 2.1 support: no, DSC 1.2 support: no
<7> [95.529179] i915 0000:00:02.0: [drm:update_display_info.part.0] [CONNECTOR:176:HDMI-A-2] ELD monitor 28E850
<7> [95.529186] i915 0000:00:02.0: [drm:update_display_info.part.0] [CONNECTOR:176:HDMI-A-2] HDMI: latency present 0 0, video latency 0 0, audio latency 0 0
<7> [95.529194] i915 0000:00:02.0: [drm:update_display_info.part.0] [CONNECTOR:176:HDMI-A-2] ELD size 32, SAD count 1
<7> [95.530326] i915 0000:00:02.0: [drm:do_gmbus_xfer [i915]] GMBUS [i915 gmbus dpc] NAK for addr: 0040 w(1)
<7> [95.530800] i915 0000:00:02.0: [drm:do_gmbus_xfer [i915]] GMBUS [i915 gmbus dpc] NAK on first message, retry
<7> [95.531417] i915 0000:00:02.0: [drm:do_gmbus_xfer [i915]] GMBUS [i915 gmbus dpc] NAK for addr: 0040 w(1)
<7> [95.531812] i915 0000:00:02.0: [drm:drm_dp_dual_mode_detect [drm_display_helper]] DP dual mode HDMI ID: (err -6)
<7> [95.534617] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] [CONNECTOR:176:HDMI-A-2] probed modes:
<7> [95.534630] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "1920x1080": 60 148500 1920 2008 2052 2200 1080 1083 1088 1125 0x48 0x9
<7> [95.534642] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "4096x2160": 60 594000 4096 4184 4272 4400 2160 2168 2178 2250 0x40 0x5
<7> [95.534650] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "4096x2160": 60 593407 4096 4184 4272 4400 2160 2168 2178 2250 0x40 0x5
<7> [95.534657] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "4096x2160": 50 594000 4096 5064 5152 5280 2160 2168 2178 2250 0x40 0x5
<7> [95.534665] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "4096x2160": 24 297000 4096 5116 5204 5500 2160 2168 2178 2250 0x40 0x5
<7> [95.534672] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "4096x2160": 24 296703 4096 5116 5204 5500 2160 2168 2178 2250 0x40 0x5
<7> [95.534679] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "3840x2160": 60 594000 3840 4016 4104 4400 2160 2162 2172 2250 0x40 0x5
<7> [95.534686] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "3840x2160": 60 594000 3840 4016 4104 4400 2160 2168 2178 2250 0x40 0x5
<7> [95.534693] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "3840x2160": 60 593407 3840 4016 4104 4400 2160 2168 2178 2250 0x40 0x5
<7> [95.534700] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "3840x2160": 50 594000 3840 4896 4984 5280 2160 2168 2178 2250 0x40 0x5
<7> [95.534707] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "3840x2160": 30 297000 3840 3888 3920 4400 2160 2164 2170 2250 0x40 0x9
<7> [95.534714] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "3840x2160": 30 297000 3840 4016 4104 4400 2160 2168 2178 2250 0x40 0x5
<7> [95.534721] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "3840x2160": 30 296703 3840 4016 4104 4400 2160 2168 2178 2250 0x40 0x5
<7> [95.534728] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "3840x2160": 25 297000 3840 4896 4984 5280 2160 2168 2178 2250 0x40 0x5
<7> [95.534735] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "3840x2160": 24 297000 3840 5116 5204 5500 2160 2168 2178 2250 0x40 0x5
<7> [95.534742] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "3840x2160": 24 296703 3840 5116 5204 5500 2160 2168 2178 2250 0x40 0x5
<7> [95.534749] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "2880x1800": 60 336720 2880 2928 2960 3040 1800 1803 1809 1846 0x40 0x9
<7> [95.534756] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "2560x1600": 60 268500 2560 2608 2640 2720 1600 1603 1609 1646 0x40 0x9
<7> [95.534763] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "2560x1440": 60 241500 2560 2608 2640 2720 1440 1443 1449 1481 0x40 0x9
<7> [95.534770] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "1920x1200": 60 154000 1920 1968 2000 2080 1200 1203 1209 1235 0x40 0x9
<7> [95.534777] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "1920x1080": 120 297000 1920 2008 2052 2200 1080 1084 1089 1125 0x40 0x5
<7> [95.534784] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "1920x1080": 120 296703 1920 2008 2052 2200 1080 1084 1089 1125 0x40 0x5
<7> [95.534791] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "1920x1080": 75 220597 1920 2056 2264 2608 1080 1081 1084 1128 0x0 0x6
<7> [95.534798] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "1920x1080i": 60 74250 1920 2008 2052 2200 1080 1084 1094 1125 0x40 0x15
<7> [95.534805] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "1920x1080i": 60 74176 1920 2008 2052 2200 1080 1084 1094 1125 0x40 0x15
<7> [95.534813] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "1920x1080": 50 148500 1920 2448 2492 2640 1080 1084 1089 1125 0x40 0x5
<7> [95.534819] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "1920x1080i": 50 74250 1920 2448 2492 2640 1080 1084 1094 1125 0x40 0x15
<7> [95.534827] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "1920x1080": 24 74250 1920 2558 2602 2750 1080 1084 1089 1125 0x40 0x5
<7> [95.534834] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "1920x1080": 24 74176 1920 2558 2602 2750 1080 1084 1089 1125 0x40 0x5
<7> [95.534841] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "1680x1050": 60 119000 1680 1728 1760 1840 1050 1053 1059 1080 0x40 0x9
<7> [95.534848] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "1600x900": 60 108000 1600 1624 1704 1800 900 901 904 1000 0x40 0x5
<7> [95.534855] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "1280x1024": 75 135000 1280 1296 1440 1688 1024 1025 1028 1066 0x40 0x5
<7> [95.534862] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "1280x1024": 61 110809 1280 1360 1496 1712 1024 1025 1028 1061 0x0 0x6
<7> [95.534869] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "1440x900": 60 88750 1440 1488 1520 1600 900 903 909 926 0x40 0x9
<7> [95.534876] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "1280x800": 60 71000 1280 1328 1360 1440 800 803 809 823 0x40 0x9
<7> [95.534883] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "1280x720": 60 74250 1280 1390 1430 1650 720 725 730 750 0x40 0x5
<7> [95.534890] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "1280x720": 60 74250 1280 1390 1430 1650 720 725 730 750 0x40 0x5
<7> [95.534897] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "1280x720": 60 74176 1280 1390 1430 1650 720 725 730 750 0x40 0x5
<7> [95.534904] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "1280x720": 50 74250 1280 1720 1760 1980 720 725 730 750 0x40 0x5
<7> [95.534911] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "1024x768": 75 78750 1024 1040 1136 1312 768 769 772 800 0x40 0x5
<7> [95.534918] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "1024x768": 70 75000 1024 1048 1184 1328 768 771 777 806 0x40 0xa
<7> [95.534925] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "1024x768": 60 65000 1024 1048 1184 1344 768 771 777 806 0x40 0xa
<7> [95.534932] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "800x600": 75 49500 800 816 896 1056 600 601 604 625 0x40 0x5
<7> [95.534939] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "800x600": 72 50000 800 856 976 1040 600 637 643 666 0x40 0x5
<7> [95.534946] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "800x600": 60 40000 800 840 968 1056 600 601 605 628 0x40 0x5
<7> [95.534953] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "800x600": 56 36000 800 824 896 1024 600 601 603 625 0x40 0x5
<7> [95.534960] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "720x576": 50 27000 720 732 796 864 576 581 586 625 0x40 0xa
<7> [95.534967] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "720x480": 60 27027 720 736 798 858 480 489 495 525 0x40 0xa
<7> [95.534974] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "720x480": 60 27000 720 736 798 858 480 489 495 525 0x40 0xa
<7> [95.534980] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "640x480": 75 31500 640 656 720 840 480 481 484 500 0x40 0xa
<7> [95.534987] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "640x480": 73 31500 640 664 704 832 480 489 492 520 0x40 0xa
<7> [95.534994] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "640x480": 60 25200 640 656 752 800 480 490 492 525 0x40 0xa
<7> [95.535001] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "640x480": 60 25175 640 656 752 800 480 490 492 525 0x40 0xa
<7> [95.535008] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "640x480": 60 25175 640 656 752 800 480 490 492 525 0x40 0xa
<6> [95.551836] [IGT] kms_flip: starting subtest 2x-flip-vs-expired-vblank-interruptible
<6> [95.558095] [IGT] kms_flip: starting dynamic subtest AB-HDMI-A1-HDMI-A2
<7> [95.560845] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:179]
<7> [95.561494] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:185]
<7> [95.681248] i915 0000:00:02.0: [drm:drm_mode_setcrtc] [CRTC:78:pipe A]
<7> [95.681923] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:78:pipe A] fastset requirement not met in hw.enable (expected yes, found no)
<7> [95.682697] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:78:pipe A] fastset requirement not met in hw.active (expected yes, found no)
<7> [95.683084] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:78:pipe A] fastset requirement not met in cpu_transcoder (expected 0, found -1)
<7> [95.683760] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:78:pipe A] fastset requirement not met in lane_count (expected 4, found 0)
<7> [95.684148] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:78:pipe A] fastset requirement not met in lane_lat_optim_mask (expected 0x0000000d, found 0x00000000)
<7> [95.684928] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:78:pipe A] fastset requirement not met in output_types (expected 0x00000040, found 0x00000000)
<7> [95.685668] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:78:pipe A] fastset requirement not met in framestart_delay (expected 1, found 0)
<7> [95.686057] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:78:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hdisplay (expected 1920, found 0)
<7> [95.686696] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:78:pipe A] fastset requirement not met in hw.pipe_mode.crtc_htotal (expected 2200, found 0)
<7> [95.687082] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:78:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hblank_start (expected 1920, found 0)
<7> [95.687666] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:78:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hblank_end (expected 2200, found 0)
<7> [95.688051] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:78:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hsync_start (expected 2008, found 0)
<7> [95.688615] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:78:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hsync_end (expected 2052, found 0)
<7> [95.689007] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:78:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vdisplay (expected 1080, found 0)
<7> [95.690552] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:78:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vblank_start (expected 1080, found 0)
<7> [95.690971] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:78:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vsync_start (expected 1083, found 0)
<7> [95.691814] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:78:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vsync_end (expected 1088, found 0)
<7> [95.692469] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:78:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vtotal (expected 1125, found 0)
<7> [95.692854] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:78:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vblank_end (expected 1125, found 0)
<7> [95.693503] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:78:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hdisplay (expected 1920, found 0)
<7> [95.693891] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:78:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_htotal (expected 2200, found 0)
<7> [95.694451] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:78:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hblank_start (expected 1920, found 0)
<7> [95.694845] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:78:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hblank_end (expected 2200, found 0)
<7> [95.696620] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:78:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hsync_start (expected 2008, found 0)
<7> [95.697042] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:78:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hsync_end (expected 2052, found 0)
<7> [95.697865] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:78:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vdisplay (expected 1080, found 0)
<7> [95.698518] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:78:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vblank_start (expected 1080, found 0)
<7> [95.698902] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:78:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vsync_start (expected 1083, found 0)
<7> [95.699492] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:78:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vsync_end (expected 1088, found 0)
<7> [95.699874] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:78:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vtotal (expected 1125, found 0)
<7> [95.700430] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:78:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vblank_end (expected 1125, found 0)
<7> [95.700815] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:78:pipe A] fastset requirement not met in pixel_multiplier (expected 1, found 0)
<7> [95.701192] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:78:pipe A] fastset requirement not met in hw.adjusted_mode.flags (1) (expected 1, found 0)
<7> [95.702560] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:78:pipe A] fastset requirement not met in hw.adjusted_mode.flags (8) (expected 8, found 0)
<7> [95.702959] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:78:pipe A] fastset requirement not met in has_hdmi_sink (expected yes, found no)
<7> [95.703664] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:78:pipe A] fastset requirement not met in has_infoframe (expected yes, found no)
<7> [95.704055] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:78:pipe A] fastset requirement not met in pipe_bpp (expected 36, found 0)
<7> [95.704747] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:78:pipe A] fastset requirement not met in hw.pipe_mode.crtc_clock (expected 148500, found 0)
<7> [95.705143] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:78:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_clock (expected 148500, found 0)
<7> [95.705745] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:78:pipe A] fastset requirement not met in port_clock (expected 222750, found 0)
<7> [95.708132] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:78:pipe A] fastset requirement not met in infoframes.enable (expected 0x00000071, found 0x00000000)
<7> [95.709098] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:78:pipe A] fastset requirement not met in infoframes.gcp (expected 0x00000006, found 0x00000000)
<7> [95.709756] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:78:pipe A] fastset requirement not met in avi infoframe
<7> [95.710139] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] expected:
<7> [95.710696] i915 0000:00:02.0: HDMI infoframe: Auxiliary Video Information (AVI), version 2, length 13
<7> [95.710702] i915 0000:00:02.0: colorspace: RGB
<7> [95.710706] i915 0000:00:02.0: scan mode: Underscan
<7> [95.710709] i915 0000:00:02.0: colorimetry: No Data
<7> [95.710712] i915 0000:00:02.0: picture aspect: No Data
<7> [95.710715] i915 0000:00:02.0: active aspect: Same as Picture
<7> [95.710718] i915 0000:00:02.0: itc: No Data
<7> [95.710721] i915 0000:00:02.0: extended colorimetry: xvYCC 601
<7> [95.710725] i915 0000:00:02.0: quantization range: Full
<7> [95.710728] i915 0000:00:02.0: nups: Unknown Non-uniform Scaling
<7> [95.710731] i915 0000:00:02.0: video code: 0
<7> [95.710734] i915 0000:00:02.0: ycc quantization range: Full
<7> [95.710737] i915 0000:00:02.0: hdmi content type: Graphics
<7> [95.710740] i915 0000:00:02.0: pixel repeat: 0
<7> [95.710743] i915 0000:00:02.0: bar top 0, bottom 0, left 0, right 0
<7> [95.710747] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] found:
<7> [95.711128] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:78:pipe A] fastset requirement not met in spd infoframe
<7> [95.711778] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] expected:
<7> [95.712164] i915 0000:00:02.0: HDMI infoframe: Source Product Description (SPD), version 1, length 25
<7> [95.712168] i915 0000:00:02.0: vendor: Intel
<7> [95.712171] i915 0000:00:02.0: product: Integrated gfx
<7> [95.712174] i915 0000:00:02.0: source device information: PC General (0x9)
<7> [95.712178] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] found:
<7> [95.714164] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:78:pipe A] fastset requirement not met in hdmi infoframe
<7> [95.714795] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] expected:
<7> [95.715177] i915 0000:00:02.0: HDMI infoframe: Vendor, version 1, length 4
<7> [95.715182] i915 0000:00:02.0: empty frame
<7> [95.715185] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] found:
<7> [95.715929] i915 0000:00:02.0: [drm:intel_atomic_check [i915]] [CRTC:78:pipe A] fastset requirement not met, forcing full modeset
<7> [95.716572] i915 0000:00:02.0: [drm:intel_dpll_crtc_put [i915]] [CRTC:78:pipe A] releasing PORT PLL B
<7> [95.717021] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] [CRTC:78:pipe A] dbuf slices 0x1 -> 0x0, ddb (0 - 510) -> (0 - 0), active pipes 0x3 -> 0x2
<7> [95.717618] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] [CRTC:121:pipe B] dbuf slices 0x1 -> 0x1, ddb (510 - 1020) -> (0 - 1020), active pipes 0x3 -> 0x2
<7> [95.718096] i915 0000:00:02.0: [drm:skl_print_plane_ddb_changes [i915]] [PLANE:36:plane 1A] ddb ( 0 - 497) -> ( 0 - 0), size 497 -> 0
<7> [95.718713] i915 0000:00:02.0: [drm:skl_print_plane_ddb_changes [i915]] [PLANE:72:cursor A] ddb ( 497 - 510) -> ( 0 - 0), size 13 -> 0
<7> [95.719093] i915 0000:00:02.0: [drm:skl_print_plane_wm_changes [i915]] [PLANE:36: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> [95.720274] i915 0000:00:02.0: [drm:skl_print_plane_wm_changes [i915]] [PLANE:36:plane 1A] lines 1, 1, 1, 2, 2, 2, 2, 2, 0, 0, 0 -> 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0
<7> [95.720666] i915 0000:00:02.0: [drm:skl_print_plane_wm_changes [i915]] [PLANE:36:plane 1A] blocks 16, 16, 16, 33, 33, 33, 33, 33, 30, 0, 0 -> 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0
<7> [95.721510] i915 0000:00:02.0: [drm:skl_print_plane_wm_changes [i915]] [PLANE:36:plane 1A] min_ddb 17, 17, 17, 34, 34, 34, 34, 34, 31, 0, 0 -> 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0
<7> [95.721924] i915 0000:00:02.0: [drm:skl_print_plane_wm_changes [i915]] [PLANE:36:plane 1A] min_ddb_uv 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0 -> 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0
<7> [95.722760] i915 0000:00:02.0: [drm:skl_print_plane_ddb_changes [i915]] [PLANE:79:plane 1B] ddb ( 510 - 1007) -> ( 0 - 988), size 497 -> 988
<7> [95.723150] i915 0000:00:02.0: [drm:skl_print_plane_ddb_changes [i915]] [PLANE:115:cursor B] ddb (1007 - 1020) -> ( 988 - 1020), size 13 -> 32
<7> [95.723836] i915 0000:00:02.0: [drm:intel_cdclk_atomic_check [i915]] [CRTC:78:pipe A] min cdclk: 192000 kHz -> 0 kHz
<7> [95.724456] i915 0000:00:02.0: [drm:intel_cdclk_update_dbuf_bw_min_cdclk [i915]] dbuf bandwidth min cdclk: 18563 kHz -> 9282 kHz
<7> [95.724851] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [CRTC:78:pipe A] enable: no [modeset]
<7> [95.725413] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:36:plane 1A] fb: [NOFB], visible: no
<7> [95.725798] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:45:plane 2A] fb: [NOFB], visible: no
<7> [95.726175] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:54:plane 3A] fb: [NOFB], visible: no
<7> [95.727706] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:63:plane 4A] fb: [NOFB], visible: no
<7> [95.728117] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:72:cursor A] fb: [NOFB], visible: no
<7> [95.729357] i915 0000:00:02.0: [drm:intel_audio_codec_disable [i915]] [CONNECTOR:166:HDMI-A-1][ENCODER:165:DDI B/PHY B] Disable audio codec on [CRTC:78:pipe A]
<7> [95.751990] i915 0000:00:02.0: [drm:intel_audio_component_get_eld [i915]] Not valid for port B
<7> [95.764842] i915 0000:00:02.0: [drm:intel_audio_component_get_power [i915]] restored AUD_FREQ_CNTRL to 0x10
<7> [95.768571] i915 0000:00:02.0: [drm:intel_disable_transcoder [i915]] disabling pipe A
<7> [95.786524] i915 0000:00:02.0: [drm:intel_ddi_disable_transcoder_func [i915]] Quirk Increase DDI disabled time
<7> [95.887759] i915 0000:00:02.0: [drm:intel_power_well_disable [i915]] disabling DDI_IO_B
<7> [95.888809] i915 0000:00:02.0: [drm:intel_dpll_disable [i915]] disable PORT PLL B (active 0x1, on? 1) for [CRTC:78:pipe A]
<7> [95.890852] i915 0000:00:02.0: [drm:intel_dpll_disable [i915]] disabling PORT PLL B
<7> [95.891629] i915 0000:00:02.0: [drm:__intel_fbc_disable [i915]] Disabling FBC on [PLANE:36:plane 1A]
<7> [95.892035] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:165:DDI B/PHY B]
<7> [95.892781] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:175:DDI C/PHY C]
<7> [95.893169] i915 0000:00:02.0: [drm:verify_connector_state [i915]] [CONNECTOR:166:HDMI-A-1]
<7> [95.905868] i915 0000:00:02.0: [drm:intel_power_well_disable [i915]] disabling dpio-common-b
<7> [95.908118] i915 0000:00:02.0: [drm:intel_modeset_verify_crtc [i915]] [CRTC:78:pipe A]
<7> [95.910391] i915 0000:00:02.0: [drm:drm_mode_setcrtc] [CRTC:121:pipe B]
<7> [95.910570] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:121:pipe B] fastset requirement not met in hw.enable (expected yes, found no)
<7> [95.911104] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:121:pipe B] fastset requirement not met in hw.active (expected yes, found no)
<7> [95.911837] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:121:pipe B] fastset requirement not met in cpu_transcoder (expected 1, found -1)
<7> [95.912444] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:121:pipe B] fastset requirement not met in lane_count (expected 4, found 0)
<7> [95.912827] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:121:pipe B] fastset requirement not met in lane_lat_optim_mask (expected 0x0000000d, found 0x00000000)
<7> [95.913214] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:121:pipe B] fastset requirement not met in output_types (expected 0x00000040, found 0x00000000)
<7> [95.914714] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:121:pipe B] fastset requirement not met in framestart_delay (expected 1, found 0)
<7> [95.915130] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:121:pipe B] fastset requirement not met in hw.pipe_mode.crtc_hdisplay (expected 1920, found 0)
<7> [95.915558] azx_init_pci: snd_hda_intel 0000:00:0e.0: Clearing TCSEL
<7> [95.915573] azx_init_pci: snd_hda_intel 0000:00:0e.0: SCH snoop: Enabled
<7> [95.916022] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:121:pipe B] fastset requirement not met in hw.pipe_mode.crtc_htotal (expected 2200, found 0)
<7> [95.916704] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:121:pipe B] fastset requirement not met in hw.pipe_mode.crtc_hblank_start (expected 1920, found 0)
<7> [95.917090] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:121:pipe B] fastset requirement not met in hw.pipe_mode.crtc_hblank_end (expected 2200, found 0)
<7> [95.917664] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:121:pipe B] fastset requirement not met in hw.pipe_mode.crtc_hsync_start (expected 2008, found 0)
<7> [95.918046] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:121:pipe B] fastset requirement not met in hw.pipe_mode.crtc_hsync_end (expected 2052, found 0)
<7> [95.918646] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:121:pipe B] fastset requirement not met in hw.pipe_mode.crtc_vdisplay (expected 1080, found 0)
<7> [95.919027] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:121:pipe B] fastset requirement not met in hw.pipe_mode.crtc_vblank_start (expected 1080, found 0)
<7> [95.920721] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:121:pipe B] fastset requirement not met in hw.pipe_mode.crtc_vsync_start (expected 1083, found 0)
<7> [95.921194] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:121:pipe B] fastset requirement not met in hw.pipe_mode.crtc_vsync_end (expected 1088, found 0)
<7> [95.921994] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:121:pipe B] fastset requirement not met in hw.pipe_mode.crtc_vtotal (expected 1125, found 0)
<7> [95.922703] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:121:pipe B] fastset requirement not met in hw.pipe_mode.crtc_vblank_end (expected 1125, found 0)
<7> [95.923088] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:121:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_hdisplay (expected 1920, found 0)
<7> [95.923649] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:121:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_htotal (expected 2200, found 0)
<7> [95.924041] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:121:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_hblank_start (expected 1920, found 0)
<7> [95.924685] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:121:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_hblank_end (expected 2200, found 0)
<7> [95.925072] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:121:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_hsync_start (expected 2008, found 0)
<7> [95.926468] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:121:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_hsync_end (expected 2052, found 0)
<7> [95.926873] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:121:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_vdisplay (expected 1080, found 0)
<7> [95.927614] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:121:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_vblank_start (expected 1080, found 0)
<7> [95.928002] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:121:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_vsync_start (expected 1083, found 0)
<7> [95.928702] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:121:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_vsync_end (expected 1088, found 0)
<7> [95.929086] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:121:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_vtotal (expected 1125, found 0)
<7> [95.929684] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:121:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_vblank_end (expected 1125, found 0)
<7> [95.930067] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:121:pipe B] fastset requirement not met in pixel_multiplier (expected 1, found 0)
<7> [95.930626] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:121:pipe B] fastset requirement not met in hw.adjusted_mode.flags (1) (expected 1, found 0)
<7> [95.931013] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:121:pipe B] fastset requirement not met in hw.adjusted_mode.flags (8) (expected 8, found 0)
<7> [95.932458] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:121:pipe B] fastset requirement not met in has_hdmi_sink (expected yes, found no)
<7> [95.932878] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:121:pipe B] fastset requirement not met in has_infoframe (expected yes, found no)
<7> [95.933631] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:121:pipe B] fastset requirement not met in pipe_bpp (expected 36, found 0)
<7> [95.934022] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:121:pipe B] fastset requirement not met in hw.pipe_mode.crtc_clock (expected 148500, found 0)
<7> [95.934683] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:121:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_clock (expected 148500, found 0)
<7> [95.935069] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:121:pipe B] fastset requirement not met in port_clock (expected 222750, found 0)
<7> [95.935662] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:121:pipe B] fastset requirement not met in infoframes.enable (expected 0x00000071, found 0x00000000)
<7> [95.936045] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:121:pipe B] fastset requirement not met in infoframes.gcp (expected 0x00000006, found 0x00000000)
<7> [95.936618] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:121:pipe B] fastset requirement not met in avi infoframe
<7> [95.936999] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] expected:
<7> [95.938306] i915 0000:00:02.0: HDMI infoframe: Auxiliary Video Information (AVI), version 2, length 13
<7> [95.938312] i915 0000:00:02.0: colorspace: RGB
<7> [95.938316] i915 0000:00:02.0: scan mode: Underscan
<7> [95.938319] i915 0000:00:02.0: colorimetry: No Data
<7> [95.938322] i915 0000:00:02.0: picture aspect: No Data
<7> [95.938325] i915 0000:00:02.0: active aspect: Same as Picture
<7> [95.938328] i915 0000:00:02.0: itc: No Data
<7> [95.938331] i915 0000:00:02.0: extended colorimetry: xvYCC 601
<7> [95.938334] i915 0000:00:02.0: quantization range: Full
<7> [95.938337] i915 0000:00:02.0: nups: Unknown Non-uniform Scaling
<7> [95.938340] i915 0000:00:02.0: video code: 0
<7> [95.938343] i915 0000:00:02.0: ycc quantization range: Full
<7> [95.938346] i915 0000:00:02.0: hdmi content type: Graphics
<7> [95.938349] i915 0000:00:02.0: pixel repeat: 0
<7> [95.938352] i915 0000:00:02.0: bar top 0, bottom 0, left 0, right 0
<7> [95.938356] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] found:
<7> [95.938750] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:121:pipe B] fastset requirement not met in spd infoframe
<7> [95.939594] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] expected:
<7> [95.939981] i915 0000:00:02.0: HDMI infoframe: Source Product Description (SPD), version 1, length 25
<7> [95.939985] i915 0000:00:02.0: vendor: Intel
<7> [95.939989] i915 0000:00:02.0: product: Integrated gfx
<7> [95.939992] i915 0000:00:02.0: source device information: PC General (0x9)
<7> [95.939996] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] found:
<7> [95.940661] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:121:pipe B] fastset requirement not met in hdmi infoframe
<7> [95.941047] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] expected:
<7> [95.941602] i915 0000:00:02.0: HDMI infoframe: Vendor, version 1, length 4
<7> [95.941606] i915 0000:00:02.0: empty frame
<7> [95.941610] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] found:
<7> [95.941991] i915 0000:00:02.0: [drm:intel_atomic_check [i915]] [CRTC:121:pipe B] fastset requirement not met, forcing full modeset
<7> [95.942598] i915 0000:00:02.0: [drm:intel_dpll_crtc_put [i915]] [CRTC:121:pipe B] releasing PORT PLL C
<7> [95.943053] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] [CRTC:121:pipe B] dbuf slices 0x1 -> 0x0, ddb (0 - 1020) -> (0 - 0), active pipes 0x2 -> 0x0
<7> [95.944848] i915 0000:00:02.0: [drm:skl_print_plane_ddb_changes [i915]] [PLANE:79:plane 1B] ddb ( 0 - 988) -> ( 0 - 0), size 988 -> 0
<7> [95.945619] i915 0000:00:02.0: [drm:skl_print_plane_ddb_changes [i915]] [PLANE:115:cursor B] ddb ( 988 - 1020) -> ( 0 - 0), size 32 -> 0
<7> [95.946003] i915 0000:00:02.0: [drm:skl_print_plane_wm_changes [i915]] [PLANE:79:plane 1B] level *wm0,*wm1,*wm2,*wm3,*wm4,*wm5,*wm6,*wm7,*twm, swm, stwm -> wm0, wm1, wm2, wm3, wm4, wm5, wm6, wm7, twm, swm, stwm
<7> [95.946653] i915 0000:00:02.0: [drm:skl_print_plane_wm_changes [i915]] [PLANE:79:plane 1B] lines 1, 1, 1, 2, 2, 2, 2, 2, 0, 0, 0 -> 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0
<7> [95.947034] i915 0000:00:02.0: [drm:skl_print_plane_wm_changes [i915]] [PLANE:79:plane 1B] blocks 16, 16, 16, 33, 33, 33, 33, 33, 30, 0, 0 -> 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0
<7> [95.947625] i915 0000:00:02.0: [drm:skl_print_plane_wm_changes [i915]] [PLANE:79:plane 1B] min_ddb 17, 17, 17, 34, 34, 34, 34, 34, 31, 0, 0 -> 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0
<7> [95.948003] i915 0000:00:02.0: [drm:skl_print_plane_wm_changes [i915]] [PLANE:79:plane 1B] min_ddb_uv 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0 -> 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0
<7> [95.948679] i915 0000:00:02.0: [drm:intel_cdclk_atomic_check [i915]] [CRTC:121:pipe B] min cdclk: 192000 kHz -> 0 kHz
<7> [95.949110] i915 0000:00:02.0: [drm:intel_cdclk_update_dbuf_bw_min_cdclk [i915]] dbuf bandwidth min cdclk: 9282 kHz -> 0 kHz
<7> [95.950481] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [CRTC:121:pipe B] enable: no [modeset]
<7> [95.950888] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:79:plane 1B] fb: [NOFB], visible: no
<7> [95.951629] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:88:plane 2B] fb: [NOFB], visible: no
<7> [95.952020] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:97:plane 3B] fb: [NOFB], visible: no
<7> [95.952686] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:106:plane 4B] fb: [NOFB], visible: no
<7> [95.953071] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:115:cursor B] fb: [NOFB], visible: no
<7> [95.953744] i915 0000:00:02.0: [drm:intel_audio_codec_disable [i915]] [CONNECTOR:176:HDMI-A-2][ENCODER:175:DDI C/PHY C] Disable audio codec on [CRTC:121:pipe B]
<7> [95.972119] i915 0000:00:02.0: [drm:intel_audio_component_get_eld [i915]] Not valid for port C
<7> [95.972737] i915 0000:00:02.0: [drm:intel_disable_transcoder [i915]] disabling pipe B
<7> [95.990291] i915 0000:00:02.0: [drm:intel_ddi_disable_transcoder_func [i915]] Quirk Increase DDI disabled time
<7> [96.095840] i915 0000:00:02.0: [drm:intel_power_well_disable [i915]] disabling DDI_IO_C
<7> [96.096876] i915 0000:00:02.0: [drm:intel_dpll_disable [i915]] disable PORT PLL C (active 0x2, on? 1) for [CRTC:121:pipe B]
<7> [96.099032] i915 0000:00:02.0: [drm:intel_dpll_disable [i915]] disabling PORT PLL C
<7> [96.099831] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:165:DDI B/PHY B]
<7> [96.100223] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:175:DDI C/PHY C]
<7> [96.100936] i915 0000:00:02.0: [drm:verify_connector_state [i915]] [CONNECTOR:176:HDMI-A-2]
<7> [96.101726] i915 0000:00:02.0: [drm:intel_power_well_disable [i915]] disabling dpio-common-c
<7> [96.102180] i915 0000:00:02.0: [drm:intel_modeset_verify_crtc [i915]] [CRTC:121:pipe B]
<7> [96.103540] i915 0000:00:02.0: [drm:intel_cdclk_atomic_check [i915]] Modeset required for cdclk change
<7> [96.103968] i915 0000:00:02.0: [drm:intel_cdclk_atomic_check [i915]] New cdclk calculated to be logical 79200 kHz, actual 79200 kHz
<7> [96.104374] i915 0000:00:02.0: [drm:intel_cdclk_atomic_check [i915]] New voltage level calculated to be logical 4, actual 4
<7> [96.106211] i915 0000:00:02.0: [drm:intel_set_cdclk [i915]] Pre changing CDCLK to 79200 kHz, VCO 633600 kHz, ref 19200 kHz, bypass 19200 kHz, voltage level 4
<7> [96.107153] i915 0000:00:02.0: [drm:drm_mode_setcrtc] [CRTC:164:pipe C]
<7> [96.109752] i915 0000:00:02.0: [drm:drm_mode_setcrtc] [CRTC:121:pipe B]
<7> [96.109819] i915 0000:00:02.0: [drm:drm_mode_setcrtc] [CONNECTOR:176:HDMI-A-2]
<7> [96.110029] i915 0000:00:02.0: [drm:intel_hdmi_compute_output_format [i915]] picking 12 bpc for HDMI output (pipe bpp: 36)
<7> [96.110825] i915 0000:00:02.0: [drm:intel_atomic_check [i915]] [CRTC:121:pipe B] hw max bpp: 36, pipe bpp: 36, dithering: 0
<7> [96.111226] i915 0000:00:02.0: [drm:intel_ddi_compute_config_late [i915]] [ENCODER:175:DDI C/PHY C] [CRTC:121:pipe B]
<7> [96.111925] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:121:pipe B] fastset requirement not met in hw.enable (expected no, found yes)
<7> [96.112496] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:121:pipe B] fastset requirement not met in hw.active (expected no, found yes)
<7> [96.112890] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:121:pipe B] fastset requirement not met in cpu_transcoder (expected -1, found 1)
<7> [96.113455] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:121:pipe B] fastset requirement not met in lane_count (expected 0, found 4)
<7> [96.113845] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:121:pipe B] fastset requirement not met in lane_lat_optim_mask (expected 0x00000000, found 0x0000000d)
<7> [96.114376] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:121:pipe B] fastset requirement not met in output_types (expected 0x00000000, found 0x00000040)
<7> [96.114770] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:121:pipe B] fastset requirement not met in framestart_delay (expected 0, found 1)
<7> [96.115152] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:121:pipe B] fastset requirement not met in hw.pipe_mode.crtc_hdisplay (expected 0, found 1920)
<7> [96.115769] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:121:pipe B] fastset requirement not met in hw.pipe_mode.crtc_htotal (expected 0, found 2200)
<7> [96.116154] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:121:pipe B] fastset requirement not met in hw.pipe_mode.crtc_hblank_start (expected 0, found 1920)
<7> [96.116709] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:121:pipe B] fastset requirement not met in hw.pipe_mode.crtc_hblank_end (expected 0, found 2200)
<7> [96.117095] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:121:pipe B] fastset requirement not met in hw.pipe_mode.crtc_hsync_start (expected 0, found 2008)
<7> [96.117652] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:121:pipe B] fastset requirement not met in hw.pipe_mode.crtc_hsync_end (expected 0, found 2052)
<7> [96.118042] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:121:pipe B] fastset requirement not met in hw.pipe_mode.crtc_vdisplay (expected 0, found 1080)
<7> [96.118623] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:121:pipe B] fastset requirement not met in hw.pipe_mode.crtc_vblank_start (expected 0, found 1080)
<7> [96.119031] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:121:pipe B] fastset requirement not met in hw.pipe_mode.crtc_vsync_start (expected 0, found 1083)
<7> [96.119669] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:121:pipe B] fastset requirement not met in hw.pipe_mode.crtc_vsync_end (expected 0, found 1088)
<7> [96.120088] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:121:pipe B] fastset requirement not met in hw.pipe_mode.crtc_vtotal (expected 0, found 1125)
<7> [96.120700] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:121:pipe B] fastset requirement not met in hw.pipe_mode.crtc_vblank_end (expected 0, found 1125)
<7> [96.121091] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:121:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_hdisplay (expected 0, found 1920)
<7> [96.121945] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:121:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_htotal (expected 0, found 2200)
<7> [96.122716] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:121:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_hblank_start (expected 0, found 1920)
<7> [96.123168] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:121:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_hblank_end (expected 0, found 2200)
<7> [96.123759] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:121:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_hsync_start (expected 0, found 2008)
<7> [96.124157] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:121:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_hsync_end (expected 0, found 2052)
<7> [96.124721] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:121:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_vdisplay (expected 0, found 1080)
<7> [96.125113] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:121:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_vblank_start (expected 0, found 1080)
<7> [96.125672] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:121:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_vsync_start (expected 0, found 1083)
<7> [96.126060] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:121:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_vsync_end (expected 0, found 1088)
<7> [96.126675] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:121:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_vtotal (expected 0, found 1125)
<7> [96.127088] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:121:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_vblank_end (expected 0, found 1125)
<7> [96.127642] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:121:pipe B] fastset requirement not met in pixel_multiplier (expected 0, found 1)
<7> [96.128026] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:121:pipe B] fastset requirement not met in hw.adjusted_mode.flags (1) (expected 0, found 1)
<7> [96.128592] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:121:pipe B] fastset requirement not met in hw.adjusted_mode.flags (8) (expected 0, found 8)
<7> [96.128977] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:121:pipe B] fastset requirement not met in has_hdmi_sink (expected no, found yes)
<7> [96.129657] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:121:pipe B] fastset requirement not met in has_infoframe (expected no, found yes)
<7> [96.130055] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:121:pipe B] fastset requirement not met in pipe_bpp (expected 0, found 36)
<7> [96.130652] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:121:pipe B] fastset requirement not met in hw.pipe_mode.crtc_clock (expected 0, found 148500)
<7> [96.131048] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:121:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_clock (expected 0, found 148500)
<7> [96.131606] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:121:pipe B] fastset requirement not met in port_clock (expected 0, found 222750)
<7> [96.131993] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:121:pipe B] fastset requirement not met in infoframes.enable (expected 0x00000000, found 0x00000071)
<7> [96.132549] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:121:pipe B] fastset requirement not met in infoframes.gcp (expected 0x00000000, found 0x00000006)
<7> [96.132936] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:121:pipe B] fastset requirement not met in avi infoframe
<7> [96.133532] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] expected:
<7> [96.133925] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] found:
<7> [96.134485] i915 0000:00:02.0: HDMI infoframe: Auxiliary Video Information (AVI), version 2, length 13
<7> [96.134490] i915 0000:00:02.0: colorspace: RGB
<7> [96.134494] i915 0000:00:02.0: scan mode: Underscan
<7> [96.134497] i915 0000:00:02.0: colorimetry: No Data
<7> [96.134500] i915 0000:00:02.0: picture aspect: No Data
<7> [96.134504] i915 0000:00:02.0: active aspect: Same as Picture
<7> [96.134507] i915 0000:00:02.0: itc: No Data
<7> [96.134510] i915 0000:00:02.0: extended colorimetry: xvYCC 601
<7> [96.134513] i915 0000:00:02.0: quantization range: Full
<7> [96.134516] i915 0000:00:02.0: nups: Unknown Non-uniform Scaling
<7> [96.134519] i915 0000:00:02.0: video code: 0
<7> [96.134522] i915 0000:00:02.0: ycc quantization range: Full
<7> [96.134525] i915 0000:00:02.0: hdmi content type: Graphics
<7> [96.134529] i915 0000:00:02.0: pixel repeat: 0
<7> [96.134532] i915 0000:00:02.0: bar top 0, bottom 0, left 0, right 0
<7> [96.134535] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:121:pipe B] fastset requirement not met in spd infoframe
<7> [96.134921] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] expected:
<7> [96.135492] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] found:
<7> [96.135888] i915 0000:00:02.0: HDMI infoframe: Source Product Description (SPD), version 1, length 25
<7> [96.135892] i915 0000:00:02.0: vendor: Intel
<7> [96.135896] i915 0000:00:02.0: product: Integrated gfx
<7> [96.135899] i915 0000:00:02.0: source device information: PC General (0x9)
<7> [96.135903] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:121:pipe B] fastset requirement not met in hdmi infoframe
<7> [96.136572] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] expected:
<7> [96.136962] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] found:
<7> [96.137510] i915 0000:00:02.0: HDMI infoframe: Vendor, version 1, length 4
<7> [96.137515] i915 0000:00:02.0: empty frame
<7> [96.137520] i915 0000:00:02.0: [drm:intel_atomic_check [i915]] [CRTC:121:pipe B] fastset requirement not met, forcing full modeset
<7> [96.137992] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] [CRTC:121:pipe B] dbuf slices 0x0 -> 0x1, ddb (0 - 0) -> (0 - 1020), active pipes 0x0 -> 0x2
<7> [96.138640] i915 0000:00:02.0: [drm:skl_print_plane_ddb_changes [i915]] [PLANE:79:plane 1B] ddb ( 0 - 0) -> ( 0 - 988), size 0 -> 988
<7> [96.139029] i915 0000:00:02.0: [drm:skl_print_plane_ddb_changes [i915]] [PLANE:115:cursor B] ddb ( 0 - 0) -> ( 988 - 1020), size 0 -> 32
<7> [96.139583] i915 0000:00:02.0: [drm:skl_print_plane_wm_changes [i915]] [PLANE:79:plane 1B] level wm0, wm1, wm2, wm3, wm4, wm5, wm6, wm7, twm, swm, stwm -> *wm0,*wm1,*wm2,*wm3,*wm4,*wm5,*wm6,*wm7,*twm, swm, stwm
<7> [96.139970] i915 0000:00:02.0: [drm:skl_print_plane_wm_changes [i915]] [PLANE:79:plane 1B] lines 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0 -> 1, 1, 1, 2, 2, 2, 2, 2, 0, 0, 0
<7> [96.140524] i915 0000:00:02.0: [drm:skl_print_plane_wm_changes [i915]] [PLANE:79:plane 1B] blocks 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0 -> 16, 16, 16, 33, 33, 33, 33, 33, 30, 0, 0
<7> [96.140908] i915 0000:00:02.0: [drm:skl_print_plane_wm_changes [i915]] [PLANE:79:plane 1B] min_ddb 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0 -> 17, 17, 17, 34, 34, 34, 34, 34, 31, 0, 0
<7> [96.141557] i915 0000:00:02.0: [drm:skl_print_plane_wm_changes [i915]] [PLANE:79:plane 1B] min_ddb_uv 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0 -> 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0
<7> [96.141991] i915 0000:00:02.0: [drm:intel_cdclk_atomic_check [i915]] [CRTC:121:pipe B] min cdclk: 0 kHz -> 192000 kHz
<7> [96.142605] i915 0000:00:02.0: [drm:intel_cdclk_update_dbuf_bw_min_cdclk [i915]] dbuf bandwidth min cdclk: 0 kHz -> 9282 kHz
<7> [96.143042] i915 0000:00:02.0: [drm:intel_cdclk_atomic_check [i915]] Modeset required for cdclk change
<7> [96.143615] i915 0000:00:02.0: [drm:intel_cdclk_atomic_check [i915]] New cdclk calculated to be logical 316800 kHz, actual 316800 kHz
<7> [96.143997] i915 0000:00:02.0: [drm:intel_cdclk_atomic_check [i915]] New voltage level calculated to be logical 13, actual 13
<7> [96.144556] i915 0000:00:02.0: [drm:bxt_get_dpll [i915]] [CRTC:121:pipe B] using pre-allocated PORT PLL C
<7> [96.144952] i915 0000:00:02.0: [drm:intel_dpll_crtc_get [i915]] [CRTC:121:pipe B] reserving PORT PLL C
<7> [96.145522] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [CRTC:121:pipe B] enable: yes [modeset]
<7> [96.145917] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] active: yes, output_types: HDMI (0x40), output format: RGB, sink format: RGB
<7> [96.146555] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] cpu_transcoder: B, pipe bpp: 36, dithering: 0
<7> [96.146952] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] MST master transcoder: <invalid>
<7> [96.147602] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] port sync: master transcoder: <invalid>, slave transcoder bitmask = 0x0
<7> [96.147985] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] joiner: no, pipes: 0x0
<7> [96.148549] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] splitter: disabled, link count 0, overlap 0
<7> [96.148934] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] audio: 1, infoframes: 1, infoframes enabled: 0x71
<7> [96.149488] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] GCP: 0x6
<7> [96.149872] i915 0000:00:02.0: HDMI infoframe: Auxiliary Video Information (AVI), version 2, length 13
<7> [96.149876] i915 0000:00:02.0: colorspace: RGB
<7> [96.149880] i915 0000:00:02.0: scan mode: Underscan
<7> [96.149883] i915 0000:00:02.0: colorimetry: No Data
<7> [96.149886] i915 0000:00:02.0: picture aspect: No Data
<7> [96.149889] i915 0000:00:02.0: active aspect: Same as Picture
<7> [96.149892] i915 0000:00:02.0: itc: No Data
<7> [96.149895] i915 0000:00:02.0: extended colorimetry: xvYCC 601
<7> [96.149898] i915 0000:00:02.0: quantization range: Full
<7> [96.149901] i915 0000:00:02.0: nups: Unknown Non-uniform Scaling
<7> [96.149904] i915 0000:00:02.0: video code: 0
<7> [96.149907] i915 0000:00:02.0: ycc quantization range: Full
<7> [96.149910] i915 0000:00:02.0: hdmi content type: Graphics
<7> [96.149913] i915 0000:00:02.0: pixel repeat: 0
<7> [96.149916] i915 0000:00:02.0: bar top 0, bottom 0, left 0, right 0
<7> [96.149920] i915 0000:00:02.0: HDMI infoframe: Source Product Description (SPD), version 1, length 25
<7> [96.149923] i915 0000:00:02.0: vendor: Intel
<7> [96.149927] i915 0000:00:02.0: product: Integrated gfx
<7> [96.149930] i915 0000:00:02.0: source device information: PC General (0x9)
<7> [96.149933] i915 0000:00:02.0: HDMI infoframe: Vendor, version 1, length 4
<7> [96.149937] i915 0000:00:02.0: empty frame
<7> [96.149940] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] ELD: 10 00 07 00 66 10 00 01 00 00 00 00 00 00 00 00
<7> [96.150635] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] ELD: 05 e3 cd 0c 32 38 45 38 35 30 09 07 07 00 00 00
<7> [96.151032] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] scanline offset: 2
<7> [96.151610] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] framestart delay: 1, MSA timing delay: 0, set context latency: 0
<7> [96.152018] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] vrr: no, fixed rr: no, vmin: 0, vmax: 0, flipline: 0, pipeline full: 0, guardband: 0 vsync start: 0, vsync end: 0
<7> [96.152615] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] vrr: vmin vblank: 0, vmax vblank: 0, vmin vtotal: 0, vmax vtotal: 0
<7> [96.152995] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] vrr: dc balance: no, vmin: 0 vmax: 0 guardband: 0, slope: 0 max increase: 0 max decrease: 0 vblank target: 0
<7> [96.153575] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] requested mode: "1920x1080": 60 148500 1920 2008 2052 2200 1080 1083 1088 1125 0x48 0x9
<7> [96.153957] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] adjusted mode: "1920x1080": 60 148500 1920 2008 2052 2200 1080 1083 1088 1125 0x48 0x9
<7> [96.154517] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] crtc timings: clock=148500, hd=1920 hb=1920-2200 hs=2008-2052 ht=2200, vd=1080 vb=1080-1125 vs=1083-1088 vt=1125, flags=0x9
<7> [96.154903] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pipe mode: "1920x1080": 60 148500 1920 2008 2052 2200 1080 1083 1088 1125 0x40 0x9
<7> [96.155475] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] crtc timings: clock=148500, hd=1920 hb=1920-2200 hs=2008-2052 ht=2200, vd=1080 vb=1080-1125 vs=1083-1088 vt=1125, flags=0x9
<7> [96.155863] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] port clock: 222750, pixel rate 148500, min cdclk 192000, min voltage level 0
<7> [96.157267] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] linetime: 59, ips linetime: 0
<7> [96.157681] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] num_scalers: 2, scaler_users: 0x0, scaler_id: -1, scaling_filter: 0, sharpness_strength: 0
<7> [96.158062] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pipe src: 1920x1080+0+0
<7> [96.158741] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pch pfit: 0x0+0+0, disabled, force thru: no
<7> [96.159134] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] sharpness strength: 0, sharpness tap size: 0, sharpness enable: 0
<7> [96.159694] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] ips: 0, double wide: 0, drrs: 0
<7> [96.160083] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] dpll_hw_state: ebb0: 0x6200, ebb4: 0x2000,pll0: 0x21, pll1: 0x100, pll2: 0x1a6666, pll3: 0x10000, pll6: 0x30904, pll8: 0x8, pll9: 0xa, pll10: 0x8003c00, pcsdw12: 0x4d
<7> [96.160659] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] csc_mode: 0x0 gamma_mode: 0x0 gamma_enable: 0 csc_enable: 0
<7> [96.161045] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pre csc lut: 0 entries, post csc lut: 0 entries
<7> [96.161623] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pipe csc: pre offsets: 0x0000 0x0000 0x0000
<7> [96.162011] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pipe csc: coefficients: 0x0000 0x0000 0x0000
<7> [96.163494] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pipe csc: coefficients: 0x0000 0x0000 0x0000
<7> [96.163916] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pipe csc: coefficients: 0x0000 0x0000 0x0000
<7> [96.164476] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pipe csc: post offsets: 0x0000 0x0000 0x0000
<7> [96.164861] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:79:plane 1B] fb: [FB:179] 1920x1080 format = XR24 little-endian (0x34325258) modifier = 0x100000000000001, visible: yes
<7> [96.165508] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] rotation: 0x1, scaler: -1, scaling_filter: 0
<7> [96.165900] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] src: 1920.000000x1080.000000+0.000000+0.000000 dst: 1920x1080+0+0
<7> [96.166498] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:88:plane 2B] fb: [NOFB], visible: no
<7> [96.166892] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:97:plane 3B] fb: [NOFB], visible: no
<7> [96.168139] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:106:plane 4B] fb: [NOFB], visible: no
<7> [96.168746] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:115:cursor B] fb: [NOFB], visible: no
<7> [96.173758] i915 0000:00:02.0: [drm:intel_power_well_enable [i915]] enabling dpio-common-c
<7> [96.174679] i915 0000:00:02.0: [drm:intel_set_cdclk [i915]] Pre changing CDCLK to 316800 kHz, VCO 633600 kHz, ref 19200 kHz, bypass 19200 kHz, voltage level 13
<7> [96.175113] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:165:DDI B/PHY B]
<7> [96.175786] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:175:DDI C/PHY C]
<7> [96.176556] i915 0000:00:02.0: [drm:intel_dpll_enable [i915]] enable PORT PLL C (active 0x2, on? 0) for [CRTC:121:pipe B]
<7> [96.176966] i915 0000:00:02.0: [drm:intel_dpll_enable [i915]] enabling PORT PLL C
<7> [96.178398] i915 0000:00:02.0: [drm:intel_power_well_enable [i915]] enabling DDI_IO_C
<7> [96.178939] i915 0000:00:02.0: [drm:intel_enable_transcoder [i915]] enabling pipe B
<7> [96.213344] i915 0000:00:02.0: [drm:intel_audio_codec_enable [i915]] [CONNECTOR:176:HDMI-A-2][ENCODER:175:DDI C/PHY C] Enable audio codec on [CRTC:121:pipe B], 32 bytes ELD
<7> [96.229992] i915 0000:00:02.0: [drm:audio_config_hdmi_pixel_clock [i915]] Configuring HDMI audio for pixel clock 148500 (0x00090000)
<7> [96.230509] i915 0000:00:02.0: [drm:hsw_audio_config_update [i915]] using automatic N
<7> [96.231069] i915 0000:00:02.0: [drm:verify_connector_state [i915]] [CONNECTOR:176:HDMI-A-2]
<7> [96.232943] i915 0000:00:02.0: [drm:intel_modeset_verify_crtc [i915]] [CRTC:121:pipe B]
<7> [96.236040] i915 0000:00:02.0: [drm:drm_mode_setcrtc] [CRTC:78:pipe A]
<7> [96.236103] i915 0000:00:02.0: [drm:drm_mode_setcrtc] [CONNECTOR:166:HDMI-A-1]
<7> [96.237307] i915 0000:00:02.0: [drm:intel_hdmi_compute_output_format [i915]] picking 12 bpc for HDMI output (pipe bpp: 36)
<7> [96.237955] i915 0000:00:02.0: [drm:intel_atomic_check [i915]] [CRTC:78:pipe A] hw max bpp: 36, pipe bpp: 36, dithering: 0
<7> [96.239139] i915 0000:00:02.0: [drm:intel_ddi_compute_config_late [i915]] [ENCODER:165:DDI B/PHY B] [CRTC:78:pipe A]
<7> [96.239720] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:78:pipe A] fastset requirement not met in hw.enable (expected no, found yes)
<7> [96.240106] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:78:pipe A] fastset requirement not met in hw.active (expected no, found yes)
<7> [96.240956] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:78:pipe A] fastset requirement not met in cpu_transcoder (expected -1, found 0)
<7> [96.241646] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:78:pipe A] fastset requirement not met in lane_count (expected 0, found 4)
<7> [96.242032] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:78:pipe A] fastset requirement not met in lane_lat_optim_mask (expected 0x00000000, found 0x0000000d)
<7> [96.242644] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:78:pipe A] fastset requirement not met in output_types (expected 0x00000000, found 0x00000040)
<7> [96.243033] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:78:pipe A] fastset requirement not met in framestart_delay (expected 0, found 1)
<7> [96.243587] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:78:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hdisplay (expected 0, found 1920)
<7> [96.243972] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:78:pipe A] fastset requirement not met in hw.pipe_mode.crtc_htotal (expected 0, found 2200)
<7> [96.245303] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:78:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hblank_start (expected 0, found 1920)
<7> [96.245703] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:78:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hblank_end (expected 0, found 2200)
<7> [96.246086] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:78:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hsync_start (expected 0, found 2008)
<7> [96.246912] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:78:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hsync_end (expected 0, found 2052)
<7> [96.247626] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:78:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vdisplay (expected 0, found 1080)
<7> [96.248013] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:78:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vblank_start (expected 0, found 1080)
<7> [96.248601] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:78:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vsync_start (expected 0, found 1083)
<7> [96.248984] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:78:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vsync_end (expected 0, found 1088)
<7> [96.249544] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:78:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vtotal (expected 0, found 1125)
<7> [96.249929] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:78:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vblank_end (expected 0, found 1125)
<7> [96.251326] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:78:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hdisplay (expected 0, found 1920)
<7> [96.251741] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:78:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_htotal (expected 0, found 2200)
<7> [96.252121] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:78:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hblank_start (expected 0, found 1920)
<7> [96.252990] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:78:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hblank_end (expected 0, found 2200)
<7> [96.253685] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:78:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hsync_start (expected 0, found 2008)
<7> [96.254071] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:78:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hsync_end (expected 0, found 2052)
<7> [96.254664] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:78:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vdisplay (expected 0, found 1080)
<7> [96.255048] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:78:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vblank_start (expected 0, found 1080)
<7> [96.255605] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:78:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vsync_start (expected 0, found 1083)
<7> [96.255991] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:78:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vsync_end (expected 0, found 1088)
<7> [96.257317] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:78:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vtotal (expected 0, found 1125)
<7> [96.257717] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:78:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vblank_end (expected 0, found 1125)
<7> [96.258098] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:78:pipe A] fastset requirement not met in pixel_multiplier (expected 0, found 1)
<7> [96.258815] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:78:pipe A] fastset requirement not met in hw.adjusted_mode.flags (1) (expected 0, found 1)
<7> [96.259201] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:78:pipe A] fastset requirement not met in hw.adjusted_mode.flags (8) (expected 0, found 8)
<7> [96.259828] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:78:pipe A] fastset requirement not met in has_hdmi_sink (expected no, found yes)
<7> [96.260214] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:78:pipe A] fastset requirement not met in has_infoframe (expected no, found yes)
<7> [96.260809] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:78:pipe A] fastset requirement not met in pipe_bpp (expected 0, found 36)
<7> [96.261192] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:78:pipe A] fastset requirement not met in hw.pipe_mode.crtc_clock (expected 0, found 148500)
<7> [96.261747] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:78:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_clock (expected 0, found 148500)
<7> [96.262132] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:78:pipe A] fastset requirement not met in port_clock (expected 0, found 222750)
<7> [96.263465] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:78:pipe A] fastset requirement not met in infoframes.enable (expected 0x00000000, found 0x00000071)
<7> [96.263890] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:78:pipe A] fastset requirement not met in infoframes.gcp (expected 0x00000000, found 0x00000006)
<7> [96.264726] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:78:pipe A] fastset requirement not met in avi infoframe
<7> [96.265116] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] expected:
<7> [96.265798] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] found:
<7> [96.266180] i915 0000:00:02.0: HDMI infoframe: Auxiliary Video Information (AVI), version 2, length 13
<7> [96.266184] i915 0000:00:02.0: colorspace: RGB
<7> [96.266188] i915 0000:00:02.0: scan mode: Underscan
<7> [96.266191] i915 0000:00:02.0: colorimetry: No Data
<7> [96.266194] i915 0000:00:02.0: picture aspect: No Data
<7> [96.266197] i915 0000:00:02.0: active aspect: Same as Picture
<7> [96.266201] i915 0000:00:02.0: itc: No Data
<7> [96.266204] i915 0000:00:02.0: extended colorimetry: xvYCC 601
<7> [96.266207] i915 0000:00:02.0: quantization range: Full
<7> [96.266210] i915 0000:00:02.0: nups: Unknown Non-uniform Scaling
<7> [96.266213] i915 0000:00:02.0: video code: 0
<7> [96.266216] i915 0000:00:02.0: ycc quantization range: Full
<7> [96.266219] i915 0000:00:02.0: hdmi content type: Graphics
<7> [96.266222] i915 0000:00:02.0: pixel repeat: 0
<7> [96.266225] i915 0000:00:02.0: bar top 0, bottom 0, left 0, right 0
<7> [96.266229] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:78:pipe A] fastset requirement not met in spd infoframe
<7> [96.266829] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] expected:
<7> [96.267211] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] found:
<7> [96.267794] i915 0000:00:02.0: HDMI infoframe: Source Product Description (SPD), version 1, length 25
<7> [96.267799] i915 0000:00:02.0: vendor: Intel
<7> [96.267803] i915 0000:00:02.0: product: Integrated gfx
<7> [96.267806] i915 0000:00:02.0: source device information: PC General (0x9)
<7> [96.267810] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:78:pipe A] fastset requirement not met in hdmi infoframe
<7> [96.268190] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] expected:
<7> [96.270167] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] found:
<7> [96.271011] i915 0000:00:02.0: HDMI infoframe: Vendor, version 1, length 4
<7> [96.271017] i915 0000:00:02.0: empty frame
<7> [96.271022] i915 0000:00:02.0: [drm:intel_atomic_check [i915]] [CRTC:78:pipe A] fastset requirement not met, forcing full modeset
<7> [96.271752] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] [CRTC:78:pipe A] dbuf slices 0x0 -> 0x1, ddb (0 - 0) -> (0 - 510), active pipes 0x2 -> 0x3
<7> [96.272164] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] [CRTC:121:pipe B] dbuf slices 0x1 -> 0x1, ddb (0 - 1020) -> (510 - 1020), active pipes 0x2 -> 0x3
<7> [96.272840] i915 0000:00:02.0: [drm:skl_print_plane_ddb_changes [i915]] [PLANE:36:plane 1A] ddb ( 0 - 0) -> ( 0 - 497), size 0 -> 497
<7> [96.273223] i915 0000:00:02.0: [drm:skl_print_plane_ddb_changes [i915]] [PLANE:72:cursor A] ddb ( 0 - 0) -> ( 497 - 510), size 0 -> 13
<7> [96.273859] i915 0000:00:02.0: [drm:skl_print_plane_wm_changes [i915]] [PLANE:36: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> [96.274395] i915 0000:00:02.0: [drm:skl_print_plane_wm_changes [i915]] [PLANE:36:plane 1A] lines 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0 -> 1, 1, 1, 2, 2, 2, 2, 2, 0, 0, 0
<7> [96.274771] i915 0000:00:02.0: [drm:skl_print_plane_wm_changes [i915]] [PLANE:36:plane 1A] blocks 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0 -> 16, 16, 16, 33, 33, 33, 33, 33, 30, 0, 0
<7> [96.275147] i915 0000:00:02.0: [drm:skl_print_plane_wm_changes [i915]] [PLANE:36:plane 1A] min_ddb 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0 -> 17, 17, 17, 34, 34, 34, 34, 34, 31, 0, 0
<7> [96.276788] i915 0000:00:02.0: [drm:skl_print_plane_wm_changes [i915]] [PLANE:36:plane 1A] min_ddb_uv 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0 -> 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0
<7> [96.277204] i915 0000:00:02.0: [drm:skl_print_plane_ddb_changes [i915]] [PLANE:79:plane 1B] ddb ( 0 - 988) -> ( 510 - 1007), size 988 -> 497
<7> [96.278017] i915 0000:00:02.0: [drm:skl_print_plane_ddb_changes [i915]] [PLANE:115:cursor B] ddb ( 988 - 1020) -> (1007 - 1020), size 32 -> 13
<7> [96.278704] i915 0000:00:02.0: [drm:intel_cdclk_atomic_check [i915]] [CRTC:78:pipe A] min cdclk: 0 kHz -> 192000 kHz
<7> [96.279133] i915 0000:00:02.0: [drm:intel_cdclk_update_dbuf_bw_min_cdclk [i915]] dbuf bandwidth min cdclk: 9282 kHz -> 18563 kHz
<7> [96.279697] i915 0000:00:02.0: [drm:bxt_get_dpll [i915]] [CRTC:78:pipe A] using pre-allocated PORT PLL B
<7> [96.280091] i915 0000:00:02.0: [drm:intel_dpll_crtc_get [i915]] [CRTC:78:pipe A] reserving PORT PLL B
<7> [96.280715] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [CRTC:78:pipe A] enable: yes [modeset]
<7> [96.281103] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] active: yes, output_types: HDMI (0x40), output format: RGB, sink format: RGB
<7> [96.282403] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] cpu_transcoder: A, pipe bpp: 36, dithering: 0
<7> [96.282801] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] MST master transcoder: <invalid>
<7> [96.283181] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] port sync: master transcoder: <invalid>, slave transcoder bitmask = 0x0
<7> [96.283897] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] joiner: no, pipes: 0x0
<7> [96.284522] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] splitter: disabled, link count 0, overlap 0
<7> [96.284903] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] audio: 1, infoframes: 1, infoframes enabled: 0x71
<7> [96.285456] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] GCP: 0x6
<7> [96.285836] i915 0000:00:02.0: HDMI infoframe: Auxiliary Video Information (AVI), version 2, length 13
<7> [96.285840] i915 0000:00:02.0: colorspace: RGB
<7> [96.285844] i915 0000:00:02.0: scan mode: Underscan
<7> [96.285847] i915 0000:00:02.0: colorimetry: No Data
<7> [96.285850] i915 0000:00:02.0: picture aspect: No Data
<7> [96.285853] i915 0000:00:02.0: active aspect: Same as Picture
<7> [96.285856] i915 0000:00:02.0: itc: No Data
<7> [96.285859] i915 0000:00:02.0: extended colorimetry: xvYCC 601
<7> [96.285862] i915 0000:00:02.0: quantization range: Full
<7> [96.285865] i915 0000:00:02.0: nups: Unknown Non-uniform Scaling
<7> [96.285868] i915 0000:00:02.0: video code: 0
<7> [96.285871] i915 0000:00:02.0: ycc quantization range: Full
<7> [96.285874] i915 0000:00:02.0: hdmi content type: Graphics
<7> [96.285877] i915 0000:00:02.0: pixel repeat: 0
<7> [96.285880] i915 0000:00:02.0: bar top 0, bottom 0, left 0, right 0
<7> [96.285884] i915 0000:00:02.0: HDMI infoframe: Source Product Description (SPD), version 1, length 25
<7> [96.285888] i915 0000:00:02.0: vendor: Intel
<7> [96.285891] i915 0000:00:02.0: product: Integrated gfx
<7> [96.285894] i915 0000:00:02.0: source device information: PC General (0x9)
<7> [96.285898] i915 0000:00:02.0: HDMI infoframe: Vendor, version 1, length 4
<7> [96.285901] i915 0000:00:02.0: empty frame
<7> [96.285908] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] ELD: 10 00 07 00 66 10 00 01 00 00 00 00 00 00 00 00
<7> [96.286634] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] ELD: 05 e3 cd 0c 32 38 45 38 35 30 09 07 07 00 00 00
<7> [96.287019] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] scanline offset: 2
<7> [96.289910] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] framestart delay: 1, MSA timing delay: 0, set context latency: 0
<7> [96.290621] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] vrr: no, fixed rr: no, vmin: 0, vmax: 0, flipline: 0, pipeline full: 0, guardband: 0 vsync start: 0, vsync end: 0
<7> [96.291134] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] vrr: vmin vblank: 0, vmax vblank: 0, vmin vtotal: 0, vmax vtotal: 0
<7> [96.291811] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] vrr: dc balance: no, vmin: 0 vmax: 0 guardband: 0, slope: 0 max increase: 0 max decrease: 0 vblank target: 0
<7> [96.292198] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] requested mode: "1920x1080": 60 148500 1920 2008 2052 2200 1080 1083 1088 1125 0x48 0x9
<7> [96.293106] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] adjusted mode: "1920x1080": 60 148500 1920 2008 2052 2200 1080 1083 1088 1125 0x48 0x9
<7> [96.293770] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] crtc timings: clock=148500, hd=1920 hb=1920-2200 hs=2008-2052 ht=2200, vd=1080 vb=1080-1125 vs=1083-1088 vt=1125, flags=0x9
<7> [96.294154] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pipe mode: "1920x1080": 60 148500 1920 2008 2052 2200 1080 1083 1088 1125 0x40 0x9
<7> [96.294760] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] crtc timings: clock=148500, hd=1920 hb=1920-2200 hs=2008-2052 ht=2200, vd=1080 vb=1080-1125 vs=1083-1088 vt=1125, flags=0x9
<7> [96.295157] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] port clock: 222750, pixel rate 148500, min cdclk 192000, min voltage level 0
<7> [96.295825] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] linetime: 59, ips linetime: 0
<7> [96.296221] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] num_scalers: 2, scaler_users: 0x0, scaler_id: -1, scaling_filter: 0, sharpness_strength: 0
<7> [96.297731] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pipe src: 1920x1080+0+0
<7> [96.298128] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pch pfit: 0x0+0+0, disabled, force thru: no
<7> [96.298807] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] sharpness strength: 0, sharpness tap size: 0, sharpness enable: 0
<7> [96.299190] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] ips: 0, double wide: 0, drrs: 0
<7> [96.299941] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] dpll_hw_state: ebb0: 0x6200, ebb4: 0x2000,pll0: 0x21, pll1: 0x100, pll2: 0x1a6666, pll3: 0x10000, pll6: 0x30904, pll8: 0x8, pll9: 0xa, pll10: 0x8003c00, pcsdw12: 0x4d
<7> [96.300592] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] csc_mode: 0x0 gamma_mode: 0x0 gamma_enable: 0 csc_enable: 0
<7> [96.300976] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pre csc lut: 0 entries, post csc lut: 0 entries
<7> [96.301528] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pipe csc: pre offsets: 0x0000 0x0000 0x0000
<7> [96.301908] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pipe csc: coefficients: 0x0000 0x0000 0x0000
<7> [96.302490] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pipe csc: coefficients: 0x0000 0x0000 0x0000
<7> [96.302874] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pipe csc: coefficients: 0x0000 0x0000 0x0000
<7> [96.304118] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pipe csc: post offsets: 0x0000 0x0000 0x0000
<7> [96.304961] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:36:plane 1A] fb: [FB:179] 1920x1080 format = XR24 little-endian (0x34325258) modifier = 0x100000000000001, visible: yes
<7> [96.305623] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] rotation: 0x1, scaler: -1, scaling_filter: 0
<7> [96.306005] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] src: 1920.000000x1080.000000+0.000000+0.000000 dst: 1920x1080+0+0
<7> [96.306561] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:45:plane 2A] fb: [NOFB], visible: no
<7> [96.306942] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:54:plane 3A] fb: [NOFB], visible: no
<7> [96.307529] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:63:plane 4A] fb: [NOFB], visible: no
<7> [96.307912] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:72:cursor A] fb: [NOFB], visible: no
<7> [96.309501] i915 0000:00:02.0: [drm:intel_power_well_enable [i915]] enabling dpio-common-b
<7> [96.310538] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:165:DDI B/PHY B]
<7> [96.310932] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:175:DDI C/PHY C]
<7> [96.313589] i915 0000:00:02.0: [drm:intel_dpll_enable [i915]] enable PORT PLL B (active 0x1, on? 0) for [CRTC:78:pipe A]
<7> [96.314040] i915 0000:00:02.0: [drm:intel_dpll_enable [i915]] enabling PORT PLL B
<7> [96.314950] i915 0000:00:02.0: [drm:intel_power_well_enable [i915]] enabling DDI_IO_B
<7> [96.315463] i915 0000:00:02.0: [drm:intel_enable_transcoder [i915]] enabling pipe A
<7> [96.333046] i915 0000:00:02.0: [drm:intel_fbc_update [i915]] reserved 16588800 bytes of contiguous stolen space for FBC, limit: 1
<7> [96.334357] i915 0000:00:02.0: [drm:intel_fbc_update [i915]] Enabling FBC on [PLANE:36:plane 1A]
<7> [96.349674] i915 0000:00:02.0: [drm:intel_audio_codec_enable [i915]] [CONNECTOR:166:HDMI-A-1][ENCODER:165:DDI B/PHY B] Enable audio codec on [CRTC:78:pipe A], 32 bytes ELD
<7> [96.366311] i915 0000:00:02.0: [drm:audio_config_hdmi_pixel_clock [i915]] Configuring HDMI audio for pixel clock 148500 (0x00090000)
<7> [96.366734] i915 0000:00:02.0: [drm:hsw_audio_config_update [i915]] using automatic N
<7> [96.367766] i915 0000:00:02.0: [drm:verify_connector_state [i915]] [CONNECTOR:166:HDMI-A-1]
<7> [96.368558] i915 0000:00:02.0: [drm:intel_modeset_verify_crtc [i915]] [CRTC:78:pipe A]
<6> [102.392147] [IGT] kms_flip: finished subtest AB-HDMI-A1-HDMI-A2, FAIL
Created at 2026-05-16 14:59:31