Result: 361 Warning(s)
integration-manifest git-log-oneline i915_display_info2 igt_runner2 runtimes2 results2.json results2-i915-load.json guc_logs2.tar i915_display_info_post_exec2 boot2 dmesg2
pstore-001-dmesg2 pstore-003-dmesg2 pstore-002-dmesg2| Detail | Value |
|---|---|
| Duration | 0.66 seconds |
| Hostname |
shard-tglu-2 |
| Igt-Version |
IGT-Version: 2.3-gc6cd0883b (x86_64) (Linux: 6.19.0-rc8-CI_DRM_17919-ga68485eec772+ x86_64) |
| Out |
Using IGT_SRANDOM=1770062727 for randomisation Opened device: /dev/dri/card0 Using monotonic timestamps Starting subtest: plain-flip-interruptible Starting dynamic subtest: A-HDMI-A1 1920x1080: 120 285500 1920 1968 2000 2080 1080 1083 1088 1144 0x48 0x5 Dynamic subtest A-HDMI-A1: SUCCESS (0.657s) |
| Err |
Starting subtest: plain-flip-interruptible Starting dynamic subtest: A-HDMI-A1 Dynamic subtest A-HDMI-A1: SUCCESS (0.657s) |
| Dmesg |
<6> [376.423569] Console: switching to colour dummy device 80x25
<6> [376.424015] [IGT] kms_flip: executing
<7> [376.427111] i915 0000:00:02.0: [drm:i915_gem_open [i915]]
<7> [376.427784] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc]
<7> [376.428075] i915 0000:00:02.0: [drm:i915_gem_open [i915]]
<7> [376.437750] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] [CONNECTOR:597:DP-1]
<7> [376.437760] i915 0000:00:02.0: [drm:intel_dp_detect [i915]] [CONNECTOR:597:DP-1]
<7> [376.442148] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] [CONNECTOR:597:DP-1] disconnected
<7> [376.442551] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] [CONNECTOR:607:DP-2]
<7> [376.442555] i915 0000:00:02.0: [drm:intel_dp_detect [i915]] [CONNECTOR:607:DP-2]
<7> [376.442908] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] [CONNECTOR:607:DP-2] disconnected
<7> [376.443281] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] [CONNECTOR:616:DP-3]
<7> [376.443286] i915 0000:00:02.0: [drm:intel_dp_detect [i915]] [CONNECTOR:616:DP-3]
<7> [376.443608] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] [CONNECTOR:616:DP-3] disconnected
<7> [376.443997] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] [CONNECTOR:625:DP-4]
<7> [376.444002] i915 0000:00:02.0: [drm:intel_dp_detect [i915]] [CONNECTOR:625:DP-4]
<7> [376.444320] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] [CONNECTOR:625:DP-4] disconnected
<7> [376.444905] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] [CONNECTOR:587:HDMI-A-1]
<7> [376.444916] i915 0000:00:02.0: [drm:intel_hdmi_detect [i915]] [CONNECTOR:587:HDMI-A-1]
<7> [376.471903] i915 0000:00:02.0: [drm:update_display_info.part.0] [CONNECTOR:587:HDMI-A-1] Supported Monitor Refresh rate range is 0 Hz - 0 Hz
<7> [376.471913] i915 0000:00:02.0: [drm:update_display_info.part.0] [CONNECTOR:587:HDMI-A-1] HDMI: DVI dual 0, max TMDS clock 300000 kHz
<7> [376.471916] i915 0000:00:02.0: [drm:update_display_info.part.0] [CONNECTOR:587:HDMI-A-1] No deep color support on this HDMI sink.
<7> [376.471918] i915 0000:00:02.0: [drm:update_display_info.part.0] [CONNECTOR:587:HDMI-A-1] HF-VSDB: max TMDS clock: 600000 KHz, HDMI 2.1 support: no, DSC 1.2 support: no
<7> [376.471921] i915 0000:00:02.0: [drm:update_display_info.part.0] [CONNECTOR:587:HDMI-A-1] Assigning EDID-1.4 digital sink color depth as 8 bpc.
<7> [376.471924] i915 0000:00:02.0: [drm:update_display_info.part.0] [CONNECTOR:587:HDMI-A-1] ELD monitor fitHeadlessGS
<7> [376.471927] i915 0000:00:02.0: [drm:update_display_info.part.0] [CONNECTOR:587:HDMI-A-1] HDMI: latency present 0 0, video latency 0 0, audio latency 0 0
<7> [376.471930] i915 0000:00:02.0: [drm:update_display_info.part.0] [CONNECTOR:587:HDMI-A-1] ELD size 64, SAD count 10
<7> [376.472329] i915 0000:00:02.0: [drm:do_gmbus_xfer [i915]] GMBUS [i915 gmbus dpb] NAK for addr: 0040 w(1)
<7> [376.472480] i915 0000:00:02.0: [drm:do_gmbus_xfer [i915]] GMBUS [i915 gmbus dpb] NAK on first message, retry
<7> [376.473012] i915 0000:00:02.0: [drm:do_gmbus_xfer [i915]] GMBUS [i915 gmbus dpb] NAK for addr: 0040 w(1)
<7> [376.473169] i915 0000:00:02.0: [drm:drm_dp_dual_mode_detect [drm_display_helper]] DP dual mode HDMI ID: (err -6)
<7> [376.474009] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] [CONNECTOR:587:HDMI-A-1] probed modes:
<7> [376.474015] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "1920x1080": 120 285500 1920 1968 2000 2080 1080 1083 1088 1144 0x48 0x5
<7> [376.474020] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "4096x2160": 60 594000 4096 4184 4272 4400 2160 2168 2178 2250 0x40 0x5
<7> [376.474024] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "4096x2160": 60 593407 4096 4184 4272 4400 2160 2168 2178 2250 0x40 0x5
<7> [376.474028] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "4096x2160": 30 297000 4096 4184 4272 4400 2160 2168 2178 2250 0x40 0x5
<7> [376.474032] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "4096x2160": 30 296703 4096 4184 4272 4400 2160 2168 2178 2250 0x40 0x5
<7> [376.474035] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "3840x2160": 60 594000 3840 4016 4104 4400 2160 2168 2178 2250 0x40 0x5
<7> [376.474039] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "3840x2160": 60 593407 3840 4016 4104 4400 2160 2168 2178 2250 0x40 0x5
<7> [376.474042] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "3840x2160": 30 297000 3840 4016 4104 4400 2160 2168 2178 2250 0x40 0x5
<7> [376.474046] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "3840x2160": 30 296703 3840 4016 4104 4400 2160 2168 2178 2250 0x40 0x5
<7> [376.474050] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "3840x2160": 25 297000 3840 4896 4984 5280 2160 2168 2178 2250 0x40 0x5
<7> [376.474053] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "3840x2160": 24 297000 3840 5116 5204 5500 2160 2168 2178 2250 0x40 0x5
<7> [376.474057] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "3840x2160": 24 296703 3840 5116 5204 5500 2160 2168 2178 2250 0x40 0x5
<7> [376.474060] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "3440x1440": 90 476140 3440 3448 3480 3520 1440 1441 1449 1503 0x40 0xa
<7> [376.474064] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "2560x1600": 75 443250 2560 2768 3048 3536 1600 1603 1609 1672 0x40 0x6
<7> [376.474067] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "2560x1600": 60 348500 2560 2752 3032 3504 1600 1603 1609 1658 0x40 0x6
<7> [376.474071] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "2560x1440": 120 497770 2560 2608 2640 2720 1440 1443 1448 1525 0x40 0xa
<7> [376.474075] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "2048x1536": 60 267027 2048 2200 2424 2800 1536 1537 1540 1589 0x0 0x6
<7> [376.474078] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "2560x1080": 120 495000 2560 3108 3152 3300 1080 1084 1089 1250 0x40 0x5
<7> [376.474082] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "2560x1080": 120 494505 2560 3108 3152 3300 1080 1084 1089 1250 0x40 0x5
<7> [376.474086] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "1920x1440": 75 297000 1920 2064 2288 2640 1440 1441 1444 1500 0x40 0x6
<7> [376.474089] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "1920x1440": 60 234000 1920 2048 2256 2600 1440 1441 1444 1500 0x40 0x6
<7> [376.474093] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "2160x1200": 90 261420 2160 2208 2240 2320 1200 1203 1208 1252 0x40 0xa
<7> [376.474096] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "1856x1392": 75 288000 1856 1984 2208 2560 1392 1393 1396 1500 0x40 0x6
<7> [376.474100] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "1856x1392": 60 218250 1856 1952 2176 2528 1392 1393 1396 1439 0x40 0x6
<7> [376.474103] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "1792x1344": 75 261000 1792 1888 2104 2456 1344 1345 1348 1417 0x40 0x6
<7> [376.474107] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "1792x1344": 60 204750 1792 1920 2120 2448 1344 1345 1348 1394 0x40 0x6
<7> [376.474111] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "2048x1152": 60 162000 2048 2074 2154 2250 1152 1153 1156 1200 0x40 0x5
<7> [376.474114] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "1920x1200": 120 317250 1920 1968 2000 2080 1200 1203 1209 1271 0x40 0xa
<7> [376.474118] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "1920x1200": 75 245250 1920 2056 2264 2608 1200 1203 1209 1255 0x40 0x6
<7> [376.474121] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "1920x1200": 60 193250 1920 2056 2256 2592 1200 1203 1209 1245 0x40 0x6
<7> [376.474125] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "1920x1080": 120 297000 1920 2008 2052 2200 1080 1084 1089 1125 0x40 0x5
<7> [376.474128] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "1920x1080": 120 296703 1920 2008 2052 2200 1080 1084 1089 1125 0x40 0x5
<7> [376.474132] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "1920x1080": 75 220597 1920 2056 2264 2608 1080 1081 1084 1128 0x0 0x6
<7> [376.474136] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "1920x1080": 60 148500 1920 2008 2052 2200 1080 1084 1089 1125 0x40 0x5
<7> [376.474139] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "1920x1080": 60 148352 1920 2008 2052 2200 1080 1084 1089 1125 0x40 0x5
<7> [376.474143] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "1600x1200": 75 202500 1600 1664 1856 2160 1200 1201 1204 1250 0x40 0x5
<7> [376.474146] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "1600x1200": 70 189000 1600 1664 1856 2160 1200 1201 1204 1250 0x40 0x5
<7> [376.474150] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "1600x1200": 65 175500 1600 1664 1856 2160 1200 1201 1204 1250 0x40 0x5
<7> [376.474154] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "1600x1200": 60 162000 1600 1664 1856 2160 1200 1201 1204 1250 0x40 0x5
<7> [376.474157] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "1680x1050": 75 187000 1680 1800 1976 2272 1050 1053 1059 1099 0x40 0x6
<7> [376.474161] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "1680x1050": 60 146250 1680 1784 1960 2240 1050 1053 1059 1089 0x40 0x6
<7> [376.474164] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "1680x945": 60 131481 1680 1784 1960 2240 945 946 949 978 0x0 0x6
<7> [376.474168] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "1400x1050": 75 156000 1400 1504 1648 1896 1050 1053 1057 1099 0x40 0x6
<7> [376.474172] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "1400x1050": 60 121750 1400 1488 1632 1864 1050 1053 1057 1089 0x40 0x6
<7> [376.474175] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "1600x900": 60 108000 1600 1624 1704 1800 900 901 904 1000 0x40 0x5
<7> [376.474179] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "1280x1024": 75 135000 1280 1296 1440 1688 1024 1025 1028 1066 0x40 0x5
<7> [376.474182] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "1280x1024": 60 108000 1280 1328 1440 1688 1024 1025 1028 1066 0x40 0x5
<7> [376.474186] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "1440x900": 75 136750 1440 1536 1688 1936 900 903 909 942 0x40 0x6
<7> [376.474190] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "1440x900": 60 106500 1440 1520 1672 1904 900 903 909 934 0x40 0x6
<7> [376.474193] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "1280x960": 60 108000 1280 1376 1488 1800 960 961 964 1000 0x40 0x5
<7> [376.474197] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "1360x768": 60 84963 1366 1431 1567 1776 768 771 781 798 0x0 0x6
<7> [376.474201] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "1360x768": 60 85500 1360 1424 1536 1792 768 771 777 795 0x40 0x5
<7> [376.474204] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "1280x800": 75 106500 1280 1360 1488 1696 800 803 809 838 0x40 0x6
<7> [376.474208] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "1280x800": 60 83500 1280 1352 1480 1680 800 803 809 831 0x40 0x6
<7> [376.474211] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "1152x864": 75 108000 1152 1216 1344 1600 864 865 868 900 0x40 0x5
<7> [376.474215] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "1280x768": 75 102250 1280 1360 1488 1696 768 771 778 805 0x40 0x6
<7> [376.474218] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "1280x768": 60 79500 1280 1344 1472 1664 768 771 778 798 0x40 0x6
<7> [376.474222] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "1280x720": 60 74250 1280 1390 1430 1650 720 725 730 750 0x40 0x5
<7> [376.474225] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "1024x768": 75 78750 1024 1040 1136 1312 768 769 772 800 0x40 0x5
<7> [376.474229] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "1024x768": 70 75000 1024 1048 1184 1328 768 771 777 806 0x40 0xa
<7> [376.474233] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "1024x768": 60 65000 1024 1048 1184 1344 768 771 777 806 0x40 0xa
<7> [376.474236] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "1024x576": 60 46970 1024 1064 1168 1312 576 577 580 597 0x0 0x6
<7> [376.474240] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "832x624": 75 57284 832 864 928 1152 624 625 628 667 0x40 0xa
<7> [376.474243] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "800x600": 75 49500 800 816 896 1056 600 601 604 625 0x40 0x5
<7> [376.474247] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "800x600": 72 50000 800 856 976 1040 600 637 643 666 0x40 0x5
<7> [376.474250] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "800x600": 60 40000 800 840 968 1056 600 601 605 628 0x40 0x5
<7> [376.474254] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "800x600": 56 36000 800 824 896 1024 600 601 603 625 0x40 0x5
<7> [376.474258] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "848x480": 60 33750 848 864 976 1088 480 486 494 517 0x40 0x5
<7> [376.474261] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "640x480": 75 31500 640 656 720 840 480 481 484 500 0x40 0xa
<7> [376.474265] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "640x480": 73 31500 640 664 704 832 480 489 492 520 0x40 0xa
<7> [376.474269] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "640x480": 60 25200 640 656 752 800 480 490 492 525 0x40 0xa
<7> [376.474272] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "640x480": 60 25175 640 656 752 800 480 490 492 525 0x40 0xa
<7> [376.474276] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "720x400": 70 28320 720 738 846 900 400 412 414 449 0x40 0x6
<7> [376.474329] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] [CONNECTOR:597:DP-1]
<7> [376.474334] i915 0000:00:02.0: [drm:intel_dp_detect [i915]] [CONNECTOR:597:DP-1]
<7> [376.478822] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] [CONNECTOR:597:DP-1] disconnected
<7> [376.478844] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] [CONNECTOR:607:DP-2]
<7> [376.478848] i915 0000:00:02.0: [drm:intel_dp_detect [i915]] [CONNECTOR:607:DP-2]
<7> [376.479174] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] [CONNECTOR:607:DP-2] disconnected
<7> [376.479189] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] [CONNECTOR:616:DP-3]
<7> [376.479193] i915 0000:00:02.0: [drm:intel_dp_detect [i915]] [CONNECTOR:616:DP-3]
<7> [376.479513] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] [CONNECTOR:616:DP-3] disconnected
<7> [376.479526] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] [CONNECTOR:625:DP-4]
<7> [376.479530] i915 0000:00:02.0: [drm:intel_dp_detect [i915]] [CONNECTOR:625:DP-4]
<7> [376.479897] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] [CONNECTOR:625:DP-4] disconnected
<6> [376.485015] [IGT] kms_flip: starting subtest plain-flip-interruptible
<6> [376.488059] [IGT] kms_flip: starting dynamic subtest A-HDMI-A1
<7> [376.488517] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:636]
<7> [376.488614] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:637]
<7> [376.516097] i915 0000:00:02.0: [drm:drm_mode_setcrtc] [CRTC:170:pipe A]
<7> [376.516211] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:170:pipe A] fastset requirement not met in hw.enable (expected yes, found no)
<7> [376.516419] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:170:pipe A] fastset requirement not met in hw.active (expected yes, found no)
<7> [376.516584] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:170:pipe A] fastset requirement not met in cpu_transcoder (expected 0, found -1)
<7> [376.516761] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:170:pipe A] fastset requirement not met in lane_count (expected 4, found 0)
<7> [376.516959] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:170:pipe A] fastset requirement not met in output_types (expected 0x00000040, found 0x00000000)
<7> [376.517121] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:170:pipe A] fastset requirement not met in framestart_delay (expected 1, found 0)
<7> [376.517280] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:170:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hdisplay (expected 1920, found 0)
<7> [376.517437] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:170:pipe A] fastset requirement not met in hw.pipe_mode.crtc_htotal (expected 2080, found 0)
<7> [376.517594] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:170:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hblank_start (expected 1920, found 0)
<7> [376.517846] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:170:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hblank_end (expected 2080, found 0)
<7> [376.518015] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:170:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hsync_start (expected 1968, found 0)
<7> [376.518174] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:170:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hsync_end (expected 2000, found 0)
<7> [376.518332] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:170:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vdisplay (expected 1080, found 0)
<7> [376.518490] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:170:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vblank_start (expected 1080, found 0)
<7> [376.518647] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:170:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vsync_start (expected 1083, found 0)
<7> [376.518827] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:170:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vsync_end (expected 1088, found 0)
<7> [376.519011] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:170:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vtotal (expected 1144, found 0)
<7> [376.519168] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:170:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vblank_end (expected 1144, found 0)
<7> [376.519322] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:170:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hdisplay (expected 1920, found 0)
<7> [376.519479] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:170:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_htotal (expected 2080, found 0)
<7> [376.519635] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:170:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hblank_start (expected 1920, found 0)
<7> [376.519814] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:170:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hblank_end (expected 2080, found 0)
<7> [376.519994] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:170:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hsync_start (expected 1968, found 0)
<7> [376.520149] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:170:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hsync_end (expected 2000, found 0)
<7> [376.520305] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:170:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vdisplay (expected 1080, found 0)
<7> [376.520459] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:170:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vblank_start (expected 1080, found 0)
<7> [376.520614] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:170:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vsync_start (expected 1083, found 0)
<7> [376.520795] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:170:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vsync_end (expected 1088, found 0)
<7> [376.520967] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:170:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vtotal (expected 1144, found 0)
<7> [376.521122] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:170:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vblank_end (expected 1144, found 0)
<7> [376.521277] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:170:pipe A] fastset requirement not met in pixel_multiplier (expected 1, found 0)
<7> [376.521432] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:170:pipe A] fastset requirement not met in hw.adjusted_mode.flags (1) (expected 1, found 0)
<7> [376.521588] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:170:pipe A] fastset requirement not met in hw.adjusted_mode.flags (4) (expected 4, found 0)
<7> [376.521763] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:170:pipe A] fastset requirement not met in has_hdmi_sink (expected yes, found no)
<7> [376.521945] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:170:pipe A] fastset requirement not met in has_infoframe (expected yes, found no)
<7> [376.522101] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:170:pipe A] fastset requirement not met in pipe_bpp (expected 24, found 0)
<7> [376.522257] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:170:pipe A] fastset requirement not met in hw.pipe_mode.crtc_clock (expected 285500, found 0)
<7> [376.522412] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:170:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_clock (expected 285500, found 0)
<7> [376.522567] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:170:pipe A] fastset requirement not met in port_clock (expected 285500, found 0)
<7> [376.522740] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:170:pipe A] fastset requirement not met in infoframes.enable (expected 0x00000071, found 0x00000000)
<7> [376.522925] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:170:pipe A] fastset requirement not met in avi infoframe
<7> [376.523086] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] expected:
<7> [376.523245] i915 0000:00:02.0: HDMI infoframe: Auxiliary Video Information (AVI), version 2, length 13
<7> [376.523248] i915 0000:00:02.0: colorspace: RGB
<7> [376.523249] i915 0000:00:02.0: scan mode: Underscan
<7> [376.523251] i915 0000:00:02.0: colorimetry: No Data
<7> [376.523253] i915 0000:00:02.0: picture aspect: No Data
<7> [376.523254] i915 0000:00:02.0: active aspect: Same as Picture
<7> [376.523256] i915 0000:00:02.0: itc: No Data
<7> [376.523257] i915 0000:00:02.0: extended colorimetry: xvYCC 601
<7> [376.523259] i915 0000:00:02.0: quantization range: Full
<7> [376.523260] i915 0000:00:02.0: nups: Unknown Non-uniform Scaling
<7> [376.523262] i915 0000:00:02.0: video code: 0
<7> [376.523264] i915 0000:00:02.0: ycc quantization range: Full
<7> [376.523265] i915 0000:00:02.0: hdmi content type: Graphics
<7> [376.523267] i915 0000:00:02.0: pixel repeat: 0
<7> [376.523268] i915 0000:00:02.0: bar top 0, bottom 0, left 0, right 0
<7> [376.523270] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] found:
<7> [376.523428] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:170:pipe A] fastset requirement not met in spd infoframe
<7> [376.523585] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] expected:
<7> [376.523764] i915 0000:00:02.0: HDMI infoframe: Source Product Description (SPD), version 1, length 25
<7> [376.523766] i915 0000:00:02.0: vendor: Intel
<7> [376.523767] i915 0000:00:02.0: product: Integrated gfx
<7> [376.523769] i915 0000:00:02.0: source device information: PC General (0x9)
<7> [376.523771] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] found:
<7> [376.523960] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:170:pipe A] fastset requirement not met in hdmi infoframe
<7> [376.524116] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] expected:
<7> [376.524272] i915 0000:00:02.0: HDMI infoframe: Vendor, version 1, length 4
<7> [376.524275] i915 0000:00:02.0: empty frame
<7> [376.524276] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] found:
<7> [376.524433] i915 0000:00:02.0: [drm:intel_atomic_check [i915]] [CRTC:170:pipe A] fastset requirement not met, forcing full modeset
<7> [376.524592] i915 0000:00:02.0: [drm:intel_dpll_crtc_put [i915]] [CRTC:170:pipe A] releasing DPLL 0
<7> [376.524881] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] Enabled dbuf slices 0x3 -> 0x1 (total dbuf slices 0x3), mbus joined? no->no
<7> [376.525052] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] [CRTC:170:pipe A] dbuf slices 0x3 -> 0x0, ddb (0 - 2048) -> (0 - 0), active pipes 0x1 -> 0x0
<7> [376.525249] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] [PLANE:34:plane 1A] ddb ( 0 - 1993) -> ( 0 - 0), size 1993 -> 0
<7> [376.525403] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] [PLANE:164:cursor A] ddb (1993 - 2048) -> ( 0 - 0), size 55 -> 0
<7> [376.525555] i915 0000:00:02.0: [drm:skl_print_plane_changes [i915]] [PLANE:34:plane 1A] level *wm0,*wm1,*wm2,*wm3,*wm4,*wm5,*wm6,*wm7,*twm, swm, stwm -> wm0, wm1, wm2, wm3, wm4, wm5, wm6, wm7, twm, swm, stwm
<7> [376.525723] i915 0000:00:02.0: [drm:skl_print_plane_changes [i915]] [PLANE:34:plane 1A] lines 1, 8, 8, 8, 8, 11, 16, 16, 0, 0, 0 -> 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0
<7> [376.525876] i915 0000:00:02.0: [drm:skl_print_plane_changes [i915]] [PLANE:34:plane 1A] blocks 16, 129, 129, 129, 129, 177, 257, 257, 30, 0, 0 -> 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0
<7> [376.526027] i915 0000:00:02.0: [drm:skl_print_plane_changes [i915]] [PLANE:34:plane 1A] min_ddb 19, 143, 143, 143, 143, 196, 284, 284, 31, 0, 0 -> 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0
<7> [376.526202] i915 0000:00:02.0: [drm:intel_bw_atomic_check [i915]] [CRTC:170:pipe A] data rate 0 num active planes 0
<7> [376.526365] i915 0000:00:02.0: [drm:intel_bw_atomic_check [i915]] QGV point 0: max bw 14993 required 0
<7> [376.526547] i915 0000:00:02.0: [drm:intel_cdclk_atomic_check [i915]] [CRTC:170:pipe A] min cdclk: 192000 kHz -> 0 kHz
<7> [376.526743] i915 0000:00:02.0: [drm:intel_cdclk_update_dbuf_bw_min_cdclk [i915]] dbuf bandwidth min cdclk: 35688 kHz -> 0 kHz
<7> [376.526934] i915 0000:00:02.0: [drm:intel_cdclk_atomic_check [i915]] Modeset required for cdclk change
<7> [376.527093] i915 0000:00:02.0: [drm:intel_cdclk_atomic_check [i915]] New cdclk calculated to be logical 172800 kHz, actual 172800 kHz
<7> [376.527250] i915 0000:00:02.0: [drm:intel_cdclk_atomic_check [i915]] New voltage level calculated to be logical 0, actual 0
<7> [376.527410] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [CRTC:170:pipe A] enable: no [modeset]
<7> [376.527572] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:34:plane 1A] fb: [NOFB], visible: no
<7> [376.527741] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:64:plane 2A] fb: [NOFB], visible: no
<7> [376.527904] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:94:plane 3A] fb: [NOFB], visible: no
<7> [376.528064] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:124:plane 4A] fb: [NOFB], visible: no
<7> [376.528224] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:134:plane 5A] fb: [NOFB], visible: no
<7> [376.528382] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:144:plane 6A] fb: [NOFB], visible: no
<7> [376.528539] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:154:plane 7A] fb: [NOFB], visible: no
<7> [376.528695] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:164:cursor A] fb: [NOFB], visible: no
<7> [376.528956] i915 0000:00:02.0: [drm:intel_audio_codec_disable [i915]] [CONNECTOR:587:HDMI-A-1][ENCODER:586:DDI B/PHY B] Disable audio codec on [CRTC:170:pipe A]
<7> [376.541383] i915 0000:00:02.0: [drm:intel_audio_component_get_eld [i915]] Not valid for port B
<7> [376.551707] i915 0000:00:02.0: [drm:intel_hdmi_handle_sink_scrambling [i915]] [CONNECTOR:587:HDMI-A-1] scrambling=no, TMDS bit clock ratio=1/10
<7> [376.552270] i915 0000:00:02.0: [drm:do_gmbus_xfer [i915]] GMBUS [i915 gmbus dpb] NAK for addr: 0054 w(1)
<7> [376.552426] i915 0000:00:02.0: [drm:do_gmbus_xfer [i915]] GMBUS [i915 gmbus dpb] NAK on first message, retry
<7> [376.552980] i915 0000:00:02.0: [drm:do_gmbus_xfer [i915]] GMBUS [i915 gmbus dpb] NAK for addr: 0054 w(1)
<7> [376.553140] i915 0000:00:02.0: [drm:drm_scdc_set_high_tmds_clock_ratio [drm_display_helper]] [CONNECTOR:587:HDMI-A-1] Failed to read TMDS config: -6
<7> [376.553157] i915 0000:00:02.0: [drm:intel_ddi_disable [i915]] [CONNECTOR:587:HDMI-A-1] Failed to reset sink scrambling/TMDS bit clock ratio
<7> [376.553347] i915 0000:00:02.0: [drm:intel_disable_transcoder [i915]] disabling pipe A
<7> [376.559719] i915 0000:00:02.0: [drm:intel_power_well_disable [i915]] disabling DDI_IO_B
<7> [376.559927] i915 0000:00:02.0: [drm:intel_dpll_disable [i915]] disable DPLL 0 (active 0x1, on? 1) for [CRTC:170:pipe A]
<7> [376.560119] i915 0000:00:02.0: [drm:intel_dpll_disable [i915]] disabling DPLL 0
<7> [376.560294] i915 0000:00:02.0: [drm:__intel_fbc_disable [i915]] Disabling FBC on [PLANE:34:plane 1A]
<7> [376.560465] i915 0000:00:02.0: [drm:intel_set_cdclk [i915]] Pre changing CDCLK to 172800 kHz, VCO 345600 kHz, ref 38400 kHz, bypass 19200 kHz, voltage level 0
<7> [376.561119] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:586:DDI B/PHY B]
<7> [376.561403] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:596:DDI TC1/PHY TC1]
<7> [376.561632] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:598:DP-MST A]
<7> [376.561988] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:599:DP-MST B]
<7> [376.562169] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:600:DP-MST C]
<7> [376.562324] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:601:DP-MST D]
<7> [376.562485] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:606:DDI TC2/PHY TC2]
<7> [376.562643] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:608:DP-MST A]
<7> [376.562867] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:609:DP-MST B]
<7> [376.563097] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:610:DP-MST C]
<7> [376.563326] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:611:DP-MST D]
<7> [376.563550] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:615:DDI TC3/PHY TC3]
<7> [376.563793] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:617:DP-MST A]
<7> [376.563958] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:618:DP-MST B]
<7> [376.564114] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:619:DP-MST C]
<7> [376.564269] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:620:DP-MST D]
<7> [376.564460] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:624:DDI TC4/PHY TC4]
<7> [376.564709] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:626:DP-MST A]
<7> [376.564938] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:627:DP-MST B]
<7> [376.565161] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:628:DP-MST C]
<7> [376.565363] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:629:DP-MST D]
<7> [376.565523] i915 0000:00:02.0: [drm:verify_connector_state [i915]] [CONNECTOR:587:HDMI-A-1]
<7> [376.565992] i915 0000:00:02.0: [drm:gen9_dbuf_slices_update [i915]] Updating dbuf slices to 0x1
<7> [376.566305] i915 0000:00:02.0: [drm:intel_power_well_disable [i915]] disabling PW_3
<7> [376.566564] i915 0000:00:02.0: [drm:intel_power_well_disable [i915]] disabling PW_2
<7> [376.566851] i915 0000:00:02.0: [drm:intel_modeset_verify_crtc [i915]] [CRTC:170:pipe A]
<7> [376.567476] i915 0000:00:02.0: [drm:drm_mode_setcrtc] [CRTC:308:pipe B]
<7> [376.567641] i915 0000:00:02.0: [drm:drm_mode_setcrtc] [CRTC:446:pipe C]
<7> [376.567866] i915 0000:00:02.0: [drm:drm_mode_setcrtc] [CRTC:584:pipe D]
<7> [376.568118] i915 0000:00:02.0: [drm:drm_mode_setcrtc] [CRTC:170:pipe A]
<7> [376.568172] i915 0000:00:02.0: [drm:drm_mode_setcrtc] [CONNECTOR:587:HDMI-A-1]
<7> [376.568288] i915 0000:00:02.0: [drm:intel_atomic_check [i915]] [CONNECTOR:587:HDMI-A-1] Limiting display bpp to 24 (EDID bpp 24, max requested bpp 36, max platform bpp 36)
<7> [376.568540] i915 0000:00:02.0: [drm:intel_hdmi_compute_clock [i915]] picking 8 bpc for HDMI output (pipe bpp: 24)
<7> [376.568727] i915 0000:00:02.0: [drm:intel_atomic_check [i915]] [CRTC:170:pipe A] hw max bpp: 24, pipe bpp: 24, dithering: 0
<7> [376.568892] i915 0000:00:02.0: [drm:intel_ddi_compute_config_late [i915]] [ENCODER:586:DDI B/PHY B] [CRTC:170:pipe A]
<7> [376.569046] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:170:pipe A] fastset requirement not met in hw.enable (expected no, found yes)
<7> [376.569207] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:170:pipe A] fastset requirement not met in hw.active (expected no, found yes)
<7> [376.569429] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:170:pipe A] fastset requirement not met in cpu_transcoder (expected -1, found 0)
<7> [376.569666] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:170:pipe A] fastset requirement not met in lane_count (expected 0, found 4)
<7> [376.569925] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:170:pipe A] fastset requirement not met in output_types (expected 0x00000000, found 0x00000040)
<7> [376.570157] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:170:pipe A] fastset requirement not met in framestart_delay (expected 0, found 1)
<7> [376.570328] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:170:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hdisplay (expected 0, found 1920)
<7> [376.570484] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:170:pipe A] fastset requirement not met in hw.pipe_mode.crtc_htotal (expected 0, found 2080)
<7> [376.570640] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:170:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hblank_start (expected 0, found 1920)
<7> [376.570821] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:170:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hblank_end (expected 0, found 2080)
<7> [376.571049] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:170:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hsync_start (expected 0, found 1968)
<7> [376.571288] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:170:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hsync_end (expected 0, found 2000)
<7> [376.571524] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:170:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vdisplay (expected 0, found 1080)
<7> [376.571766] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:170:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vblank_start (expected 0, found 1080)
<7> [376.571958] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:170:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vsync_start (expected 0, found 1083)
<7> [376.572120] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:170:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vsync_end (expected 0, found 1088)
<7> [376.572279] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:170:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vtotal (expected 0, found 1144)
<7> [376.572437] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:170:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vblank_end (expected 0, found 1144)
<7> [376.572611] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:170:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hdisplay (expected 0, found 1920)
<7> [376.572861] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:170:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_htotal (expected 0, found 2080)
<7> [376.573095] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:170:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hblank_start (expected 0, found 1920)
<7> [376.573329] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:170:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hblank_end (expected 0, found 2080)
<7> [376.573552] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:170:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hsync_start (expected 0, found 1968)
<7> [376.573719] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:170:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hsync_end (expected 0, found 2000)
<7> [376.573876] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:170:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vdisplay (expected 0, found 1080)
<7> [376.574033] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:170:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vblank_start (expected 0, found 1080)
<7> [376.574207] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:170:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vsync_start (expected 0, found 1083)
<7> [376.574435] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:170:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vsync_end (expected 0, found 1088)
<7> [376.574667] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:170:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vtotal (expected 0, found 1144)
<7> [376.574925] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:170:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vblank_end (expected 0, found 1144)
<7> [376.575152] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:170:pipe A] fastset requirement not met in pixel_multiplier (expected 0, found 1)
<7> [376.575333] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:170:pipe A] fastset requirement not met in hw.adjusted_mode.flags (1) (expected 0, found 1)
<7> [376.575489] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:170:pipe A] fastset requirement not met in hw.adjusted_mode.flags (4) (expected 0, found 4)
<7> [376.575644] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:170:pipe A] fastset requirement not met in has_hdmi_sink (expected no, found yes)
<7> [376.575817] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:170:pipe A] fastset requirement not met in has_infoframe (expected no, found yes)
<7> [376.576011] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:170:pipe A] fastset requirement not met in pipe_bpp (expected 0, found 24)
<7> [376.576243] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:170:pipe A] fastset requirement not met in hw.pipe_mode.crtc_clock (expected 0, found 285500)
<7> [376.576470] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:170:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_clock (expected 0, found 285500)
<7> [376.576705] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:170:pipe A] fastset requirement not met in port_clock (expected 0, found 285500)
<7> [376.576914] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:170:pipe A] fastset requirement not met in infoframes.enable (expected 0x00000000, found 0x00000071)
<7> [376.577071] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:170:pipe A] fastset requirement not met in avi infoframe
<7> [376.577226] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] expected:
<7> [376.577381] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] found:
<7> [376.577555] i915 0000:00:02.0: HDMI infoframe: Auxiliary Video Information (AVI), version 2, length 13
<7> [376.577559] i915 0000:00:02.0: colorspace: RGB
<7> [376.577562] i915 0000:00:02.0: scan mode: Underscan
<7> [376.577565] i915 0000:00:02.0: colorimetry: No Data
<7> [376.577568] i915 0000:00:02.0: picture aspect: No Data
<7> [376.577571] i915 0000:00:02.0: active aspect: Same as Picture
<7> [376.577574] i915 0000:00:02.0: itc: No Data
<7> [376.577576] i915 0000:00:02.0: extended colorimetry: xvYCC 601
<7> [376.577579] i915 0000:00:02.0: quantization range: Full
<7> [376.577581] i915 0000:00:02.0: nups: Unknown Non-uniform Scaling
<7> [376.577584] i915 0000:00:02.0: video code: 0
<7> [376.577586] i915 0000:00:02.0: ycc quantization range: Full
<7> [376.577589] i915 0000:00:02.0: hdmi content type: Graphics
<7> [376.577592] i915 0000:00:02.0: pixel repeat: 0
<7> [376.577595] i915 0000:00:02.0: bar top 0, bottom 0, left 0, right 0
<7> [376.577598] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:170:pipe A] fastset requirement not met in spd infoframe
<7> [376.577850] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] expected:
<7> [376.578075] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] found:
<7> [376.578300] i915 0000:00:02.0: HDMI infoframe: Source Product Description (SPD), version 1, length 25
<7> [376.578303] i915 0000:00:02.0: vendor: Intel
<7> [376.578306] i915 0000:00:02.0: product: Integrated gfx
<7> [376.578308] i915 0000:00:02.0: source device information: PC General (0x9)
<7> [376.578311] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:170:pipe A] fastset requirement not met in hdmi infoframe
<7> [376.578539] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] expected:
<7> [376.578760] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] found:
<7> [376.578947] i915 0000:00:02.0: HDMI infoframe: Vendor, version 1, length 4
<7> [376.578949] i915 0000:00:02.0: empty frame
<7> [376.578951] i915 0000:00:02.0: [drm:intel_atomic_check [i915]] [CRTC:170:pipe A] fastset requirement not met, forcing full modeset
<7> [376.579147] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] Enabled dbuf slices 0x1 -> 0x3 (total dbuf slices 0x3), mbus joined? no->no
<7> [376.579306] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] [CRTC:170:pipe A] dbuf slices 0x0 -> 0x3, ddb (0 - 0) -> (0 - 2048), active pipes 0x0 -> 0x1
<7> [376.579556] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] [PLANE:34:plane 1A] ddb ( 0 - 0) -> ( 0 - 1993), size 0 -> 1993
<7> [376.579801] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] [PLANE:164:cursor A] ddb ( 0 - 0) -> (1993 - 2048), size 0 -> 55
<7> [376.580032] i915 0000:00:02.0: [drm:skl_print_plane_changes [i915]] [PLANE:34:plane 1A] level wm0, wm1, wm2, wm3, wm4, wm5, wm6, wm7, twm, swm, stwm -> *wm0,*wm1,*wm2,*wm3,*wm4,*wm5,*wm6,*wm7,*twm, swm, stwm
<7> [376.580259] i915 0000:00:02.0: [drm:skl_print_plane_changes [i915]] [PLANE:34:plane 1A] lines 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0 -> 1, 8, 8, 8, 8, 11, 16, 16, 0, 0, 0
<7> [376.580472] i915 0000:00:02.0: [drm:skl_print_plane_changes [i915]] [PLANE:34:plane 1A] blocks 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0 -> 16, 129, 129, 129, 129, 177, 257, 257, 30, 0, 0
<7> [376.580626] i915 0000:00:02.0: [drm:skl_print_plane_changes [i915]] [PLANE:34:plane 1A] min_ddb 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0 -> 19, 143, 143, 143, 143, 196, 284, 284, 31, 0, 0
<7> [376.580814] i915 0000:00:02.0: [drm:intel_bw_atomic_check [i915]] [CRTC:170:pipe A] data rate 1142000 num active planes 1
<7> [376.580994] i915 0000:00:02.0: [drm:intel_bw_atomic_check [i915]] QGV point 0: max bw 14993 required 1142
<7> [376.581199] i915 0000:00:02.0: [drm:intel_bw_atomic_check [i915]] No SAGV, using single QGV point mask 0x1
<7> [376.581462] i915 0000:00:02.0: [drm:intel_cdclk_atomic_check [i915]] [CRTC:170:pipe A] min cdclk: 0 kHz -> 192000 kHz
<7> [376.581724] i915 0000:00:02.0: [drm:intel_cdclk_update_dbuf_bw_min_cdclk [i915]] dbuf bandwidth min cdclk: 0 kHz -> 17844 kHz
<7> [376.581996] i915 0000:00:02.0: [drm:intel_cdclk_atomic_check [i915]] Modeset required for cdclk change
<7> [376.582179] i915 0000:00:02.0: [drm:intel_cdclk_atomic_check [i915]] New cdclk calculated to be logical 192000 kHz, actual 192000 kHz
<7> [376.582334] i915 0000:00:02.0: [drm:intel_cdclk_atomic_check [i915]] New voltage level calculated to be logical 0, actual 0
<7> [376.582490] i915 0000:00:02.0: [drm:intel_find_dpll [i915]] [CRTC:170:pipe A] allocated DPLL 0
<7> [376.582654] i915 0000:00:02.0: [drm:intel_dpll_crtc_get [i915]] [CRTC:170:pipe A] reserving DPLL 0
<7> [376.582874] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [CRTC:170:pipe A] enable: yes [modeset]
<7> [376.583108] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] active: yes, output_types: HDMI (0x40), output format: RGB, sink format: RGB
<7> [376.583343] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] cpu_transcoder: A, pipe bpp: 24, dithering: 0
<7> [376.583573] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] MST master transcoder: <invalid>
<7> [376.583789] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] port sync: master transcoder: <invalid>, slave transcoder bitmask = 0x0
<7> [376.583973] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] joiner: no, pipes: 0x0
<7> [376.584129] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] splitter: disabled, link count 0, overlap 0
<7> [376.584285] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] audio: 1, infoframes: 1, infoframes enabled: 0x71
<7> [376.584482] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] GCP: 0x0
<7> [376.584721] i915 0000:00:02.0: HDMI infoframe: Auxiliary Video Information (AVI), version 2, length 13
<7> [376.584725] i915 0000:00:02.0: colorspace: RGB
<7> [376.584728] i915 0000:00:02.0: scan mode: Underscan
<7> [376.584730] i915 0000:00:02.0: colorimetry: No Data
<7> [376.584733] i915 0000:00:02.0: picture aspect: No Data
<7> [376.584736] i915 0000:00:02.0: active aspect: Same as Picture
<7> [376.584739] i915 0000:00:02.0: itc: No Data
<7> [376.584741] i915 0000:00:02.0: extended colorimetry: xvYCC 601
<7> [376.584744] i915 0000:00:02.0: quantization range: Full
<7> [376.584747] i915 0000:00:02.0: nups: Unknown Non-uniform Scaling
<7> [376.584750] i915 0000:00:02.0: video code: 0
<7> [376.584752] i915 0000:00:02.0: ycc quantization range: Full
<7> [376.584755] i915 0000:00:02.0: hdmi content type: Graphics
<7> [376.584758] i915 0000:00:02.0: pixel repeat: 0
<7> [376.584760] i915 0000:00:02.0: bar top 0, bottom 0, left 0, right 0
<7> [376.584763] i915 0000:00:02.0: HDMI infoframe: Source Product Description (SPD), version 1, length 25
<7> [376.584766] i915 0000:00:02.0: vendor: Intel
<7> [376.584769] i915 0000:00:02.0: product: Integrated gfx
<7> [376.584772] i915 0000:00:02.0: source device information: PC General (0x9)
<7> [376.584775] i915 0000:00:02.0: HDMI infoframe: Vendor, version 1, length 4
<7> [376.584778] i915 0000:00:02.0: empty frame
<7> [376.584781] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] ELD: 10 00 0f 00 6d a2 00 7f 00 00 00 00 00 00 00 00
<7> [376.585017] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] ELD: 0d 82 34 12 66 69 74 48 65 61 64 6c 65 73 73 47
<7> [376.585247] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] ELD: 53 7f 7f 28 0f 7f 07 17 7f ff 3f 7f ff 47 7f ff
<7> [376.585479] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] ELD: 5f 7f 82 7f 7f 00 7f 7f 51 7f 7f 30 77 7f 03 00
<7> [376.585687] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] scanline offset: 2
<7> [376.585874] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] framestart delay: 1, MSA timing delay: 0, set context latency: 0
<7> [376.586030] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] vrr: no, fixed rr: yes, vmin: 1144, vmax: 1144, flipline: 1144, pipeline full: 61, guardband: 63 vsync start: 0, vsync end: 0
<7> [376.586187] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] vrr: vmin vblank: 1081, vmax vblank: 1081, vmin vtotal: 1144, vmax vtotal: 1144
<7> [376.586355] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] vrr: dc balance: no, vmin: 0 vmax: 0 guardband: 0, slope: 0 max increase: 0 max decrease: 0 vblank target: 0
<7> [376.586583] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] requested mode: "1920x1080": 120 285500 1920 1968 2000 2080 1080 1083 1088 1144 0x48 0x5
<7> [376.586835] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] adjusted mode: "1920x1080": 120 285500 1920 1968 2000 2080 1080 1083 1088 1144 0x48 0x5
<7> [376.587066] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] crtc timings: clock=285500, hd=1920 hb=1920-2080 hs=1968-2000 ht=2080, vd=1080 vb=1080-1144 vs=1083-1088 vt=1144, flags=0x5
<7> [376.587294] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pipe mode: "1920x1080": 120 285500 1920 1968 2000 2080 1080 1083 1088 1144 0x40 0x5
<7> [376.587451] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] crtc timings: clock=285500, hd=1920 hb=1920-2080 hs=1968-2000 ht=2080, vd=1080 vb=1080-1144 vs=1083-1088 vt=1144, flags=0x5
<7> [376.587608] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] port clock: 285500, pipe src: 1920x1080+0+0, pixel rate 285500, min cdclk 192000
<7> [376.587778] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] linetime: 59, ips linetime: 0
<7> [376.587947] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] num_scalers: 2, scaler_users: 0x0, scaler_id: -1, scaling_filter: 0
<7> [376.588177] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pch pfit: 0x0+0+0, disabled, force thru: no
<7> [376.588406] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] ips: 0, double wide: 0, drrs: 0
<7> [376.588636] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] dpll_hw_state: cfgcr0: 0x1801be, cfgcr1: 0x488, div0: 0x0, mg_refclkin_ctl: 0x0, hg_clktop2_coreclkctl1: 0x0, mg_clktop2_hsclkctl: 0x0, mg_pll_div0: 0x0, mg_pll_div2: 0x0, mg_pll_lf: 0x0, mg_pll_frac_lock: 0x0, mg_pll_ssc: 0x0, mg_pll_bias: 0x0, mg_pll_tdc_coldst_bias: 0x0
<7> [376.588874] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] csc_mode: 0x0 gamma_mode: 0x0 gamma_enable: 0 csc_enable: 0
<7> [376.589095] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pre csc lut: 0 entries, post csc lut: 0 entries
<7> [376.589259] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] output csc: pre offsets: 0x0000 0x0000 0x0000
<7> [376.589416] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] output csc: coefficients: 0x0000 0x0000 0x0000
<7> [376.589572] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] output csc: coefficients: 0x0000 0x0000 0x0000
<7> [376.589740] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] output csc: coefficients: 0x0000 0x0000 0x0000
<7> [376.589928] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] output csc: post offsets: 0x0000 0x0000 0x0000
<7> [376.590162] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pipe csc: pre offsets: 0x0000 0x0000 0x0000
<7> [376.590388] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pipe csc: coefficients: 0x0000 0x0000 0x0000
<7> [376.590614] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pipe csc: coefficients: 0x0000 0x0000 0x0000
<7> [376.590852] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pipe csc: coefficients: 0x0000 0x0000 0x0000
<7> [376.591027] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pipe csc: post offsets: 0x0000 0x0000 0x0000
<7> [376.591186] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] sharpness strength: 0, sharpness tap size: 0, sharpness enable: 0
<7> [376.591343] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:34:plane 1A] fb: [FB:636] 1920x1080 format = XR24 little-endian (0x34325258) modifier = 0x100000000000001, visible: yes
<7> [376.591526] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] rotation: 0x1, scaler: -1, scaling_filter: 0
<7> [376.591775] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] src: 1920.000000x1080.000000+0.000000+0.000000 dst: 1920x1080+0+0
<7> [376.592007] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:64:plane 2A] fb: [NOFB], visible: no
<7> [376.592236] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:94:plane 3A] fb: [NOFB], visible: no
<7> [376.592462] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:124:plane 4A] fb: [NOFB], visible: no
<7> [376.592646] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:134:plane 5A] fb: [NOFB], visible: no
<7> [376.592826] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:144:plane 6A] fb: [NOFB], visible: no
<7> [376.592993] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:154:plane 7A] fb: [NOFB], visible: no
<7> [376.593147] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:164:cursor A] fb: [NOFB], visible: no
<7> [376.594059] i915 0000:00:02.0: [drm:intel_power_well_enable [i915]] enabling PW_2
<7> [376.594259] i915 0000:00:02.0: [drm:intel_power_well_enable [i915]] enabling PW_3
<7> [376.594437] i915 0000:00:02.0: [drm:intel_set_cdclk [i915]] Pre changing CDCLK to 192000 kHz, VCO 384000 kHz, ref 38400 kHz, bypass 19200 kHz, voltage level 0
<7> [376.594696] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:586:DDI B/PHY B]
<7> [376.594860] i915 0000:00:02.0: [drm:intel_audio_component_get_power [i915]] restored AUD_FREQ_CNTRL to 0x810
<7> [376.594918] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:596:DDI TC1/PHY TC1]
<7> [376.595155] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:598:DP-MST A]
<7> [376.595392] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:599:DP-MST B]
<7> [376.595621] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:600:DP-MST C]
<7> [376.595826] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:601:DP-MST D]
<7> [376.595987] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:606:DDI TC2/PHY TC2]
<7> [376.596145] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:608:DP-MST A]
<7> [376.596309] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:609:DP-MST B]
<7> [376.596537] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:610:DP-MST C]
<7> [376.596787] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:611:DP-MST D]
<7> [376.597015] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:615:DDI TC3/PHY TC3]
<7> [376.597238] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:617:DP-MST A]
<7> [376.597399] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:618:DP-MST B]
<7> [376.597554] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:619:DP-MST C]
<7> [376.597726] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:620:DP-MST D]
<7> [376.597909] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:624:DDI TC4/PHY TC4]
<7> [376.598140] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:626:DP-MST A]
<7> [376.598369] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:627:DP-MST B]
<7> [376.598600] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:628:DP-MST C]
<7> [376.598839] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:629:DP-MST D]
<7> [376.599160] i915 0000:00:02.0: [drm:gen9_dbuf_slices_update [i915]] Updating dbuf slices to 0x3
<7> [376.599414] i915 0000:00:02.0: [drm:intel_dpll_enable [i915]] enable DPLL 0 (active 0x1, on? 0) for [CRTC:170:pipe A]
<7> [376.599580] i915 0000:00:02.0: [drm:intel_dpll_enable [i915]] enabling DPLL 0
<7> [376.599910] i915 0000:00:02.0: [drm:intel_power_well_enable [i915]] enabling DDI_IO_B
<7> [376.600245] i915 0000:00:02.0: [drm:intel_enable_transcoder [i915]] enabling pipe A
<7> [376.600613] i915 0000:00:02.0: [drm:intel_hdmi_handle_sink_scrambling [i915]] [CONNECTOR:587:HDMI-A-1] scrambling=no, TMDS bit clock ratio=1/10
<7> [376.601168] i915 0000:00:02.0: [drm:do_gmbus_xfer [i915]] GMBUS [i915 gmbus dpb] NAK for addr: 0054 w(1)
<7> [376.601348] i915 0000:00:02.0: [drm:do_gmbus_xfer [i915]] GMBUS [i915 gmbus dpb] NAK on first message, retry
<7> [376.601975] i915 0000:00:02.0: [drm:do_gmbus_xfer [i915]] GMBUS [i915 gmbus dpb] NAK for addr: 0054 w(1)
<7> [376.602205] i915 0000:00:02.0: [drm:drm_scdc_set_high_tmds_clock_ratio [drm_display_helper]] [CONNECTOR:587:HDMI-A-1] Failed to read TMDS config: -6
<7> [376.602228] i915 0000:00:02.0: [drm:intel_ddi_enable [i915]] [CONNECTOR:587:HDMI-A-1] Failed to configure sink scrambling/TMDS bit clock ratio
<7> [376.606544] i915 0000:00:02.0: [drm:intel_fbc_update [i915]] reserved 17694720 bytes of contiguous stolen space for FBC, limit: 1
<7> [376.606765] i915 0000:00:02.0: [drm:intel_fbc_update [i915]] Enabling FBC on [PLANE:34:plane 1A]
<7> [376.610934] i915 0000:00:02.0: [drm:intel_audio_codec_enable [i915]] [CONNECTOR:587:HDMI-A-1][ENCODER:586:DDI B/PHY B] Enable audio codec on [CRTC:170:pipe A], 64 bytes ELD
<7> [376.619280] i915 0000:00:02.0: [drm:audio_config_hdmi_pixel_clock [i915]] HDMI audio pixel clock setting for 285500 not found, falling back to defaults
<7> [376.619467] i915 0000:00:02.0: [drm:audio_config_hdmi_pixel_clock [i915]] Configuring HDMI audio for pixel clock 25200 (0x00010000)
<7> [376.619627] i915 0000:00:02.0: [drm:hsw_audio_config_update [i915]] using automatic N
<6> [376.619819] snd_hda_codec_intelhdmi hdaudioC0D2: HDMI: audio coding xtype 5 not expected
<6> [376.619823] snd_hda_codec_intelhdmi hdaudioC0D2: HDMI: audio coding xtype 0 not expected
<6> [376.619826] snd_hda_codec_intelhdmi hdaudioC0D2: HDMI: audio coding xtype 10 not expected
<6> [376.619829] snd_hda_codec_intelhdmi hdaudioC0D2: HDMI: audio coding xtype 6 not expected
<7> [376.620013] i915 0000:00:02.0: [drm:verify_connector_state [i915]] [CONNECTOR:587:HDMI-A-1]
<7> [376.620418] i915 0000:00:02.0: [drm:intel_modeset_verify_crtc [i915]] [CRTC:170:pipe A]
<7> [376.683538] i915 0000:00:02.0: [drm:intel_audio_component_get_power [i915]] restored AUD_FREQ_CNTRL to 0x810
<3> [377.094669] __i915_vma_unpin_fence:388 GEM_BUG_ON(atomic_read(&vma->fence->pin_count) <= 0)
<0> [377.094963] Dumping ftrace buffer:
<0> [377.094976] ---------------------------------
<0> [377.095263] CPU:7 [LOST 224893 EVENTS]
gem_exec-2233 7..s1. 217073037us : process_csb: 0000:00:02.0 rcs0: csb[3]: status=0x00008000:0x03ff8000
<0> [377.095428] gem_exec-2233 7..s1. 217073038us : trace_ports: 0000:00:02.0 rcs0: completed { ccid:20 55:253356! prio 0 }
<0> [377.095644] gem_exec-2233 7d.s2. 217073038us : __i915_request_submit: 0000:00:02.0 rcs0: fence 55:253358, current 253356
<0> [377.095818] gem_exec-2233 7d.s1. 217073040us : trace_ports: 0000:00:02.0 rcs0: submit { ccid:20 55:253358 prio 0 }
<0> [377.096031] gem_exec-2233 7..... 217073197us : i915_request_retire.part.0: 0000:00:02.0 rcs0: fence 55:253364, current 253364
<0> [377.096243] gem_exec-2233 7..... 217073210us : __i915_request_commit: 0000:00:02.0 rcs0: fence 55:253368, current 253364
<0> [377.096453] gem_exec-2233 7d.s2. 217073220us : __i915_request_submit: 0000:00:02.0 rcs0: fence 55:253368, current 253366
<0> [377.096647] gem_exec-2233 7d.s1. 217073221us : trace_ports: 0000:00:02.0 rcs0: submit { ccid:20 55:253368 prio 0 }
<0> [377.096864] gem_exec-2233 7..... 217073404us : i915_request_retire.part.0: 0000:00:02.0 rcs0: fence 55:253374, current 253374
<0> [377.097075] gem_exec-2233 7..... 217073425us : __i915_request_commit: 0000:00:02.0 rcs0: fence 55:253378, current 253376
<0> [377.097283] gem_exec-2233 7d.s2. 217073434us : __i915_request_submit: 0000:00:02.0 rcs0: fence 55:253378, current 253376
<0> [377.097457] gem_exec-2233 7d.s1. 217073436us : execlists_submission_tasklet: 0000:00:02.0 rcs0: context:55 schedule-in, ccid:20
<0> [377.097630] gem_exec-2233 7d.s1. 217073437us : trace_ports: 0000:00:02.0 rcs0: submit { ccid:20 55:253378 prio 0 }
<0> [377.097835] gem_exec-2233 7..... 217073686us : i915_request_retire.part.0: 0000:00:02.0 rcs0: fence 55:253392, current 253392
<0> [377.098042] gem_exec-2233 7..... 217073709us : __i915_request_commit: 0000:00:02.0 rcs0: fence 55:253396, current 253394
<0> [377.098252] gem_exec-2233 7d.s2. 217073718us : __i915_request_submit: 0000:00:02.0 rcs0: fence 55:253396, current 253394
<0> [377.098427] gem_exec-2233 7d.s1. 217073719us : execlists_submission_tasklet: 0000:00:02.0 rcs0: context:55 schedule-in, ccid:20
<0> [377.098599] gem_exec-2233 7d.s1. 217073720us : trace_ports: 0000:00:02.0 rcs0: submit { ccid:20 55:253396 prio 0 }
<0> [377.098787] gem_exec-2233 7..... 217073733us : intel_rps_boost.part.0: 0000:00:02.0 boost fence:55:3ddd4
<0> [377.098997] gem_exec-2233 7..... 217073887us : i915_request_retire.part.0: 0000:00:02.0 rcs0: fence 55:253404, current 253404
<0> [377.099206] gem_exec-2233 7..... 217073902us : __i915_request_commit: 0000:00:02.0 rcs0: fence 55:253408, current 253405
<0> [377.099378] gem_exec-2233 7..s1. 217073911us : process_csb: 0000:00:02.0 rcs0: cs-irq head=4, tail=5
<0> [377.099560] gem_exec-2233 7..s1. 217073912us : process_csb: 0000:00:02.0 rcs0: csb[5]: status=0x00008000:0x03ff8000
<0> [377.099730] gem_exec-2233 7..s1. 217073912us : trace_ports: 0000:00:02.0 rcs0: completed { ccid:20 55:253406! prio 0 }
<0> [377.099936] gem_exec-2233 7d.s2. 217073913us : __i915_request_submit: 0000:00:02.0 rcs0: fence 55:253408, current 253406
<0> [377.100109] gem_exec-2233 7d.s1. 217073914us : trace_ports: 0000:00:02.0 rcs0: submit { ccid:20 55:253408 prio 0 }
<0> [377.100187] gem_exec-2233 7..... 217073927us : intel_rps_boost.part.0: 0000:00:02.0 boost fence:55:3dde0
<0> [377.100248] gem_exec-2233 7b.... 217073939us : process_csb: 0000:00:02.0 rcs0: cs-irq head=6, tail=7
<0> [377.100308] gem_exec-2233 7b.... 217073939us : process_csb: 0000:00:02.0 rcs0: csb[7]: status=0x00008000:0x03ff8000
<0> [377.100368] gem_exec-2233 7b.... 217073940us : trace_ports: 0000:00:02.0 rcs0: completed { ccid:20 55:253408! prio 0 }
<0> [377.100428] gem_exec-2233 7b.... 217073941us : __execlists_schedule_out: 0000:00:02.0 rcs0: context:55 schedule-out, ccid:20
<0> [377.100505] gem_exec-2233 7..... 217074079us : i915_request_retire.part.0: 0000:00:02.0 rcs0: fence 55:253416, current 253416
<0> [377.100588] gem_exec-2233 7..... 217074097us : __i915_request_commit: 0000:00:02.0 rcs0: fence 55:253420, current 253418
<0> [377.100655] gem_exec-2233 7..s1. 217074104us : process_csb: 0000:00:02.0 rcs0: cs-irq head=4, tail=5
<0> [377.100721] gem_exec-2233 7..s1. 217074105us : process_csb: 0000:00:02.0 rcs0: csb[5]: status=0x00008000:0x03ff8000
<0> [377.100788] gem_exec-2233 7..s1. 217074105us : trace_ports: 0000:00:02.0 rcs0: completed { ccid:20 55:253418! prio 0 }
<0> [377.100871] gem_exec-2233 7d.s2. 217074106us : __i915_request_submit: 0000:00:02.0 rcs0: fence 55:253420, current 253418
<0> [377.100938] gem_exec-2233 7d.s1. 217074107us : trace_ports: 0000:00:02.0 rcs0: submit { ccid:20 55:253420 prio 0 }
<0> [377.101021] gem_exec-2233 7..... 217074345us : i915_request_retire.part.0: 0000:00:02.0 rcs0: fence 55:253432, current 253432
<0> [377.101103] gem_exec-2233 7..... 217074357us : __i915_request_commit: 0000:00:02.0 rcs0: fence 55:253436, current 253432
<0> [377.101185] gem_exec-2233 7d.s2. 217074366us : __i915_request_submit: 0000:00:02.0 rcs0: fence 55:253436, current 253434
<0> [377.101253] gem_exec-2233 7d.s1. 217074367us : trace_ports: 0000:00:02.0 rcs0: submit { ccid:20 55:253436 prio 0 }
<0> [377.101334] gem_exec-2233 7..... 217074502us : i915_request_retire.part.0: 0000:00:02.0 rcs0: fence 55:253442, current 253442
<0> [377.101416] gem_exec-2233 7..... 217074523us : __i915_request_commit: 0000:00:02.0 rcs0: fence 55:253446, current 253444
<0> [377.101501] gem_exec-2233 7..... 217074701us : i915_request_retire.part.0: 0000:00:02.0 rcs0: fence 55:253454, current 253454
<0> [377.101586] gem_exec-2233 7..... 217074712us : __i915_request_commit: 0000:00:02.0 rcs0: fence 55:253458, current 253454
<0> [377.101665] gem_exec-2233 7d.s2. 217074721us : __i915_request_submit: 0000:00:02.0 rcs0: fence 55:253458, current 253456
<0> [377.101732] gem_exec-2233 7d.s1. 217074722us : trace_ports: 0000:00:02.0 rcs0: submit { ccid:20 55:253458 prio 0 }
<0> [377.101813] gem_exec-2233 7..... 217074907us : i915_request_retire.part.0: 0000:00:02.0 rcs0: fence 55:253468, current 253468
<0> [377.101894] gem_exec-2233 7..... 217074927us : __i915_request_commit: 0000:00:02.0 rcs0: fence 55:253472, current 253470
<0> [377.101961] ksoftirq-60 7..s.. 217074943us : process_csb: 0000:00:02.0 rcs0: cs-irq head=9, tail=10
<0> [377.102028] ksoftirq-60 7..s.. 217074943us : process_csb: 0000:00:02.0 rcs0: csb[10]: status=0x03ff8000:0x00008001
<0> [377.102095] ksoftirq-60 7..s.. 217074944us : trace_ports: 0000:00:02.0 rcs0: promote { ccid:20 55:253472 prio 0 }
<0> [377.102175] gem_exec-2233 7..... 217075045us : i915_request_retire.part.0: 0000:00:02.0 rcs0: fence 55:253476, current 253478
<0> [377.102256] gem_exec-2233 7..... 217075063us : __i915_request_commit: 0000:00:02.0 rcs0: fence 55:253480, current 253478
<0> [377.102336] gem_exec-2233 7d.s2. 217075069us : __i915_request_submit: 0000:00:02.0 rcs0: fence 55:253480, current 253478
<0> [377.102403] gem_exec-2233 7d.s1. 217075070us : execlists_submission_tasklet: 0000:00:02.0 rcs0: context:55 schedule-in, ccid:20
<0> [377.102470] gem_exec-2233 7d.s1. 217075071us : trace_ports: 0000:00:02.0 rcs0: submit { ccid:20 55:253480 prio 0 }
<0> [377.102551] gem_exec-2233 7..... 217075237us : i915_request_retire.part.0: 0000:00:02.0 rcs0: fence 55:253488, current 253490
<0> [377.102632] gem_exec-2233 7..... 217075253us : __i915_request_commit: 0000:00:02.0 rcs0: fence 55:253492, current 253490
<0> [377.102717] gem_exec-2233 7d.s2. 217075257us : __i915_request_submit: 0000:00:02.0 rcs0: fence 55:253492, current 253490
<0> [377.102786] gem_exec-2233 7d.s1. 217075258us : execlists_submission_tasklet: 0000:00:02.0 rcs0: context:55 schedule-in, ccid:20
<0> [377.102854] gem_exec-2233 7d.s1. 217075259us : trace_ports: 0000:00:02.0 rcs0: submit { ccid:20 55:253492 prio 0 }
<0> [377.102936] gem_exec-2233 7..... 217075401us : i915_request_retire.part.0: 0000:00:02.0 rcs0: fence 55:253500, current 253500
<0> [377.103018] gem_exec-2233 7..... 217075420us : __i915_request_commit: 0000:00:02.0 rcs0: fence 55:253504, current 253502
<0> [377.103085] gem_exec-2233 7..s1. 217075427us : process_csb: 0000:00:02.0 rcs0: cs-irq head=4, tail=5
<0> [377.103153] gem_exec-2233 7..s1. 217075427us : process_csb: 0000:00:02.0 rcs0: csb[5]: status=0x00008000:0x03ff8000
<0> [377.103220] gem_exec-2233 7..s1. 217075428us : trace_ports: 0000:00:02.0 rcs0: completed { ccid:20 55:253502! prio 0 }
<0> [377.103300] gem_exec-2233 7d.s2. 217075429us : __i915_request_submit: 0000:00:02.0 rcs0: fence 55:253504, current 253502
<0> [377.103367] gem_exec-2233 7d.s1. 217075430us : trace_ports: 0000:00:02.0 rcs0: submit { ccid:20 55:253504 prio 0 }
<0> [377.103447] gem_exec-2233 7..... 217075562us : i915_request_retire.part.0: 0000:00:02.0 rcs0: fence 55:253510, current 253510
<0> [377.103528] gem_exec-2233 7..... 217075579us : __i915_request_commit: 0000:00:02.0 rcs0: fence 55:253514, current 253511
<0> [377.103596] gem_exec-2233 7..s1. 217075587us : process_csb: 0000:00:02.0 rcs0: cs-irq head=2, tail=3
<0> [377.103662] gem_exec-2233 7..s1. 217075587us : process_csb: 0000:00:02.0 rcs0: csb[3]: status=0x00008000:0x03ff8000
<0> [377.103729] gem_exec-2233 7..s1. 217075588us : trace_ports: 0000:00:02.0 rcs0: completed { ccid:20 55:253512! prio 0 }
<0> [377.103809] gem_exec-2233 7d.s2. 217075589us : __i915_request_submit: 0000:00:02.0 rcs0: fence 55:253514, current 253512
<0> [377.103876] gem_exec-2233 7d.s1. 217075590us : trace_ports: 0000:00:02.0 rcs0: submit { ccid:20 55:253514 prio 0 }
<0> [377.103957] gem_exec-2233 7..... 217075674us : i915_request_retire.part.0: 0000:00:02.0 rcs0: fence 55:253516, current 253516
<0> [377.104037] gem_exec-2233 7..... 217075691us : __i915_request_commit: 0000:00:02.0 rcs0: fence 55:253520, current 253518
<0> [377.104117] gem_exec-2233 7d.s2. 217075699us : __i915_request_submit: 0000:00:02.0 rcs0: fence 55:253520, current 253518
<0> [377.104184] gem_exec-2233 7d.s1. 217075700us : execlists_submission_tasklet: 0000:00:02.0 rcs0: context:55 schedule-in, ccid:20
<0> [377.104251] gem_exec-2233 7d.s1. 217075700us : trace_ports: 0000:00:02.0 rcs0: submit { ccid:20 55:253520 prio 0 }
<0> [377.104331] gem_exec-2233 7..... 217075863us : i915_request_retire.part.0: 0000:00:02.0 rcs0: fence 55:253528, current 253528
<0> [377.104413] gem_exec-2233 7..... 217075882us : __i915_request_commit: 0000:00:02.0 rcs0: fence 55:253532, current 253530
<0> [377.104481] gem_exec-2233 7..s1. 217075890us : process_csb: 0000:00:02.0 rcs0: cs-irq head=8, tail=9
<0> [377.104549] gem_exec-2233 7..s1. 217075890us : process_csb: 0000:00:02.0 rcs0: csb[9]: status=0x00008000:0x03ff8000
<0> [377.104616] gem_exec-2233 7..s1. 217075891us : trace_ports: 0000:00:02.0 rcs0: completed { ccid:20 55:253530! prio 0 }
<0> [377.104698] gem_exec-2233 7d.s2. 217075892us : __i915_request_submit: 0000:00:02.0 rcs0: fence 55:253532, current 253530
<0> [377.104766] gem_exec-2233 7d.s1. 217075892us : trace_ports: 0000:00:02.0 rcs0: submit { ccid:20 55:253532 prio 0 }
<0> [377.104848] gem_exec-2233 7..... 217076023us : i915_request_retire.part.0: 0000:00:02.0 rcs0: fence 55:253538, current 253538
<0> [377.104931] gem_exec-2233 7..... 217076035us : __i915_request_commit: 0000:00:02.0 rcs0: fence 55:253542, current 253538
<0> [377.105013] gem_exec-2233 7d.s2. 217076044us : __i915_request_submit: 0000:00:02.0 rcs0: fence 55:253542, current 253540
<0> [377.105080] gem_exec-2233 7d.s1. 217076045us : trace_ports: 0000:00:02.0 rcs0: submit { ccid:20 55:253542 prio 0 }
<0> [377.105161] gem_exec-2233 7..... 217076164us : i915_request_retire.part.0: 0000:00:02.0 rcs0: fence 55:253548, current 253548
<0> [377.105243] gem_exec-2233 7..... 217076179us : __i915_request_commit: 0000:00:02.0 rcs0: fence 55:253552, current 253549
<0> [377.105310] gem_exec-2233 7..s1. 217076189us : process_csb: 0000:00:02.0 rcs0: cs-irq head=4, tail=5
<0> [377.105377] gem_exec-2233 7..s1. 217076189us : process_csb: 0000:00:02.0 rcs0: csb[5]: status=0x00008000:0x03ff8000
<0> [377.105443] gem_exec-2233 7..s1. 217076190us : trace_ports: 0000:00:02.0 rcs0: completed { ccid:20 55:253550! prio 0 }
<0> [377.105524] gem_exec-2233 7d.s2. 217076191us : __i915_request_submit: 0000:00:02.0 rcs0: fence 55:253552, current 253550
<0> [377.105591] gem_exec-2233 7d.s1. 217076192us : trace_ports: 0000:00:02.0 rcs0: submit { ccid:20 55:253552 prio 0 }
<0> [377.105664] gem_exec-2233 7..... 217076207us : intel_rps_boost.part.0: 0000:00:02.0 boost fence:55:3de70
<0> [377.105744] gem_exec-2233 7..... 217076448us : i915_request_retire.part.0: 0000:00:02.0 rcs0: fence 55:253566, current 253566
<0> [377.105825] gem_exec-2233 7..... 217076465us : __i915_request_commit: 0000:00:02.0 rcs0: fence 55:253570, current 253567
<0> [377.105892] gem_exec-2233 7..s1. 217076473us : process_csb: 0000:00:02.0 rcs0: cs-irq head=10, tail=11
<0> [377.105959] gem_exec-2233 7..s1. 217076473us : process_csb: 0000:00:02.0 rcs0: csb[11]: status=0x00008000:0x03ff8000
<0> [377.106025] gem_exec-2233 7..s1. 217076474us : trace_ports: 0000:00:02.0 rcs0: completed { ccid:20 55:253568! prio 0 }
<0> [377.106106] gem_exec-2233 7d.s2. 217076475us : __i915_request_submit: 0000:00:02.0 rcs0: fence 55:253570, current 253568
<0> [377.106172] gem_exec-2233 7d.s1. 217076476us : trace_ports: 0000:00:02.0 rcs0: submit { ccid:20 55:253570 prio 0 }
<0> [377.106253] gem_exec-2233 7..... 217076671us : i915_request_retire.part.0: 0000:00:02.0 rcs0: fence 55:253580, current 253580
<0> [377.106335] gem_exec-2233 7..... 217076693us : __i915_request_commit: 0000:00:02.0 rcs0: fence 55:253584, current 253582
<0> [377.106418] gem_exec-2233 7d.s2. 217076703us : __i915_request_submit: 0000:00:02.0 rcs0: fence 55:253584, current 253582
<0> [377.106487] gem_exec-2233 7d.s1. 217076704us : execlists_submission_tasklet: 0000:00:02.0 rcs0: context:55 schedule-in, ccid:20
<0> [377.106559] gem_exec-2233 7d.s1. 217076704us : trace_ports: 0000:00:02.0 rcs0: submit { ccid:20 55:253584 prio 0 }
<0> [377.106634] gem_exec-2233 7..... 217076715us : intel_rps_boost.part.0: 0000:00:02.0 boost fence:55:3de90
<0> [377.106715] gem_exec-2233 7D..1. 217076726us : __i915_request_submit: 0000:00:02.0 rcs0: fence 55:253586, current 253584
<0> [377.106783] gem_exec-2233 7D.... 217076727us : trace_ports: 0000:00:02.0 rcs0: submit { ccid:20 55:253586 prio 0 }
<0> [377.106864] gem_exec-2233 7..... 217076895us : i915_request_retire.part.0: 0000:00:02.0 rcs0: fence 55:253594, current 253594
<0> [377.106946] gem_exec-2233 7..... 217076914us : __i915_request_commit: 0000:00:02.0 rcs0: fence 55:253598, current 253596
<0> [377.107014] ksoftirq-60 7..s.. 217076930us : process_csb: 0000:00:02.0 rcs0: cs-irq head=3, tail=4
<0> [377.107081] ksoftirq-60 7..s.. 217076931us : process_csb: 0000:00:02.0 rcs0: csb[4]: status=0x03ff8000:0x00008001
<0> [377.107147] ksoftirq-60 7..s.. 217076932us : trace_ports: 0000:00:02.0 rcs0: promote { ccid:20 55:253598 prio 0 }
<0> [377.107228] gem_exec-2233 7..... 217077130us : i915_request_retire.part.0: 0000:00:02.0 rcs0: fence 55:253608, current 253608
<0> [377.107310] gem_exec-2233 7..... 217077148us : __i915_request_commit: 0000:00:02.0 rcs0: fence 55:253612, current 253610
<0> [377.107377] gem_exec-2233 7..s1. 217077155us : process_csb: 0000:00:02.0 rcs0: cs-irq head=4, tail=5
<0> [377.107443] gem_exec-2233 7..s1. 217077155us : process_csb: 0000:00:02.0 rcs0: csb[5]: status=0x00008000:0x03ff8000
<0> [377.107509] gem_exec-2233 7..s1. 217077156us : trace_ports: 0000:00:02.0 rcs0: completed { ccid:20 55:253610! prio 0 }
<0> [377.107590] gem_exec-2233 7d.s2. 217077156us : __i915_request_submit: 0000:00:02.0 rcs0: fence 55:253612, current 253610
<0> [377.107657] gem_exec-2233 7d.s1. 217077157us : trace_ports: 0000:00:02.0 rcs0: submit { ccid:20 55:253612 prio 0 }
<0> [377.107730] gem_exec-2233 7..... 217077172us : intel_rps_boost.part.0: 0000:00:02.0 boost fence:55:3deac
<0> [377.107810] gem_exec-2233 7..... 217077318us : i915_request_retire.part.0: 0000:00:02.0 rcs0: fence 55:253620, current 253620
<0> [377.107891] gem_exec-2233 7..... 217077332us : __i915_request_commit: 0000:00:02.0 rcs0: fence 55:253624, current 253621
<0> [377.107958] gem_exec-2233 7..s1. 217077340us : process_csb: 0000:00:02.0 rcs0: cs-irq head=4, tail=5
<0> [377.108024] gem_exec-2233 7..s1. 217077340us : process_csb: 0000:00:02.0 rcs0: csb[5]: status=0x00008000:0x03ff8000
<0> [377.108091] gem_exec-2233 7..s1. 217077341us : trace_ports: 0000:00:02.0 rcs0: completed { ccid:20 55:253622! prio 0 }
<0> [377.108172] gem_exec-2233 7d.s2. 217077342us : __i915_request_submit: 0000:00:02.0 rcs0: fence 55:253624, current 253622
<0> [377.108240] gem_exec-2233 7d.s1. 217077342us : trace_ports: 0000:00:02.0 rcs0: submit { ccid:20 55:253624 prio 0 }
<0> [377.108315] gem_exec-2233 7..... 217077357us : intel_rps_boost.part.0: 0000:00:02.0 boost fence:55:3deb8
<0> [377.108382] gem_exec-2233 7b.... 217077367us : process_csb: 0000:00:02.0 rcs0: cs-irq head=6, tail=7
<0> [377.108449] gem_exec-2233 7b.... 217077367us : process_csb: 0000:00:02.0 rcs0: csb[7]: status=0x00008000:0x03ff8000
<0> [377.108516] gem_exec-2233 7b.... 217077368us : trace_ports: 0000:00:02.0 rcs0: completed { ccid:20 55:253624! prio 0 }
<0> [377.108585] gem_exec-2233 7b.... 217077369us : __execlists_schedule_out: 0000:00:02.0 rcs0: context:55 schedule-out, ccid:20
<0> [377.108659] gem_exec-2233 7..... 217077478us : i915_request_retire.part.0: 0000:00:02.0 rcs0: fence 55:253630, current 253630
<0> [377.108734] gem_exec-2233 7..... 217077500us : __i915_request_commit: 0000:00:02.0 rcs0: fence 55:253634, current 253632
<0> [377.108808] gem_exec-2233 7d.s2. 217077508us : __i915_request_submit: 0000:00:02.0 rcs0: fence 55:253634, current 253632
<0> [377.108869] gem_exec-2233 7d.s1. 217077509us : execlists_submission_tasklet: 0000:00:02.0 rcs0: context:55 schedule-in, ccid:20
<0> [377.108929] gem_exec-2233 7d.s1. 217077509us : trace_ports: 0000:00:02.0 rcs0: submit { ccid:20 55:253634 prio 0 }
<0> [377.109003] gem_exec-2233 7..... 217077696us : i915_request_retire.part.0: 0000:00:02.0 rcs0: fence 55:253644, current 253644
<0> [377.109076] gem_exec-2233 7..... 217077711us : __i915_request_commit: 0000:00:02.0 rcs0: fence 55:253648, current 253645
<0> [377.109137] gem_exec-2233 7..s1. 217077719us : process_csb: 0000:00:02.0 rcs0: cs-irq head=4, tail=5
<0> [377.109197] gem_exec-2233 7..s1. 217077719us : process_csb: 0000:00:02.0 rcs0: csb[5]: status=0x00008000:0x03ff8000
<0> [377.109257] gem_exec-2233 7..s1. 217077720us : trace_ports: 0000:00:02.0 rcs0: completed { ccid:20 55:253646! prio 0 }
<0> [377.109331] gem_exec-2233 7d.s2. 217077721us : __i915_request_submit: 0000:00:02.0 rcs0: fence 55:253648, current 253646
<0> [377.109391] gem_exec-2233 7d.s1. 217077722us : trace_ports: 0000:00:02.0 rcs0: submit { ccid:20 55:253648 prio 0 }
<0> [377.109457] gem_exec-2233 7..... 217077736us : intel_rps_boost.part.0: 0000:00:02.0 boost fence:55:3ded0
<0> [377.109517] gem_exec-2233 7b.... 217077747us : process_csb: 0000:00:02.0 rcs0: cs-irq head=6, tail=7
<0> [377.109586] gem_exec-2233 7b.... 217077747us : process_csb: 0000:00:02.0 rcs0: csb[7]: status=0x00008000:0x03ff8000
<0> [377.109650] gem_exec-2233 7b.... 217077748us : trace_ports: 0000:00:02.0 rcs0: completed { ccid:20 55:253648! prio 0 }
<0> [377.109709] gem_exec-2233 7b.... 217077749us : __execlists_schedule_out: 0000:00:02.0 rcs0: context:55 schedule-out, ccid:20
<0> [377.109783] gem_exec-2233 7..... 217077877us : i915_request_retire.part.0: 0000:00:02.0 rcs0: fence 55:253656, current 253656
<0> [377.109856] gem_exec-2233 7..... 217077895us : __i915_request_commit: 0000:00:02.0 rcs0: fence 55:253660, current 253658
<0> [377.109930] gem_exec-2233 7..... 217078092us : i915_request_retire.part.0: 0000:00:02.0 rcs0: fence 55:253670, current 253670
<0> [377.110014] gem_exec-2233 7..... 217078111us : __i915_request_commit: 0000:00:02.0 rcs0: fence 55:253674, current 253672
<0> [377.110088] gem_exec-2233 7..... 217078135us : intel_rps_boost.part.0: 0000:00:02.0 boost fence:55:3deea
<0> [377.110169] gem_exec-2233 7..... 217078270us : i915_request_retire.part.0: 0000:00:02.0 rcs0: fence 55:253682, current 253682
<0> [377.110253] gem_exec-2233 7..... 217078296us : __i915_request_commit: 0000:00:02.0 rcs0: fence 55:253686, current 253684
<0> [377.110336] gem_exec-2233 7d.s2. 217078305us : __i915_request_submit: 0000:00:02.0 rcs0: fence 55:253686, current 253684
<0> [377.110404] gem_exec-2233 7d.s1. 217078307us : execlists_submission_tasklet: 0000:00:02.0 rcs0: context:55 schedule-in, ccid:20
<0> [377.110472] gem_exec-2233 7d.s1. 217078308us : trace_ports: 0000:00:02.0 rcs0: submit { ccid:20 55:253686 prio 0 }
<0> [377.110558] gem_exec-2233 7..... 217078469us : i915_request_retire.part.0: 0000:00:02.0 rcs0: fence 55:253690, current 253692
<0> [377.110632] gem_exec-2233 7..... 217078488us : __i915_request_commit: 0000:00:02.0 rcs0: fence 55:253694, current 253692
<0> [377.110706] gem_exec-2233 7d.s2. 217078497us : __i915_request_submit: 0000:00:02.0 rcs0: fence 55:253694, current 253692
<0> [377.110768] gem_exec-2233 7d.s1. 217078498us : execlists_submission_tasklet: 0000:00:02.0 rcs0: context:55 schedule-in, ccid:20
<0> [377.110829] gem_exec-2233 7d.s1. 217078499us : trace_ports: 0000:00:02.0 rcs0: submit { ccid:20 55:253694 prio 0 }
<0> [377.110902] gem_exec-2233 7..... 217078685us : i915_request_retire.part.0: 0000:00:02.0 rcs0: fence 55:253704, current 253704
<0> [377.110975] gem_exec-2233 7..... 217078706us : __i915_request_commit: 0000:00:02.0 rcs0: fence 55:253708, current 253706
<0> [377.111060] gem_exec-2233 7d.s2. 217078714us : __i915_request_submit: 0000:00:02.0 rcs0: fence 55:253708, current 253706
<0> [377.111127] gem_exec-2233 7d.s1. 217078715us : execlists_submission_tasklet: 0000:00:02.0 rcs0: context:55 schedule-in, ccid:20
<0> [377.111194] gem_exec-2233 7d.s1. 217078715us : trace_ports: 0000:00:02.0 rcs0: submit { ccid:20 55:253708 prio 0 }
<0> [377.111275] gem_exec-2233 7..... 217078902us : i915_request_retire.part.0: 0000:00:02.0 rcs0: fence 55:253718, current 253718
<0> [377.111356] gem_exec-2233 7..... 217078919us : __i915_request_commit: 0000:00:02.0 rcs0: fence 55:253722, current 253719
<0> [377.111424] gem_exec-2233 7..s1. 217078927us : process_csb: 0000:00:02.0 rcs0: cs-irq head=6, tail=7
<0> [377.111490] gem_exec-2233 7..s1. 217078927us : process_csb: 0000:00:02.0 rcs0: csb[7]: status=0x00008000:0x03ff8000
<0> [377.111563] gem_exec-2233 7..s1. 217078928us : trace_ports: 0000:00:02.0 rcs0: completed { ccid:20 55:253720! prio 0 }
<0> [377.111647] gem_exec-2233 7d.s2. 217078929us : __i915_request_submit: 0000:00:02.0 rcs0: fence 55:253722, current 253720
<0> [377.111715] gem_exec-2233 7d.s1. 217078930us : trace_ports: 0000:00:02.0 rcs0: submit { ccid:20 55:253722 prio 0 }
<0> [377.111797] gem_exec-2233 7..... 217079110us : i915_request_retire.part.0: 0000:00:02.0 rcs0: fence 55:253732, current 253732
<0> [377.111880] gem_exec-2233 7..... 217079124us : __i915_request_commit: 0000:00:02.0 rcs0: fence 55:253736, current 253733
<0> [377.111947] gem_exec-2233 7..s1. 217079132us : process_csb: 0000:00:02.0 rcs0: cs-irq head=8, tail=9
<0> [377.112014] gem_exec-2233 7..s1. 217079133us : process_csb: 0000:00:02.0 rcs0: csb[9]: status=0x00008000:0x03ff8000
<0> [377.112081] gem_exec-2233 7..s1. 217079133us : trace_ports: 0000:00:02.0 rcs0: completed { ccid:20 55:253734! prio 0 }
<0> [377.112163] gem_exec-2233 7d.s2. 217079134us : __i915_request_submit: 0000:00:02.0 rcs0: fence 55:253736, current 253734
<0> [377.112230] gem_exec-2233 7d.s1. 217079135us : trace_ports: 0000:00:02.0 rcs0: submit { ccid:20 55:253736 prio 0 }
<0> [377.112312] gem_exec-2233 7..... 217079320us : i915_request_retire.part.0: 0000:00:02.0 rcs0: fence 55:253746, current 253746
<0> [377.112393] gem_exec-2233 7..... 217079334us : __i915_request_commit: 0000:00:02.0 rcs0: fence 55:253750, current 253747
<0> [377.112460] gem_exec-2233 7..s1. 217079343us : process_csb: 0000:00:02.0 rcs0: cs-irq head=10, tail=11
<0> [377.112527] gem_exec-2233 7..s1. 217079344us : process_csb: 0000:00:02.0 rcs0: csb[11]: status=0x00008000:0x03ff8000
<0> [377.112594] gem_exec-2233 7..s1. 217079344us : trace_ports: 0000:00:02.0 rcs0: completed { ccid:20 55:253748! prio 0 }
<0> [377.112675] gem_exec-2233 7d.s2. 217079345us : __i915_request_submit: 0000:00:02.0 rcs0: fence 55:253750, current 253748
<0> [377.112742] gem_exec-2233 7d.s1. 217079346us : trace_ports: 0000:00:02.0 rcs0: submit { ccid:20 55:253750 prio 0 }
<0> [377.112823] gem_exec-2233 7..... 217079532us : i915_request_retire.part.0: 0000:00:02.0 rcs0: fence 55:253760, current 253760
<0> [377.112905] gem_exec-2233 7..... 217079553us : __i915_request_commit: 0000:00:02.0 rcs0: fence 55:253764, current 253762
<0> [377.112985] gem_exec-2233 7..... 217079698us : i915_request_retire.part.0: 0000:00:02.0 rcs0: fence 55:253770, current 253770
<0> [377.113067] gem_exec-2233 7..... 217079711us : __i915_request_commit: 0000:00:02.0 rcs0: fence 55:253774, current 253770
<0> [377.113134] gem_exec-2233 7..s1. 217079720us : process_csb: 0000:00:02.0 rcs0: cs-irq head=10, tail=11
<0> [377.113201] gem_exec-2233 7..s1. 217079720us : process_csb: 0000:00:02.0 rcs0: csb[11]: status=0x00008000:0x03ff8000
<0> [377.113268] gem_exec-2233 7..s1. 217079721us : trace_ports: 0000:00:02.0 rcs0: completed { ccid:20 55:253772! prio 0 }
<0> [377.113351] gem_exec-2233 7d.s2. 217079722us : __i915_request_submit: 0000:00:02.0 rcs0: fence 55:253774, current 253772
<0> [377.113418] gem_exec-2233 7d.s1. 217079723us : trace_ports: 0000:00:02.0 rcs0: submit { ccid:20 55:253774 prio 0 }
<0> [377.113501] gem_exec-2233 7..... 217079973us : i915_request_retire.part.0: 0000:00:02.0 rcs0: fence 55:253788, current 253788
<0> [377.113582] gem_exec-2233 7..... 217079994us : __i915_request_commit: 0000:00:02.0 rcs0: fence 55:253792, current 253790
<0> [377.113656] gem_exec-2233 7..... 217080199us : i915_request_retire.part.0: 0000:00:02.0 rcs0: fence 55:253802, current 253802
<0> [377.113731] gem_exec-2233 7..... 217080214us : __i915_request_commit: 0000:00:02.0 rcs0: fence 55:253806, current 253803
<0> [377.113792] gem_exec-2233 7..s1. 217080223us : process_csb: 0000:00:02.0 rcs0: cs-irq head=6, tail=7
<0> [377.113852] gem_exec-2233 7..s1. 217080223us : process_csb: 0000:00:02.0 rcs0: csb[7]: status=0x00008000:0x03ff8000
<0> [377.113912] gem_exec-2233 7..s1. 217080224us : trace_ports: 0000:00:02.0 rcs0: completed { ccid:20 55:253804! prio 0 }
<0> [377.113985] gem_exec-2233 7d.s2. 217080225us : __i915_request_submit: 0000:00:02.0 rcs0: fence 55:253806, current 253804
<0> [377.114046] gem_exec-2233 7d.s1. 217080226us : trace_ports: 0000:00:02.0 rcs0: submit { ccid:20 55:253806 prio 0 }
<0> [377.114127] gem_exec-2233 7..... 217080448us : __i915_request_commit: 0000:00:02.0 rcs0: fence 55:253816, current 253812
<0> [377.114194] gem_exec-2233 7..s1. 217080457us : process_csb: 0000:00:02.0 rcs0: cs-irq head=4, tail=5
<0> [377.114260] gem_exec-2233 7..s1. 217080457us : process_csb: 0000:00:02.0 rcs0: csb[5]: status=0x00008000:0x03ff8000
<0> [377.114326] gem_exec-2233 7..s1. 217080458us : trace_ports: 0000:00:02.0 rcs0: completed { ccid:20 55:253814! prio 0 }
<0> [377.114407] gem_exec-2233 7d.s2. 217080459us : __i915_request_submit: 0000:00:02.0 rcs0: fence 55:253816, current 253814
<0> [377.114474] gem_exec-2233 7d.s1. 217080460us : trace_ports: 0000:00:02.0 rcs0: submit { ccid:20 55:253816 prio 0 }
<0> [377.114554] gem_exec-2233 7..... 217080644us : i915_request_retire.part.0: 0000:00:02.0 rcs0: fence 55:253826, current 253826
<0> [377.114633] gem_exec-2233 7..... 217080658us : __i915_request_commit: 0000:00:02.0 rcs0: fence 55:253830, current 253826
<0> [377.114693] gem_exec-2233 7..s1. 217080666us : process_csb: 0000:00:02.0 rcs0: cs-irq head=6, tail=7
<0> [377.114753] gem_exec-2233 7..s1. 217080667us : process_csb: 0000:00:02.0 rcs0: csb[7]: status=0x00008000:0x03ff8000
<0> [377.114814] gem_exec-2233 7..s1. 217080668us : trace_ports: 0000:00:02.0 rcs0: completed { ccid:20 55:253828! prio 0 }
<0> [377.114888] gem_exec-2233 7d.s2. 217080668us : __i915_request_submit: 0000:00:02.0 rcs0: fence 55:253830, current 253828
<0> [377.114949] gem_exec-2233 7d.s1. 217080670us : trace_ports: 0000:00:02.0 rcs0: submit { ccid:20 55:253830 prio 0 }
<0> [377.115024] gem_exec-2233 7..... 217080843us : i915_request_retire.part.0: 0000:00:02.0 rcs0: fence 55:253840, current 253840
<0> [377.115099] gem_exec-2233 7..... 217080864us : __i915_request_commit: 0000:00:02.0 rcs0: fence 55:253844, current 253842
<0> [377.115174] gem_exec-2233 7..... 217080984us : i915_request_retire.part.0: 0000:00:02.0 rcs0: fence 55:253848, current 253850
<0> [377.115248] gem_exec-2233 7..... 217080999us : __i915_request_commit: 0000:00:02.0 rcs0: fence 55:253852, current 253850
<0> [377.115322] gem_exec-2233 7d.s2. 217081004us : __i915_request_submit: 0000:00:02.0 rcs0: fence 55:253852, current 253850
<0> [377.115383] gem_exec-2233 7d.s1. 217081004us : execlists_submission_tasklet: 0000:00:02.0 rcs0: context:55 schedule-in, ccid:20
<0> [377.115445] gem_exec-2233 7d.s1. 217081005us : trace_ports: 0000:00:02.0 rcs0: submit { ccid:20 55:253852 prio 0 }
<0> [377.115519] gem_exec-2233 7..... 217081173us : i915_request_retire.part.0: 0000:00:02.0 rcs0: fence 55:253862, current 253862
<0> [377.115603] gem_exec-2233 7..... 217081195us : __i915_request_commit: 0000:00:02.0 rcs0: fence 55:253866, current 253864
<0> [377.115685] gem_exec-2233 7d.s2. 217081202us : __i915_request_submit: 0000:00:02.0 rcs0: fence 55:253866, current 253864
<0> [377.115753] gem_exec-2233 7d.s1. 217081203us : execlists_submission_tasklet: 0000:00:02.0 rcs0: context:55 schedule-in, ccid:20
<0> [377.115819] gem_exec-2233 7d.s1. 217081204us : trace_ports: 0000:00:02.0 rcs0: submit { ccid:20 55:253866 prio 0 }
<0> [377.115900] gem_exec-2233 7..... 217081397us : i915_request_retire.part.0: 0000:00:02.0 rcs0: fence 55:253876, current 253878
<0> [377.115981] gem_exec-2233 7..... 217081417us : __i915_request_commit: 0000:00:02.0 rcs0: fence 55:253880, current 253878
<0> [377.116061] gem_exec-2233 7d.s2. 217081424us : __i915_request_submit: 0000:00:02.0 rcs0: fence 55:253880, current 253878
<0> [377.116129] gem_exec-2233 7d.s1. 217081424us : execlists_submission_tasklet: 0000:00:02.0 rcs0: context:55 schedule-in, ccid:20
<0> [377.116196] gem_exec-2233 7d.s1. 217081425us : trace_ports: 0000:00:02.0 rcs0: submit { ccid:20 55:253880 prio 0 }
<0> [377.116276] gem_exec-2233 7..... 217081668us : i915_request_retire.part.0: 0000:00:02.0 rcs0: fence 55:253892, current 253892
<0> [377.116357] gem_exec-2233 7..... 217081686us : __i915_request_commit: 0000:00:02.0 rcs0: fence 55:253896, current 253894
<0> [377.116424] gem_exec-2233 7..s1. 217081693us : process_csb: 0000:00:02.0 rcs0: cs-irq head=0, tail=1
<0> [377.116490] gem_exec-2233 7..s1. 217081693us : process_csb: 0000:00:02.0 rcs0: csb[1]: status=0x00008000:0x03ff8000
<0> [377.116564] gem_exec-2233 7..s1. 217081694us : trace_ports: 0000:00:02.0 rcs0: completed { ccid:20 55:253894! prio 0 }
<0> [377.116637] gem_exec-2233 7d.s2. 217081695us : __i915_request_submit: 0000:00:02.0 rcs0: fence 55:253896, current 253894
<0> [377.116697] gem_exec-2233 7d.s1. 217081695us : trace_ports: 0000:00:02.0 rcs0: submit { ccid:20 55:253896 prio 0 }
<0> [377.116770] gem_exec-2233 7..... 217081871us : i915_request_retire.part.0: 0000:00:02.0 rcs0: fence 55:253904, current 253904
<0> [377.116843] gem_exec-2233 7..... 217081891us : __i915_request_commit: 0000:00:02.0 rcs0: fence 55:253908, current 253906
<0> [377.116915] gem_exec-2233 7..... 217082157us : i915_request_retire.part.0: 0000:00:02.0 rcs0: fence 55:253922, current 253922
<0> [377.116989] gem_exec-2233 7..... 217082176us : __i915_request_commit: 0000:00:02.0 rcs0: fence 55:253926, current 253924
<0> [377.117051] gem_exec-2233 7..s1. 217082183us : process_csb: 0000:00:02.0 rcs0: cs-irq head=6, tail=7
<0> [377.117112] gem_exec-2233 7..s1. 217082183us : process_csb: 0000:00:02.0 rcs0: csb[7]: status=0x00008000:0x03ff8000
<0> [377.117173] gem_exec-2233 7..s1. 217082183us : trace_ports: 0000:00:02.0 rcs0: completed { ccid:20 55:253924! prio 0 }
<0> [377.117247] gem_exec-2233 7d.s2. 217082184us : __i915_request_submit: 0000:00:02.0 rcs0: fence 55:253926, current 253924
<0> [377.117308] gem_exec-2233 7d.s1. 217082185us : trace_ports: 0000:00:02.0 rcs0: submit { ccid:20 55:253926 prio 0 }
<0> [377.117382] gem_exec-2233 7..... 217082646us : i915_request_retire.part.0: 0000:00:02.0 rcs0: fence 55:253950, current 253950
<0> [377.117456] gem_exec-2233 7..... 217082666us : __i915_request_commit: 0000:00:02.0 rcs0: fence 55:253954, current 253952
<0> [377.117535] gem_exec-2233 7..... 217082891us : i915_request_retire.part.0: 0000:00:02.0 rcs0: fence 55:253966, current 253966
<0> [377.117617] gem_exec-2233 7..... 217082910us : __i915_request_commit: 0000:00:02.0 rcs0: fence 55:253970, current 253967
<0> [377.117684] gem_exec-2233 7..s1. 217082917us : process_csb: 0000:00:02.0 rcs0: cs-irq head=2, tail=3
<0> [377.117751] gem_exec-2233 7..s1. 217082917us : process_csb: 0000:00:02.0 rcs0: csb[3]: status=0x00008000:0x03ff8000
<0> [377.117817] gem_exec-2233 7..s1. 217082917us : trace_ports: 0000:00:02.0 rcs0: completed { ccid:20 55:253968! prio 0 }
<0> [377.117899] gem_exec-2233 7d.s2. 217082918us : __i915_request_submit: 0000:00:02.0 rcs0: fence 55:253970, current 253968
<0> [377.117967] gem_exec-2233 7d.s1. 217082919us : trace_ports: 0000:00:02.0 rcs0: submit { ccid:20 55:253970 prio 0 }
<0> [377.118050] gem_exec-2233 7..... 217083117us : i915_request_retire.part.0: 0000:00:02.0 rcs0: fence 55:253980, current 253980
<0> [377.118132] gem_exec-2233 7..... 217083132us : __i915_request_commit: 0000:00:02.0 rcs0: fence 55:253984, current 253981
<0> [377.118214] gem_exec-2233 7d.s2. 217083140us : __i915_request_submit: 0000:00:02.0 rcs0: fence 55:253984, current 253982
<0> [377.118283] gem_exec-2233 7d.s1. 217083141us : trace_ports: 0000:00:02.0 rcs0: submit { ccid:20 55:253984 prio 0 }
<0> [377.118364] gem_exec-2233 7..... 217083390us : i915_request_retire.part.0: 0000:00:02.0 rcs0: fence 55:253996, current 253996
<0> [377.118445] gem_exec-2233 7..... 217083411us : __i915_request_commit: 0000:00:02.0 rcs0: fence 55:254000, current 253998
<0> [377.118526] gem_exec-2233 7d.s2. 217083419us : __i915_request_submit: 0000:00:02.0 rcs0: fence 55:254000, current 253998
<0> [377.118592] gem_exec-2233 7d.s1. 217083421us : execlists_submission_tasklet: 0000:00:02.0 rcs0: context:55 schedule-in, ccid:20
<0> [377.118653] gem_exec-2233 7d.s1. 217083422us : trace_ports: 0000:00:02.0 rcs0: submit { ccid:20 55:254000 prio 0 }
<0> [377.118726] gem_exec-2233 7..... 217083689us : i915_request_retire.part.0: 0000:00:02.0 rcs0: fence 55:254014, current 254014
<0> [377.118800] gem_exec-2233 7..... 217083709us : __i915_request_commit: 0000:00:02.0 rcs0: fence 55:254018, current 254016
<0> [377.118872] gem_exec-2233 7d.s2. 217083718us : __i915_request_submit: 0000:00:02.0 rcs0: fence 55:254018, current 254016
<0> [377.118934] gem_exec-2233 7d.s1. 217083720us : execlists_submission_tasklet: 0000:00:02.0 rcs0: context:55 schedule-in, ccid:20
<0> [377.118994] gem_exec-2233 7d.s1. 217083720us : trace_ports: 0000:00:02.0 rcs0: submit { ccid:20 55:254018 prio 0 }
<0> [377.119067] gem_exec-2233 7..... 217083992us : i915_request_retire.part.0: 0000:00:02.0 rcs0: fence 55:254030, current 254030
<0> [377.119140] gem_exec-2233 7..... 217084011us : __i915_request_commit: 0000:00:02.0 rcs0: fence 55:254034, current 254032
<0> [377.119201] gem_exec-2233 7..s1. 217084018us : process_csb: 0000:00:02.0 rcs0: cs-irq head=6, tail=7
<0> [377.119261] gem_exec-2233 7..s1. 217084019us : process_csb: 0000:00:02.0 rcs0: csb[7]: status=0x00008000:0x03ff8000
<0> [377.119322] gem_exec-2233 7..s1. 217084019us : trace_ports: 0000:00:02.0 rcs0: completed { ccid:20 55:254032! prio 0 }
<0> [377.119403] gem_exec-2233 7d.s2. 217084020us : __i915_request_submit: 0000:00:02.0 rcs0: fence 55:254034, current 254032
<0> [377.119470] gem_exec-2233 7d.s1. 217084021us : trace_ports: 0000:00:02.0 rcs0: submit { ccid:20 55:254034 prio 0 }
<0> [377.119550] gem_exec-2233 7..... 217084035us : intel_rps_boost.part.0: 0000:00:02.0 boost fence:55:3e052
<0> [377.119634] gem_exec-2233 7..... 217084393us : i915_request_retire.part.0: 0000:00:02.0 rcs0: fence 55:254052, current 254052
<0> [377.119717] gem_exec-2233 7..... 217084412us : __i915_request_commit: 0000:00:02.0 rcs0: fence 55:254056, current 254054
<0> [377.119792] gem_exec-2233 7..... 217084436us : intel_rps_boost.part.0: 0000:00:02.0 boost fence:55:3e068
<0> [377.119873] gem_exec-2233 7..... 217084631us : i915_request_retire.part.0: 0000:00:02.0 rcs0: fence 55:254066, current 254066
<0> [377.119955] gem_exec-2233 7..... 217084653us : __i915_request_commit: 0000:00:02.0 rcs0: fence 55:254070, current 254068
<0> [377.120036] gem_exec-2233 7d.s2. 217084661us : __i915_request_submit: 0000:00:02.0 rcs0: fence 55:254070, current 254068
<0> [377.120105] gem_exec-2233 7d.s1. 217084662us : execlists_submission_tasklet: 0000:00:02.0 rcs0: context:55 schedule-in, ccid:20
<0> [377.120172] gem_exec-2233 7d.s1. 217084663us : trace_ports: 0000:00:02.0 rcs0: submit { ccid:20 55:254070 prio 0 }
<0> [377.120252] gem_exec-2233 7..... 217084885us : i915_request_retire.part.0: 0000:00:02.0 rcs0: fence 55:254082, current 254082
<0> [377.120333] gem_exec-2233 7..... 217084904us : __i915_request_commit: 0000:00:02.0 rcs0: fence 55:254086, current 254084
<0> [377.120400] gem_exec-2233 7..s1. 217084911us : process_csb: 0000:00:02.0 rcs0: cs-irq head=10, tail=11
<0> [377.120467] gem_exec-2233 7..s1. 217084911us : process_csb: 0000:00:02.0 rcs0: csb[11]: status=0x00008000:0x03ff8000
<0> [377.120539] gem_exec-2233 7..s1. 217084912us : trace_ports: 0000:00:02.0 rcs0: completed { ccid:20 55:254084! prio 0 }
<0> [377.120613] gem_exec-2233 7d.s2. 217084913us : __i915_request_submit: 0000:00:02.0 rcs0: fence 55:254086, current 254084
<0> [377.120674] gem_exec-2233 7d.s1. 217084913us : trace_ports: 0000:00:02.0 rcs0: submit { ccid:20 55:254086 prio 0 }
<0> [377.120746] gem_exec-2233 7..... 217085114us : i915_request_retire.part.0: 0000:00:02.0 rcs0: fence 55:254096, current 254096
<0> [377.120820] gem_exec-2233 7..... 217085133us : __i915_request_commit: 0000:00:02.0 rcs0: fence 55:254100, current 254098
<0> [377.120881] gem_exec-2233 7..s1. 217085140us : process_csb: 0000:00:02.0 rcs0: cs-irq head=0, tail=1
<0> [377.120941] gem_exec-2233 7..s1. 217085140us : process_csb: 0000:00:02.0 rcs0: csb[1]: status=0x00008000:0x03ff8000
<0> [377.121001] gem_exec-2233 7..s1. 217085140us : trace_ports: 0000:00:02.0 rcs0: completed { ccid:20 55:254098! prio 0 }
<0> [377.121074] gem_exec-2233 7d.s2. 217085141us : __i915_request_submit: 0000:00:02.0 rcs0: fence 55:254100, current 254098
<0> [377.121134] gem_exec-2233 7d.s1. 217085142us : trace_ports: 0000:00:02.0 rcs0: submit { ccid:20 55:254100 prio 0 }
<0> [377.121207] gem_exec-2233 7..... 217085490us : i915_request_retire.part.0: 0000:00:02.0 rcs0: fence 55:254112, current 254112
<0> [377.121279] gem_exec-2233 7..... 217085506us : __i915_request_commit: 0000:00:02.0 rcs0: fence 55:254116, current 254113
<0> [377.121340] gem_exec-2233 7..s1. 217085514us : process_csb: 0000:00:02.0 rcs0: cs-irq head=4, tail=5
<0> [377.121400] gem_exec-2233 7..s1. 217085515us : process_csb: 0000:00:02.0 rcs0: csb[5]: status=0x00008000:0x03ff8000
<0> [377.121460] gem_exec-2233 7..s1. 217085515us : trace_ports: 0000:00:02.0 rcs0: completed { ccid:20 55:254114! prio 0 }
<0> [377.121546] gem_exec-2233 7d.s2. 217085516us : __i915_request_submit: 0000:00:02.0 rcs0: fence 55:254116, current 254114
<0> [377.121615] gem_exec-2233 7d.s1. 217085517us : trace_ports: 0000:00:02.0 rcs0: submit { ccid:20 55:254116 prio 0 }
<0> [377.121689] gem_exec-2233 7..... 217085532us : intel_rps_boost.part.0: 0000:00:02.0 boost fence:55:3e0a4
<0> [377.121772] gem_exec-2233 7..... 217085701us : i915_request_retire.part.0: 0000:00:02.0 rcs0: fence 55:254124, current 254124
<0> [377.121855] gem_exec-2233 7..... 217085723us : __i915_request_commit: 0000:00:02.0 rcs0: fence 55:254128, current 254126
<0> [377.121937] gem_exec-2233 7d.s2. 217085732us : __i915_request_submit: 0000:00:02.0 rcs0: fence 55:254128, current 254126
<0> [377.122005] gem_exec-2233 7d.s1. 217085733us : execlists_submission_tasklet: 0000:00:02.0 rcs0: context:55 schedule-in, ccid:20
<0> [377.122072] gem_exec-2233 7d.s1. 217085734us : trace_ports: 0000:00:02.0 rcs0: submit { ccid:20 55:254128 prio 0 }
<0> [377.122153] gem_exec-2233 7..... 217086083us : i915_request_retire.part.0: 0000:00:02.0 rcs0: fence 55:254144, current 254144
<0> [377.122234] gem_exec-2233 7..... 217086099us : __i915_request_commit: 0000:00:02.0 rcs0: fence 55:254148, current 254145
<0> [377.122301] gem_exec-2233 7..s1. 217086108us : process_csb: 0000:00:02.0 rcs0: cs-irq head=0, tail=1
<0> [377.122368] gem_exec-2233 7..s1. 217086108us : process_csb: 0000:00:02.0 rcs0: csb[1]: status=0x00008000:0x03ff8000
<0> [377.122435] gem_exec-2233 7..s1. 217086109us : trace_ports: 0000:00:02.0 rcs0: completed { ccid:20 55:254146! prio 0 }
<0> [377.122520] gem_exec-2233 7d.s2. 217086109us : __i915_request_submit: 0000:00:02.0 rcs0: fence 55:254148, current 254146
<0> [377.122587] gem_exec-2233 7d.s1. 217086110us : trace_ports: 0000:00:02.0 rcs0: submit { ccid:20 55:254148 prio 0 }
<0> [377.122662] gem_exec-2233 7..... 217086338us : i915_request_retire.part.0: 0000:00:02.0 rcs0: fence 55:254160, current 254160
<0> [377.122737] gem_exec-2233 7..... 217086362us : __i915_request_commit: 0000:00:02.0 rcs0: fence 55:254164, current 254162
<0> [377.122812] gem_exec-2233 7d.s2. 217086371us : __i915_request_submit: 0000:00:02.0 rcs0: fence 55:254164, current 254162
<0> [377.122874] gem_exec-2233 7d.s1. 217086372us : execlists_submission_tasklet: 0000:00:02.0 rcs0: context:55 schedule-in, ccid:20
<0> [377.122935] gem_exec-2233 7d.s1. 217086373us : trace_ports: 0000:00:02.0 rcs0: submit { ccid:20 55:254164 prio 0 }
<0> [377.123008] gem_exec-2233 7..... 217086584us : i915_request_retire.part.0: 0000:00:02.0 rcs0: fence 55:254176, current 254176
<0> [377.123081] gem_exec-2233 7..... 217086603us : __i915_request_commit: 0000:00:02.0 rcs0: fence 55:254180, current 254178
<0> [377.123142] gem_exec-2233 7..s1. 217086610us : process_csb: 0000:00:02.0 rcs0: cs-irq head=8, tail=9
<0> [377.123203] gem_exec-2233 7..s1. 217086611us : process_csb: 0000:00:02.0 rcs0: csb[9]: status=0x00008000:0x03ff8000
<0> [377.123263] gem_exec-2233 7..s1. 217086611us : trace_ports: 0000:00:02.0 rcs0: completed { ccid:20 55:254178! prio 0 }
<0> [377.123336] gem_exec-2233 7d.s2. 217086612us : __i915_request_submit: 0000:00:02.0 rcs0: fence 55:254180, current 254178
<0> [377.123396] gem_exec-2233 7d.s1. 217086612us : trace_ports: 0000:00:02.0 rcs0: submit { ccid:20 55:254180 prio 0 }
<0> [377.123469] gem_exec-2233 7..... 217087012us : i915_request_retire.part.0: 0000:00:02.0 rcs0: fence 55:254200, current 254200
<0> [377.123546] gem_exec-2233 7..... 217087034us : __i915_request_commit: 0000:00:02.0 rcs0: fence 55:254204, current 254202
<0> [377.123627] gem_exec-2233 7..... 217087206us : i915_request_retire.part.0: 0000:00:02.0 rcs0: fence 55:254212, current 254212
<0> [377.123700] gem_exec-2233 7..... 217087220us : __i915_request_commit: 0000:00:02.0 rcs0: fence 55:254216, current 254213
<0> [377.123761] gem_exec-2233 7..s1. 217087228us : process_csb: 0000:00:02.0 rcs0: cs-irq head=8, tail=9
<0> [377.123821] gem_exec-2233 7..s1. 217087228us : process_csb: 0000:00:02.0 rcs0: csb[9]: status=0x00008000:0x03ff8000
<0> [377.123881] gem_exec-2233 7..s1. 217087229us : trace_ports: 0000:00:02.0 rcs0: completed { ccid:20 55:254214! prio 0 }
<0> [377.123954] gem_exec-2233 7d.s2. 217087230us : __i915_request_submit: 0000:00:02.0 rcs0: fence 55:254216, current 254214
<0> [377.124015] gem_exec-2233 7d.s1. 217087231us : trace_ports: 0000:00:02.0 rcs0: submit { ccid:20 55:254216 prio 0 }
<0> [377.124087] gem_exec-2233 7..... 217087456us : i915_request_retire.part.0: 0000:00:02.0 rcs0: fence 55:254224, current 254224
<0> [377.124160] gem_exec-2233 7..... 217087477us : __i915_request_commit: 0000:00:02.0 rcs0: fence 55:254228, current 254226
<0> [377.124233] gem_exec-2233 7d.s2. 217087487us : __i915_request_submit: 0000:00:02.0 rcs0: fence 55:254228, current 254226
<0> [377.124294] gem_exec-2233 7d.s1. 217087488us : execlists_submission_tasklet: 0000:00:02.0 rcs0: context:55 schedule-in, ccid:20
<0> [377.124354] gem_exec-2233 7d.s1. 217087489us : trace_ports: 0000:00:02.0 rcs0: submit { ccid:20 55:254228 prio 0 }
<0> [377.124428] gem_exec-2233 7..... 217087694us : i915_request_retire.part.0: 0000:00:02.0 rcs0: fence 55:254238, current 254238
<0> [377.124514] gem_exec-2233 7..... 217087710us : __i915_request_commit: 0000:00:02.0 rcs0: fence 55:254242, current 254239
<0> [377.124585] gem_exec-2233 7..s1. 217087719us : process_csb: 0000:00:02.0 rcs0: cs-irq head=10, tail=11
<0> [377.124647] gem_exec-2233 7..s1. 217087719us : process_csb: 0000:00:02.0 rcs0: csb[11]: status=0x00008000:0x03ff8000
<0> [377.124708] gem_exec-2233 7..s1. 217087720us : trace_ports: 0000:00:02.0 rcs0: completed { ccid:20 55:254240! prio 0 }
<0> [377.124782] gem_exec-2233 7d.s2. 217087721us : __i915_request_submit: 0000:00:02.0 rcs0: fence 55:254242, current 254240
<0> [377.124843] gem_exec-2233 7d.s1. 217087722us : trace_ports: 0000:00:02.0 rcs0: submit { ccid:20 55:254242 prio 0 }
<0> [377.124917] gem_exec-2233 7..... 217087918us : i915_request_retire.part.0: 0000:00:02.0 rcs0: fence 55:254252, current 254252
<0> [377.124992] gem_exec-2233 7..... 217087939us : __i915_request_commit: 0000:00:02.0 rcs0: fence 55:254256, current 254254
<0> [377.125052] gem_exec-2233 7..s1. 217087947us : process_csb: 0000:00:02.0 rcs0: cs-irq head=0, tail=1
<0> [377.125112] gem_exec-2233 7..s1. 217087947us : process_csb: 0000:00:02.0 rcs0: csb[1]: status=0x00008000:0x03ff8000
<0> [377.125173] gem_exec-2233 7..s1. 217087947us : trace_ports: 0000:00:02.0 rcs0: completed { ccid:20 55:254254! prio 0 }
<0> [377.125246] gem_exec-2233 7d.s2. 217087948us : __i915_request_submit: 0000:00:02.0 rcs0: fence 55:254256, current 254254
<0> [377.125306] gem_exec-2233 7d.s1. 217087949us : trace_ports: 0000:00:02.0 rcs0: submit { ccid:20 55:254256 prio 0 }
<0> [377.125380] gem_exec-2233 7..... 217088096us : i915_request_retire.part.0: 0000:00:02.0 rcs0: fence 55:254262, current 254263
<0> [377.125453] gem_exec-2233 7..... 217088115us : __i915_request_commit: 0000:00:02.0 rcs0: fence 55:254266, current 254264
<0> [377.125538] gem_exec-2233 7d.s2. 217088120us : __i915_request_submit: 0000:00:02.0 rcs0: fence 55:254266, current 254264
<0> [377.125608] gem_exec-2233 7d.s1. 217088121us : execlists_submission_tasklet: 0000:00:02.0 rcs0: context:55 schedule-in, ccid:20
<0> [377.125668] gem_exec-2233 7d.s1. 217088121us : trace_ports: 0000:00:02.0 rcs0: submit { ccid:20 55:254266 prio 0 }
<0> [377.125741] gem_exec-2233 7..... 217088319us : i915_request_retire.part.0: 0000:00:02.0 rcs0: fence 55:254276, current 254276
<0> [377.125814] gem_exec-2233 7..... 217088333us : __i915_request_commit: 0000:00:02.0 rcs0: fence 55:254280, current 254277
<0> [377.125875] gem_exec-2233 7..s1. 217088342us : process_csb: 0000:00:02.0 rcs0: cs-irq head=0, tail=1
<0> [377.125935] gem_exec-2233 7..s1. 217088343us : process_csb: 0000:00:02.0 rcs0: csb[1]: status=0x00008000:0x03ff8000
<0> [377.125995] gem_exec-2233 7..s1. 217088344us : trace_ports: 0000:00:02.0 rcs0: completed { ccid:20 55:254278! prio 0 }
<0> [377.126069] gem_exec-2233 7d.s2. 217088344us : __i915_request_submit: 0000:00:02.0 rcs0: fence 55:254280, current 254278
<0> [377.126131] gem_exec-2233 7d.s1. 217088345us : trace_ports: 0000:00:02.0 rcs0: submit { ccid:20 55:254280 prio 0 }
<0> [377.126205] gem_exec-2233 7..... 217088448us : i915_request_retire.part.0: 0000:00:02.0 rcs0: fence 55:254284, current 254285
<0> [377.126280] gem_exec-2233 7..... 217088467us : __i915_request_commit: 0000:00:02.0 rcs0: fence 55:254288, current 254286
<0> [377.126355] gem_exec-2233 7d.s2. 217088476us : __i915_request_submit: 0000:00:02.0 rcs0: fence 55:254288, current 254286
<0> [377.126416] gem_exec-2233 7d.s1. 217088477us : execlists_submission_tasklet: 0000:00:02.0 rcs0: context:55 schedule-in, ccid:20
<0> [377.126477] gem_exec-2233 7d.s1. 217088478us : trace_ports: 0000:00:02.0 rcs0: submit { ccid:20 55:254288 prio 0 }
<0> [377.126545] gem_exec-2233 7b.... 217088491us : process_csb: 0000:00:02.0 rcs0: cs-irq head=9, tail=10
<0> [377.126617] gem_exec-2233 7b.... 217088491us : process_csb: 0000:00:02.0 rcs0: csb[10]: status=0x03ff8000:0x00008001
<0> [377.126682] gem_exec-2233 7b.... 217088491us : trace_ports: 0000:00:02.0 rcs0: promote { ccid:20 55:254288 prio 0 }
<0> [377.126755] gem_exec-2233 7..... 217088658us : __i915_request_commit: 0000:00:02.0 rcs0: fence 55:254298, current 254295
<0> [377.126816] gem_exec-2233 7..s1. 217088667us : process_csb: 0000:00:02.0 rcs0: cs-irq head=6, tail=7
<0> [377.126876] gem_exec-2233 7..s1. 217088667us : process_csb: 0000:00:02.0 rcs0: csb[7]: status=0x00008000:0x03ff8000
<0> [377.126936] gem_exec-2233 7..s1. 217088668us : trace_ports: 0000:00:02.0 rcs0: completed { ccid:20 55:254296! prio 0 }
<0> [377.127009] gem_exec-2233 7d.s2. 217088669us : __i915_request_submit: 0000:00:02.0 rcs0: fence 55:254298, current 254296
<0> [377.127069] gem_exec-2233 7d.s1. 217088670us : trace_ports: 0000:00:02.0 rcs0: submit { ccid:20 55:254298 prio 0 }
<0> [377.127141] gem_exec-2233 7..... 217088788us : i915_request_retire.part.0: 0000:00:02.0 rcs0: fence 55:254302, current 254303
<0> [377.127215] gem_exec-2233 7..... 217088806us : __i915_request_commit: 0000:00:02.0 rcs0: fence 55:254306, current 254304
<0> [377.127287] gem_exec-2233 7d.s2. 217088815us : __i915_request_submit: 0000:00:02.0 rcs0: fence 55:254306, current 254304
<0> [377.127348] gem_exec-2233 7d.s1. 217088816us : execlists_submission_tasklet: 0000:00:02.0 rcs0: context:55 schedule-in, ccid:20
<0> [377.127408] gem_exec-2233 7d.s1. 217088817us : trace_ports: 0000:00:02.0 rcs0: submit { ccid:20 55:254306 prio 0 }
<0> [377.127481] gem_exec-2233 7..... 217088961us : i915_request_retire.part.0: 0000:00:02.0 rcs0: fence 55:254312, current 254312
<0> [377.127563] gem_exec-2233 7..... 217088975us : __i915_request_commit: 0000:00:02.0 rcs0: fence 55:254316, current 254313
<0> [377.127630] gem_exec-2233 7..s1. 217088984us : process_csb: 0000:00:02.0 rcs0: cs-irq head=0, tail=1
<0> [377.127697] gem_exec-2233 7..s1. 217088984us : process_csb: 0000:00:02.0 rcs0: csb[1]: status=0x00008000:0x03ff8000
<7> [377.127694] i915 0000:00:02.0: [drm:drm_mode_rmfb_work_fn] Removing [FB:637] from all active usage due to RMFB ioctl
<7> [377.127743] i915 0000:00:02.0: [drm:atomic_remove_fb] Disabling [PLANE:34:plane 1A] because [FB:637] is removed
<0> [377.127764] gem_exec-2233 7..s1. 217088985us : trace_ports: 0000:00:02.0 rcs0: completed { ccid:20 55:254314! prio 0 }
<0> [377.127847] gem_exec-2233 7d.s2. 217088986us : __i915_request_submit: 0000:00:02.0 rcs0: fence 55:254316, current 254314
<7> [377.127783] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] [PLANE:34:plane 1A] ddb ( 0 - 1993) -> ( 0 - 0), size 1993 -> 0
<0> [377.127914] gem_exec-2233 7d.s1. 217088987us : trace_ports: 0000:00:02.0 rcs0: submit { ccid:20 55:254316 prio 0 }
<0> [377.127998] gem_exec-2233 7..... 217089079us : i915_request_retire.part.0: 0000:00:02.0 rcs0: fence 55:254318, current 254319
<7> [377.128063] i915 0000:00:02.0: [drm:skl_print_plane_changes [i915]] [PLANE:34:plane 1A] level *wm0,*wm1,*wm2,*wm3,*wm4,*wm5,*wm6,*wm7,*twm, swm, stwm -> wm0, wm1, wm2, wm3, wm4, wm5, wm6, wm7, twm, swm, stwm
<0> [377.128148] gem_exec-2233 7..... 217089097us : __i915_request_commit: 0000:00:02.0 rcs0: fence 55:254322, current 254320
<0> [377.128231] gem_exec-2233 7d.s2. 217089105us : __i915_request_submit: 0000:00:02.0 rcs0: fence 55:254322, current 254320
<0> [377.128299] gem_exec-2233 7d.s1. 217089106us : execlists_submission_tasklet: 0000:00:02.0 rcs0: context:55 schedule-in, ccid:20
<7> [377.128224] i915 0000:00:02.0: [drm:skl_print_plane_changes [i915]] [PLANE:34:plane 1A] lines 1, 8, 8, 8, 8, 11, 16, 16, 0, 0, 0 -> 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0
<0> [377.128366] gem_exec-2233 7d.s1. 217089107us : trace_ports: 0000:00:02.0 rcs0: submit { ccid:20 55:254322 prio 0 }
<0> [377.128448] gem_exec-2233 7..... 217089377us : __i915_request_commit: 0000:00:02.0 rcs0: fence 55:254338, current 254332
<7> [377.128382] i915 0000:00:02.0: [drm:skl_print_plane_changes [i915]] [PLANE:34:plane 1A] blocks 16, 129, 129, 129, 129, 177, 257, 257, 30, 0, 0 -> 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0
<0> [377.128529] gem_exec-2233 7..... 217089673us : i915_request_retire.part.0: 0000:00:02.0 rcs0: fence 55:254336, current 254346
<0> [377.128619] gem_exec-2233 7..... 217089697us : __i915_request_commit: 0000:00:02.0 rcs0: fence 55:254350, current 254348
<7> [377.128562] i915 0000:00:02.0: [drm:skl_print_plane_changes [i915]] [PLANE:34:plane 1A] min_ddb 19, 143, 143, 143, 143, 196, 284, 284, 31, 0, 0 -> 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0
<0> [377.128711] gem_exec-2233 7..... 217089706us : i915_request_retire.part.0: 0000:00:02.0 rcs0: fence 55:254338, current 254348
<0> [377.128792] gem_exec-2233 7..... 217089708us : i915_request_retire.part.0: 0000:00:02.0 rcs0: fence 55:254340, current 254348
<7> [377.128767] i915 0000:00:02.0: [drm:intel_bw_atomic_check [i915]] [CRTC:170:pipe A] data rate 0 num active planes 0
<0> [377.128876] gem_exec-2233 7..... 217089710us : i915_request_retire.part.0: 0000:00:02.0 rcs0: fence 55:254342, current 254348
<0> [377.128958] gem_exec-2233 7..... 217089712us : i915_request_retire.part.0: 0000:00:02.0 rcs0: fence 55:254344, current 254348
<0> [377.129040] gem_exec-2233 7..... 217089713us : i915_request_retire.part.0: 0000:00:02.0 rcs0: fence 55:254346, current 254348
<7> [377.128995] i915 0000:00:02.0: [drm:intel_bw_atomic_check [i915]] QGV point 0: max bw 14993 required 0
<0> [377.129123] gem_exec-2233 7..... 217089927us : i915_request_retire.part.0: 0000:00:02.0 rcs0: fence 55:254360, current 254360
<0> [377.129207] gem_exec-2233 7..... 217089951us : __i915_request_commit: 0000:00:02.0 rcs0: fence 55:254364, current 254362
<0> [377.129287] gem_exec-2233 7d.s2. 217089960us : __i915_request_submit: 0000:00:02.0 rcs0: fence 55:254364, current 254362
<0> [377.129355] gem_exec-2233 7d.s1. 217089962us : execlists_submission_tasklet: 0000:00:02.0 rcs0: context:55 schedule-in, ccid:20
<0> [377.129422] gem_exec-2233 7d.s1. 217089963us : trace_ports: 0000:00:02.0 rcs0: submit { ccid:20 55:254364 prio 0 }
<0> [377.129506] gem_exec-2233 7..... 217090159us : i915_request_retire.part.0: 0000:00:02.0 rcs0: fence 55:254372, current 254372
<0> [377.129591] gem_exec-2233 7..... 217090180us : __i915_request_commit: 0000:00:02.0 rcs0: fence 55:254376, current 254374
<0> [377.129673] gem_exec-2233 7..... 217090398us : i915_request_retire.part.0: 0000:00:02.0 rcs0: fence 55:254384, current 254384
<0> [377.129755] gem_exec-2233 7..... 217090419us : __i915_request_commit: 0000:00:02.0 rcs0: fence 55:254388, current 254386
<0> [377.129837] gem_exec-2233 7..... 217090588us : i915_request_retire.part.0: 0000:00:02.0 rcs0: fence 55:254396, current 254396
<0> [377.129918] gem_exec-2233 7..... 217090608us : __i915_request_commit: 0000:00:02.0 rcs0: fence 55:254400, current 254398
<0> [377.129999] gem_exec-2233 7..... 217090845us : i915_request_retire.part.0: 0000:00:02.0 rcs0: fence 55:254412, current 254412
<0> [377.130080] gem_exec-2233 7..... 217090866us : __i915_request_commit: 0000:00:02.0 rcs0: fence 55:254416, current 254414
<0> [377.130160] gem_exec-2233 7..... 217091141us : i915_request_retire.part.0: 0000:00:02.0 rcs0: fence 55:254430, current 254430
<0> [377.130240] gem_exec-2233 7..... 217091161us : __i915_request_commit: 0000:00:02.0 rcs0: fence 55:254434, current 254432
<0> [377.130320] gem_exec-2233 7..... 217091600us : i915_request_retire.part.0: 0000:00:02.0 rcs0: fence 55:254454, current 254454
<0> [377.130401] gem_exec-2233 7..... 217091621us : __i915_request_commit: 0000:00:02.0 rcs0: fence 55:254458, current 254456
<0> [377.130469] gem_exec-2233 7..s1. 217091629us : process_csb: 0000:00:02.0 rcs0: cs-irq head=11, tail=0
<0> [377.130539] gem_exec-2233 7..s1. 217091629us : process_csb: 0000:00:02.0 rcs0: csb[0]: status=0x00008000:0x03ff8000
<0> [377.130607] gem_exec-2233 7..s1. 217091630us : trace_ports: 0000:00:02.0 rcs0: completed { ccid:20 55:254456! prio 0 }
<0> [377.130688] gem_exec-2233 7d.s2. 217091631us : __i915_request_submit: 0000:00:02.0 rcs0: fence 55:254458, current 254456
<0> [377.130764] gem_exec-2233 7d.s1. 217091632us : trace_ports: 0000:00:02.0 rcs0: submit { ccid:20 55:254458 prio 0 }
<0> [377.130845] gem_exec-2233 7..... 217091905us : i915_request_retire.part.0: 0000:00:02.0 rcs0: fence 55:254472, current 254474
<0> [377.130925] gem_exec-2233 7..... 217091928us : __i915_request_commit: 0000:00:02.0 rcs0: fence 55:254476, current 254474
<0> [377.131005] gem_exec-2233 7d.s2. 217091937us : __i915_request_submit: 0000:00:02.0 rcs0: fence 55:254476, current 254474
<0> [377.131073] gem_exec-2233 7d.s1. 217091938us : execlists_submission_tasklet: 0000:00:02.0 rcs0: context:55 schedule-in, ccid:20
<0> [377.131140] gem_exec-2233 7d.s1. 217091939us : trace_ports: 0000:00:02.0 rcs0: submit { ccid:20 55:254476 prio 0 }
<0> [377.131222] gem_exec-2233 7..... 217092171us : i915_request_retire.part.0: 0000:00:02.0 rcs0: fence 55:254488, current 254488
<0> [377.131306] gem_exec-2233 7..... 217092195us : __i915_request_commit: 0000:00:02.0 rcs0: fence 55:254492, current 254490
<0> [377.131388] gem_exec-2233 7d.s2. 217092203us : __i915_request_submit: 0000:00:02.0 rcs0: fence 55:254492, current 254490
<0> [377.131456] gem_exec-2233 7d.s1. 217092204us : execlists_submission_tasklet: 0000:00:02.0 rcs0: context:55 schedule-in, ccid:20
<0> [377.131526] gem_exec-2233 7d.s1. 217092204us : trace_ports: 0000:00:02.0 rcs0: submit { ccid:20 55:254492 prio 0 }
<0> [377.131609] gem_exec-2233 7..... 217092344us : i915_request_retire.part.0: 0000:00:02.0 rcs0: fence 55:254498, current 254498
<0> [377.131691] gem_exec-2233 7..... 217092363us : __i915_request_commit: 0000:00:02.0 rcs0: fence 55:254502, current 254500
<0> [377.131772] gem_exec-2233 7..... 217092892us : i915_request_retire.part.0: 0000:00:02.0 rcs0: fence 55:254528, current 254528
<0> [377.131853] gem_exec-2233 7..... 217092913us : __i915_request_commit: 0000:00:02.0 rcs0: fence 55:254532, current 254530
<0> [377.131934] gem_exec-2233 7..... 217093038us : i915_request_retire.part.0: 0000:00:02.0 rcs0: fence 55:254536, current 254536
<0> [377.132015] gem_exec-2233 7..... 217093055us : __i915_request_commit: 0000:00:02.0 rcs0: fence 55:254540, current 254537
<0> [377.132083] gem_exec-2233 7..s1. 217093062us : process_csb: 0000:00:02.0 rcs0: cs-irq head=9, tail=10
<0> [377.132150] gem_exec-2233 7..s1. 217093063us : process_csb: 0000:00:02.0 rcs0: csb[10]: status=0x00008000:0x03ff8000
<0> [377.132216] gem_exec-2233 7..s1. 217093063us : trace_ports: 0000:00:02.0 rcs0: completed { ccid:20 55:254538! prio 0 }
<0> [377.132296] gem_exec-2233 7d.s2. 217093064us : __i915_request_submit: 0000:00:02.0 rcs0: fence 55:254540, current 254538
<0> [377.132363] gem_exec-2233 7d.s1. 217093066us : trace_ports: 0000:00:02.0 rcs0: submit { ccid:20 55:254540 prio 0 }
<0> [377.132436] gem_exec-2233 7..... 217093077us : intel_rps_boost.part.0: 0000:00:02.0 boost fence:55:3e24c
<0> [377.132520] gem_exec-2233 7..... 217093242us : i915_request_retire.part.0: 0000:00:02.0 rcs0: fence 55:254548, current 254548
<0> [377.132601] gem_exec-2233 7..... 217093264us : __i915_request_commit: 0000:00:02.0 rcs0: fence 55:254552, current 254550
<0> [377.132682] gem_exec-2233 7d.s2. 217093278us : __i915_request_submit: 0000:00:02.0 rcs0: fence 55:254552, current 254550
<0> [377.132750] gem_exec-2233 7d.s1. 217093279us : execlists_submission_tasklet: 0000:00:02.0 rcs0: context:55 schedule-in, ccid:20
<0> [377.132825] gem_exec-2233 7d.s1. 217093280us : trace_ports: 0000:00:02.0 rcs0: submit { ccid:20 55:254552 prio 0 }
<0> [377.132908] gem_exec-2233 7..... 217093538us : i915_request_retire.part.0: 0000:00:02.0 rcs0: fence 55:254562, current 254562
<0> [377.132991] gem_exec-2233 7..... 217093557us : __i915_request_commit: 0000:00:02.0 rcs0: fence 55:254568, current 254564
<0> [377.133074] gem_exec-2233 7d.s2. 217093567us : __i915_request_submit: 0000:00:02.0 rcs0: fence 55:254568, current 254566
<0> [377.133142] gem_exec-2233 7d.s1. 217093568us : trace_ports: 0000:00:02.0 rcs0: submit { ccid:20 55:254568 prio 0 }
<0> [377.133224] gem_exec-2233 7..... 217093570us : i915_request_retire.part.0: 0000:00:02.0 rcs0: fence 55:254564, current 254566
<0> [377.133306] gem_exec-2233 7..... 217093703us : i915_request_retire.part.0: 0000:00:02.0 rcs0: fence 55:254574, current 254574
<0> [377.133387] gem_exec-2233 7..... 217093726us : __i915_request_commit: 0000:00:02.0 rcs0: fence 55:254578, current 254576
<0> [377.133468] gem_exec-2233 7d.s2. 217093734us : __i915_request_submit: 0000:00:02.0 rcs0: fence 55:254578, current 254576
<0> [377.133542] gem_exec-2233 7d.s1. 217093735us : execlists_submission_tasklet: 0000:00:02.0 rcs0: context:55 schedule-in, ccid:20
<0> [377.133611] gem_exec-2233 7d.s1. 217093735us : trace_ports: 0000:00:02.0 rcs0: submit { ccid:20 55:254578 prio 0 }
<0> [377.133692] gem_exec-2233 7..... 217093980us : i915_request_retire.part.0: 0000:00:02.0 rcs0: fence 55:254592, current 254592
<0> [377.133773] gem_exec-2233 7..... 217093997us : __i915_request_commit: 0000:00:02.0 rcs0: fence 55:254596, current 254593
<0> [377.133841] gem_exec-2233 7..s1. 217094004us : process_csb: 0000:00:02.0 rcs0: cs-irq head=9, tail=10
<0> [377.133908] gem_exec-2233 7..s1. 217094004us : process_csb: 0000:00:02.0 rcs0: csb[10]: status=0x00008000:0x03ff8000
<0> [377.133974] gem_exec-2233 7..s1. 217094005us : trace_ports: 0000:00:02.0 rcs0: completed { ccid:20 55:254594! prio 0 }
<0> [377.134055] gem_exec-2233 7d.s2. 217094006us : __i915_request_submit: 0000:00:02.0 rcs0: fence 55:254596, current 254594
<0> [377.134122] gem_exec-2233 7d.s1. 217094007us : trace_ports: 0000:00:02.0 rcs0: submit { ccid:20 55:254596 prio 0 }
<0> [377.134202] gem_exec-2233 7..... 217094195us : i915_request_retire.part.0: 0000:00:02.0 rcs0: fence 55:254604, current 254604
<0> [377.134283] gem_exec-2233 7..... 217094215us : __i915_request_commit: 0000:00:02.0 rcs0: fence 55:254608, current 254606
<0> [377.134363] gem_exec-2233 7..... 217094549us : i915_request_retire.part.0: 0000:00:02.0 rcs0: fence 55:254620, current 254620
<0> [377.134444] gem_exec-2233 7..... 217094564us : __i915_request_commit: 0000:00:02.0 rcs0: fence 55:254624, current 254621
<0> [377.134516] gem_exec-2233 7..s1. 217094573us : process_csb: 0000:00:02.0 rcs0: cs-irq head=1, tail=2
<0> [377.134583] gem_exec-2233 7..s1. 217094573us : process_csb: 0000:00:02.0 rcs0: csb[2]: status=0x00008000:0x03ff8000
<0> [377.134650] gem_exec-2233 7..s1. 217094574us : trace_ports: 0000:00:02.0 rcs0: completed { ccid:20 55:254622! prio 0 }
<0> [377.134732] gem_exec-2233 7d.s2. 217094575us : __i915_request_submit: 0000:00:02.0 rcs0: fence 55:254624, current 254622
<0> [377.134800] gem_exec-2233 7d.s1. 217094576us : trace_ports: 0000:00:02.0 rcs0: submit { ccid:20 55:254624 prio 0 }
<0> [377.134888] gem_exec-2233 7..... 217094795us : i915_request_retire.part.0: 0000:00:02.0 rcs0: fence 55:254634, current 254634
<0> [377.134971] gem_exec-2233 7..... 217094815us : __i915_request_commit: 0000:00:02.0 rcs0: fence 55:254638, current 254636
<0> [377.135053] gem_exec-2233 7..... 217095103us : i915_request_retire.part.0: 0000:00:02.0 rcs0: fence 55:254652, current 254652
<0> [377.135135] gem_exec-2233 7..... 217095120us : __i915_request_commit: 0000:00:02.0 rcs0: fence 55:254656, current 254653
<0> [377.135203] gem_exec-2233 7..s1. 217095128us : process_csb: 0000:00:02.0 rcs0: cs-irq head=9, tail=10
<0> [377.135270] gem_exec-2233 7..s1. 217095128us : process_csb: 0000:00:02.0 rcs0: csb[10]: status=0x00008000:0x03ff8000
<0> [377.135337] gem_exec-2233 7..s1. 217095129us : trace_ports: 0000:00:02.0 rcs0: completed { ccid:20 55:254654! prio 0 }
<0> [377.135419] gem_exec-2233 7d.s2. 217095130us : __i915_request_submit: 0000:00:02.0 rcs0: fence 55:254656, current 254654
<0> [377.135490] gem_exec-2233 7d.s1. 217095131us : trace_ports: 0000:00:02.0 rcs0: submit { ccid:20 55:254656 prio 0 }
<0> [377.135573] gem_exec-2233 7..... 217095404us : i915_request_retire.part.0: 0000:00:02.0 rcs0: fence 55:254668, current 254668
<0> [377.135656] gem_exec-2233 7..... 217095426us : __i915_request_commit: 0000:00:02.0 rcs0: fence 55:254672, current 254670
<0> [377.135737] gem_exec-2233 7d.s2. 217095435us : __i915_request_submit: 0000:00:02.0 rcs0: fence 55:254672, current 254670
<0> [377.135805] gem_exec-2233 7d.s1. 217095436us : execlists_submission_tasklet: 0000:00:02.0 rcs0: context:55 schedule-in, ccid:20
<0> [377.135872] gem_exec-2233 7d.s1. 217095437us : trace_ports: 0000:00:02.0 rcs0: submit { ccid:20 55:254672 prio 0 }
<0> [377.135953] gem_exec-2233 7..... 217095785us : i915_request_retire.part.0: 0000:00:02.0 rcs0: fence 55:254690, current 254690
<0> [377.136035] gem_exec-2233 7..... 217095803us : __i915_request_commit: 0000:00:02.0 rcs0: fence 55:254694, current 254691
<0> [377.136105] gem_exec-2233 7..s1. 217095810us : process_csb: 0000:00:02.0 rcs0: cs-irq head=11, tail=0
<7> [377.135992] i915 0000:00:02.0: [drm:__intel_fbc_disable [i915]] Disabling FBC on [PLANE:34:plane 1A]
<0> [377.136172] gem_exec-2233 7..s1. 217095811us : process_csb: 0000:00:02.0 rcs0: csb[0]: status=0x00008000:0x03ff8000
<0> [377.136241] gem_exec-2233 7..s1. 217095811us : trace_ports: 0000:00:02.0 rcs0: completed { ccid:20 55:254692! prio 0 }
<0> [377.136321] gem_exec-2233 7d.s2. 217095812us : __i915_request_submit: 0000:00:02.0 rcs0: fence 55:254694, current 254692
<0> [377.136464] gem_exec-2233 7d.s1. 217095813us : trace_ports: 0000:00:02.0 rcs0: submit { ccid:20 55:254694 prio 0 }
<0> [377.136553] gem_exec-2233 7..... 217096779us : i915_request_retire.part.0: 0000:00:02.0 rcs0: fence 55:254746, current 254746
<0> [377.136635] gem_exec-2233 7..... 217096799us : __i915_request_commit: 0000:00:02.0 rcs0: fence 55:254750, current 254748
<0> [377.136716] gem_exec-2233 7..... 217097039us : i915_request_retire.part.0: 0000:00:02.0 rcs0: fence 55:254762, current 254762
<0> [377.136798] gem_exec-2233 7..... 217097059us : __i915_request_commit: 0000:00:02.0 rcs0: fence 55:254766, current 254764
<0> [377.136878] gem_exec-2233 7..... 217097331us : i915_request_retire.part.0: 0000:00:02.0 rcs0: fence 55:254778, current 254778
<0> [377.136966] gem_exec-2233 7..... 217097352us : __i915_request_commit: 0000:00:02.0 rcs0: fence 55:254782, current 254780
<0> [377.137047] gem_exec-2233 7..... 217097552us : i915_request_retire.part.0: 0000:00:02.0 rcs0: fence 55:254792, current 254794
<0> [377.137127] gem_exec-2233 7..... 217097573us : __i915_request_commit: 0000:00:02.0 rcs0: fence 55:254796, current 254794
<0> [377.137208] gem_exec-2233 7d.s2. 217097580us : __i915_request_submit: 0000:00:02.0 rcs0: fence 55:254796, current 254794
<0> [377.137276] gem_exec-2233 7d.s1. 217097581us : execlists_submission_tasklet: 0000:00:02.0 rcs0: context:55 schedule-in, ccid:20
<0> [377.137343] gem_exec-2233 7d.s1. 217097582us : trace_ports: 0000:00:02.0 rcs0: submit { ccid:20 55:254796 prio 0 }
<0> [377.137424] gem_exec-2233 7..... 217097849us : i915_request_retire.part.0: 0000:00:02.0 rcs0: fence 55:254810, current 254810
<0> [377.137512] gem_exec-2233 7..... 217097869us : __i915_request_commit: 0000:00:02.0 rcs0: fence 55:254814, current 254812
<0> [377.137596] gem_exec-2233 7..... 217098215us : i915_request_retire.part.0: 0000:00:02.0 rcs0: fence 55:254830, current 254830
<0> [377.137679] gem_exec-2233 7..... 217098230us : __i915_request_commit: 0000:00:02.0 rcs0: fence 55:254834, current 254831
<0> [377.137748] gem_exec-2233 7..s1. 217098239us : process_csb: 0000:00:02.0 rcs0: cs-irq head=7, tail=8
<0> [377.137815] gem_exec-2233 7..s1. 217098239us : process_csb: 0000:00:02.0 rcs0: csb[8]: status=0x00008000:0x03ff8000
<0> [377.137883] gem_exec-2233 7..s1. 217098240us : trace_ports: 0000:00:02.0 rcs0: completed { ccid:20 55:254832! prio 0 }
<0> [377.137964] gem_exec-2233 7d.s2. 217098241us : __i915_request_submit: 0000:00:02.0 rcs0: fence 55:254834, current 254832
<0> [377.138031] gem_exec-2233 7d.s1. 217098242us : trace_ports: 0000:00:02.0 rcs0: submit { ccid:20 55:254834 prio 0 }
<0> [377.138112] gem_exec-2233 7..... 217098477us : i915_request_retire.part.0: 0000:00:02.0 rcs0: fence 55:254846, current 254846
<0> [377.138194] gem_exec-2233 7..... 217098498us : __i915_request_commit: 0000:00:02.0 rcs0: fence 55:254850, current 254848
<0> [377.138274] gem_exec-2233 7..... 217098681us : i915_request_retire.part.0: 0000:00:02.0 rcs0: fence 55:254858, current 254860
<0> [377.138355] gem_exec-2233 7..... 217098701us : __i915_request_commit: 0000:00:02.0 rcs0: fence 55:254862, current 254860
<0> [377.138436] gem_exec-2233 7d.s2. 217098705us : __i915_request_submit: 0000:00:02.0 rcs0: fence 55:254862, current 254860
<0> [377.138506] gem_exec-2233 7d.s1. 217098706us : execlists_submission_tasklet: 0000:00:02.0 rcs0: context:55 schedule-in, ccid:20
<0> [377.138573] gem_exec-2233 7d.s1. 217098707us : trace_ports: 0000:00:02.0 rcs0: submit { ccid:20 55:254862 prio 0 }
<0> [377.138654] gem_exec-2233 7..... 217098943us : i915_request_retire.part.0: 0000:00:02.0 rcs0: fence 55:254874, current 254874
<0> [377.138735] gem_exec-2233 7..... 217098957us : __i915_request_commit: 0000:00:02.0 rcs0: fence 55:254878, current 254874
<0> [377.138802] gem_exec-2233 7..s1. 217098966us : process_csb: 0000:00:02.0 rcs0: cs-irq head=3, tail=4
<0> [377.138869] gem_exec-2233 7..s1. 217098966us : process_csb: 0000:00:02.0 rcs0: csb[4]: status=0x00008000:0x03ff8000
<0> [377.138936] gem_exec-2233 7..s1. 217098967us : trace_ports: 0000:00:02.0 rcs0: completed { ccid:20 55:254876! prio 0 }
<0> [377.139023] gem_exec-2233 7d.s2. 217098968us : __i915_request_submit: 0000:00:02.0 rcs0: fence 55:254878, current 254876
<0> [377.139091] gem_exec-2233 7d.s1. 217098969us : trace_ports: 0000:00:02.0 rcs0: submit { ccid:20 55:254878 prio 0 }
<0> [377.139172] gem_exec-2233 7..... 217099147us : i915_request_retire.part.0: 0000:00:02.0 rcs0: fence 55:254888, current 254888
<0> [377.139253] gem_exec-2233 7..... 217099159us : __i915_request_commit: 0000:00:02.0 rcs0: fence 55:254892, current 254888
<0> [377.139333] gem_exec-2233 7d.s2. 217099168us : __i915_request_submit: 0000:00:02.0 rcs0: fence 55:254892, current 254890
<0> [377.139400] gem_exec-2233 7d.s1. 217099169us : trace_ports: 0000:00:02.0 rcs0: submit { ccid:20 55:254892 prio 0 }
<0> [377.139485] gem_exec-2233 7..... 217099391us : i915_request_retire.part.0: 0000:00:02.0 rcs0: fence 55:254902, current 254902
<0> [377.139569] gem_exec-2233 7..... 217099412us : __i915_request_commit: 0000:00:02.0 rcs0: fence 55:254906, current 254903
<0> [377.139651] gem_exec-2233 7..... 217099654us : i915_request_retire.part.0: 0000:00:02.0 rcs0: fence 55:254918, current 254918
<0> [377.139733] gem_exec-2233 7..... 217099668us : __i915_request_commit: 0000:00:02.0 rcs0: fence 55:254922, current 254919
<0> [377.139801] gem_exec-2233 7..s1. 217099676us : process_csb: 0000:00:02.0 rcs0: cs-irq head=11, tail=0
<0> [377.139869] gem_exec-2233 7..s1. 217099677us : process_csb: 0000:00:02.0 rcs0: csb[0]: status=0x00008000:0x03ff8000
<0> [377.139936] gem_exec-2233 7..s1. 217099678us : trace_ports: 0000:00:02.0 rcs0: completed { ccid:20 55:254920! prio 0 }
<0> [377.140017] gem_exec-2233 7d.s2. 217099678us : __i915_request_submit: 0000:00:02.0 rcs0: fence 55:254922, current 254920
<0> [377.140084] gem_exec-2233 7d.s1. 217099680us : trace_ports: 0000:00:02.0 rcs0: submit { ccid:20 55:254922 prio 0 }
<0> [377.140164] gem_exec-2233 7..... 217099916us : i915_request_retire.part.0: 0000:00:02.0 rcs0: fence 55:254934, current 254934
<0> [377.140246] gem_exec-2233 7..... 217099934us : __i915_request_commit: 0000:00:02.0 rcs0: fence 55:254938, current 254936
<0> [377.140314] gem_exec-2233 7..s1. 217099941us : process_csb: 0000:00:02.0 rcs0: cs-irq head=3, tail=4
<0> [377.140381] gem_exec-2233 7..s1. 217099941us : process_csb: 0000:00:02.0 rcs0: csb[4]: status=0x00008000:0x03ff8000
<0> [377.140447] gem_exec-2233 7..s1. 217099942us : trace_ports: 0000:00:02.0 rcs0: completed { ccid:20 55:254936! prio 0 }
<0> [377.140539] gem_exec-2233 7d.s2. 217099942us : __i915_request_submit: 0000:00:02.0 rcs0: fence 55:254938, current 254936
<0> [377.140608] gem_exec-2233 7d.s1. 217099943us : trace_ports: 0000:00:02.0 rcs0: submit { ccid:20 55:254938 prio 0 }
<0> [377.140689] gem_exec-2233 7..... 217100148us : i915_request_retire.part.0: 0000:00:02.0 rcs0: fence 55:254948, current 254948
<0> [377.140770] gem_exec-2233 7..... 217100165us : __i915_request_commit: 0000:00:02.0 rcs0: fence 55:254952, current 254949
<0> [377.140837] gem_exec-2233 7..s1. 217100173us : process_csb: 0000:00:02.0 rcs0: cs-irq head=5, tail=6
<0> [377.140904] gem_exec-2233 7..s1. 217100173us : process_csb: 0000:00:02.0 rcs0: csb[6]: status=0x00008000:0x03ff8000
<0> [377.140970] gem_exec-2233 7..s1. 217100174us : trace_ports: 0000:00:02.0 rcs0: completed { ccid:20 55:254950! prio 0 }
<0> [377.141059] gem_exec-2233 7d.s2. 217100175us : __i915_request_submit: 0000:00:02.0 rcs0: fence 55:254952, current 254950
<0> [377.141128] gem_exec-2233 7d.s1. 217100176us : trace_ports: 0000:00:02.0 rcs0: submit { ccid:20 55:254952 prio 0 }
<0> [377.141211] gem_exec-2233 7..... 217100420us : i915_request_retire.part.0: 0000:00:02.0 rcs0: fence 55:254964, current 254964
<0> [377.141294] gem_exec-2233 7..... 217100440us : __i915_request_commit: 0000:00:02.0 rcs0: fence 55:254968, current 254966
<0> [377.141376] gem_exec-2233 7..... 217100679us : i915_request_retire.part.0: 0000:00:02.0 rcs0: fence 55:254980, current 254980
<0> [377.141458] gem_exec-2233 7..... 217100699us : __i915_request_commit: 0000:00:02.0 rcs0: fence 55:254984, current 254982
<0> [377.141542] gem_exec-2233 7d.s2. 217100708us : __i915_request_submit: 0000:00:02.0 rcs0: fence 55:254984, current 254982
<0> [377.141610] gem_exec-2233 7d.s1. 217100709us : execlists_submission_tasklet: 0000:00:02.0 rcs0: context:55 schedule-in, ccid:20
<0> [377.141677] gem_exec-2233 7d.s1. 217100710us : trace_ports: 0000:00:02.0 rcs0: submit { ccid:20 55:254984 prio 0 }
<0> [377.141758] gem_exec-2233 7..... 217100985us : i915_request_retire.part.0: 0000:00:02.0 rcs0: fence 55:254998, current 254998
<0> [377.141839] gem_exec-2233 7..... 217101002us : __i915_request_commit: 0000:00:02.0 rcs0: fence 55:255002, current 254999
<0> [377.141906] gem_exec-2233 7..s1. 217101010us : process_csb: 0000:00:02.0 rcs0: cs-irq head=7, tail=8
<0> [377.141973] gem_exec-2233 7..s1. 217101010us : process_csb: 0000:00:02.0 rcs0: csb[8]: status=0x00008000:0x03ff8000
<0> [377.142039] gem_exec-2233 7..s1. 217101011us : trace_ports: 0000:00:02.0 rcs0: completed { ccid:20 55:255000! prio 0 }
<0> [377.142119] gem_exec-2233 7d.s2. 217101012us : __i915_request_submit: 0000:00:02.0 rcs0: fence 55:255002, current 255000
<0> [377.142186] gem_exec-2233 7d.s1. 217101013us : trace_ports: 0000:00:02.0 rcs0: submit { ccid:20 55:255002 prio 0 }
<0> [377.142260] gem_exec-2233 7..... 217101028us : intel_rps_boost.part.0: 0000:00:02.0 boost fence:55:3e41a
<0> [377.142340] gem_exec-2233 7..... 217101151us : i915_request_retire.part.0: 0000:00:02.0 rcs0: fence 55:255010, current 255010
<0> [377.142421] gem_exec-2233 7..... 217101170us : __i915_request_commit: 0000:00:02.0 rcs0: fence 55:255014, current 255012
<0> [377.142495] gem_exec-2233 7..s1. 217101178us : process_csb: 0000:00:02.0 rcs0: cs-irq head=7, tail=8
<0> [377.142563] gem_exec-2233 7..s1. 217101178us : process_csb: 0000:00:02.0 rcs0: csb[8]: status=0x00008000:0x03ff8000
<0> [377.142629] gem_exec-2233 7..s1. 217101179us : trace_ports: 0000:00:02.0 rcs0: completed { ccid:20 55:255012! prio 0 }
<0> [377.142710] gem_exec-2233 7d.s2. 217101179us : __i915_request_submit: 0000:00:02.0 rcs0: fence 55:255014, current 255012
<0> [377.142776] gem_exec-2233 7d.s1. 217101180us : trace_ports: 0000:00:02.0 rcs0: submit { ccid:20 55:255014 prio 0 }
<0> [377.142858] gem_exec-2233 7..... 217101440us : i915_request_retire.part.0: 0000:00:02.0 rcs0: fence 55:255026, current 255026
<0> [377.142941] gem_exec-2233 7..... 217101460us : __i915_request_commit: 0000:00:02.0 rcs0: fence 55:255030, current 255028
<0> [377.143023] gem_exec-2233 7d.s2. 217101466us : __i915_request_submit: 0000:00:02.0 rcs0: fence 55:255030, current 255028
<0> [377.143099] gem_exec-2233 7d.s1. 217101467us : execlists_submission_tasklet: 0000:00:02.0 rcs0: context:55 schedule-in, ccid:20
<0> [377.143168] gem_exec-2233 7d.s1. 217101468us : trace_ports: 0000:00:02.0 rcs0: submit { ccid:20 55:255030 prio 0 }
<0> [377.143250] gem_exec-2233 7..... 217101652us : i915_request_retire.part.0: 0000:00:02.0 rcs0: fence 55:255040, current 255040
<0> [377.143333] gem_exec-2233 7..... 217101672us : __i915_request_commit: 0000:00:02.0 rcs0: fence 55:255044, current 255042
<0> [377.143414] gem_exec-2233 7..... 217101950us : i915_request_retire.part.0: 0000:00:02.0 rcs0: fence 55:255060, current 255060
<0> [377.143500] gem_exec-2233 7..... 217101971us : __i915_request_commit: 0000:00:02.0 rcs0: fence 55:255064, current 255062
<0> [377.143583] gem_exec-2233 7..... 217102221us : i915_request_retire.part.0: 0000:00:02.0 rcs0: fence 55:255078, current 255078
<0> [377.143665] gem_exec-2233 7..... 217102238us : __i915_request_commit: 0000:00:02.0 rcs0: fence 55:255082, current 255079
<0> [377.143733] gem_exec-2233 7..s1. 217102246us : process_csb: 0000:00:02.0 rcs0: cs-irq head=3, tail=4
<0> [377.143801] gem_exec-2233 7..s1. 217102246us : process_csb: 0000:00:02.0 rcs0: csb[4]: status=0x00008000:0x03ff8000
<0> [377.143867] gem_exec-2233 7..s1. 217102247us : trace_ports: 0000:00:02.0 rcs0: completed { ccid:20 55:255080! prio 0 }
<0> [377.143948] gem_exec-2233 7d.s2. 217102248us : __i915_request_submit: 0000:00:02.0 rcs0: fence 55:255082, current 255080
<0> [377.144015] gem_exec-2233 7d.s1. 217102249us : trace_ports: 0000:00:02.0 rcs0: submit { ccid:20 55:255082 prio 0 }
<0> [377.144095] gem_exec-2233 7..... 217102581us : i915_request_retire.part.0: 0000:00:02.0 rcs0: fence 55:255096, current 255096
<0> [377.144176] gem_exec-2233 7..... 217102604us : __i915_request_commit: 0000:00:02.0 rcs0: fence 55:255100, current 255098
<0> [377.144256] gem_exec-2233 7d.s2. 217102612us : __i915_request_submit: 0000:00:02.0 rcs0: fence 55:255100, current 255098
<0> [377.144324] gem_exec-2233 7d.s1. 217102613us : execlists_submission_tasklet: 0000:00:02.0 rcs0: context:55 schedule-in, ccid:20
<0> [377.144392] gem_exec-2233 7d.s1. 217102614us : trace_ports: 0000:00:02.0 rcs0: submit { ccid:20 55:255100 prio 0 }
<0> [377.144480] gem_exec-2233 7..... 217102804us : i915_request_retire.part.0: 0000:00:02.0 rcs0: fence 55:255108, current 255108
<0> [377.144591] gem_exec-2233 7..... 217102827us : __i915_request_commit: 0000:00:02.0 rcs0: fence 55:255112, current 255110
<7> [377.144591] i915 0000:00:02.0: [drm:drm_mode_rmfb_work_fn] Removing [FB:636] from all active usage due to RMFB ioctl
<0> [377.144688] gem_exec-2233 7d.s2. 217102836us : __i915_request_submit: 0000:00:02.0 rcs0: fence 55:255112, current 255110
<0> [377.144757] gem_exec-2233 7d.s1. 217102837us : execlists_submission_tasklet: 0000:00:02.0 rcs0: context:55 schedule-in, ccid:20
<0> [377.144824] gem_exec-2233 7d.s1. 217102838us : trace_ports: 0000:00:02.0 rcs0: submit { ccid:20 55:255112 prio 0 }
<0> [377.144915] gem_exec-2233 7..... 217102917us : i915_request_retire.part.0: 0000:00:02.0 rcs0: fence 55:255114, current 255115
<0> [377.145000] gem_exec-2233 7..... 217102943us : __i915_request_commit: 0000:00:02.0 rcs0: fence 55:255118, current 255116
<0> [377.145083] gem_exec-2233 7d.s2. 217102950us : __i915_request_submit: 0000:00:02.0 rcs0: fence 55:255118, current 255116
<0> [377.145170] gem_exec-2233 7d.s1. 217102951us : execlists_submission_tasklet: 0000:00:02.0 rcs0: context:55 schedule-in, ccid:20
<0> [377.145240] gem_exec-2233 7d.s1. 217102952us : trace_ports: 0000:00:02.0 rcs0: submit { ccid:20 55:255118 prio 0 }
<0> [377.145346] gem_exec-2233 7..... 217103223us : i915_request_retire.part.0: 0000:00:02.0 rcs0: fence 55:255132, current 255132
<0> [377.145438] gem_exec-2233 7..... 217103241us : __i915_request_commit: 0000:00:02.0 rcs0: fence 55:255136, current 255133
<6> [377.145482] [IGT] kms_flip: finished subtest A-HDMI-A1, SUCCESS
<0> [377.145510] gem_exec-2233 7..s1. 217103248us : process_csb: 0000:00:02.0 rcs0: cs-irq head=9, tail=10
<0> [377.145578] gem_exec-2233 7..s1. 217103248us : process_csb: 0000:00:02.0 rcs0: csb[10]: status=0x00008000:0x03ff8000
<0> [377.145653] gem_exec-2233 7..s1. 217103249us : trace_ports: 0000:00:02.0 rcs0: completed { ccid:20 55:255134! prio 0 }
<0> [377.145734] gem_exec-2233 7d.s2. 217103250us : __i915_request_submit: 0000:00:02.0 rcs0: fence 55:255136, current 255134
<0> [377.145802] gem_exec-2233 7d.s1. 217103250us : trace_ports: 0000:00:02.0 rcs0: submit { ccid:20 55:255136 prio 0 }
<0> [377.145890] gem_exec-2233 7..... 217103645us : i915_request_retire.part.0: 0000:00:02.0 rcs0: fence 55:255152, current 255152
<0> [377.145972] gem_exec-2233 7..... 217103668us : __i915_request_commit: 0000:00:02.0 rcs0: fence 55:255156, current 255154
<0> [377.146053] gem_exec-2233 7d.s2. 217103677us : __i915_request_submit: 0000:00:02.0 rcs0: fence 55:255156, current 255154
<0> [377.146121] gem_exec-2233 7d.s1. 217103679us : execlists_submission_tasklet: 0000:00:02.0 rcs0: context:55 schedule-in, ccid:20
<0> [377.146189] gem_exec-2233 7d.s1. 217103680us : trace_ports: 0000:00:02.0 rcs0: submit { ccid:20 55:255156 prio 0 }
<0> [377.146270] gem_exec-2233 7..... 217103966us : __i915_request_commit: 0000:00:02.0 rcs0: fence 55:255172, current 255170
<0> [377.146355] gem_exec-2233 7d.s2. 217103974us : __i915_request_submit: 0000:00:02.0 rcs0: fence 55:255172, current 255170
<0> [377.146424] gem_exec-2233 7d.s1. 217103975us : execlists_submission_tasklet: 0000:00:02.0 rcs0: context:55 schedule-in, ccid:20
<0> [377.146499] gem_exec-2233 7d.s1. 217103976us : trace_ports: 0000:00:02.0 rcs0: submit { ccid:20 55:255172 prio 0 }
<0> [377.146583] gem_exec-2233 7..... 217104389us : i915_request_retire.part.0: 0000:00:02.0 rcs0: fence 55:255190, current 255192
<0> [377.146691] gem_exec-2233 7..... 217104410us : __i915_request_commit: 0000:00:02.0 rcs0: fence 55:255194, current 255192
<0> [377.146787] gem_exec-2233 7d.s2. 217104419us : __i915_request_submit: 0000:00:02.0 rcs0: fence 55:255194, current 255192
|