Results for igt@kms_flip@flip-vs-blocking-wf-vblank@b-edp1

Result: Fail

git-log-oneline i915_display_info9 igt_runner9 runtimes9 results9.json results9-i915-load.json i915_display_info_post_exec9 boot9 dmesg9

DetailValue
Duration 20.77 seconds
Hostname
shard-mtlp-5
Igt-Version
IGT-Version: 2.2-gdd5157451 (x86_64) (Linux: 6.18.0-rc5-CI_DRM_17537-g2395af7950ab+ x86_64)
Out
Starting dynamic subtest: B-eDP1
  2880x1800: 90 513820 2880 2928 2960 3040 1800 1803 1809 1878 0x48 0xa 
Expected frametime: 11111us; measured 11111.4us +- 2.277us accuracy 0.06%
Event flip: expected 675, counted 670, passrate = 73.13%, encoder type 2
Event vblank: expected 675, counted 670, passrate = 71.64%, encoder type 2
Expected frametime: 11111us; measured 11265.6us +- 2.553us accuracy 0.07%
vblank interval differs from modeline! expected 11111.1us, measured 11266us +- 2.553us, difference 154.5us (60.5 sigma)
Event flip: expected 666, counted 670, passrate = 49.25%, encoder type 2
Event vblank: expected 666, counted 670, passrate = 47.76%, encoder type 2
Stack trace:
  #0 ../lib/igt_core.c:2075 __igt_fail_assert()
  #1 ../tests/kms_flip.c:428 run_test_on_crtc_set.constprop.0()
  #2 ../tests/kms_flip.c:1889 run_test()
  #3 ../tests/kms_flip.c:2122 __igt_unique____real_main2045()
  #4 ../tests/kms_flip.c:2045 main()
  #5 [__libc_init_first+0x8a]
  #6 [__libc_start_main+0x8b]
  #7 [_start+0x25]
