Results for igt@kms_flip@plain-flip-ts-check

Result: Fail

integration-manifest git-log-oneline i915_display_info20 igt_runner20 runtimes20 results20.json results20-i915-load.json guc_logs20.tar i915_display_info_post_exec20 boot20 dmesg20

DetailValue
Duration 44.72 seconds
Hostname 
shard-rkl-4
Igt-Version 
IGT-Version: 2.3-ga50285a68 (x86_64) (Linux: 7.0.0-rc2-CI_DRM_18095-gd927c128e21f+ x86_64)
Out 
Using IGT_SRANDOM=1772767451 for randomisation
Opened device: /dev/dri/card0
Using monotonic timestamps
Starting subtest: plain-flip-ts-check
Starting dynamic subtest: A-HDMI-A2
  1920x1080: 53 139930 1920 2008 2096 2360 1080 1084 1089 1125 0x48 0x5 
Expected frametime: 18974us; measured 19907.8us +- 7.742us accuracy 0.12%
vblank interval differs from modeline! expected 18973.8us, measured 19908us +- 7.742us, difference 934.0us (120.6 sigma)
Event flip: expected 502, counted 514, passrate = 0.39%, encoder type 2
Expected frametime: 18974us; measured 19126.4us +- 8.342us accuracy 0.13%
vblank interval differs from modeline! expected 18973.8us, measured 19126us +- 8.342us, difference 152.7us (18.3 sigma)
Event flip: expected 523, counted 525, passrate = 84.57%, encoder type 2
Stack trace:
  #0 ../lib/igt_core.c:2075 __igt_fail_assert()
  #1 ../tests/kms_flip.c:428 run_test_on_crtc_set.constprop.0()
  #2 ../tests/kms_flip.c:1887 run_test()
  #3 ../tests/kms_flip.c:2120 __igt_unique____real_main2043()
  #4 ../tests/kms_flip.c:2043 main()
  #5 [__libc_init_first+0x8a]
  #6 [__libc_start_main+0x8b]
  #7 [_start+0x25]
Dynamic subtest A-HDMI-A2: FAIL (23.776s)
Starting dynamic subtest: B-HDMI-A2
  1920x1080: 53 139930 1920 2008 2096 2360 1080 1084 1089 1125 0x48 0x5 
Expected frametime: 18974us; measured 19019.3us +- 6.019us accuracy 0.09%
vblank interval differs from modeline! expected 18973.8us, measured 19019us +- 6.019us, difference 45.5us (7.6 sigma)
Event flip: expected 526, counted 527, passrate = 100.00%, encoder type 2
Dynamic subtest B-HDMI-A2: SUCCESS (10.479s)
Starting dynamic subtest: C-HDMI-A2
  1920x1080: 53 139930 1920 2008 2096 2360 1080 1084 1089 1125 0x48 0x5 
