[48.631102] Initializing watchdogs
[48.631400]   /dev/watchdog0
[48.647652] [001/142] (960s left) feature_discovery (display-3x)
[48.974301] Starting subtest: display-3x
[48.977063] Subtest display-3x: SKIP (0.000s)
[49.059375] [002/142] (960s left) gem_eio (create-ext)
[49.305193] Starting subtest: create-ext
[49.364283] Subtest create-ext: SUCCESS (0.059s)
[49.558649] [003/142] (959s left) gem_set_tiling_vs_pwrite
[49.891403] [004/142] (959s left) gem_exec_reloc (basic-cpu-gtt-noreloc)
[50.111988] Starting subtest: basic-cpu-gtt-noreloc
[50.130529] Subtest basic-cpu-gtt-noreloc: SUCCESS (0.020s)
[50.308565] [005/142] (958s left) syncobj_basic (bad-create-flags)
[50.512775] Starting subtest: bad-create-flags
[50.514257] Subtest bad-create-flags: SUCCESS (0.000s)
[50.592275] [006/142] (958s left) kms_cursor_crc (cursor-dpms)
[50.897431] Starting subtest: cursor-dpms
[50.902096] Starting dynamic subtest: pipe-A-DP-1
[52.631101] Dynamic subtest pipe-A-DP-1: SUCCESS (1.726s)
[52.648330] Starting dynamic subtest: pipe-C-DP-1
[54.415824] Dynamic subtest pipe-C-DP-1: SUCCESS (1.780s)
[54.417206] Subtest cursor-dpms: SUCCESS (3.513s)
[54.791242] [007/142] (954s left) gem_exec_fence (basic-busy)
[55.161260] Starting subtest: basic-busy
[55.162736] Starting dynamic subtest: rcs0
[55.188434] Dynamic subtest rcs0: SUCCESS (0.028s)
[55.205262] Starting dynamic subtest: bcs0
[55.212097] Dynamic subtest bcs0: SUCCESS (0.024s)
[55.226814] Starting dynamic subtest: vcs0
[55.236529] Dynamic subtest vcs0: SUCCESS (0.024s)
[55.250571] Starting dynamic subtest: vecs0
[55.268571] Dynamic subtest vecs0: SUCCESS (0.032s)
[55.269914] Subtest basic-busy: SUCCESS (0.109s)
[56.007081] [008/142] (953s left) kms_chamelium_hpd (dp-hpd-fast)
[56.419554] Subtest dp-hpd-fast: SKIP (0.000s)
[56.697899] [009/142] (952s left) perf_pmu (busy-no-semaphores)
[56.907227] Starting subtest: busy-no-semaphores
[56.908963] Starting dynamic subtest: rcs0
[57.444920] Dynamic subtest rcs0: SUCCESS (0.534s)
[57.462886] Starting dynamic subtest: bcs0
[57.972590] Dynamic subtest bcs0: SUCCESS (0.529s)
[57.989702] Starting dynamic subtest: vcs0
[58.498066] Dynamic subtest vcs0: SUCCESS (0.523s)
[58.515815] Starting dynamic subtest: vecs0
[59.028419] Dynamic subtest vecs0: SUCCESS (0.531s)
[59.029926] Subtest busy-no-semaphores: SUCCESS (2.119s)
[59.128617] [010/142] (950s left) i915_pm_rpm (modeset-lpsp)
[61.013183] Starting subtest: modeset-lpsp
[61.369581] Subtest modeset-lpsp: SKIP (0.352s)
[61.839951] [011/142] (947s left) gem_linear_blits (normal)
[63.176293] Starting subtest: normal
[79.638948] Subtest normal: SUCCESS (16.462s)
[79.792367] [012/142] (929s left) perf (blocking)
[80.277740] Starting subtest: blocking
[80.279221] Starting dynamic subtest: 0-rcs0
[90.368907] Dynamic subtest 0-rcs0: SUCCESS (10.088s)
[90.370426] Subtest blocking: SUCCESS (10.088s)
[90.421904] [013/142] (919s left) kms_plane_scaling (plane-downscale-with-pixel-format-factor-0-25)
[90.725102] Starting subtest: plane-downscale-with-pixel-format-factor-0-25
[90.726598] Starting dynamic subtest: pipe-A-DP-1
[90.774594] Dynamic subtest pipe-A-DP-1: SKIP (0.045s)
[90.794275] Starting dynamic subtest: pipe-B-DP-1
[90.869279] Dynamic subtest pipe-B-DP-1: SKIP (0.095s)
[90.889109] Starting dynamic subtest: pipe-C-DP-1
[90.963125] Dynamic subtest pipe-C-DP-1: SKIP (0.089s)
[90.965727] Subtest plane-downscale-with-pixel-format-factor-0-25: SKIP (0.238s)
[91.058269] [014/142] (918s left) gem_exec_reloc (basic-write-wc-active)
[91.272364] Starting subtest: basic-write-wc-active
[91.415807] Subtest basic-write-wc-active: SUCCESS (0.142s)
[91.608116] [015/142] (918s left) kms_ccs (pipe-a-bad-aux-stride-4_tiled_mtl_rc_ccs)
[92.058578] Starting subtest: pipe-A-bad-aux-stride-4_tiled_mtl_rc_ccs
[92.061219] Subtest pipe-A-bad-aux-stride-4_tiled_mtl_rc_ccs: SKIP (0.000s)
[92.583772] [016/142] (917s left) kms_big_fb (linear-addfb)
[92.907368] Starting subtest: linear-addfb
[92.908731] Subtest linear-addfb: SUCCESS (0.000s)
[93.017183] [017/142] (916s left) kms_ccs (pipe-a-random-ccs-data-y_tiled_ccs)
[93.441643] Starting subtest: pipe-A-random-ccs-data-y_tiled_ccs
[93.877281] Subtest pipe-A-random-ccs-data-y_tiled_ccs: SUCCESS (0.433s)
[94.560689] [018/142] (915s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-mmap-wc)
[94.872332] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-mmap-wc
[94.874943] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[94.978072] [019/142] (914s left) gem_userptr_blits (map-fixed-invalidate-overlap-busy)
[95.225630] Starting subtest: map-fixed-invalidate-overlap-busy
[95.227089] Starting dynamic subtest: gtt
[99.145185] Dynamic subtest gtt: SUCCESS (3.919s)
[99.164867] Starting dynamic subtest: wb
[103.125239] Dynamic subtest wb: SUCCESS (3.979s)
[103.143591] Starting dynamic subtest: wc
[107.143557] Dynamic subtest wc: SUCCESS (4.019s)
[107.163036] Starting dynamic subtest: uc
[111.187084] Dynamic subtest uc: SUCCESS (4.043s)
[111.188436] Subtest map-fixed-invalidate-overlap-busy: SUCCESS (15.962s)
[111.311416] [020/142] (898s left) gem_ppgtt (shrink-vs-evict-pinned)
[111.522425] Starting subtest: shrink-vs-evict-pinned
[116.608036] Subtest shrink-vs-evict-pinned: SUCCESS (5.082s)
[116.676466] [021/142] (893s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence)
[116.971963] Starting subtest: nonblocking-crc-frame-sequence
[116.973435] Starting dynamic subtest: pipe-A-DP-1
[117.568426] Dynamic subtest pipe-A-DP-1: SUCCESS (0.596s)
[117.588067] Starting dynamic subtest: pipe-B-DP-1
[118.469847] Dynamic subtest pipe-B-DP-1: SUCCESS (0.899s)
[118.490526] Starting dynamic subtest: pipe-C-DP-1
[119.517783] Dynamic subtest pipe-C-DP-1: SUCCESS (1.045s)
[119.519810] Subtest nonblocking-crc-frame-sequence: SUCCESS (2.549s)
[119.833696] [022/142] (890s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytile-upscaling)
[120.136962] Starting subtest: flip-64bpp-ytile-to-32bpp-ytile-upscaling
[120.139177] Starting dynamic subtest: pipe-A-valid-mode
[120.616143] Dynamic subtest pipe-A-valid-mode: SKIP (0.477s)
[120.618681] Subtest flip-64bpp-ytile-to-32bpp-ytile-upscaling: SKIP (0.479s)
[120.987510] [023/142] (888s left) syncobj_timeline (single-wait-all-available-signaled)
[121.191829] Starting subtest: single-wait-all-available-signaled
[121.193664] Subtest single-wait-all-available-signaled: SUCCESS (0.001s)
[121.286990] [024/142] (888s left) kms_cursor_crc (cursor-sliding-128x42)
[121.605431] Starting subtest: cursor-sliding-128x42
[121.616981] Starting dynamic subtest: pipe-A-DP-1
[125.498401] Dynamic subtest pipe-A-DP-1: SUCCESS (3.879s)
[125.582666] Starting dynamic subtest: pipe-C-DP-1
[129.573952] Dynamic subtest pipe-C-DP-1: SUCCESS (4.014s)
[129.577225] Subtest cursor-sliding-128x42: SUCCESS (7.968s)
[129.944861] [025/142] (880s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-mmap-wc)
[130.257197] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-mmap-wc
[130.259899] Subtest psr-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[130.358472] [026/142] (879s left) gem_mmap_gtt (close-race)
[130.564625] Starting subtest: close-race
[150.674841] Subtest close-race: SUCCESS (20.108s)
[150.775619] [027/142] (859s left) gem_eio (execbuf)
[150.996772] Starting subtest: execbuf
[151.038283] Subtest execbuf: SUCCESS (0.043s)
[151.242288] [028/142] (858s left) kms_chamelium_edid (dp-mode-timings)
[151.653810] Subtest dp-mode-timings: SKIP (0.000s)
[151.950234] [029/142] (858s left) kms_flip (plain-flip-interruptible)
[152.252183] Starting subtest: plain-flip-interruptible
[152.257621] Starting dynamic subtest: A-DP1
[153.470741] Dynamic subtest A-DP1: SUCCESS (1.199s)
[153.498321] Starting dynamic subtest: B-DP1
[154.582671] Dynamic subtest B-DP1: SUCCESS (1.124s)
[154.605641] Starting dynamic subtest: C-DP1
[155.687260] Dynamic subtest C-DP1: SUCCESS (1.102s)
[155.692216] Subtest plain-flip-interruptible: SUCCESS (3.437s)
[156.108833] [030/142] (854s left) gem_ctx_persistence (saturated-hostile)
[156.324048] Starting subtest: saturated-hostile
[156.325538] Starting dynamic subtest: rcs0
[156.445423] Dynamic subtest rcs0: SUCCESS (0.121s)
[156.465256] Starting dynamic subtest: bcs0
[156.564858] Dynamic subtest bcs0: SUCCESS (0.119s)
[156.584507] Starting dynamic subtest: vcs0
[156.676918] Dynamic subtest vcs0: SUCCESS (0.111s)
[156.699159] Starting dynamic subtest: vecs0
[156.802698] Dynamic subtest vecs0: SUCCESS (0.125s)
[156.804079] Subtest saturated-hostile: SUCCESS (0.479s)
[156.923422] [031/142] (853s left) gen3_render_linear_blits
[157.188299] [032/142] (853s left) kms_force_connector_basic (force-load-detect)
[157.389758] Subtest force-load-detect: SKIP (0.000s)
[157.438989] [033/142] (852s left) kms_ccs (pipe-a-ccs-on-another-bo-y_tiled_gen12_rc_ccs)
[157.882462] Starting subtest: pipe-A-ccs-on-another-bo-y_tiled_gen12_rc_ccs
[157.885162] Subtest pipe-A-ccs-on-another-bo-y_tiled_gen12_rc_ccs: SKIP (0.000s)
[158.424669] [034/142] (851s left) gem_exec_params (invalid-bsd2-flag-on-vebox)
[158.636821] Starting subtest: invalid-bsd2-flag-on-vebox
[158.638704] Subtest invalid-bsd2-flag-on-vebox: SUCCESS (0.001s)
[158.740699] [035/142] (851s left) kms_hdr (static-toggle-dpms)
[159.038635] Starting subtest: static-toggle-dpms
[159.041233] Subtest static-toggle-dpms: SKIP (0.000s)
[159.124244] [036/142] (851s left) syncobj_timeline (host-signal-points)
[159.326871] Starting subtest: host-signal-points
[159.346141] Subtest host-signal-points: SUCCESS (0.020s)
[159.440917] [037/142] (851s left) drm_fdinfo (virtual-busy-idle)
[159.651472] Starting subtest: virtual-busy-idle
[162.235352] Subtest virtual-busy-idle: SUCCESS (2.583s)
[162.323607] [038/142] (848s left) kms_ccs (pipe-b-bad-pixel-format-yf_tiled_ccs)
[162.793925] Starting subtest: pipe-B-bad-pixel-format-yf_tiled_ccs
[162.795429] Subtest pipe-B-bad-pixel-format-yf_tiled_ccs: SUCCESS (0.001s)
[163.308399] [039/142] (847s left) prime_vgem (basic-fence-blt)
[163.530464] Starting subtest: basic-fence-blt
[163.659274] Subtest basic-fence-blt: SUCCESS (0.127s)
[163.775979] [040/142] (846s left) kms_flip (plain-flip-ts-check)
[164.052993] Starting subtest: plain-flip-ts-check
[164.054503] Starting dynamic subtest: A-DP1
[174.892401] Dynamic subtest A-DP1: SUCCESS (10.838s)
[174.914348] Starting dynamic subtest: B-DP1
[185.650837] Dynamic subtest B-DP1: SUCCESS (10.755s)
[185.671243] Starting dynamic subtest: C-DP1
[196.394265] Dynamic subtest C-DP1: SUCCESS (10.742s)
[196.397804] Subtest plain-flip-ts-check: SUCCESS (32.345s)
[196.821453] [041/142] (813s left) prime_self_import (basic-llseek-size)
[197.016260] Starting subtest: basic-llseek-size
[197.022679] Subtest basic-llseek-size: SUCCESS (0.007s)
[197.135264] [042/142] (813s left) gem_render_copy (y-tiled-ccs-to-y-tiled)
[197.357739] Starting subtest: y-tiled-ccs-to-y-tiled
[197.359432] Starting dynamic subtest: smem
[197.655509] Dynamic subtest smem: SUCCESS (0.296s)
[197.657040] Subtest y-tiled-ccs-to-y-tiled: SUCCESS (0.297s)
[197.853949] [043/142] (812s left) syncobj_wait (wait-for-submit-complex)
[198.060797] Starting subtest: wait-for-submit-complex
[198.125290] Subtest wait-for-submit-complex: SUCCESS (0.063s)
[198.218457] [044/142] (812s left) i915_pm_rpm (fences-dpms)
[200.007872] Starting subtest: fences-dpms
[202.853748] Subtest fences-dpms: SUCCESS (2.846s)
[203.080659] [045/142] (807s left) kms_plane_scaling (plane-upscale-with-rotation-factor-0-25)
[203.383212] Starting subtest: plane-upscale-with-rotation-factor-0-25
[203.384543] Starting dynamic subtest: pipe-A-DP-1
[203.437764] Dynamic subtest pipe-A-DP-1: SKIP (0.053s)
[203.459548] Starting dynamic subtest: pipe-B-DP-1
[203.783818] Dynamic subtest pipe-B-DP-1: SKIP (0.340s)
[203.803705] Starting dynamic subtest: pipe-C-DP-1
[204.133321] Dynamic subtest pipe-C-DP-1: SKIP (0.347s)
[204.136138] Subtest plane-upscale-with-rotation-factor-0-25: SKIP (0.751s)
[204.538126] [046/142] (806s left) gem_exec_whisper (basic-contexts-priority-all)
[204.765334] Starting subtest: basic-contexts-priority-all
[228.734333] Subtest basic-contexts-priority-all: SUCCESS (23.966s)
[228.940089] [047/142] (781s left) gem_workarounds (suspend-resume-context)
[229.176837] Starting subtest: suspend-resume-context
[245.759441] Subtest suspend-resume-context: SUCCESS (1.580s)
[250.883424] [048/142] (780s left) gem_exec_balancer (invalid-bonds)
[251.116484] Starting subtest: invalid-bonds
[251.130334] Subtest invalid-bonds: SUCCESS (0.014s)
[255.041428] [049/142] (775s left) kms_cursor_legacy (short-busy-flip-before-cursor-atomic-transitions)
[255.344289] Starting subtest: short-busy-flip-before-cursor-atomic-transitions
[255.347202] Subtest short-busy-flip-before-cursor-atomic-transitions: SKIP (0.000s)
[255.441256] [050/142] (775s left) kms_ccs (pipe-b-bad-rotation-90-y_tiled_gen12_rc_ccs)
[255.920517] Starting subtest: pipe-B-bad-rotation-90-y_tiled_gen12_rc_ccs
[255.924839] Subtest pipe-B-bad-rotation-90-y_tiled_gen12_rc_ccs: SKIP (0.000s)
[256.439811] [051/142] (774s left) vc4/vc4_purgeable_bo (mark-unpurgeable-purged)
[256.694688] Subtest mark-unpurgeable-purged: SKIP (0.000s)
[256.772097] [052/142] (774s left) kms_frontbuffer_tracking (fbc-suspend)
[257.076576] Starting subtest: fbc-suspend
[294.950525] Subtest fbc-suspend: SUCCESS (6.069s)
[295.942186] [053/142] (767s left) gem_watchdog (default-virtual)
[296.172507] Starting subtest: default-virtual
[297.451411] Subtest default-virtual: SUCCESS (1.279s)
[297.531034] [054/142] (766s left) kms_ccs (pipe-c-crc-primary-basic-4_tiled_dg2_rc_ccs)
[298.145114] Starting subtest: pipe-C-crc-primary-basic-4_tiled_dg2_rc_ccs
[298.150178] Subtest pipe-C-crc-primary-basic-4_tiled_dg2_rc_ccs: SKIP (0.002s)
[298.552432] [055/142] (765s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-pwrite)
[298.869107] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-pwrite
[300.972622] Subtest fbc-1p-primscrn-spr-indfb-draw-pwrite: SUCCESS (2.106s)
[301.136701] [056/142] (762s left) vc4/vc4_perfmon (create-perfmon-0)
[301.390394] Subtest create-perfmon-0: SKIP (0.000s)
[301.468307] [057/142] (762s left) gen9_exec_parse (batch-zero-length)
[301.698173] Starting subtest: batch-zero-length
[301.701734] Subtest batch-zero-length: SUCCESS (0.002s)
[301.935316] [058/142] (762s left) kms_frontbuffer_tracking (fbc-1p-offscren-pri-shrfb-draw-mmap-gtt)
[302.249260] Starting subtest: fbc-1p-offscren-pri-shrfb-draw-mmap-gtt
[304.107643] Subtest fbc-1p-offscren-pri-shrfb-draw-mmap-gtt: SUCCESS (1.862s)
[304.251806] [059/142] (759s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-move)
[304.569179] Starting subtest: psr-2p-scndscrn-spr-indfb-move
[304.571878] Subtest psr-2p-scndscrn-spr-indfb-move: SKIP (0.000s)
[304.685645] [060/142] (759s left) kms_vblank (pipe-b-query-forked-hang)
[304.986274] Starting subtest: pipe-B-query-forked-hang
[312.778467] Subtest pipe-B-query-forked-hang: SUCCESS (7.791s)
[313.129646] [061/142] (750s left) kms_big_fb (yf-tiled-16bpp-rotate-90)
[313.452086] Starting subtest: yf-tiled-16bpp-rotate-90
[313.543048] Subtest yf-tiled-16bpp-rotate-90: SKIP (0.088s)
[313.662351] [062/142] (750s left) gem_lmem_swapping (basic)
[313.873090] Subtest basic: SKIP (0.000s)
[313.926834] [063/142] (750s left) gem_mmap_wc (write-cpu-read-wc-unflushed)
[314.125649] Starting subtest: write-cpu-read-wc-unflushed
[314.391948] Subtest write-cpu-read-wc-unflushed: SUCCESS (0.265s)
[314.478140] [064/142] (749s left) kms_frontbuffer_tracking (psr-1p-offscren-pri-indfb-draw-mmap-gtt)
[314.793536] Starting subtest: psr-1p-offscren-pri-indfb-draw-mmap-gtt
[314.796269] Subtest psr-1p-offscren-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[314.912035] [065/142] (749s left) vgem_basic (bad-pad)
[315.132397] Starting subtest: bad-pad
[315.133804] Subtest bad-pad: SUCCESS (0.000s)
[315.212142] [066/142] (749s left) kms_psr2_su (frontbuffer-xrgb8888)
[315.413837] Subtest frontbuffer-XRGB8888: SKIP (0.000s)
[315.478215] [067/142] (748s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-0-async-flip)
[315.807426] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-0-async-flip
[316.948609] Subtest y-tiled-max-hw-stride-64bpp-rotate-0-async-flip: SUCCESS (1.140s)
[317.296675] [068/142] (747s left) kms_chamelium_hpd (vga-hpd-without-ddc)
[317.701277] Subtest vga-hpd-without-ddc: SKIP (0.000s)
[318.001378] [069/142] (746s left) kms_ccs (pipe-d-bad-rotation-90-4_tiled_mtl_mc_ccs)
[318.683784] Subtest pipe-D-bad-rotation-90-4_tiled_mtl_mc_ccs: SKIP (0.000s)
[319.005807] [070/142] (745s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-onoff)
[319.312317] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-onoff
[319.315055] Subtest fbcpsr-2p-primscrn-spr-indfb-onoff: SKIP (0.000s)
[319.422570] [071/142] (745s left) perf (gen12-group-exclusive-stream-sample-oa)
[319.714664] Starting subtest: gen12-group-exclusive-stream-sample-oa
[319.717393] Subtest gen12-group-exclusive-stream-sample-oa: SKIP (0.000s)
[319.773354] [072/142] (744s left) kms_big_fb (4-tiled-8bpp-rotate-180)
[320.094664] Starting subtest: 4-tiled-8bpp-rotate-180
[320.098751] Subtest 4-tiled-8bpp-rotate-180: SKIP (0.000s)
[320.189922] [073/142] (744s left) gem_ctx_isolation (preservation-reset)
[320.529135] Starting subtest: preservation-reset
[320.530812] Starting dynamic subtest: rcs0
[321.748554] Dynamic subtest rcs0: SUCCESS (1.217s)
[321.775736] Starting dynamic subtest: bcs0
[323.228123] Dynamic subtest bcs0: SUCCESS (1.478s)
[323.254202] Starting dynamic subtest: vcs0
[324.362447] Dynamic subtest vcs0: SUCCESS (1.133s)
[324.386943] Starting dynamic subtest: vecs0
[325.432743] Dynamic subtest vecs0: SUCCESS (1.068s)
[325.434177] Subtest preservation-reset: SUCCESS (4.905s)
[325.574030] [074/142] (739s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-move)
[325.881019] Starting subtest: psr-1p-primscrn-spr-indfb-move
[325.883684] Subtest psr-1p-primscrn-spr-indfb-move: SKIP (0.000s)
[326.005552] [075/142] (738s left) kms_ccs (pipe-c-missing-ccs-buffer-yf_tiled_ccs)
[326.656477] Starting subtest: pipe-C-missing-ccs-buffer-yf_tiled_ccs
[326.660289] Subtest pipe-C-missing-ccs-buffer-yf_tiled_ccs: SKIP (0.000s)
[327.026974] [076/142] (737s left) kms_vblank (pipe-d-query-busy)
[327.335600] Subtest pipe-D-query-busy: SKIP (0.000s)
[327.427270] [077/142] (737s left) kms_getfb (getfb-addfb-different-handles)
[327.634363] Starting subtest: getfb-addfb-different-handles
[327.636322] Subtest getfb-addfb-different-handles: SUCCESS (0.000s)
[327.744315] [078/142] (737s left) kms_flip (basic-flip-vs-modeset)
[328.036933] Starting subtest: basic-flip-vs-modeset
[328.038522] Starting dynamic subtest: A-DP1
[329.363365] Dynamic subtest A-DP1: SUCCESS (1.321s)
[329.389339] Starting dynamic subtest: B-DP1
[330.530227] Dynamic subtest B-DP1: SUCCESS (1.166s)
[330.556120] Starting dynamic subtest: C-DP1
[331.710846] Dynamic subtest C-DP1: SUCCESS (1.178s)
[331.712666] Subtest basic-flip-vs-modeset: SUCCESS (3.677s)
[332.071547] [079/142] (732s left) kms_vblank (pipe-b-query-busy)
[332.379253] Starting subtest: pipe-B-query-busy
[335.282663] Subtest pipe-B-query-busy: SUCCESS (2.905s)
[335.625323] [080/142] (729s left) kms_flip_scaled_crc (flip-32bpp-yftileccs-to-64bpp-yftile-upscaling)
[335.926118] Starting subtest: flip-32bpp-yftileccs-to-64bpp-yftile-upscaling
[335.927466] Starting dynamic subtest: pipe-A-valid-mode
[336.040343] Dynamic subtest pipe-A-valid-mode: SKIP (0.110s)
[336.043173] Subtest flip-32bpp-yftileccs-to-64bpp-yftile-upscaling: SKIP (0.114s)
[336.378663] [081/142] (728s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-mmap-cpu)
[336.686140] Starting subtest: psr-1p-primscrn-pri-indfb-draw-mmap-cpu
[336.688690] Subtest psr-1p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[336.794595] [082/142] (728s left) gem_basic (create-close)
[337.001299] Starting subtest: create-close
[337.004404] Subtest create-close: SUCCESS (0.000s)
[337.109918] [083/142] (728s left) v3d/v3d_job_submission (threaded-job-submission)
[337.365053] Subtest threaded-job-submission: SKIP (0.000s)
[337.443496] [084/142] (727s left) kms_psr (sprite_blt)
[337.646342] Subtest sprite_blt: SKIP (0.000s)
[337.709215] [085/142] (727s left) kms_plane_cursor (primary)
[338.012778] Starting subtest: primary
[338.015656] Starting dynamic subtest: pipe-A-DP-1-size-64
[340.428975] Dynamic subtest pipe-A-DP-1-size-64: SUCCESS (2.417s)
[340.487526] Starting dynamic subtest: pipe-A-DP-1-size-128
[342.878903] Dynamic subtest pipe-A-DP-1-size-128: SUCCESS (2.415s)
[342.938978] Starting dynamic subtest: pipe-A-DP-1-size-256
[345.329037] Dynamic subtest pipe-A-DP-1-size-256: SUCCESS (2.415s)
[345.491048] Starting dynamic subtest: pipe-B-DP-1-size-64
[348.100182] Dynamic subtest pipe-B-DP-1-size-64: SUCCESS (2.635s)
[348.164313] Starting dynamic subtest: pipe-B-DP-1-size-128
[350.550241] Dynamic subtest pipe-B-DP-1-size-128: SUCCESS (2.415s)
[350.611987] Starting dynamic subtest: pipe-B-DP-1-size-256
[353.000008] Dynamic subtest pipe-B-DP-1-size-256: SUCCESS (2.415s)
[353.159289] Starting dynamic subtest: pipe-C-DP-1-size-64
[355.784968] Dynamic subtest pipe-C-DP-1-size-64: SUCCESS (2.649s)
[355.843989] Starting dynamic subtest: pipe-C-DP-1-size-128
[358.235700] Dynamic subtest pipe-C-DP-1-size-128: SUCCESS (2.415s)
[358.293174] Starting dynamic subtest: pipe-C-DP-1-size-256
[360.685068] Dynamic subtest pipe-C-DP-1-size-256: SUCCESS (2.415s)
[360.822459] Subtest primary: SUCCESS (22.811s)
[361.138992] [086/142] (704s left) gem_mmap_wc (coherency)
[361.345418] Starting subtest: coherency
[361.501267] Subtest coherency: SUCCESS (0.155s)
[361.621429] [087/142] (703s left) kms_vblank (pipe-b-wait-forked-busy)
[361.919093] Starting subtest: pipe-B-wait-forked-busy
[364.781392] Subtest pipe-B-wait-forked-busy: SUCCESS (2.866s)
[365.134844] [088/142] (700s left) gem_tiled_pread_basic
[365.700800] [089/142] (699s left) dmabuf (all-tests)
[365.904683] Starting subtest: all-tests
[365.906163] Starting dynamic subtest: sanitycheck
[365.982145] Dynamic subtest sanitycheck: SUCCESS (0.074s)
[366.010911] Starting dynamic subtest: dma_fence
[366.177913] Dynamic subtest dma_fence: SUCCESS (0.192s)
[366.204984] Starting dynamic subtest: dma_fence_chain
[389.731907] Dynamic subtest dma_fence_chain: SUCCESS (23.550s)
[389.760415] Starting dynamic subtest: dma_fence_unwrap
[389.808651] Dynamic subtest dma_fence_unwrap: SUCCESS (0.075s)
[389.842217] Starting dynamic subtest: dma_resv
[389.882702] Dynamic subtest dma_resv: SUCCESS (0.071s)
[389.884591] Subtest all-tests: SUCCESS (23.980s)
[389.966049] [090/142] (675s left) api_intel_allocator (fork-simple-stress)
[390.168608] Starting subtest: fork-simple-stress
[395.684038] Subtest fork-simple-stress: SUCCESS (5.513s)
[395.785922] [091/142] (669s left) sw_sync (timeline_closed_signaled)
[395.986390] Starting subtest: timeline_closed_signaled
[395.988127] Subtest timeline_closed_signaled: SUCCESS (0.001s)
[396.067037] [092/142] (669s left) gem_exec_flush (basic-uc-pro-default)
[396.293213] Starting subtest: basic-uc-pro-default
[401.762175] Subtest basic-uc-pro-default: SUCCESS (5.469s)
[401.970458] [093/142] (663s left) kms_ccs (pipe-a-crc-primary-rotation-180-4_tiled_mtl_rc_ccs_cc)
[402.388136] Starting subtest: pipe-A-crc-primary-rotation-180-4_tiled_mtl_rc_ccs_cc
[402.390923] Subtest pipe-A-crc-primary-rotation-180-4_tiled_mtl_rc_ccs_cc: SKIP (0.001s)
[402.986928] [094/142] (662s left) gem_softpin (allocator-nopin-reserve)
[403.199455] Starting subtest: allocator-nopin-reserve
[403.444005] Subtest allocator-nopin-reserve: SUCCESS (0.241s)
[403.573043] [095/142] (662s left) gem_userptr_blits (invalid-mmap-offset-unsync)
[403.787512] Subtest invalid-mmap-offset-unsync: SKIP (0.000s)
[403.956430] [096/142] (661s left) kms_vblank (crtc-id)
[404.268266] Starting subtest: crtc-id
[404.571025] Subtest crtc-id: SUCCESS (0.305s)
[404.915356] [097/142] (660s left) kms_ccs (pipe-d-random-ccs-data-y_tiled_gen12_rc_ccs)
[405.610326] Subtest pipe-D-random-ccs-data-y_tiled_gen12_rc_ccs: SKIP (0.000s)
[405.944703] [098/142] (659s left) kms_flip (2x-modeset-vs-vblank-race)
[406.235204] Starting subtest: 2x-modeset-vs-vblank-race
[406.237824] Subtest 2x-modeset-vs-vblank-race: SKIP (0.003s)
[406.362314] [099/142] (659s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-mmap-wc)
[406.675215] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-mmap-wc
[406.678170] Subtest psr-2p-scndscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[406.778360] [100/142] (659s left) kms_big_fb (4-tiled-16bpp-rotate-0)
[407.097547] Starting subtest: 4-tiled-16bpp-rotate-0
[407.100895] Subtest 4-tiled-16bpp-rotate-0: SKIP (0.000s)
[407.194936] [101/142] (658s left) v3d/v3d_submit_cl (single-in-sync)
[407.448643] Subtest single-in-sync: SKIP (0.000s)
[407.527405] [102/142] (658s left) sysfs_preempt_timeout (idempotent)
[407.738812] Starting subtest: idempotent
[407.743243] Starting dynamic subtest: vecs0
[407.744971] Dynamic subtest vecs0: SUCCESS (0.002s)
[407.773355] Starting dynamic subtest: vcs0
[407.774696] Dynamic subtest vcs0: SUCCESS (0.002s)
[407.799482] Starting dynamic subtest: bcs0
[407.800830] Dynamic subtest bcs0: SUCCESS (0.002s)
[407.825171] Starting dynamic subtest: rcs0
[407.826561] Dynamic subtest rcs0: SUCCESS (0.002s)
[407.827915] Subtest idempotent: SUCCESS (0.021s)
[407.862934] [103/142] (658s left) syncobj_wait (single-wait-submitted)
[408.068391] Starting subtest: single-wait-submitted
[408.171234] Subtest single-wait-submitted: SUCCESS (0.101s)
[408.261081] [104/142] (657s left) kms_dsc (dsc-with-output-formats)
[408.571663] Subtest dsc-with-output-formats: SKIP (0.000s)
[408.627556] [105/142] (657s left) gem_userptr_blits (map-fixed-invalidate)
[408.871215] Starting subtest: map-fixed-invalidate
[408.872630] Starting dynamic subtest: gtt
[409.229205] Dynamic subtest gtt: SUCCESS (0.355s)
[409.259397] Starting dynamic subtest: wb
[409.511961] Dynamic subtest wb: SUCCESS (0.279s)
[409.540916] Starting dynamic subtest: wc
[409.789668] Dynamic subtest wc: SUCCESS (0.274s)
[409.822049] Starting dynamic subtest: uc
[410.072819] Dynamic subtest uc: SUCCESS (0.280s)
[410.074561] Subtest map-fixed-invalidate: SUCCESS (1.201s)
[410.211796] [106/142] (655s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-wc)
[410.520023] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-wc
[410.523022] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[410.645283] [107/142] (655s left) gem_ctx_param (vm)
[410.850200] Starting subtest: vm
[410.912419] Subtest vm: SUCCESS (0.062s)
[411.027565] [108/142] (655s left) kms_cursor_legacy (cursora-vs-flipb-atomic-transitions)
[411.326874] Starting subtest: cursorA-vs-flipB-atomic-transitions
[411.329759] Subtest cursorA-vs-flipB-atomic-transitions: SKIP (0.003s)
[411.428255] [109/142] (654s left) kms_ccs (pipe-c-bad-pixel-format-4_tiled_mtl_rc_ccs_cc)
[412.007858] Starting subtest: pipe-C-bad-pixel-format-4_tiled_mtl_rc_ccs_cc
[412.010688] Subtest pipe-C-bad-pixel-format-4_tiled_mtl_rc_ccs_cc: SKIP (0.000s)
[412.427379] [110/142] (653s left) gem_userptr_blits (access-control)
[412.703236] Starting subtest: access-control
[412.706354] Subtest access-control: SKIP (0.000s)
[412.828179] [111/142] (653s left) kms_big_fb (x-tiled-64bpp-rotate-90)
[413.153221] Starting subtest: x-tiled-64bpp-rotate-90
[413.238909] Subtest x-tiled-64bpp-rotate-90: SKIP (0.083s)
[413.363901] [112/142] (653s left) api_intel_bb (delta-check)
[413.570066] Starting subtest: delta-check
[413.578639] Subtest delta-check: SUCCESS (0.009s)
[413.694879] [113/142] (652s left) gem_create (create-ext-cpu-access-sanity-check)
[414.033840] Starting subtest: create-ext-cpu-access-sanity-check
[414.036552] Subtest create-ext-cpu-access-sanity-check: SKIP (0.001s)
[414.127445] [114/142] (652s left) kms_addfb_basic (basic-x-tiled-legacy)
[414.333189] Starting subtest: basic-x-tiled-legacy
[414.334737] Subtest basic-x-tiled-legacy: SUCCESS (0.000s)
[414.544395] [115/142] (652s left) gem_exec_reloc (basic-write-read-noreloc)
[414.758688] Starting subtest: basic-write-read-noreloc
[414.766323] Subtest basic-write-read-noreloc: SUCCESS (0.007s)
[414.960869] [116/142] (651s left) kms_ccs (pipe-d-crc-sprite-planes-basic-4_tiled_mtl_rc_ccs)
[415.643406] Subtest pipe-D-crc-sprite-planes-basic-4_tiled_mtl_rc_ccs: SKIP (0.000s)
[415.966277] [117/142] (650s left) gem_exec_fence (syncobj-repeat)
[416.642924] Starting subtest: syncobj-repeat
[417.499211] Subtest syncobj-repeat: SUCCESS (0.858s)
[417.850312] [118/142] (648s left) kms_ccs (pipe-b-crc-sprite-planes-basic-4_tiled_dg2_rc_ccs)
[418.416257] Starting subtest: pipe-B-crc-sprite-planes-basic-4_tiled_dg2_rc_ccs
[418.422541] Subtest pipe-B-crc-sprite-planes-basic-4_tiled_dg2_rc_ccs: SKIP (0.005s)
[418.859497] [119/142] (647s left) kms_cursor_crc (cursor-onscreen-64x64)
[419.165150] Starting subtest: cursor-onscreen-64x64
[419.175530] Starting dynamic subtest: pipe-A-DP-1
[421.512413] Dynamic subtest pipe-A-DP-1: SUCCESS (2.333s)
[421.598545] Starting dynamic subtest: pipe-C-DP-1
[424.249177] Dynamic subtest pipe-C-DP-1: SUCCESS (2.673s)
[424.250607] Subtest cursor-onscreen-64x64: SUCCESS (5.085s)
[424.623521] [120/142] (642s left) kms_rotation_crc (primary-4-tiled-reflect-x-180)
[424.929047] Starting subtest: primary-4-tiled-reflect-x-180
[424.931750] Subtest primary-4-tiled-reflect-x-180: SKIP (0.003s)
[425.020974] [121/142] (641s left) gem_render_copy (yf-tiled-ccs-to-x-tiled)
[425.243142] Starting subtest: yf-tiled-ccs-to-x-tiled
[425.244682] Starting dynamic subtest: smem
[425.556970] Dynamic subtest smem: SUCCESS (0.310s)
[425.558260] Subtest yf-tiled-ccs-to-x-tiled: SUCCESS (0.313s)
[425.773427] [122/142] (641s left) kms_invalid_mode (int-max-clock)
[426.077946] Starting subtest: int-max-clock
[426.079544] Starting dynamic subtest: DP-1-pipe-A
[426.180497] Dynamic subtest DP-1-pipe-A: SUCCESS (0.104s)
[426.208658] Starting dynamic subtest: DP-1-pipe-B
[426.210048] Dynamic subtest DP-1-pipe-B: SUCCESS (0.014s)
[426.235151] Starting dynamic subtest: DP-1-pipe-C
[426.236385] Dynamic subtest DP-1-pipe-C: SUCCESS (0.014s)
[426.237649] Subtest int-max-clock: SUCCESS (0.145s)
[426.583134] [123/142] (640s left) syncobj_timeline (etime-multi-wait-all-for-submit-available-unsubmitted-submi
[426.788349] Starting subtest: etime-multi-wait-all-for-submit-available-unsubmitted-submitted
[426.898891] Subtest etime-multi-wait-all-for-submit-available-unsubmitted-submitted: SUCCESS (0.109s)
[426.999411] [124/142] (640s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-render)
[427.317132] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-render
[427.319699] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-render: SKIP (0.000s)
[427.417594] [125/142] (639s left) kms_plane_scaling (planes-upscale-factor-0-25-downscale-factor-0-25)
[427.713482] Starting subtest: planes-upscale-factor-0-25-downscale-factor-0-25
[427.714966] Starting dynamic subtest: pipe-A-DP-1
[427.746323] Dynamic subtest pipe-A-DP-1: SKIP (0.031s)
[427.792038] Starting dynamic subtest: pipe-B-DP-1
[427.832138] Dynamic subtest pipe-B-DP-1: SKIP (0.081s)
[427.860234] Starting dynamic subtest: pipe-C-DP-1
[427.916368] Dynamic subtest pipe-C-DP-1: SKIP (0.079s)
[427.918936] Subtest planes-upscale-factor-0-25-downscale-factor-0-25: SKIP (0.206s)
[428.034173] [126/142] (639s left) syncobj_timeline (multi-wait-for-submit-available-submitted-signaled)
[428.240885] Starting subtest: multi-wait-for-submit-available-submitted-signaled
[428.245560] Subtest multi-wait-for-submit-available-submitted-signaled: SUCCESS (0.003s)
[428.349425] [127/142] (638s left) gem_exec_schedule (preempt-hang)
[428.704395] Starting subtest: preempt-hang
[428.705917] Starting dynamic subtest: rcs0
[428.989546] Dynamic subtest rcs0: SUCCESS (0.283s)
[429.022020] Starting dynamic subtest: bcs0
[429.279226] Dynamic subtest bcs0: SUCCESS (0.287s)
[429.311225] Starting dynamic subtest: vcs0
[429.552161] Dynamic subtest vcs0: SUCCESS (0.269s)
[429.579749] Starting dynamic subtest: vecs0
[429.822624] Dynamic subtest vecs0: SUCCESS (0.268s)
[429.825322] Subtest preempt-hang: SUCCESS (1.120s)
[430.068120] [128/142] (637s left) gem_pxp (create-protected-buffer)
[432.798796] Subtest create-protected-buffer: SKIP (0.000s)
[432.899154] [129/142] (634s left) i915_pm_dc (dc6-psr)
[434.210913] Starting subtest: dc6-psr
[434.215004] Subtest dc6-psr: SKIP (0.000s)
[434.383986] [130/142] (632s left) gem_exec_gttfill (engines)
[434.616604] Starting subtest: engines
[434.618268] Starting dynamic subtest: rcs0
[471.145631] Dynamic subtest rcs0: SUCCESS (36.529s)
[471.173838] Starting dynamic subtest: bcs0
[509.152106] Dynamic subtest bcs0: SUCCESS (38.003s)
[509.177095] Starting dynamic subtest: vcs0
[545.185549] Dynamic subtest vcs0: SUCCESS (36.032s)
[545.210942] Starting dynamic subtest: vecs0
[581.689413] Dynamic subtest vecs0: SUCCESS (36.501s)
[581.690836] Subtest engines: SUCCESS (147.075s)
[581.904083] [131/142] (485s left) kms_big_fb (y-tiled-16bpp-rotate-270)
[582.375501] Starting subtest: y-tiled-16bpp-rotate-270
[582.488059] Subtest y-tiled-16bpp-rotate-270: SKIP (0.109s)
[582.619345] [132/142] (484s left) syncobj_wait (single-wait-all-submitted)
[582.852456] Starting subtest: single-wait-all-submitted
[582.956581] Subtest single-wait-all-submitted: SUCCESS (0.102s)
[583.051136] [133/142] (484s left) kms_ccs (pipe-c-bad-aux-stride-yf_tiled_ccs)
[583.739152] Starting subtest: pipe-C-bad-aux-stride-yf_tiled_ccs
[583.741865] Subtest pipe-C-bad-aux-stride-yf_tiled_ccs: SKIP (0.000s)
[584.076793] [134/142] (483s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-onoff)
[584.395347] Starting subtest: fbc-2p-primscrn-cur-indfb-onoff
[584.398514] Subtest fbc-2p-primscrn-cur-indfb-onoff: SKIP (0.000s)
[584.510181] [135/142] (483s left) perf_pmu (interrupts-sync)
[584.733695] Starting subtest: interrupts-sync
[585.852815] Subtest interrupts-sync: SUCCESS (1.117s)
[585.975284] [136/142] (481s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-shrfb-msflip-blt)
[586.285696] Starting subtest: fbc-2p-scndscrn-shrfb-msflip-blt
[586.288460] Subtest fbc-2p-scndscrn-shrfb-msflip-blt: SKIP (0.000s)
[586.394039] [137/142] (481s left) kms_ccs (pipe-d-bad-pixel-format-y_tiled_ccs)
[587.074753] Subtest pipe-D-bad-pixel-format-y_tiled_ccs: SKIP (0.000s)
[587.394120] [138/142] (480s left) gem_exec_schedule (smoketest)
[587.767423] Starting subtest: smoketest
[587.768791] Starting dynamic subtest: rcs0
[593.228303] Dynamic subtest rcs0: SUCCESS (5.455s)
[593.254662] Starting dynamic subtest: bcs0
[598.699092] Dynamic subtest bcs0: SUCCESS (5.466s)
[598.723667] Starting dynamic subtest: vcs0
[604.162856] Dynamic subtest vcs0: SUCCESS (5.461s)
[604.189057] Starting dynamic subtest: vecs0
[609.629041] Dynamic subtest vecs0: SUCCESS (5.464s)
[609.630363] Subtest smoketest: SUCCESS (21.858s)
[609.826998] [139/142] (457s left) syncobj_timeline (invalid-wait-illegal-handle)
[610.035821] Starting subtest: invalid-wait-illegal-handle
[610.037518] Subtest invalid-wait-illegal-handle: SUCCESS (0.000s)
[610.126994] [140/142] (457s left) kms_cursor_legacy (2x-long-cursor-vs-flip-atomic)
[610.431433] Starting subtest: 2x-long-cursor-vs-flip-atomic
[610.436629] Subtest 2x-long-cursor-vs-flip-atomic: SKIP (0.004s)
[610.527669] [141/142] (457s left) i915_query (query-topology-garbage-items)
[610.735463] Starting subtest: query-topology-garbage-items
[610.737008] Subtest query-topology-garbage-items: SUCCESS (0.002s)
[610.827102] [142/142] (457s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-onoff)
[611.143473] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-onoff
[611.146591] Subtest fbcpsr-1p-primscrn-cur-indfb-onoff: SKIP (0.000s)
[611.239395] Closing watchdogs
Done.