[59.346326] Initializing watchdogs
[59.346370]   /dev/watchdog0
[59.359784] [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.363979] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[59.366374] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[59.369830] [001/133] (960s left) kms_frontbuffer_tracking (fbcpsr-farfromfence-mmap-gtt)
[59.486565] Starting subtest: fbcpsr-farfromfence-mmap-gtt
[59.491120] Subtest fbcpsr-farfromfence-mmap-gtt: SKIP (0.000s)
[59.606034] [002/133] (960s left) syncobj_timeline (wait-for-submit-delayed-submit)
[59.663289] Starting subtest: wait-for-submit-delayed-submit
[59.768032] Subtest wait-for-submit-delayed-submit: SUCCESS (0.104s)
[59.866203] [003/133] (960s left) kms_chamelium_hpd (dp-hpd)
[60.256296] Subtest dp-hpd: SKIP (0.000s)
[61.089842] [004/133] (958s left) kms_cursor_edge_walk (256x256-top-bottom)
[61.192440] Starting subtest: 256x256-top-bottom
[61.194841] Starting dynamic subtest: pipe-A-eDP-1
[64.694071] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.498s)
[64.702754] Starting dynamic subtest: pipe-D-eDP-1
[67.804225] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.111s)
[67.806106] Subtest 256x256-top-bottom: SUCCESS (6.610s)
[68.613807] [005/133] (951s left) gem_mmap_offset (clear)
[68.671718] Starting subtest: clear
[68.674363] Starting dynamic subtest: smem0
[93.214666] Dynamic subtest smem0: SUCCESS (24.541s)
[93.217588] Subtest clear: SUCCESS (24.541s)
[93.367945] [006/133] (926s left) kms_joiner (basic-force-big-joiner)
[93.522313] Starting subtest: basic-force-big-joiner
[93.526613] Subtest basic-force-big-joiner: SKIP (0.000s)
[93.597766] [007/133] (926s left) gem_exec_balancer (waits)
[93.665606] Starting subtest: waits
[100.146382] Subtest waits: SUCCESS (6.480s)
[100.449665] [008/133] (919s left) gem_exec_whisper (basic-queues)
[100.509123] Starting subtest: basic-queues
[107.894313] Subtest basic-queues: SUCCESS (7.380s)
[108.084802] [009/133] (912s left) gem_exec_suspend (basic-s3)
[108.169596] Starting subtest: basic-S3
[108.171456] Starting dynamic subtest: smem
[129.218719] Dynamic subtest smem: SUCCESS (6.731s)
[129.221737] Subtest basic-S3: SUCCESS (6.732s)
[129.410972] [010/133] (890s left) kms_psr (psr2-sprite-render)
[129.507267] Starting subtest: psr2-sprite-render
[129.509629] Starting dynamic subtest: eDP-1
[131.204482] Dynamic subtest eDP-1: SUCCESS (1.696s)
[131.206819] Subtest psr2-sprite-render: SUCCESS (1.697s)
[132.058130] [011/133] (888s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-mmap-wc)
[132.171258] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-mmap-wc
[138.779447] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-mmap-wc: SUCCESS (6.611s)
[138.919849] [012/133] (881s left) kms_content_protection (atomic)
[139.068777] Starting subtest: atomic
[139.073298] Subtest atomic: SKIP (0.000s)
[139.213711] [013/133] (881s left) kms_async_flips (invalid-async-flip)
[139.315154] Starting subtest: invalid-async-flip
[139.693421] Starting dynamic subtest: pipe-A-eDP-1
[140.524190] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.832s)
[140.880394] Starting dynamic subtest: pipe-B-eDP-1
[141.740504] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.868s)
[142.102714] Starting dynamic subtest: pipe-C-eDP-1
[142.873128] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.778s)
[143.229197] Starting dynamic subtest: pipe-D-eDP-1
[143.993277] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.771s)
[143.995611] Subtest invalid-async-flip: SUCCESS (4.678s)
[145.155670] [014/133] (875s left) kms_flip (blocking-absolute-wf_vblank)
[145.252494] Starting subtest: blocking-absolute-wf_vblank
[145.254824] Starting dynamic subtest: A-eDP1
[154.002598] Dynamic subtest A-eDP1: SUCCESS (8.751s)
[154.015005] Starting dynamic subtest: B-eDP1
[162.733554] Dynamic subtest B-eDP1: SUCCESS (8.731s)
[162.744839] Starting dynamic subtest: C-eDP1
[171.447174] Dynamic subtest C-eDP1: SUCCESS (8.714s)
[171.455587] Starting dynamic subtest: D-eDP1
[180.172961] Dynamic subtest D-eDP1: SUCCESS (8.725s)
[180.178529] Subtest blocking-absolute-wf_vblank: SUCCESS (34.930s)
[181.402305] [015/133] (838s left) gem_exec_schedule (reorder-wide)
[181.600659] Subtest reorder-wide: SKIP (0.000s)
[181.790970] [016/133] (838s left) gem_watchdog (default-virtual)
[181.854184] Starting subtest: default-virtual
[188.127351] Subtest default-virtual: SUCCESS (6.284s)
[188.231095] [017/133] (832s left) gem_pwrite (basic-self)
[188.297134] Subtest basic-self: SKIP (0.000s)
[188.360590] [018/133] (832s left) kms_psr (fbc-psr2-cursor-mmap-gtt)
[188.458470] Starting subtest: fbc-psr2-cursor-mmap-gtt
[188.460339] Starting dynamic subtest: eDP-1
[188.464238] Dynamic subtest eDP-1: SKIP (0.000s)
[188.468016] Subtest fbc-psr2-cursor-mmap-gtt: SKIP (0.001s)
[188.538182] [019/133] (832s left) kms_cursor_legacy (forked-move)
[188.670967] Starting subtest: forked-move
[188.673137] Starting dynamic subtest: pipe-A
[194.123130] Dynamic subtest pipe-A: SUCCESS (5.451s)
[194.134659] Starting dynamic subtest: pipe-B
[199.593539] Dynamic subtest pipe-B: SUCCESS (5.469s)
[199.606927] Starting dynamic subtest: pipe-C
[205.074897] Dynamic subtest pipe-C: SUCCESS (5.480s)
[205.085999] Starting dynamic subtest: pipe-D
[210.547361] Dynamic subtest pipe-D: SUCCESS (5.472s)
[210.557997] Starting dynamic subtest: all-pipes
[216.050856] Dynamic subtest all-pipes: SUCCESS (5.501s)
[216.053341] Subtest forked-move: SUCCESS (27.379s)
[216.240158] [020/133] (804s left) vgem_basic (debugfs)
[216.368009] Starting subtest: debugfs
[216.369888] Subtest debugfs: SUCCESS (0.001s)
[216.444731] [FACT vgem_basic (debugfs)] new: kernel.kmod_is_loaded.vgem: true
[216.447993] [021/133] (804s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-pwrite)
[216.555001] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-pwrite
[216.559081] Subtest fbc-2p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[216.675819] [022/133] (803s left) kms_plane_lowres (tiling-yf)
[216.762979] Starting subtest: tiling-yf
[216.767016] Subtest tiling-yf: SKIP (0.000s)
[216.844789] [023/133] (803s left) kms_flip (2x-flip-vs-dpms-off-vs-modeset)
[216.950962] Starting subtest: 2x-flip-vs-dpms-off-vs-modeset
[216.962022] Subtest 2x-flip-vs-dpms-off-vs-modeset: SKIP (0.010s)
[217.069737] [024/133] (803s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-32bpp-xtile-upscaling)
[217.178723] Starting subtest: flip-64bpp-xtile-to-32bpp-xtile-upscaling
[217.180822] Starting dynamic subtest: pipe-A-default-mode
[219.913721] Dynamic subtest pipe-A-default-mode: SUCCESS (2.734s)
[219.915602] Subtest flip-64bpp-xtile-to-32bpp-xtile-upscaling: SUCCESS (2.735s)
[220.789293] [025/133] (800s left) kms_vrr (flip-basic)
[220.879597] Starting subtest: flip-basic
[220.886126] Subtest flip-basic: SKIP (0.000s)
[220.962536] [026/133] (799s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-mmap-cpu)
[221.060068] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-mmap-cpu
[221.064272] Subtest fbc-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[221.183485] [027/133] (799s left) kms_flip (modeset-vs-vblank-race-interruptible)
[221.284137] Starting subtest: modeset-vs-vblank-race-interruptible
[221.286390] Starting dynamic subtest: A-eDP1
[226.011764] Dynamic subtest A-eDP1: SUCCESS (4.726s)
[226.023482] Starting dynamic subtest: B-eDP1
[230.661802] Dynamic subtest B-eDP1: SUCCESS (4.647s)
[230.673066] Starting dynamic subtest: C-eDP1
[235.267043] Dynamic subtest C-eDP1: SUCCESS (4.604s)
[235.275410] Starting dynamic subtest: D-eDP1
[239.807912] Dynamic subtest D-eDP1: SUCCESS (4.538s)
[239.813390] Subtest modeset-vs-vblank-race-interruptible: SUCCESS (18.526s)
[240.997285] [028/133] (779s left) kms_addfb_basic (bad-pitch-63)
[241.068628] Starting subtest: bad-pitch-63
[241.070854] Subtest bad-pitch-63: SUCCESS (0.000s)
[241.222406] [029/133] (779s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-mmap-wc)
[241.323198] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-mmap-wc
[241.327511] Subtest psr-2p-scndscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[241.465234] [030/133] (779s left) syncobj_wait (invalid-reset-one-illegal-handle)
[241.533192] Starting subtest: invalid-reset-one-illegal-handle
[241.535524] Subtest invalid-reset-one-illegal-handle: SUCCESS (0.000s)
[241.658337] [031/133] (779s left) gem_ctx_persistence (legacy-engines-queued)
[241.717955] Starting subtest: legacy-engines-queued
[241.720471] Starting dynamic subtest: render
[241.854514] Dynamic subtest render: SUCCESS (0.136s)
[241.866256] Starting dynamic subtest: bsd1
[243.171714] Dynamic subtest bsd1: SUCCESS (1.312s)
[243.183747] Starting dynamic subtest: bsd2
[245.217849] Dynamic subtest bsd2: SUCCESS (2.043s)
[245.230413] Starting dynamic subtest: blt
[245.261428] Dynamic subtest blt: SUCCESS (0.042s)
[245.270938] Starting dynamic subtest: vebox
[247.200673] Dynamic subtest vebox: SUCCESS (1.935s)
[247.203666] Subtest legacy-engines-queued: SUCCESS (5.481s)
[247.307305] [032/133] (773s left) syncobj_wait (invalid-single-wait-unsubmitted)
[247.360172] Starting subtest: invalid-single-wait-unsubmitted
[247.362454] Subtest invalid-single-wait-unsubmitted: SUCCESS (0.000s)
[247.479155] [033/133] (773s left) gem_pxp (verify-pxp-stale-ctx-execution)
[247.592704] Starting subtest: verify-pxp-stale-ctx-execution
[248.658102] Subtest verify-pxp-stale-ctx-execution: SUCCESS (1.068s)
[248.817128] [034/133] (772s left) gem_mmap_gtt (cpuset-basic-small-copy-odd)
[248.866369] Subtest cpuset-basic-small-copy-odd: SKIP (0.000s)
[248.943859] [035/133] (772s left) kms_cursor_crc (cursor-onscreen-512x170)
[249.250621] Starting subtest: cursor-onscreen-512x170
[249.255119] Subtest cursor-onscreen-512x170: SKIP (0.001s)
[249.437191] [036/133] (771s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-mmap-cpu)
[249.544299] Starting subtest: psr-1p-primscrn-spr-indfb-draw-mmap-cpu
[256.150552] Subtest psr-1p-primscrn-spr-indfb-draw-mmap-cpu: SUCCESS (6.609s)
[256.286174] [037/133] (765s left) kms_chamelium_color (ctm-0-25)
[256.385975] Subtest ctm-0-25: SKIP (0.000s)
[256.429703] [038/133] (764s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted-signaled)
[256.499122] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted-signaled
[256.606961] Subtest etime-multi-wait-all-for-submit-unsubmitted-signaled: SUCCESS (0.107s)
[256.693424] [039/133] (764s left) gem_exec_fence (syncobj-timeline-unused-fence)
[257.231454] Starting subtest: syncobj-timeline-unused-fence
[257.236994] Subtest syncobj-timeline-unused-fence: SUCCESS (0.007s)
[258.374833] [040/133] (763s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-blt)
[258.489562] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-blt
[258.494018] Subtest fbc-2p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[258.624457] [041/133] (762s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-pwrite)
[258.739498] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-pwrite
[258.743640] Subtest fbc-2p-scndscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[258.869551] [042/133] (762s left) kms_chamelium_frames (hdmi-cmp-planar-formats)
[259.250578] Subtest hdmi-cmp-planar-formats: SKIP (0.000s)
[260.067652] [043/133] (761s left) kms_plane_scaling (plane-downscale-factor-0-5-with-pixel-format)
[260.164686] Starting subtest: plane-downscale-factor-0-5-with-pixel-format
[260.167200] Starting dynamic subtest: pipe-A
[260.187139] Dynamic subtest pipe-A: SKIP (0.017s)
[260.196788] Starting dynamic subtest: pipe-B
[260.220359] Dynamic subtest pipe-B: SKIP (0.031s)
[260.230761] Starting dynamic subtest: pipe-C
[260.260685] Dynamic subtest pipe-C: SKIP (0.040s)
[260.268912] Starting dynamic subtest: pipe-D
[260.291838] Dynamic subtest pipe-D: SKIP (0.031s)
[260.296108] Subtest plane-downscale-factor-0-5-with-pixel-format: SKIP (0.123s)
[260.406295] [044/133] (761s left) gem_render_copy (y-tiled-to-vebox-x-tiled)
[260.464869] Starting subtest: y-tiled-to-vebox-x-tiled
[260.469372] Subtest y-tiled-to-vebox-x-tiled: SKIP (0.000s)
[260.668207] [045/133] (760s left) gen9_exec_parse (batch-without-end)
[260.738124] Subtest batch-without-end: SKIP (0.000s)
[260.825573] [046/133] (760s left) syncobj_timeline (etime-single-wait-submitted)
[260.887151] Starting subtest: etime-single-wait-submitted
[260.991734] Subtest etime-single-wait-submitted: SUCCESS (0.104s)
[261.077561] [047/133] (760s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180-hflip)
[261.186270] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180-hflip
[261.190341] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180-hflip: SKIP (0.000s)
[261.302440] [048/133] (760s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc)
[261.401001] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc
[267.897323] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc: SUCCESS (6.499s)
[268.045366] [049/133] (753s left) kms_ccs (crc-primary-suspend-y-tiled-gen12-rc-ccs)
[268.141959] Starting subtest: crc-primary-suspend-y-tiled-gen12-rc-ccs
[268.144308] Starting dynamic subtest: pipe-A-eDP-1
[268.153540] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[268.163418] Starting dynamic subtest: pipe-B-eDP-1
[268.172568] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[268.180408] Starting dynamic subtest: pipe-C-eDP-1
[268.188988] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[268.196711] Starting dynamic subtest: pipe-D-eDP-1
[268.205349] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[268.209415] Subtest crc-primary-suspend-y-tiled-gen12-rc-ccs: SKIP (0.004s)
[270.473322] [050/133] (751s left) kms_atomic_transition (plane-use-after-nonblocking-unbind)
[270.576698] Starting subtest: plane-use-after-nonblocking-unbind
[270.579344] Starting dynamic subtest: pipe-A-eDP-1
[270.642701] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.067s)
[270.937742] Starting dynamic subtest: pipe-B-eDP-1
[271.764089] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.836s)
[272.073695] Subtest plane-use-after-nonblocking-unbind: SUCCESS (1.498s)
[272.944059] [051/133] (748s left) gem_partial_pwrite_pread (reads-uncached)
[273.013561] Subtest reads-uncached: SKIP (0.000s)
[273.071636] [052/133] (748s left) syncobj_wait (multi-wait-for-submit-unsubmitted-submitted-signaled)
[273.129150] Starting subtest: multi-wait-for-submit-unsubmitted-submitted-signaled
[273.131551] Subtest multi-wait-for-submit-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[273.254013] [053/133] (748s left) i915_pm_rc6_residency (rc6-fence)
[273.313370] Starting subtest: rc6-fence
[273.339661] Starting dynamic subtest: gt0
[285.658487] Dynamic subtest gt0: SUCCESS (12.318s)
[285.669876] Starting dynamic subtest: gt1
[302.146274] Dynamic subtest gt1: SUCCESS (16.483s)
[302.149040] Subtest rc6-fence: SUCCESS (28.833s)
[302.234383] [054/133] (719s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite)
[302.350476] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite
[302.354875] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[302.475197] [055/133] (719s left) kms_frontbuffer_tracking (psr-2p-primscrn-indfb-msflip-blt)
[302.580067] Starting subtest: psr-2p-primscrn-indfb-msflip-blt
[302.584359] Subtest psr-2p-primscrn-indfb-msflip-blt: SKIP (0.000s)
[302.682028] [056/133] (719s left) kms_big_fb (yf-tiled-16bpp-rotate-180)
[302.782775] Starting subtest: yf-tiled-16bpp-rotate-180
[302.787279] Subtest yf-tiled-16bpp-rotate-180: SKIP (0.000s)
[302.890416] [057/133] (719s left) gem_ctx_param (root-set)
[302.957080] Starting subtest: root-set
[302.959429] Subtest root-set: SUCCESS (0.001s)
[303.083441] [058/133] (719s left) gem_exec_fence (syncobj-invalid-wait)
[303.494562] Starting subtest: syncobj-invalid-wait
[303.496993] Subtest syncobj-invalid-wait: SUCCESS (0.000s)
[305.289689] [059/133] (716s left) kms_lease (invalid-create-leases)
[305.392820] Starting subtest: invalid-create-leases
[305.397595] Subtest invalid-create-leases: SUCCESS (0.006s)
[305.524742] [060/133] (716s left) kms_ccs (missing-ccs-buffer-4-tiled-mtl-mc-ccs)
[305.615017] Starting subtest: missing-ccs-buffer-4-tiled-mtl-mc-ccs
[305.617285] Starting dynamic subtest: pipe-A-eDP-1
[305.636825] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.019s)
[305.652151] Starting dynamic subtest: pipe-B-eDP-1
[305.671849] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.019s)
[305.681640] Starting dynamic subtest: pipe-C-eDP-1
[305.701074] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.019s)
[305.709703] Starting dynamic subtest: pipe-D-eDP-1
[305.728166] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.019s)
[305.729951] Subtest missing-ccs-buffer-4-tiled-mtl-mc-ccs: SUCCESS (0.081s)
[307.929589] [061/133] (714s left) kms_sequence (queue-busy)
[308.040844] Starting subtest: queue-busy
[308.043190] Starting dynamic subtest: pipe-A-eDP-1
[309.955723] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.914s)
[309.966299] Starting dynamic subtest: pipe-B-eDP-1
[312.592826] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.638s)
[312.602512] Starting dynamic subtest: pipe-C-eDP-1
[315.207855] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.613s)
[315.217455] Starting dynamic subtest: pipe-D-eDP-1
[317.750716] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.542s)
[317.753046] Subtest queue-busy: SUCCESS (9.712s)
[318.557574] [062/133] (703s left) prime_vgem (basic-fence-blt)
[318.628589] Starting subtest: basic-fence-blt
[318.710320] Subtest basic-fence-blt: SUCCESS (0.081s)
[318.847789] [063/133] (703s left) i915_suspend (basic-s3-without-i915)
[318.881674] Starting subtest: basic-s3-without-i915
[322.313285] Subtest basic-s3-without-i915: SKIP (3.431s)
[323.967454] [064/133] (698s left) i915_module_load (reload-no-display)
[324.002275] Starting subtest: reload-no-display
[330.018212] Subtest reload-no-display: SUCCESS (6.014s)
[330.047545] [FACT i915_module_load (reload-no-display)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[330.049383] [FACT i915_module_load (reload-no-display)] deleted: kernel.kmod_is_loaded.i915: true
[330.053630] [065/133] (692s left) prime_vgem (basic-gtt)
[331.587980] Starting subtest: basic-gtt
[331.592266] Subtest basic-gtt: SKIP (0.000s)
[331.683183] [FACT prime_vgem (basic-gtt)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[331.684355] [FACT prime_vgem (basic-gtt)] new: kernel.kmod_is_loaded.i915: true
[331.687988] [066/133] (690s left) vgem_basic (second-client)
[331.732589] Starting subtest: second-client
[331.753088] Subtest second-client: SUCCESS (0.022s)
[331.824701] [067/133] (690s left) kms_psr (fbc-pr-dpms)
[331.922092] Starting subtest: fbc-pr-dpms
[331.926109] Subtest fbc-pr-dpms: SKIP (0.000s)
[332.005665] [068/133] (690s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-0-hflip)
[332.116350] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-0-hflip
[332.120550] Subtest yf-tiled-max-hw-stride-32bpp-rotate-0-hflip: SKIP (0.000s)
[332.221875] [069/133] (690s left) gem_exec_balancer (full-late)
[332.278741] Starting subtest: full-late
[337.071594] Subtest full-late: SUCCESS (4.792s)
[337.406499] [070/133] (685s left) kms_psr (pr-primary-mmap-gtt)
[337.524005] Starting subtest: pr-primary-mmap-gtt
[337.528406] Subtest pr-primary-mmap-gtt: SKIP (0.000s)
[337.605813] [071/133] (685s left) syncobj_wait (single-wait-all-signaled)
[337.670977] Starting subtest: single-wait-all-signaled
[337.673203] Subtest single-wait-all-signaled: SUCCESS (0.000s)
[337.794375] [072/133] (684s left) kms_ccs (bad-aux-stride-y-tiled-gen12-rc-ccs-cc)
[337.886988] Starting subtest: bad-aux-stride-y-tiled-gen12-rc-ccs-cc
[337.889246] Starting dynamic subtest: pipe-A-eDP-1
[337.911867] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[337.923256] Starting dynamic subtest: pipe-B-eDP-1
[337.944580] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[337.952057] Starting dynamic subtest: pipe-C-eDP-1
[337.973428] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[337.983256] Starting dynamic subtest: pipe-D-eDP-1
[338.005914] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[338.010493] Subtest bad-aux-stride-y-tiled-gen12-rc-ccs-cc: SKIP (0.004s)
[340.129128] [073/133] (682s left) syncobj_timeline (single-wait-all-available-signaled)
[340.192608] Starting subtest: single-wait-all-available-signaled
[340.195041] Subtest single-wait-all-available-signaled: SUCCESS (0.000s)
[340.329740] [074/133] (682s left) kms_addfb_basic (addfb25-x-tiled-legacy)
[340.440876] Subtest addfb25-x-tiled-legacy: SKIP (0.000s)
[340.564521] [075/133] (682s left) gem_exec_capture (userptr)
[340.622161] Starting subtest: userptr
[341.425750] Subtest userptr: SUCCESS (0.806s)
[341.579252] [076/133] (681s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-render)
[341.675724] Starting subtest: fbcpsr-rgb565-draw-render
[348.719466] Subtest fbcpsr-rgb565-draw-render: SUCCESS (7.047s)
[348.869333] [077/133] (674s left) prime_mmap (test_reprime)
[348.932735] Starting subtest: test_reprime
[348.935063] Starting dynamic subtest: test_reprime-smem
[348.960036] Dynamic subtest test_reprime-smem: SUCCESS (0.030s)
[348.962441] Subtest test_reprime: SUCCESS (0.030s)
[349.080704] [078/133] (673s left) syncobj_wait (wait-all-snapshot)
[349.130507] Starting subtest: wait-all-snapshot
[349.210724] Subtest wait-all-snapshot: SUCCESS (0.082s)
[349.299430] [079/133] (673s left) kms_plane_scaling (planes-downscale-factor-0-75-upscale-20x20)
[349.392959] Starting subtest: planes-downscale-factor-0-75-upscale-20x20
[349.395241] Starting dynamic subtest: pipe-A
[349.455104] Dynamic subtest pipe-A: SUCCESS (0.064s)
[349.465470] Starting dynamic subtest: pipe-B
[350.585089] Dynamic subtest pipe-B: SUCCESS (1.129s)
[350.595343] Starting dynamic subtest: pipe-C
[351.687418] Dynamic subtest pipe-C: SUCCESS (1.100s)
[351.695704] Starting dynamic subtest: pipe-D
[352.823789] Dynamic subtest pipe-D: SUCCESS (1.136s)
[352.826095] Subtest planes-downscale-factor-0-75-upscale-20x20: SUCCESS (3.434s)
[353.996085] [080/133] (669s left) gem_softpin (allocator-fork)
[354.052484] Starting subtest: allocator-fork
[356.263048] Subtest allocator-fork: SUCCESS (2.209s)
[356.422163] [081/133] (666s left) api_intel_bb (object-reloc-keep-cache)
[356.488560] Starting subtest: object-reloc-keep-cache
[356.493368] Subtest object-reloc-keep-cache: SKIP (0.003s)
[356.595058] [082/133] (666s left) syncobj_wait (wait-all-for-submit-delayed-submit)
[356.652848] Starting subtest: wait-all-for-submit-delayed-submit
[356.752948] Subtest wait-all-for-submit-delayed-submit: SUCCESS (0.101s)
[356.846808] [083/133] (666s left) kms_color (degamma)
[356.956779] Starting subtest: degamma
[356.958664] Starting dynamic subtest: pipe-A-eDP-1
[357.681112] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.725s)
[357.690396] Starting dynamic subtest: pipe-B-eDP-1
[359.105707] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.424s)
[359.116011] Starting dynamic subtest: pipe-C-eDP-1
[360.487809] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.382s)
[360.498566] Starting dynamic subtest: pipe-D-eDP-1
[361.810563] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.318s)
[361.812754] Subtest degamma: SUCCESS (4.853s)
[362.627647] [084/133] (660s left) gem_userptr_blits (coherency-unsync)
[362.698752] Subtest coherency-unsync: SKIP (0.000s)
[362.831993] [085/133] (660s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip)
[362.934873] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip
[363.558773] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SUCCESS (0.625s)
[363.789250] [086/133] (659s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-180)
[363.902064] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-180
[363.906005] Subtest y-tiled-max-hw-stride-32bpp-rotate-180: SKIP (0.000s)
[364.035924] [087/133] (659s left) kms_plane_scaling (2x-scaler-multi-pipe)
[364.130525] Starting subtest: 2x-scaler-multi-pipe
[364.134667] Subtest 2x-scaler-multi-pipe: SKIP (0.001s)
[364.259829] [088/133] (659s left) gem_exec_parallel (fds)
[364.320861] Starting subtest: fds
[364.323226] Starting dynamic subtest: rcs0
[366.918721] Dynamic subtest rcs0: SUCCESS (2.596s)
[366.930655] Starting dynamic subtest: bcs0
[370.148298] Dynamic subtest bcs0: SUCCESS (3.228s)
[370.159380] Starting dynamic subtest: vcs0
[374.432283] Dynamic subtest vcs0: SUCCESS (4.281s)
[374.443916] Starting dynamic subtest: vcs1
[378.453002] Dynamic subtest vcs1: SUCCESS (4.018s)
[378.465072] Starting dynamic subtest: vecs0
[382.501421] Dynamic subtest vecs0: SUCCESS (4.046s)
[382.511786] Starting dynamic subtest: ccs0
[386.032558] Dynamic subtest ccs0: SUCCESS (3.528s)
[386.035186] Subtest fds: SUCCESS (21.711s)
[386.241197] [089/133] (637s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-mmap-gtt)
[386.345172] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-mmap-gtt
[386.349239] Subtest fbc-2p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[386.493611] [090/133] (636s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-blt)
[386.608821] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-blt
[386.612654] Subtest fbc-2p-scndscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[386.740036] [091/133] (636s left) kms_getfb (getfb2-into-addfb2)
[386.827003] Starting subtest: getfb2-into-addfb2
[386.829278] Subtest getfb2-into-addfb2: SUCCESS (0.000s)
[386.952721] [092/133] (636s left) kms_flip (busy-flip)
[387.045350] Starting subtest: busy-flip
[387.047640] Starting dynamic subtest: A-eDP1
[388.728651] Dynamic subtest A-eDP1: SUCCESS (1.683s)
[388.738128] Starting dynamic subtest: B-eDP1
[390.353191] Dynamic subtest B-eDP1: SUCCESS (1.623s)
[390.362358] Starting dynamic subtest: C-eDP1
[391.995702] Dynamic subtest C-eDP1: SUCCESS (1.640s)
[392.006347] Starting dynamic subtest: D-eDP1
[393.627153] Dynamic subtest D-eDP1: SUCCESS (1.631s)
[393.629743] Subtest busy-flip: SUCCESS (6.586s)
[394.903638] [093/133] (628s left) gem_ctx_sseu (mmap-args)
[394.971387] Subtest mmap-args: SKIP (0.000s)
[395.045196] [094/133] (628s left) kms_cursor_crc (cursor-random-32x32)
[395.175857] Starting subtest: cursor-random-32x32
[395.225594] Subtest cursor-random-32x32: SKIP (0.045s)
[395.533789] [095/133] (628s left) kms_ccs (ccs-on-another-bo-y-tiled-gen12-rc-ccs-cc)
[395.619646] Starting subtest: ccs-on-another-bo-y-tiled-gen12-rc-ccs-cc
[395.621784] Starting dynamic subtest: pipe-A-eDP-1
[395.643309] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[395.653826] Starting dynamic subtest: pipe-B-eDP-1
[395.674590] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[395.683318] Starting dynamic subtest: pipe-C-eDP-1
[395.704489] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[395.713080] Starting dynamic subtest: pipe-D-eDP-1
[395.734766] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[395.739084] Subtest ccs-on-another-bo-y-tiled-gen12-rc-ccs-cc: SKIP (0.004s)
[397.876563] [096/133] (625s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-mmap-cpu)
[397.989692] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-mmap-cpu
[401.948765] Subtest fbc-1p-offscreen-pri-shrfb-draw-mmap-cpu: SUCCESS (3.963s)
[403.097931] [097/133] (620s left) gem_exec_schedule (u-submit-late-slice)
[403.174215] Starting subtest: u-submit-late-slice
[403.176198] Starting dynamic subtest: rcs0
[403.204410] Dynamic subtest rcs0: SUCCESS (0.038s)
[403.215832] Starting dynamic subtest: bcs0
[403.238532] Dynamic subtest bcs0: SUCCESS (0.033s)
[403.255570] Starting dynamic subtest: vcs0
[403.267317] Dynamic subtest vcs0: SUCCESS (0.028s)
[403.278863] Starting dynamic subtest: vcs1
[403.302224] Dynamic subtest vcs1: SUCCESS (0.034s)
[403.312436] Starting dynamic subtest: vecs0
[403.332516] Dynamic subtest vecs0: SUCCESS (0.030s)
[403.341630] Starting dynamic subtest: ccs0
[403.361520] Dynamic subtest ccs0: SUCCESS (0.028s)
[403.363680] Subtest u-submit-late-slice: SUCCESS (0.196s)
[405.359240] [098/133] (618s left) kms_frontbuffer_tracking (fbcpsr-stridechange)
[405.466048] Starting subtest: fbcpsr-stridechange
[411.706084] Subtest fbcpsr-stridechange: SUCCESS (6.242s)
[411.864668] [099/133] (611s left) dumb_buffer (map-valid)
[411.928487] Starting subtest: map-valid
[411.930774] Subtest map-valid: SUCCESS (0.000s)
[412.046502] [100/133] (611s left) perf_pmu (idle)
[412.084853] Starting subtest: idle
[412.087428] Starting dynamic subtest: rcs0
[412.650972] Dynamic subtest rcs0: SUCCESS (0.567s)
[412.660985] Starting dynamic subtest: bcs0
[413.166885] Dynamic subtest bcs0: SUCCESS (0.513s)
[413.176855] Starting dynamic subtest: vcs0
[413.698439] Dynamic subtest vcs0: SUCCESS (0.524s)
[413.707997] Starting dynamic subtest: vcs1
[414.215824] Dynamic subtest vcs1: SUCCESS (0.511s)
[414.226907] Starting dynamic subtest: vecs0
[414.742667] Dynamic subtest vecs0: SUCCESS (0.531s)
[414.755135] Starting dynamic subtest: ccs0
[415.269972] Dynamic subtest ccs0: SUCCESS (0.524s)
[415.272829] Subtest idle: SUCCESS (3.188s)
[415.414727] [101/133] (608s left) kms_pm_rpm (i2c)
[417.339845] Starting subtest: i2c
[422.658963] Subtest i2c: SUCCESS (5.319s)
[422.757027] [102/133] (601s left) kms_big_fb (linear-64bpp-rotate-180)
[422.867771] Starting subtest: linear-64bpp-rotate-180
[424.428806] Subtest linear-64bpp-rotate-180: SUCCESS (1.561s)
[424.609119] [103/133] (599s left) kms_feature_discovery (dp-mst)
[424.716622] Starting subtest: dp-mst
[424.721000] Subtest dp-mst: SKIP (0.000s)
[424.802102] [104/133] (599s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-blt)
[424.902696] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-blt
[424.906231] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-blt: SKIP (0.000s)
[425.024893] [105/133] (599s left) kms_pipe_stress (stress-xrgb8888-untiled)
[425.118933] Starting subtest: stress-xrgb8888-untiled
[430.958901] Subtest stress-xrgb8888-untiled: SUCCESS (5.842s)
[431.011276] [106/133] (593s left) gem_softpin (invalid)
[431.072319] Starting subtest: invalid
[431.080148] Subtest invalid: SUCCESS (0.007s)
[431.222478] [107/133] (592s left) kms_psr2_sf (fbc-psr2-overlay-plane-update-continuous-sf)
[436.221746] Starting subtest: fbc-psr2-overlay-plane-update-continuous-sf
[436.224140] Starting dynamic subtest: pipe-A-eDP-1
[437.013896] Dynamic subtest pipe-A-eDP-1: SKIP (0.790s)
[437.023410] Starting dynamic subtest: pipe-B-eDP-1
[438.150777] Dynamic subtest pipe-B-eDP-1: SKIP (1.134s)
[438.154976] Subtest fbc-psr2-overlay-plane-update-continuous-sf: SKIP (1.928s)
[439.344915] [108/133] (584s left) kms_rotation_crc (primary-x-tiled-reflect-x-0)
[439.449967] Starting subtest: primary-x-tiled-reflect-x-0
[446.677074] Subtest primary-x-tiled-reflect-x-0: SUCCESS (7.228s)
[447.917432] [109/133] (576s left) i915_drm_fdinfo (busy)
[447.967311] Starting subtest: busy
[447.969472] Starting dynamic subtest: rcs0
[447.986903] Dynamic subtest rcs0: SKIP (0.018s)
[447.996792] Starting dynamic subtest: bcs0
[448.005554] Dynamic subtest bcs0: SKIP (0.018s)
[448.014586] Starting dynamic subtest: vcs0
[448.018598] Dynamic subtest vcs0: SKIP (0.001s)
[448.027655] Starting dynamic subtest: vcs1
[448.031898] Dynamic subtest vcs1: SKIP (0.001s)
[448.041040] Starting dynamic subtest: vecs0
[448.045074] Dynamic subtest vecs0: SKIP (0.000s)
[448.053640] Starting dynamic subtest: ccs0
[448.057589] Dynamic subtest ccs0: SKIP (0.000s)
[448.061568] Subtest busy: SKIP (0.046s)
[448.101444] [110/133] (576s left) kms_big_fb (linear-max-hw-stride-64bpp-rotate-180-hflip)
[448.204213] Starting subtest: linear-max-hw-stride-64bpp-rotate-180-hflip
[448.208222] Subtest linear-max-hw-stride-64bpp-rotate-180-hflip: SKIP (0.000s)
[448.314337] [111/133] (576s left) kms_scaling_modes (scaling-mode-full)
[448.414141] Starting subtest: scaling-mode-full
[448.416428] Starting dynamic subtest: pipe-A-eDP-1
[448.505911] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.094s)
[448.516009] Starting dynamic subtest: pipe-B-eDP-1
[449.645413] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.138s)
[449.656188] Starting dynamic subtest: pipe-C-eDP-1
[450.850147] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.203s)
[450.859369] Starting dynamic subtest: pipe-D-eDP-1
[451.998045] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.147s)
[452.000280] Subtest scaling-mode-full: SUCCESS (3.587s)
[453.151042] [112/133] (571s left) kms_psr2_sf (fbc-psr2-overlay-plane-move-continuous-exceed-fully-sf)
[458.140016] Starting subtest: fbc-psr2-overlay-plane-move-continuous-exceed-fully-sf
[458.142441] Starting dynamic subtest: pipe-A-eDP-1
[458.937237] Dynamic subtest pipe-A-eDP-1: SKIP (0.795s)
[458.947478] Starting dynamic subtest: pipe-B-eDP-1
[460.064825] Dynamic subtest pipe-B-eDP-1: SKIP (1.126s)
[460.069015] Subtest fbc-psr2-overlay-plane-move-continuous-exceed-fully-sf: SKIP (1.925s)
[461.279415] [113/133] (563s left) gem_exec_schedule (preemptive-hang)
[461.452956] Starting subtest: preemptive-hang
[461.455761] Starting dynamic subtest: rcs0
[470.321186] Dynamic subtest rcs0: SUCCESS (8.867s)
[470.329733] Starting dynamic subtest: bcs0
[479.339729] Dynamic subtest bcs0: SUCCESS (9.018s)
[479.350997] Starting dynamic subtest: vcs0
[488.369759] Dynamic subtest vcs0: SUCCESS (9.030s)
[488.378750] Starting dynamic subtest: vcs1
[497.322679] Dynamic subtest vcs1: SUCCESS (8.950s)
[497.332903] Starting dynamic subtest: vecs0
[506.341172] Dynamic subtest vecs0: SUCCESS (9.017s)
[506.349999] Starting dynamic subtest: ccs0
[515.382432] Dynamic subtest ccs0: SUCCESS (9.038s)
[515.384812] Subtest preemptive-hang: SUCCESS (53.929s)
[515.637643] [114/133] (508s left) syncobj_timeline (multi-wait-all-for-submit-available-submitted)
[515.684964] Starting subtest: multi-wait-all-for-submit-available-submitted
[515.687238] Subtest multi-wait-all-for-submit-available-submitted: SUCCESS (0.000s)
[515.807356] [115/133] (508s left) perf (per-context-mode-unprivileged)
[515.972573] Starting subtest: per-context-mode-unprivileged
[515.977070] Subtest per-context-mode-unprivileged: SKIP (0.000s)
[516.014319] [116/133] (508s left) gem_exec_reloc (basic-gtt-noreloc)
[516.083408] Subtest basic-gtt-noreloc: SKIP (0.000s)
[516.154065] [117/133] (508s left) kms_flip (2x-flip-vs-dpms)
[516.259240] Starting subtest: 2x-flip-vs-dpms
[516.283234] Subtest 2x-flip-vs-dpms: SKIP (0.023s)
[516.387685] [118/133] (508s left) gem_ctx_exec (basic-close-race)
[516.451246] Starting subtest: basic-close-race
[522.257320] Subtest basic-close-race: SUCCESS (5.805s)
[522.412025] [119/133] (502s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-gtt)
[522.526613] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-gtt
[522.531210] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[522.650834] [120/133] (502s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-64bpp-yftile-upscaling)
[522.751902] Starting subtest: flip-32bpp-yftile-to-64bpp-yftile-upscaling
[522.756324] Subtest flip-32bpp-yftile-to-64bpp-yftile-upscaling: SKIP (0.000s)
[522.837540] [121/133] (501s left) gem_ctx_param (invalid-get-no-zeromap)
[522.901733] Starting subtest: invalid-get-no-zeromap
[522.904095] Subtest invalid-get-no-zeromap: SUCCESS (0.001s)
[523.020017] [122/133] (501s left) dumb_buffer (invalid-bpp)
[523.071138] Starting subtest: invalid-bpp
[523.073561] Subtest invalid-bpp: SUCCESS (0.000s)
[523.193448] [123/133] (501s left) kms_addfb_basic (basic)
[523.256705] Starting subtest: basic
[523.258663] Subtest basic: SUCCESS (0.000s)
[523.409492] [124/133] (501s left) kms_plane (pixel-format-4-tiled-modifier-source-clamping)
[523.495939] Starting subtest: pixel-format-4-tiled-modifier-source-clamping
[523.522133] Starting dynamic subtest: pipe-A-plane-0
[524.144999] Dynamic subtest pipe-A-plane-0: SUCCESS (0.622s)
[524.159296] Starting dynamic subtest: pipe-A-plane-3
[524.521908] Dynamic subtest pipe-A-plane-3: SUCCESS (0.377s)
[524.530695] Starting dynamic subtest: pipe-A-plane-5
[524.534179] Dynamic subtest pipe-A-plane-5: SKIP (0.000s)
[525.626619] Starting dynamic subtest: pipe-B-plane-0
[526.229835] Dynamic subtest pipe-B-plane-0: SUCCESS (0.611s)
[526.239058] Starting dynamic subtest: pipe-B-plane-3
[526.662858] Dynamic subtest pipe-B-plane-3: SUCCESS (0.433s)
[526.671463] Starting dynamic subtest: pipe-B-plane-5
[526.674873] Dynamic subtest pipe-B-plane-5: SKIP (0.000s)
[526.985718] Subtest pixel-format-4-tiled-modifier-source-clamping: SUCCESS (3.488s)
[527.806128] [125/133] (497s left) perf_pmu (busy-double-start)
[527.844280] Starting subtest: busy-double-start
[527.846664] Starting dynamic subtest: rcs0
[531.485912] Dynamic subtest rcs0: FAIL (3.587s)
[531.497204] Starting dynamic subtest: bcs0
[535.004173] Dynamic subtest bcs0: SUCCESS (3.571s)
[535.016512] Starting dynamic subtest: vcs0
[538.757706] Dynamic subtest vcs0: SUCCESS (3.752s)
[538.768051] Starting dynamic subtest: vcs1
[542.727777] Dynamic subtest vcs1: SUCCESS (3.968s)
[542.739421] Starting dynamic subtest: vecs0
[546.757071] Dynamic subtest vecs0: SUCCESS (4.027s)
[546.768783] Starting dynamic subtest: ccs0
[550.392135] Dynamic subtest ccs0: FAIL (3.565s)
[550.394390] Subtest busy-double-start: FAIL (22.480s)
[550.459977] [126/133] (474s left) gem_ctx_param (basic-default)
[550.509685] Starting subtest: basic-default
[550.512076] Subtest basic-default: SUCCESS (0.000s)
[550.599815] [127/133] (474s left) gem_mmap_gtt (big-bo-tiledx)
[550.665363] Subtest big-bo-tiledX: SKIP (0.000s)
[550.731032] [128/133] (474s left) gem_userptr_blits (stress-mm)
[550.799570] Starting subtest: stress-mm
[556.172299] Subtest stress-mm: SUCCESS (5.369s)
[556.317219] [129/133] (468s left) prime_vgem (fence-read-hang)
[556.406200] Subtest fence-read-hang: SKIP (0.000s)
[556.536426] [130/133] (468s left) kms_flip (2x-flip-vs-expired-vblank-interruptible)
[556.634634] Starting subtest: 2x-flip-vs-expired-vblank-interruptible
[556.645845] Subtest 2x-flip-vs-expired-vblank-interruptible: SKIP (0.010s)
[556.766291] [131/133] (468s left) kms_psr (fbc-psr-primary-render)
[556.868354] Starting subtest: fbc-psr-primary-render
[556.870254] Starting dynamic subtest: eDP-1
[556.874309] Dynamic subtest eDP-1: SKIP (0.000s)
[556.878390] Subtest fbc-psr-primary-render: SKIP (0.001s)
[556.966842] [132/133] (468s left) kms_frontbuffer_tracking (psr-modesetfrombusy)
[557.073611] Starting subtest: psr-modesetfrombusy
[563.246172] Subtest psr-modesetfrombusy: SUCCESS (6.176s)
[563.430611] [133/133] (461s left) kms_pm_rpm (system-suspend-modeset)
[565.452599] Starting subtest: system-suspend-modeset
[584.895831] Subtest system-suspend-modeset: SUCCESS (4.628s)
[585.284839] 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.