[50.654665] Initializing watchdogs
[50.654863]   /dev/watchdog0
[50.689584] [001/142] (960s left) v3d/v3d_submit_csd (valid-multisync-submission)
[51.020955] Subtest valid-multisync-submission: SKIP (0.000s)
[51.106065] [002/142] (960s left) perf_pmu (module-unload)
[51.364438] Starting subtest: module-unload
[88.604802] Subtest module-unload: SUCCESS (37.264s)
[88.684114] [003/142] (922s left) kms_cursor_crc (cursor-random-512x512)
[92.129527] Starting subtest: cursor-random-512x512
[92.172682] Subtest cursor-random-512x512: SKIP (0.003s)
[92.262774] [004/142] (919s left) kms_ccs (pipe-a-bad-rotation-90-4_tiled_mtl_rc_ccs)
[92.686694] Starting subtest: pipe-A-bad-rotation-90-4_tiled_mtl_rc_ccs
[92.727586] Subtest pipe-A-bad-rotation-90-4_tiled_mtl_rc_ccs: SKIP (0.000s)
[93.165998] [005/142] (918s left) gen9_exec_parse (allowed-single)
[93.421926] Starting subtest: allowed-single
[93.444181] Subtest allowed-single: SUCCESS (0.025s)
[93.678943] [006/142] (917s left) api_intel_bb (intel-bb-blit-x)
[93.919079] Starting subtest: intel-bb-blit-x
[97.285652] Subtest intel-bb-blit-x: SUCCESS (3.227s)
[97.371824] [007/142] (914s left) gem_exec_params (rel-constants-invalid-ring)
[97.601277] Starting subtest: rel-constants-invalid-ring
[97.622838] Subtest rel-constants-invalid-ring: SUCCESS (0.001s)
[97.717281] [008/142] (914s left) kms_cursor_edge_walk (64x64-top-bottom)
[98.015992] Starting subtest: 64x64-top-bottom
[98.034823] Starting dynamic subtest: pipe-A-DP-1
[101.907718] Dynamic subtest pipe-A-DP-1: SUCCESS (3.875s)
[101.946865] Starting dynamic subtest: pipe-C-DP-1
[105.357769] Dynamic subtest pipe-C-DP-1: SUCCESS (3.466s)
[105.382213] Subtest 64x64-top-bottom: SUCCESS (7.347s)
[105.713986] [009/142] (906s left) syncobj_timeline (multi-wait-all-available-submitted-signaled)
[105.989228] Starting subtest: multi-wait-all-available-submitted-signaled
[106.018821] Subtest multi-wait-all-available-submitted-signaled: SUCCESS (0.002s)
[106.121698] [010/142] (905s left) kms_busy (extended-modeset-hang-oldfb-with-reset)
[106.454557] Starting subtest: extended-modeset-hang-oldfb-with-reset
[106.476394] Starting dynamic subtest: pipe-A
[108.395594] Dynamic subtest pipe-A: SUCCESS (1.944s)
[108.428516] Starting dynamic subtest: pipe-C
[110.486203] Dynamic subtest pipe-C: SUCCESS (2.078s)
[110.506638] Subtest extended-modeset-hang-oldfb-with-reset: SUCCESS (4.032s)
[110.842333] [011/142] (901s left) kms_getfb (getfb2-handle-not-fb)
[111.079406] Starting subtest: getfb2-handle-not-fb
[111.145597] Subtest getfb2-handle-not-fb: SUCCESS (0.092s)
[111.268506] [012/142] (900s left) gem_ctx_param (invalid-param-set)
[111.508952] Starting subtest: invalid-param-set
[111.527957] Subtest invalid-param-set: SUCCESS (0.000s)
[111.611588] [013/142] (900s left) kms_cursor_edge_walk (256x256-top-bottom)
[111.903528] Starting subtest: 256x256-top-bottom
[111.924392] Starting dynamic subtest: pipe-A-DP-1
[115.552777] Dynamic subtest pipe-A-DP-1: SUCCESS (3.647s)
[115.585944] Starting dynamic subtest: pipe-C-DP-1
[119.070329] Dynamic subtest pipe-C-DP-1: SUCCESS (3.497s)
[119.089186] Subtest 256x256-top-bottom: SUCCESS (7.150s)
[119.389950] [014/142] (892s left) gem_set_tiling_vs_blt (untiled-to-tiled)
[119.622302] Starting subtest: untiled-to-tiled
[119.745732] Subtest untiled-to-tiled: SUCCESS (0.118s)
[119.854249] [015/142] (892s left) sw_sync (sync_merge)
[120.068193] Starting subtest: sync_merge
[120.090116] Subtest sync_merge: SUCCESS (0.001s)
[120.178141] [016/142] (892s left) gem_busy (busy)
[120.411834] Starting subtest: busy
[120.434370] Starting dynamic subtest: all-engines
[120.494268] Dynamic subtest all-engines: SUCCESS (0.090s)
[120.531150] Starting dynamic subtest: rcs0
[120.549970] Dynamic subtest rcs0: SUCCESS (0.013s)
[120.582472] Starting dynamic subtest: bcs0
[120.601282] Dynamic subtest bcs0: SUCCESS (0.014s)
[120.644634] Starting dynamic subtest: vcs0
[120.665471] Dynamic subtest vcs0: SUCCESS (0.018s)
[120.704908] Starting dynamic subtest: vecs0
[120.725098] Dynamic subtest vecs0: SUCCESS (0.013s)
[120.743829] Subtest busy: SUCCESS (0.150s)
[120.955364] [017/142] (891s left) kms_ccs (pipe-b-crc-sprite-planes-basic-y_tiled_gen12_mc_ccs)
[121.429684] Starting subtest: pipe-B-crc-sprite-planes-basic-y_tiled_gen12_mc_ccs
[121.470303] Subtest pipe-B-crc-sprite-planes-basic-y_tiled_gen12_mc_ccs: SKIP (0.005s)
[121.836479] [018/142] (890s left) gem_mmap_offset (close-race)
[122.070459] Starting subtest: close-race
[142.342605] Subtest close-race: SUCCESS (20.126s)
[142.429589] [019/142] (870s left) kms_big_fb (y-tiled-addfb)
[142.769523] Starting subtest: y-tiled-addfb
[142.788636] Subtest y-tiled-addfb: SUCCESS (0.000s)
[142.874463] [020/142] (869s left) gem_lmem_swapping (heavy-random)
[143.129142] Subtest heavy-random: SKIP (0.000s)
[143.217955] [021/142] (869s left) kms_cursor_legacy (2x-cursor-vs-flip-legacy)
[143.517598] Starting subtest: 2x-cursor-vs-flip-legacy
[143.554751] Subtest 2x-cursor-vs-flip-legacy: SKIP (0.004s)
[143.640263] [022/142] (869s left) api_intel_bb (simple-bb-ctx)
[143.868151] Starting subtest: simple-bb-ctx
[143.886948] Subtest simple-bb-ctx: SUCCESS (0.016s)
[143.986634] [023/142] (869s left) kms_cursor_crc (cursor-offscreen-256x256)
[144.300706] Starting subtest: cursor-offscreen-256x256
[144.319500] Starting dynamic subtest: pipe-A-DP-1
[146.801619] Dynamic subtest pipe-A-DP-1: SUCCESS (2.489s)
[146.882155] Starting dynamic subtest: pipe-C-DP-1
[149.441694] Dynamic subtest pipe-C-DP-1: SUCCESS (2.580s)
[149.460639] Subtest cursor-offscreen-256x256: SUCCESS (5.145s)
[149.804365] [024/142] (863s left) kms_lease (lease-uevent)
[150.103731] Starting subtest: lease-uevent
[151.117574] Subtest lease-uevent: SUCCESS (1.024s)
[151.229400] [025/142] (862s left) kms_chamelium_hpd (vga-hpd-without-ddc)
[151.659523] Subtest vga-hpd-without-ddc: SKIP (0.000s)
[151.947457] [026/142] (861s left) syncobj_wait (invalid-signal-zero-handles)
[152.191147] Starting subtest: invalid-signal-zero-handles
[152.210130] Subtest invalid-signal-zero-handles: SUCCESS (0.000s)
[152.291611] [027/142] (861s left) gem_mmap_gtt (fault-concurrent-x)
[152.528126] Starting subtest: fault-concurrent-X
[156.195375] Subtest fault-concurrent-X: SUCCESS (3.523s)
[156.351265] [028/142] (857s left) kms_psr (psr2_cursor_plane_move)
[156.607328] Subtest psr2_cursor_plane_move: SKIP (0.000s)
[156.689565] [029/142] (856s left) kms_ccs (pipe-d-bad-rotation-90-yf_tiled_ccs)
[157.257132] Subtest pipe-D-bad-rotation-90-yf_tiled_ccs: SKIP (0.000s)
[157.584557] [030/142] (856s left) kms_ccs (pipe-a-missing-ccs-buffer-4_tiled_mtl_mc_ccs)
[158.002407] Starting subtest: pipe-A-missing-ccs-buffer-4_tiled_mtl_mc_ccs
[158.052108] Subtest pipe-A-missing-ccs-buffer-4_tiled_mtl_mc_ccs: SKIP (0.000s)
[158.477093] [031/142] (855s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-mmap-wc)
[158.869073] Starting subtest: psr-2p-primscrn-cur-indfb-draw-mmap-wc
[158.908054] Subtest psr-2p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[158.990126] [032/142] (854s left) dmabuf_sync_file (import-multiple-read-write)
[159.320347] Starting subtest: import-multiple-read-write
[159.342401] Subtest import-multiple-read-write: SUCCESS (0.012s)
[159.428801] [033/142] (854s left) kms_flip (flip-vs-modeset-vs-hang)
[159.730056] Starting subtest: flip-vs-modeset-vs-hang
[159.748701] Starting dynamic subtest: A-DP1
[173.946951] Dynamic subtest A-DP1: SUCCESS (14.218s)
[173.981522] Starting dynamic subtest: C-DP1
[187.965538] Dynamic subtest C-DP1: SUCCESS (14.014s)
[187.986288] Subtest flip-vs-modeset-vs-hang: SUCCESS (28.238s)
[188.354793] [034/142] (825s left) syncobj_timeline (single-wait-available-submitted)
[188.578489] Starting subtest: single-wait-available-submitted
[188.600106] Subtest single-wait-available-submitted: SUCCESS (0.001s)
[188.687385] [035/142] (825s left) gem_workarounds (reset-fd)
[188.924221] Starting subtest: reset-fd
[188.965453] Subtest reset-fd: SUCCESS (0.028s)
[189.084194] [036/142] (825s left) template (a)
[189.312203] Starting subtest: A
[189.330997] Subtest A: SUCCESS (0.000s)
[189.425712] [037/142] (824s left) kms_ccs (pipe-c-crc-primary-rotation-180-y_tiled_gen12_mc_ccs)
[189.921451] Starting subtest: pipe-C-crc-primary-rotation-180-y_tiled_gen12_mc_ccs
[189.965107] Subtest pipe-C-crc-primary-rotation-180-y_tiled_gen12_mc_ccs: SKIP (0.001s)
[190.297574] [038/142] (824s left) gem_exec_schedule (preempt)
[190.694354] Starting subtest: preempt
[190.713669] Starting dynamic subtest: rcs0
[190.736140] Dynamic subtest rcs0: SUCCESS (0.067s)
[190.775376] Starting dynamic subtest: bcs0
[190.796759] Dynamic subtest bcs0: SUCCESS (0.086s)
[190.834478] Starting dynamic subtest: vcs0
[190.853501] Dynamic subtest vcs0: SUCCESS (0.059s)
[190.887509] Starting dynamic subtest: vecs0
[190.906238] Dynamic subtest vecs0: SUCCESS (0.059s)
[190.924736] Subtest preempt: SUCCESS (0.276s)
[191.215210] [039/142] (823s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-gtt)
[191.568916] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-gtt
[191.611365] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[191.699330] [040/142] (822s left) kms_frontbuffer_tracking (psr-2p-scndscrn-indfb-plflip-blt)
[192.054957] Starting subtest: psr-2p-scndscrn-indfb-plflip-blt
[192.096962] Subtest psr-2p-scndscrn-indfb-plflip-blt: SKIP (0.000s)
[192.182491] [041/142] (822s left) core_getstats
[192.501831] [042/142] (822s left) sw_sync (sync_busy)
[192.711103] Starting subtest: sync_busy
[192.729961] Subtest sync_busy: SUCCESS (0.007s)
[192.815739] [043/142] (821s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-onoff)
[193.195225] Starting subtest: fbc-2p-scndscrn-spr-indfb-onoff
[193.232393] Subtest fbc-2p-scndscrn-spr-indfb-onoff: SKIP (0.000s)
[193.322442] [044/142] (821s left) kms_flip (flip-vs-panning-interruptible)
[193.621762] Starting subtest: flip-vs-panning-interruptible
[193.640430] Starting dynamic subtest: A-DP1
[204.202451] Dynamic subtest A-DP1: SUCCESS (10.581s)
[204.239067] Starting dynamic subtest: B-DP1
[214.695085] Dynamic subtest B-DP1: SUCCESS (10.466s)
[214.734741] Starting dynamic subtest: C-DP1
[225.166095] Dynamic subtest C-DP1: SUCCESS (10.483s)
[225.184741] Subtest flip-vs-panning-interruptible: SUCCESS (31.541s)
[225.615102] [045/142] (789s left) kms_big_fb (yf-tiled-64bpp-rotate-90)
[225.954187] Starting subtest: yf-tiled-64bpp-rotate-90
[225.994414] Subtest yf-tiled-64bpp-rotate-90: SKIP (0.000s)
[226.080661] [046/142] (788s left) vc4/vc4_tiling (set-get)
[226.357274] Subtest set-get: SKIP (0.000s)
[226.447396] [047/142] (788s left) gem_ctx_param (invalid-size-set)
[226.675431] Starting subtest: invalid-size-set
[226.696693] Subtest invalid-size-set: SUCCESS (0.000s)
[226.791901] [048/142] (788s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling)
[227.100860] Starting subtest: flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling
[227.119963] Starting dynamic subtest: pipe-A-valid-mode
[227.210238] Dynamic subtest pipe-A-valid-mode: SKIP (0.098s)
[227.255554] Subtest flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling: SKIP (0.101s)
[227.518486] [049/142] (787s left) gem_userptr_blits (process-exit)
[227.837509] Starting subtest: process-exit
[227.859241] Subtest process-exit: SUCCESS (0.038s)
[227.967237] [050/142] (787s left) gem_workarounds (suspend-resume-fd)
[228.198587] Starting subtest: suspend-resume-fd
[244.210247] Subtest suspend-resume-fd: SUCCESS (1.861s)
[251.356868] [051/142] (785s left) kms_lease (setcrtc_implicit_plane)
[251.643711] Starting subtest: setcrtc_implicit_plane
[251.662444] Starting dynamic subtest: pipe-A-DP-1
[251.943821] Dynamic subtest pipe-A-DP-1: SUCCESS (0.296s)
[251.990328] Starting dynamic subtest: pipe-B-DP-1
[252.408339] Dynamic subtest pipe-B-DP-1: SUCCESS (0.465s)
[252.452205] Starting dynamic subtest: pipe-C-DP-1
[252.886769] Dynamic subtest pipe-C-DP-1: SUCCESS (0.478s)
[252.908759] Subtest setcrtc_implicit_plane: SUCCESS (1.250s)
[253.236747] [052/142] (783s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-pwrite)
[253.593748] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-pwrite
[253.635917] Subtest fbc-2p-scndscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[253.727774] [053/142] (783s left) gem_exec_balancer (persistence)
[258.103455] Starting subtest: persistence
[261.718278] Subtest persistence: SUCCESS (3.725s)
[261.808418] [054/142] (775s left) gem_fence_thrash (bo-write-verify-none)
[262.024492] Starting subtest: bo-write-verify-none
[263.177325] Subtest bo-write-verify-none: SUCCESS (1.172s)
[263.301974] [055/142] (773s left) dumb_buffer (map-invalid-size)
[263.535934] Starting subtest: map-invalid-size
[263.557531] Subtest map-invalid-size: SUCCESS (0.000s)
[263.651199] [056/142] (773s left) kms_psr (sprite_plane_move)
[263.901978] Subtest sprite_plane_move: SKIP (0.000s)
[263.989778] [057/142] (773s left) syncobj_wait (multi-wait-for-submit-unsubmitted-submitted)
[264.221987] Starting subtest: multi-wait-for-submit-unsubmitted-submitted
[264.297100] Subtest multi-wait-for-submit-unsubmitted-submitted: SUCCESS (0.104s)
[264.419455] [058/142] (772s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180-hflip)
[264.734053] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180-hflip
[264.811678] Subtest x-tiled-max-hw-stride-32bpp-rotate-180-hflip: SKIP (0.020s)
[264.908563] [059/142] (772s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-pwrite)
[265.258947] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-pwrite
[265.301614] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[265.395810] [060/142] (772s left) kms_chamelium_edid (hdmi-edid-change-during-suspend)
[265.803702] Subtest hdmi-edid-change-during-suspend: SKIP (0.000s)
[266.117637] [061/142] (771s left) kms_ccs (pipe-b-random-ccs-data-y_tiled_gen12_rc_ccs)
[266.576864] Starting subtest: pipe-B-random-ccs-data-y_tiled_gen12_rc_ccs
[266.656495] Subtest pipe-B-random-ccs-data-y_tiled_gen12_rc_ccs: SKIP (0.000s)
[267.016947] [062/142] (770s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-gtt)
[267.429687] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-gtt
[267.484514] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[267.599771] [063/142] (770s left) kms_chamelium_hpd (vga-hpd-after-suspend)
[268.016608] Subtest vga-hpd-after-suspend: SKIP (0.000s)
[268.326531] [064/142] (769s left) perf (missing-sample-flags)
[268.707110] Starting subtest: missing-sample-flags
[268.726233] Subtest missing-sample-flags: SUCCESS (0.001s)
[268.838240] [065/142] (769s left) syncobj_timeline (invalid-query-bad-pad)
[269.067775] Starting subtest: invalid-query-bad-pad
[269.088073] Subtest invalid-query-bad-pad: SUCCESS (0.000s)
[269.183857] [066/142] (768s left) kms_pm_dc (dc5-dpms)
[270.501706] Starting subtest: dc5-dpms
[272.157914] Subtest dc5-dpms: SUCCESS (1.683s)
[272.366017] [067/142] (765s left) gem_pxp (create-regular-buffer)
[275.288683] Subtest create-regular-buffer: SKIP (0.000s)
[275.442954] [068/142] (762s left) kms_plane_scaling (plane-downscale-with-pixel-format-factor-0-75)
[275.747525] Starting subtest: plane-downscale-with-pixel-format-factor-0-75
[275.766684] Starting dynamic subtest: pipe-A-DP-1
[278.155144] Dynamic subtest pipe-A-DP-1: SUCCESS (2.414s)
[278.193594] Starting dynamic subtest: pipe-B-DP-1
[280.818768] Dynamic subtest pipe-B-DP-1: SUCCESS (2.642s)
[280.863635] Starting dynamic subtest: pipe-C-DP-1
[281.196483] Dynamic subtest pipe-C-DP-1: SUCCESS (0.384s)
[281.218254] Subtest plane-downscale-with-pixel-format-factor-0-75: SUCCESS (5.455s)
[281.636614] [069/142] (756s left) kms_psr_stress_test (invalidate-primary-flip-overlay)
[281.896855] Subtest invalidate-primary-flip-overlay: SKIP (0.000s)
[281.992783] [070/142] (756s left) kms_ccs (pipe-c-bad-rotation-90-4_tiled_mtl_rc_ccs)
[282.488267] Starting subtest: pipe-C-bad-rotation-90-4_tiled_mtl_rc_ccs
[282.529769] Subtest pipe-C-bad-rotation-90-4_tiled_mtl_rc_ccs: SKIP (0.000s)
[282.884459] [071/142] (755s left) kms_flip (flip-vs-absolute-wf_vblank-interruptible)
[283.205488] Starting subtest: flip-vs-absolute-wf_vblank-interruptible
[283.225529] Starting dynamic subtest: A-DP1
[294.147709] Dynamic subtest A-DP1: SUCCESS (10.782s)
[294.199484] Starting dynamic subtest: B-DP1
[304.688268] Dynamic subtest B-DP1: SUCCESS (10.710s)
[304.727424] Starting dynamic subtest: C-DP1
[315.414095] Dynamic subtest C-DP1: SUCCESS (10.716s)
[315.433556] Subtest flip-vs-absolute-wf_vblank-interruptible: SUCCESS (32.222s)
[315.859658] [072/142] (722s left) kms_ccs (pipe-b-bad-pixel-format-y_tiled_gen12_mc_ccs)
[316.283462] Starting subtest: pipe-B-bad-pixel-format-y_tiled_gen12_mc_ccs
[316.324049] Subtest pipe-B-bad-pixel-format-y_tiled_gen12_mc_ccs: SKIP (0.000s)
[316.720654] [073/142] (722s left) kms_ccs (pipe-a-bad-aux-stride-4_tiled_mtl_rc_ccs_cc)
[317.123764] Starting subtest: pipe-A-bad-aux-stride-4_tiled_mtl_rc_ccs_cc
[317.164563] Subtest pipe-A-bad-aux-stride-4_tiled_mtl_rc_ccs_cc: SKIP (0.000s)
[317.578317] [074/142] (721s left) gem_exec_reloc (basic-range-active)
[317.813582] Starting subtest: basic-range-active
[317.889836] Subtest basic-range-active: SUCCESS (0.098s)
[318.109619] [075/142] (720s left) kms_selftest (framebuffer)
[318.316907] Starting subtest: framebuffer
[318.359666] Subtest framebuffer: SKIP (0.004s)
[318.450230] [076/142] (720s left) vc4/vc4_perfmon (get-values-invalid-pointer)
[318.729305] Subtest get-values-invalid-pointer: SKIP (0.000s)
[318.820386] [077/142] (720s left) gem_sync (basic-each)
[319.229527] Starting subtest: basic-each
[321.422374] Subtest basic-each: SUCCESS (2.357s)
[321.654384] [078/142] (717s left) kms_ccs (pipe-b-crc-primary-rotation-180-4_tiled_dg2_rc_ccs)
[322.122606] Starting subtest: pipe-B-crc-primary-rotation-180-4_tiled_dg2_rc_ccs
[322.182282] Subtest pipe-B-crc-primary-rotation-180-4_tiled_dg2_rc_ccs: SKIP (0.002s)
[322.571860] [079/142] (716s left) kms_vblank (pipe-a-query-forked-busy)
[322.864885] Starting subtest: pipe-A-query-forked-busy
[325.335320] Subtest pipe-A-query-forked-busy: SUCCESS (2.460s)
[325.676977] [080/142] (713s left) kms_setmode (invalid-clone-single-crtc)
[325.915371] Starting subtest: invalid-clone-single-crtc
[325.974343] Subtest invalid-clone-single-crtc: SKIP (0.000s)
[326.066515] [081/142] (713s left) gem_ringfill (engines-basic)
[326.584439] Starting subtest: engines-basic
[326.605864] Starting dynamic subtest: rcs0
[326.626949] Dynamic subtest rcs0: SUCCESS (0.033s)
[326.671082] Starting dynamic subtest: bcs0
[326.691459] Dynamic subtest bcs0: SUCCESS (0.026s)
[326.730281] Starting dynamic subtest: vcs0
[326.749073] Dynamic subtest vcs0: SUCCESS (0.024s)
[326.787639] Starting dynamic subtest: vecs0
[326.809110] Dynamic subtest vecs0: SUCCESS (0.029s)
[326.830362] Subtest engines-basic: SUCCESS (0.122s)
[326.927715] [082/142] (712s left) v3d/v3d_submit_cl (bad-multisync-extension)
[327.198638] Subtest bad-multisync-extension: SKIP (0.000s)
[327.288363] [083/142] (712s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-fullscreen)
[327.639566] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-fullscreen
[327.679709] Subtest fbcpsr-1p-primscrn-spr-indfb-fullscreen: SKIP (0.000s)
[327.771758] [084/142] (712s left) gem_mmap (basic-small-bo)
[328.019351] Starting subtest: basic-small-bo
[330.678488] Subtest basic-small-bo: SUCCESS (2.696s)
[330.835357] [085/142] (709s left) syncobj_timeline (etime-multi-wait-all-for-submit-submitted-signaled)
[331.236166] Starting subtest: etime-multi-wait-all-for-submit-submitted-signaled
[331.344160] Subtest etime-multi-wait-all-for-submit-submitted-signaled: SUCCESS (0.106s)
[331.476825] [086/142] (708s left) kms_ccs (pipe-b-bad-aux-stride-y_tiled_gen12_mc_ccs)
[331.989563] Starting subtest: pipe-B-bad-aux-stride-y_tiled_gen12_mc_ccs
[332.030798] Subtest pipe-B-bad-aux-stride-y_tiled_gen12_mc_ccs: SKIP (0.000s)
[332.407622] [087/142] (707s left) kms_frontbuffer_tracking (psr-rgb101010-draw-mmap-wc)
[332.767225] Starting subtest: psr-rgb101010-draw-mmap-wc
[332.807096] Subtest psr-rgb101010-draw-mmap-wc: SKIP (0.000s)
[332.906938] [088/142] (707s left) kms_ccs (pipe-d-crc-primary-basic-4_tiled_mtl_rc_ccs_cc)
[333.445030] Subtest pipe-D-crc-primary-basic-4_tiled_mtl_rc_ccs_cc: SKIP (0.000s)
[333.771923] [089/142] (706s left) gem_exec_schedule (u-semaphore-user)
[334.172565] Starting subtest: u-semaphore-user
[334.191940] Subtest u-semaphore-user: SUCCESS (0.025s)
[334.443529] [090/142] (705s left) kms_vblank (pipe-b-query-forked-busy-hang)
[334.743788] Starting subtest: pipe-B-query-forked-busy-hang
[342.148877] Subtest pipe-B-query-forked-busy-hang: SUCCESS (7.406s)
[342.517016] [091/142] (697s left) kms_plane_scaling (planes-unity-scaling-downscale-factor-0-5)
[342.822166] Starting subtest: planes-unity-scaling-downscale-factor-0-5
[342.841731] Starting dynamic subtest: pipe-A-DP-1
[343.174070] Dynamic subtest pipe-A-DP-1: SUCCESS (0.352s)
[343.233009] Starting dynamic subtest: pipe-B-DP-1
[343.593890] Dynamic subtest pipe-B-DP-1: SUCCESS (0.399s)
[343.637183] Starting dynamic subtest: pipe-C-DP-1
[343.970177] Dynamic subtest pipe-C-DP-1: SUCCESS (0.370s)
[343.990708] Subtest planes-unity-scaling-downscale-factor-0-5: SUCCESS (1.137s)
[344.382493] [092/142] (696s left) perf (enable-disable)
[344.756680] Starting subtest: enable-disable
[344.777598] Starting dynamic subtest: 0-rcs0
[347.925364] Dynamic subtest 0-rcs0: SUCCESS (2.994s)
[347.947044] Subtest enable-disable: SUCCESS (2.997s)
[348.062218] [093/142] (692s left) gem_eio (kms)
[348.414069] Starting subtest: kms
[360.733950] Subtest kms: SUCCESS (12.340s)
[361.155379] [094/142] (679s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-32bpp-yftileccs-downscaling)
[361.473957] Starting subtest: flip-32bpp-yftile-to-32bpp-yftileccs-downscaling
[361.494717] Starting dynamic subtest: pipe-A-valid-mode
[362.153005] Dynamic subtest pipe-A-valid-mode: SUCCESS (0.684s)
[362.171778] Subtest flip-32bpp-yftile-to-32bpp-yftileccs-downscaling: SUCCESS (0.688s)
[362.514281] [095/142] (678s left) i915_module_load (load)
[362.727775] Starting subtest: load
[362.770763] Subtest load: SKIP (0.003s)
[362.868637] [096/142] (678s left) kms_big_fb (4-tiled-8bpp-rotate-0)
[363.213145] Starting subtest: 4-tiled-8bpp-rotate-0
[363.262354] Subtest 4-tiled-8bpp-rotate-0: SKIP (0.000s)
[363.361827] [097/142] (677s left) kms_frontbuffer_tracking (fbcpsr-tiling-y)
[363.715800] Starting subtest: fbcpsr-tiling-y
[363.757688] Subtest fbcpsr-tiling-y: SKIP (0.000s)
[363.854803] [098/142] (677s left) gem_exec_fence (syncobj-import)
[364.557485] Starting subtest: syncobj-import
[364.584317] Subtest syncobj-import: SUCCESS (0.007s)
[364.942683] [099/142] (676s left) gem_exec_schedule (fairslice-all)
[365.386614] Starting subtest: fairslice-all
[367.315553] Subtest fairslice-all: SUCCESS (2.116s)
[367.693655] [100/142] (673s left) v3d/v3d_perfmon (get-values-invalid-perfmon)
[368.016129] Subtest get-values-invalid-perfmon: SKIP (0.000s)
[368.132557] [101/142] (673s left) gem_render_copy (y-tiled-ccs-to-yf-tiled)
[368.370714] Starting subtest: y-tiled-ccs-to-yf-tiled
[368.393240] Starting dynamic subtest: smem
[368.770453] Dynamic subtest smem: SUCCESS (0.406s)
[368.791511] Subtest y-tiled-ccs-to-yf-tiled: SUCCESS (0.409s)
[369.016825] [102/142] (672s left) gem_exec_params (secure-non-master)
[369.234930] Starting subtest: secure-non-master
[369.275455] Subtest secure-non-master: SKIP (0.000s)
[369.374877] [103/142] (672s left) kms_addfb_basic (addfb25-x-tiled-legacy)
[369.608693] Starting subtest: addfb25-x-tiled-legacy
[369.629600] Subtest addfb25-x-tiled-legacy: SUCCESS (0.000s)
[369.808424] [104/142] (671s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-mmap-wc)
[370.178041] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-mmap-wc
[370.215588] Subtest fbc-2p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[370.312634] [105/142] (671s left) kms_flip (dpms-vs-vblank-race)
[370.637716] Starting subtest: dpms-vs-vblank-race
[370.658262] Starting dynamic subtest: A-DP1
[374.904565] Dynamic subtest A-DP1: SUCCESS (4.279s)
[374.948640] Starting dynamic subtest: B-DP1
[379.149296] Dynamic subtest B-DP1: SUCCESS (4.244s)
[379.190382] Starting dynamic subtest: C-DP1
[383.324145] Dynamic subtest C-DP1: SUCCESS (4.178s)
[383.352953] Subtest dpms-vs-vblank-race: SUCCESS (12.716s)
[383.739468] [106/142] (658s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite)
[384.169584] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite
[384.219798] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[384.333474] [107/142] (657s left) kms_big_fb (x-tiled-8bpp-rotate-180)
[384.915935] Starting subtest: x-tiled-8bpp-rotate-180
[387.543237] Subtest x-tiled-8bpp-rotate-180: SUCCESS (2.877s)
[387.828631] [108/142] (654s left) kms_vblank (pipe-d-ts-continuation-suspend)
[388.158193] Subtest pipe-D-ts-continuation-suspend: SKIP (0.000s)
[388.369907] [109/142] (653s left) kms_plane_cursor (primary)
[388.691353] Starting subtest: primary
[388.729320] Starting dynamic subtest: pipe-A-DP-1-size-64
[391.103494] Dynamic subtest pipe-A-DP-1-size-64: SUCCESS (2.415s)
[391.174914] Starting dynamic subtest: pipe-A-DP-1-size-128
[393.555984] Dynamic subtest pipe-A-DP-1-size-128: SUCCESS (2.415s)
[393.624435] Starting dynamic subtest: pipe-A-DP-1-size-256
[396.003598] Dynamic subtest pipe-A-DP-1-size-256: SUCCESS (2.415s)
[396.180719] Starting dynamic subtest: pipe-B-DP-1-size-64
[398.783436] Dynamic subtest pipe-B-DP-1-size-64: SUCCESS (2.647s)
[398.853211] Starting dynamic subtest: pipe-B-DP-1-size-128
[401.233371] Dynamic subtest pipe-B-DP-1-size-128: SUCCESS (2.415s)
[401.304241] Starting dynamic subtest: pipe-B-DP-1-size-256
[403.685836] Dynamic subtest pipe-B-DP-1-size-256: SUCCESS (2.415s)
[403.868848] Starting dynamic subtest: pipe-C-DP-1-size-64
[406.487574] Dynamic subtest pipe-C-DP-1-size-64: SUCCESS (2.657s)
[406.564223] Starting dynamic subtest: pipe-C-DP-1-size-128
[408.929611] Dynamic subtest pipe-C-DP-1-size-128: SUCCESS (2.415s)
[408.997888] Starting dynamic subtest: pipe-C-DP-1-size-256
[411.382165] Dynamic subtest pipe-C-DP-1-size-256: SUCCESS (2.415s)
[411.524411] Subtest primary: SUCCESS (22.822s)
[411.865454] [110/142] (630s left) kms_hdmi_inject (inject-audio)
[412.110662] Subtest inject-audio: SKIP (0.000s)
[412.214481] [111/142] (630s left) kms_rotation_crc (primary-rotation-90)
[412.529015] Starting subtest: primary-rotation-90
[418.761224] Subtest primary-rotation-90: SUCCESS (6.247s)
[419.232659] [112/142] (623s left) kms_chamelium_color (ctm-0-25)
[419.564139] Subtest ctm-0-25: SKIP (0.000s)
[419.664478] [113/142] (622s left) gem_spin_batch (legacy-resubmit-new)
[419.903639] Starting subtest: legacy-resubmit-new
[419.925032] Starting dynamic subtest: default
[419.944794] Dynamic subtest default: SUCCESS (0.008s)
[419.987492] Starting dynamic subtest: render
[420.006628] Dynamic subtest render: SUCCESS (0.007s)
[420.048351] Starting dynamic subtest: bsd
[420.070220] Dynamic subtest bsd: SUCCESS (0.007s)
[420.114851] Starting dynamic subtest: bsd1
[420.135910] Dynamic subtest bsd1: SUCCESS (0.009s)
[420.181069] Starting dynamic subtest: blt
[420.200342] Dynamic subtest blt: SUCCESS (0.008s)
[420.242376] Starting dynamic subtest: vebox
[420.261461] Dynamic subtest vebox: SUCCESS (0.007s)
[420.280709] Subtest legacy-resubmit-new: SUCCESS (0.067s)
[420.382784] [114/142] (622s left) gem_ctx_shared (create-shared-gtt)
[420.623210] Starting subtest: create-shared-gtt
[422.941463] Subtest create-shared-gtt: SUCCESS (2.152s)
[423.035006] [115/142] (619s left) sysfs_timeslice_duration (idempotent)
[423.275465] Starting subtest: idempotent
[423.293940] Starting dynamic subtest: vecs0
[423.312633] Dynamic subtest vecs0: SUCCESS (0.001s)
[423.357079] Starting dynamic subtest: vcs0
[423.378823] Dynamic subtest vcs0: SUCCESS (0.001s)
[423.422738] Starting dynamic subtest: bcs0
[423.443578] Dynamic subtest bcs0: SUCCESS (0.001s)
[423.484997] Starting dynamic subtest: rcs0
[423.503782] Dynamic subtest rcs0: SUCCESS (0.001s)
[423.522425] Subtest idempotent: SUCCESS (0.018s)
[423.621403] [116/142] (619s left) gem_ctx_engines (execute-allforone)
[423.858662] Starting subtest: execute-allforone
[423.880672] Subtest execute-allforone: SUCCESS (0.016s)
[424.124251] [117/142] (618s left) gem_exec_suspend (basic-s0)
[424.361514] Starting subtest: basic-S0
[424.380611] Starting dynamic subtest: smem
[444.333904] Dynamic subtest smem: SUCCESS (19.969s)
[444.352863] Subtest basic-S0: SUCCESS (19.972s)
[447.067780] [118/142] (598s left) kms_flip (flip-vs-expired-vblank)
[447.366101] Starting subtest: flip-vs-expired-vblank
[447.387581] Starting dynamic subtest: A-DP1
[458.049815] Dynamic subtest A-DP1: SUCCESS (10.517s)
[458.096906] Starting dynamic subtest: B-DP1
[468.503510] Dynamic subtest B-DP1: SUCCESS (10.450s)
[468.548453] Starting dynamic subtest: C-DP1
[478.770038] Dynamic subtest C-DP1: SUCCESS (10.437s)
[478.789276] Subtest flip-vs-expired-vblank: SUCCESS (31.418s)
[479.226235] [119/142] (566s left) gem_exec_fence (basic-busy)
[479.604571] Starting subtest: basic-busy
[479.623554] Starting dynamic subtest: rcs0
[479.665807] Dynamic subtest rcs0: SUCCESS (0.038s)
[479.711146] Starting dynamic subtest: bcs0
[479.752722] Dynamic subtest bcs0: SUCCESS (0.025s)
[479.794893] Starting dynamic subtest: vcs0
[479.832999] Dynamic subtest vcs0: SUCCESS (0.024s)
[479.879030] Starting dynamic subtest: vecs0
[479.922151] Dynamic subtest vecs0: SUCCESS (0.027s)
[479.942925] Subtest basic-busy: SUCCESS (0.125s)
[480.410636] [120/142] (565s left) kms_atomic (plane-primary-overlay-mutable-zpos)
[480.834586] Starting subtest: plane-primary-overlay-mutable-zpos
[480.890614] Subtest plane-primary-overlay-mutable-zpos: SKIP (0.000s)
[481.286998] [121/142] (564s left) kms_frontbuffer_tracking (fbc-1p-offscren-pri-indfb-draw-render)
[481.680511] Starting subtest: fbc-1p-offscren-pri-indfb-draw-render
[483.518551] Subtest fbc-1p-offscren-pri-indfb-draw-render: SUCCESS (1.920s)
[483.682212] [122/142] (562s left) gen9_exec_parse (bb-start-far)
[483.907613] Starting subtest: bb-start-far
[483.926636] Subtest bb-start-far: SUCCESS (0.005s)
[484.172019] [123/142] (561s left) prime_mmap (test_invalid_sync_flags)
[484.406847] Starting subtest: test_invalid_sync_flags
[484.428555] Starting dynamic subtest: test_invalid_sync_flags-smem
[484.450163] Dynamic subtest test_invalid_sync_flags-smem: SUCCESS (0.000s)
[484.470821] Subtest test_invalid_sync_flags: SUCCESS (0.003s)
[484.567996] [124/142] (561s left) gem_eio (execbuf)
[484.822053] Starting subtest: execbuf
[484.843301] Subtest execbuf: SUCCESS (0.044s)
[485.052579] [125/142] (561s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-blt)
[485.410375] Starting subtest: psr-1p-primscrn-pri-indfb-draw-blt
[485.453366] Subtest psr-1p-primscrn-pri-indfb-draw-blt: SKIP (0.000s)
[485.554228] [126/142] (560s left) kms_ccs (pipe-d-bad-aux-stride-4_tiled_mtl_mc_ccs)
[486.110396] Subtest pipe-D-bad-aux-stride-4_tiled_mtl_mc_ccs: SKIP (0.000s)
[486.441534] [127/142] (559s left) kms_ccs (pipe-d-crc-primary-rotation-180-4_tiled_mtl_rc_ccs)
[486.978854] Subtest pipe-D-crc-primary-rotation-180-4_tiled_mtl_rc_ccs: SKIP (0.000s)
[487.319870] [128/142] (559s left) kms_frontbuffer_tracking (fbcpsr-1p-offscren-pri-shrfb-draw-mmap-cpu)
[487.681180] Starting subtest: fbcpsr-1p-offscren-pri-shrfb-draw-mmap-cpu
[487.723599] Subtest fbcpsr-1p-offscren-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[487.821266] [129/142] (558s left) i915_pm_rpm (gem-execbuf-stress-pc8)
[489.581018] Starting subtest: gem-execbuf-stress-pc8
[489.642981] Subtest gem-execbuf-stress-pc8: SKIP (0.040s)
[490.065990] [130/142] (556s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-onoff)
[490.429054] Starting subtest: fbc-1p-primscrn-cur-indfb-onoff
[492.777582] Subtest fbc-1p-primscrn-cur-indfb-onoff: SUCCESS (2.413s)
[492.954219] [131/142] (553s left) i915_pm_rpm (system-suspend-modeset)
[494.734256] Starting subtest: system-suspend-modeset
[512.462300] Subtest system-suspend-modeset: SUCCESS (2.165s)
[519.095660] [132/142] (549s left) perf_pmu (busy-idle)
[519.340511] Starting subtest: busy-idle
[519.362082] Starting dynamic subtest: rcs0
[519.969615] Dynamic subtest rcs0: SUCCESS (0.645s)
[520.012467] Starting dynamic subtest: bcs0
[520.612201] Dynamic subtest bcs0: SUCCESS (0.635s)
[520.657149] Starting dynamic subtest: vcs0
[521.248454] Dynamic subtest vcs0: SUCCESS (0.636s)
[521.290535] Starting dynamic subtest: vecs0
[521.889258] Dynamic subtest vecs0: SUCCESS (0.637s)
[521.910379] Subtest busy-idle: SUCCESS (2.564s)
[522.027068] [133/142] (546s left) syncobj_timeline (etime-single-wait-for-submit-unsubmitted)
[522.239890] Starting subtest: etime-single-wait-for-submit-unsubmitted
[522.309267] Subtest etime-single-wait-for-submit-unsubmitted: SUCCESS (0.102s)
[522.440199] [134/142] (546s left) gem_flink_race (flink_name)
[522.648592] Starting subtest: flink_name
[528.199292] Subtest flink_name: SUCCESS (5.374s)
[528.315209] [135/142] (540s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-mmap-wc)
[528.711079] Starting subtest: fbcpsr-rgb565-draw-mmap-wc
[528.762483] Subtest fbcpsr-rgb565-draw-mmap-wc: SKIP (0.000s)
[528.876743] [136/142] (539s left) api_intel_allocator (default-alignment)
[529.129439] Starting subtest: default-alignment
[529.148286] Subtest default-alignment: SUCCESS (0.003s)
[529.255352] [137/142] (539s left) gem_ctx_persistence (engines-mixed)
[529.487890] Starting subtest: engines-mixed
[529.509442] Starting dynamic subtest: rcs0
[529.531101] Dynamic subtest rcs0: SUCCESS (0.056s)
[529.577960] Starting dynamic subtest: bcs0
[529.598705] Dynamic subtest bcs0: SUCCESS (0.052s)
[529.640894] Starting dynamic subtest: vcs0
[529.659710] Dynamic subtest vcs0: SUCCESS (0.056s)
[529.701948] Starting dynamic subtest: vecs0
[529.720688] Dynamic subtest vecs0: SUCCESS (0.050s)
[529.742211] Subtest engines-mixed: SUCCESS (0.226s)
[529.843437] [138/142] (539s left) perf (oa-exponents)
[530.160070] Starting subtest: oa-exponents
[530.179073] Starting dynamic subtest: 0-rcs0
[534.282019] Dynamic subtest 0-rcs0: SUCCESS (4.148s)
[534.306243] Subtest oa-exponents: SUCCESS (4.151s)
[534.426720] [139/142] (534s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-render)
[534.791827] Starting subtest: psr-2p-primscrn-spr-indfb-draw-render
[534.834485] Subtest psr-2p-primscrn-spr-indfb-draw-render: SKIP (0.000s)
[534.934289] [140/142] (534s left) kms_big_fb (linear-32bpp-rotate-0)
[535.274827] Starting subtest: linear-32bpp-rotate-0
[541.131269] Subtest linear-32bpp-rotate-0: SUCCESS (5.877s)
[541.706461] [141/142] (527s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-mmap-gtt)
[542.070002] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-mmap-gtt
[544.130562] Subtest fbc-1p-primscrn-spr-indfb-draw-mmap-gtt: SUCCESS (2.139s)
[544.303623] [142/142] (525s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling)
[544.515021] Starting subtest: addfb25-framebuffer-vs-set-tiling
[544.534006] Subtest addfb25-framebuffer-vs-set-tiling: SUCCESS (0.000s)
[544.699123] Closing watchdogs
Done.