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

Result: Fail

i915_display_info16 igt_runner16 results16.json results16-xe-load.json i915_display_info_post_exec16 boot16 dmesg16

DetailValue
Duration 27.15 seconds
Hostname 
shard-lnl-2
Igt-Version 
IGT-Version: 2.2-g412678fec (x86_64) (Linux: 6.18.0-lgci-xe-xe-4180-f7bb20c7069861306+ x86_64)
Out 
Using IGT_SRANDOM=1764725451 for randomisation
Opened device: /dev/dri/card0
Using monotonic timestamps
Starting subtest: flip-vs-expired-vblank-interruptible
Starting dynamic subtest: A-eDP1
  2880x1800: 60 347710 2880 2928 2960 3040 1800 1803 1809 1906 0x48 0xa 
Stack trace:
  #0 ../lib/igt_core.c:2075 __igt_fail_assert()
  #1 ../tests/kms_flip.c:923 run_test_on_crtc_set.constprop.0()
  #2 ../tests/kms_flip.c:1889 run_test()
  #3 ../tests/kms_flip.c:2158 __igt_unique____real_main2045()
  #4 ../tests/kms_flip.c:2045 main()
  #5 [__libc_init_first+0x8a]
  #6 [__libc_start_main+0x8b]
  #7 [_start+0x25]
Dynamic subtest A-eDP1: FAIL (4.562s)
Starting dynamic subtest: B-eDP1
  2880x1800: 60 347710 2880 2928 2960 3040 1800 1803 1809 1906 0x48 0xa 
Dynamic subtest B-eDP1: SUCCESS (11.242s)
Starting dynamic subtest: C-eDP1
  2880x1800: 60 347710 2880 2928 2960 3040 1800 1803 1809 1906 0x48 0xa 
