[33.428245] Initializing watchdogs
[33.428300]   /dev/watchdog0
[33.432954] [001/142] (960s left) kms_plane_scaling (planes-downscale-factor-0-5-upscale-20x20)
[33.527303] Starting subtest: planes-downscale-factor-0-5-upscale-20x20
[33.533077] Starting dynamic subtest: pipe-A-HDMI-A-1
[33.680328] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.153s)
[33.683258] Starting dynamic subtest: pipe-B-HDMI-A-1
[33.806474] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.125s)
[33.807183] Subtest planes-downscale-factor-0-5-upscale-20x20: SUCCESS (0.281s)
[33.928216] [002/142] (960s left) fbdev (unaligned-read)
[33.992489] Starting subtest: unaligned-read
[33.996850] Subtest unaligned-read: SUCCESS (0.005s)
[34.040632] [003/142] (959s left) kms_cursor_legacy (short-flip-after-cursor-atomic-transitions-varying-size)
[34.130736] Starting subtest: short-flip-after-cursor-atomic-transitions-varying-size
[35.258838] Subtest short-flip-after-cursor-atomic-transitions-varying-size: SUCCESS (1.128s)
[35.386573] [004/142] (958s left) kms_ccs (pipe-b-bad-aux-stride-y_tiled_gen12_rc_ccs_cc)
[35.607820] Starting subtest: pipe-B-bad-aux-stride-y_tiled_gen12_rc_ccs_cc
[35.608554] Subtest pipe-B-bad-aux-stride-y_tiled_gen12_rc_ccs_cc: SUCCESS (0.001s)
[35.710454] [005/142] (958s left) v3d/v3d_mmap (mmap-bad-handle)
[35.796267] Subtest mmap-bad-handle: SKIP (0.000s)
[35.843330] [006/142] (958s left) kms_dsc (dsc-with-bpc-formats)
[35.931016] Starting subtest: dsc-with-bpc-formats
[35.932421] Subtest dsc-with-bpc-formats: SKIP (0.001s)
[35.994471] [007/142] (957s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling)
[36.085306] Starting subtest: flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling
[36.086221] Starting dynamic subtest: pipe-A-valid-mode
[36.127882] Dynamic subtest pipe-A-valid-mode: SKIP (0.042s)
[36.131136] Subtest flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling: SKIP (0.042s)
[36.218763] [008/142] (957s left) kms_fbcon_fbt (fbc-suspend)
[36.268461] Starting subtest: fbc-suspend
[84.583064] Subtest fbc-suspend: SUCCESS (48.313s)
[85.611717] [009/142] (909s left) gem_ctx_persistence (legacy-engines-mixed-process)
[85.675027] Starting subtest: legacy-engines-mixed-process
[85.675714] Starting dynamic subtest: render
[86.004069] Dynamic subtest render: SUCCESS (0.328s)
[86.008214] Starting dynamic subtest: bsd
[86.362046] Dynamic subtest bsd: SUCCESS (0.358s)
[86.365942] Starting dynamic subtest: blt
[86.684101] Dynamic subtest blt: SUCCESS (0.322s)
[86.688796] Starting dynamic subtest: vebox
[87.025042] Dynamic subtest vebox: SUCCESS (0.341s)
[87.025798] Subtest legacy-engines-mixed-process: SUCCESS (1.350s)
[87.101812] [010/142] (907s left) kms_cursor_legacy (cursora-vs-flipb-atomic)
[87.200482] Starting subtest: cursorA-vs-flipB-atomic
[87.203132] Subtest cursorA-vs-flipB-atomic: SKIP (0.001s)
[87.267050] [011/142] (907s left) kms_rotation_crc (exhaust-fences)
[87.359025] Starting subtest: exhaust-fences
[89.913463] Subtest exhaust-fences: SUCCESS (2.555s)
[90.004389] [012/142] (905s left) i915_pm_rpm (basic-pci-d3-state)
[91.438358] Starting subtest: basic-pci-d3-state
[91.800226] Subtest basic-pci-d3-state: SUCCESS (0.362s)
[91.986549] [013/142] (903s left) kms_frontbuffer_tracking (fbc-1p-offscren-pri-indfb-draw-pwrite)
[92.093955] Starting subtest: fbc-1p-offscren-pri-indfb-draw-pwrite
[94.493520] Subtest fbc-1p-offscren-pri-indfb-draw-pwrite: SUCCESS (2.402s)
[94.637402] [014/142] (900s left) gem_softpin (invalid)
[94.683497] Starting subtest: invalid
[94.686623] Subtest invalid: SUCCESS (0.003s)
[94.808126] [015/142] (900s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip)
[94.900779] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip
[95.232623] Subtest y-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip: SUCCESS (0.332s)
[95.385446] [016/142] (899s left) gem_exec_reloc (basic-gtt-read-active)
[95.445714] Subtest basic-gtt-read-active: SKIP (0.000s)
[95.487929] [017/142] (899s left) kms_ccs (pipe-a-crc-primary-rotation-180-yf_tiled_ccs)
[95.653488] Starting subtest: pipe-A-crc-primary-rotation-180-yf_tiled_ccs
[95.654874] Subtest pipe-A-crc-primary-rotation-180-yf_tiled_ccs: SKIP (0.000s)
[95.833296] [018/142] (899s left) syncobj_timeline (etime-multi-wait-all-for-submit-available-unsubmitted-submi
[95.876124] Starting subtest: etime-multi-wait-all-for-submit-available-unsubmitted-submitted
[95.982258] Subtest etime-multi-wait-all-for-submit-available-unsubmitted-submitted: SUCCESS (0.106s)
[96.044497] [019/142] (899s left) gem_exec_schedule (preempt-queue)
[96.110812] Starting subtest: preempt-queue
[96.111481] Starting dynamic subtest: rcs0
[96.159153] Dynamic subtest rcs0: SUCCESS (0.048s)
[96.163298] Starting dynamic subtest: bcs0
[96.204568] Dynamic subtest bcs0: SUCCESS (0.045s)
[96.208753] Starting dynamic subtest: vcs0
[96.249395] Dynamic subtest vcs0: SUCCESS (0.045s)
[96.253566] Starting dynamic subtest: vecs0
[96.293801] Dynamic subtest vecs0: SUCCESS (0.044s)
[96.294479] Subtest preempt-queue: SUCCESS (0.183s)
[96.597623] [020/142] (898s left) syncobj_timeline (invalid-multi-wait-available-unsubmitted-submitted-signaled
[96.653469] Starting subtest: invalid-multi-wait-available-unsubmitted-submitted-signaled
[96.654171] Subtest invalid-multi-wait-available-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[96.709128] [021/142] (898s left) v3d/v3d_wait_bo (bad-bo)
[96.790236] Subtest bad-bo: SKIP (0.000s)
[96.843774] [022/142] (898s left) gem_exec_balancer (waits)
[96.908094] Starting subtest: waits
[97.694202] Subtest waits: SUCCESS (0.786s)
[98.682868] [023/142] (896s left) kms_ccs (pipe-b-crc-primary-basic-y_tiled_gen12_rc_ccs_cc)
[98.889188] Starting subtest: pipe-B-crc-primary-basic-y_tiled_gen12_rc_ccs_cc
[99.182870] Subtest pipe-B-crc-primary-basic-y_tiled_gen12_rc_ccs_cc: SUCCESS (0.293s)
[99.359990] [024/142] (895s left) debugfs_test (read_all_entries_display_on)
[99.456725] Starting subtest: read_all_entries_display_on
[99.558326] Subtest read_all_entries_display_on: SUCCESS (0.102s)
[99.682213] [025/142] (895s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-fullscreen)
[99.773239] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-fullscreen
[99.774561] Subtest fbcpsr-1p-primscrn-spr-indfb-fullscreen: SKIP (0.000s)
[99.853657] [026/142] (895s left) syncobj_timeline (wait-for-submit-delayed-submit)
[99.911343] Starting subtest: wait-for-submit-delayed-submit
[100.014273] Subtest wait-for-submit-delayed-submit: SUCCESS (0.102s)
[100.086463] [027/142] (895s left) api_intel_allocator (reloc-allocator)
[100.133332] Starting subtest: reloc-allocator
[100.134031] Starting dynamic subtest: basic
[100.134729] Dynamic subtest basic: SUCCESS (0.001s)
[100.139630] Starting dynamic subtest: parallel-one
[100.140319] Dynamic subtest parallel-one: SUCCESS (0.005s)
[100.144812] Starting dynamic subtest: print
[100.145485] Dynamic subtest print: SUCCESS (0.000s)
[100.149534] Starting dynamic subtest: reuse
[100.150207] Dynamic subtest reuse: SUCCESS (0.000s)
[100.154234] Starting dynamic subtest: fork-reopen-allocator
[100.154910] Dynamic subtest fork-reopen-allocator: SUCCESS (0.011s)
[100.155571] Subtest reloc-allocator: SUCCESS (0.017s)
[100.218416] [028/142] (895s left) i915_pm_rpm (universal-planes)
[101.633121] Starting subtest: universal-planes
[101.634361] Starting dynamic subtest: plane-31
[103.469053] Dynamic subtest plane-31: SUCCESS (1.836s)
[103.476033] Starting dynamic subtest: plane-40
[105.480987] Dynamic subtest plane-40: SUCCESS (2.011s)
[105.489270] Starting dynamic subtest: plane-49
[110.508253] Dynamic subtest plane-49: SUCCESS (5.026s)
[110.517060] Starting dynamic subtest: plane-58
[112.451424] Dynamic subtest plane-58: SUCCESS (1.942s)
[112.459249] Starting dynamic subtest: plane-67
[114.376354] Dynamic subtest plane-67: SUCCESS (1.924s)
[114.384758] Starting dynamic subtest: plane-76
[116.159462] Dynamic subtest plane-76: SUCCESS (1.782s)
[116.160337] Subtest universal-planes: SUCCESS (14.527s)
[116.371014] [029/142] (878s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-mmap-gtt)
[116.464773] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-mmap-gtt
[116.466177] Subtest psr-2p-scndscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[116.540668] [030/142] (878s left) gem_exec_reloc (basic-wc-gtt-noreloc)
[116.590064] Subtest basic-wc-gtt-noreloc: SKIP (0.000s)
[116.657704] [031/142] (878s left) kms_lease (cursor_implicit_plane)
[116.759476] Starting subtest: cursor_implicit_plane
[116.760256] Starting dynamic subtest: pipe-A-HDMI-A-1
[117.165347] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.405s)
[117.169706] Starting dynamic subtest: pipe-B-HDMI-A-1
[117.591019] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.426s)
[117.591712] Subtest cursor_implicit_plane: SUCCESS (0.833s)
[117.683287] [032/142] (877s left) syncobj_wait (single-wait-signaled)
[117.732719] Starting subtest: single-wait-signaled
[117.733394] Subtest single-wait-signaled: SUCCESS (0.000s)
[117.797252] [033/142] (877s left) syncobj_wait (single-wait-all-submitted)
[117.840131] Starting subtest: single-wait-all-submitted
[117.941784] Subtest single-wait-all-submitted: SUCCESS (0.102s)
[118.005835] [034/142] (877s left) kms_cursor_edge_walk (128x128-top-bottom)
[118.094120] Starting subtest: 128x128-top-bottom
[118.094819] Starting dynamic subtest: pipe-A-HDMI-A-1
[121.777128] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (3.683s)
[121.782367] Starting dynamic subtest: pipe-B-HDMI-A-1
[125.389139] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (3.611s)
[125.389834] Subtest 128x128-top-bottom: SUCCESS (7.296s)
[125.482028] [035/142] (869s left) syncobj_timeline (multi-wait-available-signaled)
[125.525759] Starting subtest: multi-wait-available-signaled
[125.526424] Subtest multi-wait-available-signaled: SUCCESS (0.000s)
[125.599044] [036/142] (869s left) kms_frontbuffer_tracking (psr-1p-offscren-pri-shrfb-draw-mmap-gtt)
[125.704673] Starting subtest: psr-1p-offscren-pri-shrfb-draw-mmap-gtt
[125.706032] Subtest psr-1p-offscren-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[125.786257] [037/142] (869s left) api_intel_allocator (reserve-simple)
[125.834771] Starting subtest: reserve-simple
[125.835480] Subtest reserve-simple: SUCCESS (0.001s)
[125.944929] [038/142] (869s left) kms_busy (extended-modeset-hang-newfb-with-reset)
[126.054705] Starting subtest: extended-modeset-hang-newfb-with-reset
[126.055398] Starting dynamic subtest: pipe-A
[128.853442] Dynamic subtest pipe-A: SUCCESS (2.798s)
[128.858885] Starting dynamic subtest: pipe-B
[131.610852] Dynamic subtest pipe-B: SUCCESS (2.756s)
[131.611604] Subtest extended-modeset-hang-newfb-with-reset: SUCCESS (5.557s)
[131.742847] [039/142] (863s left) kms_chamelium_frames (hdmi-aspect-ratio)
[131.873940] Subtest hdmi-aspect-ratio: SKIP (0.000s)
[131.929081] [040/142] (863s left) gem_set_tiling_vs_gtt
[132.374792] [041/142] (863s left) kms_flip (blocking-absolute-wf_vblank-interruptible)
[132.471401] Starting subtest: blocking-absolute-wf_vblank-interruptible
[132.472977] Starting dynamic subtest: A-HDMI-A1
[147.840162] Dynamic subtest A-HDMI-A1: SUCCESS (15.366s)
[147.846105] Starting dynamic subtest: B-HDMI-A1
[163.149742] Dynamic subtest B-HDMI-A1: SUCCESS (15.309s)
[163.152382] Subtest blocking-absolute-wf_vblank-interruptible: SUCCESS (30.680s)
[163.289212] [042/142] (832s left) gem_exec_schedule (independent)
[163.338447] Starting subtest: independent
[163.339139] Starting dynamic subtest: rcs0
[163.435775] Dynamic subtest rcs0: SUCCESS (0.096s)
[163.452226] Starting dynamic subtest: bcs0
[163.532669] Dynamic subtest bcs0: SUCCESS (0.095s)
[163.549259] Starting dynamic subtest: vcs0
[163.622922] Dynamic subtest vcs0: SUCCESS (0.088s)
[163.637114] Starting dynamic subtest: vecs0
[163.718700] Dynamic subtest vecs0: SUCCESS (0.094s)
[163.719977] Subtest independent: SUCCESS (0.381s)
[164.033519] [043/142] (831s left) gem_exec_nop (basic-series)
[164.091704] Starting subtest: basic-series
[167.114038] Subtest basic-series: SUCCESS (3.022s)
[167.338227] [044/142] (828s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-render)
[167.434695] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-render
[167.436045] Subtest psr-2p-scndscrn-cur-indfb-draw-render: SKIP (0.000s)
[167.523044] [045/142] (828s left) kms_cursor_crc (cursor-random-256x85)
[167.630952] Starting subtest: cursor-random-256x85
[167.633657] Starting dynamic subtest: pipe-A-HDMI-A-1
[171.938732] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (4.305s)
[171.957736] Starting dynamic subtest: pipe-B-HDMI-A-1
[176.266794] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (4.313s)
[176.267487] Subtest cursor-random-256x85: SUCCESS (8.637s)
[176.384866] [046/142] (819s left) kms_rotation_crc (primary-4-tiled-reflect-x-0)
[176.474883] Starting subtest: primary-4-tiled-reflect-x-0
[176.595506] Subtest primary-4-tiled-reflect-x-0: SKIP (0.120s)
[176.677727] [047/142] (818s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip)
[176.779766] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip
[177.144147] Subtest x-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip: SUCCESS (0.365s)
[177.293556] [048/142] (818s left) gem_partial_pwrite_pread (write-uncached)
[177.353618] Subtest write-uncached: SKIP (0.000s)
[177.398279] [049/142] (818s left) gem_eio (in-flight-contexts-immediate)
[177.459085] Starting subtest: in-flight-contexts-immediate
[189.195830] Subtest in-flight-contexts-immediate: SUCCESS (11.737s)
[189.365284] [050/142] (806s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-cpu)
[189.469993] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-cpu
[189.471597] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[189.571672] [051/142] (806s left) kms_ccs (pipe-b-crc-sprite-planes-basic-y_tiled_gen12_rc_ccs)
[189.809783] Starting subtest: pipe-B-crc-sprite-planes-basic-y_tiled_gen12_rc_ccs
[190.904911] Subtest pipe-B-crc-sprite-planes-basic-y_tiled_gen12_rc_ccs: SUCCESS (1.095s)
[191.043367] [052/142] (804s left) kms_big_fb (linear-64bpp-rotate-0)
[191.136422] Starting subtest: linear-64bpp-rotate-0
[192.985147] Subtest linear-64bpp-rotate-0: SUCCESS (1.849s)
[193.190741] [053/142] (802s left) vgem_basic (sysfs)
[193.271453] Starting subtest: sysfs
[193.272226] Subtest sysfs: SUCCESS (0.000s)
[193.323447] [054/142] (802s left) kms_psr (cursor_blt)
[193.378869] Subtest cursor_blt: SKIP (0.000s)
[193.410910] [055/142] (802s left) kms_prime (basic-crc-hybrid)
[194.075630] Subtest basic-crc-hybrid: SKIP (0.000s)
[194.163875] [056/142] (801s left) gem_tiled_partial_pwrite_pread (writes)
[194.218508] Subtest writes: SKIP (0.000s)
[194.272077] [057/142] (801s left) kms_panel_fitting (atomic-fastset)
[194.373067] Starting subtest: atomic-fastset
[194.374554] Subtest atomic-fastset: SKIP (0.000s)
[194.438708] [058/142] (801s left) gem_tiled_blits (normal)
[195.076234] Starting subtest: normal
[205.530286] Subtest normal: SUCCESS (10.454s)
[205.643805] [059/142] (790s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-mmap-wc)
[205.781250] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-mmap-wc
[208.486655] Subtest fbc-1p-primscrn-spr-indfb-draw-mmap-wc: SUCCESS (2.707s)
[208.632212] [060/142] (787s left) kms_getfb (getfb2-handle-protection)
[208.679067] Starting subtest: getfb2-handle-protection
[208.686077] Subtest getfb2-handle-protection: SUCCESS (0.008s)
[208.764810] [061/142] (787s left) gem_exec_reloc (basic-gtt-noreloc)
[208.814284] Subtest basic-gtt-noreloc: SKIP (0.000s)
[208.865799] [062/142] (786s left) kms_cursor_legacy (cursor-vs-flip-legacy)
[208.969701] Starting subtest: cursor-vs-flip-legacy
[236.842385] Subtest cursor-vs-flip-legacy: SUCCESS (27.874s)
[236.965630] [063/142] (758s left) kms_big_fb (x-tiled-64bpp-rotate-270)
[237.067212] Starting subtest: x-tiled-64bpp-rotate-270
[237.118527] Subtest x-tiled-64bpp-rotate-270: SKIP (0.050s)
[237.211678] [064/142] (758s left) vc4/vc4_purgeable_bo (mark-unpurgeable-purged)
[237.315575] Subtest mark-unpurgeable-purged: SKIP (0.000s)
[237.371631] [065/142] (758s left) syncobj_timeline (host-signal-points)
[237.422474] Starting subtest: host-signal-points
[237.425915] Subtest host-signal-points: SUCCESS (0.004s)
[237.503324] [066/142] (758s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip)
[237.607470] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip
[237.608835] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SKIP (0.000s)
[237.713847] [067/142] (758s left) kms_ccs (pipe-a-missing-ccs-buffer-y_tiled_gen12_mc_ccs)
[237.878164] Starting subtest: pipe-A-missing-ccs-buffer-y_tiled_gen12_mc_ccs
[237.879494] Subtest pipe-A-missing-ccs-buffer-y_tiled_gen12_mc_ccs: SKIP (0.000s)
[238.047407] [068/142] (757s left) kms_ccs (pipe-d-ccs-on-another-bo-4_tiled_mtl_rc_ccs_cc)
[238.277292] Subtest pipe-D-ccs-on-another-bo-4_tiled_mtl_rc_ccs_cc: SKIP (0.000s)
[238.369599] [069/142] (757s left) kms_ccs (pipe-c-crc-primary-rotation-180-4_tiled_mtl_mc_ccs)
[238.599972] Subtest pipe-C-crc-primary-rotation-180-4_tiled_mtl_mc_ccs: SKIP (0.000s)
[238.692901] [070/142] (757s left) v3d/v3d_submit_cl (job-perfmon)
[238.776377] Subtest job-perfmon: SKIP (0.000s)
[238.825497] [071/142] (757s left) kms_pipe_crc_basic (disable-crc-after-crtc)
[238.913287] Starting subtest: disable-crc-after-crtc
[238.914020] Starting dynamic subtest: pipe-A-HDMI-A-1
[239.538592] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.625s)
[239.544731] Starting dynamic subtest: pipe-B-HDMI-A-1
[240.175967] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.636s)
[240.176683] Subtest disable-crc-after-crtc: SUCCESS (1.264s)
[240.289221] [072/142] (755s left) gem_busy (semaphore)
[240.455229] Starting subtest: semaphore
[240.455921] Starting dynamic subtest: rcs0
[240.517724] Dynamic subtest rcs0: SUCCESS (0.065s)
[240.522722] Starting dynamic subtest: bcs0
[240.531722] Dynamic subtest bcs0: SUCCESS (0.013s)
[240.536601] Starting dynamic subtest: vcs0
[240.549723] Dynamic subtest vcs0: SUCCESS (0.018s)
[240.554601] Starting dynamic subtest: vecs0
[240.564784] Dynamic subtest vecs0: SUCCESS (0.015s)
[240.565467] Subtest semaphore: SUCCESS (0.113s)
[240.763566] [073/142] (755s left) syncobj_wait (invalid-wait-illegal-handle)
[240.807347] Starting subtest: invalid-wait-illegal-handle
[240.808052] Subtest invalid-wait-illegal-handle: SUCCESS (0.000s)
[240.877415] [074/142] (755s left) gem_ctx_shared (exec-single-timeline)
[240.925641] Starting subtest: exec-single-timeline
[240.926349] Starting dynamic subtest: rcs0
[241.987733] Dynamic subtest rcs0: SUCCESS (1.056s)
[241.993946] Starting dynamic subtest: bcs0
[243.006915] Dynamic subtest bcs0: SUCCESS (1.022s)
[243.014855] Starting dynamic subtest: vcs0
[244.030915] Dynamic subtest vcs0: SUCCESS (1.022s)
[244.039445] Starting dynamic subtest: vecs0
[245.054796] Dynamic subtest vecs0: SUCCESS (1.022s)
[245.056180] Subtest exec-single-timeline: SUCCESS (4.129s)
[245.227025] [075/142] (750s left) gem_userptr_blits (sync-unmap)
[245.291167] Starting subtest: sync-unmap
[245.301857] Subtest sync-unmap: SUCCESS (0.011s)
[245.396828] [076/142] (750s left) kms_ccs (pipe-b-bad-rotation-90-4_tiled_mtl_mc_ccs)
[245.596328] Starting subtest: pipe-B-bad-rotation-90-4_tiled_mtl_mc_ccs
[245.597740] Subtest pipe-B-bad-rotation-90-4_tiled_mtl_mc_ccs: SKIP (0.000s)
[245.735483] [077/142] (750s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-gtt)
[245.826184] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-gtt
[245.827515] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[245.906281] [078/142] (750s left) vc4/vc4_tiling (get-bad-handle)
[246.011336] Subtest get-bad-handle: SKIP (0.000s)
[246.065455] [079/142] (749s left) gem_render_copy (yf-tiled)
[246.123065] Starting subtest: yf-tiled
[246.123786] Starting dynamic subtest: smem
[246.191921] Dynamic subtest smem: SUCCESS (0.068s)
[246.192642] Subtest yf-tiled: SUCCESS (0.069s)
[246.369528] [080/142] (749s left) kms_ccs (pipe-d-missing-ccs-buffer-4_tiled_mtl_mc_ccs)
[246.612518] Subtest pipe-D-missing-ccs-buffer-4_tiled_mtl_mc_ccs: SKIP (0.000s)
[246.704457] [081/142] (749s left) kms_ccs (pipe-c-bad-pixel-format-y_tiled_ccs)
[246.935072] Subtest pipe-C-bad-pixel-format-y_tiled_ccs: SKIP (0.000s)
[247.027724] [082/142] (749s left) gem_exec_create (basic)
[247.076193] Starting subtest: basic
[247.076919] Starting dynamic subtest: smem
[249.119845] Dynamic subtest smem: SUCCESS (2.043s)
[249.120535] Subtest basic: SUCCESS (2.044s)
[249.308021] [083/142] (746s left) syncobj_wait (single-wait-submitted)
[249.359492] Starting subtest: single-wait-submitted
[249.462353] Subtest single-wait-submitted: SUCCESS (0.103s)
[249.534036] [084/142] (746s left) kms_vblank (pipe-b-query-busy-hang)
[249.632577] Starting subtest: pipe-B-query-busy-hang
[264.165057] Subtest pipe-B-query-busy-hang: SUCCESS (14.533s)
[264.298144] [085/142] (731s left) gem_exec_schedule (u-fairslice)
[264.349076] Starting subtest: u-fairslice
[264.349778] Starting dynamic subtest: rcs0
[266.363630] Dynamic subtest rcs0: SUCCESS (2.013s)
[266.370867] Starting dynamic subtest: bcs0
[268.372608] Dynamic subtest bcs0: SUCCESS (2.009s)
[268.380384] Starting dynamic subtest: vcs0
[270.381709] Dynamic subtest vcs0: SUCCESS (2.008s)
[270.390437] Starting dynamic subtest: vecs0
[272.390383] Dynamic subtest vecs0: SUCCESS (2.009s)
[272.391087] Subtest u-fairslice: SUCCESS (8.041s)
[272.693332] [086/142] (723s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-mmap-gtt)
[272.788717] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-mmap-gtt
[272.790060] Subtest fbc-2p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[272.877449] [087/142] (723s left) perf_pmu (idle)
[272.932863] Starting subtest: idle
[272.933552] Starting dynamic subtest: rcs0
[273.458660] Dynamic subtest rcs0: SUCCESS (0.525s)
[273.468231] Starting dynamic subtest: bcs0
[273.976766] Dynamic subtest bcs0: SUCCESS (0.516s)
[273.986259] Starting dynamic subtest: vcs0
[274.494385] Dynamic subtest vcs0: SUCCESS (0.516s)
[274.504109] Starting dynamic subtest: vecs0
[275.012404] Dynamic subtest vecs0: SUCCESS (0.516s)
[275.013691] Subtest idle: SUCCESS (2.080s)
[275.080128] [088/142] (721s left) gen3_render_mixed_blits
[275.168988] [089/142] (721s left) kms_addfb_basic (addfb25-y-tiled-small-legacy)
[275.266909] Starting subtest: addfb25-y-tiled-small-legacy
[275.267628] Subtest addfb25-y-tiled-small-legacy: SUCCESS (0.000s)
[275.366228] [090/142] (720s left) gem_softpin (allocator-basic)
[275.421719] Starting subtest: allocator-basic
[275.475391] Subtest allocator-basic: SUCCESS (0.054s)
[275.597599] [091/142] (720s left) kms_ccs (pipe-d-crc-primary-basic-y_tiled_gen12_mc_ccs)
[275.838613] Subtest pipe-D-crc-primary-basic-y_tiled_gen12_mc_ccs: SKIP (0.000s)
[275.931236] [092/142] (720s left) kms_ccs (pipe-a-bad-rotation-90-y_tiled_ccs)
[276.060892] Starting subtest: pipe-A-bad-rotation-90-y_tiled_ccs
[276.062265] Subtest pipe-A-bad-rotation-90-y_tiled_ccs: SKIP (0.000s)
[276.253905] [093/142] (720s left) i915_pm_backlight (fade-with-dpms)
[276.342930] Subtest fade-with-dpms: SKIP (0.000s)
[276.363022] [094/142] (719s left) gen9_exec_parse (bb-start-param)
[276.408161] Subtest bb-start-param: SKIP (0.000s)
[276.438802] [095/142] (719s left) kms_frontbuffer_tracking (fbc-1p-offscren-pri-shrfb-draw-mmap-wc)
[276.530609] Starting subtest: fbc-1p-offscren-pri-shrfb-draw-mmap-wc
[278.897583] Subtest fbc-1p-offscren-pri-shrfb-draw-mmap-wc: SUCCESS (2.369s)
[279.023893] [096/142] (717s left) gem_exec_whisper (basic-queues-forked)
[279.075329] Starting subtest: basic-queues-forked
[283.762307] Subtest basic-queues-forked: SUCCESS (4.687s)
[283.947869] [097/142] (712s left) gem_exec_schedule (smoketest-all)
[284.010283] Starting subtest: smoketest-all
[316.281110] Subtest smoketest-all: SUCCESS (32.262s)
[316.581697] [098/142] (679s left) kms_vblank (pipe-b-wait-forked)
[316.671425] Starting subtest: pipe-B-wait-forked
[319.519732] Subtest pipe-B-wait-forked: SUCCESS (2.848s)
[319.636226] [099/142] (676s left) gem_exec_balancer (fairslice)
[319.685327] Starting subtest: fairslice
[320.477175] Subtest fairslice: SUCCESS (0.792s)
[321.441873] [100/142] (674s left) gem_lmem_swapping (heavy-random)
[321.492011] Subtest heavy-random: SKIP (0.000s)
[321.508962] [101/142] (674s left) kms_cursor_crc (cursor-offscreen-32x32)
[321.598738] Starting subtest: cursor-offscreen-32x32
[321.625548] Subtest cursor-offscreen-32x32: SKIP (0.026s)
[321.722974] [102/142] (674s left) kms_ccs (pipe-c-crc-primary-rotation-180-y_tiled_gen12_rc_ccs)
[321.951328] Subtest pipe-C-crc-primary-rotation-180-y_tiled_gen12_rc_ccs: SKIP (0.000s)
[322.044081] [103/142] (674s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-blt)
[322.135022] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-blt
[322.136329] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[322.214716] [104/142] (674s left) gem_pxp (reject-modify-context-protection-off-3)
[324.765766] Subtest reject-modify-context-protection-off-3: SKIP (0.000s)
[324.838362] [105/142] (671s left) gem_exec_fence (keep-in-fence)
[325.011311] Starting subtest: keep-in-fence
[325.012529] Starting dynamic subtest: rcs0
[325.052342] Dynamic subtest rcs0: SUCCESS (0.040s)
[325.070403] Starting dynamic subtest: bcs0
[325.087262] Dynamic subtest bcs0: SUCCESS (0.033s)
[325.103197] Starting dynamic subtest: vcs0
[325.118352] Dynamic subtest vcs0: SUCCESS (0.029s)
[325.133869] Starting dynamic subtest: vecs0
[325.149824] Dynamic subtest vecs0: SUCCESS (0.030s)
[325.150519] Subtest keep-in-fence: SUCCESS (0.140s)
[325.596753] [106/142] (670s left) gem_vm_create (invalid-create)
[325.648660] Starting subtest: invalid-create
[325.649369] Subtest invalid-create: SUCCESS (0.000s)
[325.731596] [107/142] (670s left) gem_madvise (dontneed-before-pwrite)
[325.778187] Starting subtest: dontneed-before-pwrite
[325.780227] Subtest dontneed-before-pwrite: SKIP (0.001s)
[325.818358] [108/142] (670s left) gem_exec_fence (syncobj-unused-fence)
[326.139910] Starting subtest: syncobj-unused-fence
[326.141639] Subtest syncobj-unused-fence: SUCCESS (0.002s)
[326.450333] [109/142] (670s left) drm_fdinfo (all-busy-idle-check-all)
[326.504694] Starting subtest: all-busy-idle-check-all
[327.128435] Subtest all-busy-idle-check-all: SUCCESS (0.623s)
[327.208317] [110/142] (669s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-mmap-wc)
[327.302504] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-mmap-wc
[327.304018] Subtest fbc-2p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[327.397069] [111/142] (669s left) syncobj_timeline (single-wait-all-for-submit-available-signaled)
[327.444495] Starting subtest: single-wait-all-for-submit-available-signaled
[327.445244] Subtest single-wait-all-for-submit-available-signaled: SUCCESS (0.000s)
[327.511718] [112/142] (669s left) kms_sequence (queue-busy)
[327.603568] Starting subtest: queue-busy
[327.604316] Starting dynamic subtest: HDMI-A-1-pipe-A
[330.519923] Dynamic subtest HDMI-A-1-pipe-A: SUCCESS (2.916s)
[330.526462] Starting dynamic subtest: HDMI-A-1-pipe-B
[333.444021] Dynamic subtest HDMI-A-1-pipe-B: SUCCESS (2.923s)
[333.444716] Subtest queue-busy: SUCCESS (5.842s)
[333.538212] [113/142] (663s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu)
[333.633027] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu
[333.634354] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[333.737958] [114/142] (662s left) kms_atomic_interruptible (legacy-setmode)
[333.837737] Starting subtest: legacy-setmode
[333.838428] Starting dynamic subtest: HDMI-A-1-pipe-A
[340.022893] Dynamic subtest HDMI-A-1-pipe-A: SUCCESS (6.185s)
[340.023580] Subtest legacy-setmode: SUCCESS (6.186s)
[340.149912] [115/142] (656s left) kms_chamelium_edid (dp-mode-timings)
[340.279868] Subtest dp-mode-timings: SKIP (0.000s)
[340.336351] [116/142] (656s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip)
[340.428760] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip
[340.430113] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SKIP (0.000s)
[340.510366] [117/142] (656s left) kms_psr2_su (page_flip-nv12)
[340.557881] Subtest page_flip-NV12: SKIP (0.000s)
[340.581521] [118/142] (656s left) prime_vgem (basic-fence-read)
[340.652978] Starting subtest: basic-fence-read
[340.657265] Subtest basic-fence-read: SKIP (0.004s)
[340.768064] [119/142] (655s left) gem_exec_reloc (basic-cpu-read)
[340.816362] Subtest basic-cpu-read: SKIP (0.000s)
[340.867641] [120/142] (655s left) kms_vblank (pipe-d-ts-continuation-modeset)
[340.968104] Subtest pipe-D-ts-continuation-modeset: SKIP (0.000s)
[341.023350] [121/142] (655s left) kms_vblank (pipe-c-wait-forked-busy-hang)
[341.112517] Subtest pipe-C-wait-forked-busy-hang: SKIP (0.000s)
[341.174371] [122/142] (655s left) kms_async_flips (test-time-stamp)
[341.263338] Starting subtest: test-time-stamp
[341.882810] Starting dynamic subtest: pipe-A-HDMI-A-1
[342.050907] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.168s)
[342.681354] Starting dynamic subtest: pipe-B-HDMI-A-1
[342.755544] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.079s)
[342.756268] Subtest test-time-stamp: SUCCESS (1.492s)
[343.265056] [123/142] (653s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-mmap-gtt)
[343.360988] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-mmap-gtt
[343.362344] Subtest psr-1p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[343.435901] [124/142] (653s left) kms_ccs (pipe-c-random-ccs-data-4_tiled_mtl_mc_ccs)
[343.665511] Subtest pipe-C-random-ccs-data-4_tiled_mtl_mc_ccs: SKIP (0.000s)
[343.759303] [125/142] (652s left) gem_mmap_gtt (cpuset-basic-small-copy)
[343.802336] Starting subtest: cpuset-basic-small-copy
[347.742344] Subtest cpuset-basic-small-copy: SUCCESS (3.940s)
[347.804095] [126/142] (648s left) perf_pmu (enable-race)
[347.891106] Starting subtest: enable-race
[347.891811] Starting dynamic subtest: rcs0
[360.461895] Dynamic subtest rcs0: SUCCESS (12.571s)
[360.467537] Starting dynamic subtest: bcs0
[373.045743] Dynamic subtest bcs0: SUCCESS (12.583s)
[373.051367] Starting dynamic subtest: vcs0
[385.628787] Dynamic subtest vcs0: SUCCESS (12.582s)
[385.634371] Starting dynamic subtest: vecs0
[398.203746] Dynamic subtest vecs0: SUCCESS (12.574s)
[398.204442] Subtest enable-race: SUCCESS (50.313s)
[398.275638] [127/142] (598s left) prime_mmap (test_aperture_limit)
[398.329028] Starting subtest: test_aperture_limit
[398.329718] Starting dynamic subtest: test_aperture_limit-smem
[398.335294] Dynamic subtest test_aperture_limit-smem: SUCCESS (0.007s)
[398.335998] Subtest test_aperture_limit: SUCCESS (0.007s)
[398.432282] [128/142] (598s left) gem_ctx_isolation (preservation-reset)
[398.598440] Starting subtest: preservation-reset
[398.599689] Starting dynamic subtest: rcs0
[398.672498] Dynamic subtest rcs0: SUCCESS (0.074s)
[398.678205] Starting dynamic subtest: bcs0
[398.766043] Dynamic subtest bcs0: SUCCESS (0.093s)
[398.771728] Starting dynamic subtest: vcs0
[398.868204] Dynamic subtest vcs0: SUCCESS (0.102s)
[398.873936] Starting dynamic subtest: vecs0
[398.976452] Dynamic subtest vecs0: SUCCESS (0.108s)
[398.977208] Subtest preservation-reset: SUCCESS (0.379s)
[399.074965] [129/142] (597s left) gem_mmap_gtt (basic-write)
[399.124888] Starting subtest: basic-write
[399.332779] Subtest basic-write: SUCCESS (0.208s)
[399.412428] [130/142] (597s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-mmap-wc)
[399.520790] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-mmap-wc
[399.522219] Subtest fbc-2p-scndscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[399.627565] [131/142] (597s left) gem_sync (basic-all)
[399.680273] Starting subtest: basic-all
[401.756857] Subtest basic-all: SUCCESS (2.077s)
[401.942218] [132/142] (594s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling)
[402.042836] Starting subtest: flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling
[402.043601] Starting dynamic subtest: pipe-A-valid-mode
[402.657665] Dynamic subtest pipe-A-valid-mode: SUCCESS (0.615s)
[402.658381] Subtest flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling: SUCCESS (0.616s)
[402.774504] [133/142] (594s left) i915_pm_rpm (legacy-planes-dpms)
[404.230147] Starting subtest: legacy-planes-dpms
[404.231555] Starting dynamic subtest: plane-40
[406.573392] Dynamic subtest plane-40: SUCCESS (2.343s)
[406.581567] Starting dynamic subtest: plane-49
[408.686531] Dynamic subtest plane-49: SUCCESS (2.112s)
[408.695830] Starting dynamic subtest: plane-58
[410.614402] Dynamic subtest plane-58: SUCCESS (1.927s)
[410.622760] Starting dynamic subtest: plane-67
[413.759970] Dynamic subtest plane-67: SUCCESS (3.144s)
[413.760996] Subtest legacy-planes-dpms: SUCCESS (9.531s)
[413.972707] [134/142] (582s left) kms_chamelium_hpd (vga-hpd-without-ddc)
[414.102612] Subtest vga-hpd-without-ddc: SKIP (0.000s)
[414.159350] [135/142] (582s left) gem_mmap_gtt (pf-nonblock)
[414.201982] Starting subtest: pf-nonblock
[414.204348] Subtest pf-nonblock: SUCCESS (0.002s)
[414.295152] [136/142] (582s left) kms_properties (crtc-properties-atomic)
[414.387096] Starting subtest: crtc-properties-atomic
[414.578740] Subtest crtc-properties-atomic: SUCCESS (0.193s)
[414.699840] [137/142] (582s left) gem_userptr_blits (userfault)
[414.753110] Starting subtest: userfault
[414.753801] Subtest userfault: SUCCESS (0.002s)
[414.875180] [138/142] (582s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-pwrite)
[414.976573] Starting subtest: psr-2p-primscrn-cur-indfb-draw-pwrite
[414.977956] Subtest psr-2p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[415.063516] [139/142] (581s left) gem_ctx_param (invalid-param-set)
[415.117879] Starting subtest: invalid-param-set
[415.118581] Subtest invalid-param-set: SUCCESS (0.000s)
[415.180659] [140/142] (581s left) kms_plane_alpha_blend (constant-alpha-mid)
[415.279470] Starting subtest: constant-alpha-mid
[415.334909] Starting dynamic subtest: pipe-A-HDMI-A-1
[416.080861] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.745s)
[416.086535] Starting dynamic subtest: pipe-B-HDMI-A-1
[416.815723] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.734s)
[416.816425] Subtest constant-alpha-mid: SUCCESS (1.538s)
[416.944302] [141/142] (580s left) kms_color (deep-color)
[417.038212] Starting subtest: deep-color
[417.040946] Subtest deep-color: SKIP (0.001s)
[417.094058] [142/142] (579s left) kms_plane_scaling (plane-downscale-with-rotation-factor-0-5)
[417.183736] Starting subtest: plane-downscale-with-rotation-factor-0-5
[417.184610] Starting dynamic subtest: pipe-A-HDMI-A-1
[417.311010] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.126s)
[417.316837] Starting dynamic subtest: pipe-B-HDMI-A-1
[417.402235] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.090s)
[417.403746] Subtest plane-downscale-with-rotation-factor-0-5: SKIP (0.218s)
[417.533618] Closing watchdogs
Done.