[57.628126] Initializing watchdogs
[57.628197]   /dev/watchdog0
[57.642509] [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]
[57.646974] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[57.649216] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[57.652707] [001/133] (960s left) gem_exec_fence (basic-await)
[57.856545] Starting subtest: basic-await
[57.859085] Starting dynamic subtest: rcs0
[57.938342] Dynamic subtest rcs0: SUCCESS (0.082s)
[57.948326] Starting dynamic subtest: bcs0
[58.018284] Dynamic subtest bcs0: SUCCESS (0.080s)
[58.027938] Starting dynamic subtest: vcs0
[58.095492] Dynamic subtest vcs0: SUCCESS (0.077s)
[58.105762] Starting dynamic subtest: vcs1
[58.169493] Dynamic subtest vcs1: SUCCESS (0.073s)
[58.178721] Starting dynamic subtest: vecs0
[58.244776] Dynamic subtest vecs0: SUCCESS (0.075s)
[58.254638] Starting dynamic subtest: ccs0
[58.320964] Dynamic subtest ccs0: SUCCESS (0.076s)
[58.323425] Subtest basic-await: SUCCESS (0.465s)
[59.988825] [FACT gem_exec_fence (basic-await)] new: kernel.kmod_is_loaded.vgem: true
[59.992469] [002/133] (958s left) kms_big_fb (linear-8bpp-rotate-0)
[60.101521] Starting subtest: linear-8bpp-rotate-0
[61.381213] Subtest linear-8bpp-rotate-0: SUCCESS (1.281s)
[61.513671] [003/133] (956s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu)
[61.613571] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu
[61.617324] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[61.691974] [004/133] (956s left) gem_exec_params (rel-constants-invalid)
[61.758166] Starting subtest: rel-constants-invalid
[61.760107] Subtest rel-constants-invalid: SUCCESS (0.000s)
[61.881192] [005/133] (956s left) kms_big_fb (4-tiled-addfb-size-offset-overflow)
[61.992837] Starting subtest: 4-tiled-addfb-size-offset-overflow
[61.994871] Subtest 4-tiled-addfb-size-offset-overflow: SUCCESS (0.000s)
[62.085425] [006/133] (956s left) gem_sync (basic-store-all)
[62.155775] Starting subtest: basic-store-all
[64.463510] Subtest basic-store-all: SUCCESS (2.316s)
[64.644919] [007/133] (953s left) gem_mmap_gtt (fault-concurrent-x)
[64.699635] Subtest fault-concurrent-X: SKIP (0.000s)
[64.762878] [008/133] (953s left) kms_chamelium_color (ctm-blue-to-red)
[64.855727] Subtest ctm-blue-to-red: SKIP (0.000s)
[64.899839] [009/133] (953s left) kms_flip_scaled_crc (flip-64bpp-linear-to-32bpp-linear-upscaling)
[64.992608] Starting subtest: flip-64bpp-linear-to-32bpp-linear-upscaling
[64.995125] Starting dynamic subtest: pipe-A-default-mode
[67.696870] Dynamic subtest pipe-A-default-mode: SUCCESS (2.702s)
[67.698857] Subtest flip-64bpp-linear-to-32bpp-linear-upscaling: SUCCESS (2.703s)
[68.528973] [010/133] (949s left) kms_hdr (static-toggle)
[68.631918] Starting subtest: static-toggle
[68.638257] Subtest static-toggle: SKIP (0.000s)
[68.701145] [011/133] (949s left) prime_vgem (fence-wait)
[68.765851] Starting subtest: fence-wait
[68.767692] Starting dynamic subtest: rcs0
[69.816383] Dynamic subtest rcs0: SUCCESS (1.049s)
[69.825303] Starting dynamic subtest: bcs0
[70.869433] Dynamic subtest bcs0: SUCCESS (1.053s)
[70.879263] Starting dynamic subtest: vcs0
[71.912171] Dynamic subtest vcs0: SUCCESS (1.042s)
[71.921121] Starting dynamic subtest: vcs1
[72.954815] Dynamic subtest vcs1: SUCCESS (1.041s)
[72.963753] Starting dynamic subtest: vecs0
[73.997719] Dynamic subtest vecs0: SUCCESS (1.041s)
[74.013695] Starting dynamic subtest: ccs0
[75.042519] Dynamic subtest ccs0: SUCCESS (1.044s)
[75.045065] Subtest fence-wait: SUCCESS (6.277s)
[75.172059] [012/133] (943s left) gen7_exec_parse (cmd-crossing-page)
[75.247261] Subtest cmd-crossing-page: SKIP (0.000s)
[75.318494] [013/133] (943s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc)
[75.417606] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc
[75.421814] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[75.510753] [014/133] (943s left) kms_chamelium_hpd (dp-hpd-storm)
[75.915709] Subtest dp-hpd-storm: SKIP (0.000s)
[76.742401] [015/133] (941s left) kms_ccs (crc-primary-rotation-180-4-tiled-mtl-rc-ccs-cc)
[76.844843] Starting subtest: crc-primary-rotation-180-4-tiled-mtl-rc-ccs-cc
[76.847220] Starting dynamic subtest: pipe-A-eDP-1
[77.734995] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.885s)
[77.742974] Starting dynamic subtest: pipe-B-eDP-1
[79.381806] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.642s)
[79.390691] Starting dynamic subtest: pipe-C-eDP-1
[80.900167] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.518s)
[80.909702] Starting dynamic subtest: pipe-D-eDP-1
[82.421245] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.521s)
[82.423870] Subtest crc-primary-rotation-180-4-tiled-mtl-rc-ccs-cc: SUCCESS (5.569s)
[83.594948] [016/133] (935s left) kms_content_protection (legacy-hdcp14)
[83.744083] Starting subtest: legacy-hdcp14
[83.748686] Subtest legacy-hdcp14: SKIP (0.000s)
[83.877218] [017/133] (934s left) kms_plane_multiple (tiling-yf)
[83.963825] Starting subtest: tiling-yf
[83.968055] Subtest tiling-yf: SKIP (0.000s)
[84.034594] [018/133] (934s left) kms_ccs (crc-primary-basic-4-tiled-bmg-ccs)
[84.131556] Starting subtest: crc-primary-basic-4-tiled-bmg-ccs
[84.136248] Subtest crc-primary-basic-4-tiled-bmg-ccs: SKIP (0.000s)
[85.223823] [019/133] (933s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-blt)
[85.328337] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-blt
[92.255711] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-blt: SUCCESS (6.931s)
[92.408494] [020/133] (926s left) kms_psr_stress_test (invalidate-primary-flip-overlay)
[92.507449] Starting subtest: invalidate-primary-flip-overlay
[103.281412] Subtest invalidate-primary-flip-overlay: SUCCESS (10.777s)
[103.396869] [021/133] (915s left) kms_big_fb (y-tiled-32bpp-rotate-180)
[103.503808] Starting subtest: y-tiled-32bpp-rotate-180
[103.507500] Subtest y-tiled-32bpp-rotate-180: SKIP (0.000s)
[103.602713] [022/133] (915s left) kms_lease (atomic-implicit-crtc)
[103.700265] Starting subtest: atomic-implicit-crtc
[103.702179] Starting dynamic subtest: pipe-A-eDP-1
[103.711651] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[103.720458] Starting dynamic subtest: pipe-B-eDP-1
[103.729615] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.010s)
[103.737151] Starting dynamic subtest: pipe-C-eDP-1
[103.745984] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.010s)
[103.752843] Starting dynamic subtest: pipe-D-eDP-1
[103.761432] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.012s)
[103.763064] Subtest atomic-implicit-crtc: SUCCESS (0.038s)
[103.842299] [023/133] (915s left) kms_cursor_crc (cursor-dpms)
[103.972115] Starting subtest: cursor-dpms
[103.973738] Starting dynamic subtest: pipe-A-eDP-1
[106.991308] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.018s)
[107.002866] Starting dynamic subtest: pipe-D-eDP-1
[110.578483] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.587s)
[110.580879] Subtest cursor-dpms: SUCCESS (6.607s)
[111.414273] [024/133] (907s left) syncobj_wait (invalid-multi-wait-all-unsubmitted-submitted)
[111.484530] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted
[111.487068] Subtest invalid-multi-wait-all-unsubmitted-submitted: SUCCESS (0.000s)
[111.614907] [025/133] (907s left) kms_big_fb (x-tiled-32bpp-rotate-270)
[111.721266] Starting subtest: x-tiled-32bpp-rotate-270
[111.741044] Subtest x-tiled-32bpp-rotate-270: SKIP (0.019s)
[111.843856] [026/133] (907s left) kms_cursor_crc (cursor-tearing-position-change)
[111.954264] Starting subtest: cursor-tearing-position-change
[111.956711] Starting dynamic subtest: pipe-A-eDP-1
[112.536947] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.581s)
[112.546831] Starting dynamic subtest: pipe-D-eDP-1
[113.744297] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.206s)
[113.746469] Subtest cursor-tearing-position-change: SUCCESS (1.789s)
[114.572099] [027/133] (904s left) api_intel_allocator (execbuf-with-allocator)
[114.635674] Starting subtest: execbuf-with-allocator
[114.640344] Subtest execbuf-with-allocator: SUCCESS (0.006s)
[114.781049] [028/133] (904s left) kms_plane (pixel-format-4-tiled-mtl-rc-ccs-cc-modifier)
[114.872987] Starting subtest: pixel-format-4-tiled-mtl-rc-ccs-cc-modifier
[114.898685] Starting dynamic subtest: pipe-A-plane-0
[115.198384] Dynamic subtest pipe-A-plane-0: SUCCESS (0.300s)
[115.206595] Starting dynamic subtest: pipe-A-plane-3
[115.465244] Dynamic subtest pipe-A-plane-3: SUCCESS (0.266s)
[115.473040] Starting dynamic subtest: pipe-A-plane-5
[115.476956] Dynamic subtest pipe-A-plane-5: SKIP (0.000s)
[116.553067] Starting dynamic subtest: pipe-B-plane-0
[116.847466] Dynamic subtest pipe-B-plane-0: SUCCESS (0.300s)
[116.857776] Starting dynamic subtest: pipe-B-plane-3
[117.091518] Dynamic subtest pipe-B-plane-3: SUCCESS (0.244s)
[117.100405] Starting dynamic subtest: pipe-B-plane-5
[117.104461] Dynamic subtest pipe-B-plane-5: SKIP (0.000s)
[117.401537] Subtest pixel-format-4-tiled-mtl-rc-ccs-cc-modifier: SUCCESS (2.529s)
[118.242870] [029/133] (901s left) kms_cursor_legacy (cursorb-vs-flipa-varying-size)
[118.365069] Starting subtest: cursorB-vs-flipA-varying-size
[118.369426] Subtest cursorB-vs-flipA-varying-size: SKIP (0.001s)
[118.521110] [030/133] (900s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-mmap-gtt)
[118.620194] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-mmap-gtt
[118.624317] Subtest psr-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[118.722931] [031/133] (900s left) gem_exec_reloc (basic-gtt-read-active)
[118.790207] Subtest basic-gtt-read-active: SKIP (0.000s)
[118.858319] [032/133] (900s left) kms_async_flips (crc-atomic)
[118.951621] Starting subtest: crc-atomic
[119.330094] Starting dynamic subtest: pipe-A-eDP-1
[122.248137] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.916s)
[122.625068] Starting dynamic subtest: pipe-B-eDP-1
[125.606297] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.966s)
[125.970958] Starting dynamic subtest: pipe-C-eDP-1
[128.912969] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.950s)
[129.305208] Starting dynamic subtest: pipe-D-eDP-1
[132.169844] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.873s)
[132.172188] Subtest crc-atomic: SUCCESS (13.220s)
[133.326855] [033/133] (886s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-16bpp-ytile-downscaling)
[133.418868] Starting subtest: flip-64bpp-ytile-to-16bpp-ytile-downscaling
[133.423208] Subtest flip-64bpp-ytile-to-16bpp-ytile-downscaling: SKIP (0.000s)
[133.490530] [034/133] (885s left) api_intel_bb (object-noreloc-purge-cache-simple)
[133.541034] Starting subtest: object-noreloc-purge-cache-simple
[133.551438] Subtest object-noreloc-purge-cache-simple: SUCCESS (0.012s)
[133.668828] [035/133] (885s left) kms_cursor_crc (cursor-rapid-movement-256x85)
[133.942036] Starting subtest: cursor-rapid-movement-256x85
[133.991494] Subtest cursor-rapid-movement-256x85: SKIP (0.044s)
[134.163992] [036/133] (885s left) syncobj_wait (wait-all-snapshot)
[134.227504] Starting subtest: wait-all-snapshot
[134.307894] Subtest wait-all-snapshot: SUCCESS (0.081s)
[134.393917] [037/133] (885s left) gem_eio (kms)
[134.661082] Starting subtest: kms
[154.408540] Subtest kms: SUCCESS (19.744s)
[155.615398] [038/133] (864s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip)
[155.718934] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip
[155.723502] Subtest y-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SKIP (0.000s)
[155.811608] [039/133] (863s left) gem_render_copy_redux (interruptible)
[155.870845] Starting subtest: interruptible
[156.250333] Subtest interruptible: SUCCESS (0.380s)
[156.387289] [040/133] (863s left) kms_frontbuffer_tracking (fbcpsr-slowdraw)
[156.478758] Starting subtest: fbcpsr-slowdraw
[181.747321] Subtest fbcpsr-slowdraw: SUCCESS (25.271s)
[181.883421] [041/133] (837s left) syncobj_basic (bad-handle-to-fd)
[181.935505] Starting subtest: bad-handle-to-fd
[181.937678] Subtest bad-handle-to-fd: SUCCESS (0.000s)
[182.053473] [042/133] (837s left) gem_exec_reloc (basic-gtt-read)
[182.125146] Subtest basic-gtt-read: SKIP (0.000s)
[182.194461] [043/133] (837s left) kms_atomic_transition (plane-all-modeset-transition)
[182.290183] Starting subtest: plane-all-modeset-transition
[182.294596] Subtest plane-all-modeset-transition: SKIP (0.000s)
[182.362541] [044/133] (837s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-pwrite)
[182.463214] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-pwrite
[182.467230] Subtest fbc-2p-scndscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[182.553619] [045/133] (837s left) syncobj_timeline (etime-multi-wait-all-for-submit-available-unsubmitted)
[182.608807] Starting subtest: etime-multi-wait-all-for-submit-available-unsubmitted
[182.714525] Subtest etime-multi-wait-all-for-submit-available-unsubmitted: SUCCESS (0.104s)
[182.804134] [046/133] (837s left) kms_cursor_legacy (flip-vs-cursor-atomic-transitions-varying-size)
[182.920556] Starting subtest: flip-vs-cursor-atomic-transitions-varying-size
[192.159581] Subtest flip-vs-cursor-atomic-transitions-varying-size: SUCCESS (9.239s)
[192.963832] [047/133] (827s left) kms_chamelium_frames (hdmi-crc-multiple)
[193.360505] Subtest hdmi-crc-multiple: SKIP (0.000s)
[194.168009] [048/133] (825s left) kms_sequence (get-idle)
[194.263085] Starting subtest: get-idle
[194.265431] Starting dynamic subtest: pipe-A-eDP-1
[196.078837] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.817s)
[196.087263] Starting dynamic subtest: pipe-B-eDP-1
[198.574145] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.492s)
[198.582745] Starting dynamic subtest: pipe-C-eDP-1
[201.006246] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.431s)
[201.015119] Starting dynamic subtest: pipe-D-eDP-1
[203.432199] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.423s)
[203.434625] Subtest get-idle: SUCCESS (9.170s)
[204.237523] [049/133] (815s left) kms_ccs (bad-pixel-format-4-tiled-mtl-mc-ccs)
[204.341327] Starting subtest: bad-pixel-format-4-tiled-mtl-mc-ccs
[204.343667] Starting dynamic subtest: pipe-A-eDP-1
[204.363805] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[204.373678] Starting dynamic subtest: pipe-B-eDP-1
[204.392999] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[204.401372] Starting dynamic subtest: pipe-C-eDP-1
[204.421174] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[204.428963] Starting dynamic subtest: pipe-D-eDP-1
[204.448337] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[204.450512] Subtest bad-pixel-format-4-tiled-mtl-mc-ccs: SUCCESS (0.007s)
[206.514774] [050/133] (813s left) kms_feature_discovery (display-4x)
[206.608315] Starting subtest: display-4x
[206.612535] Subtest display-4x: SKIP (0.000s)
[206.695306] [051/133] (813s left) kms_cursor_legacy (single-move)
[206.826648] Starting subtest: single-move
[206.828830] Starting dynamic subtest: pipe-A
[212.262840] Dynamic subtest pipe-A: SUCCESS (5.379s)
[212.273777] Starting dynamic subtest: pipe-B
[217.642861] Dynamic subtest pipe-B: SUCCESS (5.379s)
[217.653475] Starting dynamic subtest: pipe-C
[223.024947] Dynamic subtest pipe-C: SUCCESS (5.379s)
[223.035197] Starting dynamic subtest: pipe-D
[228.406771] Dynamic subtest pipe-D: SUCCESS (5.379s)
[228.417779] Starting dynamic subtest: all-pipes
[233.793770] Dynamic subtest all-pipes: SUCCESS (5.386s)
[233.796076] Subtest single-move: SUCCESS (26.917s)
[233.889591] [052/133] (786s left) kms_plane_scaling (planes-scaler-unity-scaling)
[233.994671] Starting subtest: planes-scaler-unity-scaling
[233.997019] Starting dynamic subtest: pipe-A
[234.055995] Dynamic subtest pipe-A: SUCCESS (0.064s)
[234.064580] Starting dynamic subtest: pipe-B
[235.230263] Dynamic subtest pipe-B: SUCCESS (1.173s)
[235.240544] Starting dynamic subtest: pipe-C
[236.338968] Dynamic subtest pipe-C: SUCCESS (1.107s)
[236.347418] Starting dynamic subtest: pipe-D
[237.480793] Dynamic subtest pipe-D: SUCCESS (1.141s)
[237.483197] Subtest planes-scaler-unity-scaling: SUCCESS (3.489s)
[238.637971] [053/133] (781s left) gem_pxp (fail-invalid-protected-context)
[238.763411] Starting subtest: fail-invalid-protected-context
[238.765852] Subtest fail-invalid-protected-context: SUCCESS (0.000s)
[238.876829] [054/133] (781s left) sw_sync (timeline_closed_signaled)
[238.922135] Starting subtest: timeline_closed_signaled
[238.924457] Subtest timeline_closed_signaled: SUCCESS (0.000s)
[238.976328] [055/133] (781s left) kms_addfb_basic (bad-pitch-32)
[239.034215] Starting subtest: bad-pitch-32
[239.036122] Subtest bad-pitch-32: SUCCESS (0.000s)
[239.162298] [056/133] (781s left) kms_psr2_su (page_flip-nv12)
[239.218082] Subtest page_flip-NV12: SKIP (0.000s)
[239.275308] [057/133] (781s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-render)
[239.367219] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-render
[246.241614] Subtest psr-1p-offscreen-pri-shrfb-draw-render: SUCCESS (6.875s)
[246.382816] [058/133] (774s left) kms_pm_rpm (modeset-non-lpsp)
[248.019487] Starting subtest: modeset-non-lpsp
[249.187754] Subtest modeset-non-lpsp: SKIP (1.165s)
[249.562244] [059/133] (770s left) syncobj_timeline (multi-wait-all-for-submit-available-submitted)
[249.625728] Starting subtest: multi-wait-all-for-submit-available-submitted
[249.628209] Subtest multi-wait-all-for-submit-available-submitted: SUCCESS (0.001s)
[249.721609] [060/133] (770s left) kms_flip (single-buffer-flip-vs-dpms-off-vs-modeset)
[249.812872] Starting subtest: single-buffer-flip-vs-dpms-off-vs-modeset
[249.815028] Starting dynamic subtest: A-eDP1
[253.397146] Dynamic subtest A-eDP1: SUCCESS (3.583s)
[253.405893] Starting dynamic subtest: B-eDP1
[256.602545] Dynamic subtest B-eDP1: SUCCESS (3.205s)
[256.611462] Starting dynamic subtest: C-eDP1
[259.685753] Dynamic subtest C-eDP1: SUCCESS (3.083s)
[259.695026] Starting dynamic subtest: D-eDP1
[262.812772] Dynamic subtest D-eDP1: SUCCESS (3.128s)
[262.815065] Subtest single-buffer-flip-vs-dpms-off-vs-modeset: SUCCESS (13.005s)
[263.612303] [061/133] (756s left) gem_workarounds (basic-read)
[263.681877] Starting subtest: basic-read
[263.695627] Subtest basic-read: SUCCESS (0.013s)
[263.819492] [062/133] (756s left) i915_drm_fdinfo (virtual-idle)
[263.858512] Starting subtest: virtual-idle
[266.915836] Subtest virtual-idle: SUCCESS (3.056s)
[266.992286] [063/133] (753s left) kms_vrr (negative-basic)
[267.092657] Starting subtest: negative-basic
[267.099276] Starting dynamic subtest: pipe-A-eDP-1
[272.568736] Dynamic subtest pipe-A-eDP-1: SUCCESS (5.415s)
[272.803850] Subtest negative-basic: SUCCESS (5.712s)
[273.636318] [064/133] (747s left) kms_big_fb (yf-tiled-8bpp-rotate-0)
[273.742612] Starting subtest: yf-tiled-8bpp-rotate-0
[273.746978] Subtest yf-tiled-8bpp-rotate-0: SKIP (0.000s)
[273.851273] [065/133] (746s left) kms_psr (fbc-psr-primary-blt)
[273.944566] Starting subtest: fbc-psr-primary-blt
[273.948714] Starting dynamic subtest: eDP-1
[273.952673] Dynamic subtest eDP-1: SKIP (0.000s)
[273.956715] Subtest fbc-psr-primary-blt: SKIP (0.002s)
[274.019800] [066/133] (746s left) gem_exec_schedule (manyslice)
[274.086389] Starting subtest: manyslice
[274.088575] Starting dynamic subtest: rcs0
[279.271547] Dynamic subtest rcs0: SUCCESS (5.140s)
[279.283077] Starting dynamic subtest: bcs0
[287.443719] Dynamic subtest bcs0: SUCCESS (8.171s)
[287.457913] Starting dynamic subtest: vcs0
[293.029339] Dynamic subtest vcs0: SUCCESS (5.583s)
[293.037816] Starting dynamic subtest: vcs1
[298.606084] Dynamic subtest vcs1: SUCCESS (5.575s)
[298.617040] Starting dynamic subtest: vecs0
[305.146914] Dynamic subtest vecs0: SUCCESS (6.589s)
[305.160030] Starting dynamic subtest: ccs0
[311.895374] Dynamic subtest ccs0: SUCCESS (6.696s)
[311.897798] Subtest manyslice: SUCCESS (37.766s)
[312.149068] [067/133] (708s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-gtt)
[312.253648] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-gtt
[312.257614] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[312.357342] [068/133] (708s left) kms_fbcon_fbt (fbc)
[312.410700] Starting subtest: fbc
[318.795361] Subtest fbc: SUCCESS (6.384s)
[319.881111] [069/133] (701s left) gem_create (create-ext-cpu-access-big)
[320.051889] Starting subtest: create-ext-cpu-access-big
[320.056160] Subtest create-ext-cpu-access-big: SKIP (0.001s)
[320.122980] [070/133] (700s left) kms_ccs (crc-sprite-planes-basic-4-tiled-dg2-rc-ccs)
[320.230133] Starting subtest: crc-sprite-planes-basic-4-tiled-dg2-rc-ccs
[320.232397] Starting dynamic subtest: pipe-A-eDP-1
[320.290313] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[320.299155] Starting dynamic subtest: pipe-B-eDP-1
[320.353620] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[320.361650] Starting dynamic subtest: pipe-C-eDP-1
[320.415560] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[320.423629] Starting dynamic subtest: pipe-D-eDP-1
[320.477588] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[320.481700] Subtest crc-sprite-planes-basic-4-tiled-dg2-rc-ccs: SKIP (0.009s)
[322.542869] [071/133] (698s left) gem_ctx_isolation (clean)
[322.614372] Starting subtest: clean
[322.616742] Starting dynamic subtest: rcs0
[322.656530] Dynamic subtest rcs0: SUCCESS (0.041s)
[322.667630] Starting dynamic subtest: bcs0
[322.721831] Dynamic subtest bcs0: SUCCESS (0.064s)
[322.731847] Starting dynamic subtest: vcs0
[322.789874] Dynamic subtest vcs0: SUCCESS (0.067s)
[322.799887] Starting dynamic subtest: vcs1
[323.922572] Dynamic subtest vcs1: SUCCESS (1.131s)
[323.932931] Starting dynamic subtest: vecs0
[325.926425] Dynamic subtest vecs0: SUCCESS (2.003s)
[325.936783] Starting dynamic subtest: ccs0
[327.916317] Dynamic subtest ccs0: SUCCESS (1.989s)
[327.918744] Subtest clean: SUCCESS (5.302s)
[328.147219] [072/133] (692s left) kms_rotation_crc (sprite-rotation-180)
[328.240666] Starting subtest: sprite-rotation-180
[335.120026] Subtest sprite-rotation-180: SUCCESS (6.881s)
[336.295996] [073/133] (684s left) gem_exec_whisper (basic-sync-all)
[336.352750] Starting subtest: basic-sync-all
[344.007585] Subtest basic-sync-all: SUCCESS (7.652s)
[344.190658] [074/133] (676s left) i915_pm_rpm (sysfs-read)
[346.028826] Starting subtest: sysfs-read
[347.185286] Subtest sysfs-read: SUCCESS (1.157s)
[347.556769] [075/133] (673s left) kms_plane (plane-panning-bottom-right-suspend)
[347.657314] Starting subtest: plane-panning-bottom-right-suspend
[347.659267] Starting dynamic subtest: pipe-A
[365.620652] Dynamic subtest pipe-A: SUCCESS (2.909s)
[365.630402] Starting dynamic subtest: pipe-B
[383.600468] Dynamic subtest pipe-B: SUCCESS (3.471s)
[383.603541] Subtest plane-panning-bottom-right-suspend: SUCCESS (6.383s)
[384.398018] [076/133] (636s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-onoff)
[384.507428] Starting subtest: fbc-2p-primscrn-spr-indfb-onoff
[384.511802] Subtest fbc-2p-primscrn-spr-indfb-onoff: SKIP (0.000s)
[384.586705] [077/133] (636s left) kms_vblank (wait-busy-hang)
[384.674215] Starting subtest: wait-busy-hang
[384.676426] Starting dynamic subtest: pipe-A-eDP-1
[412.241072] Dynamic subtest pipe-A-eDP-1: SUCCESS (27.581s)
[412.256509] Starting dynamic subtest: pipe-D-eDP-1
[427.210185] Dynamic subtest pipe-D-eDP-1: SUCCESS (14.963s)
[427.212905] Subtest wait-busy-hang: SUCCESS (42.548s)
[428.051513] [078/133] (593s left) i915_selftest (mock)
[429.809675] Starting subtest: mock
[429.812671] Starting dynamic subtest: sanitycheck
[431.334390] Dynamic subtest sanitycheck: SUCCESS (1.524s)
[431.344535] Starting dynamic subtest: shmem
[432.863026] Dynamic subtest shmem: SUCCESS (1.527s)
[432.874213] Starting dynamic subtest: fence
[441.596378] Dynamic subtest fence: SUCCESS (8.732s)
[441.606191] Starting dynamic subtest: scatterlist
[444.095020] Dynamic subtest scatterlist: SUCCESS (2.498s)
[444.104587] Starting dynamic subtest: syncmap
[448.130856] Dynamic subtest syncmap: SUCCESS (4.034s)
[448.138826] Starting dynamic subtest: uncore
[449.630640] Dynamic subtest uncore: SUCCESS (1.498s)
[449.640521] Starting dynamic subtest: ring
[451.172029] Dynamic subtest ring: SUCCESS (1.540s)
[451.182198] Starting dynamic subtest: engine
[452.675489] Dynamic subtest engine: SUCCESS (1.502s)
[452.683668] Starting dynamic subtest: timelines
[457.485226] Dynamic subtest timelines: SUCCESS (4.808s)
[457.494590] Starting dynamic subtest: requests
[461.650901] Dynamic subtest requests: SUCCESS (4.165s)
[461.660592] Starting dynamic subtest: objects
[463.208566] Dynamic subtest objects: SUCCESS (1.557s)
[463.218090] Starting dynamic subtest: phys
[464.793965] Dynamic subtest phys: SUCCESS (1.585s)
[464.803891] Starting dynamic subtest: dmabuf
[466.400551] Dynamic subtest dmabuf: SUCCESS (1.605s)
[466.410141] Starting dynamic subtest: vma
[472.988834] Dynamic subtest vma: SUCCESS (6.588s)
[472.998134] Starting dynamic subtest: evict
[475.240311] Dynamic subtest evict: SUCCESS (2.251s)
[475.250325] Starting dynamic subtest: gtt
[479.440646] Dynamic subtest gtt: SUCCESS (4.199s)
[479.450458] Starting dynamic subtest: hugepages
[481.133502] Dynamic subtest hugepages: SUCCESS (1.690s)
[481.143427] Starting dynamic subtest: memory_region
[484.474011] Dynamic subtest memory_region: SUCCESS (3.339s)
[484.476908] Subtest mock: SUCCESS (54.668s)
[484.506889] [FACT i915_selftest (mock)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[484.507598] [FACT i915_selftest (mock)] deleted: kernel.kmod_is_loaded.i915: true
[484.511303] [079/133] (536s left) gem_readwrite (write-bad-handle)
[486.881014] Subtest write-bad-handle: SKIP (0.000s)
[486.939292] [FACT gem_readwrite (write-bad-handle)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[486.940680] [FACT gem_readwrite (write-bad-handle)] new: kernel.kmod_is_loaded.i915: true
[486.945012] [080/133] (534s left) syncobj_timeline (reset-during-wait-for-submit)
[487.007516] Starting subtest: reset-during-wait-for-submit
[487.108184] Subtest reset-during-wait-for-submit: SUCCESS (0.102s)
[487.189057] [081/133] (534s left) fbdev (write)
[487.227982] Starting subtest: write
[487.874768] Subtest write: SUCCESS (0.648s)
[487.940396] [082/133] (533s left) gem_eio (in-flight-1us)
[488.071023] Starting subtest: in-flight-1us
[495.128414] Subtest in-flight-1us: SUCCESS (7.055s)
[495.248053] [083/133] (526s left) syncobj_wait (invalid-wait-bad-flags)
[495.304911] Starting subtest: invalid-wait-bad-flags
[495.307376] Subtest invalid-wait-bad-flags: SUCCESS (0.000s)
[495.402931] [084/133] (526s left) kms_rotation_crc (primary-x-tiled-reflect-x-180)
[495.506471] Starting subtest: primary-x-tiled-reflect-x-180
[503.144322] Subtest primary-x-tiled-reflect-x-180: SUCCESS (7.638s)
[504.326282] [085/133] (517s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-mmap-wc)
[504.423097] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-mmap-wc
[504.428135] Subtest psr-2p-scndscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[504.523080] [086/133] (517s left) perf_pmu (enable-race)
[504.561583] Starting subtest: enable-race
[504.564422] Starting dynamic subtest: rcs0
[517.348230] Dynamic subtest rcs0: SUCCESS (12.768s)
[517.358661] Starting dynamic subtest: bcs0
[530.091000] Dynamic subtest bcs0: SUCCESS (12.741s)
[530.101307] Starting dynamic subtest: vcs0
[545.427376] Dynamic subtest vcs0: SUCCESS (15.353s)
[545.439255] Starting dynamic subtest: vcs1
[561.491156] Dynamic subtest vcs1: SUCCESS (16.062s)
[561.503450] Starting dynamic subtest: vecs0
[577.490901] Dynamic subtest vecs0: SUCCESS (15.998s)
[577.503660] Starting dynamic subtest: ccs0
[590.238388] Dynamic subtest ccs0: SUCCESS (12.747s)
[590.240880] Subtest enable-race: SUCCESS (85.684s)
[590.334901] [087/133] (431s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-render)
[590.447927] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-render
[590.452530] Subtest fbc-2p-scndscrn-pri-indfb-draw-render: SKIP (0.000s)
[590.536087] [088/133] (431s left) gem_exec_schedule (implicit-boths)
[590.625149] Starting subtest: implicit-boths
[590.627639] Starting dynamic subtest: rcs0
[590.745806] Dynamic subtest rcs0: SUCCESS (0.135s)
[590.758076] Starting dynamic subtest: vcs0
[590.842949] Dynamic subtest vcs0: SUCCESS (0.096s)
[590.855591] Starting dynamic subtest: vcs1
[590.929468] Dynamic subtest vcs1: SUCCESS (0.086s)
[590.941636] Starting dynamic subtest: vecs0
[591.012664] Dynamic subtest vecs0: SUCCESS (0.080s)
[591.024491] Starting dynamic subtest: ccs0
[591.106318] Dynamic subtest ccs0: SUCCESS (0.093s)
[591.109453] Subtest implicit-boths: SUCCESS (0.496s)
[592.558996] [089/133] (429s left) gem_exec_schedule (u-fairslice)
[592.635678] Starting subtest: u-fairslice
[592.638107] Starting dynamic subtest: rcs0
[594.656455] Dynamic subtest rcs0: SUCCESS (2.027s)
[594.665971] Starting dynamic subtest: bcs0
[596.679666] Dynamic subtest bcs0: SUCCESS (2.025s)
[596.689182] Starting dynamic subtest: vcs0
[598.702803] Dynamic subtest vcs0: SUCCESS (2.020s)
[598.711911] Starting dynamic subtest: vcs1
[600.724665] Dynamic subtest vcs1: SUCCESS (2.022s)
[600.734650] Starting dynamic subtest: vecs0
[602.750133] Dynamic subtest vecs0: SUCCESS (2.024s)
[602.760340] Starting dynamic subtest: ccs0
[604.829945] Dynamic subtest ccs0: SUCCESS (2.028s)
[604.832672] Subtest u-fairslice: SUCCESS (12.152s)
[605.094595] [090/133] (416s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip)
[605.200196] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip
[606.102544] Subtest x-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SUCCESS (0.903s)
[606.255321] [091/133] (415s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24)
[606.344328] Starting subtest: compare-crc-sanitycheck-xr24
[606.346423] Starting dynamic subtest: pipe-A-eDP-1
[606.999892] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.654s)
[607.010050] Starting dynamic subtest: pipe-B-eDP-1
[608.294451] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.292s)
[608.306521] Starting dynamic subtest: pipe-C-eDP-1
[609.590681] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.292s)
[609.600701] Starting dynamic subtest: pipe-D-eDP-1
[610.827520] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.236s)
[610.830640] Subtest compare-crc-sanitycheck-xr24: SUCCESS (4.482s)
[611.639103] [092/133] (410s left) kms_properties (plane-properties-atomic)
[611.731627] Starting subtest: plane-properties-atomic
[611.734470] Starting dynamic subtest: pipe-A-eDP-1
[612.283503] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.551s)
[612.294401] Starting dynamic subtest: pipe-B-eDP-1
[613.526621] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.242s)
[613.537537] Starting dynamic subtest: pipe-C-eDP-1
[614.751399] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.224s)
[614.762437] Starting dynamic subtest: pipe-D-eDP-1
[615.987011] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.235s)
[615.989505] Subtest plane-properties-atomic: SUCCESS (4.257s)
[616.838468] [093/133] (405s left) gem_ringfill (legacy-basic)
[622.487369] Starting subtest: legacy-basic
[622.490334] Starting dynamic subtest: default
[622.545885] Dynamic subtest default: SUCCESS (0.057s)
[622.557673] Starting dynamic subtest: render
[622.589729] Dynamic subtest render: SUCCESS (0.043s)
[622.601509] Starting dynamic subtest: bsd
[622.633937] Dynamic subtest bsd: SUCCESS (0.042s)
[622.644278] Starting dynamic subtest: bsd1
[622.680323] Dynamic subtest bsd1: SUCCESS (0.044s)
[622.690788] Starting dynamic subtest: bsd2
[622.721018] Dynamic subtest bsd2: SUCCESS (0.038s)
[622.731672] Starting dynamic subtest: blt
[622.767798] Dynamic subtest blt: SUCCESS (0.045s)
[622.778826] Starting dynamic subtest: vebox
[622.814178] Dynamic subtest vebox: SUCCESS (0.044s)
[622.816905] Subtest legacy-basic: SUCCESS (0.329s)
[622.899935] [094/133] (399s left) gem_mmap_wc (read)
[622.962535] Subtest read: SKIP (0.000s)
[623.024768] [095/133] (399s left) kms_psr (psr2-cursor-mmap-gtt)
[623.122763] Starting subtest: psr2-cursor-mmap-gtt
[623.124934] Starting dynamic subtest: eDP-1
[624.879812] Dynamic subtest eDP-1: SUCCESS (1.757s)
[624.882766] Subtest psr2-cursor-mmap-gtt: SUCCESS (1.759s)
[625.677048] [096/133] (396s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-onoff)
[625.796520] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-onoff
[625.801568] Subtest fbcpsr-2p-scndscrn-cur-indfb-onoff: SKIP (0.000s)
[625.888150] [097/133] (396s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-mmap-cpu)
[625.981648] Starting subtest: psr-2p-primscrn-cur-indfb-draw-mmap-cpu
[625.986533] Subtest psr-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[626.090617] [098/133] (396s left) gem_exec_balancer (full-pulse)
[626.154543] Starting subtest: full-pulse
[630.415683] Subtest full-pulse: SUCCESS (4.260s)
[630.728638] [099/133] (391s left) gem_exec_whisper (basic-fds-priority-all)
[630.793953] Starting subtest: basic-fds-priority-all
[655.441597] Subtest basic-fds-priority-all: SUCCESS (24.629s)
[655.613679] [100/133] (366s left) kms_pm_backlight (basic-brightness)
[655.702861] Starting subtest: basic-brightness
[655.755687] Starting dynamic subtest: eDP-1
[656.074589] Dynamic subtest eDP-1: SUCCESS (0.319s)
[656.077142] Subtest basic-brightness: SUCCESS (0.373s)
[656.914123] [101/133] (365s left) gem_ctx_persistence (legacy-engines-mixed-process)
[656.980255] Starting subtest: legacy-engines-mixed-process
[656.982914] Starting dynamic subtest: render
[658.453433] Dynamic subtest render: SUCCESS (1.472s)
[658.468513] Starting dynamic subtest: bsd1
[660.443182] Dynamic subtest bsd1: SUCCESS (1.986s)
[660.454929] Starting dynamic subtest: bsd2
[662.491455] Dynamic subtest bsd2: SUCCESS (2.046s)
[662.503205] Starting dynamic subtest: blt
[664.467156] Dynamic subtest blt: SUCCESS (1.974s)
[664.478483] Starting dynamic subtest: vebox
[666.520542] Dynamic subtest vebox: SUCCESS (2.052s)
[666.523278] Subtest legacy-engines-mixed-process: SUCCESS (9.541s)
[666.601052] [102/133] (355s left) gem_exec_reloc (basic-wc-gtt-active)
[666.666693] Subtest basic-wc-gtt-active: SKIP (0.000s)
[666.734433] [103/133] (355s left) gem_wait (await)
[666.801565] Starting subtest: await
[666.804571] Starting dynamic subtest: all-engines
[667.950943] Dynamic subtest all-engines: SUCCESS (1.149s)
[667.963070] Starting dynamic subtest: rcs0
[669.030348] Dynamic subtest rcs0: SUCCESS (1.077s)
[669.042662] Starting dynamic subtest: bcs0
[670.102982] Dynamic subtest bcs0: SUCCESS (1.070s)
[670.119720] Starting dynamic subtest: vcs0
[671.163277] Dynamic subtest vcs0: SUCCESS (1.059s)
[671.187905] Starting dynamic subtest: vcs1
[672.246696] Dynamic subtest vcs1: SUCCESS (1.081s)
[672.262589] Starting dynamic subtest: vecs0
[673.312786] Dynamic subtest vecs0: SUCCESS (1.063s)
[673.329386] Starting dynamic subtest: ccs0
[674.375517] Dynamic subtest ccs0: SUCCESS (1.060s)
[674.378534] Subtest await: SUCCESS (7.575s)
[674.582804] [104/133] (347s left) kms_psr (fbc-psr2-sprite-blt)
[674.687574] Starting subtest: fbc-psr2-sprite-blt
[674.690020] Starting dynamic subtest: eDP-1
[674.694637] Dynamic subtest eDP-1: SKIP (0.000s)
[674.699355] Subtest fbc-psr2-sprite-blt: SKIP (0.001s)
[674.781988] [105/133] (347s left) i915_drm_fdinfo (virtual-busy-hang)
[674.822175] Starting subtest: virtual-busy-hang
[674.827437] Subtest virtual-busy-hang: SKIP (0.000s)
[674.892326] [106/133] (347s left) gem_exec_create (madvise)
[674.955634] Starting subtest: madvise
[674.958535] Starting dynamic subtest: smem
[695.504194] Dynamic subtest smem: SUCCESS (20.550s)
[695.507309] Subtest madvise: SUCCESS (20.551s)
[696.375756] [107/133] (326s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-mmap-cpu)
[696.484066] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-mmap-cpu
[696.489086] Subtest fbc-2p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[696.573033] [108/133] (325s left) kms_psr2_sf (pr-cursor-plane-move-continuous-exceed-fully-sf)
[696.664241] Starting subtest: pr-cursor-plane-move-continuous-exceed-fully-sf
[696.669535] Subtest pr-cursor-plane-move-continuous-exceed-fully-sf: SKIP (0.000s)
[696.734930] [109/133] (325s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-pwrite)
[696.830717] Starting subtest: psr-2p-primscrn-spr-indfb-draw-pwrite
[696.836119] Subtest psr-2p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[696.931013] [110/133] (325s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-mmap-wc)
[697.024425] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-mmap-wc
[703.841305] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-mmap-wc: SUCCESS (6.820s)
[703.976768] [111/133] (318s left) gem_exec_fence (syncobj-timeline-repeat)
[704.556491] Starting subtest: syncobj-timeline-repeat
[704.801815] Subtest syncobj-timeline-repeat: SUCCESS (0.245s)
[705.587333] [112/133] (317s left) gem_mmap_gtt (basic-write-read)
[705.634639] Subtest basic-write-read: SKIP (0.000s)
[705.697480] [113/133] (317s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-blt)
[705.797282] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-blt
[705.802145] Subtest fbc-2p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[705.894346] [114/133] (316s left) syncobj_timeline (single-wait-all-for-submit-signaled)
[705.965665] Starting subtest: single-wait-all-for-submit-signaled
[705.968470] Subtest single-wait-all-for-submit-signaled: SUCCESS (0.000s)
[706.082405] [115/133] (316s left) kms_async_flips (async-flip-suspend-resume)
[706.184024] Starting subtest: async-flip-suspend-resume
[706.558727] Starting dynamic subtest: pipe-A-eDP-1
[724.186373] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.934s)
[724.567443] Starting dynamic subtest: pipe-B-eDP-1
[742.216110] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.900s)
[742.603077] Starting dynamic subtest: pipe-C-eDP-1
[760.209677] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.866s)
[760.598700] Starting dynamic subtest: pipe-D-eDP-1
[778.235229] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.932s)
[778.237601] Subtest async-flip-suspend-resume: SUCCESS (13.144s)
[779.409703] [116/133] (243s left) kms_flip (2x-flip-vs-dpms-on-nop)
[779.512196] Starting subtest: 2x-flip-vs-dpms-on-nop
[779.523698] Subtest 2x-flip-vs-dpms-on-nop: SKIP (0.011s)
[779.603730] [117/133] (243s left) prime_vgem (basic-fence-read)
[779.677208] Starting subtest: basic-fence-read
[779.685434] Subtest basic-fence-read: SKIP (0.006s)
[779.814531] [118/133] (243s left) gem_unref_active_buffers
[780.008748] [119/133] (243s left) kms_psr (pr-primary-mmap-gtt)
[780.104378] Starting subtest: pr-primary-mmap-gtt
[780.108650] Subtest pr-primary-mmap-gtt: SKIP (0.000s)
[780.184849] [120/133] (242s left) syncobj_timeline (etime-single-wait-available-unsubmitted)
[780.244752] Starting subtest: etime-single-wait-available-unsubmitted
[780.346520] Subtest etime-single-wait-available-unsubmitted: SUCCESS (0.102s)
[780.436124] [121/133] (242s left) syncobj_wait (single-wait-for-submit-signaled)
[780.480892] Starting subtest: single-wait-for-submit-signaled
[780.483024] Subtest single-wait-for-submit-signaled: SUCCESS (0.000s)
[780.573918] [122/133] (242s left) gem_ctx_bad_destroy (invalid-ctx)
[780.623027] Starting subtest: invalid-ctx
[780.625292] Subtest invalid-ctx: SUCCESS (0.000s)
[780.698264] [123/133] (242s left) gem_pxp (protected-encrypted-src-copy-not-readible)
[780.818564] Starting subtest: protected-encrypted-src-copy-not-readible
[780.930806] Subtest protected-encrypted-src-copy-not-readible: SUCCESS (0.113s)
[781.053100] [124/133] (242s left) kms_flip (2x-absolute-wf_vblank-interruptible)
[781.145959] Starting subtest: 2x-absolute-wf_vblank-interruptible
[781.157878] Subtest 2x-absolute-wf_vblank-interruptible: SKIP (0.011s)
[781.237930] [125/133] (242s left) gem_userptr_blits (relocations)
[781.295196] Starting subtest: relocations
[781.299310] Subtest relocations: SKIP (0.001s)
[781.428026] [126/133] (241s left) kms_properties (colorop-properties-legacy)
[781.513037] Starting subtest: colorop-properties-legacy
[781.515329] Starting dynamic subtest: pipe-A-eDP-1
[781.893002] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.379s)
[781.903307] Starting dynamic subtest: pipe-B-eDP-1
[783.000471] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.102s)
[783.011922] Starting dynamic subtest: pipe-C-eDP-1
[784.105570] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.104s)
[784.116225] Starting dynamic subtest: pipe-D-eDP-1
[785.147113] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.037s)
[785.149564] Subtest colorop-properties-legacy: SUCCESS (3.629s)
[785.939890] [127/133] (237s left) gem_mmap_gtt (hang-user)
[785.993620] Subtest hang-user: SKIP (0.000s)
[786.049397] [128/133] (237s left) kms_frontbuffer_tracking (fbc-1p-primscrn-indfb-pgflip-blt)
[786.142739] Starting subtest: fbc-1p-primscrn-indfb-pgflip-blt
[790.649271] Subtest fbc-1p-primscrn-indfb-pgflip-blt: SUCCESS (4.505s)
[791.862097] [129/133] (231s left) kms_color_pipeline (plane-lut1d-ctm3x4)
[791.963301] Starting subtest: plane-lut1d-ctm3x4
[792.110576] Starting dynamic subtest: pipe-A-plane-0
[792.462452] Dynamic subtest pipe-A-plane-0: FAIL (0.180s)
[792.474835] Starting dynamic subtest: pipe-A-plane-1
[792.688777] Dynamic subtest pipe-A-plane-1: FAIL (0.183s)
[792.700548] Starting dynamic subtest: pipe-A-plane-2
[792.913475] Dynamic subtest pipe-A-plane-2: FAIL (0.176s)
[793.857752] Starting dynamic subtest: pipe-B-plane-0
[794.311386] Dynamic subtest pipe-B-plane-0: FAIL (0.197s)
[794.321641] Starting dynamic subtest: pipe-B-plane-1
[794.619146] Dynamic subtest pipe-B-plane-1: FAIL (0.165s)
[794.630731] Starting dynamic subtest: pipe-B-plane-2
[794.916919] Dynamic subtest pipe-B-plane-2: FAIL (0.166s)
[795.602088] Starting dynamic subtest: pipe-C-plane-0
[796.107413] Dynamic subtest pipe-C-plane-0: FAIL (0.140s)
[796.119378] Starting dynamic subtest: pipe-C-plane-1
[796.514115] Dynamic subtest pipe-C-plane-1: FAIL (0.157s)
[796.526820] Starting dynamic subtest: pipe-C-plane-2
[796.910959] Dynamic subtest pipe-C-plane-2: FAIL (0.173s)
[797.735460] Starting dynamic subtest: pipe-D-plane-0
[798.345595] Dynamic subtest pipe-D-plane-0: FAIL (0.162s)
[798.356906] Starting dynamic subtest: pipe-D-plane-1
[798.813347] Dynamic subtest pipe-D-plane-1: FAIL (0.632s)
[798.825459] Starting dynamic subtest: pipe-D-plane-2
[799.268286] Dynamic subtest pipe-D-plane-2: FAIL (0.572s)
[799.399084] Subtest plane-lut1d-ctm3x4: FAIL (7.433s)
[800.201354] [130/133] (223s left) sysfs_timeslice_duration (duration)
[800.262843] Starting subtest: duration
[800.265237] Starting dynamic subtest: vecs0
[815.293087] Dynamic subtest vecs0: SUCCESS (15.023s)
[815.306113] Starting dynamic subtest: ccs0
[828.463961] Dynamic subtest ccs0: SUCCESS (13.151s)
[828.478050] Starting dynamic subtest: vcs0
[842.300894] Dynamic subtest vcs0: SUCCESS (13.845s)
[842.313145] Starting dynamic subtest: bcs0
[855.463290] Dynamic subtest bcs0: SUCCESS (13.134s)
[855.473383] Starting dynamic subtest: rcs0
[868.604118] Dynamic subtest rcs0: SUCCESS (13.133s)
[868.616715] Starting dynamic subtest: vcs1
[882.300777] Dynamic subtest vcs1: SUCCESS (13.717s)
[882.303780] Subtest duration: SUCCESS (82.020s)
[882.379700] [131/133] (141s left) gem_spin_batch (resubmit-new)
[882.445516] Starting subtest: resubmit-new
[882.447915] Starting dynamic subtest: rcs0
[882.457678] Dynamic subtest rcs0: SUCCESS (0.012s)
[882.469590] Starting dynamic subtest: bcs0
[882.472205] Dynamic subtest bcs0: SUCCESS (0.007s)
[882.482329] Starting dynamic subtest: vcs0
[882.484192] Dynamic subtest vcs0: SUCCESS (0.007s)
[882.494253] Starting dynamic subtest: vcs1
[882.496790] Dynamic subtest vcs1: SUCCESS (0.004s)
[882.506628] Starting dynamic subtest: vecs0
[882.508920] Dynamic subtest vecs0: SUCCESS (0.006s)
[882.518630] Starting dynamic subtest: ccs0
[882.520851] Dynamic subtest ccs0: SUCCESS (0.007s)
[882.523009] Subtest resubmit-new: SUCCESS (0.047s)
[884.429527] [132/133] (139s left) gem_userptr_blits (create-destroy-sync)
[884.490908] Starting subtest: create-destroy-sync
[889.557799] Subtest create-destroy-sync: SUCCESS (5.017s)
[889.639407] [133/133] (134s left) dmabuf_sync_file (export-multiwait)
[889.689558] Starting subtest: export-multiwait
[889.691493] Subtest export-multiwait: SUCCESS (0.001s)
[889.745090] Closing watchdogs
results: parsing output: 0/ for test: gem_exec_fence
results: parsing output: 1/ for test: kms_big_fb
results: parsing output: 2/ for test: kms_frontbuffer_tracking
results: parsing output: 3/ for test: gem_exec_params
results: parsing output: 4/ for test: kms_big_fb
results: parsing output: 5/ for test: gem_sync
results: parsing output: 6/ for test: gem_mmap_gtt
results: parsing output: 7/ for test: kms_chamelium_color
results: parsing output: 8/ for test: kms_flip_scaled_crc
results: parsing output: 9/ for test: kms_hdr
results: parsing output: 10/ for test: prime_vgem
results: parsing output: 11/ for test: gen7_exec_parse
results: parsing output: 12/ for test: kms_frontbuffer_tracking
results: parsing output: 13/ for test: kms_chamelium_hpd
results: parsing output: 14/ for test: kms_ccs
results: parsing output: 15/ for test: kms_content_protection
results: parsing output: 16/ for test: kms_plane_multiple
results: parsing output: 17/ for test: kms_ccs
results: parsing output: 18/ for test: kms_frontbuffer_tracking
results: parsing output: 19/ for test: kms_psr_stress_test
results: parsing output: 20/ for test: kms_big_fb
results: parsing output: 21/ for test: kms_lease
results: parsing output: 22/ for test: kms_cursor_crc
results: parsing output: 23/ for test: syncobj_wait
results: parsing output: 24/ for test: kms_big_fb
results: parsing output: 25/ for test: kms_cursor_crc
results: parsing output: 26/ for test: api_intel_allocator
results: parsing output: 27/ for test: kms_plane
results: parsing output: 28/ for test: kms_cursor_legacy
results: parsing output: 29/ for test: kms_frontbuffer_tracking
results: parsing output: 30/ for test: gem_exec_reloc
results: parsing output: 31/ for test: kms_async_flips
results: parsing output: 32/ for test: kms_flip_scaled_crc
results: parsing output: 33/ for test: api_intel_bb
results: parsing output: 34/ for test: kms_cursor_crc
results: parsing output: 35/ for test: syncobj_wait
results: parsing output: 36/ for test: gem_eio
results: parsing output: 37/ for test: kms_big_fb
results: parsing output: 38/ for test: gem_render_copy_redux
results: parsing output: 39/ for test: kms_frontbuffer_tracking
results: parsing output: 40/ for test: syncobj_basic
results: parsing output: 41/ for test: gem_exec_reloc
results: parsing output: 42/ for test: kms_atomic_transition
results: parsing output: 43/ for test: kms_frontbuffer_tracking
results: parsing output: 44/ for test: syncobj_timeline
results: parsing output: 45/ for test: kms_cursor_legacy
results: parsing output: 46/ for test: kms_chamelium_frames
results: parsing output: 47/ for test: kms_sequence
results: parsing output: 48/ for test: kms_ccs
results: parsing output: 49/ for test: kms_feature_discovery
results: parsing output: 50/ for test: kms_cursor_legacy
results: parsing output: 51/ for test: kms_plane_scaling
results: parsing output: 52/ for test: gem_pxp
results: parsing output: 53/ for test: sw_sync
results: parsing output: 54/ for test: kms_addfb_basic
results: parsing output: 55/ for test: kms_psr2_su
results: parsing output: 56/ for test: kms_frontbuffer_tracking
results: parsing output: 57/ for test: kms_pm_rpm
results: parsing output: 58/ for test: syncobj_timeline
results: parsing output: 59/ for test: kms_flip
results: parsing output: 60/ for test: gem_workarounds
results: parsing output: 61/ for test: i915_drm_fdinfo
results: parsing output: 62/ for test: kms_vrr
results: parsing output: 63/ for test: kms_big_fb
results: parsing output: 64/ for test: kms_psr
results: parsing output: 65/ for test: gem_exec_schedule
results: parsing output: 66/ for test: kms_frontbuffer_tracking
results: parsing output: 67/ for test: kms_fbcon_fbt
results: parsing output: 68/ for test: gem_create
results: parsing output: 69/ for test: kms_ccs
results: parsing output: 70/ for test: gem_ctx_isolation
results: parsing output: 71/ for test: kms_rotation_crc
results: parsing output: 72/ for test: gem_exec_whisper
results: parsing output: 73/ for test: i915_pm_rpm
results: parsing output: 74/ for test: kms_plane
results: parsing output: 75/ for test: kms_frontbuffer_tracking
results: parsing output: 76/ for test: kms_vblank
results: parsing output: 77/ for test: i915_selftest
results: parsing output: 78/ for test: gem_readwrite
results: parsing output: 79/ for test: syncobj_timeline
results: parsing output: 80/ for test: fbdev
results: parsing output: 81/ for test: gem_eio
results: parsing output: 82/ for test: syncobj_wait
results: parsing output: 83/ for test: kms_rotation_crc
results: parsing output: 84/ for test: kms_frontbuffer_tracking
results: parsing output: 85/ for test: perf_pmu
results: parsing output: 86/ for test: kms_frontbuffer_tracking
results: parsing output: 87/ for test: gem_exec_schedule
results: parsing output: 88/ for test: gem_exec_schedule
results: parsing output: 89/ for test: kms_big_fb
results: parsing output: 90/ for test: kms_pipe_crc_basic
results: parsing output: 91/ for test: kms_properties
results: parsing output: 92/ for test: gem_ringfill
results: parsing output: 93/ for test: gem_mmap_wc
results: parsing output: 94/ for test: kms_psr
results: parsing output: 95/ for test: kms_frontbuffer_tracking
results: parsing output: 96/ for test: kms_frontbuffer_tracking
results: parsing output: 97/ for test: gem_exec_balancer
results: parsing output: 98/ for test: gem_exec_whisper
results: parsing output: 99/ for test: kms_pm_backlight
results: parsing output: 100/ for test: gem_ctx_persistence
results: parsing output: 101/ for test: gem_exec_reloc
results: parsing output: 102/ for test: gem_wait
results: parsing output: 103/ for test: kms_psr
results: parsing output: 104/ for test: i915_drm_fdinfo
results: parsing output: 105/ for test: gem_exec_create
results: parsing output: 106/ for test: kms_frontbuffer_tracking
results: parsing output: 107/ for test: kms_psr2_sf
results: parsing output: 108/ for test: kms_frontbuffer_tracking
results: parsing output: 109/ for test: kms_frontbuffer_tracking
results: parsing output: 110/ for test: gem_exec_fence
results: parsing output: 111/ for test: gem_mmap_gtt
results: parsing output: 112/ for test: kms_frontbuffer_tracking
results: parsing output: 113/ for test: syncobj_timeline
results: parsing output: 114/ for test: kms_async_flips
results: parsing output: 115/ for test: kms_flip
results: parsing output: 116/ for test: prime_vgem
results: parsing output: 117/ for test: gem_unref_active_buffers
results: parsing output: 118/ for test: kms_psr
results: parsing output: 119/ for test: syncobj_timeline
results: parsing output: 120/ for test: syncobj_wait
results: parsing output: 121/ for test: gem_ctx_bad_destroy
results: parsing output: 122/ for test: gem_pxp
results: parsing output: 123/ for test: kms_flip
results: parsing output: 124/ for test: gem_userptr_blits
results: parsing output: 125/ for test: kms_properties
results: parsing output: 126/ for test: gem_mmap_gtt
results: parsing output: 127/ for test: kms_frontbuffer_tracking
results: parsing output: 128/ for test: kms_color_pipeline
results: parsing output: 129/ for test: sysfs_timeslice_duration
results: parsing output: 130/ for test: gem_spin_batch
results: parsing output: 131/ for test: gem_userptr_blits
results: parsing output: 132/ for test: dmabuf_sync_file
Done.