[55.602618] Initializing watchdogs
[55.602737]   /dev/watchdog0
[55.617498] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics]
[55.621833] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[55.625057] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[55.628257] [001/131] (960s left) gem_ctx_isolation (nonpriv-switch)
[55.708814] Starting subtest: nonpriv-switch
[55.711116] Starting dynamic subtest: rcs0
[56.085041] Dynamic subtest rcs0: SUCCESS (0.376s)
[56.095827] Starting dynamic subtest: bcs0
[56.463350] Dynamic subtest bcs0: SUCCESS (0.379s)
[56.472549] Starting dynamic subtest: vcs0
[56.800772] Dynamic subtest vcs0: SUCCESS (0.337s)
[56.810604] Starting dynamic subtest: vcs1
[58.171154] Dynamic subtest vcs1: SUCCESS (1.371s)
[58.181276] Starting dynamic subtest: vecs0
[60.240497] Dynamic subtest vecs0: SUCCESS (2.069s)
[60.250183] Starting dynamic subtest: ccs0
[62.227043] Dynamic subtest ccs0: SUCCESS (1.986s)
[62.229504] Subtest nonpriv-switch: SUCCESS (6.520s)
[62.494054] [002/131] (953s left) gem_pxp (hw-rejects-pxp-context)
[62.628446] Starting subtest: hw-rejects-pxp-context
[62.632842] Subtest hw-rejects-pxp-context: SKIP (0.000s)
[62.760568] [003/131] (953s left) gem_exec_reloc (basic-gtt-read-noreloc)
[62.829425] Subtest basic-gtt-read-noreloc: SKIP (0.000s)
[62.917882] [004/131] (953s left) kms_color (ctm-negative)
[63.019580] Starting subtest: ctm-negative
[63.021929] Starting dynamic subtest: pipe-A-eDP-1
[63.745270] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.724s)
[63.752350] Starting dynamic subtest: pipe-B-eDP-1
[65.137457] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.391s)
[65.145922] Starting dynamic subtest: pipe-C-eDP-1
[66.505382] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.366s)
[66.512949] Starting dynamic subtest: pipe-D-eDP-1
[67.841795] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.337s)
[67.843855] Subtest ctm-negative: SUCCESS (4.819s)
[68.668869] [005/131] (947s left) syncobj_eventfd (timeline-wait-signaled)
[68.726378] Starting subtest: timeline-wait-signaled
[68.728760] Subtest timeline-wait-signaled: SUCCESS (0.000s)
[68.864158] [006/131] (947s left) gem_exec_balancer (hog)
[68.921637] Starting subtest: hog
[68.926373] Subtest hog: SKIP (0.000s)
[69.245720] [007/131] (947s left) gem_partial_pwrite_pread (writes-after-reads-display)
[69.297230] Subtest writes-after-reads-display: SKIP (0.000s)
[69.365996] [008/131] (947s left) i915_drm_fdinfo (context-close-stress)
[69.405109] Starting subtest: context-close-stress
[80.151616] Subtest context-close-stress: SUCCESS (10.745s)
[80.229969] [009/131] (936s left) i915_drm_fdinfo (memory-info-active)
[80.269889] Starting subtest: memory-info-active
[80.272209] Starting dynamic subtest: smem0
[83.096584] Dynamic subtest smem0: SUCCESS (2.828s)
[83.098872] Subtest memory-info-active: SUCCESS (2.828s)
[83.182553] [010/131] (933s left) syncobj_timeline (single-wait-for-submit-signaled)
[83.237272] Starting subtest: single-wait-for-submit-signaled
[83.239172] Subtest single-wait-for-submit-signaled: SUCCESS (0.000s)
[83.365272] [011/131] (933s left) kms_pm_dc (dc5-psr)
[84.475102] Starting subtest: dc5-psr
[87.335213] Subtest dc5-psr: SUCCESS (2.861s)
[88.211195] [012/131] (928s left) kms_big_fb (linear-16bpp-rotate-0)
[88.320289] Starting subtest: linear-16bpp-rotate-0
[89.721485] Subtest linear-16bpp-rotate-0: SUCCESS (1.400s)
[89.851781] [013/131] (926s left) perf (non-system-wide-paranoid)
[89.976076] Starting subtest: non-system-wide-paranoid
[90.001543] Subtest non-system-wide-paranoid: SUCCESS (0.027s)
[90.036220] [014/131] (926s left) gem_exec_schedule (semaphore-resolve)
[90.100908] Starting subtest: semaphore-resolve
[90.134498] Subtest semaphore-resolve: SUCCESS (0.039s)
[90.499721] [015/131] (926s left) kms_frontbuffer_tracking (psr-indfb-scaledprimary)
[90.590730] Starting subtest: psr-indfb-scaledprimary
[96.351596] Subtest psr-indfb-scaledprimary: SUCCESS (5.763s)
[96.497462] [016/131] (920s left) kms_cursor_crc (cursor-sliding-32x32)
[96.645094] Starting subtest: cursor-sliding-32x32
[96.687624] Subtest cursor-sliding-32x32: SKIP (0.038s)
[97.003159] [017/131] (919s left) api_intel_bb (blit-reloc-purge-cache)
[97.054966] Starting subtest: blit-reloc-purge-cache
[97.059337] Subtest blit-reloc-purge-cache: SKIP (0.000s)
[97.181485] [018/131] (919s left) gem_exec_whisper (basic-queues-priority)
[97.237507] Starting subtest: basic-queues-priority
[120.142903] Subtest basic-queues-priority: SUCCESS (22.901s)
[120.337829] [019/131] (896s left) kms_psr2_sf (fbc-pr-overlay-plane-move-continuous-sf)
[125.410721] Starting subtest: fbc-pr-overlay-plane-move-continuous-sf
[125.415978] Subtest fbc-pr-overlay-plane-move-continuous-sf: SKIP (0.002s)
[126.275624] [020/131] (890s left) kms_psr2_sf (pr-cursor-plane-update-sf)
[131.250738] Starting subtest: pr-cursor-plane-update-sf
[131.255732] Subtest pr-cursor-plane-update-sf: SKIP (0.002s)
[132.117255] [021/131] (884s left) kms_atomic_transition (plane-all-modeset-transition-fencing-internal-panels)
[132.208073] Starting subtest: plane-all-modeset-transition-fencing-internal-panels
[132.209957] Starting dynamic subtest: pipe-A-eDP-1
[133.541629] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.333s)
[133.825434] Starting dynamic subtest: pipe-B-eDP-1
[134.856682] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.041s)
[135.122522] Subtest plane-all-modeset-transition-fencing-internal-panels: SUCCESS (2.915s)
[135.993273] [022/131] (880s left) i915_module_load (reload-with-fault-injection)
[136.029255] Starting subtest: reload-with-fault-injection
[170.990222] Subtest reload-with-fault-injection: SUCCESS (34.957s)
[171.017412] [FACT i915_module_load (reload-with-fault-injection)] deleted: kernel.kmod_is_loaded.i915: true
[171.020430] [023/131] (845s left) kms_draw_crc (draw-method-mmap-cpu)
[172.529722] Starting subtest: draw-method-mmap-cpu
[172.531985] Starting dynamic subtest: xrgb8888-untiled
[172.760690] Dynamic subtest xrgb8888-untiled: SUCCESS (0.232s)
[172.769075] Starting dynamic subtest: rgb565-untiled
[172.949539] Dynamic subtest rgb565-untiled: SUCCESS (0.189s)
[172.958026] Starting dynamic subtest: xrgb2101010-untiled
[173.127463] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.177s)
[173.136058] Starting dynamic subtest: xbgr16161616f-untiled
[173.316305] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.188s)
[173.324392] Starting dynamic subtest: xrgb8888-xtiled
[173.449195] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.133s)
[173.458230] Starting dynamic subtest: rgb565-xtiled
[173.571568] Dynamic subtest rgb565-xtiled: SUCCESS (0.122s)
[173.579530] Starting dynamic subtest: xrgb2101010-xtiled
[173.693755] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.122s)
[173.702510] Starting dynamic subtest: xbgr16161616f-xtiled
[173.827121] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.133s)
[173.836723] Starting dynamic subtest: xrgb8888-4tiled
[173.971364] Dynamic subtest xrgb8888-4tiled: SUCCESS (0.144s)
[173.978751] Starting dynamic subtest: rgb565-4tiled
[174.104750] Dynamic subtest rgb565-4tiled: SUCCESS (0.133s)
[174.114410] Starting dynamic subtest: xrgb2101010-4tiled
[174.227073] Dynamic subtest xrgb2101010-4tiled: SUCCESS (0.122s)
[174.235852] Starting dynamic subtest: xbgr16161616f-4tiled
[174.360377] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (0.133s)
[174.362215] Subtest draw-method-mmap-cpu: SUCCESS (1.833s)
[174.458980] [FACT kms_draw_crc (draw-method-mmap-cpu)] new: kernel.kmod_is_loaded.i915: true
[174.462638] [024/131] (842s left) gem_mmap_gtt (pf-nonblock)
[174.526746] Subtest pf-nonblock: SKIP (0.000s)
[174.579693] [025/131] (842s left) gem_eio (in-flight-internal-1us)
[174.727706] Starting subtest: in-flight-internal-1us
[175.926313] Subtest in-flight-internal-1us: SUCCESS (1.198s)
[176.093955] [026/131] (840s left) sysfs_preempt_timeout (idempotent)
[176.143034] Starting subtest: idempotent
[176.145302] Starting dynamic subtest: vecs0
[176.147509] Dynamic subtest vecs0: SUCCESS (0.000s)
[176.155878] Starting dynamic subtest: ccs0
[176.158073] Dynamic subtest ccs0: SUCCESS (0.000s)
[176.166116] Starting dynamic subtest: vcs0
[176.168301] Dynamic subtest vcs0: SUCCESS (0.000s)
[176.176248] Starting dynamic subtest: bcs0
[176.178477] Dynamic subtest bcs0: SUCCESS (0.000s)
[176.186539] Starting dynamic subtest: rcs0
[176.188790] Dynamic subtest rcs0: SUCCESS (0.000s)
[176.196830] Starting dynamic subtest: vcs1
[176.199032] Dynamic subtest vcs1: SUCCESS (0.000s)
[176.201188] Subtest idempotent: SUCCESS (0.005s)
[176.280506] [027/131] (840s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-render)
[176.378401] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-render
[183.071785] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-render: SUCCESS (6.696s)
[183.243821] [028/131] (833s left) gem_lmem_swapping (heavy-random)
[183.281958] Subtest heavy-random: SKIP (0.000s)
[183.323146] [029/131] (833s left) gem_exec_fence (syncobj-timeline-wait)
[183.847349] Starting subtest: syncobj-timeline-wait
[184.945038] Subtest syncobj-timeline-wait: SUCCESS (1.098s)
[186.977613] [FACT gem_exec_fence (syncobj-timeline-wait)] new: kernel.kmod_is_loaded.vgem: true
[186.980817] [030/131] (830s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-pwrite)
[187.097430] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-pwrite
[187.101330] Subtest fbc-2p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[187.213124] [031/131] (830s left) gem_eio (in-flight-contexts-1us)
[187.374638] Starting subtest: in-flight-contexts-1us
[197.931335] Subtest in-flight-contexts-1us: SUCCESS (10.556s)
[198.136549] [032/131] (819s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-onoff)
[198.226899] Starting subtest: psr-2p-scndscrn-cur-indfb-onoff
[198.231305] Subtest psr-2p-scndscrn-cur-indfb-onoff: SKIP (0.000s)
[198.346929] [033/131] (818s left) kms_lease (lease-invalid-plane)
[198.443997] Starting subtest: lease-invalid-plane
[198.446246] Starting dynamic subtest: pipe-A-eDP-1
[198.448339] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[198.457178] Starting dynamic subtest: pipe-B-eDP-1
[198.459313] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[198.467767] Starting dynamic subtest: pipe-C-eDP-1
[198.470070] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[198.478839] Starting dynamic subtest: pipe-D-eDP-1
[198.481035] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[198.483169] Subtest lease-invalid-plane: SUCCESS (0.003s)
[198.527405] [034/131] (818s left) kms_cursor_crc (cursor-offscreen-512x170)
[198.822364] Starting subtest: cursor-offscreen-512x170
[198.826659] Subtest cursor-offscreen-512x170: SKIP (0.001s)
[198.978085] [035/131] (818s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0-async-flip)
[199.073574] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0-async-flip
[199.077379] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0-async-flip: SKIP (0.000s)
[199.172863] [036/131] (818s left) perf (gen12-invalid-class-instance)
[199.305979] Starting subtest: gen12-invalid-class-instance
[199.315079] Subtest gen12-invalid-class-instance: SUCCESS (0.009s)
[199.358383] [037/131] (818s left) gem_exec_balancer (busy)
[199.417172] Starting subtest: busy
[200.927885] Subtest busy: SUCCESS (1.509s)
[201.281859] [038/131] (816s left) kms_flip (plain-flip-ts-check)
[201.362322] Starting subtest: plain-flip-ts-check
[201.364629] Starting dynamic subtest: A-eDP1
[210.263966] Dynamic subtest A-eDP1: SUCCESS (8.900s)
[210.274777] Starting dynamic subtest: B-eDP1
[219.085627] Dynamic subtest B-eDP1: SUCCESS (8.821s)
[219.094890] Starting dynamic subtest: C-eDP1
[227.914856] Dynamic subtest C-eDP1: SUCCESS (8.828s)
[227.927575] Starting dynamic subtest: D-eDP1
[236.750452] Dynamic subtest D-eDP1: SUCCESS (8.835s)
[236.755499] Subtest plain-flip-ts-check: SUCCESS (35.391s)
[237.947334] [039/131] (779s left) kms_psr (psr-cursor-render)
[238.034218] Starting subtest: psr-cursor-render
[238.036502] Starting dynamic subtest: eDP-1
[239.739952] Dynamic subtest eDP-1: SUCCESS (1.706s)
[239.742225] Subtest psr-cursor-render: SUCCESS (1.707s)
[240.625901] [040/131] (776s left) kms_prime (basic-crc-vgem)
[240.712400] Starting subtest: basic-crc-vgem
[240.714821] Starting dynamic subtest: second-to-first
[241.646242] Dynamic subtest second-to-first: SUCCESS (0.938s)
[241.648076] Subtest basic-crc-vgem: SUCCESS (0.939s)
[241.765508] [041/131] (775s left) sw_sync (alloc_fence)
[241.796292] Starting subtest: alloc_fence
[241.798228] Subtest alloc_fence: SUCCESS (0.000s)
[241.861518] [042/131] (775s left) kms_plane_scaling (planes-unity-scaling-downscale-factor-0-5)
[242.001666] Starting subtest: planes-unity-scaling-downscale-factor-0-5
[242.003617] Starting dynamic subtest: pipe-A
[242.011111] Dynamic subtest pipe-A: SKIP (0.005s)
[242.020542] Starting dynamic subtest: pipe-B
[242.028265] Dynamic subtest pipe-B: SKIP (0.018s)
[242.036892] Starting dynamic subtest: pipe-C
[242.047764] Dynamic subtest pipe-C: SKIP (0.018s)
[242.056178] Starting dynamic subtest: pipe-D
[242.065782] Dynamic subtest pipe-D: SKIP (0.018s)
[242.068804] Subtest planes-unity-scaling-downscale-factor-0-5: SKIP (0.061s)
[242.178581] [043/131] (775s left) kms_flip (flip-vs-expired-vblank-interruptible)
[242.264985] Starting subtest: flip-vs-expired-vblank-interruptible
[242.267073] Starting dynamic subtest: A-eDP1
[250.897681] Dynamic subtest A-eDP1: SUCCESS (8.630s)
[250.909258] Starting dynamic subtest: B-eDP1
[259.531421] Dynamic subtest B-eDP1: SUCCESS (8.632s)
[259.543207] Starting dynamic subtest: C-eDP1
[268.151083] Dynamic subtest C-eDP1: SUCCESS (8.618s)
[268.161983] Starting dynamic subtest: D-eDP1
[276.787835] Dynamic subtest D-eDP1: SUCCESS (8.636s)
[276.793130] Subtest flip-vs-expired-vblank-interruptible: SUCCESS (34.526s)
[277.972264] [044/131] (739s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-32bpp-yftile-downscaling)
[278.058835] Starting subtest: flip-64bpp-yftile-to-32bpp-yftile-downscaling
[278.061214] Starting dynamic subtest: pipe-A-default-mode
[278.352209] Dynamic subtest pipe-A-default-mode: SKIP (0.289s)
[278.356656] Subtest flip-64bpp-yftile-to-32bpp-yftile-downscaling: SKIP (0.291s)
[279.212810] [045/131] (738s left) kms_ccs (bad-rotation-90-4-tiled-lnl-ccs)
[279.299262] Starting subtest: bad-rotation-90-4-tiled-lnl-ccs
[279.303804] Subtest bad-rotation-90-4-tiled-lnl-ccs: SKIP (0.000s)
[280.450009] [046/131] (737s left) syncobj_wait (wait-for-submit-snapshot)
[280.511973] Starting subtest: wait-for-submit-snapshot
[280.594117] Subtest wait-for-submit-snapshot: SUCCESS (0.082s)
[280.682100] [047/131] (737s left) kms_vblank (wait-busy-hang)
[280.777067] Starting subtest: wait-busy-hang
[280.778953] Starting dynamic subtest: pipe-A-eDP-1
[307.732053] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.951s)
[307.745554] Starting dynamic subtest: pipe-D-eDP-1
[332.695962] Dynamic subtest pipe-D-eDP-1: SUCCESS (24.960s)
[332.698240] Subtest wait-busy-hang: SUCCESS (51.916s)
[333.601488] [048/131] (684s left) gem_wait (invalid-buf)
[333.667995] Starting subtest: invalid-buf
[333.670417] Subtest invalid-buf: SUCCESS (0.000s)
[333.913935] [049/131] (684s left) kms_frontbuffer_tracking (pipe-fbc-rte)
[334.018097] Starting subtest: pipe-fbc-rte
[334.024608] Starting dynamic subtest: pipe-B-eDP-1
[339.470927] Dynamic subtest pipe-B-eDP-1: SUCCESS (5.456s)
[339.478609] Subtest pipe-fbc-rte: SUCCESS (5.458s)
[341.830880] [050/131] (676s left) gem_exec_reloc (basic-cpu-gtt-active)
[341.904225] Subtest basic-cpu-gtt-active: SKIP (0.000s)
[341.975021] [051/131] (676s left) gem_exec_params (secure-non-root)
[342.038052] Starting subtest: secure-non-root
[342.042268] Subtest secure-non-root: SKIP (0.000s)
[342.169912] [052/131] (675s left) kms_frontbuffer_tracking (fbc-1p-offscren-pri-shrfb-draw-pwrite)
[342.262127] Starting subtest: fbc-1p-offscren-pri-shrfb-draw-pwrite
[349.311294] Subtest fbc-1p-offscren-pri-shrfb-draw-pwrite: SUCCESS (7.051s)
[350.452274] [053/131] (667s left) gem_ctx_persistence (file)
[350.503651] Starting subtest: file
[350.618924] Subtest file: SUCCESS (0.115s)
[350.771376] [054/131] (667s left) fbdev (unaligned-write)
[350.818286] Starting subtest: unaligned-write
[350.919834] Subtest unaligned-write: SUCCESS (0.101s)
[350.997740] [055/131] (667s left) gem_userptr_blits (sync-unmap-cycles)
[351.064617] Starting subtest: sync-unmap-cycles
[356.445547] Subtest sync-unmap-cycles: SUCCESS (5.381s)
[356.619752] [056/131] (661s left) syncobj_wait (multi-wait-submitted-signaled)
[356.672601] Starting subtest: multi-wait-submitted-signaled
[356.674477] Subtest multi-wait-submitted-signaled: SUCCESS (0.000s)
[356.814270] [057/131] (661s left) gen9_exec_parse (allowed-all)
[356.878663] Subtest allowed-all: SKIP (0.000s)
[356.969783] [058/131] (661s left) kms_plane (planar-pixel-format-settings)
[357.073444] Starting subtest: planar-pixel-format-settings
[357.102076] Subtest planar-pixel-format-settings: SUCCESS (0.029s)
[357.225217] [059/131] (661s left) kms_psr (fbc-psr-sprite-mmap-gtt)
[357.311517] Starting subtest: fbc-psr-sprite-mmap-gtt
[357.313380] Starting dynamic subtest: eDP-1
[357.316857] Dynamic subtest eDP-1: SKIP (0.000s)
[357.320286] Subtest fbc-psr-sprite-mmap-gtt: SKIP (0.001s)
[357.407067] [060/131] (660s left) gem_basic (multigpu-create-close)
[357.467054] Starting subtest: multigpu-create-close
[357.470630] Subtest multigpu-create-close: SKIP (0.000s)
[357.626404] [061/131] (660s left) kms_busy (extended-modeset-hang-newfb)
[357.727713] Starting subtest: extended-modeset-hang-newfb
[357.729595] Starting dynamic subtest: pipe-A
[391.760064] Dynamic subtest pipe-A: SUCCESS (34.029s)
[391.770237] Starting dynamic subtest: pipe-D
[414.819092] Dynamic subtest pipe-D: SUCCESS (23.058s)
[414.821378] Subtest extended-modeset-hang-newfb: SUCCESS (57.091s)
[415.618726] [062/131] (602s left) kms_atomic (crtc-invalid-params)
[415.714200] Starting subtest: crtc-invalid-params
[415.716506] Starting dynamic subtest: pipe-A-eDP-1
[416.077346] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.363s)
[416.079602] Subtest crtc-invalid-params: SUCCESS (0.364s)
[416.947892] [063/131] (601s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-onoff)
[417.047093] Starting subtest: fbc-2p-scndscrn-cur-indfb-onoff
[417.051510] Subtest fbc-2p-scndscrn-cur-indfb-onoff: SKIP (0.000s)
[417.167160] [064/131] (601s left) gem_userptr_blits (invalid-null-pointer)
[417.229504] Starting subtest: invalid-null-pointer
[417.231423] Subtest invalid-null-pointer: SUCCESS (0.001s)
[417.371868] [065/131] (601s left) kms_frontbuffer_tracking (psr-1p-offscren-pri-indfb-draw-mmap-cpu)
[417.458677] Starting subtest: psr-1p-offscren-pri-indfb-draw-mmap-cpu
[424.096818] Subtest psr-1p-offscren-pri-indfb-draw-mmap-cpu: SUCCESS (6.640s)
[424.247048] [066/131] (594s left) kms_psr (pr-sprite-plane-move)
[424.352934] Starting subtest: pr-sprite-plane-move
[424.357132] Subtest pr-sprite-plane-move: SKIP (0.000s)
[424.453356] [067/131] (594s left) kms_cursor_crc (cursor-onscreen-512x170)
[424.752765] Starting subtest: cursor-onscreen-512x170
[424.757211] Subtest cursor-onscreen-512x170: SKIP (0.001s)
[424.943361] [068/131] (593s left) kms_big_fb (yf-tiled-32bpp-rotate-270)
[425.051222] Starting subtest: yf-tiled-32bpp-rotate-270
[425.055634] Subtest yf-tiled-32bpp-rotate-270: SKIP (0.000s)
[425.172839] [069/131] (593s left) gem_mmap_gtt (fault-concurrent)
[425.234564] Subtest fault-concurrent: SKIP (0.000s)
[425.292481] [070/131] (593s left) perf_pmu (semaphore-busy)
[425.332483] Starting subtest: semaphore-busy
[425.334065] Starting dynamic subtest: rcs0
[427.010867] Dynamic subtest rcs0: SUCCESS (1.674s)
[427.022439] Starting dynamic subtest: bcs0
[428.640968] Dynamic subtest bcs0: SUCCESS (1.628s)
[428.652524] Starting dynamic subtest: vcs0
[432.397475] Dynamic subtest vcs0: SUCCESS (3.754s)
[432.409090] Starting dynamic subtest: vcs1
[438.414707] Dynamic subtest vcs1: SUCCESS (6.015s)
[438.424106] Starting dynamic subtest: vecs0
[444.430536] Dynamic subtest vecs0: SUCCESS (6.013s)
[444.441845] Starting dynamic subtest: ccs0
[447.504907] Dynamic subtest ccs0: SUCCESS (3.072s)
[447.507879] Subtest semaphore-busy: SUCCESS (22.169s)
[447.640303] [071/131] (571s left) prime_mmap (test_correct_cpu_write)
[447.701236] Starting subtest: test_correct_cpu_write
[447.703508] Starting dynamic subtest: test_correct_cpu_write-smem
[447.705432] Dynamic subtest test_correct_cpu_write-smem: SUCCESS (0.000s)
[447.707323] Subtest test_correct_cpu_write: SUCCESS (0.001s)
[447.822153] [072/131] (571s left) gem_mmap (basic-small-bo)
[447.883842] Subtest basic-small-bo: SKIP (0.000s)
[447.951405] [073/131] (570s left) kms_chamelium_color (ctm-red-to-blue)
[448.039187] Subtest ctm-red-to-blue: SKIP (0.000s)
[448.086635] [074/131] (570s left) gem_mmap_offset (clear-via-pagefault)
[448.142054] Starting subtest: clear-via-pagefault
[448.144543] Starting dynamic subtest: smem0
[481.805061] Dynamic subtest smem0: SUCCESS (33.655s)
[481.807161] Subtest clear-via-pagefault: SUCCESS (33.657s)
[481.930646] [075/131] (537s left) kms_ccs (bad-aux-stride-4-tiled-mtl-mc-ccs)
[482.030970] Starting subtest: bad-aux-stride-4-tiled-mtl-mc-ccs
[482.033233] Starting dynamic subtest: pipe-A-eDP-1
[482.091954] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.061s)
[482.106752] Starting dynamic subtest: pipe-B-eDP-1
[482.154252] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.063s)
[482.163979] Starting dynamic subtest: pipe-C-eDP-1
[482.216043] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.059s)
[482.225876] Starting dynamic subtest: pipe-D-eDP-1
[482.279109] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.062s)
[482.281375] Subtest bad-aux-stride-4-tiled-mtl-mc-ccs: SUCCESS (0.249s)
[484.446711] [076/131] (534s left) kms_frontbuffer_tracking (fbc-1p-primscrn-indfb-plflip-blt)
[484.548816] Starting subtest: fbc-1p-primscrn-indfb-plflip-blt
[489.180485] Subtest fbc-1p-primscrn-indfb-plflip-blt: SUCCESS (4.635s)
[490.347235] [077/131] (528s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-pwrite)
[490.449598] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-pwrite
[490.453961] Subtest psr-2p-scndscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[490.575341] [078/131] (528s left) kms_ccs (missing-ccs-buffer-4-tiled-mtl-rc-ccs)
[490.674107] Starting subtest: missing-ccs-buffer-4-tiled-mtl-rc-ccs
[490.676270] Starting dynamic subtest: pipe-A-eDP-1
[490.696728] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[490.708042] Starting dynamic subtest: pipe-B-eDP-1
[490.727363] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[490.735922] Starting dynamic subtest: pipe-C-eDP-1
[490.756039] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[490.765231] Starting dynamic subtest: pipe-D-eDP-1
[490.784611] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[490.786558] Subtest missing-ccs-buffer-4-tiled-mtl-rc-ccs: SUCCESS (0.005s)
[493.002158] [079/131] (526s left) kms_selftest (drm_plane_helper)
[493.040079] Starting subtest: drm_plane_helper
[493.081572] Starting dynamic subtest: drm_test_check_plane_state
[493.191203] Dynamic subtest drm_test_check_plane_state: SUCCESS (0.111s)
[493.202365] Starting dynamic subtest: drm_test_check_invalid_plane_state
[493.341907] Dynamic subtest drm_test_check_invalid_plane_state: SUCCESS (0.149s)
[493.344239] Subtest drm_plane_helper: SUCCESS (0.301s)
[493.544318] [080/131] (525s left) kms_flip_scaled_crc (flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling)
[493.634120] Starting subtest: flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling
[493.636395] Starting dynamic subtest: pipe-A-default-mode
[493.940550] Dynamic subtest pipe-A-default-mode: SKIP (0.304s)
[493.944745] Subtest flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling: SKIP (0.305s)
[494.726162] [081/131] (524s left) kms_invalid_mode (bad-hsync-start)
[494.827465] Starting subtest: bad-hsync-start
[494.829765] Starting dynamic subtest: pipe-A-eDP-1
[495.110533] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.285s)
[495.120916] Starting dynamic subtest: pipe-B-eDP-1
[495.122839] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[495.131648] Starting dynamic subtest: pipe-C-eDP-1
[495.133923] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[495.142598] Starting dynamic subtest: pipe-D-eDP-1
[495.144555] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[495.146507] Subtest bad-hsync-start: SUCCESS (0.290s)
[495.971348] [082/131] (523s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-mmap-gtt)
[496.075258] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-mmap-gtt
[496.079540] Subtest fbc-2p-scndscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[496.205167] [083/131] (523s left) kms_flip (plain-flip-interruptible)
[496.299478] Starting subtest: plain-flip-interruptible
[496.301835] Starting dynamic subtest: A-eDP1
[497.958555] Dynamic subtest A-eDP1: SUCCESS (1.658s)
[497.969094] Starting dynamic subtest: B-eDP1
[499.591078] Dynamic subtest B-eDP1: SUCCESS (1.632s)
[499.602499] Starting dynamic subtest: C-eDP1
[501.209753] Dynamic subtest C-eDP1: SUCCESS (1.618s)
[501.220234] Starting dynamic subtest: D-eDP1
[502.841427] Dynamic subtest D-eDP1: SUCCESS (1.631s)
[502.843791] Subtest plain-flip-interruptible: SUCCESS (6.545s)
[504.031182] [084/131] (515s left) gem_vm_create (invalid-create)
[504.085447] Starting subtest: invalid-create
[504.087763] Subtest invalid-create: SUCCESS (0.002s)
[504.217048] [085/131] (515s left) kms_pipe_crc_basic (nonblocking-crc)
[504.312133] Starting subtest: nonblocking-crc
[504.313919] Starting dynamic subtest: pipe-A-eDP-1
[505.045575] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.734s)
[505.055150] Starting dynamic subtest: pipe-B-eDP-1
[506.408133] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.362s)
[506.418859] Starting dynamic subtest: pipe-C-eDP-1
[507.804822] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.396s)
[507.814595] Starting dynamic subtest: pipe-D-eDP-1
[509.134239] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.328s)
[509.136667] Subtest nonblocking-crc: SUCCESS (4.824s)
[509.946680] [086/131] (509s left) gem_ctx_persistence (many-contexts)
[510.013745] Starting subtest: many-contexts
[547.715568] Subtest many-contexts: SUCCESS (37.700s)
[547.805163] [087/131] (471s left) kms_plane (plane-position-covered)
[547.896039] Starting subtest: plane-position-covered
[548.386174] Starting dynamic subtest: pipe-A-plane-1
[549.695699] Dynamic subtest pipe-A-plane-1: SUCCESS (1.309s)
[549.708027] Starting dynamic subtest: pipe-A-plane-2
[550.915655] Dynamic subtest pipe-A-plane-2: SUCCESS (1.219s)
[550.925860] Starting dynamic subtest: pipe-A-plane-3
[552.179417] Dynamic subtest pipe-A-plane-3: SUCCESS (1.262s)
[552.189138] Starting dynamic subtest: pipe-A-plane-4
[553.492075] Dynamic subtest pipe-A-plane-4: SUCCESS (1.313s)
[553.502445] Starting dynamic subtest: pipe-A-plane-5
[553.519819] Dynamic subtest pipe-A-plane-5: SUCCESS (0.025s)
[554.658069] Starting dynamic subtest: pipe-B-plane-1
[555.871072] Dynamic subtest pipe-B-plane-1: SUCCESS (1.224s)
[555.882192] Starting dynamic subtest: pipe-B-plane-2
[557.095032] Dynamic subtest pipe-B-plane-2: SUCCESS (1.223s)
[557.108630] Starting dynamic subtest: pipe-B-plane-3
[558.326412] Dynamic subtest pipe-B-plane-3: SUCCESS (1.230s)
[558.336879] Starting dynamic subtest: pipe-B-plane-4
[559.562755] Dynamic subtest pipe-B-plane-4: SUCCESS (1.235s)
[559.573087] Starting dynamic subtest: pipe-B-plane-5
[559.586892] Dynamic subtest pipe-B-plane-5: SUCCESS (0.023s)
[559.589208] Subtest plane-position-covered: SUCCESS (11.691s)
[560.376654] [088/131] (459s left) kms_psr (fbc-psr2-primary-blt)
[560.466055] Starting subtest: fbc-psr2-primary-blt
[560.468174] Starting dynamic subtest: eDP-1
[560.472119] Dynamic subtest eDP-1: SKIP (0.000s)
[560.476084] Subtest fbc-psr2-primary-blt: SKIP (0.001s)
[560.563082] [089/131] (459s left) kms_frontbuffer_tracking (fbcpsr-1p-offscren-pri-shrfb-draw-pwrite)
[560.663781] Starting subtest: fbcpsr-1p-offscren-pri-shrfb-draw-pwrite
[570.007369] Subtest fbcpsr-1p-offscren-pri-shrfb-draw-pwrite: SUCCESS (9.345s)
[570.179893] [090/131] (449s left) kms_ccs (crc-primary-suspend-4-tiled-dg2-rc-ccs-cc)
[570.278054] Starting subtest: crc-primary-suspend-4-tiled-dg2-rc-ccs-cc
[570.280219] Starting dynamic subtest: pipe-A-eDP-1
[570.289162] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[570.299357] Starting dynamic subtest: pipe-B-eDP-1
[570.308239] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[570.317135] Starting dynamic subtest: pipe-C-eDP-1
[570.325272] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[570.334345] Starting dynamic subtest: pipe-D-eDP-1
[570.342730] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[570.346893] Subtest crc-primary-suspend-4-tiled-dg2-rc-ccs-cc: SKIP (0.004s)
[572.449423] [091/131] (447s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-blt)
[572.539071] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-blt
[572.543065] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-blt: SKIP (0.000s)
[572.675948] [092/131] (447s left) kms_addfb_basic (bo-too-small)
[572.757980] Starting subtest: bo-too-small
[572.760400] Subtest bo-too-small: SUCCESS (0.000s)
[572.885239] [093/131] (446s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180-async-flip)
[572.994356] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180-async-flip
[573.796707] Subtest x-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SUCCESS (0.803s)
[573.993267] [094/131] (445s left) gem_exec_reloc (basic-cpu-gtt)
[574.057028] Subtest basic-cpu-gtt: SKIP (0.000s)
[574.154240] [095/131] (445s left) kms_addfb_basic (addfb25-x-tiled-legacy)
[574.248098] Subtest addfb25-x-tiled-legacy: SKIP (0.000s)
[574.378351] [096/131] (445s left) syncobj_timeline (multi-wait-all-for-submit-available-submitted)
[574.444296] Starting subtest: multi-wait-all-for-submit-available-submitted
[574.446297] Subtest multi-wait-all-for-submit-available-submitted: SUCCESS (0.000s)
[574.573630] [097/131] (445s left) kms_big_fb (linear-64bpp-rotate-180)
[574.662408] Starting subtest: linear-64bpp-rotate-180
[576.173833] Subtest linear-64bpp-rotate-180: SUCCESS (1.511s)
[576.374701] [098/131] (443s left) gem_render_copy (x-tiled-to-vebox-yf-tiled)
[576.434999] Starting subtest: x-tiled-to-vebox-yf-tiled
[576.439557] Subtest x-tiled-to-vebox-yf-tiled: SKIP (0.000s)
[576.643049] [099/131] (443s left) kms_cursor_legacy (short-flip-after-cursor-atomic-transitions)
[576.766640] Starting subtest: short-flip-after-cursor-atomic-transitions
[577.720480] Subtest short-flip-after-cursor-atomic-transitions: SUCCESS (0.953s)
[578.567394] [100/131] (441s left) kms_ccs (random-ccs-data-4-tiled-dg2-mc-ccs)
[578.675382] Starting subtest: random-ccs-data-4-tiled-dg2-mc-ccs
[578.677660] Starting dynamic subtest: pipe-A-eDP-1
[578.703214] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[578.713991] Starting dynamic subtest: pipe-B-eDP-1
[578.737799] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[578.747253] Starting dynamic subtest: pipe-C-eDP-1
[578.770958] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[578.779334] Starting dynamic subtest: pipe-D-eDP-1
[578.803318] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[578.807747] Subtest random-ccs-data-4-tiled-dg2-mc-ccs: SKIP (0.004s)
[580.947747] [101/131] (439s left) gem_exec_schedule (thriceslice)
[581.018721] Starting subtest: thriceslice
[581.021106] Starting dynamic subtest: rcs0
[581.036557] Dynamic subtest rcs0: SUCCESS (0.029s)
[581.048216] Starting dynamic subtest: bcs0
[581.064365] Dynamic subtest bcs0: SUCCESS (0.027s)
[581.073944] Starting dynamic subtest: vcs0
[581.115242] Dynamic subtest vcs0: SUCCESS (0.050s)
[581.130297] Starting dynamic subtest: vcs1
[581.146711] Dynamic subtest vcs1: SUCCESS (0.030s)
[581.159177] Starting dynamic subtest: vecs0
[581.174812] Dynamic subtest vecs0: SUCCESS (0.028s)
[581.184458] Starting dynamic subtest: ccs0
[581.206705] Dynamic subtest ccs0: SUCCESS (0.030s)
[581.209024] Subtest thriceslice: SUCCESS (0.200s)
[581.521153] [102/131] (438s left) prime_self_import (export-vs-gem_close-race)
[581.555592] Starting subtest: export-vs-gem_close-race
[586.663480] Subtest export-vs-gem_close-race: SUCCESS (5.105s)
[586.757903] [103/131] (433s left) kms_atomic_transition (plane-all-transition-fencing)
[586.859950] Starting subtest: plane-all-transition-fencing
[586.862385] Starting dynamic subtest: pipe-A-eDP-1
[589.362137] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.504s)
[589.673729] Starting dynamic subtest: pipe-B-eDP-1
[592.861442] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.195s)
[593.175578] Subtest plane-all-transition-fencing: SUCCESS (6.317s)
[594.003552] [104/131] (426s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-move)
[594.106858] Starting subtest: psr-1p-primscrn-cur-indfb-move
[601.342197] Subtest psr-1p-primscrn-cur-indfb-move: SUCCESS (7.237s)
[601.514133] [105/131] (418s left) gem_mmap_gtt (basic-write-cpu-read-gtt)
[601.577560] Subtest basic-write-cpu-read-gtt: SKIP (0.000s)
[601.647411] [106/131] (418s left) api_intel_allocator (fork-simple-once)
[601.697258] Starting subtest: fork-simple-once
[601.708371] Subtest fork-simple-once: SUCCESS (0.013s)
[601.849177] [107/131] (418s left) gem_exec_fence (submit)
[602.018540] Starting subtest: submit
[602.023174] Subtest submit: SKIP (0.000s)
[604.030364] [108/131] (416s left) gem_ringfill (engines-basic)
[609.880597] Starting subtest: engines-basic
[609.883441] Starting dynamic subtest: rcs0
[609.974750] Dynamic subtest rcs0: SUCCESS (0.094s)
[609.987069] Starting dynamic subtest: bcs0
[610.020814] Dynamic subtest bcs0: SUCCESS (0.044s)
[610.031396] Starting dynamic subtest: vcs0
[610.063106] Dynamic subtest vcs0: SUCCESS (0.041s)
[610.073914] Starting dynamic subtest: vcs1
[610.105331] Dynamic subtest vcs1: SUCCESS (0.041s)
[610.116570] Starting dynamic subtest: vecs0
[610.149057] Dynamic subtest vecs0: SUCCESS (0.042s)
[610.160578] Starting dynamic subtest: ccs0
[610.193706] Dynamic subtest ccs0: SUCCESS (0.043s)
[610.196115] Subtest engines-basic: SUCCESS (0.315s)
[610.289834] [109/131] (410s left) gem_exec_reloc (basic-wc-read-active)
[610.356917] Subtest basic-wc-read-active: SKIP (0.000s)
[610.440775] [110/131] (410s left) kms_cursor_legacy (forked-move)
[610.571451] Starting subtest: forked-move
[610.573357] Starting dynamic subtest: pipe-A
[616.043169] Dynamic subtest pipe-A: SUCCESS (5.470s)
[616.055420] Starting dynamic subtest: pipe-B
[621.515425] Dynamic subtest pipe-B: SUCCESS (5.470s)
[621.529696] Starting dynamic subtest: pipe-C
[627.004712] Dynamic subtest pipe-C: SUCCESS (5.473s)
[627.019942] Starting dynamic subtest: pipe-D
[632.462033] Dynamic subtest pipe-D: SUCCESS (5.467s)
[632.474261] Starting dynamic subtest: all-pipes
[637.961894] Dynamic subtest all-pipes: SUCCESS (5.499s)
[637.964463] Subtest forked-move: SUCCESS (27.389s)
[638.134741] [111/131] (382s left) kms_chamelium_hpd (dp-hpd-after-suspend)
[638.526211] Subtest dp-hpd-after-suspend: SKIP (0.000s)
[639.312929] [112/131] (381s left) syncobj_wait (multi-wait-all-for-submit-submitted-signaled)
[639.359989] Starting subtest: multi-wait-all-for-submit-submitted-signaled
[639.462608] Subtest multi-wait-all-for-submit-submitted-signaled: SUCCESS (0.102s)
[639.568185] [113/131] (381s left) prime_mmap (test_userptr)
[639.617704] Starting subtest: test_userptr
[639.620066] Starting dynamic subtest: test_userptr-smem
[639.622268] Dynamic subtest test_userptr-smem: SUCCESS (0.000s)
[639.624479] Subtest test_userptr: SUCCESS (0.002s)
[639.741577] [114/131] (380s left) gem_close_race (basic-threads)
[639.801990] Starting subtest: basic-threads
[641.227068] Subtest basic-threads: SUCCESS (1.425s)
[641.419376] [115/131] (379s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-blt)
[641.521530] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-blt
[641.525894] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-blt: SKIP (0.000s)
[641.622547] [116/131] (379s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling)
[641.719065] Starting subtest: flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling
[641.721313] Starting dynamic subtest: pipe-A-default-mode
[642.006665] Dynamic subtest pipe-A-default-mode: SKIP (0.285s)
[642.011549] Subtest flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling: SKIP (0.286s)
[642.875761] [117/131] (377s left) gem_ctx_create (basic-files)
[642.931310] Starting subtest: basic-files
[645.007918] Subtest basic-files: SUCCESS (2.076s)
[646.988958] [118/131] (373s left) kms_psr (fbc-pr-dpms)
[647.093842] Starting subtest: fbc-pr-dpms
[647.098151] Subtest fbc-pr-dpms: SKIP (0.000s)
[647.181143] [119/131] (373s left) gem_tiled_wc
[647.301833] [120/131] (373s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-indfb-plflip-blt)
[647.402730] Starting subtest: fbcpsr-2p-scndscrn-indfb-plflip-blt
[647.406736] Subtest fbcpsr-2p-scndscrn-indfb-plflip-blt: SKIP (0.000s)
[647.531299] [121/131] (373s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-render)
[647.635194] Starting subtest: psr-2p-primscrn-cur-indfb-draw-render
[647.639122] Subtest psr-2p-primscrn-cur-indfb-draw-render: SKIP (0.000s)
[647.768181] [122/131] (373s left) kms_big_fb (4-tiled-32bpp-rotate-0)
[647.859315] Starting subtest: 4-tiled-32bpp-rotate-0
[649.238033] Subtest 4-tiled-32bpp-rotate-0: SUCCESS (1.378s)
[649.403923] [123/131] (371s left) kms_sequence (queue-busy)
[649.513293] Starting subtest: queue-busy
[649.514832] Starting dynamic subtest: pipe-A-eDP-1
[651.442724] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.928s)
[651.452292] Starting dynamic subtest: pipe-B-eDP-1
[654.064698] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.622s)
[654.074734] Starting dynamic subtest: pipe-C-eDP-1
[656.673051] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.604s)
[656.683414] Starting dynamic subtest: pipe-D-eDP-1
[659.215101] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.543s)
[659.217678] Subtest queue-busy: SUCCESS (9.702s)
[660.013405] [124/131] (361s left) gem_exec_schedule (implicit-read-write)
[660.087168] Starting subtest: implicit-read-write
[660.089457] Starting dynamic subtest: rcs0
[660.195861] Dynamic subtest rcs0: SUCCESS (0.116s)
[660.208105] Starting dynamic subtest: vcs0
[660.279600] Dynamic subtest vcs0: SUCCESS (0.083s)
[660.290523] Starting dynamic subtest: vcs1
[660.357735] Dynamic subtest vcs1: SUCCESS (0.077s)
[660.369901] Starting dynamic subtest: vecs0
[660.436097] Dynamic subtest vecs0: SUCCESS (0.078s)
[660.447359] Starting dynamic subtest: ccs0
[660.525485] Dynamic subtest ccs0: SUCCESS (0.089s)
[660.527934] Subtest implicit-read-write: SUCCESS (0.447s)
[662.045187] [125/131] (359s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling)
[662.143123] Subtest addfb25-framebuffer-vs-set-tiling: SKIP (0.000s)
[662.273174] [126/131] (358s left) i915_pm_rpm (system-suspend)
[664.097868] Starting subtest: system-suspend
[682.529949] Subtest system-suspend: SUCCESS (2.971s)
[682.890057] [127/131] (338s left) dmabuf (all-tests)
[682.932081] Starting subtest: all-tests
[682.934246] Starting dynamic subtest: sanitycheck
[683.075934] Dynamic subtest sanitycheck: SUCCESS (0.148s)
[683.089212] Starting dynamic subtest: dma_fence
[683.314535] Dynamic subtest dma_fence: SUCCESS (0.246s)
[683.325923] Starting dynamic subtest: dma_fence_chain
[691.498253] Dynamic subtest dma_fence_chain: SUCCESS (8.369s)
[691.511116] Starting dynamic subtest: dma_fence_unwrap
[691.626969] Dynamic subtest dma_fence_unwrap: SUCCESS (0.129s)
[691.639867] Starting dynamic subtest: dma_resv
[691.728057] Dynamic subtest dma_resv: SUCCESS (0.101s)
[691.730589] Subtest all-tests: SUCCESS (9.003s)
[691.828568] [128/131] (329s left) kms_addfb_basic (size-max)
[691.920392] Starting subtest: size-max
[691.922829] Subtest size-max: SUCCESS (0.000s)
[692.063426] [129/131] (329s left) syncobj_timeline (reset-signaled)
[692.117321] Starting subtest: reset-signaled
[692.119220] Subtest reset-signaled: SUCCESS (0.000s)
[692.217666] [130/131] (329s left) prime_busy (after-wait)
[692.274714] Starting subtest: after-wait
[692.276976] Starting dynamic subtest: rcs0
[692.329423] Dynamic subtest rcs0: SUCCESS (0.055s)
[692.341185] Starting dynamic subtest: bcs0
[692.388998] Dynamic subtest bcs0: SUCCESS (0.059s)
[692.398542] Starting dynamic subtest: vcs0
[692.428478] Dynamic subtest vcs0: SUCCESS (0.040s)
[692.438141] Starting dynamic subtest: vcs1
[692.469457] Dynamic subtest vcs1: SUCCESS (0.041s)
[692.479232] Starting dynamic subtest: vecs0
[692.510070] Dynamic subtest vecs0: SUCCESS (0.041s)
[692.519694] Starting dynamic subtest: ccs0
[692.549330] Dynamic subtest ccs0: SUCCESS (0.039s)
[692.655936] Subtest after-wait: SUCCESS (0.387s)
[692.745878] [131/131] (328s left) syncobj_timeline (invalid-query-bad-pad)
[692.790627] Starting subtest: invalid-query-bad-pad
[692.792795] Subtest invalid-query-bad-pad: SUCCESS (0.000s)
[692.901154] Closing watchdogs
results: parsing output: 0/ for test: gem_ctx_isolation
results: parsing output: 1/ for test: gem_pxp
results: parsing output: 2/ for test: gem_exec_reloc
results: parsing output: 3/ for test: kms_color
results: parsing output: 4/ for test: syncobj_eventfd
results: parsing output: 5/ for test: gem_exec_balancer
results: parsing output: 6/ for test: gem_partial_pwrite_pread
results: parsing output: 7/ for test: i915_drm_fdinfo
results: parsing output: 8/ for test: i915_drm_fdinfo
results: parsing output: 9/ for test: syncobj_timeline
results: parsing output: 10/ for test: kms_pm_dc
results: parsing output: 11/ for test: kms_big_fb
results: parsing output: 12/ for test: perf
results: parsing output: 13/ for test: gem_exec_schedule
results: parsing output: 14/ for test: kms_frontbuffer_tracking
results: parsing output: 15/ for test: kms_cursor_crc
results: parsing output: 16/ for test: api_intel_bb
results: parsing output: 17/ for test: gem_exec_whisper
results: parsing output: 18/ for test: kms_psr2_sf
results: parsing output: 19/ for test: kms_psr2_sf
results: parsing output: 20/ for test: kms_atomic_transition
results: parsing output: 21/ for test: i915_module_load
results: parsing output: 22/ for test: kms_draw_crc
results: parsing output: 23/ for test: gem_mmap_gtt
results: parsing output: 24/ for test: gem_eio
results: parsing output: 25/ for test: sysfs_preempt_timeout
results: parsing output: 26/ for test: kms_frontbuffer_tracking
results: parsing output: 27/ for test: gem_lmem_swapping
results: parsing output: 28/ for test: gem_exec_fence
results: parsing output: 29/ for test: kms_frontbuffer_tracking
results: parsing output: 30/ for test: gem_eio
results: parsing output: 31/ for test: kms_frontbuffer_tracking
results: parsing output: 32/ for test: kms_lease
results: parsing output: 33/ for test: kms_cursor_crc
results: parsing output: 34/ for test: kms_big_fb
results: parsing output: 35/ for test: perf
results: parsing output: 36/ for test: gem_exec_balancer
results: parsing output: 37/ for test: kms_flip
results: parsing output: 38/ for test: kms_psr
results: parsing output: 39/ for test: kms_prime
results: parsing output: 40/ for test: sw_sync
results: parsing output: 41/ for test: kms_plane_scaling
results: parsing output: 42/ for test: kms_flip
results: parsing output: 43/ for test: kms_flip_scaled_crc
results: parsing output: 44/ for test: kms_ccs
results: parsing output: 45/ for test: syncobj_wait
results: parsing output: 46/ for test: kms_vblank
results: parsing output: 47/ for test: gem_wait
results: parsing output: 48/ for test: kms_frontbuffer_tracking
results: parsing output: 49/ for test: gem_exec_reloc
results: parsing output: 50/ for test: gem_exec_params
results: parsing output: 51/ for test: kms_frontbuffer_tracking
results: parsing output: 52/ for test: gem_ctx_persistence
results: parsing output: 53/ for test: fbdev
results: parsing output: 54/ for test: gem_userptr_blits
results: parsing output: 55/ for test: syncobj_wait
results: parsing output: 56/ for test: gen9_exec_parse
results: parsing output: 57/ for test: kms_plane
results: parsing output: 58/ for test: kms_psr
results: parsing output: 59/ for test: gem_basic
results: parsing output: 60/ for test: kms_busy
results: parsing output: 61/ for test: kms_atomic
results: parsing output: 62/ for test: kms_frontbuffer_tracking
results: parsing output: 63/ for test: gem_userptr_blits
results: parsing output: 64/ for test: kms_frontbuffer_tracking
results: parsing output: 65/ for test: kms_psr
results: parsing output: 66/ for test: kms_cursor_crc
results: parsing output: 67/ for test: kms_big_fb
results: parsing output: 68/ for test: gem_mmap_gtt
results: parsing output: 69/ for test: perf_pmu
results: parsing output: 70/ for test: prime_mmap
results: parsing output: 71/ for test: gem_mmap
results: parsing output: 72/ for test: kms_chamelium_color
results: parsing output: 73/ for test: gem_mmap_offset
results: parsing output: 74/ for test: kms_ccs
results: parsing output: 75/ for test: kms_frontbuffer_tracking
results: parsing output: 76/ for test: kms_frontbuffer_tracking
results: parsing output: 77/ for test: kms_ccs
results: parsing output: 78/ for test: kms_selftest
results: parsing output: 79/ for test: kms_flip_scaled_crc
results: parsing output: 80/ for test: kms_invalid_mode
results: parsing output: 81/ for test: kms_frontbuffer_tracking
results: parsing output: 82/ for test: kms_flip
results: parsing output: 83/ for test: gem_vm_create
results: parsing output: 84/ for test: kms_pipe_crc_basic
results: parsing output: 85/ for test: gem_ctx_persistence
results: parsing output: 86/ for test: kms_plane
results: parsing output: 87/ for test: kms_psr
results: parsing output: 88/ for test: kms_frontbuffer_tracking
results: parsing output: 89/ for test: kms_ccs
results: parsing output: 90/ for test: kms_frontbuffer_tracking
results: parsing output: 91/ for test: kms_addfb_basic
results: parsing output: 92/ for test: kms_big_fb
results: parsing output: 93/ for test: gem_exec_reloc
results: parsing output: 94/ for test: kms_addfb_basic
results: parsing output: 95/ for test: syncobj_timeline
results: parsing output: 96/ for test: kms_big_fb
results: parsing output: 97/ for test: gem_render_copy
results: parsing output: 98/ for test: kms_cursor_legacy
results: parsing output: 99/ for test: kms_ccs
results: parsing output: 100/ for test: gem_exec_schedule
results: parsing output: 101/ for test: prime_self_import
results: parsing output: 102/ for test: kms_atomic_transition
results: parsing output: 103/ for test: kms_frontbuffer_tracking
results: parsing output: 104/ for test: gem_mmap_gtt
results: parsing output: 105/ for test: api_intel_allocator
results: parsing output: 106/ for test: gem_exec_fence
results: parsing output: 107/ for test: gem_ringfill
results: parsing output: 108/ for test: gem_exec_reloc
results: parsing output: 109/ for test: kms_cursor_legacy
results: parsing output: 110/ for test: kms_chamelium_hpd
results: parsing output: 111/ for test: syncobj_wait
results: parsing output: 112/ for test: prime_mmap
results: parsing output: 113/ for test: gem_close_race
results: parsing output: 114/ for test: kms_frontbuffer_tracking
results: parsing output: 115/ for test: kms_flip_scaled_crc
results: parsing output: 116/ for test: gem_ctx_create
results: parsing output: 117/ for test: kms_psr
results: parsing output: 118/ for test: gem_tiled_wc
results: parsing output: 119/ for test: kms_frontbuffer_tracking
results: parsing output: 120/ for test: kms_frontbuffer_tracking
results: parsing output: 121/ for test: kms_big_fb
results: parsing output: 122/ for test: kms_sequence
results: parsing output: 123/ for test: gem_exec_schedule
results: parsing output: 124/ for test: kms_addfb_basic
results: parsing output: 125/ for test: i915_pm_rpm
results: parsing output: 126/ for test: dmabuf
results: parsing output: 127/ for test: kms_addfb_basic
results: parsing output: 128/ for test: syncobj_timeline
results: parsing output: 129/ for test: prime_busy
results: parsing output: 130/ for test: syncobj_timeline
Done.