<7>[ 59.562484] [IGT] gem_exec_reloc: executing <7>[ 59.576487] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 59.577412] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 59.577725] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 59.578310] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 59.579855] i915 0000:00:02.0: [drm:intel_power_well_enable [i915]] enabling always-on <7>[ 59.584037] [drm:eb_validate_vma [i915]] EINVAL at eb_validate_vma:508 <7>[ 59.584370] [IGT] gem_exec_reloc: exiting, ret=77 <7>[ 59.584526] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 59.631152] i915 0000:00:02.0: [drm:drm_client_dev_restore] fbdev: ret=0 <7>[ 59.685429] i915 0000:00:02.0: [drm:intel_power_well_disable [i915]] disabling always-on <7>[ 59.720627] [IGT] kms_plane_scaling: executing <7>[ 59.735114] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 59.735968] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 59.736344] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 59.740653] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] [CONNECTOR:148:HDMI-A-1] <7>[ 59.740663] i915 0000:00:02.0: [drm:intel_hdmi_detect [i915]] [CONNECTOR:148:HDMI-A-1] <7>[ 59.740861] i915 0000:00:02.0: [drm:intel_power_well_enable [i915]] enabling always-on <7>[ 59.745421] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] [CONNECTOR:148:HDMI-A-1] disconnected <7>[ 59.745686] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] [CONNECTOR:158:HDMI-A-2] <7>[ 59.745690] i915 0000:00:02.0: [drm:intel_hdmi_detect [i915]] [CONNECTOR:158:HDMI-A-2] <7>[ 59.750192] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] [CONNECTOR:158:HDMI-A-2] disconnected <7>[ 59.750441] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] [CONNECTOR:162:DP-1] <7>[ 59.750445] i915 0000:00:02.0: [drm:intel_dp_detect [i915]] [CONNECTOR:162:DP-1] <7>[ 59.754870] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] [CONNECTOR:162:DP-1] disconnected <7>[ 59.755119] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] [CONNECTOR:169:HDMI-A-3] <7>[ 59.755123] i915 0000:00:02.0: [drm:intel_hdmi_detect [i915]] [CONNECTOR:169:HDMI-A-3] <7>[ 59.759757] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] [CONNECTOR:169:HDMI-A-3] disconnected <7>[ 59.760012] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] [CONNECTOR:148:HDMI-A-1] <7>[ 59.760015] i915 0000:00:02.0: [drm:intel_hdmi_detect [i915]] [CONNECTOR:148:HDMI-A-1] <7>[ 59.764487] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] [CONNECTOR:148:HDMI-A-1] disconnected <7>[ 59.764500] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] [CONNECTOR:158:HDMI-A-2] <7>[ 59.764503] i915 0000:00:02.0: [drm:intel_hdmi_detect [i915]] [CONNECTOR:158:HDMI-A-2] <7>[ 59.768975] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] [CONNECTOR:158:HDMI-A-2] disconnected <7>[ 59.768988] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] [CONNECTOR:162:DP-1] <7>[ 59.768991] i915 0000:00:02.0: [drm:intel_dp_detect [i915]] [CONNECTOR:162:DP-1] <7>[ 59.773963] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] [CONNECTOR:162:DP-1] disconnected <7>[ 59.773976] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] [CONNECTOR:169:HDMI-A-3] <7>[ 59.773979] i915 0000:00:02.0: [drm:intel_hdmi_detect [i915]] [CONNECTOR:169:HDMI-A-3] <7>[ 59.778556] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] [CONNECTOR:169:HDMI-A-3] disconnected <7>[ 59.778629] [IGT] kms_plane_scaling: starting subtest planes-unity-scaling-downscale-factor-0-75 <7>[ 59.778714] [IGT] kms_plane_scaling: starting dynamic subtest pipe-A <7>[ 59.778776] [IGT] kms_plane_scaling: finished subtest pipe-A, SKIP <7>[ 59.778831] [IGT] kms_plane_scaling: starting dynamic subtest pipe-B <7>[ 59.778883] [IGT] kms_plane_scaling: finished subtest pipe-B, SKIP <7>[ 59.778952] [IGT] kms_plane_scaling: finished subtest planes-unity-scaling-downscale-factor-0-75, SKIP <7>[ 59.779115] [IGT] kms_plane_scaling: exiting, ret=77 <7>[ 59.779404] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 59.779540] i915 0000:00:02.0: [drm:drm_client_dev_restore] fbdev: ret=0 <7>[ 59.885190] i915 0000:00:02.0: [drm:intel_power_well_disable [i915]] disabling always-on <7>[ 59.928244] [IGT] kms_debugfs: executing <7>[ 59.942554] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 59.943105] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 59.943481] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 59.947541] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] [CONNECTOR:148:HDMI-A-1] <7>[ 59.947548] i915 0000:00:02.0: [drm:intel_hdmi_detect [i915]] [CONNECTOR:148:HDMI-A-1] <7>[ 59.947695] i915 0000:00:02.0: [drm:intel_power_well_enable [i915]] enabling always-on <7>[ 59.952192] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] [CONNECTOR:148:HDMI-A-1] disconnected <7>[ 59.952675] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] [CONNECTOR:158:HDMI-A-2] <7>[ 59.952680] i915 0000:00:02.0: [drm:intel_hdmi_detect [i915]] [CONNECTOR:158:HDMI-A-2] <7>[ 59.957719] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] [CONNECTOR:158:HDMI-A-2] disconnected <7>[ 59.958199] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] [CONNECTOR:162:DP-1] <7>[ 59.958205] i915 0000:00:02.0: [drm:intel_dp_detect [i915]] [CONNECTOR:162:DP-1] <7>[ 59.962754] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] [CONNECTOR:162:DP-1] disconnected <7>[ 59.963270] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] [CONNECTOR:169:HDMI-A-3] <7>[ 59.963276] i915 0000:00:02.0: [drm:intel_hdmi_detect [i915]] [CONNECTOR:169:HDMI-A-3] <7>[ 59.967768] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] [CONNECTOR:169:HDMI-A-3] disconnected <7>[ 59.968268] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] [CONNECTOR:148:HDMI-A-1] <7>[ 59.968273] i915 0000:00:02.0: [drm:intel_hdmi_detect [i915]] [CONNECTOR:148:HDMI-A-1] <7>[ 59.972812] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] [CONNECTOR:148:HDMI-A-1] disconnected <7>[ 59.972832] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] [CONNECTOR:158:HDMI-A-2] <7>[ 59.972837] i915 0000:00:02.0: [drm:intel_hdmi_detect [i915]] [CONNECTOR:158:HDMI-A-2] <7>[ 59.977877] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] [CONNECTOR:158:HDMI-A-2] disconnected <7>[ 59.977898] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] [CONNECTOR:162:DP-1] <7>[ 59.977903] i915 0000:00:02.0: [drm:intel_dp_detect [i915]] [CONNECTOR:162:DP-1] <7>[ 59.982936] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] [CONNECTOR:162:DP-1] disconnected <7>[ 59.982956] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] [CONNECTOR:169:HDMI-A-3] <7>[ 59.982961] i915 0000:00:02.0: [drm:intel_hdmi_detect [i915]] [CONNECTOR:169:HDMI-A-3] <7>[ 59.988019] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] [CONNECTOR:169:HDMI-A-3] disconnected <7>[ 59.988140] [IGT] kms_debugfs: exiting, ret=77 <7>[ 59.988668] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 59.993783] i915 0000:00:02.0: [drm:drm_client_dev_restore] fbdev: ret=0 <7>[ 60.072803] [IGT] sriov_basic: executing <7>[ 60.088534] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 60.089093] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 60.089345] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 60.089852] [IGT] sriov_basic: exiting, ret=77 <7>[ 60.090010] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 60.092754] i915 0000:00:02.0: [drm:drm_client_dev_restore] fbdev: ret=0 <7>[ 60.093238] i915 0000:00:02.0: [drm:intel_power_well_disable [i915]] disabling always-on <7>[ 60.190452] [IGT] gem_render_copy: executing <7>[ 60.204674] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 60.205271] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 60.206086] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 60.206352] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 60.211930] [IGT] gem_render_copy: starting subtest yf-tiled-ccs-to-y-tiled-ccs <7>[ 60.212022] [IGT] gem_render_copy: starting dynamic subtest smem <7>[ 60.212113] i915 0000:00:02.0: [drm:intel_power_well_enable [i915]] enabling always-on <7>[ 60.212453] [drm:eb_validate_vma [i915]] EINVAL at eb_validate_vma:508 <7>[ 60.358260] [IGT] gem_render_copy: finished subtest smem, SUCCESS <7>[ 60.358351] [IGT] gem_render_copy: finished subtest yf-tiled-ccs-to-y-tiled-ccs, SUCCESS <7>[ 60.405416] i915 0000:00:02.0: [drm:intel_power_well_disable [i915]] disabling always-on <7>[ 60.465381] [IGT] gem_render_copy: exiting, ret=0 <7>[ 60.465765] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 60.465938] i915 0000:00:02.0: [drm:drm_client_dev_restore] fbdev: ret=0 <7>[ 60.552379] [IGT] gem_fence_thrash: executing <7>[ 60.563939] [IGT] gem_fence_thrash: starting subtest bo-write-verify-threaded-none <7>[ 60.564077] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 60.564724] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 60.564947] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 67.557042] [IGT] gem_fence_thrash: finished subtest bo-write-verify-threaded-none, SUCCESS <7>[ 67.557132] [IGT] gem_fence_thrash: exiting, ret=0 <7>[ 67.557367] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 67.584519] i915 0000:00:02.0: [drm:drm_client_dev_restore] fbdev: ret=0 <7>[ 67.723510] [IGT] kms_big_fb: executing <7>[ 67.738638] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 67.739640] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 67.740007] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 67.744791] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] [CONNECTOR:148:HDMI-A-1] <7>[ 67.744799] i915 0000:00:02.0: [drm:intel_hdmi_detect [i915]] [CONNECTOR:148:HDMI-A-1] <7>[ 67.744959] i915 0000:00:02.0: [drm:intel_power_well_enable [i915]] enabling always-on <7>[ 67.749979] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] [CONNECTOR:148:HDMI-A-1] disconnected <7>[ 67.750343] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] [CONNECTOR:158:HDMI-A-2] <7>[ 67.750347] i915 0000:00:02.0: [drm:intel_hdmi_detect [i915]] [CONNECTOR:158:HDMI-A-2] <7>[ 67.754820] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] [CONNECTOR:158:HDMI-A-2] disconnected <7>[ 67.755066] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] [CONNECTOR:162:DP-1] <7>[ 67.755070] i915 0000:00:02.0: [drm:intel_dp_detect [i915]] [CONNECTOR:162:DP-1] <7>[ 67.760096] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] [CONNECTOR:162:DP-1] disconnected <7>[ 67.760388] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] [CONNECTOR:169:HDMI-A-3] <7>[ 67.760392] i915 0000:00:02.0: [drm:intel_hdmi_detect [i915]] [CONNECTOR:169:HDMI-A-3] <7>[ 67.764848] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] [CONNECTOR:169:HDMI-A-3] disconnected <7>[ 67.765100] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] [CONNECTOR:148:HDMI-A-1] <7>[ 67.765103] i915 0000:00:02.0: [drm:intel_hdmi_detect [i915]] [CONNECTOR:148:HDMI-A-1] <7>[ 67.770078] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] [CONNECTOR:148:HDMI-A-1] disconnected <7>[ 67.770091] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] [CONNECTOR:158:HDMI-A-2] <7>[ 67.770094] i915 0000:00:02.0: [drm:intel_hdmi_detect [i915]] [CONNECTOR:158:HDMI-A-2] <7>[ 67.775170] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] [CONNECTOR:158:HDMI-A-2] disconnected <7>[ 67.775183] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] [CONNECTOR:162:DP-1] <7>[ 67.775192] i915 0000:00:02.0: [drm:intel_dp_detect [i915]] [CONNECTOR:162:DP-1] <7>[ 67.779731] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] [CONNECTOR:162:DP-1] disconnected <7>[ 67.779743] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] [CONNECTOR:169:HDMI-A-3] <7>[ 67.779746] i915 0000:00:02.0: [drm:intel_hdmi_detect [i915]] [CONNECTOR:169:HDMI-A-3] <7>[ 67.784243] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] [CONNECTOR:169:HDMI-A-3] disconnected <7>[ 67.784370] [IGT] kms_big_fb: exiting, ret=77 <7>[ 67.784630] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 67.787578] i915 0000:00:02.0: [drm:drm_client_dev_restore] fbdev: ret=0 <7>[ 67.885217] i915 0000:00:02.0: [drm:intel_power_well_disable [i915]] disabling always-on <7>[ 67.887787] [IGT] syncobj_timeline: executing <7>[ 67.897436] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 67.898076] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 67.898368] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 67.900004] [IGT] syncobj_timeline: starting subtest invalid-signal-one-illegal-handle <7>[ 67.900498] [IGT] syncobj_timeline: finished subtest invalid-signal-one-illegal-handle, SUCCESS <7>[ 67.900718] [IGT] syncobj_timeline: exiting, ret=0 <7>[ 67.900918] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 67.901089] i915 0000:00:02.0: [drm:drm_client_dev_restore] fbdev: ret=0 <7>[ 68.015851] [IGT] kms_atomic_transition: executing <7>[ 68.028290] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 68.028868] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 68.029099] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 68.033050] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] [CONNECTOR:148:HDMI-A-1] <7>[ 68.033060] i915 0000:00:02.0: [drm:intel_hdmi_detect [i915]] [CONNECTOR:148:HDMI-A-1] <7>[ 68.033287] i915 0000:00:02.0: [drm:intel_power_well_enable [i915]] enabling always-on <7>[ 68.037874] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] [CONNECTOR:148:HDMI-A-1] disconnected <7>[ 68.038455] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] [CONNECTOR:158:HDMI-A-2] <7>[ 68.038463] i915 0000:00:02.0: [drm:intel_hdmi_detect [i915]] [CONNECTOR:158:HDMI-A-2] <7>[ 68.043070] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] [CONNECTOR:158:HDMI-A-2] disconnected <7>[ 68.043484] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] [CONNECTOR:162:DP-1] <7>[ 68.043490] i915 0000:00:02.0: [drm:intel_dp_detect [i915]] [CONNECTOR:162:DP-1] <7>[ 68.048006] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] [CONNECTOR:162:DP-1] disconnected <7>[ 68.048283] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] [CONNECTOR:169:HDMI-A-3] <7>[ 68.048287] i915 0000:00:02.0: [drm:intel_hdmi_detect [i915]] [CONNECTOR:169:HDMI-A-3] <7>[ 68.052745] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] [CONNECTOR:169:HDMI-A-3] disconnected <7>[ 68.052988] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] [CONNECTOR:148:HDMI-A-1] <7>[ 68.052991] i915 0000:00:02.0: [drm:intel_hdmi_detect [i915]] [CONNECTOR:148:HDMI-A-1] <7>[ 68.057457] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] [CONNECTOR:148:HDMI-A-1] disconnected <7>[ 68.057470] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] [CONNECTOR:158:HDMI-A-2] <7>[ 68.057473] i915 0000:00:02.0: [drm:intel_hdmi_detect [i915]] [CONNECTOR:158:HDMI-A-2] <7>[ 68.061937] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] [CONNECTOR:158:HDMI-A-2] disconnected <7>[ 68.061950] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] [CONNECTOR:162:DP-1] <7>[ 68.061953] i915 0000:00:02.0: [drm:intel_dp_detect [i915]] [CONNECTOR:162:DP-1] <7>[ 68.066461] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] [CONNECTOR:162:DP-1] disconnected <7>[ 68.066473] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] [CONNECTOR:169:HDMI-A-3] <7>[ 68.066476] i915 0000:00:02.0: [drm:intel_hdmi_detect [i915]] [CONNECTOR:169:HDMI-A-3] <7>[ 68.070944] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] [CONNECTOR:169:HDMI-A-3] disconnected <7>[ 68.071473] [IGT] kms_atomic_transition: exiting, ret=77 <7>[ 68.071731] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 68.169325] [IGT] api_intel_bb: executing <7>[ 68.181810] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 68.182511] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 68.182806] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 68.183536] [IGT] api_intel_bb: starting subtest crc32 <7>[ 68.183677] [IGT] api_intel_bb: finished subtest crc32, SKIP <7>[ 68.183867] [IGT] api_intel_bb: exiting, ret=77 <7>[ 68.184093] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 68.298919] [IGT] kms_flip_scaled_crc: executing <7>[ 68.313872] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 68.315342] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 68.315664] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 68.357073] [IGT] kms_flip_scaled_crc: starting subtest flip-32bpp-ytile-to-32bpp-ytileccs-downscaling <7>[ 68.357204] [IGT] kms_flip_scaled_crc: finished subtest flip-32bpp-ytile-to-32bpp-ytileccs-downscaling, SKIP <7>[ 68.357424] [IGT] kms_flip_scaled_crc: exiting, ret=77 <7>[ 68.357667] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 68.466699] [IGT] kms_ccs: executing <7>[ 68.472911] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 68.473569] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 68.473799] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 68.514324] [IGT] kms_ccs: exiting, ret=77 <7>[ 68.514619] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 68.610764] [IGT] gem_ctx_persistence: executing <7>[ 68.621962] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 68.622625] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 68.622865] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 68.623314] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 68.626886] [IGT] gem_ctx_persistence: starting subtest userptr <7>[ 68.626981] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 68.631265] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 68.631632] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x0000005c [0x0000005c] <7>[ 68.631934] [drm:eb_validate_vma [i915]] EINVAL at eb_validate_vma:508 <7>[ 68.638723] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x00000200 [0x00000200] <7>[ 68.706831] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x00000200 [0x00000200] <7>[ 68.716615] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x00000200 [0x00000200] <7>[ 68.729635] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x00000080 [0x00000080] <7>[ 68.729846] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x0000005c [0x0000005c] <7>[ 68.730071] [IGT] gem_ctx_persistence: finished subtest userptr, SUCCESS <7>[ 68.733517] [IGT] gem_ctx_persistence: exiting, ret=0 <7>[ 68.733691] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 68.821316] [IGT] kms_psr: executing <7>[ 68.835464] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 68.836013] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 68.836271] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 68.877562] [IGT] kms_psr: exiting, ret=77 <7>[ 68.877821] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 68.954944] [IGT] kms_frontbuffer_tracking: executing <7>[ 68.966644] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 68.967218] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 68.967427] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 69.007875] [IGT] kms_frontbuffer_tracking: exiting, ret=77 <7>[ 69.008123] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 69.088807] [IGT] kms_atomic_transition: executing <7>[ 69.103284] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 69.103915] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 69.104239] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 69.144854] [IGT] kms_atomic_transition: exiting, ret=77 <7>[ 69.145086] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 69.236780] [IGT] syncobj_wait: executing <7>[ 69.248240] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 69.248823] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 69.249046] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 69.250720] [IGT] syncobj_wait: starting subtest invalid-multi-wait-unsubmitted <7>[ 69.250916] [IGT] syncobj_wait: finished subtest invalid-multi-wait-unsubmitted, SUCCESS <7>[ 69.251101] [IGT] syncobj_wait: exiting, ret=0 <7>[ 69.251294] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 69.354469] [IGT] gem_exec_balancer: executing <7>[ 69.362379] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 69.363486] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 69.363844] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 69.364541] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 69.376812] [IGT] gem_exec_balancer: starting subtest bonded-dual <7>[ 70.543895] [IGT] gem_exec_balancer: finished subtest bonded-dual, SUCCESS <7>[ 70.653434] i915 0000:00:02.0: [drm:error_state_write [i915]] Resetting error state <7>[ 70.653737] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 70.657760] [IGT] gem_exec_balancer: exiting, ret=0 <7>[ 70.658533] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 70.738079] [IGT] gem_exec_schedule: executing <7>[ 70.753936] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 70.754745] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 70.755089] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 70.756865] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 70.767418] [IGT] gem_exec_schedule: starting subtest preempt-user <7>[ 70.767542] [IGT] gem_exec_schedule: starting dynamic subtest rcs0 <7>[ 70.767791] [drm:eb_validate_vma [i915]] EINVAL at eb_validate_vma:508 <7>[ 70.770888] [drm:eb_validate_vma [i915]] EINVAL at eb_validate_vma:508 <7>[ 70.789062] [IGT] gem_exec_schedule: finished subtest rcs0, SUCCESS <7>[ 70.789132] [IGT] gem_exec_schedule: starting dynamic subtest bcs0 <7>[ 70.790038] [drm:eb_validate_vma [i915]] EINVAL at eb_validate_vma:508 <7>[ 70.791224] [drm:eb_validate_vma [i915]] EINVAL at eb_validate_vma:508 <7>[ 70.808069] [IGT] gem_exec_schedule: finished subtest bcs0, SUCCESS <7>[ 70.808155] [IGT] gem_exec_schedule: starting dynamic subtest vcs0 <7>[ 70.808414] [drm:eb_validate_vma [i915]] EINVAL at eb_validate_vma:508 <7>[ 70.808937] [drm:eb_validate_vma [i915]] EINVAL at eb_validate_vma:508 <7>[ 70.825396] [IGT] gem_exec_schedule: finished subtest vcs0, SUCCESS <7>[ 70.825476] [IGT] gem_exec_schedule: starting dynamic subtest vecs0 <7>[ 70.825581] [drm:eb_validate_vma [i915]] EINVAL at eb_validate_vma:508 <7>[ 70.826079] [drm:eb_validate_vma [i915]] EINVAL at eb_validate_vma:508 <7>[ 70.842942] [IGT] gem_exec_schedule: finished subtest vecs0, SUCCESS <7>[ 70.843023] [IGT] gem_exec_schedule: finished subtest preempt-user, SUCCESS <7>[ 70.948419] i915 0000:00:02.0: [drm:error_state_write [i915]] Resetting error state <7>[ 71.063236] [IGT] gem_exec_schedule: exiting, ret=0 <7>[ 71.063948] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 71.152903] [IGT] gen7_exec_parse: executing <7>[ 71.171396] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 71.172423] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 71.172794] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 71.173515] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 71.177809] [IGT] gen7_exec_parse: exiting, ret=77 <7>[ 71.177979] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 71.278269] [IGT] kms_big_fb: executing <7>[ 71.296373] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 71.297602] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 71.297984] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 71.340485] [IGT] kms_big_fb: exiting, ret=77 <7>[ 71.340787] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 71.433200] [IGT] perf_pmu: executing <7>[ 71.444810] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 71.445347] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 71.448369] [IGT] perf_pmu: starting subtest rc6-suspend <7>[ 71.448484] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x0000005c [0x0000005c] <6>[ 73.717379] PM: suspend entry (s2idle) <6>[ 73.727531] Filesystems sync: 0.010 seconds <6>[ 73.740785] Freezing user space processes <6>[ 73.749596] Freezing user space processes completed (elapsed 0.008 seconds) <6>[ 73.749692] OOM killer disabled. <6>[ 73.749699] Freezing remaining freezable tasks <6>[ 73.751446] Freezing remaining freezable tasks completed (elapsed 0.001 seconds) <6>[ 73.871918] e1000e: EEE TX LPI TIMER: 00000000 <6>[ 73.871942] e1000e: EEE TX LPI TIMER: 00000011 <7>[ 73.905810] azx_init_pci: snd_hda_intel 0000:00:1f.3: Clearing TCSEL <7>[ 73.905850] azx_init_pci: snd_hda_intel 0000:00:1f.3: SCH snoop: Enabled <7>[ 73.918255] i915 0000:00:02.0: [drm:i915_hdcp_component_unbind [i915]] I915 HDCP comp unbind <3>[ 73.942704] igc 0000:02:00.0 enp2s0: Timeout reading IGC_PTM_STAT register <7>[ 74.074418] PM: suspend of devices complete after 211.776 msecs <7>[ 74.074446] PM: start suspend of devices complete after 322.639 msecs <7>[ 74.114561] PM: late suspend of devices complete after 40.104 msecs <6>[ 74.133389] ACPI: EC: interrupt blocked <7>[ 74.351417] PM: noirq suspend of devices complete after 233.822 msecs <6>[ 74.351452] ACPI: \_SB_.PR00: LPI: Device not power manageable <6>[ 74.351463] ACPI: \_SB_.PR01: LPI: Device not power manageable <6>[ 74.351469] ACPI: \_SB_.PR02: LPI: Device not power manageable <6>[ 74.351475] ACPI: \_SB_.PR03: LPI: Device not power manageable <6>[ 74.351480] ACPI: \_SB_.PR04: LPI: Device not power manageable <6>[ 74.351486] ACPI: \_SB_.PR05: LPI: Device not power manageable <6>[ 74.351491] ACPI: \_SB_.PR06: LPI: Device not power manageable <6>[ 74.351497] ACPI: \_SB_.PR07: LPI: Device not power manageable <6>[ 74.351502] ACPI: \_SB_.PC00.GFX0: LPI: Device not power manageable <6>[ 74.351513] ACPI: \_SB_.PR08: LPI: Device not power manageable <6>[ 74.351519] ACPI: \_SB_.PR09: LPI: Device not power manageable <6>[ 74.351524] ACPI: \_SB_.PR10: LPI: Device not power manageable <6>[ 74.351530] ACPI: \_SB_.PR11: LPI: Device not power manageable <6>[ 74.351535] ACPI: \_SB_.PC00.HECI: LPI: Device not power manageable <6>[ 74.351541] ACPI: \_SB_.PC00.GNA0: LPI: Device not power manageable <6>[ 74.354765] ACPI: \_SB_.PEPD: Successfully transitioned to state screen off <7>[ 74.411546] PM: Triggering wakeup from IRQ 9 <6>[ 74.493293] ACPI: \_SB_.PEPD: Successfully transitioned to state lps0 entry <7>[ 74.493299] PM: suspend-to-idle <7>[ 74.493449] ACPI: EC: ACPI EC GPE status set <7>[ 74.493478] ACPI: PM: Rearming ACPI SCI for wakeup <7>[ 89.668491] Timekeeping suspended for 15.171 seconds <7>[ 89.670861] PM: Triggering wakeup from IRQ 9 <7>[ 89.671343] ACPI: PM: ACPI fixed event wakeup <7>[ 89.671356] PM: resume from suspend-to-idle <6>[ 89.821512] ACPI: \_SB_.PEPD: Successfully transitioned to state lps0 exit <6>[ 89.825368] ACPI: \_SB_.PEPD: Successfully transitioned to state screen on <6>[ 89.826186] ACPI: EC: interrupt unblocked <7>[ 90.189330] PM: noirq resume of devices complete after 363.955 msecs <7>[ 90.197671] PM: early resume of devices complete after 6.088 msecs <7>[ 90.213815] azx_init_pci: snd_hda_intel 0000:00:1f.3: Clearing TCSEL <7>[ 90.213827] azx_init_pci: snd_hda_intel 0000:00:1f.3: SCH snoop: Enabled <6>[ 90.214128] nvme nvme0: D3 entry latency set to 10 seconds <6>[ 90.219626] nvme nvme0: 12/0/0 default/read/poll queues <6>[ 90.226022] serial 00:02: activated <3>[ 90.452842] atkbd serio0: Failed to deactivate keyboard on isa0060/serio0 <6>[ 90.515268] ata3: SATA link down (SStatus 4 SControl 300) <6>[ 90.516052] ata4: SATA link down (SStatus 4 SControl 300) <6>[ 90.516181] ata2: SATA link down (SStatus 4 SControl 300) <3>[ 90.828002] atkbd serio0: Failed to enable keyboard on isa0060/serio0 <7>[ 91.457979] PM: resume of devices complete after 1260.304 msecs <6>[ 91.462025] OOM killer enabled. <6>[ 91.462031] Restarting tasks: Starting <7>[ 91.463772] i915 0000:00:02.0: [drm:i915_hdcp_component_bind [i915]] I915 HDCP comp bind <6>[ 91.465054] mei_hdcp 0000:00:16.0-b638ab7e-94e2-4ea2-a552-d1c54b627f04: bound 0000:00:02.0 (ops i915_hdcp_ops [i915]) <6>[ 91.469011] Restarting tasks: Done <5>[ 91.469302] random: crng reseeded on system resumption <6>[ 91.470327] mei_pxp 0000:00:16.0-fbf6fcf1-96cf-4e2e-a6a6-1bab8cbe36b1: bound 0000:00:02.0 (ops i915_pxp_tee_component_ops [i915]) <6>[ 91.470632] PM: suspend exit <6>[ 92.889049] e1000e 0000:03:00.0 enp3s0: NIC Link is Up 1000 Mbps Full Duplex, Flow Control: None <7>[ 95.649561] [IGT] perf_pmu: finished subtest rc6-suspend, SUCCESS <7>[ 95.650138] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 95.652017] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 95.655927] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x0000005c [0x0000005c] <7>[ 98.064565] [IGT] gem_exec_flush: executing <7>[ 98.079763] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 98.080403] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 98.080641] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 98.081048] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 98.088749] [IGT] gem_exec_flush: starting subtest basic-wb-prw-default <7>[ 98.093287] [drm:eb_validate_vma [i915]] EINVAL at eb_validate_vma:508 <7>[ 98.096905] [drm:eb_validate_vma [i915]] EINVAL at eb_validate_vma:508 <7>[ 98.100880] [drm:eb_validate_vma [i915]] EINVAL at eb_validate_vma:508 <7>[ 98.105118] [drm:eb_validate_vma [i915]] EINVAL at eb_validate_vma:508 <7>[ 98.109654] [drm:eb_validate_vma [i915]] EINVAL at eb_validate_vma:508 <7>[ 98.113839] [drm:eb_validate_vma [i915]] EINVAL at eb_validate_vma:508 <7>[ 98.118478] [drm:eb_validate_vma [i915]] EINVAL at eb_validate_vma:508 <7>[ 98.125730] [drm:eb_validate_vma [i915]] EINVAL at eb_validate_vma:508 <7>[ 98.132195] [drm:eb_validate_vma [i915]] EINVAL at eb_validate_vma:508 <7>[ 98.139349] [drm:eb_validate_vma [i915]] EINVAL at eb_validate_vma:508 <7>[ 98.145343] [drm:eb_validate_vma [i915]] EINVAL at eb_validate_vma:508 <7>[ 98.151970] [drm:eb_validate_vma [i915]] EINVAL at eb_validate_vma:508 <7>[ 103.529398] [IGT] gem_exec_flush: finished subtest basic-wb-prw-default, SUCCESS <7>[ 103.640474] [IGT] gem_exec_flush: exiting, ret=0 <7>[ 103.641180] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 103.771955] [IGT] kms_psr: executing <7>[ 103.787066] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 103.787951] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 103.788253] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 103.836054] [IGT] kms_psr: exiting, ret=77 <7>[ 103.836380] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 103.918653] [IGT] gem_ctx_exec: executing <7>[ 103.928860] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 103.929363] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 103.930005] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 103.930238] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 103.931539] [IGT] gem_ctx_exec: starting subtest basic-nohangcheck <7>[ 103.931681] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 103.932901] [drm:eb_validate_vma [i915]] EINVAL at eb_validate_vma:508 <5>[ 104.042539] i915 0000:00:02.0: [drm] Resetting vecs0 for preemption time out <5>[ 104.048642] i915 0000:00:02.0: [drm] Resetting vcs0 for preemption time out <5>[ 104.053454] i915 0000:00:02.0: [drm] Resetting bcs0 for preemption time out <5>[ 104.058343] i915 0000:00:02.0: [drm] Resetting rcs0 for preemption time out <6>[ 104.192391] i915 0000:00:02.0: [drm] GPU HANG: ecode 12:8:277ffefe, in gem_ctx_exec [2280] <6>[ 104.192545] i915 0000:00:02.0: [drm] GPU HANG: ecode 12:4:277ffefe, in gem_ctx_exec [2280] <6>[ 104.192599] i915 0000:00:02.0: [drm] GPU HANG: ecode 12:2:18800102, in gem_ctx_exec [2280] <6>[ 104.192645] i915 0000:00:02.0: [drm] GPU HANG: ecode 12:1:e75ffefe, in gem_ctx_exec [2280] <7>[ 104.194367] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x0000005c [0x0000005c] <7>[ 104.228867] [IGT] gem_ctx_exec: finished subtest basic-nohangcheck, SUCCESS <7>[ 104.232473] [IGT] gem_ctx_exec: exiting, ret=0 <7>[ 104.233777] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 104.358939] [IGT] gem_mmap_gtt: executing <7>[ 104.370898] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 104.371554] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 104.371797] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 104.372323] [IGT] gem_mmap_gtt: starting subtest cpuset-basic-small-copy <7>[ 104.390649] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <6>[ 104.391033] gem_mmap_gtt (2282): drop_caches: 4 <7>[ 104.391096] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x00000070 [0x00000070] <7>[ 104.701176] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x00000070 [0x00000070] <7>[ 108.902186] [IGT] gem_mmap_gtt: finished subtest cpuset-basic-small-copy, SUCCESS <7>[ 108.902436] [IGT] gem_mmap_gtt: exiting, ret=0 <7>[ 108.902697] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 109.040102] [IGT] kms_feature_discovery: executing <7>[ 109.051909] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 109.052514] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 109.052763] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 109.099620] [IGT] kms_feature_discovery: starting subtest chamelium <7>[ 109.099811] [IGT] kms_feature_discovery: finished subtest chamelium, SKIP <7>[ 109.099929] [IGT] kms_feature_discovery: exiting, ret=77 <7>[ 109.100131] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 109.193155] [IGT] kms_cursor_legacy: executing <7>[ 109.207812] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 109.208523] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 109.208828] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 109.254640] [IGT] kms_cursor_legacy: exiting, ret=77 <7>[ 109.254946] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 109.399043] [IGT] kms_big_fb: executing <7>[ 109.409996] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 109.410577] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 109.410806] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 109.456848] [IGT] kms_big_fb: exiting, ret=77 <7>[ 109.457120] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 109.553997] [IGT] kms_psr: executing <7>[ 109.566117] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 109.566773] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 109.567015] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 109.611658] [IGT] kms_psr: exiting, ret=77 <7>[ 109.611940] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 109.704616] [IGT] kms_flip: executing <7>[ 109.714176] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 109.714769] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 109.714975] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 109.762781] [IGT] kms_flip: starting subtest 2x-flip-vs-rmfb-interruptible <7>[ 109.763316] [IGT] kms_flip: finished subtest 2x-flip-vs-rmfb-interruptible, SKIP <7>[ 109.765666] [IGT] kms_flip: exiting, ret=77 <7>[ 109.765952] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 109.862879] [IGT] kms_prime: executing <7>[ 109.870720] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <6>[ 109.929784] [drm] Initialized vgem 1.0.0 for vgem on minor 1 <7>[ 109.941286] [IGT] kms_prime: exiting, ret=77 <7>[ 110.014807] [IGT] gem_exec_reloc: executing <7>[ 110.021052] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 110.021627] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 110.021838] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 110.022217] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 110.026367] [drm:eb_validate_vma [i915]] EINVAL at eb_validate_vma:508 <7>[ 110.026624] [IGT] gem_exec_reloc: exiting, ret=77 <7>[ 110.026807] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 110.133468] [IGT] i915_drm_fdinfo: executing <7>[ 110.139903] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 110.140368] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 110.143663] [IGT] i915_drm_fdinfo: starting subtest virtual-busy-hang-all <7>[ 110.144118] [IGT] i915_drm_fdinfo: finished subtest virtual-busy-hang-all, SUCCESS <7>[ 110.144227] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 110.144806] [IGT] i915_drm_fdinfo: exiting, ret=0 <7>[ 110.250611] [IGT] kms_chamelium_frames: executing <7>[ 110.262364] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 110.262940] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 110.263160] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 110.311035] [IGT] kms_chamelium_frames: exiting, ret=77 <7>[ 110.311254] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 110.399793] [IGT] kms_big_fb: executing <7>[ 110.411923] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 110.412603] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 110.412866] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 110.455757] [IGT] kms_big_fb: exiting, ret=77 <7>[ 110.456048] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 110.544692] [IGT] gem_pwrite: executing <7>[ 110.552358] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 110.552935] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 110.553134] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 110.553608] [IGT] gem_pwrite: exiting, ret=77 <7>[ 110.553775] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 110.661522] [IGT] gem_spin_batch: executing <7>[ 110.669109] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 110.669684] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 110.669896] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 110.670259] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 110.676915] [IGT] gem_spin_batch: starting subtest resubmit-all <7>[ 110.677034] [IGT] gem_spin_batch: starting dynamic subtest rcs0 <7>[ 110.677262] [drm:eb_validate_vma [i915]] EINVAL at eb_validate_vma:508 <7>[ 110.681834] [IGT] gem_spin_batch: finished subtest rcs0, SUCCESS <7>[ 110.681897] [IGT] gem_spin_batch: starting dynamic subtest bcs0 <7>[ 110.681969] [drm:eb_validate_vma [i915]] EINVAL at eb_validate_vma:508 <7>[ 110.683077] [IGT] gem_spin_batch: finished subtest bcs0, SUCCESS <7>[ 110.683133] [IGT] gem_spin_batch: starting dynamic subtest vcs0 <7>[ 110.683207] [drm:eb_validate_vma [i915]] EINVAL at eb_validate_vma:508 <7>[ 110.684153] [IGT] gem_spin_batch: finished subtest vcs0, SUCCESS <7>[ 110.684207] [IGT] gem_spin_batch: starting dynamic subtest vecs0 <7>[ 110.684280] [drm:eb_validate_vma [i915]] EINVAL at eb_validate_vma:508 <7>[ 110.685596] [IGT] gem_spin_batch: finished subtest vecs0, SUCCESS <7>[ 110.685673] [IGT] gem_spin_batch: finished subtest resubmit-all, SUCCESS <7>[ 110.796019] [IGT] gem_spin_batch: exiting, ret=0 <7>[ 110.796189] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 110.887961] [IGT] gem_exec_reloc: executing <7>[ 110.899506] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 110.900187] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 110.900483] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 110.901044] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 110.904499] [drm:eb_validate_vma [i915]] EINVAL at eb_validate_vma:508 <7>[ 110.904888] [IGT] gem_exec_reloc: exiting, ret=77 <7>[ 110.905113] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 111.040680] [IGT] kms_vblank: executing <7>[ 111.048518] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 111.049045] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 111.049245] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 111.097033] [IGT] kms_vblank: exiting, ret=77 <7>[ 111.097328] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 111.188829] [IGT] perf: executing <7>[ 111.205976] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 111.206465] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 111.212998] i915 0000:00:02.0: [drm:i915_perf_add_config_ioctl [i915]] Added config 5b492c36-73f7-4827-83b3-c6863697ec51 id=2 <7>[ 111.213180] i915 0000:00:02.0: [drm:i915_perf_add_config_ioctl [i915]] Added config 09740672-ccc3-48da-a5bc-64994fe3a0a7 id=3 <7>[ 111.213357] i915 0000:00:02.0: [drm:i915_perf_add_config_ioctl [i915]] Added config 833bb0f2-9483-498e-b3bf-ebf026a6301a id=4 <7>[ 111.214176] i915 0000:00:02.0: [drm:i915_perf_add_config_ioctl [i915]] Added config 40ef13ef-25d9-4ac6-8582-ce97c47fc900 id=5 <7>[ 111.214486] i915 0000:00:02.0: [drm:i915_perf_add_config_ioctl [i915]] Added config bf60f7bd-9029-4edf-8311-f6e86599395e id=6 <7>[ 111.214766] i915 0000:00:02.0: [drm:i915_perf_add_config_ioctl [i915]] Added config a5f6ac3d-853f-42a4-a038-c4a09e8075be id=7 <7>[ 111.215030] i915 0000:00:02.0: [drm:i915_perf_add_config_ioctl [i915]] Added config bb080384-a01f-442f-8be2-3eae2c7394cd id=8 <7>[ 111.215288] i915 0000:00:02.0: [drm:i915_perf_add_config_ioctl [i915]] Added config 9f39ce80-0463-484e-b797-3135b7e0ab0a id=9 <7>[ 111.215612] i915 0000:00:02.0: [drm:i915_perf_add_config_ioctl [i915]] Added config 11e091e1-bbd3-4bd6-9ce8-8982d2d3a3b2 id=10 <7>[ 111.215865] i915 0000:00:02.0: [drm:i915_perf_add_config_ioctl [i915]] Added config 0f2e1818-c190-494a-a828-2ed4422d71f3 id=11 <7>[ 111.216117] i915 0000:00:02.0: [drm:i915_perf_add_config_ioctl [i915]] Added config ebd91ba3-4d01-4bdf-8752-384cd0a4e139 id=12 <7>[ 111.216395] i915 0000:00:02.0: [drm:i915_perf_add_config_ioctl [i915]] Added config 5102fa66-b5f3-45f2-a16d-0a13a4cbb6c9 id=13 <7>[ 111.216784] i915 0000:00:02.0: [drm:i915_perf_add_config_ioctl [i915]] Added config 8706c725-7753-427d-ae2d-ba25c1168f2a id=14 <7>[ 111.217048] i915 0000:00:02.0: [drm:i915_perf_add_config_ioctl [i915]] Added config 3eab195e-e4d8-482e-9981-811935722b21 id=15 <7>[ 111.217309] i915 0000:00:02.0: [drm:i915_perf_add_config_ioctl [i915]] Added config 100ae8ce-31c6-457f-97a2-dfd44812bce6 id=16 <7>[ 111.217607] i915 0000:00:02.0: [drm:i915_perf_add_config_ioctl [i915]] Added config 7e926c0a-471b-40b3-a641-75f3d73339ec id=17 <7>[ 111.217871] i915 0000:00:02.0: [drm:i915_perf_add_config_ioctl [i915]] Added config aca9005f-fafe-4d02-a9de-b2584ff76f04 id=18 <7>[ 111.218137] i915 0000:00:02.0: [drm:i915_perf_add_config_ioctl [i915]] Added config ad96806d-7c0d-49f0-b844-c5010ade30af id=19 <7>[ 111.218411] i915 0000:00:02.0: [drm:i915_perf_add_config_ioctl [i915]] Added config 1669e79f-976e-47ba-a553-0a716ebd3c71 id=20 <7>[ 111.218708] i915 0000:00:02.0: [drm:i915_perf_add_config_ioctl [i915]] Added config d100e474-1e6c-4100-812b-71ec9cfe3523 id=21 <7>[ 111.218967] i915 0000:00:02.0: [drm:i915_perf_add_config_ioctl [i915]] Added config b22d38f6-a056-496a-8d7d-dede47051806 id=22 <7>[ 111.219228] i915 0000:00:02.0: [drm:i915_perf_add_config_ioctl [i915]] Added config c68abf37-fe6e-45f6-9dcb-549b3fbef699 id=23 <7>[ 111.219497] i915 0000:00:02.0: [drm:i915_perf_add_config_ioctl [i915]] Added config 74dbc739-d871-41b5-be7b-fb547ac5bec9 id=24 <7>[ 111.220751] [IGT] perf: starting subtest oa-exponents <7>[ 111.220874] [IGT] perf: starting dynamic subtest 0-rcs0 <7>[ 111.221565] [drm:eb_validate_vma [i915]] EINVAL at eb_validate_vma:508 <7>[ 111.239013] i915 0000:00:02.0: [drm:i915_oa_stream_init.isra.0 [i915]] opening stream oa config uuid=74dbc739-d871-41b5-be7b-fb547ac5bec9 <7>[ 111.249145] i915 0000:00:02.0: [drm:i915_oa_stream_init.isra.0 [i915]] opening stream oa config uuid=74dbc739-d871-41b5-be7b-fb547ac5bec9 <7>[ 111.260112] i915 0000:00:02.0: [drm:i915_oa_stream_init.isra.0 [i915]] opening stream oa config uuid=74dbc739-d871-41b5-be7b-fb547ac5bec9 <7>[ 111.268446] i915 0000:00:02.0: [drm:i915_oa_stream_init.isra.0 [i915]] opening stream oa config uuid=74dbc739-d871-41b5-be7b-fb547ac5bec9 <7>[ 111.285538] i915 0000:00:02.0: [drm:i915_oa_stream_init.isra.0 [i915]] opening stream oa config uuid=74dbc739-d871-41b5-be7b-fb547ac5bec9 <7>[ 111.299953] i915 0000:00:02.0: [drm:i915_oa_stream_init.isra.0 [i915]] opening stream oa config uuid=74dbc739-d871-41b5-be7b-fb547ac5bec9 <7>[ 111.313125] i915 0000:00:02.0: [drm:i915_oa_stream_init.isra.0 [i915]] opening stream oa config uuid=74dbc739-d871-41b5-be7b-fb547ac5bec9 <7>[ 111.331605] i915 0000:00:02.0: [drm:i915_oa_stream_init.isra.0 [i915]] opening stream oa config uuid=74dbc739-d871-41b5-be7b-fb547ac5bec9 <7>[ 111.364618] i915 0000:00:02.0: [drm:i915_oa_stream_init.isra.0 [i915]] opening stream oa config uuid=74dbc739-d871-41b5-be7b-fb547ac5bec9 <7>[ 111.417686] i915 0000:00:02.0: [drm:i915_oa_stream_init.isra.0 [i915]] opening stream oa config uuid=74dbc739-d871-41b5-be7b-fb547ac5bec9 <7>[ 111.510646] i915 0000:00:02.0: [drm:i915_oa_stream_init.isra.0 [i915]] opening stream oa config uuid=74dbc739-d871-41b5-be7b-fb547ac5bec9 <7>[ 111.683840] i915 0000:00:02.0: [drm:i915_oa_stream_init.isra.0 [i915]] opening stream oa config uuid=74dbc739-d871-41b5-be7b-fb547ac5bec9 <7>[ 112.021724] i915 0000:00:02.0: [drm:i915_oa_stream_init.isra.0 [i915]] opening stream oa config uuid=74dbc739-d871-41b5-be7b-fb547ac5bec9 <7>[ 112.686210] i915 0000:00:02.0: [drm:i915_oa_stream_init.isra.0 [i915]] opening stream oa config uuid=74dbc739-d871-41b5-be7b-fb547ac5bec9 <7>[ 113.981347] i915 0000:00:02.0: [drm:i915_oa_stream_init.isra.0 [i915]] opening stream oa config uuid=74dbc739-d871-41b5-be7b-fb547ac5bec9 <7>[ 116.590083] [IGT] perf: finished subtest 0-rcs0, SUCCESS <7>[ 116.590229] [IGT] perf: finished subtest oa-exponents, SUCCESS <7>[ 116.590477] [IGT] perf: exiting, ret=0 <7>[ 116.752246] [IGT] gem_ccs: executing <7>[ 116.764455] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 116.765286] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 116.765623] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 116.766310] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 116.773446] [IGT] gem_ccs: starting subtest block-copy-compressed <7>[ 116.773730] [IGT] gem_ccs: finished subtest block-copy-compressed, SKIP <7>[ 116.774208] i915 0000:00:02.0: [drm:error_state_write [i915]] Resetting error state <7>[ 116.775549] [IGT] gem_ccs: exiting, ret=77 <7>[ 116.775985] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 116.877668] [IGT] kms_frontbuffer_tracking: executing <7>[ 116.889517] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 116.890168] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 116.890434] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 116.937622] [IGT] kms_frontbuffer_tracking: exiting, ret=77 <7>[ 116.937860] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 117.027814] [IGT] kms_psr2_sf: executing <7>[ 117.039343] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 117.039851] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 117.040046] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 117.087005] [IGT] kms_psr2_sf: exiting, ret=77 <7>[ 117.087347] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 117.170086] [IGT] prime_mmap: executing <7>[ 117.177860] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 117.178448] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 117.178673] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 117.179663] [IGT] prime_mmap: starting subtest test_map_unmap <7>[ 117.179743] [IGT] prime_mmap: starting dynamic subtest test_map_unmap-smem <7>[ 117.223546] [IGT] prime_mmap: finished subtest test_map_unmap-smem, SUCCESS <7>[ 117.223639] [IGT] prime_mmap: finished subtest test_map_unmap, SUCCESS <7>[ 117.223800] [IGT] prime_mmap: exiting, ret=0 <7>[ 117.223954] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 117.311010] [IGT] kms_content_protection: executing <7>[ 117.322698] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 117.323290] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 117.323516] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 117.366821] [IGT] kms_content_protection: exiting, ret=77 <7>[ 117.367026] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 117.480274] [IGT] kms_psr2_sf: executing <7>[ 117.488405] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 117.488921] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 117.489173] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 117.535287] [IGT] kms_psr2_sf: exiting, ret=77 <7>[ 117.535560] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 117.635571] [IGT] kms_frontbuffer_tracking: executing <7>[ 117.647173] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 117.647731] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 117.647958] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 117.690638] [IGT] kms_frontbuffer_tracking: exiting, ret=77 <7>[ 117.690876] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 117.778632] [IGT] gem_exec_fence: executing <7>[ 117.786419] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 117.786936] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 117.787208] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 117.787615] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 117.795871] [IGT] gem_exec_fence: starting subtest basic-wait-all <7>[ 117.796163] [drm:eb_validate_vma [i915]] EINVAL at eb_validate_vma:508 <7>[ 117.797592] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x0000005c [0x0000005c] <7>[ 117.862754] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x0000005c [0x0000005c] <7>[ 117.885746] [IGT] gem_exec_fence: finished subtest basic-wait-all, SUCCESS <7>[ 117.994247] i915 0000:00:02.0: [drm:error_state_write [i915]] Resetting error state <7>[ 118.110897] i915 0000:00:02.0: [drm:error_state_write [i915]] Resetting error state <7>[ 118.116246] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 118.134268] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 118.138716] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 118.143391] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 118.379747] [IGT] gem_exec_fence: exiting, ret=0 <7>[ 118.380616] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 118.471444] [IGT] kms_frontbuffer_tracking: executing <7>[ 118.483371] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 118.484070] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 118.484357] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 118.531820] [IGT] kms_frontbuffer_tracking: exiting, ret=77 <7>[ 118.532061] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 118.619399] [IGT] kms_frontbuffer_tracking: executing <7>[ 118.625803] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 118.626389] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 118.626597] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 118.673743] [IGT] kms_frontbuffer_tracking: exiting, ret=77 <7>[ 118.673984] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 118.760410] [IGT] kms_frontbuffer_tracking: executing <7>[ 118.767592] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 118.768134] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 118.768340] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 118.811620] [IGT] kms_frontbuffer_tracking: exiting, ret=77 <7>[ 118.811850] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 118.894768] [IGT] kms_chamelium_audio: executing <7>[ 118.906622] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 118.907427] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 118.907897] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 118.953833] [IGT] kms_chamelium_audio: exiting, ret=77 <7>[ 118.954107] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 119.044257] [IGT] kms_pm_rpm: executing <7>[ 119.055684] [IGT] kms_pm_rpm: starting subtest basic-rte <7>[ 119.055826] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 120.122211] i915 0000:00:02.0: [drm:intel_runtime_suspend [i915]] Suspending device <7>[ 120.129004] i915 0000:00:02.0: [drm:intel_runtime_suspend [i915]] Device suspended <7>[ 120.153668] i915 0000:00:02.0: [drm:intel_runtime_resume [i915]] Resuming device <7>[ 120.163972] i915 0000:00:02.0: [drm:intel_runtime_resume [i915]] Device resumed <7>[ 120.187227] i915 0000:00:02.0: [drm:intel_runtime_suspend [i915]] Suspending device <7>[ 120.194062] i915 0000:00:02.0: [drm:intel_runtime_suspend [i915]] Device suspended <7>[ 120.218214] i915 0000:00:02.0: [drm:intel_runtime_resume [i915]] Resuming device <7>[ 120.231094] i915 0000:00:02.0: [drm:intel_runtime_resume [i915]] Device resumed <7>[ 120.260703] i915 0000:00:02.0: [drm:intel_runtime_suspend [i915]] Suspending device <7>[ 120.265896] i915 0000:00:02.0: [drm:intel_runtime_suspend [i915]] Device suspended <7>[ 120.356233] i915 0000:00:02.0: [drm:intel_runtime_resume [i915]] Resuming device <7>[ 120.371542] i915 0000:00:02.0: [drm:intel_runtime_resume [i915]] Device resumed <7>[ 120.400452] i915 0000:00:02.0: [drm:intel_runtime_suspend [i915]] Suspending device <7>[ 120.407390] i915 0000:00:02.0: [drm:intel_runtime_suspend [i915]] Device suspended <7>[ 120.494335] i915 0000:00:02.0: [drm:intel_runtime_resume [i915]] Resuming device <7>[ 120.513695] i915 0000:00:02.0: [drm:intel_runtime_resume [i915]] Device resumed <7>[ 120.516329] [IGT] kms_pm_rpm: finished subtest basic-rte, SUCCESS <7>[ 120.625664] i915 0000:00:02.0: [drm:intel_runtime_suspend [i915]] Suspending device <7>[ 120.633575] i915 0000:00:02.0: [drm:intel_runtime_suspend [i915]] Device suspended <7>[ 120.739929] [IGT] kms_pm_rpm: exiting, ret=0 <7>[ 120.830934] [IGT] kms_frontbuffer_tracking: executing <7>[ 120.842744] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 120.843496] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 120.843741] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 120.859182] i915 0000:00:02.0: [drm:intel_runtime_resume [i915]] Resuming device <7>[ 120.871395] i915 0000:00:02.0: [drm:intel_runtime_resume [i915]] Device resumed <7>[ 120.932838] [IGT] kms_frontbuffer_tracking: exiting, ret=77 <7>[ 120.933096] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 121.020631] [IGT] syncobj_timeline: executing <7>[ 121.033034] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 121.033652] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 121.033886] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 121.035867] [IGT] syncobj_timeline: starting subtest signal-array <7>[ 121.036153] [IGT] syncobj_timeline: finished subtest signal-array, SUCCESS <7>[ 121.036380] [IGT] syncobj_timeline: exiting, ret=0 <7>[ 121.036591] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 121.144128] [IGT] syncobj_wait: executing <7>[ 121.154341] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 121.154853] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 121.155165] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 121.157520] [IGT] syncobj_wait: starting subtest multi-wait-signaled <7>[ 121.158438] [IGT] syncobj_wait: finished subtest multi-wait-signaled, SUCCESS <7>[ 121.158792] [IGT] syncobj_wait: exiting, ret=0 <7>[ 121.159192] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 121.263341] [IGT] sw_sync: executing <7>[ 121.274397] [IGT] sw_sync: starting subtest alloc_timeline <7>[ 121.274529] [IGT] sw_sync: finished subtest alloc_timeline, SUCCESS <7>[ 121.274589] [IGT] sw_sync: exiting, ret=0 <7>[ 121.378883] [IGT] kms_frontbuffer_tracking: executing <7>[ 121.396707] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 121.397629] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 121.398006] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 121.446702] [IGT] kms_frontbuffer_tracking: exiting, ret=77 <7>[ 121.446952] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 121.545865] [IGT] vgem_slow: executing <7>[ 121.557405] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 121.558070] [IGT] vgem_slow: starting subtest nohang <7>[ 131.978614] [IGT] vgem_slow: finished subtest nohang, SUCCESS <7>[ 131.979515] [IGT] vgem_slow: exiting, ret=0 <7>[ 132.074301] [IGT] gem_mmap_offset: executing <7>[ 132.088482] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 132.089514] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 132.089927] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 132.090651] [IGT] gem_mmap_offset: starting subtest partial-remap <7>[ 132.090823] [IGT] gem_mmap_offset: starting dynamic subtest smem0 <7>[ 132.094841] [IGT] gem_mmap_offset: finished subtest smem0, SUCCESS <7>[ 132.094910] [IGT] gem_mmap_offset: finished subtest partial-remap, SUCCESS <7>[ 132.095097] [IGT] gem_mmap_offset: exiting, ret=0 <7>[ 132.095269] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 132.244707] [IGT] kms_big_fb: executing <7>[ 132.258721] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 132.259519] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 132.259820] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 132.303613] [IGT] kms_big_fb: exiting, ret=77 <7>[ 132.303900] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 132.408199] [IGT] syncobj_wait: executing <7>[ 132.416213] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 132.416731] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 132.416938] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 132.418530] [IGT] syncobj_wait: starting subtest wait-any-snapshot <7>[ 132.500734] [IGT] syncobj_wait: finished subtest wait-any-snapshot, SUCCESS <7>[ 132.501481] [IGT] syncobj_wait: exiting, ret=0 <7>[ 132.502247] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 132.600045] [IGT] kms_plane: executing <7>[ 132.611333] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 132.611941] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 132.612239] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 132.656452] [IGT] kms_plane: starting subtest plane-panning-bottom-right-suspend <7>[ 132.656545] [IGT] kms_plane: finished subtest plane-panning-bottom-right-suspend, SKIP <7>[ 132.656716] [IGT] kms_plane: exiting, ret=77 <7>[ 132.656949] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 132.760852] [IGT] kms_joiner: executing <7>[ 132.772550] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 132.773332] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 132.773739] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 132.819197] [IGT] kms_joiner: starting subtest invalid-modeset-ultra-joiner <7>[ 132.819302] [IGT] kms_joiner: finished subtest invalid-modeset-ultra-joiner, SKIP <7>[ 132.819446] [IGT] kms_joiner: exiting, ret=77 <7>[ 132.819672] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 132.934065] [IGT] perf_pmu: executing <7>[ 132.945942] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 132.946544] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 132.950301] [IGT] perf_pmu: starting subtest busy-double-start <7>[ 132.950383] [IGT] perf_pmu: starting dynamic subtest rcs0 <7>[ 132.950602] [drm:eb_validate_vma [i915]] EINVAL at eb_validate_vma:508 <7>[ 132.951789] [drm:eb_validate_vma [i915]] EINVAL at eb_validate_vma:508 <7>[ 135.962632] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x0000005c [0x0000005c] <7>[ 136.465592] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x0000005c [0x0000005c] <7>[ 136.507601] [IGT] perf_pmu: finished subtest rcs0, SUCCESS <7>[ 136.507901] [IGT] perf_pmu: starting dynamic subtest bcs0 <7>[ 136.508679] [drm:eb_validate_vma [i915]] EINVAL at eb_validate_vma:508 <7>[ 136.510686] [drm:eb_validate_vma [i915]] EINVAL at eb_validate_vma:508 <7>[ 139.521851] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x0000005c [0x0000005c] <7>[ 140.024565] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x0000005c [0x0000005c] <7>[ 140.072633] [IGT] perf_pmu: finished subtest bcs0, SUCCESS <7>[ 140.072944] [IGT] perf_pmu: starting dynamic subtest vcs0 <7>[ 140.073810] [drm:eb_validate_vma [i915]] EINVAL at eb_validate_vma:508 <7>[ 140.075949] [drm:eb_validate_vma [i915]] EINVAL at eb_validate_vma:508 <7>[ 143.082992] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x0000005c [0x0000005c] <7>[ 143.586257] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x0000005c [0x0000005c] <7>[ 143.628424] [IGT] perf_pmu: finished subtest vcs0, SUCCESS <7>[ 143.628708] [IGT] perf_pmu: starting dynamic subtest vecs0 <7>[ 143.629392] [drm:eb_validate_vma [i915]] EINVAL at eb_validate_vma:508 <7>[ 143.631594] [drm:eb_validate_vma [i915]] EINVAL at eb_validate_vma:508 <7>[ 146.642235] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x0000005c [0x0000005c] <7>[ 147.144807] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x0000005c [0x0000005c] <7>[ 147.188657] [IGT] perf_pmu: finished subtest vecs0, SUCCESS <7>[ 147.189080] [IGT] perf_pmu: finished subtest busy-double-start, SUCCESS <7>[ 147.189902] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 147.192641] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 147.194660] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x0000005c [0x0000005c] <7>[ 147.194964] [IGT] perf_pmu: exiting, ret=0 <7>[ 147.290505] [IGT] gem_partial_pwrite_pread: executing <7>[ 147.302811] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 147.303458] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 147.303707] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 147.304191] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 147.307179] [IGT] gem_partial_pwrite_pread: exiting, ret=77 <7>[ 147.307351] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 147.413353] [IGT] kms_cursor_legacy: executing <7>[ 147.421613] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 147.422154] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 147.422368] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 147.466897] [IGT] kms_cursor_legacy: exiting, ret=77 <7>[ 147.467407] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 147.617518] [IGT] gem_lmem_swapping: executing <7>[ 147.627993] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 147.628551] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 147.631079] [IGT] gem_lmem_swapping: exiting, ret=77 <7>[ 147.731769] [IGT] gem_exec_balancer: executing <7>[ 147.749665] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 147.750594] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 147.750961] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 147.751624] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 147.759918] [IGT] gem_exec_balancer: starting subtest invalid-balancer <7>[ 147.796326] i915 0000:00:02.0: [drm:set_proto_ctx_engines_balance [i915]] Invalid placement[1], already occupied <7>[ 147.796482] i915 0000:00:02.0: [drm:set_proto_ctx_engines_balance [i915]] Invalid placement[1], already occupied <7>[ 147.796612] i915 0000:00:02.0: [drm:set_proto_ctx_engines_balance [i915]] Invalid placement value, 2 >= 2 <7>[ 147.796768] i915 0000:00:02.0: [drm:set_proto_ctx_engines_balance [i915]] Invalid placement[0], already occupied <7>[ 147.835531] i915 0000:00:02.0: [drm:set_proto_ctx_engines_balance [i915]] Invalid placement[1], already occupied <7>[ 147.835676] i915 0000:00:02.0: [drm:set_proto_ctx_engines_balance [i915]] Invalid placement[1], already occupied <7>[ 147.835806] i915 0000:00:02.0: [drm:set_proto_ctx_engines_balance [i915]] Invalid placement value, 2 >= 2 <7>[ 147.835962] i915 0000:00:02.0: [drm:set_proto_ctx_engines_balance [i915]] Invalid placement[0], already occupied <7>[ 147.874251] i915 0000:00:02.0: [drm:set_proto_ctx_engines_balance [i915]] Invalid placement[1], already occupied <7>[ 147.874407] i915 0000:00:02.0: [drm:set_proto_ctx_engines_balance [i915]] Invalid placement[1], already occupied <7>[ 147.874537] i915 0000:00:02.0: [drm:set_proto_ctx_engines_balance [i915]] Invalid placement value, 2 >= 2 <7>[ 147.874696] i915 0000:00:02.0: [drm:set_proto_ctx_engines_balance [i915]] Invalid placement[0], already occupied <7>[ 147.913495] i915 0000:00:02.0: [drm:set_proto_ctx_engines_balance [i915]] Invalid placement[1], already occupied <7>[ 147.913643] i915 0000:00:02.0: [drm:set_proto_ctx_engines_balance [i915]] Invalid placement[1], already occupied <7>[ 147.913775] i915 0000:00:02.0: [drm:set_proto_ctx_engines_balance [i915]] Invalid placement value, 2 >= 2 <7>[ 147.913931] i915 0000:00:02.0: [drm:set_proto_ctx_engines_balance [i915]] Invalid placement[0], already occupied <7>[ 148.980571] [IGT] gem_exec_balancer: finished subtest invalid-balancer, SUCCESS <7>[ 149.090542] i915 0000:00:02.0: [drm:error_state_write [i915]] Resetting error state <7>[ 149.090817] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 149.093912] [IGT] gem_exec_balancer: exiting, ret=0 <7>[ 149.094681] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 149.183351] [IGT] kms_scaling_modes: executing <7>[ 149.201816] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 149.202857] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 149.203291] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 149.248240] [IGT] kms_scaling_modes: exiting, ret=77 <7>[ 149.248472] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 149.354724] [IGT] kms_flip: executing <7>[ 149.368956] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 149.369771] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 149.370135] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 149.419257] [IGT] kms_flip: starting subtest wf_vblank-ts-check-interruptible <7>[ 149.419944] [IGT] kms_flip: finished subtest wf_vblank-ts-check-interruptible, SKIP <7>[ 149.422348] [IGT] kms_flip: exiting, ret=77 <7>[ 149.422628] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 149.532737] [IGT] sw_sync: executing <7>[ 149.548932] [IGT] sw_sync: starting subtest sync_multi_consumer_producer <7>[ 149.827771] [IGT] sw_sync: finished subtest sync_multi_consumer_producer, SUCCESS <7>[ 149.827867] [IGT] sw_sync: exiting, ret=0 <7>[ 149.922799] [IGT] kms_pipe_crc_basic: executing <7>[ 149.937203] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 149.937900] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 149.938229] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 149.982937] [IGT] kms_pipe_crc_basic: exiting, ret=77 <7>[ 149.983350] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 150.065287] [IGT] i915_pm_rps: executing <7>[ 150.080198] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 150.080708] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 150.080913] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 150.081396] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 150.086874] [IGT] i915_pm_rps: starting subtest thresholds <7>[ 150.087107] [IGT] i915_pm_rps: starting dynamic subtest gt0 <7>[ 150.087326] [drm:eb_validate_vma [i915]] EINVAL at eb_validate_vma:508 <7>[ 160.130776] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x0000005c [0x0000005c] <7>[ 160.179425] [IGT] i915_pm_rps: finished subtest gt0, SUCCESS <7>[ 160.179546] [IGT] i915_pm_rps: finished subtest thresholds, SUCCESS <7>[ 160.179696] [IGT] i915_pm_rps: exiting, ret=0 <7>[ 160.181816] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 160.277507] [IGT] kms_frontbuffer_tracking: executing <7>[ 160.289429] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 160.290057] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 160.290350] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 160.337665] [IGT] kms_frontbuffer_tracking: exiting, ret=77 <7>[ 160.337904] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 160.441461] [IGT] gen9_exec_parse: executing <7>[ 160.450584] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 160.451151] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 160.451365] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 160.451739] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 160.455019] [IGT] gen9_exec_parse: exiting, ret=77 <7>[ 160.455229] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 160.565792] [IGT] kms_frontbuffer_tracking: executing <7>[ 160.579998] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 160.580698] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 160.580996] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 160.629143] [IGT] kms_frontbuffer_tracking: exiting, ret=77 <7>[ 160.629374] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 160.744597] [IGT] kms_hdr: executing <7>[ 160.750581] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 160.751187] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 160.751400] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 160.795476] [IGT] kms_hdr: exiting, ret=77 <7>[ 160.795720] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 160.901167] [IGT] gem_mmap_wc: executing <7>[ 160.919404] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 160.920284] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 160.920647] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 160.921555] [IGT] gem_mmap_wc: starting subtest set-cache-level <7>[ 160.921865] [IGT] gem_mmap_wc: finished subtest set-cache-level, SKIP <7>[ 160.922499] [IGT] gem_mmap_wc: exiting, ret=77 <7>[ 160.922772] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 161.056884] [IGT] gem_exec_reloc: executing <7>[ 161.068666] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 161.069345] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 161.069590] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 161.070058] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 161.072986] [drm:eb_validate_vma [i915]] EINVAL at eb_validate_vma:508 <7>[ 161.073260] [IGT] gem_exec_reloc: exiting, ret=77 <7>[ 161.073406] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 161.210985] [IGT] kms_frontbuffer_tracking: executing <7>[ 161.223630] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 161.224364] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 161.224639] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 161.270914] [IGT] kms_frontbuffer_tracking: exiting, ret=77 <7>[ 161.271166] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 161.369588] [IGT] kms_addfb_basic: executing <7>[ 161.384223] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 161.384841] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 161.385121] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 161.429488] [IGT] kms_addfb_basic: starting subtest addfb25-x-tiled-mismatch-legacy <7>[ 161.429590] [IGT] kms_addfb_basic: finished subtest addfb25-x-tiled-mismatch-legacy, SUCCESS <7>[ 161.429881] [IGT] kms_addfb_basic: exiting, ret=0 <7>[ 161.430135] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 161.570981] [IGT] kms_flip: executing <7>[ 161.578904] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 161.579481] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 161.579685] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 161.627585] [IGT] kms_flip: starting subtest 2x-plain-flip <7>[ 161.628139] [IGT] kms_flip: finished subtest 2x-plain-flip, SKIP <7>[ 161.633885] [IGT] kms_flip: exiting, ret=77 <7>[ 161.634218] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 161.756245] [IGT] gem_ctx_persistence: executing <7>[ 161.770458] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 161.771149] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 161.771411] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 161.771872] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 161.775718] [IGT] gem_ctx_persistence: starting subtest legacy-engines-hostile <7>[ 161.775941] [IGT] gem_ctx_persistence: starting dynamic subtest render <7>[ 161.776006] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 161.776645] [drm:eb_validate_vma [i915]] EINVAL at eb_validate_vma:508 <5>[ 161.834650] i915 0000:00:02.0: [drm] Resetting rcs0 for preemption time out <6>[ 161.842986] i915 0000:00:02.0: [drm] GPU HANG: ecode 12:1:e75ffefe, in gem_ctx_persist [2372] <6>[ 161.842997] i915 0000:00:02.0: [drm] GPU error state saved to /sys/class/drm/card0/error <7>[ 161.845341] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x0000005c [0x0000005c] <7>[ 161.880658] [IGT] gem_ctx_persistence: finished subtest render, SUCCESS <7>[ 161.881751] [IGT] gem_ctx_persistence: starting dynamic subtest bsd <7>[ 161.882143] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 161.884797] [drm:eb_validate_vma [i915]] EINVAL at eb_validate_vma:508 <5>[ 161.944392] i915 0000:00:02.0: [drm] Resetting vcs0 for preemption time out <6>[ 161.947485] i915 0000:00:02.0: [drm] GPU HANG: ecode 12:4:277ffefe, in gem_ctx_persist [2372] <7>[ 161.947993] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x0000005c [0x0000005c] <7>[ 161.994561] [IGT] gem_ctx_persistence: finished subtest bsd, SUCCESS <7>[ 161.995827] [IGT] gem_ctx_persistence: starting dynamic subtest blt <7>[ 161.996244] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 161.998945] [drm:eb_validate_vma [i915]] EINVAL at eb_validate_vma:508 <5>[ 162.059611] i915 0000:00:02.0: [drm] Resetting bcs0 for preemption time out <6>[ 162.063656] i915 0000:00:02.0: [drm] GPU HANG: ecode 12:2:18800102, in gem_ctx_persist [2372] <7>[ 162.065366] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x0000005c [0x0000005c] <7>[ 162.110502] [IGT] gem_ctx_persistence: finished subtest blt, SUCCESS <7>[ 162.111598] [IGT] gem_ctx_persistence: starting dynamic subtest vebox <7>[ 162.111934] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 162.114715] [drm:eb_validate_vma [i915]] EINVAL at eb_validate_vma:508 <5>[ 162.174504] i915 0000:00:02.0: [drm] Resetting vecs0 for preemption time out <6>[ 162.178595] i915 0000:00:02.0: [drm] GPU HANG: ecode 12:8:277ffefe, in gem_ctx_persist [2372] <7>[ 162.180252] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x0000005c [0x0000005c] <7>[ 162.224476] [IGT] gem_ctx_persistence: finished subtest vebox, SUCCESS <7>[ 162.224808] [IGT] gem_ctx_persistence: finished subtest legacy-engines-hostile, SUCCESS <7>[ 162.228597] [IGT] gem_ctx_persistence: exiting, ret=0 <7>[ 162.229335] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 162.331496] [IGT] kms_frontbuffer_tracking: executing <7>[ 162.345734] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 162.346567] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 162.346857] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 162.391162] [IGT] kms_frontbuffer_tracking: exiting, ret=77 <7>[ 162.391387] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 162.487198] [IGT] kms_frontbuffer_tracking: executing <7>[ 162.498751] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 162.499426] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 162.499675] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 162.544550] [IGT] kms_frontbuffer_tracking: exiting, ret=77 <7>[ 162.544787] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 162.640938] [IGT] gem_exec_store: executing <7>[ 162.659178] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 162.660154] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 162.660604] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 162.661577] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 162.677935] [IGT] gem_exec_store: starting subtest dword <7>[ 162.678162] [IGT] gem_exec_store: starting dynamic subtest rcs0 <7>[ 162.678322] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x0000005c [0x0000005c] <7>[ 162.680201] [drm:eb_validate_vma [i915]] EINVAL at eb_validate_vma:508 <7>[ 162.681848] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x0000005c [0x0000005c] <7>[ 162.724888] [IGT] gem_exec_store: finished subtest rcs0, SUCCESS <7>[ 162.725247] [IGT] gem_exec_store: starting dynamic subtest bcs0 <7>[ 162.725554] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x0000005c [0x0000005c] <7>[ 162.726988] [drm:eb_validate_vma [i915]] EINVAL at eb_validate_vma:508 <7>[ 162.731950] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x0000005c [0x0000005c] <7>[ 162.745797] [IGT] gem_exec_store: finished subtest bcs0, SUCCESS <7>[ 162.746113] [IGT] gem_exec_store: starting dynamic subtest vcs0 <7>[ 162.746388] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x0000005c [0x0000005c] <7>[ 162.747636] [drm:eb_validate_vma [i915]] EINVAL at eb_validate_vma:508 <7>[ 162.751330] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x0000005c [0x0000005c] <7>[ 162.762632] [IGT] gem_exec_store: finished subtest vcs0, SUCCESS <7>[ 162.762767] [IGT] gem_exec_store: starting dynamic subtest vecs0 <7>[ 162.762917] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x0000005c [0x0000005c] <7>[ 162.763661] [drm:eb_validate_vma [i915]] EINVAL at eb_validate_vma:508 <7>[ 162.766785] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x0000005c [0x0000005c] <7>[ 162.780527] [IGT] gem_exec_store: finished subtest vecs0, SUCCESS <7>[ 162.780679] [IGT] gem_exec_store: finished subtest dword, SUCCESS <7>[ 162.888339] [IGT] gem_exec_store: exiting, ret=0 <7>[ 162.888536] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 162.981578] [IGT] kms_big_fb: executing <7>[ 162.995890] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 162.996678] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 162.996881] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 163.039745] [IGT] kms_big_fb: exiting, ret=77 <7>[ 163.040046] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 163.137754] [IGT] syncobj_timeline: executing <7>[ 163.149314] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 163.149828] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 163.150045] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 163.151321] [IGT] syncobj_timeline: starting subtest etime-multi-wait-all-for-submit-available-unsubmitted <7>[ 163.256717] [IGT] syncobj_timeline: finished subtest etime-multi-wait-all-for-submit-available-unsubmitted, SUCCESS <7>[ 163.257644] [IGT] syncobj_timeline: exiting, ret=0 <7>[ 163.258456] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 163.355087] [IGT] dmabuf: executing <7>[ 163.366743] [IGT] dmabuf: starting subtest all-tests <7>[ 163.366823] [IGT] dmabuf: starting dynamic subtest sanitycheck <6>[ 163.369402] dma-buf: Running sanitycheck <7>[ 163.442978] [IGT] dmabuf: finished subtest sanitycheck, SUCCESS <7>[ 163.443610] [IGT] dmabuf: starting dynamic subtest dma_fence <6>[ 163.450666] dma-buf: Running dma_fence <6>[ 163.450676] sizeof(dma_fence)=64 <6>[ 163.451722] dma-buf: Running dma_fence/sanitycheck <6>[ 163.452594] dma-buf: Running dma_fence/test_signaling <6>[ 163.452637] dma-buf: Running dma_fence/test_add_callback <6>[ 163.452670] dma-buf: Running dma_fence/test_late_add_callback <6>[ 163.452705] dma-buf: Running dma_fence/test_rm_callback <6>[ 163.452738] dma-buf: Running dma_fence/test_late_rm_callback <6>[ 163.452772] dma-buf: Running dma_fence/test_status <6>[ 163.452805] dma-buf: Running dma_fence/test_error <6>[ 163.452837] dma-buf: Running dma_fence/test_wait <6>[ 163.452914] dma-buf: Running dma_fence/test_wait_timeout <6>[ 163.456503] dma-buf: Running dma_fence/test_stub <6>[ 163.456510] dma-buf: Running dma_fence/race_signal_callback <6>[ 163.507087] thread_signal_callback[0] completed 9572 passes, 3 misses <6>[ 163.507723] thread_signal_callback[1] completed 9578 passes, 13 misses <6>[ 163.559059] thread_signal_callback[0] completed 10278 passes, 10277 misses <6>[ 163.559079] thread_signal_callback[1] completed 10281 passes, 10278 misses <7>[ 163.683949] [IGT] dmabuf: finished subtest dma_fence, SUCCESS <7>[ 163.684473] [IGT] dmabuf: starting dynamic subtest dma_fence_chain <6>[ 163.691534] dma-buf: Running dma_fence_chain <6>[ 163.691544] sizeof(dma_fence_chain)=184 <6>[ 163.692521] dma-buf: Running dma_fence_chain/sanitycheck <6>[ 163.693714] dma-buf: Running dma_fence_chain/find_seqno <6>[ 163.697562] dma-buf: Running dma_fence_chain/find_signaled <6>[ 163.697730] dma-buf: Running dma_fence_chain/find_out_of_order <6>[ 163.697952] dma-buf: Running dma_fence_chain/find_gap <6>[ 163.700644] dma-buf: Running dma_fence_chain/find_race <6>[ 168.841613] Completed 4095 cycles <6>[ 168.852522] dma-buf: Running dma_fence_chain/signal_forward <6>[ 168.853198] dma-buf: Running dma_fence_chain/signal_backward <6>[ 168.854665] dma-buf: Running dma_fence_chain/wait_forward <6>[ 168.900398] dma-buf: Running dma_fence_chain/wait_backward <6>[ 172.352546] dma-buf: Running dma_fence_chain/wait_random <7>[ 172.519440] [IGT] dmabuf: finished subtest dma_fence_chain, SUCCESS <7>[ 172.519533] [IGT] dmabuf: starting dynamic subtest dma_fence_unwrap <6>[ 172.521277] dma-buf: Running dma_fence_unwrap <6>[ 172.521279] dma-buf: Running dma_fence_unwrap/sanitycheck <6>[ 172.521346] dma-buf: Running dma_fence_unwrap/unwrap_array <6>[ 172.521372] dma-buf: Running dma_fence_unwrap/unwrap_chain <6>[ 172.521389] dma-buf: Running dma_fence_unwrap/unwrap_chain_array <6>[ 172.521416] dma-buf: Running dma_fence_unwrap/unwrap_merge <6>[ 172.521440] dma-buf: Running dma_fence_unwrap/unwrap_merge_duplicate <6>[ 172.521451] dma-buf: Running dma_fence_unwrap/unwrap_merge_seqno <6>[ 172.521476] dma-buf: Running dma_fence_unwrap/unwrap_merge_order <6>[ 172.521511] dma-buf: Running dma_fence_unwrap/unwrap_merge_complex <6>[ 172.521552] dma-buf: Running dma_fence_unwrap/unwrap_merge_complex_seqno <7>[ 172.604956] [IGT] dmabuf: finished subtest dma_fence_unwrap, SUCCESS <7>[ 172.605401] [IGT] dmabuf: starting dynamic subtest dma_resv <6>[ 172.610776] dma-buf: Running dma_resv <6>[ 172.610779] dma-buf: Running dma_resv/sanitycheck <6>[ 172.611015] dma-buf: Running dma_resv/test_signaling <6>[ 172.611150] dma-buf: Running dma_resv/test_for_each <6>[ 172.611166] dma-buf: Running dma_resv/test_for_each_unlocked <6>[ 172.611178] dma-buf: Running dma_resv/test_get_fences <6>[ 172.611198] dma-buf: Running dma_resv/sanitycheck <6>[ 172.611205] dma-buf: Running dma_resv/test_signaling <6>[ 172.611215] dma-buf: Running dma_resv/test_for_each <6>[ 172.611231] dma-buf: Running dma_resv/test_for_each_unlocked <6>[ 172.611241] dma-buf: Running dma_resv/test_get_fences <6>[ 172.611255] dma-buf: Running dma_resv/sanitycheck <6>[ 172.611261] dma-buf: Running dma_resv/test_signaling <6>[ 172.611271] dma-buf: Running dma_resv/test_for_each <6>[ 172.611280] dma-buf: Running dma_resv/test_for_each_unlocked <6>[ 172.611291] dma-buf: Running dma_resv/test_get_fences <6>[ 172.611310] dma-buf: Running dma_resv/sanitycheck <6>[ 172.611315] dma-buf: Running dma_resv/test_signaling <6>[ 172.611324] dma-buf: Running dma_resv/test_for_each <6>[ 172.611332] dma-buf: Running dma_resv/test_for_each_unlocked <6>[ 172.611341] dma-buf: Running dma_resv/test_get_fences <7>[ 172.696815] [IGT] dmabuf: finished subtest dma_resv, SUCCESS <7>[ 172.697315] [IGT] dmabuf: finished subtest all-tests, SUCCESS <7>[ 172.697812] [IGT] dmabuf: exiting, ret=0 <7>[ 172.803976] [IGT] drm_read: executing <7>[ 172.818276] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 172.818895] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 172.819184] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 172.865144] [IGT] drm_read: exiting, ret=77 <7>[ 172.865430] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 172.956937] [IGT] gem_exec_params: executing <7>[ 172.968468] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 172.969017] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 172.969313] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 172.969732] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 172.972695] [IGT] gem_exec_params: starting subtest invalid-bsd2-flag-on-render <7>[ 172.972753] i915 0000:00:02.0: [drm:i915_gem_do_execbuffer [i915]] execbuf with non bsd ring but with invalid bsd dispatch flags: -2147467263 <7>[ 172.972914] [IGT] gem_exec_params: finished subtest invalid-bsd2-flag-on-render, SUCCESS <7>[ 172.973103] [IGT] gem_exec_params: exiting, ret=0 <7>[ 172.973271] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 173.088700] [IGT] kms_frontbuffer_tracking: executing <7>[ 173.106857] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 173.107781] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 173.108170] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 173.154601] [IGT] kms_frontbuffer_tracking: exiting, ret=77 <7>[ 173.154830] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 173.260027] [IGT] syncobj_wait: executing <7>[ 173.274216] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 173.274911] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 173.275272] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 173.277070] [IGT] syncobj_wait: starting subtest single-wait-for-submit-signaled <7>[ 173.277407] [IGT] syncobj_wait: finished subtest single-wait-for-submit-signaled, SUCCESS <7>[ 173.277622] [IGT] syncobj_wait: exiting, ret=0 <7>[ 173.277844] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 173.389309] [IGT] kms_psr: executing <7>[ 173.404376] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 173.405312] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 173.405937] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 173.451749] [IGT] kms_psr: exiting, ret=77 <7>[ 173.451981] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 173.557824] [IGT] dumb_buffer: executing <7>[ 173.571827] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 173.572630] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 173.572944] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 173.573678] [IGT] dumb_buffer: starting subtest map-invalid-size <7>[ 173.573939] [IGT] dumb_buffer: finished subtest map-invalid-size, SUCCESS <7>[ 173.574795] [IGT] dumb_buffer: exiting, ret=0 <7>[ 173.575014] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 173.690425] [IGT] gem_exec_params: executing <7>[ 173.700303] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 173.700854] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 173.701079] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 173.701471] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 173.704198] [IGT] gem_exec_params: starting subtest invalid-batch-start-offset <7>[ 173.704343] [drm:i915_gem_execbuffer2_ioctl [i915]] EINVAL at i915_gem_check_execbuffer:2215 <7>[ 173.704466] [drm:i915_gem_execbuffer2_ioctl [i915]] EINVAL at i915_gem_check_execbuffer:2215 <7>[ 173.704584] [drm:i915_gem_execbuffer2_ioctl [i915]] EINVAL at i915_gem_check_execbuffer:2215 <7>[ 173.704826] i915 0000:00:02.0: [drm:eb_add_vma [i915]] Attempting to use out-of-bounds batch <7>[ 173.704940] [drm:eb_add_vma [i915]] EINVAL at eb_add_vma:612 <7>[ 173.705249] i915 0000:00:02.0: [drm:eb_add_vma [i915]] Attempting to use out-of-bounds batch <7>[ 173.705370] [drm:eb_add_vma [i915]] EINVAL at eb_add_vma:612 <7>[ 173.705545] i915 0000:00:02.0: [drm:eb_add_vma [i915]] Attempting to use out-of-bounds batch <7>[ 173.705664] [drm:eb_add_vma [i915]] EINVAL at eb_add_vma:612 <7>[ 173.705836] i915 0000:00:02.0: [drm:eb_add_vma [i915]] Attempting to use out-of-bounds batch <7>[ 173.705955] [drm:eb_add_vma [i915]] EINVAL at eb_add_vma:612 <7>[ 173.706433] [IGT] gem_exec_params: finished subtest invalid-batch-start-offset, SUCCESS <7>[ 173.706587] [IGT] gem_exec_params: exiting, ret=0 <7>[ 173.706743] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 173.861082] [IGT] kms_frontbuffer_tracking: executing <7>[ 173.872840] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 173.873477] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 173.873730] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 173.920493] [IGT] kms_frontbuffer_tracking: exiting, ret=77 <7>[ 173.920728] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 174.027190] [IGT] i915_pm_rc6_residency: executing <7>[ 174.037045] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 174.037637] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 174.037871] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 174.038259] [IGT] i915_pm_rc6_residency: starting subtest rc6-fence <7>[ 174.038393] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 174.040867] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x0000005c [0x0000005c] <7>[ 174.041065] [IGT] i915_pm_rc6_residency: starting dynamic subtest gt0 <7>[ 174.042199] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x00000040 [0x00000040] <7>[ 177.214284] [drm:eb_validate_vma [i915]] EINVAL at eb_validate_vma:508 <7>[ 180.221672] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x0000005c [0x0000005c] <7>[ 183.260598] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x0000005c [0x0000005c] <7>[ 186.288285] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x0000005c [0x0000005c] <7>[ 189.313178] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x0000005c [0x0000005c] <7>[ 189.329679] [IGT] i915_pm_rc6_residency: finished subtest gt0, SUCCESS <7>[ 189.330236] [IGT] i915_pm_rc6_residency: finished subtest rc6-fence, SUCCESS <7>[ 189.331240] [IGT] i915_pm_rc6_residency: exiting, ret=0 <7>[ 189.331963] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 189.420790] [IGT] kms_frontbuffer_tracking: executing <7>[ 189.438922] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 189.439862] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 189.440285] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 189.487442] [IGT] kms_frontbuffer_tracking: exiting, ret=77 <7>[ 189.487677] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 189.577607] [IGT] api_intel_allocator: executing <7>[ 189.583558] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 189.584093] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 189.584296] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 189.584625] [IGT] api_intel_allocator: starting subtest gem-pool <7>[ 189.584848] [drm:eb_validate_vma [i915]] EINVAL at eb_validate_vma:508 <7>[ 189.588884] [IGT] api_intel_allocator: finished subtest gem-pool, SUCCESS <7>[ 189.589166] [IGT] api_intel_allocator: exiting, ret=0 <7>[ 189.589332] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 189.719886] [IGT] kms_cursor_edge_walk: executing <7>[ 189.731538] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 189.732199] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 189.732469] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 189.776106] [IGT] kms_cursor_edge_walk: exiting, ret=77 <7>[ 189.776327] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 189.866639] [IGT] kms_cursor_legacy: executing <7>[ 189.877926] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 189.878611] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 189.878852] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 189.923121] [IGT] kms_cursor_legacy: exiting, ret=77 <7>[ 189.923419] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 190.060216] [IGT] gem_exec_endless: executing <7>[ 190.067586] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 190.068184] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 190.068391] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 190.068763] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 190.083983] [IGT] gem_exec_endless: starting subtest dispatch <7>[ 190.084106] [IGT] gem_exec_endless: starting dynamic subtest rcs0 <7>[ 190.086710] [IGT] gem_exec_endless: finished subtest rcs0, SUCCESS <7>[ 190.086776] [IGT] gem_exec_endless: starting dynamic subtest bcs0 <7>[ 190.088924] [IGT] gem_exec_endless: finished subtest bcs0, SUCCESS <7>[ 190.089260] [IGT] gem_exec_endless: starting dynamic subtest vcs0 <7>[ 190.091697] [IGT] gem_exec_endless: finished subtest vcs0, SUCCESS <7>[ 190.091758] [IGT] gem_exec_endless: starting dynamic subtest vecs0 <7>[ 190.093895] [IGT] gem_exec_endless: finished subtest vecs0, SUCCESS <7>[ 190.093992] [IGT] gem_exec_endless: finished subtest dispatch, SUCCESS <7>[ 190.095028] [IGT] gem_exec_endless: exiting, ret=0 <7>[ 190.095284] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 190.285726] [IGT] kms_ccs: executing <7>[ 190.297584] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 190.298374] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 190.298629] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 190.344419] [IGT] kms_ccs: exiting, ret=77 <7>[ 190.344704] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 190.433606] [IGT] kms_frontbuffer_tracking: executing <7>[ 190.445429] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 190.446036] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 190.446266] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 190.492998] [IGT] kms_frontbuffer_tracking: exiting, ret=77 <7>[ 190.493240] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 190.580739] [IGT] kms_color: executing <7>[ 190.592418] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 190.594160] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 190.594432] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 190.638237] [IGT] kms_color: starting subtest legacy-gamma-reset <7>[ 190.638334] [IGT] kms_color: finished subtest legacy-gamma-reset, SKIP <7>[ 190.638505] [IGT] kms_color: exiting, ret=77 <7>[ 190.638780] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 190.739372] [IGT] kms_async_flips: executing <7>[ 190.751370] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 190.752122] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 190.752559] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 190.801148] [IGT] kms_async_flips: exiting, ret=77 <7>[ 190.801424] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 190.891937] [IGT] perf: executing <7>[ 190.914643] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 190.915203] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 190.920097] [IGT] perf: starting subtest disabled-read-error <7>[ 190.924777] i915 0000:00:02.0: [drm:i915_oa_stream_init.isra.0 [i915]] opening stream oa config uuid=74dbc739-d871-41b5-be7b-fb547ac5bec9 <7>[ 190.929972] i915 0000:00:02.0: [drm:i915_oa_stream_init.isra.0 [i915]] opening stream oa config uuid=74dbc739-d871-41b5-be7b-fb547ac5bec9 <7>[ 190.940497] [IGT] perf: finished subtest disabled-read-error, SUCCESS <7>[ 190.940784] [IGT] perf: exiting, ret=0 <7>[ 191.021200] [IGT] kms_psr: executing <7>[ 191.029016] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 191.029533] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 191.029737] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 191.076549] [IGT] kms_psr: exiting, ret=77 <7>[ 191.076791] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 191.165401] [IGT] syncobj_timeline: executing <7>[ 191.173052] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 191.173595] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 191.173796] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 191.175533] [IGT] syncobj_timeline: starting subtest etime-single-wait-submitted <7>[ 191.280442] [IGT] syncobj_timeline: finished subtest etime-single-wait-submitted, SUCCESS <7>[ 191.281376] [IGT] syncobj_timeline: exiting, ret=0 <7>[ 191.282187] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 191.375231] [IGT] syncobj_timeline: executing <7>[ 191.393233] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 191.394154] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 191.394523] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 191.396428] [IGT] syncobj_timeline: starting subtest single-wait-all-signaled <7>[ 191.396770] [IGT] syncobj_timeline: finished subtest single-wait-all-signaled, SUCCESS <7>[ 191.397043] [IGT] syncobj_timeline: exiting, ret=0 <7>[ 191.397261] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 191.491375] [IGT] kms_vblank: executing <7>[ 191.499643] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 191.500286] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 191.500498] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 191.545051] [IGT] kms_vblank: exiting, ret=77 <7>[ 191.545298] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 191.641076] [IGT] gem_exec_schedule: executing <7>[ 191.654283] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 191.654922] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 191.655211] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 191.655950] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 191.662027] [IGT] gem_exec_schedule: starting subtest implicit-write-read <7>[ 191.662134] [IGT] gem_exec_schedule: starting dynamic subtest rcs0 <7>[ 191.662310] [drm:eb_validate_vma [i915]] EINVAL at eb_validate_vma:508 <7>[ 191.668101] [drm:eb_validate_vma [i915]] EINVAL at eb_validate_vma:508 <7>[ 191.669136] [drm:eb_validate_vma [i915]] EINVAL at eb_validate_vma:508 <7>[ 191.670186] [drm:eb_validate_vma [i915]] EINVAL at eb_validate_vma:508 <7>[ 191.671437] [drm:eb_validate_vma [i915]] EINVAL at eb_validate_vma:508 <7>[ 191.672459] [drm:eb_validate_vma [i915]] EINVAL at eb_validate_vma:508 <7>[ 191.673422] [drm:eb_validate_vma [i915]] EINVAL at eb_validate_vma:508 <7>[ 191.674409] [drm:eb_validate_vma [i915]] EINVAL at eb_validate_vma:508 <7>[ 191.675385] [drm:eb_validate_vma [i915]] EINVAL at eb_validate_vma:508 <7>[ 191.676898] [drm:eb_validate_vma [i915]] EINVAL at eb_validate_vma:508 <7>[ 191.677858] [drm:eb_validate_vma [i915]] EINVAL at eb_validate_vma:508 <7>[ 191.678830] [drm:eb_validate_vma [i915]] EINVAL at eb_validate_vma:508 <7>[ 191.679914] [drm:eb_validate_vma [i915]] EINVAL at eb_validate_vma:508 <7>[ 191.680857] [drm:eb_validate_vma [i915]] EINVAL at eb_validate_vma:508 <7>[ 191.681797] [drm:eb_validate_vma [i915]] EINVAL at eb_validate_vma:508 <7>[ 191.682753] [drm:eb_validate_vma [i915]] EINVAL at eb_validate_vma:508 <7>[ 191.683724] [drm:eb_validate_vma [i915]] EINVAL at eb_validate_vma:508 <7>[ 191.738542] [IGT] gem_exec_schedule: finished subtest rcs0, SUCCESS <7>[ 191.738694] [IGT] gem_exec_schedule: starting dynamic subtest bcs0 <7>[ 191.739702] [drm:eb_validate_vma [i915]] EINVAL at eb_validate_vma:508 <7>[ 191.744649] [drm:eb_validate_vma [i915]] EINVAL at eb_validate_vma:508 <7>[ 191.746153] [drm:eb_validate_vma [i915]] EINVAL at eb_validate_vma:508 <7>[ 191.747408] [drm:eb_validate_vma [i915]] EINVAL at eb_validate_vma:508 <7>[ 191.748513] [drm:eb_validate_vma [i915]] EINVAL at eb_validate_vma:508 <7>[ 191.749771] [drm:eb_validate_vma [i915]] EINVAL at eb_validate_vma:508 <7>[ 191.750746] [drm:eb_validate_vma [i915]] EINVAL at eb_validate_vma:508 <7>[ 191.751791] [drm:eb_validate_vma [i915]] EINVAL at eb_validate_vma:508 <7>[ 191.752779] [drm:eb_validate_vma [i915]] EINVAL at eb_validate_vma:508 <7>[ 191.753797] [drm:eb_validate_vma [i915]] EINVAL at eb_validate_vma:508 <7>[ 191.754802] [drm:eb_validate_vma [i915]] EINVAL at eb_validate_vma:508 <7>[ 191.755970] [drm:eb_validate_vma [i915]] EINVAL at eb_validate_vma:508 <7>[ 191.756950] [drm:eb_validate_vma [i915]] EINVAL at eb_validate_vma:508 <7>[ 191.757883] [drm:eb_validate_vma [i915]] EINVAL at eb_validate_vma:508 <7>[ 191.758864] [drm:eb_validate_vma [i915]] EINVAL at eb_validate_vma:508 <7>[ 191.759786] [drm:eb_validate_vma [i915]] EINVAL at eb_validate_vma:508 <7>[ 191.760800] [drm:eb_validate_vma [i915]] EINVAL at eb_validate_vma:508 <7>[ 191.808539] [IGT] gem_exec_schedule: finished subtest bcs0, SUCCESS <7>[ 191.808698] [IGT] gem_exec_schedule: starting dynamic subtest vcs0 <7>[ 191.809450] [drm:eb_validate_vma [i915]] EINVAL at eb_validate_vma:508 <7>[ 191.814561] [drm:eb_validate_vma [i915]] EINVAL at eb_validate_vma:508 <7>[ 191.816299] [drm:eb_validate_vma [i915]] EINVAL at eb_validate_vma:508 <7>[ 191.817651] [drm:eb_validate_vma [i915]] EINVAL at eb_validate_vma:508 <7>[ 191.818927] [drm:eb_validate_vma [i915]] EINVAL at eb_validate_vma:508 <7>[ 191.819906] [drm:eb_validate_vma [i915]] EINVAL at eb_validate_vma:508 <7>[ 191.821015] [drm:eb_validate_vma [i915]] EINVAL at eb_validate_vma:508 <7>[ 191.822021] [drm:eb_validate_vma [i915]] EINVAL at eb_validate_vma:508 <7>[ 191.822992] [drm:eb_validate_vma [i915]] EINVAL at eb_validate_vma:508 <7>[ 191.824013] [drm:eb_validate_vma [i915]] EINVAL at eb_validate_vma:508 <7>[ 191.824976] [drm:eb_validate_vma [i915]] EINVAL at eb_validate_vma:508 <7>[ 191.825928] [drm:eb_validate_vma [i915]] EINVAL at eb_validate_vma:508 <7>[ 191.826909] [drm:eb_validate_vma [i915]] EINVAL at eb_validate_vma:508 <7>[ 191.827851] [drm:eb_validate_vma [i915]] EINVAL at eb_validate_vma:508 <7>[ 191.828870] [drm:eb_validate_vma [i915]] EINVAL at eb_validate_vma:508 <7>[ 191.829815] [drm:eb_validate_vma [i915]] EINVAL at eb_validate_vma:508 <7>[ 191.831966] [drm:eb_validate_vma [i915]] EINVAL at eb_validate_vma:508 <7>[ 191.881873] [IGT] gem_exec_schedule: finished subtest vcs0, SUCCESS <7>[ 191.882047] [IGT] gem_exec_schedule: starting dynamic subtest vecs0 <7>[ 191.882335] [drm:eb_validate_vma [i915]] EINVAL at eb_validate_vma:508 <7>[ 191.888299] [drm:eb_validate_vma [i915]] EINVAL at eb_validate_vma:508 <7>[ 191.889849] [drm:eb_validate_vma [i915]] EINVAL at eb_validate_vma:508 <7>[ 191.891179] [drm:eb_validate_vma [i915]] EINVAL at eb_validate_vma:508 <7>[ 191.892238] [drm:eb_validate_vma [i915]] EINVAL at eb_validate_vma:508 <7>[ 191.893318] [drm:eb_validate_vma [i915]] EINVAL at eb_validate_vma:508 <7>[ 191.894463] [drm:eb_validate_vma [i915]] EINVAL at eb_validate_vma:508 <7>[ 191.895460] [drm:eb_validate_vma [i915]] EINVAL at eb_validate_vma:508 <7>[ 191.896448] [drm:eb_validate_vma [i915]] EINVAL at eb_validate_vma:508 <7>[ 191.897410] [drm:eb_validate_vma [i915]] EINVAL at eb_validate_vma:508 <7>[ 191.898378] [drm:eb_validate_vma [i915]] EINVAL at eb_validate_vma:508 <7>[ 191.899342] [drm:eb_validate_vma [i915]] EINVAL at eb_validate_vma:508 <7>[ 191.900288] [drm:eb_validate_vma [i915]] EINVAL at eb_validate_vma:508 <7>[ 191.901247] [drm:eb_validate_vma [i915]] EINVAL at eb_validate_vma:508 <7>[ 191.902587] [drm:eb_validate_vma [i915]] EINVAL at eb_validate_vma:508 <7>[ 191.903876] [drm:eb_validate_vma [i915]] EINVAL at eb_validate_vma:508 <7>[ 191.904878] [drm:eb_validate_vma [i915]] EINVAL at eb_validate_vma:508 <7>[ 191.948854] [IGT] gem_exec_schedule: finished subtest vecs0, SUCCESS <7>[ 191.949037] [IGT] gem_exec_schedule: finished subtest implicit-write-read, SUCCESS <7>[ 192.054675] i915 0000:00:02.0: [drm:error_state_write [i915]] Resetting error state <7>[ 192.161045] [IGT] gem_exec_schedule: exiting, ret=0 <7>[ 192.161202] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 192.248629] [IGT] kms_frontbuffer_tracking: executing <7>[ 192.260418] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 192.261070] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 192.261312] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 192.306357] [IGT] kms_frontbuffer_tracking: exiting, ret=77 <7>[ 192.306600] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 192.399364] [IGT] syncobj_wait: executing <7>[ 192.413421] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 192.414625] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 192.415221] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 192.418736] [IGT] syncobj_wait: starting subtest multi-wait-all-for-submit-submitted-signaled <7>[ 192.520452] [IGT] syncobj_wait: finished subtest multi-wait-all-for-submit-submitted-signaled, SUCCESS <7>[ 192.521472] [IGT] syncobj_wait: exiting, ret=0 <7>[ 192.522930] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 192.627587] [IGT] kms_plane_multiple: executing <7>[ 192.639440] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 192.640041] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 192.640276] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 192.687076] [IGT] kms_plane_multiple: exiting, ret=77 <7>[ 192.687313] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 192.777278] [IGT] kms_chamelium_hpd: executing <7>[ 192.787039] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 192.787585] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 192.788259] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 192.833923] [IGT] kms_chamelium_hpd: exiting, ret=77 <7>[ 192.834178] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 192.938313] [IGT] kms_cursor_crc: executing <7>[ 192.946020] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 192.946555] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 192.946772] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 192.989760] [IGT] kms_cursor_crc: exiting, ret=77 <7>[ 192.990009] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 193.093305] [IGT] kms_ccs: executing <7>[ 193.102322] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 193.103137] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 193.103369] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 193.145501] [IGT] kms_ccs: exiting, ret=77 <7>[ 193.145763] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 193.242756] [IGT] perf_pmu: executing <7>[ 193.248823] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 193.249308] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 193.252431] [IGT] perf_pmu: starting subtest all-busy-check-all <7>[ 193.252636] [drm:eb_validate_vma [i915]] EINVAL at eb_validate_vma:508 <7>[ 193.757553] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x0000005c [0x0000005c] <7>[ 193.787189] [IGT] perf_pmu: finished subtest all-busy-check-all, SUCCESS <7>[ 193.787695] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 193.789571] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 193.792991] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x0000005c [0x0000005c] <7>[ 193.793273] [IGT] perf_pmu: exiting, ret=0 <7>[ 193.881171] [IGT] kms_cursor_crc: executing <7>[ 193.895100] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 193.895959] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 193.896462] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 193.944815] [IGT] kms_cursor_crc: exiting, ret=77 <7>[ 193.945030] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 194.042760] [IGT] gem_readwrite: executing <7>[ 194.050231] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 194.050810] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 194.051036] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 194.051450] [IGT] gem_readwrite: exiting, ret=77 <7>[ 194.051599] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 194.167752] [IGT] gem_mmap_gtt: executing <7>[ 194.180974] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 194.181564] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 194.181879] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 194.182336] [IGT] gem_mmap_gtt: starting subtest basic-small-bo-tiledX <7>[ 194.191817] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 194.192210] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x00000070 [0x00000070] <7>[ 194.233953] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x00000070 [0x00000070] <7>[ 194.268920] [IGT] gem_mmap_gtt: finished subtest basic-small-bo-tiledX, SUCCESS <7>[ 194.269423] [IGT] gem_mmap_gtt: exiting, ret=0 <7>[ 194.269787] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 194.418016] [IGT] gem_render_copy: executing <7>[ 194.424196] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 194.424660] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 194.425615] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 194.425950] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 194.431751] [IGT] gem_render_copy: starting subtest y-tiled-to-vebox-x-tiled <7>[ 194.431839] [IGT] gem_render_copy: starting dynamic subtest smem <7>[ 194.432026] [drm:eb_validate_vma [i915]] EINVAL at eb_validate_vma:508 <7>[ 194.545588] [IGT] gem_render_copy: finished subtest smem, SUCCESS <7>[ 194.545691] [IGT] gem_render_copy: finished subtest y-tiled-to-vebox-x-tiled, SUCCESS <7>[ 194.652993] [IGT] gem_render_copy: exiting, ret=0 <7>[ 194.653370] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 194.745617] [IGT] kms_big_fb: executing <7>[ 194.757266] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 194.757887] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 194.758127] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 194.807111] [IGT] kms_big_fb: exiting, ret=77 <7>[ 194.807350] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 194.905826] [IGT] kms_ccs: executing <7>[ 194.920894] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 194.922447] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 194.922870] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 194.973056] [IGT] kms_ccs: exiting, ret=77 <7>[ 194.973335] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 195.068969] [IGT] gem_exec_whisper: executing <7>[ 195.080840] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 195.081368] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 195.081571] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 195.082198] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 195.092329] [IGT] gem_exec_whisper: starting subtest basic-normal-all <7>[ 195.092608] [drm:eb_validate_vma [i915]] EINVAL at eb_validate_vma:508 <7>[ 195.093327] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x0000005c [0x0000005c] <7>[ 196.110810] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x0000005c [0x0000005c] <7>[ 196.123275] [IGT] gem_exec_whisper: finished subtest basic-normal-all, SUCCESS <7>[ 196.234674] [IGT] gem_exec_whisper: exiting, ret=0 <7>[ 196.235372] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 196.334807] [IGT] kms_frontbuffer_tracking: executing <7>[ 196.343912] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 196.344493] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 196.344749] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 196.391201] [IGT] kms_frontbuffer_tracking: exiting, ret=77 <7>[ 196.391439] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc]