[52.587342] Initializing watchdogs [52.587591] /dev/watchdog0 [52.603666] [001/141] (960s left) kms_vblank (pipe-b-query-forked-busy-hang) [52.924235] Starting subtest: pipe-B-query-forked-busy-hang [60.017853] Subtest pipe-B-query-forked-busy-hang: SUCCESS (7.095s) [60.360387] [002/141] (952s left) i915_query (query-topology-kernel-writes) [60.567253] Starting subtest: query-topology-kernel-writes [60.568945] Subtest query-topology-kernel-writes: SUCCESS (0.000s) [60.642936] [003/141] (952s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-blt) [60.956668] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-blt [60.959175] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-blt: SKIP (0.000s) [61.042470] [004/141] (952s left) gem_exec_schedule (u-fairslice) [61.286932] Starting subtest: u-fairslice [61.288440] Starting dynamic subtest: rcs0 [63.332356] Dynamic subtest rcs0: SUCCESS (2.042s) [63.347151] Starting dynamic subtest: bcs0 [65.367849] Dynamic subtest bcs0: SUCCESS (2.035s) [65.383334] Starting dynamic subtest: vcs0 [67.399168] Dynamic subtest vcs0: SUCCESS (2.030s) [67.412915] Starting dynamic subtest: vecs0 [69.431298] Dynamic subtest vecs0: SUCCESS (2.033s) [69.432945] Subtest u-fairslice: SUCCESS (8.141s) [69.759112] [005/141] (943s left) gem_tiled_wc [72.525589] [006/141] (940s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-64bpp-ytile-downscaling) [72.828979] Starting subtest: flip-32bpp-ytile-to-64bpp-ytile-downscaling [72.832660] Starting dynamic subtest: pipe-A-valid-mode [73.545227] Dynamic subtest pipe-A-valid-mode: SKIP (0.711s) [73.549480] Subtest flip-32bpp-ytile-to-64bpp-ytile-downscaling: SKIP (0.713s) [73.944676] [007/141] (939s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-pwrite) [74.253147] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-pwrite [76.361108] Subtest fbc-1p-primscrn-spr-indfb-draw-pwrite: SUCCESS (2.110s) [76.498416] [008/141] (936s left) gem_mmap_offset (open-flood) [76.699763] Starting subtest: open-flood [98.259056] Subtest open-flood: SUCCESS (21.560s) [98.361687] [009/141] (915s left) gem_exec_whisper (basic-queues-all) [98.597792] Starting subtest: basic-queues-all [109.287973] Subtest basic-queues-all: SUCCESS (10.689s) [109.477078] [010/141] (903s left) gem_tiled_blits (normal) [110.976057] Starting subtest: normal [163.143561] Subtest normal: SUCCESS (52.167s) [163.248351] [011/141] (850s left) kms_flip (2x-flip-vs-panning) [163.656177] Starting subtest: 2x-flip-vs-panning [163.658911] Subtest 2x-flip-vs-panning: SKIP (0.003s) [163.766039] [012/141] (849s left) i915_query (query-topology-coherent-slice-mask) [163.970521] Starting subtest: query-topology-coherent-slice-mask [163.972197] Subtest query-topology-coherent-slice-mask: SUCCESS (0.000s) [164.048742] [013/141] (849s left) gem_exec_balancer (parallel-contexts) [168.051432] Subtest parallel-contexts: SKIP (0.000s) [168.148271] [014/141] (845s left) kms_ccs (pipe-c-bad-pixel-format-y_tiled_gen12_mc_ccs) [168.754197] Starting subtest: pipe-C-bad-pixel-format-y_tiled_gen12_mc_ccs [168.757877] Subtest pipe-C-bad-pixel-format-y_tiled_gen12_mc_ccs: SKIP (0.000s) [169.175826] [015/141] (844s left) gen9_exec_parse (unaligned-jump) [169.400470] Starting subtest: unaligned-jump [169.648946] Subtest unaligned-jump: SUCCESS (0.248s) [169.875960] [016/141] (843s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-mmap-gtt) [170.183482] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-mmap-gtt [170.186133] Subtest fbc-2p-scndscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s) [170.291992] [017/141] (843s left) i915_power (sanity) [170.491027] Starting subtest: sanity [174.514442] Subtest sanity: SUCCESS (4.021s) [174.623945] [018/141] (839s left) kms_cursor_crc (cursor-sliding-max-size) [174.944676] Starting subtest: cursor-sliding-max-size [174.948864] Subtest cursor-sliding-max-size: SKIP (0.000s) [175.042130] [019/141] (838s left) kms_psr (cursor_blt) [175.246537] Subtest cursor_blt: SKIP (0.000s) [175.291112] [020/141] (838s left) kms_cursor_legacy (cursorb-vs-flipb-varying-size) [175.586976] Starting subtest: cursorB-vs-flipB-varying-size [175.589843] Subtest cursorB-vs-flipB-varying-size: SKIP (0.003s) [175.675611] [021/141] (838s left) gem_exec_schedule (preempt-queue-chain) [175.922441] Starting subtest: preempt-queue-chain [175.923855] Starting dynamic subtest: rcs0 [176.482719] Dynamic subtest rcs0: SUCCESS (0.559s) [176.504179] Starting dynamic subtest: bcs0 [177.066557] Dynamic subtest bcs0: SUCCESS (0.583s) [177.088909] Starting dynamic subtest: vcs0 [177.628420] Dynamic subtest vcs0: SUCCESS (0.561s) [177.649503] Starting dynamic subtest: vecs0 [178.223192] Dynamic subtest vecs0: SUCCESS (0.594s) [178.224824] Subtest preempt-queue-chain: SUCCESS (2.300s) [178.576275] [022/141] (835s left) gem_exec_fence (syncobj-timeline-invalid-wait) [179.463374] Starting subtest: syncobj-timeline-invalid-wait [179.469297] Subtest syncobj-timeline-invalid-wait: SUCCESS (0.004s) [179.692547] [023/141] (834s left) gem_lmem_swapping (verify) [179.903130] Subtest verify: SKIP (0.000s) [179.959506] [024/141] (833s left) kms_ccs (pipe-c-bad-aux-stride-4_tiled_mtl_rc_ccs_cc) [180.653997] Starting subtest: pipe-C-bad-aux-stride-4_tiled_mtl_rc_ccs_cc [180.657283] Subtest pipe-C-bad-aux-stride-4_tiled_mtl_rc_ccs_cc: SKIP (0.000s) [180.991516] [025/141] (832s left) syncobj_timeline (wait-all-for-submit-complex) [181.197596] Starting subtest: wait-all-for-submit-complex [181.414231] Subtest wait-all-for-submit-complex: SUCCESS (0.216s) [181.508079] [026/141] (832s left) kms_frontbuffer_tracking (psr-1p-primscrn-shrfb-pgflip-blt) [181.811115] Starting subtest: psr-1p-primscrn-shrfb-pgflip-blt [181.813951] Subtest psr-1p-primscrn-shrfb-pgflip-blt: SKIP (0.000s) [181.908599] [027/141] (832s left) syncobj_timeline (etime-multi-wait-all-for-submit-available-unsubmitted-signa [182.113029] Starting subtest: etime-multi-wait-all-for-submit-available-unsubmitted-signaled [182.219387] Subtest etime-multi-wait-all-for-submit-available-unsubmitted-signaled: SUCCESS (0.105s) [182.310095] [028/141] (831s left) vgem_basic (dmabuf-fence) [182.521169] Starting subtest: dmabuf-fence [182.522699] Subtest dmabuf-fence: SUCCESS (0.001s) [182.591160] [029/141] (831s left) kms_chamelium_frames (dp-crc-single) [182.986901] Subtest dp-crc-single: SKIP (0.000s) [183.269022] [030/141] (830s left) prime_mmap_coherency (ioctl-errors) [183.476760] Starting subtest: ioctl-errors [198.095492] Subtest ioctl-errors: SUCCESS (14.617s) [198.285631] [031/141] (815s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-0) [198.751216] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-0 [198.754239] Subtest 4-tiled-max-hw-stride-64bpp-rotate-0: SKIP (0.002s) [198.848636] [032/141] (815s left) kms_lease (cursor_implicit_plane) [199.155081] Starting subtest: cursor_implicit_plane [199.156801] Starting dynamic subtest: pipe-A-DP-1 [199.441124] Dynamic subtest pipe-A-DP-1: SUCCESS (0.285s) [199.460282] Starting dynamic subtest: pipe-B-DP-1 [199.981263] Dynamic subtest pipe-B-DP-1: SUCCESS (0.537s) [200.002697] Starting dynamic subtest: pipe-C-DP-1 [200.653667] Dynamic subtest pipe-C-DP-1: SUCCESS (0.669s) [200.655880] Subtest cursor_implicit_plane: SUCCESS (1.502s) [200.959032] [033/141] (813s left) i915_pm_rpm (cursor) [203.039994] Starting subtest: cursor [205.712189] Subtest cursor: SUCCESS (2.672s) [206.149949] [034/141] (808s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic) [206.456809] Starting subtest: basic-busy-flip-before-cursor-atomic [206.459578] Subtest basic-busy-flip-before-cursor-atomic: SKIP (0.000s) [206.547974] [035/141] (807s left) kms_big_fb (y-tiled-64bpp-rotate-90) [206.866663] Starting subtest: y-tiled-64bpp-rotate-90 [206.948674] Subtest y-tiled-64bpp-rotate-90: SKIP (0.078s) [207.064810] [036/141] (807s left) perf_pmu (busy-idle-no-semaphores) [207.277570] Starting subtest: busy-idle-no-semaphores [207.279270] Starting dynamic subtest: rcs0 [207.914063] Dynamic subtest rcs0: SUCCESS (0.635s) [207.934450] Starting dynamic subtest: bcs0 [208.543620] Dynamic subtest bcs0: SUCCESS (0.629s) [208.564640] Starting dynamic subtest: vcs0 [209.172123] Dynamic subtest vcs0: SUCCESS (0.628s) [209.193056] Starting dynamic subtest: vecs0 [209.800514] Dynamic subtest vecs0: SUCCESS (0.628s) [209.802087] Subtest busy-idle-no-semaphores: SUCCESS (2.522s) [209.898374] [037/141] (804s left) gem_lmem_swapping (parallel-multi) [210.121633] Subtest parallel-multi: SKIP (0.000s) [210.180845] [038/141] (804s left) api_intel_allocator (default-alignment) [210.379401] Starting subtest: default-alignment [210.381921] Subtest default-alignment: SUCCESS (0.004s) [210.497806] [039/141] (803s left) i915_pm_rpm (system-suspend) [212.272120] Starting subtest: system-suspend [228.877825] Subtest system-suspend: SUCCESS (1.846s) [235.578033] [040/141] (799s left) syncobj_basic (bad-destroy) [235.783359] Starting subtest: bad-destroy [235.784982] Subtest bad-destroy: SUCCESS (0.000s) [235.867453] [041/141] (799s left) gem_render_copy (yf-tiled-ccs-to-y-tiled-ccs) [236.087978] Starting subtest: yf-tiled-ccs-to-y-tiled-ccs [236.089864] Starting dynamic subtest: smem [236.420335] Dynamic subtest smem: SUCCESS (0.332s) [236.421837] Subtest yf-tiled-ccs-to-y-tiled-ccs: SUCCESS (0.333s) [236.620227] [042/141] (798s left) kms_psr2_sf (overlay-plane-move-continuous-exceed-fully-sf) [236.821524] Subtest overlay-plane-move-continuous-exceed-fully-sf: SKIP (0.000s) [236.885351] [043/141] (798s left) kms_cursor_crc (cursor-offscreen-256x256) [237.193327] Starting subtest: cursor-offscreen-256x256 [237.205391] Starting dynamic subtest: pipe-A-DP-1 [239.697714] Dynamic subtest pipe-A-DP-1: SUCCESS (2.486s) [239.783224] Starting dynamic subtest: pipe-C-DP-1 [242.571794] Dynamic subtest pipe-C-DP-1: SUCCESS (2.815s) [242.573343] Subtest cursor-offscreen-256x256: SUCCESS (5.377s) [242.929601] [044/141] (792s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-move) [243.245006] Starting subtest: psr-2p-scndscrn-cur-indfb-move [243.247643] Subtest psr-2p-scndscrn-cur-indfb-move: SKIP (0.000s) [243.359619] [045/141] (792s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-mmap-cpu) [243.665678] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-mmap-cpu [243.668563] Subtest psr-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s) [243.759546] [046/141] (791s left) gem_exec_gttfill (all-engines) [243.985005] Starting subtest: all-engines [284.849534] Subtest all-engines: SUCCESS (40.863s) [285.060621] [047/141] (750s left) kms_plane_scaling (planes-downscale-factor-0-25-upscale-factor-0-25) [285.485177] Starting subtest: planes-downscale-factor-0-25-upscale-factor-0-25 [285.486565] Starting dynamic subtest: pipe-A-DP-1 [285.522817] Dynamic subtest pipe-A-DP-1: SKIP (0.032s) [285.545989] Starting dynamic subtest: pipe-B-DP-1 [285.621713] Dynamic subtest pipe-B-DP-1: SKIP (0.096s) [285.647370] Starting dynamic subtest: pipe-C-DP-1 [285.708005] Dynamic subtest pipe-C-DP-1: SKIP (0.084s) [285.710942] Subtest planes-downscale-factor-0-25-upscale-factor-0-25: SKIP (0.224s) [285.844353] [048/141] (749s left) kms_universal_plane (universal-plane-pipe-a-functional) [286.156193] Starting subtest: universal-plane-pipe-A-functional [288.595924] Subtest universal-plane-pipe-A-functional: SUCCESS (2.439s) [288.910567] [049/141] (746s left) gem_pread (display) [289.113109] Starting subtest: display [293.492763] Subtest display: SUCCESS (4.376s) [293.591960] [050/141] (742s left) i915_pm_backlight (basic-brightness) [293.893000] Subtest basic-brightness: SKIP (0.000s) [293.941792] [051/141] (741s left) gem_set_tiling_vs_pwrite [294.278768] [052/141] (741s left) gem_workarounds (basic-read-fd) [294.519240] Starting subtest: basic-read-fd [294.544936] Subtest basic-read-fd: SUCCESS (0.025s) [294.658705] [053/141] (741s left) gem_ctx_exec (basic-nohangcheck) [294.864728] Starting subtest: basic-nohangcheck [295.201224] Subtest basic-nohangcheck: SUCCESS (0.338s) [295.292373] [054/141] (740s left) kms_frontbuffer_tracking (fbc-stridechange) [295.599042] Starting subtest: fbc-stridechange [297.217527] Subtest fbc-stridechange: SUCCESS (1.618s) [297.359045] [055/141] (738s left) kms_big_joiner (basic) [297.657530] Subtest basic: SKIP (0.000s) [297.708467] [056/141] (738s left) kms_cursor_legacy (cursorb-vs-flipb-atomic) [298.006566] Starting subtest: cursorB-vs-flipB-atomic [298.009814] Subtest cursorB-vs-flipB-atomic: SKIP (0.003s) [298.093925] [057/141] (737s left) sysfs_timeslice_duration (invalid) [298.299446] Starting subtest: invalid [298.303786] Starting dynamic subtest: vecs0 [298.305501] Dynamic subtest vecs0: SUCCESS (0.001s) [298.329122] Starting dynamic subtest: vcs0 [298.330576] Dynamic subtest vcs0: SUCCESS (0.001s) [298.353336] Starting dynamic subtest: bcs0 [298.354736] Dynamic subtest bcs0: SUCCESS (0.001s) [298.377668] Starting dynamic subtest: rcs0 [298.379164] Dynamic subtest rcs0: SUCCESS (0.001s) [298.380542] Subtest invalid: SUCCESS (0.011s) [298.413301] [058/141] (737s left) kms_flip (plain-flip-ts-check-interruptible) [298.714656] Starting subtest: plain-flip-ts-check-interruptible [298.719423] Starting dynamic subtest: A-DP1 [309.695385] Dynamic subtest A-DP1: SUCCESS (10.976s) [309.719950] Starting dynamic subtest: B-DP1 [320.390870] Dynamic subtest B-DP1: SUCCESS (10.694s) [320.416115] Starting dynamic subtest: C-DP1 [331.092456] Dynamic subtest C-DP1: SUCCESS (10.699s) [331.093905] Subtest plain-flip-ts-check-interruptible: SUCCESS (32.379s) [331.500809] [059/141] (704s left) syncobj_wait (reset-signaled) [331.717621] Starting subtest: reset-signaled [331.719031] Subtest reset-signaled: SUCCESS (0.000s) [331.813696] [060/141] (704s left) kms_ccs (pipe-c-random-ccs-data-y_tiled_gen12_mc_ccs) [332.484267] Starting subtest: pipe-C-random-ccs-data-y_tiled_gen12_mc_ccs [332.490374] Subtest pipe-C-random-ccs-data-y_tiled_gen12_mc_ccs: SKIP (0.000s) [332.867672] [061/141] (703s left) kms_busy (basic-hang) [333.195942] Starting subtest: basic-hang [333.201213] Starting dynamic subtest: flip-pipe-A [333.837891] Dynamic subtest flip-pipe-A: SUCCESS (0.635s) [333.863015] Starting dynamic subtest: modeset-pipe-A [335.259104] Dynamic subtest modeset-pipe-A: SUCCESS (1.421s) [335.291321] Starting dynamic subtest: flip-pipe-C [336.222141] Dynamic subtest flip-pipe-C: SUCCESS (0.953s) [336.247434] Starting dynamic subtest: modeset-pipe-C [337.845733] Dynamic subtest modeset-pipe-C: SUCCESS (1.622s) [337.847259] Subtest basic-hang: SUCCESS (4.649s) [338.199491] [062/141] (698s left) kms_frontbuffer_tracking (fbcpsr-1p-offscren-pri-shrfb-draw-mmap-gtt) [338.502858] Starting subtest: fbcpsr-1p-offscren-pri-shrfb-draw-mmap-gtt [338.505750] Subtest fbcpsr-1p-offscren-pri-shrfb-draw-mmap-gtt: SKIP (0.000s) [338.613864] [063/141] (697s left) kms_ccs (pipe-a-crc-primary-basic-4_tiled_mtl_mc_ccs) [339.031987] Starting subtest: pipe-A-crc-primary-basic-4_tiled_mtl_mc_ccs [339.034843] Subtest pipe-A-crc-primary-basic-4_tiled_mtl_mc_ccs: SKIP (0.002s) [339.690807] [064/141] (696s left) gem_ctx_shared (q-smoketest) [339.918296] Starting subtest: Q-smoketest [339.919984] Starting dynamic subtest: rcs0 [345.410926] Dynamic subtest rcs0: SUCCESS (5.486s) [345.435017] Starting dynamic subtest: bcs0 [350.883165] Dynamic subtest bcs0: SUCCESS (5.469s) [350.911905] Starting dynamic subtest: vcs0 [356.345723] Dynamic subtest vcs0: SUCCESS (5.462s) [356.369043] Starting dynamic subtest: vecs0 [361.819939] Dynamic subtest vecs0: SUCCESS (5.473s) [361.821483] Subtest Q-smoketest: SUCCESS (21.896s) [362.023863] [065/141] (674s left) kms_sysfs_edid_timing [363.506350] [066/141] (672s left) gem_ringfill (legacy-basic) [363.975828] Starting subtest: legacy-basic [363.977552] Starting dynamic subtest: default [364.002047] Dynamic subtest default: SUCCESS (0.025s) [364.030620] Starting dynamic subtest: render [364.032508] Dynamic subtest render: SUCCESS (0.024s) [364.063198] Starting dynamic subtest: bsd [364.064655] Dynamic subtest bsd: SUCCESS (0.019s) [364.092170] Starting dynamic subtest: bsd1 [364.093570] Dynamic subtest bsd1: SUCCESS (0.023s) [364.118304] Starting dynamic subtest: blt [364.119712] Dynamic subtest blt: SUCCESS (0.022s) [364.143670] Starting dynamic subtest: vebox [364.145149] Dynamic subtest vebox: SUCCESS (0.024s) [364.146595] Subtest legacy-basic: SUCCESS (0.147s) [364.223489] [067/141] (672s left) perf (sysctl-defaults) [364.536811] Starting subtest: sysctl-defaults [364.538196] Subtest sysctl-defaults: SUCCESS (0.000s) [364.622875] [068/141] (671s left) kms_big_fb (x-tiled-16bpp-rotate-0) [364.945245] Starting subtest: x-tiled-16bpp-rotate-0 [368.660202] Subtest x-tiled-16bpp-rotate-0: SUCCESS (3.717s) [368.991675] [069/141] (667s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-mmap-wc) [369.307489] Starting subtest: psr-2p-primscrn-pri-indfb-draw-mmap-wc [369.310381] Subtest psr-2p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s) [369.456711] [070/141] (667s left) gem_spin_batch (legacy-resubmit) [369.678832] Starting subtest: legacy-resubmit [369.683323] Starting dynamic subtest: default [369.686736] Dynamic subtest default: SUCCESS (0.005s) [369.713500] Starting dynamic subtest: render [369.714975] Dynamic subtest render: SUCCESS (0.005s) [369.739329] Starting dynamic subtest: bsd [369.740663] Dynamic subtest bsd: SUCCESS (0.006s) [369.763112] Starting dynamic subtest: bsd1 [369.764636] Dynamic subtest bsd1: SUCCESS (0.005s) [369.786966] Starting dynamic subtest: blt [369.788404] Dynamic subtest blt: SUCCESS (0.008s) [369.810679] Starting dynamic subtest: vebox [369.812071] Dynamic subtest vebox: SUCCESS (0.005s) [369.813339] Subtest legacy-resubmit: SUCCESS (0.045s) [369.957017] [071/141] (666s left) kms_plane_scaling (planes-upscale-20x20-downscale-factor-0-5) [370.258962] Starting subtest: planes-upscale-20x20-downscale-factor-0-5 [370.260699] Starting dynamic subtest: pipe-A-DP-1 [370.595278] Dynamic subtest pipe-A-DP-1: SUCCESS (0.330s) [370.633236] Starting dynamic subtest: pipe-B-DP-1 [370.976114] Dynamic subtest pipe-B-DP-1: SUCCESS (0.379s) [371.021728] Starting dynamic subtest: pipe-C-DP-1 [371.072202] Dynamic subtest pipe-C-DP-1: SKIP (0.089s) [371.073912] Subtest planes-upscale-20x20-downscale-factor-0-5: SUCCESS (0.816s) [371.479739] [072/141] (665s left) kms_flip (flip-vs-panning) [371.761792] Starting subtest: flip-vs-panning [371.763198] Starting dynamic subtest: A-DP1 [382.344458] Dynamic subtest A-DP1: SUCCESS (10.582s) [382.368350] Starting dynamic subtest: B-DP1 [392.889293] Dynamic subtest B-DP1: SUCCESS (10.543s) [392.913948] Starting dynamic subtest: C-DP1 [403.413644] Dynamic subtest C-DP1: SUCCESS (10.522s) [403.415147] Subtest flip-vs-panning: SUCCESS (31.656s) [403.846199] [073/141] (632s left) kms_ccs (pipe-b-crc-primary-rotation-180-4_tiled_dg2_rc_ccs) [404.366989] Starting subtest: pipe-B-crc-primary-rotation-180-4_tiled_dg2_rc_ccs [404.370001] Subtest pipe-B-crc-primary-rotation-180-4_tiled_dg2_rc_ccs: SKIP (0.001s) [404.874532] [074/141] (631s left) kms_frontbuffer_tracking (fbc-tiling-linear) [405.186720] Starting subtest: fbc-tiling-linear [407.094803] Subtest fbc-tiling-linear: SUCCESS (1.909s) [407.225434] [075/141] (629s left) kms_vblank (pipe-d-wait-idle-hang) [407.535610] Subtest pipe-D-wait-idle-hang: SKIP (0.000s) [407.625495] [076/141] (629s left) i915_suspend (fence-restore-untiled) [407.828219] Starting subtest: fence-restore-untiled [427.754404] Subtest fence-restore-untiled: SUCCESS (4.116s) [432.890015] [077/141] (624s left) syncobj_timeline (invalid-wait-bad-flags) [433.092929] Starting subtest: invalid-wait-bad-flags [433.094487] Subtest invalid-wait-bad-flags: SUCCESS (0.000s) [433.181016] [078/141] (624s left) kms_cursor_edge_walk (128x128-left-edge) [433.486159] Starting subtest: 128x128-left-edge [433.491149] Starting dynamic subtest: pipe-A-DP-1 [437.109547] Dynamic subtest pipe-A-DP-1: SUCCESS (3.618s) [437.133525] Starting dynamic subtest: pipe-C-DP-1 [440.595537] Dynamic subtest pipe-C-DP-1: SUCCESS (3.481s) [440.598002] Subtest 128x128-left-edge: SUCCESS (7.110s) [440.920863] [079/141] (616s left) kms_plane_alpha_blend (constant-alpha-min) [441.222804] Starting subtest: constant-alpha-min [441.526635] Starting dynamic subtest: pipe-A-DP-1 [442.204563] Dynamic subtest pipe-A-DP-1: SUCCESS (0.677s) [442.247687] Starting dynamic subtest: pipe-C-DP-1 [443.116121] Dynamic subtest pipe-C-DP-1: SUCCESS (0.904s) [443.118420] Subtest constant-alpha-min: SUCCESS (1.895s) [443.541137] [080/141] (614s left) kms_rotation_crc (multiplane-rotation-cropping-top) [443.851318] Starting subtest: multiplane-rotation-cropping-top [457.846746] Subtest multiplane-rotation-cropping-top: SUCCESS (13.999s) [457.972805] [081/141] (599s left) gem_pxp (verify-pxp-execution-after-suspend-resume) [460.704786] Subtest verify-pxp-execution-after-suspend-resume: SKIP (0.000s) [460.789257] [082/141] (597s left) gem_exec_reloc (basic-cpu-wc) [460.998617] Starting subtest: basic-cpu-wc [461.018902] Subtest basic-cpu-wc: SUCCESS (0.021s) [461.224563] [083/141] (596s left) gem_ccs (suspend-resume) [461.431811] Subtest suspend-resume: SKIP (0.000s) [461.489657] [084/141] (596s left) core_setmaster (master-drop-set-user) [463.387136] Starting subtest: master-drop-set-user [463.427600] Subtest master-drop-set-user: SUCCESS (0.043s) [463.471398] [085/141] (594s left) perf (gen8-unprivileged-single-ctx-counters) [463.765347] Starting subtest: gen8-unprivileged-single-ctx-counters [463.972683] Subtest gen8-unprivileged-single-ctx-counters: SUCCESS (0.207s) [464.027057] [086/141] (594s left) gem_ctx_param (invalid-param-set) [464.232026] Starting subtest: invalid-param-set [464.233632] Subtest invalid-param-set: SUCCESS (0.000s) [464.323690] [087/141] (593s left) kms_ccs (pipe-d-crc-sprite-planes-basic-yf_tiled_ccs) [465.051611] Subtest pipe-D-crc-sprite-planes-basic-yf_tiled_ccs: SKIP (0.000s) [465.367698] [088/141] (592s left) gem_tiled_partial_pwrite_pread (writes-after-reads) [465.578930] Starting subtest: writes-after-reads [469.171068] Subtest writes-after-reads: SUCCESS (3.592s) [469.284780] [089/141] (588s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-render) [469.599284] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-render [469.602208] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-render: SKIP (0.000s) [469.701521] [090/141] (588s left) vc4/vc4_perfmon (create-single-perfmon) [469.956452] Subtest create-single-perfmon: SKIP (0.000s) [470.032763] [091/141] (588s left) drm_fdinfo (virtual-busy-idle-all) [470.240890] Starting subtest: virtual-busy-idle-all [470.242510] Subtest virtual-busy-idle-all: SUCCESS (0.001s) [470.333184] [092/141] (588s left) kms_vblank (pipe-c-ts-continuation-idle) [470.631558] Starting subtest: pipe-C-ts-continuation-idle [471.371648] Subtest pipe-C-ts-continuation-idle: SUCCESS (0.742s) [471.707862] [093/141] (586s left) gen7_exec_parse (bitmasks) [471.920157] Subtest bitmasks: SKIP (0.000s) [471.990851] [094/141] (586s left) kms_big_fb (yf-tiled-64bpp-rotate-0) [472.310932] Starting subtest: yf-tiled-64bpp-rotate-0 [472.314107] Subtest yf-tiled-64bpp-rotate-0: SKIP (0.000s) [472.407841] [095/141] (586s left) gem_partial_pwrite_pread (reads-snoop) [472.620165] Starting subtest: reads-snoop [479.320015] Subtest reads-snoop: SUCCESS (6.700s) [479.439832] [096/141] (579s left) kms_ccs (pipe-d-random-ccs-data-4_tiled_dg2_rc_ccs_cc) [480.152014] Subtest pipe-D-random-ccs-data-4_tiled_dg2_rc_ccs_cc: SKIP (0.000s) [480.469169] [097/141] (578s left) kms_frontbuffer_tracking (psr-rgb565-draw-mmap-cpu) [480.775083] Starting subtest: psr-rgb565-draw-mmap-cpu [480.777864] Subtest psr-rgb565-draw-mmap-cpu: SKIP (0.000s) [480.885833] [098/141] (577s left) kms_frontbuffer_tracking (fbc-rgb565-draw-blt) [481.201897] Starting subtest: fbc-rgb565-draw-blt [483.438631] Subtest fbc-rgb565-draw-blt: SUCCESS (2.240s) [483.568241] [099/141] (575s left) kms_ccs (pipe-b-crc-primary-basic-4_tiled_mtl_rc_ccs) [484.095561] Starting subtest: pipe-B-crc-primary-basic-4_tiled_mtl_rc_ccs [484.098422] Subtest pipe-B-crc-primary-basic-4_tiled_mtl_rc_ccs: SKIP (0.001s) [484.616239] [100/141] (574s left) kms_vblank (pipe-b-wait-forked-busy) [484.920284] Starting subtest: pipe-B-wait-forked-busy [487.761691] Subtest pipe-B-wait-forked-busy: SUCCESS (2.843s) [488.094698] [101/141] (570s left) gem_mmap_wc (write-cpu-read-wc) [488.302357] Starting subtest: write-cpu-read-wc [488.572420] Subtest write-cpu-read-wc: SUCCESS (0.272s) [488.660537] [102/141] (570s left) v3d/v3d_submit_csd (single-out-sync) [488.916423] Subtest single-out-sync: SKIP (0.000s) [488.992380] [103/141] (569s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-blt) [489.311992] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-blt [489.314831] Subtest fbc-2p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s) [489.411279] [104/141] (569s left) syncobj_timeline (invalid-multi-wait-available-unsubmitted-submitted) [489.615511] Starting subtest: invalid-multi-wait-available-unsubmitted-submitted [489.617521] Subtest invalid-multi-wait-available-unsubmitted-submitted: SUCCESS (0.001s) [489.710480] [105/141] (569s left) kms_cursor_legacy (short-flip-before-cursor-toggle) [490.017780] Starting subtest: short-flip-before-cursor-toggle [491.111598] Subtest short-flip-before-cursor-toggle: SUCCESS (1.096s) [491.445370] [106/141] (567s left) kms_ccs (pipe-a-ccs-on-another-bo-y_tiled_ccs) [491.916830] Starting subtest: pipe-A-ccs-on-another-bo-y_tiled_ccs [491.918497] Subtest pipe-A-ccs-on-another-bo-y_tiled_ccs: SUCCESS (0.002s) [492.531175] [107/141] (566s left) kms_ccs (pipe-d-crc-primary-basic-yf_tiled_ccs) [493.246106] Subtest pipe-D-crc-primary-basic-yf_tiled_ccs: SKIP (0.000s) [493.561746] [108/141] (565s left) kms_vblank (pipe-d-wait-forked-busy-hang) [493.861195] Subtest pipe-D-wait-forked-busy-hang: SKIP (0.000s) [493.944543] [109/141] (565s left) api_intel_allocator (two-level-inception) [494.145213] Starting subtest: two-level-inception [499.675313] Subtest two-level-inception: SUCCESS (5.527s) [499.761810] [110/141] (559s left) syncobj_wait (wait-all-snapshot) [499.962782] Starting subtest: wait-all-snapshot [500.046969] Subtest wait-all-snapshot: SUCCESS (0.084s) [500.143881] [111/141] (559s left) kms_cursor_crc (cursor-offscreen-64x21) [500.445537] Starting subtest: cursor-offscreen-64x21 [500.458983] Starting dynamic subtest: pipe-A-DP-1 [502.927867] Dynamic subtest pipe-A-DP-1: SUCCESS (2.470s) [503.020150] Starting dynamic subtest: pipe-C-DP-1 [505.770262] Dynamic subtest pipe-C-DP-1: SUCCESS (2.778s) [505.771576] Subtest cursor-offscreen-64x21: SUCCESS (5.321s) [506.130610] [112/141] (553s left) kms_color (deep-color) [506.438788] Starting subtest: deep-color [506.441381] Subtest deep-color: SKIP (0.000s) [506.527639] [113/141] (552s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-shrfb-plflip-blt) [506.844932] Starting subtest: fbcpsr-2p-scndscrn-shrfb-plflip-blt [506.848067] Subtest fbcpsr-2p-scndscrn-shrfb-plflip-blt: SKIP (0.000s) [506.944328] [114/141] (552s left) perf (invalid-open-flags) [507.232637] Starting subtest: invalid-open-flags [507.234365] Subtest invalid-open-flags: SUCCESS (0.001s) [507.294276] [115/141] (552s left) kms_ccs (pipe-b-bad-pixel-format-4_tiled_mtl_rc_ccs) [507.773837] Starting subtest: pipe-B-bad-pixel-format-4_tiled_mtl_rc_ccs [507.776811] Subtest pipe-B-bad-pixel-format-4_tiled_mtl_rc_ccs: SKIP (0.000s) [508.309659] [116/141] (551s left) vc4/vc4_wait_bo (used-bo-0ns) [508.564683] Subtest used-bo-0ns: SKIP (0.000s) [508.642429] [117/141] (550s left) kms_psr (psr2_sprite_blt) [508.844313] Subtest psr2_sprite_blt: SKIP (0.000s) [508.908397] [118/141] (550s left) kms_flip_scaled_crc (flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling) [509.210911] Starting subtest: flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling [509.212461] Starting dynamic subtest: pipe-A-valid-mode [509.312987] Dynamic subtest pipe-A-valid-mode: SKIP (0.099s) [509.316956] Subtest flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling: SKIP (0.103s) [509.632297] [119/141] (549s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-fullscreen) [509.947132] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-fullscreen [509.950012] Subtest fbcpsr-1p-primscrn-spr-indfb-fullscreen: SKIP (0.000s) [510.048688] [120/141] (549s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt) [510.365579] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt [510.368327] Subtest fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s) [510.465597] [121/141] (549s left) gem_exec_fair (basic-none-vip) [510.696267] Starting subtest: basic-none-vip [510.700728] Starting dynamic subtest: rcs0 [516.494621] Dynamic subtest rcs0: SUCCESS (5.795s) [516.496241] Subtest basic-none-vip: SUCCESS (5.797s) [516.700635] [122/141] (543s left) kms_pipe_crc_basic (suspend-read-crc) [517.003518] Starting subtest: suspend-read-crc [517.007670] Starting dynamic subtest: pipe-A-DP-1 [535.935920] Dynamic subtest pipe-A-DP-1: SUCCESS (2.664s) [535.964779] Starting dynamic subtest: pipe-B-DP-1 [554.946716] Dynamic subtest pipe-B-DP-1: SUCCESS (3.160s) [554.978983] Starting dynamic subtest: pipe-C-DP-1 [574.214913] Dynamic subtest pipe-C-DP-1: SUCCESS (3.333s) [574.216926] Subtest suspend-read-crc: SUCCESS (9.175s) [577.328199] [123/141] (533s left) perf (create-destroy-userspace-config) [577.682032] Starting subtest: create-destroy-userspace-config [577.768486] Subtest create-destroy-userspace-config: SUCCESS (0.087s) [577.839700] [124/141] (532s left) kms_ccs (pipe-c-crc-primary-rotation-180-4_tiled_mtl_mc_ccs) [578.473421] Starting subtest: pipe-C-crc-primary-rotation-180-4_tiled_mtl_mc_ccs [578.476242] Subtest pipe-C-crc-primary-rotation-180-4_tiled_mtl_mc_ccs: SKIP (0.001s) [578.868471] [125/141] (531s left) syncobj_timeline (32bits-limit) [579.068777] Starting subtest: 32bits-limit [579.074101] Subtest 32bits-limit: SUCCESS (0.004s) [579.168134] [126/141] (531s left) kms_flip (nonexisting-fb-interruptible) [579.461980] Starting subtest: nonexisting-fb-interruptible [579.467338] Starting dynamic subtest: A-DP1 [579.984624] Dynamic subtest A-DP1: SUCCESS (0.517s) [580.010750] Starting dynamic subtest: B-DP1 [580.399439] Dynamic subtest B-DP1: SUCCESS (0.413s) [580.427234] Starting dynamic subtest: C-DP1 [580.810456] Dynamic subtest C-DP1: SUCCESS (0.409s) [580.813039] Subtest nonexisting-fb-interruptible: SUCCESS (1.350s) [581.215334] [127/141] (529s left) kms_ccs (pipe-c-random-ccs-data-4_tiled_dg2_rc_ccs) [581.908109] Starting subtest: pipe-C-random-ccs-data-4_tiled_dg2_rc_ccs [581.913594] Subtest pipe-C-random-ccs-data-4_tiled_dg2_rc_ccs: SKIP (0.000s) [582.296952] [128/141] (528s left) kms_frontbuffer_tracking (fbc-1p-shrfb-fliptrack-mmap-gtt) [582.607676] Starting subtest: fbc-1p-shrfb-fliptrack-mmap-gtt [585.665661] Subtest fbc-1p-shrfb-fliptrack-mmap-gtt: SUCCESS (3.062s) [585.813793] [129/141] (524s left) gem_ctx_persistence (heartbeat-close) [586.023131] Starting subtest: heartbeat-close [586.177273] Subtest heartbeat-close: SUCCESS (0.154s) [586.280281] [130/141] (524s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-render) [586.594926] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-render [586.597929] Subtest fbc-2p-scndscrn-pri-shrfb-draw-render: SKIP (0.000s) [586.713166] [131/141] (524s left) kms_chamelium_audio (hdmi-audio-edid) [587.115629] Subtest hdmi-audio-edid: SKIP (0.000s) [587.404512] [132/141] (523s left) kms_addfb_basic (unused-handle) [587.603791] Starting subtest: unused-handle [587.605267] Subtest unused-handle: SUCCESS (0.000s) [587.816045] [133/141] (523s left) syncobj_timeline (multi-wait-for-submit-unsubmitted-submitted-signaled) [588.016180] Starting subtest: multi-wait-for-submit-unsubmitted-submitted-signaled [588.021377] Subtest multi-wait-for-submit-unsubmitted-submitted-signaled: SUCCESS (0.002s) [588.115744] [134/141] (522s left) kms_atomic (plane-invalid-params) [588.542680] Starting subtest: plane-invalid-params [588.703099] Subtest plane-invalid-params: SUCCESS (0.160s) [589.146317] [135/141] (521s left) kms_ccs (pipe-a-crc-sprite-planes-basic-y_tiled_gen12_rc_ccs) [589.639600] Starting subtest: pipe-A-crc-sprite-planes-basic-y_tiled_gen12_rc_ccs [589.643880] Subtest pipe-A-crc-sprite-planes-basic-y_tiled_gen12_rc_ccs: SKIP (0.005s) [590.211831] [136/141] (520s left) kms_cursor_legacy (flip-vs-cursor-crc-atomic) [590.510630] Starting subtest: flip-vs-cursor-crc-atomic [591.132879] Subtest flip-vs-cursor-crc-atomic: SUCCESS (0.621s) [591.461244] [137/141] (519s left) gem_exec_balancer (hog) [591.686055] Starting subtest: hog [595.359953] Subtest hog: SUCCESS (3.672s) [599.260706] [138/141] (511s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip) [599.579558] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip [599.585590] Subtest x-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip: SKIP (0.004s) [599.692884] [139/141] (511s left) fbdev (write) [599.897501] Starting subtest: write [600.632450] Subtest write: SUCCESS (0.734s) [600.709891] [140/141] (510s left) v3d/v3d_perfmon (create-two-perfmon) [600.964200] Subtest create-two-perfmon: SKIP (0.000s) [601.041481] [141/141] (510s left) kms_frontbuffer_tracking (fbcpsr-shrfb-scaledprimary) [601.344651] Starting subtest: fbcpsr-shrfb-scaledprimary [601.347196] Subtest fbcpsr-shrfb-scaledprimary: SKIP (0.000s) [601.438640] Closing watchdogs Done.