[59.152835] Initializing watchdogs
[59.152881]   /dev/watchdog0
[59.166824] [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]
[59.171495] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[59.173911] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[59.177230] [001/133] (960s left) kms_cursor_legacy (short-flip-before-cursor-atomic-transitions-varying-size)
[59.320913] Starting subtest: short-flip-before-cursor-atomic-transitions-varying-size
[60.345603] Subtest short-flip-before-cursor-atomic-transitions-varying-size: SUCCESS (1.017s)
[61.208302] [002/133] (958s left) kms_hdr (brightness-with-hdr)
[61.303062] Starting subtest: brightness-with-hdr
[61.309452] Subtest brightness-with-hdr: SKIP (0.000s)
[61.386178] [003/133] (958s left) gem_sync (basic-store-all)
[61.464488] Starting subtest: basic-store-all
[63.887642] Subtest basic-store-all: SUCCESS (2.424s)
[64.070291] [004/133] (955s left) gem_ctx_persistence (heartbeat-stop)
[64.123883] Starting subtest: heartbeat-stop
[64.128713] Subtest heartbeat-stop: SKIP (0.000s)
[64.233878] [005/133] (955s left) gem_ctx_shared (q-smoketest)
[64.305307] Starting subtest: Q-smoketest
[64.307646] Starting dynamic subtest: rcs0
[69.882190] Dynamic subtest rcs0: SUCCESS (5.519s)
[69.889854] Starting dynamic subtest: bcs0
[75.352342] Dynamic subtest bcs0: SUCCESS (5.462s)
[75.360126] Starting dynamic subtest: vcs0
[80.845626] Dynamic subtest vcs0: SUCCESS (5.478s)
[80.854627] Starting dynamic subtest: vcs1
[86.332073] Dynamic subtest vcs1: SUCCESS (5.490s)
[86.341244] Starting dynamic subtest: vecs0
[91.809717] Dynamic subtest vecs0: SUCCESS (5.469s)
[91.821503] Starting dynamic subtest: ccs0
[97.309221] Dynamic subtest ccs0: SUCCESS (5.503s)
[97.311158] Subtest Q-smoketest: SUCCESS (32.925s)
[97.449552] [006/133] (922s left) kms_chamelium_hpd (hdmi-hpd-enable-disable-mode)
[97.846747] Subtest hdmi-hpd-enable-disable-mode: SKIP (0.000s)
[98.651123] [007/133] (921s left) kms_cursor_legacy (cursora-vs-flipa-atomic-transitions)
[98.774026] Starting subtest: cursorA-vs-flipA-atomic-transitions
[109.954166] Subtest cursorA-vs-flipA-atomic-transitions: SUCCESS (11.177s)
[110.804970] [008/133] (909s left) gem_pread (display)
[110.869115] Subtest display: SKIP (0.000s)
[110.930263] [009/133] (909s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180)
[111.031408] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180
[112.111591] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180: SUCCESS (1.080s)
[112.229032] [010/133] (907s left) gen3_render_tiledy_blits
[112.338145] [011/133] (907s left) kms_flip_scaled_crc (flip-64bpp-linear-to-16bpp-linear-downscaling)
[112.437362] Starting subtest: flip-64bpp-linear-to-16bpp-linear-downscaling
[112.439277] Starting dynamic subtest: pipe-A-default-mode
[113.569232] Dynamic subtest pipe-A-default-mode: SKIP (1.129s)
[113.573695] Subtest flip-64bpp-linear-to-16bpp-linear-downscaling: SKIP (1.130s)
[113.714568] [012/133] (906s left) gem_mmap_gtt (big-bo-tiledy)
[113.764279] Subtest big-bo-tiledY: SKIP (0.000s)
[113.815293] [013/133] (906s left) kms_flip (flip-vs-absolute-wf_vblank-interruptible)
[113.907067] Starting subtest: flip-vs-absolute-wf_vblank-interruptible
[113.909246] Starting dynamic subtest: A-eDP1
[122.790359] Dynamic subtest A-eDP1: SUCCESS (8.881s)
[122.800463] Starting dynamic subtest: B-eDP1
[131.718674] Dynamic subtest B-eDP1: SUCCESS (8.925s)
[131.727475] Starting dynamic subtest: C-eDP1
[140.638167] Dynamic subtest C-eDP1: SUCCESS (8.917s)
[140.647642] Starting dynamic subtest: D-eDP1
[149.565450] Dynamic subtest D-eDP1: SUCCESS (8.926s)
[149.567916] Subtest flip-vs-absolute-wf_vblank-interruptible: SUCCESS (35.657s)
[150.812918] [014/133] (869s left) kms_atomic_transition (plane-all-transition-nonblocking)
[150.914697] Starting subtest: plane-all-transition-nonblocking
[150.917115] Starting dynamic subtest: pipe-A-eDP-1
[153.427334] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.515s)
[153.736597] Starting dynamic subtest: pipe-B-eDP-1
[156.941558] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.214s)
[157.241977] Subtest plane-all-transition-nonblocking: SUCCESS (6.328s)
[158.059518] [015/133] (862s left) gem_softpin (allocator-fork)
[158.128173] Starting subtest: allocator-fork
[160.335650] Subtest allocator-fork: SUCCESS (2.205s)
[160.447536] [016/133] (859s left) kms_big_fb (x-tiled-8bpp-rotate-180)
[160.548473] Starting subtest: x-tiled-8bpp-rotate-180
[161.761068] Subtest x-tiled-8bpp-rotate-180: SUCCESS (1.213s)
[161.881077] [017/133] (858s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-render)
[161.984794] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-render
[161.988189] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-render: SKIP (0.000s)
[162.085372] [018/133] (858s left) gem_create (create-clear)
[162.141126] Starting subtest: create-clear
[162.142820] Starting dynamic subtest: smem0
[195.071939] Dynamic subtest smem0: SUCCESS (32.927s)
[195.074074] Subtest create-clear: SUCCESS (32.927s)
[195.258256] [019/133] (825s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180)
[195.355959] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180
[195.360369] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180: SKIP (0.000s)
[195.450232] [020/133] (824s left) kms_chamelium_color (ctm-max)
[195.542165] Subtest ctm-max: SKIP (0.000s)
[195.586870] [021/133] (824s left) gem_render_copy (yf-tiled-ccs-to-linear)
[195.637902] Starting subtest: yf-tiled-ccs-to-linear
[195.642883] Subtest yf-tiled-ccs-to-linear: SKIP (0.000s)
[195.818852] [022/133] (824s left) kms_frontbuffer_tracking (fbc-shrfb-scaledprimary)
[195.911107] Starting subtest: fbc-shrfb-scaledprimary
[199.146146] Subtest fbc-shrfb-scaledprimary: SUCCESS (3.238s)
[200.279990] [023/133] (820s left) kms_big_fb (y-tiled-64bpp-rotate-180)
[200.385018] Starting subtest: y-tiled-64bpp-rotate-180
[200.389421] Subtest y-tiled-64bpp-rotate-180: SKIP (0.000s)
[200.480913] [024/133] (820s left) gem_userptr_blits (unsync-overlap)
[200.545978] Subtest unsync-overlap: SKIP (0.000s)
[200.665812] [025/133] (819s left) syncobj_timeline (invalid-signal-illegal-handle)
[200.717039] Starting subtest: invalid-signal-illegal-handle
[200.719339] Subtest invalid-signal-illegal-handle: SUCCESS (0.000s)
[200.799798] [026/133] (819s left) gem_exec_schedule (timeslicing)
[200.869197] Starting subtest: timeslicing
[200.871399] Starting dynamic subtest: rcs0
[200.881031] Dynamic subtest rcs0: SUCCESS (0.022s)
[200.889165] Starting dynamic subtest: bcs0
[200.901451] Dynamic subtest bcs0: SUCCESS (0.020s)
[200.908952] Starting dynamic subtest: vcs0
[200.922311] Dynamic subtest vcs0: SUCCESS (0.020s)
[200.930062] Starting dynamic subtest: vcs1
[200.942497] Dynamic subtest vcs1: SUCCESS (0.020s)
[200.949975] Starting dynamic subtest: vecs0
[200.964248] Dynamic subtest vecs0: SUCCESS (0.021s)
[200.971645] Starting dynamic subtest: ccs0
[200.984072] Dynamic subtest ccs0: SUCCESS (0.019s)
[200.986353] Subtest timeslicing: SUCCESS (0.125s)
[202.955251] [027/133] (817s left) kms_lease (lease-unleased-crtc)
[203.041041] Starting subtest: lease-unleased-crtc
[203.043417] Starting dynamic subtest: pipe-A-eDP-1
[203.332676] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.289s)
[203.340412] Starting dynamic subtest: pipe-B-eDP-1
[204.126497] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.794s)
[204.135790] Starting dynamic subtest: pipe-C-eDP-1
[204.138122] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.004s)
[204.145810] Starting dynamic subtest: pipe-D-eDP-1
[204.148117] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.004s)
[204.150260] Subtest lease-unleased-crtc: SUCCESS (1.097s)
[204.507382] [028/133] (816s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-blt)
[204.622713] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-blt
[211.412502] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-blt: SUCCESS (6.791s)
[211.557539] [029/133] (809s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-mmap-cpu)
[211.664231] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-mmap-cpu
[211.668195] Subtest fbc-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[211.766426] [030/133] (809s left) kms_cursor_crc (cursor-offscreen-64x21)
[211.942651] Starting subtest: cursor-offscreen-64x21
[211.994358] Subtest cursor-offscreen-64x21: SKIP (0.046s)
[212.221596] [031/133] (808s left) kms_vrr (negative-basic)
[212.301252] Starting subtest: negative-basic
[212.307380] Starting dynamic subtest: pipe-A-eDP-1
[217.721680] Dynamic subtest pipe-A-eDP-1: SUCCESS (5.413s)
[218.014047] Subtest negative-basic: SUCCESS (5.712s)
[218.850892] [032/133] (802s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-180)
[218.956015] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-180
[218.960370] Subtest y-tiled-max-hw-stride-32bpp-rotate-180: SKIP (0.000s)
[219.043137] [033/133] (801s left) gem_wait (write-wait)
[219.112055] Starting subtest: write-wait
[219.114376] Starting dynamic subtest: all-engines
[220.273939] Dynamic subtest all-engines: SUCCESS (1.161s)
[220.293272] Starting dynamic subtest: rcs0
[221.331207] Dynamic subtest rcs0: SUCCESS (1.055s)
[221.347766] Starting dynamic subtest: bcs0
[222.389595] Dynamic subtest bcs0: SUCCESS (1.056s)
[222.405900] Starting dynamic subtest: vcs0
[223.444646] Dynamic subtest vcs0: SUCCESS (1.053s)
[223.460062] Starting dynamic subtest: vcs1
[224.498223] Dynamic subtest vcs1: SUCCESS (1.051s)
[224.513622] Starting dynamic subtest: vecs0
[225.551454] Dynamic subtest vecs0: SUCCESS (1.051s)
[225.566883] Starting dynamic subtest: ccs0
[226.609752] Dynamic subtest ccs0: SUCCESS (1.056s)
[226.612505] Subtest write-wait: SUCCESS (7.498s)
[226.832823] [FACT gem_wait (write-wait)] new: kernel.kmod_is_loaded.vgem: true
[226.836470] [034/133] (794s left) gem_exec_fence (basic-busy)
[227.012521] Starting subtest: basic-busy
[227.014917] Starting dynamic subtest: rcs0
[227.094233] Dynamic subtest rcs0: SUCCESS (0.082s)
[227.104807] Starting dynamic subtest: bcs0
[227.156816] Dynamic subtest bcs0: SUCCESS (0.061s)
[227.167076] Starting dynamic subtest: vcs0
[227.222666] Dynamic subtest vcs0: SUCCESS (0.063s)
[227.233055] Starting dynamic subtest: vcs1
[227.289185] Dynamic subtest vcs1: SUCCESS (0.065s)
[227.299141] Starting dynamic subtest: vecs0
[227.353069] Dynamic subtest vecs0: SUCCESS (0.062s)
[227.363154] Starting dynamic subtest: ccs0
[227.408835] Dynamic subtest ccs0: SUCCESS (0.054s)
[227.411797] Subtest basic-busy: SUCCESS (0.398s)
[228.961469] [035/133] (792s left) gem_tiled_wc
[229.087283] [036/133] (791s left) kms_plane (pixel-format-y-tiled-gen12-rc-ccs-cc-modifier-source-clamping)
[229.188834] Starting subtest: pixel-format-y-tiled-gen12-rc-ccs-cc-modifier-source-clamping
[229.194591] Subtest pixel-format-y-tiled-gen12-rc-ccs-cc-modifier-source-clamping: SKIP (0.000s)
[229.261020] [037/133] (791s left) gem_exec_fence (submit)
[229.427817] Starting subtest: submit
[229.432462] Subtest submit: SKIP (0.000s)
[231.004405] [038/133] (790s left) kms_ccs (crc-sprite-planes-basic-y-tiled-gen12-rc-ccs)
[231.097050] Starting subtest: crc-sprite-planes-basic-y-tiled-gen12-rc-ccs
[231.099212] Starting dynamic subtest: pipe-A-eDP-1
[231.156406] Dynamic subtest pipe-A-eDP-1: SKIP (0.002s)
[231.165516] Starting dynamic subtest: pipe-B-eDP-1
[231.221276] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[231.229970] Starting dynamic subtest: pipe-C-eDP-1
[231.286839] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[231.295339] Starting dynamic subtest: pipe-D-eDP-1
[231.352182] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[231.356556] Subtest crc-sprite-planes-basic-y-tiled-gen12-rc-ccs: SKIP (0.011s)
[233.412618] [039/133] (787s left) vgem_basic (bad-handle)
[233.464439] Starting subtest: bad-handle
[233.466790] Subtest bad-handle: SUCCESS (0.000s)
[233.520644] [040/133] (787s left) gem_exec_reloc (basic-cpu-wc-active)
[233.571868] Subtest basic-cpu-wc-active: SKIP (0.000s)
[233.642449] [041/133] (787s left) kms_chamelium_edid (hdmi-edid-stress-resolution-non-4k)
[234.012410] Subtest hdmi-edid-stress-resolution-non-4k: SKIP (0.000s)
[234.815085] [042/133] (786s left) gem_exec_reloc (basic-gtt-cpu-noreloc)
[234.887184] Subtest basic-gtt-cpu-noreloc: SKIP (0.000s)
[234.951458] [043/133] (786s left) gem_readwrite (new-obj)
[235.012873] Subtest new-obj: SKIP (0.000s)
[235.071325] [044/133] (786s left) gem_exec_reloc (basic-wc-cpu-active)
[235.133198] Subtest basic-wc-cpu-active: SKIP (0.000s)
[235.203797] [045/133] (786s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-shrfb-plflip-blt)
[235.296899] Starting subtest: fbcpsr-1p-primscrn-shrfb-plflip-blt
[242.915385] Subtest fbcpsr-1p-primscrn-shrfb-plflip-blt: SUCCESS (7.621s)
[243.059410] [046/133] (778s left) gem_pxp (fail-invalid-protected-context)
[243.180584] Starting subtest: fail-invalid-protected-context
[243.183265] Subtest fail-invalid-protected-context: SUCCESS (0.000s)
[243.283606] [047/133] (778s left) kms_psr (fbc-psr-primary-page-flip)
[243.386621] Starting subtest: fbc-psr-primary-page-flip
[243.388828] Starting dynamic subtest: eDP-1
[243.393162] Dynamic subtest eDP-1: SKIP (0.000s)
[243.397511] Subtest fbc-psr-primary-page-flip: SKIP (0.001s)
[243.455763] [048/133] (778s left) kms_cursor_legacy (short-flip-before-cursor-atomic-transitions)
[243.580500] Starting subtest: short-flip-before-cursor-atomic-transitions
[244.549076] Subtest short-flip-before-cursor-atomic-transitions: SUCCESS (0.966s)
[245.388305] [049/133] (776s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip)
[245.495367] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip
[246.119604] Subtest x-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SUCCESS (0.626s)
[246.270141] [050/133] (775s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-mmap-wc)
[246.355664] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-mmap-wc
[246.360165] Subtest psr-2p-scndscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[246.444120] [051/133] (775s left) gem_exec_schedule (noreorder-priority)
[246.627901] Starting subtest: noreorder-priority
[246.630469] Starting dynamic subtest: rcs0
[247.757928] Dynamic subtest rcs0: SUCCESS (1.131s)
[247.769598] Starting dynamic subtest: vcs0
[248.918814] Dynamic subtest vcs0: SUCCESS (1.159s)
[248.929657] Starting dynamic subtest: vcs1
[250.900432] Dynamic subtest vcs1: SUCCESS (1.978s)
[250.910256] Starting dynamic subtest: vecs0
[252.878219] Dynamic subtest vecs0: SUCCESS (1.975s)
[252.888964] Starting dynamic subtest: ccs0
[254.016870] Dynamic subtest ccs0: SUCCESS (1.137s)
[254.019728] Subtest noreorder-priority: SUCCESS (7.391s)
[254.208017] [052/133] (767s left) gem_lmem_swapping (verify-ccs)
[254.260570] Subtest verify-ccs: SKIP (0.000s)
[254.306621] [053/133] (767s left) gem_ctx_isolation (dirty-create)
[254.374091] Starting subtest: dirty-create
[254.375991] Starting dynamic subtest: rcs0
[254.614163] Dynamic subtest rcs0: SUCCESS (0.242s)
[254.622470] Starting dynamic subtest: bcs0
[254.873373] Dynamic subtest bcs0: SUCCESS (0.258s)
[254.883203] Starting dynamic subtest: vcs0
[255.101829] Dynamic subtest vcs0: SUCCESS (0.227s)
[255.111795] Starting dynamic subtest: vcs1
[257.131495] Dynamic subtest vcs1: SUCCESS (2.028s)
[257.141227] Starting dynamic subtest: vecs0
[259.116780] Dynamic subtest vecs0: SUCCESS (1.984s)
[259.124843] Starting dynamic subtest: ccs0
[261.136861] Dynamic subtest ccs0: SUCCESS (2.019s)
[261.139221] Subtest dirty-create: SUCCESS (6.766s)
[261.373670] [054/133] (760s left) kms_psr2_sf (fbc-pr-plane-move-sf-dmg-area)
[261.475987] Starting subtest: fbc-pr-plane-move-sf-dmg-area
[261.480402] Subtest fbc-pr-plane-move-sf-dmg-area: SKIP (0.000s)
[261.541692] [055/133] (760s left) dmabuf (all-tests)
[261.589941] Starting subtest: all-tests
[261.592180] Starting dynamic subtest: sanitycheck
[261.687948] Dynamic subtest sanitycheck: SUCCESS (0.102s)
[261.700097] Starting dynamic subtest: dma_fence
[261.880904] Dynamic subtest dma_fence: SUCCESS (0.190s)
[261.892455] Starting dynamic subtest: dma_fence_chain
[271.386437] Dynamic subtest dma_fence_chain: SUCCESS (9.502s)
[271.395798] Starting dynamic subtest: dma_fence_unwrap
[271.471393] Dynamic subtest dma_fence_unwrap: SUCCESS (0.084s)
[271.482276] Starting dynamic subtest: dma_resv
[271.567572] Dynamic subtest dma_resv: SUCCESS (0.094s)
[271.570154] Subtest all-tests: SUCCESS (9.982s)
[271.630578] [056/133] (750s left) syncobj_timeline (reset-unsignaled)
[271.693362] Starting subtest: reset-unsignaled
[271.695678] Subtest reset-unsignaled: SUCCESS (0.000s)
[271.791857] [057/133] (750s left) syncobj_wait (multi-wait-signaled)
[271.847212] Starting subtest: multi-wait-signaled
[271.849582] Subtest multi-wait-signaled: SUCCESS (0.000s)
[271.949484] [058/133] (749s left) kms_flip (2x-flip-vs-absolute-wf_vblank)
[272.050831] Starting subtest: 2x-flip-vs-absolute-wf_vblank
[272.060499] Subtest 2x-flip-vs-absolute-wf_vblank: SKIP (0.011s)
[272.139466] [059/133] (749s left) kms_psr (pr-cursor-mmap-cpu)
[272.225220] Starting subtest: pr-cursor-mmap-cpu
[272.229526] Subtest pr-cursor-mmap-cpu: SKIP (0.000s)
[272.299450] [060/133] (749s left) syncobj_wait (multi-wait-all-for-submit-unsubmitted-signaled)
[272.359579] Starting subtest: multi-wait-all-for-submit-unsubmitted-signaled
[272.464511] Subtest multi-wait-all-for-submit-unsubmitted-signaled: SUCCESS (0.105s)
[272.541195] [061/133] (749s left) kms_atomic_transition (modeset-transition-fencing)
[272.626055] Starting subtest: modeset-transition-fencing
[272.628216] Starting dynamic subtest: 1x-outputs
[283.432634] Dynamic subtest 1x-outputs: SUCCESS (10.806s)
[283.435074] Subtest modeset-transition-fencing: SUCCESS (10.808s)
[284.280533] [062/133] (737s left) kms_psr (fbc-psr2-cursor-plane-onoff)
[284.382152] Starting subtest: fbc-psr2-cursor-plane-onoff
[284.384469] Starting dynamic subtest: eDP-1
[284.388840] Dynamic subtest eDP-1: SKIP (0.000s)
[284.393258] Subtest fbc-psr2-cursor-plane-onoff: SKIP (0.001s)
[284.453566] [063/133] (737s left) i915_hangman (error-state-basic)
[284.509554] Starting subtest: error-state-basic
[284.649409] Subtest error-state-basic: SUCCESS (0.140s)
[284.734574] [064/133] (737s left) gem_tiled_fence_blits (basic)
[284.788628] Subtest basic: SKIP (0.000s)
[284.879122] [065/133] (737s left) kms_frontbuffer_tracking (fbc-rgb565-draw-mmap-cpu)
[284.974287] Starting subtest: fbc-rgb565-draw-mmap-cpu
[289.007880] Subtest fbc-rgb565-draw-mmap-cpu: SUCCESS (4.036s)
[290.181118] [066/133] (732s left) gem_gpgpu_fill (offset-16x16)
[290.235088] Starting subtest: offset-16x16
[290.242114] Subtest offset-16x16: SUCCESS (0.009s)
[290.383538] [067/133] (731s left) perf_pmu (all-busy-check-all)
[290.423414] Starting subtest: all-busy-check-all
[291.925269] Subtest all-busy-check-all: SUCCESS (1.503s)
[292.040363] [068/133] (730s left) gen9_exec_parse (unaligned-jump)
[292.093594] Subtest unaligned-jump: SKIP (0.000s)
[292.161350] [069/133] (730s left) i915_pm_rpm (system-suspend-execbuf)
[294.088922] Starting subtest: system-suspend-execbuf
[353.052258] Subtest system-suspend-execbuf: SUCCESS (43.748s)
[353.442335] [070/133] (668s left) kms_frontbuffer_tracking (fbc-farfromfence-mmap-gtt)
[353.544455] Starting subtest: fbc-farfromfence-mmap-gtt
[353.548478] Subtest fbc-farfromfence-mmap-gtt: SKIP (0.000s)
[353.643507] [071/133] (668s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-render)
[353.751481] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-render
[353.755736] Subtest psr-2p-primscrn-pri-shrfb-draw-render: SKIP (0.000s)
[353.847549] [072/133] (668s left) kms_psr (psr2-sprite-render)
[353.934224] Starting subtest: psr2-sprite-render
[353.936514] Starting dynamic subtest: eDP-1
[355.624244] Dynamic subtest eDP-1: SUCCESS (1.688s)
[355.626115] Subtest psr2-sprite-render: SUCCESS (1.689s)
[356.484510] [073/133] (666s left) kms_ccs (bad-pixel-format-4-tiled-mtl-rc-ccs)
[356.576034] Starting subtest: bad-pixel-format-4-tiled-mtl-rc-ccs
[356.578323] Starting dynamic subtest: pipe-A-eDP-1
[356.599082] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[356.609656] Starting dynamic subtest: pipe-B-eDP-1
[356.629890] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[356.638819] Starting dynamic subtest: pipe-C-eDP-1
[356.658293] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[356.668696] Starting dynamic subtest: pipe-D-eDP-1
[356.687741] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[356.690123] Subtest bad-pixel-format-4-tiled-mtl-rc-ccs: SUCCESS (0.006s)
[358.836920] [074/133] (663s left) perf_pmu (idle-no-semaphores)
[358.884456] Starting subtest: idle-no-semaphores
[358.886727] Starting dynamic subtest: rcs0
[359.428545] Dynamic subtest rcs0: SUCCESS (0.544s)
[359.441031] Starting dynamic subtest: bcs0
[359.952493] Dynamic subtest bcs0: SUCCESS (0.520s)
[359.965143] Starting dynamic subtest: vcs0
[360.468087] Dynamic subtest vcs0: SUCCESS (0.513s)
[360.480009] Starting dynamic subtest: vcs1
[360.982882] Dynamic subtest vcs1: SUCCESS (0.512s)
[360.994251] Starting dynamic subtest: vecs0
[361.497840] Dynamic subtest vecs0: SUCCESS (0.511s)
[361.510095] Starting dynamic subtest: ccs0
[362.022136] Dynamic subtest ccs0: SUCCESS (0.521s)
[362.025200] Subtest idle-no-semaphores: SUCCESS (3.139s)
[362.120899] [075/133] (660s left) gem_exec_fence (syncobj-timeline-signal)
[362.683657] Starting subtest: syncobj-timeline-signal
[362.698055] Subtest syncobj-timeline-signal: SUCCESS (0.016s)
[363.869149] [076/133] (658s left) kms_plane_multiple (tiling-yf)
[363.973772] Starting subtest: tiling-yf
[363.977996] Subtest tiling-yf: SKIP (0.000s)
[364.060118] [077/133] (658s left) kms_plane_scaling (plane-upscale-factor-0-25-with-pixel-format)
[364.157997] Starting subtest: plane-upscale-factor-0-25-with-pixel-format
[364.160277] Starting dynamic subtest: pipe-A
[365.206060] Dynamic subtest pipe-A: SUCCESS (1.050s)
[365.215319] Starting dynamic subtest: pipe-B
[367.341129] Dynamic subtest pipe-B: SUCCESS (2.133s)
[367.351088] Starting dynamic subtest: pipe-C
[368.575916] Dynamic subtest pipe-C: SUCCESS (1.232s)
[368.585696] Starting dynamic subtest: pipe-D
[369.800995] Dynamic subtest pipe-D: SUCCESS (1.224s)
[369.803380] Subtest plane-upscale-factor-0-25-with-pixel-format: SUCCESS (5.644s)
[371.012546] [078/133] (651s left) kms_flip (flip-vs-expired-vblank)
[371.118103] Starting subtest: flip-vs-expired-vblank
[371.120275] Starting dynamic subtest: A-eDP1
[379.801310] Dynamic subtest A-eDP1: SUCCESS (8.680s)
[379.811889] Starting dynamic subtest: B-eDP1
[388.448076] Dynamic subtest B-eDP1: SUCCESS (8.642s)
[388.465654] Starting dynamic subtest: C-eDP1
[397.083624] Dynamic subtest C-eDP1: SUCCESS (8.629s)
[397.093107] Starting dynamic subtest: D-eDP1
[405.719208] Dynamic subtest D-eDP1: SUCCESS (8.630s)
[405.724445] Subtest flip-vs-expired-vblank: SUCCESS (34.592s)
[406.885339] [079/133] (615s left) syncobj_timeline (single-wait-for-submit-available-signaled)
[406.955634] Starting subtest: single-wait-for-submit-available-signaled
[406.958059] Subtest single-wait-for-submit-available-signaled: SUCCESS (0.000s)
[407.073941] [080/133] (615s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip)
[407.181318] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip
[407.982504] Subtest 4-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip: SUCCESS (0.803s)
[408.143864] [081/133] (614s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-pwrite)
[408.245222] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-pwrite
[417.519839] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-pwrite: SUCCESS (9.280s)
[417.643398] [082/133] (605s left) kms_ccs (ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc)
[417.740095] Starting subtest: ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc
[417.742444] Starting dynamic subtest: pipe-A-eDP-1
[417.763985] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[417.774966] Starting dynamic subtest: pipe-B-eDP-1
[417.794080] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[417.802966] Starting dynamic subtest: pipe-C-eDP-1
[417.822192] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[417.831182] Starting dynamic subtest: pipe-D-eDP-1
[417.850187] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[417.852080] Subtest ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.008s)
[420.023165] [083/133] (602s left) kms_frontbuffer_tracking (fbc-2p-pri-indfb-multidraw)
[420.124225] Starting subtest: fbc-2p-pri-indfb-multidraw
[420.128285] Subtest fbc-2p-pri-indfb-multidraw: SKIP (0.000s)
[420.224858] [084/133] (602s left) gem_render_tiled_blits (basic)
[420.284702] Subtest basic: SKIP (0.000s)
[420.374528] [085/133] (602s left) kms_ccs (crc-primary-rotation-180-y-tiled-gen12-rc-ccs-cc)
[420.464228] Starting subtest: crc-primary-rotation-180-y-tiled-gen12-rc-ccs-cc
[420.466511] Starting dynamic subtest: pipe-A-eDP-1
[420.489091] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[420.500360] Starting dynamic subtest: pipe-B-eDP-1
[420.521387] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[420.530994] Starting dynamic subtest: pipe-C-eDP-1
[420.552331] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[420.562013] Starting dynamic subtest: pipe-D-eDP-1
[420.583995] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[420.588003] Subtest crc-primary-rotation-180-y-tiled-gen12-rc-ccs-cc: SKIP (0.006s)
[422.802639] [086/133] (600s left) kms_vblank (ts-continuation-dpms-rpm)
[422.905191] Starting subtest: ts-continuation-dpms-rpm
[422.907397] Starting dynamic subtest: pipe-A-eDP-1
[425.398978] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.495s)
[425.414120] Starting dynamic subtest: pipe-D-eDP-1
[427.665722] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.262s)
[427.667731] Subtest ts-continuation-dpms-rpm: SUCCESS (4.761s)
[428.546513] [087/133] (594s left) gem_exec_whisper (basic-fds-priority)
[428.608465] Starting subtest: basic-fds-priority
[452.886224] Subtest basic-fds-priority: SUCCESS (24.274s)
[453.069994] [088/133] (570s left) kms_pm_rpm (legacy-planes-dpms)
[455.004026] Starting subtest: legacy-planes-dpms
[455.006410] Starting dynamic subtest: plane-64
[463.302524] Dynamic subtest plane-64: SUCCESS (8.299s)
[463.315300] Starting dynamic subtest: plane-94
[471.637982] Dynamic subtest plane-94: SUCCESS (8.331s)
[471.651783] Starting dynamic subtest: plane-124
[480.320857] Dynamic subtest plane-124: SUCCESS (8.678s)
[480.333059] Starting dynamic subtest: plane-134
[488.754262] Dynamic subtest plane-134: SUCCESS (8.429s)
[488.756658] Subtest legacy-planes-dpms: SUCCESS (33.747s)
[489.137843] [089/133] (534s left) intel_hwmon (hwmon-write)
[489.188521] Subtest hwmon-write: SKIP (0.000s)
[489.254174] [090/133] (533s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-pwrite)
[489.354470] Starting subtest: fbcpsr-rgb101010-draw-pwrite
[496.360928] Subtest fbcpsr-rgb101010-draw-pwrite: SUCCESS (7.009s)
[496.461679] [091/133] (526s left) syncobj_basic (bad-pad-fd-to-handle)
[496.524209] Starting subtest: bad-pad-fd-to-handle
[496.526263] Subtest bad-pad-fd-to-handle: SUCCESS (0.000s)
[496.629577] [092/133] (526s left) gen9_exec_parse (bb-chained)
[496.686899] Subtest bb-chained: SKIP (0.000s)
[496.754035] [093/133] (526s left) kms_frontbuffer_tracking (psr-1p-primscrn-shrfb-msflip-blt)
[496.864707] Starting subtest: psr-1p-primscrn-shrfb-msflip-blt
[504.248954] Subtest psr-1p-primscrn-shrfb-msflip-blt: SUCCESS (7.385s)
[504.401652] [094/133] (518s left) gem_exec_params (rel-constants-invalid-ring)
[504.454507] Starting subtest: rel-constants-invalid-ring
[504.456865] Subtest rel-constants-invalid-ring: SUCCESS (0.000s)
[504.568710] [095/133] (518s left) gem_workarounds (suspend-resume-fd)
[504.630297] Starting subtest: suspend-resume-fd
[520.287343] Subtest suspend-resume-fd: SUCCESS (1.246s)
[520.453178] [096/133] (503s left) kms_color (ctm-signed)
[520.572093] Starting subtest: ctm-signed
[520.573992] Starting dynamic subtest: pipe-A-eDP-1
[522.630682] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.060s)
[522.641551] Starting dynamic subtest: pipe-B-eDP-1
[525.455356] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.762s)
[525.466897] Starting dynamic subtest: pipe-C-eDP-1
[528.128285] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.609s)
[528.138978] Starting dynamic subtest: pipe-D-eDP-1
[530.844370] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.667s)
[530.846782] Subtest ctm-signed: SUCCESS (10.101s)
[531.672755] [097/133] (491s left) kms_cursor_crc (cursor-random-256x256)
[531.927956] Starting subtest: cursor-random-256x256
[531.933039] Starting dynamic subtest: pipe-A-eDP-1
[535.387985] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.419s)
[535.416777] Starting dynamic subtest: pipe-D-eDP-1
[539.460472] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.025s)
[539.462871] Subtest cursor-random-256x256: SUCCESS (7.469s)
[540.302971] [098/133] (483s left) gem_mmap_gtt (ptrace)
[540.358686] Subtest ptrace: SKIP (0.000s)
[540.422156] [099/133] (483s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-mmap-cpu)
[540.517120] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-mmap-cpu
[544.119463] Subtest fbc-1p-primscrn-cur-indfb-draw-mmap-cpu: SUCCESS (3.593s)
[545.332854] [100/133] (478s left) gem_exec_balancer (parallel-balancer)
[545.596613] Starting subtest: parallel-balancer
[546.509320] Subtest parallel-balancer: SUCCESS (0.911s)
[546.635453] [101/133] (477s left) syncobj_timeline (etime-single-wait-all-submitted)
[546.687949] Starting subtest: etime-single-wait-all-submitted
[546.791936] Subtest etime-single-wait-all-submitted: SUCCESS (0.103s)
[546.883609] [102/133] (476s left) api_intel_bb (crc32)
[546.939910] Starting subtest: crc32
[546.941776] Starting dynamic subtest: rcs0-smem0
[547.243724] Dynamic subtest rcs0-smem0: SUCCESS (0.303s)
[547.256261] Starting dynamic subtest: bcs0-smem0
[547.578172] Dynamic subtest bcs0-smem0: SUCCESS (0.330s)
[547.591432] Starting dynamic subtest: vcs0-smem0
[547.919624] Dynamic subtest vcs0-smem0: SUCCESS (0.337s)
[547.931479] Starting dynamic subtest: vcs1-smem0
[548.295651] Dynamic subtest vcs1-smem0: SUCCESS (0.373s)
[548.307630] Starting dynamic subtest: vecs0-smem0
[548.638400] Dynamic subtest vecs0-smem0: SUCCESS (0.340s)
[548.651156] Starting dynamic subtest: ccs0-smem0
[549.005428] Dynamic subtest ccs0-smem0: SUCCESS (0.364s)
[549.007926] Subtest crc32: SUCCESS (2.064s)
[549.124523] [103/133] (474s left) kms_frontbuffer_tracking (psr-rgb565-draw-mmap-gtt)
[549.229481] Starting subtest: psr-rgb565-draw-mmap-gtt
[549.233521] Subtest psr-rgb565-draw-mmap-gtt: SKIP (0.000s)
[549.337418] [104/133] (474s left) syncobj_wait (multi-wait-all-for-submit-unsubmitted-submitted)
[549.402491] Starting subtest: multi-wait-all-for-submit-unsubmitted-submitted
[549.502378] Subtest multi-wait-all-for-submit-unsubmitted-submitted: SUCCESS (0.101s)
[549.593458] [105/133] (474s left) gem_exec_reloc (basic-cpu-wc)
[549.660164] Subtest basic-cpu-wc: SKIP (0.000s)
[549.727935] [106/133] (474s left) api_intel_bb (purge-bb)
[549.787805] Starting subtest: purge-bb
[549.789998] Subtest purge-bb: SUCCESS (0.004s)
[549.903116] [107/133] (474s left) kms_plane_scaling (plane-scaler-with-clipping-clamping-modifiers)
[549.986794] Starting subtest: plane-scaler-with-clipping-clamping-modifiers
[549.988995] Starting dynamic subtest: pipe-A
[550.336239] Dynamic subtest pipe-A: SUCCESS (0.351s)
[550.353320] Starting dynamic subtest: pipe-B
[551.777198] Dynamic subtest pipe-B: SUCCESS (1.436s)
[551.788769] Starting dynamic subtest: pipe-C
[553.175137] Dynamic subtest pipe-C: SUCCESS (1.395s)
[553.187104] Starting dynamic subtest: pipe-D
[554.622320] Dynamic subtest pipe-D: SUCCESS (1.445s)
[554.624557] Subtest plane-scaler-with-clipping-clamping-modifiers: SUCCESS (4.632s)
[555.823221] [108/133] (468s left) gem_mmap_gtt (basic-write-read-distinct)
[555.888500] Subtest basic-write-read-distinct: SKIP (0.000s)
[555.953246] [109/133] (468s left) kms_feature_discovery (psr1)
[556.050822] Starting subtest: psr1
[556.053110] Subtest psr1: SUCCESS (0.000s)
[556.125290] [110/133] (468s left) kms_cursor_crc (cursor-tearing-position-change)
[556.233967] Starting subtest: cursor-tearing-position-change
[556.236236] Starting dynamic subtest: pipe-A-eDP-1
[556.798224] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.562s)
[556.809030] Starting dynamic subtest: pipe-D-eDP-1
[558.024783] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.220s)
[558.026630] Subtest cursor-tearing-position-change: SUCCESS (1.786s)
[558.862502] [111/133] (465s left) kms_frontbuffer_tracking (fbc-2p-primscrn-indfb-msflip-blt)
[558.964338] Starting subtest: fbc-2p-primscrn-indfb-msflip-blt
[558.968847] Subtest fbc-2p-primscrn-indfb-msflip-blt: SKIP (0.000s)
[559.081258] [112/133] (465s left) kms_flip_scaled_crc (flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling)
[559.181182] Starting subtest: flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling
[559.185239] Subtest flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling: SKIP (0.000s)
[559.251370] [113/133] (465s left) gem_bad_reloc (negative-reloc)
[559.317017] Subtest negative-reloc: SKIP (0.000s)
[559.409491] [114/133] (464s left) kms_rotation_crc (primary-yf-tiled-reflect-x-180)
[559.524179] Starting subtest: primary-yf-tiled-reflect-x-180
[559.597373] Subtest primary-yf-tiled-reflect-x-180: SKIP (0.073s)
[559.726950] [115/133] (464s left) drm_read (empty-block)
[559.897546] Starting subtest: empty-block
[560.898218] Subtest empty-block: SUCCESS (1.000s)
[561.045629] [116/133] (463s left) gem_render_copy (yf-tiled-to-vebox-linear)
[561.101620] Starting subtest: yf-tiled-to-vebox-linear
[561.106042] Subtest yf-tiled-to-vebox-linear: SKIP (0.000s)
[561.289109] [117/133] (463s left) kms_pm_rpm (dpms-lpsp)
[563.434726] Starting subtest: dpms-lpsp
[563.748647] Subtest dpms-lpsp: SUCCESS (0.317s)
[563.841686] [118/133] (460s left) kms_cursor_legacy (forked-move)
[563.969304] Starting subtest: forked-move
[563.971494] Starting dynamic subtest: pipe-A
[569.427643] Dynamic subtest pipe-A: SUCCESS (5.455s)
[569.448178] Starting dynamic subtest: pipe-B
[574.911548] Dynamic subtest pipe-B: SUCCESS (5.479s)
[574.923867] Starting dynamic subtest: pipe-C
[580.389645] Dynamic subtest pipe-C: SUCCESS (5.474s)
[580.401969] Starting dynamic subtest: pipe-D
[585.862411] Dynamic subtest pipe-D: SUCCESS (5.468s)
[585.874178] Starting dynamic subtest: all-pipes
[591.368639] Dynamic subtest all-pipes: SUCCESS (5.501s)
[591.371177] Subtest forked-move: SUCCESS (27.390s)
[591.511583] [119/133] (433s left) kms_psr_stress_test (flip-primary-invalidate-overlay)
[591.617124] Starting subtest: flip-primary-invalidate-overlay
[603.239044] Subtest flip-primary-invalidate-overlay: SUCCESS (11.619s)
[603.386812] [120/133] (421s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-gtt)
[603.488514] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-gtt
[603.492157] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[603.578483] [121/133] (421s left) kms_content_protection (srm)
[603.714725] Starting subtest: srm
[603.720843] Subtest srm: SKIP (0.002s)
[603.846104] [122/133] (420s left) prime_busy (after-wait)
[603.896971] Starting subtest: after-wait
[603.901400] Starting dynamic subtest: rcs0
[603.927293] Dynamic subtest rcs0: SUCCESS (0.027s)
[603.938025] Starting dynamic subtest: bcs0
[603.975196] Dynamic subtest bcs0: SUCCESS (0.047s)
[603.986155] Starting dynamic subtest: vcs0
[604.014847] Dynamic subtest vcs0: SUCCESS (0.039s)
[604.024217] Starting dynamic subtest: vcs1
[604.056321] Dynamic subtest vcs1: SUCCESS (0.041s)
[604.065767] Starting dynamic subtest: vecs0
[604.097000] Dynamic subtest vecs0: SUCCESS (0.040s)
[604.106694] Starting dynamic subtest: ccs0
[604.138306] Dynamic subtest ccs0: SUCCESS (0.041s)
[604.246402] Subtest after-wait: SUCCESS (0.347s)
[604.336293] [123/133] (420s left) kms_pipe_crc_basic (disable-crc-after-crtc)
[604.442254] Starting subtest: disable-crc-after-crtc
[604.444472] Starting dynamic subtest: pipe-A-eDP-1
[606.085296] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.641s)
[606.095969] Starting dynamic subtest: pipe-B-eDP-1
[608.456967] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.371s)
[608.466892] Starting dynamic subtest: pipe-C-eDP-1
[610.718070] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.257s)
[610.729087] Starting dynamic subtest: pipe-D-eDP-1
[612.971490] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.253s)
[612.973766] Subtest disable-crc-after-crtc: SUCCESS (8.528s)
[613.801653] [124/133] (410s left) kms_psr2_sf (psr2-overlay-primary-update-sf-dmg-area)
[613.893229] Starting subtest: psr2-overlay-primary-update-sf-dmg-area
[613.895493] Starting dynamic subtest: pipe-A-eDP-1
[619.779820] Dynamic subtest pipe-A-eDP-1: SUCCESS (5.885s)
[619.790119] Starting dynamic subtest: pipe-B-eDP-1
[626.434626] Dynamic subtest pipe-B-eDP-1: SUCCESS (6.656s)
[626.436892] Subtest psr2-overlay-primary-update-sf-dmg-area: SUCCESS (12.545s)
[627.313284] [125/133] (397s left) kms_universal_plane (universal-plane-sanity)
[627.420475] Starting subtest: universal-plane-sanity
[627.422396] Starting dynamic subtest: pipe-A-eDP-1
[628.026214] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.605s)
[628.037729] Starting dynamic subtest: pipe-B-eDP-1
[629.235639] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.207s)
[629.246148] Starting dynamic subtest: pipe-C-eDP-1
[630.448463] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.212s)
[630.459144] Starting dynamic subtest: pipe-D-eDP-1
[631.678435] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.228s)
[631.680326] Subtest universal-plane-sanity: SUCCESS (4.259s)
[632.545651] [126/133] (392s left) kms_invalid_mode (clock-too-high)
[632.651598] Starting subtest: clock-too-high
[632.654077] Starting dynamic subtest: pipe-A-eDP-1
[632.658756] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[632.671083] Starting dynamic subtest: pipe-B-eDP-1
[632.675413] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[632.685265] Starting dynamic subtest: pipe-C-eDP-1
[632.689239] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[632.700708] Starting dynamic subtest: pipe-D-eDP-1
[632.704899] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[632.708958] Subtest clock-too-high: SKIP (0.004s)
[632.762223] [127/133] (392s left) kms_psr2_sf (pr-cursor-plane-move-continuous-exceed-sf)
[632.863447] Starting subtest: pr-cursor-plane-move-continuous-exceed-sf
[632.867626] Subtest pr-cursor-plane-move-continuous-exceed-sf: SKIP (0.000s)
[632.942978] [128/133] (391s left) gem_eio (wait-immediate)
[633.181065] Starting subtest: wait-immediate
[633.549093] Subtest wait-immediate: SUCCESS (0.370s)
[633.678905] [129/133] (391s left) kms_frontbuffer_tracking (fbc-2p-primscrn-shrfb-pgflip-blt)
[633.775493] Starting subtest: fbc-2p-primscrn-shrfb-pgflip-blt
[633.779084] Subtest fbc-2p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[633.867494] [130/133] (391s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted)
[633.914117] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted
[634.014555] Subtest etime-multi-wait-all-for-submit-unsubmitted: SUCCESS (0.101s)
[634.093763] [131/133] (390s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-blt)
[634.210627] Starting subtest: psr-1p-primscrn-pri-indfb-draw-blt
[641.570088] Subtest psr-1p-primscrn-pri-indfb-draw-blt: SUCCESS (7.363s)
[641.722511] [132/133] (383s left) i915_suspend (basic-s2idle-without-i915)
[641.759608] Starting subtest: basic-s2idle-without-i915
[660.662715] Subtest basic-s2idle-without-i915: SUCCESS (4.019s)
[660.811988] [133/133] (364s left) kms_frontbuffer_tracking (fbc-rgb565-draw-blt)
[660.919892] Starting subtest: fbc-rgb565-draw-blt
[665.189768] Subtest fbc-rgb565-draw-blt: SUCCESS (4.157s)
[666.536070] Closing watchdogs
results: parsing output: 0/ for test: kms_cursor_legacy
results: parsing output: 1/ for test: kms_hdr
results: parsing output: 2/ for test: gem_sync
results: parsing output: 3/ for test: gem_ctx_persistence
results: parsing output: 4/ for test: gem_ctx_shared
results: parsing output: 5/ for test: kms_chamelium_hpd
results: parsing output: 6/ for test: kms_cursor_legacy
results: parsing output: 7/ for test: gem_pread
results: parsing output: 8/ for test: kms_big_fb
results: parsing output: 9/ for test: gen3_render_tiledy_blits
results: parsing output: 10/ for test: kms_flip_scaled_crc
results: parsing output: 11/ for test: gem_mmap_gtt
results: parsing output: 12/ for test: kms_flip
results: parsing output: 13/ for test: kms_atomic_transition
results: parsing output: 14/ for test: gem_softpin
results: parsing output: 15/ for test: kms_big_fb
results: parsing output: 16/ for test: kms_frontbuffer_tracking
results: parsing output: 17/ for test: gem_create
results: parsing output: 18/ for test: kms_big_fb
results: parsing output: 19/ for test: kms_chamelium_color
results: parsing output: 20/ for test: gem_render_copy
results: parsing output: 21/ for test: kms_frontbuffer_tracking
results: parsing output: 22/ for test: kms_big_fb
results: parsing output: 23/ for test: gem_userptr_blits
results: parsing output: 24/ for test: syncobj_timeline
results: parsing output: 25/ for test: gem_exec_schedule
results: parsing output: 26/ for test: kms_lease
results: parsing output: 27/ for test: kms_frontbuffer_tracking
results: parsing output: 28/ for test: kms_frontbuffer_tracking
results: parsing output: 29/ for test: kms_cursor_crc
results: parsing output: 30/ for test: kms_vrr
results: parsing output: 31/ for test: kms_big_fb
results: parsing output: 32/ for test: gem_wait
results: parsing output: 33/ for test: gem_exec_fence
results: parsing output: 34/ for test: gem_tiled_wc
results: parsing output: 35/ for test: kms_plane
results: parsing output: 36/ for test: gem_exec_fence
results: parsing output: 37/ for test: kms_ccs
results: parsing output: 38/ for test: vgem_basic
results: parsing output: 39/ for test: gem_exec_reloc
results: parsing output: 40/ for test: kms_chamelium_edid
results: parsing output: 41/ for test: gem_exec_reloc
results: parsing output: 42/ for test: gem_readwrite
results: parsing output: 43/ for test: gem_exec_reloc
results: parsing output: 44/ for test: kms_frontbuffer_tracking
results: parsing output: 45/ for test: gem_pxp
results: parsing output: 46/ for test: kms_psr
results: parsing output: 47/ for test: kms_cursor_legacy
results: parsing output: 48/ for test: kms_big_fb
results: parsing output: 49/ for test: kms_frontbuffer_tracking
results: parsing output: 50/ for test: gem_exec_schedule
results: parsing output: 51/ for test: gem_lmem_swapping
results: parsing output: 52/ for test: gem_ctx_isolation
results: parsing output: 53/ for test: kms_psr2_sf
results: parsing output: 54/ for test: dmabuf
results: parsing output: 55/ for test: syncobj_timeline
results: parsing output: 56/ for test: syncobj_wait
results: parsing output: 57/ for test: kms_flip
results: parsing output: 58/ for test: kms_psr
results: parsing output: 59/ for test: syncobj_wait
results: parsing output: 60/ for test: kms_atomic_transition
results: parsing output: 61/ for test: kms_psr
results: parsing output: 62/ for test: i915_hangman
results: parsing output: 63/ for test: gem_tiled_fence_blits
results: parsing output: 64/ for test: kms_frontbuffer_tracking
results: parsing output: 65/ for test: gem_gpgpu_fill
results: parsing output: 66/ for test: perf_pmu
results: parsing output: 67/ for test: gen9_exec_parse
results: parsing output: 68/ for test: i915_pm_rpm
results: parsing output: 69/ for test: kms_frontbuffer_tracking
results: parsing output: 70/ for test: kms_frontbuffer_tracking
results: parsing output: 71/ for test: kms_psr
results: parsing output: 72/ for test: kms_ccs
results: parsing output: 73/ for test: perf_pmu
results: parsing output: 74/ for test: gem_exec_fence
results: parsing output: 75/ for test: kms_plane_multiple
results: parsing output: 76/ for test: kms_plane_scaling
results: parsing output: 77/ for test: kms_flip
results: parsing output: 78/ for test: syncobj_timeline
results: parsing output: 79/ for test: kms_big_fb
results: parsing output: 80/ for test: kms_frontbuffer_tracking
results: parsing output: 81/ for test: kms_ccs
results: parsing output: 82/ for test: kms_frontbuffer_tracking
results: parsing output: 83/ for test: gem_render_tiled_blits
results: parsing output: 84/ for test: kms_ccs
results: parsing output: 85/ for test: kms_vblank
results: parsing output: 86/ for test: gem_exec_whisper
results: parsing output: 87/ for test: kms_pm_rpm
results: parsing output: 88/ for test: intel_hwmon
results: parsing output: 89/ for test: kms_frontbuffer_tracking
results: parsing output: 90/ for test: syncobj_basic
results: parsing output: 91/ for test: gen9_exec_parse
results: parsing output: 92/ for test: kms_frontbuffer_tracking
results: parsing output: 93/ for test: gem_exec_params
results: parsing output: 94/ for test: gem_workarounds
results: parsing output: 95/ for test: kms_color
results: parsing output: 96/ for test: kms_cursor_crc
results: parsing output: 97/ for test: gem_mmap_gtt
results: parsing output: 98/ for test: kms_frontbuffer_tracking
results: parsing output: 99/ for test: gem_exec_balancer
results: parsing output: 100/ for test: syncobj_timeline
results: parsing output: 101/ for test: api_intel_bb
results: parsing output: 102/ for test: kms_frontbuffer_tracking
results: parsing output: 103/ for test: syncobj_wait
results: parsing output: 104/ for test: gem_exec_reloc
results: parsing output: 105/ for test: api_intel_bb
results: parsing output: 106/ for test: kms_plane_scaling
results: parsing output: 107/ for test: gem_mmap_gtt
results: parsing output: 108/ for test: kms_feature_discovery
results: parsing output: 109/ for test: kms_cursor_crc
results: parsing output: 110/ for test: kms_frontbuffer_tracking
results: parsing output: 111/ for test: kms_flip_scaled_crc
results: parsing output: 112/ for test: gem_bad_reloc
results: parsing output: 113/ for test: kms_rotation_crc
results: parsing output: 114/ for test: drm_read
results: parsing output: 115/ for test: gem_render_copy
results: parsing output: 116/ for test: kms_pm_rpm
results: parsing output: 117/ for test: kms_cursor_legacy
results: parsing output: 118/ for test: kms_psr_stress_test
results: parsing output: 119/ for test: kms_frontbuffer_tracking
results: parsing output: 120/ for test: kms_content_protection
results: parsing output: 121/ for test: prime_busy
results: parsing output: 122/ for test: kms_pipe_crc_basic
results: parsing output: 123/ for test: kms_psr2_sf
results: parsing output: 124/ for test: kms_universal_plane
results: parsing output: 125/ for test: kms_invalid_mode
results: parsing output: 126/ for test: kms_psr2_sf
results: parsing output: 127/ for test: gem_eio
results: parsing output: 128/ for test: kms_frontbuffer_tracking
results: parsing output: 129/ for test: syncobj_timeline
results: parsing output: 130/ for test: kms_frontbuffer_tracking
results: parsing output: 131/ for test: i915_suspend
results: parsing output: 132/ for test: kms_frontbuffer_tracking
Done.