[44.309845] Initializing watchdogs
[44.310270]   /dev/watchdog0
[44.327234] [001/142] (960s left) gem_ctx_persistence (heartbeat-hostile)
[44.582419] Starting subtest: heartbeat-hostile
[45.795968] Subtest heartbeat-hostile: SUCCESS (1.214s)
[45.883935] [002/142] (958s left) i915_pm_rpm (legacy-planes)
[47.945172] Starting subtest: legacy-planes
[47.947851] Starting dynamic subtest: plane-39
[50.239323] Dynamic subtest plane-39: SUCCESS (2.294s)
[50.253893] Starting dynamic subtest: plane-47
[52.774815] Dynamic subtest plane-47: SUCCESS (2.535s)
[52.777168] Subtest legacy-planes: SUCCESS (4.830s)
[53.245248] [003/142] (951s left) v3d/v3d_perfmon (destroy-valid-perfmon)
[53.509160] Subtest destroy-valid-perfmon: SKIP (0.000s)
[53.575325] [004/142] (951s left) kms_big_fb (x-tiled-16bpp-rotate-0)
[53.905739] Starting subtest: x-tiled-16bpp-rotate-0
[57.723685] Subtest x-tiled-16bpp-rotate-0: SUCCESS (3.817s)
[58.512576] [005/142] (946s left) kms_ccs (pipe-b-bad-pixel-format-4_tiled_dg2_mc_ccs)
[59.005651] Starting subtest: pipe-B-bad-pixel-format-4_tiled_dg2_mc_ccs
[59.010564] Subtest pipe-B-bad-pixel-format-4_tiled_dg2_mc_ccs: SKIP (0.000s)
[59.526726] [006/142] (945s left) gem_eio (in-flight-contexts-immediate)
[59.764328] Starting subtest: in-flight-contexts-immediate
[71.229783] Subtest in-flight-contexts-immediate: SUCCESS (11.466s)
[71.443632] [007/142] (933s left) kms_ccs (pipe-b-crc-primary-rotation-180-y_tiled_ccs)
[71.951229] Starting subtest: pipe-B-crc-primary-rotation-180-y_tiled_ccs
[72.615668] Subtest pipe-B-crc-primary-rotation-180-y_tiled_ccs: SUCCESS (0.666s)
[73.156121] [008/142] (931s left) kms_sequence (queue-idle)
[73.463342] Starting subtest: queue-idle
[73.464862] Starting dynamic subtest: DP-1-pipe-A
[75.763497] Dynamic subtest DP-1-pipe-A: SUCCESS (2.302s)
[75.780672] Starting dynamic subtest: DP-1-pipe-B
[78.335386] Dynamic subtest DP-1-pipe-B: SUCCESS (2.569s)
[78.350906] Starting dynamic subtest: DP-1-pipe-C
[81.043959] Dynamic subtest DP-1-pipe-C: SUCCESS (2.706s)
[81.045602] Subtest queue-idle: SUCCESS (7.583s)
[81.358594] [009/142] (923s left) kms_plane_scaling (plane-scaler-with-clipping-clamping-modifiers)
[81.666647] Starting subtest: plane-scaler-with-clipping-clamping-modifiers
[81.668088] Starting dynamic subtest: pipe-A-DP-1
[82.836498] Dynamic subtest pipe-A-DP-1: SUCCESS (1.172s)
[82.854216] Starting dynamic subtest: pipe-B-DP-1
[84.246876] Dynamic subtest pipe-B-DP-1: SUCCESS (1.408s)
[84.264664] Starting dynamic subtest: pipe-C-DP-1
[85.336037] Dynamic subtest pipe-C-DP-1: SUCCESS (1.086s)
[85.337448] Subtest plane-scaler-with-clipping-clamping-modifiers: SUCCESS (3.675s)
[85.744131] [010/142] (919s left) kms_psr2_sf (primary-plane-update-sf-dmg-area)
[85.951485] Subtest primary-plane-update-sf-dmg-area: SKIP (0.000s)
[86.009999] [011/142] (919s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-blt)
[86.318149] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-blt
[86.320926] Subtest psr-2p-scndscrn-pri-indfb-draw-blt: SKIP (0.000s)
[86.410928] [012/142] (918s left) gem_vm_create (execbuf)
[86.621411] Starting subtest: execbuf
[86.631700] Subtest execbuf: SUCCESS (0.009s)
[86.743847] [013/142] (918s left) kms_flip (2x-blocking-absolute-wf_vblank)
[87.034215] Starting subtest: 2x-blocking-absolute-wf_vblank
[87.036899] Subtest 2x-blocking-absolute-wf_vblank: SKIP (0.003s)
[87.144759] [014/142] (918s left) kms_addfb_basic (bad-pitch-999)
[87.348599] Starting subtest: bad-pitch-999
[87.350275] Subtest bad-pitch-999: SUCCESS (0.000s)
[87.545388] [015/142] (917s left) gem_ctx_sseu (mmap-args)
[87.755616] Subtest mmap-args: SKIP (0.000s)
[87.809280] [016/142] (917s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-render)
[88.115553] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-render
[88.118153] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-render: SKIP (0.000s)
[88.210448] [017/142] (917s left) vgem_basic (sysfs)
[88.492237] Starting subtest: sysfs
[88.495423] Subtest sysfs: SUCCESS (0.002s)
[88.560707] [018/142] (916s left) kms_plane_scaling (planes-upscale-20x20-downscale-factor-0-5)
[88.859913] Starting subtest: planes-upscale-20x20-downscale-factor-0-5
[88.866830] Starting dynamic subtest: pipe-A-DP-1
[89.188233] Dynamic subtest pipe-A-DP-1: SUCCESS (0.324s)
[89.204694] Starting dynamic subtest: pipe-B-DP-1
[89.561098] Dynamic subtest pipe-B-DP-1: SUCCESS (0.370s)
[89.580056] Starting dynamic subtest: pipe-C-DP-1
[89.683184] Dynamic subtest pipe-C-DP-1: SKIP (0.118s)
[89.684595] Subtest planes-upscale-20x20-downscale-factor-0-5: SUCCESS (0.822s)
[90.077920] [019/142] (915s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-move)
[90.389510] Starting subtest: psr-2p-primscrn-spr-indfb-move
[90.392230] Subtest psr-2p-primscrn-spr-indfb-move: SKIP (0.000s)
[90.496741] [020/142] (915s left) kms_big_fb (yf-tiled-32bpp-rotate-180)
[90.819614] Starting subtest: yf-tiled-32bpp-rotate-180
[95.906977] Subtest yf-tiled-32bpp-rotate-180: SUCCESS (5.088s)
[96.428465] [021/142] (909s left) kms_cursor_legacy (2x-flip-vs-cursor-atomic)
[96.733238] Starting subtest: 2x-flip-vs-cursor-atomic
[96.739057] Subtest 2x-flip-vs-cursor-atomic: SKIP (0.004s)
[96.829171] [022/142] (908s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-mmap-gtt)
[97.154030] Starting subtest: fbc-rgb101010-draw-mmap-gtt
[99.807796] Subtest fbc-rgb101010-draw-mmap-gtt: SUCCESS (2.655s)
[99.943960] [023/142] (905s left) gem_wait (invalid-buf)
[100.156270] Starting subtest: invalid-buf
[100.157910] Subtest invalid-buf: SUCCESS (0.000s)
[100.427353] [024/142] (905s left) kms_busy (basic)
[100.740077] Starting subtest: basic
[100.741548] Starting dynamic subtest: flip
[101.470719] Dynamic subtest flip: SUCCESS (0.732s)
[101.487174] Starting dynamic subtest: modeset
[103.003470] Dynamic subtest modeset: SUCCESS (1.532s)
[103.004983] Subtest basic: SUCCESS (2.268s)
[103.357688] [025/142] (902s left) kms_ccs (pipe-d-crc-primary-rotation-180-y_tiled_gen12_rc_ccs_cc)
[104.043611] Subtest pipe-D-crc-primary-rotation-180-y_tiled_gen12_rc_ccs_cc: SKIP (0.000s)
[104.358734] [026/142] (901s left) kms_plane_alpha_blend (coverage-vs-premult-vs-constant)
[104.661058] Starting subtest: coverage-vs-premult-vs-constant
[104.973827] Starting dynamic subtest: pipe-A-DP-1
[105.402045] Dynamic subtest pipe-A-DP-1: SUCCESS (0.427s)
[105.419491] Starting dynamic subtest: pipe-C-DP-1
[106.078767] Dynamic subtest pipe-C-DP-1: SUCCESS (0.672s)
[106.080468] Subtest coverage-vs-premult-vs-constant: SUCCESS (1.418s)
[106.443225] [027/142] (899s left) kms_frontbuffer_tracking (psr-slowdraw)
[106.760213] Starting subtest: psr-slowdraw
[106.762976] Subtest psr-slowdraw: SKIP (0.000s)
[106.860145] [028/142] (898s left) kms_getfb (getfb2-into-addfb2)
[107.062899] Starting subtest: getfb2-into-addfb2
[107.064666] Subtest getfb2-into-addfb2: SUCCESS (0.000s)
[107.159242] [029/142] (898s left) kms_frontbuffer_tracking (fbc-1p-offscren-pri-indfb-draw-render)
[107.474795] Starting subtest: fbc-1p-offscren-pri-indfb-draw-render
[109.373185] Subtest fbc-1p-offscren-pri-indfb-draw-render: SUCCESS (1.902s)
[109.493412] [030/142] (896s left) kms_prop_blob (invalid-set-prop)
[109.699582] Starting subtest: invalid-set-prop
[109.701116] Subtest invalid-set-prop: SUCCESS (0.000s)
[109.776898] [031/142] (896s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-pwrite)
[110.090368] Starting subtest: psr-2p-primscrn-pri-indfb-draw-pwrite
[110.093180] Subtest psr-2p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[110.193309] [032/142] (895s left) syncobj_timeline (invalid-single-wait-available-unsubmitted)
[110.400581] Starting subtest: invalid-single-wait-available-unsubmitted
[110.402590] Subtest invalid-single-wait-available-unsubmitted: SUCCESS (0.000s)
[110.493302] [033/142] (895s left) gem_render_copy (y-tiled-ccs-to-y-tiled-ccs)
[110.714203] Starting subtest: y-tiled-ccs-to-y-tiled-ccs
[110.719938] Starting dynamic subtest: smem
[111.031339] Dynamic subtest smem: SUCCESS (0.312s)
[111.032648] Subtest y-tiled-ccs-to-y-tiled-ccs: SUCCESS (0.316s)
[111.228233] [034/142] (894s left) kms_cursor_legacy (2x-long-flip-vs-cursor-atomic)
[111.526107] Starting subtest: 2x-long-flip-vs-cursor-atomic
[111.530711] Subtest 2x-long-flip-vs-cursor-atomic: SKIP (0.004s)
[111.609854] [035/142] (894s left) gem_userptr_blits (coherency-sync)
[111.857856] Starting subtest: coherency-sync
[113.217252] Subtest coherency-sync: SKIP (1.346s)
[113.376405] [036/142] (892s left) kms_color (deep-color)
[113.801155] Starting subtest: deep-color
[113.803922] Subtest deep-color: SKIP (0.000s)
[113.878339] [037/142] (892s left) prime_vgem (basic-fence-read)
[114.110794] Starting subtest: basic-fence-read
[114.216544] Subtest basic-fence-read: SUCCESS (0.106s)
[114.312610] [038/142] (891s left) kms_selftest (drm_format)
[114.508035] Starting subtest: drm_format
[114.524797] Subtest drm_format: SKIP (0.016s)
[114.594755] [039/142] (891s left) kms_cursor_legacy (forked-bo)
[114.897740] Starting subtest: forked-bo
[114.899160] Starting dynamic subtest: pipe-A
[120.392434] Dynamic subtest pipe-A: SUCCESS (5.496s)
[120.412090] Starting dynamic subtest: pipe-B
[125.883974] Dynamic subtest pipe-B: SUCCESS (5.488s)
[125.902165] Starting dynamic subtest: pipe-C
[131.396931] Dynamic subtest pipe-C: SUCCESS (5.510s)
[131.415183] Starting dynamic subtest: all-pipes
[136.919264] Dynamic subtest all-pipes: SUCCESS (5.491s)
[136.920693] Subtest forked-bo: SUCCESS (21.990s)
[136.979400] [040/142] (869s left) kms_frontbuffer_tracking (fbc-rgb565-draw-render)
[137.296423] Starting subtest: fbc-rgb565-draw-render
[139.522932] Subtest fbc-rgb565-draw-render: SUCCESS (2.228s)
[139.644184] [041/142] (866s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-render)
[139.952929] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-render
[139.955786] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-render: SKIP (0.000s)
[140.045362] [042/142] (866s left) kms_chamelium_hpd (common-hpd-after-suspend)
[140.440647] Subtest common-hpd-after-suspend: SKIP (0.000s)
[140.717597] [043/142] (865s left) gen9_exec_parse (bb-large)
[140.943674] Starting subtest: bb-large
[223.206435] Subtest bb-large: SUCCESS (82.261s)
[223.457702] [044/142] (782s left) gem_pxp (verify-pxp-execution-after-suspend-resume)
[226.304349] Subtest verify-pxp-execution-after-suspend-resume: SKIP (0.000s)
[226.380534] [045/142] (780s left) kms_ccs (pipe-c-crc-sprite-planes-basic-4_tiled_mtl_rc_ccs)
[227.053178] Starting subtest: pipe-C-crc-sprite-planes-basic-4_tiled_mtl_rc_ccs
[227.058555] Subtest pipe-C-crc-sprite-planes-basic-4_tiled_mtl_rc_ccs: SKIP (0.004s)
[227.388409] [046/142] (779s left) kms_ccs (pipe-a-random-ccs-data-yf_tiled_ccs)
[227.838045] Starting subtest: pipe-A-random-ccs-data-yf_tiled_ccs
[228.283188] Subtest pipe-A-random-ccs-data-yf_tiled_ccs: SUCCESS (0.444s)
[228.958439] [047/142] (777s left) kms_ccs (pipe-b-crc-primary-basic-y_tiled_ccs)
[229.466290] Starting subtest: pipe-B-crc-primary-basic-y_tiled_ccs
[230.374353] Subtest pipe-B-crc-primary-basic-y_tiled_ccs: SUCCESS (0.908s)
[230.981830] [048/142] (775s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-pwrite)
[231.299408] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-pwrite
[231.302120] Subtest psr-1p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[231.397540] [049/142] (775s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-mmap-wc)
[231.717654] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-mmap-wc
[231.720219] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[231.813511] [050/142] (774s left) gem_mmap_gtt (hang-busy)
[232.016338] Starting subtest: hang-busy
[247.210647] Subtest hang-busy: SUCCESS (15.192s)
[247.313585] [051/142] (759s left) kms_ccs (pipe-c-crc-primary-basic-y_tiled_gen12_rc_ccs_cc)
[247.905334] Starting subtest: pipe-C-crc-primary-basic-y_tiled_gen12_rc_ccs_cc
[247.907930] Subtest pipe-C-crc-primary-basic-y_tiled_gen12_rc_ccs_cc: SKIP (0.001s)
[248.299390] [052/142] (758s left) syncobj_timeline (etime-multi-wait-all-for-submit-submitted)
[248.515299] Starting subtest: etime-multi-wait-all-for-submit-submitted
[248.618604] Subtest etime-multi-wait-all-for-submit-submitted: SUCCESS (0.104s)
[248.698694] [053/142] (758s left) kms_ccs (pipe-a-crc-primary-basic-y_tiled_gen12_rc_ccs_cc)
[249.118112] Starting subtest: pipe-A-crc-primary-basic-y_tiled_gen12_rc_ccs_cc
[249.120911] Subtest pipe-A-crc-primary-basic-y_tiled_gen12_rc_ccs_cc: SKIP (0.001s)
[249.706423] [054/142] (757s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-indfb-pgflip-blt)
[250.018606] Starting subtest: fbcpsr-1p-primscrn-indfb-pgflip-blt
[250.021693] Subtest fbcpsr-1p-primscrn-indfb-pgflip-blt: SKIP (0.000s)
[250.120395] [055/142] (756s left) kms_addfb_basic (invalid-get-prop)
[250.324307] Starting subtest: invalid-get-prop
[250.325755] Subtest invalid-get-prop: SUCCESS (0.000s)
[250.520566] [056/142] (756s left) api_intel_bb (blit-noreloc-keep-cache)
[250.723929] Starting subtest: blit-noreloc-keep-cache
[250.741971] Subtest blit-noreloc-keep-cache: SUCCESS (0.018s)
[250.853180] [057/142] (756s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180-async-flip)
[251.178508] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180-async-flip
[251.181565] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SKIP (0.000s)
[251.286886] [058/142] (755s left) kms_flip_scaled_crc (flip-64bpp-linear-to-32bpp-linear-downscaling)
[251.587398] Starting subtest: flip-64bpp-linear-to-32bpp-linear-downscaling
[251.588675] Starting dynamic subtest: pipe-A-valid-mode
[252.292865] Dynamic subtest pipe-A-valid-mode: SUCCESS (0.705s)
[252.294662] Subtest flip-64bpp-linear-to-32bpp-linear-downscaling: SUCCESS (0.709s)
[252.636497] [059/142] (754s left) kms_frontbuffer_tracking (fbc-2p-rte)
[252.944840] Starting subtest: fbc-2p-rte
[252.947749] Subtest fbc-2p-rte: SKIP (0.000s)
[253.053289] [060/142] (753s left) gem_lmem_swapping (heavy-verify-random)
[253.265635] Subtest heavy-verify-random: SKIP (0.000s)
[253.318502] [061/142] (753s left) gem_exec_schedule (fifo)
[253.551045] Starting subtest: fifo
[253.552507] Starting dynamic subtest: rcs0
[253.688217] Dynamic subtest rcs0: SUCCESS (0.135s)
[253.712260] Starting dynamic subtest: bcs0
[253.832543] Dynamic subtest bcs0: SUCCESS (0.140s)
[253.856995] Starting dynamic subtest: vcs0
[253.961507] Dynamic subtest vcs0: SUCCESS (0.128s)
[253.985022] Starting dynamic subtest: vecs0
[254.086488] Dynamic subtest vecs0: SUCCESS (0.125s)
[254.088210] Subtest fifo: SUCCESS (0.536s)
[254.453147] [062/142] (752s left) prime_mmap (test_reprime)
[254.655638] Starting subtest: test_reprime
[254.656918] Starting dynamic subtest: test_reprime-smem
[254.662271] Dynamic subtest test_reprime-smem: SUCCESS (0.008s)
[254.663953] Subtest test_reprime: SUCCESS (0.010s)
[254.768999] [063/142] (752s left) gem_userptr_blits (process-exit-busy)
[255.010981] Starting subtest: process-exit-busy
[255.062811] Subtest process-exit-busy: SUCCESS (0.052s)
[255.203237] [064/142] (751s left) kms_flip (2x-nonexisting-fb)
[255.496604] Starting subtest: 2x-nonexisting-fb
[255.501780] Subtest 2x-nonexisting-fb: SKIP (0.003s)
[255.619644] [065/142] (751s left) perf_pmu (most-busy-check-all)
[255.835081] Starting subtest: most-busy-check-all
[255.836660] Starting dynamic subtest: rcs0
[256.364838] Dynamic subtest rcs0: SUCCESS (0.529s)
[256.389990] Starting dynamic subtest: bcs0
[256.888729] Dynamic subtest bcs0: SUCCESS (0.522s)
[256.915046] Starting dynamic subtest: vcs0
[257.415812] Dynamic subtest vcs0: SUCCESS (0.525s)
[257.444789] Starting dynamic subtest: vecs0
[257.942730] Dynamic subtest vecs0: SUCCESS (0.525s)
[257.945727] Subtest most-busy-check-all: SUCCESS (2.109s)
[258.036734] [066/142] (749s left) gem_ctx_param (get-priority-new-ctx)
[258.239493] Starting subtest: get-priority-new-ctx
[258.241167] Subtest get-priority-new-ctx: SUCCESS (0.000s)
[258.321997] [067/142] (748s left) gem_eio (reset-stress)
[258.548111] Starting subtest: reset-stress
[291.513023] Subtest reset-stress: SUCCESS (32.966s)
[291.706137] [068/142] (715s left) vc4/vc4_perfmon (create-perfmon-exceed)
[291.963289] Subtest create-perfmon-exceed: SKIP (0.000s)
[292.036490] [069/142] (715s left) kms_cursor_legacy (short-flip-after-cursor-atomic-transitions)
[292.338458] Starting subtest: short-flip-after-cursor-atomic-transitions
[293.480127] Subtest short-flip-after-cursor-atomic-transitions: SUCCESS (1.144s)
[293.824962] [070/142] (713s left) gem_exec_create (forked)
[294.054185] Starting subtest: forked
[294.056044] Starting dynamic subtest: smem
[314.159579] Dynamic subtest smem: SUCCESS (20.105s)
[314.161281] Subtest forked: SUCCESS (20.108s)
[314.372497] [071/142] (693s left) gem_exec_nop (basic-parallel)
[314.601109] Starting subtest: basic-parallel
[317.750148] Subtest basic-parallel: SUCCESS (3.151s)
[317.988825] [072/142] (689s left) core_setmaster (master-drop-set-shared-fd)
[319.985523] Starting subtest: master-drop-set-shared-fd
[320.030514] Subtest master-drop-set-shared-fd: SUCCESS (0.044s)
[320.071113] [073/142] (687s left) gem_exec_schedule (semaphore-codependency)
[320.307057] Starting subtest: semaphore-codependency
[320.329709] Subtest semaphore-codependency: SUCCESS (0.022s)
[320.689109] [074/142] (686s left) gem_userptr_blits (sync-overlap)
[320.928566] Starting subtest: sync-overlap
[320.929976] Subtest sync-overlap: SUCCESS (0.001s)
[321.073130] [075/142] (686s left) gen3_render_tiledx_blits
[321.340192] [076/142] (686s left) kms_ccs (pipe-d-crc-primary-basic-4_tiled_dg2_mc_ccs)
[322.018746] Subtest pipe-D-crc-primary-basic-4_tiled_dg2_mc_ccs: SKIP (0.000s)
[322.335910] [077/142] (685s left) syncobj_timeline (wait-all-for-submit-complex)
[322.541868] Starting subtest: wait-all-for-submit-complex
[322.757819] Subtest wait-all-for-submit-complex: SUCCESS (0.215s)
[322.852556] [078/142] (684s left) kms_big_fb (x-tiled-64bpp-rotate-0)
[323.177763] Starting subtest: x-tiled-64bpp-rotate-0
[330.560901] Subtest x-tiled-64bpp-rotate-0: SUCCESS (7.381s)
[331.485162] [079/142] (676s left) kms_pipe_crc_basic (hang-read-crc)
[331.787981] Starting subtest: hang-read-crc
[331.791933] Starting dynamic subtest: pipe-A-DP-1
[333.117795] Dynamic subtest pipe-A-DP-1: SUCCESS (1.325s)
[333.140692] Starting dynamic subtest: pipe-B-DP-1
[334.919416] Dynamic subtest pipe-B-DP-1: SUCCESS (1.796s)
[334.942238] Starting dynamic subtest: pipe-C-DP-1
[336.848351] Dynamic subtest pipe-C-DP-1: SUCCESS (1.926s)
[336.849824] Subtest hang-read-crc: SUCCESS (5.061s)
[337.162259] [080/142] (670s left) v3d/v3d_submit_cl (single-out-sync)
[337.420885] Subtest single-out-sync: SKIP (0.000s)
[337.495950] [081/142] (670s left) kms_atomic_interruptible (universal-setplane-primary)
[337.793942] Starting subtest: universal-setplane-primary
[337.797870] Starting dynamic subtest: DP-1-pipe-A
[344.334634] Dynamic subtest DP-1-pipe-A: SUCCESS (6.534s)
[344.335957] Subtest universal-setplane-primary: SUCCESS (6.539s)
[344.663273] [082/142] (663s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-onoff)
[344.977451] Starting subtest: fbc-1p-primscrn-spr-indfb-onoff
[347.568350] Subtest fbc-1p-primscrn-spr-indfb-onoff: SUCCESS (2.593s)
[347.711830] [083/142] (660s left) kms_chamelium_color (ctm-max)
[348.021587] Subtest ctm-max: SKIP (0.000s)
[348.077756] [084/142] (659s left) drm_fdinfo (virtual-busy-hang)
[348.284425] Starting subtest: virtual-busy-hang
[352.496042] Subtest virtual-busy-hang: SUCCESS (4.212s)
[352.579211] [085/142] (655s left) kms_addfb_basic (addfb25-yf-tiled-legacy)
[352.884960] Starting subtest: addfb25-yf-tiled-legacy
[352.886405] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.000s)
[352.995513] [086/142] (655s left) gem_exec_schedule (pi-common)
[353.359071] Starting subtest: pi-common
[353.360558] Starting dynamic subtest: rcs0
[353.468231] Dynamic subtest rcs0: SUCCESS (0.108s)
[353.494046] Starting dynamic subtest: bcs0
[353.559584] Dynamic subtest bcs0: SUCCESS (0.089s)
[353.584893] Starting dynamic subtest: vcs0
[353.650695] Dynamic subtest vcs0: SUCCESS (0.089s)
[353.677645] Starting dynamic subtest: vecs0
[353.742382] Dynamic subtest vecs0: SUCCESS (0.089s)
[353.743919] Subtest pi-common: SUCCESS (0.385s)
[353.969355] [087/142] (654s left) gem_ctx_engines (execute-oneforall)
[354.195398] Starting subtest: execute-oneforall
[354.894167] Subtest execute-oneforall: SUCCESS (0.699s)
[355.111803] [088/142] (653s left) kms_ccs (pipe-b-missing-ccs-buffer-yf_tiled_ccs)
[355.651190] Starting subtest: pipe-B-missing-ccs-buffer-yf_tiled_ccs
[355.652618] Subtest pipe-B-missing-ccs-buffer-yf_tiled_ccs: SUCCESS (0.001s)
[356.131298] [089/142] (652s left) syncobj_timeline (multi-wait-submitted-signaled)
[356.335354] Starting subtest: multi-wait-submitted-signaled
[356.339938] Subtest multi-wait-submitted-signaled: SUCCESS (0.002s)
[356.431582] [090/142] (651s left) kms_big_fb (y-tiled-16bpp-rotate-90)
[356.750938] Starting subtest: y-tiled-16bpp-rotate-90
[356.829563] Subtest y-tiled-16bpp-rotate-90: SKIP (0.077s)
[356.948222] [091/142] (651s left) kms_invalid_mode (bad-vtotal)
[357.245908] Starting subtest: bad-vtotal
[357.247265] Starting dynamic subtest: DP-1-pipe-A
[357.344268] Dynamic subtest DP-1-pipe-A: SUCCESS (0.097s)
[357.367414] Starting dynamic subtest: DP-1-pipe-B
[357.368734] Dynamic subtest DP-1-pipe-B: SUCCESS (0.014s)
[357.389467] Starting dynamic subtest: DP-1-pipe-C
[357.390750] Dynamic subtest DP-1-pipe-C: SUCCESS (0.014s)
[357.391997] Subtest bad-vtotal: SUCCESS (0.138s)
[357.707676] [092/142] (650s left) syncobj_wait (multi-wait-for-submit-unsubmitted)
[357.912021] Starting subtest: multi-wait-for-submit-unsubmitted
[358.018904] Subtest multi-wait-for-submit-unsubmitted: SUCCESS (0.106s)
[358.105890] [093/142] (650s left) gem_close (basic)
[358.314331] Starting subtest: basic
[358.316105] Subtest basic: SUCCESS (0.000s)
[358.422703] [094/142] (649s left) v3d/v3d_submit_csd (valid-submission)
[358.681640] Subtest valid-submission: SKIP (0.000s)
[358.755775] [095/142] (649s left) perf_pmu (busy-idle-check-all)
[358.961505] Starting subtest: busy-idle-check-all
[358.963090] Starting dynamic subtest: rcs0
[359.591955] Dynamic subtest rcs0: SUCCESS (0.629s)
[359.615340] Starting dynamic subtest: bcs0
[360.225853] Dynamic subtest bcs0: SUCCESS (0.632s)
[360.249511] Starting dynamic subtest: vcs0
[360.856809] Dynamic subtest vcs0: SUCCESS (0.629s)
[360.881489] Starting dynamic subtest: vecs0
[361.491661] Dynamic subtest vecs0: SUCCESS (0.632s)
[361.493397] Subtest busy-idle-check-all: SUCCESS (2.532s)
[361.588612] [096/142] (646s left) kms_cursor_crc (cursor-rapid-movement-64x21)
[361.901215] Starting subtest: cursor-rapid-movement-64x21
[361.912159] Starting dynamic subtest: pipe-A-DP-1
[362.426970] Dynamic subtest pipe-A-DP-1: SUCCESS (0.516s)
[362.516160] Starting dynamic subtest: pipe-C-DP-1
[363.323865] Dynamic subtest pipe-C-DP-1: SUCCESS (0.827s)
[363.325246] Subtest cursor-rapid-movement-64x21: SUCCESS (1.425s)
[363.692597] [097/142] (644s left) kms_cursor_legacy (cursorb-vs-flipa-varying-size)
[364.004832] Starting subtest: cursorB-vs-flipA-varying-size
[364.008274] Subtest cursorB-vs-flipA-varying-size: SKIP (0.004s)
[364.105538] [098/142] (644s left) gem_eio (in-flight-contexts-1us)
[364.331649] Starting subtest: in-flight-contexts-1us
[376.251922] Subtest in-flight-contexts-1us: SUCCESS (11.921s)
[376.475715] [099/142] (632s left) gem_exec_fence (syncobj-import)
[377.155126] Starting subtest: syncobj-import
[377.161378] Subtest syncobj-import: SUCCESS (0.006s)
[377.522189] [100/142] (631s left) gem_exec_fence (keep-in-fence)
[377.885942] Starting subtest: keep-in-fence
[377.887354] Starting dynamic subtest: rcs0
[377.918701] Dynamic subtest rcs0: SUCCESS (0.034s)
[377.942622] Starting dynamic subtest: bcs0
[378.061260] Dynamic subtest bcs0: SUCCESS (0.140s)
[378.084816] Starting dynamic subtest: vcs0
[378.110146] Dynamic subtest vcs0: SUCCESS (0.045s)
[378.136440] Starting dynamic subtest: vecs0
[378.160221] Dynamic subtest vecs0: SUCCESS (0.047s)
[378.161697] Subtest keep-in-fence: SUCCESS (0.279s)
[378.838989] [101/142] (629s left) i915_query (query-topology-unsupported)
[379.039920] Starting subtest: query-topology-unsupported
[379.042785] Subtest query-topology-unsupported: SKIP (0.000s)
[379.137761] [102/142] (629s left) i915_module_load (resize-bar)
[379.339033] Starting subtest: resize-bar
[379.352415] Subtest resize-bar: SKIP (0.013s)
[379.414406] [103/142] (629s left) gem_pipe_control_store_loop (fresh-buffer)
[379.627959] Starting subtest: fresh-buffer
[381.782676] Subtest fresh-buffer: SUCCESS (2.155s)
[381.904425] [104/142] (626s left) kms_flip_scaled_crc (flip-32bpp-linear-to-64bpp-linear-downscaling)
[382.210785] Starting subtest: flip-32bpp-linear-to-64bpp-linear-downscaling
[382.212279] Starting dynamic subtest: pipe-A-valid-mode
[382.997280] Dynamic subtest pipe-A-valid-mode: SKIP (0.784s)
[383.001634] Subtest flip-32bpp-linear-to-64bpp-linear-downscaling: SKIP (0.789s)
[383.408779] [105/142] (625s left) kms_vblank (pipe-b-wait-busy-hang)
[383.714926] Starting subtest: pipe-B-wait-busy-hang
[390.963892] Subtest pipe-B-wait-busy-hang: SUCCESS (7.250s)
[391.318268] [106/142] (617s left) kms_addfb_basic (invalid-get-prop-any)
[391.521639] Starting subtest: invalid-get-prop-any
[391.523390] Subtest invalid-get-prop-any: SUCCESS (0.000s)
[391.718215] [107/142] (617s left) kms_ccs (pipe-c-bad-pixel-format-4_tiled_dg2_mc_ccs)
[392.303936] Starting subtest: pipe-C-bad-pixel-format-4_tiled_dg2_mc_ccs
[392.306950] Subtest pipe-C-bad-pixel-format-4_tiled_dg2_mc_ccs: SKIP (0.000s)
[392.725191] [108/142] (616s left) kms_ccs (pipe-a-bad-rotation-90-4_tiled_mtl_mc_ccs)
[393.115501] Starting subtest: pipe-A-bad-rotation-90-4_tiled_mtl_mc_ccs
[393.118153] Subtest pipe-A-bad-rotation-90-4_tiled_mtl_mc_ccs: SKIP (0.000s)
[393.731979] [109/142] (615s left) kms_vblank (pipe-d-wait-idle)
[394.040212] Subtest pipe-D-wait-idle: SKIP (0.000s)
[394.131541] [110/142] (614s left) kms_addfb_basic (framebuffer-vs-set-tiling)
[394.335639] Starting subtest: framebuffer-vs-set-tiling
[394.337152] Subtest framebuffer-vs-set-tiling: SUCCESS (0.000s)
[394.547919] [111/142] (614s left) gem_spin_batch (resubmit-new)
[394.773830] Starting subtest: resubmit-new
[394.775410] Starting dynamic subtest: rcs0
[394.784839] Dynamic subtest rcs0: SUCCESS (0.009s)
[394.822802] Starting dynamic subtest: bcs0
[394.824627] Dynamic subtest bcs0: SUCCESS (0.011s)
[394.845144] Starting dynamic subtest: vcs0
[394.846469] Dynamic subtest vcs0: SUCCESS (0.007s)
[394.866423] Starting dynamic subtest: vecs0
[394.867704] Dynamic subtest vecs0: SUCCESS (0.007s)
[394.868950] Subtest resubmit-new: SUCCESS (0.049s)
[395.049528] [112/142] (614s left) kms_flip (2x-flip-vs-blocking-wf-vblank)
[395.331731] Starting subtest: 2x-flip-vs-blocking-wf-vblank
[395.334308] Subtest 2x-flip-vs-blocking-wf-vblank: SKIP (0.003s)
[395.449305] [113/142] (613s left) syncobj_timeline (etime-single-wait-submitted)
[395.654510] Starting subtest: etime-single-wait-submitted
[395.762575] Subtest etime-single-wait-submitted: SUCCESS (0.107s)
[395.847802] [114/142] (613s left) gem_exec_balancer (sequential)
[396.071380] Starting subtest: sequential
[399.726378] Subtest sequential: SUCCESS (3.655s)
[403.631194] [115/142] (605s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-0-hflip)
[403.955349] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-0-hflip
[403.989731] Subtest y-tiled-max-hw-stride-64bpp-rotate-0-hflip: SKIP (0.033s)
[404.114892] [116/142] (605s left) vgem_basic (busy-fence)
[404.322381] Starting subtest: busy-fence
[404.323937] Subtest busy-fence: SUCCESS (0.000s)
[404.397524] [117/142] (604s left) gem_ccs (ctrl-surf-copy-new-ctx)
[404.609905] Subtest ctrl-surf-copy-new-ctx: SKIP (0.000s)
[404.663913] [118/142] (604s left) kms_cursor_legacy (cursorb-vs-flipb-varying-size)
[404.966444] Starting subtest: cursorB-vs-flipB-varying-size
[404.969503] Subtest cursorB-vs-flipB-varying-size: SKIP (0.003s)
[405.064984] [119/142] (604s left) sysfs_heartbeat_interval (mixed)
[405.273082] Starting subtest: mixed
[405.277713] Starting dynamic subtest: vecs0
[410.502576] Dynamic subtest vecs0: SUCCESS (5.227s)
[410.526761] Starting dynamic subtest: vcs0
[415.741395] Dynamic subtest vcs0: SUCCESS (5.235s)
[415.765912] Starting dynamic subtest: bcs0
[421.011863] Dynamic subtest bcs0: SUCCESS (5.267s)
[421.037823] Starting dynamic subtest: rcs0
[426.307100] Dynamic subtest rcs0: SUCCESS (5.292s)
[426.308721] Subtest mixed: SUCCESS (21.035s)
[426.397935] [120/142] (583s left) syncobj_basic (bad-handle-to-fd)
[426.603513] Starting subtest: bad-handle-to-fd
[426.605188] Subtest bad-handle-to-fd: SUCCESS (0.000s)
[426.696874] [121/142] (582s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-mmap-gtt)
[426.999692] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-mmap-gtt
[427.002353] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[427.115718] [122/142] (582s left) kms_vblank (pipe-b-query-forked-busy)
[427.414883] Starting subtest: pipe-B-query-forked-busy
[430.279234] Subtest pipe-B-query-forked-busy: SUCCESS (2.866s)
[430.620315] [123/142] (579s left) gem_pxp (verify-pxp-stale-ctx-execution)
[433.344793] Subtest verify-pxp-stale-ctx-execution: SKIP (0.000s)
[433.434539] [124/142] (576s left) i915_pm_rpm (fences)
[435.239072] Starting subtest: fences
[438.130138] Subtest fences: SUCCESS (2.891s)
[438.360075] [125/142] (571s left) kms_ccs (pipe-d-random-ccs-data-4_tiled_dg2_rc_ccs_cc)
[439.019229] Subtest pipe-D-random-ccs-data-4_tiled_dg2_rc_ccs_cc: SKIP (0.000s)
[439.331602] [126/142] (570s left) i915_pm_rps (basic-api)
[439.540504] Starting subtest: basic-api
[439.548202] Subtest basic-api: SUCCESS (0.007s)
[439.647757] [127/142] (570s left) kms_big_fb (4-tiled-16bpp-rotate-270)
[439.970503] Starting subtest: 4-tiled-16bpp-rotate-270
[439.973211] Subtest 4-tiled-16bpp-rotate-270: SKIP (0.000s)
[440.081420] [128/142] (569s left) kms_ccs (pipe-d-bad-aux-stride-4_tiled_mtl_mc_ccs)
[440.765582] Subtest pipe-D-bad-aux-stride-4_tiled_mtl_mc_ccs: SKIP (0.000s)
[441.088142] [129/142] (568s left) fbdev (nullptr)
[441.296525] Starting subtest: nullptr
[441.297958] Subtest nullptr: SUCCESS (0.000s)
[441.370810] [130/142] (568s left) gem_exec_whisper (basic-contexts-priority)
[441.601262] Starting subtest: basic-contexts-priority
[457.639691] Subtest basic-contexts-priority: SUCCESS (16.036s)
[457.854845] [131/142] (552s left) gem_mmap_wc (copy)
[458.056909] Starting subtest: copy
[458.396230] Subtest copy: SUCCESS (0.340s)
[458.488545] [132/142] (551s left) gem_exec_flush (basic-uc-prw-default)
[458.722035] Starting subtest: basic-uc-prw-default
[464.202703] Subtest basic-uc-prw-default: SUCCESS (5.482s)
[464.406789] [133/142] (545s left) syncobj_basic (bad-flags-handle-to-fd)
[464.607268] Starting subtest: bad-flags-handle-to-fd
[464.608647] Subtest bad-flags-handle-to-fd: SUCCESS (0.000s)
[464.703255] [134/142] (545s left) gem_exec_balancer (fairslice)
[464.927741] Starting subtest: fairslice
[464.930343] Subtest fairslice: SKIP (0.000s)
[468.804912] [135/142] (541s left) kms_cursor_crc (cursor-offscreen-64x64)
[469.108447] Starting subtest: cursor-offscreen-64x64
[469.118255] Starting dynamic subtest: pipe-A-DP-1
[471.624153] Dynamic subtest pipe-A-DP-1: SUCCESS (2.490s)
[471.707613] Starting dynamic subtest: pipe-C-DP-1
[474.521171] Dynamic subtest pipe-C-DP-1: SUCCESS (2.841s)
[474.522369] Subtest cursor-offscreen-64x64: SUCCESS (5.413s)
[474.881902] [136/142] (535s left) gem_mmap_offset (basic-uaf)
[475.083619] Starting subtest: basic-uaf
[475.088153] Subtest basic-uaf: SUCCESS (0.004s)
[475.195347] [137/142] (535s left) kms_draw_crc (draw-method-mmap-wc)
[475.499191] Starting subtest: draw-method-mmap-wc
[475.500618] Starting dynamic subtest: xrgb8888-untiled
[475.801119] Dynamic subtest xrgb8888-untiled: SUCCESS (0.301s)
[475.825781] Starting dynamic subtest: rgb565-untiled
[476.083374] Dynamic subtest rgb565-untiled: SUCCESS (0.280s)
[476.107376] Starting dynamic subtest: xrgb2101010-untiled
[476.385355] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.297s)
[476.406798] Starting dynamic subtest: xrgb8888-xtiled
[476.602479] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.214s)
[476.625601] Starting dynamic subtest: rgb565-xtiled
[476.802035] Dynamic subtest rgb565-xtiled: SUCCESS (0.197s)
[476.823155] Starting dynamic subtest: xrgb2101010-xtiled
[477.016489] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.214s)
[477.041448] Starting dynamic subtest: xrgb8888-ytiled
[477.233240] Dynamic subtest xrgb8888-ytiled: SUCCESS (0.213s)
[477.257182] Starting dynamic subtest: rgb565-ytiled
[477.433126] Dynamic subtest rgb565-ytiled: SUCCESS (0.197s)
[477.457377] Starting dynamic subtest: xrgb2101010-ytiled
[477.649717] Dynamic subtest xrgb2101010-ytiled: SUCCESS (0.214s)
[477.651220] Subtest draw-method-mmap-wc: SUCCESS (2.154s)
[477.761659] [138/142] (532s left) gem_render_copy (linear)
[477.986708] Starting subtest: linear
[477.988431] Starting dynamic subtest: smem
[478.243027] Dynamic subtest smem: SUCCESS (0.255s)
[478.245666] Subtest linear: SUCCESS (0.258s)
[478.445831] [139/142] (531s left) kms_content_protection (dp-mst-type-1)
[478.778640] Starting subtest: dp-mst-type-1
[478.781680] Subtest dp-mst-type-1: SKIP (0.001s)
[478.895371] [140/142] (531s left) kms_rotation_crc (primary-y-tiled-reflect-x-180)
[479.199194] Starting subtest: primary-y-tiled-reflect-x-180
[479.202186] Subtest primary-y-tiled-reflect-x-180: SKIP (0.003s)
[479.316340] [141/142] (531s left) kms_addfb_basic (invalid-set-prop)
[479.516421] Starting subtest: invalid-set-prop
[479.517982] Subtest invalid-set-prop: SUCCESS (0.000s)
[479.728567] [142/142] (530s left) kms_psr (cursor_mmap_gtt)
[479.927947] Subtest cursor_mmap_gtt: SKIP (0.000s)
[479.990912] Closing watchdogs
Done.