[37.753971] Initializing watchdogs
[37.754046]   /dev/watchdog0
[37.759765] [001/144] (960s left) kms_chamelium_color (ctm-red-to-blue)
[39.813285] Subtest ctm-red-to-blue: SKIP (0.000s)
[39.843648] [002/144] (958s left) kms_ccs (pipe-a-random-ccs-data-4-tiled-dg2-rc-ccs-cc)
[41.872551] Starting subtest: pipe-A-random-ccs-data-4-tiled-dg2-rc-ccs-cc
[41.874987] Subtest pipe-A-random-ccs-data-4-tiled-dg2-rc-ccs-cc: SKIP (0.000s)
[42.085283] [003/144] (956s left) gem_mmap_wc (write-wc-read-gtt)
[42.151620] Subtest write-wc-read-gtt: SKIP (0.000s)
[42.177780] [004/144] (956s left) kms_cursor_legacy (short-flip-after-cursor-atomic-transitions)
[44.141125] Starting subtest: short-flip-after-cursor-atomic-transitions
[45.412347] Subtest short-flip-after-cursor-atomic-transitions: SUCCESS (1.272s)
[45.517580] [005/144] (952s left) vc4/vc4_perfmon (create-single-perfmon)
[45.604619] Subtest create-single-perfmon: SKIP (0.000s)
[45.655401] [006/144] (952s left) prime_udl
[45.727353] [007/144] (952s left) syncobj_timeline (invalid-wait-illegal-handle)
[45.789846] Starting subtest: invalid-wait-illegal-handle
[45.790701] Subtest invalid-wait-illegal-handle: SUCCESS (0.000s)
[45.899977] [008/144] (952s left) gem_mmap_wc (coherency)
[45.998814] Subtest coherency: SKIP (0.000s)
[46.026866] [009/144] (952s left) kms_ccs (pipe-b-crc-sprite-planes-basic-4-tiled-mtl-rc-ccs)
[48.094436] Starting subtest: pipe-B-crc-sprite-planes-basic-4-tiled-mtl-rc-ccs
[48.098587] Subtest pipe-B-crc-sprite-planes-basic-4-tiled-mtl-rc-ccs: SKIP (0.003s)
[48.258450] [010/144] (950s left) core_auth (basic-auth)
[48.329548] Starting subtest: basic-auth
[48.335476] Subtest basic-auth: SUCCESS (0.006s)
[48.439509] [011/144] (949s left) gem_eio (in-flight-suspend)
[48.660355] Starting subtest: in-flight-suspend
[90.858182] Subtest in-flight-suspend: SUCCESS (15.844s)
[94.845769] [012/144] (931s left) kms_lease (lease-get)
[96.843780] Starting subtest: lease-get
[96.844659] Starting dynamic subtest: pipe-A-HDMI-A-4
[96.848626] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (0.002s)
[96.856120] Starting dynamic subtest: pipe-B-HDMI-A-4
[96.856982] Dynamic subtest pipe-B-HDMI-A-4: SUCCESS (0.002s)
[96.863968] Starting dynamic subtest: pipe-C-HDMI-A-4
[96.864823] Dynamic subtest pipe-C-HDMI-A-4: SUCCESS (0.002s)
[96.871702] Starting dynamic subtest: pipe-D-HDMI-A-4
[96.872754] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (0.002s)
[96.873774] Subtest lease-get: SUCCESS (0.013s)
[96.939852] [013/144] (929s left) gem_exec_reloc (basic-cpu-active)
[97.078732] Subtest basic-cpu-active: SKIP (0.000s)
[97.108061] [014/144] (929s left) kms_rotation_crc (multiplane-rotation)
[99.061850] Starting subtest: multiplane-rotation
[119.215136] Subtest multiplane-rotation: SUCCESS (20.153s)
[119.326248] [015/144] (907s left) kms_draw_crc (fill-fb)
[121.294297] Starting subtest: fill-fb
[121.830093] Subtest fill-fb: SUCCESS (0.537s)
[121.939631] [016/144] (904s left) kms_multipipe_modeset (basic-max-pipe-crc-check)
[123.902984] Starting subtest: basic-max-pipe-crc-check
[123.905562] Subtest basic-max-pipe-crc-check: SKIP (0.000s)
[123.937809] [017/144] (902s left) kms_pm_rpm (system-suspend-modeset)
[128.775439] Starting subtest: system-suspend-modeset
[152.051486] Subtest system-suspend-modeset: SUCCESS (11.610s)
[154.186829] [018/144] (885s left) kms_setmode (invalid-clone-single-crtc-stealing)
[154.256852] Starting subtest: invalid-clone-single-crtc-stealing
[154.259228] Subtest invalid-clone-single-crtc-stealing: SKIP (0.000s)
[154.337451] [019/144] (885s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-render)
[156.313675] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-render
[156.315524] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-render: SKIP (0.000s)
[156.398873] [020/144] (883s left) kms_ccs (pipe-a-ccs-on-another-bo-y-tiled-gen12-rc-ccs)
[158.535037] Starting subtest: pipe-A-ccs-on-another-bo-y-tiled-gen12-rc-ccs
[158.535963] Subtest pipe-A-ccs-on-another-bo-y-tiled-gen12-rc-ccs: SUCCESS (0.000s)
[158.743588] [021/144] (880s left) kms_ccs (pipe-c-crc-primary-basic-4-tiled-mtl-rc-ccs)
[160.827838] Starting subtest: pipe-C-crc-primary-basic-4-tiled-mtl-rc-ccs
[160.830116] Subtest pipe-C-crc-primary-basic-4-tiled-mtl-rc-ccs: SKIP (0.000s)
[160.979167] [022/144] (878s left) gem_ctx_bad_destroy (invalid-default-ctx)
[161.039341] Starting subtest: invalid-default-ctx
[161.040434] Subtest invalid-default-ctx: SUCCESS (0.000s)
[161.098872] [023/144] (878s left) kms_plane_scaling (planes-downscale-factor-0-5-upscale-factor-0-25)
[163.074280] Starting subtest: planes-downscale-factor-0-5-upscale-factor-0-25
[163.079448] Starting dynamic subtest: pipe-A-HDMI-A-4
[163.217940] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (0.139s)
[163.231481] Starting dynamic subtest: pipe-B-HDMI-A-4
[163.357927] Dynamic subtest pipe-B-HDMI-A-4: SUCCESS (0.135s)
[163.369289] Starting dynamic subtest: pipe-C-HDMI-A-4
[163.480510] Dynamic subtest pipe-C-HDMI-A-4: SUCCESS (0.118s)
[163.492787] Starting dynamic subtest: pipe-D-HDMI-A-4
[163.602633] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (0.117s)
[163.603496] Subtest planes-downscale-factor-0-5-upscale-factor-0-25: SUCCESS (0.529s)
[163.725651] [024/144] (875s left) api_intel_allocator (fork-simple-stress-signal)
[163.784654] Starting subtest: fork-simple-stress-signal
[169.218735] Subtest fork-simple-stress-signal: SUCCESS (5.431s)
[169.298871] [025/144] (870s left) gem_exec_parallel (basic)
[169.437413] Starting subtest: basic
[169.439728] Starting dynamic subtest: rcs0
[170.937646] Dynamic subtest rcs0: SUCCESS (1.499s)
[170.947138] Starting dynamic subtest: bcs0
[172.421805] Dynamic subtest bcs0: SUCCESS (1.483s)
[172.430421] Starting dynamic subtest: vcs0
[173.952702] Dynamic subtest vcs0: SUCCESS (1.530s)
[173.960936] Starting dynamic subtest: vcs1
[175.448628] Dynamic subtest vcs1: SUCCESS (1.495s)
[175.456373] Starting dynamic subtest: vecs0
[176.895767] Dynamic subtest vecs0: SUCCESS (1.446s)
[176.896848] Subtest basic: SUCCESS (7.459s)
[177.179074] [026/144] (862s left) i915_pm_rpm (reg-read-ioctl)
[181.516950] Starting subtest: reg-read-ioctl
[183.926054] Subtest reg-read-ioctl: SUCCESS (2.409s)
[185.041458] [027/144] (854s left) syncobj_timeline (wait-all-complex)
[185.114182] Starting subtest: wait-all-complex
[185.334831] Subtest wait-all-complex: SUCCESS (0.216s)
[185.455719] [028/144] (854s left) kms_frontbuffer_tracking (psr-1p-primscrn-shrfb-plflip-blt)
[187.430529] Starting subtest: psr-1p-primscrn-shrfb-plflip-blt
[187.432312] Subtest psr-1p-primscrn-shrfb-plflip-blt: SKIP (0.000s)
[187.534401] [029/144] (852s left) gem_exec_schedule (preempt-queue)
[187.698637] Subtest preempt-queue: SKIP (0.000s)
[188.052066] [030/144] (851s left) perf (create-destroy-userspace-config)
[188.151332] Starting subtest: create-destroy-userspace-config
[188.183831] Subtest create-destroy-userspace-config: SUCCESS (0.032s)
[188.204904] [031/144] (851s left) kms_psr2_su (page_flip-xrgb8888)
[188.263863] Subtest page_flip-XRGB8888: SKIP (0.000s)
[188.305328] [032/144] (851s left) kms_ccs (pipe-b-bad-pixel-format-y-tiled-gen12-rc-ccs)
[190.378554] Starting subtest: pipe-B-bad-pixel-format-y-tiled-gen12-rc-ccs
[190.379575] Subtest pipe-B-bad-pixel-format-y-tiled-gen12-rc-ccs: SUCCESS (0.000s)
[190.574232] [033/144] (849s left) v3d/v3d_submit_csd (single-in-sync)
[190.658233] Subtest single-in-sync: SKIP (0.000s)
[190.717344] [034/144] (849s left) kms_cursor_legacy (forked-move)
[192.707856] Starting subtest: forked-move
[192.708824] Starting dynamic subtest: pipe-A
[198.132128] Dynamic subtest pipe-A: SUCCESS (5.421s)
[198.142256] Starting dynamic subtest: pipe-B
[203.583288] Dynamic subtest pipe-B: SUCCESS (5.450s)
[203.596866] Starting dynamic subtest: pipe-C
[209.059453] Dynamic subtest pipe-C: SUCCESS (5.475s)
[209.076540] Starting dynamic subtest: pipe-D
[214.524930] Dynamic subtest pipe-D: SUCCESS (5.464s)
[214.539293] Starting dynamic subtest: all-pipes
[219.955529] Dynamic subtest all-pipes: SUCCESS (5.430s)
[219.956646] Subtest forked-move: SUCCESS (27.245s)
[220.050179] [035/144] (819s left) gem_render_copy (y-tiled-mc-ccs-to-yf-tiled-ccs)
[220.148646] Starting subtest: y-tiled-mc-ccs-to-yf-tiled-ccs
[220.149799] Starting dynamic subtest: smem
[220.248431] Dynamic subtest smem: SUCCESS (0.099s)
[220.256279] Starting dynamic subtest: lmem0
[221.355771] Dynamic subtest lmem0: SUCCESS (1.104s)
[221.356748] Subtest y-tiled-mc-ccs-to-yf-tiled-ccs: SUCCESS (1.205s)
[221.585041] [036/144] (818s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-onoff)
[223.549596] Starting subtest: psr-2p-scndscrn-spr-indfb-onoff
[223.551480] Subtest psr-2p-scndscrn-spr-indfb-onoff: SKIP (0.000s)
[223.625311] [037/144] (816s left) perf_pmu (rc6-all-gts)
[223.751115] Starting subtest: rc6-all-gts
[223.753070] Subtest rc6-all-gts: SKIP (0.000s)
[223.845054] [038/144] (816s left) syncobj_wait (wait-all-for-submit-complex)
[223.921990] Starting subtest: wait-all-for-submit-complex
[224.143404] Subtest wait-all-for-submit-complex: SUCCESS (0.217s)
[224.212447] [039/144] (815s left) vc4/vc4_perfmon (destroy-invalid-perfmon)
[224.287022] Subtest destroy-invalid-perfmon: SKIP (0.000s)
[224.339220] [040/144] (815s left) kms_cursor_crc (cursor-rapid-movement-32x10)
[226.396825] Starting subtest: cursor-rapid-movement-32x10
[226.439502] Subtest cursor-rapid-movement-32x10: SKIP (0.040s)
[226.782123] [041/144] (813s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-move)
[228.756806] Starting subtest: fbc-1p-primscrn-cur-indfb-move
[231.753014] Subtest fbc-1p-primscrn-cur-indfb-move: SUCCESS (2.996s)
[231.919366] [042/144] (808s left) syncobj_wait (invalid-wait-illegal-handle)
[231.979619] Starting subtest: invalid-wait-illegal-handle
[231.980549] Subtest invalid-wait-illegal-handle: SUCCESS (0.000s)
[232.066192] [043/144] (808s left) kms_ccs (pipe-b-random-ccs-data-y-tiled-gen12-rc-ccs)
[234.123316] Starting subtest: pipe-B-random-ccs-data-y-tiled-gen12-rc-ccs
[234.229346] Subtest pipe-B-random-ccs-data-y-tiled-gen12-rc-ccs: SUCCESS (0.106s)
[234.441928] [044/144] (805s left) kms_big_fb (yf-tiled-32bpp-rotate-90)
[236.416096] Starting subtest: yf-tiled-32bpp-rotate-90
[236.418132] Subtest yf-tiled-32bpp-rotate-90: SKIP (0.000s)
[236.497849] [045/144] (803s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-blt)
[238.539652] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-blt
[238.541941] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-blt: SKIP (0.000s)
[238.612480] [046/144] (801s left) gen9_exec_parse (shadow-peek)
[238.724068] Subtest shadow-peek: SKIP (0.000s)
[238.774271] [047/144] (801s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-move)
[240.773145] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-move
[240.774825] Subtest fbcpsr-2p-primscrn-spr-indfb-move: SKIP (0.000s)
[240.845456] [048/144] (799s left) core_getstats
[241.055485] [049/144] (799s left) kms_plane_scaling (planes-upscale-20x20-downscale-factor-0-75)
[243.038574] Starting subtest: planes-upscale-20x20-downscale-factor-0-75
[243.044620] Starting dynamic subtest: pipe-A-HDMI-A-4
[243.156829] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (0.113s)
[243.170388] Starting dynamic subtest: pipe-B-HDMI-A-4
[243.297875] Dynamic subtest pipe-B-HDMI-A-4: SUCCESS (0.136s)
[243.309821] Starting dynamic subtest: pipe-C-HDMI-A-4
[243.420304] Dynamic subtest pipe-C-HDMI-A-4: SUCCESS (0.117s)
[243.432974] Starting dynamic subtest: pipe-D-HDMI-A-4
[243.542582] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (0.117s)
[243.543503] Subtest planes-upscale-20x20-downscale-factor-0-75: SUCCESS (0.505s)
[243.665102] [050/144] (796s left) gem_exec_balancer (bonded-semaphore)
[243.731530] Starting subtest: bonded-semaphore
[243.733355] Subtest bonded-semaphore: SKIP (0.000s)
[244.103268] [051/144] (796s left) syncobj_timeline (etime-multi-wait-all-for-submit-submitted-signaled)
[244.165751] Starting subtest: etime-multi-wait-all-for-submit-submitted-signaled
[244.274533] Subtest etime-multi-wait-all-for-submit-submitted-signaled: SUCCESS (0.104s)
[244.346481] [052/144] (796s left) gem_render_copy (mixed-tiled-to-y-tiled-ccs)
[244.447643] Starting subtest: mixed-tiled-to-y-tiled-ccs
[244.448715] Starting dynamic subtest: smem
[244.552986] Dynamic subtest smem: SUCCESS (0.104s)
[244.560857] Starting dynamic subtest: lmem0
[245.491986] Dynamic subtest lmem0: SUCCESS (0.937s)
[245.492992] Subtest mixed-tiled-to-y-tiled-ccs: SUCCESS (1.042s)
[245.725736] [053/144] (794s left) kms_big_fb (x-tiled-8bpp-rotate-90)
[247.703318] Starting subtest: x-tiled-8bpp-rotate-90
[247.787269] Subtest x-tiled-8bpp-rotate-90: SKIP (0.083s)
[247.881418] [054/144] (792s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-render)
[249.858840] Starting subtest: psr-1p-primscrn-pri-indfb-draw-render
[249.861043] Subtest psr-1p-primscrn-pri-indfb-draw-render: SKIP (0.000s)
[249.938190] [055/144] (790s left) kms_busy (extended-modeset-hang-newfb-with-reset)
[252.002584] Starting subtest: extended-modeset-hang-newfb-with-reset
[252.005055] Starting dynamic subtest: pipe-A
[272.659607] Dynamic subtest pipe-A: SUCCESS (20.654s)
[272.671065] Starting dynamic subtest: pipe-D
[293.631978] Dynamic subtest pipe-D: SUCCESS (20.968s)
[293.632789] Subtest extended-modeset-hang-newfb-with-reset: SUCCESS (41.630s)
[293.758488] [056/144] (746s left) kms_flip (2x-flip-vs-rmfb)
[295.724168] Starting subtest: 2x-flip-vs-rmfb
[295.749892] Subtest 2x-flip-vs-rmfb: SKIP (0.025s)
[295.827677] [057/144] (744s left) gem_exec_params (rsvd2-dirt)
[295.942424] Starting subtest: rsvd2-dirt
[295.944714] Subtest rsvd2-dirt: SKIP (0.000s)
[296.080838] [058/144] (744s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-64bpp-yftile-upscaling)
[298.081605] Starting subtest: flip-32bpp-yftile-to-64bpp-yftile-upscaling
[298.084795] Starting dynamic subtest: pipe-A-valid-mode
[298.129907] Dynamic subtest pipe-A-valid-mode: SKIP (0.046s)
[298.131913] Subtest flip-32bpp-yftile-to-64bpp-yftile-upscaling: SKIP (0.048s)
[298.216512] [059/144] (742s left) kms_psr (fbc-psr2-sprite-mmap-gtt)
[300.202646] Subtest fbc-psr2-sprite-mmap-gtt: SKIP (0.000s)
[300.225410] [060/144] (740s left) prime_mmap (test_aperture_limit)
[300.287570] Starting subtest: test_aperture_limit
[300.288578] Starting dynamic subtest: test_aperture_limit-smem
[305.888614] Dynamic subtest test_aperture_limit-smem: SUCCESS (5.598s)
[305.889492] Subtest test_aperture_limit: SUCCESS (5.599s)
[308.047170] [061/144] (732s left) kms_cursor_legacy (short-flip-after-cursor-atomic-transitions-varying-size)
[310.043376] Starting subtest: short-flip-after-cursor-atomic-transitions-varying-size
[311.069725] Subtest short-flip-after-cursor-atomic-transitions-varying-size: SUCCESS (1.027s)
[311.197780] [062/144] (729s left) v3d/v3d_perfmon (create-perfmon-exceed)
[311.299624] Subtest create-perfmon-exceed: SKIP (0.000s)
[311.352571] [063/144] (729s left) kms_flip (2x-plain-flip-interruptible)
[313.328876] Starting subtest: 2x-plain-flip-interruptible
[313.355297] Subtest 2x-plain-flip-interruptible: SKIP (0.025s)
[313.416068] [064/144] (727s left) gem_exec_flush (basic-uc-set-default)
[313.516962] Subtest basic-uc-set-default: SKIP (0.000s)
[313.566745] [065/144] (727s left) api_intel_bb (object-noreloc-purge-cache-simple)
[313.652380] Starting subtest: object-noreloc-purge-cache-simple
[313.672960] Subtest object-noreloc-purge-cache-simple: SUCCESS (0.021s)
[313.785106] [066/144] (726s left) gem_busy (semaphore)
[314.026885] Subtest semaphore: SKIP (0.000s)
[314.311588] [067/144] (726s left) kms_big_fb (y-tiled-32bpp-rotate-180)
[316.307216] Starting subtest: y-tiled-32bpp-rotate-180
[318.166306] Subtest y-tiled-32bpp-rotate-180: SUCCESS (1.855s)
[318.328575] [068/144] (722s left) kms_plane_scaling (intel-max-src-size)
[320.294664] Starting subtest: intel-max-src-size
[320.298032] Starting dynamic subtest: pipe-A-HDMI-A-4
[320.785118] Dynamic subtest pipe-A-HDMI-A-4: FAIL (0.353s)
[320.786430] Subtest intel-max-src-size: FAIL (0.360s)
[320.808139] [069/144] (720s left) syncobj_wait (invalid-single-wait-all-unsubmitted)
[320.868857] Starting subtest: invalid-single-wait-all-unsubmitted
[320.869772] Subtest invalid-single-wait-all-unsubmitted: SUCCESS (0.000s)
[320.965705] [070/144] (719s left) kms_flip (2x-flip-vs-dpms)
[322.958696] Starting subtest: 2x-flip-vs-dpms
[322.984065] Subtest 2x-flip-vs-dpms: SKIP (0.025s)
[323.067427] [071/144] (717s left) kms_psr (psr2-dpms)
[325.088327] Subtest psr2-dpms: SKIP (0.000s)
[325.121223] [072/144] (715s left) gem_exec_fence (expired-history)
[325.585734] Starting subtest: expired-history
[331.685387] Subtest expired-history: SUCCESS (6.097s)
[332.675774] [073/144] (708s left) gem_media_vme
[332.820408] [074/144] (708s left) dmabuf (all-tests)
[332.871107] Starting subtest: all-tests
[332.942933] Starting dynamic subtest: sanitycheck
[333.044101] Dynamic subtest sanitycheck: SUCCESS (0.172s)
[333.055638] Starting dynamic subtest: dma_fence
[333.231645] Dynamic subtest dma_fence: SUCCESS (0.185s)
[333.268564] Starting dynamic subtest: dma_fence_chain
[346.104559] Dynamic subtest dma_fence_chain: SUCCESS (12.863s)
[346.112834] Starting dynamic subtest: dma_fence_unwrap
[346.169386] Dynamic subtest dma_fence_unwrap: SUCCESS (0.067s)
[346.197666] Starting dynamic subtest: dma_resv
[346.254080] Dynamic subtest dma_resv: SUCCESS (0.080s)
[346.255262] Subtest all-tests: SUCCESS (13.384s)
[346.349042] [075/144] (694s left) gem_exec_params (invalid-bsd2-flag-on-render)
[346.417839] Starting subtest: invalid-bsd2-flag-on-render
[346.418804] Subtest invalid-bsd2-flag-on-render: SUCCESS (0.000s)
[346.532706] [076/144] (694s left) gem_exec_capture (many-4k-zero)
[346.610094] Starting subtest: many-4K-zero
[347.387890] Subtest many-4K-zero: FAIL (0.754s)
[347.535816] [077/144] (693s left) kms_psr (psr-cursor-mmap-cpu)
[349.608568] Subtest psr-cursor-mmap-cpu: SKIP (0.000s)
[349.634801] [078/144] (691s left) kms_flip (2x-single-buffer-flip-vs-dpms-off-vs-modeset-interruptible)
[351.603268] Starting subtest: 2x-single-buffer-flip-vs-dpms-off-vs-modeset-interruptible
[351.629611] Subtest 2x-single-buffer-flip-vs-dpms-off-vs-modeset-interruptible: SKIP (0.025s)
[351.696104] [079/144] (689s left) sysfs_heartbeat_interval (invalid)
[351.811543] Starting subtest: invalid
[351.812695] Starting dynamic subtest: vecs0
[351.813800] Dynamic subtest vecs0: SUCCESS (0.000s)
[351.823321] Starting dynamic subtest: vcs0
[351.824567] Dynamic subtest vcs0: SUCCESS (0.000s)
[351.833314] Starting dynamic subtest: bcs0
[351.834655] Dynamic subtest bcs0: SUCCESS (0.000s)
[351.843359] Starting dynamic subtest: rcs0
[351.844476] Dynamic subtest rcs0: SUCCESS (0.000s)
[351.852981] Starting dynamic subtest: vcs1
[351.854102] Dynamic subtest vcs1: SUCCESS (0.000s)
[351.855181] Subtest invalid: SUCCESS (0.007s)
[351.912007] [080/144] (689s left) kms_ccs (pipe-a-crc-sprite-planes-basic-4-tiled-mtl-rc-ccs)
[353.960661] Starting subtest: pipe-A-crc-sprite-planes-basic-4-tiled-mtl-rc-ccs
[353.965013] Subtest pipe-A-crc-sprite-planes-basic-4-tiled-mtl-rc-ccs: SKIP (0.003s)
[354.165294] [081/144] (686s left) gem_softpin (noreloc-s3)
[354.239587] Starting subtest: noreloc-S3
[375.704272] Subtest noreloc-S3: SUCCESS (8.828s)
[379.806739] [082/144] (677s left) kms_flip (2x-flip-vs-fences-interruptible)
[381.776792] Starting subtest: 2x-flip-vs-fences-interruptible
[381.778996] Subtest 2x-flip-vs-fences-interruptible: SKIP (0.000s)
[381.845991] [083/144] (675s left) gem_exec_fence (syncobj-wait)
[382.319117] Starting subtest: syncobj-wait
[382.397093] Subtest syncobj-wait: SUCCESS (0.078s)
[382.740648] [084/144] (675s left) kms_ccs (pipe-c-bad-rotation-90-y-tiled-ccs)
[384.837494] Starting subtest: pipe-C-bad-rotation-90-y-tiled-ccs
[384.839128] Subtest pipe-C-bad-rotation-90-y-tiled-ccs: SKIP (0.000s)
[384.994495] [085/144] (672s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-render)
[386.965875] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-render
[389.726620] Subtest fbc-1p-primscrn-pri-indfb-draw-render: SUCCESS (2.760s)
[389.853114] [086/144] (668s left) kms_universal_plane (universal-plane-functional)
[391.823140] Starting subtest: universal-plane-functional
[391.824287] Starting dynamic subtest: pipe-A-HDMI-A-4
[393.862939] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (2.038s)
[393.872911] Starting dynamic subtest: pipe-B-HDMI-A-4
[395.769859] Dynamic subtest pipe-B-HDMI-A-4: SUCCESS (1.905s)
[395.779943] Starting dynamic subtest: pipe-C-HDMI-A-4
[397.679017] Dynamic subtest pipe-C-HDMI-A-4: SUCCESS (1.906s)
[397.689396] Starting dynamic subtest: pipe-D-HDMI-A-4
[399.586260] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (1.904s)
[399.587173] Subtest universal-plane-functional: SUCCESS (7.764s)
[399.712012] [087/144] (658s left) gem_userptr_blits (create-destroy-unsync)
[399.781287] Subtest create-destroy-unsync: SKIP (0.000s)
[399.895155] [088/144] (658s left) gem_exec_store (pages)
[399.968546] Starting subtest: pages
[399.969364] Starting dynamic subtest: rcs0
[400.110633] Dynamic subtest rcs0: SUCCESS (0.141s)
[400.120998] Starting dynamic subtest: bcs0
[400.210273] Dynamic subtest bcs0: SUCCESS (0.098s)
[400.220177] Starting dynamic subtest: vcs0
[400.318268] Dynamic subtest vcs0: SUCCESS (0.107s)
[400.328085] Starting dynamic subtest: vcs1
[400.420208] Dynamic subtest vcs1: SUCCESS (0.101s)
[400.429938] Starting dynamic subtest: vecs0
[400.519274] Dynamic subtest vecs0: SUCCESS (0.098s)
[400.520086] Subtest pages: SUCCESS (0.551s)
[400.746662] [089/144] (657s left) gem_eio (in-flight-internal-1us)
[400.951234] Starting subtest: in-flight-internal-1us
[401.959206] Subtest in-flight-internal-1us: SUCCESS (1.008s)
[403.913848] [090/144] (654s left) gem_ctx_persistence (engines-mixed-process)
[404.017173] Starting subtest: engines-mixed-process
[404.018672] Starting dynamic subtest: rcs0
[405.941563] Dynamic subtest rcs0: SUCCESS (1.924s)
[405.955158] Starting dynamic subtest: bcs0
[407.915374] Dynamic subtest bcs0: SUCCESS (1.972s)
[407.926561] Starting dynamic subtest: vcs0
[409.967422] Dynamic subtest vcs0: SUCCESS (2.050s)
[409.978627] Starting dynamic subtest: vcs1
[411.956564] Dynamic subtest vcs1: SUCCESS (1.987s)
[411.969474] Starting dynamic subtest: vecs0
[413.940455] Dynamic subtest vecs0: SUCCESS (1.982s)
[413.941489] Subtest engines-mixed-process: SUCCESS (9.925s)
[414.015503] [091/144] (643s left) kms_psr (pr-cursor-mmap-gtt)
[415.985079] Subtest pr-cursor-mmap-gtt: SKIP (0.000s)
[416.018878] [092/144] (641s left) syncobj_wait (wait-any-interrupted)
[416.095906] Starting subtest: wait-any-interrupted
[416.201917] Subtest wait-any-interrupted: SUCCESS (0.101s)
[416.338725] [093/144] (641s left) kms_ccs (pipe-d-bad-pixel-format-4-tiled-dg2-mc-ccs)
[418.469538] Starting subtest: pipe-D-bad-pixel-format-4-tiled-dg2-mc-ccs
[418.471492] Subtest pipe-D-bad-pixel-format-4-tiled-dg2-mc-ccs: SKIP (0.000s)
[418.594633] [094/144] (639s left) gem_exec_balancer (parallel-bb-first)
[418.888823] Starting subtest: parallel-bb-first
[420.120730] Subtest parallel-bb-first: SUCCESS (1.232s)
[420.213098] [095/144] (637s left) kms_ccs (pipe-d-bad-rotation-90-4-tiled-mtl-mc-ccs)
[422.343357] Starting subtest: pipe-D-bad-rotation-90-4-tiled-mtl-mc-ccs
[422.345293] Subtest pipe-D-bad-rotation-90-4-tiled-mtl-mc-ccs: SKIP (0.000s)
[422.464739] [096/144] (635s left) kms_cursor_legacy (2x-flip-vs-cursor-legacy)
[424.429708] Starting subtest: 2x-flip-vs-cursor-legacy
[424.432297] Subtest 2x-flip-vs-cursor-legacy: SKIP (0.004s)
[424.501228] [097/144] (633s left) kms_ccs (pipe-d-missing-ccs-buffer-y-tiled-gen12-rc-ccs-cc)
[426.693177] Starting subtest: pipe-D-missing-ccs-buffer-y-tiled-gen12-rc-ccs-cc
[426.694294] Subtest pipe-D-missing-ccs-buffer-y-tiled-gen12-rc-ccs-cc: SUCCESS (0.000s)
[426.799937] [098/144] (631s left) gem_spin_batch (resubmit-all)
[426.865961] Starting subtest: resubmit-all
[426.866952] Starting dynamic subtest: rcs0
[426.890696] Dynamic subtest rcs0: SUCCESS (0.024s)
[426.900191] Starting dynamic subtest: bcs0
[426.901203] Dynamic subtest bcs0: SUCCESS (0.002s)
[426.910279] Starting dynamic subtest: vcs0
[426.911536] Dynamic subtest vcs0: SUCCESS (0.002s)
[426.920340] Starting dynamic subtest: vcs1
[426.921705] Dynamic subtest vcs1: SUCCESS (0.002s)
[426.930369] Starting dynamic subtest: vecs0
[426.931811] Dynamic subtest vecs0: SUCCESS (0.002s)
[426.933189] Subtest resubmit-all: SUCCESS (0.038s)
[427.176604] [099/144] (631s left) kms_pm_rpm (dpms-lpsp)
[432.129527] Starting subtest: dpms-lpsp
[432.134039] Subtest dpms-lpsp: SKIP (0.001s)
[433.244638] [100/144] (624s left) kms_content_protection (atomic)
[435.284617] Starting subtest: atomic
[435.547211] Subtest atomic: SKIP (0.261s)
[435.701883] [101/144] (622s left) gem_set_tiling_vs_gtt
[435.796679] [102/144] (622s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-shrfb-plflip-blt)
[437.779388] Starting subtest: fbc-2p-scndscrn-shrfb-plflip-blt
[437.781509] Subtest fbc-2p-scndscrn-shrfb-plflip-blt: SKIP (0.000s)
[437.882543] [103/144] (620s left) gem_userptr_blits (probe)
[438.057202] Starting subtest: probe
[438.289757] Subtest probe: SUCCESS (0.229s)
[438.404437] [104/144] (619s left) vc4/vc4_wait_bo (unused-bo-1ns)
[438.500648] Subtest unused-bo-1ns: SKIP (0.000s)
[438.558055] [105/144] (619s left) i915_getparams_basic (basic-eu-total)
[438.621755] Starting subtest: basic-eu-total
[438.623414] Subtest basic-eu-total: SUCCESS (0.000s)
[438.747985] [106/144] (619s left) gem_exec_schedule (pi-distinct-iova)
[438.948047] Starting subtest: pi-distinct-iova
[438.949007] Starting dynamic subtest: rcs0
[439.129355] Dynamic subtest rcs0: SUCCESS (0.181s)
[439.138195] Starting dynamic subtest: bcs0
[439.246099] Dynamic subtest bcs0: SUCCESS (0.115s)
[439.254926] Starting dynamic subtest: vcs0
[439.372915] Dynamic subtest vcs0: SUCCESS (0.126s)
[439.381717] Starting dynamic subtest: vcs1
[439.501344] Dynamic subtest vcs1: SUCCESS (0.127s)
[439.510386] Starting dynamic subtest: vecs0
[439.633462] Dynamic subtest vecs0: SUCCESS (0.131s)
[439.634479] Subtest pi-distinct-iova: SUCCESS (0.686s)
[439.930247] [107/144] (618s left) kms_getfb (getfb2-handle-not-fb)
[440.013308] Starting subtest: getfb2-handle-not-fb
[441.918255] Subtest getfb2-handle-not-fb: SUCCESS (1.905s)
[442.009490] [108/144] (616s left) kms_cursor_crc (cursor-onscreen-256x256)
[444.270622] Starting subtest: cursor-onscreen-256x256
[444.278445] Starting dynamic subtest: pipe-A-HDMI-A-4
[447.004379] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (2.726s)
[447.032926] Starting dynamic subtest: pipe-D-HDMI-A-4
[449.650977] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (2.626s)
[449.652021] Subtest cursor-onscreen-256x256: SUCCESS (5.379s)
[449.925534] [109/144] (608s left) kms_feature_discovery (display)
[451.890560] Starting subtest: display
[451.891643] Subtest display: SUCCESS (0.000s)
[451.960223] [110/144] (606s left) kms_writeback (writeback-fb-id-xrgb2101010)
[455.890316] Subtest writeback-fb-id-XRGB2101010: SKIP (0.000s)
[455.915487] [111/144] (602s left) kms_big_fb (linear-max-hw-stride-32bpp-rotate-0)
[457.887815] Starting subtest: linear-max-hw-stride-32bpp-rotate-0
[459.138502] Subtest linear-max-hw-stride-32bpp-rotate-0: SUCCESS (1.250s)
[459.261127] [112/144] (599s left) syncobj_eventfd (timeline-wait)
[459.320765] Starting subtest: timeline-wait
[459.331451] Subtest timeline-wait: SUCCESS (0.011s)
[459.414481] [113/144] (599s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0-hflip)
[461.423183] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0-hflip
[461.425084] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0-hflip: SKIP (0.000s)
[461.493174] [114/144] (597s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-pwrite)
[463.530743] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-pwrite
[463.532573] Subtest psr-2p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[463.613169] [115/144] (594s left) kms_cursor_legacy (cursor-vs-flip-varying-size)
[465.668354] Starting subtest: cursor-vs-flip-varying-size
[497.255217] Subtest cursor-vs-flip-varying-size: SUCCESS (31.588s)
[497.370591] [116/144] (561s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-16bpp-ytile-downscaling)
[499.343703] Starting subtest: flip-64bpp-ytile-to-16bpp-ytile-downscaling
[499.347066] Starting dynamic subtest: pipe-A-valid-mode
[500.478278] Dynamic subtest pipe-A-valid-mode: SUCCESS (1.132s)
[500.479227] Subtest flip-64bpp-ytile-to-16bpp-ytile-downscaling: SUCCESS (1.134s)
[500.579890] [117/144] (558s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-blt)
[502.552298] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-blt
[502.554383] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[502.638194] [118/144] (556s left) kms_ccs (pipe-d-crc-primary-basic-y-tiled-gen12-rc-ccs-cc)
[504.848830] Starting subtest: pipe-D-crc-primary-basic-y-tiled-gen12-rc-ccs-cc
[505.183373] Subtest pipe-D-crc-primary-basic-y-tiled-gen12-rc-ccs-cc: SUCCESS (0.333s)
[505.397623] [119/144] (553s left) gem_mmap_gtt (big-bo)
[505.463057] Subtest big-bo: SKIP (0.000s)
[505.509626] [120/144] (553s left) syncobj_timeline (multi-wait-for-submit-available-unsubmitted-submitted)
[505.580761] Starting subtest: multi-wait-for-submit-available-unsubmitted-submitted
[505.581828] Subtest multi-wait-for-submit-available-unsubmitted-submitted: SUCCESS (0.000s)
[505.668959] [121/144] (553s left) kms_frontbuffer_tracking (fbc-rgb565-draw-render)
[507.644785] Starting subtest: fbc-rgb565-draw-render
[510.393791] Subtest fbc-rgb565-draw-render: SUCCESS (2.749s)
[510.524216] [122/144] (548s left) kms_chamelium_frames (hdmi-aspect-ratio)
[512.533242] Subtest hdmi-aspect-ratio: SKIP (0.000s)
[512.591680] [123/144] (546s left) kms_ccs (pipe-c-crc-sprite-planes-basic-y-tiled-gen12-mc-ccs)
[514.700851] Starting subtest: pipe-C-crc-sprite-planes-basic-y-tiled-gen12-mc-ccs
[514.705073] Subtest pipe-C-crc-sprite-planes-basic-y-tiled-gen12-mc-ccs: SKIP (0.003s)
[514.833782] [124/144] (543s left) gem_ctx_persistence (smoketest)
[514.902742] Starting subtest: smoketest
[545.917106] Subtest smoketest: SUCCESS (31.014s)
[545.989546] [125/144] (512s left) kms_dsc (dsc-fractional-bpp-with-bpc)
[547.978637] Starting subtest: dsc-fractional-bpp-with-bpc
[547.980788] Subtest dsc-fractional-bpp-with-bpc: SKIP (0.001s)
[548.049777] [126/144] (510s left) kms_color (ctm-0-25)
[550.093264] Starting subtest: ctm-0-25
[550.094289] Starting dynamic subtest: pipe-A
[551.653244] Dynamic subtest pipe-A: SUCCESS (1.559s)
[551.662325] Starting dynamic subtest: pipe-B
[553.015534] Dynamic subtest pipe-B: SUCCESS (1.362s)
[553.027884] Starting dynamic subtest: pipe-C
[554.303394] Dynamic subtest pipe-C: SUCCESS (1.286s)
[554.313976] Starting dynamic subtest: pipe-D
[555.647893] Dynamic subtest pipe-D: SUCCESS (1.343s)
[555.648914] Subtest ctm-0-25: SUCCESS (5.555s)
[555.776204] [127/144] (503s left) syncobj_timeline (etime-single-wait-all-for-submit-unsubmitted)
[555.839652] Starting subtest: etime-single-wait-all-for-submit-unsubmitted
[555.951220] Subtest etime-single-wait-all-for-submit-unsubmitted: SUCCESS (0.107s)
[556.030081] [128/144] (502s left) perf_pmu (busy-idle)
[556.084276] Starting subtest: busy-idle
[556.085234] Starting dynamic subtest: rcs0
[556.764491] Dynamic subtest rcs0: SUCCESS (0.679s)
[556.778824] Starting dynamic subtest: bcs0
[557.436422] Dynamic subtest bcs0: SUCCESS (0.669s)
[557.455661] Starting dynamic subtest: vcs0
[558.105236] Dynamic subtest vcs0: SUCCESS (0.663s)
[558.124925] Starting dynamic subtest: vcs1
[558.766334] Dynamic subtest vcs1: SUCCESS (0.655s)
[558.785548] Starting dynamic subtest: vecs0
[559.433220] Dynamic subtest vecs0: SUCCESS (0.661s)
[559.436232] Subtest busy-idle: SUCCESS (3.351s)
[559.572590] [129/144] (499s left) kms_big_fb (4-tiled-32bpp-rotate-90)
[561.554307] Starting subtest: 4-tiled-32bpp-rotate-90
[561.556511] Subtest 4-tiled-32bpp-rotate-90: SKIP (0.000s)
[561.631120] [130/144] (497s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-mmap-gtt)
[563.668882] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-mmap-gtt
[563.670889] Subtest psr-2p-scndscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[563.770011] [131/144] (495s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-180-async-flip)
[565.831138] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-180-async-flip
[566.356690] Subtest y-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SUCCESS (0.525s)
[566.576994] [132/144] (492s left) gem_huc_copy (huc-copy)
[566.676832] Starting subtest: huc-copy
[566.681225] Subtest huc-copy: SUCCESS (0.004s)
[566.821597] [133/144] (492s left) i915_pm_rps (thresholds-idle)
[566.884364] Starting subtest: thresholds-idle
[566.885354] Starting dynamic subtest: gt0
[566.904712] Dynamic subtest gt0: SKIP (0.019s)
[566.906554] Subtest thresholds-idle: SKIP (0.020s)
[567.013873] [134/144] (492s left) gem_softpin (overlap)
[567.102656] Starting subtest: overlap
[570.064999] Subtest overlap: SUCCESS (2.959s)
[570.182869] [135/144] (488s left) gem_create (hog-create)
[570.271653] Starting subtest: hog-create
[570.272582] Starting dynamic subtest: lmem0
[602.544602] Dynamic subtest lmem0: SUCCESS (32.272s)
[602.555438] Starting dynamic subtest: smem0
[634.797655] Dynamic subtest smem0: SUCCESS (32.252s)
[634.798564] Subtest hog-create: SUCCESS (64.527s)
[635.035338] [136/144] (424s left) gem_ctx_param (basic-default)
[635.094163] Starting subtest: basic-default
[635.095142] Subtest basic-default: SUCCESS (0.000s)
[635.181777] [137/144] (423s left) kms_ccs (pipe-b-crc-primary-basic-y-tiled-gen12-mc-ccs)
[637.225849] Starting subtest: pipe-B-crc-primary-basic-y-tiled-gen12-mc-ccs
[637.227887] Subtest pipe-B-crc-primary-basic-y-tiled-gen12-mc-ccs: SKIP (0.000s)
[637.415209] [138/144] (421s left) gem_mmap_offset (oob-read)
[637.479635] Starting subtest: oob-read
[637.480476] Subtest oob-read: SUCCESS (0.000s)
[637.620992] [139/144] (421s left) vgem_slow (nohang)
[637.696796] Starting subtest: nohang
[648.143750] Subtest nohang: SUCCESS (10.444s)
[648.204867] [140/144] (411s left) kms_psr2_sf (overlay-plane-move-continuous-sf)
[648.266516] Subtest overlay-plane-move-continuous-sf: SKIP (0.000s)
[648.305976] [141/144] (410s left) drm_fdinfo (virtual-busy-all)
[648.355010] Starting subtest: virtual-busy-all
[648.356816] Subtest virtual-busy-all: SKIP (0.000s)
[648.420571] [142/144] (410s left) drm_read (empty-block)
[650.478099] Starting subtest: empty-block
[651.482549] Subtest empty-block: SUCCESS (1.000s)
[651.620817] [143/144] (407s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-indfb-msflip-blt)
[653.594367] Starting subtest: fbcpsr-1p-primscrn-indfb-msflip-blt
[653.596095] Subtest fbcpsr-1p-primscrn-indfb-msflip-blt: SKIP (0.000s)
[653.669148] [144/144] (405s left) kms_addfb_basic (addfb25-y-tiled-small-legacy)
[655.729142] Starting subtest: addfb25-y-tiled-small-legacy
[655.730076] Subtest addfb25-y-tiled-small-legacy: SUCCESS (0.000s)
[655.800787] Closing watchdogs
Done.