Results for igt@kms_flip@2x-flip-vs-expired-vblank-interruptible@bd-dp2-hdmi-a3

Result: Fail

i915_display_info0 igt_runner0 results0.json results0-xe-load.json guc_logs0.tar i915_display_info_post_exec0 serial_data0 boot0 dmesg0

DetailValue
Duration 1.63 seconds
Hostname
shard-bmg-3
Igt-Version
IGT-Version: 2.4-g6f88532e2 (x86_64) (Linux: 7.1.0-rc3-lgci-xe-xe-5043-0ce1c813197dfbe15-debug+ x86_64)
Out
Starting dynamic subtest: BD-DP2-HDMI-A3
  1920x1080: 60 148500 1920 2008 2052 2200 1080 1084 1089 1125 0x48 0x5 
  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:926 run_test_on_crtc_set()
  #2 ../tests/kms_flip.c:2029 run_pair()
  #3 ../tests/kms_flip.c:2227 __igt_unique____real_main2105()
  #4 ../tests/kms_flip.c:2105 main()
  #5 [__libc_init_first+0x8a]
  #6 [__libc_start_main+0x8b]
  #7 [_start+0x25]
Dynamic subtest BD-DP2-HDMI-A3: FAIL (1.633s)
Err
Starting dynamic subtest: BD-DP2-HDMI-A3
(kms_flip:4061) CRITICAL: Test assertion failure function run_test_step, file ../tests/kms_flip.c:931:
(kms_flip:4061) CRITICAL: Failed assertion: end - start < 500
(kms_flip:4061) CRITICAL: Last errno: 4, Interrupted system call
Dynamic subtest BD-DP2-HDMI-A3 failed.
**** DEBUG ****
(kms_flip:4061) igt_fb-DEBUG: igt_create_fb_with_bo_size(width=1920, height=1080, format=XR24(0x34325258), modifier=0x100000000000009, size=0)
(kms_flip:4061) drmtest-DEBUG: Test requirement passed: is_intel_device(fd)
(kms_flip:4061) drmtest-DEBUG: Test requirement passed: is_intel_device(fd)
(kms_flip:4061) igt_fb-DEBUG: igt_create_fb_with_bo_size(handle=1, pitch=7680)
(kms_flip:4061) ioctl_wrappers-DEBUG: Test requirement passed: igt_has_fb_modifiers(fd)
(kms_flip:4061) igt_fb-DEBUG: igt_create_fb_with_bo_size(width=1920, height=1080, format=XR24(0x34325258), modifier=0x100000000000009, size=0)
(kms_flip:4061) drmtest-DEBUG: Test requirement passed: is_intel_device(fd)
(kms_flip:4061) drmtest-DEBUG: Test requirement passed: is_intel_device(fd)
(kms_flip:4061) igt_fb-DEBUG: igt_create_fb_with_bo_size(handle=2, pitch=7680)
(kms_flip:4061) ioctl_wrappers-DEBUG: Test requirement passed: igt_has_fb_modifiers(fd)
(kms_flip:4061) intel_allocator_simple-DEBUG: Using simple allocator
(kms_flip:4061) intel_allocator_simple-DEBUG: <ial: 0x5bcad5551200, fd: 5> objects: 3, reserved_areas: 0
(kms_flip:4061) intel_allocator_simple-DEBUG: <ial: 0x5bcad5551200, fd: 5> objects: 3, reserved_areas: 0
(kms_flip:4061) intel_allocator_simple-DEBUG: Using simple allocator
(kms_flip:4061) intel_allocator_simple-DEBUG: <ial: 0x5bcad54be9d0, fd: 5> objects: 3, reserved_areas: 0
(kms_flip:4061) intel_allocator_simple-DEBUG: <ial: 0x5bcad54be9d0, fd: 5> objects: 3, reserved_areas: 0
(kms_flip:4061) intel_allocator_simple-DEBUG: Using simple allocator
(kms_flip:4061) intel_allocator_simple-DEBUG: <ial: 0x5bcad5551200, fd: 5> objects: 3, reserved_areas: 0
(kms_flip:4061) intel_allocator_simple-DEBUG: <ial: 0x5bcad5551200, fd: 5> objects: 3, reserved_areas: 0
(kms_flip:4061) intel_allocator_simple-DEBUG: Using simple allocator
(kms_flip:4061) intel_allocator_simple-DEBUG: <ial: 0x5bcad5551200, fd: 5> objects: 3, reserved_areas: 0
(kms_flip:4061) intel_allocator_simple-DEBUG: <ial: 0x5bcad5551200, fd: 5> objects: 3, reserved_areas: 0
(kms_flip:4061) igt_kms-INFO:   1920x1080: 60 148500 1920 2008 2052 2200 1080 1084 1089 1125 0x48 0x5 
(kms_flip:4061) igt_kms-INFO:   1920x1080: 60 148500 1920 2008 2052 2200 1080 1083 1088 1125 0x48 0x9 
(kms_flip:4061) DEBUG: No stale events found
(kms_flip:4061) i915/intel_drrs-DEBUG: Manually disabling DRRS. 0
(kms_flip:4061) i915/intel_drrs-DEBUG: Test requirement passed: dir >= 0
(kms_flip:4061) i915/intel_drrs-DEBUG: Manually disabling DRRS. 0
(kms_flip:4061) i915/intel_drrs-DEBUG: Test requirement passed: dir >= 0
(kms_flip:4061) DEBUG: name = flip
last_ts = 0.000000
last_received_ts = 0.000000
last_seq = 0
current_ts = 115.904335
current_received_ts = 115.903954
current_seq = 1022
count = 0
seq_step = 1
(kms_flip:4061) DEBUG: Vblank took 38us
(kms_flip:4061) DEBUG: name = flip
last_ts = 115.904335
last_received_ts = 115.903954
last_seq = 1022
current_ts = 115.920998
current_received_ts = 115.920631
current_seq = 1023
count = 1
seq_step = 1
(kms_flip:4061) DEBUG: Vblank took 27us
(kms_flip:4061) DEBUG: name = flip
last_ts = 115.920998
last_received_ts = 115.920631
last_seq = 1023
current_ts = 115.937668
current_received_ts = 115.937302
current_seq = 1024
count = 2
seq_step = 1
(kms_flip:4061) DEBUG: Vblank took 29us
(kms_flip:4061) DEBUG: name = flip
last_ts = 115.937668
last_received_ts = 115.937302
last_seq = 1024
current_ts = 115.954330
current_received_ts = 115.953964
current_seq = 1025
count = 3
seq_step = 1
(kms_flip:4061) DEBUG: Vblank took 26us
(kms_flip:4061) DEBUG: name = flip
last_ts = 115.954330
last_received_ts = 115.953964
last_seq = 1025
current_ts = 115.971008
current_received_ts = 115.970604
current_seq = 1026
count = 4
seq_step = 1
(kms_flip:4061) DEBUG: Vblank took 26us
(kms_flip:4061) DEBUG: name = flip
last_ts = 115.971008
last_received_ts = 115.970604
last_seq = 1026
current_ts = 115.987671
current_received_ts = 115.987274
current_seq = 1027
count = 5
seq_step = 1
(kms_flip:4061) DEBUG: Vblank took 25us
(kms_flip:4061) DEBUG: name = flip
last_ts = 115.987671
last_received_ts = 115.987274
last_seq = 1027
current_ts = 116.004341
current_received_ts = 116.003937
current_seq = 1028
count = 6
seq_step = 1
(kms_flip:4061) DEBUG: Vblank took 47us
(kms_flip:4061) DEBUG: name = flip
last_ts = 116.004341
last_received_ts = 116.003937
last_seq = 1028
current_ts = 116.021011
current_received_ts = 116.020554
current_seq = 1029
count = 7
seq_step = 1
(kms_flip:4061) DEBUG: Vblank took 25us
(kms_flip:4061) DEBUG: name = flip
last_ts = 116.021011
last_received_ts = 116.020554
last_seq = 1029
current_ts = 116.037674
current_received_ts = 116.037170
current_seq = 1030
count = 8
seq_step = 1
(kms_flip:4061) DEBUG: Vblank took 26us
(kms_flip:4061) DEBUG: name = flip
last_ts = 116.037674
last_received_ts = 116.037170
last_seq = 1030
current_ts = 116.054344
current_received_ts = 116.053841
current_seq = 1031
count = 9
seq_step = 1
(kms_flip:4061) DEBUG: Vblank took 27us
(kms_flip:4061) DEBUG: name = flip
last_ts = 116.054344
last_received_ts = 116.053841
last_seq = 1031
current_ts = 116.071014
current_received_ts = 116.070503
current_seq = 1032
count = 10
seq_step = 1
(kms_flip:4061) DEBUG: Vblank took 26us
(kms_flip:4061) DEBUG: name = flip
last_ts = 116.071014
last_received_ts = 116.070503
last_seq = 1032
current_ts = 116.087677
current_received_ts = 116.087173
current_seq = 1033
count = 11
seq_step = 1
(kms_flip:4061) DEBUG: Vblank took 25us
(kms_flip:4061) DEBUG: name = flip
last_ts = 116.087677
last_received_ts = 116.087173
last_seq = 1033
current_ts = 116.104347
current_received_ts = 116.103836
current_seq = 1034
count = 12
seq_step = 1
(kms_flip:4061) DEBUG: Vblank took 26us
(kms_flip:4061) DEBUG: name = flip
last_ts = 116.104347
last_received_ts = 116.103836
last_seq = 1034
current_ts = 116.121017
current_received_ts = 116.120506
current_seq = 1035
count = 13
seq_step = 1
(kms_flip:4061) DEBUG: Vblank took 26us
(kms_flip:4061) DEBUG: name = flip
last_ts = 116.121017
last_received_ts = 116.120506
last_seq = 1035
current_ts = 116.137688
current_received_ts = 116.137169
current_seq = 1036
count = 14
seq_step = 1
(kms_flip:4061) DEBUG: Vblank took 26us
(kms_flip:4061) DEBUG: name = flip
last_ts = 116.137688
last_received_ts = 116.137169
last_seq = 1036
current_ts = 116.154350
current_received_ts = 116.153870
current_seq = 1037
count = 15
seq_step = 1
(kms_flip:4061) DEBUG: Vblank took 26us
(kms_flip:4061) DEBUG: name = flip
last_ts = 116.154350
last_received_ts = 116.153870
last_seq = 1037
current_ts = 116.171013
current_received_ts = 116.170639
current_seq = 1038
count = 16
seq_step = 1
(kms_flip:4061) DEBUG: Vblank took 27us
(kms_flip:4061) DEBUG: name = flip
last_ts = 116.171013
last_received_ts = 116.170639
last_seq = 1038
current_ts = 116.187683
current_received_ts = 116.187317
current_seq = 1039
count = 17
seq_step = 1
(kms_flip:4061) DEBUG: Vblank took 26us
(kms_flip:4061) DEBUG: name = flip
last_ts = 116.187683
last_received_ts = 116.187317
last_seq = 1039
current_ts = 116.204361
current_received_ts = 116.203972
current_seq = 1040
count = 18
seq_step = 1
(kms_flip:4061) DEBUG: Vblank took 27us
(kms_flip:4061) DEBUG: name = flip
last_ts = 116.204361
last_received_ts = 116.203972
last_seq = 1040
current_ts = 116.221016
current_received_ts = 116.220642
current_seq = 1041
count = 19
seq_step = 1
(kms_flip:4061) DEBUG: Vblank took 26us
(kms_flip:4061) DEBUG: name = flip
last_ts = 116.221016
last_received_ts = 116.220642
last_seq = 1041
current_ts = 116.237679
current_received_ts = 116.237305
current_seq = 1042
count = 20
seq_step = 1
(kms_flip:4061) DEBUG: Vblank took 26us
(kms_flip:4061) DEBUG: name = flip
last_ts = 116.237679
last_received_ts = 116.237305
last_seq = 1042
current_ts = 116.254356
current_received_ts = 116.253952
current_seq = 1043
count = 21
seq_step = 1
(kms_flip:4061) DEBUG: Vblank took 25us
(kms_flip:4061) DEBUG: name = flip
last_ts = 116.254356
last_received_ts = 116.253952
last_seq = 1043
current_ts = 116.271027
current_received_ts = 116.270561
current_seq = 1044
count = 22
seq_step = 1
(kms_flip:4061) DEBUG: Vblank took 25us
(kms_flip:4061) DEBUG: name = flip
last_ts = 116.271027
last_received_ts = 116.270561
last_seq = 1044
current_ts = 116.287689
current_received_ts = 116.287231
current_seq = 1045
count = 23
seq_step = 1
(kms_flip:4061) DEBUG: Vblank took 25us
(kms_flip:4061) DEBUG: name = flip
last_ts = 116.287689
last_received_ts = 116.287231
last_seq = 1045
current_ts = 116.304359
current_received_ts = 116.303894
current_seq = 1046
count = 24
seq_step = 1
(kms_flip:4061) DEBUG: Vblank took 26us
(kms_flip:4061) DEBUG: name = flip
last_ts = 116.304359
last_received_ts = 116.303894
last_seq = 1046
current_ts = 116.321030
current_received_ts = 116.320518
current_seq = 1047
count = 25
seq_step = 1
(kms_flip:4061) DEBUG: Vblank took 26us
(kms_flip:4061) DEBUG: name = flip
last_ts = 116.321030
last_received_ts = 116.320518
last_seq = 1047
current_ts = 116.337692
current_received_ts = 116.337189
current_seq = 1048
count = 26
seq_step = 1
(kms_flip:4061) DEBUG: Vblank took 26us
(kms_flip:4061) DEBUG: name = flip
last_ts = 116.337692
last_received_ts = 116.337189
last_seq = 1048
current_ts = 116.354362
current_received_ts = 116.353859
current_seq = 1049
count = 27
seq_step = 1
(kms_flip:4061) DEBUG: Vblank took 25us
(kms_flip:4061) DEBUG: name = flip
last_ts = 116.354362
last_received_ts = 116.353859
last_seq = 1049
current_ts = 116.371025
current_received_ts = 116.370522
current_seq = 1050
count = 28
seq_step = 1
(kms_flip:4061) DEBUG: Vblank took 26us
(kms_flip:4061) DEBUG: name = flip
last_ts = 116.371025
last_received_ts = 116.370522
last_seq = 1050
current_ts = 116.387695
current_received_ts = 116.387192
current_seq = 1051
count = 29
seq_step = 1
(kms_flip:4061) DEBUG: Vblank took 26us
(kms_flip:4061) DEBUG: name = flip
last_ts = 116.387695
last_received_ts = 116.387192
last_seq = 1051
current_ts = 116.404366
current_received_ts = 116.403854
current_seq = 1052
count = 30
seq_step = 1
(kms_flip:4061) DEBUG: Vblank took 26us
(kms_flip:4061) DEBUG: name = flip
last_ts = 116.404366
last_received_ts = 116.403854
last_seq = 1052
current_ts = 116.421028
current_received_ts = 116.420525
current_seq = 1053
count = 31
seq_step = 1
(kms_flip:4061) DEBUG: Vblank took 27us
(kms_flip:4061) DEBUG: name = flip
last_ts = 116.421028
last_received_ts = 116.420525
last_seq = 1053
current_ts = 116.437698
current_received_ts = 116.437195
current_seq = 1054
count = 32
seq_step = 1
(kms_flip:4061) DEBUG: Vblank took 26us
(kms_flip:4061) DEBUG: name = flip
last_ts = 116.437698
last_received_ts = 116.437195
last_seq = 1054
current_ts = 116.454369
current_received_ts = 116.453865
current_seq = 1055
count = 33
seq_step = 1
(kms_flip:4061) DEBUG: Vblank took 26us
(kms_flip:4061) DEBUG: name = flip
last_ts = 116.454369
last_received_ts = 116.453865
last_seq = 1055
current_ts = 116.471031
current_received_ts = 116.470657
current_seq = 1056
count = 34
seq_step = 1
(kms_flip:4061) DEBUG: Vblank took 26us
(kms_flip:4061) DEBUG: name = flip
last_ts = 116.471031
last_received_ts = 116.470657
last_seq = 1056
current_ts = 116.487694
current_received_ts = 116.487328
current_seq = 1057
count = 35
seq_step = 1
(kms_flip:4061) DEBUG: Vblank took 26us
(kms_flip:4061) DEBUG: name = flip
last_ts = 116.487694
last_received_ts = 116.487328
last_seq = 1057
current_ts = 116.504364
current_received_ts = 116.503990
current_seq = 1058
count = 36
seq_step = 1
(kms_flip:4061) DEBUG: Vblank took 26us
(kms_flip:4061) DEBUG: name = flip
last_ts = 116.504364
last_received_ts = 116.503990
last_seq = 1058
current_ts = 116.521027
current_received_ts = 116.520660
current_seq = 1059
count = 37
seq_step = 1
(kms_flip:4061) DEBUG: Vblank took 26us
(kms_flip:4061) DEBUG: name = flip
last_ts = 116.521027
last_received_ts = 116.520660
last_seq = 1059
current_ts = 116.537697
current_received_ts = 116.537323
current_seq = 1060
count = 38
seq_step = 1
(kms_flip:4061) DEBUG: Vblank took 26us
(kms_flip:4061) DEBUG: name = flip
last_ts = 116.537697
last_received_ts = 116.537323
last_seq = 1060
current_ts = 116.554375
current_received_ts = 116.553970
current_seq = 1061
count = 39
seq_step = 1
(kms_flip:4061) DEBUG: Vblank took 26us
(kms_flip:4061) DEBUG: name = flip
last_ts = 116.554375
last_received_ts = 116.553970
last_seq = 1061
current_ts = 116.571037
current_received_ts = 116.570580
current_seq = 1062
count = 40
seq_step = 1
(kms_flip:4061) DEBUG: Vblank took 26us
(kms_flip:4061) DEBUG: name = flip
last_ts = 116.571037
last_received_ts = 116.570580
last_seq = 1062
current_ts = 116.587708
current_received_ts = 116.587242
current_seq = 1063
count = 41
seq_step = 1
(kms_flip:4061) DEBUG: Vblank took 26us
(kms_flip:4061) DEBUG: name = flip
last_ts = 116.587708
last_received_ts = 116.587242
last_seq = 1063
current_ts = 116.604378
current_received_ts = 116.603867
current_seq = 1064
count = 42
seq_step = 1
(kms_flip:4061) DEBUG: Vblank took 26us
(kms_flip:4061) DEBUG: name = flip
last_ts = 116.604378
last_received_ts = 116.603867
last_seq = 1064
current_ts = 116.621040
current_received_ts = 116.620537
current_seq = 1065
count = 43
seq_step = 1
(kms_flip:4061) DEBUG: Vblank took 25us
(kms_flip:4061) DEBUG: name = flip
last_ts = 116.621040
last_received_ts = 116.620537
last_seq = 1065
current_ts = 116.637711
current_received_ts = 116.637199
current_seq = 1066
count = 44
seq_step = 1
(kms_flip:4061) DEBUG: Vblank took 25us
(kms_flip:4061) DEBUG: name = flip
last_ts = 116.637711
last_received_ts = 116.637199
last_seq = 1066
current_ts = 116.654373
current_received_ts = 116.653870
current_seq = 1067
count = 45
seq_step = 1
(kms_flip:4061) DEBUG: Vblank took 26us
(kms_flip:4061) DEBUG: name = flip
last_ts = 116.654373
last_received_ts = 116.653870
last_seq = 1067
current_ts = 116.671043
current_received_ts = 116.670540
current_seq = 1068
count = 46
seq_step = 1
(kms_flip:4061) DEBUG: Vblank took 25us
(kms_flip:4061) DEBUG: name = flip
last_ts = 116.671043
last_received_ts = 116.670540
last_seq = 1068
current_ts = 116.687714
current_received_ts = 116.687210
current_seq = 1069
count = 47
seq_step = 1
(kms_flip:4061) DEBUG: Vblank took 26us
(kms_flip:4061) DEBUG: name = flip
last_ts = 116.687714
last_received_ts = 116.687210
last_seq = 1069
current_ts = 116.704376
current_received_ts = 116.703873
current_seq = 1070
count = 48
seq_step = 1
(kms_flip:4061) DEBUG: Vblank took 26us
(kms_flip:4061) DEBUG: name = flip
last_ts = 116.704376
last_received_ts = 116.703873
last_seq = 1070
current_ts = 116.721046
current_received_ts = 116.720543
current_seq = 1071
count = 49
seq_step = 1
(kms_flip:4061) DEBUG: Vblank took 26us
(kms_flip:4061) DEBUG: name = flip
last_ts = 116.721046
last_received_ts = 116.720543
last_seq = 1071
current_ts = 116.737717
current_received_ts = 116.737206
current_seq = 1072
count = 50
seq_step = 1
(kms_flip:4061) DEBUG: Vblank took 26us
(kms_flip:4061) DEBUG: name = flip
last_ts = 116.737717
last_received_ts = 116.737206
last_seq = 1072
current_ts = 116.754379
current_received_ts = 116.753876
current_seq = 1073
count = 51
seq_step = 1
(kms_flip:4061) DEBUG: Vblank took 25us
(kms_flip:4061) DEBUG: name = flip
last_ts = 116.754379
last_received_ts = 116.753876
last_seq = 1073
current_ts = 116.771042
current_received_ts = 116.770668
current_seq = 1074
count = 52
seq_step = 1
(kms_flip:4061) DEBUG: Vblank took 26us
(kms_flip:4061) DEBUG: name = flip
last_ts = 116.771042
last_received_ts = 116.770668
last_seq = 1074
current_ts = 116.787712
current_received_ts = 116.787338
current_seq = 1075
count = 53
seq_step = 1
(kms_flip:4061) DEBUG: Vblank took 50us
(kms_flip:4061) DEBUG: name = flip
last_ts = 116.787712
last_received_ts = 116.787338
last_seq = 1075
current_ts = 116.804382
current_received_ts = 116.804024
current_seq = 1076
count = 54
seq_step = 1
(kms_flip:4061) DEBUG: Vblank took 26us
(kms_flip:4061) DEBUG: name = flip
last_ts = 116.804382
last_received_ts = 116.804024
last_seq = 1076
current_ts = 116.821060
current_received_ts = 116.820671
current_seq = 1077
count = 55
seq_step = 1
(kms_flip:4061) DEBUG: Vblank took 25us
(kms_flip:4061) DEBUG: name = flip
last_ts = 116.821060
last_received_ts = 116.820671
last_seq = 1077
current_ts = 116.837723
current_received_ts = 116.837334
current_seq = 1078
count = 56
seq_step = 1
(kms_flip:4061) DEBUG: Vblank took 26us
(kms_flip:4061) DEBUG: name = flip
last_ts = 116.837723
last_received_ts = 116.837334
last_seq = 1078
current_ts = 116.854385
current_received_ts = 116.853981
current_seq = 1079
count = 57
seq_step = 1
(kms_flip:4061) DEBUG: Vblank took 26us
(kms_flip:4061) DEBUG: name = flip
last_ts = 116.854385
last_received_ts = 116.853981
last_seq = 1079
current_ts = 116.871056
current_received_ts = 116.870590
current_seq = 1080
count = 58
seq_step = 1
(kms_flip:4061) DEBUG: Vblank took 26us
(kms_flip:4061) DEBUG: name = flip
last_ts = 116.871056
last_received_ts = 116.870590
last_seq = 1080
current_ts = 116.887718
current_received_ts = 116.887260
current_seq = 1081
count = 59
seq_step = 1
(kms_flip:4061) DEBUG: Vblank took 26us
(kms_flip:4061) DEBUG: name = flip
last_ts = 116.887718
last_received_ts = 116.887260
last_seq = 1081
current_ts = 116.904388
current_received_ts = 116.903885
current_seq = 1082
count = 60
seq_step = 1
(kms_flip:4061) DEBUG: Vblank took 27us
(kms_flip:4061) DEBUG: name = flip
last_ts = 116.904388
last_received_ts = 116.903885
last_seq = 1082
current_ts = 116.921059
current_received_ts = 116.920555
current_seq = 1083
count = 61
seq_step = 1
(kms_flip:4061) DEBUG: Vblank took 26us
(kms_flip:4061) DEBUG: name = flip
last_ts = 116.921059
last_received_ts = 116.920555
last_seq = 1083
current_ts = 116.937729
current_received_ts = 116.937218
current_seq = 1084
count = 62
seq_step = 1
(kms_flip:4061) DEBUG: Vblank took 27us
(kms_flip:4061) DEBUG: name = flip
last_ts = 116.937729
last_received_ts = 116.937218
last_seq = 1084
current_ts = 116.954391
current_received_ts = 116.953888
current_seq = 1085
count = 63
seq_step = 1
(kms_flip:4061) DEBUG: Vblank took 26us
(kms_flip:4061) DEBUG: name = flip
last_ts = 116.954391
last_received_ts = 116.953888
last_seq = 1085
current_ts = 116.971062
current_received_ts = 116.970551
current_seq = 1086
count = 64
seq_step = 1
(kms_flip:4061) DEBUG: Vblank took 26us
(kms_flip:4061) DEBUG: name = flip
last_ts = 116.971062
last_received_ts = 116.970551
last_seq = 1086
current_ts = 116.987724
current_received_ts = 116.987221
current_seq = 1087
count = 65
seq_step = 1
(kms_flip:4061) DEBUG: Vblank took 25us
(kms_flip:4061) DEBUG: name = flip
last_ts = 116.987724
last_received_ts = 116.987221
last_seq = 1087
current_ts = 117.004395
current_received_ts = 117.003883
current_seq = 1088
count = 66
seq_step = 1
(kms_flip:4061) DEBUG: Vblank took 26us
(kms_flip:4061) DEBUG: name = flip
last_ts = 117.004395
last_received_ts = 117.003883
last_seq = 1088
current_ts = 117.021065
current_received_ts = 117.020554
current_seq = 1089
count = 67
seq_step = 1
(kms_flip:4061) DEBUG: Vblank took 25us
(kms_flip:4061) DEBUG: name = flip
last_ts = 117.021065
last_received_ts = 117.020554
last_seq = 1089
current_ts = 117.037727
current_received_ts = 117.037224
current_seq = 1090
count = 68
seq_step = 1
(kms_flip:4061) DEBUG: Vblank took 25us
(kms_flip:4061) DEBUG: name = flip
last_ts = 117.037727
last_received_ts = 117.037224
last_seq = 1090
current_ts = 117.054398
current_received_ts = 117.053894
current_seq = 1091
count = 69
seq_step = 1
(kms_flip:4061) DEBUG: Vblank took 26us
(kms_flip:4061) DEBUG: name = flip
last_ts = 117.054398
last_received_ts = 117.053894
last_seq = 1091
current_ts = 117.071060
current_received_ts = 117.070686
current_seq = 1092
count = 70
seq_step = 1
(kms_flip:4061) DEBUG: Vblank took 26us
(kms_flip:4061) DEBUG: name = flip
last_ts = 117.071060
last_received_ts = 117.070686
last_seq = 1092
current_ts = 117.087730
current_received_ts = 117.087357
current_seq = 1093
count = 71
seq_step = 1
(kms_flip:4061) DEBUG: Vblank took 1201us
(kms_flip:4061) CRITICAL: Test assertion failure function run_test_step, file ../tests/kms_flip.c:931:
(kms_flip:4061) CRITICAL: Failed assertion: end - start < 500
(kms_flip:4061) CRITICAL: Last errno: 4, Interrupted system call
(kms_flip:4061) igt_core-INFO: Stack trace:
(kms_flip:4061) igt_core-INFO:   #0 ../lib/igt_core.c:2075 __igt_fail_assert()
(kms_flip:4061) igt_core-INFO:   #1 ../tests/kms_flip.c:926 run_test_on_crtc_set()
(kms_flip:4061) igt_core-INFO:   #2 ../tests/kms_flip.c:2029 run_pair()
(kms_flip:4061) igt_core-INFO:   #3 ../tests/kms_flip.c:2227 __igt_unique____real_main2105()
(kms_flip:4061) igt_core-INFO:   #4 ../tests/kms_flip.c:2105 main()
(kms_flip:4061) igt_core-INFO:   #5 [__libc_init_first+0x8a]
(kms_flip:4061) igt_core-INFO:   #6 [__libc_start_main+0x8b]
(kms_flip:4061) igt_core-INFO:   #7 [_start+0x25]
****  END  ****
Dynamic subtest BD-DP2-HDMI-A3: FAIL (1.633s)
Dmesg
<6> [115.663814] [IGT] kms_flip: starting dynamic subtest BD-DP2-HDMI-A3
<7> [115.666999] xe 0000:03:00.0: [drm:drm_mode_addfb2] [FB:554]
<7> [115.669146] xe 0000:03:00.0: [drm:drm_mode_addfb2] [FB:560]
<7> [115.710665] xe 0000:03:00.0: [drm:drm_mode_setcrtc] [CRTC:151:pipe A]
<7> [115.710779] xe 0000:03:00.0: [drm:drm_mode_setcrtc] [CRTC:269:pipe C]
<7> [115.710845] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:269:pipe C] fastset requirement not met in hw.enable (expected yes, found no)
<7> [115.710981] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:269:pipe C] fastset requirement not met in hw.active (expected yes, found no)
<7> [115.711089] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:269:pipe C] fastset requirement not met in cpu_transcoder (expected 2, found -1)
<7> [115.711191] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:269:pipe C] fastset requirement not met in lane_count (expected 4, found 0)
<7> [115.711291] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:269:pipe C] fastset requirement not met in dp_m_n (expected tu 64 data 5190451/8388608 link 288358/524288, found tu 0, data 0/0 link 0/0)
<7> [115.711390] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:269:pipe C] fastset requirement not met in output_types (expected 0x00000080, found 0x00000000)
<7> [115.711486] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:269:pipe C] fastset requirement not met in framestart_delay (expected 1, found 0)
<7> [115.711658] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:269:pipe C] fastset requirement not met in hw.pipe_mode.crtc_hdisplay (expected 1920, found 0)
<7> [115.711759] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:269:pipe C] fastset requirement not met in hw.pipe_mode.crtc_htotal (expected 2200, found 0)
<7> [115.711856] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:269:pipe C] fastset requirement not met in hw.pipe_mode.crtc_hblank_start (expected 1920, found 0)
<7> [115.711952] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:269:pipe C] fastset requirement not met in hw.pipe_mode.crtc_hblank_end (expected 2200, found 0)
<7> [115.712050] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:269:pipe C] fastset requirement not met in hw.pipe_mode.crtc_hsync_start (expected 2008, found 0)
<7> [115.712145] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:269:pipe C] fastset requirement not met in hw.pipe_mode.crtc_hsync_end (expected 2052, found 0)
<7> [115.712240] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:269:pipe C] fastset requirement not met in hw.pipe_mode.crtc_vdisplay (expected 1080, found 0)
<7> [115.712334] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:269:pipe C] fastset requirement not met in hw.pipe_mode.crtc_vblank_start (expected 1080, found 0)
<7> [115.712430] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:269:pipe C] fastset requirement not met in hw.pipe_mode.crtc_vsync_start (expected 1084, found 0)
<7> [115.712524] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:269:pipe C] fastset requirement not met in hw.pipe_mode.crtc_vsync_end (expected 1089, found 0)
<7> [115.712665] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:269:pipe C] fastset requirement not met in hw.pipe_mode.crtc_vtotal (expected 1125, found 0)
<7> [115.712764] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:269:pipe C] fastset requirement not met in hw.pipe_mode.crtc_vblank_end (expected 1125, found 0)
<7> [115.712859] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:269:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_hdisplay (expected 1920, found 0)
<7> [115.712953] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:269:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_htotal (expected 2200, found 0)
<7> [115.713047] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:269:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_hblank_start (expected 1920, found 0)
<7> [115.713140] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:269:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_hblank_end (expected 2200, found 0)
<7> [115.713235] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:269:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_hsync_start (expected 2008, found 0)
<7> [115.713330] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:269:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_hsync_end (expected 2052, found 0)
<7> [115.713425] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:269:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_vdisplay (expected 1080, found 0)
<7> [115.713520] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:269:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_vblank_start (expected 1080, found 0)
<7> [115.713644] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:269:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_vsync_start (expected 1084, found 0)
<7> [115.713760] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:269:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_vsync_end (expected 1089, found 0)
<7> [115.713856] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:269:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_vtotal (expected 1125, found 0)
<7> [115.713952] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:269:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_vblank_end (expected 1125, found 0)
<7> [115.714047] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:269:pipe C] fastset requirement not met in pixel_multiplier (expected 1, found 0)
<7> [115.714142] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:269:pipe C] fastset requirement not met in hw.adjusted_mode.flags (1) (expected 1, found 0)
<7> [115.714238] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:269:pipe C] fastset requirement not met in hw.adjusted_mode.flags (4) (expected 4, found 0)
<7> [115.714332] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:269:pipe C] fastset requirement not met in enhanced_framing (expected yes, found no)
<7> [115.714429] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:269:pipe C] fastset requirement not met in pipe_bpp (expected 36, found 0)
<7> [115.714525] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:269:pipe C] fastset requirement not met in hw.pipe_mode.crtc_clock (expected 148500, found 0)
<7> [115.714637] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:269:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_clock (expected 148500, found 0)
<7> [115.714733] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:269:pipe C] fastset requirement not met in port_clock (expected 270000, found 0)
<7> [115.714829] xe 0000:03:00.0: [drm:intel_atomic_check [xe]] [CRTC:269:pipe C] fastset requirement not met, forcing full modeset
<7> [115.714926] xe 0000:03:00.0: [drm:intel_dpll_crtc_put [xe]] [CRTC:269:pipe C] releasing TC PLL 2
<7> [115.715056] xe 0000:03:00.0: [drm:skl_compute_wm [xe]] Enabled dbuf slices 0xd -> 0xf (total dbuf slices 0xf), mbus joined? no->yes
<7> [115.715146] xe 0000:03:00.0: [drm:skl_compute_wm [xe]] [CRTC:387:pipe B] dbuf slices 0xc -> 0xf, ddb (0 - 1024) -> (0 - 4096), active pipes 0x6 -> 0x2
<7> [115.715226] xe 0000:03:00.0: [drm:skl_compute_wm [xe]] [CRTC:269:pipe C] dbuf slices 0xc -> 0x0, ddb (1024 - 2048) -> (0 - 0), active pipes 0x6 -> 0x2
<7> [115.715330] xe 0000:03:00.0: [drm:skl_print_plane_ddb_changes [xe]] [PLANE:381:cursor B] ddb ( 965 - 1024) -> (4037 - 4096), size 59 -> 59
<7> [115.715406] xe 0000:03:00.0: [drm:skl_print_plane_ddb_changes [xe]] [PLANE:263:cursor C] ddb (1989 - 2048) -> ( 0 - 0), size 59 -> 0
<7> [115.715480] xe 0000:03:00.0: [drm:intel_cdclk_atomic_check [xe]] [CRTC:269:pipe C] min cdclk: 192000 kHz -> 0 kHz
<7> [115.715629] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] [CRTC:269:pipe C] enable: no [modeset]
<7> [115.715737] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] [PLANE:153:plane 1C] fb: [NOFB], visible: no
<7> [115.715842] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] [PLANE:183:plane 2C] fb: [NOFB], visible: no
<7> [115.715945] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] [PLANE:213:plane 3C] fb: [NOFB], visible: no
<7> [115.716046] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] [PLANE:243:plane 4C] fb: [NOFB], visible: no
<7> [115.716148] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] [PLANE:253:plane 5C] fb: [NOFB], visible: no
<7> [115.716248] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] [PLANE:263:cursor C] fb: [NOFB], visible: no
<7> [115.716752] xe 0000:03:00.0: [drm:intel_audio_codec_disable [xe]] [CONNECTOR:527:DP-2][ENCODER:526:DDI TC2/PHY G] Disable audio codec on [CRTC:269:pipe C]
<7> [115.739597] xe 0000:03:00.0: [drm:intel_disable_transcoder [xe]] disabling pipe C
<7> [115.756684] xe 0000:03:00.0: [drm:intel_power_well_enable [xe]] enabling AUX_TC2
<7> [115.759332] xe 0000:03:00.0: [drm:intel_dpll_disable [xe]] disable TC PLL 2 (active 0x4, on? 1) for [CRTC:269:pipe C]
<7> [115.761774] xe 0000:03:00.0: [drm:intel_dpll_disable [xe]] disabling TC PLL 2
<7> [115.762485] xe 0000:03:00.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:507:DDI TC1/PHY F]
<7> [115.762979] xe 0000:03:00.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:509:DP-MST A]
<7> [115.763376] xe 0000:03:00.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:510:DP-MST B]
<7> [115.763797] xe 0000:03:00.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:511:DP-MST C]
<7> [115.764164] xe 0000:03:00.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:512:DP-MST D]
<7> [115.764512] xe 0000:03:00.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:526:DDI TC2/PHY G]
<7> [115.765100] xe 0000:03:00.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:528:DP-MST A]
<7> [115.765411] xe 0000:03:00.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:529:DP-MST B]
<7> [115.765746] xe 0000:03:00.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:530:DP-MST C]
<7> [115.766054] xe 0000:03:00.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:531:DP-MST D]
<7> [115.766334] xe 0000:03:00.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:538:DDI TC3/PHY H]
<7> [115.766640] xe 0000:03:00.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:542:DDI TC4/PHY I]
<7> [115.766920] xe 0000:03:00.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:544:DP-MST A]
<7> [115.767196] xe 0000:03:00.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:545:DP-MST B]
<7> [115.767452] xe 0000:03:00.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:546:DP-MST C]
<7> [115.767728] xe 0000:03:00.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:547:DP-MST D]
<7> [115.767967] xe 0000:03:00.0: [drm:verify_connector_state [xe]] [CONNECTOR:527:DP-2]
<7> [115.769923] xe 0000:03:00.0: [drm:gen9_dbuf_slices_update [xe]] Updating dbuf slices to 0xf
<7> [115.770334] xe 0000:03:00.0: [drm:intel_dbuf_mbus_join_update [xe]] Changing mbus joined: no -> yes (pipe: B)
<7> [115.770623] xe 0000:03:00.0: [drm:intel_dbuf_mdclk_cdclk_ratio_update [xe]] Updating dbuf ratio to 4 (mbus joined: yes)
<7> [115.782380] xe 0000:03:00.0: [drm:intel_power_well_disable [xe]] disabling PW_C
<7> [115.783034] xe 0000:03:00.0: [drm:dss_pipe_gating_enable_disable [xe]] DSS clock gating disabled for pipe_mask=0x4 (CLKGATE_DIS_DSSDSC=0xa2000000)
<7> [115.783734] xe 0000:03:00.0: [drm:intel_modeset_verify_crtc [xe]] [CRTC:269:pipe C]
<7> [115.784918] xe 0000:03:00.0: [drm:drm_mode_setcrtc] [CRTC:387:pipe B]
<7> [115.785172] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:387:pipe B] fastset requirement not met in hw.enable (expected yes, found no)
<7> [115.785674] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:387:pipe B] fastset requirement not met in hw.active (expected yes, found no)
<7> [115.786139] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:387:pipe B] fastset requirement not met in cpu_transcoder (expected 1, found -1)
<7> [115.786579] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:387:pipe B] fastset requirement not met in lane_count (expected 4, found 0)
<7> [115.787009] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:387:pipe B] fastset requirement not met in output_types (expected 0x00000040, found 0x00000000)
<7> [115.787412] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:387:pipe B] fastset requirement not met in framestart_delay (expected 1, found 0)
<7> [115.787794] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:387:pipe B] fastset requirement not met in hw.pipe_mode.crtc_hdisplay (expected 1920, found 0)
<7> [115.788123] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:387:pipe B] fastset requirement not met in hw.pipe_mode.crtc_htotal (expected 2200, found 0)
<7> [115.788448] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:387:pipe B] fastset requirement not met in hw.pipe_mode.crtc_hblank_start (expected 1920, found 0)
<7> [115.788788] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:387:pipe B] fastset requirement not met in hw.pipe_mode.crtc_hblank_end (expected 2200, found 0)
<7> [115.789084] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:387:pipe B] fastset requirement not met in hw.pipe_mode.crtc_hsync_start (expected 2008, found 0)
<7> [115.789368] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:387:pipe B] fastset requirement not met in hw.pipe_mode.crtc_hsync_end (expected 2052, found 0)
<7> [115.789663] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:387:pipe B] fastset requirement not met in hw.pipe_mode.crtc_vdisplay (expected 1080, found 0)
<7> [115.789939] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:387:pipe B] fastset requirement not met in hw.pipe_mode.crtc_vblank_start (expected 1080, found 0)
<7> [115.790205] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:387:pipe B] fastset requirement not met in hw.pipe_mode.crtc_vsync_start (expected 1083, found 0)
<7> [115.790455] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:387:pipe B] fastset requirement not met in hw.pipe_mode.crtc_vsync_end (expected 1088, found 0)
<7> [115.790710] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:387:pipe B] fastset requirement not met in hw.pipe_mode.crtc_vtotal (expected 1125, found 0)
<7> [115.790948] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:387:pipe B] fastset requirement not met in hw.pipe_mode.crtc_vblank_end (expected 1125, found 0)
<7> [115.791180] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:387:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_hdisplay (expected 1920, found 0)
<7> [115.791402] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:387:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_htotal (expected 2200, found 0)
<7> [115.791638] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:387:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_hblank_start (expected 1920, found 0)
<7> [115.791849] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:387:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_hblank_end (expected 2200, found 0)
<7> [115.792059] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:387:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_hsync_start (expected 2008, found 0)
<7> [115.792258] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:387:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_hsync_end (expected 2052, found 0)
<7> [115.792448] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:387:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_vdisplay (expected 1080, found 0)
<7> [115.792692] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:387:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_vblank_start (expected 1080, found 0)
<7> [115.792883] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:387:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_vsync_start (expected 1083, found 0)
<7> [115.793066] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:387:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_vsync_end (expected 1088, found 0)
<7> [115.793237] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:387:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_vtotal (expected 1125, found 0)
<7> [115.793408] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:387:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_vblank_end (expected 1125, found 0)
<7> [115.793583] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:387:pipe B] fastset requirement not met in pixel_multiplier (expected 1, found 0)
<7> [115.793745] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:387:pipe B] fastset requirement not met in hw.adjusted_mode.flags (1) (expected 1, found 0)
<7> [115.793910] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:387:pipe B] fastset requirement not met in hw.adjusted_mode.flags (8) (expected 8, found 0)
<7> [115.794074] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:387:pipe B] fastset requirement not met in has_hdmi_sink (expected yes, found no)
<7> [115.794231] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:387:pipe B] fastset requirement not met in has_infoframe (expected yes, found no)
<7> [115.794380] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:387:pipe B] fastset requirement not met in pipe_bpp (expected 36, found 0)
<7> [115.794523] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:387:pipe B] fastset requirement not met in hw.pipe_mode.crtc_clock (expected 148500, found 0)
<7> [115.794681] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:387:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_clock (expected 148500, found 0)
<7> [115.794821] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:387:pipe B] fastset requirement not met in port_clock (expected 222750, found 0)
<7> [115.794961] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:387:pipe B] fastset requirement not met in infoframes.enable (expected 0x00000071, found 0x00000000)
<7> [115.795098] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:387:pipe B] fastset requirement not met in infoframes.gcp (expected 0x00000006, found 0x00000000)
<7> [115.795227] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:387:pipe B] fastset requirement not met in avi infoframe
<7> [115.795355] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] expected:
<7> [115.795480] xe 0000:03:00.0: HDMI infoframe: Auxiliary Video Information (AVI), version 2, length 13
<7> [115.795482] xe 0000:03:00.0: colorspace: RGB
<7> [115.795484] xe 0000:03:00.0: scan mode: Underscan
<7> [115.795486] xe 0000:03:00.0: colorimetry: No Data
<7> [115.795490] xe 0000:03:00.0: picture aspect: No Data
<7> [115.795492] xe 0000:03:00.0: active aspect: Same as Picture
<7> [115.795493] xe 0000:03:00.0: itc: No Data
<7> [115.795495] xe 0000:03:00.0: extended colorimetry: xvYCC 601
<7> [115.795497] xe 0000:03:00.0: quantization range: Full
<7> [115.795498] xe 0000:03:00.0: nups: Unknown Non-uniform Scaling
<7> [115.795500] xe 0000:03:00.0: video code: 0
<7> [115.795502] xe 0000:03:00.0: ycc quantization range: Full
<7> [115.795503] xe 0000:03:00.0: hdmi content type: Graphics
<7> [115.795505] xe 0000:03:00.0: pixel repeat: 0
<7> [115.795506] xe 0000:03:00.0: bar top 0, bottom 0, left 0, right 0
<7> [115.795509] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] found:
<7> [115.795643] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:387:pipe B] fastset requirement not met in spd infoframe
<7> [115.795764] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] expected:
<7> [115.795882] xe 0000:03:00.0: HDMI infoframe: Source Product Description (SPD), version 1, length 25
<7> [115.795884] xe 0000:03:00.0: vendor: Intel
<7> [115.795886] xe 0000:03:00.0: product: Discrete gfx
<7> [115.795888] xe 0000:03:00.0: source device information: PC General (0x9)
<7> [115.795889] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] found:
<7> [115.796007] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:387:pipe B] fastset requirement not met in hdmi infoframe
<7> [115.796128] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] expected:
<7> [115.796245] xe 0000:03:00.0: HDMI infoframe: Vendor, version 1, length 4
<7> [115.796247] xe 0000:03:00.0: empty frame
<7> [115.796248] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] found:
<7> [115.796356] xe 0000:03:00.0: [drm:intel_atomic_check [xe]] [CRTC:387:pipe B] fastset requirement not met, forcing full modeset
<7> [115.796469] xe 0000:03:00.0: [drm:intel_dpll_crtc_put [xe]] [CRTC:387:pipe B] releasing TC PLL 3
<7> [115.796621] xe 0000:03:00.0: [drm:skl_compute_wm [xe]] Enabled dbuf slices 0xf -> 0x1 (total dbuf slices 0xf), mbus joined? yes->no
<7> [115.796716] xe 0000:03:00.0: [drm:skl_compute_wm [xe]] [CRTC:387:pipe B] dbuf slices 0xf -> 0x0, ddb (0 - 4096) -> (0 - 0), active pipes 0x2 -> 0x0
<7> [115.796826] xe 0000:03:00.0: [drm:skl_print_plane_ddb_changes [xe]] [PLANE:381:cursor B] ddb (4037 - 4096) -> ( 0 - 0), size 59 -> 0
<7> [115.796912] xe 0000:03:00.0: [drm:intel_cdclk_atomic_check [xe]] [CRTC:387:pipe B] min cdclk: 192000 kHz -> 0 kHz
<7> [115.797056] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] [CRTC:387:pipe B] enable: no [modeset]
<7> [115.797174] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] [PLANE:271:plane 1B] fb: [NOFB], visible: no
<7> [115.797282] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] [PLANE:301:plane 2B] fb: [NOFB], visible: no
<7> [115.797387] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] [PLANE:331:plane 3B] fb: [NOFB], visible: no
<7> [115.797487] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] [PLANE:361:plane 4B] fb: [NOFB], visible: no
<7> [115.797597] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] [PLANE:371:plane 5B] fb: [NOFB], visible: no
<7> [115.797696] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] [PLANE:381:cursor B] fb: [NOFB], visible: no
<7> [115.798368] xe 0000:03:00.0: [drm:intel_audio_codec_disable [xe]] [CONNECTOR:539:HDMI-A-3][ENCODER:538:DDI TC3/PHY H] Disable audio codec on [CRTC:387:pipe B]
<7> [115.816000] xe 0000:03:00.0: [drm:intel_disable_transcoder [xe]] disabling pipe B
<7> [115.833787] xe 0000:03:00.0: [drm:intel_dpll_disable [xe]] disable TC PLL 3 (active 0x2, on? 1) for [CRTC:387:pipe B]
<7> [115.836380] xe 0000:03:00.0: [drm:intel_dpll_disable [xe]] disabling TC PLL 3
<7> [115.837293] xe 0000:03:00.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:507:DDI TC1/PHY F]
<7> [115.837854] xe 0000:03:00.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:509:DP-MST A]
<7> [115.838354] xe 0000:03:00.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:510:DP-MST B]
<7> [115.838875] xe 0000:03:00.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:511:DP-MST C]
<7> [115.839355] xe 0000:03:00.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:512:DP-MST D]
<7> [115.839829] xe 0000:03:00.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:526:DDI TC2/PHY G]
<7> [115.840244] xe 0000:03:00.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:528:DP-MST A]
<7> [115.840695] xe 0000:03:00.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:529:DP-MST B]
<7> [115.841102] xe 0000:03:00.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:530:DP-MST C]
<7> [115.841476] xe 0000:03:00.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:531:DP-MST D]
<7> [115.841868] xe 0000:03:00.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:538:DDI TC3/PHY H]
<7> [115.842409] xe 0000:03:00.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:542:DDI TC4/PHY I]
<7> [115.842753] xe 0000:03:00.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:544:DP-MST A]
<7> [115.843061] xe 0000:03:00.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:545:DP-MST B]
<7> [115.843357] xe 0000:03:00.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:546:DP-MST C]
<7> [115.843659] xe 0000:03:00.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:547:DP-MST D]
<7> [115.843939] xe 0000:03:00.0: [drm:verify_connector_state [xe]] [CONNECTOR:539:HDMI-A-3]
<7> [115.844456] xe 0000:03:00.0: [drm:intel_dbuf_mdclk_cdclk_ratio_update [xe]] Updating dbuf ratio to 2 (mbus joined: no)
<7> [115.844935] xe 0000:03:00.0: [drm:intel_dbuf_mbus_join_update [xe]] Changing mbus joined: yes -> no (pipe: *)
<7> [115.845168] xe 0000:03:00.0: [drm:gen9_dbuf_slices_update [xe]] Updating dbuf slices to 0x1
<7> [115.845748] xe 0000:03:00.0: [drm:intel_power_well_disable [xe]] disabling PW_B
<7> [115.846231] xe 0000:03:00.0: [drm:dss_pipe_gating_enable_disable [xe]] DSS clock gating disabled for pipe_mask=0x2 (CLKGATE_DIS_DSSDSC=0xaa000000)
<7> [115.846716] xe 0000:03:00.0: [drm:intel_power_well_disable [xe]] disabling PW_2
<7> [115.847185] xe 0000:03:00.0: [drm:intel_modeset_verify_crtc [xe]] [CRTC:387:pipe B]
<7> [115.847802] xe 0000:03:00.0: [drm:drm_mode_setcrtc] [CRTC:505:pipe D]
<7> [115.848543] xe 0000:03:00.0: [drm:drm_mode_setcrtc] [CRTC:505:pipe D]
<7> [115.848575] xe 0000:03:00.0: [drm:drm_mode_setcrtc] [CONNECTOR:539:HDMI-A-3]
<7> [115.848669] xe 0000:03:00.0: [drm:intel_hdmi_compute_output_format [xe]] picking 12 bpc for HDMI output (pipe bpp: 36)
<7> [115.848860] xe 0000:03:00.0: [drm:intel_atomic_check [xe]] [CRTC:505:pipe D] hw max bpp: 36, pipe bpp: 36, dithering: 0
<7> [115.849052] xe 0000:03:00.0: [drm:intel_ddi_compute_config_late [xe]] [ENCODER:538:DDI TC3/PHY H] [CRTC:505:pipe D]
<7> [115.849231] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:505:pipe D] fastset requirement not met in hw.enable (expected no, found yes)
<7> [115.849400] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:505:pipe D] fastset requirement not met in hw.active (expected no, found yes)
<7> [115.849571] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:505:pipe D] fastset requirement not met in cpu_transcoder (expected -1, found 3)
<7> [115.849737] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:505:pipe D] fastset requirement not met in lane_count (expected 0, found 4)
<7> [115.849895] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:505:pipe D] fastset requirement not met in output_types (expected 0x00000000, found 0x00000040)
<7> [115.850051] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:505:pipe D] fastset requirement not met in framestart_delay (expected 0, found 1)
<7> [115.850206] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:505:pipe D] fastset requirement not met in hw.pipe_mode.crtc_hdisplay (expected 0, found 1920)
<7> [115.850348] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:505:pipe D] fastset requirement not met in hw.pipe_mode.crtc_htotal (expected 0, found 2200)
<7> [115.850490] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:505:pipe D] fastset requirement not met in hw.pipe_mode.crtc_hblank_start (expected 0, found 1920)
<7> [115.850640] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:505:pipe D] fastset requirement not met in hw.pipe_mode.crtc_hblank_end (expected 0, found 2200)
<7> [115.850774] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:505:pipe D] fastset requirement not met in hw.pipe_mode.crtc_hsync_start (expected 0, found 2008)
<7> [115.850902] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:505:pipe D] fastset requirement not met in hw.pipe_mode.crtc_hsync_end (expected 0, found 2052)
<7> [115.851031] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:505:pipe D] fastset requirement not met in hw.pipe_mode.crtc_vdisplay (expected 0, found 1080)
<7> [115.851158] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:505:pipe D] fastset requirement not met in hw.pipe_mode.crtc_vblank_start (expected 0, found 1080)
<7> [115.851281] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:505:pipe D] fastset requirement not met in hw.pipe_mode.crtc_vsync_start (expected 0, found 1083)
<7> [115.851409] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:505:pipe D] fastset requirement not met in hw.pipe_mode.crtc_vsync_end (expected 0, found 1088)
<7> [115.851525] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:505:pipe D] fastset requirement not met in hw.pipe_mode.crtc_vtotal (expected 0, found 1125)
<7> [115.851650] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:505:pipe D] fastset requirement not met in hw.pipe_mode.crtc_vblank_end (expected 0, found 1125)
<7> [115.851765] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:505:pipe D] fastset requirement not met in hw.adjusted_mode.crtc_hdisplay (expected 0, found 1920)
<7> [115.851874] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:505:pipe D] fastset requirement not met in hw.adjusted_mode.crtc_htotal (expected 0, found 2200)
<7> [115.851981] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:505:pipe D] fastset requirement not met in hw.adjusted_mode.crtc_hblank_start (expected 0, found 1920)
<7> [115.852089] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:505:pipe D] fastset requirement not met in hw.adjusted_mode.crtc_hblank_end (expected 0, found 2200)
<7> [115.852196] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:505:pipe D] fastset requirement not met in hw.adjusted_mode.crtc_hsync_start (expected 0, found 2008)
<7> [115.852294] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:505:pipe D] fastset requirement not met in hw.adjusted_mode.crtc_hsync_end (expected 0, found 2052)
<7> [115.852392] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:505:pipe D] fastset requirement not met in hw.adjusted_mode.crtc_vdisplay (expected 0, found 1080)
<7> [115.852489] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:505:pipe D] fastset requirement not met in hw.adjusted_mode.crtc_vblank_start (expected 0, found 1080)
<7> [115.852593] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:505:pipe D] fastset requirement not met in hw.adjusted_mode.crtc_vsync_start (expected 0, found 1083)
<7> [115.852694] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:505:pipe D] fastset requirement not met in hw.adjusted_mode.crtc_vsync_end (expected 0, found 1088)
<7> [115.852791] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:505:pipe D] fastset requirement not met in hw.adjusted_mode.crtc_vtotal (expected 0, found 1125)
<7> [115.852884] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:505:pipe D] fastset requirement not met in hw.adjusted_mode.crtc_vblank_end (expected 0, found 1125)
<7> [115.852975] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:505:pipe D] fastset requirement not met in pixel_multiplier (expected 0, found 1)
<7> [115.853067] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:505:pipe D] fastset requirement not met in hw.adjusted_mode.flags (1) (expected 0, found 1)
<7> [115.853159] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:505:pipe D] fastset requirement not met in hw.adjusted_mode.flags (8) (expected 0, found 8)
<7> [115.853249] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:505:pipe D] fastset requirement not met in has_hdmi_sink (expected no, found yes)
<7> [115.853340] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:505:pipe D] fastset requirement not met in has_infoframe (expected no, found yes)
<7> [115.853432] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:505:pipe D] fastset requirement not met in pipe_bpp (expected 0, found 36)
<7> [115.853522] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:505:pipe D] fastset requirement not met in hw.pipe_mode.crtc_clock (expected 0, found 148500)
<7> [115.853631] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:505:pipe D] fastset requirement not met in hw.adjusted_mode.crtc_clock (expected 0, found 148500)
<7> [115.853730] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:505:pipe D] fastset requirement not met in port_clock (expected 0, found 222750)
<7> [115.853825] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:505:pipe D] fastset requirement not met in infoframes.enable (expected 0x00000000, found 0x00000071)
<7> [115.853916] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:505:pipe D] fastset requirement not met in infoframes.gcp (expected 0x00000000, found 0x00000006)
<7> [115.854007] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:505:pipe D] fastset requirement not met in avi infoframe
<7> [115.854098] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] expected:
<7> [115.854189] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] found:
<7> [115.854279] xe 0000:03:00.0: HDMI infoframe: Auxiliary Video Information (AVI), version 2, length 13
<7> [115.854280] xe 0000:03:00.0: colorspace: RGB
<7> [115.854282] xe 0000:03:00.0: scan mode: Underscan
<7> [115.854283] xe 0000:03:00.0: colorimetry: No Data
<7> [115.854284] xe 0000:03:00.0: picture aspect: No Data
<7> [115.854285] xe 0000:03:00.0: active aspect: Same as Picture
<7> [115.854286] xe 0000:03:00.0: itc: No Data
<7> [115.854287] xe 0000:03:00.0: extended colorimetry: xvYCC 601
<7> [115.854288] xe 0000:03:00.0: quantization range: Full
<7> [115.854290] xe 0000:03:00.0: nups: Unknown Non-uniform Scaling
<7> [115.854291] xe 0000:03:00.0: video code: 0
<7> [115.854292] xe 0000:03:00.0: ycc quantization range: Full
<7> [115.854293] xe 0000:03:00.0: hdmi content type: Graphics
<7> [115.854294] xe 0000:03:00.0: pixel repeat: 0
<7> [115.854295] xe 0000:03:00.0: bar top 0, bottom 0, left 0, right 0
<7> [115.854297] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:505:pipe D] fastset requirement not met in spd infoframe
<7> [115.854388] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] expected:
<7> [115.854479] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] found:
<7> [115.854581] xe 0000:03:00.0: HDMI infoframe: Source Product Description (SPD), version 1, length 25
<7> [115.854582] xe 0000:03:00.0: vendor: Intel
<7> [115.854583] xe 0000:03:00.0: product: Discrete gfx
<7> [115.854585] xe 0000:03:00.0: source device information: PC General (0x9)
<7> [115.854586] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:505:pipe D] fastset requirement not met in hdmi infoframe
<7> [115.854687] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] expected:
<7> [115.854786] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] found:
<7> [115.854887] xe 0000:03:00.0: HDMI infoframe: Vendor, version 1, length 4
<7> [115.854888] xe 0000:03:00.0: empty frame
<7> [115.854890] xe 0000:03:00.0: [drm:intel_atomic_check [xe]] [CRTC:505:pipe D] fastset requirement not met, forcing full modeset
<7> [115.855009] xe 0000:03:00.0: [drm:skl_compute_wm [xe]] Enabled dbuf slices 0x1 -> 0x3 (total dbuf slices 0xf), mbus joined? no->no
<7> [115.855096] xe 0000:03:00.0: [drm:skl_compute_wm [xe]] [CRTC:505:pipe D] dbuf slices 0x0 -> 0x3, ddb (0 - 0) -> (0 - 2048), active pipes 0x0 -> 0x8
<7> [115.855201] xe 0000:03:00.0: [drm:skl_print_plane_ddb_changes [xe]] [PLANE:389:plane 1D] ddb ( 0 - 0) -> ( 0 - 1989), size 0 -> 1989
<7> [115.855282] xe 0000:03:00.0: [drm:skl_print_plane_ddb_changes [xe]] [PLANE:499:cursor D] ddb ( 0 - 0) -> (1989 - 2048), size 0 -> 59
<7> [115.855362] xe 0000:03:00.0: [drm:skl_print_plane_wm_changes [xe]] [PLANE:389:plane 1D] level wm0, wm1, wm2, wm3, wm4, wm5, wm6, wm7, twm, swm, stwm -> *wm0,*wm1,*wm2,*wm3,*wm4,*wm5, wm6, wm7,*twm,*swm,*stwm
<7> [115.855441] xe 0000:03:00.0: [drm:skl_print_plane_wm_changes [xe]] [PLANE:389:plane 1D] lines 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0 -> 4, 4, 9, 9, 17, 17, 17, 17, 0, 15, 0
<7> [115.855518] xe 0000:03:00.0: [drm:skl_print_plane_wm_changes [xe]] [PLANE:389:plane 1D] blocks 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0 -> 62, 62, 139, 139, 261, 261, 261, 261, 137, 230, 244
<7> [115.855609] xe 0000:03:00.0: [drm:skl_print_plane_wm_changes [xe]] [PLANE:389:plane 1D] min_ddb 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0 -> 123, 123, 245, 245, 367, 367, 0, 0, 138, 306, 306
<7> [115.855697] xe 0000:03:00.0: [drm:intel_bw_atomic_check [xe]] [CRTC:505:pipe D] data rate 594000 num active planes 1
<7> [115.855812] xe 0000:03:00.0: [drm:intel_bw_atomic_check [xe]] QGV point 0: max bw 33600 required 624 qgv_peak_bw: 48000
<7> [115.855924] xe 0000:03:00.0: [drm:intel_bw_atomic_check [xe]] QGV point 1: max bw 53000 required 624 qgv_peak_bw: 48000
<7> [115.856032] xe 0000:03:00.0: [drm:intel_bw_atomic_check [xe]] Matching peaks QGV bw: 48000 for required data rate: 624
<7> [115.856148] xe 0000:03:00.0: [drm:intel_cdclk_atomic_check [xe]] [CRTC:505:pipe D] min cdclk: 0 kHz -> 192000 kHz
<7> [115.856280] xe 0000:03:00.0: [drm:intel_find_dpll [xe]] [CRTC:505:pipe D] allocated TC PLL 3
<7> [115.856384] xe 0000:03:00.0: [drm:intel_dpll_crtc_get [xe]] [CRTC:505:pipe D] reserving TC PLL 3
<7> [115.856485] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] [CRTC:505:pipe D] enable: yes [modeset]
<7> [115.856605] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] active: yes, output_types: HDMI (0x40), output format: RGB, sink format: RGB
<7> [115.856716] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] cpu_transcoder: D, pipe bpp: 36, dithering: 0
<7> [115.856824] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] MST master transcoder: <invalid>
<7> [115.856931] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] port sync: master transcoder: <invalid>, slave transcoder bitmask = 0x0
<7> [115.857037] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] joiner: no, pipes: 0x0
<7> [115.857141] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] splitter: disabled, link count 0, overlap 0
<7> [115.857244] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] audio: 1, infoframes: 1, infoframes enabled: 0x71
<7> [115.857348] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] GCP: 0x6
<7> [115.857452] xe 0000:03:00.0: HDMI infoframe: Auxiliary Video Information (AVI), version 2, length 13
<7> [115.857453] xe 0000:03:00.0: colorspace: RGB
<7> [115.857455] xe 0000:03:00.0: scan mode: Underscan
<7> [115.857456] xe 0000:03:00.0: colorimetry: No Data
<7> [115.857457] xe 0000:03:00.0: picture aspect: No Data
<7> [115.857458] xe 0000:03:00.0: active aspect: Same as Picture
<7> [115.857460] xe 0000:03:00.0: itc: No Data
<7> [115.857461] xe 0000:03:00.0: extended colorimetry: xvYCC 601
<7> [115.857462] xe 0000:03:00.0: quantization range: Full
<7> [115.857463] xe 0000:03:00.0: nups: Unknown Non-uniform Scaling
<7> [115.857465] xe 0000:03:00.0: video code: 0
<7> [115.857466] xe 0000:03:00.0: ycc quantization range: Full
<7> [115.857467] xe 0000:03:00.0: hdmi content type: Graphics
<7> [115.857468] xe 0000:03:00.0: pixel repeat: 0
<7> [115.857469] xe 0000:03:00.0: bar top 0, bottom 0, left 0, right 0
<7> [115.857471] xe 0000:03:00.0: HDMI infoframe: Source Product Description (SPD), version 1, length 25
<7> [115.857472] xe 0000:03:00.0: vendor: Intel
<7> [115.857474] xe 0000:03:00.0: product: Discrete gfx
<7> [115.857475] xe 0000:03:00.0: source device information: PC General (0x9)
<7> [115.857476] xe 0000:03:00.0: HDMI infoframe: Vendor, version 1, length 4
<7> [115.857478] xe 0000:03:00.0: empty frame
<7> [115.857479] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] ELD: 10 00 07 00 66 10 00 01 00 00 00 00 00 00 00 00
<7> [115.857591] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] ELD: 05 e3 cd 0c 32 38 45 38 35 30 09 07 07 00 00 00
<7> [115.857695] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] scanline offset: 1
<7> [115.857798] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] framestart delay: 1, MSA timing delay: 0, set context latency: 0
<7> [115.857900] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] vrr: no, fixed rr: yes, vmin: 1125, vmax: 1125, flipline: 1125, pipeline full: 0, guardband: 45 vsync start: 42, vsync end: 37
<7> [115.858004] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] vrr: vmin vblank: 1080, vmax vblank: 1080, vmin vtotal: 1125, vmax vtotal: 1125
<7> [115.858105] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] vrr: dc balance: no, vmin: 0 vmax: 0 guardband: 0, slope: 0 max increase: 0 max decrease: 0 vblank target: 0
<7> [115.858209] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] requested mode: "1920x1080": 60 148500 1920 2008 2052 2200 1080 1083 1088 1125 0x48 0x9
<7> [115.858311] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] adjusted mode: "1920x1080": 60 148500 1920 2008 2052 2200 1080 1083 1088 1125 0x48 0x9
<7> [115.858413] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] 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> [115.858516] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] pipe mode: "1920x1080": 60 148500 1920 2008 2052 2200 1080 1083 1088 1125 0x40 0x9
<7> [115.858632] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] 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> [115.858735] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] port clock: 222750, pixel rate 148500, min cdclk 192000, min voltage level 0
<7> [115.858838] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] linetime: 119, ips linetime: 0
<7> [115.858940] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] num_scalers: 2, scaler_users: 0x0, scaler_id: -1, scaling_filter: 0, sharpness_strength: 0
<7> [115.859043] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] pipe src: 1920x1080+0+0
<7> [115.859144] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] pch pfit: 0x0+0+0, disabled, force thru: no
<7> [115.859246] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] sharpness strength: 0, sharpness tap size: 0, sharpness enable: 0
<7> [115.859348] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] ips: 0, double wide: 0, drrs: 0
<7> [115.859450] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] cx0pll_hw_state: lane_count: 4, ssc_enabled: no, use_c10: no, tbt_mode: no
<7> [115.859555] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] c20pll_hw_state:
<7> [115.859657] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] tx[0] = 0xbe88, tx[1] = 0x5800, tx[2] = 0x0000
<7> [115.859759] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] cmn[0] = 0x0500, cmn[1] = 0x0005, cmn[2] = 0x0000, cmn[3] = 0x0000
<7> [115.859862] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] mpllb[0] = 0x40e8
<7> [115.859964] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] mpllb[1] = 0x7d20
<7> [115.860065] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] mpllb[2] = 0x0a06
<7> [115.860167] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] mpllb[3] = 0x8f1c
<7> [115.860269] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] mpllb[4] = 0x0000
<7> [115.860370] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] mpllb[5] = 0x0000
<7> [115.860472] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] mpllb[6] = 0x2200
<7> [115.860581] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] mpllb[7] = 0xffff
<7> [115.860683] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] mpllb[8] = 0x0400
<7> [115.860784] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] mpllb[9] = 0x0000
<7> [115.860885] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] mpllb[10] = 0x0001
<7> [115.860987] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] vdr: custom width: 0x00, serdes rate: 0x00, hdmi rate: 0x00
<7> [115.861087] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] csc_mode: 0x0 gamma_mode: 0x0 gamma_enable: 0 csc_enable: 0
<7> [115.861189] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] pre csc lut: 0 entries, post csc lut: 0 entries
<7> [115.861291] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] output csc: pre offsets: 0x0000 0x0000 0x0000
<7> [115.861393] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] output csc: coefficients: 0x0000 0x0000 0x0000
<7> [115.861495] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] output csc: coefficients: 0x0000 0x0000 0x0000
<7> [115.861604] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] output csc: coefficients: 0x0000 0x0000 0x0000
<7> [115.861705] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] output csc: post offsets: 0x0000 0x0000 0x0000
<7> [115.861805] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] pipe csc: pre offsets: 0x0000 0x0000 0x0000
<7> [115.861907] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] pipe csc: coefficients: 0x0000 0x0000 0x0000
<7> [115.862008] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] pipe csc: coefficients: 0x0000 0x0000 0x0000
<7> [115.862110] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] pipe csc: coefficients: 0x0000 0x0000 0x0000
<7> [115.862211] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] pipe csc: post offsets: 0x0000 0x0000 0x0000
<7> [115.862312] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] [PLANE:389:plane 1D] fb: [FB:554] 1920x1080 format = XR24 little-endian (0x34325258) modifier = 0x100000000000009, visible: yes
<7> [115.862415] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] rotation: 0x1, scaler: -1, scaling_filter: 0
<7> [115.862517] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] src: 1920.000000x1080.000000+0.000000+0.000000 dst: 1920x1080+0+0
<7> [115.862652] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] [PLANE:419:plane 2D] fb: [NOFB], visible: no
<7> [115.862755] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] [PLANE:449:plane 3D] fb: [NOFB], visible: no
<7> [115.862856] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] [PLANE:479:plane 4D] fb: [NOFB], visible: no
<7> [115.862957] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] [PLANE:489:plane 5D] fb: [NOFB], visible: no
<7> [115.863058] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] [PLANE:499:cursor D] fb: [NOFB], visible: no
<7> [115.863655] xe 0000:03:00.0: [drm:intel_power_well_disable [xe]] disabling AUX_TC2
<7> [115.863876] xe 0000:03:00.0: [drm:intel_power_well_disable [xe]] disabling DC_off
<7> [115.864248] xe 0000:03:00.0: [drm:skl_enable_dc6 [xe]] Enabling DC6
<7> [115.864397] xe 0000:03:00.0: [drm:gen9_set_dc_state.part.0 [xe]] Setting DC state from 00 to 02
<7> [115.864772] xe 0000:03:00.0: [drm:intel_power_well_disable [xe]] disabling always-on
<7> [115.864972] xe 0000:03:00.0: [drm:intel_power_well_enable [xe]] enabling always-on
<7> [115.865119] xe 0000:03:00.0: [drm:intel_power_well_enable [xe]] enabling DC_off
<7> [115.865567] xe 0000:03:00.0: [drm:gen9_set_dc_state.part.0 [xe]] Setting DC state from 02 to 00
<7> [115.866055] xe 0000:03:00.0: [drm:intel_power_well_enable [xe]] enabling PW_2
<7> [115.866373] xe 0000:03:00.0: [drm:intel_power_well_enable [xe]] enabling PW_D
<7> [115.866497] xe 0000:03:00.0: [drm:dss_pipe_gating_enable_disable [xe]] DSS clock gating enabled for pipe_mask=0x8 (CLKGATE_DIS_DSSDSC=0x2a000000)
<7> [115.866821] xe 0000:03:00.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:507:DDI TC1/PHY F]
<7> [115.866920] xe 0000:03:00.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:509:DP-MST A]
<7> [115.867015] xe 0000:03:00.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:510:DP-MST B]
<7> [115.867106] xe 0000:03:00.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:511:DP-MST C]
<7> [115.867196] xe 0000:03:00.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:512:DP-MST D]
<7> [115.867286] xe 0000:03:00.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:526:DDI TC2/PHY G]
<7> [115.867375] xe 0000:03:00.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:528:DP-MST A]
<7> [115.867463] xe 0000:03:00.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:529:DP-MST B]
<7> [115.867556] xe 0000:03:00.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:530:DP-MST C]
<7> [115.867645] xe 0000:03:00.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:531:DP-MST D]
<7> [115.867732] xe 0000:03:00.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:538:DDI TC3/PHY H]
<7> [115.867818] xe 0000:03:00.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:542:DDI TC4/PHY I]
<7> [115.867905] xe 0000:03:00.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:544:DP-MST A]
<7> [115.867991] xe 0000:03:00.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:545:DP-MST B]
<7> [115.868078] xe 0000:03:00.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:546:DP-MST C]
<7> [115.868163] xe 0000:03:00.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:547:DP-MST D]
<7> [115.868465] xe 0000:03:00.0: [drm:gen9_dbuf_slices_update [xe]] Updating dbuf slices to 0x3
<7> [115.868648] xe 0000:03:00.0: [drm:intel_dbuf_mdclk_cdclk_ratio_update [xe]] Updating dbuf ratio to 2 (mbus joined: no)
<7> [115.868955] xe 0000:03:00.0: [drm:intel_dpll_enable [xe]] enable TC PLL 3 (active 0x8, on? 0) for [CRTC:505:pipe D]
<7> [115.869057] xe 0000:03:00.0: [drm:intel_dpll_enable [xe]] enabling TC PLL 3
<7> [115.871424] xe 0000:03:00.0: [drm:intel_enable_transcoder [xe]] enabling pipe D
<7> [115.906958] xe 0000:03:00.0: [drm:intel_audio_codec_enable [xe]] [CONNECTOR:539:HDMI-A-3][ENCODER:538:DDI TC3/PHY H] Enable audio codec on [CRTC:505:pipe D], 32 bytes ELD
<7> [115.923374] xe 0000:03:00.0: [drm:audio_config_hdmi_pixel_clock [xe]] Configuring HDMI audio for pixel clock 148500 (0x00090000)
<7> [115.924145] xe 0000:03:00.0: [drm:hsw_audio_config_update [xe]] using automatic N
<7> [115.925201] xe 0000:03:00.0: [drm:verify_connector_state [xe]] [CONNECTOR:539:HDMI-A-3]
<7> [115.926033] xe 0000:03:00.0: [drm:intel_modeset_verify_crtc [xe]] [CRTC:505:pipe D]
<7> [115.931757] xe 0000:03:00.0: [drm:drm_mode_setcrtc] [CRTC:269:pipe C]
<7> [115.931843] xe 0000:03:00.0: [drm:drm_mode_setcrtc] [CONNECTOR:527:DP-2]
<7> [115.932112] xe 0000:03:00.0: [drm:intel_dp_compute_config_limits [xe]] [ENCODER:526:DDI TC2/PHY G][CRTC:269:pipe C] DP link limits: pixel clock 148500 kHz DSC off max lanes 4 max rate 540000 max pipe_bpp 36 min link_bpp 18.0000 max link_bpp 36.0000
<7> [115.932619] xe 0000:03:00.0: [drm:intel_dp_compute_output_format [xe]] DP lane count 4 clock 270000 bpp input 36 compressed 0.0000 HDR no link rate required 668250 available 1080000
<7> [115.933094] xe 0000:03:00.0: [drm:intel_atomic_check [xe]] [CRTC:269:pipe C] hw max bpp: 36, pipe bpp: 36, dithering: 0
<7> [115.933557] xe 0000:03:00.0: [drm:intel_ddi_compute_config_late [xe]] [ENCODER:526:DDI TC2/PHY G] [CRTC:269:pipe C]
<7> [115.933999] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:269:pipe C] fastset requirement not met in hw.enable (expected no, found yes)
<7> [115.934390] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:269:pipe C] fastset requirement not met in hw.active (expected no, found yes)
<7> [115.934781] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:269:pipe C] fastset requirement not met in cpu_transcoder (expected -1, found 2)
<7> [115.935136] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:269:pipe C] fastset requirement not met in lane_count (expected 0, found 4)
<7> [115.935483] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:269:pipe C] fastset requirement not met in dp_m_n (expected tu 0 data 0/0 link 0/0, found tu 64, data 5190451/8388608 link 288358/524288)
<7> [115.935835] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:269:pipe C] fastset requirement not met in output_types (expected 0x00000000, found 0x00000080)
<7> [115.936140] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:269:pipe C] fastset requirement not met in framestart_delay (expected 0, found 1)
<7> [115.936425] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:269:pipe C] fastset requirement not met in hw.pipe_mode.crtc_hdisplay (expected 0, found 1920)
<7> [115.936725] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:269:pipe C] fastset requirement not met in hw.pipe_mode.crtc_htotal (expected 0, found 2200)
<7> [115.936989] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:269:pipe C] fastset requirement not met in hw.pipe_mode.crtc_hblank_start (expected 0, found 1920)
<7> [115.937245] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:269:pipe C] fastset requirement not met in hw.pipe_mode.crtc_hblank_end (expected 0, found 2200)
<7> [115.937488] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:269:pipe C] fastset requirement not met in hw.pipe_mode.crtc_hsync_start (expected 0, found 2008)
<7> [115.937756] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:269:pipe C] fastset requirement not met in hw.pipe_mode.crtc_hsync_end (expected 0, found 2052)
<7> [115.938002] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:269:pipe C] fastset requirement not met in hw.pipe_mode.crtc_vdisplay (expected 0, found 1080)
<7> [115.938238] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:269:pipe C] fastset requirement not met in hw.pipe_mode.crtc_vblank_start (expected 0, found 1080)
<7> [115.938454] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:269:pipe C] fastset requirement not met in hw.pipe_mode.crtc_vsync_start (expected 0, found 1084)
<7> [115.938682] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:269:pipe C] fastset requirement not met in hw.pipe_mode.crtc_vsync_end (expected 0, found 1089)
<7> [115.938892] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:269:pipe C] fastset requirement not met in hw.pipe_mode.crtc_vtotal (expected 0, found 1125)
<7> [115.939096] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:269:pipe C] fastset requirement not met in hw.pipe_mode.crtc_vblank_end (expected 0, found 1125)
<7> [115.939296] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:269:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_hdisplay (expected 0, found 1920)
<7> [115.939488] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:269:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_htotal (expected 0, found 2200)
<7> [115.939685] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:269:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_hblank_start (expected 0, found 1920)
<7> [115.939870] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:269:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_hblank_end (expected 0, found 2200)
<7> [115.940053] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:269:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_hsync_start (expected 0, found 2008)
<7> [115.940230] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:269:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_hsync_end (expected 0, found 2052)
<7> [115.940397] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:269:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_vdisplay (expected 0, found 1080)
<7> [115.940564] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:269:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_vblank_start (expected 0, found 1080)
<7> [115.940725] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:269:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_vsync_start (expected 0, found 1084)
<7> [115.940885] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:269:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_vsync_end (expected 0, found 1089)
<7> [115.941045] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:269:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_vtotal (expected 0, found 1125)
<7> [115.941194] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:269:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_vblank_end (expected 0, found 1125)
<7> [115.941340] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:269:pipe C] fastset requirement not met in pixel_multiplier (expected 0, found 1)
<7> [115.941483] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:269:pipe C] fastset requirement not met in hw.adjusted_mode.flags (1) (expected 0, found 1)
<7> [115.941635] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:269:pipe C] fastset requirement not met in hw.adjusted_mode.flags (4) (expected 0, found 4)
<7> [115.941774] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:269:pipe C] fastset requirement not met in enhanced_framing (expected no, found yes)
<7> [115.941911] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:269:pipe C] fastset requirement not met in pipe_bpp (expected 0, found 36)
<7> [115.942045] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:269:pipe C] fastset requirement not met in hw.pipe_mode.crtc_clock (expected 0, found 148500)
<7> [115.942174] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:269:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_clock (expected 0, found 148500)
<7> [115.942302] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:269:pipe C] fastset requirement not met in port_clock (expected 0, found 270000)
<7> [115.942427] xe 0000:03:00.0: [drm:intel_atomic_check [xe]] [CRTC:269:pipe C] fastset requirement not met, forcing full modeset
<7> [115.942580] xe 0000:03:00.0: [drm:skl_compute_wm [xe]] Enabled dbuf slices 0x3 -> 0xf (total dbuf slices 0xf), mbus joined? no->no
<7> [115.942686] xe 0000:03:00.0: [drm:skl_compute_wm [xe]] [CRTC:269:pipe C] dbuf slices 0x0 -> 0xc, ddb (0 - 0) -> (0 - 2048), active pipes 0x8 -> 0xc
<7> [115.942812] xe 0000:03:00.0: [drm:skl_print_plane_ddb_changes [xe]] [PLANE:153:plane 1C] ddb ( 0 - 0) -> ( 0 - 1989), size 0 -> 1989
<7> [115.942908] xe 0000:03:00.0: [drm:skl_print_plane_ddb_changes [xe]] [PLANE:263:cursor C] ddb ( 0 - 0) -> (1989 - 2048), size 0 -> 59
<7> [115.943000] xe 0000:03:00.0: [drm:skl_print_plane_wm_changes [xe]] [PLANE:153: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> [115.943088] xe 0000:03:00.0: [drm:skl_print_plane_wm_changes [xe]] [PLANE:153:plane 1C] lines 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0 -> 4, 4, 9, 9, 17, 17, 17, 17, 0, 15, 0
<7> [115.943175] xe 0000:03:00.0: [drm:skl_print_plane_wm_changes [xe]] [PLANE:153:plane 1C] blocks 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0 -> 62, 62, 139, 139, 261, 261, 261, 261, 137, 230, 244
<7> [115.943261] xe 0000:03:00.0: [drm:skl_print_plane_wm_changes [xe]] [PLANE:153:plane 1C] min_ddb 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0 -> 123, 123, 245, 245, 367, 367, 0, 0, 138, 306, 306
<7> [115.943354] xe 0000:03:00.0: [drm:intel_bw_atomic_check [xe]] [CRTC:269:pipe C] data rate 594000 num active planes 1
<7> [115.943476] xe 0000:03:00.0: [drm:intel_bw_atomic_check [xe]] QGV point 0: max bw 33600 required 1248 qgv_peak_bw: 48000
<7> [115.943602] xe 0000:03:00.0: [drm:intel_bw_atomic_check [xe]] QGV point 1: max bw 53000 required 1248 qgv_peak_bw: 48000
<7> [115.943714] xe 0000:03:00.0: [drm:intel_bw_atomic_check [xe]] Matching peaks QGV bw: 48000 for required data rate: 1248
<7> [115.943834] xe 0000:03:00.0: [drm:intel_cdclk_atomic_check [xe]] [CRTC:269:pipe C] min cdclk: 0 kHz -> 192000 kHz
<7> [115.943953] xe 0000:03:00.0: [drm:intel_cdclk_update_dbuf_bw_min_cdclk [xe]] dbuf bandwidth min cdclk: 9282 kHz -> 18563 kHz
<7> [115.944070] xe 0000:03:00.0: [drm:intel_find_dpll [xe]] [CRTC:269:pipe C] allocated TC PLL 2
<7> [115.944173] xe 0000:03:00.0: [drm:intel_dpll_crtc_get [xe]] [CRTC:269:pipe C] reserving TC PLL 2
<7> [115.944267] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] [CRTC:269:pipe C] enable: yes [modeset]
<7> [115.944374] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] active: yes, output_types: DP (0x80), output format: RGB, sink format: RGB
<7> [115.944479] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] cpu_transcoder: C, pipe bpp: 36, dithering: 0
<7> [115.944592] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] MST master transcoder: <invalid>
<7> [115.944693] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] port sync: master transcoder: <invalid>, slave transcoder bitmask = 0x0
<7> [115.944792] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] joiner: no, pipes: 0x0
<7> [115.944891] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] splitter: disabled, link count 0, overlap 0
<7> [115.944989] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] dp m_n: lanes: 4; data_m: 5190451, data_n: 8388608, link_m: 288358, link_n: 524288, tu: 64
<7> [115.945088] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] dp m2_n2: lanes: 4; data_m: 0, data_n: 0, link_m: 0, link_n: 0, tu: 0
<7> [115.945186] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] fec: disabled, enhanced framing: enabled
<7> [115.945283] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] sdp split: disabled
<7> [115.945380] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] psr: disabled, selective update: disabled, panel replay: disabled, selective fetch: disabled
<7> [115.945477] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] minimum hblank: 0
<7> [115.945581] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] audio: 1, infoframes: 0, infoframes enabled: 0x0
<7> [115.945680] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] ELD: 10 00 09 00 68 36 00 01 00 00 00 00 00 00 00 00
<7> [115.945777] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] ELD: 61 a4 9a 00 44 50 46 39 30 34 33 35 09 07 07 11
<7> [115.945872] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] ELD: 17 50 51 07 00 00 00 00
<7> [115.945969] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] scanline offset: 1
<7> [115.946064] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] framestart delay: 1, MSA timing delay: 0, set context latency: 0
<7> [115.946158] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] vrr: no, fixed rr: yes, vmin: 1125, vmax: 1125, flipline: 1125, pipeline full: 0, guardband: 42 vsync start: 41, vsync end: 36
<7> [115.946254] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] vrr: vmin vblank: 1083, vmax vblank: 1083, vmin vtotal: 1125, vmax vtotal: 1125
<7> [115.946349] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] vrr: dc balance: no, vmin: 0 vmax: 0 guardband: 0, slope: 0 max increase: 0 max decrease: 0 vblank target: 0
<7> [115.946446] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] requested mode: "1920x1080": 60 148500 1920 2008 2052 2200 1080 1084 1089 1125 0x48 0x5
<7> [115.946547] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] adjusted mode: "1920x1080": 60 148500 1920 2008 2052 2200 1080 1084 1089 1125 0x48 0x5
<7> [115.946644] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] crtc timings: clock=148500, hd=1920 hb=1920-2200 hs=2008-2052 ht=2200, vd=1080 vb=1080-1125 vs=1084-1089 vt=1125, flags=0x5
<7> [115.946741] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] pipe mode: "1920x1080": 60 148500 1920 2008 2052 2200 1080 1084 1089 1125 0x40 0x5
<7> [115.946838] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] crtc timings: clock=148500, hd=1920 hb=1920-2200 hs=2008-2052 ht=2200, vd=1080 vb=1080-1125 vs=1084-1089 vt=1125, flags=0x5
<7> [115.946935] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] port clock: 270000, pixel rate 148500, min cdclk 192000, min voltage level 0
<7> [115.947032] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] linetime: 119, ips linetime: 0
<7> [115.947128] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] num_scalers: 2, scaler_users: 0x0, scaler_id: -1, scaling_filter: 0, sharpness_strength: 0
<7> [115.947222] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] pipe src: 1920x1080+0+0
<7> [115.947316] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] pch pfit: 0x0+0+0, disabled, force thru: no
<7> [115.947413] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] sharpness strength: 0, sharpness tap size: 0, sharpness enable: 0
<7> [115.947509] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] ips: 0, double wide: 0, drrs: 0
<7> [115.947615] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] cx0pll_hw_state: lane_count: 4, ssc_enabled: no, use_c10: no, tbt_mode: no
<7> [115.947712] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] c20pll_hw_state:
<7> [115.947806] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] tx[0] = 0xbe88, tx[1] = 0x4800, tx[2] = 0x0000
<7> [115.947902] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] cmn[0] = 0x0500, cmn[1] = 0x0005, cmn[2] = 0x0000, cmn[3] = 0x0000
<7> [115.948002] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] mpllb[0] = 0x308c
<7> [115.948102] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] mpllb[1] = 0x2110
<7> [115.948201] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] mpllb[2] = 0xcc9c
<7> [115.948298] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] mpllb[3] = 0xbfc1
<7> [115.948392] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] mpllb[4] = 0x4b9a
<7> [115.948487] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] mpllb[5] = 0x3f81
<7> [115.948593] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] mpllb[6] = 0x2000
<7> [115.948687] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] mpllb[7] = 0x0001
<7> [115.948782] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] mpllb[8] = 0x5000
<7> [115.948877] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] mpllb[9] = 0x0000
<7> [115.948972] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] mpllb[10] = 0x0000
<7> [115.949066] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] vdr: custom width: 0x00, serdes rate: 0x42, hdmi rate: 0x00
<7> [115.949161] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] csc_mode: 0x40000000 gamma_mode: 0x0 gamma_enable: 0 csc_enable: 0
<7> [115.949256] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] pre csc lut: 0 entries, post csc lut: 0 entries
<7> [115.949351] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] output csc: pre offsets: 0x0000 0x0000 0x0000
<7> [115.949445] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] output csc: coefficients: 0x0db0 0x0000 0x0000
<7> [115.949542] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] output csc: coefficients: 0x0000 0x0db0 0x0000
<7> [115.949637] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] output csc: coefficients: 0x0000 0x0000 0x0db0
<7> [115.949730] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] output csc: post offsets: 0x0100 0x0100 0x0100
<7> [115.949825] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] pipe csc: pre offsets: 0x0000 0x0000 0x0000
<7> [115.949919] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] pipe csc: coefficients: 0x0000 0x0000 0x0000
<7> [115.950013] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] pipe csc: coefficients: 0x0000 0x0000 0x0000
<7> [115.950106] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] pipe csc: coefficients: 0x0000 0x0000 0x0000
<7> [115.950199] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] pipe csc: post offsets: 0x0000 0x0000 0x0000
<7> [115.950293] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] [PLANE:153:plane 1C] fb: [FB:554] 1920x1080 format = XR24 little-endian (0x34325258) modifier = 0x100000000000009, visible: yes
<7> [115.950387] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] rotation: 0x1, scaler: -1, scaling_filter: 0
<7> [115.950482] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] src: 1920.000000x1080.000000+0.000000+0.000000 dst: 1920x1080+0+0
<7> [115.950585] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] [PLANE:183:plane 2C] fb: [NOFB], visible: no
<7> [115.950679] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] [PLANE:213:plane 3C] fb: [NOFB], visible: no
<7> [115.950773] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] [PLANE:243:plane 4C] fb: [NOFB], visible: no
<7> [115.950866] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] [PLANE:253:plane 5C] fb: [NOFB], visible: no
<7> [115.950960] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] [PLANE:263:cursor C] fb: [NOFB], visible: no
<7> [115.951462] xe 0000:03:00.0: [drm:intel_power_well_enable [xe]] enabling PW_C
<7> [115.951625] xe 0000:03:00.0: [drm:dss_pipe_gating_enable_disable [xe]] DSS clock gating enabled for pipe_mask=0x4 (CLKGATE_DIS_DSSDSC=0x0a000000)
<7> [115.951943] xe 0000:03:00.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:507:DDI TC1/PHY F]
<7> [115.952034] xe 0000:03:00.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:509:DP-MST A]
<7> [115.952123] xe 0000:03:00.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:510:DP-MST B]
<7> [115.952210] xe 0000:03:00.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:511:DP-MST C]
<7> [115.952292] xe 0000:03:00.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:512:DP-MST D]
<7> [115.952373] xe 0000:03:00.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:526:DDI TC2/PHY G]
<7> [115.952453] xe 0000:03:00.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:528:DP-MST A]
<7> [115.952536] xe 0000:03:00.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:529:DP-MST B]
<7> [115.952618] xe 0000:03:00.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:530:DP-MST C]
<7> [115.952699] xe 0000:03:00.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:531:DP-MST D]
<7> [115.952784] xe 0000:03:00.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:538:DDI TC3/PHY H]
<7> [115.952865] xe 0000:03:00.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:542:DDI TC4/PHY I]
<7> [115.952945] xe 0000:03:00.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:544:DP-MST A]
<7> [115.953024] xe 0000:03:00.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:545:DP-MST B]
<7> [115.953102] xe 0000:03:00.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:546:DP-MST C]
<7> [115.953184] xe 0000:03:00.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:547:DP-MST D]
<7> [115.954988] xe 0000:03:00.0: [drm:gen9_dbuf_slices_update [xe]] Updating dbuf slices to 0xf
<7> [115.955359] xe 0000:03:00.0: [drm:intel_dbuf_mdclk_cdclk_ratio_update [xe]] Updating dbuf ratio to 2 (mbus joined: no)
<7> [115.955456] xe 0000:03:00.0: [drm:intel_dpll_enable [xe]] enable TC PLL 2 (active 0x4, on? 0) for [CRTC:269:pipe C]
<7> [115.955576] xe 0000:03:00.0: [drm:intel_dpll_enable [xe]] enabling TC PLL 2
<7> [115.958052] xe 0000:03:00.0: [drm:intel_power_well_enable [xe]] enabling AUX_TC2
<7> [115.962111] xe 0000:03:00.0: [drm:drm_dp_read_dpcd_caps [drm_display_helper]] AUX USBC2/DDI TC2/PHY G: DPCD: 12 14 c4 01 01 15 01 81 00 01 04 01 0f 00 01
<7> [115.966860] xe 0000:03:00.0: [drm:intel_dp_init_lttpr_and_dprx_caps [xe]] [CONNECTOR:527:DP-2][ENCODER:526:DDI TC2/PHY G][DPRX] LTTPR common capabilities: 00 00 00 00 00 00 00 00
<7> [115.967885] xe 0000:03:00.0: [drm:drm_dp_read_dpcd_caps [drm_display_helper]] AUX USBC2/DDI TC2/PHY G: DPCD: 12 14 c4 01 01 15 01 81 00 01 04 01 0f 00 01
<7> [115.968328] xe 0000:03:00.0: [drm:intel_dp_start_link_train [xe]] [CONNECTOR:527:DP-2][ENCODER:526:DDI TC2/PHY G][DPRX] Using LINK_BW_SET value 0a
<7> [115.969840] xe 0000:03:00.0: [drm:intel_dp_set_signal_levels [xe]] [CONNECTOR:527:DP-2][ENCODER:526:DDI TC2/PHY G][DPRX] 8b/10b, lanes: 4, vswing levels: 0/0/0/0, pre-emphasis levels: 0/0/0/0
<7> [115.970398] xe 0000:03:00.0: [drm:intel_dp_program_link_training_pattern [xe]] [CONNECTOR:527:DP-2][ENCODER:526:DDI TC2/PHY G][DPRX] Using DP training pattern TPS1
<7> [115.977454] xe 0000:03:00.0: [drm:intel_dp_link_train_phy [xe]] [CONNECTOR:527:DP-2][ENCODER:526:DDI TC2/PHY G][DPRX] Clock recovery OK
<7> [115.977697] xe 0000:03:00.0: [drm:intel_dp_program_link_training_pattern [xe]] [CONNECTOR:527:DP-2][ENCODER:526:DDI TC2/PHY G][DPRX] Using DP training pattern TPS3
<7> [115.985461] xe 0000:03:00.0: [drm:intel_dp_link_train_phy [xe]] [CONNECTOR:527:DP-2][ENCODER:526:DDI TC2/PHY G][DPRX] Channel EQ done. DP Training successful
<7> [115.985924] xe 0000:03:00.0: [drm:intel_dp_link_train_phy [xe]] [CONNECTOR:527:DP-2][ENCODER:526:DDI TC2/PHY G][DPRX] Link Training passed at link rate = 270000, lane count = 4
<7> [115.987377] xe 0000:03:00.0: [drm:intel_enable_transcoder [xe]] enabling pipe C
<7> [116.021851] xe 0000:03:00.0: [drm:intel_audio_codec_enable [xe]] [CONNECTOR:527:DP-2][ENCODER:526:DDI TC2/PHY G] Enable audio codec on [CRTC:269:pipe C], 40 bytes ELD
<7> [116.038490] xe 0000:03:00.0: [drm:verify_connector_state [xe]] [CONNECTOR:527:DP-2]
<7> [116.039404] xe 0000:03:00.0: [drm:intel_modeset_verify_crtc [xe]] [CRTC:269:pipe C]
<7> [116.088675] xe 0000:03:00.0: [drm:intel_power_well_disable [xe]] disabling AUX_TC2
<6> [117.297625] [IGT] kms_flip: finished subtest BD-DP2-HDMI-A3, FAIL
Created at 2026-05-12 02:35:53