[56.390963] Initializing watchdogs
[56.391019]   /dev/watchdog0
[56.403991] [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]
[56.408234] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[56.410357] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[56.413573] [001/133] (960s left) kms_frontbuffer_tracking (fbcpsr-farfromfence-mmap-gtt)
[56.539546] Starting subtest: fbcpsr-farfromfence-mmap-gtt
[56.543685] Subtest fbcpsr-farfromfence-mmap-gtt: SKIP (0.000s)
[56.670057] [002/133] (960s left) syncobj_timeline (wait-for-submit-delayed-submit)
[56.725085] Starting subtest: wait-for-submit-delayed-submit
[56.829118] Subtest wait-for-submit-delayed-submit: SUCCESS (0.103s)
[56.925746] [003/133] (960s left) kms_chamelium_hpd (dp-hpd)
[57.306985] Subtest dp-hpd: SKIP (0.000s)
[58.094402] [004/133] (958s left) kms_cursor_edge_walk (256x256-top-bottom)
[58.187327] Starting subtest: 256x256-top-bottom
[58.189757] Starting dynamic subtest: pipe-A-eDP-1
[61.683855] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.502s)
[61.692130] Starting dynamic subtest: pipe-D-eDP-1
[64.777324] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.099s)
[64.779621] Subtest 256x256-top-bottom: SUCCESS (6.603s)
[65.596469] [005/133] (951s left) gem_mmap_offset (clear)
[65.665063] Starting subtest: clear
[65.667997] Starting dynamic subtest: smem0
[90.492544] Dynamic subtest smem0: SUCCESS (24.828s)
[90.494996] Subtest clear: SUCCESS (24.829s)
[90.657762] [006/133] (926s left) kms_joiner (basic-force-big-joiner)
[90.814589] Starting subtest: basic-force-big-joiner
[90.819291] Subtest basic-force-big-joiner: SKIP (0.000s)
[90.889140] [007/133] (926s left) gem_exec_balancer (waits)
[90.948577] Starting subtest: waits
[97.437621] Subtest waits: SUCCESS (6.485s)
[97.748896] [008/133] (919s left) gem_exec_whisper (basic-queues)
[97.815748] Starting subtest: basic-queues
[105.909921] Subtest basic-queues: SUCCESS (8.092s)
[106.103634] [009/133] (911s left) gem_exec_suspend (basic-s3)
[106.174470] Starting subtest: basic-S3
[106.177073] Starting dynamic subtest: smem
[126.867835] Dynamic subtest smem: SUCCESS (6.760s)
[126.870972] Subtest basic-S3: SUCCESS (6.761s)
[127.057119] [010/133] (890s left) kms_psr (psr2-sprite-render)
[127.157861] Starting subtest: psr2-sprite-render
[127.160274] Starting dynamic subtest: eDP-1
[128.911101] Dynamic subtest eDP-1: SUCCESS (1.771s)
[128.913693] Subtest psr2-sprite-render: SUCCESS (1.772s)
[129.783995] [011/133] (887s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-mmap-wc)
[129.896748] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-mmap-wc
[136.558587] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-mmap-wc: SUCCESS (6.698s)
[136.705681] [012/133] (880s left) kms_content_protection (atomic)
[136.859383] Starting subtest: atomic
[136.864681] Subtest atomic: SKIP (0.000s)
[137.002048] [013/133] (880s left) kms_async_flips (invalid-async-flip)
[137.102004] Starting subtest: invalid-async-flip
[137.471897] Starting dynamic subtest: pipe-A-eDP-1
[138.296927] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.829s)
[138.653920] Starting dynamic subtest: pipe-B-eDP-1
[139.505773] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.863s)
[139.860912] Starting dynamic subtest: pipe-C-eDP-1
[140.637321] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.787s)
[140.991401] Starting dynamic subtest: pipe-D-eDP-1
[141.746865] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.764s)
[141.749721] Subtest invalid-async-flip: SUCCESS (4.658s)
[142.920525] [014/133] (874s left) kms_flip (blocking-absolute-wf_vblank)
[143.016399] Starting subtest: blocking-absolute-wf_vblank
[143.018650] Starting dynamic subtest: A-eDP1
[151.755654] Dynamic subtest A-eDP1: SUCCESS (8.752s)
[151.770637] Starting dynamic subtest: B-eDP1
[160.474510] Dynamic subtest B-eDP1: SUCCESS (8.721s)
[160.490627] Starting dynamic subtest: C-eDP1
[169.191606] Dynamic subtest C-eDP1: SUCCESS (8.717s)
[169.206492] Starting dynamic subtest: D-eDP1
[177.920700] Dynamic subtest D-eDP1: SUCCESS (8.730s)
[177.926927] Subtest blocking-absolute-wf_vblank: SUCCESS (34.929s)
[179.146063] [015/133] (838s left) gem_exec_schedule (reorder-wide)
[179.354957] Subtest reorder-wide: SKIP (0.000s)
[179.541231] [016/133] (837s left) gem_watchdog (default-virtual)
[179.625660] Starting subtest: default-virtual
[185.902405] Subtest default-virtual: SUCCESS (6.289s)
[186.008908] [017/133] (831s left) gem_pwrite (basic-self)
[186.073972] Subtest basic-self: SKIP (0.000s)
[186.146121] [018/133] (831s left) kms_psr (fbc-psr2-cursor-mmap-gtt)
[186.247833] Starting subtest: fbc-psr2-cursor-mmap-gtt
[186.250164] Starting dynamic subtest: eDP-1
[186.254746] Dynamic subtest eDP-1: SKIP (0.000s)
[186.259686] Subtest fbc-psr2-cursor-mmap-gtt: SKIP (0.001s)
[186.328962] [019/133] (831s left) kms_cursor_legacy (forked-move)
[186.452772] Starting subtest: forked-move
[186.455143] Starting dynamic subtest: pipe-A
[191.907373] Dynamic subtest pipe-A: SUCCESS (5.455s)
[191.920869] Starting dynamic subtest: pipe-B
[197.384247] Dynamic subtest pipe-B: SUCCESS (5.478s)
[197.396664] Starting dynamic subtest: pipe-C
[202.850834] Dynamic subtest pipe-C: SUCCESS (5.467s)
[202.861260] Starting dynamic subtest: pipe-D
[208.313582] Dynamic subtest pipe-D: SUCCESS (5.465s)
[208.323506] Starting dynamic subtest: all-pipes
[213.794628] Dynamic subtest all-pipes: SUCCESS (5.482s)
[213.797506] Subtest forked-move: SUCCESS (27.353s)
[213.953122] [020/133] (803s left) vgem_basic (debugfs)
[214.085956] Starting subtest: debugfs
[214.088752] Subtest debugfs: SUCCESS (0.000s)
[214.151102] [FACT vgem_basic (debugfs)] new: kernel.kmod_is_loaded.vgem: true
[214.154502] [021/133] (803s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-pwrite)
[214.260725] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-pwrite
[214.265737] Subtest fbc-2p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[214.363434] [022/133] (803s left) kms_plane_lowres (tiling-yf)
[214.463576] Starting subtest: tiling-yf
[214.468440] Subtest tiling-yf: SKIP (0.000s)
[214.548069] [023/133] (803s left) kms_flip (2x-flip-vs-dpms-off-vs-modeset)
[214.650969] Starting subtest: 2x-flip-vs-dpms-off-vs-modeset
[214.660545] Subtest 2x-flip-vs-dpms-off-vs-modeset: SKIP (0.011s)
[214.749275] [024/133] (803s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-32bpp-xtile-upscaling)
[214.843966] Starting subtest: flip-64bpp-xtile-to-32bpp-xtile-upscaling
[214.846521] Starting dynamic subtest: pipe-A-default-mode
[217.575726] Dynamic subtest pipe-A-default-mode: SUCCESS (2.733s)
[217.578839] Subtest flip-64bpp-xtile-to-32bpp-xtile-upscaling: SUCCESS (2.734s)
[218.432824] [025/133] (799s left) kms_vrr (flip-basic)
[218.532780] Starting subtest: flip-basic
[218.540356] Subtest flip-basic: SKIP (0.000s)
[218.614593] [026/133] (799s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-mmap-cpu)
[218.717804] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-mmap-cpu
[218.723083] Subtest fbc-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[218.822269] [027/133] (799s left) kms_flip (modeset-vs-vblank-race-interruptible)
[218.923760] Starting subtest: modeset-vs-vblank-race-interruptible
[218.926510] Starting dynamic subtest: A-eDP1
[223.651441] Dynamic subtest A-eDP1: SUCCESS (4.725s)
[223.663283] Starting dynamic subtest: B-eDP1
[228.295338] Dynamic subtest B-eDP1: SUCCESS (4.639s)
[228.306835] Starting dynamic subtest: C-eDP1
[232.814119] Dynamic subtest C-eDP1: SUCCESS (4.515s)
[232.824262] Starting dynamic subtest: D-eDP1
[237.359651] Dynamic subtest D-eDP1: SUCCESS (4.543s)
[237.365844] Subtest modeset-vs-vblank-race-interruptible: SUCCESS (18.432s)
[238.551166] [028/133] (779s left) kms_addfb_basic (bad-pitch-63)
[238.622190] Starting subtest: bad-pitch-63
[238.624944] Subtest bad-pitch-63: SUCCESS (0.000s)
[238.784178] [029/133] (779s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-mmap-wc)
[238.878731] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-mmap-wc
[238.883933] Subtest psr-2p-scndscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[239.003757] [030/133] (779s left) syncobj_wait (invalid-reset-one-illegal-handle)
[239.072227] Starting subtest: invalid-reset-one-illegal-handle
[239.074750] Subtest invalid-reset-one-illegal-handle: SUCCESS (0.000s)
[239.195160] [031/133] (778s left) gem_ctx_persistence (legacy-engines-queued)
[239.262765] Starting subtest: legacy-engines-queued
[239.265759] Starting dynamic subtest: render
[239.382310] Dynamic subtest render: SUCCESS (0.119s)
[239.394380] Starting dynamic subtest: bsd1
[240.819225] Dynamic subtest bsd1: SUCCESS (1.433s)
[240.831547] Starting dynamic subtest: bsd2
[242.801498] Dynamic subtest bsd2: SUCCESS (1.978s)
[242.813687] Starting dynamic subtest: blt
[242.877221] Dynamic subtest blt: SUCCESS (0.074s)
[242.887575] Starting dynamic subtest: vebox
[244.848292] Dynamic subtest vebox: SUCCESS (1.967s)
[244.851153] Subtest legacy-engines-queued: SUCCESS (5.584s)
[244.938410] [032/133] (773s left) syncobj_wait (invalid-single-wait-unsubmitted)
[245.009769] Starting subtest: invalid-single-wait-unsubmitted
[245.012750] Subtest invalid-single-wait-unsubmitted: SUCCESS (0.000s)
[245.125815] [033/133] (773s left) gem_pxp (verify-pxp-stale-ctx-execution)
[245.251702] Starting subtest: verify-pxp-stale-ctx-execution
[246.321154] Subtest verify-pxp-stale-ctx-execution: SUCCESS (1.068s)
[246.471575] [034/133] (771s left) gem_mmap_gtt (cpuset-basic-small-copy-odd)
[246.542966] Subtest cpuset-basic-small-copy-odd: SKIP (0.000s)
[246.610232] [035/133] (771s left) kms_cursor_crc (cursor-onscreen-512x170)
[246.912230] Starting subtest: cursor-onscreen-512x170
[246.916767] Subtest cursor-onscreen-512x170: SKIP (0.001s)
[247.077543] [036/133] (771s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-mmap-cpu)
[247.179500] Starting subtest: psr-1p-primscrn-spr-indfb-draw-mmap-cpu
[253.704748] Subtest psr-1p-primscrn-spr-indfb-draw-mmap-cpu: SUCCESS (6.526s)
[253.853837] [037/133] (764s left) kms_chamelium_color (ctm-0-25)
[253.948602] Subtest ctm-0-25: SKIP (0.000s)
[253.990626] [038/133] (764s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted-signaled)
[254.040510] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted-signaled
[254.140428] Subtest etime-multi-wait-all-for-submit-unsubmitted-signaled: SUCCESS (0.101s)
[254.233316] [039/133] (764s left) gem_exec_fence (syncobj-timeline-unused-fence)
[254.762056] Starting subtest: syncobj-timeline-unused-fence
[254.765368] Subtest syncobj-timeline-unused-fence: SUCCESS (0.009s)
[255.895115] [040/133] (762s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-blt)
[256.018762] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-blt
[256.023960] Subtest fbc-2p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[256.122029] [041/133] (762s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-pwrite)
[256.215957] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-pwrite
[256.221071] Subtest fbc-2p-scndscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[256.332158] [042/133] (762s left) kms_chamelium_frames (hdmi-cmp-planar-formats)
[256.713205] Subtest hdmi-cmp-planar-formats: SKIP (0.000s)
[257.490602] [043/133] (761s left) kms_plane_scaling (plane-downscale-factor-0-5-with-pixel-format)
[257.589650] Starting subtest: plane-downscale-factor-0-5-with-pixel-format
[257.592431] Starting dynamic subtest: pipe-A
[257.611898] Dynamic subtest pipe-A: SKIP (0.017s)
[257.621553] Starting dynamic subtest: pipe-B
[257.640717] Dynamic subtest pipe-B: SKIP (0.030s)
[257.649858] Starting dynamic subtest: pipe-C
[257.672751] Dynamic subtest pipe-C: SKIP (0.031s)
[257.681912] Starting dynamic subtest: pipe-D
[257.701686] Dynamic subtest pipe-D: SKIP (0.029s)
[257.706791] Subtest plane-downscale-factor-0-5-with-pixel-format: SKIP (0.109s)
[257.822853] [044/133] (760s left) gem_render_copy (y-tiled-to-vebox-x-tiled)
[257.890707] Starting subtest: y-tiled-to-vebox-x-tiled
[257.896086] Subtest y-tiled-to-vebox-x-tiled: SKIP (0.000s)
[258.083914] [045/133] (760s left) gen9_exec_parse (batch-without-end)
[258.166741] Subtest batch-without-end: SKIP (0.000s)
[258.245960] [046/133] (760s left) syncobj_timeline (etime-single-wait-submitted)
[258.302334] Starting subtest: etime-single-wait-submitted
[258.405967] Subtest etime-single-wait-submitted: SUCCESS (0.104s)
[258.493434] [047/133] (760s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180-hflip)
[258.601828] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180-hflip
[258.607183] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180-hflip: SKIP (0.000s)
[258.719455] [048/133] (760s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc)
[258.823402] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc
[265.322118] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc: SUCCESS (6.502s)
[265.467620] [049/133] (753s left) kms_ccs (crc-primary-suspend-y-tiled-gen12-rc-ccs)
[265.561808] Starting subtest: crc-primary-suspend-y-tiled-gen12-rc-ccs
[265.564655] Starting dynamic subtest: pipe-A-eDP-1
[265.575774] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[265.586428] Starting dynamic subtest: pipe-B-eDP-1
[265.596744] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[265.605565] Starting dynamic subtest: pipe-C-eDP-1
[265.616035] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[265.624605] Starting dynamic subtest: pipe-D-eDP-1
[265.634613] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[265.639694] Subtest crc-primary-suspend-y-tiled-gen12-rc-ccs: SKIP (0.004s)
[267.727258] [050/133] (751s left) kms_atomic_transition (plane-use-after-nonblocking-unbind)
[267.838156] Starting subtest: plane-use-after-nonblocking-unbind
[267.840820] Starting dynamic subtest: pipe-A-eDP-1
[267.896816] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.061s)
[268.191403] Starting dynamic subtest: pipe-B-eDP-1
[269.013430] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.832s)
[269.307828] Subtest plane-use-after-nonblocking-unbind: SUCCESS (1.473s)
[270.175479] [051/133] (748s left) gem_partial_pwrite_pread (reads-uncached)
[270.243176] Subtest reads-uncached: SKIP (0.000s)
[270.306877] [052/133] (748s left) syncobj_wait (multi-wait-for-submit-unsubmitted-submitted-signaled)
[270.365752] Starting subtest: multi-wait-for-submit-unsubmitted-submitted-signaled
[270.368582] Subtest multi-wait-for-submit-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[270.484140] [053/133] (748s left) i915_pm_rc6_residency (rc6-fence)
[270.541543] Starting subtest: rc6-fence
[270.576338] Starting dynamic subtest: gt0
[282.898833] Dynamic subtest gt0: SUCCESS (12.324s)
[282.910675] Starting dynamic subtest: gt1
[297.810038] Dynamic subtest gt1: SUCCESS (14.911s)
[297.812707] Subtest rc6-fence: SUCCESS (27.276s)
[297.899747] [054/133] (721s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite)
[298.008605] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite
[298.013547] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[298.128981] [055/133] (720s left) kms_frontbuffer_tracking (psr-2p-primscrn-indfb-msflip-blt)
[298.232752] Starting subtest: psr-2p-primscrn-indfb-msflip-blt
[298.237730] Subtest psr-2p-primscrn-indfb-msflip-blt: SKIP (0.000s)
[298.349383] [056/133] (720s left) kms_big_fb (yf-tiled-16bpp-rotate-180)
[298.446075] Starting subtest: yf-tiled-16bpp-rotate-180
[298.450962] Subtest yf-tiled-16bpp-rotate-180: SKIP (0.000s)
[298.543924] [057/133] (720s left) gem_ctx_param (root-set)
[298.606218] Starting subtest: root-set
[298.608965] Subtest root-set: SUCCESS (0.001s)
[298.752365] [058/133] (720s left) gem_exec_fence (syncobj-invalid-wait)
[299.155699] Starting subtest: syncobj-invalid-wait
[299.158853] Subtest syncobj-invalid-wait: SUCCESS (0.000s)
[300.957581] [059/133] (718s left) kms_lease (invalid-create-leases)
[301.061546] Starting subtest: invalid-create-leases
[301.066571] Subtest invalid-create-leases: SUCCESS (0.006s)
[301.185496] [060/133] (718s left) kms_ccs (missing-ccs-buffer-4-tiled-mtl-mc-ccs)
[301.283902] Starting subtest: missing-ccs-buffer-4-tiled-mtl-mc-ccs
[301.286661] Starting dynamic subtest: pipe-A-eDP-1
[301.309457] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.024s)
[301.318816] Starting dynamic subtest: pipe-B-eDP-1
[301.339354] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.020s)
[301.347819] Starting dynamic subtest: pipe-C-eDP-1
[301.368638] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.021s)
[301.377217] Starting dynamic subtest: pipe-D-eDP-1
[301.397906] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.021s)
[301.400527] Subtest missing-ccs-buffer-4-tiled-mtl-mc-ccs: SUCCESS (0.091s)
[303.652399] [061/133] (715s left) kms_sequence (queue-busy)
[303.754154] Starting subtest: queue-busy
[303.757071] Starting dynamic subtest: pipe-A-eDP-1
[305.689784] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.933s)
[305.709952] Starting dynamic subtest: pipe-B-eDP-1
[308.336709] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.648s)
[308.346751] Starting dynamic subtest: pipe-C-eDP-1
[310.931912] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.595s)
[310.942952] Starting dynamic subtest: pipe-D-eDP-1
[313.482751] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.548s)
[313.485281] Subtest queue-busy: SUCCESS (9.730s)
[314.294388] [062/133] (705s left) prime_vgem (basic-fence-blt)
[314.379635] Starting subtest: basic-fence-blt
[314.471237] Subtest basic-fence-blt: SUCCESS (0.092s)
[314.620857] [063/133] (704s left) i915_suspend (basic-s3-without-i915)
[314.656334] Starting subtest: basic-s3-without-i915
[318.166755] Subtest basic-s3-without-i915: SKIP (3.504s)
[321.138461] [064/133] (698s left) i915_module_load (reload-no-display)
[321.184621] Starting subtest: reload-no-display
[327.014496] Subtest reload-no-display: SUCCESS (5.832s)
[327.043224] [FACT i915_module_load (reload-no-display)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[327.043942] [FACT i915_module_load (reload-no-display)] deleted: kernel.kmod_is_loaded.i915: true
[327.047612] [065/133] (692s left) prime_vgem (basic-gtt)
[329.770483] Starting subtest: basic-gtt
[329.775677] Subtest basic-gtt: SKIP (0.000s)
[329.901827] [FACT prime_vgem (basic-gtt)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[329.903084] [FACT prime_vgem (basic-gtt)] new: kernel.kmod_is_loaded.i915: true
[329.907417] [066/133] (689s left) vgem_basic (second-client)
[329.967702] Starting subtest: second-client
[329.986995] Subtest second-client: SUCCESS (0.022s)
[330.055035] [067/133] (689s left) kms_psr (fbc-pr-dpms)
[330.153959] Starting subtest: fbc-pr-dpms
[330.158874] Subtest fbc-pr-dpms: SKIP (0.000s)
[330.237969] [068/133] (689s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-0-hflip)
[330.347197] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-0-hflip
[330.352614] Subtest yf-tiled-max-hw-stride-32bpp-rotate-0-hflip: SKIP (0.000s)
[330.449712] [069/133] (689s left) gem_exec_balancer (full-late)
[330.521496] Starting subtest: full-late
[335.669664] Subtest full-late: SUCCESS (5.149s)
[336.026931] [070/133] (683s left) kms_psr (pr-primary-mmap-gtt)
[336.136967] Starting subtest: pr-primary-mmap-gtt
[336.142766] Subtest pr-primary-mmap-gtt: SKIP (0.000s)
[336.219941] [071/133] (683s left) syncobj_wait (single-wait-all-signaled)
[336.284604] Starting subtest: single-wait-all-signaled
[336.286809] Subtest single-wait-all-signaled: SUCCESS (0.000s)
[336.403458] [072/133] (683s left) kms_ccs (bad-aux-stride-y-tiled-gen12-rc-ccs-cc)
[336.504547] Starting subtest: bad-aux-stride-y-tiled-gen12-rc-ccs-cc
[336.506939] Starting dynamic subtest: pipe-A-eDP-1
[336.533361] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[336.543717] Starting dynamic subtest: pipe-B-eDP-1
[336.568165] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[336.576326] Starting dynamic subtest: pipe-C-eDP-1
[336.601312] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[336.610071] Starting dynamic subtest: pipe-D-eDP-1
[336.637731] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[336.642905] Subtest bad-aux-stride-y-tiled-gen12-rc-ccs-cc: SKIP (0.008s)
[338.751269] [073/133] (681s left) syncobj_timeline (single-wait-all-available-signaled)
[338.813767] Starting subtest: single-wait-all-available-signaled
[338.816292] Subtest single-wait-all-available-signaled: SUCCESS (0.000s)
[338.911262] [074/133] (680s left) kms_addfb_basic (addfb25-x-tiled-legacy)
[339.009302] Subtest addfb25-x-tiled-legacy: SKIP (0.000s)
[339.114151] [075/133] (680s left) gem_exec_capture (userptr)
[339.175999] Starting subtest: userptr
[339.975496] Subtest userptr: SUCCESS (0.800s)
[340.106373] [076/133] (679s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-render)
[340.192923] Starting subtest: fbcpsr-rgb565-draw-render
[347.197756] Subtest fbcpsr-rgb565-draw-render: SUCCESS (7.010s)
[347.334834] [077/133] (672s left) prime_mmap (test_reprime)
[347.390409] Starting subtest: test_reprime
[347.392645] Starting dynamic subtest: test_reprime-smem
[347.417176] Dynamic subtest test_reprime-smem: SUCCESS (0.029s)
[347.419917] Subtest test_reprime: SUCCESS (0.030s)
[347.531741] [078/133] (672s left) syncobj_wait (wait-all-snapshot)
[347.600756] Starting subtest: wait-all-snapshot
[347.680171] Subtest wait-all-snapshot: SUCCESS (0.082s)
[347.771708] [079/133] (672s left) kms_plane_scaling (planes-downscale-factor-0-75-upscale-20x20)
[347.871346] Starting subtest: planes-downscale-factor-0-75-upscale-20x20
[347.873702] Starting dynamic subtest: pipe-A
[347.934581] Dynamic subtest pipe-A: SUCCESS (0.065s)
[347.942775] Starting dynamic subtest: pipe-B
[349.102915] Dynamic subtest pipe-B: SUCCESS (1.166s)
[349.113482] Starting dynamic subtest: pipe-C
[350.237764] Dynamic subtest pipe-C: SUCCESS (1.133s)
[350.246378] Starting dynamic subtest: pipe-D
[351.364446] Dynamic subtest pipe-D: SUCCESS (1.124s)
[351.366660] Subtest planes-downscale-factor-0-75-upscale-20x20: SUCCESS (3.495s)
[352.521219] [080/133] (667s left) gem_softpin (allocator-fork)
[352.585630] Starting subtest: allocator-fork
[354.792526] Subtest allocator-fork: SUCCESS (2.205s)
[354.992796] [081/133] (665s left) api_intel_bb (object-reloc-keep-cache)
[355.058663] Starting subtest: object-reloc-keep-cache
[355.063773] Subtest object-reloc-keep-cache: SKIP (0.004s)
[355.218148] [082/133] (665s left) syncobj_wait (wait-all-for-submit-delayed-submit)
[355.280098] Starting subtest: wait-all-for-submit-delayed-submit
[355.381643] Subtest wait-all-for-submit-delayed-submit: SUCCESS (0.103s)
[355.479178] [083/133] (664s left) kms_color (degamma)
[355.586455] Starting subtest: degamma
[355.588592] Starting dynamic subtest: pipe-A-eDP-1
[356.310620] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.724s)
[356.320561] Starting dynamic subtest: pipe-B-eDP-1
[357.784529] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.475s)
[357.796198] Starting dynamic subtest: pipe-C-eDP-1
[359.127917] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.339s)
[359.137908] Starting dynamic subtest: pipe-D-eDP-1
[360.460975] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.330s)
[360.463819] Subtest degamma: SUCCESS (4.873s)
[361.268405] [084/133] (659s left) gem_userptr_blits (coherency-unsync)
[361.349772] Subtest coherency-unsync: SKIP (0.000s)
[361.502785] [085/133] (658s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip)
[361.613825] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip
[362.226697] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SUCCESS (0.615s)
[362.414056] [086/133] (657s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-180)
[362.514078] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-180
[362.518982] Subtest y-tiled-max-hw-stride-32bpp-rotate-180: SKIP (0.000s)
[362.641263] [087/133] (657s left) kms_plane_scaling (2x-scaler-multi-pipe)
[362.737949] Starting subtest: 2x-scaler-multi-pipe
[362.742950] Subtest 2x-scaler-multi-pipe: SKIP (0.001s)
[362.867342] [088/133] (657s left) gem_exec_parallel (fds)
[362.940861] Starting subtest: fds
[362.943563] Starting dynamic subtest: rcs0
[366.274541] Dynamic subtest rcs0: SUCCESS (3.331s)
[366.286668] Starting dynamic subtest: bcs0
[370.643470] Dynamic subtest bcs0: SUCCESS (4.366s)
[370.655956] Starting dynamic subtest: vcs0
[375.929036] Dynamic subtest vcs0: SUCCESS (5.281s)
[375.940513] Starting dynamic subtest: vcs1
[380.131440] Dynamic subtest vcs1: SUCCESS (4.201s)
[380.140924] Starting dynamic subtest: vecs0
[385.937839] Dynamic subtest vecs0: SUCCESS (5.804s)
[385.950571] Starting dynamic subtest: ccs0
[390.748245] Dynamic subtest ccs0: SUCCESS (4.808s)
[390.751355] Subtest fds: SUCCESS (27.801s)
[390.964426] [089/133] (629s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-mmap-gtt)
[391.086737] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-mmap-gtt
[391.091738] Subtest fbc-2p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[391.206532] [090/133] (629s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-blt)
[391.302407] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-blt
[391.307558] Subtest fbc-2p-scndscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[391.408146] [091/133] (629s left) kms_getfb (getfb2-into-addfb2)
[391.506206] Starting subtest: getfb2-into-addfb2
[391.508673] Subtest getfb2-into-addfb2: SUCCESS (0.000s)
[391.610128] [092/133] (629s left) kms_flip (busy-flip)
[391.700985] Starting subtest: busy-flip
[391.703335] Starting dynamic subtest: A-eDP1
[393.376931] Dynamic subtest A-eDP1: SUCCESS (1.678s)
[393.387754] Starting dynamic subtest: B-eDP1
[395.019632] Dynamic subtest B-eDP1: SUCCESS (1.641s)
[395.029531] Starting dynamic subtest: C-eDP1
[396.730174] Dynamic subtest C-eDP1: SUCCESS (1.708s)
[396.742986] Starting dynamic subtest: D-eDP1
[398.365677] Dynamic subtest D-eDP1: SUCCESS (1.634s)
[398.368572] Subtest busy-flip: SUCCESS (6.670s)
[399.564129] [093/133] (621s left) gem_ctx_sseu (mmap-args)
[399.626727] Subtest mmap-args: SKIP (0.000s)
[399.702409] [094/133] (621s left) kms_cursor_crc (cursor-random-32x32)
[399.859966] Starting subtest: cursor-random-32x32
[399.905315] Subtest cursor-random-32x32: SKIP (0.042s)
[400.234310] [095/133] (620s left) kms_ccs (ccs-on-another-bo-y-tiled-gen12-rc-ccs-cc)
[400.335718] Starting subtest: ccs-on-another-bo-y-tiled-gen12-rc-ccs-cc
[400.338213] Starting dynamic subtest: pipe-A-eDP-1
[400.362084] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[400.370943] Starting dynamic subtest: pipe-B-eDP-1
[400.396952] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[400.407054] Starting dynamic subtest: pipe-C-eDP-1
[400.429789] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[400.437957] Starting dynamic subtest: pipe-D-eDP-1
[400.461066] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[400.465702] Subtest ccs-on-another-bo-y-tiled-gen12-rc-ccs-cc: SKIP (0.005s)
[402.610401] [096/133] (618s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-mmap-cpu)
[402.714615] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-mmap-cpu
[406.682097] Subtest fbc-1p-offscreen-pri-shrfb-draw-mmap-cpu: SUCCESS (3.977s)
[407.811056] [097/133] (613s left) gem_exec_schedule (u-submit-late-slice)
[407.889621] Starting subtest: u-submit-late-slice
[407.891740] Starting dynamic subtest: rcs0
[407.918672] Dynamic subtest rcs0: SUCCESS (0.039s)
[407.929570] Starting dynamic subtest: bcs0
[407.949766] Dynamic subtest bcs0: SUCCESS (0.031s)
[407.962365] Starting dynamic subtest: vcs0
[407.980824] Dynamic subtest vcs0: SUCCESS (0.029s)
[407.989955] Starting dynamic subtest: vcs1
[408.017911] Dynamic subtest vcs1: SUCCESS (0.037s)
[408.034788] Starting dynamic subtest: vecs0
[408.051056] Dynamic subtest vecs0: SUCCESS (0.031s)
[408.062287] Starting dynamic subtest: ccs0
[408.079565] Dynamic subtest ccs0: SUCCESS (0.028s)
[408.082293] Subtest u-submit-late-slice: SUCCESS (0.200s)
[410.007772] [098/133] (610s left) kms_frontbuffer_tracking (fbcpsr-stridechange)
[410.118595] Starting subtest: fbcpsr-stridechange
[416.337691] Subtest fbcpsr-stridechange: SUCCESS (6.222s)
[416.505503] [099/133] (604s left) dumb_buffer (map-valid)
[416.562683] Starting subtest: map-valid
[416.565409] Subtest map-valid: SUCCESS (0.000s)
[416.676209] [100/133] (604s left) perf_pmu (idle)
[416.725218] Starting subtest: idle
[416.727961] Starting dynamic subtest: rcs0
[417.293185] Dynamic subtest rcs0: SUCCESS (0.570s)
[417.305939] Starting dynamic subtest: bcs0
[417.819876] Dynamic subtest bcs0: SUCCESS (0.524s)
[417.829579] Starting dynamic subtest: vcs0
[418.346297] Dynamic subtest vcs0: SUCCESS (0.524s)
[418.358934] Starting dynamic subtest: vcs1
[418.877302] Dynamic subtest vcs1: SUCCESS (0.525s)
[418.887797] Starting dynamic subtest: vecs0
[419.400653] Dynamic subtest vecs0: SUCCESS (0.525s)
[419.413422] Starting dynamic subtest: ccs0
[419.929929] Dynamic subtest ccs0: SUCCESS (0.527s)
[419.932819] Subtest idle: SUCCESS (3.209s)
[420.056435] [101/133] (600s left) kms_pm_rpm (i2c)
[422.009816] Starting subtest: i2c
[427.364839] Subtest i2c: SUCCESS (5.356s)
[427.466043] [102/133] (593s left) kms_big_fb (linear-64bpp-rotate-180)
[427.568186] Starting subtest: linear-64bpp-rotate-180
[429.330597] Subtest linear-64bpp-rotate-180: SUCCESS (1.762s)
[429.507737] [103/133] (591s left) kms_feature_discovery (dp-mst)
[429.601198] Starting subtest: dp-mst
[429.605248] Subtest dp-mst: SKIP (0.000s)
[429.683104] [104/133] (591s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-blt)
[429.788189] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-blt
[429.793048] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-blt: SKIP (0.000s)
[429.946089] [105/133] (591s left) kms_pipe_stress (stress-xrgb8888-untiled)
[430.047523] Starting subtest: stress-xrgb8888-untiled
[435.982596] Subtest stress-xrgb8888-untiled: SUCCESS (5.935s)
[436.040700] [106/133] (585s left) gem_softpin (invalid)
[436.105611] Starting subtest: invalid
[436.112426] Subtest invalid: SUCCESS (0.006s)
[436.262828] [107/133] (585s left) kms_psr2_sf (fbc-psr2-overlay-plane-update-continuous-sf)
[441.336675] Starting subtest: fbc-psr2-overlay-plane-update-continuous-sf
[441.339620] Starting dynamic subtest: pipe-A-eDP-1
[442.134927] Dynamic subtest pipe-A-eDP-1: SKIP (0.794s)
[442.145257] Starting dynamic subtest: pipe-B-eDP-1
[443.276756] Dynamic subtest pipe-B-eDP-1: SKIP (1.140s)
[443.282442] Subtest fbc-psr2-overlay-plane-update-continuous-sf: SKIP (1.937s)
[444.472406] [108/133] (576s left) kms_rotation_crc (primary-x-tiled-reflect-x-0)
[444.575757] Starting subtest: primary-x-tiled-reflect-x-0
[451.683785] Subtest primary-x-tiled-reflect-x-0: SUCCESS (7.108s)
[452.933582] [109/133] (568s left) i915_drm_fdinfo (busy)
[452.983954] Starting subtest: busy
[452.986425] Starting dynamic subtest: rcs0
[453.002031] Dynamic subtest rcs0: SKIP (0.016s)
[453.012802] Starting dynamic subtest: bcs0
[453.018490] Dynamic subtest bcs0: SKIP (0.012s)
[453.027632] Starting dynamic subtest: vcs0
[453.032956] Dynamic subtest vcs0: SKIP (0.000s)
[453.042563] Starting dynamic subtest: vcs1
[453.047797] Dynamic subtest vcs1: SKIP (0.000s)
[453.056761] Starting dynamic subtest: vecs0
[453.061940] Dynamic subtest vecs0: SKIP (0.000s)
[453.070917] Starting dynamic subtest: ccs0
[453.075951] Dynamic subtest ccs0: SKIP (0.000s)
[453.080936] Subtest busy: SKIP (0.033s)
[453.120640] [110/133] (568s left) kms_big_fb (linear-max-hw-stride-64bpp-rotate-180-hflip)
[453.237871] Starting subtest: linear-max-hw-stride-64bpp-rotate-180-hflip
[453.242938] Subtest linear-max-hw-stride-64bpp-rotate-180-hflip: SKIP (0.000s)
[453.345637] [111/133] (568s left) kms_scaling_modes (scaling-mode-full)
[453.430688] Starting subtest: scaling-mode-full
[453.433438] Starting dynamic subtest: pipe-A-eDP-1
[453.526245] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.095s)
[453.536585] Starting dynamic subtest: pipe-B-eDP-1
[454.653814] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.127s)
[454.664822] Starting dynamic subtest: pipe-C-eDP-1
[455.758957] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.104s)
[455.768367] Starting dynamic subtest: pipe-D-eDP-1
[456.901440] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.140s)
[456.903956] Subtest scaling-mode-full: SUCCESS (3.470s)
[458.080402] [112/133] (563s left) kms_psr2_sf (fbc-psr2-overlay-plane-move-continuous-exceed-fully-sf)
[463.153401] Starting subtest: fbc-psr2-overlay-plane-move-continuous-exceed-fully-sf
[463.155994] Starting dynamic subtest: pipe-A-eDP-1
[463.938371] Dynamic subtest pipe-A-eDP-1: SKIP (0.782s)
[463.948449] Starting dynamic subtest: pipe-B-eDP-1
[465.057902] Dynamic subtest pipe-B-eDP-1: SKIP (1.120s)
[465.062946] Subtest fbc-psr2-overlay-plane-move-continuous-exceed-fully-sf: SKIP (1.906s)
[466.253300] [113/133] (555s left) gem_exec_schedule (preemptive-hang)
[466.417944] Starting subtest: preemptive-hang
[466.420555] Starting dynamic subtest: rcs0
[476.030124] Dynamic subtest rcs0: SUCCESS (9.611s)
[476.041326] Starting dynamic subtest: bcs0
[484.987529] Dynamic subtest bcs0: SUCCESS (8.956s)
[484.998408] Starting dynamic subtest: vcs0
[493.947736] Dynamic subtest vcs0: SUCCESS (8.960s)
[493.957484] Starting dynamic subtest: vcs1
[502.967763] Dynamic subtest vcs1: SUCCESS (9.021s)
[502.980074] Starting dynamic subtest: vecs0
[511.990975] Dynamic subtest vecs0: SUCCESS (9.025s)
[512.002944] Starting dynamic subtest: ccs0
[520.957623] Dynamic subtest ccs0: SUCCESS (8.966s)
[520.960281] Subtest preemptive-hang: SUCCESS (54.545s)
[521.234851] [114/133] (500s left) syncobj_timeline (multi-wait-all-for-submit-available-submitted)
[521.305845] Starting subtest: multi-wait-all-for-submit-available-submitted
[521.308535] Subtest multi-wait-all-for-submit-available-submitted: SUCCESS (0.000s)
[521.431442] [115/133] (500s left) perf (per-context-mode-unprivileged)
[521.562557] Starting subtest: per-context-mode-unprivileged
[521.566804] Subtest per-context-mode-unprivileged: SKIP (0.000s)
[521.605407] [116/133] (500s left) gem_exec_reloc (basic-gtt-noreloc)
[521.689151] Subtest basic-gtt-noreloc: SKIP (0.000s)
[521.775865] [117/133] (499s left) kms_flip (2x-flip-vs-dpms)
[521.879755] Starting subtest: 2x-flip-vs-dpms
[521.898730] Subtest 2x-flip-vs-dpms: SKIP (0.017s)
[521.991797] [118/133] (499s left) gem_ctx_exec (basic-close-race)
[522.056855] Starting subtest: basic-close-race
[527.989187] Subtest basic-close-race: SUCCESS (5.931s)
[528.162443] [119/133] (493s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-gtt)
[528.271853] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-gtt
[528.276442] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[528.388719] [120/133] (493s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-64bpp-yftile-upscaling)
[528.486716] Starting subtest: flip-32bpp-yftile-to-64bpp-yftile-upscaling
[528.491876] Subtest flip-32bpp-yftile-to-64bpp-yftile-upscaling: SKIP (0.000s)
[528.571558] [121/133] (493s left) gem_ctx_param (invalid-get-no-zeromap)
[528.636941] Starting subtest: invalid-get-no-zeromap
[528.639865] Subtest invalid-get-no-zeromap: SUCCESS (0.001s)
[528.768034] [122/133] (493s left) dumb_buffer (invalid-bpp)
[528.828922] Starting subtest: invalid-bpp
[528.831732] Subtest invalid-bpp: SUCCESS (0.000s)
[528.954376] [123/133] (493s left) kms_addfb_basic (basic)
[529.016612] Starting subtest: basic
[529.018330] Subtest basic: SUCCESS (0.000s)
[529.167806] [124/133] (492s left) kms_plane (pixel-format-4-tiled-modifier-source-clamping)
[529.265337] Starting subtest: pixel-format-4-tiled-modifier-source-clamping
[529.291797] Starting dynamic subtest: pipe-A-plane-0
[529.971495] Dynamic subtest pipe-A-plane-0: SUCCESS (0.677s)
[529.981967] Starting dynamic subtest: pipe-A-plane-3
[530.435759] Dynamic subtest pipe-A-plane-3: SUCCESS (0.466s)
[530.445178] Starting dynamic subtest: pipe-A-plane-5
[530.448579] Dynamic subtest pipe-A-plane-5: SKIP (0.000s)
[531.512924] Starting dynamic subtest: pipe-B-plane-0
[532.195720] Dynamic subtest pipe-B-plane-0: SUCCESS (0.689s)
[532.205984] Starting dynamic subtest: pipe-B-plane-3
[532.650523] Dynamic subtest pipe-B-plane-3: SUCCESS (0.455s)
[532.659648] Starting dynamic subtest: pipe-B-plane-5
[532.663741] Dynamic subtest pipe-B-plane-5: SKIP (0.000s)
[532.977941] Subtest pixel-format-4-tiled-modifier-source-clamping: SUCCESS (3.714s)
[533.792031] [125/133] (488s left) perf_pmu (busy-double-start)
[533.840265] Starting subtest: busy-double-start
[533.842786] Starting dynamic subtest: rcs0
[537.497927] Dynamic subtest rcs0: FAIL (3.587s)
[537.508569] Starting dynamic subtest: bcs0
[540.993966] Dynamic subtest bcs0: SUCCESS (3.568s)
[541.005347] Starting dynamic subtest: vcs0
[545.404392] Dynamic subtest vcs0: SUCCESS (4.409s)
[545.416836] Starting dynamic subtest: vcs1
[549.440957] Dynamic subtest vcs1: SUCCESS (4.035s)
[549.453972] Starting dynamic subtest: vecs0
[553.371257] Dynamic subtest vecs0: SUCCESS (3.929s)
[553.383967] Starting dynamic subtest: ccs0
[557.024922] Dynamic subtest ccs0: FAIL (3.568s)
[557.027438] Subtest busy-double-start: FAIL (23.106s)
[557.075660] [126/133] (465s left) gem_ctx_param (basic-default)
[557.138543] Starting subtest: basic-default
[557.141414] Subtest basic-default: SUCCESS (0.000s)
[557.230286] [127/133] (464s left) gem_mmap_gtt (big-bo-tiledx)
[557.295705] Subtest big-bo-tiledX: SKIP (0.000s)
[557.362639] [128/133] (464s left) gem_userptr_blits (stress-mm)
[557.435336] Starting subtest: stress-mm
[562.800517] Subtest stress-mm: SUCCESS (5.369s)
[562.956106] [129/133] (459s left) prime_vgem (fence-read-hang)
[563.032771] Subtest fence-read-hang: SKIP (0.000s)
[563.143163] [130/133] (459s left) kms_flip (2x-flip-vs-expired-vblank-interruptible)
[563.239708] Starting subtest: 2x-flip-vs-expired-vblank-interruptible
[563.252578] Subtest 2x-flip-vs-expired-vblank-interruptible: SKIP (0.011s)
[563.339009] [131/133] (459s left) kms_psr (fbc-psr-primary-render)
[563.437846] Starting subtest: fbc-psr-primary-render
[563.440168] Starting dynamic subtest: eDP-1
[563.444688] Dynamic subtest eDP-1: SKIP (0.000s)
[563.449274] Subtest fbc-psr-primary-render: SKIP (0.001s)
[563.520553] [132/133] (458s left) kms_frontbuffer_tracking (psr-modesetfrombusy)
[563.613622] Starting subtest: psr-modesetfrombusy
[569.736974] Subtest psr-modesetfrombusy: SUCCESS (6.129s)
[569.908292] [133/133] (452s left) kms_pm_rpm (system-suspend-modeset)
[572.035511] Starting subtest: system-suspend-modeset
[591.195490] Subtest system-suspend-modeset: SUCCESS (4.306s)
[591.578663] 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.