Results for igt@kms_flip@plain-flip-fb-recreate@a-edp1

Machine description: shard-lnl-3

Result: Fail

i915_display_info2 igt_runner2 results2.json results2-xe-load.json i915_display_info_post_exec2 boot2 dmesg2

DetailValue
Duration 9.47 seconds
Hostname 
shard-lnl-3
Igt-Version 
IGT-Version: 1.30-g425208736 (x86_64) (Linux: 6.14.0-rc5-xe+ x86_64)
Out 
Using IGT_SRANDOM=1741121117 for randomisation
Opened device: /dev/dri/card0
Using monotonic timestamps
Starting subtest: plain-flip-fb-recreate
Starting dynamic subtest: A-eDP1
  2880x1800: 60 347710 2880 2928 2960 3040 1800 1803 1809 1906 0x48 0xa 
Expected frametime: 16664us; measured 16846.2us +- 3.454us accuracy 0.06%
vblank interval differs from modeline! expected 16664.0us, measured 16846us +- 3.454us, difference 182.2us (52.8 sigma)
Stack trace:
  #0 ../lib/igt_core.c:2055 __igt_fail_assert()
  #1 ../tests/kms_flip.c:791 run_test_on_crtc_set.constprop.0()
  #2 ../tests/kms_flip.c:1845 run_test()
  #3 ../tests/kms_flip.c:2078 __igt_unique____real_main2001()
  #4 ../tests/kms_flip.c:2001 main()
  #5 [__libc_init_first+0x8a]
  #6 [__libc_start_main+0x8b]
  #7 [_start+0x25]
Dynamic subtest A-eDP1: FAIL (9.475s)
Err 
Starting subtest: plain-flip-fb-recreate
Starting dynamic subtest: A-eDP1
(kms_flip:2337) CRITICAL: Test assertion failure function __run_test_on_crtc_set, file ../tests/kms_flip.c:1674:
(kms_flip:2337) CRITICAL: Failed assertion: !retried && needs_retry_after_link_reset(mon)
Dynamic subtest A-eDP1 failed.
**** DEBUG ****
(kms_flip:2337) DEBUG: flip ts/seq: last 66.575356/615, current 66.592140/616: elapsed=16783.0us expected=16846.2us +- 84.2us, error 0.4%
(kms_flip:2337) DEBUG: name = flip
last_ts = 66.592140
last_received_ts = 66.591293
last_seq = 616
current_ts = 66.608925
current_received_ts = 66.608093
current_seq = 617
count = 158
seq_step = 1
(kms_flip:2337) DEBUG: flip ts/seq: last 66.592140/616, current 66.608925/617: elapsed=16788.0us expected=16846.2us +- 84.2us, error 0.3%
(kms_flip:2337) DEBUG: name = flip
last_ts = 66.608925
last_received_ts = 66.608093
last_seq = 617
current_ts = 66.625717
current_received_ts = 66.624893
current_seq = 618
count = 159
seq_step = 1
(kms_flip:2337) DEBUG: flip ts/seq: last 66.608925/617, current 66.625717/618: elapsed=16790.0us expected=16846.2us +- 84.2us, error 0.3%
(kms_flip:2337) DEBUG: name = flip
last_ts = 66.625717
last_received_ts = 66.624893
last_seq = 618
current_ts = 66.642502
current_received_ts = 66.641678
current_seq = 619
count = 160
seq_step = 1
(kms_flip:2337) DEBUG: flip ts/seq: last 66.625717/618, current 66.642502/619: elapsed=16785.0us expected=16846.2us +- 84.2us, error 0.4%
(kms_flip:2337) DEBUG: name = flip
last_ts = 66.642502
last_received_ts = 66.641678
last_seq = 619
current_ts = 66.659286
current_received_ts = 66.658524
current_seq = 620
count = 161
seq_step = 1
(kms_flip:2337) DEBUG: flip ts/seq: last 66.642502/619, current 66.659286/620: elapsed=16785.0us expected=16846.2us +- 84.2us, error 0.4%
(kms_flip:2337) DEBUG: name = flip
last_ts = 66.659286
last_received_ts = 66.658524
last_seq = 620
current_ts = 66.676064
current_received_ts = 66.675262
current_seq = 621
count = 162
seq_step = 1
(kms_flip:2337) DEBUG: flip ts/seq: last 66.659286/620, current 66.676064/621: elapsed=16780.0us expected=16846.2us +- 84.2us, error 0.4%
(kms_flip:2337) DEBUG: name = flip
last_ts = 66.676064
last_received_ts = 66.675262
last_seq = 621
current_ts = 66.692856
current_received_ts = 66.692055
current_seq = 622
count = 163
seq_step = 1
(kms_flip:2337) DEBUG: flip ts/seq: last 66.676064/621, current 66.692856/622: elapsed=16792.0us expected=16846.2us +- 84.2us, error 0.3%
(kms_flip:2337) DEBUG: name = flip
last_ts = 66.692856
last_received_ts = 66.692055
last_seq = 622
current_ts = 66.709648
current_received_ts = 66.708832
current_seq = 623
count = 164
seq_step = 1
(kms_flip:2337) DEBUG: flip ts/seq: last 66.692856/622, current 66.709648/623: elapsed=16786.0us expected=16846.2us +- 84.2us, error 0.4%
(kms_flip:2337) DEBUG: name = flip
last_ts = 66.709648
last_received_ts = 66.708832
last_seq = 623
current_ts = 66.726433
current_received_ts = 66.725609
current_seq = 624
count = 165
seq_step = 1
(kms_flip:2337) DEBUG: flip ts/seq: last 66.709648/623, current 66.726433/624: elapsed=16787.0us expected=16846.2us +- 84.2us, error 0.4%
(kms_flip:2337) DEBUG: name = flip
last_ts = 66.726433
last_received_ts = 66.725609
last_seq = 624
current_ts = 66.743210
current_received_ts = 66.742409
current_seq = 625
count = 166
seq_step = 1
(kms_flip:2337) DEBUG: flip ts/seq: last 66.726433/624, current 66.743210/625: elapsed=16781.0us expected=16846.2us +- 84.2us, error 0.4%
(kms_flip:2337) DEBUG: name = flip
last_ts = 66.743210
last_received_ts = 66.742409
last_seq = 625
current_ts = 66.759995
current_received_ts = 66.759209
current_seq = 626
count = 167
seq_step = 1
(kms_flip:2337) DEBUG: flip ts/seq: last 66.743210/625, current 66.759995/626: elapsed=16785.0us expected=16846.2us +- 84.2us, error 0.4%
(kms_flip:2337) DEBUG: name = flip
last_ts = 66.759995
last_received_ts = 66.759209
last_seq = 626
current_ts = 66.776787
current_received_ts = 66.775970
current_seq = 627
count = 168
seq_step = 1
(kms_flip:2337) DEBUG: flip ts/seq: last 66.759995/626, current 66.776787/627: elapsed=16790.0us expected=16846.2us +- 84.2us, error 0.3%
(kms_flip:2337) DEBUG: name = flip
last_ts = 66.776787
last_received_ts = 66.775970
last_seq = 627
current_ts = 66.793571
current_received_ts = 66.792763
current_seq = 628
count = 169
seq_step = 1
(kms_flip:2337) DEBUG: flip ts/seq: last 66.776787/627, current 66.793571/628: elapsed=16785.0us expected=16846.2us +- 84.2us, error 0.4%
(kms_flip:2337) DEBUG: name = flip
last_ts = 66.793571
last_received_ts = 66.792763
last_seq = 628
current_ts = 66.810356
current_received_ts = 66.809547
current_seq = 629
count = 170
seq_step = 1
(kms_flip:2337) DEBUG: flip ts/seq: last 66.793571/628, current 66.810356/629: elapsed=16786.0us expected=16846.2us +- 84.2us, error 0.4%
(kms_flip:2337) DEBUG: name = flip
last_ts = 66.810356
last_received_ts = 66.809547
last_seq = 629
current_ts = 66.827141
current_received_ts = 66.826324
current_seq = 630
count = 171
seq_step = 1
(kms_flip:2337) DEBUG: flip ts/seq: last 66.810356/629, current 66.827141/630: elapsed=16784.0us expected=16846.2us +- 84.2us, error 0.4%
(kms_flip:2337) DEBUG: name = flip
last_ts = 66.827141
last_received_ts = 66.826324
last_seq = 630
current_ts = 66.843925
current_received_ts = 66.843155
current_seq = 631
count = 172
seq_step = 1
(kms_flip:2337) DEBUG: flip ts/seq: last 66.827141/630, current 66.843925/631: elapsed=16786.0us expected=16846.2us +- 84.2us, error 0.4%
(kms_flip:2337) DEBUG: name = flip
last_ts = 66.843925
last_received_ts = 66.843155
last_seq = 631
current_ts = 66.860718
current_received_ts = 66.859909
current_seq = 632
count = 173
seq_step = 1
(kms_flip:2337) DEBUG: flip ts/seq: last 66.843925/631, current 66.860718/632: elapsed=16791.0us expected=16846.2us +- 84.2us, error 0.3%
(kms_flip:2337) DEBUG: name = flip
last_ts = 66.860718
last_received_ts = 66.859909
last_seq = 632
current_ts = 66.877502
current_received_ts = 66.876694
current_seq = 633
count = 174
seq_step = 1
(kms_flip:2337) DEBUG: flip ts/seq: last 66.860718/632, current 66.877502/633: elapsed=16785.0us expected=16846.2us +- 84.2us, error 0.4%
(kms_flip:2337) DEBUG: name = flip
last_ts = 66.877502
last_received_ts = 66.876694
last_seq = 633
current_ts = 66.894295
current_received_ts = 66.893486
current_seq = 634
count = 175
seq_step = 1
(kms_flip:2337) DEBUG: flip ts/seq: last 66.877502/633, current 66.894295/634: elapsed=16786.0us expected=16846.2us +- 84.2us, error 0.4%
(kms_flip:2337) DEBUG: name = flip
last_ts = 66.894295
last_received_ts = 66.893486
last_seq = 634
current_ts = 66.911072
current_received_ts = 66.910301
current_seq = 635
count = 176
seq_step = 1
(kms_flip:2337) DEBUG: flip ts/seq: last 66.894295/634, current 66.911072/635: elapsed=16779.0us expected=16846.2us +- 84.2us, error 0.4%
(kms_flip:2337) DEBUG: name = flip
last_ts = 66.911072
last_received_ts = 66.910301
last_seq = 635
current_ts = 66.927864
current_received_ts = 66.927094
current_seq = 636
count = 177
seq_step = 1
(kms_flip:2337) DEBUG: flip ts/seq: last 66.911072/635, current 66.927864/636: elapsed=16792.0us expected=16846.2us +- 84.2us, error 0.3%
(kms_flip:2337) DEBUG: name = flip
last_ts = 66.927864
last_received_ts = 66.927094
last_seq = 636
current_ts = 66.944641
current_received_ts = 66.943871
current_seq = 637
count = 178
seq_step = 1
(kms_flip:2337) DEBUG: flip ts/seq: last 66.927864/636, current 66.944641/637: elapsed=16780.0us expected=16846.2us +- 84.2us, error 0.4%
(kms_flip:2337) DEBUG: name = flip
last_ts = 66.944641
last_received_ts = 66.943871
last_seq = 637
current_ts = 66.961433
current_received_ts = 66.960625
current_seq = 638
count = 179
seq_step = 1
(kms_flip:2337) DEBUG: flip ts/seq: last 66.944641/637, current 66.961433/638: elapsed=16791.0us expected=16846.2us +- 84.2us, error 0.3%
(kms_flip:2337) DEBUG: name = flip
last_ts = 66.961433
last_received_ts = 66.960625
last_seq = 638
current_ts = 66.978218
current_received_ts = 66.977394
current_seq = 639
count = 180
seq_step = 1
(kms_flip:2337) DEBUG: flip ts/seq: last 66.961433/638, current 66.978218/639: elapsed=16782.0us expected=16846.2us +- 84.2us, error 0.4%
(kms_flip:2337) DEBUG: name = flip
last_ts = 66.978218
last_received_ts = 66.977394
last_seq = 639
current_ts = 66.995003
current_received_ts = 66.994179
current_seq = 640
count = 181
seq_step = 1
(kms_flip:2337) DEBUG: flip ts/seq: last 66.978218/639, current 66.995003/640: elapsed=16785.0us expected=16846.2us +- 84.2us, error 0.4%
(kms_flip:2337) DEBUG: name = flip
last_ts = 66.995003
last_received_ts = 66.994179
last_seq = 640
current_ts = 67.011787
current_received_ts = 67.011024
current_seq = 641
count = 182
seq_step = 1
(kms_flip:2337) DEBUG: flip ts/seq: last 66.995003/640, current 67.011787/641: elapsed=16791.0us expected=16846.2us +- 84.2us, error 0.3%
(kms_flip:2337) DEBUG: name = flip
last_ts = 67.011787
last_received_ts = 67.011024
last_seq = 641
current_ts = 67.028580
current_received_ts = 67.027771
current_seq = 642
count = 183
seq_step = 1
(kms_flip:2337) DEBUG: flip ts/seq: last 67.011787/641, current 67.028580/642: elapsed=16787.0us expected=16846.2us +- 84.2us, error 0.4%
(kms_flip:2337) DEBUG: name = flip
last_ts = 67.028580
last_received_ts = 67.027771
last_seq = 642
current_ts = 67.045364
current_received_ts = 67.044540
current_seq = 643
count = 184
seq_step = 1
(kms_flip:2337) DEBUG: flip ts/seq: last 67.028580/642, current 67.045364/643: elapsed=16783.0us expected=16846.2us +- 84.2us, error 0.4%
(kms_flip:2337) DEBUG: name = flip
last_ts = 67.045364
last_received_ts = 67.044540
last_seq = 643
current_ts = 67.062149
current_received_ts = 67.061317
current_seq = 644
count = 185
seq_step = 1
(kms_flip:2337) DEBUG: flip ts/seq: last 67.045364/643, current 67.062149/644: elapsed=16790.0us expected=16846.2us +- 84.2us, error 0.3%
(kms_flip:2337) DEBUG: name = flip
last_ts = 67.062149
last_received_ts = 67.061317
last_seq = 644
current_ts = 67.078934
current_received_ts = 67.078148
current_seq = 645
count = 186
seq_step = 1
(kms_flip:2337) DEBUG: flip ts/seq: last 67.062149/644, current 67.078934/645: elapsed=16781.0us expected=16846.2us +- 84.2us, error 0.4%
(kms_flip:2337) DEBUG: name = flip
last_ts = 67.078934
last_received_ts = 67.078148
last_seq = 645
current_ts = 67.095718
current_received_ts = 67.094917
current_seq = 646
count = 187
seq_step = 1
(kms_flip:2337) DEBUG: flip ts/seq: last 67.078934/645, current 67.095718/646: elapsed=16788.0us expected=16846.2us +- 84.2us, error 0.3%
(kms_flip:2337) DEBUG: name = flip
last_ts = 67.095718
last_received_ts = 67.094917
last_seq = 646
current_ts = 67.112511
current_received_ts = 67.111725
current_seq = 647
count = 188
seq_step = 1
(kms_flip:2337) DEBUG: flip ts/seq: last 67.095718/646, current 67.112511/647: elapsed=16787.0us expected=16846.2us +- 84.2us, error 0.4%
(kms_flip:2337) DEBUG: name = flip
last_ts = 67.112511
last_received_ts = 67.111725
last_seq = 647
current_ts = 67.129288
current_received_ts = 67.128494
current_seq = 648
count = 189
seq_step = 1
(kms_flip:2337) DEBUG: flip ts/seq: last 67.112511/647, current 67.129288/648: elapsed=16780.0us expected=16846.2us +- 84.2us, error 0.4%
(kms_flip:2337) DEBUG: name = flip
last_ts = 67.129288
last_received_ts = 67.128494
last_seq = 648
current_ts = 67.146072
current_received_ts = 67.145287
current_seq = 649
count = 190
seq_step = 1
(kms_flip:2337) DEBUG: flip ts/seq: last 67.129288/648, current 67.146072/649: elapsed=16788.0us expected=16846.2us +- 84.2us, error 0.3%
(kms_flip:2337) DEBUG: name = flip
last_ts = 67.146072
last_received_ts = 67.145287
last_seq = 649
current_ts = 67.162865
current_received_ts = 67.162094
current_seq = 650
count = 191
seq_step = 1
(kms_flip:2337) DEBUG: flip ts/seq: last 67.146072/649, current 67.162865/650: elapsed=16789.0us expected=16846.2us +- 84.2us, error 0.3%
(kms_flip:2337) DEBUG: name = flip
last_ts = 67.162865
last_received_ts = 67.162094
last_seq = 650
current_ts = 67.179649
current_received_ts = 67.178871
current_seq = 651
count = 192
seq_step = 1
(kms_flip:2337) DEBUG: flip ts/seq: last 67.162865/650, current 67.179649/651: elapsed=16786.0us expected=16846.2us +- 84.2us, error 0.4%
(kms_flip:2337) DEBUG: name = flip
last_ts = 67.179649
last_received_ts = 67.178871
last_seq = 651
current_ts = 67.196434
current_received_ts = 67.195633
current_seq = 652
count = 193
seq_step = 1
(kms_flip:2337) DEBUG: flip ts/seq: last 67.179649/651, current 67.196434/652: elapsed=16787.0us expected=16846.2us +- 84.2us, error 0.4%
(kms_flip:2337) DEBUG: name = flip
last_ts = 67.196434
last_received_ts = 67.195633
last_seq = 652
current_ts = 67.213219
current_received_ts = 67.212402
current_seq = 653
count = 194
seq_step = 1
(kms_flip:2337) DEBUG: flip ts/seq: last 67.196434/652, current 67.213219/653: elapsed=16779.0us expected=16846.2us +- 84.2us, error 0.4%
(kms_flip:2337) DEBUG: name = flip
last_ts = 67.213219
last_received_ts = 67.212402
last_seq = 653
current_ts = 67.230003
current_received_ts = 67.229195
current_seq = 654
count = 195
seq_step = 1
(kms_flip:2337) DEBUG: flip ts/seq: last 67.213219/653, current 67.230003/654: elapsed=16786.0us expected=16846.2us +- 84.2us, error 0.4%
(kms_flip:2337) DEBUG: name = flip
last_ts = 67.230003
last_received_ts = 67.229195
last_seq = 654
current_ts = 67.246796
current_received_ts = 67.246033
current_seq = 655
count = 196
seq_step = 1
(kms_flip:2337) DEBUG: flip ts/seq: last 67.230003/654, current 67.246796/655: elapsed=16792.0us expected=16846.2us +- 84.2us, error 0.3%
(kms_flip:2337) DEBUG: name = flip
last_ts = 67.246796
last_received_ts = 67.246033
last_seq = 655
current_ts = 67.263580
current_received_ts = 67.262772
current_seq = 656
count = 197
seq_step = 1
(kms_flip:2337) DEBUG: flip ts/seq: last 67.246796/655, current 67.263580/656: elapsed=16785.0us expected=16846.2us +- 84.2us, error 0.4%
(kms_flip:2337) DEBUG: name = flip
last_ts = 67.263580
last_received_ts = 67.262772
last_seq = 656
current_ts = 67.280365
current_received_ts = 67.279549
current_seq = 657
count = 198
seq_step = 1
(kms_flip:2337) DEBUG: flip ts/seq: last 67.263580/656, current 67.280365/657: elapsed=16787.0us expected=16846.2us +- 84.2us, error 0.4%
(kms_flip:2337) DEBUG: name = flip
last_ts = 67.280365
last_received_ts = 67.279549
last_seq = 657
current_ts = 67.297142
current_received_ts = 67.296326
current_seq = 658
count = 199
seq_step = 1
(kms_flip:2337) DEBUG: flip ts/seq: last 67.280365/657, current 67.297142/658: elapsed=16779.0us expected=16846.2us +- 84.2us, error 0.4%
(kms_flip:2337) DEBUG: name = flip
last_ts = 67.297142
last_received_ts = 67.296326
last_seq = 658
current_ts = 67.313934
current_received_ts = 67.313156
current_seq = 659
count = 200
seq_step = 1
(kms_flip:2337) DEBUG: flip ts/seq: last 67.297142/658, current 67.313934/659: elapsed=16793.0us expected=16846.2us +- 84.2us, error 0.3%
(kms_flip:2337) DEBUG: name = flip
last_ts = 67.313934
last_received_ts = 67.313156
last_seq = 659
current_ts = 67.330727
current_received_ts = 67.329933
current_seq = 660
count = 201
seq_step = 1
(kms_flip:2337) DEBUG: flip ts/seq: last 67.313934/659, current 67.330727/660: elapsed=16786.0us expected=16846.2us +- 84.2us, error 0.4%
(kms_flip:2337) DEBUG: name = flip
last_ts = 67.330727
last_received_ts = 67.329933
last_seq = 660
current_ts = 67.347511
current_received_ts = 67.346695
current_seq = 661
count = 202
seq_step = 1
(kms_flip:2337) DEBUG: flip ts/seq: last 67.330727/660, current 67.347511/661: elapsed=16786.0us expected=16846.2us +- 84.2us, error 0.4%
(kms_flip:2337) DEBUG: name = flip
last_ts = 67.347511
last_received_ts = 67.346695
last_seq = 661
current_ts = 67.364296
current_received_ts = 67.363487
current_seq = 662
count = 203
seq_step = 1
(kms_flip:2337) DEBUG: flip ts/seq: last 67.347511/661, current 67.364296/662: elapsed=16785.0us expected=16846.2us +- 84.2us, error 0.4%
(kms_flip:2337) DEBUG: name = flip
last_ts = 67.364296
last_received_ts = 67.363487
last_seq = 662
current_ts = 67.381073
current_received_ts = 67.380302
current_seq = 663
count = 204
seq_step = 1
(kms_flip:2337) DEBUG: flip ts/seq: last 67.364296/662, current 67.381073/663: elapsed=16781.0us expected=16846.2us +- 84.2us, error 0.4%
(kms_flip:2337) DEBUG: name = flip
last_ts = 67.381073
last_received_ts = 67.380302
last_seq = 663
current_ts = 67.397865
current_received_ts = 67.397102
current_seq = 664
count = 205
seq_step = 1
(kms_flip:2337) DEBUG: flip ts/seq: last 67.381073/663, current 67.397865/664: elapsed=16791.0us expected=16846.2us +- 84.2us, error 0.3%
(kms_flip:2337) DEBUG: name = flip
last_ts = 67.397865
last_received_ts = 67.397102
last_seq = 664
current_ts = 67.414650
current_received_ts = 67.413841
current_seq = 665
count = 206
seq_step = 1
(kms_flip:2337) DEBUG: flip ts/seq: last 67.397865/664, current 67.414650/665: elapsed=16785.0us expected=16846.2us +- 84.2us, error 0.4%
(kms_flip:2337) DEBUG: name = flip
last_ts = 67.414650
last_received_ts = 67.413841
last_seq = 665
current_ts = 67.431435
current_received_ts = 67.430626
current_seq = 666
count = 207
seq_step = 1
(kms_flip:2337) DEBUG: flip ts/seq: last 67.414650/665, current 67.431435/666: elapsed=16786.0us expected=16846.2us +- 84.2us, error 0.4%
(kms_flip:2337) DEBUG: name = flip
last_ts = 67.431435
last_received_ts = 67.430626
last_seq = 666
current_ts = 67.448219
current_received_ts = 67.447411
current_seq = 667
count = 208
seq_step = 1
(kms_flip:2337) DEBUG: flip ts/seq: last 67.431435/666, current 67.448219/667: elapsed=16782.0us expected=16846.2us +- 84.2us, error 0.4%
(kms_flip:2337) DEBUG: name = flip
last_ts = 67.448219
last_received_ts = 67.447411
last_seq = 667
current_ts = 67.465012
current_received_ts = 67.464226
current_seq = 668
count = 209
seq_step = 1
(kms_flip:2337) DEBUG: flip ts/seq: last 67.448219/667, current 67.465012/668: elapsed=16792.0us expected=16846.2us +- 84.2us, error 0.3%
(kms_flip:2337) DEBUG: name = flip
last_ts = 67.465012
last_received_ts = 67.464226
last_seq = 668
current_ts = 67.481796
current_received_ts = 67.481033
current_seq = 669
count = 210
seq_step = 1
(kms_flip:2337) DEBUG: flip ts/seq: last 67.465012/668, current 67.481796/669: elapsed=16784.0us expected=16846.2us +- 84.2us, error 0.4%
(kms_flip:2337) DEBUG: name = flip
last_ts = 67.481796
last_received_ts = 67.481033
last_seq = 669
current_ts = 67.498581
current_received_ts = 67.497787
current_seq = 670
count = 211
seq_step = 1
(kms_flip:2337) DEBUG: flip ts/seq: last 67.481796/669, current 67.498581/670: elapsed=16785.0us expected=16846.2us +- 84.2us, error 0.4%
(kms_flip:2337) DEBUG: name = flip
last_ts = 67.498581
last_received_ts = 67.497787
last_seq = 670
current_ts = 67.515366
current_received_ts = 67.514587
current_seq = 671
count = 212
seq_step = 1
(kms_flip:2337) DEBUG: flip ts/seq: last 67.498581/670, current 67.515366/671: elapsed=16785.0us expected=16846.2us +- 84.2us, error 0.4%
(kms_flip:2337) DEBUG: name = flip
last_ts = 67.515366
last_received_ts = 67.514587
last_seq = 671
current_ts = 67.532158
current_received_ts = 67.531334
current_seq = 672
count = 213
seq_step = 1
(kms_flip:2337) DEBUG: flip ts/seq: last 67.515366/671, current 67.532158/672: elapsed=16790.0us expected=16846.2us +- 84.2us, error 0.3%
(kms_flip:2337) DEBUG: name = flip
last_ts = 67.532158
last_received_ts = 67.531334
last_seq = 672
current_ts = 67.548935
current_received_ts = 67.548271
current_seq = 673
count = 214
seq_step = 1
(kms_flip:2337) DEBUG: flip ts/seq: last 67.532158/672, current 67.548935/673: elapsed=16779.0us expected=16846.2us +- 84.2us, error 0.4%
(kms_flip:2337) DEBUG: name = flip
last_ts = 67.548935
last_received_ts = 67.548271
last_seq = 673
current_ts = 67.565727
current_received_ts = 67.564957
current_seq = 674
count = 215
seq_step = 1
(kms_flip:2337) DEBUG: flip ts/seq: last 67.548935/673, current 67.565727/674: elapsed=16791.0us expected=16846.2us +- 84.2us, error 0.3%
(kms_flip:2337) DEBUG: name = flip
last_ts = 67.565727
last_received_ts = 67.564957
last_seq = 674
current_ts = 67.582504
current_received_ts = 67.581696
current_seq = 675
count = 216
seq_step = 1
(kms_flip:2337) DEBUG: flip ts/seq: last 67.565727/674, current 67.582504/675: elapsed=16782.0us expected=16846.2us +- 84.2us, error 0.4%
(kms_flip:2337) DEBUG: name = flip
last_ts = 67.582504
last_received_ts = 67.581696
last_seq = 675
current_ts = 67.599274
current_received_ts = 67.598610
current_seq = 676
count = 217
seq_step = 1
(kms_flip:2337) DEBUG: flip ts/seq: last 67.582504/675, current 67.599274/676: elapsed=16769.0us expected=16846.2us +- 84.2us, error 0.5%
(kms_flip:2337) DEBUG: name = flip
last_ts = 67.599274
last_received_ts = 67.598610
last_seq = 676
current_ts = 67.616051
current_received_ts = 67.615257
current_seq = 677
count = 218
seq_step = 1
(kms_flip:2337) DEBUG: flip ts/seq: last 67.599274/676, current 67.616051/677: elapsed=16772.0us expected=16846.2us +- 84.2us, error 0.4%
(kms_flip:2337) DEBUG: name = flip
last_ts = 67.616051
last_received_ts = 67.615257
last_seq = 677
current_ts = 67.632820
current_received_ts = 67.632027
current_seq = 678
count = 219
seq_step = 1
(kms_flip:2337) DEBUG: flip ts/seq: last 67.616051/677, current 67.632820/678: elapsed=16769.0us expected=16846.2us +- 84.2us, error 0.5%
(kms_flip:2337) DEBUG: name = flip
last_ts = 67.632820
last_received_ts = 67.632027
last_seq = 678
current_ts = 67.649590
current_received_ts = 67.648811
current_seq = 679
count = 220
seq_step = 1
(kms_flip:2337) DEBUG: flip ts/seq: last 67.632820/678, current 67.649590/679: elapsed=16771.0us expected=16846.2us +- 84.2us, error 0.4%
(kms_flip:2337) DEBUG: name = flip
last_ts = 67.649590
last_received_ts = 67.648811
last_seq = 679
current_ts = 67.666359
current_received_ts = 67.665543
current_seq = 680
count = 221
seq_step = 1
(kms_flip:2337) DEBUG: flip ts/seq: last 67.649590/679, current 67.666359/680: elapsed=16770.0us expected=16846.2us +- 84.2us, error 0.5%
(kms_flip:2337) DEBUG: name = flip
last_ts = 67.666359
last_received_ts = 67.665543
last_seq = 680
current_ts = 67.683128
current_received_ts = 67.682312
current_seq = 681
count = 222
seq_step = 1
(kms_flip:2337) DEBUG: flip ts/seq: last 67.666359/680, current 67.683128/681: elapsed=16767.0us expected=16846.2us +- 84.2us, error 0.5%
(kms_flip:2337) DEBUG: name = flip
last_ts = 67.683128
last_received_ts = 67.682312
last_seq = 681
current_ts = 67.699905
current_received_ts = 67.699120
current_seq = 682
count = 223
seq_step = 1
(kms_flip:2337) DEBUG: flip ts/seq: last 67.683128/681, current 67.699905/682: elapsed=16777.0us expected=16846.2us +- 84.2us, error 0.4%
(kms_flip:2337) DEBUG: name = flip
last_ts = 67.699905
last_received_ts = 67.699120
last_seq = 682
current_ts = 67.716675
current_received_ts = 67.716049
current_seq = 683
count = 224
seq_step = 1
(kms_flip:2337) DEBUG: flip ts/seq: last 67.699905/682, current 67.716675/683: elapsed=16768.0us expected=16846.2us +- 84.2us, error 0.5%
(kms_flip:2337) DEBUG: name = flip
last_ts = 67.716675
last_received_ts = 67.716049
last_seq = 683
current_ts = 67.733444
current_received_ts = 67.732651
current_seq = 684
count = 225
seq_step = 1
(kms_flip:2337) DEBUG: flip ts/seq: last 67.716675/683, current 67.733444/684: elapsed=16772.0us expected=16846.2us +- 84.2us, error 0.4%
(kms_flip:2337) DEBUG: name = flip
last_ts = 67.733444
last_received_ts = 67.732651
last_seq = 684
current_ts = 67.750206
current_received_ts = 67.749405
current_seq = 685
count = 226
seq_step = 1
(kms_flip:2337) DEBUG: flip ts/seq: last 67.733444/684, current 67.750206/685: elapsed=16764.0us expected=16846.2us +- 84.2us, error 0.5%
(kms_flip:2337) DEBUG: name = flip
last_ts = 67.750206
last_received_ts = 67.749405
last_seq = 685
current_ts = 67.766983
current_received_ts = 67.766319
current_seq = 686
count = 227
seq_step = 1
(kms_flip:2337) DEBUG: flip ts/seq: last 67.750206/685, current 67.766983/686: elapsed=16779.0us expected=16846.2us +- 84.2us, error 0.4%
(kms_flip:2337) DEBUG: name = flip
last_ts = 67.766983
last_received_ts = 67.766319
last_seq = 686
current_ts = 67.783752
current_received_ts = 67.782990
current_seq = 687
count = 228
seq_step = 1
(kms_flip:2337) DEBUG: flip ts/seq: last 67.766983/686, current 67.783752/687: elapsed=16769.0us expected=16846.2us +- 84.2us, error 0.5%
(kms_flip:2337) DEBUG: name = flip
last_ts = 67.783752
last_received_ts = 67.782990
last_seq = 687
current_ts = 67.800529
current_received_ts = 67.799721
current_seq = 688
count = 229
seq_step = 1
(kms_flip:2337) DEBUG: flip ts/seq: last 67.783752/687, current 67.800529/688: elapsed=16771.0us expected=16846.2us +- 84.2us, error 0.4%
(kms_flip:2337) DEBUG: name = flip
last_ts = 67.800529
last_received_ts = 67.799721
last_seq = 688
current_ts = 67.817299
current_received_ts = 67.816483
current_seq = 689
count = 230
seq_step = 1
(kms_flip:2337) DEBUG: flip ts/seq: last 67.800529/688, current 67.817299/689: elapsed=16770.0us expected=16846.2us +- 84.2us, error 0.5%
(kms_flip:2337) DEBUG: name = flip
last_ts = 67.817299
last_received_ts = 67.816483
last_seq = 689
current_ts = 67.834061
current_received_ts = 67.833389
current_seq = 690
count = 231
seq_step = 1
(kms_flip:2337) DEBUG: flip ts/seq: last 67.817299/689, current 67.834061/690: elapsed=16766.0us expected=16846.2us +- 84.2us, error 0.5%
(kms_flip:2337) DEBUG: name = flip
last_ts = 67.834061
last_received_ts = 67.833389
last_seq = 690
current_ts = 67.850838
current_received_ts = 67.850060
current_seq = 691
count = 232
seq_step = 1
(kms_flip:2337) DEBUG: flip ts/seq: last 67.834061/690, current 67.850838/691: elapsed=16773.0us expected=16846.2us +- 84.2us, error 0.4%
(kms_flip:2337) DEBUG: name = flip
last_ts = 67.850838
last_received_ts = 67.850060
last_seq = 691
current_ts = 67.867607
current_received_ts = 67.866798
current_seq = 692
count = 233
seq_step = 1
(kms_flip:2337) DEBUG: flip ts/seq: last 67.850838/691, current 67.867607/692: elapsed=16772.0us expected=16846.2us +- 84.2us, error 0.4%
(kms_flip:2337) DEBUG: name = flip
last_ts = 67.867607
last_received_ts = 67.866798
last_seq = 692
current_ts = 67.884377
current_received_ts = 67.883606
current_seq = 693
count = 234
seq_step = 1
(kms_flip:2337) DEBUG: flip ts/seq: last 67.867607/692, current 67.884377/693: elapsed=16773.0us expected=16846.2us +- 84.2us, error 0.4%
(kms_flip:2337) DEBUG: name = flip
last_ts = 67.884377
last_received_ts = 67.883606
last_seq = 693
current_ts = 67.901146
current_received_ts = 67.900345
current_seq = 694
count = 235
seq_step = 1
(kms_flip:2337) DEBUG: flip ts/seq: last 67.884377/693, current 67.901146/694: elapsed=16764.0us expected=16846.2us +- 84.2us, error 0.5%
(kms_flip:2337) DEBUG: name = flip
last_ts = 67.901146
last_received_ts = 67.900345
last_seq = 694
current_ts = 67.917923
current_received_ts = 67.917114
current_seq = 695
count = 236
seq_step = 1
(kms_flip:2337) DEBUG: flip ts/seq: last 67.901146/694, current 67.917923/695: elapsed=16776.0us expected=16846.2us +- 84.2us, error 0.4%
(kms_flip:2337) DEBUG: name = flip
last_ts = 67.917923
last_received_ts = 67.917114
last_seq = 695
current_ts = 67.934692
current_received_ts = 67.933922
current_seq = 696
count = 237
seq_step = 1
(kms_flip:2337) DEBUG: flip ts/seq: last 67.917923/695, current 67.934692/696: elapsed=16770.0us expected=16846.2us +- 84.2us, error 0.5%
(kms_flip:2337) DEBUG: name = flip
last_ts = 67.934692
last_received_ts = 67.933922
last_seq = 696
current_ts = 67.951462
current_received_ts = 67.950684
current_seq = 697
count = 238
seq_step = 1
(kms_flip:2337) DEBUG: flip ts/seq: last 67.934692/696, current 67.951462/697: elapsed=16771.0us expected=16846.2us +- 84.2us, error 0.4%
(kms_flip:2337) DEBUG: name = flip
last_ts = 67.951462
last_received_ts = 67.950684
last_seq = 697
current_ts = 67.968231
current_received_ts = 67.967430
current_seq = 698
count = 239
seq_step = 1
(kms_flip:2337) DEBUG: flip ts/seq: last 67.951462/697, current 67.968231/698: elapsed=16768.0us expected=16846.2us +- 84.2us, error 0.5%
(kms_flip:2337) DEBUG: name = flip
last_ts = 67.968231
last_received_ts = 67.967430
last_seq = 698
current_ts = 67.984993
current_received_ts = 67.984192
current_seq = 699
count = 240
seq_step = 1
(kms_flip:2337) DEBUG: flip ts/seq: last 67.968231/698, current 67.984993/699: elapsed=16767.0us expected=16846.2us +- 84.2us, error 0.5%
(kms_flip:2337) DEBUG: name = flip
last_ts = 67.984993
last_received_ts = 67.984192
last_seq = 699
current_ts = 68.001770
current_received_ts = 68.000969
current_seq = 700
count = 241
seq_step = 1
(kms_flip:2337) DEBUG: flip ts/seq: last 67.984993/699, current 68.001770/700: elapsed=16777.0us expected=16846.2us +- 84.2us, error 0.4%
(kms_flip:2337) DEBUG: name = flip
last_ts = 68.001770
last_received_ts = 68.000969
last_seq = 700
current_ts = 68.018539
current_received_ts = 68.017731
current_seq = 701
count = 242
seq_step = 1
(kms_flip:2337) DEBUG: flip ts/seq: last 68.001770/700, current 68.018539/701: elapsed=16770.0us expected=16846.2us +- 84.2us, error 0.5%
(kms_flip:2337) DEBUG: name = flip
last_ts = 68.018539
last_received_ts = 68.017731
last_seq = 701
current_ts = 68.035316
current_received_ts = 68.034500
current_seq = 702
count = 243
seq_step = 1
(kms_flip:2337) DEBUG: flip ts/seq: last 68.018539/701, current 68.035316/702: elapsed=16771.0us expected=16846.2us +- 84.2us, error 0.4%
(kms_flip:2337) DEBUG: name = flip
last_ts = 68.035316
last_received_ts = 68.034500
last_seq = 702
current_ts = 68.052086
current_received_ts = 68.051399
current_seq = 703
count = 244
seq_step = 1
(kms_flip:2337) DEBUG: flip ts/seq: last 68.035316/702, current 68.052086/703: elapsed=16773.0us expected=16846.2us +- 84.2us, error 0.4%
(kms_flip:2337) DEBUG: name = flip
last_ts = 68.052086
last_received_ts = 68.051399
last_seq = 703
current_ts = 68.068855
current_received_ts = 68.068085
current_seq = 704
count = 245
seq_step = 1
(kms_flip:2337) DEBUG: flip ts/seq: last 68.052086/703, current 68.068855/704: elapsed=16768.0us expected=16846.2us +- 84.2us, error 0.5%
(kms_flip:2337) DEBUG: name = flip
last_ts = 68.068855
last_received_ts = 68.068085
last_seq = 704
current_ts = 68.085625
current_received_ts = 68.084961
current_seq = 705
count = 246
seq_step = 1
(kms_flip:2337) DEBUG: flip ts/seq: last 68.068855/704, current 68.085625/705: elapsed=16771.0us expected=16846.2us +- 84.2us, error 0.4%
(kms_flip:2337) DEBUG: name = flip
last_ts = 68.085625
last_received_ts = 68.084961
last_seq = 705
current_ts = 68.102394
current_received_ts = 68.101639
current_seq = 706
count = 247
seq_step = 1
(kms_flip:2337) DEBUG: flip ts/seq: last 68.085625/705, current 68.102394/706: elapsed=16770.0us expected=16846.2us +- 84.2us, error 0.5%
(kms_flip:2337) DEBUG: name = flip
last_ts = 68.102394
last_received_ts = 68.101639
last_seq = 706
current_ts = 68.119171
current_received_ts = 68.118355
current_seq = 707
count = 248
seq_step = 1
(kms_flip:2337) DEBUG: flip ts/seq: last 68.102394/706, current 68.119171/707: elapsed=16774.0us expected=16846.2us +- 84.2us, error 0.4%
(kms_flip:2337) DEBUG: name = flip
last_ts = 68.119171
last_received_ts = 68.118355
last_seq = 707
current_ts = 68.135941
current_received_ts = 68.135170
current_seq = 708
count = 249
seq_step = 1
(kms_flip:2337) DEBUG: flip ts/seq: last 68.119171/707, current 68.135941/708: elapsed=16769.0us expected=16846.2us +- 84.2us, error 0.5%
(kms_flip:2337) DEBUG: name = flip
last_ts = 68.135941
last_received_ts = 68.135170
last_seq = 708
current_ts = 68.152710
current_received_ts = 68.151947
current_seq = 709
count = 250
seq_step = 1
(kms_flip:2337) DEBUG: flip ts/seq: last 68.135941/708, current 68.152710/709: elapsed=16769.0us expected=16846.2us +- 84.2us, error 0.5%
(kms_flip:2337) DEBUG: name = flip
last_ts = 68.152710
last_received_ts = 68.151947
last_seq = 709
current_ts = 68.169479
current_received_ts = 68.168709
current_seq = 710
count = 251
seq_step = 1
(kms_flip:2337) DEBUG: flip ts/seq: last 68.152710/709, current 68.169479/710: elapsed=16770.0us expected=16846.2us +- 84.2us, error 0.5%
(kms_flip:2337) DEBUG: name = flip
last_ts = 68.169479
last_received_ts = 68.168709
last_seq = 710
current_ts = 68.186249
current_received_ts = 68.185471
current_seq = 711
count = 252
seq_step = 1
(kms_flip:2337) DEBUG: flip ts/seq: last 68.169479/710, current 68.186249/711: elapsed=16772.0us expected=16846.2us +- 84.2us, error 0.4%
(kms_flip:2337) DEBUG: name = flip
last_ts = 68.186249
last_received_ts = 68.185471
last_seq = 711
current_ts = 68.203018
current_received_ts = 68.202255
current_seq = 712
count = 253
seq_step = 1
(kms_flip:2337) DEBUG: flip ts/seq: last 68.186249/711, current 68.203018/712: elapsed=16767.0us expected=16846.2us +- 84.2us, error 0.5%
(kms_flip:2337) DEBUG: name = flip
last_ts = 68.203018
last_received_ts = 68.202255
last_seq = 712
current_ts = 68.219788
current_received_ts = 68.219131
current_seq = 713
count = 254
seq_step = 1
(kms_flip:2337) DEBUG: flip ts/seq: last 68.203018/712, current 68.219788/713: elapsed=16771.0us expected=16846.2us +- 84.2us, error 0.4%
(kms_flip:2337) DEBUG: name = flip
last_ts = 68.219788
last_received_ts = 68.219131
last_seq = 713
current_ts = 68.236565
current_received_ts = 68.235802
current_seq = 714
count = 255
seq_step = 1
(kms_flip:2337) DEBUG: flip ts/seq: last 68.219788/713, current 68.236565/714: elapsed=16775.0us expected=16846.2us +- 84.2us, error 0.4%
(kms_flip:2337) DEBUG: name = flip
last_ts = 68.236565
last_received_ts = 68.235802
last_seq = 714
current_ts = 68.253334
current_received_ts = 68.252525
current_seq = 715
count = 256
seq_step = 1
(kms_flip:2337) DEBUG: flip ts/seq: last 68.236565/714, current 68.253334/715: elapsed=16768.0us expected=16846.2us +- 84.2us, error 0.5%
(kms_flip:2337) DEBUG: name = flip
last_ts = 68.253334
last_received_ts = 68.252525
last_seq = 715
current_ts = 68.270103
current_received_ts = 68.269287
current_seq = 716
count = 257
seq_step = 1
(kms_flip:2337) DEBUG: flip ts/seq: last 68.253334/715, current 68.270103/716: elapsed=16774.0us expected=16846.2us +- 84.2us, error 0.4%
(kms_flip:2337) DEBUG: name = flip
last_ts = 68.270103
last_received_ts = 68.269287
last_seq = 716
current_ts = 68.286873
current_received_ts = 68.286201
current_seq = 717
count = 258
seq_step = 1
(kms_flip:2337) DEBUG: flip ts/seq: last 68.270103/716, current 68.286873/717: elapsed=16769.0us expected=16846.2us +- 84.2us, error 0.5%
(kms_flip:2337) DEBUG: name = flip
last_ts = 68.286873
last_received_ts = 68.286201
last_seq = 717
current_ts = 68.303642
current_received_ts = 68.302879
current_seq = 718
count = 259
seq_step = 1
(kms_flip:2337) DEBUG: flip ts/seq: last 68.286873/717, current 68.303642/718: elapsed=16770.0us expected=16846.2us +- 84.2us, error 0.5%
(kms_flip:2337) DEBUG: name = flip
last_ts = 68.303642
last_received_ts = 68.302879
last_seq = 718
current_ts = 68.320412
current_received_ts = 68.319603
current_seq = 719
count = 260
seq_step = 1
(kms_flip:2337) DEBUG: flip ts/seq: last 68.303642/718, current 68.320412/719: elapsed=16770.0us expected=16846.2us +- 84.2us, error 0.5%
(kms_flip:2337) DEBUG: name = flip
last_ts = 68.320412
last_received_ts = 68.319603
last_seq = 719
current_ts = 68.337181
current_received_ts = 68.336372
current_seq = 720
count = 261
seq_step = 1
(kms_flip:2337) DEBUG: flip ts/seq: last 68.320412/719, current 68.337181/720: elapsed=16767.0us expected=16846.2us +- 84.2us, error 0.5%
(kms_flip:2337) DEBUG: name = flip
last_ts = 68.337181
last_received_ts = 68.336372
last_seq = 720
current_ts = 68.353951
current_received_ts = 68.353180
current_seq = 721
count = 262
seq_step = 1
(kms_flip:2337) DEBUG: flip ts/seq: last 68.337181/720, current 68.353951/721: elapsed=16771.0us expected=16846.2us +- 84.2us, error 0.4%
(kms_flip:2337) DEBUG: name = flip
last_ts = 68.353951
last_received_ts = 68.353180
last_seq = 721
current_ts = 68.370728
current_received_ts = 68.370087
current_seq = 722
count = 263
seq_step = 1
(kms_flip:2337) DEBUG: flip ts/seq: last 68.353951/721, current 68.370728/722: elapsed=16775.0us expected=16846.2us +- 84.2us, error 0.4%
(kms_flip:2337) DEBUG: name = flip
last_ts = 68.370728
last_received_ts = 68.370087
last_seq = 722
current_ts = 68.387497
current_received_ts = 68.386711
current_seq = 723
count = 264
seq_step = 1
(kms_flip:2337) DEBUG: flip ts/seq: last 68.370728/722, current 68.387497/723: elapsed=16771.0us expected=16846.2us +- 84.2us, error 0.4%
(kms_flip:2337) DEBUG: name = flip
last_ts = 68.387497
last_received_ts = 68.386711
last_seq = 723
current_ts = 68.404266
current_received_ts = 68.403458
current_seq = 724
count = 265
seq_step = 1
(kms_flip:2337) DEBUG: flip ts/seq: last 68.387497/723, current 68.404266/724: elapsed=16771.0us expected=16846.2us +- 84.2us, error 0.4%
(kms_flip:2337) DEBUG: name = flip
last_ts = 68.404266
last_received_ts = 68.403458
last_seq = 724
current_ts = 68.421036
current_received_ts = 68.420212
current_seq = 725
count = 266
seq_step = 1
(kms_flip:2337) DEBUG: flip ts/seq: last 68.404266/724, current 68.421036/725: elapsed=16765.0us expected=16846.2us +- 84.2us, error 0.5%
(kms_flip:2337) DEBUG: name = flip
last_ts = 68.421036
last_received_ts = 68.420212
last_seq = 725
current_ts = 68.437813
current_received_ts = 68.437141
current_seq = 726
count = 267
seq_step = 1
(kms_flip:2337) DEBUG: flip ts/seq: last 68.421036/725, current 68.437813/726: elapsed=16777.0us expected=16846.2us +- 84.2us, error 0.4%
(kms_flip:2337) DEBUG: name = flip
last_ts = 68.437813
last_received_ts = 68.437141
last_seq = 726
current_ts = 68.454582
current_received_ts = 68.453789
current_seq = 727
count = 268
seq_step = 1
(kms_flip:2337) DEBUG: flip ts/seq: last 68.437813/726, current 68.454582/727: elapsed=16770.0us expected=16846.2us +- 84.2us, error 0.5%
(kms_flip:2337) DEBUG: name = flip
last_ts = 68.454582
last_received_ts = 68.453789
last_seq = 727
current_ts = 68.471352
current_received_ts = 68.470551
current_seq = 728
count = 269
seq_step = 1
(kms_flip:2337) DEBUG: flip ts/seq: last 68.454582/727, current 68.471352/728: elapsed=16770.0us expected=16846.2us +- 84.2us, error 0.5%
(kms_flip:2337) DEBUG: name = flip
last_ts = 68.471352
last_received_ts = 68.470551
last_seq = 728
current_ts = 68.488113
current_received_ts = 68.487312
current_seq = 729
count = 270
seq_step = 1
(kms_flip:2337) DEBUG: flip ts/seq: last 68.471352/728, current 68.488113/729: elapsed=16765.0us expected=16846.2us +- 84.2us, error 0.5%
(kms_flip:2337) DEBUG: name = flip
last_ts = 68.488113
last_received_ts = 68.487312
last_seq = 729
current_ts = 68.504890
current_received_ts = 68.504097
current_seq = 730
count = 271
seq_step = 1
(kms_flip:2337) DEBUG: flip ts/seq: last 68.488113/729, current 68.504890/730: elapsed=16778.0us expected=16846.2us +- 84.2us, error 0.4%
(kms_flip:2337) DEBUG: name = flip
last_ts = 68.504890
last_received_ts = 68.504097
last_seq = 730
current_ts = 68.521667
current_received_ts = 68.520859
current_seq = 731
count = 272
seq_step = 1
(kms_flip:2337) DEBUG: flip ts/seq: last 68.504890/730, current 68.521667/731: elapsed=16770.0us expected=16846.2us +- 84.2us, error 0.5%
(kms_flip:2337) DEBUG: name = flip
last_ts = 68.521667
last_received_ts = 68.520859
last_seq = 731
current_ts = 68.538437
current_received_ts = 68.537621
current_seq = 732
count = 273
seq_step = 1
(kms_flip:2337) DEBUG: flip ts/seq: last 68.521667/731, current 68.538437/732: elapsed=16771.0us expected=16846.2us +- 84.2us, error 0.4%
(kms_flip:2337) DEBUG: name = flip
last_ts = 68.538437
last_received_ts = 68.537621
last_seq = 732
current_ts = 68.555199
current_received_ts = 68.554398
current_seq = 733
count = 274
seq_step = 1
(kms_flip:2337) DEBUG: flip ts/seq: last 68.538437/732, current 68.555199/733: elapsed=16765.0us expected=16846.2us +- 84.2us, error 0.5%
(kms_flip:2337) DEBUG: name = flip
last_ts = 68.555199
last_received_ts = 68.554398
last_seq = 733
current_ts = 68.571968
current_received_ts = 68.571297
current_seq = 734
count = 275
seq_step = 1
(kms_flip:2337) DEBUG: flip ts/seq: last 68.555199/733, current 68.571968/734: elapsed=16770.0us expected=16846.2us +- 84.2us, error 0.5%
(kms_flip:2337) DEBUG: name = flip
last_ts = 68.571968
last_received_ts = 68.571297
last_seq = 734
current_ts = 68.588737
current_received_ts = 68.587959
current_seq = 735
count = 276
seq_step = 1
(kms_flip:2337) DEBUG: flip ts/seq: last 68.571968/734, current 68.588737/735: elapsed=16767.0us expected=16846.2us +- 84.2us, error 0.5%
(kms_flip:2337) DEBUG: name = flip
last_ts = 68.588737
last_received_ts = 68.587959
last_seq = 735
current_ts = 68.605492
current_received_ts = 68.604736
current_seq = 736
count = 277
seq_step = 1
(kms_flip:2337) DEBUG: flip ts/seq: last 68.588737/735, current 68.605492/736: elapsed=16758.0us expected=16846.2us +- 84.2us, error 0.5%
(kms_flip:2337) DEBUG: inconsistent flip ts/seq: last 68.588737/735, current 68.605492/736: elapsed=16758.0us expected=16846.2us
(kms_flip:2337) DEBUG: expected 66553, counted 277, encoder type 2
(kms_flip:2337) DEBUG: dropped frames, expected 66553, counted 277, encoder type 2
(kms_flip:2337) CRITICAL: Test assertion failure function __run_test_on_crtc_set, file ../tests/kms_flip.c:1674:
(kms_flip:2337) CRITICAL: Failed assertion: !retried && needs_retry_after_link_reset(mon)
(kms_flip:2337) igt_core-INFO: Stack trace:
(kms_flip:2337) igt_core-INFO:   #0 ../lib/igt_core.c:2055 __igt_fail_assert()
(kms_flip:2337) igt_core-INFO:   #1 ../tests/kms_flip.c:791 run_test_on_crtc_set.constprop.0()
(kms_flip:2337) igt_core-INFO:   #2 ../tests/kms_flip.c:1845 run_test()
(kms_flip:2337) igt_core-INFO:   #3 ../tests/kms_flip.c:2078 __igt_unique____real_main2001()
(kms_flip:2337) igt_core-INFO:   #4 ../tests/kms_flip.c:2001 main()
(kms_flip:2337) igt_core-INFO:   #5 [__libc_init_first+0x8a]
(kms_flip:2337) igt_core-INFO:   #6 [__libc_start_main+0x8b]
(kms_flip:2337) igt_core-INFO:   #7 [_start+0x25]
****  END  ****
Dynamic subtest A-eDP1: FAIL (9.475s)
Dmesg
<6> [62.213939] Console: switching to colour dummy device 80x25
<6> [62.213979] [IGT] kms_flip: executing
<7> [62.220658] xe 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] [CONNECTOR:198:DP-1]
<7> [62.220676] xe 0000:00:02.0: [drm:intel_dp_detect [xe]] [CONNECTOR:198:DP-1]
<7> [62.220799] xe 0000:00:02.0: [drm:intel_tc_port_reset_mode [xe]] Port D/TC#1: TC port mode reset (disconnected -> tbt-alt)
<7> [62.220880] xe 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] [CONNECTOR:198:DP-1] disconnected
<7> [62.221885] xe 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] [CONNECTOR:210:DP-2]
<7> [62.221897] xe 0000:00:02.0: [drm:intel_dp_detect [xe]] [CONNECTOR:210:DP-2]
<7> [62.222004] xe 0000:00:02.0: [drm:intel_tc_port_reset_mode [xe]] Port E/TC#2: TC port mode reset (disconnected -> tbt-alt)
<7> [62.222103] xe 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] [CONNECTOR:210:DP-2] disconnected
<7> [62.222346] xe 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] [CONNECTOR:218:DP-3]
<7> [62.222353] xe 0000:00:02.0: [drm:intel_dp_detect [xe]] [CONNECTOR:218:DP-3]
<7> [62.222451] xe 0000:00:02.0: [drm:intel_tc_port_reset_mode [xe]] Port F/TC#3: TC port mode reset (disconnected -> tbt-alt)
<7> [62.222525] xe 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] [CONNECTOR:218:DP-3] disconnected
<7> [62.222787] xe 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] [CONNECTOR:189:eDP-1]
<7> [62.222794] xe 0000:00:02.0: [drm:intel_dp_detect [xe]] [CONNECTOR:189:eDP-1]
<7> [62.223494] 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> [62.224019] xe 0000:00:02.0: [drm:intel_dp_print_rates [xe]] source rates: 162000, 216000, 243000, 270000, 324000, 432000, 540000, 675000, 810000
<7> [62.224107] xe 0000:00:02.0: [drm:intel_dp_print_rates [xe]] sink rates: 162000, 216000, 243000, 270000, 324000, 432000, 540000, 810000
<7> [62.224180] xe 0000:00:02.0: [drm:intel_dp_print_rates [xe]] common rates: 162000, 216000, 243000, 270000, 324000, 432000, 540000, 810000
<7> [62.224274] xe 0000:00:02.0: [drm:update_display_info.part.0] [CONNECTOR:189:eDP-1] Supported Monitor Refresh rate range is 40 Hz - 120 Hz
<5> [62.224280] [drm] DisplayID checksum invalid, remainder is 248
<5> [62.224281] [drm] DisplayID checksum invalid, remainder is 248
<7> [62.224282] xe 0000:00:02.0: [drm:update_display_info.part.0] [CONNECTOR:189:eDP-1] Assigning EDID-1.4 digital sink color depth as 10 bpc.
<5> [62.224284] [drm] DisplayID checksum invalid, remainder is 248
<7> [62.224285] xe 0000:00:02.0: [drm:update_display_info.part.0] [CONNECTOR:189:eDP-1] ELD monitor
<5> [62.224287] [drm] DisplayID checksum invalid, remainder is 248
<7> [62.224288] xe 0000:00:02.0: [drm:update_display_info.part.0] [CONNECTOR:189:eDP-1] ELD size 20, SAD count 0
<5> [62.224290] [drm] DisplayID checksum invalid, remainder is 248
<7> [62.224302] xe 0000:00:02.0: [drm:intel_dp_set_edid [xe]] [CONNECTOR:189:eDP-1] VRR capable: yes
<7> [62.224374] xe 0000:00:02.0: [drm:intel_dp_set_edid [xe]] [CONNECTOR:189:eDP-1] DFP max bpc 0, max dotclock 0, TMDS clock 0-0, PCON Max FRL BW 0Gbps
<7> [62.224999] xe 0000:00:02.0: [drm:intel_dp_set_edid [xe]] PCON ENCODER DSC DPCD: 00 00 00 00 00 00 00 00 00 00 00 00 00
<7> [62.225085] xe 0000:00:02.0: [drm:intel_dp_set_edid [xe]] [CONNECTOR:189:eDP-1] RGB->YcbCr conversion? no, YCbCr 4:2:0 allowed? yes, YCbCr 4:4:4->4:2:0 conversion? no
<5> [62.226031] [drm] DisplayID checksum invalid, remainder is 248
<5> [62.226033] [drm] DisplayID checksum invalid, remainder is 248
<5> [62.226034] [drm] DisplayID checksum invalid, remainder is 248
<7> [62.226063] xe 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] [CONNECTOR:189:eDP-1] probed modes:
<7> [62.226074] xe 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] Probed mode: "2880x1800": 60 347710 2880 2928 2960 3040 1800 1803 1809 1906 0x48 0xa
<7> [62.226094] xe 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] [CONNECTOR:198:DP-1]
<7> [62.226103] xe 0000:00:02.0: [drm:intel_dp_detect [xe]] [CONNECTOR:198:DP-1]
<7> [62.226226] xe 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] [CONNECTOR:198:DP-1] disconnected
<7> [62.226242] xe 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] [CONNECTOR:210:DP-2]
<7> [62.226249] xe 0000:00:02.0: [drm:intel_dp_detect [xe]] [CONNECTOR:210:DP-2]
<7> [62.226352] xe 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] [CONNECTOR:210:DP-2] disconnected
<7> [62.226364] xe 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] [CONNECTOR:218:DP-3]
<7> [62.226370] xe 0000:00:02.0: [drm:intel_dp_detect [xe]] [CONNECTOR:218:DP-3]
<7> [62.226460] xe 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] [CONNECTOR:218:DP-3] disconnected
<6> [62.226666] [IGT] kms_flip: starting subtest plain-flip-fb-recreate
<6> [62.227641] [IGT] kms_flip: starting dynamic subtest A-eDP1
<7> [62.228283] xe 0000:00:02.0: [drm:drm_mode_addfb2] [FB:226]
<7> [62.228524] xe 0000:00:02.0: [drm:drm_mode_addfb2] [FB:228]
<7> [62.324521] xe 0000:00:02.0: [drm:drm_mode_setcrtc] [CRTC:82:pipe A]
<7> [62.324767] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:82:pipe A] fastset requirement not met in hw.enable (expected yes, found no)
<7> [62.325074] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:82:pipe A] fastset requirement not met in hw.active (expected yes, found no)
<7> [62.325291] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:82:pipe A] fastset requirement not met in cpu_transcoder (expected 0, found -1)
<7> [62.325503] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:82:pipe A] fastset requirement not met in lane_count (expected 4, found 0)
<7> [62.325736] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:82: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> [62.325938] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:82:pipe A] fastset requirement not met in output_types (expected 0x00000100, found 0x00000000)
<7> [62.326136] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:82:pipe A] fastset requirement not met in framestart_delay (expected 1, found 0)
<7> [62.326356] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:82:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hdisplay (expected 2880, found 0)
<7> [62.326552] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:82:pipe A] fastset requirement not met in hw.pipe_mode.crtc_htotal (expected 3040, found 0)
<7> [62.326732] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:82:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hblank_start (expected 2880, found 0)
<7> [62.326908] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:82:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hblank_end (expected 3040, found 0)
<7> [62.327104] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:82:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hsync_start (expected 2928, found 0)
<7> [62.327292] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:82:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hsync_end (expected 2960, found 0)
<7> [62.327456] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:82:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vdisplay (expected 1800, found 0)
<7> [62.327699] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:82:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vblank_start (expected 1800, found 0)
<7> [62.327860] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:82:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vsync_start (expected 1803, found 0)
<7> [62.328019] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:82:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vsync_end (expected 1809, found 0)
<7> [62.328176] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:82:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vtotal (expected 1906, found 0)
<7> [62.328347] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:82:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vblank_end (expected 1906, found 0)
<7> [62.328526] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:82:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hdisplay (expected 2880, found 0)
<7> [62.328667] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:82:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_htotal (expected 3040, found 0)
<7> [62.328806] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:82:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hblank_start (expected 2880, found 0)
<7> [62.328942] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:82:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hblank_end (expected 3040, found 0)
<7> [62.329072] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:82:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hsync_start (expected 2928, found 0)
<7> [62.329200] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:82:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hsync_end (expected 2960, found 0)
<7> [62.329323] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:82:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vdisplay (expected 1800, found 0)
<7> [62.329444] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:82:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vblank_start (expected 1800, found 0)
<7> [62.329591] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:82:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vsync_start (expected 1803, found 0)
<7> [62.329713] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:82:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vsync_end (expected 1809, found 0)
<7> [62.329833] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:82:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vtotal (expected 1906, found 0)
<7> [62.329967] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:82:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vblank_end (expected 1906, found 0)
<7> [62.330103] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:82:pipe A] fastset requirement not met in pixel_multiplier (expected 1, found 0)
<7> [62.330221] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:82:pipe A] fastset requirement not met in hw.adjusted_mode.flags (2) (expected 2, found 0)
<7> [62.330330] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:82:pipe A] fastset requirement not met in hw.adjusted_mode.flags (8) (expected 8, found 0)
<7> [62.330444] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:82:pipe A] fastset requirement not met in pipe_bpp (expected 30, found 0)
<7> [62.330571] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:82:pipe A] fastset requirement not met in hw.pipe_mode.crtc_clock (expected 347710, found 0)
<7> [62.330678] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:82:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_clock (expected 347710, found 0)
<7> [62.330789] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:82:pipe A] fastset requirement not met in port_clock (expected 432000, found 0)
<7> [62.330895] xe 0000:00:02.0: [drm:intel_atomic_check [xe]] [CRTC:82:pipe A] fastset requirement not met, forcing full modeset
<7> [62.331045] xe 0000:00:02.0: [drm:skl_compute_wm [xe]] Enabled dbuf slices 0xf -> 0x1 (total dbuf slices 0xf), mbus joined? yes->no
<7> [62.331140] xe 0000:00:02.0: [drm:skl_compute_wm [xe]] [CRTC:82:pipe A] dbuf slices 0xf -> 0x0, ddb (0 - 4096) -> (0 - 0), active pipes 0x1 -> 0x0
<7> [62.331287] xe 0000:00:02.0: [drm:skl_compute_wm [xe]] [PLANE:32:plane 1A] ddb ( 0 - 4054) -> ( 0 - 0), size 4054 -> 0
<7> [62.331377] xe 0000:00:02.0: [drm:skl_compute_wm [xe]] [PLANE:77:cursor A] ddb (4054 - 4096) -> ( 0 - 0), size 42 -> 0
<7> [62.331475] xe 0000:00:02.0: [drm:skl_compute_wm [xe]] [PLANE:32: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> [62.331562] xe 0000:00:02.0: [drm:skl_compute_wm [xe]] [PLANE:32:plane 1A] lines 1, 12, 12, 12, 11, 12, 0, 0, 0, 3, 0 -> 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0
<7> [62.331644] xe 0000:00:02.0: [drm:skl_compute_wm [xe]] [PLANE:32:plane 1A] blocks 24, 289, 289, 289, 265, 289, 0, 0, 38, 73, 87 -> 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0
<7> [62.331734] xe 0000:00:02.0: [drm:skl_compute_wm [xe]] [PLANE:32:plane 1A] min_ddb 28, 319, 319, 319, 293, 319, 0, 0, 39, 82, 88 -> 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0
<7> [62.331829] xe 0000:00:02.0: [drm:intel_bw_atomic_check [xe]] [CRTC:82:pipe A] data rate 0 num active planes 0
<7> [62.331950] xe 0000:00:02.0: [drm:intel_bw_atomic_check [xe]] QGV point 0: max bw 23530 required 0 qgv_peak_bw: 38400
<7> [62.332050] xe 0000:00:02.0: [drm:intel_bw_atomic_check [xe]] QGV point 1: max bw 36260 required 0 qgv_peak_bw: 38400
<7> [62.332148] xe 0000:00:02.0: [drm:intel_bw_atomic_check [xe]] QGV point 2: max bw 38000 required 0 qgv_peak_bw: 38400
<7> [62.332243] xe 0000:00:02.0: [drm:intel_bw_atomic_check [xe]] QGV point 3: max bw 38000 required 0 qgv_peak_bw: 38400
<7> [62.332347] xe 0000:00:02.0: [drm:intel_bw_atomic_check [xe]] Matching peaks QGV bw: 38400 for required data rate: 0
<7> [62.332467] xe 0000:00:02.0: [drm:intel_modeset_calc_cdclk [xe]] Can change cdclk via squashing
<7> [62.332569] xe 0000:00:02.0: [drm:intel_modeset_calc_cdclk [xe]] New cdclk calculated to be logical 153600 kHz, actual 153600 kHz
<7> [62.332658] xe 0000:00:02.0: [drm:intel_modeset_calc_cdclk [xe]] New voltage level calculated to be logical 0, actual 0
<7> [62.332768] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [CRTC:82:pipe A] enable: no [modeset]
<7> [62.332873] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [PLANE:32:plane 1A] fb: [NOFB], visible: no
<7> [62.332978] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [PLANE:41:plane 2A] fb: [NOFB], visible: no
<7> [62.333074] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [PLANE:50:plane 3A] fb: [NOFB], visible: no
<7> [62.333160] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [PLANE:59:plane 4A] fb: [NOFB], visible: no
<7> [62.333245] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [PLANE:68:plane 5A] fb: [NOFB], visible: no
<7> [62.333327] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [PLANE:77:cursor A] fb: [NOFB], visible: no
<7> [62.333471] xe 0000:00:02.0: [drm:intel_power_well_enable [xe]] enabling DC_off
<7> [62.334186] xe 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [xe]] Setting DC state from 02 to 00
<7> [62.334316] xe 0000:00:02.0: [drm:intel_psr_disable_locked [xe]] Disabling PSR2
<7> [62.351286] xe 0000:00:02.0: [drm:intel_edp_backlight_off [xe]]
<7> [62.552426] xe 0000:00:02.0: [drm:intel_backlight_set_pwm_level [xe]] [CONNECTOR:189:eDP-1] set backlight PWM = 0
<7> [62.552698] xe 0000:00:02.0: [drm:intel_disable_transcoder [xe]] disabling pipe A
<7> [62.573315] xe 0000:00:02.0: [drm:intel_pps_off_unlocked [xe]] [ENCODER:188:DDI A/PHY A] PPS 0 turn panel power off
<7> [62.573388] xe 0000:00:02.0: [drm:icp_irq_handler [xe]] hotplug event received, stat 0x00010000, dig 0x00000009, pins 0x00000010, long 0x00000000
<7> [62.573590] xe 0000:00:02.0: [drm:intel_pps_off_unlocked [xe]] [ENCODER:188:DDI A/PHY A] PPS 0 wait for panel power off time
<7> [62.573703] xe 0000:00:02.0: [drm:intel_hpd_irq_handler [xe]] digital hpd on [ENCODER:188:DDI A/PHY A] - short
<7> [62.573854] xe 0000:00:02.0: [drm:wait_panel_status [xe]] [ENCODER:188:DDI A/PHY A] PPS 0 mask: 0xb0000000 value: 0x00000000 PP_STATUS: 0xa0000002 PP_CONTROL: 0x00000060
<7> [62.626275] xe 0000:00:02.0: [drm:icp_irq_handler [xe]] hotplug event received, stat 0x00010000, dig 0x00000009, pins 0x00000010, long 0x00000000
<7> [62.626444] xe 0000:00:02.0: [drm:intel_hpd_irq_handler [xe]] digital hpd on [ENCODER:188:DDI A/PHY A] - short
<7> [62.656331] xe 0000:00:02.0: [drm:wait_panel_status [xe]] Wait complete
<7> [62.656685] xe 0000:00:02.0: [drm:intel_dp_hpd_pulse [xe]] ignoring short hpd on eDP [ENCODER:188:DDI A/PHY A]
<7> [62.656732] xe 0000:00:02.0: [drm:intel_power_well_disable [xe]] disabling AUX_A
<7> [62.657133] xe 0000:00:02.0: [drm:intel_dp_hpd_pulse [xe]] ignoring short hpd on eDP [ENCODER:188:DDI A/PHY A]
<7> [62.657111] xe 0000:00:02.0: [drm:__intel_fbc_disable [xe]] Disabling FBC on [PLANE:32:plane 1A]
<7> [62.657624] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:188:DDI A/PHY A]
<7> [62.657871] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:197:DDI TC1/PHY TC1]
<7> [62.658120] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:199:DP-MST A]
<7> [62.658340] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:200:DP-MST B]
<7> [62.658604] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:201:DP-MST C]
<7> [62.658823] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:209:DDI TC2/PHY TC2]
<7> [62.659053] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:211:DP-MST A]
<7> [62.659253] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:212:DP-MST B]
<7> [62.659451] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:213:DP-MST C]
<7> [62.659647] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:217:DDI TC3/PHY TC3]
<7> [62.659841] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:219:DP-MST A]
<7> [62.660047] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:220:DP-MST B]
<7> [62.660238] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:221:DP-MST C]
<7> [62.660428] xe 0000:00:02.0: [drm:verify_connector_state [xe]] [CONNECTOR:189:eDP-1]
<7> [62.660652] xe 0000:00:02.0: [drm:intel_dbuf_mdclk_cdclk_ratio_update [xe]] Updating dbuf ratio to 4 (mbus joined: no)
<7> [62.660857] xe 0000:00:02.0: [drm:intel_dbuf_mbus_join_update [xe]] Changing mbus joined: yes -> no (pipe: *)
<7> [62.661071] 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> [62.661404] xe 0000:00:02.0: [drm:intel_dbuf_mdclk_cdclk_ratio_update [xe]] Updating dbuf ratio to 4 (mbus joined: no)
<7> [62.661641] xe 0000:00:02.0: [drm:intel_audio_cdclk_change_post.part.0 [xe]] aud_ts_cdclk set to M=60, N=384
<7> [62.661898] xe 0000:00:02.0: [drm:gen9_dbuf_slices_update [xe]] Updating dbuf slices to 0x1
<7> [62.662284] xe 0000:00:02.0: [drm:intel_power_well_disable [xe]] disabling PW_A
<7> [62.662613] xe 0000:00:02.0: [drm:icp_irq_handler [xe]] hotplug event received, stat 0x00010000, dig 0x0000000a, pins 0x00000010, long 0x00000010
<7> [62.662767] xe 0000:00:02.0: [drm:intel_hpd_irq_handler [xe]] digital hpd on [ENCODER:188:DDI A/PHY A] - long
<7> [62.662913] xe 0000:00:02.0: [drm:intel_hpd_irq_handler [xe]] Received HPD interrupt on PIN 4 - cnt: 10
<7> [62.663071] xe 0000:00:02.0: [drm:intel_dp_hpd_pulse [xe]] ignoring long hpd on eDP [ENCODER:188:DDI A/PHY A]
<7> [62.663167] xe 0000:00:02.0: [drm:intel_modeset_verify_crtc [xe]] [CRTC:82:pipe A]
<7> [62.663517] xe 0000:00:02.0: [drm:drm_mode_setcrtc] [CRTC:134:pipe B]
<7> [62.663852] xe 0000:00:02.0: [drm:drm_mode_setcrtc] [CRTC:186:pipe C]
<7> [62.664079] xe 0000:00:02.0: [drm:drm_mode_setcrtc] [CRTC:82:pipe A]
<7> [62.664142] xe 0000:00:02.0: [drm:drm_mode_setcrtc] [CONNECTOR:189:eDP-1]
<7> [62.664311] xe 0000:00:02.0: [drm:intel_atomic_check [xe]] [CONNECTOR:189:eDP-1] Limiting display bpp to 30 (EDID bpp 30, max requested bpp 36, max platform bpp 36)
<7> [62.664599] xe 0000:00:02.0: [drm:intel_dp_compute_config_limits [xe]] [ENCODER:188:DDI A/PHY A][CRTC:82: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> [62.664851] 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> [62.665176] xe 0000:00:02.0: [drm:intel_atomic_check [xe]] [CRTC:82:pipe A] hw max bpp: 30, pipe bpp: 30, dithering: 0
<7> [62.665501] xe 0000:00:02.0: [drm:intel_ddi_compute_config_late [xe]] [ENCODER:188:DDI A/PHY A] [CRTC:82:pipe A]
<7> [62.665793] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:82:pipe A] fastset requirement not met in hw.enable (expected no, found yes)
<7> [62.666142] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:82:pipe A] fastset requirement not met in hw.active (expected no, found yes)
<7> [62.666408] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:82:pipe A] fastset requirement not met in cpu_transcoder (expected -1, found 0)
<7> [62.666654] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:82:pipe A] fastset requirement not met in lane_count (expected 0, found 4)
<7> [62.666893] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:82: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> [62.667158] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:82:pipe A] fastset requirement not met in output_types (expected 0x00000000, found 0x00000100)
<7> [62.667413] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:82:pipe A] fastset requirement not met in framestart_delay (expected 0, found 1)
<7> [62.667618] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:82:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hdisplay (expected 0, found 2880)
<7> [62.667823] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:82:pipe A] fastset requirement not met in hw.pipe_mode.crtc_htotal (expected 0, found 3040)
<7> [62.668092] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:82:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hblank_start (expected 0, found 2880)
<7> [62.668286] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:82:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hblank_end (expected 0, found 3040)
<7> [62.668491] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:82:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hsync_start (expected 0, found 2928)
<7> [62.668686] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:82:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hsync_end (expected 0, found 2960)
<7> [62.668867] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:82:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vdisplay (expected 0, found 1800)
<7> [62.669069] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:82:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vblank_start (expected 0, found 1800)
<7> [62.669244] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:82:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vsync_start (expected 0, found 1803)
<7> [62.669434] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:82:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vsync_end (expected 0, found 1809)
<7> [62.669613] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:82:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vtotal (expected 0, found 1906)
<7> [62.669773] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:82:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vblank_end (expected 0, found 1906)
<7> [62.669944] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:82:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hdisplay (expected 0, found 2880)
<7> [62.670121] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:82:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_htotal (expected 0, found 3040)
<7> [62.670277] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:82:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hblank_start (expected 0, found 2880)
<7> [62.670420] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:82:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hblank_end (expected 0, found 3040)
<7> [62.670560] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:82:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hsync_start (expected 0, found 2928)
<7> [62.670698] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:82:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hsync_end (expected 0, found 2960)
<7> [62.670838] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:82:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vdisplay (expected 0, found 1800)
<7> [62.670993] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:82:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vblank_start (expected 0, found 1800)
<7> [62.671125] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:82:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vsync_start (expected 0, found 1803)
<7> [62.671251] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:82:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vsync_end (expected 0, found 1809)
<7> [62.671375] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:82:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vtotal (expected 0, found 1906)
<7> [62.671498] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:82:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vblank_end (expected 0, found 1906)
<7> [62.671622] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:82:pipe A] fastset requirement not met in pixel_multiplier (expected 0, found 1)
<7> [62.671740] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:82:pipe A] fastset requirement not met in hw.adjusted_mode.flags (2) (expected 0, found 2)
<7> [62.671857] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:82:pipe A] fastset requirement not met in hw.adjusted_mode.flags (8) (expected 0, found 8)
<7> [62.672001] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:82:pipe A] fastset requirement not met in pipe_bpp (expected 0, found 30)
<7> [62.672115] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:82:pipe A] fastset requirement not met in hw.pipe_mode.crtc_clock (expected 0, found 347710)
<7> [62.672239] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:82:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_clock (expected 0, found 347710)
<7> [62.672367] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:82:pipe A] fastset requirement not met in port_clock (expected 0, found 432000)
<7> [62.672475] xe 0000:00:02.0: [drm:intel_atomic_check [xe]] [CRTC:82:pipe A] fastset requirement not met, forcing full modeset
<7> [62.672798] xe 0000:00:02.0: [drm:skl_compute_wm [xe]] Enabled dbuf slices 0x1 -> 0xf (total dbuf slices 0xf), mbus joined? no->yes
<7> [62.672913] xe 0000:00:02.0: [drm:skl_compute_wm [xe]] [CRTC:82:pipe A] dbuf slices 0x0 -> 0xf, ddb (0 - 0) -> (0 - 4096), active pipes 0x0 -> 0x1
<7> [62.673053] xe 0000:00:02.0: [drm:skl_compute_wm [xe]] [PLANE:32:plane 1A] ddb ( 0 - 0) -> ( 0 - 4054), size 0 -> 4054
<7> [62.673163] xe 0000:00:02.0: [drm:skl_compute_wm [xe]] [PLANE:77:cursor A] ddb ( 0 - 0) -> (4054 - 4096), size 0 -> 42
<7> [62.673258] xe 0000:00:02.0: [drm:skl_compute_wm [xe]] [PLANE:32: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> [62.673345] xe 0000:00:02.0: [drm:skl_compute_wm [xe]] [PLANE:32:plane 1A] lines 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0 -> 1, 12, 12, 12, 11, 12, 0, 0, 0, 3, 0
<7> [62.673429] xe 0000:00:02.0: [drm:skl_compute_wm [xe]] [PLANE:32:plane 1A] blocks 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0 -> 24, 289, 289, 289, 265, 289, 0, 0, 38, 73, 87
<7> [62.673513] xe 0000:00:02.0: [drm:skl_compute_wm [xe]] [PLANE:32:plane 1A] min_ddb 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0 -> 28, 319, 319, 319, 293, 319, 0, 0, 39, 82, 88
<7> [62.673596] xe 0000:00:02.0: [drm:intel_bw_atomic_check [xe]] [CRTC:82:pipe A] data rate 1390840 num active planes 1
<7> [62.673704] xe 0000:00:02.0: [drm:intel_bw_atomic_check [xe]] QGV point 0: max bw 23530 required 1461 qgv_peak_bw: 38400
<7> [62.673811] xe 0000:00:02.0: [drm:intel_bw_atomic_check [xe]] QGV point 1: max bw 36260 required 1461 qgv_peak_bw: 38400
<7> [62.673947] xe 0000:00:02.0: [drm:intel_bw_atomic_check [xe]] QGV point 2: max bw 38000 required 1461 qgv_peak_bw: 38400
<7> [62.674053] xe 0000:00:02.0: [drm:intel_bw_atomic_check [xe]] QGV point 3: max bw 38000 required 1461 qgv_peak_bw: 38400
<7> [62.674154] xe 0000:00:02.0: [drm:intel_bw_atomic_check [xe]] Matching peaks QGV bw: 38400 for required data rate: 1461
<7> [62.674254] xe 0000:00:02.0: [drm:intel_plane_calc_min_cdclk [xe]] [PLANE:32:plane 1A] min cdclk (173855 kHz) > [CRTC:82:pipe A] min cdclk (0 kHz)
<7> [62.674353] xe 0000:00:02.0: [drm:intel_bw_calc_min_cdclk [xe]] new bandwidth min cdclk (27165 kHz) > old min cdclk (0 kHz)
<7> [62.674450] xe 0000:00:02.0: [drm:intel_modeset_calc_cdclk [xe]] Can change cdclk via squashing
<7> [62.674542] xe 0000:00:02.0: [drm:intel_modeset_calc_cdclk [xe]] New cdclk calculated to be logical 192000 kHz, actual 192000 kHz
<7> [62.674632] xe 0000:00:02.0: [drm:intel_modeset_calc_cdclk [xe]] New voltage level calculated to be logical 0, actual 0
<7> [62.674740] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [CRTC:82:pipe A] enable: yes [modeset]
<7> [62.674855] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] active: yes, output_types: EDP (0x100), output format: RGB, sink format: RGB
<7> [62.674955] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] cpu_transcoder: A, pipe bpp: 30, dithering: 0
<7> [62.675043] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] MST master transcoder: <invalid>
<7> [62.675127] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] port sync: master transcoder: <invalid>, slave transcoder bitmask = 0x0
<7> [62.675212] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] joiner: no, pipes: 0x0
<7> [62.675296] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] splitter: disabled, link count 0, overlap 0
<7> [62.675377] 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> [62.675457] 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> [62.675537] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] fec: disabled, enhanced framing: disabled
<7> [62.675617] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] sdp split: disabled
<7> [62.675693] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] psr: enabled, selective update: enabled, panel replay: disabled, selective fetch: enabled
<7> [62.675767] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] minimum HBlank: 0
<7> [62.675849] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] audio: 0, infoframes: 0, infoframes enabled: 0x4
<7> [62.675924] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] DP SDP: VSC, revision 4, length 14
<7> [62.676000] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] pixelformat: RGB
<7> [62.676075] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] colorimetry: sRGB
<7> [62.676148] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] bpc: 0
<7> [62.676218] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] dynamic range: VESA range
<7> [62.676284] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] content type: Not defined
<7> [62.676350] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] scanline offset: 1
<7> [62.676415] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] vblank delay: 0, framestart delay: 1, MSA timing delay: 0
<7> [62.676479] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] vrr: no, vmin: 1906, vmax: 2859, flipline: 1906, pipeline full: 0, guardband: 106 vsync start: 103, vsync end: 97
<7> [62.676543] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] vrr: vmin vblank: 1800, vmax vblank: 2753, vmin vtotal: 1906, vmax vtotal: 2859
<7> [62.676608] 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> [62.676670] 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> [62.676732] 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> [62.676793] 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> [62.676875] 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> [62.676949] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] port clock: 432000, pipe src: 2880x1800+0+0, pixel rate 347710
<7> [62.677022] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] linetime: 70, ips linetime: 0
<7> [62.677093] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] num_scalers: 2, scaler_users: 0x0, scaler_id: -1, scaling_filter: 0
<7> [62.677164] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] pch pfit: 0x0+0+0, disabled, force thru: no
<7> [62.677231] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] ips: 0, double wide: 0, drrs: 0
<7> [62.677288] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] dpll_hw_state: dpll: 0x69780, dpll_md: 0x42110, fp0: 0x1a2, fp1: 0x1000000
<7> [62.677344] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] csc_mode: 0x0 gamma_mode: 0x0 gamma_enable: 0 csc_enable: 0
<7> [62.677400] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] pre csc lut: 0 entries, post csc lut: 0 entries
<7> [62.677455] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] output csc: pre offsets: 0x0000 0x0000 0x0000
<7> [62.677511] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] output csc: coefficients: 0x0000 0x0000 0x0000
<7> [62.677565] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] output csc: coefficients: 0x0000 0x0000 0x0000
<7> [62.677618] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] output csc: coefficients: 0x0000 0x0000 0x0000
<7> [62.677675] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] output csc: post offsets: 0x0000 0x0000 0x0000
<7> [62.677734] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] pipe csc: pre offsets: 0x0000 0x0000 0x0000
<7> [62.677797] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] pipe csc: coefficients: 0x0000 0x0000 0x0000
<7> [62.677868] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] pipe csc: coefficients: 0x0000 0x0000 0x0000
<7> [62.677941] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] pipe csc: coefficients: 0x0000 0x0000 0x0000
<7> [62.678015] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] pipe csc: post offsets: 0x0000 0x0000 0x0000
<7> [62.678089] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [PLANE:32:plane 1A] fb: [FB:226] 2880x1800 format = XR24 little-endian (0x34325258) modifier = 0x0, visible: yes
<7> [62.678148] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] rotation: 0x1, scaler: -1, scaling_filter: 0
<7> [62.678203] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] src: 2880.000000x1800.000000+0.000000+0.000000 dst: 2880x1800+0+0
<7> [62.678259] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [PLANE:41:plane 2A] fb: [NOFB], visible: no
<7> [62.678313] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [PLANE:50:plane 3A] fb: [NOFB], visible: no
<7> [62.678369] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [PLANE:59:plane 4A] fb: [NOFB], visible: no
<7> [62.678424] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [PLANE:68:plane 5A] fb: [NOFB], visible: no
<7> [62.678478] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [PLANE:77:cursor A] fb: [NOFB], visible: no
<7> [62.680737] xe 0000:00:02.0: [drm:intel_power_well_enable [xe]] enabling PW_A
<7> [62.680910] 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> [62.681011] xe 0000:00:02.0: [drm:intel_dbuf_mdclk_cdclk_ratio_update [xe]] Updating dbuf ratio to 4 (mbus joined: no)
<7> [62.681109] xe 0000:00:02.0: [drm:intel_audio_cdclk_change_post.part.0 [xe]] aud_ts_cdclk set to M=60, N=480
<7> [62.681170] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:188:DDI A/PHY A]
<7> [62.681226] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:197:DDI TC1/PHY TC1]
<7> [62.681283] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:199:DP-MST A]
<7> [62.681338] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:200:DP-MST B]
<7> [62.681392] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:201:DP-MST C]
<7> [62.681445] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:209:DDI TC2/PHY TC2]
<7> [62.681498] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:211:DP-MST A]
<7> [62.681551] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:212:DP-MST B]
<7> [62.681602] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:213:DP-MST C]
<7> [62.681653] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:217:DDI TC3/PHY TC3]
<7> [62.681704] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:219:DP-MST A]
<7> [62.681770] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:220:DP-MST B]
<7> [62.681838] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:221:DP-MST C]
<7> [62.681905] xe 0000:00:02.0: [drm:gen9_dbuf_slices_update [xe]] Updating dbuf slices to 0xf
<7> [62.682064] xe 0000:00:02.0: [drm:intel_dbuf_mbus_join_update [xe]] Changing mbus joined: no -> yes (pipe: *)
<7> [62.682133] xe 0000:00:02.0: [drm:intel_dbuf_mdclk_cdclk_ratio_update [xe]] Updating dbuf ratio to 8 (mbus joined: yes)
<7> [62.682206] xe 0000:00:02.0: [drm:intel_power_well_enable [xe]] enabling AUX_A
<7> [62.683623] xe 0000:00:02.0: [drm:intel_pps_on_unlocked [xe]] [ENCODER:188:DDI A/PHY A] PPS 0 turn panel power on
<7> [62.683716] xe 0000:00:02.0: [drm:wait_panel_power_cycle [xe]] [ENCODER:188:DDI A/PHY A] PPS 0 wait for panel power cycle (473 ms remaining)
<7> [63.153262] xe 0000:00:02.0: [drm:wait_panel_status [xe]] [ENCODER:188:DDI A/PHY A] PPS 0 mask: 0xb800000f value: 0x00000000 PP_STATUS: 0x08000001 PP_CONTROL: 0x00000060
<7> [63.216567] xe 0000:00:02.0: [drm:wait_panel_status [xe]] Wait complete
<7> [63.216866] xe 0000:00:02.0: [drm:intel_pps_on_unlocked [xe]] [ENCODER:188:DDI A/PHY A] PPS 0 wait for panel power on
<7> [63.217169] xe 0000:00:02.0: [drm:wait_panel_status [xe]] [ENCODER:188:DDI A/PHY A] PPS 0 mask: 0xb000000f value: 0x80000008 PP_STATUS: 0x9000000a PP_CONTROL: 0x00000063
<7> [63.253518] xe 0000:00:02.0: [drm:icp_irq_handler [xe]] hotplug event received, stat 0x00010000, dig 0x0000000a, pins 0x00000010, long 0x00000010
<7> [63.253787] xe 0000:00:02.0: [drm:intel_hpd_irq_handler [xe]] digital hpd on [ENCODER:188:DDI A/PHY A] - long
<7> [63.254004] xe 0000:00:02.0: [drm:intel_hpd_irq_handler [xe]] Received HPD interrupt on PIN 4 - cnt: 20
<7> [63.254240] xe 0000:00:02.0: [drm:intel_dp_hpd_pulse [xe]] ignoring long hpd on eDP [ENCODER:188:DDI A/PHY A]
<7> [63.256751] xe 0000:00:02.0: [drm:intel_tc_port_reset_mode [xe]] Port F/TC#3: TC port mode reset (tbt-alt -> disconnected)
<7> [63.256868] xe 0000:00:02.0: [drm:intel_tc_port_reset_mode [xe]] Port E/TC#2: TC port mode reset (tbt-alt -> disconnected)
<7> [63.256901] xe 0000:00:02.0: [drm:intel_tc_port_reset_mode [xe]] Port D/TC#1: TC port mode reset (tbt-alt -> disconnected)
<7> [63.522729] xe 0000:00:02.0: [drm:wait_panel_status [xe]] Wait complete
<7> [63.525422] xe 0000:00:02.0: [drm:intel_pps_vdd_on_unlocked [xe]] [ENCODER:188:DDI A/PHY A] PPS 0 turning VDD on
<7> [63.525950] xe 0000:00:02.0: [drm:intel_pps_vdd_on_unlocked [xe]] [ENCODER:188:DDI A/PHY A] PPS 0 PP_STATUS: 0x80000008 PP_CONTROL: 0x0000006b
<7> [63.529739] 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> [63.531110] xe 0000:00:02.0: [drm:intel_dp_start_link_train [xe]] [CONNECTOR:189:eDP-1][ENCODER:188:DDI A/PHY A][DPRX] Reloading eDP link rates
<7> [63.532446] xe 0000:00:02.0: [drm:intel_dp_start_link_train [xe]] [CONNECTOR:189:eDP-1][ENCODER:188:DDI A/PHY A][DPRX] Using LINK_RATE_SET value 05
<7> [63.533824] xe 0000:00:02.0: [drm:intel_dp_set_signal_levels [xe]] [CONNECTOR:189:eDP-1][ENCODER:188:DDI A/PHY A][DPRX] 8b/10b, lanes: 4, vswing levels: 0/0/0/0, pre-emphasis levels: 0/0/0/0
<7> [63.535093] xe 0000:00:02.0: [drm:intel_dp_program_link_training_pattern [xe]] [CONNECTOR:189:eDP-1][ENCODER:188:DDI A/PHY A][DPRX] Using DP training pattern TPS1
<7> [63.536556] xe 0000:00:02.0: [drm:intel_dp_link_train_phy [xe]] [CONNECTOR:189:eDP-1][ENCODER:188:DDI A/PHY A][DPRX] Clock recovery OK
<7> [63.536921] xe 0000:00:02.0: [drm:intel_dp_program_link_training_pattern [xe]] [CONNECTOR:189:eDP-1][ENCODER:188:DDI A/PHY A][DPRX] Using DP training pattern TPS4
<7> [63.538711] xe 0000:00:02.0: [drm:intel_dp_link_train_phy [xe]] [CONNECTOR:189:eDP-1][ENCODER:188:DDI A/PHY A][DPRX] Channel EQ done. DP Training successful
<7> [63.539068] xe 0000:00:02.0: [drm:intel_dp_link_train_phy [xe]] [CONNECTOR:189:eDP-1][ENCODER:188:DDI A/PHY A][DPRX] Link Training passed at link rate = 432000, lane count = 4
<7> [63.539953] xe 0000:00:02.0: [drm:intel_enable_transcoder [xe]] enabling pipe A
<7> [63.540500] xe 0000:00:02.0: [drm:intel_edp_backlight_on [xe]]
<7> [63.540870] xe 0000:00:02.0: [drm:intel_backlight_enable [xe]] pipe A
<7> [63.541369] xe 0000:00:02.0: [drm:intel_backlight_set_pwm_level [xe]] [CONNECTOR:189:eDP-1] set backlight PWM = 13892
<7> [63.543478] xe 0000:00:02.0: [drm:intel_fbc_update [xe]] reserved 10600448 bytes of contiguous stolen space for FBC, limit: 2
<7> [63.543809] xe 0000:00:02.0: [drm:intel_fbc_update [xe]] Enabling FBC on [PLANE:32:plane 1A]
<7> [63.557345] xe 0000:00:02.0: [drm:intel_psr_post_plane_update [xe]] Enabling PSR2
<7> [63.559146] xe 0000:00:02.0: [drm:verify_connector_state [xe]] [CONNECTOR:189:eDP-1]
<7> [63.559512] xe 0000:00:02.0: [drm:intel_modeset_verify_crtc [xe]] [CRTC:82:pipe A]
<7> [63.579847] xe 0000:00:02.0: [drm:intel_power_well_disable [xe]] disabling DC_off
<7> [63.580207] xe 0000:00:02.0: [drm:skl_enable_dc6 [xe]] Enabling DC6
<7> [63.580514] xe 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [xe]] Setting DC state from 00 to 02
<7> [63.845126] xe 0000:00:02.0: [drm:intel_power_well_enable [xe]] enabling DC_off
<7> [63.845478] xe 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [xe]] Setting DC state from 02 to 00
<7> [63.857502] xe 0000:00:02.0: [drm:drm_mode_addfb2] [FB:225]
<7> [63.858282] xe 0000:00:02.0: [drm:drm_mode_rmfb_work_fn] Removing [FB:226] from all active usage due to RMFB ioctl
<7> [63.874096] xe 0000:00:02.0: [drm:drm_mode_addfb2] [FB:226]
<7> [63.874153] xe 0000:00:02.0: [drm:drm_mode_rmfb_work_fn] Removing [FB:228] from all active usage due to RMFB ioctl
<7> [63.890753] xe 0000:00:02.0: [drm:drm_mode_addfb2] [FB:228]
<7> [63.890800] xe 0000:00:02.0: [drm:drm_mode_rmfb_work_fn] Removing [FB:225] from all active usage due to RMFB ioctl
<7> [63.907387] xe 0000:00:02.0: [drm:drm_mode_addfb2] [FB:225]
<7> [63.907441] xe 0000:00:02.0: [drm:drm_mode_rmfb_work_fn] Removing [FB:226] from all active usage due to RMFB ioctl
<7> [63.924123] xe 0000:00:02.0: [drm:drm_mode_addfb2] [FB:226]
<7> [63.924190] xe 0000:00:02.0: [drm:drm_mode_rmfb_work_fn] Removing [FB:228] from all active usage due to RMFB ioctl
<7> [63.940821] xe 0000:00:02.0: [drm:drm_mode_addfb2] [FB:228]
<7> [63.940876] xe 0000:00:02.0: [drm:drm_mode_rmfb_work_fn] Removing [FB:225] from all active usage due to RMFB ioctl
<7> [63.957463] xe 0000:00:02.0: [drm:drm_mode_addfb2] [FB:225]
<7> [63.957508] xe 0000:00:02.0: [drm:drm_mode_rmfb_work_fn] Removing [FB:226] from all active usage due to RMFB ioctl
<7> [63.974105] xe 0000:00:02.0: [drm:drm_mode_addfb2] [FB:226]
<7> [63.974161] xe 0000:00:02.0: [drm:drm_mode_rmfb_work_fn] Removing [FB:228] from all active usage due to RMFB ioctl
<7> [63.990709] xe 0000:00:02.0: [drm:drm_mode_addfb2] [FB:228]
<7> [63.990754] xe 0000:00:02.0: [drm:drm_mode_rmfb_work_fn] Removing [FB:225] from all active usage due to RMFB ioctl
<7> [64.007410] xe 0000:00:02.0: [drm:drm_mode_addfb2] [FB:225]
<7> [64.007465] xe 0000:00:02.0: [drm:drm_mode_rmfb_work_fn] Removing [FB:226] from all active usage due to RMFB ioctl
<7> [64.024129] xe 0000:00:02.0: [drm:drm_mode_addfb2] [FB:226]
<7> [64.024184] xe 0000:00:02.0: [drm:drm_mode_rmfb_work_fn] Removing [FB:228] from all active usage due to RMFB ioctl
<7> [64.040816] xe 0000:00:02.0: [drm:drm_mode_addfb2] [FB:228]
<7> [64.040871] xe 0000:00:02.0: [drm:drm_mode_rmfb_work_fn] Removing [FB:225] from all active usage due to RMFB ioctl
<7> [64.057415] xe 0000:00:02.0: [drm:drm_mode_addfb2] [FB:225]
<7> [64.057499] xe 0000:00:02.0: [drm:drm_mode_rmfb_work_fn] Removing [FB:226] from all active usage due to RMFB ioctl
<7> [64.074358] xe 0000:00:02.0: [drm:drm_mode_addfb2] [FB:226]
<7> [64.074419] xe 0000:00:02.0: [drm:drm_mode_rmfb_work_fn] Removing [FB:228] from all active usage due to RMFB ioctl
<7> [64.090653] xe 0000:00:02.0: [drm:drm_mode_addfb2] [FB:228]
<7> [64.090704] xe 0000:00:02.0: [drm:drm_mode_rmfb_work_fn] Removing [FB:225] from all active usage due to RMFB ioctl
<7> [64.107205] xe 0000:00:02.0: [drm:drm_mode_addfb2] [FB:225]
<7> [64.107232] xe 0000:00:02.0: [drm:drm_mode_rmfb_work_fn] Removing [FB:226] from all active usage due to RMFB ioctl
<7> [64.123870] xe 0000:00:02.0: [drm:drm_mode_addfb2] [FB:226]
<7> [64.123895] xe 0000:00:02.0: [drm:drm_mode_rmfb_work_fn] Removing [FB:228] from all active usage due to RMFB ioctl
<7> [64.140569] xe 0000:00:02.0: [drm:drm_mode_addfb2] [FB:228]
<7> [64.140590] xe 0000:00:02.0: [drm:drm_mode_rmfb_work_fn] Removing [FB:225] from all active usage due to RMFB ioctl
<7> [64.157217] xe 0000:00:02.0: [drm:drm_mode_addfb2] [FB:225]
<7> [64.157237] xe 0000:00:02.0: [drm:drm_mode_rmfb_work_fn] Removing [FB:226] from all active usage due to RMFB ioctl
<7> [64.173882] xe 0000:00:02.0: [drm:drm_mode_addfb2] [FB:226]
<7> [64.173907] xe 0000:00:02.0: [drm:drm_mode_rmfb_work_fn] Removing [FB:228] from all active usage due to RMFB ioctl
<7> [64.190553] xe 0000:00:02.0: [drm:drm_mode_addfb2] [FB:228]
<7> [64.190579] xe 0000:00:02.0: [drm:drm_mode_rmfb_work_fn] Removing [FB:225] from all active usage due to RMFB ioctl
<7> [64.207196] xe 0000:00:02.0: [drm:drm_mode_addfb2] [FB:225]
<7> [64.207218] xe 0000:00:02.0: [drm:drm_mode_rmfb_work_fn] Removing [FB:226] from all active usage due to RMFB ioctl
<7> [64.223832] xe 0000:00:02.0: [drm:drm_mode_addfb2] [FB:226]
<7> [64.223853] xe 0000:00:02.0: [drm:drm_mode_rmfb_work_fn] Removing [FB:228] from all active usage due to RMFB ioctl
<7> [64.240537] xe 0000:00:02.0: [drm:drm_mode_addfb2] [FB:228]
<7> [64.240558] xe 0000:00:02.0: [drm:drm_mode_rmfb_work_fn] Removing [FB:225] from all active usage due to RMFB ioctl
<7> [64.257197] xe 0000:00:02.0: [drm:drm_mode_addfb2] [FB:225]
<7> [64.257218] xe 0000:00:02.0: [drm:drm_mode_rmfb_work_fn] Removing [FB:226] from all active usage due to RMFB ioctl
<7> [64.277353] xe 0000:00:02.0: [drm:drm_mode_addfb2] [FB:226]
<7> [64.290613] xe 0000:00:02.0: [drm:drm_mode_addfb2] [FB:228]
<7> [64.290691] xe 0000:00:02.0: [drm:drm_mode_rmfb_work_fn] Removing [FB:225] from all active usage due to RMFB ioctl
<7> [64.307258] xe 0000:00:02.0: [drm:drm_mode_addfb2] [FB:225]
<7> [64.307314] xe 0000:00:02.0: [drm:drm_mode_rmfb_work_fn] Removing [FB:226] from all active usage due to RMFB ioctl
<7> [64.323895] xe 0000:00:02.0: [drm:drm_mode_addfb2] [FB:226]
<7> [64.323945] xe 0000:00:02.0: [drm:drm_mode_rmfb_work_fn] Removing [FB:228] from all active usage due to RMFB ioctl
<7> [64.340570] xe 0000:00:02.0: [drm:drm_mode_addfb2] [FB:228]
<7> [64.340619] xe 0000:00:02.0: [drm:drm_mode_rmfb_work_fn] Removing [FB:225] from all active usage due to RMFB ioctl
<7> [64.357245] xe 0000:00:02.0: [drm:drm_mode_addfb2] [FB:225]
<7> [64.357292] xe 0000:00:02.0: [drm:drm_mode_rmfb_work_fn] Removing [FB:226] from all active usage due to RMFB ioctl
<7> [64.373878] xe 0000:00:02.0: [drm:drm_mode_addfb2] [FB:226]
<7> [64.373922] xe 0000:00:02.0: [drm:drm_mode_rmfb_work_fn] Removing [FB:228] from all active usage due to RMFB ioctl
<7> [64.390552] xe 0000:00:02.0: [drm:drm_mode_addfb2] [FB:228]
<7> [64.390596] xe 0000:00:02.0: [drm:drm_mode_rmfb_work_fn] Removing [FB:225] from all active usage due to RMFB ioctl
<7> [64.407212] xe 0000:00:02.0: [drm:drm_mode_addfb2] [FB:225]
<7> [64.407256] xe 0000:00:02.0: [drm:drm_mode_rmfb_work_fn] Removing [FB:226] from all active usage due to RMFB ioctl
<7> [64.423861] xe 0000:00:02.0: [drm:drm_mode_addfb2] [FB:226]
<7> [64.423906] xe 0000:00:02.0: [drm:drm_mode_rmfb_work_fn] Removing [FB:228] from all active usage due to RMFB ioctl
<7> [64.440525] xe 0000:00:02.0: [drm:drm_mode_addfb2] [FB:228]
<7> [64.440568] xe 0000:00:02.0: [drm:drm_mode_rmfb_work_fn] Removing [FB:225] from all active usage due to RMFB ioctl
<7> [64.457214] xe 0000:00:02.0: [drm:drm_mode_addfb2] [FB:225]
<7> [64.457260] xe 0000:00:02.0: [drm:drm_mode_rmfb_work_fn] Removing [FB:226] from all active usage due to RMFB ioctl
<7> [64.473856] xe 0000:00:02.0: [drm:drm_mode_addfb2] [FB:226]
<7> [64.473932] xe 0000:00:02.0: [drm:drm_mode_rmfb_work_fn] Removing [FB:228] from all active usage due to RMFB ioctl
<7> [64.490526] xe 0000:00:02.0: [drm:drm_mode_addfb2] [FB:228]
<7> [64.490572] xe 0000:00:02.0: [drm:drm_mode_rmfb_work_fn] Removing [FB:225] from all active usage due to RMFB ioctl
<7> [64.507193] xe 0000:00:02.0: [drm:drm_mode_addfb2] [FB:225]
<7> [64.507238] xe 0000:00:02.0: [drm:drm_mode_rmfb_work_fn] Removing [FB:226] from all active usage due to RMFB ioctl
<7> [64.523861] xe 0000:00:02.0: [drm:drm_mode_addfb2] [FB:226]
<7> [64.523905] xe 0000:00:02.0: [drm:drm_mode_rmfb_work_fn] Removing [FB:228] from all active usage due to RMFB ioctl
<7> [64.540510] xe 0000:00:02.0: [drm:drm_mode_addfb2] [FB:228]
<7> [64.540553] xe 0000:00:02.0: [drm:drm_mode_rmfb_work_fn] Removing [FB:225] from all active usage due to RMFB ioctl
<7> [64.557225] xe 0000:00:02.0: [drm:drm_mode_addfb2] [FB:225]
<7> [64.557276] xe 0000:00:02.0: [drm:drm_mode_rmfb_work_fn] Removing [FB:226] from all active usage due to RMFB ioctl
<7> [64.573851] xe 0000:00:02.0: [drm:drm_mode_addfb2] [FB:226]
<7> [64.573932] xe 0000:00:02.0: [drm:drm_mode_rmfb_work_fn] Removing [FB:228] from all active usage due to RMFB ioctl
<7> [64.590591] xe 0000:00:02.0: [drm:drm_mode_addfb2] [FB:228]
<7> [64.590654] xe 0000:00:02.0: [drm:drm_mode_rmfb_work_fn] Removing [FB:225] from all active usage due to RMFB ioctl
<7> [64.607208] xe 0000:00:02.0: [drm:drm_mode_addfb2] [FB:225]
<7> [64.607260] xe 0000:00:02.0: [drm:drm_mode_rmfb_work_fn] Removing [FB:226] from all active usage due to RMFB ioctl
<7> [64.623883] xe 0000:00:02.0: [drm:drm_mode_addfb2] [FB:226]
<7> [64.623943] xe 0000:00:02.0: [drm:drm_mode_rmfb_work_fn] Removing [FB:228] from all active usage due to RMFB ioctl
<7> [64.640545] xe 0000:00:02.0: [drm:drm_mode_addfb2] [FB:228]
<7> [64.640598] xe 0000:00:02.0: [drm:drm_mode_rmfb_work_fn] Removing [FB:225] from all active usage due to RMFB ioctl
<7> [64.657210] xe 0000:00:02.0: [drm:drm_mode_addfb2] [FB:225]
<7> [64.657263] xe 0000:00:02.0: [drm:drm_mode_rmfb_work_fn] Removing [FB:226] from all active usage due to RMFB ioctl
<7> [64.673848] xe 0000:00:02.0: [drm:drm_mode_addfb2] [FB:226]
<7> [64.673898] xe 0000:00:02.0: [drm:drm_mode_rmfb_work_fn] Removing [FB:228] from all active usage due to RMFB ioctl
<7> [64.690513] xe 0000:00:02.0: [drm:drm_mode_addfb2] [FB:228]
<7> [64.690568] xe 0000:00:02.0: [drm:drm_mode_rmfb_work_fn] Removing [FB:225] from all active usage due to RMFB ioctl
<7> [64.707175] xe 0000:00:02.0: [drm:drm_mode_addfb2] [FB:225]
<7> [64.707225] xe 0000:00:02.0: [drm:drm_mode_rmfb_work_fn] Removing [FB:226] from all active usage due to RMFB ioctl
<7> [64.723842] xe 0000:00:02.0: [drm:drm_mode_addfb2] [FB:226]
<7> [64.723891] xe 0000:00:02.0: [drm:drm_mode_rmfb_work_fn] Removing [FB:228] from all active usage due to RMFB ioctl
<7> [64.740513] xe 0000:00:02.0: [drm:drm_mode_addfb2] [FB:228]
<7> [64.740563] xe 0000:00:02.0: [drm:drm_mode_rmfb_work_fn] Removing [FB:225] from all active usage due to RMFB ioctl
<7> [64.757196] xe 0000:00:02.0: [drm:drm_mode_addfb2] [FB:225]
<7> [64.757252] xe 0000:00:02.0: [drm:drm_mode_rmfb_work_fn] Removing [FB:226] from all active usage due to RMFB ioctl
<7> [64.773830] xe 0000:00:02.0: [drm:drm_mode_addfb2] [FB:226]
<7> [64.773880] xe 0000:00:02.0: [drm:drm_mode_rmfb_work_fn] Removing [FB:228] from all active usage due to RMFB ioctl
<7> [64.790503] xe 0000:00:02.0: [drm:drm_mode_addfb2] [FB:228]
<7> [64.790555] xe 0000:00:02.0: [drm:drm_mode_rmfb_work_fn] Removing [FB:225] from all active usage due to RMFB ioctl
<7> [64.807158] xe 0000:00:02.0: [drm:drm_mode_addfb2] [FB:225]
<7> [64.807210] xe 0000:00:02.0: [drm:drm_mode_rmfb_work_fn] Removing [FB:226] from all active usage due to RMFB ioctl
<7> [64.823821] xe 0000:00:02.0: [drm:drm_mode_addfb2] [FB:226]
<7> [64.823872] xe 0000:00:02.0: [drm:drm_mode_rmfb_work_fn] Removing [FB:228] from all active usage due to RMFB ioctl
<7> [64.840512] xe 0000:00:02.0: [drm:drm_mode_addfb2] [FB:228]
<7> [64.840574] xe 0000:00:02.0: [drm:drm_mode_rmfb_work_fn] Removing [FB:225] from all active usage due to RMFB ioctl
<7> [64.857191] xe 0000:00:02.0: [drm:drm_mode_addfb2] [FB:225]
<7> [64.857262] xe 0000:00:02.0: [drm:drm_mode_rmfb_work_fn] Removing [FB:226] from all active usage due to RMFB ioctl
<7> [64.873820] xe 0000:00:02.0: [drm:drm_mode_addfb2] [FB:226]
<7> [64.873871] xe 0000:00:02.0: [drm:drm_mode_rmfb_work_fn] Removing [FB:228] from all active usage due to RMFB ioctl
<7> [64.890484] xe 0000:00:02.0: [drm:drm_mode_addfb2] [FB:228]
<7> [64.890535] xe 0000:00:02.0: [drm:drm_mode_rmfb_work_fn] Removing [FB:225] from all active usage due to RMFB ioctl
<7> [64.907142] xe 0000:00:02.0: [drm:drm_mode_addfb2] [FB:225]
<7> [64.907194] xe 0000:00:02.0: [drm:drm_mode_rmfb_work_fn] Removing [FB:226] from all active usage due to RMFB ioctl
<7> [64.923812] xe 0000:00:02.0: [drm:drm_mode_addfb2] [FB:226]
<7> [64.923867] xe 0000:00:02.0: [drm:drm_mode_rmfb_work_fn] Removing [FB:228] from all active usage due to RMFB ioctl
<7> [64.940533] xe 0000:00:02.0: [drm:drm_mode_addfb2] [FB:228]
<7> [64.940591] xe 0000:00:02.0: [drm:drm_mode_rmfb_work_fn] Removing [FB:225] from all active usage due to RMFB ioctl
<7> [64.957135] xe 0000:00:02.0: [drm:drm_mode_addfb2] [FB:225]
<7> [64.957185] xe 0000:00:02.0: [drm:drm_mode_rmfb_work_fn] Removing [FB:226] from all active usage due to RMFB ioctl
<7> [64.973800] xe 0000:00:02.0: [drm:drm_mode_addfb2] [FB:226]
<7> [64.973850] xe 0000:00:02.0: [drm:drm_mode_rmfb_work_fn] Removing [FB:228] from all active usage due to RMFB ioctl
<7> [64.990478] xe 0000:00:02.0: [drm:drm_mode_addfb2] [FB:228]
<7> [64.990528] xe 0000:00:02.0: [drm:drm_mode_rmfb_work_fn] Removing [FB:225] from all active usage due to RMFB ioctl
<7> [65.007138] xe 0000:00:02.0: [drm:drm_mode_addfb2] [FB:225]
<7> [65.007191] xe 0000:00:02.0: [drm:drm_mode_rmfb_work_fn] Removing [FB:226] from all active usage due to RMFB ioctl
<7> [65.023805] xe 0000:00:02.0: [drm:drm_mode_addfb2] [FB:226]
<7> [65.023854] xe 0000:00:02.0: [drm:drm_mode_rmfb_work_fn] Removing [FB:228] from all active usage due to RMFB ioctl
<7> [65.040557] xe 0000:00:02.0: [drm:drm_mode_addfb2] [FB:228]
<7> [65.040626] xe 0000:00:02.0: [drm:drm_mode_rmfb_work_fn] Removing [FB:225] from all active usage due to RMFB ioctl
<7> [65.057160] xe 0000:00:02.0: [drm:drm_mode_addfb2] [FB:225]
<7> [65.057219] xe 0000:00:02.0: [drm:drm_mode_rmfb_work_fn] Removing [FB:226] from all active usage due to RMFB ioctl
<7> [65.073816] xe 0000:00:02.0: [drm:drm_mode_addfb2] [FB:226]
<7> [65.073873] xe 0000:00:02.0: [drm:drm_mode_rmfb_work_fn] Removing [FB:228] from all active usage due to RMFB ioctl
<7> [65.090476] xe 0000:00:02.0: [drm:drm_mode_addfb2] [FB:228]
<7> [65.090536] xe 0000:00:02.0: [drm:drm_mode_rmfb_work_fn] Removing [FB:225] from all active usage due to RMFB ioctl
<7> [65.107113] xe 0000:00:02.0: [drm:drm_mode_addfb2] [FB:225]
<7> [65.107162] xe 0000:00:02.0: [drm:drm_mode_rmfb_work_fn] Removing [FB:226] from all active usage due to RMFB ioctl
<7> [65.123797] xe 0000:00:02.0: [drm:drm_mode_addfb2] [FB:226]
<7> [65.123847] xe 0000:00:02.0: [drm:drm_mode_rmfb_work_fn] Removing [FB:228] from all active usage due to RMFB ioctl
<7> [65.140441] xe 0000:00:02.0: [drm:drm_mode_addfb2] [FB:228]
<7> [65.140527] xe 0000:00:02.0: [drm:drm_mode_rmfb_work_fn] Removing [FB:225] from all active usage due to RMFB ioctl
<7> [65.157110] xe 0000:00:02.0: [drm:drm_mode_addfb2] [FB:225]
<7> [65.157161] xe 0000:00:02.0: [drm:drm_mode_rmfb_work_fn] Removing [FB:226] from all active usage due to RMFB ioctl
<7> [65.173772] xe 0000:00:02.0: [drm:drm_mode_addfb2] [FB:226]
<7> [65.173821] xe 0000:00:02.0: [drm:drm_mode_rmfb_work_fn] Removing [FB:228] from all active usage due to RMFB ioctl
<7> [65.190425] xe 0000:00:02.0: [drm:drm_mode_addfb2] [FB:228]
<7> [65.190476] xe 0000:00:02.0: [drm:drm_mode_rmfb_work_fn] Removing [FB:225] from all active usage due to RMFB ioctl
<7> [65.207147] xe 0000:00:02.0: [drm:drm_mode_addfb2] [FB:225]
<7> [65.207208] xe 0000:00:02.0: [drm:drm_mode_rmfb_work_fn] Removing [FB:226] from all active usage due to RMFB ioctl
<7> [65.223784] xe 0000:00:02.0: [drm:drm_mode_addfb2] [FB:226]
<7> [65.223835] xe 0000:00:02.0: [drm:drm_mode_rmfb_work_fn] Removing [FB:228] from all active usage due to RMFB ioctl
<7> [65.240426] xe 0000:00:02.0: [drm:drm_mode_addfb2] [FB:228]
<7> [65.240475] xe 0000:00:02.0: [drm:drm_mode_rmfb_work_fn] Removing [FB:225] from all active usage due to RMFB ioctl
<7> [65.257089] xe 0000:00:02.0: [drm:drm_mode_addfb2] [FB:225]
<7> [65.257139] xe 0000:00:02.0: [drm:drm_mode_rmfb_work_fn] Removing [FB:226] from all active usage due to RMFB ioctl
<7> [65.273754] xe 0000:00:02.0: [drm:drm_mode_addfb2] [FB:226]
<7> [65.273811] xe 0000:00:02.0: [drm:drm_mode_rmfb_work_fn] Removing [FB:228] from all active usage due to RMFB ioctl
<7> [65.290452] xe 0000:00:02.0: [drm:drm_mode_addfb2] [FB:228]
<7> [65.290512] xe 0000:00:02.0: [drm:drm_mode_rmfb_work_fn] Removing [FB:225] from all active usage due to RMFB ioctl
<7> [65.307129] xe 0000:00:02.0: [drm:drm_mode_addfb2] [FB:225]
<7> [65.307199] xe 0000:00:02.0: [drm:drm_mode_rmfb_work_fn] Removing [FB:226] from all active usage due to RMFB ioctl
<7> [65.323780] xe 0000:00:02.0: [drm:drm_mode_addfb2] [FB:226]
<7> [65.323845] xe 0000:00:02.0: [drm:drm_mode_rmfb_work_fn] Removing [FB:228] from all active usage due to RMFB ioctl
<7> [65.340444] xe 0000:00:02.0: [drm:drm_mode_addfb2] [FB:228]
<7> [65.340502] xe 0000:00:02.0: [drm:drm_mode_rmfb_work_fn] Removing [FB:225] from all active usage due to RMFB ioctl
<7> [65.357073] xe 0000:00:02.0: [drm:drm_mode_addfb2] [FB:225]
<7> [65.357124] xe 0000:00:02.0: [drm:drm_mode_rmfb_work_fn] Removing [FB:226] from all active usage due to RMFB ioctl
<7> [65.373727] xe 0000:00:02.0: [drm:drm_mode_addfb2] [FB:226]
<7> [65.373777] xe 0000:00:02.0: [drm:drm_mode_rmfb_work_fn] Removing [FB:228] from all active usage due to RMFB ioctl
<7> [65.390421] xe 0000:00:02.0: [drm:drm_mode_addfb2] [FB:228]
<7> [65.390479] xe 0000:00:02.0: [drm:drm_mode_rmfb_work_fn] Removing [FB:225] from all active usage due to RMFB ioctl
<7> [65.407134] xe 0000:00:02.0: [drm:drm_mode_addfb2] [FB:225]
<7> [65.407192] xe 0000:00:02.0: [drm:drm_mode_rmfb_work_fn] Removing [FB:226] from all active usage due to RMFB ioctl
<7> [65.423760] xe 0000:00:02.0: [drm:drm_mode_addfb2] [FB:226]
<7> [65.423879] xe 0000:00:02.0: [drm:drm_mode_rmfb_work_fn] Removing [FB:228] from all active usage due to RMFB ioctl
<7> [65.440430] xe 0000:00:02.0: [drm:drm_mode_addfb2] [FB:228]
<7> [65.440487] xe 0000:00:02.0: [drm:drm_mode_rmfb_work_fn] Removing [FB:225] from all active usage due to RMFB ioctl
<7> [65.457084] xe 0000:00:02.0: [drm:drm_mode_addfb2] [FB:225]
<7> [65.457141] xe 0000:00:02.0: [drm:drm_mode_rmfb_work_fn] Removing [FB:226] from all active usage due to RMFB ioctl
<7> [65.473714] xe 0000:00:02.0: [drm:drm_mode_addfb2] [FB:226]
<7> [65.473764] xe 0000:00:02.0: [drm:drm_mode_rmfb_work_fn] Removing [FB:228] from all active usage due to RMFB ioctl
<7> [65.490416] xe 0000:00:02.0: [drm:drm_mode_addfb2] [FB:228]
<7> [65.490474] xe 0000:00:02.0: [drm:drm_mode_rmfb_work_fn] Removing [FB:225] from all active usage due to RMFB ioctl
<7> [65.507120] xe 0000:00:02.0: [drm:drm_mode_addfb2] [FB:225]
<7> [65.507179] xe 0000:00:02.0: [drm:drm_mode_rmfb_work_fn] Removing [FB:226] from all active usage due to RMFB ioctl
<7> [65.523742] xe 0000:00:02.0: [drm:drm_mode_addfb2] [FB:226]
<7> [65.523799] xe 0000:00:02.0: [drm:drm_mode_rmfb_work_fn] Removing [FB:228] from all active usage due to RMFB ioctl
<7> [65.540406] xe 0000:00:02.0: [drm:drm_mode_addfb2] [FB:228]
<7> [65.540464] xe 0000:00:02.0: [drm:drm_mode_rmfb_work_fn] Removing [FB:225] from all active usage due to RMFB ioctl
<7> [65.557071] xe 0000:00:02.0: [drm:drm_mode_addfb2] [FB:225]
<7> [65.557129] xe 0000:00:02.0: [drm:drm_mode_rmfb_work_fn] Removing [FB:226] from all active usage due to RMFB ioctl
<7> [65.573728] xe 0000:00:02.0: [drm:drm_mode_addfb2] [FB:226]
<7> [65.573786] xe 0000:00:02.0: [drm:drm_mode_rmfb_work_fn] Removing [FB:228] from all active usage due to RMFB ioctl
<7> [65.590423] xe 0000:00:02.0: [drm:drm_mode_addfb2] [FB:228]
<7> [65.590481] xe 0000:00:02.0: [drm:drm_mode_rmfb_work_fn] Removing [FB:225] from all active usage due to RMFB ioctl
<7> [65.607057] xe 0000:00:02.0: [drm:drm_mode_addfb2] [FB:225]
<7> [65.607115] xe 0000:00:02.0: [drm:drm_mode_rmfb_work_fn] Removing [FB:226] from all active usage due to RMFB ioctl
<7> [65.623729] xe 0000:00:02.0: [drm:drm_mode_addfb2] [FB:226]
<7> [65.623788] xe 0000:00:02.0: [drm:drm_mode_rmfb_work_fn] Removing [FB:228] from all active usage due to RMFB ioctl
<7> [65.640386] xe 0000:00:02.0: [drm:drm_mode_addfb2] [FB:228]
<7> [65.640441] xe 0000:00:02.0: [drm:drm_mode_rmfb_work_fn] Removing [FB:225] from all active usage due to RMFB ioctl
<7> [65.657056] xe 0000:00:02.0: [drm:drm_mode_addfb2] [FB:225]
<7> [65.657115] xe 0000:00:02.0: [drm:drm_mode_rmfb_work_fn] Removing [FB:226] from all active usage due to RMFB ioctl
<7> [65.673778] xe 0000:00:02.0: [drm:drm_mode_addfb2] [FB:226]
<7> [65.673836] xe 0000:00:02.0: [drm:drm_mode_rmfb_work_fn] Removing [FB:228] from all active usage due to RMFB ioctl
<7> [65.690378] xe 0000:00:02.0: [drm:drm_mode_addfb2] [FB:228]
<7> [65.690436] xe 0000:00:02.0: [drm:drm_mode_rmfb_work_fn] Removing [FB:225] from all active usage due to RMFB ioctl
<7> [65.707047] xe 0000:00:02.0: [drm:drm_mode_addfb2] [FB:225]
<7> [65.707106] xe 0000:00:02.0: [drm:drm_mode_rmfb_work_fn] Removing [FB:226] from all active usage due to RMFB ioctl
<7> [65.723700] xe 0000:00:02.0: [drm:drm_mode_addfb2] [FB:226]
<7> [65.723756] xe 0000:00:02.0: [drm:drm_mode_rmfb_work_fn] Removing [FB:228] from all active usage due to RMFB ioctl
<7> [65.740377] xe 0000:00:02.0: [drm:drm_mode_addfb2] [FB:228]
<7> [65.740438] xe 0000:00:02.0: [drm:drm_mode_rmfb_work_fn] Removing [FB:225] from all active usage due to RMFB ioctl
<7> [65.757057] xe 0000:00:02.0: [drm:drm_mode_addfb2] [FB:225]
<7> [65.757115] xe 0000:00:02.0: [drm:drm_mode_rmfb_work_fn] Removing [FB:226] from all active usage due to RMFB ioctl
<7> [65.773700] xe 0000:00:02.0: [drm:drm_mode_addfb2] [FB:226]
<7> [65.773756] xe 0000:00:02.0: [drm:drm_mode_rmfb_work_fn] Removing [FB:228] from all active usage due to RMFB ioctl
<7> [65.790360] xe 0000:00:02.0: [drm:drm_mode_addfb2] [FB:228]
<7> [65.790417] xe 0000:00:02.0: [drm:drm_mode_rmfb_work_fn] Removing [FB:225] from all active usage due to RMFB ioctl
<7> [65.807034] xe 0000:00:02.0: [drm:drm_mode_addfb2] [FB:225]
<7> [65.807096] xe 0000:00:02.0: [drm:drm_mode_rmfb_work_fn] Removing [FB:226] from all active usage due to RMFB ioctl
<7> [65.823704] xe 0000:00:02.0: [drm:drm_mode_addfb2] [FB:226]
<7> [65.823763] xe 0000:00:02.0: [drm:drm_mode_rmfb_work_fn] Removing [FB:228] from all active usage due to RMFB ioctl
<7> [65.840379] xe 0000:00:02.0: [drm:drm_mode_addfb2] [FB:228]
<7> [65.840452] xe 0000:00:02.0: [drm:drm_mode_rmfb_work_fn] Removing [FB:225] from all active usage due to RMFB ioctl
<7> [65.858715] xe 0000:00:02.0: [drm:drm_mode_addfb2] [FB:225]
<7> [65.858829] xe 0000:00:02.0: [drm:drm_mode_rmfb_work_fn] Removing [FB:226] from all active usage due to RMFB ioctl
<7> [65.873794] xe 0000:00:02.0: [drm:drm_mode_addfb2] [FB:226]
<7> [65.873878] xe 0000:00:02.0: [drm:drm_mode_rmfb_work_fn] Removing [FB:228] from all active usage due to RMFB ioctl
<7> [65.890552] xe 0000:00:02.0: [drm:drm_mode_addfb2] [FB:228]
<7> [65.890644] xe 0000:00:02.0: [drm:drm_mode_rmfb_work_fn] Removing [FB:225] from all active usage due to RMFB ioctl
<7> [65.906952] xe 0000:00:02.0: [drm:drm_mode_addfb2] [FB:225]
<7> [65.906988] xe 0000:00:02.0: [drm:drm_mode_rmfb_work_fn] Removing [FB:226] from all active usage due to RMFB ioctl
<7> [65.923656] xe 0000:00:02.0: [drm:drm_mode_addfb2] [FB:226]
<7> [65.923697] xe 0000:00:02.0: [drm:drm_mode_rmfb_work_fn] Removing [FB:228] from all active usage due to RMFB ioctl
<7> [65.940375] xe 0000:00:02.0: [drm:drm_mode_addfb2] [FB:228]
<7> [65.940448] xe 0000:00:02.0: [drm:drm_mode_rmfb_work_fn] Removing [FB:225] from all active usage due to RMFB ioctl
<7> [65.957029] xe 0000:00:02.0: [drm:drm_mode_addfb2] [FB:225]
<7> [65.957081] xe 0000:00:02.0: [drm:drm_mode_rmfb_work_fn] Removing [FB:226] from all active usage due to RMFB ioctl
<7> [65.973720] xe 0000:00:02.0: [drm:drm_mode_addfb2] [FB:226]
<7> [65.973763] xe 0000:00:02.0: [drm:drm_mode_rmfb_work_fn] Removing [FB:228] from all active usage due to RMFB ioctl
<7> [65.990459] xe 0000:00:02.0: [drm:drm_mode_addfb2] [FB:228]
<7> [65.990507] xe 0000:00:02.0: [drm:drm_mode_rmfb_work_fn] Removing [FB:225] from all active usage due to RMFB ioctl
<7> [66.006998] xe 0000:00:02.0: [drm:drm_mode_addfb2] [FB:225]
<7> [66.007037] xe 0000:00:02.0: [drm:drm_mode_rmfb_work_fn] Removing [FB:226] from all active usage due to RMFB ioctl
<7> [66.023622] xe 0000:00:02.0: [drm:drm_mode_addfb2] [FB:226]
<7> [66.023651] xe 0000:00:02.0: [drm:drm_mode_rmfb_work_fn] Removing [FB:228] from all active usage due to RMFB ioctl
<7> [66.040396] xe 0000:00:02.0: [drm:drm_mode_addfb2] [FB:228]
<7> [66.040455] xe 0000:00:02.0: [drm:drm_mode_rmfb_work_fn] Removing [FB:225] from all active usage due to RMFB ioctl
<7> [66.044598] xe 0000:00:02.0: [drm:intel_pps_vdd_off_sync_unlocked [xe]] [ENCODER:188:DDI A/PHY A] PPS 0 turning VDD off
<7> [66.044942] xe 0000:00:02.0: [drm:intel_pps_vdd_off_sync_unlocked [xe]] [ENCODER:188:DDI A/PHY A] PPS 0 PP_STATUS: 0x80000008 PP_CONTROL: 0x00000067
<7> [66.057035] xe 0000:00:02.0: [drm:drm_mode_addfb2] [FB:225]
<7> [66.057090] xe 0000:00:02.0: [drm:drm_mode_rmfb_work_fn] Removing [FB:226] from all active usage due to RMFB ioctl
<7> [66.073559] xe 0000:00:02.0: [drm:drm_mode_addfb2] [FB:226]
<7> [66.073586] xe 0000:00:02.0: [drm:drm_mode_rmfb_work_fn] Removing [FB:228] from all active usage due to RMFB ioctl
<7> [66.090290] xe 0000:00:02.0: [drm:drm_mode_addfb2] [FB:228]
<7> [66.090319] xe 0000:00:02.0: [drm:drm_mode_rmfb_work_fn] Removing [FB:225] from all active usage due to RMFB ioctl
<7> [66.106908] xe 0000:00:02.0: [drm:drm_mode_addfb2] [FB:225]
<7> [66.106931] xe 0000:00:02.0: [drm:drm_mode_rmfb_work_fn] Removing [FB:226] from all active usage due to RMFB ioctl
<7> [66.123570] xe 0000:00:02.0: [drm:drm_mode_addfb2] [FB:226]
<7> [66.123594] xe 0000:00:02.0: [drm:drm_mode_rmfb_work_fn] Removing [FB:228] from all active usage due to RMFB ioctl
<7> [66.140227] xe 0000:00:02.0: [drm:drm_mode_addfb2] [FB:228]
<7> [66.140248] xe 0000:00:02.0: [drm:drm_mode_rmfb_work_fn] Removing [FB:225] from all active usage due to RMFB ioctl
<7> [66.156864] xe 0000:00:02.0: [drm:drm_mode_addfb2] [FB:225]
<7> [66.156885] xe 0000:00:02.0: [drm:drm_mode_rmfb_work_fn] Removing [FB:226] from all active usage due to RMFB ioctl
<7> [66.173543] xe 0000:00:02.0: [drm:drm_mode_addfb2] [FB:226]
<7> [66.173565] xe 0000:00:02.0: [drm:drm_mode_rmfb_work_fn] Removing [FB:228] from all active usage due to RMFB ioctl
<7> [66.190217] xe 0000:00:02.0: [drm:drm_mode_addfb2] [FB:228]
<7> [66.190237] xe 0000:00:02.0: [drm:drm_mode_rmfb_work_fn] Removing [FB:225] from all active usage due to RMFB ioctl
<7> [66.206890] xe 0000:00:02.0: [drm:drm_mode_addfb2] [FB:225]
<7> [66.206910] xe 0000:00:02.0: [drm:drm_mode_rmfb_work_fn] Removing [FB:226] from all active usage due to RMFB ioctl
<7> [66.223553] xe 0000:00:02.0: [drm:drm_mode_addfb2] [FB:226]
<7> [66.223573] xe 0000:00:02.0: [drm:drm_mode_rmfb_work_fn] Removing [FB:228] from all active usage due to RMFB ioctl
<7> [66.240434] xe 0000:00:02.0: [drm:drm_mode_addfb2] [FB:228]
<7> [66.240481] xe 0000:00:02.0: [drm:drm_mode_rmfb_work_fn] Removing [FB:225] from all active usage due to RMFB ioctl
<7> [66.256952] xe 0000:00:02.0: [drm:drm_mode_addfb2] [FB:225]
<7> [66.256995] xe 0000:00:02.0: [drm:drm_mode_rmfb_work_fn] Removing [FB:226] from all active usage due to RMFB ioctl
<7> [66.273661] xe 0000:00:02.0: [drm:drm_mode_addfb2] [FB:226]
<7> [66.273711] xe 0000:00:02.0: [drm:drm_mode_rmfb_work_fn] Removing [FB:228] from all active usage due to RMFB ioctl
<7> [66.290321] xe 0000:00:02.0: [drm:drm_mode_addfb2] [FB:228]
<7> [66.290381] xe 0000:00:02.0: [drm:drm_mode_rmfb_work_fn] Removing [FB:225] from all active usage due to RMFB ioctl
<7> [66.306917] xe 0000:00:02.0: [drm:drm_mode_addfb2] [FB:225]
<7> [66.306954] xe 0000:00:02.0: [drm:drm_mode_rmfb_work_fn] Removing [FB:226] from all active usage due to RMFB ioctl
<7> [66.323537] xe 0000:00:02.0: [drm:drm_mode_addfb2] [FB:226]
<7> [66.323572] xe 0000:00:02.0: [drm:drm_mode_rmfb_work_fn] Removing [FB:228] from all active usage due to RMFB ioctl
<7> [66.340191] xe 0000:00:02.0: [drm:drm_mode_addfb2] [FB:228]
<7> [66.340214] xe 0000:00:02.0: [drm:drm_mode_rmfb_work_fn] Removing [FB:225] from all active usage due to RMFB ioctl
<7> [66.356880] xe 0000:00:02.0: [drm:drm_mode_addfb2] [FB:225]
<7> [66.356927] xe 0000:00:02.0: [drm:drm_mode_rmfb_work_fn] Removing [FB:226] from all active usage due to RMFB ioctl
<7> [66.373558] xe 0000:00:02.0: [drm:drm_mode_addfb2] [FB:226]
<7> [66.373585] xe 0000:00:02.0: [drm:drm_mode_rmfb_work_fn] Removing [FB:228] from all active usage due to RMFB ioctl
<7> [66.390206] xe 0000:00:02.0: [drm:drm_mode_addfb2] [FB:228]
<7> [66.390231] xe 0000:00:02.0: [drm:drm_mode_rmfb_work_fn] Removing [FB:225] from all active usage due to RMFB ioctl
<7> [66.406829] xe 0000:00:02.0: [drm:drm_mode_addfb2] [FB:225]
<7> [66.406854] xe 0000:00:02.0: [drm:drm_mode_rmfb_work_fn] Removing [FB:226] from all active usage due to RMFB ioctl
<7> [66.423501] xe 0000:00:02.0: [drm:drm_mode_addfb2] [FB:226]
<7> [66.423525] xe 0000:00:02.0: [drm:drm_mode_rmfb_work_fn] Removing [FB:228] from all active usage due to RMFB ioctl
<7> [66.440187] xe 0000:00:02.0: [drm:drm_mode_addfb2] [FB:228]
<7> [66.440236] xe 0000:00:02.0: [drm:drm_mode_rmfb_work_fn] Removing [FB:225] from all active usage due to RMFB ioctl
<7> [66.456860] xe 0000:00:02.0: [drm:drm_mode_addfb2] [FB:225]
<7> [66.456885] xe 0000:00:02.0: [drm:drm_mode_rmfb_work_fn] Removing [FB:226] from all active usage due to RMFB ioctl
<7> [66.473521] xe 0000:00:02.0: [drm:drm_mode_addfb2] [FB:226]
<7> [66.473545] xe 0000:00:02.0: [drm:drm_mode_rmfb_work_fn] Removing [FB:228] from all active usage due to RMFB ioctl
<7> [66.490149] xe 0000:00:02.0: [drm:drm_mode_addfb2] [FB:228]
<7> [66.490169] xe 0000:00:02.0: [drm:drm_mode_rmfb_work_fn] Removing [FB:225] from all active usage due to RMFB ioctl
<7> [66.506834] xe 0000:00:02.0: [drm:drm_mode_addfb2] [FB:225]
<7> [66.506858] xe 0000:00:02.0: [drm:drm_mode_rmfb_work_fn] Removing [FB:226] from all active usage due to RMFB ioctl
<7> [66.523504] xe 0000:00:02.0: [drm:drm_mode_addfb2] [FB:226]
<7> [66.523525] xe 0000:00:02.0: [drm:drm_mode_rmfb_work_fn] Removing [FB:228] from all active usage due to RMFB ioctl
<7> [66.540167] xe 0000:00:02.0: [drm:drm_mode_addfb2] [FB:228]
<7> [66.540189] xe 0000:00:02.0: [drm:drm_mode_rmfb_work_fn] Removing [FB:225] from all active usage due to RMFB ioctl
<7> [66.556964] xe 0000:00:02.0: [drm:drm_mode_addfb2] [FB:225]
<7> [66.557021] xe 0000:00:02.0: [drm:drm_mode_rmfb_work_fn] Removing [FB:226] from all active usage due to RMFB ioctl
<7> [66.573555] xe 0000:00:02.0: [drm:drm_mode_addfb2] [FB:226]
<7> [66.573603] xe 0000:00:02.0: [drm:drm_mode_rmfb_work_fn] Removing [FB:228] from all active usage due to RMFB ioctl
<7> [66.590189] xe 0000:00:02.0: [drm:drm_mode_addfb2] [FB:228]
<7> [66.590277] xe 0000:00:02.0: [drm:drm_mode_rmfb_work_fn] Removing [FB:225] from all active usage due to RMFB ioctl
<7> [66.606872] xe 0000:00:02.0: [drm:drm_mode_addfb2] [FB:225]
<7> [66.606910] xe 0000:00:02.0: [drm:drm_mode_rmfb_work_fn] Removing [FB:226] from all active usage due to RMFB ioctl
<7> [66.623534] xe 0000:00:02.0: [drm:drm_mode_addfb2] [FB:226]
<7> [66.623574] xe 0000:00:02.0: [drm:drm_mode_rmfb_work_fn] Removing [FB:228] from all active usage due to RMFB ioctl
<7> [66.640172] xe 0000:00:02.0: [drm:drm_mode_addfb2] [FB:228]
<7> [66.640199] xe 0000:00:02.0: [drm:drm_mode_rmfb_work_fn] Removing [FB:225] from all active usage due to RMFB ioctl
<7> [66.656876] xe 0000:00:02.0: [drm:drm_mode_addfb2] [FB:225]
<7> [66.656913] xe 0000:00:02.0: [drm:drm_mode_rmfb_work_fn] Removing [FB:226] from all active usage due to RMFB ioctl
<7> [66.673535] xe 0000:00:02.0: [drm:drm_mode_addfb2] [FB:226]
<7> [66.673575] xe 0000:00:02.0: [drm:drm_mode_rmfb_work_fn] Removing [FB:228] from all active usage due to RMFB ioctl
<7> [66.690178] xe 0000:00:02.0: [drm:drm_mode_addfb2] [FB:228]
<7> [66.690210] xe 0000:00:02.0: [drm:drm_mode_rmfb_work_fn] Removing [FB:225] from all active usage due to RMFB ioctl
<7> [66.706831] xe 0000:00:02.0: [drm:drm_mode_addfb2] [FB:225]
<7> [66.706859] xe 0000:00:02.0: [drm:drm_mode_rmfb_work_fn] Removing [FB:226] from all active usage due to RMFB ioctl
<7> [66.723481] xe 0000:00:02.0: [drm:drm_mode_addfb2] [FB:226]
<7> [66.723504] xe 0000:00:02.0: [drm:drm_mode_rmfb_work_fn] Removing [FB:228] from all active usage due to RMFB ioctl
<7> [66.740240] xe 0000:00:02.0: [drm:drm_mode_addfb2] [FB:228]
<7> [66.740282] xe 0000:00:02.0: [drm:drm_mode_rmfb_work_fn] Removing [FB:225] from all active usage due to RMFB ioctl
<7> [66.756841] xe 0000:00:02.0: [drm:drm_mode_addfb2] [FB:225]
<7> [66.756898] xe 0000:00:02.0: [drm:drm_mode_rmfb_work_fn] Removing [FB:226] from all active usage due to RMFB ioctl
<7> [66.773477] xe 0000:00:02.0: [drm:drm_mode_addfb2] [FB:226]
<7> [66.773502] xe 0000:00:02.0: [drm:drm_mode_rmfb_work_fn] Removing [FB:228] from all active usage due to RMFB ioctl
<7> [66.790157] xe 0000:00:02.0: [drm:drm_mode_addfb2] [FB:228]
<7> [66.790183] xe 0000:00:02.0: [drm:drm_mode_rmfb_work_fn] Removing [FB:225] from all active usage due to RMFB ioctl
<7> [66.806927] xe 0000:00:02.0: [drm:drm_mode_addfb2] [FB:225]
<7> [66.806994] xe 0000:00:02.0: [drm:drm_mode_rmfb_work_fn] Removing [FB:226] from all active usage due to RMFB ioctl
<7> [66.823605] xe 0000:00:02.0: [drm:drm_mode_addfb2] [FB:226]
<7> [66.823667] xe 0000:00:02.0: [drm:drm_mode_rmfb_work_fn] Removing [FB:228] from all active usage due to RMFB ioctl
<7> [66.840225] xe 0000:00:02.0: [drm:drm_mode_addfb2] [FB:228]
<7> [66.840306] xe 0000:00:02.0: [drm:drm_mode_rmfb_work_fn] Removing [FB:225] from all active usage due to RMFB ioctl
<7> [66.856865] xe 0000:00:02.0: [drm:drm_mode_addfb2] [FB:225]
<7> [66.856918] xe 0000:00:02.0: [drm:drm_mode_rmfb_work_fn] Removing [FB:226] from all active usage due to RMFB ioctl
<7> [66.873484] xe 0000:00:02.0: [drm:drm_mode_addfb2] [FB:226]
<7> [66.873522] xe 0000:00:02.0: [drm:drm_mode_rmfb_work_fn] Removing [FB:228] from all active usage due to RMFB ioctl
<7> [66.890111] xe 0000:00:02.0: [drm:drm_mode_addfb2] [FB:228]
<7> [66.890135] xe 0000:00:02.0: [drm:drm_mode_rmfb_work_fn] Removing [FB:225] from all active usage due to RMFB ioctl
<7> [66.906905] xe 0000:00:02.0: [drm:drm_mode_addfb2] [FB:225]
<7> [66.906946] xe 0000:00:02.0: [drm:drm_mode_rmfb_work_fn] Removing [FB:226] from all active usage due to RMFB ioctl
<7> [66.923471] xe 0000:00:02.0: [drm:drm_mode_addfb2] [FB:226]
<7> [66.923513] xe 0000:00:02.0: [drm:drm_mode_rmfb_work_fn] Removing [FB:228] from all active usage due to RMFB ioctl
<7> [66.940104] xe 0000:00:02.0: [drm:drm_mode_addfb2] [FB:228]
<7> [66.940128] xe 0000:00:02.0: [drm:drm_mode_rmfb_work_fn] Removing [FB:225] from all active usage due to RMFB ioctl
<7> [66.956759] xe 0000:00:02.0: [drm:drm_mode_addfb2] [FB:225]
<7> [66.956782] xe 0000:00:02.0: [drm:drm_mode_rmfb_work_fn] Removing [FB:226] from all active usage due to RMFB ioctl
<7> [66.973551] xe 0000:00:02.0: [drm:drm_mode_addfb2] [FB:226]
<7> [66.973611] xe 0000:00:02.0: [drm:drm_mode_rmfb_work_fn] Removing [FB:228] from all active usage due to RMFB ioctl
<7> [66.990128] xe 0000:00:02.0: [drm:drm_mode_addfb2] [FB:228]
<7> [66.990191] xe 0000:00:02.0: [drm:drm_mode_rmfb_work_fn] Removing [FB:225] from all active usage due to RMFB ioctl
<7> [67.006852] xe 0000:00:02.0: [drm:drm_mode_addfb2] [FB:225]
<7> [67.006895] xe 0000:00:02.0: [drm:drm_mode_rmfb_work_fn] Removing [FB:226] from all active usage due to RMFB ioctl
<7> [67.023467] xe 0000:00:02.0: [drm:drm_mode_addfb2] [FB:226]
<7> [67.023503] xe 0000:00:02.0: [drm:drm_mode_rmfb_work_fn] Removing [FB:228] from all active usage due to RMFB ioctl
<7> [67.040181] xe 0000:00:02.0: [drm:drm_mode_addfb2] [FB:228]
<7> [67.040232] xe 0000:00:02.0: [drm:drm_mode_rmfb_work_fn] Removing [FB:225] from all active usage due to RMFB ioctl
<7> [67.056863] xe 0000:00:02.0: [drm:drm_mode_addfb2] [FB:225]
<7> [67.056914] xe 0000:00:02.0: [drm:drm_mode_rmfb_work_fn] Removing [FB:226] from all active usage due to RMFB ioctl
<7> [67.073527] xe 0000:00:02.0: [drm:drm_mode_addfb2] [FB:226]
<7> [67.073593] xe 0000:00:02.0: [drm:drm_mode_rmfb_work_fn] Removing [FB:228] from all active usage due to RMFB ioctl
<7> [67.090132] xe 0000:00:02.0: [drm:drm_mode_addfb2] [FB:228]
<7> [67.090175] xe 0000:00:02.0: [drm:drm_mode_rmfb_work_fn] Removing [FB:225] from all active usage due to RMFB ioctl
<7> [67.106774] xe 0000:00:02.0: [drm:drm_mode_addfb2] [FB:225]
<7> [67.106807] xe 0000:00:02.0: [drm:drm_mode_rmfb_work_fn] Removing [FB:226] from all active usage due to RMFB ioctl
<7> [67.123452] xe 0000:00:02.0: [drm:drm_mode_addfb2] [FB:226]
<7> [67.123485] xe 0000:00:02.0: [drm:drm_mode_rmfb_work_fn] Removing [FB:228] from all active usage due to RMFB ioctl
<7> [67.140186] xe 0000:00:02.0: [drm:drm_mode_addfb2] [FB:228]
<7> [67.140227] xe 0000:00:02.0: [drm:drm_mode_rmfb_work_fn] Removing [FB:225] from all active usage due to RMFB ioctl
<7> [67.156758] xe 0000:00:02.0: [drm:drm_mode_addfb2] [FB:225]
<7> [67.156786] xe 0000:00:02.0: [drm:drm_mode_rmfb_work_fn] Removing [FB:226] from all active usage due to RMFB ioctl
<7> [67.173417] xe 0000:00:02.0: [drm:drm_mode_addfb2] [FB:226]
<7> [67.173443] xe 0000:00:02.0: [drm:drm_mode_rmfb_work_fn] Removing [FB:228] from all active usage due to RMFB ioctl
<7> [67.190060] xe 0000:00:02.0: [drm:drm_mode_addfb2] [FB:228]
<7> [67.190084] xe 0000:00:02.0: [drm:drm_mode_rmfb_work_fn] Removing [FB:225] from all active usage due to RMFB ioctl
<7> [67.206835] xe 0000:00:02.0: [drm:drm_mode_addfb2] [FB:225]
<7> [67.206885] xe 0000:00:02.0: [drm:drm_mode_rmfb_work_fn] Removing [FB:226] from all active usage due to RMFB ioctl
<7> [67.223482] xe 0000:00:02.0: [drm:drm_mode_addfb2] [FB:226]
<7> [67.223533] xe 0000:00:02.0: [drm:drm_mode_rmfb_work_fn] Removing [FB:228] from all active usage due to RMFB ioctl
<7> [67.240071] xe 0000:00:02.0: [drm:drm_mode_addfb2] [FB:228]
<7> [67.240097] xe 0000:00:02.0: [drm:drm_mode_rmfb_work_fn] Removing [FB:225] from all active usage due to RMFB ioctl
<7> [67.256768] xe 0000:00:02.0: [drm:drm_mode_addfb2] [FB:225]
<7> [67.256802] xe 0000:00:02.0: [drm:drm_mode_rmfb_work_fn] Removing [FB:226] from all active usage due to RMFB ioctl
<7> [67.273506] xe 0000:00:02.0: [drm:drm_mode_addfb2] [FB:226]
<7> [67.273562] xe 0000:00:02.0: [drm:drm_mode_rmfb_work_fn] Removing [FB:228] from all active usage due to RMFB ioctl
<7> [67.290193] xe 0000:00:02.0: [drm:drm_mode_addfb2] [FB:228]
<7> [67.290249] xe 0000:00:02.0: [drm:drm_mode_rmfb_work_fn] Removing [FB:225] from all active usage due to RMFB ioctl
<7> [67.306748] xe 0000:00:02.0: [drm:drm_mode_addfb2] [FB:225]
<7> [67.306784] xe 0000:00:02.0: [drm:drm_mode_rmfb_work_fn] Removing [FB:226] from all active usage due to RMFB ioctl
<7> [67.323406] xe 0000:00:02.0: [drm:drm_mode_addfb2] [FB:226]
<7> [67.323439] xe 0000:00:02.0: [drm:drm_mode_rmfb_work_fn] Removing [FB:228] from all active usage due to RMFB ioctl
<7> [67.340049] xe 0000:00:02.0: [drm:drm_mode_addfb2] [FB:228]
<7> [67.340073] xe 0000:00:02.0: [drm:drm_mode_rmfb_work_fn] Removing [FB:225] from all active usage due to RMFB ioctl
<7> [67.356819] xe 0000:00:02.0: [drm:drm_mode_addfb2] [FB:225]
<7> [67.356873] xe 0000:00:02.0: [drm:drm_mode_rmfb_work_fn] Removing [FB:226] from all active usage due to RMFB ioctl
<7> [67.373501] xe 0000:00:02.0: [drm:drm_mode_addfb2] [FB:226]
<7> [67.373550] xe 0000:00:02.0: [drm:drm_mode_rmfb_work_fn] Removing [FB:228] from all active usage due to RMFB ioctl
<7> [67.390072] xe 0000:00:02.0: [drm:drm_mode_addfb2] [FB:228]
<7> [67.390106] xe 0000:00:02.0: [drm:drm_mode_rmfb_work_fn] Removing [FB:225] from all active usage due to RMFB ioctl
<7> [67.406788] xe 0000:00:02.0: [drm:drm_mode_addfb2] [FB:225]
<7> [67.406842] xe 0000:00:02.0: [drm:drm_mode_rmfb_work_fn] Removing [FB:226] from all active usage due to RMFB ioctl
<7> [67.423369] xe 0000:00:02.0: [drm:drm_mode_addfb2] [FB:226]
<7> [67.423398] xe 0000:00:02.0: [drm:drm_mode_rmfb_work_fn] Removing [FB:228] from all active usage due to RMFB ioctl
<7> [67.440271] xe 0000:00:02.0: [drm:drm_mode_addfb2] [FB:228]
<7> [67.440338] xe 0000:00:02.0: [drm:drm_mode_rmfb_work_fn] Removing [FB:225] from all active usage due to RMFB ioctl
<7> [67.456820] xe 0000:00:02.0: [drm:drm_mode_addfb2] [FB:225]
<7> [67.456865] xe 0000:00:02.0: [drm:drm_mode_rmfb_work_fn] Removing [FB:226] from all active usage due to RMFB ioctl
<7> [67.473383] xe 0000:00:02.0: [drm:drm_mode_addfb2] [FB:226]
<7> [67.473411] xe 0000:00:02.0: [drm:drm_mode_rmfb_work_fn] Removing [FB:228] from all active usage due to RMFB ioctl
<7> [67.490284] xe 0000:00:02.0: [drm:drm_mode_addfb2] [FB:228]
<7> [67.490361] xe 0000:00:02.0: [drm:drm_mode_rmfb_work_fn] Removing [FB:225] from all active usage due to RMFB ioctl
<7> [67.506794] xe 0000:00:02.0: [drm:drm_mode_addfb2] [FB:225]
<7> [67.506843] xe 0000:00:02.0: [drm:drm_mode_rmfb_work_fn] Removing [FB:226] from all active usage due to RMFB ioctl
<7> [67.523392] xe 0000:00:02.0: [drm:drm_mode_addfb2] [FB:226]
<7> [67.523424] xe 0000:00:02.0: [drm:drm_mode_rmfb_work_fn] Removing [FB:228] from all active usage due to RMFB ioctl
<7> [67.540172] xe 0000:00:02.0: [drm:drm_mode_addfb2] [FB:228]
<7> [67.540272] xe 0000:00:02.0: [drm:drm_mode_rmfb_work_fn] Removing [FB:225] from all active usage due to RMFB ioctl
<7> [67.556729] xe 0000:00:02.0: [drm:drm_mode_addfb2] [FB:225]
<7> [67.556769] xe 0000:00:02.0: [drm:drm_mode_rmfb_work_fn] Removing [FB:226] from all active usage due to RMFB ioctl
<7> [67.573366] xe 0000:00:02.0: [drm:drm_mode_addfb2] [FB:226]
<7> [67.573399] xe 0000:00:02.0: [drm:drm_mode_rmfb_work_fn] Removing [FB:228] from all active usage due to RMFB ioctl
<7> [67.590121] xe 0000:00:02.0: [drm:drm_mode_addfb2] [FB:228]
<7> [67.590184] xe 0000:00:02.0: [drm:drm_mode_rmfb_work_fn] Removing [FB:225] from all active usage due to RMFB ioctl
<7> [67.606951] xe 0000:00:02.0: [drm:drm_mode_addfb2] [FB:225]
<7> [67.607011] xe 0000:00:02.0: [drm:drm_mode_rmfb_work_fn] Removing [FB:226] from all active usage due to RMFB ioctl
<7> [67.623406] xe 0000:00:02.0: [drm:drm_mode_addfb2] [FB:226]
<7> [67.623448] xe 0000:00:02.0: [drm:drm_mode_rmfb_work_fn] Removing [FB:228] from all active usage due to RMFB ioctl
<7> [67.640049] xe 0000:00:02.0: [drm:drm_mode_addfb2] [FB:228]
<7> [67.640093] xe 0000:00:02.0: [drm:drm_mode_rmfb_work_fn] Removing [FB:225] from all active usage due to RMFB ioctl
<7> [67.656927] xe 0000:00:02.0: [drm:drm_mode_addfb2] [FB:225]
<7> [67.656996] xe 0000:00:02.0: [drm:drm_mode_rmfb_work_fn] Removing [FB:226] from all active usage due to RMFB ioctl
<7> [67.673511] xe 0000:00:02.0: [drm:drm_mode_addfb2] [FB:226]
<7> [67.673570] xe 0000:00:02.0: [drm:drm_mode_rmfb_work_fn] Removing [FB:228] from all active usage due to RMFB ioctl
<7> [67.690015] xe 0000:00:02.0: [drm:drm_mode_addfb2] [FB:228]
<7> [67.690043] xe 0000:00:02.0: [drm:drm_mode_rmfb_work_fn] Removing [FB:225] from all active usage due to RMFB ioctl
<7> [67.706691] xe 0000:00:02.0: [drm:drm_mode_addfb2] [FB:225]
<7> [67.706731] xe 0000:00:02.0: [drm:drm_mode_rmfb_work_fn] Removing [FB:226] from all active usage due to RMFB ioctl
<7> [67.723571] xe 0000:00:02.0: [drm:drm_mode_addfb2] [FB:226]
<7> [67.723634] xe 0000:00:02.0: [drm:drm_mode_rmfb_work_fn] Removing [FB:228] from all active usage due to RMFB ioctl
<7> [67.740087] xe 0000:00:02.0: [drm:drm_mode_addfb2] [FB:228]
<7> [67.740137] xe 0000:00:02.0: [drm:drm_mode_rmfb_work_fn] Removing [FB:225] from all active usage due to RMFB ioctl
<7> [67.756676] xe 0000:00:02.0: [drm:drm_mode_addfb2] [FB:225]
<7> [67.756713] xe 0000:00:02.0: [drm:drm_mode_rmfb_work_fn] Removing [FB:226] from all active usage due to RMFB ioctl
<7> [67.773421] xe 0000:00:02.0: [drm:drm_mode_addfb2] [FB:226]
<7> [67.773475] xe 0000:00:02.0: [drm:drm_mode_rmfb_work_fn] Removing [FB:228] from all active usage due to RMFB ioctl
<7> [67.790071] xe 0000:00:02.0: [drm:drm_mode_addfb2] [FB:228]
<7> [67.790127] xe 0000:00:02.0: [drm:drm_mode_rmfb_work_fn] Removing [FB:225] from all active usage due to RMFB ioctl
<7> [67.806668] xe 0000:00:02.0: [drm:drm_mode_addfb2] [FB:225]
<7> [67.806700] xe 0000:00:02.0: [drm:drm_mode_rmfb_work_fn] Removing [FB:226] from all active usage due to RMFB ioctl
<7> [67.823498] xe 0000:00:02.0: [drm:drm_mode_addfb2] [FB:226]
<7> [67.823564] xe 0000:00:02.0: [drm:drm_mode_rmfb_work_fn] Removing [FB:228] from all active usage due to RMFB ioctl
<7> [67.840059] xe 0000:00:02.0: [drm:drm_mode_addfb2] [FB:228]
<7> [67.840102] xe 0000:00:02.0: [drm:drm_mode_rmfb_work_fn] Removing [FB:225] from all active usage due to RMFB ioctl
<7> [67.856676] xe 0000:00:02.0: [drm:drm_mode_addfb2] [FB:225]
<7> [67.856717] xe 0000:00:02.0: [drm:drm_mode_rmfb_work_fn] Removing [FB:226] from all active usage due to RMFB ioctl
<7> [67.873368] xe 0000:00:02.0: [drm:drm_mode_addfb2] [FB:226]
<7> [67.873420] xe 0000:00:02.0: [drm:drm_mode_rmfb_work_fn] Removing [FB:228] from all active usage due to RMFB ioctl
<7> [67.890004] xe 0000:00:02.0: [drm:drm_mode_addfb2] [FB:228]
<7> [67.890041] xe 0000:00:02.0: [drm:drm_mode_rmfb_work_fn] Removing [FB:225] from all active usage due to RMFB ioctl
<7> [67.906634] xe 0000:00:02.0: [drm:drm_mode_addfb2] [FB:225]
<7> [67.906661] xe 0000:00:02.0: [drm:drm_mode_rmfb_work_fn] Removing [FB:226] from all active usage due to RMFB ioctl
<7> [67.923286] xe 0000:00:02.0: [drm:drm_mode_addfb2] [FB:226]
<7> [67.923308] xe 0000:00:02.0: [drm:drm_mode_rmfb_work_fn] Removing [FB:228] from all active usage due to RMFB ioctl
<7> [67.940172] xe 0000:00:02.0: [drm:drm_mode_addfb2] [FB:228]
<7> [67.940238] xe 0000:00:02.0: [drm:drm_mode_rmfb_work_fn] Removing [FB:225] from all active usage due to RMFB ioctl
<7> [67.956772] xe 0000:00:02.0: [drm:drm_mode_addfb2] [FB:225]
<7> [67.956846] xe 0000:00:02.0: [drm:drm_mode_rmfb_work_fn] Removing [FB:226] from all active usage due to RMFB ioctl
<7> [67.973586] xe 0000:00:02.0: [drm:drm_mode_addfb2] [FB:226]
<7> [67.973658] xe 0000:00:02.0: [drm:drm_mode_rmfb_work_fn] Removing [FB:228] from all active usage due to RMFB ioctl
<7> [67.990136] xe 0000:00:02.0: [drm:drm_mode_addfb2] [FB:228]
<7> [67.990218] xe 0000:00:02.0: [drm:drm_mode_rmfb_work_fn] Removing [FB:225] from all active usage due to RMFB ioctl
<7> [68.006659] xe 0000:00:02.0: [drm:drm_mode_addfb2] [FB:225]
<7> [68.006708] xe 0000:00:02.0: [drm:drm_mode_rmfb_work_fn] Removing [FB:226] from all active usage due to RMFB ioctl
<7> [68.023375] xe 0000:00:02.0: [drm:drm_mode_addfb2] [FB:226]
<7> [68.023421] xe 0000:00:02.0: [drm:drm_mode_rmfb_work_fn] Removing [FB:228] from all active usage due to RMFB ioctl
<7> [68.040111] xe 0000:00:02.0: [drm:drm_mode_addfb2] [FB:228]
<7> [68.040166] xe 0000:00:02.0: [drm:drm_mode_rmfb_work_fn] Removing [FB:225] from all active usage due to RMFB ioctl
<7> [68.056701] xe 0000:00:02.0: [drm:drm_mode_addfb2] [FB:225]
<7> [68.056756] xe 0000:00:02.0: [drm:drm_mode_rmfb_work_fn] Removing [FB:226] from all active usage due to RMFB ioctl
<7> [68.073356] xe 0000:00:02.0: [drm:drm_mode_addfb2] [FB:226]
<7> [68.073402] xe 0000:00:02.0: [drm:drm_mode_rmfb_work_fn] Removing [FB:228] from all active usage due to RMFB ioctl
<7> [68.090053] xe 0000:00:02.0: [drm:drm_mode_addfb2] [FB:228]
<7> [68.090106] xe 0000:00:02.0: [drm:drm_mode_rmfb_work_fn] Removing [FB:225] from all active usage due to RMFB ioctl
<7> [68.106840] xe 0000:00:02.0: [drm:drm_mode_addfb2] [FB:225]
<7> [68.106907] xe 0000:00:02.0: [drm:drm_mode_rmfb_work_fn] Removing [FB:226] from all active usage due to RMFB ioctl
<7> [68.123420] xe 0000:00:02.0: [drm:drm_mode_addfb2] [FB:226]
<7> [68.123531] xe 0000:00:02.0: [drm:drm_mode_rmfb_work_fn] Removing [FB:228] from all active usage due to RMFB ioctl
<7> [68.139928] xe 0000:00:02.0: [drm:drm_mode_addfb2] [FB:228]
<7> [68.139954] xe 0000:00:02.0: [drm:drm_mode_rmfb_work_fn] Removing [FB:225] from all active usage due to RMFB ioctl
<7> [68.156581] xe 0000:00:02.0: [drm:drm_mode_addfb2] [FB:225]
<7> [68.156603] xe 0000:00:02.0: [drm:drm_mode_rmfb_work_fn] Removing [FB:226] from all active usage due to RMFB ioctl
<7> [68.173487] xe 0000:00:02.0: [drm:drm_mode_addfb2] [FB:226]
<7> [68.173554] xe 0000:00:02.0: [drm:drm_mode_rmfb_work_fn] Removing [FB:228] from all active usage due to RMFB ioctl
<7> [68.190021] xe 0000:00:02.0: [drm:drm_mode_addfb2] [FB:228]
<7> [68.190081] xe 0000:00:02.0: [drm:drm_mode_rmfb_work_fn] Removing [FB:225] from all active usage due to RMFB ioctl
<7> [68.206586] xe 0000:00:02.0: [drm:drm_mode_addfb2] [FB:225]
<7> [68.206614] xe 0000:00:02.0: [drm:drm_mode_rmfb_work_fn] Removing [FB:226] from all active usage due to RMFB ioctl
<7> [68.223243] xe 0000:00:02.0: [drm:drm_mode_addfb2] [FB:226]
<7> [68.223266] xe 0000:00:02.0: [drm:drm_mode_rmfb_work_fn] Removing [FB:228] from all active usage due to RMFB ioctl
<7> [68.240059] xe 0000:00:02.0: [drm:drm_mode_addfb2] [FB:228]
<7> [68.240128] xe 0000:00:02.0: [drm:drm_mode_rmfb_work_fn] Removing [FB:225] from all active usage due to RMFB ioctl
<7> [68.256821] xe 0000:00:02.0: [drm:drm_mode_addfb2] [FB:225]
<7> [68.256880] xe 0000:00:02.0: [drm:drm_mode_rmfb_work_fn] Removing [FB:226] from all active usage due to RMFB ioctl
<7> [68.273320] xe 0000:00:02.0: [drm:drm_mode_addfb2] [FB:226]
<7> [68.273366] xe 0000:00:02.0: [drm:drm_mode_rmfb_work_fn] Removing [FB:228] from all active usage due to RMFB ioctl
<7> [68.289934] xe 0000:00:02.0: [drm:drm_mode_addfb2] [FB:228]
<7> [68.289973] xe 0000:00:02.0: [drm:drm_mode_rmfb_work_fn] Removing [FB:225] from all active usage due to RMFB ioctl
<7> [68.306575] xe 0000:00:02.0: [drm:drm_mode_addfb2] [FB:225]
<7> [68.306606] xe 0000:00:02.0: [drm:drm_mode_rmfb_work_fn] Removing [FB:226] from all active usage due to RMFB ioctl
<7> [68.323447] xe 0000:00:02.0: [drm:drm_mode_addfb2] [FB:226]
<7> [68.323507] xe 0000:00:02.0: [drm:drm_mode_rmfb_work_fn] Removing [FB:228] from all active usage due to RMFB ioctl
<7> [68.339956] xe 0000:00:02.0: [drm:drm_mode_addfb2] [FB:228]
<7> [68.339996] xe 0000:00:02.0: [drm:drm_mode_rmfb_work_fn] Removing [FB:225] from all active usage due to RMFB ioctl
<7> [68.356591] xe 0000:00:02.0: [drm:drm_mode_addfb2] [FB:225]
<7> [68.356627] xe 0000:00:02.0: [drm:drm_mode_rmfb_work_fn] Removing [FB:226] from all active usage due to RMFB ioctl
<7> [68.373223] xe 0000:00:02.0: [drm:drm_mode_addfb2] [FB:226]
<7> [68.373247] xe 0000:00:02.0: [drm:drm_mode_rmfb_work_fn] Removing [FB:228] from all active usage due to RMFB ioctl
<7> [68.389950] xe 0000:00:02.0: [drm:drm_mode_addfb2] [FB:228]
<7> [68.389990] xe 0000:00:02.0: [drm:drm_mode_rmfb_work_fn] Removing [FB:225] from all active usage due to RMFB ioctl
<7> [68.406578] xe 0000:00:02.0: [drm:drm_mode_addfb2] [FB:225]
<7> [68.406616] xe 0000:00:02.0: [drm:drm_mode_rmfb_work_fn] Removing [FB:226] from all active usage due to RMFB ioctl
<7> [68.423236] xe 0000:00:02.0: [drm:drm_mode_addfb2] [FB:226]
<7> [68.423267] xe 0000:00:02.0: [drm:drm_mode_rmfb_work_fn] Removing [FB:228] from all active usage due to RMFB ioctl
<7> [68.439913] xe 0000:00:02.0: [drm:drm_mode_addfb2] [FB:228]
<7> [68.439949] xe 0000:00:02.0: [drm:drm_mode_rmfb_work_fn] Removing [FB:225] from all active usage due to RMFB ioctl
<7> [68.456774] xe 0000:00:02.0: [drm:drm_mode_addfb2] [FB:225]
<7> [68.456845] xe 0000:00:02.0: [drm:drm_mode_rmfb_work_fn] Removing [FB:226] from all active usage due to RMFB ioctl
<7> [68.473314] xe 0000:00:02.0: [drm:drm_mode_addfb2] [FB:226]
<7> [68.473365] xe 0000:00:02.0: [drm:drm_mode_rmfb_work_fn] Removing [FB:228] from all active usage due to RMFB ioctl
<7> [68.507220] xe 0000:00:02.0: [drm:intel_power_well_disable [xe]] disabling DC_off
<7> [68.507634] xe 0000:00:02.0: [drm:skl_enable_dc6 [xe]] Enabling DC6
<7> [68.507971] xe 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [xe]] Setting DC state from 00 to 02
<6> [71.702523] [IGT] kms_flip: finished subtest A-eDP1, FAIL
Created at 2025-03-04 21:35:31