[57.309966] Initializing watchdogs
[57.310016]   /dev/watchdog0
[57.323314] [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]
[57.327635] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[57.329850] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[57.333973] [001/133] (960s left) kms_frontbuffer_tracking (fbcpsr-farfromfence-mmap-gtt)
[57.467650] Starting subtest: fbcpsr-farfromfence-mmap-gtt
[57.472182] Subtest fbcpsr-farfromfence-mmap-gtt: SKIP (0.000s)
[57.577488] [002/133] (960s left) syncobj_timeline (wait-for-submit-delayed-submit)
[57.631800] Starting subtest: wait-for-submit-delayed-submit
[57.736226] Subtest wait-for-submit-delayed-submit: SUCCESS (0.103s)
[57.820431] [003/133] (960s left) kms_chamelium_hpd (dp-hpd)
[58.195502] Subtest dp-hpd: SKIP (0.000s)
[58.963670] [004/133] (958s left) kms_cursor_edge_walk (256x256-top-bottom)
[59.063200] Starting subtest: 256x256-top-bottom
[59.065630] Starting dynamic subtest: pipe-A-eDP-1
[62.573211] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.496s)
[62.581934] Starting dynamic subtest: pipe-D-eDP-1
[65.701022] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.117s)
[65.703332] Subtest 256x256-top-bottom: SUCCESS (6.615s)
[66.541595] [005/133] (951s left) gem_mmap_offset (clear)
[66.601132] Starting subtest: clear
[66.603698] Starting dynamic subtest: smem0
[92.219507] Dynamic subtest smem0: SUCCESS (25.596s)
[92.221841] Subtest clear: SUCCESS (25.597s)
[92.364948] [006/133] (925s left) kms_joiner (basic-force-big-joiner)
[92.508568] Starting subtest: basic-force-big-joiner
[92.513095] Subtest basic-force-big-joiner: SKIP (0.000s)
[92.602749] [007/133] (925s left) gem_exec_balancer (waits)
[92.680484] Starting subtest: waits
[99.106512] Subtest waits: SUCCESS (6.424s)
[99.426649] [008/133] (918s left) gem_exec_whisper (basic-queues)
[99.483085] Starting subtest: basic-queues
[106.871058] Subtest basic-queues: SUCCESS (7.382s)
[107.060151] [009/133] (911s left) gem_exec_suspend (basic-s3)
[107.128752] Starting subtest: basic-S3
[107.131218] Starting dynamic subtest: smem
[127.806074] Dynamic subtest smem: SUCCESS (6.710s)
[127.809174] Subtest basic-S3: SUCCESS (6.711s)
[127.999758] [010/133] (890s left) kms_psr (psr2-sprite-render)
[128.116794] Starting subtest: psr2-sprite-render
[128.119238] Starting dynamic subtest: eDP-1
[129.838712] Dynamic subtest eDP-1: SUCCESS (1.686s)
[129.841041] Subtest psr2-sprite-render: SUCCESS (1.687s)
[130.721281] [011/133] (887s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-mmap-wc)
[130.838340] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-mmap-wc
[137.577341] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-mmap-wc: SUCCESS (6.668s)
[137.737839] [012/133] (880s left) kms_content_protection (atomic)
[137.889820] Starting subtest: atomic
[137.894455] Subtest atomic: SKIP (0.000s)
[138.030622] [013/133] (880s left) kms_async_flips (invalid-async-flip)
[138.134846] Starting subtest: invalid-async-flip
[138.507876] Starting dynamic subtest: pipe-A-eDP-1
[139.342783] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.831s)
[139.708513] Starting dynamic subtest: pipe-B-eDP-1
[140.482007] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.782s)
[140.836171] Starting dynamic subtest: pipe-C-eDP-1
[141.619220] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.787s)
[141.976382] Starting dynamic subtest: pipe-D-eDP-1
[142.748869] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.776s)
[142.751275] Subtest invalid-async-flip: SUCCESS (4.593s)
[143.924107] [014/133] (874s left) kms_flip (blocking-absolute-wf_vblank)
[144.020129] Starting subtest: blocking-absolute-wf_vblank
[144.022357] Starting dynamic subtest: A-eDP1
[152.784038] Dynamic subtest A-eDP1: SUCCESS (8.745s)
[152.793013] Starting dynamic subtest: B-eDP1
[161.518067] Dynamic subtest B-eDP1: SUCCESS (8.728s)
[161.526350] Starting dynamic subtest: C-eDP1
[170.235294] Dynamic subtest C-eDP1: SUCCESS (8.714s)
[170.245980] Starting dynamic subtest: D-eDP1
[178.961055] Dynamic subtest D-eDP1: SUCCESS (8.722s)
[178.966115] Subtest blocking-absolute-wf_vblank: SUCCESS (34.918s)
[180.182634] [015/133] (838s left) gem_exec_schedule (reorder-wide)
[180.370037] Subtest reorder-wide: SKIP (0.000s)
[180.559025] [016/133] (837s left) gem_watchdog (default-virtual)
[180.641258] Starting subtest: default-virtual
[186.916078] Subtest default-virtual: SUCCESS (6.281s)
[187.019348] [017/133] (831s left) gem_pwrite (basic-self)
[187.079696] Subtest basic-self: SKIP (0.000s)
[187.138579] [018/133] (831s left) kms_psr (fbc-psr2-cursor-mmap-gtt)
[187.241053] Starting subtest: fbc-psr2-cursor-mmap-gtt
[187.243254] Starting dynamic subtest: eDP-1
[187.247459] Dynamic subtest eDP-1: SKIP (0.000s)
[187.251804] Subtest fbc-psr2-cursor-mmap-gtt: SKIP (0.001s)
[187.324453] [019/133] (831s left) kms_cursor_legacy (forked-move)
[187.452754] Starting subtest: forked-move
[187.454990] Starting dynamic subtest: pipe-A
[192.930637] Dynamic subtest pipe-A: SUCCESS (5.473s)
[192.943013] Starting dynamic subtest: pipe-B
[198.422961] Dynamic subtest pipe-B: SUCCESS (5.489s)
[198.434221] Starting dynamic subtest: pipe-C
[203.903419] Dynamic subtest pipe-C: SUCCESS (5.477s)
[203.914914] Starting dynamic subtest: pipe-D
[209.382200] Dynamic subtest pipe-D: SUCCESS (5.475s)
[209.393116] Starting dynamic subtest: all-pipes
[214.893730] Dynamic subtest all-pipes: SUCCESS (5.507s)
[214.896167] Subtest forked-move: SUCCESS (27.427s)
[215.082703] [020/133] (803s left) vgem_basic (debugfs)
[215.214054] Starting subtest: debugfs
[215.216365] Subtest debugfs: SUCCESS (0.000s)
[215.288771] [FACT vgem_basic (debugfs)] new: kernel.kmod_is_loaded.vgem: true
[215.291788] [021/133] (803s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-pwrite)
[215.403026] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-pwrite
[215.407099] Subtest fbc-2p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[215.521920] [022/133] (803s left) kms_plane_lowres (tiling-yf)
[215.622662] Starting subtest: tiling-yf
[215.626777] Subtest tiling-yf: SKIP (0.000s)
[215.704218] [023/133] (802s left) kms_flip (2x-flip-vs-dpms-off-vs-modeset)
[215.809274] Starting subtest: 2x-flip-vs-dpms-off-vs-modeset
[215.817947] Subtest 2x-flip-vs-dpms-off-vs-modeset: SKIP (0.010s)
[215.950520] [024/133] (802s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-32bpp-xtile-upscaling)
[216.057363] Starting subtest: flip-64bpp-xtile-to-32bpp-xtile-upscaling
[216.059330] Starting dynamic subtest: pipe-A-default-mode
[218.844461] Dynamic subtest pipe-A-default-mode: SUCCESS (2.785s)
[218.847025] Subtest flip-64bpp-xtile-to-32bpp-xtile-upscaling: SUCCESS (2.786s)
[219.699481] [025/133] (799s left) kms_vrr (flip-basic)
[219.794540] Starting subtest: flip-basic
[219.800791] Subtest flip-basic: SKIP (0.000s)
[219.876551] [026/133] (798s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-mmap-cpu)
[219.969113] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-mmap-cpu
[219.973443] Subtest fbc-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[220.104831] [027/133] (798s left) kms_flip (modeset-vs-vblank-race-interruptible)
[220.214872] Starting subtest: modeset-vs-vblank-race-interruptible
[220.217173] Starting dynamic subtest: A-eDP1
[224.909080] Dynamic subtest A-eDP1: SUCCESS (4.694s)
[224.919229] Starting dynamic subtest: B-eDP1
[229.538813] Dynamic subtest B-eDP1: SUCCESS (4.629s)
[229.550317] Starting dynamic subtest: C-eDP1
[234.089734] Dynamic subtest C-eDP1: SUCCESS (4.551s)
[234.099033] Starting dynamic subtest: D-eDP1
[238.700735] Dynamic subtest D-eDP1: SUCCESS (4.610s)
[238.703054] Subtest modeset-vs-vblank-race-interruptible: SUCCESS (18.494s)
[239.975361] [028/133] (778s left) kms_addfb_basic (bad-pitch-63)
[240.034492] Starting subtest: bad-pitch-63
[240.036765] Subtest bad-pitch-63: SUCCESS (0.000s)
[240.177836] [029/133] (778s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-mmap-wc)
[240.279749] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-mmap-wc
[240.284203] Subtest psr-2p-scndscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[240.396998] [030/133] (778s left) syncobj_wait (invalid-reset-one-illegal-handle)
[240.453865] Starting subtest: invalid-reset-one-illegal-handle
[240.456352] Subtest invalid-reset-one-illegal-handle: SUCCESS (0.000s)
[240.568059] [031/133] (778s left) gem_ctx_persistence (legacy-engines-queued)
[240.626195] Starting subtest: legacy-engines-queued
[240.628472] Starting dynamic subtest: render
[240.707709] Dynamic subtest render: SUCCESS (0.081s)
[240.718595] Starting dynamic subtest: bsd1
[241.819643] Dynamic subtest bsd1: SUCCESS (1.109s)
[241.830921] Starting dynamic subtest: bsd2
[243.802718] Dynamic subtest bsd2: SUCCESS (1.982s)
[243.820877] Starting dynamic subtest: blt
[243.879191] Dynamic subtest blt: SUCCESS (0.075s)
[243.890198] Starting dynamic subtest: vebox
[245.788409] Dynamic subtest vebox: SUCCESS (1.905s)
[245.791484] Subtest legacy-engines-queued: SUCCESS (5.162s)
[245.878899] [032/133] (773s left) syncobj_wait (invalid-single-wait-unsubmitted)
[245.939356] Starting subtest: invalid-single-wait-unsubmitted
[245.941757] Subtest invalid-single-wait-unsubmitted: SUCCESS (0.000s)
[246.057563] [033/133] (773s left) gem_pxp (verify-pxp-stale-ctx-execution)
[246.183952] Starting subtest: verify-pxp-stale-ctx-execution
[247.251641] Subtest verify-pxp-stale-ctx-execution: SUCCESS (1.068s)
[247.387947] [034/133] (771s left) gem_mmap_gtt (cpuset-basic-small-copy-odd)
[247.439882] Subtest cpuset-basic-small-copy-odd: SKIP (0.000s)
[247.502548] [035/133] (771s left) kms_cursor_crc (cursor-onscreen-512x170)
[247.767826] Starting subtest: cursor-onscreen-512x170
[247.772108] Subtest cursor-onscreen-512x170: SKIP (0.001s)
[247.933022] [036/133] (771s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-mmap-cpu)
[248.041190] Starting subtest: psr-1p-primscrn-spr-indfb-draw-mmap-cpu
[254.664669] Subtest psr-1p-primscrn-spr-indfb-draw-mmap-cpu: SUCCESS (6.627s)
[254.836507] [037/133] (764s left) kms_chamelium_color (ctm-0-25)
[254.941175] Subtest ctm-0-25: SKIP (0.000s)
[254.989602] [038/133] (764s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted-signaled)
[255.045438] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted-signaled
[255.153170] Subtest etime-multi-wait-all-for-submit-unsubmitted-signaled: SUCCESS (0.107s)
[255.240187] [039/133] (764s left) gem_exec_fence (syncobj-timeline-unused-fence)
[255.775183] Starting subtest: syncobj-timeline-unused-fence
[255.780731] Subtest syncobj-timeline-unused-fence: SUCCESS (0.007s)
[256.956200] [040/133] (762s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-blt)
[257.056413] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-blt
[257.060834] Subtest fbc-2p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[257.195041] [041/133] (762s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-pwrite)
[257.296959] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-pwrite
[257.301321] Subtest fbc-2p-scndscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[257.422212] [042/133] (762s left) kms_chamelium_frames (hdmi-cmp-planar-formats)
[257.813575] Subtest hdmi-cmp-planar-formats: SKIP (0.000s)
[258.618936] [043/133] (760s left) kms_plane_scaling (plane-downscale-factor-0-5-with-pixel-format)
[258.707820] Starting subtest: plane-downscale-factor-0-5-with-pixel-format
[258.709974] Starting dynamic subtest: pipe-A
[258.727144] Dynamic subtest pipe-A: SKIP (0.017s)
[258.741905] Starting dynamic subtest: pipe-B
[258.756864] Dynamic subtest pipe-B: SKIP (0.029s)
[258.771395] Starting dynamic subtest: pipe-C
[258.788320] Dynamic subtest pipe-C: SKIP (0.029s)
[258.797874] Starting dynamic subtest: pipe-D
[258.817032] Dynamic subtest pipe-D: SKIP (0.029s)
[258.820827] Subtest plane-downscale-factor-0-5-with-pixel-format: SKIP (0.106s)
[258.954303] [044/133] (760s left) gem_render_copy (y-tiled-to-vebox-x-tiled)
[259.020407] Starting subtest: y-tiled-to-vebox-x-tiled
[259.025087] Subtest y-tiled-to-vebox-x-tiled: SKIP (0.000s)
[259.212207] [045/133] (760s left) gen9_exec_parse (batch-without-end)
[259.272926] Subtest batch-without-end: SKIP (0.000s)
[259.359141] [046/133] (760s left) syncobj_timeline (etime-single-wait-submitted)
[259.420957] Starting subtest: etime-single-wait-submitted
[259.529382] Subtest etime-single-wait-submitted: SUCCESS (0.108s)
[259.632009] [047/133] (759s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180-hflip)
[259.743396] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180-hflip
[259.747320] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180-hflip: SKIP (0.000s)
[259.880191] [048/133] (759s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc)
[259.987587] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc
[266.495264] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc: SUCCESS (6.510s)
[266.651063] [049/133] (753s left) kms_ccs (crc-primary-suspend-y-tiled-gen12-rc-ccs)
[266.740353] Starting subtest: crc-primary-suspend-y-tiled-gen12-rc-ccs
[266.742659] Starting dynamic subtest: pipe-A-eDP-1
[266.751800] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[266.766914] Starting dynamic subtest: pipe-B-eDP-1
[266.775976] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[266.786531] Starting dynamic subtest: pipe-C-eDP-1
[266.794988] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[266.803403] Starting dynamic subtest: pipe-D-eDP-1
[266.811931] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[266.816113] Subtest crc-primary-suspend-y-tiled-gen12-rc-ccs: SKIP (0.004s)
[268.966687] [050/133] (750s left) kms_atomic_transition (plane-use-after-nonblocking-unbind)
[269.087942] Starting subtest: plane-use-after-nonblocking-unbind
[269.090188] Starting dynamic subtest: pipe-A-eDP-1
[269.163698] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.072s)
[269.472356] Starting dynamic subtest: pipe-B-eDP-1
[270.254593] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.790s)
[270.563484] Subtest plane-use-after-nonblocking-unbind: SUCCESS (1.473s)
[271.431460] [051/133] (748s left) gem_partial_pwrite_pread (reads-uncached)
[271.498369] Subtest reads-uncached: SKIP (0.000s)
[271.583724] [052/133] (748s left) syncobj_wait (multi-wait-for-submit-unsubmitted-submitted-signaled)
[271.633714] Starting subtest: multi-wait-for-submit-unsubmitted-submitted-signaled
[271.636243] Subtest multi-wait-for-submit-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[271.746902] [053/133] (748s left) i915_pm_rc6_residency (rc6-fence)
[271.807378] Starting subtest: rc6-fence
[271.826044] Starting dynamic subtest: gt0
[284.149865] Dynamic subtest gt0: SUCCESS (12.321s)
[284.161319] Starting dynamic subtest: gt1
[298.813323] Dynamic subtest gt1: SUCCESS (14.656s)
[298.816107] Subtest rc6-fence: SUCCESS (27.002s)
[298.901909] [054/133] (721s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite)
[299.008436] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite
[299.012450] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[299.148020] [055/133] (720s left) kms_frontbuffer_tracking (psr-2p-primscrn-indfb-msflip-blt)
[299.254539] Starting subtest: psr-2p-primscrn-indfb-msflip-blt
[299.258966] Subtest psr-2p-primscrn-indfb-msflip-blt: SKIP (0.000s)
[299.398354] [056/133] (720s left) kms_big_fb (yf-tiled-16bpp-rotate-180)
[299.510114] Starting subtest: yf-tiled-16bpp-rotate-180
[299.514339] Subtest yf-tiled-16bpp-rotate-180: SKIP (0.000s)
[299.628117] [057/133] (720s left) gem_ctx_param (root-set)
[299.687407] Starting subtest: root-set
[299.689704] Subtest root-set: SUCCESS (0.002s)
[299.832687] [058/133] (720s left) gem_exec_fence (syncobj-invalid-wait)
[300.246979] Starting subtest: syncobj-invalid-wait
[300.249709] Subtest syncobj-invalid-wait: SUCCESS (0.001s)
[301.908305] [059/133] (718s left) kms_lease (invalid-create-leases)
[302.003237] Starting subtest: invalid-create-leases
[302.008022] Subtest invalid-create-leases: SUCCESS (0.006s)
[302.139518] [060/133] (718s left) kms_ccs (missing-ccs-buffer-4-tiled-mtl-mc-ccs)
[302.239875] Starting subtest: missing-ccs-buffer-4-tiled-mtl-mc-ccs
[302.242091] Starting dynamic subtest: pipe-A-eDP-1
[302.261953] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.021s)
[302.273114] Starting dynamic subtest: pipe-B-eDP-1
[302.292478] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.019s)
[302.301402] Starting dynamic subtest: pipe-C-eDP-1
[302.320389] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.019s)
[302.329160] Starting dynamic subtest: pipe-D-eDP-1
[302.349018] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.019s)
[302.351337] Subtest missing-ccs-buffer-4-tiled-mtl-mc-ccs: SUCCESS (0.084s)
[304.509355] [061/133] (715s left) kms_sequence (queue-busy)
[304.612663] Starting subtest: queue-busy
[304.614852] Starting dynamic subtest: pipe-A-eDP-1
[306.543283] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.931s)
[306.552612] Starting dynamic subtest: pipe-B-eDP-1
[309.101539] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.555s)
[309.110986] Starting dynamic subtest: pipe-C-eDP-1
[311.738775] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.635s)
[311.748221] Starting dynamic subtest: pipe-D-eDP-1
[314.361753] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.621s)
[314.364068] Subtest queue-busy: SUCCESS (9.748s)
[315.245262] [062/133] (704s left) prime_vgem (basic-fence-blt)
[315.329199] Starting subtest: basic-fence-blt
[315.407719] Subtest basic-fence-blt: SUCCESS (0.079s)
[315.536317] [063/133] (704s left) i915_suspend (basic-s3-without-i915)
[315.572124] Starting subtest: basic-s3-without-i915
[318.919055] Subtest basic-s3-without-i915: SKIP (3.340s)
[320.526610] [064/133] (699s left) i915_module_load (reload-no-display)
[320.567036] Starting subtest: reload-no-display
[325.005573] Subtest reload-no-display: SUCCESS (4.437s)
[325.036383] [FACT i915_module_load (reload-no-display)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[325.037100] [FACT i915_module_load (reload-no-display)] deleted: kernel.kmod_is_loaded.i915: true
[325.040311] [065/133] (695s left) prime_vgem (basic-gtt)
[326.617926] Starting subtest: basic-gtt
[326.622764] Subtest basic-gtt: SKIP (0.000s)
[326.708205] [FACT prime_vgem (basic-gtt)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[326.709473] [FACT prime_vgem (basic-gtt)] new: kernel.kmod_is_loaded.i915: true
[326.713292] [066/133] (693s left) vgem_basic (second-client)
[326.755864] Starting subtest: second-client
[326.778893] Subtest second-client: SUCCESS (0.022s)
[326.850935] [067/133] (693s left) kms_psr (fbc-pr-dpms)
[326.948005] Starting subtest: fbc-pr-dpms
[326.952315] Subtest fbc-pr-dpms: SKIP (0.000s)
[327.030376] [068/133] (693s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-0-hflip)
[327.138483] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-0-hflip
[327.142978] Subtest yf-tiled-max-hw-stride-32bpp-rotate-0-hflip: SKIP (0.000s)
[327.252544] [069/133] (693s left) gem_exec_balancer (full-late)
[327.313126] Starting subtest: full-late
[331.622726] Subtest full-late: SUCCESS (4.308s)
[331.977232] [070/133] (688s left) kms_psr (pr-primary-mmap-gtt)
[332.086975] Starting subtest: pr-primary-mmap-gtt
[332.091302] Subtest pr-primary-mmap-gtt: SKIP (0.000s)
[332.171790] [071/133] (688s left) syncobj_wait (single-wait-all-signaled)
[332.228758] Starting subtest: single-wait-all-signaled
[332.230709] Subtest single-wait-all-signaled: SUCCESS (0.000s)
[332.357438] [072/133] (688s left) kms_ccs (bad-aux-stride-y-tiled-gen12-rc-ccs-cc)
[332.444341] Starting subtest: bad-aux-stride-y-tiled-gen12-rc-ccs-cc
[332.446660] Starting dynamic subtest: pipe-A-eDP-1
[332.469043] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[332.485021] Starting dynamic subtest: pipe-B-eDP-1
[332.507200] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[332.517068] Starting dynamic subtest: pipe-C-eDP-1
[332.538838] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[332.547562] Starting dynamic subtest: pipe-D-eDP-1
[332.570510] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[332.575052] Subtest bad-aux-stride-y-tiled-gen12-rc-ccs-cc: SKIP (0.004s)
[334.771195] [073/133] (685s left) syncobj_timeline (single-wait-all-available-signaled)
[334.830889] Starting subtest: single-wait-all-available-signaled
[334.832945] Subtest single-wait-all-available-signaled: SUCCESS (0.000s)
[334.939027] [074/133] (685s left) kms_addfb_basic (addfb25-x-tiled-legacy)
[335.020418] Subtest addfb25-x-tiled-legacy: SKIP (0.000s)
[335.130264] [075/133] (685s left) gem_exec_capture (userptr)
[335.191790] Starting subtest: userptr
[335.995106] Subtest userptr: SUCCESS (0.801s)
[336.142966] [076/133] (684s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-render)
[336.268644] Starting subtest: fbcpsr-rgb565-draw-render
[343.311489] Subtest fbcpsr-rgb565-draw-render: SUCCESS (7.041s)
[343.483588] [077/133] (677s left) prime_mmap (test_reprime)
[343.542194] Starting subtest: test_reprime
[343.544035] Starting dynamic subtest: test_reprime-smem
[343.569858] Dynamic subtest test_reprime-smem: SUCCESS (0.029s)
[343.572208] Subtest test_reprime: SUCCESS (0.030s)
[343.707028] [078/133] (677s left) syncobj_wait (wait-all-snapshot)
[343.769912] Starting subtest: wait-all-snapshot
[343.849835] Subtest wait-all-snapshot: SUCCESS (0.081s)
[343.936721] [079/133] (676s left) kms_plane_scaling (planes-downscale-factor-0-75-upscale-20x20)
[344.021427] Starting subtest: planes-downscale-factor-0-75-upscale-20x20
[344.023562] Starting dynamic subtest: pipe-A
[344.086114] Dynamic subtest pipe-A: SUCCESS (0.065s)
[344.096064] Starting dynamic subtest: pipe-B
[345.188850] Dynamic subtest pipe-B: SUCCESS (1.101s)
[345.199368] Starting dynamic subtest: pipe-C
[346.293577] Dynamic subtest pipe-C: SUCCESS (1.104s)
[346.301698] Starting dynamic subtest: pipe-D
[347.416253] Dynamic subtest pipe-D: SUCCESS (1.122s)
[347.418529] Subtest planes-downscale-factor-0-75-upscale-20x20: SUCCESS (3.394s)
[348.587590] [080/133] (672s left) gem_softpin (allocator-fork)
[348.652596] Starting subtest: allocator-fork
[350.864916] Subtest allocator-fork: SUCCESS (2.211s)
[351.006650] [081/133] (669s left) api_intel_bb (object-reloc-keep-cache)
[351.051459] Starting subtest: object-reloc-keep-cache
[351.055875] Subtest object-reloc-keep-cache: SKIP (0.002s)
[351.187261] [082/133] (669s left) syncobj_wait (wait-all-for-submit-delayed-submit)
[351.247401] Starting subtest: wait-all-for-submit-delayed-submit
[351.350795] Subtest wait-all-for-submit-delayed-submit: SUCCESS (0.103s)
[351.443181] [083/133] (669s left) kms_color (degamma)
[351.546939] Starting subtest: degamma
[351.548833] Starting dynamic subtest: pipe-A-eDP-1
[352.266798] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.719s)
[352.275919] Starting dynamic subtest: pipe-B-eDP-1
[353.690351] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.423s)
[353.699356] Starting dynamic subtest: pipe-C-eDP-1
[355.082889] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.391s)
[355.091949] Starting dynamic subtest: pipe-D-eDP-1
[356.499973] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.416s)
[356.502178] Subtest degamma: SUCCESS (4.953s)
[357.322720] [084/133] (663s left) gem_userptr_blits (coherency-unsync)
[357.388708] Subtest coherency-unsync: SKIP (0.000s)
[357.538032] [085/133] (663s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip)
[357.632779] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip
[358.223663] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SUCCESS (0.592s)
[358.431930] [086/133] (662s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-180)
[358.543492] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-180
[358.547677] Subtest y-tiled-max-hw-stride-32bpp-rotate-180: SKIP (0.000s)
[358.652232] [087/133] (662s left) kms_plane_scaling (2x-scaler-multi-pipe)
[358.748964] Starting subtest: 2x-scaler-multi-pipe
[358.753328] Subtest 2x-scaler-multi-pipe: SKIP (0.001s)
[358.871716] [088/133] (662s left) gem_exec_parallel (fds)
[358.926845] Starting subtest: fds
[358.929102] Starting dynamic subtest: rcs0
[361.254319] Dynamic subtest rcs0: SUCCESS (2.327s)
[361.264265] Starting dynamic subtest: bcs0
[364.370560] Dynamic subtest bcs0: SUCCESS (3.113s)
[364.386046] Starting dynamic subtest: vcs0
[368.155953] Dynamic subtest vcs0: SUCCESS (3.783s)
[368.165167] Starting dynamic subtest: vcs1
[372.111763] Dynamic subtest vcs1: SUCCESS (3.954s)
[372.124185] Starting dynamic subtest: vecs0
[376.139875] Dynamic subtest vecs0: SUCCESS (4.027s)
[376.152741] Starting dynamic subtest: ccs0
[379.615911] Dynamic subtest ccs0: SUCCESS (3.474s)
[379.619033] Subtest fds: SUCCESS (20.691s)
[379.819028] [089/133] (641s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-mmap-gtt)
[379.936684] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-mmap-gtt
[379.940997] Subtest fbc-2p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[380.039380] [090/133] (641s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-blt)
[380.143724] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-blt
[380.147978] Subtest fbc-2p-scndscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[380.294936] [091/133] (641s left) kms_getfb (getfb2-into-addfb2)
[380.389219] Starting subtest: getfb2-into-addfb2
[380.391439] Subtest getfb2-into-addfb2: SUCCESS (0.000s)
[380.540864] [092/133] (640s left) kms_flip (busy-flip)
[380.631731] Starting subtest: busy-flip
[380.634009] Starting dynamic subtest: A-eDP1
[382.308826] Dynamic subtest A-eDP1: SUCCESS (1.675s)
[382.320229] Starting dynamic subtest: B-eDP1
[383.964201] Dynamic subtest B-eDP1: SUCCESS (1.654s)
[383.973527] Starting dynamic subtest: C-eDP1
[385.601199] Dynamic subtest C-eDP1: SUCCESS (1.636s)
[385.612017] Starting dynamic subtest: D-eDP1
[387.228038] Dynamic subtest D-eDP1: SUCCESS (1.626s)
[387.233345] Subtest busy-flip: SUCCESS (6.602s)
[388.503520] [093/133] (632s left) gem_ctx_sseu (mmap-args)
[388.558096] Subtest mmap-args: SKIP (0.000s)
[388.635605] [094/133] (632s left) kms_cursor_crc (cursor-random-32x32)
[388.786914] Starting subtest: cursor-random-32x32
[388.839092] Subtest cursor-random-32x32: SKIP (0.046s)
[389.146554] [095/133] (632s left) kms_ccs (ccs-on-another-bo-y-tiled-gen12-rc-ccs-cc)
[389.244098] Starting subtest: ccs-on-another-bo-y-tiled-gen12-rc-ccs-cc
[389.246359] Starting dynamic subtest: pipe-A-eDP-1
[389.268326] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[389.279332] Starting dynamic subtest: pipe-B-eDP-1
[389.300297] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[389.309442] Starting dynamic subtest: pipe-C-eDP-1
[389.331029] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[389.340722] Starting dynamic subtest: pipe-D-eDP-1
[389.362522] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[389.366831] Subtest ccs-on-another-bo-y-tiled-gen12-rc-ccs-cc: SKIP (0.004s)
[391.479125] [096/133] (630s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-mmap-cpu)
[391.585029] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-mmap-cpu
[395.545849] Subtest fbc-1p-offscreen-pri-shrfb-draw-mmap-cpu: SUCCESS (3.963s)
[396.687198] [097/133] (624s left) gem_exec_schedule (u-submit-late-slice)
[396.766769] Starting subtest: u-submit-late-slice
[396.768780] Starting dynamic subtest: rcs0
[396.797326] Dynamic subtest rcs0: SUCCESS (0.038s)
[396.806595] Starting dynamic subtest: bcs0
[396.829457] Dynamic subtest bcs0: SUCCESS (0.031s)
[396.838250] Starting dynamic subtest: vcs0
[396.857783] Dynamic subtest vcs0: SUCCESS (0.027s)
[396.866653] Starting dynamic subtest: vcs1
[396.887224] Dynamic subtest vcs1: SUCCESS (0.029s)
[396.899207] Starting dynamic subtest: vecs0
[396.913104] Dynamic subtest vecs0: SUCCESS (0.025s)
[396.922910] Starting dynamic subtest: ccs0
[396.944509] Dynamic subtest ccs0: SUCCESS (0.031s)
[396.946760] Subtest u-submit-late-slice: SUCCESS (0.186s)
[398.965903] [098/133] (622s left) kms_frontbuffer_tracking (fbcpsr-stridechange)
[399.078543] Starting subtest: fbcpsr-stridechange
[405.327123] Subtest fbcpsr-stridechange: SUCCESS (6.251s)
[405.496416] [099/133] (616s left) dumb_buffer (map-valid)
[405.560091] Starting subtest: map-valid
[405.562347] Subtest map-valid: SUCCESS (0.000s)
[405.667313] [100/133] (616s left) perf_pmu (idle)
[405.715372] Starting subtest: idle
[405.717714] Starting dynamic subtest: rcs0
[406.274983] Dynamic subtest rcs0: SUCCESS (0.560s)
[406.287318] Starting dynamic subtest: bcs0
[406.810620] Dynamic subtest bcs0: SUCCESS (0.533s)
[406.823056] Starting dynamic subtest: vcs0
[407.341003] Dynamic subtest vcs0: SUCCESS (0.527s)
[407.353468] Starting dynamic subtest: vcs1
[407.869806] Dynamic subtest vcs1: SUCCESS (0.527s)
[407.882048] Starting dynamic subtest: vecs0
[408.388553] Dynamic subtest vecs0: SUCCESS (0.516s)
[408.400762] Starting dynamic subtest: ccs0
[408.924202] Dynamic subtest ccs0: SUCCESS (0.533s)
[408.926988] Subtest idle: SUCCESS (3.212s)
[409.053539] [101/133] (612s left) kms_pm_rpm (i2c)
[410.981088] Starting subtest: i2c
[416.337686] Subtest i2c: SUCCESS (5.355s)
[416.436707] [102/133] (605s left) kms_big_fb (linear-64bpp-rotate-180)
[416.544447] Starting subtest: linear-64bpp-rotate-180
[418.025961] Subtest linear-64bpp-rotate-180: SUCCESS (1.481s)
[418.214991] [103/133] (603s left) kms_feature_discovery (dp-mst)
[418.313964] Starting subtest: dp-mst
[418.318451] Subtest dp-mst: SKIP (0.000s)
[418.398935] [104/133] (603s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-blt)
[418.501875] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-blt
[418.505245] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-blt: SKIP (0.000s)
[418.610237] [105/133] (603s left) kms_pipe_stress (stress-xrgb8888-untiled)
[418.709005] Starting subtest: stress-xrgb8888-untiled
[424.630076] Subtest stress-xrgb8888-untiled: SUCCESS (5.920s)
[424.684514] [106/133] (597s left) gem_softpin (invalid)
[424.745302] Starting subtest: invalid
[424.752421] Subtest invalid: SUCCESS (0.007s)
[424.908795] [107/133] (597s left) kms_psr2_sf (fbc-psr2-overlay-plane-update-continuous-sf)
[429.910945] Starting subtest: fbc-psr2-overlay-plane-update-continuous-sf
[429.913232] Starting dynamic subtest: pipe-A-eDP-1
[430.693942] Dynamic subtest pipe-A-eDP-1: SKIP (0.781s)
[430.703737] Starting dynamic subtest: pipe-B-eDP-1
[431.823710] Dynamic subtest pipe-B-eDP-1: SKIP (1.128s)
[431.828199] Subtest fbc-psr2-overlay-plane-update-continuous-sf: SKIP (1.913s)
[433.035086] [108/133] (589s left) kms_rotation_crc (primary-x-tiled-reflect-x-0)
[433.141987] Starting subtest: primary-x-tiled-reflect-x-0
[440.294060] Subtest primary-x-tiled-reflect-x-0: SUCCESS (7.150s)
[441.495717] [109/133] (580s left) i915_drm_fdinfo (busy)
[441.535298] Starting subtest: busy
[441.537171] Starting dynamic subtest: rcs0
[441.574711] Dynamic subtest rcs0: SKIP (0.038s)
[441.585876] Starting dynamic subtest: bcs0
[441.590085] Dynamic subtest bcs0: SKIP (0.000s)
[441.606643] Starting dynamic subtest: vcs0
[441.611192] Dynamic subtest vcs0: SKIP (0.000s)
[441.620796] Starting dynamic subtest: vcs1
[441.625342] Dynamic subtest vcs1: SKIP (0.000s)
[441.635303] Starting dynamic subtest: vecs0
[441.639758] Dynamic subtest vecs0: SKIP (0.000s)
[441.648349] Starting dynamic subtest: ccs0
[441.652680] Dynamic subtest ccs0: SKIP (0.000s)
[441.657108] Subtest busy: SKIP (0.045s)
[441.693036] [110/133] (580s left) kms_big_fb (linear-max-hw-stride-64bpp-rotate-180-hflip)
[441.793446] Starting subtest: linear-max-hw-stride-64bpp-rotate-180-hflip
[441.797508] Subtest linear-max-hw-stride-64bpp-rotate-180-hflip: SKIP (0.000s)
[441.915487] [111/133] (580s left) kms_scaling_modes (scaling-mode-full)
[442.015097] Starting subtest: scaling-mode-full
[442.017061] Starting dynamic subtest: pipe-A-eDP-1
[442.106507] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.093s)
[442.116476] Starting dynamic subtest: pipe-B-eDP-1
[443.297995] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.190s)
[443.310978] Starting dynamic subtest: pipe-C-eDP-1
[444.407523] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.106s)
[444.417251] Starting dynamic subtest: pipe-D-eDP-1
[445.540477] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.132s)
[445.542751] Subtest scaling-mode-full: SUCCESS (3.528s)
[446.722508] [112/133] (575s left) kms_psr2_sf (fbc-psr2-overlay-plane-move-continuous-exceed-fully-sf)
[451.788389] Starting subtest: fbc-psr2-overlay-plane-move-continuous-exceed-fully-sf
[451.790284] Starting dynamic subtest: pipe-A-eDP-1
[452.576492] Dynamic subtest pipe-A-eDP-1: SKIP (0.785s)
[452.586734] Starting dynamic subtest: pipe-B-eDP-1
[453.711433] Dynamic subtest pipe-B-eDP-1: SKIP (1.133s)
[453.715926] Subtest fbc-psr2-overlay-plane-move-continuous-exceed-fully-sf: SKIP (1.922s)
[454.914047] [113/133] (567s left) gem_exec_schedule (preemptive-hang)
[455.108015] Starting subtest: preemptive-hang
[455.110835] Starting dynamic subtest: rcs0
[463.978206] Dynamic subtest rcs0: SUCCESS (8.867s)
[463.988314] Starting dynamic subtest: bcs0
[472.933179] Dynamic subtest bcs0: SUCCESS (8.949s)
[472.944763] Starting dynamic subtest: vcs0
[481.958033] Dynamic subtest vcs0: SUCCESS (9.021s)
[481.969100] Starting dynamic subtest: vcs1
[490.981121] Dynamic subtest vcs1: SUCCESS (9.022s)
[490.997304] Starting dynamic subtest: vecs0
[499.936365] Dynamic subtest vecs0: SUCCESS (8.951s)
[499.953097] Starting dynamic subtest: ccs0
[508.971188] Dynamic subtest ccs0: SUCCESS (9.031s)
[508.973500] Subtest preemptive-hang: SUCCESS (53.853s)
[509.224113] [114/133] (513s left) syncobj_timeline (multi-wait-all-for-submit-available-submitted)
[509.291461] Starting subtest: multi-wait-all-for-submit-available-submitted
[509.293808] Subtest multi-wait-all-for-submit-available-submitted: SUCCESS (0.001s)
[509.407959] [115/133] (512s left) perf (per-context-mode-unprivileged)
[509.543762] Starting subtest: per-context-mode-unprivileged
[509.548446] Subtest per-context-mode-unprivileged: SKIP (0.000s)
[509.593653] [116/133] (512s left) gem_exec_reloc (basic-gtt-noreloc)
[509.656652] Subtest basic-gtt-noreloc: SKIP (0.000s)
[509.746522] [117/133] (512s left) kms_flip (2x-flip-vs-dpms)
[509.849915] Starting subtest: 2x-flip-vs-dpms
[509.858909] Subtest 2x-flip-vs-dpms: SKIP (0.011s)
[509.980110] [118/133] (512s left) gem_ctx_exec (basic-close-race)
[510.040549] Starting subtest: basic-close-race
[515.837083] Subtest basic-close-race: SUCCESS (5.795s)
[515.987281] [119/133] (506s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-gtt)
[516.084480] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-gtt
[516.088757] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[516.213565] [120/133] (506s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-64bpp-yftile-upscaling)
[516.307627] Starting subtest: flip-32bpp-yftile-to-64bpp-yftile-upscaling
[516.311846] Subtest flip-32bpp-yftile-to-64bpp-yftile-upscaling: SKIP (0.000s)
[516.394566] [121/133] (506s left) gem_ctx_param (invalid-get-no-zeromap)
[516.455199] Starting subtest: invalid-get-no-zeromap
[516.457681] Subtest invalid-get-no-zeromap: SUCCESS (0.001s)
[516.573415] [122/133] (506s left) dumb_buffer (invalid-bpp)
[516.637218] Starting subtest: invalid-bpp
[516.639094] Subtest invalid-bpp: SUCCESS (0.000s)
[516.751648] [123/133] (505s left) kms_addfb_basic (basic)
[516.813270] Starting subtest: basic
[516.815550] Subtest basic: SUCCESS (0.000s)
[516.972152] [124/133] (505s left) kms_plane (pixel-format-4-tiled-modifier-source-clamping)
[517.070497] Starting subtest: pixel-format-4-tiled-modifier-source-clamping
[517.097100] Starting dynamic subtest: pipe-A-plane-0
[517.719614] Dynamic subtest pipe-A-plane-0: SUCCESS (0.622s)
[517.731592] Starting dynamic subtest: pipe-A-plane-3
[518.119187] Dynamic subtest pipe-A-plane-3: SUCCESS (0.397s)
[518.127816] Starting dynamic subtest: pipe-A-plane-5
[518.131231] Dynamic subtest pipe-A-plane-5: SKIP (0.000s)
[519.208705] Starting dynamic subtest: pipe-B-plane-0
[519.845597] Dynamic subtest pipe-B-plane-0: SUCCESS (0.644s)
[519.856993] Starting dynamic subtest: pipe-B-plane-3
[520.267467] Dynamic subtest pipe-B-plane-3: SUCCESS (0.422s)
[520.276239] Starting dynamic subtest: pipe-B-plane-5
[520.279804] Dynamic subtest pipe-B-plane-5: SKIP (0.000s)
[520.592346] Subtest pixel-format-4-tiled-modifier-source-clamping: SUCCESS (3.519s)
[521.402121] [125/133] (501s left) perf_pmu (busy-double-start)
[521.442786] Starting subtest: busy-double-start
[521.444825] Starting dynamic subtest: rcs0
[525.084201] Dynamic subtest rcs0: FAIL (3.586s)
[525.094735] Starting dynamic subtest: bcs0
[528.603430] Dynamic subtest bcs0: SUCCESS (3.574s)
[528.613067] Starting dynamic subtest: vcs0
[532.402384] Dynamic subtest vcs0: SUCCESS (3.796s)
[532.413349] Starting dynamic subtest: vcs1
[536.377276] Dynamic subtest vcs1: SUCCESS (3.972s)
[536.391564] Starting dynamic subtest: vecs0
[540.354143] Dynamic subtest vecs0: SUCCESS (3.973s)
[540.366068] Starting dynamic subtest: ccs0
[543.993047] Dynamic subtest ccs0: FAIL (3.567s)
[543.995329] Subtest busy-double-start: FAIL (22.480s)
[544.054150] [126/133] (478s left) gem_ctx_param (basic-default)
[544.112014] Starting subtest: basic-default
[544.114412] Subtest basic-default: SUCCESS (0.000s)
[544.200590] [127/133] (478s left) gem_mmap_gtt (big-bo-tiledx)
[544.253215] Subtest big-bo-tiledX: SKIP (0.000s)
[544.312198] [128/133] (478s left) gem_userptr_blits (stress-mm)
[544.379667] Starting subtest: stress-mm
[549.753963] Subtest stress-mm: SUCCESS (5.369s)
[549.911602] [129/133] (473s left) prime_vgem (fence-read-hang)
[550.004349] Subtest fence-read-hang: SKIP (0.000s)
[550.132877] [130/133] (472s left) kms_flip (2x-flip-vs-expired-vblank-interruptible)
[550.234089] Starting subtest: 2x-flip-vs-expired-vblank-interruptible
[550.245379] Subtest 2x-flip-vs-expired-vblank-interruptible: SKIP (0.010s)
[550.330295] [131/133] (472s left) kms_psr (fbc-psr-primary-render)
[550.417869] Starting subtest: fbc-psr-primary-render
[550.420101] Starting dynamic subtest: eDP-1
[550.424194] Dynamic subtest eDP-1: SKIP (0.000s)
[550.428249] Subtest fbc-psr-primary-render: SKIP (0.001s)
[550.503053] [132/133] (472s left) kms_frontbuffer_tracking (psr-modesetfrombusy)
[550.598307] Starting subtest: psr-modesetfrombusy
[556.763813] Subtest psr-modesetfrombusy: SUCCESS (6.169s)
[556.936690] [133/133] (466s left) kms_pm_rpm (system-suspend-modeset)
[558.982032] Starting subtest: system-suspend-modeset
[578.237332] Subtest system-suspend-modeset: SUCCESS (4.246s)
[578.630325] 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.