[36.680762] Initializing watchdogs
[36.680816]   /dev/watchdog0
[36.693465] [001/138] (960s left) kms_setmode (clone-exclusive-crtc)
[36.792105] Starting subtest: clone-exclusive-crtc
[36.795086] Subtest clone-exclusive-crtc: SKIP (0.000s)
[36.862297] [002/138] (960s left) kms_setmode (invalid-clone-single-crtc-stealing)
[36.928054] Starting subtest: invalid-clone-single-crtc-stealing
[36.931190] Subtest invalid-clone-single-crtc-stealing: SKIP (0.000s)
[37.000970] [003/138] (960s left) prime_mmap (test_refcounting)
[37.053683] Starting subtest: test_refcounting
[37.054543] Starting dynamic subtest: test_refcounting-smem
[37.096358] Dynamic subtest test_refcounting-smem: SUCCESS (0.045s)
[37.100391] Starting dynamic subtest: test_refcounting-lmem0
[37.288435] Dynamic subtest test_refcounting-lmem0: SUCCESS (0.183s)
[37.289265] Subtest test_refcounting: SUCCESS (0.229s)
[37.362742] [004/138] (959s left) kms_ccs (pipe-c-bad-pixel-format-4-tiled-mtl-rc-ccs-cc)
[37.612278] Starting subtest: pipe-C-bad-pixel-format-4-tiled-mtl-rc-ccs-cc
[37.614141] Subtest pipe-C-bad-pixel-format-4-tiled-mtl-rc-ccs-cc: SKIP (0.000s)
[37.808087] [005/138] (959s left) kms_chamelium_hpd (hdmi-hpd)
[38.062969] Subtest hdmi-hpd: SKIP (0.000s)
[38.174140] [006/138] (959s left) core_hotunplug (unbind-rebind)
[38.280592] Starting subtest: unbind-rebind
[42.346668] Subtest unbind-rebind: SUCCESS (4.066s)
[42.358056] [007/138] (954s left) drm_fdinfo (busy-idle)
[42.409143] Starting subtest: busy-idle
[42.409954] Starting dynamic subtest: rcs0
[42.411650] Dynamic subtest rcs0: SKIP (0.000s)
[42.416563] Starting dynamic subtest: bcs0
[42.418659] Dynamic subtest bcs0: SKIP (0.000s)
[42.423656] Starting dynamic subtest: vcs0
[42.425826] Dynamic subtest vcs0: SKIP (0.000s)
[42.430466] Starting dynamic subtest: vcs1
[42.432014] Dynamic subtest vcs1: SKIP (0.000s)
[42.436627] Starting dynamic subtest: vecs0
[42.438720] Dynamic subtest vecs0: SKIP (0.000s)
[42.443652] Starting dynamic subtest: vecs1
[42.446162] Dynamic subtest vecs1: SKIP (0.000s)
[42.453107] Starting dynamic subtest: ccs0
[42.455207] Dynamic subtest ccs0: SKIP (0.000s)
[42.459888] Starting dynamic subtest: ccs1
[42.461882] Dynamic subtest ccs1: SKIP (0.000s)
[42.466878] Starting dynamic subtest: ccs2
[42.469225] Dynamic subtest ccs2: SKIP (0.000s)
[42.474195] Starting dynamic subtest: ccs3
[42.476595] Dynamic subtest ccs3: SKIP (0.000s)
[42.478783] Subtest busy-idle: SKIP (0.001s)
[42.489088] [008/138] (954s left) kms_cursor_crc (cursor-random-64x21)
[42.714118] Starting subtest: cursor-random-64x21
[42.726286] Starting dynamic subtest: pipe-A-DP-4
[47.006267] Dynamic subtest pipe-A-DP-4: SUCCESS (4.280s)
[47.049502] Starting dynamic subtest: pipe-D-DP-4
[51.384575] Dynamic subtest pipe-D-DP-4: SUCCESS (4.339s)
[51.385500] Subtest cursor-random-64x21: SUCCESS (8.670s)
[51.747450] [009/138] (945s left) gem_userptr_blits (dmabuf-sync)
[51.820574] Starting subtest: dmabuf-sync
[51.823974] Subtest dmabuf-sync: SKIP (0.003s)
[51.905733] [010/138] (945s left) kms_ccs (pipe-c-ccs-on-another-bo-yf-tiled-ccs)
[52.163712] Starting subtest: pipe-C-ccs-on-another-bo-yf-tiled-ccs
[52.165491] Subtest pipe-C-ccs-on-another-bo-yf-tiled-ccs: SKIP (0.000s)
[52.346808] [011/138] (945s left) gem_close (basic)
[52.434192] Starting subtest: basic
[52.435047] Subtest basic: SUCCESS (0.000s)
[52.520871] [012/138] (944s left) gem_exec_whisper (basic-queues-all)
[52.598367] Starting subtest: basic-queues-all
[74.614447] Subtest basic-queues-all: SUCCESS (22.006s)
[74.804344] [013/138] (922s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-mmap-cpu)
[74.966496] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-mmap-cpu
[74.968185] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[75.051655] [014/138] (922s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-fullscreen)
[75.191457] Starting subtest: psr-2p-scndscrn-spr-indfb-fullscreen
[75.193142] Subtest psr-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s)
[75.264469] [015/138] (922s left) syncobj_timeline (wait-all-delayed-signal)
[75.326297] Starting subtest: wait-all-delayed-signal
[75.427377] Subtest wait-all-delayed-signal: SUCCESS (0.101s)
[75.486223] [016/138] (922s left) gem_set_tiling_vs_blt (untiled-to-tiled)
[75.549290] Subtest untiled-to-tiled: SKIP (0.000s)
[75.571653] [017/138] (921s left) gem_pxp (protected-raw-src-copy-not-readible)
[78.181305] Subtest protected-raw-src-copy-not-readible: SKIP (0.000s)
[78.233318] [018/138] (919s left) gen7_exec_parse (basic-offset)
[78.280554] Subtest basic-offset: SKIP (0.000s)
[78.304588] [019/138] (919s left) syncobj_timeline (invalid-single-wait-all-unsubmitted)
[78.345382] Starting subtest: invalid-single-wait-all-unsubmitted
[78.346314] Subtest invalid-single-wait-all-unsubmitted: SUCCESS (0.000s)
[78.399757] [020/138] (919s left) gem_exec_reloc (basic-cpu-wc-noreloc)
[78.452241] Subtest basic-cpu-wc-noreloc: SKIP (0.000s)
[78.509886] [021/138] (919s left) kms_lease (lease-unleased-connector)
[78.652171] Starting subtest: lease-unleased-connector
[78.652992] Starting dynamic subtest: pipe-A-DP-4
[78.765066] Dynamic subtest pipe-A-DP-4: SUCCESS (0.112s)
[78.770434] Starting dynamic subtest: pipe-B-DP-4
[78.875742] Dynamic subtest pipe-B-DP-4: SUCCESS (0.111s)
[78.881097] Starting dynamic subtest: pipe-C-DP-4
[78.989105] Dynamic subtest pipe-C-DP-4: SUCCESS (0.112s)
[78.994463] Starting dynamic subtest: pipe-D-DP-4
[79.099776] Dynamic subtest pipe-D-DP-4: SUCCESS (0.111s)
[79.100675] Subtest lease-unleased-connector: SUCCESS (0.448s)
[79.162815] [022/138] (918s left) gem_tiled_partial_pwrite_pread (reads)
[79.235850] Subtest reads: SKIP (0.000s)
[79.274694] [023/138] (918s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-pwrite)
[79.431326] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-pwrite
[79.433114] Subtest psr-2p-scndscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[79.520201] [024/138] (918s left) gem_spin_batch (spin-all-new)
[79.598987] Starting subtest: spin-all-new
[94.565557] Subtest spin-all-new: FAIL (14.934s)
[95.182307] [025/138] (902s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-mmap-gtt)
[95.305955] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-mmap-gtt
[95.307506] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[95.382464] [026/138] (902s left) kms_ccs (pipe-b-crc-sprite-planes-basic-4-tiled-dg2-rc-ccs)
[95.627479] Starting subtest: pipe-B-crc-sprite-planes-basic-4-tiled-dg2-rc-ccs
[96.930806] Subtest pipe-B-crc-sprite-planes-basic-4-tiled-dg2-rc-ccs: SUCCESS (1.303s)
[97.263069] [027/138] (900s left) kms_pipe_b_c_ivb (pipe-b-double-modeset-then-modeset-pipe-c)
[97.320249] Subtest pipe-B-double-modeset-then-modeset-pipe-C: SKIP (0.000s)
[97.335978] [028/138] (900s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-onoff)
[97.452152] Starting subtest: fbc-2p-primscrn-cur-indfb-onoff
[97.453693] Subtest fbc-2p-primscrn-cur-indfb-onoff: SKIP (0.000s)
[97.532318] [029/138] (900s left) kms_flip_scaled_crc (flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling)
[97.679281] Starting subtest: flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling
[97.680186] Starting dynamic subtest: pipe-A-valid-mode
[99.335510] Dynamic subtest pipe-A-valid-mode: SUCCESS (1.654s)
[99.336349] Subtest flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling: SUCCESS (1.655s)
[99.558966] [030/138] (898s left) kms_chamelium_color (ctm-0-25)
[99.708910] Subtest ctm-0-25: SKIP (0.000s)
[99.738065] [031/138] (898s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-indfb-msflip-blt)
[99.854130] Starting subtest: fbc-2p-scndscrn-indfb-msflip-blt
[99.855820] Subtest fbc-2p-scndscrn-indfb-msflip-blt: SKIP (0.000s)
[99.933749] [032/138] (897s left) kms_ccs (pipe-b-ccs-on-another-bo-4-tiled-mtl-mc-ccs)
[100.166129] Starting subtest: pipe-B-ccs-on-another-bo-4-tiled-mtl-mc-ccs
[100.167961] Subtest pipe-B-ccs-on-another-bo-4-tiled-mtl-mc-ccs: SKIP (0.000s)
[100.381103] [033/138] (897s left) kms_vblank (ts-continuation-modeset-hang)
[100.538209] Starting subtest: ts-continuation-modeset-hang
[100.539114] Starting dynamic subtest: pipe-A-DP-4
[114.091951] Dynamic subtest pipe-A-DP-4: SUCCESS (13.553s)
[114.098694] Starting dynamic subtest: pipe-D-DP-4
[139.038268] Dynamic subtest pipe-D-DP-4: SUCCESS (24.944s)
[139.039077] Subtest ts-continuation-modeset-hang: SUCCESS (38.501s)
[139.273315] [034/138] (858s left) kms_frontbuffer_tracking (fbc-1p-offscren-pri-indfb-draw-mmap-cpu)
[139.418392] Starting subtest: fbc-1p-offscren-pri-indfb-draw-mmap-cpu
[141.261515] Subtest fbc-1p-offscren-pri-indfb-draw-mmap-cpu: SUCCESS (1.845s)
[141.379765] [035/138] (856s left) kms_big_fb (y-tiled-8bpp-rotate-270)
[141.501400] Starting subtest: y-tiled-8bpp-rotate-270
[141.503196] Subtest y-tiled-8bpp-rotate-270: SKIP (0.000s)
[141.598984] [036/138] (856s left) kms_cursor_legacy (basic-flip-before-cursor-legacy)
[141.763410] Starting subtest: basic-flip-before-cursor-legacy
[142.769348] Subtest basic-flip-before-cursor-legacy: SUCCESS (1.002s)
[143.020930] [037/138] (854s left) gem_exec_schedule (submit-early-slice)
[143.086257] Starting subtest: submit-early-slice
[143.087107] Starting dynamic subtest: rcs0
[143.230187] Dynamic subtest rcs0: SUCCESS (0.135s)
[143.239061] Starting dynamic subtest: bcs0
[143.294742] Dynamic subtest bcs0: SUCCESS (0.073s)
[143.301235] Starting dynamic subtest: vcs0
[143.353056] Dynamic subtest vcs0: SUCCESS (0.058s)
[143.359122] Starting dynamic subtest: vcs1
[143.450343] Dynamic subtest vcs1: SUCCESS (0.097s)
[143.457267] Starting dynamic subtest: vecs0
[143.525110] Dynamic subtest vecs0: SUCCESS (0.074s)
[143.532141] Starting dynamic subtest: vecs1
[143.605729] Dynamic subtest vecs1: SUCCESS (0.080s)
[143.613685] Starting dynamic subtest: ccs0
[143.683140] Dynamic subtest ccs0: SUCCESS (0.077s)
[143.691409] Starting dynamic subtest: ccs1
[143.760740] Dynamic subtest ccs1: SUCCESS (0.077s)
[143.770547] Starting dynamic subtest: ccs2
[143.841219] Dynamic subtest ccs2: SUCCESS (0.080s)
[143.847160] Starting dynamic subtest: ccs3
[143.908383] Dynamic subtest ccs3: SUCCESS (0.067s)
[143.909397] Subtest submit-early-slice: SUCCESS (0.822s)
[144.342552] [038/138] (853s left) v3d/v3d_perfmon (create-perfmon-exceed)
[144.404237] Subtest create-perfmon-exceed: SKIP (0.000s)
[144.458831] [039/138] (853s left) perf (sysctl-defaults)
[144.565938] Starting subtest: sysctl-defaults
[144.566989] Subtest sysctl-defaults: SUCCESS (0.000s)
[144.816647] [040/138] (853s left) kms_cursor_legacy (cursora-vs-flipa-atomic-transitions-varying-size)
[144.931435] Starting subtest: cursorA-vs-flipA-atomic-transitions-varying-size
[155.910116] Subtest cursorA-vs-flipA-atomic-transitions-varying-size: SUCCESS (10.978s)
[156.119419] [041/138] (841s left) sw_sync (sync_busy)
[156.196490] Starting subtest: sync_busy
[156.198567] Subtest sync_busy: SUCCESS (0.002s)
[156.241631] [042/138] (841s left) gem_mmap_gtt (basic-read-write-distinct)
[156.290008] Subtest basic-read-write-distinct: SKIP (0.000s)
[156.317673] [043/138] (841s left) gem_ctx_persistence (engines-mixed)
[156.362856] Starting subtest: engines-mixed
[156.363711] Starting dynamic subtest: rcs0
[156.430386] Dynamic subtest rcs0: SUCCESS (0.067s)
[156.437149] Starting dynamic subtest: bcs0
[156.471372] Dynamic subtest bcs0: SUCCESS (0.040s)
[156.480738] Starting dynamic subtest: vcs0
[156.519213] Dynamic subtest vcs0: SUCCESS (0.046s)
[156.549065] Starting dynamic subtest: vcs1
[156.586253] Dynamic subtest vcs1: SUCCESS (0.064s)
[156.616149] Starting dynamic subtest: vecs0
[156.643982] Dynamic subtest vecs0: SUCCESS (0.055s)
[156.662193] Starting dynamic subtest: vecs1
[156.693576] Dynamic subtest vecs1: SUCCESS (0.048s)
[156.707758] Starting dynamic subtest: ccs0
[156.751256] Dynamic subtest ccs0: SUCCESS (0.056s)
[156.781338] Starting dynamic subtest: ccs1
[156.808749] Dynamic subtest ccs1: SUCCESS (0.055s)
[156.830629] Starting dynamic subtest: ccs2
[156.869301] Dynamic subtest ccs2: SUCCESS (0.058s)
[156.899490] Starting dynamic subtest: ccs3
[156.939256] Dynamic subtest ccs3: SUCCESS (0.067s)
[156.941265] Subtest engines-mixed: SUCCESS (0.577s)
[157.068124] [044/138] (841s left) kms_chamelium_frames (dp-crc-multiple)
[157.304751] Subtest dp-crc-multiple: SKIP (0.000s)
[157.421222] [045/138] (840s left) kms_frontbuffer_tracking (fbc-tiling-4)
[157.563929] Starting subtest: fbc-tiling-4
[160.106382] Subtest fbc-tiling-4: SUCCESS (2.543s)
[160.281212] [046/138] (837s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-blt)
[160.441111] Starting subtest: psr-1p-primscrn-cur-indfb-draw-blt
[160.442805] Subtest psr-1p-primscrn-cur-indfb-draw-blt: SKIP (0.000s)
[160.506969] [047/138] (837s left) kms_prop_blob (blob-prop-core)
[160.560968] Starting subtest: blob-prop-core
[160.561904] Subtest blob-prop-core: SUCCESS (0.000s)
[160.661053] [048/138] (837s left) kms_rotation_crc (multiplane-rotation-cropping-top)
[160.805610] Starting subtest: multiplane-rotation-cropping-top
[171.959577] Subtest multiplane-rotation-cropping-top: SUCCESS (11.153s)
[172.086797] [049/138] (826s left) i915_query (query-regions-unallocated)
[172.158721] Starting subtest: query-regions-unallocated
[172.891122] Subtest query-regions-unallocated: SUCCESS (0.733s)
[172.961321] [050/138] (825s left) kms_ccs (pipe-b-bad-aux-stride-y-tiled-gen12-mc-ccs)
[173.177143] Starting subtest: pipe-B-bad-aux-stride-y-tiled-gen12-mc-ccs
[173.178705] Subtest pipe-B-bad-aux-stride-y-tiled-gen12-mc-ccs: SKIP (0.000s)
[173.389600] [051/138] (824s left) kms_pm_dc (dc6-psr)
[174.543131] Starting subtest: dc6-psr
[174.544960] Subtest dc6-psr: SKIP (0.000s)
[174.738210] [052/138] (823s left) kms_ccs (pipe-d-crc-primary-rotation-180-4-tiled-dg2-rc-ccs)
[175.027854] Starting subtest: pipe-D-crc-primary-rotation-180-4-tiled-dg2-rc-ccs
[175.446251] Subtest pipe-D-crc-primary-rotation-180-4-tiled-dg2-rc-ccs: SUCCESS (0.418s)
[175.737543] [053/138] (822s left) kms_rotation_crc (sprite-rotation-90-pos-100-0)
[175.861972] Starting subtest: sprite-rotation-90-pos-100-0
[175.863803] Subtest sprite-rotation-90-pos-100-0: SKIP (0.001s)
[175.921306] [054/138] (822s left) gem_ctx_param (set-priority-invalid-size)
[175.965790] Starting subtest: set-priority-invalid-size
[175.966710] Subtest set-priority-invalid-size: SUCCESS (0.000s)
[176.021931] [055/138] (822s left) gem_exec_params (readonly)
[176.081851] Starting subtest: readonly
[176.084279] Subtest readonly: SUCCESS (0.001s)
[176.191606] [056/138] (822s left) gem_exec_fence (syncobj-invalid-wait)
[176.977152] Starting subtest: syncobj-invalid-wait
[176.977968] Subtest syncobj-invalid-wait: SUCCESS (0.000s)
[177.358073] [057/138] (821s left) vc4/vc4_tiling (set-bad-flags)
[177.421228] Subtest set-bad-flags: SKIP (0.000s)
[177.477121] [058/138] (821s left) kms_atomic (test-only)
[177.611628] Starting subtest: test-only
[177.989359] Starting dynamic subtest: pipe-A-DP-4
[178.815071] Dynamic subtest pipe-A-DP-4: SUCCESS (0.826s)
[178.816175] Subtest test-only: SUCCESS (1.203s)
[179.049776] [059/138] (819s left) kms_ccs (pipe-c-crc-primary-rotation-180-4-tiled-mtl-rc-ccs-cc)
[179.354532] Starting subtest: pipe-C-crc-primary-rotation-180-4-tiled-mtl-rc-ccs-cc
[179.356375] Subtest pipe-C-crc-primary-rotation-180-4-tiled-mtl-rc-ccs-cc: SKIP (0.000s)
[179.547294] [060/138] (819s left) kms_ccs (pipe-d-bad-rotation-90-4-tiled-mtl-rc-ccs-cc)
[179.844539] Starting subtest: pipe-D-bad-rotation-90-4-tiled-mtl-rc-ccs-cc
[179.846388] Subtest pipe-D-bad-rotation-90-4-tiled-mtl-rc-ccs-cc: SKIP (0.000s)
[180.011400] [061/138] (818s left) kms_big_fb (linear-16bpp-rotate-90)
[180.161943] Starting subtest: linear-16bpp-rotate-90
[180.218052] Subtest linear-16bpp-rotate-90: SKIP (0.055s)
[180.377831] [062/138] (818s left) kms_ccs (pipe-b-crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc)
[180.641969] Starting subtest: pipe-B-crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc
[181.905879] Subtest pipe-B-crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc: SUCCESS (1.263s)
[182.264428] [063/138] (816s left) kms_plane (pixel-format-source-clamping)
[182.414908] Starting subtest: pixel-format-source-clamping
[182.417140] Starting dynamic subtest: pipe-A
[194.581968] Dynamic subtest pipe-A: SUCCESS (12.165s)
[194.594892] Starting dynamic subtest: pipe-B
[206.829222] Dynamic subtest pipe-B: SUCCESS (12.245s)
[206.830046] Subtest pixel-format-source-clamping: SUCCESS (24.415s)
[207.072632] [064/138] (791s left) syncobj_basic (create-signaled)
[207.142069] Starting subtest: create-signaled
[207.142920] Subtest create-signaled: SUCCESS (0.000s)
[207.198823] [065/138] (791s left) gem_exec_big (single)
[207.249875] Starting subtest: single
[212.110597] Subtest single: SUCCESS (4.852s)
[212.893065] [066/138] (785s left) kms_fbcon_fbt (fbc)
[212.977420] Starting subtest: fbc
[216.537342] Subtest fbc: SUCCESS (3.550s)
[216.575055] [067/138] (782s left) gem_exec_params (cliprects-invalid)
[216.624379] Starting subtest: cliprects-invalid
[216.625213] Subtest cliprects-invalid: SUCCESS (0.000s)
[216.741451] [068/138] (782s left) kms_cursor_crc (cursor-sliding-max-size)
[217.084769] Starting subtest: cursor-sliding-max-size
[217.087395] Subtest cursor-sliding-max-size: SKIP (0.000s)
[217.250085] [069/138] (781s left) api_intel_bb (delta-check)
[217.333244] Starting subtest: delta-check
[217.351066] Subtest delta-check: SUCCESS (0.018s)
[217.450417] [070/138] (781s left) kms_atomic_interruptible (universal-setplane-cursor)
[217.573867] Starting subtest: universal-setplane-cursor
[217.575784] Starting dynamic subtest: pipe-A-DP-4
[223.869065] Dynamic subtest pipe-A-DP-4: SUCCESS (6.293s)
[223.869962] Subtest universal-setplane-cursor: SUCCESS (6.295s)
[224.060698] [071/138] (774s left) gem_mmap_wc (pf-nonblock)
[224.136356] Subtest pf-nonblock: SKIP (0.000s)
[224.164206] [072/138] (774s left) gem_exec_schedule (pi-userfault)
[224.342033] Starting subtest: pi-userfault
[224.342940] Starting dynamic subtest: rcs0
[224.343799] Dynamic subtest rcs0: SUCCESS (0.006s)
[224.352216] Starting dynamic subtest: bcs0
[224.353116] Dynamic subtest bcs0: SUCCESS (0.005s)
[224.361562] Starting dynamic subtest: vcs0
[224.363455] Dynamic subtest vcs0: SUCCESS (0.007s)
[224.371663] Starting dynamic subtest: vcs1
[224.373411] Dynamic subtest vcs1: SUCCESS (0.008s)
[224.381591] Starting dynamic subtest: vecs0
[224.382406] Dynamic subtest vecs0: SUCCESS (0.009s)
[224.391619] Starting dynamic subtest: vecs1
[224.393997] Dynamic subtest vecs1: SUCCESS (0.005s)
[224.402125] Starting dynamic subtest: ccs0
[224.402999] Dynamic subtest ccs0: SUCCESS (0.006s)
[224.411998] Starting dynamic subtest: ccs1
[224.412857] Dynamic subtest ccs1: SUCCESS (0.006s)
[224.420894] Starting dynamic subtest: ccs2
[224.422118] Dynamic subtest ccs2: SUCCESS (0.006s)
[224.430554] Starting dynamic subtest: ccs3
[224.431797] Dynamic subtest ccs3: SUCCESS (0.006s)
[224.433035] Subtest pi-userfault: SUCCESS (0.072s)
[224.616665] [073/138] (774s left) kms_flip (2x-flip-vs-expired-vblank-interruptible)
[224.750722] Starting subtest: 2x-flip-vs-expired-vblank-interruptible
[224.766687] Subtest 2x-flip-vs-expired-vblank-interruptible: SKIP (0.015s)
[224.844046] [074/138] (774s left) gem_create (create-valid-nonaligned)
[224.903607] Starting subtest: create-valid-nonaligned
[224.904506] Subtest create-valid-nonaligned: SUCCESS (0.000s)
[225.125061] [075/138] (773s left) v3d/v3d_submit_cl (bad-pad)
[225.239590] Subtest bad-pad: SKIP (0.000s)
[225.290767] [076/138] (773s left) gem_userptr_blits (sync-unmap-cycles)
[225.351216] Starting subtest: sync-unmap-cycles
[230.727440] Subtest sync-unmap-cycles: SUCCESS (5.375s)
[230.857604] [077/138] (768s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-mmap-wc)
[230.994733] Starting subtest: psr-2p-primscrn-pri-indfb-draw-mmap-wc
[230.996511] Subtest psr-2p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[231.106214] [078/138] (768s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-onoff)
[231.271513] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-onoff
[231.273204] Subtest fbcpsr-2p-scndscrn-cur-indfb-onoff: SKIP (0.000s)
[231.341286] [079/138] (767s left) fbdev (eof)
[231.405599] Starting subtest: eof
[231.406537] Subtest eof: SUCCESS (0.000s)
[231.455357] [080/138] (767s left) vc4/vc4_lookup_fail (bad-color-write)
[231.522496] Subtest bad-color-write: SKIP (0.000s)
[231.577559] [081/138] (767s left) kms_flip (plain-flip-interruptible)
[231.688408] Starting subtest: plain-flip-interruptible
[231.694537] Starting dynamic subtest: A-DP4
[232.562638] Dynamic subtest A-DP4: SUCCESS (0.868s)
[232.571428] Starting dynamic subtest: B-DP4
[233.294155] Dynamic subtest B-DP4: SUCCESS (0.731s)
[233.301697] Starting dynamic subtest: C-DP4
[234.031883] Dynamic subtest C-DP4: SUCCESS (0.737s)
[234.039459] Starting dynamic subtest: D-DP4
[234.773107] Dynamic subtest D-DP4: SUCCESS (0.740s)
[234.773993] Subtest plain-flip-interruptible: SUCCESS (3.086s)
[235.043749] [082/138] (764s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-move)
[235.188868] Starting subtest: fbc-2p-scndscrn-cur-indfb-move
[235.190486] Subtest fbc-2p-scndscrn-cur-indfb-move: SKIP (0.000s)
[235.269152] [083/138] (764s left) kms_fbcon_fbt (psr-suspend)
[235.345147] Starting subtest: psr-suspend
[235.347353] Subtest psr-suspend: SKIP (0.000s)
[235.443586] [084/138] (763s left) kms_addfb_basic (invalid-set-prop)
[235.521237] Starting subtest: invalid-set-prop
[235.522213] Subtest invalid-set-prop: SUCCESS (0.000s)
[235.664501] [085/138] (763s left) kms_frontbuffer_tracking (fbcpsr-1p-offscren-pri-indfb-draw-mmap-wc)
[235.791744] Starting subtest: fbcpsr-1p-offscren-pri-indfb-draw-mmap-wc
[235.793310] Subtest fbcpsr-1p-offscren-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[235.892699] [086/138] (763s left) kms_scaling_modes (scaling-mode-full-aspect)
[236.038916] Starting subtest: scaling-mode-full-aspect
[236.042203] Subtest scaling-mode-full-aspect: SKIP (0.001s)
[236.096610] [087/138] (763s left) gem_render_copy (mixed-tiled-to-yf-tiled-ccs)
[236.153976] Starting subtest: mixed-tiled-to-yf-tiled-ccs
[236.155569] Subtest mixed-tiled-to-yf-tiled-ccs: SKIP (0.000s)
[236.374421] [088/138] (763s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-render)
[236.531225] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-render
[236.532841] Subtest fbc-2p-scndscrn-spr-indfb-draw-render: SKIP (0.000s)
[236.639840] [089/138] (762s left) kms_ccs (pipe-d-crc-sprite-planes-basic-4-tiled-mtl-rc-ccs)
[236.908683] Starting subtest: pipe-D-crc-sprite-planes-basic-4-tiled-mtl-rc-ccs
[236.911702] Subtest pipe-D-crc-sprite-planes-basic-4-tiled-mtl-rc-ccs: SKIP (0.002s)
[237.078239] [090/138] (762s left) syncobj_timeline (etime-single-wait-all-submitted)
[237.174428] Starting subtest: etime-single-wait-all-submitted
[237.284117] Subtest etime-single-wait-all-submitted: SUCCESS (0.107s)
[237.376501] [091/138] (762s left) kms_plane_scaling (plane-downscale-factor-0-5-with-pixel-format)
[237.492694] Starting subtest: plane-downscale-factor-0-5-with-pixel-format
[237.504626] Starting dynamic subtest: pipe-A-DP-4
[271.570789] Dynamic subtest pipe-A-DP-4: SUCCESS (34.066s)
[271.589708] Starting dynamic subtest: pipe-B-DP-4
[304.961535] Dynamic subtest pipe-B-DP-4: SUCCESS (33.378s)
[304.980974] Starting dynamic subtest: pipe-C-DP-4
[305.368811] Dynamic subtest pipe-C-DP-4: SUCCESS (0.394s)
[305.397949] Starting dynamic subtest: pipe-D-DP-4
[305.769519] Dynamic subtest pipe-D-DP-4: SUCCESS (0.386s)
[305.770503] Subtest plane-downscale-factor-0-5-with-pixel-format: SUCCESS (68.278s)
[306.080874] [092/138] (693s left) perf (non-system-wide-paranoid)
[306.265577] Starting subtest: non-system-wide-paranoid
[306.299465] Subtest non-system-wide-paranoid: SUCCESS (0.034s)
[306.323517] [093/138] (693s left) kms_cursor_legacy (flip-vs-cursor-crc-legacy)
[306.442825] Starting subtest: flip-vs-cursor-crc-legacy
[307.004339] Subtest flip-vs-cursor-crc-legacy: SUCCESS (0.561s)
[307.240921] [094/138] (692s left) kms_big_fb (x-tiled-16bpp-rotate-90)
[307.400504] Starting subtest: x-tiled-16bpp-rotate-90
[307.450416] Subtest x-tiled-16bpp-rotate-90: SKIP (0.048s)
[307.609097] [095/138] (692s left) i915_pm_rps (engine-order)
[307.693501] Starting subtest: engine-order
[320.436873] Subtest engine-order: SUCCESS (12.710s)
[320.599560] [096/138] (679s left) kms_psr2_sf (overlay-plane-move-continuous-exceed-fully-sf)
[320.646680] Subtest overlay-plane-move-continuous-exceed-fully-sf: SKIP (0.000s)
[320.674974] [097/138] (679s left) kms_busy (extended-pageflip-hang-newfb)
[320.796581] Starting subtest: extended-pageflip-hang-newfb
[320.798723] Starting dynamic subtest: pipe-A
[328.638139] Dynamic subtest pipe-A: SUCCESS (7.839s)
[328.647667] Starting dynamic subtest: pipe-D
[336.509240] Dynamic subtest pipe-D: SUCCESS (7.868s)
[336.510049] Subtest extended-pageflip-hang-newfb: SUCCESS (15.713s)
[336.721420] [098/138] (663s left) i915_pm_rpm (gem-evict-pwrite)
[338.551577] Starting subtest: gem-evict-pwrite
[338.555550] Subtest gem-evict-pwrite: SKIP (0.000s)
[338.905817] [099/138] (660s left) gem_lmem_swapping (random)
[341.723295] Starting subtest: random
[341.724198] Starting dynamic subtest: lmem0
[342.413422] Dynamic subtest lmem0: SUCCESS (0.681s)
[342.414255] Subtest random: SUCCESS (0.682s)
[343.651674] [100/138] (656s left) kms_ccs (pipe-a-crc-primary-basic-4-tiled-mtl-rc-ccs-cc)
[344.593232] Starting subtest: pipe-A-crc-primary-basic-4-tiled-mtl-rc-ccs-cc
[344.595114] Subtest pipe-A-crc-primary-basic-4-tiled-mtl-rc-ccs-cc: SKIP (0.000s)
[344.890926] [101/138] (654s left) v3d/v3d_submit_cl (valid-submission)
[344.961926] Subtest valid-submission: SKIP (0.000s)
[345.016893] [102/138] (654s left) gem_ccs (block-multicopy-compressed)
[345.085293] Starting subtest: block-multicopy-compressed
[345.086270] Starting dynamic subtest: linear-compressed-compfmt0-smem-lmem0-multicopy
[345.127020] Dynamic subtest linear-compressed-compfmt0-smem-lmem0-multicopy: SUCCESS (0.041s)
[345.133782] Starting dynamic subtest: linear-compressed-compfmt0-lmem0-lmem0-multicopy
[345.231539] Dynamic subtest linear-compressed-compfmt0-lmem0-lmem0-multicopy: SUCCESS (0.104s)
[345.237489] Starting dynamic subtest: xmajor-compressed-compfmt0-smem-lmem0-multicopy
[345.247024] Dynamic subtest xmajor-compressed-compfmt0-smem-lmem0-multicopy: SUCCESS (0.015s)
[345.252983] Starting dynamic subtest: xmajor-compressed-compfmt0-lmem0-lmem0-multicopy
[345.351706] Dynamic subtest xmajor-compressed-compfmt0-lmem0-lmem0-multicopy: SUCCESS (0.104s)
[345.357770] Starting dynamic subtest: tile4-compressed-compfmt0-smem-lmem0-multicopy
[345.366254] Dynamic subtest tile4-compressed-compfmt0-smem-lmem0-multicopy: SUCCESS (0.014s)
[345.372183] Starting dynamic subtest: tile4-compressed-compfmt0-lmem0-lmem0-multicopy
[345.463436] Dynamic subtest tile4-compressed-compfmt0-lmem0-lmem0-multicopy: SUCCESS (0.096s)
[345.469271] Starting dynamic subtest: tile64-compressed-compfmt0-smem-lmem0-multicopy
[345.477263] Dynamic subtest tile64-compressed-compfmt0-smem-lmem0-multicopy: SUCCESS (0.013s)
[345.483131] Starting dynamic subtest: tile64-compressed-compfmt0-lmem0-lmem0-multicopy
[345.577234] Dynamic subtest tile64-compressed-compfmt0-lmem0-lmem0-multicopy: SUCCESS (0.099s)
[345.578125] Subtest block-multicopy-compressed: SUCCESS (0.492s)
[345.688436] [103/138] (654s left) kms_big_fb (yf-tiled-8bpp-rotate-90)
[345.811466] Starting subtest: yf-tiled-8bpp-rotate-90
[345.813263] Subtest yf-tiled-8bpp-rotate-90: SKIP (0.000s)
[345.901847] [104/138] (653s left) kms_flip_tiling (flip-change-tiling)
[346.054047] Starting subtest: flip-change-tiling
[346.054872] Starting dynamic subtest: pipe-A-DP-4-4-mc-ccs-to-4-mc-ccs
[346.304415] Dynamic subtest pipe-A-DP-4-4-mc-ccs-to-4-mc-ccs: SUCCESS (0.241s)
[346.331712] Starting dynamic subtest: pipe-A-DP-4-4-mc-ccs-to-4-rc-ccs-cc
[346.461694] Dynamic subtest pipe-A-DP-4-4-mc-ccs-to-4-rc-ccs-cc: SUCCESS (0.164s)
[346.472055] Starting dynamic subtest: pipe-A-DP-4-4-mc-ccs-to-4-rc-ccs
[346.611502] Dynamic subtest pipe-A-DP-4-4-mc-ccs-to-4-rc-ccs: SUCCESS (0.149s)
[346.621409] Starting dynamic subtest: pipe-A-DP-4-4-mc-ccs-to-4
[346.762295] Dynamic subtest pipe-A-DP-4-4-mc-ccs-to-4: SUCCESS (0.149s)
[346.776982] Starting dynamic subtest: pipe-A-DP-4-4-mc-ccs-to-x
[346.929222] Dynamic subtest pipe-A-DP-4-4-mc-ccs-to-x: SUCCESS (0.164s)
[346.960973] Starting dynamic subtest: pipe-A-DP-4-4-mc-ccs-to-linear
[347.129288] Dynamic subtest pipe-A-DP-4-4-mc-ccs-to-linear: SUCCESS (0.197s)
[347.159913] Starting dynamic subtest: pipe-A-DP-4-4-rc-ccs-cc-to-4-mc-ccs
[347.296088] Dynamic subtest pipe-A-DP-4-4-rc-ccs-cc-to-4-mc-ccs: SUCCESS (0.164s)
[347.326792] Starting dynamic subtest: pipe-A-DP-4-4-rc-ccs-cc-to-4-rc-ccs-cc
[347.461707] Dynamic subtest pipe-A-DP-4-4-rc-ccs-cc-to-4-rc-ccs-cc: SUCCESS (0.164s)
[347.474130] Starting dynamic subtest: pipe-A-DP-4-4-rc-ccs-cc-to-4-rc-ccs
[347.594977] Dynamic subtest pipe-A-DP-4-4-rc-ccs-cc-to-4-rc-ccs: SUCCESS (0.132s)
[347.603193] Starting dynamic subtest: pipe-A-DP-4-4-rc-ccs-cc-to-4
[347.745194] Dynamic subtest pipe-A-DP-4-4-rc-ccs-cc-to-4: SUCCESS (0.149s)
[347.774106] Starting dynamic subtest: pipe-A-DP-4-4-rc-ccs-cc-to-x
[347.945857] Dynamic subtest pipe-A-DP-4-4-rc-ccs-cc-to-x: SUCCESS (0.198s)
[347.960037] Starting dynamic subtest: pipe-A-DP-4-4-rc-ccs-cc-to-linear
[348.112532] Dynamic subtest pipe-A-DP-4-4-rc-ccs-cc-to-linear: SUCCESS (0.164s)
[348.141782] Starting dynamic subtest: pipe-A-DP-4-4-rc-ccs-to-4-mc-ccs
[348.278798] Dynamic subtest pipe-A-DP-4-4-rc-ccs-to-4-mc-ccs: SUCCESS (0.164s)
[348.308988] Starting dynamic subtest: pipe-A-DP-4-4-rc-ccs-to-4-rc-ccs-cc
[348.444934] Dynamic subtest pipe-A-DP-4-4-rc-ccs-to-4-rc-ccs-cc: SUCCESS (0.165s)
[348.454159] Starting dynamic subtest: pipe-A-DP-4-4-rc-ccs-to-4-rc-ccs
[348.578303] Dynamic subtest pipe-A-DP-4-4-rc-ccs-to-4-rc-ccs: SUCCESS (0.132s)
[348.589894] Starting dynamic subtest: pipe-A-DP-4-4-rc-ccs-to-4
[348.729228] Dynamic subtest pipe-A-DP-4-4-rc-ccs-to-4: SUCCESS (0.149s)
[348.743813] Starting dynamic subtest: pipe-A-DP-4-4-rc-ccs-to-x
[348.896067] Dynamic subtest pipe-A-DP-4-4-rc-ccs-to-x: SUCCESS (0.164s)
[348.926388] Starting dynamic subtest: pipe-A-DP-4-4-rc-ccs-to-linear
[349.078868] Dynamic subtest pipe-A-DP-4-4-rc-ccs-to-linear: SUCCESS (0.180s)
[349.109474] Starting dynamic subtest: pipe-A-DP-4-4-to-4-mc-ccs
[349.262529] Dynamic subtest pipe-A-DP-4-4-to-4-mc-ccs: SUCCESS (0.181s)
[349.294579] Starting dynamic subtest: pipe-A-DP-4-4-to-4-rc-ccs-cc
[349.445996] Dynamic subtest pipe-A-DP-4-4-to-4-rc-ccs-cc: SUCCESS (0.180s)
[349.476873] Starting dynamic subtest: pipe-A-DP-4-4-to-4-rc-ccs
[349.612100] Dynamic subtest pipe-A-DP-4-4-to-4-rc-ccs: SUCCESS (0.163s)
[349.642363] Starting dynamic subtest: pipe-A-DP-4-4-to-4
[349.761523] Dynamic subtest pipe-A-DP-4-4-to-4: SUCCESS (0.148s)
[349.770723] Starting dynamic subtest: pipe-A-DP-4-4-to-x
[349.945936] Dynamic subtest pipe-A-DP-4-4-to-x: SUCCESS (0.183s)
[349.977334] Starting dynamic subtest: pipe-A-DP-4-4-to-linear
[350.146123] Dynamic subtest pipe-A-DP-4-4-to-linear: SUCCESS (0.197s)
[350.177435] Starting dynamic subtest: pipe-A-DP-4-x-to-4-mc-ccs
[350.345557] Dynamic subtest pipe-A-DP-4-x-to-4-mc-ccs: SUCCESS (0.197s)
[350.359151] Starting dynamic subtest: pipe-A-DP-4-x-to-4-rc-ccs-cc
[350.495651] Dynamic subtest pipe-A-DP-4-x-to-4-rc-ccs-cc: SUCCESS (0.148s)
[350.526774] Starting dynamic subtest: pipe-A-DP-4-x-to-4-rc-ccs
[350.678870] Dynamic subtest pipe-A-DP-4-x-to-4-rc-ccs: SUCCESS (0.181s)
[350.710507] Starting dynamic subtest: pipe-A-DP-4-x-to-4
[350.879383] Dynamic subtest pipe-A-DP-4-x-to-4: SUCCESS (0.198s)
[350.893356] Starting dynamic subtest: pipe-A-DP-4-x-to-x
[351.028846] Dynamic subtest pipe-A-DP-4-x-to-x: SUCCESS (0.147s)
[351.058321] Starting dynamic subtest: pipe-A-DP-4-x-to-linear
[351.238054] Dynamic subtest pipe-A-DP-4-x-to-linear: SUCCESS (0.198s)
[351.265043] Starting dynamic subtest: pipe-A-DP-4-linear-to-4-mc-ccs
[351.411782] Dynamic subtest pipe-A-DP-4-linear-to-4-mc-ccs: SUCCESS (0.181s)
[351.429331] Starting dynamic subtest: pipe-A-DP-4-linear-to-4-rc-ccs-cc
[351.578847] Dynamic subtest pipe-A-DP-4-linear-to-4-rc-ccs-cc: SUCCESS (0.165s)
[351.605184] Starting dynamic subtest: pipe-A-DP-4-linear-to-4-rc-ccs
[351.745438] Dynamic subtest pipe-A-DP-4-linear-to-4-rc-ccs: SUCCESS (0.165s)
[351.759116] Starting dynamic subtest: pipe-A-DP-4-linear-to-4
[351.913588] Dynamic subtest pipe-A-DP-4-linear-to-4: SUCCESS (0.165s)
[351.942821] Starting dynamic subtest: pipe-A-DP-4-linear-to-x
[352.133904] Dynamic subtest pipe-A-DP-4-linear-to-x: SUCCESS (0.214s)
[352.162952] Starting dynamic subtest: pipe-A-DP-4-linear-to-linear
[352.311779] Dynamic subtest pipe-A-DP-4-linear-to-linear: SUCCESS (0.180s)
[352.373437] Starting dynamic subtest: pipe-B-DP-4-4-mc-ccs-to-4-mc-ccs
[352.710178] Dynamic subtest pipe-B-DP-4-4-mc-ccs-to-4-mc-ccs: SUCCESS (0.339s)
[352.738475] Starting dynamic subtest: pipe-B-DP-4-4-mc-ccs-to-4-rc-ccs-cc
[352.868440] Dynamic subtest pipe-B-DP-4-4-mc-ccs-to-4-rc-ccs-cc: SUCCESS (0.164s)
[352.878145] Starting dynamic subtest: pipe-B-DP-4-4-mc-ccs-to-4-rc-ccs
[353.001547] Dynamic subtest pipe-B-DP-4-4-mc-ccs-to-4-rc-ccs: SUCCESS (0.132s)
[353.013235] Starting dynamic subtest: pipe-B-DP-4-4-mc-ccs-to-4
[353.135133] Dynamic subtest pipe-B-DP-4-4-mc-ccs-to-4: SUCCESS (0.132s)
[353.145309] Starting dynamic subtest: pipe-B-DP-4-4-mc-ccs-to-x
[353.268478] Dynamic subtest pipe-B-DP-4-4-mc-ccs-to-x: SUCCESS (0.132s)
[353.283365] Starting dynamic subtest: pipe-B-DP-4-4-mc-ccs-to-linear
[353.418478] Dynamic subtest pipe-B-DP-4-4-mc-ccs-to-linear: SUCCESS (0.149s)
[353.427703] Starting dynamic subtest: pipe-B-DP-4-4-rc-ccs-cc-to-4-mc-ccs
[353.552840] Dynamic subtest pipe-B-DP-4-4-rc-ccs-cc-to-4-mc-ccs: SUCCESS (0.132s)
[353.584456] Starting dynamic subtest: pipe-B-DP-4-4-rc-ccs-cc-to-4-rc-ccs-cc
[353.718658] Dynamic subtest pipe-B-DP-4-4-rc-ccs-cc-to-4-rc-ccs-cc: SUCCESS (0.164s)
[353.744288] Starting dynamic subtest: pipe-B-DP-4-4-rc-ccs-cc-to-4-rc-ccs
[353.868418] Dynamic subtest pipe-B-DP-4-4-rc-ccs-cc-to-4-rc-ccs: SUCCESS (0.148s)
[353.877529] Starting dynamic subtest: pipe-B-DP-4-4-rc-ccs-cc-to-4
[354.001819] Dynamic subtest pipe-B-DP-4-4-rc-ccs-cc-to-4: SUCCESS (0.132s)
[354.011984] Starting dynamic subtest: pipe-B-DP-4-4-rc-ccs-cc-to-x
[354.135400] Dynamic subtest pipe-B-DP-4-4-rc-ccs-cc-to-x: SUCCESS (0.132s)
[354.144937] Starting dynamic subtest: pipe-B-DP-4-4-rc-ccs-cc-to-linear
[354.251863] Dynamic subtest pipe-B-DP-4-4-rc-ccs-cc-to-linear: SUCCESS (0.115s)
[354.264504] Starting dynamic subtest: pipe-B-DP-4-4-rc-ccs-to-4-mc-ccs
[354.385322] Dynamic subtest pipe-B-DP-4-4-rc-ccs-to-4-mc-ccs: SUCCESS (0.132s)
[354.402319] Starting dynamic subtest: pipe-B-DP-4-4-rc-ccs-to-4-rc-ccs-cc
[354.518779] Dynamic subtest pipe-B-DP-4-4-rc-ccs-to-4-rc-ccs-cc: SUCCESS (0.132s)
[354.533079] Starting dynamic subtest: pipe-B-DP-4-4-rc-ccs-to-4-rc-ccs
[354.668589] Dynamic subtest pipe-B-DP-4-4-rc-ccs-to-4-rc-ccs: SUCCESS (0.149s)
[354.682405] Starting dynamic subtest: pipe-B-DP-4-4-rc-ccs-to-4
[354.818506] Dynamic subtest pipe-B-DP-4-4-rc-ccs-to-4: SUCCESS (0.149s)
[354.828449] Starting dynamic subtest: pipe-B-DP-4-4-rc-ccs-to-x
[354.952038] Dynamic subtest pipe-B-DP-4-4-rc-ccs-to-x: SUCCESS (0.132s)
[354.966364] Starting dynamic subtest: pipe-B-DP-4-4-rc-ccs-to-linear
[355.085134] Dynamic subtest pipe-B-DP-4-4-rc-ccs-to-linear: SUCCESS (0.132s)
[355.093444] Starting dynamic subtest: pipe-B-DP-4-4-to-4-mc-ccs
[355.218618] Dynamic subtest pipe-B-DP-4-4-to-4-mc-ccs: SUCCESS (0.132s)
[355.231883] Starting dynamic subtest: pipe-B-DP-4-4-to-4-rc-ccs-cc
[355.368385] Dynamic subtest pipe-B-DP-4-4-to-4-rc-ccs-cc: SUCCESS (0.148s)
[355.377182] Starting dynamic subtest: pipe-B-DP-4-4-to-4-rc-ccs
[355.501970] Dynamic subtest pipe-B-DP-4-4-to-4-rc-ccs: SUCCESS (0.132s)
[355.516745] Starting dynamic subtest: pipe-B-DP-4-4-to-4
[355.635235] Dynamic subtest pipe-B-DP-4-4-to-4: SUCCESS (0.132s)
[355.643253] Starting dynamic subtest: pipe-B-DP-4-4-to-x
[355.768490] Dynamic subtest pipe-B-DP-4-4-to-x: SUCCESS (0.132s)
[355.780226] Starting dynamic subtest: pipe-B-DP-4-4-to-linear
[355.902225] Dynamic subtest pipe-B-DP-4-4-to-linear: SUCCESS (0.132s)
[355.923088] Starting dynamic subtest: pipe-B-DP-4-x-to-4-mc-ccs
[356.051857] Dynamic subtest pipe-B-DP-4-x-to-4-mc-ccs: SUCCESS (0.148s)
[356.069418] Starting dynamic subtest: pipe-B-DP-4-x-to-4-rc-ccs-cc
[356.201887] Dynamic subtest pipe-B-DP-4-x-to-4-rc-ccs-cc: SUCCESS (0.149s)
[356.213130] Starting dynamic subtest: pipe-B-DP-4-x-to-4-rc-ccs
[356.335390] Dynamic subtest pipe-B-DP-4-x-to-4-rc-ccs: SUCCESS (0.132s)
[356.348223] Starting dynamic subtest: pipe-B-DP-4-x-to-4
[356.468497] Dynamic subtest pipe-B-DP-4-x-to-4: SUCCESS (0.132s)
[356.479652] Starting dynamic subtest: pipe-B-DP-4-x-to-x
[356.601955] Dynamic subtest pipe-B-DP-4-x-to-x: SUCCESS (0.132s)
[356.611955] Starting dynamic subtest: pipe-B-DP-4-x-to-linear
[356.735393] Dynamic subtest pipe-B-DP-4-x-to-linear: SUCCESS (0.132s)
[356.748191] Starting dynamic subtest: pipe-B-DP-4-linear-to-4-mc-ccs
[356.868661] Dynamic subtest pipe-B-DP-4-linear-to-4-mc-ccs: SUCCESS (0.132s)
[356.881445] Starting dynamic subtest: pipe-B-DP-4-linear-to-4-rc-ccs-cc
[357.001941] Dynamic subtest pipe-B-DP-4-linear-to-4-rc-ccs-cc: SUCCESS (0.132s)
[357.014764] Starting dynamic subtest: pipe-B-DP-4-linear-to-4-rc-ccs
[357.135381] Dynamic subtest pipe-B-DP-4-linear-to-4-rc-ccs: SUCCESS (0.132s)
[357.148070] Starting dynamic subtest: pipe-B-DP-4-linear-to-4
[357.268575] Dynamic subtest pipe-B-DP-4-linear-to-4: SUCCESS (0.132s)
[357.281576] Starting dynamic subtest: pipe-B-DP-4-linear-to-x
[357.401964] Dynamic subtest pipe-B-DP-4-linear-to-x: SUCCESS (0.132s)
[357.411959] Starting dynamic subtest: pipe-B-DP-4-linear-to-linear
[357.535239] Dynamic subtest pipe-B-DP-4-linear-to-linear: SUCCESS (0.132s)
[357.579489] Starting dynamic subtest: pipe-C-DP-4-4-mc-ccs-to-4-mc-ccs
[357.900697] Dynamic subtest pipe-C-DP-4-4-mc-ccs-to-4-mc-ccs: SUCCESS (0.319s)
[357.929507] Starting dynamic subtest: pipe-C-DP-4-4-mc-ccs-to-4-rc-ccs-cc
[358.058183] Dynamic subtest pipe-C-DP-4-4-mc-ccs-to-4-rc-ccs-cc: SUCCESS (0.164s)
[358.067784] Starting dynamic subtest: pipe-C-DP-4-4-mc-ccs-to-4-rc-ccs
[358.191723] Dynamic subtest pipe-C-DP-4-4-mc-ccs-to-4-rc-ccs: SUCCESS (0.132s)
[358.209917] Starting dynamic subtest: pipe-C-DP-4-4-mc-ccs-to-4
[358.341645] Dynamic subtest pipe-C-DP-4-4-mc-ccs-to-4: SUCCESS (0.149s)
[358.352914] Starting dynamic subtest: pipe-C-DP-4-4-mc-ccs-to-x
[358.475028] Dynamic subtest pipe-C-DP-4-4-mc-ccs-to-x: SUCCESS (0.132s)
[358.491419] Starting dynamic subtest: pipe-C-DP-4-4-mc-ccs-to-linear
[358.608311] Dynamic subtest pipe-C-DP-4-4-mc-ccs-to-linear: SUCCESS (0.132s)
[358.620355] Starting dynamic subtest: pipe-C-DP-4-4-rc-ccs-cc-to-4-mc-ccs
[358.741511] Dynamic subtest pipe-C-DP-4-4-rc-ccs-cc-to-4-mc-ccs: SUCCESS (0.132s)
[358.753690] Starting dynamic subtest: pipe-C-DP-4-4-rc-ccs-cc-to-4-rc-ccs-cc
[358.891485] Dynamic subtest pipe-C-DP-4-4-rc-ccs-cc-to-4-rc-ccs-cc: SUCCESS (0.149s)
[358.900008] Starting dynamic subtest: pipe-C-DP-4-4-rc-ccs-cc-to-4-rc-ccs
[359.025070] Dynamic subtest pipe-C-DP-4-4-rc-ccs-cc-to-4-rc-ccs: SUCCESS (0.132s)
[359.042351] Starting dynamic subtest: pipe-C-DP-4-4-rc-ccs-cc-to-4
[359.175068] Dynamic subtest pipe-C-DP-4-4-rc-ccs-cc-to-4: SUCCESS (0.149s)
[359.184383] Starting dynamic subtest: pipe-C-DP-4-4-rc-ccs-cc-to-x
[359.308761] Dynamic subtest pipe-C-DP-4-4-rc-ccs-cc-to-x: SUCCESS (0.132s)
[359.339981] Starting dynamic subtest: pipe-C-DP-4-4-rc-ccs-cc-to-linear
[359.475432] Dynamic subtest pipe-C-DP-4-4-rc-ccs-cc-to-linear: SUCCESS (0.164s)
[359.488528] Starting dynamic subtest: pipe-C-DP-4-4-rc-ccs-to-4-mc-ccs
[359.608314] Dynamic subtest pipe-C-DP-4-4-rc-ccs-to-4-mc-ccs: SUCCESS (0.131s)
[359.621188] Starting dynamic subtest: pipe-C-DP-4-4-rc-ccs-to-4-rc-ccs-cc
[359.741630] Dynamic subtest pipe-C-DP-4-4-rc-ccs-to-4-rc-ccs-cc: SUCCESS (0.132s)
[359.750503] Starting dynamic subtest: pipe-C-DP-4-4-rc-ccs-to-4-rc-ccs
[359.874994] Dynamic subtest pipe-C-DP-4-4-rc-ccs-to-4-rc-ccs: SUCCESS (0.132s)
[359.886146] Starting dynamic subtest: pipe-C-DP-4-4-rc-ccs-to-4
[360.008300] Dynamic subtest pipe-C-DP-4-4-rc-ccs-to-4: SUCCESS (0.132s)
[360.018059] Starting dynamic subtest: pipe-C-DP-4-4-rc-ccs-to-x
[360.141570] Dynamic subtest pipe-C-DP-4-4-rc-ccs-to-x: SUCCESS (0.132s)
[360.152552] Starting dynamic subtest: pipe-C-DP-4-4-rc-ccs-to-linear
[360.275132] Dynamic subtest pipe-C-DP-4-4-rc-ccs-to-linear: SUCCESS (0.132s)
[360.287680] Starting dynamic subtest: pipe-C-DP-4-4-to-4-mc-ccs
[360.425160] Dynamic subtest pipe-C-DP-4-4-to-4-mc-ccs: SUCCESS (0.149s)
[360.437811] Starting dynamic subtest: pipe-C-DP-4-4-to-4-rc-ccs-cc
[360.558734] Dynamic subtest pipe-C-DP-4-4-to-4-rc-ccs-cc: SUCCESS (0.132s)
[360.573677] Starting dynamic subtest: pipe-C-DP-4-4-to-4-rc-ccs
[360.708369] Dynamic subtest pipe-C-DP-4-4-to-4-rc-ccs: SUCCESS (0.149s)
[360.719430] Starting dynamic subtest: pipe-C-DP-4-4-to-4
[360.841392] Dynamic subtest pipe-C-DP-4-4-to-4: SUCCESS (0.132s)
[360.852554] Starting dynamic subtest: pipe-C-DP-4-4-to-x
[360.975091] Dynamic subtest pipe-C-DP-4-4-to-x: SUCCESS (0.132s)
[360.987713] Starting dynamic subtest: pipe-C-DP-4-4-to-linear
[361.108232] Dynamic subtest pipe-C-DP-4-4-to-linear: SUCCESS (0.132s)
[361.116852] Starting dynamic subtest: pipe-C-DP-4-x-to-4-mc-ccs
[361.225037] Dynamic subtest pipe-C-DP-4-x-to-4-mc-ccs: SUCCESS (0.116s)
[361.237949] Starting dynamic subtest: pipe-C-DP-4-x-to-4-rc-ccs-cc
[361.358430] Dynamic subtest pipe-C-DP-4-x-to-4-rc-ccs-cc: SUCCESS (0.132s)
[361.371906] Starting dynamic subtest: pipe-C-DP-4-x-to-4-rc-ccs
[361.508463] Dynamic subtest pipe-C-DP-4-x-to-4-rc-ccs: SUCCESS (0.149s)
[361.525862] Starting dynamic subtest: pipe-C-DP-4-x-to-4
[361.658654] Dynamic subtest pipe-C-DP-4-x-to-4: SUCCESS (0.149s)
[361.679783] Starting dynamic subtest: pipe-C-DP-4-x-to-x
[361.808446] Dynamic subtest pipe-C-DP-4-x-to-x: SUCCESS (0.148s)
[361.819650] Starting dynamic subtest: pipe-C-DP-4-x-to-linear
[361.941513] Dynamic subtest pipe-C-DP-4-x-to-linear: SUCCESS (0.132s)
[361.950507] Starting dynamic subtest: pipe-C-DP-4-linear-to-4-mc-ccs
[362.075343] Dynamic subtest pipe-C-DP-4-linear-to-4-mc-ccs: SUCCESS (0.132s)
[362.087414] Starting dynamic subtest: pipe-C-DP-4-linear-to-4-rc-ccs-cc
[362.208537] Dynamic subtest pipe-C-DP-4-linear-to-4-rc-ccs-cc: SUCCESS (0.132s)
[362.225690] Starting dynamic subtest: pipe-C-DP-4-linear-to-4-rc-ccs
[362.358503] Dynamic subtest pipe-C-DP-4-linear-to-4-rc-ccs: SUCCESS (0.149s)
[362.378583] Starting dynamic subtest: pipe-C-DP-4-linear-to-4
[362.508444] Dynamic subtest pipe-C-DP-4-linear-to-4: SUCCESS (0.149s)
[362.523035] Starting dynamic subtest: pipe-C-DP-4-linear-to-x
[362.642195] Dynamic subtest pipe-C-DP-4-linear-to-x: SUCCESS (0.132s)
[362.657054] Starting dynamic subtest: pipe-C-DP-4-linear-to-linear
[362.775211] Dynamic subtest pipe-C-DP-4-linear-to-linear: SUCCESS (0.132s)
[362.833230] Starting dynamic subtest: pipe-D-DP-4-4-mc-ccs-to-4-mc-ccs
[363.154252] Dynamic subtest pipe-D-DP-4-4-mc-ccs-to-4-mc-ccs: SUCCESS (0.337s)
[363.181854] Starting dynamic subtest: pipe-D-DP-4-4-mc-ccs-to-4-rc-ccs-cc
[363.314351] Dynamic subtest pipe-D-DP-4-4-mc-ccs-to-4-rc-ccs-cc: SUCCESS (0.164s)
[363.324135] Starting dynamic subtest: pipe-D-DP-4-4-mc-ccs-to-4-rc-ccs
[363.447479] Dynamic subtest pipe-D-DP-4-4-mc-ccs-to-4-rc-ccs: SUCCESS (0.132s)
[363.458120] Starting dynamic subtest: pipe-D-DP-4-4-mc-ccs-to-4
[363.581243] Dynamic subtest pipe-D-DP-4-4-mc-ccs-to-4: SUCCESS (0.132s)
[363.605100] Starting dynamic subtest: pipe-D-DP-4-4-mc-ccs-to-x
[363.731284] Dynamic subtest pipe-D-DP-4-4-mc-ccs-to-x: SUCCESS (0.148s)
[363.740391] Starting dynamic subtest: pipe-D-DP-4-4-mc-ccs-to-linear
[363.864552] Dynamic subtest pipe-D-DP-4-4-mc-ccs-to-linear: SUCCESS (0.132s)
[363.876403] Starting dynamic subtest: pipe-D-DP-4-4-rc-ccs-cc-to-4-mc-ccs
[363.997981] Dynamic subtest pipe-D-DP-4-4-rc-ccs-cc-to-4-mc-ccs: SUCCESS (0.132s)
[364.018926] Starting dynamic subtest: pipe-D-DP-4-4-rc-ccs-cc-to-4-rc-ccs-cc
[364.147564] Dynamic subtest pipe-D-DP-4-4-rc-ccs-cc-to-4-rc-ccs-cc: SUCCESS (0.148s)
[364.157450] Starting dynamic subtest: pipe-D-DP-4-4-rc-ccs-cc-to-4-rc-ccs
[364.281217] Dynamic subtest pipe-D-DP-4-4-rc-ccs-cc-to-4-rc-ccs: SUCCESS (0.132s)
[364.291209] Starting dynamic subtest: pipe-D-DP-4-4-rc-ccs-cc-to-4
[364.414733] Dynamic subtest pipe-D-DP-4-4-rc-ccs-cc-to-4: SUCCESS (0.132s)
[364.426066] Starting dynamic subtest: pipe-D-DP-4-4-rc-ccs-cc-to-x
[364.547879] Dynamic subtest pipe-D-DP-4-4-rc-ccs-cc-to-x: SUCCESS (0.132s)
[364.557918] Starting dynamic subtest: pipe-D-DP-4-4-rc-ccs-cc-to-linear
[364.681133] Dynamic subtest pipe-D-DP-4-4-rc-ccs-cc-to-linear: SUCCESS (0.132s)
[364.690620] Starting dynamic subtest: pipe-D-DP-4-4-rc-ccs-to-4-mc-ccs
[364.814667] Dynamic subtest pipe-D-DP-4-4-rc-ccs-to-4-mc-ccs: SUCCESS (0.132s)
[364.823929] Starting dynamic subtest: pipe-D-DP-4-4-rc-ccs-to-4-rc-ccs-cc
[364.931065] Dynamic subtest pipe-D-DP-4-4-rc-ccs-to-4-rc-ccs-cc: SUCCESS (0.115s)
[364.940520] Starting dynamic subtest: pipe-D-DP-4-4-rc-ccs-to-4-rc-ccs
[365.064535] Dynamic subtest pipe-D-DP-4-4-rc-ccs-to-4-rc-ccs: SUCCESS (0.132s)
[365.074430] Starting dynamic subtest: pipe-D-DP-4-4-rc-ccs-to-4
[365.197847] Dynamic subtest pipe-D-DP-4-4-rc-ccs-to-4: SUCCESS (0.132s)
[365.208986] Starting dynamic subtest: pipe-D-DP-4-4-rc-ccs-to-x
[365.331140] Dynamic subtest pipe-D-DP-4-4-rc-ccs-to-x: SUCCESS (0.132s)
[365.344128] Starting dynamic subtest: pipe-D-DP-4-4-rc-ccs-to-linear
[365.482051] Dynamic subtest pipe-D-DP-4-4-rc-ccs-to-linear: SUCCESS (0.149s)
[365.514054] Starting dynamic subtest: pipe-D-DP-4-4-to-4-mc-ccs
[365.631113] Dynamic subtest pipe-D-DP-4-4-to-4-mc-ccs: SUCCESS (0.147s)
[365.642238] Starting dynamic subtest: pipe-D-DP-4-4-to-4-rc-ccs-cc
[365.764447] Dynamic subtest pipe-D-DP-4-4-to-4-rc-ccs-cc: SUCCESS (0.132s)
[365.773823] Starting dynamic subtest: pipe-D-DP-4-4-to-4-rc-ccs
[365.897715] Dynamic subtest pipe-D-DP-4-4-to-4-rc-ccs: SUCCESS (0.132s)
[365.906932] Starting dynamic subtest: pipe-D-DP-4-4-to-4
[366.031304] Dynamic subtest pipe-D-DP-4-4-to-4: SUCCESS (0.133s)
[366.040581] Starting dynamic subtest: pipe-D-DP-4-4-to-x
[366.164608] Dynamic subtest pipe-D-DP-4-4-to-x: SUCCESS (0.132s)
[366.184266] Starting dynamic subtest: pipe-D-DP-4-4-to-linear
[366.314451] Dynamic subtest pipe-D-DP-4-4-to-linear: SUCCESS (0.149s)
[366.326452] Starting dynamic subtest: pipe-D-DP-4-x-to-4-mc-ccs
[366.447852] Dynamic subtest pipe-D-DP-4-x-to-4-mc-ccs: SUCCESS (0.132s)
[366.462876] Starting dynamic subtest: pipe-D-DP-4-x-to-4-rc-ccs-cc
[366.581110] Dynamic subtest pipe-D-DP-4-x-to-4-rc-ccs-cc: SUCCESS (0.132s)
[366.589879] Starting dynamic subtest: pipe-D-DP-4-x-to-4-rc-ccs
[366.697862] Dynamic subtest pipe-D-DP-4-x-to-4-rc-ccs: SUCCESS (0.115s)
[366.706240] Starting dynamic subtest: pipe-D-DP-4-x-to-4
[366.814576] Dynamic subtest pipe-D-DP-4-x-to-4: SUCCESS (0.116s)
[366.825949] Starting dynamic subtest: pipe-D-DP-4-x-to-x
[366.947858] Dynamic subtest pipe-D-DP-4-x-to-x: SUCCESS (0.132s)
[366.958609] Starting dynamic subtest: pipe-D-DP-4-x-to-linear
[367.081261] Dynamic subtest pipe-D-DP-4-x-to-linear: SUCCESS (0.132s)
[367.090244] Starting dynamic subtest: pipe-D-DP-4-linear-to-4-mc-ccs
[367.214660] Dynamic subtest pipe-D-DP-4-linear-to-4-mc-ccs: SUCCESS (0.132s)
[367.227485] Starting dynamic subtest: pipe-D-DP-4-linear-to-4-rc-ccs-cc
[367.347641] Dynamic subtest pipe-D-DP-4-linear-to-4-rc-ccs-cc: SUCCESS (0.132s)
[367.359609] Starting dynamic subtest: pipe-D-DP-4-linear-to-4-rc-ccs
[367.481330] Dynamic subtest pipe-D-DP-4-linear-to-4-rc-ccs: SUCCESS (0.132s)
[367.493069] Starting dynamic subtest: pipe-D-DP-4-linear-to-4
[367.598253] Dynamic subtest pipe-D-DP-4-linear-to-4: SUCCESS (0.115s)
[367.619571] Starting dynamic subtest: pipe-D-DP-4-linear-to-x
[367.747927] Dynamic subtest pipe-D-DP-4-linear-to-x: SUCCESS (0.148s)
[367.758228] Starting dynamic subtest: pipe-D-DP-4-linear-to-linear
[367.881286] Dynamic subtest pipe-D-DP-4-linear-to-linear: SUCCESS (0.132s)
[367.914848] Subtest flip-change-tiling: SUCCESS (21.861s)
[368.207635] [105/138] (631s left) gem_exec_suspend (basic-s3)
[368.291500] Starting subtest: basic-S3
[368.292447] Starting dynamic subtest: smem
[390.738839] Dynamic subtest smem: SUCCESS (6.595s)
[390.761924] Starting dynamic subtest: lmem0
[413.831111] Dynamic subtest lmem0: SUCCESS (6.446s)
[413.832444] Subtest basic-S3: SUCCESS (13.045s)
[414.064167] [106/138] (618s left) kms_big_fb (yf-tiled-32bpp-rotate-90)
[414.183651] Starting subtest: yf-tiled-32bpp-rotate-90
[414.185279] Subtest yf-tiled-32bpp-rotate-90: SKIP (0.000s)
[414.265894] [107/138] (618s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-mmap-wc)
[414.400500] Starting subtest: psr-1p-primscrn-spr-indfb-draw-mmap-wc
[414.402286] Subtest psr-1p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[414.508796] [108/138] (617s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-render)
[414.663205] Starting subtest: fbc-rgb101010-draw-render
[417.493122] Subtest fbc-rgb101010-draw-render: SUCCESS (2.832s)
[417.629453] [109/138] (614s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite)
[417.757845] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite
[417.759647] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[417.827935] [110/138] (614s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0)
[417.962730] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0
[419.143189] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0: SUCCESS (1.180s)
[419.282259] [111/138] (613s left) perf_pmu (pmu-read)
[419.330703] Starting subtest: pmu-read
[419.333536] Subtest pmu-read: SUCCESS (0.003s)
[419.395876] [112/138] (613s left) perf (enable-disable)
[419.705843] Starting subtest: enable-disable
[419.706754] Starting dynamic subtest: 0-rcs0
[420.366975] Dynamic subtest 0-rcs0: FAIL (0.617s)
[420.367667] Subtest enable-disable: FAIL (0.618s)
[420.538064] [113/138] (612s left) kms_ccs (pipe-a-bad-rotation-90-yf-tiled-ccs)
[420.789985] Starting subtest: pipe-A-bad-rotation-90-yf-tiled-ccs
[420.791886] Subtest pipe-A-bad-rotation-90-yf-tiled-ccs: SKIP (0.000s)
[421.045413] [114/138] (611s left) kms_cursor_legacy (forked-move)
[421.190731] Starting subtest: forked-move
[421.191701] Starting dynamic subtest: pipe-A
[426.646576] Dynamic subtest pipe-A: SUCCESS (5.419s)
[426.656501] Starting dynamic subtest: pipe-B
[432.094239] Dynamic subtest pipe-B: SUCCESS (5.449s)
[432.109439] Starting dynamic subtest: pipe-C
[437.534835] Dynamic subtest pipe-C: SUCCESS (5.439s)
[437.544694] Starting dynamic subtest: pipe-D
[442.971253] Dynamic subtest pipe-D: SUCCESS (5.457s)
[442.993604] Starting dynamic subtest: all-pipes
[448.407852] Dynamic subtest all-pipes: SUCCESS (5.438s)
[448.408932] Subtest forked-move: SUCCESS (27.209s)
[448.478135] [115/138] (584s left) gem_mmap_wc (write-gtt-read-wc)
[448.559968] Subtest write-gtt-read-wc: SKIP (0.000s)
[448.592772] [116/138] (584s left) syncobj_wait (single-wait-for-submit-unsubmitted)
[448.649931] Starting subtest: single-wait-for-submit-unsubmitted
[448.752972] Subtest single-wait-for-submit-unsubmitted: SUCCESS (0.103s)
[448.850396] [117/138] (583s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-64bpp-ytile-downscaling)
[448.975657] Starting subtest: flip-32bpp-ytile-to-64bpp-ytile-downscaling
[448.976680] Starting dynamic subtest: pipe-A-valid-mode
[449.056794] Dynamic subtest pipe-A-valid-mode: SKIP (0.080s)
[449.058628] Subtest flip-32bpp-ytile-to-64bpp-ytile-downscaling: SKIP (0.082s)
[449.237267] [118/138] (583s left) gem_eio (create-ext)
[449.493920] Starting subtest: create-ext
[449.997445] Subtest create-ext: SUCCESS (0.504s)
[450.135391] [119/138] (582s left) kms_pipe_crc_basic (read-crc)
[450.254494] Starting subtest: read-crc
[450.255305] Starting dynamic subtest: pipe-A-DP-4
[450.858967] Dynamic subtest pipe-A-DP-4: SUCCESS (0.602s)
[450.872423] Starting dynamic subtest: pipe-B-DP-4
[451.401320] Dynamic subtest pipe-B-DP-4: SUCCESS (0.541s)
[451.411661] Starting dynamic subtest: pipe-C-DP-4
[451.955958] Dynamic subtest pipe-C-DP-4: SUCCESS (0.552s)
[451.969429] Starting dynamic subtest: pipe-D-DP-4
[452.497754] Dynamic subtest pipe-D-DP-4: SUCCESS (0.541s)
[452.498636] Subtest read-crc: SUCCESS (2.244s)
[452.747726] [120/138] (580s left) i915_hangman (engine-engine-hang)
[452.822784] Starting subtest: engine-engine-hang
[452.823741] Starting dynamic subtest: rcs0
[453.637027] Dynamic subtest rcs0: SUCCESS (0.814s)
[453.647296] Starting dynamic subtest: bcs0
[454.437742] Dynamic subtest bcs0: SUCCESS (0.800s)
[454.447209] Starting dynamic subtest: vcs0
[455.260947] Dynamic subtest vcs0: SUCCESS (0.822s)
[455.271934] Starting dynamic subtest: vcs1
[456.069948] Dynamic subtest vcs1: SUCCESS (0.808s)
[456.082341] Starting dynamic subtest: vecs0
[456.881775] Dynamic subtest vecs0: SUCCESS (0.811s)
[456.892059] Starting dynamic subtest: vecs1
[457.695900] Dynamic subtest vecs1: SUCCESS (0.813s)
[457.710780] Starting dynamic subtest: ccs0
[458.605766] Dynamic subtest ccs0: SUCCESS (0.909s)
[458.616550] Starting dynamic subtest: ccs1
[459.515906] Dynamic subtest ccs1: SUCCESS (0.909s)
[459.527581] Starting dynamic subtest: ccs2
[460.428052] Dynamic subtest ccs2: SUCCESS (0.911s)
[460.442256] Starting dynamic subtest: ccs3
[461.343700] Dynamic subtest ccs3: SUCCESS (0.915s)
[461.344718] Subtest engine-engine-hang: SUCCESS (8.522s)
[461.491454] [121/138] (571s left) kms_ccs (pipe-a-crc-sprite-planes-basic-y-tiled-ccs)
[461.696641] Starting subtest: pipe-A-crc-sprite-planes-basic-y-tiled-ccs
[461.699637] Subtest pipe-A-crc-sprite-planes-basic-y-tiled-ccs: SKIP (0.002s)
[461.925655] [122/138] (571s left) syncobj_timeline (multi-wait-for-submit-signaled)
[461.999853] Starting subtest: multi-wait-for-submit-signaled
[462.000727] Subtest multi-wait-for-submit-signaled: SUCCESS (0.001s)
[462.070404] [123/138] (570s left) gem_readwrite (read-write)
[462.145162] Subtest read-write: SKIP (0.000s)
[462.208392] [124/138] (570s left) prime_busy (after)
[462.271930] Starting subtest: after
[462.275962] Starting dynamic subtest: rcs0
[462.328281] Dynamic subtest rcs0: SUCCESS (0.052s)
[462.340209] Starting dynamic subtest: bcs0
[462.367654] Dynamic subtest bcs0: SUCCESS (0.038s)
[462.383358] Starting dynamic subtest: vcs0
[462.409400] Dynamic subtest vcs0: SUCCESS (0.040s)
[462.438129] Starting dynamic subtest: vcs1
[462.452214] Dynamic subtest vcs1: SUCCESS (0.041s)
[462.472257] Starting dynamic subtest: vecs0
[462.492823] Dynamic subtest vecs0: SUCCESS (0.039s)
[462.507543] Starting dynamic subtest: vecs1
[462.532528] Dynamic subtest vecs1: SUCCESS (0.039s)
[462.546888] Starting dynamic subtest: ccs0
[462.571707] Dynamic subtest ccs0: SUCCESS (0.038s)
[462.589932] Starting dynamic subtest: ccs1
[462.611948] Dynamic subtest ccs1: SUCCESS (0.039s)
[462.628548] Starting dynamic subtest: ccs2
[462.652075] Dynamic subtest ccs2: SUCCESS (0.039s)
[462.670599] Starting dynamic subtest: ccs3
[462.692139] Dynamic subtest ccs3: SUCCESS (0.039s)
[462.802450] Subtest after: SUCCESS (0.529s)
[462.918474] [125/138] (570s left) kms_content_protection (dp-mst-lic-type-0)
[463.079029] Starting subtest: dp-mst-lic-type-0
[463.080753] Subtest dp-mst-lic-type-0: SKIP (0.000s)
[463.172476] [126/138] (569s left) gem_ctx_isolation (clean)
[463.252046] Starting subtest: clean
[463.252869] Starting dynamic subtest: rcs0
[463.328150] Dynamic subtest rcs0: SUCCESS (0.075s)
[463.337223] Starting dynamic subtest: bcs0
[463.447447] Dynamic subtest bcs0: SUCCESS (0.118s)
[463.456563] Starting dynamic subtest: vcs0
[463.546399] Dynamic subtest vcs0: SUCCESS (0.098s)
[463.555482] Starting dynamic subtest: vcs1
[463.646276] Dynamic subtest vcs1: SUCCESS (0.099s)
[463.655388] Starting dynamic subtest: vecs0
[463.739930] Dynamic subtest vecs0: SUCCESS (0.093s)
[463.748979] Starting dynamic subtest: vecs1
[463.822609] Dynamic subtest vecs1: SUCCESS (0.082s)
[463.831744] Starting dynamic subtest: ccs0
[463.917267] Dynamic subtest ccs0: SUCCESS (0.094s)
[463.926344] Starting dynamic subtest: ccs1
[464.017382] Dynamic subtest ccs1: SUCCESS (0.099s)
[464.026332] Starting dynamic subtest: ccs2
[464.085453] Dynamic subtest ccs2: SUCCESS (0.067s)
[464.094235] Starting dynamic subtest: ccs3
[464.188349] Dynamic subtest ccs3: SUCCESS (0.102s)
[464.189270] Subtest clean: SUCCESS (0.937s)
[464.402539] [127/138] (568s left) syncobj_timeline (invalid-signal-illegal-point)
[464.446443] Starting subtest: invalid-signal-illegal-point
[464.447311] Subtest invalid-signal-illegal-point: SUCCESS (0.000s)
[464.532178] [128/138] (568s left) gem_ctx_shared (create-shared-gtt)
[464.594124] Starting subtest: create-shared-gtt
[466.744872] Subtest create-shared-gtt: SUCCESS (2.150s)
[469.164120] [129/138] (563s left) gem_media_fill (media-fill)
[469.236978] Subtest media-fill: SKIP (0.000s)
[469.307628] [130/138] (563s left) kms_flip (dpms-off-confusion)
[469.412698] Starting subtest: dpms-off-confusion
[469.417228] Starting dynamic subtest: A-DP4
[477.267069] Dynamic subtest A-DP4: SUCCESS (7.846s)
[477.276856] Starting dynamic subtest: B-DP4
[485.021652] Dynamic subtest B-DP4: SUCCESS (7.757s)
[485.031138] Starting dynamic subtest: C-DP4
[492.773475] Dynamic subtest C-DP4: SUCCESS (7.751s)
[492.782554] Starting dynamic subtest: D-DP4
[500.531823] Dynamic subtest D-DP4: SUCCESS (7.758s)
[500.532765] Subtest dpms-off-confusion: SUCCESS (31.122s)
[500.839298] [131/138] (532s left) kms_cursor_crc (cursor-offscreen-32x32)
[501.020085] Starting subtest: cursor-offscreen-32x32
[501.062624] Subtest cursor-offscreen-32x32: SKIP (0.040s)
[501.387456] [132/138] (531s left) kms_plane_scaling (plane-upscale-factor-0-25-with-rotation)
[501.529177] Starting subtest: plane-upscale-factor-0-25-with-rotation
[501.541519] Starting dynamic subtest: pipe-A-DP-4
[502.021212] Dynamic subtest pipe-A-DP-4: SUCCESS (0.479s)
[502.051966] Starting dynamic subtest: pipe-B-DP-4
[502.628622] Dynamic subtest pipe-B-DP-4: SUCCESS (0.592s)
[502.664621] Starting dynamic subtest: pipe-C-DP-4
[503.184909] Dynamic subtest pipe-C-DP-4: SUCCESS (0.540s)
[503.212427] Starting dynamic subtest: pipe-D-DP-4
[503.828186] Dynamic subtest pipe-D-DP-4: SUCCESS (0.629s)
[503.829661] Subtest plane-upscale-factor-0-25-with-rotation: SUCCESS (2.299s)
[504.167173] [133/138] (529s left) kms_ccs (pipe-c-random-ccs-data-4-tiled-mtl-rc-ccs-cc)
[504.444653] Starting subtest: pipe-C-random-ccs-data-4-tiled-mtl-rc-ccs-cc
[504.447377] Subtest pipe-C-random-ccs-data-4-tiled-mtl-rc-ccs-cc: SKIP (0.000s)
[504.644526] [134/138] (528s left) gem_softpin (full)
[504.732418] Starting subtest: full
[504.744595] Subtest full: SUCCESS (0.012s)
[504.858880] [135/138] (528s left) gem_exec_fair (basic-none-solo)
[504.914739] Subtest basic-none-solo: SKIP (0.000s)
[504.958111] [136/138] (528s left) perf (gen12-invalid-class-instance)
[505.107954] Starting subtest: gen12-invalid-class-instance
[505.121852] Subtest gen12-invalid-class-instance: SUCCESS (0.014s)
[505.145485] [137/138] (528s left) kms_frontbuffer_tracking (fbc-rgb565-draw-render)
[505.271138] Starting subtest: fbc-rgb565-draw-render
[507.748136] Subtest fbc-rgb565-draw-render: SUCCESS (2.479s)
[507.902083] [138/138] (525s left) api_intel_allocator (fork-simple-once)
[507.959780] Starting subtest: fork-simple-once
[507.990497] Subtest fork-simple-once: SUCCESS (0.032s)
[508.104801] Closing watchdogs
Done.