[39.896158] Initializing watchdogs
[39.896462]   /dev/watchdog0
[39.912428] [001/137] (960s left) api_intel_bb (simple-bb)
[40.115463] Starting subtest: simple-bb
[40.138169] Subtest simple-bb: SUCCESS (0.023s)
[40.246629] [002/137] (960s left) kms_chamelium_hpd (vga-hpd-after-suspend)
[40.636206] Subtest vga-hpd-after-suspend: SKIP (0.000s)
[40.930085] [003/137] (959s left) kms_lease (lease_again)
[41.204416] Starting subtest: lease_again
[41.206154] Starting dynamic subtest: pipe-A-DP-1
[41.217993] Dynamic subtest pipe-A-DP-1: SUCCESS (0.006s)
[41.231862] Starting dynamic subtest: pipe-B-DP-1
[41.233639] Dynamic subtest pipe-B-DP-1: SUCCESS (0.004s)
[41.246326] Starting dynamic subtest: pipe-C-DP-1
[41.247591] Dynamic subtest pipe-C-DP-1: SUCCESS (0.003s)
[41.248902] Subtest lease_again: SUCCESS (0.018s)
[41.319345] [004/137] (959s left) kms_atomic_transition (modeset-transition-fencing)
[41.594748] Starting subtest: modeset-transition-fencing
[41.596249] Starting dynamic subtest: 1x-outputs
[46.599987] Dynamic subtest 1x-outputs: SUCCESS (5.009s)
[46.685524] Subtest modeset-transition-fencing: SUCCESS (5.093s)
[47.001899] [005/137] (953s left) gem_mmap_gtt (cpuset-big-copy-odd)
[47.179212] Starting subtest: cpuset-big-copy-odd
[70.983945] Subtest cpuset-big-copy-odd: SUCCESS (23.804s)
[71.421812] [006/137] (929s left) kms_cursor_legacy (nonblocking-modeset-vs-cursor-atomic)
[71.822885] Starting subtest: nonblocking-modeset-vs-cursor-atomic
[72.621587] Subtest nonblocking-modeset-vs-cursor-atomic: SUCCESS (0.800s)
[72.956901] [007/137] (927s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-shrfb-msflip-blt)
[73.242191] Starting subtest: fbc-2p-scndscrn-shrfb-msflip-blt
[73.244601] Subtest fbc-2p-scndscrn-shrfb-msflip-blt: SKIP (0.000s)
[73.337162] [008/137] (927s left) gem_exec_schedule (preempt-other-chain)
[73.569370] Starting subtest: preempt-other-chain
[73.570899] Starting dynamic subtest: rcs0
[73.679899] Dynamic subtest rcs0: SUCCESS (0.111s)
[73.707221] Starting dynamic subtest: bcs0
[73.786197] Dynamic subtest bcs0: SUCCESS (0.106s)
[73.810413] Starting dynamic subtest: vcs0
[73.894697] Dynamic subtest vcs0: SUCCESS (0.108s)
[73.914200] Starting dynamic subtest: vecs0
[73.998306] Dynamic subtest vecs0: SUCCESS (0.103s)
[73.999764] Subtest preempt-other-chain: SUCCESS (0.430s)
[74.337956] [009/137] (926s left) kms_busy (extended-modeset-hang-oldfb)
[74.631727] Starting subtest: extended-modeset-hang-oldfb
[74.635635] Starting dynamic subtest: pipe-A
[76.326576] Dynamic subtest pipe-A: SUCCESS (1.689s)
[76.343731] Starting dynamic subtest: pipe-C
[78.366191] Dynamic subtest pipe-C: SUCCESS (2.037s)
[78.368189] Subtest extended-modeset-hang-oldfb: SUCCESS (3.735s)
[78.711223] [010/137] (921s left) kms_flip (2x-flip-vs-dpms)
[78.973932] Starting subtest: 2x-flip-vs-dpms
[78.976391] Subtest 2x-flip-vs-dpms: SKIP (0.003s)
[79.075113] [011/137] (921s left) kms_scaling_modes (scaling-mode-full-aspect)
[79.347189] Starting subtest: scaling-mode-full-aspect
[79.349782] Subtest scaling-mode-full-aspect: SKIP (0.001s)
[79.427073] [012/137] (921s left) kms_cursor_legacy (2x-long-flip-vs-cursor-atomic)
[79.695912] Starting subtest: 2x-long-flip-vs-cursor-atomic
[79.702136] Subtest 2x-long-flip-vs-cursor-atomic: SKIP (0.004s)
[79.774876] [013/137] (921s left) kms_frontbuffer_tracking (fbc-tiling-linear)
[80.056660] Starting subtest: fbc-tiling-linear
[81.991349] Subtest fbc-tiling-linear: SUCCESS (1.937s)
[82.124952] [014/137] (918s left) kms_big_fb (linear-max-hw-stride-64bpp-rotate-0)
[82.426746] Starting subtest: linear-max-hw-stride-64bpp-rotate-0
[83.924699] Subtest linear-max-hw-stride-64bpp-rotate-0: SUCCESS (1.498s)
[84.060480] [015/137] (916s left) kms_universal_plane (cursor-fb-leak-pipe-c)
[84.345159] Starting subtest: cursor-fb-leak-pipe-C
[84.986433] Subtest cursor-fb-leak-pipe-C: SUCCESS (0.641s)
[85.312455] [016/137] (915s left) vc4/vc4_label_bo (set-bad-name)
[85.547158] Subtest set-bad-name: SKIP (0.000s)
[85.612246] [017/137] (915s left) gem_userptr_blits (sync-unmap-after-close)
[85.817822] Starting subtest: sync-unmap-after-close
[85.851627] Subtest sync-unmap-after-close: SUCCESS (0.033s)
[85.980047] [018/137] (914s left) kms_flip (absolute-wf_vblank)
[86.241574] Starting subtest: absolute-wf_vblank
[86.243151] Starting dynamic subtest: A-DP1
[96.767689] Dynamic subtest A-DP1: SUCCESS (10.526s)
[96.784723] Starting dynamic subtest: B-DP1
[107.208544] Dynamic subtest B-DP1: SUCCESS (10.440s)
[107.224989] Starting dynamic subtest: C-DP1
[117.670347] Dynamic subtest C-DP1: SUCCESS (10.459s)
[117.671647] Subtest absolute-wf_vblank: SUCCESS (31.432s)
[118.058768] [019/137] (882s left) kms_vblank (pipe-a-query-forked)
[118.331158] Starting subtest: pipe-A-query-forked
[120.669502] Subtest pipe-A-query-forked: SUCCESS (2.340s)
[120.971121] [020/137] (880s left) gem_eio (hibernate)
[121.176706] Starting subtest: hibernate
[135.404498] Subtest hibernate: SUCCESS (14.227s)
[140.610919] [021/137] (865s left) perf (create-destroy-userspace-config)
[140.899238] Starting subtest: create-destroy-userspace-config
[140.980808] Subtest create-destroy-userspace-config: SUCCESS (0.084s)
[141.032452] [022/137] (865s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-render)
[141.313324] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-render
[143.480563] Subtest fbc-1p-primscrn-spr-indfb-draw-render: SUCCESS (2.171s)
[143.632157] [023/137] (862s left) gem_mmap_wc (read-write-distinct)
[143.802704] Starting subtest: read-write-distinct
[143.834125] Subtest read-write-distinct: SUCCESS (0.032s)
[143.929909] [024/137] (862s left) kms_frontbuffer_tracking (fbcpsr-1p-rte)
[144.203094] Starting subtest: fbcpsr-1p-rte
[144.205715] Subtest fbcpsr-1p-rte: SKIP (0.000s)
[144.300204] [025/137] (861s left) kms_plane_scaling (planes-upscale-20x20-downscale-factor-0-75)
[144.564390] Starting subtest: planes-upscale-20x20-downscale-factor-0-75
[144.565630] Starting dynamic subtest: pipe-A-DP-1
[144.748166] Dynamic subtest pipe-A-DP-1: SUCCESS (0.182s)
[144.766399] Starting dynamic subtest: pipe-B-DP-1
[145.134439] Dynamic subtest pipe-B-DP-1: SUCCESS (0.382s)
[145.153878] Starting dynamic subtest: pipe-C-DP-1
[145.259056] Dynamic subtest pipe-C-DP-1: SKIP (0.123s)
[145.262334] Subtest planes-upscale-20x20-downscale-factor-0-75: SUCCESS (0.695s)
[145.662131] [026/137] (860s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-pwrite)
[145.936495] Starting subtest: psr-2p-primscrn-spr-indfb-draw-pwrite
[145.939099] Subtest psr-2p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[146.025690] [027/137] (860s left) kms_force_connector_basic (force-connector-state)
[146.195489] Subtest force-connector-state: SKIP (0.000s)
[146.245186] [028/137] (860s left) kms_big_fb (4-tiled-addfb-size-overflow)
[146.528593] Starting subtest: 4-tiled-addfb-size-overflow
[146.531513] Subtest 4-tiled-addfb-size-overflow: SKIP (0.000s)
[146.625727] [029/137] (859s left) kms_ccs (pipe-c-crc-primary-rotation-180-4_tiled_dg2_rc_ccs_cc)
[147.087513] Starting subtest: pipe-C-crc-primary-rotation-180-4_tiled_dg2_rc_ccs_cc
[147.091534] Subtest pipe-C-crc-primary-rotation-180-4_tiled_dg2_rc_ccs_cc: SKIP (0.001s)
[147.429675] [030/137] (858s left) vgem_basic (debugfs)
[147.677493] Starting subtest: debugfs
[147.682310] Subtest debugfs: SUCCESS (0.005s)
[147.746539] [031/137] (858s left) gem_spin_batch (resubmit)
[147.937040] Starting subtest: resubmit
[147.938356] Starting dynamic subtest: rcs0
[147.945935] Dynamic subtest rcs0: SUCCESS (0.008s)
[147.972438] Starting dynamic subtest: bcs0
[147.973736] Dynamic subtest bcs0: SUCCESS (0.009s)
[147.991261] Starting dynamic subtest: vcs0
[147.992510] Dynamic subtest vcs0: SUCCESS (0.006s)
[148.010337] Starting dynamic subtest: vecs0
[148.011609] Dynamic subtest vecs0: SUCCESS (0.005s)
[148.012787] Subtest resubmit: SUCCESS (0.031s)
[148.179699] [032/137] (858s left) kms_cursor_legacy (cursora-vs-flipa-toggle)
[148.445525] Starting subtest: cursorA-vs-flipA-toggle
[159.458810] Subtest cursorA-vs-flipA-toggle: SUCCESS (11.014s)
[159.782253] [033/137] (846s left) kms_frontbuffer_tracking (fbc-indfb-scaledprimary)
[160.067433] Starting subtest: fbc-indfb-scaledprimary
[163.226519] Subtest fbc-indfb-scaledprimary: SUCCESS (3.161s)
[163.347852] [034/137] (843s left) kms_ccs (pipe-d-ccs-on-another-bo-yf_tiled_ccs)
[163.844451] Subtest pipe-D-ccs-on-another-bo-yf_tiled_ccs: SKIP (0.000s)
[164.152472] [035/137] (842s left) gem_pxp (hw-rejects-pxp-buffer)
[166.837157] Starting subtest: hw-rejects-pxp-buffer
[166.838525] Subtest hw-rejects-pxp-buffer: SUCCESS (0.000s)
[166.935500] [036/137] (839s left) kms_vblank (pipe-c-wait-busy-hang)
[167.203667] Starting subtest: pipe-C-wait-busy-hang
[174.538516] Subtest pipe-C-wait-busy-hang: SUCCESS (7.339s)
[174.874778] [037/137] (831s left) vc4/vc4_purgeable_bo (access-purgeable-bo-mem)
[175.105689] Subtest access-purgeable-bo-mem: SKIP (0.000s)
[175.174448] [038/137] (831s left) kms_vblank (pipe-b-ts-continuation-suspend)
[175.447990] Starting subtest: pipe-B-ts-continuation-suspend
[192.611804] Subtest pipe-B-ts-continuation-suspend: SUCCESS (2.075s)
[198.642986] [039/137] (828s left) gem_ctx_persistence (idempotent)
[198.826601] Starting subtest: idempotent
[198.827845] Subtest idempotent: SUCCESS (0.000s)
[198.913355] [040/137] (828s left) kms_vblank (pipe-b-accuracy-idle)
[199.181429] Starting subtest: pipe-B-accuracy-idle
[201.761539] Subtest pipe-B-accuracy-idle: SUCCESS (2.583s)
[202.098720] [041/137] (825s left) kms_hdr (bpc-switch)
[202.374823] Starting subtest: bpc-switch
[204.472473] Starting dynamic subtest: pipe-A-DP-1
[205.559835] Dynamic subtest pipe-A-DP-1: SUCCESS (1.087s)
[205.561347] Subtest bpc-switch: SUCCESS (3.189s)
[205.919698] [042/137] (821s left) gem_exec_fence (submit67)
[206.236937] Starting subtest: submit67
[206.238397] Starting dynamic subtest: rcs0
[208.577936] Dynamic subtest rcs0: SUCCESS (2.339s)
[208.602470] Starting dynamic subtest: bcs0
[209.786300] Dynamic subtest bcs0: SUCCESS (1.204s)
[209.812228] Starting dynamic subtest: vcs0
[210.844963] Dynamic subtest vcs0: SUCCESS (1.059s)
[210.870513] Starting dynamic subtest: vecs0
[211.975445] Dynamic subtest vecs0: SUCCESS (1.131s)
[211.976696] Subtest submit67: SUCCESS (5.738s)
[212.618162] [043/137] (814s left) gem_exec_schedule (timeslicing)
[212.811403] Starting subtest: timeslicing
[212.812727] Starting dynamic subtest: rcs0
[212.820183] Dynamic subtest rcs0: SUCCESS (0.008s)
[212.844666] Starting dynamic subtest: bcs0
[212.845896] Dynamic subtest bcs0: SUCCESS (0.008s)
[212.866020] Starting dynamic subtest: vcs0
[212.867415] Dynamic subtest vcs0: SUCCESS (0.007s)
[212.887538] Starting dynamic subtest: vecs0
[212.888907] Dynamic subtest vecs0: SUCCESS (0.006s)
[212.890209] Subtest timeslicing: SUCCESS (0.034s)
[213.186958] [044/137] (814s left) kms_addfb_basic (addfb25-bad-modifier)
[213.455660] Starting subtest: addfb25-bad-modifier
[213.456955] Subtest addfb25-bad-modifier: SUCCESS (0.001s)
[213.752009] [045/137] (813s left) gem_partial_pwrite_pread (reads-display)
[213.932281] Starting subtest: reads-display
[220.230931] Subtest reads-display: SUCCESS (6.299s)
[220.351671] [046/137] (807s left) prime_busy (hang)
[220.530802] Starting subtest: hang
[220.535173] Starting dynamic subtest: rcs0
[227.545121] Dynamic subtest rcs0: SUCCESS (7.009s)
[227.567244] Starting dynamic subtest: bcs0
[234.520511] Dynamic subtest bcs0: SUCCESS (6.974s)
[234.543340] Starting dynamic subtest: vcs0
[241.559837] Dynamic subtest vcs0: SUCCESS (7.039s)
[241.580601] Starting dynamic subtest: vecs0
[248.536096] Dynamic subtest vecs0: SUCCESS (6.975s)
[248.537323] Subtest hang: SUCCESS (28.003s)
[248.617775] [047/137] (779s left) kms_cursor_legacy (cursor-vs-flip-atomic-transitions-varying-size)
[248.883855] Starting subtest: cursor-vs-flip-atomic-transitions-varying-size
[289.359318] Subtest cursor-vs-flip-atomic-transitions-varying-size: SUCCESS (40.479s)
[289.702461] [048/137] (738s left) kms_big_fb (y-tiled-64bpp-rotate-180)
[289.996829] Starting subtest: y-tiled-64bpp-rotate-180
[297.527680] Subtest y-tiled-64bpp-rotate-180: SUCCESS (7.529s)
[298.467283] [049/137] (729s left) drm_fdinfo (virtual-busy)
[298.642616] Starting subtest: virtual-busy
[301.033565] Subtest virtual-busy: SUCCESS (2.390s)
[301.115621] [050/137] (726s left) syncobj_wait (signal)
[301.289267] Starting subtest: signal
[301.291050] Subtest signal: SUCCESS (0.001s)
[301.382834] [051/137] (726s left) kms_ccs (pipe-a-crc-primary-basic-4_tiled_dg2_rc_ccs)
[301.749010] Starting subtest: pipe-A-crc-primary-basic-4_tiled_dg2_rc_ccs
[301.751732] Subtest pipe-A-crc-primary-basic-4_tiled_dg2_rc_ccs: SKIP (0.001s)
[302.194247] [052/137] (725s left) gem_exec_balancer (semaphore)
[302.388088] Starting subtest: semaphore
[306.597962] Subtest semaphore: SUCCESS (4.210s)
[310.560629] [053/137] (717s left) gem_ctx_param (non-root-set)
[310.731306] Starting subtest: non-root-set
[310.755520] Subtest non-root-set: SUCCESS (0.026s)
[310.847193] [054/137] (717s left) kms_chamelium_edid (dp-edid-change-during-suspend)
[311.204342] Subtest dp-edid-change-during-suspend: SKIP (0.000s)
[311.477693] [055/137] (716s left) gem_exec_schedule (fairslice-all)
[311.670306] Starting subtest: fairslice-all
[313.779126] Subtest fairslice-all: SUCCESS (2.108s)
[314.135746] [056/137] (713s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-move)
[314.412368] Starting subtest: psr-2p-primscrn-cur-indfb-move
[314.414837] Subtest psr-2p-primscrn-cur-indfb-move: SKIP (0.000s)
[314.519734] [057/137] (713s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence)
[314.786302] Starting subtest: nonblocking-crc-frame-sequence
[314.787617] Starting dynamic subtest: pipe-A-DP-1
[315.393063] Dynamic subtest pipe-A-DP-1: SUCCESS (0.608s)
[315.418264] Starting dynamic subtest: pipe-B-DP-1
[316.198945] Dynamic subtest pipe-B-DP-1: SUCCESS (0.802s)
[316.222222] Starting dynamic subtest: pipe-C-DP-1
[316.971985] Dynamic subtest pipe-C-DP-1: SUCCESS (0.770s)
[316.973348] Subtest nonblocking-crc-frame-sequence: SUCCESS (2.190s)
[317.280759] [058/137] (710s left) vc4/vc4_wait_bo (unused-bo-0ns)
[317.510412] Subtest unused-bo-0ns: SKIP (0.000s)
[317.580865] [059/137] (710s left) syncobj_timeline (single-wait-available-submitted)
[317.754265] Starting subtest: single-wait-available-submitted
[317.756490] Subtest single-wait-available-submitted: SUCCESS (0.001s)
[317.847332] [060/137] (710s left) api_intel_allocator (fork-simple-once)
[318.018480] Starting subtest: fork-simple-once
[318.053398] Subtest fork-simple-once: SUCCESS (0.035s)
[318.164722] [061/137] (710s left) i915_getparams_basic (basic-eu-total)
[318.336208] Starting subtest: basic-eu-total
[318.338910] Subtest basic-eu-total: SUCCESS (0.000s)
[318.413730] [062/137] (709s left) kms_big_fb (y-tiled-addfb)
[318.699997] Starting subtest: y-tiled-addfb
[318.701900] Subtest y-tiled-addfb: SUCCESS (0.000s)
[318.814153] [063/137] (709s left) kms_plane_scaling (planes-unity-scaling-downscale-factor-0-75)
[319.086821] Starting subtest: planes-unity-scaling-downscale-factor-0-75
[319.088081] Starting dynamic subtest: pipe-A-DP-1
[319.290313] Dynamic subtest pipe-A-DP-1: SUCCESS (0.204s)
[319.314366] Starting dynamic subtest: pipe-B-DP-1
[319.715314] Dynamic subtest pipe-B-DP-1: SUCCESS (0.421s)
[319.742165] Starting dynamic subtest: pipe-C-DP-1
[320.141619] Dynamic subtest pipe-C-DP-1: SUCCESS (0.425s)
[320.143124] Subtest planes-unity-scaling-downscale-factor-0-75: SUCCESS (1.059s)
[320.534432] [064/137] (707s left) gem_softpin (evict-snoop-interruptible)
[320.713958] Starting subtest: evict-snoop-interruptible
[320.716851] Subtest evict-snoop-interruptible: SKIP (0.000s)
[320.798799] [065/137] (707s left) kms_cursor_crc (cursor-offscreen-64x64)
[321.073294] Starting subtest: cursor-offscreen-64x64
[321.084630] Starting dynamic subtest: pipe-A-DP-1
[323.558834] Dynamic subtest pipe-A-DP-1: SUCCESS (2.470s)
[323.639068] Starting dynamic subtest: pipe-B-DP-1
[326.176145] Dynamic subtest pipe-B-DP-1: SUCCESS (2.563s)
[326.255406] Starting dynamic subtest: pipe-C-DP-1
[328.798779] Dynamic subtest pipe-C-DP-1: SUCCESS (2.563s)
[328.800218] Subtest cursor-offscreen-64x64: SUCCESS (7.722s)
[329.158896] [066/137] (699s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-mmap-gtt)
[329.440154] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-mmap-gtt
[329.442952] Subtest fbc-2p-scndscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[329.538489] [067/137] (698s left) v3d/v3d_submit_cl (multiple-job-submission)
[329.766504] Subtest multiple-job-submission: SKIP (0.000s)
[329.838003] [068/137] (698s left) kms_cursor_crc (cursor-sliding-max-size)
[330.128360] Starting subtest: cursor-sliding-max-size
[330.132673] Subtest cursor-sliding-max-size: SKIP (0.000s)
[330.223488] [069/137] (698s left) kms_frontbuffer_tracking (fbc-2p-rte)
[330.495111] Starting subtest: fbc-2p-rte
[330.497706] Subtest fbc-2p-rte: SKIP (0.000s)
[330.588482] [070/137] (698s left) gem_vm_create (invalid-create)
[330.769155] Starting subtest: invalid-create
[330.770509] Subtest invalid-create: SUCCESS (0.001s)
[330.871358] [071/137] (697s left) syncobj_timeline (etime-multi-wait-all-for-submit-available-unsubmitted-signa
[331.044415] Starting subtest: etime-multi-wait-all-for-submit-available-unsubmitted-signaled
[331.148254] Subtest etime-multi-wait-all-for-submit-available-unsubmitted-signaled: SUCCESS (0.103s)
[331.238186] [072/137] (697s left) gem_render_copy (y-tiled-to-vebox-yf-tiled)
[331.426613] Starting subtest: y-tiled-to-vebox-yf-tiled
[331.429128] Subtest y-tiled-to-vebox-yf-tiled: SKIP (0.000s)
[331.620830] [073/137] (697s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-render)
[331.900618] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-render
[331.903218] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-render: SKIP (0.000s)
[332.005381] [074/137] (696s left) kms_dsc (dsc-basic)
[332.281270] Subtest dsc-basic: SKIP (0.000s)
[332.340911] [075/137] (696s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-gtt)
[332.617662] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-gtt
[332.620748] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[332.722609] [076/137] (696s left) gem_mmap (bad-object)
[332.896839] Starting subtest: bad-object
[332.898510] Subtest bad-object: SUCCESS (0.001s)
[333.005314] [077/137] (695s left) syncobj_timeline (invalid-query-bad-pad)
[333.178365] Starting subtest: invalid-query-bad-pad
[333.180115] Subtest invalid-query-bad-pad: SUCCESS (0.000s)
[333.274447] [078/137] (695s left) kms_psr2_sf (overlay-plane-update-sf-dmg-area)
[333.446781] Subtest overlay-plane-update-sf-dmg-area: SKIP (0.000s)
[333.506761] [079/137] (695s left) kms_vblank (pipe-d-wait-forked-busy-hang)
[333.771862] Subtest pipe-D-wait-forked-busy-hang: SKIP (0.000s)
[333.856727] [080/137] (695s left) kms_flip_scaled_crc (flip-32bpp-ytileccs-to-64bpp-ytile-upscaling)
[334.126816] Starting subtest: flip-32bpp-ytileccs-to-64bpp-ytile-upscaling
[334.128207] Starting dynamic subtest: pipe-A-valid-mode
[334.826665] Dynamic subtest pipe-A-valid-mode: SUCCESS (0.698s)
[334.827962] Subtest flip-32bpp-ytileccs-to-64bpp-ytile-upscaling: SUCCESS (0.701s)
[335.162708] [081/137] (693s left) kms_properties (crtc-properties-legacy)
[335.438854] Starting subtest: crtc-properties-legacy
[336.768803] Subtest crtc-properties-legacy: SUCCESS (1.333s)
[337.106190] [082/137] (691s left) gem_ctx_engines (execute-oneforall)
[337.299448] Starting subtest: execute-oneforall
[338.032842] Subtest execute-oneforall: SUCCESS (0.732s)
[338.256004] [083/137] (690s left) gem_lmem_swapping (parallel-random-engines)
[338.434544] Subtest parallel-random-engines: SKIP (0.000s)
[338.491163] [084/137] (690s left) i915_selftest (perf)
[340.010733] Starting subtest: perf
[340.012692] Starting dynamic subtest: engine_cs
[341.747248] Dynamic subtest engine_cs: SUCCESS (1.735s)
[341.762664] Starting dynamic subtest: request
[346.317110] Dynamic subtest request: SUCCESS (4.568s)
[346.332233] Starting dynamic subtest: migrate
[347.727522] Dynamic subtest migrate: SUCCESS (1.409s)
[347.746822] Starting dynamic subtest: region
[350.283148] Dynamic subtest region: SUCCESS (2.553s)
[350.284436] Subtest perf: SUCCESS (10.272s)
[350.316817] [085/137] (678s left) gem_ctx_param (invalid-param-set)
[351.824599] Starting subtest: invalid-param-set
[351.826174] Subtest invalid-param-set: SUCCESS (0.000s)
[351.889979] [086/137] (677s left) gem_userptr_blits (map-fixed-invalidate)
[352.238465] Starting subtest: map-fixed-invalidate
[352.239944] Starting dynamic subtest: gtt
[352.561440] Dynamic subtest gtt: SUCCESS (0.323s)
[352.582502] Starting dynamic subtest: wb
[352.790959] Dynamic subtest wb: SUCCESS (0.228s)
[352.811122] Starting dynamic subtest: wc
[353.015502] Dynamic subtest wc: SUCCESS (0.223s)
[353.035339] Starting dynamic subtest: uc
[353.239730] Dynamic subtest uc: SUCCESS (0.223s)
[353.241075] Subtest map-fixed-invalidate: SUCCESS (1.004s)
[353.359396] [087/137] (675s left) kms_psr (primary_page_flip)
[353.538544] Subtest primary_page_flip: SKIP (0.000s)
[353.594181] [088/137] (675s left) syncobj_timeline (multi-wait-for-submit-unsubmitted-submitted-signaled)
[353.766875] Starting subtest: multi-wait-for-submit-unsubmitted-submitted-signaled
[353.771590] Subtest multi-wait-for-submit-unsubmitted-submitted-signaled: SUCCESS (0.002s)
[353.858300] [089/137] (675s left) kms_content_protection (dp-mst-lic-type-0)
[354.176509] Starting subtest: dp-mst-lic-type-0
[354.179120] Subtest dp-mst-lic-type-0: SKIP (0.001s)
[354.292256] [090/137] (675s left) kms_ccs (pipe-d-crc-primary-rotation-180-4_tiled_dg2_rc_ccs_cc)
[354.790673] Subtest pipe-D-crc-primary-rotation-180-4_tiled_dg2_rc_ccs_cc: SKIP (0.000s)
[355.110177] [091/137] (674s left) kms_flip_scaled_crc (flip-64bpp-linear-to-32bpp-linear-upscaling)
[355.390532] Starting subtest: flip-64bpp-linear-to-32bpp-linear-upscaling
[355.391845] Starting dynamic subtest: pipe-A-valid-mode
[355.794485] Dynamic subtest pipe-A-valid-mode: SKIP (0.403s)
[355.797256] Subtest flip-64bpp-linear-to-32bpp-linear-upscaling: SKIP (0.406s)
[356.164809] [092/137] (673s left) fbdev (read)
[356.361654] Starting subtest: read
[357.768908] Subtest read: SUCCESS (1.406s)
[357.848511] [093/137] (671s left) kms_cursor_crc (cursor-onscreen-512x170)
[358.147630] Starting subtest: cursor-onscreen-512x170
[358.150412] Subtest cursor-onscreen-512x170: SKIP (0.002s)
[358.248362] [094/137] (671s left) api_intel_bb (blit-reloc-purge-cache)
[358.422464] Starting subtest: blit-reloc-purge-cache
[358.466958] Subtest blit-reloc-purge-cache: SUCCESS (0.047s)
[358.582418] [095/137] (670s left) perf_pmu (gt-awake)
[358.759366] Starting subtest: gt-awake
[361.321405] Subtest gt-awake: SUCCESS (2.562s)
[361.432865] [096/137] (668s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-mmap-wc)
[361.722157] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-mmap-wc
[361.725120] Subtest fbc-2p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[361.817009] [097/137] (667s left) perf (short-reads)
[362.079158] Starting subtest: short-reads
[362.143466] Subtest short-reads: SUCCESS (0.064s)
[362.198425] [098/137] (667s left) gem_exec_whisper (basic-fds-forked-all)
[362.395250] Starting subtest: basic-fds-forked-all
[386.209525] Subtest basic-fds-forked-all: SUCCESS (23.814s)
[386.400133] [099/137] (643s left) kms_frontbuffer_tracking (psr-1p-pri-indfb-multidraw)
[386.684739] Starting subtest: psr-1p-pri-indfb-multidraw
[386.687321] Subtest psr-1p-pri-indfb-multidraw: SKIP (0.000s)
[386.784512] [100/137] (642s left) kms_ccs (pipe-b-random-ccs-data-y_tiled_gen12_rc_ccs)
[387.208045] Starting subtest: pipe-B-random-ccs-data-y_tiled_gen12_rc_ccs
[387.211761] Subtest pipe-B-random-ccs-data-y_tiled_gen12_rc_ccs: SKIP (0.000s)
[387.592613] [101/137] (642s left) i915_pm_rpm (pm-caching)
[389.472179] Starting subtest: pm-caching
[391.089841] Subtest pm-caching: SUCCESS (1.618s)
[391.551594] [102/137] (638s left) syncobj_basic (bad-handle-to-fd)
[391.726226] Starting subtest: bad-handle-to-fd
[391.727782] Subtest bad-handle-to-fd: SUCCESS (0.000s)
[391.816525] [103/137] (638s left) kms_frontbuffer_tracking (psr-rgb101010-draw-mmap-gtt)
[392.090965] Starting subtest: psr-rgb101010-draw-mmap-gtt
[392.093459] Subtest psr-rgb101010-draw-mmap-gtt: SKIP (0.000s)
[392.200273] [104/137] (637s left) gem_ctx_shared (q-out-order)
[392.394830] Starting subtest: Q-out-order
[392.396662] Starting dynamic subtest: rcs0
[392.499321] Dynamic subtest rcs0: SUCCESS (0.102s)
[392.537497] Starting dynamic subtest: bcs0
[392.607140] Dynamic subtest bcs0: SUCCESS (0.105s)
[392.635505] Starting dynamic subtest: vcs0
[392.697329] Dynamic subtest vcs0: SUCCESS (0.089s)
[392.728058] Starting dynamic subtest: vecs0
[392.784403] Dynamic subtest vecs0: SUCCESS (0.085s)
[392.785871] Subtest Q-out-order: SUCCESS (0.389s)
[393.000659] [105/137] (636s left) kms_rotation_crc (bad-tiling)
[393.272634] Starting subtest: bad-tiling
[395.601899] Subtest bad-tiling: SUCCESS (2.332s)
[395.995977] [106/137] (634s left) kms_cursor_legacy (cursorb-vs-flipa-toggle)
[396.270194] Starting subtest: cursorB-vs-flipA-toggle
[396.273017] Subtest cursorB-vs-flipA-toggle: SKIP (0.004s)
[396.362786] [107/137] (633s left) kms_plane_multiple (tiling-x)
[396.632397] Starting subtest: tiling-x
[396.633734] Starting dynamic subtest: pipe-A-DP-1
[398.073309] Dynamic subtest pipe-A-DP-1: SUCCESS (1.442s)
[398.102016] Starting dynamic subtest: pipe-B-DP-1
[399.735393] Dynamic subtest pipe-B-DP-1: SUCCESS (1.660s)
[399.759439] Starting dynamic subtest: pipe-C-DP-1
[401.401752] Dynamic subtest pipe-C-DP-1: SUCCESS (1.662s)
[401.402949] Subtest tiling-x: SUCCESS (4.772s)
[401.744152] [108/137] (628s left) i915_pm_dc (dc5-dpms)
[403.022066] Starting subtest: dc5-dpms
[404.432356] Subtest dc5-dpms: SUCCESS (1.414s)
[404.637616] [109/137] (625s left) syncobj_timeline (wait-for-submit-snapshot)
[404.812047] Starting subtest: wait-for-submit-snapshot
[404.896007] Subtest wait-for-submit-snapshot: SUCCESS (0.083s)
[404.987387] [110/137] (625s left) i915_pm_rc6_residency (rc6-accuracy)
[405.326590] Starting subtest: rc6-accuracy
[408.329750] Subtest rc6-accuracy: SUCCESS (3.001s)
[408.420680] [111/137] (621s left) kms_ccs (pipe-b-missing-ccs-buffer-y_tiled_gen12_mc_ccs)
[408.863407] Starting subtest: pipe-B-missing-ccs-buffer-y_tiled_gen12_mc_ccs
[408.865980] Subtest pipe-B-missing-ccs-buffer-y_tiled_gen12_mc_ccs: SKIP (0.000s)
[409.245880] [112/137] (620s left) kms_ccs (pipe-b-bad-aux-stride-yf_tiled_ccs)
[409.682742] Starting subtest: pipe-B-bad-aux-stride-yf_tiled_ccs
[409.684245] Subtest pipe-B-bad-aux-stride-yf_tiled_ccs: SUCCESS (0.001s)
[410.068165] [113/137] (620s left) kms_big_fb (yf-tiled-32bpp-rotate-0)
[410.373886] Starting subtest: yf-tiled-32bpp-rotate-0
[415.625251] Subtest yf-tiled-32bpp-rotate-0: SUCCESS (5.251s)
[416.153007] [114/137] (614s left) kms_frontbuffer_tracking (psr-2p-scndscrn-shrfb-plflip-blt)
[416.435932] Starting subtest: psr-2p-scndscrn-shrfb-plflip-blt
[416.438675] Subtest psr-2p-scndscrn-shrfb-plflip-blt: SKIP (0.000s)
[416.569089] [115/137] (613s left) gem_exec_params (secure-non-root)
[416.752484] Starting subtest: secure-non-root
[416.755167] Subtest secure-non-root: SKIP (0.000s)
[416.900877] [116/137] (613s left) gem_fence_thrash (bo-write-verify-x)
[417.075237] Starting subtest: bo-write-verify-x
[418.199514] Subtest bo-write-verify-x: SUCCESS (1.125s)
[418.301336] [117/137] (612s left) gem_exec_reloc (basic-write-cpu-noreloc)
[418.483579] Starting subtest: basic-write-cpu-noreloc
[418.491960] Subtest basic-write-cpu-noreloc: SUCCESS (0.008s)
[418.685471] [118/137] (611s left) syncobj_timeline (etime-single-wait-all-submitted)
[418.859514] Starting subtest: etime-single-wait-all-submitted
[418.964312] Subtest etime-single-wait-all-submitted: SUCCESS (0.104s)
[419.051235] [119/137] (611s left) kms_frontbuffer_tracking (fbcpsr-1p-offscren-pri-shrfb-draw-pwrite)
[419.339541] Starting subtest: fbcpsr-1p-offscren-pri-shrfb-draw-pwrite
[419.342446] Subtest fbcpsr-1p-offscren-pri-shrfb-draw-pwrite: SKIP (0.000s)
[419.451890] [120/137] (611s left) gem_busy (busy)
[419.647413] Starting subtest: busy
[419.648921] Starting dynamic subtest: all-engines
[419.723078] Dynamic subtest all-engines: SUCCESS (0.073s)
[419.749178] Starting dynamic subtest: rcs0
[419.751133] Dynamic subtest rcs0: SUCCESS (0.019s)
[419.782884] Starting dynamic subtest: bcs0
[419.784206] Dynamic subtest bcs0: SUCCESS (0.012s)
[419.809056] Starting dynamic subtest: vcs0
[419.810452] Dynamic subtest vcs0: SUCCESS (0.013s)
[419.832464] Starting dynamic subtest: vecs0
[419.833732] Dynamic subtest vecs0: SUCCESS (0.018s)
[419.834914] Subtest busy: SUCCESS (0.143s)
[420.153332] [121/137] (610s left) gem_render_copy (x-tiled-to-vebox-y-tiled)
[420.337244] Starting subtest: x-tiled-to-vebox-y-tiled
[420.339773] Subtest x-tiled-to-vebox-y-tiled: SKIP (0.000s)
[420.535356] [122/137] (610s left) syncobj_wait (multi-wait-for-submit-submitted)
[420.706951] Starting subtest: multi-wait-for-submit-submitted
[420.812195] Subtest multi-wait-for-submit-submitted: SUCCESS (0.105s)
[420.901340] [123/137] (609s left) v3d/v3d_submit_cl (bad-flag)
[421.127608] Subtest bad-flag: SKIP (0.000s)
[421.201581] [124/137] (609s left) gem_linear_blits (interruptible)
[422.439435] Starting subtest: interruptible
[438.837817] Subtest interruptible: SUCCESS (16.399s)
[439.001697] [125/137] (591s left) gem_userptr_blits (stress-mm)
[439.330102] Starting subtest: stress-mm
[444.700628] Subtest stress-mm: SUCCESS (5.370s)
[444.835826] [126/137] (585s left) kms_ccs (pipe-d-random-ccs-data-y_tiled_ccs)
[445.327545] Subtest pipe-D-random-ccs-data-y_tiled_ccs: SKIP (0.000s)
[445.645624] [127/137] (585s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-mmap-gtt)
[445.929540] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-mmap-gtt
[445.932959] Subtest psr-1p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[446.028904] [128/137] (584s left) gem_exec_balancer (busy)
[446.217152] Starting subtest: busy
[448.118729] Subtest busy: SUCCESS (1.901s)
[451.994522] [129/137] (578s left) gem_exec_params (batch-first)
[452.170405] Starting subtest: batch-first
[452.183946] Subtest batch-first: SUCCESS (0.013s)
[452.296190] [130/137] (578s left) kms_ccs (pipe-b-bad-rotation-90-y_tiled_gen12_rc_ccs)
[452.698756] Starting subtest: pipe-B-bad-rotation-90-y_tiled_gen12_rc_ccs
[452.701347] Subtest pipe-B-bad-rotation-90-y_tiled_gen12_rc_ccs: SKIP (0.000s)
[453.104538] [131/137] (577s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-fullscreen)
[453.384672] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-fullscreen
[453.387427] Subtest fbcpsr-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s)
[453.487633] [132/137] (577s left) kms_vblank (pipe-d-accuracy-idle)
[453.764423] Subtest pipe-D-accuracy-idle: SKIP (0.000s)
[453.854216] [133/137] (577s left) gem_exec_fair (basic-none)
[454.058790] Starting subtest: basic-none
[454.060294] Starting dynamic subtest: rcs0
[459.584904] Dynamic subtest rcs0: SUCCESS (5.524s)
[459.610464] Starting dynamic subtest: bcs0
[459.612943] Dynamic subtest bcs0: SKIP (0.008s)
[459.637947] Starting dynamic subtest: vcs0
[465.582647] Dynamic subtest vcs0: SUCCESS (5.986s)
[465.608159] Starting dynamic subtest: vecs0
[471.487702] Dynamic subtest vecs0: SUCCESS (5.903s)
[471.489285] Subtest basic-none: SUCCESS (17.428s)
[471.688486] [134/137] (559s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0)
[471.990231] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0
[473.662110] Subtest x-tiled-max-hw-stride-64bpp-rotate-0: SUCCESS (1.670s)
[473.837907] [135/137] (557s left) kms_atomic (crtc-invalid-params)
[474.226698] Starting subtest: crtc-invalid-params
[474.278386] Subtest crtc-invalid-params: SUCCESS (0.052s)
[474.700223] [136/137] (556s left) kms_ccs (pipe-d-bad-aux-stride-y_tiled_ccs)
[475.188623] Subtest pipe-D-bad-aux-stride-y_tiled_ccs: SKIP (0.000s)
[475.497480] [137/137] (555s left) gem_mmap_wc (pf-nonblock)
[475.669081] Starting subtest: pf-nonblock
[475.672385] Subtest pf-nonblock: SUCCESS (0.006s)
[475.776401] Closing watchdogs
Done.