[58.167705] Initializing watchdogs
[58.167758]   /dev/watchdog0
[58.182219] [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]
[58.186545] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[58.188469] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[58.190397] [001/130] (960s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-move)
[58.379150] Starting subtest: fbc-1p-primscrn-cur-indfb-move
[61.478870] Subtest fbc-1p-primscrn-cur-indfb-move: SUCCESS (3.101s)
[61.617724] [002/130] (957s left) kms_pm_rpm (modeset-non-lpsp-stress-no-wait)
[63.171528] Starting subtest: modeset-non-lpsp-stress-no-wait
[63.221511] Subtest modeset-non-lpsp-stress-no-wait: SKIP (0.051s)
[63.880163] [003/130] (954s left) kms_cursor_crc (cursor-sliding-128x128)
[64.044068] Starting subtest: cursor-sliding-128x128
[64.046952] Starting dynamic subtest: pipe-A-eDP-1
[67.530566] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.483s)
[67.555407] Starting dynamic subtest: pipe-D-eDP-1
[71.878369] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.328s)
[71.879333] Subtest cursor-sliding-128x128: SUCCESS (7.834s)
[72.731273] [004/130] (946s left) sw_sync (sync_busy_fork_unixsocket)
[72.765071] Starting subtest: sync_busy_fork_unixsocket
[72.776452] Subtest sync_busy_fork_unixsocket: SUCCESS (0.011s)
[72.821599] [005/130] (945s left) prime_mmap_coherency (read)
[72.881141] Starting subtest: read
[78.256467] Subtest read: SUCCESS (5.373s)
[78.384678] [006/130] (940s left) i915_pm_rps (thresholds-idle)
[78.447838] Starting subtest: thresholds-idle
[78.450443] Subtest thresholds-idle: SKIP (0.001s)
[78.494860] [007/130] (940s left) kms_plane_scaling (planes-upscale-factor-0-25)
[78.586610] Starting subtest: planes-upscale-factor-0-25
[78.587684] Starting dynamic subtest: pipe-A
[78.650378] Dynamic subtest pipe-A: SUCCESS (0.064s)
[78.658053] Starting dynamic subtest: pipe-B
[79.767448] Dynamic subtest pipe-B: SUCCESS (1.117s)
[79.775344] Starting dynamic subtest: pipe-C
[80.870569] Dynamic subtest pipe-C: SUCCESS (1.103s)
[80.875925] Starting dynamic subtest: pipe-D
[81.996831] Dynamic subtest pipe-D: SUCCESS (1.126s)
[81.997908] Subtest planes-upscale-factor-0-25: SUCCESS (3.410s)
[83.141505] [008/130] (935s left) kms_big_fb (y-tiled-16bpp-rotate-0)
[83.251790] Starting subtest: y-tiled-16bpp-rotate-0
[83.253945] Subtest y-tiled-16bpp-rotate-0: SKIP (0.000s)
[83.331677] [009/130] (935s left) kms_setmode (invalid-clone-single-crtc-stealing)
[83.386534] Starting subtest: invalid-clone-single-crtc-stealing
[83.389635] Subtest invalid-clone-single-crtc-stealing: SKIP (0.000s)
[83.477370] [010/130] (935s left) syncobj_wait (invalid-signal-illegal-handle)
[83.539523] Starting subtest: invalid-signal-illegal-handle
[83.540530] Subtest invalid-signal-illegal-handle: SUCCESS (0.000s)
[83.646558] [011/130] (935s left) kms_ccs (crc-primary-basic-y-tiled-gen12-rc-ccs)
[83.732587] Starting subtest: crc-primary-basic-y-tiled-gen12-rc-ccs
[83.733597] Starting dynamic subtest: pipe-A-eDP-1
[83.742199] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[83.749292] Starting dynamic subtest: pipe-B-eDP-1
[83.757943] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[83.763244] Starting dynamic subtest: pipe-C-eDP-1
[83.771501] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[83.776684] Starting dynamic subtest: pipe-D-eDP-1
[83.784906] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[83.786559] Subtest crc-primary-basic-y-tiled-gen12-rc-ccs: SKIP (0.004s)
[85.881356] [012/130] (933s left) kms_psr (fbc-psr-primary-blt)
[85.967976] Starting subtest: fbc-psr-primary-blt
[85.969677] Starting dynamic subtest: eDP-1
[85.972488] Dynamic subtest eDP-1: SKIP (0.000s)
[85.975077] Subtest fbc-psr-primary-blt: SKIP (0.000s)
[86.045074] [013/130] (932s left) kms_selftest (drm_plane_helper)
[86.076406] Starting subtest: drm_plane_helper
[86.102856] Starting dynamic subtest: drm_test_check_plane_state
[86.268870] Dynamic subtest drm_test_check_plane_state: SUCCESS (0.167s)
[86.274245] Starting dynamic subtest: drm_test_check_invalid_plane_state
[86.384899] Dynamic subtest drm_test_check_invalid_plane_state: SUCCESS (0.115s)
[86.386104] Subtest drm_plane_helper: SUCCESS (0.308s)
[86.574251] [014/130] (932s left) gem_ctx_shared (single-timeline)
[86.631167] Starting subtest: single-timeline
[86.644366] Subtest single-timeline: SUCCESS (0.012s)
[86.865323] [015/130] (932s left) drm_fdinfo (most-busy-idle-check-all)
[86.900063] Starting subtest: most-busy-idle-check-all
[86.901051] Starting dynamic subtest: rcs0
[86.904892] Dynamic subtest rcs0: SKIP (0.004s)
[86.910475] Starting dynamic subtest: bcs0
[86.912119] Dynamic subtest bcs0: SKIP (0.000s)
[86.917236] Starting dynamic subtest: vcs0
[86.919076] Dynamic subtest vcs0: SKIP (0.000s)
[86.924350] Starting dynamic subtest: vcs1
[86.926270] Dynamic subtest vcs1: SKIP (0.001s)
[86.931599] Starting dynamic subtest: vecs0
[86.933410] Dynamic subtest vecs0: SKIP (0.000s)
[86.938933] Starting dynamic subtest: ccs0
[86.940743] Dynamic subtest ccs0: SKIP (0.000s)
[86.942554] Subtest most-busy-idle-check-all: SKIP (0.007s)
[86.966739] [016/130] (932s left) kms_ccs (bad-rotation-90-4-tiled-dg2-mc-ccs)
[87.111629] Starting subtest: bad-rotation-90-4-tiled-dg2-mc-ccs
[87.112745] Starting dynamic subtest: pipe-A-eDP-1
[87.121791] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[87.127694] Starting dynamic subtest: pipe-B-eDP-1
[87.136126] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[87.141504] Starting dynamic subtest: pipe-C-eDP-1
[87.149808] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[87.155444] Starting dynamic subtest: pipe-D-eDP-1
[87.163829] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[87.165485] Subtest bad-rotation-90-4-tiled-dg2-mc-ccs: SKIP (0.002s)
[89.227997] [017/130] (929s left) gem_exec_store (basic)
[89.283074] Starting subtest: basic
[89.373490] Subtest basic: SUCCESS (0.090s)
[89.545488] [018/130] (929s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180-hflip)
[89.645988] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180-hflip
[90.591983] Subtest x-tiled-max-hw-stride-32bpp-rotate-180-hflip: SUCCESS (0.946s)
[90.717227] [019/130] (928s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-blt)
[90.819583] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-blt
[96.118952] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-blt: SUCCESS (5.300s)
[96.245444] [020/130] (922s left) perf_pmu (module-unload)
[96.348217] Starting subtest: module-unload
[142.235847] Subtest module-unload: SUCCESS (45.883s)
[142.252496] [FACT perf_pmu (module-unload)] deleted: kernel.kmod_is_loaded.i915: true
[142.254260] [021/130] (877s left) gem_render_copy (y-tiled-to-vebox-linear)
[143.608417] Starting subtest: y-tiled-to-vebox-linear
[143.610840] Subtest y-tiled-to-vebox-linear: SKIP (0.000s)
[143.755695] [FACT gem_render_copy (y-tiled-to-vebox-linear)] new: kernel.kmod_is_loaded.i915: true
[143.757865] [022/130] (875s left) prime_mmap (test_refcounting)
[143.812624] Starting subtest: test_refcounting
[143.813712] Starting dynamic subtest: test_refcounting-smem
[143.849565] Dynamic subtest test_refcounting-smem: SUCCESS (0.038s)
[143.850724] Subtest test_refcounting: SUCCESS (0.038s)
[143.943222] [023/130] (875s left) gem_exec_balancer (parallel-dmabuf-import-out-fence)
[144.185462] Starting subtest: parallel-dmabuf-import-out-fence
[145.105526] Subtest parallel-dmabuf-import-out-fence: SUCCESS (0.920s)
[145.222383] [024/130] (874s left) gem_mmap_gtt (medium-copy-xy)
[145.281364] Subtest medium-copy-XY: SKIP (0.000s)
[145.332728] [025/130] (874s left) kms_getfb (getfb2-handle-protection)
[145.393887] Starting subtest: getfb2-handle-protection
[145.429949] Subtest getfb2-handle-protection: SUCCESS (0.036s)
[145.561420] [026/130] (873s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-render)
[145.667753] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-render
[145.669539] Subtest psr-2p-scndscrn-pri-shrfb-draw-render: SKIP (0.000s)
[145.784055] [027/130] (873s left) kms_ccs (bad-rotation-90-y-tiled-gen12-mc-ccs)
[145.872682] Starting subtest: bad-rotation-90-y-tiled-gen12-mc-ccs
[145.873761] Starting dynamic subtest: pipe-A-eDP-1
[145.882941] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[145.890786] Starting dynamic subtest: pipe-B-eDP-1
[145.899635] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[145.906321] Starting dynamic subtest: pipe-C-eDP-1
[145.914951] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[145.920263] Starting dynamic subtest: pipe-D-eDP-1
[145.933550] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[145.935206] Subtest bad-rotation-90-y-tiled-gen12-mc-ccs: SKIP (0.003s)
[147.996812] [028/130] (871s left) gem_wait (write-busy)
[148.063359] Starting subtest: write-busy
[148.064335] Starting dynamic subtest: all-engines
[148.693595] Dynamic subtest all-engines: SUCCESS (0.630s)
[148.708646] Starting dynamic subtest: rcs0
[149.242223] Dynamic subtest rcs0: SUCCESS (0.548s)
[149.255016] Starting dynamic subtest: bcs0
[149.788232] Dynamic subtest bcs0: SUCCESS (0.546s)
[149.799657] Starting dynamic subtest: vcs0
[150.890485] Dynamic subtest vcs0: SUCCESS (1.099s)
[150.901546] Starting dynamic subtest: vcs1
[152.937573] Dynamic subtest vcs1: SUCCESS (2.046s)
[152.949332] Starting dynamic subtest: vecs0
[154.921711] Dynamic subtest vecs0: SUCCESS (1.983s)
[154.933973] Starting dynamic subtest: ccs0
[155.470360] Dynamic subtest ccs0: SUCCESS (0.550s)
[155.471828] Subtest write-busy: SUCCESS (7.406s)
[155.669188] [FACT gem_wait (write-busy)] new: kernel.kmod_is_loaded.vgem: true
[155.671166] [029/130] (863s left) gem_userptr_blits (mmap-offset-banned)
[155.736816] Starting subtest: mmap-offset-banned
[155.737835] Starting dynamic subtest: wb
[155.738859] Dynamic subtest wb: SUCCESS (0.000s)
[155.746198] Starting dynamic subtest: wc
[155.747110] Dynamic subtest wc: SUCCESS (0.000s)
[155.753189] Starting dynamic subtest: uc
[155.754068] Dynamic subtest uc: SUCCESS (0.000s)
[155.754950] Subtest mmap-offset-banned: SUCCESS (0.002s)
[155.861577] [030/130] (863s left) gem_busy (semaphore)
[156.058724] Subtest semaphore: SKIP (0.000s)
[156.301086] [031/130] (863s left) kms_plane_scaling (planes-downscale-factor-0-5-unity-scaling)
[156.401789] Starting subtest: planes-downscale-factor-0-5-unity-scaling
[156.402841] Starting dynamic subtest: pipe-A
[156.408841] Dynamic subtest pipe-A: SKIP (0.005s)
[156.414974] Starting dynamic subtest: pipe-B
[156.428776] Dynamic subtest pipe-B: SKIP (0.020s)
[156.434884] Starting dynamic subtest: pipe-C
[156.448992] Dynamic subtest pipe-C: SKIP (0.020s)
[156.454791] Starting dynamic subtest: pipe-D
[156.465607] Dynamic subtest pipe-D: SKIP (0.016s)
[156.467279] Subtest planes-downscale-factor-0-5-unity-scaling: SKIP (0.062s)
[156.553680] [032/130] (863s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-shrfb-pgflip-blt)
[156.644838] Starting subtest: fbcpsr-1p-primscrn-shrfb-pgflip-blt
[161.848524] Subtest fbcpsr-1p-primscrn-shrfb-pgflip-blt: SUCCESS (5.204s)
[161.988489] [033/130] (857s left) gem_exec_schedule (preemptive-hang)
[162.164538] Starting subtest: preemptive-hang
[162.166197] Starting dynamic subtest: rcs0
[171.025761] Dynamic subtest rcs0: SUCCESS (8.863s)
[171.031872] Starting dynamic subtest: bcs0
[180.043693] Dynamic subtest bcs0: SUCCESS (9.015s)
[180.052643] Starting dynamic subtest: vcs0
[189.073294] Dynamic subtest vcs0: SUCCESS (9.030s)
[189.081320] Starting dynamic subtest: vcs1
[198.092779] Dynamic subtest vcs1: SUCCESS (9.018s)
[198.101814] Starting dynamic subtest: vecs0
[207.051576] Dynamic subtest vecs0: SUCCESS (8.959s)
[207.061442] Starting dynamic subtest: ccs0
[216.016537] Dynamic subtest ccs0: SUCCESS (8.962s)
[216.017781] Subtest preemptive-hang: SUCCESS (53.850s)
[216.268204] [034/130] (803s left) kms_frontbuffer_tracking (psr-rgb101010-draw-mmap-wc)
[216.370134] Starting subtest: psr-rgb101010-draw-mmap-wc
[221.257861] Subtest psr-rgb101010-draw-mmap-wc: SUCCESS (4.889s)
[221.353242] [035/130] (798s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-32bpp-xtile-upscaling)
[221.437781] Starting subtest: flip-64bpp-xtile-to-32bpp-xtile-upscaling
[221.438666] Starting dynamic subtest: pipe-A-default-mode
[224.155793] Dynamic subtest pipe-A-default-mode: SUCCESS (2.717s)
[224.156812] Subtest flip-64bpp-xtile-to-32bpp-xtile-upscaling: SUCCESS (2.718s)
[224.985030] [036/130] (794s left) i915_query (query-regions-sanity-check)
[225.038446] Starting subtest: query-regions-sanity-check
[225.051489] Subtest query-regions-sanity-check: SUCCESS (0.014s)
[225.165448] [037/130] (794s left) core_getversion (all-cards)
[225.200319] Starting subtest: all-cards
[227.163774] Subtest all-cards: SUCCESS (1.965s)
[227.196980] [FACT core_getversion (all-cards)] new: kernel.kmod_is_loaded.amdgpu: true
[227.197675] [FACT core_getversion (all-cards)] new: kernel.kmod_is_loaded.xe: true
[227.199436] [038/130] (792s left) kms_addfb_basic (bad-pitch-128)
[227.260291] Starting subtest: bad-pitch-128
[227.261339] Subtest bad-pitch-128: SUCCESS (0.000s)
[227.398783] [039/130] (792s left) kms_psr2_sf (fbc-pr-plane-move-sf-dmg-area)
[232.452722] Starting subtest: fbc-pr-plane-move-sf-dmg-area
[232.458034] Subtest fbc-pr-plane-move-sf-dmg-area: SKIP (0.004s)
[233.285647] [040/130] (786s left) drm_fdinfo (idle)
[233.321089] Starting subtest: idle
[233.322425] Starting dynamic subtest: rcs0
[233.893954] Dynamic subtest rcs0: SUCCESS (0.572s)
[233.903080] Starting dynamic subtest: bcs0
[234.400552] Dynamic subtest bcs0: SUCCESS (0.503s)
[234.407666] Starting dynamic subtest: vcs0
[234.906225] Dynamic subtest vcs0: SUCCESS (0.503s)
[234.915091] Starting dynamic subtest: vcs1
[235.410786] Dynamic subtest vcs1: SUCCESS (0.503s)
[235.420423] Starting dynamic subtest: vecs0
[235.915602] Dynamic subtest vecs0: SUCCESS (0.503s)
[235.924727] Starting dynamic subtest: ccs0
[236.420765] Dynamic subtest ccs0: SUCCESS (0.503s)
[236.422075] Subtest idle: SUCCESS (3.098s)
[236.487369] [041/130] (783s left) kms_flip (flip-vs-expired-vblank-interruptible)
[236.599191] Starting subtest: flip-vs-expired-vblank-interruptible
[236.601945] Starting dynamic subtest: A-eDP1
[245.298414] Dynamic subtest A-eDP1: SUCCESS (8.697s)
[245.305489] Starting dynamic subtest: B-eDP1
[253.918243] Dynamic subtest B-eDP1: SUCCESS (8.619s)
[253.927099] Starting dynamic subtest: C-eDP1
[262.626903] Dynamic subtest C-eDP1: SUCCESS (8.707s)
[262.634850] Starting dynamic subtest: D-eDP1
[271.247980] Dynamic subtest D-eDP1: SUCCESS (8.620s)
[271.251201] Subtest flip-vs-expired-vblank-interruptible: SUCCESS (34.652s)
[272.398616] [042/130] (747s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-0-hflip)
[272.497798] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-0-hflip
[272.499728] Subtest y-tiled-max-hw-stride-64bpp-rotate-0-hflip: SKIP (0.000s)
[272.602898] [043/130] (747s left) gem_exec_reloc (basic-wc)
[272.656161] Subtest basic-wc: SKIP (0.000s)
[272.718967] [044/130] (747s left) syncobj_wait (invalid-single-wait-all-unsubmitted)
[272.771902] Starting subtest: invalid-single-wait-all-unsubmitted
[272.773102] Subtest invalid-single-wait-all-unsubmitted: SUCCESS (0.000s)
[272.901283] [045/130] (747s left) syncobj_timeline (multi-wait-submitted-signaled)
[272.946395] Starting subtest: multi-wait-submitted-signaled
[272.947428] Subtest multi-wait-submitted-signaled: SUCCESS (0.001s)
[273.036046] [046/130] (747s left) kms_cursor_legacy (cursora-vs-flipb-toggle)
[273.152558] Starting subtest: cursorA-vs-flipB-toggle
[273.154482] Subtest cursorA-vs-flipB-toggle: SKIP (0.001s)
[273.281981] [047/130] (746s left) kms_big_fb (4-tiled-8bpp-rotate-0)
[273.394853] Starting subtest: 4-tiled-8bpp-rotate-0
[274.517674] Subtest 4-tiled-8bpp-rotate-0: SUCCESS (1.123s)
[274.723363] [048/130] (745s left) syncobj_wait (multi-wait-for-submit-submitted)
[274.776337] Starting subtest: multi-wait-for-submit-submitted
[274.886708] Subtest multi-wait-for-submit-submitted: SUCCESS (0.107s)
[274.955963] [049/130] (745s left) kms_flip (2x-flip-vs-expired-vblank)
[275.047459] Starting subtest: 2x-flip-vs-expired-vblank
[275.058754] Subtest 2x-flip-vs-expired-vblank: SKIP (0.011s)
[275.166637] [050/130] (745s left) kms_big_fb (yf-tiled-32bpp-rotate-90)
[275.272021] Starting subtest: yf-tiled-32bpp-rotate-90
[275.273995] Subtest yf-tiled-32bpp-rotate-90: SKIP (0.000s)
[275.365014] [051/130] (744s left) gem_exec_schedule (noreorder-corked)
[275.547085] Starting subtest: noreorder-corked
[275.549092] Starting dynamic subtest: rcs0
[276.701937] Dynamic subtest rcs0: SUCCESS (1.154s)
[276.712510] Starting dynamic subtest: vcs0
[277.940933] Dynamic subtest vcs0: SUCCESS (1.235s)
[277.950750] Starting dynamic subtest: vcs1
[279.898131] Dynamic subtest vcs1: SUCCESS (1.955s)
[279.907825] Starting dynamic subtest: vecs0
[281.918580] Dynamic subtest vecs0: SUCCESS (2.018s)
[281.928989] Starting dynamic subtest: ccs0
[283.072527] Dynamic subtest ccs0: SUCCESS (1.154s)
[283.073909] Subtest noreorder-corked: SUCCESS (7.526s)
[283.255331] [052/130] (737s left) kms_addfb_basic (legacy-format)
[283.306030] Starting subtest: legacy-format
[283.343939] Subtest legacy-format: SUCCESS (0.034s)
[283.501351] [053/130] (736s left) kms_psr (psr2-dpms)
[283.601472] Starting subtest: psr2-dpms
[283.602481] Starting dynamic subtest: eDP-1
[286.504137] Dynamic subtest eDP-1: SUCCESS (2.902s)
[286.505263] Subtest psr2-dpms: SUCCESS (2.903s)
[287.361178] [054/130] (732s left) kms_cursor_crc (cursor-onscreen-32x10)
[287.508436] Starting subtest: cursor-onscreen-32x10
[287.544834] Subtest cursor-onscreen-32x10: SKIP (0.034s)
[287.792665] [055/130] (732s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-indfb-pgflip-blt)
[287.891866] Starting subtest: fbc-2p-scndscrn-indfb-pgflip-blt
[287.893739] Subtest fbc-2p-scndscrn-indfb-pgflip-blt: SKIP (0.000s)
[288.010644] [056/130] (732s left) gen9_exec_parse (bb-oversize)
[288.070440] Subtest bb-oversize: SKIP (0.000s)
[288.137286] [057/130] (732s left) perf (gen12-group-concurrent-oa-buffer-read)
[288.245456] Starting subtest: gen12-group-concurrent-oa-buffer-read
[298.277398] Subtest gen12-group-concurrent-oa-buffer-read: SUCCESS (10.029s)
[298.317099] [058/130] (722s left) syncobj_timeline (single-wait-available-submitted)
[298.370260] Starting subtest: single-wait-available-submitted
[298.371482] Subtest single-wait-available-submitted: SUCCESS (0.000s)
[298.461543] [059/130] (722s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-mmap-cpu)
[298.564725] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-mmap-cpu
[298.566611] Subtest fbc-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[298.662023] [060/130] (721s left) gem_exec_capture (capture)
[298.723128] Starting subtest: capture
[298.723980] Starting dynamic subtest: rcs0-smem
[299.551510] Dynamic subtest rcs0-smem: SUCCESS (0.829s)
[299.560481] Starting dynamic subtest: bcs0-smem
[300.875842] Dynamic subtest bcs0-smem: SUCCESS (1.323s)
[300.882588] Starting dynamic subtest: vcs0-smem
[301.685859] Dynamic subtest vcs0-smem: SUCCESS (0.809s)
[301.694386] Starting dynamic subtest: vcs1-smem
[302.498139] Dynamic subtest vcs1-smem: SUCCESS (0.811s)
[302.506476] Starting dynamic subtest: vecs0-smem
[303.843885] Dynamic subtest vecs0-smem: FAIL (1.318s)
[303.851044] Starting dynamic subtest: ccs0-smem
[305.135564] Dynamic subtest ccs0-smem: SUCCESS (1.318s)
[305.136727] Subtest capture: FAIL (6.412s)
[305.262978] [061/130] (715s left) kms_fb_coherency (memset-crc)
[305.356280] Starting subtest: memset-crc
[305.357148] Starting dynamic subtest: mmap-offset-wc
[305.742726] Dynamic subtest mmap-offset-wc: SUCCESS (0.387s)
[306.042977] Starting dynamic subtest: mmap-offset-uc
[312.224109] Dynamic subtest mmap-offset-uc: SUCCESS (6.187s)
[312.503739] Subtest memset-crc: SUCCESS (7.147s)
[313.309821] [062/130] (707s left) kms_addfb_basic (bad-pitch-32)
[313.359060] Starting subtest: bad-pitch-32
[313.359996] Subtest bad-pitch-32: SUCCESS (0.000s)
[313.497226] [063/130] (707s left) syncobj_timeline (host-signal-points)
[313.555532] Starting subtest: host-signal-points
[313.559754] Subtest host-signal-points: SUCCESS (0.004s)
[313.663522] [064/130] (706s left) sysfs_timeslice_duration (invalid)
[313.712283] Starting subtest: invalid
[313.713217] Starting dynamic subtest: vecs0
[313.714151] Dynamic subtest vecs0: SUCCESS (0.000s)
[313.721624] Starting dynamic subtest: ccs0
[313.722436] Dynamic subtest ccs0: SUCCESS (0.000s)
[313.729018] Starting dynamic subtest: vcs0
[313.729882] Dynamic subtest vcs0: SUCCESS (0.000s)
[313.736153] Starting dynamic subtest: bcs0
[313.736990] Dynamic subtest bcs0: SUCCESS (0.000s)
[313.743343] Starting dynamic subtest: rcs0
[313.744171] Dynamic subtest rcs0: SUCCESS (0.000s)
[313.750298] Starting dynamic subtest: vcs1
[313.751070] Dynamic subtest vcs1: SUCCESS (0.000s)
[313.751848] Subtest invalid: SUCCESS (0.005s)
[313.781533] [065/130] (706s left) kms_content_protection (dp-mst-type-0)
[313.954982] Starting subtest: dp-mst-type-0
[313.957094] Subtest dp-mst-type-0: SKIP (0.000s)
[314.088245] [066/130] (706s left) kms_color (invalid-gamma-lut-sizes)
[314.172923] Starting subtest: invalid-gamma-lut-sizes
[314.174096] Starting dynamic subtest: pipe-A
[314.462208] Dynamic subtest pipe-A: SUCCESS (0.288s)
[314.475123] Starting dynamic subtest: pipe-B
[314.476176] Dynamic subtest pipe-B: SUCCESS (0.001s)
[314.484373] Starting dynamic subtest: pipe-C
[314.485365] Dynamic subtest pipe-C: SUCCESS (0.001s)
[314.491890] Starting dynamic subtest: pipe-D
[314.492752] Dynamic subtest pipe-D: SUCCESS (0.001s)
[314.493758] Subtest invalid-gamma-lut-sizes: SUCCESS (0.292s)
[315.238473] [067/130] (705s left) kms_chamelium_hpd (hdmi-hpd)
[315.624081] Subtest hdmi-hpd: SKIP (0.000s)
[316.439557] [068/130] (704s left) kms_pipe_b_c_ivb (enable-pipe-c-while-b-has-3-lanes)
[316.491994] Subtest enable-pipe-C-while-B-has-3-lanes: SKIP (0.000s)
[316.559300] [069/130] (704s left) gem_exec_reloc (basic-write-wc-noreloc)
[316.618426] Subtest basic-write-wc-noreloc: SKIP (0.000s)
[316.691498] [070/130] (704s left) kms_prime (basic-crc-hybrid)
[316.777200] Subtest basic-crc-hybrid: SKIP (0.000s)
[316.857452] [071/130] (703s left) kms_psr2_su (page_flip-xrgb8888)
[316.924073] Subtest page_flip-XRGB8888: SKIP (0.000s)
[316.981889] [072/130] (703s left) prime_vgem (basic-write)
[317.048191] Starting subtest: basic-write
[317.058428] Subtest basic-write: SKIP (0.009s)
[317.169016] [073/130] (703s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted)
[317.219022] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted
[317.326453] Subtest etime-multi-wait-all-for-submit-unsubmitted: SUCCESS (0.105s)
[317.392473] [074/130] (703s left) kms_big_fb (linear-16bpp-rotate-90)
[317.502138] Starting subtest: linear-16bpp-rotate-90
[317.521278] Subtest linear-16bpp-rotate-90: SKIP (0.019s)
[317.654418] [075/130] (703s left) gem_create (create-ext-placement-each)
[317.815352] Starting subtest: create-ext-placement-each
[317.816815] Subtest create-ext-placement-each: SUCCESS (0.000s)
[317.914989] [076/130] (703s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-wc)
[318.015220] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-wc
[318.016878] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[318.126900] [077/130] (702s left) gem_mmap_gtt (big-copy)
[318.182776] Subtest big-copy: SKIP (0.000s)
[318.246924] [078/130] (702s left) kms_ccs (random-ccs-data-4-tiled-mtl-rc-ccs-cc)
[318.347782] Starting subtest: random-ccs-data-4-tiled-mtl-rc-ccs-cc
[318.348890] Starting dynamic subtest: pipe-A-eDP-1
[319.117890] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.768s)
[319.124459] Starting dynamic subtest: pipe-B-eDP-1
[320.913722] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.794s)
[320.921815] Starting dynamic subtest: pipe-C-eDP-1
[322.740538] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.825s)
[322.747144] Starting dynamic subtest: pipe-D-eDP-1
[324.569090] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.827s)
[324.570093] Subtest random-ccs-data-4-tiled-mtl-rc-ccs-cc: SUCCESS (6.221s)
[325.670648] [079/130] (695s left) gem_ctx_param (invalid-param-set)
[325.728445] Starting subtest: invalid-param-set
[325.729556] Subtest invalid-param-set: SUCCESS (0.000s)
[325.796492] [080/130] (695s left) kms_plane (plane-position-hole-dpms)
[325.891880] Starting subtest: plane-position-hole-dpms
[326.393477] Starting dynamic subtest: pipe-A-plane-1
[328.645276] Dynamic subtest pipe-A-plane-1: SUCCESS (2.253s)
[328.651939] Starting dynamic subtest: pipe-A-plane-2
[331.003208] Dynamic subtest pipe-A-plane-2: SUCCESS (2.358s)
[331.012574] Starting dynamic subtest: pipe-A-plane-3
[333.357706] Dynamic subtest pipe-A-plane-3: SUCCESS (2.353s)
[333.364967] Starting dynamic subtest: pipe-A-plane-4
[335.624076] Dynamic subtest pipe-A-plane-4: SUCCESS (2.265s)
[335.631336] Starting dynamic subtest: pipe-A-plane-5
[335.663463] Dynamic subtest pipe-A-plane-5: SUCCESS (0.038s)
[336.783235] Starting dynamic subtest: pipe-B-plane-1
[339.006224] Dynamic subtest pipe-B-plane-1: SUCCESS (2.229s)
[339.012702] Starting dynamic subtest: pipe-B-plane-2
[341.257058] Dynamic subtest pipe-B-plane-2: SUCCESS (2.249s)
[341.263858] Starting dynamic subtest: pipe-B-plane-3
[343.614244] Dynamic subtest pipe-B-plane-3: SUCCESS (2.356s)
[343.621391] Starting dynamic subtest: pipe-B-plane-4
[345.967539] Dynamic subtest pipe-B-plane-4: SUCCESS (2.353s)
[345.974330] Starting dynamic subtest: pipe-B-plane-5
[346.005357] Dynamic subtest pipe-B-plane-5: SUCCESS (0.036s)
[346.006322] Subtest plane-position-hole-dpms: SUCCESS (20.112s)
[346.770977] [081/130] (674s left) core_setmaster_vs_auth
[346.942449] [082/130] (674s left) syncobj_timeline (invalid-signal-zero-handles)
[346.999654] Starting subtest: invalid-signal-zero-handles
[347.000534] Subtest invalid-signal-zero-handles: SUCCESS (0.000s)
[347.097761] [083/130] (674s left) kms_dsc (dsc-with-formats)
[347.191926] Starting subtest: dsc-with-formats
[347.207098] Subtest dsc-with-formats: SKIP (0.001s)
[347.269591] [084/130] (674s left) gem_ctx_persistence (engines-persistence)
[347.325213] Starting subtest: engines-persistence
[347.326125] Starting dynamic subtest: rcs0
[348.153530] Dynamic subtest rcs0: SUCCESS (0.827s)
[348.164865] Starting dynamic subtest: bcs0
[348.925671] Dynamic subtest bcs0: SUCCESS (0.770s)
[348.936186] Starting dynamic subtest: vcs0
[349.751645] Dynamic subtest vcs0: SUCCESS (0.824s)
[349.761631] Starting dynamic subtest: vcs1
[350.531933] Dynamic subtest vcs1: SUCCESS (0.778s)
[350.543298] Starting dynamic subtest: vecs0
[351.351877] Dynamic subtest vecs0: SUCCESS (0.818s)
[351.364031] Starting dynamic subtest: ccs0
[352.085813] Dynamic subtest ccs0: SUCCESS (0.732s)
[352.087058] Subtest engines-persistence: SUCCESS (4.761s)
[352.211545] [085/130] (669s left) gem_fenced_exec_thrash (no-spare-fences-busy)
[352.267417] Subtest no-spare-fences-busy: SKIP (0.000s)
[352.342685] [086/130] (669s left) kms_cursor_legacy (cursor-vs-flip-atomic)
[352.456962] Starting subtest: cursor-vs-flip-atomic
[381.740831] Subtest cursor-vs-flip-atomic: SUCCESS (29.282s)
[382.585399] [087/130] (638s left) kms_cursor_legacy (flip-vs-cursor-busy-crc-legacy)
[382.704802] Starting subtest: flip-vs-cursor-busy-crc-legacy
[383.464307] Subtest flip-vs-cursor-busy-crc-legacy: SUCCESS (0.757s)
[384.309343] [088/130] (637s left) gem_ppgtt (shrink-vs-evict-pinned)
[384.366803] Starting subtest: shrink-vs-evict-pinned
[389.900445] Subtest shrink-vs-evict-pinned: SUCCESS (5.530s)
[390.015363] [089/130] (631s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-blt)
[390.132030] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-blt
[392.852601] Subtest fbc-1p-primscrn-cur-indfb-draw-blt: SUCCESS (2.721s)
[392.986440] [090/130] (628s left) kms_vrr (seamless-rr-switch-virtual)
[393.075834] Starting subtest: seamless-rr-switch-virtual
[393.078698] Subtest seamless-rr-switch-virtual: SKIP (0.000s)
[393.141144] [091/130] (628s left) i915_hangman (gt-engine-error)
[393.201526] Starting subtest: gt-engine-error
[393.202565] Starting dynamic subtest: rcs0
[394.889534] Dynamic subtest rcs0: SUCCESS (1.685s)
[394.899316] Starting dynamic subtest: bcs0
[396.872683] Dynamic subtest bcs0: SUCCESS (1.981s)
[396.882618] Starting dynamic subtest: vcs0
[398.919864] Dynamic subtest vcs0: SUCCESS (2.044s)
[398.927974] Starting dynamic subtest: vcs1
[400.904959] Dynamic subtest vcs1: SUCCESS (1.982s)
[400.914756] Starting dynamic subtest: vecs0
[402.888622] Dynamic subtest vecs0: SUCCESS (1.981s)
[402.899715] Starting dynamic subtest: ccs0
[404.873658] Dynamic subtest ccs0: SUCCESS (1.982s)
[404.875338] Subtest gt-engine-error: SUCCESS (11.671s)
[405.018530] [092/130] (616s left) kms_cursor_legacy (modeset-atomic-cursor-hotspot)
[405.135644] Starting subtest: modeset-atomic-cursor-hotspot
[405.137545] Subtest modeset-atomic-cursor-hotspot: SKIP (0.000s)
[405.262330] [093/130] (616s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-render)
[405.364845] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-render
[408.897820] Subtest fbc-1p-primscrn-pri-indfb-draw-render: SUCCESS (3.533s)
[409.051773] [094/130] (612s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-fullscreen)
[409.189529] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-fullscreen
[409.191264] Subtest fbcpsr-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s)
[409.287465] [095/130] (612s left) kms_psr (fbc-pr-basic)
[409.382628] Starting subtest: fbc-pr-basic
[409.385074] Subtest fbc-pr-basic: SKIP (0.000s)
[409.448244] [096/130] (612s left) kms_flip (2x-dpms-vs-vblank-race)
[409.548815] Starting subtest: 2x-dpms-vs-vblank-race
[409.560114] Subtest 2x-dpms-vs-vblank-race: SKIP (0.011s)
[409.638842] [097/130] (612s left) kms_ccs (crc-sprite-planes-basic-y-tiled-ccs)
[409.726824] Starting subtest: crc-sprite-planes-basic-y-tiled-ccs
[409.727854] Starting dynamic subtest: pipe-A-eDP-1
[409.749626] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[409.756789] Starting dynamic subtest: pipe-B-eDP-1
[409.778615] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[409.785566] Starting dynamic subtest: pipe-C-eDP-1
[409.807065] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[409.814234] Starting dynamic subtest: pipe-D-eDP-1
[409.835215] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[409.836864] Subtest crc-sprite-planes-basic-y-tiled-ccs: SKIP (0.008s)
[411.911344] [098/130] (609s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-mmap-wc)
[412.000106] Starting subtest: psr-1p-primscrn-cur-indfb-draw-mmap-wc
[416.361632] Subtest psr-1p-primscrn-cur-indfb-draw-mmap-wc: SUCCESS (4.362s)
[416.468666] [099/130] (605s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-fullscreen)
[416.559803] Starting subtest: psr-2p-primscrn-spr-indfb-fullscreen
[416.561456] Subtest psr-2p-primscrn-spr-indfb-fullscreen: SKIP (0.000s)
[416.671443] [100/130] (605s left) kms_big_fb (linear-8bpp-rotate-180)
[416.770747] Starting subtest: linear-8bpp-rotate-180
[417.891954] Subtest linear-8bpp-rotate-180: SUCCESS (1.122s)
[418.020934] [101/130] (603s left) kms_pipe_crc_basic (nonblocking-crc)
[418.122839] Starting subtest: nonblocking-crc
[418.123866] Starting dynamic subtest: pipe-A-eDP-1
[418.868939] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.745s)
[418.877276] Starting dynamic subtest: pipe-B-eDP-1
[420.289153] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.417s)
[420.296080] Starting dynamic subtest: pipe-C-eDP-1
[421.657438] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.366s)
[421.664917] Starting dynamic subtest: pipe-D-eDP-1
[423.002578] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.345s)
[423.003566] Subtest nonblocking-crc: SUCCESS (4.879s)
[423.783376] [102/130] (598s left) gem_render_copy (x-tiled-to-vebox-y-tiled)
[423.836503] Starting subtest: x-tiled-to-vebox-y-tiled
[423.838402] Subtest x-tiled-to-vebox-y-tiled: SKIP (0.000s)
[424.014989] [103/130] (597s left) kms_chamelium_color (degamma)
[424.109591] Subtest degamma: SKIP (0.000s)
[424.147512] [104/130] (597s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-gtt)
[424.246908] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-gtt
[424.248607] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[424.344294] [105/130] (597s left) vgem_basic (debugfs)
[424.380160] Starting subtest: debugfs
[424.381046] Subtest debugfs: SUCCESS (0.000s)
[424.429868] [106/130] (597s left) gem_lmem_swapping (heavy-random)
[424.462986] Subtest heavy-random: SKIP (0.000s)
[424.505567] [107/130] (597s left) syncobj_wait (wait-delayed-signal)
[424.562897] Starting subtest: wait-delayed-signal
[424.668087] Subtest wait-delayed-signal: SUCCESS (0.102s)
[424.736244] [108/130] (597s left) kms_psr (fbc-psr2-sprite-render)
[424.833248] Starting subtest: fbc-psr2-sprite-render
[424.834250] Starting dynamic subtest: eDP-1
[424.836057] Dynamic subtest eDP-1: SKIP (0.000s)
[424.837874] Subtest fbc-psr2-sprite-render: SKIP (0.001s)
[424.902127] [109/130] (597s left) vgem_basic (dmabuf-export)
[424.946131] Starting subtest: dmabuf-export
[424.992901] Subtest dmabuf-export: SUCCESS (0.047s)
[425.110116] [110/130] (597s left) syncobj_wait (single-wait-signaled)
[425.160746] Starting subtest: single-wait-signaled
[425.161895] Subtest single-wait-signaled: SUCCESS (0.000s)
[425.265552] [111/130] (596s left) gem_set_tiling_vs_blt (tiled-to-tiled)
[425.316069] Subtest tiled-to-tiled: SKIP (0.000s)
[425.380165] [112/130] (596s left) gem_exec_whisper (basic-contexts-forked)
[425.434473] Starting subtest: basic-contexts-forked
[448.338565] Subtest basic-contexts-forked: SUCCESS (22.899s)
[448.515045] [113/130] (573s left) kms_flip (plain-flip-fb-recreate)
[448.616297] Starting subtest: plain-flip-fb-recreate
[448.618534] Starting dynamic subtest: A-eDP1
[457.470955] Dynamic subtest A-eDP1: SUCCESS (8.852s)
[457.479974] Starting dynamic subtest: B-eDP1
[466.396639] Dynamic subtest B-eDP1: SUCCESS (8.924s)
[466.405076] Starting dynamic subtest: C-eDP1
[475.313548] Dynamic subtest C-eDP1: SUCCESS (8.915s)
[475.321482] Starting dynamic subtest: D-eDP1
[484.140563] Dynamic subtest D-eDP1: SUCCESS (8.826s)
[484.143055] Subtest plain-flip-fb-recreate: SUCCESS (35.526s)
[485.309692] [114/130] (536s left) gem_softpin (noreloc)
[485.376054] Starting subtest: noreloc
[490.791319] Subtest noreloc: SUCCESS (5.413s)
[490.928078] [115/130] (531s left) gem_mmap_offset (partial-mmap)
[490.979501] Starting subtest: partial-mmap
[490.980445] Starting dynamic subtest: smem0
[490.987918] Dynamic subtest smem0: SUCCESS (0.008s)
[490.988804] Subtest partial-mmap: SUCCESS (0.009s)
[491.085177] [116/130] (531s left) kms_lease (simple-lease)
[491.177788] Starting subtest: simple-lease
[491.179092] Starting dynamic subtest: pipe-A-eDP-1
[491.701121] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.521s)
[491.709777] Starting dynamic subtest: pipe-B-eDP-1
[493.144912] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.441s)
[493.154298] Starting dynamic subtest: pipe-C-eDP-1
[494.528077] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.382s)
[494.535712] Starting dynamic subtest: pipe-D-eDP-1
[495.930421] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.399s)
[495.931484] Subtest simple-lease: SUCCESS (4.751s)
[496.724249] [117/130] (525s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-mmap-gtt)
[496.824810] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-mmap-gtt
[496.826556] Subtest fbc-2p-scndscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[496.929300] [118/130] (525s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-32bpp-yftileccs-upscaling)
[497.021959] Starting subtest: flip-32bpp-yftile-to-32bpp-yftileccs-upscaling
[497.023033] Starting dynamic subtest: pipe-A-default-mode
[497.314055] Dynamic subtest pipe-A-default-mode: SKIP (0.288s)
[497.315891] Subtest flip-32bpp-yftile-to-32bpp-yftileccs-upscaling: SKIP (0.290s)
[498.140870] [119/130] (524s left) kms_frontbuffer_tracking (psr-1p-offscren-pri-shrfb-draw-render)
[498.235945] Starting subtest: psr-1p-offscren-pri-shrfb-draw-render
[503.052367] Subtest psr-1p-offscren-pri-shrfb-draw-render: SUCCESS (4.815s)
[503.183755] [120/130] (519s left) api_intel_allocator (reserve-simple)
[503.241951] Starting subtest: reserve-simple
[503.244315] Subtest reserve-simple: SUCCESS (0.003s)
[503.381196] [121/130] (519s left) kms_invalid_mode (zero-vdisplay)
[503.479598] Starting subtest: zero-vdisplay
[503.480614] Starting dynamic subtest: pipe-A-eDP-1
[503.762664] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.283s)
[503.769964] Starting dynamic subtest: pipe-B-eDP-1
[503.770962] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[503.777461] Starting dynamic subtest: pipe-C-eDP-1
[503.778468] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[503.785394] Starting dynamic subtest: pipe-D-eDP-1
[503.786376] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[503.787393] Subtest zero-vdisplay: SUCCESS (0.288s)
[504.612022] [122/130] (517s left) kms_vblank (invalid)
[504.707824] Starting subtest: invalid
[504.708770] Starting dynamic subtest: pipe-A-eDP-1
[505.116187] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.407s)
[505.117183] Subtest invalid: SUCCESS (0.408s)
[505.930852] [123/130] (516s left) gem_exec_gttfill (all-engines)
[505.995273] Starting subtest: all-engines
[531.140247] Subtest all-engines: SUCCESS (25.142s)
[531.319279] [124/130] (491s left) gem_mmap_gtt (hang-busy)
[531.407863] Subtest hang-busy: SKIP (0.000s)
[531.468975] [125/130] (491s left) gem_exec_flush (basic-uc-prw-default)
[531.534977] Starting subtest: basic-uc-prw-default
[537.035409] Subtest basic-uc-prw-default: SUCCESS (5.500s)
[537.217294] [126/130] (485s left) gem_ctx_persistence (legacy-engines-persistence)
[537.276633] Starting subtest: legacy-engines-persistence
[537.277826] Starting dynamic subtest: render
[538.116736] Dynamic subtest render: SUCCESS (0.839s)
[538.128724] Starting dynamic subtest: bsd1
[538.926559] Dynamic subtest bsd1: SUCCESS (0.806s)
[538.937437] Starting dynamic subtest: bsd2
[539.692956] Dynamic subtest bsd2: SUCCESS (0.764s)
[539.706599] Starting dynamic subtest: blt
[540.462136] Dynamic subtest blt: SUCCESS (0.766s)
[540.474381] Starting dynamic subtest: vebox
[541.228857] Dynamic subtest vebox: SUCCESS (0.764s)
[541.230382] Subtest legacy-engines-persistence: SUCCESS (3.953s)
[541.306331] [127/130] (481s left) syncobj_wait (invalid-multi-wait-unsubmitted-submitted)
[541.370809] Starting subtest: invalid-multi-wait-unsubmitted-submitted
[541.372340] Subtest invalid-multi-wait-unsubmitted-submitted: SUCCESS (0.000s)
[541.474088] [128/130] (481s left) kms_psr (psr-sprite-mmap-cpu)
[541.571046] Starting subtest: psr-sprite-mmap-cpu
[541.571939] Starting dynamic subtest: eDP-1
[543.354599] Dynamic subtest eDP-1: SUCCESS (1.784s)
[543.355515] Subtest psr-sprite-mmap-cpu: SUCCESS (1.785s)
[544.181938] [129/130] (478s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-mmap-cpu)
[544.286443] Starting subtest: psr-2p-primscrn-cur-indfb-draw-mmap-cpu
[544.288304] Subtest psr-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[544.376825] [130/130] (478s left) prime_vgem (busy)
[544.466033] Starting subtest: busy
[544.467498] Starting dynamic subtest: rcs0
[544.553348] Dynamic subtest rcs0: SUCCESS (0.087s)
[544.560929] Starting dynamic subtest: bcs0
[544.593517] Dynamic subtest bcs0: SUCCESS (0.040s)
[544.602193] Starting dynamic subtest: vcs0
[544.632825] Dynamic subtest vcs0: SUCCESS (0.038s)
[544.639939] Starting dynamic subtest: vcs1
[544.676035] Dynamic subtest vcs1: SUCCESS (0.042s)
[544.683426] Starting dynamic subtest: vecs0
[544.720759] Dynamic subtest vecs0: SUCCESS (0.044s)
[544.727914] Starting dynamic subtest: ccs0
[544.766865] Dynamic subtest ccs0: SUCCESS (0.045s)
[544.767735] Subtest busy: SUCCESS (0.301s)
[544.891571] Closing watchdogs
results: parsing output: 0/ for test: kms_frontbuffer_tracking
results: parsing output: 1/ for test: kms_pm_rpm
results: parsing output: 2/ for test: kms_cursor_crc
results: parsing output: 3/ for test: sw_sync
results: parsing output: 4/ for test: prime_mmap_coherency
results: parsing output: 5/ for test: i915_pm_rps
results: parsing output: 6/ for test: kms_plane_scaling
results: parsing output: 7/ for test: kms_big_fb
results: parsing output: 8/ for test: kms_setmode
results: parsing output: 9/ for test: syncobj_wait
results: parsing output: 10/ for test: kms_ccs
results: parsing output: 11/ for test: kms_psr
results: parsing output: 12/ for test: kms_selftest
results: parsing output: 13/ for test: gem_ctx_shared
results: parsing output: 14/ for test: drm_fdinfo
results: parsing output: 15/ for test: kms_ccs
results: parsing output: 16/ for test: gem_exec_store
results: parsing output: 17/ for test: kms_big_fb
results: parsing output: 18/ for test: kms_frontbuffer_tracking
results: parsing output: 19/ for test: perf_pmu
results: parsing output: 20/ for test: gem_render_copy
results: parsing output: 21/ for test: prime_mmap
results: parsing output: 22/ for test: gem_exec_balancer
results: parsing output: 23/ for test: gem_mmap_gtt
results: parsing output: 24/ for test: kms_getfb
results: parsing output: 25/ for test: kms_frontbuffer_tracking
results: parsing output: 26/ for test: kms_ccs
results: parsing output: 27/ for test: gem_wait
results: parsing output: 28/ for test: gem_userptr_blits
results: parsing output: 29/ for test: gem_busy
results: parsing output: 30/ for test: kms_plane_scaling
results: parsing output: 31/ for test: kms_frontbuffer_tracking
results: parsing output: 32/ for test: gem_exec_schedule
results: parsing output: 33/ for test: kms_frontbuffer_tracking
results: parsing output: 34/ for test: kms_flip_scaled_crc
results: parsing output: 35/ for test: i915_query
results: parsing output: 36/ for test: core_getversion
results: parsing output: 37/ for test: kms_addfb_basic
results: parsing output: 38/ for test: kms_psr2_sf
results: parsing output: 39/ for test: drm_fdinfo
results: parsing output: 40/ for test: kms_flip
results: parsing output: 41/ for test: kms_big_fb
results: parsing output: 42/ for test: gem_exec_reloc
results: parsing output: 43/ for test: syncobj_wait
results: parsing output: 44/ for test: syncobj_timeline
results: parsing output: 45/ for test: kms_cursor_legacy
results: parsing output: 46/ for test: kms_big_fb
results: parsing output: 47/ for test: syncobj_wait
results: parsing output: 48/ for test: kms_flip
results: parsing output: 49/ for test: kms_big_fb
results: parsing output: 50/ for test: gem_exec_schedule
results: parsing output: 51/ for test: kms_addfb_basic
results: parsing output: 52/ for test: kms_psr
results: parsing output: 53/ for test: kms_cursor_crc
results: parsing output: 54/ for test: kms_frontbuffer_tracking
results: parsing output: 55/ for test: gen9_exec_parse
results: parsing output: 56/ for test: perf
results: parsing output: 57/ for test: syncobj_timeline
results: parsing output: 58/ for test: kms_frontbuffer_tracking
results: parsing output: 59/ for test: gem_exec_capture
results: parsing output: 60/ for test: kms_fb_coherency
results: parsing output: 61/ for test: kms_addfb_basic
results: parsing output: 62/ for test: syncobj_timeline
results: parsing output: 63/ for test: sysfs_timeslice_duration
results: parsing output: 64/ for test: kms_content_protection
results: parsing output: 65/ for test: kms_color
results: parsing output: 66/ for test: kms_chamelium_hpd
results: parsing output: 67/ for test: kms_pipe_b_c_ivb
results: parsing output: 68/ for test: gem_exec_reloc
results: parsing output: 69/ for test: kms_prime
results: parsing output: 70/ for test: kms_psr2_su
results: parsing output: 71/ for test: prime_vgem
results: parsing output: 72/ for test: syncobj_timeline
results: parsing output: 73/ for test: kms_big_fb
results: parsing output: 74/ for test: gem_create
results: parsing output: 75/ for test: kms_frontbuffer_tracking
results: parsing output: 76/ for test: gem_mmap_gtt
results: parsing output: 77/ for test: kms_ccs
results: parsing output: 78/ for test: gem_ctx_param
results: parsing output: 79/ for test: kms_plane
results: parsing output: 80/ for test: core_setmaster_vs_auth
results: parsing output: 81/ for test: syncobj_timeline
results: parsing output: 82/ for test: kms_dsc
results: parsing output: 83/ for test: gem_ctx_persistence
results: parsing output: 84/ for test: gem_fenced_exec_thrash
results: parsing output: 85/ for test: kms_cursor_legacy
results: parsing output: 86/ for test: kms_cursor_legacy
results: parsing output: 87/ for test: gem_ppgtt
results: parsing output: 88/ for test: kms_frontbuffer_tracking
results: parsing output: 89/ for test: kms_vrr
results: parsing output: 90/ for test: i915_hangman
results: parsing output: 91/ for test: kms_cursor_legacy
results: parsing output: 92/ for test: kms_frontbuffer_tracking
results: parsing output: 93/ for test: kms_frontbuffer_tracking
results: parsing output: 94/ for test: kms_psr
results: parsing output: 95/ for test: kms_flip
results: parsing output: 96/ for test: kms_ccs
results: parsing output: 97/ for test: kms_frontbuffer_tracking
results: parsing output: 98/ for test: kms_frontbuffer_tracking
results: parsing output: 99/ for test: kms_big_fb
results: parsing output: 100/ for test: kms_pipe_crc_basic
results: parsing output: 101/ for test: gem_render_copy
results: parsing output: 102/ for test: kms_chamelium_color
results: parsing output: 103/ for test: kms_frontbuffer_tracking
results: parsing output: 104/ for test: vgem_basic
results: parsing output: 105/ for test: gem_lmem_swapping
results: parsing output: 106/ for test: syncobj_wait
results: parsing output: 107/ for test: kms_psr
results: parsing output: 108/ for test: vgem_basic
results: parsing output: 109/ for test: syncobj_wait
results: parsing output: 110/ for test: gem_set_tiling_vs_blt
results: parsing output: 111/ for test: gem_exec_whisper
results: parsing output: 112/ for test: kms_flip
results: parsing output: 113/ for test: gem_softpin
results: parsing output: 114/ for test: gem_mmap_offset
results: parsing output: 115/ for test: kms_lease
results: parsing output: 116/ for test: kms_frontbuffer_tracking
results: parsing output: 117/ for test: kms_flip_scaled_crc
results: parsing output: 118/ for test: kms_frontbuffer_tracking
results: parsing output: 119/ for test: api_intel_allocator
results: parsing output: 120/ for test: kms_invalid_mode
results: parsing output: 121/ for test: kms_vblank
results: parsing output: 122/ for test: gem_exec_gttfill
results: parsing output: 123/ for test: gem_mmap_gtt
results: parsing output: 124/ for test: gem_exec_flush
results: parsing output: 125/ for test: gem_ctx_persistence
results: parsing output: 126/ for test: syncobj_wait
results: parsing output: 127/ for test: kms_psr
results: parsing output: 128/ for test: kms_frontbuffer_tracking
results: parsing output: 129/ for test: prime_vgem
Done.