Expected frametime: 18974us; measured 18982.1us +- 7.473us accuracy 0.12%
Event flip: expected 527, counted 527, passrate = 100.00%, encoder type 2
Dynamic subtest C-HDMI-A2: SUCCESS (10.453s)
Subtest plain-flip-ts-check: FAIL (44.717s)
Err 
Starting subtest: plain-flip-ts-check
Starting dynamic subtest: A-HDMI-A2
(kms_flip:2604) CRITICAL: Test assertion failure function __run_test_on_crtc_set, file ../tests/kms_flip.c:1707:
(kms_flip:2604) CRITICAL: Failed assertion: !retried
Dynamic subtest A-HDMI-A2 failed.
**** DEBUG ****
(kms_flip:2604) DEBUG: flip ts/seq: last 363.901337/4683, current 363.920349/4684: elapsed=19028.0us expected=19126.4us +- 95.6us, error 0.5%
(kms_flip:2604) DEBUG: inconsistent flip ts/seq: last 363.901337/4683, current 363.920349/4684: elapsed=19028.0us expected=19126.4us
(kms_flip:2604) DEBUG: name = flip
last_ts = 363.920349
last_received_ts = 363.919891
last_seq = 4684
current_ts = 363.939392
current_received_ts = 363.938934
current_seq = 4685
count = 437
seq_step = 1
(kms_flip:2604) DEBUG: flip ts/seq: last 363.920349/4684, current 363.939392/4685: elapsed=19027.0us expected=19126.4us +- 95.6us, error 0.5%
(kms_flip:2604) DEBUG: inconsistent flip ts/seq: last 363.920349/4684, current 363.939392/4685: elapsed=19027.0us expected=19126.4us
(kms_flip:2604) DEBUG: name = flip
last_ts = 363.939392
last_received_ts = 363.938934
last_seq = 4685
current_ts = 363.958435
current_received_ts = 363.957977
current_seq = 4686
count = 438
seq_step = 1
(kms_flip:2604) DEBUG: flip ts/seq: last 363.939392/4685, current 363.958435/4686: elapsed=19042.0us expected=19126.4us +- 95.6us, error 0.4%
(kms_flip:2604) DEBUG: name = flip
last_ts = 363.958435
last_received_ts = 363.957977
last_seq = 4686
current_ts = 363.977448
current_received_ts = 363.977081
current_seq = 4687
count = 439
seq_step = 1
(kms_flip:2604) DEBUG: flip ts/seq: last 363.958435/4686, current 363.977448/4687: elapsed=19032.0us expected=19126.4us +- 95.6us, error 0.5%
(kms_flip:2604) DEBUG: name = flip
last_ts = 363.977448
last_received_ts = 363.977081
last_seq = 4687
current_ts = 363.996490
current_received_ts = 363.996124
current_seq = 4688
count = 440
seq_step = 1
(kms_flip:2604) DEBUG: flip ts/seq: last 363.977448/4687, current 363.996490/4688: elapsed=19022.0us expected=19126.4us +- 95.6us, error 0.5%
(kms_flip:2604) DEBUG: inconsistent flip ts/seq: last 363.977448/4687, current 363.996490/4688: elapsed=19022.0us expected=19126.4us
(kms_flip:2604) DEBUG: name = flip
last_ts = 363.996490
last_received_ts = 363.996124
last_seq = 4688
current_ts = 364.015503
current_received_ts = 364.015076
current_seq = 4689
count = 441
seq_step = 1
(kms_flip:2604) DEBUG: flip ts/seq: last 363.996490/4688, current 364.015503/4689: elapsed=19037.0us expected=19126.4us +- 95.6us, error 0.5%
(kms_flip:2604) DEBUG: name = flip
last_ts = 364.015503
last_received_ts = 364.015076
last_seq = 4689
current_ts = 364.034546
current_received_ts = 364.034058
current_seq = 4690
count = 442
seq_step = 1
(kms_flip:2604) DEBUG: flip ts/seq: last 364.015503/4689, current 364.034546/4690: elapsed=19039.0us expected=19126.4us +- 95.6us, error 0.5%
(kms_flip:2604) DEBUG: name = flip
last_ts = 364.034546
last_received_ts = 364.034058
last_seq = 4690
current_ts = 364.053589
current_received_ts = 364.053131
current_seq = 4691
count = 443
seq_step = 1
(kms_flip:2604) DEBUG: flip ts/seq: last 364.034546/4690, current 364.053589/4691: elapsed=19020.0us expected=19126.4us +- 95.6us, error 0.6%
(kms_flip:2604) DEBUG: inconsistent flip ts/seq: last 364.034546/4690, current 364.053589/4691: elapsed=19020.0us expected=19126.4us
(kms_flip:2604) DEBUG: name = flip
last_ts = 364.053589
last_received_ts = 364.053131
last_seq = 4691
current_ts = 364.072632
current_received_ts = 364.072174
current_seq = 4692
count = 444
seq_step = 1
(kms_flip:2604) DEBUG: flip ts/seq: last 364.053589/4691, current 364.072632/4692: elapsed=19045.0us expected=19126.4us +- 95.6us, error 0.4%
(kms_flip:2604) DEBUG: name = flip
last_ts = 364.072632
last_received_ts = 364.072174
last_seq = 4692
current_ts = 364.091644
current_received_ts = 364.091125
current_seq = 4693
count = 445
seq_step = 1
(kms_flip:2604) DEBUG: flip ts/seq: last 364.072632/4692, current 364.091644/4693: elapsed=19029.0us expected=19126.4us +- 95.6us, error 0.5%
(kms_flip:2604) DEBUG: inconsistent flip ts/seq: last 364.072632/4692, current 364.091644/4693: elapsed=19029.0us expected=19126.4us
(kms_flip:2604) DEBUG: name = flip
last_ts = 364.091644
last_received_ts = 364.091125
last_seq = 4693
current_ts = 364.110657
current_received_ts = 364.110168
current_seq = 4694
count = 446
seq_step = 1
(kms_flip:2604) DEBUG: flip ts/seq: last 364.091644/4693, current 364.110657/4694: elapsed=19021.0us expected=19126.4us +- 95.6us, error 0.6%
(kms_flip:2604) DEBUG: inconsistent flip ts/seq: last 364.091644/4693, current 364.110657/4694: elapsed=19021.0us expected=19126.4us
(kms_flip:2604) DEBUG: name = flip
last_ts = 364.110657
last_received_ts = 364.110168
last_seq = 4694
current_ts = 364.129700
current_received_ts = 364.129211
current_seq = 4695
count = 447
seq_step = 1
(kms_flip:2604) DEBUG: flip ts/seq: last 364.110657/4694, current 364.129700/4695: elapsed=19032.0us expected=19126.4us +- 95.6us, error 0.5%
(kms_flip:2604) DEBUG: name = flip
last_ts = 364.129700
last_received_ts = 364.129211
last_seq = 4695
current_ts = 364.148743
current_received_ts = 364.148346
current_seq = 4696
count = 448
seq_step = 1
(kms_flip:2604) DEBUG: flip ts/seq: last 364.129700/4695, current 364.148743/4696: elapsed=19036.0us expected=19126.4us +- 95.6us, error 0.5%
(kms_flip:2604) DEBUG: name = flip
last_ts = 364.148743
last_received_ts = 364.148346
last_seq = 4696
current_ts = 364.167755
current_received_ts = 364.167267
current_seq = 4697
count = 449
seq_step = 1
(kms_flip:2604) DEBUG: flip ts/seq: last 364.148743/4696, current 364.167755/4697: elapsed=19030.0us expected=19126.4us +- 95.6us, error 0.5%
(kms_flip:2604) DEBUG: inconsistent flip ts/seq: last 364.148743/4696, current 364.167755/4697: elapsed=19030.0us expected=19126.4us
(kms_flip:2604) DEBUG: name = flip
last_ts = 364.167755
last_received_ts = 364.167267
last_seq = 4697
current_ts = 364.186798
current_received_ts = 364.186371
current_seq = 4698
count = 450
seq_step = 1
(kms_flip:2604) DEBUG: flip ts/seq: last 364.167755/4697, current 364.186798/4698: elapsed=19026.0us expected=19126.4us +- 95.6us, error 0.5%
(kms_flip:2604) DEBUG: inconsistent flip ts/seq: last 364.167755/4697, current 364.186798/4698: elapsed=19026.0us expected=19126.4us
(kms_flip:2604) DEBUG: name = flip
last_ts = 364.186798
last_received_ts = 364.186371
last_seq = 4698
current_ts = 364.205811
current_received_ts = 364.205444
current_seq = 4699
count = 451
seq_step = 1
(kms_flip:2604) DEBUG: flip ts/seq: last 364.186798/4698, current 364.205811/4699: elapsed=19022.0us expected=19126.4us +- 95.6us, error 0.5%
(kms_flip:2604) DEBUG: inconsistent flip ts/seq: last 364.186798/4698, current 364.205811/4699: elapsed=19022.0us expected=19126.4us
(kms_flip:2604) DEBUG: name = flip
last_ts = 364.205811
last_received_ts = 364.205444
last_seq = 4699
current_ts = 364.224854
current_received_ts = 364.224396
current_seq = 4700
count = 452
seq_step = 1
(kms_flip:2604) DEBUG: flip ts/seq: last 364.205811/4699, current 364.224854/4700: elapsed=19028.0us expected=19126.4us +- 95.6us, error 0.5%
(kms_flip:2604) DEBUG: inconsistent flip ts/seq: last 364.205811/4699, current 364.224854/4700: elapsed=19028.0us expected=19126.4us
(kms_flip:2604) DEBUG: name = flip
last_ts = 364.224854
last_received_ts = 364.224396
last_seq = 4700
current_ts = 364.243866
current_received_ts = 364.243469
current_seq = 4701
count = 453
seq_step = 1
(kms_flip:2604) DEBUG: flip ts/seq: last 364.224854/4700, current 364.243866/4701: elapsed=19036.0us expected=19126.4us +- 95.6us, error 0.5%
(kms_flip:2604) DEBUG: name = flip
last_ts = 364.243866
last_received_ts = 364.243469
last_seq = 4701
current_ts = 364.262909
current_received_ts = 364.262512
current_seq = 4702
count = 454
seq_step = 1
(kms_flip:2604) DEBUG: flip ts/seq: last 364.243866/4701, current 364.262909/4702: elapsed=19014.0us expected=19126.4us +- 95.6us, error 0.6%
(kms_flip:2604) DEBUG: inconsistent flip ts/seq: last 364.243866/4701, current 364.262909/4702: elapsed=19014.0us expected=19126.4us
(kms_flip:2604) DEBUG: name = flip
last_ts = 364.262909
last_received_ts = 364.262512
last_seq = 4702
current_ts = 364.281921
current_received_ts = 364.281525
current_seq = 4703
count = 455
seq_step = 1
(kms_flip:2604) DEBUG: flip ts/seq: last 364.262909/4702, current 364.281921/4703: elapsed=19036.0us expected=19126.4us +- 95.6us, error 0.5%
(kms_flip:2604) DEBUG: name = flip
last_ts = 364.281921
last_received_ts = 364.281525
last_seq = 4703
current_ts = 364.300964
current_received_ts = 364.300537
current_seq = 4704
count = 456
seq_step = 1
(kms_flip:2604) DEBUG: flip ts/seq: last 364.281921/4703, current 364.300964/4704: elapsed=19026.0us expected=19126.4us +- 95.6us, error 0.5%
(kms_flip:2604) DEBUG: inconsistent flip ts/seq: last 364.281921/4703, current 364.300964/4704: elapsed=19026.0us expected=19126.4us
(kms_flip:2604) DEBUG: name = flip
last_ts = 364.300964
last_received_ts = 364.300537
last_seq = 4704
current_ts = 364.319977
current_received_ts = 364.319580
current_seq = 4705
count = 457
seq_step = 1
(kms_flip:2604) DEBUG: flip ts/seq: last 364.300964/4704, current 364.319977/4705: elapsed=19026.0us expected=19126.4us +- 95.6us, error 0.5%
(kms_flip:2604) DEBUG: inconsistent flip ts/seq: last 364.300964/4704, current 364.319977/4705: elapsed=19026.0us expected=19126.4us
(kms_flip:2604) DEBUG: name = flip
last_ts = 364.319977
last_received_ts = 364.319580
last_seq = 4705
current_ts = 364.338989
current_received_ts = 364.338562
current_seq = 4706
count = 458
seq_step = 1
(kms_flip:2604) DEBUG: flip ts/seq: last 364.319977/4705, current 364.338989/4706: elapsed=19021.0us expected=19126.4us +- 95.6us, error 0.6%
(kms_flip:2604) DEBUG: inconsistent flip ts/seq: last 364.319977/4705, current 364.338989/4706: elapsed=19021.0us expected=19126.4us
(kms_flip:2604) DEBUG: name = flip
last_ts = 364.338989
last_received_ts = 364.338562
last_seq = 4706
current_ts = 364.358032
current_received_ts = 364.357574
current_seq = 4707
count = 459
seq_step = 1
(kms_flip:2604) DEBUG: flip ts/seq: last 364.338989/4706, current 364.358032/4707: elapsed=19021.0us expected=19126.4us +- 95.6us, error 0.6%
(kms_flip:2604) DEBUG: inconsistent flip ts/seq: last 364.338989/4706, current 364.358032/4707: elapsed=19021.0us expected=19126.4us
(kms_flip:2604) DEBUG: name = flip
last_ts = 364.358032
last_received_ts = 364.357574
last_seq = 4707
current_ts = 364.377075
current_received_ts = 364.376556
current_seq = 4708
count = 460
seq_step = 1
(kms_flip:2604) DEBUG: flip ts/seq: last 364.358032/4707, current 364.377075/4708: elapsed=19037.0us expected=19126.4us +- 95.6us, error 0.5%
(kms_flip:2604) DEBUG: name = flip
last_ts = 364.377075
last_received_ts = 364.376556
last_seq = 4708
current_ts = 364.396088
current_received_ts = 364.395599
current_seq = 4709
count = 461
seq_step = 1
(kms_flip:2604) DEBUG: flip ts/seq: last 364.377075/4708, current 364.396088/4709: elapsed=19028.0us expected=19126.4us +- 95.6us, error 0.5%
(kms_flip:2604) DEBUG: inconsistent flip ts/seq: last 364.377075/4708, current 364.396088/4709: elapsed=19028.0us expected=19126.4us
(kms_flip:2604) DEBUG: name = flip
last_ts = 364.396088
last_received_ts = 364.395599
last_seq = 4709
current_ts = 364.415100
current_received_ts = 364.414703
current_seq = 4710
count = 462
seq_step = 1
(kms_flip:2604) DEBUG: flip ts/seq: last 364.396088/4709, current 364.415100/4710: elapsed=19018.0us expected=19126.4us +- 95.6us, error 0.6%
(kms_flip:2604) DEBUG: inconsistent flip ts/seq: last 364.396088/4709, current 364.415100/4710: elapsed=19018.0us expected=19126.4us
(kms_flip:2604) DEBUG: name = flip
last_ts = 364.415100
last_received_ts = 364.414703
last_seq = 4710
current_ts = 364.434143
current_received_ts = 364.433685
current_seq = 4711
count = 463
seq_step = 1
(kms_flip:2604) DEBUG: flip ts/seq: last 364.415100/4710, current 364.434143/4711: elapsed=19033.0us expected=19126.4us +- 95.6us, error 0.5%
(kms_flip:2604) DEBUG: name = flip
last_ts = 364.434143
last_received_ts = 364.433685
last_seq = 4711
current_ts = 364.453156
current_received_ts = 364.452667
current_seq = 4712
count = 464
seq_step = 1
(kms_flip:2604) DEBUG: flip ts/seq: last 364.434143/4711, current 364.453156/4712: elapsed=19027.0us expected=19126.4us +- 95.6us, error 0.5%
(kms_flip:2604) DEBUG: inconsistent flip ts/seq: last 364.434143/4711, current 364.453156/4712: elapsed=19027.0us expected=19126.4us
(kms_flip:2604) DEBUG: name = flip
last_ts = 364.453156
last_received_ts = 364.452667
last_seq = 4712
current_ts = 364.472198
current_received_ts = 364.471649
current_seq = 4713
count = 465
seq_step = 1
(kms_flip:2604) DEBUG: flip ts/seq: last 364.453156/4712, current 364.472198/4713: elapsed=19023.0us expected=19126.4us +- 95.6us, error 0.5%
(kms_flip:2604) DEBUG: inconsistent flip ts/seq: last 364.453156/4712, current 364.472198/4713: elapsed=19023.0us expected=19126.4us
(kms_flip:2604) DEBUG: name = flip
last_ts = 364.472198
last_received_ts = 364.471649
last_seq = 4713
current_ts = 364.491211
current_received_ts = 364.490814
current_seq = 4714
count = 466
seq_step = 1
(kms_flip:2604) DEBUG: flip ts/seq: last 364.472198/4713, current 364.491211/4714: elapsed=19020.0us expected=19126.4us +- 95.6us, error 0.6%
(kms_flip:2604) DEBUG: inconsistent flip ts/seq: last 364.472198/4713, current 364.491211/4714: elapsed=19020.0us expected=19126.4us
(kms_flip:2604) DEBUG: name = flip
last_ts = 364.491211
last_received_ts = 364.490814
last_seq = 4714
current_ts = 364.510254
current_received_ts = 364.509674
current_seq = 4715
count = 467
seq_step = 1
(kms_flip:2604) DEBUG: flip ts/seq: last 364.491211/4714, current 364.510254/4715: elapsed=19029.0us expected=19126.4us +- 95.6us, error 0.5%
(kms_flip:2604) DEBUG: inconsistent flip ts/seq: last 364.491211/4714, current 364.510254/4715: elapsed=19029.0us expected=19126.4us
(kms_flip:2604) DEBUG: name = flip
last_ts = 364.510254
last_received_ts = 364.509674
last_seq = 4715
current_ts = 364.529266
current_received_ts = 364.528870
current_seq = 4716
count = 468
seq_step = 1
(kms_flip:2604) DEBUG: flip ts/seq: last 364.510254/4715, current 364.529266/4716: elapsed=19034.0us expected=19126.4us +- 95.6us, error 0.5%
(kms_flip:2604) DEBUG: name = flip
last_ts = 364.529266
last_received_ts = 364.528870
last_seq = 4716
current_ts = 364.548279
current_received_ts = 364.547821
current_seq = 4717
count = 469
seq_step = 1
(kms_flip:2604) DEBUG: flip ts/seq: last 364.529266/4716, current 364.548279/4717: elapsed=19010.0us expected=19126.4us +- 95.6us, error 0.6%
(kms_flip:2604) DEBUG: inconsistent flip ts/seq: last 364.529266/4716, current 364.548279/4717: elapsed=19010.0us expected=19126.4us
(kms_flip:2604) DEBUG: name = flip
last_ts = 364.548279
last_received_ts = 364.547821
last_seq = 4717
current_ts = 364.567322
current_received_ts = 364.566864
current_seq = 4718
count = 470
seq_step = 1
(kms_flip:2604) DEBUG: flip ts/seq: last 364.548279/4717, current 364.567322/4718: elapsed=19038.0us expected=19126.4us +- 95.6us, error 0.5%
(kms_flip:2604) DEBUG: name = flip
last_ts = 364.567322
last_received_ts = 364.566864
last_seq = 4718
current_ts = 364.586334
current_received_ts = 364.585876
current_seq = 4719
count = 471
seq_step = 1
(kms_flip:2604) DEBUG: flip ts/seq: last 364.567322/4718, current 364.586334/4719: elapsed=19022.0us expected=19126.4us +- 95.6us, error 0.5%
(kms_flip:2604) DEBUG: inconsistent flip ts/seq: last 364.567322/4718, current 364.586334/4719: elapsed=19022.0us expected=19126.4us
(kms_flip:2604) DEBUG: name = flip
last_ts = 364.586334
last_received_ts = 364.585876
last_seq = 4719
current_ts = 364.605377
current_received_ts = 364.604919
current_seq = 4720
count = 472
seq_step = 1
(kms_flip:2604) DEBUG: flip ts/seq: last 364.586334/4719, current 364.605377/4720: elapsed=19029.0us expected=19126.4us +- 95.6us, error 0.5%
(kms_flip:2604) DEBUG: inconsistent flip ts/seq: last 364.586334/4719, current 364.605377/4720: elapsed=19029.0us expected=19126.4us
(kms_flip:2604) DEBUG: name = flip
last_ts = 364.605377
last_received_ts = 364.604919
last_seq = 4720
current_ts = 364.624390
current_received_ts = 364.623932
current_seq = 4721
count = 473
seq_step = 1
(kms_flip:2604) DEBUG: flip ts/seq: last 364.605377/4720, current 364.624390/4721: elapsed=19024.0us expected=19126.4us +- 95.6us, error 0.5%
(kms_flip:2604) DEBUG: inconsistent flip ts/seq: last 364.605377/4720, current 364.624390/4721: elapsed=19024.0us expected=19126.4us
(kms_flip:2604) DEBUG: name = flip
last_ts = 364.624390
last_received_ts = 364.623932
last_seq = 4721
current_ts = 364.643433
current_received_ts = 364.643005
current_seq = 4722
count = 474
seq_step = 1
(kms_flip:2604) DEBUG: flip ts/seq: last 364.624390/4721, current 364.643433/4722: elapsed=19026.0us expected=19126.4us +- 95.6us, error 0.5%
(kms_flip:2604) DEBUG: inconsistent flip ts/seq: last 364.624390/4721, current 364.643433/4722: elapsed=19026.0us expected=19126.4us
(kms_flip:2604) DEBUG: name = flip
last_ts = 364.643433
last_received_ts = 364.643005
last_seq = 4722
current_ts = 364.662445
current_received_ts = 364.661987
current_seq = 4723
count = 475
seq_step = 1
(kms_flip:2604) DEBUG: flip ts/seq: last 364.643433/4722, current 364.662445/4723: elapsed=19024.0us expected=19126.4us +- 95.6us, error 0.5%
(kms_flip:2604) DEBUG: inconsistent flip ts/seq: last 364.643433/4722, current 364.662445/4723: elapsed=19024.0us expected=19126.4us
(kms_flip:2604) DEBUG: name = flip
last_ts = 364.662445
last_received_ts = 364.661987
last_seq = 4723
current_ts = 364.681458
current_received_ts = 364.681061
current_seq = 4724
count = 476
seq_step = 1
(kms_flip:2604) DEBUG: flip ts/seq: last 364.662445/4723, current 364.681458/4724: elapsed=19024.0us expected=19126.4us +- 95.6us, error 0.5%
(kms_flip:2604) DEBUG: inconsistent flip ts/seq: last 364.662445/4723, current 364.681458/4724: elapsed=19024.0us expected=19126.4us
(kms_flip:2604) DEBUG: name = flip
last_ts = 364.681458
last_received_ts = 364.681061
last_seq = 4724
current_ts = 364.700500
current_received_ts = 364.700073
current_seq = 4725
count = 477
seq_step = 1
(kms_flip:2604) DEBUG: flip ts/seq: last 364.681458/4724, current 364.700500/4725: elapsed=19024.0us expected=19126.4us +- 95.6us, error 0.5%
(kms_flip:2604) DEBUG: inconsistent flip ts/seq: last 364.681458/4724, current 364.700500/4725: elapsed=19024.0us expected=19126.4us
(kms_flip:2604) DEBUG: name = flip
last_ts = 364.700500
last_received_ts = 364.700073
last_seq = 4725
current_ts = 364.719543
current_received_ts = 364.719147
current_seq = 4726
count = 478
seq_step = 1
(kms_flip:2604) DEBUG: flip ts/seq: last 364.700500/4725, current 364.719543/4726: elapsed=19037.0us expected=19126.4us +- 95.6us, error 0.5%
(kms_flip:2604) DEBUG: name = flip
last_ts = 364.719543
last_received_ts = 364.719147
last_seq = 4726
current_ts = 364.738556
current_received_ts = 364.738129
current_seq = 4727
count = 479
seq_step = 1
(kms_flip:2604) DEBUG: flip ts/seq: last 364.719543/4726, current 364.738556/4727: elapsed=19014.0us expected=19126.4us +- 95.6us, error 0.6%
(kms_flip:2604) DEBUG: inconsistent flip ts/seq: last 364.719543/4726, current 364.738556/4727: elapsed=19014.0us expected=19126.4us
(kms_flip:2604) DEBUG: name = flip
last_ts = 364.738556
last_received_ts = 364.738129
last_seq = 4727
current_ts = 364.757568
current_received_ts = 364.757111
current_seq = 4728
count = 480
seq_step = 1
(kms_flip:2604) DEBUG: flip ts/seq: last 364.738556/4727, current 364.757568/4728: elapsed=19034.0us expected=19126.4us +- 95.6us, error 0.5%
(kms_flip:2604) DEBUG: name = flip
last_ts = 364.757568
last_received_ts = 364.757111
last_seq = 4728
current_ts = 364.776611
current_received_ts = 364.776154
current_seq = 4729
count = 481
seq_step = 1
(kms_flip:2604) DEBUG: flip ts/seq: last 364.757568/4728, current 364.776611/4729: elapsed=19026.0us expected=19126.4us +- 95.6us, error 0.5%
(kms_flip:2604) DEBUG: inconsistent flip ts/seq: last 364.757568/4728, current 364.776611/4729: elapsed=19026.0us expected=19126.4us
(kms_flip:2604) DEBUG: name = flip
last_ts = 364.776611
last_received_ts = 364.776154
last_seq = 4729
current_ts = 364.795624
current_received_ts = 364.795166
current_seq = 4730
count = 482
seq_step = 1
(kms_flip:2604) DEBUG: flip ts/seq: last 364.776611/4729, current 364.795624/4730: elapsed=19019.0us expected=19126.4us +- 95.6us, error 0.6%
(kms_flip:2604) DEBUG: inconsistent flip ts/seq: last 364.776611/4729, current 364.795624/4730: elapsed=19019.0us expected=19126.4us
(kms_flip:2604) DEBUG: name = flip
last_ts = 364.795624
last_received_ts = 364.795166
last_seq = 4730
current_ts = 364.814667
current_received_ts = 364.814270
current_seq = 4731
count = 483
seq_step = 1
(kms_flip:2604) DEBUG: flip ts/seq: last 364.795624/4730, current 364.814667/4731: elapsed=19037.0us expected=19126.4us +- 95.6us, error 0.5%
(kms_flip:2604) DEBUG: name = flip
last_ts = 364.814667
last_received_ts = 364.814270
last_seq = 4731
current_ts = 364.833679
current_received_ts = 364.833282
current_seq = 4732
count = 484
seq_step = 1
(kms_flip:2604) DEBUG: flip ts/seq: last 364.814667/4731, current 364.833679/4732: elapsed=19022.0us expected=19126.4us +- 95.6us, error 0.5%
(kms_flip:2604) DEBUG: inconsistent flip ts/seq: last 364.814667/4731, current 364.833679/4732: elapsed=19022.0us expected=19126.4us
(kms_flip:2604) DEBUG: name = flip
last_ts = 364.833679
last_received_ts = 364.833282
last_seq = 4732
current_ts = 364.852722
current_received_ts = 364.852234
current_seq = 4733
count = 485
seq_step = 1
(kms_flip:2604) DEBUG: flip ts/seq: last 364.833679/4732, current 364.852722/4733: elapsed=19024.0us expected=19126.4us +- 95.6us, error 0.5%
(kms_flip:2604) DEBUG: inconsistent flip ts/seq: last 364.833679/4732, current 364.852722/4733: elapsed=19024.0us expected=19126.4us
(kms_flip:2604) DEBUG: name = flip
last_ts = 364.852722
last_received_ts = 364.852234
last_seq = 4733
current_ts = 364.871735
current_received_ts = 364.871338
current_seq = 4734
count = 486
seq_step = 1
(kms_flip:2604) DEBUG: flip ts/seq: last 364.852722/4733, current 364.871735/4734: elapsed=19035.0us expected=19126.4us +- 95.6us, error 0.5%
(kms_flip:2604) DEBUG: name = flip
last_ts = 364.871735
last_received_ts = 364.871338
last_seq = 4734
current_ts = 364.890778
current_received_ts = 364.890350
current_seq = 4735
count = 487
seq_step = 1
(kms_flip:2604) DEBUG: flip ts/seq: last 364.871735/4734, current 364.890778/4735: elapsed=19026.0us expected=19126.4us +- 95.6us, error 0.5%
(kms_flip:2604) DEBUG: inconsistent flip ts/seq: last 364.871735/4734, current 364.890778/4735: elapsed=19026.0us expected=19126.4us
(kms_flip:2604) DEBUG: name = flip
last_ts = 364.890778
last_received_ts = 364.890350
last_seq = 4735
current_ts = 364.909790
current_received_ts = 364.909363
current_seq = 4736
count = 488
seq_step = 1
(kms_flip:2604) DEBUG: flip ts/seq: last 364.890778/4735, current 364.909790/4736: elapsed=19026.0us expected=19126.4us +- 95.6us, error 0.5%
(kms_flip:2604) DEBUG: inconsistent flip ts/seq: last 364.890778/4735, current 364.909790/4736: elapsed=19026.0us expected=19126.4us
(kms_flip:2604) DEBUG: name = flip
last_ts = 364.909790
last_received_ts = 364.909363
last_seq = 4736
current_ts = 364.928833
current_received_ts = 364.928345
current_seq = 4737
count = 489
seq_step = 1
(kms_flip:2604) DEBUG: flip ts/seq: last 364.909790/4736, current 364.928833/4737: elapsed=19025.0us expected=19126.4us +- 95.6us, error 0.5%
(kms_flip:2604) DEBUG: inconsistent flip ts/seq: last 364.909790/4736, current 364.928833/4737: elapsed=19025.0us expected=19126.4us
(kms_flip:2604) DEBUG: name = flip
last_ts = 364.928833
last_received_ts = 364.928345
last_seq = 4737
current_ts = 364.947845
current_received_ts = 364.947388
current_seq = 4738
count = 490
seq_step = 1
(kms_flip:2604) DEBUG: flip ts/seq: last 364.928833/4737, current 364.947845/4738: elapsed=19019.0us expected=19126.4us +- 95.6us, error 0.6%
(kms_flip:2604) DEBUG: inconsistent flip ts/seq: last 364.928833/4737, current 364.947845/4738: elapsed=19019.0us expected=19126.4us
(kms_flip:2604) DEBUG: name = flip
last_ts = 364.947845
last_received_ts = 364.947388
last_seq = 4738
current_ts = 364.966858
current_received_ts = 364.966461
current_seq = 4739
count = 491
seq_step = 1
(kms_flip:2604) DEBUG: flip ts/seq: last 364.947845/4738, current 364.966858/4739: elapsed=19035.0us expected=19126.4us +- 95.6us, error 0.5%
(kms_flip:2604) DEBUG: name = flip
last_ts = 364.966858
last_received_ts = 364.966461
last_seq = 4739
current_ts = 364.985870
current_received_ts = 364.985474
current_seq = 4740
count = 492
seq_step = 1
(kms_flip:2604) DEBUG: flip ts/seq: last 364.966858/4739, current 364.985870/4740: elapsed=19010.0us expected=19126.4us +- 95.6us, error 0.6%
(kms_flip:2604) DEBUG: inconsistent flip ts/seq: last 364.966858/4739, current 364.985870/4740: elapsed=19010.0us expected=19126.4us
(kms_flip:2604) DEBUG: name = flip
last_ts = 364.985870
last_received_ts = 364.985474
last_seq = 4740
current_ts = 365.004913
current_received_ts = 365.004517
current_seq = 4741
count = 493
seq_step = 1
(kms_flip:2604) DEBUG: flip ts/seq: last 364.985870/4740, current 365.004913/4741: elapsed=19030.0us expected=19126.4us +- 95.6us, error 0.5%
(kms_flip:2604) DEBUG: inconsistent flip ts/seq: last 364.985870/4740, current 365.004913/4741: elapsed=19030.0us expected=19126.4us
(kms_flip:2604) DEBUG: name = flip
last_ts = 365.004913
last_received_ts = 365.004517
last_seq = 4741
current_ts = 365.023926
current_received_ts = 365.023407
current_seq = 4742
count = 494
seq_step = 1
(kms_flip:2604) DEBUG: flip ts/seq: last 365.004913/4741, current 365.023926/4742: elapsed=19028.0us expected=19126.4us +- 95.6us, error 0.5%
(kms_flip:2604) DEBUG: inconsistent flip ts/seq: last 365.004913/4741, current 365.023926/4742: elapsed=19028.0us expected=19126.4us
(kms_flip:2604) DEBUG: name = flip
last_ts = 365.023926
last_received_ts = 365.023407
last_seq = 4742
current_ts = 365.042969
current_received_ts = 365.042511
current_seq = 4743
count = 495
seq_step = 1
(kms_flip:2604) DEBUG: flip ts/seq: last 365.023926/4742, current 365.042969/4743: elapsed=19035.0us expected=19126.4us +- 95.6us, error 0.5%
(kms_flip:2604) DEBUG: name = flip
last_ts = 365.042969
last_received_ts = 365.042511
last_seq = 4743
current_ts = 365.062012
current_received_ts = 365.061584
current_seq = 4744
count = 496
seq_step = 1
(kms_flip:2604) DEBUG: flip ts/seq: last 365.042969/4743, current 365.062012/4744: elapsed=19026.0us expected=19126.4us +- 95.6us, error 0.5%
(kms_flip:2604) DEBUG: inconsistent flip ts/seq: last 365.042969/4743, current 365.062012/4744: elapsed=19026.0us expected=19126.4us
(kms_flip:2604) DEBUG: name = flip
last_ts = 365.062012
last_received_ts = 365.061584
last_seq = 4744
current_ts = 365.081024
current_received_ts = 365.080627
current_seq = 4745
count = 497
seq_step = 1
(kms_flip:2604) DEBUG: flip ts/seq: last 365.062012/4744, current 365.081024/4745: elapsed=19012.0us expected=19126.4us +- 95.6us, error 0.6%
(kms_flip:2604) DEBUG: inconsistent flip ts/seq: last 365.062012/4744, current 365.081024/4745: elapsed=19012.0us expected=19126.4us
(kms_flip:2604) DEBUG: name = flip
last_ts = 365.081024
last_received_ts = 365.080627
last_seq = 4745
current_ts = 365.100037
current_received_ts = 365.099579
current_seq = 4746
count = 498
seq_step = 1
(kms_flip:2604) DEBUG: flip ts/seq: last 365.081024/4745, current 365.100037/4746: elapsed=19035.0us expected=19126.4us +- 95.6us, error 0.5%
(kms_flip:2604) DEBUG: name = flip
last_ts = 365.100037
last_received_ts = 365.099579
last_seq = 4746
current_ts = 365.119080
current_received_ts = 365.118652
current_seq = 4747
count = 499
seq_step = 1
(kms_flip:2604) DEBUG: flip ts/seq: last 365.100037/4746, current 365.119080/4747: elapsed=19019.0us expected=19126.4us +- 95.6us, error 0.6%
(kms_flip:2604) DEBUG: inconsistent flip ts/seq: last 365.100037/4746, current 365.119080/4747: elapsed=19019.0us expected=19126.4us
(kms_flip:2604) DEBUG: name = flip
last_ts = 365.119080
last_received_ts = 365.118652
last_seq = 4747
current_ts = 365.138092
current_received_ts = 365.137634
current_seq = 4748
count = 500
seq_step = 1
(kms_flip:2604) DEBUG: flip ts/seq: last 365.119080/4747, current 365.138092/4748: elapsed=19026.0us expected=19126.4us +- 95.6us, error 0.5%
(kms_flip:2604) DEBUG: inconsistent flip ts/seq: last 365.119080/4747, current 365.138092/4748: elapsed=19026.0us expected=19126.4us
(kms_flip:2604) DEBUG: name = flip
last_ts = 365.138092
last_received_ts = 365.137634
last_seq = 4748
current_ts = 365.157135
current_received_ts = 365.156677
current_seq = 4749
count = 501
seq_step = 1
(kms_flip:2604) DEBUG: flip ts/seq: last 365.138092/4748, current 365.157135/4749: elapsed=19029.0us expected=19126.4us +- 95.6us, error 0.5%
(kms_flip:2604) DEBUG: inconsistent flip ts/seq: last 365.138092/4748, current 365.157135/4749: elapsed=19029.0us expected=19126.4us
(kms_flip:2604) DEBUG: name = flip
last_ts = 365.157135
last_received_ts = 365.156677
last_seq = 4749
current_ts = 365.176147
current_received_ts = 365.175659
current_seq = 4750
count = 502
seq_step = 1
(kms_flip:2604) DEBUG: flip ts/seq: last 365.157135/4749, current 365.176147/4750: elapsed=19025.0us expected=19126.4us +- 95.6us, error 0.5%
(kms_flip:2604) DEBUG: inconsistent flip ts/seq: last 365.157135/4749, current 365.176147/4750: elapsed=19025.0us expected=19126.4us
(kms_flip:2604) DEBUG: name = flip
last_ts = 365.176147
last_received_ts = 365.175659
last_seq = 4750
current_ts = 365.195160
current_received_ts = 365.194702
current_seq = 4751
count = 503
seq_step = 1
(kms_flip:2604) DEBUG: flip ts/seq: last 365.176147/4750, current 365.195160/4751: elapsed=19014.0us expected=19126.4us +- 95.6us, error 0.6%
(kms_flip:2604) DEBUG: inconsistent flip ts/seq: last 365.176147/4750, current 365.195160/4751: elapsed=19014.0us expected=19126.4us
(kms_flip:2604) DEBUG: name = flip
last_ts = 365.195160
last_received_ts = 365.194702
last_seq = 4751
current_ts = 365.214172
current_received_ts = 365.213684
current_seq = 4752
count = 504
seq_step = 1
(kms_flip:2604) DEBUG: flip ts/seq: last 365.195160/4751, current 365.214172/4752: elapsed=19022.0us expected=19126.4us +- 95.6us, error 0.5%
(kms_flip:2604) DEBUG: inconsistent flip ts/seq: last 365.195160/4751, current 365.214172/4752: elapsed=19022.0us expected=19126.4us
(kms_flip:2604) DEBUG: name = flip
last_ts = 365.214172
last_received_ts = 365.213684
last_seq = 4752
current_ts = 365.233215
current_received_ts = 365.232758
current_seq = 4753
count = 505
seq_step = 1
(kms_flip:2604) DEBUG: flip ts/seq: last 365.214172/4752, current 365.233215/4753: elapsed=19018.0us expected=19126.4us +- 95.6us, error 0.6%
(kms_flip:2604) DEBUG: inconsistent flip ts/seq: last 365.214172/4752, current 365.233215/4753: elapsed=19018.0us expected=19126.4us
(kms_flip:2604) DEBUG: name = flip
last_ts = 365.233215
last_received_ts = 365.232758
last_seq = 4753
current_ts = 365.252228
current_received_ts = 365.251709
current_seq = 4754
count = 506
seq_step = 1
(kms_flip:2604) DEBUG: flip ts/seq: last 365.233215/4753, current 365.252228/4754: elapsed=19031.0us expected=19126.4us +- 95.6us, error 0.5%
(kms_flip:2604) DEBUG: name = flip
last_ts = 365.252228
last_received_ts = 365.251709
last_seq = 4754
current_ts = 365.271240
current_received_ts = 365.270813
current_seq = 4755
count = 507
seq_step = 1
(kms_flip:2604) DEBUG: flip ts/seq: last 365.252228/4754, current 365.271240/4755: elapsed=19016.0us expected=19126.4us +- 95.6us, error 0.6%
(kms_flip:2604) DEBUG: inconsistent flip ts/seq: last 365.252228/4754, current 365.271240/4755: elapsed=19016.0us expected=19126.4us
(kms_flip:2604) DEBUG: name = flip
last_ts = 365.271240
last_received_ts = 365.270813
last_seq = 4755
current_ts = 365.290253
current_received_ts = 365.289795
current_seq = 4756
count = 508
seq_step = 1
(kms_flip:2604) DEBUG: flip ts/seq: last 365.271240/4755, current 365.290253/4756: elapsed=19016.0us expected=19126.4us +- 95.6us, error 0.6%
(kms_flip:2604) DEBUG: inconsistent flip ts/seq: last 365.271240/4755, current 365.290253/4756: elapsed=19016.0us expected=19126.4us
(kms_flip:2604) DEBUG: name = flip
last_ts = 365.290253
last_received_ts = 365.289795
last_seq = 4756
current_ts = 365.309296
current_received_ts = 365.308838
current_seq = 4757
count = 509
seq_step = 1
(kms_flip:2604) DEBUG: flip ts/seq: last 365.290253/4756, current 365.309296/4757: elapsed=19023.0us expected=19126.4us +- 95.6us, error 0.5%
(kms_flip:2604) DEBUG: inconsistent flip ts/seq: last 365.290253/4756, current 365.309296/4757: elapsed=19023.0us expected=19126.4us
(kms_flip:2604) DEBUG: name = flip
last_ts = 365.309296
last_received_ts = 365.308838
last_seq = 4757
current_ts = 365.328308
current_received_ts = 365.327881
current_seq = 4758
count = 510
seq_step = 1
(kms_flip:2604) DEBUG: flip ts/seq: last 365.309296/4757, current 365.328308/4758: elapsed=19031.0us expected=19126.4us +- 95.6us, error 0.5%
(kms_flip:2604) DEBUG: name = flip
last_ts = 365.328308
last_received_ts = 365.327881
last_seq = 4758
current_ts = 365.347321
current_received_ts = 365.346863
current_seq = 4759
count = 511
seq_step = 1
(kms_flip:2604) DEBUG: flip ts/seq: last 365.328308/4758, current 365.347321/4759: elapsed=19008.0us expected=19126.4us +- 95.6us, error 0.6%
(kms_flip:2604) DEBUG: inconsistent flip ts/seq: last 365.328308/4758, current 365.347321/4759: elapsed=19008.0us expected=19126.4us
(kms_flip:2604) DEBUG: name = flip
last_ts = 365.347321
last_received_ts = 365.346863
last_seq = 4759
current_ts = 365.366364
current_received_ts = 365.365875
current_seq = 4760
count = 512
seq_step = 1
(kms_flip:2604) DEBUG: flip ts/seq: last 365.347321/4759, current 365.366364/4760: elapsed=19033.0us expected=19126.4us +- 95.6us, error 0.5%
(kms_flip:2604) DEBUG: name = flip
last_ts = 365.366364
last_received_ts = 365.365875
last_seq = 4760
current_ts = 365.385376
current_received_ts = 365.384918
current_seq = 4761
count = 513
seq_step = 1
(kms_flip:2604) DEBUG: flip ts/seq: last 365.366364/4760, current 365.385376/4761: elapsed=19008.0us expected=19126.4us +- 95.6us, error 0.6%
(kms_flip:2604) DEBUG: inconsistent flip ts/seq: last 365.366364/4760, current 365.385376/4761: elapsed=19008.0us expected=19126.4us
(kms_flip:2604) DEBUG: name = flip
last_ts = 365.385376
last_received_ts = 365.384918
last_seq = 4761
current_ts = 365.404388
current_received_ts = 365.403931
current_seq = 4762
count = 514
seq_step = 1
(kms_flip:2604) DEBUG: flip ts/seq: last 365.385376/4761, current 365.404388/4762: elapsed=19020.0us expected=19126.4us +- 95.6us, error 0.6%
(kms_flip:2604) DEBUG: inconsistent flip ts/seq: last 365.385376/4761, current 365.404388/4762: elapsed=19020.0us expected=19126.4us
(kms_flip:2604) DEBUG: name = flip
last_ts = 365.404388
last_received_ts = 365.403931
last_seq = 4762
current_ts = 365.423401
current_received_ts = 365.422943
current_seq = 4763
count = 515
seq_step = 1
(kms_flip:2604) DEBUG: flip ts/seq: last 365.404388/4762, current 365.423401/4763: elapsed=19024.0us expected=19126.4us +- 95.6us, error 0.5%
(kms_flip:2604) DEBUG: inconsistent flip ts/seq: last 365.404388/4762, current 365.423401/4763: elapsed=19024.0us expected=19126.4us
(kms_flip:2604) DEBUG: name = flip
last_ts = 365.423401
last_received_ts = 365.422943
last_seq = 4763
current_ts = 365.442444
current_received_ts = 365.442078
current_seq = 4764
count = 516
seq_step = 1
(kms_flip:2604) DEBUG: flip ts/seq: last 365.423401/4763, current 365.442444/4764: elapsed=19029.0us expected=19126.4us +- 95.6us, error 0.5%
(kms_flip:2604) DEBUG: inconsistent flip ts/seq: last 365.423401/4763, current 365.442444/4764: elapsed=19029.0us expected=19126.4us
(kms_flip:2604) DEBUG: name = flip
last_ts = 365.442444
last_received_ts = 365.442078
last_seq = 4764
current_ts = 365.461456
current_received_ts = 365.460999
current_seq = 4765
count = 517
seq_step = 1
(kms_flip:2604) DEBUG: flip ts/seq: last 365.442444/4764, current 365.461456/4765: elapsed=19016.0us expected=19126.4us +- 95.6us, error 0.6%
(kms_flip:2604) DEBUG: inconsistent flip ts/seq: last 365.442444/4764, current 365.461456/4765: elapsed=19016.0us expected=19126.4us
(kms_flip:2604) DEBUG: name = flip
last_ts = 365.461456
last_received_ts = 365.460999
last_seq = 4765
current_ts = 365.480469
current_received_ts = 365.480072
current_seq = 4766
count = 518
seq_step = 1
(kms_flip:2604) DEBUG: flip ts/seq: last 365.461456/4765, current 365.480469/4766: elapsed=19017.0us expected=19126.4us +- 95.6us, error 0.6%
(kms_flip:2604) DEBUG: inconsistent flip ts/seq: last 365.461456/4765, current 365.480469/4766: elapsed=19017.0us expected=19126.4us
(kms_flip:2604) DEBUG: name = flip
last_ts = 365.480469
last_received_ts = 365.480072
last_seq = 4766
current_ts = 365.499512
current_received_ts = 365.499084
current_seq = 4767
count = 519
seq_step = 1
(kms_flip:2604) DEBUG: flip ts/seq: last 365.480469/4766, current 365.499512/4767: elapsed=19023.0us expected=19126.4us +- 95.6us, error 0.5%
(kms_flip:2604) DEBUG: inconsistent flip ts/seq: last 365.480469/4766, current 365.499512/4767: elapsed=19023.0us expected=19126.4us
(kms_flip:2604) DEBUG: name = flip
last_ts = 365.499512
last_received_ts = 365.499084
last_seq = 4767
current_ts = 365.518524
current_received_ts = 365.518127
current_seq = 4768
count = 520
seq_step = 1
(kms_flip:2604) DEBUG: flip ts/seq: last 365.499512/4767, current 365.518524/4768: elapsed=19018.0us expected=19126.4us +- 95.6us, error 0.6%
(kms_flip:2604) DEBUG: inconsistent flip ts/seq: last 365.499512/4767, current 365.518524/4768: elapsed=19018.0us expected=19126.4us
(kms_flip:2604) DEBUG: name = flip
last_ts = 365.518524
last_received_ts = 365.518127
last_seq = 4768
current_ts = 365.537537
current_received_ts = 365.537109
current_seq = 4769
count = 521
seq_step = 1
(kms_flip:2604) DEBUG: flip ts/seq: last 365.518524/4768, current 365.537537/4769: elapsed=19019.0us expected=19126.4us +- 95.6us, error 0.6%
(kms_flip:2604) DEBUG: inconsistent flip ts/seq: last 365.518524/4768, current 365.537537/4769: elapsed=19019.0us expected=19126.4us
(kms_flip:2604) DEBUG: name = flip
last_ts = 365.537537
last_received_ts = 365.537109
last_seq = 4769
current_ts = 365.556580
current_received_ts = 365.556122
current_seq = 4770
count = 522
seq_step = 1
(kms_flip:2604) DEBUG: flip ts/seq: last 365.537537/4769, current 365.556580/4770: elapsed=19031.0us expected=19126.4us +- 95.6us, error 0.5%
(kms_flip:2604) DEBUG: name = flip
last_ts = 365.556580
last_received_ts = 365.556122
last_seq = 4770
current_ts = 365.575592
current_received_ts = 365.575134
current_seq = 4771
count = 523
seq_step = 1
(kms_flip:2604) DEBUG: flip ts/seq: last 365.556580/4770, current 365.575592/4771: elapsed=19023.0us expected=19126.4us +- 95.6us, error 0.5%
(kms_flip:2604) DEBUG: inconsistent flip ts/seq: last 365.556580/4770, current 365.575592/4771: elapsed=19023.0us expected=19126.4us
(kms_flip:2604) DEBUG: name = flip
last_ts = 365.575592
last_received_ts = 365.575134
last_seq = 4771
current_ts = 365.594604
current_received_ts = 365.594086
current_seq = 4772
count = 524
seq_step = 1
(kms_flip:2604) DEBUG: flip ts/seq: last 365.575592/4771, current 365.594604/4772: elapsed=19006.0us expected=19126.4us +- 95.6us, error 0.6%
(kms_flip:2604) DEBUG: inconsistent flip ts/seq: last 365.575592/4771, current 365.594604/4772: elapsed=19006.0us expected=19126.4us
(kms_flip:2604) INFO: Event flip: expected 523, counted 525, passrate = 84.57%, encoder type 2
(kms_flip:2604) DEBUG: dropped frames, expected 523, counted 525, passrate = 84.57%, encoder type 2
(kms_flip:2604) CRITICAL: Test assertion failure function __run_test_on_crtc_set, file ../tests/kms_flip.c:1707:
(kms_flip:2604) CRITICAL: Failed assertion: !retried
(kms_flip:2604) igt_core-INFO: Stack trace:
(kms_flip:2604) igt_core-INFO:   #0 ../lib/igt_core.c:2075 __igt_fail_assert()
(kms_flip:2604) igt_core-INFO:   #1 ../tests/kms_flip.c:428 run_test_on_crtc_set.constprop.0()
(kms_flip:2604) igt_core-INFO:   #2 ../tests/kms_flip.c:1887 run_test()
(kms_flip:2604) igt_core-INFO:   #3 ../tests/kms_flip.c:2120 __igt_unique____real_main2043()
(kms_flip:2604) igt_core-INFO:   #4 ../tests/kms_flip.c:2043 main()
(kms_flip:2604) igt_core-INFO:   #5 [__libc_init_first+0x8a]
(kms_flip:2604) igt_core-INFO:   #6 [__libc_start_main+0x8b]
(kms_flip:2604) igt_core-INFO:   #7 [_start+0x25]
****  END  ****
Dynamic subtest A-HDMI-A2: FAIL (23.776s)
Starting dynamic subtest: B-HDMI-A2
Dynamic subtest B-HDMI-A2: SUCCESS (10.479s)
Starting dynamic subtest: C-HDMI-A2
Dynamic subtest C-HDMI-A2: SUCCESS (10.453s)
Subtest plain-flip-ts-check: FAIL (44.717s)
Dmesg
<6> [370.280069] Console: switching to colour dummy device 80x25
<6> [370.280479] [IGT] kms_flip: executing
<7> [370.284491] i915 0000:00:02.0: [drm:i915_gem_open [i915]]
<7> [370.285068] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc]
<7> [370.285287] i915 0000:00:02.0: [drm:i915_gem_open [i915]]
<7> [370.289290] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] [CONNECTOR:389:HDMI-A-1]
<7> [370.289296] i915 0000:00:02.0: [drm:intel_hdmi_detect [i915]] [CONNECTOR:389:HDMI-A-1]
<7> [370.293339] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] [CONNECTOR:389:HDMI-A-1] disconnected
<7> [370.293723] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] [CONNECTOR:403:DP-1]
<7> [370.293726] i915 0000:00:02.0: [drm:intel_dp_detect [i915]] [CONNECTOR:403:DP-1]
<7> [370.297745] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] [CONNECTOR:403:DP-1] disconnected
<7> [370.298002] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] [CONNECTOR:411:HDMI-A-3]
<7> [370.298005] i915 0000:00:02.0: [drm:intel_hdmi_detect [i915]] [CONNECTOR:411:HDMI-A-3]
<7> [370.302040] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] [CONNECTOR:411:HDMI-A-3] disconnected
<7> [370.302336] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] [CONNECTOR:389:HDMI-A-1]
<7> [370.302339] i915 0000:00:02.0: [drm:intel_hdmi_detect [i915]] [CONNECTOR:389:HDMI-A-1]
<7> [370.306334] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] [CONNECTOR:389:HDMI-A-1] disconnected
<7> [370.306346] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] [CONNECTOR:399:HDMI-A-2]
<7> [370.306349] i915 0000:00:02.0: [drm:intel_hdmi_detect [i915]] [CONNECTOR:399:HDMI-A-2]
<7> [370.332115] i915 0000:00:02.0: [drm:update_display_info.part.0] [CONNECTOR:399:HDMI-A-2] Supported Monitor Refresh rate range is 0 Hz - 0 Hz
<7> [370.332124] i915 0000:00:02.0: [drm:update_display_info.part.0] [CONNECTOR:399:HDMI-A-2] Assigning EDID-1.4 digital sink color depth as 8 bpc.
<7> [370.332127] i915 0000:00:02.0: [drm:update_display_info.part.0] [CONNECTOR:399:HDMI-A-2] ELD monitor fitHeadless4k
<7> [370.332142] i915 0000:00:02.0: [drm:update_display_info.part.0] [CONNECTOR:399:HDMI-A-2] ELD size 36, SAD count 0
<7> [370.332368] i915 0000:00:02.0: [drm:do_gmbus_xfer [i915]] GMBUS [i915 gmbus tc1] NAK for addr: 0040 w(1)
<7> [370.332490] i915 0000:00:02.0: [drm:do_gmbus_xfer [i915]] GMBUS [i915 gmbus tc1] NAK on first message, retry
<7> [370.332784] i915 0000:00:02.0: [drm:do_gmbus_xfer [i915]] GMBUS [i915 gmbus tc1] NAK for addr: 0040 w(1)
<7> [370.332906] i915 0000:00:02.0: [drm:drm_dp_dual_mode_detect [drm_display_helper]] DP dual mode HDMI ID: (err -6)
<7> [370.333273] i915 0000:00:02.0: [drm:drm_mode_prune_invalid] Rejected mode: "1366x768": 216 268000 1366 1414 1446 1526 768 771 777 814 0x40 0x6 (CLOCK_HIGH)
<7> [370.333284] i915 0000:00:02.0: [drm:drm_mode_prune_invalid] Rejected mode: "1920x1080i": 60 74250 1920 2008 2052 2200 1080 1084 1094 1125 0x40 0x15 (NO_INTERLACE)
<7> [370.333289] i915 0000:00:02.0: [drm:drm_mode_prune_invalid] Rejected mode: "1920x1080i": 60 74176 1920 2008 2052 2200 1080 1084 1094 1125 0x40 0x15 (NO_INTERLACE)
<7> [370.333295] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] [CONNECTOR:399:HDMI-A-2] probed modes:
<7> [370.333298] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "1920x1080": 53 139930 1920 2008 2096 2360 1080 1084 1089 1125 0x48 0x5
<7> [370.333301] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "4088x2304": 10 108000 4088 4152 4280 4536 2304 2305 2308 2340 0x40 0x5
<7> [370.333303] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "3840x2160": 15 128430 3840 3889 3921 4000 2160 2163 2169 2195 0x40 0xa
<7> [370.333306] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "2880x1800": 11 60000 2880 2888 2984 3040 1800 1802 1820 1845 0x40 0xa
<7> [370.333308] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "2560x1600": 13 60000 2560 2568 2664 2720 1600 1602 1620 1645 0x40 0xa
<7> [370.333310] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "2560x1440": 15 60000 2560 2568 2664 2720 1440 1442 1460 1485 0x40 0xa
<7> [370.333313] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "2048x1536": 17 60000 2048 2056 2152 2208 1536 1538 1556 1581 0x40 0xa
<7> [370.333315] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "1600x1200": 60 162000 1600 1664 1856 2160 1200 1201 1204 1250 0x40 0x5
<7> [370.333317] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "1680x1050": 60 146250 1680 1784 1960 2240 1050 1053 1059 1089 0x40 0x6
<7> [370.333320] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "1600x900": 60 108000 1600 1624 1704 1800 900 901 904 1000 0x40 0x5
<7> [370.333322] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "1280x1024": 75 135000 1280 1296 1440 1688 1024 1025 1028 1066 0x40 0x5
<7> [370.333325] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "1360x768": 60 84963 1366 1431 1567 1776 768 771 781 798 0x0 0x6
<7> [370.333327] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "1360x768": 20 25190 1360 1368 1464 1520 768 770 788 813 0x40 0xa
<7> [370.333330] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "1280x800": 60 83500 1280 1352 1480 1680 800 803 809 831 0x40 0x6
<7> [370.333332] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "1152x864": 75 108000 1152 1216 1344 1600 864 865 868 900 0x40 0x5
<7> [370.333335] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "1280x720": 60 74250 1280 1390 1430 1650 720 725 730 750 0x40 0x5
<7> [370.333337] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "1280x720": 60 74250 1280 1390 1430 1650 720 725 730 750 0x40 0x5
<7> [370.333340] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "1280x720": 60 74176 1280 1390 1430 1650 720 725 730 750 0x40 0x5
<7> [370.333342] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "1024x768": 75 78750 1024 1040 1136 1312 768 769 772 800 0x40 0x5
<7> [370.333345] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "1024x768": 60 65000 1024 1048 1184 1344 768 771 777 806 0x40 0xa
<7> [370.333347] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "1440x480": 60 54054 1440 1472 1596 1716 480 489 495 525 0x40 0xa
<7> [370.333349] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "1440x480": 60 54000 1440 1472 1596 1716 480 489 495 525 0x40 0xa
<7> [370.333352] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "1024x576": 60 46560 1024 1064 1160 1296 576 579 584 599 0x0 0x6
<7> [370.333354] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "832x624": 75 57284 832 864 928 1152 624 625 628 667 0x40 0xa
<7> [370.333357] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "800x600": 75 49500 800 816 896 1056 600 601 604 625 0x40 0x5
<7> [370.333359] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "800x600": 60 40000 800 840 968 1056 600 601 605 628 0x40 0x5
<7> [370.333362] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "640x480": 75 31500 640 656 720 840 480 481 484 500 0x40 0xa
<7> [370.333364] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "640x480": 60 25200 640 656 752 800 480 490 492 525 0x40 0xa
<7> [370.333366] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "640x480": 60 25175 640 656 752 800 480 490 492 525 0x40 0xa
<7> [370.333369] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "640x480": 60 25175 640 656 752 800 480 490 492 525 0x40 0xa
<7> [370.333371] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "720x400": 70 28320 720 738 846 900 400 412 414 449 0x40 0x6
<7> [370.333388] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] [CONNECTOR:403:DP-1]
<7> [370.333391] i915 0000:00:02.0: [drm:intel_dp_detect [i915]] [CONNECTOR:403:DP-1]
<7> [370.337378] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] [CONNECTOR:403:DP-1] disconnected
<7> [370.337391] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] [CONNECTOR:411:HDMI-A-3]
<7> [370.337393] i915 0000:00:02.0: [drm:intel_hdmi_detect [i915]] [CONNECTOR:411:HDMI-A-3]
<7> [370.341375] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] [CONNECTOR:411:HDMI-A-3] disconnected
<6> [370.341906] [IGT] kms_flip: starting subtest plain-flip-ts-check
<6> [370.343488] [IGT] kms_flip: starting dynamic subtest A-HDMI-A2
<7> [370.343883] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:417]
<7> [370.343962] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:418]
<7> [370.385873] i915 0000:00:02.0: [drm:drm_mode_setcrtc] [CRTC:150:pipe A]
<7> [370.386024] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:150:pipe A] fastset requirement not met in hw.enable (expected yes, found no)
<7> [370.386255] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:150:pipe A] fastset requirement not met in hw.active (expected yes, found no)
<7> [370.386454] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:150:pipe A] fastset requirement not met in cpu_transcoder (expected 0, found -1)
<7> [370.386672] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:150:pipe A] fastset requirement not met in lane_count (expected 4, found 0)
<7> [370.386915] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:150:pipe A] fastset requirement not met in output_types (expected 0x00000040, found 0x00000000)
<7> [370.387116] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:150:pipe A] fastset requirement not met in framestart_delay (expected 1, found 0)
<7> [370.387301] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:150:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hdisplay (expected 1920, found 0)
<7> [370.387488] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:150:pipe A] fastset requirement not met in hw.pipe_mode.crtc_htotal (expected 2360, found 0)
<7> [370.387692] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:150:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hblank_start (expected 1920, found 0)
<7> [370.387879] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:150:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hblank_end (expected 2360, found 0)
<7> [370.388063] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:150:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hsync_start (expected 2008, found 0)
<7> [370.388247] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:150:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hsync_end (expected 2096, found 0)
<7> [370.388433] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:150:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vdisplay (expected 1080, found 0)
<7> [370.388605] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:150:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vblank_start (expected 1080, found 0)
<7> [370.388762] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:150:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vsync_start (expected 1084, found 0)
<7> [370.388920] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:150:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vsync_end (expected 1089, found 0)
<7> [370.389078] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:150:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vtotal (expected 1125, found 0)
<7> [370.389237] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:150:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vblank_end (expected 1125, found 0)
<7> [370.389395] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:150:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hdisplay (expected 1920, found 0)
<7> [370.389561] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:150:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_htotal (expected 2360, found 0)
<7> [370.389718] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:150:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hblank_start (expected 1920, found 0)
<7> [370.389887] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:150:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hblank_end (expected 2360, found 0)
<7> [370.390045] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:150:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hsync_start (expected 2008, found 0)
<7> [370.390203] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:150:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hsync_end (expected 2096, found 0)
<7> [370.390361] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:150:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vdisplay (expected 1080, found 0)
<7> [370.390530] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:150:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vblank_start (expected 1080, found 0)
<7> [370.390696] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:150:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vsync_start (expected 1084, found 0)
<7> [370.390855] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:150:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vsync_end (expected 1089, found 0)
<7> [370.391011] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:150:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vtotal (expected 1125, found 0)
<7> [370.391169] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:150:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vblank_end (expected 1125, found 0)
<7> [370.391326] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:150:pipe A] fastset requirement not met in pixel_multiplier (expected 1, found 0)
<7> [370.391504] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:150:pipe A] fastset requirement not met in hw.adjusted_mode.flags (1) (expected 1, found 0)
<7> [370.391632] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:150:pipe A] fastset requirement not met in hw.adjusted_mode.flags (4) (expected 4, found 0)
<7> [370.391759] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:150:pipe A] fastset requirement not met in pipe_bpp (expected 24, found 0)
<7> [370.391886] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:150:pipe A] fastset requirement not met in hw.pipe_mode.crtc_clock (expected 139929, found 0)
<7> [370.392014] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:150:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_clock (expected 139929, found 0)
<7> [370.392140] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:150:pipe A] fastset requirement not met in port_clock (expected 139929, found 0)
<7> [370.392268] i915 0000:00:02.0: [drm:intel_atomic_check [i915]] [CRTC:150:pipe A] fastset requirement not met, forcing full modeset
<7> [370.392408] i915 0000:00:02.0: [drm:intel_dpll_crtc_put [i915]] [CRTC:150:pipe A] releasing DPLL 0
<7> [370.392567] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] Enabled dbuf slices 0x3 -> 0x1 (total dbuf slices 0x3), mbus joined? no->no
<7> [370.392694] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] [CRTC:150:pipe A] dbuf slices 0x3 -> 0x0, ddb (0 - 2048) -> (0 - 0), active pipes 0x1 -> 0x0
<7> [370.392845] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] [PLANE:34:plane 1A] ddb ( 0 - 2016) -> ( 0 - 0), size 2016 -> 0
<7> [370.392972] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] [PLANE:144:cursor A] ddb (2016 - 2048) -> ( 0 - 0), size 32 -> 0
<7> [370.393097] i915 0000:00:02.0: [drm:skl_print_plane_changes [i915]] [PLANE:34:plane 1A] level *wm0,*wm1,*wm2,*wm3,*wm4,*wm5,*wm6,*wm7,*twm, swm, stwm -> wm0, wm1, wm2, wm3, wm4, wm5, wm6, wm7, twm, swm, stwm
<7> [370.393222] i915 0000:00:02.0: [drm:skl_print_plane_changes [i915]] [PLANE:34:plane 1A] lines 1, 2, 2, 2, 2, 5, 8, 9, 0, 0, 0 -> 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0
<7> [370.393360] i915 0000:00:02.0: [drm:skl_print_plane_changes [i915]] [PLANE:34:plane 1A] blocks 16, 33, 33, 33, 33, 81, 129, 145, 30, 0, 0 -> 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0
<7> [370.393486] i915 0000:00:02.0: [drm:skl_print_plane_changes [i915]] [PLANE:34:plane 1A] min_ddb 19, 38, 38, 38, 38, 91, 143, 161, 31, 0, 0 -> 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0
<7> [370.393628] i915 0000:00:02.0: [drm:intel_bw_atomic_check [i915]] [CRTC:150:pipe A] data rate 0 num active planes 0
<7> [370.393759] i915 0000:00:02.0: [drm:intel_bw_atomic_check [i915]] QGV point 0: max bw 16761 required 0
<7> [370.393904] i915 0000:00:02.0: [drm:intel_cdclk_atomic_check [i915]] [CRTC:150:pipe A] min cdclk: 69965 kHz -> 0 kHz
<7> [370.394050] i915 0000:00:02.0: [drm:intel_cdclk_update_dbuf_bw_min_cdclk [i915]] dbuf bandwidth min cdclk: 8746 kHz -> 0 kHz
<7> [370.394184] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [CRTC:150:pipe A] enable: no [modeset]
<7> [370.394326] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:34:plane 1A] fb: [NOFB], visible: no
<7> [370.394463] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:64:plane 2A] fb: [NOFB], visible: no
<7> [370.394594] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:94:plane 3A] fb: [NOFB], visible: no
<7> [370.394724] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:124:plane 4A] fb: [NOFB], visible: no
<7> [370.394854] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:134:plane 5A] fb: [NOFB], visible: no
<7> [370.394987] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:144:cursor A] fb: [NOFB], visible: no
<7> [370.399880] i915 0000:00:02.0: [drm:intel_disable_transcoder [i915]] disabling pipe A
<7> [370.420167] i915 0000:00:02.0: [drm:intel_power_well_disable [i915]] disabling DDI_IO_TC1
<7> [370.420580] i915 0000:00:02.0: [drm:intel_dpll_disable [i915]] disable DPLL 0 (active 0x1, on? 1) for [CRTC:150:pipe A]
<7> [370.421030] i915 0000:00:02.0: [drm:intel_dpll_disable [i915]] disabling DPLL 0
<7> [370.421428] i915 0000:00:02.0: [drm:__intel_fbc_disable [i915]] Disabling FBC on [PLANE:34:plane 1A]
<7> [370.421769] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:388:DDI B/PHY B]
<7> [370.422140] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:398:DDI TC1/PHY C]
<7> [370.422501] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:402:DDI TC2/PHY D]
<7> [370.422835] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:404:DP-MST A]
<7> [370.423195] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:405:DP-MST B]
<7> [370.423521] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:406:DP-MST C]
<7> [370.423857] i915 0000:00:02.0: [drm:verify_connector_state [i915]] [CONNECTOR:399:HDMI-A-2]
<7> [370.424349] i915 0000:00:02.0: [drm:gen9_dbuf_slices_update [i915]] Updating dbuf slices to 0x1
<7> [370.424785] i915 0000:00:02.0: [drm:intel_power_well_disable [i915]] disabling PW_3
<7> [370.425203] i915 0000:00:02.0: [drm:intel_modeset_verify_crtc [i915]] [CRTC:150:pipe A]
<7> [370.426060] i915 0000:00:02.0: [drm:drm_mode_setcrtc] [CRTC:268:pipe B]
<7> [370.426307] i915 0000:00:02.0: [drm:drm_mode_setcrtc] [CRTC:386:pipe C]
<7> [370.426532] i915 0000:00:02.0: [drm:drm_mode_setcrtc] [CRTC:150:pipe A]
<7> [370.426570] i915 0000:00:02.0: [drm:drm_mode_setcrtc] [CONNECTOR:399:HDMI-A-2]
<7> [370.426692] i915 0000:00:02.0: [drm:intel_atomic_check [i915]] [CONNECTOR:399:HDMI-A-2] Limiting target display pipe bpp to 24 (EDID bpp 24, max requested bpp 36, max platform bpp 36)
<7> [370.426994] i915 0000:00:02.0: [drm:intel_hdmi_compute_clock [i915]] picking 8 bpc for HDMI output (pipe bpp: 24)
<7> [370.427258] i915 0000:00:02.0: [drm:intel_atomic_check [i915]] [CRTC:150:pipe A] hw max bpp: 24, pipe bpp: 24, dithering: 0
<7> [370.427542] i915 0000:00:02.0: [drm:intel_ddi_compute_config_late [i915]] [ENCODER:398:DDI TC1/PHY C] [CRTC:150:pipe A]
<7> [370.427834] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:150:pipe A] fastset requirement not met in hw.enable (expected no, found yes)
<7> [370.428102] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:150:pipe A] fastset requirement not met in hw.active (expected no, found yes)
<7> [370.428363] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:150:pipe A] fastset requirement not met in cpu_transcoder (expected -1, found 0)
<7> [370.428611] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:150:pipe A] fastset requirement not met in lane_count (expected 0, found 4)
<7> [370.428823] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:150:pipe A] fastset requirement not met in output_types (expected 0x00000000, found 0x00000040)
<7> [370.429030] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:150:pipe A] fastset requirement not met in framestart_delay (expected 0, found 1)
<7> [370.429234] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:150:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hdisplay (expected 0, found 1920)
<7> [370.429439] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:150:pipe A] fastset requirement not met in hw.pipe_mode.crtc_htotal (expected 0, found 2360)
<7> [370.429666] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:150:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hblank_start (expected 0, found 1920)
<7> [370.429875] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:150:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hblank_end (expected 0, found 2360)
<7> [370.430078] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:150:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hsync_start (expected 0, found 2008)
<7> [370.430282] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:150:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hsync_end (expected 0, found 2096)
<7> [370.430496] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:150:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vdisplay (expected 0, found 1080)
<7> [370.430699] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:150:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vblank_start (expected 0, found 1080)
<7> [370.430905] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:150:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vsync_start (expected 0, found 1084)
<7> [370.431088] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:150:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vsync_end (expected 0, found 1089)
<7> [370.431272] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:150:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vtotal (expected 0, found 1125)
<7> [370.431459] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:150:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vblank_end (expected 0, found 1125)
<7> [370.431613] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:150:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hdisplay (expected 0, found 1920)
<7> [370.431767] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:150:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_htotal (expected 0, found 2360)
<7> [370.431920] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:150:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hblank_start (expected 0, found 1920)
<7> [370.432072] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:150:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hblank_end (expected 0, found 2360)
<7> [370.432225] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:150:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hsync_start (expected 0, found 2008)
<7> [370.432378] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:150:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hsync_end (expected 0, found 2096)
<7> [370.432547] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:150:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vdisplay (expected 0, found 1080)
<7> [370.432706] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:150:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vblank_start (expected 0, found 1080)
<7> [370.432859] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:150:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vsync_start (expected 0, found 1084)
<7> [370.433012] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:150:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vsync_end (expected 0, found 1089)
<7> [370.433165] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:150:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vtotal (expected 0, found 1125)
<7> [370.433317] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:150:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vblank_end (expected 0, found 1125)
<7> [370.433499] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:150:pipe A] fastset requirement not met in pixel_multiplier (expected 0, found 1)
<7> [370.433633] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:150:pipe A] fastset requirement not met in hw.adjusted_mode.flags (1) (expected 0, found 1)
<7> [370.433762] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:150:pipe A] fastset requirement not met in hw.adjusted_mode.flags (4) (expected 0, found 4)
<7> [370.433893] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:150:pipe A] fastset requirement not met in pipe_bpp (expected 0, found 24)
<7> [370.434022] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:150:pipe A] fastset requirement not met in hw.pipe_mode.crtc_clock (expected 0, found 139929)
<7> [370.434150] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:150:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_clock (expected 0, found 139929)
<7> [370.434279] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:150:pipe A] fastset requirement not met in port_clock (expected 0, found 139929)
<7> [370.434468] i915 0000:00:02.0: [drm:intel_atomic_check [i915]] [CRTC:150:pipe A] fastset requirement not met, forcing full modeset
<7> [370.434617] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] Enabled dbuf slices 0x1 -> 0x3 (total dbuf slices 0x3), mbus joined? no->no
<7> [370.434749] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] [CRTC:150:pipe A] dbuf slices 0x0 -> 0x3, ddb (0 - 0) -> (0 - 2048), active pipes 0x0 -> 0x1
<7> [370.434904] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] [PLANE:34:plane 1A] ddb ( 0 - 0) -> ( 0 - 2016), size 0 -> 2016
<7> [370.435030] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] [PLANE:144:cursor A] ddb ( 0 - 0) -> (2016 - 2048), size 0 -> 32
<7> [370.435154] i915 0000:00:02.0: [drm:skl_print_plane_changes [i915]] [PLANE:34:plane 1A] level wm0, wm1, wm2, wm3, wm4, wm5, wm6, wm7, twm, swm, stwm -> *wm0,*wm1,*wm2,*wm3,*wm4,*wm5,*wm6,*wm7,*twm, swm, stwm
<7> [370.435287] i915 0000:00:02.0: [drm:skl_print_plane_changes [i915]] [PLANE:34:plane 1A] lines 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0 -> 1, 2, 2, 2, 2, 5, 8, 9, 0, 0, 0
<7> [370.435411] i915 0000:00:02.0: [drm:skl_print_plane_changes [i915]] [PLANE:34:plane 1A] blocks 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0 -> 16, 33, 33, 33, 33, 81, 129, 145, 30, 0, 0
<7> [370.435535] i915 0000:00:02.0: [drm:skl_print_plane_changes [i915]] [PLANE:34:plane 1A] min_ddb 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0 -> 19, 38, 38, 38, 38, 91, 143, 161, 31, 0, 0
<7> [370.435674] i915 0000:00:02.0: [drm:intel_bw_atomic_check [i915]] [CRTC:150:pipe A] data rate 559716 num active planes 1
<7> [370.435805] i915 0000:00:02.0: [drm:intel_bw_atomic_check [i915]] QGV point 0: max bw 16761 required 560
<7> [370.435936] i915 0000:00:02.0: [drm:intel_bw_atomic_check [i915]] No SAGV, using single QGV point mask 0x1
<7> [370.436077] i915 0000:00:02.0: [drm:intel_cdclk_atomic_check [i915]] [CRTC:150:pipe A] min cdclk: 0 kHz -> 69965 kHz
<7> [370.436231] i915 0000:00:02.0: [drm:intel_cdclk_update_dbuf_bw_min_cdclk [i915]] dbuf bandwidth min cdclk: 0 kHz -> 8746 kHz
<7> [370.436360] i915 0000:00:02.0: [drm:intel_find_dpll [i915]] [CRTC:150:pipe A] allocated DPLL 0
<7> [370.436495] i915 0000:00:02.0: [drm:intel_dpll_crtc_get [i915]] [CRTC:150:pipe A] reserving DPLL 0
<7> [370.436630] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [CRTC:150:pipe A] enable: yes [modeset]
<7> [370.436762] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] active: yes, output_types: HDMI (0x40), output format: RGB, sink format: RGB
<7> [370.436892] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] cpu_transcoder: A, pipe bpp: 24, dithering: 0
<7> [370.437020] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] MST master transcoder: <invalid>
<7> [370.437147] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] port sync: master transcoder: <invalid>, slave transcoder bitmask = 0x0
<7> [370.437289] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] joiner: no, pipes: 0x0
<7> [370.437421] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] splitter: disabled, link count 0, overlap 0
<7> [370.437548] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] audio: 0, infoframes: 0, infoframes enabled: 0x0
<7> [370.437675] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] scanline offset: 2
<7> [370.437800] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] framestart delay: 1, MSA timing delay: 0, set context latency: 0
<7> [370.437927] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] vrr: no, fixed rr: yes, vmin: 1125, vmax: 1125, flipline: 1125, pipeline full: 42, guardband: 44 vsync start: 0, vsync end: 0
<7> [370.438053] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] vrr: vmin vblank: 1081, vmax vblank: 1081, vmin vtotal: 1125, vmax vtotal: 1125
<7> [370.438189] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] vrr: dc balance: no, vmin: 0 vmax: 0 guardband: 0, slope: 0 max increase: 0 max decrease: 0 vblank target: 0
<7> [370.438316] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] requested mode: "1920x1080": 53 139930 1920 2008 2096 2360 1080 1084 1089 1125 0x48 0x5
<7> [370.438443] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] adjusted mode: "1920x1080": 53 139930 1920 2008 2096 2360 1080 1084 1089 1125 0x48 0x5
<7> [370.438569] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] crtc timings: clock=139929, hd=1920 hb=1920-2360 hs=2008-2096 ht=2360, vd=1080 vb=1080-1125 vs=1084-1089 vt=1125, flags=0x5
<7> [370.438696] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pipe mode: "1920x1080": 53 139929 1920 2008 2096 2360 1080 1084 1089 1125 0x40 0x5
<7> [370.438822] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] crtc timings: clock=139929, hd=1920 hb=1920-2360 hs=2008-2096 ht=2360, vd=1080 vb=1080-1125 vs=1084-1089 vt=1125, flags=0x5
<7> [370.438949] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] port clock: 139929, pipe src: 1920x1080+0+0, pixel rate 139929, min cdclk 69965
<7> [370.439079] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] linetime: 135, ips linetime: 0
<7> [370.439205] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] num_scalers: 2, scaler_users: 0x0, scaler_id: -1, scaling_filter: 0
<7> [370.439331] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pch pfit: 0x0+0+0, disabled, force thru: no
<7> [370.439457] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] ips: 0, double wide: 0, drrs: 0
<7> [370.439582] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] dpll_hw_state: cfgcr0: 0x1a6655d, cfgcr1: 0xe84, div0: 0x0, mg_refclkin_ctl: 0x0, hg_clktop2_coreclkctl1: 0x0, mg_clktop2_hsclkctl: 0x0, mg_pll_div0: 0x0, mg_pll_div2: 0x0, mg_pll_lf: 0x0, mg_pll_frac_lock: 0x0, mg_pll_ssc: 0x0, mg_pll_bias: 0x0, mg_pll_tdc_coldst_bias: 0x0
<7> [370.439709] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] csc_mode: 0x0 gamma_mode: 0x0 gamma_enable: 0 csc_enable: 0
<7> [370.439835] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pre csc lut: 0 entries, post csc lut: 0 entries
<7> [370.439960] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] output csc: pre offsets: 0x0000 0x0000 0x0000
<7> [370.440095] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] output csc: coefficients: 0x0000 0x0000 0x0000
<7> [370.440224] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] output csc: coefficients: 0x0000 0x0000 0x0000
<7> [370.440349] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] output csc: coefficients: 0x0000 0x0000 0x0000
<7> [370.440474] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] output csc: post offsets: 0x0000 0x0000 0x0000
<7> [370.440599] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pipe csc: pre offsets: 0x0000 0x0000 0x0000
<7> [370.440723] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pipe csc: coefficients: 0x0000 0x0000 0x0000
<7> [370.440848] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pipe csc: coefficients: 0x0000 0x0000 0x0000
<7> [370.440980] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pipe csc: coefficients: 0x0000 0x0000 0x0000
<7> [370.441109] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pipe csc: post offsets: 0x0000 0x0000 0x0000
<7> [370.441234] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] sharpness strength: 0, sharpness tap size: 0, sharpness enable: 0
<7> [370.441359] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:34:plane 1A] fb: [FB:417] 1920x1080 format = XR24 little-endian (0x34325258) modifier = 0x100000000000001, visible: yes
<7> [370.441484] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] rotation: 0x1, scaler: -1, scaling_filter: 0
<7> [370.441609] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] src: 1920.000000x1080.000000+0.000000+0.000000 dst: 1920x1080+0+0
<7> [370.441734] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:64:plane 2A] fb: [NOFB], visible: no
<7> [370.441859] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:94:plane 3A] fb: [NOFB], visible: no
<7> [370.441992] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:124:plane 4A] fb: [NOFB], visible: no
<7> [370.442116] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:134:plane 5A] fb: [NOFB], visible: no
<7> [370.442240] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:144:cursor A] fb: [NOFB], visible: no
<7> [370.442888] i915 0000:00:02.0: [drm:intel_power_well_enable [i915]] enabling PW_3
<7> [370.443039] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:388:DDI B/PHY B]
<7> [370.443174] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:398:DDI TC1/PHY C]
<7> [370.443304] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:402:DDI TC2/PHY D]
<7> [370.443434] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:404:DP-MST A]
<7> [370.443560] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:405:DP-MST B]
<7> [370.443688] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:406:DP-MST C]
<7> [370.443868] i915 0000:00:02.0: [drm:gen9_dbuf_slices_update [i915]] Updating dbuf slices to 0x3
<7> [370.444085] i915 0000:00:02.0: [drm:intel_dpll_enable [i915]] enable DPLL 0 (active 0x1, on? 0) for [CRTC:150:pipe A]
<7> [370.444219] i915 0000:00:02.0: [drm:intel_dpll_enable [i915]] enabling DPLL 0
<7> [370.444401] i915 0000:00:02.0: [drm:intel_power_well_enable [i915]] enabling DDI_IO_TC1
<7> [370.444569] i915 0000:00:02.0: [drm:intel_enable_transcoder [i915]] enabling pipe A
<7> [370.444961] i915 0000:00:02.0: [drm:intel_fbc_update [i915]] reserved 17694720 bytes of contiguous stolen space for FBC, limit: 1
<7> [370.445092] i915 0000:00:02.0: [drm:intel_fbc_update [i915]] Enabling FBC on [PLANE:34:plane 1A]
<7> [370.464226] i915 0000:00:02.0: [drm:verify_connector_state [i915]] [CONNECTOR:399:HDMI-A-2]
<7> [370.464499] i915 0000:00:02.0: [drm:intel_modeset_verify_crtc [i915]] [CRTC:150:pipe A]
<7> [383.551537] i915 0000:00:02.0: [drm:drm_mode_setcrtc] [CRTC:150:pipe A]
<7> [383.551926] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:150:pipe A] fastset requirement not met in hw.enable (expected yes, found no)
<7> [383.552624] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:150:pipe A] fastset requirement not met in hw.active (expected yes, found no)
<7> [383.553295] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:150:pipe A] fastset requirement not met in cpu_transcoder (expected 0, found -1)
<7> [383.553929] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:150:pipe A] fastset requirement not met in lane_count (expected 4, found 0)
<7> [383.554534] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:150:pipe A] fastset requirement not met in output_types (expected 0x00000040, found 0x00000000)
<7> [383.555174] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:150:pipe A] fastset requirement not met in framestart_delay (expected 1, found 0)
<7> [383.555770] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:150:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hdisplay (expected 1920, found 0)
<7> [383.556435] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:150:pipe A] fastset requirement not met in hw.pipe_mode.crtc_htotal (expected 2360, found 0)
<7> [383.557065] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:150:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hblank_start (expected 1920, found 0)
<7> [383.557307] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:150:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hblank_end (expected 2360, found 0)
<7> [383.557435] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:150:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hsync_start (expected 2008, found 0)
<7> [383.557562] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:150:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hsync_end (expected 2096, found 0)
<7> [383.557688] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:150:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vdisplay (expected 1080, found 0)
<7> [383.557820] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:150:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vblank_start (expected 1080, found 0)
<7> [383.557947] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:150:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vsync_start (expected 1084, found 0)
<7> [383.558073] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:150:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vsync_end (expected 1089, found 0)
<7> [383.558199] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:150:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vtotal (expected 1125, found 0)
<7> [383.558325] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:150:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vblank_end (expected 1125, found 0)
<7> [383.558451] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:150:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hdisplay (expected 1920, found 0)
<7> [383.558578] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:150:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_htotal (expected 2360, found 0)
<7> [383.558704] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:150:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hblank_start (expected 1920, found 0)
<7> [383.558839] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:150:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hblank_end (expected 2360, found 0)
<7> [383.558965] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:150:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hsync_start (expected 2008, found 0)
<7> [383.559090] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:150:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hsync_end (expected 2096, found 0)
<7> [383.559215] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:150:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vdisplay (expected 1080, found 0)
<7> [383.559341] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:150:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vblank_start (expected 1080, found 0)
<7> [383.559466] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:150:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vsync_start (expected 1084, found 0)
<7> [383.559591] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:150:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vsync_end (expected 1089, found 0)
<7> [383.559717] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:150:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vtotal (expected 1125, found 0)
<7> [383.559854] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:150:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vblank_end (expected 1125, found 0)
<7> [383.559979] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:150:pipe A] fastset requirement not met in pixel_multiplier (expected 1, found 0)
<7> [383.560106] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:150:pipe A] fastset requirement not met in hw.adjusted_mode.flags (1) (expected 1, found 0)
<7> [383.560231] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:150:pipe A] fastset requirement not met in hw.adjusted_mode.flags (4) (expected 4, found 0)
<7> [383.560358] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:150:pipe A] fastset requirement not met in pipe_bpp (expected 24, found 0)
<7> [383.560484] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:150:pipe A] fastset requirement not met in hw.pipe_mode.crtc_clock (expected 139929, found 0)
<7> [383.560609] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:150:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_clock (expected 139929, found 0)
<7> [383.560735] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:150:pipe A] fastset requirement not met in port_clock (expected 139929, found 0)
<7> [383.560870] i915 0000:00:02.0: [drm:intel_atomic_check [i915]] [CRTC:150:pipe A] fastset requirement not met, forcing full modeset
<7> [383.560996] i915 0000:00:02.0: [drm:intel_dpll_crtc_put [i915]] [CRTC:150:pipe A] releasing DPLL 0
<7> [383.561154] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] Enabled dbuf slices 0x3 -> 0x1 (total dbuf slices 0x3), mbus joined? no->no
<7> [383.561282] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] [CRTC:150:pipe A] dbuf slices 0x3 -> 0x0, ddb (0 - 2048) -> (0 - 0), active pipes 0x1 -> 0x0
<7> [383.561429] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] [PLANE:34:plane 1A] ddb ( 0 - 2016) -> ( 0 - 0), size 2016 -> 0
<7> [383.561554] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] [PLANE:144:cursor A] ddb (2016 - 2048) -> ( 0 - 0), size 32 -> 0
<7> [383.561678] i915 0000:00:02.0: [drm:skl_print_plane_changes [i915]] [PLANE:34:plane 1A] level *wm0,*wm1,*wm2,*wm3,*wm4,*wm5,*wm6,*wm7,*twm, swm, stwm -> wm0, wm1, wm2, wm3, wm4, wm5, wm6, wm7, twm, swm, stwm
<7> [383.561813] i915 0000:00:02.0: [drm:skl_print_plane_changes [i915]] [PLANE:34:plane 1A] lines 1, 2, 2, 2, 2, 5, 8, 9, 0, 0, 0 -> 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0
<7> [383.561937] i915 0000:00:02.0: [drm:skl_print_plane_changes [i915]] [PLANE:34:plane 1A] blocks 16, 33, 33, 33, 33, 81, 129, 145, 30, 0, 0 -> 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0
<7> [383.562061] i915 0000:00:02.0: [drm:skl_print_plane_changes [i915]] [PLANE:34:plane 1A] min_ddb 19, 38, 38, 38, 38, 91, 143, 161, 31, 0, 0 -> 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0
<7> [383.562203] i915 0000:00:02.0: [drm:intel_bw_atomic_check [i915]] [CRTC:150:pipe A] data rate 0 num active planes 0
<7> [383.562337] i915 0000:00:02.0: [drm:intel_bw_atomic_check [i915]] QGV point 0: max bw 16761 required 0
<7> [383.562483] i915 0000:00:02.0: [drm:intel_cdclk_atomic_check [i915]] [CRTC:150:pipe A] min cdclk: 69965 kHz -> 0 kHz
<7> [383.562631] i915 0000:00:02.0: [drm:intel_cdclk_update_dbuf_bw_min_cdclk [i915]] dbuf bandwidth min cdclk: 8746 kHz -> 0 kHz
<7> [383.562764] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [CRTC:150:pipe A] enable: no [modeset]
<7> [383.562909] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:34:plane 1A] fb: [NOFB], visible: no
<7> [383.563040] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:64:plane 2A] fb: [NOFB], visible: no
<7> [383.563171] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:94:plane 3A] fb: [NOFB], visible: no
<7> [383.563299] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:124:plane 4A] fb: [NOFB], visible: no
<7> [383.563429] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:134:plane 5A] fb: [NOFB], visible: no
<7> [383.563558] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:144:cursor A] fb: [NOFB], visible: no
<7> [383.575019] i915 0000:00:02.0: [drm:intel_disable_transcoder [i915]] disabling pipe A
<7> [383.595668] i915 0000:00:02.0: [drm:intel_power_well_disable [i915]] disabling DDI_IO_TC1
<7> [383.596326] i915 0000:00:02.0: [drm:intel_dpll_disable [i915]] disable DPLL 0 (active 0x1, on? 1) for [CRTC:150:pipe A]
<7> [383.597117] i915 0000:00:02.0: [drm:intel_dpll_disable [i915]] disabling DPLL 0
<7> [383.597797] i915 0000:00:02.0: [drm:__intel_fbc_disable [i915]] Disabling FBC on [PLANE:34:plane 1A]
<7> [383.598436] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:388:DDI B/PHY B]
<7> [383.599098] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:398:DDI TC1/PHY C]
<7> [383.599790] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:402:DDI TC2/PHY D]
<7> [383.600384] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:404:DP-MST A]
<7> [383.601027] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:405:DP-MST B]
<7> [383.601644] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:406:DP-MST C]
<7> [383.602233] i915 0000:00:02.0: [drm:verify_connector_state [i915]] [CONNECTOR:399:HDMI-A-2]
<7> [383.602954] i915 0000:00:02.0: [drm:gen9_dbuf_slices_update [i915]] Updating dbuf slices to 0x1
<7> [383.603531] i915 0000:00:02.0: [drm:intel_power_well_disable [i915]] disabling PW_3
<7> [383.604076] i915 0000:00:02.0: [drm:intel_modeset_verify_crtc [i915]] [CRTC:150:pipe A]
<7> [383.605329] i915 0000:00:02.0: [drm:drm_mode_setcrtc] [CRTC:268:pipe B]
<7> [383.605699] i915 0000:00:02.0: [drm:drm_mode_setcrtc] [CRTC:386:pipe C]
<7> [383.606009] i915 0000:00:02.0: [drm:drm_mode_setcrtc] [CRTC:150:pipe A]
<7> [383.606060] i915 0000:00:02.0: [drm:drm_mode_setcrtc] [CONNECTOR:399:HDMI-A-2]
<7> [383.606203] i915 0000:00:02.0: [drm:intel_atomic_check [i915]] [CONNECTOR:399:HDMI-A-2] Limiting target display pipe bpp to 24 (EDID bpp 24, max requested bpp 36, max platform bpp 36)
<7> [383.606643] i915 0000:00:02.0: [drm:intel_hdmi_compute_clock [i915]] picking 8 bpc for HDMI output (pipe bpp: 24)
<7> [383.606999] i915 0000:00:02.0: [drm:intel_atomic_check [i915]] [CRTC:150:pipe A] hw max bpp: 24, pipe bpp: 24, dithering: 0
<7> [383.607390] i915 0000:00:02.0: [drm:intel_ddi_compute_config_late [i915]] [ENCODER:398:DDI TC1/PHY C] [CRTC:150:pipe A]
<7> [383.607783] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:150:pipe A] fastset requirement not met in hw.enable (expected no, found yes)
<7> [383.608167] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:150:pipe A] fastset requirement not met in hw.active (expected no, found yes)
<7> [383.608523] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:150:pipe A] fastset requirement not met in cpu_transcoder (expected -1, found 0)
<7> [383.608796] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:150:pipe A] fastset requirement not met in lane_count (expected 0, found 4)
<7> [383.609070] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:150:pipe A] fastset requirement not met in output_types (expected 0x00000000, found 0x00000040)
<7> [383.609342] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:150:pipe A] fastset requirement not met in framestart_delay (expected 0, found 1)
<7> [383.609640] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:150:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hdisplay (expected 0, found 1920)
<7> [383.609911] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:150:pipe A] fastset requirement not met in hw.pipe_mode.crtc_htotal (expected 0, found 2360)
<7> [383.610181] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:150:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hblank_start (expected 0, found 1920)
<7> [383.610467] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:150:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hblank_end (expected 0, found 2360)
<7> [383.610738] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:150:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hsync_start (expected 0, found 2008)
<7> [383.611008] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:150:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hsync_end (expected 0, found 2096)
<7> [383.611277] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:150:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vdisplay (expected 0, found 1080)
<7> [383.611521] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:150:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vblank_start (expected 0, found 1080)
<7> [383.611717] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:150:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vsync_start (expected 0, found 1084)
<7> [383.611913] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:150:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vsync_end (expected 0, found 1089)
<7> [383.612109] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:150:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vtotal (expected 0, found 1125)
<7> [383.612305] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:150:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vblank_end (expected 0, found 1125)
<7> [383.612524] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:150:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hdisplay (expected 0, found 1920)
<7> [383.612713] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:150:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_htotal (expected 0, found 2360)
<7> [383.612903] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:150:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hblank_start (expected 0, found 1920)
<7> [383.613092] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:150:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hblank_end (expected 0, found 2360)
<7> [383.613282] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:150:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hsync_start (expected 0, found 2008)
<7> [383.613485] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:150:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hsync_end (expected 0, found 2096)
<7> [383.613674] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:150:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vdisplay (expected 0, found 1080)
<7> [383.613862] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:150:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vblank_start (expected 0, found 1080)
<7> [383.614051] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:150:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vsync_start (expected 0, found 1084)
<7> [383.614238] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:150:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vsync_end (expected 0, found 1089)
<7> [383.614498] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:150:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vtotal (expected 0, found 1125)
<7> [383.614633] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:150:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vblank_end (expected 0, found 1125)
<7> [383.614768] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:150:pipe A] fastset requirement not met in pixel_multiplier (expected 0, found 1)
<7> [383.614903] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:150:pipe A] fastset requirement not met in hw.adjusted_mode.flags (1) (expected 0, found 1)
<7> [383.615037] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:150:pipe A] fastset requirement not met in hw.adjusted_mode.flags (4) (expected 0, found 4)
<7> [383.615174] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:150:pipe A] fastset requirement not met in pipe_bpp (expected 0, found 24)
<7> [383.615314] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:150:pipe A] fastset requirement not met in hw.pipe_mode.crtc_clock (expected 0, found 139929)
<7> [383.615459] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:150:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_clock (expected 0, found 139929)
<7> [383.615591] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:150:pipe A] fastset requirement not met in port_clock (expected 0, found 139929)
<7> [383.615725] i915 0000:00:02.0: [drm:intel_atomic_check [i915]] [CRTC:150:pipe A] fastset requirement not met, forcing full modeset
<7> [383.615878] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] Enabled dbuf slices 0x1 -> 0x3 (total dbuf slices 0x3), mbus joined? no->no
<7> [383.616011] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] [CRTC:150:pipe A] dbuf slices 0x0 -> 0x3, ddb (0 - 0) -> (0 - 2048), active pipes 0x0 -> 0x1
<7> [383.616165] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] [PLANE:34:plane 1A] ddb ( 0 - 0) -> ( 0 - 2016), size 0 -> 2016
<7> [383.616295] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] [PLANE:144:cursor A] ddb ( 0 - 0) -> (2016 - 2048), size 0 -> 32
<7> [383.616436] i915 0000:00:02.0: [drm:skl_print_plane_changes [i915]] [PLANE:34:plane 1A] level wm0, wm1, wm2, wm3, wm4, wm5, wm6, wm7, twm, swm, stwm -> *wm0,*wm1,*wm2,*wm3,*wm4,*wm5,*wm6,*wm7,*twm, swm, stwm
<7> [383.616566] i915 0000:00:02.0: [drm:skl_print_plane_changes [i915]] [PLANE:34:plane 1A] lines 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0 -> 1, 2, 2, 2, 2, 5, 8, 9, 0, 0, 0
<7> [383.616696] i915 0000:00:02.0: [drm:skl_print_plane_changes [i915]] [PLANE:34:plane 1A] blocks 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0 -> 16, 33, 33, 33, 33, 81, 129, 145, 30, 0, 0
<7> [383.616826] i915 0000:00:02.0: [drm:skl_print_plane_changes [i915]] [PLANE:34:plane 1A] min_ddb 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0 -> 19, 38, 38, 38, 38, 91, 143, 161, 31, 0, 0
<7> [383.616972] i915 0000:00:02.0: [drm:intel_bw_atomic_check [i915]] [CRTC:150:pipe A] data rate 559716 num active planes 1
<7> [383.617113] i915 0000:00:02.0: [drm:intel_bw_atomic_check [i915]] QGV point 0: max bw 16761 required 560
<7> [383.617250] i915 0000:00:02.0: [drm:intel_bw_atomic_check [i915]] No SAGV, using single QGV point mask 0x1
<7> [383.617414] i915 0000:00:02.0: [drm:intel_cdclk_atomic_check [i915]] [CRTC:150:pipe A] min cdclk: 0 kHz -> 69965 kHz
<7> [383.617556] i915 0000:00:02.0: [drm:intel_cdclk_update_dbuf_bw_min_cdclk [i915]] dbuf bandwidth min cdclk: 0 kHz -> 8746 kHz
<7> [383.617687] i915 0000:00:02.0: [drm:intel_find_dpll [i915]] [CRTC:150:pipe A] allocated DPLL 0
<7> [383.617822] i915 0000:00:02.0: [drm:intel_dpll_crtc_get [i915]] [CRTC:150:pipe A] reserving DPLL 0
<7> [383.617956] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [CRTC:150:pipe A] enable: yes [modeset]
<7> [383.618088] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] active: yes, output_types: HDMI (0x40), output format: RGB, sink format: RGB
<7> [383.618219] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] cpu_transcoder: A, pipe bpp: 24, dithering: 0
<7> [383.618355] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] MST master transcoder: <invalid>
<7> [383.618485] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] port sync: master transcoder: <invalid>, slave transcoder bitmask = 0x0
<7> [383.618614] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] joiner: no, pipes: 0x0
<7> [383.618741] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] splitter: disabled, link count 0, overlap 0
<7> [383.618868] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] audio: 0, infoframes: 0, infoframes enabled: 0x0
<7> [383.618996] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] scanline offset: 2
<7> [383.619123] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] framestart delay: 1, MSA timing delay: 0, set context latency: 0
<7> [383.619249] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] vrr: no, fixed rr: yes, vmin: 1125, vmax: 1125, flipline: 1125, pipeline full: 42, guardband: 44 vsync start: 0, vsync end: 0
<7> [383.619403] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] vrr: vmin vblank: 1081, vmax vblank: 1081, vmin vtotal: 1125, vmax vtotal: 1125
<7> [383.619531] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] vrr: dc balance: no, vmin: 0 vmax: 0 guardband: 0, slope: 0 max increase: 0 max decrease: 0 vblank target: 0
<7> [383.619658] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] requested mode: "1920x1080": 53 139930 1920 2008 2096 2360 1080 1084 1089 1125 0x48 0x5
<7> [383.619785] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] adjusted mode: "1920x1080": 53 139930 1920 2008 2096 2360 1080 1084 1089 1125 0x48 0x5
<7> [383.619913] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] crtc timings: clock=139929, hd=1920 hb=1920-2360 hs=2008-2096 ht=2360, vd=1080 vb=1080-1125 vs=1084-1089 vt=1125, flags=0x5
<7> [383.620041] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pipe mode: "1920x1080": 53 139929 1920 2008 2096 2360 1080 1084 1089 1125 0x40 0x5
<7> [383.620168] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] crtc timings: clock=139929, hd=1920 hb=1920-2360 hs=2008-2096 ht=2360, vd=1080 vb=1080-1125 vs=1084-1089 vt=1125, flags=0x5
<7> [383.620295] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] port clock: 139929, pipe src: 1920x1080+0+0, pixel rate 139929, min cdclk 69965
<7> [383.620435] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] linetime: 135, ips linetime: 0
<7> [383.620561] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] num_scalers: 2, scaler_users: 0x0, scaler_id: -1, scaling_filter: 0
<7> [383.620688] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pch pfit: 0x0+0+0, disabled, force thru: no
<7> [383.620814] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] ips: 0, double wide: 0, drrs: 0
<7> [383.620941] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] dpll_hw_state: cfgcr0: 0x1a6655d, cfgcr1: 0xe84, div0: 0x0, mg_refclkin_ctl: 0x0, hg_clktop2_coreclkctl1: 0x0, mg_clktop2_hsclkctl: 0x0, mg_pll_div0: 0x0, mg_pll_div2: 0x0, mg_pll_lf: 0x0, mg_pll_frac_lock: 0x0, mg_pll_ssc: 0x0, mg_pll_bias: 0x0, mg_pll_tdc_coldst_bias: 0x0
<7> [383.621070] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] csc_mode: 0x0 gamma_mode: 0x0 gamma_enable: 0 csc_enable: 0
<7> [383.621198] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pre csc lut: 0 entries, post csc lut: 0 entries
<7> [383.621331] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] output csc: pre offsets: 0x0000 0x0000 0x0000
<7> [383.621457] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] output csc: coefficients: 0x0000 0x0000 0x0000
<7> [383.621584] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] output csc: coefficients: 0x0000 0x0000 0x0000
<7> [383.621710] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] output csc: coefficients: 0x0000 0x0000 0x0000
<7> [383.621836] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] output csc: post offsets: 0x0000 0x0000 0x0000
<7> [383.621964] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pipe csc: pre offsets: 0x0000 0x0000 0x0000
<7> [383.622090] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pipe csc: coefficients: 0x0000 0x0000 0x0000
<7> [383.622217] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pipe csc: coefficients: 0x0000 0x0000 0x0000
<7> [383.622352] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pipe csc: coefficients: 0x0000 0x0000 0x0000
<7> [383.622480] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pipe csc: post offsets: 0x0000 0x0000 0x0000
<7> [383.622607] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] sharpness strength: 0, sharpness tap size: 0, sharpness enable: 0
<7> [383.622734] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:34:plane 1A] fb: [FB:417] 1920x1080 format = XR24 little-endian (0x34325258) modifier = 0x100000000000001, visible: yes
<7> [383.622862] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] rotation: 0x1, scaler: -1, scaling_filter: 0
<7> [383.622988] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] src: 1920.000000x1080.000000+0.000000+0.000000 dst: 1920x1080+0+0
<7> [383.623115] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:64:plane 2A] fb: [NOFB], visible: no
<7> [383.623243] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:94:plane 3A] fb: [NOFB], visible: no
<7> [383.623377] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:124:plane 4A] fb: [NOFB], visible: no
<7> [383.623503] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:134:plane 5A] fb: [NOFB], visible: no
<7> [383.623629] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:144:cursor A] fb: [NOFB], visible: no
<7> [383.623832] i915 0000:00:02.0: [drm:intel_power_well_enable [i915]] enabling PW_3
<7> [383.623978] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:388:DDI B/PHY B]
<7> [383.624110] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:398:DDI TC1/PHY C]
<7> [383.624239] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:402:DDI TC2/PHY D]
<7> [383.624380] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:404:DP-MST A]
<7> [383.624507] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:405:DP-MST B]
<7> [383.624634] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:406:DP-MST C]
<7> [383.624796] i915 0000:00:02.0: [drm:gen9_dbuf_slices_update [i915]] Updating dbuf slices to 0x3
<7> [383.625015] i915 0000:00:02.0: [drm:intel_dpll_enable [i915]] enable DPLL 0 (active 0x1, on? 0) for [CRTC:150:pipe A]
<7> [383.625150] i915 0000:00:02.0: [drm:intel_dpll_enable [i915]] enabling DPLL 0
<7> [383.625340] i915 0000:00:02.0: [drm:intel_power_well_enable [i915]] enabling DDI_IO_TC1
<7> [383.625509] i915 0000:00:02.0: [drm:intel_enable_transcoder [i915]] enabling pipe A
<7> [383.625881] i915 0000:00:02.0: [drm:intel_fbc_update [i915]] reserved 17694720 bytes of contiguous stolen space for FBC, limit: 1
<7> [383.626013] i915 0000:00:02.0: [drm:intel_fbc_update [i915]] Enabling FBC on [PLANE:34:plane 1A]
<7> [383.645094] i915 0000:00:02.0: [drm:verify_connector_state [i915]] [CONNECTOR:399:HDMI-A-2]
<7> [383.645403] i915 0000:00:02.0: [drm:intel_modeset_verify_crtc [i915]] [CRTC:150:pipe A]
<6> [394.119835] [IGT] kms_flip: finished subtest A-HDMI-A2, FAIL
<6> [394.120462] [IGT] kms_flip: starting dynamic subtest B-HDMI-A2
<7> [394.120783] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:419]
<7> [394.120866] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:420]
<7> [394.156235] i915 0000:00:02.0: [drm:drm_mode_setcrtc] [CRTC:150:pipe A]
<7> [394.156321] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:150:pipe A] fastset requirement not met in hw.enable (expected yes, found no)
<7> [394.156498] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:150:pipe A] fastset requirement not met in hw.active (expected yes, found no)
<7> [394.156635] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:150:pipe A] fastset requirement not met in cpu_transcoder (expected 0, found -1)
<7> [394.156769] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:150:pipe A] fastset requirement not met in lane_count (expected 4, found 0)
<7> [394.156901] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:150:pipe A] fastset requirement not met in output_types (expected 0x00000040, found 0x00000000)
<7> [394.157033] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:150:pipe A] fastset requirement not met in framestart_delay (expected 1, found 0)
<7> [394.157165] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:150:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hdisplay (expected 1920, found 0)
<7> [394.157310] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:150:pipe A] fastset requirement not met in hw.pipe_mode.crtc_htotal (expected 2360, found 0)
<7> [394.157474] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:150:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hblank_start (expected 1920, found 0)
<7> [394.157604] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:150:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hblank_end (expected 2360, found 0)
<7> [394.157732] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:150:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hsync_start (expected 2008, found 0)
<7> [394.157861] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:150:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hsync_end (expected 2096, found 0)
<7> [394.157990] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:150:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vdisplay (expected 1080, found 0)
<7> [394.158118] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:150:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vblank_start (expected 1080, found 0)
<7> [394.158257] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:150:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vsync_start (expected 1084, found 0)
<7> [394.158407] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:150:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vsync_end (expected 1089, found 0)
<7> [394.158535] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:150:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vtotal (expected 1125, found 0)
<7> [394.158663] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:150:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vblank_end (expected 1125, found 0)
<7> [394.158791] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:150:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hdisplay (expected 1920, found 0)
<7> [394.158919] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:150:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_htotal (expected 2360, found 0)
<7> [394.159047] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:150:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hblank_start (expected 1920, found 0)
<7> [394.159174] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:150:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hblank_end (expected 2360, found 0)
<7> [394.159313] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:150:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hsync_start (expected 2008, found 0)
<7> [394.159469] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:150:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hsync_end (expected 2096, found 0)
<7> [394.159597] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:150:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vdisplay (expected 1080, found 0)
<7> [394.159726] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:150:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vblank_start (expected 1080, found 0)
<7> [394.159853] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:150:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vsync_start (expected 1084, found 0)
<7> [394.159981] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:150:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vsync_end (expected 1089, found 0)
<7> [394.160108] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:150:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vtotal (expected 1125, found 0)
<7> [394.160247] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:150:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vblank_end (expected 1125, found 0)
<7> [394.160394] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:150:pipe A] fastset requirement not met in pixel_multiplier (expected 1, found 0)
<7> [394.160523] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:150:pipe A] fastset requirement not met in hw.adjusted_mode.flags (1) (expected 1, found 0)
<7> [394.160650] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:150:pipe A] fastset requirement not met in hw.adjusted_mode.flags (4) (expected 4, found 0)
<7> [394.160780] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:150:pipe A] fastset requirement not met in pipe_bpp (expected 24, found 0)
<7> [394.160908] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:150:pipe A] fastset requirement not met in hw.pipe_mode.crtc_clock (expected 139929, found 0)
<7> [394.161035] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:150:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_clock (expected 139929, found 0)
<7> [394.161162] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:150:pipe A] fastset requirement not met in port_clock (expected 139929, found 0)
<7> [394.161305] i915 0000:00:02.0: [drm:intel_atomic_check [i915]] [CRTC:150:pipe A] fastset requirement not met, forcing full modeset
<7> [394.161458] i915 0000:00:02.0: [drm:intel_dpll_crtc_put [i915]] [CRTC:150:pipe A] releasing DPLL 0
<7> [394.161614] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] Enabled dbuf slices 0x3 -> 0x1 (total dbuf slices 0x3), mbus joined? no->no
<7> [394.161743] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] [CRTC:150:pipe A] dbuf slices 0x3 -> 0x0, ddb (0 - 2048) -> (0 - 0), active pipes 0x1 -> 0x0
<7> [394.161893] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] [PLANE:34:plane 1A] ddb ( 0 - 2016) -> ( 0 - 0), size 2016 -> 0
<7> [394.162020] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] [PLANE:144:cursor A] ddb (2016 - 2048) -> ( 0 - 0), size 32 -> 0
<7> [394.162146] i915 0000:00:02.0: [drm:skl_print_plane_changes [i915]] [PLANE:34:plane 1A] level *wm0,*wm1,*wm2,*wm3,*wm4,*wm5,*wm6,*wm7,*twm, swm, stwm -> wm0, wm1, wm2, wm3, wm4, wm5, wm6, wm7, twm, swm, stwm
<7> [394.162287] i915 0000:00:02.0: [drm:skl_print_plane_changes [i915]] [PLANE:34:plane 1A] lines 1, 2, 2, 2, 2, 5, 8, 9, 0, 0, 0 -> 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0
<7> [394.162438] i915 0000:00:02.0: [drm:skl_print_plane_changes [i915]] [PLANE:34:plane 1A] blocks 16, 33, 33, 33, 33, 81, 129, 145, 30, 0, 0 -> 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0
<7> [394.162565] i915 0000:00:02.0: [drm:skl_print_plane_changes [i915]] [PLANE:34:plane 1A] min_ddb 19, 38, 38, 38, 38, 91, 143, 161, 31, 0, 0 -> 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0
<7> [394.162706] i915 0000:00:02.0: [drm:intel_bw_atomic_check [i915]] [CRTC:150:pipe A] data rate 0 num active planes 0
<7> [394.162840] i915 0000:00:02.0: [drm:intel_bw_atomic_check [i915]] QGV point 0: max bw 16761 required 0
<7> [394.162985] i915 0000:00:02.0: [drm:intel_cdclk_atomic_check [i915]] [CRTC:150:pipe A] min cdclk: 69965 kHz -> 0 kHz
<7> [394.163131] i915 0000:00:02.0: [drm:intel_cdclk_update_dbuf_bw_min_cdclk [i915]] dbuf bandwidth min cdclk: 8746 kHz -> 0 kHz
<7> [394.163276] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [CRTC:150:pipe A] enable: no [modeset]
<7> [394.163430] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:34:plane 1A] fb: [NOFB], visible: no
<7> [394.163561] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:64:plane 2A] fb: [NOFB], visible: no
<7> [394.163693] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:94:plane 3A] fb: [NOFB], visible: no
<7> [394.163822] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:124:plane 4A] fb: [NOFB], visible: no
<7> [394.163951] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:134:plane 5A] fb: [NOFB], visible: no
<7> [394.164081] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:144:cursor A] fb: [NOFB], visible: no
<7> [394.175385] i915 0000:00:02.0: [drm:intel_disable_transcoder [i915]] disabling pipe A
<7> [394.194281] i915 0000:00:02.0: [drm:intel_power_well_disable [i915]] disabling DDI_IO_TC1
<7> [394.194641] i915 0000:00:02.0: [drm:intel_dpll_disable [i915]] disable DPLL 0 (active 0x1, on? 1) for [CRTC:150:pipe A]
<7> [394.194980] i915 0000:00:02.0: [drm:intel_dpll_disable [i915]] disabling DPLL 0
<7> [394.195319] i915 0000:00:02.0: [drm:__intel_fbc_disable [i915]] Disabling FBC on [PLANE:34:plane 1A]
<7> [394.195689] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:388:DDI B/PHY B]
<7> [394.195965] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:398:DDI TC1/PHY C]
<7> [394.196295] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:402:DDI TC2/PHY D]
<7> [394.196648] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:404:DP-MST A]
<7> [394.196944] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:405:DP-MST B]
<7> [394.197272] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:406:DP-MST C]
<7> [394.197619] i915 0000:00:02.0: [drm:verify_connector_state [i915]] [CONNECTOR:399:HDMI-A-2]
<7> [394.198062] i915 0000:00:02.0: [drm:gen9_dbuf_slices_update [i915]] Updating dbuf slices to 0x1
<7> [394.198507] i915 0000:00:02.0: [drm:intel_power_well_disable [i915]] disabling PW_3
<7> [394.198884] i915 0000:00:02.0: [drm:intel_modeset_verify_crtc [i915]] [CRTC:150:pipe A]
<7> [394.199756] i915 0000:00:02.0: [drm:drm_mode_setcrtc] [CRTC:268:pipe B]
<7> [394.200010] i915 0000:00:02.0: [drm:drm_mode_setcrtc] [CRTC:386:pipe C]
<7> [394.200328] i915 0000:00:02.0: [drm:drm_mode_setcrtc] [CRTC:268:pipe B]
<7> [394.200368] i915 0000:00:02.0: [drm:drm_mode_setcrtc] [CONNECTOR:399:HDMI-A-2]
<7> [394.200473] i915 0000:00:02.0: [drm:intel_atomic_check [i915]] [CONNECTOR:399:HDMI-A-2] Limiting target display pipe bpp to 24 (EDID bpp 24, max requested bpp 36, max platform bpp 36)
<7> [394.200779] i915 0000:00:02.0: [drm:intel_hdmi_compute_clock [i915]] picking 8 bpc for HDMI output (pipe bpp: 24)
<7> [394.201044] i915 0000:00:02.0: [drm:intel_atomic_check [i915]] [CRTC:268:pipe B] hw max bpp: 24, pipe bpp: 24, dithering: 0
<7> [394.201357] i915 0000:00:02.0: [drm:intel_ddi_compute_config_late [i915]] [ENCODER:398:DDI TC1/PHY C] [CRTC:268:pipe B]
<7> [394.201671] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:268:pipe B] fastset requirement not met in hw.enable (expected no, found yes)
<7> [394.201951] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:268:pipe B] fastset requirement not met in hw.active (expected no, found yes)
<7> [394.202247] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:268:pipe B] fastset requirement not met in cpu_transcoder (expected -1, found 1)
<7> [394.202564] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:268:pipe B] fastset requirement not met in lane_count (expected 0, found 4)
<7> [394.202825] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:268:pipe B] fastset requirement not met in output_types (expected 0x00000000, found 0x00000040)
<7> [394.203086] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:268:pipe B] fastset requirement not met in framestart_delay (expected 0, found 1)
<7> [394.203400] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:268:pipe B] fastset requirement not met in hw.pipe_mode.crtc_hdisplay (expected 0, found 1920)
<7> [394.203671] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:268:pipe B] fastset requirement not met in hw.pipe_mode.crtc_htotal (expected 0, found 2360)
<7> [394.203903] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:268:pipe B] fastset requirement not met in hw.pipe_mode.crtc_hblank_start (expected 0, found 1920)
<7> [394.204146] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:268:pipe B] fastset requirement not met in hw.pipe_mode.crtc_hblank_end (expected 0, found 2360)
<7> [394.204415] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:268:pipe B] fastset requirement not met in hw.pipe_mode.crtc_hsync_start (expected 0, found 2008)
<7> [394.204650] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:268:pipe B] fastset requirement not met in hw.pipe_mode.crtc_hsync_end (expected 0, found 2096)
<7> [394.204880] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:268:pipe B] fastset requirement not met in hw.pipe_mode.crtc_vdisplay (expected 0, found 1080)
<7> [394.205122] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:268:pipe B] fastset requirement not met in hw.pipe_mode.crtc_vblank_start (expected 0, found 1080)
<7> [394.205387] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:268:pipe B] fastset requirement not met in hw.pipe_mode.crtc_vsync_start (expected 0, found 1084)
<7> [394.205614] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:268:pipe B] fastset requirement not met in hw.pipe_mode.crtc_vsync_end (expected 0, found 1089)
<7> [394.205841] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:268:pipe B] fastset requirement not met in hw.pipe_mode.crtc_vtotal (expected 0, found 1125)
<7> [394.206067] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:268:pipe B] fastset requirement not met in hw.pipe_mode.crtc_vblank_end (expected 0, found 1125)
<7> [394.206306] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:268:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_hdisplay (expected 0, found 1920)
<7> [394.206505] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:268:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_htotal (expected 0, found 2360)
<7> [394.206677] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:268:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_hblank_start (expected 0, found 1920)
<7> [394.206848] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:268:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_hblank_end (expected 0, found 2360)
<7> [394.207018] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:268:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_hsync_start (expected 0, found 2008)
<7> [394.207210] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:268:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_hsync_end (expected 0, found 2096)
<7> [394.207412] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:268:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_vdisplay (expected 0, found 1080)
<7> [394.207584] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:268:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_vblank_start (expected 0, found 1080)
<7> [394.207754] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:268:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_vsync_start (expected 0, found 1084)
<7> [394.207925] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:268:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_vsync_end (expected 0, found 1089)
<7> [394.208111] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:268:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_vtotal (expected 0, found 1125)
<7> [394.208307] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:268:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_vblank_end (expected 0, found 1125)
<7> [394.208479] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:268:pipe B] fastset requirement not met in pixel_multiplier (expected 0, found 1)
<7> [394.208649] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:268:pipe B] fastset requirement not met in hw.adjusted_mode.flags (1) (expected 0, found 1)
<7> [394.208820] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:268:pipe B] fastset requirement not met in hw.adjusted_mode.flags (4) (expected 0, found 4)
<7> [394.208992] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:268:pipe B] fastset requirement not met in pipe_bpp (expected 0, found 24)
<7> [394.209180] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:268:pipe B] fastset requirement not met in hw.pipe_mode.crtc_clock (expected 0, found 139929)
<7> [394.209378] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:268:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_clock (expected 0, found 139929)
<7> [394.209503] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:268:pipe B] fastset requirement not met in port_clock (expected 0, found 139929)
<7> [394.209630] i915 0000:00:02.0: [drm:intel_atomic_check [i915]] [CRTC:268:pipe B] fastset requirement not met, forcing full modeset
<7> [394.209776] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] Enabled dbuf slices 0x1 -> 0x3 (total dbuf slices 0x3), mbus joined? no->no
<7> [394.209905] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] [CRTC:268:pipe B] dbuf slices 0x0 -> 0x3, ddb (0 - 0) -> (0 - 2048), active pipes 0x0 -> 0x2
<7> [394.210054] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] [PLANE:152:plane 1B] ddb ( 0 - 0) -> ( 0 - 2016), size 0 -> 2016
<7> [394.210193] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] [PLANE:262:cursor B] ddb ( 0 - 0) -> (2016 - 2048), size 0 -> 32
<7> [394.210337] i915 0000:00:02.0: [drm:skl_print_plane_changes [i915]] [PLANE:152:plane 1B] level wm0, wm1, wm2, wm3, wm4, wm5, wm6, wm7, twm, swm, stwm -> *wm0,*wm1,*wm2,*wm3,*wm4,*wm5,*wm6,*wm7,*twm, swm, stwm
<7> [394.210462] i915 0000:00:02.0: [drm:skl_print_plane_changes [i915]] [PLANE:152:plane 1B] lines 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0 -> 1, 2, 2, 2, 2, 5, 8, 9, 0, 0, 0
<7> [394.210586] i915 0000:00:02.0: [drm:skl_print_plane_changes [i915]] [PLANE:152:plane 1B] blocks 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0 -> 16, 33, 33, 33, 33, 81, 129, 145, 30, 0, 0
<7> [394.210710] i915 0000:00:02.0: [drm:skl_print_plane_changes [i915]] [PLANE:152:plane 1B] min_ddb 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0 -> 19, 38, 38, 38, 38, 91, 143, 161, 31, 0, 0
<7> [394.210849] i915 0000:00:02.0: [drm:intel_bw_atomic_check [i915]] [CRTC:268:pipe B] data rate 559716 num active planes 1
<7> [394.210981] i915 0000:00:02.0: [drm:intel_bw_atomic_check [i915]] QGV point 0: max bw 16761 required 560
<7> [394.211125] i915 0000:00:02.0: [drm:intel_bw_atomic_check [i915]] No SAGV, using single QGV point mask 0x1
<7> [394.211291] i915 0000:00:02.0: [drm:intel_cdclk_atomic_check [i915]] [CRTC:268:pipe B] min cdclk: 0 kHz -> 69965 kHz
<7> [394.211433] i915 0000:00:02.0: [drm:intel_cdclk_update_dbuf_bw_min_cdclk [i915]] dbuf bandwidth min cdclk: 0 kHz -> 8746 kHz
<7> [394.211567] i915 0000:00:02.0: [drm:intel_find_dpll [i915]] [CRTC:268:pipe B] allocated DPLL 0
<7> [394.211702] i915 0000:00:02.0: [drm:intel_dpll_crtc_get [i915]] [CRTC:268:pipe B] reserving DPLL 0
<7> [394.211838] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [CRTC:268:pipe B] enable: yes [modeset]
<7> [394.211971] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] active: yes, output_types: HDMI (0x40), output format: RGB, sink format: RGB
<7> [394.212204] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] cpu_transcoder: B, pipe bpp: 24, dithering: 0
<7> [394.212335] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] MST master transcoder: <invalid>
<7> [394.212463] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] port sync: master transcoder: <invalid>, slave transcoder bitmask = 0x0
<7> [394.212592] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] joiner: no, pipes: 0x0
<7> [394.212719] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] splitter: disabled, link count 0, overlap 0
<7> [394.212847] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] audio: 0, infoframes: 0, infoframes enabled: 0x0
<7> [394.212973] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] scanline offset: 2
<7> [394.213109] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] framestart delay: 1, MSA timing delay: 0, set context latency: 0
<7> [394.213256] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] vrr: no, fixed rr: yes, vmin: 1125, vmax: 1125, flipline: 1125, pipeline full: 42, guardband: 44 vsync start: 0, vsync end: 0
<7> [394.213384] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] vrr: vmin vblank: 1081, vmax vblank: 1081, vmin vtotal: 1125, vmax vtotal: 1125
<7> [394.213511] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] vrr: dc balance: no, vmin: 0 vmax: 0 guardband: 0, slope: 0 max increase: 0 max decrease: 0 vblank target: 0
<7> [394.213637] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] requested mode: "1920x1080": 53 139930 1920 2008 2096 2360 1080 1084 1089 1125 0x48 0x5
<7> [394.213764] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] adjusted mode: "1920x1080": 53 139930 1920 2008 2096 2360 1080 1084 1089 1125 0x48 0x5
<7> [394.213890] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] crtc timings: clock=139929, hd=1920 hb=1920-2360 hs=2008-2096 ht=2360, vd=1080 vb=1080-1125 vs=1084-1089 vt=1125, flags=0x5
<7> [394.214017] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pipe mode: "1920x1080": 53 139929 1920 2008 2096 2360 1080 1084 1089 1125 0x40 0x5
<7> [394.214155] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] crtc timings: clock=139929, hd=1920 hb=1920-2360 hs=2008-2096 ht=2360, vd=1080 vb=1080-1125 vs=1084-1089 vt=1125, flags=0x5
<7> [394.214311] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] port clock: 139929, pipe src: 1920x1080+0+0, pixel rate 139929, min cdclk 69965
<7> [394.214442] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] linetime: 135, ips linetime: 0
<7> [394.214570] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] num_scalers: 2, scaler_users: 0x0, scaler_id: -1, scaling_filter: 0
<7> [394.214697] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pch pfit: 0x0+0+0, disabled, force thru: no
<7> [394.214824] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] ips: 0, double wide: 0, drrs: 0
<7> [394.214952] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] dpll_hw_state: cfgcr0: 0x1a6655d, cfgcr1: 0xe84, div0: 0x0, mg_refclkin_ctl: 0x0, hg_clktop2_coreclkctl1: 0x0, mg_clktop2_hsclkctl: 0x0, mg_pll_div0: 0x0, mg_pll_div2: 0x0, mg_pll_lf: 0x0, mg_pll_frac_lock: 0x0, mg_pll_ssc: 0x0, mg_pll_bias: 0x0, mg_pll_tdc_coldst_bias: 0x0
<7> [394.215089] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] csc_mode: 0x0 gamma_mode: 0x0 gamma_enable: 0 csc_enable: 0
<7> [394.215240] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pre csc lut: 0 entries, post csc lut: 0 entries
<7> [394.215366] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] output csc: pre offsets: 0x0000 0x0000 0x0000
<7> [394.215492] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] output csc: coefficients: 0x0000 0x0000 0x0000
<7> [394.215618] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] output csc: coefficients: 0x0000 0x0000 0x0000
<7> [394.215744] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] output csc: coefficients: 0x0000 0x0000 0x0000
<7> [394.215869] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] output csc: post offsets: 0x0000 0x0000 0x0000
<7> [394.215994] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pipe csc: pre offsets: 0x0000 0x0000 0x0000
<7> [394.216132] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pipe csc: coefficients: 0x0000 0x0000 0x0000
<7> [394.216279] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pipe csc: coefficients: 0x0000 0x0000 0x0000
<7> [394.216405] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pipe csc: coefficients: 0x0000 0x0000 0x0000
<7> [394.216529] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pipe csc: post offsets: 0x0000 0x0000 0x0000
<7> [394.216654] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] sharpness strength: 0, sharpness tap size: 0, sharpness enable: 0
<7> [394.216778] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:152:plane 1B] fb: [FB:419] 1920x1080 format = XR24 little-endian (0x34325258) modifier = 0x100000000000001, visible: yes
<7> [394.216904] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] rotation: 0x1, scaler: -1, scaling_filter: 0
<7> [394.217029] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] src: 1920.000000x1080.000000+0.000000+0.000000 dst: 1920x1080+0+0
<7> [394.217169] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:182:plane 2B] fb: [NOFB], visible: no
<7> [394.217321] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:212:plane 3B] fb: [NOFB], visible: no
<7> [394.217445] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:242:plane 4B] fb: [NOFB], visible: no
<7> [394.217569] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:252:plane 5B] fb: [NOFB], visible: no
<7> [394.217694] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:262:cursor B] fb: [NOFB], visible: no
<7> [394.218356] i915 0000:00:02.0: [drm:intel_power_well_enable [i915]] enabling PW_3
<7> [394.218513] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:388:DDI B/PHY B]
<7> [394.218645] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:398:DDI TC1/PHY C]
<7> [394.218775] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:402:DDI TC2/PHY D]
<7> [394.218905] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:404:DP-MST A]
<7> [394.219032] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:405:DP-MST B]
<7> [394.219180] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:406:DP-MST C]
<7> [394.219372] i915 0000:00:02.0: [drm:gen9_dbuf_slices_update [i915]] Updating dbuf slices to 0x3
<7> [394.219540] i915 0000:00:02.0: [drm:intel_dpll_enable [i915]] enable DPLL 0 (active 0x2, on? 0) for [CRTC:268:pipe B]
<7> [394.219675] i915 0000:00:02.0: [drm:intel_dpll_enable [i915]] enabling DPLL 0
<7> [394.219862] i915 0000:00:02.0: [drm:intel_power_well_enable [i915]] enabling DDI_IO_TC1
<7> [394.220032] i915 0000:00:02.0: [drm:intel_enable_transcoder [i915]] enabling pipe B
<7> [394.240145] i915 0000:00:02.0: [drm:verify_connector_state [i915]] [CONNECTOR:399:HDMI-A-2]
<7> [394.240414] i915 0000:00:02.0: [drm:intel_modeset_verify_crtc [i915]] [CRTC:268:pipe B]
<6> [394.341915] pcieport 0000:00:06.0: AER: Correctable error message received from 0000:01:00.0
<4> [394.341936] nvme 0000:01:00.0: PCIe Bus Error: severity=Correctable, type=Physical Layer, (Receiver ID)
<4> [394.341945] nvme 0000:01:00.0: device [15b7:5006] error status/mask=00000001/0000e000
<4> [394.341953] nvme 0000:01:00.0: [ 0] RxErr (First)
<7> [404.581230] i915 0000:00:02.0: [drm:drm_mode_rmfb_work_fn] Removing [FB:419] from all active usage due to RMFB ioctl
<7> [404.581444] i915 0000:00:02.0: [drm:atomic_remove_fb] Disabling [PLANE:152:plane 1B] because [FB:419] is removed
<7> [404.581618] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] [PLANE:152:plane 1B] ddb ( 0 - 2016) -> ( 0 - 0), size 2016 -> 0
<7> [404.582351] i915 0000:00:02.0: [drm:skl_print_plane_changes [i915]] [PLANE:152:plane 1B] level *wm0,*wm1,*wm2,*wm3,*wm4,*wm5,*wm6,*wm7,*twm, swm, stwm -> wm0, wm1, wm2, wm3, wm4, wm5, wm6, wm7, twm, swm, stwm
<7> [404.582981] i915 0000:00:02.0: [drm:skl_print_plane_changes [i915]] [PLANE:152:plane 1B] lines 1, 2, 2, 2, 2, 5, 8, 9, 0, 0, 0 -> 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0
<7> [404.583568] i915 0000:00:02.0: [drm:skl_print_plane_changes [i915]] [PLANE:152:plane 1B] blocks 16, 33, 33, 33, 33, 81, 129, 145, 30, 0, 0 -> 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0
<7> [404.584194] i915 0000:00:02.0: [drm:skl_print_plane_changes [i915]] [PLANE:152:plane 1B] min_ddb 19, 38, 38, 38, 38, 91, 143, 161, 31, 0, 0 -> 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0
<7> [404.584841] i915 0000:00:02.0: [drm:intel_bw_atomic_check [i915]] [CRTC:268:pipe B] data rate 0 num active planes 0
<7> [404.585526] i915 0000:00:02.0: [drm:intel_bw_atomic_check [i915]] QGV point 0: max bw 16761 required 0
<6> [404.600547] [IGT] kms_flip: finished subtest B-HDMI-A2, SUCCESS
<6> [404.602126] [IGT] kms_flip: starting dynamic subtest C-HDMI-A2
<7> [404.602821] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:419]
<7> [404.603107] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:420]
<7> [404.639995] i915 0000:00:02.0: [drm:drm_mode_setcrtc] [CRTC:150:pipe A]
<7> [404.640348] i915 0000:00:02.0: [drm:drm_mode_setcrtc] [CRTC:268:pipe B]
<7> [404.640498] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:268:pipe B] fastset requirement not met in hw.enable (expected yes, found no)
<7> [404.640963] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:268:pipe B] fastset requirement not met in hw.active (expected yes, found no)
<7> [404.641366] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:268:pipe B] fastset requirement not met in cpu_transcoder (expected 1, found -1)
<7> [404.641750] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:268:pipe B] fastset requirement not met in lane_count (expected 4, found 0)
<7> [404.642157] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:268:pipe B] fastset requirement not met in output_types (expected 0x00000040, found 0x00000000)
<7> [404.642534] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:268:pipe B] fastset requirement not met in framestart_delay (expected 1, found 0)
<7> [404.642931] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:268:pipe B] fastset requirement not met in hw.pipe_mode.crtc_hdisplay (expected 1920, found 0)
<7> [404.643322] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:268:pipe B] fastset requirement not met in hw.pipe_mode.crtc_htotal (expected 2360, found 0)
<7> [404.643695] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:268:pipe B] fastset requirement not met in hw.pipe_mode.crtc_hblank_start (expected 1920, found 0)
<7> [404.644174] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:268:pipe B] fastset requirement not met in hw.pipe_mode.crtc_hblank_end (expected 2360, found 0)
<7> [404.644544] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:268:pipe B] fastset requirement not met in hw.pipe_mode.crtc_hsync_start (expected 2008, found 0)
<7> [404.644896] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:268:pipe B] fastset requirement not met in hw.pipe_mode.crtc_hsync_end (expected 2096, found 0)
<7> [404.645222] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:268:pipe B] fastset requirement not met in hw.pipe_mode.crtc_vdisplay (expected 1080, found 0)
<7> [404.645517] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:268:pipe B] fastset requirement not met in hw.pipe_mode.crtc_vblank_start (expected 1080, found 0)
<7> [404.645813] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:268:pipe B] fastset requirement not met in hw.pipe_mode.crtc_vsync_start (expected 1084, found 0)
<7> [404.646130] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:268:pipe B] fastset requirement not met in hw.pipe_mode.crtc_vsync_end (expected 1089, found 0)
<7> [404.646426] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:268:pipe B] fastset requirement not met in hw.pipe_mode.crtc_vtotal (expected 1125, found 0)
<7> [404.646720] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:268:pipe B] fastset requirement not met in hw.pipe_mode.crtc_vblank_end (expected 1125, found 0)
<7> [404.647032] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:268:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_hdisplay (expected 1920, found 0)
<7> [404.647324] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:268:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_htotal (expected 2360, found 0)
<7> [404.647619] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:268:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_hblank_start (expected 1920, found 0)
<7> [404.647876] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:268:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_hblank_end (expected 2360, found 0)
<7> [404.648121] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:268:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_hsync_start (expected 2008, found 0)
<7> [404.648348] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:268:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_hsync_end (expected 2096, found 0)
<7> [404.648572] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:268:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_vdisplay (expected 1080, found 0)
<7> [404.648796] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:268:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_vblank_start (expected 1080, found 0)
<7> [404.649037] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:268:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_vsync_start (expected 1084, found 0)
<7> [404.649263] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:268:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_vsync_end (expected 1089, found 0)
<7> [404.649488] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:268:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_vtotal (expected 1125, found 0)
<7> [404.649712] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:268:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_vblank_end (expected 1125, found 0)
<7> [404.649945] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:268:pipe B] fastset requirement not met in pixel_multiplier (expected 1, found 0)
<7> [404.650173] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:268:pipe B] fastset requirement not met in hw.adjusted_mode.flags (1) (expected 1, found 0)
<7> [404.650396] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:268:pipe B] fastset requirement not met in hw.adjusted_mode.flags (4) (expected 4, found 0)
<7> [404.650619] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:268:pipe B] fastset requirement not met in pipe_bpp (expected 24, found 0)
<7> [404.650845] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:268:pipe B] fastset requirement not met in hw.pipe_mode.crtc_clock (expected 139929, found 0)
<7> [404.651060] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:268:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_clock (expected 139929, found 0)
<7> [404.651227] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:268:pipe B] fastset requirement not met in port_clock (expected 139929, found 0)
<7> [404.651393] i915 0000:00:02.0: [drm:intel_atomic_check [i915]] [CRTC:268:pipe B] fastset requirement not met, forcing full modeset
<7> [404.651561] i915 0000:00:02.0: [drm:intel_dpll_crtc_put [i915]] [CRTC:268:pipe B] releasing DPLL 0
<7> [404.651754] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] Enabled dbuf slices 0x3 -> 0x1 (total dbuf slices 0x3), mbus joined? no->no
<7> [404.651929] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] [CRTC:268:pipe B] dbuf slices 0x3 -> 0x0, ddb (0 - 2048) -> (0 - 0), active pipes 0x2 -> 0x0
<7> [404.652122] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] [PLANE:262:cursor B] ddb (2016 - 2048) -> ( 0 - 0), size 32 -> 0
<7> [404.652323] i915 0000:00:02.0: [drm:intel_cdclk_atomic_check [i915]] [CRTC:268:pipe B] min cdclk: 69965 kHz -> 0 kHz
<7> [404.652500] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [CRTC:268:pipe B] enable: no [modeset]
<7> [404.652673] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:152:plane 1B] fb: [NOFB], visible: no
<7> [404.652844] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:182:plane 2B] fb: [NOFB], visible: no
<7> [404.653033] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:212:plane 3B] fb: [NOFB], visible: no
<7> [404.653202] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:242:plane 4B] fb: [NOFB], visible: no
<7> [404.653377] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:252:plane 5B] fb: [NOFB], visible: no
<7> [404.653545] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:262:cursor B] fb: [NOFB], visible: no
<7> [404.653832] i915 0000:00:02.0: [drm:intel_disable_transcoder [i915]] disabling pipe B
<7> [404.656785] i915 0000:00:02.0: [drm:intel_power_well_disable [i915]] disabling DDI_IO_TC1
<7> [404.656958] i915 0000:00:02.0: [drm:intel_dpll_disable [i915]] disable DPLL 0 (active 0x2, on? 1) for [CRTC:268:pipe B]
<7> [404.657125] i915 0000:00:02.0: [drm:intel_dpll_disable [i915]] disabling DPLL 0
<7> [404.657275] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:388:DDI B/PHY B]
<7> [404.657416] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:398:DDI TC1/PHY C]
<7> [404.657570] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:402:DDI TC2/PHY D]
<7> [404.657707] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:404:DP-MST A]
<7> [404.657844] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:405:DP-MST B]
<7> [404.657990] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:406:DP-MST C]
<7> [404.658127] i915 0000:00:02.0: [drm:verify_connector_state [i915]] [CONNECTOR:399:HDMI-A-2]
<7> [404.658330] i915 0000:00:02.0: [drm:gen9_dbuf_slices_update [i915]] Updating dbuf slices to 0x1
<7> [404.658514] i915 0000:00:02.0: [drm:intel_power_well_disable [i915]] disabling PW_3
<7> [404.658683] i915 0000:00:02.0: [drm:intel_modeset_verify_crtc [i915]] [CRTC:268:pipe B]
<7> [404.658997] i915 0000:00:02.0: [drm:drm_mode_setcrtc] [CRTC:386:pipe C]
<7> [404.659131] i915 0000:00:02.0: [drm:drm_mode_setcrtc] [CRTC:386:pipe C]
<7> [404.659152] i915 0000:00:02.0: [drm:drm_mode_setcrtc] [CONNECTOR:399:HDMI-A-2]
<7> [404.659205] i915 0000:00:02.0: [drm:intel_atomic_check [i915]] [CONNECTOR:399:HDMI-A-2] Limiting target display pipe bpp to 24 (EDID bpp 24, max requested bpp 36, max platform bpp 36)
<7> [404.659358] i915 0000:00:02.0: [drm:intel_hdmi_compute_clock [i915]] picking 8 bpc for HDMI output (pipe bpp: 24)
<7> [404.659492] i915 0000:00:02.0: [drm:intel_atomic_check [i915]] [CRTC:386:pipe C] hw max bpp: 24, pipe bpp: 24, dithering: 0
<7> [404.659636] i915 0000:00:02.0: [drm:intel_ddi_compute_config_late [i915]] [ENCODER:398:DDI TC1/PHY C] [CRTC:386:pipe C]
<7> [404.659772] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:386:pipe C] fastset requirement not met in hw.enable (expected no, found yes)
<7> [404.659922] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:386:pipe C] fastset requirement not met in hw.active (expected no, found yes)
<7> [404.660068] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:386:pipe C] fastset requirement not met in cpu_transcoder (expected -1, found 2)
<7> [404.660199] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:386:pipe C] fastset requirement not met in lane_count (expected 0, found 4)
<7> [404.660330] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:386:pipe C] fastset requirement not met in output_types (expected 0x00000000, found 0x00000040)
<7> [404.660461] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:386:pipe C] fastset requirement not met in framestart_delay (expected 0, found 1)
<7> [404.660592] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:386:pipe C] fastset requirement not met in hw.pipe_mode.crtc_hdisplay (expected 0, found 1920)
<7> [404.660723] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:386:pipe C] fastset requirement not met in hw.pipe_mode.crtc_htotal (expected 0, found 2360)
<7> [404.660851] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:386:pipe C] fastset requirement not met in hw.pipe_mode.crtc_hblank_start (expected 0, found 1920)
<7> [404.660991] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:386:pipe C] fastset requirement not met in hw.pipe_mode.crtc_hblank_end (expected 0, found 2360)
<7> [404.661119] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:386:pipe C] fastset requirement not met in hw.pipe_mode.crtc_hsync_start (expected 0, found 2008)
<7> [404.661248] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:386:pipe C] fastset requirement not met in hw.pipe_mode.crtc_hsync_end (expected 0, found 2096)
<7> [404.661375] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:386:pipe C] fastset requirement not met in hw.pipe_mode.crtc_vdisplay (expected 0, found 1080)
<7> [404.661503] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:386:pipe C] fastset requirement not met in hw.pipe_mode.crtc_vblank_start (expected 0, found 1080)
<7> [404.661632] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:386:pipe C] fastset requirement not met in hw.pipe_mode.crtc_vsync_start (expected 0, found 1084)
<7> [404.661760] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:386:pipe C] fastset requirement not met in hw.pipe_mode.crtc_vsync_end (expected 0, found 1089)
<7> [404.661888] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:386:pipe C] fastset requirement not met in hw.pipe_mode.crtc_vtotal (expected 0, found 1125)
<7> [404.662028] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:386:pipe C] fastset requirement not met in hw.pipe_mode.crtc_vblank_end (expected 0, found 1125)
<7> [404.662156] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:386:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_hdisplay (expected 0, found 1920)
<7> [404.662283] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:386:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_htotal (expected 0, found 2360)
<7> [404.662410] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:386:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_hblank_start (expected 0, found 1920)
<7> [404.662538] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:386:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_hblank_end (expected 0, found 2360)
<7> [404.662666] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:386:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_hsync_start (expected 0, found 2008)
<7> [404.662793] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:386:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_hsync_end (expected 0, found 2096)
<7> [404.662926] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:386:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_vdisplay (expected 0, found 1080)
<7> [404.663054] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:386:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_vblank_start (expected 0, found 1080)
<7> [404.663181] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:386:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_vsync_start (expected 0, found 1084)
<7> [404.663308] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:386:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_vsync_end (expected 0, found 1089)
<7> [404.663435] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:386:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_vtotal (expected 0, found 1125)
<7> [404.663562] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:386:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_vblank_end (expected 0, found 1125)
<7> [404.663690] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:386:pipe C] fastset requirement not met in pixel_multiplier (expected 0, found 1)
<7> [404.663817] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:386:pipe C] fastset requirement not met in hw.adjusted_mode.flags (1) (expected 0, found 1)
<7> [404.663952] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:386:pipe C] fastset requirement not met in hw.adjusted_mode.flags (4) (expected 0, found 4)
<7> [404.664081] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:386:pipe C] fastset requirement not met in pipe_bpp (expected 0, found 24)
<7> [404.664210] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:386:pipe C] fastset requirement not met in hw.pipe_mode.crtc_clock (expected 0, found 139929)
<7> [404.664337] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:386:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_clock (expected 0, found 139929)
<7> [404.664464] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:386:pipe C] fastset requirement not met in port_clock (expected 0, found 139929)
<7> [404.664592] i915 0000:00:02.0: [drm:intel_atomic_check [i915]] [CRTC:386:pipe C] fastset requirement not met, forcing full modeset
<7> [404.664737] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] Enabled dbuf slices 0x1 -> 0x3 (total dbuf slices 0x3), mbus joined? no->no
<7> [404.664866] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] [CRTC:386:pipe C] dbuf slices 0x0 -> 0x3, ddb (0 - 0) -> (0 - 2048), active pipes 0x0 -> 0x4
<7> [404.665033] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] [PLANE:270:plane 1C] ddb ( 0 - 0) -> ( 0 - 2016), size 0 -> 2016
<7> [404.665161] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] [PLANE:380:cursor C] ddb ( 0 - 0) -> (2016 - 2048), size 0 -> 32
<7> [404.665287] i915 0000:00:02.0: [drm:skl_print_plane_changes [i915]] [PLANE:270:plane 1C] level wm0, wm1, wm2, wm3, wm4, wm5, wm6, wm7, twm, swm, stwm -> *wm0,*wm1,*wm2,*wm3,*wm4,*wm5,*wm6,*wm7,*twm, swm, stwm
<7> [404.665411] i915 0000:00:02.0: [drm:skl_print_plane_changes [i915]] [PLANE:270:plane 1C] lines 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0 -> 1, 2, 2, 2, 2, 5, 8, 9, 0, 0, 0
<7> [404.665534] i915 0000:00:02.0: [drm:skl_print_plane_changes [i915]] [PLANE:270:plane 1C] blocks 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0 -> 16, 33, 33, 33, 33, 81, 129, 145, 30, 0, 0
<7> [404.665659] i915 0000:00:02.0: [drm:skl_print_plane_changes [i915]] [PLANE:270:plane 1C] min_ddb 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0 -> 19, 38, 38, 38, 38, 91, 143, 161, 31, 0, 0
<7> [404.665795] i915 0000:00:02.0: [drm:intel_bw_atomic_check [i915]] [CRTC:386:pipe C] data rate 559716 num active planes 1
<7> [404.665936] i915 0000:00:02.0: [drm:intel_bw_atomic_check [i915]] QGV point 0: max bw 16761 required 560
<7> [404.666067] i915 0000:00:02.0: [drm:intel_bw_atomic_check [i915]] No SAGV, using single QGV point mask 0x1
<7> [404.666208] i915 0000:00:02.0: [drm:intel_cdclk_atomic_check [i915]] [CRTC:386:pipe C] min cdclk: 0 kHz -> 69965 kHz
<7> [404.666353] i915 0000:00:02.0: [drm:intel_find_dpll [i915]] [CRTC:386:pipe C] allocated DPLL 0
<7> [404.666487] i915 0000:00:02.0: [drm:intel_dpll_crtc_get [i915]] [CRTC:386:pipe C] reserving DPLL 0
<7> [404.666620] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [CRTC:386:pipe C] enable: yes [modeset]
<7> [404.666753] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] active: yes, output_types: HDMI (0x40), output format: RGB, sink format: RGB
<7> [404.666884] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] cpu_transcoder: C, pipe bpp: 24, dithering: 0
<7> [404.667026] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] MST master transcoder: <invalid>
<7> [404.667156] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] port sync: master transcoder: <invalid>, slave transcoder bitmask = 0x0
<7> [404.667286] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] joiner: no, pipes: 0x0
<7> [404.667415] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] splitter: disabled, link count 0, overlap 0
<7> [404.667543] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] audio: 0, infoframes: 0, infoframes enabled: 0x0
<7> [404.667673] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] scanline offset: 2
<7> [404.667800] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] framestart delay: 1, MSA timing delay: 0, set context latency: 0
<7> [404.667935] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] vrr: no, fixed rr: yes, vmin: 1125, vmax: 1125, flipline: 1125, pipeline full: 42, guardband: 44 vsync start: 0, vsync end: 0
<7> [404.668064] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] vrr: vmin vblank: 1081, vmax vblank: 1081, vmin vtotal: 1125, vmax vtotal: 1125
<7> [404.668208] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] vrr: dc balance: no, vmin: 0 vmax: 0 guardband: 0, slope: 0 max increase: 0 max decrease: 0 vblank target: 0
<7> [404.668335] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] requested mode: "1920x1080": 53 139930 1920 2008 2096 2360 1080 1084 1089 1125 0x48 0x5
<7> [404.668464] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] adjusted mode: "1920x1080": 53 139930 1920 2008 2096 2360 1080 1084 1089 1125 0x48 0x5
<7> [404.668592] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] crtc timings: clock=139929, hd=1920 hb=1920-2360 hs=2008-2096 ht=2360, vd=1080 vb=1080-1125 vs=1084-1089 vt=1125, flags=0x5
<7> [404.668720] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pipe mode: "1920x1080": 53 139929 1920 2008 2096 2360 1080 1084 1089 1125 0x40 0x5
<7> [404.668848] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] crtc timings: clock=139929, hd=1920 hb=1920-2360 hs=2008-2096 ht=2360, vd=1080 vb=1080-1125 vs=1084-1089 vt=1125, flags=0x5
<7> [404.669023] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] port clock: 139929, pipe src: 1920x1080+0+0, pixel rate 139929, min cdclk 69965
<7> [404.669149] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] linetime: 135, ips linetime: 0
<7> [404.669277] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] num_scalers: 2, scaler_users: 0x0, scaler_id: -1, scaling_filter: 0
<7> [404.669404] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pch pfit: 0x0+0+0, disabled, force thru: no
<7> [404.669531] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] ips: 0, double wide: 0, drrs: 0
<7> [404.669658] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] dpll_hw_state: cfgcr0: 0x1a6655d, cfgcr1: 0xe84, div0: 0x0, mg_refclkin_ctl: 0x0, hg_clktop2_coreclkctl1: 0x0, mg_clktop2_hsclkctl: 0x0, mg_pll_div0: 0x0, mg_pll_div2: 0x0, mg_pll_lf: 0x0, mg_pll_frac_lock: 0x0, mg_pll_ssc: 0x0, mg_pll_bias: 0x0, mg_pll_tdc_coldst_bias: 0x0
<7> [404.669787] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] csc_mode: 0x0 gamma_mode: 0x0 gamma_enable: 0 csc_enable: 0
<7> [404.669918] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pre csc lut: 0 entries, post csc lut: 0 entries
<7> [404.670043] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] output csc: pre offsets: 0x0000 0x0000 0x0000
<7> [404.670168] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] output csc: coefficients: 0x0000 0x0000 0x0000
<7> [404.670296] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] output csc: coefficients: 0x0000 0x0000 0x0000
<7> [404.670423] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] output csc: coefficients: 0x0000 0x0000 0x0000
<7> [404.670549] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] output csc: post offsets: 0x0000 0x0000 0x0000
<7> [404.670674] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pipe csc: pre offsets: 0x0000 0x0000 0x0000
<7> [404.670800] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pipe csc: coefficients: 0x0000 0x0000 0x0000
<7> [404.670937] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pipe csc: coefficients: 0x0000 0x0000 0x0000
<7> [404.671063] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pipe csc: coefficients: 0x0000 0x0000 0x0000
<7> [404.671189] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pipe csc: post offsets: 0x0000 0x0000 0x0000
<7> [404.671315] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] sharpness strength: 0, sharpness tap size: 0, sharpness enable: 0
<7> [404.671442] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:270:plane 1C] fb: [FB:419] 1920x1080 format = XR24 little-endian (0x34325258) modifier = 0x100000000000001, visible: yes
<7> [404.671570] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] rotation: 0x1, scaler: -1, scaling_filter: 0
<7> [404.671698] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] src: 1920.000000x1080.000000+0.000000+0.000000 dst: 1920x1080+0+0
<7> [404.671824] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:300:plane 2C] fb: [NOFB], visible: no
<7> [404.671958] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:330:plane 3C] fb: [NOFB], visible: no
<7> [404.672084] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:360:plane 4C] fb: [NOFB], visible: no
<7> [404.672210] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:370:plane 5C] fb: [NOFB], visible: no
<7> [404.672336] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:380:cursor C] fb: [NOFB], visible: no
<7> [404.673036] i915 0000:00:02.0: [drm:intel_power_well_enable [i915]] enabling PW_3
<7> [404.673192] i915 0000:00:02.0: [drm:intel_power_well_enable [i915]] enabling PW_4
<7> [404.673352] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:388:DDI B/PHY B]
<7> [404.673486] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:398:DDI TC1/PHY C]
<7> [404.673617] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:402:DDI TC2/PHY D]
<7> [404.673745] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:404:DP-MST A]
<7> [404.673874] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:405:DP-MST B]
<7> [404.674020] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:406:DP-MST C]
<7> [404.674185] i915 0000:00:02.0: [drm:gen9_dbuf_slices_update [i915]] Updating dbuf slices to 0x3
<7> [404.674350] i915 0000:00:02.0: [drm:intel_dpll_enable [i915]] enable DPLL 0 (active 0x4, on? 0) for [CRTC:386:pipe C]
<7> [404.674483] i915 0000:00:02.0: [drm:intel_dpll_enable [i915]] enabling DPLL 0
<7> [404.674670] i915 0000:00:02.0: [drm:intel_power_well_enable [i915]] enabling DDI_IO_TC1
<7> [404.674838] i915 0000:00:02.0: [drm:intel_enable_transcoder [i915]] enabling pipe C
<7> [404.694825] i915 0000:00:02.0: [drm:verify_connector_state [i915]] [CONNECTOR:399:HDMI-A-2]
<7> [404.695139] i915 0000:00:02.0: [drm:intel_modeset_verify_crtc [i915]] [CRTC:386:pipe C]
<7> [415.035783] i915 0000:00:02.0: [drm:drm_mode_rmfb_work_fn] Removing [FB:420] from all active usage due to RMFB ioctl
<7> [415.036003] i915 0000:00:02.0: [drm:drm_mode_rmfb_work_fn] Removing [FB:419] from all active usage due to RMFB ioctl
<7> [415.036125] i915 0000:00:02.0: [drm:atomic_remove_fb] Disabling [PLANE:270:plane 1C] because [FB:419] is removed
<7> [415.036346] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] [PLANE:270:plane 1C] ddb ( 0 - 2016) -> ( 0 - 0), size 2016 -> 0
<7> [415.037011] i915 0000:00:02.0: [drm:skl_print_plane_changes [i915]] [PLANE:270:plane 1C] level *wm0,*wm1,*wm2,*wm3,*wm4,*wm5,*wm6,*wm7,*twm, swm, stwm -> wm0, wm1, wm2, wm3, wm4, wm5, wm6, wm7, twm, swm, stwm
<7> [415.037660] i915 0000:00:02.0: [drm:skl_print_plane_changes [i915]] [PLANE:270:plane 1C] lines 1, 2, 2, 2, 2, 5, 8, 9, 0, 0, 0 -> 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0
<7> [415.038295] i915 0000:00:02.0: [drm:skl_print_plane_changes [i915]] [PLANE:270:plane 1C] blocks 16, 33, 33, 33, 33, 81, 129, 145, 30, 0, 0 -> 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0
<7> [415.038941] i915 0000:00:02.0: [drm:skl_print_plane_changes [i915]] [PLANE:270:plane 1C] min_ddb 19, 38, 38, 38, 38, 91, 143, 161, 31, 0, 0 -> 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0
<7> [415.039650] i915 0000:00:02.0: [drm:intel_bw_atomic_check [i915]] [CRTC:386:pipe C] data rate 0 num active planes 0
<7> [415.040301] i915 0000:00:02.0: [drm:intel_bw_atomic_check [i915]] QGV point 0: max bw 16761 required 0
<6> [415.055905] [IGT] kms_flip: finished subtest C-HDMI-A2, SUCCESS
<6> [415.059554] [IGT] kms_flip: finished subtest plain-flip-ts-check, FAIL
<6> [415.068806] [IGT] kms_flip: exiting, ret=98
<7> [415.069625] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc]
<7> [415.087555] i915 0000:00:02.0: [drm:intel_atomic_check [i915]] [CONNECTOR:399:HDMI-A-2] Limiting target display pipe bpp to 24 (EDID bpp 24, max requested bpp 36, max platform bpp 36)
<7> [415.088292] i915 0000:00:02.0: [drm:intel_hdmi_compute_clock [i915]] picking 8 bpc for HDMI output (pipe bpp: 24)
<7> [415.088879] i915 0000:00:02.0: [drm:intel_atomic_check [i915]] [CRTC:150:pipe A] hw max bpp: 24, pipe bpp: 24, dithering: 0
<7> [415.089634] i915 0000:00:02.0: [drm:intel_ddi_compute_config_late [i915]] [ENCODER:398:DDI TC1/PHY C] [CRTC:150:pipe A]
<7> [415.090449] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:150:pipe A] fastset requirement not met in hw.enable (expected no, found yes)
<7> [415.091249] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:150:pipe A] fastset requirement not met in hw.active (expected no, found yes)
<7> [415.092017] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:150:pipe A] fastset requirement not met in cpu_transcoder (expected -1, found 0)
<7> [415.092675] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:150:pipe A] fastset requirement not met in lane_count (expected 0, found 4)
<7> [415.093090] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:150:pipe A] fastset requirement not met in output_types (expected 0x00000000, found 0x00000040)
<7> [415.093625] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:150:pipe A] fastset requirement not met in framestart_delay (expected 0, found 1)
<7> [415.094214] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:150:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hdisplay (expected 0, found 1920)
<7> [415.094788] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:150:pipe A] fastset requirement not met in hw.pipe_mode.crtc_htotal (expected 0, found 2360)
<7> [415.095293] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:150:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hblank_start (expected 0, found 1920)
<7> [415.095674] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:150:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hblank_end (expected 0, found 2360)
<7> [415.096145] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:150:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hsync_start (expected 0, found 2008)
<7> [415.096584] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:150:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hsync_end (expected 0, found 2096)
<7> [415.097014] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:150:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vdisplay (expected 0, found 1080)
<7> [415.097466] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:150:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vblank_start (expected 0, found 1080)
<7> [415.097803] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:150:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vsync_start (expected 0, found 1084)
<7> [415.098294] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:150:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vsync_end (expected 0, found 1089)
<7> [415.098731] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:150:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vtotal (expected 0, found 1125)
<7> [415.098992] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:150:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vblank_end (expected 0, found 1125)
<7> [415.099217] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:150:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hdisplay (expected 0, found 1920)
<7> [415.099421] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:150:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_htotal (expected 0, found 2360)
<7> [415.099685] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:150:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hblank_start (expected 0, found 1920)
<7> [415.099997] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:150:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hblank_end (expected 0, found 2360)
<7> [415.100328] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:150:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hsync_start (expected 0, found 2008)
<7> [415.100627] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:150:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hsync_end (expected 0, found 2096)
<7> [415.100841] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:150:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vdisplay (expected 0, found 1080)
<7> [415.101046] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:150:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vblank_start (expected 0, found 1080)
<7> [415.101272] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:150:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vsync_start (expected 0, found 1084)
<7> [415.101544] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:150:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vsync_end (expected 0, found 1089)
<7> [415.101760] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:150:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vtotal (expected 0, found 1125)
<7> [415.101975] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:150:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vblank_end (expected 0, found 1125)
<7> [415.102158] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:150:pipe A] fastset requirement not met in pixel_multiplier (expected 0, found 1)
<7> [415.102299] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:150:pipe A] fastset requirement not met in hw.adjusted_mode.flags (1) (expected 0, found 1)
<7> [415.102441] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:150:pipe A] fastset requirement not met in hw.adjusted_mode.flags (4) (expected 0, found 4)
<7> [415.102582] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:150:pipe A] fastset requirement not met in pipe_bpp (expected 0, found 24)
<7> [415.102767] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:150:pipe A] fastset requirement not met in hw.pipe_mode.crtc_clock (expected 0, found 139929)
<7> [415.102981] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:150:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_clock (expected 0, found 139929)
<7> [415.103209] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:150:pipe A] fastset requirement not met in port_clock (expected 0, found 139929)
<7> [415.103427] i915 0000:00:02.0: [drm:intel_atomic_check [i915]] [CRTC:150:pipe A] fastset requirement not met, forcing full modeset
<7> [415.103586] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:386:pipe C] fastset requirement not met in hw.enable (expected yes, found no)
<7> [415.103731] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:386:pipe C] fastset requirement not met in hw.active (expected yes, found no)
<7> [415.103874] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:386:pipe C] fastset requirement not met in cpu_transcoder (expected 2, found -1)
<7> [415.104017] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:386:pipe C] fastset requirement not met in lane_count (expected 4, found 0)
<7> [415.104208] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:386:pipe C] fastset requirement not met in output_types (expected 0x00000040, found 0x00000000)
<7> [415.104437] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:386:pipe C] fastset requirement not met in framestart_delay (expected 1, found 0)
<7> [415.104631] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:386:pipe C] fastset requirement not met in hw.pipe_mode.crtc_hdisplay (expected 1920, found 0)
<7> [415.104808] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:386:pipe C] fastset requirement not met in hw.pipe_mode.crtc_htotal (expected 2360, found 0)
<7> [415.104938] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:386:pipe C] fastset requirement not met in hw.pipe_mode.crtc_hblank_start (expected 1920, found 0)
<7> [415.105066] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:386:pipe C] fastset requirement not met in hw.pipe_mode.crtc_hblank_end (expected 2360, found 0)
<7> [415.105207] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:386:pipe C] fastset requirement not met in hw.pipe_mode.crtc_hsync_start (expected 2008, found 0)
<7> [415.105342] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:386:pipe C] fastset requirement not met in hw.pipe_mode.crtc_hsync_end (expected 2096, found 0)
<7> [415.105536] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:386:pipe C] fastset requirement not met in hw.pipe_mode.crtc_vdisplay (expected 1080, found 0)
<7> [415.105734] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:386:pipe C] fastset requirement not met in hw.pipe_mode.crtc_vblank_start (expected 1080, found 0)
<7> [415.105926] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:386:pipe C] fastset requirement not met in hw.pipe_mode.crtc_vsync_start (expected 1084, found 0)
<7> [415.106061] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:386:pipe C] fastset requirement not met in hw.pipe_mode.crtc_vsync_end (expected 1089, found 0)
<7> [415.106202] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:386:pipe C] fastset requirement not met in hw.pipe_mode.crtc_vtotal (expected 1125, found 0)
<7> [415.106330] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:386:pipe C] fastset requirement not met in hw.pipe_mode.crtc_vblank_end (expected 1125, found 0)
<7> [415.106458] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:386:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_hdisplay (expected 1920, found 0)
<7> [415.106631] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:386:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_htotal (expected 2360, found 0)
<7> [415.106828] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:386:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_hblank_start (expected 1920, found 0)
<7> [415.107021] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:386:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_hblank_end (expected 2360, found 0)
<7> [415.107249] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:386:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_hsync_start (expected 2008, found 0)
<7> [415.107383] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:386:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_hsync_end (expected 2096, found 0)
<7> [415.107511] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:386:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_vdisplay (expected 1080, found 0)
<7> [415.107639] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:386:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_vblank_start (expected 1080, found 0)
<7> [415.107767] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:386:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_vsync_start (expected 1084, found 0)
<7> [415.107924] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:386:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_vsync_end (expected 1089, found 0)
<7> [415.108121] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:386:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_vtotal (expected 1125, found 0)
<7> [415.108339] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:386:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_vblank_end (expected 1125, found 0)
<7> [415.108528] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:386:pipe C] fastset requirement not met in pixel_multiplier (expected 1, found 0)
<7> [415.108662] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:386:pipe C] fastset requirement not met in hw.adjusted_mode.flags (1) (expected 1, found 0)
<7> [415.108790] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:386:pipe C] fastset requirement not met in hw.adjusted_mode.flags (4) (expected 4, found 0)
<7> [415.108919] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:386:pipe C] fastset requirement not met in pipe_bpp (expected 24, found 0)
<7> [415.109047] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:386:pipe C] fastset requirement not met in hw.pipe_mode.crtc_clock (expected 139929, found 0)
<7> [415.109249] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:386:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_clock (expected 139929, found 0)
<7> [415.109446] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:386:pipe C] fastset requirement not met in port_clock (expected 139929, found 0)
<7> [415.109640] i915 0000:00:02.0: [drm:intel_atomic_check [i915]] [CRTC:386:pipe C] fastset requirement not met, forcing full modeset
<7> [415.109828] i915 0000:00:02.0: [drm:intel_dpll_crtc_put [i915]] [CRTC:386:pipe C] releasing DPLL 0
<7> [415.109999] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] [CRTC:150:pipe A] dbuf slices 0x0 -> 0x3, ddb (0 - 0) -> (0 - 2048), active pipes 0x4 -> 0x1
<7> [415.110138] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] [CRTC:386:pipe C] dbuf slices 0x3 -> 0x0, ddb (0 - 2048) -> (0 - 0), active pipes 0x4 -> 0x1
<7> [415.110269] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] [PLANE:34:plane 1A] ddb ( 0 - 0) -> ( 0 - 2016), size 0 -> 2016
<7> [415.110396] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] [PLANE:144:cursor A] ddb ( 0 - 0) -> (2016 - 2048), size 0 -> 32
<7> [415.110525] i915 0000:00:02.0: [drm:skl_print_plane_changes [i915]] [PLANE:34:plane 1A] level wm0, wm1, wm2, wm3, wm4, wm5, wm6, wm7, twm, swm, stwm -> *wm0,*wm1,*wm2,*wm3,*wm4,*wm5,*wm6,*wm7,*twm, swm, stwm
<7> [415.110652] i915 0000:00:02.0: [drm:skl_print_plane_changes [i915]] [PLANE:34:plane 1A] lines 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0 -> 1, 2, 2, 2, 2, 5, 8, 9, 0, 0, 0
<7> [415.110777] i915 0000:00:02.0: [drm:skl_print_plane_changes [i915]] [PLANE:34:plane 1A] blocks 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0 -> 16, 33, 33, 33, 33, 81, 129, 145, 30, 0, 0
<7> [415.110903] i915 0000:00:02.0: [drm:skl_print_plane_changes [i915]] [PLANE:34:plane 1A] min_ddb 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0 -> 19, 38, 38, 38, 38, 91, 143, 161, 31, 0, 0
<7> [415.111027] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] [PLANE:380:cursor C] ddb (2016 - 2048) -> ( 0 - 0), size 32 -> 0
<7> [415.111176] i915 0000:00:02.0: [drm:intel_bw_atomic_check [i915]] [CRTC:150:pipe A] data rate 559716 num active planes 1
<7> [415.111333] i915 0000:00:02.0: [drm:intel_bw_atomic_check [i915]] QGV point 0: max bw 16761 required 560
<7> [415.111534] i915 0000:00:02.0: [drm:intel_bw_atomic_check [i915]] No SAGV, using single QGV point mask 0x1
<7> [415.111757] i915 0000:00:02.0: [drm:intel_cdclk_atomic_check [i915]] [CRTC:150:pipe A] min cdclk: 0 kHz -> 69965 kHz
<7> [415.111956] i915 0000:00:02.0: [drm:intel_cdclk_atomic_check [i915]] [CRTC:386:pipe C] min cdclk: 69965 kHz -> 0 kHz
<7> [415.112115] i915 0000:00:02.0: [drm:intel_find_dpll [i915]] [CRTC:150:pipe A] allocated DPLL 0
<7> [415.112270] i915 0000:00:02.0: [drm:intel_dpll_crtc_get [i915]] [CRTC:150:pipe A] reserving DPLL 0
<7> [415.112408] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [CRTC:150:pipe A] enable: yes [modeset]
<7> [415.112541] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] active: yes, output_types: HDMI (0x40), output format: RGB, sink format: RGB
<7> [415.112733] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] cpu_transcoder: A, pipe bpp: 24, dithering: 0
<7> [415.112934] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] MST master transcoder: <invalid>
<7> [415.113141] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] port sync: master transcoder: <invalid>, slave transcoder bitmask = 0x0
<7> [415.113330] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] joiner: no, pipes: 0x0
<7> [415.113464] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] splitter: disabled, link count 0, overlap 0
<7> [415.113594] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] audio: 0, infoframes: 0, infoframes enabled: 0x0
<7> [415.113724] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] scanline offset: 2
<7> [415.113852] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] framestart delay: 1, MSA timing delay: 0, set context latency: 0
<7> [415.114018] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] vrr: no, fixed rr: yes, vmin: 1125, vmax: 1125, flipline: 1125, pipeline full: 42, guardband: 44 vsync start: 0, vsync end: 0
<7> [415.114231] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] vrr: vmin vblank: 1081, vmax vblank: 1081, vmin vtotal: 1125, vmax vtotal: 1125
<7> [415.114429] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] vrr: dc balance: no, vmin: 0 vmax: 0 guardband: 0, slope: 0 max increase: 0 max decrease: 0 vblank target: 0
<7> [415.114621] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] requested mode: "1920x1080": 53 139930 1920 2008 2096 2360 1080 1084 1089 1125 0x48 0x5
<7> [415.114751] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] adjusted mode: "1920x1080": 53 139930 1920 2008 2096 2360 1080 1084 1089 1125 0x48 0x5
<7> [415.114878] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] crtc timings: clock=139929, hd=1920 hb=1920-2360 hs=2008-2096 ht=2360, vd=1080 vb=1080-1125 vs=1084-1089 vt=1125, flags=0x5
<7> [415.115007] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pipe mode: "1920x1080": 53 139929 1920 2008 2096 2360 1080 1084 1089 1125 0x40 0x5
<7> [415.115144] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] crtc timings: clock=139929, hd=1920 hb=1920-2360 hs=2008-2096 ht=2360, vd=1080 vb=1080-1125 vs=1084-1089 vt=1125, flags=0x5
<7> [415.115319] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] port clock: 139929, pipe src: 1920x1080+0+0, pixel rate 139929, min cdclk 69965
<7> [415.115517] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] linetime: 135, ips linetime: 0
<7> [415.115711] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] num_scalers: 2, scaler_users: 0x0, scaler_id: -1, scaling_filter: 0
<7> [415.115881] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pch pfit: 0x0+0+0, disabled, force thru: no
<7> [415.116013] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] ips: 0, double wide: 0, drrs: 0
<7> [415.116150] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] dpll_hw_state: cfgcr0: 0x1a6655d, cfgcr1: 0xe84, div0: 0x0, mg_refclkin_ctl: 0x0, hg_clktop2_coreclkctl1: 0x0, mg_clktop2_hsclkctl: 0x0, mg_pll_div0: 0x0, mg_pll_div2: 0x0, mg_pll_lf: 0x0, mg_pll_frac_lock: 0x0, mg_pll_ssc: 0x0, mg_pll_bias: 0x0, mg_pll_tdc_coldst_bias: 0x0
<7> [415.116280] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] csc_mode: 0x0 gamma_mode: 0x0 gamma_enable: 0 csc_enable: 0
<7> [415.116418] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pre csc lut: 0 entries, post csc lut: 0 entries
<7> [415.116616] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] output csc: pre offsets: 0x0000 0x0000 0x0000
<7> [415.116814] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] output csc: coefficients: 0x0000 0x0000 0x0000
<7> [415.117005] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] output csc: coefficients: 0x0000 0x0000 0x0000
<7> [415.117180] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] output csc: coefficients: 0x0000 0x0000 0x0000
<7> [415.117308] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] output csc: post offsets: 0x0000 0x0000 0x0000
<7> [415.117436] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pipe csc: pre offsets: 0x0000 0x0000 0x0000
<7> [415.117562] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pipe csc: coefficients: 0x0000 0x0000 0x0000
<7> [415.117688] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pipe csc: coefficients: 0x0000 0x0000 0x0000
<7> [415.117852] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pipe csc: coefficients: 0x0000 0x0000 0x0000
<7> [415.118047] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pipe csc: post offsets: 0x0000 0x0000 0x0000
<7> [415.118261] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] sharpness strength: 0, sharpness tap size: 0, sharpness enable: 0
<7> [415.118454] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:34:plane 1A] fb: [FB:414] 1920x1080 format = XR24 little-endian (0x34325258) modifier = 0x0, visible: yes
<7> [415.118588] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] rotation: 0x1, scaler: -1, scaling_filter: 0
<7> [415.118715] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] src: 1920.000000x1080.000000+0.000000+0.000000 dst: 1920x1080+0+0
<7> [415.118843] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:64:plane 2A] fb: [NOFB], visible: no
<7> [415.118969] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:94:plane 3A] fb: [NOFB], visible: no
<7> [415.119137] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:124:plane 4A] fb: [NOFB], visible: no
<7> [415.119336] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:134:plane 5A] fb: [NOFB], visible: no
<7> [415.119528] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:144:cursor A] fb: [NOFB], visible: no
<7> [415.119706] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [CRTC:386:pipe C] enable: no [modeset]
<7> [415.119838] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:270:plane 1C] fb: [NOFB], visible: no
<7> [415.119967] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:300:plane 2C] fb: [NOFB], visible: no
<7> [415.120094] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:330:plane 3C] fb: [NOFB], visible: no
<7> [415.120241] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:360:plane 4C] fb: [NOFB], visible: no
<7> [415.120435] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:370:plane 5C] fb: [NOFB], visible: no
<7> [415.120634] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:380:cursor C] fb: [NOFB], visible: no
<7> [415.121033] i915 0000:00:02.0: [drm:intel_disable_transcoder [i915]] disabling pipe C
<7> [415.130168] i915 0000:00:02.0: [drm:intel_power_well_disable [i915]] disabling DDI_IO_TC1
<7> [415.130328] i915 0000:00:02.0: [drm:intel_dpll_disable [i915]] disable DPLL 0 (active 0x4, on? 1) for [CRTC:386:pipe C]
<7> [415.130485] i915 0000:00:02.0: [drm:intel_dpll_disable [i915]] disabling DPLL 0
<7> [415.130628] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:388:DDI B/PHY B]
<7> [415.130762] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:398:DDI TC1/PHY C]
<7> [415.130893] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:402:DDI TC2/PHY D]
<7> [415.131024] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:404:DP-MST A]
<7> [415.131169] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:405:DP-MST B]
<7> [415.131368] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:406:DP-MST C]
<7> [415.131722] i915 0000:00:02.0: [drm:intel_dpll_enable [i915]] enable DPLL 0 (active 0x1, on? 0) for [CRTC:150:pipe A]
<7> [415.131878] i915 0000:00:02.0: [drm:intel_dpll_enable [i915]] enabling DPLL 0
<7> [415.132070] i915 0000:00:02.0: [drm:intel_power_well_enable [i915]] enabling DDI_IO_TC1
<7> [415.132256] i915 0000:00:02.0: [drm:intel_enable_transcoder [i915]] enabling pipe A
<7> [415.132710] i915 0000:00:02.0: [drm:intel_fbc_update [i915]] reserved 17694720 bytes of contiguous stolen space for FBC, limit: 1
<7> [415.132901] i915 0000:00:02.0: [drm:intel_fbc_update [i915]] Enabling FBC on [PLANE:34:plane 1A]
<7> [415.152213] i915 0000:00:02.0: [drm:verify_connector_state [i915]] [CONNECTOR:399:HDMI-A-2]
<7> [415.152498] i915 0000:00:02.0: [drm:intel_modeset_verify_crtc [i915]] [CRTC:150:pipe A]
<7> [415.153183] i915 0000:00:02.0: [drm:intel_power_well_disable [i915]] disabling PW_4
<7> [415.153616] i915 0000:00:02.0: [drm:intel_modeset_verify_crtc [i915]] [CRTC:386:pipe C]
<7> [415.154451] i915 0000:00:02.0: [drm:drm_client_dev_restore] fbdev: ret=0
<6> [415.171564] Console: switching to colour frame buffer device 240x67
<6> [415.244142] pcieport 0000:00:06.0: AER: Correctable error message received from 0000:01:00.0
<4> [415.244156] nvme 0000:01:00.0: PCIe Bus Error: severity=Correctable, type=Physical Layer, (Receiver ID)
<4> [415.244161] nvme 0000:01:00.0: device [15b7:5006] error status/mask=00000001/0000e000
<4> [415.244166] nvme 0000:01:00.0: [ 0] RxErr (First)
Created at 2026-03-06 06:09:34