Results for igt@kms_flip@2x-flip-vs-expired-vblank@bc-hdmi-a1-hdmi-a2

Result: Fail

integration-manifest git-log-oneline i915_display_info19 igt_runner19 runtimes19 results19.json results19-i915-load.json guc_logs19.tar boot19 dmesg19

DetailValue
Duration 4.21 seconds
Hostname
shard-glk6
Igt-Version
IGT-Version: 2.3-g4c8773922 (x86_64) (Linux: 7.0.0-rc3-CI_DRM_18141-g721db23a9c23+ x86_64)
Out
Starting dynamic subtest: BC-HDMI-A1-HDMI-A2
  1920x1080: 60 148500 1920 2008 2052 2200 1080 1083 1088 1125 0x48 0x9 
  1920x1080: 60 148500 1920 2008 2052 2200 1080 1083 1088 1125 0x48 0x9 
Stack trace:
  #0 ../lib/igt_core.c:2075 __igt_fail_assert()
  #1 ../tests/kms_flip.c:921 run_test_on_crtc_set.constprop.0()
  #2 ../tests/kms_flip.c:1972 run_pair()
  #3 ../tests/kms_flip.c:2131 __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 BC-HDMI-A1-HDMI-A2: FAIL (4.212s)
Subtest 2x-flip-vs-expired-vblank: FAIL (25.778s)
Stack trace:
  #0 ../lib/igt_core.c:2075 __igt_fail_assert()
  #1 ../lib/igt_kms.c:2351 kmstest_set_connector_dpms()
  #2 ../lib/igt_core.c:2961 igt_atexit_handler()
  #3 [erand48_r+0x1d6]
  #4 [exit+0x1e]
  #5 ../lib/igt_core.c:2416 igt_exit()
  #6 [main+0x3f]
  #7 [__libc_init_first+0x8a]
  #8 [__libc_start_main+0x8b]
  #9 [_start+0x25]
