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

Result: Fail

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

DetailValue
Duration 2.95 seconds
Hostname 
shard-glk9
Igt-Version 
IGT-Version: 2.2-g79d17ef4e (x86_64) (Linux: 6.19.0-rc1-CI_DRM_17686-g342b565445c9+ 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:923 run_test_on_crtc_set.constprop.0()
  #2 ../tests/kms_flip.c:1974 run_pair()
  #3 ../tests/kms_flip.c:2165 __igt_unique____real_main2045()
  #4 ../tests/kms_flip.c:2045 main()
  #5 [__libc_init_first+0x8a]
  #6 [__libc_start_main+0x8b]
  #7 [_start+0x25]
Dynamic subtest BC-HDMI-A1-HDMI-A2: FAIL (2.949s)
Subtest 2x-flip-vs-expired-vblank-interruptible: FAIL (24.353s)
Stack trace:
  #0 ../lib/igt_core.c:2075 __igt_fail_assert()
  #1 ../lib/igt_kms.c:2386 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:2671) CRITICAL: Test assertion failure function run_test_step, file ../tests/kms_flip.c:928:
(kms_flip:2671) CRITICAL: Failed assertion: end - start < 500
(kms_flip:2671) CRITICAL: Last errno: 4, Interrupted system call
Dynamic subtest BC-HDMI-A1-HDMI-A2 failed.
**** DEBUG ****
(kms_flip:2671) DEBUG: Vblank took 8us
(kms_flip:2671) DEBUG: name = flip
last_ts = 339.588715
last_received_ts = 339.588226
last_seq = 6361
current_ts = 339.605377
current_received_ts = 339.604889
current_seq = 6362
count = 1
seq_step = 1
(kms_flip:2671) DEBUG: Vblank took 8us
(kms_flip:2671) DEBUG: name = flip
last_ts = 339.605377
last_received_ts = 339.604889
last_seq = 6362
current_ts = 339.622040
current_received_ts = 339.621429
current_seq = 6363
count = 2
seq_step = 1
(kms_flip:2671) DEBUG: Vblank took 7us
(kms_flip:2671) DEBUG: name = flip
last_ts = 339.622040
last_received_ts = 339.621429
last_seq = 6363
current_ts = 339.638702
current_received_ts = 339.638092
current_seq = 6364
count = 3
seq_step = 1
(kms_flip:2671) DEBUG: Vblank took 6us
(kms_flip:2671) DEBUG: name = flip
last_ts = 339.638702
last_received_ts = 339.638092
last_seq = 6364
current_ts = 339.655365
current_received_ts = 339.654755
current_seq = 6365
count = 4
seq_step = 1
(kms_flip:2671) DEBUG: Vblank took 6us
(kms_flip:2671) DEBUG: name = flip
last_ts = 339.655365
last_received_ts = 339.654755
last_seq = 6365
current_ts = 339.672028
current_received_ts = 339.671417
current_seq = 6366
count = 5
seq_step = 1
(kms_flip:2671) DEBUG: Vblank took 6us
(kms_flip:2671) DEBUG: name = flip
last_ts = 339.672028
last_received_ts = 339.671417
last_seq = 6366
current_ts = 339.688721
current_received_ts = 339.688080
current_seq = 6367
count = 6
seq_step = 1
(kms_flip:2671) DEBUG: Vblank took 7us
(kms_flip:2671) DEBUG: name = flip
last_ts = 339.688721
last_received_ts = 339.688080
last_seq = 6367
current_ts = 339.705383
current_received_ts = 339.704773
current_seq = 6368
count = 7
seq_step = 1
(kms_flip:2671) DEBUG: Vblank took 6us
(kms_flip:2671) DEBUG: name = flip
last_ts = 339.705383
last_received_ts = 339.704773
last_seq = 6368
current_ts = 339.722046
current_received_ts = 339.721436
current_seq = 6369
count = 8
seq_step = 1
(kms_flip:2671) DEBUG: Vblank took 6us
(kms_flip:2671) DEBUG: name = flip
last_ts = 339.722046
last_received_ts = 339.721436
last_seq = 6369
current_ts = 339.738708
current_received_ts = 339.738068
current_seq = 6370
count = 9
seq_step = 1
(kms_flip:2671) DEBUG: Vblank took 6us
(kms_flip:2671) DEBUG: name = flip
last_ts = 339.738708
last_received_ts = 339.738068
last_seq = 6370
current_ts = 339.755371
current_received_ts = 339.754822
current_seq = 6371
count = 10
seq_step = 1
(kms_flip:2671) DEBUG: Vblank took 15us
(kms_flip:2671) DEBUG: name = flip
last_ts = 339.755371
last_received_ts = 339.754822
last_seq = 6371
current_ts = 339.772034
current_received_ts = 339.772034
current_seq = 6372
count = 11
seq_step = 1
(kms_flip:2671) DEBUG: Vblank took 22us
(kms_flip:2671) DEBUG: name = flip
last_ts = 339.772034
last_received_ts = 339.772034
last_seq = 6372
current_ts = 339.788696
current_received_ts = 339.788483
current_seq = 6373
count = 12
seq_step = 1
(kms_flip:2671) DEBUG: Vblank took 21us
(kms_flip:2671) DEBUG: name = flip
last_ts = 339.788696
last_received_ts = 339.788483
last_seq = 6373
current_ts = 339.805359
current_received_ts = 339.805176
current_seq = 6374
count = 13
seq_step = 1
(kms_flip:2671) DEBUG: Vblank took 24us
(kms_flip:2671) DEBUG: name = flip
last_ts = 339.805359
last_received_ts = 339.805176
last_seq = 6374
current_ts = 339.822021
current_received_ts = 339.821564
current_seq = 6375
count = 14
seq_step = 1
(kms_flip:2671) DEBUG: Vblank took 26us
(kms_flip:2671) DEBUG: name = flip
last_ts = 339.822021
last_received_ts = 339.821564
last_seq = 6375
current_ts = 339.838684
current_received_ts = 339.838501
current_seq = 6376
count = 15
seq_step = 1
(kms_flip:2671) DEBUG: Vblank took 24us
(kms_flip:2671) DEBUG: name = flip
last_ts = 339.838684
last_received_ts = 339.838501
last_seq = 6376
current_ts = 339.855347
current_received_ts = 339.854797
current_seq = 6377
count = 16
seq_step = 1
(kms_flip:2671) DEBUG: Vblank took 21us
(kms_flip:2671) DEBUG: name = flip
last_ts = 339.855347
last_received_ts = 339.854797
last_seq = 6377
current_ts = 339.872009
current_received_ts = 339.871552
current_seq = 6378
count = 17
seq_step = 1
(kms_flip:2671) DEBUG: Vblank took 22us
(kms_flip:2671) DEBUG: name = flip
last_ts = 339.872009
last_received_ts = 339.871552
last_seq = 6378
current_ts = 339.888702
current_received_ts = 339.888550
current_seq = 6379
count = 18
seq_step = 1
(kms_flip:2671) DEBUG: Vblank took 23us
(kms_flip:2671) DEBUG: name = flip
last_ts = 339.888702
last_received_ts = 339.888550
last_seq = 6379
current_ts = 339.905365
current_received_ts = 339.905609
current_seq = 6380
count = 19
seq_step = 1
(kms_flip:2671) DEBUG: Vblank took 20us
(kms_flip:2671) DEBUG: name = flip
last_ts = 339.905365
last_received_ts = 339.905609
last_seq = 6380
current_ts = 339.922028
current_received_ts = 339.921631
current_seq = 6381
count = 20
seq_step = 1
(kms_flip:2671) DEBUG: Vblank took 65us
(kms_flip:2671) DEBUG: name = flip
last_ts = 339.922028
last_received_ts = 339.921631
last_seq = 6381
current_ts = 339.938690
current_received_ts = 339.938599
current_seq = 6382
count = 21
seq_step = 1
(kms_flip:2671) DEBUG: Vblank took 23us
(kms_flip:2671) DEBUG: name = flip
last_ts = 339.938690
last_received_ts = 339.938599
last_seq = 6382
current_ts = 339.955353
current_received_ts = 339.955170
current_seq = 6383
count = 22
seq_step = 1
(kms_flip:2671) DEBUG: Vblank took 23us
(kms_flip:2671) DEBUG: name = flip
last_ts = 339.955353
last_received_ts = 339.955170
last_seq = 6383
current_ts = 339.972015
current_received_ts = 339.971588
current_seq = 6384
count = 23
seq_step = 1
(kms_flip:2671) DEBUG: Vblank took 21us
(kms_flip:2671) DEBUG: name = flip
last_ts = 339.972015
last_received_ts = 339.971588
last_seq = 6384
current_ts = 339.988678
current_received_ts = 339.988434
current_seq = 6385
count = 24
seq_step = 1
(kms_flip:2671) DEBUG: Vblank took 24us
(kms_flip:2671) DEBUG: name = flip
last_ts = 339.988678
last_received_ts = 339.988434
last_seq = 6385
current_ts = 340.005341
current_received_ts = 340.005249
current_seq = 6386
count = 25
seq_step = 1
(kms_flip:2671) DEBUG: Vblank took 20us
(kms_flip:2671) DEBUG: name = flip
last_ts = 340.005341
last_received_ts = 340.005249
last_seq = 6386
current_ts = 340.022003
current_received_ts = 340.021881
current_seq = 6387
count = 26
seq_step = 1
(kms_flip:2671) DEBUG: Vblank took 21us
(kms_flip:2671) DEBUG: name = flip
last_ts = 340.022003
last_received_ts = 340.021881
last_seq = 6387
current_ts = 340.038666
current_received_ts = 340.038483
current_seq = 6388
count = 27
seq_step = 1
(kms_flip:2671) DEBUG: Vblank took 23us
(kms_flip:2671) DEBUG: name = flip
last_ts = 340.038666
last_received_ts = 340.038483
last_seq = 6388
current_ts = 340.055328
current_received_ts = 340.055176
current_seq = 6389
count = 28
seq_step = 1
(kms_flip:2671) DEBUG: Vblank took 24us
(kms_flip:2671) DEBUG: name = flip
last_ts = 340.055328
last_received_ts = 340.055176
last_seq = 6389
current_ts = 340.072021
current_received_ts = 340.071533
current_seq = 6390
count = 29
seq_step = 1
(kms_flip:2671) DEBUG: Vblank took 24us
(kms_flip:2671) DEBUG: name = flip
last_ts = 340.072021
last_received_ts = 340.071533
last_seq = 6390
current_ts = 340.088684
current_received_ts = 340.088501
current_seq = 6391
count = 30
seq_step = 1
(kms_flip:2671) DEBUG: Vblank took 25us
(kms_flip:2671) DEBUG: name = flip
last_ts = 340.088684
last_received_ts = 340.088501
last_seq = 6391
current_ts = 340.105347
current_received_ts = 340.104858
current_seq = 6392
count = 31
seq_step = 1
(kms_flip:2671) DEBUG: Vblank took 21us
(kms_flip:2671) DEBUG: name = flip
last_ts = 340.105347
last_received_ts = 340.104858
last_seq = 6392
current_ts = 340.122009
current_received_ts = 340.121552
current_seq = 6393
count = 32
seq_step = 1
(kms_flip:2671) DEBUG: Vblank took 22us
(kms_flip:2671) DEBUG: name = flip
last_ts = 340.122009
last_received_ts = 340.121552
last_seq = 6393
current_ts = 340.138672
current_received_ts = 340.138733
current_seq = 6394
count = 33
seq_step = 1
(kms_flip:2671) DEBUG: Vblank took 23us
(kms_flip:2671) DEBUG: name = flip
last_ts = 340.138672
last_received_ts = 340.138733
last_seq = 6394
current_ts = 340.155334
current_received_ts = 340.155273
current_seq = 6395
count = 34
seq_step = 1
(kms_flip:2671) DEBUG: Vblank took 210us
(kms_flip:2671) DEBUG: name = flip
last_ts = 340.155334
last_received_ts = 340.155273
last_seq = 6395
current_ts = 340.171997
current_received_ts = 340.171600
current_seq = 6396
count = 35
seq_step = 1
(kms_flip:2671) DEBUG: Vblank took 22us
(kms_flip:2671) DEBUG: name = flip
last_ts = 340.171997
last_received_ts = 340.171600
last_seq = 6396
current_ts = 340.188660
current_received_ts = 340.188751
current_seq = 6397
count = 36
seq_step = 1
(kms_flip:2671) DEBUG: Vblank took 24us
(kms_flip:2671) DEBUG: name = flip
last_ts = 340.188660
last_received_ts = 340.188751
last_seq = 6397
current_ts = 340.205322
current_received_ts = 340.205170
current_seq = 6398
count = 37
seq_step = 1
(kms_flip:2671) DEBUG: Vblank took 21us
(kms_flip:2671) DEBUG: name = flip
last_ts = 340.205322
last_received_ts = 340.205170
last_seq = 6398
current_ts = 340.221985
current_received_ts = 340.221527
current_seq = 6399
count = 38
seq_step = 1
(kms_flip:2671) DEBUG: Vblank took 22us
(kms_flip:2671) DEBUG: name = flip
last_ts = 340.221985
last_received_ts = 340.221527
last_seq = 6399
current_ts = 340.238647
current_received_ts = 340.238495
current_seq = 6400
count = 39
seq_step = 1
(kms_flip:2671) DEBUG: Vblank took 21us
(kms_flip:2671) DEBUG: name = flip
last_ts = 340.238647
last_received_ts = 340.238495
last_seq = 6400
current_ts = 340.255341
current_received_ts = 340.254822
current_seq = 6401
count = 40
seq_step = 1
(kms_flip:2671) DEBUG: Vblank took 21us
(kms_flip:2671) DEBUG: name = flip
last_ts = 340.255341
last_received_ts = 340.254822
last_seq = 6401
current_ts = 340.272003
current_received_ts = 340.271912
current_seq = 6402
count = 41
seq_step = 1
(kms_flip:2671) DEBUG: Vblank took 21us
(kms_flip:2671) DEBUG: name = flip
last_ts = 340.272003
last_received_ts = 340.271912
last_seq = 6402
current_ts = 340.288635
current_received_ts = 340.288483
current_seq = 6403
count = 42
seq_step = 1
(kms_flip:2671) DEBUG: Vblank took 23us
(kms_flip:2671) DEBUG: name = flip
last_ts = 340.288635
last_received_ts = 340.288483
last_seq = 6403
current_ts = 340.305328
current_received_ts = 340.305115
current_seq = 6404
count = 43
seq_step = 1
(kms_flip:2671) DEBUG: Vblank took 25us
(kms_flip:2671) DEBUG: name = flip
last_ts = 340.305328
last_received_ts = 340.305115
last_seq = 6404
current_ts = 340.321991
current_received_ts = 340.321503
current_seq = 6405
count = 44
seq_step = 1
(kms_flip:2671) DEBUG: Vblank took 23us
(kms_flip:2671) DEBUG: name = flip
last_ts = 340.321991
last_received_ts = 340.321503
last_seq = 6405
current_ts = 340.338654
current_received_ts = 340.338470
current_seq = 6406
count = 45
seq_step = 1
(kms_flip:2671) DEBUG: Vblank took 23us
(kms_flip:2671) DEBUG: name = flip
last_ts = 340.338654
last_received_ts = 340.338470
last_seq = 6406
current_ts = 340.355316
current_received_ts = 340.354797
current_seq = 6407
count = 46
seq_step = 1
(kms_flip:2671) DEBUG: Vblank took 20us
(kms_flip:2671) DEBUG: name = flip
last_ts = 340.355316
last_received_ts = 340.354797
last_seq = 6407
current_ts = 340.371979
current_received_ts = 340.371552
current_seq = 6408
count = 47
seq_step = 1
(kms_flip:2671) DEBUG: Vblank took 18us
(kms_flip:2671) DEBUG: name = flip
last_ts = 340.371979
last_received_ts = 340.371552
last_seq = 6408
current_ts = 340.388641
current_received_ts = 340.388458
current_seq = 6409
count = 48
seq_step = 1
(kms_flip:2671) DEBUG: Vblank took 21us
(kms_flip:2671) DEBUG: name = flip
last_ts = 340.388641
last_received_ts = 340.388458
last_seq = 6409
current_ts = 340.405304
current_received_ts = 340.405151
current_seq = 6410
count = 49
seq_step = 1
(kms_flip:2671) DEBUG: Vblank took 22us
(kms_flip:2671) DEBUG: name = flip
last_ts = 340.405304
last_received_ts = 340.405151
last_seq = 6410
current_ts = 340.421967
current_received_ts = 340.421509
current_seq = 6411
count = 50
seq_step = 1
(kms_flip:2671) DEBUG: Vblank took 21us
(kms_flip:2671) DEBUG: name = flip
last_ts = 340.421967
last_received_ts = 340.421509
last_seq = 6411
current_ts = 340.438660
current_received_ts = 340.438507
current_seq = 6412
count = 51
seq_step = 1
(kms_flip:2671) DEBUG: Vblank took 23us
(kms_flip:2671) DEBUG: name = flip
last_ts = 340.438660
last_received_ts = 340.438507
last_seq = 6412
current_ts = 340.455292
current_received_ts = 340.455170
current_seq = 6413
count = 52
seq_step = 1
(kms_flip:2671) DEBUG: Vblank took 22us
(kms_flip:2671) DEBUG: name = flip
last_ts = 340.455292
last_received_ts = 340.455170
last_seq = 6413
current_ts = 340.471985
current_received_ts = 340.471558
current_seq = 6414
count = 53
seq_step = 1
(kms_flip:2671) DEBUG: Vblank took 21us
(kms_flip:2671) DEBUG: name = flip
last_ts = 340.471985
last_received_ts = 340.471558
last_seq = 6414
current_ts = 340.488647
current_received_ts = 340.488403
current_seq = 6415
count = 54
seq_step = 1
(kms_flip:2671) DEBUG: Vblank took 23us
(kms_flip:2671) DEBUG: name = flip
last_ts = 340.488647
last_received_ts = 340.488403
last_seq = 6415
current_ts = 340.505310
current_received_ts = 340.505157
current_seq = 6416
count = 55
seq_step = 1
(kms_flip:2671) DEBUG: Vblank took 23us
(kms_flip:2671) DEBUG: name = flip
last_ts = 340.505310
last_received_ts = 340.505157
last_seq = 6416
current_ts = 340.521973
current_received_ts = 340.521515
current_seq = 6417
count = 56
seq_step = 1
(kms_flip:2671) DEBUG: Vblank took 24us
(kms_flip:2671) DEBUG: name = flip
last_ts = 340.521973
last_received_ts = 340.521515
last_seq = 6417
current_ts = 340.538635
current_received_ts = 340.538422
current_seq = 6418
count = 57
seq_step = 1
(kms_flip:2671) DEBUG: Vblank took 25us
(kms_flip:2671) DEBUG: name = flip
last_ts = 340.538635
last_received_ts = 340.538422
last_seq = 6418
current_ts = 340.555298
current_received_ts = 340.555145
current_seq = 6419
count = 58
seq_step = 1
(kms_flip:2671) DEBUG: Vblank took 22us
(kms_flip:2671) DEBUG: name = flip
last_ts = 340.555298
last_received_ts = 340.555145
last_seq = 6419
current_ts = 340.571960
current_received_ts = 340.571899
current_seq = 6420
count = 59
seq_step = 1
(kms_flip:2671) DEBUG: Vblank took 24us
(kms_flip:2671) DEBUG: name = flip
last_ts = 340.571960
last_received_ts = 340.571899
last_seq = 6420
current_ts = 340.588623
current_received_ts = 340.588501
current_seq = 6421
count = 60
seq_step = 1
(kms_flip:2671) DEBUG: Vblank took 23us
(kms_flip:2671) DEBUG: name = flip
last_ts = 340.588623
last_received_ts = 340.588501
last_seq = 6421
current_ts = 340.605286
current_received_ts = 340.604767
current_seq = 6422
count = 61
seq_step = 1
(kms_flip:2671) DEBUG: Vblank took 17us
(kms_flip:2671) DEBUG: name = flip
last_ts = 340.605286
last_received_ts = 340.604767
last_seq = 6422
current_ts = 340.621948
current_received_ts = 340.621796
current_seq = 6423
count = 62
seq_step = 1
(kms_flip:2671) DEBUG: Vblank took 22us
(kms_flip:2671) DEBUG: name = flip
last_ts = 340.621948
last_received_ts = 340.621796
last_seq = 6423
current_ts = 340.638641
current_received_ts = 340.638519
current_seq = 6424
count = 63
seq_step = 1
(kms_flip:2671) DEBUG: Vblank took 22us
(kms_flip:2671) DEBUG: name = flip
last_ts = 340.638641
last_received_ts = 340.638519
last_seq = 6424
current_ts = 340.655304
current_received_ts = 340.655396
current_seq = 6425
count = 64
seq_step = 1
(kms_flip:2671) DEBUG: Vblank took 23us
(kms_flip:2671) DEBUG: name = flip
last_ts = 340.655304
last_received_ts = 340.655396
last_seq = 6425
current_ts = 340.671967
current_received_ts = 340.671539
current_seq = 6426
count = 65
seq_step = 1
(kms_flip:2671) DEBUG: Vblank took 24us
(kms_flip:2671) DEBUG: name = flip
last_ts = 340.671967
last_received_ts = 340.671539
last_seq = 6426
current_ts = 340.688629
current_received_ts = 340.688507
current_seq = 6427
count = 66
seq_step = 1
(kms_flip:2671) DEBUG: Vblank took 23us
(kms_flip:2671) DEBUG: name = flip
last_ts = 340.688629
last_received_ts = 340.688507
last_seq = 6427
current_ts = 340.705292
current_received_ts = 340.705170
current_seq = 6428
count = 67
seq_step = 1
(kms_flip:2671) DEBUG: Vblank took 22us
(kms_flip:2671) DEBUG: name = flip
last_ts = 340.705292
last_received_ts = 340.705170
last_seq = 6428
current_ts = 340.721954
current_received_ts = 340.721832
current_seq = 6429
count = 68
seq_step = 1
(kms_flip:2671) DEBUG: Vblank took 24us
(kms_flip:2671) DEBUG: name = flip
last_ts = 340.721954
last_received_ts = 340.721832
last_seq = 6429
current_ts = 340.738617
current_received_ts = 340.738403
current_seq = 6430
count = 69
seq_step = 1
(kms_flip:2671) DEBUG: Vblank took 25us
(kms_flip:2671) DEBUG: name = flip
last_ts = 340.738617
last_received_ts = 340.738403
last_seq = 6430
current_ts = 340.755280
current_received_ts = 340.755096
current_seq = 6431
count = 70
seq_step = 1
(kms_flip:2671) DEBUG: Vblank took 24us
(kms_flip:2671) DEBUG: name = flip
last_ts = 340.755280
last_received_ts = 340.755096
last_seq = 6431
current_ts = 340.771942
current_received_ts = 340.771484
current_seq = 6432
count = 71
seq_step = 1
(kms_flip:2671) DEBUG: Vblank took 26us
(kms_flip:2671) DEBUG: name = flip
last_ts = 340.771942
last_received_ts = 340.771484
last_seq = 6432
current_ts = 340.788605
current_received_ts = 340.788422
current_seq = 6433
count = 72
seq_step = 1
(kms_flip:2671) DEBUG: Vblank took 24us
(kms_flip:2671) DEBUG: name = flip
last_ts = 340.788605
last_received_ts = 340.788422
last_seq = 6433
current_ts = 340.805267
current_received_ts = 340.805176
current_seq = 6434
count = 73
seq_step = 1
(kms_flip:2671) DEBUG: Vblank took 23us
(kms_flip:2671) DEBUG: name = flip
last_ts = 340.805267
last_received_ts = 340.805176
last_seq = 6434
current_ts = 340.821930
current_received_ts = 340.821533
current_seq = 6435
count = 74
seq_step = 1
(kms_flip:2671) DEBUG: Vblank took 24us
(kms_flip:2671) DEBUG: name = flip
last_ts = 340.821930
last_received_ts = 340.821533
last_seq = 6435
current_ts = 340.838593
current_received_ts = 340.838409
current_seq = 6436
count = 75
seq_step = 1
(kms_flip:2671) DEBUG: Vblank took 23us
(kms_flip:2671) DEBUG: name = flip
last_ts = 340.838593
last_received_ts = 340.838409
last_seq = 6436
current_ts = 340.855286
current_received_ts = 340.855103
current_seq = 6437
count = 76
seq_step = 1
(kms_flip:2671) DEBUG: Vblank took 22us
(kms_flip:2671) DEBUG: name = flip
last_ts = 340.855286
last_received_ts = 340.855103
last_seq = 6437
current_ts = 340.871948
current_received_ts = 340.871521
current_seq = 6438
count = 77
seq_step = 1
(kms_flip:2671) DEBUG: Vblank took 23us
(kms_flip:2671) DEBUG: name = flip
last_ts = 340.871948
last_received_ts = 340.871521
last_seq = 6438
current_ts = 340.888611
current_received_ts = 340.888397
current_seq = 6439
count = 78
seq_step = 1
(kms_flip:2671) DEBUG: Vblank took 23us
(kms_flip:2671) DEBUG: name = flip
last_ts = 340.888611
last_received_ts = 340.888397
last_seq = 6439
current_ts = 340.905273
current_received_ts = 340.905121
current_seq = 6440
count = 79
seq_step = 1
(kms_flip:2671) DEBUG: Vblank took 22us
(kms_flip:2671) DEBUG: name = flip
last_ts = 340.905273
last_received_ts = 340.905121
last_seq = 6440
current_ts = 340.921936
current_received_ts = 340.921906
current_seq = 6441
count = 80
seq_step = 1
(kms_flip:2671) DEBUG: Vblank took 24us
(kms_flip:2671) DEBUG: name = flip
last_ts = 340.921936
last_received_ts = 340.921906
last_seq = 6441
current_ts = 340.938599
current_received_ts = 340.938446
current_seq = 6442
count = 81
seq_step = 1
(kms_flip:2671) DEBUG: Vblank took 23us
(kms_flip:2671) DEBUG: name = flip
last_ts = 340.938599
last_received_ts = 340.938446
last_seq = 6442
current_ts = 340.955261
current_received_ts = 340.954773
current_seq = 6443
count = 82
seq_step = 1
(kms_flip:2671) DEBUG: Vblank took 21us
(kms_flip:2671) DEBUG: name = flip
last_ts = 340.955261
last_received_ts = 340.954773
last_seq = 6443
current_ts = 340.971924
current_received_ts = 340.971497
current_seq = 6444
count = 83
seq_step = 1
(kms_flip:2671) DEBUG: Vblank took 23us
(kms_flip:2671) DEBUG: name = flip
last_ts = 340.971924
last_received_ts = 340.971497
last_seq = 6444
current_ts = 340.988617
current_received_ts = 340.988464
current_seq = 6445
count = 84
seq_step = 1
(kms_flip:2671) DEBUG: Vblank took 24us
(kms_flip:2671) DEBUG: name = flip
last_ts = 340.988617
last_received_ts = 340.988464
last_seq = 6445
current_ts = 341.005249
current_received_ts = 341.005157
current_seq = 6446
count = 85
seq_step = 1
(kms_flip:2671) DEBUG: Vblank took 22us
(kms_flip:2671) DEBUG: name = flip
last_ts = 341.005249
last_received_ts = 341.005157
last_seq = 6446
current_ts = 341.021912
current_received_ts = 341.021545
current_seq = 6447
count = 86
seq_step = 1
(kms_flip:2671) DEBUG: Vblank took 24us
(kms_flip:2671) DEBUG: name = flip
last_ts = 341.021912
last_received_ts = 341.021545
last_seq = 6447
current_ts = 341.038605
current_received_ts = 341.038513
current_seq = 6448
count = 87
seq_step = 1
(kms_flip:2671) DEBUG: Vblank took 22us
(kms_flip:2671) DEBUG: name = flip
last_ts = 341.038605
last_received_ts = 341.038513
last_seq = 6448
current_ts = 341.055267
current_received_ts = 341.054718
current_seq = 6449
count = 88
seq_step = 1
(kms_flip:2671) DEBUG: Vblank took 21us
(kms_flip:2671) DEBUG: name = flip
last_ts = 341.055267
last_received_ts = 341.054718
last_seq = 6449
current_ts = 341.071930
current_received_ts = 341.071899
current_seq = 6450
count = 89
seq_step = 1
(kms_flip:2671) DEBUG: Vblank took 20us
(kms_flip:2671) DEBUG: name = flip
last_ts = 341.071930
last_received_ts = 341.071899
last_seq = 6450
current_ts = 341.088593
current_received_ts = 341.088074
current_seq = 6451
count = 90
seq_step = 1
(kms_flip:2671) DEBUG: Vblank took 14us
(kms_flip:2671) DEBUG: name = flip
last_ts = 341.088593
last_received_ts = 341.088074
last_seq = 6451
current_ts = 341.105255
current_received_ts = 341.104828
current_seq = 6452
count = 91
seq_step = 1
(kms_flip:2671) DEBUG: Vblank took 13us
(kms_flip:2671) DEBUG: name = flip
last_ts = 341.105255
last_received_ts = 341.104828
last_seq = 6452
current_ts = 341.121918
current_received_ts = 341.121338
current_seq = 6453
count = 92
seq_step = 1
(kms_flip:2671) DEBUG: Vblank took 14us
(kms_flip:2671) DEBUG: name = flip
last_ts = 341.121918
last_received_ts = 341.121338
last_seq = 6453
current_ts = 341.138580
current_received_ts = 341.138214
current_seq = 6454
count = 93
seq_step = 1
(kms_flip:2671) DEBUG: Vblank took 16us
(kms_flip:2671) DEBUG: name = flip
last_ts = 341.138580
last_received_ts = 341.138214
last_seq = 6454
current_ts = 341.155243
current_received_ts = 341.154663
current_seq = 6455
count = 94
seq_step = 1
(kms_flip:2671) DEBUG: Vblank took 9us
(kms_flip:2671) DEBUG: name = flip
last_ts = 341.155243
last_received_ts = 341.154663
last_seq = 6455
current_ts = 341.171906
current_received_ts = 341.171387
current_seq = 6456
count = 95
seq_step = 1
(kms_flip:2671) DEBUG: Vblank took 19us
(kms_flip:2671) DEBUG: name = flip
last_ts = 341.171906
last_received_ts = 341.171387
last_seq = 6456
current_ts = 341.188568
current_received_ts = 341.188629
current_seq = 6457
count = 96
seq_step = 1
(kms_flip:2671) DEBUG: Vblank took 20us
(kms_flip:2671) DEBUG: name = flip
last_ts = 341.188568
last_received_ts = 341.188629
last_seq = 6457
current_ts = 341.205231
current_received_ts = 341.205139
current_seq = 6458
count = 97
seq_step = 1
(kms_flip:2671) DEBUG: Vblank took 21us
(kms_flip:2671) DEBUG: name = flip
last_ts = 341.205231
last_received_ts = 341.205139
last_seq = 6458
current_ts = 341.221924
current_received_ts = 341.221497
current_seq = 6459
count = 98
seq_step = 1
(kms_flip:2671) DEBUG: Vblank took 21us
(kms_flip:2671) DEBUG: name = flip
last_ts = 341.221924
last_received_ts = 341.221497
last_seq = 6459
current_ts = 341.238586
current_received_ts = 341.238647
current_seq = 6460
count = 99
seq_step = 1
(kms_flip:2671) DEBUG: Vblank took 22us
(kms_flip:2671) DEBUG: name = flip
last_ts = 341.238586
last_received_ts = 341.238647
last_seq = 6460
current_ts = 341.255249
current_received_ts = 341.255127
current_seq = 6461
count = 100
seq_step = 1
(kms_flip:2671) DEBUG: Vblank took 23us
(kms_flip:2671) DEBUG: name = flip
last_ts = 341.255249
last_received_ts = 341.255127
last_seq = 6461
current_ts = 341.271912
current_received_ts = 341.271515
current_seq = 6462
count = 101
seq_step = 1
(kms_flip:2671) DEBUG: Vblank took 22us
(kms_flip:2671) DEBUG: name = flip
last_ts = 341.271912
last_received_ts = 341.271515
last_seq = 6462
current_ts = 341.288574
current_received_ts = 341.288239
current_seq = 6463
count = 102
seq_step = 1
(kms_flip:2671) DEBUG: Vblank took 22us
(kms_flip:2671) DEBUG: name = flip
last_ts = 341.288574
last_received_ts = 341.288239
last_seq = 6463
current_ts = 341.305237
current_received_ts = 341.304810
current_seq = 6464
count = 103
seq_step = 1
(kms_flip:2671) DEBUG: Vblank took 20us
(kms_flip:2671) DEBUG: name = flip
last_ts = 341.305237
last_received_ts = 341.304810
last_seq = 6464
current_ts = 341.321899
current_received_ts = 341.321533
current_seq = 6465
count = 104
seq_step = 1
(kms_flip:2671) DEBUG: Vblank took 24us
(kms_flip:2671) DEBUG: name = flip
last_ts = 341.321899
last_received_ts = 341.321533
last_seq = 6465
current_ts = 341.338562
current_received_ts = 341.338470
current_seq = 6466
count = 105
seq_step = 1
(kms_flip:2671) DEBUG: Vblank took 23us
(kms_flip:2671) DEBUG: name = flip
last_ts = 341.338562
last_received_ts = 341.338470
last_seq = 6466
current_ts = 341.355225
current_received_ts = 341.354736
current_seq = 6467
count = 106
seq_step = 1
(kms_flip:2671) DEBUG: Vblank took 21us
(kms_flip:2671) DEBUG: name = flip
last_ts = 341.355225
last_received_ts = 341.354736
last_seq = 6467
current_ts = 341.371887
current_received_ts = 341.371460
current_seq = 6468
count = 107
seq_step = 1
(kms_flip:2671) DEBUG: Vblank took 19us
(kms_flip:2671) DEBUG: name = flip
last_ts = 341.371887
last_received_ts = 341.371460
last_seq = 6468
current_ts = 341.388580
current_received_ts = 341.388458
current_seq = 6469
count = 108
seq_step = 1
(kms_flip:2671) DEBUG: Vblank took 23us
(kms_flip:2671) DEBUG: name = flip
last_ts = 341.388580
last_received_ts = 341.388458
last_seq = 6469
current_ts = 341.405243
current_received_ts = 341.404846
current_seq = 6470
count = 109
seq_step = 1
(kms_flip:2671) DEBUG: Vblank took 21us
(kms_flip:2671) DEBUG: name = flip
last_ts = 341.405243
last_received_ts = 341.404846
last_seq = 6470
current_ts = 341.421906
current_received_ts = 341.421478
current_seq = 6471
count = 110
seq_step = 1
(kms_flip:2671) DEBUG: Vblank took 22us
(kms_flip:2671) DEBUG: name = flip
last_ts = 341.421906
last_received_ts = 341.421478
last_seq = 6471
current_ts = 341.438568
current_received_ts = 341.438446
current_seq = 6472
count = 111
seq_step = 1
(kms_flip:2671) DEBUG: Vblank took 24us
(kms_flip:2671) DEBUG: name = flip
last_ts = 341.438568
last_received_ts = 341.438446
last_seq = 6472
current_ts = 341.455231
current_received_ts = 341.454712
current_seq = 6473
count = 112
seq_step = 1
(kms_flip:2671) DEBUG: Vblank took 22us
(kms_flip:2671) DEBUG: name = flip
last_ts = 341.455231
last_received_ts = 341.454712
last_seq = 6473
current_ts = 341.471893
current_received_ts = 341.471466
current_seq = 6474
count = 113
seq_step = 1
(kms_flip:2671) DEBUG: Vblank took 22us
(kms_flip:2671) DEBUG: name = flip
last_ts = 341.471893
last_received_ts = 341.471466
last_seq = 6474
current_ts = 341.488556
current_received_ts = 341.488373
current_seq = 6475
count = 114
seq_step = 1
(kms_flip:2671) DEBUG: Vblank took 22us
(kms_flip:2671) DEBUG: name = flip
last_ts = 341.488556
last_received_ts = 341.488373
last_seq = 6475
current_ts = 341.505219
current_received_ts = 341.505188
current_seq = 6476
count = 115
seq_step = 1
(kms_flip:2671) DEBUG: Vblank took 21us
(kms_flip:2671) DEBUG: name = flip
last_ts = 341.505219
last_received_ts = 341.505188
last_seq = 6476
current_ts = 341.521881
current_received_ts = 341.521423
current_seq = 6477
count = 116
seq_step = 1
(kms_flip:2671) DEBUG: Vblank took 23us
(kms_flip:2671) DEBUG: name = flip
last_ts = 341.521881
last_received_ts = 341.521423
last_seq = 6477
current_ts = 341.538544
current_received_ts = 341.538330
current_seq = 6478
count = 117
seq_step = 1
(kms_flip:2671) DEBUG: Vblank took 21us
(kms_flip:2671) DEBUG: name = flip
last_ts = 341.538544
last_received_ts = 341.538330
last_seq = 6478
current_ts = 341.555206
current_received_ts = 341.555145
current_seq = 6479
count = 118
seq_step = 1
(kms_flip:2671) DEBUG: Vblank took 23us
(kms_flip:2671) DEBUG: name = flip
last_ts = 341.555206
last_received_ts = 341.555145
last_seq = 6479
current_ts = 341.571869
current_received_ts = 341.571503
current_seq = 6480
count = 119
seq_step = 1
(kms_flip:2671) DEBUG: Vblank took 25us
(kms_flip:2671) DEBUG: name = flip
last_ts = 341.571869
last_received_ts = 341.571503
last_seq = 6480
current_ts = 341.588531
current_received_ts = 341.588379
current_seq = 6481
count = 120
seq_step = 1
(kms_flip:2671) DEBUG: Vblank took 13us
(kms_flip:2671) DEBUG: name = flip
last_ts = 341.588531
last_received_ts = 341.588379
last_seq = 6481
current_ts = 341.605225
current_received_ts = 341.604614
current_seq = 6482
count = 121
seq_step = 1
(kms_flip:2671) DEBUG: Vblank took 544us
(kms_flip:2671) CRITICAL: Test assertion failure function run_test_step, file ../tests/kms_flip.c:928:
(kms_flip:2671) CRITICAL: Failed assertion: end - start < 500
(kms_flip:2671) CRITICAL: Last errno: 4, Interrupted system call
(kms_flip:2671) igt_core-INFO: Stack trace:
(kms_flip:2671) igt_core-INFO:   #0 ../lib/igt_core.c:2075 __igt_fail_assert()
(kms_flip:2671) igt_core-INFO:   #1 ../tests/kms_flip.c:923 run_test_on_crtc_set.constprop.0()
(kms_flip:2671) igt_core-INFO:   #2 ../tests/kms_flip.c:1974 run_pair()
(kms_flip:2671) igt_core-INFO:   #3 ../tests/kms_flip.c:2165 __igt_unique____real_main2045()
(kms_flip:2671) igt_core-INFO:   #4 ../tests/kms_flip.c:2045 main()
(kms_flip:2671) igt_core-INFO:   #5 [__libc_init_first+0x8a]
(kms_flip:2671) igt_core-INFO:   #6 [__libc_start_main+0x8b]
(kms_flip:2671) igt_core-INFO:   #7 [_start+0x25]
****  END  ****
Dynamic subtest BC-HDMI-A1-HDMI-A2: FAIL (2.949s)
Subtest 2x-flip-vs-expired-vblank-interruptible: FAIL (24.353s)
(kms_flip:2671) igt_kms-CRITICAL: Test assertion failure function kmstest_set_connector_dpms, file ../lib/igt_kms.c:2386:
(kms_flip:2671) igt_kms-CRITICAL: Failed assertion: found_it
(kms_flip:2671) igt_kms-CRITICAL: Last errno: 9, Bad file descriptor
(kms_flip:2671) igt_kms-CRITICAL: DPMS property not found on 164
Dmesg
<6> [338.690350] [IGT] kms_flip: starting dynamic subtest BC-HDMI-A1-HDMI-A2
<7> [338.691707] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:180]
<7> [338.692170] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:183]
<7> [338.728252] i915 0000:00:02.0: [drm:drm_mode_setcrtc] [CRTC:76:pipe A]
<7> [338.728617] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:76:pipe A] fastset requirement not met in hw.enable (expected yes, found no)
<7> [338.729087] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:76:pipe A] fastset requirement not met in hw.active (expected yes, found no)
<7> [338.729503] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:76:pipe A] fastset requirement not met in cpu_transcoder (expected 0, found -1)
<7> [338.729877] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:76:pipe A] fastset requirement not met in lane_count (expected 4, found 0)
<7> [338.730249] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:76:pipe A] fastset requirement not met in lane_lat_optim_mask (expected 0x0000000d, found 0x00000000)
<7> [338.730629] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:76:pipe A] fastset requirement not met in output_types (expected 0x00000040, found 0x00000000)
<7> [338.730999] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:76:pipe A] fastset requirement not met in framestart_delay (expected 1, found 0)
<7> [338.731367] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:76:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hdisplay (expected 1920, found 0)
<7> [338.731755] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:76:pipe A] fastset requirement not met in hw.pipe_mode.crtc_htotal (expected 2200, found 0)
<7> [338.732126] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:76:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hblank_start (expected 1920, found 0)
<7> [338.732505] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:76:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hblank_end (expected 2200, found 0)
<7> [338.732875] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:76:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hsync_start (expected 2008, found 0)
<7> [338.733244] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:76:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hsync_end (expected 2052, found 0)
<7> [338.733622] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:76:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vdisplay (expected 1080, found 0)
<7> [338.733993] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:76:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vblank_start (expected 1080, found 0)
<7> [338.734362] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:76:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vsync_start (expected 1083, found 0)
<7> [338.734739] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:76:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vsync_end (expected 1088, found 0)
<7> [338.735112] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:76:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vtotal (expected 1125, found 0)
<7> [338.735487] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:76:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vblank_end (expected 1125, found 0)
<7> [338.735856] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:76:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hdisplay (expected 1920, found 0)
<7> [338.736226] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:76:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_htotal (expected 2200, found 0)
<7> [338.736606] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:76:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hblank_start (expected 1920, found 0)
<7> [338.736974] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:76:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hblank_end (expected 2200, found 0)
<7> [338.737344] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:76:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hsync_start (expected 2008, found 0)
<7> [338.737721] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:76:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hsync_end (expected 2052, found 0)
<7> [338.738091] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:76:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vdisplay (expected 1080, found 0)
<7> [338.738483] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:76:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vblank_start (expected 1080, found 0)
<7> [338.738852] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:76:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vsync_start (expected 1083, found 0)
<7> [338.739222] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:76:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vsync_end (expected 1088, found 0)
<7> [338.739600] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:76:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vtotal (expected 1125, found 0)
<7> [338.739970] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:76:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vblank_end (expected 1125, found 0)
<7> [338.740339] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:76:pipe A] fastset requirement not met in pixel_multiplier (expected 1, found 0)
<7> [338.740717] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:76:pipe A] fastset requirement not met in hw.adjusted_mode.flags (1) (expected 1, found 0)
<7> [338.741087] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:76:pipe A] fastset requirement not met in hw.adjusted_mode.flags (8) (expected 8, found 0)
<7> [338.741466] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:76:pipe A] fastset requirement not met in has_hdmi_sink (expected yes, found no)
<7> [338.741838] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:76:pipe A] fastset requirement not met in has_infoframe (expected yes, found no)
<7> [338.742209] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:76:pipe A] fastset requirement not met in pipe_bpp (expected 36, found 0)
<7> [338.742598] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:76:pipe A] fastset requirement not met in hw.pipe_mode.crtc_clock (expected 148500, found 0)
<7> [338.742968] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:76:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_clock (expected 148500, found 0)
<7> [338.743338] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:76:pipe A] fastset requirement not met in port_clock (expected 222750, found 0)
<7> [338.743717] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:76:pipe A] fastset requirement not met in infoframes.enable (expected 0x00000071, found 0x00000000)
<7> [338.744087] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:76:pipe A] fastset requirement not met in infoframes.gcp (expected 0x00000006, found 0x00000000)
<7> [338.744469] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:76:pipe A] fastset requirement not met in avi infoframe
<7> [338.744841] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] expected:
<7> [338.745210] i915 0000:00:02.0: HDMI infoframe: Auxiliary Video Information (AVI), version 2, length 13
<7> [338.745214] i915 0000:00:02.0: colorspace: RGB
<7> [338.745218] i915 0000:00:02.0: scan mode: Underscan
<7> [338.745221] i915 0000:00:02.0: colorimetry: No Data
<7> [338.745225] i915 0000:00:02.0: picture aspect: No Data
<7> [338.745228] i915 0000:00:02.0: active aspect: Same as Picture
<7> [338.745231] i915 0000:00:02.0: itc: No Data
<7> [338.745234] i915 0000:00:02.0: extended colorimetry: xvYCC 601
<7> [338.745237] i915 0000:00:02.0: quantization range: Full
<7> [338.745240] i915 0000:00:02.0: nups: Unknown Non-uniform Scaling
<7> [338.745244] i915 0000:00:02.0: video code: 0
<7> [338.745247] i915 0000:00:02.0: ycc quantization range: Full
<7> [338.745250] i915 0000:00:02.0: hdmi content type: Graphics
<7> [338.745253] i915 0000:00:02.0: pixel repeat: 0
<7> [338.745256] i915 0000:00:02.0: bar top 0, bottom 0, left 0, right 0
<7> [338.745260] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] found:
<7> [338.745637] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:76:pipe A] fastset requirement not met in spd infoframe
<7> [338.746005] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] expected:
<7> [338.746376] i915 0000:00:02.0: HDMI infoframe: Source Product Description (SPD), version 1, length 25
<7> [338.746387] i915 0000:00:02.0: vendor: Intel
<7> [338.746390] i915 0000:00:02.0: product: Integrated gfx
<7> [338.746394] i915 0000:00:02.0: source device information: PC General (0x9)
<7> [338.746397] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] found:
<7> [338.746767] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:76:pipe A] fastset requirement not met in hdmi infoframe
<7> [338.747136] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] expected:
<7> [338.747511] i915 0000:00:02.0: HDMI infoframe: Vendor, version 1, length 4
<7> [338.747518] i915 0000:00:02.0: empty frame
<7> [338.747521] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] found:
<7> [338.747892] i915 0000:00:02.0: [drm:intel_atomic_check [i915]] [CRTC:76:pipe A] fastset requirement not met, forcing full modeset
<7> [338.748268] i915 0000:00:02.0: [drm:intel_dpll_crtc_put [i915]] [CRTC:76:pipe A] releasing PORT PLL B
<7> [338.749172] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] [CRTC:76:pipe A] dbuf slices 0x1 -> 0x0, ddb (0 - 510) -> (0 - 0), active pipes 0x5 -> 0x4
<7> [338.749603] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] [CRTC:162:pipe C] dbuf slices 0x1 -> 0x1, ddb (510 - 1020) -> (0 - 1020), active pipes 0x5 -> 0x4
<7> [338.750035] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] [PLANE:70:cursor A] ddb ( 497 - 510) -> ( 0 - 0), size 13 -> 0
<7> [338.750454] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] [PLANE:156:cursor C] ddb (1007 - 1020) -> ( 988 - 1020), size 13 -> 32
<7> [338.751016] i915 0000:00:02.0: [drm:intel_cdclk_atomic_check [i915]] [CRTC:76:pipe A] min cdclk: 192000 kHz -> 0 kHz
<7> [338.751444] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [CRTC:76:pipe A] enable: no [modeset]
<7> [338.751821] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:34:plane 1A] fb: [NOFB], visible: no
<7> [338.752192] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:43:plane 2A] fb: [NOFB], visible: no
<7> [338.752586] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:52:plane 3A] fb: [NOFB], visible: no
<7> [338.752956] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:61:plane 4A] fb: [NOFB], visible: no
<7> [338.753323] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:70:cursor A] fb: [NOFB], visible: no
<7> [338.754233] i915 0000:00:02.0: [drm:intel_audio_codec_disable [i915]] [CONNECTOR:164:HDMI-A-1][ENCODER:163:DDI B/PHY B] Disable audio codec on [CRTC:76:pipe A]
<7> [338.783077] i915 0000:00:02.0: [drm:intel_disable_transcoder [i915]] disabling pipe A
<7> [338.800470] i915 0000:00:02.0: [drm:intel_ddi_disable_transcoder_func [i915]] Quirk Increase DDI disabled time
<7> [338.907897] i915 0000:00:02.0: [drm:intel_power_well_disable [i915]] disabling DDI_IO_B
<7> [338.909018] i915 0000:00:02.0: [drm:intel_dpll_disable [i915]] disable PORT PLL B (active 0x1, on? 1) for [CRTC:76:pipe A]
<7> [338.910667] i915 0000:00:02.0: [drm:intel_dpll_disable [i915]] disabling PORT PLL B
<7> [338.911069] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:163:DDI B/PHY B]
<7> [338.913105] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:173:DDI C/PHY C]
<7> [338.913645] i915 0000:00:02.0: [drm:verify_connector_state [i915]] [CONNECTOR:164:HDMI-A-1]
<7> [338.928033] i915 0000:00:02.0: [drm:intel_power_well_disable [i915]] disabling dpio-common-b
<7> [338.929176] i915 0000:00:02.0: [drm:intel_modeset_verify_crtc [i915]] [CRTC:76:pipe A]
<7> [338.933258] i915 0000:00:02.0: [drm:drm_mode_setcrtc] [CRTC:119:pipe B]
<7> [338.933780] i915 0000:00:02.0: [drm:drm_mode_setcrtc] [CRTC:162:pipe C]
<7> [338.933966] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:162:pipe C] fastset requirement not met in hw.enable (expected yes, found no)
<7> [338.934528] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:162:pipe C] fastset requirement not met in hw.active (expected yes, found no)
<7> [338.934911] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:162:pipe C] fastset requirement not met in cpu_transcoder (expected 2, found -1)
<7> [338.935286] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:162:pipe C] fastset requirement not met in lane_count (expected 4, found 0)
<7> [338.935685] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:162:pipe C] fastset requirement not met in lane_lat_optim_mask (expected 0x0000000d, found 0x00000000)
<7> [338.936058] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:162:pipe C] fastset requirement not met in output_types (expected 0x00000040, found 0x00000000)
<7> [338.936455] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:162:pipe C] fastset requirement not met in framestart_delay (expected 1, found 0)
<7> [338.936830] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:162:pipe C] fastset requirement not met in hw.pipe_mode.crtc_hdisplay (expected 1920, found 0)
<7> [338.937200] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:162:pipe C] fastset requirement not met in hw.pipe_mode.crtc_htotal (expected 2200, found 0)
<7> [338.937648] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:162:pipe C] fastset requirement not met in hw.pipe_mode.crtc_hblank_start (expected 1920, found 0)
<7> [338.938052] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:162:pipe C] fastset requirement not met in hw.pipe_mode.crtc_hblank_end (expected 2200, found 0)
<7> [338.938471] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:162:pipe C] fastset requirement not met in hw.pipe_mode.crtc_hsync_start (expected 2008, found 0)
<7> [338.938846] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:162:pipe C] fastset requirement not met in hw.pipe_mode.crtc_hsync_end (expected 2052, found 0)
<7> [338.939216] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:162:pipe C] fastset requirement not met in hw.pipe_mode.crtc_vdisplay (expected 1080, found 0)
<7> [338.939621] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:162:pipe C] fastset requirement not met in hw.pipe_mode.crtc_vblank_start (expected 1080, found 0)
<7> [338.939992] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:162:pipe C] fastset requirement not met in hw.pipe_mode.crtc_vsync_start (expected 1083, found 0)
<7> [338.940364] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:162:pipe C] fastset requirement not met in hw.pipe_mode.crtc_vsync_end (expected 1088, found 0)
<7> [338.940781] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:162:pipe C] fastset requirement not met in hw.pipe_mode.crtc_vtotal (expected 1125, found 0)
<7> [338.941152] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:162:pipe C] fastset requirement not met in hw.pipe_mode.crtc_vblank_end (expected 1125, found 0)
<7> [338.941556] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:162:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_hdisplay (expected 1920, found 0)
<7> [338.941930] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:162:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_htotal (expected 2200, found 0)
<7> [338.942301] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:162:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_hblank_start (expected 1920, found 0)
<7> [338.942718] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:162:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_hblank_end (expected 2200, found 0)
<7> [338.943094] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:162:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_hsync_start (expected 2008, found 0)
<7> [338.943481] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:162:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_hsync_end (expected 2052, found 0)
<7> [338.943851] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:162:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_vdisplay (expected 1080, found 0)
<7> [338.944222] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:162:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_vblank_start (expected 1080, found 0)
<7> [338.944657] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:162:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_vsync_start (expected 1083, found 0)
<7> [338.945032] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:162:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_vsync_end (expected 1088, found 0)
<7> [338.945419] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:162:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_vtotal (expected 1125, found 0)
<7> [338.945789] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:162:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_vblank_end (expected 1125, found 0)
<7> [338.946159] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:162:pipe C] fastset requirement not met in pixel_multiplier (expected 1, found 0)
<7> [338.946558] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:162:pipe C] fastset requirement not met in hw.adjusted_mode.flags (1) (expected 1, found 0)
<7> [338.946931] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:162:pipe C] fastset requirement not met in hw.adjusted_mode.flags (8) (expected 8, found 0)
<7> [338.947303] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:162:pipe C] fastset requirement not met in has_hdmi_sink (expected yes, found no)
<7> [338.947684] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:162:pipe C] fastset requirement not met in has_infoframe (expected yes, found no)
<7> [338.948058] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:162:pipe C] fastset requirement not met in pipe_bpp (expected 36, found 0)
<7> [338.948454] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:162:pipe C] fastset requirement not met in hw.pipe_mode.crtc_clock (expected 148500, found 0)
<7> [338.948827] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:162:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_clock (expected 148500, found 0)
<7> [338.949197] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:162:pipe C] fastset requirement not met in port_clock (expected 222750, found 0)
<7> [338.949584] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:162:pipe C] fastset requirement not met in infoframes.enable (expected 0x00000071, found 0x00000000)
<7> [338.949958] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:162:pipe C] fastset requirement not met in infoframes.gcp (expected 0x00000006, found 0x00000000)
<7> [338.950330] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:162:pipe C] fastset requirement not met in avi infoframe
<7> [338.950730] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] expected:
<7> [338.951102] i915 0000:00:02.0: HDMI infoframe: Auxiliary Video Information (AVI), version 2, length 13
<7> [338.951107] i915 0000:00:02.0: colorspace: RGB
<7> [338.951111] i915 0000:00:02.0: scan mode: Underscan
<7> [338.951114] i915 0000:00:02.0: colorimetry: No Data
<7> [338.951118] i915 0000:00:02.0: picture aspect: No Data
<7> [338.951121] i915 0000:00:02.0: active aspect: Same as Picture
<7> [338.951124] i915 0000:00:02.0: itc: No Data
<7> [338.951127] i915 0000:00:02.0: extended colorimetry: xvYCC 601
<7> [338.951130] i915 0000:00:02.0: quantization range: Full
<7> [338.951133] i915 0000:00:02.0: nups: Unknown Non-uniform Scaling
<7> [338.951137] i915 0000:00:02.0: video code: 0
<7> [338.951140] i915 0000:00:02.0: ycc quantization range: Full
<7> [338.951143] i915 0000:00:02.0: hdmi content type: Graphics
<7> [338.951146] i915 0000:00:02.0: pixel repeat: 0
<7> [338.951149] i915 0000:00:02.0: bar top 0, bottom 0, left 0, right 0
<7> [338.951153] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] found:
<7> [338.951542] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:162:pipe C] fastset requirement not met in spd infoframe
<7> [338.951912] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] expected:
<7> [338.952280] i915 0000:00:02.0: HDMI infoframe: Source Product Description (SPD), version 1, length 25
<7> [338.952284] i915 0000:00:02.0: vendor: Intel
<7> [338.952287] i915 0000:00:02.0: product: Integrated gfx
<7> [338.952290] i915 0000:00:02.0: source device information: PC General (0x9)
<7> [338.952294] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] found:
<7> [338.952687] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:162:pipe C] fastset requirement not met in hdmi infoframe
<7> [338.953057] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] expected:
<7> [338.953435] i915 0000:00:02.0: HDMI infoframe: Vendor, version 1, length 4
<7> [338.953439] i915 0000:00:02.0: empty frame
<7> [338.953442] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] found:
<7> [338.953815] i915 0000:00:02.0: [drm:intel_atomic_check [i915]] [CRTC:162:pipe C] fastset requirement not met, forcing full modeset
<7> [338.954189] i915 0000:00:02.0: [drm:intel_dpll_crtc_put [i915]] [CRTC:162:pipe C] releasing PORT PLL C
<7> [338.954766] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] [CRTC:162:pipe C] dbuf slices 0x1 -> 0x0, ddb (0 - 1020) -> (0 - 0), active pipes 0x4 -> 0x0
<7> [338.955197] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] [PLANE:156:cursor C] ddb ( 988 - 1020) -> ( 0 - 0), size 32 -> 0
<7> [338.955690] i915 0000:00:02.0: [drm:intel_cdclk_atomic_check [i915]] [CRTC:162:pipe C] min cdclk: 192000 kHz -> 0 kHz
<7> [338.956120] i915 0000:00:02.0: [drm:intel_cdclk_atomic_check [i915]] Modeset required for cdclk change
<7> [338.956516] i915 0000:00:02.0: [drm:intel_cdclk_atomic_check [i915]] New cdclk calculated to be logical 79200 kHz, actual 79200 kHz
<7> [338.956883] i915 0000:00:02.0: [drm:intel_cdclk_atomic_check [i915]] New voltage level calculated to be logical 4, actual 4
<7> [338.957257] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [CRTC:162:pipe C] enable: no [modeset]
<7> [338.957650] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:120:plane 1C] fb: [NOFB], visible: no
<7> [338.958024] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:129:plane 2C] fb: [NOFB], visible: no
<7> [338.958394] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:138:plane 3C] fb: [NOFB], visible: no
<7> [338.958793] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:147:plane 4C] fb: [NOFB], visible: no
<7> [338.959168] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:156:cursor C] fb: [NOFB], visible: no
<7> [338.959749] i915 0000:00:02.0: [drm:intel_audio_codec_disable [i915]] [CONNECTOR:174:HDMI-A-2][ENCODER:173:DDI C/PHY C] Disable audio codec on [CRTC:162:pipe C]
<7> [338.977801] i915 0000:00:02.0: [drm:intel_disable_transcoder [i915]] disabling pipe C
<7> [338.994466] i915 0000:00:02.0: [drm:intel_ddi_disable_transcoder_func [i915]] Quirk Increase DDI disabled time
<7> [339.099774] i915 0000:00:02.0: [drm:intel_power_well_disable [i915]] disabling DDI_IO_C
<7> [339.101123] i915 0000:00:02.0: [drm:intel_dpll_disable [i915]] disable PORT PLL C (active 0x4, on? 1) for [CRTC:162:pipe C]
<7> [339.103347] i915 0000:00:02.0: [drm:intel_dpll_disable [i915]] disabling PORT PLL C
<7> [339.103997] 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> [339.104944] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:163:DDI B/PHY B]
<7> [339.105450] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:173:DDI C/PHY C]
<7> [339.106221] i915 0000:00:02.0: [drm:verify_connector_state [i915]] [CONNECTOR:174:HDMI-A-2]
<7> [339.106967] i915 0000:00:02.0: [drm:intel_power_well_disable [i915]] disabling dpio-common-c
<7> [339.107380] i915 0000:00:02.0: [drm:intel_power_well_disable [i915]] disabling PW_2
<7> [339.107884] i915 0000:00:02.0: [drm:intel_modeset_verify_crtc [i915]] [CRTC:162:pipe C]
<7> [339.108892] i915 0000:00:02.0: [drm:drm_mode_setcrtc] [CRTC:162:pipe C]
<7> [339.108962] i915 0000:00:02.0: [drm:drm_mode_setcrtc] [CONNECTOR:174:HDMI-A-2]
<7> [339.110531] i915 0000:00:02.0: [drm:intel_hdmi_compute_clock [i915]] picking 12 bpc for HDMI output (pipe bpp: 36)
<7> [339.111051] i915 0000:00:02.0: [drm:intel_atomic_check [i915]] [CRTC:162:pipe C] hw max bpp: 36, pipe bpp: 36, dithering: 0
<7> [339.111461] i915 0000:00:02.0: [drm:intel_ddi_compute_config_late [i915]] [ENCODER:173:DDI C/PHY C] [CRTC:162:pipe C]
<7> [339.111833] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:162:pipe C] fastset requirement not met in hw.enable (expected no, found yes)
<7> [339.112209] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:162:pipe C] fastset requirement not met in hw.active (expected no, found yes)
<7> [339.112596] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:162:pipe C] fastset requirement not met in cpu_transcoder (expected -1, found 2)
<7> [339.112969] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:162:pipe C] fastset requirement not met in lane_count (expected 0, found 4)
<7> [339.113339] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:162:pipe C] fastset requirement not met in lane_lat_optim_mask (expected 0x00000000, found 0x0000000d)
<7> [339.113728] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:162:pipe C] fastset requirement not met in output_types (expected 0x00000000, found 0x00000040)
<7> [339.114103] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:162:pipe C] fastset requirement not met in framestart_delay (expected 0, found 1)
<7> [339.114496] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:162:pipe C] fastset requirement not met in hw.pipe_mode.crtc_hdisplay (expected 0, found 1920)
<7> [339.114867] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:162:pipe C] fastset requirement not met in hw.pipe_mode.crtc_htotal (expected 0, found 2200)
<7> [339.115238] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:162:pipe C] fastset requirement not met in hw.pipe_mode.crtc_hblank_start (expected 0, found 1920)
<7> [339.115631] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:162:pipe C] fastset requirement not met in hw.pipe_mode.crtc_hblank_end (expected 0, found 2200)
<7> [339.116000] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:162:pipe C] fastset requirement not met in hw.pipe_mode.crtc_hsync_start (expected 0, found 2008)
<7> [339.116371] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:162:pipe C] fastset requirement not met in hw.pipe_mode.crtc_hsync_end (expected 0, found 2052)
<7> [339.116756] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:162:pipe C] fastset requirement not met in hw.pipe_mode.crtc_vdisplay (expected 0, found 1080)
<7> [339.117128] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:162:pipe C] fastset requirement not met in hw.pipe_mode.crtc_vblank_start (expected 0, found 1080)
<7> [339.117515] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:162:pipe C] fastset requirement not met in hw.pipe_mode.crtc_vsync_start (expected 0, found 1083)
<7> [339.117886] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:162:pipe C] fastset requirement not met in hw.pipe_mode.crtc_vsync_end (expected 0, found 1088)
<7> [339.118261] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:162:pipe C] fastset requirement not met in hw.pipe_mode.crtc_vtotal (expected 0, found 1125)
<7> [339.118648] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:162:pipe C] fastset requirement not met in hw.pipe_mode.crtc_vblank_end (expected 0, found 1125)
<7> [339.119018] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:162:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_hdisplay (expected 0, found 1920)
<7> [339.119390] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:162:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_htotal (expected 0, found 2200)
<7> [339.119799] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:162:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_hblank_start (expected 0, found 1920)
<7> [339.120171] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:162:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_hblank_end (expected 0, found 2200)
<7> [339.120581] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:162:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_hsync_start (expected 0, found 2008)
<7> [339.120954] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:162:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_hsync_end (expected 0, found 2052)
<7> [339.121323] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:162:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_vdisplay (expected 0, found 1080)
<7> [339.121733] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:162:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_vblank_start (expected 0, found 1080)
<7> [339.122103] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:162:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_vsync_start (expected 0, found 1083)
<7> [339.122514] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:162:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_vsync_end (expected 0, found 1088)
<7> [339.122884] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:162:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_vtotal (expected 0, found 1125)
<7> [339.123255] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:162:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_vblank_end (expected 0, found 1125)
<7> [339.123648] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:162:pipe C] fastset requirement not met in pixel_multiplier (expected 0, found 1)
<7> [339.124018] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:162:pipe C] fastset requirement not met in hw.adjusted_mode.flags (1) (expected 0, found 1)
<7> [339.124387] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:162:pipe C] fastset requirement not met in hw.adjusted_mode.flags (8) (expected 0, found 8)
<7> [339.124787] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:162:pipe C] fastset requirement not met in has_hdmi_sink (expected no, found yes)
<7> [339.125157] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:162:pipe C] fastset requirement not met in has_infoframe (expected no, found yes)
<7> [339.125547] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:162:pipe C] fastset requirement not met in pipe_bpp (expected 0, found 36)
<7> [339.125922] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:162:pipe C] fastset requirement not met in hw.pipe_mode.crtc_clock (expected 0, found 148500)
<7> [339.126292] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:162:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_clock (expected 0, found 148500)
<7> [339.126699] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:162:pipe C] fastset requirement not met in port_clock (expected 0, found 222750)
<7> [339.126754] i915 0000:00:02.0: [drm:intel_power_well_disable [i915]] disabling DC_off
<7> [339.127072] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:162:pipe C] fastset requirement not met in infoframes.enable (expected 0x00000000, found 0x00000071)
<7> [339.127168] i915 0000:00:02.0: [drm:gen9_enable_dc5 [i915]] Enabling DC5
<7> [339.127459] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:162:pipe C] fastset requirement not met in infoframes.gcp (expected 0x00000000, found 0x00000006)
<7> [339.127565] i915 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [i915]] Setting DC state from 00 to 01
<7> [339.127834] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:162:pipe C] fastset requirement not met in avi infoframe
<7> [339.128208] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] expected:
<7> [339.128594] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] found:
<7> [339.128962] i915 0000:00:02.0: HDMI infoframe: Auxiliary Video Information (AVI), version 2, length 13
<7> [339.128968] i915 0000:00:02.0: colorspace: RGB
<7> [339.128972] i915 0000:00:02.0: scan mode: Underscan
<7> [339.128975] i915 0000:00:02.0: colorimetry: No Data
<7> [339.128978] i915 0000:00:02.0: picture aspect: No Data
<7> [339.128981] i915 0000:00:02.0: active aspect: Same as Picture
<7> [339.128985] i915 0000:00:02.0: itc: No Data
<7> [339.128988] i915 0000:00:02.0: extended colorimetry: xvYCC 601
<7> [339.128991] i915 0000:00:02.0: quantization range: Full
<7> [339.128994] i915 0000:00:02.0: nups: Unknown Non-uniform Scaling
<7> [339.128997] i915 0000:00:02.0: video code: 0
<7> [339.129000] i915 0000:00:02.0: ycc quantization range: Full
<7> [339.129003] i915 0000:00:02.0: hdmi content type: Graphics
<7> [339.129006] i915 0000:00:02.0: pixel repeat: 0
<7> [339.129009] i915 0000:00:02.0: bar top 0, bottom 0, left 0, right 0
<7> [339.128936] i915 0000:00:02.0: [drm:intel_power_well_disable [i915]] disabling always-on
<7> [339.129013] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:162:pipe C] fastset requirement not met in spd infoframe
<7> [339.129383] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] expected:
<7> [339.129764] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] found:
<7> [339.130135] i915 0000:00:02.0: HDMI infoframe: Source Product Description (SPD), version 1, length 25
<7> [339.130139] i915 0000:00:02.0: vendor: Intel
<7> [339.130142] i915 0000:00:02.0: product: Integrated gfx
<7> [339.130145] i915 0000:00:02.0: source device information: PC General (0x9)
<7> [339.130149] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:162:pipe C] fastset requirement not met in hdmi infoframe
<7> [339.130541] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] expected:
<7> [339.130909] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] found:
<7> [339.131275] i915 0000:00:02.0: HDMI infoframe: Vendor, version 1, length 4
<7> [339.131281] i915 0000:00:02.0: empty frame
<7> [339.131286] i915 0000:00:02.0: [drm:intel_atomic_check [i915]] [CRTC:162:pipe C] fastset requirement not met, forcing full modeset
<7> [339.132003] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] [CRTC:162:pipe C] dbuf slices 0x0 -> 0x1, ddb (0 - 0) -> (0 - 1020), active pipes 0x0 -> 0x4
<7> [339.132623] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] [PLANE:120:plane 1C] ddb ( 0 - 0) -> ( 0 - 988), size 0 -> 988
<7> [339.132998] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] [PLANE:156:cursor C] ddb ( 0 - 0) -> ( 988 - 1020), size 0 -> 32
<7> [339.133364] i915 0000:00:02.0: [drm:skl_print_plane_changes [i915]] [PLANE:120: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> [339.133753] i915 0000:00:02.0: [drm:skl_print_plane_changes [i915]] [PLANE:120: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> [339.134124] i915 0000:00:02.0: [drm:skl_print_plane_changes [i915]] [PLANE:120: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> [339.134515] i915 0000:00:02.0: [drm:skl_print_plane_changes [i915]] [PLANE:120: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> [339.134975] i915 0000:00:02.0: [drm:intel_cdclk_atomic_check [i915]] [CRTC:162:pipe C] min cdclk: 0 kHz -> 192000 kHz
<7> [339.135462] i915 0000:00:02.0: [drm:intel_cdclk_update_dbuf_bw_min_cdclk [i915]] dbuf bandwidth min cdclk: 18563 kHz -> 9282 kHz
<7> [339.135880] i915 0000:00:02.0: [drm:intel_cdclk_atomic_check [i915]] Modeset required for cdclk change
<7> [339.136252] i915 0000:00:02.0: [drm:intel_cdclk_atomic_check [i915]] New cdclk calculated to be logical 316800 kHz, actual 316800 kHz
<7> [339.136674] i915 0000:00:02.0: [drm:intel_cdclk_atomic_check [i915]] New voltage level calculated to be logical 13, actual 13
<7> [339.137054] i915 0000:00:02.0: [drm:bxt_get_dpll [i915]] [CRTC:162:pipe C] using pre-allocated PORT PLL C
<7> [339.137459] i915 0000:00:02.0: [drm:intel_dpll_crtc_get [i915]] [CRTC:162:pipe C] reserving PORT PLL C
<7> [339.137837] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [CRTC:162:pipe C] enable: yes [modeset]
<7> [339.138209] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] active: yes, output_types: HDMI (0x40), output format: RGB, sink format: RGB
<7> [339.138611] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] cpu_transcoder: C, pipe bpp: 36, dithering: 0
<7> [339.138979] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] MST master transcoder: <invalid>
<7> [339.139347] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] port sync: master transcoder: <invalid>, slave transcoder bitmask = 0x0
<7> [339.139743] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] joiner: no, pipes: 0x0
<7> [339.140110] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] splitter: disabled, link count 0, overlap 0
<7> [339.140504] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] audio: 1, infoframes: 1, infoframes enabled: 0x71
<7> [339.140875] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] GCP: 0x6
<7> [339.141249] i915 0000:00:02.0: HDMI infoframe: Auxiliary Video Information (AVI), version 2, length 13
<7> [339.141254] i915 0000:00:02.0: colorspace: RGB
<7> [339.141257] i915 0000:00:02.0: scan mode: Underscan
<7> [339.141261] i915 0000:00:02.0: colorimetry: No Data
<7> [339.141264] i915 0000:00:02.0: picture aspect: No Data
<7> [339.141267] i915 0000:00:02.0: active aspect: Same as Picture
<7> [339.141270] i915 0000:00:02.0: itc: No Data
<7> [339.141273] i915 0000:00:02.0: extended colorimetry: xvYCC 601
<7> [339.141276] i915 0000:00:02.0: quantization range: Full
<7> [339.141279] i915 0000:00:02.0: nups: Unknown Non-uniform Scaling
<7> [339.141283] i915 0000:00:02.0: video code: 0
<7> [339.141286] i915 0000:00:02.0: ycc quantization range: Full
<7> [339.141289] i915 0000:00:02.0: hdmi content type: Graphics
<7> [339.141292] i915 0000:00:02.0: pixel repeat: 0
<7> [339.141295] i915 0000:00:02.0: bar top 0, bottom 0, left 0, right 0
<7> [339.141299] i915 0000:00:02.0: HDMI infoframe: Source Product Description (SPD), version 1, length 25
<7> [339.141303] i915 0000:00:02.0: vendor: Intel
<7> [339.141306] i915 0000:00:02.0: product: Integrated gfx
<7> [339.141309] i915 0000:00:02.0: source device information: PC General (0x9)
<7> [339.141313] i915 0000:00:02.0: HDMI infoframe: Vendor, version 1, length 4
<7> [339.141316] i915 0000:00:02.0: empty frame
<7> [339.141320] 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> [339.141708] 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> [339.142077] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] scanline offset: 2
<7> [339.142462] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] framestart delay: 1, MSA timing delay: 0, set context latency: 0
<7> [339.142834] 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> [339.143206] 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> [339.143595] 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> [339.143967] 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> [339.144335] 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> [339.144735] 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> [339.145106] 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> [339.145494] 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> [339.145864] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] linetime: 59, ips linetime: 0
<7> [339.146233] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] num_scalers: 1, scaler_users: 0x0, scaler_id: -1, scaling_filter: 0
<7> [339.146625] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pch pfit: 0x0+0+0, disabled, force thru: no
<7> [339.146996] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] ips: 0, double wide: 0, drrs: 0
<7> [339.147368] 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> [339.147759] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] csc_mode: 0x0 gamma_mode: 0x0 gamma_enable: 0 csc_enable: 0
<7> [339.148128] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pre csc lut: 0 entries, post csc lut: 0 entries
<7> [339.148524] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pipe csc: pre offsets: 0x0000 0x0000 0x0000
<7> [339.148896] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pipe csc: coefficients: 0x0000 0x0000 0x0000
<7> [339.149263] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pipe csc: coefficients: 0x0000 0x0000 0x0000
<7> [339.149651] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pipe csc: coefficients: 0x0000 0x0000 0x0000
<7> [339.150019] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pipe csc: post offsets: 0x0000 0x0000 0x0000
<7> [339.150388] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] sharpness strength: 0, sharpness tap size: 0, sharpness enable: 0
<7> [339.150781] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:120:plane 1C] fb: [FB:180] 1920x1080 format = XR24 little-endian (0x34325258) modifier = 0x100000000000001, visible: yes
<7> [339.151154] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] rotation: 0x1, scaler: -1, scaling_filter: 0
<7> [339.151542] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] src: 1920.000000x1080.000000+0.000000+0.000000 dst: 1920x1080+0+0
<7> [339.151913] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:129:plane 2C] fb: [NOFB], visible: no
<7> [339.152279] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:138:plane 3C] fb: [NOFB], visible: no
<7> [339.152679] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:147:plane 4C] fb: [NOFB], visible: no
<7> [339.153051] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:156:cursor C] fb: [NOFB], visible: no
<7> [339.154383] i915 0000:00:02.0: [drm:intel_power_well_enable [i915]] enabling always-on
<7> [339.154832] i915 0000:00:02.0: [drm:intel_power_well_enable [i915]] enabling DC_off
<7> [339.155732] i915 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [i915]] Setting DC state from 01 to 00
<7> [339.156908] i915 0000:00:02.0: [drm:intel_power_well_enable [i915]] enabling PW_2
<7> [339.157404] i915 0000:00:02.0: [drm:intel_power_well_enable [i915]] enabling dpio-common-c
<7> [339.158183] 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> [339.158744] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:163:DDI B/PHY B]
<7> [339.159121] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:173:DDI C/PHY C]
<7> [339.159674] i915 0000:00:02.0: [drm:intel_dpll_enable [i915]] enable PORT PLL C (active 0x4, on? 0) for [CRTC:162:pipe C]
<7> [339.160052] i915 0000:00:02.0: [drm:intel_dpll_enable [i915]] enabling PORT PLL C
<7> [339.160611] i915 0000:00:02.0: [drm:intel_power_well_enable [i915]] enabling DDI_IO_C
<7> [339.161091] i915 0000:00:02.0: [drm:intel_enable_transcoder [i915]] enabling pipe C
<7> [339.179176] i915 0000:00:02.0: [drm:intel_audio_codec_enable [i915]] [CONNECTOR:174:HDMI-A-2][ENCODER:173:DDI C/PHY C] Enable audio codec on [CRTC:162:pipe C], 32 bytes ELD
<7> [339.195792] i915 0000:00:02.0: [drm:audio_config_hdmi_pixel_clock [i915]] Configuring HDMI audio for pixel clock 148500 (0x00090000)
<7> [339.196272] i915 0000:00:02.0: [drm:hsw_audio_config_update [i915]] using automatic N
<7> [339.197983] i915 0000:00:02.0: [drm:verify_connector_state [i915]] [CONNECTOR:174:HDMI-A-2]
<7> [339.198677] i915 0000:00:02.0: [drm:intel_modeset_verify_crtc [i915]] [CRTC:162:pipe C]
<7> [339.201372] i915 0000:00:02.0: [drm:drm_mode_setcrtc] [CRTC:119:pipe B]
<7> [339.201466] i915 0000:00:02.0: [drm:drm_mode_setcrtc] [CONNECTOR:164:HDMI-A-1]
<7> [339.201648] i915 0000:00:02.0: [drm:intel_hdmi_compute_clock [i915]] picking 12 bpc for HDMI output (pipe bpp: 36)
<7> [339.202123] i915 0000:00:02.0: [drm:intel_atomic_check [i915]] [CRTC:119:pipe B] hw max bpp: 36, pipe bpp: 36, dithering: 0
<7> [339.202541] i915 0000:00:02.0: [drm:intel_ddi_compute_config_late [i915]] [ENCODER:163:DDI B/PHY B] [CRTC:119:pipe B]
<7> [339.202910] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:119:pipe B] fastset requirement not met in hw.enable (expected no, found yes)
<7> [339.203285] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:119:pipe B] fastset requirement not met in hw.active (expected no, found yes)
<7> [339.203690] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:119:pipe B] fastset requirement not met in cpu_transcoder (expected -1, found 1)
<7> [339.204062] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:119:pipe B] fastset requirement not met in lane_count (expected 0, found 4)
<7> [339.204461] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:119:pipe B] fastset requirement not met in lane_lat_optim_mask (expected 0x00000000, found 0x0000000d)
<7> [339.204832] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:119:pipe B] fastset requirement not met in output_types (expected 0x00000000, found 0x00000040)
<7> [339.205201] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:119:pipe B] fastset requirement not met in framestart_delay (expected 0, found 1)
<7> [339.205606] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:119:pipe B] fastset requirement not met in hw.pipe_mode.crtc_hdisplay (expected 0, found 1920)
<7> [339.205977] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:119:pipe B] fastset requirement not met in hw.pipe_mode.crtc_htotal (expected 0, found 2200)
<7> [339.206344] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:119:pipe B] fastset requirement not met in hw.pipe_mode.crtc_hblank_start (expected 0, found 1920)
<7> [339.206742] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:119:pipe B] fastset requirement not met in hw.pipe_mode.crtc_hblank_end (expected 0, found 2200)
<7> [339.207112] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:119:pipe B] fastset requirement not met in hw.pipe_mode.crtc_hsync_start (expected 0, found 2008)
<7> [339.207516] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:119:pipe B] fastset requirement not met in hw.pipe_mode.crtc_hsync_end (expected 0, found 2052)
<7> [339.207886] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:119:pipe B] fastset requirement not met in hw.pipe_mode.crtc_vdisplay (expected 0, found 1080)
<7> [339.208254] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:119:pipe B] fastset requirement not met in hw.pipe_mode.crtc_vblank_start (expected 0, found 1080)
<7> [339.208651] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:119:pipe B] fastset requirement not met in hw.pipe_mode.crtc_vsync_start (expected 0, found 1083)
<7> [339.209021] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:119:pipe B] fastset requirement not met in hw.pipe_mode.crtc_vsync_end (expected 0, found 1088)
<7> [339.209390] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:119:pipe B] fastset requirement not met in hw.pipe_mode.crtc_vtotal (expected 0, found 1125)
<7> [339.209802] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:119:pipe B] fastset requirement not met in hw.pipe_mode.crtc_vblank_end (expected 0, found 1125)
<7> [339.210171] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:119:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_hdisplay (expected 0, found 1920)
<7> [339.210571] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:119:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_htotal (expected 0, found 2200)
<7> [339.210941] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:119:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_hblank_start (expected 0, found 1920)
<7> [339.211309] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:119:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_hblank_end (expected 0, found 2200)
<7> [339.211703] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:119:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_hsync_start (expected 0, found 2008)
<7> [339.212072] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:119:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_hsync_end (expected 0, found 2052)
<7> [339.212492] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:119:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_vdisplay (expected 0, found 1080)
<7> [339.212864] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:119:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_vblank_start (expected 0, found 1080)
<7> [339.213234] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:119:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_vsync_start (expected 0, found 1083)
<7> [339.213626] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:119:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_vsync_end (expected 0, found 1088)
<7> [339.213996] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:119:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_vtotal (expected 0, found 1125)
<7> [339.214363] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:119:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_vblank_end (expected 0, found 1125)
<7> [339.214750] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:119:pipe B] fastset requirement not met in pixel_multiplier (expected 0, found 1)
<7> [339.215119] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:119:pipe B] fastset requirement not met in hw.adjusted_mode.flags (1) (expected 0, found 1)
<7> [339.215510] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:119:pipe B] fastset requirement not met in hw.adjusted_mode.flags (8) (expected 0, found 8)
<7> [339.215879] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:119:pipe B] fastset requirement not met in has_hdmi_sink (expected no, found yes)
<7> [339.216248] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:119:pipe B] fastset requirement not met in has_infoframe (expected no, found yes)
<7> [339.216627] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:119:pipe B] fastset requirement not met in pipe_bpp (expected 0, found 36)
<7> [339.216995] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:119:pipe B] fastset requirement not met in hw.pipe_mode.crtc_clock (expected 0, found 148500)
<7> [339.217362] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:119:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_clock (expected 0, found 148500)
<7> [339.217746] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:119:pipe B] fastset requirement not met in port_clock (expected 0, found 222750)
<7> [339.218115] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:119:pipe B] fastset requirement not met in infoframes.enable (expected 0x00000000, found 0x00000071)
<7> [339.218498] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:119:pipe B] fastset requirement not met in infoframes.gcp (expected 0x00000000, found 0x00000006)
<7> [339.218870] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:119:pipe B] fastset requirement not met in avi infoframe
<7> [339.219238] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] expected:
<7> [339.219628] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] found:
<7> [339.219996] i915 0000:00:02.0: HDMI infoframe: Auxiliary Video Information (AVI), version 2, length 13
<7> [339.220001] i915 0000:00:02.0: colorspace: RGB
<7> [339.220004] i915 0000:00:02.0: scan mode: Underscan
<7> [339.220008] i915 0000:00:02.0: colorimetry: No Data
<7> [339.220011] i915 0000:00:02.0: picture aspect: No Data
<7> [339.220014] i915 0000:00:02.0: active aspect: Same as Picture
<7> [339.220017] i915 0000:00:02.0: itc: No Data
<7> [339.220020] i915 0000:00:02.0: extended colorimetry: xvYCC 601
<7> [339.220024] i915 0000:00:02.0: quantization range: Full
<7> [339.220027] i915 0000:00:02.0: nups: Unknown Non-uniform Scaling
<7> [339.220030] i915 0000:00:02.0: video code: 0
<7> [339.220033] i915 0000:00:02.0: ycc quantization range: Full
<7> [339.220036] i915 0000:00:02.0: hdmi content type: Graphics
<7> [339.220039] i915 0000:00:02.0: pixel repeat: 0
<7> [339.220042] i915 0000:00:02.0: bar top 0, bottom 0, left 0, right 0
<7> [339.220046] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:119:pipe B] fastset requirement not met in spd infoframe
<7> [339.220413] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] expected:
<7> [339.220796] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] found:
<7> [339.221165] i915 0000:00:02.0: HDMI infoframe: Source Product Description (SPD), version 1, length 25
<7> [339.221168] i915 0000:00:02.0: vendor: Intel
<7> [339.221172] i915 0000:00:02.0: product: Integrated gfx
<7> [339.221175] i915 0000:00:02.0: source device information: PC General (0x9)
<7> [339.221179] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:119:pipe B] fastset requirement not met in hdmi infoframe
<7> [339.221571] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] expected:
<7> [339.221939] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] found:
<7> [339.222305] i915 0000:00:02.0: HDMI infoframe: Vendor, version 1, length 4
<7> [339.222309] i915 0000:00:02.0: empty frame
<7> [339.222314] i915 0000:00:02.0: [drm:intel_atomic_check [i915]] [CRTC:119:pipe B] fastset requirement not met, forcing full modeset
<7> [339.224512] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] [CRTC:119:pipe B] dbuf slices 0x0 -> 0x1, ddb (0 - 0) -> (0 - 510), active pipes 0x4 -> 0x6
<7> [339.225005] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] [CRTC:162:pipe C] dbuf slices 0x1 -> 0x1, ddb (0 - 1020) -> (510 - 1020), active pipes 0x4 -> 0x6
<7> [339.225498] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] [PLANE:77:plane 1B] ddb ( 0 - 0) -> ( 0 - 497), size 0 -> 497
<7> [339.225864] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] [PLANE:113:cursor B] ddb ( 0 - 0) -> ( 497 - 510), size 0 -> 13
<7> [339.226228] i915 0000:00:02.0: [drm:skl_print_plane_changes [i915]] [PLANE:77: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> [339.226623] i915 0000:00:02.0: [drm:skl_print_plane_changes [i915]] [PLANE:77: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> [339.226989] i915 0000:00:02.0: [drm:skl_print_plane_changes [i915]] [PLANE:77: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> [339.227354] i915 0000:00:02.0: [drm:skl_print_plane_changes [i915]] [PLANE:77: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> [339.227742] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] [PLANE:120:plane 1C] ddb ( 0 - 988) -> ( 510 - 1007), size 988 -> 497
<7> [339.228106] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] [PLANE:156:cursor C] ddb ( 988 - 1020) -> (1007 - 1020), size 32 -> 13
<7> [339.230043] i915 0000:00:02.0: [drm:intel_cdclk_atomic_check [i915]] [CRTC:119:pipe B] min cdclk: 0 kHz -> 192000 kHz
<7> [339.230716] i915 0000:00:02.0: [drm:intel_cdclk_update_dbuf_bw_min_cdclk [i915]] dbuf bandwidth min cdclk: 9282 kHz -> 18563 kHz
<7> [339.231096] i915 0000:00:02.0: [drm:bxt_get_dpll [i915]] [CRTC:119:pipe B] using pre-allocated PORT PLL B
<7> [339.231504] i915 0000:00:02.0: [drm:intel_dpll_crtc_get [i915]] [CRTC:119:pipe B] reserving PORT PLL B
<7> [339.231885] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [CRTC:119:pipe B] enable: yes [modeset]
<7> [339.232257] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] active: yes, output_types: HDMI (0x40), output format: RGB, sink format: RGB
<7> [339.232649] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] cpu_transcoder: B, pipe bpp: 36, dithering: 0
<7> [339.233019] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] MST master transcoder: <invalid>
<7> [339.233385] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] port sync: master transcoder: <invalid>, slave transcoder bitmask = 0x0
<7> [339.233777] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] joiner: no, pipes: 0x0
<7> [339.234144] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] splitter: disabled, link count 0, overlap 0
<7> [339.234535] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] audio: 1, infoframes: 1, infoframes enabled: 0x71
<7> [339.234904] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] GCP: 0x6
<7> [339.235271] i915 0000:00:02.0: HDMI infoframe: Auxiliary Video Information (AVI), version 2, length 13
<7> [339.235276] i915 0000:00:02.0: colorspace: RGB
<7> [339.235279] i915 0000:00:02.0: scan mode: Underscan
<7> [339.235282] i915 0000:00:02.0: colorimetry: No Data
<7> [339.235285] i915 0000:00:02.0: picture aspect: No Data
<7> [339.235288] i915 0000:00:02.0: active aspect: Same as Picture
<7> [339.235292] i915 0000:00:02.0: itc: No Data
<7> [339.235295] i915 0000:00:02.0: extended colorimetry: xvYCC 601
<7> [339.235298] i915 0000:00:02.0: quantization range: Full
<7> [339.235301] i915 0000:00:02.0: nups: Unknown Non-uniform Scaling
<7> [339.235304] i915 0000:00:02.0: video code: 0
<7> [339.235307] i915 0000:00:02.0: ycc quantization range: Full
<7> [339.235310] i915 0000:00:02.0: hdmi content type: Graphics
<7> [339.235313] i915 0000:00:02.0: pixel repeat: 0
<7> [339.235316] i915 0000:00:02.0: bar top 0, bottom 0, left 0, right 0
<7> [339.235320] i915 0000:00:02.0: HDMI infoframe: Source Product Description (SPD), version 1, length 25
<7> [339.235324] i915 0000:00:02.0: vendor: Intel
<7> [339.235327] i915 0000:00:02.0: product: Integrated gfx
<7> [339.235330] i915 0000:00:02.0: source device information: PC General (0x9)
<7> [339.235334] i915 0000:00:02.0: HDMI infoframe: Vendor, version 1, length 4
<7> [339.235338] i915 0000:00:02.0: empty frame
<7> [339.235341] 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> [339.235732] 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> [339.236101] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] scanline offset: 2
<7> [339.236482] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] framestart delay: 1, MSA timing delay: 0, set context latency: 0
<7> [339.236850] 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> [339.237218] 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> [339.237607] 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> [339.237976] 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> [339.238345] 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> [339.238729] 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> [339.239099] 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> [339.239494] 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> [339.239863] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] linetime: 59, ips linetime: 0
<7> [339.240230] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] num_scalers: 2, scaler_users: 0x0, scaler_id: -1, scaling_filter: 0
<7> [339.240616] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pch pfit: 0x0+0+0, disabled, force thru: no
<7> [339.240984] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] ips: 0, double wide: 0, drrs: 0
<7> [339.241351] 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> [339.241742] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] csc_mode: 0x0 gamma_mode: 0x0 gamma_enable: 0 csc_enable: 0
<7> [339.242111] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pre csc lut: 0 entries, post csc lut: 0 entries
<7> [339.242493] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pipe csc: pre offsets: 0x0000 0x0000 0x0000
<7> [339.242861] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pipe csc: coefficients: 0x0000 0x0000 0x0000
<7> [339.243228] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pipe csc: coefficients: 0x0000 0x0000 0x0000
<7> [339.243616] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pipe csc: coefficients: 0x0000 0x0000 0x0000
<7> [339.243984] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pipe csc: post offsets: 0x0000 0x0000 0x0000
<7> [339.244351] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] sharpness strength: 0, sharpness tap size: 0, sharpness enable: 0
<7> [339.244734] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:77:plane 1B] fb: [FB:180] 1920x1080 format = XR24 little-endian (0x34325258) modifier = 0x100000000000001, visible: yes
<7> [339.245109] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] rotation: 0x1, scaler: -1, scaling_filter: 0
<7> [339.245503] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] src: 1920.000000x1080.000000+0.000000+0.000000 dst: 1920x1080+0+0
<7> [339.245873] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:86:plane 2B] fb: [NOFB], visible: no
<7> [339.246240] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:95:plane 3B] fb: [NOFB], visible: no
<7> [339.246622] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:104:plane 4B] fb: [NOFB], visible: no
<7> [339.246990] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:113:cursor B] fb: [NOFB], visible: no
<7> [339.247762] i915 0000:00:02.0: [drm:intel_power_well_enable [i915]] enabling dpio-common-b
<7> [339.248467] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:163:DDI B/PHY B]
<7> [339.248839] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:173:DDI C/PHY C]
<7> [339.262550] i915 0000:00:02.0: [drm:intel_dpll_enable [i915]] enable PORT PLL B (active 0x2, on? 0) for [CRTC:119:pipe B]
<7> [339.263035] i915 0000:00:02.0: [drm:intel_dpll_enable [i915]] enabling PORT PLL B
<7> [339.264979] i915 0000:00:02.0: [drm:intel_power_well_enable [i915]] enabling DDI_IO_B
<7> [339.265595] i915 0000:00:02.0: [drm:intel_enable_transcoder [i915]] enabling pipe B
<7> [339.283590] i915 0000:00:02.0: [drm:intel_audio_codec_enable [i915]] [CONNECTOR:164:HDMI-A-1][ENCODER:163:DDI B/PHY B] Enable audio codec on [CRTC:119:pipe B], 32 bytes ELD
<7> [339.300241] i915 0000:00:02.0: [drm:audio_config_hdmi_pixel_clock [i915]] Configuring HDMI audio for pixel clock 148500 (0x00090000)
<7> [339.300739] i915 0000:00:02.0: [drm:hsw_audio_config_update [i915]] using automatic N
<7> [339.301282] i915 0000:00:02.0: [drm:verify_connector_state [i915]] [CONNECTOR:164:HDMI-A-1]
<7> [339.303023] i915 0000:00:02.0: [drm:intel_modeset_verify_crtc [i915]] [CRTC:119:pipe B]
<6> [341.645303] [IGT] kms_flip: finished subtest BC-HDMI-A1-HDMI-A2, FAIL
<6> [341.649020] [IGT] kms_flip: finished subtest 2x-flip-vs-expired-vblank-interruptible, FAIL
<7> [341.659253] i915 0000:00:02.0: [drm:drm_mode_rmfb_work_fn] Removing [FB:183] from all active usage due to RMFB ioctl
<7> [341.661809] i915 0000:00:02.0: [drm:atomic_remove_fb] Disabling [PLANE:77:plane 1B] because [FB:183] is removed
<7> [341.661873] i915 0000:00:02.0: [drm:atomic_remove_fb] Disabling [PLANE:120:plane 1C] because [FB:183] is removed
<7> [341.661970] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] [PLANE:77:plane 1B] ddb ( 0 - 497) -> ( 0 - 0), size 497 -> 0
<7> [341.662446] i915 0000:00:02.0: [drm:skl_print_plane_changes [i915]] [PLANE:77: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> [341.662879] i915 0000:00:02.0: [drm:skl_print_plane_changes [i915]] [PLANE:77: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> [341.663248] i915 0000:00:02.0: [drm:skl_print_plane_changes [i915]] [PLANE:77: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> [341.663613] i915 0000:00:02.0: [drm:skl_print_plane_changes [i915]] [PLANE:77: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> [341.663998] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] [PLANE:120:plane 1C] ddb ( 510 - 1007) -> ( 0 - 0), size 497 -> 0
<7> [341.664362] i915 0000:00:02.0: [drm:skl_print_plane_changes [i915]] [PLANE:120: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> [341.664755] i915 0000:00:02.0: [drm:skl_print_plane_changes [i915]] [PLANE:120: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> [341.665122] i915 0000:00:02.0: [drm:skl_print_plane_changes [i915]] [PLANE:120: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> [341.665487] i915 0000:00:02.0: [drm:skl_print_plane_changes [i915]] [PLANE:120: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> [341.687284] [IGT] kms_flip: exiting, ret=98
<7> [341.724962] i915 0000:00:02.0: [drm:intel_hdmi_compute_clock [i915]] picking 12 bpc for HDMI output (pipe bpp: 36)
<7> [341.725537] i915 0000:00:02.0: [drm:intel_atomic_check [i915]] [CRTC:76:pipe A] hw max bpp: 36, pipe bpp: 36, dithering: 0
<7> [341.726654] i915 0000:00:02.0: [drm:intel_hdmi_compute_clock [i915]] picking 12 bpc for HDMI output (pipe bpp: 36)
<7> [341.727073] i915 0000:00:02.0: [drm:intel_atomic_check [i915]] [CRTC:119:pipe B] hw max bpp: 36, pipe bpp: 36, dithering: 0
<7> [341.727481] i915 0000:00:02.0: [drm:intel_ddi_compute_config_late [i915]] [ENCODER:163:DDI B/PHY B] [CRTC:76:pipe A]
<7> [341.727954] i915 0000:00:02.0: [drm:intel_ddi_compute_config_late [i915]] [ENCODER:173:DDI C/PHY C] [CRTC:119:pipe B]
<7> [341.728329] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:76:pipe A] fastset requirement not met in hw.enable (expected no, found yes)
<7> [341.728857] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:76:pipe A] fastset requirement not met in hw.active (expected no, found yes)
<7> [341.729236] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:76:pipe A] fastset requirement not met in cpu_transcoder (expected -1, found 0)
<7> [341.729610] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:76:pipe A] fastset requirement not met in lane_count (expected 0, found 4)
<7> [341.730021] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:76:pipe A] fastset requirement not met in lane_lat_optim_mask (expected 0x00000000, found 0x0000000d)
<7> [341.730396] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:76:pipe A] fastset requirement not met in output_types (expected 0x00000000, found 0x00000040)
<7> [341.730805] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:76:pipe A] fastset requirement not met in framestart_delay (expected 0, found 1)
<7> [341.731178] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:76:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hdisplay (expected 0, found 1920)
<7> [341.731549] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:76:pipe A] fastset requirement not met in hw.pipe_mode.crtc_htotal (expected 0, found 2200)
<7> [341.731960] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:76:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hblank_start (expected 0, found 1920)
<7> [341.732333] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:76:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hblank_end (expected 0, found 2200)
<7> [341.732778] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:76:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hsync_start (expected 0, found 2008)
<7> [341.733185] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:76:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hsync_end (expected 0, found 2052)
<7> [341.733560] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:76:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vdisplay (expected 0, found 1080)
<7> [341.733955] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:76:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vblank_start (expected 0, found 1080)
<7> [341.734327] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:76:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vsync_start (expected 0, found 1083)
<7> [341.734754] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:76:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vsync_end (expected 0, found 1088)
<7> [341.735181] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:76:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vtotal (expected 0, found 1125)
<7> [341.735554] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:76:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vblank_end (expected 0, found 1125)
<7> [341.735962] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:76:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hdisplay (expected 0, found 1920)
<7> [341.736334] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:76:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_htotal (expected 0, found 2200)
<7> [341.736748] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:76:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hblank_start (expected 0, found 1920)
<7> [341.737119] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:76:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hblank_end (expected 0, found 2200)
<7> [341.737488] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:76:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hsync_start (expected 0, found 2008)
<7> [341.737880] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:76:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hsync_end (expected 0, found 2052)
<7> [341.738252] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:76:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vdisplay (expected 0, found 1080)
<7> [341.738685] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:76:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vblank_start (expected 0, found 1080)
<7> [341.739060] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:76:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vsync_start (expected 0, found 1083)
<7> [341.739434] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:76:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vsync_end (expected 0, found 1088)
<7> [341.739860] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:76:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vtotal (expected 0, found 1125)
<7> [341.740236] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:76:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vblank_end (expected 0, found 1125)
<7> [341.740606] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:76:pipe A] fastset requirement not met in pixel_multiplier (expected 0, found 1)
<7> [341.741034] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:76:pipe A] fastset requirement not met in hw.adjusted_mode.flags (1) (expected 0, found 1)
<7> [341.741411] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:76:pipe A] fastset requirement not met in hw.adjusted_mode.flags (8) (expected 0, found 8)
<7> [341.741800] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:76:pipe A] fastset requirement not met in has_hdmi_sink (expected no, found yes)
<7> [341.742175] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:76:pipe A] fastset requirement not met in has_infoframe (expected no, found yes)
<7> [341.742548] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:76:pipe A] fastset requirement not met in pipe_bpp (expected 0, found 36)
<7> [341.742942] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:76:pipe A] fastset requirement not met in hw.pipe_mode.crtc_clock (expected 0, found 148500)
<7> [341.743316] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:76:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_clock (expected 0, found 148500)
<7> [341.743706] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:76:pipe A] fastset requirement not met in port_clock (expected 0, found 222750)
<7> [341.744078] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:76:pipe A] fastset requirement not met in infoframes.enable (expected 0x00000000, found 0x00000071)
<7> [341.744450] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:76:pipe A] fastset requirement not met in infoframes.gcp (expected 0x00000000, found 0x00000006)
<7> [341.744841] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:76:pipe A] fastset requirement not met in avi infoframe
<7> [341.745213] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] expected:
<7> [341.745582] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] found:
<7> [341.745970] i915 0000:00:02.0: HDMI infoframe: Auxiliary Video Information (AVI), version 2, length 13
<7> [341.745976] i915 0000:00:02.0: colorspace: RGB
<7> [341.745981] i915 0000:00:02.0: scan mode: Underscan
<7> [341.745985] i915 0000:00:02.0: colorimetry: No Data
<7> [341.745989] i915 0000:00:02.0: picture aspect: No Data
<7> [341.745993] i915 0000:00:02.0: active aspect: Same as Picture
<7> [341.745996] i915 0000:00:02.0: itc: No Data
<7> [341.746000] i915 0000:00:02.0: extended colorimetry: xvYCC 601
<7> [341.746004] i915 0000:00:02.0: quantization range: Full
<7> [341.746007] i915 0000:00:02.0: nups: Unknown Non-uniform Scaling
<7> [341.746011] i915 0000:00:02.0: video code: 0
<7> [341.746015] i915 0000:00:02.0: ycc quantization range: Full
<7> [341.746018] i915 0000:00:02.0: hdmi content type: Graphics
<7> [341.746022] i915 0000:00:02.0: pixel repeat: 0
<7> [341.746026] i915 0000:00:02.0: bar top 0, bottom 0, left 0, right 0
<7> [341.746030] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:76:pipe A] fastset requirement not met in spd infoframe
<7> [341.746402] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] expected:
<7> [341.746793] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] found:
<7> [341.747164] i915 0000:00:02.0: HDMI infoframe: Source Product Description (SPD), version 1, length 25
<7> [341.747169] i915 0000:00:02.0: vendor: Intel
<7> [341.747173] i915 0000:00:02.0: product: Integrated gfx
<7> [341.747176] i915 0000:00:02.0: source device information: PC General (0x9)
<7> [341.747181] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:76:pipe A] fastset requirement not met in hdmi infoframe
<7> [341.747552] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] expected:
<7> [341.747949] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] found:
<7> [341.748320] i915 0000:00:02.0: HDMI infoframe: Vendor, version 1, length 4
<7> [341.748325] i915 0000:00:02.0: empty frame
<7> [341.748331] i915 0000:00:02.0: [drm:intel_atomic_check [i915]] [CRTC:76:pipe A] fastset requirement not met, forcing full modeset
<7> [341.748757] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:162:pipe C] fastset requirement not met in hw.enable (expected yes, found no)
<7> [341.749132] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:162:pipe C] fastset requirement not met in hw.active (expected yes, found no)
<7> [341.749502] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:162:pipe C] fastset requirement not met in cpu_transcoder (expected 2, found -1)
<7> [341.749893] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:162:pipe C] fastset requirement not met in lane_count (expected 4, found 0)
<7> [341.750266] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:162:pipe C] fastset requirement not met in lane_lat_optim_mask (expected 0x0000000d, found 0x00000000)
<7> [341.750656] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:162:pipe C] fastset requirement not met in output_types (expected 0x00000040, found 0x00000000)
<7> [341.751029] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:162:pipe C] fastset requirement not met in framestart_delay (expected 1, found 0)
<7> [341.751399] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:162:pipe C] fastset requirement not met in hw.pipe_mode.crtc_hdisplay (expected 1920, found 0)
<7> [341.751790] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:162:pipe C] fastset requirement not met in hw.pipe_mode.crtc_htotal (expected 2200, found 0)
<7> [341.752163] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:162:pipe C] fastset requirement not met in hw.pipe_mode.crtc_hblank_start (expected 1920, found 0)
<7> [341.752533] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:162:pipe C] fastset requirement not met in hw.pipe_mode.crtc_hblank_end (expected 2200, found 0)
<7> [341.752931] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:162:pipe C] fastset requirement not met in hw.pipe_mode.crtc_hsync_start (expected 2008, found 0)
<7> [341.753301] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:162:pipe C] fastset requirement not met in hw.pipe_mode.crtc_hsync_end (expected 2052, found 0)
<7> [341.753686] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:162:pipe C] fastset requirement not met in hw.pipe_mode.crtc_vdisplay (expected 1080, found 0)
<7> [341.754058] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:162:pipe C] fastset requirement not met in hw.pipe_mode.crtc_vblank_start (expected 1080, found 0)
<7> [341.754429] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:162:pipe C] fastset requirement not met in hw.pipe_mode.crtc_vsync_start (expected 1083, found 0)
<7> [341.754828] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:162:pipe C] fastset requirement not met in hw.pipe_mode.crtc_vsync_end (expected 1088, found 0)
<7> [341.755200] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:162:pipe C] fastset requirement not met in hw.pipe_mode.crtc_vtotal (expected 1125, found 0)
<7> [341.755571] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:162:pipe C] fastset requirement not met in hw.pipe_mode.crtc_vblank_end (expected 1125, found 0)
<7> [341.755966] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:162:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_hdisplay (expected 1920, found 0)
<7> [341.756339] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:162:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_htotal (expected 2200, found 0)
<7> [341.756728] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:162:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_hblank_start (expected 1920, found 0)
<7> [341.757100] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:162:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_hblank_end (expected 2200, found 0)
<7> [341.757472] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:162:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_hsync_start (expected 2008, found 0)
<7> [341.757865] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:162:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_hsync_end (expected 2052, found 0)
<7> [341.758237] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:162:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_vdisplay (expected 1080, found 0)
<7> [341.758608] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:162:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_vblank_start (expected 1080, found 0)
<7> [341.759013] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:162:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_vsync_start (expected 1083, found 0)
<7> [341.759386] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:162:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_vsync_end (expected 1088, found 0)
<7> [341.759781] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:162:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_vtotal (expected 1125, found 0)
<7> [341.760156] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:162:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_vblank_end (expected 1125, found 0)
<7> [341.760525] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:162:pipe C] fastset requirement not met in pixel_multiplier (expected 1, found 0)
<7> [341.760921] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:162:pipe C] fastset requirement not met in hw.adjusted_mode.flags (1) (expected 1, found 0)
<7> [341.761294] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:162:pipe C] fastset requirement not met in hw.adjusted_mode.flags (8) (expected 8, found 0)
<7> [341.761684] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:162:pipe C] fastset requirement not met in has_hdmi_sink (expected yes, found no)
<7> [341.762057] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:162:pipe C] fastset requirement not met in has_infoframe (expected yes, found no)
<7> [341.762429] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:162:pipe C] fastset requirement not met in pipe_bpp (expected 36, found 0)
<7> [341.762849] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:162:pipe C] fastset requirement not met in hw.pipe_mode.crtc_clock (expected 148500, found 0)
<7> [341.763222] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:162:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_clock (expected 148500, found 0)
<7> [341.763592] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:162:pipe C] fastset requirement not met in port_clock (expected 222750, found 0)
<7> [341.764006] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:162:pipe C] fastset requirement not met in infoframes.enable (expected 0x00000071, found 0x00000000)
<7> [341.764382] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:162:pipe C] fastset requirement not met in infoframes.gcp (expected 0x00000006, found 0x00000000)
<7> [341.764783] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:162:pipe C] fastset requirement not met in avi infoframe
<7> [341.765209] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] expected:
<7> [341.765581] i915 0000:00:02.0: HDMI infoframe: Auxiliary Video Information (AVI), version 2, length 13
<7> [341.765586] i915 0000:00:02.0: colorspace: RGB
<7> [341.765591] i915 0000:00:02.0: scan mode: Underscan
<7> [341.765594] i915 0000:00:02.0: colorimetry: No Data
<7> [341.765598] i915 0000:00:02.0: picture aspect: No Data
<7> [341.765601] i915 0000:00:02.0: active aspect: Same as Picture
<7> [341.765605] i915 0000:00:02.0: itc: No Data
<7> [341.765609] i915 0000:00:02.0: extended colorimetry: xvYCC 601
<7> [341.765613] i915 0000:00:02.0: quantization range: Full
<7> [341.765617] i915 0000:00:02.0: nups: Unknown Non-uniform Scaling
<7> [341.765620] i915 0000:00:02.0: video code: 0
<7> [341.765624] i915 0000:00:02.0: ycc quantization range: Full
<7> [341.765643] i915 0000:00:02.0: hdmi content type: Graphics
<7> [341.765648] i915 0000:00:02.0: pixel repeat: 0
<7> [341.765652] i915 0000:00:02.0: bar top 0, bottom 0, left 0, right 0
<7> [341.765656] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] found:
<7> [341.766026] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:162:pipe C] fastset requirement not met in spd infoframe
<7> [341.766409] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] expected:
<7> [341.766802] i915 0000:00:02.0: HDMI infoframe: Source Product Description (SPD), version 1, length 25
<7> [341.766807] i915 0000:00:02.0: vendor: Intel
<7> [341.766811] i915 0000:00:02.0: product: Integrated gfx
<7> [341.766815] i915 0000:00:02.0: source device information: PC General (0x9)
<7> [341.766819] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] found:
<7> [341.767194] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:162:pipe C] fastset requirement not met in hdmi infoframe
<7> [341.767563] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] expected:
<7> [341.767947] i915 0000:00:02.0: HDMI infoframe: Vendor, version 1, length 4
<7> [341.767952] i915 0000:00:02.0: empty frame
<7> [341.767955] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] found:
<7> [341.768335] i915 0000:00:02.0: [drm:intel_atomic_check [i915]] [CRTC:162:pipe C] fastset requirement not met, forcing full modeset
<7> [341.768731] i915 0000:00:02.0: [drm:intel_dpll_crtc_put [i915]] [CRTC:119:pipe B] releasing PORT PLL B
<7> [341.769108] i915 0000:00:02.0: [drm:intel_dpll_crtc_put [i915]] [CRTC:162:pipe C] releasing PORT PLL C
<7> [341.769897] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] [CRTC:76:pipe A] dbuf slices 0x0 -> 0x1, ddb (0 - 0) -> (0 - 510), active pipes 0x6 -> 0x3
<7> [341.770303] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] [CRTC:119:pipe B] dbuf slices 0x1 -> 0x1, ddb (0 - 510) -> (510 - 1020), active pipes 0x6 -> 0x3
<7> [341.770706] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] [CRTC:162:pipe C] dbuf slices 0x1 -> 0x0, ddb (510 - 1020) -> (0 - 0), active pipes 0x6 -> 0x3
<7> [341.771121] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] [PLANE:34:plane 1A] ddb ( 0 - 0) -> ( 0 - 497), size 0 -> 497
<7> [341.771494] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] [PLANE:70:cursor A] ddb ( 0 - 0) -> ( 497 - 510), size 0 -> 13
<7> [341.771892] i915 0000:00:02.0: [drm:skl_print_plane_changes [i915]] [PLANE:34:plane 1A] level wm0, wm1, wm2, wm3, wm4, wm5, wm6, wm7, twm, swm, stwm -> *wm0,*wm1,*wm2,*wm3,*wm4,*wm5,*wm6,*wm7,*twm, swm, stwm
<7> [341.772259] i915 0000:00:02.0: [drm:skl_print_plane_changes [i915]] [PLANE:34:plane 1A] lines 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0 -> 1, 1, 1, 2, 2, 2, 2, 2, 0, 0, 0
<7> [341.772626] i915 0000:00:02.0: [drm:skl_print_plane_changes [i915]] [PLANE:34:plane 1A] blocks 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0 -> 16, 16, 16, 33, 33, 33, 33, 33, 30, 0, 0
<7> [341.773044] i915 0000:00:02.0: [drm:skl_print_plane_changes [i915]] [PLANE:34:plane 1A] min_ddb 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0 -> 17, 17, 17, 34, 34, 34, 34, 34, 31, 0, 0
<7> [341.773417] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] [PLANE:77:plane 1B] ddb ( 0 - 0) -> ( 510 - 1007), size 0 -> 497
<7> [341.773889] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] [PLANE:113:cursor B] ddb ( 497 - 510) -> (1007 - 1020), size 13 -> 13
<7> [341.774260] i915 0000:00:02.0: [drm:skl_print_plane_changes [i915]] [PLANE:77: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> [341.774625] i915 0000:00:02.0: [drm:skl_print_plane_changes [i915]] [PLANE:77: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> [341.775019] i915 0000:00:02.0: [drm:skl_print_plane_changes [i915]] [PLANE:77: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> [341.775453] i915 0000:00:02.0: [drm:skl_print_plane_changes [i915]] [PLANE:77: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> [341.775861] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] [PLANE:156:cursor C] ddb (1007 - 1020) -> ( 0 - 0), size 13 -> 0
<7> [341.776364] i915 0000:00:02.0: [drm:intel_cdclk_atomic_check [i915]] [CRTC:76:pipe A] min cdclk: 0 kHz -> 192000 kHz
<7> [341.776808] i915 0000:00:02.0: [drm:intel_cdclk_atomic_check [i915]] [CRTC:162:pipe C] min cdclk: 192000 kHz -> 0 kHz
<7> [341.777279] i915 0000:00:02.0: [drm:bxt_get_dpll [i915]] [CRTC:76:pipe A] using pre-allocated PORT PLL B
<7> [341.777693] i915 0000:00:02.0: [drm:intel_dpll_crtc_get [i915]] [CRTC:76:pipe A] reserving PORT PLL B
<7> [341.778076] i915 0000:00:02.0: [drm:bxt_get_dpll [i915]] [CRTC:119:pipe B] using pre-allocated PORT PLL C
<7> [341.778448] i915 0000:00:02.0: [drm:intel_dpll_crtc_get [i915]] [CRTC:119:pipe B] reserving PORT PLL C
<7> [341.778878] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [CRTC:76:pipe A] enable: yes [modeset]
<7> [341.779261] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] active: yes, output_types: HDMI (0x40), output format: RGB, sink format: RGB
<7> [341.779688] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] cpu_transcoder: A, pipe bpp: 36, dithering: 0
<7> [341.780058] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] MST master transcoder: <invalid>
<7> [341.780427] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] port sync: master transcoder: <invalid>, slave transcoder bitmask = 0x0
<7> [341.780846] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] joiner: no, pipes: 0x0
<7> [341.781216] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] splitter: disabled, link count 0, overlap 0
<7> [341.781584] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] audio: 1, infoframes: 1, infoframes enabled: 0x71
<7> [341.782048] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] GCP: 0x6
<7> [341.782424] i915 0000:00:02.0: HDMI infoframe: Auxiliary Video Information (AVI), version 2, length 13
<7> [341.782429] i915 0000:00:02.0: colorspace: RGB
<7> [341.782433] i915 0000:00:02.0: scan mode: Underscan
<7> [341.782437] i915 0000:00:02.0: colorimetry: No Data
<7> [341.782441] i915 0000:00:02.0: picture aspect: No Data
<7> [341.782444] i915 0000:00:02.0: active aspect: Same as Picture
<7> [341.782448] i915 0000:00:02.0: itc: No Data
<7> [341.782452] i915 0000:00:02.0: extended colorimetry: xvYCC 601
<7> [341.782456] i915 0000:00:02.0: quantization range: Full
<7> [341.782459] i915 0000:00:02.0: nups: Unknown Non-uniform Scaling
<7> [341.782463] i915 0000:00:02.0: video code: 0
<7> [341.782467] i915 0000:00:02.0: ycc quantization range: Full
<7> [341.782471] i915 0000:00:02.0: hdmi content type: Graphics
<7> [341.782474] i915 0000:00:02.0: pixel repeat: 0
<7> [341.782478] i915 0000:00:02.0: bar top 0, bottom 0, left 0, right 0
<7> [341.782483] i915 0000:00:02.0: HDMI infoframe: Source Product Description (SPD), version 1, length 25
<7> [341.782487] i915 0000:00:02.0: vendor: Intel
<7> [341.782491] i915 0000:00:02.0: product: Integrated gfx
<7> [341.782495] i915 0000:00:02.0: source device information: PC General (0x9)
<7> [341.782499] i915 0000:00:02.0: HDMI infoframe: Vendor, version 1, length 4
<7> [341.782503] i915 0000:00:02.0: empty frame
<7> [341.782507] 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> [341.782904] 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> [341.783280] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] scanline offset: 2
<7> [341.783665] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] framestart delay: 1, MSA timing delay: 0, set context latency: 0
<7> [341.784035] 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> [341.784406] 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> [341.784804] 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> [341.785181] 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> [341.785619] 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> [341.786025] 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> [341.786399] 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> [341.786799] 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> [341.787194] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] linetime: 59, ips linetime: 0
<7> [341.787570] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] num_scalers: 2, scaler_users: 0x0, scaler_id: -1, scaling_filter: 0
<7> [341.787998] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pch pfit: 0x0+0+0, disabled, force thru: no
<7> [341.788372] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] ips: 0, double wide: 0, drrs: 0
<7> [341.788770] 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> [341.789149] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] csc_mode: 0x0 gamma_mode: 0x0 gamma_enable: 0 csc_enable: 0
<7> [341.789520] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pre csc lut: 0 entries, post csc lut: 0 entries
<7> [341.789914] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pipe csc: pre offsets: 0x0000 0x0000 0x0000
<7> [341.790285] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pipe csc: coefficients: 0x0000 0x0000 0x0000
<7> [341.790680] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pipe csc: coefficients: 0x0000 0x0000 0x0000
<7> [341.791052] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pipe csc: coefficients: 0x0000 0x0000 0x0000
<7> [341.791420] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pipe csc: post offsets: 0x0000 0x0000 0x0000
<7> [341.791809] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] sharpness strength: 0, sharpness tap size: 0, sharpness enable: 0
<7> [341.792184] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:34:plane 1A] fb: [FB:178] 1920x1080 format = XR24 little-endian (0x34325258) modifier = 0x0, visible: yes
<7> [341.792558] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] rotation: 0x1, scaler: -1, scaling_filter: 0
<7> [341.792947] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] src: 1920.000000x1080.000000+0.000000+0.000000 dst: 1920x1080+0+0
<7> [341.793324] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:43:plane 2A] fb: [NOFB], visible: no
<7> [341.793718] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:52:plane 3A] fb: [NOFB], visible: no
<7> [341.794088] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:61:plane 4A] fb: [NOFB], visible: no
<7> [341.794458] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:70:cursor A] fb: [NOFB], visible: no
<7> [341.794857] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [CRTC:119:pipe B] enable: yes [modeset]
<7> [341.795233] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] active: yes, output_types: HDMI (0x40), output format: RGB, sink format: RGB
<7> [341.795603] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] cpu_transcoder: B, pipe bpp: 36, dithering: 0
<7> [341.796000] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] MST master transcoder: <invalid>
<7> [341.796369] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] port sync: master transcoder: <invalid>, slave transcoder bitmask = 0x0
<7> [341.796759] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] joiner: no, pipes: 0x0
<7> [341.797130] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] splitter: disabled, link count 0, overlap 0
<7> [341.797502] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] audio: 1, infoframes: 1, infoframes enabled: 0x71
<7> [341.797897] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] GCP: 0x6
<7> [341.798268] i915 0000:00:02.0: HDMI infoframe: Auxiliary Video Information (AVI), version 2, length 13
<7> [341.798273] i915 0000:00:02.0: colorspace: RGB
<7> [341.798277] i915 0000:00:02.0: scan mode: Underscan
<7> [341.798281] i915 0000:00:02.0: colorimetry: No Data
<7> [341.798285] i915 0000:00:02.0: picture aspect: No Data
<7> [341.798288] i915 0000:00:02.0: active aspect: Same as Picture
<7> [341.798292] i915 0000:00:02.0: itc: No Data
<7> [341.798295] i915 0000:00:02.0: extended colorimetry: xvYCC 601
<7> [341.798299] i915 0000:00:02.0: quantization range: Full
<7> [341.798303] i915 0000:00:02.0: nups: Unknown Non-uniform Scaling
<7> [341.798307] i915 0000:00:02.0: video code: 0
<7> [341.798310] i915 0000:00:02.0: ycc quantization range: Full
<7> [341.798314] i915 0000:00:02.0: hdmi content type: Graphics
<7> [341.798318] i915 0000:00:02.0: pixel repeat: 0
<7> [341.798322] i915 0000:00:02.0: bar top 0, bottom 0, left 0, right 0
<7> [341.798326] i915 0000:00:02.0: HDMI infoframe: Source Product Description (SPD), version 1, length 25
<7> [341.798330] i915 0000:00:02.0: vendor: Intel
<7> [341.798334] i915 0000:00:02.0: product: Integrated gfx
<7> [341.798338] i915 0000:00:02.0: source device information: PC General (0x9)
<7> [341.798342] i915 0000:00:02.0: HDMI infoframe: Vendor, version 1, length 4
<7> [341.798346] i915 0000:00:02.0: empty frame
<7> [341.798350] 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> [341.798755] 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> [341.799127] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] scanline offset: 2
<7> [341.799496] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] framestart delay: 1, MSA timing delay: 0, set context latency: 0
<7> [341.799886] 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> [341.800256] 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> [341.800656] 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> [341.801030] 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> [341.801400] 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> [341.801784] 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> [341.802156] 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> [341.802527] 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> [341.802923] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] linetime: 59, ips linetime: 0
<7> [341.803293] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] num_scalers: 2, scaler_users: 0x0, scaler_id: -1, scaling_filter: 0
<7> [341.803686] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pch pfit: 0x0+0+0, disabled, force thru: no
<7> [341.804057] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] ips: 0, double wide: 0, drrs: 0
<7> [341.804426] 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> [341.804825] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] csc_mode: 0x0 gamma_mode: 0x0 gamma_enable: 0 csc_enable: 0
<7> [341.805194] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pre csc lut: 0 entries, post csc lut: 0 entries
<7> [341.805563] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pipe csc: pre offsets: 0x0000 0x0000 0x0000
<7> [341.805955] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pipe csc: coefficients: 0x0000 0x0000 0x0000
<7> [341.806325] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pipe csc: coefficients: 0x0000 0x0000 0x0000
<7> [341.806726] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pipe csc: coefficients: 0x0000 0x0000 0x0000
<7> [341.807101] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pipe csc: post offsets: 0x0000 0x0000 0x0000
<7> [341.807472] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] sharpness strength: 0, sharpness tap size: 0, sharpness enable: 0
<7> [341.807858] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:77:plane 1B] fb: [FB:178] 1920x1080 format = XR24 little-endian (0x34325258) modifier = 0x0, visible: yes
<7> [341.808234] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] rotation: 0x1, scaler: -1, scaling_filter: 0
<7> [341.808604] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] src: 1920.000000x1080.000000+0.000000+0.000000 dst: 1920x1080+0+0
<7> [341.809015] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:86:plane 2B] fb: [NOFB], visible: no
<7> [341.809388] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:95:plane 3B] fb: [NOFB], visible: no
<7> [341.809779] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:104:plane 4B] fb: [NOFB], visible: no
<7> [341.810150] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:113:cursor B] fb: [NOFB], visible: no
<7> [341.810522] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [CRTC:162:pipe C] enable: no [modeset]
<7> [341.810913] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:120:plane 1C] fb: [NOFB], visible: no
<7> [341.811410] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:129:plane 2C] fb: [NOFB], visible: no
<7> [341.811815] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:138:plane 3C] fb: [NOFB], visible: no
<7> [341.812270] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:147:plane 4C] fb: [NOFB], visible: no
<7> [341.812668] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:156:cursor C] fb: [NOFB], visible: no
<7> [341.813563] i915 0000:00:02.0: [drm:intel_audio_codec_disable [i915]] [CONNECTOR:164:HDMI-A-1][ENCODER:163:DDI B/PHY B] Disable audio codec on [CRTC:119:pipe B]
<7> [341.833550] i915 0000:00:02.0: [drm:intel_audio_codec_disable [i915]] [CONNECTOR:174:HDMI-A-2][ENCODER:173:DDI C/PHY C] Disable audio codec on [CRTC:162:pipe C]
<7> [341.863190] i915 0000:00:02.0: [drm:intel_disable_transcoder [i915]] disabling pipe B
<7> [341.866879] i915 0000:00:02.0: [drm:intel_ddi_disable_transcoder_func [i915]] Quirk Increase DDI disabled time
<7> [341.972780] i915 0000:00:02.0: [drm:intel_power_well_disable [i915]] disabling DDI_IO_B
<7> [341.973310] i915 0000:00:02.0: [drm:intel_dpll_disable [i915]] disable PORT PLL B (active 0x2, on? 1) for [CRTC:119:pipe B]
<7> [341.973978] i915 0000:00:02.0: [drm:intel_dpll_disable [i915]] disabling PORT PLL B
<7> [341.974614] i915 0000:00:02.0: [drm:intel_disable_transcoder [i915]] disabling pipe C
<7> [341.979788] i915 0000:00:02.0: [drm:intel_ddi_disable_transcoder_func [i915]] Quirk Increase DDI disabled time
<7> [342.083775] i915 0000:00:02.0: [drm:intel_power_well_disable [i915]] disabling DDI_IO_C
<7> [342.084387] i915 0000:00:02.0: [drm:intel_dpll_disable [i915]] disable PORT PLL C (active 0x4, on? 1) for [CRTC:162:pipe C]
<7> [342.085101] i915 0000:00:02.0: [drm:intel_dpll_disable [i915]] disabling PORT PLL C
<7> [342.085540] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:163:DDI B/PHY B]
<7> [342.085949] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:173:DDI C/PHY C]
<7> [342.086674] i915 0000:00:02.0: [drm:intel_dpll_enable [i915]] enable PORT PLL B (active 0x1, on? 0) for [CRTC:76:pipe A]
<7> [342.087062] i915 0000:00:02.0: [drm:intel_dpll_enable [i915]] enabling PORT PLL B
<7> [342.087590] i915 0000:00:02.0: [drm:intel_power_well_enable [i915]] enabling DDI_IO_B
<7> [342.088438] i915 0000:00:02.0: [drm:intel_enable_transcoder [i915]] enabling pipe A
<7> [342.090202] i915 0000:00:02.0: [drm:intel_dpll_enable [i915]] enable PORT PLL C (active 0x2, on? 0) for [CRTC:119:pipe B]
<7> [342.090625] i915 0000:00:02.0: [drm:intel_dpll_enable [i915]] enabling PORT PLL C
<7> [342.091270] i915 0000:00:02.0: [drm:intel_power_well_enable [i915]] enabling DDI_IO_C
<7> [342.091834] i915 0000:00:02.0: [drm:intel_enable_transcoder [i915]] enabling pipe B
<7> [342.092720] i915 0000:00:02.0: [drm:intel_fbc_update [i915]] reserved 16588800 bytes of contiguous stolen space for FBC, limit: 1
<7> [342.093133] i915 0000:00:02.0: [drm:intel_fbc_update [i915]] Enabling FBC on [PLANE:34:plane 1A]
<7> [342.109349] i915 0000:00:02.0: [drm:intel_audio_codec_enable [i915]] [CONNECTOR:164:HDMI-A-1][ENCODER:163:DDI B/PHY B] Enable audio codec on [CRTC:76:pipe A], 32 bytes ELD
<7> [342.123486] i915 0000:00:02.0: [drm:audio_config_hdmi_pixel_clock [i915]] Configuring HDMI audio for pixel clock 148500 (0x00090000)
<7> [342.123943] i915 0000:00:02.0: [drm:hsw_audio_config_update [i915]] using automatic N
<7> [342.124524] i915 0000:00:02.0: [drm:verify_connector_state [i915]] [CONNECTOR:164:HDMI-A-1]
<7> [342.125243] i915 0000:00:02.0: [drm:intel_modeset_verify_crtc [i915]] [CRTC:76:pipe A]
<7> [342.126536] i915 0000:00:02.0: [drm:intel_audio_codec_enable [i915]] [CONNECTOR:174:HDMI-A-2][ENCODER:173:DDI C/PHY C] Enable audio codec on [CRTC:119:pipe B], 32 bytes ELD
<7> [342.142736] i915 0000:00:02.0: [drm:audio_config_hdmi_pixel_clock [i915]] Configuring HDMI audio for pixel clock 148500 (0x00090000)
<7> [342.143188] i915 0000:00:02.0: [drm:hsw_audio_config_update [i915]] using automatic N
<7> [342.144361] i915 0000:00:02.0: [drm:verify_connector_state [i915]] [CONNECTOR:174:HDMI-A-2]
<7> [342.145326] i915 0000:00:02.0: [drm:intel_modeset_verify_crtc [i915]] [CRTC:119:pipe B]
<7> [342.146735] i915 0000:00:02.0: [drm:intel_modeset_verify_crtc [i915]] [CRTC:162:pipe C]
<7> [342.148924] i915 0000:00:02.0: [drm:drm_client_dev_restore] fbdev: ret=0
Created at 2025-12-15 22:00:30