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

Result: Fail

integration-manifest git-log-oneline igt_runner21 run21 boot21 dmesg21 runtimes21

DetailValue
Duration 2.96 seconds
Hostname
shard-skl1
Igt-Version
IGT-Version: 1.25-gaf1ef32bf (x86_64) (Linux: 5.8.0-rc3-CI-CI_DRM_8684+ x86_64)
Out
Starting dynamic subtest: C-eDP1
  2400x1600 60 2400 2448 2480 2560 1600 1603 1613 1646 0xa 0x48 252750
Stack trace:
  #0 ../lib/igt_core.c:1727 __igt_fail_assert()
  #1 ../tests/kms_flip.c:1279 run_test_on_crtc_set.constprop.13()
  #2 [_fini+0xff6]
Dynamic subtest C-eDP1: FAIL (2.961s)
Subtest flip-vs-expired-vblank-interruptible: FAIL (26.956s)
Err
Starting dynamic subtest: C-eDP1
(kms_flip:904) CRITICAL: Test assertion failure function run_test_step, file ../tests/kms_flip.c:712:
(kms_flip:904) CRITICAL: Failed assertion: reply.sequence == exp_seq
(kms_flip:904) CRITICAL: Last errno: 4, Interrupted system call
(kms_flip:904) CRITICAL: error: 75 != 74
Dynamic subtest C-eDP1 failed.
**** DEBUG ****
(kms_flip:904) igt_fb-DEBUG: igt_create_fb_with_bo_size(width=2400, height=1600, format=XR24(0x34325258), modifier=0x0, size=0)
(kms_flip:904) igt_fb-DEBUG: igt_create_fb_with_bo_size(handle=2, pitch=9600)
(kms_flip:904) ioctl_wrappers-DEBUG: Test requirement passed: igt_has_fb_modifiers(fd)
(kms_flip:904) igt_fb-DEBUG: igt_create_fb_with_bo_size(width=2400, height=1600, format=XR24(0x34325258), modifier=0x0, size=0)
(kms_flip:904) igt_fb-DEBUG: igt_create_fb_with_bo_size(handle=3, pitch=9600)
(kms_flip:904) ioctl_wrappers-DEBUG: Test requirement passed: igt_has_fb_modifiers(fd)
(kms_flip:904) igt_fb-DEBUG: Test requirement passed: cairo_surface_status(fb->cairo_surface) == CAIRO_STATUS_SUCCESS
(kms_flip:904) igt_fb-DEBUG: Test requirement passed: cairo_surface_status(fb->cairo_surface) == CAIRO_STATUS_SUCCESS
(kms_flip:904) igt_kms-INFO:   2400x1600 60 2400 2448 2480 2560 1600 1603 1613 1646 0xa 0x48 252750
(kms_flip:904) DEBUG: name = flip
last_ts = 0.000000
last_received_ts = 0.000000
last_seq = 0
current_ts = 98.035240
current_received_ts = 98.035080
current_seq = 4
count = 0
seq_step = 1
(kms_flip:904) DEBUG: Vblank took 35us
(kms_flip:904) DEBUG: name = flip
last_ts = 98.035240
last_received_ts = 98.035080
last_seq = 4
current_ts = 98.051903
current_received_ts = 98.051758
current_seq = 5
count = 1
seq_step = 1
(kms_flip:904) DEBUG: Vblank took 33us
(kms_flip:904) DEBUG: name = flip
last_ts = 98.051903
last_received_ts = 98.051758
last_seq = 5
current_ts = 98.068581
current_received_ts = 98.068542
current_seq = 6
count = 2
seq_step = 1
(kms_flip:904) DEBUG: Vblank took 32us
(kms_flip:904) DEBUG: name = flip
last_ts = 98.068581
last_received_ts = 98.068542
last_seq = 6
current_ts = 98.085258
current_received_ts = 98.085014
current_seq = 7
count = 3
seq_step = 1
(kms_flip:904) DEBUG: Vblank took 33us
(kms_flip:904) DEBUG: name = flip
last_ts = 98.085258
last_received_ts = 98.085014
last_seq = 7
current_ts = 98.101929
current_received_ts = 98.101707
current_seq = 8
count = 4
seq_step = 1
(kms_flip:904) DEBUG: Vblank took 30us
(kms_flip:904) DEBUG: name = flip
last_ts = 98.101929
last_received_ts = 98.101707
last_seq = 8
current_ts = 98.118599
current_received_ts = 98.118469
current_seq = 9
count = 5
seq_step = 1
(kms_flip:904) DEBUG: Vblank took 30us
(kms_flip:904) DEBUG: name = flip
last_ts = 98.118599
last_received_ts = 98.118469
last_seq = 9
current_ts = 98.135262
current_received_ts = 98.135056
current_seq = 10
count = 6
seq_step = 1
(kms_flip:904) DEBUG: Vblank took 31us
(kms_flip:904) DEBUG: name = flip
last_ts = 98.135262
last_received_ts = 98.135056
last_seq = 10
current_ts = 98.151939
current_received_ts = 98.151772
current_seq = 11
count = 7
seq_step = 1
(kms_flip:904) DEBUG: Vblank took 31us
(kms_flip:904) DEBUG: name = flip
last_ts = 98.151939
last_received_ts = 98.151772
last_seq = 11
current_ts = 98.168610
current_received_ts = 98.168457
current_seq = 12
count = 8
seq_step = 1
(kms_flip:904) DEBUG: Vblank took 30us
(kms_flip:904) DEBUG: name = flip
last_ts = 98.168610
last_received_ts = 98.168457
last_seq = 12
current_ts = 98.185280
current_received_ts = 98.185051
current_seq = 13
count = 9
seq_step = 1
(kms_flip:904) DEBUG: Vblank took 30us
(kms_flip:904) DEBUG: name = flip
last_ts = 98.185280
last_received_ts = 98.185051
last_seq = 13
current_ts = 98.201950
current_received_ts = 98.201721
current_seq = 14
count = 10
seq_step = 1
(kms_flip:904) DEBUG: Vblank took 30us
(kms_flip:904) DEBUG: name = flip
last_ts = 98.201950
last_received_ts = 98.201721
last_seq = 14
current_ts = 98.218628
current_received_ts = 98.218491
current_seq = 15
count = 11
seq_step = 1
(kms_flip:904) DEBUG: Vblank took 30us
(kms_flip:904) DEBUG: name = flip
last_ts = 98.218628
last_received_ts = 98.218491
last_seq = 15
current_ts = 98.235298
current_received_ts = 98.235077
current_seq = 16
count = 12
seq_step = 1
(kms_flip:904) DEBUG: Vblank took 30us
(kms_flip:904) DEBUG: name = flip
last_ts = 98.235298
last_received_ts = 98.235077
last_seq = 16
current_ts = 98.251961
current_received_ts = 98.251831
current_seq = 17
count = 13
seq_step = 1
(kms_flip:904) DEBUG: Vblank took 29us
(kms_flip:904) DEBUG: name = flip
last_ts = 98.251961
last_received_ts = 98.251831
last_seq = 17
current_ts = 98.268639
current_received_ts = 98.268456
current_seq = 18
count = 14
seq_step = 1
(kms_flip:904) DEBUG: Vblank took 30us
(kms_flip:904) DEBUG: name = flip
last_ts = 98.268639
last_received_ts = 98.268456
last_seq = 18
current_ts = 98.285309
current_received_ts = 98.285088
current_seq = 19
count = 15
seq_step = 1
(kms_flip:904) DEBUG: Vblank took 30us
(kms_flip:904) DEBUG: name = flip
last_ts = 98.285309
last_received_ts = 98.285088
last_seq = 19
current_ts = 98.301979
current_received_ts = 98.301765
current_seq = 20
count = 16
seq_step = 1
(kms_flip:904) DEBUG: Vblank took 30us
(kms_flip:904) DEBUG: name = flip
last_ts = 98.301979
last_received_ts = 98.301765
last_seq = 20
current_ts = 98.318649
current_received_ts = 98.318443
current_seq = 21
count = 17
seq_step = 1
(kms_flip:904) DEBUG: Vblank took 29us
(kms_flip:904) DEBUG: name = flip
last_ts = 98.318649
last_received_ts = 98.318443
last_seq = 21
current_ts = 98.335327
current_received_ts = 98.335098
current_seq = 22
count = 18
seq_step = 1
(kms_flip:904) DEBUG: Vblank took 29us
(kms_flip:904) DEBUG: name = flip
last_ts = 98.335327
last_received_ts = 98.335098
last_seq = 22
current_ts = 98.351997
current_received_ts = 98.351845
current_seq = 23
count = 19
seq_step = 1
(kms_flip:904) DEBUG: Vblank took 29us
(kms_flip:904) DEBUG: name = flip
last_ts = 98.351997
last_received_ts = 98.351845
last_seq = 23
current_ts = 98.368675
current_received_ts = 98.368484
current_seq = 24
count = 20
seq_step = 1
(kms_flip:904) DEBUG: Vblank took 29us
(kms_flip:904) DEBUG: name = flip
last_ts = 98.368675
last_received_ts = 98.368484
last_seq = 24
current_ts = 98.385345
current_received_ts = 98.385117
current_seq = 25
count = 21
seq_step = 1
(kms_flip:904) DEBUG: Vblank took 29us
(kms_flip:904) DEBUG: name = flip
last_ts = 98.385345
last_received_ts = 98.385117
last_seq = 25
current_ts = 98.402008
current_received_ts = 98.401802
current_seq = 26
count = 22
seq_step = 1
(kms_flip:904) DEBUG: Vblank took 30us
(kms_flip:904) DEBUG: name = flip
last_ts = 98.402008
last_received_ts = 98.401802
last_seq = 26
current_ts = 98.418686
current_received_ts = 98.418472
current_seq = 27
count = 23
seq_step = 1
(kms_flip:904) DEBUG: Vblank took 29us
(kms_flip:904) DEBUG: name = flip
last_ts = 98.418686
last_received_ts = 98.418472
last_seq = 27
current_ts = 98.435356
current_received_ts = 98.435112
current_seq = 28
count = 24
seq_step = 1
(kms_flip:904) DEBUG: Vblank took 29us
(kms_flip:904) DEBUG: name = flip
last_ts = 98.435356
last_received_ts = 98.435112
last_seq = 28
current_ts = 98.452026
current_received_ts = 98.451866
current_seq = 29
count = 25
seq_step = 1
(kms_flip:904) DEBUG: Vblank took 29us
(kms_flip:904) DEBUG: name = flip
last_ts = 98.452026
last_received_ts = 98.451866
last_seq = 29
current_ts = 98.468704
current_received_ts = 98.468498
current_seq = 30
count = 26
seq_step = 1
(kms_flip:904) DEBUG: Vblank took 29us
(kms_flip:904) DEBUG: name = flip
last_ts = 98.468704
last_received_ts = 98.468498
last_seq = 30
current_ts = 98.485374
current_received_ts = 98.485153
current_seq = 31
count = 27
seq_step = 1
(kms_flip:904) DEBUG: Vblank took 30us
(kms_flip:904) DEBUG: name = flip
last_ts = 98.485374
last_received_ts = 98.485153
last_seq = 31
current_ts = 98.502045
current_received_ts = 98.501785
current_seq = 32
count = 28
seq_step = 1
(kms_flip:904) DEBUG: Vblank took 30us
(kms_flip:904) DEBUG: name = flip
last_ts = 98.502045
last_received_ts = 98.501785
last_seq = 32
current_ts = 98.518707
current_received_ts = 98.518494
current_seq = 33
count = 29
seq_step = 1
(kms_flip:904) DEBUG: Vblank took 30us
(kms_flip:904) DEBUG: name = flip
last_ts = 98.518707
last_received_ts = 98.518494
last_seq = 33
current_ts = 98.535378
current_received_ts = 98.535149
current_seq = 34
count = 30
seq_step = 1
(kms_flip:904) DEBUG: Vblank took 31us
(kms_flip:904) DEBUG: name = flip
last_ts = 98.535378
last_received_ts = 98.535149
last_seq = 34
current_ts = 98.552055
current_received_ts = 98.551872
current_seq = 35
count = 31
seq_step = 1
(kms_flip:904) DEBUG: Vblank took 30us
(kms_flip:904) DEBUG: name = flip
last_ts = 98.552055
last_received_ts = 98.551872
last_seq = 35
current_ts = 98.568726
current_received_ts = 98.568504
current_seq = 36
count = 32
seq_step = 1
(kms_flip:904) DEBUG: Vblank took 30us
(kms_flip:904) DEBUG: name = flip
last_ts = 98.568726
last_received_ts = 98.568504
last_seq = 36
current_ts = 98.585396
current_received_ts = 98.585175
current_seq = 37
count = 33
seq_step = 1
(kms_flip:904) DEBUG: Vblank took 30us
(kms_flip:904) DEBUG: name = flip
last_ts = 98.585396
last_received_ts = 98.585175
last_seq = 37
current_ts = 98.602074
current_received_ts = 98.601845
current_seq = 38
count = 34
seq_step = 1
(kms_flip:904) DEBUG: Vblank took 30us
(kms_flip:904) DEBUG: name = flip
last_ts = 98.602074
last_received_ts = 98.601845
last_seq = 38
current_ts = 98.618736
current_received_ts = 98.618523
current_seq = 39
count = 35
seq_step = 1
(kms_flip:904) DEBUG: Vblank took 29us
(kms_flip:904) DEBUG: name = flip
last_ts = 98.618736
last_received_ts = 98.618523
last_seq = 39
current_ts = 98.635422
current_received_ts = 98.635201
current_seq = 40
count = 36
seq_step = 1
(kms_flip:904) DEBUG: Vblank took 134us
(kms_flip:904) DEBUG: name = flip
last_ts = 98.635422
last_received_ts = 98.635201
last_seq = 40
current_ts = 98.652084
current_received_ts = 98.651878
current_seq = 41
count = 37
seq_step = 1
(kms_flip:904) DEBUG: Vblank took 30us
(kms_flip:904) DEBUG: name = flip
last_ts = 98.652084
last_received_ts = 98.651878
last_seq = 41
current_ts = 98.668755
current_received_ts = 98.668556
current_seq = 42
count = 38
seq_step = 1
(kms_flip:904) DEBUG: Vblank took 30us
(kms_flip:904) DEBUG: name = flip
last_ts = 98.668755
last_received_ts = 98.668556
last_seq = 42
current_ts = 98.685432
current_received_ts = 98.685219
current_seq = 43
count = 39
seq_step = 1
(kms_flip:904) DEBUG: Vblank took 116us
(kms_flip:904) DEBUG: name = flip
last_ts = 98.685432
last_received_ts = 98.685219
last_seq = 43
current_ts = 98.702103
current_received_ts = 98.701874
current_seq = 44
count = 40
seq_step = 1
(kms_flip:904) DEBUG: Vblank took 28us
(kms_flip:904) DEBUG: name = flip
last_ts = 98.702103
last_received_ts = 98.701874
last_seq = 44
current_ts = 98.718773
current_received_ts = 98.718658
current_seq = 45
count = 41
seq_step = 1
(kms_flip:904) DEBUG: Vblank took 29us
(kms_flip:904) DEBUG: name = flip
last_ts = 98.718773
last_received_ts = 98.718658
last_seq = 45
current_ts = 98.735443
current_received_ts = 98.735229
current_seq = 46
count = 42
seq_step = 1
(kms_flip:904) DEBUG: Vblank took 30us
(kms_flip:904) DEBUG: name = flip
last_ts = 98.735443
last_received_ts = 98.735229
last_seq = 46
current_ts = 98.752121
current_received_ts = 98.751884
current_seq = 47
count = 43
seq_step = 1
(kms_flip:904) DEBUG: Vblank took 28us
(kms_flip:904) DEBUG: name = flip
last_ts = 98.752121
last_received_ts = 98.751884
last_seq = 47
current_ts = 98.768791
current_received_ts = 98.768639
current_seq = 48
count = 44
seq_step = 1
(kms_flip:904) DEBUG: Vblank took 30us
(kms_flip:904) DEBUG: name = flip
last_ts = 98.768791
last_received_ts = 98.768639
last_seq = 48
current_ts = 98.785469
current_received_ts = 98.785240
current_seq = 49
count = 45
seq_step = 1
(kms_flip:904) DEBUG: Vblank took 30us
(kms_flip:904) DEBUG: name = flip
last_ts = 98.785469
last_received_ts = 98.785240
last_seq = 49
current_ts = 98.802124
current_received_ts = 98.801888
current_seq = 50
count = 46
seq_step = 1
(kms_flip:904) DEBUG: Vblank took 29us
(kms_flip:904) DEBUG: name = flip
last_ts = 98.802124
last_received_ts = 98.801888
last_seq = 50
current_ts = 98.818810
current_received_ts = 98.818672
current_seq = 51
count = 47
seq_step = 1
(kms_flip:904) DEBUG: Vblank took 30us
(kms_flip:904) DEBUG: name = flip
last_ts = 98.818810
last_received_ts = 98.818672
last_seq = 51
current_ts = 98.835472
current_received_ts = 98.835258
current_seq = 52
count = 48
seq_step = 1
(kms_flip:904) DEBUG: Vblank took 30us
(kms_flip:904) DEBUG: name = flip
last_ts = 98.835472
last_received_ts = 98.835258
last_seq = 52
current_ts = 98.852142
current_received_ts = 98.851921
current_seq = 53
count = 49
seq_step = 1
(kms_flip:904) DEBUG: Vblank took 29us
(kms_flip:904) DEBUG: name = flip
last_ts = 98.852142
last_received_ts = 98.851921
last_seq = 53
current_ts = 98.868813
current_received_ts = 98.868713
current_seq = 54
count = 50
seq_step = 1
(kms_flip:904) DEBUG: Vblank took 30us
(kms_flip:904) DEBUG: name = flip
last_ts = 98.868813
last_received_ts = 98.868713
last_seq = 54
current_ts = 98.885490
current_received_ts = 98.885254
current_seq = 55
count = 51
seq_step = 1
(kms_flip:904) DEBUG: Vblank took 29us
(kms_flip:904) DEBUG: name = flip
last_ts = 98.885490
last_received_ts = 98.885254
last_seq = 55
current_ts = 98.902161
current_received_ts = 98.901947
current_seq = 56
count = 52
seq_step = 1
(kms_flip:904) DEBUG: Vblank took 30us
(kms_flip:904) DEBUG: name = flip
last_ts = 98.902161
last_received_ts = 98.901947
last_seq = 56
current_ts = 98.918831
current_received_ts = 98.918694
current_seq = 57
count = 53
seq_step = 1
(kms_flip:904) DEBUG: Vblank took 30us
(kms_flip:904) DEBUG: name = flip
last_ts = 98.918831
last_received_ts = 98.918694
last_seq = 57
current_ts = 98.935501
current_received_ts = 98.935272
current_seq = 58
count = 54
seq_step = 1
(kms_flip:904) DEBUG: Vblank took 30us
(kms_flip:904) DEBUG: name = flip
last_ts = 98.935501
last_received_ts = 98.935272
last_seq = 58
current_ts = 98.952171
current_received_ts = 98.951950
current_seq = 59
count = 55
seq_step = 1
(kms_flip:904) DEBUG: Vblank took 29us
(kms_flip:904) DEBUG: name = flip
last_ts = 98.952171
last_received_ts = 98.951950
last_seq = 59
current_ts = 98.968849
current_received_ts = 98.968651
current_seq = 60
count = 56
seq_step = 1
(kms_flip:904) DEBUG: Vblank took 30us
(kms_flip:904) DEBUG: name = flip
last_ts = 98.968849
last_received_ts = 98.968651
last_seq = 60
current_ts = 98.985519
current_received_ts = 98.985291
current_seq = 61
count = 57
seq_step = 1
(kms_flip:904) DEBUG: Vblank took 30us
(kms_flip:904) DEBUG: name = flip
last_ts = 98.985519
last_received_ts = 98.985291
last_seq = 61
current_ts = 99.002190
current_received_ts = 99.001999
current_seq = 62
count = 58
seq_step = 1
(kms_flip:904) DEBUG: Vblank took 30us
(kms_flip:904) DEBUG: name = flip
last_ts = 99.002190
last_received_ts = 99.001999
last_seq = 62
current_ts = 99.018867
current_received_ts = 99.018639
current_seq = 63
count = 59
seq_step = 1
(kms_flip:904) DEBUG: Vblank took 29us
(kms_flip:904) DEBUG: name = flip
last_ts = 99.018867
last_received_ts = 99.018639
last_seq = 63
current_ts = 99.035538
current_received_ts = 99.035286
current_seq = 64
count = 60
seq_step = 1
(kms_flip:904) DEBUG: Vblank took 30us
(kms_flip:904) DEBUG: name = flip
last_ts = 99.035538
last_received_ts = 99.035286
last_seq = 64
current_ts = 99.052208
current_received_ts = 99.051987
current_seq = 65
count = 61
seq_step = 1
(kms_flip:904) DEBUG: Vblank took 29us
(kms_flip:904) DEBUG: name = flip
last_ts = 99.052208
last_received_ts = 99.051987
last_seq = 65
current_ts = 99.068871
current_received_ts = 99.068642
current_seq = 66
count = 62
seq_step = 1
(kms_flip:904) DEBUG: Vblank took 28us
(kms_flip:904) DEBUG: name = flip
last_ts = 99.068871
last_received_ts = 99.068642
last_seq = 66
current_ts = 99.085548
current_received_ts = 99.085457
current_seq = 67
count = 63
seq_step = 1
(kms_flip:904) DEBUG: Vblank took 30us
(kms_flip:904) DEBUG: name = flip
last_ts = 99.085548
last_received_ts = 99.085457
last_seq = 67
current_ts = 99.102219
current_received_ts = 99.101982
current_seq = 68
count = 64
seq_step = 1
(kms_flip:904) DEBUG: Vblank took 29us
(kms_flip:904) DEBUG: name = flip
last_ts = 99.102219
last_received_ts = 99.101982
last_seq = 68
current_ts = 99.118889
current_received_ts = 99.118698
current_seq = 69
count = 65
seq_step = 1
(kms_flip:904) DEBUG: Vblank took 29us
(kms_flip:904) DEBUG: name = flip
last_ts = 99.118889
last_received_ts = 99.118698
last_seq = 69
current_ts = 99.135567
current_received_ts = 99.135414
current_seq = 70
count = 66
seq_step = 1
(kms_flip:904) DEBUG: Vblank took 29us
(kms_flip:904) DEBUG: name = flip
last_ts = 99.135567
last_received_ts = 99.135414
last_seq = 70
current_ts = 99.152229
current_received_ts = 99.152016
current_seq = 71
count = 67
seq_step = 1
(kms_flip:904) DEBUG: Vblank took 30us
(kms_flip:904) DEBUG: name = flip
last_ts = 99.152229
last_received_ts = 99.152016
last_seq = 71
current_ts = 99.168907
current_received_ts = 99.168671
current_seq = 72
count = 68
seq_step = 1
(kms_flip:904) DEBUG: Vblank took 30us
(kms_flip:904) DEBUG: name = flip
last_ts = 99.168907
last_received_ts = 99.168671
last_seq = 72
current_ts = 99.185577
current_received_ts = 99.186111
current_seq = 73
count = 69
seq_step = 1
(kms_flip:904) DEBUG: Vblank took 37us
(kms_flip:904) DEBUG: name = flip
last_ts = 99.185577
last_received_ts = 99.186111
last_seq = 73
current_ts = 99.202248
current_received_ts = 99.224091
current_seq = 74
count = 70
seq_step = 1
(kms_flip:904) DEBUG: Vblank took 289us
(kms_flip:904) CRITICAL: Test assertion failure function run_test_step, file ../tests/kms_flip.c:712:
(kms_flip:904) CRITICAL: Failed assertion: reply.sequence == exp_seq
(kms_flip:904) CRITICAL: Last errno: 4, Interrupted system call
(kms_flip:904) CRITICAL: error: 75 != 74
(kms_flip:904) igt_core-INFO: Stack trace:
(kms_flip:904) igt_core-INFO:   #0 ../lib/igt_core.c:1727 __igt_fail_assert()
(kms_flip:904) igt_core-INFO:   #1 ../tests/kms_flip.c:1279 run_test_on_crtc_set.constprop.13()
(kms_flip:904) igt_core-INFO:   #2 [_fini+0xff6]
****  END  ****
Dynamic subtest C-eDP1: FAIL (2.961s)
Subtest flip-vs-expired-vblank-interruptible: FAIL (26.956s)
Dmesg
<6> [96.384733] [IGT] kms_flip: starting dynamic subtest C-eDP1
<7> [96.389458] [drm:drm_mode_addfb2] [FB:128]
<7> [96.390102] [drm:drm_mode_addfb2] [FB:129]
<7> [96.827687] [drm:drm_mode_setcrtc] [CRTC:51:pipe A]
<7> [96.829910] [drm:drm_mode_setcrtc] [CRTC:72:pipe B]
<7> [96.831390] i915 0000:00:02.0: [drm:pipe_config_mismatch [i915]] [CRTC:72:pipe B] fastset mismatch in cpu_transcoder (expected 4, found -1)
<7> [96.832085] i915 0000:00:02.0: [drm:pipe_config_mismatch [i915]] [CRTC:72:pipe B] fastset mismatch in lane_count (expected 4, found 0)
<7> [96.832592] i915 0000:00:02.0: [drm:pipe_config_mismatch [i915]] [CRTC:72:pipe B] fastset mismatch in output_types (expected 0x00000100, found 0x00000000)
<7> [96.833235] i915 0000:00:02.0: [drm:pipe_config_mismatch [i915]] [CRTC:72:pipe B] fastset mismatch in hw.adjusted_mode.crtc_hdisplay (expected 2400, found 0)
<7> [96.833808] i915 0000:00:02.0: [drm:pipe_config_mismatch [i915]] [CRTC:72:pipe B] fastset mismatch in hw.adjusted_mode.crtc_htotal (expected 2560, found 0)
<7> [96.834292] i915 0000:00:02.0: [drm:pipe_config_mismatch [i915]] [CRTC:72:pipe B] fastset mismatch in hw.adjusted_mode.crtc_hblank_start (expected 2400, found 0)
<7> [96.834904] i915 0000:00:02.0: [drm:pipe_config_mismatch [i915]] [CRTC:72:pipe B] fastset mismatch in hw.adjusted_mode.crtc_hblank_end (expected 2560, found 0)
<7> [96.835390] i915 0000:00:02.0: [drm:pipe_config_mismatch [i915]] [CRTC:72:pipe B] fastset mismatch in hw.adjusted_mode.crtc_hsync_start (expected 2448, found 0)
<7> [96.835955] i915 0000:00:02.0: [drm:pipe_config_mismatch [i915]] [CRTC:72:pipe B] fastset mismatch in hw.adjusted_mode.crtc_hsync_end (expected 2480, found 0)
<7> [96.836436] i915 0000:00:02.0: [drm:pipe_config_mismatch [i915]] [CRTC:72:pipe B] fastset mismatch in hw.adjusted_mode.crtc_vdisplay (expected 1600, found 0)
<7> [96.837063] i915 0000:00:02.0: [drm:pipe_config_mismatch [i915]] [CRTC:72:pipe B] fastset mismatch in hw.adjusted_mode.crtc_vtotal (expected 1646, found 0)
<7> [96.837546] i915 0000:00:02.0: [drm:pipe_config_mismatch [i915]] [CRTC:72:pipe B] fastset mismatch in hw.adjusted_mode.crtc_vblank_start (expected 1600, found 0)
<7> [96.838179] i915 0000:00:02.0: [drm:pipe_config_mismatch [i915]] [CRTC:72:pipe B] fastset mismatch in hw.adjusted_mode.crtc_vblank_end (expected 1646, found 0)
<7> [96.838662] i915 0000:00:02.0: [drm:pipe_config_mismatch [i915]] [CRTC:72:pipe B] fastset mismatch in hw.adjusted_mode.crtc_vsync_start (expected 1603, found 0)
<7> [96.839302] i915 0000:00:02.0: [drm:pipe_config_mismatch [i915]] [CRTC:72:pipe B] fastset mismatch in hw.adjusted_mode.crtc_vsync_end (expected 1613, found 0)
<7> [96.839877] i915 0000:00:02.0: [drm:pipe_config_mismatch [i915]] [CRTC:72:pipe B] fastset mismatch in pixel_multiplier (expected 1, found 0)
<7> [96.840357] i915 0000:00:02.0: [drm:pipe_config_mismatch [i915]] [CRTC:72:pipe B] fastset mismatch in output_format (expected 1, found 0)
<7> [96.840966] i915 0000:00:02.0: [drm:pipe_config_mismatch [i915]] [CRTC:72:pipe B] fastset mismatch in hw.adjusted_mode.flags (2) (expected 2, found 0)
<7> [96.841449] i915 0000:00:02.0: [drm:pipe_config_mismatch [i915]] [CRTC:72:pipe B] fastset mismatch in hw.adjusted_mode.flags (8) (expected 8, found 0)
<7> [96.842017] i915 0000:00:02.0: [drm:pipe_config_mismatch [i915]] [CRTC:72:pipe B] fastset mismatch in pipe_bpp (expected 24, found 0)
<7> [96.842502] i915 0000:00:02.0: [drm:pipe_config_mismatch [i915]] [CRTC:72:pipe B] fastset mismatch in hw.adjusted_mode.crtc_clock (expected 252750, found 0)
<7> [96.843047] i915 0000:00:02.0: [drm:pipe_config_mismatch [i915]] [CRTC:72:pipe B] fastset mismatch in port_clock (expected 270000, found 0)
<7> [96.843541] i915 0000:00:02.0: [drm:pipe_config_mismatch [i915]] [CRTC:72:pipe B] fastset mismatch in infoframes.enable (expected 0x00000004, found 0x00000000)
<7> [96.844378] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] [PLANE:68:cursor B] ddb ( 859 - 892) -> ( 0 - 0), size 33 -> 0
<7> [96.844960] i915 0000:00:02.0: [drm:intel_modeset_calc_cdclk [i915]] New cdclk calculated to be logical 337500 kHz, actual 337500 kHz
<7> [96.845331] i915 0000:00:02.0: [drm:intel_modeset_calc_cdclk [i915]] New voltage level calculated to be logical 0, actual 0
<7> [96.845781] i915 0000:00:02.0: [drm:intel_dump_pipe_config [i915]] [CRTC:72:pipe B] enable: no [modeset]
<7> [96.846126] i915 0000:00:02.0: [drm:intel_dump_pipe_config [i915]] [PLANE:52:plane 1B] fb: [NOFB], visible: no
<7> [96.846486] i915 0000:00:02.0: [drm:intel_dump_pipe_config [i915]] [PLANE:60:plane 2B] fb: [NOFB], visible: no
<7> [96.846916] i915 0000:00:02.0: [drm:intel_dump_pipe_config [i915]] [PLANE:68:cursor B] fb: [NOFB], visible: no
<7> [96.848124] i915 0000:00:02.0: [drm:intel_psr_disable_locked [i915]] Disabling PSR1
<7> [96.854966] i915 0000:00:02.0: [drm:edp_panel_vdd_on [i915]] Turning [ENCODER:94:DDI A] VDD on
<7> [96.855669] i915 0000:00:02.0: [drm:edp_panel_vdd_on [i915]] PP_STATUS: 0x80000008 PP_CONTROL: 0x0000000f
<7> [96.858481] i915 0000:00:02.0: [drm:intel_edp_backlight_off [i915]]
<7> [97.066858] i915 0000:00:02.0: [drm:intel_panel_actually_set_backlight [i915]] set backlight PWM = 0
<7> [97.067542] i915 0000:00:02.0: [drm:intel_disable_pipe [i915]] disabling pipe B
<7> [97.071941] i915 0000:00:02.0: [drm:intel_edp_panel_off.part.52 [i915]] Turn [ENCODER:94:DDI A] panel power off
<7> [97.072534] i915 0000:00:02.0: [drm:intel_edp_panel_off.part.52 [i915]] Wait for panel power off time
<7> [97.073352] i915 0000:00:02.0: [drm:wait_panel_status [i915]] mask b0000000 value 00000000 status a0000002 control 00000000
<7> [97.123791] i915 0000:00:02.0: [drm:wait_panel_status [i915]] Wait complete
<7> [97.124185] i915 0000:00:02.0: [drm:intel_power_well_disable [i915]] disabling DDI A/E IO power well
<7> [97.125633] i915 0000:00:02.0: [drm:gen8_de_irq_handler [i915]] hotplug event received, stat 0x01000000, dig 0x12101010, pins 0x00000010, long 0x00000010
<7> [97.126086] i915 0000:00:02.0: [drm:intel_disable_shared_dpll [i915]] disable DPLL 0 (active 2, on? 1) for crtc 72
<7> [97.126506] i915 0000:00:02.0: [drm:intel_hpd_irq_handler [i915]] digital hpd on [ENCODER:94:DDI A] - long
<7> [97.126935] i915 0000:00:02.0: [drm:intel_hpd_irq_handler [i915]] Received HPD interrupt on PIN 4 - cnt: 10
<7> [97.127465] i915 0000:00:02.0: [drm:intel_dp_hpd_pulse [i915]] ignoring long hpd on eDP [ENCODER:94:DDI A]
<7> [97.127883] i915 0000:00:02.0: [drm:intel_disable_shared_dpll [i915]] disabling DPLL 0
<7> [97.128615] i915 0000:00:02.0: [drm:intel_atomic_commit_tail [i915]] [ENCODER:94:DDI A]
<7> [97.129291] i915 0000:00:02.0: [drm:intel_atomic_commit_tail [i915]] [ENCODER:102:DDI B]
<7> [97.129827] i915 0000:00:02.0: [drm:intel_atomic_commit_tail [i915]] [ENCODER:104:DP-MST A]
<7> [97.130311] i915 0000:00:02.0: [drm:intel_atomic_commit_tail [i915]] [ENCODER:105:DP-MST B]
<7> [97.130893] i915 0000:00:02.0: [drm:intel_atomic_commit_tail [i915]] [ENCODER:106:DP-MST C]
<7> [97.131497] i915 0000:00:02.0: [drm:intel_atomic_commit_tail [i915]] [ENCODER:116:DDI C]
<7> [97.132085] i915 0000:00:02.0: [drm:intel_atomic_commit_tail [i915]] [ENCODER:118:DP-MST A]
<7> [97.132515] i915 0000:00:02.0: [drm:intel_atomic_commit_tail [i915]] [ENCODER:119:DP-MST B]
<7> [97.133170] i915 0000:00:02.0: [drm:intel_atomic_commit_tail [i915]] [ENCODER:120:DP-MST C]
<7> [97.133660] i915 0000:00:02.0: [drm:verify_connector_state [i915]] [CONNECTOR:95:eDP-1]
<7> [97.134313] i915 0000:00:02.0: [drm:verify_single_dpll_state.isra.147 [i915]] DPLL 0
<7> [97.134913] i915 0000:00:02.0: [drm:verify_single_dpll_state.isra.147 [i915]] DPLL 1
<7> [97.135456] i915 0000:00:02.0: [drm:verify_single_dpll_state.isra.147 [i915]] DPLL 2
<7> [97.136131] i915 0000:00:02.0: [drm:verify_single_dpll_state.isra.147 [i915]] DPLL 3
<7> [97.136950] i915 0000:00:02.0: [drm:intel_power_well_disable [i915]] disabling power well 2
<7> [97.137951] i915 0000:00:02.0: [drm:intel_atomic_commit_tail [i915]] [CRTC:72:pipe B]
<7> [97.138628] i915 0000:00:02.0: [drm:intel_power_well_disable [i915]] disabling DC off
<7> [97.139351] i915 0000:00:02.0: [drm:skl_enable_dc6 [i915]] Enabling DC6
<7> [97.139966] i915 0000:00:02.0: [drm:gen9_set_dc_state [i915]] Setting DC state from 00 to 02
<7> [97.141433] i915 0000:00:02.0: [drm:intel_power_well_disable [i915]] disabling always-on
<7> [97.142661] i915 Wakeref last acquired:
track_intel_runtime_pm_wakeref+0x14/0x90 [i915]
intel_atomic_commit+0x26/0x440 [i915]
drm_atomic_helper_set_config+0x57/0xa0
drm_mode_setcrtc+0x1c4/0x720
drm_ioctl_kernel+0xb0/0xf0
drm_ioctl+0x305/0x3c0
ksys_ioctl+0x7b/0x90
__x64_sys_ioctl+0x11/0x20
<7> [97.144831] i915 Wakeref last released:
__untrack_all_wakerefs+0x6f/0x80 [i915]
__intel_wakeref_dec_and_check_tracking+0x61/0x80 [i915]
__intel_runtime_pm_put+0x131/0x2a0 [i915]
intel_atomic_commit_tail+0x882/0x1470 [i915]
intel_atomic_commit+0x3d8/0x440 [i915]
drm_atomic_helper_set_config+0x57/0xa0
drm_mode_setcrtc+0x1c4/0x720
drm_ioctl_kernel+0xb0/0xf0
<7> [97.144864] i915 Wakeref count: 8
<7> [97.148390] i915 Wakeref x1 taken at:
track_intel_runtime_pm_wakeref+0x14/0x90 [i915]
intel_display_power_get+0x1f/0x60 [i915]
intel_ddi_pre_pll_enable+0x6e/0x120 [i915]
intel_encoders_pre_pll_enable+0x79/0x90 [i915]
hsw_crtc_enable+0x64/0x630 [i915]
intel_enable_crtc+0x4e/0x60 [i915]
skl_commit_modeset_enables+0x31b/0x520 [i915]
intel_atomic_commit_tail+0x319/0x1470 [i915]
<7> [97.153116] i915 Wakeref x1 taken at:
track_intel_runtime_pm_wakeref+0x14/0x90 [i915]
intel_display_power_get+0x1f/0x60 [i915]
intel_ddi_pre_enable+0x19a/0xdb0 [i915]
intel_encoders_pre_enable+0x79/0x90 [i915]
hsw_crtc_enable+0x81/0x630 [i915]
intel_enable_crtc+0x4e/0x60 [i915]
skl_commit_modeset_enables+0x31b/0x520 [i915]
intel_atomic_commit_tail+0x319/0x1470 [i915]
<7> [97.155677] i915 Wakeref x1 taken at:
track_intel_runtime_pm_wakeref+0x14/0x90 [i915]
intel_display_power_get+0x1f/0x60 [i915]
edp_panel_vdd_on+0xd5/0x220 [i915]
intel_dp_aux_xfer+0xeb/0x9c0 [i915]
intel_dp_aux_transfer+0x12f/0x270 [i915]
drm_dp_dpcd_access+0x76/0x110
drm_dp_dpcd_write+0x2a/0xb0
intel_dp_sink_dpms+0x58/0x110 [i915]
<7> [97.157844] i915 Wakeref x4 taken at:
track_intel_runtime_pm_wakeref+0x14/0x90 [i915]
intel_display_power_get+0x1f/0x60 [i915]
modeset_get_crtc_power_domains+0x123/0x140 [i915]
intel_atomic_commit_tail+0xd4/0x1470 [i915]
intel_atomic_commit+0x3d8/0x440 [i915]
drm_atomic_helper_set_config+0x57/0xa0
drm_mode_setcrtc+0x1c4/0x720
drm_ioctl_kernel+0xb0/0xf0
<7> [97.160665] i915 Wakeref x1 taken at:
track_intel_runtime_pm_wakeref+0x14/0x90 [i915]
intel_display_power_get+0x1f/0x60 [i915]
edp_panel_vdd_on+0xd5/0x220 [i915]
intel_dp_aux_xfer+0xeb/0x9c0 [i915]
intel_dp_aux_transfer+0x12f/0x270 [i915]
drm_dp_dpcd_access+0x76/0x110
drm_dp_dpcd_write+0x2a/0xb0
intel_psr_disable_locked+0xf5/0x1b0 [i915]
<7> [97.161609] [drm:drm_mode_setcrtc] [CRTC:93:pipe C]
<7> [97.163514] [drm:drm_mode_setcrtc] [CRTC:93:pipe C]
<7> [97.163684] [drm:drm_mode_setcrtc] [CONNECTOR:95:eDP-1]
<7> [97.164499] i915 0000:00:02.0: [drm:intel_atomic_check [i915]] [CONNECTOR:95:eDP-1] Limiting display bpp to 24 instead of EDID bpp 24, requested bpp 36, max platform bpp 36
<7> [97.165210] i915 0000:00:02.0: [drm:intel_dp_compute_config [i915]] DP link computation with max lane count 4 max rate 270000 max bpp 24 pixel clock 252750KHz
<7> [97.165810] i915 0000:00:02.0: [drm:intel_dp_compute_config [i915]] Force DSC en = 0
<7> [97.166284] i915 0000:00:02.0: [drm:intel_dp_compute_config [i915]] DP lane count 4 clock 270000 bpp 24
<7> [97.166918] i915 0000:00:02.0: [drm:intel_dp_compute_config [i915]] DP link rate required 758250 available 1080000
<7> [97.167491] i915 0000:00:02.0: [drm:intel_atomic_check [i915]] hw max bpp: 24, pipe bpp: 24, dithering: 0
<7> [97.168126] i915 0000:00:02.0: [drm:intel_ddi_compute_config_late [i915]] [ENCODER:94:DDI A] [CRTC:93:pipe C]
<7> [97.168607] i915 0000:00:02.0: [drm:pipe_config_mismatch [i915]] [CRTC:93:pipe C] fastset mismatch in cpu_transcoder (expected 2, found 4)
<7> [97.169106] i915 0000:00:02.0: [drm:pipe_config_mismatch [i915]] [CRTC:93:pipe C] fastset mismatch in lane_count (expected 0, found 4)
<7> [97.169558] i915 0000:00:02.0: [drm:pipe_config_mismatch [i915]] [CRTC:93:pipe C] fastset mismatch in dp_m_n (expected tu 0 gmch 0/0 link 0/0, or tu 0 gmch 0/0 link 0/0, found tu 64, gmch 5889501/8388608 link 490791/524288)
<7> [97.170126] i915 0000:00:02.0: [drm:pipe_config_mismatch [i915]] [CRTC:93:pipe C] fastset mismatch in output_types (expected 0x00000000, found 0x00000100)
<7> [97.170580] i915 0000:00:02.0: [drm:pipe_config_mismatch [i915]] [CRTC:93:pipe C] fastset mismatch in hw.adjusted_mode.crtc_hdisplay (expected 0, found 2400)
<7> [97.171123] i915 0000:00:02.0: [drm:pipe_config_mismatch [i915]] [CRTC:93:pipe C] fastset mismatch in hw.adjusted_mode.crtc_htotal (expected 0, found 2560)
<7> [97.171570] i915 0000:00:02.0: [drm:pipe_config_mismatch [i915]] [CRTC:93:pipe C] fastset mismatch in hw.adjusted_mode.crtc_hblank_start (expected 0, found 2400)
<7> [97.172154] i915 0000:00:02.0: [drm:pipe_config_mismatch [i915]] [CRTC:93:pipe C] fastset mismatch in hw.adjusted_mode.crtc_hblank_end (expected 0, found 2560)
<7> [97.172600] i915 0000:00:02.0: [drm:pipe_config_mismatch [i915]] [CRTC:93:pipe C] fastset mismatch in hw.adjusted_mode.crtc_hsync_start (expected 0, found 2448)
<7> [97.173131] i915 0000:00:02.0: [drm:pipe_config_mismatch [i915]] [CRTC:93:pipe C] fastset mismatch in hw.adjusted_mode.crtc_hsync_end (expected 0, found 2480)
<7> [97.173578] i915 0000:00:02.0: [drm:pipe_config_mismatch [i915]] [CRTC:93:pipe C] fastset mismatch in hw.adjusted_mode.crtc_vdisplay (expected 0, found 1600)
<7> [97.174144] i915 0000:00:02.0: [drm:pipe_config_mismatch [i915]] [CRTC:93:pipe C] fastset mismatch in hw.adjusted_mode.crtc_vtotal (expected 0, found 1646)
<7> [97.174590] i915 0000:00:02.0: [drm:pipe_config_mismatch [i915]] [CRTC:93:pipe C] fastset mismatch in hw.adjusted_mode.crtc_vblank_start (expected 0, found 1600)
<7> [97.175105] i915 0000:00:02.0: [drm:pipe_config_mismatch [i915]] [CRTC:93:pipe C] fastset mismatch in hw.adjusted_mode.crtc_vblank_end (expected 0, found 1646)
<7> [97.175549] i915 0000:00:02.0: [drm:pipe_config_mismatch [i915]] [CRTC:93:pipe C] fastset mismatch in hw.adjusted_mode.crtc_vsync_start (expected 0, found 1603)
<7> [97.176124] i915 0000:00:02.0: [drm:pipe_config_mismatch [i915]] [CRTC:93:pipe C] fastset mismatch in hw.adjusted_mode.crtc_vsync_end (expected 0, found 1613)
<7> [97.176567] i915 0000:00:02.0: [drm:pipe_config_mismatch [i915]] [CRTC:93:pipe C] fastset mismatch in pixel_multiplier (expected 0, found 1)
<7> [97.177141] i915 0000:00:02.0: [drm:pipe_config_mismatch [i915]] [CRTC:93:pipe C] fastset mismatch in output_format (expected 0, found 1)
<7> [97.177611] i915 0000:00:02.0: [drm:pipe_config_mismatch [i915]] [CRTC:93:pipe C] fastset mismatch in hw.adjusted_mode.flags (2) (expected 0, found 2)
<7> [97.178254] i915 0000:00:02.0: [drm:pipe_config_mismatch [i915]] [CRTC:93:pipe C] fastset mismatch in hw.adjusted_mode.flags (8) (expected 0, found 8)
<7> [97.178804] i915 0000:00:02.0: [drm:pipe_config_mismatch [i915]] [CRTC:93:pipe C] fastset mismatch in pipe_bpp (expected 0, found 24)
<7> [97.179147] i915 0000:00:02.0: [drm:pipe_config_mismatch [i915]] [CRTC:93:pipe C] fastset mismatch in hw.adjusted_mode.crtc_clock (expected 0, found 252750)
<7> [97.179558] i915 0000:00:02.0: [drm:pipe_config_mismatch [i915]] [CRTC:93:pipe C] fastset mismatch in port_clock (expected 0, found 270000)
<7> [97.180153] i915 0000:00:02.0: [drm:pipe_config_mismatch [i915]] [CRTC:93:pipe C] fastset mismatch in infoframes.enable (expected 0x00000000, found 0x00000004)
<7> [97.180816] i915 0000:00:02.0: [drm:skl_allocate_pipe_ddb [i915]] [CRTC:93:pipe C] dbuf slices 0x1, ddb (0 - 892), active pipes 0x4
<7> [97.181428] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] [PLANE:73:plane 1C] ddb ( 0 - 0) -> ( 0 - 859), size 0 -> 859
<7> [97.181898] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] [PLANE:89:cursor C] ddb ( 0 - 0) -> ( 859 - 892), size 0 -> 33
<7> [97.182188] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] [PLANE:73:plane 1C] level wm0, wm1, wm2, wm3, wm4, wm5, wm6, wm7, twm, swm -> *wm0,*wm1,*wm2,*wm3,*wm4,*wm5,*wm6,*wm7, twm, swm
<7> [97.182617] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] [PLANE:73:plane 1C] lines 0, 0, 0, 0, 0, 0, 0, 0, 0, 0 -> 0, 2, 3, 4, 7, 8, 9, 10, 0, 0
<7> [97.182943] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] [PLANE:73:plane 1C] blocks 0, 0, 0, 0, 0, 0, 0, 0, 0, 0 -> 5, 40, 58, 66, 127, 155, 166, 198, 0, 0
<7> [97.183234] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] [PLANE:73:plane 1C] min_ddb 0, 0, 0, 0, 0, 0, 0, 0, 0, 0 -> 6, 41, 59, 67, 128, 156, 167, 199, 0, 0
<7> [97.183959] i915 0000:00:02.0: [drm:intel_plane_calc_min_cdclk [i915]] [PLANE:73:plane 1C] min cdclk (252750 kHz) > [CRTC:93:pipe C] min cdclk (0 kHz)
<7> [97.184478] i915 0000:00:02.0: [drm:intel_modeset_calc_cdclk [i915]] New cdclk calculated to be logical 337500 kHz, actual 337500 kHz
<7> [97.185161] i915 0000:00:02.0: [drm:intel_modeset_calc_cdclk [i915]] New voltage level calculated to be logical 0, actual 0
<7> [97.185661] i915 0000:00:02.0: [drm:intel_find_shared_dpll [i915]] [CRTC:93:pipe C] allocated DPLL 0
<7> [97.186312] i915 0000:00:02.0: [drm:intel_reference_shared_dpll.isra.20 [i915]] using DPLL 0 for pipe C
<7> [97.186899] i915 0000:00:02.0: [drm:intel_dump_pipe_config [i915]] [CRTC:93:pipe C] enable: yes [modeset]
<7> [97.187308] i915 0000:00:02.0: [drm:intel_dump_pipe_config [i915]] active: yes, output_types: EDP (0x100), output format: RGB
<7> [97.187961] i915 0000:00:02.0: [drm:intel_dump_pipe_config [i915]] cpu_transcoder: EDP, pipe bpp: 24, dithering: 0
<7> [97.188445] i915 0000:00:02.0: [drm:intel_dump_pipe_config [i915]] port sync: master transcoder: <invalid>, slave transcoder bitmask = 0x0
<7> [97.189007] i915 0000:00:02.0: [drm:intel_dump_m_n_config.isra.103 [i915]] dp m_n: lanes: 4; gmch_m: 5889501, gmch_n: 8388608, link_m: 490791, link_n: 524288, tu: 64
<7> [97.189421] i915 0000:00:02.0: [drm:intel_dump_pipe_config [i915]] audio: 0, infoframes: 0, infoframes enabled: 0x4
<7> [97.189601] i915 0000:00:02.0: DP SDP: VSC, revision 0, length 0
<7> [97.189628] i915 0000:00:02.0: pixelformat: RGB
<7> [97.189656] i915 0000:00:02.0: colorimetry: sRGB
<7> [97.189684] i915 0000:00:02.0: bpc: 0
<7> [97.189715] i915 0000:00:02.0: dynamic range: VESA range
<7> [97.189743] i915 0000:00:02.0: content type: Not defined
<7> [97.190147] i915 0000:00:02.0: [drm:intel_dump_pipe_config [i915]] requested mode:
<7> [97.190199] [drm:drm_mode_debug_printmodeline] Modeline "2400x1600": 60 252750 2400 2448 2480 2560 1600 1603 1613 1646 0x48 0xa
<7> [97.190693] i915 0000:00:02.0: [drm:intel_dump_pipe_config [i915]] adjusted mode:
<7> [97.190742] [drm:drm_mode_debug_printmodeline] Modeline "2400x1600": 60 252750 2400 2448 2480 2560 1600 1603 1613 1646 0x48 0xa
<7> [97.191144] i915 0000:00:02.0: [drm:intel_dump_pipe_config [i915]] crtc timings: 252750 2400 2448 2480 2560 1600 1603 1613 1646, type: 0x48 flags: 0xa
<7> [97.191615] i915 0000:00:02.0: [drm:intel_dump_pipe_config [i915]] port clock: 270000, pipe src size: 2400x1600, pixel rate 252750
<7> [97.192245] i915 0000:00:02.0: [drm:intel_dump_pipe_config [i915]] linetime: 82, ips linetime: 0
<7> [97.192798] i915 0000:00:02.0: [drm:intel_dump_pipe_config [i915]] num_scalers: 1, scaler_users: 0x0, scaler_id: -1
<7> [97.193195] i915 0000:00:02.0: [drm:intel_dump_pipe_config [i915]] pch pfit: 0x0+0+0, disabled, force thru: no
<7> [97.193740] i915 0000:00:02.0: [drm:intel_dump_pipe_config [i915]] ips: 0, double wide: 0
<7> [97.194211] i915 0000:00:02.0: [drm:intel_dump_pipe_config [i915]] dpll_hw_state: ctrl1: 0x3, cfgcr1: 0x0, cfgcr2: 0x0
<7> [97.194742] i915 0000:00:02.0: [drm:intel_dump_pipe_config [i915]] csc_mode: 0x2 gamma_mode: 0x0 gamma_enable: 0 csc_enable: 0
<7> [97.195141] i915 0000:00:02.0: [drm:intel_dump_pipe_config [i915]] MST master transcoder: <invalid>
<7> [97.195624] i915 0000:00:02.0: [drm:intel_dump_pipe_config [i915]] [PLANE:73:plane 1C] fb: [FB:128] 2400x1600 format = XR24 little-endian (0x34325258), visible: yes
<7> [97.196196] i915 0000:00:02.0: [drm:intel_dump_pipe_config [i915]] rotation: 0x1, scaler: -1
<7> [97.196745] i915 0000:00:02.0: [drm:intel_dump_pipe_config [i915]] src: 2400.000000x1600.000000+0.000000+0.000000 dst: 2400x1600+0+0
<7> [97.197143] i915 0000:00:02.0: [drm:intel_dump_pipe_config [i915]] [PLANE:81:plane 2C] fb: [NOFB], visible: no
<7> [97.197614] i915 0000:00:02.0: [drm:intel_dump_pipe_config [i915]] [PLANE:89:cursor C] fb: [NOFB], visible: no
<7> [97.202898] i915 0000:00:02.0: [drm:intel_power_well_enable [i915]] enabling always-on
<7> [97.203372] i915 0000:00:02.0: [drm:intel_power_well_enable [i915]] enabling DC off
<7> [97.204394] i915 0000:00:02.0: [drm:gen9_set_dc_state [i915]] Setting DC state from 02 to 00
<7> [97.205494] i915 0000:00:02.0: [drm:intel_power_well_enable [i915]] enabling power well 2
<7> [97.206507] i915 0000:00:02.0: [drm:intel_atomic_commit_tail [i915]] [ENCODER:94:DDI A]
<7> [97.207114] i915 0000:00:02.0: [drm:intel_atomic_commit_tail [i915]] [ENCODER:102:DDI B]
<7> [97.207593] i915 0000:00:02.0: [drm:intel_atomic_commit_tail [i915]] [ENCODER:104:DP-MST A]
<7> [97.208196] i915 0000:00:02.0: [drm:intel_atomic_commit_tail [i915]] [ENCODER:105:DP-MST B]
<7> [97.208717] i915 0000:00:02.0: [drm:intel_atomic_commit_tail [i915]] [ENCODER:106:DP-MST C]
<7> [97.209200] i915 0000:00:02.0: [drm:intel_atomic_commit_tail [i915]] [ENCODER:116:DDI C]
<7> [97.209768] i915 0000:00:02.0: [drm:intel_atomic_commit_tail [i915]] [ENCODER:118:DP-MST A]
<7> [97.210199] i915 0000:00:02.0: [drm:intel_atomic_commit_tail [i915]] [ENCODER:119:DP-MST B]
<7> [97.210773] i915 0000:00:02.0: [drm:intel_atomic_commit_tail [i915]] [ENCODER:120:DP-MST C]
<7> [97.211176] i915 0000:00:02.0: [drm:verify_single_dpll_state.isra.147 [i915]] DPLL 0
<7> [97.211822] i915 0000:00:02.0: [drm:verify_single_dpll_state.isra.147 [i915]] DPLL 1
<7> [97.212305] i915 0000:00:02.0: [drm:verify_single_dpll_state.isra.147 [i915]] DPLL 2
<7> [97.212940] i915 0000:00:02.0: [drm:verify_single_dpll_state.isra.147 [i915]] DPLL 3
<7> [97.213547] i915 0000:00:02.0: [drm:intel_enable_shared_dpll [i915]] enable DPLL 0 (active 4, on? 0) for crtc 93
<7> [97.214147] i915 0000:00:02.0: [drm:intel_enable_shared_dpll [i915]] enabling DPLL 0
<7> [97.214895] i915 0000:00:02.0: [drm:edp_panel_on [i915]] Turn [ENCODER:94:DDI A] panel power on
<7> [97.215355] i915 0000:00:02.0: [drm:wait_panel_power_cycle [i915]] Wait for panel power cycle
<7> [97.770955] i915 0000:00:02.0: [drm:wait_panel_status [i915]] mask b800000f value 00000000 status 00000000 control 00000000
<7> [97.771370] i915 0000:00:02.0: [drm:wait_panel_status [i915]] Wait complete
<7> [97.772071] i915 0000:00:02.0: [drm:edp_panel_on [i915]] Wait for panel power on
<7> [97.772863] i915 0000:00:02.0: [drm:wait_panel_status [i915]] mask b000000f value 80000008 status 9000000a control 00000003
<7> [97.833108] i915 0000:00:02.0: [drm:gen8_de_irq_handler [i915]] hotplug event received, stat 0x01000000, dig 0x12101010, pins 0x00000010, long 0x00000010
<7> [97.833517] i915 0000:00:02.0: [drm:intel_hpd_irq_handler [i915]] digital hpd on [ENCODER:94:DDI A] - long
<7> [97.833920] i915 0000:00:02.0: [drm:intel_hpd_irq_handler [i915]] Received HPD interrupt on PIN 4 - cnt: 20
<7> [97.834495] i915 0000:00:02.0: [drm:intel_dp_hpd_pulse [i915]] ignoring long hpd on eDP [ENCODER:94:DDI A]
<7> [97.972829] i915 0000:00:02.0: [drm:wait_panel_status [i915]] Wait complete
<7> [97.973293] i915 0000:00:02.0: [drm:intel_power_well_enable [i915]] enabling DDI A/E IO power well
<7> [97.974550] i915 0000:00:02.0: [drm:edp_panel_vdd_on [i915]] Turning [ENCODER:94:DDI A] VDD on
<7> [97.975280] i915 0000:00:02.0: [drm:edp_panel_vdd_on [i915]] PP_STATUS: 0x80000008 PP_CONTROL: 0x0000000b
<7> [97.977549] i915 0000:00:02.0: [drm:intel_dp_start_link_train [i915]] Using LINK_BW_SET value 0a
<7> [97.979672] i915 0000:00:02.0: [drm:intel_dp_set_signal_levels [i915]] Using vswing level 0
<7> [97.980452] i915 0000:00:02.0: [drm:intel_dp_set_signal_levels [i915]] Using pre-emphasis level 0
<7> [97.981094] i915 0000:00:02.0: [drm:hsw_set_signal_levels [i915]] Using signal levels 00000000
<7> [97.981649] i915 0000:00:02.0: [drm:intel_dp_program_link_training_pattern [i915]] Using DP training pattern TPS1
<7> [97.985461] i915 0000:00:02.0: [drm:intel_dp_start_link_train [i915]] clock recovery OK
<7> [97.986078] i915 0000:00:02.0: [drm:intel_dp_program_link_training_pattern [i915]] Using DP training pattern TPS2
<7> [97.990298] i915 0000:00:02.0: [drm:intel_dp_set_signal_levels [i915]] Using vswing level 0
<7> [97.990786] i915 0000:00:02.0: [drm:intel_dp_set_signal_levels [i915]] Using pre-emphasis level 1
<7> [97.991129] i915 0000:00:02.0: [drm:hsw_set_signal_levels [i915]] Using signal levels 01000000
<7> [97.994809] i915 0000:00:02.0: [drm:intel_dp_set_signal_levels [i915]] Using vswing level 0
<7> [97.995318] i915 0000:00:02.0: [drm:intel_dp_set_signal_levels [i915]] Using pre-emphasis level 2
<7> [97.995987] i915 0000:00:02.0: [drm:hsw_set_signal_levels [i915]] Using signal levels 02000000
<7> [97.999871] i915 0000:00:02.0: [drm:intel_dp_set_signal_levels [i915]] Using vswing level 0
<7> [98.000602] i915 0000:00:02.0: [drm:intel_dp_set_signal_levels [i915]] Using pre-emphasis level 0
<7> [98.001232] i915 0000:00:02.0: [drm:hsw_set_signal_levels [i915]] Using signal levels 00000000
<7> [98.004998] i915 0000:00:02.0: [drm:intel_dp_start_link_train [i915]] Channel EQ done. DP Training successful
<7> [98.005522] i915 0000:00:02.0: [drm:intel_dp_start_link_train [i915]] [CONNECTOR:95:eDP-1] Link Training Passed at Link Rate = 270000, Lane count = 4
<7> [98.007299] i915 0000:00:02.0: [drm:intel_enable_pipe [i915]] enabling pipe C
<7> [98.008203] i915 0000:00:02.0: [drm:intel_edp_backlight_on [i915]]
<7> [98.008819] i915 0000:00:02.0: [drm:intel_panel_enable_backlight [i915]] pipe C
<7> [98.009495] i915 0000:00:02.0: [drm:intel_panel_actually_set_backlight [i915]] set backlight PWM = 187
<7> [98.010228] i915 0000:00:02.0: [drm:intel_psr_enable_locked [i915]] Enabling PSR1
<7> [98.012350] i915 0000:00:02.0: [drm:intel_enable_ddi [i915]] Panel doesn't support DRRS
<7> [98.025595] i915 0000:00:02.0: [drm:verify_connector_state [i915]] [CONNECTOR:95:eDP-1]
<7> [98.026224] i915 0000:00:02.0: [drm:intel_atomic_commit_tail [i915]] [CRTC:93:pipe C]
<7> [98.027625] i915 0000:00:02.0: [drm:verify_single_dpll_state.isra.147 [i915]] DPLL 0
<6> [99.392134] [IGT] kms_flip: exiting, ret=98
<6> [99.428570] Console: switching to colour frame buffer device 300x100
<7> [99.533237] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] [PLANE:73:plane 1C] ddb ( 0 - 859) -> ( 0 - 0), size 859 -> 0
<7> [99.533637] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] [PLANE:73:plane 1C] level *wm0,*wm1,*wm2,*wm3,*wm4,*wm5,*wm6,*wm7, twm, swm -> wm0, wm1, wm2, wm3, wm4, wm5, wm6, wm7, twm, swm
<7> [99.533859] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] [PLANE:73:plane 1C] lines 0, 2, 3, 4, 7, 8, 9, 10, 0, 0 -> 0, 0, 0, 0, 0, 0, 0, 0, 0, 0
<7> [99.534073] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] [PLANE:73:plane 1C] blocks 5, 40, 58, 66, 127, 155, 166, 198, 0, 0 -> 0, 0, 0, 0, 0, 0, 0, 0, 0, 0
<7> [99.534283] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] [PLANE:73:plane 1C] min_ddb 6, 41, 59, 67, 128, 156, 167, 199, 0, 0 -> 0, 0, 0, 0, 0, 0, 0, 0, 0, 0
<7> [99.587064] i915 0000:00:02.0: [drm:intel_atomic_check [i915]] [CONNECTOR:95:eDP-1] Limiting display bpp to 24 instead of EDID bpp 24, requested bpp 36, max platform bpp 36
<7> [99.589328] i915 0000:00:02.0: [drm:intel_dp_compute_config [i915]] DP link computation with max lane count 4 max rate 270000 max bpp 24 pixel clock 252750KHz
<7> [99.589943] i915 0000:00:02.0: [drm:intel_dp_compute_config [i915]] Force DSC en = 0
<7> [99.590439] i915 0000:00:02.0: [drm:intel_dp_compute_config [i915]] DP lane count 4 clock 270000 bpp 24
<7> [99.591121] i915 0000:00:02.0: [drm:intel_dp_compute_config [i915]] DP link rate required 758250 available 1080000
<7> [99.591800] i915 0000:00:02.0: [drm:intel_atomic_check [i915]] hw max bpp: 24, pipe bpp: 24, dithering: 0
<7> [99.592437] i915 0000:00:02.0: [drm:intel_ddi_compute_config_late [i915]] [ENCODER:94:DDI A] [CRTC:51:pipe A]
<7> [99.593041] i915 0000:00:02.0: [drm:pipe_config_mismatch [i915]] [CRTC:51:pipe A] fastset mismatch in cpu_transcoder (expected -1, found 4)
<7> [99.593531] i915 0000:00:02.0: [drm:pipe_config_mismatch [i915]] [CRTC:51:pipe A] fastset mismatch in lane_count (expected 0, found 4)
<7> [99.594217] i915 0000:00:02.0: [drm:pipe_config_mismatch [i915]] [CRTC:51:pipe A] fastset mismatch in dp_m_n (expected tu 0 gmch 0/0 link 0/0, or tu 0 gmch 0/0 link 0/0, found tu 64, gmch 5889501/8388608 link 490791/524288)
<7> [99.594802] i915 0000:00:02.0: [drm:pipe_config_mismatch [i915]] [CRTC:51:pipe A] fastset mismatch in output_types (expected 0x00000000, found 0x00000100)
<7> [99.596469] i915 0000:00:02.0: [drm:pipe_config_mismatch [i915]] [CRTC:51:pipe A] fastset mismatch in hw.adjusted_mode.crtc_hdisplay (expected 0, found 2400)
<7> [99.597972] i915 0000:00:02.0: [drm:pipe_config_mismatch [i915]] [CRTC:51:pipe A] fastset mismatch in hw.adjusted_mode.crtc_htotal (expected 0, found 2560)
<7> [99.598473] i915 0000:00:02.0: [drm:pipe_config_mismatch [i915]] [CRTC:51:pipe A] fastset mismatch in hw.adjusted_mode.crtc_hblank_start (expected 0, found 2400)
<7> [99.599158] i915 0000:00:02.0: [drm:pipe_config_mismatch [i915]] [CRTC:51:pipe A] fastset mismatch in hw.adjusted_mode.crtc_hblank_end (expected 0, found 2560)
<7> [99.600145] i915 0000:00:02.0: [drm:pipe_config_mismatch [i915]] [CRTC:51:pipe A] fastset mismatch in hw.adjusted_mode.crtc_hsync_start (expected 0, found 2448)
<7> [99.601030] i915 0000:00:02.0: [drm:pipe_config_mismatch [i915]] [CRTC:51:pipe A] fastset mismatch in hw.adjusted_mode.crtc_hsync_end (expected 0, found 2480)
<7> [99.601561] i915 0000:00:02.0: [drm:pipe_config_mismatch [i915]] [CRTC:51:pipe A] fastset mismatch in hw.adjusted_mode.crtc_vdisplay (expected 0, found 1600)
<7> [99.603163] i915 0000:00:02.0: [drm:pipe_config_mismatch [i915]] [CRTC:51:pipe A] fastset mismatch in hw.adjusted_mode.crtc_vtotal (expected 0, found 1646)
<7> [99.603670] i915 0000:00:02.0: [drm:pipe_config_mismatch [i915]] [CRTC:51:pipe A] fastset mismatch in hw.adjusted_mode.crtc_vblank_start (expected 0, found 1600)
<7> [99.604425] i915 0000:00:02.0: [drm:pipe_config_mismatch [i915]] [CRTC:51:pipe A] fastset mismatch in hw.adjusted_mode.crtc_vblank_end (expected 0, found 1646)
<7> [99.605101] i915 0000:00:02.0: [drm:pipe_config_mismatch [i915]] [CRTC:51:pipe A] fastset mismatch in hw.adjusted_mode.crtc_vsync_start (expected 0, found 1603)
<7> [99.605594] i915 0000:00:02.0: [drm:pipe_config_mismatch [i915]] [CRTC:51:pipe A] fastset mismatch in hw.adjusted_mode.crtc_vsync_end (expected 0, found 1613)
<7> [99.606247] i915 0000:00:02.0: [drm:pipe_config_mismatch [i915]] [CRTC:51:pipe A] fastset mismatch in pixel_multiplier (expected 0, found 1)
<7> [99.606903] i915 0000:00:02.0: [drm:pipe_config_mismatch [i915]] [CRTC:51:pipe A] fastset mismatch in output_format (expected 0, found 1)
<7> [99.607390] i915 0000:00:02.0: [drm:pipe_config_mismatch [i915]] [CRTC:51:pipe A] fastset mismatch in hw.adjusted_mode.flags (2) (expected 0, found 2)
<7> [99.608041] i915 0000:00:02.0: [drm:pipe_config_mismatch [i915]] [CRTC:51:pipe A] fastset mismatch in hw.adjusted_mode.flags (8) (expected 0, found 8)
<7> [99.608538] i915 0000:00:02.0: [drm:pipe_config_mismatch [i915]] [CRTC:51:pipe A] fastset mismatch in pipe_bpp (expected 0, found 24)
<7> [99.609168] i915 0000:00:02.0: [drm:pipe_config_mismatch [i915]] [CRTC:51:pipe A] fastset mismatch in hw.adjusted_mode.crtc_clock (expected 0, found 252750)
<7> [99.609647] i915 0000:00:02.0: [drm:pipe_config_mismatch [i915]] [CRTC:51:pipe A] fastset mismatch in port_clock (expected 0, found 270000)
<7> [99.610289] i915 0000:00:02.0: [drm:pipe_config_mismatch [i915]] [CRTC:51:pipe A] fastset mismatch in infoframes.enable (expected 0x00000000, found 0x00000004)
<7> [99.610890] i915 0000:00:02.0: [drm:pipe_config_mismatch [i915]] [CRTC:93:pipe C] fastset mismatch in cpu_transcoder (expected 4, found -1)
<7> [99.611380] i915 0000:00:02.0: [drm:pipe_config_mismatch [i915]] [CRTC:93:pipe C] fastset mismatch in lane_count (expected 4, found 0)
<7> [99.612015] i915 0000:00:02.0: [drm:pipe_config_mismatch [i915]] [CRTC:93:pipe C] fastset mismatch in output_types (expected 0x00000100, found 0x00000000)
<7> [99.612497] i915 0000:00:02.0: [drm:pipe_config_mismatch [i915]] [CRTC:93:pipe C] fastset mismatch in hw.adjusted_mode.crtc_hdisplay (expected 2400, found 0)
<7> [99.613152] i915 0000:00:02.0: [drm:pipe_config_mismatch [i915]] [CRTC:93:pipe C] fastset mismatch in hw.adjusted_mode.crtc_htotal (expected 2560, found 0)
<7> [99.613632] i915 0000:00:02.0: [drm:pipe_config_mismatch [i915]] [CRTC:93:pipe C] fastset mismatch in hw.adjusted_mode.crtc_hblank_start (expected 2400, found 0)
<7> [99.614336] i915 0000:00:02.0: [drm:pipe_config_mismatch [i915]] [CRTC:93:pipe C] fastset mismatch in hw.adjusted_mode.crtc_hblank_end (expected 2560, found 0)
<7> [99.614916] i915 0000:00:02.0: [drm:pipe_config_mismatch [i915]] [CRTC:93:pipe C] fastset mismatch in hw.adjusted_mode.crtc_hsync_start (expected 2448, found 0)
<7> [99.615409] i915 0000:00:02.0: [drm:pipe_config_mismatch [i915]] [CRTC:93:pipe C] fastset mismatch in hw.adjusted_mode.crtc_hsync_end (expected 2480, found 0)
<7> [99.616068] i915 0000:00:02.0: [drm:pipe_config_mismatch [i915]] [CRTC:93:pipe C] fastset mismatch in hw.adjusted_mode.crtc_vdisplay (expected 1600, found 0)
<7> [99.616552] i915 0000:00:02.0: [drm:pipe_config_mismatch [i915]] [CRTC:93:pipe C] fastset mismatch in hw.adjusted_mode.crtc_vtotal (expected 1646, found 0)
<7> [99.617152] i915 0000:00:02.0: [drm:pipe_config_mismatch [i915]] [CRTC:93:pipe C] fastset mismatch in hw.adjusted_mode.crtc_vblank_start (expected 1600, found 0)
<7> [99.617631] i915 0000:00:02.0: [drm:pipe_config_mismatch [i915]] [CRTC:93:pipe C] fastset mismatch in hw.adjusted_mode.crtc_vblank_end (expected 1646, found 0)
<7> [99.618253] i915 0000:00:02.0: [drm:pipe_config_mismatch [i915]] [CRTC:93:pipe C] fastset mismatch in hw.adjusted_mode.crtc_vsync_start (expected 1603, found 0)
<7> [99.618829] i915 0000:00:02.0: [drm:pipe_config_mismatch [i915]] [CRTC:93:pipe C] fastset mismatch in hw.adjusted_mode.crtc_vsync_end (expected 1613, found 0)
<7> [99.619309] i915 0000:00:02.0: [drm:pipe_config_mismatch [i915]] [CRTC:93:pipe C] fastset mismatch in pixel_multiplier (expected 1, found 0)
<7> [99.619885] i915 0000:00:02.0: [drm:pipe_config_mismatch [i915]] [CRTC:93:pipe C] fastset mismatch in output_format (expected 1, found 0)
<7> [99.620365] i915 0000:00:02.0: [drm:pipe_config_mismatch [i915]] [CRTC:93:pipe C] fastset mismatch in hw.adjusted_mode.flags (2) (expected 2, found 0)
<7> [99.620937] i915 0000:00:02.0: [drm:pipe_config_mismatch [i915]] [CRTC:93:pipe C] fastset mismatch in hw.adjusted_mode.flags (8) (expected 8, found 0)
<7> [99.621428] i915 0000:00:02.0: [drm:pipe_config_mismatch [i915]] [CRTC:93:pipe C] fastset mismatch in pipe_bpp (expected 24, found 0)
<7> [99.622028] i915 0000:00:02.0: [drm:pipe_config_mismatch [i915]] [CRTC:93:pipe C] fastset mismatch in hw.adjusted_mode.crtc_clock (expected 252750, found 0)
<7> [99.622512] i915 0000:00:02.0: [drm:pipe_config_mismatch [i915]] [CRTC:93:pipe C] fastset mismatch in port_clock (expected 270000, found 0)
<7> [99.623163] i915 0000:00:02.0: [drm:pipe_config_mismatch [i915]] [CRTC:93:pipe C] fastset mismatch in infoframes.enable (expected 0x00000004, found 0x00000000)
<7> [99.623969] i915 0000:00:02.0: [drm:skl_allocate_pipe_ddb [i915]] [CRTC:51:pipe A] dbuf slices 0x1, ddb (0 - 892), active pipes 0x1
<7> [99.624508] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] [PLANE:31:plane 1A] ddb ( 0 - 0) -> ( 0 - 859), size 0 -> 859
<7> [99.625026] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] [PLANE:47:cursor A] ddb ( 0 - 0) -> ( 859 - 892), size 0 -> 33
<7> [99.625377] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] [PLANE:31:plane 1A] level wm0, wm1, wm2, wm3, wm4, wm5, wm6, wm7, twm, swm -> *wm0,*wm1,*wm2,*wm3,*wm4,*wm5,*wm6,*wm7, twm, swm
<7> [99.625913] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] [PLANE:31:plane 1A] lines 0, 0, 0, 0, 0, 0, 0, 0, 0, 0 -> 0, 2, 3, 4, 7, 8, 9, 10, 0, 0
<7> [99.626263] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] [PLANE:31:plane 1A] blocks 0, 0, 0, 0, 0, 0, 0, 0, 0, 0 -> 5, 40, 58, 66, 127, 155, 166, 198, 0, 0
<7> [99.626766] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] [PLANE:31:plane 1A] min_ddb 0, 0, 0, 0, 0, 0, 0, 0, 0, 0 -> 6, 41, 59, 67, 128, 156, 167, 199, 0, 0
<7> [99.627113] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] [PLANE:89:cursor C] ddb ( 859 - 892) -> ( 0 - 0), size 33 -> 0
<7> [99.627937] i915 0000:00:02.0: [drm:intel_plane_calc_min_cdclk [i915]] [PLANE:31:plane 1A] min cdclk (252750 kHz) > [CRTC:51:pipe A] min cdclk (0 kHz)
<7> [99.628473] i915 0000:00:02.0: [drm:intel_modeset_calc_cdclk [i915]] New cdclk calculated to be logical 337500 kHz, actual 337500 kHz
<7> [99.629385] i915 0000:00:02.0: [drm:intel_modeset_calc_cdclk [i915]] New voltage level calculated to be logical 0, actual 0
<7> [99.630115] i915 0000:00:02.0: [drm:intel_find_shared_dpll [i915]] [CRTC:51:pipe A] allocated DPLL 0
<7> [99.630606] i915 0000:00:02.0: [drm:intel_reference_shared_dpll.isra.20 [i915]] using DPLL 0 for pipe A
<7> [99.631269] i915 0000:00:02.0: [drm:intel_dump_pipe_config [i915]] [CRTC:51:pipe A] enable: yes [modeset]
<7> [99.631914] i915 0000:00:02.0: [drm:intel_dump_pipe_config [i915]] active: yes, output_types: EDP (0x100), output format: RGB
<7> [99.632399] i915 0000:00:02.0: [drm:intel_dump_pipe_config [i915]] cpu_transcoder: EDP, pipe bpp: 24, dithering: 0
<7> [99.632997] i915 0000:00:02.0: [drm:intel_dump_pipe_config [i915]] port sync: master transcoder: <invalid>, slave transcoder bitmask = 0x0
<7> [99.633485] i915 0000:00:02.0: [drm:intel_dump_m_n_config.isra.103 [i915]] dp m_n: lanes: 4; gmch_m: 5889501, gmch_n: 8388608, link_m: 490791, link_n: 524288, tu: 64
<7> [99.634076] i915 0000:00:02.0: [drm:intel_dump_pipe_config [i915]] audio: 0, infoframes: 0, infoframes enabled: 0x4
<7> [99.634722] i915 0000:00:02.0: DP SDP: VSC, revision 0, length 0
<7> [99.634758] i915 0000:00:02.0: pixelformat: RGB
<7> [99.634793] i915 0000:00:02.0: colorimetry: sRGB
<7> [99.634828] i915 0000:00:02.0: bpc: 0
<7> [99.634864] i915 0000:00:02.0: dynamic range: VESA range
<7> [99.634900] i915 0000:00:02.0: content type: Not defined
<7> [99.635381] i915 0000:00:02.0: [drm:intel_dump_pipe_config [i915]] requested mode:
<7> [99.635538] [drm:drm_mode_debug_printmodeline] Modeline "2400x1600": 60 252750 2400 2448 2480 2560 1600 1603 1613 1646 0x48 0xa
<7> [99.636021] i915 0000:00:02.0: [drm:intel_dump_pipe_config [i915]] adjusted mode:
<7> [99.636072] [drm:drm_mode_debug_printmodeline] Modeline "2400x1600": 60 252750 2400 2448 2480 2560 1600 1603 1613 1646 0x48 0xa
<7> [99.636556] i915 0000:00:02.0: [drm:intel_dump_pipe_config [i915]] crtc timings: 252750 2400 2448 2480 2560 1600 1603 1613 1646, type: 0x48 flags: 0xa
<7> [99.637137] i915 0000:00:02.0: [drm:intel_dump_pipe_config [i915]] port clock: 270000, pipe src size: 2400x1600, pixel rate 252750
<7> [99.637620] i915 0000:00:02.0: [drm:intel_dump_pipe_config [i915]] linetime: 82, ips linetime: 0
<7> [99.638227] i915 0000:00:02.0: [drm:intel_dump_pipe_config [i915]] num_scalers: 2, scaler_users: 0x0, scaler_id: -1
<7> [99.638816] i915 0000:00:02.0: [drm:intel_dump_pipe_config [i915]] pch pfit: 0x0+0+0, disabled, force thru: no
<7> [99.639295] i915 0000:00:02.0: [drm:intel_dump_pipe_config [i915]] ips: 0, double wide: 0
<7> [99.639868] i915 0000:00:02.0: [drm:intel_dump_pipe_config [i915]] dpll_hw_state: ctrl1: 0x3, cfgcr1: 0x0, cfgcr2: 0x0
<7> [99.640343] i915 0000:00:02.0: [drm:intel_dump_pipe_config [i915]] csc_mode: 0x2 gamma_mode: 0x0 gamma_enable: 0 csc_enable: 0
<7> [99.640976] i915 0000:00:02.0: [drm:intel_dump_pipe_config [i915]] MST master transcoder: <invalid>
<7> [99.641469] i915 0000:00:02.0: [drm:intel_dump_pipe_config [i915]] [PLANE:31:plane 1A] fb: [FB:127] 2400x1600 format = XR24 little-endian (0x34325258), visible: yes
<7> [99.642057] i915 0000:00:02.0: [drm:intel_dump_pipe_config [i915]] rotation: 0x1, scaler: -1
<7> [99.642544] i915 0000:00:02.0: [drm:intel_dump_pipe_config [i915]] src: 2400.000000x1600.000000+0.000000+0.000000 dst: 2400x1600+0+0
<7> [99.643189] i915 0000:00:02.0: [drm:intel_dump_pipe_config [i915]] [PLANE:39:plane 2A] fb: [NOFB], visible: no
<7> [99.643767] i915 0000:00:02.0: [drm:intel_dump_pipe_config [i915]] [PLANE:47:cursor A] fb: [NOFB], visible: no
<7> [99.644248] i915 0000:00:02.0: [drm:intel_dump_pipe_config [i915]] [CRTC:93:pipe C] enable: no [modeset]
<7> [99.644877] i915 0000:00:02.0: [drm:intel_dump_pipe_config [i915]] [PLANE:73:plane 1C] fb: [NOFB], visible: no
<7> [99.645354] i915 0000:00:02.0: [drm:intel_dump_pipe_config [i915]] [PLANE:81:plane 2C] fb: [NOFB], visible: no
<7> [99.645961] i915 0000:00:02.0: [drm:intel_dump_pipe_config [i915]] [PLANE:89:cursor C] fb: [NOFB], visible: no
<7> [99.650634] i915 0000:00:02.0: [drm:intel_psr_disable_locked [i915]] Disabling PSR1
<7> [99.654528] i915 0000:00:02.0: [drm:intel_edp_backlight_off [i915]]
<7> [99.859014] i915 0000:00:02.0: [drm:intel_panel_actually_set_backlight [i915]] set backlight PWM = 0
<7> [99.860205] i915 0000:00:02.0: [drm:intel_disable_pipe [i915]] disabling pipe C
<7> [99.870463] i915 0000:00:02.0: [drm:intel_edp_panel_off.part.52 [i915]] Turn [ENCODER:94:DDI A] panel power off
<7> [99.871277] i915 0000:00:02.0: [drm:intel_edp_panel_off.part.52 [i915]] Wait for panel power off time
<7> [99.872199] i915 0000:00:02.0: [drm:wait_panel_status [i915]] mask b0000000 value 00000000 status a0000002 control 00000000
<7> [99.922856] i915 0000:00:02.0: [drm:wait_panel_status [i915]] Wait complete
<7> [99.923365] i915 0000:00:02.0: [drm:intel_power_well_disable [i915]] disabling DDI A/E IO power well
<7> [99.924312] i915 0000:00:02.0: [drm:gen8_de_irq_handler [i915]] hotplug event received, stat 0x01000000, dig 0x12101010, pins 0x00000010, long 0x00000010
<7> [99.924797] i915 0000:00:02.0: [drm:intel_disable_shared_dpll [i915]] disable DPLL 0 (active 4, on? 1) for crtc 93
<7> [99.925258] i915 0000:00:02.0: [drm:intel_hpd_irq_handler [i915]] digital hpd on [ENCODER:94:DDI A] - long
<7> [99.925712] i915 0000:00:02.0: [drm:intel_hpd_irq_handler [i915]] Received HPD interrupt on PIN 4 - cnt: 10
<7> [99.926054] i915 0000:00:02.0: [drm:intel_disable_shared_dpll [i915]] disabling DPLL 0
<7> [99.926486] i915 0000:00:02.0: [drm:intel_atomic_commit_tail [i915]] [ENCODER:94:DDI A]
<7> [99.926898] i915 0000:00:02.0: [drm:intel_dp_hpd_pulse [i915]] ignoring long hpd on eDP [ENCODER:94:DDI A]
<7> [99.928135] i915 0000:00:02.0: [drm:intel_atomic_commit_tail [i915]] [ENCODER:102:DDI B]
<7> [99.928641] i915 0000:00:02.0: [drm:intel_atomic_commit_tail [i915]] [ENCODER:104:DP-MST A]
<7> [99.929273] i915 0000:00:02.0: [drm:intel_atomic_commit_tail [i915]] [ENCODER:105:DP-MST B]
<7> [99.930531] i915 0000:00:02.0: [drm:intel_atomic_commit_tail [i915]] [ENCODER:106:DP-MST C]
<7> [99.931264] i915 0000:00:02.0: [drm:intel_atomic_commit_tail [i915]] [ENCODER:116:DDI C]
<7> [99.931928] i915 0000:00:02.0: [drm:intel_atomic_commit_tail [i915]] [ENCODER:118:DP-MST A]
<7> [99.932409] i915 0000:00:02.0: [drm:intel_atomic_commit_tail [i915]] [ENCODER:119:DP-MST B]
<7> [99.933057] i915 0000:00:02.0: [drm:intel_atomic_commit_tail [i915]] [ENCODER:120:DP-MST C]
<7> [99.934012] i915 0000:00:02.0: [drm:verify_single_dpll_state.isra.147 [i915]] DPLL 0
<7> [99.934491] i915 0000:00:02.0: [drm:verify_single_dpll_state.isra.147 [i915]] DPLL 1
<7> [99.935133] i915 0000:00:02.0: [drm:verify_single_dpll_state.isra.147 [i915]] DPLL 2
<7> [99.935642] i915 0000:00:02.0: [drm:verify_single_dpll_state.isra.147 [i915]] DPLL 3
<7> [99.936563] i915 0000:00:02.0: [drm:intel_enable_shared_dpll [i915]] enable DPLL 0 (active 1, on? 0) for crtc 51
<7> [99.937122] i915 0000:00:02.0: [drm:intel_enable_shared_dpll [i915]] enabling DPLL 0
<7> [99.937855] i915 0000:00:02.0: [drm:edp_panel_on [i915]] Turn [ENCODER:94:DDI A] panel power on
<7> [99.938363] i915 0000:00:02.0: [drm:wait_panel_power_cycle [i915]] Wait for panel power cycle
<7> [100.587036] i915 0000:00:02.0: [drm:wait_panel_status [i915]] mask b800000f value 00000000 status 00000000 control 00000000
<7> [100.587461] i915 0000:00:02.0: [drm:wait_panel_status [i915]] Wait complete
<7> [100.588256] i915 0000:00:02.0: [drm:edp_panel_on [i915]] Wait for panel power on
<7> [100.589057] i915 0000:00:02.0: [drm:wait_panel_status [i915]] mask b000000f value 80000008 status 9000000a control 00000003
<7> [100.649341] i915 0000:00:02.0: [drm:gen8_de_irq_handler [i915]] hotplug event received, stat 0x01000000, dig 0x12101010, pins 0x00000010, long 0x00000010
<7> [100.649716] i915 0000:00:02.0: [drm:intel_hpd_irq_handler [i915]] digital hpd on [ENCODER:94:DDI A] - long
<7> [100.650078] i915 0000:00:02.0: [drm:intel_hpd_irq_handler [i915]] Received HPD interrupt on PIN 4 - cnt: 20
<7> [100.650692] i915 0000:00:02.0: [drm:intel_dp_hpd_pulse [i915]] ignoring long hpd on eDP [ENCODER:94:DDI A]
<7> [100.788830] i915 0000:00:02.0: [drm:wait_panel_status [i915]] Wait complete
<7> [100.789330] i915 0000:00:02.0: [drm:intel_power_well_enable [i915]] enabling DDI A/E IO power well
<7> [100.790993] i915 0000:00:02.0: [drm:edp_panel_vdd_on [i915]] Turning [ENCODER:94:DDI A] VDD on
<7> [100.791882] i915 0000:00:02.0: [drm:edp_panel_vdd_on [i915]] PP_STATUS: 0x80000008 PP_CONTROL: 0x0000000b
<7> [100.793828] i915 0000:00:02.0: [drm:intel_dp_start_link_train [i915]] Using LINK_BW_SET value 0a
<7> [100.796005] i915 0000:00:02.0: [drm:intel_dp_set_signal_levels [i915]] Using vswing level 0
<7> [100.796511] i915 0000:00:02.0: [drm:intel_dp_set_signal_levels [i915]] Using pre-emphasis level 0
<7> [100.797187] i915 0000:00:02.0: [drm:hsw_set_signal_levels [i915]] Using signal levels 00000000
<7> [100.797866] i915 0000:00:02.0: [drm:intel_dp_program_link_training_pattern [i915]] Using DP training pattern TPS1
<7> [100.801464] i915 0000:00:02.0: [drm:intel_dp_start_link_train [i915]] clock recovery OK
<7> [100.802103] i915 0000:00:02.0: [drm:intel_dp_program_link_training_pattern [i915]] Using DP training pattern TPS2
<7> [100.806092] i915 0000:00:02.0: [drm:intel_dp_set_signal_levels [i915]] Using vswing level 0
<7> [100.806595] i915 0000:00:02.0: [drm:intel_dp_set_signal_levels [i915]] Using pre-emphasis level 1
<7> [100.807209] i915 0000:00:02.0: [drm:hsw_set_signal_levels [i915]] Using signal levels 01000000
<7> [100.812178] i915 0000:00:02.0: [drm:intel_dp_set_signal_levels [i915]] Using vswing level 0
<7> [100.812676] i915 0000:00:02.0: [drm:intel_dp_set_signal_levels [i915]] Using pre-emphasis level 2
<7> [100.813358] i915 0000:00:02.0: [drm:hsw_set_signal_levels [i915]] Using signal levels 02000000
<7> [100.817393] i915 0000:00:02.0: [drm:intel_dp_set_signal_levels [i915]] Using vswing level 0
<7> [100.818009] i915 0000:00:02.0: [drm:intel_dp_set_signal_levels [i915]] Using pre-emphasis level 0
<7> [100.818909] i915 0000:00:02.0: [drm:hsw_set_signal_levels [i915]] Using signal levels 00000000
<7> [100.822968] i915 0000:00:02.0: [drm:intel_dp_start_link_train [i915]] Channel EQ done. DP Training successful
<7> [100.823507] i915 0000:00:02.0: [drm:intel_dp_start_link_train [i915]] [CONNECTOR:95:eDP-1] Link Training Passed at Link Rate = 270000, Lane count = 4
<7> [100.825339] i915 0000:00:02.0: [drm:intel_enable_pipe [i915]] enabling pipe A
<7> [100.826541] i915 0000:00:02.0: [drm:intel_edp_backlight_on [i915]]
<7> [100.827149] i915 0000:00:02.0: [drm:intel_panel_enable_backlight [i915]] pipe A
<7> [100.827894] i915 0000:00:02.0: [drm:intel_panel_actually_set_backlight [i915]] set backlight PWM = 187
<7> [100.828474] i915 0000:00:02.0: [drm:intel_psr_enable_locked [i915]] Enabling PSR1
<7> [100.831131] i915 0000:00:02.0: [drm:intel_enable_ddi [i915]] Panel doesn't support DRRS
<7> [100.843924] i915 0000:00:02.0: [drm:verify_connector_state [i915]] [CONNECTOR:95:eDP-1]
<7> [100.845260] i915 0000:00:02.0: [drm:intel_atomic_commit_tail [i915]] [CRTC:51:pipe A]
<7> [100.847354] i915 0000:00:02.0: [drm:verify_single_dpll_state.isra.147 [i915]] DPLL 0
<7> [100.847876] i915 0000:00:02.0: [drm:intel_power_well_disable [i915]] disabling power well 2
<7> [100.848783] i915 0000:00:02.0: [drm:intel_atomic_commit_tail [i915]] [CRTC:93:pipe C]
Created at 2020-07-01 18:15:36