Dynamic subtest C-eDP1: SUCCESS (11.323s)
Subtest flip-vs-expired-vblank-interruptible: FAIL (27.147s)
Err 
Starting subtest: flip-vs-expired-vblank-interruptible
Starting dynamic subtest: A-eDP1
(kms_flip:5505) CRITICAL: Test assertion failure function run_test_step, file ../tests/kms_flip.c:928:
(kms_flip:5505) CRITICAL: Failed assertion: end - start < 500
(kms_flip:5505) CRITICAL: Last errno: 4, Interrupted system call
Dynamic subtest A-eDP1 failed.
**** DEBUG ****
(kms_flip:5505) DEBUG: Vblank took 54us
(kms_flip:5505) DEBUG: name = flip
last_ts = 274.101227
last_received_ts = 274.100555
last_seq = 4721
current_ts = 274.117889
current_received_ts = 274.117096
current_seq = 4722
count = 77
seq_step = 1
(kms_flip:5505) DEBUG: Vblank took 54us
(kms_flip:5505) DEBUG: name = flip
last_ts = 274.117889
last_received_ts = 274.117096
last_seq = 4722
current_ts = 274.134552
current_received_ts = 274.133850
current_seq = 4723
count = 78
seq_step = 1
(kms_flip:5505) DEBUG: Vblank took 48us
(kms_flip:5505) DEBUG: name = flip
last_ts = 274.134552
last_received_ts = 274.133850
last_seq = 4723
current_ts = 274.151215
current_received_ts = 274.150513
current_seq = 4724
count = 79
seq_step = 1
(kms_flip:5505) DEBUG: Vblank took 49us
(kms_flip:5505) DEBUG: name = flip
last_ts = 274.151215
last_received_ts = 274.150513
last_seq = 4724
current_ts = 274.167877
current_received_ts = 274.167175
current_seq = 4725
count = 80
seq_step = 1
(kms_flip:5505) DEBUG: Vblank took 47us
(kms_flip:5505) DEBUG: name = flip
last_ts = 274.167877
last_received_ts = 274.167175
last_seq = 4725
current_ts = 274.184540
current_received_ts = 274.183868
current_seq = 4726
count = 81
seq_step = 1
(kms_flip:5505) DEBUG: Vblank took 48us
(kms_flip:5505) DEBUG: name = flip
last_ts = 274.184540
last_received_ts = 274.183868
last_seq = 4726
current_ts = 274.201202
current_received_ts = 274.200531
current_seq = 4727
count = 82
seq_step = 1
(kms_flip:5505) DEBUG: Vblank took 56us
(kms_flip:5505) DEBUG: name = flip
last_ts = 274.201202
last_received_ts = 274.200531
last_seq = 4727
current_ts = 274.217896
current_received_ts = 274.217194
current_seq = 4728
count = 83
seq_step = 1
(kms_flip:5505) DEBUG: Vblank took 53us
(kms_flip:5505) DEBUG: name = flip
last_ts = 274.217896
last_received_ts = 274.217194
last_seq = 4728
current_ts = 274.234528
current_received_ts = 274.233856
current_seq = 4729
count = 84
seq_step = 1
(kms_flip:5505) DEBUG: Vblank took 56us
(kms_flip:5505) DEBUG: name = flip
last_ts = 274.234528
last_received_ts = 274.233856
last_seq = 4729
current_ts = 274.251221
current_received_ts = 274.250519
current_seq = 4730
count = 85
seq_step = 1
(kms_flip:5505) DEBUG: Vblank took 61us
(kms_flip:5505) DEBUG: name = flip
last_ts = 274.251221
last_received_ts = 274.250519
last_seq = 4730
current_ts = 274.267883
current_received_ts = 274.267181
current_seq = 4731
count = 86
seq_step = 1
(kms_flip:5505) DEBUG: Vblank took 54us
(kms_flip:5505) DEBUG: name = flip
last_ts = 274.267883
last_received_ts = 274.267181
last_seq = 4731
current_ts = 274.284546
current_received_ts = 274.283844
current_seq = 4732
count = 87
seq_step = 1
(kms_flip:5505) DEBUG: Vblank took 46us
(kms_flip:5505) DEBUG: name = flip
last_ts = 274.284546
last_received_ts = 274.283844
last_seq = 4732
current_ts = 274.301208
current_received_ts = 274.300537
current_seq = 4733
count = 88
seq_step = 1
(kms_flip:5505) DEBUG: Vblank took 45us
(kms_flip:5505) DEBUG: name = flip
last_ts = 274.301208
last_received_ts = 274.300537
last_seq = 4733
current_ts = 274.317871
current_received_ts = 274.317200
current_seq = 4734
count = 89
seq_step = 1
(kms_flip:5505) DEBUG: Vblank took 59us
(kms_flip:5505) DEBUG: name = flip
last_ts = 274.317871
last_received_ts = 274.317200
last_seq = 4734
current_ts = 274.334534
current_received_ts = 274.333832
current_seq = 4735
count = 90
seq_step = 1
(kms_flip:5505) DEBUG: Vblank took 51us
(kms_flip:5505) DEBUG: name = flip
last_ts = 274.334534
last_received_ts = 274.333832
last_seq = 4735
current_ts = 274.351196
current_received_ts = 274.350433
current_seq = 4736
count = 91
seq_step = 1
(kms_flip:5505) DEBUG: Vblank took 41us
(kms_flip:5505) DEBUG: name = flip
last_ts = 274.351196
last_received_ts = 274.350433
last_seq = 4736
current_ts = 274.367859
current_received_ts = 274.367065
current_seq = 4737
count = 92
seq_step = 1
(kms_flip:5505) DEBUG: Vblank took 57us
(kms_flip:5505) DEBUG: name = flip
last_ts = 274.367859
last_received_ts = 274.367065
last_seq = 4737
current_ts = 274.384521
current_received_ts = 274.383850
current_seq = 4738
count = 93
seq_step = 1
(kms_flip:5505) DEBUG: Vblank took 56us
(kms_flip:5505) DEBUG: name = flip
last_ts = 274.384521
last_received_ts = 274.383850
last_seq = 4738
current_ts = 274.401184
current_received_ts = 274.400513
current_seq = 4739
count = 94
seq_step = 1
(kms_flip:5505) DEBUG: Vblank took 54us
(kms_flip:5505) DEBUG: name = flip
last_ts = 274.401184
last_received_ts = 274.400513
last_seq = 4739
current_ts = 274.417847
current_received_ts = 274.417145
current_seq = 4740
count = 95
seq_step = 1
(kms_flip:5505) DEBUG: Vblank took 52us
(kms_flip:5505) DEBUG: name = flip
last_ts = 274.417847
last_received_ts = 274.417145
last_seq = 4740
current_ts = 274.434509
current_received_ts = 274.433868
current_seq = 4741
count = 96
seq_step = 1
(kms_flip:5505) DEBUG: Vblank took 57us
(kms_flip:5505) DEBUG: name = flip
last_ts = 274.434509
last_received_ts = 274.433868
last_seq = 4741
current_ts = 274.451202
current_received_ts = 274.450500
current_seq = 4742
count = 97
seq_step = 1
(kms_flip:5505) DEBUG: Vblank took 47us
(kms_flip:5505) DEBUG: name = flip
last_ts = 274.451202
last_received_ts = 274.450500
last_seq = 4742
current_ts = 274.467865
current_received_ts = 274.467133
current_seq = 4743
count = 98
seq_step = 1
(kms_flip:5505) DEBUG: Vblank took 55us
(kms_flip:5505) DEBUG: name = flip
last_ts = 274.467865
last_received_ts = 274.467133
last_seq = 4743
current_ts = 274.484528
current_received_ts = 274.483826
current_seq = 4744
count = 99
seq_step = 1
(kms_flip:5505) DEBUG: Vblank took 51us
(kms_flip:5505) DEBUG: name = flip
last_ts = 274.484528
last_received_ts = 274.483826
last_seq = 4744
current_ts = 274.501190
current_received_ts = 274.500488
current_seq = 4745
count = 100
seq_step = 1
(kms_flip:5505) DEBUG: Vblank took 46us
(kms_flip:5505) DEBUG: name = flip
last_ts = 274.501190
last_received_ts = 274.500488
last_seq = 4745
current_ts = 274.517853
current_received_ts = 274.517151
current_seq = 4746
count = 101
seq_step = 1
(kms_flip:5505) DEBUG: Vblank took 51us
(kms_flip:5505) DEBUG: name = flip
last_ts = 274.517853
last_received_ts = 274.517151
last_seq = 4746
current_ts = 274.534515
current_received_ts = 274.533783
current_seq = 4747
count = 102
seq_step = 1
(kms_flip:5505) DEBUG: Vblank took 52us
(kms_flip:5505) DEBUG: name = flip
last_ts = 274.534515
last_received_ts = 274.533783
last_seq = 4747
current_ts = 274.551178
current_received_ts = 274.550507
current_seq = 4748
count = 103
seq_step = 1
(kms_flip:5505) DEBUG: Vblank took 57us
(kms_flip:5505) DEBUG: name = flip
last_ts = 274.551178
last_received_ts = 274.550507
last_seq = 4748
current_ts = 274.567841
current_received_ts = 274.567139
current_seq = 4749
count = 104
seq_step = 1
(kms_flip:5505) DEBUG: Vblank took 55us
(kms_flip:5505) DEBUG: name = flip
last_ts = 274.567841
last_received_ts = 274.567139
last_seq = 4749
current_ts = 274.584503
current_received_ts = 274.583801
current_seq = 4750
count = 105
seq_step = 1
(kms_flip:5505) DEBUG: Vblank took 54us
(kms_flip:5505) DEBUG: name = flip
last_ts = 274.584503
last_received_ts = 274.583801
last_seq = 4750
current_ts = 274.601166
current_received_ts = 274.600494
current_seq = 4751
count = 106
seq_step = 1
(kms_flip:5505) DEBUG: Vblank took 56us
(kms_flip:5505) DEBUG: name = flip
last_ts = 274.601166
last_received_ts = 274.600494
last_seq = 4751
current_ts = 274.617828
current_received_ts = 274.617126
current_seq = 4752
count = 107
seq_step = 1
(kms_flip:5505) DEBUG: Vblank took 50us
(kms_flip:5505) DEBUG: name = flip
last_ts = 274.617828
last_received_ts = 274.617126
last_seq = 4752
current_ts = 274.634491
current_received_ts = 274.633789
current_seq = 4753
count = 108
seq_step = 1
(kms_flip:5505) DEBUG: Vblank took 48us
(kms_flip:5505) DEBUG: name = flip
last_ts = 274.634491
last_received_ts = 274.633789
last_seq = 4753
current_ts = 274.651154
current_received_ts = 274.650391
current_seq = 4754
count = 109
seq_step = 1
(kms_flip:5505) DEBUG: Vblank took 46us
(kms_flip:5505) DEBUG: name = flip
last_ts = 274.651154
last_received_ts = 274.650391
last_seq = 4754
current_ts = 274.667816
current_received_ts = 274.667114
current_seq = 4755
count = 110
seq_step = 1
(kms_flip:5505) DEBUG: Vblank took 41us
(kms_flip:5505) DEBUG: name = flip
last_ts = 274.667816
last_received_ts = 274.667114
last_seq = 4755
current_ts = 274.684509
current_received_ts = 274.683777
current_seq = 4756
count = 111
seq_step = 1
(kms_flip:5505) DEBUG: Vblank took 50us
(kms_flip:5505) DEBUG: name = flip
last_ts = 274.684509
last_received_ts = 274.683777
last_seq = 4756
current_ts = 274.701141
current_received_ts = 274.700470
current_seq = 4757
count = 112
seq_step = 1
(kms_flip:5505) DEBUG: Vblank took 39us
(kms_flip:5505) DEBUG: name = flip
last_ts = 274.701141
last_received_ts = 274.700470
last_seq = 4757
current_ts = 274.717834
current_received_ts = 274.717102
current_seq = 4758
count = 113
seq_step = 1
(kms_flip:5505) DEBUG: Vblank took 49us
(kms_flip:5505) DEBUG: name = flip
last_ts = 274.717834
last_received_ts = 274.717102
last_seq = 4758
current_ts = 274.734497
current_received_ts = 274.733795
current_seq = 4759
count = 114
seq_step = 1
(kms_flip:5505) DEBUG: Vblank took 48us
(kms_flip:5505) DEBUG: name = flip
last_ts = 274.734497
last_received_ts = 274.733795
last_seq = 4759
current_ts = 274.751160
current_received_ts = 274.750641
current_seq = 4760
count = 115
seq_step = 1
(kms_flip:5505) DEBUG: Vblank took 88us
(kms_flip:5505) DEBUG: name = flip
last_ts = 274.751160
last_received_ts = 274.750641
last_seq = 4760
current_ts = 274.767822
current_received_ts = 274.767151
current_seq = 4761
count = 116
seq_step = 1
(kms_flip:5505) DEBUG: Vblank took 67us
(kms_flip:5505) DEBUG: name = flip
last_ts = 274.767822
last_received_ts = 274.767151
last_seq = 4761
current_ts = 274.784485
current_received_ts = 274.783813
current_seq = 4762
count = 117
seq_step = 1
(kms_flip:5505) DEBUG: Vblank took 64us
(kms_flip:5505) DEBUG: name = flip
last_ts = 274.784485
last_received_ts = 274.783813
last_seq = 4762
current_ts = 274.801147
current_received_ts = 274.800476
current_seq = 4763
count = 118
seq_step = 1
(kms_flip:5505) DEBUG: Vblank took 42us
(kms_flip:5505) DEBUG: name = flip
last_ts = 274.801147
last_received_ts = 274.800476
last_seq = 4763
current_ts = 274.817810
current_received_ts = 274.817108
current_seq = 4764
count = 119
seq_step = 1
(kms_flip:5505) DEBUG: Vblank took 52us
(kms_flip:5505) DEBUG: name = flip
last_ts = 274.817810
last_received_ts = 274.817108
last_seq = 4764
current_ts = 274.834473
current_received_ts = 274.833801
current_seq = 4765
count = 120
seq_step = 1
(kms_flip:5505) DEBUG: Vblank took 39us
(kms_flip:5505) DEBUG: name = flip
last_ts = 274.834473
last_received_ts = 274.833801
last_seq = 4765
current_ts = 274.851135
current_received_ts = 274.850433
current_seq = 4766
count = 121
seq_step = 1
(kms_flip:5505) DEBUG: Vblank took 51us
(kms_flip:5505) DEBUG: name = flip
last_ts = 274.851135
last_received_ts = 274.850433
last_seq = 4766
current_ts = 274.867798
current_received_ts = 274.867096
current_seq = 4767
count = 122
seq_step = 1
(kms_flip:5505) DEBUG: Vblank took 53us
(kms_flip:5505) DEBUG: name = flip
last_ts = 274.867798
last_received_ts = 274.867096
last_seq = 4767
current_ts = 274.884460
current_received_ts = 274.883789
current_seq = 4768
count = 123
seq_step = 1
(kms_flip:5505) DEBUG: Vblank took 64us
(kms_flip:5505) DEBUG: name = flip
last_ts = 274.884460
last_received_ts = 274.883789
last_seq = 4768
current_ts = 274.901123
current_received_ts = 274.900482
current_seq = 4769
count = 124
seq_step = 1
(kms_flip:5505) DEBUG: Vblank took 59us
(kms_flip:5505) DEBUG: name = flip
last_ts = 274.901123
last_received_ts = 274.900482
last_seq = 4769
current_ts = 274.917816
current_received_ts = 274.917114
current_seq = 4770
count = 125
seq_step = 1
(kms_flip:5505) DEBUG: Vblank took 51us
(kms_flip:5505) DEBUG: name = flip
last_ts = 274.917816
last_received_ts = 274.917114
last_seq = 4770
current_ts = 274.934448
current_received_ts = 274.933777
current_seq = 4771
count = 126
seq_step = 1
(kms_flip:5505) DEBUG: Vblank took 53us
(kms_flip:5505) DEBUG: name = flip
last_ts = 274.934448
last_received_ts = 274.933777
last_seq = 4771
current_ts = 274.951141
current_received_ts = 274.950439
current_seq = 4772
count = 127
seq_step = 1
(kms_flip:5505) DEBUG: Vblank took 52us
(kms_flip:5505) DEBUG: name = flip
last_ts = 274.951141
last_received_ts = 274.950439
last_seq = 4772
current_ts = 274.967804
current_received_ts = 274.967102
current_seq = 4773
count = 128
seq_step = 1
(kms_flip:5505) DEBUG: Vblank took 57us
(kms_flip:5505) DEBUG: name = flip
last_ts = 274.967804
last_received_ts = 274.967102
last_seq = 4773
current_ts = 274.984467
current_received_ts = 274.983795
current_seq = 4774
count = 129
seq_step = 1
(kms_flip:5505) DEBUG: Vblank took 49us
(kms_flip:5505) DEBUG: name = flip
last_ts = 274.984467
last_received_ts = 274.983795
last_seq = 4774
current_ts = 275.001129
current_received_ts = 275.000427
current_seq = 4775
count = 130
seq_step = 1
(kms_flip:5505) DEBUG: Vblank took 52us
(kms_flip:5505) DEBUG: name = flip
last_ts = 275.001129
last_received_ts = 275.000427
last_seq = 4775
current_ts = 275.017792
current_received_ts = 275.017090
current_seq = 4776
count = 131
seq_step = 1
(kms_flip:5505) DEBUG: Vblank took 49us
(kms_flip:5505) DEBUG: name = flip
last_ts = 275.017792
last_received_ts = 275.017090
last_seq = 4776
current_ts = 275.034454
current_received_ts = 275.033783
current_seq = 4777
count = 132
seq_step = 1
(kms_flip:5505) DEBUG: Vblank took 49us
(kms_flip:5505) DEBUG: name = flip
last_ts = 275.034454
last_received_ts = 275.033783
last_seq = 4777
current_ts = 275.051117
current_received_ts = 275.050446
current_seq = 4778
count = 133
seq_step = 1
(kms_flip:5505) DEBUG: Vblank took 51us
(kms_flip:5505) DEBUG: name = flip
last_ts = 275.051117
last_received_ts = 275.050446
last_seq = 4778
current_ts = 275.067780
current_received_ts = 275.067078
current_seq = 4779
count = 134
seq_step = 1
(kms_flip:5505) DEBUG: Vblank took 54us
(kms_flip:5505) DEBUG: name = flip
last_ts = 275.067780
last_received_ts = 275.067078
last_seq = 4779
current_ts = 275.084442
current_received_ts = 275.083771
current_seq = 4780
count = 135
seq_step = 1
(kms_flip:5505) DEBUG: Vblank took 52us
(kms_flip:5505) DEBUG: name = flip
last_ts = 275.084442
last_received_ts = 275.083771
last_seq = 4780
current_ts = 275.101105
current_received_ts = 275.100433
current_seq = 4781
count = 136
seq_step = 1
(kms_flip:5505) DEBUG: Vblank took 40us
(kms_flip:5505) DEBUG: name = flip
last_ts = 275.101105
last_received_ts = 275.100433
last_seq = 4781
current_ts = 275.117767
current_received_ts = 275.117035
current_seq = 4782
count = 137
seq_step = 1
(kms_flip:5505) DEBUG: Vblank took 56us
(kms_flip:5505) DEBUG: name = flip
last_ts = 275.117767
last_received_ts = 275.117035
last_seq = 4782
current_ts = 275.134430
current_received_ts = 275.133759
current_seq = 4783
count = 138
seq_step = 1
(kms_flip:5505) DEBUG: Vblank took 49us
(kms_flip:5505) DEBUG: name = flip
last_ts = 275.134430
last_received_ts = 275.133759
last_seq = 4783
current_ts = 275.151123
current_received_ts = 275.150421
current_seq = 4784
count = 139
seq_step = 1
(kms_flip:5505) DEBUG: Vblank took 51us
(kms_flip:5505) DEBUG: name = flip
last_ts = 275.151123
last_received_ts = 275.150421
last_seq = 4784
current_ts = 275.167786
current_received_ts = 275.167084
current_seq = 4785
count = 140
seq_step = 1
(kms_flip:5505) DEBUG: Vblank took 60us
(kms_flip:5505) DEBUG: name = flip
last_ts = 275.167786
last_received_ts = 275.167084
last_seq = 4785
current_ts = 275.184448
current_received_ts = 275.183746
current_seq = 4786
count = 141
seq_step = 1
(kms_flip:5505) DEBUG: Vblank took 56us
(kms_flip:5505) DEBUG: name = flip
last_ts = 275.184448
last_received_ts = 275.183746
last_seq = 4786
current_ts = 275.201111
current_received_ts = 275.200439
current_seq = 4787
count = 142
seq_step = 1
(kms_flip:5505) DEBUG: Vblank took 50us
(kms_flip:5505) DEBUG: name = flip
last_ts = 275.201111
last_received_ts = 275.200439
last_seq = 4787
current_ts = 275.217773
current_received_ts = 275.217072
current_seq = 4788
count = 143
seq_step = 1
(kms_flip:5505) DEBUG: Vblank took 48us
(kms_flip:5505) DEBUG: name = flip
last_ts = 275.217773
last_received_ts = 275.217072
last_seq = 4788
current_ts = 275.234436
current_received_ts = 275.233765
current_seq = 4789
count = 144
seq_step = 1
(kms_flip:5505) DEBUG: Vblank took 57us
(kms_flip:5505) DEBUG: name = flip
last_ts = 275.234436
last_received_ts = 275.233765
last_seq = 4789
current_ts = 275.251099
current_received_ts = 275.250458
current_seq = 4790
count = 145
seq_step = 1
(kms_flip:5505) DEBUG: Vblank took 62us
(kms_flip:5505) DEBUG: name = flip
last_ts = 275.251099
last_received_ts = 275.250458
last_seq = 4790
current_ts = 275.267761
current_received_ts = 275.267090
current_seq = 4791
count = 146
seq_step = 1
(kms_flip:5505) DEBUG: Vblank took 55us
(kms_flip:5505) DEBUG: name = flip
last_ts = 275.267761
last_received_ts = 275.267090
last_seq = 4791
current_ts = 275.284424
current_received_ts = 275.283722
current_seq = 4792
count = 147
seq_step = 1
(kms_flip:5505) DEBUG: Vblank took 59us
(kms_flip:5505) DEBUG: name = flip
last_ts = 275.284424
last_received_ts = 275.283722
last_seq = 4792
current_ts = 275.301086
current_received_ts = 275.300415
current_seq = 4793
count = 148
seq_step = 1
(kms_flip:5505) DEBUG: Vblank took 50us
(kms_flip:5505) DEBUG: name = flip
last_ts = 275.301086
last_received_ts = 275.300415
last_seq = 4793
current_ts = 275.317749
current_received_ts = 275.317078
current_seq = 4794
count = 149
seq_step = 1
(kms_flip:5505) DEBUG: Vblank took 54us
(kms_flip:5505) DEBUG: name = flip
last_ts = 275.317749
last_received_ts = 275.317078
last_seq = 4794
current_ts = 275.334412
current_received_ts = 275.333771
current_seq = 4795
count = 150
seq_step = 1
(kms_flip:5505) DEBUG: Vblank took 53us
(kms_flip:5505) DEBUG: name = flip
last_ts = 275.334412
last_received_ts = 275.333771
last_seq = 4795
current_ts = 275.351074
current_received_ts = 275.350342
current_seq = 4796
count = 151
seq_step = 1
(kms_flip:5505) DEBUG: Vblank took 54us
(kms_flip:5505) DEBUG: name = flip
last_ts = 275.351074
last_received_ts = 275.350342
last_seq = 4796
current_ts = 275.367737
current_received_ts = 275.367065
current_seq = 4797
count = 152
seq_step = 1
(kms_flip:5505) DEBUG: Vblank took 77us
(kms_flip:5505) DEBUG: name = flip
last_ts = 275.367737
last_received_ts = 275.367065
last_seq = 4797
current_ts = 275.384399
current_received_ts = 275.383698
current_seq = 4798
count = 153
seq_step = 1
(kms_flip:5505) DEBUG: Vblank took 48us
(kms_flip:5505) DEBUG: name = flip
last_ts = 275.384399
last_received_ts = 275.383698
last_seq = 4798
current_ts = 275.401093
current_received_ts = 275.400421
current_seq = 4799
count = 154
seq_step = 1
(kms_flip:5505) DEBUG: Vblank took 60us
(kms_flip:5505) DEBUG: name = flip
last_ts = 275.401093
last_received_ts = 275.400421
last_seq = 4799
current_ts = 275.417755
current_received_ts = 275.417053
current_seq = 4800
count = 155
seq_step = 1
(kms_flip:5505) DEBUG: Vblank took 61us
(kms_flip:5505) DEBUG: name = flip
last_ts = 275.417755
last_received_ts = 275.417053
last_seq = 4800
current_ts = 275.434418
current_received_ts = 275.433716
current_seq = 4801
count = 156
seq_step = 1
(kms_flip:5505) DEBUG: Vblank took 52us
(kms_flip:5505) DEBUG: name = flip
last_ts = 275.434418
last_received_ts = 275.433716
last_seq = 4801
current_ts = 275.451080
current_received_ts = 275.450378
current_seq = 4802
count = 157
seq_step = 1
(kms_flip:5505) DEBUG: Vblank took 54us
(kms_flip:5505) DEBUG: name = flip
last_ts = 275.451080
last_received_ts = 275.450378
last_seq = 4802
current_ts = 275.467743
current_received_ts = 275.467072
current_seq = 4803
count = 158
seq_step = 1
(kms_flip:5505) DEBUG: Vblank took 49us
(kms_flip:5505) DEBUG: name = flip
last_ts = 275.467743
last_received_ts = 275.467072
last_seq = 4803
current_ts = 275.484406
current_received_ts = 275.483734
current_seq = 4804
count = 159
seq_step = 1
(kms_flip:5505) DEBUG: Vblank took 43us
(kms_flip:5505) DEBUG: name = flip
last_ts = 275.484406
last_received_ts = 275.483734
last_seq = 4804
current_ts = 275.501068
current_received_ts = 275.500397
current_seq = 4805
count = 160
seq_step = 1
(kms_flip:5505) DEBUG: Vblank took 53us
(kms_flip:5505) DEBUG: name = flip
last_ts = 275.501068
last_received_ts = 275.500397
last_seq = 4805
current_ts = 275.517731
current_received_ts = 275.517029
current_seq = 4806
count = 161
seq_step = 1
(kms_flip:5505) DEBUG: Vblank took 60us
(kms_flip:5505) DEBUG: name = flip
last_ts = 275.517731
last_received_ts = 275.517029
last_seq = 4806
current_ts = 275.534393
current_received_ts = 275.533722
current_seq = 4807
count = 162
seq_step = 1
(kms_flip:5505) DEBUG: Vblank took 43us
(kms_flip:5505) DEBUG: name = flip
last_ts = 275.534393
last_received_ts = 275.533722
last_seq = 4807
current_ts = 275.551056
current_received_ts = 275.550385
current_seq = 4808
count = 163
seq_step = 1
(kms_flip:5505) DEBUG: Vblank took 53us
(kms_flip:5505) DEBUG: name = flip
last_ts = 275.551056
last_received_ts = 275.550385
last_seq = 4808
current_ts = 275.567719
current_received_ts = 275.567047
current_seq = 4809
count = 164
seq_step = 1
(kms_flip:5505) DEBUG: Vblank took 49us
(kms_flip:5505) DEBUG: name = flip
last_ts = 275.567719
last_received_ts = 275.567047
last_seq = 4809
current_ts = 275.584381
current_received_ts = 275.583710
current_seq = 4810
count = 165
seq_step = 1
(kms_flip:5505) DEBUG: Vblank took 40us
(kms_flip:5505) DEBUG: name = flip
last_ts = 275.584381
last_received_ts = 275.583710
last_seq = 4810
current_ts = 275.601074
current_received_ts = 275.600372
current_seq = 4811
count = 166
seq_step = 1
(kms_flip:5505) DEBUG: Vblank took 50us
(kms_flip:5505) DEBUG: name = flip
last_ts = 275.601074
last_received_ts = 275.600372
last_seq = 4811
current_ts = 275.617737
current_received_ts = 275.617065
current_seq = 4812
count = 167
seq_step = 1
(kms_flip:5505) DEBUG: Vblank took 50us
(kms_flip:5505) DEBUG: name = flip
last_ts = 275.617737
last_received_ts = 275.617065
last_seq = 4812
current_ts = 275.634399
current_received_ts = 275.633698
current_seq = 4813
count = 168
seq_step = 1
(kms_flip:5505) DEBUG: Vblank took 54us
(kms_flip:5505) DEBUG: name = flip
last_ts = 275.634399
last_received_ts = 275.633698
last_seq = 4813
current_ts = 275.651062
current_received_ts = 275.650360
current_seq = 4814
count = 169
seq_step = 1
(kms_flip:5505) DEBUG: Vblank took 57us
(kms_flip:5505) DEBUG: name = flip
last_ts = 275.651062
last_received_ts = 275.650360
last_seq = 4814
current_ts = 275.667725
current_received_ts = 275.667053
current_seq = 4815
count = 170
seq_step = 1
(kms_flip:5505) DEBUG: Vblank took 54us
(kms_flip:5505) DEBUG: name = flip
last_ts = 275.667725
last_received_ts = 275.667053
last_seq = 4815
current_ts = 275.684387
current_received_ts = 275.683685
current_seq = 4816
count = 171
seq_step = 1
(kms_flip:5505) DEBUG: Vblank took 56us
(kms_flip:5505) DEBUG: name = flip
last_ts = 275.684387
last_received_ts = 275.683685
last_seq = 4816
current_ts = 275.701050
current_received_ts = 275.700348
current_seq = 4817
count = 172
seq_step = 1
(kms_flip:5505) DEBUG: Vblank took 39us
(kms_flip:5505) DEBUG: name = flip
last_ts = 275.701050
last_received_ts = 275.700348
last_seq = 4817
current_ts = 275.717712
current_received_ts = 275.717102
current_seq = 4818
count = 173
seq_step = 1
(kms_flip:5505) DEBUG: Vblank took 90us
(kms_flip:5505) DEBUG: name = flip
last_ts = 275.717712
last_received_ts = 275.717102
last_seq = 4818
current_ts = 275.734375
current_received_ts = 275.734467
current_seq = 4819
count = 174
seq_step = 1
(kms_flip:5505) DEBUG: Vblank took 85us
(kms_flip:5505) DEBUG: name = flip
last_ts = 275.734375
last_received_ts = 275.734467
last_seq = 4819
current_ts = 275.751038
current_received_ts = 275.750366
current_seq = 4820
count = 175
seq_step = 1
(kms_flip:5505) DEBUG: Vblank took 78us
(kms_flip:5505) DEBUG: name = flip
last_ts = 275.751038
last_received_ts = 275.750366
last_seq = 4820
current_ts = 275.767700
current_received_ts = 275.767151
current_seq = 4821
count = 176
seq_step = 1
(kms_flip:5505) DEBUG: Vblank took 74us
(kms_flip:5505) DEBUG: name = flip
last_ts = 275.767700
last_received_ts = 275.767151
last_seq = 4821
current_ts = 275.784363
current_received_ts = 275.783752
current_seq = 4822
count = 177
seq_step = 1
(kms_flip:5505) DEBUG: Vblank took 65us
(kms_flip:5505) DEBUG: name = flip
last_ts = 275.784363
last_received_ts = 275.783752
last_seq = 4822
current_ts = 275.801056
current_received_ts = 275.800385
current_seq = 4823
count = 178
seq_step = 1
(kms_flip:5505) DEBUG: Vblank took 72us
(kms_flip:5505) DEBUG: name = flip
last_ts = 275.801056
last_received_ts = 275.800385
last_seq = 4823
current_ts = 275.817688
current_received_ts = 275.817047
current_seq = 4824
count = 179
seq_step = 1
(kms_flip:5505) DEBUG: Vblank took 66us
(kms_flip:5505) DEBUG: name = flip
last_ts = 275.817688
last_received_ts = 275.817047
last_seq = 4824
current_ts = 275.834381
current_received_ts = 275.833710
current_seq = 4825
count = 180
seq_step = 1
(kms_flip:5505) DEBUG: Vblank took 72us
(kms_flip:5505) DEBUG: name = flip
last_ts = 275.834381
last_received_ts = 275.833710
last_seq = 4825
current_ts = 275.851044
current_received_ts = 275.850494
current_seq = 4826
count = 181
seq_step = 1
(kms_flip:5505) DEBUG: Vblank took 48us
(kms_flip:5505) DEBUG: name = flip
last_ts = 275.851044
last_received_ts = 275.850494
last_seq = 4826
current_ts = 275.867706
current_received_ts = 275.867126
current_seq = 4827
count = 182
seq_step = 1
(kms_flip:5505) DEBUG: Vblank took 71us
(kms_flip:5505) DEBUG: name = flip
last_ts = 275.867706
last_received_ts = 275.867126
last_seq = 4827
current_ts = 275.884369
current_received_ts = 275.883698
current_seq = 4828
count = 183
seq_step = 1
(kms_flip:5505) DEBUG: Vblank took 66us
(kms_flip:5505) DEBUG: name = flip
last_ts = 275.884369
last_received_ts = 275.883698
last_seq = 4828
current_ts = 275.901031
current_received_ts = 275.900452
current_seq = 4829
count = 184
seq_step = 1
(kms_flip:5505) DEBUG: Vblank took 47us
(kms_flip:5505) DEBUG: name = flip
last_ts = 275.901031
last_received_ts = 275.900452
last_seq = 4829
current_ts = 275.917694
current_received_ts = 275.917114
current_seq = 4830
count = 185
seq_step = 1
(kms_flip:5505) DEBUG: Vblank took 71us
(kms_flip:5505) DEBUG: name = flip
last_ts = 275.917694
last_received_ts = 275.917114
last_seq = 4830
current_ts = 275.934357
current_received_ts = 275.933807
current_seq = 4831
count = 186
seq_step = 1
(kms_flip:5505) DEBUG: Vblank took 65us
(kms_flip:5505) DEBUG: name = flip
last_ts = 275.934357
last_received_ts = 275.933807
last_seq = 4831
current_ts = 275.951019
current_received_ts = 275.950470
current_seq = 4832
count = 187
seq_step = 1
(kms_flip:5505) DEBUG: Vblank took 63us
(kms_flip:5505) DEBUG: name = flip
last_ts = 275.951019
last_received_ts = 275.950470
last_seq = 4832
current_ts = 275.967682
current_received_ts = 275.967072
current_seq = 4833
count = 188
seq_step = 1
(kms_flip:5505) DEBUG: Vblank took 62us
(kms_flip:5505) DEBUG: name = flip
last_ts = 275.967682
last_received_ts = 275.967072
last_seq = 4833
current_ts = 275.984344
current_received_ts = 275.983643
current_seq = 4834
count = 189
seq_step = 1
(kms_flip:5505) DEBUG: Vblank took 64us
(kms_flip:5505) DEBUG: name = flip
last_ts = 275.984344
last_received_ts = 275.983643
last_seq = 4834
current_ts = 276.001007
current_received_ts = 276.000458
current_seq = 4835
count = 190
seq_step = 1
(kms_flip:5505) DEBUG: Vblank took 46us
(kms_flip:5505) DEBUG: name = flip
last_ts = 276.001007
last_received_ts = 276.000458
last_seq = 4835
current_ts = 276.017670
current_received_ts = 276.017120
current_seq = 4836
count = 191
seq_step = 1
(kms_flip:5505) DEBUG: Vblank took 86us
(kms_flip:5505) DEBUG: name = flip
last_ts = 276.017670
last_received_ts = 276.017120
last_seq = 4836
current_ts = 276.034332
current_received_ts = 276.033661
current_seq = 4837
count = 192
seq_step = 1
(kms_flip:5505) DEBUG: Vblank took 73us
(kms_flip:5505) DEBUG: name = flip
last_ts = 276.034332
last_received_ts = 276.033661
last_seq = 4837
current_ts = 276.050995
current_received_ts = 276.050354
current_seq = 4838
count = 193
seq_step = 1
(kms_flip:5505) DEBUG: Vblank took 70us
(kms_flip:5505) DEBUG: name = flip
last_ts = 276.050995
last_received_ts = 276.050354
last_seq = 4838
current_ts = 276.067688
current_received_ts = 276.067108
current_seq = 4839
count = 194
seq_step = 1
(kms_flip:5505) DEBUG: Vblank took 72us
(kms_flip:5505) DEBUG: name = flip
last_ts = 276.067688
last_received_ts = 276.067108
last_seq = 4839
current_ts = 276.084351
current_received_ts = 276.083710
current_seq = 4840
count = 195
seq_step = 1
(kms_flip:5505) DEBUG: Vblank took 93us
(kms_flip:5505) DEBUG: name = flip
last_ts = 276.084351
last_received_ts = 276.083710
last_seq = 4840
current_ts = 276.101013
current_received_ts = 276.100372
current_seq = 4841
count = 196
seq_step = 1
(kms_flip:5505) DEBUG: Vblank took 68us
(kms_flip:5505) DEBUG: name = flip
last_ts = 276.101013
last_received_ts = 276.100372
last_seq = 4841
current_ts = 276.117676
current_received_ts = 276.116913
current_seq = 4842
count = 197
seq_step = 1
(kms_flip:5505) DEBUG: Vblank took 1751us
(kms_flip:5505) CRITICAL: Test assertion failure function run_test_step, file ../tests/kms_flip.c:928:
(kms_flip:5505) CRITICAL: Failed assertion: end - start < 500
(kms_flip:5505) CRITICAL: Last errno: 4, Interrupted system call
(kms_flip:5505) igt_core-INFO: Stack trace:
(kms_flip:5505) igt_core-INFO:   #0 ../lib/igt_core.c:2075 __igt_fail_assert()
(kms_flip:5505) igt_core-INFO:   #1 ../tests/kms_flip.c:923 run_test_on_crtc_set.constprop.0()
(kms_flip:5505) igt_core-INFO:   #2 ../tests/kms_flip.c:1889 run_test()
(kms_flip:5505) igt_core-INFO:   #3 ../tests/kms_flip.c:2158 __igt_unique____real_main2045()
(kms_flip:5505) igt_core-INFO:   #4 ../tests/kms_flip.c:2045 main()
(kms_flip:5505) igt_core-INFO:   #5 [__libc_init_first+0x8a]
(kms_flip:5505) igt_core-INFO:   #6 [__libc_start_main+0x8b]
(kms_flip:5505) igt_core-INFO:   #7 [_start+0x25]
****  END  ****
Dynamic subtest A-eDP1: FAIL (4.562s)
Starting dynamic subtest: B-eDP1
Dynamic subtest B-eDP1: SUCCESS (11.242s)
Starting dynamic subtest: C-eDP1
Dynamic subtest C-eDP1: SUCCESS (11.323s)
Subtest flip-vs-expired-vblank-interruptible: FAIL (27.147s)
Dmesg
<6> [271.379012] Console: switching to colour dummy device 80x25
<6> [271.379283] [IGT] kms_flip: executing
<7> [271.384634] xe 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] [CONNECTOR:220:DP-1]
<7> [271.384644] xe 0000:00:02.0: [drm:intel_dp_detect [xe]] [CONNECTOR:220:DP-1]
<7> [271.384821] xe 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] [CONNECTOR:220:DP-1] disconnected
<7> [271.385111] xe 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] [CONNECTOR:232:DP-2]
<7> [271.385114] xe 0000:00:02.0: [drm:intel_dp_detect [xe]] [CONNECTOR:232:DP-2]
<7> [271.385261] xe 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] [CONNECTOR:232:DP-2] disconnected
<7> [271.385546] xe 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] [CONNECTOR:240:DP-3]
<7> [271.385549] xe 0000:00:02.0: [drm:intel_dp_detect [xe]] [CONNECTOR:240:DP-3]
<7> [271.385714] xe 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] [CONNECTOR:240:DP-3] disconnected
<7> [271.386041] xe 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] [CONNECTOR:211:eDP-1]
<7> [271.386044] xe 0000:00:02.0: [drm:intel_dp_detect [xe]] [CONNECTOR:211:eDP-1]
<7> [271.386523] 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> [271.386856] xe 0000:00:02.0: [drm:intel_dp_print_rates [xe]] source rates: 162000, 216000, 243000, 270000, 324000, 432000, 540000, 675000, 810000
<7> [271.386990] xe 0000:00:02.0: [drm:intel_dp_print_rates [xe]] sink rates: 162000, 216000, 243000, 270000, 324000, 432000, 540000, 810000
<7> [271.387120] xe 0000:00:02.0: [drm:intel_dp_print_rates [xe]] common rates: 162000, 216000, 243000, 270000, 324000, 432000, 540000, 810000
<7> [271.387277] xe 0000:00:02.0: [drm:update_display_info.part.0] [CONNECTOR:211:eDP-1] Supported Monitor Refresh rate range is 40 Hz - 120 Hz
<5> [271.387282] [drm] DisplayID checksum invalid, remainder is 248 (ignoring)
<5> [271.387284] [drm] DisplayID checksum invalid, remainder is 248 (ignoring)
<7> [271.387285] xe 0000:00:02.0: [drm:update_display_info.part.0] [CONNECTOR:211:eDP-1] DisplayID extension version 0x13, primary use 0x00
<7> [271.387288] xe 0000:00:02.0: [drm:update_display_info.part.0] [CONNECTOR:211:eDP-1] Assigning EDID-1.4 digital sink color depth as 10 bpc.
<5> [271.387290] [drm] DisplayID checksum invalid, remainder is 248 (ignoring)
<7> [271.387292] xe 0000:00:02.0: [drm:update_display_info.part.0] [CONNECTOR:211:eDP-1] ELD monitor
<5> [271.387295] [drm] DisplayID checksum invalid, remainder is 248 (ignoring)
<7> [271.387297] xe 0000:00:02.0: [drm:update_display_info.part.0] [CONNECTOR:211:eDP-1] ELD size 20, SAD count 0
<5> [271.387299] [drm] DisplayID checksum invalid, remainder is 248 (ignoring)
<7> [271.387314] xe 0000:00:02.0: [drm:intel_dp_set_edid [xe]] [CONNECTOR:211:eDP-1] VRR capable: yes
<7> [271.387467] xe 0000:00:02.0: [drm:intel_dp_set_edid [xe]] [CONNECTOR:211:eDP-1] DFP max bpc 0, max dotclock 0, TMDS clock 0-0, PCON Max FRL BW 0Gbps
<7> [271.387607] xe 0000:00:02.0: [drm:intel_dp_set_edid [xe]] [CONNECTOR:211:eDP-1] RGB->YcbCr conversion? no, YCbCr 4:2:0 allowed? yes, YCbCr 4:4:4->4:2:0 conversion? no
<5> [271.388183] [drm] DisplayID checksum invalid, remainder is 248 (ignoring)
<5> [271.388185] [drm] DisplayID checksum invalid, remainder is 248 (ignoring)
<5> [271.388186] [drm] DisplayID checksum invalid, remainder is 248 (ignoring)
<7> [271.388244] xe 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] [CONNECTOR:211:eDP-1] probed modes:
<7> [271.388247] 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> [271.388251] 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> [271.388265] xe 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] [CONNECTOR:220:DP-1]
<7> [271.388268] xe 0000:00:02.0: [drm:intel_dp_detect [xe]] [CONNECTOR:220:DP-1]
<7> [271.388404] xe 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] [CONNECTOR:220:DP-1] disconnected
<7> [271.388414] xe 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] [CONNECTOR:232:DP-2]
<7> [271.388417] xe 0000:00:02.0: [drm:intel_dp_detect [xe]] [CONNECTOR:232:DP-2]
<7> [271.388548] xe 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] [CONNECTOR:232:DP-2] disconnected
<7> [271.388558] xe 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] [CONNECTOR:240:DP-3]
<7> [271.388560] xe 0000:00:02.0: [drm:intel_dp_detect [xe]] [CONNECTOR:240:DP-3]
<7> [271.388740] xe 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] [CONNECTOR:240:DP-3] disconnected
<6> [271.393301] [IGT] kms_flip: starting subtest flip-vs-expired-vblank-interruptible
<6> [271.394586] [IGT] kms_flip: starting dynamic subtest A-eDP1
<7> [271.401002] xe 0000:00:02.0: [drm:drm_mode_addfb2] [FB:248]
<7> [271.401387] xe 0000:00:02.0: [drm:drm_mode_addfb2] [FB:250]
<7> [271.458031] xe 0000:00:02.0: [drm:drm_mode_setcrtc] [CRTC:89:pipe A]
<7> [271.458109] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:89:pipe A] fastset requirement not met in hw.enable (expected yes, found no)
<7> [271.458239] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:89:pipe A] fastset requirement not met in hw.active (expected yes, found no)
<7> [271.458350] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:89:pipe A] fastset requirement not met in cpu_transcoder (expected 0, found -1)
<7> [271.458448] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:89:pipe A] fastset requirement not met in lane_count (expected 4, found 0)
<7> [271.458541] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:89: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> [271.458640] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:89:pipe A] fastset requirement not met in output_types (expected 0x00000100, found 0x00000000)
<7> [271.458757] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:89:pipe A] fastset requirement not met in framestart_delay (expected 1, found 0)
<7> [271.458872] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:89:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hdisplay (expected 2880, found 0)
<7> [271.458976] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:89:pipe A] fastset requirement not met in hw.pipe_mode.crtc_htotal (expected 3040, found 0)
<7> [271.459069] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:89:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hblank_start (expected 2880, found 0)
<7> [271.459154] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:89:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hblank_end (expected 3040, found 0)
<7> [271.459237] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:89:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hsync_start (expected 2928, found 0)
<7> [271.459324] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:89:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hsync_end (expected 2960, found 0)
<7> [271.459416] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:89:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vdisplay (expected 1800, found 0)
<7> [271.459511] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:89:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vblank_start (expected 1800, found 0)
<7> [271.459604] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:89:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vsync_start (expected 1803, found 0)
<7> [271.459772] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:89:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vsync_end (expected 1809, found 0)
<7> [271.459896] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:89:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vtotal (expected 1906, found 0)
<7> [271.460003] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:89:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vblank_end (expected 1906, found 0)
<7> [271.460100] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:89:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hdisplay (expected 2880, found 0)
<7> [271.460181] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:89:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_htotal (expected 3040, found 0)
<7> [271.460263] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:89:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hblank_start (expected 2880, found 0)
<7> [271.460351] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:89:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hblank_end (expected 3040, found 0)
<7> [271.460438] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:89:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hsync_start (expected 2928, found 0)
<7> [271.460523] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:89:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hsync_end (expected 2960, found 0)
<7> [271.460609] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:89:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vdisplay (expected 1800, found 0)
<7> [271.460717] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:89:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vblank_start (expected 1800, found 0)
<7> [271.460817] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:89:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vsync_start (expected 1803, found 0)
<7> [271.460916] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:89:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vsync_end (expected 1809, found 0)
<7> [271.460994] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:89:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vtotal (expected 1906, found 0)
<7> [271.461069] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:89:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vblank_end (expected 1906, found 0)
<7> [271.461150] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:89:pipe A] fastset requirement not met in pixel_multiplier (expected 1, found 0)
<7> [271.461231] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:89:pipe A] fastset requirement not met in hw.adjusted_mode.flags (2) (expected 2, found 0)
<7> [271.461312] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:89:pipe A] fastset requirement not met in hw.adjusted_mode.flags (8) (expected 8, found 0)
<7> [271.461395] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:89:pipe A] fastset requirement not met in pipe_bpp (expected 30, found 0)
<7> [271.461476] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:89:pipe A] fastset requirement not met in hw.pipe_mode.crtc_clock (expected 347710, found 0)
<7> [271.461556] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:89:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_clock (expected 347710, found 0)
<7> [271.461641] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:89:pipe A] fastset requirement not met in port_clock (expected 432000, found 0)
<7> [271.461738] xe 0000:00:02.0: [drm:intel_atomic_check [xe]] [CRTC:89:pipe A] fastset requirement not met, forcing full modeset
<7> [271.461835] xe 0000:00:02.0: [drm:intel_dpll_crtc_put [xe]] [CRTC:89:pipe A] releasing DPLL 0
<7> [271.461966] xe 0000:00:02.0: [drm:skl_compute_wm [xe]] Enabled dbuf slices 0xf -> 0x1 (total dbuf slices 0xf), mbus joined? yes->no
<7> [271.462037] xe 0000:00:02.0: [drm:skl_compute_wm [xe]] [CRTC:89:pipe A] dbuf slices 0xf -> 0x0, ddb (0 - 4096) -> (0 - 0), active pipes 0x1 -> 0x0
<7> [271.462132] xe 0000:00:02.0: [drm:skl_compute_wm [xe]] [PLANE:33:plane 1A] ddb ( 0 - 4051) -> ( 0 - 0), size 4051 -> 0
<7> [271.462210] xe 0000:00:02.0: [drm:skl_compute_wm [xe]] [PLANE:83:cursor A] ddb (4051 - 4096) -> ( 0 - 0), size 45 -> 0
<7> [271.462285] xe 0000:00:02.0: [drm:skl_print_plane_changes [xe]] [PLANE:33:plane 1A] level *wm0,*wm1,*wm2,*wm3,*wm4,*wm5, wm6, wm7,*twm,*swm,*stwm -> wm0, wm1, wm2, wm3, wm4, wm5, wm6, wm7, twm, swm, stwm
<7> [271.462350] xe 0000:00:02.0: [drm:skl_print_plane_changes [xe]] [PLANE:33: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> [271.462414] xe 0000:00:02.0: [drm:skl_print_plane_changes [xe]] [PLANE:33: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> [271.462477] xe 0000:00:02.0: [drm:skl_print_plane_changes [xe]] [PLANE:33: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> [271.462555] xe 0000:00:02.0: [drm:intel_bw_atomic_check [xe]] [CRTC:89:pipe A] data rate 0 num active planes 0
<7> [271.462653] xe 0000:00:02.0: [drm:intel_bw_atomic_check [xe]] QGV point 0: max bw 23530 required 0 qgv_peak_bw: 38400
<7> [271.462763] xe 0000:00:02.0: [drm:intel_bw_atomic_check [xe]] QGV point 1: max bw 36260 required 0 qgv_peak_bw: 38400
<7> [271.462869] xe 0000:00:02.0: [drm:intel_bw_atomic_check [xe]] QGV point 2: max bw 38000 required 0 qgv_peak_bw: 38400
<7> [271.462968] xe 0000:00:02.0: [drm:intel_bw_atomic_check [xe]] QGV point 3: max bw 38000 required 0 qgv_peak_bw: 38400
<7> [271.463055] xe 0000:00:02.0: [drm:intel_bw_atomic_check [xe]] Matching peaks QGV bw: 38400 for required data rate: 0
<7> [271.463144] xe 0000:00:02.0: [drm:intel_cdclk_atomic_check [xe]] [CRTC:89:pipe A] min cdclk: 173855 kHz -> 0 kHz
<7> [271.463248] xe 0000:00:02.0: [drm:intel_cdclk_update_dbuf_bw_min_cdclk [xe]] dbuf bandwidth min cdclk: 21732 kHz -> 0 kHz
<7> [271.463345] xe 0000:00:02.0: [drm:intel_cdclk_atomic_check [xe]] Can change cdclk via squashing
<7> [271.463437] xe 0000:00:02.0: [drm:intel_cdclk_atomic_check [xe]] New cdclk calculated to be logical 153600 kHz, actual 153600 kHz
<7> [271.463522] xe 0000:00:02.0: [drm:intel_cdclk_atomic_check [xe]] New voltage level calculated to be logical 0, actual 0
<7> [271.463617] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [CRTC:89:pipe A] enable: no [modeset]
<7> [271.463726] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [PLANE:33:plane 1A] fb: [NOFB], visible: no
<7> [271.463831] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [PLANE:43:plane 2A] fb: [NOFB], visible: no
<7> [271.463937] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [PLANE:53:plane 3A] fb: [NOFB], visible: no
<7> [271.464025] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [PLANE:63:plane 4A] fb: [NOFB], visible: no
<7> [271.464112] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [PLANE:73:plane 5A] fb: [NOFB], visible: no
<7> [271.464198] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [PLANE:83:cursor A] fb: [NOFB], visible: no
<7> [271.464320] xe 0000:00:02.0: [drm:intel_power_well_enable [xe]] enabling DC_off
<7> [271.464423] xe 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [xe]] Setting DC state from 02 to 00
<7> [271.464569] xe 0000:00:02.0: [drm:intel_psr_disable_locked [xe]] Disabling PSR2
<7> [271.465288] xe 0000:00:02.0: [drm:intel_alpm_disable [xe]] Disabling ALPM
<7> [271.465398] xe 0000:00:02.0: [drm:intel_edp_backlight_off [xe]]
<7> [271.673828] xe 0000:00:02.0: [drm:intel_backlight_set_pwm_level [xe]] [CONNECTOR:211:eDP-1] set backlight PWM = 0
<7> [271.674479] xe 0000:00:02.0: [drm:intel_disable_transcoder [xe]] disabling pipe A
<7> [271.685149] xe 0000:00:02.0: [drm:intel_pps_off_unlocked [xe]] [ENCODER:210:DDI A/PHY A] PPS 0 turn panel power off
<7> [271.685502] xe 0000:00:02.0: [drm:intel_pps_off_unlocked [xe]] [ENCODER:210:DDI A/PHY A] PPS 0 wait for panel power off time
<7> [271.685908] xe 0000:00:02.0: [drm:wait_panel_status [xe]] [ENCODER:210:DDI A/PHY A] PPS 0 mask: 0xb0000000 value: 0x00000000 PP_STATUS: 0xa0000002 PP_CONTROL: 0x00000060
<7> [271.737887] xe 0000:00:02.0: [drm:icp_irq_handler [xe]] hotplug event received, stat 0x00010000, dig 0x00000009, pins 0x00000010, long 0x00000000
<7> [271.738232] xe 0000:00:02.0: [drm:intel_hpd_irq_handler [xe]] digital hpd on [ENCODER:210:DDI A/PHY A] - short
<7> [271.747077] xe 0000:00:02.0: [drm:wait_panel_status [xe]] Wait complete
<7> [271.747585] xe 0000:00:02.0: [drm:intel_dp_hpd_pulse [xe]] ignoring short hpd on eDP [ENCODER:210:DDI A/PHY A]
<7> [271.747558] xe 0000:00:02.0: [drm:intel_dpll_disable [xe]] disable DPLL 0 (active 0x1, on? 1) for [CRTC:89:pipe A]
<7> [271.749044] xe 0000:00:02.0: [drm:intel_dpll_disable [xe]] disabling DPLL 0
<7> [271.749592] xe 0000:00:02.0: [drm:intel_power_well_disable [xe]] disabling AUX_A
<7> [271.750227] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:210:DDI A/PHY A]
<7> [271.750666] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:219:DDI TC1/PHY TC1]
<7> [271.751043] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:221:DP-MST A]
<7> [271.751373] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:222:DP-MST B]
<7> [271.751709] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:223:DP-MST C]
<7> [271.752079] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:231:DDI TC2/PHY TC2]
<7> [271.752392] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:233:DP-MST A]
<7> [271.752718] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:234:DP-MST B]
<7> [271.753037] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:235:DP-MST C]
<7> [271.753333] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:239:DDI TC3/PHY TC3]
<7> [271.753640] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:241:DP-MST A]
<7> [271.753937] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:242:DP-MST B]
<7> [271.754227] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:243:DP-MST C]
<7> [271.754512] xe 0000:00:02.0: [drm:verify_connector_state [xe]] [CONNECTOR:211:eDP-1]
<7> [271.754927] xe 0000:00:02.0: [drm:intel_dbuf_mdclk_cdclk_ratio_update [xe]] Updating dbuf ratio to 4 (mbus joined: no)
<7> [271.755235] xe 0000:00:02.0: [drm:intel_dbuf_mbus_join_update [xe]] Changing mbus joined: yes -> no (pipe: *)
<7> [271.755526] xe 0000:00:02.0: [drm:gen9_dbuf_slices_update [xe]] Updating dbuf slices to 0x1
<7> [271.756065] xe 0000:00:02.0: [drm:intel_power_well_disable [xe]] disabling PW_A
<7> [271.756562] xe 0000:00:02.0: [drm:intel_modeset_verify_crtc [xe]] [CRTC:89:pipe A]
<7> [271.756946] 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> [271.757361] xe 0000:00:02.0: [drm:intel_dbuf_mdclk_cdclk_ratio_update [xe]] Updating dbuf ratio to 4 (mbus joined: no)
<7> [271.757724] xe 0000:00:02.0: [drm:intel_audio_cdclk_change_post.part.0 [xe]] aud_ts_cdclk set to M=60, N=384
<7> [271.758646] xe 0000:00:02.0: [drm:drm_mode_setcrtc] [CRTC:148:pipe B]
<7> [271.759041] xe 0000:00:02.0: [drm:drm_mode_setcrtc] [CRTC:207:pipe C]
<7> [271.759341] xe 0000:00:02.0: [drm:drm_mode_setcrtc] [CRTC:89:pipe A]
<7> [271.759414] xe 0000:00:02.0: [drm:drm_mode_setcrtc] [CONNECTOR:211:eDP-1]
<7> [271.759596] xe 0000:00:02.0: [drm:intel_atomic_check [xe]] [CONNECTOR:211:eDP-1] Limiting display bpp to 30 (EDID bpp 30, max requested bpp 36, max platform bpp 36)
<7> [271.760079] xe 0000:00:02.0: [drm:intel_dp_compute_config_limits [xe]] [ENCODER:210:DDI A/PHY A][CRTC:89:pipe A] DP link limits: pixel clock 347710 kHz DSC off max lanes 4 max rate 810000 max pipe_bpp 30 max link_bpp 30.0000
<7> [271.760427] xe 0000:00:02.0: [drm:intel_dp_compute_link_config [xe]] DP lane count 4 clock 432000 bpp input 30 compressed 0.0000 link rate required 1303913 available 1728000
<7> [271.760782] xe 0000:00:02.0: [drm:intel_atomic_check [xe]] [CRTC:89:pipe A] hw max bpp: 30, pipe bpp: 30, dithering: 0
<7> [271.761133] xe 0000:00:02.0: [drm:intel_ddi_compute_config_late [xe]] [ENCODER:210:DDI A/PHY A] [CRTC:89:pipe A]
<7> [271.761433] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:89:pipe A] fastset requirement not met in hw.enable (expected no, found yes)
<7> [271.761747] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:89:pipe A] fastset requirement not met in hw.active (expected no, found yes)
<7> [271.762036] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:89:pipe A] fastset requirement not met in cpu_transcoder (expected -1, found 0)
<7> [271.762303] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:89:pipe A] fastset requirement not met in lane_count (expected 0, found 4)
<7> [271.762553] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:89: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> [271.762840] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:89:pipe A] fastset requirement not met in output_types (expected 0x00000000, found 0x00000100)
<7> [271.763108] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:89:pipe A] fastset requirement not met in framestart_delay (expected 0, found 1)
<7> [271.763349] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:89:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hdisplay (expected 0, found 2880)
<7> [271.763572] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:89:pipe A] fastset requirement not met in hw.pipe_mode.crtc_htotal (expected 0, found 3040)
<7> [271.763851] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:89:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hblank_start (expected 0, found 2880)
<7> [271.764065] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:89:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hblank_end (expected 0, found 3040)
<7> [271.764266] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:89:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hsync_start (expected 0, found 2928)
<7> [271.764459] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:89:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hsync_end (expected 0, found 2960)
<7> [271.764658] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:89:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vdisplay (expected 0, found 1800)
<7> [271.764876] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:89:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vblank_start (expected 0, found 1800)
<7> [271.765068] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:89:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vsync_start (expected 0, found 1803)
<7> [271.765264] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:89:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vsync_end (expected 0, found 1809)
<7> [271.765454] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:89:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vtotal (expected 0, found 1906)
<7> [271.765630] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:89:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vblank_end (expected 0, found 1906)
<7> [271.765791] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:89:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hdisplay (expected 0, found 2880)
<7> [271.765943] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:89:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_htotal (expected 0, found 3040)
<7> [271.766096] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:89:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hblank_start (expected 0, found 2880)
<7> [271.766246] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:89:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hblank_end (expected 0, found 3040)
<7> [271.766390] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:89:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hsync_start (expected 0, found 2928)
<7> [271.766535] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:89:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hsync_end (expected 0, found 2960)
<7> [271.766692] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:89:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vdisplay (expected 0, found 1800)
<7> [271.766831] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:89:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vblank_start (expected 0, found 1800)
<7> [271.766962] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:89:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vsync_start (expected 0, found 1803)
<7> [271.767085] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:89:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vsync_end (expected 0, found 1809)
<7> [271.767223] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:89:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vtotal (expected 0, found 1906)
<7> [271.767348] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:89:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vblank_end (expected 0, found 1906)
<7> [271.767462] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:89:pipe A] fastset requirement not met in pixel_multiplier (expected 0, found 1)
<7> [271.767579] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:89:pipe A] fastset requirement not met in hw.adjusted_mode.flags (2) (expected 0, found 2)
<7> [271.767712] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:89:pipe A] fastset requirement not met in hw.adjusted_mode.flags (8) (expected 0, found 8)
<7> [271.767836] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:89:pipe A] fastset requirement not met in pipe_bpp (expected 0, found 30)
<7> [271.767949] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:89:pipe A] fastset requirement not met in hw.pipe_mode.crtc_clock (expected 0, found 347710)
<7> [271.768053] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:89:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_clock (expected 0, found 347710)
<7> [271.768157] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:89:pipe A] fastset requirement not met in port_clock (expected 0, found 432000)
<7> [271.768261] xe 0000:00:02.0: [drm:intel_atomic_check [xe]] [CRTC:89:pipe A] fastset requirement not met, forcing full modeset
<7> [271.768412] xe 0000:00:02.0: [drm:skl_compute_wm [xe]] Enabled dbuf slices 0x1 -> 0xf (total dbuf slices 0xf), mbus joined? no->yes
<7> [271.768514] xe 0000:00:02.0: [drm:skl_compute_wm [xe]] [CRTC:89:pipe A] dbuf slices 0x0 -> 0xf, ddb (0 - 0) -> (0 - 4096), active pipes 0x0 -> 0x1
<7> [271.768672] xe 0000:00:02.0: [drm:skl_compute_wm [xe]] [PLANE:33:plane 1A] ddb ( 0 - 0) -> ( 0 - 4051), size 0 -> 4051
<7> [271.768759] xe 0000:00:02.0: [drm:skl_compute_wm [xe]] [PLANE:83:cursor A] ddb ( 0 - 0) -> (4051 - 4096), size 0 -> 45
<7> [271.768838] xe 0000:00:02.0: [drm:skl_print_plane_changes [xe]] [PLANE:33:plane 1A] level wm0, wm1, wm2, wm3, wm4, wm5, wm6, wm7, twm, swm, stwm -> *wm0,*wm1,*wm2,*wm3,*wm4,*wm5, wm6, wm7,*twm,*swm,*stwm
<7> [271.768916] xe 0000:00:02.0: [drm:skl_print_plane_changes [xe]] [PLANE:33: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> [271.768992] xe 0000:00:02.0: [drm:skl_print_plane_changes [xe]] [PLANE:33: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> [271.769071] xe 0000:00:02.0: [drm:skl_print_plane_changes [xe]] [PLANE:33: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> [271.769172] xe 0000:00:02.0: [drm:intel_bw_atomic_check [xe]] [CRTC:89:pipe A] data rate 1390840 num active planes 1
<7> [271.769288] xe 0000:00:02.0: [drm:intel_bw_atomic_check [xe]] QGV point 0: max bw 23530 required 1461 qgv_peak_bw: 38400
<7> [271.769387] xe 0000:00:02.0: [drm:intel_bw_atomic_check [xe]] QGV point 1: max bw 36260 required 1461 qgv_peak_bw: 38400
<7> [271.769482] xe 0000:00:02.0: [drm:intel_bw_atomic_check [xe]] QGV point 2: max bw 38000 required 1461 qgv_peak_bw: 38400
<7> [271.769576] xe 0000:00:02.0: [drm:intel_bw_atomic_check [xe]] QGV point 3: max bw 38000 required 1461 qgv_peak_bw: 38400
<7> [271.769684] xe 0000:00:02.0: [drm:intel_bw_atomic_check [xe]] Matching peaks QGV bw: 38400 for required data rate: 1461
<7> [271.769788] xe 0000:00:02.0: [drm:intel_cdclk_atomic_check [xe]] [CRTC:89:pipe A] min cdclk: 0 kHz -> 173855 kHz
<7> [271.769917] xe 0000:00:02.0: [drm:intel_cdclk_update_dbuf_bw_min_cdclk [xe]] dbuf bandwidth min cdclk: 0 kHz -> 21732 kHz
<7> [271.770016] xe 0000:00:02.0: [drm:intel_cdclk_atomic_check [xe]] Can change cdclk via squashing
<7> [271.770115] xe 0000:00:02.0: [drm:intel_cdclk_atomic_check [xe]] New cdclk calculated to be logical 192000 kHz, actual 192000 kHz
<7> [271.770213] xe 0000:00:02.0: [drm:intel_cdclk_atomic_check [xe]] New voltage level calculated to be logical 0, actual 0
<7> [271.770314] xe 0000:00:02.0: [drm:intel_find_dpll [xe]] [CRTC:89:pipe A] allocated DPLL 0
<7> [271.770425] xe 0000:00:02.0: [drm:intel_dpll_crtc_get [xe]] [CRTC:89:pipe A] reserving DPLL 0
<7> [271.770538] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [CRTC:89:pipe A] enable: yes [modeset]
<7> [271.770659] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] active: yes, output_types: EDP (0x100), output format: RGB, sink format: RGB
<7> [271.770768] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] cpu_transcoder: A, pipe bpp: 30, dithering: 0
<7> [271.770874] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] MST master transcoder: <invalid>
<7> [271.770976] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] port sync: master transcoder: <invalid>, slave transcoder bitmask = 0x0
<7> [271.771079] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] joiner: no, pipes: 0x0
<7> [271.771175] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] splitter: disabled, link count 0, overlap 0
<7> [271.771258] 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> [271.771341] 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> [271.771424] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] fec: disabled, enhanced framing: disabled
<7> [271.771506] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] sdp split: disabled
<7> [271.771588] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] psr: enabled, selective update: enabled, panel replay: disabled, selective fetch: enabled
<7> [271.771688] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] minimum HBlank: 0
<7> [271.771792] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] audio: 0, infoframes: 0, infoframes enabled: 0x4
<7> [271.771895] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] DP SDP: VSC, revision 4, length 14
<7> [271.771993] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] pixelformat: RGB
<7> [271.772091] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] colorimetry: sRGB
<7> [271.772187] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] bpc: 0
<7> [271.772286] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] dynamic range: VESA range
<7> [271.772386] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] content type: Not defined
<7> [271.772485] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] scanline offset: 1
<7> [271.772581] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] framestart delay: 1, MSA timing delay: 0, set context latency: 0
<7> [271.772689] 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> [271.772791] 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> [271.772892] 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> [271.772991] 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> [271.773087] 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> [271.773182] 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> [271.773276] 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> [271.773371] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] port clock: 432000, pipe src: 2880x1800+0+0, pixel rate 347710, min cdclk 173855
<7> [271.773465] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] linetime: 70, ips linetime: 0
<7> [271.773550] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] num_scalers: 2, scaler_users: 0x0, scaler_id: -1, scaling_filter: 0
<7> [271.773636] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] pch pfit: 0x0+0+0, disabled, force thru: no
<7> [271.773737] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] ips: 0, double wide: 0, drrs: 0
<7> [271.773828] 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> [271.773921] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] c10pll_hw_state: clock: 432000, fracen: no,
<7> [271.774000] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] multiplier: 225, tx_clk_div: 1.
<7> [271.774078] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] c10pll_rawhw_state:
<7> [271.774157] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] tx: 0x10, cmn: 0x21
<7> [271.774233] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] pll[0] = 0x4, pll[1] = 0x0, pll[2] = 0xa2, pll[3] = 0x1
<7> [271.774310] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] pll[4] = 0x0, pll[5] = 0x0, pll[6] = 0x0, pll[7] = 0x0
<7> [271.774387] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] pll[8] = 0x0, pll[9] = 0x1, pll[10] = 0x0, pll[11] = 0x0
<7> [271.774464] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] pll[12] = 0x0, pll[13] = 0x0, pll[14] = 0x0, pll[15] = 0x1
<7> [271.774541] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] pll[16] = 0x85, pll[17] = 0xf, pll[18] = 0xe6, pll[19] = 0x23
<7> [271.774615] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] csc_mode: 0x0 gamma_mode: 0x0 gamma_enable: 0 csc_enable: 0
<7> [271.774696] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] pre csc lut: 0 entries, post csc lut: 0 entries
<7> [271.774781] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] output csc: pre offsets: 0x0000 0x0000 0x0000
<7> [271.774867] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] output csc: coefficients: 0x0000 0x0000 0x0000
<7> [271.774950] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] output csc: coefficients: 0x0000 0x0000 0x0000
<7> [271.775030] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] output csc: coefficients: 0x0000 0x0000 0x0000
<7> [271.775110] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] output csc: post offsets: 0x0000 0x0000 0x0000
<7> [271.775190] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] pipe csc: pre offsets: 0x0000 0x0000 0x0000
<7> [271.775269] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] pipe csc: coefficients: 0x0000 0x0000 0x0000
<7> [271.775348] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] pipe csc: coefficients: 0x0000 0x0000 0x0000
<7> [271.775423] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] pipe csc: coefficients: 0x0000 0x0000 0x0000
<7> [271.775494] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] pipe csc: post offsets: 0x0000 0x0000 0x0000
<7> [271.775565] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] sharpness strength: 0, sharpness tap size: 0, sharpness enable: 0
<7> [271.775653] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [PLANE:33:plane 1A] fb: [FB:248] 2880x1800 format = XR24 little-endian (0x34325258) modifier = 0x100000000000009, visible: yes
<7> [271.775739] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] rotation: 0x1, scaler: -1, scaling_filter: 0
<7> [271.775817] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] src: 2880.000000x1800.000000+0.000000+0.000000 dst: 2880x1800+0+0
<7> [271.775895] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [PLANE:43:plane 2A] fb: [NOFB], visible: no
<7> [271.775972] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [PLANE:53:plane 3A] fb: [NOFB], visible: no
<7> [271.776049] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [PLANE:63:plane 4A] fb: [NOFB], visible: no
<7> [271.776125] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [PLANE:73:plane 5A] fb: [NOFB], visible: no
<7> [271.776202] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [PLANE:83:cursor A] fb: [NOFB], visible: no
<7> [271.776306] xe 0000:00:02.0: [drm:icp_irq_handler [xe]] hotplug event received, stat 0x00010000, dig 0x0000000a, pins 0x00000010, long 0x00000010
<7> [271.776384] xe 0000:00:02.0: [drm:intel_hpd_irq_handler [xe]] digital hpd on [ENCODER:210:DDI A/PHY A] - long
<7> [271.776460] xe 0000:00:02.0: [drm:intel_hpd_irq_handler [xe]] Received HPD interrupt on PIN 4 - cnt: 10
<7> [271.776552] xe 0000:00:02.0: [drm:intel_dp_hpd_pulse [xe]] ignoring long hpd on eDP [ENCODER:210:DDI A/PHY A]
<7> [271.776876] xe 0000:00:02.0: [drm:intel_power_well_enable [xe]] enabling PW_A
<7> [271.777032] 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> [271.777136] xe 0000:00:02.0: [drm:intel_dbuf_mdclk_cdclk_ratio_update [xe]] Updating dbuf ratio to 4 (mbus joined: no)
<7> [271.777230] xe 0000:00:02.0: [drm:intel_audio_cdclk_change_post.part.0 [xe]] aud_ts_cdclk set to M=60, N=480
<7> [271.777321] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:210:DDI A/PHY A]
<7> [271.777392] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:219:DDI TC1/PHY TC1]
<7> [271.777465] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:221:DP-MST A]
<7> [271.777545] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:222:DP-MST B]
<7> [271.777675] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:223:DP-MST C]
<7> [271.777758] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:231:DDI TC2/PHY TC2]
<7> [271.777830] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:233:DP-MST A]
<7> [271.777898] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:234:DP-MST B]
<7> [271.777967] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:235:DP-MST C]
<7> [271.778036] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:239:DDI TC3/PHY TC3]
<7> [271.778100] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:241:DP-MST A]
<7> [271.778163] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:242:DP-MST B]
<7> [271.778224] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:243:DP-MST C]
<7> [271.778311] xe 0000:00:02.0: [drm:gen9_dbuf_slices_update [xe]] Updating dbuf slices to 0xf
<7> [271.778488] xe 0000:00:02.0: [drm:intel_dbuf_mbus_join_update [xe]] Changing mbus joined: no -> yes (pipe: *)
<7> [271.778563] xe 0000:00:02.0: [drm:intel_dbuf_mdclk_cdclk_ratio_update [xe]] Updating dbuf ratio to 8 (mbus joined: yes)
<7> [271.778692] xe 0000:00:02.0: [drm:intel_power_well_enable [xe]] enabling AUX_A
<7> [271.779715] xe 0000:00:02.0: [drm:intel_dpll_enable [xe]] enable DPLL 0 (active 0x1, on? 0) for [CRTC:89:pipe A]
<7> [271.779848] xe 0000:00:02.0: [drm:intel_dpll_enable [xe]] enabling DPLL 0
<7> [271.781554] xe 0000:00:02.0: [drm:intel_pps_on_unlocked [xe]] [ENCODER:210:DDI A/PHY A] PPS 0 turn panel power on
<7> [271.781644] xe 0000:00:02.0: [drm:wait_panel_power_cycle [xe]] [ENCODER:210:DDI A/PHY A] PPS 0 wait for panel power cycle (466 ms remaining)
<7> [272.249865] xe 0000:00:02.0: [drm:wait_panel_status [xe]] [ENCODER:210:DDI A/PHY A] PPS 0 mask: 0xb800000f value: 0x00000000 PP_STATUS: 0x08000001 PP_CONTROL: 0x00000060
<7> [272.341804] xe 0000:00:02.0: [drm:wait_panel_status [xe]] Wait complete
<7> [272.342197] xe 0000:00:02.0: [drm:intel_pps_on_unlocked [xe]] [ENCODER:210:DDI A/PHY A] PPS 0 wait for panel power on
<7> [272.342530] xe 0000:00:02.0: [drm:wait_panel_status [xe]] [ENCODER:210:DDI A/PHY A] PPS 0 mask: 0xb000000f value: 0x80000008 PP_STATUS: 0x9000000a PP_CONTROL: 0x00000063
<7> [272.378421] xe 0000:00:02.0: [drm:icp_irq_handler [xe]] hotplug event received, stat 0x00010000, dig 0x0000000a, pins 0x00000010, long 0x00000010
<7> [272.378790] xe 0000:00:02.0: [drm:intel_hpd_irq_handler [xe]] digital hpd on [ENCODER:210:DDI A/PHY A] - long
<7> [272.379107] xe 0000:00:02.0: [drm:intel_hpd_irq_handler [xe]] Received HPD interrupt on PIN 4 - cnt: 20
<7> [272.379445] xe 0000:00:02.0: [drm:intel_dp_hpd_pulse [xe]] ignoring long hpd on eDP [ENCODER:210:DDI A/PHY A]
<7> [272.426632] 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> [272.426742] 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> [272.426740] 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> [272.552230] xe 0000:00:02.0: [drm:wait_panel_status [xe]] Wait complete
<7> [272.552667] xe 0000:00:02.0: [drm:intel_pps_vdd_on_unlocked [xe]] [ENCODER:210:DDI A/PHY A] PPS 0 turning VDD on
<7> [272.553008] xe 0000:00:02.0: [drm:intel_pps_vdd_on_unlocked [xe]] [ENCODER:210:DDI A/PHY A] PPS 0 PP_STATUS: 0x80000008 PP_CONTROL: 0x0000006b
<7> [272.555073] 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> [272.556385] xe 0000:00:02.0: [drm:intel_dp_start_link_train [xe]] [CONNECTOR:211:eDP-1][ENCODER:210:DDI A/PHY A][DPRX] Reloading eDP link rates
<7> [272.557251] xe 0000:00:02.0: [drm:intel_dp_start_link_train [xe]] [CONNECTOR:211:eDP-1][ENCODER:210:DDI A/PHY A][DPRX] Using LINK_RATE_SET value 05
<7> [272.558368] xe 0000:00:02.0: [drm:intel_dp_set_signal_levels [xe]] [CONNECTOR:211:eDP-1][ENCODER:210:DDI A/PHY A][DPRX] 8b/10b, lanes: 4, vswing levels: 0/0/0/0, pre-emphasis levels: 0/0/0/0
<7> [272.559548] xe 0000:00:02.0: [drm:intel_dp_program_link_training_pattern [xe]] [CONNECTOR:211:eDP-1][ENCODER:210:DDI A/PHY A][DPRX] Using DP training pattern TPS1
<7> [272.560656] xe 0000:00:02.0: [drm:intel_dp_link_train_phy [xe]] [CONNECTOR:211:eDP-1][ENCODER:210:DDI A/PHY A][DPRX] Clock recovery OK
<7> [272.561059] xe 0000:00:02.0: [drm:intel_dp_program_link_training_pattern [xe]] [CONNECTOR:211:eDP-1][ENCODER:210:DDI A/PHY A][DPRX] Using DP training pattern TPS4
<7> [272.562549] xe 0000:00:02.0: [drm:intel_dp_link_train_phy [xe]] [CONNECTOR:211:eDP-1][ENCODER:210:DDI A/PHY A][DPRX] Channel EQ done. DP Training successful
<7> [272.562975] xe 0000:00:02.0: [drm:intel_dp_link_train_phy [xe]] [CONNECTOR:211:eDP-1][ENCODER:210:DDI A/PHY A][DPRX] Link Training passed at link rate = 432000, lane count = 4
<7> [272.563802] xe 0000:00:02.0: [drm:intel_enable_transcoder [xe]] enabling pipe A
<7> [272.564351] xe 0000:00:02.0: [drm:intel_edp_backlight_on [xe]]
<7> [272.564786] xe 0000:00:02.0: [drm:intel_backlight_enable [xe]] pipe A
<7> [272.565196] xe 0000:00:02.0: [drm:intel_backlight_set_pwm_level [xe]] [CONNECTOR:211:eDP-1] set backlight PWM = 4518
<7> [272.581279] xe 0000:00:02.0: [drm:intel_psr_post_plane_update [xe]] Enabling PSR2
<7> [272.583229] xe 0000:00:02.0: [drm:verify_connector_state [xe]] [CONNECTOR:211:eDP-1]
<7> [272.583792] xe 0000:00:02.0: [drm:intel_modeset_verify_crtc [xe]] [CRTC:89:pipe A]
<7> [275.113571] xe 0000:00:02.0: [drm:intel_pps_vdd_off_sync_unlocked [xe]] [ENCODER:210:DDI A/PHY A] PPS 0 turning VDD off
<7> [275.114134] xe 0000:00:02.0: [drm:intel_pps_vdd_off_sync_unlocked [xe]] [ENCODER:210:DDI A/PHY A] PPS 0 PP_STATUS: 0x80000008 PP_CONTROL: 0x00000067
<7> [275.915452] xe 0000:00:02.0: [drm:intel_power_well_disable [xe]] disabling DC_off
<7> [275.915818] xe 0000:00:02.0: [drm:skl_enable_dc6 [xe]] Enabling DC6
<7> [275.916067] xe 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [xe]] Setting DC state from 00 to 02
<6> [275.959722] [IGT] kms_flip: finished subtest A-eDP1, FAIL
<6> [275.962727] [IGT] kms_flip: starting dynamic subtest B-eDP1
<7> [275.979861] xe 0000:00:02.0: [drm:drm_mode_addfb2] [FB:251]
<7> [275.980426] xe 0000:00:02.0: [drm:drm_mode_addfb2] [FB:252]
<7> [276.045515] xe 0000:00:02.0: [drm:drm_mode_setcrtc] [CRTC:89:pipe A]
<7> [276.045663] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:89:pipe A] fastset requirement not met in hw.enable (expected yes, found no)
<7> [276.045824] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:89:pipe A] fastset requirement not met in hw.active (expected yes, found no)
<7> [276.045943] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:89:pipe A] fastset requirement not met in cpu_transcoder (expected 0, found -1)
<7> [276.046055] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:89:pipe A] fastset requirement not met in lane_count (expected 4, found 0)
<7> [276.046162] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:89: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> [276.046268] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:89:pipe A] fastset requirement not met in output_types (expected 0x00000100, found 0x00000000)
<7> [276.046370] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:89:pipe A] fastset requirement not met in framestart_delay (expected 1, found 0)
<7> [276.046497] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:89:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hdisplay (expected 2880, found 0)
<7> [276.046599] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:89:pipe A] fastset requirement not met in hw.pipe_mode.crtc_htotal (expected 3040, found 0)
<7> [276.046698] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:89:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hblank_start (expected 2880, found 0)
<7> [276.046798] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:89:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hblank_end (expected 3040, found 0)
<7> [276.046897] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:89:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hsync_start (expected 2928, found 0)
<7> [276.046995] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:89:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hsync_end (expected 2960, found 0)
<7> [276.047093] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:89:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vdisplay (expected 1800, found 0)
<7> [276.047192] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:89:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vblank_start (expected 1800, found 0)
<7> [276.047290] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:89:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vsync_start (expected 1803, found 0)
<7> [276.047399] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:89:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vsync_end (expected 1809, found 0)
<7> [276.047500] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:89:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vtotal (expected 1906, found 0)
<7> [276.047599] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:89:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vblank_end (expected 1906, found 0)
<7> [276.047696] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:89:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hdisplay (expected 2880, found 0)
<7> [276.047794] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:89:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_htotal (expected 3040, found 0)
<7> [276.047892] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:89:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hblank_start (expected 2880, found 0)
<7> [276.047990] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:89:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hblank_end (expected 3040, found 0)
<7> [276.048088] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:89:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hsync_start (expected 2928, found 0)
<7> [276.048186] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:89:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hsync_end (expected 2960, found 0)
<7> [276.048283] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:89:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vdisplay (expected 1800, found 0)
<7> [276.048380] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:89:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vblank_start (expected 1800, found 0)
<7> [276.048542] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:89:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vsync_start (expected 1803, found 0)
<7> [276.048641] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:89:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vsync_end (expected 1809, found 0)
<7> [276.048738] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:89:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vtotal (expected 1906, found 0)
<7> [276.048835] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:89:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vblank_end (expected 1906, found 0)
<7> [276.048932] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:89:pipe A] fastset requirement not met in pixel_multiplier (expected 1, found 0)
<7> [276.049030] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:89:pipe A] fastset requirement not met in hw.adjusted_mode.flags (2) (expected 2, found 0)
<7> [276.049127] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:89:pipe A] fastset requirement not met in hw.adjusted_mode.flags (8) (expected 8, found 0)
<7> [276.049226] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:89:pipe A] fastset requirement not met in pipe_bpp (expected 30, found 0)
<7> [276.049324] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:89:pipe A] fastset requirement not met in hw.pipe_mode.crtc_clock (expected 347710, found 0)
<7> [276.049429] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:89:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_clock (expected 347710, found 0)
<7> [276.049529] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:89:pipe A] fastset requirement not met in port_clock (expected 432000, found 0)
<7> [276.049629] xe 0000:00:02.0: [drm:intel_atomic_check [xe]] [CRTC:89:pipe A] fastset requirement not met, forcing full modeset
<7> [276.049730] xe 0000:00:02.0: [drm:intel_dpll_crtc_put [xe]] [CRTC:89:pipe A] releasing DPLL 0
<7> [276.049887] xe 0000:00:02.0: [drm:skl_compute_wm [xe]] Enabled dbuf slices 0xf -> 0x1 (total dbuf slices 0xf), mbus joined? yes->no
<7> [276.049974] xe 0000:00:02.0: [drm:skl_compute_wm [xe]] [CRTC:89:pipe A] dbuf slices 0xf -> 0x0, ddb (0 - 4096) -> (0 - 0), active pipes 0x1 -> 0x0
<7> [276.050088] xe 0000:00:02.0: [drm:skl_compute_wm [xe]] [PLANE:33:plane 1A] ddb ( 0 - 4051) -> ( 0 - 0), size 4051 -> 0
<7> [276.050166] xe 0000:00:02.0: [drm:skl_compute_wm [xe]] [PLANE:83:cursor A] ddb (4051 - 4096) -> ( 0 - 0), size 45 -> 0
<7> [276.050241] xe 0000:00:02.0: [drm:skl_print_plane_changes [xe]] [PLANE:33:plane 1A] level *wm0,*wm1,*wm2,*wm3,*wm4,*wm5, wm6, wm7,*twm,*swm,*stwm -> wm0, wm1, wm2, wm3, wm4, wm5, wm6, wm7, twm, swm, stwm
<7> [276.050314] xe 0000:00:02.0: [drm:skl_print_plane_changes [xe]] [PLANE:33: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> [276.050385] xe 0000:00:02.0: [drm:skl_print_plane_changes [xe]] [PLANE:33: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> [276.050462] xe 0000:00:02.0: [drm:skl_print_plane_changes [xe]] [PLANE:33: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> [276.050557] xe 0000:00:02.0: [drm:intel_bw_atomic_check [xe]] [CRTC:89:pipe A] data rate 0 num active planes 0
<7> [276.050673] xe 0000:00:02.0: [drm:intel_bw_atomic_check [xe]] QGV point 0: max bw 23530 required 0 qgv_peak_bw: 38400
<7> [276.050784] xe 0000:00:02.0: [drm:intel_bw_atomic_check [xe]] QGV point 1: max bw 36260 required 0 qgv_peak_bw: 38400
<7> [276.050892] xe 0000:00:02.0: [drm:intel_bw_atomic_check [xe]] QGV point 2: max bw 38000 required 0 qgv_peak_bw: 38400
<7> [276.051000] xe 0000:00:02.0: [drm:intel_bw_atomic_check [xe]] QGV point 3: max bw 38000 required 0 qgv_peak_bw: 38400
<7> [276.051107] xe 0000:00:02.0: [drm:intel_bw_atomic_check [xe]] Matching peaks QGV bw: 38400 for required data rate: 0
<7> [276.051215] xe 0000:00:02.0: [drm:intel_cdclk_atomic_check [xe]] [CRTC:89:pipe A] min cdclk: 173855 kHz -> 0 kHz
<7> [276.051345] xe 0000:00:02.0: [drm:intel_cdclk_update_dbuf_bw_min_cdclk [xe]] dbuf bandwidth min cdclk: 21732 kHz -> 0 kHz
<7> [276.051742] xe 0000:00:02.0: [drm:intel_cdclk_atomic_check [xe]] Can change cdclk via squashing
<7> [276.051861] xe 0000:00:02.0: [drm:intel_cdclk_atomic_check [xe]] New cdclk calculated to be logical 153600 kHz, actual 153600 kHz
<7> [276.051966] xe 0000:00:02.0: [drm:intel_cdclk_atomic_check [xe]] New voltage level calculated to be logical 0, actual 0
<7> [276.052117] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [CRTC:89:pipe A] enable: no [modeset]
<7> [276.052227] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [PLANE:33:plane 1A] fb: [NOFB], visible: no
<7> [276.052334] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [PLANE:43:plane 2A] fb: [NOFB], visible: no
<7> [276.052451] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [PLANE:53:plane 3A] fb: [NOFB], visible: no
<7> [276.052561] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [PLANE:63:plane 4A] fb: [NOFB], visible: no
<7> [276.052668] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [PLANE:73:plane 5A] fb: [NOFB], visible: no
<7> [276.052771] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [PLANE:83:cursor A] fb: [NOFB], visible: no
<7> [276.052971] xe 0000:00:02.0: [drm:intel_power_well_enable [xe]] enabling DC_off
<7> [276.053103] xe 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [xe]] Setting DC state from 02 to 00
<7> [276.053283] xe 0000:00:02.0: [drm:intel_psr_disable_locked [xe]] Disabling PSR2
<7> [276.053493] xe 0000:00:02.0: [drm:intel_pps_vdd_on_unlocked [xe]] [ENCODER:210:DDI A/PHY A] PPS 0 turning VDD on
<7> [276.053639] xe 0000:00:02.0: [drm:intel_pps_vdd_on_unlocked [xe]] [ENCODER:210:DDI A/PHY A] PPS 0 PP_STATUS: 0x80000008 PP_CONTROL: 0x0000006f
<7> [276.054290] xe 0000:00:02.0: [drm:intel_alpm_disable [xe]] Disabling ALPM
<7> [276.054424] xe 0000:00:02.0: [drm:intel_edp_backlight_off [xe]]
<7> [276.257503] xe 0000:00:02.0: [drm:intel_backlight_set_pwm_level [xe]] [CONNECTOR:211:eDP-1] set backlight PWM = 0
<7> [276.258812] xe 0000:00:02.0: [drm:intel_disable_transcoder [xe]] disabling pipe A
<7> [276.280285] xe 0000:00:02.0: [drm:intel_pps_off_unlocked [xe]] [ENCODER:210:DDI A/PHY A] PPS 0 turn panel power off
<7> [276.280655] xe 0000:00:02.0: [drm:icp_irq_handler [xe]] hotplug event received, stat 0x00010000, dig 0x00000009, pins 0x00000010, long 0x00000000
<7> [276.280918] xe 0000:00:02.0: [drm:intel_pps_off_unlocked [xe]] [ENCODER:210:DDI A/PHY A] PPS 0 wait for panel power off time
<7> [276.281146] xe 0000:00:02.0: [drm:intel_hpd_irq_handler [xe]] digital hpd on [ENCODER:210:DDI A/PHY A] - short
<7> [276.281510] xe 0000:00:02.0: [drm:wait_panel_status [xe]] [ENCODER:210:DDI A/PHY A] PPS 0 mask: 0xb0000000 value: 0x00000000 PP_STATUS: 0xa0000002 PP_CONTROL: 0x00000060
<7> [276.333182] xe 0000:00:02.0: [drm:icp_irq_handler [xe]] hotplug event received, stat 0x00010000, dig 0x00000009, pins 0x00000010, long 0x00000000
<7> [276.333586] xe 0000:00:02.0: [drm:intel_hpd_irq_handler [xe]] digital hpd on [ENCODER:210:DDI A/PHY A] - short
<7> [276.342308] xe 0000:00:02.0: [drm:wait_panel_status [xe]] Wait complete
<7> [276.342741] xe 0000:00:02.0: [drm:intel_dpll_disable [xe]] disable DPLL 0 (active 0x1, on? 1) for [CRTC:89:pipe A]
<7> [276.342788] xe 0000:00:02.0: [drm:intel_dp_hpd_pulse [xe]] ignoring short hpd on eDP [ENCODER:210:DDI A/PHY A]
<7> [276.343322] xe 0000:00:02.0: [drm:intel_dp_hpd_pulse [xe]] ignoring short hpd on eDP [ENCODER:210:DDI A/PHY A]
<7> [276.344102] xe 0000:00:02.0: [drm:intel_dpll_disable [xe]] disabling DPLL 0
<7> [276.344645] xe 0000:00:02.0: [drm:intel_power_well_disable [xe]] disabling AUX_A
<7> [276.345223] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:210:DDI A/PHY A]
<7> [276.345638] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:219:DDI TC1/PHY TC1]
<7> [276.346000] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:221:DP-MST A]
<7> [276.346352] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:222:DP-MST B]
<7> [276.346725] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:223:DP-MST C]
<7> [276.347076] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:231:DDI TC2/PHY TC2]
<7> [276.347443] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:233:DP-MST A]
<7> [276.347792] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:234:DP-MST B]
<7> [276.348140] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:235:DP-MST C]
<7> [276.348517] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:239:DDI TC3/PHY TC3]
<7> [276.348877] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:241:DP-MST A]
<7> [276.349224] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:242:DP-MST B]
<7> [276.349595] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:243:DP-MST C]
<7> [276.349945] xe 0000:00:02.0: [drm:verify_connector_state [xe]] [CONNECTOR:211:eDP-1]
<7> [276.350406] xe 0000:00:02.0: [drm:intel_dbuf_mdclk_cdclk_ratio_update [xe]] Updating dbuf ratio to 4 (mbus joined: no)
<7> [276.350745] xe 0000:00:02.0: [drm:intel_dbuf_mbus_join_update [xe]] Changing mbus joined: yes -> no (pipe: *)
<7> [276.351074] xe 0000:00:02.0: [drm:gen9_dbuf_slices_update [xe]] Updating dbuf slices to 0x1
<7> [276.351660] xe 0000:00:02.0: [drm:intel_power_well_disable [xe]] disabling PW_A
<7> [276.352225] xe 0000:00:02.0: [drm:intel_modeset_verify_crtc [xe]] [CRTC:89:pipe A]
<7> [276.352671] 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> [276.353201] xe 0000:00:02.0: [drm:intel_dbuf_mdclk_cdclk_ratio_update [xe]] Updating dbuf ratio to 4 (mbus joined: no)
<7> [276.353593] xe 0000:00:02.0: [drm:intel_audio_cdclk_change_post.part.0 [xe]] aud_ts_cdclk set to M=60, N=384
<7> [276.354978] xe 0000:00:02.0: [drm:drm_mode_setcrtc] [CRTC:148:pipe B]
<7> [276.355521] xe 0000:00:02.0: [drm:drm_mode_setcrtc] [CRTC:207:pipe C]
<7> [276.355845] xe 0000:00:02.0: [drm:drm_mode_setcrtc] [CRTC:148:pipe B]
<7> [276.355918] xe 0000:00:02.0: [drm:drm_mode_setcrtc] [CONNECTOR:211:eDP-1]
<7> [276.356114] xe 0000:00:02.0: [drm:intel_atomic_check [xe]] [CONNECTOR:211:eDP-1] Limiting display bpp to 30 (EDID bpp 30, max requested bpp 36, max platform bpp 36)
<7> [276.356642] xe 0000:00:02.0: [drm:intel_dp_compute_config_limits [xe]] [ENCODER:210:DDI A/PHY A][CRTC:148:pipe B] DP link limits: pixel clock 347710 kHz DSC off max lanes 4 max rate 810000 max pipe_bpp 30 max link_bpp 30.0000
<7> [276.357056] xe 0000:00:02.0: [drm:intel_dp_compute_link_config [xe]] DP lane count 4 clock 432000 bpp input 30 compressed 0.0000 link rate required 1303913 available 1728000
<7> [276.357487] xe 0000:00:02.0: [drm:intel_atomic_check [xe]] [CRTC:148:pipe B] hw max bpp: 30, pipe bpp: 30, dithering: 0
<7> [276.357848] xe 0000:00:02.0: [drm:intel_ddi_compute_config_late [xe]] [ENCODER:210:DDI A/PHY A] [CRTC:148:pipe B]
<7> [276.358190] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:148:pipe B] fastset requirement not met in hw.enable (expected no, found yes)
<7> [276.358552] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:148:pipe B] fastset requirement not met in hw.active (expected no, found yes)
<7> [276.358884] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:148:pipe B] fastset requirement not met in cpu_transcoder (expected -1, found 1)
<7> [276.359178] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:148:pipe B] fastset requirement not met in lane_count (expected 0, found 4)
<7> [276.359471] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:148:pipe B] fastset requirement not met in dp_m_n (expected tu 0 data 0/0 link 0/0, found tu 64, data 6329869/8388608 link 421991/524288)
<7> [276.359760] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:148:pipe B] fastset requirement not met in output_types (expected 0x00000000, found 0x00000100)
<7> [276.360011] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:148:pipe B] fastset requirement not met in framestart_delay (expected 0, found 1)
<7> [276.360248] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:148:pipe B] fastset requirement not met in hw.pipe_mode.crtc_hdisplay (expected 0, found 2880)
<7> [276.360534] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:148:pipe B] fastset requirement not met in hw.pipe_mode.crtc_htotal (expected 0, found 3040)
<7> [276.360760] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:148:pipe B] fastset requirement not met in hw.pipe_mode.crtc_hblank_start (expected 0, found 2880)
<7> [276.360974] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:148:pipe B] fastset requirement not met in hw.pipe_mode.crtc_hblank_end (expected 0, found 3040)
<7> [276.361207] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:148:pipe B] fastset requirement not met in hw.pipe_mode.crtc_hsync_start (expected 0, found 2928)
<7> [276.361427] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:148:pipe B] fastset requirement not met in hw.pipe_mode.crtc_hsync_end (expected 0, found 2960)
<7> [276.361613] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:148:pipe B] fastset requirement not met in hw.pipe_mode.crtc_vdisplay (expected 0, found 1800)
<7> [276.361795] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:148:pipe B] fastset requirement not met in hw.pipe_mode.crtc_vblank_start (expected 0, found 1800)
<7> [276.361997] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:148:pipe B] fastset requirement not met in hw.pipe_mode.crtc_vsync_start (expected 0, found 1803)
<7> [276.362168] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:148:pipe B] fastset requirement not met in hw.pipe_mode.crtc_vsync_end (expected 0, found 1809)
<7> [276.362327] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:148:pipe B] fastset requirement not met in hw.pipe_mode.crtc_vtotal (expected 0, found 1906)
<7> [276.362501] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:148:pipe B] fastset requirement not met in hw.pipe_mode.crtc_vblank_end (expected 0, found 1906)
<7> [276.362652] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:148:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_hdisplay (expected 0, found 2880)
<7> [276.362811] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:148:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_htotal (expected 0, found 3040)
<7> [276.362953] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:148:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_hblank_start (expected 0, found 2880)
<7> [276.363091] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:148:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_hblank_end (expected 0, found 3040)
<7> [276.363245] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:148:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_hsync_start (expected 0, found 2928)
<7> [276.363399] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:148:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_hsync_end (expected 0, found 2960)
<7> [276.363531] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:148:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_vdisplay (expected 0, found 1800)
<7> [276.363658] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:148:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_vblank_start (expected 0, found 1800)
<7> [276.363784] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:148:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_vsync_start (expected 0, found 1803)
<7> [276.363904] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:148:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_vsync_end (expected 0, found 1809)
<7> [276.364022] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:148:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_vtotal (expected 0, found 1906)
<7> [276.364150] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:148:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_vblank_end (expected 0, found 1906)
<7> [276.364284] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:148:pipe B] fastset requirement not met in pixel_multiplier (expected 0, found 1)
<7> [276.364412] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:148:pipe B] fastset requirement not met in hw.adjusted_mode.flags (2) (expected 0, found 2)
<7> [276.364524] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:148:pipe B] fastset requirement not met in hw.adjusted_mode.flags (8) (expected 0, found 8)
<7> [276.364637] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:148:pipe B] fastset requirement not met in pipe_bpp (expected 0, found 30)
<7> [276.364746] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:148:pipe B] fastset requirement not met in hw.pipe_mode.crtc_clock (expected 0, found 347710)
<7> [276.364850] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:148:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_clock (expected 0, found 347710)
<7> [276.364952] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:148:pipe B] fastset requirement not met in port_clock (expected 0, found 432000)
<7> [276.365053] xe 0000:00:02.0: [drm:intel_atomic_check [xe]] [CRTC:148:pipe B] fastset requirement not met, forcing full modeset
<7> [276.365204] xe 0000:00:02.0: [drm:skl_compute_wm [xe]] Enabled dbuf slices 0x1 -> 0xf (total dbuf slices 0xf), mbus joined? no->yes
<7> [276.365298] xe 0000:00:02.0: [drm:skl_compute_wm [xe]] [CRTC:148:pipe B] dbuf slices 0x0 -> 0xf, ddb (0 - 0) -> (0 - 4096), active pipes 0x0 -> 0x2
<7> [276.365425] xe 0000:00:02.0: [drm:skl_compute_wm [xe]] [PLANE:92:plane 1B] ddb ( 0 - 0) -> ( 0 - 4051), size 0 -> 4051
<7> [276.365517] xe 0000:00:02.0: [drm:skl_compute_wm [xe]] [PLANE:142:cursor B] ddb ( 0 - 0) -> (4051 - 4096), size 0 -> 45
<7> [276.365597] xe 0000:00:02.0: [drm:skl_print_plane_changes [xe]] [PLANE:92:plane 1B] level wm0, wm1, wm2, wm3, wm4, wm5, wm6, wm7, twm, swm, stwm -> *wm0,*wm1,*wm2,*wm3,*wm4,*wm5, wm6, wm7,*twm,*swm,*stwm
<7> [276.365675] xe 0000:00:02.0: [drm:skl_print_plane_changes [xe]] [PLANE:92:plane 1B] lines 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0 -> 4, 13, 13, 13, 13, 13, 0, 0, 0, 4, 0
<7> [276.365751] xe 0000:00:02.0: [drm:skl_print_plane_changes [xe]] [PLANE:92:plane 1B] blocks 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0 -> 92, 297, 297, 297, 297, 297, 0, 0, 197, 92, 197
<7> [276.365819] xe 0000:00:02.0: [drm:skl_print_plane_changes [xe]] [PLANE:92:plane 1B] min_ddb 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0 -> 183, 456, 456, 456, 456, 456, 0, 0, 198, 183, 198
<7> [276.365908] xe 0000:00:02.0: [drm:intel_bw_atomic_check [xe]] [CRTC:148:pipe B] data rate 1390840 num active planes 1
<7> [276.366017] xe 0000:00:02.0: [drm:intel_bw_atomic_check [xe]] QGV point 0: max bw 23530 required 1461 qgv_peak_bw: 38400
<7> [276.366125] xe 0000:00:02.0: [drm:intel_bw_atomic_check [xe]] QGV point 1: max bw 36260 required 1461 qgv_peak_bw: 38400
<7> [276.366225] xe 0000:00:02.0: [drm:intel_bw_atomic_check [xe]] QGV point 2: max bw 38000 required 1461 qgv_peak_bw: 38400
<7> [276.366310] xe 0000:00:02.0: [drm:intel_bw_atomic_check [xe]] QGV point 3: max bw 38000 required 1461 qgv_peak_bw: 38400
<7> [276.366402] xe 0000:00:02.0: [drm:intel_bw_atomic_check [xe]] Matching peaks QGV bw: 38400 for required data rate: 1461
<7> [276.366506] xe 0000:00:02.0: [drm:intel_cdclk_atomic_check [xe]] [CRTC:148:pipe B] min cdclk: 0 kHz -> 173855 kHz
<7> [276.366637] xe 0000:00:02.0: [drm:intel_cdclk_update_dbuf_bw_min_cdclk [xe]] dbuf bandwidth min cdclk: 0 kHz -> 21732 kHz
<7> [276.366736] xe 0000:00:02.0: [drm:intel_cdclk_atomic_check [xe]] Can change cdclk via squashing
<7> [276.366817] xe 0000:00:02.0: [drm:intel_cdclk_atomic_check [xe]] New cdclk calculated to be logical 192000 kHz, actual 192000 kHz
<7> [276.366894] xe 0000:00:02.0: [drm:intel_cdclk_atomic_check [xe]] New voltage level calculated to be logical 0, actual 0
<7> [276.366993] xe 0000:00:02.0: [drm:intel_find_dpll [xe]] [CRTC:148:pipe B] allocated DPLL 0
<7> [276.367074] xe 0000:00:02.0: [drm:intel_dpll_crtc_get [xe]] [CRTC:148:pipe B] reserving DPLL 0
<7> [276.367156] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [CRTC:148:pipe B] enable: yes [modeset]
<7> [276.367238] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] active: yes, output_types: EDP (0x100), output format: RGB, sink format: RGB
<7> [276.367318] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] cpu_transcoder: B, pipe bpp: 30, dithering: 0
<7> [276.367405] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] MST master transcoder: <invalid>
<7> [276.367509] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] port sync: master transcoder: <invalid>, slave transcoder bitmask = 0x0
<7> [276.367611] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] joiner: no, pipes: 0x0
<7> [276.367708] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] splitter: disabled, link count 0, overlap 0
<7> [276.367788] 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> [276.367868] 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> [276.367950] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] fec: disabled, enhanced framing: disabled
<7> [276.368032] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] sdp split: disabled
<7> [276.368108] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] psr: enabled, selective update: enabled, panel replay: disabled, selective fetch: enabled
<7> [276.368183] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] minimum HBlank: 0
<7> [276.368257] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] audio: 0, infoframes: 0, infoframes enabled: 0x4
<7> [276.368332] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] DP SDP: VSC, revision 4, length 14
<7> [276.368440] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] pixelformat: RGB
<7> [276.368541] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] colorimetry: sRGB
<7> [276.368637] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] bpc: 0
<7> [276.368725] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] dynamic range: VESA range
<7> [276.368799] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] content type: Not defined
<7> [276.368874] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] scanline offset: 1
<7> [276.368947] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] framestart delay: 1, MSA timing delay: 0, set context latency: 0
<7> [276.369020] 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> [276.369095] 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> [276.369166] 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> [276.369238] 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> [276.369311] 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> [276.369394] 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> [276.369487] 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> [276.369579] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] port clock: 432000, pipe src: 2880x1800+0+0, pixel rate 347710, min cdclk 173855
<7> [276.369671] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] linetime: 70, ips linetime: 0
<7> [276.369770] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] num_scalers: 2, scaler_users: 0x0, scaler_id: -1, scaling_filter: 0
<7> [276.369853] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] pch pfit: 0x0+0+0, disabled, force thru: no
<7> [276.369931] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] ips: 0, double wide: 0, drrs: 0
<7> [276.370007] 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> [276.370082] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] c10pll_hw_state: clock: 432000, fracen: no,
<7> [276.370156] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] multiplier: 225, tx_clk_div: 1.
<7> [276.370231] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] c10pll_rawhw_state:
<7> [276.370304] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] tx: 0x10, cmn: 0x21
<7> [276.370384] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] pll[0] = 0x4, pll[1] = 0x0, pll[2] = 0xa2, pll[3] = 0x1
<7> [276.370477] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] pll[4] = 0x0, pll[5] = 0x0, pll[6] = 0x0, pll[7] = 0x0
<7> [276.370571] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] pll[8] = 0x0, pll[9] = 0x1, pll[10] = 0x0, pll[11] = 0x0
<7> [276.370664] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] pll[12] = 0x0, pll[13] = 0x0, pll[14] = 0x0, pll[15] = 0x1
<7> [276.370750] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] pll[16] = 0x85, pll[17] = 0xf, pll[18] = 0xe6, pll[19] = 0x23
<7> [276.370827] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] csc_mode: 0x0 gamma_mode: 0x0 gamma_enable: 0 csc_enable: 0
<7> [276.370900] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] pre csc lut: 0 entries, post csc lut: 0 entries
<7> [276.370971] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] output csc: pre offsets: 0x0000 0x0000 0x0000
<7> [276.371043] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] output csc: coefficients: 0x0000 0x0000 0x0000
<7> [276.371115] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] output csc: coefficients: 0x0000 0x0000 0x0000
<7> [276.371187] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] output csc: coefficients: 0x0000 0x0000 0x0000
<7> [276.371257] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] output csc: post offsets: 0x0000 0x0000 0x0000
<7> [276.371328] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] pipe csc: pre offsets: 0x0000 0x0000 0x0000
<7> [276.371413] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] pipe csc: coefficients: 0x0000 0x0000 0x0000
<7> [276.371532] xe 0000:00:02.0: [drm:icp_irq_handler [xe]] hotplug event received, stat 0x00010000, dig 0x0000000a, pins 0x00000010, long 0x00000010
<7> [276.371629] xe 0000:00:02.0: [drm:intel_hpd_irq_handler [xe]] digital hpd on [ENCODER:210:DDI A/PHY A] - long
<7> [276.371718] xe 0000:00:02.0: [drm:intel_hpd_irq_handler [xe]] Received HPD interrupt on PIN 4 - cnt: 10
<7> [276.371803] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] pipe csc: coefficients: 0x0000 0x0000 0x0000
<7> [276.371839] xe 0000:00:02.0: [drm:intel_dp_hpd_pulse [xe]] ignoring long hpd on eDP [ENCODER:210:DDI A/PHY A]
<7> [276.371908] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] pipe csc: coefficients: 0x0000 0x0000 0x0000
<7> [276.372002] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] pipe csc: post offsets: 0x0000 0x0000 0x0000
<7> [276.372086] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] sharpness strength: 0, sharpness tap size: 0, sharpness enable: 0
<7> [276.372170] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [PLANE:92:plane 1B] fb: [FB:251] 2880x1800 format = XR24 little-endian (0x34325258) modifier = 0x100000000000009, visible: yes
<7> [276.372247] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] rotation: 0x1, scaler: -1, scaling_filter: 0
<7> [276.372323] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] src: 2880.000000x1800.000000+0.000000+0.000000 dst: 2880x1800+0+0
<7> [276.372411] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [PLANE:102:plane 2B] fb: [NOFB], visible: no
<7> [276.372510] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [PLANE:112:plane 3B] fb: [NOFB], visible: no
<7> [276.372606] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [PLANE:122:plane 4B] fb: [NOFB], visible: no
<7> [276.372697] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [PLANE:132:plane 5B] fb: [NOFB], visible: no
<7> [276.372772] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [PLANE:142:cursor B] fb: [NOFB], visible: no
<7> [276.373176] xe 0000:00:02.0: [drm:intel_power_well_enable [xe]] enabling PW_2
<7> [276.373314] xe 0000:00:02.0: [drm:intel_power_well_enable [xe]] enabling PW_B
<7> [276.373472] 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> [276.373596] xe 0000:00:02.0: [drm:intel_dbuf_mdclk_cdclk_ratio_update [xe]] Updating dbuf ratio to 4 (mbus joined: no)
<7> [276.373707] xe 0000:00:02.0: [drm:intel_audio_cdclk_change_post.part.0 [xe]] aud_ts_cdclk set to M=60, N=480
<7> [276.373807] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:210:DDI A/PHY A]
<7> [276.373883] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:219:DDI TC1/PHY TC1]
<7> [276.373953] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:221:DP-MST A]
<7> [276.374021] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:222:DP-MST B]
<7> [276.374088] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:223:DP-MST C]
<7> [276.374154] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:231:DDI TC2/PHY TC2]
<7> [276.374219] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:233:DP-MST A]
<7> [276.374283] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:234:DP-MST B]
<7> [276.374346] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:235:DP-MST C]
<7> [276.374424] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:239:DDI TC3/PHY TC3]
<7> [276.374507] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:241:DP-MST A]
<7> [276.374587] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:242:DP-MST B]
<7> [276.374670] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:243:DP-MST C]
<7> [276.374774] xe 0000:00:02.0: [drm:gen9_dbuf_slices_update [xe]] Updating dbuf slices to 0xf
<7> [276.374935] xe 0000:00:02.0: [drm:intel_dbuf_mbus_join_update [xe]] Changing mbus joined: no -> yes (pipe: *)
<7> [276.375001] xe 0000:00:02.0: [drm:intel_dbuf_mdclk_cdclk_ratio_update [xe]] Updating dbuf ratio to 8 (mbus joined: yes)
<7> [276.375113] xe 0000:00:02.0: [drm:intel_power_well_enable [xe]] enabling AUX_A
<7> [276.376410] xe 0000:00:02.0: [drm:intel_dpll_enable [xe]] enable DPLL 0 (active 0x2, on? 0) for [CRTC:148:pipe B]
<7> [276.376528] xe 0000:00:02.0: [drm:intel_dpll_enable [xe]] enabling DPLL 0
<7> [276.378275] xe 0000:00:02.0: [drm:intel_pps_on_unlocked [xe]] [ENCODER:210:DDI A/PHY A] PPS 0 turn panel power on
<7> [276.378347] xe 0000:00:02.0: [drm:wait_panel_power_cycle [xe]] [ENCODER:210:DDI A/PHY A] PPS 0 wait for panel power cycle (465 ms remaining)
<7> [276.849462] xe 0000:00:02.0: [drm:wait_panel_status [xe]] [ENCODER:210:DDI A/PHY A] PPS 0 mask: 0xb800000f value: 0x00000000 PP_STATUS: 0x08000001 PP_CONTROL: 0x00000060
<7> [276.899413] xe 0000:00:02.0: [drm:wait_panel_status [xe]] Wait complete
<7> [276.899891] xe 0000:00:02.0: [drm:intel_pps_on_unlocked [xe]] [ENCODER:210:DDI A/PHY A] PPS 0 wait for panel power on
<7> [276.900324] xe 0000:00:02.0: [drm:wait_panel_status [xe]] [ENCODER:210:DDI A/PHY A] PPS 0 mask: 0xb000000f value: 0x80000008 PP_STATUS: 0x9000000a PP_CONTROL: 0x00000063
<7> [276.936049] xe 0000:00:02.0: [drm:icp_irq_handler [xe]] hotplug event received, stat 0x00010000, dig 0x0000000a, pins 0x00000010, long 0x00000010
<7> [276.936556] xe 0000:00:02.0: [drm:intel_hpd_irq_handler [xe]] digital hpd on [ENCODER:210:DDI A/PHY A] - long
<7> [276.936974] xe 0000:00:02.0: [drm:intel_hpd_irq_handler [xe]] Received HPD interrupt on PIN 4 - cnt: 20
<7> [276.937505] xe 0000:00:02.0: [drm:intel_dp_hpd_pulse [xe]] ignoring long hpd on eDP [ENCODER:210:DDI A/PHY A]
<7> [277.110140] xe 0000:00:02.0: [drm:wait_panel_status [xe]] Wait complete
<7> [277.110692] xe 0000:00:02.0: [drm:intel_pps_vdd_on_unlocked [xe]] [ENCODER:210:DDI A/PHY A] PPS 0 turning VDD on
<7> [277.111132] xe 0000:00:02.0: [drm:intel_pps_vdd_on_unlocked [xe]] [ENCODER:210:DDI A/PHY A] PPS 0 PP_STATUS: 0x80000008 PP_CONTROL: 0x0000006b
<7> [277.113361] 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> [277.114706] xe 0000:00:02.0: [drm:intel_dp_start_link_train [xe]] [CONNECTOR:211:eDP-1][ENCODER:210:DDI A/PHY A][DPRX] Reloading eDP link rates
<7> [277.115525] xe 0000:00:02.0: [drm:intel_dp_start_link_train [xe]] [CONNECTOR:211:eDP-1][ENCODER:210:DDI A/PHY A][DPRX] Using LINK_RATE_SET value 05
<7> [277.116785] xe 0000:00:02.0: [drm:intel_dp_set_signal_levels [xe]] [CONNECTOR:211:eDP-1][ENCODER:210:DDI A/PHY A][DPRX] 8b/10b, lanes: 4, vswing levels: 0/0/0/0, pre-emphasis levels: 0/0/0/0
<7> [277.118024] xe 0000:00:02.0: [drm:intel_dp_program_link_training_pattern [xe]] [CONNECTOR:211:eDP-1][ENCODER:210:DDI A/PHY A][DPRX] Using DP training pattern TPS1
<7> [277.119173] xe 0000:00:02.0: [drm:intel_dp_link_train_phy [xe]] [CONNECTOR:211:eDP-1][ENCODER:210:DDI A/PHY A][DPRX] Clock recovery OK
<7> [277.119583] xe 0000:00:02.0: [drm:intel_dp_program_link_training_pattern [xe]] [CONNECTOR:211:eDP-1][ENCODER:210:DDI A/PHY A][DPRX] Using DP training pattern TPS4
<7> [277.121143] xe 0000:00:02.0: [drm:intel_dp_link_train_phy [xe]] [CONNECTOR:211:eDP-1][ENCODER:210:DDI A/PHY A][DPRX] Channel EQ done. DP Training successful
<7> [277.121532] xe 0000:00:02.0: [drm:intel_dp_link_train_phy [xe]] [CONNECTOR:211:eDP-1][ENCODER:210:DDI A/PHY A][DPRX] Link Training passed at link rate = 432000, lane count = 4
<7> [277.122471] xe 0000:00:02.0: [drm:intel_enable_transcoder [xe]] enabling pipe B
<7> [277.123015] xe 0000:00:02.0: [drm:intel_edp_backlight_on [xe]]
<7> [277.123469] xe 0000:00:02.0: [drm:intel_backlight_enable [xe]] pipe B
<7> [277.123928] xe 0000:00:02.0: [drm:intel_backlight_set_pwm_level [xe]] [CONNECTOR:211:eDP-1] set backlight PWM = 4518
<7> [277.139893] xe 0000:00:02.0: [drm:intel_psr_post_plane_update [xe]] Enabling PSR2
<7> [277.141747] xe 0000:00:02.0: [drm:verify_connector_state [xe]] [CONNECTOR:211:eDP-1]
<7> [277.142228] xe 0000:00:02.0: [drm:intel_modeset_verify_crtc [xe]] [CRTC:148:pipe B]
<7> [279.657287] xe 0000:00:02.0: [drm:intel_pps_vdd_off_sync_unlocked [xe]] [ENCODER:210:DDI A/PHY A] PPS 0 turning VDD off
<7> [279.657851] xe 0000:00:02.0: [drm:intel_pps_vdd_off_sync_unlocked [xe]] [ENCODER:210:DDI A/PHY A] PPS 0 PP_STATUS: 0x80000008 PP_CONTROL: 0x00000067
<7> [287.171825] xe 0000:00:02.0: [drm:drm_mode_rmfb_work_fn] Removing [FB:252] from all active usage due to RMFB ioctl
<7> [287.178482] xe 0000:00:02.0: [drm:drm_mode_rmfb_work_fn] Removing [FB:251] from all active usage due to RMFB ioctl
<7> [287.178588] xe 0000:00:02.0: [drm:atomic_remove_fb] Disabling [PLANE:92:plane 1B] because [FB:251] is removed
<7> [287.178721] xe 0000:00:02.0: [drm:skl_compute_wm [xe]] [PLANE:92:plane 1B] ddb ( 0 - 4051) -> ( 0 - 0), size 4051 -> 0
<7> [287.179203] xe 0000:00:02.0: [drm:skl_print_plane_changes [xe]] [PLANE:92:plane 1B] level *wm0,*wm1,*wm2,*wm3,*wm4,*wm5, wm6, wm7,*twm,*swm,*stwm -> wm0, wm1, wm2, wm3, wm4, wm5, wm6, wm7, twm, swm, stwm
<7> [287.179539] xe 0000:00:02.0: [drm:skl_print_plane_changes [xe]] [PLANE:92:plane 1B] lines 4, 13, 13, 13, 13, 13, 0, 0, 0, 4, 0 -> 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0
<7> [287.179842] xe 0000:00:02.0: [drm:skl_print_plane_changes [xe]] [PLANE:92:plane 1B] blocks 92, 297, 297, 297, 297, 297, 0, 0, 197, 92, 197 -> 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0
<7> [287.180149] xe 0000:00:02.0: [drm:skl_print_plane_changes [xe]] [PLANE:92:plane 1B] min_ddb 183, 456, 456, 456, 456, 456, 0, 0, 198, 183, 198 -> 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0
<7> [287.180495] xe 0000:00:02.0: [drm:intel_bw_atomic_check [xe]] [CRTC:148:pipe B] data rate 0 num active planes 0
<7> [287.180950] xe 0000:00:02.0: [drm:intel_bw_atomic_check [xe]] QGV point 0: max bw 23530 required 0 qgv_peak_bw: 38400
<7> [287.181412] xe 0000:00:02.0: [drm:intel_bw_atomic_check [xe]] QGV point 1: max bw 36260 required 0 qgv_peak_bw: 38400
<7> [287.181841] xe 0000:00:02.0: [drm:intel_bw_atomic_check [xe]] QGV point 2: max bw 38000 required 0 qgv_peak_bw: 38400
<7> [287.182310] xe 0000:00:02.0: [drm:intel_bw_atomic_check [xe]] QGV point 3: max bw 38000 required 0 qgv_peak_bw: 38400
<7> [287.182728] xe 0000:00:02.0: [drm:intel_bw_atomic_check [xe]] Matching peaks QGV bw: 38400 for required data rate: 0
<7> [287.183910] xe 0000:00:02.0: [drm:intel_psr_disable_locked [xe]] Disabling PSR2
<7> [287.190135] xe 0000:00:02.0: [drm:intel_pps_vdd_on_unlocked [xe]] [ENCODER:210:DDI A/PHY A] PPS 0 turning VDD on
<7> [287.190524] xe 0000:00:02.0: [drm:intel_pps_vdd_on_unlocked [xe]] [ENCODER:210:DDI A/PHY A] PPS 0 PP_STATUS: 0x80000008 PP_CONTROL: 0x0000006f
<6> [287.207426] [IGT] kms_flip: finished subtest B-eDP1, SUCCESS
<6> [287.210979] [IGT] kms_flip: starting dynamic subtest C-eDP1
<7> [287.253741] xe 0000:00:02.0: [drm:intel_power_well_disable [xe]] disabling DC_off
<7> [287.253880] xe 0000:00:02.0: [drm:skl_enable_dc6 [xe]] Enabling DC6
<7> [287.253983] xe 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [xe]] Setting DC state from 00 to 02
<7> [287.254149] xe 0000:00:02.0: [drm:drm_mode_addfb2] [FB:251]
<7> [287.270695] xe 0000:00:02.0: [drm:drm_mode_addfb2] [FB:252]
<7> [287.327992] xe 0000:00:02.0: [drm:drm_mode_setcrtc] [CRTC:89:pipe A]
<7> [287.328153] xe 0000:00:02.0: [drm:intel_power_well_enable [xe]] enabling DC_off
<7> [287.328312] xe 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [xe]] Setting DC state from 02 to 00
<7> [287.328514] xe 0000:00:02.0: [drm:drm_mode_setcrtc] [CRTC:148:pipe B]
<7> [287.328602] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:148:pipe B] fastset requirement not met in hw.enable (expected yes, found no)
<7> [287.328718] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:148:pipe B] fastset requirement not met in hw.active (expected yes, found no)
<7> [287.328828] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:148:pipe B] fastset requirement not met in cpu_transcoder (expected 1, found -1)
<7> [287.328938] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:148:pipe B] fastset requirement not met in lane_count (expected 4, found 0)
<7> [287.329078] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:148:pipe B] fastset requirement not met in dp_m_n (expected tu 64 data 6329869/8388608 link 421991/524288, found tu 0, data 0/0 link 0/0)
<7> [287.329193] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:148:pipe B] fastset requirement not met in output_types (expected 0x00000100, found 0x00000000)
<7> [287.329298] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:148:pipe B] fastset requirement not met in framestart_delay (expected 1, found 0)
<7> [287.329403] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:148:pipe B] fastset requirement not met in hw.pipe_mode.crtc_hdisplay (expected 2880, found 0)
<7> [287.329504] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:148:pipe B] fastset requirement not met in hw.pipe_mode.crtc_htotal (expected 3040, found 0)
<7> [287.329604] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:148:pipe B] fastset requirement not met in hw.pipe_mode.crtc_hblank_start (expected 2880, found 0)
<7> [287.329704] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:148:pipe B] fastset requirement not met in hw.pipe_mode.crtc_hblank_end (expected 3040, found 0)
<7> [287.329803] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:148:pipe B] fastset requirement not met in hw.pipe_mode.crtc_hsync_start (expected 2928, found 0)
<7> [287.329906] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:148:pipe B] fastset requirement not met in hw.pipe_mode.crtc_hsync_end (expected 2960, found 0)
<7> [287.330010] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:148:pipe B] fastset requirement not met in hw.pipe_mode.crtc_vdisplay (expected 1800, found 0)
<7> [287.330284] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:148:pipe B] fastset requirement not met in hw.pipe_mode.crtc_vblank_start (expected 1800, found 0)
<7> [287.330393] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:148:pipe B] fastset requirement not met in hw.pipe_mode.crtc_vsync_start (expected 1803, found 0)
<7> [287.330494] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:148:pipe B] fastset requirement not met in hw.pipe_mode.crtc_vsync_end (expected 1809, found 0)
<7> [287.330593] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:148:pipe B] fastset requirement not met in hw.pipe_mode.crtc_vtotal (expected 1906, found 0)
<7> [287.330691] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:148:pipe B] fastset requirement not met in hw.pipe_mode.crtc_vblank_end (expected 1906, found 0)
<7> [287.330789] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:148:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_hdisplay (expected 2880, found 0)
<7> [287.330887] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:148:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_htotal (expected 3040, found 0)
<7> [287.330986] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:148:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_hblank_start (expected 2880, found 0)
<7> [287.331105] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:148:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_hblank_end (expected 3040, found 0)
<7> [287.331213] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:148:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_hsync_start (expected 2928, found 0)
<7> [287.331315] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:148:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_hsync_end (expected 2960, found 0)
<7> [287.331415] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:148:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_vdisplay (expected 1800, found 0)
<7> [287.331517] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:148:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_vblank_start (expected 1800, found 0)
<7> [287.331618] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:148:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_vsync_start (expected 1803, found 0)
<7> [287.331717] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:148:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_vsync_end (expected 1809, found 0)
<7> [287.331814] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:148:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_vtotal (expected 1906, found 0)
<7> [287.331911] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:148:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_vblank_end (expected 1906, found 0)
<7> [287.332008] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:148:pipe B] fastset requirement not met in pixel_multiplier (expected 1, found 0)
<7> [287.332114] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:148:pipe B] fastset requirement not met in hw.adjusted_mode.flags (2) (expected 2, found 0)
<7> [287.332217] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:148:pipe B] fastset requirement not met in hw.adjusted_mode.flags (8) (expected 8, found 0)
<7> [287.332320] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:148:pipe B] fastset requirement not met in pipe_bpp (expected 30, found 0)
<7> [287.332422] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:148:pipe B] fastset requirement not met in hw.pipe_mode.crtc_clock (expected 347710, found 0)
<7> [287.332523] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:148:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_clock (expected 347710, found 0)
<7> [287.332626] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:148:pipe B] fastset requirement not met in port_clock (expected 432000, found 0)
<7> [287.332728] xe 0000:00:02.0: [drm:intel_atomic_check [xe]] [CRTC:148:pipe B] fastset requirement not met, forcing full modeset
<7> [287.332830] xe 0000:00:02.0: [drm:intel_dpll_crtc_put [xe]] [CRTC:148:pipe B] releasing DPLL 0
<7> [287.333067] xe 0000:00:02.0: [drm:skl_compute_wm [xe]] Enabled dbuf slices 0xf -> 0x1 (total dbuf slices 0xf), mbus joined? yes->no
<7> [287.333161] xe 0000:00:02.0: [drm:skl_compute_wm [xe]] [CRTC:148:pipe B] dbuf slices 0xf -> 0x0, ddb (0 - 4096) -> (0 - 0), active pipes 0x2 -> 0x0
<7> [287.333269] xe 0000:00:02.0: [drm:skl_compute_wm [xe]] [PLANE:142:cursor B] ddb (4051 - 4096) -> ( 0 - 0), size 45 -> 0
<7> [287.333370] xe 0000:00:02.0: [drm:intel_cdclk_atomic_check [xe]] [CRTC:148:pipe B] min cdclk: 173855 kHz -> 0 kHz
<7> [287.333489] xe 0000:00:02.0: [drm:intel_cdclk_atomic_check [xe]] Can change cdclk via squashing
<7> [287.333604] xe 0000:00:02.0: [drm:intel_cdclk_atomic_check [xe]] New cdclk calculated to be logical 153600 kHz, actual 153600 kHz
<7> [287.333720] xe 0000:00:02.0: [drm:intel_cdclk_atomic_check [xe]] New voltage level calculated to be logical 0, actual 0
<7> [287.333866] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [CRTC:148:pipe B] enable: no [modeset]
<7> [287.333983] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [PLANE:92:plane 1B] fb: [NOFB], visible: no
<7> [287.334240] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [PLANE:102:plane 2B] fb: [NOFB], visible: no
<7> [287.334354] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [PLANE:112:plane 3B] fb: [NOFB], visible: no
<7> [287.334459] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [PLANE:122:plane 4B] fb: [NOFB], visible: no
<7> [287.334563] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [PLANE:132:plane 5B] fb: [NOFB], visible: no
<7> [287.334668] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [PLANE:142:cursor B] fb: [NOFB], visible: no
<7> [287.334992] xe 0000:00:02.0: [drm:intel_alpm_disable [xe]] Disabling ALPM
<7> [287.335123] xe 0000:00:02.0: [drm:intel_edp_backlight_off [xe]]
<7> [287.537095] xe 0000:00:02.0: [drm:intel_backlight_set_pwm_level [xe]] [CONNECTOR:211:eDP-1] set backlight PWM = 0
<7> [287.537785] xe 0000:00:02.0: [drm:intel_disable_transcoder [xe]] disabling pipe B
<7> [287.558876] xe 0000:00:02.0: [drm:intel_pps_off_unlocked [xe]] [ENCODER:210:DDI A/PHY A] PPS 0 turn panel power off
<7> [287.559308] xe 0000:00:02.0: [drm:intel_pps_off_unlocked [xe]] [ENCODER:210:DDI A/PHY A] PPS 0 wait for panel power off time
<7> [287.559656] xe 0000:00:02.0: [drm:wait_panel_status [xe]] [ENCODER:210:DDI A/PHY A] PPS 0 mask: 0xb0000000 value: 0x00000000 PP_STATUS: 0xa0000002 PP_CONTROL: 0x00000060
<7> [287.611709] xe 0000:00:02.0: [drm:icp_irq_handler [xe]] hotplug event received, stat 0x00010000, dig 0x00000009, pins 0x00000010, long 0x00000000
<7> [287.612086] xe 0000:00:02.0: [drm:intel_hpd_irq_handler [xe]] digital hpd on [ENCODER:210:DDI A/PHY A] - short
<7> [287.619197] xe 0000:00:02.0: [drm:wait_panel_status [xe]] Wait complete
<7> [287.619505] xe 0000:00:02.0: [drm:intel_dpll_disable [xe]] disable DPLL 0 (active 0x2, on? 1) for [CRTC:148:pipe B]
<7> [287.619555] xe 0000:00:02.0: [drm:intel_dp_hpd_pulse [xe]] ignoring short hpd on eDP [ENCODER:210:DDI A/PHY A]
<7> [287.620726] xe 0000:00:02.0: [drm:intel_dpll_disable [xe]] disabling DPLL 0
<7> [287.621132] xe 0000:00:02.0: [drm:intel_power_well_disable [xe]] disabling AUX_A
<7> [287.621560] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:210:DDI A/PHY A]
<7> [287.621832] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:219:DDI TC1/PHY TC1]
<7> [287.622103] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:221:DP-MST A]
<7> [287.622341] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:222:DP-MST B]
<7> [287.622572] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:223:DP-MST C]
<7> [287.622808] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:231:DDI TC2/PHY TC2]
<7> [287.623058] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:233:DP-MST A]
<7> [287.623294] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:234:DP-MST B]
<7> [287.623529] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:235:DP-MST C]
<7> [287.623767] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:239:DDI TC3/PHY TC3]
<7> [287.624003] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:241:DP-MST A]
<7> [287.624260] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:242:DP-MST B]
<7> [287.624499] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:243:DP-MST C]
<7> [287.624735] xe 0000:00:02.0: [drm:verify_connector_state [xe]] [CONNECTOR:211:eDP-1]
<7> [287.625080] xe 0000:00:02.0: [drm:intel_dbuf_mdclk_cdclk_ratio_update [xe]] Updating dbuf ratio to 4 (mbus joined: no)
<7> [287.625317] xe 0000:00:02.0: [drm:intel_dbuf_mbus_join_update [xe]] Changing mbus joined: yes -> no (pipe: *)
<7> [287.625542] xe 0000:00:02.0: [drm:gen9_dbuf_slices_update [xe]] Updating dbuf slices to 0x1
<7> [287.625947] xe 0000:00:02.0: [drm:intel_power_well_disable [xe]] disabling PW_B
<7> [287.626317] xe 0000:00:02.0: [drm:intel_power_well_disable [xe]] disabling PW_2
<7> [287.626689] xe 0000:00:02.0: [drm:intel_modeset_verify_crtc [xe]] [CRTC:148:pipe B]
<7> [287.626989] 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> [287.627376] xe 0000:00:02.0: [drm:intel_dbuf_mdclk_cdclk_ratio_update [xe]] Updating dbuf ratio to 4 (mbus joined: no)
<7> [287.627645] xe 0000:00:02.0: [drm:intel_audio_cdclk_change_post.part.0 [xe]] aud_ts_cdclk set to M=60, N=384
<7> [287.628604] xe 0000:00:02.0: [drm:drm_mode_setcrtc] [CRTC:207:pipe C]
<7> [287.629106] xe 0000:00:02.0: [drm:drm_mode_setcrtc] [CRTC:207:pipe C]
<7> [287.629189] xe 0000:00:02.0: [drm:drm_mode_setcrtc] [CONNECTOR:211:eDP-1]
<7> [287.629396] xe 0000:00:02.0: [drm:intel_atomic_check [xe]] [CONNECTOR:211:eDP-1] Limiting display bpp to 30 (EDID bpp 30, max requested bpp 36, max platform bpp 36)
<7> [287.629771] xe 0000:00:02.0: [drm:intel_dp_compute_config_limits [xe]] [ENCODER:210:DDI A/PHY A][CRTC:207:pipe C] DP link limits: pixel clock 347710 kHz DSC off max lanes 4 max rate 810000 max pipe_bpp 30 max link_bpp 30.0000
<7> [287.630089] xe 0000:00:02.0: [drm:intel_dp_compute_link_config [xe]] DP lane count 4 clock 432000 bpp input 30 compressed 0.0000 link rate required 1303913 available 1728000
<7> [287.630383] xe 0000:00:02.0: [drm:intel_psr_compute_config [xe]] PSR2 not supported in transcoder C
<7> [287.630650] xe 0000:00:02.0: [drm:intel_atomic_check [xe]] [CRTC:207:pipe C] hw max bpp: 30, pipe bpp: 30, dithering: 0
<7> [287.630962] xe 0000:00:02.0: [drm:intel_ddi_compute_config_late [xe]] [ENCODER:210:DDI A/PHY A] [CRTC:207:pipe C]
<7> [287.631297] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:207:pipe C] fastset requirement not met in hw.enable (expected no, found yes)
<7> [287.631602] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:207:pipe C] fastset requirement not met in hw.active (expected no, found yes)
<7> [287.631901] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:207:pipe C] fastset requirement not met in cpu_transcoder (expected -1, found 2)
<7> [287.632212] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:207:pipe C] fastset requirement not met in lane_count (expected 0, found 4)
<7> [287.632483] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:207:pipe C] fastset requirement not met in dp_m_n (expected tu 0 data 0/0 link 0/0, found tu 64, data 6329869/8388608 link 421991/524288)
<7> [287.632755] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:207:pipe C] fastset requirement not met in output_types (expected 0x00000000, found 0x00000100)
<7> [287.633030] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:207:pipe C] fastset requirement not met in framestart_delay (expected 0, found 1)
<7> [287.633284] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:207:pipe C] fastset requirement not met in hw.pipe_mode.crtc_hdisplay (expected 0, found 2880)
<7> [287.633536] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:207:pipe C] fastset requirement not met in hw.pipe_mode.crtc_htotal (expected 0, found 3040)
<7> [287.633779] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:207:pipe C] fastset requirement not met in hw.pipe_mode.crtc_hblank_start (expected 0, found 2880)
<7> [287.634012] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:207:pipe C] fastset requirement not met in hw.pipe_mode.crtc_hblank_end (expected 0, found 3040)
<7> [287.634254] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:207:pipe C] fastset requirement not met in hw.pipe_mode.crtc_hsync_start (expected 0, found 2928)
<7> [287.634475] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:207:pipe C] fastset requirement not met in hw.pipe_mode.crtc_hsync_end (expected 0, found 2960)
<7> [287.634694] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:207:pipe C] fastset requirement not met in hw.pipe_mode.crtc_vdisplay (expected 0, found 1800)
<7> [287.634903] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:207:pipe C] fastset requirement not met in hw.pipe_mode.crtc_vblank_start (expected 0, found 1800)
<7> [287.635121] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:207:pipe C] fastset requirement not met in hw.pipe_mode.crtc_vsync_start (expected 0, found 1803)
<7> [287.635321] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:207:pipe C] fastset requirement not met in hw.pipe_mode.crtc_vsync_end (expected 0, found 1809)
<7> [287.635515] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:207:pipe C] fastset requirement not met in hw.pipe_mode.crtc_vtotal (expected 0, found 1906)
<7> [287.635707] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:207:pipe C] fastset requirement not met in hw.pipe_mode.crtc_vblank_end (expected 0, found 1906)
<7> [287.635889] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:207:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_hdisplay (expected 0, found 2880)
<7> [287.636081] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:207:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_htotal (expected 0, found 3040)
<7> [287.636259] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:207:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_hblank_start (expected 0, found 2880)
<7> [287.636435] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:207:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_hblank_end (expected 0, found 3040)
<7> [287.636603] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:207:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_hsync_start (expected 0, found 2928)
<7> [287.636768] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:207:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_hsync_end (expected 0, found 2960)
<7> [287.636928] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:207:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_vdisplay (expected 0, found 1800)
<7> [287.637094] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:207:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_vblank_start (expected 0, found 1800)
<7> [287.637252] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:207:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_vsync_start (expected 0, found 1803)
<7> [287.637406] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:207:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_vsync_end (expected 0, found 1809)
<7> [287.637553] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:207:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_vtotal (expected 0, found 1906)
<7> [287.637699] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:207:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_vblank_end (expected 0, found 1906)
<7> [287.637838] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:207:pipe C] fastset requirement not met in pixel_multiplier (expected 0, found 1)
<7> [287.637976] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:207:pipe C] fastset requirement not met in hw.adjusted_mode.flags (2) (expected 0, found 2)
<7> [287.638180] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:207:pipe C] fastset requirement not met in hw.adjusted_mode.flags (8) (expected 0, found 8)
<7> [287.638323] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:207:pipe C] fastset requirement not met in pipe_bpp (expected 0, found 30)
<7> [287.638453] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:207:pipe C] fastset requirement not met in hw.pipe_mode.crtc_clock (expected 0, found 347710)
<7> [287.638584] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:207:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_clock (expected 0, found 347710)
<7> [287.638713] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:207:pipe C] fastset requirement not met in port_clock (expected 0, found 432000)
<7> [287.638840] xe 0000:00:02.0: [drm:intel_atomic_check [xe]] [CRTC:207:pipe C] fastset requirement not met, forcing full modeset
<7> [287.639004] xe 0000:00:02.0: [drm:skl_compute_wm [xe]] Enabled dbuf slices 0x1 -> 0xd (total dbuf slices 0xf), mbus joined? no->no
<7> [287.639115] xe 0000:00:02.0: [drm:skl_compute_wm [xe]] [CRTC:207:pipe C] dbuf slices 0x0 -> 0xc, ddb (0 - 0) -> (0 - 2048), active pipes 0x0 -> 0x4
<7> [287.639264] xe 0000:00:02.0: [drm:skl_compute_wm [xe]] [PLANE:151:plane 1C] ddb ( 0 - 0) -> ( 0 - 2003), size 0 -> 2003
<7> [287.639356] xe 0000:00:02.0: [drm:skl_compute_wm [xe]] [PLANE:201:cursor C] ddb ( 0 - 0) -> (2003 - 2048), size 0 -> 45
<7> [287.639439] xe 0000:00:02.0: [drm:skl_print_plane_changes [xe]] [PLANE:151:plane 1C] level wm0, wm1, wm2, wm3, wm4, wm5, wm6, wm7, twm, swm, stwm -> *wm0,*wm1,*wm2,*wm3,*wm4,*wm5, wm6, wm7,*twm,*swm,*stwm
<7> [287.639519] xe 0000:00:02.0: [drm:skl_print_plane_changes [xe]] [PLANE:151:plane 1C] lines 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0 -> 4, 13, 13, 13, 13, 13, 0, 0, 0, 4, 0
<7> [287.639598] xe 0000:00:02.0: [drm:skl_print_plane_changes [xe]] [PLANE:151:plane 1C] blocks 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0 -> 92, 297, 297, 297, 297, 297, 0, 0, 197, 92, 197
<7> [287.639676] xe 0000:00:02.0: [drm:skl_print_plane_changes [xe]] [PLANE:151:plane 1C] min_ddb 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0 -> 183, 456, 456, 456, 456, 456, 0, 0, 198, 183, 198
<7> [287.639781] xe 0000:00:02.0: [drm:intel_bw_atomic_check [xe]] [CRTC:207:pipe C] data rate 1390840 num active planes 1
<7> [287.639904] xe 0000:00:02.0: [drm:intel_bw_atomic_check [xe]] QGV point 0: max bw 23530 required 1461 qgv_peak_bw: 38400
<7> [287.640031] xe 0000:00:02.0: [drm:intel_bw_atomic_check [xe]] QGV point 1: max bw 36260 required 1461 qgv_peak_bw: 38400
<7> [287.640148] xe 0000:00:02.0: [drm:intel_bw_atomic_check [xe]] QGV point 2: max bw 38000 required 1461 qgv_peak_bw: 38400
<7> [287.640259] xe 0000:00:02.0: [drm:intel_bw_atomic_check [xe]] QGV point 3: max bw 38000 required 1461 qgv_peak_bw: 38400
<7> [287.640369] xe 0000:00:02.0: [drm:intel_bw_atomic_check [xe]] Matching peaks QGV bw: 38400 for required data rate: 1461
<7> [287.640511] xe 0000:00:02.0: [drm:intel_cdclk_atomic_check [xe]] [CRTC:207:pipe C] min cdclk: 0 kHz -> 173855 kHz
<7> [287.640655] xe 0000:00:02.0: [drm:intel_cdclk_atomic_check [xe]] Can change cdclk via squashing
<7> [287.640762] xe 0000:00:02.0: [drm:intel_cdclk_atomic_check [xe]] New cdclk calculated to be logical 192000 kHz, actual 192000 kHz
<7> [287.640868] xe 0000:00:02.0: [drm:intel_cdclk_atomic_check [xe]] New voltage level calculated to be logical 0, actual 0
<7> [287.641002] xe 0000:00:02.0: [drm:intel_find_dpll [xe]] [CRTC:207:pipe C] allocated DPLL 0
<7> [287.641118] xe 0000:00:02.0: [drm:intel_dpll_crtc_get [xe]] [CRTC:207:pipe C] reserving DPLL 0
<7> [287.641227] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [CRTC:207:pipe C] enable: yes [modeset]
<7> [287.641343] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] active: yes, output_types: EDP (0x100), output format: RGB, sink format: RGB
<7> [287.641453] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] cpu_transcoder: C, pipe bpp: 30, dithering: 0
<7> [287.641561] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] MST master transcoder: <invalid>
<7> [287.641666] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] port sync: master transcoder: <invalid>, slave transcoder bitmask = 0x0
<7> [287.641772] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] joiner: no, pipes: 0x0
<7> [287.641878] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] splitter: disabled, link count 0, overlap 0
<7> [287.641984] 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> [287.642101] 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> [287.642211] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] fec: disabled, enhanced framing: disabled
<7> [287.642319] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] sdp split: disabled
<7> [287.642426] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] psr: enabled, selective update: disabled, panel replay: disabled, selective fetch: disabled
<7> [287.642532] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] minimum HBlank: 0
<7> [287.642636] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] audio: 0, infoframes: 0, infoframes enabled: 0x4
<7> [287.642742] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] DP SDP: VSC, revision 2, length 8
<7> [287.642847] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] pixelformat: RGB
<7> [287.642954] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] colorimetry: sRGB
<7> [287.643070] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] bpc: 0
<7> [287.643181] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] dynamic range: VESA range
<7> [287.643288] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] content type: Not defined
<7> [287.643394] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] scanline offset: 1
<7> [287.643498] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] framestart delay: 1, MSA timing delay: 0, set context latency: 0
<7> [287.643604] 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> [287.643710] 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> [287.643814] 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> [287.643920] 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> [287.644037] 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> [287.644148] 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> [287.644254] 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> [287.644362] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] port clock: 432000, pipe src: 2880x1800+0+0, pixel rate 347710, min cdclk 173855
<7> [287.644469] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] linetime: 70, ips linetime: 0
<7> [287.644576] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] num_scalers: 2, scaler_users: 0x0, scaler_id: -1, scaling_filter: 0
<7> [287.644682] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] pch pfit: 0x0+0+0, disabled, force thru: no
<7> [287.644787] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] ips: 0, double wide: 0, drrs: 0
<7> [287.644892] 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> [287.644999] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] c10pll_hw_state: clock: 432000, fracen: no,
<7> [287.645115] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] multiplier: 225, tx_clk_div: 1.
<7> [287.645224] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] c10pll_rawhw_state:
<7> [287.645332] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] tx: 0x10, cmn: 0x21
<7> [287.645438] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] pll[0] = 0x4, pll[1] = 0x0, pll[2] = 0xa2, pll[3] = 0x1
<7> [287.645544] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] pll[4] = 0x0, pll[5] = 0x0, pll[6] = 0x0, pll[7] = 0x0
<7> [287.645649] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] pll[8] = 0x0, pll[9] = 0x1, pll[10] = 0x0, pll[11] = 0x0
<7> [287.645754] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] pll[12] = 0x0, pll[13] = 0x0, pll[14] = 0x0, pll[15] = 0x1
<7> [287.645859] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] pll[16] = 0x85, pll[17] = 0xf, pll[18] = 0xe6, pll[19] = 0x23
<7> [287.645964] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] csc_mode: 0x0 gamma_mode: 0x0 gamma_enable: 0 csc_enable: 0
<7> [287.646084] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] pre csc lut: 0 entries, post csc lut: 0 entries
<7> [287.646101] xe 0000:00:02.0: [drm:intel_power_well_disable [xe]] disabling DC_off
<7> [287.646198] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] output csc: pre offsets: 0x0000 0x0000 0x0000
<7> [287.646271] xe 0000:00:02.0: [drm:skl_enable_dc6 [xe]] Enabling DC6
<7> [287.646306] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] output csc: coefficients: 0x0000 0x0000 0x0000
<7> [287.646402] xe 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [xe]] Setting DC state from 00 to 02
<7> [287.646414] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] output csc: coefficients: 0x0000 0x0000 0x0000
<7> [287.646519] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] output csc: coefficients: 0x0000 0x0000 0x0000
<7> [287.646541] xe 0000:00:02.0: [drm:intel_power_well_disable [xe]] disabling always-on
<7> [287.646624] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] output csc: post offsets: 0x0000 0x0000 0x0000
<7> [287.646733] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] pipe csc: pre offsets: 0x0000 0x0000 0x0000
<7> [287.646839] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] pipe csc: coefficients: 0x0000 0x0000 0x0000
<7> [287.646943] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] pipe csc: coefficients: 0x0000 0x0000 0x0000
<7> [287.647052] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] pipe csc: coefficients: 0x0000 0x0000 0x0000
<7> [287.647163] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] pipe csc: post offsets: 0x0000 0x0000 0x0000
<7> [287.647269] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] sharpness strength: 0, sharpness tap size: 0, sharpness enable: 0
<7> [287.647373] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [PLANE:151:plane 1C] fb: [FB:251] 2880x1800 format = XR24 little-endian (0x34325258) modifier = 0x100000000000009, visible: yes
<7> [287.647480] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] rotation: 0x1, scaler: -1, scaling_filter: 0
<7> [287.647583] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] src: 2880.000000x1800.000000+0.000000+0.000000 dst: 2880x1800+0+0
<7> [287.647689] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [PLANE:161:plane 2C] fb: [NOFB], visible: no
<7> [287.647794] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [PLANE:171:plane 3C] fb: [NOFB], visible: no
<7> [287.647899] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [PLANE:181:plane 4C] fb: [NOFB], visible: no
<7> [287.648007] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [PLANE:191:plane 5C] fb: [NOFB], visible: no
<7> [287.648123] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [PLANE:201:cursor C] fb: [NOFB], visible: no
<7> [287.648700] xe 0000:00:02.0: [drm:intel_power_well_enable [xe]] enabling always-on
<7> [287.648832] xe 0000:00:02.0: [drm:intel_power_well_enable [xe]] enabling DC_off
<7> [287.648946] xe 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [xe]] Setting DC state from 02 to 00
<7> [287.649133] xe 0000:00:02.0: [drm:intel_power_well_enable [xe]] enabling PW_2
<7> [287.649312] xe 0000:00:02.0: [drm:intel_power_well_enable [xe]] enabling PW_C
<7> [287.649491] 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> [287.649623] xe 0000:00:02.0: [drm:intel_dbuf_mdclk_cdclk_ratio_update [xe]] Updating dbuf ratio to 4 (mbus joined: no)
<7> [287.649737] xe 0000:00:02.0: [drm:intel_audio_cdclk_change_post.part.0 [xe]] aud_ts_cdclk set to M=60, N=480
<7> [287.649757] xe 0000:00:02.0: [drm:icp_irq_handler [xe]] hotplug event received, stat 0x00010000, dig 0x0000000a, pins 0x00000010, long 0x00000010
<7> [287.649851] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:210:DDI A/PHY A]
<7> [287.649874] xe 0000:00:02.0: [drm:intel_hpd_irq_handler [xe]] digital hpd on [ENCODER:210:DDI A/PHY A] - long
<7> [287.649944] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:219:DDI TC1/PHY TC1]
<7> [287.649968] xe 0000:00:02.0: [drm:intel_hpd_irq_handler [xe]] Received HPD interrupt on PIN 4 - cnt: 10
<7> [287.650041] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:221:DP-MST A]
<7> [287.650088] xe 0000:00:02.0: [drm:intel_dp_hpd_pulse [xe]] ignoring long hpd on eDP [ENCODER:210:DDI A/PHY A]
<7> [287.650138] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:222:DP-MST B]
<7> [287.650253] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:223:DP-MST C]
<7> [287.650352] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:231:DDI TC2/PHY TC2]
<7> [287.650475] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:233:DP-MST A]
<7> [287.650580] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:234:DP-MST B]
<7> [287.650690] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:235:DP-MST C]
<7> [287.650822] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:239:DDI TC3/PHY TC3]
<7> [287.650948] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:241:DP-MST A]
<7> [287.651064] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:242:DP-MST B]
<7> [287.651179] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:243:DP-MST C]
<7> [287.651310] xe 0000:00:02.0: [drm:gen9_dbuf_slices_update [xe]] Updating dbuf slices to 0xd
<7> [287.651536] xe 0000:00:02.0: [drm:intel_dbuf_mdclk_cdclk_ratio_update [xe]] Updating dbuf ratio to 4 (mbus joined: no)
<7> [287.651696] xe 0000:00:02.0: [drm:intel_power_well_enable [xe]] enabling AUX_A
<7> [287.653024] xe 0000:00:02.0: [drm:intel_dpll_enable [xe]] enable DPLL 0 (active 0x4, on? 0) for [CRTC:207:pipe C]
<7> [287.653135] xe 0000:00:02.0: [drm:intel_dpll_enable [xe]] enabling DPLL 0
<7> [287.654844] xe 0000:00:02.0: [drm:intel_pps_on_unlocked [xe]] [ENCODER:210:DDI A/PHY A] PPS 0 turn panel power on
<7> [287.654948] xe 0000:00:02.0: [drm:wait_panel_power_cycle [xe]] [ENCODER:210:DDI A/PHY A] PPS 0 wait for panel power cycle (465 ms remaining)
<7> [288.129105] xe 0000:00:02.0: [drm:wait_panel_status [xe]] [ENCODER:210:DDI A/PHY A] PPS 0 mask: 0xb800000f value: 0x00000000 PP_STATUS: 0x08000001 PP_CONTROL: 0x00000060
<7> [288.229798] xe 0000:00:02.0: [drm:wait_panel_status [xe]] Wait complete
<7> [288.230067] xe 0000:00:02.0: [drm:intel_pps_on_unlocked [xe]] [ENCODER:210:DDI A/PHY A] PPS 0 wait for panel power on
<7> [288.230290] xe 0000:00:02.0: [drm:wait_panel_status [xe]] [ENCODER:210:DDI A/PHY A] PPS 0 mask: 0xb000000f value: 0x80000008 PP_STATUS: 0x9000000a PP_CONTROL: 0x00000063
<7> [288.266263] xe 0000:00:02.0: [drm:icp_irq_handler [xe]] hotplug event received, stat 0x00010000, dig 0x0000000a, pins 0x00000010, long 0x00000010
<7> [288.266623] xe 0000:00:02.0: [drm:intel_hpd_irq_handler [xe]] digital hpd on [ENCODER:210:DDI A/PHY A] - long
<7> [288.266941] xe 0000:00:02.0: [drm:intel_hpd_irq_handler [xe]] Received HPD interrupt on PIN 4 - cnt: 20
<7> [288.267414] xe 0000:00:02.0: [drm:intel_dp_hpd_pulse [xe]] ignoring long hpd on eDP [ENCODER:210:DDI A/PHY A]
<7> [288.441193] xe 0000:00:02.0: [drm:wait_panel_status [xe]] Wait complete
<7> [288.441451] xe 0000:00:02.0: [drm:intel_pps_vdd_on_unlocked [xe]] [ENCODER:210:DDI A/PHY A] PPS 0 turning VDD on
<7> [288.441669] xe 0000:00:02.0: [drm:intel_pps_vdd_on_unlocked [xe]] [ENCODER:210:DDI A/PHY A] PPS 0 PP_STATUS: 0x80000008 PP_CONTROL: 0x0000006b
<7> [288.443650] 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> [288.444946] xe 0000:00:02.0: [drm:intel_dp_start_link_train [xe]] [CONNECTOR:211:eDP-1][ENCODER:210:DDI A/PHY A][DPRX] Reloading eDP link rates
<7> [288.445626] xe 0000:00:02.0: [drm:intel_dp_start_link_train [xe]] [CONNECTOR:211:eDP-1][ENCODER:210:DDI A/PHY A][DPRX] Using LINK_RATE_SET value 05
<7> [288.446618] xe 0000:00:02.0: [drm:intel_dp_set_signal_levels [xe]] [CONNECTOR:211:eDP-1][ENCODER:210:DDI A/PHY A][DPRX] 8b/10b, lanes: 4, vswing levels: 0/0/0/0, pre-emphasis levels: 0/0/0/0
<7> [288.447665] xe 0000:00:02.0: [drm:intel_dp_program_link_training_pattern [xe]] [CONNECTOR:211:eDP-1][ENCODER:210:DDI A/PHY A][DPRX] Using DP training pattern TPS1
<7> [288.448644] xe 0000:00:02.0: [drm:intel_dp_link_train_phy [xe]] [CONNECTOR:211:eDP-1][ENCODER:210:DDI A/PHY A][DPRX] Clock recovery OK
<7> [288.448894] xe 0000:00:02.0: [drm:intel_dp_program_link_training_pattern [xe]] [CONNECTOR:211:eDP-1][ENCODER:210:DDI A/PHY A][DPRX] Using DP training pattern TPS4
<7> [288.450290] xe 0000:00:02.0: [drm:intel_dp_link_train_phy [xe]] [CONNECTOR:211:eDP-1][ENCODER:210:DDI A/PHY A][DPRX] Channel EQ done. DP Training successful
<7> [288.450545] xe 0000:00:02.0: [drm:intel_dp_link_train_phy [xe]] [CONNECTOR:211:eDP-1][ENCODER:210:DDI A/PHY A][DPRX] Link Training passed at link rate = 432000, lane count = 4
<7> [288.451311] xe 0000:00:02.0: [drm:intel_enable_transcoder [xe]] enabling pipe C
<7> [288.451712] xe 0000:00:02.0: [drm:intel_edp_backlight_on [xe]]
<7> [288.451982] xe 0000:00:02.0: [drm:intel_backlight_enable [xe]] pipe C
<7> [288.452335] xe 0000:00:02.0: [drm:intel_backlight_set_pwm_level [xe]] [CONNECTOR:211:eDP-1] set backlight PWM = 4518
<7> [288.453718] xe 0000:00:02.0: [drm:intel_fbc_update [xe]] reserved 14745600 bytes of contiguous stolen space for FBC, limit: 2
<7> [288.454011] xe 0000:00:02.0: [drm:intel_fbc_update [xe]] Enabling FBC on [PLANE:151:plane 1C]
<7> [288.468505] xe 0000:00:02.0: [drm:intel_psr_post_plane_update [xe]] Enabling PSR1
<7> [288.469976] xe 0000:00:02.0: [drm:verify_connector_state [xe]] [CONNECTOR:211:eDP-1]
<7> [288.470425] xe 0000:00:02.0: [drm:intel_modeset_verify_crtc [xe]] [CRTC:207:pipe C]
<7> [290.986014] xe 0000:00:02.0: [drm:intel_pps_vdd_off_sync_unlocked [xe]] [ENCODER:210:DDI A/PHY A] PPS 0 turning VDD off
<7> [290.986550] xe 0000:00:02.0: [drm:intel_pps_vdd_off_sync_unlocked [xe]] [ENCODER:210:DDI A/PHY A] PPS 0 PP_STATUS: 0x80000008 PP_CONTROL: 0x00000067
<7> [298.500386] xe 0000:00:02.0: [drm:drm_mode_rmfb_work_fn] Removing [FB:252] from all active usage due to RMFB ioctl
<7> [298.500629] xe 0000:00:02.0: [drm:drm_mode_rmfb_work_fn] Removing [FB:251] from all active usage due to RMFB ioctl
<7> [298.500702] xe 0000:00:02.0: [drm:atomic_remove_fb] Disabling [PLANE:151:plane 1C] because [FB:251] is removed
<7> [298.500837] xe 0000:00:02.0: [drm:skl_compute_wm [xe]] [PLANE:151:plane 1C] ddb ( 0 - 2003) -> ( 0 - 0), size 2003 -> 0
<7> [298.501338] xe 0000:00:02.0: [drm:skl_print_plane_changes [xe]] [PLANE:151:plane 1C] level *wm0,*wm1,*wm2,*wm3,*wm4,*wm5, wm6, wm7,*twm,*swm,*stwm -> wm0, wm1, wm2, wm3, wm4, wm5, wm6, wm7, twm, swm, stwm
<7> [298.501784] xe 0000:00:02.0: [drm:skl_print_plane_changes [xe]] [PLANE:151:plane 1C] lines 4, 13, 13, 13, 13, 13, 0, 0, 0, 4, 0 -> 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0
<7> [298.502172] xe 0000:00:02.0: [drm:skl_print_plane_changes [xe]] [PLANE:151:plane 1C] blocks 92, 297, 297, 297, 297, 297, 0, 0, 197, 92, 197 -> 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0
<7> [298.502563] xe 0000:00:02.0: [drm:skl_print_plane_changes [xe]] [PLANE:151:plane 1C] min_ddb 183, 456, 456, 456, 456, 456, 0, 0, 198, 183, 198 -> 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0
<7> [298.503069] xe 0000:00:02.0: [drm:intel_bw_atomic_check [xe]] [CRTC:207:pipe C] data rate 0 num active planes 0
<7> [298.503635] xe 0000:00:02.0: [drm:intel_bw_atomic_check [xe]] QGV point 0: max bw 23530 required 0 qgv_peak_bw: 38400
<7> [298.504225] xe 0000:00:02.0: [drm:intel_bw_atomic_check [xe]] QGV point 1: max bw 36260 required 0 qgv_peak_bw: 38400
<7> [298.504745] xe 0000:00:02.0: [drm:intel_bw_atomic_check [xe]] QGV point 2: max bw 38000 required 0 qgv_peak_bw: 38400
<7> [298.505278] xe 0000:00:02.0: [drm:intel_bw_atomic_check [xe]] QGV point 3: max bw 38000 required 0 qgv_peak_bw: 38400
<7> [298.505777] xe 0000:00:02.0: [drm:intel_bw_atomic_check [xe]] Matching peaks QGV bw: 38400 for required data rate: 0
<7> [298.506861] xe 0000:00:02.0: [drm:intel_psr_disable_locked [xe]] Disabling PSR1
<7> [298.507285] xe 0000:00:02.0: [drm:intel_pps_vdd_on_unlocked [xe]] [ENCODER:210:DDI A/PHY A] PPS 0 turning VDD on
<7> [298.507708] xe 0000:00:02.0: [drm:intel_pps_vdd_on_unlocked [xe]] [ENCODER:210:DDI A/PHY A] PPS 0 PP_STATUS: 0x80000008 PP_CONTROL: 0x0000006f
<7> [298.516867] xe 0000:00:02.0: [drm:__intel_fbc_disable [xe]] Disabling FBC on [PLANE:151:plane 1C]
<6> [298.535431] [IGT] kms_flip: finished subtest C-eDP1, SUCCESS
<6> [298.542081] [IGT] kms_flip: finished subtest flip-vs-expired-vblank-interruptible, FAIL
<7> [298.562692] xe 0000:00:02.0: [drm:intel_atomic_check [xe]] [CONNECTOR:211:eDP-1] Limiting display bpp to 30 (EDID bpp 30, max requested bpp 36, max platform bpp 36)
<7> [298.563415] xe 0000:00:02.0: [drm:intel_dp_compute_config_limits [xe]] [ENCODER:210:DDI A/PHY A][CRTC:89:pipe A] DP link limits: pixel clock 347710 kHz DSC off max lanes 4 max rate 810000 max pipe_bpp 30 max link_bpp 30.0000
<7> [298.564028] xe 0000:00:02.0: [drm:intel_dp_compute_link_config [xe]] DP lane count 4 clock 432000 bpp input 30 compressed 0.0000 link rate required 1303913 available 1728000
<7> [298.564551] xe 0000:00:02.0: [drm:intel_atomic_check [xe]] [CRTC:89:pipe A] hw max bpp: 30, pipe bpp: 30, dithering: 0
<7> [298.565080] xe 0000:00:02.0: [drm:intel_ddi_compute_config_late [xe]] [ENCODER:210:DDI A/PHY A] [CRTC:89:pipe A]
<7> [298.565549] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:89:pipe A] fastset requirement not met in hw.enable (expected no, found yes)
<7> [298.566154] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:89:pipe A] fastset requirement not met in hw.active (expected no, found yes)
<7> [298.566512] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:89:pipe A] fastset requirement not met in cpu_transcoder (expected -1, found 0)
<7> [298.566869] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:89:pipe A] fastset requirement not met in lane_count (expected 0, found 4)
<7> [298.567209] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:89: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> [298.567512] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:89:pipe A] fastset requirement not met in output_types (expected 0x00000000, found 0x00000100)
<7> [298.567845] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:89:pipe A] fastset requirement not met in framestart_delay (expected 0, found 1)
<7> [298.568121] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:89:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hdisplay (expected 0, found 2880)
<7> [298.568374] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:89:pipe A] fastset requirement not met in hw.pipe_mode.crtc_htotal (expected 0, found 3040)
<7> [298.568652] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:89:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hblank_start (expected 0, found 2880)
<7> [298.569155] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:89:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hblank_end (expected 0, found 3040)
<7> [298.569376] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:89:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hsync_start (expected 0, found 2928)
<7> [298.569585] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:89:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hsync_end (expected 0, found 2960)
<7> [298.569844] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:89:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vdisplay (expected 0, found 1800)
<7> [298.570041] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:89:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vblank_start (expected 0, found 1800)
<7> [298.570232] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:89:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vsync_start (expected 0, found 1803)
<7> [298.570445] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:89:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vsync_end (expected 0, found 1809)
<7> [298.570651] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:89:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vtotal (expected 0, found 1906)
<7> [298.570888] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:89:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vblank_end (expected 0, found 1906)
<7> [298.571061] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:89:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hdisplay (expected 0, found 2880)
<7> [298.571230] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:89:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_htotal (expected 0, found 3040)
<7> [298.571391] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:89:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hblank_start (expected 0, found 2880)
<7> [298.571545] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:89:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hblank_end (expected 0, found 3040)
<7> [298.571696] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:89:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hsync_start (expected 0, found 2928)
<7> [298.571860] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:89:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hsync_end (expected 0, found 2960)
<7> [298.571999] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:89:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vdisplay (expected 0, found 1800)
<7> [298.572136] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:89:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vblank_start (expected 0, found 1800)
<7> [298.572267] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:89:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vsync_start (expected 0, found 1803)
<7> [298.572395] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:89:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vsync_end (expected 0, found 1809)
<7> [298.572520] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:89:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vtotal (expected 0, found 1906)
<7> [298.572642] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:89:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vblank_end (expected 0, found 1906)
<7> [298.572776] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:89:pipe A] fastset requirement not met in pixel_multiplier (expected 0, found 1)
<7> [298.572893] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:89:pipe A] fastset requirement not met in hw.adjusted_mode.flags (2) (expected 0, found 2)
<7> [298.573005] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:89:pipe A] fastset requirement not met in hw.adjusted_mode.flags (8) (expected 0, found 8)
<7> [298.573116] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:89:pipe A] fastset requirement not met in pipe_bpp (expected 0, found 30)
<7> [298.573222] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:89:pipe A] fastset requirement not met in hw.pipe_mode.crtc_clock (expected 0, found 347710)
<7> [298.573327] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:89:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_clock (expected 0, found 347710)
<7> [298.573429] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:89:pipe A] fastset requirement not met in port_clock (expected 0, found 432000)
<7> [298.573533] xe 0000:00:02.0: [drm:intel_atomic_check [xe]] [CRTC:89:pipe A] fastset requirement not met, forcing full modeset
<7> [298.573636] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:207:pipe C] fastset requirement not met in hw.enable (expected yes, found no)
<7> [298.573736] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:207:pipe C] fastset requirement not met in hw.active (expected yes, found no)
<7> [298.573892] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:207:pipe C] fastset requirement not met in cpu_transcoder (expected 2, found -1)
<7> [298.573995] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:207:pipe C] fastset requirement not met in lane_count (expected 4, found 0)
<7> [298.574093] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:207:pipe C] fastset requirement not met in dp_m_n (expected tu 64 data 6329869/8388608 link 421991/524288, found tu 0, data 0/0 link 0/0)
<7> [298.574189] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:207:pipe C] fastset requirement not met in output_types (expected 0x00000100, found 0x00000000)
<7> [298.574288] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:207:pipe C] fastset requirement not met in framestart_delay (expected 1, found 0)
<7> [298.574387] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:207:pipe C] fastset requirement not met in hw.pipe_mode.crtc_hdisplay (expected 2880, found 0)
<7> [298.574482] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:207:pipe C] fastset requirement not met in hw.pipe_mode.crtc_htotal (expected 3040, found 0)
<7> [298.574568] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:207:pipe C] fastset requirement not met in hw.pipe_mode.crtc_hblank_start (expected 2880, found 0)
<7> [298.574653] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:207:pipe C] fastset requirement not met in hw.pipe_mode.crtc_hblank_end (expected 3040, found 0)
<7> [298.574738] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:207:pipe C] fastset requirement not met in hw.pipe_mode.crtc_hsync_start (expected 2928, found 0)
<7> [298.574870] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:207:pipe C] fastset requirement not met in hw.pipe_mode.crtc_hsync_end (expected 2960, found 0)
<7> [298.574967] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:207:pipe C] fastset requirement not met in hw.pipe_mode.crtc_vdisplay (expected 1800, found 0)
<7> [298.575059] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:207:pipe C] fastset requirement not met in hw.pipe_mode.crtc_vblank_start (expected 1800, found 0)
<7> [298.575136] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:207:pipe C] fastset requirement not met in hw.pipe_mode.crtc_vsync_start (expected 1803, found 0)
<7> [298.575215] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:207:pipe C] fastset requirement not met in hw.pipe_mode.crtc_vsync_end (expected 1809, found 0)
<7> [298.575293] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:207:pipe C] fastset requirement not met in hw.pipe_mode.crtc_vtotal (expected 1906, found 0)
<7> [298.575373] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:207:pipe C] fastset requirement not met in hw.pipe_mode.crtc_vblank_end (expected 1906, found 0)
<7> [298.575447] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:207:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_hdisplay (expected 2880, found 0)
<7> [298.575519] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:207:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_htotal (expected 3040, found 0)
<7> [298.575591] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:207:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_hblank_start (expected 2880, found 0)
<7> [298.575666] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:207:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_hblank_end (expected 3040, found 0)
<7> [298.575745] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:207:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_hsync_start (expected 2928, found 0)
<7> [298.575859] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:207:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_hsync_end (expected 2960, found 0)
<7> [298.575960] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:207:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_vdisplay (expected 1800, found 0)
<7> [298.576059] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:207:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_vblank_start (expected 1800, found 0)
<7> [298.576149] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:207:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_vsync_start (expected 1803, found 0)
<7> [298.576246] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:207:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_vsync_end (expected 1809, found 0)
<7> [298.576344] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:207:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_vtotal (expected 1906, found 0)
<7> [298.576431] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:207:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_vblank_end (expected 1906, found 0)
<7> [298.576512] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:207:pipe C] fastset requirement not met in pixel_multiplier (expected 1, found 0)
<7> [298.576587] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:207:pipe C] fastset requirement not met in hw.adjusted_mode.flags (2) (expected 2, found 0)
<7> [298.576665] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:207:pipe C] fastset requirement not met in hw.adjusted_mode.flags (8) (expected 8, found 0)
<7> [298.576746] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:207:pipe C] fastset requirement not met in pipe_bpp (expected 30, found 0)
<7> [298.576864] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:207:pipe C] fastset requirement not met in hw.pipe_mode.crtc_clock (expected 347710, found 0)
<7> [298.576961] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:207:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_clock (expected 347710, found 0)
<7> [298.577056] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:207:pipe C] fastset requirement not met in port_clock (expected 432000, found 0)
<7> [298.577136] xe 0000:00:02.0: [drm:intel_atomic_check [xe]] [CRTC:207:pipe C] fastset requirement not met, forcing full modeset
<7> [298.577217] xe 0000:00:02.0: [drm:intel_dpll_crtc_put [xe]] [CRTC:207:pipe C] releasing DPLL 0
<7> [298.577444] xe 0000:00:02.0: [drm:skl_compute_wm [xe]] Enabled dbuf slices 0xd -> 0xf (total dbuf slices 0xf), mbus joined? no->yes
<7> [298.577515] xe 0000:00:02.0: [drm:skl_compute_wm [xe]] [CRTC:89:pipe A] dbuf slices 0x0 -> 0xf, ddb (0 - 0) -> (0 - 4096), active pipes 0x4 -> 0x1
<7> [298.577587] xe 0000:00:02.0: [drm:skl_compute_wm [xe]] [CRTC:207:pipe C] dbuf slices 0xc -> 0x0, ddb (0 - 2048) -> (0 - 0), active pipes 0x4 -> 0x1
<7> [298.577660] xe 0000:00:02.0: [drm:skl_compute_wm [xe]] [PLANE:33:plane 1A] ddb ( 0 - 0) -> ( 0 - 4051), size 0 -> 4051
<7> [298.577721] xe 0000:00:02.0: [drm:skl_compute_wm [xe]] [PLANE:83:cursor A] ddb ( 0 - 0) -> (4051 - 4096), size 0 -> 45
<7> [298.577799] xe 0000:00:02.0: [drm:skl_print_plane_changes [xe]] [PLANE:33:plane 1A] level wm0, wm1, wm2, wm3, wm4, wm5, wm6, wm7, twm, swm, stwm -> *wm0,*wm1,*wm2,*wm3,*wm4,*wm5, wm6, wm7,*twm,*swm,*stwm
<7> [298.577877] xe 0000:00:02.0: [drm:skl_print_plane_changes [xe]] [PLANE:33:plane 1A] lines 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0 -> 1, 13, 13, 13, 13, 13, 0, 0, 0, 3, 0
<7> [298.577953] xe 0000:00:02.0: [drm:skl_print_plane_changes [xe]] [PLANE:33:plane 1A] blocks 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0 -> 24, 313, 313, 313, 313, 313, 0, 0, 38, 73, 87
<7> [298.578027] xe 0000:00:02.0: [drm:skl_print_plane_changes [xe]] [PLANE:33:plane 1A] min_ddb 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0 -> 28, 346, 346, 346, 346, 346, 0, 0, 39, 82, 88
<7> [298.578090] xe 0000:00:02.0: [drm:skl_compute_wm [xe]] [PLANE:201:cursor C] ddb (2003 - 2048) -> ( 0 - 0), size 45 -> 0
<7> [298.578165] xe 0000:00:02.0: [drm:intel_bw_atomic_check [xe]] [CRTC:89:pipe A] data rate 1390840 num active planes 1
<7> [298.578249] xe 0000:00:02.0: [drm:intel_bw_atomic_check [xe]] QGV point 0: max bw 23530 required 1461 qgv_peak_bw: 38400
<7> [298.578333] xe 0000:00:02.0: [drm:intel_bw_atomic_check [xe]] QGV point 1: max bw 36260 required 1461 qgv_peak_bw: 38400
<7> [298.578415] xe 0000:00:02.0: [drm:intel_bw_atomic_check [xe]] QGV point 2: max bw 38000 required 1461 qgv_peak_bw: 38400
<7> [298.578496] xe 0000:00:02.0: [drm:intel_bw_atomic_check [xe]] QGV point 3: max bw 38000 required 1461 qgv_peak_bw: 38400
<7> [298.578575] xe 0000:00:02.0: [drm:intel_bw_atomic_check [xe]] Matching peaks QGV bw: 38400 for required data rate: 1461
<7> [298.578655] xe 0000:00:02.0: [drm:intel_cdclk_atomic_check [xe]] [CRTC:89:pipe A] min cdclk: 0 kHz -> 173855 kHz
<7> [298.578736] xe 0000:00:02.0: [drm:intel_cdclk_atomic_check [xe]] [CRTC:207:pipe C] min cdclk: 173855 kHz -> 0 kHz
<7> [298.578902] xe 0000:00:02.0: [drm:intel_find_dpll [xe]] [CRTC:89:pipe A] allocated DPLL 0
<7> [298.579016] xe 0000:00:02.0: [drm:intel_dpll_crtc_get [xe]] [CRTC:89:pipe A] reserving DPLL 0
<7> [298.579116] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [CRTC:89:pipe A] enable: yes [modeset]
<7> [298.579209] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] active: yes, output_types: EDP (0x100), output format: RGB, sink format: RGB
<7> [298.579295] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] cpu_transcoder: A, pipe bpp: 30, dithering: 0
<7> [298.579377] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] MST master transcoder: <invalid>
<7> [298.579460] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] port sync: master transcoder: <invalid>, slave transcoder bitmask = 0x0
<7> [298.579562] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] joiner: no, pipes: 0x0
<7> [298.579663] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] splitter: disabled, link count 0, overlap 0
<7> [298.579764] 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> [298.579867] 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> [298.579969] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] fec: disabled, enhanced framing: disabled
<7> [298.580067] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] sdp split: disabled
<7> [298.580151] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] psr: enabled, selective update: enabled, panel replay: disabled, selective fetch: enabled
<7> [298.580231] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] minimum HBlank: 0
<7> [298.580309] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] audio: 0, infoframes: 0, infoframes enabled: 0x4
<7> [298.580382] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] DP SDP: VSC, revision 4, length 14
<7> [298.580472] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] pixelformat: RGB
<7> [298.580570] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] colorimetry: sRGB
<7> [298.580669] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] bpc: 0
<7> [298.580772] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] dynamic range: VESA range
<7> [298.580873] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] content type: Not defined
<7> [298.580974] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] scanline offset: 1
<7> [298.581070] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] framestart delay: 1, MSA timing delay: 0, set context latency: 0
<7> [298.581153] 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> [298.581234] 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> [298.581310] 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> [298.581392] 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> [298.581474] 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> [298.581556] 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> [298.581629] 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> [298.581703] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] port clock: 432000, pipe src: 2880x1800+0+0, pixel rate 347710, min cdclk 173855
<7> [298.581941] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] linetime: 70, ips linetime: 0
<7> [298.582038] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] num_scalers: 2, scaler_users: 0x0, scaler_id: -1, scaling_filter: 0
<7> [298.582133] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] pch pfit: 0x0+0+0, disabled, force thru: no
<7> [298.582212] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] ips: 0, double wide: 0, drrs: 0
<7> [298.582284] 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> [298.582359] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] c10pll_hw_state: clock: 432000, fracen: no,
<7> [298.582448] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] multiplier: 225, tx_clk_div: 1.
<7> [298.582546] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] c10pll_rawhw_state:
<7> [298.582643] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] tx: 0x10, cmn: 0x21
<7> [298.582721] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] pll[0] = 0x4, pll[1] = 0x0, pll[2] = 0xa2, pll[3] = 0x1
<7> [298.582821] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] pll[4] = 0x0, pll[5] = 0x0, pll[6] = 0x0, pll[7] = 0x0
<7> [298.582920] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] pll[8] = 0x0, pll[9] = 0x1, pll[10] = 0x0, pll[11] = 0x0
<7> [298.583018] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] pll[12] = 0x0, pll[13] = 0x0, pll[14] = 0x0, pll[15] = 0x1
<7> [298.583104] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] pll[16] = 0x85, pll[17] = 0xf, pll[18] = 0xe6, pll[19] = 0x23
<7> [298.583184] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] csc_mode: 0x0 gamma_mode: 0x0 gamma_enable: 0 csc_enable: 0
<7> [298.583257] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] pre csc lut: 0 entries, post csc lut: 0 entries
<7> [298.583335] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] output csc: pre offsets: 0x0000 0x0000 0x0000
<7> [298.583413] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] output csc: coefficients: 0x0000 0x0000 0x0000
<7> [298.583492] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] output csc: coefficients: 0x0000 0x0000 0x0000
<7> [298.583571] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] output csc: coefficients: 0x0000 0x0000 0x0000
<7> [298.583644] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] output csc: post offsets: 0x0000 0x0000 0x0000
<7> [298.583715] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] pipe csc: pre offsets: 0x0000 0x0000 0x0000
<7> [298.583811] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] pipe csc: coefficients: 0x0000 0x0000 0x0000
<7> [298.583906] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] pipe csc: coefficients: 0x0000 0x0000 0x0000
<7> [298.583999] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] pipe csc: coefficients: 0x0000 0x0000 0x0000
<7> [298.584081] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] pipe csc: post offsets: 0x0000 0x0000 0x0000
<7> [298.584152] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] sharpness strength: 0, sharpness tap size: 0, sharpness enable: 0
<7> [298.584232] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [PLANE:33:plane 1A] fb: [FB:212] 2880x1800 format = XR24 little-endian (0x34325258) modifier = 0x0, visible: yes
<7> [298.584326] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] rotation: 0x1, scaler: -1, scaling_filter: 0
<7> [298.584418] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] src: 2880.000000x1800.000000+0.000000+0.000000 dst: 2880x1800+0+0
<7> [298.584505] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [PLANE:43:plane 2A] fb: [NOFB], visible: no
<7> [298.584579] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [PLANE:53:plane 3A] fb: [NOFB], visible: no
<7> [298.584650] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [PLANE:63:plane 4A] fb: [NOFB], visible: no
<7> [298.584720] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [PLANE:73:plane 5A] fb: [NOFB], visible: no
<7> [298.584814] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [PLANE:83:cursor A] fb: [NOFB], visible: no
<7> [298.584913] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [CRTC:207:pipe C] enable: no [modeset]
<7> [298.585011] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [PLANE:151:plane 1C] fb: [NOFB], visible: no
<7> [298.585099] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [PLANE:161:plane 2C] fb: [NOFB], visible: no
<7> [298.585176] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [PLANE:171:plane 3C] fb: [NOFB], visible: no
<7> [298.585253] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [PLANE:181:plane 4C] fb: [NOFB], visible: no
<7> [298.585332] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [PLANE:191:plane 5C] fb: [NOFB], visible: no
<7> [298.585412] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [PLANE:201:cursor C] fb: [NOFB], visible: no
<7> [298.585568] xe 0000:00:02.0: [drm:intel_power_well_enable [xe]] enabling PW_A
<7> [298.585847] xe 0000:00:02.0: [drm:intel_alpm_disable [xe]] Disabling ALPM
<7> [298.585964] xe 0000:00:02.0: [drm:intel_edp_backlight_off [xe]]
<7> [298.792959] xe 0000:00:02.0: [drm:intel_backlight_set_pwm_level [xe]] [CONNECTOR:211:eDP-1] set backlight PWM = 0
<7> [298.793579] xe 0000:00:02.0: [drm:intel_disable_transcoder [xe]] disabling pipe C
<7> [298.804300] xe 0000:00:02.0: [drm:intel_pps_off_unlocked [xe]] [ENCODER:210:DDI A/PHY A] PPS 0 turn panel power off
<7> [298.804751] xe 0000:00:02.0: [drm:icp_irq_handler [xe]] hotplug event received, stat 0x00010000, dig 0x00000009, pins 0x00000010, long 0x00000000
<7> [298.805246] xe 0000:00:02.0: [drm:intel_hpd_irq_handler [xe]] digital hpd on [ENCODER:210:DDI A/PHY A] - short
<7> [298.805834] xe 0000:00:02.0: [drm:intel_pps_off_unlocked [xe]] [ENCODER:210:DDI A/PHY A] PPS 0 wait for panel power off time
<7> [298.806374] xe 0000:00:02.0: [drm:wait_panel_status [xe]] [ENCODER:210:DDI A/PHY A] PPS 0 mask: 0xb0000000 value: 0x00000000 PP_STATUS: 0xa0000002 PP_CONTROL: 0x00000060
<7> [298.858299] xe 0000:00:02.0: [drm:icp_irq_handler [xe]] hotplug event received, stat 0x00010000, dig 0x00000009, pins 0x00000010, long 0x00000000
<7> [298.858823] xe 0000:00:02.0: [drm:intel_hpd_irq_handler [xe]] digital hpd on [ENCODER:210:DDI A/PHY A] - short
<7> [298.866805] xe 0000:00:02.0: [drm:wait_panel_status [xe]] Wait complete
<7> [298.867244] xe 0000:00:02.0: [drm:intel_dpll_disable [xe]] disable DPLL 0 (active 0x4, on? 1) for [CRTC:207:pipe C]
<7> [298.867299] xe 0000:00:02.0: [drm:intel_dp_hpd_pulse [xe]] ignoring short hpd on eDP [ENCODER:210:DDI A/PHY A]
<7> [298.867902] xe 0000:00:02.0: [drm:intel_dp_hpd_pulse [xe]] ignoring short hpd on eDP [ENCODER:210:DDI A/PHY A]
<7> [298.868649] xe 0000:00:02.0: [drm:intel_dpll_disable [xe]] disabling DPLL 0
<7> [298.869290] xe 0000:00:02.0: [drm:intel_power_well_disable [xe]] disabling AUX_A
<7> [298.869890] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:210:DDI A/PHY A]
<7> [298.870310] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:219:DDI TC1/PHY TC1]
<7> [298.870668] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:221:DP-MST A]
<7> [298.871027] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:222:DP-MST B]
<7> [298.871398] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:223:DP-MST C]
<7> [298.871722] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:231:DDI TC2/PHY TC2]
<7> [298.872111] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:233:DP-MST A]
<7> [298.872463] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:234:DP-MST B]
<7> [298.872780] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:235:DP-MST C]
<7> [298.873079] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:239:DDI TC3/PHY TC3]
<7> [298.873374] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:241:DP-MST A]
<7> [298.873666] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:242:DP-MST B]
<7> [298.874114] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:243:DP-MST C]
<7> [298.874526] xe 0000:00:02.0: [drm:gen9_dbuf_slices_update [xe]] Updating dbuf slices to 0xf
<7> [298.875071] xe 0000:00:02.0: [drm:intel_dbuf_mbus_join_update [xe]] Changing mbus joined: no -> yes (pipe: *)
<7> [298.875369] xe 0000:00:02.0: [drm:intel_dbuf_mdclk_cdclk_ratio_update [xe]] Updating dbuf ratio to 8 (mbus joined: yes)
<7> [298.875725] xe 0000:00:02.0: [drm:intel_power_well_enable [xe]] enabling AUX_A
<7> [298.876936] xe 0000:00:02.0: [drm:intel_dpll_enable [xe]] enable DPLL 0 (active 0x1, on? 0) for [CRTC:89:pipe A]
<7> [298.877465] xe 0000:00:02.0: [drm:intel_dpll_enable [xe]] enabling DPLL 0
<7> [298.879772] xe 0000:00:02.0: [drm:intel_pps_on_unlocked [xe]] [ENCODER:210:DDI A/PHY A] PPS 0 turn panel power on
<7> [298.880173] xe 0000:00:02.0: [drm:wait_panel_power_cycle [xe]] [ENCODER:210:DDI A/PHY A] PPS 0 wait for panel power cycle (488 ms remaining)
<7> [298.895954] xe 0000:00:02.0: [drm:icp_irq_handler [xe]] hotplug event received, stat 0x00010000, dig 0x0000000a, pins 0x00000010, long 0x00000010
<7> [298.896277] xe 0000:00:02.0: [drm:intel_hpd_irq_handler [xe]] digital hpd on [ENCODER:210:DDI A/PHY A] - long
<7> [298.896619] xe 0000:00:02.0: [drm:intel_hpd_irq_handler [xe]] Received HPD interrupt on PIN 4 - cnt: 10
<7> [298.897144] xe 0000:00:02.0: [drm:intel_dp_hpd_pulse [xe]] ignoring long hpd on eDP [ENCODER:210:DDI A/PHY A]
<7> [299.376943] xe 0000:00:02.0: [drm:wait_panel_status [xe]] [ENCODER:210:DDI A/PHY A] PPS 0 mask: 0xb800000f value: 0x00000000 PP_STATUS: 0x08000001 PP_CONTROL: 0x00000060
<7> [299.445978] xe 0000:00:02.0: [drm:wait_panel_status [xe]] Wait complete
<7> [299.446392] xe 0000:00:02.0: [drm:intel_pps_on_unlocked [xe]] [ENCODER:210:DDI A/PHY A] PPS 0 wait for panel power on
<7> [299.446840] xe 0000:00:02.0: [drm:wait_panel_status [xe]] [ENCODER:210:DDI A/PHY A] PPS 0 mask: 0xb000000f value: 0x80000008 PP_STATUS: 0x9000000a PP_CONTROL: 0x00000063
<7> [299.482587] xe 0000:00:02.0: [drm:icp_irq_handler [xe]] hotplug event received, stat 0x00010000, dig 0x0000000a, pins 0x00000010, long 0x00000010
<7> [299.482954] xe 0000:00:02.0: [drm:intel_hpd_irq_handler [xe]] digital hpd on [ENCODER:210:DDI A/PHY A] - long
<7> [299.483274] xe 0000:00:02.0: [drm:intel_hpd_irq_handler [xe]] Received HPD interrupt on PIN 4 - cnt: 20
<7> [299.483769] xe 0000:00:02.0: [drm:intel_dp_hpd_pulse [xe]] ignoring long hpd on eDP [ENCODER:210:DDI A/PHY A]
<7> [299.655288] xe 0000:00:02.0: [drm:wait_panel_status [xe]] Wait complete
<7> [299.655678] xe 0000:00:02.0: [drm:intel_pps_vdd_on_unlocked [xe]] [ENCODER:210:DDI A/PHY A] PPS 0 turning VDD on
<7> [299.656063] xe 0000:00:02.0: [drm:intel_pps_vdd_on_unlocked [xe]] [ENCODER:210:DDI A/PHY A] PPS 0 PP_STATUS: 0x80000008 PP_CONTROL: 0x0000006b
<7> [299.658195] 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> [299.659494] xe 0000:00:02.0: [drm:intel_dp_start_link_train [xe]] [CONNECTOR:211:eDP-1][ENCODER:210:DDI A/PHY A][DPRX] Reloading eDP link rates
<7> [299.660375] xe 0000:00:02.0: [drm:intel_dp_start_link_train [xe]] [CONNECTOR:211:eDP-1][ENCODER:210:DDI A/PHY A][DPRX] Using LINK_RATE_SET value 05
<7> [299.661620] xe 0000:00:02.0: [drm:intel_dp_set_signal_levels [xe]] [CONNECTOR:211:eDP-1][ENCODER:210:DDI A/PHY A][DPRX] 8b/10b, lanes: 4, vswing levels: 0/0/0/0, pre-emphasis levels: 0/0/0/0
<7> [299.662941] xe 0000:00:02.0: [drm:intel_dp_program_link_training_pattern [xe]] [CONNECTOR:211:eDP-1][ENCODER:210:DDI A/PHY A][DPRX] Using DP training pattern TPS1
<7> [299.664130] xe 0000:00:02.0: [drm:intel_dp_link_train_phy [xe]] [CONNECTOR:211:eDP-1][ENCODER:210:DDI A/PHY A][DPRX] Clock recovery OK
<7> [299.664549] xe 0000:00:02.0: [drm:intel_dp_program_link_training_pattern [xe]] [CONNECTOR:211:eDP-1][ENCODER:210:DDI A/PHY A][DPRX] Using DP training pattern TPS4
<7> [299.666051] xe 0000:00:02.0: [drm:intel_dp_link_train_phy [xe]] [CONNECTOR:211:eDP-1][ENCODER:210:DDI A/PHY A][DPRX] Channel EQ done. DP Training successful
<7> [299.666461] xe 0000:00:02.0: [drm:intel_dp_link_train_phy [xe]] [CONNECTOR:211:eDP-1][ENCODER:210:DDI A/PHY A][DPRX] Link Training passed at link rate = 432000, lane count = 4
<7> [299.667361] xe 0000:00:02.0: [drm:intel_enable_transcoder [xe]] enabling pipe A
<7> [299.667923] xe 0000:00:02.0: [drm:intel_edp_backlight_on [xe]]
<7> [299.668336] xe 0000:00:02.0: [drm:intel_backlight_enable [xe]] pipe A
<7> [299.668810] xe 0000:00:02.0: [drm:intel_backlight_set_pwm_level [xe]] [CONNECTOR:211:eDP-1] set backlight PWM = 4518
<7> [299.684930] xe 0000:00:02.0: [drm:intel_psr_post_plane_update [xe]] Enabling PSR2
<7> [299.686883] xe 0000:00:02.0: [drm:verify_connector_state [xe]] [CONNECTOR:211:eDP-1]
<7> [299.687424] xe 0000:00:02.0: [drm:intel_modeset_verify_crtc [xe]] [CRTC:89:pipe A]
<7> [299.690139] xe 0000:00:02.0: [drm:intel_power_well_disable [xe]] disabling PW_C
<7> [299.690664] xe 0000:00:02.0: [drm:intel_power_well_disable [xe]] disabling PW_2
<7> [299.691234] xe 0000:00:02.0: [drm:intel_modeset_verify_crtc [xe]] [CRTC:207:pipe C]
<7> [299.692340] xe 0000:00:02.0: [drm:drm_client_dev_restore] fbdev: ret=0
<6> [299.693520] [IGT] kms_flip: exiting, ret=98
<6> [299.702429] Console: switching to colour frame buffer device 180x56
<7> [299.719912] xe 0000:00:02.0: [drm:intel_power_well_disable [xe]] disabling DC_off
<7> [299.720493] xe 0000:00:02.0: [drm:skl_enable_dc6 [xe]] Enabling DC6
<7> [299.721060] xe 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [xe]] Setting DC state from 00 to 02
<7> [299.721716] xe 0000:00:02.0: [drm:intel_power_well_enable [xe]] enabling DC_off
<7> [299.722382] xe 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [xe]] Setting DC state from 02 to 00
<7> [299.753905] xe 0000:00:02.0: [drm:intel_power_well_disable [xe]] disabling DC_off
<7> [299.754473] xe 0000:00:02.0: [drm:skl_enable_dc6 [xe]] Enabling DC6
<7> [299.755029] xe 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [xe]] Setting DC state from 00 to 02
Created at 2025-12-03 01:57:07