[53.951567] Initializing watchdogs
[53.951630]   /dev/watchdog0
[53.966216] [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]
[53.970733] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[53.972811] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[53.975915] [001/131] (960s left) syncobj_timeline (wait-all-for-submit-complex)
[54.051970] Starting subtest: wait-all-for-submit-complex
[54.266050] Subtest wait-all-for-submit-complex: SUCCESS (0.214s)
[54.336689] [002/131] (960s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-onoff)
[54.455020] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-onoff
[61.327152] Subtest fbcpsr-1p-primscrn-cur-indfb-onoff: SUCCESS (6.877s)
[61.456074] [003/131] (953s left) gem_mmap_offset (basic-uaf)
[61.528078] Starting subtest: basic-uaf
[61.530046] Subtest basic-uaf: SUCCESS (0.001s)
[61.637421] [004/131] (952s left) kms_getfb (getfb-repeated-different-handles)
[61.729941] Starting subtest: getfb-repeated-different-handles
[61.731884] Subtest getfb-repeated-different-handles: SUCCESS (0.000s)
[61.835870] [005/131] (952s left) kms_atomic_transition (plane-all-modeset-transition-fencing-internal-panels)
[61.919807] Starting subtest: plane-all-modeset-transition-fencing-internal-panels
[61.922156] Starting dynamic subtest: pipe-A-eDP-1
[63.272335] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.351s)
[63.549598] Starting dynamic subtest: pipe-B-eDP-1
[64.595072] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.052s)
[64.859767] Subtest plane-all-modeset-transition-fencing-internal-panels: SUCCESS (2.939s)
[65.695731] [006/131] (948s left) gem_exec_whisper (basic-forked-all)
[65.754074] Starting subtest: basic-forked-all
[79.896679] Subtest basic-forked-all: SUCCESS (14.138s)
[80.075815] [007/131] (934s left) gem_mmap_wc (write-prefaulted)
[80.130568] Subtest write-prefaulted: SKIP (0.000s)
[80.191903] [008/131] (934s left) kms_ccs (random-ccs-data-4-tiled-mtl-mc-ccs)
[80.284059] Starting subtest: random-ccs-data-4-tiled-mtl-mc-ccs
[80.286413] Starting dynamic subtest: pipe-A-eDP-1
[81.543945] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.258s)
[81.553079] Starting dynamic subtest: pipe-B-eDP-1
[83.843527] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.300s)
[83.852915] Starting dynamic subtest: pipe-C-eDP-1
[86.145972] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.302s)
[86.154090] Starting dynamic subtest: pipe-D-eDP-1
[88.479913] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.333s)
[88.482380] Subtest random-ccs-data-4-tiled-mtl-mc-ccs: SUCCESS (8.195s)
[89.595054] [009/131] (925s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-mmap-wc)
[89.696586] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-mmap-wc
[89.701101] Subtest fbc-2p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[89.787697] [010/131] (925s left) gem_ctx_persistence (saturated-hostile)
[89.843920] Starting subtest: saturated-hostile
[89.846237] Starting dynamic subtest: rcs0
[90.696879] Dynamic subtest rcs0: SUCCESS (0.852s)
[90.705727] Starting dynamic subtest: bcs0
[91.491105] Dynamic subtest bcs0: SUCCESS (0.795s)
[91.501990] Starting dynamic subtest: vcs0
[92.294217] Dynamic subtest vcs0: SUCCESS (0.802s)
[92.304217] Starting dynamic subtest: vcs1
[93.117256] Dynamic subtest vcs1: SUCCESS (0.823s)
[93.125111] Starting dynamic subtest: vecs0
[93.913524] Dynamic subtest vecs0: SUCCESS (0.796s)
[93.921266] Starting dynamic subtest: ccs0
[94.752418] Dynamic subtest ccs0: SUCCESS (0.838s)
[94.754894] Subtest saturated-hostile: SUCCESS (4.908s)
[94.824234] [011/131] (920s left) gem_exec_balancer (parallel-keep-in-fence)
[95.084196] Starting subtest: parallel-keep-in-fence
[96.100562] Subtest parallel-keep-in-fence: SUCCESS (1.015s)
[96.197294] [012/131] (918s left) kms_cursor_crc (cursor-sliding-64x21)
[96.400717] Starting subtest: cursor-sliding-64x21
[96.440172] Subtest cursor-sliding-64x21: SKIP (0.038s)
[96.679215] [013/131] (918s left) syncobj_wait (invalid-multi-wait-unsubmitted-submitted)
[96.735930] Starting subtest: invalid-multi-wait-unsubmitted-submitted
[96.738432] Subtest invalid-multi-wait-unsubmitted-submitted: SUCCESS (0.000s)
[96.830677] [014/131] (918s left) kms_psr (fbc-pr-primary-blt)
[96.923250] Starting subtest: fbc-pr-primary-blt
[96.927897] Subtest fbc-pr-primary-blt: SKIP (0.000s)
[96.991811] [015/131] (917s left) perf (gen12-group-exclusive-stream-sample-oa)
[97.108271] Starting subtest: gen12-group-exclusive-stream-sample-oa
[97.142520] Subtest gen12-group-exclusive-stream-sample-oa: SUCCESS (0.034s)
[97.197375] [016/131] (917s left) kms_psr (pr-primary-mmap-cpu)
[97.281718] Starting subtest: pr-primary-mmap-cpu
[97.285257] Subtest pr-primary-mmap-cpu: SKIP (0.000s)
[97.346808] [017/131] (917s left) kms_content_protection (mei-interface)
[97.514044] Starting subtest: mei-interface
[97.518041] Subtest mei-interface: SKIP (0.001s)
[97.658144] [018/131] (917s left) gem_tiled_swapping (non-threaded)
[97.709756] Subtest non-threaded: SKIP (0.000s)
[97.783283] [019/131] (917s left) kms_big_fb (yf-tiled-8bpp-rotate-0)
[97.882644] Starting subtest: yf-tiled-8bpp-rotate-0
[97.886079] Subtest yf-tiled-8bpp-rotate-0: SKIP (0.000s)
[97.963205] [020/131] (917s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-render)
[98.054486] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-render
[105.260659] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-render: SUCCESS (7.208s)
[105.394768] [021/131] (909s left) sw_sync (sync_merge_invalid)
[105.427683] Starting subtest: sync_merge_invalid
[105.459289] Subtest sync_merge_invalid: SUCCESS (0.033s)
[105.557615] [022/131] (909s left) kms_frontbuffer_tracking (fbc-1p-primscrn-indfb-plflip-blt)
[105.661346] Starting subtest: fbc-1p-primscrn-indfb-plflip-blt
[110.189492] Subtest fbc-1p-primscrn-indfb-plflip-blt: SUCCESS (4.532s)
[111.381350] [023/131] (903s left) kms_plane_scaling (planes-downscale-factor-0-25-upscale-20x20)
[111.466488] Starting subtest: planes-downscale-factor-0-25-upscale-20x20
[111.468968] Starting dynamic subtest: pipe-A
[111.484903] Dynamic subtest pipe-A: SKIP (0.012s)
[111.494261] Starting dynamic subtest: pipe-B
[111.509121] Dynamic subtest pipe-B: SKIP (0.024s)
[111.516912] Starting dynamic subtest: pipe-C
[111.531915] Dynamic subtest pipe-C: SKIP (0.024s)
[111.539696] Starting dynamic subtest: pipe-D
[111.556229] Dynamic subtest pipe-D: SKIP (0.024s)
[111.560517] Subtest planes-downscale-factor-0-25-upscale-20x20: SKIP (0.085s)
[111.674088] [024/131] (903s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-render)
[111.782449] Starting subtest: psr-2p-primscrn-pri-indfb-draw-render
[111.786894] Subtest psr-2p-primscrn-pri-indfb-draw-render: SKIP (0.000s)
[111.879235] [025/131] (903s left) kms_big_fb (x-tiled-64bpp-rotate-270)
[111.981478] Starting subtest: x-tiled-64bpp-rotate-270
[112.003621] Subtest x-tiled-64bpp-rotate-270: SKIP (0.019s)
[112.135463] [026/131] (903s left) kms_plane_multiple (tiling-x)
[112.225993] Starting subtest: tiling-x
[112.228377] Starting dynamic subtest: pipe-A-eDP-1
[115.885033] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.656s)
[115.893992] Starting dynamic subtest: pipe-B-eDP-1
[120.284450] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.399s)
[120.292401] Starting dynamic subtest: pipe-C-eDP-1
[124.576274] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.290s)
[124.585248] Starting dynamic subtest: pipe-D-eDP-1
[128.853041] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.277s)
[128.855061] Subtest tiling-x: SUCCESS (16.626s)
[129.656911] [027/131] (885s left) api_intel_bb (offset-control)
[129.706117] Starting subtest: offset-control
[129.712622] Subtest offset-control: SUCCESS (0.008s)
[129.827918] [028/131] (885s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-mmap-gtt)
[129.928153] Starting subtest: fbcpsr-rgb101010-draw-mmap-gtt
[129.932263] Subtest fbcpsr-rgb101010-draw-mmap-gtt: SKIP (0.000s)
[130.046020] [029/131] (885s left) gem_render_copy_redux (normal)
[130.111748] Starting subtest: normal
[130.453460] Subtest normal: SUCCESS (0.343s)
[130.577992] [030/131] (884s left) gem_exec_fence (syncobj-import)
[131.008902] Starting subtest: syncobj-import
[131.014142] Subtest syncobj-import: SUCCESS (0.005s)
[133.001761] [FACT gem_exec_fence (syncobj-import)] new: kernel.kmod_is_loaded.vgem: true
[133.005748] [031/131] (882s left) kms_cursor_crc (cursor-random-32x10)
[133.186613] Starting subtest: cursor-random-32x10
[133.233389] Subtest cursor-random-32x10: SKIP (0.040s)
[133.482733] [032/131] (882s left) gem_pxp (reject-modify-context-protection-off-3)
[133.601877] Starting subtest: reject-modify-context-protection-off-3
[133.604644] Subtest reject-modify-context-protection-off-3: SUCCESS (0.002s)
[133.720354] [033/131] (881s left) kms_ccs (crc-primary-suspend-4-tiled-mtl-rc-ccs-cc)
[133.812072] Starting subtest: crc-primary-suspend-4-tiled-mtl-rc-ccs-cc
[133.814285] Starting dynamic subtest: pipe-A-eDP-1
[150.364411] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.533s)
[150.374602] Starting dynamic subtest: pipe-B-eDP-1
[167.255994] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.331s)
[167.265444] Starting dynamic subtest: pipe-C-eDP-1
[184.224965] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.285s)
[184.234617] Starting dynamic subtest: pipe-D-eDP-1
[201.247517] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.226s)
[201.249892] Subtest crc-primary-suspend-4-tiled-mtl-rc-ccs-cc: SUCCESS (8.379s)
[202.451800] [034/131] (813s left) kms_sequence (queue-idle)
[202.542515] Starting subtest: queue-idle
[202.545178] Starting dynamic subtest: pipe-A-eDP-1
[204.359171] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.812s)
[204.369047] Starting dynamic subtest: pipe-B-eDP-1
[206.823357] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.460s)
[206.833473] Starting dynamic subtest: pipe-C-eDP-1
[209.240157] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.410s)
[209.249849] Starting dynamic subtest: pipe-D-eDP-1
[211.650926] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.410s)
[211.653364] Subtest queue-idle: SUCCESS (9.095s)
[212.459385] [035/131] (803s left) gen7_exec_parse (load-register-reg)
[212.514290] Subtest load-register-reg: SKIP (0.000s)
[212.624086] [036/131] (803s left) kms_busy (basic)
[212.724566] Starting subtest: basic
[212.726875] Starting dynamic subtest: flip
[213.418309] Dynamic subtest flip: SUCCESS (0.692s)
[213.427703] Starting dynamic subtest: modeset
[216.865561] Dynamic subtest modeset: SUCCESS (3.443s)
[216.867954] Subtest basic: SUCCESS (4.137s)
[217.660828] [037/131] (798s left) kms_flip (flip-vs-modeset-vs-hang)
[217.760828] Starting subtest: flip-vs-modeset-vs-hang
[217.762993] Starting dynamic subtest: A-eDP1
[257.422675] Dynamic subtest A-eDP1: SUCCESS (39.632s)
[257.433618] Starting dynamic subtest: D-eDP1
[307.409880] Dynamic subtest D-eDP1: SUCCESS (49.977s)
[307.411733] Subtest flip-vs-modeset-vs-hang: SUCCESS (89.613s)
[307.773985] [038/131] (708s left) kms_psr2_sf (fbc-pr-overlay-plane-update-continuous-sf)
[312.818789] Starting subtest: fbc-pr-overlay-plane-update-continuous-sf
[312.823482] Subtest fbc-pr-overlay-plane-update-continuous-sf: SKIP (0.002s)
[313.675281] [039/131] (702s left) gem_exec_flush (basic-wb-prw-default)
[313.739974] Starting subtest: basic-wb-prw-default
[319.216519] Subtest basic-wb-prw-default: SUCCESS (5.449s)
[319.381222] [040/131] (696s left) gem_exec_reloc (basic-write-wc-active)
[319.445323] Subtest basic-write-wc-active: SKIP (0.000s)
[319.532380] [041/131] (696s left) kms_color (degamma)
[319.639106] Starting subtest: degamma
[319.641578] Starting dynamic subtest: pipe-A-eDP-1
[320.374266] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.733s)
[320.386124] Starting dynamic subtest: pipe-B-eDP-1
[321.806376] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.431s)
[321.816511] Starting dynamic subtest: pipe-C-eDP-1
[323.132905] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.328s)
[323.144065] Starting dynamic subtest: pipe-D-eDP-1
[324.484950] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.349s)
[324.486869] Subtest degamma: SUCCESS (4.845s)
[325.268372] [042/131] (690s left) gem_mmap_wc (write)
[325.320497] Subtest write: SKIP (0.000s)
[325.387157] [043/131] (690s left) gen9_exec_parse (unaligned-access)
[325.451852] Subtest unaligned-access: SKIP (0.000s)
[325.532322] [044/131] (690s left) kms_chamelium_color (ctm-max)
[325.627600] Subtest ctm-max: SKIP (0.000s)
[325.673213] [045/131] (690s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-blt)
[325.770967] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-blt
[325.775413] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[325.886608] [046/131] (690s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-32bpp-xtile-downscaling)
[325.972792] Starting subtest: flip-64bpp-xtile-to-32bpp-xtile-downscaling
[325.975030] Starting dynamic subtest: pipe-A-default-mode
[327.119794] Dynamic subtest pipe-A-default-mode: SKIP (1.140s)
[327.124588] Subtest flip-64bpp-xtile-to-32bpp-xtile-downscaling: SKIP (1.141s)
[327.255960] [047/131] (688s left) kms_ccs (crc-primary-suspend-4-tiled-dg2-rc-ccs-cc)
[327.347689] Starting subtest: crc-primary-suspend-4-tiled-dg2-rc-ccs-cc
[327.349943] Starting dynamic subtest: pipe-A-eDP-1
[327.359063] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[327.369436] Starting dynamic subtest: pipe-B-eDP-1
[327.378386] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[327.387569] Starting dynamic subtest: pipe-C-eDP-1
[327.396330] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[327.405303] Starting dynamic subtest: pipe-D-eDP-1
[327.413930] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[327.418417] Subtest crc-primary-suspend-4-tiled-dg2-rc-ccs-cc: SKIP (0.004s)
[329.633246] [048/131] (686s left) fbdev (pan)
[329.664304] Starting subtest: pan
[329.697150] Subtest pan: SUCCESS (0.034s)
[329.771094] [049/131] (686s left) kms_atomic (crtc-invalid-params-fence)
[329.859774] Starting subtest: crtc-invalid-params-fence
[329.862134] Starting dynamic subtest: pipe-A-eDP-1
[330.271060] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.407s)
[330.272908] Subtest crtc-invalid-params-fence: SUCCESS (0.408s)
[331.057325] [050/131] (685s left) kms_flip (flip-vs-expired-vblank-interruptible)
[331.162047] Starting subtest: flip-vs-expired-vblank-interruptible
[331.164394] Starting dynamic subtest: A-eDP1
[339.906812] Dynamic subtest A-eDP1: SUCCESS (8.711s)
[339.916097] Starting dynamic subtest: B-eDP1
[348.620864] Dynamic subtest B-eDP1: SUCCESS (8.708s)
[348.632388] Starting dynamic subtest: C-eDP1
[357.243928] Dynamic subtest C-eDP1: SUCCESS (8.611s)
[357.254949] Starting dynamic subtest: D-eDP1
[365.868870] Dynamic subtest D-eDP1: SUCCESS (8.624s)
[365.870882] Subtest flip-vs-expired-vblank-interruptible: SUCCESS (34.663s)
[366.983882] [051/131] (649s left) kms_flip (2x-blocking-wf_vblank)
[367.084514] Starting subtest: 2x-blocking-wf_vblank
[367.095767] Subtest 2x-blocking-wf_vblank: SKIP (0.011s)
[367.175829] [052/131] (649s left) sw_sync (sync_merge)
[367.208194] Starting subtest: sync_merge
[367.210517] Subtest sync_merge: SUCCESS (0.000s)
[367.259479] [053/131] (649s left) gem_exec_whisper (basic-contexts-forked)
[367.316570] Starting subtest: basic-contexts-forked
[390.540118] Subtest basic-contexts-forked: SUCCESS (23.215s)
[390.724561] [054/131] (625s left) gem_spin_batch (resubmit-all)
[390.803512] Starting subtest: resubmit-all
[390.805717] Starting dynamic subtest: rcs0
[390.823585] Dynamic subtest rcs0: SUCCESS (0.020s)
[390.834640] Starting dynamic subtest: bcs0
[390.836851] Dynamic subtest bcs0: SUCCESS (0.003s)
[390.845670] Starting dynamic subtest: vcs0
[390.847817] Dynamic subtest vcs0: SUCCESS (0.002s)
[390.856227] Starting dynamic subtest: vcs1
[390.858490] Dynamic subtest vcs1: SUCCESS (0.003s)
[390.866839] Starting dynamic subtest: vecs0
[390.869084] Dynamic subtest vecs0: SUCCESS (0.002s)
[390.877638] Starting dynamic subtest: ccs0
[390.879859] Dynamic subtest ccs0: SUCCESS (0.003s)
[390.882127] Subtest resubmit-all: SUCCESS (0.037s)
[391.959747] [055/131] (624s left) kms_flip (2x-flip-vs-panning-interruptible)
[392.062295] Starting subtest: 2x-flip-vs-panning-interruptible
[392.072805] Subtest 2x-flip-vs-panning-interruptible: SKIP (0.010s)
[392.171613] [056/131] (624s left) gem_exec_schedule (preemptive-hang)
[392.340897] Starting subtest: preemptive-hang
[392.343623] Starting dynamic subtest: rcs0
[402.077907] Dynamic subtest rcs0: SUCCESS (9.725s)
[402.087999] Starting dynamic subtest: bcs0
[411.099039] Dynamic subtest bcs0: SUCCESS (9.024s)
[411.107216] Starting dynamic subtest: vcs0
[420.059062] Dynamic subtest vcs0: SUCCESS (8.955s)
[420.070730] Starting dynamic subtest: vcs1
[429.075944] Dynamic subtest vcs1: SUCCESS (9.015s)
[429.085031] Starting dynamic subtest: vecs0
[438.041046] Dynamic subtest vecs0: SUCCESS (8.956s)
[438.052008] Starting dynamic subtest: ccs0
[447.068139] Dynamic subtest ccs0: SUCCESS (9.027s)
[447.070510] Subtest preemptive-hang: SUCCESS (54.709s)
[447.300316] [057/131] (569s left) i915_query (query-topology-garbage-items)
[447.363590] Starting subtest: query-topology-garbage-items
[447.365849] Subtest query-topology-garbage-items: SUCCESS (0.000s)
[447.492351] [058/131] (569s left) syncobj_wait (wait-all-snapshot)
[447.536260] Starting subtest: wait-all-snapshot
[447.617172] Subtest wait-all-snapshot: SUCCESS (0.081s)
[447.694718] [059/131] (569s left) kms_frontbuffer_tracking (fbc-1p-primscrn-shrfb-msflip-blt)
[447.806122] Starting subtest: fbc-1p-primscrn-shrfb-msflip-blt
[452.339044] Subtest fbc-1p-primscrn-shrfb-msflip-blt: SUCCESS (4.543s)
[453.480910] [060/131] (563s left) kms_frontbuffer_tracking (psr-modesetfrombusy)
[453.585758] Starting subtest: psr-modesetfrombusy
[459.690119] Subtest psr-modesetfrombusy: SUCCESS (6.109s)
[459.826536] [061/131] (556s left) kms_cursor_legacy (flip-vs-cursor-atomic)
[459.939649] Starting subtest: flip-vs-cursor-atomic
[466.949511] Subtest flip-vs-cursor-atomic: SUCCESS (7.006s)
[467.802343] [062/131] (549s left) gem_mmap_wc (coherency)
[467.856216] Subtest coherency: SKIP (0.000s)
[467.920751] [063/131] (548s left) kms_setmode (invalid-clone-single-crtc-stealing)
[467.979356] Starting subtest: invalid-clone-single-crtc-stealing
[467.986218] Subtest invalid-clone-single-crtc-stealing: SKIP (0.000s)
[468.086039] [064/131] (548s left) kms_big_fb (4-tiled-32bpp-rotate-0)
[468.190369] Starting subtest: 4-tiled-32bpp-rotate-0
[469.947131] Subtest 4-tiled-32bpp-rotate-0: SUCCESS (1.756s)
[470.123120] [065/131] (546s left) gem_eio (context-create)
[470.333762] Starting subtest: context-create
[470.626459] Subtest context-create: SUCCESS (0.294s)
[470.762016] [066/131] (546s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-render)
[470.857564] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-render
[474.527370] Subtest fbc-1p-primscrn-cur-indfb-draw-render: SUCCESS (3.673s)
[475.690318] [067/131] (541s left) gem_render_copy (yf-tiled-ccs-to-linear)
[475.746023] Starting subtest: yf-tiled-ccs-to-linear
[475.750661] Subtest yf-tiled-ccs-to-linear: SKIP (0.000s)
[475.931872] [068/131] (541s left) kms_frontbuffer_tracking (psr-2p-scndscrn-indfb-msflip-blt)
[476.030468] Starting subtest: psr-2p-scndscrn-indfb-msflip-blt
[476.034945] Subtest psr-2p-scndscrn-indfb-msflip-blt: SKIP (0.000s)
[476.153298] [069/131] (540s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-render)
[476.248685] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-render
[476.252965] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-render: SKIP (0.000s)
[476.345356] [070/131] (540s left) sw_sync (sync_multi_consumer_producer)
[476.380692] Starting subtest: sync_multi_consumer_producer
[476.715644] Subtest sync_multi_consumer_producer: SUCCESS (0.337s)
[476.773901] [071/131] (540s left) syncobj_timeline (invalid-signal-illegal-point)
[476.831262] Starting subtest: invalid-signal-illegal-point
[476.833945] Subtest invalid-signal-illegal-point: SUCCESS (0.000s)
[476.931284] [072/131] (540s left) i915_suspend (basic-s2idle-without-i915)
[476.963307] Starting subtest: basic-s2idle-without-i915
[497.536606] Subtest basic-s2idle-without-i915: SUCCESS (5.752s)
[497.649533] [073/131] (519s left) kms_vrr (flip-suspend)
[497.752724] Starting subtest: flip-suspend
[497.759439] Subtest flip-suspend: SKIP (0.000s)
[497.826764] [074/131] (519s left) kms_big_fb (y-tiled-64bpp-rotate-0)
[497.933897] Starting subtest: y-tiled-64bpp-rotate-0
[497.937573] Subtest y-tiled-64bpp-rotate-0: SKIP (0.000s)
[498.037419] [075/131] (519s left) kms_draw_crc (draw-method-pwrite)
[498.130092] Starting subtest: draw-method-pwrite
[498.131708] Starting dynamic subtest: xrgb8888-untiled
[498.687863] Dynamic subtest xrgb8888-untiled: SUCCESS (0.559s)
[498.696985] Starting dynamic subtest: rgb565-untiled
[499.144348] Dynamic subtest rgb565-untiled: SUCCESS (0.456s)
[499.153971] Starting dynamic subtest: xrgb2101010-untiled
[499.688088] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.543s)
[499.697441] Starting dynamic subtest: xbgr16161616f-untiled
[500.443976] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.755s)
[500.452340] Starting dynamic subtest: xrgb8888-xtiled
[502.183559] Dynamic subtest xrgb8888-xtiled: SUCCESS (1.733s)
[502.192252] Starting dynamic subtest: rgb565-xtiled
[503.243225] Dynamic subtest rgb565-xtiled: SUCCESS (1.054s)
[503.252326] Starting dynamic subtest: xrgb2101010-xtiled
[504.982371] Dynamic subtest xrgb2101010-xtiled: SUCCESS (1.732s)
[504.991081] Starting dynamic subtest: xbgr16161616f-xtiled
[508.212117] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (3.222s)
[508.220627] Starting dynamic subtest: xrgb8888-4tiled
[509.269791] Dynamic subtest xrgb8888-4tiled: SUCCESS (1.055s)
[509.278617] Starting dynamic subtest: rgb565-4tiled
[509.815203] Dynamic subtest rgb565-4tiled: SUCCESS (0.543s)
[509.823735] Starting dynamic subtest: xrgb2101010-4tiled
[510.872401] Dynamic subtest xrgb2101010-4tiled: SUCCESS (1.055s)
[510.882003] Starting dynamic subtest: xbgr16161616f-4tiled
[513.754332] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (2.877s)
[513.756683] Subtest draw-method-pwrite: SUCCESS (15.593s)
[513.868702] [076/131] (503s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-mmap-cpu)
[513.978676] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-mmap-cpu
[517.583964] Subtest fbc-1p-primscrn-cur-indfb-draw-mmap-cpu: SUCCESS (3.606s)
[518.751495] [077/131] (498s left) kms_prime (d3hot)
[518.833792] Subtest D3hot: SKIP (0.000s)
[518.920219] [078/131] (498s left) kms_frontbuffer_tracking (psr-1p-offscren-pri-indfb-draw-render)
[519.013650] Starting subtest: psr-1p-offscren-pri-indfb-draw-render
[525.909681] Subtest psr-1p-offscren-pri-indfb-draw-render: SUCCESS (6.893s)
[526.088020] [079/131] (491s left) kms_tv_load_detect (load-detect)
[526.144373] Subtest load-detect: SKIP (0.000s)
[526.208837] [080/131] (491s left) kms_psr (psr2-sprite-blt)
[526.311804] Starting subtest: psr2-sprite-blt
[526.314114] Starting dynamic subtest: eDP-1
[528.013058] Dynamic subtest eDP-1: SUCCESS (1.699s)
[528.014972] Subtest psr2-sprite-blt: SUCCESS (1.700s)
[528.873207] [081/131] (488s left) kms_ccs (ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc)
[528.962335] Starting subtest: ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc
[528.964690] Starting dynamic subtest: pipe-A-eDP-1
[528.984153] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[528.993814] Starting dynamic subtest: pipe-B-eDP-1
[529.013833] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[529.022339] Starting dynamic subtest: pipe-C-eDP-1
[529.041860] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[529.050563] Starting dynamic subtest: pipe-D-eDP-1
[529.070357] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[529.072242] Subtest ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.007s)
[531.219898] [082/131] (486s left) gem_exec_reloc (basic-gtt)
[531.282392] Subtest basic-gtt: SKIP (0.000s)
[531.378793] [083/131] (486s left) gem_mmap_gtt (basic)
[531.431778] Subtest basic: SKIP (0.000s)
[531.484470] [084/131] (486s left) gem_exec_reloc (basic-gtt-wc-active)
[531.541234] Subtest basic-gtt-wc-active: SKIP (0.000s)
[531.631398] [085/131] (486s left) kms_hdr (invalid-hdr)
[531.719462] Starting subtest: invalid-hdr
[532.789971] Starting dynamic subtest: pipe-A-eDP-1
[535.679809] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.892s)
[535.682167] Subtest invalid-hdr: SUCCESS (3.963s)
[535.817245] [086/131] (481s left) gem_exec_params (readonly)
[535.880205] Starting subtest: readonly
[535.884736] Subtest readonly: SUCCESS (0.005s)
[536.023878] [087/131] (481s left) i915_pm_rpm (gem-evict-pwrite)
[537.867375] Starting subtest: gem-evict-pwrite
[537.872342] Subtest gem-evict-pwrite: SKIP (0.000s)
[538.328617] [088/131] (479s left) kms_flip (flip-vs-dpms-on-nop)
[538.417404] Starting subtest: flip-vs-dpms-on-nop
[538.419657] Starting dynamic subtest: A-eDP1
[540.301832] Dynamic subtest A-eDP1: SUCCESS (1.884s)
[540.312711] Starting dynamic subtest: B-eDP1
[542.225881] Dynamic subtest B-eDP1: SUCCESS (1.923s)
[542.236741] Starting dynamic subtest: C-eDP1
[544.155300] Dynamic subtest C-eDP1: SUCCESS (1.928s)
[544.166228] Starting dynamic subtest: D-eDP1
[546.064640] Dynamic subtest D-eDP1: SUCCESS (1.908s)
[546.067036] Subtest flip-vs-dpms-on-nop: SUCCESS (7.651s)
[547.241955] [089/131] (470s left) syncobj_timeline (etime-single-wait-all-available-unsubmitted)
[547.294477] Starting subtest: etime-single-wait-all-available-unsubmitted
[547.404135] Subtest etime-single-wait-all-available-unsubmitted: SUCCESS (0.108s)
[547.477239] [090/131] (470s left) gem_readwrite (write-bad-handle)
[547.526648] Subtest write-bad-handle: SKIP (0.000s)
[547.590946] [091/131] (470s left) kms_joiner (invalid-modeset-big-joiner)
[547.687884] Starting subtest: invalid-modeset-big-joiner
[547.691750] Subtest invalid-modeset-big-joiner: SKIP (0.000s)
[547.753518] [092/131] (470s left) prime_vgem (coherency-gtt)
[547.819572] Starting subtest: coherency-gtt
[547.824356] Subtest coherency-gtt: SKIP (0.000s)
[547.928091] [093/131] (470s left) gem_softpin (evict-single-offset)
[547.972199] Starting subtest: evict-single-offset
[577.751902] Subtest evict-single-offset: SUCCESS (29.771s)
[577.833045] [094/131] (440s left) kms_rotation_crc (multiplane-rotation)
[577.976908] Starting subtest: multiplane-rotation
[586.249685] Subtest multiplane-rotation: SUCCESS (8.270s)
[586.363023] [095/131] (431s left) gem_softpin (noreloc)
[586.421647] Starting subtest: noreloc
[591.898886] Subtest noreloc: SUCCESS (5.422s)
[591.978529] [096/131] (426s left) i915_query (query-topology-matches-eu-total)
[592.042164] Starting subtest: query-topology-matches-eu-total
[592.044662] Subtest query-topology-matches-eu-total: SUCCESS (0.000s)
[592.142037] [097/131] (426s left) vgem_slow (nohang)
[592.185652] Starting subtest: nohang
[602.408410] Subtest nohang: SUCCESS (10.175s)
[602.446008] [098/131] (415s left) kms_pipe_crc_basic (read-crc-frame-sequence)
[602.547155] Starting subtest: read-crc-frame-sequence
[602.549630] Starting dynamic subtest: pipe-A-eDP-1
[603.270377] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.723s)
[603.280895] Starting dynamic subtest: pipe-B-eDP-1
[604.626337] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.352s)
[604.636250] Starting dynamic subtest: pipe-C-eDP-1
[605.905053] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.278s)
[605.915193] Starting dynamic subtest: pipe-D-eDP-1
[607.252024] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.347s)
[607.254347] Subtest read-crc-frame-sequence: SUCCESS (4.705s)
[608.066873] [099/131] (410s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-mmap-wc)
[608.168280] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-mmap-wc
[615.106534] Subtest psr-1p-primscrn-pri-shrfb-draw-mmap-wc: SUCCESS (6.943s)
[615.229561] [100/131] (403s left) kms_psr (fbc-psr-primary-mmap-cpu)
[615.325832] Starting subtest: fbc-psr-primary-mmap-cpu
[615.327724] Starting dynamic subtest: eDP-1
[615.331915] Dynamic subtest eDP-1: SKIP (0.000s)
[615.336048] Subtest fbc-psr-primary-mmap-cpu: SKIP (0.001s)
[615.393463] [101/131] (402s left) kms_lease (lease-uevent)
[615.485735] Starting subtest: lease-uevent
[616.493994] Subtest lease-uevent: SUCCESS (1.007s)
[616.573996] [102/131] (401s left) kms_pm_backlight (fade)
[616.664783] Starting subtest: fade
[616.749773] Starting dynamic subtest: eDP-1
[619.426918] Dynamic subtest eDP-1: SUCCESS (2.679s)
[619.429202] Subtest fade: SUCCESS (2.765s)
[620.272730] [103/131] (398s left) gem_create (create-ext-cpu-access-sanity-check)
[620.440298] Starting subtest: create-ext-cpu-access-sanity-check
[620.444486] Subtest create-ext-cpu-access-sanity-check: SKIP (0.001s)
[620.514076] [104/131] (397s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-64bpp-yftile-downscaling)
[620.608923] Starting subtest: flip-32bpp-yftile-to-64bpp-yftile-downscaling
[620.611229] Starting dynamic subtest: pipe-A-default-mode
[620.902231] Dynamic subtest pipe-A-default-mode: SKIP (0.290s)
[620.906829] Subtest flip-32bpp-yftile-to-64bpp-yftile-downscaling: SKIP (0.291s)
[621.698334] [105/131] (396s left) gem_sync (basic-store-all)
[621.775475] Starting subtest: basic-store-all
[624.615955] Subtest basic-store-all: SUCCESS (2.852s)
[624.800253] [106/131] (393s left) kms_chamelium_frames (hdmi-crc-nonplanar-formats)
[625.191119] Subtest hdmi-crc-nonplanar-formats: SKIP (0.000s)
[626.001759] [107/131] (392s left) perf (invalid-create-userspace-config)
[626.138663] Starting subtest: invalid-create-userspace-config
[626.140816] Subtest invalid-create-userspace-config: SUCCESS (0.001s)
[626.183271] [108/131] (392s left) kms_psr2_sf (psr2-cursor-plane-update-sf)
[631.187327] Starting subtest: psr2-cursor-plane-update-sf
[631.189706] Starting dynamic subtest: pipe-A-eDP-1
[632.471895] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.282s)
[632.482680] Starting dynamic subtest: pipe-B-eDP-1
[633.794866] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.322s)
[633.797332] Subtest psr2-cursor-plane-update-sf: SUCCESS (2.608s)
[634.662554] [109/131] (384s left) kms_big_fb (4-tiled-addfb-size-offset-overflow)
[634.773782] Starting subtest: 4-tiled-addfb-size-offset-overflow
[634.775652] Subtest 4-tiled-addfb-size-offset-overflow: SUCCESS (0.000s)
[634.867935] [110/131] (383s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-mmap-cpu)
[634.961430] Starting subtest: psr-2p-primscrn-spr-indfb-draw-mmap-cpu
[634.965582] Subtest psr-2p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[635.066286] [111/131] (383s left) kms_cursor_legacy (torture-bo)
[635.179754] Starting subtest: torture-bo
[635.182034] Starting dynamic subtest: pipe-A
[641.184440] Dynamic subtest pipe-A: SUCCESS (6.003s)
[641.197602] Starting dynamic subtest: pipe-B
[648.060341] Dynamic subtest pipe-B: SUCCESS (6.822s)
[648.070786] Starting dynamic subtest: pipe-C
[654.408884] Dynamic subtest pipe-C: SUCCESS (6.395s)
[654.421255] Starting dynamic subtest: pipe-D
[661.328430] Dynamic subtest pipe-D: SUCCESS (6.865s)
[661.338550] Starting dynamic subtest: all-pipes
[668.076395] Dynamic subtest all-pipes: SUCCESS (6.744s)
[668.078839] Subtest torture-bo: SUCCESS (32.840s)
[668.179646] [112/131] (350s left) prime_vgem (busy)
[668.260147] Starting subtest: busy
[668.262486] Starting dynamic subtest: rcs0
[668.347588] Dynamic subtest rcs0: SUCCESS (0.087s)
[668.358003] Starting dynamic subtest: bcs0
[668.419305] Dynamic subtest bcs0: SUCCESS (0.071s)
[668.428438] Starting dynamic subtest: vcs0
[668.469465] Dynamic subtest vcs0: SUCCESS (0.049s)
[668.478578] Starting dynamic subtest: vcs1
[668.514943] Dynamic subtest vcs1: SUCCESS (0.045s)
[668.524115] Starting dynamic subtest: vecs0
[668.559792] Dynamic subtest vecs0: SUCCESS (0.044s)
[668.569452] Starting dynamic subtest: ccs0
[668.606854] Dynamic subtest ccs0: SUCCESS (0.046s)
[668.609345] Subtest busy: SUCCESS (0.347s)
[668.741064] [113/131] (350s left) kms_psr (fbc-psr2-sprite-plane-onoff)
[668.841160] Starting subtest: fbc-psr2-sprite-plane-onoff
[668.843026] Starting dynamic subtest: eDP-1
[668.846934] Dynamic subtest eDP-1: SKIP (0.000s)
[668.850826] Subtest fbc-psr2-sprite-plane-onoff: SKIP (0.001s)
[668.911968] [114/131] (349s left) syncobj_wait (wait-all-for-submit-snapshot)
[668.987099] Starting subtest: wait-all-for-submit-snapshot
[669.066807] Subtest wait-all-for-submit-snapshot: SUCCESS (0.082s)
[669.160347] [115/131] (349s left) gem_unref_active_buffers
[669.326273] [116/131] (349s left) gem_exec_fence (syncobj-unused-fence)
[669.731627] Starting subtest: syncobj-unused-fence
[669.737486] Subtest syncobj-unused-fence: SUCCESS (0.005s)
[670.844208] [117/131] (348s left) kms_ccs (bad-aux-stride-y-tiled-gen12-rc-ccs)
[670.940891] Starting subtest: bad-aux-stride-y-tiled-gen12-rc-ccs
[670.943160] Starting dynamic subtest: pipe-A-eDP-1
[670.965846] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[670.976322] Starting dynamic subtest: pipe-B-eDP-1
[670.997228] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[671.005921] Starting dynamic subtest: pipe-C-eDP-1
[671.026871] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[671.035546] Starting dynamic subtest: pipe-D-eDP-1
[671.057855] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[671.061840] Subtest bad-aux-stride-y-tiled-gen12-rc-ccs: SKIP (0.007s)
[673.120785] [118/131] (345s left) gem_lmem_swapping (heavy-verify-multi)
[673.156004] Subtest heavy-verify-multi: SKIP (0.000s)
[673.194877] [119/131] (345s left) kms_plane_scaling (planes-upscale-factor-0-25)
[673.285753] Starting subtest: planes-upscale-factor-0-25
[673.288008] Starting dynamic subtest: pipe-A
[673.349571] Dynamic subtest pipe-A: SUCCESS (0.064s)
[673.359008] Starting dynamic subtest: pipe-B
[674.441279] Dynamic subtest pipe-B: SUCCESS (1.091s)
[674.452451] Starting dynamic subtest: pipe-C
[675.538909] Dynamic subtest pipe-C: SUCCESS (1.096s)
[675.549126] Starting dynamic subtest: pipe-D
[676.660121] Dynamic subtest pipe-D: SUCCESS (1.120s)
[676.662429] Subtest planes-upscale-factor-0-25: SUCCESS (3.374s)
[677.809945] [120/131] (341s left) syncobj_wait (reset-signaled)
[677.869982] Starting subtest: reset-signaled
[677.872308] Subtest reset-signaled: SUCCESS (0.000s)
[677.987695] [121/131] (341s left) syncobj_timeline (etime-multi-wait-all-for-submit-submitted-signaled)
[678.047323] Starting subtest: etime-multi-wait-all-for-submit-submitted-signaled
[678.156925] Subtest etime-multi-wait-all-for-submit-submitted-signaled: SUCCESS (0.107s)
[678.239843] [122/131] (340s left) gem_ctx_engines (none)
[678.305625] Starting subtest: none
[678.308109] Subtest none: SUCCESS (0.002s)
[678.489962] [123/131] (340s left) perf_pmu (render-node-busy)
[678.567798] Starting subtest: render-node-busy
[678.570337] Starting dynamic subtest: rcs0
[679.129375] Dynamic subtest rcs0: SUCCESS (0.561s)
[679.141855] Starting dynamic subtest: bcs0
[679.696056] Dynamic subtest bcs0: SUCCESS (0.565s)
[679.707624] Starting dynamic subtest: vcs0
[681.752010] Dynamic subtest vcs0: SUCCESS (2.052s)
[681.764398] Starting dynamic subtest: vcs1
[683.800810] Dynamic subtest vcs1: SUCCESS (2.046s)
[683.813009] Starting dynamic subtest: vecs0
[685.785061] Dynamic subtest vecs0: SUCCESS (1.981s)
[685.796797] Starting dynamic subtest: ccs0
[686.356998] Dynamic subtest ccs0: SUCCESS (0.571s)
[686.359595] Subtest render-node-busy: SUCCESS (7.788s)
[686.451714] [124/131] (332s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180-async-flip)
[686.563272] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180-async-flip
[687.821006] Subtest x-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SUCCESS (1.259s)
[688.023977] [125/131] (331s left) gem_ctx_persistence (heartbeat-close)
[688.078732] Starting subtest: heartbeat-close
[688.083476] Subtest heartbeat-close: SKIP (0.000s)
[688.200470] [126/131] (331s left) syncobj_wait (reset-multiple-signaled)
[688.271682] Starting subtest: reset-multiple-signaled
[688.274426] Subtest reset-multiple-signaled: SUCCESS (0.000s)
[688.382116] [127/131] (331s left) sysfs_timeslice_duration (invalid)
[688.428924] Starting subtest: invalid
[688.431194] Starting dynamic subtest: vecs0
[688.433475] Dynamic subtest vecs0: SUCCESS (0.000s)
[688.442650] Starting dynamic subtest: ccs0
[688.444925] Dynamic subtest ccs0: SUCCESS (0.000s)
[688.453699] Starting dynamic subtest: vcs0
[688.455880] Dynamic subtest vcs0: SUCCESS (0.000s)
[688.464512] Starting dynamic subtest: bcs0
[688.466786] Dynamic subtest bcs0: SUCCESS (0.000s)
[688.475976] Starting dynamic subtest: rcs0
[688.477898] Dynamic subtest rcs0: SUCCESS (0.000s)
[688.487077] Starting dynamic subtest: vcs1
[688.489331] Dynamic subtest vcs1: SUCCESS (0.000s)
[688.491497] Subtest invalid: SUCCESS (0.005s)
[688.530544] [128/131] (330s left) api_intel_bb (blit-noreloc-keep-cache)
[688.587210] Starting subtest: blit-noreloc-keep-cache
[688.595198] Subtest blit-noreloc-keep-cache: SUCCESS (0.011s)
[688.729006] [129/131] (330s left) syncobj_timeline (reset-during-wait-for-submit)
[688.778992] Starting subtest: reset-during-wait-for-submit
[688.875647] Subtest reset-during-wait-for-submit: SUCCESS (0.103s)
[688.953303] [130/131] (330s left) i915_hangman (engine-engine-error)
[689.019885] Starting subtest: engine-engine-error
[689.021771] Starting dynamic subtest: rcs0
[690.743949] Dynamic subtest rcs0: SUCCESS (1.721s)
[690.756254] Starting dynamic subtest: bcs0
[692.726117] Dynamic subtest bcs0: SUCCESS (1.980s)
[692.739320] Starting dynamic subtest: vcs0
[694.711371] Dynamic subtest vcs0: SUCCESS (1.982s)
[694.725575] Starting dynamic subtest: vcs1
[696.694046] Dynamic subtest vcs1: SUCCESS (1.980s)
[696.707340] Starting dynamic subtest: vecs0
[698.741516] Dynamic subtest vecs0: SUCCESS (2.045s)
[698.753694] Starting dynamic subtest: ccs0
[700.725592] Dynamic subtest ccs0: SUCCESS (1.981s)
[700.728330] Subtest engine-engine-error: SUCCESS (11.702s)
[700.809655] [131/131] (318s left) gem_mmap_wc (read)
[700.878416] Subtest read: SKIP (0.000s)
[700.928674] Closing watchdogs
results: parsing output: 0/ for test: syncobj_timeline
results: parsing output: 1/ for test: kms_frontbuffer_tracking
results: parsing output: 2/ for test: gem_mmap_offset
results: parsing output: 3/ for test: kms_getfb
results: parsing output: 4/ for test: kms_atomic_transition
results: parsing output: 5/ for test: gem_exec_whisper
results: parsing output: 6/ for test: gem_mmap_wc
results: parsing output: 7/ for test: kms_ccs
results: parsing output: 8/ for test: kms_frontbuffer_tracking
results: parsing output: 9/ for test: gem_ctx_persistence
results: parsing output: 10/ for test: gem_exec_balancer
results: parsing output: 11/ for test: kms_cursor_crc
results: parsing output: 12/ for test: syncobj_wait
results: parsing output: 13/ for test: kms_psr
results: parsing output: 14/ for test: perf
results: parsing output: 15/ for test: kms_psr
results: parsing output: 16/ for test: kms_content_protection
results: parsing output: 17/ for test: gem_tiled_swapping
results: parsing output: 18/ for test: kms_big_fb
results: parsing output: 19/ for test: kms_frontbuffer_tracking
results: parsing output: 20/ for test: sw_sync
results: parsing output: 21/ for test: kms_frontbuffer_tracking
results: parsing output: 22/ for test: kms_plane_scaling
results: parsing output: 23/ for test: kms_frontbuffer_tracking
results: parsing output: 24/ for test: kms_big_fb
results: parsing output: 25/ for test: kms_plane_multiple
results: parsing output: 26/ for test: api_intel_bb
results: parsing output: 27/ for test: kms_frontbuffer_tracking
results: parsing output: 28/ for test: gem_render_copy_redux
results: parsing output: 29/ for test: gem_exec_fence
results: parsing output: 30/ for test: kms_cursor_crc
results: parsing output: 31/ for test: gem_pxp
results: parsing output: 32/ for test: kms_ccs
results: parsing output: 33/ for test: kms_sequence
results: parsing output: 34/ for test: gen7_exec_parse
results: parsing output: 35/ for test: kms_busy
results: parsing output: 36/ for test: kms_flip
results: parsing output: 37/ for test: kms_psr2_sf
results: parsing output: 38/ for test: gem_exec_flush
results: parsing output: 39/ for test: gem_exec_reloc
results: parsing output: 40/ for test: kms_color
results: parsing output: 41/ for test: gem_mmap_wc
results: parsing output: 42/ for test: gen9_exec_parse
results: parsing output: 43/ for test: kms_chamelium_color
results: parsing output: 44/ for test: kms_frontbuffer_tracking
results: parsing output: 45/ for test: kms_flip_scaled_crc
results: parsing output: 46/ for test: kms_ccs
results: parsing output: 47/ for test: fbdev
results: parsing output: 48/ for test: kms_atomic
results: parsing output: 49/ for test: kms_flip
results: parsing output: 50/ for test: kms_flip
results: parsing output: 51/ for test: sw_sync
results: parsing output: 52/ for test: gem_exec_whisper
results: parsing output: 53/ for test: gem_spin_batch
results: parsing output: 54/ for test: kms_flip
results: parsing output: 55/ for test: gem_exec_schedule
results: parsing output: 56/ for test: i915_query
results: parsing output: 57/ for test: syncobj_wait
results: parsing output: 58/ for test: kms_frontbuffer_tracking
results: parsing output: 59/ for test: kms_frontbuffer_tracking
results: parsing output: 60/ for test: kms_cursor_legacy
results: parsing output: 61/ for test: gem_mmap_wc
results: parsing output: 62/ for test: kms_setmode
results: parsing output: 63/ for test: kms_big_fb
results: parsing output: 64/ for test: gem_eio
results: parsing output: 65/ for test: kms_frontbuffer_tracking
results: parsing output: 66/ for test: gem_render_copy
results: parsing output: 67/ for test: kms_frontbuffer_tracking
results: parsing output: 68/ for test: kms_frontbuffer_tracking
results: parsing output: 69/ for test: sw_sync
results: parsing output: 70/ for test: syncobj_timeline
results: parsing output: 71/ for test: i915_suspend
results: parsing output: 72/ for test: kms_vrr
results: parsing output: 73/ for test: kms_big_fb
results: parsing output: 74/ for test: kms_draw_crc
results: parsing output: 75/ for test: kms_frontbuffer_tracking
results: parsing output: 76/ for test: kms_prime
results: parsing output: 77/ for test: kms_frontbuffer_tracking
results: parsing output: 78/ for test: kms_tv_load_detect
results: parsing output: 79/ for test: kms_psr
results: parsing output: 80/ for test: kms_ccs
results: parsing output: 81/ for test: gem_exec_reloc
results: parsing output: 82/ for test: gem_mmap_gtt
results: parsing output: 83/ for test: gem_exec_reloc
results: parsing output: 84/ for test: kms_hdr
results: parsing output: 85/ for test: gem_exec_params
results: parsing output: 86/ for test: i915_pm_rpm
results: parsing output: 87/ for test: kms_flip
results: parsing output: 88/ for test: syncobj_timeline
results: parsing output: 89/ for test: gem_readwrite
results: parsing output: 90/ for test: kms_joiner
results: parsing output: 91/ for test: prime_vgem
results: parsing output: 92/ for test: gem_softpin
results: parsing output: 93/ for test: kms_rotation_crc
results: parsing output: 94/ for test: gem_softpin
results: parsing output: 95/ for test: i915_query
results: parsing output: 96/ for test: vgem_slow
results: parsing output: 97/ for test: kms_pipe_crc_basic
results: parsing output: 98/ for test: kms_frontbuffer_tracking
results: parsing output: 99/ for test: kms_psr
results: parsing output: 100/ for test: kms_lease
results: parsing output: 101/ for test: kms_pm_backlight
results: parsing output: 102/ for test: gem_create
results: parsing output: 103/ for test: kms_flip_scaled_crc
results: parsing output: 104/ for test: gem_sync
results: parsing output: 105/ for test: kms_chamelium_frames
results: parsing output: 106/ for test: perf
results: parsing output: 107/ for test: kms_psr2_sf
results: parsing output: 108/ for test: kms_big_fb
results: parsing output: 109/ for test: kms_frontbuffer_tracking
results: parsing output: 110/ for test: kms_cursor_legacy
results: parsing output: 111/ for test: prime_vgem
results: parsing output: 112/ for test: kms_psr
results: parsing output: 113/ for test: syncobj_wait
results: parsing output: 114/ for test: gem_unref_active_buffers
results: parsing output: 115/ for test: gem_exec_fence
results: parsing output: 116/ for test: kms_ccs
results: parsing output: 117/ for test: gem_lmem_swapping
results: parsing output: 118/ for test: kms_plane_scaling
results: parsing output: 119/ for test: syncobj_wait
results: parsing output: 120/ for test: syncobj_timeline
results: parsing output: 121/ for test: gem_ctx_engines
results: parsing output: 122/ for test: perf_pmu
results: parsing output: 123/ for test: kms_big_fb
results: parsing output: 124/ for test: gem_ctx_persistence
results: parsing output: 125/ for test: syncobj_wait
results: parsing output: 126/ for test: sysfs_timeslice_duration
results: parsing output: 127/ for test: api_intel_bb
results: parsing output: 128/ for test: syncobj_timeline
results: parsing output: 129/ for test: i915_hangman
results: parsing output: 130/ for test: gem_mmap_wc
Done.