Err
Starting dynamic subtest: BC-HDMI-A1-HDMI-A2
(kms_flip:2544) CRITICAL: Test assertion failure function run_test_step, file ../tests/kms_flip.c:926:
(kms_flip:2544) CRITICAL: Failed assertion: end - start < 500
Dynamic subtest BC-HDMI-A1-HDMI-A2 failed.
**** DEBUG ****
(kms_flip:2544) DEBUG: name = flip
last_ts = 358.967896
last_received_ts = 358.967743
last_seq = 12509
current_ts = 358.984558
current_received_ts = 358.984253
current_seq = 12510
count = 47
seq_step = 1
(kms_flip:2544) DEBUG: Vblank took 23us
(kms_flip:2544) DEBUG: name = flip
last_ts = 358.984558
last_received_ts = 358.984253
last_seq = 12510
current_ts = 359.001221
current_received_ts = 359.000824
current_seq = 12511
count = 48
seq_step = 1
(kms_flip:2544) DEBUG: Vblank took 26us
(kms_flip:2544) DEBUG: name = flip
last_ts = 359.001221
last_received_ts = 359.000824
last_seq = 12511
current_ts = 359.017883
current_received_ts = 359.017914
current_seq = 12512
count = 49
seq_step = 1
(kms_flip:2544) DEBUG: Vblank took 26us
(kms_flip:2544) DEBUG: name = flip
last_ts = 359.017883
last_received_ts = 359.017914
last_seq = 12512
current_ts = 359.034546
current_received_ts = 359.034332
current_seq = 12513
count = 50
seq_step = 1
(kms_flip:2544) DEBUG: Vblank took 24us
(kms_flip:2544) DEBUG: name = flip
last_ts = 359.034546
last_received_ts = 359.034332
last_seq = 12513
current_ts = 359.051208
current_received_ts = 359.050995
current_seq = 12514
count = 51
seq_step = 1
(kms_flip:2544) DEBUG: Vblank took 27us
(kms_flip:2544) DEBUG: name = flip
last_ts = 359.051208
last_received_ts = 359.050995
last_seq = 12514
current_ts = 359.067902
current_received_ts = 359.067413
current_seq = 12515
count = 52
seq_step = 1
(kms_flip:2544) DEBUG: Vblank took 17us
(kms_flip:2544) DEBUG: name = flip
last_ts = 359.067902
last_received_ts = 359.067413
last_seq = 12515
current_ts = 359.084564
current_received_ts = 359.084320
current_seq = 12516
count = 53
seq_step = 1
(kms_flip:2544) DEBUG: Vblank took 20us
(kms_flip:2544) DEBUG: name = flip
last_ts = 359.084564
last_received_ts = 359.084320
last_seq = 12516
current_ts = 359.101227
current_received_ts = 359.100891
current_seq = 12517
count = 54
seq_step = 1
(kms_flip:2544) DEBUG: Vblank took 22us
(kms_flip:2544) DEBUG: name = flip
last_ts = 359.101227
last_received_ts = 359.100891
last_seq = 12517
current_ts = 359.117889
current_received_ts = 359.117493
current_seq = 12518
count = 55
seq_step = 1
(kms_flip:2544) DEBUG: Vblank took 24us
(kms_flip:2544) DEBUG: name = flip
last_ts = 359.117889
last_received_ts = 359.117493
last_seq = 12518
current_ts = 359.134552
current_received_ts = 359.134247
current_seq = 12519
count = 56
seq_step = 1
(kms_flip:2544) DEBUG: Vblank took 19us
(kms_flip:2544) DEBUG: name = flip
last_ts = 359.134552
last_received_ts = 359.134247
last_seq = 12519
current_ts = 359.151215
current_received_ts = 359.150940
current_seq = 12520
count = 57
seq_step = 1
(kms_flip:2544) DEBUG: Vblank took 65us
(kms_flip:2544) DEBUG: name = flip
last_ts = 359.151215
last_received_ts = 359.150940
last_seq = 12520
current_ts = 359.167877
current_received_ts = 359.167419
current_seq = 12521
count = 58
seq_step = 1
(kms_flip:2544) DEBUG: Vblank took 23us
(kms_flip:2544) DEBUG: name = flip
last_ts = 359.167877
last_received_ts = 359.167419
last_seq = 12521
current_ts = 359.184540
current_received_ts = 359.184296
current_seq = 12522
count = 59
seq_step = 1
(kms_flip:2544) DEBUG: Vblank took 24us
(kms_flip:2544) DEBUG: name = flip
last_ts = 359.184540
last_received_ts = 359.184296
last_seq = 12522
current_ts = 359.201233
current_received_ts = 359.200775
current_seq = 12523
count = 60
seq_step = 1
(kms_flip:2544) DEBUG: Vblank took 26us
(kms_flip:2544) DEBUG: name = flip
last_ts = 359.201233
last_received_ts = 359.200775
last_seq = 12523
current_ts = 359.217896
current_received_ts = 359.217468
current_seq = 12524
count = 61
seq_step = 1
(kms_flip:2544) DEBUG: Vblank took 23us
(kms_flip:2544) DEBUG: name = flip
last_ts = 359.217896
last_received_ts = 359.217468
last_seq = 12524
current_ts = 359.234558
current_received_ts = 359.234283
current_seq = 12525
count = 62
seq_step = 1
(kms_flip:2544) DEBUG: Vblank took 21us
(kms_flip:2544) DEBUG: name = flip
last_ts = 359.234558
last_received_ts = 359.234283
last_seq = 12525
current_ts = 359.251221
current_received_ts = 359.251068
current_seq = 12526
count = 63
seq_step = 1
(kms_flip:2544) DEBUG: Vblank took 26us
(kms_flip:2544) DEBUG: name = flip
last_ts = 359.251221
last_received_ts = 359.251068
last_seq = 12526
current_ts = 359.267883
current_received_ts = 359.267548
current_seq = 12527
count = 64
seq_step = 1
(kms_flip:2544) DEBUG: Vblank took 27us
(kms_flip:2544) DEBUG: name = flip
last_ts = 359.267883
last_received_ts = 359.267548
last_seq = 12527
current_ts = 359.284546
current_received_ts = 359.284302
current_seq = 12528
count = 65
seq_step = 1
(kms_flip:2544) DEBUG: Vblank took 23us
(kms_flip:2544) DEBUG: name = flip
last_ts = 359.284546
last_received_ts = 359.284302
last_seq = 12528
current_ts = 359.301208
current_received_ts = 359.301117
current_seq = 12529
count = 66
seq_step = 1
(kms_flip:2544) DEBUG: Vblank took 27us
(kms_flip:2544) DEBUG: name = flip
last_ts = 359.301208
last_received_ts = 359.301117
last_seq = 12529
current_ts = 359.317871
current_received_ts = 359.317413
current_seq = 12530
count = 67
seq_step = 1
(kms_flip:2544) DEBUG: Vblank took 22us
(kms_flip:2544) DEBUG: name = flip
last_ts = 359.317871
last_received_ts = 359.317413
last_seq = 12530
current_ts = 359.334564
current_received_ts = 359.334290
current_seq = 12531
count = 68
seq_step = 1
(kms_flip:2544) DEBUG: Vblank took 23us
(kms_flip:2544) DEBUG: name = flip
last_ts = 359.334564
last_received_ts = 359.334290
last_seq = 12531
current_ts = 359.351227
current_received_ts = 359.351074
current_seq = 12532
count = 69
seq_step = 1
(kms_flip:2544) DEBUG: Vblank took 24us
(kms_flip:2544) DEBUG: name = flip
last_ts = 359.351227
last_received_ts = 359.351074
last_seq = 12532
current_ts = 359.367889
current_received_ts = 359.367401
current_seq = 12533
count = 70
seq_step = 1
(kms_flip:2544) DEBUG: Vblank took 23us
(kms_flip:2544) DEBUG: name = flip
last_ts = 359.367889
last_received_ts = 359.367401
last_seq = 12533
current_ts = 359.384552
current_received_ts = 359.384247
current_seq = 12534
count = 71
seq_step = 1
(kms_flip:2544) DEBUG: Vblank took 23us
(kms_flip:2544) DEBUG: name = flip
last_ts = 359.384552
last_received_ts = 359.384247
last_seq = 12534
current_ts = 359.401215
current_received_ts = 359.401001
current_seq = 12535
count = 72
seq_step = 1
(kms_flip:2544) DEBUG: Vblank took 24us
(kms_flip:2544) DEBUG: name = flip
last_ts = 359.401215
last_received_ts = 359.401001
last_seq = 12535
current_ts = 359.417877
current_received_ts = 359.417480
current_seq = 12536
count = 73
seq_step = 1
(kms_flip:2544) DEBUG: Vblank took 27us
(kms_flip:2544) DEBUG: name = flip
last_ts = 359.417877
last_received_ts = 359.417480
last_seq = 12536
current_ts = 359.434540
current_received_ts = 359.434265
current_seq = 12537
count = 74
seq_step = 1
(kms_flip:2544) DEBUG: Vblank took 20us
(kms_flip:2544) DEBUG: name = flip
last_ts = 359.434540
last_received_ts = 359.434265
last_seq = 12537
current_ts = 359.451202
current_received_ts = 359.451141
current_seq = 12538
count = 75
seq_step = 1
(kms_flip:2544) DEBUG: Vblank took 26us
(kms_flip:2544) DEBUG: name = flip
last_ts = 359.451202
last_received_ts = 359.451141
last_seq = 12538
current_ts = 359.467865
current_received_ts = 359.467529
current_seq = 12539
count = 76
seq_step = 1
(kms_flip:2544) DEBUG: Vblank took 25us
(kms_flip:2544) DEBUG: name = flip
last_ts = 359.467865
last_received_ts = 359.467529
last_seq = 12539
current_ts = 359.484558
current_received_ts = 359.484283
current_seq = 12540
count = 77
seq_step = 1
(kms_flip:2544) DEBUG: Vblank took 23us
(kms_flip:2544) DEBUG: name = flip
last_ts = 359.484558
last_received_ts = 359.484283
last_seq = 12540
current_ts = 359.501221
current_received_ts = 359.501099
current_seq = 12541
count = 78
seq_step = 1
(kms_flip:2544) DEBUG: Vblank took 28us
(kms_flip:2544) DEBUG: name = flip
last_ts = 359.501221
last_received_ts = 359.501099
last_seq = 12541
current_ts = 359.517883
current_received_ts = 359.517426
current_seq = 12542
count = 79
seq_step = 1
(kms_flip:2544) DEBUG: Vblank took 23us
(kms_flip:2544) DEBUG: name = flip
last_ts = 359.517883
last_received_ts = 359.517426
last_seq = 12542
current_ts = 359.534546
current_received_ts = 359.534302
current_seq = 12543
count = 80
seq_step = 1
(kms_flip:2544) DEBUG: Vblank took 24us
(kms_flip:2544) DEBUG: name = flip
last_ts = 359.534546
last_received_ts = 359.534302
last_seq = 12543
current_ts = 359.551208
current_received_ts = 359.551086
current_seq = 12544
count = 81
seq_step = 1
(kms_flip:2544) DEBUG: Vblank took 24us
(kms_flip:2544) DEBUG: name = flip
last_ts = 359.551208
last_received_ts = 359.551086
last_seq = 12544
current_ts = 359.567871
current_received_ts = 359.567444
current_seq = 12545
count = 82
seq_step = 1
(kms_flip:2544) DEBUG: Vblank took 24us
(kms_flip:2544) DEBUG: name = flip
last_ts = 359.567871
last_received_ts = 359.567444
last_seq = 12545
current_ts = 359.584564
current_received_ts = 359.584259
current_seq = 12546
count = 83
seq_step = 1
(kms_flip:2544) DEBUG: Vblank took 26us
(kms_flip:2544) DEBUG: name = flip
last_ts = 359.584564
last_received_ts = 359.584259
last_seq = 12546
current_ts = 359.601227
current_received_ts = 359.601044
current_seq = 12547
count = 84
seq_step = 1
(kms_flip:2544) DEBUG: Vblank took 24us
(kms_flip:2544) DEBUG: name = flip
last_ts = 359.601227
last_received_ts = 359.601044
last_seq = 12547
current_ts = 359.617889
current_received_ts = 359.617493
current_seq = 12548
count = 85
seq_step = 1
(kms_flip:2544) DEBUG: Vblank took 20us
(kms_flip:2544) DEBUG: name = flip
last_ts = 359.617889
last_received_ts = 359.617493
last_seq = 12548
current_ts = 359.634552
current_received_ts = 359.634277
current_seq = 12549
count = 86
seq_step = 1
(kms_flip:2544) DEBUG: Vblank took 18us
(kms_flip:2544) DEBUG: name = flip
last_ts = 359.634552
last_received_ts = 359.634277
last_seq = 12549
current_ts = 359.651215
current_received_ts = 359.651093
current_seq = 12550
count = 87
seq_step = 1
(kms_flip:2544) DEBUG: Vblank took 27us
(kms_flip:2544) DEBUG: name = flip
last_ts = 359.651215
last_received_ts = 359.651093
last_seq = 12550
current_ts = 359.667877
current_received_ts = 359.667480
current_seq = 12551
count = 88
seq_step = 1
(kms_flip:2544) DEBUG: Vblank took 23us
(kms_flip:2544) DEBUG: name = flip
last_ts = 359.667877
last_received_ts = 359.667480
last_seq = 12551
current_ts = 359.684540
current_received_ts = 359.684296
current_seq = 12552
count = 89
seq_step = 1
(kms_flip:2544) DEBUG: Vblank took 23us
(kms_flip:2544) DEBUG: name = flip
last_ts = 359.684540
last_received_ts = 359.684296
last_seq = 12552
current_ts = 359.701202
current_received_ts = 359.701111
current_seq = 12553
count = 90
seq_step = 1
(kms_flip:2544) DEBUG: Vblank took 29us
(kms_flip:2544) DEBUG: name = flip
last_ts = 359.701202
last_received_ts = 359.701111
last_seq = 12553
current_ts = 359.717896
current_received_ts = 359.717499
current_seq = 12554
count = 91
seq_step = 1
(kms_flip:2544) DEBUG: Vblank took 20us
(kms_flip:2544) DEBUG: name = flip
last_ts = 359.717896
last_received_ts = 359.717499
last_seq = 12554
current_ts = 359.734558
current_received_ts = 359.734283
current_seq = 12555
count = 92
seq_step = 1
(kms_flip:2544) DEBUG: Vblank took 18us
(kms_flip:2544) DEBUG: name = flip
last_ts = 359.734558
last_received_ts = 359.734283
last_seq = 12555
current_ts = 359.751221
current_received_ts = 359.751129
current_seq = 12556
count = 93
seq_step = 1
(kms_flip:2544) DEBUG: Vblank took 28us
(kms_flip:2544) DEBUG: name = flip
last_ts = 359.751221
last_received_ts = 359.751129
last_seq = 12556
current_ts = 359.767883
current_received_ts = 359.767456
current_seq = 12557
count = 94
seq_step = 1
(kms_flip:2544) DEBUG: Vblank took 18us
(kms_flip:2544) DEBUG: name = flip
last_ts = 359.767883
last_received_ts = 359.767456
last_seq = 12557
current_ts = 359.784546
current_received_ts = 359.784271
current_seq = 12558
count = 95
seq_step = 1
(kms_flip:2544) DEBUG: Vblank took 26us
(kms_flip:2544) DEBUG: name = flip
last_ts = 359.784546
last_received_ts = 359.784271
last_seq = 12558
current_ts = 359.801208
current_received_ts = 359.801056
current_seq = 12559
count = 96
seq_step = 1
(kms_flip:2544) DEBUG: Vblank took 22us
(kms_flip:2544) DEBUG: name = flip
last_ts = 359.801208
last_received_ts = 359.801056
last_seq = 12559
current_ts = 359.817902
current_received_ts = 359.817474
current_seq = 12560
count = 97
seq_step = 1
(kms_flip:2544) DEBUG: Vblank took 21us
(kms_flip:2544) DEBUG: name = flip
last_ts = 359.817902
last_received_ts = 359.817474
last_seq = 12560
current_ts = 359.834564
current_received_ts = 359.834259
current_seq = 12561
count = 98
seq_step = 1
(kms_flip:2544) DEBUG: Vblank took 23us
(kms_flip:2544) DEBUG: name = flip
last_ts = 359.834564
last_received_ts = 359.834259
last_seq = 12561
current_ts = 359.851227
current_received_ts = 359.850952
current_seq = 12562
count = 99
seq_step = 1
(kms_flip:2544) DEBUG: Vblank took 22us
(kms_flip:2544) DEBUG: name = flip
last_ts = 359.851227
last_received_ts = 359.850952
last_seq = 12562
current_ts = 359.867889
current_received_ts = 359.867859
current_seq = 12563
count = 100
seq_step = 1
(kms_flip:2544) DEBUG: Vblank took 24us
(kms_flip:2544) DEBUG: name = flip
last_ts = 359.867889
last_received_ts = 359.867859
last_seq = 12563
current_ts = 359.884552
current_received_ts = 359.884308
current_seq = 12564
count = 101
seq_step = 1
(kms_flip:2544) DEBUG: Vblank took 27us
(kms_flip:2544) DEBUG: name = flip
last_ts = 359.884552
last_received_ts = 359.884308
last_seq = 12564
current_ts = 359.901215
current_received_ts = 359.901093
current_seq = 12565
count = 102
seq_step = 1
(kms_flip:2544) DEBUG: Vblank took 27us
(kms_flip:2544) DEBUG: name = flip
last_ts = 359.901215
last_received_ts = 359.901093
last_seq = 12565
current_ts = 359.917877
current_received_ts = 359.917480
current_seq = 12566
count = 103
seq_step = 1
(kms_flip:2544) DEBUG: Vblank took 15us
(kms_flip:2544) DEBUG: name = flip
last_ts = 359.917877
last_received_ts = 359.917480
last_seq = 12566
current_ts = 359.934540
current_received_ts = 359.934235
current_seq = 12567
count = 104
seq_step = 1
(kms_flip:2544) DEBUG: Vblank took 22us
(kms_flip:2544) DEBUG: name = flip
last_ts = 359.934540
last_received_ts = 359.934235
last_seq = 12567
current_ts = 359.951202
current_received_ts = 359.951111
current_seq = 12568
count = 105
seq_step = 1
(kms_flip:2544) DEBUG: Vblank took 27us
(kms_flip:2544) DEBUG: name = flip
last_ts = 359.951202
last_received_ts = 359.951111
last_seq = 12568
current_ts = 359.967896
current_received_ts = 359.967529
current_seq = 12569
count = 106
seq_step = 1
(kms_flip:2544) DEBUG: Vblank took 25us
(kms_flip:2544) DEBUG: name = flip
last_ts = 359.967896
last_received_ts = 359.967529
last_seq = 12569
current_ts = 359.984558
current_received_ts = 359.984253
current_seq = 12570
count = 107
seq_step = 1
(kms_flip:2544) DEBUG: Vblank took 23us
(kms_flip:2544) DEBUG: name = flip
last_ts = 359.984558
last_received_ts = 359.984253
last_seq = 12570
current_ts = 360.001221
current_received_ts = 360.001099
current_seq = 12571
count = 108
seq_step = 1
(kms_flip:2544) DEBUG: Vblank took 28us
(kms_flip:2544) DEBUG: name = flip
last_ts = 360.001221
last_received_ts = 360.001099
last_seq = 12571
current_ts = 360.017883
current_received_ts = 360.017456
current_seq = 12572
count = 109
seq_step = 1
(kms_flip:2544) DEBUG: Vblank took 26us
(kms_flip:2544) DEBUG: name = flip
last_ts = 360.017883
last_received_ts = 360.017456
last_seq = 12572
current_ts = 360.034546
current_received_ts = 360.034271
current_seq = 12573
count = 110
seq_step = 1
(kms_flip:2544) DEBUG: Vblank took 19us
(kms_flip:2544) DEBUG: name = flip
last_ts = 360.034546
last_received_ts = 360.034271
last_seq = 12573
current_ts = 360.051208
current_received_ts = 360.051056
current_seq = 12574
count = 111
seq_step = 1
(kms_flip:2544) DEBUG: Vblank took 25us
(kms_flip:2544) DEBUG: name = flip
last_ts = 360.051208
last_received_ts = 360.051056
last_seq = 12574
current_ts = 360.067871
current_received_ts = 360.067444
current_seq = 12575
count = 112
seq_step = 1
(kms_flip:2544) DEBUG: Vblank took 25us
(kms_flip:2544) DEBUG: name = flip
last_ts = 360.067871
last_received_ts = 360.067444
last_seq = 12575
current_ts = 360.084534
current_received_ts = 360.084290
current_seq = 12576
count = 113
seq_step = 1
(kms_flip:2544) DEBUG: Vblank took 24us
(kms_flip:2544) DEBUG: name = flip
last_ts = 360.084534
last_received_ts = 360.084290
last_seq = 12576
current_ts = 360.101227
current_received_ts = 360.101135
current_seq = 12577
count = 114
seq_step = 1
(kms_flip:2544) DEBUG: Vblank took 27us
(kms_flip:2544) DEBUG: name = flip
last_ts = 360.101227
last_received_ts = 360.101135
last_seq = 12577
current_ts = 360.117889
current_received_ts = 360.117493
current_seq = 12578
count = 115
seq_step = 1
(kms_flip:2544) DEBUG: Vblank took 25us
(kms_flip:2544) DEBUG: name = flip
last_ts = 360.117889
last_received_ts = 360.117493
last_seq = 12578
current_ts = 360.134552
current_received_ts = 360.134247
current_seq = 12579
count = 116
seq_step = 1
(kms_flip:2544) DEBUG: Vblank took 19us
(kms_flip:2544) DEBUG: name = flip
last_ts = 360.134552
last_received_ts = 360.134247
last_seq = 12579
current_ts = 360.151215
current_received_ts = 360.150970
current_seq = 12580
count = 117
seq_step = 1
(kms_flip:2544) DEBUG: Vblank took 25us
(kms_flip:2544) DEBUG: name = flip
last_ts = 360.151215
last_received_ts = 360.150970
last_seq = 12580
current_ts = 360.167877
current_received_ts = 360.167419
current_seq = 12581
count = 118
seq_step = 1
(kms_flip:2544) DEBUG: Vblank took 25us
(kms_flip:2544) DEBUG: name = flip
last_ts = 360.167877
last_received_ts = 360.167419
last_seq = 12581
current_ts = 360.184540
current_received_ts = 360.184296
current_seq = 12582
count = 119
seq_step = 1
(kms_flip:2544) DEBUG: Vblank took 26us
(kms_flip:2544) DEBUG: name = flip
last_ts = 360.184540
last_received_ts = 360.184296
last_seq = 12582
current_ts = 360.201202
current_received_ts = 360.200867
current_seq = 12583
count = 120
seq_step = 1
(kms_flip:2544) DEBUG: Vblank took 18us
(kms_flip:2544) DEBUG: name = flip
last_ts = 360.201202
last_received_ts = 360.200867
last_seq = 12583
current_ts = 360.217896
current_received_ts = 360.217407
current_seq = 12584
count = 121
seq_step = 1
(kms_flip:2544) DEBUG: Vblank took 24us
(kms_flip:2544) DEBUG: name = flip
last_ts = 360.217896
last_received_ts = 360.217407
last_seq = 12584
current_ts = 360.234558
current_received_ts = 360.234283
current_seq = 12585
count = 122
seq_step = 1
(kms_flip:2544) DEBUG: Vblank took 25us
(kms_flip:2544) DEBUG: name = flip
last_ts = 360.234558
last_received_ts = 360.234283
last_seq = 12585
current_ts = 360.251221
current_received_ts = 360.251099
current_seq = 12586
count = 123
seq_step = 1
(kms_flip:2544) DEBUG: Vblank took 28us
(kms_flip:2544) DEBUG: name = flip
last_ts = 360.251221
last_received_ts = 360.251099
last_seq = 12586
current_ts = 360.267883
current_received_ts = 360.267426
current_seq = 12587
count = 124
seq_step = 1
(kms_flip:2544) DEBUG: Vblank took 22us
(kms_flip:2544) DEBUG: name = flip
last_ts = 360.267883
last_received_ts = 360.267426
last_seq = 12587
current_ts = 360.284546
current_received_ts = 360.284241
current_seq = 12588
count = 125
seq_step = 1
(kms_flip:2544) DEBUG: Vblank took 24us
(kms_flip:2544) DEBUG: name = flip
last_ts = 360.284546
last_received_ts = 360.284241
last_seq = 12588
current_ts = 360.301239
current_received_ts = 360.300873
current_seq = 12589
count = 126
seq_step = 1
(kms_flip:2544) DEBUG: Vblank took 25us
(kms_flip:2544) DEBUG: name = flip
last_ts = 360.301239
last_received_ts = 360.300873
last_seq = 12589
current_ts = 360.317902
current_received_ts = 360.317413
current_seq = 12590
count = 127
seq_step = 1
(kms_flip:2544) DEBUG: Vblank took 25us
(kms_flip:2544) DEBUG: name = flip
last_ts = 360.317902
last_received_ts = 360.317413
last_seq = 12590
current_ts = 360.334534
current_received_ts = 360.334229
current_seq = 12591
count = 128
seq_step = 1
(kms_flip:2544) DEBUG: Vblank took 22us
(kms_flip:2544) DEBUG: name = flip
last_ts = 360.334534
last_received_ts = 360.334229
last_seq = 12591
current_ts = 360.351227
current_received_ts = 360.351044
current_seq = 12592
count = 129
seq_step = 1
(kms_flip:2544) DEBUG: Vblank took 25us
(kms_flip:2544) DEBUG: name = flip
last_ts = 360.351227
last_received_ts = 360.351044
last_seq = 12592
current_ts = 360.367889
current_received_ts = 360.367493
current_seq = 12593
count = 130
seq_step = 1
(kms_flip:2544) DEBUG: Vblank took 21us
(kms_flip:2544) DEBUG: name = flip
last_ts = 360.367889
last_received_ts = 360.367493
last_seq = 12593
current_ts = 360.384552
current_received_ts = 360.384277
current_seq = 12594
count = 131
seq_step = 1
(kms_flip:2544) DEBUG: Vblank took 27us
(kms_flip:2544) DEBUG: name = flip
last_ts = 360.384552
last_received_ts = 360.384277
last_seq = 12594
current_ts = 360.401215
current_received_ts = 360.401093
current_seq = 12595
count = 132
seq_step = 1
(kms_flip:2544) DEBUG: Vblank took 26us
(kms_flip:2544) DEBUG: name = flip
last_ts = 360.401215
last_received_ts = 360.401093
last_seq = 12595
current_ts = 360.417877
current_received_ts = 360.417450
current_seq = 12596
count = 133
seq_step = 1
(kms_flip:2544) DEBUG: Vblank took 23us
(kms_flip:2544) DEBUG: name = flip
last_ts = 360.417877
last_received_ts = 360.417450
last_seq = 12596
current_ts = 360.434540
current_received_ts = 360.434296
current_seq = 12597
count = 134
seq_step = 1
(kms_flip:2544) DEBUG: Vblank took 29us
(kms_flip:2544) DEBUG: name = flip
last_ts = 360.434540
last_received_ts = 360.434296
last_seq = 12597
current_ts = 360.451202
current_received_ts = 360.450958
current_seq = 12598
count = 135
seq_step = 1
(kms_flip:2544) DEBUG: Vblank took 23us
(kms_flip:2544) DEBUG: name = flip
last_ts = 360.451202
last_received_ts = 360.450958
last_seq = 12598
current_ts = 360.467865
current_received_ts = 360.467438
current_seq = 12599
count = 136
seq_step = 1
(kms_flip:2544) DEBUG: Vblank took 27us
(kms_flip:2544) DEBUG: name = flip
last_ts = 360.467865
last_received_ts = 360.467438
last_seq = 12599
current_ts = 360.484558
current_received_ts = 360.484314
current_seq = 12600
count = 137
seq_step = 1
(kms_flip:2544) DEBUG: Vblank took 26us
(kms_flip:2544) DEBUG: name = flip
last_ts = 360.484558
last_received_ts = 360.484314
last_seq = 12600
current_ts = 360.501221
current_received_ts = 360.500977
current_seq = 12601
count = 138
seq_step = 1
(kms_flip:2544) DEBUG: Vblank took 25us
(kms_flip:2544) DEBUG: name = flip
last_ts = 360.501221
last_received_ts = 360.500977
last_seq = 12601
current_ts = 360.517883
current_received_ts = 360.517914
current_seq = 12602
count = 139
seq_step = 1
(kms_flip:2544) DEBUG: Vblank took 66us
(kms_flip:2544) DEBUG: name = flip
last_ts = 360.517883
last_received_ts = 360.517914
last_seq = 12602
current_ts = 360.534546
current_received_ts = 360.534302
current_seq = 12603
count = 140
seq_step = 1
(kms_flip:2544) DEBUG: Vblank took 27us
(kms_flip:2544) DEBUG: name = flip
last_ts = 360.534546
last_received_ts = 360.534302
last_seq = 12603
current_ts = 360.551239
current_received_ts = 360.550873
current_seq = 12604
count = 141
seq_step = 1
(kms_flip:2544) DEBUG: Vblank took 24us
(kms_flip:2544) DEBUG: name = flip
last_ts = 360.551239
last_received_ts = 360.550873
last_seq = 12604
current_ts = 360.567902
current_received_ts = 360.567413
current_seq = 12605
count = 142
seq_step = 1
(kms_flip:2544) DEBUG: Vblank took 25us
(kms_flip:2544) DEBUG: name = flip
last_ts = 360.567902
last_received_ts = 360.567413
last_seq = 12605
current_ts = 360.584564
current_received_ts = 360.584290
current_seq = 12606
count = 143
seq_step = 1
(kms_flip:2544) DEBUG: Vblank took 26us
(kms_flip:2544) DEBUG: name = flip
last_ts = 360.584564
last_received_ts = 360.584290
last_seq = 12606
current_ts = 360.601227
current_received_ts = 360.601074
current_seq = 12607
count = 144
seq_step = 1
(kms_flip:2544) DEBUG: Vblank took 27us
(kms_flip:2544) DEBUG: name = flip
last_ts = 360.601227
last_received_ts = 360.601074
last_seq = 12607
current_ts = 360.617889
current_received_ts = 360.617432
current_seq = 12608
count = 145
seq_step = 1
(kms_flip:2544) DEBUG: Vblank took 24us
(kms_flip:2544) DEBUG: name = flip
last_ts = 360.617889
last_received_ts = 360.617432
last_seq = 12608
current_ts = 360.634552
current_received_ts = 360.634308
current_seq = 12609
count = 146
seq_step = 1
(kms_flip:2544) DEBUG: Vblank took 24us
(kms_flip:2544) DEBUG: name = flip
last_ts = 360.634552
last_received_ts = 360.634308
last_seq = 12609
current_ts = 360.651215
current_received_ts = 360.651062
current_seq = 12610
count = 147
seq_step = 1
(kms_flip:2544) DEBUG: Vblank took 25us
(kms_flip:2544) DEBUG: name = flip
last_ts = 360.651215
last_received_ts = 360.651062
last_seq = 12610
current_ts = 360.667877
current_received_ts = 360.667450
current_seq = 12611
count = 148
seq_step = 1
(kms_flip:2544) DEBUG: Vblank took 23us
(kms_flip:2544) DEBUG: name = flip
last_ts = 360.667877
last_received_ts = 360.667450
last_seq = 12611
current_ts = 360.684570
current_received_ts = 360.684326
current_seq = 12612
count = 149
seq_step = 1
(kms_flip:2544) DEBUG: Vblank took 25us
(kms_flip:2544) DEBUG: name = flip
last_ts = 360.684570
last_received_ts = 360.684326
last_seq = 12612
current_ts = 360.701233
current_received_ts = 360.700989
current_seq = 12613
count = 150
seq_step = 1
(kms_flip:2544) DEBUG: Vblank took 25us
(kms_flip:2544) DEBUG: name = flip
last_ts = 360.701233
last_received_ts = 360.700989
last_seq = 12613
current_ts = 360.717896
current_received_ts = 360.717529
current_seq = 12614
count = 151
seq_step = 1
(kms_flip:2544) DEBUG: Vblank took 24us
(kms_flip:2544) DEBUG: name = flip
last_ts = 360.717896
last_received_ts = 360.717529
last_seq = 12614
current_ts = 360.734558
current_received_ts = 360.734253
current_seq = 12615
count = 152
seq_step = 1
(kms_flip:2544) DEBUG: Vblank took 20us
(kms_flip:2544) DEBUG: name = flip
last_ts = 360.734558
last_received_ts = 360.734253
last_seq = 12615
current_ts = 360.751221
current_received_ts = 360.750977
current_seq = 12616
count = 153
seq_step = 1
(kms_flip:2544) DEBUG: Vblank took 22us
(kms_flip:2544) DEBUG: name = flip
last_ts = 360.751221
last_received_ts = 360.750977
last_seq = 12616
current_ts = 360.767883
current_received_ts = 360.767883
current_seq = 12617
count = 154
seq_step = 1
(kms_flip:2544) DEBUG: Vblank took 25us
(kms_flip:2544) DEBUG: name = flip
last_ts = 360.767883
last_received_ts = 360.767883
last_seq = 12617
current_ts = 360.784546
current_received_ts = 360.784241
current_seq = 12618
count = 155
seq_step = 1
(kms_flip:2544) DEBUG: Vblank took 22us
(kms_flip:2544) DEBUG: name = flip
last_ts = 360.784546
last_received_ts = 360.784241
last_seq = 12618
current_ts = 360.801208
current_received_ts = 360.800964
current_seq = 12619
count = 156
seq_step = 1
(kms_flip:2544) DEBUG: Vblank took 24us
(kms_flip:2544) DEBUG: name = flip
last_ts = 360.801208
last_received_ts = 360.800964
last_seq = 12619
current_ts = 360.817871
current_received_ts = 360.817627
current_seq = 12620
count = 157
seq_step = 1
(kms_flip:2544) DEBUG: Vblank took 25us
(kms_flip:2544) DEBUG: name = flip
last_ts = 360.817871
last_received_ts = 360.817627
last_seq = 12620
current_ts = 360.834564
current_received_ts = 360.834259
current_seq = 12621
count = 158
seq_step = 1
(kms_flip:2544) DEBUG: Vblank took 25us
(kms_flip:2544) DEBUG: name = flip
last_ts = 360.834564
last_received_ts = 360.834259
last_seq = 12621
current_ts = 360.851227
current_received_ts = 360.850952
current_seq = 12622
count = 159
seq_step = 1
(kms_flip:2544) DEBUG: Vblank took 25us
(kms_flip:2544) DEBUG: name = flip
last_ts = 360.851227
last_received_ts = 360.850952
last_seq = 12622
current_ts = 360.867889
current_received_ts = 360.867401
current_seq = 12623
count = 160
seq_step = 1
(kms_flip:2544) DEBUG: Vblank took 22us
(kms_flip:2544) DEBUG: name = flip
last_ts = 360.867889
last_received_ts = 360.867401
last_seq = 12623
current_ts = 360.884552
current_received_ts = 360.884308
current_seq = 12624
count = 161
seq_step = 1
(kms_flip:2544) DEBUG: Vblank took 24us
(kms_flip:2544) DEBUG: name = flip
last_ts = 360.884552
last_received_ts = 360.884308
last_seq = 12624
current_ts = 360.901215
current_received_ts = 360.900970
current_seq = 12625
count = 162
seq_step = 1
(kms_flip:2544) DEBUG: Vblank took 25us
(kms_flip:2544) DEBUG: name = flip
last_ts = 360.901215
last_received_ts = 360.900970
last_seq = 12625
current_ts = 360.917877
current_received_ts = 360.917511
current_seq = 12626
count = 163
seq_step = 1
(kms_flip:2544) DEBUG: Vblank took 24us
(kms_flip:2544) DEBUG: name = flip
last_ts = 360.917877
last_received_ts = 360.917511
last_seq = 12626
current_ts = 360.934540
current_received_ts = 360.934387
current_seq = 12627
count = 164
seq_step = 1
(kms_flip:2544) DEBUG: Vblank took 72us
(kms_flip:2544) DEBUG: name = flip
last_ts = 360.934540
last_received_ts = 360.934387
last_seq = 12627
current_ts = 360.951233
current_received_ts = 360.950623
current_seq = 12628
count = 165
seq_step = 1
(kms_flip:2544) DEBUG: Vblank took 14us
(kms_flip:2544) DEBUG: name = flip
last_ts = 360.951233
last_received_ts = 360.950623
last_seq = 12628
current_ts = 360.967896
current_received_ts = 360.967285
current_seq = 12629
count = 166
seq_step = 1
(kms_flip:2544) DEBUG: Vblank took 11us
(kms_flip:2544) DEBUG: name = flip
last_ts = 360.967896
last_received_ts = 360.967285
last_seq = 12629
current_ts = 360.984558
current_received_ts = 360.984070
current_seq = 12630
count = 167
seq_step = 1
(kms_flip:2544) DEBUG: Vblank took 12us
(kms_flip:2544) DEBUG: name = flip
last_ts = 360.984558
last_received_ts = 360.984070
last_seq = 12630
current_ts = 361.001221
current_received_ts = 361.000610
current_seq = 12631
count = 168
seq_step = 1
(kms_flip:2544) DEBUG: Vblank took 1415us
(kms_flip:2544) CRITICAL: Test assertion failure function run_test_step, file ../tests/kms_flip.c:926:
(kms_flip:2544) CRITICAL: Failed assertion: end - start < 500
(kms_flip:2544) igt_core-INFO: Stack trace:
(kms_flip:2544) igt_core-INFO:   #0 ../lib/igt_core.c:2075 __igt_fail_assert()
(kms_flip:2544) igt_core-INFO:   #1 ../tests/kms_flip.c:921 run_test_on_crtc_set.constprop.0()
(kms_flip:2544) igt_core-INFO:   #2 ../tests/kms_flip.c:1972 run_pair()
(kms_flip:2544) igt_core-INFO:   #3 ../tests/kms_flip.c:2131 __igt_unique____real_main2043()
(kms_flip:2544) igt_core-INFO:   #4 ../tests/kms_flip.c:2043 main()
(kms_flip:2544) igt_core-INFO:   #5 [__libc_init_first+0x8a]
(kms_flip:2544) igt_core-INFO:   #6 [__libc_start_main+0x8b]
(kms_flip:2544) igt_core-INFO:   #7 [_start+0x25]
****  END  ****
Dynamic subtest BC-HDMI-A1-HDMI-A2: FAIL (4.212s)
Subtest 2x-flip-vs-expired-vblank: FAIL (25.778s)
(kms_flip:2544) igt_kms-CRITICAL: Test assertion failure function kmstest_set_connector_dpms, file ../lib/igt_kms.c:2351:
(kms_flip:2544) igt_kms-CRITICAL: Failed assertion: found_it
(kms_flip:2544) igt_kms-CRITICAL: Last errno: 9, Bad file descriptor
(kms_flip:2544) igt_kms-CRITICAL: DPMS property not found on 165
Dmesg
<6> [357.872597] [IGT] kms_flip: starting dynamic subtest BC-HDMI-A1-HDMI-A2
<7> [357.874690] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:178]
<7> [357.875028] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:182]
<7> [357.930924] i915 0000:00:02.0: [drm:drm_mode_setcrtc] [CRTC:77:pipe A]
<7> [357.931512] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:77:pipe A] fastset requirement not met in hw.enable (expected yes, found no)
<7> [357.932663] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:77:pipe A] fastset requirement not met in hw.active (expected yes, found no)
<7> [357.934286] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:77:pipe A] fastset requirement not met in cpu_transcoder (expected 0, found -1)
<7> [357.935655] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:77:pipe A] fastset requirement not met in lane_count (expected 4, found 0)
<7> [357.936083] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:77:pipe A] fastset requirement not met in lane_lat_optim_mask (expected 0x0000000d, found 0x00000000)
<7> [357.936639] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:77:pipe A] fastset requirement not met in output_types (expected 0x00000040, found 0x00000000)
<7> [357.937020] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:77:pipe A] fastset requirement not met in framestart_delay (expected 1, found 0)
<7> [357.937691] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:77:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hdisplay (expected 1920, found 0)
<7> [357.938075] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:77:pipe A] fastset requirement not met in hw.pipe_mode.crtc_htotal (expected 2200, found 0)
<7> [357.938787] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:77:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hblank_start (expected 1920, found 0)
<7> [357.939170] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:77:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hblank_end (expected 2200, found 0)
<7> [357.939828] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:77:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hsync_start (expected 2008, found 0)
<7> [357.940390] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:77:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hsync_end (expected 2052, found 0)
<7> [357.940770] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:77:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vdisplay (expected 1080, found 0)
<7> [357.941147] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:77:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vblank_start (expected 1080, found 0)
<7> [357.941698] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:77:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vsync_start (expected 1083, found 0)
<7> [357.942077] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:77:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vsync_end (expected 1088, found 0)
<7> [357.942688] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:77:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vtotal (expected 1125, found 0)
<7> [357.943069] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:77:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vblank_end (expected 1125, found 0)
<7> [357.943721] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:77:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hdisplay (expected 1920, found 0)
<7> [357.944165] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:77:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_htotal (expected 2200, found 0)
<7> [357.944765] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:77:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hblank_start (expected 1920, found 0)
<7> [357.945146] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:77:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hblank_end (expected 2200, found 0)
<7> [357.945706] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:77:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hsync_start (expected 2008, found 0)
<7> [357.946086] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:77:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hsync_end (expected 2052, found 0)
<7> [357.946721] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:77:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vdisplay (expected 1080, found 0)
<7> [357.947112] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:77:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vblank_start (expected 1080, found 0)
<7> [357.947993] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:77:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vsync_start (expected 1083, found 0)
<7> [357.948648] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:77:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vsync_end (expected 1088, found 0)
<7> [357.949031] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:77:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vtotal (expected 1125, found 0)
<7> [357.949580] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:77:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vblank_end (expected 1125, found 0)
<7> [357.949960] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:77:pipe A] fastset requirement not met in pixel_multiplier (expected 1, found 0)
<7> [357.950529] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:77:pipe A] fastset requirement not met in hw.adjusted_mode.flags (1) (expected 1, found 0)
<7> [357.950908] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:77:pipe A] fastset requirement not met in hw.adjusted_mode.flags (8) (expected 8, found 0)
<7> [357.951492] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:77:pipe A] fastset requirement not met in has_hdmi_sink (expected yes, found no)
<7> [357.951873] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:77:pipe A] fastset requirement not met in has_infoframe (expected yes, found no)
<7> [357.952592] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:77:pipe A] fastset requirement not met in pipe_bpp (expected 36, found 0)
<7> [357.953049] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:77:pipe A] fastset requirement not met in hw.pipe_mode.crtc_clock (expected 148500, found 0)
<7> [357.953640] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:77:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_clock (expected 148500, found 0)
<7> [357.954020] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:77:pipe A] fastset requirement not met in port_clock (expected 222750, found 0)
<7> [357.954576] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:77:pipe A] fastset requirement not met in infoframes.enable (expected 0x00000071, found 0x00000000)
<7> [357.954959] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:77:pipe A] fastset requirement not met in infoframes.gcp (expected 0x00000006, found 0x00000000)
<7> [357.955513] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:77:pipe A] fastset requirement not met in avi infoframe
<7> [357.955898] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] expected:
<7> [357.956738] i915 0000:00:02.0: HDMI infoframe: Auxiliary Video Information (AVI), version 2, length 13
<7> [357.956744] i915 0000:00:02.0: colorspace: RGB
<7> [357.956748] i915 0000:00:02.0: scan mode: Underscan
<7> [357.956751] i915 0000:00:02.0: colorimetry: No Data
<7> [357.956755] i915 0000:00:02.0: picture aspect: No Data
<7> [357.956758] i915 0000:00:02.0: active aspect: Same as Picture
<7> [357.956761] i915 0000:00:02.0: itc: No Data
<7> [357.956765] i915 0000:00:02.0: extended colorimetry: xvYCC 601
<7> [357.956768] i915 0000:00:02.0: quantization range: Full
<7> [357.956771] i915 0000:00:02.0: nups: Unknown Non-uniform Scaling
<7> [357.956775] i915 0000:00:02.0: video code: 0
<7> [357.956778] i915 0000:00:02.0: ycc quantization range: Full
<7> [357.956781] i915 0000:00:02.0: hdmi content type: Graphics
<7> [357.956784] i915 0000:00:02.0: pixel repeat: 0
<7> [357.956787] i915 0000:00:02.0: bar top 0, bottom 0, left 0, right 0
<7> [357.956791] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] found:
<7> [357.957556] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:77:pipe A] fastset requirement not met in spd infoframe
<7> [357.957936] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] expected:
<7> [357.958496] i915 0000:00:02.0: HDMI infoframe: Source Product Description (SPD), version 1, length 25
<7> [357.958501] i915 0000:00:02.0: vendor: Intel
<7> [357.958505] i915 0000:00:02.0: product: Integrated gfx
<7> [357.958508] i915 0000:00:02.0: source device information: PC General (0x9)
<7> [357.958512] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] found:
<7> [357.958892] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:77:pipe A] fastset requirement not met in hdmi infoframe
<7> [357.959469] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] expected:
<7> [357.959846] i915 0000:00:02.0: HDMI infoframe: Vendor, version 1, length 4
<7> [357.959852] i915 0000:00:02.0: empty frame
<7> [357.959856] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] found:
<7> [357.960440] i915 0000:00:02.0: [drm:intel_atomic_check [i915]] [CRTC:77:pipe A] fastset requirement not met, forcing full modeset
<7> [357.960822] i915 0000:00:02.0: [drm:intel_dpll_crtc_put [i915]] [CRTC:77:pipe A] releasing PORT PLL B
<7> [357.961526] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] [CRTC:77:pipe A] dbuf slices 0x1 -> 0x0, ddb (0 - 510) -> (0 - 0), active pipes 0x5 -> 0x4
<7> [357.961995] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] [CRTC:163:pipe C] dbuf slices 0x1 -> 0x1, ddb (510 - 1020) -> (0 - 1020), active pipes 0x5 -> 0x4
<7> [357.962712] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] [PLANE:71:cursor A] ddb ( 497 - 510) -> ( 0 - 0), size 13 -> 0
<7> [357.963094] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] [PLANE:157:cursor C] ddb (1007 - 1020) -> ( 988 - 1020), size 13 -> 32
<7> [357.963739] i915 0000:00:02.0: [drm:intel_cdclk_atomic_check [i915]] [CRTC:77:pipe A] min cdclk: 192000 kHz -> 0 kHz
<7> [357.964137] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [CRTC:77:pipe A] enable: no [modeset]
<7> [357.964765] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:35:plane 1A] fb: [NOFB], visible: no
<7> [357.965147] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:44:plane 2A] fb: [NOFB], visible: no
<7> [357.965987] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:53:plane 3A] fb: [NOFB], visible: no
<7> [357.966642] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:62:plane 4A] fb: [NOFB], visible: no
<7> [357.967026] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:71:cursor A] fb: [NOFB], visible: no
<7> [357.967738] i915 0000:00:02.0: [drm:intel_audio_codec_disable [i915]] [CONNECTOR:165:HDMI-A-1][ENCODER:164:DDI B/PHY B] Disable audio codec on [CRTC:77:pipe A]
<7> [357.997919] i915 0000:00:02.0: [drm:intel_audio_component_get_eld [i915]] Not valid for port B
<7> [357.999227] i915 0000:00:02.0: [drm:intel_disable_transcoder [i915]] disabling pipe A
<7> [358.010786] i915 0000:00:02.0: [drm:intel_audio_component_get_power [i915]] restored AUD_FREQ_CNTRL to 0x10
<7> [358.015271] i915 0000:00:02.0: [drm:intel_ddi_disable_transcoder_func [i915]] Quirk Increase DDI disabled time
<7> [358.116699] i915 0000:00:02.0: [drm:intel_power_well_disable [i915]] disabling DDI_IO_B
<7> [358.118898] i915 0000:00:02.0: [drm:intel_dpll_disable [i915]] disable PORT PLL B (active 0x1, on? 1) for [CRTC:77:pipe A]
<7> [358.120534] i915 0000:00:02.0: [drm:intel_dpll_disable [i915]] disabling PORT PLL B
<7> [358.122310] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:164:DDI B/PHY B]
<7> [358.122849] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:174:DDI C/PHY C]
<7> [358.123479] i915 0000:00:02.0: [drm:verify_connector_state [i915]] [CONNECTOR:165:HDMI-A-1]
<7> [358.127554] i915 0000:00:02.0: [drm:intel_power_well_disable [i915]] disabling dpio-common-b
<7> [358.128036] i915 0000:00:02.0: [drm:intel_modeset_verify_crtc [i915]] [CRTC:77:pipe A]
<7> [358.129664] i915 0000:00:02.0: [drm:drm_mode_setcrtc] [CRTC:120:pipe B]
<7> [358.130008] i915 0000:00:02.0: [drm:drm_mode_setcrtc] [CRTC:163:pipe C]
<7> [358.130165] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:163:pipe C] fastset requirement not met in hw.enable (expected yes, found no)
<7> [358.131010] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:163:pipe C] fastset requirement not met in hw.active (expected yes, found no)
<7> [358.131603] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:163:pipe C] fastset requirement not met in cpu_transcoder (expected 2, found -1)
<7> [358.131986] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:163:pipe C] fastset requirement not met in lane_count (expected 4, found 0)
<7> [358.132622] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:163:pipe C] fastset requirement not met in lane_lat_optim_mask (expected 0x0000000d, found 0x00000000)
<7> [358.133003] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:163:pipe C] fastset requirement not met in output_types (expected 0x00000040, found 0x00000000)
<7> [358.134054] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:163:pipe C] fastset requirement not met in framestart_delay (expected 1, found 0)
<7> [358.134497] azx_init_pci: snd_hda_intel 0000:00:0e.0: Clearing TCSEL
<7> [358.134513] azx_init_pci: snd_hda_intel 0000:00:0e.0: SCH snoop: Enabled
<7> [358.134713] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:163:pipe C] fastset requirement not met in hw.pipe_mode.crtc_hdisplay (expected 1920, found 0)
<7> [358.135095] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:163:pipe C] fastset requirement not met in hw.pipe_mode.crtc_htotal (expected 2200, found 0)
<7> [358.135712] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:163:pipe C] fastset requirement not met in hw.pipe_mode.crtc_hblank_start (expected 1920, found 0)
<7> [358.136113] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:163:pipe C] fastset requirement not met in hw.pipe_mode.crtc_hblank_end (expected 2200, found 0)
<7> [358.136708] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:163:pipe C] fastset requirement not met in hw.pipe_mode.crtc_hsync_start (expected 2008, found 0)
<7> [358.137091] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:163:pipe C] fastset requirement not met in hw.pipe_mode.crtc_hsync_end (expected 2052, found 0)
<7> [358.137725] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:163:pipe C] fastset requirement not met in hw.pipe_mode.crtc_vdisplay (expected 1080, found 0)
<7> [358.138471] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:163:pipe C] fastset requirement not met in hw.pipe_mode.crtc_vblank_start (expected 1080, found 0)
<7> [358.138865] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:163:pipe C] fastset requirement not met in hw.pipe_mode.crtc_vsync_start (expected 1083, found 0)
<7> [358.139430] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:163:pipe C] fastset requirement not met in hw.pipe_mode.crtc_vsync_end (expected 1088, found 0)
<7> [358.139813] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:163:pipe C] fastset requirement not met in hw.pipe_mode.crtc_vtotal (expected 1125, found 0)
<7> [358.140380] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:163:pipe C] fastset requirement not met in hw.pipe_mode.crtc_vblank_end (expected 1125, found 0)
<7> [358.140759] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:163:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_hdisplay (expected 1920, found 0)
<7> [358.141136] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:163:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_htotal (expected 2200, found 0)
<7> [358.142091] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:163:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_hblank_start (expected 1920, found 0)
<7> [358.142701] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:163:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_hblank_end (expected 2200, found 0)
<7> [358.143084] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:163:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_hsync_start (expected 2008, found 0)
<7> [358.143780] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:163:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_hsync_end (expected 2052, found 0)
<7> [358.144388] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:163:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_vdisplay (expected 1080, found 0)
<7> [358.144771] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:163:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_vblank_start (expected 1080, found 0)
<7> [358.145146] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:163:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_vsync_start (expected 1083, found 0)
<7> [358.145776] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:163:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_vsync_end (expected 1088, found 0)
<7> [358.146158] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:163:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_vtotal (expected 1125, found 0)
<7> [358.146794] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:163:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_vblank_end (expected 1125, found 0)
<7> [358.147429] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:163:pipe C] fastset requirement not met in pixel_multiplier (expected 1, found 0)
<7> [358.147816] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:163:pipe C] fastset requirement not met in hw.adjusted_mode.flags (1) (expected 1, found 0)
<7> [358.148381] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:163:pipe C] fastset requirement not met in hw.adjusted_mode.flags (8) (expected 8, found 0)
<7> [358.148762] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:163:pipe C] fastset requirement not met in has_hdmi_sink (expected yes, found no)
<7> [358.149142] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:163:pipe C] fastset requirement not met in has_infoframe (expected yes, found no)
<7> [358.149697] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:163:pipe C] fastset requirement not met in pipe_bpp (expected 36, found 0)
<7> [358.150080] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:163:pipe C] fastset requirement not met in hw.pipe_mode.crtc_clock (expected 148500, found 0)
<7> [358.150652] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:163:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_clock (expected 148500, found 0)
<7> [358.151032] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:163:pipe C] fastset requirement not met in port_clock (expected 222750, found 0)
<7> [358.151766] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:163:pipe C] fastset requirement not met in infoframes.enable (expected 0x00000071, found 0x00000000)
<7> [358.152150] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:163:pipe C] fastset requirement not met in infoframes.gcp (expected 0x00000006, found 0x00000000)
<7> [358.152817] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:163:pipe C] fastset requirement not met in avi infoframe
<7> [358.153367] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] expected:
<7> [358.153747] i915 0000:00:02.0: HDMI infoframe: Auxiliary Video Information (AVI), version 2, length 13
<7> [358.153752] i915 0000:00:02.0: colorspace: RGB
<7> [358.153756] i915 0000:00:02.0: scan mode: Underscan
<7> [358.153760] i915 0000:00:02.0: colorimetry: No Data
<7> [358.153763] i915 0000:00:02.0: picture aspect: No Data
<7> [358.153767] i915 0000:00:02.0: active aspect: Same as Picture
<7> [358.153771] i915 0000:00:02.0: itc: No Data
<7> [358.153774] i915 0000:00:02.0: extended colorimetry: xvYCC 601
<7> [358.153778] i915 0000:00:02.0: quantization range: Full
<7> [358.153781] i915 0000:00:02.0: nups: Unknown Non-uniform Scaling
<7> [358.153784] i915 0000:00:02.0: video code: 0
<7> [358.153787] i915 0000:00:02.0: ycc quantization range: Full
<7> [358.153791] i915 0000:00:02.0: hdmi content type: Graphics
<7> [358.153794] i915 0000:00:02.0: pixel repeat: 0
<7> [358.153797] i915 0000:00:02.0: bar top 0, bottom 0, left 0, right 0
<7> [358.153801] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] found:
<7> [358.154178] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:163:pipe C] fastset requirement not met in spd infoframe
<7> [358.154849] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] expected:
<7> [358.155425] i915 0000:00:02.0: HDMI infoframe: Source Product Description (SPD), version 1, length 25
<7> [358.155430] i915 0000:00:02.0: vendor: Intel
<7> [358.155434] i915 0000:00:02.0: product: Integrated gfx
<7> [358.155437] i915 0000:00:02.0: source device information: PC General (0x9)
<7> [358.155441] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] found:
<7> [358.155819] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:163:pipe C] fastset requirement not met in hdmi infoframe
<7> [358.156542] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] expected:
<7> [358.157005] i915 0000:00:02.0: HDMI infoframe: Vendor, version 1, length 4
<7> [358.157010] i915 0000:00:02.0: empty frame
<7> [358.157014] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] found:
<7> [358.157616] i915 0000:00:02.0: [drm:intel_atomic_check [i915]] [CRTC:163:pipe C] fastset requirement not met, forcing full modeset
<7> [358.158001] i915 0000:00:02.0: [drm:intel_dpll_crtc_put [i915]] [CRTC:163:pipe C] releasing PORT PLL C
<7> [358.158618] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] [CRTC:163:pipe C] dbuf slices 0x1 -> 0x0, ddb (0 - 1020) -> (0 - 0), active pipes 0x4 -> 0x0
<7> [358.159058] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] [PLANE:157:cursor C] ddb ( 988 - 1020) -> ( 0 - 0), size 32 -> 0
<7> [358.159710] i915 0000:00:02.0: [drm:intel_cdclk_atomic_check [i915]] [CRTC:163:pipe C] min cdclk: 192000 kHz -> 0 kHz
<7> [358.160111] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [CRTC:163:pipe C] enable: no [modeset]
<7> [358.160912] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:121:plane 1C] fb: [NOFB], visible: no
<7> [358.161609] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:130:plane 2C] fb: [NOFB], visible: no
<7> [358.161991] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:139:plane 3C] fb: [NOFB], visible: no
<7> [358.162556] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:148:plane 4C] fb: [NOFB], visible: no
<7> [358.162935] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:157:cursor C] fb: [NOFB], visible: no
<7> [358.163612] i915 0000:00:02.0: [drm:intel_audio_codec_disable [i915]] [CONNECTOR:175:HDMI-A-2][ENCODER:174:DDI C/PHY C] Disable audio codec on [CRTC:163:pipe C]
<7> [358.194211] i915 0000:00:02.0: [drm:intel_audio_component_get_eld [i915]] Not valid for port C
<7> [358.194833] i915 0000:00:02.0: [drm:intel_disable_transcoder [i915]] disabling pipe C
<7> [358.211267] i915 0000:00:02.0: [drm:intel_ddi_disable_transcoder_func [i915]] Quirk Increase DDI disabled time
<7> [358.316693] i915 0000:00:02.0: [drm:intel_power_well_disable [i915]] disabling DDI_IO_C
<7> [358.317901] i915 0000:00:02.0: [drm:intel_dpll_disable [i915]] disable PORT PLL C (active 0x4, on? 1) for [CRTC:163:pipe C]
<7> [358.319849] i915 0000:00:02.0: [drm:intel_dpll_disable [i915]] disabling PORT PLL C
<7> [358.320454] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:164:DDI B/PHY B]
<7> [358.320837] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:174:DDI C/PHY C]
<7> [358.321435] i915 0000:00:02.0: [drm:verify_connector_state [i915]] [CONNECTOR:175:HDMI-A-2]
<7> [358.322037] i915 0000:00:02.0: [drm:intel_power_well_disable [i915]] disabling dpio-common-c
<7> [358.322860] i915 0000:00:02.0: [drm:intel_modeset_verify_crtc [i915]] [CRTC:163:pipe C]
<7> [358.324514] i915 0000:00:02.0: [drm:intel_cdclk_atomic_check [i915]] Modeset required for cdclk change
<7> [358.324949] i915 0000:00:02.0: [drm:intel_cdclk_atomic_check [i915]] New cdclk calculated to be logical 79200 kHz, actual 79200 kHz
<7> [358.325355] i915 0000:00:02.0: [drm:intel_cdclk_atomic_check [i915]] New voltage level calculated to be logical 4, actual 4
<7> [358.325845] i915 0000:00:02.0: [drm:intel_set_cdclk [i915]] Pre changing CDCLK to 79200 kHz, VCO 633600 kHz, ref 19200 kHz, bypass 19200 kHz, voltage level 4
<7> [358.326918] i915 0000:00:02.0: [drm:drm_mode_setcrtc] [CRTC:163:pipe C]
<7> [358.326989] i915 0000:00:02.0: [drm:drm_mode_setcrtc] [CONNECTOR:175:HDMI-A-2]
<7> [358.327972] i915 0000:00:02.0: [drm:intel_hdmi_compute_clock [i915]] picking 12 bpc for HDMI output (pipe bpp: 36)
<7> [358.328525] i915 0000:00:02.0: [drm:intel_atomic_check [i915]] [CRTC:163:pipe C] hw max bpp: 36, pipe bpp: 36, dithering: 0
<7> [358.328909] i915 0000:00:02.0: [drm:intel_ddi_compute_config_late [i915]] [ENCODER:174:DDI C/PHY C] [CRTC:163:pipe C]
<7> [358.329527] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:163:pipe C] fastset requirement not met in hw.enable (expected no, found yes)
<7> [358.329910] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:163:pipe C] fastset requirement not met in hw.active (expected no, found yes)
<7> [358.330704] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:163:pipe C] fastset requirement not met in cpu_transcoder (expected -1, found 2)
<7> [358.331453] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:163:pipe C] fastset requirement not met in lane_count (expected 0, found 4)
<7> [358.331835] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:163:pipe C] fastset requirement not met in lane_lat_optim_mask (expected 0x00000000, found 0x0000000d)
<7> [358.332408] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:163:pipe C] fastset requirement not met in output_types (expected 0x00000000, found 0x00000040)
<7> [358.332790] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:163:pipe C] fastset requirement not met in framestart_delay (expected 0, found 1)
<7> [358.333166] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:163:pipe C] fastset requirement not met in hw.pipe_mode.crtc_hdisplay (expected 0, found 1920)
<7> [358.333727] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:163:pipe C] fastset requirement not met in hw.pipe_mode.crtc_htotal (expected 0, found 2200)
<7> [358.334106] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:163:pipe C] fastset requirement not met in hw.pipe_mode.crtc_hblank_start (expected 0, found 1920)
<7> [358.334884] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:163:pipe C] fastset requirement not met in hw.pipe_mode.crtc_hblank_end (expected 0, found 2200)
<7> [358.335542] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:163:pipe C] fastset requirement not met in hw.pipe_mode.crtc_hsync_start (expected 0, found 2008)
<7> [358.335925] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:163:pipe C] fastset requirement not met in hw.pipe_mode.crtc_hsync_end (expected 0, found 2052)
<7> [358.336475] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:163:pipe C] fastset requirement not met in hw.pipe_mode.crtc_vdisplay (expected 0, found 1080)
<7> [358.336860] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:163:pipe C] fastset requirement not met in hw.pipe_mode.crtc_vblank_start (expected 0, found 1080)
<7> [358.337422] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:163:pipe C] fastset requirement not met in hw.pipe_mode.crtc_vsync_start (expected 0, found 1083)
<7> [358.337801] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:163:pipe C] fastset requirement not met in hw.pipe_mode.crtc_vsync_end (expected 0, found 1088)
<7> [358.338178] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:163:pipe C] fastset requirement not met in hw.pipe_mode.crtc_vtotal (expected 0, found 1125)
<7> [358.338776] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:163:pipe C] fastset requirement not met in hw.pipe_mode.crtc_vblank_end (expected 0, found 1125)
<7> [358.339156] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:163:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_hdisplay (expected 0, found 1920)
<7> [358.340094] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:163:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_htotal (expected 0, found 2200)
<7> [358.340858] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:163:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_hblank_start (expected 0, found 1920)
<7> [358.341524] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:163:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_hblank_end (expected 0, found 2200)
<7> [358.341909] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:163:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_hsync_start (expected 0, found 2008)
<7> [358.342575] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:163:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_hsync_end (expected 0, found 2052)
<7> [358.342964] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:163:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_vdisplay (expected 0, found 1080)
<7> [358.343702] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:163:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_vblank_start (expected 0, found 1080)
<7> [358.344087] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:163:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_vsync_start (expected 0, found 1083)
<7> [358.344764] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:163:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_vsync_end (expected 0, found 1088)
<7> [358.345146] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:163:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_vtotal (expected 0, found 1125)
<7> [358.345730] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:163:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_vblank_end (expected 0, found 1125)
<7> [358.346114] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:163:pipe C] fastset requirement not met in pixel_multiplier (expected 0, found 1)
<7> [358.346662] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:163:pipe C] fastset requirement not met in hw.adjusted_mode.flags (1) (expected 0, found 1)
<7> [358.347041] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:163:pipe C] fastset requirement not met in hw.adjusted_mode.flags (8) (expected 0, found 8)
<7> [358.347634] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:163:pipe C] fastset requirement not met in has_hdmi_sink (expected no, found yes)
<7> [358.348017] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:163:pipe C] fastset requirement not met in has_infoframe (expected no, found yes)
<7> [358.348678] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:163:pipe C] fastset requirement not met in pipe_bpp (expected 0, found 36)
<7> [358.349135] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:163:pipe C] fastset requirement not met in hw.pipe_mode.crtc_clock (expected 0, found 148500)
<7> [358.349714] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:163:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_clock (expected 0, found 148500)
<7> [358.350094] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:163:pipe C] fastset requirement not met in port_clock (expected 0, found 222750)
<7> [358.350663] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:163:pipe C] fastset requirement not met in infoframes.enable (expected 0x00000000, found 0x00000071)
<7> [358.351046] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:163:pipe C] fastset requirement not met in infoframes.gcp (expected 0x00000000, found 0x00000006)
<7> [358.351651] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:163:pipe C] fastset requirement not met in avi infoframe
<7> [358.352032] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] expected:
<7> [358.352872] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] found:
<7> [358.353515] i915 0000:00:02.0: HDMI infoframe: Auxiliary Video Information (AVI), version 2, length 13
<7> [358.353521] i915 0000:00:02.0: colorspace: RGB
<7> [358.353525] i915 0000:00:02.0: scan mode: Underscan
<7> [358.353528] i915 0000:00:02.0: colorimetry: No Data
<7> [358.353532] i915 0000:00:02.0: picture aspect: No Data
<7> [358.353535] i915 0000:00:02.0: active aspect: Same as Picture
<7> [358.353539] i915 0000:00:02.0: itc: No Data
<7> [358.353542] i915 0000:00:02.0: extended colorimetry: xvYCC 601
<7> [358.353546] i915 0000:00:02.0: quantization range: Full
<7> [358.353549] i915 0000:00:02.0: nups: Unknown Non-uniform Scaling
<7> [358.353552] i915 0000:00:02.0: video code: 0
<7> [358.353555] i915 0000:00:02.0: ycc quantization range: Full
<7> [358.353559] i915 0000:00:02.0: hdmi content type: Graphics
<7> [358.353562] i915 0000:00:02.0: pixel repeat: 0
<7> [358.353565] i915 0000:00:02.0: bar top 0, bottom 0, left 0, right 0
<7> [358.353570] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:163:pipe C] fastset requirement not met in spd infoframe
<7> [358.353949] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] expected:
<7> [358.354562] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] found:
<7> [358.354941] i915 0000:00:02.0: HDMI infoframe: Source Product Description (SPD), version 1, length 25
<7> [358.354945] i915 0000:00:02.0: vendor: Intel
<7> [358.354949] i915 0000:00:02.0: product: Integrated gfx
<7> [358.354952] i915 0000:00:02.0: source device information: PC General (0x9)
<7> [358.354956] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:163:pipe C] fastset requirement not met in hdmi infoframe
<7> [358.355519] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] expected:
<7> [358.355896] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] found:
<7> [358.356506] i915 0000:00:02.0: HDMI infoframe: Vendor, version 1, length 4
<7> [358.356511] i915 0000:00:02.0: empty frame
<7> [358.356516] i915 0000:00:02.0: [drm:intel_atomic_check [i915]] [CRTC:163:pipe C] fastset requirement not met, forcing full modeset
<7> [358.356979] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] [CRTC:163:pipe C] dbuf slices 0x0 -> 0x1, ddb (0 - 0) -> (0 - 1020), active pipes 0x0 -> 0x4
<7> [358.357826] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] [PLANE:121:plane 1C] ddb ( 0 - 0) -> ( 0 - 988), size 0 -> 988
<7> [358.358526] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] [PLANE:157:cursor C] ddb ( 0 - 0) -> ( 988 - 1020), size 0 -> 32
<7> [358.358903] i915 0000:00:02.0: [drm:skl_print_plane_changes [i915]] [PLANE:121: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> [358.359451] i915 0000:00:02.0: [drm:skl_print_plane_changes [i915]] [PLANE:121:plane 1C] lines 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0 -> 1, 1, 1, 2, 2, 2, 2, 2, 0, 0, 0
<7> [358.359826] i915 0000:00:02.0: [drm:skl_print_plane_changes [i915]] [PLANE:121:plane 1C] blocks 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0 -> 16, 16, 16, 33, 33, 33, 33, 33, 30, 0, 0
<7> [358.360388] i915 0000:00:02.0: [drm:skl_print_plane_changes [i915]] [PLANE:121:plane 1C] min_ddb 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0 -> 17, 17, 17, 34, 34, 34, 34, 34, 31, 0, 0
<7> [358.360862] i915 0000:00:02.0: [drm:intel_cdclk_atomic_check [i915]] [CRTC:163:pipe C] min cdclk: 0 kHz -> 192000 kHz
<7> [358.361461] i915 0000:00:02.0: [drm:intel_cdclk_update_dbuf_bw_min_cdclk [i915]] dbuf bandwidth min cdclk: 18563 kHz -> 9282 kHz
<7> [358.361893] i915 0000:00:02.0: [drm:intel_cdclk_atomic_check [i915]] Modeset required for cdclk change
<7> [358.362456] i915 0000:00:02.0: [drm:intel_cdclk_atomic_check [i915]] New cdclk calculated to be logical 316800 kHz, actual 316800 kHz
<7> [358.362834] i915 0000:00:02.0: [drm:intel_cdclk_atomic_check [i915]] New voltage level calculated to be logical 13, actual 13
<7> [358.363690] i915 0000:00:02.0: [drm:bxt_get_dpll [i915]] [CRTC:163:pipe C] using pre-allocated PORT PLL C
<7> [358.364084] i915 0000:00:02.0: [drm:intel_dpll_crtc_get [i915]] [CRTC:163:pipe C] reserving PORT PLL C
<7> [358.364756] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [CRTC:163:pipe C] enable: yes [modeset]
<7> [358.365140] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] active: yes, output_types: HDMI (0x40), output format: RGB, sink format: RGB
<7> [358.365689] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] cpu_transcoder: C, pipe bpp: 36, dithering: 0
<7> [358.366071] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] MST master transcoder: <invalid>
<7> [358.366632] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] port sync: master transcoder: <invalid>, slave transcoder bitmask = 0x0
<7> [358.367012] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] joiner: no, pipes: 0x0
<7> [358.367594] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] splitter: disabled, link count 0, overlap 0
<7> [358.367976] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] audio: 1, infoframes: 1, infoframes enabled: 0x71
<7> [358.368639] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] GCP: 0x6
<7> [358.369091] i915 0000:00:02.0: HDMI infoframe: Auxiliary Video Information (AVI), version 2, length 13
<7> [358.369097] i915 0000:00:02.0: colorspace: RGB
<7> [358.369101] i915 0000:00:02.0: scan mode: Underscan
<7> [358.369104] i915 0000:00:02.0: colorimetry: No Data
<7> [358.369108] i915 0000:00:02.0: picture aspect: No Data
<7> [358.369111] i915 0000:00:02.0: active aspect: Same as Picture
<7> [358.369114] i915 0000:00:02.0: itc: No Data
<7> [358.369118] i915 0000:00:02.0: extended colorimetry: xvYCC 601
<7> [358.369122] i915 0000:00:02.0: quantization range: Full
<7> [358.369125] i915 0000:00:02.0: nups: Unknown Non-uniform Scaling
<7> [358.369128] i915 0000:00:02.0: video code: 0
<7> [358.369131] i915 0000:00:02.0: ycc quantization range: Full
<7> [358.369134] i915 0000:00:02.0: hdmi content type: Graphics
<7> [358.369138] i915 0000:00:02.0: pixel repeat: 0
<7> [358.369141] i915 0000:00:02.0: bar top 0, bottom 0, left 0, right 0
<7> [358.369144] i915 0000:00:02.0: HDMI infoframe: Source Product Description (SPD), version 1, length 25
<7> [358.369148] i915 0000:00:02.0: vendor: Intel
<7> [358.369151] i915 0000:00:02.0: product: Integrated gfx
<7> [358.369155] i915 0000:00:02.0: source device information: PC General (0x9)
<7> [358.369159] i915 0000:00:02.0: HDMI infoframe: Vendor, version 1, length 4
<7> [358.369163] i915 0000:00:02.0: empty frame
<7> [358.369167] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] ELD: 10 00 07 00 66 10 00 01 00 00 00 00 00 00 00 00
<7> [358.369938] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] ELD: 05 e3 cd 0c 32 38 45 38 35 30 09 07 07 00 00 00
<7> [358.370494] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] scanline offset: 2
<7> [358.370877] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] framestart delay: 1, MSA timing delay: 0, set context latency: 0
<7> [358.371432] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] vrr: no, fixed rr: no, vmin: 0, vmax: 0, flipline: 0, pipeline full: 0, guardband: 0 vsync start: 0, vsync end: 0
<7> [358.371815] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] vrr: vmin vblank: 0, vmax vblank: 0, vmin vtotal: 0, vmax vtotal: 0
<7> [358.372454] 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> [358.372837] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] requested mode: "1920x1080": 60 148500 1920 2008 2052 2200 1080 1083 1088 1125 0x48 0x9
<7> [358.373527] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] adjusted mode: "1920x1080": 60 148500 1920 2008 2052 2200 1080 1083 1088 1125 0x48 0x9
<7> [358.373917] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] crtc timings: clock=148500, hd=1920 hb=1920-2200 hs=2008-2052 ht=2200, vd=1080 vb=1080-1125 vs=1083-1088 vt=1125, flags=0x9
<7> [358.374608] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pipe mode: "1920x1080": 60 148500 1920 2008 2052 2200 1080 1083 1088 1125 0x40 0x9
<7> [358.374988] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] crtc timings: clock=148500, hd=1920 hb=1920-2200 hs=2008-2052 ht=2200, vd=1080 vb=1080-1125 vs=1083-1088 vt=1125, flags=0x9
<7> [358.375590] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] port clock: 222750, pipe src: 1920x1080+0+0, pixel rate 148500, min cdclk 192000
<7> [358.375972] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] linetime: 59, ips linetime: 0
<7> [358.376528] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] num_scalers: 1, scaler_users: 0x0, scaler_id: -1, scaling_filter: 0
<7> [358.376911] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pch pfit: 0x0+0+0, disabled, force thru: no
<7> [358.377527] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] ips: 0, double wide: 0, drrs: 0
<7> [358.377908] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] dpll_hw_state: ebb0: 0x6200, ebb4: 0x2000,pll0: 0x21, pll1: 0x100, pll2: 0x1a6666, pll3: 0x10000, pll6: 0x30904, pll8: 0x8, pll9: 0xa, pll10: 0x8003c00, pcsdw12: 0x4d
<7> [358.378558] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] csc_mode: 0x0 gamma_mode: 0x0 gamma_enable: 0 csc_enable: 0
<7> [358.378990] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pre csc lut: 0 entries, post csc lut: 0 entries
<7> [358.379591] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pipe csc: pre offsets: 0x0000 0x0000 0x0000
<7> [358.379972] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pipe csc: coefficients: 0x0000 0x0000 0x0000
<7> [358.380517] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pipe csc: coefficients: 0x0000 0x0000 0x0000
<7> [358.380894] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pipe csc: coefficients: 0x0000 0x0000 0x0000
<7> [358.381353] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pipe csc: post offsets: 0x0000 0x0000 0x0000
<7> [358.381731] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] sharpness strength: 0, sharpness tap size: 0, sharpness enable: 0
<7> [358.382107] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:121:plane 1C] fb: [FB:178] 1920x1080 format = XR24 little-endian (0x34325258) modifier = 0x100000000000001, visible: yes
<7> [358.382974] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] rotation: 0x1, scaler: -1, scaling_filter: 0
<7> [358.383626] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] src: 1920.000000x1080.000000+0.000000+0.000000 dst: 1920x1080+0+0
<7> [358.384007] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:130:plane 2C] fb: [NOFB], visible: no
<7> [358.384556] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:139:plane 3C] fb: [NOFB], visible: no
<7> [358.384937] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:148:plane 4C] fb: [NOFB], visible: no
<7> [358.385503] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:157:cursor C] fb: [NOFB], visible: no
<7> [358.386771] i915 0000:00:02.0: [drm:intel_power_well_enable [i915]] enabling dpio-common-c
<7> [358.387774] i915 0000:00:02.0: [drm:intel_set_cdclk [i915]] Pre changing CDCLK to 316800 kHz, VCO 633600 kHz, ref 19200 kHz, bypass 19200 kHz, voltage level 13
<7> [358.388337] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:164:DDI B/PHY B]
<7> [358.388720] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:174:DDI C/PHY C]
<7> [358.389535] i915 0000:00:02.0: [drm:intel_dpll_enable [i915]] enable PORT PLL C (active 0x4, on? 0) for [CRTC:163:pipe C]
<7> [358.389926] i915 0000:00:02.0: [drm:intel_dpll_enable [i915]] enabling PORT PLL C
<7> [358.390709] i915 0000:00:02.0: [drm:intel_power_well_enable [i915]] enabling DDI_IO_C
<7> [358.391556] i915 0000:00:02.0: [drm:intel_enable_transcoder [i915]] enabling pipe C
<7> [358.409342] i915 0000:00:02.0: [drm:intel_audio_codec_enable [i915]] [CONNECTOR:175:HDMI-A-2][ENCODER:174:DDI C/PHY C] Enable audio codec on [CRTC:163:pipe C], 32 bytes ELD
<7> [358.426045] i915 0000:00:02.0: [drm:audio_config_hdmi_pixel_clock [i915]] Configuring HDMI audio for pixel clock 148500 (0x00090000)
<7> [358.426551] i915 0000:00:02.0: [drm:hsw_audio_config_update [i915]] using automatic N
<7> [358.427124] i915 0000:00:02.0: [drm:verify_connector_state [i915]] [CONNECTOR:175:HDMI-A-2]
<7> [358.429265] i915 0000:00:02.0: [drm:intel_modeset_verify_crtc [i915]] [CRTC:163:pipe C]
<7> [358.432615] i915 0000:00:02.0: [drm:drm_mode_setcrtc] [CRTC:120:pipe B]
<7> [358.432676] i915 0000:00:02.0: [drm:drm_mode_setcrtc] [CONNECTOR:165:HDMI-A-1]
<7> [358.432866] i915 0000:00:02.0: [drm:intel_hdmi_compute_clock [i915]] picking 12 bpc for HDMI output (pipe bpp: 36)
<7> [358.433574] i915 0000:00:02.0: [drm:intel_atomic_check [i915]] [CRTC:120:pipe B] hw max bpp: 36, pipe bpp: 36, dithering: 0
<7> [358.433958] i915 0000:00:02.0: [drm:intel_ddi_compute_config_late [i915]] [ENCODER:164:DDI B/PHY B] [CRTC:120:pipe B]
<7> [358.434569] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:120:pipe B] fastset requirement not met in hw.enable (expected no, found yes)
<7> [358.434951] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:120:pipe B] fastset requirement not met in hw.active (expected no, found yes)
<7> [358.435657] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:120:pipe B] fastset requirement not met in cpu_transcoder (expected -1, found 1)
<7> [358.436037] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:120:pipe B] fastset requirement not met in lane_count (expected 0, found 4)
<7> [358.438242] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:120:pipe B] fastset requirement not met in lane_lat_optim_mask (expected 0x00000000, found 0x0000000d)
<7> [358.438737] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:120:pipe B] fastset requirement not met in output_types (expected 0x00000000, found 0x00000040)
<7> [358.439112] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:120:pipe B] fastset requirement not met in framestart_delay (expected 0, found 1)
<7> [358.440020] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:120:pipe B] fastset requirement not met in hw.pipe_mode.crtc_hdisplay (expected 0, found 1920)
<7> [358.440791] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:120:pipe B] fastset requirement not met in hw.pipe_mode.crtc_htotal (expected 0, found 2200)
<7> [358.441173] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:120:pipe B] fastset requirement not met in hw.pipe_mode.crtc_hblank_start (expected 0, found 1920)
<7> [358.441844] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:120:pipe B] fastset requirement not met in hw.pipe_mode.crtc_hblank_end (expected 0, found 2200)
<7> [358.442462] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:120:pipe B] fastset requirement not met in hw.pipe_mode.crtc_hsync_start (expected 0, found 2008)
<7> [358.442882] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:120:pipe B] fastset requirement not met in hw.pipe_mode.crtc_hsync_end (expected 0, found 2052)
<7> [358.443428] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:120:pipe B] fastset requirement not met in hw.pipe_mode.crtc_vdisplay (expected 0, found 1080)
<7> [358.443809] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:120:pipe B] fastset requirement not met in hw.pipe_mode.crtc_vblank_start (expected 0, found 1080)
<7> [358.446526] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:120:pipe B] fastset requirement not met in hw.pipe_mode.crtc_vsync_start (expected 0, found 1083)
<7> [358.447015] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:120:pipe B] fastset requirement not met in hw.pipe_mode.crtc_vsync_end (expected 0, found 1088)
<7> [358.447782] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:120:pipe B] fastset requirement not met in hw.pipe_mode.crtc_vtotal (expected 0, found 1125)
<7> [358.448163] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:120:pipe B] fastset requirement not met in hw.pipe_mode.crtc_vblank_end (expected 0, found 1125)
<7> [358.448956] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:120:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_hdisplay (expected 0, found 1920)
<7> [358.449591] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:120:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_htotal (expected 0, found 2200)
<7> [358.449973] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:120:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_hblank_start (expected 0, found 1920)
<7> [358.450566] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:120:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_hblank_end (expected 0, found 2200)
<7> [358.450945] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:120:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_hsync_start (expected 0, found 2008)
<7> [358.451513] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:120:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_hsync_end (expected 0, found 2052)
<7> [358.451892] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:120:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_vdisplay (expected 0, found 1080)
<7> [358.454251] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:120:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_vblank_start (expected 0, found 1080)
<7> [358.454739] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:120:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_vsync_start (expected 0, found 1083)
<7> [358.455115] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:120:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_vsync_end (expected 0, found 1088)
<7> [358.455757] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:120:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_vtotal (expected 0, found 1125)
<7> [358.456136] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:120:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_vblank_end (expected 0, found 1125)
<7> [358.457081] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:120:pipe B] fastset requirement not met in pixel_multiplier (expected 0, found 1)
<7> [358.457828] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:120:pipe B] fastset requirement not met in hw.adjusted_mode.flags (1) (expected 0, found 1)
<7> [358.458461] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:120:pipe B] fastset requirement not met in hw.adjusted_mode.flags (8) (expected 0, found 8)
<7> [358.458842] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:120:pipe B] fastset requirement not met in has_hdmi_sink (expected no, found yes)
<7> [358.459403] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:120:pipe B] fastset requirement not met in has_infoframe (expected no, found yes)
<7> [358.459787] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:120:pipe B] fastset requirement not met in pipe_bpp (expected 0, found 36)
<7> [358.460165] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:120:pipe B] fastset requirement not met in hw.pipe_mode.crtc_clock (expected 0, found 148500)
<7> [358.460719] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:120:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_clock (expected 0, found 148500)
<7> [358.461098] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:120:pipe B] fastset requirement not met in port_clock (expected 0, found 222750)
<7> [358.463251] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:120:pipe B] fastset requirement not met in infoframes.enable (expected 0x00000000, found 0x00000071)
<7> [358.463742] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:120:pipe B] fastset requirement not met in infoframes.gcp (expected 0x00000000, found 0x00000006)
<7> [358.464118] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:120:pipe B] fastset requirement not met in avi infoframe
<7> [358.465390] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] expected:
<7> [358.465780] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] found:
<7> [358.466153] i915 0000:00:02.0: HDMI infoframe: Auxiliary Video Information (AVI), version 2, length 13
<7> [358.466158] i915 0000:00:02.0: colorspace: RGB
<7> [358.466162] i915 0000:00:02.0: scan mode: Underscan
<7> [358.466166] i915 0000:00:02.0: colorimetry: No Data
<7> [358.466169] i915 0000:00:02.0: picture aspect: No Data
<7> [358.466172] i915 0000:00:02.0: active aspect: Same as Picture
<7> [358.466175] i915 0000:00:02.0: itc: No Data
<7> [358.466651] i915 0000:00:02.0: extended colorimetry: xvYCC 601
<7> [358.466657] i915 0000:00:02.0: quantization range: Full
<7> [358.466660] i915 0000:00:02.0: nups: Unknown Non-uniform Scaling
<7> [358.466663] i915 0000:00:02.0: video code: 0
<7> [358.466667] i915 0000:00:02.0: ycc quantization range: Full
<7> [358.466670] i915 0000:00:02.0: hdmi content type: Graphics
<7> [358.466673] i915 0000:00:02.0: pixel repeat: 0
<7> [358.466676] i915 0000:00:02.0: bar top 0, bottom 0, left 0, right 0
<7> [358.466681] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:120:pipe B] fastset requirement not met in spd infoframe
<7> [358.467062] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] expected:
<7> [358.467854] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] found:
<7> [358.468417] i915 0000:00:02.0: HDMI infoframe: Source Product Description (SPD), version 1, length 25
<7> [358.468422] i915 0000:00:02.0: vendor: Intel
<7> [358.468426] i915 0000:00:02.0: product: Integrated gfx
<7> [358.468429] i915 0000:00:02.0: source device information: PC General (0x9)
<7> [358.468433] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:120:pipe B] fastset requirement not met in hdmi infoframe
<7> [358.468812] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] expected:
<7> [358.469373] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] found:
<7> [358.469751] i915 0000:00:02.0: HDMI infoframe: Vendor, version 1, length 4
<7> [358.469755] i915 0000:00:02.0: empty frame
<7> [358.469761] i915 0000:00:02.0: [drm:intel_atomic_check [i915]] [CRTC:120:pipe B] fastset requirement not met, forcing full modeset
<7> [358.472258] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] [CRTC:120:pipe B] dbuf slices 0x0 -> 0x1, ddb (0 - 0) -> (0 - 510), active pipes 0x4 -> 0x6
<7> [358.472774] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] [CRTC:163:pipe C] dbuf slices 0x1 -> 0x1, ddb (0 - 1020) -> (510 - 1020), active pipes 0x4 -> 0x6
<7> [358.473517] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] [PLANE:78:plane 1B] ddb ( 0 - 0) -> ( 0 - 497), size 0 -> 497
<7> [358.473891] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] [PLANE:114:cursor B] ddb ( 0 - 0) -> ( 497 - 510), size 0 -> 13
<7> [358.475342] i915 0000:00:02.0: [drm:skl_print_plane_changes [i915]] [PLANE:78: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> [358.475726] i915 0000:00:02.0: [drm:skl_print_plane_changes [i915]] [PLANE:78:plane 1B] lines 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0 -> 1, 1, 1, 2, 2, 2, 2, 2, 0, 0, 0
<7> [358.476097] i915 0000:00:02.0: [drm:skl_print_plane_changes [i915]] [PLANE:78:plane 1B] blocks 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0 -> 16, 16, 16, 33, 33, 33, 33, 33, 30, 0, 0
<7> [358.476996] i915 0000:00:02.0: [drm:skl_print_plane_changes [i915]] [PLANE:78:plane 1B] min_ddb 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0 -> 17, 17, 17, 34, 34, 34, 34, 34, 31, 0, 0
<7> [358.477656] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] [PLANE:121:plane 1C] ddb ( 0 - 988) -> ( 510 - 1007), size 988 -> 497
<7> [358.478028] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] [PLANE:157:cursor C] ddb ( 988 - 1020) -> (1007 - 1020), size 32 -> 13
<7> [358.478727] i915 0000:00:02.0: [drm:intel_cdclk_atomic_check [i915]] [CRTC:120:pipe B] min cdclk: 0 kHz -> 192000 kHz
<7> [358.479149] i915 0000:00:02.0: [drm:intel_cdclk_update_dbuf_bw_min_cdclk [i915]] dbuf bandwidth min cdclk: 9282 kHz -> 18563 kHz
<7> [358.479710] i915 0000:00:02.0: [drm:bxt_get_dpll [i915]] [CRTC:120:pipe B] using pre-allocated PORT PLL B
<7> [358.480096] i915 0000:00:02.0: [drm:intel_dpll_crtc_get [i915]] [CRTC:120:pipe B] reserving PORT PLL B
<7> [358.482274] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [CRTC:120:pipe B] enable: yes [modeset]
<7> [358.482765] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] active: yes, output_types: HDMI (0x40), output format: RGB, sink format: RGB
<7> [358.483139] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] cpu_transcoder: B, pipe bpp: 36, dithering: 0
<7> [358.484519] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] MST master transcoder: <invalid>
<7> [358.484910] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] port sync: master transcoder: <invalid>, slave transcoder bitmask = 0x0
<7> [358.485734] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] joiner: no, pipes: 0x0
<7> [358.486115] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] splitter: disabled, link count 0, overlap 0
<7> [358.486770] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] audio: 1, infoframes: 1, infoframes enabled: 0x71
<7> [358.487151] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] GCP: 0x6
<7> [358.487691] i915 0000:00:02.0: HDMI infoframe: Auxiliary Video Information (AVI), version 2, length 13
<7> [358.487697] i915 0000:00:02.0: colorspace: RGB
<7> [358.487701] i915 0000:00:02.0: scan mode: Underscan
<7> [358.487704] i915 0000:00:02.0: colorimetry: No Data
<7> [358.487707] i915 0000:00:02.0: picture aspect: No Data
<7> [358.487710] i915 0000:00:02.0: active aspect: Same as Picture
<7> [358.487714] i915 0000:00:02.0: itc: No Data
<7> [358.487717] i915 0000:00:02.0: extended colorimetry: xvYCC 601
<7> [358.487720] i915 0000:00:02.0: quantization range: Full
<7> [358.487723] i915 0000:00:02.0: nups: Unknown Non-uniform Scaling
<7> [358.487727] i915 0000:00:02.0: video code: 0
<7> [358.487730] i915 0000:00:02.0: ycc quantization range: Full
<7> [358.487733] i915 0000:00:02.0: hdmi content type: Graphics
<7> [358.487736] i915 0000:00:02.0: pixel repeat: 0
<7> [358.487740] i915 0000:00:02.0: bar top 0, bottom 0, left 0, right 0
<7> [358.487744] i915 0000:00:02.0: HDMI infoframe: Source Product Description (SPD), version 1, length 25
<7> [358.487747] i915 0000:00:02.0: vendor: Intel
<7> [358.487751] i915 0000:00:02.0: product: Integrated gfx
<7> [358.487754] i915 0000:00:02.0: source device information: PC General (0x9)
<7> [358.487758] i915 0000:00:02.0: HDMI infoframe: Vendor, version 1, length 4
<7> [358.487761] i915 0000:00:02.0: empty frame
<7> [358.487765] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] ELD: 10 00 07 00 66 10 00 01 00 00 00 00 00 00 00 00
<7> [358.488143] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] ELD: 05 e3 cd 0c 32 38 45 38 35 30 09 07 07 00 00 00
<7> [358.488871] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] scanline offset: 2
<7> [358.491273] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] framestart delay: 1, MSA timing delay: 0, set context latency: 0
<7> [358.491774] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] vrr: no, fixed rr: no, vmin: 0, vmax: 0, flipline: 0, pipeline full: 0, guardband: 0 vsync start: 0, vsync end: 0
<7> [358.492154] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] vrr: vmin vblank: 0, vmax vblank: 0, vmin vtotal: 0, vmax vtotal: 0
<7> [358.492798] 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> [358.494448] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] requested mode: "1920x1080": 60 148500 1920 2008 2052 2200 1080 1083 1088 1125 0x48 0x9
<7> [358.494834] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] adjusted mode: "1920x1080": 60 148500 1920 2008 2052 2200 1080 1083 1088 1125 0x48 0x9
<7> [358.495706] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] crtc timings: clock=148500, hd=1920 hb=1920-2200 hs=2008-2052 ht=2200, vd=1080 vb=1080-1125 vs=1083-1088 vt=1125, flags=0x9
<7> [358.496092] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pipe mode: "1920x1080": 60 148500 1920 2008 2052 2200 1080 1083 1088 1125 0x40 0x9
<7> [358.496783] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] crtc timings: clock=148500, hd=1920 hb=1920-2200 hs=2008-2052 ht=2200, vd=1080 vb=1080-1125 vs=1083-1088 vt=1125, flags=0x9
<7> [358.497164] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] port clock: 222750, pipe src: 1920x1080+0+0, pixel rate 148500, min cdclk 192000
<7> [358.497711] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] linetime: 59, ips linetime: 0
<7> [358.498089] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] num_scalers: 2, scaler_users: 0x0, scaler_id: -1, scaling_filter: 0
<7> [358.498629] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pch pfit: 0x0+0+0, disabled, force thru: no
<7> [358.499006] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] ips: 0, double wide: 0, drrs: 0
<7> [358.501252] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] dpll_hw_state: ebb0: 0x6200, ebb4: 0x2000,pll0: 0x21, pll1: 0x100, pll2: 0x1a6666, pll3: 0x10000, pll6: 0x30904, pll8: 0x8, pll9: 0xa, pll10: 0x8003c00, pcsdw12: 0x4d
<7> [358.501744] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] csc_mode: 0x0 gamma_mode: 0x0 gamma_enable: 0 csc_enable: 0
<7> [358.502117] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pre csc lut: 0 entries, post csc lut: 0 entries
<7> [358.502745] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pipe csc: pre offsets: 0x0000 0x0000 0x0000
<7> [358.503121] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pipe csc: coefficients: 0x0000 0x0000 0x0000
<7> [358.504118] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pipe csc: coefficients: 0x0000 0x0000 0x0000
<7> [358.504770] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pipe csc: coefficients: 0x0000 0x0000 0x0000
<7> [358.505147] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pipe csc: post offsets: 0x0000 0x0000 0x0000
<7> [358.505870] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] sharpness strength: 0, sharpness tap size: 0, sharpness enable: 0
<7> [358.506413] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:78:plane 1B] fb: [FB:178] 1920x1080 format = XR24 little-endian (0x34325258) modifier = 0x100000000000001, visible: yes
<7> [358.506797] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] rotation: 0x1, scaler: -1, scaling_filter: 0
<7> [358.507171] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] src: 1920.000000x1080.000000+0.000000+0.000000 dst: 1920x1080+0+0
<7> [358.507718] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:87:plane 2B] fb: [NOFB], visible: no
<7> [358.508096] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:96:plane 3B] fb: [NOFB], visible: no
<7> [358.510018] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:105:plane 4B] fb: [NOFB], visible: no
<7> [358.510767] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:114:cursor B] fb: [NOFB], visible: no
<7> [358.512423] i915 0000:00:02.0: [drm:intel_power_well_enable [i915]] enabling dpio-common-b
<7> [358.513661] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:164:DDI B/PHY B]
<7> [358.514055] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:174:DDI C/PHY C]
<7> [358.526105] i915 0000:00:02.0: [drm:intel_dpll_enable [i915]] enable PORT PLL B (active 0x2, on? 0) for [CRTC:120:pipe B]
<7> [358.526640] i915 0000:00:02.0: [drm:intel_dpll_enable [i915]] enabling PORT PLL B
<7> [358.527163] i915 0000:00:02.0: [drm:intel_power_well_enable [i915]] enabling DDI_IO_B
<7> [358.529092] i915 0000:00:02.0: [drm:intel_enable_transcoder [i915]] enabling pipe B
<7> [358.547814] i915 0000:00:02.0: [drm:intel_audio_codec_enable [i915]] [CONNECTOR:165:HDMI-A-1][ENCODER:164:DDI B/PHY B] Enable audio codec on [CRTC:120:pipe B], 32 bytes ELD
<7> [358.564498] i915 0000:00:02.0: [drm:audio_config_hdmi_pixel_clock [i915]] Configuring HDMI audio for pixel clock 148500 (0x00090000)
<7> [358.564979] i915 0000:00:02.0: [drm:hsw_audio_config_update [i915]] using automatic N
<7> [358.567282] i915 0000:00:02.0: [drm:verify_connector_state [i915]] [CONNECTOR:165:HDMI-A-1]
<7> [358.567955] i915 0000:00:02.0: [drm:intel_modeset_verify_crtc [i915]] [CRTC:120:pipe B]
<6> [362.085767] [IGT] kms_flip: finished subtest BC-HDMI-A1-HDMI-A2, FAIL
<6> [362.087580] [IGT] kms_flip: finished subtest 2x-flip-vs-expired-vblank, FAIL
<7> [362.108527] i915 0000:00:02.0: [drm:drm_mode_rmfb_work_fn] Removing [FB:178] from all active usage due to RMFB ioctl
<7> [362.109371] i915 0000:00:02.0: [drm:atomic_remove_fb] Disabling [PLANE:78:plane 1B] because [FB:178] is removed
<7> [362.109432] i915 0000:00:02.0: [drm:atomic_remove_fb] Disabling [PLANE:121:plane 1C] because [FB:178] is removed
<7> [362.109535] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] [PLANE:78:plane 1B] ddb ( 0 - 497) -> ( 0 - 0), size 497 -> 0
<7> [362.109987] i915 0000:00:02.0: [drm:skl_print_plane_changes [i915]] [PLANE:78: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> [362.112002] i915 0000:00:02.0: [drm:skl_print_plane_changes [i915]] [PLANE:78:plane 1B] lines 1, 1, 1, 2, 2, 2, 2, 2, 0, 0, 0 -> 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0
<7> [362.112641] i915 0000:00:02.0: [drm:skl_print_plane_changes [i915]] [PLANE:78:plane 1B] blocks 16, 16, 16, 33, 33, 33, 33, 33, 30, 0, 0 -> 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0
<7> [362.113014] i915 0000:00:02.0: [drm:skl_print_plane_changes [i915]] [PLANE:78:plane 1B] min_ddb 17, 17, 17, 34, 34, 34, 34, 34, 31, 0, 0 -> 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0
<7> [362.114002] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] [PLANE:121:plane 1C] ddb ( 510 - 1007) -> ( 0 - 0), size 497 -> 0
<7> [362.114538] i915 0000:00:02.0: [drm:skl_print_plane_changes [i915]] [PLANE:121: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> [362.114914] i915 0000:00:02.0: [drm:skl_print_plane_changes [i915]] [PLANE:121:plane 1C] lines 1, 1, 1, 2, 2, 2, 2, 2, 0, 0, 0 -> 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0
<7> [362.115463] i915 0000:00:02.0: [drm:skl_print_plane_changes [i915]] [PLANE:121:plane 1C] blocks 16, 16, 16, 33, 33, 33, 33, 33, 30, 0, 0 -> 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0
<7> [362.115836] i915 0000:00:02.0: [drm:skl_print_plane_changes [i915]] [PLANE:121:plane 1C] min_ddb 17, 17, 17, 34, 34, 34, 34, 34, 31, 0, 0 -> 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0
<6> [362.135902] [IGT] kms_flip: exiting, ret=98
<7> [362.174299] i915 0000:00:02.0: [drm:intel_hdmi_compute_clock [i915]] picking 12 bpc for HDMI output (pipe bpp: 36)
<7> [362.174821] i915 0000:00:02.0: [drm:intel_atomic_check [i915]] [CRTC:77:pipe A] hw max bpp: 36, pipe bpp: 36, dithering: 0
<7> [362.175358] i915 0000:00:02.0: [drm:intel_hdmi_compute_clock [i915]] picking 12 bpc for HDMI output (pipe bpp: 36)
<7> [362.175756] i915 0000:00:02.0: [drm:intel_atomic_check [i915]] [CRTC:120:pipe B] hw max bpp: 36, pipe bpp: 36, dithering: 0
<7> [362.176166] i915 0000:00:02.0: [drm:intel_ddi_compute_config_late [i915]] [ENCODER:164:DDI B/PHY B] [CRTC:77:pipe A]
<7> [362.176594] i915 0000:00:02.0: [drm:intel_ddi_compute_config_late [i915]] [ENCODER:174:DDI C/PHY C] [CRTC:120:pipe B]
<7> [362.176965] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:77:pipe A] fastset requirement not met in hw.enable (expected no, found yes)
<7> [362.177391] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:77:pipe A] fastset requirement not met in hw.active (expected no, found yes)
<7> [362.177800] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:77:pipe A] fastset requirement not met in cpu_transcoder (expected -1, found 0)
<7> [362.178497] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:77:pipe A] fastset requirement not met in lane_count (expected 0, found 4)
<7> [362.178931] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:77:pipe A] fastset requirement not met in lane_lat_optim_mask (expected 0x00000000, found 0x0000000d)
<7> [362.179425] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:77:pipe A] fastset requirement not met in output_types (expected 0x00000000, found 0x00000040)
<7> [362.179807] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:77:pipe A] fastset requirement not met in framestart_delay (expected 0, found 1)
<7> [362.180211] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:77:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hdisplay (expected 0, found 1920)
<7> [362.180590] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:77:pipe A] fastset requirement not met in hw.pipe_mode.crtc_htotal (expected 0, found 2200)
<7> [362.180996] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:77:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hblank_start (expected 0, found 1920)
<7> [362.181446] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:77:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hblank_end (expected 0, found 2200)
<7> [362.181846] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:77:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hsync_start (expected 0, found 2008)
<7> [362.182468] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:77:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hsync_end (expected 0, found 2052)
<7> [362.182850] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:77:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vdisplay (expected 0, found 1080)
<7> [362.183271] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:77:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vblank_start (expected 0, found 1080)
<7> [362.183676] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:77:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vsync_start (expected 0, found 1083)
<7> [362.184093] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:77:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vsync_end (expected 0, found 1088)
<7> [362.184559] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:77:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vtotal (expected 0, found 1125)
<7> [362.184940] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:77:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vblank_end (expected 0, found 1125)
<7> [362.185370] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:77:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hdisplay (expected 0, found 1920)
<7> [362.185753] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:77:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_htotal (expected 0, found 2200)
<7> [362.186150] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:77:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hblank_start (expected 0, found 1920)
<7> [362.186600] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:77:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hblank_end (expected 0, found 2200)
<7> [362.187008] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:77:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hsync_start (expected 0, found 2008)
<7> [362.187444] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:77:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hsync_end (expected 0, found 2052)
<7> [362.187822] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:77:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vdisplay (expected 0, found 1080)
<7> [362.188234] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:77:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vblank_start (expected 0, found 1080)
<7> [362.188639] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:77:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vsync_start (expected 0, found 1083)
<7> [362.189017] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:77:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vsync_end (expected 0, found 1088)
<7> [362.189435] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:77:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vtotal (expected 0, found 1125)
<7> [362.189815] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:77:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vblank_end (expected 0, found 1125)
<7> [362.190219] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:77:pipe A] fastset requirement not met in pixel_multiplier (expected 0, found 1)
<7> [362.190597] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:77:pipe A] fastset requirement not met in hw.adjusted_mode.flags (1) (expected 0, found 1)
<7> [362.191034] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:77:pipe A] fastset requirement not met in hw.adjusted_mode.flags (8) (expected 0, found 8)
<7> [362.191531] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:77:pipe A] fastset requirement not met in has_hdmi_sink (expected no, found yes)
<7> [362.191913] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:77:pipe A] fastset requirement not met in has_infoframe (expected no, found yes)
<7> [362.192332] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:77:pipe A] fastset requirement not met in pipe_bpp (expected 0, found 36)
<7> [362.192711] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:77:pipe A] fastset requirement not met in hw.pipe_mode.crtc_clock (expected 0, found 148500)
<7> [362.193105] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:77:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_clock (expected 0, found 148500)
<7> [362.193545] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:77:pipe A] fastset requirement not met in port_clock (expected 0, found 222750)
<7> [362.193945] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:77:pipe A] fastset requirement not met in infoframes.enable (expected 0x00000000, found 0x00000071)
<7> [362.194371] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:77:pipe A] fastset requirement not met in infoframes.gcp (expected 0x00000000, found 0x00000006)
<7> [362.194749] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:77:pipe A] fastset requirement not met in avi infoframe
<7> [362.195126] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] expected:
<7> [362.195584] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] found:
<7> [362.196006] i915 0000:00:02.0: HDMI infoframe: Auxiliary Video Information (AVI), version 2, length 13
<7> [362.196012] i915 0000:00:02.0: colorspace: RGB
<7> [362.196017] i915 0000:00:02.0: scan mode: Underscan
<7> [362.196021] i915 0000:00:02.0: colorimetry: No Data
<7> [362.196025] i915 0000:00:02.0: picture aspect: No Data
<7> [362.196029] i915 0000:00:02.0: active aspect: Same as Picture
<7> [362.196033] i915 0000:00:02.0: itc: No Data
<7> [362.196036] i915 0000:00:02.0: extended colorimetry: xvYCC 601
<7> [362.196040] i915 0000:00:02.0: quantization range: Full
<7> [362.196044] i915 0000:00:02.0: nups: Unknown Non-uniform Scaling
<7> [362.196048] i915 0000:00:02.0: video code: 0
<7> [362.196052] i915 0000:00:02.0: ycc quantization range: Full
<7> [362.196055] i915 0000:00:02.0: hdmi content type: Graphics
<7> [362.196059] i915 0000:00:02.0: pixel repeat: 0
<7> [362.196063] i915 0000:00:02.0: bar top 0, bottom 0, left 0, right 0
<7> [362.196068] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:77:pipe A] fastset requirement not met in spd infoframe
<7> [362.196538] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] expected:
<7> [362.196915] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] found:
<7> [362.197332] i915 0000:00:02.0: HDMI infoframe: Source Product Description (SPD), version 1, length 25
<7> [362.197337] i915 0000:00:02.0: vendor: Intel
<7> [362.197341] i915 0000:00:02.0: product: Integrated gfx
<7> [362.197346] i915 0000:00:02.0: source device information: PC General (0x9)
<7> [362.197350] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:77:pipe A] fastset requirement not met in hdmi infoframe
<7> [362.197727] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] expected:
<7> [362.198131] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] found:
<7> [362.198554] i915 0000:00:02.0: HDMI infoframe: Vendor, version 1, length 4
<7> [362.198559] i915 0000:00:02.0: empty frame
<7> [362.198565] i915 0000:00:02.0: [drm:intel_atomic_check [i915]] [CRTC:77:pipe A] fastset requirement not met, forcing full modeset
<7> [362.198973] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:163:pipe C] fastset requirement not met in hw.enable (expected yes, found no)
<7> [362.199401] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:163:pipe C] fastset requirement not met in hw.active (expected yes, found no)
<7> [362.199779] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:163:pipe C] fastset requirement not met in cpu_transcoder (expected 2, found -1)
<7> [362.200158] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:163:pipe C] fastset requirement not met in lane_count (expected 4, found 0)
<7> [362.200600] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:163:pipe C] fastset requirement not met in lane_lat_optim_mask (expected 0x0000000d, found 0x00000000)
<7> [362.201019] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:163:pipe C] fastset requirement not met in output_types (expected 0x00000040, found 0x00000000)
<7> [362.201501] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:163:pipe C] fastset requirement not met in framestart_delay (expected 1, found 0)
<7> [362.201881] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:163:pipe C] fastset requirement not met in hw.pipe_mode.crtc_hdisplay (expected 1920, found 0)
<7> [362.202279] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:163:pipe C] fastset requirement not met in hw.pipe_mode.crtc_htotal (expected 2200, found 0)
<7> [362.202656] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:163:pipe C] fastset requirement not met in hw.pipe_mode.crtc_hblank_start (expected 1920, found 0)
<7> [362.203051] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:163:pipe C] fastset requirement not met in hw.pipe_mode.crtc_hblank_end (expected 2200, found 0)
<7> [362.203510] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:163:pipe C] fastset requirement not met in hw.pipe_mode.crtc_hsync_start (expected 2008, found 0)
<7> [362.203912] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:163:pipe C] fastset requirement not met in hw.pipe_mode.crtc_hsync_end (expected 2052, found 0)
<7> [362.204350] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:163:pipe C] fastset requirement not met in hw.pipe_mode.crtc_vdisplay (expected 1080, found 0)
<7> [362.204731] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:163:pipe C] fastset requirement not met in hw.pipe_mode.crtc_vblank_start (expected 1080, found 0)
<7> [362.205108] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:163:pipe C] fastset requirement not met in hw.pipe_mode.crtc_vsync_start (expected 1083, found 0)
<7> [362.205559] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:163:pipe C] fastset requirement not met in hw.pipe_mode.crtc_vsync_end (expected 1088, found 0)
<7> [362.205980] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:163:pipe C] fastset requirement not met in hw.pipe_mode.crtc_vtotal (expected 1125, found 0)
<7> [362.206380] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:163:pipe C] fastset requirement not met in hw.pipe_mode.crtc_vblank_end (expected 1125, found 0)
<7> [362.206807] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:163:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_hdisplay (expected 1920, found 0)
<7> [362.207224] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:163:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_htotal (expected 2200, found 0)
<7> [362.207604] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:163:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_hblank_start (expected 1920, found 0)
<7> [362.208011] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:163:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_hblank_end (expected 2200, found 0)
<7> [362.208436] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:163:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_hsync_start (expected 2008, found 0)
<7> [362.208835] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:163:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_hsync_end (expected 2052, found 0)
<7> [362.209266] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:163:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_vdisplay (expected 1080, found 0)
<7> [362.209647] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:163:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_vblank_start (expected 1080, found 0)
<7> [362.210023] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:163:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_vsync_start (expected 1083, found 0)
<7> [362.210461] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:163:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_vsync_end (expected 1088, found 0)
<7> [362.210880] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:163:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_vtotal (expected 1125, found 0)
<7> [362.211364] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:163:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_vblank_end (expected 1125, found 0)
<7> [362.211845] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:163:pipe C] fastset requirement not met in pixel_multiplier (expected 1, found 0)
<7> [362.212258] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:163:pipe C] fastset requirement not met in hw.adjusted_mode.flags (1) (expected 1, found 0)
<7> [362.212653] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:163:pipe C] fastset requirement not met in hw.adjusted_mode.flags (8) (expected 8, found 0)
<7> [362.213033] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:163:pipe C] fastset requirement not met in has_hdmi_sink (expected yes, found no)
<7> [362.213469] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:163:pipe C] fastset requirement not met in has_infoframe (expected yes, found no)
<7> [362.213867] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:163:pipe C] fastset requirement not met in pipe_bpp (expected 36, found 0)
<7> [362.214309] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:163:pipe C] fastset requirement not met in hw.pipe_mode.crtc_clock (expected 148500, found 0)
<7> [362.214687] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:163:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_clock (expected 148500, found 0)
<7> [362.215063] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:163:pipe C] fastset requirement not met in port_clock (expected 222750, found 0)
<7> [362.215514] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:163:pipe C] fastset requirement not met in infoframes.enable (expected 0x00000071, found 0x00000000)
<7> [362.215938] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:163:pipe C] fastset requirement not met in infoframes.gcp (expected 0x00000006, found 0x00000000)
<7> [362.216410] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:163:pipe C] fastset requirement not met in avi infoframe
<7> [362.216790] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] expected:
<7> [362.217164] i915 0000:00:02.0: HDMI infoframe: Auxiliary Video Information (AVI), version 2, length 13
<7> [362.217170] i915 0000:00:02.0: colorspace: RGB
<7> [362.217220] i915 0000:00:02.0: scan mode: Underscan
<7> [362.217224] i915 0000:00:02.0: colorimetry: No Data
<7> [362.217228] i915 0000:00:02.0: picture aspect: No Data
<7> [362.217232] i915 0000:00:02.0: active aspect: Same as Picture
<7> [362.217235] i915 0000:00:02.0: itc: No Data
<7> [362.217239] i915 0000:00:02.0: extended colorimetry: xvYCC 601
<7> [362.217243] i915 0000:00:02.0: quantization range: Full
<7> [362.217247] i915 0000:00:02.0: nups: Unknown Non-uniform Scaling
<7> [362.217251] i915 0000:00:02.0: video code: 0
<7> [362.217254] i915 0000:00:02.0: ycc quantization range: Full
<7> [362.217258] i915 0000:00:02.0: hdmi content type: Graphics
<7> [362.217262] i915 0000:00:02.0: pixel repeat: 0
<7> [362.217266] i915 0000:00:02.0: bar top 0, bottom 0, left 0, right 0
<7> [362.217270] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] found:
<7> [362.217648] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:163:pipe C] fastset requirement not met in spd infoframe
<7> [362.218045] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] expected:
<7> [362.218480] i915 0000:00:02.0: HDMI infoframe: Source Product Description (SPD), version 1, length 25
<7> [362.218485] i915 0000:00:02.0: vendor: Intel
<7> [362.218489] i915 0000:00:02.0: product: Integrated gfx
<7> [362.218493] i915 0000:00:02.0: source device information: PC General (0x9)
<7> [362.218497] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] found:
<7> [362.218896] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:163:pipe C] fastset requirement not met in hdmi infoframe
<7> [362.219326] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] expected:
<7> [362.219703] i915 0000:00:02.0: HDMI infoframe: Vendor, version 1, length 4
<7> [362.219708] i915 0000:00:02.0: empty frame
<7> [362.219711] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] found:
<7> [362.220087] i915 0000:00:02.0: [drm:intel_atomic_check [i915]] [CRTC:163:pipe C] fastset requirement not met, forcing full modeset
<7> [362.220532] i915 0000:00:02.0: [drm:intel_dpll_crtc_put [i915]] [CRTC:120:pipe B] releasing PORT PLL B
<7> [362.220955] i915 0000:00:02.0: [drm:intel_dpll_crtc_put [i915]] [CRTC:163:pipe C] releasing PORT PLL C
<7> [362.221480] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] [CRTC:77:pipe A] dbuf slices 0x0 -> 0x1, ddb (0 - 0) -> (0 - 510), active pipes 0x6 -> 0x3
<7> [362.221911] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] [CRTC:120:pipe B] dbuf slices 0x1 -> 0x1, ddb (0 - 510) -> (510 - 1020), active pipes 0x6 -> 0x3
<7> [362.222313] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] [CRTC:163:pipe C] dbuf slices 0x1 -> 0x0, ddb (510 - 1020) -> (0 - 0), active pipes 0x6 -> 0x3
<7> [362.222692] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] [PLANE:35:plane 1A] ddb ( 0 - 0) -> ( 0 - 497), size 0 -> 497
<7> [362.223104] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] [PLANE:71:cursor A] ddb ( 0 - 0) -> ( 497 - 510), size 0 -> 13
<7> [362.223602] i915 0000:00:02.0: [drm:skl_print_plane_changes [i915]] [PLANE:35:plane 1A] level wm0, wm1, wm2, wm3, wm4, wm5, wm6, wm7, twm, swm, stwm -> *wm0,*wm1,*wm2,*wm3,*wm4,*wm5,*wm6,*wm7,*twm, swm, stwm
<7> [362.223979] i915 0000:00:02.0: [drm:skl_print_plane_changes [i915]] [PLANE:35:plane 1A] lines 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0 -> 1, 1, 1, 2, 2, 2, 2, 2, 0, 0, 0
<7> [362.224380] i915 0000:00:02.0: [drm:skl_print_plane_changes [i915]] [PLANE:35:plane 1A] blocks 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0 -> 16, 16, 16, 33, 33, 33, 33, 33, 30, 0, 0
<7> [362.224779] i915 0000:00:02.0: [drm:skl_print_plane_changes [i915]] [PLANE:35:plane 1A] min_ddb 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0 -> 17, 17, 17, 34, 34, 34, 34, 34, 31, 0, 0
<7> [362.225153] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] [PLANE:78:plane 1B] ddb ( 0 - 0) -> ( 510 - 1007), size 0 -> 497
<7> [362.225610] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] [PLANE:114:cursor B] ddb ( 497 - 510) -> (1007 - 1020), size 13 -> 13
<7> [362.226030] i915 0000:00:02.0: [drm:skl_print_plane_changes [i915]] [PLANE:78: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> [362.226439] i915 0000:00:02.0: [drm:skl_print_plane_changes [i915]] [PLANE:78:plane 1B] lines 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0 -> 1, 1, 1, 2, 2, 2, 2, 2, 0, 0, 0
<7> [362.226812] i915 0000:00:02.0: [drm:skl_print_plane_changes [i915]] [PLANE:78:plane 1B] blocks 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0 -> 16, 16, 16, 33, 33, 33, 33, 33, 30, 0, 0
<7> [362.227272] i915 0000:00:02.0: [drm:skl_print_plane_changes [i915]] [PLANE:78:plane 1B] min_ddb 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0 -> 17, 17, 17, 34, 34, 34, 34, 34, 31, 0, 0
<7> [362.227667] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] [PLANE:157:cursor C] ddb (1007 - 1020) -> ( 0 - 0), size 13 -> 0
<7> [362.228124] i915 0000:00:02.0: [drm:intel_cdclk_atomic_check [i915]] [CRTC:77:pipe A] min cdclk: 0 kHz -> 192000 kHz
<7> [362.228582] i915 0000:00:02.0: [drm:intel_cdclk_atomic_check [i915]] [CRTC:163:pipe C] min cdclk: 192000 kHz -> 0 kHz
<7> [362.229006] i915 0000:00:02.0: [drm:bxt_get_dpll [i915]] [CRTC:77:pipe A] using pre-allocated PORT PLL B
<7> [362.229444] i915 0000:00:02.0: [drm:intel_dpll_crtc_get [i915]] [CRTC:77:pipe A] reserving PORT PLL B
<7> [362.229860] i915 0000:00:02.0: [drm:bxt_get_dpll [i915]] [CRTC:120:pipe B] using pre-allocated PORT PLL C
<7> [362.230269] i915 0000:00:02.0: [drm:intel_dpll_crtc_get [i915]] [CRTC:120:pipe B] reserving PORT PLL C
<7> [362.230653] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [CRTC:77:pipe A] enable: yes [modeset]
<7> [362.231081] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] active: yes, output_types: HDMI (0x40), output format: RGB, sink format: RGB
<7> [362.231570] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] cpu_transcoder: A, pipe bpp: 36, dithering: 0
<7> [362.231951] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] MST master transcoder: <invalid>
<7> [362.232353] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] port sync: master transcoder: <invalid>, slave transcoder bitmask = 0x0
<7> [362.232728] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] joiner: no, pipes: 0x0
<7> [362.233118] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] splitter: disabled, link count 0, overlap 0
<7> [362.233546] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] audio: 1, infoframes: 1, infoframes enabled: 0x71
<7> [362.233950] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] GCP: 0x6
<7> [362.234383] i915 0000:00:02.0: HDMI infoframe: Auxiliary Video Information (AVI), version 2, length 13
<7> [362.234388] i915 0000:00:02.0: colorspace: RGB
<7> [362.234392] i915 0000:00:02.0: scan mode: Underscan
<7> [362.234395] i915 0000:00:02.0: colorimetry: No Data
<7> [362.234399] i915 0000:00:02.0: picture aspect: No Data
<7> [362.234403] i915 0000:00:02.0: active aspect: Same as Picture
<7> [362.234407] i915 0000:00:02.0: itc: No Data
<7> [362.234410] i915 0000:00:02.0: extended colorimetry: xvYCC 601
<7> [362.234414] i915 0000:00:02.0: quantization range: Full
<7> [362.234418] i915 0000:00:02.0: nups: Unknown Non-uniform Scaling
<7> [362.234422] i915 0000:00:02.0: video code: 0
<7> [362.234426] i915 0000:00:02.0: ycc quantization range: Full
<7> [362.234430] i915 0000:00:02.0: hdmi content type: Graphics
<7> [362.234434] i915 0000:00:02.0: pixel repeat: 0
<7> [362.234437] i915 0000:00:02.0: bar top 0, bottom 0, left 0, right 0
<7> [362.234442] i915 0000:00:02.0: HDMI infoframe: Source Product Description (SPD), version 1, length 25
<7> [362.234446] i915 0000:00:02.0: vendor: Intel
<7> [362.234449] i915 0000:00:02.0: product: Integrated gfx
<7> [362.234453] i915 0000:00:02.0: source device information: PC General (0x9)
<7> [362.234457] i915 0000:00:02.0: HDMI infoframe: Vendor, version 1, length 4
<7> [362.234461] i915 0000:00:02.0: empty frame
<7> [362.234466] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] ELD: 10 00 07 00 66 10 00 01 00 00 00 00 00 00 00 00
<7> [362.234842] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] ELD: 05 e3 cd 0c 32 38 45 38 35 30 09 07 07 00 00 00
<7> [362.235255] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] scanline offset: 2
<7> [362.235654] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] framestart delay: 1, MSA timing delay: 0, set context latency: 0
<7> [362.236030] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] vrr: no, fixed rr: no, vmin: 0, vmax: 0, flipline: 0, pipeline full: 0, guardband: 0 vsync start: 0, vsync end: 0
<7> [362.236430] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] vrr: vmin vblank: 0, vmax vblank: 0, vmin vtotal: 0, vmax vtotal: 0
<7> [362.236804] 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> [362.237277] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] requested mode: "1920x1080": 60 148500 1920 2008 2052 2200 1080 1083 1088 1125 0x48 0x9
<7> [362.237656] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] adjusted mode: "1920x1080": 60 148500 1920 2008 2052 2200 1080 1083 1088 1125 0x48 0x9
<7> [362.238032] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] crtc timings: clock=148500, hd=1920 hb=1920-2200 hs=2008-2052 ht=2200, vd=1080 vb=1080-1125 vs=1083-1088 vt=1125, flags=0x9
<7> [362.238492] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pipe mode: "1920x1080": 60 148500 1920 2008 2052 2200 1080 1083 1088 1125 0x40 0x9
<7> [362.238868] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] crtc timings: clock=148500, hd=1920 hb=1920-2200 hs=2008-2052 ht=2200, vd=1080 vb=1080-1125 vs=1083-1088 vt=1125, flags=0x9
<7> [362.239289] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] port clock: 222750, pipe src: 1920x1080+0+0, pixel rate 148500, min cdclk 192000
<7> [362.239667] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] linetime: 59, ips linetime: 0
<7> [362.240057] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] num_scalers: 2, scaler_users: 0x0, scaler_id: -1, scaling_filter: 0
<7> [362.240492] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pch pfit: 0x0+0+0, disabled, force thru: no
<7> [362.240888] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] ips: 0, double wide: 0, drrs: 0
<7> [362.241326] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] dpll_hw_state: ebb0: 0x6200, ebb4: 0x2000,pll0: 0x21, pll1: 0x100, pll2: 0x1a6666, pll3: 0x10000, pll6: 0x30904, pll8: 0x8, pll9: 0xa, pll10: 0x8003c00, pcsdw12: 0x4d
<7> [362.241705] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] csc_mode: 0x0 gamma_mode: 0x0 gamma_enable: 0 csc_enable: 0
<7> [362.242077] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pre csc lut: 0 entries, post csc lut: 0 entries
<7> [362.242511] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pipe csc: pre offsets: 0x0000 0x0000 0x0000
<7> [362.242931] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pipe csc: coefficients: 0x0000 0x0000 0x0000
<7> [362.243410] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pipe csc: coefficients: 0x0000 0x0000 0x0000
<7> [362.243787] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pipe csc: coefficients: 0x0000 0x0000 0x0000
<7> [362.244159] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pipe csc: post offsets: 0x0000 0x0000 0x0000
<7> [362.244574] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] sharpness strength: 0, sharpness tap size: 0, sharpness enable: 0
<7> [362.244948] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:35:plane 1A] fb: [FB:180] 1920x1080 format = XR24 little-endian (0x34325258) modifier = 0x0, visible: yes
<7> [362.245386] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] rotation: 0x1, scaler: -1, scaling_filter: 0
<7> [362.245782] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] src: 1920.000000x1080.000000+0.000000+0.000000 dst: 1920x1080+0+0
<7> [362.246159] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:44:plane 2A] fb: [NOFB], visible: no
<7> [362.246589] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:53:plane 3A] fb: [NOFB], visible: no
<7> [362.246964] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:62:plane 4A] fb: [NOFB], visible: no
<7> [362.247379] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:71:cursor A] fb: [NOFB], visible: no
<7> [362.247781] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [CRTC:120:pipe B] enable: yes [modeset]
<7> [362.248154] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] active: yes, output_types: HDMI (0x40), output format: RGB, sink format: RGB
<7> [362.248553] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] cpu_transcoder: B, pipe bpp: 36, dithering: 0
<7> [362.248970] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] MST master transcoder: <invalid>
<7> [362.249451] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] port sync: master transcoder: <invalid>, slave transcoder bitmask = 0x0
<7> [362.249830] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] joiner: no, pipes: 0x0
<7> [362.250224] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] splitter: disabled, link count 0, overlap 0
<7> [362.250615] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] audio: 1, infoframes: 1, infoframes enabled: 0x71
<7> [362.250988] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] GCP: 0x6
<7> [362.251418] i915 0000:00:02.0: HDMI infoframe: Auxiliary Video Information (AVI), version 2, length 13
<7> [362.251423] i915 0000:00:02.0: colorspace: RGB
<7> [362.251427] i915 0000:00:02.0: scan mode: Underscan
<7> [362.251431] i915 0000:00:02.0: colorimetry: No Data
<7> [362.251434] i915 0000:00:02.0: picture aspect: No Data
<7> [362.251438] i915 0000:00:02.0: active aspect: Same as Picture
<7> [362.251442] i915 0000:00:02.0: itc: No Data
<7> [362.251445] i915 0000:00:02.0: extended colorimetry: xvYCC 601
<7> [362.251449] i915 0000:00:02.0: quantization range: Full
<7> [362.251473] i915 0000:00:02.0: nups: Unknown Non-uniform Scaling
<7> [362.251478] i915 0000:00:02.0: video code: 0
<7> [362.251482] i915 0000:00:02.0: ycc quantization range: Full
<7> [362.251486] i915 0000:00:02.0: hdmi content type: Graphics
<7> [362.251489] i915 0000:00:02.0: pixel repeat: 0
<7> [362.251493] i915 0000:00:02.0: bar top 0, bottom 0, left 0, right 0
<7> [362.251497] i915 0000:00:02.0: HDMI infoframe: Source Product Description (SPD), version 1, length 25
<7> [362.251502] i915 0000:00:02.0: vendor: Intel
<7> [362.251506] i915 0000:00:02.0: product: Integrated gfx
<7> [362.251509] i915 0000:00:02.0: source device information: PC General (0x9)
<7> [362.251514] i915 0000:00:02.0: HDMI infoframe: Vendor, version 1, length 4
<7> [362.251518] i915 0000:00:02.0: empty frame
<7> [362.251522] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] ELD: 10 00 07 00 66 10 00 01 00 00 00 00 00 00 00 00
<7> [362.251904] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] ELD: 05 e3 cd 0c 32 38 45 38 35 30 09 07 07 00 00 00
<7> [362.252342] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] scanline offset: 2
<7> [362.252716] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] framestart delay: 1, MSA timing delay: 0, set context latency: 0
<7> [362.253089] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] vrr: no, fixed rr: no, vmin: 0, vmax: 0, flipline: 0, pipeline full: 0, guardband: 0 vsync start: 0, vsync end: 0
<7> [362.253544] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] vrr: vmin vblank: 0, vmax vblank: 0, vmin vtotal: 0, vmax vtotal: 0
<7> [362.253973] 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> [362.254437] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] requested mode: "1920x1080": 60 148500 1920 2008 2052 2200 1080 1083 1088 1125 0x48 0x9
<7> [362.254818] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] adjusted mode: "1920x1080": 60 148500 1920 2008 2052 2200 1080 1083 1088 1125 0x48 0x9
<7> [362.255241] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] crtc timings: clock=148500, hd=1920 hb=1920-2200 hs=2008-2052 ht=2200, vd=1080 vb=1080-1125 vs=1083-1088 vt=1125, flags=0x9
<7> [362.255637] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pipe mode: "1920x1080": 60 148500 1920 2008 2052 2200 1080 1083 1088 1125 0x40 0x9
<7> [362.256013] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] crtc timings: clock=148500, hd=1920 hb=1920-2200 hs=2008-2052 ht=2200, vd=1080 vb=1080-1125 vs=1083-1088 vt=1125, flags=0x9
<7> [362.256436] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] port clock: 222750, pipe src: 1920x1080+0+0, pixel rate 148500, min cdclk 192000
<7> [362.256840] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] linetime: 59, ips linetime: 0
<7> [362.257272] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] num_scalers: 2, scaler_users: 0x0, scaler_id: -1, scaling_filter: 0
<7> [362.257648] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pch pfit: 0x0+0+0, disabled, force thru: no
<7> [362.258020] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] ips: 0, double wide: 0, drrs: 0
<7> [362.258453] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] dpll_hw_state: ebb0: 0x6200, ebb4: 0x2000,pll0: 0x21, pll1: 0x100, pll2: 0x1a6666, pll3: 0x10000, pll6: 0x30904, pll8: 0x8, pll9: 0xa, pll10: 0x8003c00, pcsdw12: 0x4d
<7> [362.258874] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] csc_mode: 0x0 gamma_mode: 0x0 gamma_enable: 0 csc_enable: 0
<7> [362.259347] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pre csc lut: 0 entries, post csc lut: 0 entries
<7> [362.259728] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pipe csc: pre offsets: 0x0000 0x0000 0x0000
<7> [362.260103] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pipe csc: coefficients: 0x0000 0x0000 0x0000
<7> [362.260503] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pipe csc: coefficients: 0x0000 0x0000 0x0000
<7> [362.260911] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pipe csc: coefficients: 0x0000 0x0000 0x0000
<7> [362.261406] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pipe csc: post offsets: 0x0000 0x0000 0x0000
<7> [362.261786] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] sharpness strength: 0, sharpness tap size: 0, sharpness enable: 0
<7> [362.262160] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:78:plane 1B] fb: [FB:180] 1920x1080 format = XR24 little-endian (0x34325258) modifier = 0x0, visible: yes
<7> [362.262607] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] rotation: 0x1, scaler: -1, scaling_filter: 0
<7> [362.262982] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] src: 1920.000000x1080.000000+0.000000+0.000000 dst: 1920x1080+0+0
<7> [362.263398] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:87:plane 2B] fb: [NOFB], visible: no
<7> [362.263802] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:96:plane 3B] fb: [NOFB], visible: no
<7> [362.264212] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:105:plane 4B] fb: [NOFB], visible: no
<7> [362.264587] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:114:cursor B] fb: [NOFB], visible: no
<7> [362.265007] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [CRTC:163:pipe C] enable: no [modeset]
<7> [362.265491] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:121:plane 1C] fb: [NOFB], visible: no
<7> [362.265870] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:130:plane 2C] fb: [NOFB], visible: no
<7> [362.266272] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:139:plane 3C] fb: [NOFB], visible: no
<7> [362.266664] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:148:plane 4C] fb: [NOFB], visible: no
<7> [362.267040] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:157:cursor C] fb: [NOFB], visible: no
<7> [362.267895] i915 0000:00:02.0: [drm:intel_audio_codec_disable [i915]] [CONNECTOR:165:HDMI-A-1][ENCODER:164:DDI B/PHY B] Disable audio codec on [CRTC:120:pipe B]
<7> [362.297804] i915 0000:00:02.0: [drm:intel_audio_component_get_eld [i915]] Not valid for port B
<7> [362.298328] i915 0000:00:02.0: [drm:intel_audio_codec_disable [i915]] [CONNECTOR:175:HDMI-A-2][ENCODER:174:DDI C/PHY C] Disable audio codec on [CRTC:163:pipe C]
<7> [362.325990] i915 0000:00:02.0: [drm:intel_audio_component_get_eld [i915]] Not valid for port C
<7> [362.327280] i915 0000:00:02.0: [drm:intel_disable_transcoder [i915]] disabling pipe B
<7> [362.331277] i915 0000:00:02.0: [drm:intel_ddi_disable_transcoder_func [i915]] Quirk Increase DDI disabled time
<7> [362.436275] i915 0000:00:02.0: [drm:intel_power_well_disable [i915]] disabling DDI_IO_B
<7> [362.436845] i915 0000:00:02.0: [drm:intel_dpll_disable [i915]] disable PORT PLL B (active 0x2, on? 1) for [CRTC:120:pipe B]
<7> [362.437448] i915 0000:00:02.0: [drm:intel_dpll_disable [i915]] disabling PORT PLL B
<7> [362.438132] i915 0000:00:02.0: [drm:intel_disable_transcoder [i915]] disabling pipe C
<7> [362.442910] i915 0000:00:02.0: [drm:intel_ddi_disable_transcoder_func [i915]] Quirk Increase DDI disabled time
<7> [362.548646] i915 0000:00:02.0: [drm:intel_power_well_disable [i915]] disabling DDI_IO_C
<7> [362.549883] i915 0000:00:02.0: [drm:intel_dpll_disable [i915]] disable PORT PLL C (active 0x4, on? 1) for [CRTC:163:pipe C]
<7> [362.552742] i915 0000:00:02.0: [drm:intel_dpll_disable [i915]] disabling PORT PLL C
<7> [362.553440] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:164:DDI B/PHY B]
<7> [362.553833] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:174:DDI C/PHY C]
<7> [362.555279] i915 0000:00:02.0: [drm:intel_dpll_enable [i915]] enable PORT PLL B (active 0x1, on? 0) for [CRTC:77:pipe A]
<7> [362.555688] i915 0000:00:02.0: [drm:intel_dpll_enable [i915]] enabling PORT PLL B
<7> [362.556376] i915 0000:00:02.0: [drm:intel_power_well_enable [i915]] enabling DDI_IO_B
<7> [362.556887] i915 0000:00:02.0: [drm:intel_enable_transcoder [i915]] enabling pipe A
<7> [362.558288] i915 0000:00:02.0: [drm:intel_dpll_enable [i915]] enable PORT PLL C (active 0x2, on? 0) for [CRTC:120:pipe B]
<7> [362.558692] i915 0000:00:02.0: [drm:intel_dpll_enable [i915]] enabling PORT PLL C
<7> [362.559396] i915 0000:00:02.0: [drm:intel_power_well_enable [i915]] enabling DDI_IO_C
<7> [362.559925] i915 0000:00:02.0: [drm:intel_enable_transcoder [i915]] enabling pipe B
<7> [362.560831] i915 0000:00:02.0: [drm:intel_fbc_update [i915]] reserved 16588800 bytes of contiguous stolen space for FBC, limit: 1
<7> [362.561340] i915 0000:00:02.0: [drm:intel_fbc_update [i915]] Enabling FBC on [PLANE:35:plane 1A]
<7> [362.577765] i915 0000:00:02.0: [drm:intel_audio_codec_enable [i915]] [CONNECTOR:165:HDMI-A-1][ENCODER:164:DDI B/PHY B] Enable audio codec on [CRTC:77:pipe A], 32 bytes ELD
<7> [362.591708] i915 0000:00:02.0: [drm:audio_config_hdmi_pixel_clock [i915]] Configuring HDMI audio for pixel clock 148500 (0x00090000)
<7> [362.592868] i915 0000:00:02.0: [drm:hsw_audio_config_update [i915]] using automatic N
<7> [362.596540] i915 0000:00:02.0: [drm:verify_connector_state [i915]] [CONNECTOR:165:HDMI-A-1]
<7> [362.597278] i915 0000:00:02.0: [drm:intel_modeset_verify_crtc [i915]] [CRTC:77:pipe A]
<7> [362.599497] i915 0000:00:02.0: [drm:intel_audio_codec_enable [i915]] [CONNECTOR:175:HDMI-A-2][ENCODER:174:DDI C/PHY C] Enable audio codec on [CRTC:120:pipe B], 32 bytes ELD
<7> [362.611270] i915 0000:00:02.0: [drm:audio_config_hdmi_pixel_clock [i915]] Configuring HDMI audio for pixel clock 148500 (0x00090000)
<7> [362.611744] i915 0000:00:02.0: [drm:hsw_audio_config_update [i915]] using automatic N
<7> [362.612413] i915 0000:00:02.0: [drm:verify_connector_state [i915]] [CONNECTOR:175:HDMI-A-2]
<7> [362.613000] i915 0000:00:02.0: [drm:intel_modeset_verify_crtc [i915]] [CRTC:120:pipe B]
<7> [362.615425] i915 0000:00:02.0: [drm:intel_modeset_verify_crtc [i915]] [CRTC:163:pipe C]
<7> [362.616912] i915 0000:00:02.0: [drm:drm_client_dev_restore] fbdev: ret=0
Created at 2026-03-14 04:22:38