<7>[ 60.524674] [IGT] gem_exec_reloc: executing <7>[ 60.543425] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 60.544199] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 60.544524] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 60.545055] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 60.546631] i915 0000:00:02.0: [drm:intel_power_well_enable [i915]] enabling always-on <7>[ 60.550834] [drm:eb_validate_vma [i915]] EINVAL at eb_validate_vma:508 <7>[ 60.551096] [IGT] gem_exec_reloc: exiting, ret=77 <7>[ 60.551276] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 60.584441] i915 0000:00:02.0: [drm:drm_client_dev_restore] fbdev: ret=0 <7>[ 60.653191] i915 0000:00:02.0: [drm:intel_power_well_disable [i915]] disabling always-on <7>[ 60.668158] [IGT] kms_plane_scaling: executing <7>[ 60.683004] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 60.683867] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 60.684930] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 60.689182] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] [CONNECTOR:148:HDMI-A-1] <7>[ 60.689438] i915 0000:00:02.0: [drm:intel_hdmi_detect [i915]] [CONNECTOR:148:HDMI-A-1] <7>[ 60.689639] i915 0000:00:02.0: [drm:intel_power_well_enable [i915]] enabling always-on <7>[ 60.694160] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] [CONNECTOR:148:HDMI-A-1] disconnected <7>[ 60.694439] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] [CONNECTOR:158:HDMI-A-2] <7>[ 60.694443] i915 0000:00:02.0: [drm:intel_hdmi_detect [i915]] [CONNECTOR:158:HDMI-A-2] <7>[ 60.698926] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] [CONNECTOR:158:HDMI-A-2] disconnected <7>[ 60.699235] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] [CONNECTOR:162:DP-1] <7>[ 60.699239] i915 0000:00:02.0: [drm:intel_dp_detect [i915]] [CONNECTOR:162:DP-1] <7>[ 60.703691] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] [CONNECTOR:162:DP-1] disconnected <7>[ 60.703949] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] [CONNECTOR:169:HDMI-A-3] <7>[ 60.703953] i915 0000:00:02.0: [drm:intel_hdmi_detect [i915]] [CONNECTOR:169:HDMI-A-3] <7>[ 60.708430] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] [CONNECTOR:169:HDMI-A-3] disconnected <7>[ 60.708735] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] [CONNECTOR:148:HDMI-A-1] <7>[ 60.708739] i915 0000:00:02.0: [drm:intel_hdmi_detect [i915]] [CONNECTOR:148:HDMI-A-1] <7>[ 60.713703] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] [CONNECTOR:148:HDMI-A-1] disconnected <7>[ 60.713716] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] [CONNECTOR:158:HDMI-A-2] <7>[ 60.713719] i915 0000:00:02.0: [drm:intel_hdmi_detect [i915]] [CONNECTOR:158:HDMI-A-2] <7>[ 60.718769] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] [CONNECTOR:158:HDMI-A-2] disconnected <7>[ 60.718781] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] [CONNECTOR:162:DP-1] <7>[ 60.718784] i915 0000:00:02.0: [drm:intel_dp_detect [i915]] [CONNECTOR:162:DP-1] <7>[ 60.723365] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] [CONNECTOR:162:DP-1] disconnected <7>[ 60.723378] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] [CONNECTOR:169:HDMI-A-3] <7>[ 60.723381] i915 0000:00:02.0: [drm:intel_hdmi_detect [i915]] [CONNECTOR:169:HDMI-A-3] <7>[ 60.727829] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] [CONNECTOR:169:HDMI-A-3] disconnected <7>[ 60.727899] [IGT] kms_plane_scaling: starting subtest planes-unity-scaling-downscale-factor-0-75 <7>[ 60.727978] [IGT] kms_plane_scaling: starting dynamic subtest pipe-A <7>[ 60.728039] [IGT] kms_plane_scaling: finished subtest pipe-A, SKIP <7>[ 60.728090] [IGT] kms_plane_scaling: starting dynamic subtest pipe-B <7>[ 60.728155] [IGT] kms_plane_scaling: finished subtest pipe-B, SKIP <7>[ 60.728224] [IGT] kms_plane_scaling: finished subtest planes-unity-scaling-downscale-factor-0-75, SKIP <7>[ 60.728396] [IGT] kms_plane_scaling: exiting, ret=77 <7>[ 60.728612] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 60.728766] i915 0000:00:02.0: [drm:drm_client_dev_restore] fbdev: ret=0 <7>[ 60.829243] i915 0000:00:02.0: [drm:intel_power_well_disable [i915]] disabling always-on <7>[ 60.903036] [IGT] kms_debugfs: executing <7>[ 60.915075] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 60.915736] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 60.915986] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 60.919431] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] [CONNECTOR:148:HDMI-A-1] <7>[ 60.919438] i915 0000:00:02.0: [drm:intel_hdmi_detect [i915]] [CONNECTOR:148:HDMI-A-1] <7>[ 60.919578] i915 0000:00:02.0: [drm:intel_power_well_enable [i915]] enabling always-on <7>[ 60.924034] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] [CONNECTOR:148:HDMI-A-1] disconnected <7>[ 60.924322] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] [CONNECTOR:158:HDMI-A-2] <7>[ 60.924327] i915 0000:00:02.0: [drm:intel_hdmi_detect [i915]] [CONNECTOR:158:HDMI-A-2] <7>[ 60.928786] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] [CONNECTOR:158:HDMI-A-2] disconnected <7>[ 60.929036] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] [CONNECTOR:162:DP-1] <7>[ 60.929039] i915 0000:00:02.0: [drm:intel_dp_detect [i915]] [CONNECTOR:162:DP-1] <7>[ 60.933520] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] [CONNECTOR:162:DP-1] disconnected <7>[ 60.933782] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] [CONNECTOR:169:HDMI-A-3] <7>[ 60.933785] i915 0000:00:02.0: [drm:intel_hdmi_detect [i915]] [CONNECTOR:169:HDMI-A-3] <7>[ 60.938220] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] [CONNECTOR:169:HDMI-A-3] disconnected <7>[ 60.938505] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] [CONNECTOR:148:HDMI-A-1] <7>[ 60.938509] i915 0000:00:02.0: [drm:intel_hdmi_detect [i915]] [CONNECTOR:148:HDMI-A-1] <7>[ 60.942983] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] [CONNECTOR:148:HDMI-A-1] disconnected <7>[ 60.942996] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] [CONNECTOR:158:HDMI-A-2] <7>[ 60.942999] i915 0000:00:02.0: [drm:intel_hdmi_detect [i915]] [CONNECTOR:158:HDMI-A-2] <7>[ 60.947961] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] [CONNECTOR:158:HDMI-A-2] disconnected <7>[ 60.947974] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] [CONNECTOR:162:DP-1] <7>[ 60.947977] i915 0000:00:02.0: [drm:intel_dp_detect [i915]] [CONNECTOR:162:DP-1] <7>[ 60.952559] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] [CONNECTOR:162:DP-1] disconnected <7>[ 60.952572] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] [CONNECTOR:169:HDMI-A-3] <7>[ 60.952575] i915 0000:00:02.0: [drm:intel_hdmi_detect [i915]] [CONNECTOR:169:HDMI-A-3] <7>[ 60.957043] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] [CONNECTOR:169:HDMI-A-3] disconnected <7>[ 60.957137] [IGT] kms_debugfs: exiting, ret=77 <7>[ 60.957491] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 60.960552] i915 0000:00:02.0: [drm:drm_client_dev_restore] fbdev: ret=0 <7>[ 61.054701] [IGT] sriov_basic: executing <7>[ 61.061670] i915 0000:00:02.0: [drm:intel_power_well_disable [i915]] disabling always-on <7>[ 61.068871] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 61.069651] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 61.069938] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 61.070775] [IGT] sriov_basic: exiting, ret=77 <7>[ 61.070973] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 61.074000] i915 0000:00:02.0: [drm:drm_client_dev_restore] fbdev: ret=0 <7>[ 61.174346] [IGT] gem_render_copy: executing <7>[ 61.189231] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 61.189918] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 61.190885] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 61.191209] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 61.197760] [IGT] gem_render_copy: starting subtest yf-tiled-ccs-to-y-tiled-ccs <7>[ 61.197905] [IGT] gem_render_copy: starting dynamic subtest smem <7>[ 61.198053] i915 0000:00:02.0: [drm:intel_power_well_enable [i915]] enabling always-on <7>[ 61.198490] [drm:eb_validate_vma [i915]] EINVAL at eb_validate_vma:508 <7>[ 61.343319] [IGT] gem_render_copy: finished subtest smem, SUCCESS <7>[ 61.343420] [IGT] gem_render_copy: finished subtest yf-tiled-ccs-to-y-tiled-ccs, SUCCESS <7>[ 61.389395] i915 0000:00:02.0: [drm:intel_power_well_disable [i915]] disabling always-on <7>[ 61.451321] [IGT] gem_render_copy: exiting, ret=0 <7>[ 61.451719] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 61.451902] i915 0000:00:02.0: [drm:drm_client_dev_restore] fbdev: ret=0 <7>[ 61.536481] [IGT] gem_fence_thrash: executing <7>[ 61.548097] [IGT] gem_fence_thrash: starting subtest bo-write-verify-threaded-none <7>[ 61.548254] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 61.548849] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 61.549075] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 68.545507] [IGT] gem_fence_thrash: finished subtest bo-write-verify-threaded-none, SUCCESS <7>[ 68.545589] [IGT] gem_fence_thrash: exiting, ret=0 <7>[ 68.545755] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 68.575424] i915 0000:00:02.0: [drm:drm_client_dev_restore] fbdev: ret=0 <7>[ 68.720797] [IGT] kms_big_fb: executing <7>[ 68.736476] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 68.737360] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 68.737708] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 68.742700] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] [CONNECTOR:148:HDMI-A-1] <7>[ 68.742709] i915 0000:00:02.0: [drm:intel_hdmi_detect [i915]] [CONNECTOR:148:HDMI-A-1] <7>[ 68.742898] i915 0000:00:02.0: [drm:intel_power_well_enable [i915]] enabling always-on <7>[ 68.747886] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] [CONNECTOR:148:HDMI-A-1] disconnected <7>[ 68.748152] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] [CONNECTOR:158:HDMI-A-2] <7>[ 68.748156] i915 0000:00:02.0: [drm:intel_hdmi_detect [i915]] [CONNECTOR:158:HDMI-A-2] <7>[ 68.752673] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] [CONNECTOR:158:HDMI-A-2] disconnected <7>[ 68.752926] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] [CONNECTOR:162:DP-1] <7>[ 68.752930] i915 0000:00:02.0: [drm:intel_dp_detect [i915]] [CONNECTOR:162:DP-1] <7>[ 68.757878] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] [CONNECTOR:162:DP-1] disconnected <7>[ 68.758429] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] [CONNECTOR:169:HDMI-A-3] <7>[ 68.758435] i915 0000:00:02.0: [drm:intel_hdmi_detect [i915]] [CONNECTOR:169:HDMI-A-3] <7>[ 68.762951] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] [CONNECTOR:169:HDMI-A-3] disconnected <7>[ 68.763236] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] [CONNECTOR:148:HDMI-A-1] <7>[ 68.763239] i915 0000:00:02.0: [drm:intel_hdmi_detect [i915]] [CONNECTOR:148:HDMI-A-1] <7>[ 68.767677] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] [CONNECTOR:148:HDMI-A-1] disconnected <7>[ 68.767690] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] [CONNECTOR:158:HDMI-A-2] <7>[ 68.767692] i915 0000:00:02.0: [drm:intel_hdmi_detect [i915]] [CONNECTOR:158:HDMI-A-2] <7>[ 68.772154] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] [CONNECTOR:158:HDMI-A-2] disconnected <7>[ 68.772184] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] [CONNECTOR:162:DP-1] <7>[ 68.772187] i915 0000:00:02.0: [drm:intel_dp_detect [i915]] [CONNECTOR:162:DP-1] <7>[ 68.776686] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] [CONNECTOR:162:DP-1] disconnected <7>[ 68.776698] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] [CONNECTOR:169:HDMI-A-3] <7>[ 68.776701] i915 0000:00:02.0: [drm:intel_hdmi_detect [i915]] [CONNECTOR:169:HDMI-A-3] <7>[ 68.781211] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] [CONNECTOR:169:HDMI-A-3] disconnected <7>[ 68.781342] [IGT] kms_big_fb: exiting, ret=77 <7>[ 68.781600] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 68.784506] i915 0000:00:02.0: [drm:drm_client_dev_restore] fbdev: ret=0 <7>[ 68.861221] [IGT] syncobj_timeline: executing <7>[ 68.875637] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 68.876254] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 68.876463] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 68.877750] [IGT] syncobj_timeline: starting subtest invalid-signal-one-illegal-handle <7>[ 68.878097] [IGT] syncobj_timeline: finished subtest invalid-signal-one-illegal-handle, SUCCESS <7>[ 68.878494] [IGT] syncobj_timeline: exiting, ret=0 <7>[ 68.878646] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 68.878782] i915 0000:00:02.0: [drm:drm_client_dev_restore] fbdev: ret=0 <7>[ 68.886276] i915 0000:00:02.0: [drm:intel_power_well_disable [i915]] disabling always-on <7>[ 68.967941] [IGT] kms_atomic_transition: executing <7>[ 68.983018] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 68.983624] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 68.983828] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 68.986977] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] [CONNECTOR:148:HDMI-A-1] <7>[ 68.986985] i915 0000:00:02.0: [drm:intel_hdmi_detect [i915]] [CONNECTOR:148:HDMI-A-1] <7>[ 68.987138] i915 0000:00:02.0: [drm:intel_power_well_enable [i915]] enabling always-on <7>[ 68.991707] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] [CONNECTOR:148:HDMI-A-1] disconnected <7>[ 68.991971] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] [CONNECTOR:158:HDMI-A-2] <7>[ 68.991974] i915 0000:00:02.0: [drm:intel_hdmi_detect [i915]] [CONNECTOR:158:HDMI-A-2] <7>[ 68.996949] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] [CONNECTOR:158:HDMI-A-2] disconnected <7>[ 68.997304] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] [CONNECTOR:162:DP-1] <7>[ 68.997310] i915 0000:00:02.0: [drm:intel_dp_detect [i915]] [CONNECTOR:162:DP-1] <7>[ 69.001759] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] [CONNECTOR:162:DP-1] disconnected <7>[ 69.002033] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] [CONNECTOR:169:HDMI-A-3] <7>[ 69.002037] i915 0000:00:02.0: [drm:intel_hdmi_detect [i915]] [CONNECTOR:169:HDMI-A-3] <7>[ 69.007138] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] [CONNECTOR:169:HDMI-A-3] disconnected <7>[ 69.007596] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] [CONNECTOR:148:HDMI-A-1] <7>[ 69.007602] i915 0000:00:02.0: [drm:intel_hdmi_detect [i915]] [CONNECTOR:148:HDMI-A-1] <7>[ 69.012180] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] [CONNECTOR:148:HDMI-A-1] disconnected <7>[ 69.012219] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] [CONNECTOR:158:HDMI-A-2] <7>[ 69.012224] i915 0000:00:02.0: [drm:intel_hdmi_detect [i915]] [CONNECTOR:158:HDMI-A-2] <7>[ 69.016763] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] [CONNECTOR:158:HDMI-A-2] disconnected <7>[ 69.016784] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] [CONNECTOR:162:DP-1] <7>[ 69.016789] i915 0000:00:02.0: [drm:intel_dp_detect [i915]] [CONNECTOR:162:DP-1] <7>[ 69.021331] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] [CONNECTOR:162:DP-1] disconnected <7>[ 69.021353] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] [CONNECTOR:169:HDMI-A-3] <7>[ 69.021359] i915 0000:00:02.0: [drm:intel_hdmi_detect [i915]] [CONNECTOR:169:HDMI-A-3] <7>[ 69.025887] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] [CONNECTOR:169:HDMI-A-3] disconnected <7>[ 69.026815] [IGT] kms_atomic_transition: exiting, ret=77 <7>[ 69.027298] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 69.113550] [IGT] api_intel_bb: executing <7>[ 69.125735] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 69.126338] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 69.126601] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 69.127238] [IGT] api_intel_bb: starting subtest crc32 <7>[ 69.127358] [IGT] api_intel_bb: finished subtest crc32, SKIP <7>[ 69.127520] [IGT] api_intel_bb: exiting, ret=77 <7>[ 69.127707] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 69.247328] [IGT] kms_flip_scaled_crc: executing <7>[ 69.261786] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 69.262612] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 69.262934] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 69.306961] [IGT] kms_flip_scaled_crc: starting subtest flip-32bpp-ytile-to-32bpp-ytileccs-downscaling <7>[ 69.307057] [IGT] kms_flip_scaled_crc: finished subtest flip-32bpp-ytile-to-32bpp-ytileccs-downscaling, SKIP <7>[ 69.307293] [IGT] kms_flip_scaled_crc: exiting, ret=77 <7>[ 69.307567] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 69.435808] [IGT] kms_ccs: executing <7>[ 69.444596] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 69.445292] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 69.445548] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 69.485422] [IGT] kms_ccs: exiting, ret=77 <7>[ 69.485672] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 69.599420] [IGT] gem_ctx_persistence: executing <7>[ 69.607676] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 69.608346] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 69.608590] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 69.608996] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 69.612559] [IGT] gem_ctx_persistence: starting subtest userptr <7>[ 69.612673] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 69.618061] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 69.618577] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x0000005c [0x0000005c] <7>[ 69.618917] [drm:eb_validate_vma [i915]] EINVAL at eb_validate_vma:508 <7>[ 69.627197] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x00000200 [0x00000200] <7>[ 69.688912] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x00000200 [0x00000200] <7>[ 69.698491] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x00000200 [0x00000200] <7>[ 69.714995] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x00000080 [0x00000080] <7>[ 69.715874] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x0000005c [0x0000005c] <7>[ 69.716737] [IGT] gem_ctx_persistence: finished subtest userptr, SUCCESS <7>[ 69.723353] [IGT] gem_ctx_persistence: exiting, ret=0 <7>[ 69.724056] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 69.809812] [IGT] kms_psr: executing <7>[ 69.824304] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 69.824972] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 69.825244] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 69.868302] [IGT] kms_psr: exiting, ret=77 <7>[ 69.868601] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 69.965781] [IGT] kms_frontbuffer_tracking: executing <7>[ 69.978191] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 69.978895] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 69.979537] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 70.020340] [IGT] kms_frontbuffer_tracking: exiting, ret=77 <7>[ 70.020630] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 70.118740] [IGT] kms_atomic_transition: executing <7>[ 70.130442] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 70.130990] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 70.131217] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 70.171811] [IGT] kms_atomic_transition: exiting, ret=77 <7>[ 70.172056] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 70.252549] [IGT] syncobj_wait: executing <7>[ 70.260344] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 70.260898] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 70.261124] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 70.262461] [IGT] syncobj_wait: starting subtest invalid-multi-wait-unsubmitted <7>[ 70.262623] [IGT] syncobj_wait: finished subtest invalid-multi-wait-unsubmitted, SUCCESS <7>[ 70.262783] [IGT] syncobj_wait: exiting, ret=0 <7>[ 70.262936] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 70.362979] [IGT] gem_exec_balancer: executing <7>[ 70.374949] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 70.375614] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 70.375856] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 70.376849] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 70.385088] [IGT] gem_exec_balancer: starting subtest bonded-dual <7>[ 71.577896] [IGT] gem_exec_balancer: finished subtest bonded-dual, SUCCESS <7>[ 71.686858] i915 0000:00:02.0: [drm:error_state_write [i915]] Resetting error state <7>[ 71.687175] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 71.696732] [IGT] gem_exec_balancer: exiting, ret=0 <7>[ 71.697240] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 71.769922] [IGT] gem_exec_schedule: executing <7>[ 71.783635] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 71.785562] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 71.785882] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 71.786886] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 71.800612] [IGT] gem_exec_schedule: starting subtest preempt-user <7>[ 71.800710] [IGT] gem_exec_schedule: starting dynamic subtest rcs0 <7>[ 71.800919] [drm:eb_validate_vma [i915]] EINVAL at eb_validate_vma:508 <7>[ 71.802643] [drm:eb_validate_vma [i915]] EINVAL at eb_validate_vma:508 <7>[ 71.820087] [IGT] gem_exec_schedule: finished subtest rcs0, SUCCESS <7>[ 71.820222] [IGT] gem_exec_schedule: starting dynamic subtest bcs0 <7>[ 71.820354] [drm:eb_validate_vma [i915]] EINVAL at eb_validate_vma:508 <7>[ 71.820845] [drm:eb_validate_vma [i915]] EINVAL at eb_validate_vma:508 <7>[ 71.838162] [IGT] gem_exec_schedule: finished subtest bcs0, SUCCESS <7>[ 71.838250] [IGT] gem_exec_schedule: starting dynamic subtest vcs0 <7>[ 71.839793] [drm:eb_validate_vma [i915]] EINVAL at eb_validate_vma:508 <7>[ 71.840334] [drm:eb_validate_vma [i915]] EINVAL at eb_validate_vma:508 <7>[ 71.857673] [IGT] gem_exec_schedule: finished subtest vcs0, SUCCESS <7>[ 71.857746] [IGT] gem_exec_schedule: starting dynamic subtest vecs0 <7>[ 71.857867] [drm:eb_validate_vma [i915]] EINVAL at eb_validate_vma:508 <7>[ 71.858423] [drm:eb_validate_vma [i915]] EINVAL at eb_validate_vma:508 <7>[ 71.874668] [IGT] gem_exec_schedule: finished subtest vecs0, SUCCESS <7>[ 71.874747] [IGT] gem_exec_schedule: finished subtest preempt-user, SUCCESS <7>[ 71.979202] i915 0000:00:02.0: [drm:error_state_write [i915]] Resetting error state <7>[ 72.091121] [IGT] gem_exec_schedule: exiting, ret=0 <7>[ 72.091332] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 72.174016] [IGT] gen7_exec_parse: executing <7>[ 72.186275] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 72.186925] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 72.187185] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 72.187632] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 72.190417] [IGT] gen7_exec_parse: exiting, ret=77 <7>[ 72.190582] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 72.286589] [IGT] kms_big_fb: executing <7>[ 72.298333] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 72.298897] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 72.299160] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 72.340482] [IGT] kms_big_fb: exiting, ret=77 <7>[ 72.340722] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 72.428678] [IGT] perf_pmu: executing <7>[ 72.440629] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 72.441553] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 72.445195] [IGT] perf_pmu: starting subtest rc6-suspend <7>[ 72.445316] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x0000005c [0x0000005c] <6>[ 74.701730] PM: suspend entry (s2idle) <6>[ 74.715484] Filesystems sync: 0.013 seconds <6>[ 74.729104] Freezing user space processes <6>[ 74.738534] Freezing user space processes completed (elapsed 0.009 seconds) <6>[ 74.738627] OOM killer disabled. <6>[ 74.738633] Freezing remaining freezable tasks <6>[ 74.740457] Freezing remaining freezable tasks completed (elapsed 0.001 seconds) <6>[ 74.858947] e1000e: EEE TX LPI TIMER: 00000000 <6>[ 74.859082] e1000e: EEE TX LPI TIMER: 00000011 <7>[ 74.895988] azx_init_pci: snd_hda_intel 0000:00:1f.3: Clearing TCSEL <7>[ 74.896019] azx_init_pci: snd_hda_intel 0000:00:1f.3: SCH snoop: Enabled <7>[ 74.916640] i915 0000:00:02.0: [drm:i915_hdcp_component_unbind [i915]] I915 HDCP comp unbind <3>[ 74.921247] igc 0000:02:00.0 enp2s0: Timeout reading IGC_PTM_STAT register <7>[ 75.244467] PM: suspend of devices complete after 394.774 msecs <7>[ 75.244496] PM: start suspend of devices complete after 503.686 msecs <7>[ 75.282505] PM: late suspend of devices complete after 37.999 msecs <6>[ 75.302621] ACPI: EC: interrupt blocked <7>[ 75.470952] PM: noirq suspend of devices complete after 185.570 msecs <6>[ 75.470983] ACPI: \_SB_.PR00: LPI: Device not power manageable <6>[ 75.470994] ACPI: \_SB_.PR01: LPI: Device not power manageable <6>[ 75.470999] ACPI: \_SB_.PR02: LPI: Device not power manageable <6>[ 75.471005] ACPI: \_SB_.PR03: LPI: Device not power manageable <6>[ 75.471010] ACPI: \_SB_.PR04: LPI: Device not power manageable <6>[ 75.471016] ACPI: \_SB_.PR05: LPI: Device not power manageable <6>[ 75.471021] ACPI: \_SB_.PR06: LPI: Device not power manageable <6>[ 75.471027] ACPI: \_SB_.PR07: LPI: Device not power manageable <6>[ 75.471033] ACPI: \_SB_.PC00.GFX0: LPI: Device not power manageable <6>[ 75.471044] ACPI: \_SB_.PR08: LPI: Device not power manageable <6>[ 75.471049] ACPI: \_SB_.PR09: LPI: Device not power manageable <6>[ 75.471055] ACPI: \_SB_.PR10: LPI: Device not power manageable <6>[ 75.471060] ACPI: \_SB_.PR11: LPI: Device not power manageable <6>[ 75.471066] ACPI: \_SB_.PC00.HECI: LPI: Device not power manageable <6>[ 75.471072] ACPI: \_SB_.PC00.GNA0: LPI: Device not power manageable <6>[ 75.474312] ACPI: \_SB_.PEPD: Successfully transitioned to state screen off <7>[ 75.768567] PM: Triggering wakeup from IRQ 9 <6>[ 75.772424] ACPI: \_SB_.PEPD: Successfully transitioned to state lps0 entry <7>[ 75.772430] PM: suspend-to-idle <7>[ 75.772580] ACPI: EC: ACPI EC GPE status set <7>[ 75.772609] ACPI: PM: Rearming ACPI SCI for wakeup <7>[ 89.831294] Timekeeping suspended for 14.055 seconds <7>[ 89.833692] PM: Triggering wakeup from IRQ 9 <7>[ 89.834204] ACPI: PM: ACPI fixed event wakeup <7>[ 89.834217] PM: resume from suspend-to-idle <6>[ 89.981624] ACPI: \_SB_.PEPD: Successfully transitioned to state lps0 exit <6>[ 89.984802] ACPI: \_SB_.PEPD: Successfully transitioned to state screen on <6>[ 89.985736] ACPI: EC: interrupt unblocked <7>[ 90.374047] PM: noirq resume of devices complete after 389.237 msecs <7>[ 90.381297] PM: early resume of devices complete after 6.189 msecs <6>[ 90.393846] nvme nvme0: D3 entry latency set to 10 seconds <7>[ 90.398066] azx_init_pci: snd_hda_intel 0000:00:1f.3: Clearing TCSEL <7>[ 90.398077] azx_init_pci: snd_hda_intel 0000:00:1f.3: SCH snoop: Enabled <6>[ 90.399412] nvme nvme0: 12/0/0 default/read/poll queues <6>[ 90.405353] serial 00:02: activated <3>[ 90.695820] atkbd serio0: Failed to deactivate keyboard on isa0060/serio0 <6>[ 90.696508] ata3: SATA link down (SStatus 4 SControl 300) <6>[ 90.696574] ata4: SATA link down (SStatus 4 SControl 300) <6>[ 90.696638] ata2: SATA link down (SStatus 4 SControl 300) <3>[ 91.071622] atkbd serio0: Failed to enable keyboard on isa0060/serio0 <7>[ 91.626454] PM: resume of devices complete after 1245.151 msecs <6>[ 91.630283] OOM killer enabled. <6>[ 91.630287] Restarting tasks: Starting <7>[ 91.631649] i915 0000:00:02.0: [drm:i915_hdcp_component_bind [i915]] I915 HDCP comp bind <6>[ 91.632067] mei_hdcp 0000:00:16.0-b638ab7e-94e2-4ea2-a552-d1c54b627f04: bound 0000:00:02.0 (ops i915_hdcp_ops [i915]) <6>[ 91.632573] Restarting tasks: Done <5>[ 91.632665] random: crng reseeded on system resumption <6>[ 91.633047] PM: suspend exit <6>[ 91.633884] mei_pxp 0000:00:16.0-fbf6fcf1-96cf-4e2e-a6a6-1bab8cbe36b1: bound 0000:00:02.0 (ops i915_pxp_tee_component_ops [i915]) <6>[ 92.980658] e1000e 0000:03:00.0 enp3s0: NIC Link is Up 1000 Mbps Full Duplex, Flow Control: None <7>[ 95.808276] [IGT] perf_pmu: finished subtest rc6-suspend, SUCCESS <7>[ 95.809006] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 95.809690] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 95.810609] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x0000005c [0x0000005c] <7>[ 98.058942] [IGT] gem_exec_flush: executing <7>[ 98.071660] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 98.072273] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 98.072486] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 98.072856] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 98.079427] [IGT] gem_exec_flush: starting subtest basic-wb-prw-default <7>[ 98.083450] [drm:eb_validate_vma [i915]] EINVAL at eb_validate_vma:508 <7>[ 98.087029] [drm:eb_validate_vma [i915]] EINVAL at eb_validate_vma:508 <7>[ 98.091062] [drm:eb_validate_vma [i915]] EINVAL at eb_validate_vma:508 <7>[ 98.095420] [drm:eb_validate_vma [i915]] EINVAL at eb_validate_vma:508 <7>[ 98.099721] [drm:eb_validate_vma [i915]] EINVAL at eb_validate_vma:508 <7>[ 98.104138] [drm:eb_validate_vma [i915]] EINVAL at eb_validate_vma:508 <7>[ 98.111269] [drm:eb_validate_vma [i915]] EINVAL at eb_validate_vma:508 <7>[ 98.119180] [drm:eb_validate_vma [i915]] EINVAL at eb_validate_vma:508 <7>[ 98.128393] [drm:eb_validate_vma [i915]] EINVAL at eb_validate_vma:508 <7>[ 98.132314] [drm:eb_validate_vma [i915]] EINVAL at eb_validate_vma:508 <7>[ 98.139853] [drm:eb_validate_vma [i915]] EINVAL at eb_validate_vma:508 <7>[ 98.146304] [drm:eb_validate_vma [i915]] EINVAL at eb_validate_vma:508 <7>[ 103.523839] [IGT] gem_exec_flush: finished subtest basic-wb-prw-default, SUCCESS <7>[ 103.635275] [IGT] gem_exec_flush: exiting, ret=0 <7>[ 103.635995] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 103.768206] [IGT] kms_psr: executing <7>[ 103.779611] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 103.780249] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 103.780509] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 103.825304] [IGT] kms_psr: exiting, ret=77 <7>[ 103.825577] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 103.911217] [IGT] gem_ctx_exec: executing <7>[ 103.918909] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 103.919433] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 103.920031] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 103.920235] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 103.921318] [IGT] gem_ctx_exec: starting subtest basic-nohangcheck <7>[ 103.921441] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 103.922424] [drm:eb_validate_vma [i915]] EINVAL at eb_validate_vma:508 <5>[ 104.032911] i915 0000:00:02.0: [drm] Resetting vecs0 for preemption time out <5>[ 104.040235] i915 0000:00:02.0: [drm] Resetting vcs0 for preemption time out <5>[ 104.046327] i915 0000:00:02.0: [drm] Resetting bcs0 for preemption time out <5>[ 104.051203] i915 0000:00:02.0: [drm] Resetting rcs0 for preemption time out <6>[ 104.052505] i915 0000:00:02.0: [drm] GPU HANG: ecode 12:8:277ffefe, in gem_ctx_exec [2294] <6>[ 104.053257] i915 0000:00:02.0: [drm] GPU HANG: ecode 12:4:277ffefe, in gem_ctx_exec [2294] <6>[ 104.053297] i915 0000:00:02.0: [drm] GPU HANG: ecode 12:2:1b200001, in gem_ctx_exec [2294] <6>[ 104.053345] i915 0000:00:02.0: [drm] GPU HANG: ecode 12:1:e75bfefe, in gem_ctx_exec [2294] <7>[ 104.054348] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x0000005c [0x0000005c] <7>[ 104.108598] [IGT] gem_ctx_exec: finished subtest basic-nohangcheck, SUCCESS <7>[ 104.112119] [IGT] gem_ctx_exec: exiting, ret=0 <7>[ 104.113444] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 104.247808] [IGT] gem_mmap_gtt: executing <7>[ 104.259555] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 104.260174] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 104.260434] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 104.260932] [IGT] gem_mmap_gtt: starting subtest cpuset-basic-small-copy <7>[ 104.275530] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <6>[ 104.275997] gem_mmap_gtt (2296): drop_caches: 4 <7>[ 104.276090] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x00000070 [0x00000070] <7>[ 104.522480] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x00000070 [0x00000070] <7>[ 108.707010] [IGT] gem_mmap_gtt: finished subtest cpuset-basic-small-copy, SUCCESS <7>[ 108.707323] [IGT] gem_mmap_gtt: exiting, ret=0 <7>[ 108.707531] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 108.858696] [IGT] kms_feature_discovery: executing <7>[ 108.865191] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 108.865791] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 108.865997] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 108.915299] [IGT] kms_feature_discovery: starting subtest chamelium <7>[ 108.915501] [IGT] kms_feature_discovery: finished subtest chamelium, SKIP <7>[ 108.915681] [IGT] kms_feature_discovery: exiting, ret=77 <7>[ 108.915921] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 109.015735] [IGT] kms_cursor_legacy: executing <7>[ 109.031200] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 109.032048] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 109.032339] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 109.076866] [IGT] kms_cursor_legacy: exiting, ret=77 <7>[ 109.077160] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 109.228533] [IGT] kms_big_fb: executing <7>[ 109.246782] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 109.247778] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 109.248179] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 109.296888] [IGT] kms_big_fb: exiting, ret=77 <7>[ 109.297140] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 109.380627] [IGT] kms_psr: executing <7>[ 109.388034] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 109.388571] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 109.388805] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 109.434091] [IGT] kms_psr: exiting, ret=77 <7>[ 109.434390] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 109.535847] [IGT] kms_flip: executing <7>[ 109.545008] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 109.545569] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 109.545812] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 109.595975] [IGT] kms_flip: starting subtest 2x-flip-vs-rmfb-interruptible <7>[ 109.596529] [IGT] kms_flip: finished subtest 2x-flip-vs-rmfb-interruptible, SKIP <7>[ 109.599283] [IGT] kms_flip: exiting, ret=77 <7>[ 109.599610] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 109.720672] [IGT] kms_prime: executing <7>[ 109.731692] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <6>[ 109.791684] [drm] Initialized vgem 1.0.0 for vgem on minor 1 <7>[ 109.801408] [IGT] kms_prime: exiting, ret=77 <7>[ 109.891077] [IGT] gem_exec_reloc: executing <7>[ 109.900490] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 109.901055] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 109.901256] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 109.901731] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 109.906743] [drm:eb_validate_vma [i915]] EINVAL at eb_validate_vma:508 <7>[ 109.906995] [IGT] gem_exec_reloc: exiting, ret=77 <7>[ 109.907154] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 109.996813] [IGT] i915_drm_fdinfo: executing <7>[ 110.006469] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 110.007452] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 110.010423] [IGT] i915_drm_fdinfo: starting subtest virtual-busy-hang-all <7>[ 110.010904] [IGT] i915_drm_fdinfo: finished subtest virtual-busy-hang-all, SUCCESS <7>[ 110.011009] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 110.011563] [IGT] i915_drm_fdinfo: exiting, ret=0 <7>[ 110.101181] [IGT] kms_chamelium_frames: executing <7>[ 110.119197] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 110.119818] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 110.120055] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 110.168667] [IGT] kms_chamelium_frames: exiting, ret=77 <7>[ 110.168893] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 110.266493] [IGT] kms_big_fb: executing <7>[ 110.278692] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 110.279365] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 110.279652] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 110.324252] [IGT] kms_big_fb: exiting, ret=77 <7>[ 110.324581] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 110.424027] [IGT] gem_pwrite: executing <7>[ 110.431651] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 110.432177] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 110.432382] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 110.432795] [IGT] gem_pwrite: exiting, ret=77 <7>[ 110.432948] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 110.556194] [IGT] gem_spin_batch: executing <7>[ 110.567607] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 110.568174] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 110.568382] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 110.568781] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 110.575066] [IGT] gem_spin_batch: starting subtest resubmit-all <7>[ 110.575162] [IGT] gem_spin_batch: starting dynamic subtest rcs0 <7>[ 110.575348] [drm:eb_validate_vma [i915]] EINVAL at eb_validate_vma:508 <7>[ 110.578981] [IGT] gem_spin_batch: finished subtest rcs0, SUCCESS <7>[ 110.579046] [IGT] gem_spin_batch: starting dynamic subtest bcs0 <7>[ 110.579143] [drm:eb_validate_vma [i915]] EINVAL at eb_validate_vma:508 <7>[ 110.580177] [IGT] gem_spin_batch: finished subtest bcs0, SUCCESS <7>[ 110.580233] [IGT] gem_spin_batch: starting dynamic subtest vcs0 <7>[ 110.580322] [drm:eb_validate_vma [i915]] EINVAL at eb_validate_vma:508 <7>[ 110.581203] [IGT] gem_spin_batch: finished subtest vcs0, SUCCESS <7>[ 110.581261] [IGT] gem_spin_batch: starting dynamic subtest vecs0 <7>[ 110.581353] [drm:eb_validate_vma [i915]] EINVAL at eb_validate_vma:508 <7>[ 110.582308] [IGT] gem_spin_batch: finished subtest vecs0, SUCCESS <7>[ 110.582375] [IGT] gem_spin_batch: finished subtest resubmit-all, SUCCESS <7>[ 110.692507] [IGT] gem_spin_batch: exiting, ret=0 <7>[ 110.692709] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 110.789219] [IGT] gem_exec_reloc: executing <7>[ 110.801167] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 110.801849] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 110.802113] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 110.802592] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 110.805628] [drm:eb_validate_vma [i915]] EINVAL at eb_validate_vma:508 <7>[ 110.805887] [IGT] gem_exec_reloc: exiting, ret=77 <7>[ 110.806050] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 110.920119] [IGT] kms_vblank: executing <7>[ 110.936122] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 110.937107] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 110.937498] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 110.984715] [IGT] kms_vblank: exiting, ret=77 <7>[ 110.984998] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 111.088751] [IGT] perf: executing <7>[ 111.106408] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 111.106914] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 111.112363] i915 0000:00:02.0: [drm:i915_perf_add_config_ioctl [i915]] Added config 5b492c36-73f7-4827-83b3-c6863697ec51 id=2 <7>[ 111.112602] i915 0000:00:02.0: [drm:i915_perf_add_config_ioctl [i915]] Added config 09740672-ccc3-48da-a5bc-64994fe3a0a7 id=3 <7>[ 111.112772] i915 0000:00:02.0: [drm:i915_perf_add_config_ioctl [i915]] Added config 833bb0f2-9483-498e-b3bf-ebf026a6301a id=4 <7>[ 111.112941] i915 0000:00:02.0: [drm:i915_perf_add_config_ioctl [i915]] Added config 40ef13ef-25d9-4ac6-8582-ce97c47fc900 id=5 <7>[ 111.113110] i915 0000:00:02.0: [drm:i915_perf_add_config_ioctl [i915]] Added config bf60f7bd-9029-4edf-8311-f6e86599395e id=6 <7>[ 111.113270] i915 0000:00:02.0: [drm:i915_perf_add_config_ioctl [i915]] Added config a5f6ac3d-853f-42a4-a038-c4a09e8075be id=7 <7>[ 111.113429] i915 0000:00:02.0: [drm:i915_perf_add_config_ioctl [i915]] Added config bb080384-a01f-442f-8be2-3eae2c7394cd id=8 <7>[ 111.113661] i915 0000:00:02.0: [drm:i915_perf_add_config_ioctl [i915]] Added config 9f39ce80-0463-484e-b797-3135b7e0ab0a id=9 <7>[ 111.113832] i915 0000:00:02.0: [drm:i915_perf_add_config_ioctl [i915]] Added config 11e091e1-bbd3-4bd6-9ce8-8982d2d3a3b2 id=10 <7>[ 111.113990] i915 0000:00:02.0: [drm:i915_perf_add_config_ioctl [i915]] Added config 0f2e1818-c190-494a-a828-2ed4422d71f3 id=11 <7>[ 111.114144] i915 0000:00:02.0: [drm:i915_perf_add_config_ioctl [i915]] Added config ebd91ba3-4d01-4bdf-8752-384cd0a4e139 id=12 <7>[ 111.114339] i915 0000:00:02.0: [drm:i915_perf_add_config_ioctl [i915]] Added config 5102fa66-b5f3-45f2-a16d-0a13a4cbb6c9 id=13 <7>[ 111.114548] i915 0000:00:02.0: [drm:i915_perf_add_config_ioctl [i915]] Added config 8706c725-7753-427d-ae2d-ba25c1168f2a id=14 <7>[ 111.114724] i915 0000:00:02.0: [drm:i915_perf_add_config_ioctl [i915]] Added config 3eab195e-e4d8-482e-9981-811935722b21 id=15 <7>[ 111.114886] i915 0000:00:02.0: [drm:i915_perf_add_config_ioctl [i915]] Added config 100ae8ce-31c6-457f-97a2-dfd44812bce6 id=16 <7>[ 111.115051] i915 0000:00:02.0: [drm:i915_perf_add_config_ioctl [i915]] Added config 7e926c0a-471b-40b3-a641-75f3d73339ec id=17 <7>[ 111.115214] i915 0000:00:02.0: [drm:i915_perf_add_config_ioctl [i915]] Added config aca9005f-fafe-4d02-a9de-b2584ff76f04 id=18 <7>[ 111.115375] i915 0000:00:02.0: [drm:i915_perf_add_config_ioctl [i915]] Added config ad96806d-7c0d-49f0-b844-c5010ade30af id=19 <7>[ 111.115597] i915 0000:00:02.0: [drm:i915_perf_add_config_ioctl [i915]] Added config 1669e79f-976e-47ba-a553-0a716ebd3c71 id=20 <7>[ 111.115757] i915 0000:00:02.0: [drm:i915_perf_add_config_ioctl [i915]] Added config d100e474-1e6c-4100-812b-71ec9cfe3523 id=21 <7>[ 111.115917] i915 0000:00:02.0: [drm:i915_perf_add_config_ioctl [i915]] Added config b22d38f6-a056-496a-8d7d-dede47051806 id=22 <7>[ 111.116084] i915 0000:00:02.0: [drm:i915_perf_add_config_ioctl [i915]] Added config c68abf37-fe6e-45f6-9dcb-549b3fbef699 id=23 <7>[ 111.116251] i915 0000:00:02.0: [drm:i915_perf_add_config_ioctl [i915]] Added config 74dbc739-d871-41b5-be7b-fb547ac5bec9 id=24 <7>[ 111.117094] [IGT] perf: starting subtest oa-exponents <7>[ 111.117169] [IGT] perf: starting dynamic subtest 0-rcs0 <7>[ 111.117597] [drm:eb_validate_vma [i915]] EINVAL at eb_validate_vma:508 <7>[ 111.134526] 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.144550] 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.155396] 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.171904] 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.187270] 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.201714] 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.216919] 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.235256] 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.269401] 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.322240] 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.416431] 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.589223] 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.928660] 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.588107] 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.908278] 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.468243] [IGT] perf: finished subtest 0-rcs0, SUCCESS <7>[ 116.468387] [IGT] perf: finished subtest oa-exponents, SUCCESS <7>[ 116.468734] [IGT] perf: exiting, ret=0 <7>[ 116.641477] [IGT] gem_ccs: executing <7>[ 116.653762] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 116.655108] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 116.655490] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 116.656135] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 116.659962] [IGT] gem_ccs: starting subtest block-copy-compressed <7>[ 116.660064] [IGT] gem_ccs: finished subtest block-copy-compressed, SKIP <7>[ 116.660212] i915 0000:00:02.0: [drm:error_state_write [i915]] Resetting error state <7>[ 116.660501] [IGT] gem_ccs: exiting, ret=77 <7>[ 116.660657] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 116.767138] [IGT] kms_frontbuffer_tracking: executing <7>[ 116.778831] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 116.779546] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 116.779815] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 116.825664] [IGT] kms_frontbuffer_tracking: exiting, ret=77 <7>[ 116.825904] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 116.917900] [IGT] kms_psr2_sf: executing <7>[ 116.929706] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 116.930459] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 116.930756] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 116.975017] [IGT] kms_psr2_sf: exiting, ret=77 <7>[ 116.975275] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 117.075748] [IGT] prime_mmap: executing <7>[ 117.087319] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 117.087869] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 117.088072] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 117.088962] [IGT] prime_mmap: starting subtest test_map_unmap <7>[ 117.089056] [IGT] prime_mmap: starting dynamic subtest test_map_unmap-smem <7>[ 117.135941] [IGT] prime_mmap: finished subtest test_map_unmap-smem, SUCCESS <7>[ 117.136026] [IGT] prime_mmap: finished subtest test_map_unmap, SUCCESS <7>[ 117.136170] [IGT] prime_mmap: exiting, ret=0 <7>[ 117.136367] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 117.265147] [IGT] kms_content_protection: executing <7>[ 117.277234] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 117.277835] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 117.278070] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 117.321557] [IGT] kms_content_protection: exiting, ret=77 <7>[ 117.321808] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 117.410241] [IGT] kms_psr2_sf: executing <7>[ 117.418510] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 117.419051] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 117.419273] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 117.462641] [IGT] kms_psr2_sf: exiting, ret=77 <7>[ 117.462870] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 117.551608] [IGT] kms_frontbuffer_tracking: executing <7>[ 117.563644] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 117.564227] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 117.564621] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 117.609958] [IGT] kms_frontbuffer_tracking: exiting, ret=77 <7>[ 117.610203] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 117.701353] [IGT] gem_exec_fence: executing <7>[ 117.709457] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 117.709984] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 117.710185] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 117.710602] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 117.716922] [IGT] gem_exec_fence: starting subtest basic-wait-all <7>[ 117.717139] [drm:eb_validate_vma [i915]] EINVAL at eb_validate_vma:508 <7>[ 117.718545] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x0000005c [0x0000005c] <7>[ 117.786992] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x0000005c [0x0000005c] <7>[ 117.805828] [IGT] gem_exec_fence: finished subtest basic-wait-all, SUCCESS <7>[ 117.909061] i915 0000:00:02.0: [drm:error_state_write [i915]] Resetting error state <7>[ 118.020182] i915 0000:00:02.0: [drm:error_state_write [i915]] Resetting error state <7>[ 118.021459] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 118.027643] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 118.032763] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 118.037777] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 118.268684] [IGT] gem_exec_fence: exiting, ret=0 <7>[ 118.268909] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 118.360115] [IGT] kms_frontbuffer_tracking: executing <7>[ 118.372097] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 118.372826] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 118.373085] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 118.419048] [IGT] kms_frontbuffer_tracking: exiting, ret=77 <7>[ 118.419362] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 118.511917] [IGT] kms_frontbuffer_tracking: executing <7>[ 118.523618] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 118.524231] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 118.524556] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 118.573242] [IGT] kms_frontbuffer_tracking: exiting, ret=77 <7>[ 118.573503] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 118.677650] [IGT] kms_frontbuffer_tracking: executing <7>[ 118.691757] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 118.692470] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 118.692753] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 118.739343] [IGT] kms_frontbuffer_tracking: exiting, ret=77 <7>[ 118.739586] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 118.846556] [IGT] kms_chamelium_audio: executing <7>[ 118.854522] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 118.855041] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 118.855722] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 118.907537] [IGT] kms_chamelium_audio: exiting, ret=77 <7>[ 118.907797] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 118.997310] [IGT] kms_pm_rpm: executing <7>[ 119.011431] [IGT] kms_pm_rpm: starting subtest basic-rte <7>[ 119.011584] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 120.081668] i915 0000:00:02.0: [drm:intel_runtime_suspend [i915]] Suspending device <7>[ 120.088549] i915 0000:00:02.0: [drm:intel_runtime_suspend [i915]] Device suspended <7>[ 120.113434] i915 0000:00:02.0: [drm:intel_runtime_resume [i915]] Resuming device <7>[ 120.131075] i915 0000:00:02.0: [drm:intel_runtime_resume [i915]] Device resumed <7>[ 120.154391] i915 0000:00:02.0: [drm:intel_runtime_suspend [i915]] Suspending device <7>[ 120.161065] i915 0000:00:02.0: [drm:intel_runtime_suspend [i915]] Device suspended <7>[ 120.184482] i915 0000:00:02.0: [drm:intel_runtime_resume [i915]] Resuming device <7>[ 120.196952] i915 0000:00:02.0: [drm:intel_runtime_resume [i915]] Device resumed <7>[ 120.225923] i915 0000:00:02.0: [drm:intel_runtime_suspend [i915]] Suspending device <7>[ 120.231025] i915 0000:00:02.0: [drm:intel_runtime_suspend [i915]] Device suspended <7>[ 120.321434] i915 0000:00:02.0: [drm:intel_runtime_resume [i915]] Resuming device <7>[ 120.336550] i915 0000:00:02.0: [drm:intel_runtime_resume [i915]] Device resumed <7>[ 120.365676] i915 0000:00:02.0: [drm:intel_runtime_suspend [i915]] Suspending device <7>[ 120.371063] i915 0000:00:02.0: [drm:intel_runtime_suspend [i915]] Device suspended <7>[ 120.459457] i915 0000:00:02.0: [drm:intel_runtime_resume [i915]] Resuming device <7>[ 120.477257] i915 0000:00:02.0: [drm:intel_runtime_resume [i915]] Device resumed <7>[ 120.479848] [IGT] kms_pm_rpm: finished subtest basic-rte, SUCCESS <7>[ 120.582988] i915 0000:00:02.0: [drm:intel_runtime_suspend [i915]] Suspending device <7>[ 120.590827] i915 0000:00:02.0: [drm:intel_runtime_suspend [i915]] Device suspended <7>[ 120.705164] [IGT] kms_pm_rpm: exiting, ret=0 <7>[ 120.786532] [IGT] kms_frontbuffer_tracking: executing <7>[ 120.803385] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 120.804181] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 120.804583] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 120.821405] i915 0000:00:02.0: [drm:intel_runtime_resume [i915]] Resuming device <7>[ 120.835421] i915 0000:00:02.0: [drm:intel_runtime_resume [i915]] Device resumed <7>[ 120.894471] [IGT] kms_frontbuffer_tracking: exiting, ret=77 <7>[ 120.894729] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 121.001392] [IGT] syncobj_timeline: executing <7>[ 121.012411] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 121.012996] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 121.013259] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 121.014862] [IGT] syncobj_timeline: starting subtest signal-array <7>[ 121.015078] [IGT] syncobj_timeline: finished subtest signal-array, SUCCESS <7>[ 121.015322] [IGT] syncobj_timeline: exiting, ret=0 <7>[ 121.015553] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 121.124144] [IGT] syncobj_wait: executing <7>[ 121.136134] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 121.136740] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 121.136961] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 121.138328] [IGT] syncobj_wait: starting subtest multi-wait-signaled <7>[ 121.138899] [IGT] syncobj_wait: finished subtest multi-wait-signaled, SUCCESS <7>[ 121.139094] [IGT] syncobj_wait: exiting, ret=0 <7>[ 121.139354] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 121.251020] [IGT] sw_sync: executing <7>[ 121.263717] [IGT] sw_sync: starting subtest alloc_timeline <7>[ 121.263856] [IGT] sw_sync: finished subtest alloc_timeline, SUCCESS <7>[ 121.263917] [IGT] sw_sync: exiting, ret=0 <7>[ 121.367315] [IGT] kms_frontbuffer_tracking: executing <7>[ 121.374741] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 121.375311] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 121.375520] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 121.420553] [IGT] kms_frontbuffer_tracking: exiting, ret=77 <7>[ 121.420802] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 121.533030] [IGT] vgem_slow: executing <7>[ 121.545152] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 121.545907] [IGT] vgem_slow: starting subtest nohang <7>[ 131.886351] [IGT] vgem_slow: finished subtest nohang, SUCCESS <7>[ 131.887325] [IGT] vgem_slow: exiting, ret=0 <7>[ 131.986435] [IGT] gem_mmap_offset: executing <7>[ 132.001294] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 132.002031] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 132.002314] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 132.002797] [IGT] gem_mmap_offset: starting subtest partial-remap <7>[ 132.002901] [IGT] gem_mmap_offset: starting dynamic subtest smem0 <7>[ 132.006190] [IGT] gem_mmap_offset: finished subtest smem0, SUCCESS <7>[ 132.006336] [IGT] gem_mmap_offset: finished subtest partial-remap, SUCCESS <7>[ 132.006580] [IGT] gem_mmap_offset: exiting, ret=0 <7>[ 132.006924] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 132.162499] [IGT] kms_big_fb: executing <7>[ 132.181548] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 132.182571] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 132.183015] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 132.229471] [IGT] kms_big_fb: exiting, ret=77 <7>[ 132.229719] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 132.336253] [IGT] syncobj_wait: executing <7>[ 132.354292] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 132.355267] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 132.355763] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 132.358317] [IGT] syncobj_wait: starting subtest wait-any-snapshot <7>[ 132.440981] [IGT] syncobj_wait: finished subtest wait-any-snapshot, SUCCESS <7>[ 132.441862] [IGT] syncobj_wait: exiting, ret=0 <7>[ 132.442693] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 132.540088] [IGT] kms_plane: executing <7>[ 132.548897] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 132.549441] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 132.549729] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 132.593879] [IGT] kms_plane: starting subtest plane-panning-bottom-right-suspend <7>[ 132.593971] [IGT] kms_plane: finished subtest plane-panning-bottom-right-suspend, SKIP <7>[ 132.594147] [IGT] kms_plane: exiting, ret=77 <7>[ 132.594416] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 132.706925] [IGT] kms_joiner: executing <7>[ 132.715703] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 132.716463] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 132.716806] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 132.762116] [IGT] kms_joiner: starting subtest invalid-modeset-ultra-joiner <7>[ 132.762213] [IGT] kms_joiner: finished subtest invalid-modeset-ultra-joiner, SKIP <7>[ 132.762375] [IGT] kms_joiner: exiting, ret=77 <7>[ 132.762631] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 132.878712] [IGT] perf_pmu: executing <7>[ 132.894107] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 132.894812] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 132.900090] [IGT] perf_pmu: starting subtest busy-double-start <7>[ 132.900240] [IGT] perf_pmu: starting dynamic subtest rcs0 <7>[ 132.900625] [drm:eb_validate_vma [i915]] EINVAL at eb_validate_vma:508 <7>[ 132.903212] [drm:eb_validate_vma [i915]] EINVAL at eb_validate_vma:508 <7>[ 135.913287] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x0000005c [0x0000005c] <7>[ 136.418958] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x0000005c [0x0000005c] <7>[ 136.478850] [IGT] perf_pmu: finished subtest rcs0, SUCCESS <7>[ 136.479165] [IGT] perf_pmu: starting dynamic subtest bcs0 <7>[ 136.479983] [drm:eb_validate_vma [i915]] EINVAL at eb_validate_vma:508 <7>[ 136.481490] [drm:eb_validate_vma [i915]] EINVAL at eb_validate_vma:508 <7>[ 139.488974] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x0000005c [0x0000005c] <7>[ 139.991500] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x0000005c [0x0000005c] <7>[ 140.038664] [IGT] perf_pmu: finished subtest bcs0, SUCCESS <7>[ 140.038981] [IGT] perf_pmu: starting dynamic subtest vcs0 <7>[ 140.039757] [drm:eb_validate_vma [i915]] EINVAL at eb_validate_vma:508 <7>[ 140.041257] [drm:eb_validate_vma [i915]] EINVAL at eb_validate_vma:508 <7>[ 143.051309] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x0000005c [0x0000005c] <7>[ 143.553644] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x0000005c [0x0000005c] <7>[ 143.606428] [IGT] perf_pmu: finished subtest vcs0, SUCCESS <7>[ 143.606738] [IGT] perf_pmu: starting dynamic subtest vecs0 <7>[ 143.607491] [drm:eb_validate_vma [i915]] EINVAL at eb_validate_vma:508 <7>[ 143.609014] [drm:eb_validate_vma [i915]] EINVAL at eb_validate_vma:508 <7>[ 146.619621] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x0000005c [0x0000005c] <7>[ 147.121926] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x0000005c [0x0000005c] <7>[ 147.157367] [IGT] perf_pmu: finished subtest vecs0, SUCCESS <7>[ 147.157783] [IGT] perf_pmu: finished subtest busy-double-start, SUCCESS <7>[ 147.158303] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 147.160306] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 147.162743] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x0000005c [0x0000005c] <7>[ 147.163036] [IGT] perf_pmu: exiting, ret=0 <7>[ 147.259016] [IGT] gem_partial_pwrite_pread: executing <7>[ 147.271029] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 147.271651] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 147.271917] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 147.272345] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 147.276083] [IGT] gem_partial_pwrite_pread: exiting, ret=77 <7>[ 147.276311] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 147.395762] [IGT] kms_cursor_legacy: executing <7>[ 147.403274] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 147.403838] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 147.404044] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 147.448539] [IGT] kms_cursor_legacy: exiting, ret=77 <7>[ 147.448877] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 147.584574] [IGT] gem_lmem_swapping: executing <7>[ 147.597347] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 147.597935] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 147.600802] [IGT] gem_lmem_swapping: exiting, ret=77 <7>[ 147.707710] [IGT] gem_exec_balancer: executing <7>[ 147.719321] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 147.720005] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 147.720409] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 147.721229] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 147.729183] [IGT] gem_exec_balancer: starting subtest invalid-balancer <7>[ 147.766633] i915 0000:00:02.0: [drm:set_proto_ctx_engines_balance [i915]] Invalid placement[1], already occupied <7>[ 147.766801] i915 0000:00:02.0: [drm:set_proto_ctx_engines_balance [i915]] Invalid placement[1], already occupied <7>[ 147.766932] i915 0000:00:02.0: [drm:set_proto_ctx_engines_balance [i915]] Invalid placement value, 2 >= 2 <7>[ 147.767089] i915 0000:00:02.0: [drm:set_proto_ctx_engines_balance [i915]] Invalid placement[0], already occupied <7>[ 147.805673] i915 0000:00:02.0: [drm:set_proto_ctx_engines_balance [i915]] Invalid placement[1], already occupied <7>[ 147.805830] i915 0000:00:02.0: [drm:set_proto_ctx_engines_balance [i915]] Invalid placement[1], already occupied <7>[ 147.805960] i915 0000:00:02.0: [drm:set_proto_ctx_engines_balance [i915]] Invalid placement value, 2 >= 2 <7>[ 147.806116] i915 0000:00:02.0: [drm:set_proto_ctx_engines_balance [i915]] Invalid placement[0], already occupied <7>[ 147.844051] i915 0000:00:02.0: [drm:set_proto_ctx_engines_balance [i915]] Invalid placement[1], already occupied <7>[ 147.844200] i915 0000:00:02.0: [drm:set_proto_ctx_engines_balance [i915]] Invalid placement[1], already occupied <7>[ 147.844330] i915 0000:00:02.0: [drm:set_proto_ctx_engines_balance [i915]] Invalid placement value, 2 >= 2 <7>[ 147.844487] i915 0000:00:02.0: [drm:set_proto_ctx_engines_balance [i915]] Invalid placement[0], already occupied <7>[ 147.882302] i915 0000:00:02.0: [drm:set_proto_ctx_engines_balance [i915]] Invalid placement[1], already occupied <7>[ 147.882454] i915 0000:00:02.0: [drm:set_proto_ctx_engines_balance [i915]] Invalid placement[1], already occupied <7>[ 147.882585] i915 0000:00:02.0: [drm:set_proto_ctx_engines_balance [i915]] Invalid placement value, 2 >= 2 <7>[ 147.882869] i915 0000:00:02.0: [drm:set_proto_ctx_engines_balance [i915]] Invalid placement[0], already occupied <7>[ 148.898175] [IGT] gem_exec_balancer: finished subtest invalid-balancer, SUCCESS <7>[ 149.003620] i915 0000:00:02.0: [drm:error_state_write [i915]] Resetting error state <7>[ 149.003944] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 149.006360] [IGT] gem_exec_balancer: exiting, ret=0 <7>[ 149.006510] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 149.085022] [IGT] kms_scaling_modes: executing <7>[ 149.096869] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 149.097445] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 149.097733] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 149.141594] [IGT] kms_scaling_modes: exiting, ret=77 <7>[ 149.141879] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 149.241109] [IGT] kms_flip: executing <7>[ 149.251193] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 149.251787] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 149.252001] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 149.298666] [IGT] kms_flip: starting subtest wf_vblank-ts-check-interruptible <7>[ 149.299381] [IGT] kms_flip: finished subtest wf_vblank-ts-check-interruptible, SKIP <7>[ 149.301863] [IGT] kms_flip: exiting, ret=77 <7>[ 149.302151] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 149.406635] [IGT] sw_sync: executing <7>[ 149.420319] [IGT] sw_sync: starting subtest sync_multi_consumer_producer <7>[ 149.702958] [IGT] sw_sync: finished subtest sync_multi_consumer_producer, SUCCESS <7>[ 149.703054] [IGT] sw_sync: exiting, ret=0 <7>[ 149.797971] [IGT] kms_pipe_crc_basic: executing <7>[ 149.806281] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 149.806868] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 149.807077] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 149.851208] [IGT] kms_pipe_crc_basic: exiting, ret=77 <7>[ 149.851497] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 149.956721] [IGT] i915_pm_rps: executing <7>[ 149.970595] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 149.971308] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 149.971581] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 149.972105] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 149.978343] [IGT] i915_pm_rps: starting subtest thresholds <7>[ 149.978713] [IGT] i915_pm_rps: starting dynamic subtest gt0 <7>[ 149.978945] [drm:eb_validate_vma [i915]] EINVAL at eb_validate_vma:508 <7>[ 160.023279] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x0000005c [0x0000005c] <7>[ 160.053808] [IGT] i915_pm_rps: finished subtest gt0, SUCCESS <7>[ 160.054561] [IGT] i915_pm_rps: finished subtest thresholds, SUCCESS <7>[ 160.055158] [IGT] i915_pm_rps: exiting, ret=0 <7>[ 160.058192] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 160.163099] [IGT] kms_frontbuffer_tracking: executing <7>[ 160.178002] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 160.178763] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 160.179066] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 160.223362] [IGT] kms_frontbuffer_tracking: exiting, ret=77 <7>[ 160.223617] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 160.331590] [IGT] gen9_exec_parse: executing <7>[ 160.342568] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 160.343204] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 160.343475] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 160.343927] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 160.347169] [IGT] gen9_exec_parse: exiting, ret=77 <7>[ 160.347316] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 160.454588] [IGT] kms_frontbuffer_tracking: executing <7>[ 160.469765] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 160.470620] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 160.470938] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 160.514183] [IGT] kms_frontbuffer_tracking: exiting, ret=77 <7>[ 160.514438] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 160.609740] [IGT] kms_hdr: executing <7>[ 160.617476] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 160.618022] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 160.618230] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 160.660091] [IGT] kms_hdr: exiting, ret=77 <7>[ 160.660393] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 160.754028] [IGT] gem_mmap_wc: executing <7>[ 160.772300] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 160.773297] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 160.773819] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 160.774717] [IGT] gem_mmap_wc: starting subtest set-cache-level <7>[ 160.775093] [IGT] gem_mmap_wc: finished subtest set-cache-level, SKIP <7>[ 160.775417] [IGT] gem_mmap_wc: exiting, ret=77 <7>[ 160.775743] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 160.896319] [IGT] gem_exec_reloc: executing <7>[ 160.905476] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 160.906013] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 160.906218] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 160.906663] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 160.910256] [drm:eb_validate_vma [i915]] EINVAL at eb_validate_vma:508 <7>[ 160.910539] [IGT] gem_exec_reloc: exiting, ret=77 <7>[ 160.910694] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 161.017450] [IGT] kms_frontbuffer_tracking: executing <7>[ 161.024689] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 161.025223] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 161.025494] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 161.072536] [IGT] kms_frontbuffer_tracking: exiting, ret=77 <7>[ 161.072787] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 161.161587] [IGT] kms_addfb_basic: executing <7>[ 161.175955] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 161.176734] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 161.177043] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 161.222947] [IGT] kms_addfb_basic: starting subtest addfb25-x-tiled-mismatch-legacy <7>[ 161.223055] [IGT] kms_addfb_basic: finished subtest addfb25-x-tiled-mismatch-legacy, SUCCESS <7>[ 161.223338] [IGT] kms_addfb_basic: exiting, ret=0 <7>[ 161.223553] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 161.319902] [IGT] kms_flip: executing <7>[ 161.334050] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 161.334862] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 161.335174] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 161.379219] [IGT] kms_flip: starting subtest 2x-plain-flip <7>[ 161.379781] [IGT] kms_flip: finished subtest 2x-plain-flip, SKIP <7>[ 161.385728] [IGT] kms_flip: exiting, ret=77 <7>[ 161.386041] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 161.499078] [IGT] gem_ctx_persistence: executing <7>[ 161.513503] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 161.514147] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 161.514489] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 161.515046] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 161.519721] [IGT] gem_ctx_persistence: starting subtest legacy-engines-hostile <7>[ 161.520093] [IGT] gem_ctx_persistence: starting dynamic subtest render <7>[ 161.520228] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 161.521464] [drm:eb_validate_vma [i915]] EINVAL at eb_validate_vma:508 <5>[ 161.579770] i915 0000:00:02.0: [drm] Resetting rcs0 for preemption time out <6>[ 161.587060] i915 0000:00:02.0: [drm] GPU HANG: ecode 12:1:e75ffefe, in gem_ctx_persist [2389] <6>[ 161.587071] i915 0000:00:02.0: [drm] GPU error state saved to /sys/class/drm/card0/error <7>[ 161.589120] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x0000005c [0x0000005c] <7>[ 161.637928] [IGT] gem_ctx_persistence: finished subtest render, SUCCESS <7>[ 161.638987] [IGT] gem_ctx_persistence: starting dynamic subtest bsd <7>[ 161.639380] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 161.642033] [drm:eb_validate_vma [i915]] EINVAL at eb_validate_vma:508 <5>[ 161.701793] i915 0000:00:02.0: [drm] Resetting vcs0 for preemption time out <6>[ 161.705780] i915 0000:00:02.0: [drm] GPU HANG: ecode 12:4:277ffefe, in gem_ctx_persist [2389] <7>[ 161.707569] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x0000005c [0x0000005c] <7>[ 161.738930] [IGT] gem_ctx_persistence: finished subtest bsd, SUCCESS <7>[ 161.740097] [IGT] gem_ctx_persistence: starting dynamic subtest blt <7>[ 161.740531] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 161.743368] [drm:eb_validate_vma [i915]] EINVAL at eb_validate_vma:508 <5>[ 161.804929] i915 0000:00:02.0: [drm] Resetting bcs0 for preemption time out <6>[ 161.806864] i915 0000:00:02.0: [drm] GPU HANG: ecode 12:2:18800102, in gem_ctx_persist [2389] <7>[ 161.807398] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x0000005c [0x0000005c] <7>[ 161.853908] [IGT] gem_ctx_persistence: finished subtest blt, SUCCESS <7>[ 161.855126] [IGT] gem_ctx_persistence: starting dynamic subtest vebox <7>[ 161.855625] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 161.858389] [drm:eb_validate_vma [i915]] EINVAL at eb_validate_vma:508 <5>[ 161.917791] i915 0000:00:02.0: [drm] Resetting vecs0 for preemption time out <6>[ 161.921743] i915 0000:00:02.0: [drm] GPU HANG: ecode 12:8:277ffefe, in gem_ctx_persist [2389] <7>[ 161.923500] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x0000005c [0x0000005c] <7>[ 161.957770] [IGT] gem_ctx_persistence: finished subtest vebox, SUCCESS <7>[ 161.958107] [IGT] gem_ctx_persistence: finished subtest legacy-engines-hostile, SUCCESS <7>[ 161.962083] [IGT] gem_ctx_persistence: exiting, ret=0 <7>[ 161.962913] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 162.066803] [IGT] kms_frontbuffer_tracking: executing <7>[ 162.078798] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 162.079514] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 162.079766] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 162.123700] [IGT] kms_frontbuffer_tracking: exiting, ret=77 <7>[ 162.123947] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 162.225530] [IGT] kms_frontbuffer_tracking: executing <7>[ 162.237535] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 162.238228] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 162.238538] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 162.286129] [IGT] kms_frontbuffer_tracking: exiting, ret=77 <7>[ 162.286422] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 162.393504] [IGT] gem_exec_store: executing <7>[ 162.405326] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 162.405858] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 162.406060] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 162.406569] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 162.413109] [IGT] gem_exec_store: starting subtest dword <7>[ 162.413208] [IGT] gem_exec_store: starting dynamic subtest rcs0 <7>[ 162.413281] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x0000005c [0x0000005c] <7>[ 162.414854] [drm:eb_validate_vma [i915]] EINVAL at eb_validate_vma:508 <7>[ 162.416190] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x0000005c [0x0000005c] <7>[ 162.467064] [IGT] gem_exec_store: finished subtest rcs0, SUCCESS <7>[ 162.467398] [IGT] gem_exec_store: starting dynamic subtest bcs0 <7>[ 162.467835] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x0000005c [0x0000005c] <7>[ 162.469487] [drm:eb_validate_vma [i915]] EINVAL at eb_validate_vma:508 <7>[ 162.473732] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x0000005c [0x0000005c] <7>[ 162.486701] [IGT] gem_exec_store: finished subtest bcs0, SUCCESS <7>[ 162.486856] [IGT] gem_exec_store: starting dynamic subtest vcs0 <7>[ 162.487027] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x0000005c [0x0000005c] <7>[ 162.487898] [drm:eb_validate_vma [i915]] EINVAL at eb_validate_vma:508 <7>[ 162.491003] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x0000005c [0x0000005c] <7>[ 162.515654] [IGT] gem_exec_store: finished subtest vcs0, SUCCESS <7>[ 162.515750] [IGT] gem_exec_store: starting dynamic subtest vecs0 <7>[ 162.515844] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x0000005c [0x0000005c] <7>[ 162.516334] [drm:eb_validate_vma [i915]] EINVAL at eb_validate_vma:508 <7>[ 162.518542] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x0000005c [0x0000005c] <7>[ 162.543843] [IGT] gem_exec_store: finished subtest vecs0, SUCCESS <7>[ 162.543994] [IGT] gem_exec_store: finished subtest dword, SUCCESS <7>[ 162.654961] [IGT] gem_exec_store: exiting, ret=0 <7>[ 162.655901] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 162.749085] [IGT] kms_big_fb: executing <7>[ 162.761129] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 162.761756] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 162.762004] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 162.807940] [IGT] kms_big_fb: exiting, ret=77 <7>[ 162.808207] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 162.893664] [IGT] syncobj_timeline: executing <7>[ 162.901618] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 162.902183] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 162.902575] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 162.903948] [IGT] syncobj_timeline: starting subtest etime-multi-wait-all-for-submit-available-unsubmitted <7>[ 163.011939] [IGT] syncobj_timeline: finished subtest etime-multi-wait-all-for-submit-available-unsubmitted, SUCCESS <7>[ 163.012956] [IGT] syncobj_timeline: exiting, ret=0 <7>[ 163.013931] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 163.106332] [IGT] dmabuf: executing <7>[ 163.116714] [IGT] dmabuf: starting subtest all-tests <7>[ 163.116788] [IGT] dmabuf: starting dynamic subtest sanitycheck <6>[ 163.119483] dma-buf: Running sanitycheck <7>[ 163.191161] [IGT] dmabuf: finished subtest sanitycheck, SUCCESS <7>[ 163.191955] [IGT] dmabuf: starting dynamic subtest dma_fence <6>[ 163.198974] dma-buf: Running dma_fence <6>[ 163.198983] sizeof(dma_fence)=64 <6>[ 163.199816] dma-buf: Running dma_fence/sanitycheck <6>[ 163.200048] dma-buf: Running dma_fence/test_signaling <6>[ 163.200057] dma-buf: Running dma_fence/test_add_callback <6>[ 163.200064] dma-buf: Running dma_fence/test_late_add_callback <6>[ 163.200072] dma-buf: Running dma_fence/test_rm_callback <6>[ 163.200079] dma-buf: Running dma_fence/test_late_rm_callback <6>[ 163.200087] dma-buf: Running dma_fence/test_status <6>[ 163.200094] dma-buf: Running dma_fence/test_error <6>[ 163.200101] dma-buf: Running dma_fence/test_wait <6>[ 163.200113] dma-buf: Running dma_fence/test_wait_timeout <6>[ 163.203730] dma-buf: Running dma_fence/test_stub <6>[ 163.203737] dma-buf: Running dma_fence/race_signal_callback <6>[ 163.254333] thread_signal_callback[0] completed 8747 passes, 7 misses <6>[ 163.254354] thread_signal_callback[1] completed 8749 passes, 11 misses <6>[ 163.305369] thread_signal_callback[0] completed 9659 passes, 9659 misses <6>[ 163.305390] thread_signal_callback[1] completed 9679 passes, 9672 misses <7>[ 163.420114] [IGT] dmabuf: finished subtest dma_fence, SUCCESS <7>[ 163.420690] [IGT] dmabuf: starting dynamic subtest dma_fence_chain <6>[ 163.427756] dma-buf: Running dma_fence_chain <6>[ 163.427765] sizeof(dma_fence_chain)=184 <6>[ 163.428868] dma-buf: Running dma_fence_chain/sanitycheck <6>[ 163.429798] dma-buf: Running dma_fence_chain/find_seqno <6>[ 163.430748] dma-buf: Running dma_fence_chain/find_signaled <6>[ 163.430788] dma-buf: Running dma_fence_chain/find_out_of_order <6>[ 163.430852] dma-buf: Running dma_fence_chain/find_gap <6>[ 163.431701] dma-buf: Running dma_fence_chain/find_race <6>[ 168.748717] Completed 4095 cycles <6>[ 168.759888] dma-buf: Running dma_fence_chain/signal_forward <6>[ 168.761133] dma-buf: Running dma_fence_chain/signal_backward <6>[ 168.763125] dma-buf: Running dma_fence_chain/wait_forward <6>[ 168.807915] dma-buf: Running dma_fence_chain/wait_backward <6>[ 172.234885] dma-buf: Running dma_fence_chain/wait_random <7>[ 172.430594] [IGT] dmabuf: finished subtest dma_fence_chain, SUCCESS <7>[ 172.430789] [IGT] dmabuf: starting dynamic subtest dma_fence_unwrap <6>[ 172.434034] dma-buf: Running dma_fence_unwrap <6>[ 172.434038] dma-buf: Running dma_fence_unwrap/sanitycheck <6>[ 172.434124] dma-buf: Running dma_fence_unwrap/unwrap_array <6>[ 172.434158] dma-buf: Running dma_fence_unwrap/unwrap_chain <6>[ 172.434183] dma-buf: Running dma_fence_unwrap/unwrap_chain_array <6>[ 172.434236] dma-buf: Running dma_fence_unwrap/unwrap_merge <6>[ 172.434261] dma-buf: Running dma_fence_unwrap/unwrap_merge_duplicate <6>[ 172.434274] dma-buf: Running dma_fence_unwrap/unwrap_merge_seqno <6>[ 172.434308] dma-buf: Running dma_fence_unwrap/unwrap_merge_order <6>[ 172.434347] dma-buf: Running dma_fence_unwrap/unwrap_merge_complex <6>[ 172.434392] dma-buf: Running dma_fence_unwrap/unwrap_merge_complex_seqno <7>[ 172.500035] [IGT] dmabuf: finished subtest dma_fence_unwrap, SUCCESS <7>[ 172.500644] [IGT] dmabuf: starting dynamic subtest dma_resv <6>[ 172.507610] dma-buf: Running dma_resv <6>[ 172.507624] dma-buf: Running dma_resv/sanitycheck <6>[ 172.508337] dma-buf: Running dma_resv/test_signaling <6>[ 172.508587] dma-buf: Running dma_resv/test_for_each <6>[ 172.508606] dma-buf: Running dma_resv/test_for_each_unlocked <6>[ 172.508624] dma-buf: Running dma_resv/test_get_fences <6>[ 172.508653] dma-buf: Running dma_resv/sanitycheck <6>[ 172.508662] dma-buf: Running dma_resv/test_signaling <6>[ 172.508677] dma-buf: Running dma_resv/test_for_each <6>[ 172.508698] dma-buf: Running dma_resv/test_for_each_unlocked <6>[ 172.508714] dma-buf: Running dma_resv/test_get_fences <6>[ 172.508739] dma-buf: Running dma_resv/sanitycheck <6>[ 172.508749] dma-buf: Running dma_resv/test_signaling <6>[ 172.508765] dma-buf: Running dma_resv/test_for_each <6>[ 172.508782] dma-buf: Running dma_resv/test_for_each_unlocked <6>[ 172.508799] dma-buf: Running dma_resv/test_get_fences <6>[ 172.508824] dma-buf: Running dma_resv/sanitycheck <6>[ 172.508834] dma-buf: Running dma_resv/test_signaling <6>[ 172.508850] dma-buf: Running dma_resv/test_for_each <6>[ 172.508865] dma-buf: Running dma_resv/test_for_each_unlocked <6>[ 172.508881] dma-buf: Running dma_resv/test_get_fences <7>[ 172.581977] [IGT] dmabuf: finished subtest dma_resv, SUCCESS <7>[ 172.582705] [IGT] dmabuf: finished subtest all-tests, SUCCESS <7>[ 172.583280] [IGT] dmabuf: exiting, ret=0 <7>[ 172.679081] [IGT] drm_read: executing <7>[ 172.691460] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 172.692014] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 172.692243] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 172.736379] [IGT] drm_read: exiting, ret=77 <7>[ 172.736615] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 172.824962] [IGT] gem_exec_params: executing <7>[ 172.840350] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 172.841119] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 172.841453] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 172.842000] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 172.846482] [IGT] gem_exec_params: starting subtest invalid-bsd2-flag-on-render <7>[ 172.846544] 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.846711] [IGT] gem_exec_params: finished subtest invalid-bsd2-flag-on-render, SUCCESS <7>[ 172.846857] [IGT] gem_exec_params: exiting, ret=0 <7>[ 172.847003] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 172.965381] [IGT] kms_frontbuffer_tracking: executing <7>[ 172.977023] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 172.977636] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 172.977863] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 173.023964] [IGT] kms_frontbuffer_tracking: exiting, ret=77 <7>[ 173.024263] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 173.113549] [IGT] syncobj_wait: executing <7>[ 173.121405] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 173.121930] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 173.122266] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 173.123788] [IGT] syncobj_wait: starting subtest single-wait-for-submit-signaled <7>[ 173.124009] [IGT] syncobj_wait: finished subtest single-wait-for-submit-signaled, SUCCESS <7>[ 173.124188] [IGT] syncobj_wait: exiting, ret=0 <7>[ 173.124348] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 173.225472] [IGT] kms_psr: executing <7>[ 173.237460] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 173.238110] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 173.238365] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 173.282365] [IGT] kms_psr: exiting, ret=77 <7>[ 173.282646] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 173.373591] [IGT] dumb_buffer: executing <7>[ 173.385284] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 173.385931] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 173.386214] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 173.386613] [IGT] dumb_buffer: starting subtest map-invalid-size <7>[ 173.386838] [IGT] dumb_buffer: finished subtest map-invalid-size, SUCCESS <7>[ 173.387014] [IGT] dumb_buffer: exiting, ret=0 <7>[ 173.387231] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 173.505372] [IGT] gem_exec_params: executing <7>[ 173.517194] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 173.517774] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 173.518000] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 173.518439] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 173.521372] [IGT] gem_exec_params: starting subtest invalid-batch-start-offset <7>[ 173.521525] [drm:i915_gem_execbuffer2_ioctl [i915]] EINVAL at i915_gem_check_execbuffer:2215 <7>[ 173.521655] [drm:i915_gem_execbuffer2_ioctl [i915]] EINVAL at i915_gem_check_execbuffer:2215 <7>[ 173.521783] [drm:i915_gem_execbuffer2_ioctl [i915]] EINVAL at i915_gem_check_execbuffer:2215 <7>[ 173.522047] i915 0000:00:02.0: [drm:eb_add_vma [i915]] Attempting to use out-of-bounds batch <7>[ 173.522176] [drm:eb_add_vma [i915]] EINVAL at eb_add_vma:612 <7>[ 173.522371] i915 0000:00:02.0: [drm:eb_add_vma [i915]] Attempting to use out-of-bounds batch <7>[ 173.522485] [drm:eb_add_vma [i915]] EINVAL at eb_add_vma:612 <7>[ 173.522649] i915 0000:00:02.0: [drm:eb_add_vma [i915]] Attempting to use out-of-bounds batch <7>[ 173.522763] [drm:eb_add_vma [i915]] EINVAL at eb_add_vma:612 <7>[ 173.522929] i915 0000:00:02.0: [drm:eb_add_vma [i915]] Attempting to use out-of-bounds batch <7>[ 173.523044] [drm:eb_add_vma [i915]] EINVAL at eb_add_vma:612 <7>[ 173.523342] [IGT] gem_exec_params: finished subtest invalid-batch-start-offset, SUCCESS <7>[ 173.523485] [IGT] gem_exec_params: exiting, ret=0 <7>[ 173.523636] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 173.663539] [IGT] kms_frontbuffer_tracking: executing <7>[ 173.671940] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 173.672502] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 173.672709] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 173.716380] [IGT] kms_frontbuffer_tracking: exiting, ret=77 <7>[ 173.716626] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 173.806848] [IGT] i915_pm_rc6_residency: executing <7>[ 173.818734] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 173.819448] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 173.819709] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 173.820176] [IGT] i915_pm_rc6_residency: starting subtest rc6-fence <7>[ 173.820343] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 173.823556] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x0000005c [0x0000005c] <7>[ 173.823775] [IGT] i915_pm_rc6_residency: starting dynamic subtest gt0 <7>[ 173.825053] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x00000040 [0x00000040] <7>[ 176.997484] [drm:eb_validate_vma [i915]] EINVAL at eb_validate_vma:508 <7>[ 180.002826] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x0000005c [0x0000005c] <7>[ 183.106651] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x0000005c [0x0000005c] <7>[ 186.131928] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x0000005c [0x0000005c] <7>[ 189.164692] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x0000005c [0x0000005c] <7>[ 189.180518] [IGT] i915_pm_rc6_residency: finished subtest gt0, SUCCESS <7>[ 189.181130] [IGT] i915_pm_rc6_residency: finished subtest rc6-fence, SUCCESS <7>[ 189.182120] [IGT] i915_pm_rc6_residency: exiting, ret=0 <7>[ 189.182891] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 189.267468] [IGT] kms_frontbuffer_tracking: executing <7>[ 189.279478] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 189.280183] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 189.280398] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 189.326657] [IGT] kms_frontbuffer_tracking: exiting, ret=77 <7>[ 189.326954] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 189.423343] [IGT] api_intel_allocator: executing <7>[ 189.431420] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 189.432018] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 189.432231] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 189.432564] [IGT] api_intel_allocator: starting subtest gem-pool <7>[ 189.432792] [drm:eb_validate_vma [i915]] EINVAL at eb_validate_vma:508 <7>[ 189.436794] [IGT] api_intel_allocator: finished subtest gem-pool, SUCCESS <7>[ 189.437035] [IGT] api_intel_allocator: exiting, ret=0 <7>[ 189.437199] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 189.570324] [IGT] kms_cursor_edge_walk: executing <7>[ 189.578068] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 189.578586] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 189.578791] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 189.623090] [IGT] kms_cursor_edge_walk: exiting, ret=77 <7>[ 189.623313] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 189.720263] [IGT] kms_cursor_legacy: executing <7>[ 189.730146] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 189.730721] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 189.730998] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 189.778683] [IGT] kms_cursor_legacy: exiting, ret=77 <7>[ 189.779021] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 189.932468] [IGT] gem_exec_endless: executing <7>[ 189.944128] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 189.944739] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 189.945003] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 189.945438] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 189.963351] [IGT] gem_exec_endless: starting subtest dispatch <7>[ 189.963443] [IGT] gem_exec_endless: starting dynamic subtest rcs0 <7>[ 189.966049] [IGT] gem_exec_endless: finished subtest rcs0, SUCCESS <7>[ 189.966113] [IGT] gem_exec_endless: starting dynamic subtest bcs0 <7>[ 189.968208] [IGT] gem_exec_endless: finished subtest bcs0, SUCCESS <7>[ 189.968266] [IGT] gem_exec_endless: starting dynamic subtest vcs0 <7>[ 189.970753] [IGT] gem_exec_endless: finished subtest vcs0, SUCCESS <7>[ 189.970813] [IGT] gem_exec_endless: starting dynamic subtest vecs0 <7>[ 189.973214] [IGT] gem_exec_endless: finished subtest vecs0, SUCCESS <7>[ 189.973294] [IGT] gem_exec_endless: finished subtest dispatch, SUCCESS <7>[ 189.974675] [IGT] gem_exec_endless: exiting, ret=0 <7>[ 189.974867] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 190.191028] [IGT] kms_ccs: executing <7>[ 190.206537] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 190.207423] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 190.207736] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 190.254421] [IGT] kms_ccs: exiting, ret=77 <7>[ 190.254705] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 190.354381] [IGT] kms_frontbuffer_tracking: executing <7>[ 190.361888] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 190.362436] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 190.362644] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 190.407097] [IGT] kms_frontbuffer_tracking: exiting, ret=77 <7>[ 190.407352] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 190.515135] [IGT] kms_color: executing <7>[ 190.522965] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 190.523493] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 190.523697] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 190.568145] [IGT] kms_color: starting subtest legacy-gamma-reset <7>[ 190.568240] [IGT] kms_color: finished subtest legacy-gamma-reset, SKIP <7>[ 190.568429] [IGT] kms_color: exiting, ret=77 <7>[ 190.568667] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 190.682760] [IGT] kms_async_flips: executing <7>[ 190.697226] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 190.698060] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 190.698366] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 190.747013] [IGT] kms_async_flips: exiting, ret=77 <7>[ 190.747270] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 190.851730] [IGT] perf: executing <7>[ 190.876668] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 190.877127] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 190.882341] [IGT] perf: starting subtest disabled-read-error <7>[ 190.887239] 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.893156] 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.900993] [IGT] perf: finished subtest disabled-read-error, SUCCESS <7>[ 190.901273] [IGT] perf: exiting, ret=0 <7>[ 190.987764] [IGT] kms_psr: executing <7>[ 190.999314] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 190.999856] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 191.000121] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 191.047282] [IGT] kms_psr: exiting, ret=77 <7>[ 191.047589] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 191.143784] [IGT] syncobj_timeline: executing <7>[ 191.153467] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 191.154066] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 191.154292] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 191.155598] [IGT] syncobj_timeline: starting subtest etime-single-wait-submitted <7>[ 191.259017] [IGT] syncobj_timeline: finished subtest etime-single-wait-submitted, SUCCESS <7>[ 191.259245] [IGT] syncobj_timeline: exiting, ret=0 <7>[ 191.259438] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 191.340052] [IGT] syncobj_timeline: executing <7>[ 191.351687] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 191.352376] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 191.352632] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 191.354236] [IGT] syncobj_timeline: starting subtest single-wait-all-signaled <7>[ 191.354583] [IGT] syncobj_timeline: finished subtest single-wait-all-signaled, SUCCESS <7>[ 191.354836] [IGT] syncobj_timeline: exiting, ret=0 <7>[ 191.355060] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 191.477358] [IGT] kms_vblank: executing <7>[ 191.485002] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 191.485548] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 191.485765] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 191.528761] [IGT] kms_vblank: exiting, ret=77 <7>[ 191.529123] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 191.619868] [IGT] gem_exec_schedule: executing <7>[ 191.640321] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 191.641296] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 191.641683] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 191.642588] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 191.650336] [IGT] gem_exec_schedule: starting subtest implicit-write-read <7>[ 191.650447] [IGT] gem_exec_schedule: starting dynamic subtest rcs0 <7>[ 191.650630] [drm:eb_validate_vma [i915]] EINVAL at eb_validate_vma:508 <7>[ 191.655183] [drm:eb_validate_vma [i915]] EINVAL at eb_validate_vma:508 <7>[ 191.656434] [drm:eb_validate_vma [i915]] EINVAL at eb_validate_vma:508 <7>[ 191.657484] [drm:eb_validate_vma [i915]] EINVAL at eb_validate_vma:508 <7>[ 191.658492] [drm:eb_validate_vma [i915]] EINVAL at eb_validate_vma:508 <7>[ 191.659490] [drm:eb_validate_vma [i915]] EINVAL at eb_validate_vma:508 <7>[ 191.660561] [drm:eb_validate_vma [i915]] EINVAL at eb_validate_vma:508 <7>[ 191.661564] [drm:eb_validate_vma [i915]] EINVAL at eb_validate_vma:508 <7>[ 191.662538] [drm:eb_validate_vma [i915]] EINVAL at eb_validate_vma:508 <7>[ 191.663620] [drm:eb_validate_vma [i915]] EINVAL at eb_validate_vma:508 <7>[ 191.664613] [drm:eb_validate_vma [i915]] EINVAL at eb_validate_vma:508 <7>[ 191.665679] [drm:eb_validate_vma [i915]] EINVAL at eb_validate_vma:508 <7>[ 191.666720] [drm:eb_validate_vma [i915]] EINVAL at eb_validate_vma:508 <7>[ 191.667925] [drm:eb_validate_vma [i915]] EINVAL at eb_validate_vma:508 <7>[ 191.668886] [drm:eb_validate_vma [i915]] EINVAL at eb_validate_vma:508 <7>[ 191.670000] [drm:eb_validate_vma [i915]] EINVAL at eb_validate_vma:508 <7>[ 191.671057] [drm:eb_validate_vma [i915]] EINVAL at eb_validate_vma:508 <7>[ 191.725034] [IGT] gem_exec_schedule: finished subtest rcs0, SUCCESS <7>[ 191.725194] [IGT] gem_exec_schedule: starting dynamic subtest bcs0 <7>[ 191.725629] [drm:eb_validate_vma [i915]] EINVAL at eb_validate_vma:508 <7>[ 191.730053] [drm:eb_validate_vma [i915]] EINVAL at eb_validate_vma:508 <7>[ 191.731678] [drm:eb_validate_vma [i915]] EINVAL at eb_validate_vma:508 <7>[ 191.732853] [drm:eb_validate_vma [i915]] EINVAL at eb_validate_vma:508 <7>[ 191.734039] [drm:eb_validate_vma [i915]] EINVAL at eb_validate_vma:508 <7>[ 191.735144] [drm:eb_validate_vma [i915]] EINVAL at eb_validate_vma:508 <7>[ 191.736282] [drm:eb_validate_vma [i915]] EINVAL at eb_validate_vma:508 <7>[ 191.737299] [drm:eb_validate_vma [i915]] EINVAL at eb_validate_vma:508 <7>[ 191.738348] [drm:eb_validate_vma [i915]] EINVAL at eb_validate_vma:508 <7>[ 191.739371] [drm:eb_validate_vma [i915]] EINVAL at eb_validate_vma:508 <7>[ 191.741755] [drm:eb_validate_vma [i915]] EINVAL at eb_validate_vma:508 <7>[ 191.742812] [drm:eb_validate_vma [i915]] EINVAL at eb_validate_vma:508 <7>[ 191.743831] [drm:eb_validate_vma [i915]] EINVAL at eb_validate_vma:508 <7>[ 191.744961] [drm:eb_validate_vma [i915]] EINVAL at eb_validate_vma:508 <7>[ 191.745948] [drm:eb_validate_vma [i915]] EINVAL at eb_validate_vma:508 <7>[ 191.746929] [drm:eb_validate_vma [i915]] EINVAL at eb_validate_vma:508 <7>[ 191.747943] [drm:eb_validate_vma [i915]] EINVAL at eb_validate_vma:508 <7>[ 191.792887] [IGT] gem_exec_schedule: finished subtest bcs0, SUCCESS <7>[ 191.793089] [IGT] gem_exec_schedule: starting dynamic subtest vcs0 <7>[ 191.795669] [drm:eb_validate_vma [i915]] EINVAL at eb_validate_vma:508 <7>[ 191.800080] [drm:eb_validate_vma [i915]] EINVAL at eb_validate_vma:508 <7>[ 191.801621] [drm:eb_validate_vma [i915]] EINVAL at eb_validate_vma:508 <7>[ 191.803027] [drm:eb_validate_vma [i915]] EINVAL at eb_validate_vma:508 <7>[ 191.804198] [drm:eb_validate_vma [i915]] EINVAL at eb_validate_vma:508 <7>[ 191.805227] [drm:eb_validate_vma [i915]] EINVAL at eb_validate_vma:508 <7>[ 191.806276] [drm:eb_validate_vma [i915]] EINVAL at eb_validate_vma:508 <7>[ 191.808599] [drm:eb_validate_vma [i915]] EINVAL at eb_validate_vma:508 <7>[ 191.809674] [drm:eb_validate_vma [i915]] EINVAL at eb_validate_vma:508 <7>[ 191.810723] [drm:eb_validate_vma [i915]] EINVAL at eb_validate_vma:508 <7>[ 191.811796] [drm:eb_validate_vma [i915]] EINVAL at eb_validate_vma:508 <7>[ 191.812864] [drm:eb_validate_vma [i915]] EINVAL at eb_validate_vma:508 <7>[ 191.813865] [drm:eb_validate_vma [i915]] EINVAL at eb_validate_vma:508 <7>[ 191.814960] [drm:eb_validate_vma [i915]] EINVAL at eb_validate_vma:508 <7>[ 191.815973] [drm:eb_validate_vma [i915]] EINVAL at eb_validate_vma:508 <7>[ 191.816921] [drm:eb_validate_vma [i915]] EINVAL at eb_validate_vma:508 <7>[ 191.817943] [drm:eb_validate_vma [i915]] EINVAL at eb_validate_vma:508 <7>[ 191.867628] [IGT] gem_exec_schedule: finished subtest vcs0, SUCCESS <7>[ 191.867706] [IGT] gem_exec_schedule: starting dynamic subtest vecs0 <7>[ 191.868820] [drm:eb_validate_vma [i915]] EINVAL at eb_validate_vma:508 <7>[ 191.871213] [drm:eb_validate_vma [i915]] EINVAL at eb_validate_vma:508 <7>[ 191.872247] [drm:eb_validate_vma [i915]] EINVAL at eb_validate_vma:508 <7>[ 191.873252] [drm:eb_validate_vma [i915]] EINVAL at eb_validate_vma:508 <7>[ 191.874231] [drm:eb_validate_vma [i915]] EINVAL at eb_validate_vma:508 <7>[ 191.875238] [drm:eb_validate_vma [i915]] EINVAL at eb_validate_vma:508 <7>[ 191.876355] [drm:eb_validate_vma [i915]] EINVAL at eb_validate_vma:508 <7>[ 191.877490] [drm:eb_validate_vma [i915]] EINVAL at eb_validate_vma:508 <7>[ 191.878611] [drm:eb_validate_vma [i915]] EINVAL at eb_validate_vma:508 <7>[ 191.879732] [drm:eb_validate_vma [i915]] EINVAL at eb_validate_vma:508 <7>[ 191.880750] [drm:eb_validate_vma [i915]] EINVAL at eb_validate_vma:508 <7>[ 191.883722] [drm:eb_validate_vma [i915]] EINVAL at eb_validate_vma:508 <7>[ 191.884729] [drm:eb_validate_vma [i915]] EINVAL at eb_validate_vma:508 <7>[ 191.885753] [drm:eb_validate_vma [i915]] EINVAL at eb_validate_vma:508 <7>[ 191.886693] [drm:eb_validate_vma [i915]] EINVAL at eb_validate_vma:508 <7>[ 191.887661] [drm:eb_validate_vma [i915]] EINVAL at eb_validate_vma:508 <7>[ 191.888680] [drm:eb_validate_vma [i915]] EINVAL at eb_validate_vma:508 <7>[ 191.949178] [IGT] gem_exec_schedule: finished subtest vecs0, SUCCESS <7>[ 191.949302] [IGT] gem_exec_schedule: finished subtest implicit-write-read, SUCCESS <7>[ 192.054538] i915 0000:00:02.0: [drm:error_state_write [i915]] Resetting error state <7>[ 192.165269] [IGT] gem_exec_schedule: exiting, ret=0 <7>[ 192.165487] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 192.259054] [IGT] kms_frontbuffer_tracking: executing <7>[ 192.271072] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 192.271629] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 192.271937] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 192.321629] [IGT] kms_frontbuffer_tracking: exiting, ret=77 <7>[ 192.321997] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 192.412984] [IGT] syncobj_wait: executing <7>[ 192.431071] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 192.431949] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 192.432338] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 192.434502] [IGT] syncobj_wait: starting subtest multi-wait-all-for-submit-submitted-signaled <7>[ 192.539464] [IGT] syncobj_wait: finished subtest multi-wait-all-for-submit-submitted-signaled, SUCCESS <7>[ 192.540331] [IGT] syncobj_wait: exiting, ret=0 <7>[ 192.541137] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 192.637035] [IGT] kms_plane_multiple: executing <7>[ 192.644960] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 192.645485] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 192.645683] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 192.691002] [IGT] kms_plane_multiple: exiting, ret=77 <7>[ 192.691251] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 192.782049] [IGT] kms_chamelium_hpd: executing <7>[ 192.790097] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 192.790634] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 192.790884] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 192.837794] [IGT] kms_chamelium_hpd: exiting, ret=77 <7>[ 192.838055] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 192.928410] [IGT] kms_cursor_crc: executing <7>[ 192.942977] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 192.943650] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 192.943953] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 192.988247] [IGT] kms_cursor_crc: exiting, ret=77 <7>[ 192.988468] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 193.093176] [IGT] kms_ccs: executing <7>[ 193.101058] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 193.101583] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 193.101811] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 193.147153] [IGT] kms_ccs: exiting, ret=77 <7>[ 193.147417] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 193.236645] [IGT] perf_pmu: executing <7>[ 193.248440] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 193.249108] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 193.253341] [IGT] perf_pmu: starting subtest all-busy-check-all <7>[ 193.253586] [drm:eb_validate_vma [i915]] EINVAL at eb_validate_vma:508 <7>[ 193.758687] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x0000005c [0x0000005c] <7>[ 193.825364] [IGT] perf_pmu: finished subtest all-busy-check-all, SUCCESS <7>[ 193.825978] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 193.827985] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 193.831092] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x0000005c [0x0000005c] <7>[ 193.831387] [IGT] perf_pmu: exiting, ret=0 <7>[ 193.913037] [IGT] kms_cursor_crc: executing <7>[ 193.924730] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 193.925338] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 193.925584] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 193.971256] [IGT] kms_cursor_crc: exiting, ret=77 <7>[ 193.971464] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 194.056151] [IGT] gem_readwrite: executing <7>[ 194.063611] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 194.064164] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 194.064369] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 194.064777] [IGT] gem_readwrite: exiting, ret=77 <7>[ 194.064926] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 194.174450] [IGT] gem_mmap_gtt: executing <7>[ 194.186334] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 194.186963] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 194.187207] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 194.187606] [IGT] gem_mmap_gtt: starting subtest basic-small-bo-tiledX <7>[ 194.197744] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 194.198129] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x00000070 [0x00000070] <7>[ 194.240316] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x00000070 [0x00000070] <7>[ 194.273342] [IGT] gem_mmap_gtt: finished subtest basic-small-bo-tiledX, SUCCESS <7>[ 194.273764] [IGT] gem_mmap_gtt: exiting, ret=0 <7>[ 194.273953] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 194.438886] [IGT] gem_render_copy: executing <7>[ 194.446353] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 194.446885] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 194.447505] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 194.447686] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 194.452897] [IGT] gem_render_copy: starting subtest y-tiled-to-vebox-x-tiled <7>[ 194.452984] [IGT] gem_render_copy: starting dynamic subtest smem <7>[ 194.453183] [drm:eb_validate_vma [i915]] EINVAL at eb_validate_vma:508 <7>[ 194.577036] [IGT] gem_render_copy: finished subtest smem, SUCCESS <7>[ 194.577193] [IGT] gem_render_copy: finished subtest y-tiled-to-vebox-x-tiled, SUCCESS <7>[ 194.682941] [IGT] gem_render_copy: exiting, ret=0 <7>[ 194.683343] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 194.767268] [IGT] kms_big_fb: executing <7>[ 194.779138] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 194.779835] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 194.780099] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 194.827812] [IGT] kms_big_fb: exiting, ret=77 <7>[ 194.828068] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 194.928765] [IGT] kms_ccs: executing <7>[ 194.936365] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 194.936915] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 194.937124] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 194.981206] [IGT] kms_ccs: exiting, ret=77 <7>[ 194.981485] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 195.071640] [IGT] gem_exec_whisper: executing <7>[ 195.083291] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 195.083904] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 195.084114] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 195.084495] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 195.093048] [IGT] gem_exec_whisper: starting subtest basic-normal-all <7>[ 195.093334] [drm:eb_validate_vma [i915]] EINVAL at eb_validate_vma:508 <7>[ 195.093874] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x0000005c [0x0000005c] <7>[ 196.149475] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x0000005c [0x0000005c] <7>[ 196.157321] [IGT] gem_exec_whisper: finished subtest basic-normal-all, SUCCESS <7>[ 196.265556] [IGT] gem_exec_whisper: exiting, ret=0 <7>[ 196.265783] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 196.347507] [IGT] kms_frontbuffer_tracking: executing <7>[ 196.359261] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 196.359863] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 196.360094] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 196.404213] [IGT] kms_frontbuffer_tracking: exiting, ret=77 <7>[ 196.404449] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc]