Results for igt@kms_flip@flip-vs-expired-vblank

Result: Fail

i915_display_info1 igt_runner1 results1.json results1-xe-load.json guc_logs1.tar i915_display_info_post_exec1 boot1 dmesg1

DetailValue
Duration 27.46 seconds
Hostname 
shard-lnl-3
Igt-Version 
IGT-Version: 2.3-g611f1cac6 (x86_64) (Linux: 7.0.0-rc3-lgci-xe-xe-4711-721db23a9c232926f-debug+ x86_64)
Out 
Using IGT_SRANDOM=1773472693 for randomisation
Opened device: /dev/dri/card0
Using monotonic timestamps
Starting subtest: flip-vs-expired-vblank
Starting dynamic subtest: A-eDP1
  2880x1800: 60 347710 2880 2928 2960 3040 1800 1803 1809 1906 0x48 0xa 
Stack trace:
  #0 ../lib/igt_core.c:2075 __igt_fail_assert()
  #1 ../tests/kms_flip.c:921 run_test_on_crtc_set.constprop.0()
  #2 ../tests/kms_flip.c:1887 run_test()
  #3 ../tests/kms_flip.c:2122 __igt_unique____real_main2043()
  #4 ../tests/kms_flip.c:2043 main()
  #5 [__libc_init_first+0x8a]
  #6 [__libc_start_main+0x8b]
  #7 [_start+0x25]
Dynamic subtest A-eDP1: FAIL (4.936s)
Starting dynamic subtest: B-eDP1
  2880x1800: 60 347710 2880 2928 2960 3040 1800 1803 1809 1906 0x48 0xa 
Dynamic subtest B-eDP1: SUCCESS (11.294s)
Starting dynamic subtest: C-eDP1
  2880x1800: 60 347710 2880 2928 2960 3040 1800 1803 1809 1906 0x48 0xa 
Dynamic subtest C-eDP1: SUCCESS (11.223s)
Subtest flip-vs-expired-vblank: FAIL (27.465s)
Err 
Starting subtest: flip-vs-expired-vblank
Starting dynamic subtest: A-eDP1
(kms_flip:5897) CRITICAL: Test assertion failure function run_test_step, file ../tests/kms_flip.c:926:
(kms_flip:5897) CRITICAL: Failed assertion: end - start < 500
Dynamic subtest A-eDP1 failed.
**** DEBUG ****
(kms_flip:5897) DEBUG: name = flip
last_ts = 245.790146
last_received_ts = 245.789566
last_seq = 1098
current_ts = 245.806793
current_received_ts = 245.806183
current_seq = 1099
count = 89
seq_step = 1
(kms_flip:5897) DEBUG: Vblank took 79us
(kms_flip:5897) DEBUG: name = flip
last_ts = 245.806793
last_received_ts = 245.806183
last_seq = 1099
current_ts = 245.823410
current_received_ts = 245.822830
current_seq = 1100
count = 90
seq_step = 1
(kms_flip:5897) DEBUG: Vblank took 63us
(kms_flip:5897) DEBUG: name = flip
last_ts = 245.823410
last_received_ts = 245.822830
last_seq = 1100
current_ts = 245.840042
current_received_ts = 245.839539
current_seq = 1101
count = 91
seq_step = 1
(kms_flip:5897) DEBUG: Vblank took 64us
(kms_flip:5897) DEBUG: name = flip
last_ts = 245.840042
last_received_ts = 245.839539
last_seq = 1101
current_ts = 245.856689
current_received_ts = 245.856110
current_seq = 1102
count = 92
seq_step = 1
(kms_flip:5897) DEBUG: Vblank took 70us
(kms_flip:5897) DEBUG: name = flip
last_ts = 245.856689
last_received_ts = 245.856110
last_seq = 1102
current_ts = 245.873306
current_received_ts = 245.872742
current_seq = 1103
count = 93
seq_step = 1
(kms_flip:5897) DEBUG: Vblank took 70us
(kms_flip:5897) DEBUG: name = flip
last_ts = 245.873306
last_received_ts = 245.872742
last_seq = 1103
current_ts = 245.889938
current_received_ts = 245.889359
current_seq = 1104
count = 94
seq_step = 1
(kms_flip:5897) DEBUG: Vblank took 69us
(kms_flip:5897) DEBUG: name = flip
last_ts = 245.889938
last_received_ts = 245.889359
last_seq = 1104
current_ts = 245.906586
current_received_ts = 245.905991
current_seq = 1105
count = 95
seq_step = 1
(kms_flip:5897) DEBUG: Vblank took 75us
(kms_flip:5897) DEBUG: name = flip
last_ts = 245.906586
last_received_ts = 245.905991
last_seq = 1105
current_ts = 245.923203
current_received_ts = 245.922653
current_seq = 1106
count = 96
seq_step = 1
(kms_flip:5897) DEBUG: Vblank took 70us
(kms_flip:5897) DEBUG: name = flip
last_ts = 245.923203
last_received_ts = 245.922653
last_seq = 1106
current_ts = 245.939835
current_received_ts = 245.939240
current_seq = 1107
count = 97
seq_step = 1
(kms_flip:5897) DEBUG: Vblank took 165us
(kms_flip:5897) DEBUG: name = flip
last_ts = 245.939835
last_received_ts = 245.939240
last_seq = 1107
current_ts = 245.956467
current_received_ts = 245.955887
current_seq = 1108
count = 98
seq_step = 1
(kms_flip:5897) DEBUG: Vblank took 77us
(kms_flip:5897) DEBUG: name = flip
last_ts = 245.956467
last_received_ts = 245.955887
last_seq = 1108
current_ts = 245.973099
current_received_ts = 245.972519
current_seq = 1109
count = 99
seq_step = 1
(kms_flip:5897) DEBUG: Vblank took 76us
(kms_flip:5897) DEBUG: name = flip
last_ts = 245.973099
last_received_ts = 245.972519
last_seq = 1109
current_ts = 245.989731
current_received_ts = 245.989151
current_seq = 1110
count = 100
seq_step = 1
(kms_flip:5897) DEBUG: Vblank took 70us
(kms_flip:5897) DEBUG: name = flip
last_ts = 245.989731
last_received_ts = 245.989151
last_seq = 1110
current_ts = 246.006363
current_received_ts = 246.005798
current_seq = 1111
count = 101
seq_step = 1
(kms_flip:5897) DEBUG: Vblank took 70us
(kms_flip:5897) DEBUG: name = flip
last_ts = 246.006363
last_received_ts = 246.005798
last_seq = 1111
current_ts = 246.022995
current_received_ts = 246.022354
current_seq = 1112
count = 102
seq_step = 1
(kms_flip:5897) DEBUG: Vblank took 77us
(kms_flip:5897) DEBUG: name = flip
last_ts = 246.022995
last_received_ts = 246.022354
last_seq = 1112
current_ts = 246.039627
current_received_ts = 246.039062
current_seq = 1113
count = 103
seq_step = 1
(kms_flip:5897) DEBUG: Vblank took 79us
(kms_flip:5897) DEBUG: name = flip
last_ts = 246.039627
last_received_ts = 246.039062
last_seq = 1113
current_ts = 246.056259
current_received_ts = 246.055695
current_seq = 1114
count = 104
seq_step = 1
(kms_flip:5897) DEBUG: Vblank took 78us
(kms_flip:5897) DEBUG: name = flip
last_ts = 246.056259
last_received_ts = 246.055695
last_seq = 1114
current_ts = 246.072891
current_received_ts = 246.072357
current_seq = 1115
count = 105
seq_step = 1
(kms_flip:5897) DEBUG: Vblank took 70us
(kms_flip:5897) DEBUG: name = flip
last_ts = 246.072891
last_received_ts = 246.072357
last_seq = 1115
current_ts = 246.089523
current_received_ts = 246.088974
current_seq = 1116
count = 106
seq_step = 1
(kms_flip:5897) DEBUG: Vblank took 100us
(kms_flip:5897) DEBUG: name = flip
last_ts = 246.089523
last_received_ts = 246.088974
last_seq = 1116
current_ts = 246.106155
current_received_ts = 246.105606
current_seq = 1117
count = 107
seq_step = 1
(kms_flip:5897) DEBUG: Vblank took 78us
(kms_flip:5897) DEBUG: name = flip
last_ts = 246.106155
last_received_ts = 246.105606
last_seq = 1117
current_ts = 246.122787
current_received_ts = 246.122192
current_seq = 1118
count = 108
seq_step = 1
(kms_flip:5897) DEBUG: Vblank took 70us
(kms_flip:5897) DEBUG: name = flip
last_ts = 246.122787
last_received_ts = 246.122192
last_seq = 1118
current_ts = 246.139420
current_received_ts = 246.138870
current_seq = 1119
count = 109
seq_step = 1
(kms_flip:5897) DEBUG: Vblank took 78us
(kms_flip:5897) DEBUG: name = flip
last_ts = 246.139420
last_received_ts = 246.138870
last_seq = 1119
current_ts = 246.156052
current_received_ts = 246.155487
current_seq = 1120
count = 110
seq_step = 1
(kms_flip:5897) DEBUG: Vblank took 128us
(kms_flip:5897) DEBUG: name = flip
last_ts = 246.156052
last_received_ts = 246.155487
last_seq = 1120
current_ts = 246.172684
current_received_ts = 246.172134
current_seq = 1121
count = 111
seq_step = 1
(kms_flip:5897) DEBUG: Vblank took 70us
(kms_flip:5897) DEBUG: name = flip
last_ts = 246.172684
last_received_ts = 246.172134
last_seq = 1121
current_ts = 246.189316
current_received_ts = 246.188751
current_seq = 1122
count = 112
seq_step = 1
(kms_flip:5897) DEBUG: Vblank took 70us
(kms_flip:5897) DEBUG: name = flip
last_ts = 246.189316
last_received_ts = 246.188751
last_seq = 1122
current_ts = 246.205948
current_received_ts = 246.205338
current_seq = 1123
count = 113
seq_step = 1
(kms_flip:5897) DEBUG: Vblank took 70us
(kms_flip:5897) DEBUG: name = flip
last_ts = 246.205948
last_received_ts = 246.205338
last_seq = 1123
current_ts = 246.222580
current_received_ts = 246.222046
current_seq = 1124
count = 114
seq_step = 1
(kms_flip:5897) DEBUG: Vblank took 77us
(kms_flip:5897) DEBUG: name = flip
last_ts = 246.222580
last_received_ts = 246.222046
last_seq = 1124
current_ts = 246.239212
current_received_ts = 246.238647
current_seq = 1125
count = 115
seq_step = 1
(kms_flip:5897) DEBUG: Vblank took 70us
(kms_flip:5897) DEBUG: name = flip
last_ts = 246.239212
last_received_ts = 246.238647
last_seq = 1125
current_ts = 246.255844
current_received_ts = 246.255249
current_seq = 1126
count = 116
seq_step = 1
(kms_flip:5897) DEBUG: Vblank took 122us
(kms_flip:5897) DEBUG: name = flip
last_ts = 246.255844
last_received_ts = 246.255249
last_seq = 1126
current_ts = 246.272476
current_received_ts = 246.271927
current_seq = 1127
count = 117
seq_step = 1
(kms_flip:5897) DEBUG: Vblank took 93us
(kms_flip:5897) DEBUG: name = flip
last_ts = 246.272476
last_received_ts = 246.271927
last_seq = 1127
current_ts = 246.289108
current_received_ts = 246.288528
current_seq = 1128
count = 118
seq_step = 1
(kms_flip:5897) DEBUG: Vblank took 53us
(kms_flip:5897) DEBUG: name = flip
last_ts = 246.289108
last_received_ts = 246.288528
last_seq = 1128
current_ts = 246.305740
current_received_ts = 246.305191
current_seq = 1129
count = 119
seq_step = 1
(kms_flip:5897) DEBUG: Vblank took 69us
(kms_flip:5897) DEBUG: name = flip
last_ts = 246.305740
last_received_ts = 246.305191
last_seq = 1129
current_ts = 246.322372
current_received_ts = 246.321823
current_seq = 1130
count = 120
seq_step = 1
(kms_flip:5897) DEBUG: Vblank took 78us
(kms_flip:5897) DEBUG: name = flip
last_ts = 246.322372
last_received_ts = 246.321823
last_seq = 1130
current_ts = 246.339005
current_received_ts = 246.338440
current_seq = 1131
count = 121
seq_step = 1
(kms_flip:5897) DEBUG: Vblank took 125us
(kms_flip:5897) DEBUG: name = flip
last_ts = 246.339005
last_received_ts = 246.338440
last_seq = 1131
current_ts = 246.355652
current_received_ts = 246.355103
current_seq = 1132
count = 122
seq_step = 1
(kms_flip:5897) DEBUG: Vblank took 70us
(kms_flip:5897) DEBUG: name = flip
last_ts = 246.355652
last_received_ts = 246.355103
last_seq = 1132
current_ts = 246.372284
current_received_ts = 246.371719
current_seq = 1133
count = 123
seq_step = 1
(kms_flip:5897) DEBUG: Vblank took 83us
(kms_flip:5897) DEBUG: name = flip
last_ts = 246.372284
last_received_ts = 246.371719
last_seq = 1133
current_ts = 246.388916
current_received_ts = 246.388367
current_seq = 1134
count = 124
seq_step = 1
(kms_flip:5897) DEBUG: Vblank took 131us
(kms_flip:5897) DEBUG: name = flip
last_ts = 246.388916
last_received_ts = 246.388367
last_seq = 1134
current_ts = 246.405548
current_received_ts = 246.405029
current_seq = 1135
count = 125
seq_step = 1
(kms_flip:5897) DEBUG: Vblank took 128us
(kms_flip:5897) DEBUG: name = flip
last_ts = 246.405548
last_received_ts = 246.405029
last_seq = 1135
current_ts = 246.422180
current_received_ts = 246.421616
current_seq = 1136
count = 126
seq_step = 1
(kms_flip:5897) DEBUG: Vblank took 70us
(kms_flip:5897) DEBUG: name = flip
last_ts = 246.422180
last_received_ts = 246.421616
last_seq = 1136
current_ts = 246.438812
current_received_ts = 246.438232
current_seq = 1137
count = 127
seq_step = 1
(kms_flip:5897) DEBUG: Vblank took 127us
(kms_flip:5897) DEBUG: name = flip
last_ts = 246.438812
last_received_ts = 246.438232
last_seq = 1137
current_ts = 246.455460
current_received_ts = 246.454895
current_seq = 1138
count = 128
seq_step = 1
(kms_flip:5897) DEBUG: Vblank took 76us
(kms_flip:5897) DEBUG: name = flip
last_ts = 246.455460
last_received_ts = 246.454895
last_seq = 1138
current_ts = 246.472092
current_received_ts = 246.471512
current_seq = 1139
count = 129
seq_step = 1
(kms_flip:5897) DEBUG: Vblank took 77us
(kms_flip:5897) DEBUG: name = flip
last_ts = 246.472092
last_received_ts = 246.471512
last_seq = 1139
current_ts = 246.488724
current_received_ts = 246.488159
current_seq = 1140
count = 130
seq_step = 1
(kms_flip:5897) DEBUG: Vblank took 70us
(kms_flip:5897) DEBUG: name = flip
last_ts = 246.488724
last_received_ts = 246.488159
last_seq = 1140
current_ts = 246.505371
current_received_ts = 246.504776
current_seq = 1141
count = 131
seq_step = 1
(kms_flip:5897) DEBUG: Vblank took 70us
(kms_flip:5897) DEBUG: name = flip
last_ts = 246.505371
last_received_ts = 246.504776
last_seq = 1141
current_ts = 246.522003
current_received_ts = 246.521378
current_seq = 1142
count = 132
seq_step = 1
(kms_flip:5897) DEBUG: Vblank took 69us
(kms_flip:5897) DEBUG: name = flip
last_ts = 246.522003
last_received_ts = 246.521378
last_seq = 1142
current_ts = 246.538635
current_received_ts = 246.538071
current_seq = 1143
count = 133
seq_step = 1
(kms_flip:5897) DEBUG: Vblank took 70us
(kms_flip:5897) DEBUG: name = flip
last_ts = 246.538635
last_received_ts = 246.538071
last_seq = 1143
current_ts = 246.555267
current_received_ts = 246.554688
current_seq = 1144
count = 134
seq_step = 1
(kms_flip:5897) DEBUG: Vblank took 78us
(kms_flip:5897) DEBUG: name = flip
last_ts = 246.555267
last_received_ts = 246.554688
last_seq = 1144
current_ts = 246.571899
current_received_ts = 246.571243
current_seq = 1145
count = 135
seq_step = 1
(kms_flip:5897) DEBUG: Vblank took 137us
(kms_flip:5897) DEBUG: name = flip
last_ts = 246.571899
last_received_ts = 246.571243
last_seq = 1145
current_ts = 246.588531
current_received_ts = 246.587875
current_seq = 1146
count = 136
seq_step = 1
(kms_flip:5897) DEBUG: Vblank took 71us
(kms_flip:5897) DEBUG: name = flip
last_ts = 246.588531
last_received_ts = 246.587875
last_seq = 1146
current_ts = 246.605164
current_received_ts = 246.604507
current_seq = 1147
count = 137
seq_step = 1
(kms_flip:5897) DEBUG: Vblank took 128us
(kms_flip:5897) DEBUG: name = flip
last_ts = 246.605164
last_received_ts = 246.604507
last_seq = 1147
current_ts = 246.621811
current_received_ts = 246.621185
current_seq = 1148
count = 138
seq_step = 1
(kms_flip:5897) DEBUG: Vblank took 70us
(kms_flip:5897) DEBUG: name = flip
last_ts = 246.621811
last_received_ts = 246.621185
last_seq = 1148
current_ts = 246.638443
current_received_ts = 246.637787
current_seq = 1149
count = 139
seq_step = 1
(kms_flip:5897) DEBUG: Vblank took 78us
(kms_flip:5897) DEBUG: name = flip
last_ts = 246.638443
last_received_ts = 246.637787
last_seq = 1149
current_ts = 246.655075
current_received_ts = 246.654434
current_seq = 1150
count = 140
seq_step = 1
(kms_flip:5897) DEBUG: Vblank took 142us
(kms_flip:5897) DEBUG: name = flip
last_ts = 246.655075
last_received_ts = 246.654434
last_seq = 1150
current_ts = 246.671707
current_received_ts = 246.671066
current_seq = 1151
count = 141
seq_step = 1
(kms_flip:5897) DEBUG: Vblank took 71us
(kms_flip:5897) DEBUG: name = flip
last_ts = 246.671707
last_received_ts = 246.671066
last_seq = 1151
current_ts = 246.688339
current_received_ts = 246.687698
current_seq = 1152
count = 142
seq_step = 1
(kms_flip:5897) DEBUG: Vblank took 70us
(kms_flip:5897) DEBUG: name = flip
last_ts = 246.688339
last_received_ts = 246.687698
last_seq = 1152
current_ts = 246.704987
current_received_ts = 246.704346
current_seq = 1153
count = 143
seq_step = 1
(kms_flip:5897) DEBUG: Vblank took 121us
(kms_flip:5897) DEBUG: name = flip
last_ts = 246.704987
last_received_ts = 246.704346
last_seq = 1153
current_ts = 246.721619
current_received_ts = 246.720963
current_seq = 1154
count = 144
seq_step = 1
(kms_flip:5897) DEBUG: Vblank took 92us
(kms_flip:5897) DEBUG: name = flip
last_ts = 246.721619
last_received_ts = 246.720963
last_seq = 1154
current_ts = 246.738251
current_received_ts = 246.737595
current_seq = 1155
count = 145
seq_step = 1
(kms_flip:5897) DEBUG: Vblank took 70us
(kms_flip:5897) DEBUG: name = flip
last_ts = 246.738251
last_received_ts = 246.737595
last_seq = 1155
current_ts = 246.754883
current_received_ts = 246.754211
current_seq = 1156
count = 146
seq_step = 1
(kms_flip:5897) DEBUG: Vblank took 128us
(kms_flip:5897) DEBUG: name = flip
last_ts = 246.754883
last_received_ts = 246.754211
last_seq = 1156
current_ts = 246.771515
current_received_ts = 246.770874
current_seq = 1157
count = 147
seq_step = 1
(kms_flip:5897) DEBUG: Vblank took 78us
(kms_flip:5897) DEBUG: name = flip
last_ts = 246.771515
last_received_ts = 246.770874
last_seq = 1157
current_ts = 246.788162
current_received_ts = 246.787491
current_seq = 1158
count = 148
seq_step = 1
(kms_flip:5897) DEBUG: Vblank took 149us
(kms_flip:5897) DEBUG: name = flip
last_ts = 246.788162
last_received_ts = 246.787491
last_seq = 1158
current_ts = 246.804794
current_received_ts = 246.804153
current_seq = 1159
count = 149
seq_step = 1
(kms_flip:5897) DEBUG: Vblank took 77us
(kms_flip:5897) DEBUG: name = flip
last_ts = 246.804794
last_received_ts = 246.804153
last_seq = 1159
current_ts = 246.821426
current_received_ts = 246.820786
current_seq = 1160
count = 150
seq_step = 1
(kms_flip:5897) DEBUG: Vblank took 76us
(kms_flip:5897) DEBUG: name = flip
last_ts = 246.821426
last_received_ts = 246.820786
last_seq = 1160
current_ts = 246.838058
current_received_ts = 246.837402
current_seq = 1161
count = 151
seq_step = 1
(kms_flip:5897) DEBUG: Vblank took 127us
(kms_flip:5897) DEBUG: name = flip
last_ts = 246.838058
last_received_ts = 246.837402
last_seq = 1161
current_ts = 246.854691
current_received_ts = 246.854050
current_seq = 1162
count = 152
seq_step = 1
(kms_flip:5897) DEBUG: Vblank took 77us
(kms_flip:5897) DEBUG: name = flip
last_ts = 246.854691
last_received_ts = 246.854050
last_seq = 1162
current_ts = 246.871323
current_received_ts = 246.870697
current_seq = 1163
count = 153
seq_step = 1
(kms_flip:5897) DEBUG: Vblank took 54us
(kms_flip:5897) DEBUG: name = flip
last_ts = 246.871323
last_received_ts = 246.870697
last_seq = 1163
current_ts = 246.887970
current_received_ts = 246.887314
current_seq = 1164
count = 154
seq_step = 1
(kms_flip:5897) DEBUG: Vblank took 128us
(kms_flip:5897) DEBUG: name = flip
last_ts = 246.887970
last_received_ts = 246.887314
last_seq = 1164
current_ts = 246.904602
current_received_ts = 246.903946
current_seq = 1165
count = 155
seq_step = 1
(kms_flip:5897) DEBUG: Vblank took 106us
(kms_flip:5897) DEBUG: name = flip
last_ts = 246.904602
last_received_ts = 246.903946
last_seq = 1165
current_ts = 246.921234
current_received_ts = 246.920578
current_seq = 1166
count = 156
seq_step = 1
(kms_flip:5897) DEBUG: Vblank took 70us
(kms_flip:5897) DEBUG: name = flip
last_ts = 246.921234
last_received_ts = 246.920578
last_seq = 1166
current_ts = 246.937866
current_received_ts = 246.937195
current_seq = 1167
count = 157
seq_step = 1
(kms_flip:5897) DEBUG: Vblank took 70us
(kms_flip:5897) DEBUG: name = flip
last_ts = 246.937866
last_received_ts = 246.937195
last_seq = 1167
current_ts = 246.954498
current_received_ts = 246.953857
current_seq = 1168
count = 158
seq_step = 1
(kms_flip:5897) DEBUG: Vblank took 82us
(kms_flip:5897) DEBUG: name = flip
last_ts = 246.954498
last_received_ts = 246.953857
last_seq = 1168
current_ts = 246.971130
current_received_ts = 246.970490
current_seq = 1169
count = 159
seq_step = 1
(kms_flip:5897) DEBUG: Vblank took 138us
(kms_flip:5897) DEBUG: name = flip
last_ts = 246.971130
last_received_ts = 246.970490
last_seq = 1169
current_ts = 246.987762
current_received_ts = 246.987122
current_seq = 1170
count = 160
seq_step = 1
(kms_flip:5897) DEBUG: Vblank took 70us
(kms_flip:5897) DEBUG: name = flip
last_ts = 246.987762
last_received_ts = 246.987122
last_seq = 1170
current_ts = 247.004410
current_received_ts = 247.003754
current_seq = 1171
count = 161
seq_step = 1
(kms_flip:5897) DEBUG: Vblank took 70us
(kms_flip:5897) DEBUG: name = flip
last_ts = 247.004410
last_received_ts = 247.003754
last_seq = 1171
current_ts = 247.021042
current_received_ts = 247.020386
current_seq = 1172
count = 162
seq_step = 1
(kms_flip:5897) DEBUG: Vblank took 125us
(kms_flip:5897) DEBUG: name = flip
last_ts = 247.021042
last_received_ts = 247.020386
last_seq = 1172
current_ts = 247.037674
current_received_ts = 247.037048
current_seq = 1173
count = 163
seq_step = 1
(kms_flip:5897) DEBUG: Vblank took 69us
(kms_flip:5897) DEBUG: name = flip
last_ts = 247.037674
last_received_ts = 247.037048
last_seq = 1173
current_ts = 247.054306
current_received_ts = 247.053665
current_seq = 1174
count = 164
seq_step = 1
(kms_flip:5897) DEBUG: Vblank took 77us
(kms_flip:5897) DEBUG: name = flip
last_ts = 247.054306
last_received_ts = 247.053665
last_seq = 1174
current_ts = 247.070953
current_received_ts = 247.070297
current_seq = 1175
count = 165
seq_step = 1
(kms_flip:5897) DEBUG: Vblank took 98us
(kms_flip:5897) DEBUG: name = flip
last_ts = 247.070953
last_received_ts = 247.070297
last_seq = 1175
current_ts = 247.087585
current_received_ts = 247.086929
current_seq = 1176
count = 166
seq_step = 1
(kms_flip:5897) DEBUG: Vblank took 105us
(kms_flip:5897) DEBUG: name = flip
last_ts = 247.087585
last_received_ts = 247.086929
last_seq = 1176
current_ts = 247.104218
current_received_ts = 247.103577
current_seq = 1177
count = 167
seq_step = 1
(kms_flip:5897) DEBUG: Vblank took 70us
(kms_flip:5897) DEBUG: name = flip
last_ts = 247.104218
last_received_ts = 247.103577
last_seq = 1177
current_ts = 247.120850
current_received_ts = 247.120178
current_seq = 1178
count = 168
seq_step = 1
(kms_flip:5897) DEBUG: Vblank took 71us
(kms_flip:5897) DEBUG: name = flip
last_ts = 247.120850
last_received_ts = 247.120178
last_seq = 1178
current_ts = 247.137482
current_received_ts = 247.136826
current_seq = 1179
count = 169
seq_step = 1
(kms_flip:5897) DEBUG: Vblank took 71us
(kms_flip:5897) DEBUG: name = flip
last_ts = 247.137482
last_received_ts = 247.136826
last_seq = 1179
current_ts = 247.154114
current_received_ts = 247.153458
current_seq = 1180
count = 170
seq_step = 1
(kms_flip:5897) DEBUG: Vblank took 141us
(kms_flip:5897) DEBUG: name = flip
last_ts = 247.154114
last_received_ts = 247.153458
last_seq = 1180
current_ts = 247.170746
current_received_ts = 247.170105
current_seq = 1181
count = 171
seq_step = 1
(kms_flip:5897) DEBUG: Vblank took 78us
(kms_flip:5897) DEBUG: name = flip
last_ts = 247.170746
last_received_ts = 247.170105
last_seq = 1181
current_ts = 247.187393
current_received_ts = 247.186737
current_seq = 1182
count = 172
seq_step = 1
(kms_flip:5897) DEBUG: Vblank took 70us
(kms_flip:5897) DEBUG: name = flip
last_ts = 247.187393
last_received_ts = 247.186737
last_seq = 1182
current_ts = 247.204025
current_received_ts = 247.203384
current_seq = 1183
count = 173
seq_step = 1
(kms_flip:5897) DEBUG: Vblank took 142us
(kms_flip:5897) DEBUG: name = flip
last_ts = 247.204025
last_received_ts = 247.203384
last_seq = 1183
current_ts = 247.220657
current_received_ts = 247.220032
current_seq = 1184
count = 174
seq_step = 1
(kms_flip:5897) DEBUG: Vblank took 76us
(kms_flip:5897) DEBUG: name = flip
last_ts = 247.220657
last_received_ts = 247.220032
last_seq = 1184
current_ts = 247.237289
current_received_ts = 247.236649
current_seq = 1185
count = 175
seq_step = 1
(kms_flip:5897) DEBUG: Vblank took 71us
(kms_flip:5897) DEBUG: name = flip
last_ts = 247.237289
last_received_ts = 247.236649
last_seq = 1185
current_ts = 247.253922
current_received_ts = 247.253265
current_seq = 1186
count = 176
seq_step = 1
(kms_flip:5897) DEBUG: Vblank took 103us
(kms_flip:5897) DEBUG: name = flip
last_ts = 247.253922
last_received_ts = 247.253265
last_seq = 1186
current_ts = 247.270554
current_received_ts = 247.269913
current_seq = 1187
count = 177
seq_step = 1
(kms_flip:5897) DEBUG: Vblank took 93us
(kms_flip:5897) DEBUG: name = flip
last_ts = 247.270554
last_received_ts = 247.269913
last_seq = 1187
current_ts = 247.287201
current_received_ts = 247.286545
current_seq = 1188
count = 178
seq_step = 1
(kms_flip:5897) DEBUG: Vblank took 74us
(kms_flip:5897) DEBUG: name = flip
last_ts = 247.287201
last_received_ts = 247.286545
last_seq = 1188
current_ts = 247.303833
current_received_ts = 247.303177
current_seq = 1189
count = 179
seq_step = 1
(kms_flip:5897) DEBUG: Vblank took 70us
(kms_flip:5897) DEBUG: name = flip
last_ts = 247.303833
last_received_ts = 247.303177
last_seq = 1189
current_ts = 247.320480
current_received_ts = 247.319824
current_seq = 1190
count = 180
seq_step = 1
(kms_flip:5897) DEBUG: Vblank took 78us
(kms_flip:5897) DEBUG: name = flip
last_ts = 247.320480
last_received_ts = 247.319824
last_seq = 1190
current_ts = 247.337112
current_received_ts = 247.336456
current_seq = 1191
count = 181
seq_step = 1
(kms_flip:5897) DEBUG: Vblank took 125us
(kms_flip:5897) DEBUG: name = flip
last_ts = 247.337112
last_received_ts = 247.336456
last_seq = 1191
current_ts = 247.353745
current_received_ts = 247.353104
current_seq = 1192
count = 182
seq_step = 1
(kms_flip:5897) DEBUG: Vblank took 77us
(kms_flip:5897) DEBUG: name = flip
last_ts = 247.353745
last_received_ts = 247.353104
last_seq = 1192
current_ts = 247.370392
current_received_ts = 247.369736
current_seq = 1193
count = 183
seq_step = 1
(kms_flip:5897) DEBUG: Vblank took 70us
(kms_flip:5897) DEBUG: name = flip
last_ts = 247.370392
last_received_ts = 247.369736
last_seq = 1193
current_ts = 247.387024
current_received_ts = 247.386368
current_seq = 1194
count = 184
seq_step = 1
(kms_flip:5897) DEBUG: Vblank took 120us
(kms_flip:5897) DEBUG: name = flip
last_ts = 247.387024
last_received_ts = 247.386368
last_seq = 1194
current_ts = 247.403656
current_received_ts = 247.403030
current_seq = 1195
count = 185
seq_step = 1
(kms_flip:5897) DEBUG: Vblank took 68us
(kms_flip:5897) DEBUG: name = flip
last_ts = 247.403656
last_received_ts = 247.403030
last_seq = 1195
current_ts = 247.420303
current_received_ts = 247.419647
current_seq = 1196
count = 186
seq_step = 1
(kms_flip:5897) DEBUG: Vblank took 70us
(kms_flip:5897) DEBUG: name = flip
last_ts = 247.420303
last_received_ts = 247.419647
last_seq = 1196
current_ts = 247.436935
current_received_ts = 247.436279
current_seq = 1197
count = 187
seq_step = 1
(kms_flip:5897) DEBUG: Vblank took 117us
(kms_flip:5897) DEBUG: name = flip
last_ts = 247.436935
last_received_ts = 247.436279
last_seq = 1197
current_ts = 247.453568
current_received_ts = 247.452911
current_seq = 1198
count = 188
seq_step = 1
(kms_flip:5897) DEBUG: Vblank took 66us
(kms_flip:5897) DEBUG: name = flip
last_ts = 247.453568
last_received_ts = 247.452911
last_seq = 1198
current_ts = 247.470215
current_received_ts = 247.469559
current_seq = 1199
count = 189
seq_step = 1
(kms_flip:5897) DEBUG: Vblank took 70us
(kms_flip:5897) DEBUG: name = flip
last_ts = 247.470215
last_received_ts = 247.469559
last_seq = 1199
current_ts = 247.486847
current_received_ts = 247.486206
current_seq = 1200
count = 190
seq_step = 1
(kms_flip:5897) DEBUG: Vblank took 81us
(kms_flip:5897) DEBUG: name = flip
last_ts = 247.486847
last_received_ts = 247.486206
last_seq = 1200
current_ts = 247.503479
current_received_ts = 247.502838
current_seq = 1201
count = 191
seq_step = 1
(kms_flip:5897) DEBUG: Vblank took 78us
(kms_flip:5897) DEBUG: name = flip
last_ts = 247.503479
last_received_ts = 247.502838
last_seq = 1201
current_ts = 247.520126
current_received_ts = 247.519470
current_seq = 1202
count = 192
seq_step = 1
(kms_flip:5897) DEBUG: Vblank took 124us
(kms_flip:5897) DEBUG: name = flip
last_ts = 247.520126
last_received_ts = 247.519470
last_seq = 1202
current_ts = 247.536758
current_received_ts = 247.536118
current_seq = 1203
count = 193
seq_step = 1
(kms_flip:5897) DEBUG: Vblank took 77us
(kms_flip:5897) DEBUG: name = flip
last_ts = 247.536758
last_received_ts = 247.536118
last_seq = 1203
current_ts = 247.553391
current_received_ts = 247.552750
current_seq = 1204
count = 194
seq_step = 1
(kms_flip:5897) DEBUG: Vblank took 78us
(kms_flip:5897) DEBUG: name = flip
last_ts = 247.553391
last_received_ts = 247.552750
last_seq = 1204
current_ts = 247.570038
current_received_ts = 247.569382
current_seq = 1205
count = 195
seq_step = 1
(kms_flip:5897) DEBUG: Vblank took 69us
(kms_flip:5897) DEBUG: name = flip
last_ts = 247.570038
last_received_ts = 247.569382
last_seq = 1205
current_ts = 247.586670
current_received_ts = 247.586044
current_seq = 1206
count = 196
seq_step = 1
(kms_flip:5897) DEBUG: Vblank took 76us
(kms_flip:5897) DEBUG: name = flip
last_ts = 247.586670
last_received_ts = 247.586044
last_seq = 1206
current_ts = 247.603302
current_received_ts = 247.602676
current_seq = 1207
count = 197
seq_step = 1
(kms_flip:5897) DEBUG: Vblank took 70us
(kms_flip:5897) DEBUG: name = flip
last_ts = 247.603302
last_received_ts = 247.602676
last_seq = 1207
current_ts = 247.619949
current_received_ts = 247.619308
current_seq = 1208
count = 198
seq_step = 1
(kms_flip:5897) DEBUG: Vblank took 63us
(kms_flip:5897) DEBUG: name = flip
last_ts = 247.619949
last_received_ts = 247.619308
last_seq = 1208
current_ts = 247.636581
current_received_ts = 247.635941
current_seq = 1209
count = 199
seq_step = 1
(kms_flip:5897) DEBUG: Vblank took 105us
(kms_flip:5897) DEBUG: name = flip
last_ts = 247.636581
last_received_ts = 247.635941
last_seq = 1209
current_ts = 247.653229
current_received_ts = 247.652573
current_seq = 1210
count = 200
seq_step = 1
(kms_flip:5897) DEBUG: Vblank took 69us
(kms_flip:5897) DEBUG: name = flip
last_ts = 247.653229
last_received_ts = 247.652573
last_seq = 1210
current_ts = 247.669861
current_received_ts = 247.669189
current_seq = 1211
count = 201
seq_step = 1
(kms_flip:5897) DEBUG: Vblank took 70us
(kms_flip:5897) DEBUG: name = flip
last_ts = 247.669861
last_received_ts = 247.669189
last_seq = 1211
current_ts = 247.686493
current_received_ts = 247.685852
current_seq = 1212
count = 202
seq_step = 1
(kms_flip:5897) DEBUG: Vblank took 70us
(kms_flip:5897) DEBUG: name = flip
last_ts = 247.686493
last_received_ts = 247.685852
last_seq = 1212
current_ts = 247.703140
current_received_ts = 247.702499
current_seq = 1213
count = 203
seq_step = 1
(kms_flip:5897) DEBUG: Vblank took 53us
(kms_flip:5897) DEBUG: name = flip
last_ts = 247.703140
last_received_ts = 247.702499
last_seq = 1213
current_ts = 247.719772
current_received_ts = 247.719131
current_seq = 1214
count = 204
seq_step = 1
(kms_flip:5897) DEBUG: Vblank took 83us
(kms_flip:5897) DEBUG: name = flip
last_ts = 247.719772
last_received_ts = 247.719131
last_seq = 1214
current_ts = 247.736404
current_received_ts = 247.735764
current_seq = 1215
count = 205
seq_step = 1
(kms_flip:5897) DEBUG: Vblank took 74us
(kms_flip:5897) DEBUG: name = flip
last_ts = 247.736404
last_received_ts = 247.735764
last_seq = 1215
current_ts = 247.753052
current_received_ts = 247.752396
current_seq = 1216
count = 206
seq_step = 1
(kms_flip:5897) DEBUG: Vblank took 130us
(kms_flip:5897) DEBUG: name = flip
last_ts = 247.753052
last_received_ts = 247.752396
last_seq = 1216
current_ts = 247.769684
current_received_ts = 247.769058
current_seq = 1217
count = 207
seq_step = 1
(kms_flip:5897) DEBUG: Vblank took 74us
(kms_flip:5897) DEBUG: name = flip
last_ts = 247.769684
last_received_ts = 247.769058
last_seq = 1217
current_ts = 247.786316
current_received_ts = 247.785675
current_seq = 1218
count = 208
seq_step = 1
(kms_flip:5897) DEBUG: Vblank took 70us
(kms_flip:5897) DEBUG: name = flip
last_ts = 247.786316
last_received_ts = 247.785675
last_seq = 1218
current_ts = 247.802963
current_received_ts = 247.802338
current_seq = 1219
count = 209
seq_step = 1
(kms_flip:5897) DEBUG: Vblank took 134us
(kms_flip:5897) DEBUG: name = flip
last_ts = 247.802963
last_received_ts = 247.802338
last_seq = 1219
current_ts = 247.819595
current_received_ts = 247.818970
current_seq = 1220
count = 210
seq_step = 1
(kms_flip:5897) DEBUG: Vblank took 597us
(kms_flip:5897) CRITICAL: Test assertion failure function run_test_step, file ../tests/kms_flip.c:926:
(kms_flip:5897) CRITICAL: Failed assertion: end - start < 500
(kms_flip:5897) igt_core-INFO: Stack trace:
(kms_flip:5897) igt_core-INFO:   #0 ../lib/igt_core.c:2075 __igt_fail_assert()
(kms_flip:5897) igt_core-INFO:   #1 ../tests/kms_flip.c:921 run_test_on_crtc_set.constprop.0()
(kms_flip:5897) igt_core-INFO:   #2 ../tests/kms_flip.c:1887 run_test()
(kms_flip:5897) igt_core-INFO:   #3 ../tests/kms_flip.c:2122 __igt_unique____real_main2043()
(kms_flip:5897) igt_core-INFO:   #4 ../tests/kms_flip.c:2043 main()
(kms_flip:5897) igt_core-INFO:   #5 [__libc_init_first+0x8a]
(kms_flip:5897) igt_core-INFO:   #6 [__libc_start_main+0x8b]
(kms_flip:5897) igt_core-INFO:   #7 [_start+0x25]
****  END  ****
Dynamic subtest A-eDP1: FAIL (4.936s)
Starting dynamic subtest: B-eDP1
Dynamic subtest B-eDP1: SUCCESS (11.294s)
Starting dynamic subtest: C-eDP1
Dynamic subtest C-eDP1: SUCCESS (11.223s)
Subtest flip-vs-expired-vblank: FAIL (27.465s)
Dmesg
<6> [303.426903] Console: switching to colour dummy device 80x25
<6> [303.427219] [IGT] kms_flip: executing
<7> [303.432715] xe 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] [CONNECTOR:401:DP-1]
<7> [303.432726] xe 0000:00:02.0: [drm:intel_dp_detect [xe]] [CONNECTOR:401:DP-1]
<7> [303.432899] xe 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] [CONNECTOR:401:DP-1] disconnected
<7> [303.433128] xe 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] [CONNECTOR:413:DP-2]
<7> [303.433130] xe 0000:00:02.0: [drm:intel_dp_detect [xe]] [CONNECTOR:413:DP-2]
<7> [303.433247] xe 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] [CONNECTOR:413:DP-2] disconnected
<7> [303.433464] xe 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] [CONNECTOR:421:DP-3]
<7> [303.433466] xe 0000:00:02.0: [drm:intel_dp_detect [xe]] [CONNECTOR:421:DP-3]
<7> [303.433592] xe 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] [CONNECTOR:421:DP-3] disconnected
<7> [303.434091] xe 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] [CONNECTOR:392:eDP-1]
<7> [303.434095] xe 0000:00:02.0: [drm:intel_dp_detect [xe]] [CONNECTOR:392:eDP-1]
<7> [303.434539] xe 0000:00:02.0: [drm:intel_dp_read_dsc_dpcd [xe]] DSC DPCD: 00 11 00 76 0b 01 01 80 00 01 06 66 08 00 00 00
<7> [303.434864] xe 0000:00:02.0: [drm:intel_dp_print_rates [xe]] source rates: 162000, 216000, 243000, 270000, 324000, 432000, 540000, 675000, 810000
<7> [303.434978] xe 0000:00:02.0: [drm:intel_dp_print_rates [xe]] sink rates: 162000, 216000, 243000, 270000, 324000, 432000, 540000, 810000
<7> [303.435114] xe 0000:00:02.0: [drm:intel_dp_print_rates [xe]] common rates: 162000, 216000, 243000, 270000, 324000, 432000, 540000, 810000
<7> [303.435312] xe 0000:00:02.0: [drm:update_display_info.part.0] [CONNECTOR:392:eDP-1] Supported Monitor Refresh rate range is 40 Hz - 120 Hz
<5> [303.435320] [drm] DisplayID checksum invalid, remainder is 248 (ignoring)
<5> [303.435323] [drm] DisplayID checksum invalid, remainder is 248 (ignoring)
<7> [303.435326] xe 0000:00:02.0: [drm:update_display_info.part.0] [CONNECTOR:392:eDP-1] DisplayID extension version 0x13, primary use 0x00
<7> [303.435331] xe 0000:00:02.0: [drm:update_display_info.part.0] [CONNECTOR:392:eDP-1] Assigning EDID-1.4 digital sink color depth as 10 bpc.
<5> [303.435336] [drm] DisplayID checksum invalid, remainder is 248 (ignoring)
<7> [303.435339] xe 0000:00:02.0: [drm:update_display_info.part.0] [CONNECTOR:392:eDP-1] ELD monitor
<5> [303.435345] [drm] DisplayID checksum invalid, remainder is 248 (ignoring)
<7> [303.435348] xe 0000:00:02.0: [drm:update_display_info.part.0] [CONNECTOR:392:eDP-1] ELD size 20, SAD count 0
<5> [303.435353] [drm] DisplayID checksum invalid, remainder is 248 (ignoring)
<7> [303.435373] xe 0000:00:02.0: [drm:intel_dp_set_edid [xe]] [CONNECTOR:392:eDP-1] VRR capable: yes
<7> [303.435546] xe 0000:00:02.0: [drm:intel_dp_set_edid [xe]] [CONNECTOR:392:eDP-1] DFP max bpc 0, max dotclock 0, TMDS clock 0-0, PCON Max FRL BW 0Gbps
<7> [303.435708] xe 0000:00:02.0: [drm:intel_dp_set_edid [xe]] [CONNECTOR:392:eDP-1] RGB->YcbCr conversion? no, YCbCr 4:2:0 allowed? yes, YCbCr 4:4:4->4:2:0 conversion? no
<5> [303.436094] [drm] DisplayID checksum invalid, remainder is 248 (ignoring)
<5> [303.436096] [drm] DisplayID checksum invalid, remainder is 248 (ignoring)
<5> [303.436098] [drm] DisplayID checksum invalid, remainder is 248 (ignoring)
<7> [303.436156] xe 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] [CONNECTOR:392:eDP-1] probed modes:
<7> [303.436159] xe 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "2880x1800": 60 347710 2880 2928 2960 3040 1800 1803 1809 1906 0x48 0xa
<7> [303.436162] xe 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "2880x1800": 120 695310 2880 2928 2960 3040 1800 1803 1809 1906 0x40 0xa
<7> [303.436175] xe 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] [CONNECTOR:401:DP-1]
<7> [303.436178] xe 0000:00:02.0: [drm:intel_dp_detect [xe]] [CONNECTOR:401:DP-1]
<7> [303.436308] xe 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] [CONNECTOR:401:DP-1] disconnected
<7> [303.436318] xe 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] [CONNECTOR:413:DP-2]
<7> [303.436321] xe 0000:00:02.0: [drm:intel_dp_detect [xe]] [CONNECTOR:413:DP-2]
<7> [303.436431] xe 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] [CONNECTOR:413:DP-2] disconnected
<7> [303.436439] xe 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] [CONNECTOR:421:DP-3]
<7> [303.436441] xe 0000:00:02.0: [drm:intel_dp_detect [xe]] [CONNECTOR:421:DP-3]
<7> [303.436543] xe 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] [CONNECTOR:421:DP-3] disconnected
<6> [303.437020] [IGT] kms_flip: starting subtest flip-vs-expired-vblank
<6> [303.438210] [IGT] kms_flip: starting dynamic subtest A-eDP1
<7> [303.452467] xe 0000:00:02.0: [drm:drm_mode_addfb2] [FB:430]
<7> [303.452939] xe 0000:00:02.0: [drm:drm_mode_addfb2] [FB:431]
<7> [303.540016] xe 0000:00:02.0: [drm:drm_mode_setcrtc] [CRTC:150:pipe A]
<7> [303.540281] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:150:pipe A] fastset requirement not met in hw.enable (expected yes, found no)
<7> [303.540676] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:150:pipe A] fastset requirement not met in hw.active (expected yes, found no)
<7> [303.541050] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:150:pipe A] fastset requirement not met in cpu_transcoder (expected 0, found -1)
<7> [303.541376] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:150:pipe A] fastset requirement not met in lane_count (expected 4, found 0)
<7> [303.541691] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:150:pipe A] fastset requirement not met in dp_m_n (expected tu 64 data 6329869/8388608 link 421991/524288, found tu 0, data 0/0 link 0/0)
<7> [303.542012] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:150:pipe A] fastset requirement not met in output_types (expected 0x00000100, found 0x00000000)
<7> [303.542286] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:150:pipe A] fastset requirement not met in framestart_delay (expected 1, found 0)
<7> [303.542547] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:150:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hdisplay (expected 2880, found 0)
<7> [303.542800] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:150:pipe A] fastset requirement not met in hw.pipe_mode.crtc_htotal (expected 3040, found 0)
<7> [303.543060] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:150:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hblank_start (expected 2880, found 0)
<7> [303.543296] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:150:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hblank_end (expected 3040, found 0)
<7> [303.543564] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:150:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hsync_start (expected 2928, found 0)
<7> [303.543780] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:150:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hsync_end (expected 2960, found 0)
<7> [303.543997] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:150:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vdisplay (expected 1800, found 0)
<7> [303.544204] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:150:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vblank_start (expected 1800, found 0)
<7> [303.544434] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:150:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vsync_start (expected 1803, found 0)
<7> [303.544639] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:150:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vsync_end (expected 1809, found 0)
<7> [303.544861] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:150:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vtotal (expected 1906, found 0)
<7> [303.545065] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:150:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vblank_end (expected 1906, found 0)
<7> [303.545248] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:150:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hdisplay (expected 2880, found 0)
<7> [303.545426] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:150:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_htotal (expected 3040, found 0)
<7> [303.545596] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:150:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hblank_start (expected 2880, found 0)
<7> [303.545765] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:150:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hblank_end (expected 3040, found 0)
<7> [303.545936] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:150:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hsync_start (expected 2928, found 0)
<7> [303.546161] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:150:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hsync_end (expected 2960, found 0)
<7> [303.546323] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:150:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vdisplay (expected 1800, found 0)
<7> [303.546474] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:150:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vblank_start (expected 1800, found 0)
<7> [303.546624] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:150:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vsync_start (expected 1803, found 0)
<7> [303.546772] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:150:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vsync_end (expected 1809, found 0)
<7> [303.546916] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:150:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vtotal (expected 1906, found 0)
<7> [303.547079] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:150:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vblank_end (expected 1906, found 0)
<7> [303.547222] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:150:pipe A] fastset requirement not met in pixel_multiplier (expected 1, found 0)
<7> [303.547378] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:150:pipe A] fastset requirement not met in hw.adjusted_mode.flags (2) (expected 2, found 0)
<7> [303.547527] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:150:pipe A] fastset requirement not met in hw.adjusted_mode.flags (8) (expected 8, found 0)
<7> [303.547666] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:150:pipe A] fastset requirement not met in pipe_bpp (expected 30, found 0)
<7> [303.547796] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:150:pipe A] fastset requirement not met in hw.pipe_mode.crtc_clock (expected 347710, found 0)
<7> [303.547925] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:150:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_clock (expected 347710, found 0)
<7> [303.548081] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:150:pipe A] fastset requirement not met in port_clock (expected 432000, found 0)
<7> [303.548217] xe 0000:00:02.0: [drm:intel_atomic_check [xe]] [CRTC:150:pipe A] fastset requirement not met, forcing full modeset
<7> [303.548349] xe 0000:00:02.0: [drm:intel_dpll_crtc_put [xe]] [CRTC:150:pipe A] releasing DPLL 0
<7> [303.548552] xe 0000:00:02.0: [drm:skl_compute_wm [xe]] Enabled dbuf slices 0xf -> 0x1 (total dbuf slices 0xf), mbus joined? yes->no
<7> [303.548655] xe 0000:00:02.0: [drm:skl_compute_wm [xe]] [CRTC:150:pipe A] dbuf slices 0xf -> 0x0, ddb (0 - 4096) -> (0 - 0), active pipes 0x1 -> 0x0
<7> [303.548788] xe 0000:00:02.0: [drm:skl_compute_wm [xe]] [PLANE:34:plane 1A] ddb ( 0 - 4051) -> ( 0 - 0), size 4051 -> 0
<7> [303.548900] xe 0000:00:02.0: [drm:skl_compute_wm [xe]] [PLANE:144:cursor A] ddb (4051 - 4096) -> ( 0 - 0), size 45 -> 0
<7> [303.549028] xe 0000:00:02.0: [drm:skl_print_plane_changes [xe]] [PLANE:34: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> [303.549123] xe 0000:00:02.0: [drm:skl_print_plane_changes [xe]] [PLANE:34:plane 1A] lines 1, 13, 13, 13, 13, 13, 0, 0, 0, 3, 0 -> 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0
<7> [303.549211] xe 0000:00:02.0: [drm:skl_print_plane_changes [xe]] [PLANE:34:plane 1A] blocks 24, 313, 313, 313, 313, 313, 0, 0, 38, 73, 87 -> 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0
<7> [303.549308] xe 0000:00:02.0: [drm:skl_print_plane_changes [xe]] [PLANE:34:plane 1A] min_ddb 28, 346, 346, 346, 346, 346, 0, 0, 39, 82, 88 -> 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0
<7> [303.549435] xe 0000:00:02.0: [drm:intel_bw_atomic_check [xe]] [CRTC:150:pipe A] data rate 0 num active planes 0
<7> [303.549569] xe 0000:00:02.0: [drm:intel_bw_atomic_check [xe]] QGV point 0: max bw 23530 required 0 qgv_peak_bw: 38400
<7> [303.549690] xe 0000:00:02.0: [drm:intel_bw_atomic_check [xe]] QGV point 1: max bw 36260 required 0 qgv_peak_bw: 38400
<7> [303.549808] xe 0000:00:02.0: [drm:intel_bw_atomic_check [xe]] QGV point 2: max bw 38000 required 0 qgv_peak_bw: 38400
<7> [303.549924] xe 0000:00:02.0: [drm:intel_bw_atomic_check [xe]] QGV point 3: max bw 38000 required 0 qgv_peak_bw: 38400
<7> [303.550055] xe 0000:00:02.0: [drm:intel_bw_atomic_check [xe]] Matching peaks QGV bw: 38400 for required data rate: 0
<7> [303.550170] xe 0000:00:02.0: [drm:intel_cdclk_atomic_check [xe]] [CRTC:150:pipe A] min cdclk: 173855 kHz -> 0 kHz
<7> [303.550303] xe 0000:00:02.0: [drm:intel_cdclk_update_dbuf_bw_min_cdclk [xe]] dbuf bandwidth min cdclk: 21732 kHz -> 0 kHz
<7> [303.550411] xe 0000:00:02.0: [drm:intel_cdclk_atomic_check [xe]] Can change cdclk via squashing
<7> [303.550515] xe 0000:00:02.0: [drm:intel_cdclk_atomic_check [xe]] New cdclk calculated to be logical 153600 kHz, actual 153600 kHz
<7> [303.550617] xe 0000:00:02.0: [drm:intel_cdclk_atomic_check [xe]] New voltage level calculated to be logical 0, actual 0
<7> [303.550750] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [CRTC:150:pipe A] enable: no [modeset]
<7> [303.550870] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [PLANE:34:plane 1A] fb: [NOFB], visible: no
<7> [303.550995] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [PLANE:64:plane 2A] fb: [NOFB], visible: no
<7> [303.551106] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [PLANE:94:plane 3A] fb: [NOFB], visible: no
<7> [303.551203] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [PLANE:124:plane 4A] fb: [NOFB], visible: no
<7> [303.551298] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [PLANE:134:plane 5A] fb: [NOFB], visible: no
<7> [303.551387] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [PLANE:144:cursor A] fb: [NOFB], visible: no
<7> [303.551540] xe 0000:00:02.0: [drm:intel_power_well_enable [xe]] enabling DC_off
<7> [303.552291] xe 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [xe]] Setting DC state from 02 to 00
<7> [303.552426] xe 0000:00:02.0: [drm:intel_psr_disable_locked [xe]] Disabling PSR2
<7> [303.553137] xe 0000:00:02.0: [drm:intel_alpm_disable [xe]] Disabling ALPM
<7> [303.553248] xe 0000:00:02.0: [drm:intel_edp_backlight_off [xe]]
<7> [303.755783] xe 0000:00:02.0: [drm:intel_backlight_set_pwm_level [xe]] [CONNECTOR:392:eDP-1] set backlight PWM = 0
<7> [303.756396] xe 0000:00:02.0: [drm:intel_disable_transcoder [xe]] disabling pipe A
<7> [303.777428] xe 0000:00:02.0: [drm:intel_pps_off_unlocked [xe]] [ENCODER:391:DDI A/PHY A] PPS 0 turn panel power off
<7> [303.777893] xe 0000:00:02.0: [drm:intel_pps_off_unlocked [xe]] [ENCODER:391:DDI A/PHY A] PPS 0 wait for panel power off time
<7> [303.777871] xe 0000:00:02.0: [drm:icp_irq_handler [xe]] hotplug event received, stat 0x00010000, dig 0x00000009, pins 0x00000010, long 0x00000000
<7> [303.778261] xe 0000:00:02.0: [drm:wait_panel_status [xe]] [ENCODER:391:DDI A/PHY A] PPS 0 mask: 0xb0000000 value: 0x00000000 PP_STATUS: 0xa0000002 PP_CONTROL: 0x00000060
<7> [303.778358] xe 0000:00:02.0: [drm:intel_hpd_irq_handler [xe]] digital hpd on [ENCODER:391:DDI A/PHY A] - short
<7> [303.830533] xe 0000:00:02.0: [drm:icp_irq_handler [xe]] hotplug event received, stat 0x00010000, dig 0x00000009, pins 0x00000010, long 0x00000000
<7> [303.830915] xe 0000:00:02.0: [drm:intel_hpd_irq_handler [xe]] digital hpd on [ENCODER:391:DDI A/PHY A] - short
<7> [303.839165] xe 0000:00:02.0: [drm:wait_panel_status [xe]] Wait complete
<7> [303.839596] xe 0000:00:02.0: [drm:intel_dpll_disable [xe]] disable DPLL 0 (active 0x1, on? 1) for [CRTC:150:pipe A]
<7> [303.839646] xe 0000:00:02.0: [drm:intel_dp_hpd_pulse [xe]] ignoring short hpd on eDP [ENCODER:391:DDI A/PHY A]
<7> [303.840136] xe 0000:00:02.0: [drm:intel_dp_hpd_pulse [xe]] ignoring short hpd on eDP [ENCODER:391:DDI A/PHY A]
<7> [303.841113] xe 0000:00:02.0: [drm:intel_dpll_disable [xe]] disabling DPLL 0
<7> [303.841525] xe 0000:00:02.0: [drm:intel_power_well_disable [xe]] disabling AUX_A
<7> [303.841982] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:391:DDI A/PHY A]
<7> [303.842313] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:400:DDI TC1/PHY TC1]
<7> [303.842578] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:402:DP-MST A]
<7> [303.842870] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:403:DP-MST B]
<7> [303.843124] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:404:DP-MST C]
<7> [303.843370] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:412:DDI TC2/PHY TC2]
<7> [303.843612] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:414:DP-MST A]
<7> [303.843882] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:415:DP-MST B]
<7> [303.844175] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:416:DP-MST C]
<7> [303.844419] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:420:DDI TC3/PHY TC3]
<7> [303.844650] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:422:DP-MST A]
<7> [303.844922] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:423:DP-MST B]
<7> [303.845152] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:424:DP-MST C]
<7> [303.845412] xe 0000:00:02.0: [drm:verify_connector_state [xe]] [CONNECTOR:392:eDP-1]
<7> [303.845721] xe 0000:00:02.0: [drm:intel_dbuf_mdclk_cdclk_ratio_update [xe]] Updating dbuf ratio to 4 (mbus joined: no)
<7> [303.845946] xe 0000:00:02.0: [drm:intel_dbuf_mbus_join_update [xe]] Changing mbus joined: yes -> no (pipe: *)
<7> [303.846166] xe 0000:00:02.0: [drm:gen9_dbuf_slices_update [xe]] Updating dbuf slices to 0x1
<7> [303.846584] xe 0000:00:02.0: [drm:intel_power_well_disable [xe]] disabling PW_A
<7> [303.846934] xe 0000:00:02.0: [drm:dss_pipe_gating_enable_disable [xe]] DSS clock gating disabled for pipe_mask=0x1 (CLKGATE_DIS_DSSDSC=0xaa000000)
<7> [303.847367] xe 0000:00:02.0: [drm:intel_modeset_verify_crtc [xe]] [CRTC:150:pipe A]
<7> [303.847654] xe 0000:00:02.0: [drm:intel_set_cdclk [xe]] Post changing CDCLK to 153600 kHz, VCO 614400 kHz, ref 38400 kHz, bypass 19200 kHz, voltage level 0
<7> [303.848043] xe 0000:00:02.0: [drm:intel_dbuf_mdclk_cdclk_ratio_update [xe]] Updating dbuf ratio to 4 (mbus joined: no)
<7> [303.848353] xe 0000:00:02.0: [drm:intel_audio_cdclk_change_post.part.0 [xe]] aud_ts_cdclk set to M=60, N=384
<7> [303.849173] xe 0000:00:02.0: [drm:drm_mode_setcrtc] [CRTC:269:pipe B]
<7> [303.849523] xe 0000:00:02.0: [drm:drm_mode_setcrtc] [CRTC:388:pipe C]
<7> [303.849811] xe 0000:00:02.0: [drm:drm_mode_setcrtc] [CRTC:150:pipe A]
<7> [303.849870] xe 0000:00:02.0: [drm:drm_mode_setcrtc] [CONNECTOR:392:eDP-1]
<7> [303.850032] xe 0000:00:02.0: [drm:intel_atomic_check [xe]] [CONNECTOR:392:eDP-1] Limiting target display pipe bpp to 30 (EDID bpp 30, max requested bpp 36, max platform bpp 36)
<7> [303.850389] xe 0000:00:02.0: [drm:intel_dp_compute_config_limits [xe]] [ENCODER:391:DDI A/PHY A][CRTC:150:pipe A] DP link limits: pixel clock 347710 kHz DSC off max lanes 4 max rate 810000 max pipe_bpp 30 min link_bpp 18.0000 max link_bpp 30.0000
<7> [303.850773] xe 0000:00:02.0: [drm:intel_dp_compute_link_config [xe]] DP lane count 4 clock 432000 bpp input 30 compressed 0.0000 HDR no link rate required 1303913 available 1728000
<7> [303.851098] xe 0000:00:02.0: [drm:intel_atomic_check [xe]] [CRTC:150:pipe A] hw max bpp: 30, pipe bpp: 30, dithering: 0
<7> [303.851411] xe 0000:00:02.0: [drm:intel_ddi_compute_config_late [xe]] [ENCODER:391:DDI A/PHY A] [CRTC:150:pipe A]
<7> [303.851728] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:150:pipe A] fastset requirement not met in hw.enable (expected no, found yes)
<7> [303.852047] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:150:pipe A] fastset requirement not met in hw.active (expected no, found yes)
<7> [303.852333] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:150:pipe A] fastset requirement not met in cpu_transcoder (expected -1, found 0)
<7> [303.852617] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:150:pipe A] fastset requirement not met in lane_count (expected 0, found 4)
<7> [303.852909] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:150:pipe A] fastset requirement not met in dp_m_n (expected tu 0 data 0/0 link 0/0, found tu 64, data 6329869/8388608 link 421991/524288)
<7> [303.853227] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:150:pipe A] fastset requirement not met in output_types (expected 0x00000000, found 0x00000100)
<7> [303.853481] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:150:pipe A] fastset requirement not met in framestart_delay (expected 0, found 1)
<7> [303.853794] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:150:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hdisplay (expected 0, found 2880)
<7> [303.854045] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:150:pipe A] fastset requirement not met in hw.pipe_mode.crtc_htotal (expected 0, found 3040)
<7> [303.854281] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:150:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hblank_start (expected 0, found 2880)
<7> [303.854501] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:150:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hblank_end (expected 0, found 3040)
<7> [303.854705] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:150:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hsync_start (expected 0, found 2928)
<7> [303.854943] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:150:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hsync_end (expected 0, found 2960)
<7> [303.855169] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:150:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vdisplay (expected 0, found 1800)
<7> [303.855366] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:150:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vblank_start (expected 0, found 1800)
<7> [303.855555] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:150:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vsync_start (expected 0, found 1803)
<7> [303.855739] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:150:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vsync_end (expected 0, found 1809)
<7> [303.855945] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:150:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vtotal (expected 0, found 1906)
<7> [303.856116] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:150:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vblank_end (expected 0, found 1906)
<7> [303.856280] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:150:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hdisplay (expected 0, found 2880)
<7> [303.856437] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:150:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_htotal (expected 0, found 3040)
<7> [303.856597] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:150:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hblank_start (expected 0, found 2880)
<7> [303.856758] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:150:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hblank_end (expected 0, found 3040)
<7> [303.856910] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:150:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hsync_start (expected 0, found 2928)
<7> [303.857063] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:150:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hsync_end (expected 0, found 2960)
<7> [303.857227] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:150:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vdisplay (expected 0, found 1800)
<7> [303.857391] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:150:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vblank_start (expected 0, found 1800)
<7> [303.857533] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:150:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vsync_start (expected 0, found 1803)
<7> [303.857666] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:150:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vsync_end (expected 0, found 1809)
<7> [303.857821] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:150:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vtotal (expected 0, found 1906)
<7> [303.857976] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:150:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vblank_end (expected 0, found 1906)
<7> [303.858106] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:150:pipe A] fastset requirement not met in pixel_multiplier (expected 0, found 1)
<7> [303.858232] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:150:pipe A] fastset requirement not met in hw.adjusted_mode.flags (2) (expected 0, found 2)
<7> [303.858356] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:150:pipe A] fastset requirement not met in hw.adjusted_mode.flags (8) (expected 0, found 8)
<7> [303.858484] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:150:pipe A] fastset requirement not met in pipe_bpp (expected 0, found 30)
<7> [303.858606] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:150:pipe A] fastset requirement not met in hw.pipe_mode.crtc_clock (expected 0, found 347710)
<7> [303.858732] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:150:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_clock (expected 0, found 347710)
<7> [303.858857] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:150:pipe A] fastset requirement not met in port_clock (expected 0, found 432000)
<7> [303.858979] xe 0000:00:02.0: [drm:intel_atomic_check [xe]] [CRTC:150:pipe A] fastset requirement not met, forcing full modeset
<7> [303.859144] xe 0000:00:02.0: [drm:skl_compute_wm [xe]] Enabled dbuf slices 0x1 -> 0xf (total dbuf slices 0xf), mbus joined? no->yes
<7> [303.859246] xe 0000:00:02.0: [drm:skl_compute_wm [xe]] [CRTC:150:pipe A] dbuf slices 0x0 -> 0xf, ddb (0 - 0) -> (0 - 4096), active pipes 0x0 -> 0x1
<7> [303.859365] xe 0000:00:02.0: [drm:skl_compute_wm [xe]] [PLANE:34:plane 1A] ddb ( 0 - 0) -> ( 0 - 4051), size 0 -> 4051
<7> [303.859444] xe 0000:00:02.0: [drm:skl_compute_wm [xe]] [PLANE:144:cursor A] ddb ( 0 - 0) -> (4051 - 4096), size 0 -> 45
<7> [303.859521] xe 0000:00:02.0: [drm:skl_print_plane_changes [xe]] [PLANE:34: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> [303.859595] xe 0000:00:02.0: [drm:skl_print_plane_changes [xe]] [PLANE:34:plane 1A] lines 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0 -> 4, 13, 13, 13, 13, 13, 0, 0, 0, 4, 0
<7> [303.859669] xe 0000:00:02.0: [drm:skl_print_plane_changes [xe]] [PLANE:34:plane 1A] blocks 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0 -> 92, 297, 297, 297, 297, 297, 0, 0, 197, 92, 197
<7> [303.859764] xe 0000:00:02.0: [drm:skl_print_plane_changes [xe]] [PLANE:34:plane 1A] min_ddb 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0 -> 183, 456, 456, 456, 456, 456, 0, 0, 198, 183, 198
<7> [303.859867] xe 0000:00:02.0: [drm:intel_bw_atomic_check [xe]] [CRTC:150:pipe A] data rate 1390840 num active planes 1
<7> [303.859999] xe 0000:00:02.0: [drm:intel_bw_atomic_check [xe]] QGV point 0: max bw 23530 required 1461 qgv_peak_bw: 38400
<7> [303.860126] xe 0000:00:02.0: [drm:intel_bw_atomic_check [xe]] QGV point 1: max bw 36260 required 1461 qgv_peak_bw: 38400
<7> [303.860229] xe 0000:00:02.0: [drm:intel_bw_atomic_check [xe]] QGV point 2: max bw 38000 required 1461 qgv_peak_bw: 38400
<7> [303.860329] xe 0000:00:02.0: [drm:intel_bw_atomic_check [xe]] QGV point 3: max bw 38000 required 1461 qgv_peak_bw: 38400
<7> [303.860425] xe 0000:00:02.0: [drm:intel_bw_atomic_check [xe]] Matching peaks QGV bw: 38400 for required data rate: 1461
<7> [303.860519] xe 0000:00:02.0: [drm:intel_cdclk_atomic_check [xe]] [CRTC:150:pipe A] min cdclk: 0 kHz -> 173855 kHz
<7> [303.860630] xe 0000:00:02.0: [drm:intel_cdclk_update_dbuf_bw_min_cdclk [xe]] dbuf bandwidth min cdclk: 0 kHz -> 21732 kHz
<7> [303.860722] xe 0000:00:02.0: [drm:intel_cdclk_atomic_check [xe]] Can change cdclk via squashing
<7> [303.860837] xe 0000:00:02.0: [drm:intel_cdclk_atomic_check [xe]] New cdclk calculated to be logical 192000 kHz, actual 192000 kHz
<7> [303.860936] xe 0000:00:02.0: [drm:intel_cdclk_atomic_check [xe]] New voltage level calculated to be logical 0, actual 0
<7> [303.861047] xe 0000:00:02.0: [drm:intel_find_dpll [xe]] [CRTC:150:pipe A] allocated DPLL 0
<7> [303.861142] xe 0000:00:02.0: [drm:intel_dpll_crtc_get [xe]] [CRTC:150:pipe A] reserving DPLL 0
<7> [303.861240] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [CRTC:150:pipe A] enable: yes [modeset]
<7> [303.861337] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] active: yes, output_types: EDP (0x100), output format: RGB, sink format: RGB
<7> [303.861425] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] cpu_transcoder: A, pipe bpp: 30, dithering: 0
<7> [303.861505] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] MST master transcoder: <invalid>
<7> [303.861583] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] port sync: master transcoder: <invalid>, slave transcoder bitmask = 0x0
<7> [303.861661] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] joiner: no, pipes: 0x0
<7> [303.861747] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] splitter: disabled, link count 0, overlap 0
<7> [303.861850] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] dp m_n: lanes: 4; data_m: 6329869, data_n: 8388608, link_m: 421991, link_n: 524288, tu: 64
<7> [303.861950] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] dp m2_n2: lanes: 4; data_m: 0, data_n: 0, link_m: 0, link_n: 0, tu: 0
<7> [303.862046] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] fec: disabled, enhanced framing: disabled
<7> [303.862120] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] sdp split: disabled
<7> [303.862193] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] psr: enabled, selective update: enabled, panel replay: disabled, selective fetch: enabled
<7> [303.862267] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] minimum HBlank: 0
<7> [303.862351] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] audio: 0, infoframes: 0, infoframes enabled: 0x4
<7> [303.862449] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] DP SDP: VSC, revision 4, length 14
<7> [303.862536] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] pixelformat: RGB
<7> [303.862616] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] colorimetry: sRGB
<7> [303.862697] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] bpc: 0
<7> [303.862799] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] dynamic range: VESA range
<7> [303.862893] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] content type: Not defined
<7> [303.862983] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] scanline offset: 1
<7> [303.863067] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] framestart delay: 1, MSA timing delay: 0, set context latency: 0
<7> [303.863138] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] vrr: no, fixed rr: yes, vmin: 1906, vmax: 1906, flipline: 1906, pipeline full: 0, guardband: 104 vsync start: 103, vsync end: 97
<7> [303.863207] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] vrr: vmin vblank: 1802, vmax vblank: 1802, vmin vtotal: 1906, vmax vtotal: 1906
<7> [303.863276] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] vrr: dc balance: no, vmin: 0 vmax: 0 guardband: 0, slope: 0 max increase: 0 max decrease: 0 vblank target: 0
<7> [303.863350] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] requested mode: "2880x1800": 60 347710 2880 2928 2960 3040 1800 1803 1809 1906 0x48 0xa
<7> [303.863435] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] adjusted mode: "2880x1800": 60 347710 2880 2928 2960 3040 1800 1803 1809 1906 0x48 0xa
<7> [303.863519] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] crtc timings: clock=347710, hd=2880 hb=2880-3040 hs=2928-2960 ht=3040, vd=1800 vb=1800-1906 vs=1803-1809 vt=1906, flags=0xa
<7> [303.863597] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] pipe mode: "2880x1800": 60 347710 2880 2928 2960 3040 1800 1803 1809 1906 0x40 0xa
<7> [303.863675] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] crtc timings: clock=347710, hd=2880 hb=2880-3040 hs=2928-2960 ht=3040, vd=1800 vb=1800-1906 vs=1803-1809 vt=1906, flags=0xa
<7> [303.863754] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] port clock: 432000, pipe src: 2880x1800+0+0, pixel rate 347710, min cdclk 173855
<7> [303.863845] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] linetime: 70, ips linetime: 0
<7> [303.863935] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] num_scalers: 2, scaler_users: 0x0, scaler_id: -1, scaling_filter: 0
<7> [303.864024] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] pch pfit: 0x0+0+0, disabled, force thru: no
<7> [303.864104] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] ips: 0, double wide: 0, drrs: 0
<7> [303.864177] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] cx0pll_hw_state: lane_count: 4, ssc_enabled: no, use_c10: yes, tbt_mode: no
<7> [303.864255] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] c10pll_hw_state: fracen: no,
<7> [303.864340] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] multiplier: 225, tx_clk_div: 1.
<7> [303.864421] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] c10pll_rawhw_state:
<7> [303.864501] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] tx: 0x10, cmn: 0x21
<7> [303.864587] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] pll[0] = 0x4, pll[1] = 0x0, pll[2] = 0xa2, pll[3] = 0x1
<7> [303.864679] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] pll[4] = 0x0, pll[5] = 0x0, pll[6] = 0x0, pll[7] = 0x0
<7> [303.864824] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] pll[8] = 0x0, pll[9] = 0x1, pll[10] = 0x0, pll[11] = 0x0
<7> [303.864928] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] pll[12] = 0x0, pll[13] = 0x0, pll[14] = 0x0, pll[15] = 0x1
<7> [303.865032] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] pll[16] = 0x85, pll[17] = 0xf, pll[18] = 0xe6, pll[19] = 0x23
<7> [303.865112] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] csc_mode: 0x0 gamma_mode: 0x0 gamma_enable: 0 csc_enable: 0
<7> [303.865197] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] pre csc lut: 0 entries, post csc lut: 0 entries
<7> [303.865282] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] output csc: pre offsets: 0x0000 0x0000 0x0000
<7> [303.865362] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] output csc: coefficients: 0x0000 0x0000 0x0000
<7> [303.865441] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] output csc: coefficients: 0x0000 0x0000 0x0000
<7> [303.865516] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] output csc: coefficients: 0x0000 0x0000 0x0000
<7> [303.865591] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] output csc: post offsets: 0x0000 0x0000 0x0000
<7> [303.865665] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] pipe csc: pre offsets: 0x0000 0x0000 0x0000
<7> [303.865739] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] pipe csc: coefficients: 0x0000 0x0000 0x0000
<7> [303.865842] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] pipe csc: coefficients: 0x0000 0x0000 0x0000
<7> [303.865933] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] pipe csc: coefficients: 0x0000 0x0000 0x0000
<7> [303.866022] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] pipe csc: post offsets: 0x0000 0x0000 0x0000
<7> [303.866111] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] sharpness strength: 0, sharpness tap size: 0, sharpness enable: 0
<7> [303.866194] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [PLANE:34:plane 1A] fb: [FB:430] 2880x1800 format = XR24 little-endian (0x34325258) modifier = 0x100000000000009, visible: yes
<7> [303.866271] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] rotation: 0x1, scaler: -1, scaling_filter: 0
<7> [303.866347] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] src: 2880.000000x1800.000000+0.000000+0.000000 dst: 2880x1800+0+0
<7> [303.866436] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [PLANE:64:plane 2A] fb: [NOFB], visible: no
<7> [303.866524] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [PLANE:94:plane 3A] fb: [NOFB], visible: no
<7> [303.866612] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [PLANE:124:plane 4A] fb: [NOFB], visible: no
<7> [303.866697] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [PLANE:134:plane 5A] fb: [NOFB], visible: no
<7> [303.866774] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [PLANE:144:cursor A] fb: [NOFB], visible: no
<7> [303.867212] xe 0000:00:02.0: [drm:intel_power_well_enable [xe]] enabling PW_A
<7> [303.867380] xe 0000:00:02.0: [drm:dss_pipe_gating_enable_disable [xe]] DSS clock gating enabled for pipe_mask=0x1 (CLKGATE_DIS_DSSDSC=0xa8000000)
<7> [303.867487] xe 0000:00:02.0: [drm:intel_set_cdclk [xe]] Pre changing CDCLK to 192000 kHz, VCO 614400 kHz, ref 38400 kHz, bypass 19200 kHz, voltage level 0
<7> [303.867582] xe 0000:00:02.0: [drm:intel_dbuf_mdclk_cdclk_ratio_update [xe]] Updating dbuf ratio to 4 (mbus joined: no)
<7> [303.867668] xe 0000:00:02.0: [drm:intel_audio_cdclk_change_post.part.0 [xe]] aud_ts_cdclk set to M=60, N=480
<7> [303.867746] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:391:DDI A/PHY A]
<7> [303.867854] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:400:DDI TC1/PHY TC1]
<7> [303.867948] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:402:DP-MST A]
<7> [303.868049] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:403:DP-MST B]
<7> [303.868128] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:404:DP-MST C]
<7> [303.868197] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:412:DDI TC2/PHY TC2]
<7> [303.868267] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:414:DP-MST A]
<7> [303.868333] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:415:DP-MST B]
<7> [303.868398] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:416:DP-MST C]
<7> [303.868464] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:420:DDI TC3/PHY TC3]
<7> [303.868530] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:422:DP-MST A]
<7> [303.868591] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:423:DP-MST B]
<7> [303.868652] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:424:DP-MST C]
<7> [303.868732] xe 0000:00:02.0: [drm:gen9_dbuf_slices_update [xe]] Updating dbuf slices to 0xf
<7> [303.868920] xe 0000:00:02.0: [drm:intel_dbuf_mbus_join_update [xe]] Changing mbus joined: no -> yes (pipe: *)
<7> [303.869011] xe 0000:00:02.0: [drm:intel_dbuf_mdclk_cdclk_ratio_update [xe]] Updating dbuf ratio to 8 (mbus joined: yes)
<7> [303.869130] xe 0000:00:02.0: [drm:intel_power_well_enable [xe]] enabling AUX_A
<7> [303.869858] xe 0000:00:02.0: [drm:icp_irq_handler [xe]] hotplug event received, stat 0x00010000, dig 0x0000000a, pins 0x00000010, long 0x00000010
<7> [303.869985] xe 0000:00:02.0: [drm:intel_hpd_irq_handler [xe]] digital hpd on [ENCODER:391:DDI A/PHY A] - long
<7> [303.870080] xe 0000:00:02.0: [drm:intel_hpd_irq_handler [xe]] Received HPD interrupt on PIN 4 - cnt: 10
<7> [303.870203] xe 0000:00:02.0: [drm:intel_dp_hpd_pulse [xe]] ignoring long hpd on eDP [ENCODER:391:DDI A/PHY A]
<7> [303.870461] xe 0000:00:02.0: [drm:intel_dpll_enable [xe]] enable DPLL 0 (active 0x1, on? 0) for [CRTC:150:pipe A]
<7> [303.870550] xe 0000:00:02.0: [drm:intel_dpll_enable [xe]] enabling DPLL 0
<7> [303.872513] xe 0000:00:02.0: [drm:intel_pps_on_unlocked [xe]] [ENCODER:391:DDI A/PHY A] PPS 0 turn panel power on
<7> [303.872604] xe 0000:00:02.0: [drm:wait_panel_power_cycle [xe]] [ENCODER:391:DDI A/PHY A] PPS 0 wait for panel power cycle (468 ms remaining)
<7> [304.349346] xe 0000:00:02.0: [drm:wait_panel_status [xe]] [ENCODER:391:DDI A/PHY A] PPS 0 mask: 0xb800000f value: 0x00000000 PP_STATUS: 0x08000001 PP_CONTROL: 0x00000060
<7> [304.429224] xe 0000:00:02.0: [drm:wait_panel_status [xe]] Wait complete
<7> [304.429523] xe 0000:00:02.0: [drm:intel_pps_on_unlocked [xe]] [ENCODER:391:DDI A/PHY A] PPS 0 wait for panel power on
<7> [304.429767] xe 0000:00:02.0: [drm:wait_panel_status [xe]] [ENCODER:391:DDI A/PHY A] PPS 0 mask: 0xb000000f value: 0x80000008 PP_STATUS: 0x9000000a PP_CONTROL: 0x00000063
<7> [304.466471] xe 0000:00:02.0: [drm:icp_irq_handler [xe]] hotplug event received, stat 0x00010000, dig 0x0000000a, pins 0x00000010, long 0x00000010
<7> [304.466865] xe 0000:00:02.0: [drm:intel_hpd_irq_handler [xe]] digital hpd on [ENCODER:391:DDI A/PHY A] - long
<7> [304.467173] xe 0000:00:02.0: [drm:intel_hpd_irq_handler [xe]] Received HPD interrupt on PIN 4 - cnt: 20
<7> [304.467722] xe 0000:00:02.0: [drm:intel_dp_hpd_pulse [xe]] ignoring long hpd on eDP [ENCODER:391:DDI A/PHY A]
<7> [304.478292] xe 0000:00:02.0: [drm:intel_tc_port_reset_mode [xe]] Port D/TC#1: TC port mode reset (tbt-alt -> disconnected) pin assignment: - max lanes: 4
<7> [304.478280] xe 0000:00:02.0: [drm:intel_tc_port_reset_mode [xe]] Port E/TC#2: TC port mode reset (tbt-alt -> disconnected) pin assignment: - max lanes: 4
<7> [304.478280] xe 0000:00:02.0: [drm:intel_tc_port_reset_mode [xe]] Port F/TC#3: TC port mode reset (tbt-alt -> disconnected) pin assignment: - max lanes: 4
<7> [304.637012] xe 0000:00:02.0: [drm:wait_panel_status [xe]] Wait complete
<7> [304.637392] xe 0000:00:02.0: [drm:intel_pps_vdd_on_unlocked [xe]] [ENCODER:391:DDI A/PHY A] PPS 0 turning VDD on
<7> [304.637799] xe 0000:00:02.0: [drm:intel_pps_vdd_on_unlocked [xe]] [ENCODER:391:DDI A/PHY A] PPS 0 PP_STATUS: 0x80000008 PP_CONTROL: 0x0000006b
<7> [304.639885] xe 0000:00:02.0: [drm:drm_dp_read_dpcd_caps [drm_display_helper]] AUX A/DDI A/PHY A: DPCD: 14 1e 44 c1 00 00 01 c0 02 00 02 00 00 0b 80
<7> [304.641449] xe 0000:00:02.0: [drm:intel_dp_start_link_train [xe]] [CONNECTOR:392:eDP-1][ENCODER:391:DDI A/PHY A][DPRX] Reloading eDP link rates
<7> [304.642314] xe 0000:00:02.0: [drm:intel_dp_start_link_train [xe]] [CONNECTOR:392:eDP-1][ENCODER:391:DDI A/PHY A][DPRX] Using LINK_RATE_SET value 05
<7> [304.643504] xe 0000:00:02.0: [drm:intel_dp_set_signal_levels [xe]] [CONNECTOR:392:eDP-1][ENCODER:391:DDI A/PHY A][DPRX] 8b/10b, lanes: 4, vswing levels: 0/0/0/0, pre-emphasis levels: 0/0/0/0
<7> [304.644838] xe 0000:00:02.0: [drm:intel_dp_program_link_training_pattern [xe]] [CONNECTOR:392:eDP-1][ENCODER:391:DDI A/PHY A][DPRX] Using DP training pattern TPS1
<7> [304.645901] xe 0000:00:02.0: [drm:intel_dp_link_train_phy [xe]] [CONNECTOR:392:eDP-1][ENCODER:391:DDI A/PHY A][DPRX] Clock recovery OK
<7> [304.646238] xe 0000:00:02.0: [drm:intel_dp_program_link_training_pattern [xe]] [CONNECTOR:392:eDP-1][ENCODER:391:DDI A/PHY A][DPRX] Using DP training pattern TPS4
<7> [304.647839] xe 0000:00:02.0: [drm:intel_dp_link_train_phy [xe]] [CONNECTOR:392:eDP-1][ENCODER:391:DDI A/PHY A][DPRX] Channel EQ done. DP Training successful
<7> [304.648250] xe 0000:00:02.0: [drm:intel_dp_link_train_phy [xe]] [CONNECTOR:392:eDP-1][ENCODER:391:DDI A/PHY A][DPRX] Link Training passed at link rate = 432000, lane count = 4
<7> [304.649050] xe 0000:00:02.0: [drm:intel_enable_transcoder [xe]] enabling pipe A
<7> [304.649537] xe 0000:00:02.0: [drm:intel_edp_backlight_on [xe]]
<7> [304.649922] xe 0000:00:02.0: [drm:intel_backlight_enable [xe]] pipe A
<7> [304.650293] xe 0000:00:02.0: [drm:intel_backlight_set_pwm_level [xe]] [CONNECTOR:392:eDP-1] set backlight PWM = 192000
<7> [304.666539] xe 0000:00:02.0: [drm:intel_psr_post_plane_update [xe]] Enabling PSR2
<7> [304.668212] xe 0000:00:02.0: [drm:verify_connector_state [xe]] [CONNECTOR:392:eDP-1]
<7> [304.668501] xe 0000:00:02.0: [drm:intel_modeset_verify_crtc [xe]] [CRTC:150:pipe A]
<7> [307.235853] xe 0000:00:02.0: [drm:intel_pps_vdd_off_sync_unlocked [xe]] [ENCODER:391:DDI A/PHY A] PPS 0 turning VDD off
<7> [307.236239] xe 0000:00:02.0: [drm:intel_pps_vdd_off_sync_unlocked [xe]] [ENCODER:391:DDI A/PHY A] PPS 0 PP_STATUS: 0x80000008 PP_CONTROL: 0x00000067
<7> [308.216484] xe 0000:00:02.0: [drm:intel_power_well_disable [xe]] disabling DC_off
<7> [308.216967] xe 0000:00:02.0: [drm:skl_enable_dc6 [xe]] Enabling DC6
<7> [308.217393] xe 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [xe]] Setting DC state from 00 to 02
<6> [308.375139] [IGT] kms_flip: finished subtest A-eDP1, FAIL
<6> [308.378151] [IGT] kms_flip: starting dynamic subtest B-eDP1
<7> [308.408185] xe 0000:00:02.0: [drm:drm_mode_addfb2] [FB:432]
<7> [308.423671] xe 0000:00:02.0: [drm:drm_mode_addfb2] [FB:433]
<7> [308.514576] xe 0000:00:02.0: [drm:drm_mode_setcrtc] [CRTC:150:pipe A]
<7> [308.514965] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:150:pipe A] fastset requirement not met in hw.enable (expected yes, found no)
<7> [308.515323] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:150:pipe A] fastset requirement not met in hw.active (expected yes, found no)
<7> [308.515603] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:150:pipe A] fastset requirement not met in cpu_transcoder (expected 0, found -1)
<7> [308.515911] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:150:pipe A] fastset requirement not met in lane_count (expected 4, found 0)
<7> [308.516150] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:150:pipe A] fastset requirement not met in dp_m_n (expected tu 64 data 6329869/8388608 link 421991/524288, found tu 0, data 0/0 link 0/0)
<7> [308.516378] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:150:pipe A] fastset requirement not met in output_types (expected 0x00000100, found 0x00000000)
<7> [308.516589] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:150:pipe A] fastset requirement not met in framestart_delay (expected 1, found 0)
<7> [308.516814] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:150:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hdisplay (expected 2880, found 0)
<7> [308.517017] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:150:pipe A] fastset requirement not met in hw.pipe_mode.crtc_htotal (expected 3040, found 0)
<7> [308.517215] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:150:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hblank_start (expected 2880, found 0)
<7> [308.517410] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:150:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hblank_end (expected 3040, found 0)
<7> [308.517597] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:150:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hsync_start (expected 2928, found 0)
<7> [308.517779] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:150:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hsync_end (expected 2960, found 0)
<7> [308.517973] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:150:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vdisplay (expected 1800, found 0)
<7> [308.518159] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:150:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vblank_start (expected 1800, found 0)
<7> [308.518336] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:150:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vsync_start (expected 1803, found 0)
<7> [308.518510] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:150:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vsync_end (expected 1809, found 0)
<7> [308.518678] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:150:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vtotal (expected 1906, found 0)
<7> [308.518853] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:150:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vblank_end (expected 1906, found 0)
<7> [308.519019] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:150:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hdisplay (expected 2880, found 0)
<7> [308.519185] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:150:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_htotal (expected 3040, found 0)
<7> [308.519348] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:150:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hblank_start (expected 2880, found 0)
<7> [308.519503] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:150:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hblank_end (expected 3040, found 0)
<7> [308.519655] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:150:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hsync_start (expected 2928, found 0)
<7> [308.519818] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:150:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hsync_end (expected 2960, found 0)
<7> [308.519968] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:150:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vdisplay (expected 1800, found 0)
<7> [308.520117] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:150:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vblank_start (expected 1800, found 0)
<7> [308.520263] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:150:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vsync_start (expected 1803, found 0)
<7> [308.520403] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:150:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vsync_end (expected 1809, found 0)
<7> [308.520544] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:150:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vtotal (expected 1906, found 0)
<7> [308.520684] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:150:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vblank_end (expected 1906, found 0)
<7> [308.520832] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:150:pipe A] fastset requirement not met in pixel_multiplier (expected 1, found 0)
<7> [308.520967] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:150:pipe A] fastset requirement not met in hw.adjusted_mode.flags (2) (expected 2, found 0)
<7> [308.521097] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:150:pipe A] fastset requirement not met in hw.adjusted_mode.flags (8) (expected 8, found 0)
<7> [308.521232] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:150:pipe A] fastset requirement not met in pipe_bpp (expected 30, found 0)
<7> [308.521359] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:150:pipe A] fastset requirement not met in hw.pipe_mode.crtc_clock (expected 347710, found 0)
<7> [308.521485] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:150:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_clock (expected 347710, found 0)
<7> [308.521610] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:150:pipe A] fastset requirement not met in port_clock (expected 432000, found 0)
<7> [308.521736] xe 0000:00:02.0: [drm:intel_atomic_check [xe]] [CRTC:150:pipe A] fastset requirement not met, forcing full modeset
<7> [308.521917] xe 0000:00:02.0: [drm:intel_dpll_crtc_put [xe]] [CRTC:150:pipe A] releasing DPLL 0
<7> [308.522137] xe 0000:00:02.0: [drm:skl_compute_wm [xe]] Enabled dbuf slices 0xf -> 0x1 (total dbuf slices 0xf), mbus joined? yes->no
<7> [308.522242] xe 0000:00:02.0: [drm:skl_compute_wm [xe]] [CRTC:150:pipe A] dbuf slices 0xf -> 0x0, ddb (0 - 4096) -> (0 - 0), active pipes 0x1 -> 0x0
<7> [308.522370] xe 0000:00:02.0: [drm:skl_compute_wm [xe]] [PLANE:34:plane 1A] ddb ( 0 - 4051) -> ( 0 - 0), size 4051 -> 0
<7> [308.522453] xe 0000:00:02.0: [drm:skl_compute_wm [xe]] [PLANE:144:cursor A] ddb (4051 - 4096) -> ( 0 - 0), size 45 -> 0
<7> [308.522534] xe 0000:00:02.0: [drm:skl_print_plane_changes [xe]] [PLANE:34: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> [308.522613] xe 0000:00:02.0: [drm:skl_print_plane_changes [xe]] [PLANE:34:plane 1A] lines 4, 13, 13, 13, 13, 13, 0, 0, 0, 4, 0 -> 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0
<7> [308.522689] xe 0000:00:02.0: [drm:skl_print_plane_changes [xe]] [PLANE:34:plane 1A] blocks 92, 297, 297, 297, 297, 297, 0, 0, 197, 92, 197 -> 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0
<7> [308.522763] xe 0000:00:02.0: [drm:skl_print_plane_changes [xe]] [PLANE:34:plane 1A] min_ddb 183, 456, 456, 456, 456, 456, 0, 0, 198, 183, 198 -> 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0
<7> [308.522885] xe 0000:00:02.0: [drm:intel_bw_atomic_check [xe]] [CRTC:150:pipe A] data rate 0 num active planes 0
<7> [308.523016] xe 0000:00:02.0: [drm:intel_bw_atomic_check [xe]] QGV point 0: max bw 23530 required 0 qgv_peak_bw: 38400
<7> [308.523135] xe 0000:00:02.0: [drm:intel_bw_atomic_check [xe]] QGV point 1: max bw 36260 required 0 qgv_peak_bw: 38400
<7> [308.523250] xe 0000:00:02.0: [drm:intel_bw_atomic_check [xe]] QGV point 2: max bw 38000 required 0 qgv_peak_bw: 38400
<7> [308.523365] xe 0000:00:02.0: [drm:intel_bw_atomic_check [xe]] QGV point 3: max bw 38000 required 0 qgv_peak_bw: 38400
<7> [308.523477] xe 0000:00:02.0: [drm:intel_bw_atomic_check [xe]] Matching peaks QGV bw: 38400 for required data rate: 0
<7> [308.523590] xe 0000:00:02.0: [drm:intel_cdclk_atomic_check [xe]] [CRTC:150:pipe A] min cdclk: 173855 kHz -> 0 kHz
<7> [308.523742] xe 0000:00:02.0: [drm:intel_cdclk_update_dbuf_bw_min_cdclk [xe]] dbuf bandwidth min cdclk: 21732 kHz -> 0 kHz
<7> [308.523870] xe 0000:00:02.0: [drm:intel_cdclk_atomic_check [xe]] Can change cdclk via squashing
<7> [308.523983] xe 0000:00:02.0: [drm:intel_cdclk_atomic_check [xe]] New cdclk calculated to be logical 153600 kHz, actual 153600 kHz
<7> [308.524095] xe 0000:00:02.0: [drm:intel_cdclk_atomic_check [xe]] New voltage level calculated to be logical 0, actual 0
<7> [308.524257] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [CRTC:150:pipe A] enable: no [modeset]
<7> [308.524371] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [PLANE:34:plane 1A] fb: [NOFB], visible: no
<7> [308.524482] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [PLANE:64:plane 2A] fb: [NOFB], visible: no
<7> [308.524593] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [PLANE:94:plane 3A] fb: [NOFB], visible: no
<7> [308.524704] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [PLANE:124:plane 4A] fb: [NOFB], visible: no
<7> [308.524823] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [PLANE:134:plane 5A] fb: [NOFB], visible: no
<7> [308.524937] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [PLANE:144:cursor A] fb: [NOFB], visible: no
<7> [308.525157] xe 0000:00:02.0: [drm:intel_power_well_enable [xe]] enabling DC_off
<7> [308.525912] xe 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [xe]] Setting DC state from 02 to 00
<7> [308.526083] xe 0000:00:02.0: [drm:intel_psr_disable_locked [xe]] Disabling PSR2
<7> [308.526284] xe 0000:00:02.0: [drm:intel_pps_vdd_on_unlocked [xe]] [ENCODER:391:DDI A/PHY A] PPS 0 turning VDD on
<7> [308.526412] xe 0000:00:02.0: [drm:intel_pps_vdd_on_unlocked [xe]] [ENCODER:391:DDI A/PHY A] PPS 0 PP_STATUS: 0x80000008 PP_CONTROL: 0x0000006f
<7> [308.527049] xe 0000:00:02.0: [drm:intel_alpm_disable [xe]] Disabling ALPM
<7> [308.527182] xe 0000:00:02.0: [drm:intel_edp_backlight_off [xe]]
<7> [308.733203] xe 0000:00:02.0: [drm:intel_backlight_set_pwm_level [xe]] [CONNECTOR:392:eDP-1] set backlight PWM = 0
<7> [308.733934] xe 0000:00:02.0: [drm:intel_disable_transcoder [xe]] disabling pipe A
<7> [308.744687] xe 0000:00:02.0: [drm:intel_pps_off_unlocked [xe]] [ENCODER:391:DDI A/PHY A] PPS 0 turn panel power off
<7> [308.745084] xe 0000:00:02.0: [drm:intel_pps_off_unlocked [xe]] [ENCODER:391:DDI A/PHY A] PPS 0 wait for panel power off time
<7> [308.745129] xe 0000:00:02.0: [drm:icp_irq_handler [xe]] hotplug event received, stat 0x00010000, dig 0x00000009, pins 0x00000010, long 0x00000000
<7> [308.745509] xe 0000:00:02.0: [drm:wait_panel_status [xe]] [ENCODER:391:DDI A/PHY A] PPS 0 mask: 0xb0000000 value: 0x00000000 PP_STATUS: 0xa0000002 PP_CONTROL: 0x00000060
<7> [308.745671] xe 0000:00:02.0: [drm:intel_hpd_irq_handler [xe]] digital hpd on [ENCODER:391:DDI A/PHY A] - short
<7> [308.797693] xe 0000:00:02.0: [drm:icp_irq_handler [xe]] hotplug event received, stat 0x00010000, dig 0x00000009, pins 0x00000010, long 0x00000000
<7> [308.798183] xe 0000:00:02.0: [drm:intel_hpd_irq_handler [xe]] digital hpd on [ENCODER:391:DDI A/PHY A] - short
<7> [308.803385] xe 0000:00:02.0: [drm:wait_panel_status [xe]] Wait complete
<7> [308.803806] xe 0000:00:02.0: [drm:intel_dpll_disable [xe]] disable DPLL 0 (active 0x1, on? 1) for [CRTC:150:pipe A]
<7> [308.803853] xe 0000:00:02.0: [drm:intel_dp_hpd_pulse [xe]] ignoring short hpd on eDP [ENCODER:391:DDI A/PHY A]
<7> [308.804474] xe 0000:00:02.0: [drm:intel_dp_hpd_pulse [xe]] ignoring short hpd on eDP [ENCODER:391:DDI A/PHY A]
<7> [308.805475] xe 0000:00:02.0: [drm:intel_dpll_disable [xe]] disabling DPLL 0
<7> [308.806057] xe 0000:00:02.0: [drm:intel_power_well_disable [xe]] disabling AUX_A
<7> [308.806716] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:391:DDI A/PHY A]
<7> [308.807166] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:400:DDI TC1/PHY TC1]
<7> [308.807563] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:402:DP-MST A]
<7> [308.807928] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:403:DP-MST B]
<7> [308.808306] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:404:DP-MST C]
<7> [308.808667] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:412:DDI TC2/PHY TC2]
<7> [308.809026] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:414:DP-MST A]
<7> [308.809400] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:415:DP-MST B]
<7> [308.809752] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:416:DP-MST C]
<7> [308.810104] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:420:DDI TC3/PHY TC3]
<7> [308.810472] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:422:DP-MST A]
<7> [308.810823] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:423:DP-MST B]
<7> [308.811174] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:424:DP-MST C]
<7> [308.811540] xe 0000:00:02.0: [drm:verify_connector_state [xe]] [CONNECTOR:392:eDP-1]
<7> [308.811983] xe 0000:00:02.0: [drm:intel_dbuf_mdclk_cdclk_ratio_update [xe]] Updating dbuf ratio to 4 (mbus joined: no)
<7> [308.812331] xe 0000:00:02.0: [drm:intel_dbuf_mbus_join_update [xe]] Changing mbus joined: yes -> no (pipe: *)
<7> [308.812655] xe 0000:00:02.0: [drm:gen9_dbuf_slices_update [xe]] Updating dbuf slices to 0x1
<7> [308.813209] xe 0000:00:02.0: [drm:intel_power_well_disable [xe]] disabling PW_A
<7> [308.813644] xe 0000:00:02.0: [drm:dss_pipe_gating_enable_disable [xe]] DSS clock gating disabled for pipe_mask=0x1 (CLKGATE_DIS_DSSDSC=0xaa000000)
<7> [308.814143] xe 0000:00:02.0: [drm:intel_modeset_verify_crtc [xe]] [CRTC:150:pipe A]
<7> [308.814527] xe 0000:00:02.0: [drm:intel_set_cdclk [xe]] Post changing CDCLK to 153600 kHz, VCO 614400 kHz, ref 38400 kHz, bypass 19200 kHz, voltage level 0
<7> [308.814953] xe 0000:00:02.0: [drm:intel_dbuf_mdclk_cdclk_ratio_update [xe]] Updating dbuf ratio to 4 (mbus joined: no)
<7> [308.815269] xe 0000:00:02.0: [drm:intel_audio_cdclk_change_post.part.0 [xe]] aud_ts_cdclk set to M=60, N=384
<7> [308.816352] xe 0000:00:02.0: [drm:drm_mode_setcrtc] [CRTC:269:pipe B]
<7> [308.816850] xe 0000:00:02.0: [drm:drm_mode_setcrtc] [CRTC:388:pipe C]
<7> [308.817207] xe 0000:00:02.0: [drm:drm_mode_setcrtc] [CRTC:269:pipe B]
<7> [308.817344] xe 0000:00:02.0: [drm:drm_mode_setcrtc] [CONNECTOR:392:eDP-1]
<7> [308.817565] xe 0000:00:02.0: [drm:intel_atomic_check [xe]] [CONNECTOR:392:eDP-1] Limiting target display pipe bpp to 30 (EDID bpp 30, max requested bpp 36, max platform bpp 36)
<7> [308.817985] xe 0000:00:02.0: [drm:intel_dp_compute_config_limits [xe]] [ENCODER:391:DDI A/PHY A][CRTC:269:pipe B] DP link limits: pixel clock 347710 kHz DSC off max lanes 4 max rate 810000 max pipe_bpp 30 min link_bpp 18.0000 max link_bpp 30.0000
<7> [308.818310] xe 0000:00:02.0: [drm:intel_dp_compute_link_config [xe]] DP lane count 4 clock 432000 bpp input 30 compressed 0.0000 HDR no link rate required 1303913 available 1728000
<7> [308.818613] xe 0000:00:02.0: [drm:intel_atomic_check [xe]] [CRTC:269:pipe B] hw max bpp: 30, pipe bpp: 30, dithering: 0
<7> [308.818888] xe 0000:00:02.0: [drm:intel_ddi_compute_config_late [xe]] [ENCODER:391:DDI A/PHY A] [CRTC:269:pipe B]
<7> [308.819145] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:269:pipe B] fastset requirement not met in hw.enable (expected no, found yes)
<7> [308.819401] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:269:pipe B] fastset requirement not met in hw.active (expected no, found yes)
<7> [308.819631] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:269:pipe B] fastset requirement not met in cpu_transcoder (expected -1, found 1)
<7> [308.819856] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:269:pipe B] fastset requirement not met in lane_count (expected 0, found 4)
<7> [308.820068] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:269:pipe B] fastset requirement not met in dp_m_n (expected tu 0 data 0/0 link 0/0, found tu 64, data 6329869/8388608 link 421991/524288)
<7> [308.820298] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:269:pipe B] fastset requirement not met in output_types (expected 0x00000000, found 0x00000100)
<7> [308.820500] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:269:pipe B] fastset requirement not met in framestart_delay (expected 0, found 1)
<7> [308.820695] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:269:pipe B] fastset requirement not met in hw.pipe_mode.crtc_hdisplay (expected 0, found 2880)
<7> [308.820880] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:269:pipe B] fastset requirement not met in hw.pipe_mode.crtc_htotal (expected 0, found 3040)
<7> [308.821067] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:269:pipe B] fastset requirement not met in hw.pipe_mode.crtc_hblank_start (expected 0, found 2880)
<7> [308.821251] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:269:pipe B] fastset requirement not met in hw.pipe_mode.crtc_hblank_end (expected 0, found 3040)
<7> [308.821445] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:269:pipe B] fastset requirement not met in hw.pipe_mode.crtc_hsync_start (expected 0, found 2928)
<7> [308.821616] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:269:pipe B] fastset requirement not met in hw.pipe_mode.crtc_hsync_end (expected 0, found 2960)
<7> [308.821780] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:269:pipe B] fastset requirement not met in hw.pipe_mode.crtc_vdisplay (expected 0, found 1800)
<7> [308.821940] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:269:pipe B] fastset requirement not met in hw.pipe_mode.crtc_vblank_start (expected 0, found 1800)
<7> [308.822100] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:269:pipe B] fastset requirement not met in hw.pipe_mode.crtc_vsync_start (expected 0, found 1803)
<7> [308.822257] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:269:pipe B] fastset requirement not met in hw.pipe_mode.crtc_vsync_end (expected 0, found 1809)
<7> [308.822416] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:269:pipe B] fastset requirement not met in hw.pipe_mode.crtc_vtotal (expected 0, found 1906)
<7> [308.822565] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:269:pipe B] fastset requirement not met in hw.pipe_mode.crtc_vblank_end (expected 0, found 1906)
<7> [308.822708] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:269:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_hdisplay (expected 0, found 2880)
<7> [308.822846] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:269:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_htotal (expected 0, found 3040)
<7> [308.822981] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:269:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_hblank_start (expected 0, found 2880)
<7> [308.823116] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:269:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_hblank_end (expected 0, found 3040)
<7> [308.823249] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:269:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_hsync_start (expected 0, found 2928)
<7> [308.823780] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:269:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_hsync_end (expected 0, found 2960)
<7> [308.823926] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:269:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_vdisplay (expected 0, found 1800)
<7> [308.824050] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:269:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_vblank_start (expected 0, found 1800)
<7> [308.824172] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:269:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_vsync_start (expected 0, found 1803)
<7> [308.824292] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:269:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_vsync_end (expected 0, found 1809)
<7> [308.824409] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:269:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_vtotal (expected 0, found 1906)
<7> [308.824518] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:269:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_vblank_end (expected 0, found 1906)
<7> [308.824626] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:269:pipe B] fastset requirement not met in pixel_multiplier (expected 0, found 1)
<7> [308.824731] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:269:pipe B] fastset requirement not met in hw.adjusted_mode.flags (2) (expected 0, found 2)
<7> [308.824835] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:269:pipe B] fastset requirement not met in hw.adjusted_mode.flags (8) (expected 0, found 8)
<7> [308.824943] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:269:pipe B] fastset requirement not met in pipe_bpp (expected 0, found 30)
<7> [308.825047] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:269:pipe B] fastset requirement not met in hw.pipe_mode.crtc_clock (expected 0, found 347710)
<7> [308.825152] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:269:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_clock (expected 0, found 347710)
<7> [308.825255] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:269:pipe B] fastset requirement not met in port_clock (expected 0, found 432000)
<7> [308.825388] xe 0000:00:02.0: [drm:intel_atomic_check [xe]] [CRTC:269:pipe B] fastset requirement not met, forcing full modeset
<7> [308.825570] xe 0000:00:02.0: [drm:skl_compute_wm [xe]] Enabled dbuf slices 0x1 -> 0xf (total dbuf slices 0xf), mbus joined? no->yes
<7> [308.825665] xe 0000:00:02.0: [drm:skl_compute_wm [xe]] [CRTC:269:pipe B] dbuf slices 0x0 -> 0xf, ddb (0 - 0) -> (0 - 4096), active pipes 0x0 -> 0x2
<7> [308.825793] xe 0000:00:02.0: [drm:skl_compute_wm [xe]] [PLANE:153:plane 1B] ddb ( 0 - 0) -> ( 0 - 4051), size 0 -> 4051
<7> [308.825873] xe 0000:00:02.0: [drm:skl_compute_wm [xe]] [PLANE:263:cursor B] ddb ( 0 - 0) -> (4051 - 4096), size 0 -> 45
<7> [308.825945] xe 0000:00:02.0: [drm:skl_print_plane_changes [xe]] [PLANE:153: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> [308.826018] xe 0000:00:02.0: [drm:skl_print_plane_changes [xe]] [PLANE:153:plane 1B] lines 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0 -> 4, 13, 13, 13, 13, 13, 0, 0, 0, 4, 0
<7> [308.826089] xe 0000:00:02.0: [drm:skl_print_plane_changes [xe]] [PLANE:153:plane 1B] blocks 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0 -> 92, 297, 297, 297, 297, 297, 0, 0, 197, 92, 197
<7> [308.826160] xe 0000:00:02.0: [drm:skl_print_plane_changes [xe]] [PLANE:153:plane 1B] min_ddb 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0 -> 183, 456, 456, 456, 456, 456, 0, 0, 198, 183, 198
<7> [308.826260] xe 0000:00:02.0: [drm:intel_bw_atomic_check [xe]] [CRTC:269:pipe B] data rate 1390840 num active planes 1
<7> [308.826392] xe 0000:00:02.0: [drm:intel_bw_atomic_check [xe]] QGV point 0: max bw 23530 required 1461 qgv_peak_bw: 38400
<7> [308.826517] xe 0000:00:02.0: [drm:intel_bw_atomic_check [xe]] QGV point 1: max bw 36260 required 1461 qgv_peak_bw: 38400
<7> [308.826634] xe 0000:00:02.0: [drm:intel_bw_atomic_check [xe]] QGV point 2: max bw 38000 required 1461 qgv_peak_bw: 38400
<7> [308.826749] xe 0000:00:02.0: [drm:intel_bw_atomic_check [xe]] QGV point 3: max bw 38000 required 1461 qgv_peak_bw: 38400
<7> [308.826862] xe 0000:00:02.0: [drm:intel_bw_atomic_check [xe]] Matching peaks QGV bw: 38400 for required data rate: 1461
<7> [308.826975] xe 0000:00:02.0: [drm:intel_cdclk_atomic_check [xe]] [CRTC:269:pipe B] min cdclk: 0 kHz -> 173855 kHz
<7> [308.827117] xe 0000:00:02.0: [drm:intel_cdclk_update_dbuf_bw_min_cdclk [xe]] dbuf bandwidth min cdclk: 0 kHz -> 21732 kHz
<7> [308.827233] xe 0000:00:02.0: [drm:intel_cdclk_atomic_check [xe]] Can change cdclk via squashing
<7> [308.827349] xe 0000:00:02.0: [drm:intel_cdclk_atomic_check [xe]] New cdclk calculated to be logical 192000 kHz, actual 192000 kHz
<7> [308.827462] xe 0000:00:02.0: [drm:intel_cdclk_atomic_check [xe]] New voltage level calculated to be logical 0, actual 0
<7> [308.827606] xe 0000:00:02.0: [drm:intel_find_dpll [xe]] [CRTC:269:pipe B] allocated DPLL 0
<7> [308.827709] xe 0000:00:02.0: [drm:intel_dpll_crtc_get [xe]] [CRTC:269:pipe B] reserving DPLL 0
<7> [308.827819] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [CRTC:269:pipe B] enable: yes [modeset]
<7> [308.827936] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] active: yes, output_types: EDP (0x100), output format: RGB, sink format: RGB
<7> [308.828050] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] cpu_transcoder: B, pipe bpp: 30, dithering: 0
<7> [308.828162] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] MST master transcoder: <invalid>
<7> [308.828280] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] port sync: master transcoder: <invalid>, slave transcoder bitmask = 0x0
<7> [308.828396] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] joiner: no, pipes: 0x0
<7> [308.828509] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] splitter: disabled, link count 0, overlap 0
<7> [308.828622] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] dp m_n: lanes: 4; data_m: 6329869, data_n: 8388608, link_m: 421991, link_n: 524288, tu: 64
<7> [308.828734] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] dp m2_n2: lanes: 4; data_m: 0, data_n: 0, link_m: 0, link_n: 0, tu: 0
<7> [308.828846] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] fec: disabled, enhanced framing: disabled
<7> [308.828957] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] sdp split: disabled
<7> [308.829067] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] psr: enabled, selective update: enabled, panel replay: disabled, selective fetch: enabled
<7> [308.829179] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] minimum HBlank: 0
<7> [308.829298] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] audio: 0, infoframes: 0, infoframes enabled: 0x4
<7> [308.829413] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] DP SDP: VSC, revision 4, length 14
<7> [308.829526] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] pixelformat: RGB
<7> [308.829637] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] colorimetry: sRGB
<7> [308.829748] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] bpc: 0
<7> [308.829859] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] dynamic range: VESA range
<7> [308.829970] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] content type: Not defined
<7> [308.830081] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] scanline offset: 1
<7> [308.830192] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] framestart delay: 1, MSA timing delay: 0, set context latency: 0
<7> [308.830311] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] vrr: no, fixed rr: yes, vmin: 1906, vmax: 1906, flipline: 1906, pipeline full: 0, guardband: 104 vsync start: 103, vsync end: 97
<7> [308.830431] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] vrr: vmin vblank: 1802, vmax vblank: 1802, vmin vtotal: 1906, vmax vtotal: 1906
<7> [308.830547] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] vrr: dc balance: no, vmin: 0 vmax: 0 guardband: 0, slope: 0 max increase: 0 max decrease: 0 vblank target: 0
<7> [308.830660] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] requested mode: "2880x1800": 60 347710 2880 2928 2960 3040 1800 1803 1809 1906 0x48 0xa
<7> [308.830773] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] adjusted mode: "2880x1800": 60 347710 2880 2928 2960 3040 1800 1803 1809 1906 0x48 0xa
<7> [308.830885] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] crtc timings: clock=347710, hd=2880 hb=2880-3040 hs=2928-2960 ht=3040, vd=1800 vb=1800-1906 vs=1803-1809 vt=1906, flags=0xa
<7> [308.830997] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] pipe mode: "2880x1800": 60 347710 2880 2928 2960 3040 1800 1803 1809 1906 0x40 0xa
<7> [308.831109] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] crtc timings: clock=347710, hd=2880 hb=2880-3040 hs=2928-2960 ht=3040, vd=1800 vb=1800-1906 vs=1803-1809 vt=1906, flags=0xa
<7> [308.831223] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] port clock: 432000, pipe src: 2880x1800+0+0, pixel rate 347710, min cdclk 173855
<7> [308.831344] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] linetime: 70, ips linetime: 0
<7> [308.831460] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] num_scalers: 2, scaler_users: 0x0, scaler_id: -1, scaling_filter: 0
<7> [308.831570] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] pch pfit: 0x0+0+0, disabled, force thru: no
<7> [308.831683] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] ips: 0, double wide: 0, drrs: 0
<7> [308.831793] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] cx0pll_hw_state: lane_count: 4, ssc_enabled: no, use_c10: yes, tbt_mode: no
<7> [308.831906] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] c10pll_hw_state: fracen: no,
<7> [308.832019] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] multiplier: 225, tx_clk_div: 1.
<7> [308.832131] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] c10pll_rawhw_state:
<7> [308.832243] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] tx: 0x10, cmn: 0x21
<7> [308.832360] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] pll[0] = 0x4, pll[1] = 0x0, pll[2] = 0xa2, pll[3] = 0x1
<7> [308.832473] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] pll[4] = 0x0, pll[5] = 0x0, pll[6] = 0x0, pll[7] = 0x0
<7> [308.832584] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] pll[8] = 0x0, pll[9] = 0x1, pll[10] = 0x0, pll[11] = 0x0
<7> [308.832695] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] pll[12] = 0x0, pll[13] = 0x0, pll[14] = 0x0, pll[15] = 0x1
<7> [308.832804] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] pll[16] = 0x85, pll[17] = 0xf, pll[18] = 0xe6, pll[19] = 0x23
<7> [308.832916] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] csc_mode: 0x0 gamma_mode: 0x0 gamma_enable: 0 csc_enable: 0
<7> [308.833026] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] pre csc lut: 0 entries, post csc lut: 0 entries
<7> [308.833137] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] output csc: pre offsets: 0x0000 0x0000 0x0000
<7> [308.833246] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] output csc: coefficients: 0x0000 0x0000 0x0000
<7> [308.833359] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] output csc: coefficients: 0x0000 0x0000 0x0000
<7> [308.833470] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] output csc: coefficients: 0x0000 0x0000 0x0000
<7> [308.833578] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] output csc: post offsets: 0x0000 0x0000 0x0000
<7> [308.833687] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] pipe csc: pre offsets: 0x0000 0x0000 0x0000
<7> [308.833796] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] pipe csc: coefficients: 0x0000 0x0000 0x0000
<7> [308.833906] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] pipe csc: coefficients: 0x0000 0x0000 0x0000
<7> [308.834014] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] pipe csc: coefficients: 0x0000 0x0000 0x0000
<7> [308.834121] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] pipe csc: post offsets: 0x0000 0x0000 0x0000
<7> [308.834228] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] sharpness strength: 0, sharpness tap size: 0, sharpness enable: 0
<7> [308.834351] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [PLANE:153:plane 1B] fb: [FB:432] 2880x1800 format = XR24 little-endian (0x34325258) modifier = 0x100000000000009, visible: yes
<7> [308.834366] xe 0000:00:02.0: [drm:intel_power_well_disable [xe]] disabling DC_off
<7> [308.834467] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] rotation: 0x1, scaler: -1, scaling_filter: 0
<7> [308.834539] xe 0000:00:02.0: [drm:skl_enable_dc6 [xe]] Enabling DC6
<7> [308.834577] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] src: 2880.000000x1800.000000+0.000000+0.000000 dst: 2880x1800+0+0
<7> [308.834664] xe 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [xe]] Setting DC state from 00 to 02
<7> [308.834688] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [PLANE:183:plane 2B] fb: [NOFB], visible: no
<7> [308.834797] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [PLANE:213:plane 3B] fb: [NOFB], visible: no
<7> [308.834814] xe 0000:00:02.0: [drm:intel_power_well_disable [xe]] disabling always-on
<7> [308.834905] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [PLANE:243:plane 4B] fb: [NOFB], visible: no
<7> [308.835012] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [PLANE:253:plane 5B] fb: [NOFB], visible: no
<7> [308.835120] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [PLANE:263:cursor B] fb: [NOFB], visible: no
<7> [308.835677] xe 0000:00:02.0: [drm:intel_power_well_enable [xe]] enabling always-on
<7> [308.835809] xe 0000:00:02.0: [drm:intel_power_well_enable [xe]] enabling DC_off
<7> [308.836070] xe 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [xe]] Setting DC state from 02 to 00
<7> [308.836236] xe 0000:00:02.0: [drm:intel_power_well_enable [xe]] enabling PW_2
<7> [308.836499] xe 0000:00:02.0: [drm:intel_power_well_enable [xe]] enabling PW_B
<7> [308.836680] xe 0000:00:02.0: [drm:dss_pipe_gating_enable_disable [xe]] DSS clock gating enabled for pipe_mask=0x2 (CLKGATE_DIS_DSSDSC=0xa2000000)
<7> [308.836771] xe 0000:00:02.0: [drm:icp_irq_handler [xe]] hotplug event received, stat 0x00010000, dig 0x0000000a, pins 0x00000010, long 0x00000010
<7> [308.836816] xe 0000:00:02.0: [drm:intel_set_cdclk [xe]] Pre changing CDCLK to 192000 kHz, VCO 614400 kHz, ref 38400 kHz, bypass 19200 kHz, voltage level 0
<7> [308.836871] xe 0000:00:02.0: [drm:intel_hpd_irq_handler [xe]] digital hpd on [ENCODER:391:DDI A/PHY A] - long
<7> [308.836949] xe 0000:00:02.0: [drm:intel_dbuf_mdclk_cdclk_ratio_update [xe]] Updating dbuf ratio to 4 (mbus joined: no)
<7> [308.836964] xe 0000:00:02.0: [drm:intel_hpd_irq_handler [xe]] Received HPD interrupt on PIN 4 - cnt: 10
<7> [308.837063] xe 0000:00:02.0: [drm:intel_audio_cdclk_change_post.part.0 [xe]] aud_ts_cdclk set to M=60, N=480
<7> [308.837069] xe 0000:00:02.0: [drm:intel_dp_hpd_pulse [xe]] ignoring long hpd on eDP [ENCODER:391:DDI A/PHY A]
<7> [308.837185] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:391:DDI A/PHY A]
<7> [308.837279] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:400:DDI TC1/PHY TC1]
<7> [308.837409] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:402:DP-MST A]
<7> [308.837505] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:403:DP-MST B]
<7> [308.837590] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:404:DP-MST C]
<7> [308.837672] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:412:DDI TC2/PHY TC2]
<7> [308.837754] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:414:DP-MST A]
<7> [308.837833] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:415:DP-MST B]
<7> [308.837915] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:416:DP-MST C]
<7> [308.837996] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:420:DDI TC3/PHY TC3]
<7> [308.838076] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:422:DP-MST A]
<7> [308.838158] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:423:DP-MST B]
<7> [308.838240] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:424:DP-MST C]
<7> [308.838358] xe 0000:00:02.0: [drm:gen9_dbuf_slices_update [xe]] Updating dbuf slices to 0xf
<7> [308.838554] xe 0000:00:02.0: [drm:intel_dbuf_mbus_join_update [xe]] Changing mbus joined: no -> yes (pipe: *)
<7> [308.838636] xe 0000:00:02.0: [drm:intel_dbuf_mdclk_cdclk_ratio_update [xe]] Updating dbuf ratio to 8 (mbus joined: yes)
<7> [308.838768] xe 0000:00:02.0: [drm:intel_power_well_enable [xe]] enabling AUX_A
<7> [308.840129] xe 0000:00:02.0: [drm:intel_dpll_enable [xe]] enable DPLL 0 (active 0x2, on? 0) for [CRTC:269:pipe B]
<7> [308.840238] xe 0000:00:02.0: [drm:intel_dpll_enable [xe]] enabling DPLL 0
<7> [308.842271] xe 0000:00:02.0: [drm:intel_pps_on_unlocked [xe]] [ENCODER:391:DDI A/PHY A] PPS 0 turn panel power on
<7> [308.842372] xe 0000:00:02.0: [drm:wait_panel_power_cycle [xe]] [ENCODER:391:DDI A/PHY A] PPS 0 wait for panel power cycle (462 ms remaining)
<7> [309.310195] xe 0000:00:02.0: [drm:wait_panel_status [xe]] [ENCODER:391:DDI A/PHY A] PPS 0 mask: 0xb800000f value: 0x00000000 PP_STATUS: 0x08000001 PP_CONTROL: 0x00000060
<7> [309.381581] xe 0000:00:02.0: [drm:wait_panel_status [xe]] Wait complete
<7> [309.382226] xe 0000:00:02.0: [drm:intel_pps_on_unlocked [xe]] [ENCODER:391:DDI A/PHY A] PPS 0 wait for panel power on
<7> [309.382678] xe 0000:00:02.0: [drm:wait_panel_status [xe]] [ENCODER:391:DDI A/PHY A] PPS 0 mask: 0xb000000f value: 0x80000008 PP_STATUS: 0x9000000a PP_CONTROL: 0x00000063
<7> [309.419177] xe 0000:00:02.0: [drm:icp_irq_handler [xe]] hotplug event received, stat 0x00010000, dig 0x0000000a, pins 0x00000010, long 0x00000010
<7> [309.419871] xe 0000:00:02.0: [drm:intel_hpd_irq_handler [xe]] digital hpd on [ENCODER:391:DDI A/PHY A] - long
<7> [309.420393] xe 0000:00:02.0: [drm:intel_hpd_irq_handler [xe]] Received HPD interrupt on PIN 4 - cnt: 20
<7> [309.421111] xe 0000:00:02.0: [drm:intel_dp_hpd_pulse [xe]] ignoring long hpd on eDP [ENCODER:391:DDI A/PHY A]
<7> [309.591296] xe 0000:00:02.0: [drm:wait_panel_status [xe]] Wait complete
<7> [309.591810] xe 0000:00:02.0: [drm:intel_pps_vdd_on_unlocked [xe]] [ENCODER:391:DDI A/PHY A] PPS 0 turning VDD on
<7> [309.592160] xe 0000:00:02.0: [drm:intel_pps_vdd_on_unlocked [xe]] [ENCODER:391:DDI A/PHY A] PPS 0 PP_STATUS: 0x80000008 PP_CONTROL: 0x0000006b
<7> [309.594458] xe 0000:00:02.0: [drm:drm_dp_read_dpcd_caps [drm_display_helper]] AUX A/DDI A/PHY A: DPCD: 14 1e 44 c1 00 00 01 c0 02 00 02 00 00 0b 80
<7> [309.596016] xe 0000:00:02.0: [drm:intel_dp_start_link_train [xe]] [CONNECTOR:392:eDP-1][ENCODER:391:DDI A/PHY A][DPRX] Reloading eDP link rates
<7> [309.596852] xe 0000:00:02.0: [drm:intel_dp_start_link_train [xe]] [CONNECTOR:392:eDP-1][ENCODER:391:DDI A/PHY A][DPRX] Using LINK_RATE_SET value 05
<7> [309.597992] xe 0000:00:02.0: [drm:intel_dp_set_signal_levels [xe]] [CONNECTOR:392:eDP-1][ENCODER:391:DDI A/PHY A][DPRX] 8b/10b, lanes: 4, vswing levels: 0/0/0/0, pre-emphasis levels: 0/0/0/0
<7> [309.599292] xe 0000:00:02.0: [drm:intel_dp_program_link_training_pattern [xe]] [CONNECTOR:392:eDP-1][ENCODER:391:DDI A/PHY A][DPRX] Using DP training pattern TPS1
<7> [309.600411] xe 0000:00:02.0: [drm:intel_dp_link_train_phy [xe]] [CONNECTOR:392:eDP-1][ENCODER:391:DDI A/PHY A][DPRX] Clock recovery OK
<7> [309.600746] xe 0000:00:02.0: [drm:intel_dp_program_link_training_pattern [xe]] [CONNECTOR:392:eDP-1][ENCODER:391:DDI A/PHY A][DPRX] Using DP training pattern TPS4
<7> [309.602196] xe 0000:00:02.0: [drm:intel_dp_link_train_phy [xe]] [CONNECTOR:392:eDP-1][ENCODER:391:DDI A/PHY A][DPRX] Channel EQ done. DP Training successful
<7> [309.602542] xe 0000:00:02.0: [drm:intel_dp_link_train_phy [xe]] [CONNECTOR:392:eDP-1][ENCODER:391:DDI A/PHY A][DPRX] Link Training passed at link rate = 432000, lane count = 4
<7> [309.603368] xe 0000:00:02.0: [drm:intel_enable_transcoder [xe]] enabling pipe B
<7> [309.603848] xe 0000:00:02.0: [drm:intel_edp_backlight_on [xe]]
<7> [309.604168] xe 0000:00:02.0: [drm:intel_backlight_enable [xe]] pipe B
<7> [309.604548] xe 0000:00:02.0: [drm:intel_backlight_set_pwm_level [xe]] [CONNECTOR:392:eDP-1] set backlight PWM = 192000
<7> [309.620707] xe 0000:00:02.0: [drm:intel_psr_post_plane_update [xe]] Enabling PSR2
<7> [309.622562] xe 0000:00:02.0: [drm:verify_connector_state [xe]] [CONNECTOR:392:eDP-1]
<7> [309.622924] xe 0000:00:02.0: [drm:intel_modeset_verify_crtc [xe]] [CRTC:269:pipe B]
<7> [312.164497] xe 0000:00:02.0: [drm:intel_pps_vdd_off_sync_unlocked [xe]] [ENCODER:391:DDI A/PHY A] PPS 0 turning VDD off
<7> [312.165089] xe 0000:00:02.0: [drm:intel_pps_vdd_off_sync_unlocked [xe]] [ENCODER:391:DDI A/PHY A] PPS 0 PP_STATUS: 0x80000008 PP_CONTROL: 0x00000067
<7> [319.636079] xe 0000:00:02.0: [drm:drm_mode_rmfb_work_fn] Removing [FB:433] from all active usage due to RMFB ioctl
<7> [319.636187] xe 0000:00:02.0: [drm:atomic_remove_fb] Disabling [PLANE:153:plane 1B] because [FB:433] is removed
<7> [319.636265] xe 0000:00:02.0: [drm:skl_compute_wm [xe]] [PLANE:153:plane 1B] ddb ( 0 - 4051) -> ( 0 - 0), size 4051 -> 0
<7> [319.636612] xe 0000:00:02.0: [drm:skl_print_plane_changes [xe]] [PLANE:153: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> [319.636888] xe 0000:00:02.0: [drm:skl_print_plane_changes [xe]] [PLANE:153:plane 1B] lines 4, 13, 13, 13, 13, 13, 0, 0, 0, 4, 0 -> 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0
<7> [319.637235] xe 0000:00:02.0: [drm:skl_print_plane_changes [xe]] [PLANE:153:plane 1B] blocks 92, 297, 297, 297, 297, 297, 0, 0, 197, 92, 197 -> 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0
<7> [319.637524] xe 0000:00:02.0: [drm:skl_print_plane_changes [xe]] [PLANE:153:plane 1B] min_ddb 183, 456, 456, 456, 456, 456, 0, 0, 198, 183, 198 -> 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0
<7> [319.637856] xe 0000:00:02.0: [drm:intel_bw_atomic_check [xe]] [CRTC:269:pipe B] data rate 0 num active planes 0
<7> [319.638265] xe 0000:00:02.0: [drm:intel_bw_atomic_check [xe]] QGV point 0: max bw 23530 required 0 qgv_peak_bw: 38400
<7> [319.638620] xe 0000:00:02.0: [drm:intel_bw_atomic_check [xe]] QGV point 1: max bw 36260 required 0 qgv_peak_bw: 38400
<7> [319.638975] xe 0000:00:02.0: [drm:intel_bw_atomic_check [xe]] QGV point 2: max bw 38000 required 0 qgv_peak_bw: 38400
<7> [319.639315] xe 0000:00:02.0: [drm:intel_bw_atomic_check [xe]] QGV point 3: max bw 38000 required 0 qgv_peak_bw: 38400
<7> [319.639654] xe 0000:00:02.0: [drm:intel_bw_atomic_check [xe]] Matching peaks QGV bw: 38400 for required data rate: 0
<7> [319.640544] xe 0000:00:02.0: [drm:intel_psr_disable_locked [xe]] Disabling PSR2
<7> [319.660392] xe 0000:00:02.0: [drm:intel_pps_vdd_on_unlocked [xe]] [ENCODER:391:DDI A/PHY A] PPS 0 turning VDD on
<7> [319.660698] xe 0000:00:02.0: [drm:intel_pps_vdd_on_unlocked [xe]] [ENCODER:391:DDI A/PHY A] PPS 0 PP_STATUS: 0x80000008 PP_CONTROL: 0x0000006f
<6> [319.673129] [IGT] kms_flip: finished subtest B-eDP1, SUCCESS
<6> [319.674932] [IGT] kms_flip: starting dynamic subtest C-eDP1
<7> [319.698474] xe 0000:00:02.0: [drm:intel_power_well_disable [xe]] disabling DC_off
<7> [319.698621] xe 0000:00:02.0: [drm:skl_enable_dc6 [xe]] Enabling DC6
<7> [319.698759] xe 0000:00:02.0: [drm:drm_mode_addfb2] [FB:432]
<7> [319.698722] xe 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [xe]] Setting DC state from 00 to 02
<7> [319.699178] xe 0000:00:02.0: [drm:drm_mode_addfb2] [FB:433]
<7> [319.771711] xe 0000:00:02.0: [drm:drm_mode_setcrtc] [CRTC:150:pipe A]
<7> [319.772036] xe 0000:00:02.0: [drm:intel_power_well_enable [xe]] enabling DC_off
<7> [319.772360] xe 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [xe]] Setting DC state from 02 to 00
<7> [319.772713] xe 0000:00:02.0: [drm:drm_mode_setcrtc] [CRTC:269:pipe B]
<7> [319.772884] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:269:pipe B] fastset requirement not met in hw.enable (expected yes, found no)
<7> [319.773219] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:269:pipe B] fastset requirement not met in hw.active (expected yes, found no)
<7> [319.773462] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:269:pipe B] fastset requirement not met in cpu_transcoder (expected 1, found -1)
<7> [319.773697] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:269:pipe B] fastset requirement not met in lane_count (expected 4, found 0)
<7> [319.773936] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:269:pipe B] fastset requirement not met in dp_m_n (expected tu 64 data 6329869/8388608 link 421991/524288, found tu 0, data 0/0 link 0/0)
<7> [319.774156] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:269:pipe B] fastset requirement not met in output_types (expected 0x00000100, found 0x00000000)
<7> [319.774369] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:269:pipe B] fastset requirement not met in framestart_delay (expected 1, found 0)
<7> [319.774577] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:269:pipe B] fastset requirement not met in hw.pipe_mode.crtc_hdisplay (expected 2880, found 0)
<7> [319.774773] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:269:pipe B] fastset requirement not met in hw.pipe_mode.crtc_htotal (expected 3040, found 0)
<7> [319.774987] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:269:pipe B] fastset requirement not met in hw.pipe_mode.crtc_hblank_start (expected 2880, found 0)
<7> [319.775188] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:269:pipe B] fastset requirement not met in hw.pipe_mode.crtc_hblank_end (expected 3040, found 0)
<7> [319.775374] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:269:pipe B] fastset requirement not met in hw.pipe_mode.crtc_hsync_start (expected 2928, found 0)
<7> [319.775557] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:269:pipe B] fastset requirement not met in hw.pipe_mode.crtc_hsync_end (expected 2960, found 0)
<7> [319.775728] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:269:pipe B] fastset requirement not met in hw.pipe_mode.crtc_vdisplay (expected 1800, found 0)
<7> [319.776009] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:269:pipe B] fastset requirement not met in hw.pipe_mode.crtc_vblank_start (expected 1800, found 0)
<7> [319.776171] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:269:pipe B] fastset requirement not met in hw.pipe_mode.crtc_vsync_start (expected 1803, found 0)
<7> [319.776327] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:269:pipe B] fastset requirement not met in hw.pipe_mode.crtc_vsync_end (expected 1809, found 0)
<7> [319.776484] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:269:pipe B] fastset requirement not met in hw.pipe_mode.crtc_vtotal (expected 1906, found 0)
<7> [319.776634] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:269:pipe B] fastset requirement not met in hw.pipe_mode.crtc_vblank_end (expected 1906, found 0)
<7> [319.776781] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:269:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_hdisplay (expected 2880, found 0)
<7> [319.776969] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:269:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_htotal (expected 3040, found 0)
<7> [319.777128] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:269:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_hblank_start (expected 2880, found 0)
<7> [319.777265] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:269:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_hblank_end (expected 3040, found 0)
<7> [319.777421] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:269:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_hsync_start (expected 2928, found 0)
<7> [319.777575] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:269:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_hsync_end (expected 2960, found 0)
<7> [319.777704] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:269:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_vdisplay (expected 1800, found 0)
<7> [319.777833] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:269:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_vblank_start (expected 1800, found 0)
<7> [319.777995] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:269:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_vsync_start (expected 1803, found 0)
<7> [319.778128] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:269:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_vsync_end (expected 1809, found 0)
<7> [319.778251] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:269:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_vtotal (expected 1906, found 0)
<7> [319.778369] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:269:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_vblank_end (expected 1906, found 0)
<7> [319.778487] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:269:pipe B] fastset requirement not met in pixel_multiplier (expected 1, found 0)
<7> [319.778605] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:269:pipe B] fastset requirement not met in hw.adjusted_mode.flags (2) (expected 2, found 0)
<7> [319.778723] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:269:pipe B] fastset requirement not met in hw.adjusted_mode.flags (8) (expected 8, found 0)
<7> [319.778861] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:269:pipe B] fastset requirement not met in pipe_bpp (expected 30, found 0)
<7> [319.778989] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:269:pipe B] fastset requirement not met in hw.pipe_mode.crtc_clock (expected 347710, found 0)
<7> [319.779114] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:269:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_clock (expected 347710, found 0)
<7> [319.779241] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:269:pipe B] fastset requirement not met in port_clock (expected 432000, found 0)
<7> [319.779353] xe 0000:00:02.0: [drm:intel_atomic_check [xe]] [CRTC:269:pipe B] fastset requirement not met, forcing full modeset
<7> [319.779460] xe 0000:00:02.0: [drm:intel_dpll_crtc_put [xe]] [CRTC:269:pipe B] releasing DPLL 0
<7> [319.779612] xe 0000:00:02.0: [drm:skl_compute_wm [xe]] Enabled dbuf slices 0xf -> 0x1 (total dbuf slices 0xf), mbus joined? yes->no
<7> [319.779714] xe 0000:00:02.0: [drm:skl_compute_wm [xe]] [CRTC:269:pipe B] dbuf slices 0xf -> 0x0, ddb (0 - 4096) -> (0 - 0), active pipes 0x2 -> 0x0
<7> [319.779842] xe 0000:00:02.0: [drm:skl_compute_wm [xe]] [PLANE:263:cursor B] ddb (4051 - 4096) -> ( 0 - 0), size 45 -> 0
<7> [319.779967] xe 0000:00:02.0: [drm:intel_cdclk_atomic_check [xe]] [CRTC:269:pipe B] min cdclk: 173855 kHz -> 0 kHz
<7> [319.780085] xe 0000:00:02.0: [drm:intel_cdclk_atomic_check [xe]] Can change cdclk via squashing
<7> [319.780195] xe 0000:00:02.0: [drm:intel_cdclk_atomic_check [xe]] New cdclk calculated to be logical 153600 kHz, actual 153600 kHz
<7> [319.780303] xe 0000:00:02.0: [drm:intel_cdclk_atomic_check [xe]] New voltage level calculated to be logical 0, actual 0
<7> [319.780438] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [CRTC:269:pipe B] enable: no [modeset]
<7> [319.780543] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [PLANE:153:plane 1B] fb: [NOFB], visible: no
<7> [319.780647] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [PLANE:183:plane 2B] fb: [NOFB], visible: no
<7> [319.780748] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [PLANE:213:plane 3B] fb: [NOFB], visible: no
<7> [319.780846] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [PLANE:243:plane 4B] fb: [NOFB], visible: no
<7> [319.780957] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [PLANE:253:plane 5B] fb: [NOFB], visible: no
<7> [319.781055] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [PLANE:263:cursor B] fb: [NOFB], visible: no
<7> [319.781307] xe 0000:00:02.0: [drm:intel_alpm_disable [xe]] Disabling ALPM
<7> [319.781432] xe 0000:00:02.0: [drm:intel_edp_backlight_off [xe]]
<7> [319.984066] xe 0000:00:02.0: [drm:intel_backlight_set_pwm_level [xe]] [CONNECTOR:392:eDP-1] set backlight PWM = 0
<7> [319.984688] xe 0000:00:02.0: [drm:intel_disable_transcoder [xe]] disabling pipe B
<7> [319.986037] xe 0000:00:02.0: [drm:intel_pps_off_unlocked [xe]] [ENCODER:391:DDI A/PHY A] PPS 0 turn panel power off
<7> [319.986395] xe 0000:00:02.0: [drm:intel_pps_off_unlocked [xe]] [ENCODER:391:DDI A/PHY A] PPS 0 wait for panel power off time
<7> [319.986747] xe 0000:00:02.0: [drm:wait_panel_status [xe]] [ENCODER:391:DDI A/PHY A] PPS 0 mask: 0xb0000000 value: 0x00000000 PP_STATUS: 0xa0000002 PP_CONTROL: 0x00000060
<7> [320.039182] xe 0000:00:02.0: [drm:icp_irq_handler [xe]] hotplug event received, stat 0x00010000, dig 0x00000009, pins 0x00000010, long 0x00000000
<7> [320.039704] xe 0000:00:02.0: [drm:intel_hpd_irq_handler [xe]] digital hpd on [ENCODER:391:DDI A/PHY A] - short
<7> [320.047897] xe 0000:00:02.0: [drm:wait_panel_status [xe]] Wait complete
<7> [320.048360] xe 0000:00:02.0: [drm:intel_dpll_disable [xe]] disable DPLL 0 (active 0x2, on? 1) for [CRTC:269:pipe B]
<7> [320.048412] xe 0000:00:02.0: [drm:intel_dp_hpd_pulse [xe]] ignoring short hpd on eDP [ENCODER:391:DDI A/PHY A]
<7> [320.049924] xe 0000:00:02.0: [drm:intel_dpll_disable [xe]] disabling DPLL 0
<7> [320.050410] xe 0000:00:02.0: [drm:intel_power_well_disable [xe]] disabling AUX_A
<7> [320.050939] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:391:DDI A/PHY A]
<7> [320.051325] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:400:DDI TC1/PHY TC1]
<7> [320.051649] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:402:DP-MST A]
<7> [320.052002] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:403:DP-MST B]
<7> [320.052308] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:404:DP-MST C]
<7> [320.052603] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:412:DDI TC2/PHY TC2]
<7> [320.052973] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:414:DP-MST A]
<7> [320.053300] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:415:DP-MST B]
<7> [320.053580] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:416:DP-MST C]
<7> [320.053872] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:420:DDI TC3/PHY TC3]
<7> [320.054148] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:422:DP-MST A]
<7> [320.054421] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:423:DP-MST B]
<7> [320.054722] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:424:DP-MST C]
<7> [320.055036] xe 0000:00:02.0: [drm:verify_connector_state [xe]] [CONNECTOR:392:eDP-1]
<7> [320.055399] xe 0000:00:02.0: [drm:intel_dbuf_mdclk_cdclk_ratio_update [xe]] Updating dbuf ratio to 4 (mbus joined: no)
<7> [320.055730] xe 0000:00:02.0: [drm:intel_dbuf_mbus_join_update [xe]] Changing mbus joined: yes -> no (pipe: *)
<7> [320.056051] xe 0000:00:02.0: [drm:gen9_dbuf_slices_update [xe]] Updating dbuf slices to 0x1
<7> [320.056551] xe 0000:00:02.0: [drm:intel_power_well_disable [xe]] disabling PW_B
<7> [320.056907] xe 0000:00:02.0: [drm:dss_pipe_gating_enable_disable [xe]] DSS clock gating disabled for pipe_mask=0x2 (CLKGATE_DIS_DSSDSC=0xaa000000)
<7> [320.057282] xe 0000:00:02.0: [drm:intel_power_well_disable [xe]] disabling PW_2
<7> [320.057668] xe 0000:00:02.0: [drm:intel_modeset_verify_crtc [xe]] [CRTC:269:pipe B]
<7> [320.058001] xe 0000:00:02.0: [drm:intel_set_cdclk [xe]] Post changing CDCLK to 153600 kHz, VCO 614400 kHz, ref 38400 kHz, bypass 19200 kHz, voltage level 0
<7> [320.058374] xe 0000:00:02.0: [drm:intel_dbuf_mdclk_cdclk_ratio_update [xe]] Updating dbuf ratio to 4 (mbus joined: no)
<7> [320.058641] xe 0000:00:02.0: [drm:intel_audio_cdclk_change_post.part.0 [xe]] aud_ts_cdclk set to M=60, N=384
<7> [320.059498] xe 0000:00:02.0: [drm:drm_mode_setcrtc] [CRTC:388:pipe C]
<7> [320.059906] xe 0000:00:02.0: [drm:drm_mode_setcrtc] [CRTC:388:pipe C]
<7> [320.059982] xe 0000:00:02.0: [drm:drm_mode_setcrtc] [CONNECTOR:392:eDP-1]
<7> [320.060160] xe 0000:00:02.0: [drm:intel_atomic_check [xe]] [CONNECTOR:392:eDP-1] Limiting target display pipe bpp to 30 (EDID bpp 30, max requested bpp 36, max platform bpp 36)
<7> [320.060530] xe 0000:00:02.0: [drm:intel_dp_compute_config_limits [xe]] [ENCODER:391:DDI A/PHY A][CRTC:388:pipe C] DP link limits: pixel clock 347710 kHz DSC off max lanes 4 max rate 810000 max pipe_bpp 30 min link_bpp 18.0000 max link_bpp 30.0000
<7> [320.060870] xe 0000:00:02.0: [drm:intel_dp_compute_link_config [xe]] DP lane count 4 clock 432000 bpp input 30 compressed 0.0000 HDR no link rate required 1303913 available 1728000
<7> [320.061174] xe 0000:00:02.0: [drm:intel_psr_compute_config [xe]] PSR2 not supported in transcoder C
<7> [320.061422] xe 0000:00:02.0: [drm:intel_atomic_check [xe]] [CRTC:388:pipe C] hw max bpp: 30, pipe bpp: 30, dithering: 0
<7> [320.061769] xe 0000:00:02.0: [drm:intel_ddi_compute_config_late [xe]] [ENCODER:391:DDI A/PHY A] [CRTC:388:pipe C]
<7> [320.062093] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:388:pipe C] fastset requirement not met in hw.enable (expected no, found yes)
<7> [320.062407] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:388:pipe C] fastset requirement not met in hw.active (expected no, found yes)
<7> [320.062681] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:388:pipe C] fastset requirement not met in cpu_transcoder (expected -1, found 2)
<7> [320.062971] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:388:pipe C] fastset requirement not met in lane_count (expected 0, found 4)
<7> [320.063271] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:388:pipe C] fastset requirement not met in dp_m_n (expected tu 0 data 0/0 link 0/0, found tu 64, data 6329869/8388608 link 421991/524288)
<7> [320.063503] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:388:pipe C] fastset requirement not met in output_types (expected 0x00000000, found 0x00000100)
<7> [320.063737] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:388:pipe C] fastset requirement not met in framestart_delay (expected 0, found 1)
<7> [320.064031] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:388:pipe C] fastset requirement not met in hw.pipe_mode.crtc_hdisplay (expected 0, found 2880)
<7> [320.064252] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:388:pipe C] fastset requirement not met in hw.pipe_mode.crtc_htotal (expected 0, found 3040)
<7> [320.064462] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:388:pipe C] fastset requirement not met in hw.pipe_mode.crtc_hblank_start (expected 0, found 2880)
<7> [320.064693] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:388:pipe C] fastset requirement not met in hw.pipe_mode.crtc_hblank_end (expected 0, found 3040)
<7> [320.064893] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:388:pipe C] fastset requirement not met in hw.pipe_mode.crtc_hsync_start (expected 0, found 2928)
<7> [320.065077] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:388:pipe C] fastset requirement not met in hw.pipe_mode.crtc_hsync_end (expected 0, found 2960)
<7> [320.065250] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:388:pipe C] fastset requirement not met in hw.pipe_mode.crtc_vdisplay (expected 0, found 1800)
<7> [320.065424] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:388:pipe C] fastset requirement not met in hw.pipe_mode.crtc_vblank_start (expected 0, found 1800)
<7> [320.065596] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:388:pipe C] fastset requirement not met in hw.pipe_mode.crtc_vsync_start (expected 0, found 1803)
<7> [320.065759] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:388:pipe C] fastset requirement not met in hw.pipe_mode.crtc_vsync_end (expected 0, found 1809)
<7> [320.065935] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:388:pipe C] fastset requirement not met in hw.pipe_mode.crtc_vtotal (expected 0, found 1906)
<7> [320.066093] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:388:pipe C] fastset requirement not met in hw.pipe_mode.crtc_vblank_end (expected 0, found 1906)
<7> [320.066244] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:388:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_hdisplay (expected 0, found 2880)
<7> [320.066390] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:388:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_htotal (expected 0, found 3040)
<7> [320.066537] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:388:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_hblank_start (expected 0, found 2880)
<7> [320.066677] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:388:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_hblank_end (expected 0, found 3040)
<7> [320.066821] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:388:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_hsync_start (expected 0, found 2928)
<7> [320.066957] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:388:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_hsync_end (expected 0, found 2960)
<7> [320.067090] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:388:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_vdisplay (expected 0, found 1800)
<7> [320.067228] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:388:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_vblank_start (expected 0, found 1800)
<7> [320.067393] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:388:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_vsync_start (expected 0, found 1803)
<7> [320.067534] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:388:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_vsync_end (expected 0, found 1809)
<7> [320.067672] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:388:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_vtotal (expected 0, found 1906)
<7> [320.067795] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:388:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_vblank_end (expected 0, found 1906)
<7> [320.067975] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:388:pipe C] fastset requirement not met in pixel_multiplier (expected 0, found 1)
<7> [320.068093] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:388:pipe C] fastset requirement not met in hw.adjusted_mode.flags (2) (expected 0, found 2)
<7> [320.068208] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:388:pipe C] fastset requirement not met in hw.adjusted_mode.flags (8) (expected 0, found 8)
<7> [320.068338] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:388:pipe C] fastset requirement not met in dpll_hw_state
<7> [320.068470] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] expected:
<7> [320.068593] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] cx0pll_hw_state: lane_count: 0, ssc_enabled: no, use_c10: no, tbt_mode: no
<7> [320.068697] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] c20pll_hw_state:
<7> [320.068801] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] tx[0] = 0x0000, tx[1] = 0x0000, tx[2] = 0x0000
<7> [320.068924] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] cmn[0] = 0x0000, cmn[1] = 0x0000, cmn[2] = 0x0000, cmn[3] = 0x0000
<7> [320.069024] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] mplla[0] = 0x0000
<7> [320.069121] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] mplla[1] = 0x0000
<7> [320.069214] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] mplla[2] = 0x0000
<7> [320.069318] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] mplla[3] = 0x0000
<7> [320.069426] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] mplla[4] = 0x0000
<7> [320.069536] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] mplla[5] = 0x0000
<7> [320.069628] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] mplla[6] = 0x0000
<7> [320.069716] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] mplla[7] = 0x0000
<7> [320.069804] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] mplla[8] = 0x0000
<7> [320.069908] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] mplla[9] = 0x0000
<7> [320.069994] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] mpllb[10] = 0x0000
<7> [320.070076] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] vdr: custom width: 0x00, serdes rate: 0x00, hdmi rate: 0x00
<7> [320.070158] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] found:
<7> [320.070237] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] cx0pll_hw_state: lane_count: 4, ssc_enabled: no, use_c10: yes, tbt_mode: no
<7> [320.070317] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] c10pll_hw_state: fracen: no,
<7> [320.070397] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] multiplier: 225, tx_clk_div: 1.
<7> [320.070476] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] c10pll_rawhw_state:
<7> [320.070555] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] tx: 0x10, cmn: 0x21
<7> [320.070630] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] pll[0] = 0x4, pll[1] = 0x0, pll[2] = 0xa2, pll[3] = 0x1
<7> [320.070704] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] pll[4] = 0x0, pll[5] = 0x0, pll[6] = 0x0, pll[7] = 0x0
<7> [320.070777] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] pll[8] = 0x0, pll[9] = 0x1, pll[10] = 0x0, pll[11] = 0x0
<7> [320.070861] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] pll[12] = 0x0, pll[13] = 0x0, pll[14] = 0x0, pll[15] = 0x1
<7> [320.070958] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] pll[16] = 0x85, pll[17] = 0xf, pll[18] = 0xe6, pll[19] = 0x23
<7> [320.071059] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:388:pipe C] fastset requirement not met in pipe_bpp (expected 0, found 30)
<7> [320.071159] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:388:pipe C] fastset requirement not met in hw.pipe_mode.crtc_clock (expected 0, found 347710)
<7> [320.071233] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:388:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_clock (expected 0, found 347710)
<7> [320.071308] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:388:pipe C] fastset requirement not met in port_clock (expected 0, found 432000)
<7> [320.071378] xe 0000:00:02.0: [drm:intel_atomic_check [xe]] [CRTC:388:pipe C] fastset requirement not met, forcing full modeset
<7> [320.071470] xe 0000:00:02.0: [drm:skl_compute_wm [xe]] Enabled dbuf slices 0x1 -> 0xd (total dbuf slices 0xf), mbus joined? no->no
<7> [320.071526] xe 0000:00:02.0: [drm:skl_compute_wm [xe]] [CRTC:388:pipe C] dbuf slices 0x0 -> 0xc, ddb (0 - 0) -> (0 - 2048), active pipes 0x0 -> 0x4
<7> [320.071601] xe 0000:00:02.0: [drm:skl_compute_wm [xe]] [PLANE:272:plane 1C] ddb ( 0 - 0) -> ( 0 - 2003), size 0 -> 2003
<7> [320.071661] xe 0000:00:02.0: [drm:skl_compute_wm [xe]] [PLANE:382:cursor C] ddb ( 0 - 0) -> (2003 - 2048), size 0 -> 45
<7> [320.071715] xe 0000:00:02.0: [drm:skl_print_plane_changes [xe]] [PLANE:272:plane 1C] level wm0, wm1, wm2, wm3, wm4, wm5, wm6, wm7, twm, swm, stwm -> *wm0,*wm1,*wm2,*wm3,*wm4,*wm5, wm6, wm7,*twm,*swm,*stwm
<7> [320.071768] xe 0000:00:02.0: [drm:skl_print_plane_changes [xe]] [PLANE:272:plane 1C] lines 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0 -> 4, 13, 13, 13, 13, 13, 0, 0, 0, 4, 0
<7> [320.071828] xe 0000:00:02.0: [drm:skl_print_plane_changes [xe]] [PLANE:272:plane 1C] blocks 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0 -> 92, 297, 297, 297, 297, 297, 0, 0, 197, 92, 197
<7> [320.071886] xe 0000:00:02.0: [drm:skl_print_plane_changes [xe]] [PLANE:272:plane 1C] min_ddb 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0 -> 183, 456, 456, 456, 456, 456, 0, 0, 198, 183, 198
<7> [320.071959] xe 0000:00:02.0: [drm:intel_bw_atomic_check [xe]] [CRTC:388:pipe C] data rate 1390840 num active planes 1
<7> [320.072046] xe 0000:00:02.0: [drm:intel_bw_atomic_check [xe]] QGV point 0: max bw 23530 required 1461 qgv_peak_bw: 38400
<7> [320.072131] xe 0000:00:02.0: [drm:intel_bw_atomic_check [xe]] QGV point 1: max bw 36260 required 1461 qgv_peak_bw: 38400
<7> [320.072208] xe 0000:00:02.0: [drm:intel_bw_atomic_check [xe]] QGV point 2: max bw 38000 required 1461 qgv_peak_bw: 38400
<7> [320.072285] xe 0000:00:02.0: [drm:intel_bw_atomic_check [xe]] QGV point 3: max bw 38000 required 1461 qgv_peak_bw: 38400
<7> [320.072361] xe 0000:00:02.0: [drm:intel_bw_atomic_check [xe]] Matching peaks QGV bw: 38400 for required data rate: 1461
<7> [320.072457] xe 0000:00:02.0: [drm:intel_cdclk_atomic_check [xe]] [CRTC:388:pipe C] min cdclk: 0 kHz -> 173855 kHz
<7> [320.072549] xe 0000:00:02.0: [drm:intel_cdclk_atomic_check [xe]] Can change cdclk via squashing
<7> [320.072634] xe 0000:00:02.0: [drm:intel_cdclk_atomic_check [xe]] New cdclk calculated to be logical 192000 kHz, actual 192000 kHz
<7> [320.072720] xe 0000:00:02.0: [drm:intel_cdclk_atomic_check [xe]] New voltage level calculated to be logical 0, actual 0
<7> [320.072819] xe 0000:00:02.0: [drm:intel_find_dpll [xe]] [CRTC:388:pipe C] allocated DPLL 0
<7> [320.072902] xe 0000:00:02.0: [drm:intel_dpll_crtc_get [xe]] [CRTC:388:pipe C] reserving DPLL 0
<7> [320.072996] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [CRTC:388:pipe C] enable: yes [modeset]
<7> [320.073098] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] active: yes, output_types: EDP (0x100), output format: RGB, sink format: RGB
<7> [320.073197] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] cpu_transcoder: C, pipe bpp: 30, dithering: 0
<7> [320.073278] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] MST master transcoder: <invalid>
<7> [320.073352] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] port sync: master transcoder: <invalid>, slave transcoder bitmask = 0x0
<7> [320.073426] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] joiner: no, pipes: 0x0
<7> [320.073500] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] splitter: disabled, link count 0, overlap 0
<7> [320.073573] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] dp m_n: lanes: 4; data_m: 6329869, data_n: 8388608, link_m: 421991, link_n: 524288, tu: 64
<7> [320.073647] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] dp m2_n2: lanes: 4; data_m: 0, data_n: 0, link_m: 0, link_n: 0, tu: 0
<7> [320.073720] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] fec: disabled, enhanced framing: disabled
<7> [320.073792] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] sdp split: disabled
<7> [320.073893] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] psr: enabled, selective update: disabled, panel replay: disabled, selective fetch: disabled
<7> [320.073989] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] minimum HBlank: 0
<7> [320.074083] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] audio: 0, infoframes: 0, infoframes enabled: 0x4
<7> [320.074166] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] DP SDP: VSC, revision 2, length 8
<7> [320.074238] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] pixelformat: RGB
<7> [320.074310] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] colorimetry: sRGB
<7> [320.074381] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] bpc: 0
<7> [320.074453] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] dynamic range: VESA range
<7> [320.074527] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] content type: Not defined
<7> [320.074600] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] scanline offset: 1
<7> [320.074672] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] framestart delay: 1, MSA timing delay: 0, set context latency: 0
<7> [320.074744] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] vrr: no, fixed rr: yes, vmin: 1906, vmax: 1906, flipline: 1906, pipeline full: 0, guardband: 104 vsync start: 103, vsync end: 97
<7> [320.074821] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] vrr: vmin vblank: 1802, vmax vblank: 1802, vmin vtotal: 1906, vmax vtotal: 1906
<7> [320.074901] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] vrr: dc balance: no, vmin: 0 vmax: 0 guardband: 0, slope: 0 max increase: 0 max decrease: 0 vblank target: 0
<7> [320.074979] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] requested mode: "2880x1800": 60 347710 2880 2928 2960 3040 1800 1803 1809 1906 0x48 0xa
<7> [320.075058] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] adjusted mode: "2880x1800": 60 347710 2880 2928 2960 3040 1800 1803 1809 1906 0x48 0xa
<7> [320.075134] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] crtc timings: clock=347710, hd=2880 hb=2880-3040 hs=2928-2960 ht=3040, vd=1800 vb=1800-1906 vs=1803-1809 vt=1906, flags=0xa
<7> [320.075205] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] pipe mode: "2880x1800": 60 347710 2880 2928 2960 3040 1800 1803 1809 1906 0x40 0xa
<7> [320.075276] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] crtc timings: clock=347710, hd=2880 hb=2880-3040 hs=2928-2960 ht=3040, vd=1800 vb=1800-1906 vs=1803-1809 vt=1906, flags=0xa
<7> [320.075346] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] port clock: 432000, pipe src: 2880x1800+0+0, pixel rate 347710, min cdclk 173855
<7> [320.075419] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] linetime: 70, ips linetime: 0
<7> [320.075495] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] num_scalers: 2, scaler_users: 0x0, scaler_id: -1, scaling_filter: 0
<7> [320.075570] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] pch pfit: 0x0+0+0, disabled, force thru: no
<7> [320.075645] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] ips: 0, double wide: 0, drrs: 0
<7> [320.075718] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] cx0pll_hw_state: lane_count: 4, ssc_enabled: no, use_c10: yes, tbt_mode: no
<7> [320.075787] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] c10pll_hw_state: fracen: no,
<7> [320.075871] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] multiplier: 225, tx_clk_div: 1.
<7> [320.075962] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] c10pll_rawhw_state:
<7> [320.076052] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] tx: 0x10, cmn: 0x21
<7> [320.076139] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] pll[0] = 0x4, pll[1] = 0x0, pll[2] = 0xa2, pll[3] = 0x1
<7> [320.076208] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] pll[4] = 0x0, pll[5] = 0x0, pll[6] = 0x0, pll[7] = 0x0
<7> [320.076276] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] pll[8] = 0x0, pll[9] = 0x1, pll[10] = 0x0, pll[11] = 0x0
<7> [320.076344] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] pll[12] = 0x0, pll[13] = 0x0, pll[14] = 0x0, pll[15] = 0x1
<7> [320.076413] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] pll[16] = 0x85, pll[17] = 0xf, pll[18] = 0xe6, pll[19] = 0x23
<7> [320.076481] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] csc_mode: 0x0 gamma_mode: 0x0 gamma_enable: 0 csc_enable: 0
<7> [320.076548] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] pre csc lut: 0 entries, post csc lut: 0 entries
<7> [320.076616] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] output csc: pre offsets: 0x0000 0x0000 0x0000
<7> [320.076684] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] output csc: coefficients: 0x0000 0x0000 0x0000
<7> [320.076751] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] output csc: coefficients: 0x0000 0x0000 0x0000
<7> [320.076828] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] output csc: coefficients: 0x0000 0x0000 0x0000
<7> [320.076842] xe 0000:00:02.0: [drm:intel_power_well_disable [xe]] disabling DC_off
<7> [320.076907] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] output csc: post offsets: 0x0000 0x0000 0x0000
<7> [320.076986] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] pipe csc: pre offsets: 0x0000 0x0000 0x0000
<7> [320.076977] xe 0000:00:02.0: [drm:skl_enable_dc6 [xe]] Enabling DC6
<7> [320.077063] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] pipe csc: coefficients: 0x0000 0x0000 0x0000
<7> [320.077078] xe 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [xe]] Setting DC state from 00 to 02
<7> [320.077141] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] pipe csc: coefficients: 0x0000 0x0000 0x0000
<7> [320.077205] xe 0000:00:02.0: [drm:intel_power_well_disable [xe]] disabling always-on
<7> [320.077217] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] pipe csc: coefficients: 0x0000 0x0000 0x0000
<7> [320.077294] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] pipe csc: post offsets: 0x0000 0x0000 0x0000
<7> [320.077371] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] sharpness strength: 0, sharpness tap size: 0, sharpness enable: 0
<7> [320.077447] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [PLANE:272:plane 1C] fb: [FB:432] 2880x1800 format = XR24 little-endian (0x34325258) modifier = 0x100000000000009, visible: yes
<7> [320.077525] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] rotation: 0x1, scaler: -1, scaling_filter: 0
<7> [320.077599] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] src: 2880.000000x1800.000000+0.000000+0.000000 dst: 2880x1800+0+0
<7> [320.077669] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [PLANE:302:plane 2C] fb: [NOFB], visible: no
<7> [320.077737] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [PLANE:332:plane 3C] fb: [NOFB], visible: no
<7> [320.077811] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [PLANE:362:plane 4C] fb: [NOFB], visible: no
<7> [320.077779] xe 0000:00:02.0: [drm:icp_irq_handler [xe]] hotplug event received, stat 0x00010000, dig 0x0000000a, pins 0x00000010, long 0x00000010
<7> [320.077887] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [PLANE:372:plane 5C] fb: [NOFB], visible: no
<7> [320.077947] xe 0000:00:02.0: [drm:intel_hpd_irq_handler [xe]] digital hpd on [ENCODER:391:DDI A/PHY A] - long
<7> [320.077967] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [PLANE:382:cursor C] fb: [NOFB], visible: no
<7> [320.078060] xe 0000:00:02.0: [drm:intel_hpd_irq_handler [xe]] Received HPD interrupt on PIN 4 - cnt: 10
<7> [320.078174] xe 0000:00:02.0: [drm:intel_dp_hpd_pulse [xe]] ignoring long hpd on eDP [ENCODER:391:DDI A/PHY A]
<7> [320.078347] xe 0000:00:02.0: [drm:intel_power_well_enable [xe]] enabling always-on
<7> [320.078460] xe 0000:00:02.0: [drm:intel_power_well_enable [xe]] enabling DC_off
<7> [320.078701] xe 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [xe]] Setting DC state from 02 to 00
<7> [320.078848] xe 0000:00:02.0: [drm:intel_power_well_enable [xe]] enabling PW_2
<7> [320.078992] xe 0000:00:02.0: [drm:intel_power_well_enable [xe]] enabling PW_C
<7> [320.079145] xe 0000:00:02.0: [drm:dss_pipe_gating_enable_disable [xe]] DSS clock gating enabled for pipe_mask=0x4 (CLKGATE_DIS_DSSDSC=0x8a000000)
<7> [320.079234] xe 0000:00:02.0: [drm:intel_set_cdclk [xe]] Pre changing CDCLK to 192000 kHz, VCO 614400 kHz, ref 38400 kHz, bypass 19200 kHz, voltage level 0
<7> [320.079322] xe 0000:00:02.0: [drm:intel_dbuf_mdclk_cdclk_ratio_update [xe]] Updating dbuf ratio to 4 (mbus joined: no)
<7> [320.079416] xe 0000:00:02.0: [drm:intel_audio_cdclk_change_post.part.0 [xe]] aud_ts_cdclk set to M=60, N=480
<7> [320.079505] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:391:DDI A/PHY A]
<7> [320.079576] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:400:DDI TC1/PHY TC1]
<7> [320.079642] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:402:DP-MST A]
<7> [320.079706] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:403:DP-MST B]
<7> [320.079770] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:404:DP-MST C]
<7> [320.079854] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:412:DDI TC2/PHY TC2]
<7> [320.079940] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:414:DP-MST A]
<7> [320.080021] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:415:DP-MST B]
<7> [320.080101] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:416:DP-MST C]
<7> [320.080180] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:420:DDI TC3/PHY TC3]
<7> [320.080255] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:422:DP-MST A]
<7> [320.080323] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:423:DP-MST B]
<7> [320.080386] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:424:DP-MST C]
<7> [320.080470] xe 0000:00:02.0: [drm:gen9_dbuf_slices_update [xe]] Updating dbuf slices to 0xd
<7> [320.080626] xe 0000:00:02.0: [drm:intel_dbuf_mdclk_cdclk_ratio_update [xe]] Updating dbuf ratio to 4 (mbus joined: no)
<7> [320.080732] xe 0000:00:02.0: [drm:intel_power_well_enable [xe]] enabling AUX_A
<7> [320.081875] xe 0000:00:02.0: [drm:intel_dpll_enable [xe]] enable DPLL 0 (active 0x4, on? 0) for [CRTC:388:pipe C]
<7> [320.082004] xe 0000:00:02.0: [drm:intel_dpll_enable [xe]] enabling DPLL 0
<7> [320.083979] xe 0000:00:02.0: [drm:intel_pps_on_unlocked [xe]] [ENCODER:391:DDI A/PHY A] PPS 0 turn panel power on
<7> [320.084078] xe 0000:00:02.0: [drm:wait_panel_power_cycle [xe]] [ENCODER:391:DDI A/PHY A] PPS 0 wait for panel power cycle (465 ms remaining)
<7> [320.551909] xe 0000:00:02.0: [drm:wait_panel_status [xe]] [ENCODER:391:DDI A/PHY A] PPS 0 mask: 0xb800000f value: 0x00000000 PP_STATUS: 0x08000001 PP_CONTROL: 0x00000060
<7> [320.592885] xe 0000:00:02.0: [drm:wait_panel_status [xe]] Wait complete
<7> [320.593203] xe 0000:00:02.0: [drm:intel_pps_on_unlocked [xe]] [ENCODER:391:DDI A/PHY A] PPS 0 wait for panel power on
<7> [320.593462] xe 0000:00:02.0: [drm:wait_panel_status [xe]] [ENCODER:391:DDI A/PHY A] PPS 0 mask: 0xb000000f value: 0x80000008 PP_STATUS: 0x9000000a PP_CONTROL: 0x00000063
<7> [320.630064] xe 0000:00:02.0: [drm:icp_irq_handler [xe]] hotplug event received, stat 0x00010000, dig 0x0000000a, pins 0x00000010, long 0x00000010
<7> [320.630425] xe 0000:00:02.0: [drm:intel_hpd_irq_handler [xe]] digital hpd on [ENCODER:391:DDI A/PHY A] - long
<7> [320.630710] xe 0000:00:02.0: [drm:intel_hpd_irq_handler [xe]] Received HPD interrupt on PIN 4 - cnt: 20
<7> [320.631043] xe 0000:00:02.0: [drm:intel_dp_hpd_pulse [xe]] ignoring long hpd on eDP [ENCODER:391:DDI A/PHY A]
<7> [320.804159] xe 0000:00:02.0: [drm:wait_panel_status [xe]] Wait complete
<7> [320.804539] xe 0000:00:02.0: [drm:intel_pps_vdd_on_unlocked [xe]] [ENCODER:391:DDI A/PHY A] PPS 0 turning VDD on
<7> [320.804887] xe 0000:00:02.0: [drm:intel_pps_vdd_on_unlocked [xe]] [ENCODER:391:DDI A/PHY A] PPS 0 PP_STATUS: 0x80000008 PP_CONTROL: 0x0000006b
<7> [320.806833] xe 0000:00:02.0: [drm:drm_dp_read_dpcd_caps [drm_display_helper]] AUX A/DDI A/PHY A: DPCD: 14 1e 44 c1 00 00 01 c0 02 00 02 00 00 0b 80
<7> [320.808357] xe 0000:00:02.0: [drm:intel_dp_start_link_train [xe]] [CONNECTOR:392:eDP-1][ENCODER:391:DDI A/PHY A][DPRX] Reloading eDP link rates
<7> [320.809189] xe 0000:00:02.0: [drm:intel_dp_start_link_train [xe]] [CONNECTOR:392:eDP-1][ENCODER:391:DDI A/PHY A][DPRX] Using LINK_RATE_SET value 05
<7> [320.810305] xe 0000:00:02.0: [drm:intel_dp_set_signal_levels [xe]] [CONNECTOR:392:eDP-1][ENCODER:391:DDI A/PHY A][DPRX] 8b/10b, lanes: 4, vswing levels: 0/0/0/0, pre-emphasis levels: 0/0/0/0
<7> [320.811643] xe 0000:00:02.0: [drm:intel_dp_program_link_training_pattern [xe]] [CONNECTOR:392:eDP-1][ENCODER:391:DDI A/PHY A][DPRX] Using DP training pattern TPS1
<7> [320.812696] xe 0000:00:02.0: [drm:intel_dp_link_train_phy [xe]] [CONNECTOR:392:eDP-1][ENCODER:391:DDI A/PHY A][DPRX] Clock recovery OK
<7> [320.813025] xe 0000:00:02.0: [drm:intel_dp_program_link_training_pattern [xe]] [CONNECTOR:392:eDP-1][ENCODER:391:DDI A/PHY A][DPRX] Using DP training pattern TPS4
<7> [320.814429] xe 0000:00:02.0: [drm:intel_dp_link_train_phy [xe]] [CONNECTOR:392:eDP-1][ENCODER:391:DDI A/PHY A][DPRX] Channel EQ done. DP Training successful
<7> [320.814778] xe 0000:00:02.0: [drm:intel_dp_link_train_phy [xe]] [CONNECTOR:392:eDP-1][ENCODER:391:DDI A/PHY A][DPRX] Link Training passed at link rate = 432000, lane count = 4
<7> [320.815634] xe 0000:00:02.0: [drm:intel_enable_transcoder [xe]] enabling pipe C
<7> [320.816064] xe 0000:00:02.0: [drm:intel_edp_backlight_on [xe]]
<7> [320.816380] xe 0000:00:02.0: [drm:intel_backlight_enable [xe]] pipe C
<7> [320.816776] xe 0000:00:02.0: [drm:intel_backlight_set_pwm_level [xe]] [CONNECTOR:392:eDP-1] set backlight PWM = 192000
<7> [320.818356] xe 0000:00:02.0: [drm:intel_fbc_update [xe]] reserved 14745600 bytes of contiguous stolen space for FBC, limit: 2
<7> [320.818700] xe 0000:00:02.0: [drm:intel_fbc_update [xe]] Enabling FBC on [PLANE:272:plane 1C]
<7> [320.832895] xe 0000:00:02.0: [drm:intel_psr_post_plane_update [xe]] Enabling PSR1
<7> [320.834282] xe 0000:00:02.0: [drm:verify_connector_state [xe]] [CONNECTOR:392:eDP-1]
<7> [320.834658] xe 0000:00:02.0: [drm:intel_modeset_verify_crtc [xe]] [CRTC:388:pipe C]
<7> [323.360054] xe 0000:00:02.0: [drm:intel_pps_vdd_off_sync_unlocked [xe]] [ENCODER:391:DDI A/PHY A] PPS 0 turning VDD off
<7> [323.360447] xe 0000:00:02.0: [drm:intel_pps_vdd_off_sync_unlocked [xe]] [ENCODER:391:DDI A/PHY A] PPS 0 PP_STATUS: 0x80000008 PP_CONTROL: 0x00000067
<7> [330.864800] xe 0000:00:02.0: [drm:drm_mode_rmfb_work_fn] Removing [FB:433] from all active usage due to RMFB ioctl
<7> [330.865044] xe 0000:00:02.0: [drm:drm_mode_rmfb_work_fn] Removing [FB:432] from all active usage due to RMFB ioctl
<7> [330.865111] xe 0000:00:02.0: [drm:atomic_remove_fb] Disabling [PLANE:272:plane 1C] because [FB:432] is removed
<7> [330.865259] xe 0000:00:02.0: [drm:skl_compute_wm [xe]] [PLANE:272:plane 1C] ddb ( 0 - 2003) -> ( 0 - 0), size 2003 -> 0
<7> [330.865623] xe 0000:00:02.0: [drm:skl_print_plane_changes [xe]] [PLANE:272:plane 1C] level *wm0,*wm1,*wm2,*wm3,*wm4,*wm5, wm6, wm7,*twm,*swm,*stwm -> wm0, wm1, wm2, wm3, wm4, wm5, wm6, wm7, twm, swm, stwm
<7> [330.865898] xe 0000:00:02.0: [drm:skl_print_plane_changes [xe]] [PLANE:272:plane 1C] lines 4, 13, 13, 13, 13, 13, 0, 0, 0, 4, 0 -> 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0
<7> [330.866205] xe 0000:00:02.0: [drm:skl_print_plane_changes [xe]] [PLANE:272:plane 1C] blocks 92, 297, 297, 297, 297, 297, 0, 0, 197, 92, 197 -> 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0
<7> [330.866467] xe 0000:00:02.0: [drm:skl_print_plane_changes [xe]] [PLANE:272:plane 1C] min_ddb 183, 456, 456, 456, 456, 456, 0, 0, 198, 183, 198 -> 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0
<7> [330.866756] xe 0000:00:02.0: [drm:intel_bw_atomic_check [xe]] [CRTC:388:pipe C] data rate 0 num active planes 0
<7> [330.867118] xe 0000:00:02.0: [drm:intel_bw_atomic_check [xe]] QGV point 0: max bw 23530 required 0 qgv_peak_bw: 38400
<7> [330.867521] xe 0000:00:02.0: [drm:intel_bw_atomic_check [xe]] QGV point 1: max bw 36260 required 0 qgv_peak_bw: 38400
<7> [330.867862] xe 0000:00:02.0: [drm:intel_bw_atomic_check [xe]] QGV point 2: max bw 38000 required 0 qgv_peak_bw: 38400
<7> [330.868259] xe 0000:00:02.0: [drm:intel_bw_atomic_check [xe]] QGV point 3: max bw 38000 required 0 qgv_peak_bw: 38400
<7> [330.868622] xe 0000:00:02.0: [drm:intel_bw_atomic_check [xe]] Matching peaks QGV bw: 38400 for required data rate: 0
<7> [330.869415] xe 0000:00:02.0: [drm:intel_psr_disable_locked [xe]] Disabling PSR1
<7> [330.869715] xe 0000:00:02.0: [drm:intel_pps_vdd_on_unlocked [xe]] [ENCODER:391:DDI A/PHY A] PPS 0 turning VDD on
<7> [330.870021] xe 0000:00:02.0: [drm:intel_pps_vdd_on_unlocked [xe]] [ENCODER:391:DDI A/PHY A] PPS 0 PP_STATUS: 0x80000008 PP_CONTROL: 0x0000006f
<7> [330.881324] xe 0000:00:02.0: [drm:__intel_fbc_disable [xe]] Disabling FBC on [PLANE:272:plane 1C]
<6> [330.899529] [IGT] kms_flip: finished subtest C-eDP1, SUCCESS
<6> [330.902931] [IGT] kms_flip: finished subtest flip-vs-expired-vblank, FAIL
<7> [330.928028] xe 0000:00:02.0: [drm:intel_atomic_check [xe]] [CONNECTOR:392:eDP-1] Limiting target display pipe bpp to 30 (EDID bpp 30, max requested bpp 36, max platform bpp 36)
<7> [330.928251] xe 0000:00:02.0: [drm:intel_dp_compute_config_limits [xe]] [ENCODER:391:DDI A/PHY A][CRTC:150:pipe A] DP link limits: pixel clock 347710 kHz DSC off max lanes 4 max rate 810000 max pipe_bpp 30 min link_bpp 18.0000 max link_bpp 30.0000
<7> [330.928380] xe 0000:00:02.0: [drm:intel_dp_compute_link_config [xe]] DP lane count 4 clock 432000 bpp input 30 compressed 0.0000 HDR no link rate required 1303913 available 1728000
<7> [330.928515] xe 0000:00:02.0: [drm:intel_atomic_check [xe]] [CRTC:150:pipe A] hw max bpp: 30, pipe bpp: 30, dithering: 0
<7> [330.928648] xe 0000:00:02.0: [drm:intel_ddi_compute_config_late [xe]] [ENCODER:391:DDI A/PHY A] [CRTC:150:pipe A]
<7> [330.928768] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:150:pipe A] fastset requirement not met in hw.enable (expected no, found yes)
<7> [330.928881] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:150:pipe A] fastset requirement not met in hw.active (expected no, found yes)
<7> [330.928991] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:150:pipe A] fastset requirement not met in cpu_transcoder (expected -1, found 0)
<7> [330.929100] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:150:pipe A] fastset requirement not met in lane_count (expected 0, found 4)
<7> [330.929227] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:150:pipe A] fastset requirement not met in dp_m_n (expected tu 0 data 0/0 link 0/0, found tu 64, data 6329869/8388608 link 421991/524288)
<7> [330.929338] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:150:pipe A] fastset requirement not met in output_types (expected 0x00000000, found 0x00000100)
<7> [330.929461] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:150:pipe A] fastset requirement not met in framestart_delay (expected 0, found 1)
<7> [330.929592] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:150:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hdisplay (expected 0, found 2880)
<7> [330.929729] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:150:pipe A] fastset requirement not met in hw.pipe_mode.crtc_htotal (expected 0, found 3040)
<7> [330.929851] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:150:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hblank_start (expected 0, found 2880)
<7> [330.929963] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:150:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hblank_end (expected 0, found 3040)
<7> [330.930080] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:150:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hsync_start (expected 0, found 2928)
<7> [330.930214] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:150:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hsync_end (expected 0, found 2960)
<7> [330.930334] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:150:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vdisplay (expected 0, found 1800)
<7> [330.930446] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:150:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vblank_start (expected 0, found 1800)
<7> [330.930551] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:150:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vsync_start (expected 0, found 1803)
<7> [330.930656] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:150:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vsync_end (expected 0, found 1809)
<7> [330.930761] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:150:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vtotal (expected 0, found 1906)
<7> [330.930866] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:150:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vblank_end (expected 0, found 1906)
<7> [330.930971] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:150:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hdisplay (expected 0, found 2880)
<7> [330.931075] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:150:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_htotal (expected 0, found 3040)
<7> [330.931193] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:150:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hblank_start (expected 0, found 2880)
<7> [330.931322] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:150:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hblank_end (expected 0, found 3040)
<7> [330.931446] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:150:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hsync_start (expected 0, found 2928)
<7> [330.931573] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:150:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hsync_end (expected 0, found 2960)
<7> [330.931690] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:150:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vdisplay (expected 0, found 1800)
<7> [330.931801] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:150:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vblank_start (expected 0, found 1800)
<7> [330.931915] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:150:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vsync_start (expected 0, found 1803)
<7> [330.932027] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:150:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vsync_end (expected 0, found 1809)
<7> [330.932137] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:150:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vtotal (expected 0, found 1906)
<7> [330.932249] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:150:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vblank_end (expected 0, found 1906)
<7> [330.932356] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:150:pipe A] fastset requirement not met in pixel_multiplier (expected 0, found 1)
<7> [330.932464] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:150:pipe A] fastset requirement not met in hw.adjusted_mode.flags (2) (expected 0, found 2)
<7> [330.932568] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:150:pipe A] fastset requirement not met in hw.adjusted_mode.flags (8) (expected 0, found 8)
<7> [330.932673] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:150:pipe A] fastset requirement not met in pipe_bpp (expected 0, found 30)
<7> [330.932776] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:150:pipe A] fastset requirement not met in hw.pipe_mode.crtc_clock (expected 0, found 347710)
<7> [330.932880] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:150:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_clock (expected 0, found 347710)
<7> [330.932988] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:150:pipe A] fastset requirement not met in port_clock (expected 0, found 432000)
<7> [330.933101] xe 0000:00:02.0: [drm:intel_atomic_check [xe]] [CRTC:150:pipe A] fastset requirement not met, forcing full modeset
<7> [330.933581] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:388:pipe C] fastset requirement not met in hw.enable (expected yes, found no)
<7> [330.933695] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:388:pipe C] fastset requirement not met in hw.active (expected yes, found no)
<7> [330.933800] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:388:pipe C] fastset requirement not met in cpu_transcoder (expected 2, found -1)
<7> [330.933905] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:388:pipe C] fastset requirement not met in lane_count (expected 4, found 0)
<7> [330.934008] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:388:pipe C] fastset requirement not met in dp_m_n (expected tu 64 data 6329869/8388608 link 421991/524288, found tu 0, data 0/0 link 0/0)
<7> [330.934113] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:388:pipe C] fastset requirement not met in output_types (expected 0x00000100, found 0x00000000)
<7> [330.934224] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:388:pipe C] fastset requirement not met in framestart_delay (expected 1, found 0)
<7> [330.934331] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:388:pipe C] fastset requirement not met in hw.pipe_mode.crtc_hdisplay (expected 2880, found 0)
<7> [330.934451] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:388:pipe C] fastset requirement not met in hw.pipe_mode.crtc_htotal (expected 3040, found 0)
<7> [330.934571] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:388:pipe C] fastset requirement not met in hw.pipe_mode.crtc_hblank_start (expected 2880, found 0)
<7> [330.934690] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:388:pipe C] fastset requirement not met in hw.pipe_mode.crtc_hblank_end (expected 3040, found 0)
<7> [330.934810] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:388:pipe C] fastset requirement not met in hw.pipe_mode.crtc_hsync_start (expected 2928, found 0)
<7> [330.934922] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:388:pipe C] fastset requirement not met in hw.pipe_mode.crtc_hsync_end (expected 2960, found 0)
<7> [330.935035] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:388:pipe C] fastset requirement not met in hw.pipe_mode.crtc_vdisplay (expected 1800, found 0)
<7> [330.935148] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:388:pipe C] fastset requirement not met in hw.pipe_mode.crtc_vblank_start (expected 1800, found 0)
<7> [330.935284] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:388:pipe C] fastset requirement not met in hw.pipe_mode.crtc_vsync_start (expected 1803, found 0)
<7> [330.935391] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:388:pipe C] fastset requirement not met in hw.pipe_mode.crtc_vsync_end (expected 1809, found 0)
<7> [330.935496] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:388:pipe C] fastset requirement not met in hw.pipe_mode.crtc_vtotal (expected 1906, found 0)
<7> [330.935600] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:388:pipe C] fastset requirement not met in hw.pipe_mode.crtc_vblank_end (expected 1906, found 0)
<7> [330.935703] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:388:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_hdisplay (expected 2880, found 0)
<7> [330.935806] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:388:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_htotal (expected 3040, found 0)
<7> [330.935910] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:388:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_hblank_start (expected 2880, found 0)
<7> [330.936018] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:388:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_hblank_end (expected 3040, found 0)
<7> [330.936128] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:388:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_hsync_start (expected 2928, found 0)
<7> [330.936252] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:388:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_hsync_end (expected 2960, found 0)
<7> [330.936373] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:388:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_vdisplay (expected 1800, found 0)
<7> [330.936488] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:388:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_vblank_start (expected 1800, found 0)
<7> [330.936597] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:388:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_vsync_start (expected 1803, found 0)
<7> [330.936708] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:388:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_vsync_end (expected 1809, found 0)
<7> [330.936819] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:388:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_vtotal (expected 1906, found 0)
<7> [330.936922] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:388:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_vblank_end (expected 1906, found 0)
<7> [330.937025] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:388:pipe C] fastset requirement not met in pixel_multiplier (expected 1, found 0)
<7> [330.937128] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:388:pipe C] fastset requirement not met in hw.adjusted_mode.flags (2) (expected 2, found 0)
<7> [330.937306] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:388:pipe C] fastset requirement not met in hw.adjusted_mode.flags (8) (expected 8, found 0)
<7> [330.937419] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:388:pipe C] fastset requirement not met in pipe_bpp (expected 30, found 0)
<7> [330.937522] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:388:pipe C] fastset requirement not met in hw.pipe_mode.crtc_clock (expected 347710, found 0)
<7> [330.937628] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:388:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_clock (expected 347710, found 0)
<7> [330.937736] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:388:pipe C] fastset requirement not met in port_clock (expected 432000, found 0)
<7> [330.937848] xe 0000:00:02.0: [drm:intel_atomic_check [xe]] [CRTC:388:pipe C] fastset requirement not met, forcing full modeset
<7> [330.937966] xe 0000:00:02.0: [drm:intel_dpll_crtc_put [xe]] [CRTC:388:pipe C] releasing DPLL 0
<7> [330.938217] xe 0000:00:02.0: [drm:skl_compute_wm [xe]] Enabled dbuf slices 0xd -> 0xf (total dbuf slices 0xf), mbus joined? no->yes
<7> [330.938315] xe 0000:00:02.0: [drm:skl_compute_wm [xe]] [CRTC:150:pipe A] dbuf slices 0x0 -> 0xf, ddb (0 - 0) -> (0 - 4096), active pipes 0x4 -> 0x1
<7> [330.938398] xe 0000:00:02.0: [drm:skl_compute_wm [xe]] [CRTC:388:pipe C] dbuf slices 0xc -> 0x0, ddb (0 - 2048) -> (0 - 0), active pipes 0x4 -> 0x1
<7> [330.938480] xe 0000:00:02.0: [drm:skl_compute_wm [xe]] [PLANE:34:plane 1A] ddb ( 0 - 0) -> ( 0 - 4051), size 0 -> 4051
<7> [330.938555] xe 0000:00:02.0: [drm:skl_compute_wm [xe]] [PLANE:144:cursor A] ddb ( 0 - 0) -> (4051 - 4096), size 0 -> 45
<7> [330.938627] xe 0000:00:02.0: [drm:skl_print_plane_changes [xe]] [PLANE:34: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> [330.938699] xe 0000:00:02.0: [drm:skl_print_plane_changes [xe]] [PLANE:34:plane 1A] lines 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0 -> 1, 13, 13, 13, 13, 13, 0, 0, 0, 3, 0
<7> [330.938770] xe 0000:00:02.0: [drm:skl_print_plane_changes [xe]] [PLANE:34:plane 1A] blocks 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0 -> 24, 313, 313, 313, 313, 313, 0, 0, 38, 73, 87
<7> [330.938840] xe 0000:00:02.0: [drm:skl_print_plane_changes [xe]] [PLANE:34:plane 1A] min_ddb 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0 -> 28, 346, 346, 346, 346, 346, 0, 0, 39, 82, 88
<7> [330.938912] xe 0000:00:02.0: [drm:skl_compute_wm [xe]] [PLANE:382:cursor C] ddb (2003 - 2048) -> ( 0 - 0), size 45 -> 0
<7> [330.939009] xe 0000:00:02.0: [drm:intel_bw_atomic_check [xe]] [CRTC:150:pipe A] data rate 1390840 num active planes 1
<7> [330.939139] xe 0000:00:02.0: [drm:intel_bw_atomic_check [xe]] QGV point 0: max bw 23530 required 1461 qgv_peak_bw: 38400
<7> [330.939282] xe 0000:00:02.0: [drm:intel_bw_atomic_check [xe]] QGV point 1: max bw 36260 required 1461 qgv_peak_bw: 38400
<7> [330.939414] xe 0000:00:02.0: [drm:intel_bw_atomic_check [xe]] QGV point 2: max bw 38000 required 1461 qgv_peak_bw: 38400
<7> [330.939541] xe 0000:00:02.0: [drm:intel_bw_atomic_check [xe]] QGV point 3: max bw 38000 required 1461 qgv_peak_bw: 38400
<7> [330.939666] xe 0000:00:02.0: [drm:intel_bw_atomic_check [xe]] Matching peaks QGV bw: 38400 for required data rate: 1461
<7> [330.939792] xe 0000:00:02.0: [drm:intel_cdclk_atomic_check [xe]] [CRTC:150:pipe A] min cdclk: 0 kHz -> 173855 kHz
<7> [330.939911] xe 0000:00:02.0: [drm:intel_cdclk_atomic_check [xe]] [CRTC:388:pipe C] min cdclk: 173855 kHz -> 0 kHz
<7> [330.940084] xe 0000:00:02.0: [drm:intel_find_dpll [xe]] [CRTC:150:pipe A] allocated DPLL 0
<7> [330.940194] xe 0000:00:02.0: [drm:intel_dpll_crtc_get [xe]] [CRTC:150:pipe A] reserving DPLL 0
<7> [330.940309] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [CRTC:150:pipe A] enable: yes [modeset]
<7> [330.940429] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] active: yes, output_types: EDP (0x100), output format: RGB, sink format: RGB
<7> [330.940546] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] cpu_transcoder: A, pipe bpp: 30, dithering: 0
<7> [330.940665] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] MST master transcoder: <invalid>
<7> [330.940793] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] port sync: master transcoder: <invalid>, slave transcoder bitmask = 0x0
<7> [330.940920] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] joiner: no, pipes: 0x0
<7> [330.941048] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] splitter: disabled, link count 0, overlap 0
<7> [330.941177] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] dp m_n: lanes: 4; data_m: 6329869, data_n: 8388608, link_m: 421991, link_n: 524288, tu: 64
<7> [330.941301] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] dp m2_n2: lanes: 4; data_m: 0, data_n: 0, link_m: 0, link_n: 0, tu: 0
<7> [330.941413] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] fec: disabled, enhanced framing: disabled
<7> [330.941525] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] sdp split: disabled
<7> [330.941635] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] psr: enabled, selective update: enabled, panel replay: disabled, selective fetch: enabled
<7> [330.941745] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] minimum HBlank: 0
<7> [330.941855] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] audio: 0, infoframes: 0, infoframes enabled: 0x4
<7> [330.941969] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] DP SDP: VSC, revision 4, length 14
<7> [330.942084] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] pixelformat: RGB
<7> [330.942284] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] colorimetry: sRGB
<7> [330.942410] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] bpc: 0
<7> [330.942530] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] dynamic range: VESA range
<7> [330.942645] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] content type: Not defined
<7> [330.942755] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] scanline offset: 1
<7> [330.942865] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] framestart delay: 1, MSA timing delay: 0, set context latency: 0
<7> [330.942974] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] vrr: no, fixed rr: yes, vmin: 1906, vmax: 1906, flipline: 1906, pipeline full: 0, guardband: 104 vsync start: 103, vsync end: 97
<7> [330.943085] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] vrr: vmin vblank: 1802, vmax vblank: 1802, vmin vtotal: 1906, vmax vtotal: 1906
<7> [330.943201] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] vrr: dc balance: no, vmin: 0 vmax: 0 guardband: 0, slope: 0 max increase: 0 max decrease: 0 vblank target: 0
<7> [330.943320] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] requested mode: "2880x1800": 60 347710 2880 2928 2960 3040 1800 1803 1809 1906 0x48 0xa
<7> [330.943441] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] adjusted mode: "2880x1800": 60 347710 2880 2928 2960 3040 1800 1803 1809 1906 0x48 0xa
<7> [330.943565] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] crtc timings: clock=347710, hd=2880 hb=2880-3040 hs=2928-2960 ht=3040, vd=1800 vb=1800-1906 vs=1803-1809 vt=1906, flags=0xa
<7> [330.943693] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] pipe mode: "2880x1800": 60 347710 2880 2928 2960 3040 1800 1803 1809 1906 0x40 0xa
<7> [330.943819] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] crtc timings: clock=347710, hd=2880 hb=2880-3040 hs=2928-2960 ht=3040, vd=1800 vb=1800-1906 vs=1803-1809 vt=1906, flags=0xa
<7> [330.943933] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] port clock: 432000, pipe src: 2880x1800+0+0, pixel rate 347710, min cdclk 173855
<7> [330.944050] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] linetime: 70, ips linetime: 0
<7> [330.944166] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] num_scalers: 2, scaler_users: 0x0, scaler_id: -1, scaling_filter: 0
<7> [330.944278] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] pch pfit: 0x0+0+0, disabled, force thru: no
<7> [330.944396] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] ips: 0, double wide: 0, drrs: 0
<7> [330.944505] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] cx0pll_hw_state: lane_count: 4, ssc_enabled: no, use_c10: yes, tbt_mode: no
<7> [330.944614] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] c10pll_hw_state: fracen: no,
<7> [330.944722] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] multiplier: 225, tx_clk_div: 1.
<7> [330.944831] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] c10pll_rawhw_state:
<7> [330.944941] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] tx: 0x10, cmn: 0x21
<7> [330.945053] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] pll[0] = 0x4, pll[1] = 0x0, pll[2] = 0xa2, pll[3] = 0x1
<7> [330.945173] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] pll[4] = 0x0, pll[5] = 0x0, pll[6] = 0x0, pll[7] = 0x0
<7> [330.945296] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] pll[8] = 0x0, pll[9] = 0x1, pll[10] = 0x0, pll[11] = 0x0
<7> [330.945411] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] pll[12] = 0x0, pll[13] = 0x0, pll[14] = 0x0, pll[15] = 0x1
<7> [330.945527] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] pll[16] = 0x85, pll[17] = 0xf, pll[18] = 0xe6, pll[19] = 0x23
<7> [330.945640] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] csc_mode: 0x0 gamma_mode: 0x0 gamma_enable: 0 csc_enable: 0
<7> [330.945748] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] pre csc lut: 0 entries, post csc lut: 0 entries
<7> [330.945855] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] output csc: pre offsets: 0x0000 0x0000 0x0000
<7> [330.945962] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] output csc: coefficients: 0x0000 0x0000 0x0000
<7> [330.946069] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] output csc: coefficients: 0x0000 0x0000 0x0000
<7> [330.946181] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] output csc: coefficients: 0x0000 0x0000 0x0000
<7> [330.946292] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] output csc: post offsets: 0x0000 0x0000 0x0000
<7> [330.946409] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] pipe csc: pre offsets: 0x0000 0x0000 0x0000
<7> [330.946528] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] pipe csc: coefficients: 0x0000 0x0000 0x0000
<7> [330.946647] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] pipe csc: coefficients: 0x0000 0x0000 0x0000
<7> [330.946766] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] pipe csc: coefficients: 0x0000 0x0000 0x0000
<7> [330.946877] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] pipe csc: post offsets: 0x0000 0x0000 0x0000
<7> [330.946989] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] sharpness strength: 0, sharpness tap size: 0, sharpness enable: 0
<7> [330.947098] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [PLANE:34:plane 1A] fb: [FB:393] 2880x1800 format = XR24 little-endian (0x34325258) modifier = 0x0, visible: yes
<7> [330.947230] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] rotation: 0x1, scaler: -1, scaling_filter: 0
<7> [330.947341] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] src: 2880.000000x1800.000000+0.000000+0.000000 dst: 2880x1800+0+0
<7> [330.947457] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [PLANE:64:plane 2A] fb: [NOFB], visible: no
<7> [330.947564] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [PLANE:94:plane 3A] fb: [NOFB], visible: no
<7> [330.947671] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [PLANE:124:plane 4A] fb: [NOFB], visible: no
<7> [330.947778] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [PLANE:134:plane 5A] fb: [NOFB], visible: no
<7> [330.947888] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [PLANE:144:cursor A] fb: [NOFB], visible: no
<7> [330.947999] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [CRTC:388:pipe C] enable: no [modeset]
<7> [330.948113] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [PLANE:272:plane 1C] fb: [NOFB], visible: no
<7> [330.948238] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [PLANE:302:plane 2C] fb: [NOFB], visible: no
<7> [330.948354] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [PLANE:332:plane 3C] fb: [NOFB], visible: no
<7> [330.948468] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [PLANE:362:plane 4C] fb: [NOFB], visible: no
<7> [330.948581] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [PLANE:372:plane 5C] fb: [NOFB], visible: no
<7> [330.948693] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [PLANE:382:cursor C] fb: [NOFB], visible: no
<7> [330.948895] xe 0000:00:02.0: [drm:intel_power_well_enable [xe]] enabling PW_A
<7> [330.949067] xe 0000:00:02.0: [drm:dss_pipe_gating_enable_disable [xe]] DSS clock gating enabled for pipe_mask=0x1 (CLKGATE_DIS_DSSDSC=0x88000000)
<7> [330.949409] xe 0000:00:02.0: [drm:intel_alpm_disable [xe]] Disabling ALPM
<7> [330.949530] xe 0000:00:02.0: [drm:intel_edp_backlight_off [xe]]
<7> [331.158222] xe 0000:00:02.0: [drm:intel_backlight_set_pwm_level [xe]] [CONNECTOR:392:eDP-1] set backlight PWM = 0
<7> [331.158902] xe 0000:00:02.0: [drm:intel_disable_transcoder [xe]] disabling pipe C
<7> [331.169730] xe 0000:00:02.0: [drm:intel_pps_off_unlocked [xe]] [ENCODER:391:DDI A/PHY A] PPS 0 turn panel power off
<7> [331.170121] xe 0000:00:02.0: [drm:intel_pps_off_unlocked [xe]] [ENCODER:391:DDI A/PHY A] PPS 0 wait for panel power off time
<7> [331.170145] xe 0000:00:02.0: [drm:icp_irq_handler [xe]] hotplug event received, stat 0x00010000, dig 0x00000009, pins 0x00000010, long 0x00000000
<7> [331.170518] xe 0000:00:02.0: [drm:wait_panel_status [xe]] [ENCODER:391:DDI A/PHY A] PPS 0 mask: 0xb0000000 value: 0x00000000 PP_STATUS: 0xa0000002 PP_CONTROL: 0x00000060
<7> [331.170629] xe 0000:00:02.0: [drm:intel_hpd_irq_handler [xe]] digital hpd on [ENCODER:391:DDI A/PHY A] - short
<7> [331.222858] xe 0000:00:02.0: [drm:icp_irq_handler [xe]] hotplug event received, stat 0x00010000, dig 0x00000009, pins 0x00000010, long 0x00000000
<7> [331.223223] xe 0000:00:02.0: [drm:intel_hpd_irq_handler [xe]] digital hpd on [ENCODER:391:DDI A/PHY A] - short
<7> [331.231205] xe 0000:00:02.0: [drm:wait_panel_status [xe]] Wait complete
<7> [331.231572] xe 0000:00:02.0: [drm:intel_dpll_disable [xe]] disable DPLL 0 (active 0x4, on? 1) for [CRTC:388:pipe C]
<7> [331.231601] xe 0000:00:02.0: [drm:intel_dp_hpd_pulse [xe]] ignoring short hpd on eDP [ENCODER:391:DDI A/PHY A]
<7> [331.232116] xe 0000:00:02.0: [drm:intel_dp_hpd_pulse [xe]] ignoring short hpd on eDP [ENCODER:391:DDI A/PHY A]
<7> [331.233076] xe 0000:00:02.0: [drm:intel_dpll_disable [xe]] disabling DPLL 0
<7> [331.233559] xe 0000:00:02.0: [drm:intel_power_well_disable [xe]] disabling AUX_A
<7> [331.234053] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:391:DDI A/PHY A]
<7> [331.234400] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:400:DDI TC1/PHY TC1]
<7> [331.234699] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:402:DP-MST A]
<7> [331.234989] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:403:DP-MST B]
<7> [331.235296] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:404:DP-MST C]
<7> [331.235591] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:412:DDI TC2/PHY TC2]
<7> [331.235886] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:414:DP-MST A]
<7> [331.236196] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:415:DP-MST B]
<7> [331.236497] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:416:DP-MST C]
<7> [331.236795] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:420:DDI TC3/PHY TC3]
<7> [331.237091] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:422:DP-MST A]
<7> [331.237398] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:423:DP-MST B]
<7> [331.237688] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:424:DP-MST C]
<7> [331.238041] xe 0000:00:02.0: [drm:gen9_dbuf_slices_update [xe]] Updating dbuf slices to 0xf
<7> [331.238530] xe 0000:00:02.0: [drm:intel_dbuf_mbus_join_update [xe]] Changing mbus joined: no -> yes (pipe: *)
<7> [331.238802] xe 0000:00:02.0: [drm:intel_dbuf_mdclk_cdclk_ratio_update [xe]] Updating dbuf ratio to 8 (mbus joined: yes)
<7> [331.239129] xe 0000:00:02.0: [drm:intel_power_well_enable [xe]] enabling AUX_A
<7> [331.240201] xe 0000:00:02.0: [drm:intel_dpll_enable [xe]] enable DPLL 0 (active 0x1, on? 0) for [CRTC:150:pipe A]
<7> [331.240566] xe 0000:00:02.0: [drm:intel_dpll_enable [xe]] enabling DPLL 0
<7> [331.242979] xe 0000:00:02.0: [drm:intel_pps_on_unlocked [xe]] [ENCODER:391:DDI A/PHY A] PPS 0 turn panel power on
<7> [331.243317] xe 0000:00:02.0: [drm:wait_panel_power_cycle [xe]] [ENCODER:391:DDI A/PHY A] PPS 0 wait for panel power cycle (489 ms remaining)
<7> [331.261122] xe 0000:00:02.0: [drm:icp_irq_handler [xe]] hotplug event received, stat 0x00010000, dig 0x0000000a, pins 0x00000010, long 0x00000010
<7> [331.261555] xe 0000:00:02.0: [drm:intel_hpd_irq_handler [xe]] digital hpd on [ENCODER:391:DDI A/PHY A] - long
<7> [331.261935] xe 0000:00:02.0: [drm:intel_hpd_irq_handler [xe]] Received HPD interrupt on PIN 4 - cnt: 10
<7> [331.262330] xe 0000:00:02.0: [drm:intel_dp_hpd_pulse [xe]] ignoring long hpd on eDP [ENCODER:391:DDI A/PHY A]
<7> [331.734269] xe 0000:00:02.0: [drm:wait_panel_status [xe]] [ENCODER:391:DDI A/PHY A] PPS 0 mask: 0xb800000f value: 0x00000000 PP_STATUS: 0x08000001 PP_CONTROL: 0x00000060
<7> [331.814283] xe 0000:00:02.0: [drm:wait_panel_status [xe]] Wait complete
<7> [331.814674] xe 0000:00:02.0: [drm:intel_pps_on_unlocked [xe]] [ENCODER:391:DDI A/PHY A] PPS 0 wait for panel power on
<7> [331.815003] xe 0000:00:02.0: [drm:wait_panel_status [xe]] [ENCODER:391:DDI A/PHY A] PPS 0 mask: 0xb000000f value: 0x80000008 PP_STATUS: 0x9000000a PP_CONTROL: 0x00000063
<7> [331.851476] xe 0000:00:02.0: [drm:icp_irq_handler [xe]] hotplug event received, stat 0x00010000, dig 0x0000000a, pins 0x00000010, long 0x00000010
<7> [331.851947] xe 0000:00:02.0: [drm:intel_hpd_irq_handler [xe]] digital hpd on [ENCODER:391:DDI A/PHY A] - long
<7> [331.852359] xe 0000:00:02.0: [drm:intel_hpd_irq_handler [xe]] Received HPD interrupt on PIN 4 - cnt: 20
<7> [331.852797] xe 0000:00:02.0: [drm:intel_dp_hpd_pulse [xe]] ignoring long hpd on eDP [ENCODER:391:DDI A/PHY A]
<7> [332.026351] xe 0000:00:02.0: [drm:wait_panel_status [xe]] Wait complete
<7> [332.026788] xe 0000:00:02.0: [drm:intel_pps_vdd_on_unlocked [xe]] [ENCODER:391:DDI A/PHY A] PPS 0 turning VDD on
<7> [332.027128] xe 0000:00:02.0: [drm:intel_pps_vdd_on_unlocked [xe]] [ENCODER:391:DDI A/PHY A] PPS 0 PP_STATUS: 0x80000008 PP_CONTROL: 0x0000006b
<7> [332.029362] xe 0000:00:02.0: [drm:drm_dp_read_dpcd_caps [drm_display_helper]] AUX A/DDI A/PHY A: DPCD: 14 1e 44 c1 00 00 01 c0 02 00 02 00 00 0b 80
<7> [332.030972] xe 0000:00:02.0: [drm:intel_dp_start_link_train [xe]] [CONNECTOR:392:eDP-1][ENCODER:391:DDI A/PHY A][DPRX] Reloading eDP link rates
<7> [332.031941] xe 0000:00:02.0: [drm:intel_dp_start_link_train [xe]] [CONNECTOR:392:eDP-1][ENCODER:391:DDI A/PHY A][DPRX] Using LINK_RATE_SET value 05
<7> [332.033294] xe 0000:00:02.0: [drm:intel_dp_set_signal_levels [xe]] [CONNECTOR:392:eDP-1][ENCODER:391:DDI A/PHY A][DPRX] 8b/10b, lanes: 4, vswing levels: 0/0/0/0, pre-emphasis levels: 0/0/0/0
<7> [332.034846] xe 0000:00:02.0: [drm:intel_dp_program_link_training_pattern [xe]] [CONNECTOR:392:eDP-1][ENCODER:391:DDI A/PHY A][DPRX] Using DP training pattern TPS1
<7> [332.036084] xe 0000:00:02.0: [drm:intel_dp_link_train_phy [xe]] [CONNECTOR:392:eDP-1][ENCODER:391:DDI A/PHY A][DPRX] Clock recovery OK
<7> [332.036595] xe 0000:00:02.0: [drm:intel_dp_program_link_training_pattern [xe]] [CONNECTOR:392:eDP-1][ENCODER:391:DDI A/PHY A][DPRX] Using DP training pattern TPS4
<7> [332.038222] xe 0000:00:02.0: [drm:intel_dp_link_train_phy [xe]] [CONNECTOR:392:eDP-1][ENCODER:391:DDI A/PHY A][DPRX] Channel EQ done. DP Training successful
<7> [332.038608] xe 0000:00:02.0: [drm:intel_dp_link_train_phy [xe]] [CONNECTOR:392:eDP-1][ENCODER:391:DDI A/PHY A][DPRX] Link Training passed at link rate = 432000, lane count = 4
<7> [332.039508] xe 0000:00:02.0: [drm:intel_enable_transcoder [xe]] enabling pipe A
<7> [332.039987] xe 0000:00:02.0: [drm:intel_edp_backlight_on [xe]]
<7> [332.040438] xe 0000:00:02.0: [drm:intel_backlight_enable [xe]] pipe A
<7> [332.040853] xe 0000:00:02.0: [drm:intel_backlight_set_pwm_level [xe]] [CONNECTOR:392:eDP-1] set backlight PWM = 192000
<7> [332.056887] xe 0000:00:02.0: [drm:intel_psr_post_plane_update [xe]] Enabling PSR2
<7> [332.058768] xe 0000:00:02.0: [drm:verify_connector_state [xe]] [CONNECTOR:392:eDP-1]
<7> [332.059161] xe 0000:00:02.0: [drm:intel_modeset_verify_crtc [xe]] [CRTC:150:pipe A]
<7> [332.062195] xe 0000:00:02.0: [drm:intel_power_well_disable [xe]] disabling PW_C
<7> [332.062614] xe 0000:00:02.0: [drm:dss_pipe_gating_enable_disable [xe]] DSS clock gating disabled for pipe_mask=0x4 (CLKGATE_DIS_DSSDSC=0xa8000000)
<7> [332.063020] xe 0000:00:02.0: [drm:intel_power_well_disable [xe]] disabling PW_2
<7> [332.063474] xe 0000:00:02.0: [drm:intel_modeset_verify_crtc [xe]] [CRTC:388:pipe C]
<7> [332.063952] xe 0000:00:02.0: [drm:drm_client_dev_restore] fbdev: ret=0
<6> [332.065715] [IGT] kms_flip: exiting, ret=98
<6> [332.073845] Console: switching to colour frame buffer device 180x56
Created at 2026-03-14 08:10:50