[58.113465] Initializing watchdogs
[58.113513]   /dev/watchdog0
[58.127294] [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.131884] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[58.134186] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[58.137556] [001/133] (960s left) kms_frontbuffer_tracking (fbcpsr-farfromfence-mmap-gtt)
[58.263740] Starting subtest: fbcpsr-farfromfence-mmap-gtt
[58.268384] Subtest fbcpsr-farfromfence-mmap-gtt: SKIP (0.000s)
[58.383156] [002/133] (960s left) syncobj_timeline (wait-for-submit-delayed-submit)
[58.447057] Starting subtest: wait-for-submit-delayed-submit
[58.551723] Subtest wait-for-submit-delayed-submit: SUCCESS (0.103s)
[58.651105] [003/133] (960s left) kms_chamelium_hpd (dp-hpd)
[59.036442] Subtest dp-hpd: SKIP (0.000s)
[59.871090] [004/133] (958s left) kms_cursor_edge_walk (256x256-top-bottom)
[59.968409] Starting subtest: 256x256-top-bottom
[59.974527] Starting dynamic subtest: pipe-A-eDP-1
[63.485104] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.498s)
[63.493723] Starting dynamic subtest: pipe-D-eDP-1
[66.612882] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.117s)
[66.615570] Subtest 256x256-top-bottom: SUCCESS (6.617s)
[67.466160] [005/133] (951s left) gem_mmap_offset (clear)
[67.587436] Starting subtest: clear
[67.590113] Starting dynamic subtest: smem0
[93.058201] Dynamic subtest smem0: SUCCESS (25.449s)
[93.060604] Subtest clear: SUCCESS (25.450s)
[93.208511] [006/133] (925s left) kms_joiner (basic-force-big-joiner)
[93.353286] Starting subtest: basic-force-big-joiner
[93.357269] Subtest basic-force-big-joiner: SKIP (0.000s)
[93.428660] [007/133] (925s left) gem_exec_balancer (waits)
[93.492616] Starting subtest: waits
[99.947995] Subtest waits: SUCCESS (6.453s)
[100.287189] [008/133] (918s left) gem_exec_whisper (basic-queues)
[100.355817] Starting subtest: basic-queues
[107.894266] Subtest basic-queues: SUCCESS (7.532s)
[108.082250] [009/133] (910s left) gem_exec_suspend (basic-s3)
[108.147843] Starting subtest: basic-S3
[108.150197] Starting dynamic subtest: smem
[128.724057] Dynamic subtest smem: SUCCESS (6.706s)
[128.726934] Subtest basic-S3: SUCCESS (6.707s)
[128.919978] [010/133] (890s left) kms_psr (psr2-sprite-render)
[129.045749] Starting subtest: psr2-sprite-render
[129.048001] Starting dynamic subtest: eDP-1
[130.824037] Dynamic subtest eDP-1: SUCCESS (1.731s)
[130.826536] Subtest psr2-sprite-render: SUCCESS (1.732s)
[131.735080] [011/133] (887s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-mmap-wc)
[131.856048] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-mmap-wc
[138.610599] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-mmap-wc: SUCCESS (6.666s)
[138.773644] [012/133] (880s left) kms_content_protection (atomic)
[138.921085] Starting subtest: atomic
[138.925595] Subtest atomic: SKIP (0.000s)
[139.071805] [013/133] (880s left) kms_async_flips (invalid-async-flip)
[139.175798] Starting subtest: invalid-async-flip
[139.551797] Starting dynamic subtest: pipe-A-eDP-1
[140.379963] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.822s)
[140.742275] Starting dynamic subtest: pipe-B-eDP-1
[141.519924] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.781s)
[141.884015] Starting dynamic subtest: pipe-C-eDP-1
[142.652443] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.771s)
[143.014524] Starting dynamic subtest: pipe-D-eDP-1
[143.787599] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.777s)
[143.790021] Subtest invalid-async-flip: SUCCESS (4.586s)
[144.970162] [014/133] (874s left) kms_flip (blocking-absolute-wf_vblank)
[145.077505] Starting subtest: blocking-absolute-wf_vblank
[145.079771] Starting dynamic subtest: A-eDP1
[153.840797] Dynamic subtest A-eDP1: SUCCESS (8.743s)
[153.855459] Starting dynamic subtest: B-eDP1
[162.576121] Dynamic subtest B-eDP1: SUCCESS (8.729s)
[162.584633] Starting dynamic subtest: C-eDP1
[171.296478] Dynamic subtest C-eDP1: SUCCESS (8.720s)
[171.310472] Starting dynamic subtest: D-eDP1
[180.025867] Dynamic subtest D-eDP1: SUCCESS (8.726s)
[180.030810] Subtest blocking-absolute-wf_vblank: SUCCESS (34.926s)
[181.264654] [015/133] (837s left) gem_exec_schedule (reorder-wide)
[181.454853] Subtest reorder-wide: SKIP (0.000s)
[181.645782] [016/133] (837s left) gem_watchdog (default-virtual)
[181.710276] Starting subtest: default-virtual
[187.986224] Subtest default-virtual: SUCCESS (6.283s)
[188.087126] [017/133] (831s left) gem_pwrite (basic-self)
[188.150537] Subtest basic-self: SKIP (0.000s)
[188.215867] [018/133] (831s left) kms_psr (fbc-psr2-cursor-mmap-gtt)
[188.318379] Starting subtest: fbc-psr2-cursor-mmap-gtt
[188.320442] Starting dynamic subtest: eDP-1
[188.324637] Dynamic subtest eDP-1: SKIP (0.000s)
[188.328787] Subtest fbc-psr2-cursor-mmap-gtt: SKIP (0.001s)
[188.412431] [019/133] (830s left) kms_cursor_legacy (forked-move)
[188.536281] Starting subtest: forked-move
[188.538145] Starting dynamic subtest: pipe-A
[193.997731] Dynamic subtest pipe-A: SUCCESS (5.456s)
[194.010454] Starting dynamic subtest: pipe-B
[199.463240] Dynamic subtest pipe-B: SUCCESS (5.463s)
[199.475743] Starting dynamic subtest: pipe-C
[204.945565] Dynamic subtest pipe-C: SUCCESS (5.479s)
[204.958175] Starting dynamic subtest: pipe-D
[210.415247] Dynamic subtest pipe-D: SUCCESS (5.466s)
[210.426441] Starting dynamic subtest: all-pipes
[215.912255] Dynamic subtest all-pipes: SUCCESS (5.494s)
[215.914660] Subtest forked-move: SUCCESS (27.364s)
[216.070287] [020/133] (803s left) vgem_basic (debugfs)
[216.190506] Starting subtest: debugfs
[216.192780] Subtest debugfs: SUCCESS (0.000s)
[216.270572] [FACT vgem_basic (debugfs)] new: kernel.kmod_is_loaded.vgem: true
[216.273847] [021/133] (803s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-pwrite)
[216.400847] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-pwrite
[216.404900] Subtest fbc-2p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[216.538237] [022/133] (802s left) kms_plane_lowres (tiling-yf)
[216.643537] Starting subtest: tiling-yf
[216.647642] Subtest tiling-yf: SKIP (0.000s)
[216.744373] [023/133] (802s left) kms_flip (2x-flip-vs-dpms-off-vs-modeset)
[216.844230] Starting subtest: 2x-flip-vs-dpms-off-vs-modeset
[216.854979] Subtest 2x-flip-vs-dpms-off-vs-modeset: SKIP (0.010s)
[216.993449] [024/133] (802s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-32bpp-xtile-upscaling)
[217.094186] Starting subtest: flip-64bpp-xtile-to-32bpp-xtile-upscaling
[217.096148] Starting dynamic subtest: pipe-A-default-mode
[219.785254] Dynamic subtest pipe-A-default-mode: SUCCESS (2.689s)
[219.787626] Subtest flip-64bpp-xtile-to-32bpp-xtile-upscaling: SUCCESS (2.691s)
[220.666098] [025/133] (799s left) kms_vrr (flip-basic)
[220.765481] Starting subtest: flip-basic
[220.771489] Subtest flip-basic: SKIP (0.000s)
[220.860563] [026/133] (798s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-mmap-cpu)
[220.955015] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-mmap-cpu
[220.959301] Subtest fbc-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[221.070074] [027/133] (798s left) kms_flip (modeset-vs-vblank-race-interruptible)
[221.177305] Starting subtest: modeset-vs-vblank-race-interruptible
[221.182441] Starting dynamic subtest: A-eDP1
[225.850315] Dynamic subtest A-eDP1: SUCCESS (4.671s)
[225.861949] Starting dynamic subtest: B-eDP1
[230.467737] Dynamic subtest B-eDP1: SUCCESS (4.617s)
[230.479156] Starting dynamic subtest: C-eDP1
[235.071242] Dynamic subtest C-eDP1: SUCCESS (4.604s)
[235.081198] Starting dynamic subtest: D-eDP1
[239.701124] Dynamic subtest D-eDP1: SUCCESS (4.629s)
[239.703475] Subtest modeset-vs-vblank-race-interruptible: SUCCESS (18.533s)
[240.883115] [028/133] (778s left) kms_addfb_basic (bad-pitch-63)
[240.939775] Starting subtest: bad-pitch-63
[240.941719] Subtest bad-pitch-63: SUCCESS (0.000s)
[241.107482] [029/133] (778s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-mmap-wc)
[241.221321] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-mmap-wc
[241.225748] Subtest psr-2p-scndscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[241.339349] [030/133] (778s left) syncobj_wait (invalid-reset-one-illegal-handle)
[241.408472] Starting subtest: invalid-reset-one-illegal-handle
[241.410566] Subtest invalid-reset-one-illegal-handle: SUCCESS (0.000s)
[241.539240] [031/133] (778s left) gem_ctx_persistence (legacy-engines-queued)
[241.588891] Starting subtest: legacy-engines-queued
[241.591140] Starting dynamic subtest: render
[241.667949] Dynamic subtest render: SUCCESS (0.078s)
[241.679677] Starting dynamic subtest: bsd1
[243.700029] Dynamic subtest bsd1: SUCCESS (2.029s)
[243.711763] Starting dynamic subtest: bsd2
[245.683473] Dynamic subtest bsd2: SUCCESS (1.979s)
[245.694159] Starting dynamic subtest: blt
[245.710042] Dynamic subtest blt: SUCCESS (0.027s)
[245.718256] Starting dynamic subtest: vebox
[247.665237] Dynamic subtest vebox: SUCCESS (1.952s)
[247.669759] Subtest legacy-engines-queued: SUCCESS (6.077s)
[247.758271] [032/133] (772s left) syncobj_wait (invalid-single-wait-unsubmitted)
[247.813274] Starting subtest: invalid-single-wait-unsubmitted
[247.815520] Subtest invalid-single-wait-unsubmitted: SUCCESS (0.000s)
[247.939161] [033/133] (772s left) gem_pxp (verify-pxp-stale-ctx-execution)
[248.063146] Starting subtest: verify-pxp-stale-ctx-execution
[249.130179] Subtest verify-pxp-stale-ctx-execution: SUCCESS (1.066s)
[249.285057] [034/133] (770s left) gem_mmap_gtt (cpuset-basic-small-copy-odd)
[249.337006] Subtest cpuset-basic-small-copy-odd: SKIP (0.000s)
[249.403676] [035/133] (770s left) kms_cursor_crc (cursor-onscreen-512x170)
[249.686483] Starting subtest: cursor-onscreen-512x170
[249.691676] Subtest cursor-onscreen-512x170: SKIP (0.002s)
[249.867378] [036/133] (770s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-mmap-cpu)
[249.978285] Starting subtest: psr-1p-primscrn-spr-indfb-draw-mmap-cpu
[256.573178] Subtest psr-1p-primscrn-spr-indfb-draw-mmap-cpu: SUCCESS (6.598s)
[256.702423] [037/133] (763s left) kms_chamelium_color (ctm-0-25)
[256.799944] Subtest ctm-0-25: SKIP (0.000s)
[256.845836] [038/133] (763s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted-signaled)
[256.903071] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted-signaled
[257.008187] Subtest etime-multi-wait-all-for-submit-unsubmitted-signaled: SUCCESS (0.105s)
[257.109833] [039/133] (763s left) gem_exec_fence (syncobj-timeline-unused-fence)
[257.636313] Starting subtest: syncobj-timeline-unused-fence
[257.641350] Subtest syncobj-timeline-unused-fence: SUCCESS (0.006s)
[258.850844] [040/133] (761s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-blt)
[258.953247] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-blt
[258.957332] Subtest fbc-2p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[259.103950] [041/133] (761s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-pwrite)
[259.200379] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-pwrite
[259.204555] Subtest fbc-2p-scndscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[259.326515] [042/133] (761s left) kms_chamelium_frames (hdmi-cmp-planar-formats)
[259.726018] Subtest hdmi-cmp-planar-formats: SKIP (0.000s)
[260.523876] [043/133] (759s left) kms_plane_scaling (plane-downscale-factor-0-5-with-pixel-format)
[260.625785] Starting subtest: plane-downscale-factor-0-5-with-pixel-format
[260.628152] Starting dynamic subtest: pipe-A
[260.647655] Dynamic subtest pipe-A: SKIP (0.017s)
[260.657844] Starting dynamic subtest: pipe-B
[260.678625] Dynamic subtest pipe-B: SKIP (0.031s)
[260.692325] Starting dynamic subtest: pipe-C
[260.709364] Dynamic subtest pipe-C: SKIP (0.030s)
[260.719887] Starting dynamic subtest: pipe-D
[260.739543] Dynamic subtest pipe-D: SKIP (0.030s)
[260.743277] Subtest plane-downscale-factor-0-5-with-pixel-format: SKIP (0.111s)
[260.854587] [044/133] (759s left) gem_render_copy (y-tiled-to-vebox-x-tiled)
[260.915005] Starting subtest: y-tiled-to-vebox-x-tiled
[260.919465] Subtest y-tiled-to-vebox-x-tiled: SKIP (0.000s)
[261.111350] [045/133] (759s left) gen9_exec_parse (batch-without-end)
[261.174036] Subtest batch-without-end: SKIP (0.000s)
[261.279397] [046/133] (759s left) syncobj_timeline (etime-single-wait-submitted)
[261.334337] Starting subtest: etime-single-wait-submitted
[261.440153] Subtest etime-single-wait-submitted: SUCCESS (0.105s)
[261.539714] [047/133] (759s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180-hflip)
[261.653994] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180-hflip
[261.658366] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180-hflip: SKIP (0.000s)
[261.782513] [048/133] (758s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc)
[261.890009] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc
[268.532025] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc: SUCCESS (6.644s)
[268.714729] [049/133] (752s left) kms_ccs (crc-primary-suspend-y-tiled-gen12-rc-ccs)
[268.811918] Starting subtest: crc-primary-suspend-y-tiled-gen12-rc-ccs
[268.814128] Starting dynamic subtest: pipe-A-eDP-1
[268.823147] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[268.837524] Starting dynamic subtest: pipe-B-eDP-1
[268.846348] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[268.855804] Starting dynamic subtest: pipe-C-eDP-1
[268.864081] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[268.872576] Starting dynamic subtest: pipe-D-eDP-1
[268.880908] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[268.884875] Subtest crc-primary-suspend-y-tiled-gen12-rc-ccs: SKIP (0.005s)
[271.063096] [050/133] (749s left) kms_atomic_transition (plane-use-after-nonblocking-unbind)
[271.165630] Starting subtest: plane-use-after-nonblocking-unbind
[271.168046] Starting dynamic subtest: pipe-A-eDP-1
[271.229428] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.065s)
[271.549843] Starting dynamic subtest: pipe-B-eDP-1
[272.358440] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.818s)
[272.652900] Subtest plane-use-after-nonblocking-unbind: SUCCESS (1.487s)
[273.526558] [051/133] (747s left) gem_partial_pwrite_pread (reads-uncached)
[273.590272] Subtest reads-uncached: SKIP (0.000s)
[273.678449] [052/133] (747s left) syncobj_wait (multi-wait-for-submit-unsubmitted-submitted-signaled)
[273.738286] Starting subtest: multi-wait-for-submit-unsubmitted-submitted-signaled
[273.740212] Subtest multi-wait-for-submit-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[273.851384] [053/133] (747s left) i915_pm_rc6_residency (rc6-fence)
[273.909648] Starting subtest: rc6-fence
[273.951589] Starting dynamic subtest: gt0
[286.273471] Dynamic subtest gt0: SUCCESS (12.319s)
[286.285119] Starting dynamic subtest: gt1
[301.651382] Dynamic subtest gt1: SUCCESS (15.371s)
[301.654381] Subtest rc6-fence: SUCCESS (27.737s)
[301.740371] [054/133] (719s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite)
[301.847770] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite
[301.851662] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[301.969146] [055/133] (719s left) kms_frontbuffer_tracking (psr-2p-primscrn-indfb-msflip-blt)
[302.062241] Starting subtest: psr-2p-primscrn-indfb-msflip-blt
[302.066291] Subtest psr-2p-primscrn-indfb-msflip-blt: SKIP (0.000s)
[302.190043] [056/133] (718s left) kms_big_fb (yf-tiled-16bpp-rotate-180)
[302.295152] Starting subtest: yf-tiled-16bpp-rotate-180
[302.299427] Subtest yf-tiled-16bpp-rotate-180: SKIP (0.000s)
[302.436588] [057/133] (718s left) gem_ctx_param (root-set)
[302.507121] Starting subtest: root-set
[302.509001] Subtest root-set: SUCCESS (0.001s)
[302.610222] [058/133] (718s left) gem_exec_fence (syncobj-invalid-wait)
[303.030470] Starting subtest: syncobj-invalid-wait
[303.032968] Subtest syncobj-invalid-wait: SUCCESS (0.001s)
[304.856516] [059/133] (716s left) kms_lease (invalid-create-leases)
[304.949483] Starting subtest: invalid-create-leases
[304.953920] Subtest invalid-create-leases: SUCCESS (0.006s)
[305.093146] [060/133] (716s left) kms_ccs (missing-ccs-buffer-4-tiled-mtl-mc-ccs)
[305.206491] Starting subtest: missing-ccs-buffer-4-tiled-mtl-mc-ccs
[305.208638] Starting dynamic subtest: pipe-A-eDP-1
[305.230494] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.023s)
[305.239825] Starting dynamic subtest: pipe-B-eDP-1
[305.259840] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.020s)
[305.268684] Starting dynamic subtest: pipe-C-eDP-1
[305.288051] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.021s)
[305.297134] Starting dynamic subtest: pipe-D-eDP-1
[305.317004] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.019s)
[305.319195] Subtest missing-ccs-buffer-4-tiled-mtl-mc-ccs: SUCCESS (0.088s)
[307.608494] [061/133] (713s left) kms_sequence (queue-busy)
[307.704771] Starting subtest: queue-busy
[307.707079] Starting dynamic subtest: pipe-A-eDP-1
[309.620468] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.914s)
[309.630119] Starting dynamic subtest: pipe-B-eDP-1
[312.201534] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.581s)
[312.210550] Starting dynamic subtest: pipe-C-eDP-1
[314.840987] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.635s)
[314.850860] Starting dynamic subtest: pipe-D-eDP-1
[317.449745] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.606s)
[317.451938] Subtest queue-busy: SUCCESS (9.742s)
[318.274422] [062/133] (703s left) prime_vgem (basic-fence-blt)
[318.371390] Starting subtest: basic-fence-blt
[318.452219] Subtest basic-fence-blt: SUCCESS (0.081s)
[318.603671] [063/133] (702s left) i915_suspend (basic-s3-without-i915)
[318.643890] Starting subtest: basic-s3-without-i915
[322.076963] Subtest basic-s3-without-i915: SKIP (3.427s)
[323.777104] [064/133] (697s left) i915_module_load (reload-no-display)
[323.820338] Starting subtest: reload-no-display
[328.354141] Subtest reload-no-display: SUCCESS (4.534s)
[328.383161] [FACT i915_module_load (reload-no-display)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[328.383920] [FACT i915_module_load (reload-no-display)] deleted: kernel.kmod_is_loaded.i915: true
[328.387105] [065/133] (693s left) prime_vgem (basic-gtt)
[329.953554] Starting subtest: basic-gtt
[329.958246] Subtest basic-gtt: SKIP (0.000s)
[330.068891] [FACT prime_vgem (basic-gtt)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[330.070381] [FACT prime_vgem (basic-gtt)] new: kernel.kmod_is_loaded.i915: true
[330.074092] [066/133] (691s left) vgem_basic (second-client)
[330.130697] Starting subtest: second-client
[330.152413] Subtest second-client: SUCCESS (0.021s)
[330.221089] [067/133] (691s left) kms_psr (fbc-pr-dpms)
[330.315992] Starting subtest: fbc-pr-dpms
[330.319929] Subtest fbc-pr-dpms: SKIP (0.000s)
[330.415184] [068/133] (691s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-0-hflip)
[330.519917] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-0-hflip
[330.524439] Subtest yf-tiled-max-hw-stride-32bpp-rotate-0-hflip: SKIP (0.000s)
[330.664020] [069/133] (690s left) gem_exec_balancer (full-late)
[330.720465] Starting subtest: full-late
[335.634361] Subtest full-late: SUCCESS (4.913s)
[335.979478] [070/133] (685s left) kms_psr (pr-primary-mmap-gtt)
[336.085606] Starting subtest: pr-primary-mmap-gtt
[336.090025] Subtest pr-primary-mmap-gtt: SKIP (0.000s)
[336.170628] [071/133] (685s left) syncobj_wait (single-wait-all-signaled)
[336.229333] Starting subtest: single-wait-all-signaled
[336.231651] Subtest single-wait-all-signaled: SUCCESS (0.000s)
[336.350889] [072/133] (685s left) kms_ccs (bad-aux-stride-y-tiled-gen12-rc-ccs-cc)
[336.455823] Starting subtest: bad-aux-stride-y-tiled-gen12-rc-ccs-cc
[336.458094] Starting dynamic subtest: pipe-A-eDP-1
[336.482146] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[336.494165] Starting dynamic subtest: pipe-B-eDP-1
[336.515979] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[336.524669] Starting dynamic subtest: pipe-C-eDP-1
[336.546499] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[336.555043] Starting dynamic subtest: pipe-D-eDP-1
[336.577063] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[336.581134] Subtest bad-aux-stride-y-tiled-gen12-rc-ccs-cc: SKIP (0.005s)
[338.796837] [073/133] (682s left) syncobj_timeline (single-wait-all-available-signaled)
[338.848822] Starting subtest: single-wait-all-available-signaled
[338.851164] Subtest single-wait-all-available-signaled: SUCCESS (0.000s)
[338.954649] [074/133] (682s left) kms_addfb_basic (addfb25-x-tiled-legacy)
[339.042028] Subtest addfb25-x-tiled-legacy: SKIP (0.000s)
[339.181328] [075/133] (682s left) gem_exec_capture (userptr)
[339.243055] Starting subtest: userptr
[340.042235] Subtest userptr: SUCCESS (0.799s)
[340.188286] [076/133] (681s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-render)
[340.290147] Starting subtest: fbcpsr-rgb565-draw-render
[347.369859] Subtest fbcpsr-rgb565-draw-render: SUCCESS (7.081s)
[347.530854] [077/133] (674s left) prime_mmap (test_reprime)
[347.582501] Starting subtest: test_reprime
[347.584349] Starting dynamic subtest: test_reprime-smem
[347.611977] Dynamic subtest test_reprime-smem: SUCCESS (0.031s)
[347.614405] Subtest test_reprime: SUCCESS (0.031s)
[347.737988] [078/133] (674s left) syncobj_wait (wait-all-snapshot)
[347.792863] Starting subtest: wait-all-snapshot
[347.872208] Subtest wait-all-snapshot: SUCCESS (0.081s)
[347.962834] [079/133] (674s left) kms_plane_scaling (planes-downscale-factor-0-75-upscale-20x20)
[348.060436] Starting subtest: planes-downscale-factor-0-75-upscale-20x20
[348.062778] Starting dynamic subtest: pipe-A
[348.122659] Dynamic subtest pipe-A: SUCCESS (0.065s)
[348.133227] Starting dynamic subtest: pipe-B
[349.253009] Dynamic subtest pipe-B: SUCCESS (1.129s)
[349.264117] Starting dynamic subtest: pipe-C
[350.374281] Dynamic subtest pipe-C: SUCCESS (1.120s)
[350.384991] Starting dynamic subtest: pipe-D
[351.515082] Dynamic subtest pipe-D: SUCCESS (1.140s)
[351.517181] Subtest planes-downscale-factor-0-75-upscale-20x20: SUCCESS (3.458s)
[352.680205] [080/133] (669s left) gem_softpin (allocator-fork)
[352.749074] Starting subtest: allocator-fork
[354.960459] Subtest allocator-fork: SUCCESS (2.211s)
[355.108029] [081/133] (667s left) api_intel_bb (object-reloc-keep-cache)
[355.173814] Starting subtest: object-reloc-keep-cache
[355.178098] Subtest object-reloc-keep-cache: SKIP (0.004s)
[355.328126] [082/133] (666s left) syncobj_wait (wait-all-for-submit-delayed-submit)
[355.392518] Starting subtest: wait-all-for-submit-delayed-submit
[355.494257] Subtest wait-all-for-submit-delayed-submit: SUCCESS (0.102s)
[355.600202] [083/133] (666s left) kms_color (degamma)
[355.701658] Starting subtest: degamma
[355.703853] Starting dynamic subtest: pipe-A-eDP-1
[356.425185] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.721s)
[356.444663] Starting dynamic subtest: pipe-B-eDP-1
[357.913376] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.491s)
[357.922715] Starting dynamic subtest: pipe-C-eDP-1
[359.283451] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.368s)
[359.292862] Starting dynamic subtest: pipe-D-eDP-1
[360.737480] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.454s)
[360.739764] Subtest degamma: SUCCESS (5.038s)
[361.604647] [084/133] (660s left) gem_userptr_blits (coherency-unsync)
[361.675777] Subtest coherency-unsync: SKIP (0.000s)
[361.827825] [085/133] (660s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip)
[361.932631] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip
[362.534195] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SUCCESS (0.604s)
[362.729177] [086/133] (659s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-180)
[362.835340] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-180
[362.839848] Subtest y-tiled-max-hw-stride-32bpp-rotate-180: SKIP (0.000s)
[362.946105] [087/133] (659s left) kms_plane_scaling (2x-scaler-multi-pipe)
[363.054995] Starting subtest: 2x-scaler-multi-pipe
[363.059313] Subtest 2x-scaler-multi-pipe: SKIP (0.001s)
[363.181732] [088/133] (659s left) gem_exec_parallel (fds)
[363.239469] Starting subtest: fds
[363.241831] Starting dynamic subtest: rcs0
[365.666397] Dynamic subtest rcs0: SUCCESS (2.425s)
[365.678472] Starting dynamic subtest: bcs0
[368.836153] Dynamic subtest bcs0: SUCCESS (3.169s)
[368.847823] Starting dynamic subtest: vcs0
[372.965733] Dynamic subtest vcs0: SUCCESS (4.130s)
[372.983339] Starting dynamic subtest: vcs1
[377.009263] Dynamic subtest vcs1: SUCCESS (4.042s)
[377.021380] Starting dynamic subtest: vecs0
[381.036066] Dynamic subtest vecs0: SUCCESS (4.025s)
[381.046761] Starting dynamic subtest: ccs0
[384.621999] Dynamic subtest ccs0: SUCCESS (3.584s)
[384.624329] Subtest fds: SUCCESS (21.385s)
[384.832412] [089/133] (637s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-mmap-gtt)
[384.934333] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-mmap-gtt
[384.938502] Subtest fbc-2p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[385.065576] [090/133] (637s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-blt)
[385.174012] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-blt
[385.178062] Subtest fbc-2p-scndscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[385.290117] [091/133] (637s left) kms_getfb (getfb2-into-addfb2)
[385.389793] Starting subtest: getfb2-into-addfb2
[385.392037] Subtest getfb2-into-addfb2: SUCCESS (0.000s)
[385.533575] [092/133] (637s left) kms_flip (busy-flip)
[385.632927] Starting subtest: busy-flip
[385.635232] Starting dynamic subtest: A-eDP1
[387.289781] Dynamic subtest A-eDP1: SUCCESS (1.656s)
[387.299901] Starting dynamic subtest: B-eDP1
[389.030994] Dynamic subtest B-eDP1: SUCCESS (1.739s)
[389.041942] Starting dynamic subtest: C-eDP1
[390.753663] Dynamic subtest C-eDP1: SUCCESS (1.721s)
[390.770814] Starting dynamic subtest: D-eDP1
[392.404824] Dynamic subtest D-eDP1: SUCCESS (1.649s)
[392.409734] Subtest busy-flip: SUCCESS (6.777s)
[393.673896] [093/133] (628s left) gem_ctx_sseu (mmap-args)
[393.738748] Subtest mmap-args: SKIP (0.000s)
[393.806321] [094/133] (628s left) kms_cursor_crc (cursor-random-32x32)
[393.961024] Starting subtest: cursor-random-32x32
[394.009872] Subtest cursor-random-32x32: SKIP (0.043s)
[394.306743] [095/133] (628s left) kms_ccs (ccs-on-another-bo-y-tiled-gen12-rc-ccs-cc)
[394.406854] Starting subtest: ccs-on-another-bo-y-tiled-gen12-rc-ccs-cc
[394.409045] Starting dynamic subtest: pipe-A-eDP-1
[394.431559] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[394.442975] Starting dynamic subtest: pipe-B-eDP-1
[394.465715] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[394.476932] Starting dynamic subtest: pipe-C-eDP-1
[394.498349] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[394.507584] Starting dynamic subtest: pipe-D-eDP-1
[394.528734] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[394.532600] Subtest ccs-on-another-bo-y-tiled-gen12-rc-ccs-cc: SKIP (0.004s)
[396.723735] [096/133] (626s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-mmap-cpu)
[396.830014] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-mmap-cpu
[400.781339] Subtest fbc-1p-offscreen-pri-shrfb-draw-mmap-cpu: SUCCESS (3.954s)
[401.940338] [097/133] (620s left) gem_exec_schedule (u-submit-late-slice)
[402.025182] Starting subtest: u-submit-late-slice
[402.027064] Starting dynamic subtest: rcs0
[402.058281] Dynamic subtest rcs0: SUCCESS (0.035s)
[402.069517] Starting dynamic subtest: bcs0
[402.088718] Dynamic subtest bcs0: SUCCESS (0.030s)
[402.097790] Starting dynamic subtest: vcs0
[402.122806] Dynamic subtest vcs0: SUCCESS (0.033s)
[402.136125] Starting dynamic subtest: vcs1
[402.150918] Dynamic subtest vcs1: SUCCESS (0.027s)
[402.160619] Starting dynamic subtest: vecs0
[402.180130] Dynamic subtest vecs0: SUCCESS (0.029s)
[402.190364] Starting dynamic subtest: ccs0
[402.208761] Dynamic subtest ccs0: SUCCESS (0.028s)
[402.211059] Subtest u-submit-late-slice: SUCCESS (0.186s)
[403.849594] [098/133] (618s left) kms_frontbuffer_tracking (fbcpsr-stridechange)
[403.966234] Starting subtest: fbcpsr-stridechange
[410.253064] Subtest fbcpsr-stridechange: SUCCESS (6.289s)
[410.450998] [099/133] (612s left) dumb_buffer (map-valid)
[410.505676] Starting subtest: map-valid
[410.507922] Subtest map-valid: SUCCESS (0.000s)
[410.637449] [100/133] (612s left) perf_pmu (idle)
[410.679303] Starting subtest: idle
[410.681738] Starting dynamic subtest: rcs0
[411.235300] Dynamic subtest rcs0: SUCCESS (0.558s)
[411.247778] Starting dynamic subtest: bcs0
[411.760889] Dynamic subtest bcs0: SUCCESS (0.523s)
[411.771245] Starting dynamic subtest: vcs0
[412.288778] Dynamic subtest vcs0: SUCCESS (0.526s)
[412.299481] Starting dynamic subtest: vcs1
[412.826619] Dynamic subtest vcs1: SUCCESS (0.516s)
[412.836326] Starting dynamic subtest: vecs0
[413.333520] Dynamic subtest vecs0: SUCCESS (0.524s)
[413.344764] Starting dynamic subtest: ccs0
[413.858528] Dynamic subtest ccs0: SUCCESS (0.522s)
[413.861561] Subtest idle: SUCCESS (3.183s)
[413.983002] [101/133] (608s left) kms_pm_rpm (i2c)
[415.923156] Starting subtest: i2c
[421.279648] Subtest i2c: SUCCESS (5.356s)
[421.392631] [102/133] (601s left) kms_big_fb (linear-64bpp-rotate-180)
[421.498589] Starting subtest: linear-64bpp-rotate-180
[423.227843] Subtest linear-64bpp-rotate-180: SUCCESS (1.728s)
[423.426548] [103/133] (599s left) kms_feature_discovery (dp-mst)
[423.523171] Starting subtest: dp-mst
[423.526673] Subtest dp-mst: SKIP (0.000s)
[423.619492] [104/133] (599s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-blt)
[423.716579] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-blt
[423.720175] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-blt: SKIP (0.000s)
[423.833641] [105/133] (599s left) kms_pipe_stress (stress-xrgb8888-untiled)
[423.952028] Starting subtest: stress-xrgb8888-untiled
[429.876180] Subtest stress-xrgb8888-untiled: SUCCESS (5.923s)
[429.925223] [106/133] (593s left) gem_softpin (invalid)
[429.984283] Starting subtest: invalid
[429.991683] Subtest invalid: SUCCESS (0.006s)
[430.135500] [107/133] (593s left) kms_psr2_sf (fbc-psr2-overlay-plane-update-continuous-sf)
[435.231165] Starting subtest: fbc-psr2-overlay-plane-update-continuous-sf
[435.233562] Starting dynamic subtest: pipe-A-eDP-1
[436.018007] Dynamic subtest pipe-A-eDP-1: SKIP (0.785s)
[436.028083] Starting dynamic subtest: pipe-B-eDP-1
[437.144212] Dynamic subtest pipe-B-eDP-1: SKIP (1.123s)
[437.148926] Subtest fbc-psr2-overlay-plane-update-continuous-sf: SKIP (1.912s)
[438.335551] [108/133] (584s left) kms_rotation_crc (primary-x-tiled-reflect-x-0)
[438.428617] Starting subtest: primary-x-tiled-reflect-x-0
[445.530389] Subtest primary-x-tiled-reflect-x-0: SUCCESS (7.103s)
[446.811800] [109/133] (576s left) i915_drm_fdinfo (busy)
[446.865655] Starting subtest: busy
[446.868305] Starting dynamic subtest: rcs0
[446.902836] Dynamic subtest rcs0: SKIP (0.035s)
[446.914406] Starting dynamic subtest: bcs0
[446.918744] Dynamic subtest bcs0: SKIP (0.000s)
[446.927549] Starting dynamic subtest: vcs0
[446.931620] Dynamic subtest vcs0: SKIP (0.000s)
[446.940873] Starting dynamic subtest: vcs1
[446.945167] Dynamic subtest vcs1: SKIP (0.000s)
[446.954105] Starting dynamic subtest: vecs0
[446.958467] Dynamic subtest vecs0: SKIP (0.000s)
[446.967434] Starting dynamic subtest: ccs0
[446.971808] Dynamic subtest ccs0: SKIP (0.000s)
[446.976045] Subtest busy: SKIP (0.042s)
[447.012319] [110/133] (576s left) kms_big_fb (linear-max-hw-stride-64bpp-rotate-180-hflip)
[447.127815] Starting subtest: linear-max-hw-stride-64bpp-rotate-180-hflip
[447.132302] Subtest linear-max-hw-stride-64bpp-rotate-180-hflip: SKIP (0.000s)
[447.254426] [111/133] (576s left) kms_scaling_modes (scaling-mode-full)
[447.348049] Starting subtest: scaling-mode-full
[447.350273] Starting dynamic subtest: pipe-A-eDP-1
[447.443331] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.095s)
[447.455592] Starting dynamic subtest: pipe-B-eDP-1
[448.624081] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.178s)
[448.636280] Starting dynamic subtest: pipe-C-eDP-1
[449.736847] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.112s)
[449.746590] Starting dynamic subtest: pipe-D-eDP-1
[450.865363] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.127s)
[450.867654] Subtest scaling-mode-full: SUCCESS (3.517s)
[452.141668] [112/133] (571s left) kms_psr2_sf (fbc-psr2-overlay-plane-move-continuous-exceed-fully-sf)
[457.218337] Starting subtest: fbc-psr2-overlay-plane-move-continuous-exceed-fully-sf
[457.220664] Starting dynamic subtest: pipe-A-eDP-1
[457.994130] Dynamic subtest pipe-A-eDP-1: SKIP (0.772s)
[458.004653] Starting dynamic subtest: pipe-B-eDP-1
[459.118801] Dynamic subtest pipe-B-eDP-1: SKIP (1.124s)
[459.123432] Subtest fbc-psr2-overlay-plane-move-continuous-exceed-fully-sf: SKIP (1.900s)
[460.316984] [113/133] (563s left) gem_exec_schedule (preemptive-hang)
[460.500618] Starting subtest: preemptive-hang
[460.503287] Starting dynamic subtest: rcs0
[469.824229] Dynamic subtest rcs0: SUCCESS (9.322s)
[469.835531] Starting dynamic subtest: bcs0
[478.845042] Dynamic subtest bcs0: SUCCESS (9.016s)
[478.856491] Starting dynamic subtest: vcs0
[487.862928] Dynamic subtest vcs0: SUCCESS (9.017s)
[487.872472] Starting dynamic subtest: vcs1
[496.829359] Dynamic subtest vcs1: SUCCESS (8.962s)
[496.841204] Starting dynamic subtest: vecs0
[505.849485] Dynamic subtest vecs0: SUCCESS (9.018s)
[505.861585] Starting dynamic subtest: ccs0
[514.878893] Dynamic subtest ccs0: SUCCESS (9.025s)
[514.881205] Subtest preemptive-hang: SUCCESS (54.368s)
[515.131422] [114/133] (508s left) syncobj_timeline (multi-wait-all-for-submit-available-submitted)
[515.187359] Starting subtest: multi-wait-all-for-submit-available-submitted
[515.189717] Subtest multi-wait-all-for-submit-available-submitted: SUCCESS (0.000s)
[515.296571] [115/133] (508s left) perf (per-context-mode-unprivileged)
[515.442862] Starting subtest: per-context-mode-unprivileged
[515.447191] Subtest per-context-mode-unprivileged: SKIP (0.000s)
[515.483857] [116/133] (508s left) gem_exec_reloc (basic-gtt-noreloc)
[515.548542] Subtest basic-gtt-noreloc: SKIP (0.000s)
[515.618365] [117/133] (507s left) kms_flip (2x-flip-vs-dpms)
[515.727705] Starting subtest: 2x-flip-vs-dpms
[515.736429] Subtest 2x-flip-vs-dpms: SKIP (0.010s)
[515.868246] [118/133] (507s left) gem_ctx_exec (basic-close-race)
[515.953311] Starting subtest: basic-close-race
[521.719583] Subtest basic-close-race: SUCCESS (5.767s)
[521.884315] [119/133] (501s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-gtt)
[521.993716] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-gtt
[521.997888] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[522.126974] [120/133] (501s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-64bpp-yftile-upscaling)
[522.230961] Starting subtest: flip-32bpp-yftile-to-64bpp-yftile-upscaling
[522.235314] Subtest flip-32bpp-yftile-to-64bpp-yftile-upscaling: SKIP (0.000s)
[522.313462] [121/133] (501s left) gem_ctx_param (invalid-get-no-zeromap)
[522.376306] Starting subtest: invalid-get-no-zeromap
[522.378573] Subtest invalid-get-no-zeromap: SUCCESS (0.001s)
[522.526861] [122/133] (501s left) dumb_buffer (invalid-bpp)
[522.602332] Starting subtest: invalid-bpp
[522.604770] Subtest invalid-bpp: SUCCESS (0.000s)
[522.735759] [123/133] (501s left) kms_addfb_basic (basic)
[522.794870] Starting subtest: basic
[522.797031] Subtest basic: SUCCESS (0.000s)
[522.968720] [124/133] (500s left) kms_plane (pixel-format-4-tiled-modifier-source-clamping)
[523.077214] Starting subtest: pixel-format-4-tiled-modifier-source-clamping
[523.104313] Starting dynamic subtest: pipe-A-plane-0
[523.726148] Dynamic subtest pipe-A-plane-0: SUCCESS (0.622s)
[523.735555] Starting dynamic subtest: pipe-A-plane-3
[524.159536] Dynamic subtest pipe-A-plane-3: SUCCESS (0.433s)
[524.169019] Starting dynamic subtest: pipe-A-plane-5
[524.172541] Dynamic subtest pipe-A-plane-5: SKIP (0.000s)
[525.292158] Starting dynamic subtest: pipe-B-plane-0
[525.906627] Dynamic subtest pipe-B-plane-0: SUCCESS (0.622s)
[525.916357] Starting dynamic subtest: pipe-B-plane-3
[526.328667] Dynamic subtest pipe-B-plane-3: SUCCESS (0.421s)
[526.337949] Starting dynamic subtest: pipe-B-plane-5
[526.341525] Dynamic subtest pipe-B-plane-5: SKIP (0.000s)
[526.639529] Subtest pixel-format-4-tiled-modifier-source-clamping: SUCCESS (3.560s)
[527.484984] [125/133] (496s left) perf_pmu (busy-double-start)
[527.524922] Starting subtest: busy-double-start
[527.527225] Starting dynamic subtest: rcs0
[531.165554] Dynamic subtest rcs0: FAIL (3.582s)
[531.176602] Starting dynamic subtest: bcs0
[534.686579] Dynamic subtest bcs0: SUCCESS (3.577s)
[534.698716] Starting dynamic subtest: vcs0
[539.264345] Dynamic subtest vcs0: SUCCESS (4.575s)
[539.276254] Starting dynamic subtest: vcs1
[543.286325] Dynamic subtest vcs1: SUCCESS (4.019s)
[543.302148] Starting dynamic subtest: vecs0
[547.225471] Dynamic subtest vecs0: SUCCESS (3.935s)
[547.237944] Starting dynamic subtest: ccs0
[550.860594] Dynamic subtest ccs0: FAIL (3.564s)
[550.862846] Subtest busy-double-start: FAIL (23.262s)
[550.925142] [126/133] (473s left) gem_ctx_param (basic-default)
[550.984998] Starting subtest: basic-default
[550.987299] Subtest basic-default: SUCCESS (0.000s)
[551.074440] [127/133] (472s left) gem_mmap_gtt (big-bo-tiledx)
[551.133552] Subtest big-bo-tiledX: SKIP (0.000s)
[551.194958] [128/133] (472s left) gem_userptr_blits (stress-mm)
[551.267633] Starting subtest: stress-mm
[556.638124] Subtest stress-mm: SUCCESS (5.369s)
[556.807661] [129/133] (467s left) prime_vgem (fence-read-hang)
[556.896493] Subtest fence-read-hang: SKIP (0.000s)
[557.039695] [130/133] (467s left) kms_flip (2x-flip-vs-expired-vblank-interruptible)
[557.143834] Starting subtest: 2x-flip-vs-expired-vblank-interruptible
[557.155132] Subtest 2x-flip-vs-expired-vblank-interruptible: SKIP (0.011s)
[557.231719] [131/133] (466s left) kms_psr (fbc-psr-primary-render)
[557.324548] Starting subtest: fbc-psr-primary-render
[557.326754] Starting dynamic subtest: eDP-1
[557.330692] Dynamic subtest eDP-1: SKIP (0.000s)
[557.334654] Subtest fbc-psr-primary-render: SKIP (0.001s)
[557.403144] [132/133] (466s left) kms_frontbuffer_tracking (psr-modesetfrombusy)
[557.488334] Starting subtest: psr-modesetfrombusy
[563.755591] Subtest psr-modesetfrombusy: SUCCESS (6.269s)
[563.917734] [133/133] (460s left) kms_pm_rpm (system-suspend-modeset)
[565.848509] Starting subtest: system-suspend-modeset
[585.424435] Subtest system-suspend-modeset: SUCCESS (4.570s)
[585.846575] 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.