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

Result: Fail

i915_display_info23 igt_runner23 results23.json results23-xe-load.json guc_logs23.tar i915_display_info_post_exec23 serial_data23 boot23 dmesg23

DetailValue
Duration 26.68 seconds
Hostname 
shard-lnl-8
Igt-Version 
IGT-Version: 2.4-gd28bd0b9e (x86_64) (Linux: 7.1.0-rc3-lgci-xe-xe-pw-166291v1-debug+ x86_64)
Out 
Using IGT_SRANDOM=1778508837 for randomisation
Opened device: /dev/dri/card0
Using monotonic timestamps
Starting subtest: flip-vs-blocking-wf-vblank
Starting dynamic subtest: A-eDP1
  2880x1800: 60 347710 2880 2928 2960 3040 1800 1803 1809 1906 0x48 0xa 
Expected frametime: 16664us; measured 16664.7us +- 3.550us accuracy 0.06%
Event flip: expected 609, counted 620, passrate = 43.55%, encoder type 2
Event vblank: expected 609, counted 620, passrate = 41.94%, encoder type 2
Expected frametime: 16664us; measured 16478.3us +- 12.419us accuracy 0.23%
vblank interval differs from modeline! expected 16664.0us, measured 16478us +- 12.419us, difference 185.7us (15.0 sigma)
Event flip: expected 613, counted 610, passrate = 49.18%, encoder type 2
Event vblank: expected 613, counted 610, passrate = 47.54%, encoder type 2
Stack trace:
  #0 ../lib/igt_core.c:2075 __igt_fail_assert()
  #1 ../tests/kms_flip.c:1071 run_test_on_crtc_set()
  #2 ../tests/kms_flip.c:1920 run_test()
  #3 ../tests/kms_flip.c:2184 __igt_unique____real_main2105()
  #4 ../tests/kms_flip.c:2105 main()
  #5 [__libc_init_first+0x8a]
  #6 [__libc_start_main+0x8b]
  #7 [_start+0x25]
