[57.610710] Initializing watchdogs
[57.610758]   /dev/watchdog0
[57.625455] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics]
[57.630033] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[57.632251] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[57.635817] [001/133] (960s left) gem_exec_fence (submit-chain)
[57.832738] Starting subtest: submit-chain
[57.861710] Subtest submit-chain: SUCCESS (0.029s)
[60.004785] [FACT gem_exec_fence (submit-chain)] new: kernel.kmod_is_loaded.vgem: true
[60.007937] [002/133] (958s left) syncobj_wait (multi-wait-signaled)
[60.058951] Starting subtest: multi-wait-signaled
[60.061261] Subtest multi-wait-signaled: SUCCESS (0.000s)
[60.166142] [003/133] (958s left) gem_exec_schedule (noreorder-priority)
[60.341377] Starting subtest: noreorder-priority
[60.343998] Starting dynamic subtest: rcs0
[61.485397] Dynamic subtest rcs0: SUCCESS (1.151s)
[61.495973] Starting dynamic subtest: vcs0
[62.932392] Dynamic subtest vcs0: SUCCESS (1.452s)
[62.941830] Starting dynamic subtest: vcs1
[64.916553] Dynamic subtest vcs1: SUCCESS (1.990s)
[64.926919] Starting dynamic subtest: vecs0
[66.897229] Dynamic subtest vecs0: SUCCESS (1.985s)
[66.906799] Starting dynamic subtest: ccs0
[68.151733] Dynamic subtest ccs0: SUCCESS (1.257s)
[68.154277] Subtest noreorder-priority: SUCCESS (7.840s)
[68.334562] [004/133] (949s left) kms_cursor_legacy (modeset-atomic-cursor-hotspot)
[68.467370] Starting subtest: modeset-atomic-cursor-hotspot
[68.472018] Subtest modeset-atomic-cursor-hotspot: SKIP (0.000s)
[68.609188] [005/133] (949s left) gem_ctx_persistence (legacy-engines-hostile-preempt)
[68.664783] Starting subtest: legacy-engines-hostile-preempt
[68.666768] Starting dynamic subtest: render
[68.732188] Dynamic subtest render: SUCCESS (0.070s)
[68.742265] Starting dynamic subtest: bsd1
[69.885387] Dynamic subtest bsd1: SUCCESS (1.152s)
[69.894709] Starting dynamic subtest: bsd2
[71.885361] Dynamic subtest bsd2: SUCCESS (2.000s)
[71.896533] Starting dynamic subtest: blt
[71.925528] Dynamic subtest blt: SUCCESS (0.040s)
[71.933699] Starting dynamic subtest: vebox
[73.933475] Dynamic subtest vebox: SUCCESS (2.008s)
[73.936196] Subtest legacy-engines-hostile-preempt: SUCCESS (5.278s)
[74.010895] [006/133] (944s left) kms_flip (basic-flip-vs-wf_vblank)
[74.109211] Starting subtest: basic-flip-vs-wf_vblank
[74.111699] Starting dynamic subtest: A-eDP1
[76.107461] Dynamic subtest A-eDP1: SUCCESS (2.002s)
[76.117415] Starting dynamic subtest: B-eDP1
[78.046181] Dynamic subtest B-eDP1: SUCCESS (1.938s)
[78.054655] Starting dynamic subtest: C-eDP1
[79.963147] Dynamic subtest C-eDP1: SUCCESS (1.917s)
[79.973364] Starting dynamic subtest: D-eDP1
[81.895028] Dynamic subtest D-eDP1: SUCCESS (1.930s)
[81.897590] Subtest basic-flip-vs-wf_vblank: SUCCESS (7.794s)
[83.131624] [007/133] (935s left) api_intel_allocator (two-level-inception)
[83.187988] Starting subtest: two-level-inception
[88.587853] Subtest two-level-inception: SUCCESS (5.400s)
[88.744508] [008/133] (929s left) gem_exec_parallel (contexts)
[88.821411] Starting subtest: contexts
[88.823703] Starting dynamic subtest: rcs0
[92.423943] Dynamic subtest rcs0: SUCCESS (3.600s)
[92.431530] Starting dynamic subtest: bcs0
[95.985421] Dynamic subtest bcs0: SUCCESS (3.561s)
[95.993686] Starting dynamic subtest: vcs0
[100.410702] Dynamic subtest vcs0: SUCCESS (4.424s)
[100.420795] Starting dynamic subtest: vcs1
[104.466912] Dynamic subtest vcs1: SUCCESS (4.055s)
[104.474560] Starting dynamic subtest: vecs0
[108.402078] Dynamic subtest vecs0: SUCCESS (3.934s)
[108.409805] Starting dynamic subtest: ccs0
[112.293757] Dynamic subtest ccs0: SUCCESS (3.890s)
[112.296677] Subtest contexts: SUCCESS (23.471s)
[112.479229] [009/133] (905s left) kms_cursor_edge_walk (64x64-top-edge)
[112.579867] Starting subtest: 64x64-top-edge
[112.582267] Starting dynamic subtest: pipe-A-eDP-1
[116.014741] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.435s)
[116.023996] Starting dynamic subtest: pipe-D-eDP-1
[119.142681] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.126s)
[119.145026] Subtest 64x64-top-edge: SUCCESS (6.564s)
[119.955014] [010/133] (898s left) i915_drm_fdinfo (virtual-busy-all)
[119.994783] Starting subtest: virtual-busy-all
[119.999245] Subtest virtual-busy-all: SKIP (0.000s)
[120.061024] [011/133] (898s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-pwrite)
[120.147481] Starting subtest: fbcpsr-rgb101010-draw-pwrite
[127.166669] Subtest fbcpsr-rgb101010-draw-pwrite: SUCCESS (7.022s)
[127.280186] [012/133] (891s left) kms_atomic_transition (plane-all-modeset-transition-fencing-internal-panels)
[127.371585] Starting subtest: plane-all-modeset-transition-fencing-internal-panels
[127.373918] Starting dynamic subtest: pipe-A-eDP-1
[128.699878] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.329s)
[128.977905] Starting dynamic subtest: pipe-B-eDP-1
[130.030227] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.059s)
[130.299228] Subtest plane-all-modeset-transition-fencing-internal-panels: SUCCESS (2.927s)
[131.154204] [013/133] (887s left) gem_tiled_pread_basic (basic)
[131.217389] Subtest basic: SKIP (0.000s)
[131.272995] [014/133] (887s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-indfb-msflip-blt)
[131.398633] Starting subtest: fbcpsr-1p-primscrn-indfb-msflip-blt
[138.781991] Subtest fbcpsr-1p-primscrn-indfb-msflip-blt: SUCCESS (7.386s)
[138.915361] [015/133] (879s left) i915_drm_fdinfo (virtual-idle)
[138.956545] Starting subtest: virtual-idle
[142.022363] Subtest virtual-idle: SUCCESS (3.064s)
[142.100789] [016/133] (876s left) core_sysfs (read-all-entries)
[142.148861] Starting subtest: read-all-entries
[142.154174] Subtest read-all-entries: SUCCESS (0.007s)
[142.231729] [017/133] (876s left) kms_vblank (wait-idle)
[142.327166] Starting subtest: wait-idle
[142.329463] Starting dynamic subtest: pipe-A-eDP-1
[144.082921] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.755s)
[144.096441] Starting dynamic subtest: pipe-D-eDP-1
[146.531682] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.449s)
[146.534119] Subtest wait-idle: SUCCESS (4.207s)
[147.350440] [018/133] (871s left) kms_flip (flip-vs-panning-vs-hang)
[147.451685] Starting subtest: flip-vs-panning-vs-hang
[147.453641] Starting dynamic subtest: A-eDP1
[198.396737] Dynamic subtest A-eDP1: SUCCESS (50.947s)
[198.406040] Starting dynamic subtest: D-eDP1
[238.410697] Dynamic subtest D-eDP1: SUCCESS (40.013s)
[238.415694] Subtest flip-vs-panning-vs-hang: SUCCESS (90.965s)
[239.647183] [019/133] (779s left) gem_mmap_offset (blt-coherency)
[239.704062] Starting subtest: blt-coherency
[239.710087] Subtest blt-coherency: SUCCESS (0.008s)
[239.854230] [020/133] (779s left) gem_madvise (dontneed-before-exec)
[239.891145] Starting subtest: dontneed-before-exec
[239.910195] Subtest dontneed-before-exec: SKIP (0.017s)
[239.967542] [021/133] (778s left) gem_softpin (evict-active)
[240.025316] Starting subtest: evict-active
[240.031358] Subtest evict-active: SUCCESS (0.006s)
[240.158215] [022/133] (778s left) gem_sync (basic-many-each)
[240.220730] Starting subtest: basic-many-each
[242.499924] Subtest basic-many-each: SUCCESS (2.290s)
[242.678774] [023/133] (776s left) sysfs_timeslice_duration (timeout)
[242.731835] Starting subtest: timeout
[242.734270] Starting dynamic subtest: vecs0
[251.917715] Dynamic subtest vecs0: SUCCESS (9.183s)
[251.929980] Starting dynamic subtest: ccs0
[253.229238] Dynamic subtest ccs0: SUCCESS (1.311s)
[253.239650] Starting dynamic subtest: vcs0
[262.926934] Dynamic subtest vcs0: SUCCESS (9.696s)
[262.938294] Starting dynamic subtest: bcs0
[263.519249] Dynamic subtest bcs0: SUCCESS (0.593s)
[263.529302] Starting dynamic subtest: rcs0
[264.760337] Dynamic subtest rcs0: SUCCESS (1.238s)
[264.770778] Starting dynamic subtest: vcs1
[273.939023] Dynamic subtest vcs1: SUCCESS (9.176s)
[273.941534] Subtest timeout: SUCCESS (31.203s)
[274.019223] [024/133] (745s left) kms_atomic (crtc-invalid-params)
[274.114946] Starting subtest: crtc-invalid-params
[274.117348] Starting dynamic subtest: pipe-A-eDP-1
[274.470522] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.355s)
[274.472759] Subtest crtc-invalid-params: SUCCESS (0.356s)
[275.292265] [025/133] (743s left) gem_pread (snoop)
[275.361338] Subtest snoop: SKIP (0.000s)
[275.420257] [026/133] (743s left) i915_pm_rc6_residency (rc6-accuracy)
[275.472676] Starting subtest: rc6-accuracy
[275.474981] Starting dynamic subtest: gt0
[278.646305] Dynamic subtest gt0: SUCCESS (3.169s)
[278.655640] Starting dynamic subtest: gt1
[281.816984] Dynamic subtest gt1: SUCCESS (3.169s)
[281.819527] Subtest rc6-accuracy: SUCCESS (6.341s)
[281.902704] [027/133] (737s left) kms_pm_dc (dc5-psr)
[283.001138] Starting subtest: dc5-psr
[285.893881] Subtest dc5-psr: SUCCESS (2.892s)
[286.714696] [028/133] (732s left) kms_psr2_sf (pr-cursor-plane-move-continuous-exceed-fully-sf)
[286.814768] Starting subtest: pr-cursor-plane-move-continuous-exceed-fully-sf
[286.818940] Subtest pr-cursor-plane-move-continuous-exceed-fully-sf: SKIP (0.000s)
[286.895787] [029/133] (732s left) gem_ctx_param (non-root-set)
[286.936663] Starting subtest: non-root-set
[286.954668] Subtest non-root-set: SUCCESS (0.018s)
[287.053403] [030/133] (732s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-mmap-cpu)
[287.152252] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-mmap-cpu
[287.156231] Subtest psr-2p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[287.248648] [031/133] (732s left) gem_mmap_wc (read)
[287.313299] Subtest read: SKIP (0.000s)
[287.366270] [032/133] (732s left) syncobj_timeline (invalid-query-one-illegal-handle)
[287.413674] Starting subtest: invalid-query-one-illegal-handle
[287.415952] Subtest invalid-query-one-illegal-handle: SUCCESS (0.000s)
[287.500197] [033/133] (731s left) kms_color_pipeline (plane-ctm3x4-lut1d)
[287.587567] Starting subtest: plane-ctm3x4-lut1d
[287.736291] Starting dynamic subtest: pipe-A-plane-0
[288.065276] Dynamic subtest pipe-A-plane-0: FAIL (0.187s)
[288.075905] Starting dynamic subtest: pipe-A-plane-1
[288.272936] Dynamic subtest pipe-A-plane-1: FAIL (0.176s)
[288.283237] Starting dynamic subtest: pipe-A-plane-2
[288.486469] Dynamic subtest pipe-A-plane-2: FAIL (0.189s)
[289.552598] Starting dynamic subtest: pipe-B-plane-0
[289.976273] Dynamic subtest pipe-B-plane-0: FAIL (0.152s)
[289.985320] Starting dynamic subtest: pipe-B-plane-1
[290.304156] Dynamic subtest pipe-B-plane-1: FAIL (0.169s)
[290.316076] Starting dynamic subtest: pipe-B-plane-2
[290.597123] Dynamic subtest pipe-B-plane-2: FAIL (0.186s)
[291.248220] Starting dynamic subtest: pipe-C-plane-0
[291.755253] Dynamic subtest pipe-C-plane-0: FAIL (0.140s)
[291.764520] Starting dynamic subtest: pipe-C-plane-1
[292.154500] Dynamic subtest pipe-C-plane-1: FAIL (0.166s)
[292.165027] Starting dynamic subtest: pipe-C-plane-2
[292.540199] Dynamic subtest pipe-C-plane-2: FAIL (0.173s)
[293.410772] Starting dynamic subtest: pipe-D-plane-0
[294.020861] Dynamic subtest pipe-D-plane-0: FAIL (0.151s)
[294.030487] Starting dynamic subtest: pipe-D-plane-1
[294.486950] Dynamic subtest pipe-D-plane-1: FAIL (0.624s)
[294.496176] Starting dynamic subtest: pipe-D-plane-2
[294.936769] Dynamic subtest pipe-D-plane-2: FAIL (0.569s)
[295.042330] Subtest plane-ctm3x4-lut1d: FAIL (7.455s)
[295.886583] [034/133] (723s left) kms_lease (cursor-implicit-plane)
[295.989016] Starting subtest: cursor-implicit-plane
[295.991318] Starting dynamic subtest: pipe-A-eDP-1
[296.449480] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.459s)
[296.458783] Starting dynamic subtest: pipe-B-eDP-1
[297.606383] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.154s)
[297.615643] Starting dynamic subtest: pipe-C-eDP-1
[298.718648] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.111s)
[298.729214] Starting dynamic subtest: pipe-D-eDP-1
[299.852193] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.133s)
[299.854061] Subtest cursor-implicit-plane: SUCCESS (3.862s)
[300.715745] [035/133] (718s left) i915_pm_rps (thresholds-idle-park)
[300.781089] Starting subtest: thresholds-idle-park
[300.785641] Subtest thresholds-idle-park: SKIP (0.001s)
[300.898814] [036/133] (718s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted-submitted)
[300.946066] Starting subtest: etime-multi-wait-all-available-unsubmitted-submitted
[301.050640] Subtest etime-multi-wait-all-available-unsubmitted-submitted: SUCCESS (0.104s)
[301.124875] [037/133] (718s left) syncobj_wait (multi-wait-for-submit-submitted)
[301.185452] Starting subtest: multi-wait-for-submit-submitted
[301.290037] Subtest multi-wait-for-submit-submitted: SUCCESS (0.105s)
[301.376775] [038/133] (718s left) gem_softpin (allocator-evict)
[301.434470] Starting subtest: allocator-evict
[301.437040] Starting dynamic subtest: rcs0
[325.122567] Dynamic subtest rcs0: SUCCESS (23.685s)
[325.134036] Starting dynamic subtest: bcs0
[348.753575] Dynamic subtest bcs0: SUCCESS (23.629s)
[348.764314] Starting dynamic subtest: vcs0
[372.333759] Dynamic subtest vcs0: SUCCESS (23.578s)
[372.344461] Starting dynamic subtest: vcs1
[395.805237] Dynamic subtest vcs1: SUCCESS (23.470s)
[395.815032] Starting dynamic subtest: vecs0
[419.441037] Dynamic subtest vecs0: SUCCESS (23.634s)
[419.449478] Starting dynamic subtest: ccs0
[443.334726] Dynamic subtest ccs0: SUCCESS (23.892s)
[443.337173] Subtest allocator-evict: SUCCESS (141.893s)
[443.417409] [039/133] (576s left) perf_pmu (semaphore-busy)
[443.494868] Starting subtest: semaphore-busy
[443.497173] Starting dynamic subtest: rcs0
[445.140058] Dynamic subtest rcs0: SUCCESS (1.642s)
[445.150359] Starting dynamic subtest: bcs0
[446.776486] Dynamic subtest bcs0: SUCCESS (1.634s)
[446.786703] Starting dynamic subtest: vcs0
[450.448813] Dynamic subtest vcs0: SUCCESS (3.670s)
[450.457912] Starting dynamic subtest: vcs1
[456.399936] Dynamic subtest vcs1: SUCCESS (5.949s)
[456.409675] Starting dynamic subtest: vecs0
[462.416077] Dynamic subtest vecs0: SUCCESS (6.013s)
[462.425169] Starting dynamic subtest: ccs0
[465.489969] Dynamic subtest ccs0: SUCCESS (3.072s)
[465.492477] Subtest semaphore-busy: SUCCESS (21.993s)
[465.605149] [040/133] (554s left) kms_plane (pixel-format-y-tiled-gen12-rc-ccs-modifier)
[465.716936] Starting subtest: pixel-format-y-tiled-gen12-rc-ccs-modifier
[465.721244] Subtest pixel-format-y-tiled-gen12-rc-ccs-modifier: SKIP (0.000s)
[465.788461] [041/133] (553s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-16bpp-ytile-downscaling)
[465.874975] Starting subtest: flip-64bpp-ytile-to-16bpp-ytile-downscaling
[465.878885] Subtest flip-64bpp-ytile-to-16bpp-ytile-downscaling: SKIP (0.000s)
[465.944143] [042/133] (553s left) gem_lmem_swapping (smem-oom)
[465.992340] Subtest smem-oom: SKIP (0.000s)
[466.036678] [043/133] (553s left) gem_exec_params (rs-invalid)
[466.104075] Starting subtest: rs-invalid
[466.106033] Subtest rs-invalid: SUCCESS (0.003s)
[466.220601] [044/133] (553s left) fbdev (info)
[466.260130] Starting subtest: info
[466.262452] Subtest info: SUCCESS (0.000s)
[466.331438] [045/133] (553s left) kms_getfb (getfb-handle-protection)
[466.415979] Starting subtest: getfb-handle-protection
[466.432154] Subtest getfb-handle-protection: SUCCESS (0.016s)
[466.538942] [046/133] (553s left) syncobj_timeline (single-wait-for-submit-signaled)
[466.595915] Starting subtest: single-wait-for-submit-signaled
[466.597781] Subtest single-wait-for-submit-signaled: SUCCESS (0.000s)
[466.692676] [047/133] (553s left) gem_exec_reloc (basic-write-read-noreloc)
[466.746544] Subtest basic-write-read-noreloc: SKIP (0.000s)
[466.818154] [048/133] (553s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-mmap-gtt)
[466.918137] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-mmap-gtt
[466.921920] Subtest fbc-2p-scndscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[467.036348] [049/133] (553s left) kms_ccs (bad-pixel-format-4-tiled-mtl-rc-ccs-cc)
[467.122240] Starting subtest: bad-pixel-format-4-tiled-mtl-rc-ccs-cc
[467.124148] Starting dynamic subtest: pipe-A-eDP-1
[467.145094] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[467.158670] Starting dynamic subtest: pipe-B-eDP-1
[467.174646] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[467.182573] Starting dynamic subtest: pipe-C-eDP-1
[467.198265] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[467.205866] Starting dynamic subtest: pipe-D-eDP-1
[467.221512] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[467.223059] Subtest bad-pixel-format-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.005s)
[469.388715] [050/133] (550s left) kms_plane_scaling (plane-upscale-factor-0-25-with-pixel-format)
[469.487090] Starting subtest: plane-upscale-factor-0-25-with-pixel-format
[469.489380] Starting dynamic subtest: pipe-A
[470.535284] Dynamic subtest pipe-A: SUCCESS (1.050s)
[470.544250] Starting dynamic subtest: pipe-B
[472.677067] Dynamic subtest pipe-B: SUCCESS (2.141s)
[472.685306] Starting dynamic subtest: pipe-C
[473.883667] Dynamic subtest pipe-C: SUCCESS (1.205s)
[473.894461] Starting dynamic subtest: pipe-D
[475.037990] Dynamic subtest pipe-D: SUCCESS (1.153s)
[475.040407] Subtest plane-upscale-factor-0-25-with-pixel-format: SUCCESS (5.553s)
[476.252185] [051/133] (543s left) kms_plane_multiple (2x-tiling-4)
[476.348681] Starting subtest: 2x-tiling-4
[476.353140] Subtest 2x-tiling-4: SKIP (0.000s)
[476.421006] [052/133] (543s left) gem_userptr_blits (sync-overlap)
[476.486519] Starting subtest: sync-overlap
[476.488832] Subtest sync-overlap: SUCCESS (0.000s)
[476.603344] [053/133] (543s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-mmap-cpu)
[476.691177] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-mmap-cpu
[476.695129] Subtest psr-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[476.788053] [054/133] (543s left) kms_plane_alpha_blend (constant-alpha-mid)
[476.893166] Starting subtest: constant-alpha-mid
[477.193709] Starting dynamic subtest: pipe-A-eDP-1
[478.162016] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.968s)
[478.171205] Starting dynamic subtest: pipe-D-eDP-1
[479.648714] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.486s)
[479.651056] Subtest constant-alpha-mid: SUCCESS (2.758s)
[480.493956] [055/133] (539s left) kms_cursor_legacy (flip-vs-cursor-busy-crc-legacy)
[480.625504] Starting subtest: flip-vs-cursor-busy-crc-legacy
[481.469219] Subtest flip-vs-cursor-busy-crc-legacy: SUCCESS (0.840s)
[482.330162] [056/133] (538s left) gem_exec_reloc (basic-write-gtt)
[482.392644] Subtest basic-write-gtt: SKIP (0.000s)
[482.460160] [057/133] (537s left) gem_sync (basic-each)
[482.532887] Starting subtest: basic-each
[484.849269] Subtest basic-each: SUCCESS (2.326s)
[485.045661] [058/133] (535s left) kms_chamelium_color (ctm-0-75)
[485.138417] Subtest ctm-0-75: SKIP (0.000s)
[485.188292] [059/133] (535s left) perf (polling-small-buf)
[485.357493] Starting subtest: polling-small-buf
[485.449316] Subtest polling-small-buf: SUCCESS (0.090s)
[485.495189] [060/133] (535s left) kms_rmfb (rmfb-ioctl)
[485.591084] Starting subtest: rmfb-ioctl
[485.593209] Starting dynamic subtest: pipe-A-eDP-1
[485.695908] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.106s)
[485.706023] Starting dynamic subtest: pipe-B-eDP-1
[486.882360] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.185s)
[486.894979] Starting dynamic subtest: pipe-C-eDP-1
[488.020921] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.137s)
[488.030165] Starting dynamic subtest: pipe-D-eDP-1
[489.143269] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.121s)
[489.145381] Subtest rmfb-ioctl: SUCCESS (3.555s)
[490.378441] [061/133] (530s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy)
[490.479861] Subtest addfb25-x-tiled-mismatch-legacy: SKIP (0.000s)
[490.570374] [062/133] (530s left) gem_eio (kms)
[490.866328] Starting subtest: kms
[511.718613] Subtest kms: SUCCESS (20.852s)
[512.915640] [063/133] (507s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-cpu)
[513.012300] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-cpu
[513.016562] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[513.098108] [064/133] (507s left) kms_big_fb (x-tiled-8bpp-rotate-270)
[513.205908] Starting subtest: x-tiled-8bpp-rotate-270
[513.227071] Subtest x-tiled-8bpp-rotate-270: SKIP (0.020s)
[513.332750] [065/133] (507s left) gem_wait (invalid-buf)
[513.390817] Starting subtest: invalid-buf
[513.393193] Subtest invalid-buf: SUCCESS (0.000s)
[513.629683] [066/133] (507s left) gem_exec_schedule (semaphore-noskip)
[513.694156] Starting subtest: semaphore-noskip
[514.135047] Subtest semaphore-noskip: SUCCESS (0.446s)
[514.461372] [067/133] (506s left) kms_vrr (seamless-rr-switch-vrr)
[514.564205] Starting subtest: seamless-rr-switch-vrr
[514.570703] Subtest seamless-rr-switch-vrr: SKIP (0.000s)
[514.642393] [068/133] (506s left) kms_big_fb (linear-64bpp-rotate-270)
[514.736983] Starting subtest: linear-64bpp-rotate-270
[514.757714] Subtest linear-64bpp-rotate-270: SKIP (0.020s)
[514.860192] [069/133] (506s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-pwrite)
[514.966786] Starting subtest: fbc-rgb101010-draw-pwrite
[520.368203] Subtest fbc-rgb101010-draw-pwrite: SUCCESS (5.404s)
[521.518600] [070/133] (499s left) kms_pipe_b_c_ivb (disable-pipe-b-enable-pipe-c)
[521.572376] Subtest disable-pipe-B-enable-pipe-C: SKIP (0.000s)
[521.639696] [071/133] (499s left) kms_psr (psr2-sprite-blt)
[521.730113] Starting subtest: psr2-sprite-blt
[521.732376] Starting dynamic subtest: eDP-1
[523.417156] Dynamic subtest eDP-1: SUCCESS (1.687s)
[523.419558] Subtest psr2-sprite-blt: SUCCESS (1.688s)
[524.284313] [072/133] (496s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip)
[524.386890] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip
[524.391156] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SKIP (0.000s)
[524.476747] [073/133] (496s left) kms_content_protection (dp-mst-type-0)
[524.617153] Starting subtest: dp-mst-type-0
[524.621146] Subtest dp-mst-type-0: SKIP (0.000s)
[524.727236] [074/133] (496s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-render)
[524.824698] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-render
[524.828660] Subtest fbc-2p-primscrn-pri-indfb-draw-render: SKIP (0.000s)
[524.920865] [075/133] (496s left) kms_force_connector_basic (force-edid)
[525.003950] Starting subtest: force-edid
[525.369651] Subtest force-edid: SUCCESS (0.366s)
[525.505654] [076/133] (495s left) perf (non-sampling-read-error)
[525.607380] Starting subtest: non-sampling-read-error
[525.616629] Subtest non-sampling-read-error: SUCCESS (0.007s)
[525.659122] [077/133] (495s left) kms_rotation_crc (primary-rotation-180)
[525.743493] Starting subtest: primary-rotation-180
[532.710842] Subtest primary-rotation-180: SUCCESS (6.970s)
[533.910756] [078/133] (487s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-blt)
[534.016534] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-blt
[534.020894] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[534.135527] [079/133] (487s left) kms_fb_coherency (memset-crc)
[534.225437] Starting subtest: memset-crc
[534.227637] Starting dynamic subtest: mmap-offset-wc
[534.622729] Dynamic subtest mmap-offset-wc: SUCCESS (0.397s)
[534.922882] Starting dynamic subtest: mmap-offset-uc
[541.079330] Dynamic subtest mmap-offset-uc: SUCCESS (6.162s)
[541.371373] Subtest memset-crc: SUCCESS (7.144s)
[542.205470] [080/133] (479s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-mmap-cpu)
[542.307192] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-mmap-cpu
[546.233800] Subtest fbc-1p-offscreen-pri-indfb-draw-mmap-cpu: SUCCESS (3.929s)
[547.421377] [081/133] (473s left) gem_lmem_swapping (heavy-random)
[547.464718] Subtest heavy-random: SKIP (0.000s)
[547.516688] [082/133] (473s left) gem_exec_balancer (noheartbeat)
[547.775652] Starting subtest: noheartbeat
[547.780490] Subtest noheartbeat: SKIP (0.000s)
[547.891914] [083/133] (473s left) gem_ctx_isolation (preservation-s3)
[547.963132] Starting subtest: preservation-S3
[547.965528] Starting dynamic subtest: rcs0
[564.816593] Dynamic subtest rcs0: SUCCESS (1.838s)
[564.827938] Starting dynamic subtest: bcs0
[581.825934] Dynamic subtest bcs0: SUCCESS (1.685s)
[581.837294] Starting dynamic subtest: vcs0
[598.830483] Dynamic subtest vcs0: SUCCESS (2.843s)
[598.841103] Starting dynamic subtest: vcs1
[616.842105] Dynamic subtest vcs1: SUCCESS (5.053s)
[616.852926] Starting dynamic subtest: vecs0
[634.844783] Dynamic subtest vecs0: SUCCESS (4.995s)
[634.856193] Starting dynamic subtest: ccs0
[652.828349] Dynamic subtest ccs0: SUCCESS (3.106s)
[652.831006] Subtest preservation-S3: SUCCESS (19.526s)
[659.090162] [084/133] (368s left) perf_pmu (frequency)
[659.157418] Starting subtest: frequency
[659.161338] Starting dynamic subtest: gt0
[661.296944] Dynamic subtest gt0: SUCCESS (2.189s)
[661.307305] Starting dynamic subtest: idle-gt0
[661.801917] Dynamic subtest idle-gt0: SUCCESS (0.516s)
[661.812455] Starting dynamic subtest: gt1
[666.221853] Dynamic subtest gt1: SUCCESS (4.490s)
[666.233668] Starting dynamic subtest: idle-gt1
[666.727476] Dynamic subtest idle-gt1: SUCCESS (0.511s)
[666.730067] Subtest frequency: SUCCESS (7.726s)
[666.829418] [085/133] (360s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-mmap-cpu)
[666.925123] Starting subtest: fbc-rgb101010-draw-mmap-cpu
[671.482735] Subtest fbc-rgb101010-draw-mmap-cpu: SUCCESS (4.600s)
[672.648177] [086/133] (355s left) kms_pm_rpm (pm-caching)
[674.385473] Starting subtest: pm-caching
[674.390543] Subtest pm-caching: SKIP (0.000s)
[674.930679] [087/133] (352s left) api_intel_bb (lot-of-buffers)
[674.982472] Starting subtest: lot-of-buffers
[676.052837] Subtest lot-of-buffers: SUCCESS (1.075s)
[676.490219] [088/133] (351s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-mmap-gtt)
[676.591135] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-mmap-gtt
[676.595276] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[676.676641] [089/133] (351s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-render)
[676.782096] Starting subtest: psr-1p-primscrn-spr-indfb-draw-render
[683.521569] Subtest psr-1p-primscrn-spr-indfb-draw-render: SUCCESS (6.757s)
[683.657845] [090/133] (344s left) gem_exec_balancer (smoke)
[683.729854] Starting subtest: smoke
[706.364436] Subtest smoke: SUCCESS (22.637s)
[708.333912] [091/133] (319s left) kms_invalid_mode (zero-clock)
[708.441975] Starting subtest: zero-clock
[708.444402] Starting dynamic subtest: pipe-A-eDP-1
[708.729853] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.289s)
[708.742683] Starting dynamic subtest: pipe-B-eDP-1
[708.744817] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[708.754855] Starting dynamic subtest: pipe-C-eDP-1
[708.757141] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[708.767344] Starting dynamic subtest: pipe-D-eDP-1
[708.769742] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[708.772172] Subtest zero-clock: SUCCESS (0.295s)
[709.597216] [092/133] (318s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-180-async-flip)
[709.696850] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-180-async-flip
[709.701230] Subtest y-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SKIP (0.000s)
[709.789345] [093/133] (318s left) kms_flip (2x-flip-vs-suspend)
[709.891261] Starting subtest: 2x-flip-vs-suspend
[709.900921] Subtest 2x-flip-vs-suspend: SKIP (0.011s)
[709.982789] [094/133] (318s left) kms_psr (fbc-psr-suspend)
[710.065090] Starting subtest: fbc-psr-suspend
[710.067009] Starting dynamic subtest: eDP-1
[710.071058] Dynamic subtest eDP-1: SKIP (0.000s)
[710.075088] Subtest fbc-psr-suspend: SKIP (0.001s)
[710.141123] [095/133] (317s left) gem_cs_tlb (engines)
[710.199877] Starting subtest: engines
[710.202070] Starting dynamic subtest: rcs0
[712.354857] Dynamic subtest rcs0: SUCCESS (2.151s)
[712.367569] Starting dynamic subtest: bcs0
[714.507830] Dynamic subtest bcs0: SUCCESS (2.151s)
[714.520132] Starting dynamic subtest: vcs0
[716.660802] Dynamic subtest vcs0: SUCCESS (2.152s)
[716.671138] Starting dynamic subtest: vcs1
[718.814452] Dynamic subtest vcs1: SUCCESS (2.153s)
[718.825050] Starting dynamic subtest: vecs0
[720.967007] Dynamic subtest vecs0: SUCCESS (2.152s)
[720.978087] Starting dynamic subtest: ccs0
[723.119169] Dynamic subtest ccs0: SUCCESS (2.152s)
[723.121338] Subtest engines: SUCCESS (12.918s)
[723.225195] [096/133] (304s left) kms_cursor_crc (cursor-random-256x85)
[723.493436] Starting subtest: cursor-random-256x85
[723.542751] Subtest cursor-random-256x85: SKIP (0.044s)
[723.729623] [097/133] (304s left) gem_exec_reloc (basic-gtt-read-noreloc)
[723.787559] Subtest basic-gtt-read-noreloc: SKIP (0.000s)
[723.862247] [098/133] (304s left) sw_sync (sync_random_merge)
[723.898264] Starting subtest: sync_random_merge
[723.937061] Subtest sync_random_merge: SUCCESS (0.044s)
[723.998585] [099/133] (304s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0)
[724.094337] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0
[725.140026] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0: SUCCESS (1.046s)
[725.263097] [100/133] (302s left) kms_plane (plane-panning-top-left)
[725.358335] Starting subtest: plane-panning-top-left
[725.360213] Starting dynamic subtest: pipe-A
[727.038712] Dynamic subtest pipe-A: SUCCESS (1.678s)
[727.052524] Starting dynamic subtest: pipe-B
[729.404581] Dynamic subtest pipe-B: SUCCESS (2.364s)
[729.406530] Subtest plane-panning-top-left: SUCCESS (4.045s)
[730.287435] [101/133] (298s left) kms_vblank (query-busy)
[730.381911] Starting subtest: query-busy
[730.384136] Starting dynamic subtest: pipe-A-eDP-1
[732.253721] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.874s)
[732.270095] Starting dynamic subtest: pipe-D-eDP-1
[734.804286] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.548s)
[734.806821] Subtest query-busy: SUCCESS (4.425s)
[735.680835] [102/133] (292s left) gem_workarounds (reset-fd)
[735.753295] Starting subtest: reset-fd
[735.933589] Subtest reset-fd: SUCCESS (0.178s)
[736.067531] [103/133] (292s left) kms_frontbuffer_tracking (fbc-rgb565-draw-render)
[736.161975] Starting subtest: fbc-rgb565-draw-render
[740.303697] Subtest fbc-rgb565-draw-render: SUCCESS (4.146s)
[741.498188] [104/133] (286s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-shrfb-msflip-blt)
[741.597808] Starting subtest: fbcpsr-1p-primscrn-shrfb-msflip-blt
[748.938563] Subtest fbcpsr-1p-primscrn-shrfb-msflip-blt: SUCCESS (7.344s)
[749.080265] [105/133] (279s left) kms_big_fb (yf-tiled-64bpp-rotate-180)
[749.182003] Starting subtest: yf-tiled-64bpp-rotate-180
[749.186294] Subtest yf-tiled-64bpp-rotate-180: SKIP (0.000s)
[749.302149] [106/133] (279s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-mmap-cpu)
[749.405077] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-mmap-cpu
[749.409537] Subtest psr-2p-scndscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[749.520008] [107/133] (279s left) kms_rotation_crc (bad-tiling)
[749.627743] Starting subtest: bad-tiling
[749.632001] Subtest bad-tiling: SKIP (0.001s)
[749.705685] [108/133] (278s left) kms_ccs (crc-sprite-planes-basic-y-tiled-ccs)
[749.795564] Starting subtest: crc-sprite-planes-basic-y-tiled-ccs
[749.797708] Starting dynamic subtest: pipe-A-eDP-1
[749.853466] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[749.864705] Starting dynamic subtest: pipe-B-eDP-1
[749.912602] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[749.923780] Starting dynamic subtest: pipe-C-eDP-1
[749.969792] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[749.980648] Starting dynamic subtest: pipe-D-eDP-1
[750.027194] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[750.030656] Subtest crc-sprite-planes-basic-y-tiled-ccs: SKIP (0.009s)
[752.078650] [109/133] (276s left) kms_cursor_legacy (cursora-vs-flipb-varying-size)
[752.197783] Starting subtest: cursorA-vs-flipB-varying-size
[752.202754] Subtest cursorA-vs-flipB-varying-size: SKIP (0.001s)
[752.355755] [110/133] (276s left) syncobj_wait (signal)
[752.406443] Starting subtest: signal
[752.408773] Subtest signal: SUCCESS (0.000s)
[752.513003] [111/133] (276s left) kms_chamelium_frames (dp-crc-multiple)
[752.900015] Subtest dp-crc-multiple: SKIP (0.000s)
[753.753053] [112/133] (275s left) kms_flip (blocking-absolute-wf_vblank-interruptible)
[753.849954] Starting subtest: blocking-absolute-wf_vblank-interruptible
[753.852325] Starting dynamic subtest: A-eDP1
[762.600139] Dynamic subtest A-eDP1: SUCCESS (8.746s)
[762.612350] Starting dynamic subtest: B-eDP1
[771.303735] Dynamic subtest B-eDP1: SUCCESS (8.698s)
[771.325391] Starting dynamic subtest: C-eDP1
[779.990496] Dynamic subtest C-eDP1: SUCCESS (8.682s)
[780.012444] Starting dynamic subtest: D-eDP1
[788.694136] Dynamic subtest D-eDP1: SUCCESS (8.700s)
[788.699587] Subtest blocking-absolute-wf_vblank-interruptible: SUCCESS (34.842s)
[789.878949] [113/133] (238s left) kms_psr (fbc-psr2-cursor-plane-move)
[789.972655] Starting subtest: fbc-psr2-cursor-plane-move
[789.975003] Starting dynamic subtest: eDP-1
[789.979487] Dynamic subtest eDP-1: SKIP (0.000s)
[789.983953] Subtest fbc-psr2-cursor-plane-move: SKIP (0.001s)
[790.052073] [114/133] (238s left) gem_render_copy (yf-tiled-ccs-to-y-tiled)
[790.109984] Starting subtest: yf-tiled-ccs-to-y-tiled
[790.114463] Subtest yf-tiled-ccs-to-y-tiled: SKIP (0.000s)
[790.296032] [115/133] (238s left) kms_flip (2x-flip-vs-wf_vblank-interruptible)
[790.391804] Starting subtest: 2x-flip-vs-wf_vblank-interruptible
[790.404965] Subtest 2x-flip-vs-wf_vblank-interruptible: SKIP (0.011s)
[790.489993] [116/133] (238s left) gem_pxp (verify-pxp-key-change-after-suspend-resume)
[790.610447] Starting subtest: verify-pxp-key-change-after-suspend-resume
[797.811359] Subtest verify-pxp-key-change-after-suspend-resume: SUCCESS (7.202s)
[808.939980] [117/133] (231s left) kms_psr (fbc-pr-cursor-blt)
[809.043373] Starting subtest: fbc-pr-cursor-blt
[809.047966] Subtest fbc-pr-cursor-blt: SKIP (0.000s)
[809.123816] [118/133] (230s left) kms_flip (flip-vs-panning-interruptible)
[809.218776] Starting subtest: flip-vs-panning-interruptible
[809.224482] Starting dynamic subtest: A-eDP1
[817.954036] Dynamic subtest A-eDP1: SUCCESS (8.731s)
[817.966349] Starting dynamic subtest: B-eDP1
[826.652603] Dynamic subtest B-eDP1: SUCCESS (8.697s)
[826.664851] Starting dynamic subtest: C-eDP1
[835.336026] Dynamic subtest C-eDP1: SUCCESS (8.682s)
[835.347647] Starting dynamic subtest: D-eDP1
[844.041330] Dynamic subtest D-eDP1: SUCCESS (8.706s)
[844.045347] Subtest flip-vs-panning-interruptible: SUCCESS (34.831s)
[845.262457] [119/133] (194s left) kms_cursor_crc (cursor-offscreen-32x10)
[845.422409] Starting subtest: cursor-offscreen-32x10
[845.469606] Subtest cursor-offscreen-32x10: SKIP (0.043s)
[845.706716] [120/133] (194s left) kms_chamelium_hpd (dp-hpd-enable-disable-mode)
[846.102135] Subtest dp-hpd-enable-disable-mode: SKIP (0.000s)
[846.933415] [121/133] (193s left) gen9_exec_parse (bb-oversize)
[846.998548] Subtest bb-oversize: SKIP (0.000s)
[847.068193] [122/133] (193s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180-hflip)
[847.186519] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180-hflip
[848.287072] Subtest x-tiled-max-hw-stride-32bpp-rotate-180-hflip: SUCCESS (1.100s)
[848.404857] [123/133] (191s left) kms_psr2_sf (fbc-pr-cursor-plane-move-continuous-exceed-sf)
[848.512035] Starting subtest: fbc-pr-cursor-plane-move-continuous-exceed-sf
[848.515324] Subtest fbc-pr-cursor-plane-move-continuous-exceed-sf: SKIP (0.000s)
[848.584669] [124/133] (191s left) kms_psr (fbc-psr-cursor-blt)
[848.672470] Starting subtest: fbc-psr-cursor-blt
[848.674342] Starting dynamic subtest: eDP-1
[848.677579] Dynamic subtest eDP-1: SKIP (0.000s)
[848.680852] Subtest fbc-psr-cursor-blt: SKIP (0.001s)
[848.746826] [125/133] (191s left) kms_ccs (crc-primary-suspend-4-tiled-mtl-rc-ccs-cc)
[848.842991] Starting subtest: crc-primary-suspend-4-tiled-mtl-rc-ccs-cc
[848.844972] Starting dynamic subtest: pipe-A-eDP-1
[866.014960] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.849s)
[866.037892] Starting dynamic subtest: pipe-B-eDP-1
[884.001982] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.828s)
[884.017089] Starting dynamic subtest: pipe-C-eDP-1
[901.940655] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.776s)
[901.951842] Starting dynamic subtest: pipe-D-eDP-1
[919.952372] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.756s)
[919.954791] Subtest crc-primary-suspend-4-tiled-mtl-rc-ccs-cc: SUCCESS (10.215s)
[930.177409] [126/133] (119s left) kms_ccs (crc-primary-basic-4-tiled-mtl-mc-ccs)
[930.282331] Starting subtest: crc-primary-basic-4-tiled-mtl-mc-ccs
[930.284610] Starting dynamic subtest: pipe-A-eDP-1
[932.539052] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.251s)
[932.549145] Starting dynamic subtest: pipe-B-eDP-1
[935.002112] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.457s)
[935.012384] Starting dynamic subtest: pipe-C-eDP-1
[937.252481] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.246s)
[937.263086] Starting dynamic subtest: pipe-D-eDP-1
[939.389658] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.131s)
[939.391572] Subtest crc-primary-basic-4-tiled-mtl-mc-ccs: SUCCESS (9.092s)
[940.582030] [127/133] (108s left) kms_addfb_basic (bad-pitch-0)
[940.641625] Starting subtest: bad-pitch-0
[940.643967] Subtest bad-pitch-0: SUCCESS (0.000s)
[940.769802] [128/133] (108s left) gem_pread (bench)
[940.818713] Subtest bench: SKIP (0.000s)
[940.880711] [129/133] (108s left) gem_ctx_create (basic-files)
[940.936331] Starting subtest: basic-files
[942.944766] Subtest basic-files: SUCCESS (2.007s)
[944.198517] [130/133] (105s left) kms_psr_stress_test (flip-primary-invalidate-overlay)
[944.307613] Starting subtest: flip-primary-invalidate-overlay
[955.989559] Subtest flip-primary-invalidate-overlay: SUCCESS (11.680s)
[956.163631] [131/133] ( 93s left) gem_exec_whisper (basic-fds-priority-all)
[956.228747] Starting subtest: basic-fds-priority-all
[978.400121] Subtest basic-fds-priority-all: SUCCESS (22.164s)
[978.586705] [132/133] ( 71s left) syncobj_timeline (multi-wait-available-unsubmitted-submitted-signaled)
[978.634400] Starting subtest: multi-wait-available-unsubmitted-submitted-signaled
[978.636735] Subtest multi-wait-available-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[978.732260] [133/133] ( 71s left) syncobj_timeline (invalid-multi-wait-all-unsubmitted-submitted-signaled)
[978.792376] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted-signaled
[978.794936] Subtest invalid-multi-wait-all-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[978.902219] Closing watchdogs
results: parsing output: 0/ for test: gem_exec_fence
results: parsing output: 1/ for test: syncobj_wait
results: parsing output: 2/ for test: gem_exec_schedule
results: parsing output: 3/ for test: kms_cursor_legacy
results: parsing output: 4/ for test: gem_ctx_persistence
results: parsing output: 5/ for test: kms_flip
results: parsing output: 6/ for test: api_intel_allocator
results: parsing output: 7/ for test: gem_exec_parallel
results: parsing output: 8/ for test: kms_cursor_edge_walk
results: parsing output: 9/ for test: i915_drm_fdinfo
results: parsing output: 10/ for test: kms_frontbuffer_tracking
results: parsing output: 11/ for test: kms_atomic_transition
results: parsing output: 12/ for test: gem_tiled_pread_basic
results: parsing output: 13/ for test: kms_frontbuffer_tracking
results: parsing output: 14/ for test: i915_drm_fdinfo
results: parsing output: 15/ for test: core_sysfs
results: parsing output: 16/ for test: kms_vblank
results: parsing output: 17/ for test: kms_flip
results: parsing output: 18/ for test: gem_mmap_offset
results: parsing output: 19/ for test: gem_madvise
results: parsing output: 20/ for test: gem_softpin
results: parsing output: 21/ for test: gem_sync
results: parsing output: 22/ for test: sysfs_timeslice_duration
results: parsing output: 23/ for test: kms_atomic
results: parsing output: 24/ for test: gem_pread
results: parsing output: 25/ for test: i915_pm_rc6_residency
results: parsing output: 26/ for test: kms_pm_dc
results: parsing output: 27/ for test: kms_psr2_sf
results: parsing output: 28/ for test: gem_ctx_param
results: parsing output: 29/ for test: kms_frontbuffer_tracking
results: parsing output: 30/ for test: gem_mmap_wc
results: parsing output: 31/ for test: syncobj_timeline
results: parsing output: 32/ for test: kms_color_pipeline
results: parsing output: 33/ for test: kms_lease
results: parsing output: 34/ for test: i915_pm_rps
results: parsing output: 35/ for test: syncobj_timeline
results: parsing output: 36/ for test: syncobj_wait
results: parsing output: 37/ for test: gem_softpin
results: parsing output: 38/ for test: perf_pmu
results: parsing output: 39/ for test: kms_plane
results: parsing output: 40/ for test: kms_flip_scaled_crc
results: parsing output: 41/ for test: gem_lmem_swapping
results: parsing output: 42/ for test: gem_exec_params
results: parsing output: 43/ for test: fbdev
results: parsing output: 44/ for test: kms_getfb
results: parsing output: 45/ for test: syncobj_timeline
results: parsing output: 46/ for test: gem_exec_reloc
results: parsing output: 47/ for test: kms_frontbuffer_tracking
results: parsing output: 48/ for test: kms_ccs
results: parsing output: 49/ for test: kms_plane_scaling
results: parsing output: 50/ for test: kms_plane_multiple
results: parsing output: 51/ for test: gem_userptr_blits
results: parsing output: 52/ for test: kms_frontbuffer_tracking
results: parsing output: 53/ for test: kms_plane_alpha_blend
results: parsing output: 54/ for test: kms_cursor_legacy
results: parsing output: 55/ for test: gem_exec_reloc
results: parsing output: 56/ for test: gem_sync
results: parsing output: 57/ for test: kms_chamelium_color
results: parsing output: 58/ for test: perf
results: parsing output: 59/ for test: kms_rmfb
results: parsing output: 60/ for test: kms_addfb_basic
results: parsing output: 61/ for test: gem_eio
results: parsing output: 62/ for test: kms_frontbuffer_tracking
results: parsing output: 63/ for test: kms_big_fb
results: parsing output: 64/ for test: gem_wait
results: parsing output: 65/ for test: gem_exec_schedule
results: parsing output: 66/ for test: kms_vrr
results: parsing output: 67/ for test: kms_big_fb
results: parsing output: 68/ for test: kms_frontbuffer_tracking
results: parsing output: 69/ for test: kms_pipe_b_c_ivb
results: parsing output: 70/ for test: kms_psr
results: parsing output: 71/ for test: kms_big_fb
results: parsing output: 72/ for test: kms_content_protection
results: parsing output: 73/ for test: kms_frontbuffer_tracking
results: parsing output: 74/ for test: kms_force_connector_basic
results: parsing output: 75/ for test: perf
results: parsing output: 76/ for test: kms_rotation_crc
results: parsing output: 77/ for test: kms_frontbuffer_tracking
results: parsing output: 78/ for test: kms_fb_coherency
results: parsing output: 79/ for test: kms_frontbuffer_tracking
results: parsing output: 80/ for test: gem_lmem_swapping
results: parsing output: 81/ for test: gem_exec_balancer
results: parsing output: 82/ for test: gem_ctx_isolation
results: parsing output: 83/ for test: perf_pmu
results: parsing output: 84/ for test: kms_frontbuffer_tracking
results: parsing output: 85/ for test: kms_pm_rpm
results: parsing output: 86/ for test: api_intel_bb
results: parsing output: 87/ for test: kms_frontbuffer_tracking
results: parsing output: 88/ for test: kms_frontbuffer_tracking
results: parsing output: 89/ for test: gem_exec_balancer
results: parsing output: 90/ for test: kms_invalid_mode
results: parsing output: 91/ for test: kms_big_fb
results: parsing output: 92/ for test: kms_flip
results: parsing output: 93/ for test: kms_psr
results: parsing output: 94/ for test: gem_cs_tlb
results: parsing output: 95/ for test: kms_cursor_crc
results: parsing output: 96/ for test: gem_exec_reloc
results: parsing output: 97/ for test: sw_sync
results: parsing output: 98/ for test: kms_big_fb
results: parsing output: 99/ for test: kms_plane
results: parsing output: 100/ for test: kms_vblank
results: parsing output: 101/ for test: gem_workarounds
results: parsing output: 102/ for test: kms_frontbuffer_tracking
results: parsing output: 103/ for test: kms_frontbuffer_tracking
results: parsing output: 104/ for test: kms_big_fb
results: parsing output: 105/ for test: kms_frontbuffer_tracking
results: parsing output: 106/ for test: kms_rotation_crc
results: parsing output: 107/ for test: kms_ccs
results: parsing output: 108/ for test: kms_cursor_legacy
results: parsing output: 109/ for test: syncobj_wait
results: parsing output: 110/ for test: kms_chamelium_frames
results: parsing output: 111/ for test: kms_flip
results: parsing output: 112/ for test: kms_psr
results: parsing output: 113/ for test: gem_render_copy
results: parsing output: 114/ for test: kms_flip
results: parsing output: 115/ for test: gem_pxp
results: parsing output: 116/ for test: kms_psr
results: parsing output: 117/ for test: kms_flip
results: parsing output: 118/ for test: kms_cursor_crc
results: parsing output: 119/ for test: kms_chamelium_hpd
results: parsing output: 120/ for test: gen9_exec_parse
results: parsing output: 121/ for test: kms_big_fb
results: parsing output: 122/ for test: kms_psr2_sf
results: parsing output: 123/ for test: kms_psr
results: parsing output: 124/ for test: kms_ccs
results: parsing output: 125/ for test: kms_ccs
results: parsing output: 126/ for test: kms_addfb_basic
results: parsing output: 127/ for test: gem_pread
results: parsing output: 128/ for test: gem_ctx_create
results: parsing output: 129/ for test: kms_psr_stress_test
results: parsing output: 130/ for test: gem_exec_whisper
results: parsing output: 131/ for test: syncobj_timeline
results: parsing output: 132/ for test: syncobj_timeline
Done.