[54.001009] Initializing watchdogs
[54.001074]   /dev/watchdog0
[54.005275] [001/137] (960s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-mmap-gtt)
[54.090784] Starting subtest: psr-1p-primscrn-spr-indfb-draw-mmap-gtt
[54.092222] Subtest psr-1p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[54.179706] [002/137] (960s left) gem_exec_fence (syncobj-timeline-chain-engines)
[54.660389] Starting subtest: syncobj-timeline-chain-engines
[54.695044] Subtest syncobj-timeline-chain-engines: SUCCESS (0.036s)
[54.920635] [003/137] (959s left) kms_color (invalid-degamma-lut-sizes)
[55.014202] Starting subtest: invalid-degamma-lut-sizes
[55.014922] Starting dynamic subtest: pipe-A
[55.052076] Dynamic subtest pipe-A: SUCCESS (0.038s)
[55.055132] Starting dynamic subtest: pipe-B
[55.057263] Dynamic subtest pipe-B: SUCCESS (0.005s)
[55.057971] Subtest invalid-degamma-lut-sizes: SUCCESS (0.043s)
[55.141448] [004/137] (959s left) i915_pm_dc (dc6-dpms)
[56.220883] Starting subtest: dc6-dpms
[56.222907] Subtest dc6-dpms: SKIP (0.000s)
[56.374548] [005/137] (958s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-render)
[56.465083] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-render
[56.466430] Subtest fbc-2p-primscrn-spr-indfb-draw-render: SKIP (0.000s)
[56.561136] [006/137] (958s left) i915_hangman (engine-engine-hang)
[56.627932] Starting subtest: engine-engine-hang
[56.628653] Starting dynamic subtest: rcs0
[57.198590] Dynamic subtest rcs0: SUCCESS (0.571s)
[57.205839] Starting dynamic subtest: bcs0
[57.766509] Dynamic subtest bcs0: SUCCESS (0.568s)
[57.773907] Starting dynamic subtest: vcs0
[58.326515] Dynamic subtest vcs0: SUCCESS (0.560s)
[58.333868] Starting dynamic subtest: vecs0
[58.890448] Dynamic subtest vecs0: SUCCESS (0.564s)
[58.891762] Subtest engine-engine-hang: SUCCESS (2.263s)
[58.970872] [007/137] (955s left) syncobj_wait (multi-wait-all-for-submit-unsubmitted-signaled)
[59.028736] Starting subtest: multi-wait-all-for-submit-unsubmitted-signaled
[59.132534] Subtest multi-wait-all-for-submit-unsubmitted-signaled: SUCCESS (0.103s)
[59.201649] [008/137] (955s left) v3d/v3d_mmap (mmap-bad-flags)
[59.288087] Subtest mmap-bad-flags: SKIP (0.000s)
[59.351354] [009/137] (955s left) kms_flip (plain-flip-fb-recreate-interruptible)
[59.440939] Starting subtest: plain-flip-fb-recreate-interruptible
[59.442364] Starting dynamic subtest: A-HDMI-A2
[75.008103] Dynamic subtest A-HDMI-A2: SUCCESS (15.565s)
[75.015745] Starting dynamic subtest: B-HDMI-A2
[90.459823] Dynamic subtest B-HDMI-A2: SUCCESS (15.451s)
[90.460803] Subtest plain-flip-fb-recreate-interruptible: SUCCESS (31.019s)
[90.588658] [010/137] (924s left) kms_big_fb (y-tiled-8bpp-rotate-180)
[90.671429] Starting subtest: y-tiled-8bpp-rotate-180
[92.058960] Subtest y-tiled-8bpp-rotate-180: SUCCESS (1.387s)
[92.180557] [011/137] (922s left) gem_exec_balancer (parallel-keep-in-fence)
[93.163495] Subtest parallel-keep-in-fence: SKIP (0.000s)
[93.230279] [012/137] (921s left) kms_cursor_crc (cursor-rapid-movement-64x64)
[93.312492] Starting subtest: cursor-rapid-movement-64x64
[93.316420] Starting dynamic subtest: pipe-A-HDMI-A-2
[93.714286] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (0.398s)
[93.732887] Starting dynamic subtest: pipe-B-HDMI-A-2
[94.217391] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (0.487s)
[94.218079] Subtest cursor-rapid-movement-64x64: SUCCESS (0.905s)
[94.344571] [013/137] (920s left) syncobj_wait (reset-signaled)
[94.387339] Starting subtest: reset-signaled
[94.388057] Subtest reset-signaled: SUCCESS (0.000s)
[94.438502] [014/137] (920s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-blt)
[94.517612] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-blt
[94.518932] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-blt: SKIP (0.000s)
[94.624592] [015/137] (920s left) kms_ccs (pipe-b-crc-sprite-planes-basic-4_tiled_dg2_rc_ccs_cc)
[94.889912] Starting subtest: pipe-B-crc-sprite-planes-basic-4_tiled_dg2_rc_ccs_cc
[94.891989] Subtest pipe-B-crc-sprite-planes-basic-4_tiled_dg2_rc_ccs_cc: SKIP (0.001s)
[94.982038] [016/137] (919s left) kms_chamelium_frames (dp-crc-fast)
[95.092490] Subtest dp-crc-fast: SKIP (0.000s)
[95.139436] [017/137] (919s left) gem_ctx_persistence (legacy-engines-hostile-preempt)
[95.184510] Starting subtest: legacy-engines-hostile-preempt
[95.185185] Starting dynamic subtest: render
[95.267829] Dynamic subtest render: SUCCESS (0.083s)
[95.272144] Starting dynamic subtest: bsd
[95.350387] Dynamic subtest bsd: SUCCESS (0.082s)
[95.357127] Starting dynamic subtest: blt
[95.439380] Dynamic subtest blt: SUCCESS (0.088s)
[95.446886] Starting dynamic subtest: vebox
[95.528446] Dynamic subtest vebox: SUCCESS (0.089s)
[95.529692] Subtest legacy-engines-hostile-preempt: SUCCESS (0.343s)
[95.625362] [018/137] (919s left) kms_cursor_crc (cursor-offscreen-512x170)
[95.714148] Starting subtest: cursor-offscreen-512x170
[95.716197] Subtest cursor-offscreen-512x170: SKIP (0.001s)
[95.806836] [019/137] (918s left) kms_big_fb (x-tiled-64bpp-rotate-0)
[95.902206] Starting subtest: x-tiled-64bpp-rotate-0
[97.999558] Subtest x-tiled-64bpp-rotate-0: SUCCESS (2.097s)
[98.189835] [020/137] (916s left) gen7_exec_parse (basic-allocation)
[98.245416] Subtest basic-allocation: SKIP (0.000s)
[98.269093] [021/137] (916s left) kms_cursor_legacy (basic-flip-before-cursor-legacy)
[98.356727] Starting subtest: basic-flip-before-cursor-legacy
[99.408282] Subtest basic-flip-before-cursor-legacy: SUCCESS (1.053s)
[99.516982] [022/137] (915s left) kms_plane (pixel-format-source-clamping)
[99.592875] Starting subtest: pixel-format-source-clamping
[99.593640] Starting dynamic subtest: pipe-A-planes
[110.630371] Dynamic subtest pipe-A-planes: SUCCESS (11.037s)
[110.635724] Starting dynamic subtest: pipe-B-planes
[121.643601] Dynamic subtest pipe-B-planes: SUCCESS (11.011s)
[121.644308] Subtest pixel-format-source-clamping: SUCCESS (22.051s)
[121.771777] [023/137] (893s left) kms_psr (sprite_mmap_cpu)
[121.815476] Subtest sprite_mmap_cpu: SKIP (0.000s)
[121.843411] [024/137] (892s left) kms_flip (2x-flip-vs-fences)
[121.930128] Starting subtest: 2x-flip-vs-fences
[121.931462] Subtest 2x-flip-vs-fences: SKIP (0.001s)
[122.037915] [025/137] (892s left) i915_pm_rpm (gem-execbuf-stress)
[123.434213] Starting subtest: gem-execbuf-stress
[123.435514] Starting dynamic subtest: smem0
[125.080390] Dynamic subtest smem0: SUCCESS (1.646s)
[125.093119] Starting dynamic subtest: extra-wait-smem0
[176.683669] Dynamic subtest extra-wait-smem0: SUCCESS (51.602s)
[176.684973] Subtest gem-execbuf-stress: SUCCESS (53.248s)
[176.874645] [026/137] (838s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-mmap-wc)
[176.953048] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-mmap-wc
[179.407139] Subtest fbc-1p-primscrn-pri-indfb-draw-mmap-wc: SUCCESS (2.455s)
[179.550857] [027/137] (835s left) kms_cursor_legacy (cursorb-vs-flipa-atomic)
[179.635696] Starting subtest: cursorB-vs-flipA-atomic
[179.637795] Subtest cursorB-vs-flipA-atomic: SKIP (0.002s)
[179.716454] [028/137] (835s left) api_intel_bb (reset-bb)
[179.777075] Starting subtest: reset-bb
[179.778647] Subtest reset-bb: SUCCESS (0.001s)
[179.887779] [029/137] (835s left) kms_atomic (plane-immutable-zpos)
[180.019025] Starting subtest: plane-immutable-zpos
[180.355159] Subtest plane-immutable-zpos: SUCCESS (0.336s)
[180.506474] [030/137] (834s left) syncobj_timeline (invalid-multi-wait-available-unsubmitted-submitted-signaled
[180.550060] Starting subtest: invalid-multi-wait-available-unsubmitted-submitted-signaled
[180.550815] Subtest invalid-multi-wait-available-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[180.620320] [031/137] (834s left) kms_flip (modeset-vs-vblank-race-interruptible)
[180.710375] Starting subtest: modeset-vs-vblank-race-interruptible
[180.712024] Starting dynamic subtest: A-HDMI-A2
[186.248425] Dynamic subtest A-HDMI-A2: SUCCESS (5.537s)
[186.251965] Starting dynamic subtest: B-HDMI-A2
[191.731635] Dynamic subtest B-HDMI-A2: SUCCESS (5.483s)
[191.732384] Subtest modeset-vs-vblank-race-interruptible: SUCCESS (11.022s)
[191.859480] [032/137] (823s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-pwrite)
[191.944012] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-pwrite
[191.945352] Subtest fbc-2p-scndscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[192.029845] [033/137] (822s left) kms_busy (extended-modeset-hang-newfb-with-reset)
[192.110092] Starting subtest: extended-modeset-hang-newfb-with-reset
[192.110797] Starting dynamic subtest: pipe-A
[194.897607] Dynamic subtest pipe-A: SUCCESS (2.787s)
[194.903245] Starting dynamic subtest: pipe-B
[197.643906] Dynamic subtest pipe-B: SUCCESS (2.743s)
[197.644605] Subtest extended-modeset-hang-newfb-with-reset: SUCCESS (5.534s)
[197.774751] [034/137] (817s left) kms_ccs (pipe-d-bad-pixel-format-y_tiled_gen12_rc_ccs)
[198.041759] Subtest pipe-D-bad-pixel-format-y_tiled_gen12_rc_ccs: SKIP (0.000s)
[198.126064] [035/137] (816s left) gem_exec_reloc (basic-wc-read-noreloc)
[198.171195] Subtest basic-wc-read-noreloc: SKIP (0.000s)
[198.223770] [036/137] (816s left) kms_ccs (pipe-c-bad-rotation-90-yf_tiled_ccs)
[198.484892] Subtest pipe-C-bad-rotation-90-yf_tiled_ccs: SKIP (0.000s)
[198.569672] [037/137] (816s left) kms_ccs (pipe-b-bad-pixel-format-y_tiled_ccs)
[198.763612] Starting subtest: pipe-B-bad-pixel-format-y_tiled_ccs
[198.765709] Subtest pipe-B-bad-pixel-format-y_tiled_ccs: SKIP (0.000s)
[198.918769] [038/137] (816s left) gem_softpin (evict-snoop)
[198.963952] Starting subtest: evict-snoop
[198.965352] Subtest evict-snoop: SKIP (0.000s)
[199.051459] [039/137] (816s left) kms_vblank (pipe-a-query-busy-hang)
[199.142027] Starting subtest: pipe-A-query-busy-hang
[212.953030] Subtest pipe-A-query-busy-hang: SUCCESS (13.811s)
[213.067121] [040/137] (802s left) prime_vgem (basic-blt)
[213.116225] Starting subtest: basic-blt
[213.127813] Subtest basic-blt: SUCCESS (0.011s)
[213.234118] [041/137] (801s left) kms_frontbuffer_tracking (psr-1p-primscrn-indfb-msflip-blt)
[213.321036] Starting subtest: psr-1p-primscrn-indfb-msflip-blt
[213.322365] Subtest psr-1p-primscrn-indfb-msflip-blt: SKIP (0.000s)
[213.430266] [042/137] (801s left) syncobj_timeline (invalid-multi-wait-all-available-unsubmitted)
[213.486783] Starting subtest: invalid-multi-wait-all-available-unsubmitted
[213.487492] Subtest invalid-multi-wait-all-available-unsubmitted: SUCCESS (0.000s)
[213.557706] [043/137] (801s left) gem_ctx_engines (execute-allforone)
[213.620381] Starting subtest: execute-allforone
[213.623550] Subtest execute-allforone: SUCCESS (0.003s)
[213.805150] [044/137] (801s left) perf_pmu (interrupts)
[213.865962] Starting subtest: interrupts
[214.960997] Subtest interrupts: SUCCESS (1.095s)
[215.056589] [045/137] (800s left) gem_ctx_sseu (mmap-args)
[215.114415] Subtest mmap-args: SKIP (0.000s)
[215.130897] [046/137] (800s left) syncobj_wait (invalid-wait-illegal-handle)
[215.179536] Starting subtest: invalid-wait-illegal-handle
[215.180249] Subtest invalid-wait-illegal-handle: SUCCESS (0.000s)
[215.244791] [047/137] (799s left) gem_pxp (regular-baseline-src-copy-readible)
[217.817207] Subtest regular-baseline-src-copy-readible: SKIP (0.000s)
[217.875695] [048/137] (797s left) kms_plane_scaling (planes-upscale-20x20-downscale-factor-0-75)
[217.963857] Starting subtest: planes-upscale-20x20-downscale-factor-0-75
[217.964588] Starting dynamic subtest: pipe-A-HDMI-A-2
[218.065482] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (0.101s)
[218.070569] Starting dynamic subtest: pipe-B-HDMI-A-2
[218.184776] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (0.118s)
[218.185500] Subtest planes-upscale-20x20-downscale-factor-0-75: SUCCESS (0.222s)
[218.314670] [049/137] (796s left) i915_pm_dc (dc6-psr)
[219.402255] Starting subtest: dc6-psr
[219.403765] Subtest dc6-psr: SKIP (0.000s)
[219.537180] [050/137] (795s left) kms_frontbuffer_tracking (psr-rgb101010-draw-mmap-gtt)
[219.624804] Starting subtest: psr-rgb101010-draw-mmap-gtt
[219.626218] Subtest psr-rgb101010-draw-mmap-gtt: SKIP (0.000s)
[219.738646] [051/137] (795s left) kms_frontbuffer_tracking (fbc-tiling-y)
[219.832056] Starting subtest: fbc-tiling-y
[222.211148] Subtest fbc-tiling-y: SUCCESS (2.381s)
[222.370965] [052/137] (792s left) gem_reg_read (timestamp-monotonic)
[222.421384] Starting subtest: timestamp-monotonic
[226.770976] Subtest timestamp-monotonic: SUCCESS (4.349s)
[226.846765] [053/137] (788s left) gem_exec_store (cachelines)
[226.909709] Starting subtest: cachelines
[226.910407] Starting dynamic subtest: rcs0
[226.972564] Dynamic subtest rcs0: SUCCESS (0.062s)
[226.981437] Starting dynamic subtest: bcs0
[227.008685] Dynamic subtest bcs0: SUCCESS (0.035s)
[227.020802] Starting dynamic subtest: vcs0
[227.045625] Dynamic subtest vcs0: SUCCESS (0.036s)
[227.057541] Starting dynamic subtest: vecs0
[227.089896] Dynamic subtest vecs0: SUCCESS (0.043s)
[227.091133] Subtest cachelines: SUCCESS (0.180s)
[227.270299] [054/137] (788s left) perf_pmu (semaphore-wait)
[227.329754] Starting subtest: semaphore-wait
[227.330444] Starting dynamic subtest: rcs0
[227.838789] Dynamic subtest rcs0: SUCCESS (0.508s)
[227.846662] Starting dynamic subtest: bcs0
[228.350143] Dynamic subtest bcs0: SUCCESS (0.510s)
[228.357479] Starting dynamic subtest: vcs0
[228.861044] Dynamic subtest vcs0: SUCCESS (0.509s)
[228.868582] Starting dynamic subtest: vecs0
[229.372076] Dynamic subtest vecs0: SUCCESS (0.510s)
[229.373518] Subtest semaphore-wait: SUCCESS (2.042s)
[229.465125] [055/137] (785s left) kms_ccs (pipe-a-random-ccs-data-y_tiled_ccs)
[229.623554] Starting subtest: pipe-A-random-ccs-data-y_tiled_ccs
[229.625579] Subtest pipe-A-random-ccs-data-y_tiled_ccs: SKIP (0.000s)
[229.818644] [056/137] (785s left) prime_self_import (basic-llseek-bad)
[229.860952] Starting subtest: basic-llseek-bad
[229.862608] Subtest basic-llseek-bad: SUCCESS (0.001s)
[229.974105] [057/137] (785s left) kms_frontbuffer_tracking (fbc-badstride)
[230.059382] Starting subtest: fbc-badstride
[238.213211] Subtest fbc-badstride: SUCCESS (8.155s)
[238.316095] [058/137] (777s left) sw_sync (sync_busy)
[238.372723] Starting subtest: sync_busy
[238.374369] Subtest sync_busy: SUCCESS (0.001s)
[238.421623] [059/137] (777s left) drm_fdinfo (all-busy-idle-check-all)
[238.479576] Starting subtest: all-busy-idle-check-all
[239.094355] Subtest all-busy-idle-check-all: SUCCESS (0.614s)
[239.160265] [060/137] (776s left) kms_ccs (pipe-c-missing-ccs-buffer-y_tiled_gen12_rc_ccs_cc)
[239.420262] Subtest pipe-C-missing-ccs-buffer-y_tiled_gen12_rc_ccs_cc: SKIP (0.000s)
[239.505342] [061/137] (775s left) kms_psr (psr2_primary_page_flip)
[239.550102] Subtest psr2_primary_page_flip: SKIP (0.000s)
[239.575760] [062/137] (775s left) gem_eio (context-create)
[239.625192] Starting subtest: context-create
[239.645139] Subtest context-create: SUCCESS (0.019s)
[239.708464] [063/137] (775s left) v3d/v3d_submit_csd (bad-multisync-extension)
[239.780115] Subtest bad-multisync-extension: SKIP (0.000s)
[239.846988] [064/137] (775s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-cpu)
[239.943195] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-cpu
[239.944617] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[240.040202] [065/137] (775s left) gem_exec_params (invalid-bsd2-flag-on-blt)
[240.098983] Starting subtest: invalid-bsd2-flag-on-blt
[240.099731] Subtest invalid-bsd2-flag-on-blt: SUCCESS (0.000s)
[240.195464] [066/137] (775s left) gem_userptr_blits (coherency-sync)
[240.253605] Starting subtest: coherency-sync
[240.628440] Subtest coherency-sync: SKIP (0.368s)
[240.749620] [067/137] (774s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-0-hflip)
[240.881575] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-0-hflip
[240.882963] Subtest 4-tiled-max-hw-stride-64bpp-rotate-0-hflip: SKIP (0.000s)
[240.989850] [068/137] (774s left) kms_vblank (pipe-b-query-idle)
[241.076913] Starting subtest: pipe-B-query-idle
[243.885604] Subtest pipe-B-query-idle: SUCCESS (2.808s)
[243.990983] [069/137] (771s left) gem_spin_batch (resubmit)
[244.038650] Starting subtest: resubmit
[244.039371] Starting dynamic subtest: rcs0
[244.041038] Dynamic subtest rcs0: SUCCESS (0.002s)
[244.045573] Starting dynamic subtest: bcs0
[244.046260] Dynamic subtest bcs0: SUCCESS (0.001s)
[244.050775] Starting dynamic subtest: vcs0
[244.051588] Dynamic subtest vcs0: SUCCESS (0.001s)
[244.057817] Starting dynamic subtest: vecs0
[244.058579] Dynamic subtest vecs0: SUCCESS (0.001s)
[244.059340] Subtest resubmit: SUCCESS (0.005s)
[244.239290] [070/137] (771s left) vc4/vc4_dmabuf_poll (poll-write-waits-until-write-done)
[244.321761] Subtest poll-write-waits-until-write-done: SKIP (0.000s)
[244.387699] [071/137] (771s left) kms_frontbuffer_tracking (fbc-suspend)
[244.481093] Starting subtest: fbc-suspend
[282.737367] Subtest fbc-suspend: SUCCESS (38.257s)
[283.880806] [072/137] (732s left) kms_chamelium_hpd (hdmi-hpd-after-suspend)
[284.014811] Subtest hdmi-hpd-after-suspend: SKIP (0.000s)
[284.066301] [073/137] (732s left) kms_cursor_crc (cursor-random-256x85)
[284.152163] Starting subtest: cursor-random-256x85
[284.155114] Starting dynamic subtest: pipe-A-HDMI-A-2
[288.389856] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (4.235s)
[288.410314] Starting dynamic subtest: pipe-B-HDMI-A-2
[292.706470] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (4.301s)
[292.707179] Subtest cursor-random-256x85: SUCCESS (8.555s)
[292.814691] [074/137] (723s left) kms_cursor_legacy (cursora-vs-flipa-atomic-transitions-varying-size)
[292.893124] Starting subtest: cursorA-vs-flipA-atomic-transitions-varying-size
[303.736314] Subtest cursorA-vs-flipA-atomic-transitions-varying-size: SUCCESS (10.844s)
[303.849503] [075/137] (712s left) syncobj_basic (bad-pad-fd-to-handle)
[303.895792] Starting subtest: bad-pad-fd-to-handle
[303.896479] Subtest bad-pad-fd-to-handle: SUCCESS (0.000s)
[303.978422] [076/137] (712s left) perf (missing-sample-flags)
[304.090064] Starting subtest: missing-sample-flags
[304.090767] Subtest missing-sample-flags: SUCCESS (0.000s)
[304.113402] [077/137] (712s left) kms_ccs (pipe-d-crc-sprite-planes-basic-4_tiled_dg2_rc_ccs)
[304.378157] Subtest pipe-D-crc-sprite-planes-basic-4_tiled_dg2_rc_ccs: SKIP (0.000s)
[304.464072] [078/137] (712s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-render)
[304.545317] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-render
[304.546667] Subtest fbc-2p-scndscrn-pri-indfb-draw-render: SKIP (0.000s)
[304.658714] [079/137] (712s left) i915_pm_rps (reset)
[304.710466] Starting subtest: reset
[308.231841] Subtest reset: SUCCESS (3.521s)
[308.330151] [080/137] (708s left) kms_sequence (get-busy)
[308.414925] Starting subtest: get-busy
[308.415784] Starting dynamic subtest: HDMI-A-2-pipe-A
[311.173887] Dynamic subtest HDMI-A-2-pipe-A: SUCCESS (2.759s)
[311.180855] Starting dynamic subtest: HDMI-A-2-pipe-B
[314.098780] Dynamic subtest HDMI-A-2-pipe-B: SUCCESS (2.922s)
[314.099546] Subtest get-busy: SUCCESS (5.684s)
[314.188489] [081/137] (702s left) perf_pmu (event-wait)
[314.233470] Starting subtest: event-wait
[314.234185] Starting dynamic subtest: rcs0
[314.235562] Dynamic subtest rcs0: SKIP (0.000s)
[314.236919] Subtest event-wait: SKIP (0.000s)
[314.321787] [082/137] (702s left) kms_plane_scaling (planes-downscale-factor-0-5)
[314.411792] Starting subtest: planes-downscale-factor-0-5
[314.415337] Starting dynamic subtest: pipe-A-HDMI-A-2
[314.560142] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (0.147s)
[314.566677] Starting dynamic subtest: pipe-B-HDMI-A-2
[314.677118] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (0.116s)
[314.677889] Subtest planes-downscale-factor-0-5: SUCCESS (0.265s)
[314.810566] [083/137] (702s left) gem_mmap_wc (pf-nonblock)
[314.856855] Starting subtest: pf-nonblock
[314.858944] Subtest pf-nonblock: SUCCESS (0.002s)
[314.982270] [084/137] (701s left) kms_ccs (pipe-d-random-ccs-data-y_tiled_gen12_rc_ccs)
[315.244322] Subtest pipe-D-random-ccs-data-y_tiled_gen12_rc_ccs: SKIP (0.000s)
[315.330870] [085/137] (701s left) vc4/vc4_tiling (set-get)
[315.412321] Subtest set-get: SKIP (0.000s)
[315.475959] [086/137] (701s left) gem_ctx_param (non-root-set)
[315.523371] Starting subtest: non-root-set
[315.530665] Subtest non-root-set: SUCCESS (0.008s)
[315.614756] [087/137] (701s left) gem_ccs (block-multicopy-inplace)
[315.671530] Starting subtest: block-multicopy-inplace
[315.672977] Subtest block-multicopy-inplace: SKIP (0.000s)
[315.745061] [088/137] (701s left) gem_exec_schedule (semaphore-resolve)
[315.808650] Starting subtest: semaphore-resolve
[315.818408] Subtest semaphore-resolve: SUCCESS (0.010s)
[316.122332] [089/137] (700s left) drm_read (short-buffer-nonblock)
[316.248108] Starting subtest: short-buffer-nonblock
[316.248859] Subtest short-buffer-nonblock: SUCCESS (0.000s)
[316.395353] [090/137] (700s left) gem_exec_suspend (basic)
[316.454175] Starting subtest: basic
[316.454940] Starting dynamic subtest: smem
[316.815091] Dynamic subtest smem: SUCCESS (0.361s)
[316.815781] Subtest basic: SUCCESS (0.361s)
[317.014945] [091/137] (699s left) kms_big_fb (yf-tiled-addfb-size-overflow)
[317.104196] Starting subtest: yf-tiled-addfb-size-overflow
[317.105614] Subtest yf-tiled-addfb-size-overflow: SKIP (0.000s)
[317.212715] [092/137] (699s left) gem_exec_fair (basic-none-solo)
[317.271864] Starting subtest: basic-none-solo
[317.272565] Starting dynamic subtest: rcs0
[323.523086] Dynamic subtest rcs0: FAIL (6.235s)
[323.523970] Subtest basic-none-solo: FAIL (6.236s)
[323.691746] [093/137] (693s left) api_intel_bb (bb-with-allocator)
[323.737018] Starting subtest: bb-with-allocator
[323.738816] Subtest bb-with-allocator: SUCCESS (0.002s)
[323.853049] [094/137] (693s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling)
[323.941195] Starting subtest: flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling
[323.941896] Starting dynamic subtest: pipe-A-valid-mode
[323.973766] Dynamic subtest pipe-A-valid-mode: SKIP (0.032s)
[323.975113] Subtest flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling: SKIP (0.033s)
[324.059583] [095/137] (693s left) gem_render_copy (yf-tiled-ccs-to-y-tiled-ccs)
[324.107366] Starting subtest: yf-tiled-ccs-to-y-tiled-ccs
[324.108067] Starting dynamic subtest: smem
[324.247422] Dynamic subtest smem: SUCCESS (0.139s)
[324.248137] Subtest yf-tiled-ccs-to-y-tiled-ccs: SUCCESS (0.140s)
[324.444071] [096/137] (692s left) kms_atomic (atomic_plane_damage)
[324.571326] Starting subtest: atomic_plane_damage
[324.827763] Subtest atomic_plane_damage: SUCCESS (0.256s)
[324.991332] [097/137] (692s left) gem_exec_suspend (basic-s3)
[325.038038] Starting subtest: basic-S3
[325.038751] Starting dynamic subtest: smem
[328.341051] Dynamic subtest smem: SUCCESS (3.303s)
[328.341758] Subtest basic-S3: SUCCESS (3.303s)
[331.526311] [098/137] (688s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-mmap-gtt)
[331.621493] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-mmap-gtt
[331.622872] Subtest psr-2p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[331.718104] [099/137] (688s left) syncobj_basic (bad-fd-to-handle)
[331.766273] Starting subtest: bad-fd-to-handle
[331.767227] Subtest bad-fd-to-handle: SUCCESS (0.000s)
[331.859237] [100/137] (688s left) kms_psr2_sf (overlay-primary-update-sf-dmg-area)
[331.909557] Subtest overlay-primary-update-sf-dmg-area: SKIP (0.000s)
[331.924781] [101/137] (688s left) vc4/vc4_perfmon (get-values-invalid-perfmon)
[332.014055] Subtest get-values-invalid-perfmon: SKIP (0.000s)
[332.085153] [102/137] (688s left) gem_exec_parallel (fds)
[332.144964] Starting subtest: fds
[332.145685] Starting dynamic subtest: rcs0
[334.059250] Dynamic subtest rcs0: SUCCESS (1.914s)
[334.067864] Starting dynamic subtest: bcs0
[335.912853] Dynamic subtest bcs0: SUCCESS (1.853s)
[335.930525] Starting dynamic subtest: vcs0
[337.776573] Dynamic subtest vcs0: SUCCESS (1.863s)
[337.787054] Starting dynamic subtest: vecs0
[339.666739] Dynamic subtest vecs0: SUCCESS (1.889s)
[339.668030] Subtest fds: SUCCESS (7.521s)
[339.863124] [103/137] (680s left) kms_big_fb (linear-max-hw-stride-32bpp-rotate-180)
[339.955169] Starting subtest: linear-max-hw-stride-32bpp-rotate-180
[341.197116] Subtest linear-max-hw-stride-32bpp-rotate-180: SUCCESS (1.242s)
[341.319545] [104/137] (678s left) kms_frontbuffer_tracking (psr-2p-scndscrn-shrfb-msflip-blt)
[341.404166] Starting subtest: psr-2p-scndscrn-shrfb-msflip-blt
[341.405525] Subtest psr-2p-scndscrn-shrfb-msflip-blt: SKIP (0.000s)
[341.516632] [105/137] (678s left) syncobj_timeline (single-wait-for-submit-signaled)
[341.568546] Starting subtest: single-wait-for-submit-signaled
[341.569258] Subtest single-wait-for-submit-signaled: SUCCESS (0.000s)
[341.646223] [106/137] (678s left) perf (low-oa-exponent-permissions)
[341.744403] Starting subtest: low-oa-exponent-permissions
[341.778937] Subtest low-oa-exponent-permissions: SUCCESS (0.035s)
[341.797837] [107/137] (678s left) gem_exec_fence (syncobj-wait)
[342.131894] Starting subtest: syncobj-wait
[342.188107] Subtest syncobj-wait: SUCCESS (0.056s)
[342.523940] [108/137] (677s left) kms_lease (master-vs-lease)
[342.606164] Starting subtest: master-vs-lease
[342.606955] Subtest master-vs-lease: SUCCESS (0.001s)
[342.684278] [109/137] (677s left) kms_flip_event_leak (basic)
[342.774704] Starting subtest: basic
[342.775588] Starting dynamic subtest: pipe-A-HDMI-A-2
[343.022722] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (0.247s)
[343.029826] Starting dynamic subtest: pipe-B-HDMI-A-2
[343.437750] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (0.412s)
[343.438444] Subtest basic: SUCCESS (0.664s)
[343.540127] [110/137] (676s left) gem_lmem_swapping (parallel-random-verify-ccs)
[343.585675] Subtest parallel-random-verify-ccs: SKIP (0.000s)
[343.610150] [111/137] (676s left) sysfs_heartbeat_interval (idempotent)
[343.653774] Starting subtest: idempotent
[343.654503] Starting dynamic subtest: vecs0
[343.655236] Dynamic subtest vecs0: SUCCESS (0.001s)
[343.660461] Starting dynamic subtest: vcs0
[343.661168] Dynamic subtest vcs0: SUCCESS (0.001s)
[343.666126] Starting dynamic subtest: bcs0
[343.666826] Dynamic subtest bcs0: SUCCESS (0.001s)
[343.671759] Starting dynamic subtest: rcs0
[343.672459] Dynamic subtest rcs0: SUCCESS (0.001s)
[343.673160] Subtest idempotent: SUCCESS (0.005s)
[343.710506] [112/137] (676s left) gem_exec_schedule (preempt-self)
[343.762596] Starting subtest: preempt-self
[343.763305] Starting dynamic subtest: rcs0
[343.769127] Dynamic subtest rcs0: SUCCESS (0.006s)
[343.774295] Starting dynamic subtest: bcs0
[343.776006] Dynamic subtest bcs0: SUCCESS (0.006s)
[343.781202] Starting dynamic subtest: vcs0
[343.781923] Dynamic subtest vcs0: SUCCESS (0.005s)
[343.787251] Starting dynamic subtest: vecs0
[343.787947] Dynamic subtest vecs0: SUCCESS (0.005s)
[343.788623] Subtest preempt-self: SUCCESS (0.024s)
[344.105287] [113/137] (676s left) kms_ccs (pipe-c-bad-pixel-format-y_tiled_gen12_rc_ccs)
[344.373862] Subtest pipe-C-bad-pixel-format-y_tiled_gen12_rc_ccs: SKIP (0.000s)
[344.460318] [114/137] (675s left) gem_mmap (bad-offset)
[344.504108] Starting subtest: bad-offset
[344.504859] Subtest bad-offset: SUCCESS (0.000s)
[344.608301] [115/137] (675s left) kms_concurrent (pipe-c)
[344.690921] Subtest pipe-C: SKIP (0.000s)
[344.748477] [116/137] (675s left) kms_addfb_basic (no-handle)
[344.803733] Starting subtest: no-handle
[344.804450] Subtest no-handle: SUCCESS (0.000s)
[344.938318] [117/137] (675s left) kms_cursor_legacy (short-busy-flip-before-cursor-atomic-transitions)
[345.023199] Starting subtest: short-busy-flip-before-cursor-atomic-transitions
[345.024618] Subtest short-busy-flip-before-cursor-atomic-transitions: SKIP (0.000s)
[345.093247] [118/137] (675s left) gem_userptr_blits (map-fixed-invalidate)
[345.157368] Starting subtest: map-fixed-invalidate
[345.158077] Starting dynamic subtest: gtt
[345.223208] Dynamic subtest gtt: SUCCESS (0.065s)
[345.228441] Starting dynamic subtest: wb
[345.274133] Dynamic subtest wb: SUCCESS (0.051s)
[345.279260] Starting dynamic subtest: wc
[345.324561] Dynamic subtest wc: SUCCESS (0.050s)
[345.330130] Starting dynamic subtest: uc
[345.376728] Dynamic subtest uc: SUCCESS (0.052s)
[345.377415] Subtest map-fixed-invalidate: SUCCESS (0.219s)
[345.488956] [119/137] (675s left) kms_getfb (getfb2-into-addfb2)
[345.538582] Starting subtest: getfb2-into-addfb2
[345.539300] Subtest getfb2-into-addfb2: SUCCESS (0.000s)
[345.633564] [120/137] (674s left) kms_addfb_basic (bad-pitch-128)
[345.685138] Starting subtest: bad-pitch-128
[345.685856] Subtest bad-pitch-128: SUCCESS (0.000s)
[345.831719] [121/137] (674s left) kms_pipe_crc_basic (compare-crc-sanitycheck)
[345.918899] Starting subtest: compare-crc-sanitycheck
[345.920948] Starting dynamic subtest: pipe-A-HDMI-A-2
[346.331746] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (0.412s)
[346.338993] Starting dynamic subtest: pipe-B-HDMI-A-2
[346.920790] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (0.586s)
[346.921486] Subtest compare-crc-sanitycheck: SUCCESS (1.002s)
[347.030144] [122/137] (673s left) kms_vblank (pipe-b-query-forked-busy)
[347.107696] Starting subtest: pipe-B-query-forked-busy
[350.146407] Subtest pipe-B-query-forked-busy: SUCCESS (3.039s)
[350.276353] [123/137] (670s left) dumb_buffer (map-invalid-size)
[350.319553] Starting subtest: map-invalid-size
[350.320276] Subtest map-invalid-size: SUCCESS (0.000s)
[350.431361] [124/137] (670s left) api_intel_allocator (gem-pool)
[350.484075] Starting subtest: gem-pool
[350.486874] Subtest gem-pool: SUCCESS (0.003s)
[350.602511] [125/137] (670s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-render)
[350.692055] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-render
[350.693393] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-render: SKIP (0.000s)
[350.792794] [126/137] (669s left) kms_vrr (flipline)
[350.879931] Starting subtest: flipline
[350.881584] Subtest flipline: SKIP (0.000s)
[350.896650] [127/137] (669s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-mmap-gtt)
[350.976027] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-mmap-gtt
[350.977391] Subtest fbc-2p-scndscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[351.068112] [128/137] (669s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180-async-flip)
[351.160273] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180-async-flip
[351.161684] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SKIP (0.000s)
[351.266364] [129/137] (669s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-blt)
[351.350170] Starting subtest: fbcpsr-rgb101010-draw-blt
[351.351525] Subtest fbcpsr-rgb101010-draw-blt: SKIP (0.000s)
[351.456296] [130/137] (669s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-pwrite)
[351.546180] Starting subtest: fbcpsr-rgb565-draw-pwrite
[351.547499] Subtest fbcpsr-rgb565-draw-pwrite: SKIP (0.000s)
[351.665392] [131/137] (669s left) kms_setmode (basic-clone-single-crtc)
[351.719592] Starting subtest: basic-clone-single-crtc
[351.721624] Subtest basic-clone-single-crtc: SKIP (0.000s)
[351.792694] [132/137] (668s left) gem_ringfill (legacy-basic)
[351.969048] Starting subtest: legacy-basic
[351.970608] Starting dynamic subtest: default
[352.024929] Dynamic subtest default: SUCCESS (0.047s)
[352.043208] Starting dynamic subtest: render
[352.044206] Dynamic subtest render: SUCCESS (0.019s)
[352.052751] Starting dynamic subtest: bsd
[352.059025] Dynamic subtest bsd: SUCCESS (0.020s)
[352.066413] Starting dynamic subtest: bsd1
[352.079392] Dynamic subtest bsd1: SUCCESS (0.020s)
[352.089718] Starting dynamic subtest: blt
[352.101432] Dynamic subtest blt: SUCCESS (0.021s)
[352.112509] Starting dynamic subtest: vebox
[352.126564] Dynamic subtest vebox: SUCCESS (0.024s)
[352.128111] Subtest legacy-basic: SUCCESS (0.158s)
[352.214695] [133/137] (668s left) gem_render_copy_redux (interruptible)
[352.268555] Starting subtest: interruptible
[352.629035] Subtest interruptible: SUCCESS (0.360s)
[352.748198] [134/137] (668s left) syncobj_timeline (multi-wait-submitted-signaled)
[352.801459] Starting subtest: multi-wait-submitted-signaled
[352.802201] Subtest multi-wait-submitted-signaled: SUCCESS (0.000s)
[352.879080] [135/137] (667s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-render)
[352.969120] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-render
[352.970492] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-render: SKIP (0.000s)
[353.090344] [136/137] (667s left) gem_exec_nop (basic-parallel)
[353.149916] Starting subtest: basic-parallel
[356.194942] Subtest basic-parallel: SUCCESS (3.047s)
[356.428869] [137/137] (664s left) kms_ccs (pipe-a-crc-primary-basic-4_tiled_dg2_mc_ccs)
[356.559644] Starting subtest: pipe-A-crc-primary-basic-4_tiled_dg2_mc_ccs
[356.561047] Subtest pipe-A-crc-primary-basic-4_tiled_dg2_mc_ccs: SKIP (0.000s)
[356.772417] Closing watchdogs
Done.