Dynamic subtest B-eDP1: FAIL (20.772s)
Err
Starting dynamic subtest: B-eDP1
(kms_flip:2202) CRITICAL: Test assertion failure function __run_test_on_crtc_set, file ../tests/kms_flip.c:1709:
(kms_flip:2202) CRITICAL: Failed assertion: !retried
Dynamic subtest B-eDP1 failed.
**** DEBUG ****
(kms_flip:2202) DEBUG: flip ts/seq: last 80.303001/943, current 80.415138/953: elapsed=112143.0us expected=112656.2us +- 563.3us, error 0.5%
(kms_flip:2202) DEBUG: name = vblank
last_ts = 80.403931
last_received_ts = 80.403877
last_seq = 952
current_ts = 80.516075
current_received_ts = 80.516121
current_seq = 962
count = 24
seq_step = 10
(kms_flip:2202) DEBUG: vblank ts/seq: last 80.403931/952, current 80.516075/962: elapsed=112144.0us expected=112656.2us +- 563.3us, error 0.5%
(kms_flip:2202) DEBUG: name = flip
last_ts = 80.415138
last_received_ts = 80.516174
last_seq = 953
current_ts = 80.527290
current_received_ts = 80.628395
current_seq = 963
count = 25
seq_step = 1
(kms_flip:2202) DEBUG: flip ts/seq: last 80.415138/953, current 80.527290/963: elapsed=112147.0us expected=112656.2us +- 563.3us, error 0.5%
(kms_flip:2202) DEBUG: name = vblank
last_ts = 80.516075
last_received_ts = 80.516121
last_seq = 962
current_ts = 80.628220
current_received_ts = 80.628319
current_seq = 972
count = 25
seq_step = 10
(kms_flip:2202) DEBUG: vblank ts/seq: last 80.516075/962, current 80.628220/972: elapsed=112145.0us expected=112656.2us +- 563.3us, error 0.5%
(kms_flip:2202) DEBUG: name = flip
last_ts = 80.527290
last_received_ts = 80.628395
last_seq = 963
current_ts = 80.639435
current_received_ts = 80.740471
current_seq = 973
count = 26
seq_step = 1
(kms_flip:2202) DEBUG: flip ts/seq: last 80.527290/963, current 80.639435/973: elapsed=112144.0us expected=112656.2us +- 563.3us, error 0.5%
(kms_flip:2202) DEBUG: name = vblank
last_ts = 80.628220
last_received_ts = 80.628319
last_seq = 972
current_ts = 80.740364
current_received_ts = 80.740425
current_seq = 982
count = 26
seq_step = 10
(kms_flip:2202) DEBUG: vblank ts/seq: last 80.628220/972, current 80.740364/982: elapsed=112147.0us expected=112656.2us +- 563.3us, error 0.5%
(kms_flip:2202) DEBUG: name = flip
last_ts = 80.639435
last_received_ts = 80.740471
last_seq = 973
current_ts = 80.751572
current_received_ts = 80.852676
current_seq = 983
count = 27
seq_step = 1
(kms_flip:2202) DEBUG: flip ts/seq: last 80.639435/973, current 80.751572/983: elapsed=112141.0us expected=112656.2us +- 563.3us, error 0.5%
(kms_flip:2202) DEBUG: name = vblank
last_ts = 80.740364
last_received_ts = 80.740425
last_seq = 982
current_ts = 80.852509
current_received_ts = 80.852608
current_seq = 992
count = 27
seq_step = 10
(kms_flip:2202) DEBUG: vblank ts/seq: last 80.740364/982, current 80.852509/992: elapsed=112143.0us expected=112656.2us +- 563.3us, error 0.5%
(kms_flip:2202) DEBUG: name = flip
last_ts = 80.751572
last_received_ts = 80.852676
last_seq = 983
current_ts = 80.863716
current_received_ts = 80.964767
current_seq = 993
count = 28
seq_step = 1
(kms_flip:2202) DEBUG: flip ts/seq: last 80.751572/983, current 80.863716/993: elapsed=112146.0us expected=112656.2us +- 563.3us, error 0.5%
(kms_flip:2202) DEBUG: name = vblank
last_ts = 80.852509
last_received_ts = 80.852608
last_seq = 992
current_ts = 80.964653
current_received_ts = 80.964714
current_seq = 1002
count = 28
seq_step = 10
(kms_flip:2202) DEBUG: vblank ts/seq: last 80.852509/992, current 80.964653/1002: elapsed=112146.0us expected=112656.2us +- 563.3us, error 0.5%
(kms_flip:2202) DEBUG: name = flip
last_ts = 80.863716
last_received_ts = 80.964767
last_seq = 993
current_ts = 80.975861
current_received_ts = 81.076988
current_seq = 1003
count = 29
seq_step = 1
(kms_flip:2202) DEBUG: flip ts/seq: last 80.863716/993, current 80.975861/1003: elapsed=112143.0us expected=112656.2us +- 563.3us, error 0.5%
(kms_flip:2202) DEBUG: name = vblank
last_ts = 80.964653
last_received_ts = 80.964714
last_seq = 1002
current_ts = 81.076797
current_received_ts = 81.076920
current_seq = 1012
count = 29
seq_step = 10
(kms_flip:2202) DEBUG: vblank ts/seq: last 80.964653/1002, current 81.076797/1012: elapsed=112145.0us expected=112656.2us +- 563.3us, error 0.5%
(kms_flip:2202) DEBUG: name = flip
last_ts = 80.975861
last_received_ts = 81.076988
last_seq = 1003
current_ts = 81.088013
current_received_ts = 81.189110
current_seq = 1013
count = 30
seq_step = 1
(kms_flip:2202) DEBUG: flip ts/seq: last 80.975861/1003, current 81.088013/1013: elapsed=112149.0us expected=112656.2us +- 563.3us, error 0.5%
(kms_flip:2202) DEBUG: name = vblank
last_ts = 81.076797
last_received_ts = 81.076920
last_seq = 1012
current_ts = 81.188942
current_received_ts = 81.188995
current_seq = 1022
count = 30
seq_step = 10
(kms_flip:2202) DEBUG: vblank ts/seq: last 81.076797/1012, current 81.188942/1022: elapsed=112139.0us expected=112656.2us +- 563.3us, error 0.5%
(kms_flip:2202) DEBUG: name = flip
last_ts = 81.088013
last_received_ts = 81.189110
last_seq = 1013
current_ts = 81.200157
current_received_ts = 81.301186
current_seq = 1023
count = 31
seq_step = 1
(kms_flip:2202) DEBUG: flip ts/seq: last 81.088013/1013, current 81.200157/1023: elapsed=112143.0us expected=112656.2us +- 563.3us, error 0.5%
(kms_flip:2202) DEBUG: name = vblank
last_ts = 81.188942
last_received_ts = 81.188995
last_seq = 1022
current_ts = 81.301086
current_received_ts = 81.301140
current_seq = 1032
count = 31
seq_step = 10
(kms_flip:2202) DEBUG: vblank ts/seq: last 81.188942/1022, current 81.301086/1032: elapsed=112148.0us expected=112656.2us +- 563.3us, error 0.5%
(kms_flip:2202) DEBUG: name = flip
last_ts = 81.200157
last_received_ts = 81.301186
last_seq = 1023
current_ts = 81.312286
current_received_ts = 81.413216
current_seq = 1033
count = 32
seq_step = 1
(kms_flip:2202) DEBUG: flip ts/seq: last 81.200157/1023, current 81.312286/1033: elapsed=112130.0us expected=112656.2us +- 563.3us, error 0.5%
(kms_flip:2202) DEBUG: name = vblank
last_ts = 81.301086
last_received_ts = 81.301140
last_seq = 1032
current_ts = 81.413101
current_received_ts = 81.413162
current_seq = 1042
count = 32
seq_step = 10
(kms_flip:2202) DEBUG: vblank ts/seq: last 81.301086/1032, current 81.413101/1042: elapsed=112017.0us expected=112656.2us +- 563.3us, error 0.6%
(kms_flip:2202) DEBUG: inconsistent vblank ts/seq: last 81.301086/1032, current 81.413101/1042: elapsed=112017.0us expected=112656.2us
(kms_flip:2202) DEBUG: name = flip
last_ts = 81.312286
last_received_ts = 81.413216
last_seq = 1033
current_ts = 81.424301
current_received_ts = 81.525253
current_seq = 1043
count = 33
seq_step = 1
(kms_flip:2202) DEBUG: flip ts/seq: last 81.312286/1033, current 81.424301/1043: elapsed=112017.0us expected=112656.2us +- 563.3us, error 0.6%
(kms_flip:2202) DEBUG: inconsistent flip ts/seq: last 81.312286/1033, current 81.424301/1043: elapsed=112017.0us expected=112656.2us
(kms_flip:2202) DEBUG: name = vblank
last_ts = 81.413101
last_received_ts = 81.413162
last_seq = 1042
current_ts = 81.525116
current_received_ts = 81.525208
current_seq = 1052
count = 33
seq_step = 10
(kms_flip:2202) DEBUG: vblank ts/seq: last 81.413101/1042, current 81.525116/1052: elapsed=112014.0us expected=112656.2us +- 563.3us, error 0.6%
(kms_flip:2202) DEBUG: inconsistent vblank ts/seq: last 81.413101/1042, current 81.525116/1052: elapsed=112014.0us expected=112656.2us
(kms_flip:2202) DEBUG: name = flip
last_ts = 81.424301
last_received_ts = 81.525253
last_seq = 1043
current_ts = 81.536316
current_received_ts = 81.636909
current_seq = 1053
count = 34
seq_step = 1
(kms_flip:2202) DEBUG: flip ts/seq: last 81.424301/1043, current 81.536316/1053: elapsed=112016.0us expected=112656.2us +- 563.3us, error 0.6%
(kms_flip:2202) DEBUG: inconsistent flip ts/seq: last 81.424301/1043, current 81.536316/1053: elapsed=112016.0us expected=112656.2us
(kms_flip:2202) DEBUG: name = vblank
last_ts = 81.525116
last_received_ts = 81.525208
last_seq = 1052
current_ts = 81.637131
current_received_ts = 81.636864
current_seq = 1062
count = 34
seq_step = 10
(kms_flip:2202) DEBUG: vblank ts/seq: last 81.525116/1052, current 81.637131/1062: elapsed=112012.0us expected=112656.2us +- 563.3us, error 0.6%
(kms_flip:2202) DEBUG: inconsistent vblank ts/seq: last 81.525116/1052, current 81.637131/1062: elapsed=112012.0us expected=112656.2us
(kms_flip:2202) DEBUG: name = flip
last_ts = 81.536316
last_received_ts = 81.636909
last_seq = 1053
current_ts = 81.648338
current_received_ts = 81.749344
current_seq = 1063
count = 35
seq_step = 1
(kms_flip:2202) DEBUG: flip ts/seq: last 81.536316/1053, current 81.648338/1063: elapsed=112018.0us expected=112656.2us +- 563.3us, error 0.6%
(kms_flip:2202) DEBUG: inconsistent flip ts/seq: last 81.536316/1053, current 81.648338/1063: elapsed=112018.0us expected=112656.2us
(kms_flip:2202) DEBUG: name = vblank
last_ts = 81.637131
last_received_ts = 81.636864
last_seq = 1062
current_ts = 81.749146
current_received_ts = 81.749268
current_seq = 1072
count = 35
seq_step = 10
(kms_flip:2202) DEBUG: vblank ts/seq: last 81.637131/1062, current 81.749146/1072: elapsed=112016.0us expected=112656.2us +- 563.3us, error 0.6%
(kms_flip:2202) DEBUG: inconsistent vblank ts/seq: last 81.637131/1062, current 81.749146/1072: elapsed=112016.0us expected=112656.2us
(kms_flip:2202) DEBUG: name = flip
last_ts = 81.648338
last_received_ts = 81.749344
last_seq = 1063
current_ts = 81.760345
current_received_ts = 81.861359
current_seq = 1073
count = 36
seq_step = 1
(kms_flip:2202) DEBUG: flip ts/seq: last 81.648338/1063, current 81.760345/1073: elapsed=112014.0us expected=112656.2us +- 563.3us, error 0.6%
(kms_flip:2202) DEBUG: inconsistent flip ts/seq: last 81.648338/1063, current 81.760345/1073: elapsed=112014.0us expected=112656.2us
(kms_flip:2202) DEBUG: name = vblank
last_ts = 81.749146
last_received_ts = 81.749268
last_seq = 1072
current_ts = 81.861160
current_received_ts = 81.861290
current_seq = 1082
count = 36
seq_step = 10
(kms_flip:2202) DEBUG: vblank ts/seq: last 81.749146/1072, current 81.861160/1082: elapsed=112017.0us expected=112656.2us +- 563.3us, error 0.6%
(kms_flip:2202) DEBUG: inconsistent vblank ts/seq: last 81.749146/1072, current 81.861160/1082: elapsed=112017.0us expected=112656.2us
(kms_flip:2202) DEBUG: name = flip
last_ts = 81.760345
last_received_ts = 81.861359
last_seq = 1073
current_ts = 81.872360
current_received_ts = 81.973305
current_seq = 1083
count = 37
seq_step = 1
(kms_flip:2202) DEBUG: flip ts/seq: last 81.760345/1073, current 81.872360/1083: elapsed=112014.0us expected=112656.2us +- 563.3us, error 0.6%
(kms_flip:2202) DEBUG: inconsistent flip ts/seq: last 81.760345/1073, current 81.872360/1083: elapsed=112014.0us expected=112656.2us
(kms_flip:2202) DEBUG: name = vblank
last_ts = 81.861160
last_received_ts = 81.861290
last_seq = 1082
current_ts = 81.973183
current_received_ts = 81.973251
current_seq = 1092
count = 37
seq_step = 10
(kms_flip:2202) DEBUG: vblank ts/seq: last 81.861160/1082, current 81.973183/1092: elapsed=112017.0us expected=112656.2us +- 563.3us, error 0.6%
(kms_flip:2202) DEBUG: inconsistent vblank ts/seq: last 81.861160/1082, current 81.973183/1092: elapsed=112017.0us expected=112656.2us
(kms_flip:2202) DEBUG: name = flip
last_ts = 81.872360
last_received_ts = 81.973305
last_seq = 1083
current_ts = 81.984383
current_received_ts = 82.085350
current_seq = 1093
count = 38
seq_step = 1
(kms_flip:2202) DEBUG: flip ts/seq: last 81.872360/1083, current 81.984383/1093: elapsed=112017.0us expected=112656.2us +- 563.3us, error 0.6%
(kms_flip:2202) DEBUG: inconsistent flip ts/seq: last 81.872360/1083, current 81.984383/1093: elapsed=112017.0us expected=112656.2us
(kms_flip:2202) DEBUG: name = vblank
last_ts = 81.973183
last_received_ts = 81.973251
last_seq = 1092
current_ts = 82.085197
current_received_ts = 82.085281
current_seq = 1102
count = 38
seq_step = 10
(kms_flip:2202) DEBUG: vblank ts/seq: last 81.973183/1092, current 82.085197/1102: elapsed=112016.0us expected=112656.2us +- 563.3us, error 0.6%
(kms_flip:2202) DEBUG: inconsistent vblank ts/seq: last 81.973183/1092, current 82.085197/1102: elapsed=112016.0us expected=112656.2us
(kms_flip:2202) DEBUG: name = flip
last_ts = 81.984383
last_received_ts = 82.085350
last_seq = 1093
current_ts = 82.096390
current_received_ts = 82.197319
current_seq = 1103
count = 39
seq_step = 1
(kms_flip:2202) DEBUG: flip ts/seq: last 81.984383/1093, current 82.096390/1103: elapsed=112012.0us expected=112656.2us +- 563.3us, error 0.6%
(kms_flip:2202) DEBUG: inconsistent flip ts/seq: last 81.984383/1093, current 82.096390/1103: elapsed=112012.0us expected=112656.2us
(kms_flip:2202) DEBUG: name = vblank
last_ts = 82.085197
last_received_ts = 82.085281
last_seq = 1102
current_ts = 82.197205
current_received_ts = 82.197266
current_seq = 1112
count = 39
seq_step = 10
(kms_flip:2202) DEBUG: vblank ts/seq: last 82.085197/1102, current 82.197205/1112: elapsed=112012.0us expected=112656.2us +- 563.3us, error 0.6%
(kms_flip:2202) DEBUG: inconsistent vblank ts/seq: last 82.085197/1102, current 82.197205/1112: elapsed=112012.0us expected=112656.2us
(kms_flip:2202) DEBUG: name = flip
last_ts = 82.096390
last_received_ts = 82.197319
last_seq = 1103
current_ts = 82.208412
current_received_ts = 82.309402
current_seq = 1113
count = 40
seq_step = 1
(kms_flip:2202) DEBUG: flip ts/seq: last 82.096390/1103, current 82.208412/1113: elapsed=112018.0us expected=112656.2us +- 563.3us, error 0.6%
(kms_flip:2202) DEBUG: inconsistent flip ts/seq: last 82.096390/1103, current 82.208412/1113: elapsed=112018.0us expected=112656.2us
(kms_flip:2202) DEBUG: name = vblank
last_ts = 82.197205
last_received_ts = 82.197266
last_seq = 1112
current_ts = 82.309212
current_received_ts = 82.309326
current_seq = 1122
count = 40
seq_step = 10
(kms_flip:2202) DEBUG: vblank ts/seq: last 82.197205/1112, current 82.309212/1122: elapsed=112000.0us expected=112656.2us +- 563.3us, error 0.6%
(kms_flip:2202) DEBUG: inconsistent vblank ts/seq: last 82.197205/1112, current 82.309212/1122: elapsed=112000.0us expected=112656.2us
(kms_flip:2202) DEBUG: name = flip
last_ts = 82.208412
last_received_ts = 82.309402
last_seq = 1113
current_ts = 82.320396
current_received_ts = 82.421219
current_seq = 1123
count = 41
seq_step = 1
(kms_flip:2202) DEBUG: flip ts/seq: last 82.208412/1113, current 82.320396/1123: elapsed=111986.0us expected=112656.2us +- 563.3us, error 0.6%
(kms_flip:2202) DEBUG: inconsistent flip ts/seq: last 82.208412/1113, current 82.320396/1123: elapsed=111986.0us expected=112656.2us
(kms_flip:2202) DEBUG: name = vblank
last_ts = 82.309212
last_received_ts = 82.309326
last_seq = 1122
current_ts = 82.421112
current_received_ts = 82.421173
current_seq = 1132
count = 41
seq_step = 10
(kms_flip:2202) DEBUG: vblank ts/seq: last 82.309212/1122, current 82.421112/1132: elapsed=111905.0us expected=112656.2us +- 563.3us, error 0.7%
(kms_flip:2202) DEBUG: inconsistent vblank ts/seq: last 82.309212/1122, current 82.421112/1132: elapsed=111905.0us expected=112656.2us
(kms_flip:2202) DEBUG: name = flip
last_ts = 82.320396
last_received_ts = 82.421219
last_seq = 1123
current_ts = 82.432304
current_received_ts = 82.533203
current_seq = 1133
count = 42
seq_step = 1
(kms_flip:2202) DEBUG: flip ts/seq: last 82.320396/1123, current 82.432304/1133: elapsed=111907.0us expected=112656.2us +- 563.3us, error 0.7%
(kms_flip:2202) DEBUG: inconsistent flip ts/seq: last 82.320396/1123, current 82.432304/1133: elapsed=111907.0us expected=112656.2us
(kms_flip:2202) DEBUG: name = vblank
last_ts = 82.421112
last_received_ts = 82.421173
last_seq = 1132
current_ts = 82.533012
current_received_ts = 82.533127
current_seq = 1142
count = 42
seq_step = 10
(kms_flip:2202) DEBUG: vblank ts/seq: last 82.421112/1132, current 82.533012/1142: elapsed=111902.0us expected=112656.2us +- 563.3us, error 0.7%
(kms_flip:2202) DEBUG: inconsistent vblank ts/seq: last 82.421112/1132, current 82.533012/1142: elapsed=111902.0us expected=112656.2us
(kms_flip:2202) DEBUG: name = flip
last_ts = 82.432304
last_received_ts = 82.533203
last_seq = 1133
current_ts = 82.544205
current_received_ts = 82.645081
current_seq = 1143
count = 43
seq_step = 1
(kms_flip:2202) DEBUG: flip ts/seq: last 82.432304/1133, current 82.544205/1143: elapsed=111900.0us expected=112656.2us +- 563.3us, error 0.7%
(kms_flip:2202) DEBUG: inconsistent flip ts/seq: last 82.432304/1133, current 82.544205/1143: elapsed=111900.0us expected=112656.2us
(kms_flip:2202) DEBUG: name = vblank
last_ts = 82.533012
last_received_ts = 82.533127
last_seq = 1142
current_ts = 82.644913
current_received_ts = 82.644966
current_seq = 1152
count = 43
seq_step = 10
(kms_flip:2202) DEBUG: vblank ts/seq: last 82.533012/1142, current 82.644913/1152: elapsed=111900.0us expected=112656.2us +- 563.3us, error 0.7%
(kms_flip:2202) DEBUG: inconsistent vblank ts/seq: last 82.533012/1142, current 82.644913/1152: elapsed=111900.0us expected=112656.2us
(kms_flip:2202) DEBUG: name = flip
last_ts = 82.544205
last_received_ts = 82.645081
last_seq = 1143
current_ts = 82.656105
current_received_ts = 82.756935
current_seq = 1153
count = 44
seq_step = 1
(kms_flip:2202) DEBUG: flip ts/seq: last 82.544205/1143, current 82.656105/1153: elapsed=111904.0us expected=112656.2us +- 563.3us, error 0.7%
(kms_flip:2202) DEBUG: inconsistent flip ts/seq: last 82.544205/1143, current 82.656105/1153: elapsed=111904.0us expected=112656.2us
(kms_flip:2202) DEBUG: name = vblank
last_ts = 82.644913
last_received_ts = 82.644966
last_seq = 1152
current_ts = 82.756813
current_received_ts = 82.756882
current_seq = 1162
count = 44
seq_step = 10
(kms_flip:2202) DEBUG: vblank ts/seq: last 82.644913/1152, current 82.756813/1162: elapsed=111901.0us expected=112656.2us +- 563.3us, error 0.7%
(kms_flip:2202) DEBUG: inconsistent vblank ts/seq: last 82.644913/1152, current 82.756813/1162: elapsed=111901.0us expected=112656.2us
(kms_flip:2202) DEBUG: name = flip
last_ts = 82.656105
last_received_ts = 82.756935
last_seq = 1153
current_ts = 82.768005
current_received_ts = 82.868912
current_seq = 1163
count = 45
seq_step = 1
(kms_flip:2202) DEBUG: flip ts/seq: last 82.656105/1153, current 82.768005/1163: elapsed=111900.0us expected=112656.2us +- 563.3us, error 0.7%
(kms_flip:2202) DEBUG: inconsistent flip ts/seq: last 82.656105/1153, current 82.768005/1163: elapsed=111900.0us expected=112656.2us
(kms_flip:2202) DEBUG: name = vblank
last_ts = 82.756813
last_received_ts = 82.756882
last_seq = 1162
current_ts = 82.868721
current_received_ts = 82.868835
current_seq = 1172
count = 45
seq_step = 10
(kms_flip:2202) DEBUG: vblank ts/seq: last 82.756813/1162, current 82.868721/1172: elapsed=111903.0us expected=112656.2us +- 563.3us, error 0.7%
(kms_flip:2202) DEBUG: inconsistent vblank ts/seq: last 82.756813/1162, current 82.868721/1172: elapsed=111903.0us expected=112656.2us
(kms_flip:2202) DEBUG: name = flip
last_ts = 82.768005
last_received_ts = 82.868912
last_seq = 1163
current_ts = 82.879906
current_received_ts = 82.980835
current_seq = 1173
count = 46
seq_step = 1
(kms_flip:2202) DEBUG: flip ts/seq: last 82.768005/1163, current 82.879906/1173: elapsed=111902.0us expected=112656.2us +- 563.3us, error 0.7%
(kms_flip:2202) DEBUG: inconsistent flip ts/seq: last 82.768005/1163, current 82.879906/1173: elapsed=111902.0us expected=112656.2us
(kms_flip:2202) DEBUG: name = vblank
last_ts = 82.868721
last_received_ts = 82.868835
last_seq = 1172
current_ts = 82.980621
current_received_ts = 82.980759
current_seq = 1182
count = 46
seq_step = 10
(kms_flip:2202) DEBUG: vblank ts/seq: last 82.868721/1172, current 82.980621/1182: elapsed=111902.0us expected=112656.2us +- 563.3us, error 0.7%
(kms_flip:2202) DEBUG: inconsistent vblank ts/seq: last 82.868721/1172, current 82.980621/1182: elapsed=111902.0us expected=112656.2us
(kms_flip:2202) DEBUG: name = flip
last_ts = 82.879906
last_received_ts = 82.980835
last_seq = 1173
current_ts = 82.991814
current_received_ts = 83.092651
current_seq = 1183
count = 47
seq_step = 1
(kms_flip:2202) DEBUG: flip ts/seq: last 82.879906/1173, current 82.991814/1183: elapsed=111903.0us expected=112656.2us +- 563.3us, error 0.7%
(kms_flip:2202) DEBUG: inconsistent flip ts/seq: last 82.879906/1173, current 82.991814/1183: elapsed=111903.0us expected=112656.2us
(kms_flip:2202) DEBUG: name = vblank
last_ts = 82.980621
last_received_ts = 82.980759
last_seq = 1182
current_ts = 83.092529
current_received_ts = 83.092606
current_seq = 1192
count = 47
seq_step = 10
(kms_flip:2202) DEBUG: vblank ts/seq: last 82.980621/1182, current 83.092529/1192: elapsed=111906.0us expected=112656.2us +- 563.3us, error 0.7%
(kms_flip:2202) DEBUG: inconsistent vblank ts/seq: last 82.980621/1182, current 83.092529/1192: elapsed=111906.0us expected=112656.2us
(kms_flip:2202) DEBUG: name = flip
last_ts = 82.991814
last_received_ts = 83.092651
last_seq = 1183
current_ts = 83.103714
current_received_ts = 83.204590
current_seq = 1193
count = 48
seq_step = 1
(kms_flip:2202) DEBUG: flip ts/seq: last 82.991814/1183, current 83.103714/1193: elapsed=111904.0us expected=112656.2us +- 563.3us, error 0.7%
(kms_flip:2202) DEBUG: inconsistent flip ts/seq: last 82.991814/1183, current 83.103714/1193: elapsed=111904.0us expected=112656.2us
(kms_flip:2202) DEBUG: name = vblank
last_ts = 83.092529
last_received_ts = 83.092606
last_seq = 1192
current_ts = 83.204430
current_received_ts = 83.204529
current_seq = 1202
count = 48
seq_step = 10
(kms_flip:2202) DEBUG: vblank ts/seq: last 83.092529/1192, current 83.204430/1202: elapsed=111900.0us expected=112656.2us +- 563.3us, error 0.7%
(kms_flip:2202) DEBUG: inconsistent vblank ts/seq: last 83.092529/1192, current 83.204430/1202: elapsed=111900.0us expected=112656.2us
(kms_flip:2202) DEBUG: name = flip
last_ts = 83.103714
last_received_ts = 83.204590
last_seq = 1193
current_ts = 83.215614
current_received_ts = 83.316437
current_seq = 1203
count = 49
seq_step = 1
(kms_flip:2202) DEBUG: flip ts/seq: last 83.103714/1193, current 83.215614/1203: elapsed=111901.0us expected=112656.2us +- 563.3us, error 0.7%
(kms_flip:2202) DEBUG: inconsistent flip ts/seq: last 83.103714/1193, current 83.215614/1203: elapsed=111901.0us expected=112656.2us
(kms_flip:2202) DEBUG: name = vblank
last_ts = 83.204430
last_received_ts = 83.204529
last_seq = 1202
current_ts = 83.316315
current_received_ts = 83.316383
current_seq = 1212
count = 49
seq_step = 10
(kms_flip:2202) DEBUG: vblank ts/seq: last 83.204430/1202, current 83.316315/1212: elapsed=111884.0us expected=112656.2us +- 563.3us, error 0.7%
(kms_flip:2202) DEBUG: inconsistent vblank ts/seq: last 83.204430/1202, current 83.316315/1212: elapsed=111884.0us expected=112656.2us
(kms_flip:2202) DEBUG: name = flip
last_ts = 83.215614
last_received_ts = 83.316437
last_seq = 1203
current_ts = 83.327492
current_received_ts = 83.428276
current_seq = 1213
count = 50
seq_step = 1
(kms_flip:2202) DEBUG: flip ts/seq: last 83.215614/1203, current 83.327492/1213: elapsed=111874.0us expected=112656.2us +- 563.3us, error 0.7%
(kms_flip:2202) DEBUG: inconsistent flip ts/seq: last 83.215614/1203, current 83.327492/1213: elapsed=111874.0us expected=112656.2us
(kms_flip:2202) DEBUG: name = vblank
last_ts = 83.316315
last_received_ts = 83.316383
last_seq = 1212
current_ts = 83.428108
current_received_ts = 83.428200
current_seq = 1222
count = 50
seq_step = 10
(kms_flip:2202) DEBUG: vblank ts/seq: last 83.316315/1212, current 83.428108/1222: elapsed=111801.0us expected=112656.2us +- 563.3us, error 0.8%
(kms_flip:2202) DEBUG: inconsistent vblank ts/seq: last 83.316315/1212, current 83.428108/1222: elapsed=111801.0us expected=112656.2us
(kms_flip:2202) DEBUG: name = flip
last_ts = 83.327492
last_received_ts = 83.428276
last_seq = 1213
current_ts = 83.439293
current_received_ts = 83.539711
current_seq = 1223
count = 51
seq_step = 1
(kms_flip:2202) DEBUG: flip ts/seq: last 83.327492/1213, current 83.439293/1223: elapsed=111802.0us expected=112656.2us +- 563.3us, error 0.8%
(kms_flip:2202) DEBUG: inconsistent flip ts/seq: last 83.327492/1213, current 83.439293/1223: elapsed=111802.0us expected=112656.2us
(kms_flip:2202) DEBUG: name = vblank
last_ts = 83.428108
last_received_ts = 83.428200
last_seq = 1222
current_ts = 83.539917
current_received_ts = 83.539680
current_seq = 1232
count = 51
seq_step = 10
(kms_flip:2202) DEBUG: vblank ts/seq: last 83.428108/1222, current 83.539917/1232: elapsed=111806.0us expected=112656.2us +- 563.3us, error 0.8%
(kms_flip:2202) DEBUG: inconsistent vblank ts/seq: last 83.428108/1222, current 83.539917/1232: elapsed=111806.0us expected=112656.2us
(kms_flip:2202) DEBUG: name = flip
last_ts = 83.439293
last_received_ts = 83.539711
last_seq = 1223
current_ts = 83.551094
current_received_ts = 83.651817
current_seq = 1233
count = 52
seq_step = 1
(kms_flip:2202) DEBUG: flip ts/seq: last 83.439293/1223, current 83.551094/1233: elapsed=111801.0us expected=112656.2us +- 563.3us, error 0.8%
(kms_flip:2202) DEBUG: inconsistent flip ts/seq: last 83.439293/1223, current 83.551094/1233: elapsed=111801.0us expected=112656.2us
(kms_flip:2202) DEBUG: name = vblank
last_ts = 83.539917
last_received_ts = 83.539680
last_seq = 1232
current_ts = 83.651718
current_received_ts = 83.651772
current_seq = 1242
count = 52
seq_step = 10
(kms_flip:2202) DEBUG: vblank ts/seq: last 83.539917/1232, current 83.651718/1242: elapsed=111802.0us expected=112656.2us +- 563.3us, error 0.8%
(kms_flip:2202) DEBUG: inconsistent vblank ts/seq: last 83.539917/1232, current 83.651718/1242: elapsed=111802.0us expected=112656.2us
(kms_flip:2202) DEBUG: name = flip
last_ts = 83.551094
last_received_ts = 83.651817
last_seq = 1233
current_ts = 83.662903
current_received_ts = 83.763687
current_seq = 1243
count = 53
seq_step = 1
(kms_flip:2202) DEBUG: flip ts/seq: last 83.551094/1233, current 83.662903/1243: elapsed=111807.0us expected=112656.2us +- 563.3us, error 0.8%
(kms_flip:2202) DEBUG: inconsistent flip ts/seq: last 83.551094/1233, current 83.662903/1243: elapsed=111807.0us expected=112656.2us
(kms_flip:2202) DEBUG: name = vblank
last_ts = 83.651718
last_received_ts = 83.651772
last_seq = 1242
current_ts = 83.763527
current_received_ts = 83.763611
current_seq = 1252
count = 53
seq_step = 10
(kms_flip:2202) DEBUG: vblank ts/seq: last 83.651718/1242, current 83.763527/1252: elapsed=111804.0us expected=112656.2us +- 563.3us, error 0.8%
(kms_flip:2202) DEBUG: inconsistent vblank ts/seq: last 83.651718/1242, current 83.763527/1252: elapsed=111804.0us expected=112656.2us
(kms_flip:2202) DEBUG: name = flip
last_ts = 83.662903
last_received_ts = 83.763687
last_seq = 1243
current_ts = 83.774704
current_received_ts = 83.875427
current_seq = 1253
count = 54
seq_step = 1
(kms_flip:2202) DEBUG: flip ts/seq: last 83.662903/1243, current 83.774704/1253: elapsed=111805.0us expected=112656.2us +- 563.3us, error 0.8%
(kms_flip:2202) DEBUG: inconsistent flip ts/seq: last 83.662903/1243, current 83.774704/1253: elapsed=111805.0us expected=112656.2us
(kms_flip:2202) DEBUG: name = vblank
last_ts = 83.763527
last_received_ts = 83.763611
last_seq = 1252
current_ts = 83.875328
current_received_ts = 83.875374
current_seq = 1262
count = 54
seq_step = 10
(kms_flip:2202) DEBUG: vblank ts/seq: last 83.763527/1252, current 83.875328/1262: elapsed=111802.0us expected=112656.2us +- 563.3us, error 0.8%
(kms_flip:2202) DEBUG: inconsistent vblank ts/seq: last 83.763527/1252, current 83.875328/1262: elapsed=111802.0us expected=112656.2us
(kms_flip:2202) DEBUG: name = flip
last_ts = 83.774704
last_received_ts = 83.875427
last_seq = 1253
current_ts = 83.886513
current_received_ts = 83.986862
current_seq = 1263
count = 55
seq_step = 1
(kms_flip:2202) DEBUG: flip ts/seq: last 83.774704/1253, current 83.886513/1263: elapsed=111803.0us expected=112656.2us +- 563.3us, error 0.8%
(kms_flip:2202) DEBUG: inconsistent flip ts/seq: last 83.774704/1253, current 83.886513/1263: elapsed=111803.0us expected=112656.2us
(kms_flip:2202) DEBUG: name = vblank
last_ts = 83.875328
last_received_ts = 83.875374
last_seq = 1262
current_ts = 83.987129
current_received_ts = 83.986824
current_seq = 1272
count = 55
seq_step = 10
(kms_flip:2202) DEBUG: vblank ts/seq: last 83.875328/1262, current 83.987129/1272: elapsed=111804.0us expected=112656.2us +- 563.3us, error 0.8%
(kms_flip:2202) DEBUG: inconsistent vblank ts/seq: last 83.875328/1262, current 83.987129/1272: elapsed=111804.0us expected=112656.2us
(kms_flip:2202) DEBUG: name = flip
last_ts = 83.886513
last_received_ts = 83.986862
last_seq = 1263
current_ts = 83.998306
current_received_ts = 84.098785
current_seq = 1273
count = 56
seq_step = 1
(kms_flip:2202) DEBUG: flip ts/seq: last 83.886513/1263, current 83.998306/1273: elapsed=111800.0us expected=112656.2us +- 563.3us, error 0.8%
(kms_flip:2202) DEBUG: inconsistent flip ts/seq: last 83.886513/1263, current 83.998306/1273: elapsed=111800.0us expected=112656.2us
(kms_flip:2202) DEBUG: name = vblank
last_ts = 83.987129
last_received_ts = 83.986824
last_seq = 1272
current_ts = 84.098938
current_received_ts = 84.098694
current_seq = 1282
count = 56
seq_step = 10
(kms_flip:2202) DEBUG: vblank ts/seq: last 83.987129/1272, current 84.098938/1282: elapsed=111805.0us expected=112656.2us +- 563.3us, error 0.8%
(kms_flip:2202) DEBUG: inconsistent vblank ts/seq: last 83.987129/1272, current 84.098938/1282: elapsed=111805.0us expected=112656.2us
(kms_flip:2202) DEBUG: name = flip
last_ts = 83.998306
last_received_ts = 84.098785
last_seq = 1273
current_ts = 84.110115
current_received_ts = 84.210861
current_seq = 1283
count = 57
seq_step = 1
(kms_flip:2202) DEBUG: flip ts/seq: last 83.998306/1273, current 84.110115/1283: elapsed=111809.0us expected=112656.2us +- 563.3us, error 0.8%
(kms_flip:2202) DEBUG: inconsistent flip ts/seq: last 83.998306/1273, current 84.110115/1283: elapsed=111809.0us expected=112656.2us
(kms_flip:2202) DEBUG: name = vblank
last_ts = 84.098938
last_received_ts = 84.098694
last_seq = 1282
current_ts = 84.210739
current_received_ts = 84.210808
current_seq = 1292
count = 57
seq_step = 10
(kms_flip:2202) DEBUG: vblank ts/seq: last 84.098938/1282, current 84.210739/1292: elapsed=111801.0us expected=112656.2us +- 563.3us, error 0.8%
(kms_flip:2202) DEBUG: inconsistent vblank ts/seq: last 84.098938/1282, current 84.210739/1292: elapsed=111801.0us expected=112656.2us
(kms_flip:2202) DEBUG: name = flip
last_ts = 84.110115
last_received_ts = 84.210861
last_seq = 1283
current_ts = 84.221916
current_received_ts = 84.322639
current_seq = 1293
count = 58
seq_step = 1
(kms_flip:2202) DEBUG: flip ts/seq: last 84.110115/1283, current 84.221916/1293: elapsed=111798.0us expected=112656.2us +- 563.3us, error 0.8%
(kms_flip:2202) DEBUG: inconsistent flip ts/seq: last 84.110115/1283, current 84.221916/1293: elapsed=111798.0us expected=112656.2us
(kms_flip:2202) DEBUG: name = vblank
last_ts = 84.210739
last_received_ts = 84.210808
last_seq = 1292
current_ts = 84.322517
current_received_ts = 84.322578
current_seq = 1302
count = 58
seq_step = 10
(kms_flip:2202) DEBUG: vblank ts/seq: last 84.210739/1292, current 84.322517/1302: elapsed=111779.0us expected=112656.2us +- 563.3us, error 0.8%
(kms_flip:2202) DEBUG: inconsistent vblank ts/seq: last 84.210739/1292, current 84.322517/1302: elapsed=111779.0us expected=112656.2us
(kms_flip:2202) DEBUG: name = flip
last_ts = 84.221916
last_received_ts = 84.322639
last_seq = 1293
current_ts = 84.333687
current_received_ts = 84.434418
current_seq = 1303
count = 59
seq_step = 1
(kms_flip:2202) DEBUG: flip ts/seq: last 84.221916/1293, current 84.333687/1303: elapsed=111771.0us expected=112656.2us +- 563.3us, error 0.8%
(kms_flip:2202) DEBUG: inconsistent flip ts/seq: last 84.221916/1293, current 84.333687/1303: elapsed=111771.0us expected=112656.2us
(kms_flip:2202) DEBUG: name = vblank
last_ts = 84.322517
last_received_ts = 84.322578
last_seq = 1302
current_ts = 84.434235
current_received_ts = 84.434334
current_seq = 1312
count = 59
seq_step = 10
(kms_flip:2202) DEBUG: vblank ts/seq: last 84.322517/1302, current 84.434235/1312: elapsed=111719.0us expected=112656.2us +- 563.3us, error 0.8%
(kms_flip:2202) DEBUG: inconsistent vblank ts/seq: last 84.322517/1302, current 84.434235/1312: elapsed=111719.0us expected=112656.2us
(kms_flip:2202) DEBUG: name = flip
last_ts = 84.333687
last_received_ts = 84.434418
last_seq = 1303
current_ts = 84.445404
current_received_ts = 84.546104
current_seq = 1313
count = 60
seq_step = 1
(kms_flip:2202) DEBUG: flip ts/seq: last 84.333687/1303, current 84.445404/1313: elapsed=111720.0us expected=112656.2us +- 563.3us, error 0.8%
(kms_flip:2202) DEBUG: inconsistent flip ts/seq: last 84.333687/1303, current 84.445404/1313: elapsed=111720.0us expected=112656.2us
(kms_flip:2202) DEBUG: name = vblank
last_ts = 84.434235
last_received_ts = 84.434334
last_seq = 1312
current_ts = 84.545952
current_received_ts = 84.546059
current_seq = 1322
count = 60
seq_step = 10
(kms_flip:2202) DEBUG: vblank ts/seq: last 84.434235/1312, current 84.545952/1322: elapsed=111715.0us expected=112656.2us +- 563.3us, error 0.8%
(kms_flip:2202) DEBUG: inconsistent vblank ts/seq: last 84.434235/1312, current 84.545952/1322: elapsed=111715.0us expected=112656.2us
(kms_flip:2202) DEBUG: name = flip
last_ts = 84.445404
last_received_ts = 84.546104
last_seq = 1313
current_ts = 84.557121
current_received_ts = 84.657776
current_seq = 1323
count = 61
seq_step = 1
(kms_flip:2202) DEBUG: flip ts/seq: last 84.445404/1313, current 84.557121/1323: elapsed=111715.0us expected=112656.2us +- 563.3us, error 0.8%
(kms_flip:2202) DEBUG: inconsistent flip ts/seq: last 84.445404/1313, current 84.557121/1323: elapsed=111715.0us expected=112656.2us
(kms_flip:2202) DEBUG: name = vblank
last_ts = 84.545952
last_received_ts = 84.546059
last_seq = 1322
current_ts = 84.657669
current_received_ts = 84.657722
current_seq = 1332
count = 61
seq_step = 10
(kms_flip:2202) DEBUG: vblank ts/seq: last 84.545952/1322, current 84.657669/1332: elapsed=111721.0us expected=112656.2us +- 563.3us, error 0.8%
(kms_flip:2202) DEBUG: inconsistent vblank ts/seq: last 84.545952/1322, current 84.657669/1332: elapsed=111721.0us expected=112656.2us
(kms_flip:2202) DEBUG: name = flip
last_ts = 84.557121
last_received_ts = 84.657776
last_seq = 1323
current_ts = 84.668839
current_received_ts = 84.769592
current_seq = 1333
count = 62
seq_step = 1
(kms_flip:2202) DEBUG: flip ts/seq: last 84.557121/1323, current 84.668839/1333: elapsed=111715.0us expected=112656.2us +- 563.3us, error 0.8%
(kms_flip:2202) DEBUG: inconsistent flip ts/seq: last 84.557121/1323, current 84.668839/1333: elapsed=111715.0us expected=112656.2us
(kms_flip:2202) DEBUG: name = vblank
last_ts = 84.657669
last_received_ts = 84.657722
last_seq = 1332
current_ts = 84.769386
current_received_ts = 84.769508
current_seq = 1342
count = 62
seq_step = 10
(kms_flip:2202) DEBUG: vblank ts/seq: last 84.657669/1332, current 84.769386/1342: elapsed=111714.0us expected=112656.2us +- 563.3us, error 0.8%
(kms_flip:2202) DEBUG: inconsistent vblank ts/seq: last 84.657669/1332, current 84.769386/1342: elapsed=111714.0us expected=112656.2us
(kms_flip:2202) DEBUG: name = flip
last_ts = 84.668839
last_received_ts = 84.769592
last_seq = 1333
current_ts = 84.780556
current_received_ts = 84.881264
current_seq = 1343
count = 63
seq_step = 1
(kms_flip:2202) DEBUG: flip ts/seq: last 84.668839/1333, current 84.780556/1343: elapsed=111721.0us expected=112656.2us +- 563.3us, error 0.8%
(kms_flip:2202) DEBUG: inconsistent flip ts/seq: last 84.668839/1333, current 84.780556/1343: elapsed=111721.0us expected=112656.2us
(kms_flip:2202) DEBUG: name = vblank
last_ts = 84.769386
last_received_ts = 84.769508
last_seq = 1342
current_ts = 84.881104
current_received_ts = 84.881195
current_seq = 1352
count = 63
seq_step = 10
(kms_flip:2202) DEBUG: vblank ts/seq: last 84.769386/1342, current 84.881104/1352: elapsed=111721.0us expected=112656.2us +- 563.3us, error 0.8%
(kms_flip:2202) DEBUG: inconsistent vblank ts/seq: last 84.769386/1342, current 84.881104/1352: elapsed=111721.0us expected=112656.2us
(kms_flip:2202) DEBUG: name = flip
last_ts = 84.780556
last_received_ts = 84.881264
last_seq = 1343
current_ts = 84.892273
current_received_ts = 84.992912
current_seq = 1353
count = 64
seq_step = 1
(kms_flip:2202) DEBUG: flip ts/seq: last 84.780556/1343, current 84.892273/1353: elapsed=111715.0us expected=112656.2us +- 563.3us, error 0.8%
(kms_flip:2202) DEBUG: inconsistent flip ts/seq: last 84.780556/1343, current 84.892273/1353: elapsed=111715.0us expected=112656.2us
(kms_flip:2202) DEBUG: name = vblank
last_ts = 84.881104
last_received_ts = 84.881195
last_seq = 1352
current_ts = 84.992821
current_received_ts = 84.992867
current_seq = 1362
count = 64
seq_step = 10
(kms_flip:2202) DEBUG: vblank ts/seq: last 84.881104/1352, current 84.992821/1362: elapsed=111712.0us expected=112656.2us +- 563.3us, error 0.8%
(kms_flip:2202) DEBUG: inconsistent vblank ts/seq: last 84.881104/1352, current 84.992821/1362: elapsed=111712.0us expected=112656.2us
(kms_flip:2202) DEBUG: name = flip
last_ts = 84.892273
last_received_ts = 84.992912
last_seq = 1353
current_ts = 85.003990
current_received_ts = 85.104652
current_seq = 1363
count = 65
seq_step = 1
(kms_flip:2202) DEBUG: flip ts/seq: last 84.892273/1353, current 85.003990/1363: elapsed=111718.0us expected=112656.2us +- 563.3us, error 0.8%
(kms_flip:2202) DEBUG: inconsistent flip ts/seq: last 84.892273/1353, current 85.003990/1363: elapsed=111718.0us expected=112656.2us
(kms_flip:2202) DEBUG: name = vblank
last_ts = 84.992821
last_received_ts = 84.992867
last_seq = 1362
current_ts = 85.104538
current_received_ts = 85.104576
current_seq = 1372
count = 65
seq_step = 10
(kms_flip:2202) DEBUG: vblank ts/seq: last 84.992821/1362, current 85.104538/1372: elapsed=111721.0us expected=112656.2us +- 563.3us, error 0.8%
(kms_flip:2202) DEBUG: inconsistent vblank ts/seq: last 84.992821/1362, current 85.104538/1372: elapsed=111721.0us expected=112656.2us
(kms_flip:2202) DEBUG: name = flip
last_ts = 85.003990
last_received_ts = 85.104652
last_seq = 1363
current_ts = 85.115707
current_received_ts = 85.216362
current_seq = 1373
count = 66
seq_step = 1
(kms_flip:2202) DEBUG: flip ts/seq: last 85.003990/1363, current 85.115707/1373: elapsed=111713.0us expected=112656.2us +- 563.3us, error 0.8%
(kms_flip:2202) DEBUG: inconsistent flip ts/seq: last 85.003990/1363, current 85.115707/1373: elapsed=111713.0us expected=112656.2us
(kms_flip:2202) DEBUG: name = vblank
last_ts = 85.104538
last_received_ts = 85.104576
last_seq = 1372
current_ts = 85.216255
current_received_ts = 85.216316
current_seq = 1382
count = 66
seq_step = 10
(kms_flip:2202) DEBUG: vblank ts/seq: last 85.104538/1372, current 85.216255/1382: elapsed=111715.0us expected=112656.2us +- 563.3us, error 0.8%
(kms_flip:2202) DEBUG: inconsistent vblank ts/seq: last 85.104538/1372, current 85.216255/1382: elapsed=111715.0us expected=112656.2us
(kms_flip:2202) INFO: Event flip: expected 666, counted 670, passrate = 49.25%, encoder type 2
(kms_flip:2202) DEBUG: dropped frames, expected 666, counted 670, passrate = 49.25%, encoder type 2
(kms_flip:2202) INFO: Event vblank: expected 666, counted 670, passrate = 47.76%, encoder type 2
(kms_flip:2202) DEBUG: dropped frames, expected 666, counted 670, passrate = 47.76%, encoder type 2
(kms_flip:2202) CRITICAL: Test assertion failure function __run_test_on_crtc_set, file ../tests/kms_flip.c:1709:
(kms_flip:2202) CRITICAL: Failed assertion: !retried
(kms_flip:2202) igt_core-INFO: Stack trace:
(kms_flip:2202) igt_core-INFO:   #0 ../lib/igt_core.c:2075 __igt_fail_assert()
(kms_flip:2202) igt_core-INFO:   #1 ../tests/kms_flip.c:428 run_test_on_crtc_set.constprop.0()
(kms_flip:2202) igt_core-INFO:   #2 ../tests/kms_flip.c:1889 run_test()
(kms_flip:2202) igt_core-INFO:   #3 ../tests/kms_flip.c:2122 __igt_unique____real_main2045()
(kms_flip:2202) igt_core-INFO:   #4 ../tests/kms_flip.c:2045 main()
(kms_flip:2202) igt_core-INFO:   #5 [__libc_init_first+0x8a]
(kms_flip:2202) igt_core-INFO:   #6 [__libc_start_main+0x8b]
(kms_flip:2202) igt_core-INFO:   #7 [_start+0x25]
****  END  ****
Dynamic subtest B-eDP1: FAIL (20.772s)
Dmesg
<6> [64.589967] [IGT] kms_flip: starting dynamic subtest B-eDP1
<7> [64.590486] i915 0000:00:02.0: [drm:intel_dpt_create [i915]] Allocating dpt from smem
<7> [64.590813] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:321]
<7> [64.590905] i915 0000:00:02.0: [drm:intel_dpt_create [i915]] Allocating dpt from smem
<7> [64.591191] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:322]
<7> [64.593978] [drm:eb_validate_vma [i915]] EINVAL at eb_validate_vma:509
<7> [64.594444] [drm:eb_validate_vma [i915]] EINVAL at eb_validate_vma:509
<7> [64.611727] [drm:eb_validate_vma [i915]] EINVAL at eb_validate_vma:509
<7> [64.611984] [drm:eb_validate_vma [i915]] EINVAL at eb_validate_vma:509
<7> [64.619930] [drm:eb_validate_vma [i915]] EINVAL at eb_validate_vma:509
<7> [64.620243] [drm:eb_validate_vma [i915]] EINVAL at eb_validate_vma:509
<7> [64.637330] [drm:eb_validate_vma [i915]] EINVAL at eb_validate_vma:509
<7> [64.637583] [drm:eb_validate_vma [i915]] EINVAL at eb_validate_vma:509
<7> [64.663258] i915 0000:00:02.0: [drm:drm_mode_setcrtc] [CRTC:88:pipe A]
<7> [64.663340] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:88:pipe A] fastset requirement not met in hw.enable (expected yes, found no)
<7> [64.663486] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:88:pipe A] fastset requirement not met in hw.active (expected yes, found no)
<7> [64.663623] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:88:pipe A] fastset requirement not met in cpu_transcoder (expected 0, found -1)
<7> [64.663757] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:88:pipe A] fastset requirement not met in lane_count (expected 4, found 0)
<7> [64.663895] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:88:pipe A] fastset requirement not met in dp_m_n (expected tu 64 data 7483046/8388608 link 498869/524288, found tu 0, data 0/0 link 0/0)
<7> [64.664037] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:88:pipe A] fastset requirement not met in output_types (expected 0x00000100, found 0x00000000)
<7> [64.664205] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:88:pipe A] fastset requirement not met in framestart_delay (expected 1, found 0)
<7> [64.664392] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:88:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hdisplay (expected 2880, found 0)
<7> [64.664573] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:88:pipe A] fastset requirement not met in hw.pipe_mode.crtc_htotal (expected 3040, found 0)
<7> [64.664734] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:88:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hblank_start (expected 2880, found 0)
<7> [64.664864] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:88:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hblank_end (expected 3040, found 0)
<7> [64.664994] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:88:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hsync_start (expected 2928, found 0)
<7> [64.665147] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:88:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hsync_end (expected 2960, found 0)
<7> [64.665276] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:88:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vdisplay (expected 1800, found 0)
<7> [64.665403] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:88:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vblank_start (expected 1801, found 0)
<7> [64.665531] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:88:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vsync_start (expected 1803, found 0)
<7> [64.665657] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:88:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vsync_end (expected 1809, found 0)
<7> [64.665782] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:88:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vtotal (expected 1878, found 0)
<7> [64.665908] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:88:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vblank_end (expected 1878, found 0)
<7> [64.666036] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:88:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hdisplay (expected 2880, found 0)
<7> [64.666185] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:88:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_htotal (expected 3040, found 0)
<7> [64.666312] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:88:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hblank_start (expected 2880, found 0)
<7> [64.666441] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:88:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hblank_end (expected 3040, found 0)
<7> [64.666567] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:88:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hsync_start (expected 2928, found 0)
<7> [64.666696] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:88:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hsync_end (expected 2960, found 0)
<7> [64.666824] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:88:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vdisplay (expected 1800, found 0)
<7> [64.666951] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:88:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vblank_start (expected 1801, found 0)
<7> [64.667077] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:88:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vsync_start (expected 1803, found 0)
<7> [64.667214] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:88:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vsync_end (expected 1809, found 0)
<7> [64.667350] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:88:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vtotal (expected 1878, found 0)
<7> [64.667476] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:88:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vblank_end (expected 1878, found 0)
<7> [64.667604] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:88:pipe A] fastset requirement not met in pixel_multiplier (expected 1, found 0)
<7> [64.667731] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:88:pipe A] fastset requirement not met in hw.adjusted_mode.flags (2) (expected 2, found 0)
<7> [64.667856] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:88:pipe A] fastset requirement not met in hw.adjusted_mode.flags (8) (expected 8, found 0)
<7> [64.667983] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:88:pipe A] fastset requirement not met in enhanced_framing (expected yes, found no)
<7> [64.668115] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:88:pipe A] fastset requirement not met in pipe_bpp (expected 30, found 0)
<7> [64.668240] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:88:pipe A] fastset requirement not met in hw.pipe_mode.crtc_clock (expected 513820, found 0)
<7> [64.668366] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:88:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_clock (expected 513820, found 0)
<7> [64.668492] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:88:pipe A] fastset requirement not met in port_clock (expected 540000, found 0)
<7> [64.668620] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:88:pipe A] fastset requirement not met in set_context_latency (expected 1, found 0)
<7> [64.668743] i915 0000:00:02.0: [drm:intel_atomic_check [i915]] [CRTC:88:pipe A] fastset requirement not met, forcing full modeset
<7> [64.668900] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] Enabled dbuf slices 0xf -> 0x1 (total dbuf slices 0xf), mbus joined? yes->no
<7> [64.669026] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] [CRTC:88:pipe A] dbuf slices 0xf -> 0x0, ddb (0 - 4096) -> (0 - 0), active pipes 0x1 -> 0x0
<7> [64.669179] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] [PLANE:83:cursor A] ddb (4001 - 4096) -> ( 0 - 0), size 95 -> 0
<7> [64.669324] i915 0000:00:02.0: [drm:intel_cdclk_atomic_check [i915]] [CRTC:88:pipe A] min cdclk: 256910 kHz -> 0 kHz
<7> [64.669459] i915 0000:00:02.0: [drm:intel_cdclk_atomic_check [i915]] Can change cdclk via squashing
<7> [64.669590] i915 0000:00:02.0: [drm:intel_cdclk_atomic_check [i915]] New cdclk calculated to be logical 172800 kHz, actual 172800 kHz
<7> [64.669721] i915 0000:00:02.0: [drm:intel_cdclk_atomic_check [i915]] New voltage level calculated to be logical 0, actual 0
<7> [64.669880] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [CRTC:88:pipe A] enable: no [modeset]
<7> [64.670012] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:33:plane 1A] fb: [NOFB], visible: no
<7> [64.670169] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:43:plane 2A] fb: [NOFB], visible: no
<7> [64.670298] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:53:plane 3A] fb: [NOFB], visible: no
<7> [64.670427] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:63:plane 4A] fb: [NOFB], visible: no
<7> [64.670557] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:73:plane 5A] fb: [NOFB], visible: no
<7> [64.670687] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:83:cursor A] fb: [NOFB], visible: no
<7> [64.670969] i915 0000:00:02.0: [drm:intel_edp_backlight_off [i915]]
<7> [64.878525] i915 0000:00:02.0: [drm:intel_backlight_set_pwm_level [i915]] [CONNECTOR:262:eDP-1] set backlight PWM = 0
<7> [64.879419] i915 0000:00:02.0: [drm:intel_disable_transcoder [i915]] disabling pipe A
<7> [64.889732] i915 0000:00:02.0: [drm:intel_pps_off_unlocked [i915]] [ENCODER:261:DDI A/PHY A] PPS 0 turn panel power off
<7> [64.889990] i915 0000:00:02.0: [drm:icp_irq_handler [i915]] hotplug event received, stat 0x00010000, dig 0x00000089, pins 0x00000010, long 0x00000000
<7> [64.890301] i915 0000:00:02.0: [drm:intel_pps_off_unlocked [i915]] [ENCODER:261:DDI A/PHY A] PPS 0 wait for panel power off time
<7> [64.890547] i915 0000:00:02.0: [drm:intel_hpd_irq_handler [i915]] digital hpd on [ENCODER:261:DDI A/PHY A] - short
<7> [64.890854] i915 0000:00:02.0: [drm:wait_panel_status [i915]] [ENCODER:261:DDI A/PHY A] PPS 0 mask: 0xb0000000 value: 0x00000000 PP_STATUS: 0xa0000002 PP_CONTROL: 0x00000060
<7> [64.941517] i915 0000:00:02.0: [drm:wait_panel_status [i915]] Wait complete
<7> [64.942239] i915 0000:00:02.0: [drm:intel_dp_hpd_pulse [i915]] ignoring short hpd on eDP [ENCODER:261:DDI A/PHY A]
<7> [64.942236] i915 0000:00:02.0: [drm:intel_power_well_disable [i915]] disabling AUX_A
<7> [64.942865] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:261:DDI A/PHY A]
<7> [64.942843] i915 0000:00:02.0: [drm:icp_irq_handler [i915]] hotplug event received, stat 0x00010000, dig 0x0000008a, pins 0x00000010, long 0x00000010
<7> [64.943383] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:270:DDI B/PHY B]
<7> [64.943384] i915 0000:00:02.0: [drm:intel_hpd_irq_handler [i915]] digital hpd on [ENCODER:261:DDI A/PHY A] - long
<7> [64.943833] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:272:DP-MST A]
<7> [64.943905] i915 0000:00:02.0: [drm:intel_hpd_irq_handler [i915]] Received HPD interrupt on PIN 4 - cnt: 10
<7> [64.944302] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:273:DP-MST B]
<7> [64.944515] i915 0000:00:02.0: [drm:intel_dp_hpd_pulse [i915]] ignoring long hpd on eDP [ENCODER:261:DDI A/PHY A]
<7> [64.944739] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:274:DP-MST C]
<7> [64.945031] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:275:DP-MST D]
<7> [64.945335] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:288:DDI TC1/PHY TC1]
<7> [64.945619] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:290:DP-MST A]
<7> [64.945896] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:291:DP-MST B]
<7> [64.946095] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:292:DP-MST C]
<7> [64.946364] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:293:DP-MST D]
<7> [64.946644] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:297:DDI TC2/PHY TC2]
<7> [64.946885] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:301:DDI TC3/PHY TC3]
<7> [64.947147] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:303:DP-MST A]
<7> [64.947368] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:304:DP-MST B]
<7> [64.947561] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:305:DP-MST C]
<7> [64.947726] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:306:DP-MST D]
<7> [64.947865] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:310:DDI TC4/PHY TC4]
<7> [64.947984] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:312:DP-MST A]
<7> [64.948103] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:313:DP-MST B]
<7> [64.948236] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:314:DP-MST C]
<7> [64.948366] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:315:DP-MST D]
<7> [64.948507] i915 0000:00:02.0: [drm:verify_connector_state [i915]] [CONNECTOR:262:eDP-1]
<7> [64.948680] i915 0000:00:02.0: [drm:intel_dbuf_mdclk_cdclk_ratio_update [i915]] Updating dbuf ratio to 2 (mbus joined: no)
<7> [64.948829] i915 0000:00:02.0: [drm:intel_dbuf_mbus_join_update [i915]] Changing mbus joined: yes -> no (pipe: *)
<7> [64.948958] i915 0000:00:02.0: [drm:gen9_dbuf_slices_update [i915]] Updating dbuf slices to 0x1
<7> [64.949211] i915 0000:00:02.0: [drm:intel_power_well_disable [i915]] disabling PW_A
<7> [64.949467] i915 0000:00:02.0: [drm:intel_modeset_verify_crtc [i915]] [CRTC:88:pipe A]
<7> [64.949670] i915 0000:00:02.0: [drm:intel_set_cdclk [i915]] Post changing CDCLK to 172800 kHz, VCO 614400 kHz, ref 38400 kHz, bypass 19200 kHz, voltage level 0
<7> [64.949847] i915 0000:00:02.0: [drm:intel_audio_cdclk_change_post.part.0 [i915]] aud_ts_cdclk set to M=60, N=432
<7> [64.950221] i915 0000:00:02.0: [drm:drm_mode_setcrtc] [CRTC:145:pipe B]
<7> [64.950378] i915 0000:00:02.0: [drm:drm_mode_setcrtc] [CRTC:202:pipe C]
<7> [64.950459] i915 0000:00:02.0: [drm:drm_mode_setcrtc] [CRTC:259:pipe D]
<7> [64.950549] i915 0000:00:02.0: [drm:drm_mode_setcrtc] [CRTC:145:pipe B]
<7> [64.950578] i915 0000:00:02.0: [drm:drm_mode_setcrtc] [CONNECTOR:262:eDP-1]
<7> [64.950643] i915 0000:00:02.0: [drm:intel_atomic_check [i915]] [CONNECTOR:262:eDP-1] Limiting display bpp to 30 (EDID bpp 30, max requested bpp 36, max platform bpp 36)
<7> [64.950792] i915 0000:00:02.0: [drm:intel_dp_compute_config_limits [i915]] [ENCODER:261:DDI A/PHY A][CRTC:145:pipe B] DP link limits: pixel clock 513820 kHz DSC off max lanes 4 max rate 540000 max pipe_bpp 30 max link_bpp 30.0000
<7> [64.950914] i915 0000:00:02.0: [drm:intel_dp_compute_link_config [i915]] DP lane count 4 clock 540000 bpp input 30 compressed 0.0000 link rate required 1926825 available 2160000
<7> [64.951045] i915 0000:00:02.0: [drm:intel_atomic_check [i915]] [CRTC:145:pipe B] hw max bpp: 30, pipe bpp: 30, dithering: 0
<7> [64.951202] i915 0000:00:02.0: [drm:intel_ddi_compute_config_late [i915]] [ENCODER:261:DDI A/PHY A] [CRTC:145:pipe B]
<7> [64.951330] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:145:pipe B] fastset requirement not met in hw.enable (expected no, found yes)
<7> [64.951463] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:145:pipe B] fastset requirement not met in hw.active (expected no, found yes)
<7> [64.951590] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:145:pipe B] fastset requirement not met in cpu_transcoder (expected -1, found 1)
<7> [64.951716] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:145:pipe B] fastset requirement not met in lane_count (expected 0, found 4)
<7> [64.951844] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:145:pipe B] fastset requirement not met in dp_m_n (expected tu 0 data 0/0 link 0/0, found tu 64, data 7483046/8388608 link 498869/524288)
<7> [64.951971] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:145:pipe B] fastset requirement not met in output_types (expected 0x00000000, found 0x00000100)
<7> [64.952099] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:145:pipe B] fastset requirement not met in framestart_delay (expected 0, found 1)
<7> [64.952247] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:145:pipe B] fastset requirement not met in hw.pipe_mode.crtc_hdisplay (expected 0, found 2880)
<7> [64.952374] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:145:pipe B] fastset requirement not met in hw.pipe_mode.crtc_htotal (expected 0, found 3040)
<7> [64.952498] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:145:pipe B] fastset requirement not met in hw.pipe_mode.crtc_hblank_start (expected 0, found 2880)
<7> [64.952623] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:145:pipe B] fastset requirement not met in hw.pipe_mode.crtc_hblank_end (expected 0, found 3040)
<7> [64.952748] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:145:pipe B] fastset requirement not met in hw.pipe_mode.crtc_hsync_start (expected 0, found 2928)
<7> [64.952874] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:145:pipe B] fastset requirement not met in hw.pipe_mode.crtc_hsync_end (expected 0, found 2960)
<7> [64.953000] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:145:pipe B] fastset requirement not met in hw.pipe_mode.crtc_vdisplay (expected 0, found 1800)
<7> [64.953145] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:145:pipe B] fastset requirement not met in hw.pipe_mode.crtc_vblank_start (expected 0, found 1801)
<7> [64.953295] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:145:pipe B] fastset requirement not met in hw.pipe_mode.crtc_vsync_start (expected 0, found 1803)
<7> [64.953508] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:145:pipe B] fastset requirement not met in hw.pipe_mode.crtc_vsync_end (expected 0, found 1809)
<7> [64.953635] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:145:pipe B] fastset requirement not met in hw.pipe_mode.crtc_vtotal (expected 0, found 1878)
<7> [64.953760] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:145:pipe B] fastset requirement not met in hw.pipe_mode.crtc_vblank_end (expected 0, found 1878)
<7> [64.953885] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:145:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_hdisplay (expected 0, found 2880)
<7> [64.954009] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:145:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_htotal (expected 0, found 3040)
<7> [64.954152] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:145:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_hblank_start (expected 0, found 2880)
<7> [64.954278] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:145:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_hblank_end (expected 0, found 3040)
<7> [64.954407] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:145:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_hsync_start (expected 0, found 2928)
<7> [64.954534] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:145:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_hsync_end (expected 0, found 2960)
<7> [64.954664] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:145:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_vdisplay (expected 0, found 1800)
<7> [64.954792] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:145:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_vblank_start (expected 0, found 1801)
<7> [64.954934] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:145:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_vsync_start (expected 0, found 1803)
<7> [64.955064] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:145:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_vsync_end (expected 0, found 1809)
<7> [64.955209] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:145:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_vtotal (expected 0, found 1878)
<7> [64.955338] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:145:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_vblank_end (expected 0, found 1878)
<7> [64.955476] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:145:pipe B] fastset requirement not met in pixel_multiplier (expected 0, found 1)
<7> [64.955603] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:145:pipe B] fastset requirement not met in hw.adjusted_mode.flags (2) (expected 0, found 2)
<7> [64.955730] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:145:pipe B] fastset requirement not met in hw.adjusted_mode.flags (8) (expected 0, found 8)
<7> [64.955856] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:145:pipe B] fastset requirement not met in enhanced_framing (expected no, found yes)
<7> [64.955981] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:145:pipe B] fastset requirement not met in dpll_hw_state.cx0pll C20
<7> [64.956106] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] expected:
<7> [64.956281] i915 0000:00:02.0: [drm:intel_cx0pll_dump_hw_state [i915]] c20pll_hw_state:
<7> [64.956434] i915 0000:00:02.0: [drm:intel_cx0pll_dump_hw_state [i915]] tx[0] = 0x0000, tx[1] = 0x0000, tx[2] = 0x0000
<7> [64.956558] i915 0000:00:02.0: [drm:intel_cx0pll_dump_hw_state [i915]] cmn[0] = 0x0000, cmn[1] = 0x0000, cmn[2] = 0x0000, cmn[3] = 0x0000
<7> [64.956679] i915 0000:00:02.0: [drm:intel_cx0pll_dump_hw_state [i915]] mplla[0] = 0x0000
<7> [64.956801] i915 0000:00:02.0: [drm:intel_cx0pll_dump_hw_state [i915]] mplla[1] = 0x0000
<7> [64.956923] i915 0000:00:02.0: [drm:intel_cx0pll_dump_hw_state [i915]] mplla[2] = 0x0000
<7> [64.957045] i915 0000:00:02.0: [drm:intel_cx0pll_dump_hw_state [i915]] mplla[3] = 0x0000
<7> [64.957188] i915 0000:00:02.0: [drm:intel_cx0pll_dump_hw_state [i915]] mplla[4] = 0x0000
<7> [64.957315] i915 0000:00:02.0: [drm:intel_cx0pll_dump_hw_state [i915]] mplla[5] = 0x0000
<7> [64.957441] i915 0000:00:02.0: [drm:intel_cx0pll_dump_hw_state [i915]] mplla[6] = 0x0000
<7> [64.957566] i915 0000:00:02.0: [drm:intel_cx0pll_dump_hw_state [i915]] mplla[7] = 0x0000
<7> [64.957690] i915 0000:00:02.0: [drm:intel_cx0pll_dump_hw_state [i915]] mplla[8] = 0x0000
<7> [64.957824] i915 0000:00:02.0: [drm:intel_cx0pll_dump_hw_state [i915]] mplla[9] = 0x0000
<7> [64.957950] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] found:
<7> [64.958088] i915 0000:00:02.0: [drm:intel_cx0pll_dump_hw_state [i915]] c10pll_hw_state: fracen: yes,
<7> [64.958228] i915 0000:00:02.0: [drm:intel_cx0pll_dump_hw_state [i915]] quot: 40960, rem: 0, den: 1,
<7> [64.958363] i915 0000:00:02.0: [drm:intel_cx0pll_dump_hw_state [i915]] multiplier: 140, tx_clk_div: 0.
<7> [64.958488] i915 0000:00:02.0: [drm:intel_cx0pll_dump_hw_state [i915]] c10pll_rawhw_state:
<7> [64.958613] i915 0000:00:02.0: [drm:intel_cx0pll_dump_hw_state [i915]] tx: 0x10, cmn: 0x21
<7> [64.958740] i915 0000:00:02.0: [drm:intel_cx0pll_dump_hw_state [i915]] pll[0] = 0xf4, pll[1] = 0x0, pll[2] = 0xf8, pll[3] = 0x0
<7> [64.958865] i915 0000:00:02.0: [drm:intel_cx0pll_dump_hw_state [i915]] pll[4] = 0x0, pll[5] = 0x0, pll[6] = 0x0, pll[7] = 0x0
<7> [64.959000] i915 0000:00:02.0: [drm:intel_cx0pll_dump_hw_state [i915]] pll[8] = 0x0, pll[9] = 0x1, pll[10] = 0x0, pll[11] = 0x0
<7> [64.959160] i915 0000:00:02.0: [drm:intel_cx0pll_dump_hw_state [i915]] pll[12] = 0xa0, pll[13] = 0x0, pll[14] = 0x0, pll[15] = 0x0
<7> [64.959289] i915 0000:00:02.0: [drm:intel_cx0pll_dump_hw_state [i915]] pll[16] = 0x84, pll[17] = 0x4f, pll[18] = 0xe5, pll[19] = 0x23
<7> [64.959414] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:145:pipe B] fastset requirement not met in pipe_bpp (expected 0, found 30)
<7> [64.959549] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:145:pipe B] fastset requirement not met in hw.pipe_mode.crtc_clock (expected 0, found 513820)
<7> [64.959682] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:145:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_clock (expected 0, found 513820)
<7> [64.959816] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:145:pipe B] fastset requirement not met in port_clock (expected 0, found 540000)
<7> [64.959950] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:145:pipe B] fastset requirement not met in set_context_latency (expected 0, found 1)
<7> [64.960083] i915 0000:00:02.0: [drm:intel_atomic_check [i915]] [CRTC:145:pipe B] fastset requirement not met, forcing full modeset
<7> [64.960283] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] Enabled dbuf slices 0x1 -> 0xf (total dbuf slices 0xf), mbus joined? no->yes
<7> [64.960508] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] [CRTC:145:pipe B] dbuf slices 0x0 -> 0xf, ddb (0 - 0) -> (0 - 4096), active pipes 0x0 -> 0x2
<7> [64.960658] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] [PLANE:90:plane 1B] ddb ( 0 - 0) -> ( 0 - 4001), size 0 -> 4001
<7> [64.960782] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] [PLANE:140:cursor B] ddb ( 0 - 0) -> (4001 - 4096), size 0 -> 95
<7> [64.960908] i915 0000:00:02.0: [drm:skl_print_plane_changes [i915]] [PLANE:90: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> [64.961034] i915 0000:00:02.0: [drm:skl_print_plane_changes [i915]] [PLANE:90:plane 1B] lines 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0 -> 4, 16, 16, 19, 19, 28, 0, 0, 0, 4, 0
<7> [64.961208] i915 0000:00:02.0: [drm:skl_print_plane_changes [i915]] [PLANE:90:plane 1B] blocks 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0 -> 92, 365, 365, 434, 434, 638, 0, 0, 197, 92, 197
<7> [64.961353] i915 0000:00:02.0: [drm:skl_print_plane_changes [i915]] [PLANE:90:plane 1B] min_ddb 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0 -> 183, 456, 456, 547, 547, 729, 0, 0, 198, 183, 198
<7> [64.961611] i915 0000:00:02.0: [drm:intel_bw_atomic_check [i915]] [CRTC:145:pipe B] data rate 2055280 num active planes 1
<7> [64.962231] i915 0000:00:02.0: [drm:intel_bw_atomic_check [i915]] QGV point 0: max bw 28913 required 2159 qgv_peak_bw: 51200
<7> [64.962418] i915 0000:00:02.0: [drm:intel_bw_atomic_check [i915]] QGV point 1: max bw 38000 required 2159 qgv_peak_bw: 51200
<7> [64.962549] i915 0000:00:02.0: [drm:intel_bw_atomic_check [i915]] QGV point 2: max bw 38000 required 2159 qgv_peak_bw: 51200
<7> [64.962679] i915 0000:00:02.0: [drm:intel_bw_atomic_check [i915]] QGV point 3: max bw 38000 required 2159 qgv_peak_bw: 51200
<7> [64.962810] i915 0000:00:02.0: [drm:intel_bw_atomic_check [i915]] Matching peaks QGV bw: 51200 for required data rate: 2159
<7> [64.962943] i915 0000:00:02.0: [drm:intel_cdclk_atomic_check [i915]] [CRTC:145:pipe B] min cdclk: 0 kHz -> 256910 kHz
<7> [64.963091] i915 0000:00:02.0: [drm:intel_cdclk_atomic_check [i915]] Can change cdclk via squashing
<7> [64.963234] i915 0000:00:02.0: [drm:intel_cdclk_atomic_check [i915]] New cdclk calculated to be logical 307200 kHz, actual 307200 kHz
<7> [64.963362] i915 0000:00:02.0: [drm:intel_cdclk_atomic_check [i915]] New voltage level calculated to be logical 0, actual 0
<7> [64.963519] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [CRTC:145:pipe B] enable: yes [modeset]
<7> [64.963648] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] active: yes, output_types: EDP (0x100), output format: RGB, sink format: RGB
<7> [64.963777] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] cpu_transcoder: B, pipe bpp: 30, dithering: 0
<7> [64.963907] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] MST master transcoder: <invalid>
<7> [64.964034] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] port sync: master transcoder: <invalid>, slave transcoder bitmask = 0x0
<7> [64.964185] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] joiner: no, pipes: 0x0
<7> [64.964353] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] splitter: disabled, link count 0, overlap 0
<7> [64.964527] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] dp m_n: lanes: 4; data_m: 7483046, data_n: 8388608, link_m: 498869, link_n: 524288, tu: 64
<7> [64.964657] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] dp m2_n2: lanes: 4; data_m: 0, data_n: 0, link_m: 0, link_n: 0, tu: 0
<7> [64.964785] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] fec: disabled, enhanced framing: enabled
<7> [64.964914] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] sdp split: disabled
<7> [64.965041] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] psr: enabled, selective update: enabled, panel replay: disabled, selective fetch: enabled
<7> [64.965199] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] minimum HBlank: 0
<7> [64.965327] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] audio: 0, infoframes: 0, infoframes enabled: 0x4
<7> [64.965452] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] DP SDP: VSC, revision 4, length 14
<7> [64.965579] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pixelformat: RGB
<7> [64.965706] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] colorimetry: sRGB
<7> [64.965831] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] bpc: 0
<7> [64.965960] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] dynamic range: VESA range
<7> [64.966091] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] content type: Not defined
<7> [64.966244] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] scanline offset: 1
<7> [64.966372] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] framestart delay: 1, MSA timing delay: 0, set context latency: 1
<7> [64.966500] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] vrr: no, fixed rr: yes, vmin: 1878, vmax: 1878, flipline: 1878, pipeline full: 0, guardband: 76 vsync start: 75, vsync end: 69
<7> [64.966629] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] vrr: vmin vblank: 1802, vmax vblank: 1802, vmin vtotal: 1878, vmax vtotal: 1878
<7> [64.966786] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] requested mode: "2880x1800": 90 513820 2880 2928 2960 3040 1800 1803 1809 1878 0x48 0xa
<7> [64.966960] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] adjusted mode: "2880x1800": 90 513820 2880 2928 2960 3040 1800 1803 1809 1878 0x48 0xa
<7> [64.967115] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] crtc timings: clock=513820, hd=2880 hb=2880-3040 hs=2928-2960 ht=3040, vd=1800 vb=1801-1878 vs=1803-1809 vt=1878, flags=0xa
<7> [64.967252] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pipe mode: "2880x1800": 90 513820 2880 2928 2960 3040 1800 1803 1809 1878 0x40 0xa
<7> [64.967381] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] crtc timings: clock=513820, hd=2880 hb=2880-3040 hs=2928-2960 ht=3040, vd=1800 vb=1801-1878 vs=1803-1809 vt=1878, flags=0xa
<7> [64.967513] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] port clock: 540000, pipe src: 2880x1800+0+0, pixel rate 513820, min cdclk 256910
<7> [64.967644] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] linetime: 48, ips linetime: 0
<7> [64.967772] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] num_scalers: 2, scaler_users: 0x0, scaler_id: -1, scaling_filter: 0
<7> [64.967903] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pch pfit: 0x0+0+0, disabled, force thru: no
<7> [64.968033] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] ips: 0, double wide: 0, drrs: 0
<7> [64.968175] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] dpll_hw_state: dpll: 0x83d60, dpll_md: 0xf42110, fp0: 0xf8, fp1: 0x1000000
<7> [64.968308] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] csc_mode: 0x0 gamma_mode: 0x0 gamma_enable: 0 csc_enable: 0
<7> [64.968438] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pre csc lut: 0 entries, post csc lut: 0 entries
<7> [64.968568] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] output csc: pre offsets: 0x0000 0x0000 0x0000
<7> [64.968699] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] output csc: coefficients: 0x0000 0x0000 0x0000
<7> [64.968829] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] output csc: coefficients: 0x0000 0x0000 0x0000
<7> [64.968958] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] output csc: coefficients: 0x0000 0x0000 0x0000
<7> [64.969116] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] output csc: post offsets: 0x0000 0x0000 0x0000
<7> [64.969265] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pipe csc: pre offsets: 0x0000 0x0000 0x0000
<7> [64.969168] i915 0000:00:02.0: [drm:intel_power_well_disable [i915]] disabling DC_off
<7> [64.969393] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pipe csc: coefficients: 0x0000 0x0000 0x0000
<7> [64.969521] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pipe csc: coefficients: 0x0000 0x0000 0x0000
<7> [64.969648] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pipe csc: coefficients: 0x0000 0x0000 0x0000
<7> [64.969775] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pipe csc: post offsets: 0x0000 0x0000 0x0000
<7> [64.969709] i915 0000:00:02.0: [drm:skl_enable_dc6 [i915]] Enabling DC6
<7> [64.969903] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] sharpness strength: 0, sharpness tap size: 0, sharpness enable: 0
<7> [64.970030] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:90:plane 1B] fb: [FB:321] 2880x1800 format = XR24 little-endian (0x34325258) modifier = 0x100000000000009, visible: yes
<7> [64.970184] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] rotation: 0x1, scaler: -1, scaling_filter: 0
<7> [64.970314] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] src: 2880.000000x1800.000000+0.000000+0.000000 dst: 2880x1800+0+0
<7> [64.970240] i915 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [i915]] Setting DC state from 00 to 02
<7> [64.970444] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:100:plane 2B] fb: [NOFB], visible: no
<7> [64.970571] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:110:plane 3B] fb: [NOFB], visible: no
<7> [64.970700] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:120:plane 4B] fb: [NOFB], visible: no
<7> [64.970830] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:130:plane 5B] fb: [NOFB], visible: no
<7> [64.970958] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:140:cursor B] fb: [NOFB], visible: no
<7> [64.973955] i915 0000:00:02.0: [drm:intel_power_well_enable [i915]] enabling DC_off
<7> [64.974313] i915 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [i915]] Setting DC state from 02 to 00
<7> [64.974514] i915 0000:00:02.0: [drm:intel_power_well_enable [i915]] enabling PW_2
<7> [64.974858] i915 0000:00:02.0: [drm:intel_power_well_enable [i915]] enabling PW_B
<7> [64.975068] i915 0000:00:02.0: [drm:intel_set_cdclk [i915]] Pre changing CDCLK to 307200 kHz, VCO 614400 kHz, ref 38400 kHz, bypass 19200 kHz, voltage level 0
<7> [64.975261] i915 0000:00:02.0: [drm:intel_audio_cdclk_change_post.part.0 [i915]] aud_ts_cdclk set to M=60, N=768
<7> [64.975394] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:261:DDI A/PHY A]
<7> [64.975525] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:270:DDI B/PHY B]
<7> [64.975654] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:272:DP-MST A]
<7> [64.975781] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:273:DP-MST B]
<7> [64.975905] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:274:DP-MST C]
<7> [64.976028] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:275:DP-MST D]
<7> [64.976177] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:288:DDI TC1/PHY TC1]
<7> [64.976306] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:290:DP-MST A]
<7> [64.976430] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:291:DP-MST B]
<7> [64.976554] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:292:DP-MST C]
<7> [64.976679] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:293:DP-MST D]
<7> [64.976802] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:297:DDI TC2/PHY TC2]
<7> [64.976925] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:301:DDI TC3/PHY TC3]
<7> [64.977049] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:303:DP-MST A]
<7> [64.977191] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:304:DP-MST B]
<7> [64.977316] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:305:DP-MST C]
<7> [64.977439] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:306:DP-MST D]
<7> [64.977561] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:310:DDI TC4/PHY TC4]
<7> [64.977684] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:312:DP-MST A]
<7> [64.977806] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:313:DP-MST B]
<7> [64.977927] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:314:DP-MST C]
<7> [64.978047] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:315:DP-MST D]
<7> [64.978196] i915 0000:00:02.0: [drm:gen9_dbuf_slices_update [i915]] Updating dbuf slices to 0xf
<7> [64.978418] i915 0000:00:02.0: [drm:intel_dbuf_mbus_join_update [i915]] Changing mbus joined: no -> yes (pipe: *)
<7> [64.978550] i915 0000:00:02.0: [drm:intel_dbuf_mdclk_cdclk_ratio_update [i915]] Updating dbuf ratio to 4 (mbus joined: yes)
<7> [64.978742] i915 0000:00:02.0: [drm:intel_power_well_enable [i915]] enabling AUX_A
<7> [64.980253] i915 0000:00:02.0: [drm:intel_pps_on_unlocked [i915]] [ENCODER:261:DDI A/PHY A] PPS 0 turn panel power on
<7> [64.980391] i915 0000:00:02.0: [drm:wait_panel_power_cycle [i915]] [ENCODER:261:DDI A/PHY A] PPS 0 wait for panel power cycle (462 ms remaining)
<7> [65.446769] i915 0000:00:02.0: [drm:wait_panel_status [i915]] [ENCODER:261:DDI A/PHY A] PPS 0 mask: 0xb800000f value: 0x00000000 PP_STATUS: 0x08000001 PP_CONTROL: 0x00000060
<7> [65.512884] i915 0000:00:02.0: [drm:wait_panel_status [i915]] Wait complete
<7> [65.513551] i915 0000:00:02.0: [drm:intel_pps_on_unlocked [i915]] [ENCODER:261:DDI A/PHY A] PPS 0 wait for panel power on
<7> [65.514205] i915 0000:00:02.0: [drm:wait_panel_status [i915]] [ENCODER:261:DDI A/PHY A] PPS 0 mask: 0xb000000f value: 0x80000008 PP_STATUS: 0x9000000a PP_CONTROL: 0x00000063
<7> [65.545438] i915 0000:00:02.0: [drm:icp_irq_handler [i915]] hotplug event received, stat 0x00010000, dig 0x0000008a, pins 0x00000010, long 0x00000010
<7> [65.546023] i915 0000:00:02.0: [drm:intel_hpd_irq_handler [i915]] digital hpd on [ENCODER:261:DDI A/PHY A] - long
<7> [65.546538] i915 0000:00:02.0: [drm:intel_hpd_irq_handler [i915]] Received HPD interrupt on PIN 4 - cnt: 20
<7> [65.547076] i915 0000:00:02.0: [drm:intel_dp_hpd_pulse [i915]] ignoring long hpd on eDP [ENCODER:261:DDI A/PHY A]
<7> [65.720894] i915 0000:00:02.0: [drm:wait_panel_status [i915]] Wait complete
<7> [65.724825] i915 0000:00:02.0: [drm:intel_pps_vdd_on_unlocked [i915]] [ENCODER:261:DDI A/PHY A] PPS 0 turning VDD on
<7> [65.725527] i915 0000:00:02.0: [drm:intel_pps_vdd_on_unlocked [i915]] [ENCODER:261:DDI A/PHY A] PPS 0 PP_STATUS: 0x80000008 PP_CONTROL: 0x0000006b
<7> [65.728840] i915 0000:00:02.0: [drm:drm_dp_read_dpcd_caps [drm_display_helper]] AUX A/DDI A/PHY A: DPCD: 14 14 c4 41 00 00 01 c0 02 00 00 00 00 0b 80
<7> [65.729990] i915 0000:00:02.0: [drm:intel_dp_start_link_train [i915]] [CONNECTOR:262:eDP-1][ENCODER:261:DDI A/PHY A][DPRX] Reloading eDP link rates
<7> [65.730862] i915 0000:00:02.0: [drm:intel_dp_start_link_train [i915]] [CONNECTOR:262:eDP-1][ENCODER:261:DDI A/PHY A][DPRX] Using LINK_RATE_SET value 07
<7> [65.733013] i915 0000:00:02.0: [drm:intel_dp_set_signal_levels [i915]] [CONNECTOR:262:eDP-1][ENCODER:261:DDI A/PHY A][DPRX] 8b/10b, lanes: 4, vswing levels: 0/0/0/0, pre-emphasis levels: 0/0/0/0
<7> [65.734089] i915 0000:00:02.0: [drm:intel_dp_program_link_training_pattern [i915]] [CONNECTOR:262:eDP-1][ENCODER:261:DDI A/PHY A][DPRX] Using DP training pattern TPS1
<7> [65.735102] i915 0000:00:02.0: [drm:intel_dp_link_train_phy [i915]] [CONNECTOR:262:eDP-1][ENCODER:261:DDI A/PHY A][DPRX] Clock recovery OK
<7> [65.735304] i915 0000:00:02.0: [drm:intel_dp_program_link_training_pattern [i915]] [CONNECTOR:262:eDP-1][ENCODER:261:DDI A/PHY A][DPRX] Using DP training pattern TPS3
<7> [65.736637] i915 0000:00:02.0: [drm:intel_dp_link_train_phy [i915]] [CONNECTOR:262:eDP-1][ENCODER:261:DDI A/PHY A][DPRX] Channel EQ done. DP Training successful
<7> [65.736756] i915 0000:00:02.0: [drm:intel_dp_link_train_phy [i915]] [CONNECTOR:262:eDP-1][ENCODER:261:DDI A/PHY A][DPRX] Link Training passed at link rate = 540000, lane count = 4
<7> [65.737347] i915 0000:00:02.0: [drm:intel_enable_transcoder [i915]] enabling pipe B
<7> [65.737628] i915 0000:00:02.0: [drm:intel_edp_backlight_on [i915]]
<7> [65.737750] i915 0000:00:02.0: [drm:intel_backlight_enable [i915]] pipe B
<7> [65.737923] i915 0000:00:02.0: [drm:intel_backlight_set_pwm_level [i915]] [CONNECTOR:262:eDP-1] set backlight PWM = 13892
<7> [65.748884] i915 0000:00:02.0: [drm:intel_psr_post_plane_update [i915]] Enabling PSR2
<7> [65.750502] i915 0000:00:02.0: [drm:verify_connector_state [i915]] [CONNECTOR:262:eDP-1]
<7> [65.750711] i915 0000:00:02.0: [drm:intel_modeset_verify_crtc [i915]] [CRTC:145:pipe B]
<7> [68.278419] i915 0000:00:02.0: [drm:intel_pps_vdd_off_sync_unlocked [i915]] [ENCODER:261:DDI A/PHY A] PPS 0 turning VDD off
<7> [68.279069] i915 0000:00:02.0: [drm:intel_pps_vdd_off_sync_unlocked [i915]] [ENCODER:261:DDI A/PHY A] PPS 0 PP_STATUS: 0x80000008 PP_CONTROL: 0x00000067
<7> [68.279690] i915 0000:00:02.0: [drm:intel_power_well_disable [i915]] disabling DC_off
<7> [68.280367] i915 0000:00:02.0: [drm:skl_enable_dc6 [i915]] Enabling DC6
<7> [68.280912] i915 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [i915]] Setting DC state from 00 to 02
<7> [68.282664] i915 0000:00:02.0: [drm:intel_power_well_enable [i915]] enabling DC_off
<7> [68.283006] i915 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [i915]] Setting DC state from 02 to 00
<7> [68.311202] i915 0000:00:02.0: [drm:intel_power_well_disable [i915]] disabling DC_off
<7> [68.311780] i915 0000:00:02.0: [drm:skl_enable_dc6 [i915]] Enabling DC6
<7> [68.312392] i915 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [i915]] Setting DC state from 00 to 02
<7> [68.394202] i915 0000:00:02.0: [drm:intel_power_well_enable [i915]] enabling DC_off
<7> [68.394738] i915 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [i915]] Setting DC state from 02 to 00
<7> [68.422183] i915 0000:00:02.0: [drm:intel_power_well_disable [i915]] disabling DC_off
<7> [68.422799] i915 0000:00:02.0: [drm:skl_enable_dc6 [i915]] Enabling DC6
<7> [68.423398] i915 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [i915]] Setting DC state from 00 to 02
<7> [68.504818] i915 0000:00:02.0: [drm:intel_power_well_enable [i915]] enabling DC_off
<7> [68.505075] i915 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [i915]] Setting DC state from 02 to 00
<7> [68.534215] i915 0000:00:02.0: [drm:intel_power_well_disable [i915]] disabling DC_off
<7> [68.534785] i915 0000:00:02.0: [drm:skl_enable_dc6 [i915]] Enabling DC6
<7> [68.535364] i915 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [i915]] Setting DC state from 00 to 02
<7> [68.616729] i915 0000:00:02.0: [drm:intel_power_well_enable [i915]] enabling DC_off
<7> [68.617456] i915 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [i915]] Setting DC state from 02 to 00
<7> [68.644253] i915 0000:00:02.0: [drm:intel_power_well_disable [i915]] disabling DC_off
<7> [68.645076] i915 0000:00:02.0: [drm:skl_enable_dc6 [i915]] Enabling DC6
<7> [68.645559] i915 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [i915]] Setting DC state from 00 to 02
<7> [68.727598] i915 0000:00:02.0: [drm:intel_power_well_enable [i915]] enabling DC_off
<7> [68.728513] i915 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [i915]] Setting DC state from 02 to 00
<7> [68.755170] i915 0000:00:02.0: [drm:intel_power_well_disable [i915]] disabling DC_off
<7> [68.755730] i915 0000:00:02.0: [drm:skl_enable_dc6 [i915]] Enabling DC6
<7> [68.756292] i915 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [i915]] Setting DC state from 00 to 02
<7> [68.837963] i915 0000:00:02.0: [drm:intel_power_well_enable [i915]] enabling DC_off
<7> [68.838142] i915 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [i915]] Setting DC state from 02 to 00
<7> [68.866203] i915 0000:00:02.0: [drm:intel_power_well_disable [i915]] disabling DC_off
<7> [68.866668] i915 0000:00:02.0: [drm:skl_enable_dc6 [i915]] Enabling DC6
<7> [68.867005] i915 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [i915]] Setting DC state from 00 to 02
<7> [68.949984] i915 0000:00:02.0: [drm:intel_power_well_enable [i915]] enabling DC_off
<7> [68.950714] i915 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [i915]] Setting DC state from 02 to 00
<7> [68.978200] i915 0000:00:02.0: [drm:intel_power_well_disable [i915]] disabling DC_off
<7> [68.978814] i915 0000:00:02.0: [drm:skl_enable_dc6 [i915]] Enabling DC6
<7> [68.979369] i915 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [i915]] Setting DC state from 00 to 02
<7> [69.060893] i915 0000:00:02.0: [drm:intel_power_well_enable [i915]] enabling DC_off
<7> [69.061513] i915 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [i915]] Setting DC state from 02 to 00
<7> [69.089187] i915 0000:00:02.0: [drm:intel_power_well_disable [i915]] disabling DC_off
<7> [69.089765] i915 0000:00:02.0: [drm:skl_enable_dc6 [i915]] Enabling DC6
<7> [69.090335] i915 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [i915]] Setting DC state from 00 to 02
<7> [69.171747] i915 0000:00:02.0: [drm:intel_power_well_enable [i915]] enabling DC_off
<7> [69.172422] i915 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [i915]] Setting DC state from 02 to 00
<7> [69.200201] i915 0000:00:02.0: [drm:intel_power_well_disable [i915]] disabling DC_off
<7> [69.200802] i915 0000:00:02.0: [drm:skl_enable_dc6 [i915]] Enabling DC6
<7> [69.201346] i915 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [i915]] Setting DC state from 00 to 02
<7> [69.283090] i915 0000:00:02.0: [drm:intel_power_well_enable [i915]] enabling DC_off
<7> [69.283835] i915 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [i915]] Setting DC state from 02 to 00
<7> [69.311187] i915 0000:00:02.0: [drm:intel_power_well_disable [i915]] disabling DC_off
<7> [69.311798] i915 0000:00:02.0: [drm:skl_enable_dc6 [i915]] Enabling DC6
<7> [69.312354] i915 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [i915]] Setting DC state from 00 to 02
<7> [69.394504] i915 0000:00:02.0: [drm:intel_power_well_enable [i915]] enabling DC_off
<7> [69.395245] i915 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [i915]] Setting DC state from 02 to 00
<7> [69.422177] i915 0000:00:02.0: [drm:intel_power_well_disable [i915]] disabling DC_off
<7> [69.422772] i915 0000:00:02.0: [drm:skl_enable_dc6 [i915]] Enabling DC6
<7> [69.423416] i915 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [i915]] Setting DC state from 00 to 02
<7> [69.505349] i915 0000:00:02.0: [drm:intel_power_well_enable [i915]] enabling DC_off
<7> [69.505972] i915 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [i915]] Setting DC state from 02 to 00
<7> [69.533207] i915 0000:00:02.0: [drm:intel_power_well_disable [i915]] disabling DC_off
<7> [69.533848] i915 0000:00:02.0: [drm:skl_enable_dc6 [i915]] Enabling DC6
<7> [69.534475] i915 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [i915]] Setting DC state from 00 to 02
<7> [69.616013] i915 0000:00:02.0: [drm:intel_power_well_enable [i915]] enabling DC_off
<7> [69.616613] i915 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [i915]] Setting DC state from 02 to 00
<7> [69.644209] i915 0000:00:02.0: [drm:intel_power_well_disable [i915]] disabling DC_off
<7> [69.644762] i915 0000:00:02.0: [drm:skl_enable_dc6 [i915]] Enabling DC6
<7> [69.645301] i915 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [i915]] Setting DC state from 00 to 02
<7> [69.727970] i915 0000:00:02.0: [drm:intel_power_well_enable [i915]] enabling DC_off
<7> [69.729163] i915 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [i915]] Setting DC state from 02 to 00
<7> [69.755208] i915 0000:00:02.0: [drm:intel_power_well_disable [i915]] disabling DC_off
<7> [69.755801] i915 0000:00:02.0: [drm:skl_enable_dc6 [i915]] Enabling DC6
<7> [69.756337] i915 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [i915]] Setting DC state from 00 to 02
<7> [69.838359] i915 0000:00:02.0: [drm:intel_power_well_enable [i915]] enabling DC_off
<7> [69.838880] i915 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [i915]] Setting DC state from 02 to 00
<7> [69.866206] i915 0000:00:02.0: [drm:intel_power_well_disable [i915]] disabling DC_off
<7> [69.866755] i915 0000:00:02.0: [drm:skl_enable_dc6 [i915]] Enabling DC6
<7> [69.867301] i915 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [i915]] Setting DC state from 00 to 02
<7> [69.949411] i915 0000:00:02.0: [drm:intel_power_well_enable [i915]] enabling DC_off
<7> [69.949921] i915 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [i915]] Setting DC state from 02 to 00
<7> [69.977223] i915 0000:00:02.0: [drm:intel_power_well_disable [i915]] disabling DC_off
<7> [69.977805] i915 0000:00:02.0: [drm:skl_enable_dc6 [i915]] Enabling DC6
<7> [69.978450] i915 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [i915]] Setting DC state from 00 to 02
<7> [70.060381] i915 0000:00:02.0: [drm:intel_power_well_enable [i915]] enabling DC_off
<7> [70.060891] i915 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [i915]] Setting DC state from 02 to 00
<7> [70.089273] i915 0000:00:02.0: [drm:intel_power_well_disable [i915]] disabling DC_off
<7> [70.089847] i915 0000:00:02.0: [drm:skl_enable_dc6 [i915]] Enabling DC6
<7> [70.090388] i915 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [i915]] Setting DC state from 00 to 02
<7> [70.171627] i915 0000:00:02.0: [drm:intel_power_well_enable [i915]] enabling DC_off
<7> [70.172196] i915 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [i915]] Setting DC state from 02 to 00
<7> [70.200289] i915 0000:00:02.0: [drm:intel_power_well_disable [i915]] disabling DC_off
<7> [70.200880] i915 0000:00:02.0: [drm:skl_enable_dc6 [i915]] Enabling DC6
<7> [70.201518] i915 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [i915]] Setting DC state from 00 to 02
<7> [70.283330] i915 0000:00:02.0: [drm:intel_power_well_enable [i915]] enabling DC_off
<7> [70.284412] i915 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [i915]] Setting DC state from 02 to 00
<7> [70.311205] i915 0000:00:02.0: [drm:intel_power_well_disable [i915]] disabling DC_off
<7> [70.311767] i915 0000:00:02.0: [drm:skl_enable_dc6 [i915]] Enabling DC6
<7> [70.312307] i915 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [i915]] Setting DC state from 00 to 02
<7> [70.394056] i915 0000:00:02.0: [drm:intel_power_well_enable [i915]] enabling DC_off
<7> [70.394661] i915 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [i915]] Setting DC state from 02 to 00
<7> [70.422235] i915 0000:00:02.0: [drm:intel_power_well_disable [i915]] disabling DC_off
<7> [70.422824] i915 0000:00:02.0: [drm:skl_enable_dc6 [i915]] Enabling DC6
<7> [70.423405] i915 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [i915]] Setting DC state from 00 to 02
<7> [70.505377] i915 0000:00:02.0: [drm:intel_power_well_enable [i915]] enabling DC_off
<7> [70.506000] i915 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [i915]] Setting DC state from 02 to 00
<7> [70.533185] i915 0000:00:02.0: [drm:intel_power_well_disable [i915]] disabling DC_off
<7> [70.533763] i915 0000:00:02.0: [drm:skl_enable_dc6 [i915]] Enabling DC6
<7> [70.534299] i915 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [i915]] Setting DC state from 00 to 02
<7> [70.616820] i915 0000:00:02.0: [drm:intel_power_well_enable [i915]] enabling DC_off
<7> [70.617608] i915 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [i915]] Setting DC state from 02 to 00
<7> [70.644191] i915 0000:00:02.0: [drm:intel_power_well_disable [i915]] disabling DC_off
<7> [70.644758] i915 0000:00:02.0: [drm:skl_enable_dc6 [i915]] Enabling DC6
<7> [70.645364] i915 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [i915]] Setting DC state from 00 to 02
<7> [70.727684] i915 0000:00:02.0: [drm:intel_power_well_enable [i915]] enabling DC_off
<7> [70.728342] i915 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [i915]] Setting DC state from 02 to 00
<7> [70.755175] i915 0000:00:02.0: [drm:intel_power_well_disable [i915]] disabling DC_off
<7> [70.755741] i915 0000:00:02.0: [drm:skl_enable_dc6 [i915]] Enabling DC6
<7> [70.756281] i915 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [i915]] Setting DC state from 00 to 02
<7> [70.838399] i915 0000:00:02.0: [drm:intel_power_well_enable [i915]] enabling DC_off
<7> [70.838700] i915 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [i915]] Setting DC state from 02 to 00
<7> [70.866522] i915 0000:00:02.0: [drm:intel_power_well_disable [i915]] disabling DC_off
<7> [70.866755] i915 0000:00:02.0: [drm:skl_enable_dc6 [i915]] Enabling DC6
<7> [70.866933] i915 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [i915]] Setting DC state from 00 to 02
<7> [70.949328] i915 0000:00:02.0: [drm:intel_power_well_enable [i915]] enabling DC_off
<7> [70.949551] i915 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [i915]] Setting DC state from 02 to 00
<7> [70.978136] i915 0000:00:02.0: [drm:intel_power_well_disable [i915]] disabling DC_off
<7> [70.978369] i915 0000:00:02.0: [drm:skl_enable_dc6 [i915]] Enabling DC6
<7> [70.978552] i915 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [i915]] Setting DC state from 00 to 02
<7> [71.060506] i915 0000:00:02.0: [drm:intel_power_well_enable [i915]] enabling DC_off
<7> [71.060735] i915 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [i915]] Setting DC state from 02 to 00
<7> [71.090159] i915 0000:00:02.0: [drm:intel_power_well_disable [i915]] disabling DC_off
<7> [71.090384] i915 0000:00:02.0: [drm:skl_enable_dc6 [i915]] Enabling DC6
<7> [71.090566] i915 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [i915]] Setting DC state from 00 to 02
<7> [71.171499] i915 0000:00:02.0: [drm:intel_power_well_enable [i915]] enabling DC_off
<7> [71.171699] i915 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [i915]] Setting DC state from 02 to 00
<7> [71.201143] i915 0000:00:02.0: [drm:intel_power_well_disable [i915]] disabling DC_off
<7> [71.201367] i915 0000:00:02.0: [drm:skl_enable_dc6 [i915]] Enabling DC6
<7> [71.201554] i915 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [i915]] Setting DC state from 00 to 02
<7> [71.282575] i915 0000:00:02.0: [drm:intel_power_well_enable [i915]] enabling DC_off
<7> [71.282899] i915 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [i915]] Setting DC state from 02 to 00
<7> [71.310865] i915 0000:00:02.0: [drm:intel_power_well_disable [i915]] disabling DC_off
<7> [71.311507] i915 0000:00:02.0: [drm:skl_enable_dc6 [i915]] Enabling DC6
<7> [71.312192] i915 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [i915]] Setting DC state from 00 to 02
<7> [71.393748] i915 0000:00:02.0: [drm:intel_power_well_enable [i915]] enabling DC_off
<7> [71.393958] i915 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [i915]] Setting DC state from 02 to 00
<7> [71.422421] i915 0000:00:02.0: [drm:intel_power_well_disable [i915]] disabling DC_off
<7> [71.423022] i915 0000:00:02.0: [drm:skl_enable_dc6 [i915]] Enabling DC6
<7> [71.423854] i915 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [i915]] Setting DC state from 00 to 02
<7> [71.505001] i915 0000:00:02.0: [drm:intel_power_well_enable [i915]] enabling DC_off
<7> [71.505321] i915 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [i915]] Setting DC state from 02 to 00
<7> [71.533988] i915 0000:00:02.0: [drm:intel_power_well_disable [i915]] disabling DC_off
<7> [71.534625] i915 0000:00:02.0: [drm:skl_enable_dc6 [i915]] Enabling DC6
<7> [71.535240] i915 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [i915]] Setting DC state from 00 to 02
<7> [71.616112] i915 0000:00:02.0: [drm:intel_power_well_enable [i915]] enabling DC_off
<7> [71.616332] i915 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [i915]] Setting DC state from 02 to 00
<7> [71.643574] i915 0000:00:02.0: [drm:intel_power_well_disable [i915]] disabling DC_off
<7> [71.644195] i915 0000:00:02.0: [drm:skl_enable_dc6 [i915]] Enabling DC6
<7> [71.644773] i915 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [i915]] Setting DC state from 00 to 02
<7> [71.727198] i915 0000:00:02.0: [drm:intel_power_well_enable [i915]] enabling DC_off
<7> [71.727480] i915 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [i915]] Setting DC state from 02 to 00
<7> [71.756114] i915 0000:00:02.0: [drm:intel_power_well_disable [i915]] disabling DC_off
<7> [71.756739] i915 0000:00:02.0: [drm:skl_enable_dc6 [i915]] Enabling DC6
<7> [71.757390] i915 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [i915]] Setting DC state from 00 to 02
<7> [71.838299] i915 0000:00:02.0: [drm:intel_power_well_enable [i915]] enabling DC_off
<7> [71.838671] i915 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [i915]] Setting DC state from 02 to 00
<7> [71.866693] i915 0000:00:02.0: [drm:intel_power_well_disable [i915]] disabling DC_off
<7> [71.867323] i915 0000:00:02.0: [drm:skl_enable_dc6 [i915]] Enabling DC6
<7> [71.867999] i915 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [i915]] Setting DC state from 00 to 02
<7> [71.949540] i915 0000:00:02.0: [drm:intel_power_well_enable [i915]] enabling DC_off
<7> [71.949910] i915 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [i915]] Setting DC state from 02 to 00
<7> [71.978241] i915 0000:00:02.0: [drm:intel_power_well_disable [i915]] disabling DC_off
<7> [71.978874] i915 0000:00:02.0: [drm:skl_enable_dc6 [i915]] Enabling DC6
<7> [71.979507] i915 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [i915]] Setting DC state from 00 to 02
<7> [72.060494] i915 0000:00:02.0: [drm:intel_power_well_enable [i915]] enabling DC_off
<7> [72.060737] i915 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [i915]] Setting DC state from 02 to 00
<7> [72.087850] i915 0000:00:02.0: [drm:intel_power_well_disable [i915]] disabling DC_off
<7> [72.088231] i915 0000:00:02.0: [drm:skl_enable_dc6 [i915]] Enabling DC6
<7> [72.088543] i915 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [i915]] Setting DC state from 00 to 02
<7> [72.171811] i915 0000:00:02.0: [drm:intel_power_well_enable [i915]] enabling DC_off
<7> [72.172432] i915 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [i915]] Setting DC state from 02 to 00
<7> [72.199413] i915 0000:00:02.0: [drm:intel_power_well_disable [i915]] disabling DC_off
<7> [72.200041] i915 0000:00:02.0: [drm:skl_enable_dc6 [i915]] Enabling DC6
<7> [72.200700] i915 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [i915]] Setting DC state from 00 to 02
<7> [72.282705] i915 0000:00:02.0: [drm:intel_power_well_enable [i915]] enabling DC_off
<7> [72.283293] i915 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [i915]] Setting DC state from 02 to 00
<7> [72.311232] i915 0000:00:02.0: [drm:intel_power_well_disable [i915]] disabling DC_off
<7> [72.311782] i915 0000:00:02.0: [drm:skl_enable_dc6 [i915]] Enabling DC6
<7> [72.312335] i915 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [i915]] Setting DC state from 00 to 02
<7> [72.394531] i915 0000:00:02.0: [drm:intel_power_well_enable [i915]] enabling DC_off
<7> [72.395211] i915 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [i915]] Setting DC state from 02 to 00
<7> [72.422215] i915 0000:00:02.0: [drm:intel_power_well_disable [i915]] disabling DC_off
<7> [72.422772] i915 0000:00:02.0: [drm:skl_enable_dc6 [i915]] Enabling DC6
<7> [72.423383] i915 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [i915]] Setting DC state from 00 to 02
<7> [72.505133] i915 0000:00:02.0: [drm:intel_power_well_enable [i915]] enabling DC_off
<7> [72.505717] i915 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [i915]] Setting DC state from 02 to 00
<7> [72.533127] i915 0000:00:02.0: [drm:intel_power_well_disable [i915]] disabling DC_off
<7> [72.533664] i915 0000:00:02.0: [drm:skl_enable_dc6 [i915]] Enabling DC6
<7> [72.534249] i915 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [i915]] Setting DC state from 00 to 02
<7> [72.616562] i915 0000:00:02.0: [drm:intel_power_well_enable [i915]] enabling DC_off
<7> [72.617135] i915 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [i915]] Setting DC state from 02 to 00
<7> [72.645180] i915 0000:00:02.0: [drm:intel_power_well_disable [i915]] disabling DC_off
<7> [72.645724] i915 0000:00:02.0: [drm:skl_enable_dc6 [i915]] Enabling DC6
<7> [72.646340] i915 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [i915]] Setting DC state from 00 to 02
<7> [72.727671] i915 0000:00:02.0: [drm:intel_power_well_enable [i915]] enabling DC_off
<7> [72.728347] i915 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [i915]] Setting DC state from 02 to 00
<7> [72.755245] i915 0000:00:02.0: [drm:intel_power_well_disable [i915]] disabling DC_off
<7> [72.755801] i915 0000:00:02.0: [drm:skl_enable_dc6 [i915]] Enabling DC6
<7> [72.756350] i915 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [i915]] Setting DC state from 00 to 02
<7> [72.838708] i915 0000:00:02.0: [drm:intel_power_well_enable [i915]] enabling DC_off
<7> [72.839333] i915 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [i915]] Setting DC state from 02 to 00
<7> [72.866175] i915 0000:00:02.0: [drm:intel_power_well_disable [i915]] disabling DC_off
<7> [72.866735] i915 0000:00:02.0: [drm:skl_enable_dc6 [i915]] Enabling DC6
<7> [72.867275] i915 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [i915]] Setting DC state from 00 to 02
<7> [72.950125] i915 0000:00:02.0: [drm:intel_power_well_enable [i915]] enabling DC_off
<7> [72.950855] i915 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [i915]] Setting DC state from 02 to 00
<7> [72.977188] i915 0000:00:02.0: [drm:intel_power_well_disable [i915]] disabling DC_off
<7> [72.977750] i915 0000:00:02.0: [drm:skl_enable_dc6 [i915]] Enabling DC6
<7> [72.978323] i915 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [i915]] Setting DC state from 00 to 02
<7> [73.061247] i915 0000:00:02.0: [drm:intel_power_well_enable [i915]] enabling DC_off
<7> [73.061920] i915 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [i915]] Setting DC state from 02 to 00
<7> [73.088215] i915 0000:00:02.0: [drm:intel_power_well_disable [i915]] disabling DC_off
<7> [73.088762] i915 0000:00:02.0: [drm:skl_enable_dc6 [i915]] Enabling DC6
<7> [73.089302] i915 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [i915]] Setting DC state from 00 to 02
<7> [73.172453] i915 0000:00:02.0: [drm:intel_power_well_enable [i915]] enabling DC_off
<7> [73.173267] i915 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [i915]] Setting DC state from 02 to 00
<7> [73.199087] i915 0000:00:02.0: [drm:intel_power_well_disable [i915]] disabling DC_off
<7> [73.199676] i915 0000:00:02.0: [drm:skl_enable_dc6 [i915]] Enabling DC6
<7> [73.200247] i915 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [i915]] Setting DC state from 00 to 02
<7> [73.282685] i915 0000:00:02.0: [drm:intel_power_well_enable [i915]] enabling DC_off
<7> [73.283255] i915 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [i915]] Setting DC state from 02 to 00
<7> [73.310380] i915 0000:00:02.0: [drm:intel_power_well_disable [i915]] disabling DC_off
<7> [73.310952] i915 0000:00:02.0: [drm:skl_enable_dc6 [i915]] Enabling DC6
<7> [73.311506] i915 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [i915]] Setting DC state from 00 to 02
<7> [76.359420] i915 0000:00:02.0: [drm:drm_mode_setcrtc] [CRTC:88:pipe A]
<7> [76.360021] i915 0000:00:02.0: [drm:intel_power_well_enable [i915]] enabling DC_off
<7> [76.361586] i915 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [i915]] Setting DC state from 02 to 00
<7> [76.363264] i915 0000:00:02.0: [drm:drm_mode_setcrtc] [CRTC:145:pipe B]
<7> [76.363406] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:145:pipe B] fastset requirement not met in hw.enable (expected yes, found no)
<7> [76.363831] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:145:pipe B] fastset requirement not met in hw.active (expected yes, found no)
<7> [76.364219] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:145:pipe B] fastset requirement not met in cpu_transcoder (expected 1, found -1)
<7> [76.364474] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:145:pipe B] fastset requirement not met in lane_count (expected 4, found 0)
<7> [76.364731] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:145:pipe B] fastset requirement not met in dp_m_n (expected tu 64 data 7483046/8388608 link 498869/524288, found tu 0, data 0/0 link 0/0)
<7> [76.364981] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:145:pipe B] fastset requirement not met in output_types (expected 0x00000100, found 0x00000000)
<7> [76.365225] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:145:pipe B] fastset requirement not met in framestart_delay (expected 1, found 0)
<7> [76.365468] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:145:pipe B] fastset requirement not met in hw.pipe_mode.crtc_hdisplay (expected 2880, found 0)
<7> [76.365722] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:145:pipe B] fastset requirement not met in hw.pipe_mode.crtc_htotal (expected 3040, found 0)
<7> [76.366051] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:145:pipe B] fastset requirement not met in hw.pipe_mode.crtc_hblank_start (expected 2880, found 0)
<7> [76.366320] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:145:pipe B] fastset requirement not met in hw.pipe_mode.crtc_hblank_end (expected 3040, found 0)
<7> [76.366476] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:145:pipe B] fastset requirement not met in hw.pipe_mode.crtc_hsync_start (expected 2928, found 0)
<7> [76.366664] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:145:pipe B] fastset requirement not met in hw.pipe_mode.crtc_hsync_end (expected 2960, found 0)
<7> [76.366913] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:145:pipe B] fastset requirement not met in hw.pipe_mode.crtc_vdisplay (expected 1800, found 0)
<7> [76.367111] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:145:pipe B] fastset requirement not met in hw.pipe_mode.crtc_vblank_start (expected 1801, found 0)
<7> [76.367265] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:145:pipe B] fastset requirement not met in hw.pipe_mode.crtc_vsync_start (expected 1803, found 0)
<7> [76.367388] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:145:pipe B] fastset requirement not met in hw.pipe_mode.crtc_vsync_end (expected 1809, found 0)
<7> [76.367520] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:145:pipe B] fastset requirement not met in hw.pipe_mode.crtc_vtotal (expected 1878, found 0)
<7> [76.367669] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:145:pipe B] fastset requirement not met in hw.pipe_mode.crtc_vblank_end (expected 1878, found 0)
<7> [76.367818] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:145:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_hdisplay (expected 2880, found 0)
<7> [76.367979] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:145:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_htotal (expected 3040, found 0)
<7> [76.368104] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:145:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_hblank_start (expected 2880, found 0)
<7> [76.368230] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:145:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_hblank_end (expected 3040, found 0)
<7> [76.368355] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:145:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_hsync_start (expected 2928, found 0)
<7> [76.368478] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:145:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_hsync_end (expected 2960, found 0)
<7> [76.368611] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:145:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_vdisplay (expected 1800, found 0)
<7> [76.368736] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:145:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_vblank_start (expected 1801, found 0)
<7> [76.368859] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:145:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_vsync_start (expected 1803, found 0)
<7> [76.368982] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:145:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_vsync_end (expected 1809, found 0)
<7> [76.369105] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:145:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_vtotal (expected 1878, found 0)
<7> [76.369230] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:145:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_vblank_end (expected 1878, found 0)
<7> [76.369356] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:145:pipe B] fastset requirement not met in pixel_multiplier (expected 1, found 0)
<7> [76.369483] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:145:pipe B] fastset requirement not met in hw.adjusted_mode.flags (2) (expected 2, found 0)
<7> [76.369622] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:145:pipe B] fastset requirement not met in hw.adjusted_mode.flags (8) (expected 8, found 0)
<7> [76.369747] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:145:pipe B] fastset requirement not met in enhanced_framing (expected yes, found no)
<7> [76.369867] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:145:pipe B] fastset requirement not met in pipe_bpp (expected 30, found 0)
<7> [76.369989] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:145:pipe B] fastset requirement not met in hw.pipe_mode.crtc_clock (expected 513820, found 0)
<7> [76.370112] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:145:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_clock (expected 513820, found 0)
<7> [76.370239] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:145:pipe B] fastset requirement not met in port_clock (expected 540000, found 0)
<7> [76.370366] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:145:pipe B] fastset requirement not met in set_context_latency (expected 1, found 0)
<7> [76.370495] i915 0000:00:02.0: [drm:intel_atomic_check [i915]] [CRTC:145:pipe B] fastset requirement not met, forcing full modeset
<7> [76.370652] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] Enabled dbuf slices 0xf -> 0x1 (total dbuf slices 0xf), mbus joined? yes->no
<7> [76.370781] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] [CRTC:145:pipe B] dbuf slices 0xf -> 0x0, ddb (0 - 4096) -> (0 - 0), active pipes 0x2 -> 0x0
<7> [76.370926] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] [PLANE:90:plane 1B] ddb ( 0 - 4001) -> ( 0 - 0), size 4001 -> 0
<7> [76.371050] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] [PLANE:140:cursor B] ddb (4001 - 4096) -> ( 0 - 0), size 95 -> 0
<7> [76.371173] i915 0000:00:02.0: [drm:skl_print_plane_changes [i915]] [PLANE:90: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> [76.371298] i915 0000:00:02.0: [drm:skl_print_plane_changes [i915]] [PLANE:90:plane 1B] lines 4, 16, 16, 19, 19, 28, 0, 0, 0, 4, 0 -> 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0
<7> [76.371423] i915 0000:00:02.0: [drm:skl_print_plane_changes [i915]] [PLANE:90:plane 1B] blocks 92, 365, 365, 434, 434, 638, 0, 0, 197, 92, 197 -> 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0
<7> [76.371561] i915 0000:00:02.0: [drm:skl_print_plane_changes [i915]] [PLANE:90:plane 1B] min_ddb 183, 456, 456, 547, 547, 729, 0, 0, 198, 183, 198 -> 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0
<7> [76.371697] i915 0000:00:02.0: [drm:intel_bw_atomic_check [i915]] [CRTC:145:pipe B] data rate 0 num active planes 0
<7> [76.371827] i915 0000:00:02.0: [drm:intel_bw_atomic_check [i915]] QGV point 0: max bw 28913 required 0 qgv_peak_bw: 51200
<7> [76.371952] i915 0000:00:02.0: [drm:intel_bw_atomic_check [i915]] QGV point 1: max bw 38000 required 0 qgv_peak_bw: 51200
<7> [76.372079] i915 0000:00:02.0: [drm:intel_bw_atomic_check [i915]] QGV point 2: max bw 38000 required 0 qgv_peak_bw: 51200
<7> [76.372208] i915 0000:00:02.0: [drm:intel_bw_atomic_check [i915]] QGV point 3: max bw 38000 required 0 qgv_peak_bw: 51200
<7> [76.372338] i915 0000:00:02.0: [drm:intel_bw_atomic_check [i915]] Matching peaks QGV bw: 51200 for required data rate: 0
<7> [76.372471] i915 0000:00:02.0: [drm:intel_cdclk_atomic_check [i915]] [CRTC:145:pipe B] min cdclk: 256910 kHz -> 0 kHz
<7> [76.372618] i915 0000:00:02.0: [drm:intel_cdclk_update_dbuf_bw_min_cdclk [i915]] dbuf bandwidth min cdclk: 32114 kHz -> 0 kHz
<7> [76.372743] i915 0000:00:02.0: [drm:intel_cdclk_atomic_check [i915]] Can change cdclk via squashing
<7> [76.372867] i915 0000:00:02.0: [drm:intel_cdclk_atomic_check [i915]] New cdclk calculated to be logical 172800 kHz, actual 172800 kHz
<7> [76.372993] i915 0000:00:02.0: [drm:intel_cdclk_atomic_check [i915]] New voltage level calculated to be logical 0, actual 0
<7> [76.373136] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [CRTC:145:pipe B] enable: no [modeset]
<7> [76.373267] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:90:plane 1B] fb: [NOFB], visible: no
<7> [76.373397] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:100:plane 2B] fb: [NOFB], visible: no
<7> [76.373539] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:110:plane 3B] fb: [NOFB], visible: no
<7> [76.373671] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:120:plane 4B] fb: [NOFB], visible: no
<7> [76.373801] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:130:plane 5B] fb: [NOFB], visible: no
<7> [76.373927] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:140:cursor B] fb: [NOFB], visible: no
<7> [76.374097] i915 0000:00:02.0: [drm:intel_psr_disable_locked [i915]] Disabling PSR2
<7> [76.374572] i915 0000:00:02.0: [drm:intel_pps_vdd_on_unlocked [i915]] [ENCODER:261:DDI A/PHY A] PPS 0 turning VDD on
<7> [76.374809] i915 0000:00:02.0: [drm:intel_pps_vdd_on_unlocked [i915]] [ENCODER:261:DDI A/PHY A] PPS 0 PP_STATUS: 0x80000008 PP_CONTROL: 0x0000006f
<7> [76.375676] i915 0000:00:02.0: [drm:intel_edp_backlight_off [i915]]
<7> [76.578621] i915 0000:00:02.0: [drm:intel_backlight_set_pwm_level [i915]] [CONNECTOR:262:eDP-1] set backlight PWM = 0
<7> [76.579619] i915 0000:00:02.0: [drm:intel_disable_transcoder [i915]] disabling pipe B
<7> [76.587794] i915 0000:00:02.0: [drm:intel_pps_off_unlocked [i915]] [ENCODER:261:DDI A/PHY A] PPS 0 turn panel power off
<7> [76.588138] i915 0000:00:02.0: [drm:icp_irq_handler [i915]] hotplug event received, stat 0x00010000, dig 0x00000089, pins 0x00000010, long 0x00000000
<7> [76.588375] i915 0000:00:02.0: [drm:intel_pps_off_unlocked [i915]] [ENCODER:261:DDI A/PHY A] PPS 0 wait for panel power off time
<7> [76.588690] i915 0000:00:02.0: [drm:intel_hpd_irq_handler [i915]] digital hpd on [ENCODER:261:DDI A/PHY A] - short
<7> [76.588869] i915 0000:00:02.0: [drm:wait_panel_status [i915]] [ENCODER:261:DDI A/PHY A] PPS 0 mask: 0xb0000000 value: 0x00000000 PP_STATUS: 0xa0000002 PP_CONTROL: 0x00000060
<7> [76.641047] i915 0000:00:02.0: [drm:icp_irq_handler [i915]] hotplug event received, stat 0x00010000, dig 0x0000008a, pins 0x00000010, long 0x00000010
<7> [76.641619] i915 0000:00:02.0: [drm:intel_hpd_irq_handler [i915]] digital hpd on [ENCODER:261:DDI A/PHY A] - long
<7> [76.642142] i915 0000:00:02.0: [drm:intel_hpd_irq_handler [i915]] Received HPD interrupt on PIN 4 - cnt: 10
<7> [76.644224] i915 0000:00:02.0: [drm:wait_panel_status [i915]] Wait complete
<7> [76.644892] i915 0000:00:02.0: [drm:intel_power_well_disable [i915]] disabling AUX_A
<7> [76.644912] i915 0000:00:02.0: [drm:intel_dp_hpd_pulse [i915]] ignoring short hpd on eDP [ENCODER:261:DDI A/PHY A]
<7> [76.645434] i915 0000:00:02.0: [drm:intel_dp_hpd_pulse [i915]] ignoring long hpd on eDP [ENCODER:261:DDI A/PHY A]
<7> [76.645518] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:261:DDI A/PHY A]
<7> [76.646052] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:270:DDI B/PHY B]
<7> [76.646568] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:272:DP-MST A]
<7> [76.647092] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:273:DP-MST B]
<7> [76.647429] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:274:DP-MST C]
<7> [76.647711] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:275:DP-MST D]
<7> [76.648135] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:288:DDI TC1/PHY TC1]
<7> [76.648414] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:290:DP-MST A]
<7> [76.648655] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:291:DP-MST B]
<7> [76.648949] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:292:DP-MST C]
<7> [76.649210] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:293:DP-MST D]
<7> [76.649457] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:297:DDI TC2/PHY TC2]
<7> [76.649602] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:301:DDI TC3/PHY TC3]
<7> [76.649746] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:303:DP-MST A]
<7> [76.649889] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:304:DP-MST B]
<7> [76.650197] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:305:DP-MST C]
<7> [76.650371] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:306:DP-MST D]
<7> [76.650509] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:310:DDI TC4/PHY TC4]
<7> [76.650633] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:312:DP-MST A]
<7> [76.650756] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:313:DP-MST B]
<7> [76.650876] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:314:DP-MST C]
<7> [76.650997] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:315:DP-MST D]
<7> [76.651132] i915 0000:00:02.0: [drm:verify_connector_state [i915]] [CONNECTOR:262:eDP-1]
<7> [76.651293] i915 0000:00:02.0: [drm:intel_dbuf_mdclk_cdclk_ratio_update [i915]] Updating dbuf ratio to 2 (mbus joined: no)
<7> [76.651440] i915 0000:00:02.0: [drm:intel_dbuf_mbus_join_update [i915]] Changing mbus joined: yes -> no (pipe: *)
<7> [76.651570] i915 0000:00:02.0: [drm:gen9_dbuf_slices_update [i915]] Updating dbuf slices to 0x1
<7> [76.651801] i915 0000:00:02.0: [drm:intel_power_well_disable [i915]] disabling PW_B
<7> [76.651978] i915 0000:00:02.0: [drm:intel_power_well_disable [i915]] disabling PW_2
<7> [76.652158] i915 0000:00:02.0: [drm:intel_modeset_verify_crtc [i915]] [CRTC:145:pipe B]
<7> [76.652335] i915 0000:00:02.0: [drm:intel_set_cdclk [i915]] Post changing CDCLK to 172800 kHz, VCO 614400 kHz, ref 38400 kHz, bypass 19200 kHz, voltage level 0
<7> [76.652501] i915 0000:00:02.0: [drm:intel_audio_cdclk_change_post.part.0 [i915]] aud_ts_cdclk set to M=60, N=432
<7> [76.652925] i915 0000:00:02.0: [drm:drm_mode_setcrtc] [CRTC:202:pipe C]
<7> [76.653137] i915 0000:00:02.0: [drm:drm_mode_setcrtc] [CRTC:259:pipe D]
<7> [76.653256] i915 0000:00:02.0: [drm:drm_mode_setcrtc] [CRTC:145:pipe B]
<7> [76.653284] i915 0000:00:02.0: [drm:drm_mode_setcrtc] [CONNECTOR:262:eDP-1]
<7> [76.653331] i915 0000:00:02.0: [drm:intel_atomic_check [i915]] [CONNECTOR:262:eDP-1] Limiting display bpp to 30 (EDID bpp 30, max requested bpp 36, max platform bpp 36)
<7> [76.653476] i915 0000:00:02.0: [drm:intel_dp_compute_config_limits [i915]] [ENCODER:261:DDI A/PHY A][CRTC:145:pipe B] DP link limits: pixel clock 513820 kHz DSC off max lanes 4 max rate 540000 max pipe_bpp 30 max link_bpp 30.0000
<7> [76.653599] i915 0000:00:02.0: [drm:intel_dp_compute_link_config [i915]] DP lane count 4 clock 540000 bpp input 30 compressed 0.0000 link rate required 1926825 available 2160000
<7> [76.653728] i915 0000:00:02.0: [drm:intel_atomic_check [i915]] [CRTC:145:pipe B] hw max bpp: 30, pipe bpp: 30, dithering: 0
<7> [76.653861] i915 0000:00:02.0: [drm:intel_ddi_compute_config_late [i915]] [ENCODER:261:DDI A/PHY A] [CRTC:145:pipe B]
<7> [76.653981] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:145:pipe B] fastset requirement not met in hw.enable (expected no, found yes)
<7> [76.654133] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:145:pipe B] fastset requirement not met in hw.active (expected no, found yes)
<7> [76.654262] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:145:pipe B] fastset requirement not met in cpu_transcoder (expected -1, found 1)
<7> [76.654392] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:145:pipe B] fastset requirement not met in lane_count (expected 0, found 4)
<7> [76.654523] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:145:pipe B] fastset requirement not met in dp_m_n (expected tu 0 data 0/0 link 0/0, found tu 64, data 7483046/8388608 link 498869/524288)
<7> [76.654654] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:145:pipe B] fastset requirement not met in output_types (expected 0x00000000, found 0x00000100)
<7> [76.654785] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:145:pipe B] fastset requirement not met in framestart_delay (expected 0, found 1)
<7> [76.654915] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:145:pipe B] fastset requirement not met in hw.pipe_mode.crtc_hdisplay (expected 0, found 2880)
<7> [76.655054] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:145:pipe B] fastset requirement not met in hw.pipe_mode.crtc_htotal (expected 0, found 3040)
<7> [76.655184] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:145:pipe B] fastset requirement not met in hw.pipe_mode.crtc_hblank_start (expected 0, found 2880)
<7> [76.655315] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:145:pipe B] fastset requirement not met in hw.pipe_mode.crtc_hblank_end (expected 0, found 3040)
<7> [76.655442] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:145:pipe B] fastset requirement not met in hw.pipe_mode.crtc_hsync_start (expected 0, found 2928)
<7> [76.655568] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:145:pipe B] fastset requirement not met in hw.pipe_mode.crtc_hsync_end (expected 0, found 2960)
<7> [76.655693] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:145:pipe B] fastset requirement not met in hw.pipe_mode.crtc_vdisplay (expected 0, found 1800)
<7> [76.655818] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:145:pipe B] fastset requirement not met in hw.pipe_mode.crtc_vblank_start (expected 0, found 1801)
<7> [76.655944] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:145:pipe B] fastset requirement not met in hw.pipe_mode.crtc_vsync_start (expected 0, found 1803)
<7> [76.656082] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:145:pipe B] fastset requirement not met in hw.pipe_mode.crtc_vsync_end (expected 0, found 1809)
<7> [76.656209] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:145:pipe B] fastset requirement not met in hw.pipe_mode.crtc_vtotal (expected 0, found 1878)
<7> [76.656335] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:145:pipe B] fastset requirement not met in hw.pipe_mode.crtc_vblank_end (expected 0, found 1878)
<7> [76.656461] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:145:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_hdisplay (expected 0, found 2880)
<7> [76.656585] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:145:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_htotal (expected 0, found 3040)
<7> [76.656709] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:145:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_hblank_start (expected 0, found 2880)
<7> [76.656836] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:145:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_hblank_end (expected 0, found 3040)
<7> [76.656968] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:145:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_hsync_start (expected 0, found 2928)
<7> [76.657094] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:145:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_hsync_end (expected 0, found 2960)
<7> [76.657219] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:145:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_vdisplay (expected 0, found 1800)
<7> [76.657342] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:145:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_vblank_start (expected 0, found 1801)
<7> [76.657465] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:145:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_vsync_start (expected 0, found 1803)
<7> [76.657588] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:145:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_vsync_end (expected 0, found 1809)
<7> [76.657712] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:145:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_vtotal (expected 0, found 1878)
<7> [76.657837] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:145:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_vblank_end (expected 0, found 1878)
<7> [76.657977] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:145:pipe B] fastset requirement not met in pixel_multiplier (expected 0, found 1)
<7> [76.658105] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:145:pipe B] fastset requirement not met in hw.adjusted_mode.flags (2) (expected 0, found 2)
<7> [76.658233] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:145:pipe B] fastset requirement not met in hw.adjusted_mode.flags (8) (expected 0, found 8)
<7> [76.658359] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:145:pipe B] fastset requirement not met in enhanced_framing (expected no, found yes)
<7> [76.658484] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:145:pipe B] fastset requirement not met in pipe_bpp (expected 0, found 30)
<7> [76.658609] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:145:pipe B] fastset requirement not met in hw.pipe_mode.crtc_clock (expected 0, found 513820)
<7> [76.658734] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:145:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_clock (expected 0, found 513820)
<7> [76.658857] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:145:pipe B] fastset requirement not met in port_clock (expected 0, found 540000)
<7> [76.658990] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:145:pipe B] fastset requirement not met in set_context_latency (expected 0, found 1)
<7> [76.659115] i915 0000:00:02.0: [drm:intel_atomic_check [i915]] [CRTC:145:pipe B] fastset requirement not met, forcing full modeset
<7> [76.659272] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] Enabled dbuf slices 0x1 -> 0xf (total dbuf slices 0xf), mbus joined? no->yes
<7> [76.659399] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] [CRTC:145:pipe B] dbuf slices 0x0 -> 0xf, ddb (0 - 0) -> (0 - 4096), active pipes 0x0 -> 0x2
<7> [76.659540] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] [PLANE:90:plane 1B] ddb ( 0 - 0) -> ( 0 - 4001), size 0 -> 4001
<7> [76.659667] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] [PLANE:140:cursor B] ddb ( 0 - 0) -> (4001 - 4096), size 0 -> 95
<7> [76.659796] i915 0000:00:02.0: [drm:skl_print_plane_changes [i915]] [PLANE:90: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> [76.659938] i915 0000:00:02.0: [drm:skl_print_plane_changes [i915]] [PLANE:90:plane 1B] lines 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0 -> 4, 16, 16, 19, 19, 28, 0, 0, 0, 4, 0
<7> [76.660062] i915 0000:00:02.0: [drm:skl_print_plane_changes [i915]] [PLANE:90:plane 1B] blocks 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0 -> 92, 365, 365, 434, 434, 638, 0, 0, 197, 92, 197
<7> [76.660184] i915 0000:00:02.0: [drm:skl_print_plane_changes [i915]] [PLANE:90:plane 1B] min_ddb 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0 -> 183, 456, 456, 547, 547, 729, 0, 0, 198, 183, 198
<7> [76.660322] i915 0000:00:02.0: [drm:intel_bw_atomic_check [i915]] [CRTC:145:pipe B] data rate 2055280 num active planes 1
<7> [76.660456] i915 0000:00:02.0: [drm:intel_bw_atomic_check [i915]] QGV point 0: max bw 28913 required 2159 qgv_peak_bw: 51200
<7> [76.660586] i915 0000:00:02.0: [drm:intel_bw_atomic_check [i915]] QGV point 1: max bw 38000 required 2159 qgv_peak_bw: 51200
<7> [76.660714] i915 0000:00:02.0: [drm:intel_bw_atomic_check [i915]] QGV point 2: max bw 38000 required 2159 qgv_peak_bw: 51200
<7> [76.660843] i915 0000:00:02.0: [drm:intel_bw_atomic_check [i915]] QGV point 3: max bw 38000 required 2159 qgv_peak_bw: 51200
<7> [76.660980] i915 0000:00:02.0: [drm:intel_bw_atomic_check [i915]] Matching peaks QGV bw: 51200 for required data rate: 2159
<7> [76.661106] i915 0000:00:02.0: [drm:intel_cdclk_atomic_check [i915]] [CRTC:145:pipe B] min cdclk: 0 kHz -> 256910 kHz
<7> [76.661247] i915 0000:00:02.0: [drm:intel_cdclk_update_dbuf_bw_min_cdclk [i915]] dbuf bandwidth min cdclk: 0 kHz -> 32114 kHz
<7> [76.661374] i915 0000:00:02.0: [drm:intel_cdclk_atomic_check [i915]] Can change cdclk via squashing
<7> [76.661500] i915 0000:00:02.0: [drm:intel_cdclk_atomic_check [i915]] New cdclk calculated to be logical 307200 kHz, actual 307200 kHz
<7> [76.661627] i915 0000:00:02.0: [drm:intel_cdclk_atomic_check [i915]] New voltage level calculated to be logical 0, actual 0
<7> [76.661777] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [CRTC:145:pipe B] enable: yes [modeset]
<7> [76.661937] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] active: yes, output_types: EDP (0x100), output format: RGB, sink format: RGB
<7> [76.662064] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] cpu_transcoder: B, pipe bpp: 30, dithering: 0
<7> [76.662194] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] MST master transcoder: <invalid>
<7> [76.662323] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] port sync: master transcoder: <invalid>, slave transcoder bitmask = 0x0
<7> [76.662451] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] joiner: no, pipes: 0x0
<7> [76.662578] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] splitter: disabled, link count 0, overlap 0
<7> [76.662705] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] dp m_n: lanes: 4; data_m: 7483046, data_n: 8388608, link_m: 498869, link_n: 524288, tu: 64
<7> [76.662835] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] dp m2_n2: lanes: 4; data_m: 0, data_n: 0, link_m: 0, link_n: 0, tu: 0
<7> [76.662980] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] fec: disabled, enhanced framing: enabled
<7> [76.663108] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] sdp split: disabled
<7> [76.663237] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] psr: enabled, selective update: enabled, panel replay: disabled, selective fetch: enabled
<7> [76.663365] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] minimum HBlank: 0
<7> [76.663493] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] audio: 0, infoframes: 0, infoframes enabled: 0x4
<7> [76.663621] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] DP SDP: VSC, revision 4, length 14
<7> [76.663753] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pixelformat: RGB
<7> [76.663909] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] colorimetry: sRGB
<7> [76.664038] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] bpc: 0
<7> [76.664166] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] dynamic range: VESA range
<7> [76.664295] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] content type: Not defined
<7> [76.664424] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] scanline offset: 1
<7> [76.664555] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] framestart delay: 1, MSA timing delay: 0, set context latency: 1
<7> [76.664685] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] vrr: no, fixed rr: yes, vmin: 1878, vmax: 1878, flipline: 1878, pipeline full: 0, guardband: 76 vsync start: 75, vsync end: 69
<7> [76.664817] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] vrr: vmin vblank: 1802, vmax vblank: 1802, vmin vtotal: 1878, vmax vtotal: 1878
<7> [76.664968] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] requested mode: "2880x1800": 90 513820 2880 2928 2960 3040 1800 1803 1809 1878 0x48 0xa
<7> [76.665095] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] adjusted mode: "2880x1800": 90 513820 2880 2928 2960 3040 1800 1803 1809 1878 0x48 0xa
<7> [76.665224] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] crtc timings: clock=513820, hd=2880 hb=2880-3040 hs=2928-2960 ht=3040, vd=1800 vb=1801-1878 vs=1803-1809 vt=1878, flags=0xa
<7> [76.665352] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pipe mode: "2880x1800": 90 513820 2880 2928 2960 3040 1800 1803 1809 1878 0x40 0xa
<7> [76.665478] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] crtc timings: clock=513820, hd=2880 hb=2880-3040 hs=2928-2960 ht=3040, vd=1800 vb=1801-1878 vs=1803-1809 vt=1878, flags=0xa
<7> [76.665605] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] port clock: 540000, pipe src: 2880x1800+0+0, pixel rate 513820, min cdclk 256910
<7> [76.665729] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] linetime: 48, ips linetime: 0
<7> [76.665884] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] num_scalers: 2, scaler_users: 0x0, scaler_id: -1, scaling_filter: 0
<7> [76.666011] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pch pfit: 0x0+0+0, disabled, force thru: no
<7> [76.666138] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] ips: 0, double wide: 0, drrs: 0
<7> [76.666264] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] dpll_hw_state: dpll: 0x83d60, dpll_md: 0xf42110, fp0: 0xf8, fp1: 0x1000000
<7> [76.666389] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] csc_mode: 0x0 gamma_mode: 0x0 gamma_enable: 0 csc_enable: 0
<7> [76.666514] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pre csc lut: 0 entries, post csc lut: 0 entries
<7> [76.666638] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] output csc: pre offsets: 0x0000 0x0000 0x0000
<7> [76.666768] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] output csc: coefficients: 0x0000 0x0000 0x0000
<7> [76.666914] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] output csc: coefficients: 0x0000 0x0000 0x0000
<7> [76.667041] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] output csc: coefficients: 0x0000 0x0000 0x0000
<7> [76.667166] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] output csc: post offsets: 0x0000 0x0000 0x0000
<7> [76.667291] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pipe csc: pre offsets: 0x0000 0x0000 0x0000
<7> [76.667417] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pipe csc: coefficients: 0x0000 0x0000 0x0000
<7> [76.667542] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pipe csc: coefficients: 0x0000 0x0000 0x0000
<7> [76.667667] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pipe csc: coefficients: 0x0000 0x0000 0x0000
<7> [76.667810] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pipe csc: post offsets: 0x0000 0x0000 0x0000
<7> [76.667935] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] sharpness strength: 0, sharpness tap size: 0, sharpness enable: 0
<7> [76.668060] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:90:plane 1B] fb: [FB:321] 2880x1800 format = XR24 little-endian (0x34325258) modifier = 0x100000000000009, visible: yes
<7> [76.668187] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] rotation: 0x1, scaler: -1, scaling_filter: 0
<7> [76.668311] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] src: 2880.000000x1800.000000+0.000000+0.000000 dst: 2880x1800+0+0
<7> [76.668435] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:100:plane 2B] fb: [NOFB], visible: no
<7> [76.668558] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:110:plane 3B] fb: [NOFB], visible: no
<7> [76.668685] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:120:plane 4B] fb: [NOFB], visible: no
<7> [76.668824] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:130:plane 5B] fb: [NOFB], visible: no
<7> [76.668950] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:140:cursor B] fb: [NOFB], visible: no
<7> [76.669149] i915 0000:00:02.0: [drm:intel_power_well_enable [i915]] enabling PW_2
<7> [76.669334] i915 0000:00:02.0: [drm:intel_power_well_enable [i915]] enabling PW_B
<7> [76.669542] i915 0000:00:02.0: [drm:intel_set_cdclk [i915]] Pre changing CDCLK to 307200 kHz, VCO 614400 kHz, ref 38400 kHz, bypass 19200 kHz, voltage level 0
<7> [76.669709] i915 0000:00:02.0: [drm:intel_audio_cdclk_change_post.part.0 [i915]] aud_ts_cdclk set to M=60, N=768
<7> [76.669850] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:261:DDI A/PHY A]
<7> [76.669977] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:270:DDI B/PHY B]
<7> [76.670104] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:272:DP-MST A]
<7> [76.670227] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:273:DP-MST B]
<7> [76.670350] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:274:DP-MST C]
<7> [76.670473] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:275:DP-MST D]
<7> [76.670594] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:288:DDI TC1/PHY TC1]
<7> [76.670716] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:290:DP-MST A]
<7> [76.670852] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:291:DP-MST B]
<7> [76.670981] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:292:DP-MST C]
<7> [76.671105] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:293:DP-MST D]
<7> [76.671230] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:297:DDI TC2/PHY TC2]
<7> [76.671353] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:301:DDI TC3/PHY TC3]
<7> [76.671477] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:303:DP-MST A]
<7> [76.671599] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:304:DP-MST B]
<7> [76.671730] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:305:DP-MST C]
<7> [76.671856] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:306:DP-MST D]
<7> [76.671981] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:310:DDI TC4/PHY TC4]
<7> [76.672105] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:312:DP-MST A]
<7> [76.672230] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:313:DP-MST B]
<7> [76.672355] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:314:DP-MST C]
<7> [76.672481] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:315:DP-MST D]
<7> [76.672606] i915 0000:00:02.0: [drm:gen9_dbuf_slices_update [i915]] Updating dbuf slices to 0xf
<7> [76.672848] i915 0000:00:02.0: [drm:intel_dbuf_mbus_join_update [i915]] Changing mbus joined: no -> yes (pipe: *)
<7> [76.672982] i915 0000:00:02.0: [drm:intel_dbuf_mdclk_cdclk_ratio_update [i915]] Updating dbuf ratio to 4 (mbus joined: yes)
<7> [76.673184] i915 0000:00:02.0: [drm:intel_power_well_enable [i915]] enabling AUX_A
<7> [76.674585] i915 0000:00:02.0: [drm:intel_pps_on_unlocked [i915]] [ENCODER:261:DDI A/PHY A] PPS 0 turn panel power on
<7> [76.674771] i915 0000:00:02.0: [drm:wait_panel_power_cycle [i915]] [ENCODER:261:DDI A/PHY A] PPS 0 wait for panel power cycle (470 ms remaining)
<7> [77.145605] i915 0000:00:02.0: [drm:wait_panel_status [i915]] [ENCODER:261:DDI A/PHY A] PPS 0 mask: 0xb800000f value: 0x00000000 PP_STATUS: 0x00000000 PP_CONTROL: 0x00000060
<7> [77.149267] i915 0000:00:02.0: [drm:wait_panel_status [i915]] Wait complete
<7> [77.149894] i915 0000:00:02.0: [drm:intel_pps_on_unlocked [i915]] [ENCODER:261:DDI A/PHY A] PPS 0 wait for panel power on
<7> [77.150519] i915 0000:00:02.0: [drm:wait_panel_status [i915]] [ENCODER:261:DDI A/PHY A] PPS 0 mask: 0xb000000f value: 0x80000008 PP_STATUS: 0x9000000a PP_CONTROL: 0x00000063
<7> [77.181809] i915 0000:00:02.0: [drm:icp_irq_handler [i915]] hotplug event received, stat 0x00010000, dig 0x0000008a, pins 0x00000010, long 0x00000010
<7> [77.182358] i915 0000:00:02.0: [drm:intel_hpd_irq_handler [i915]] digital hpd on [ENCODER:261:DDI A/PHY A] - long
<7> [77.182880] i915 0000:00:02.0: [drm:intel_hpd_irq_handler [i915]] Received HPD interrupt on PIN 4 - cnt: 20
<7> [77.183479] i915 0000:00:02.0: [drm:intel_dp_hpd_pulse [i915]] ignoring long hpd on eDP [ENCODER:261:DDI A/PHY A]
<7> [77.350992] i915 0000:00:02.0: [drm:wait_panel_status [i915]] Wait complete
<7> [77.353610] i915 0000:00:02.0: [drm:intel_pps_vdd_on_unlocked [i915]] [ENCODER:261:DDI A/PHY A] PPS 0 turning VDD on
<7> [77.354211] i915 0000:00:02.0: [drm:intel_pps_vdd_on_unlocked [i915]] [ENCODER:261:DDI A/PHY A] PPS 0 PP_STATUS: 0x80000008 PP_CONTROL: 0x0000006b
<7> [77.357660] i915 0000:00:02.0: [drm:drm_dp_read_dpcd_caps [drm_display_helper]] AUX A/DDI A/PHY A: DPCD: 14 14 c4 41 00 00 01 c0 02 00 00 00 00 0b 80
<7> [77.358492] i915 0000:00:02.0: [drm:intel_dp_start_link_train [i915]] [CONNECTOR:262:eDP-1][ENCODER:261:DDI A/PHY A][DPRX] Reloading eDP link rates
<7> [77.359143] i915 0000:00:02.0: [drm:intel_dp_start_link_train [i915]] [CONNECTOR:262:eDP-1][ENCODER:261:DDI A/PHY A][DPRX] Using LINK_RATE_SET value 07
<7> [77.360140] i915 0000:00:02.0: [drm:intel_dp_set_signal_levels [i915]] [CONNECTOR:262:eDP-1][ENCODER:261:DDI A/PHY A][DPRX] 8b/10b, lanes: 4, vswing levels: 0/0/0/0, pre-emphasis levels: 0/0/0/0
<7> [77.360808] i915 0000:00:02.0: [drm:intel_dp_program_link_training_pattern [i915]] [CONNECTOR:262:eDP-1][ENCODER:261:DDI A/PHY A][DPRX] Using DP training pattern TPS1
<7> [77.361673] i915 0000:00:02.0: [drm:intel_dp_link_train_phy [i915]] [CONNECTOR:262:eDP-1][ENCODER:261:DDI A/PHY A][DPRX] Clock recovery OK
<7> [77.361795] i915 0000:00:02.0: [drm:intel_dp_program_link_training_pattern [i915]] [CONNECTOR:262:eDP-1][ENCODER:261:DDI A/PHY A][DPRX] Using DP training pattern TPS3
<7> [77.363333] i915 0000:00:02.0: [drm:intel_dp_link_train_phy [i915]] [CONNECTOR:262:eDP-1][ENCODER:261:DDI A/PHY A][DPRX] Channel EQ done. DP Training successful
<7> [77.363451] i915 0000:00:02.0: [drm:intel_dp_link_train_phy [i915]] [CONNECTOR:262:eDP-1][ENCODER:261:DDI A/PHY A][DPRX] Link Training passed at link rate = 540000, lane count = 4
<7> [77.364035] i915 0000:00:02.0: [drm:intel_enable_transcoder [i915]] enabling pipe B
<7> [77.364294] i915 0000:00:02.0: [drm:intel_edp_backlight_on [i915]]
<7> [77.364417] i915 0000:00:02.0: [drm:intel_backlight_enable [i915]] pipe B
<7> [77.364590] i915 0000:00:02.0: [drm:intel_backlight_set_pwm_level [i915]] [CONNECTOR:262:eDP-1] set backlight PWM = 13892
<7> [77.375529] i915 0000:00:02.0: [drm:intel_psr_post_plane_update [i915]] Enabling PSR2
<7> [77.377163] i915 0000:00:02.0: [drm:verify_connector_state [i915]] [CONNECTOR:262:eDP-1]
<7> [77.377366] i915 0000:00:02.0: [drm:intel_modeset_verify_crtc [i915]] [CRTC:145:pipe B]
<7> [79.887458] i915 0000:00:02.0: [drm:intel_pps_vdd_off_sync_unlocked [i915]] [ENCODER:261:DDI A/PHY A] PPS 0 turning VDD off
<7> [79.888499] i915 0000:00:02.0: [drm:intel_pps_vdd_off_sync_unlocked [i915]] [ENCODER:261:DDI A/PHY A] PPS 0 PP_STATUS: 0x80000008 PP_CONTROL: 0x00000067
<7> [79.888996] i915 0000:00:02.0: [drm:intel_power_well_disable [i915]] disabling DC_off
<7> [79.889585] i915 0000:00:02.0: [drm:skl_enable_dc6 [i915]] Enabling DC6
<7> [79.890044] i915 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [i915]] Setting DC state from 00 to 02
<7> [79.909433] i915 0000:00:02.0: [drm:intel_power_well_enable [i915]] enabling DC_off
<7> [79.910060] i915 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [i915]] Setting DC state from 02 to 00
<7> [79.937838] i915 0000:00:02.0: [drm:intel_power_well_disable [i915]] disabling DC_off
<7> [79.938369] i915 0000:00:02.0: [drm:skl_enable_dc6 [i915]] Enabling DC6
<7> [79.938898] i915 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [i915]] Setting DC state from 00 to 02
<7> [80.021371] i915 0000:00:02.0: [drm:intel_power_well_enable [i915]] enabling DC_off
<7> [80.022036] i915 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [i915]] Setting DC state from 02 to 00
<7> [80.048729] i915 0000:00:02.0: [drm:intel_power_well_disable [i915]] disabling DC_off
<7> [80.049272] i915 0000:00:02.0: [drm:skl_enable_dc6 [i915]] Enabling DC6
<7> [80.049849] i915 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [i915]] Setting DC state from 00 to 02
<7> [80.132069] i915 0000:00:02.0: [drm:intel_power_well_enable [i915]] enabling DC_off
<7> [80.132696] i915 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [i915]] Setting DC state from 02 to 00
<7> [80.159583] i915 0000:00:02.0: [drm:intel_power_well_disable [i915]] disabling DC_off
<7> [80.160141] i915 0000:00:02.0: [drm:skl_enable_dc6 [i915]] Enabling DC6
<7> [80.160682] i915 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [i915]] Setting DC state from 00 to 02
<7> [80.243222] i915 0000:00:02.0: [drm:intel_power_well_enable [i915]] enabling DC_off
<7> [80.243943] i915 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [i915]] Setting DC state from 02 to 00
<7> [80.270546] i915 0000:00:02.0: [drm:intel_power_well_disable [i915]] disabling DC_off
<7> [80.271141] i915 0000:00:02.0: [drm:skl_enable_dc6 [i915]] Enabling DC6
<7> [80.271682] i915 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [i915]] Setting DC state from 00 to 02
<7> [80.354345] i915 0000:00:02.0: [drm:intel_power_well_enable [i915]] enabling DC_off
<7> [80.355063] i915 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [i915]] Setting DC state from 02 to 00
<7> [80.382421] i915 0000:00:02.0: [drm:intel_power_well_disable [i915]] disabling DC_off
<7> [80.382977] i915 0000:00:02.0: [drm:skl_enable_dc6 [i915]] Enabling DC6
<7> [80.383527] i915 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [i915]] Setting DC state from 00 to 02
<7> [80.465588] i915 0000:00:02.0: [drm:intel_power_well_enable [i915]] enabling DC_off
<7> [80.466197] i915 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [i915]] Setting DC state from 02 to 00
<7> [80.494350] i915 0000:00:02.0: [drm:intel_power_well_disable [i915]] disabling DC_off
<7> [80.494941] i915 0000:00:02.0: [drm:skl_enable_dc6 [i915]] Enabling DC6
<7> [80.495471] i915 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [i915]] Setting DC state from 00 to 02
<7> [80.576544] i915 0000:00:02.0: [drm:intel_power_well_enable [i915]] enabling DC_off
<7> [80.577125] i915 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [i915]] Setting DC state from 02 to 00
<7> [80.604449] i915 0000:00:02.0: [drm:intel_power_well_disable [i915]] disabling DC_off
<7> [80.605039] i915 0000:00:02.0: [drm:skl_enable_dc6 [i915]] Enabling DC6
<7> [80.605665] i915 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [i915]] Setting DC state from 00 to 02
<7> [80.687845] i915 0000:00:02.0: [drm:intel_power_well_enable [i915]] enabling DC_off
<7> [80.688419] i915 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [i915]] Setting DC state from 02 to 00
<7> [80.715297] i915 0000:00:02.0: [drm:intel_power_well_disable [i915]] disabling DC_off
<7> [80.715854] i915 0000:00:02.0: [drm:skl_enable_dc6 [i915]] Enabling DC6
<7> [80.716418] i915 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [i915]] Setting DC state from 00 to 02
<7> [80.798815] i915 0000:00:02.0: [drm:intel_power_well_enable [i915]] enabling DC_off
<7> [80.799426] i915 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [i915]] Setting DC state from 02 to 00
<7> [80.826394] i915 0000:00:02.0: [drm:intel_power_well_disable [i915]] disabling DC_off
<7> [80.827033] i915 0000:00:02.0: [drm:skl_enable_dc6 [i915]] Enabling DC6
<7> [80.827737] i915 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [i915]] Setting DC state from 00 to 02
<7> [80.910095] i915 0000:00:02.0: [drm:intel_power_well_enable [i915]] enabling DC_off
<7> [80.910790] i915 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [i915]] Setting DC state from 02 to 00
<7> [80.937322] i915 0000:00:02.0: [drm:intel_power_well_disable [i915]] disabling DC_off
<7> [80.937968] i915 0000:00:02.0: [drm:skl_enable_dc6 [i915]] Enabling DC6
<7> [80.938510] i915 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [i915]] Setting DC state from 00 to 02
<7> [81.021018] i915 0000:00:02.0: [drm:intel_power_well_enable [i915]] enabling DC_off
<7> [81.021685] i915 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [i915]] Setting DC state from 02 to 00
<7> [81.049314] i915 0000:00:02.0: [drm:intel_power_well_disable [i915]] disabling DC_off
<7> [81.049967] i915 0000:00:02.0: [drm:skl_enable_dc6 [i915]] Enabling DC6
<7> [81.050596] i915 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [i915]] Setting DC state from 00 to 02
<7> [81.132068] i915 0000:00:02.0: [drm:intel_power_well_enable [i915]] enabling DC_off
<7> [81.132665] i915 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [i915]] Setting DC state from 02 to 00
<7> [81.160274] i915 0000:00:02.0: [drm:intel_power_well_disable [i915]] disabling DC_off
<7> [81.160831] i915 0000:00:02.0: [drm:skl_enable_dc6 [i915]] Enabling DC6
<7> [81.161394] i915 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [i915]] Setting DC state from 00 to 02
<7> [81.243206] i915 0000:00:02.0: [drm:intel_power_well_enable [i915]] enabling DC_off
<7> [81.243886] i915 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [i915]] Setting DC state from 02 to 00
<7> [81.271313] i915 0000:00:02.0: [drm:intel_power_well_disable [i915]] disabling DC_off
<7> [81.271903] i915 0000:00:02.0: [drm:skl_enable_dc6 [i915]] Enabling DC6
<7> [81.272482] i915 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [i915]] Setting DC state from 00 to 02
<7> [81.354300] i915 0000:00:02.0: [drm:intel_power_well_enable [i915]] enabling DC_off
<7> [81.354972] i915 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [i915]] Setting DC state from 02 to 00
<7> [81.382407] i915 0000:00:02.0: [drm:intel_power_well_disable [i915]] disabling DC_off
<7> [81.382971] i915 0000:00:02.0: [drm:skl_enable_dc6 [i915]] Enabling DC6
<7> [81.383513] i915 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [i915]] Setting DC state from 00 to 02
<7> [81.465056] i915 0000:00:02.0: [drm:intel_power_well_enable [i915]] enabling DC_off
<7> [81.465713] i915 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [i915]] Setting DC state from 02 to 00
<7> [81.493526] i915 0000:00:02.0: [drm:intel_power_well_disable [i915]] disabling DC_off
<7> [81.494096] i915 0000:00:02.0: [drm:skl_enable_dc6 [i915]] Enabling DC6
<7> [81.494655] i915 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [i915]] Setting DC state from 00 to 02
<7> [81.576677] i915 0000:00:02.0: [drm:intel_power_well_enable [i915]] enabling DC_off
<7> [81.577373] i915 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [i915]] Setting DC state from 02 to 00
<7> [81.604594] i915 0000:00:02.0: [drm:intel_power_well_disable [i915]] disabling DC_off
<7> [81.605166] i915 0000:00:02.0: [drm:skl_enable_dc6 [i915]] Enabling DC6
<7> [81.605735] i915 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [i915]] Setting DC state from 00 to 02
<7> [81.687712] i915 0000:00:02.0: [drm:intel_power_well_enable [i915]] enabling DC_off
<7> [81.688382] i915 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [i915]] Setting DC state from 02 to 00
<7> [81.716705] i915 0000:00:02.0: [drm:intel_power_well_disable [i915]] disabling DC_off
<7> [81.717304] i915 0000:00:02.0: [drm:skl_enable_dc6 [i915]] Enabling DC6
<7> [81.717876] i915 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [i915]] Setting DC state from 00 to 02
<7> [81.798742] i915 0000:00:02.0: [drm:intel_power_well_enable [i915]] enabling DC_off
<7> [81.799370] i915 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [i915]] Setting DC state from 02 to 00
<7> [81.827756] i915 0000:00:02.0: [drm:intel_power_well_disable [i915]] disabling DC_off
<7> [81.828326] i915 0000:00:02.0: [drm:skl_enable_dc6 [i915]] Enabling DC6
<7> [81.828848] i915 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [i915]] Setting DC state from 00 to 02
<7> [81.910075] i915 0000:00:02.0: [drm:intel_power_well_enable [i915]] enabling DC_off
<7> [81.910657] i915 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [i915]] Setting DC state from 02 to 00
<7> [81.937865] i915 0000:00:02.0: [drm:intel_power_well_disable [i915]] disabling DC_off
<7> [81.938414] i915 0000:00:02.0: [drm:skl_enable_dc6 [i915]] Enabling DC6
<7> [81.938991] i915 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [i915]] Setting DC state from 00 to 02
<7> [82.021029] i915 0000:00:02.0: [drm:intel_power_well_enable [i915]] enabling DC_off
<7> [82.022130] i915 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [i915]] Setting DC state from 02 to 00
<7> [82.050062] i915 0000:00:02.0: [drm:intel_power_well_disable [i915]] disabling DC_off
<7> [82.050653] i915 0000:00:02.0: [drm:skl_enable_dc6 [i915]] Enabling DC6
<7> [82.051260] i915 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [i915]] Setting DC state from 00 to 02
<7> [82.132311] i915 0000:00:02.0: [drm:intel_power_well_enable [i915]] enabling DC_off
<7> [82.132944] i915 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [i915]] Setting DC state from 02 to 00
<7> [82.161095] i915 0000:00:02.0: [drm:intel_power_well_disable [i915]] disabling DC_off
<7> [82.161641] i915 0000:00:02.0: [drm:skl_enable_dc6 [i915]] Enabling DC6
<7> [82.162197] i915 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [i915]] Setting DC state from 00 to 02
<7> [82.243199] i915 0000:00:02.0: [drm:intel_power_well_enable [i915]] enabling DC_off
<7> [82.243881] i915 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [i915]] Setting DC state from 02 to 00
<7> [82.271454] i915 0000:00:02.0: [drm:intel_power_well_disable [i915]] disabling DC_off
<7> [82.272035] i915 0000:00:02.0: [drm:skl_enable_dc6 [i915]] Enabling DC6
<7> [82.272613] i915 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [i915]] Setting DC state from 00 to 02
<7> [82.354490] i915 0000:00:02.0: [drm:intel_power_well_enable [i915]] enabling DC_off
<7> [82.355214] i915 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [i915]] Setting DC state from 02 to 00
<7> [82.382514] i915 0000:00:02.0: [drm:intel_power_well_disable [i915]] disabling DC_off
<7> [82.383101] i915 0000:00:02.0: [drm:skl_enable_dc6 [i915]] Enabling DC6
<7> [82.383665] i915 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [i915]] Setting DC state from 00 to 02
<7> [82.465475] i915 0000:00:02.0: [drm:intel_power_well_enable [i915]] enabling DC_off
<7> [82.466177] i915 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [i915]] Setting DC state from 02 to 00
<7> [82.492740] i915 0000:00:02.0: [drm:intel_power_well_disable [i915]] disabling DC_off
<7> [82.493336] i915 0000:00:02.0: [drm:skl_enable_dc6 [i915]] Enabling DC6
<7> [82.493914] i915 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [i915]] Setting DC state from 00 to 02
<7> [82.576619] i915 0000:00:02.0: [drm:intel_power_well_enable [i915]] enabling DC_off
<7> [82.577249] i915 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [i915]] Setting DC state from 02 to 00
<7> [82.604022] i915 0000:00:02.0: [drm:intel_power_well_disable [i915]] disabling DC_off
<7> [82.604610] i915 0000:00:02.0: [drm:skl_enable_dc6 [i915]] Enabling DC6
<7> [82.605149] i915 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [i915]] Setting DC state from 00 to 02
<7> [82.687971] i915 0000:00:02.0: [drm:intel_power_well_enable [i915]] enabling DC_off
<7> [82.688674] i915 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [i915]] Setting DC state from 02 to 00
<7> [82.715286] i915 0000:00:02.0: [drm:intel_power_well_disable [i915]] disabling DC_off
<7> [82.716134] i915 0000:00:02.0: [drm:skl_enable_dc6 [i915]] Enabling DC6
<7> [82.716821] i915 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [i915]] Setting DC state from 00 to 02
<7> [82.798974] i915 0000:00:02.0: [drm:intel_power_well_enable [i915]] enabling DC_off
<7> [82.799662] i915 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [i915]] Setting DC state from 02 to 00
<7> [82.826450] i915 0000:00:02.0: [drm:intel_power_well_disable [i915]] disabling DC_off
<7> [82.827003] i915 0000:00:02.0: [drm:skl_enable_dc6 [i915]] Enabling DC6
<7> [82.827540] i915 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [i915]] Setting DC state from 00 to 02
<7> [82.909904] i915 0000:00:02.0: [drm:intel_power_well_enable [i915]] enabling DC_off
<7> [82.910490] i915 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [i915]] Setting DC state from 02 to 00
<7> [82.938661] i915 0000:00:02.0: [drm:intel_power_well_disable [i915]] disabling DC_off
<7> [82.939304] i915 0000:00:02.0: [drm:skl_enable_dc6 [i915]] Enabling DC6
<7> [82.940025] i915 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [i915]] Setting DC state from 00 to 02
<7> [83.021033] i915 0000:00:02.0: [drm:intel_power_well_enable [i915]] enabling DC_off
<7> [83.021647] i915 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [i915]] Setting DC state from 02 to 00
<7> [83.048844] i915 0000:00:02.0: [drm:intel_power_well_disable [i915]] disabling DC_off
<7> [83.049455] i915 0000:00:02.0: [drm:skl_enable_dc6 [i915]] Enabling DC6
<7> [83.050000] i915 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [i915]] Setting DC state from 00 to 02
<7> [83.132076] i915 0000:00:02.0: [drm:intel_power_well_enable [i915]] enabling DC_off
<7> [83.132792] i915 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [i915]] Setting DC state from 02 to 00
<7> [83.160123] i915 0000:00:02.0: [drm:intel_power_well_disable [i915]] disabling DC_off
<7> [83.160764] i915 0000:00:02.0: [drm:skl_enable_dc6 [i915]] Enabling DC6
<7> [83.161392] i915 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [i915]] Setting DC state from 00 to 02
<7> [83.243374] i915 0000:00:02.0: [drm:intel_power_well_enable [i915]] enabling DC_off
<7> [83.244142] i915 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [i915]] Setting DC state from 02 to 00
<7> [83.271413] i915 0000:00:02.0: [drm:intel_power_well_disable [i915]] disabling DC_off
<7> [83.272012] i915 0000:00:02.0: [drm:skl_enable_dc6 [i915]] Enabling DC6
<7> [83.272546] i915 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [i915]] Setting DC state from 00 to 02
<7> [83.353877] i915 0000:00:02.0: [drm:intel_power_well_enable [i915]] enabling DC_off
<7> [83.354486] i915 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [i915]] Setting DC state from 02 to 00
<7> [83.381697] i915 0000:00:02.0: [drm:intel_power_well_disable [i915]] disabling DC_off
<7> [83.382327] i915 0000:00:02.0: [drm:skl_enable_dc6 [i915]] Enabling DC6
<7> [83.382955] i915 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [i915]] Setting DC state from 00 to 02
<7> [83.465450] i915 0000:00:02.0: [drm:intel_power_well_enable [i915]] enabling DC_off
<7> [83.466209] i915 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [i915]] Setting DC state from 02 to 00
<7> [83.493941] i915 0000:00:02.0: [drm:intel_power_well_disable [i915]] disabling DC_off
<7> [83.494536] i915 0000:00:02.0: [drm:skl_enable_dc6 [i915]] Enabling DC6
<7> [83.495076] i915 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [i915]] Setting DC state from 00 to 02
<7> [83.576841] i915 0000:00:02.0: [drm:intel_power_well_enable [i915]] enabling DC_off
<7> [83.577708] i915 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [i915]] Setting DC state from 02 to 00
<7> [83.604328] i915 0000:00:02.0: [drm:intel_power_well_disable [i915]] disabling DC_off
<7> [83.604933] i915 0000:00:02.0: [drm:skl_enable_dc6 [i915]] Enabling DC6
<7> [83.605518] i915 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [i915]] Setting DC state from 00 to 02
<7> [83.687593] i915 0000:00:02.0: [drm:intel_power_well_enable [i915]] enabling DC_off
<7> [83.688285] i915 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [i915]] Setting DC state from 02 to 00
<7> [83.715559] i915 0000:00:02.0: [drm:intel_power_well_disable [i915]] disabling DC_off
<7> [83.716158] i915 0000:00:02.0: [drm:skl_enable_dc6 [i915]] Enabling DC6
<7> [83.716687] i915 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [i915]] Setting DC state from 00 to 02
<7> [83.798247] i915 0000:00:02.0: [drm:intel_power_well_enable [i915]] enabling DC_off
<7> [83.798782] i915 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [i915]] Setting DC state from 02 to 00
<7> [83.826844] i915 0000:00:02.0: [drm:intel_power_well_disable [i915]] disabling DC_off
<7> [83.827360] i915 0000:00:02.0: [drm:skl_enable_dc6 [i915]] Enabling DC6
<7> [83.827857] i915 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [i915]] Setting DC state from 00 to 02
<7> [83.909864] i915 0000:00:02.0: [drm:intel_power_well_enable [i915]] enabling DC_off
<7> [83.910462] i915 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [i915]] Setting DC state from 02 to 00
<7> [83.938232] i915 0000:00:02.0: [drm:intel_power_well_disable [i915]] disabling DC_off
<7> [83.938801] i915 0000:00:02.0: [drm:skl_enable_dc6 [i915]] Enabling DC6
<7> [83.939162] i915 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [i915]] Setting DC state from 00 to 02
<7> [84.021028] i915 0000:00:02.0: [drm:intel_power_well_enable [i915]] enabling DC_off
<7> [84.021696] i915 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [i915]] Setting DC state from 02 to 00
<7> [84.048547] i915 0000:00:02.0: [drm:intel_power_well_disable [i915]] disabling DC_off
<7> [84.049112] i915 0000:00:02.0: [drm:skl_enable_dc6 [i915]] Enabling DC6
<7> [84.049675] i915 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [i915]] Setting DC state from 00 to 02
<7> [84.132175] i915 0000:00:02.0: [drm:intel_power_well_enable [i915]] enabling DC_off
<7> [84.132851] i915 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [i915]] Setting DC state from 02 to 00
<7> [84.159870] i915 0000:00:02.0: [drm:intel_power_well_disable [i915]] disabling DC_off
<7> [84.160416] i915 0000:00:02.0: [drm:skl_enable_dc6 [i915]] Enabling DC6
<7> [84.160998] i915 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [i915]] Setting DC state from 00 to 02
<7> [84.243427] i915 0000:00:02.0: [drm:intel_power_well_enable [i915]] enabling DC_off
<7> [84.244088] i915 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [i915]] Setting DC state from 02 to 00
<7> [84.271327] i915 0000:00:02.0: [drm:intel_power_well_disable [i915]] disabling DC_off
<7> [84.271878] i915 0000:00:02.0: [drm:skl_enable_dc6 [i915]] Enabling DC6
<7> [84.272413] i915 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [i915]] Setting DC state from 00 to 02
<7> [84.354340] i915 0000:00:02.0: [drm:intel_power_well_enable [i915]] enabling DC_off
<7> [84.355004] i915 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [i915]] Setting DC state from 02 to 00
<7> [84.382640] i915 0000:00:02.0: [drm:intel_power_well_disable [i915]] disabling DC_off
<7> [84.383220] i915 0000:00:02.0: [drm:skl_enable_dc6 [i915]] Enabling DC6
<7> [84.383783] i915 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [i915]] Setting DC state from 00 to 02
<7> [84.465381] i915 0000:00:02.0: [drm:intel_power_well_enable [i915]] enabling DC_off
<7> [84.465989] i915 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [i915]] Setting DC state from 02 to 00
<7> [84.494022] i915 0000:00:02.0: [drm:intel_power_well_disable [i915]] disabling DC_off
<7> [84.494611] i915 0000:00:02.0: [drm:skl_enable_dc6 [i915]] Enabling DC6
<7> [84.495156] i915 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [i915]] Setting DC state from 00 to 02
<7> [84.576739] i915 0000:00:02.0: [drm:intel_power_well_enable [i915]] enabling DC_off
<7> [84.577364] i915 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [i915]] Setting DC state from 02 to 00
<7> [84.605438] i915 0000:00:02.0: [drm:intel_power_well_disable [i915]] disabling DC_off
<7> [84.606082] i915 0000:00:02.0: [drm:skl_enable_dc6 [i915]] Enabling DC6
<7> [84.606747] i915 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [i915]] Setting DC state from 00 to 02
<7> [84.687784] i915 0000:00:02.0: [drm:intel_power_well_enable [i915]] enabling DC_off
<7> [84.688483] i915 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [i915]] Setting DC state from 02 to 00
<7> [84.715822] i915 0000:00:02.0: [drm:intel_power_well_disable [i915]] disabling DC_off
<7> [84.716366] i915 0000:00:02.0: [drm:skl_enable_dc6 [i915]] Enabling DC6
<7> [84.716931] i915 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [i915]] Setting DC state from 00 to 02
<7> [84.798756] i915 0000:00:02.0: [drm:intel_power_well_enable [i915]] enabling DC_off
<7> [84.799435] i915 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [i915]] Setting DC state from 02 to 00
<7> [84.827357] i915 0000:00:02.0: [drm:intel_power_well_disable [i915]] disabling DC_off
<7> [84.827936] i915 0000:00:02.0: [drm:skl_enable_dc6 [i915]] Enabling DC6
<7> [84.828564] i915 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [i915]] Setting DC state from 00 to 02
<7> [84.910070] i915 0000:00:02.0: [drm:intel_power_well_enable [i915]] enabling DC_off
<7> [84.910761] i915 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [i915]] Setting DC state from 02 to 00
<7> [84.937715] i915 0000:00:02.0: [drm:intel_power_well_disable [i915]] disabling DC_off
<7> [84.938278] i915 0000:00:02.0: [drm:skl_enable_dc6 [i915]] Enabling DC6
<7> [84.938837] i915 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [i915]] Setting DC state from 00 to 02
<6> [85.362289] [IGT] kms_flip: finished subtest B-eDP1, FAIL
Created at 2025-11-13 21:59:47