[58.847416] Initializing watchdogs
[58.847461]   /dev/watchdog0
[58.861752] [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.866709] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[58.869188] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[58.872613] [001/133] (960s left) kms_frontbuffer_tracking (fbcpsr-farfromfence-mmap-gtt)
[59.004780] Starting subtest: fbcpsr-farfromfence-mmap-gtt
[59.009131] Subtest fbcpsr-farfromfence-mmap-gtt: SKIP (0.000s)
[59.124810] [002/133] (960s left) syncobj_timeline (wait-for-submit-delayed-submit)
[59.179350] Starting subtest: wait-for-submit-delayed-submit
[59.282797] Subtest wait-for-submit-delayed-submit: SUCCESS (0.103s)
[59.373124] [003/133] (960s left) kms_chamelium_hpd (dp-hpd)
[59.753621] Subtest dp-hpd: SKIP (0.000s)
[60.570222] [004/133] (958s left) kms_cursor_edge_walk (256x256-top-bottom)
[60.667317] Starting subtest: 256x256-top-bottom
[60.669795] Starting dynamic subtest: pipe-A-eDP-1
[64.176963] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.499s)
[64.184876] Starting dynamic subtest: pipe-D-eDP-1
[67.306364] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.121s)
[67.308681] Subtest 256x256-top-bottom: SUCCESS (6.621s)
[68.119588] [005/133] (951s left) gem_mmap_offset (clear)
[68.169652] Starting subtest: clear
[68.172290] Starting dynamic subtest: smem0
[91.805809] Dynamic subtest smem0: SUCCESS (23.617s)
[91.807966] Subtest clear: SUCCESS (23.618s)
[91.978828] [006/133] (927s left) kms_joiner (basic-force-big-joiner)
[92.130780] Starting subtest: basic-force-big-joiner
[92.135228] Subtest basic-force-big-joiner: SKIP (0.000s)
[92.206172] [007/133] (927s left) gem_exec_balancer (waits)
[92.263686] Starting subtest: waits
[98.762859] Subtest waits: SUCCESS (6.496s)
[99.087452] [008/133] (920s left) gem_exec_whisper (basic-queues)
[99.170760] Starting subtest: basic-queues
[105.818127] Subtest basic-queues: SUCCESS (6.644s)
[106.008726] [009/133] (913s left) gem_exec_suspend (basic-s3)
[106.089996] Starting subtest: basic-S3
[106.092489] Starting dynamic subtest: smem
[125.994269] Dynamic subtest smem: SUCCESS (6.783s)
[125.997528] Subtest basic-S3: SUCCESS (6.785s)
[126.206416] [010/133] (893s left) kms_psr (psr2-sprite-render)
[126.337826] Starting subtest: psr2-sprite-render
[126.340342] Starting dynamic subtest: eDP-1
[128.083001] Dynamic subtest eDP-1: SUCCESS (1.703s)
[128.085376] Subtest psr2-sprite-render: SUCCESS (1.704s)
[128.976293] [011/133] (890s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-mmap-wc)
[129.099828] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-mmap-wc
[135.872503] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-mmap-wc: SUCCESS (6.688s)
[136.032456] [012/133] (883s left) kms_content_protection (atomic)
[136.175295] Starting subtest: atomic
[136.179951] Subtest atomic: SKIP (0.000s)
[136.339355] [013/133] (883s left) kms_async_flips (invalid-async-flip)
[136.432518] Starting subtest: invalid-async-flip
[136.807360] Starting dynamic subtest: pipe-A-eDP-1
[137.620635] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.808s)
[137.986152] Starting dynamic subtest: pipe-B-eDP-1
[138.778113] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.797s)
[139.138517] Starting dynamic subtest: pipe-C-eDP-1
[139.995812] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.863s)
[140.354997] Starting dynamic subtest: pipe-D-eDP-1
[141.141488] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.790s)
[141.143879] Subtest invalid-async-flip: SUCCESS (4.684s)
[142.304341] [014/133] (877s left) kms_flip (blocking-absolute-wf_vblank)
[142.406858] Starting subtest: blocking-absolute-wf_vblank
[142.409218] Starting dynamic subtest: A-eDP1
[151.166781] Dynamic subtest A-eDP1: SUCCESS (8.741s)
[151.177837] Starting dynamic subtest: B-eDP1
[159.897762] Dynamic subtest B-eDP1: SUCCESS (8.725s)
[159.913143] Starting dynamic subtest: C-eDP1
[168.618184] Dynamic subtest C-eDP1: SUCCESS (8.717s)
[168.627475] Starting dynamic subtest: D-eDP1
[177.356867] Dynamic subtest D-eDP1: SUCCESS (8.736s)
[177.359567] Subtest blocking-absolute-wf_vblank: SUCCESS (34.926s)
[178.580883] [015/133] (841s left) gem_exec_schedule (reorder-wide)
[178.780663] Subtest reorder-wide: SKIP (0.000s)
[178.991228] [016/133] (840s left) gem_watchdog (default-virtual)
[179.061651] Starting subtest: default-virtual
[185.338237] Subtest default-virtual: SUCCESS (6.285s)
[185.452153] [017/133] (834s left) gem_pwrite (basic-self)
[185.508913] Subtest basic-self: SKIP (0.000s)
[185.590786] [018/133] (834s left) kms_psr (fbc-psr2-cursor-mmap-gtt)
[185.702376] Starting subtest: fbc-psr2-cursor-mmap-gtt
[185.704754] Starting dynamic subtest: eDP-1
[185.708895] Dynamic subtest eDP-1: SKIP (0.000s)
[185.713107] Subtest fbc-psr2-cursor-mmap-gtt: SKIP (0.001s)
[185.785552] [019/133] (834s left) kms_cursor_legacy (forked-move)
[185.939312] Starting subtest: forked-move
[185.941522] Starting dynamic subtest: pipe-A
[191.398106] Dynamic subtest pipe-A: SUCCESS (5.455s)
[191.411599] Starting dynamic subtest: pipe-B
[196.880277] Dynamic subtest pipe-B: SUCCESS (5.479s)
[196.891898] Starting dynamic subtest: pipe-C
[202.350184] Dynamic subtest pipe-C: SUCCESS (5.466s)
[202.361029] Starting dynamic subtest: pipe-D
[207.819130] Dynamic subtest pipe-D: SUCCESS (5.465s)
[207.830810] Starting dynamic subtest: all-pipes
[213.318042] Dynamic subtest all-pipes: SUCCESS (5.494s)
[213.320515] Subtest forked-move: SUCCESS (27.366s)
[213.476516] [020/133] (806s left) vgem_basic (debugfs)
[213.609151] Starting subtest: debugfs
[213.611564] Subtest debugfs: SUCCESS (0.000s)
[213.680482] [FACT vgem_basic (debugfs)] new: kernel.kmod_is_loaded.vgem: true
[213.683544] [021/133] (806s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-pwrite)
[213.779885] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-pwrite
[213.784012] Subtest fbc-2p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[213.907484] [022/133] (806s left) kms_plane_lowres (tiling-yf)
[214.009400] Starting subtest: tiling-yf
[214.013510] Subtest tiling-yf: SKIP (0.000s)
[214.105304] [023/133] (806s left) kms_flip (2x-flip-vs-dpms-off-vs-modeset)
[214.191585] Starting subtest: 2x-flip-vs-dpms-off-vs-modeset
[214.202717] Subtest 2x-flip-vs-dpms-off-vs-modeset: SKIP (0.011s)
[214.293378] [024/133] (806s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-32bpp-xtile-upscaling)
[214.409782] Starting subtest: flip-64bpp-xtile-to-32bpp-xtile-upscaling
[214.411881] Starting dynamic subtest: pipe-A-default-mode
[217.127873] Dynamic subtest pipe-A-default-mode: SUCCESS (2.716s)
[217.130138] Subtest flip-64bpp-xtile-to-32bpp-xtile-upscaling: SUCCESS (2.717s)
[217.999172] [025/133] (802s left) kms_vrr (flip-basic)
[218.100765] Starting subtest: flip-basic
[218.107215] Subtest flip-basic: SKIP (0.000s)
[218.195636] [026/133] (802s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-mmap-cpu)
[218.297550] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-mmap-cpu
[218.301672] Subtest fbc-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[218.416954] [027/133] (802s left) kms_flip (modeset-vs-vblank-race-interruptible)
[218.504542] Starting subtest: modeset-vs-vblank-race-interruptible
[218.506848] Starting dynamic subtest: A-eDP1
[223.206131] Dynamic subtest A-eDP1: SUCCESS (4.702s)
[223.217783] Starting dynamic subtest: B-eDP1
[227.823802] Dynamic subtest B-eDP1: SUCCESS (4.617s)
[227.835453] Starting dynamic subtest: C-eDP1
[232.442019] Dynamic subtest C-eDP1: SUCCESS (4.618s)
[232.453150] Starting dynamic subtest: D-eDP1
[237.051027] Dynamic subtest D-eDP1: SUCCESS (4.609s)
[237.056141] Subtest modeset-vs-vblank-race-interruptible: SUCCESS (18.556s)
[238.248776] [028/133] (782s left) kms_addfb_basic (bad-pitch-63)
[238.317314] Starting subtest: bad-pitch-63
[238.319746] Subtest bad-pitch-63: SUCCESS (0.000s)
[238.488418] [029/133] (782s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-mmap-wc)
[238.602570] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-mmap-wc
[238.606523] Subtest psr-2p-scndscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[238.725624] [030/133] (781s left) syncobj_wait (invalid-reset-one-illegal-handle)
[238.786502] Starting subtest: invalid-reset-one-illegal-handle
[238.788823] Subtest invalid-reset-one-illegal-handle: SUCCESS (0.000s)
[238.900918] [031/133] (781s left) gem_ctx_persistence (legacy-engines-queued)
[238.970250] Starting subtest: legacy-engines-queued
[238.972652] Starting dynamic subtest: render
[239.081478] Dynamic subtest render: SUCCESS (0.110s)
[239.093943] Starting dynamic subtest: bsd1
[240.969941] Dynamic subtest bsd1: SUCCESS (1.885s)
[240.982345] Starting dynamic subtest: bsd2
[242.952267] Dynamic subtest bsd2: SUCCESS (1.979s)
[242.964151] Starting dynamic subtest: blt
[242.994825] Dynamic subtest blt: SUCCESS (0.041s)
[243.003651] Starting dynamic subtest: vebox
[244.935651] Dynamic subtest vebox: SUCCESS (1.938s)
[244.940721] Subtest legacy-engines-queued: SUCCESS (5.965s)
[245.029738] [032/133] (775s left) syncobj_wait (invalid-single-wait-unsubmitted)
[245.098789] Starting subtest: invalid-single-wait-unsubmitted
[245.101053] Subtest invalid-single-wait-unsubmitted: SUCCESS (0.000s)
[245.225198] [033/133] (775s left) gem_pxp (verify-pxp-stale-ctx-execution)
[245.345765] Starting subtest: verify-pxp-stale-ctx-execution
[246.408957] Subtest verify-pxp-stale-ctx-execution: SUCCESS (1.062s)
[246.579731] [034/133] (774s left) gem_mmap_gtt (cpuset-basic-small-copy-odd)
[246.645342] Subtest cpuset-basic-small-copy-odd: SKIP (0.000s)
[246.708107] [035/133] (774s left) kms_cursor_crc (cursor-onscreen-512x170)
[246.994995] Starting subtest: cursor-onscreen-512x170
[246.999418] Subtest cursor-onscreen-512x170: SKIP (0.001s)
[247.171582] [036/133] (773s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-mmap-cpu)
[247.279280] Starting subtest: psr-1p-primscrn-spr-indfb-draw-mmap-cpu
[253.928581] Subtest psr-1p-primscrn-spr-indfb-draw-mmap-cpu: SUCCESS (6.652s)
[254.051821] [037/133] (766s left) kms_chamelium_color (ctm-0-25)
[254.153620] Subtest ctm-0-25: SKIP (0.000s)
[254.200784] [038/133] (766s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted-signaled)
[254.264837] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted-signaled
[254.372780] Subtest etime-multi-wait-all-for-submit-unsubmitted-signaled: SUCCESS (0.108s)
[254.476752] [039/133] (766s left) gem_exec_fence (syncobj-timeline-unused-fence)
[255.007417] Starting subtest: syncobj-timeline-unused-fence
[255.013501] Subtest syncobj-timeline-unused-fence: SUCCESS (0.006s)
[256.123911] [040/133] (764s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-blt)
[256.242355] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-blt
[256.246913] Subtest fbc-2p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[256.374008] [041/133] (764s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-pwrite)
[256.475042] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-pwrite
[256.479215] Subtest fbc-2p-scndscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[256.611129] [042/133] (764s left) kms_chamelium_frames (hdmi-cmp-planar-formats)
[257.011933] Subtest hdmi-cmp-planar-formats: SKIP (0.000s)
[257.855504] [043/133] (763s left) kms_plane_scaling (plane-downscale-factor-0-5-with-pixel-format)
[257.951804] Starting subtest: plane-downscale-factor-0-5-with-pixel-format
[257.954695] Starting dynamic subtest: pipe-A
[257.973227] Dynamic subtest pipe-A: SKIP (0.018s)
[257.983517] Starting dynamic subtest: pipe-B
[258.003706] Dynamic subtest pipe-B: SKIP (0.031s)
[258.013312] Starting dynamic subtest: pipe-C
[258.035845] Dynamic subtest pipe-C: SKIP (0.031s)
[258.045023] Starting dynamic subtest: pipe-D
[258.069811] Dynamic subtest pipe-D: SKIP (0.031s)
[258.074192] Subtest plane-downscale-factor-0-5-with-pixel-format: SKIP (0.114s)
[258.200166] [044/133] (762s left) gem_render_copy (y-tiled-to-vebox-x-tiled)
[258.255704] Starting subtest: y-tiled-to-vebox-x-tiled
[258.260158] Subtest y-tiled-to-vebox-x-tiled: SKIP (0.000s)
[258.462998] [045/133] (762s left) gen9_exec_parse (batch-without-end)
[258.518957] Subtest batch-without-end: SKIP (0.000s)
[258.586321] [046/133] (762s left) syncobj_timeline (etime-single-wait-submitted)
[258.638361] Starting subtest: etime-single-wait-submitted
[258.740991] Subtest etime-single-wait-submitted: SUCCESS (0.103s)
[258.844476] [047/133] (762s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180-hflip)
[258.948662] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180-hflip
[258.953065] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180-hflip: SKIP (0.000s)
[259.061270] [048/133] (762s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc)
[259.151221] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc
[265.781590] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc: SUCCESS (6.632s)
[265.930841] [049/133] (755s left) kms_ccs (crc-primary-suspend-y-tiled-gen12-rc-ccs)
[266.035707] Starting subtest: crc-primary-suspend-y-tiled-gen12-rc-ccs
[266.038082] Starting dynamic subtest: pipe-A-eDP-1
[266.047216] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[266.062563] Starting dynamic subtest: pipe-B-eDP-1
[266.072220] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[266.083036] Starting dynamic subtest: pipe-C-eDP-1
[266.091632] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[266.100381] Starting dynamic subtest: pipe-D-eDP-1
[266.108795] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[266.113161] Subtest crc-primary-suspend-y-tiled-gen12-rc-ccs: SKIP (0.004s)
[268.284154] [050/133] (753s left) kms_atomic_transition (plane-use-after-nonblocking-unbind)
[268.383481] Starting subtest: plane-use-after-nonblocking-unbind
[268.385802] Starting dynamic subtest: pipe-A-eDP-1
[268.444360] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.062s)
[268.758933] Starting dynamic subtest: pipe-B-eDP-1
[269.560121] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.810s)
[269.846899] Subtest plane-use-after-nonblocking-unbind: SUCCESS (1.462s)
[270.726372] [051/133] (750s left) gem_partial_pwrite_pread (reads-uncached)
[270.791115] Subtest reads-uncached: SKIP (0.000s)
[270.859893] [052/133] (750s left) syncobj_wait (multi-wait-for-submit-unsubmitted-submitted-signaled)
[270.920275] Starting subtest: multi-wait-for-submit-unsubmitted-submitted-signaled
[270.922538] Subtest multi-wait-for-submit-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[271.038383] [053/133] (750s left) i915_pm_rc6_residency (rc6-fence)
[271.094619] Starting subtest: rc6-fence
[271.114248] Starting dynamic subtest: gt0
[283.434417] Dynamic subtest gt0: SUCCESS (12.317s)
[283.446510] Starting dynamic subtest: gt1
[297.961314] Dynamic subtest gt1: SUCCESS (14.519s)
[297.964380] Subtest rc6-fence: SUCCESS (26.862s)
[298.050778] [054/133] (723s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite)
[298.156109] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite
[298.160254] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[298.263075] [055/133] (723s left) kms_frontbuffer_tracking (psr-2p-primscrn-indfb-msflip-blt)
[298.360338] Starting subtest: psr-2p-primscrn-indfb-msflip-blt
[298.364779] Subtest psr-2p-primscrn-indfb-msflip-blt: SKIP (0.000s)
[298.469428] [056/133] (723s left) kms_big_fb (yf-tiled-16bpp-rotate-180)
[298.584118] Starting subtest: yf-tiled-16bpp-rotate-180
[298.588684] Subtest yf-tiled-16bpp-rotate-180: SKIP (0.000s)
[298.692942] [057/133] (723s left) gem_ctx_param (root-set)
[298.746770] Starting subtest: root-set
[298.749109] Subtest root-set: SUCCESS (0.001s)
[298.866411] [058/133] (722s left) gem_exec_fence (syncobj-invalid-wait)
[299.291126] Starting subtest: syncobj-invalid-wait
[299.293627] Subtest syncobj-invalid-wait: SUCCESS (0.001s)
[301.096882] [059/133] (720s left) kms_lease (invalid-create-leases)
[301.213612] Starting subtest: invalid-create-leases
[301.218618] Subtest invalid-create-leases: SUCCESS (0.006s)
[301.357007] [060/133] (720s left) kms_ccs (missing-ccs-buffer-4-tiled-mtl-mc-ccs)
[301.453558] Starting subtest: missing-ccs-buffer-4-tiled-mtl-mc-ccs
[301.455840] Starting dynamic subtest: pipe-A-eDP-1
[301.475850] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.022s)
[301.491063] Starting dynamic subtest: pipe-B-eDP-1
[301.511543] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.021s)
[301.523036] Starting dynamic subtest: pipe-C-eDP-1
[301.542807] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.021s)
[301.551945] Starting dynamic subtest: pipe-D-eDP-1
[301.572213] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.020s)
[301.574501] Subtest missing-ccs-buffer-4-tiled-mtl-mc-ccs: SUCCESS (0.090s)
[303.808911] [061/133] (718s left) kms_sequence (queue-busy)
[303.925225] Starting subtest: queue-busy
[303.927190] Starting dynamic subtest: pipe-A-eDP-1
[305.864176] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.937s)
[305.875110] Starting dynamic subtest: pipe-B-eDP-1
[308.500673] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.634s)
[308.512462] Starting dynamic subtest: pipe-C-eDP-1
[311.118815] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.616s)
[311.128937] Starting dynamic subtest: pipe-D-eDP-1
[313.752795] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.633s)
[313.755244] Subtest queue-busy: SUCCESS (9.826s)
[314.581745] [062/133] (707s left) prime_vgem (basic-fence-blt)
[314.664964] Starting subtest: basic-fence-blt
[314.740855] Subtest basic-fence-blt: SUCCESS (0.076s)
[314.879751] [063/133] (707s left) i915_suspend (basic-s3-without-i915)
[314.921720] Starting subtest: basic-s3-without-i915
[316.883821] Subtest basic-s3-without-i915: SKIP (1.957s)
[318.618050] [064/133] (703s left) i915_module_load (reload-no-display)
[318.672211] Starting subtest: reload-no-display
[323.177842] Subtest reload-no-display: SUCCESS (4.506s)
[323.207203] [FACT i915_module_load (reload-no-display)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[323.207925] [FACT i915_module_load (reload-no-display)] deleted: kernel.kmod_is_loaded.i915: true
[323.210965] [065/133] (698s left) prime_vgem (basic-gtt)
[324.794614] Starting subtest: basic-gtt
[324.799373] Subtest basic-gtt: SKIP (0.000s)
[324.885542] [FACT prime_vgem (basic-gtt)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[324.886806] [FACT prime_vgem (basic-gtt)] new: kernel.kmod_is_loaded.i915: true
[324.890917] [066/133] (697s left) vgem_basic (second-client)
[324.949021] Starting subtest: second-client
[324.971009] Subtest second-client: SUCCESS (0.022s)
[325.043516] [067/133] (697s left) kms_psr (fbc-pr-dpms)
[325.140683] Starting subtest: fbc-pr-dpms
[325.144957] Subtest fbc-pr-dpms: SKIP (0.000s)
[325.227949] [068/133] (696s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-0-hflip)
[325.332112] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-0-hflip
[325.336587] Subtest yf-tiled-max-hw-stride-32bpp-rotate-0-hflip: SKIP (0.000s)
[325.464671] [069/133] (696s left) gem_exec_balancer (full-late)
[325.537047] Starting subtest: full-late
[329.891218] Subtest full-late: SUCCESS (4.352s)
[330.282084] [070/133] (691s left) kms_psr (pr-primary-mmap-gtt)
[330.385712] Starting subtest: pr-primary-mmap-gtt
[330.390249] Subtest pr-primary-mmap-gtt: SKIP (0.000s)
[330.469874] [071/133] (691s left) syncobj_wait (single-wait-all-signaled)
[330.537753] Starting subtest: single-wait-all-signaled
[330.540327] Subtest single-wait-all-signaled: SUCCESS (0.000s)
[330.663035] [072/133] (691s left) kms_ccs (bad-aux-stride-y-tiled-gen12-rc-ccs-cc)
[330.760714] Starting subtest: bad-aux-stride-y-tiled-gen12-rc-ccs-cc
[330.763030] Starting dynamic subtest: pipe-A-eDP-1
[330.785277] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[330.794369] Starting dynamic subtest: pipe-B-eDP-1
[330.814784] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[330.822598] Starting dynamic subtest: pipe-C-eDP-1
[330.843008] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[330.850633] Starting dynamic subtest: pipe-D-eDP-1
[330.871565] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[330.875773] Subtest bad-aux-stride-y-tiled-gen12-rc-ccs-cc: SKIP (0.004s)
[333.018599] [073/133] (689s left) syncobj_timeline (single-wait-all-available-signaled)
[333.082074] Starting subtest: single-wait-all-available-signaled
[333.084351] Subtest single-wait-all-available-signaled: SUCCESS (0.000s)
[333.178371] [074/133] (689s left) kms_addfb_basic (addfb25-x-tiled-legacy)
[333.267958] Subtest addfb25-x-tiled-legacy: SKIP (0.000s)
[333.401917] [075/133] (689s left) gem_exec_capture (userptr)
[333.470242] Starting subtest: userptr
[334.281566] Subtest userptr: SUCCESS (0.808s)
[334.451264] [076/133] (688s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-render)
[334.560631] Starting subtest: fbcpsr-rgb565-draw-render
[342.758846] Subtest fbcpsr-rgb565-draw-render: SUCCESS (8.198s)
[342.918143] [077/133] (679s left) prime_mmap (test_reprime)
[342.977975] Starting subtest: test_reprime
[342.979923] Starting dynamic subtest: test_reprime-smem
[343.006702] Dynamic subtest test_reprime-smem: SUCCESS (0.031s)
[343.009129] Subtest test_reprime: SUCCESS (0.032s)
[343.131138] [078/133] (679s left) syncobj_wait (wait-all-snapshot)
[343.194951] Starting subtest: wait-all-snapshot
[343.276494] Subtest wait-all-snapshot: SUCCESS (0.082s)
[343.368515] [079/133] (679s left) kms_plane_scaling (planes-downscale-factor-0-75-upscale-20x20)
[343.451463] Starting subtest: planes-downscale-factor-0-75-upscale-20x20
[343.453645] Starting dynamic subtest: pipe-A
[343.514978] Dynamic subtest pipe-A: SUCCESS (0.065s)
[343.525312] Starting dynamic subtest: pipe-B
[344.710227] Dynamic subtest pipe-B: SUCCESS (1.194s)
[344.719480] Starting dynamic subtest: pipe-C
[345.838159] Dynamic subtest pipe-C: SUCCESS (1.127s)
[345.847456] Starting dynamic subtest: pipe-D
[346.966331] Dynamic subtest pipe-D: SUCCESS (1.127s)
[346.968653] Subtest planes-downscale-factor-0-75-upscale-20x20: SUCCESS (3.516s)
[348.153965] [080/133] (674s left) gem_softpin (allocator-fork)
[348.222473] Starting subtest: allocator-fork
[350.431579] Subtest allocator-fork: SUCCESS (2.209s)
[350.611501] [081/133] (672s left) api_intel_bb (object-reloc-keep-cache)
[350.684262] Starting subtest: object-reloc-keep-cache
[350.692094] Subtest object-reloc-keep-cache: SKIP (0.005s)
[350.808106] [082/133] (671s left) syncobj_wait (wait-all-for-submit-delayed-submit)
[350.871002] Starting subtest: wait-all-for-submit-delayed-submit
[350.972501] Subtest wait-all-for-submit-delayed-submit: SUCCESS (0.103s)
[351.079588] [083/133] (671s left) kms_color (degamma)
[351.182202] Starting subtest: degamma
[351.184406] Starting dynamic subtest: pipe-A-eDP-1
[351.905141] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.724s)
[351.916524] Starting dynamic subtest: pipe-B-eDP-1
[353.373175] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.465s)
[353.383019] Starting dynamic subtest: pipe-C-eDP-1
[354.710472] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.339s)
[354.719690] Starting dynamic subtest: pipe-D-eDP-1
[356.053642] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.340s)
[356.055511] Subtest degamma: SUCCESS (4.872s)
[356.874252] [084/133] (666s left) gem_userptr_blits (coherency-unsync)
[356.947080] Subtest coherency-unsync: SKIP (0.000s)
[357.098473] [085/133] (665s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip)
[357.198164] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip
[357.833521] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SUCCESS (0.637s)
[358.040872] [086/133] (664s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-180)
[358.150730] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-180
[358.154710] Subtest y-tiled-max-hw-stride-32bpp-rotate-180: SKIP (0.000s)
[358.278485] [087/133] (664s left) kms_plane_scaling (2x-scaler-multi-pipe)
[358.373968] Starting subtest: 2x-scaler-multi-pipe
[358.378306] Subtest 2x-scaler-multi-pipe: SKIP (0.001s)
[358.486832] [088/133] (664s left) gem_exec_parallel (fds)
[358.564291] Starting subtest: fds
[358.566304] Starting dynamic subtest: rcs0
[361.303302] Dynamic subtest rcs0: SUCCESS (2.740s)
[361.315296] Starting dynamic subtest: bcs0
[364.545379] Dynamic subtest bcs0: SUCCESS (3.240s)
[364.557784] Starting dynamic subtest: vcs0
[368.281957] Dynamic subtest vcs0: SUCCESS (3.735s)
[368.292884] Starting dynamic subtest: vcs1
[372.234079] Dynamic subtest vcs1: SUCCESS (3.951s)
[372.245887] Starting dynamic subtest: vecs0
[376.361270] Dynamic subtest vecs0: SUCCESS (4.126s)
[376.373371] Starting dynamic subtest: ccs0
[380.214500] Dynamic subtest ccs0: SUCCESS (3.852s)
[380.217479] Subtest fds: SUCCESS (21.655s)
[380.416871] [089/133] (642s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-mmap-gtt)
[380.536731] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-mmap-gtt
[380.541003] Subtest fbc-2p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[380.653157] [090/133] (642s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-blt)
[380.745763] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-blt
[380.749802] Subtest fbc-2p-scndscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[380.867560] [091/133] (642s left) kms_getfb (getfb2-into-addfb2)
[380.968717] Starting subtest: getfb2-into-addfb2
[380.970909] Subtest getfb2-into-addfb2: SUCCESS (0.000s)
[381.109035] [092/133] (642s left) kms_flip (busy-flip)
[381.205666] Starting subtest: busy-flip
[381.207999] Starting dynamic subtest: A-eDP1
[382.861257] Dynamic subtest A-eDP1: SUCCESS (1.655s)
[382.872118] Starting dynamic subtest: B-eDP1
[384.604658] Dynamic subtest B-eDP1: SUCCESS (1.729s)
[384.623159] Starting dynamic subtest: C-eDP1
[386.231166] Dynamic subtest C-eDP1: SUCCESS (1.637s)
[386.242101] Starting dynamic subtest: D-eDP1
[387.864809] Dynamic subtest D-eDP1: SUCCESS (1.633s)
[387.867191] Subtest busy-flip: SUCCESS (6.663s)
[389.121266] [093/133] (634s left) gem_ctx_sseu (mmap-args)
[389.191102] Subtest mmap-args: SKIP (0.000s)
[389.257382] [094/133] (634s left) kms_cursor_crc (cursor-random-32x32)
[389.401079] Starting subtest: cursor-random-32x32
[389.451967] Subtest cursor-random-32x32: SKIP (0.045s)
[389.768216] [095/133] (633s left) kms_ccs (ccs-on-another-bo-y-tiled-gen12-rc-ccs-cc)
[389.865706] Starting subtest: ccs-on-another-bo-y-tiled-gen12-rc-ccs-cc
[389.868038] Starting dynamic subtest: pipe-A-eDP-1
[389.891170] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[389.902279] Starting dynamic subtest: pipe-B-eDP-1
[389.923978] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[389.934901] Starting dynamic subtest: pipe-C-eDP-1
[389.956265] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[389.966398] Starting dynamic subtest: pipe-D-eDP-1
[389.989218] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[389.993563] Subtest ccs-on-another-bo-y-tiled-gen12-rc-ccs-cc: SKIP (0.004s)
[392.183788] [096/133] (631s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-mmap-cpu)
[392.275541] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-mmap-cpu
[396.319642] Subtest fbc-1p-offscreen-pri-shrfb-draw-mmap-cpu: SUCCESS (4.046s)
[397.486493] [097/133] (625s left) gem_exec_schedule (u-submit-late-slice)
[397.565622] Starting subtest: u-submit-late-slice
[397.567585] Starting dynamic subtest: rcs0
[397.591759] Dynamic subtest rcs0: SUCCESS (0.034s)
[397.603798] Starting dynamic subtest: bcs0
[397.619992] Dynamic subtest bcs0: SUCCESS (0.027s)
[397.629606] Starting dynamic subtest: vcs0
[397.654365] Dynamic subtest vcs0: SUCCESS (0.034s)
[397.666376] Starting dynamic subtest: vcs1
[397.688002] Dynamic subtest vcs1: SUCCESS (0.033s)
[397.697793] Starting dynamic subtest: vecs0
[397.715536] Dynamic subtest vecs0: SUCCESS (0.027s)
[397.725017] Starting dynamic subtest: ccs0
[397.747078] Dynamic subtest ccs0: SUCCESS (0.031s)
[397.749344] Subtest u-submit-late-slice: SUCCESS (0.190s)
[399.154253] [098/133] (624s left) kms_frontbuffer_tracking (fbcpsr-stridechange)
[399.270526] Starting subtest: fbcpsr-stridechange
[405.516536] Subtest fbcpsr-stridechange: SUCCESS (6.249s)
[405.697945] [099/133] (617s left) dumb_buffer (map-valid)
[405.768730] Starting subtest: map-valid
[405.770790] Subtest map-valid: SUCCESS (0.000s)
[405.910281] [100/133] (617s left) perf_pmu (idle)
[405.951289] Starting subtest: idle
[405.953507] Starting dynamic subtest: rcs0
[406.524537] Dynamic subtest rcs0: SUCCESS (0.572s)
[406.536578] Starting dynamic subtest: bcs0
[407.053160] Dynamic subtest bcs0: SUCCESS (0.525s)
[407.065121] Starting dynamic subtest: vcs0
[407.572094] Dynamic subtest vcs0: SUCCESS (0.516s)
[407.584283] Starting dynamic subtest: vcs1
[408.093677] Dynamic subtest vcs1: SUCCESS (0.519s)
[408.105212] Starting dynamic subtest: vecs0
[408.615232] Dynamic subtest vecs0: SUCCESS (0.519s)
[408.627748] Starting dynamic subtest: ccs0
[409.138141] Dynamic subtest ccs0: SUCCESS (0.520s)
[409.140966] Subtest idle: SUCCESS (3.188s)
[409.260076] [101/133] (614s left) kms_pm_rpm (i2c)
[411.184058] Starting subtest: i2c
[416.242518] Subtest i2c: SUCCESS (5.061s)
[416.343844] [102/133] (607s left) kms_big_fb (linear-64bpp-rotate-180)
[416.463163] Starting subtest: linear-64bpp-rotate-180
[418.020839] Subtest linear-64bpp-rotate-180: SUCCESS (1.558s)
[418.219821] [103/133] (605s left) kms_feature_discovery (dp-mst)
[418.321168] Starting subtest: dp-mst
[418.325647] Subtest dp-mst: SKIP (0.000s)
[418.412710] [104/133] (605s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-blt)
[418.523564] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-blt
[418.527545] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-blt: SKIP (0.000s)
[418.648887] [105/133] (605s left) kms_pipe_stress (stress-xrgb8888-untiled)
[418.759780] Starting subtest: stress-xrgb8888-untiled
[424.615238] Subtest stress-xrgb8888-untiled: SUCCESS (5.858s)
[424.673836] [106/133] (599s left) gem_softpin (invalid)
[424.730820] Starting subtest: invalid
[424.737549] Subtest invalid: SUCCESS (0.007s)
[424.890534] [107/133] (598s left) kms_psr2_sf (fbc-psr2-overlay-plane-update-continuous-sf)
[429.881907] Starting subtest: fbc-psr2-overlay-plane-update-continuous-sf
[429.884287] Starting dynamic subtest: pipe-A-eDP-1
[430.687466] Dynamic subtest pipe-A-eDP-1: SKIP (0.801s)
[430.697962] Starting dynamic subtest: pipe-B-eDP-1
[431.820970] Dynamic subtest pipe-B-eDP-1: SKIP (1.130s)
[431.825336] Subtest fbc-psr2-overlay-plane-update-continuous-sf: SKIP (1.936s)
[433.066995] [108/133] (590s left) kms_rotation_crc (primary-x-tiled-reflect-x-0)
[433.160532] Starting subtest: primary-x-tiled-reflect-x-0
[440.281884] Subtest primary-x-tiled-reflect-x-0: SUCCESS (7.122s)
[441.489788] [109/133] (582s left) i915_drm_fdinfo (busy)
[441.528901] Starting subtest: busy
[441.531182] Starting dynamic subtest: rcs0
[441.551501] Dynamic subtest rcs0: SKIP (0.022s)
[441.561234] Starting dynamic subtest: bcs0
[441.575373] Dynamic subtest bcs0: SKIP (0.023s)
[441.585525] Starting dynamic subtest: vcs0
[441.589688] Dynamic subtest vcs0: SKIP (0.000s)
[441.599268] Starting dynamic subtest: vcs1
[441.603828] Dynamic subtest vcs1: SKIP (0.000s)
[441.612537] Starting dynamic subtest: vecs0
[441.616636] Dynamic subtest vecs0: SKIP (0.000s)
[441.626086] Starting dynamic subtest: ccs0
[441.630319] Dynamic subtest ccs0: SKIP (0.000s)
[441.635179] Subtest busy: SKIP (0.050s)
[441.673118] [110/133] (582s left) kms_big_fb (linear-max-hw-stride-64bpp-rotate-180-hflip)
[441.783497] Starting subtest: linear-max-hw-stride-64bpp-rotate-180-hflip
[441.787622] Subtest linear-max-hw-stride-64bpp-rotate-180-hflip: SKIP (0.000s)
[441.895040] [111/133] (582s left) kms_scaling_modes (scaling-mode-full)
[441.993287] Starting subtest: scaling-mode-full
[441.995139] Starting dynamic subtest: pipe-A-eDP-1
[442.085682] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.094s)
[442.096236] Starting dynamic subtest: pipe-B-eDP-1
[443.220860] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.133s)
[443.230998] Starting dynamic subtest: pipe-C-eDP-1
[444.336546] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.114s)
[444.346714] Starting dynamic subtest: pipe-D-eDP-1
[445.469644] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.131s)
[445.471771] Subtest scaling-mode-full: SUCCESS (3.479s)
[446.654614] [112/133] (577s left) kms_psr2_sf (fbc-psr2-overlay-plane-move-continuous-exceed-fully-sf)
[451.711248] Starting subtest: fbc-psr2-overlay-plane-move-continuous-exceed-fully-sf
[451.713764] Starting dynamic subtest: pipe-A-eDP-1
[452.511072] Dynamic subtest pipe-A-eDP-1: SKIP (0.795s)
[452.521712] Starting dynamic subtest: pipe-B-eDP-1
[453.639815] Dynamic subtest pipe-B-eDP-1: SKIP (1.128s)
[453.644614] Subtest fbc-psr2-overlay-plane-move-continuous-exceed-fully-sf: SKIP (1.927s)
[454.849015] [113/133] (569s left) gem_exec_schedule (preemptive-hang)
[455.022355] Starting subtest: preemptive-hang
[455.025306] Starting dynamic subtest: rcs0
[464.091949] Dynamic subtest rcs0: SUCCESS (9.068s)
[464.104413] Starting dynamic subtest: bcs0
[473.108021] Dynamic subtest bcs0: SUCCESS (9.011s)
[473.127183] Starting dynamic subtest: vcs0
[482.133754] Dynamic subtest vcs0: SUCCESS (9.022s)
[482.149464] Starting dynamic subtest: vcs1
[491.089179] Dynamic subtest vcs1: SUCCESS (8.950s)
[491.100912] Starting dynamic subtest: vecs0
[500.107569] Dynamic subtest vecs0: SUCCESS (9.018s)
[500.117192] Starting dynamic subtest: ccs0
[509.074716] Dynamic subtest ccs0: SUCCESS (8.962s)
[509.076979] Subtest preemptive-hang: SUCCESS (54.042s)
[509.341707] [114/133] (514s left) syncobj_timeline (multi-wait-all-for-submit-available-submitted)
[509.406497] Starting subtest: multi-wait-all-for-submit-available-submitted
[509.408815] Subtest multi-wait-all-for-submit-available-submitted: SUCCESS (0.000s)
[509.535525] [115/133] (514s left) perf (per-context-mode-unprivileged)
[509.686091] Starting subtest: per-context-mode-unprivileged
[509.690484] Subtest per-context-mode-unprivileged: SKIP (0.000s)
[509.727278] [116/133] (514s left) gem_exec_reloc (basic-gtt-noreloc)
[509.796470] Subtest basic-gtt-noreloc: SKIP (0.000s)
[509.860607] [117/133] (514s left) kms_flip (2x-flip-vs-dpms)
[509.956263] Starting subtest: 2x-flip-vs-dpms
[509.966541] Subtest 2x-flip-vs-dpms: SKIP (0.011s)
[510.058401] [118/133] (514s left) gem_ctx_exec (basic-close-race)
[510.114836] Starting subtest: basic-close-race
[515.880766] Subtest basic-close-race: SUCCESS (5.764s)
[516.054674] [119/133] (508s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-gtt)
[516.152082] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-gtt
[516.156065] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[516.275746] [120/133] (508s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-64bpp-yftile-upscaling)
[516.364546] Starting subtest: flip-32bpp-yftile-to-64bpp-yftile-upscaling
[516.368683] Subtest flip-32bpp-yftile-to-64bpp-yftile-upscaling: SKIP (0.000s)
[516.478078] [121/133] (508s left) gem_ctx_param (invalid-get-no-zeromap)
[516.555237] Starting subtest: invalid-get-no-zeromap
[516.557617] Subtest invalid-get-no-zeromap: SUCCESS (0.001s)
[516.679947] [122/133] (507s left) dumb_buffer (invalid-bpp)
[516.738089] Starting subtest: invalid-bpp
[516.740388] Subtest invalid-bpp: SUCCESS (0.000s)
[516.849464] [123/133] (507s left) kms_addfb_basic (basic)
[516.914210] Starting subtest: basic
[516.916183] Subtest basic: SUCCESS (0.000s)
[517.053112] [124/133] (507s left) kms_plane (pixel-format-4-tiled-modifier-source-clamping)
[517.158973] Starting subtest: pixel-format-4-tiled-modifier-source-clamping
[517.186534] Starting dynamic subtest: pipe-A-plane-0
[517.808674] Dynamic subtest pipe-A-plane-0: SUCCESS (0.622s)
[517.817770] Starting dynamic subtest: pipe-A-plane-3
[518.209473] Dynamic subtest pipe-A-plane-3: SUCCESS (0.399s)
[518.226295] Starting dynamic subtest: pipe-A-plane-5
[518.230448] Dynamic subtest pipe-A-plane-5: SKIP (0.000s)
[519.315105] Starting dynamic subtest: pipe-B-plane-0
[519.960535] Dynamic subtest pipe-B-plane-0: SUCCESS (0.655s)
[519.970955] Starting dynamic subtest: pipe-B-plane-3
[520.382499] Dynamic subtest pipe-B-plane-3: SUCCESS (0.420s)
[520.393610] Starting dynamic subtest: pipe-B-plane-5
[520.397410] Dynamic subtest pipe-B-plane-5: SKIP (0.000s)
[520.708184] Subtest pixel-format-4-tiled-modifier-source-clamping: SUCCESS (3.546s)
[521.518001] [125/133] (503s left) perf_pmu (busy-double-start)
[521.563489] Starting subtest: busy-double-start
[521.565858] Starting dynamic subtest: rcs0
[525.133433] Dynamic subtest rcs0: SUCCESS (3.571s)
[525.145517] Starting dynamic subtest: bcs0
[528.728317] Dynamic subtest bcs0: SUCCESS (3.591s)
[528.739097] Starting dynamic subtest: vcs0
[532.562241] Dynamic subtest vcs0: SUCCESS (3.831s)
[532.573372] Starting dynamic subtest: vcs1
[536.537467] Dynamic subtest vcs1: SUCCESS (3.972s)
[536.550147] Starting dynamic subtest: vecs0
[540.556386] Dynamic subtest vecs0: SUCCESS (4.016s)
[540.568618] Starting dynamic subtest: ccs0
[544.201731] Dynamic subtest ccs0: FAIL (3.582s)
[544.203721] Subtest busy-double-start: FAIL (22.575s)
[544.272082] [126/133] (480s left) gem_ctx_param (basic-default)
[544.326329] Starting subtest: basic-default
[544.328638] Subtest basic-default: SUCCESS (0.000s)
[544.432762] [127/133] (480s left) gem_mmap_gtt (big-bo-tiledx)
[544.500692] Subtest big-bo-tiledX: SKIP (0.000s)
[544.559590] [128/133] (480s left) gem_userptr_blits (stress-mm)
[544.637497] Starting subtest: stress-mm
[550.009396] Subtest stress-mm: SUCCESS (5.369s)
[550.193813] [129/133] (474s left) prime_vgem (fence-read-hang)
[550.293384] Subtest fence-read-hang: SKIP (0.000s)
[550.408584] [130/133] (474s left) kms_flip (2x-flip-vs-expired-vblank-interruptible)
[550.516079] Starting subtest: 2x-flip-vs-expired-vblank-interruptible
[550.527652] Subtest 2x-flip-vs-expired-vblank-interruptible: SKIP (0.011s)
[550.613868] [131/133] (474s left) kms_psr (fbc-psr-primary-render)
[550.699281] Starting subtest: fbc-psr-primary-render
[550.701533] Starting dynamic subtest: eDP-1
[550.705653] Dynamic subtest eDP-1: SKIP (0.000s)
[550.709924] Subtest fbc-psr-primary-render: SKIP (0.001s)
[550.785696] [132/133] (474s left) kms_frontbuffer_tracking (psr-modesetfrombusy)
[550.881599] Starting subtest: psr-modesetfrombusy
[557.036463] Subtest psr-modesetfrombusy: SUCCESS (6.157s)
[557.211195] [133/133] (467s left) kms_pm_rpm (system-suspend-modeset)
[559.155672] Starting subtest: system-suspend-modeset
[578.396976] Subtest system-suspend-modeset: SUCCESS (4.261s)
[578.812191] Closing watchdogs
results: parsing output: 0/ for test: kms_frontbuffer_tracking
results: parsing output: 1/ for test: syncobj_timeline
results: parsing output: 2/ for test: kms_chamelium_hpd
results: parsing output: 3/ for test: kms_cursor_edge_walk
results: parsing output: 4/ for test: gem_mmap_offset
results: parsing output: 5/ for test: kms_joiner
results: parsing output: 6/ for test: gem_exec_balancer
results: parsing output: 7/ for test: gem_exec_whisper
results: parsing output: 8/ for test: gem_exec_suspend
results: parsing output: 9/ for test: kms_psr
results: parsing output: 10/ for test: kms_frontbuffer_tracking
results: parsing output: 11/ for test: kms_content_protection
results: parsing output: 12/ for test: kms_async_flips
results: parsing output: 13/ for test: kms_flip
results: parsing output: 14/ for test: gem_exec_schedule
results: parsing output: 15/ for test: gem_watchdog
results: parsing output: 16/ for test: gem_pwrite
results: parsing output: 17/ for test: kms_psr
results: parsing output: 18/ for test: kms_cursor_legacy
results: parsing output: 19/ for test: vgem_basic
results: parsing output: 20/ for test: kms_frontbuffer_tracking
results: parsing output: 21/ for test: kms_plane_lowres
results: parsing output: 22/ for test: kms_flip
results: parsing output: 23/ for test: kms_flip_scaled_crc
results: parsing output: 24/ for test: kms_vrr
results: parsing output: 25/ for test: kms_frontbuffer_tracking
results: parsing output: 26/ for test: kms_flip
results: parsing output: 27/ for test: kms_addfb_basic
results: parsing output: 28/ for test: kms_frontbuffer_tracking
results: parsing output: 29/ for test: syncobj_wait
results: parsing output: 30/ for test: gem_ctx_persistence
results: parsing output: 31/ for test: syncobj_wait
results: parsing output: 32/ for test: gem_pxp
results: parsing output: 33/ for test: gem_mmap_gtt
results: parsing output: 34/ for test: kms_cursor_crc
results: parsing output: 35/ for test: kms_frontbuffer_tracking
results: parsing output: 36/ for test: kms_chamelium_color
results: parsing output: 37/ for test: syncobj_timeline
results: parsing output: 38/ for test: gem_exec_fence
results: parsing output: 39/ for test: kms_frontbuffer_tracking
results: parsing output: 40/ for test: kms_frontbuffer_tracking
results: parsing output: 41/ for test: kms_chamelium_frames
results: parsing output: 42/ for test: kms_plane_scaling
results: parsing output: 43/ for test: gem_render_copy
results: parsing output: 44/ for test: gen9_exec_parse
results: parsing output: 45/ for test: syncobj_timeline
results: parsing output: 46/ for test: kms_big_fb
results: parsing output: 47/ for test: kms_frontbuffer_tracking
results: parsing output: 48/ for test: kms_ccs
results: parsing output: 49/ for test: kms_atomic_transition
results: parsing output: 50/ for test: gem_partial_pwrite_pread
results: parsing output: 51/ for test: syncobj_wait
results: parsing output: 52/ for test: i915_pm_rc6_residency
results: parsing output: 53/ for test: kms_frontbuffer_tracking
results: parsing output: 54/ for test: kms_frontbuffer_tracking
results: parsing output: 55/ for test: kms_big_fb
results: parsing output: 56/ for test: gem_ctx_param
results: parsing output: 57/ for test: gem_exec_fence
results: parsing output: 58/ for test: kms_lease
results: parsing output: 59/ for test: kms_ccs
results: parsing output: 60/ for test: kms_sequence
results: parsing output: 61/ for test: prime_vgem
results: parsing output: 62/ for test: i915_suspend
results: parsing output: 63/ for test: i915_module_load
results: parsing output: 64/ for test: prime_vgem
results: parsing output: 65/ for test: vgem_basic
results: parsing output: 66/ for test: kms_psr
results: parsing output: 67/ for test: kms_big_fb
results: parsing output: 68/ for test: gem_exec_balancer
results: parsing output: 69/ for test: kms_psr
results: parsing output: 70/ for test: syncobj_wait
results: parsing output: 71/ for test: kms_ccs
results: parsing output: 72/ for test: syncobj_timeline
results: parsing output: 73/ for test: kms_addfb_basic
results: parsing output: 74/ for test: gem_exec_capture
results: parsing output: 75/ for test: kms_frontbuffer_tracking
results: parsing output: 76/ for test: prime_mmap
results: parsing output: 77/ for test: syncobj_wait
results: parsing output: 78/ for test: kms_plane_scaling
results: parsing output: 79/ for test: gem_softpin
results: parsing output: 80/ for test: api_intel_bb
results: parsing output: 81/ for test: syncobj_wait
results: parsing output: 82/ for test: kms_color
results: parsing output: 83/ for test: gem_userptr_blits
results: parsing output: 84/ for test: kms_big_fb
results: parsing output: 85/ for test: kms_big_fb
results: parsing output: 86/ for test: kms_plane_scaling
results: parsing output: 87/ for test: gem_exec_parallel
results: parsing output: 88/ for test: kms_frontbuffer_tracking
results: parsing output: 89/ for test: kms_frontbuffer_tracking
results: parsing output: 90/ for test: kms_getfb
results: parsing output: 91/ for test: kms_flip
results: parsing output: 92/ for test: gem_ctx_sseu
results: parsing output: 93/ for test: kms_cursor_crc
results: parsing output: 94/ for test: kms_ccs
results: parsing output: 95/ for test: kms_frontbuffer_tracking
results: parsing output: 96/ for test: gem_exec_schedule
results: parsing output: 97/ for test: kms_frontbuffer_tracking
results: parsing output: 98/ for test: dumb_buffer
results: parsing output: 99/ for test: perf_pmu
results: parsing output: 100/ for test: kms_pm_rpm
results: parsing output: 101/ for test: kms_big_fb
results: parsing output: 102/ for test: kms_feature_discovery
results: parsing output: 103/ for test: kms_frontbuffer_tracking
results: parsing output: 104/ for test: kms_pipe_stress
results: parsing output: 105/ for test: gem_softpin
results: parsing output: 106/ for test: kms_psr2_sf
results: parsing output: 107/ for test: kms_rotation_crc
results: parsing output: 108/ for test: i915_drm_fdinfo
results: parsing output: 109/ for test: kms_big_fb
results: parsing output: 110/ for test: kms_scaling_modes
results: parsing output: 111/ for test: kms_psr2_sf
results: parsing output: 112/ for test: gem_exec_schedule
results: parsing output: 113/ for test: syncobj_timeline
results: parsing output: 114/ for test: perf
results: parsing output: 115/ for test: gem_exec_reloc
results: parsing output: 116/ for test: kms_flip
results: parsing output: 117/ for test: gem_ctx_exec
results: parsing output: 118/ for test: kms_frontbuffer_tracking
results: parsing output: 119/ for test: kms_flip_scaled_crc
results: parsing output: 120/ for test: gem_ctx_param
results: parsing output: 121/ for test: dumb_buffer
results: parsing output: 122/ for test: kms_addfb_basic
results: parsing output: 123/ for test: kms_plane
results: parsing output: 124/ for test: perf_pmu
results: parsing output: 125/ for test: gem_ctx_param
results: parsing output: 126/ for test: gem_mmap_gtt
results: parsing output: 127/ for test: gem_userptr_blits
results: parsing output: 128/ for test: prime_vgem
results: parsing output: 129/ for test: kms_flip
results: parsing output: 130/ for test: kms_psr
results: parsing output: 131/ for test: kms_frontbuffer_tracking
results: parsing output: 132/ for test: kms_pm_rpm
Done.