[60.402429] Initializing watchdogs
[60.402741]   /dev/watchdog0
[60.418096] [001/141] (960s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-gtt)
[60.971070] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-gtt
[60.973832] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[61.064427] [002/141] (959s left) i915_pm_rpm (modeset-lpsp-stress)
[63.041330] Starting subtest: modeset-lpsp-stress
[63.458522] Subtest modeset-lpsp-stress: SKIP (0.415s)
[63.935484] [003/141] (957s left) perf_pmu (all-busy-idle-check-all)
[64.156765] Starting subtest: all-busy-idle-check-all
[64.803341] Subtest all-busy-idle-check-all: SUCCESS (0.646s)
[64.886586] [004/141] (956s left) kms_multipipe_modeset (basic-max-pipe-crc-check)
[65.239391] Starting subtest: basic-max-pipe-crc-check
[65.241992] Subtest basic-max-pipe-crc-check: SKIP (0.000s)
[65.300997] [005/141] (955s left) kms_vblank (pipe-d-wait-forked-hang)
[65.628210] Subtest pipe-D-wait-forked-hang: SKIP (0.000s)
[65.701340] [006/141] (955s left) gem_exec_basic (basic)
[65.918082] Starting subtest: basic
[65.919585] Starting dynamic subtest: rcs0-smem
[65.924253] Dynamic subtest rcs0-smem: SUCCESS (0.005s)
[65.941518] Starting dynamic subtest: bcs0-smem
[65.942798] Dynamic subtest bcs0-smem: SUCCESS (0.003s)
[65.956494] Starting dynamic subtest: vcs0-smem
[65.957775] Dynamic subtest vcs0-smem: SUCCESS (0.001s)
[65.971628] Starting dynamic subtest: vecs0-smem
[65.972952] Dynamic subtest vecs0-smem: SUCCESS (0.002s)
[65.974194] Subtest basic: SUCCESS (0.014s)
[66.151338] [007/141] (954s left) kms_ccs (pipe-c-bad-pixel-format-y_tiled_ccs)
[66.760769] Starting subtest: pipe-C-bad-pixel-format-y_tiled_ccs
[66.763385] Subtest pipe-C-bad-pixel-format-y_tiled_ccs: SKIP (0.000s)
[67.182241] [008/141] (953s left) kms_ccs (pipe-b-random-ccs-data-y_tiled_gen12_rc_ccs)
[67.723664] Starting subtest: pipe-B-random-ccs-data-y_tiled_gen12_rc_ccs
[67.727702] Subtest pipe-B-random-ccs-data-y_tiled_gen12_rc_ccs: SKIP (0.000s)
[68.221056] [009/141] (952s left) kms_ccs (pipe-a-bad-pixel-format-4_tiled_mtl_mc_ccs)
[68.530889] Starting subtest: pipe-A-bad-pixel-format-4_tiled_mtl_mc_ccs
[68.535044] Subtest pipe-A-bad-pixel-format-4_tiled_mtl_mc_ccs: SKIP (0.000s)
[69.250375] [010/141] (951s left) kms_ccs (pipe-d-bad-rotation-90-y_tiled_gen12_rc_ccs_cc)
[69.998294] Subtest pipe-D-bad-rotation-90-y_tiled_gen12_rc_ccs_cc: SKIP (0.000s)
[70.306734] [011/141] (950s left) kms_hdr (static-toggle)
[70.610316] Starting subtest: static-toggle
[70.612877] Subtest static-toggle: SKIP (0.000s)
[70.689381] [012/141] (950s left) gem_exec_flush (basic-batch-kernel-default-wb)
[70.922216] Starting subtest: basic-batch-kernel-default-wb
[76.852802] Subtest basic-batch-kernel-default-wb: SUCCESS (5.930s)
[77.056490] [013/141] (944s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-mmap-wc)
[77.366407] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-mmap-wc
[77.368853] Subtest psr-2p-scndscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[77.457207] [014/141] (943s left) syncobj_timeline (etime-multi-wait-all-for-submit-submitted)
[77.664640] Starting subtest: etime-multi-wait-all-for-submit-submitted
[77.770427] Subtest etime-multi-wait-all-for-submit-submitted: SUCCESS (0.106s)
[77.855780] [015/141] (943s left) kms_psr (cursor_render)
[78.067895] Subtest cursor_render: SKIP (0.000s)
[78.123622] [016/141] (943s left) kms_ccs (pipe-b-crc-primary-rotation-180-y_tiled_gen12_mc_ccs)
[78.651364] Starting subtest: pipe-B-crc-primary-rotation-180-y_tiled_gen12_mc_ccs
[78.655390] Subtest pipe-B-crc-primary-rotation-180-y_tiled_gen12_mc_ccs: SKIP (0.001s)
[79.156418] [017/141] (942s left) kms_rotation_crc (primary-4-tiled-reflect-x-180)
[79.460189] Starting subtest: primary-4-tiled-reflect-x-180
[79.462876] Subtest primary-4-tiled-reflect-x-180: SKIP (0.003s)
[79.539644] [018/141] (941s left) kms_frontbuffer_tracking (fbcpsr-1p-rte)
[79.848760] Starting subtest: fbcpsr-1p-rte
[79.851225] Subtest fbcpsr-1p-rte: SKIP (0.000s)
[79.939715] [019/141] (941s left) kms_flip (2x-absolute-wf_vblank)
[80.230490] Starting subtest: 2x-absolute-wf_vblank
[80.233250] Subtest 2x-absolute-wf_vblank: SKIP (0.003s)
[80.340461] [020/141] (941s left) kms_chamelium_hpd (vga-hpd-for-each-pipe)
[80.739253] Subtest vga-hpd-for-each-pipe: SKIP (0.000s)
[81.021610] [021/141] (940s left) kms_async_flips (alternate-sync-async-flip)
[81.327516] Starting subtest: alternate-sync-async-flip
[81.742465] Starting dynamic subtest: pipe-A-DP-1
[84.103632] Dynamic subtest pipe-A-DP-1: SUCCESS (2.360s)
[84.578508] Starting dynamic subtest: pipe-B-DP-1
[86.874427] Dynamic subtest pipe-B-DP-1: SUCCESS (2.308s)
[87.245119] Starting dynamic subtest: pipe-C-DP-1
[89.495342] Dynamic subtest pipe-C-DP-1: SUCCESS (2.262s)
[89.497258] Subtest alternate-sync-async-flip: SUCCESS (8.171s)
[90.043184] [022/141] (931s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-shrfb-plflip-blt)
[90.358120] Starting subtest: fbcpsr-2p-primscrn-shrfb-plflip-blt
[90.361029] Subtest fbcpsr-2p-primscrn-shrfb-plflip-blt: SKIP (0.000s)
[90.443069] [023/141] (931s left) kms_pipe_b_c_ivb (enable-pipe-c-while-b-has-3-lanes)
[90.643826] Subtest enable-pipe-C-while-B-has-3-lanes: SKIP (0.000s)
[90.692495] [024/141] (930s left) vgem_basic (second-client)
[90.976054] Starting subtest: second-client
[91.023734] Subtest second-client: SUCCESS (0.049s)
[91.093478] [025/141] (930s left) kms_big_fb (4-tiled-8bpp-rotate-270)
[91.417362] Starting subtest: 4-tiled-8bpp-rotate-270
[91.420243] Subtest 4-tiled-8bpp-rotate-270: SKIP (0.000s)
[91.510966] [026/141] (930s left) i915_pm_rps (min-max-config-loaded)
[91.717527] Starting subtest: min-max-config-loaded
[92.097332] Subtest min-max-config-loaded: SUCCESS (0.380s)
[92.195181] [027/141] (929s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-mmap-cpu)
[92.581843] Starting subtest: psr-2p-primscrn-spr-indfb-draw-mmap-cpu
[92.585080] Subtest psr-2p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[92.680497] [028/141] (929s left) prime_vgem (basic-blt)
[92.937262] Starting subtest: basic-blt
[93.006453] Subtest basic-blt: SUCCESS (0.067s)
[93.116056] [029/141] (928s left) gem_exec_reloc (basic-scanout)
[93.430664] Starting subtest: basic-scanout
[93.432153] Starting dynamic subtest: rcs0
[93.690900] Dynamic subtest rcs0: SUCCESS (0.260s)
[93.708136] Starting dynamic subtest: bcs0
[93.858550] Dynamic subtest bcs0: SUCCESS (0.168s)
[93.875617] Starting dynamic subtest: vcs0
[94.023315] Dynamic subtest vcs0: SUCCESS (0.165s)
[94.039347] Starting dynamic subtest: vecs0
[94.190730] Dynamic subtest vecs0: SUCCESS (0.167s)
[94.192788] Subtest basic-scanout: SUCCESS (0.761s)
[94.296293] [030/141] (927s left) kms_rotation_crc (primary-y-tiled-reflect-x-0)
[94.588776] Starting subtest: primary-y-tiled-reflect-x-0
[94.591416] Subtest primary-y-tiled-reflect-x-0: SKIP (0.003s)
[94.677956] [031/141] (927s left) kms_dsc (dsc-basic)
[94.988128] Subtest dsc-basic: SKIP (0.000s)
[95.043103] [032/141] (926s left) vc4/vc4_purgeable_bo (access-purged-bo-mem)
[95.292668] Subtest access-purged-bo-mem: SKIP (0.000s)
[95.360507] [033/141] (926s left) kms_lease (lease_invalid_connector)
[95.658335] Starting subtest: lease_invalid_connector
[95.659644] Starting dynamic subtest: pipe-A-DP-1
[95.660892] Dynamic subtest pipe-A-DP-1: SUCCESS (0.000s)
[95.676187] Starting dynamic subtest: pipe-B-DP-1
[95.677427] Dynamic subtest pipe-B-DP-1: SUCCESS (0.000s)
[95.692392] Starting dynamic subtest: pipe-C-DP-1
[95.693673] Dynamic subtest pipe-C-DP-1: SUCCESS (0.000s)
[95.694865] Subtest lease_invalid_connector: SUCCESS (0.007s)
[95.744060] [034/141] (926s left) kms_ccs (pipe-d-crc-sprite-planes-basic-y_tiled_gen12_mc_ccs)
[96.461105] Subtest pipe-D-crc-sprite-planes-basic-y_tiled_gen12_mc_ccs: SKIP (0.000s)
[96.766177] [035/141] (925s left) kms_flip_scaled_crc (flip-32bpp-yftileccs-to-64bpp-yftile-downscaling)
[97.067407] Starting subtest: flip-32bpp-yftileccs-to-64bpp-yftile-downscaling
[97.069886] Starting dynamic subtest: pipe-A-valid-mode
[97.196142] Dynamic subtest pipe-A-valid-mode: SKIP (0.127s)
[97.200575] Subtest flip-32bpp-yftileccs-to-64bpp-yftile-downscaling: SKIP (0.130s)
[97.527124] [036/141] (924s left) perf_pmu (invalid-init)
[97.732754] Starting subtest: invalid-init
[97.734537] Subtest invalid-init: SUCCESS (0.002s)
[97.826739] [037/141] (924s left) gem_mmap_wc (fault-concurrent)
[98.025364] Starting subtest: fault-concurrent
[99.695764] Subtest fault-concurrent: SUCCESS (1.671s)
[99.776138] [038/141] (922s left) syncobj_basic (bad-handle-to-fd)
[99.976735] Starting subtest: bad-handle-to-fd
[99.978391] Subtest bad-handle-to-fd: SUCCESS (0.000s)
[100.060770] [039/141] (922s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-onoff)
[100.371515] Starting subtest: psr-1p-primscrn-spr-indfb-onoff
[100.374153] Subtest psr-1p-primscrn-spr-indfb-onoff: SKIP (0.000s)
[100.476738] [040/141] (921s left) kms_vblank (pipe-a-wait-forked)
[100.779450] Starting subtest: pipe-A-wait-forked
[103.123893] Subtest pipe-A-wait-forked: SUCCESS (2.341s)
[103.451373] [041/141] (918s left) syncobj_wait (invalid-wait-bad-flags)
[103.654856] Starting subtest: invalid-wait-bad-flags
[103.656761] Subtest invalid-wait-bad-flags: SUCCESS (0.000s)
[103.733695] [042/141] (918s left) dumb_buffer (create-clear)
[103.928767] Starting subtest: create-clear
[147.080502] Subtest create-clear: SUCCESS (43.150s)
[147.583961] [043/141] (874s left) gem_watchdog (default-virtual)
[147.797302] Starting subtest: default-virtual
[148.831171] Subtest default-virtual: SUCCESS (1.033s)
[148.899490] [044/141] (873s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-mmap-wc)
[149.207549] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-mmap-wc
[149.210128] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[149.300742] [045/141] (873s left) syncobj_basic (bad-flags-handle-to-fd)
[149.501609] Starting subtest: bad-flags-handle-to-fd
[149.503149] Subtest bad-flags-handle-to-fd: SUCCESS (0.000s)
[149.584077] [046/141] (872s left) api_intel_bb (destroy-bb)
[149.784991] Starting subtest: destroy-bb
[149.809079] Subtest destroy-bb: SUCCESS (0.026s)
[149.921510] [047/141] (872s left) gem_exec_whisper (basic-fds-priority-all)
[150.146705] Starting subtest: basic-fds-priority-all
[174.259612] Subtest basic-fds-priority-all: SUCCESS (24.111s)
[174.468810] [048/141] (848s left) kms_getfb (getfb-handle-closed)
[174.665414] Starting subtest: getfb-handle-closed
[174.666904] Subtest getfb-handle-closed: SUCCESS (0.000s)
[174.767340] [049/141] (847s left) gem_render_copy (x-tiled-to-vebox-y-tiled)
[174.984148] Starting subtest: x-tiled-to-vebox-y-tiled
[174.986576] Subtest x-tiled-to-vebox-y-tiled: SKIP (0.000s)
[175.184331] [050/141] (847s left) gem_set_tiling_vs_gtt
[175.767776] [051/141] (846s left) i915_pm_rc6_residency (rc6-idle)
[175.963748] Starting subtest: rc6-idle
[175.972605] Starting dynamic subtest: rcs0
[188.241739] Dynamic subtest rcs0: SUCCESS (12.268s)
[188.258418] Starting dynamic subtest: bcs0
[200.514867] Dynamic subtest bcs0: SUCCESS (12.274s)
[200.531673] Starting dynamic subtest: vcs0
[212.794359] Dynamic subtest vcs0: SUCCESS (12.278s)
[212.811026] Starting dynamic subtest: vecs0
[225.060765] Dynamic subtest vecs0: SUCCESS (12.267s)
[225.062851] Subtest rc6-idle: SUCCESS (49.098s)
[225.353151] [052/141] (797s left) gem_mmap_gtt (cpuset-medium-copy)
[225.551691] Starting subtest: cpuset-medium-copy
[237.635650] Subtest cpuset-medium-copy: SUCCESS (12.083s)
[237.768929] [053/141] (784s left) syncobj_timeline (invalid-multi-wait-all-available-unsubmitted-submitted)
[238.108333] Starting subtest: invalid-multi-wait-all-available-unsubmitted-submitted
[238.110214] Subtest invalid-multi-wait-all-available-unsubmitted-submitted: SUCCESS (0.002s)
[238.202196] [054/141] (784s left) kms_psr2_sf (cursor-plane-move-continuous-exceed-sf)
[238.403505] Subtest cursor-plane-move-continuous-exceed-sf: SKIP (0.000s)
[238.451195] [055/141] (784s left) syncobj_wait (multi-wait-for-submit-unsubmitted-signaled)
[238.648642] Starting subtest: multi-wait-for-submit-unsubmitted-signaled
[238.650375] Subtest multi-wait-for-submit-unsubmitted-signaled: SUCCESS (0.001s)
[238.734678] [056/141] (784s left) kms_plane_scaling (plane-downscale-with-rotation-factor-0-5)
[239.038917] Starting subtest: plane-downscale-with-rotation-factor-0-5
[239.042425] Starting dynamic subtest: pipe-A-DP-1
[239.393869] Dynamic subtest pipe-A-DP-1: SKIP (0.348s)
[239.412085] Starting dynamic subtest: pipe-B-DP-1
[239.771356] Dynamic subtest pipe-B-DP-1: SKIP (0.377s)
[239.789484] Starting dynamic subtest: pipe-C-DP-1
[240.141389] Dynamic subtest pipe-C-DP-1: SKIP (0.366s)
[240.148070] Subtest plane-downscale-with-rotation-factor-0-5: SKIP (1.102s)
[240.534634] [057/141] (782s left) kms_chamelium_hpd (hdmi-hpd-after-suspend)
[240.927350] Subtest hdmi-hpd-after-suspend: SKIP (0.000s)
[241.211496] [058/141] (781s left) gem_spin_batch (resubmit)
[241.433269] Starting subtest: resubmit
[241.434693] Starting dynamic subtest: rcs0
[241.443398] Dynamic subtest rcs0: SUCCESS (0.009s)
[241.471303] Starting dynamic subtest: bcs0
[241.472641] Dynamic subtest bcs0: SUCCESS (0.009s)
[241.490302] Starting dynamic subtest: vcs0
[241.491601] Dynamic subtest vcs0: SUCCESS (0.006s)
[241.509036] Starting dynamic subtest: vecs0
[241.510303] Dynamic subtest vecs0: SUCCESS (0.006s)
[241.511490] Subtest resubmit: SUCCESS (0.033s)
[241.690763] [059/141] (781s left) kms_dither (fb-8bpc-vs-panel-6bpc)
[241.987553] Starting subtest: FB-8BPC-Vs-Panel-6BPC
[241.989079] Starting dynamic subtest: pipe-A-DP-1
[242.427118] Dynamic subtest pipe-A-DP-1: SUCCESS (0.441s)
[242.428433] Subtest FB-8BPC-Vs-Panel-6BPC: SUCCESS (0.442s)
[242.749309] [060/141] (780s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-pwrite)
[243.054192] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-pwrite
[243.056668] Subtest fbc-2p-scndscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[243.149258] [061/141] (779s left) kms_ccs (pipe-a-crc-primary-rotation-180-4_tiled_dg2_rc_ccs_cc)
[243.567164] Starting subtest: pipe-A-crc-primary-rotation-180-4_tiled_dg2_rc_ccs_cc
[243.570110] Subtest pipe-A-crc-primary-rotation-180-4_tiled_dg2_rc_ccs_cc: SKIP (0.001s)
[244.172760] [062/141] (778s left) gem_exec_reloc (basic-write-read-noreloc)
[244.385495] Starting subtest: basic-write-read-noreloc
[244.393944] Subtest basic-write-read-noreloc: SUCCESS (0.008s)
[244.589308] [063/141] (778s left) kms_addfb_basic (bo-too-small)
[244.888850] Starting subtest: bo-too-small
[244.890334] Subtest bo-too-small: SUCCESS (0.001s)
[244.988907] [064/141] (778s left) gem_exec_schedule (u-semaphore-resolve)
[245.226063] Starting subtest: u-semaphore-resolve
[245.280851] Subtest u-semaphore-resolve: SUCCESS (0.055s)
[245.623667] [065/141] (777s left) kms_frontbuffer_tracking (fbcpsr-1p-offscren-pri-indfb-draw-mmap-gtt)
[245.933336] Starting subtest: fbcpsr-1p-offscren-pri-indfb-draw-mmap-gtt
[245.935867] Subtest fbcpsr-1p-offscren-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[246.039716] [066/141] (777s left) kms_plane_scaling (planes-upscale-20x20-downscale-factor-0-75)
[246.335359] Starting subtest: planes-upscale-20x20-downscale-factor-0-75
[246.336678] Starting dynamic subtest: pipe-A-DP-1
[246.416941] Dynamic subtest pipe-A-DP-1: SUCCESS (0.080s)
[246.441806] Starting dynamic subtest: pipe-B-DP-1
[246.793033] Dynamic subtest pipe-B-DP-1: SUCCESS (0.372s)
[246.817081] Starting dynamic subtest: pipe-C-DP-1
[246.885861] Dynamic subtest pipe-C-DP-1: SKIP (0.088s)
[246.887361] Subtest planes-upscale-20x20-downscale-factor-0-75: SUCCESS (0.552s)
[247.286157] [067/141] (775s left) kms_psr2_su (page_flip-nv12)
[247.489716] Subtest page_flip-NV12: SKIP (0.000s)
[247.535889] [068/141] (775s left) gem_exec_await (wide-contexts)
[247.938319] Starting subtest: wide-contexts
[269.797349] Subtest wide-contexts: SUCCESS (21.858s)
[270.028815] [069/141] (753s left) core_setmaster_vs_auth
[270.435190] [070/141] (752s left) kms_cursor_legacy (flip-vs-cursor-atomic)
[270.744735] Starting subtest: flip-vs-cursor-atomic
[286.393925] Subtest flip-vs-cursor-atomic: SUCCESS (15.652s)
[286.730248] [071/141] (736s left) kms_big_fb (yf-tiled-8bpp-rotate-90)
[287.066051] Starting subtest: yf-tiled-8bpp-rotate-90
[287.068779] Subtest yf-tiled-8bpp-rotate-90: SKIP (0.000s)
[287.178085] [072/141] (736s left) v3d/v3d_get_bo_offset (get-bad-handle)
[287.455778] Subtest get-bad-handle: SKIP (0.000s)
[287.528451] [073/141] (735s left) gem_eio (context-create)
[287.756581] Starting subtest: context-create
[287.797214] Subtest context-create: SUCCESS (0.040s)
[287.977285] [074/141] (735s left) perf_pmu (multi-client)
[288.185213] Starting subtest: multi-client
[288.186605] Starting dynamic subtest: rcs0
[289.217204] Dynamic subtest rcs0: SUCCESS (1.032s)
[289.237229] Starting dynamic subtest: bcs0
[290.244043] Dynamic subtest bcs0: SUCCESS (1.025s)
[290.263769] Starting dynamic subtest: vcs0
[291.272739] Dynamic subtest vcs0: SUCCESS (1.026s)
[291.292520] Starting dynamic subtest: vecs0
[292.298034] Dynamic subtest vecs0: SUCCESS (1.025s)
[292.299476] Subtest multi-client: SUCCESS (4.114s)
[292.411906] [075/141] (731s left) gem_exec_suspend (basic-s4-devices)
[292.637142] Starting subtest: basic-S4-devices
[292.638504] Starting dynamic subtest: smem
[303.853850] Dynamic subtest smem: SUCCESS (11.216s)
[303.855142] Subtest basic-S4-devices: SUCCESS (11.217s)
[309.069208] [076/141] (719s left) kms_flip (flip-vs-panning-vs-hang)
[309.360531] Starting subtest: flip-vs-panning-vs-hang
[309.361839] Starting dynamic subtest: A-DP1
[322.919983] Dynamic subtest A-DP1: SUCCESS (13.558s)
[322.941749] Starting dynamic subtest: C-DP1
[335.912364] Dynamic subtest C-DP1: SUCCESS (12.992s)
[335.915819] Subtest flip-vs-panning-vs-hang: SUCCESS (26.556s)
[336.358869] [077/141] (692s left) kms_ccs (pipe-a-random-ccs-data-y_tiled_gen12_mc_ccs)
[336.785287] Starting subtest: pipe-A-random-ccs-data-y_tiled_gen12_mc_ccs
[336.789297] Subtest pipe-A-random-ccs-data-y_tiled_gen12_mc_ccs: SKIP (0.000s)
[337.388923] [078/141] (691s left) drm_fdinfo (busy-check-all)
[337.595578] Starting subtest: busy-check-all
[337.597121] Starting dynamic subtest: rcs0
[338.126087] Dynamic subtest rcs0: SUCCESS (0.529s)
[338.148442] Starting dynamic subtest: bcs0
[338.654460] Dynamic subtest bcs0: SUCCESS (0.527s)
[338.678632] Starting dynamic subtest: vcs0
[339.185723] Dynamic subtest vcs0: SUCCESS (0.531s)
[339.208305] Starting dynamic subtest: vecs0
[339.714838] Dynamic subtest vecs0: SUCCESS (0.528s)
[339.716371] Subtest busy-check-all: SUCCESS (2.119s)
[339.804484] [079/141] (688s left) gem_userptr_blits (stress-mm-invalidate-close)
[340.043739] Starting subtest: stress-mm-invalidate-close
[342.193736] Subtest stress-mm-invalidate-close: SUCCESS (2.149s)
[342.338266] [080/141] (686s left) kms_cursor_crc (cursor-offscreen-128x128)
[342.649579] Starting subtest: cursor-offscreen-128x128
[342.660851] Starting dynamic subtest: pipe-A-DP-1
[345.159501] Dynamic subtest pipe-A-DP-1: SUCCESS (2.497s)
[345.238783] Starting dynamic subtest: pipe-C-DP-1
[348.041484] Dynamic subtest pipe-C-DP-1: SUCCESS (2.821s)
[348.042760] Subtest cursor-offscreen-128x128: SUCCESS (5.390s)
[348.402397] [081/141] (680s left) gem_userptr_blits (stress-mm)
[348.645123] Starting subtest: stress-mm
[354.014306] Subtest stress-mm: SUCCESS (5.370s)
[354.148220] [082/141] (674s left) gem_exec_fence (nb-await)
[354.504035] Starting subtest: nb-await
[354.505486] Starting dynamic subtest: rcs0
[354.580303] Dynamic subtest rcs0: SUCCESS (0.074s)
[354.605446] Starting dynamic subtest: bcs0
[354.652508] Dynamic subtest bcs0: SUCCESS (0.071s)
[354.678769] Starting dynamic subtest: vcs0
[354.725889] Dynamic subtest vcs0: SUCCESS (0.072s)
[354.753199] Starting dynamic subtest: vecs0
[354.796774] Dynamic subtest vecs0: SUCCESS (0.070s)
[354.798423] Subtest nb-await: SUCCESS (0.293s)
[355.481824] [083/141] (673s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip)
[355.805911] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip
[355.811903] Subtest y-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip: SKIP (0.004s)
[355.915676] [084/141] (673s left) gem_userptr_blits (map-fixed-invalidate-busy)
[356.152994] Starting subtest: map-fixed-invalidate-busy
[356.154508] Starting dynamic subtest: gtt
[359.854533] Dynamic subtest gtt: SUCCESS (3.700s)
[359.878509] Starting dynamic subtest: wb
[363.465243] Dynamic subtest wb: SUCCESS (3.609s)
[363.487727] Starting dynamic subtest: wc
[367.060679] Dynamic subtest wc: SUCCESS (3.594s)
[367.083052] Starting dynamic subtest: uc
[370.657708] Dynamic subtest uc: SUCCESS (3.596s)
[370.659139] Subtest map-fixed-invalidate-busy: SUCCESS (14.504s)
[370.796882] [085/141] (658s left) gem_render_copy_redux (normal)
[371.022185] Starting subtest: normal
[373.275878] Subtest normal: SUCCESS (2.253s)
[373.381224] [086/141] (655s left) gem_unref_active_buffers
[373.845372] [087/141] (655s left) kms_setmode (invalid-clone-single-crtc)
[374.048489] Starting subtest: invalid-clone-single-crtc
[374.053702] Subtest invalid-clone-single-crtc: SKIP (0.000s)
[374.130724] [088/141] (654s left) kms_ccs (pipe-a-bad-rotation-90-4_tiled_dg2_mc_ccs)
[374.523505] Starting subtest: pipe-A-bad-rotation-90-4_tiled_dg2_mc_ccs
[374.526169] Subtest pipe-A-bad-rotation-90-4_tiled_dg2_mc_ccs: SKIP (0.000s)
[375.158150] [089/141] (653s left) syncobj_wait (invalid-multi-wait-all-unsubmitted-submitted-signaled)
[375.362900] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted-signaled
[375.364369] Subtest invalid-multi-wait-all-unsubmitted-submitted-signaled: SUCCESS (0.001s)
[375.458502] [090/141] (653s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite)
[375.777339] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite
[375.780725] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[375.891835] [091/141] (653s left) gem_ctx_persistence (heartbeat-hang)
[376.101634] Starting subtest: heartbeat-hang
[377.289613] Subtest heartbeat-hang: SUCCESS (1.188s)
[377.391950] [092/141] (651s left) kms_flip (blocking-absolute-wf_vblank)
[377.683645] Starting subtest: blocking-absolute-wf_vblank
[377.685150] Starting dynamic subtest: A-DP1
[388.207201] Dynamic subtest A-DP1: SUCCESS (10.522s)
[388.229672] Starting dynamic subtest: B-DP1
[398.699353] Dynamic subtest B-DP1: SUCCESS (10.491s)
[398.721683] Starting dynamic subtest: C-DP1
[409.326885] Dynamic subtest C-DP1: SUCCESS (10.626s)
[409.328208] Subtest blocking-absolute-wf_vblank: SUCCESS (31.648s)
[409.735542] [093/141] (619s left) v3d/v3d_wait_bo (map-bo-1ns)
[409.991435] Subtest map-bo-1ns: SKIP (0.000s)
[410.066257] [094/141] (619s left) v3d/v3d_submit_cl (single-out-sync)
[410.325754] Subtest single-out-sync: SKIP (0.000s)
[410.398786] [095/141] (618s left) kms_cursor_crc (cursor-rapid-movement-64x21)
[410.704359] Starting subtest: cursor-rapid-movement-64x21
[410.718103] Starting dynamic subtest: pipe-A-DP-1
[411.205834] Dynamic subtest pipe-A-DP-1: SUCCESS (0.488s)
[411.289219] Starting dynamic subtest: pipe-C-DP-1
[412.133498] Dynamic subtest pipe-C-DP-1: SUCCESS (0.864s)
[412.135783] Subtest cursor-rapid-movement-64x21: SUCCESS (1.426s)
[412.496688] [096/141] (616s left) kms_frontbuffer_tracking (psr-1p-offscren-pri-shrfb-draw-mmap-cpu)
[412.803876] Starting subtest: psr-1p-offscren-pri-shrfb-draw-mmap-cpu
[412.806486] Subtest psr-1p-offscren-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[412.892804] [097/141] (616s left) kms_properties (crtc-properties-atomic)
[413.189245] Starting subtest: crtc-properties-atomic
[414.156056] Subtest crtc-properties-atomic: SUCCESS (0.966s)
[414.478677] [098/141] (615s left) kms_ccs (pipe-b-bad-pixel-format-4_tiled_dg2_mc_ccs)
[414.981128] Starting subtest: pipe-B-bad-pixel-format-4_tiled_dg2_mc_ccs
[414.985388] Subtest pipe-B-bad-pixel-format-4_tiled_dg2_mc_ccs: SKIP (0.000s)
[415.535469] [099/141] (614s left) gem_pxp (display-protected-crc)
[418.257356] Subtest display-protected-crc: SKIP (0.000s)
[418.334856] [100/141] (611s left) kms_ccs (pipe-d-bad-aux-stride-y_tiled_gen12_rc_ccs_cc)
[419.071373] Subtest pipe-D-bad-aux-stride-y_tiled_gen12_rc_ccs_cc: SKIP (0.000s)
[419.385491] [101/141] (610s left) device_reset (unbind-reset-rebind)
[419.624532] Starting subtest: unbind-reset-rebind
[420.515194] Subtest unbind-reset-rebind: SUCCESS (0.889s)
[421.059775] [102/141] (608s left) gem_userptr_blits (dmabuf-sync)
[421.321845] Starting subtest: dmabuf-sync
[421.329123] Subtest dmabuf-sync: SKIP (0.007s)
[421.476467] [103/141] (608s left) perf (blocking)
[421.818365] Starting subtest: blocking
[421.820118] Starting dynamic subtest: 0-rcs0
[431.900561] Dynamic subtest 0-rcs0: SUCCESS (10.081s)
[431.901965] Subtest blocking: SUCCESS (10.082s)
[431.959508] [104/141] (597s left) kms_frontbuffer_tracking (fbc-1p-offscren-pri-indfb-draw-mmap-cpu)
[432.268822] Starting subtest: fbc-1p-offscren-pri-indfb-draw-mmap-cpu
[434.098988] Subtest fbc-1p-offscren-pri-indfb-draw-mmap-cpu: SUCCESS (1.833s)
[434.242769] [105/141] (595s left) syncobj_timeline (multi-wait-available-submitted)
[434.454477] Starting subtest: multi-wait-available-submitted
[434.456120] Subtest multi-wait-available-submitted: SUCCESS (0.002s)
[434.543507] [106/141] (595s left) kms_cursor_crc (cursor-onscreen-128x42)
[434.846891] Starting subtest: cursor-onscreen-128x42
[434.860192] Starting dynamic subtest: pipe-A-DP-1
[437.214389] Dynamic subtest pipe-A-DP-1: SUCCESS (2.353s)
[437.312583] Starting dynamic subtest: pipe-C-DP-1
[439.982346] Dynamic subtest pipe-C-DP-1: SUCCESS (2.699s)
[439.983665] Subtest cursor-onscreen-128x42: SUCCESS (5.133s)
[440.359179] [107/141] (589s left) gem_exec_reloc (basic-wc)
[440.572484] Starting subtest: basic-wc
[440.592758] Subtest basic-wc: SUCCESS (0.020s)
[440.787669] [108/141] (589s left) i915_module_load (reload-with-fault-injection)
[440.983390] Starting subtest: reload-with-fault-injection
[445.899869] Subtest reload-with-fault-injection: SUCCESS (4.916s)
[445.937543] [109/141] (584s left) kms_ccs (pipe-b-ccs-on-another-bo-4_tiled_mtl_rc_ccs_cc)
[447.843712] Starting subtest: pipe-B-ccs-on-another-bo-4_tiled_mtl_rc_ccs_cc
[447.846747] Subtest pipe-B-ccs-on-another-bo-4_tiled_mtl_rc_ccs_cc: SKIP (0.001s)
[448.323424] [110/141] (581s left) v3d/v3d_wait_bo (used-bo-1ns)
[448.586664] Subtest used-bo-1ns: SKIP (0.000s)
[448.659902] [111/141] (581s left) gen9_exec_parse (batch-invalid-length)
[448.906269] Starting subtest: batch-invalid-length
[448.931490] Subtest batch-invalid-length: SUCCESS (0.026s)
[449.160841] [112/141] (580s left) syncobj_timeline (signal-array)
[449.366722] Starting subtest: signal-array
[449.368245] Subtest signal-array: SUCCESS (0.001s)
[449.460376] [113/141] (580s left) kms_big_fb (linear-max-hw-stride-64bpp-rotate-180)
[449.783820] Starting subtest: linear-max-hw-stride-64bpp-rotate-180
[451.267841] Subtest linear-max-hw-stride-64bpp-rotate-180: SUCCESS (1.483s)
[451.445560] [114/141] (578s left) gem_eio (kms)
[451.780661] Starting subtest: kms
[464.110206] Subtest kms: SUCCESS (12.333s)
[464.186674] [115/141] (566s left) kms_big_fb (x-tiled-8bpp-rotate-0)
[464.509237] Starting subtest: x-tiled-8bpp-rotate-0
[467.458044] Subtest x-tiled-8bpp-rotate-0: SUCCESS (2.948s)
[467.673894] [116/141] (562s left) kms_atomic (test-only)
[468.113355] Starting subtest: test-only
[469.059847] Subtest test-only: SUCCESS (0.946s)
[469.411748] [117/141] (560s left) gem_exec_fair (basic-deadline)
[469.641226] Starting subtest: basic-deadline
[472.070776] Subtest basic-deadline: FAIL (2.327s)
[472.211301] [118/141] (558s left) kms_ccs (pipe-c-random-ccs-data-4_tiled_mtl_mc_ccs)
[472.857865] Starting subtest: pipe-C-random-ccs-data-4_tiled_mtl_mc_ccs
[472.862115] Subtest pipe-C-random-ccs-data-4_tiled_mtl_mc_ccs: SKIP (0.000s)
[473.238183] [119/141] (557s left) kms_cursor_legacy (cursorb-vs-flipb-toggle)
[473.538615] Starting subtest: cursorB-vs-flipB-toggle
[473.544717] Subtest cursorB-vs-flipB-toggle: SKIP (0.003s)
[473.637816] [120/141] (556s left) kms_plane (plane-panning-bottom-right-suspend)
[473.939715] Starting subtest: plane-panning-bottom-right-suspend
[473.941564] Starting dynamic subtest: pipe-A-planes
[491.502153] Dynamic subtest pipe-A-planes: SUCCESS (2.286s)
[491.529090] Starting dynamic subtest: pipe-B-planes
[510.567973] Dynamic subtest pipe-B-planes: SUCCESS (2.506s)
[510.569552] Subtest plane-panning-bottom-right-suspend: SUCCESS (4.803s)
[516.563420] [121/141] (551s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-mmap-wc)
[516.876877] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-mmap-wc
[516.880428] Subtest psr-1p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[516.999381] [122/141] (551s left) kms_frontbuffer_tracking (fbcpsr-1p-indfb-fliptrack-mmap-gtt)
[517.315406] Starting subtest: fbcpsr-1p-indfb-fliptrack-mmap-gtt
[517.318211] Subtest fbcpsr-1p-indfb-fliptrack-mmap-gtt: SKIP (0.000s)
[517.415532] [123/141] (550s left) kms_vblank (pipe-b-wait-forked)
[517.718107] Starting subtest: pipe-B-wait-forked
[520.464585] Subtest pipe-B-wait-forked: SUCCESS (2.744s)
[520.802646] [124/141] (547s left) gem_ctx_isolation (preservation)
[521.026335] Starting subtest: preservation
[521.027848] Starting dynamic subtest: rcs0
[522.168299] Dynamic subtest rcs0: SUCCESS (1.139s)
[522.197008] Starting dynamic subtest: bcs0
[523.671734] Dynamic subtest bcs0: SUCCESS (1.499s)
[523.697052] Starting dynamic subtest: vcs0
[524.749754] Dynamic subtest vcs0: SUCCESS (1.078s)
[524.775099] Starting dynamic subtest: vecs0
[525.847036] Dynamic subtest vecs0: SUCCESS (1.097s)
[525.848340] Subtest preservation: SUCCESS (4.821s)
[526.086006] [125/141] (542s left) gem_render_copy (y-tiled-to-vebox-y-tiled)
[526.304438] Starting subtest: y-tiled-to-vebox-y-tiled
[526.307102] Subtest y-tiled-to-vebox-y-tiled: SKIP (0.000s)
[526.519476] [126/141] (541s left) template (a)
[526.718745] Starting subtest: A
[526.720882] Subtest A: SUCCESS (0.000s)
[526.818964] [127/141] (541s left) gem_exec_schedule (preempt-queue-contexts)
[527.052831] Starting subtest: preempt-queue-contexts
[527.057017] Starting dynamic subtest: rcs0
[528.044734] Dynamic subtest rcs0: SUCCESS (0.987s)
[528.088391] Starting dynamic subtest: bcs0
[529.074595] Dynamic subtest bcs0: SUCCESS (1.023s)
[529.118562] Starting dynamic subtest: vcs0
[530.070318] Dynamic subtest vcs0: SUCCESS (0.998s)
[530.113075] Starting dynamic subtest: vecs0
[531.110130] Dynamic subtest vecs0: SUCCESS (1.040s)
[531.111368] Subtest preempt-queue-contexts: SUCCESS (4.056s)
[531.469966] [128/141] (536s left) gem_exec_whisper (basic-sync-all)
[531.694554] Starting subtest: basic-sync-all
[544.063543] Subtest basic-sync-all: SUCCESS (12.368s)
[544.269812] [129/141] (524s left) gem_ctx_bad_destroy (invalid-default-ctx)
[544.471146] Starting subtest: invalid-default-ctx
[544.472514] Subtest invalid-default-ctx: SUCCESS (0.000s)
[544.569061] [130/141] (523s left) kms_flip (bo-too-big-interruptible)
[544.868413] Starting subtest: bo-too-big-interruptible
[544.874023] Starting dynamic subtest: A-DP1
[547.812620] Dynamic subtest A-DP1: SUCCESS (2.938s)
[547.840260] Starting dynamic subtest: B-DP1
[550.692608] Dynamic subtest B-DP1: SUCCESS (2.876s)
[550.718842] Starting dynamic subtest: C-DP1
[553.592141] Dynamic subtest C-DP1: SUCCESS (2.897s)
[553.593426] Subtest bo-too-big-interruptible: SUCCESS (8.724s)
[554.201142] [131/141] (514s left) gem_busy (extended)
[554.573168] Starting subtest: extended
[554.574692] Starting dynamic subtest: rcs0
[554.654543] Dynamic subtest rcs0: SUCCESS (0.080s)
[554.682178] Starting dynamic subtest: bcs0
[554.694893] Dynamic subtest bcs0: SUCCESS (0.037s)
[554.720895] Starting dynamic subtest: vcs0
[554.732526] Dynamic subtest vcs0: SUCCESS (0.037s)
[554.758368] Starting dynamic subtest: vecs0
[554.792506] Dynamic subtest vecs0: SUCCESS (0.059s)
[554.793804] Subtest extended: SUCCESS (0.219s)
[555.096256] [132/141] (513s left) kms_ccs (pipe-d-missing-ccs-buffer-y_tiled_gen12_rc_ccs_cc)
[555.806698] Subtest pipe-D-missing-ccs-buffer-y_tiled_gen12_rc_ccs_cc: SKIP (0.000s)
[556.112784] [133/141] (512s left) kms_big_fb (y-tiled-32bpp-rotate-0)
[556.446281] Starting subtest: y-tiled-32bpp-rotate-0
[561.314468] Subtest y-tiled-32bpp-rotate-0: SUCCESS (4.868s)
[562.796366] [134/141] (505s left) syncobj_timeline (wait-all-interrupted)
[563.000237] Starting subtest: wait-all-interrupted
[563.109988] Subtest wait-all-interrupted: SUCCESS (0.109s)
[563.210662] [135/141] (505s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-mmap-wc)
[563.517253] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-mmap-wc
[565.747560] Subtest fbc-1p-primscrn-pri-indfb-draw-mmap-wc: SUCCESS (2.232s)
[565.895255] [136/141] (502s left) kms_ccs (pipe-c-crc-primary-rotation-180-y_tiled_gen12_rc_ccs_cc)
[566.550865] Starting subtest: pipe-C-crc-primary-rotation-180-y_tiled_gen12_rc_ccs_cc
[566.553457] Subtest pipe-C-crc-primary-rotation-180-y_tiled_gen12_rc_ccs_cc: SKIP (0.001s)
[566.943912] [137/141] (501s left) kms_chamelium_color (gamma)
[567.243781] Subtest gamma: SKIP (0.000s)
[567.308651] [138/141] (501s left) kms_addfb_basic (size-max)
[567.605474] Starting subtest: size-max
[567.607043] Subtest size-max: SUCCESS (0.000s)
[567.709546] [139/141] (501s left) gem_mmap_wc (pf-nonblock)
[567.911678] Starting subtest: pf-nonblock
[567.917454] Subtest pf-nonblock: SUCCESS (0.006s)
[568.026452] [140/141] (500s left) kms_vrr (flipline)
[568.330697] Starting subtest: flipline
[568.333376] Subtest flipline: SKIP (0.000s)
[568.392765] [141/141] (500s left) kms_frontbuffer_tracking (fbc-1p-offscren-pri-shrfb-draw-mmap-cpu)
[568.691147] Starting subtest: fbc-1p-offscren-pri-shrfb-draw-mmap-cpu
[570.512866] Subtest fbc-1p-offscren-pri-shrfb-draw-mmap-cpu: SUCCESS (1.826s)
[570.654519] Closing watchdogs
Done.