[25.391949] Initializing watchdogs
[25.392010]   /dev/watchdog0
[25.396569] [001/142] (960s left) kms_atomic_transition (plane-toggle-modeset-transition)
[25.497363] Starting subtest: plane-toggle-modeset-transition
[25.498305] Starting dynamic subtest: pipe-A-HDMI-A-1
[27.253237] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.755s)
[27.259101] Starting dynamic subtest: pipe-B-HDMI-A-1
[28.981611] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (1.725s)
[28.986037] Subtest plane-toggle-modeset-transition: SUCCESS (3.488s)
[29.085152] [002/142] (956s left) kms_ccs (pipe-d-bad-rotation-90-4_tiled_dg2_mc_ccs)
[29.408955] Starting subtest: pipe-D-bad-rotation-90-4_tiled_dg2_mc_ccs
[29.410524] Subtest pipe-D-bad-rotation-90-4_tiled_dg2_mc_ccs: SKIP (0.000s)
[29.540071] [003/142] (956s left) prime_vgem (wait)
[29.623938] Starting subtest: wait
[29.624756] Starting dynamic subtest: rcs0
[29.648165] Dynamic subtest rcs0: SUCCESS (0.024s)
[29.651991] Starting dynamic subtest: bcs0
[29.666449] Dynamic subtest bcs0: SUCCESS (0.018s)
[29.670179] Starting dynamic subtest: vcs0
[29.683809] Dynamic subtest vcs0: SUCCESS (0.017s)
[29.687348] Starting dynamic subtest: vcs1
[29.699548] Dynamic subtest vcs1: SUCCESS (0.015s)
[29.702885] Starting dynamic subtest: vecs0
[29.714305] Dynamic subtest vecs0: SUCCESS (0.014s)
[29.715134] Subtest wait: SUCCESS (0.091s)
[29.792797] [004/142] (956s left) kms_busy (basic-hang)
[29.891228] Starting subtest: basic-hang
[29.893129] Starting dynamic subtest: flip-pipe-A
[30.226139] Dynamic subtest flip-pipe-A: SUCCESS (0.333s)
[30.229588] Starting dynamic subtest: modeset-pipe-A
[30.690658] Dynamic subtest modeset-pipe-A: SUCCESS (0.464s)
[30.698115] Starting dynamic subtest: flip-pipe-D
[31.780930] Dynamic subtest flip-pipe-D: SUCCESS (1.085s)
[31.785052] Starting dynamic subtest: modeset-pipe-D
[33.049607] Dynamic subtest modeset-pipe-D: SUCCESS (1.268s)
[33.050418] Subtest basic-hang: SUCCESS (3.158s)
[33.134081] [005/142] (952s left) kms_flip (2x-nonexisting-fb)
[33.218548] Starting subtest: 2x-nonexisting-fb
[33.230697] Subtest 2x-nonexisting-fb: SKIP (0.012s)
[33.276576] [006/142] (952s left) kms_rotation_crc (bad-pixel-format)
[33.387020] Starting subtest: bad-pixel-format
[34.278859] Subtest bad-pixel-format: SUCCESS (0.893s)
[34.416429] [007/142] (951s left) kms_ccs (pipe-c-crc-primary-basic-4_tiled_mtl_rc_ccs)
[34.682159] Starting subtest: pipe-C-crc-primary-basic-4_tiled_mtl_rc_ccs
[34.683634] Subtest pipe-C-crc-primary-basic-4_tiled_mtl_rc_ccs: SKIP (0.000s)
[34.871954] [008/142] (951s left) i915_module_load (reload-with-fault-injection)
[34.917439] Starting subtest: reload-with-fault-injection
[38.616766] Subtest reload-with-fault-injection: SUCCESS (3.691s)
[38.623821] [009/142] (947s left) kms_flip (flip-vs-dpms-off-vs-modeset)
[39.653087] Starting subtest: flip-vs-dpms-off-vs-modeset
[39.655478] Starting dynamic subtest: A-HDMI-A1
[40.363649] Dynamic subtest A-HDMI-A1: SUCCESS (0.707s)
[40.367951] Starting dynamic subtest: B-HDMI-A1
[40.974527] Dynamic subtest B-HDMI-A1: SUCCESS (0.611s)
[40.978193] Starting dynamic subtest: C-HDMI-A1
[41.565130] Dynamic subtest C-HDMI-A1: SUCCESS (0.590s)
[41.569754] Starting dynamic subtest: D-HDMI-A1
[42.160571] Dynamic subtest D-HDMI-A1: SUCCESS (0.594s)
[42.162737] Subtest flip-vs-dpms-off-vs-modeset: SUCCESS (2.511s)
[42.249770] [010/142] (943s left) gem_exec_params (secure-non-root)
[42.305675] Starting subtest: secure-non-root
[42.307162] Subtest secure-non-root: SKIP (0.000s)
[42.368649] [011/142] (943s left) gem_exec_await (wide-all)
[42.455514] Starting subtest: wide-all
[64.531815] Subtest wide-all: SUCCESS (22.066s)
[64.692553] [012/142] (921s left) i915_pm_rpm (fences)
[76.348554] Starting subtest: fences
[87.267299] Subtest fences: FAIL (10.906s)
[87.366371] [013/142] (898s left) i915_pm_rps (thresholds-idle)
[87.419226] Starting subtest: thresholds-idle
[87.419948] Starting dynamic subtest: gt0
[87.422281] Dynamic subtest gt0: SKIP (0.001s)
[87.423665] Subtest thresholds-idle: SKIP (0.002s)
[87.482421] [014/142] (898s left) syncobj_wait (invalid-wait-bad-flags)
[87.538318] Starting subtest: invalid-wait-bad-flags
[87.539172] Subtest invalid-wait-bad-flags: SUCCESS (0.000s)
[87.580974] [015/142] (898s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-pwrite)
[87.690986] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-pwrite
[87.692447] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[87.749813] [016/142] (898s left) gem_request_retire (retire-vma-not-inactive)
[87.799870] Starting subtest: retire-vma-not-inactive
[87.808436] Subtest retire-vma-not-inactive: SUCCESS (0.008s)
[87.889548] [017/142] (898s left) kms_psr_stress_test (flip-primary-invalidate-overlay)
[87.947307] Subtest flip-primary-invalidate-overlay: SKIP (0.000s)
[87.975626] [018/142] (898s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-mmap-cpu)
[88.079985] Starting subtest: psr-2p-primscrn-spr-indfb-draw-mmap-cpu
[88.081501] Subtest psr-2p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[88.133130] [019/142] (897s left) kms_big_fb (x-tiled-16bpp-rotate-180)
[88.237405] Starting subtest: x-tiled-16bpp-rotate-180
[89.236821] Subtest x-tiled-16bpp-rotate-180: SUCCESS (0.999s)
[89.336043] [020/142] (896s left) gem_exec_reloc (basic-gtt-active)
[89.389026] Starting subtest: basic-gtt-active
[89.514874] Subtest basic-gtt-active: SUCCESS (0.117s)
[89.608317] [021/142] (896s left) gem_exec_balancer (nohangcheck)
[89.865570] Starting subtest: nohangcheck
[90.680378] Subtest nohangcheck: SUCCESS (0.813s)
[90.711781] [022/142] (895s left) vgem_basic (sysfs)
[90.770697] Starting subtest: sysfs
[90.771535] Subtest sysfs: SUCCESS (0.000s)
[90.799501] [023/142] (895s left) kms_ccs (pipe-b-bad-rotation-90-4_tiled_mtl_mc_ccs)
[91.013823] Starting subtest: pipe-B-bad-rotation-90-4_tiled_mtl_mc_ccs
[91.015377] Subtest pipe-B-bad-rotation-90-4_tiled_mtl_mc_ccs: SKIP (0.000s)
[91.289332] [024/142] (894s left) kms_hdr (static-toggle-suspend)
[91.384437] Starting subtest: static-toggle-suspend
[91.386115] Subtest static-toggle-suspend: SKIP (0.000s)
[91.419720] [025/142] (894s left) kms_ccs (pipe-b-crc-primary-basic-y_tiled_gen12_rc_ccs)
[91.639491] Starting subtest: pipe-B-crc-primary-basic-y_tiled_gen12_rc_ccs
[91.833036] Subtest pipe-B-crc-primary-basic-y_tiled_gen12_rc_ccs: SUCCESS (0.194s)
[92.140130] [026/142] (894s left) kms_cdclk (mode-transition-all-outputs)
[92.196294] Subtest mode-transition-all-outputs: SKIP (0.000s)
[92.215663] [027/142] (894s left) kms_color (deep-color)
[92.329545] Starting subtest: deep-color
[92.334053] Subtest deep-color: SKIP (0.003s)
[92.371054] [028/142] (893s left) kms_plane_multiple (tiling-none)
[92.467721] Starting subtest: tiling-none
[92.468547] Starting dynamic subtest: pipe-A-HDMI-A-1
[92.963728] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.496s)
[92.969136] Starting dynamic subtest: pipe-B-HDMI-A-1
[93.479390] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.514s)
[93.486065] Starting dynamic subtest: pipe-C-HDMI-A-1
[93.997054] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.515s)
[94.002484] Starting dynamic subtest: pipe-D-HDMI-A-1
[94.496854] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.499s)
[94.497627] Subtest tiling-none: SUCCESS (2.030s)
[94.600640] [029/142] (891s left) kms_ccs (pipe-c-bad-rotation-90-y_tiled_ccs)
[94.902556] Starting subtest: pipe-C-bad-rotation-90-y_tiled_ccs
[94.904176] Subtest pipe-C-bad-rotation-90-y_tiled_ccs: SKIP (0.000s)
[95.107170] [030/142] (891s left) kms_lease (setcrtc_implicit_plane)
[95.202131] Starting subtest: setcrtc_implicit_plane
[95.202843] Starting dynamic subtest: pipe-A-HDMI-A-1
[95.364907] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.162s)
[95.370904] Starting dynamic subtest: pipe-B-HDMI-A-1
[95.809348] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.442s)
[95.816215] Starting dynamic subtest: pipe-C-HDMI-A-1
[96.508617] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.698s)
[96.514233] Starting dynamic subtest: pipe-D-HDMI-A-1
[96.651705] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.141s)
[96.652537] Subtest setcrtc_implicit_plane: SUCCESS (1.449s)
[96.735733] [031/142] (889s left) kms_addfb_basic (bad-pitch-1024)
[96.787281] Starting subtest: bad-pitch-1024
[96.788062] Subtest bad-pitch-1024: SUCCESS (0.000s)
[96.894018] [032/142] (889s left) kms_ccs (pipe-b-bad-pixel-format-4_tiled_dg2_rc_ccs_cc)
[97.105567] Starting subtest: pipe-B-bad-pixel-format-4_tiled_dg2_rc_ccs_cc
[97.107096] Subtest pipe-B-bad-pixel-format-4_tiled_dg2_rc_ccs_cc: SKIP (0.000s)
[97.380474] [033/142] (888s left) gem_exec_fair (basic-flow)
[97.437074] Starting subtest: basic-flow
[97.437831] Starting dynamic subtest: rcs0
[104.458771] Dynamic subtest rcs0: SUCCESS (7.013s)
[104.459841] Subtest basic-flow: SUCCESS (7.014s)
[104.608882] [034/142] (881s left) kms_flip (flip-vs-absolute-wf_vblank)
[104.698603] Starting subtest: flip-vs-absolute-wf_vblank
[104.701170] Starting dynamic subtest: A-HDMI-A1
[112.524326] Dynamic subtest A-HDMI-A1: SUCCESS (7.823s)
[112.531569] Starting dynamic subtest: B-HDMI-A1
[120.320367] Dynamic subtest B-HDMI-A1: SUCCESS (7.795s)
[120.325533] Starting dynamic subtest: C-HDMI-A1
[128.119668] Dynamic subtest C-HDMI-A1: SUCCESS (7.795s)
[128.123997] Starting dynamic subtest: D-HDMI-A1
[135.910794] Dynamic subtest D-HDMI-A1: SUCCESS (7.789s)
[135.911631] Subtest flip-vs-absolute-wf_vblank: SUCCESS (31.211s)
[136.053993] [035/142] (850s left) kms_ccs (pipe-a-bad-pixel-format-y_tiled_gen12_rc_ccs)
[136.162755] Starting subtest: pipe-A-bad-pixel-format-y_tiled_gen12_rc_ccs
[136.163526] Subtest pipe-A-bad-pixel-format-y_tiled_gen12_rc_ccs: SUCCESS (0.000s)
[136.550094] [036/142] (849s left) gem_render_copy (y-tiled-ccs-to-yf-tiled-ccs)
[136.602928] Starting subtest: y-tiled-ccs-to-yf-tiled-ccs
[136.603656] Starting dynamic subtest: smem
[136.684674] Dynamic subtest smem: SUCCESS (0.081s)
[136.685407] Subtest y-tiled-ccs-to-yf-tiled-ccs: SUCCESS (0.082s)
[136.834410] [037/142] (849s left) kms_ccs (pipe-c-crc-sprite-planes-basic-4_tiled_mtl_rc_ccs)
[137.172364] Starting subtest: pipe-C-crc-sprite-planes-basic-4_tiled_mtl_rc_ccs
[137.175191] Subtest pipe-C-crc-sprite-planes-basic-4_tiled_mtl_rc_ccs: SKIP (0.002s)
[137.328323] [038/142] (849s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-fullscreen)
[137.431032] Starting subtest: fbc-1p-primscrn-spr-indfb-fullscreen
[138.240549] Subtest fbc-1p-primscrn-spr-indfb-fullscreen: SUCCESS (0.811s)
[138.332877] [039/142] (848s left) kms_ccs (pipe-a-ccs-on-another-bo-y_tiled_gen12_rc_ccs_cc)
[138.517204] Starting subtest: pipe-A-ccs-on-another-bo-y_tiled_gen12_rc_ccs_cc
[138.517953] Subtest pipe-A-ccs-on-another-bo-y_tiled_gen12_rc_ccs_cc: SUCCESS (0.000s)
[138.801346] [040/142] (847s left) gem_exec_schedule (submit-early-slice)
[138.858205] Starting subtest: submit-early-slice
[138.859019] Starting dynamic subtest: rcs0
[138.887703] Dynamic subtest rcs0: SUCCESS (0.029s)
[138.892370] Starting dynamic subtest: bcs0
[138.912953] Dynamic subtest bcs0: SUCCESS (0.025s)
[138.917793] Starting dynamic subtest: vcs0
[138.937536] Dynamic subtest vcs0: SUCCESS (0.024s)
[138.942144] Starting dynamic subtest: vcs1
[138.963681] Dynamic subtest vcs1: SUCCESS (0.026s)
[138.968397] Starting dynamic subtest: vecs0
[138.989127] Dynamic subtest vecs0: SUCCESS (0.025s)
[138.989927] Subtest submit-early-slice: SUCCESS (0.131s)
[139.259115] [041/142] (847s left) gem_exec_params (invalid-ring2)
[139.317586] Starting subtest: invalid-ring2
[139.318386] Subtest invalid-ring2: SUCCESS (0.000s)
[139.387946] [042/142] (847s left) gem_wait (invalid-buf)
[139.437306] Starting subtest: invalid-buf
[139.438050] Subtest invalid-buf: SUCCESS (0.000s)
[139.617323] [043/142] (846s left) gem_exec_reloc (basic-wc-gtt-active)
[139.675456] Starting subtest: basic-wc-gtt-active
[139.800969] Subtest basic-wc-gtt-active: SUCCESS (0.116s)
[139.885121] [044/142] (846s left) i915_suspend (fence-restore-tiled2untiled)
[139.935115] Starting subtest: fence-restore-tiled2untiled
[159.996331] Subtest fence-restore-tiled2untiled: SUCCESS (5.148s)
[161.059966] [045/142] (841s left) api_intel_allocator (two-level-inception-interruptible)
[161.117000] Starting subtest: two-level-inception-interruptible
[166.531626] Subtest two-level-inception-interruptible: SUCCESS (5.415s)
[166.598937] [046/142] (835s left) kms_ccs (pipe-a-crc-sprite-planes-basic-4_tiled_mtl_rc_ccs_cc)
[166.817940] Starting subtest: pipe-A-crc-sprite-planes-basic-4_tiled_mtl_rc_ccs_cc
[166.821024] Subtest pipe-A-crc-sprite-planes-basic-4_tiled_mtl_rc_ccs_cc: SKIP (0.002s)
[167.094238] [047/142] (835s left) gem_userptr_blits (stress-purge)
[167.152162] Starting subtest: stress-purge
[172.556682] Subtest stress-purge: SUCCESS (5.404s)
[172.659047] [048/142] (829s left) kms_chamelium_frames (hdmi-cmp-planar-formats)
[172.839662] Subtest hdmi-cmp-planar-formats: SKIP (0.000s)
[172.899822] [049/142] (829s left) gem_mmap_wc (set-cache-level)
[172.949589] Starting subtest: set-cache-level
[172.950332] Subtest set-cache-level: SUCCESS (0.001s)
[173.004487] [050/142] (829s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-16bpp-4tile-downscaling)
[173.099367] Starting subtest: flip-64bpp-4tile-to-16bpp-4tile-downscaling
[173.100178] Starting dynamic subtest: pipe-A-valid-mode
[173.150575] Dynamic subtest pipe-A-valid-mode: SKIP (0.049s)
[173.151979] Subtest flip-64bpp-4tile-to-16bpp-4tile-downscaling: SKIP (0.051s)
[173.225666] [051/142] (829s left) syncobj_timeline (single-wait-for-submit-available-signaled)
[173.279801] Starting subtest: single-wait-for-submit-available-signaled
[173.280546] Subtest single-wait-for-submit-available-signaled: SUCCESS (0.000s)
[173.316053] [052/142] (829s left) kms_psr2_sf (cursor-plane-move-continuous-sf)
[173.366589] Subtest cursor-plane-move-continuous-sf: SKIP (0.000s)
[173.383933] [053/142] (829s left) kms_vblank (pipe-d-query-idle)
[173.481379] Starting subtest: pipe-D-query-idle
[175.499960] Subtest pipe-D-query-idle: SUCCESS (2.018s)
[175.583424] [054/142] (826s left) kms_addfb_basic (too-high)
[175.705241] Starting subtest: too-high
[175.706028] Subtest too-high: SUCCESS (0.000s)
[175.756285] [055/142] (826s left) kms_big_fb (yf-tiled-16bpp-rotate-270)
[175.859606] Starting subtest: yf-tiled-16bpp-rotate-270
[175.861135] Subtest yf-tiled-16bpp-rotate-270: SKIP (0.000s)
[175.923210] [056/142] (826s left) gem_exec_schedule (preempt-hang)
[176.091686] Starting subtest: preempt-hang
[176.092711] Starting dynamic subtest: rcs0
[176.280187] Dynamic subtest rcs0: SUCCESS (0.189s)
[176.285733] Starting dynamic subtest: bcs0
[176.462863] Dynamic subtest bcs0: SUCCESS (0.182s)
[176.469818] Starting dynamic subtest: vcs0
[176.649079] Dynamic subtest vcs0: SUCCESS (0.185s)
[176.654534] Starting dynamic subtest: vcs1
[176.832093] Dynamic subtest vcs1: SUCCESS (0.183s)
[176.838089] Starting dynamic subtest: vecs0
[177.015464] Dynamic subtest vecs0: SUCCESS (0.183s)
[177.016225] Subtest preempt-hang: SUCCESS (0.925s)
[177.173989] [057/142] (825s left) prime_udl
[177.240280] [058/142] (825s left) kms_plane_scaling (plane-downscale-with-modifiers-factor-0-25)
[177.338681] Starting subtest: plane-downscale-with-modifiers-factor-0-25
[177.339376] Starting dynamic subtest: pipe-A-HDMI-A-1
[177.356459] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.016s)
[177.361417] Starting dynamic subtest: pipe-B-HDMI-A-1
[177.387258] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.028s)
[177.392175] Starting dynamic subtest: pipe-C-HDMI-A-1
[177.417076] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.028s)
[177.423321] Starting dynamic subtest: pipe-D-HDMI-A-1
[177.446791] Dynamic subtest pipe-D-HDMI-A-1: SKIP (0.028s)
[177.448297] Subtest plane-downscale-with-modifiers-factor-0-25: SKIP (0.108s)
[177.500167] [059/142] (825s left) gen7_exec_parse (basic-rejected)
[177.550382] Subtest basic-rejected: SKIP (0.000s)
[177.574579] [060/142] (825s left) vgem_basic (bad-fence)
[177.626300] Starting subtest: bad-fence
[177.627131] Subtest bad-fence: SUCCESS (0.000s)
[177.656460] [061/142] (824s left) kms_psr (psr2_primary_page_flip)
[177.704861] Subtest psr2_primary_page_flip: SKIP (0.000s)
[177.724749] [062/142] (824s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-render)
[177.825778] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-render
[177.827222] Subtest fbc-2p-primscrn-spr-indfb-draw-render: SKIP (0.000s)
[177.881687] [063/142] (824s left) fbdev (eof)
[177.934631] Starting subtest: eof
[177.935394] Subtest eof: SUCCESS (0.000s)
[177.964773] [064/142] (824s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0-hflip)
[178.065640] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0-hflip
[178.067160] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0-hflip: SKIP (0.000s)
[178.115380] [065/142] (824s left) kms_psr (suspend)
[178.163280] Subtest suspend: SKIP (0.000s)
[178.183142] [066/142] (824s left) syncobj_wait (single-wait-all-for-submit-signaled)
[178.232529] Starting subtest: single-wait-all-for-submit-signaled
[178.233377] Subtest single-wait-all-for-submit-signaled: SUCCESS (0.000s)
[178.273303] [067/142] (824s left) kms_frontbuffer_tracking (fbc-rgb565-draw-mmap-gtt)
[178.372719] Starting subtest: fbc-rgb565-draw-mmap-gtt
[179.401622] Subtest fbc-rgb565-draw-mmap-gtt: SUCCESS (1.030s)
[179.486360] [068/142] (823s left) kms_frontbuffer_tracking (fbcpsr-tiling-4)
[179.588861] Starting subtest: fbcpsr-tiling-4
[179.590237] Subtest fbcpsr-tiling-4: SKIP (0.000s)
[179.657533] [069/142] (823s left) kms_cursor_legacy (2x-nonblocking-modeset-vs-cursor-atomic)
[179.752699] Starting subtest: 2x-nonblocking-modeset-vs-cursor-atomic
[179.755809] Subtest 2x-nonblocking-modeset-vs-cursor-atomic: SKIP (0.003s)
[179.790227] [070/142] (822s left) gem_exec_fence (basic-busy-all)
[179.844761] Starting subtest: basic-busy-all
[179.880272] Subtest basic-busy-all: SUCCESS (0.035s)
[180.416462] [071/142] (822s left) gem_ctx_persistence (idempotent)
[180.474962] Starting subtest: idempotent
[180.475683] Subtest idempotent: SUCCESS (0.000s)
[180.514975] [072/142] (822s left) drm_fdinfo (virtual-busy-hang)
[180.570208] Starting subtest: virtual-busy-hang
[185.717552] Subtest virtual-busy-hang: SUCCESS (5.147s)
[185.761240] [073/142] (817s left) v3d/v3d_mmap (mmap-bad-handle)
[185.836204] Subtest mmap-bad-handle: SKIP (0.000s)
[185.866359] [074/142] (816s left) perf (rc6-disable)
[185.964611] Starting subtest: rc6-disable
[186.139825] Subtest rc6-disable: SUCCESS (0.175s)
[186.163589] [075/142] (816s left) kms_panel_fitting (atomic-fastset)
[186.259996] Starting subtest: atomic-fastset
[186.261544] Subtest atomic-fastset: SKIP (0.000s)
[186.299824] [076/142] (816s left) syncobj_timeline (wait-for-submit-delayed-submit)
[186.347872] Starting subtest: wait-for-submit-delayed-submit
[186.449108] Subtest wait-for-submit-delayed-submit: SUCCESS (0.102s)
[186.501810] [077/142] (816s left) kms_vblank (pipe-a-query-busy-hang)
[186.603493] Starting subtest: pipe-A-query-busy-hang
[200.753326] Subtest pipe-A-query-busy-hang: SUCCESS (14.150s)
[200.859164] [078/142] (801s left) gem_exec_whisper (basic-fds-priority-all)
[200.915583] Starting subtest: basic-fds-priority-all
[224.408441] Subtest basic-fds-priority-all: SUCCESS (23.492s)
[224.559504] [079/142] (778s left) perf_pmu (busy-check-all)
[224.617735] Starting subtest: busy-check-all
[224.618510] Starting dynamic subtest: rcs0
[225.131389] Dynamic subtest rcs0: SUCCESS (0.513s)
[225.138961] Starting dynamic subtest: bcs0
[225.649169] Dynamic subtest bcs0: SUCCESS (0.517s)
[225.658152] Starting dynamic subtest: vcs0
[226.165072] Dynamic subtest vcs0: SUCCESS (0.515s)
[226.174386] Starting dynamic subtest: vcs1
[226.686263] Dynamic subtest vcs1: SUCCESS (0.520s)
[226.695330] Starting dynamic subtest: vecs0
[227.203184] Dynamic subtest vecs0: SUCCESS (0.516s)
[227.204243] Subtest busy-check-all: SUCCESS (2.586s)
[227.250902] [080/142] (775s left) kms_color (ctm-0-25)
[227.354393] Starting subtest: ctm-0-25
[227.355148] Starting dynamic subtest: pipe-A
[228.113122] Dynamic subtest pipe-A: SUCCESS (0.758s)
[228.130525] Starting dynamic subtest: pipe-B
[229.117331] Dynamic subtest pipe-B: SUCCESS (1.005s)
[229.122886] Starting dynamic subtest: pipe-C
[230.363318] Dynamic subtest pipe-C: SUCCESS (1.245s)
[230.369594] Starting dynamic subtest: pipe-D
[231.048040] Dynamic subtest pipe-D: SUCCESS (0.683s)
[231.048758] Subtest ctm-0-25: SUCCESS (3.694s)
[231.146590] [081/142] (771s left) kms_frontbuffer_tracking (psr-1p-pri-indfb-multidraw)
[231.250760] Starting subtest: psr-1p-pri-indfb-multidraw
[231.252151] Subtest psr-1p-pri-indfb-multidraw: SKIP (0.000s)
[231.305246] [082/142] (771s left) vc4/vc4_perfmon (get-values-invalid-perfmon)
[231.374264] Subtest get-values-invalid-perfmon: SKIP (0.000s)
[231.405195] [083/142] (771s left) kms_cursor_legacy (flip-vs-cursor-toggle)
[231.500729] Starting subtest: flip-vs-cursor-toggle
[237.191161] Subtest flip-vs-cursor-toggle: SUCCESS (5.690s)
[237.283326] [084/142] (765s left) core_auth (basic-auth)
[237.335640] Starting subtest: basic-auth
[237.336453] Subtest basic-auth: SUCCESS (0.001s)
[237.374234] [085/142] (765s left) kms_vblank (pipe-a-query-idle-hang)
[237.482707] Starting subtest: pipe-A-query-idle-hang
[250.924909] Subtest pipe-A-query-idle-hang: SUCCESS (13.443s)
[251.032825] [086/142] (751s left) gem_linear_blits (interruptible)
[251.182069] Starting subtest: interruptible
[254.756621] Subtest interruptible: SUCCESS (3.574s)
[254.858184] [087/142] (748s left) gem_ctx_persistence (many-contexts)
[254.938555] Starting subtest: many-contexts
[290.234570] Subtest many-contexts: SUCCESS (35.295s)
[290.275226] [088/142] (712s left) kms_cursor_legacy (cursora-vs-flipa-atomic)
[290.373003] Starting subtest: cursorA-vs-flipA-atomic
[301.283583] Subtest cursorA-vs-flipA-atomic: SUCCESS (10.911s)
[301.377129] [089/142] (701s left) gem_pxp (reject-modify-context-protection-on)
[303.941991] Subtest reject-modify-context-protection-on: SKIP (0.000s)
[303.980136] [090/142] (699s left) gem_fence_thrash (bo-write-verify-none)
[304.027645] Starting subtest: bo-write-verify-none
[305.251584] Subtest bo-write-verify-none: SUCCESS (1.224s)
[305.313249] [091/142] (697s left) prime_self_import (basic-llseek-bad)
[305.358509] Starting subtest: basic-llseek-bad
[305.360128] Subtest basic-llseek-bad: SUCCESS (0.001s)
[305.425958] [092/142] (697s left) kms_writeback (writeback-pixel-formats)
[305.570961] Subtest writeback-pixel-formats: SKIP (0.000s)
[305.597113] [093/142] (697s left) kms_frontbuffer_tracking (fbcpsr-modesetfrombusy)
[305.698296] Starting subtest: fbcpsr-modesetfrombusy
[305.699849] Subtest fbcpsr-modesetfrombusy: SKIP (0.000s)
[305.752219] [094/142] (697s left) kms_flip_scaled_crc (flip-64bpp-linear-to-32bpp-linear-upscaling)
[305.848387] Starting subtest: flip-64bpp-linear-to-32bpp-linear-upscaling
[305.849158] Starting dynamic subtest: pipe-A-valid-mode
[306.607353] Dynamic subtest pipe-A-valid-mode: SUCCESS (0.758s)
[306.608126] Subtest flip-64bpp-linear-to-32bpp-linear-upscaling: SUCCESS (0.759s)
[306.702445] [095/142] (696s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180)
[306.807192] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180
[306.808752] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180: SKIP (0.000s)
[306.869590] [096/142] (696s left) gem_exec_schedule (deep)
[307.038058] Starting subtest: deep
[307.038925] Starting dynamic subtest: rcs0
[314.082699] Dynamic subtest rcs0: SUCCESS (7.044s)
[314.088734] Starting dynamic subtest: bcs0
[321.340736] Dynamic subtest bcs0: SUCCESS (7.257s)
[321.347257] Starting dynamic subtest: vcs0
[328.633614] Dynamic subtest vcs0: SUCCESS (7.292s)
[328.639773] Starting dynamic subtest: vcs1
[335.774953] Dynamic subtest vcs1: SUCCESS (7.141s)
[335.780961] Starting dynamic subtest: vecs0
[342.981051] Dynamic subtest vecs0: SUCCESS (7.205s)
[342.981902] Subtest deep: SUCCESS (35.943s)
[343.339229] [097/142] (659s left) kms_frontbuffer_tracking (fbcpsr-1p-offscren-pri-indfb-draw-render)
[343.441499] Starting subtest: fbcpsr-1p-offscren-pri-indfb-draw-render
[343.442900] Subtest fbcpsr-1p-offscren-pri-indfb-draw-render: SKIP (0.000s)
[343.482527] [098/142] (659s left) kms_universal_plane (disable-primary-vs-flip-pipe-b)
[343.579527] Starting subtest: disable-primary-vs-flip-pipe-B
[344.220037] Subtest disable-primary-vs-flip-pipe-B: SUCCESS (0.641s)
[344.312801] [099/142] (658s left) gem_busy (semaphore)
[344.480815] Starting subtest: semaphore
[344.486556] Starting dynamic subtest: rcs0
[344.502736] Dynamic subtest rcs0: SUCCESS (0.022s)
[344.509150] Starting dynamic subtest: bcs0
[344.520716] Dynamic subtest bcs0: SUCCESS (0.017s)
[344.526951] Starting dynamic subtest: vcs0
[344.546634] Dynamic subtest vcs0: SUCCESS (0.025s)
[344.552584] Starting dynamic subtest: vcs1
[344.562742] Dynamic subtest vcs1: SUCCESS (0.015s)
[344.568932] Starting dynamic subtest: vecs0
[344.581669] Dynamic subtest vecs0: SUCCESS (0.018s)
[344.582383] Subtest semaphore: SUCCESS (0.102s)
[344.746082] [100/142] (658s left) i915_pm_rpm (legacy-planes)
[356.299023] Starting subtest: legacy-planes
[356.300161] Starting dynamic subtest: plane-40
[367.252579] Dynamic subtest plane-40: FAIL (10.928s)
[367.257895] Starting dynamic subtest: plane-49
[378.188186] Dynamic subtest plane-49: FAIL (10.949s)
[378.193774] Starting dynamic subtest: plane-58
[389.052835] Dynamic subtest plane-58: FAIL (10.861s)
[389.060083] Starting dynamic subtest: plane-67
[399.921625] Dynamic subtest plane-67: FAIL (10.869s)
[399.932128] Starting dynamic subtest: plane-76
[412.671747] Dynamic subtest plane-76: FAIL (12.727s)
[412.677503] Starting dynamic subtest: plane-85
[423.580543] Dynamic subtest plane-85: FAIL (10.930s)
[423.581249] Subtest legacy-planes: FAIL (67.269s)
[423.683036] [101/142] (579s left) gem_ctx_param (set-priority-not-supported)
[423.732991] Starting subtest: set-priority-not-supported
[423.734551] Subtest set-priority-not-supported: SKIP (0.000s)
[423.774047] [102/142] (579s left) gem_exec_balancer (busy)
[423.828448] Starting subtest: busy
[424.249210] Subtest busy: SUCCESS (0.419s)
[424.493321] [103/142] (578s left) kms_flip (2x-flip-vs-suspend)
[424.584294] Starting subtest: 2x-flip-vs-suspend
[424.597292] Subtest 2x-flip-vs-suspend: SKIP (0.013s)
[424.649762] [104/142] (578s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-move)
[424.752717] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-move
[424.754172] Subtest fbcpsr-1p-primscrn-cur-indfb-move: SKIP (0.000s)
[424.798628] [105/142] (578s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-mmap-gtt)
[424.899421] Starting subtest: fbc-rgb101010-draw-mmap-gtt
[427.309679] Subtest fbc-rgb101010-draw-mmap-gtt: SUCCESS (2.413s)
[427.394112] [106/142] (575s left) gem_ctx_param (invalid-ctx-set)
[427.450511] Starting subtest: invalid-ctx-set
[427.451304] Subtest invalid-ctx-set: SUCCESS (0.000s)
[427.491619] [107/142] (575s left) gem_mmap_gtt (basic-write-read-distinct)
[427.545113] Starting subtest: basic-write-read-distinct
[427.547932] Subtest basic-write-read-distinct: SUCCESS (0.003s)
[427.614539] [108/142] (575s left) gem_exec_fence (syncobj-invalid-wait)
[427.947306] Starting subtest: syncobj-invalid-wait
[427.948097] Subtest syncobj-invalid-wait: SUCCESS (0.000s)
[428.215534] [109/142] (575s left) api_intel_bb (reset-flags)
[428.271501] Starting subtest: reset-flags
[428.276360] Subtest reset-flags: SUCCESS (0.006s)
[428.356443] [110/142] (574s left) kms_plane_scaling (planes-upscale-factor-0-25)
[428.455961] Starting subtest: planes-upscale-factor-0-25
[428.456679] Starting dynamic subtest: pipe-A-HDMI-A-1
[428.509254] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.053s)
[428.516114] Starting dynamic subtest: pipe-B-HDMI-A-1
[428.618236] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.107s)
[428.625125] Starting dynamic subtest: pipe-C-HDMI-A-1
[428.727539] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.108s)
[428.734421] Starting dynamic subtest: pipe-D-HDMI-A-1
[428.835242] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.106s)
[428.835979] Subtest planes-upscale-factor-0-25: SUCCESS (0.380s)
[428.949139] [111/142] (574s left) v3d/v3d_submit_cl (multisync-out-syncs)
[429.017898] Subtest multisync-out-syncs: SKIP (0.000s)
[429.053626] [112/142] (574s left) kms_cursor_crc (cursor-random-256x256)
[429.154228] Starting subtest: cursor-random-256x256
[429.159655] Starting dynamic subtest: pipe-A-HDMI-A-1
[431.051183] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.892s)
[431.077209] Starting dynamic subtest: pipe-D-HDMI-A-1
[433.792016] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (2.720s)
[433.792815] Subtest cursor-random-256x256: SUCCESS (4.639s)
[433.892095] [113/142] (569s left) gem_mmap (bad-size)
[433.941494] Starting subtest: bad-size
[433.942254] Subtest bad-size: SUCCESS (0.000s)
[433.990827] [114/142] (569s left) i915_query (query-topology-known-pci-ids)
[434.039750] Starting subtest: query-topology-known-pci-ids
[434.041374] Subtest query-topology-known-pci-ids: SKIP (0.000s)
[434.073276] [115/142] (569s left) gen9_exec_parse (cmd-crossing-page)
[434.123326] Subtest cmd-crossing-page: SKIP (0.000s)
[434.150622] [116/142] (569s left) syncobj_timeline (multi-wait-for-submit-available-unsubmitted-submitted-signa
[434.198726] Starting subtest: multi-wait-for-submit-available-unsubmitted-submitted-signaled
[434.199558] Subtest multi-wait-for-submit-available-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[434.241516] [117/142] (569s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-fullscreen)
[434.347307] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-fullscreen
[434.348719] Subtest fbcpsr-2p-primscrn-spr-indfb-fullscreen: SKIP (0.000s)
[434.399290] [118/142] (569s left) kms_ccs (pipe-b-random-ccs-data-y_tiled_ccs)
[434.628103] Starting subtest: pipe-B-random-ccs-data-y_tiled_ccs
[434.630247] Subtest pipe-B-random-ccs-data-y_tiled_ccs: SKIP (0.000s)
[434.864406] [119/142] (568s left) gem_mmap_offset (bad-extensions)
[434.913615] Starting subtest: bad-extensions
[434.914325] Subtest bad-extensions: SUCCESS (0.000s)
[434.955338] [120/142] (568s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-mmap-wc)
[435.053862] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-mmap-wc
[435.055372] Subtest psr-2p-scndscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[435.114346] [121/142] (568s left) kms_atomic_interruptible (legacy-dpms)
[435.212028] Starting subtest: legacy-dpms
[435.213780] Starting dynamic subtest: HDMI-A-1-pipe-A
[441.418870] Dynamic subtest HDMI-A-1-pipe-A: SUCCESS (6.205s)
[441.419582] Subtest legacy-dpms: SUCCESS (6.207s)
[441.515216] [122/142] (561s left) perf_pmu (rc6-suspend)
[441.564720] Starting subtest: rc6-suspend
[464.193243] Subtest rc6-suspend: SUCCESS (7.479s)
[464.239371] [123/142] (554s left) kms_ccs (pipe-d-crc-primary-rotation-180-4_tiled_mtl_rc_ccs_cc)
[464.588824] Starting subtest: pipe-D-crc-primary-rotation-180-4_tiled_mtl_rc_ccs_cc
[464.590623] Subtest pipe-D-crc-primary-rotation-180-4_tiled_mtl_rc_ccs_cc: SKIP (0.000s)
[464.708543] [124/142] (553s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-mmap-cpu)
[464.811452] Starting subtest: psr-1p-primscrn-spr-indfb-draw-mmap-cpu
[464.812857] Subtest psr-1p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[464.873234] [125/142] (553s left) kms_big_fb (4-tiled-32bpp-rotate-270)
[464.973986] Starting subtest: 4-tiled-32bpp-rotate-270
[464.975656] Subtest 4-tiled-32bpp-rotate-270: SKIP (0.000s)
[465.023487] [126/142] (553s left) syncobj_wait (multi-wait-all-signaled)
[465.071089] Starting subtest: multi-wait-all-signaled
[465.071863] Subtest multi-wait-all-signaled: SUCCESS (0.000s)
[465.106591] [127/142] (553s left) syncobj_timeline (etime-single-wait-for-submit-submitted)
[465.155192] Starting subtest: etime-single-wait-for-submit-submitted
[465.256983] Subtest etime-single-wait-for-submit-submitted: SUCCESS (0.102s)
[465.307585] [128/142] (553s left) kms_big_fb (linear-16bpp-rotate-270)
[465.415566] Starting subtest: linear-16bpp-rotate-270
[465.474472] Subtest linear-16bpp-rotate-270: SKIP (0.058s)
[465.556592] [129/142] (553s left) kms_cursor_edge_walk (128x128-top-bottom)
[465.655569] Starting subtest: 128x128-top-bottom
[465.656326] Starting dynamic subtest: pipe-A-HDMI-A-1
[467.397975] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.741s)
[467.404844] Starting dynamic subtest: pipe-D-HDMI-A-1
[469.072660] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (1.673s)
[469.073514] Subtest 128x128-top-bottom: SUCCESS (3.418s)
[469.152083] [130/142] (549s left) gem_ctx_engines (execute-one)
[469.206230] Starting subtest: execute-one
[470.119081] Subtest execute-one: SUCCESS (0.909s)
[470.270128] [131/142] (548s left) syncobj_timeline (invalid-multi-wait-unsubmitted-submitted-signaled)
[470.324242] Starting subtest: invalid-multi-wait-unsubmitted-submitted-signaled
[470.325046] Subtest invalid-multi-wait-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[470.358831] [132/142] (548s left) kms_ccs (pipe-d-crc-sprite-planes-basic-y_tiled_gen12_rc_ccs_cc)
[470.758791] Starting subtest: pipe-D-crc-sprite-planes-basic-y_tiled_gen12_rc_ccs_cc
[471.548263] Subtest pipe-D-crc-sprite-planes-basic-y_tiled_gen12_rc_ccs_cc: SUCCESS (0.789s)
[471.687413] [133/142] (547s left) gem_softpin (allocator-fork)
[471.740264] Starting subtest: allocator-fork
[473.956816] Subtest allocator-fork: SUCCESS (2.216s)
[474.039044] [134/142] (544s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-move)
[474.145928] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-move
[474.147324] Subtest fbcpsr-2p-primscrn-cur-indfb-move: SKIP (0.000s)
[474.204634] [135/142] (544s left) gem_exercise_blt (fast-copy-emit)
[474.252969] Starting subtest: fast-copy-emit
[474.253739] Starting dynamic subtest: linear-smem-smem-emit
[474.273771] Dynamic subtest linear-smem-smem-emit: SUCCESS (0.020s)
[474.279766] Starting dynamic subtest: ymajor-smem-smem-emit
[474.291652] Dynamic subtest ymajor-smem-smem-emit: SUCCESS (0.017s)
[474.297449] Starting dynamic subtest: tile4-smem-smem-emit
[474.309109] Dynamic subtest tile4-smem-smem-emit: SUCCESS (0.017s)
[474.314822] Starting dynamic subtest: tile64-smem-smem-emit
[474.326228] Dynamic subtest tile64-smem-smem-emit: SUCCESS (0.017s)
[474.327006] Subtest fast-copy-emit: SUCCESS (0.074s)
[474.395752] [136/142] (544s left) kms_cursor_legacy (cursor-vs-flip-varying-size)
[474.499733] Starting subtest: cursor-vs-flip-varying-size
[503.359260] Subtest cursor-vs-flip-varying-size: SUCCESS (28.860s)
[503.457584] [137/142] (515s left) v3d/v3d_submit_csd (valid-submission)
[503.525761] Subtest valid-submission: SKIP (0.000s)
[503.556650] [138/142] (515s left) gem_wait (invalid-flags)
[503.607595] Starting subtest: invalid-flags
[503.608374] Subtest invalid-flags: SUCCESS (0.000s)
[503.780635] [139/142] (515s left) kms_cursor_crc (cursor-rapid-movement-512x512)
[503.884224] Starting subtest: cursor-rapid-movement-512x512
[503.886603] Subtest cursor-rapid-movement-512x512: SKIP (0.001s)
[503.956881] [140/142] (514s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-pwrite)
[504.056410] Starting subtest: psr-2p-primscrn-cur-indfb-draw-pwrite
[504.057779] Subtest psr-2p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[504.115459] [141/142] (514s left) kms_ccs (pipe-d-bad-pixel-format-4_tiled_mtl_mc_ccs)
[504.438326] Starting subtest: pipe-D-bad-pixel-format-4_tiled_mtl_mc_ccs
[504.439764] Subtest pipe-D-bad-pixel-format-4_tiled_mtl_mc_ccs: SKIP (0.000s)
[504.577201] [142/142] (514s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip)
[504.679283] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip
[504.936816] Subtest y-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SUCCESS (0.257s)
[505.021498] Closing watchdogs
Done.