Dynamic subtest A-eDP1: FAIL (26.678s)
Err 
Starting subtest: flip-vs-blocking-wf-vblank
Starting dynamic subtest: A-eDP1
(kms_flip:8895) CRITICAL: Test assertion failure function __run_test_on_crtc_set, file ../tests/kms_flip.c:1722:
(kms_flip:8895) CRITICAL: Failed assertion: !retried
Dynamic subtest A-eDP1 failed.
**** DEBUG ****
(kms_flip:8895) DEBUG: vblank ts/seq: last 368.872101/5428, current 369.037415/5438: elapsed=165290.0us expected=164783.1us +- 823.9us, error 0.3%
(kms_flip:8895) DEBUG: name = flip
last_ts = 368.888641
last_received_ts = 369.036957
last_seq = 5429
current_ts = 369.053925
current_received_ts = 369.202271
current_seq = 5439
count = 17
seq_step = 1
(kms_flip:8895) DEBUG: flip ts/seq: last 368.888641/5429, current 369.053925/5439: elapsed=165287.0us expected=164783.1us +- 823.9us, error 0.3%
(kms_flip:8895) DEBUG: name = vblank
last_ts = 369.037415
last_received_ts = 369.036865
last_seq = 5438
current_ts = 369.202820
current_received_ts = 369.202209
current_seq = 5448
count = 17
seq_step = 10
(kms_flip:8895) DEBUG: vblank ts/seq: last 369.037415/5438, current 369.202820/5448: elapsed=165410.0us expected=164783.1us +- 823.9us, error 0.4%
(kms_flip:8895) DEBUG: name = flip
last_ts = 369.053925
last_received_ts = 369.202271
last_seq = 5439
current_ts = 369.219360
current_received_ts = 369.367737
current_seq = 5449
count = 18
seq_step = 1
(kms_flip:8895) DEBUG: flip ts/seq: last 369.053925/5439, current 369.219360/5449: elapsed=165431.0us expected=164783.1us +- 823.9us, error 0.4%
(kms_flip:8895) DEBUG: name = vblank
last_ts = 369.202820
last_received_ts = 369.202209
last_seq = 5448
current_ts = 369.368256
current_received_ts = 369.367645
current_seq = 5458
count = 18
seq_step = 10
(kms_flip:8895) DEBUG: vblank ts/seq: last 369.202820/5448, current 369.368256/5458: elapsed=165449.0us expected=164783.1us +- 823.9us, error 0.4%
(kms_flip:8895) DEBUG: name = flip
last_ts = 369.219360
last_received_ts = 369.367737
last_seq = 5449
current_ts = 369.384796
current_received_ts = 369.533203
current_seq = 5459
count = 19
seq_step = 1
(kms_flip:8895) DEBUG: flip ts/seq: last 369.219360/5449, current 369.384796/5459: elapsed=165446.0us expected=164783.1us +- 823.9us, error 0.4%
(kms_flip:8895) DEBUG: name = vblank
last_ts = 369.368256
last_received_ts = 369.367645
last_seq = 5458
current_ts = 369.533722
current_received_ts = 369.533142
current_seq = 5468
count = 19
seq_step = 10
(kms_flip:8895) DEBUG: vblank ts/seq: last 369.368256/5458, current 369.533722/5468: elapsed=165448.0us expected=164783.1us +- 823.9us, error 0.4%
(kms_flip:8895) DEBUG: name = flip
last_ts = 369.384796
last_received_ts = 369.533203
last_seq = 5459
current_ts = 369.550262
current_received_ts = 369.698639
current_seq = 5469
count = 20
seq_step = 1
(kms_flip:8895) DEBUG: flip ts/seq: last 369.384796/5459, current 369.550262/5469: elapsed=165454.0us expected=164783.1us +- 823.9us, error 0.4%
(kms_flip:8895) DEBUG: name = vblank
last_ts = 369.533722
last_received_ts = 369.533142
last_seq = 5468
current_ts = 369.699158
current_received_ts = 369.698578
current_seq = 5478
count = 20
seq_step = 10
(kms_flip:8895) DEBUG: vblank ts/seq: last 369.533722/5468, current 369.699158/5478: elapsed=165449.0us expected=164783.1us +- 823.9us, error 0.4%
(kms_flip:8895) DEBUG: name = flip
last_ts = 369.550262
last_received_ts = 369.698639
last_seq = 5469
current_ts = 369.715698
current_received_ts = 369.864136
current_seq = 5479
count = 21
seq_step = 1
(kms_flip:8895) DEBUG: flip ts/seq: last 369.550262/5469, current 369.715698/5479: elapsed=165449.0us expected=164783.1us +- 823.9us, error 0.4%
(kms_flip:8895) DEBUG: name = vblank
last_ts = 369.699158
last_received_ts = 369.698578
last_seq = 5478
current_ts = 369.864624
current_received_ts = 369.864075
current_seq = 5488
count = 21
seq_step = 10
(kms_flip:8895) DEBUG: vblank ts/seq: last 369.699158/5478, current 369.864624/5488: elapsed=165454.0us expected=164783.1us +- 823.9us, error 0.4%
(kms_flip:8895) DEBUG: name = flip
last_ts = 369.715698
last_received_ts = 369.864136
last_seq = 5479
current_ts = 369.881165
current_received_ts = 370.029572
current_seq = 5489
count = 22
seq_step = 1
(kms_flip:8895) DEBUG: flip ts/seq: last 369.715698/5479, current 369.881165/5489: elapsed=165447.0us expected=164783.1us +- 823.9us, error 0.4%
(kms_flip:8895) DEBUG: name = vblank
last_ts = 369.864624
last_received_ts = 369.864075
last_seq = 5488
current_ts = 370.030060
current_received_ts = 370.029480
current_seq = 5498
count = 22
seq_step = 10
(kms_flip:8895) DEBUG: vblank ts/seq: last 369.864624/5488, current 370.030060/5498: elapsed=165442.0us expected=164783.1us +- 823.9us, error 0.4%
(kms_flip:8895) DEBUG: name = flip
last_ts = 369.881165
last_received_ts = 370.029572
last_seq = 5489
current_ts = 370.046600
current_received_ts = 370.195129
current_seq = 5499
count = 23
seq_step = 1
(kms_flip:8895) DEBUG: flip ts/seq: last 369.881165/5489, current 370.046600/5499: elapsed=165447.0us expected=164783.1us +- 823.9us, error 0.4%
(kms_flip:8895) DEBUG: name = vblank
last_ts = 370.030060
last_received_ts = 370.029480
last_seq = 5498
current_ts = 370.195618
current_received_ts = 370.195068
current_seq = 5508
count = 23
seq_step = 10
(kms_flip:8895) DEBUG: vblank ts/seq: last 370.030060/5498, current 370.195618/5508: elapsed=165558.0us expected=164783.1us +- 823.9us, error 0.5%
(kms_flip:8895) DEBUG: name = flip
last_ts = 370.046600
last_received_ts = 370.195129
last_seq = 5499
current_ts = 370.212158
current_received_ts = 370.360657
current_seq = 5509
count = 24
seq_step = 1
(kms_flip:8895) DEBUG: flip ts/seq: last 370.046600/5499, current 370.212158/5509: elapsed=165568.0us expected=164783.1us +- 823.9us, error 0.5%
(kms_flip:8895) DEBUG: name = vblank
last_ts = 370.195618
last_received_ts = 370.195068
last_seq = 5508
current_ts = 370.361206
current_received_ts = 370.360596
current_seq = 5518
count = 24
seq_step = 10
(kms_flip:8895) DEBUG: vblank ts/seq: last 370.195618/5508, current 370.361206/5518: elapsed=165587.0us expected=164783.1us +- 823.9us, error 0.5%
(kms_flip:8895) DEBUG: name = flip
last_ts = 370.212158
last_received_ts = 370.360657
last_seq = 5509
current_ts = 370.377747
current_received_ts = 370.526245
current_seq = 5519
count = 25
seq_step = 1
(kms_flip:8895) DEBUG: flip ts/seq: last 370.212158/5509, current 370.377747/5519: elapsed=165587.0us expected=164783.1us +- 823.9us, error 0.5%
(kms_flip:8895) DEBUG: name = vblank
last_ts = 370.361206
last_received_ts = 370.360596
last_seq = 5518
current_ts = 370.526794
current_received_ts = 370.526184
current_seq = 5528
count = 25
seq_step = 10
(kms_flip:8895) DEBUG: vblank ts/seq: last 370.361206/5518, current 370.526794/5528: elapsed=165587.0us expected=164783.1us +- 823.9us, error 0.5%
(kms_flip:8895) DEBUG: name = flip
last_ts = 370.377747
last_received_ts = 370.526245
last_seq = 5519
current_ts = 370.543335
current_received_ts = 370.691833
current_seq = 5529
count = 26
seq_step = 1
(kms_flip:8895) DEBUG: flip ts/seq: last 370.377747/5519, current 370.543335/5529: elapsed=165591.0us expected=164783.1us +- 823.9us, error 0.5%
(kms_flip:8895) DEBUG: name = vblank
last_ts = 370.526794
last_received_ts = 370.526184
last_seq = 5528
current_ts = 370.692383
current_received_ts = 370.691772
current_seq = 5538
count = 26
seq_step = 10
(kms_flip:8895) DEBUG: vblank ts/seq: last 370.526794/5528, current 370.692383/5538: elapsed=165590.0us expected=164783.1us +- 823.9us, error 0.5%
(kms_flip:8895) DEBUG: name = flip
last_ts = 370.543335
last_received_ts = 370.691833
last_seq = 5529
current_ts = 370.708923
current_received_ts = 370.857452
current_seq = 5539
count = 27
seq_step = 1
(kms_flip:8895) DEBUG: flip ts/seq: last 370.543335/5529, current 370.708923/5539: elapsed=165587.0us expected=164783.1us +- 823.9us, error 0.5%
(kms_flip:8895) DEBUG: name = vblank
last_ts = 370.692383
last_received_ts = 370.691772
last_seq = 5538
current_ts = 370.857971
current_received_ts = 370.857391
current_seq = 5548
count = 27
seq_step = 10
(kms_flip:8895) DEBUG: vblank ts/seq: last 370.692383/5538, current 370.857971/5548: elapsed=165588.0us expected=164783.1us +- 823.9us, error 0.5%
(kms_flip:8895) DEBUG: name = flip
last_ts = 370.708923
last_received_ts = 370.857452
last_seq = 5539
current_ts = 370.874512
current_received_ts = 371.023071
current_seq = 5549
count = 28
seq_step = 1
(kms_flip:8895) DEBUG: flip ts/seq: last 370.708923/5539, current 370.874512/5549: elapsed=165583.0us expected=164783.1us +- 823.9us, error 0.5%
(kms_flip:8895) DEBUG: name = vblank
last_ts = 370.857971
last_received_ts = 370.857391
last_seq = 5548
current_ts = 371.023560
current_received_ts = 371.022949
current_seq = 5558
count = 28
seq_step = 10
(kms_flip:8895) DEBUG: vblank ts/seq: last 370.857971/5548, current 371.023560/5558: elapsed=165586.0us expected=164783.1us +- 823.9us, error 0.5%
(kms_flip:8895) DEBUG: name = flip
last_ts = 370.874512
last_received_ts = 371.023071
last_seq = 5549
current_ts = 371.040100
current_received_ts = 371.188721
current_seq = 5559
count = 29
seq_step = 1
(kms_flip:8895) DEBUG: flip ts/seq: last 370.874512/5549, current 371.040100/5559: elapsed=165592.0us expected=164783.1us +- 823.9us, error 0.5%
(kms_flip:8895) DEBUG: name = vblank
last_ts = 371.023560
last_received_ts = 371.022949
last_seq = 5558
current_ts = 371.189209
current_received_ts = 371.188660
current_seq = 5568
count = 29
seq_step = 10
(kms_flip:8895) DEBUG: vblank ts/seq: last 371.023560/5558, current 371.189209/5568: elapsed=165668.0us expected=164783.1us +- 823.9us, error 0.5%
(kms_flip:8895) DEBUG: inconsistent vblank ts/seq: last 371.023560/5558, current 371.189209/5568: elapsed=165668.0us expected=164783.1us
(kms_flip:8895) DEBUG: name = flip
last_ts = 371.040100
last_received_ts = 371.188721
last_seq = 5559
current_ts = 371.205780
current_received_ts = 371.354401
current_seq = 5569
count = 30
seq_step = 1
(kms_flip:8895) DEBUG: flip ts/seq: last 371.040100/5559, current 371.205780/5569: elapsed=165683.0us expected=164783.1us +- 823.9us, error 0.5%
(kms_flip:8895) DEBUG: inconsistent flip ts/seq: last 371.040100/5559, current 371.205780/5569: elapsed=165683.0us expected=164783.1us
(kms_flip:8895) DEBUG: name = vblank
last_ts = 371.189209
last_received_ts = 371.188660
last_seq = 5568
current_ts = 371.354919
current_received_ts = 371.354340
current_seq = 5578
count = 30
seq_step = 10
(kms_flip:8895) DEBUG: vblank ts/seq: last 371.189209/5568, current 371.354919/5578: elapsed=165711.0us expected=164783.1us +- 823.9us, error 0.6%
(kms_flip:8895) DEBUG: inconsistent vblank ts/seq: last 371.189209/5568, current 371.354919/5578: elapsed=165711.0us expected=164783.1us
(kms_flip:8895) DEBUG: name = flip
last_ts = 371.205780
last_received_ts = 371.354401
last_seq = 5569
current_ts = 371.371490
current_received_ts = 371.520172
current_seq = 5579
count = 31
seq_step = 1
(kms_flip:8895) DEBUG: flip ts/seq: last 371.205780/5569, current 371.371490/5579: elapsed=165706.0us expected=164783.1us +- 823.9us, error 0.6%
(kms_flip:8895) DEBUG: inconsistent flip ts/seq: last 371.205780/5569, current 371.371490/5579: elapsed=165706.0us expected=164783.1us
(kms_flip:8895) DEBUG: name = vblank
last_ts = 371.354919
last_received_ts = 371.354340
last_seq = 5578
current_ts = 371.520630
current_received_ts = 371.520081
current_seq = 5588
count = 31
seq_step = 10
(kms_flip:8895) DEBUG: vblank ts/seq: last 371.354919/5578, current 371.520630/5588: elapsed=165708.0us expected=164783.1us +- 823.9us, error 0.6%
(kms_flip:8895) DEBUG: inconsistent vblank ts/seq: last 371.354919/5578, current 371.520630/5588: elapsed=165708.0us expected=164783.1us
(kms_flip:8895) DEBUG: name = flip
last_ts = 371.371490
last_received_ts = 371.520172
last_seq = 5579
current_ts = 371.537201
current_received_ts = 371.685822
current_seq = 5589
count = 32
seq_step = 1
(kms_flip:8895) DEBUG: flip ts/seq: last 371.371490/5579, current 371.537201/5589: elapsed=165710.0us expected=164783.1us +- 823.9us, error 0.6%
(kms_flip:8895) DEBUG: inconsistent flip ts/seq: last 371.371490/5579, current 371.537201/5589: elapsed=165710.0us expected=164783.1us
(kms_flip:8895) DEBUG: name = vblank
last_ts = 371.520630
last_received_ts = 371.520081
last_seq = 5588
current_ts = 371.686340
current_received_ts = 371.685760
current_seq = 5598
count = 32
seq_step = 10
(kms_flip:8895) DEBUG: vblank ts/seq: last 371.520630/5588, current 371.686340/5598: elapsed=165713.0us expected=164783.1us +- 823.9us, error 0.6%
(kms_flip:8895) DEBUG: inconsistent vblank ts/seq: last 371.520630/5588, current 371.686340/5598: elapsed=165713.0us expected=164783.1us
(kms_flip:8895) DEBUG: name = flip
last_ts = 371.537201
last_received_ts = 371.685822
last_seq = 5589
current_ts = 371.702911
current_received_ts = 371.851562
current_seq = 5599
count = 33
seq_step = 1
(kms_flip:8895) DEBUG: flip ts/seq: last 371.537201/5589, current 371.702911/5599: elapsed=165714.0us expected=164783.1us +- 823.9us, error 0.6%
(kms_flip:8895) DEBUG: inconsistent flip ts/seq: last 371.537201/5589, current 371.702911/5599: elapsed=165714.0us expected=164783.1us
(kms_flip:8895) DEBUG: name = vblank
last_ts = 371.686340
last_received_ts = 371.685760
last_seq = 5598
current_ts = 371.852051
current_received_ts = 371.851471
current_seq = 5608
count = 33
seq_step = 10
(kms_flip:8895) DEBUG: vblank ts/seq: last 371.686340/5598, current 371.852051/5608: elapsed=165701.0us expected=164783.1us +- 823.9us, error 0.6%
(kms_flip:8895) DEBUG: inconsistent vblank ts/seq: last 371.686340/5598, current 371.852051/5608: elapsed=165701.0us expected=164783.1us
(kms_flip:8895) DEBUG: name = flip
last_ts = 371.702911
last_received_ts = 371.851562
last_seq = 5599
current_ts = 371.868622
current_received_ts = 372.017212
current_seq = 5609
count = 34
seq_step = 1
(kms_flip:8895) DEBUG: flip ts/seq: last 371.702911/5599, current 371.868622/5609: elapsed=165704.0us expected=164783.1us +- 823.9us, error 0.6%
(kms_flip:8895) DEBUG: inconsistent flip ts/seq: last 371.702911/5599, current 371.868622/5609: elapsed=165704.0us expected=164783.1us
(kms_flip:8895) DEBUG: name = vblank
last_ts = 371.852051
last_received_ts = 371.851471
last_seq = 5608
current_ts = 372.017761
current_received_ts = 372.017151
current_seq = 5618
count = 34
seq_step = 10
(kms_flip:8895) DEBUG: vblank ts/seq: last 371.852051/5608, current 372.017761/5618: elapsed=165711.0us expected=164783.1us +- 823.9us, error 0.6%
(kms_flip:8895) DEBUG: inconsistent vblank ts/seq: last 371.852051/5608, current 372.017761/5618: elapsed=165711.0us expected=164783.1us
(kms_flip:8895) DEBUG: name = flip
last_ts = 371.868622
last_received_ts = 372.017212
last_seq = 5609
current_ts = 372.034332
current_received_ts = 372.183105
current_seq = 5619
count = 35
seq_step = 1
(kms_flip:8895) DEBUG: flip ts/seq: last 371.868622/5609, current 372.034332/5619: elapsed=165711.0us expected=164783.1us +- 823.9us, error 0.6%
(kms_flip:8895) DEBUG: inconsistent flip ts/seq: last 371.868622/5609, current 372.034332/5619: elapsed=165711.0us expected=164783.1us
(kms_flip:8895) DEBUG: name = vblank
last_ts = 372.017761
last_received_ts = 372.017151
last_seq = 5618
current_ts = 372.183533
current_received_ts = 372.182983
current_seq = 5628
count = 35
seq_step = 10
(kms_flip:8895) DEBUG: vblank ts/seq: last 372.017761/5618, current 372.183533/5628: elapsed=165777.0us expected=164783.1us +- 823.9us, error 0.6%
(kms_flip:8895) DEBUG: inconsistent vblank ts/seq: last 372.017761/5618, current 372.183533/5628: elapsed=165777.0us expected=164783.1us
(kms_flip:8895) DEBUG: name = flip
last_ts = 372.034332
last_received_ts = 372.183105
last_seq = 5619
current_ts = 372.200134
current_received_ts = 372.348846
current_seq = 5629
count = 36
seq_step = 1
(kms_flip:8895) DEBUG: flip ts/seq: last 372.034332/5619, current 372.200134/5629: elapsed=165784.0us expected=164783.1us +- 823.9us, error 0.6%
(kms_flip:8895) DEBUG: inconsistent flip ts/seq: last 372.034332/5619, current 372.200134/5629: elapsed=165784.0us expected=164783.1us
(kms_flip:8895) DEBUG: name = vblank
last_ts = 372.183533
last_received_ts = 372.182983
last_seq = 5628
current_ts = 372.349365
current_received_ts = 372.348755
current_seq = 5638
count = 36
seq_step = 10
(kms_flip:8895) DEBUG: vblank ts/seq: last 372.183533/5628, current 372.349365/5638: elapsed=165821.0us expected=164783.1us +- 823.9us, error 0.6%
(kms_flip:8895) DEBUG: inconsistent vblank ts/seq: last 372.183533/5628, current 372.349365/5638: elapsed=165821.0us expected=164783.1us
(kms_flip:8895) DEBUG: name = flip
last_ts = 372.200134
last_received_ts = 372.348846
last_seq = 5629
current_ts = 372.365936
current_received_ts = 372.514679
current_seq = 5639
count = 37
seq_step = 1
(kms_flip:8895) DEBUG: flip ts/seq: last 372.200134/5629, current 372.365936/5639: elapsed=165817.0us expected=164783.1us +- 823.9us, error 0.6%
(kms_flip:8895) DEBUG: inconsistent flip ts/seq: last 372.200134/5629, current 372.365936/5639: elapsed=165817.0us expected=164783.1us
(kms_flip:8895) DEBUG: name = vblank
last_ts = 372.349365
last_received_ts = 372.348755
last_seq = 5638
current_ts = 372.515167
current_received_ts = 372.514587
current_seq = 5648
count = 37
seq_step = 10
(kms_flip:8895) DEBUG: vblank ts/seq: last 372.349365/5638, current 372.515167/5648: elapsed=165815.0us expected=164783.1us +- 823.9us, error 0.6%
(kms_flip:8895) DEBUG: inconsistent vblank ts/seq: last 372.349365/5638, current 372.515167/5648: elapsed=165815.0us expected=164783.1us
(kms_flip:8895) DEBUG: name = flip
last_ts = 372.365936
last_received_ts = 372.514679
last_seq = 5639
current_ts = 372.531769
current_received_ts = 372.680450
current_seq = 5649
count = 38
seq_step = 1
(kms_flip:8895) DEBUG: flip ts/seq: last 372.365936/5639, current 372.531769/5649: elapsed=165815.0us expected=164783.1us +- 823.9us, error 0.6%
(kms_flip:8895) DEBUG: inconsistent flip ts/seq: last 372.365936/5639, current 372.531769/5649: elapsed=165815.0us expected=164783.1us
(kms_flip:8895) DEBUG: name = vblank
last_ts = 372.515167
last_received_ts = 372.514587
last_seq = 5648
current_ts = 372.681000
current_received_ts = 372.680389
current_seq = 5658
count = 38
seq_step = 10
(kms_flip:8895) DEBUG: vblank ts/seq: last 372.515167/5648, current 372.681000/5658: elapsed=165815.0us expected=164783.1us +- 823.9us, error 0.6%
(kms_flip:8895) DEBUG: inconsistent vblank ts/seq: last 372.515167/5648, current 372.681000/5658: elapsed=165815.0us expected=164783.1us
(kms_flip:8895) DEBUG: name = flip
last_ts = 372.531769
last_received_ts = 372.680450
last_seq = 5649
current_ts = 372.697571
current_received_ts = 372.846283
current_seq = 5659
count = 39
seq_step = 1
(kms_flip:8895) DEBUG: flip ts/seq: last 372.531769/5649, current 372.697571/5659: elapsed=165814.0us expected=164783.1us +- 823.9us, error 0.6%
(kms_flip:8895) DEBUG: inconsistent flip ts/seq: last 372.531769/5649, current 372.697571/5659: elapsed=165814.0us expected=164783.1us
(kms_flip:8895) DEBUG: name = vblank
last_ts = 372.681000
last_received_ts = 372.680389
last_seq = 5658
current_ts = 372.846802
current_received_ts = 372.846191
current_seq = 5668
count = 39
seq_step = 10
(kms_flip:8895) DEBUG: vblank ts/seq: last 372.681000/5658, current 372.846802/5668: elapsed=165813.0us expected=164783.1us +- 823.9us, error 0.6%
(kms_flip:8895) DEBUG: inconsistent vblank ts/seq: last 372.681000/5658, current 372.846802/5668: elapsed=165813.0us expected=164783.1us
(kms_flip:8895) DEBUG: name = flip
last_ts = 372.697571
last_received_ts = 372.846283
last_seq = 5659
current_ts = 372.863373
current_received_ts = 373.012146
current_seq = 5669
count = 40
seq_step = 1
(kms_flip:8895) DEBUG: flip ts/seq: last 372.697571/5659, current 372.863373/5669: elapsed=165819.0us expected=164783.1us +- 823.9us, error 0.6%
(kms_flip:8895) DEBUG: inconsistent flip ts/seq: last 372.697571/5659, current 372.863373/5669: elapsed=165819.0us expected=164783.1us
(kms_flip:8895) DEBUG: name = vblank
last_ts = 372.846802
last_received_ts = 372.846191
last_seq = 5668
current_ts = 373.012604
current_received_ts = 373.012085
current_seq = 5678
count = 40
seq_step = 10
(kms_flip:8895) DEBUG: vblank ts/seq: last 372.846802/5668, current 373.012604/5678: elapsed=165814.0us expected=164783.1us +- 823.9us, error 0.6%
(kms_flip:8895) DEBUG: inconsistent vblank ts/seq: last 372.846802/5668, current 373.012604/5678: elapsed=165814.0us expected=164783.1us
(kms_flip:8895) DEBUG: name = flip
last_ts = 372.863373
last_received_ts = 373.012146
last_seq = 5669
current_ts = 373.029205
current_received_ts = 373.177856
current_seq = 5679
count = 41
seq_step = 1
(kms_flip:8895) DEBUG: flip ts/seq: last 372.863373/5669, current 373.029205/5679: elapsed=165809.0us expected=164783.1us +- 823.9us, error 0.6%
(kms_flip:8895) DEBUG: inconsistent flip ts/seq: last 372.863373/5669, current 373.029205/5679: elapsed=165809.0us expected=164783.1us
(kms_flip:8895) DEBUG: name = vblank
last_ts = 373.012604
last_received_ts = 373.012085
last_seq = 5678
current_ts = 373.178497
current_received_ts = 373.177795
current_seq = 5688
count = 41
seq_step = 10
(kms_flip:8895) DEBUG: vblank ts/seq: last 373.012604/5678, current 373.178497/5688: elapsed=165868.0us expected=164783.1us +- 823.9us, error 0.7%
(kms_flip:8895) DEBUG: inconsistent vblank ts/seq: last 373.012604/5678, current 373.178497/5688: elapsed=165868.0us expected=164783.1us
(kms_flip:8895) DEBUG: name = flip
last_ts = 373.029205
last_received_ts = 373.177856
last_seq = 5679
current_ts = 373.195068
current_received_ts = 373.343872
current_seq = 5689
count = 42
seq_step = 1
(kms_flip:8895) DEBUG: flip ts/seq: last 373.029205/5679, current 373.195068/5689: elapsed=165882.0us expected=164783.1us +- 823.9us, error 0.7%
(kms_flip:8895) DEBUG: inconsistent flip ts/seq: last 373.029205/5679, current 373.195068/5689: elapsed=165882.0us expected=164783.1us
(kms_flip:8895) DEBUG: name = vblank
last_ts = 373.178497
last_received_ts = 373.177795
last_seq = 5688
current_ts = 373.344391
current_received_ts = 373.343811
current_seq = 5698
count = 42
seq_step = 10
(kms_flip:8895) DEBUG: vblank ts/seq: last 373.178497/5688, current 373.344391/5698: elapsed=165914.0us expected=164783.1us +- 823.9us, error 0.7%
(kms_flip:8895) DEBUG: inconsistent vblank ts/seq: last 373.178497/5688, current 373.344391/5698: elapsed=165914.0us expected=164783.1us
(kms_flip:8895) DEBUG: name = flip
last_ts = 373.195068
last_received_ts = 373.343872
last_seq = 5689
current_ts = 373.360992
current_received_ts = 373.509796
current_seq = 5699
count = 43
seq_step = 1
(kms_flip:8895) DEBUG: flip ts/seq: last 373.195068/5689, current 373.360992/5699: elapsed=165912.0us expected=164783.1us +- 823.9us, error 0.7%
(kms_flip:8895) DEBUG: inconsistent flip ts/seq: last 373.195068/5689, current 373.360992/5699: elapsed=165912.0us expected=164783.1us
(kms_flip:8895) DEBUG: name = vblank
last_ts = 373.344391
last_received_ts = 373.343811
last_seq = 5698
current_ts = 373.510315
current_received_ts = 373.509705
current_seq = 5708
count = 43
seq_step = 10
(kms_flip:8895) DEBUG: vblank ts/seq: last 373.344391/5698, current 373.510315/5708: elapsed=165905.0us expected=164783.1us +- 823.9us, error 0.7%
(kms_flip:8895) DEBUG: inconsistent vblank ts/seq: last 373.344391/5698, current 373.510315/5708: elapsed=165905.0us expected=164783.1us
(kms_flip:8895) DEBUG: name = flip
last_ts = 373.360992
last_received_ts = 373.509796
last_seq = 5699
current_ts = 373.526886
current_received_ts = 373.675690
current_seq = 5709
count = 44
seq_step = 1
(kms_flip:8895) DEBUG: flip ts/seq: last 373.360992/5699, current 373.526886/5709: elapsed=165904.0us expected=164783.1us +- 823.9us, error 0.7%
(kms_flip:8895) DEBUG: inconsistent flip ts/seq: last 373.360992/5699, current 373.526886/5709: elapsed=165904.0us expected=164783.1us
(kms_flip:8895) DEBUG: name = vblank
last_ts = 373.510315
last_received_ts = 373.509705
last_seq = 5708
current_ts = 373.676208
current_received_ts = 373.675598
current_seq = 5718
count = 44
seq_step = 10
(kms_flip:8895) DEBUG: vblank ts/seq: last 373.510315/5708, current 373.676208/5718: elapsed=165910.0us expected=164783.1us +- 823.9us, error 0.7%
(kms_flip:8895) DEBUG: inconsistent vblank ts/seq: last 373.510315/5708, current 373.676208/5718: elapsed=165910.0us expected=164783.1us
(kms_flip:8895) DEBUG: name = flip
last_ts = 373.526886
last_received_ts = 373.675690
last_seq = 5709
current_ts = 373.692810
current_received_ts = 373.841614
current_seq = 5719
count = 45
seq_step = 1
(kms_flip:8895) DEBUG: flip ts/seq: last 373.526886/5709, current 373.692810/5719: elapsed=165911.0us expected=164783.1us +- 823.9us, error 0.7%
(kms_flip:8895) DEBUG: inconsistent flip ts/seq: last 373.526886/5709, current 373.692810/5719: elapsed=165911.0us expected=164783.1us
(kms_flip:8895) DEBUG: name = vblank
last_ts = 373.676208
last_received_ts = 373.675598
last_seq = 5718
current_ts = 373.842133
current_received_ts = 373.841522
current_seq = 5728
count = 45
seq_step = 10
(kms_flip:8895) DEBUG: vblank ts/seq: last 373.676208/5718, current 373.842133/5728: elapsed=165902.0us expected=164783.1us +- 823.9us, error 0.7%
(kms_flip:8895) DEBUG: inconsistent vblank ts/seq: last 373.676208/5718, current 373.842133/5728: elapsed=165902.0us expected=164783.1us
(kms_flip:8895) DEBUG: name = flip
last_ts = 373.692810
last_received_ts = 373.841614
last_seq = 5719
current_ts = 373.858704
current_received_ts = 374.007477
current_seq = 5729
count = 46
seq_step = 1
(kms_flip:8895) DEBUG: flip ts/seq: last 373.692810/5719, current 373.858704/5729: elapsed=165908.0us expected=164783.1us +- 823.9us, error 0.7%
(kms_flip:8895) DEBUG: inconsistent flip ts/seq: last 373.692810/5719, current 373.858704/5729: elapsed=165908.0us expected=164783.1us
(kms_flip:8895) DEBUG: name = vblank
last_ts = 373.842133
last_received_ts = 373.841522
last_seq = 5728
current_ts = 374.008026
current_received_ts = 374.007416
current_seq = 5738
count = 46
seq_step = 10
(kms_flip:8895) DEBUG: vblank ts/seq: last 373.842133/5728, current 374.008026/5738: elapsed=165907.0us expected=164783.1us +- 823.9us, error 0.7%
(kms_flip:8895) DEBUG: inconsistent vblank ts/seq: last 373.842133/5728, current 374.008026/5738: elapsed=165907.0us expected=164783.1us
(kms_flip:8895) DEBUG: name = flip
last_ts = 373.858704
last_received_ts = 374.007477
last_seq = 5729
current_ts = 374.024628
current_received_ts = 374.173523
current_seq = 5739
count = 47
seq_step = 1
(kms_flip:8895) DEBUG: flip ts/seq: last 373.858704/5729, current 374.024628/5739: elapsed=165905.0us expected=164783.1us +- 823.9us, error 0.7%
(kms_flip:8895) DEBUG: inconsistent flip ts/seq: last 373.858704/5729, current 374.024628/5739: elapsed=165905.0us expected=164783.1us
(kms_flip:8895) DEBUG: name = vblank
last_ts = 374.008026
last_received_ts = 374.007416
last_seq = 5738
current_ts = 374.173981
current_received_ts = 374.173431
current_seq = 5748
count = 47
seq_step = 10
(kms_flip:8895) DEBUG: vblank ts/seq: last 374.008026/5738, current 374.173981/5748: elapsed=165955.0us expected=164783.1us +- 823.9us, error 0.7%
(kms_flip:8895) DEBUG: inconsistent vblank ts/seq: last 374.008026/5738, current 374.173981/5748: elapsed=165955.0us expected=164783.1us
(kms_flip:8895) DEBUG: name = flip
last_ts = 374.024628
last_received_ts = 374.173523
last_seq = 5739
current_ts = 374.190582
current_received_ts = 374.339355
current_seq = 5749
count = 48
seq_step = 1
(kms_flip:8895) DEBUG: flip ts/seq: last 374.024628/5739, current 374.190582/5749: elapsed=165952.0us expected=164783.1us +- 823.9us, error 0.7%
(kms_flip:8895) DEBUG: inconsistent flip ts/seq: last 374.024628/5739, current 374.190582/5749: elapsed=165952.0us expected=164783.1us
(kms_flip:8895) DEBUG: name = vblank
last_ts = 374.173981
last_received_ts = 374.173431
last_seq = 5748
current_ts = 374.339966
current_received_ts = 374.339264
current_seq = 5758
count = 48
seq_step = 10
(kms_flip:8895) DEBUG: vblank ts/seq: last 374.173981/5748, current 374.339966/5758: elapsed=165987.0us expected=164783.1us +- 823.9us, error 0.7%
(kms_flip:8895) DEBUG: inconsistent vblank ts/seq: last 374.173981/5748, current 374.339966/5758: elapsed=165987.0us expected=164783.1us
(kms_flip:8895) DEBUG: name = flip
last_ts = 374.190582
last_received_ts = 374.339355
last_seq = 5749
current_ts = 374.356567
current_received_ts = 374.505432
current_seq = 5759
count = 49
seq_step = 1
(kms_flip:8895) DEBUG: flip ts/seq: last 374.190582/5749, current 374.356567/5759: elapsed=165993.0us expected=164783.1us +- 823.9us, error 0.7%
(kms_flip:8895) DEBUG: inconsistent flip ts/seq: last 374.190582/5749, current 374.356567/5759: elapsed=165993.0us expected=164783.1us
(kms_flip:8895) DEBUG: name = vblank
last_ts = 374.339966
last_received_ts = 374.339264
last_seq = 5758
current_ts = 374.505951
current_received_ts = 374.505341
current_seq = 5768
count = 49
seq_step = 10
(kms_flip:8895) DEBUG: vblank ts/seq: last 374.339966/5758, current 374.505951/5768: elapsed=165989.0us expected=164783.1us +- 823.9us, error 0.7%
(kms_flip:8895) DEBUG: inconsistent vblank ts/seq: last 374.339966/5758, current 374.505951/5768: elapsed=165989.0us expected=164783.1us
(kms_flip:8895) DEBUG: name = flip
last_ts = 374.356567
last_received_ts = 374.505432
last_seq = 5759
current_ts = 374.522552
current_received_ts = 374.671417
current_seq = 5769
count = 50
seq_step = 1
(kms_flip:8895) DEBUG: flip ts/seq: last 374.356567/5759, current 374.522552/5769: elapsed=165987.0us expected=164783.1us +- 823.9us, error 0.7%
(kms_flip:8895) DEBUG: inconsistent flip ts/seq: last 374.356567/5759, current 374.522552/5769: elapsed=165987.0us expected=164783.1us
(kms_flip:8895) DEBUG: name = vblank
last_ts = 374.505951
last_received_ts = 374.505341
last_seq = 5768
current_ts = 374.671936
current_received_ts = 374.671326
current_seq = 5778
count = 50
seq_step = 10
(kms_flip:8895) DEBUG: vblank ts/seq: last 374.505951/5768, current 374.671936/5778: elapsed=165984.0us expected=164783.1us +- 823.9us, error 0.7%
(kms_flip:8895) DEBUG: inconsistent vblank ts/seq: last 374.505951/5768, current 374.671936/5778: elapsed=165984.0us expected=164783.1us
(kms_flip:8895) DEBUG: name = flip
last_ts = 374.522552
last_received_ts = 374.671417
last_seq = 5769
current_ts = 374.688538
current_received_ts = 374.837402
current_seq = 5779
count = 51
seq_step = 1
(kms_flip:8895) DEBUG: flip ts/seq: last 374.522552/5769, current 374.688538/5779: elapsed=165995.0us expected=164783.1us +- 823.9us, error 0.7%
(kms_flip:8895) DEBUG: inconsistent flip ts/seq: last 374.522552/5769, current 374.688538/5779: elapsed=165995.0us expected=164783.1us
(kms_flip:8895) DEBUG: name = vblank
last_ts = 374.671936
last_received_ts = 374.671326
last_seq = 5778
current_ts = 374.837921
current_received_ts = 374.837311
current_seq = 5788
count = 51
seq_step = 10
(kms_flip:8895) DEBUG: vblank ts/seq: last 374.671936/5778, current 374.837921/5788: elapsed=165989.0us expected=164783.1us +- 823.9us, error 0.7%
(kms_flip:8895) DEBUG: inconsistent vblank ts/seq: last 374.671936/5778, current 374.837921/5788: elapsed=165989.0us expected=164783.1us
(kms_flip:8895) DEBUG: name = flip
last_ts = 374.688538
last_received_ts = 374.837402
last_seq = 5779
current_ts = 374.854523
current_received_ts = 375.003418
current_seq = 5789
count = 52
seq_step = 1
(kms_flip:8895) DEBUG: flip ts/seq: last 374.688538/5779, current 374.854523/5789: elapsed=165983.0us expected=164783.1us +- 823.9us, error 0.7%
(kms_flip:8895) DEBUG: inconsistent flip ts/seq: last 374.688538/5779, current 374.854523/5789: elapsed=165983.0us expected=164783.1us
(kms_flip:8895) DEBUG: name = vblank
last_ts = 374.837921
last_received_ts = 374.837311
last_seq = 5788
current_ts = 375.003906
current_received_ts = 375.003326
current_seq = 5798
count = 52
seq_step = 10
(kms_flip:8895) DEBUG: vblank ts/seq: last 374.837921/5788, current 375.003906/5798: elapsed=165989.0us expected=164783.1us +- 823.9us, error 0.7%
(kms_flip:8895) DEBUG: inconsistent vblank ts/seq: last 374.837921/5788, current 375.003906/5798: elapsed=165989.0us expected=164783.1us
(kms_flip:8895) DEBUG: name = flip
last_ts = 374.854523
last_received_ts = 375.003418
last_seq = 5789
current_ts = 375.020508
current_received_ts = 375.169434
current_seq = 5799
count = 53
seq_step = 1
(kms_flip:8895) DEBUG: flip ts/seq: last 374.854523/5789, current 375.020508/5799: elapsed=165988.0us expected=164783.1us +- 823.9us, error 0.7%
(kms_flip:8895) DEBUG: inconsistent flip ts/seq: last 374.854523/5789, current 375.020508/5799: elapsed=165988.0us expected=164783.1us
(kms_flip:8895) DEBUG: name = vblank
last_ts = 375.003906
last_received_ts = 375.003326
last_seq = 5798
current_ts = 375.169952
current_received_ts = 375.169342
current_seq = 5808
count = 53
seq_step = 10
(kms_flip:8895) DEBUG: vblank ts/seq: last 375.003906/5798, current 375.169952/5808: elapsed=166030.0us expected=164783.1us +- 823.9us, error 0.8%
(kms_flip:8895) DEBUG: inconsistent vblank ts/seq: last 375.003906/5798, current 375.169952/5808: elapsed=166030.0us expected=164783.1us
(kms_flip:8895) DEBUG: name = flip
last_ts = 375.020508
last_received_ts = 375.169434
last_seq = 5799
current_ts = 375.186554
current_received_ts = 375.335480
current_seq = 5809
count = 54
seq_step = 1
(kms_flip:8895) DEBUG: flip ts/seq: last 375.020508/5799, current 375.186554/5809: elapsed=166033.0us expected=164783.1us +- 823.9us, error 0.8%
(kms_flip:8895) DEBUG: inconsistent flip ts/seq: last 375.020508/5799, current 375.186554/5809: elapsed=166033.0us expected=164783.1us
(kms_flip:8895) DEBUG: name = vblank
last_ts = 375.169952
last_received_ts = 375.169342
last_seq = 5808
current_ts = 375.335999
current_received_ts = 375.335419
current_seq = 5818
count = 54
seq_step = 10
(kms_flip:8895) DEBUG: vblank ts/seq: last 375.169952/5808, current 375.335999/5818: elapsed=166056.0us expected=164783.1us +- 823.9us, error 0.8%
(kms_flip:8895) DEBUG: inconsistent vblank ts/seq: last 375.169952/5808, current 375.335999/5818: elapsed=166056.0us expected=164783.1us
(kms_flip:8895) DEBUG: name = flip
last_ts = 375.186554
last_received_ts = 375.335480
last_seq = 5809
current_ts = 375.352600
current_received_ts = 375.501556
current_seq = 5819
count = 55
seq_step = 1
(kms_flip:8895) DEBUG: flip ts/seq: last 375.186554/5809, current 375.352600/5819: elapsed=166062.0us expected=164783.1us +- 823.9us, error 0.8%
(kms_flip:8895) DEBUG: inconsistent flip ts/seq: last 375.186554/5809, current 375.352600/5819: elapsed=166062.0us expected=164783.1us
(kms_flip:8895) DEBUG: name = vblank
last_ts = 375.335999
last_received_ts = 375.335419
last_seq = 5818
current_ts = 375.502075
current_received_ts = 375.501495
current_seq = 5828
count = 55
seq_step = 10
(kms_flip:8895) DEBUG: vblank ts/seq: last 375.335999/5818, current 375.502075/5828: elapsed=166064.0us expected=164783.1us +- 823.9us, error 0.8%
(kms_flip:8895) DEBUG: inconsistent vblank ts/seq: last 375.335999/5818, current 375.502075/5828: elapsed=166064.0us expected=164783.1us
(kms_flip:8895) DEBUG: name = flip
last_ts = 375.352600
last_received_ts = 375.501556
last_seq = 5819
current_ts = 375.518677
current_received_ts = 375.667450
current_seq = 5829
count = 56
seq_step = 1
(kms_flip:8895) DEBUG: flip ts/seq: last 375.352600/5819, current 375.518677/5829: elapsed=166061.0us expected=164783.1us +- 823.9us, error 0.8%
(kms_flip:8895) DEBUG: inconsistent flip ts/seq: last 375.352600/5819, current 375.518677/5829: elapsed=166061.0us expected=164783.1us
(kms_flip:8895) DEBUG: name = vblank
last_ts = 375.502075
last_received_ts = 375.501495
last_seq = 5828
current_ts = 375.668121
current_received_ts = 375.667389
current_seq = 5838
count = 56
seq_step = 10
(kms_flip:8895) DEBUG: vblank ts/seq: last 375.502075/5828, current 375.668121/5838: elapsed=166057.0us expected=164783.1us +- 823.9us, error 0.8%
(kms_flip:8895) DEBUG: inconsistent vblank ts/seq: last 375.502075/5828, current 375.668121/5838: elapsed=166057.0us expected=164783.1us
(kms_flip:8895) DEBUG: name = flip
last_ts = 375.518677
last_received_ts = 375.667450
last_seq = 5829
current_ts = 375.684723
current_received_ts = 375.833710
current_seq = 5839
count = 57
seq_step = 1
(kms_flip:8895) DEBUG: flip ts/seq: last 375.518677/5829, current 375.684723/5839: elapsed=166056.0us expected=164783.1us +- 823.9us, error 0.8%
(kms_flip:8895) DEBUG: inconsistent flip ts/seq: last 375.518677/5829, current 375.684723/5839: elapsed=166056.0us expected=164783.1us
(kms_flip:8895) DEBUG: name = vblank
last_ts = 375.668121
last_received_ts = 375.667389
last_seq = 5838
current_ts = 375.834198
current_received_ts = 375.833649
current_seq = 5848
count = 57
seq_step = 10
(kms_flip:8895) DEBUG: vblank ts/seq: last 375.668121/5838, current 375.834198/5848: elapsed=166060.0us expected=164783.1us +- 823.9us, error 0.8%
(kms_flip:8895) DEBUG: inconsistent vblank ts/seq: last 375.668121/5838, current 375.834198/5848: elapsed=166060.0us expected=164783.1us
(kms_flip:8895) DEBUG: name = flip
last_ts = 375.684723
last_received_ts = 375.833710
last_seq = 5839
current_ts = 375.850800
current_received_ts = 375.999725
current_seq = 5849
count = 58
seq_step = 1
(kms_flip:8895) DEBUG: flip ts/seq: last 375.684723/5839, current 375.850800/5849: elapsed=166058.0us expected=164783.1us +- 823.9us, error 0.8%
(kms_flip:8895) DEBUG: inconsistent flip ts/seq: last 375.684723/5839, current 375.850800/5849: elapsed=166058.0us expected=164783.1us
(kms_flip:8895) DEBUG: name = vblank
last_ts = 375.834198
last_received_ts = 375.833649
last_seq = 5848
current_ts = 376.000244
current_received_ts = 375.999634
current_seq = 5858
count = 58
seq_step = 10
(kms_flip:8895) DEBUG: vblank ts/seq: last 375.834198/5848, current 376.000244/5858: elapsed=166062.0us expected=164783.1us +- 823.9us, error 0.8%
(kms_flip:8895) DEBUG: inconsistent vblank ts/seq: last 375.834198/5848, current 376.000244/5858: elapsed=166062.0us expected=164783.1us
(kms_flip:8895) DEBUG: name = flip
last_ts = 375.850800
last_received_ts = 375.999725
last_seq = 5849
current_ts = 376.016846
current_received_ts = 376.165802
current_seq = 5859
count = 59
seq_step = 1
(kms_flip:8895) DEBUG: flip ts/seq: last 375.850800/5849, current 376.016846/5859: elapsed=166067.0us expected=164783.1us +- 823.9us, error 0.8%
(kms_flip:8895) DEBUG: inconsistent flip ts/seq: last 375.850800/5849, current 376.016846/5859: elapsed=166067.0us expected=164783.1us
(kms_flip:8895) DEBUG: name = vblank
last_ts = 376.000244
last_received_ts = 375.999634
last_seq = 5858
current_ts = 376.166351
current_received_ts = 376.165741
current_seq = 5868
count = 59
seq_step = 10
(kms_flip:8895) DEBUG: vblank ts/seq: last 376.000244/5858, current 376.166351/5868: elapsed=166092.0us expected=164783.1us +- 823.9us, error 0.8%
(kms_flip:8895) DEBUG: inconsistent vblank ts/seq: last 376.000244/5858, current 376.166351/5868: elapsed=166092.0us expected=164783.1us
(kms_flip:8895) DEBUG: name = flip
last_ts = 376.016846
last_received_ts = 376.165802
last_seq = 5859
current_ts = 376.182953
current_received_ts = 376.331970
current_seq = 5869
count = 60
seq_step = 1
(kms_flip:8895) DEBUG: flip ts/seq: last 376.016846/5859, current 376.182953/5869: elapsed=166100.0us expected=164783.1us +- 823.9us, error 0.8%
(kms_flip:8895) DEBUG: inconsistent flip ts/seq: last 376.016846/5859, current 376.182953/5869: elapsed=166100.0us expected=164783.1us
(kms_flip:8895) DEBUG: name = vblank
last_ts = 376.166351
last_received_ts = 376.165741
last_seq = 5868
current_ts = 376.332458
current_received_ts = 376.331879
current_seq = 5878
count = 60
seq_step = 10
(kms_flip:8895) DEBUG: vblank ts/seq: last 376.166351/5868, current 376.332458/5878: elapsed=166118.0us expected=164783.1us +- 823.9us, error 0.8%
(kms_flip:8895) DEBUG: inconsistent vblank ts/seq: last 376.166351/5868, current 376.332458/5878: elapsed=166118.0us expected=164783.1us
(kms_flip:8895) INFO: Event flip: expected 613, counted 610, passrate = 49.18%, encoder type 2
(kms_flip:8895) DEBUG: dropped frames, expected 613, counted 610, passrate = 49.18%, encoder type 2
(kms_flip:8895) INFO: Event vblank: expected 613, counted 610, passrate = 47.54%, encoder type 2
(kms_flip:8895) DEBUG: dropped frames, expected 613, counted 610, passrate = 47.54%, encoder type 2
(kms_flip:8895) CRITICAL: Test assertion failure function __run_test_on_crtc_set, file ../tests/kms_flip.c:1722:
(kms_flip:8895) CRITICAL: Failed assertion: !retried
(kms_flip:8895) igt_core-INFO: Stack trace:
(kms_flip:8895) igt_core-INFO:   #0 ../lib/igt_core.c:2075 __igt_fail_assert()
(kms_flip:8895) igt_core-INFO:   #1 ../tests/kms_flip.c:1071 run_test_on_crtc_set()
(kms_flip:8895) igt_core-INFO:   #2 ../tests/kms_flip.c:1920 run_test()
(kms_flip:8895) igt_core-INFO:   #3 ../tests/kms_flip.c:2184 __igt_unique____real_main2105()
(kms_flip:8895) igt_core-INFO:   #4 ../tests/kms_flip.c:2105 main()
(kms_flip:8895) igt_core-INFO:   #5 [__libc_init_first+0x8a]
(kms_flip:8895) igt_core-INFO:   #6 [__libc_start_main+0x8b]
(kms_flip:8895) igt_core-INFO:   #7 [_start+0x25]
****  END  ****
Dynamic subtest A-eDP1: FAIL (26.678s)
Dmesg
<6> [364.919093] Console: switching to colour dummy device 80x25
<6> [364.919644] [IGT] kms_flip: executing
<7> [364.928556] xe 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] [CONNECTOR:402:DP-1]
<7> [364.928577] xe 0000:00:02.0: [drm:intel_dp_detect [xe]] [CONNECTOR:402:DP-1]
<7> [364.928789] xe 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] [CONNECTOR:402:DP-1] disconnected
<7> [364.929124] xe 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] [CONNECTOR:414:DP-2]
<7> [364.929129] xe 0000:00:02.0: [drm:intel_dp_detect [xe]] [CONNECTOR:414:DP-2]
<7> [364.929452] xe 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] [CONNECTOR:414:DP-2] disconnected
<7> [364.929732] xe 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] [CONNECTOR:422:DP-3]
<7> [364.929736] xe 0000:00:02.0: [drm:intel_dp_detect [xe]] [CONNECTOR:422:DP-3]
<7> [364.929913] xe 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] [CONNECTOR:422:DP-3] disconnected
<7> [364.930158] xe 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] [CONNECTOR:393:eDP-1]
<7> [364.930162] xe 0000:00:02.0: [drm:intel_dp_detect [xe]] [CONNECTOR:393:eDP-1]
<7> [364.930642] xe 0000:00:02.0: [drm:intel_dp_read_dsc_dpcd [xe]] DSC DPCD: 00 11 00 76 0b 01 01 80 00 01 06 66 08 00 00 00
<7> [364.930969] xe 0000:00:02.0: [drm:intel_dp_print_rates [xe]] source rates: 162000, 216000, 243000, 270000, 324000, 432000, 540000, 675000, 810000
<7> [364.931126] xe 0000:00:02.0: [drm:intel_dp_print_rates [xe]] sink rates: 162000, 216000, 243000, 270000, 324000, 432000, 540000, 810000
<7> [364.931308] xe 0000:00:02.0: [drm:intel_dp_print_rates [xe]] common rates: 162000, 216000, 243000, 270000, 324000, 432000, 540000, 810000
<7> [364.931495] xe 0000:00:02.0: [drm:update_display_info.part.0] [CONNECTOR:393:eDP-1] Supported Monitor Refresh rate range is 40 Hz - 120 Hz
<5> [364.931503] [drm] DisplayID checksum invalid, remainder is 248 (ignoring)
<5> [364.931506] [drm] DisplayID checksum invalid, remainder is 248 (ignoring)
<7> [364.931508] xe 0000:00:02.0: [drm:update_display_info.part.0] [CONNECTOR:393:eDP-1] DisplayID extension version 0x13, primary use 0x00
<7> [364.931513] xe 0000:00:02.0: [drm:update_display_info.part.0] [CONNECTOR:393:eDP-1] Assigning EDID-1.4 digital sink color depth as 10 bpc.
<5> [364.931517] [drm] DisplayID checksum invalid, remainder is 248 (ignoring)
<7> [364.931520] xe 0000:00:02.0: [drm:update_display_info.part.0] [CONNECTOR:393:eDP-1] ELD monitor
<5> [364.931526] [drm] DisplayID checksum invalid, remainder is 248 (ignoring)
<7> [364.931528] xe 0000:00:02.0: [drm:update_display_info.part.0] [CONNECTOR:393:eDP-1] ELD size 20, SAD count 0
<5> [364.931533] [drm] DisplayID checksum invalid, remainder is 248 (ignoring)
<7> [364.931556] xe 0000:00:02.0: [drm:intel_dp_set_edid [xe]] [CONNECTOR:393:eDP-1] VRR capable: yes
<7> [364.931736] xe 0000:00:02.0: [drm:intel_dp_set_edid [xe]] [CONNECTOR:393:eDP-1] DFP max bpc 0, max dotclock 0, TMDS clock 0-0, PCON Max FRL BW 0Gbps
<7> [364.931877] xe 0000:00:02.0: [drm:intel_dp_set_edid [xe]] [CONNECTOR:393:eDP-1] RGB->YcbCr conversion? no, YCbCr 4:2:0 allowed? yes, YCbCr 4:4:4->4:2:0 conversion? no
<5> [364.932186] [drm] DisplayID checksum invalid, remainder is 248 (ignoring)
<5> [364.932188] [drm] DisplayID checksum invalid, remainder is 248 (ignoring)
<5> [364.932190] [drm] DisplayID checksum invalid, remainder is 248 (ignoring)
<7> [364.932238] xe 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] [CONNECTOR:393:eDP-1] probed modes:
<7> [364.932242] xe 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "2880x1800": 60 347710 2880 2928 2960 3040 1800 1803 1809 1906 0x48 0xa
<7> [364.932246] xe 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "2880x1800": 120 695310 2880 2928 2960 3040 1800 1803 1809 1906 0x40 0xa
<7> [364.932260] xe 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] [CONNECTOR:402:DP-1]
<7> [364.932265] xe 0000:00:02.0: [drm:intel_dp_detect [xe]] [CONNECTOR:402:DP-1]
<7> [364.932419] xe 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] [CONNECTOR:402:DP-1] disconnected
<7> [364.932431] xe 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] [CONNECTOR:414:DP-2]
<7> [364.932435] xe 0000:00:02.0: [drm:intel_dp_detect [xe]] [CONNECTOR:414:DP-2]
<7> [364.932558] xe 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] [CONNECTOR:414:DP-2] disconnected
<7> [364.932566] xe 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] [CONNECTOR:422:DP-3]
<7> [364.932568] xe 0000:00:02.0: [drm:intel_dp_detect [xe]] [CONNECTOR:422:DP-3]
<7> [364.932675] xe 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] [CONNECTOR:422:DP-3] disconnected
<6> [364.933209] [IGT] kms_flip: starting subtest flip-vs-blocking-wf-vblank
<6> [364.934466] [IGT] kms_flip: starting dynamic subtest A-eDP1
<7> [364.936006] xe 0000:00:02.0: [drm:drm_mode_addfb2] [FB:431]
<7> [364.936387] xe 0000:00:02.0: [drm:drm_mode_addfb2] [FB:432]
<7> [365.019769] xe 0000:00:02.0: [drm:drm_mode_setcrtc] [CRTC:151:pipe A]
<7> [365.019989] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:151:pipe A] fastset requirement not met in hw.enable (expected yes, found no)
<7> [365.020416] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:151:pipe A] fastset requirement not met in hw.active (expected yes, found no)
<7> [365.020723] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:151:pipe A] fastset requirement not met in cpu_transcoder (expected 0, found -1)
<7> [365.021012] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:151:pipe A] fastset requirement not met in lane_count (expected 4, found 0)
<7> [365.021317] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:151:pipe A] fastset requirement not met in dp_m_n (expected tu 64 data 6329869/8388608 link 421991/524288, found tu 0, data 0/0 link 0/0)
<7> [365.021588] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:151:pipe A] fastset requirement not met in output_types (expected 0x00000100, found 0x00000000)
<7> [365.021867] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:151:pipe A] fastset requirement not met in framestart_delay (expected 1, found 0)
<7> [365.022156] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:151:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hdisplay (expected 2880, found 0)
<7> [365.022489] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:151:pipe A] fastset requirement not met in hw.pipe_mode.crtc_htotal (expected 3040, found 0)
<7> [365.022755] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:151:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hblank_start (expected 2880, found 0)
<7> [365.023009] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:151:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hblank_end (expected 3040, found 0)
<7> [365.023304] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:151:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hsync_start (expected 2928, found 0)
<7> [365.023546] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:151:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hsync_end (expected 2960, found 0)
<7> [365.023778] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:151:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vdisplay (expected 1800, found 0)
<7> [365.024042] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:151:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vblank_start (expected 1800, found 0)
<7> [365.024295] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:151:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vsync_start (expected 1803, found 0)
<7> [365.024513] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:151:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vsync_end (expected 1809, found 0)
<7> [365.024724] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:151:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vtotal (expected 1906, found 0)
<7> [365.024931] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:151:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vblank_end (expected 1906, found 0)
<7> [365.025129] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:151:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hdisplay (expected 2880, found 0)
<7> [365.025351] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:151:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_htotal (expected 3040, found 0)
<7> [365.025537] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:151:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hblank_start (expected 2880, found 0)
<7> [365.025722] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:151:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hblank_end (expected 3040, found 0)
<7> [365.025934] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:151:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hsync_start (expected 2928, found 0)
<7> [365.026123] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:151:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hsync_end (expected 2960, found 0)
<7> [365.026419] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:151:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vdisplay (expected 1800, found 0)
<7> [365.026613] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:151:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vblank_start (expected 1800, found 0)
<7> [365.026792] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:151:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vsync_start (expected 1803, found 0)
<7> [365.026949] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:151:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vsync_end (expected 1809, found 0)
<7> [365.027129] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:151:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vtotal (expected 1906, found 0)
<7> [365.027323] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:151:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vblank_end (expected 1906, found 0)
<7> [365.027473] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:151:pipe A] fastset requirement not met in pixel_multiplier (expected 1, found 0)
<7> [365.027619] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:151:pipe A] fastset requirement not met in hw.adjusted_mode.flags (2) (expected 2, found 0)
<7> [365.027761] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:151:pipe A] fastset requirement not met in hw.adjusted_mode.flags (8) (expected 8, found 0)
<7> [365.027904] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:151:pipe A] fastset requirement not met in pipe_bpp (expected 30, found 0)
<7> [365.028040] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:151:pipe A] fastset requirement not met in hw.pipe_mode.crtc_clock (expected 347710, found 0)
<7> [365.028184] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:151:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_clock (expected 347710, found 0)
<7> [365.028324] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:151:pipe A] fastset requirement not met in port_clock (expected 432000, found 0)
<7> [365.028466] xe 0000:00:02.0: [drm:intel_atomic_check [xe]] [CRTC:151:pipe A] fastset requirement not met, forcing full modeset
<7> [365.028609] xe 0000:00:02.0: [drm:intel_dpll_crtc_put [xe]] [CRTC:151:pipe A] releasing DPLL 0
<7> [365.028817] xe 0000:00:02.0: [drm:skl_compute_wm [xe]] Enabled dbuf slices 0xf -> 0x1 (total dbuf slices 0xf), mbus joined? yes->no
<7> [365.028936] xe 0000:00:02.0: [drm:skl_compute_wm [xe]] [CRTC:151:pipe A] dbuf slices 0xf -> 0x0, ddb (0 - 4096) -> (0 - 0), active pipes 0x1 -> 0x0
<7> [365.029076] xe 0000:00:02.0: [drm:skl_print_plane_ddb_changes [xe]] [PLANE:35:plane 1A] ddb ( 0 - 4051) -> ( 0 - 0), size 4051 -> 0
<7> [365.029187] xe 0000:00:02.0: [drm:skl_print_plane_ddb_changes [xe]] [PLANE:145:cursor A] ddb (4051 - 4096) -> ( 0 - 0), size 45 -> 0
<7> [365.029283] xe 0000:00:02.0: [drm:skl_print_plane_wm_changes [xe]] [PLANE:35:plane 1A] level *wm0,*wm1,*wm2,*wm3,*wm4,*wm5, wm6, wm7,*twm,*swm,*stwm -> wm0, wm1, wm2, wm3, wm4, wm5, wm6, wm7, twm, swm, stwm
<7> [365.029372] xe 0000:00:02.0: [drm:skl_print_plane_wm_changes [xe]] [PLANE:35:plane 1A] lines 1, 13, 13, 13, 13, 13, 0, 0, 0, 3, 0 -> 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0
<7> [365.029459] xe 0000:00:02.0: [drm:skl_print_plane_wm_changes [xe]] [PLANE:35:plane 1A] blocks 24, 313, 313, 313, 313, 313, 0, 0, 38, 73, 87 -> 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0
<7> [365.029555] xe 0000:00:02.0: [drm:skl_print_plane_wm_changes [xe]] [PLANE:35:plane 1A] min_ddb 28, 346, 346, 346, 346, 346, 0, 0, 39, 82, 88 -> 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0
<7> [365.029667] xe 0000:00:02.0: [drm:intel_bw_atomic_check [xe]] [CRTC:151:pipe A] data rate 0 num active planes 0
<7> [365.029798] xe 0000:00:02.0: [drm:intel_bw_atomic_check [xe]] QGV point 0: max bw 23530 required 0 qgv_peak_bw: 38400
<7> [365.029922] xe 0000:00:02.0: [drm:intel_bw_atomic_check [xe]] QGV point 1: max bw 36260 required 0 qgv_peak_bw: 38400
<7> [365.030044] xe 0000:00:02.0: [drm:intel_bw_atomic_check [xe]] QGV point 2: max bw 38000 required 0 qgv_peak_bw: 38400
<7> [365.030176] xe 0000:00:02.0: [drm:intel_bw_atomic_check [xe]] QGV point 3: max bw 38000 required 0 qgv_peak_bw: 38400
<7> [365.030292] xe 0000:00:02.0: [drm:intel_bw_atomic_check [xe]] Matching peaks QGV bw: 38400 for required data rate: 0
<7> [365.030407] xe 0000:00:02.0: [drm:intel_cdclk_atomic_check [xe]] [CRTC:151:pipe A] min cdclk: 173855 kHz -> 0 kHz
<7> [365.030542] xe 0000:00:02.0: [drm:intel_cdclk_update_dbuf_bw_min_cdclk [xe]] dbuf bandwidth min cdclk: 21732 kHz -> 0 kHz
<7> [365.030671] xe 0000:00:02.0: [drm:intel_cdclk_atomic_check [xe]] Can change cdclk via squashing
<7> [365.030783] xe 0000:00:02.0: [drm:intel_cdclk_atomic_check [xe]] New cdclk calculated to be logical 153600 kHz, actual 153600 kHz
<7> [365.030893] xe 0000:00:02.0: [drm:intel_cdclk_atomic_check [xe]] New voltage level calculated to be logical 0, actual 0
<7> [365.031026] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [CRTC:151:pipe A] enable: no [modeset]
<7> [365.031134] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [PLANE:35:plane 1A] fb: [NOFB], visible: no
<7> [365.031261] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [PLANE:65:plane 2A] fb: [NOFB], visible: no
<7> [365.031371] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [PLANE:95:plane 3A] fb: [NOFB], visible: no
<7> [365.031478] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [PLANE:125:plane 4A] fb: [NOFB], visible: no
<7> [365.031574] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [PLANE:135:plane 5A] fb: [NOFB], visible: no
<7> [365.031669] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [PLANE:145:cursor A] fb: [NOFB], visible: no
<7> [365.031825] xe 0000:00:02.0: [drm:intel_power_well_enable [xe]] enabling DC_off
<7> [365.031939] xe 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [xe]] Setting DC state from 02 to 00
<7> [365.032098] xe 0000:00:02.0: [drm:intel_psr_disable_locked [xe]] Disabling PSR2
<7> [365.032817] xe 0000:00:02.0: [drm:intel_alpm_disable [xe]] Disabling ALPM
<7> [365.033080] xe 0000:00:02.0: [drm:intel_edp_backlight_off [xe]]
<7> [365.241413] xe 0000:00:02.0: [drm:intel_backlight_set_pwm_level [xe]] [CONNECTOR:393:eDP-1] set backlight PWM = 0
<7> [365.241853] xe 0000:00:02.0: [drm:intel_disable_transcoder [xe]] disabling pipe A
<7> [365.249504] xe 0000:00:02.0: [drm:intel_pps_off_unlocked [xe]] [ENCODER:392:DDI A/PHY A] PPS 0 turn panel power off
<7> [365.249761] xe 0000:00:02.0: [drm:intel_pps_off_unlocked [xe]] [ENCODER:392:DDI A/PHY A] PPS 0 wait for panel power off time
<7> [365.250003] xe 0000:00:02.0: [drm:wait_panel_status [xe]] [ENCODER:392:DDI A/PHY A] PPS 0 mask: 0xb0000000 value: 0x00000000 PP_STATUS: 0xa0000002 PP_CONTROL: 0x00000060
<7> [365.302613] xe 0000:00:02.0: [drm:icp_irq_handler [xe]] hotplug event received, stat 0x00010000, dig 0x00000009, pins 0x00000010, long 0x00000000
<7> [365.302941] xe 0000:00:02.0: [drm:intel_hpd_irq_handler [xe]] digital hpd on [ENCODER:392:DDI A/PHY A] - short
<7> [365.311082] xe 0000:00:02.0: [drm:wait_panel_status [xe]] Wait complete
<7> [365.311481] xe 0000:00:02.0: [drm:intel_dpll_disable [xe]] disable DPLL 0 (active 0x1, on? 1) for [CRTC:151:pipe A]
<7> [365.311501] xe 0000:00:02.0: [drm:intel_dp_hpd_pulse [xe]] ignoring short hpd on eDP [ENCODER:392:DDI A/PHY A]
<7> [365.312867] xe 0000:00:02.0: [drm:intel_dpll_disable [xe]] disabling DPLL 0
<7> [365.313284] xe 0000:00:02.0: [drm:intel_power_well_disable [xe]] disabling AUX_A
<7> [365.313682] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:392:DDI A/PHY A]
<7> [365.314006] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:401:DDI TC1/PHY TC1]
<7> [365.314309] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:403:DP-MST A]
<7> [365.314571] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:404:DP-MST B]
<7> [365.314846] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:405:DP-MST C]
<7> [365.315115] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:413:DDI TC2/PHY TC2]
<7> [365.315424] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:415:DP-MST A]
<7> [365.315686] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:416:DP-MST B]
<7> [365.315974] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:417:DP-MST C]
<7> [365.316316] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:421:DDI TC3/PHY TC3]
<7> [365.316595] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:423:DP-MST A]
<7> [365.316866] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:424:DP-MST B]
<7> [365.317168] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:425:DP-MST C]
<7> [365.317438] xe 0000:00:02.0: [drm:verify_connector_state [xe]] [CONNECTOR:393:eDP-1]
<7> [365.317797] xe 0000:00:02.0: [drm:intel_dbuf_mdclk_cdclk_ratio_update [xe]] Updating dbuf ratio to 4 (mbus joined: no)
<7> [365.318066] xe 0000:00:02.0: [drm:intel_dbuf_mbus_join_update [xe]] Changing mbus joined: yes -> no (pipe: *)
<7> [365.318425] xe 0000:00:02.0: [drm:gen9_dbuf_slices_update [xe]] Updating dbuf slices to 0x1
<7> [365.318888] xe 0000:00:02.0: [drm:intel_power_well_disable [xe]] disabling PW_A
<7> [365.319245] xe 0000:00:02.0: [drm:dss_pipe_gating_enable_disable [xe]] DSS clock gating disabled for pipe_mask=0x1 (CLKGATE_DIS_DSSDSC=0xaa000000)
<7> [365.319659] xe 0000:00:02.0: [drm:intel_modeset_verify_crtc [xe]] [CRTC:151:pipe A]
<7> [365.319958] xe 0000:00:02.0: [drm:intel_set_cdclk [xe]] Post changing CDCLK to 153600 kHz, VCO 614400 kHz, ref 38400 kHz, bypass 19200 kHz, voltage level 0
<7> [365.320351] xe 0000:00:02.0: [drm:intel_dbuf_mdclk_cdclk_ratio_update [xe]] Updating dbuf ratio to 4 (mbus joined: no)
<7> [365.320614] xe 0000:00:02.0: [drm:intel_audio_cdclk_change_post.part.0 [xe]] aud_ts_cdclk set to M=60, N=384
<7> [365.321410] xe 0000:00:02.0: [drm:drm_mode_setcrtc] [CRTC:270:pipe B]
<7> [365.321791] xe 0000:00:02.0: [drm:drm_mode_setcrtc] [CRTC:389:pipe C]
<7> [365.322076] xe 0000:00:02.0: [drm:drm_mode_setcrtc] [CRTC:151:pipe A]
<7> [365.322158] xe 0000:00:02.0: [drm:drm_mode_setcrtc] [CONNECTOR:393:eDP-1]
<7> [365.322333] xe 0000:00:02.0: [drm:compute_baseline_pipe_bpp [xe]] [CONNECTOR:393:eDP-1] Limiting target display pipe bpp to 30 (EDID bpp 30, max requested bpp 36, max platform bpp 36)
<7> [365.322709] xe 0000:00:02.0: [drm:intel_dp_compute_config_limits [xe]] [ENCODER:392:DDI A/PHY A][CRTC:151:pipe A] DP link limits: pixel clock 347710 kHz DSC off max lanes 4 max rate 810000 max pipe_bpp 30 min link_bpp 18.0000 max link_bpp 30.0000
<7> [365.323042] xe 0000:00:02.0: [drm:intel_dp_compute_output_format [xe]] DP lane count 4 clock 432000 bpp input 30 compressed 0.0000 HDR no link rate required 1303913 available 1728000
<7> [365.323421] xe 0000:00:02.0: [drm:intel_atomic_check [xe]] [CRTC:151:pipe A] hw max bpp: 30, pipe bpp: 30, dithering: 0
<7> [365.323762] xe 0000:00:02.0: [drm:intel_ddi_compute_config_late [xe]] [ENCODER:392:DDI A/PHY A] [CRTC:151:pipe A]
<7> [365.324086] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:151:pipe A] fastset requirement not met in hw.enable (expected no, found yes)
<7> [365.324436] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:151:pipe A] fastset requirement not met in hw.active (expected no, found yes)
<7> [365.324732] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:151:pipe A] fastset requirement not met in cpu_transcoder (expected -1, found 0)
<7> [365.325094] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:151:pipe A] fastset requirement not met in lane_count (expected 0, found 4)
<7> [365.325387] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:151:pipe A] fastset requirement not met in dp_m_n (expected tu 0 data 0/0 link 0/0, found tu 64, data 6329869/8388608 link 421991/524288)
<7> [365.325644] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:151:pipe A] fastset requirement not met in output_types (expected 0x00000000, found 0x00000100)
<7> [365.325893] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:151:pipe A] fastset requirement not met in framestart_delay (expected 0, found 1)
<7> [365.326188] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:151:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hdisplay (expected 0, found 2880)
<7> [365.326421] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:151:pipe A] fastset requirement not met in hw.pipe_mode.crtc_htotal (expected 0, found 3040)
<7> [365.326641] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:151:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hblank_start (expected 0, found 2880)
<7> [365.326854] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:151:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hblank_end (expected 0, found 3040)
<7> [365.327089] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:151:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hsync_start (expected 0, found 2928)
<7> [365.327328] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:151:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hsync_end (expected 0, found 2960)
<7> [365.327531] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:151:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vdisplay (expected 0, found 1800)
<7> [365.327719] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:151:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vblank_start (expected 0, found 1800)
<7> [365.327900] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:151:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vsync_start (expected 0, found 1803)
<7> [365.328075] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:151:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vsync_end (expected 0, found 1809)
<7> [365.328268] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:151:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vtotal (expected 0, found 1906)
<7> [365.328463] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:151:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vblank_end (expected 0, found 1906)
<7> [365.328638] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:151:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hdisplay (expected 0, found 2880)
<7> [365.328799] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:151:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_htotal (expected 0, found 3040)
<7> [365.328953] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:151:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hblank_start (expected 0, found 2880)
<7> [365.329105] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:151:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hblank_end (expected 0, found 3040)
<7> [365.329301] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:151:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hsync_start (expected 0, found 2928)
<7> [365.329472] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:151:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hsync_end (expected 0, found 2960)
<7> [365.329637] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:151:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vdisplay (expected 0, found 1800)
<7> [365.329797] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:151:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vblank_start (expected 0, found 1800)
<7> [365.329942] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:151:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vsync_start (expected 0, found 1803)
<7> [365.330083] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:151:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vsync_end (expected 0, found 1809)
<7> [365.330229] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:151:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vtotal (expected 0, found 1906)
<7> [365.330366] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:151:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vblank_end (expected 0, found 1906)
<7> [365.330494] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:151:pipe A] fastset requirement not met in pixel_multiplier (expected 0, found 1)
<7> [365.330619] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:151:pipe A] fastset requirement not met in hw.adjusted_mode.flags (2) (expected 0, found 2)
<7> [365.330744] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:151:pipe A] fastset requirement not met in hw.adjusted_mode.flags (8) (expected 0, found 8)
<7> [365.330872] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:151:pipe A] fastset requirement not met in pipe_bpp (expected 0, found 30)
<7> [365.330990] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:151:pipe A] fastset requirement not met in hw.pipe_mode.crtc_clock (expected 0, found 347710)
<7> [365.331104] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:151:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_clock (expected 0, found 347710)
<7> [365.331270] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:151:pipe A] fastset requirement not met in port_clock (expected 0, found 432000)
<7> [365.331382] xe 0000:00:02.0: [drm:intel_atomic_check [xe]] [CRTC:151:pipe A] fastset requirement not met, forcing full modeset
<7> [365.331532] xe 0000:00:02.0: [drm:skl_compute_wm [xe]] Enabled dbuf slices 0x1 -> 0xf (total dbuf slices 0xf), mbus joined? no->yes
<7> [365.331631] xe 0000:00:02.0: [drm:skl_compute_wm [xe]] [CRTC:151:pipe A] dbuf slices 0x0 -> 0xf, ddb (0 - 0) -> (0 - 4096), active pipes 0x0 -> 0x1
<7> [365.331756] xe 0000:00:02.0: [drm:skl_print_plane_ddb_changes [xe]] [PLANE:35:plane 1A] ddb ( 0 - 0) -> ( 0 - 4051), size 0 -> 4051
<7> [365.331849] xe 0000:00:02.0: [drm:skl_print_plane_ddb_changes [xe]] [PLANE:145:cursor A] ddb ( 0 - 0) -> (4051 - 4096), size 0 -> 45
<7> [365.331928] xe 0000:00:02.0: [drm:skl_print_plane_wm_changes [xe]] [PLANE:35:plane 1A] level wm0, wm1, wm2, wm3, wm4, wm5, wm6, wm7, twm, swm, stwm -> *wm0,*wm1,*wm2,*wm3,*wm4,*wm5, wm6, wm7,*twm,*swm,*stwm
<7> [365.332006] xe 0000:00:02.0: [drm:skl_print_plane_wm_changes [xe]] [PLANE:35:plane 1A] lines 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0 -> 4, 13, 13, 13, 13, 13, 0, 0, 0, 4, 0
<7> [365.332080] xe 0000:00:02.0: [drm:skl_print_plane_wm_changes [xe]] [PLANE:35:plane 1A] blocks 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0 -> 92, 297, 297, 297, 297, 297, 0, 0, 197, 92, 197
<7> [365.332165] xe 0000:00:02.0: [drm:skl_print_plane_wm_changes [xe]] [PLANE:35:plane 1A] min_ddb 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0 -> 183, 456, 456, 456, 456, 456, 0, 0, 198, 183, 198
<7> [365.332260] xe 0000:00:02.0: [drm:intel_bw_atomic_check [xe]] [CRTC:151:pipe A] data rate 1390840 num active planes 1
<7> [365.332372] xe 0000:00:02.0: [drm:intel_bw_atomic_check [xe]] QGV point 0: max bw 23530 required 1461 qgv_peak_bw: 38400
<7> [365.332478] xe 0000:00:02.0: [drm:intel_bw_atomic_check [xe]] QGV point 1: max bw 36260 required 1461 qgv_peak_bw: 38400
<7> [365.332579] xe 0000:00:02.0: [drm:intel_bw_atomic_check [xe]] QGV point 2: max bw 38000 required 1461 qgv_peak_bw: 38400
<7> [365.332680] xe 0000:00:02.0: [drm:intel_bw_atomic_check [xe]] QGV point 3: max bw 38000 required 1461 qgv_peak_bw: 38400
<7> [365.332780] xe 0000:00:02.0: [drm:intel_bw_atomic_check [xe]] Matching peaks QGV bw: 38400 for required data rate: 1461
<7> [365.332878] xe 0000:00:02.0: [drm:intel_cdclk_atomic_check [xe]] [CRTC:151:pipe A] min cdclk: 0 kHz -> 173855 kHz
<7> [365.332988] xe 0000:00:02.0: [drm:intel_cdclk_update_dbuf_bw_min_cdclk [xe]] dbuf bandwidth min cdclk: 0 kHz -> 21732 kHz
<7> [365.333090] xe 0000:00:02.0: [drm:intel_cdclk_atomic_check [xe]] Can change cdclk via squashing
<7> [365.333205] xe 0000:00:02.0: [drm:intel_cdclk_atomic_check [xe]] New cdclk calculated to be logical 192000 kHz, actual 192000 kHz
<7> [365.333300] xe 0000:00:02.0: [drm:intel_cdclk_atomic_check [xe]] New voltage level calculated to be logical 0, actual 0
<7> [365.333405] xe 0000:00:02.0: [drm:intel_find_dpll [xe]] [CRTC:151:pipe A] allocated DPLL 0
<7> [365.333493] xe 0000:00:02.0: [drm:intel_dpll_crtc_get [xe]] [CRTC:151:pipe A] reserving DPLL 0
<7> [365.333583] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [CRTC:151:pipe A] enable: yes [modeset]
<7> [365.333674] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] active: yes, output_types: EDP (0x100), output format: RGB, sink format: RGB
<7> [365.333761] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] cpu_transcoder: A, pipe bpp: 30, dithering: 0
<7> [365.333847] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] MST master transcoder: <invalid>
<7> [365.333930] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] port sync: master transcoder: <invalid>, slave transcoder bitmask = 0x0
<7> [365.334011] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] joiner: no, pipes: 0x0
<7> [365.334092] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] splitter: disabled, link count 0, overlap 0
<7> [365.334185] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] dp m_n: lanes: 4; data_m: 6329869, data_n: 8388608, link_m: 421991, link_n: 524288, tu: 64
<7> [365.334278] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] dp m2_n2: lanes: 4; data_m: 0, data_n: 0, link_m: 0, link_n: 0, tu: 0
<7> [365.334372] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] fec: disabled, enhanced framing: disabled
<7> [365.334457] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] sdp split: disabled
<7> [365.334536] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] psr: enabled, selective update: enabled, panel replay: disabled, selective fetch: enabled
<7> [365.334619] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] minimum hblank: 0
<7> [365.334703] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] audio: 0, infoframes: 0, infoframes enabled: 0x4
<7> [365.334788] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] DP SDP: VSC, revision 4, length 14
<7> [365.334872] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] pixelformat: RGB
<7> [365.334950] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] colorimetry: sRGB
<7> [365.335026] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] bpc: 0
<7> [365.335101] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] dynamic range: VESA range
<7> [365.335191] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] content type: Not defined
<7> [365.335294] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] scanline offset: 1
<7> [365.335399] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] framestart delay: 1, MSA timing delay: 0, set context latency: 0
<7> [365.335489] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] vrr: no, fixed rr: yes, vmin: 1906, vmax: 1906, flipline: 1906, pipeline full: 0, guardband: 104 vsync start: 103, vsync end: 97
<7> [365.335572] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] vrr: vmin vblank: 1802, vmax vblank: 1802, vmin vtotal: 1906, vmax vtotal: 1906
<7> [365.335650] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] vrr: dc balance: no, vmin: 0 vmax: 0 guardband: 0, slope: 0 max increase: 0 max decrease: 0 vblank target: 0
<7> [365.335728] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] requested mode: "2880x1800": 60 347710 2880 2928 2960 3040 1800 1803 1809 1906 0x48 0xa
<7> [365.335807] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] adjusted mode: "2880x1800": 60 347710 2880 2928 2960 3040 1800 1803 1809 1906 0x48 0xa
<7> [365.335885] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] crtc timings: clock=347710, hd=2880 hb=2880-3040 hs=2928-2960 ht=3040, vd=1800 vb=1800-1906 vs=1803-1809 vt=1906, flags=0xa
<7> [365.335964] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] pipe mode: "2880x1800": 60 347710 2880 2928 2960 3040 1800 1803 1809 1906 0x40 0xa
<7> [365.336040] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] crtc timings: clock=347710, hd=2880 hb=2880-3040 hs=2928-2960 ht=3040, vd=1800 vb=1800-1906 vs=1803-1809 vt=1906, flags=0xa
<7> [365.336115] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] port clock: 432000, pixel rate 347710, min cdclk 173855, min voltage level 0
<7> [365.336210] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] linetime: 70, ips linetime: 0
<7> [365.336297] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] num_scalers: 2, scaler_users: 0x0, scaler_id: -1, scaling_filter: 0, sharpness_strength: 0
<7> [365.336384] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] pipe src: 2880x1800+0+0
<7> [365.336467] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] pch pfit: 0x0+0+0, disabled, force thru: no
<7> [365.336545] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] sharpness strength: 0, sharpness tap size: 0, sharpness enable: 0
<7> [365.336625] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] ips: 0, double wide: 0, drrs: 0
<7> [365.336708] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] cx0pll_hw_state: lane_count: 4, ssc_enabled: no, use_c10: yes, tbt_mode: no
<7> [365.336791] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] c10pll_hw_state: fracen: no,
<7> [365.336873] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] multiplier: 225, tx_clk_div: 1.
<7> [365.336949] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] c10pll_rawhw_state:
<7> [365.337022] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] tx: 0x10, cmn: 0x21
<7> [365.337098] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] pll[0] = 0x4, pll[1] = 0x0, pll[2] = 0xa2, pll[3] = 0x1
<7> [365.337186] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] pll[4] = 0x0, pll[5] = 0x0, pll[6] = 0x0, pll[7] = 0x0
<7> [365.337273] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] pll[8] = 0x0, pll[9] = 0x1, pll[10] = 0x0, pll[11] = 0x0
<7> [365.337358] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] pll[12] = 0x0, pll[13] = 0x0, pll[14] = 0x0, pll[15] = 0x1
<7> [365.337439] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] pll[16] = 0x85, pll[17] = 0xf, pll[18] = 0xe6, pll[19] = 0x23
<7> [365.337515] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] csc_mode: 0x0 gamma_mode: 0x0 gamma_enable: 0 csc_enable: 0
<7> [365.337589] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] pre csc lut: 0 entries, post csc lut: 0 entries
<7> [365.337664] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] output csc: pre offsets: 0x0000 0x0000 0x0000
<7> [365.337738] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] output csc: coefficients: 0x0000 0x0000 0x0000
<7> [365.337812] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] output csc: coefficients: 0x0000 0x0000 0x0000
<7> [365.337886] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] output csc: coefficients: 0x0000 0x0000 0x0000
<7> [365.337960] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] output csc: post offsets: 0x0000 0x0000 0x0000
<7> [365.338033] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] pipe csc: pre offsets: 0x0000 0x0000 0x0000
<7> [365.338108] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] pipe csc: coefficients: 0x0000 0x0000 0x0000
<7> [365.338199] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] pipe csc: coefficients: 0x0000 0x0000 0x0000
<7> [365.338282] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] pipe csc: coefficients: 0x0000 0x0000 0x0000
<7> [365.338331] xe 0000:00:02.0: [drm:icp_irq_handler [xe]] hotplug event received, stat 0x00010000, dig 0x0000000a, pins 0x00000010, long 0x00000010
<7> [365.338372] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] pipe csc: post offsets: 0x0000 0x0000 0x0000
<7> [365.338457] xe 0000:00:02.0: [drm:intel_hpd_irq_handler [xe]] digital hpd on [ENCODER:392:DDI A/PHY A] - long
<7> [365.338478] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [PLANE:35:plane 1A] fb: [FB:431] 2880x1800 format = XR24 little-endian (0x34325258) modifier = 0x100000000000009, visible: yes
<7> [365.338584] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] rotation: 0x1, scaler: -1, scaling_filter: 0
<7> [365.338576] xe 0000:00:02.0: [drm:intel_hpd_irq_handler [xe]] Received HPD interrupt on PIN 4 - cnt: 10
<7> [365.338680] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] src: 2880.000000x1800.000000+0.000000+0.000000 dst: 2880x1800+0+0
<7> [365.338706] xe 0000:00:02.0: [drm:intel_dp_hpd_pulse [xe]] ignoring long hpd on eDP [ENCODER:392:DDI A/PHY A]
<7> [365.338767] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [PLANE:65:plane 2A] fb: [NOFB], visible: no
<7> [365.338849] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [PLANE:95:plane 3A] fb: [NOFB], visible: no
<7> [365.338925] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [PLANE:125:plane 4A] fb: [NOFB], visible: no
<7> [365.339003] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [PLANE:135:plane 5A] fb: [NOFB], visible: no
<7> [365.339089] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [PLANE:145:cursor A] fb: [NOFB], visible: no
<7> [365.339205] xe 0000:00:02.0: [drm:intel_power_well_disable [xe]] disabling DC_off
<7> [365.339429] xe 0000:00:02.0: [drm:skl_enable_dc6 [xe]] Enabling DC6
<7> [365.339541] xe 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [xe]] Setting DC state from 00 to 02
<7> [365.339665] xe 0000:00:02.0: [drm:intel_power_well_enable [xe]] enabling DC_off
<7> [365.339760] xe 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [xe]] Setting DC state from 02 to 00
<7> [365.339894] xe 0000:00:02.0: [drm:intel_power_well_enable [xe]] enabling PW_A
<7> [365.340034] xe 0000:00:02.0: [drm:dss_pipe_gating_enable_disable [xe]] DSS clock gating enabled for pipe_mask=0x1 (CLKGATE_DIS_DSSDSC=0xa8000000)
<7> [365.340144] xe 0000:00:02.0: [drm:intel_set_cdclk [xe]] Pre changing CDCLK to 192000 kHz, VCO 614400 kHz, ref 38400 kHz, bypass 19200 kHz, voltage level 0
<7> [365.340260] xe 0000:00:02.0: [drm:intel_dbuf_mdclk_cdclk_ratio_update [xe]] Updating dbuf ratio to 4 (mbus joined: no)
<7> [365.340367] xe 0000:00:02.0: [drm:intel_audio_cdclk_change_post.part.0 [xe]] aud_ts_cdclk set to M=60, N=480
<7> [365.340470] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:392:DDI A/PHY A]
<7> [365.340540] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:401:DDI TC1/PHY TC1]
<7> [365.340609] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:403:DP-MST A]
<7> [365.340676] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:404:DP-MST B]
<7> [365.340743] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:405:DP-MST C]
<7> [365.340809] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:413:DDI TC2/PHY TC2]
<7> [365.340878] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:415:DP-MST A]
<7> [365.340951] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:416:DP-MST B]
<7> [365.341019] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:417:DP-MST C]
<7> [365.341086] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:421:DDI TC3/PHY TC3]
<7> [365.341166] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:423:DP-MST A]
<7> [365.341240] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:424:DP-MST B]
<7> [365.341310] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:425:DP-MST C]
<7> [365.341401] xe 0000:00:02.0: [drm:gen9_dbuf_slices_update [xe]] Updating dbuf slices to 0xf
<7> [365.341566] xe 0000:00:02.0: [drm:intel_dbuf_mbus_join_update [xe]] Changing mbus joined: no -> yes (pipe: *)
<7> [365.341628] xe 0000:00:02.0: [drm:intel_dbuf_mdclk_cdclk_ratio_update [xe]] Updating dbuf ratio to 8 (mbus joined: yes)
<7> [365.341733] xe 0000:00:02.0: [drm:intel_power_well_enable [xe]] enabling AUX_A
<7> [365.343173] xe 0000:00:02.0: [drm:intel_dpll_enable [xe]] enable DPLL 0 (active 0x1, on? 0) for [CRTC:151:pipe A]
<7> [365.343297] xe 0000:00:02.0: [drm:intel_dpll_enable [xe]] enabling DPLL 0
<7> [365.345317] xe 0000:00:02.0: [drm:intel_pps_on_unlocked [xe]] [ENCODER:392:DDI A/PHY A] PPS 0 turn panel power on
<7> [365.345420] xe 0000:00:02.0: [drm:wait_panel_power_cycle [xe]] [ENCODER:392:DDI A/PHY A] PPS 0 wait for panel power cycle (467 ms remaining)
<7> [365.817256] xe 0000:00:02.0: [drm:wait_panel_status [xe]] [ENCODER:392:DDI A/PHY A] PPS 0 mask: 0xb800000f value: 0x00000000 PP_STATUS: 0x08000001 PP_CONTROL: 0x00000060
<7> [365.887560] xe 0000:00:02.0: [drm:wait_panel_status [xe]] Wait complete
<7> [365.887883] xe 0000:00:02.0: [drm:intel_pps_on_unlocked [xe]] [ENCODER:392:DDI A/PHY A] PPS 0 wait for panel power on
<7> [365.888193] xe 0000:00:02.0: [drm:wait_panel_status [xe]] [ENCODER:392:DDI A/PHY A] PPS 0 mask: 0xb000000f value: 0x80000008 PP_STATUS: 0x9000000a PP_CONTROL: 0x00000063
<7> [365.924889] xe 0000:00:02.0: [drm:icp_irq_handler [xe]] hotplug event received, stat 0x00010000, dig 0x0000000a, pins 0x00000010, long 0x00000010
<7> [365.925226] xe 0000:00:02.0: [drm:intel_hpd_irq_handler [xe]] digital hpd on [ENCODER:392:DDI A/PHY A] - long
<7> [365.925517] xe 0000:00:02.0: [drm:intel_hpd_irq_handler [xe]] Received HPD interrupt on PIN 4 - cnt: 20
<7> [365.925875] xe 0000:00:02.0: [drm:intel_dp_hpd_pulse [xe]] ignoring long hpd on eDP [ENCODER:392:DDI A/PHY A]
<7> [365.969555] xe 0000:00:02.0: [drm:intel_tc_port_reset_mode [xe]] Port F/TC#3: TC port mode reset (tbt-alt -> disconnected) pin assignment: - max lanes: 4
<7> [365.969625] xe 0000:00:02.0: [drm:intel_tc_port_reset_mode [xe]] Port E/TC#2: TC port mode reset (tbt-alt -> disconnected) pin assignment: - max lanes: 4
<7> [365.969747] xe 0000:00:02.0: [drm:intel_tc_port_reset_mode [xe]] Port D/TC#1: TC port mode reset (tbt-alt -> disconnected) pin assignment: - max lanes: 4
<7> [366.095800] xe 0000:00:02.0: [drm:wait_panel_status [xe]] Wait complete
<7> [366.096178] xe 0000:00:02.0: [drm:intel_pps_vdd_on_unlocked [xe]] [ENCODER:392:DDI A/PHY A] PPS 0 turning VDD on
<7> [366.096440] xe 0000:00:02.0: [drm:intel_pps_vdd_on_unlocked [xe]] [ENCODER:392:DDI A/PHY A] PPS 0 PP_STATUS: 0x80000008 PP_CONTROL: 0x0000006b
<7> [366.098396] xe 0000:00:02.0: [drm:drm_dp_read_dpcd_caps [drm_display_helper]] AUX A/DDI A/PHY A: DPCD: 14 1e 44 c1 00 00 01 c0 02 00 02 00 00 0b 80
<7> [366.099870] xe 0000:00:02.0: [drm:intel_dp_start_link_train [xe]] [CONNECTOR:393:eDP-1][ENCODER:392:DDI A/PHY A][DPRX] Reloading eDP link rates
<7> [366.100618] xe 0000:00:02.0: [drm:intel_dp_start_link_train [xe]] [CONNECTOR:393:eDP-1][ENCODER:392:DDI A/PHY A][DPRX] Using LINK_RATE_SET value 05
<7> [366.101660] xe 0000:00:02.0: [drm:intel_dp_set_signal_levels [xe]] [CONNECTOR:393:eDP-1][ENCODER:392:DDI A/PHY A][DPRX] 8b/10b, lanes: 4, vswing levels: 0/0/0/0, pre-emphasis levels: 0/0/0/0
<7> [366.102953] xe 0000:00:02.0: [drm:intel_dp_program_link_training_pattern [xe]] [CONNECTOR:393:eDP-1][ENCODER:392:DDI A/PHY A][DPRX] Using DP training pattern TPS1
<7> [366.104056] xe 0000:00:02.0: [drm:intel_dp_link_train_phy [xe]] [CONNECTOR:393:eDP-1][ENCODER:392:DDI A/PHY A][DPRX] Clock recovery OK
<7> [366.104456] xe 0000:00:02.0: [drm:intel_dp_program_link_training_pattern [xe]] [CONNECTOR:393:eDP-1][ENCODER:392:DDI A/PHY A][DPRX] Using DP training pattern TPS4
<7> [366.105890] xe 0000:00:02.0: [drm:intel_dp_link_train_phy [xe]] [CONNECTOR:393:eDP-1][ENCODER:392:DDI A/PHY A][DPRX] Channel EQ done. DP Training successful
<7> [366.106288] xe 0000:00:02.0: [drm:intel_dp_link_train_phy [xe]] [CONNECTOR:393:eDP-1][ENCODER:392:DDI A/PHY A][DPRX] Link Training passed at link rate = 432000, lane count = 4
<7> [366.107063] xe 0000:00:02.0: [drm:intel_enable_transcoder [xe]] enabling pipe A
<7> [366.107581] xe 0000:00:02.0: [drm:intel_edp_backlight_on [xe]]
<7> [366.107988] xe 0000:00:02.0: [drm:intel_backlight_enable [xe]] pipe A
<7> [366.108458] xe 0000:00:02.0: [drm:intel_backlight_set_pwm_level [xe]] [CONNECTOR:393:eDP-1] set backlight PWM = 4518
<7> [366.141309] xe 0000:00:02.0: [drm:intel_psr_post_plane_update [xe]] Enabling PSR2
<7> [366.142925] xe 0000:00:02.0: [drm:verify_connector_state [xe]] [CONNECTOR:393:eDP-1]
<7> [366.143230] xe 0000:00:02.0: [drm:intel_modeset_verify_crtc [xe]] [CRTC:151:pipe A]
<7> [366.163179] xe 0000:00:02.0: [drm:intel_power_well_disable [xe]] disabling DC_off
<7> [366.163671] xe 0000:00:02.0: [drm:skl_enable_dc6 [xe]] Enabling DC6
<7> [366.164053] xe 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [xe]] Setting DC state from 00 to 02
<7> [366.425888] xe 0000:00:02.0: [drm:intel_power_well_enable [xe]] enabling DC_off
<7> [366.426308] xe 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [xe]] Setting DC state from 02 to 00
<7> [366.475255] xe 0000:00:02.0: [drm:intel_power_well_disable [xe]] disabling DC_off
<7> [366.475705] xe 0000:00:02.0: [drm:skl_enable_dc6 [xe]] Enabling DC6
<7> [366.476157] xe 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [xe]] Setting DC state from 00 to 02
<7> [366.609162] xe 0000:00:02.0: [drm:intel_power_well_enable [xe]] enabling DC_off
<7> [366.609506] xe 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [xe]] Setting DC state from 02 to 00
<7> [366.642259] xe 0000:00:02.0: [drm:intel_power_well_disable [xe]] disabling DC_off
<7> [366.642987] xe 0000:00:02.0: [drm:skl_enable_dc6 [xe]] Enabling DC6
<7> [366.643656] xe 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [xe]] Setting DC state from 00 to 02
<7> [366.775841] xe 0000:00:02.0: [drm:intel_power_well_enable [xe]] enabling DC_off
<7> [366.776224] xe 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [xe]] Setting DC state from 02 to 00
<7> [366.809144] xe 0000:00:02.0: [drm:intel_power_well_disable [xe]] disabling DC_off
<7> [366.809670] xe 0000:00:02.0: [drm:skl_enable_dc6 [xe]] Enabling DC6
<7> [366.810197] xe 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [xe]] Setting DC state from 00 to 02
<7> [366.942476] xe 0000:00:02.0: [drm:intel_power_well_enable [xe]] enabling DC_off
<7> [366.942824] xe 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [xe]] Setting DC state from 02 to 00
<7> [366.975322] xe 0000:00:02.0: [drm:intel_power_well_disable [xe]] disabling DC_off
<7> [366.975692] xe 0000:00:02.0: [drm:skl_enable_dc6 [xe]] Enabling DC6
<7> [366.975979] xe 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [xe]] Setting DC state from 00 to 02
<7> [367.109182] xe 0000:00:02.0: [drm:intel_power_well_enable [xe]] enabling DC_off
<7> [367.109546] xe 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [xe]] Setting DC state from 02 to 00
<7> [367.142332] xe 0000:00:02.0: [drm:intel_power_well_disable [xe]] disabling DC_off
<7> [367.142811] xe 0000:00:02.0: [drm:skl_enable_dc6 [xe]] Enabling DC6
<7> [367.143236] xe 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [xe]] Setting DC state from 00 to 02
<7> [367.275893] xe 0000:00:02.0: [drm:intel_power_well_enable [xe]] enabling DC_off
<7> [367.276357] xe 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [xe]] Setting DC state from 02 to 00
<7> [367.308309] xe 0000:00:02.0: [drm:intel_power_well_disable [xe]] disabling DC_off
<7> [367.308793] xe 0000:00:02.0: [drm:skl_enable_dc6 [xe]] Enabling DC6
<7> [367.309252] xe 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [xe]] Setting DC state from 00 to 02
<7> [367.442539] xe 0000:00:02.0: [drm:intel_power_well_enable [xe]] enabling DC_off
<7> [367.442939] xe 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [xe]] Setting DC state from 02 to 00
<7> [367.475320] xe 0000:00:02.0: [drm:intel_power_well_disable [xe]] disabling DC_off
<7> [367.475806] xe 0000:00:02.0: [drm:skl_enable_dc6 [xe]] Enabling DC6
<7> [367.476263] xe 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [xe]] Setting DC state from 00 to 02
<7> [367.609236] xe 0000:00:02.0: [drm:intel_power_well_enable [xe]] enabling DC_off
<7> [367.609599] xe 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [xe]] Setting DC state from 02 to 00
<7> [367.642310] xe 0000:00:02.0: [drm:intel_power_well_disable [xe]] disabling DC_off
<7> [367.642793] xe 0000:00:02.0: [drm:skl_enable_dc6 [xe]] Enabling DC6
<7> [367.643263] xe 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [xe]] Setting DC state from 00 to 02
<7> [367.775780] xe 0000:00:02.0: [drm:intel_power_well_enable [xe]] enabling DC_off
<7> [367.776237] xe 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [xe]] Setting DC state from 02 to 00
<7> [367.808294] xe 0000:00:02.0: [drm:intel_power_well_disable [xe]] disabling DC_off
<7> [367.808782] xe 0000:00:02.0: [drm:skl_enable_dc6 [xe]] Enabling DC6
<7> [367.809251] xe 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [xe]] Setting DC state from 00 to 02
<7> [367.942381] xe 0000:00:02.0: [drm:intel_power_well_enable [xe]] enabling DC_off
<7> [367.942723] xe 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [xe]] Setting DC state from 02 to 00
<7> [367.975290] xe 0000:00:02.0: [drm:intel_power_well_disable [xe]] disabling DC_off
<7> [367.975778] xe 0000:00:02.0: [drm:skl_enable_dc6 [xe]] Enabling DC6
<7> [367.976235] xe 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [xe]] Setting DC state from 00 to 02
<7> [368.109065] xe 0000:00:02.0: [drm:intel_power_well_enable [xe]] enabling DC_off
<7> [368.109475] xe 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [xe]] Setting DC state from 02 to 00
<7> [368.142318] xe 0000:00:02.0: [drm:intel_power_well_disable [xe]] disabling DC_off
<7> [368.142805] xe 0000:00:02.0: [drm:skl_enable_dc6 [xe]] Enabling DC6
<7> [368.143295] xe 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [xe]] Setting DC state from 00 to 02
<7> [368.275708] xe 0000:00:02.0: [drm:intel_power_well_enable [xe]] enabling DC_off
<7> [368.276144] xe 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [xe]] Setting DC state from 02 to 00
<7> [368.308272] xe 0000:00:02.0: [drm:intel_power_well_disable [xe]] disabling DC_off
<7> [368.308720] xe 0000:00:02.0: [drm:skl_enable_dc6 [xe]] Enabling DC6
<7> [368.309171] xe 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [xe]] Setting DC state from 00 to 02
<7> [368.442331] xe 0000:00:02.0: [drm:intel_power_well_enable [xe]] enabling DC_off
<7> [368.442715] xe 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [xe]] Setting DC state from 02 to 00
<7> [368.475270] xe 0000:00:02.0: [drm:intel_power_well_disable [xe]] disabling DC_off
<7> [368.475754] xe 0000:00:02.0: [drm:skl_enable_dc6 [xe]] Enabling DC6
<7> [368.476215] xe 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [xe]] Setting DC state from 00 to 02
<7> [368.608977] xe 0000:00:02.0: [drm:intel_power_well_enable [xe]] enabling DC_off
<7> [368.609439] xe 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [xe]] Setting DC state from 02 to 00
<7> [368.642273] xe 0000:00:02.0: [drm:intel_power_well_disable [xe]] disabling DC_off
<7> [368.642805] xe 0000:00:02.0: [drm:skl_enable_dc6 [xe]] Enabling DC6
<7> [368.643316] xe 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [xe]] Setting DC state from 00 to 02
<7> [368.657173] xe 0000:00:02.0: [drm:intel_pps_vdd_off_sync_unlocked [xe]] [ENCODER:392:DDI A/PHY A] PPS 0 turning VDD off
<7> [368.657549] xe 0000:00:02.0: [drm:intel_pps_vdd_off_sync_unlocked [xe]] [ENCODER:392:DDI A/PHY A] PPS 0 PP_STATUS: 0x80000008 PP_CONTROL: 0x00000067
<7> [368.775586] xe 0000:00:02.0: [drm:intel_power_well_enable [xe]] enabling DC_off
<7> [368.776041] xe 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [xe]] Setting DC state from 02 to 00
<7> [368.808249] xe 0000:00:02.0: [drm:intel_power_well_disable [xe]] disabling DC_off
<7> [368.808736] xe 0000:00:02.0: [drm:skl_enable_dc6 [xe]] Enabling DC6
<7> [368.809194] xe 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [xe]] Setting DC state from 00 to 02
<7> [368.942269] xe 0000:00:02.0: [drm:intel_power_well_enable [xe]] enabling DC_off
<7> [368.942629] xe 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [xe]] Setting DC state from 02 to 00
<7> [368.975283] xe 0000:00:02.0: [drm:intel_power_well_disable [xe]] disabling DC_off
<7> [368.975817] xe 0000:00:02.0: [drm:skl_enable_dc6 [xe]] Enabling DC6
<7> [368.976338] xe 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [xe]] Setting DC state from 00 to 02
<7> [369.108878] xe 0000:00:02.0: [drm:intel_power_well_enable [xe]] enabling DC_off
<7> [369.109345] xe 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [xe]] Setting DC state from 02 to 00
<7> [369.142242] xe 0000:00:02.0: [drm:intel_power_well_disable [xe]] disabling DC_off
<7> [369.142730] xe 0000:00:02.0: [drm:skl_enable_dc6 [xe]] Enabling DC6
<7> [369.143197] xe 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [xe]] Setting DC state from 00 to 02
<7> [369.275536] xe 0000:00:02.0: [drm:intel_power_well_enable [xe]] enabling DC_off
<7> [369.275937] xe 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [xe]] Setting DC state from 02 to 00
<7> [369.308240] xe 0000:00:02.0: [drm:intel_power_well_disable [xe]] disabling DC_off
<7> [369.308772] xe 0000:00:02.0: [drm:skl_enable_dc6 [xe]] Enabling DC6
<7> [369.309293] xe 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [xe]] Setting DC state from 00 to 02
<7> [369.442195] xe 0000:00:02.0: [drm:intel_power_well_enable [xe]] enabling DC_off
<7> [369.442554] xe 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [xe]] Setting DC state from 02 to 00
<7> [369.475239] xe 0000:00:02.0: [drm:intel_power_well_disable [xe]] disabling DC_off
<7> [369.475769] xe 0000:00:02.0: [drm:skl_enable_dc6 [xe]] Enabling DC6
<7> [369.476236] xe 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [xe]] Setting DC state from 00 to 02
<7> [369.608850] xe 0000:00:02.0: [drm:intel_power_well_enable [xe]] enabling DC_off
<7> [369.609306] xe 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [xe]] Setting DC state from 02 to 00
<7> [369.642244] xe 0000:00:02.0: [drm:intel_power_well_disable [xe]] disabling DC_off
<7> [369.642769] xe 0000:00:02.0: [drm:skl_enable_dc6 [xe]] Enabling DC6
<7> [369.643240] xe 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [xe]] Setting DC state from 00 to 02
<7> [369.775462] xe 0000:00:02.0: [drm:intel_power_well_enable [xe]] enabling DC_off
<7> [369.775860] xe 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [xe]] Setting DC state from 02 to 00
<7> [369.808222] xe 0000:00:02.0: [drm:intel_power_well_disable [xe]] disabling DC_off
<7> [369.808704] xe 0000:00:02.0: [drm:skl_enable_dc6 [xe]] Enabling DC6
<7> [369.809219] xe 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [xe]] Setting DC state from 00 to 02
<7> [369.942244] xe 0000:00:02.0: [drm:intel_power_well_enable [xe]] enabling DC_off
<7> [369.942686] xe 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [xe]] Setting DC state from 02 to 00
<7> [369.975232] xe 0000:00:02.0: [drm:intel_power_well_disable [xe]] disabling DC_off
<7> [369.975759] xe 0000:00:02.0: [drm:skl_enable_dc6 [xe]] Enabling DC6
<7> [369.976219] xe 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [xe]] Setting DC state from 00 to 02
<7> [370.108851] xe 0000:00:02.0: [drm:intel_power_well_enable [xe]] enabling DC_off
<7> [370.109322] xe 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [xe]] Setting DC state from 02 to 00
<7> [370.141122] xe 0000:00:02.0: [drm:intel_power_well_disable [xe]] disabling DC_off
<7> [370.141604] xe 0000:00:02.0: [drm:skl_enable_dc6 [xe]] Enabling DC6
<7> [370.142048] xe 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [xe]] Setting DC state from 00 to 02
<7> [370.275435] xe 0000:00:02.0: [drm:intel_power_well_enable [xe]] enabling DC_off
<7> [370.275852] xe 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [xe]] Setting DC state from 02 to 00
<7> [370.308104] xe 0000:00:02.0: [drm:intel_power_well_disable [xe]] disabling DC_off
<7> [370.308640] xe 0000:00:02.0: [drm:skl_enable_dc6 [xe]] Enabling DC6
<7> [370.309148] xe 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [xe]] Setting DC state from 00 to 02
<7> [370.442182] xe 0000:00:02.0: [drm:intel_power_well_enable [xe]] enabling DC_off
<7> [370.442617] xe 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [xe]] Setting DC state from 02 to 00
<7> [370.475172] xe 0000:00:02.0: [drm:intel_power_well_disable [xe]] disabling DC_off
<7> [370.475701] xe 0000:00:02.0: [drm:skl_enable_dc6 [xe]] Enabling DC6
<7> [370.476175] xe 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [xe]] Setting DC state from 00 to 02
<7> [370.608614] xe 0000:00:02.0: [drm:intel_power_well_enable [xe]] enabling DC_off
<7> [370.609019] xe 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [xe]] Setting DC state from 02 to 00
<7> [370.641273] xe 0000:00:02.0: [drm:intel_power_well_disable [xe]] disabling DC_off
<7> [370.641719] xe 0000:00:02.0: [drm:skl_enable_dc6 [xe]] Enabling DC6
<7> [370.642080] xe 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [xe]] Setting DC state from 00 to 02
<7> [370.775442] xe 0000:00:02.0: [drm:intel_power_well_enable [xe]] enabling DC_off
<7> [370.775864] xe 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [xe]] Setting DC state from 02 to 00
<7> [370.808330] xe 0000:00:02.0: [drm:intel_power_well_disable [xe]] disabling DC_off
<7> [370.808863] xe 0000:00:02.0: [drm:skl_enable_dc6 [xe]] Enabling DC6
<7> [370.809358] xe 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [xe]] Setting DC state from 00 to 02
<7> [370.942093] xe 0000:00:02.0: [drm:intel_power_well_enable [xe]] enabling DC_off
<7> [370.942536] xe 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [xe]] Setting DC state from 02 to 00
<7> [370.975164] xe 0000:00:02.0: [drm:intel_power_well_disable [xe]] disabling DC_off
<7> [370.975695] xe 0000:00:02.0: [drm:skl_enable_dc6 [xe]] Enabling DC6
<7> [370.976175] xe 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [xe]] Setting DC state from 00 to 02
<7> [371.108561] xe 0000:00:02.0: [drm:intel_power_well_enable [xe]] enabling DC_off
<7> [371.108975] xe 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [xe]] Setting DC state from 02 to 00
<7> [371.142550] xe 0000:00:02.0: [drm:intel_power_well_disable [xe]] disabling DC_off
<7> [371.143052] xe 0000:00:02.0: [drm:skl_enable_dc6 [xe]] Enabling DC6
<7> [371.143476] xe 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [xe]] Setting DC state from 00 to 02
<7> [371.275383] xe 0000:00:02.0: [drm:intel_power_well_enable [xe]] enabling DC_off
<7> [371.275910] xe 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [xe]] Setting DC state from 02 to 00
<7> [371.308895] xe 0000:00:02.0: [drm:intel_power_well_disable [xe]] disabling DC_off
<7> [371.309427] xe 0000:00:02.0: [drm:skl_enable_dc6 [xe]] Enabling DC6
<7> [371.309896] xe 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [xe]] Setting DC state from 00 to 02
<7> [371.441886] xe 0000:00:02.0: [drm:intel_power_well_enable [xe]] enabling DC_off
<7> [371.442254] xe 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [xe]] Setting DC state from 02 to 00
<7> [371.475248] xe 0000:00:02.0: [drm:intel_power_well_disable [xe]] disabling DC_off
<7> [371.475727] xe 0000:00:02.0: [drm:skl_enable_dc6 [xe]] Enabling DC6
<7> [371.476167] xe 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [xe]] Setting DC state from 00 to 02
<7> [371.608502] xe 0000:00:02.0: [drm:intel_power_well_enable [xe]] enabling DC_off
<7> [371.608897] xe 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [xe]] Setting DC state from 02 to 00
<7> [371.641625] xe 0000:00:02.0: [drm:intel_power_well_disable [xe]] disabling DC_off
<7> [371.642152] xe 0000:00:02.0: [drm:skl_enable_dc6 [xe]] Enabling DC6
<7> [371.642627] xe 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [xe]] Setting DC state from 00 to 02
<7> [371.775173] xe 0000:00:02.0: [drm:intel_power_well_enable [xe]] enabling DC_off
<7> [371.775537] xe 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [xe]] Setting DC state from 02 to 00
<7> [371.809017] xe 0000:00:02.0: [drm:intel_power_well_disable [xe]] disabling DC_off
<7> [371.809546] xe 0000:00:02.0: [drm:skl_enable_dc6 [xe]] Enabling DC6
<7> [371.810021] xe 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [xe]] Setting DC state from 00 to 02
<7> [371.941990] xe 0000:00:02.0: [drm:intel_power_well_enable [xe]] enabling DC_off
<7> [371.942430] xe 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [xe]] Setting DC state from 02 to 00
<7> [371.974938] xe 0000:00:02.0: [drm:intel_power_well_disable [xe]] disabling DC_off
<7> [371.975466] xe 0000:00:02.0: [drm:skl_enable_dc6 [xe]] Enabling DC6
<7> [371.975948] xe 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [xe]] Setting DC state from 00 to 02
<7> [372.108725] xe 0000:00:02.0: [drm:intel_power_well_enable [xe]] enabling DC_off
<7> [372.109243] xe 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [xe]] Setting DC state from 02 to 00
<7> [372.141547] xe 0000:00:02.0: [drm:intel_power_well_disable [xe]] disabling DC_off
<7> [372.142077] xe 0000:00:02.0: [drm:skl_enable_dc6 [xe]] Enabling DC6
<7> [372.142566] xe 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [xe]] Setting DC state from 00 to 02
<7> [372.275200] xe 0000:00:02.0: [drm:intel_power_well_enable [xe]] enabling DC_off
<7> [372.275644] xe 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [xe]] Setting DC state from 02 to 00
<7> [372.308093] xe 0000:00:02.0: [drm:intel_power_well_disable [xe]] disabling DC_off
<7> [372.308615] xe 0000:00:02.0: [drm:skl_enable_dc6 [xe]] Enabling DC6
<7> [372.309136] xe 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [xe]] Setting DC state from 00 to 02
<7> [372.441791] xe 0000:00:02.0: [drm:intel_power_well_enable [xe]] enabling DC_off
<7> [372.442155] xe 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [xe]] Setting DC state from 02 to 00
<7> [372.474672] xe 0000:00:02.0: [drm:intel_power_well_disable [xe]] disabling DC_off
<7> [372.475155] xe 0000:00:02.0: [drm:skl_enable_dc6 [xe]] Enabling DC6
<7> [372.475552] xe 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [xe]] Setting DC state from 00 to 02
<7> [372.608338] xe 0000:00:02.0: [drm:intel_power_well_enable [xe]] enabling DC_off
<7> [372.608723] xe 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [xe]] Setting DC state from 02 to 00
<7> [372.642436] xe 0000:00:02.0: [drm:intel_power_well_disable [xe]] disabling DC_off
<7> [372.642920] xe 0000:00:02.0: [drm:skl_enable_dc6 [xe]] Enabling DC6
<7> [372.643399] xe 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [xe]] Setting DC state from 00 to 02
<7> [372.775017] xe 0000:00:02.0: [drm:intel_power_well_enable [xe]] enabling DC_off
<7> [372.775426] xe 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [xe]] Setting DC state from 02 to 00
<7> [372.808993] xe 0000:00:02.0: [drm:intel_power_well_disable [xe]] disabling DC_off
<7> [372.809476] xe 0000:00:02.0: [drm:skl_enable_dc6 [xe]] Enabling DC6
<7> [372.809946] xe 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [xe]] Setting DC state from 00 to 02
<7> [372.941608] xe 0000:00:02.0: [drm:intel_power_well_enable [xe]] enabling DC_off
<7> [372.942023] xe 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [xe]] Setting DC state from 02 to 00
<7> [372.975408] xe 0000:00:02.0: [drm:intel_power_well_disable [xe]] disabling DC_off
<7> [372.975938] xe 0000:00:02.0: [drm:skl_enable_dc6 [xe]] Enabling DC6
<7> [372.976466] xe 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [xe]] Setting DC state from 00 to 02
<7> [373.108366] xe 0000:00:02.0: [drm:intel_power_well_enable [xe]] enabling DC_off
<7> [373.108749] xe 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [xe]] Setting DC state from 02 to 00
<7> [373.141281] xe 0000:00:02.0: [drm:intel_power_well_disable [xe]] disabling DC_off
<7> [373.141816] xe 0000:00:02.0: [drm:skl_enable_dc6 [xe]] Enabling DC6
<7> [373.142330] xe 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [xe]] Setting DC state from 00 to 02
<7> [373.274926] xe 0000:00:02.0: [drm:intel_power_well_enable [xe]] enabling DC_off
<7> [373.275389] xe 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [xe]] Setting DC state from 02 to 00
<7> [373.308176] xe 0000:00:02.0: [drm:intel_power_well_disable [xe]] disabling DC_off
<7> [373.308704] xe 0000:00:02.0: [drm:skl_enable_dc6 [xe]] Enabling DC6
<7> [373.309175] xe 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [xe]] Setting DC state from 00 to 02
<7> [373.441557] xe 0000:00:02.0: [drm:intel_power_well_enable [xe]] enabling DC_off
<7> [373.442024] xe 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [xe]] Setting DC state from 02 to 00
<7> [373.475082] xe 0000:00:02.0: [drm:intel_power_well_disable [xe]] disabling DC_off
<7> [373.475615] xe 0000:00:02.0: [drm:skl_enable_dc6 [xe]] Enabling DC6
<7> [373.476127] xe 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [xe]] Setting DC state from 00 to 02
<7> [373.608225] xe 0000:00:02.0: [drm:intel_power_well_enable [xe]] enabling DC_off
<7> [373.608632] xe 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [xe]] Setting DC state from 02 to 00
<7> [373.641974] xe 0000:00:02.0: [drm:intel_power_well_disable [xe]] disabling DC_off
<7> [373.642504] xe 0000:00:02.0: [drm:skl_enable_dc6 [xe]] Enabling DC6
<7> [373.643019] xe 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [xe]] Setting DC state from 00 to 02
<7> [373.774854] xe 0000:00:02.0: [drm:intel_power_well_enable [xe]] enabling DC_off
<7> [373.775220] xe 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [xe]] Setting DC state from 02 to 00
<7> [373.807863] xe 0000:00:02.0: [drm:intel_power_well_disable [xe]] disabling DC_off
<7> [373.808352] xe 0000:00:02.0: [drm:skl_enable_dc6 [xe]] Enabling DC6
<7> [373.808816] xe 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [xe]] Setting DC state from 00 to 02
<7> [373.941478] xe 0000:00:02.0: [drm:intel_power_well_enable [xe]] enabling DC_off
<7> [373.941936] xe 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [xe]] Setting DC state from 02 to 00
<7> [373.974678] xe 0000:00:02.0: [drm:intel_power_well_disable [xe]] disabling DC_off
<7> [373.975213] xe 0000:00:02.0: [drm:skl_enable_dc6 [xe]] Enabling DC6
<7> [373.975731] xe 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [xe]] Setting DC state from 00 to 02
<7> [374.108160] xe 0000:00:02.0: [drm:intel_power_well_enable [xe]] enabling DC_off
<7> [374.108518] xe 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [xe]] Setting DC state from 02 to 00
<7> [374.141992] xe 0000:00:02.0: [drm:intel_power_well_disable [xe]] disabling DC_off
<7> [374.142476] xe 0000:00:02.0: [drm:skl_enable_dc6 [xe]] Enabling DC6
<7> [374.142958] xe 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [xe]] Setting DC state from 00 to 02
<7> [374.274761] xe 0000:00:02.0: [drm:intel_power_well_enable [xe]] enabling DC_off
<7> [374.275201] xe 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [xe]] Setting DC state from 02 to 00
<7> [374.308268] xe 0000:00:02.0: [drm:intel_power_well_disable [xe]] disabling DC_off
<7> [374.308800] xe 0000:00:02.0: [drm:skl_enable_dc6 [xe]] Enabling DC6
<7> [374.309335] xe 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [xe]] Setting DC state from 00 to 02
<7> [374.441352] xe 0000:00:02.0: [drm:intel_power_well_enable [xe]] enabling DC_off
<7> [374.441785] xe 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [xe]] Setting DC state from 02 to 00
<7> [374.474550] xe 0000:00:02.0: [drm:intel_power_well_disable [xe]] disabling DC_off
<7> [374.475082] xe 0000:00:02.0: [drm:skl_enable_dc6 [xe]] Enabling DC6
<7> [374.475598] xe 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [xe]] Setting DC state from 00 to 02
<7> [374.608119] xe 0000:00:02.0: [drm:intel_power_well_enable [xe]] enabling DC_off
<7> [374.608533] xe 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [xe]] Setting DC state from 02 to 00
<7> [374.641843] xe 0000:00:02.0: [drm:intel_power_well_disable [xe]] disabling DC_off
<7> [374.642365] xe 0000:00:02.0: [drm:skl_enable_dc6 [xe]] Enabling DC6
<7> [374.642873] xe 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [xe]] Setting DC state from 00 to 02
<7> [374.774593] xe 0000:00:02.0: [drm:intel_power_well_enable [xe]] enabling DC_off
<7> [374.774985] xe 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [xe]] Setting DC state from 02 to 00
<7> [374.808054] xe 0000:00:02.0: [drm:intel_power_well_disable [xe]] disabling DC_off
<7> [374.808543] xe 0000:00:02.0: [drm:skl_enable_dc6 [xe]] Enabling DC6
<7> [374.808990] xe 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [xe]] Setting DC state from 00 to 02
<7> [374.941273] xe 0000:00:02.0: [drm:intel_power_well_enable [xe]] enabling DC_off
<7> [374.941715] xe 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [xe]] Setting DC state from 02 to 00
<7> [374.974327] xe 0000:00:02.0: [drm:intel_power_well_disable [xe]] disabling DC_off
<7> [374.974816] xe 0000:00:02.0: [drm:skl_enable_dc6 [xe]] Enabling DC6
<7> [374.975253] xe 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [xe]] Setting DC state from 00 to 02
<7> [375.107957] xe 0000:00:02.0: [drm:intel_power_well_enable [xe]] enabling DC_off
<7> [375.108429] xe 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [xe]] Setting DC state from 02 to 00
<7> [375.141208] xe 0000:00:02.0: [drm:intel_power_well_disable [xe]] disabling DC_off
<7> [375.141746] xe 0000:00:02.0: [drm:skl_enable_dc6 [xe]] Enabling DC6
<7> [375.142262] xe 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [xe]] Setting DC state from 00 to 02
<7> [375.274488] xe 0000:00:02.0: [drm:intel_power_well_enable [xe]] enabling DC_off
<7> [375.274903] xe 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [xe]] Setting DC state from 02 to 00
<7> [375.307975] xe 0000:00:02.0: [drm:intel_power_well_disable [xe]] disabling DC_off
<7> [375.308422] xe 0000:00:02.0: [drm:skl_enable_dc6 [xe]] Enabling DC6
<7> [375.308882] xe 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [xe]] Setting DC state from 00 to 02
<7> [375.441244] xe 0000:00:02.0: [drm:intel_power_well_enable [xe]] enabling DC_off
<7> [375.441685] xe 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [xe]] Setting DC state from 02 to 00
<7> [375.474742] xe 0000:00:02.0: [drm:intel_power_well_disable [xe]] disabling DC_off
<7> [375.475271] xe 0000:00:02.0: [drm:skl_enable_dc6 [xe]] Enabling DC6
<7> [375.475796] xe 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [xe]] Setting DC state from 00 to 02
<7> [375.607940] xe 0000:00:02.0: [drm:intel_power_well_enable [xe]] enabling DC_off
<7> [375.608376] xe 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [xe]] Setting DC state from 02 to 00
<7> [375.641544] xe 0000:00:02.0: [drm:intel_power_well_disable [xe]] disabling DC_off
<7> [375.642072] xe 0000:00:02.0: [drm:skl_enable_dc6 [xe]] Enabling DC6
<7> [375.642599] xe 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [xe]] Setting DC state from 00 to 02
<7> [375.774461] xe 0000:00:02.0: [drm:intel_power_well_enable [xe]] enabling DC_off
<7> [375.774866] xe 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [xe]] Setting DC state from 02 to 00
<7> [375.808294] xe 0000:00:02.0: [drm:intel_power_well_disable [xe]] disabling DC_off
<7> [375.808826] xe 0000:00:02.0: [drm:skl_enable_dc6 [xe]] Enabling DC6
<7> [375.809364] xe 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [xe]] Setting DC state from 00 to 02
<7> [375.941171] xe 0000:00:02.0: [drm:intel_power_well_enable [xe]] enabling DC_off
<7> [375.941618] xe 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [xe]] Setting DC state from 02 to 00
<7> [375.974040] xe 0000:00:02.0: [drm:intel_power_well_disable [xe]] disabling DC_off
<7> [375.974571] xe 0000:00:02.0: [drm:skl_enable_dc6 [xe]] Enabling DC6
<7> [375.975087] xe 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [xe]] Setting DC state from 00 to 02
<7> [376.107734] xe 0000:00:02.0: [drm:intel_power_well_enable [xe]] enabling DC_off
<7> [376.108140] xe 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [xe]] Setting DC state from 02 to 00
<7> [376.141445] xe 0000:00:02.0: [drm:intel_power_well_disable [xe]] disabling DC_off
<7> [376.141892] xe 0000:00:02.0: [drm:skl_enable_dc6 [xe]] Enabling DC6
<7> [376.142306] xe 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [xe]] Setting DC state from 00 to 02
<7> [376.274304] xe 0000:00:02.0: [drm:intel_power_well_enable [xe]] enabling DC_off
<7> [376.274686] xe 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [xe]] Setting DC state from 02 to 00
<7> [376.307750] xe 0000:00:02.0: [drm:intel_power_well_disable [xe]] disabling DC_off
<7> [376.308279] xe 0000:00:02.0: [drm:skl_enable_dc6 [xe]] Enabling DC6
<7> [376.308825] xe 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [xe]] Setting DC state from 00 to 02
<7> [376.441070] xe 0000:00:02.0: [drm:intel_power_well_enable [xe]] enabling DC_off
<7> [376.441577] xe 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [xe]] Setting DC state from 02 to 00
<7> [376.474042] xe 0000:00:02.0: [drm:intel_power_well_disable [xe]] disabling DC_off
<7> [376.474571] xe 0000:00:02.0: [drm:skl_enable_dc6 [xe]] Enabling DC6
<7> [376.475088] xe 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [xe]] Setting DC state from 00 to 02
<7> [376.607683] xe 0000:00:02.0: [drm:intel_power_well_enable [xe]] enabling DC_off
<7> [376.608092] xe 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [xe]] Setting DC state from 02 to 00
<7> [376.641365] xe 0000:00:02.0: [drm:intel_power_well_disable [xe]] disabling DC_off
<7> [376.641896] xe 0000:00:02.0: [drm:skl_enable_dc6 [xe]] Enabling DC6
<7> [376.642420] xe 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [xe]] Setting DC state from 00 to 02
<7> [379.845635] xe 0000:00:02.0: [drm:drm_mode_setcrtc] [CRTC:151:pipe A]
<7> [379.846055] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:151:pipe A] fastset requirement not met in hw.enable (expected yes, found no)
<7> [379.846543] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:151:pipe A] fastset requirement not met in hw.active (expected yes, found no)
<7> [379.847025] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:151:pipe A] fastset requirement not met in cpu_transcoder (expected 0, found -1)
<7> [379.847462] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:151:pipe A] fastset requirement not met in lane_count (expected 4, found 0)
<7> [379.847912] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:151:pipe A] fastset requirement not met in dp_m_n (expected tu 64 data 6329869/8388608 link 421991/524288, found tu 0, data 0/0 link 0/0)
<7> [379.848506] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:151:pipe A] fastset requirement not met in output_types (expected 0x00000100, found 0x00000000)
<7> [379.849089] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:151:pipe A] fastset requirement not met in framestart_delay (expected 1, found 0)
<7> [379.849578] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:151:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hdisplay (expected 2880, found 0)
<7> [379.850166] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:151:pipe A] fastset requirement not met in hw.pipe_mode.crtc_htotal (expected 3040, found 0)
<7> [379.850739] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:151:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hblank_start (expected 2880, found 0)
<7> [379.851278] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:151:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hblank_end (expected 3040, found 0)
<7> [379.851799] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:151:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hsync_start (expected 2928, found 0)
<7> [379.852376] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:151:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hsync_end (expected 2960, found 0)
<7> [379.852875] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:151:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vdisplay (expected 1800, found 0)
<7> [379.853439] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:151:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vblank_start (expected 1800, found 0)
<7> [379.853930] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:151:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vsync_start (expected 1803, found 0)
<7> [379.854380] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:151:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vsync_end (expected 1809, found 0)
<7> [379.854828] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:151:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vtotal (expected 1906, found 0)
<7> [379.855344] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:151:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vblank_end (expected 1906, found 0)
<7> [379.855824] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:151:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hdisplay (expected 2880, found 0)
<7> [379.856334] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:151:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_htotal (expected 3040, found 0)
<7> [379.856830] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:151:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hblank_start (expected 2880, found 0)
<7> [379.857332] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:151:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hblank_end (expected 3040, found 0)
<7> [379.857798] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:151:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hsync_start (expected 2928, found 0)
<7> [379.858283] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:151:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hsync_end (expected 2960, found 0)
<7> [379.858740] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:151:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vdisplay (expected 1800, found 0)
<7> [379.859251] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:151:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vblank_start (expected 1800, found 0)
<7> [379.859696] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:151:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vsync_start (expected 1803, found 0)
<7> [379.860109] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:151:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vsync_end (expected 1809, found 0)
<7> [379.860513] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:151:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vtotal (expected 1906, found 0)
<7> [379.860871] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:151:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vblank_end (expected 1906, found 0)
<7> [379.861234] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:151:pipe A] fastset requirement not met in pixel_multiplier (expected 1, found 0)
<7> [379.861582] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:151:pipe A] fastset requirement not met in hw.adjusted_mode.flags (2) (expected 2, found 0)
<7> [379.861874] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:151:pipe A] fastset requirement not met in hw.adjusted_mode.flags (8) (expected 8, found 0)
<7> [379.862223] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:151:pipe A] fastset requirement not met in pipe_bpp (expected 30, found 0)
<7> [379.862500] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:151:pipe A] fastset requirement not met in hw.pipe_mode.crtc_clock (expected 347710, found 0)
<7> [379.862772] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:151:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_clock (expected 347710, found 0)
<7> [379.863031] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:151:pipe A] fastset requirement not met in port_clock (expected 432000, found 0)
<7> [379.863286] xe 0000:00:02.0: [drm:intel_atomic_check [xe]] [CRTC:151:pipe A] fastset requirement not met, forcing full modeset
<7> [379.863531] xe 0000:00:02.0: [drm:intel_dpll_crtc_put [xe]] [CRTC:151:pipe A] releasing DPLL 0
<7> [379.863882] xe 0000:00:02.0: [drm:skl_compute_wm [xe]] Enabled dbuf slices 0xf -> 0x1 (total dbuf slices 0xf), mbus joined? yes->no
<7> [379.864083] xe 0000:00:02.0: [drm:skl_compute_wm [xe]] [CRTC:151:pipe A] dbuf slices 0xf -> 0x0, ddb (0 - 4096) -> (0 - 0), active pipes 0x1 -> 0x0
<7> [379.864308] xe 0000:00:02.0: [drm:skl_print_plane_ddb_changes [xe]] [PLANE:35:plane 1A] ddb ( 0 - 4051) -> ( 0 - 0), size 4051 -> 0
<7> [379.864471] xe 0000:00:02.0: [drm:skl_print_plane_ddb_changes [xe]] [PLANE:145:cursor A] ddb (4051 - 4096) -> ( 0 - 0), size 45 -> 0
<7> [379.864636] xe 0000:00:02.0: [drm:skl_print_plane_wm_changes [xe]] [PLANE:35:plane 1A] level *wm0,*wm1,*wm2,*wm3,*wm4,*wm5, wm6, wm7,*twm,*swm,*stwm -> wm0, wm1, wm2, wm3, wm4, wm5, wm6, wm7, twm, swm, stwm
<7> [379.864799] xe 0000:00:02.0: [drm:skl_print_plane_wm_changes [xe]] [PLANE:35:plane 1A] lines 4, 13, 13, 13, 13, 13, 0, 0, 0, 4, 0 -> 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0
<7> [379.864954] xe 0000:00:02.0: [drm:skl_print_plane_wm_changes [xe]] [PLANE:35:plane 1A] blocks 92, 297, 297, 297, 297, 297, 0, 0, 197, 92, 197 -> 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0
<7> [379.865161] xe 0000:00:02.0: [drm:skl_print_plane_wm_changes [xe]] [PLANE:35:plane 1A] min_ddb 183, 456, 456, 456, 456, 456, 0, 0, 198, 183, 198 -> 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0
<7> [379.865357] xe 0000:00:02.0: [drm:intel_bw_atomic_check [xe]] [CRTC:151:pipe A] data rate 0 num active planes 0
<7> [379.865574] xe 0000:00:02.0: [drm:intel_bw_atomic_check [xe]] QGV point 0: max bw 23530 required 0 qgv_peak_bw: 38400
<7> [379.865771] xe 0000:00:02.0: [drm:intel_bw_atomic_check [xe]] QGV point 1: max bw 36260 required 0 qgv_peak_bw: 38400
<7> [379.865962] xe 0000:00:02.0: [drm:intel_bw_atomic_check [xe]] QGV point 2: max bw 38000 required 0 qgv_peak_bw: 38400
<7> [379.866173] xe 0000:00:02.0: [drm:intel_bw_atomic_check [xe]] QGV point 3: max bw 38000 required 0 qgv_peak_bw: 38400
<7> [379.866355] xe 0000:00:02.0: [drm:intel_bw_atomic_check [xe]] Matching peaks QGV bw: 38400 for required data rate: 0
<7> [379.866554] xe 0000:00:02.0: [drm:intel_cdclk_atomic_check [xe]] [CRTC:151:pipe A] min cdclk: 173855 kHz -> 0 kHz
<7> [379.866772] xe 0000:00:02.0: [drm:intel_cdclk_update_dbuf_bw_min_cdclk [xe]] dbuf bandwidth min cdclk: 21732 kHz -> 0 kHz
<7> [379.866958] xe 0000:00:02.0: [drm:intel_cdclk_atomic_check [xe]] Can change cdclk via squashing
<7> [379.867125] xe 0000:00:02.0: [drm:intel_cdclk_atomic_check [xe]] New cdclk calculated to be logical 153600 kHz, actual 153600 kHz
<7> [379.867275] xe 0000:00:02.0: [drm:intel_cdclk_atomic_check [xe]] New voltage level calculated to be logical 0, actual 0
<7> [379.867460] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [CRTC:151:pipe A] enable: no [modeset]
<7> [379.867626] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [PLANE:35:plane 1A] fb: [NOFB], visible: no
<7> [379.867771] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [PLANE:65:plane 2A] fb: [NOFB], visible: no
<7> [379.867914] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [PLANE:95:plane 3A] fb: [NOFB], visible: no
<7> [379.868049] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [PLANE:125:plane 4A] fb: [NOFB], visible: no
<7> [379.868211] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [PLANE:135:plane 5A] fb: [NOFB], visible: no
<7> [379.868339] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [PLANE:145:cursor A] fb: [NOFB], visible: no
<7> [379.868537] xe 0000:00:02.0: [drm:intel_power_well_enable [xe]] enabling DC_off
<7> [379.868684] xe 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [xe]] Setting DC state from 02 to 00
<7> [379.868875] xe 0000:00:02.0: [drm:intel_psr_disable_locked [xe]] Disabling PSR2
<7> [379.869087] xe 0000:00:02.0: [drm:intel_pps_vdd_on_unlocked [xe]] [ENCODER:392:DDI A/PHY A] PPS 0 turning VDD on
<7> [379.869214] xe 0000:00:02.0: [drm:intel_pps_vdd_on_unlocked [xe]] [ENCODER:392:DDI A/PHY A] PPS 0 PP_STATUS: 0x80000008 PP_CONTROL: 0x0000006f
<7> [379.869808] xe 0000:00:02.0: [drm:intel_alpm_disable [xe]] Disabling ALPM
<7> [379.869935] xe 0000:00:02.0: [drm:intel_edp_backlight_off [xe]]
<7> [380.079185] xe 0000:00:02.0: [drm:intel_backlight_set_pwm_level [xe]] [CONNECTOR:393:eDP-1] set backlight PWM = 0
<7> [380.079739] xe 0000:00:02.0: [drm:intel_disable_transcoder [xe]] disabling pipe A
<7> [380.087503] xe 0000:00:02.0: [drm:intel_pps_off_unlocked [xe]] [ENCODER:392:DDI A/PHY A] PPS 0 turn panel power off
<7> [380.087973] xe 0000:00:02.0: [drm:icp_irq_handler [xe]] hotplug event received, stat 0x00010000, dig 0x00000009, pins 0x00000010, long 0x00000000
<7> [380.088455] xe 0000:00:02.0: [drm:intel_hpd_irq_handler [xe]] digital hpd on [ENCODER:392:DDI A/PHY A] - short
<7> [380.088999] xe 0000:00:02.0: [drm:intel_pps_off_unlocked [xe]] [ENCODER:392:DDI A/PHY A] PPS 0 wait for panel power off time
<7> [380.089482] xe 0000:00:02.0: [drm:wait_panel_status [xe]] [ENCODER:392:DDI A/PHY A] PPS 0 mask: 0xb0000000 value: 0x00000000 PP_STATUS: 0xa0000002 PP_CONTROL: 0x00000060
<7> [380.141316] xe 0000:00:02.0: [drm:wait_panel_status [xe]] Wait complete
<7> [380.141730] xe 0000:00:02.0: [drm:icp_irq_handler [xe]] hotplug event received, stat 0x00010000, dig 0x00000009, pins 0x00000010, long 0x00000000
<7> [380.142069] xe 0000:00:02.0: [drm:intel_hpd_irq_handler [xe]] digital hpd on [ENCODER:392:DDI A/PHY A] - short
<7> [380.142443] xe 0000:00:02.0: [drm:intel_dpll_disable [xe]] disable DPLL 0 (active 0x1, on? 1) for [CRTC:151:pipe A]
<7> [380.142595] xe 0000:00:02.0: [drm:intel_dp_hpd_pulse [xe]] ignoring short hpd on eDP [ENCODER:392:DDI A/PHY A]
<7> [380.143122] xe 0000:00:02.0: [drm:intel_dp_hpd_pulse [xe]] ignoring short hpd on eDP [ENCODER:392:DDI A/PHY A]
<7> [380.143980] xe 0000:00:02.0: [drm:intel_dpll_disable [xe]] disabling DPLL 0
<7> [380.144541] xe 0000:00:02.0: [drm:intel_power_well_disable [xe]] disabling AUX_A
<7> [380.145067] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:392:DDI A/PHY A]
<7> [380.145421] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:401:DDI TC1/PHY TC1]
<7> [380.145742] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:403:DP-MST A]
<7> [380.146040] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:404:DP-MST B]
<7> [380.146330] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:405:DP-MST C]
<7> [380.146616] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:413:DDI TC2/PHY TC2]
<7> [380.146944] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:415:DP-MST A]
<7> [380.147287] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:416:DP-MST B]
<7> [380.147568] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:417:DP-MST C]
<7> [380.147892] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:421:DDI TC3/PHY TC3]
<7> [380.148165] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:423:DP-MST A]
<7> [380.148438] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:424:DP-MST B]
<7> [380.148759] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:425:DP-MST C]
<7> [380.149042] xe 0000:00:02.0: [drm:verify_connector_state [xe]] [CONNECTOR:393:eDP-1]
<7> [380.149412] xe 0000:00:02.0: [drm:intel_dbuf_mdclk_cdclk_ratio_update [xe]] Updating dbuf ratio to 4 (mbus joined: no)
<7> [380.149677] xe 0000:00:02.0: [drm:intel_dbuf_mbus_join_update [xe]] Changing mbus joined: yes -> no (pipe: *)
<7> [380.149998] xe 0000:00:02.0: [drm:gen9_dbuf_slices_update [xe]] Updating dbuf slices to 0x1
<7> [380.150515] xe 0000:00:02.0: [drm:intel_power_well_disable [xe]] disabling PW_A
<7> [380.150924] xe 0000:00:02.0: [drm:dss_pipe_gating_enable_disable [xe]] DSS clock gating disabled for pipe_mask=0x1 (CLKGATE_DIS_DSSDSC=0xaa000000)
<7> [380.151361] xe 0000:00:02.0: [drm:intel_modeset_verify_crtc [xe]] [CRTC:151:pipe A]
<7> [380.151735] xe 0000:00:02.0: [drm:intel_set_cdclk [xe]] Post changing CDCLK to 153600 kHz, VCO 614400 kHz, ref 38400 kHz, bypass 19200 kHz, voltage level 0
<7> [380.152255] xe 0000:00:02.0: [drm:intel_dbuf_mdclk_cdclk_ratio_update [xe]] Updating dbuf ratio to 4 (mbus joined: no)
<7> [380.152548] xe 0000:00:02.0: [drm:intel_audio_cdclk_change_post.part.0 [xe]] aud_ts_cdclk set to M=60, N=384
<7> [380.153505] xe 0000:00:02.0: [drm:drm_mode_setcrtc] [CRTC:270:pipe B]
<7> [380.153910] xe 0000:00:02.0: [drm:drm_mode_setcrtc] [CRTC:389:pipe C]
<7> [380.154209] xe 0000:00:02.0: [drm:drm_mode_setcrtc] [CRTC:151:pipe A]
<7> [380.154268] xe 0000:00:02.0: [drm:drm_mode_setcrtc] [CONNECTOR:393:eDP-1]
<7> [380.154438] xe 0000:00:02.0: [drm:compute_baseline_pipe_bpp [xe]] [CONNECTOR:393:eDP-1] Limiting target display pipe bpp to 30 (EDID bpp 30, max requested bpp 36, max platform bpp 36)
<7> [380.154826] xe 0000:00:02.0: [drm:intel_dp_compute_config_limits [xe]] [ENCODER:392:DDI A/PHY A][CRTC:151:pipe A] DP link limits: pixel clock 347710 kHz DSC off max lanes 4 max rate 810000 max pipe_bpp 30 min link_bpp 18.0000 max link_bpp 30.0000
<7> [380.155167] xe 0000:00:02.0: [drm:intel_dp_compute_output_format [xe]] DP lane count 4 clock 432000 bpp input 30 compressed 0.0000 HDR no link rate required 1303913 available 1728000
<7> [380.155537] xe 0000:00:02.0: [drm:intel_atomic_check [xe]] [CRTC:151:pipe A] hw max bpp: 30, pipe bpp: 30, dithering: 0
<7> [380.155880] xe 0000:00:02.0: [drm:intel_ddi_compute_config_late [xe]] [ENCODER:392:DDI A/PHY A] [CRTC:151:pipe A]
<7> [380.156182] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:151:pipe A] fastset requirement not met in hw.enable (expected no, found yes)
<7> [380.156461] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:151:pipe A] fastset requirement not met in hw.active (expected no, found yes)
<7> [380.156724] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:151:pipe A] fastset requirement not met in cpu_transcoder (expected -1, found 0)
<7> [380.157016] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:151:pipe A] fastset requirement not met in lane_count (expected 0, found 4)
<7> [380.157289] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:151:pipe A] fastset requirement not met in dp_m_n (expected tu 0 data 0/0 link 0/0, found tu 64, data 6329869/8388608 link 421991/524288)
<7> [380.157518] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:151:pipe A] fastset requirement not met in output_types (expected 0x00000000, found 0x00000100)
<7> [380.157741] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:151:pipe A] fastset requirement not met in framestart_delay (expected 0, found 1)
<7> [380.157980] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:151:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hdisplay (expected 0, found 2880)
<7> [380.158190] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:151:pipe A] fastset requirement not met in hw.pipe_mode.crtc_htotal (expected 0, found 3040)
<7> [380.158391] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:151:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hblank_start (expected 0, found 2880)
<7> [380.158584] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:151:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hblank_end (expected 0, found 3040)
<7> [380.158775] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:151:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hsync_start (expected 0, found 2928)
<7> [380.159000] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:151:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hsync_end (expected 0, found 2960)
<7> [380.159174] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:151:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vdisplay (expected 0, found 1800)
<7> [380.159347] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:151:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vblank_start (expected 0, found 1800)
<7> [380.159513] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:151:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vsync_start (expected 0, found 1803)
<7> [380.159676] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:151:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vsync_end (expected 0, found 1809)
<7> [380.159835] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:151:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vtotal (expected 0, found 1906)
<7> [380.160039] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:151:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vblank_end (expected 0, found 1906)
<7> [380.160214] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:151:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hdisplay (expected 0, found 2880)
<7> [380.160366] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:151:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_htotal (expected 0, found 3040)
<7> [380.160509] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:151:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hblank_start (expected 0, found 2880)
<7> [380.160656] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:151:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hblank_end (expected 0, found 3040)
<7> [380.160805] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:151:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hsync_start (expected 0, found 2928)
<7> [380.161005] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:151:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hsync_end (expected 0, found 2960)
<7> [380.161146] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:151:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vdisplay (expected 0, found 1800)
<7> [380.161276] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:151:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vblank_start (expected 0, found 1800)
<7> [380.161403] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:151:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vsync_start (expected 0, found 1803)
<7> [380.161526] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:151:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vsync_end (expected 0, found 1809)
<7> [380.161645] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:151:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vtotal (expected 0, found 1906)
<7> [380.161765] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:151:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vblank_end (expected 0, found 1906)
<7> [380.161890] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:151:pipe A] fastset requirement not met in pixel_multiplier (expected 0, found 1)
<7> [380.162003] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:151:pipe A] fastset requirement not met in hw.adjusted_mode.flags (2) (expected 0, found 2)
<7> [380.162113] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:151:pipe A] fastset requirement not met in hw.adjusted_mode.flags (8) (expected 0, found 8)
<7> [380.162223] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:151:pipe A] fastset requirement not met in pipe_bpp (expected 0, found 30)
<7> [380.162332] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:151:pipe A] fastset requirement not met in hw.pipe_mode.crtc_clock (expected 0, found 347710)
<7> [380.162437] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:151:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_clock (expected 0, found 347710)
<7> [380.162540] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:151:pipe A] fastset requirement not met in port_clock (expected 0, found 432000)
<7> [380.162644] xe 0000:00:02.0: [drm:intel_atomic_check [xe]] [CRTC:151:pipe A] fastset requirement not met, forcing full modeset
<7> [380.162793] xe 0000:00:02.0: [drm:skl_compute_wm [xe]] Enabled dbuf slices 0x1 -> 0xf (total dbuf slices 0xf), mbus joined? no->yes
<7> [380.162889] xe 0000:00:02.0: [drm:skl_compute_wm [xe]] [CRTC:151:pipe A] dbuf slices 0x0 -> 0xf, ddb (0 - 0) -> (0 - 4096), active pipes 0x0 -> 0x1
<7> [380.163036] xe 0000:00:02.0: [drm:skl_print_plane_ddb_changes [xe]] [PLANE:35:plane 1A] ddb ( 0 - 0) -> ( 0 - 4051), size 0 -> 4051
<7> [380.163123] xe 0000:00:02.0: [drm:skl_print_plane_ddb_changes [xe]] [PLANE:145:cursor A] ddb ( 0 - 0) -> (4051 - 4096), size 0 -> 45
<7> [380.163207] xe 0000:00:02.0: [drm:skl_print_plane_wm_changes [xe]] [PLANE:35:plane 1A] level wm0, wm1, wm2, wm3, wm4, wm5, wm6, wm7, twm, swm, stwm -> *wm0,*wm1,*wm2,*wm3,*wm4,*wm5, wm6, wm7,*twm,*swm,*stwm
<7> [380.163279] xe 0000:00:02.0: [drm:skl_print_plane_wm_changes [xe]] [PLANE:35:plane 1A] lines 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0 -> 4, 13, 13, 13, 13, 13, 0, 0, 0, 4, 0
<7> [380.163347] xe 0000:00:02.0: [drm:skl_print_plane_wm_changes [xe]] [PLANE:35:plane 1A] blocks 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0 -> 92, 297, 297, 297, 297, 297, 0, 0, 197, 92, 197
<7> [380.163414] xe 0000:00:02.0: [drm:skl_print_plane_wm_changes [xe]] [PLANE:35:plane 1A] min_ddb 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0 -> 183, 456, 456, 456, 456, 456, 0, 0, 198, 183, 198
<7> [380.163498] xe 0000:00:02.0: [drm:intel_bw_atomic_check [xe]] [CRTC:151:pipe A] data rate 1390840 num active planes 1
<7> [380.163596] xe 0000:00:02.0: [drm:intel_bw_atomic_check [xe]] QGV point 0: max bw 23530 required 1461 qgv_peak_bw: 38400
<7> [380.163694] xe 0000:00:02.0: [drm:intel_bw_atomic_check [xe]] QGV point 1: max bw 36260 required 1461 qgv_peak_bw: 38400
<7> [380.163791] xe 0000:00:02.0: [drm:intel_bw_atomic_check [xe]] QGV point 2: max bw 38000 required 1461 qgv_peak_bw: 38400
<7> [380.163907] xe 0000:00:02.0: [drm:intel_bw_atomic_check [xe]] QGV point 3: max bw 38000 required 1461 qgv_peak_bw: 38400
<7> [380.164012] xe 0000:00:02.0: [drm:intel_bw_atomic_check [xe]] Matching peaks QGV bw: 38400 for required data rate: 1461
<7> [380.164099] xe 0000:00:02.0: [drm:intel_cdclk_atomic_check [xe]] [CRTC:151:pipe A] min cdclk: 0 kHz -> 173855 kHz
<7> [380.164201] xe 0000:00:02.0: [drm:intel_cdclk_update_dbuf_bw_min_cdclk [xe]] dbuf bandwidth min cdclk: 0 kHz -> 21732 kHz
<7> [380.164297] xe 0000:00:02.0: [drm:intel_cdclk_atomic_check [xe]] Can change cdclk via squashing
<7> [380.164391] xe 0000:00:02.0: [drm:intel_cdclk_atomic_check [xe]] New cdclk calculated to be logical 192000 kHz, actual 192000 kHz
<7> [380.164483] xe 0000:00:02.0: [drm:intel_cdclk_atomic_check [xe]] New voltage level calculated to be logical 0, actual 0
<7> [380.164583] xe 0000:00:02.0: [drm:intel_find_dpll [xe]] [CRTC:151:pipe A] allocated DPLL 0
<7> [380.164670] xe 0000:00:02.0: [drm:intel_dpll_crtc_get [xe]] [CRTC:151:pipe A] reserving DPLL 0
<7> [380.164760] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [CRTC:151:pipe A] enable: yes [modeset]
<7> [380.164854] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] active: yes, output_types: EDP (0x100), output format: RGB, sink format: RGB
<7> [380.164983] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] cpu_transcoder: A, pipe bpp: 30, dithering: 0
<7> [380.165087] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] MST master transcoder: <invalid>
<7> [380.165178] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] port sync: master transcoder: <invalid>, slave transcoder bitmask = 0x0
<7> [380.165267] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] joiner: no, pipes: 0x0
<7> [380.165356] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] splitter: disabled, link count 0, overlap 0
<7> [380.165445] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] dp m_n: lanes: 4; data_m: 6329869, data_n: 8388608, link_m: 421991, link_n: 524288, tu: 64
<7> [380.165527] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] dp m2_n2: lanes: 4; data_m: 0, data_n: 0, link_m: 0, link_n: 0, tu: 0
<7> [380.165607] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] fec: disabled, enhanced framing: disabled
<7> [380.165691] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] sdp split: disabled
<7> [380.165780] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] psr: enabled, selective update: enabled, panel replay: disabled, selective fetch: enabled
<7> [380.165868] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] minimum hblank: 0
<7> [380.165966] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] audio: 0, infoframes: 0, infoframes enabled: 0x4
<7> [380.166064] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] DP SDP: VSC, revision 4, length 14
<7> [380.166176] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] pixelformat: RGB
<7> [380.166276] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] colorimetry: sRGB
<7> [380.166359] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] bpc: 0
<7> [380.166443] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] dynamic range: VESA range
<7> [380.166527] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] content type: Not defined
<7> [380.166610] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] scanline offset: 1
<7> [380.166689] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] framestart delay: 1, MSA timing delay: 0, set context latency: 0
<7> [380.166766] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] vrr: no, fixed rr: yes, vmin: 1906, vmax: 1906, flipline: 1906, pipeline full: 0, guardband: 104 vsync start: 103, vsync end: 97
<7> [380.166848] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] vrr: vmin vblank: 1802, vmax vblank: 1802, vmin vtotal: 1906, vmax vtotal: 1906
<7> [380.166937] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] vrr: dc balance: no, vmin: 0 vmax: 0 guardband: 0, slope: 0 max increase: 0 max decrease: 0 vblank target: 0
<7> [380.167025] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] requested mode: "2880x1800": 60 347710 2880 2928 2960 3040 1800 1803 1809 1906 0x48 0xa
<7> [380.167119] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] adjusted mode: "2880x1800": 60 347710 2880 2928 2960 3040 1800 1803 1809 1906 0x48 0xa
<7> [380.167205] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] crtc timings: clock=347710, hd=2880 hb=2880-3040 hs=2928-2960 ht=3040, vd=1800 vb=1800-1906 vs=1803-1809 vt=1906, flags=0xa
<7> [380.167291] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] pipe mode: "2880x1800": 60 347710 2880 2928 2960 3040 1800 1803 1809 1906 0x40 0xa
<7> [380.167376] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] crtc timings: clock=347710, hd=2880 hb=2880-3040 hs=2928-2960 ht=3040, vd=1800 vb=1800-1906 vs=1803-1809 vt=1906, flags=0xa
<7> [380.167458] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] port clock: 432000, pixel rate 347710, min cdclk 173855, min voltage level 0
<7> [380.167534] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] linetime: 70, ips linetime: 0
<7> [380.167609] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] num_scalers: 2, scaler_users: 0x0, scaler_id: -1, scaling_filter: 0, sharpness_strength: 0
<7> [380.167687] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] pipe src: 2880x1800+0+0
<7> [380.167771] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] pch pfit: 0x0+0+0, disabled, force thru: no
<7> [380.167857] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] sharpness strength: 0, sharpness tap size: 0, sharpness enable: 0
<7> [380.167952] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] ips: 0, double wide: 0, drrs: 0
<7> [380.168038] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] cx0pll_hw_state: lane_count: 4, ssc_enabled: no, use_c10: yes, tbt_mode: no
<7> [380.168136] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] c10pll_hw_state: fracen: no,
<7> [380.168235] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] multiplier: 225, tx_clk_div: 1.
<7> [380.168324] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] c10pll_rawhw_state:
<7> [380.168407] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] tx: 0x10, cmn: 0x21
<7> [380.168488] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] pll[0] = 0x4, pll[1] = 0x0, pll[2] = 0xa2, pll[3] = 0x1
<7> [380.168567] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] pll[4] = 0x0, pll[5] = 0x0, pll[6] = 0x0, pll[7] = 0x0
<7> [380.168641] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] pll[8] = 0x0, pll[9] = 0x1, pll[10] = 0x0, pll[11] = 0x0
<7> [380.168716] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] pll[12] = 0x0, pll[13] = 0x0, pll[14] = 0x0, pll[15] = 0x1
<7> [380.168790] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] pll[16] = 0x85, pll[17] = 0xf, pll[18] = 0xe6, pll[19] = 0x23
<7> [380.168866] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] csc_mode: 0x0 gamma_mode: 0x0 gamma_enable: 0 csc_enable: 0
<7> [380.168940] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] pre csc lut: 0 entries, post csc lut: 0 entries
<7> [380.169048] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] output csc: pre offsets: 0x0000 0x0000 0x0000
<7> [380.169127] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] output csc: coefficients: 0x0000 0x0000 0x0000
<7> [380.169201] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] output csc: coefficients: 0x0000 0x0000 0x0000
<7> [380.169274] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] output csc: coefficients: 0x0000 0x0000 0x0000
<7> [380.169347] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] output csc: post offsets: 0x0000 0x0000 0x0000
<7> [380.169421] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] pipe csc: pre offsets: 0x0000 0x0000 0x0000
<7> [380.169497] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] pipe csc: coefficients: 0x0000 0x0000 0x0000
<7> [380.169574] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] pipe csc: coefficients: 0x0000 0x0000 0x0000
<7> [380.169650] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] pipe csc: coefficients: 0x0000 0x0000 0x0000
<7> [380.169727] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] pipe csc: post offsets: 0x0000 0x0000 0x0000
<7> [380.169803] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [PLANE:35:plane 1A] fb: [FB:431] 2880x1800 format = XR24 little-endian (0x34325258) modifier = 0x100000000000009, visible: yes
<7> [380.169882] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] rotation: 0x1, scaler: -1, scaling_filter: 0
<7> [380.169958] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] src: 2880.000000x1800.000000+0.000000+0.000000 dst: 2880x1800+0+0
<7> [380.170054] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [PLANE:65:plane 2A] fb: [NOFB], visible: no
<7> [380.170147] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [PLANE:95:plane 3A] fb: [NOFB], visible: no
<7> [380.170230] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [PLANE:125:plane 4A] fb: [NOFB], visible: no
<7> [380.170313] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [PLANE:135:plane 5A] fb: [NOFB], visible: no
<7> [380.170395] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [PLANE:145:cursor A] fb: [NOFB], visible: no
<7> [380.170681] xe 0000:00:02.0: [drm:intel_power_well_enable [xe]] enabling PW_A
<7> [380.170827] xe 0000:00:02.0: [drm:dss_pipe_gating_enable_disable [xe]] DSS clock gating enabled for pipe_mask=0x1 (CLKGATE_DIS_DSSDSC=0xa8000000)
<7> [380.170954] xe 0000:00:02.0: [drm:intel_set_cdclk [xe]] Pre changing CDCLK to 192000 kHz, VCO 614400 kHz, ref 38400 kHz, bypass 19200 kHz, voltage level 0
<7> [380.171100] xe 0000:00:02.0: [drm:intel_dbuf_mdclk_cdclk_ratio_update [xe]] Updating dbuf ratio to 4 (mbus joined: no)
<7> [380.171201] xe 0000:00:02.0: [drm:intel_audio_cdclk_change_post.part.0 [xe]] aud_ts_cdclk set to M=60, N=480
<7> [380.171285] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:392:DDI A/PHY A]
<7> [380.171357] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:401:DDI TC1/PHY TC1]
<7> [380.171428] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:403:DP-MST A]
<7> [380.171498] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:404:DP-MST B]
<7> [380.171567] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:405:DP-MST C]
<7> [380.171633] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:413:DDI TC2/PHY TC2]
<7> [380.171704] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:415:DP-MST A]
<7> [380.171777] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:416:DP-MST B]
<7> [380.171848] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:417:DP-MST C]
<7> [380.171918] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:421:DDI TC3/PHY TC3]
<7> [380.171994] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:423:DP-MST A]
<7> [380.172063] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:424:DP-MST B]
<7> [380.172140] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:425:DP-MST C]
<7> [380.172228] xe 0000:00:02.0: [drm:gen9_dbuf_slices_update [xe]] Updating dbuf slices to 0xf
<7> [380.172395] xe 0000:00:02.0: [drm:intel_dbuf_mbus_join_update [xe]] Changing mbus joined: no -> yes (pipe: *)
<7> [380.172463] xe 0000:00:02.0: [drm:intel_dbuf_mdclk_cdclk_ratio_update [xe]] Updating dbuf ratio to 8 (mbus joined: yes)
<7> [380.172573] xe 0000:00:02.0: [drm:intel_power_well_enable [xe]] enabling AUX_A
<7> [380.174004] xe 0000:00:02.0: [drm:intel_dpll_enable [xe]] enable DPLL 0 (active 0x1, on? 0) for [CRTC:151:pipe A]
<7> [380.174174] xe 0000:00:02.0: [drm:intel_dpll_enable [xe]] enabling DPLL 0
<7> [380.176182] xe 0000:00:02.0: [drm:intel_pps_on_unlocked [xe]] [ENCODER:392:DDI A/PHY A] PPS 0 turn panel power on
<7> [380.176278] xe 0000:00:02.0: [drm:wait_panel_power_cycle [xe]] [ENCODER:392:DDI A/PHY A] PPS 0 wait for panel power cycle (467 ms remaining)
<7> [380.177495] xe 0000:00:02.0: [drm:icp_irq_handler [xe]] hotplug event received, stat 0x00010000, dig 0x0000000a, pins 0x00000010, long 0x00000010
<7> [380.177602] xe 0000:00:02.0: [drm:intel_hpd_irq_handler [xe]] digital hpd on [ENCODER:392:DDI A/PHY A] - long
<7> [380.177695] xe 0000:00:02.0: [drm:intel_hpd_irq_handler [xe]] Received HPD interrupt on PIN 4 - cnt: 10
<7> [380.177894] xe 0000:00:02.0: [drm:intel_dp_hpd_pulse [xe]] ignoring long hpd on eDP [ENCODER:392:DDI A/PHY A]
<7> [380.653866] xe 0000:00:02.0: [drm:wait_panel_status [xe]] [ENCODER:392:DDI A/PHY A] PPS 0 mask: 0xb800000f value: 0x00000000 PP_STATUS: 0x08000001 PP_CONTROL: 0x00000060
<7> [380.685009] xe 0000:00:02.0: [drm:wait_panel_status [xe]] Wait complete
<7> [380.685404] xe 0000:00:02.0: [drm:intel_pps_on_unlocked [xe]] [ENCODER:392:DDI A/PHY A] PPS 0 wait for panel power on
<7> [380.685665] xe 0000:00:02.0: [drm:wait_panel_status [xe]] [ENCODER:392:DDI A/PHY A] PPS 0 mask: 0xb000000f value: 0x80000008 PP_STATUS: 0x9000000a PP_CONTROL: 0x00000063
<7> [380.722389] xe 0000:00:02.0: [drm:icp_irq_handler [xe]] hotplug event received, stat 0x00010000, dig 0x0000000a, pins 0x00000010, long 0x00000010
<7> [380.722724] xe 0000:00:02.0: [drm:intel_hpd_irq_handler [xe]] digital hpd on [ENCODER:392:DDI A/PHY A] - long
<7> [380.723034] xe 0000:00:02.0: [drm:intel_hpd_irq_handler [xe]] Received HPD interrupt on PIN 4 - cnt: 20
<7> [380.723507] xe 0000:00:02.0: [drm:intel_dp_hpd_pulse [xe]] ignoring long hpd on eDP [ENCODER:392:DDI A/PHY A]
<7> [380.893151] xe 0000:00:02.0: [drm:wait_panel_status [xe]] Wait complete
<7> [380.893503] xe 0000:00:02.0: [drm:intel_pps_vdd_on_unlocked [xe]] [ENCODER:392:DDI A/PHY A] PPS 0 turning VDD on
<7> [380.893871] xe 0000:00:02.0: [drm:intel_pps_vdd_on_unlocked [xe]] [ENCODER:392:DDI A/PHY A] PPS 0 PP_STATUS: 0x80000008 PP_CONTROL: 0x0000006b
<7> [380.895815] xe 0000:00:02.0: [drm:drm_dp_read_dpcd_caps [drm_display_helper]] AUX A/DDI A/PHY A: DPCD: 14 1e 44 c1 00 00 01 c0 02 00 02 00 00 0b 80
<7> [380.897289] xe 0000:00:02.0: [drm:intel_dp_start_link_train [xe]] [CONNECTOR:393:eDP-1][ENCODER:392:DDI A/PHY A][DPRX] Reloading eDP link rates
<7> [380.898013] xe 0000:00:02.0: [drm:intel_dp_start_link_train [xe]] [CONNECTOR:393:eDP-1][ENCODER:392:DDI A/PHY A][DPRX] Using LINK_RATE_SET value 05
<7> [380.899131] xe 0000:00:02.0: [drm:intel_dp_set_signal_levels [xe]] [CONNECTOR:393:eDP-1][ENCODER:392:DDI A/PHY A][DPRX] 8b/10b, lanes: 4, vswing levels: 0/0/0/0, pre-emphasis levels: 0/0/0/0
<7> [380.900450] xe 0000:00:02.0: [drm:intel_dp_program_link_training_pattern [xe]] [CONNECTOR:393:eDP-1][ENCODER:392:DDI A/PHY A][DPRX] Using DP training pattern TPS1
<7> [380.901642] xe 0000:00:02.0: [drm:intel_dp_link_train_phy [xe]] [CONNECTOR:393:eDP-1][ENCODER:392:DDI A/PHY A][DPRX] Clock recovery OK
<7> [380.902127] xe 0000:00:02.0: [drm:intel_dp_program_link_training_pattern [xe]] [CONNECTOR:393:eDP-1][ENCODER:392:DDI A/PHY A][DPRX] Using DP training pattern TPS4
<7> [380.903762] xe 0000:00:02.0: [drm:intel_dp_link_train_phy [xe]] [CONNECTOR:393:eDP-1][ENCODER:392:DDI A/PHY A][DPRX] Channel EQ done. DP Training successful
<7> [380.904229] xe 0000:00:02.0: [drm:intel_dp_link_train_phy [xe]] [CONNECTOR:393:eDP-1][ENCODER:392:DDI A/PHY A][DPRX] Link Training passed at link rate = 432000, lane count = 4
<7> [380.905183] xe 0000:00:02.0: [drm:intel_enable_transcoder [xe]] enabling pipe A
<7> [380.905740] xe 0000:00:02.0: [drm:intel_edp_backlight_on [xe]]
<7> [380.906120] xe 0000:00:02.0: [drm:intel_backlight_enable [xe]] pipe A
<7> [380.906552] xe 0000:00:02.0: [drm:intel_backlight_set_pwm_level [xe]] [CONNECTOR:393:eDP-1] set backlight PWM = 4518
<7> [380.939471] xe 0000:00:02.0: [drm:intel_psr_post_plane_update [xe]] Enabling PSR2
<7> [380.941020] xe 0000:00:02.0: [drm:verify_connector_state [xe]] [CONNECTOR:393:eDP-1]
<7> [380.941380] xe 0000:00:02.0: [drm:intel_modeset_verify_crtc [xe]] [CRTC:151:pipe A]
<7> [380.962594] xe 0000:00:02.0: [drm:intel_power_well_disable [xe]] disabling DC_off
<7> [380.963009] xe 0000:00:02.0: [drm:skl_enable_dc6 [xe]] Enabling DC6
<7> [380.963396] xe 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [xe]] Setting DC state from 00 to 02
<7> [381.224084] xe 0000:00:02.0: [drm:intel_power_well_enable [xe]] enabling DC_off
<7> [381.224494] xe 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [xe]] Setting DC state from 02 to 00
<7> [381.274015] xe 0000:00:02.0: [drm:intel_power_well_disable [xe]] disabling DC_off
<7> [381.274407] xe 0000:00:02.0: [drm:skl_enable_dc6 [xe]] Enabling DC6
<7> [381.274718] xe 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [xe]] Setting DC state from 00 to 02
<7> [381.407472] xe 0000:00:02.0: [drm:intel_power_well_enable [xe]] enabling DC_off
<7> [381.407863] xe 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [xe]] Setting DC state from 02 to 00
<7> [381.440777] xe 0000:00:02.0: [drm:intel_power_well_disable [xe]] disabling DC_off
<7> [381.441333] xe 0000:00:02.0: [drm:skl_enable_dc6 [xe]] Enabling DC6
<7> [381.441850] xe 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [xe]] Setting DC state from 00 to 02
<7> [381.574188] xe 0000:00:02.0: [drm:intel_power_well_enable [xe]] enabling DC_off
<7> [381.574598] xe 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [xe]] Setting DC state from 02 to 00
<7> [381.607524] xe 0000:00:02.0: [drm:intel_power_well_disable [xe]] disabling DC_off
<7> [381.608054] xe 0000:00:02.0: [drm:skl_enable_dc6 [xe]] Enabling DC6
<7> [381.608570] xe 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [xe]] Setting DC state from 00 to 02
<7> [381.740770] xe 0000:00:02.0: [drm:intel_power_well_enable [xe]] enabling DC_off
<7> [381.741177] xe 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [xe]] Setting DC state from 02 to 00
<7> [381.774253] xe 0000:00:02.0: [drm:intel_power_well_disable [xe]] disabling DC_off
<7> [381.774786] xe 0000:00:02.0: [drm:skl_enable_dc6 [xe]] Enabling DC6
<7> [381.775316] xe 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [xe]] Setting DC state from 00 to 02
<7> [381.907395] xe 0000:00:02.0: [drm:intel_power_well_enable [xe]] enabling DC_off
<7> [381.907779] xe 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [xe]] Setting DC state from 02 to 00
<7> [381.940969] xe 0000:00:02.0: [drm:intel_power_well_disable [xe]] disabling DC_off
<7> [381.941455] xe 0000:00:02.0: [drm:skl_enable_dc6 [xe]] Enabling DC6
<7> [381.941938] xe 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [xe]] Setting DC state from 00 to 02
<7> [382.074010] xe 0000:00:02.0: [drm:intel_power_well_enable [xe]] enabling DC_off
<7> [382.074471] xe 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [xe]] Setting DC state from 02 to 00
<7> [382.107685] xe 0000:00:02.0: [drm:intel_power_well_disable [xe]] disabling DC_off
<7> [382.108228] xe 0000:00:02.0: [drm:skl_enable_dc6 [xe]] Enabling DC6
<7> [382.108741] xe 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [xe]] Setting DC state from 00 to 02
<7> [382.240774] xe 0000:00:02.0: [drm:intel_power_well_enable [xe]] enabling DC_off
<7> [382.241181] xe 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [xe]] Setting DC state from 02 to 00
<7> [382.274219] xe 0000:00:02.0: [drm:intel_power_well_disable [xe]] disabling DC_off
<7> [382.274707] xe 0000:00:02.0: [drm:skl_enable_dc6 [xe]] Enabling DC6
<7> [382.275184] xe 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [xe]] Setting DC state from 00 to 02
<7> [382.407317] xe 0000:00:02.0: [drm:intel_power_well_enable [xe]] enabling DC_off
<7> [382.407707] xe 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [xe]] Setting DC state from 02 to 00
<7> [382.440768] xe 0000:00:02.0: [drm:intel_power_well_disable [xe]] disabling DC_off
<7> [382.441295] xe 0000:00:02.0: [drm:skl_enable_dc6 [xe]] Enabling DC6
<7> [382.441839] xe 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [xe]] Setting DC state from 00 to 02
<7> [382.574137] xe 0000:00:02.0: [drm:intel_power_well_enable [xe]] enabling DC_off
<7> [382.574578] xe 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [xe]] Setting DC state from 02 to 00
<7> [382.607268] xe 0000:00:02.0: [drm:intel_power_well_disable [xe]] disabling DC_off
<7> [382.607797] xe 0000:00:02.0: [drm:skl_enable_dc6 [xe]] Enabling DC6
<7> [382.608315] xe 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [xe]] Setting DC state from 00 to 02
<7> [382.740615] xe 0000:00:02.0: [drm:intel_power_well_enable [xe]] enabling DC_off
<7> [382.741027] xe 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [xe]] Setting DC state from 02 to 00
<7> [382.773809] xe 0000:00:02.0: [drm:intel_power_well_disable [xe]] disabling DC_off
<7> [382.774343] xe 0000:00:02.0: [drm:skl_enable_dc6 [xe]] Enabling DC6
<7> [382.774868] xe 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [xe]] Setting DC state from 00 to 02
<7> [382.907217] xe 0000:00:02.0: [drm:intel_power_well_enable [xe]] enabling DC_off
<7> [382.907583] xe 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [xe]] Setting DC state from 02 to 00
<7> [382.940348] xe 0000:00:02.0: [drm:intel_power_well_disable [xe]] disabling DC_off
<7> [382.940843] xe 0000:00:02.0: [drm:skl_enable_dc6 [xe]] Enabling DC6
<7> [382.941353] xe 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [xe]] Setting DC state from 00 to 02
<7> [383.073821] xe 0000:00:02.0: [drm:intel_power_well_enable [xe]] enabling DC_off
<7> [383.074230] xe 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [xe]] Setting DC state from 02 to 00
<7> [383.106869] xe 0000:00:02.0: [drm:intel_power_well_disable [xe]] disabling DC_off
<7> [383.107404] xe 0000:00:02.0: [drm:skl_enable_dc6 [xe]] Enabling DC6
<7> [383.107915] xe 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [xe]] Setting DC state from 00 to 02
<7> [383.240545] xe 0000:00:02.0: [drm:intel_power_well_enable [xe]] enabling DC_off
<7> [383.240989] xe 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [xe]] Setting DC state from 02 to 00
<7> [383.273208] xe 0000:00:02.0: [drm:intel_power_well_disable [xe]] disabling DC_off
<7> [383.273690] xe 0000:00:02.0: [drm:skl_enable_dc6 [xe]] Enabling DC6
<7> [383.274146] xe 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [xe]] Setting DC state from 00 to 02
<7> [383.407287] xe 0000:00:02.0: [drm:intel_power_well_enable [xe]] enabling DC_off
<7> [383.407701] xe 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [xe]] Setting DC state from 02 to 00
<7> [383.440584] xe 0000:00:02.0: [drm:intel_power_well_disable [xe]] disabling DC_off
<7> [383.441119] xe 0000:00:02.0: [drm:skl_enable_dc6 [xe]] Enabling DC6
<7> [383.441642] xe 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [xe]] Setting DC state from 00 to 02
<7> [383.505932] xe 0000:00:02.0: [drm:intel_pps_vdd_off_sync_unlocked [xe]] [ENCODER:392:DDI A/PHY A] PPS 0 turning VDD off
<7> [383.506289] xe 0000:00:02.0: [drm:intel_pps_vdd_off_sync_unlocked [xe]] [ENCODER:392:DDI A/PHY A] PPS 0 PP_STATUS: 0x80000008 PP_CONTROL: 0x00000067
<7> [383.573872] xe 0000:00:02.0: [drm:intel_power_well_enable [xe]] enabling DC_off
<7> [383.574315] xe 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [xe]] Setting DC state from 02 to 00
<7> [383.606910] xe 0000:00:02.0: [drm:intel_power_well_disable [xe]] disabling DC_off
<7> [383.607400] xe 0000:00:02.0: [drm:skl_enable_dc6 [xe]] Enabling DC6
<7> [383.607871] xe 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [xe]] Setting DC state from 00 to 02
<7> [383.740442] xe 0000:00:02.0: [drm:intel_power_well_enable [xe]] enabling DC_off
<7> [383.740868] xe 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [xe]] Setting DC state from 02 to 00
<7> [383.773276] xe 0000:00:02.0: [drm:intel_power_well_disable [xe]] disabling DC_off
<7> [383.773804] xe 0000:00:02.0: [drm:skl_enable_dc6 [xe]] Enabling DC6
<7> [383.774330] xe 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [xe]] Setting DC state from 00 to 02
<7> [383.907012] xe 0000:00:02.0: [drm:intel_power_well_enable [xe]] enabling DC_off
<7> [383.907512] xe 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [xe]] Setting DC state from 02 to 00
<7> [383.940626] xe 0000:00:02.0: [drm:intel_power_well_disable [xe]] disabling DC_off
<7> [383.941214] xe 0000:00:02.0: [drm:skl_enable_dc6 [xe]] Enabling DC6
<7> [383.941790] xe 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [xe]] Setting DC state from 00 to 02
<7> [384.073917] xe 0000:00:02.0: [drm:intel_power_well_enable [xe]] enabling DC_off
<7> [384.074395] xe 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [xe]] Setting DC state from 02 to 00
<7> [384.106961] xe 0000:00:02.0: [drm:intel_power_well_disable [xe]] disabling DC_off
<7> [384.107550] xe 0000:00:02.0: [drm:skl_enable_dc6 [xe]] Enabling DC6
<7> [384.108138] xe 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [xe]] Setting DC state from 00 to 02
<7> [384.240255] xe 0000:00:02.0: [drm:intel_power_well_enable [xe]] enabling DC_off
<7> [384.240713] xe 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [xe]] Setting DC state from 02 to 00
<7> [384.273159] xe 0000:00:02.0: [drm:intel_power_well_disable [xe]] disabling DC_off
<7> [384.273688] xe 0000:00:02.0: [drm:skl_enable_dc6 [xe]] Enabling DC6
<7> [384.274201] xe 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [xe]] Setting DC state from 00 to 02
<7> [384.407136] xe 0000:00:02.0: [drm:intel_power_well_enable [xe]] enabling DC_off
<7> [384.407619] xe 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [xe]] Setting DC state from 02 to 00
<7> [384.440358] xe 0000:00:02.0: [drm:intel_power_well_disable [xe]] disabling DC_off
<7> [384.440942] xe 0000:00:02.0: [drm:skl_enable_dc6 [xe]] Enabling DC6
<7> [384.441530] xe 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [xe]] Setting DC state from 00 to 02
<7> [384.573543] xe 0000:00:02.0: [drm:intel_power_well_enable [xe]] enabling DC_off
<7> [384.573967] xe 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [xe]] Setting DC state from 02 to 00
<7> [384.606547] xe 0000:00:02.0: [drm:intel_power_well_disable [xe]] disabling DC_off
<7> [384.607088] xe 0000:00:02.0: [drm:skl_enable_dc6 [xe]] Enabling DC6
<7> [384.607597] xe 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [xe]] Setting DC state from 00 to 02
<7> [384.740306] xe 0000:00:02.0: [drm:intel_power_well_enable [xe]] enabling DC_off
<7> [384.740726] xe 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [xe]] Setting DC state from 02 to 00
<7> [384.773715] xe 0000:00:02.0: [drm:intel_power_well_disable [xe]] disabling DC_off
<7> [384.774242] xe 0000:00:02.0: [drm:skl_enable_dc6 [xe]] Enabling DC6
<7> [384.774757] xe 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [xe]] Setting DC state from 00 to 02
<7> [384.906886] xe 0000:00:02.0: [drm:intel_power_well_enable [xe]] enabling DC_off
<7> [384.907329] xe 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [xe]] Setting DC state from 02 to 00
<7> [384.939910] xe 0000:00:02.0: [drm:intel_power_well_disable [xe]] disabling DC_off
<7> [384.940437] xe 0000:00:02.0: [drm:skl_enable_dc6 [xe]] Enabling DC6
<7> [384.940956] xe 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [xe]] Setting DC state from 00 to 02
<7> [385.073491] xe 0000:00:02.0: [drm:intel_power_well_enable [xe]] enabling DC_off
<7> [385.073933] xe 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [xe]] Setting DC state from 02 to 00
<7> [385.107126] xe 0000:00:02.0: [drm:intel_power_well_disable [xe]] disabling DC_off
<7> [385.107657] xe 0000:00:02.0: [drm:skl_enable_dc6 [xe]] Enabling DC6
<7> [385.108192] xe 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [xe]] Setting DC state from 00 to 02
<7> [385.240167] xe 0000:00:02.0: [drm:intel_power_well_enable [xe]] enabling DC_off
<7> [385.240576] xe 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [xe]] Setting DC state from 02 to 00
<7> [385.273173] xe 0000:00:02.0: [drm:intel_power_well_disable [xe]] disabling DC_off
<7> [385.273699] xe 0000:00:02.0: [drm:skl_enable_dc6 [xe]] Enabling DC6
<7> [385.274243] xe 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [xe]] Setting DC state from 00 to 02
<7> [385.406691] xe 0000:00:02.0: [drm:intel_power_well_enable [xe]] enabling DC_off
<7> [385.407172] xe 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [xe]] Setting DC state from 02 to 00
<7> [385.440228] xe 0000:00:02.0: [drm:intel_power_well_disable [xe]] disabling DC_off
<7> [385.440757] xe 0000:00:02.0: [drm:skl_enable_dc6 [xe]] Enabling DC6
<7> [385.441271] xe 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [xe]] Setting DC state from 00 to 02
<7> [385.573363] xe 0000:00:02.0: [drm:intel_power_well_enable [xe]] enabling DC_off
<7> [385.573776] xe 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [xe]] Setting DC state from 02 to 00
<7> [385.606287] xe 0000:00:02.0: [drm:intel_power_well_disable [xe]] disabling DC_off
<7> [385.606817] xe 0000:00:02.0: [drm:skl_enable_dc6 [xe]] Enabling DC6
<7> [385.607338] xe 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [xe]] Setting DC state from 00 to 02
<7> [385.740071] xe 0000:00:02.0: [drm:intel_power_well_enable [xe]] enabling DC_off
<7> [385.740434] xe 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [xe]] Setting DC state from 02 to 00
<7> [385.773327] xe 0000:00:02.0: [drm:intel_power_well_disable [xe]] disabling DC_off
<7> [385.773811] xe 0000:00:02.0: [drm:skl_enable_dc6 [xe]] Enabling DC6
<7> [385.774272] xe 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [xe]] Setting DC state from 00 to 02
<7> [385.906727] xe 0000:00:02.0: [drm:intel_power_well_enable [xe]] enabling DC_off
<7> [385.907179] xe 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [xe]] Setting DC state from 02 to 00
<7> [385.939378] xe 0000:00:02.0: [drm:intel_power_well_disable [xe]] disabling DC_off
<7> [385.939901] xe 0000:00:02.0: [drm:skl_enable_dc6 [xe]] Enabling DC6
<7> [385.940425] xe 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [xe]] Setting DC state from 00 to 02
<7> [386.073375] xe 0000:00:02.0: [drm:intel_power_well_enable [xe]] enabling DC_off
<7> [386.073790] xe 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [xe]] Setting DC state from 02 to 00
<7> [386.106460] xe 0000:00:02.0: [drm:intel_power_well_disable [xe]] disabling DC_off
<7> [386.107045] xe 0000:00:02.0: [drm:skl_enable_dc6 [xe]] Enabling DC6
<7> [386.107620] xe 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [xe]] Setting DC state from 00 to 02
<7> [386.240247] xe 0000:00:02.0: [drm:intel_power_well_enable [xe]] enabling DC_off
<7> [386.240696] xe 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [xe]] Setting DC state from 02 to 00
<7> [386.273396] xe 0000:00:02.0: [drm:intel_power_well_disable [xe]] disabling DC_off
<7> [386.273925] xe 0000:00:02.0: [drm:skl_enable_dc6 [xe]] Enabling DC6
<7> [386.274439] xe 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [xe]] Setting DC state from 00 to 02
<7> [386.406615] xe 0000:00:02.0: [drm:intel_power_well_enable [xe]] enabling DC_off
<7> [386.407110] xe 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [xe]] Setting DC state from 02 to 00
<7> [386.439328] xe 0000:00:02.0: [drm:intel_power_well_disable [xe]] disabling DC_off
<7> [386.439880] xe 0000:00:02.0: [drm:skl_enable_dc6 [xe]] Enabling DC6
<7> [386.440427] xe 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [xe]] Setting DC state from 00 to 02
<7> [386.573269] xe 0000:00:02.0: [drm:intel_power_well_enable [xe]] enabling DC_off
<7> [386.573681] xe 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [xe]] Setting DC state from 02 to 00
<7> [386.606235] xe 0000:00:02.0: [drm:intel_power_well_disable [xe]] disabling DC_off
<7> [386.606762] xe 0000:00:02.0: [drm:skl_enable_dc6 [xe]] Enabling DC6
<7> [386.607283] xe 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [xe]] Setting DC state from 00 to 02
<7> [386.740154] xe 0000:00:02.0: [drm:intel_power_well_enable [xe]] enabling DC_off
<7> [386.740596] xe 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [xe]] Setting DC state from 02 to 00
<7> [386.773175] xe 0000:00:02.0: [drm:intel_power_well_disable [xe]] disabling DC_off
<7> [386.773759] xe 0000:00:02.0: [drm:skl_enable_dc6 [xe]] Enabling DC6
<7> [386.774285] xe 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [xe]] Setting DC state from 00 to 02
<7> [386.906521] xe 0000:00:02.0: [drm:intel_power_well_enable [xe]] enabling DC_off
<7> [386.906963] xe 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [xe]] Setting DC state from 02 to 00
<7> [386.940110] xe 0000:00:02.0: [drm:intel_power_well_disable [xe]] disabling DC_off
<7> [386.940702] xe 0000:00:02.0: [drm:skl_enable_dc6 [xe]] Enabling DC6
<7> [386.941240] xe 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [xe]] Setting DC state from 00 to 02
<7> [387.073065] xe 0000:00:02.0: [drm:intel_power_well_enable [xe]] enabling DC_off
<7> [387.073450] xe 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [xe]] Setting DC state from 02 to 00
<7> [387.106037] xe 0000:00:02.0: [drm:intel_power_well_disable [xe]] disabling DC_off
<7> [387.106570] xe 0000:00:02.0: [drm:skl_enable_dc6 [xe]] Enabling DC6
<7> [387.107093] xe 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [xe]] Setting DC state from 00 to 02
<7> [387.239911] xe 0000:00:02.0: [drm:intel_power_well_enable [xe]] enabling DC_off
<7> [387.240353] xe 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [xe]] Setting DC state from 02 to 00
<7> [387.272867] xe 0000:00:02.0: [drm:intel_power_well_disable [xe]] disabling DC_off
<7> [387.273397] xe 0000:00:02.0: [drm:skl_enable_dc6 [xe]] Enabling DC6
<7> [387.273917] xe 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [xe]] Setting DC state from 00 to 02
<7> [387.406465] xe 0000:00:02.0: [drm:intel_power_well_enable [xe]] enabling DC_off
<7> [387.406871] xe 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [xe]] Setting DC state from 02 to 00
<7> [387.439707] xe 0000:00:02.0: [drm:intel_power_well_disable [xe]] disabling DC_off
<7> [387.440292] xe 0000:00:02.0: [drm:skl_enable_dc6 [xe]] Enabling DC6
<7> [387.440855] xe 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [xe]] Setting DC state from 00 to 02
<7> [387.573249] xe 0000:00:02.0: [drm:intel_power_well_enable [xe]] enabling DC_off
<7> [387.573698] xe 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [xe]] Setting DC state from 02 to 00
<7> [387.606530] xe 0000:00:02.0: [drm:intel_power_well_disable [xe]] disabling DC_off
<7> [387.607120] xe 0000:00:02.0: [drm:skl_enable_dc6 [xe]] Enabling DC6
<7> [387.607685] xe 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [xe]] Setting DC state from 00 to 02
<7> [387.739687] xe 0000:00:02.0: [drm:intel_power_well_enable [xe]] enabling DC_off
<7> [387.740141] xe 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [xe]] Setting DC state from 02 to 00
<7> [387.772353] xe 0000:00:02.0: [drm:intel_power_well_disable [xe]] disabling DC_off
<7> [387.772879] xe 0000:00:02.0: [drm:skl_enable_dc6 [xe]] Enabling DC6
<7> [387.773394] xe 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [xe]] Setting DC state from 00 to 02
<7> [387.906326] xe 0000:00:02.0: [drm:intel_power_well_enable [xe]] enabling DC_off
<7> [387.906738] xe 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [xe]] Setting DC state from 02 to 00
<7> [387.939163] xe 0000:00:02.0: [drm:intel_power_well_disable [xe]] disabling DC_off
<7> [387.939746] xe 0000:00:02.0: [drm:skl_enable_dc6 [xe]] Enabling DC6
<7> [387.940264] xe 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [xe]] Setting DC state from 00 to 02
<7> [388.073092] xe 0000:00:02.0: [drm:intel_power_well_enable [xe]] enabling DC_off
<7> [388.073502] xe 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [xe]] Setting DC state from 02 to 00
<7> [388.105989] xe 0000:00:02.0: [drm:intel_power_well_disable [xe]] disabling DC_off
<7> [388.106516] xe 0000:00:02.0: [drm:skl_enable_dc6 [xe]] Enabling DC6
<7> [388.107033] xe 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [xe]] Setting DC state from 00 to 02
<7> [388.239879] xe 0000:00:02.0: [drm:intel_power_well_enable [xe]] enabling DC_off
<7> [388.240552] xe 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [xe]] Setting DC state from 02 to 00
<7> [388.272669] xe 0000:00:02.0: [drm:intel_power_well_disable [xe]] disabling DC_off
<7> [388.273208] xe 0000:00:02.0: [drm:skl_enable_dc6 [xe]] Enabling DC6
<7> [388.273712] xe 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [xe]] Setting DC state from 00 to 02
<7> [388.406475] xe 0000:00:02.0: [drm:intel_power_well_enable [xe]] enabling DC_off
<7> [388.406929] xe 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [xe]] Setting DC state from 02 to 00
<7> [388.439487] xe 0000:00:02.0: [drm:intel_power_well_disable [xe]] disabling DC_off
<7> [388.440072] xe 0000:00:02.0: [drm:skl_enable_dc6 [xe]] Enabling DC6
<7> [388.440669] xe 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [xe]] Setting DC state from 00 to 02
<7> [388.573044] xe 0000:00:02.0: [drm:intel_power_well_enable [xe]] enabling DC_off
<7> [388.573490] xe 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [xe]] Setting DC state from 02 to 00
<7> [388.606208] xe 0000:00:02.0: [drm:intel_power_well_disable [xe]] disabling DC_off
<7> [388.606789] xe 0000:00:02.0: [drm:skl_enable_dc6 [xe]] Enabling DC6
<7> [388.607305] xe 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [xe]] Setting DC state from 00 to 02
<7> [388.739592] xe 0000:00:02.0: [drm:intel_power_well_enable [xe]] enabling DC_off
<7> [388.740034] xe 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [xe]] Setting DC state from 02 to 00
<7> [388.772950] xe 0000:00:02.0: [drm:intel_power_well_disable [xe]] disabling DC_off
<7> [388.773480] xe 0000:00:02.0: [drm:skl_enable_dc6 [xe]] Enabling DC6
<7> [388.773997] xe 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [xe]] Setting DC state from 00 to 02
<7> [388.906168] xe 0000:00:02.0: [drm:intel_power_well_enable [xe]] enabling DC_off
<7> [388.906630] xe 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [xe]] Setting DC state from 02 to 00
<7> [388.939697] xe 0000:00:02.0: [drm:intel_power_well_disable [xe]] disabling DC_off
<7> [388.940228] xe 0000:00:02.0: [drm:skl_enable_dc6 [xe]] Enabling DC6
<7> [388.940754] xe 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [xe]] Setting DC state from 00 to 02
<7> [389.072827] xe 0000:00:02.0: [drm:intel_power_well_enable [xe]] enabling DC_off
<7> [389.073277] xe 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [xe]] Setting DC state from 02 to 00
<7> [389.106409] xe 0000:00:02.0: [drm:intel_power_well_disable [xe]] disabling DC_off
<7> [389.106908] xe 0000:00:02.0: [drm:skl_enable_dc6 [xe]] Enabling DC6
<7> [389.107379] xe 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [xe]] Setting DC state from 00 to 02
<7> [389.239607] xe 0000:00:02.0: [drm:intel_power_well_enable [xe]] enabling DC_off
<7> [389.240099] xe 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [xe]] Setting DC state from 02 to 00
<7> [389.273078] xe 0000:00:02.0: [drm:intel_power_well_disable [xe]] disabling DC_off
<7> [389.273610] xe 0000:00:02.0: [drm:skl_enable_dc6 [xe]] Enabling DC6
<7> [389.274104] xe 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [xe]] Setting DC state from 00 to 02
<7> [389.406029] xe 0000:00:02.0: [drm:intel_power_well_enable [xe]] enabling DC_off
<7> [389.406533] xe 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [xe]] Setting DC state from 02 to 00
<7> [389.439746] xe 0000:00:02.0: [drm:intel_power_well_disable [xe]] disabling DC_off
<7> [389.440269] xe 0000:00:02.0: [drm:skl_enable_dc6 [xe]] Enabling DC6
<7> [389.440791] xe 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [xe]] Setting DC state from 00 to 02
<7> [389.572762] xe 0000:00:02.0: [drm:intel_power_well_enable [xe]] enabling DC_off
<7> [389.573212] xe 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [xe]] Setting DC state from 02 to 00
<7> [389.605382] xe 0000:00:02.0: [drm:intel_power_well_disable [xe]] disabling DC_off
<7> [389.605914] xe 0000:00:02.0: [drm:skl_enable_dc6 [xe]] Enabling DC6
<7> [389.606437] xe 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [xe]] Setting DC state from 00 to 02
<7> [389.739290] xe 0000:00:02.0: [drm:intel_power_well_enable [xe]] enabling DC_off
<7> [389.739705] xe 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [xe]] Setting DC state from 02 to 00
<7> [389.772033] xe 0000:00:02.0: [drm:intel_power_well_disable [xe]] disabling DC_off
<7> [389.772563] xe 0000:00:02.0: [drm:skl_enable_dc6 [xe]] Enabling DC6
<7> [389.773090] xe 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [xe]] Setting DC state from 00 to 02
<7> [389.905962] xe 0000:00:02.0: [drm:intel_power_well_enable [xe]] enabling DC_off
<7> [389.906404] xe 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [xe]] Setting DC state from 02 to 00
<7> [389.938682] xe 0000:00:02.0: [drm:intel_power_well_disable [xe]] disabling DC_off
<7> [389.939218] xe 0000:00:02.0: [drm:skl_enable_dc6 [xe]] Enabling DC6
<7> [389.939739] xe 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [xe]] Setting DC state from 00 to 02
<7> [390.072649] xe 0000:00:02.0: [drm:intel_power_well_enable [xe]] enabling DC_off
<7> [390.073094] xe 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [xe]] Setting DC state from 02 to 00
<7> [390.105344] xe 0000:00:02.0: [drm:intel_power_well_disable [xe]] disabling DC_off
<7> [390.105873] xe 0000:00:02.0: [drm:skl_enable_dc6 [xe]] Enabling DC6
<7> [390.106398] xe 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [xe]] Setting DC state from 00 to 02
<7> [390.239250] xe 0000:00:02.0: [drm:intel_power_well_enable [xe]] enabling DC_off
<7> [390.239700] xe 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [xe]] Setting DC state from 02 to 00
<7> [390.272958] xe 0000:00:02.0: [drm:intel_power_well_disable [xe]] disabling DC_off
<7> [390.273541] xe 0000:00:02.0: [drm:skl_enable_dc6 [xe]] Enabling DC6
<7> [390.274135] xe 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [xe]] Setting DC state from 00 to 02
<7> [390.406014] xe 0000:00:02.0: [drm:intel_power_well_enable [xe]] enabling DC_off
<7> [390.406532] xe 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [xe]] Setting DC state from 02 to 00
<7> [390.439552] xe 0000:00:02.0: [drm:intel_power_well_disable [xe]] disabling DC_off
<7> [390.440153] xe 0000:00:02.0: [drm:skl_enable_dc6 [xe]] Enabling DC6
<7> [390.440750] xe 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [xe]] Setting DC state from 00 to 02
<7> [390.572623] xe 0000:00:02.0: [drm:intel_power_well_enable [xe]] enabling DC_off
<7> [390.573115] xe 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [xe]] Setting DC state from 02 to 00
<7> [390.606117] xe 0000:00:02.0: [drm:intel_power_well_disable [xe]] disabling DC_off
<7> [390.606704] xe 0000:00:02.0: [drm:skl_enable_dc6 [xe]] Enabling DC6
<7> [390.607239] xe 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [xe]] Setting DC state from 00 to 02
<7> [390.739077] xe 0000:00:02.0: [drm:intel_power_well_enable [xe]] enabling DC_off
<7> [390.739532] xe 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [xe]] Setting DC state from 02 to 00
<7> [390.772682] xe 0000:00:02.0: [drm:intel_power_well_disable [xe]] disabling DC_off
<7> [390.773215] xe 0000:00:02.0: [drm:skl_enable_dc6 [xe]] Enabling DC6
<7> [390.773741] xe 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [xe]] Setting DC state from 00 to 02
<7> [390.906151] xe 0000:00:02.0: [drm:intel_power_well_enable [xe]] enabling DC_off
<7> [390.906625] xe 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [xe]] Setting DC state from 02 to 00
<7> [390.939284] xe 0000:00:02.0: [drm:intel_power_well_disable [xe]] disabling DC_off
<7> [390.939872] xe 0000:00:02.0: [drm:skl_enable_dc6 [xe]] Enabling DC6
<7> [390.940460] xe 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [xe]] Setting DC state from 00 to 02
<7> [391.072558] xe 0000:00:02.0: [drm:intel_power_well_enable [xe]] enabling DC_off
<7> [391.073000] xe 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [xe]] Setting DC state from 02 to 00
<7> [391.105839] xe 0000:00:02.0: [drm:intel_power_well_disable [xe]] disabling DC_off
<7> [391.106371] xe 0000:00:02.0: [drm:skl_enable_dc6 [xe]] Enabling DC6
<7> [391.106895] xe 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [xe]] Setting DC state from 00 to 02
<7> [391.239363] xe 0000:00:02.0: [drm:intel_power_well_enable [xe]] enabling DC_off
<7> [391.239806] xe 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [xe]] Setting DC state from 02 to 00
<7> [391.272395] xe 0000:00:02.0: [drm:intel_power_well_disable [xe]] disabling DC_off
<7> [391.272938] xe 0000:00:02.0: [drm:skl_enable_dc6 [xe]] Enabling DC6
<7> [391.273466] xe 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [xe]] Setting DC state from 00 to 02
<6> [391.613553] [IGT] kms_flip: finished subtest A-eDP1, FAIL
Created at 2026-05-11 14:22:25