[49.641511] Initializing watchdogs
[49.641709]   /dev/watchdog0
[49.676709] [001/142] (960s left) kms_ccs (pipe-a-bad-pixel-format-y_tiled_gen12_rc_ccs_cc)
[50.224163] Starting subtest: pipe-A-bad-pixel-format-y_tiled_gen12_rc_ccs_cc
[50.262993] Subtest pipe-A-bad-pixel-format-y_tiled_gen12_rc_ccs_cc: SKIP (0.000s)
[50.811199] [002/142] (959s left) kms_cursor_edge_walk (128x128-top-edge)
[51.104795] Starting subtest: 128x128-top-edge
[51.126424] Starting dynamic subtest: pipe-A-DP-1
[54.959578] Dynamic subtest pipe-A-DP-1: SUCCESS (3.850s)
[54.989136] Starting dynamic subtest: pipe-C-DP-1
[58.468470] Dynamic subtest pipe-C-DP-1: SUCCESS (3.490s)
[58.487740] Subtest 128x128-top-edge: SUCCESS (7.346s)
[58.798862] [003/142] (951s left) v3d/v3d_wait_bo (unused-bo-0ns)
[59.079642] Subtest unused-bo-0ns: SKIP (0.000s)
[59.162999] [004/142] (951s left) kms_frontbuffer_tracking (fbc-1p-offscren-pri-shrfb-draw-mmap-cpu)
[59.530089] Starting subtest: fbc-1p-offscren-pri-shrfb-draw-mmap-cpu
[61.315054] Subtest fbc-1p-offscren-pri-shrfb-draw-mmap-cpu: SUCCESS (1.861s)
[61.485353] [005/142] (949s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-move)
[61.862066] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-move
[61.900668] Subtest fbcpsr-2p-scndscrn-spr-indfb-move: SKIP (0.000s)
[61.980457] [006/142] (948s left) gem_lmem_swapping (verify)
[62.224441] Subtest verify: SKIP (0.000s)
[62.308920] [007/142] (948s left) kms_frontbuffer_tracking (psr-1p-offscren-pri-indfb-draw-render)
[62.665756] Starting subtest: psr-1p-offscren-pri-indfb-draw-render
[62.704513] Subtest psr-1p-offscren-pri-indfb-draw-render: SKIP (0.000s)
[62.790651] [008/142] (947s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-mmap-wc)
[63.140841] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-mmap-wc
[65.214412] Subtest fbc-1p-primscrn-spr-indfb-draw-mmap-wc: SUCCESS (2.127s)
[65.368974] [009/142] (945s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0-async-flip)
[65.726112] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0-async-flip
[65.764433] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0-async-flip: SKIP (0.000s)
[65.843805] [010/142] (945s left) kms_big_fb (4-tiled-32bpp-rotate-0)
[66.200642] Starting subtest: 4-tiled-32bpp-rotate-0
[66.238741] Subtest 4-tiled-32bpp-rotate-0: SKIP (0.000s)
[66.319169] [011/142] (944s left) gem_pxp (verify-pxp-stale-buf-execution)
[69.302304] Subtest verify-pxp-stale-buf-execution: SKIP (0.000s)
[69.425943] [012/142] (941s left) gem_tiled_pread_basic
[70.040566] [013/142] (941s left) kms_addfb_basic (framebuffer-vs-set-tiling)
[70.295799] Starting subtest: framebuffer-vs-set-tiling
[70.329994] Subtest framebuffer-vs-set-tiling: SUCCESS (0.000s)
[70.467823] [014/142] (940s left) sw_sync (sync_busy)
[70.704354] Starting subtest: sync_busy
[70.726884] Subtest sync_busy: SUCCESS (0.007s)
[70.825466] [015/142] (940s left) prime_vgem (basic-blt)
[71.185512] Starting subtest: basic-blt
[71.214923] Subtest basic-blt: SUCCESS (0.062s)
[71.354418] [016/142] (940s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu)
[71.745308] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu
[71.800089] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[71.908647] [017/142] (939s left) i915_pm_rpm (universal-planes)
[73.881556] Starting subtest: universal-planes
[73.912076] Starting dynamic subtest: plane-31
[76.009380] Dynamic subtest plane-31: SUCCESS (2.303s)
[76.050791] Starting dynamic subtest: plane-39
[77.907555] Dynamic subtest plane-39: SUCCESS (1.880s)
[77.945931] Starting dynamic subtest: plane-47
[79.873382] Dynamic subtest plane-47: SUCCESS (1.981s)
[79.917800] Starting dynamic subtest: plane-55
[81.725835] Dynamic subtest plane-55: SUCCESS (1.855s)
[81.746540] Subtest universal-planes: SUCCESS (8.021s)
[82.219225] [018/142] (929s left) gem_ctx_param (invalid-set-no-zeromap)
[82.440967] Starting subtest: invalid-set-no-zeromap
[82.460562] Subtest invalid-set-no-zeromap: SUCCESS (0.000s)
[82.545922] [019/142] (929s left) kms_big_fb (linear-max-hw-stride-32bpp-rotate-0)
[82.888438] Starting subtest: linear-max-hw-stride-32bpp-rotate-0
[84.409338] Subtest linear-max-hw-stride-32bpp-rotate-0: SUCCESS (1.542s)
[84.568609] [020/142] (927s left) gem_eio (in-flight-contexts-1us)
[84.846062] Starting subtest: in-flight-contexts-1us
[96.267396] Subtest in-flight-contexts-1us: SUCCESS (11.469s)
[96.488531] [021/142] (915s left) kms_cursor_crc (cursor-rapid-movement-128x42)
[96.808951] Starting subtest: cursor-rapid-movement-128x42
[96.831131] Starting dynamic subtest: pipe-A-DP-1
[97.324328] Dynamic subtest pipe-A-DP-1: SUCCESS (0.505s)
[97.390324] Starting dynamic subtest: pipe-C-DP-1
[97.985108] Dynamic subtest pipe-C-DP-1: SUCCESS (0.601s)
[98.016526] Subtest cursor-rapid-movement-128x42: SUCCESS (1.184s)
[98.438668] [022/142] (913s left) gem_exec_flush (basic-batch-kernel-default-wb)
[98.756371] Starting subtest: basic-batch-kernel-default-wb
[104.669079] Subtest basic-batch-kernel-default-wb: SUCCESS (5.992s)
[104.890282] [023/142] (907s left) kms_color (invalid-ctm-matrix-sizes)
[105.198642] Starting subtest: invalid-ctm-matrix-sizes
[105.227372] Starting dynamic subtest: pipe-A
[105.249877] Dynamic subtest pipe-A: SUCCESS (0.007s)
[105.292041] Starting dynamic subtest: pipe-B
[105.318548] Dynamic subtest pipe-B: SUCCESS (0.010s)
[105.360155] Starting dynamic subtest: pipe-C
[105.388661] Dynamic subtest pipe-C: SUCCESS (0.012s)
[105.415625] Subtest invalid-ctm-matrix-sizes: SUCCESS (0.031s)
[105.520048] [024/142] (906s left) kms_plane_scaling (plane-upscale-with-pixel-format-factor-0-25)
[105.851131] Starting subtest: plane-upscale-with-pixel-format-factor-0-25
[105.880854] Starting dynamic subtest: pipe-A-DP-1
[106.523932] Dynamic subtest pipe-A-DP-1: SUCCESS (0.658s)
[106.570765] Starting dynamic subtest: pipe-B-DP-1
[107.454729] Dynamic subtest pipe-B-DP-1: SUCCESS (0.954s)
[107.491083] Starting dynamic subtest: pipe-C-DP-1
[107.823635] Dynamic subtest pipe-C-DP-1: SUCCESS (0.360s)
[107.844482] Subtest plane-upscale-with-pixel-format-factor-0-25: SUCCESS (1.981s)
[108.235902] [025/142] (904s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-mmap-cpu)
[108.588033] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-mmap-cpu
[108.629376] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[108.718446] [026/142] (903s left) gem_fenced_exec_thrash (2-spare-fences)
[108.944796] Starting subtest: 2-spare-fences
[111.109485] Subtest 2-spare-fences: SUCCESS (2.162s)
[111.450887] [027/142] (900s left) syncobj_wait (wait-all-snapshot)
[111.680442] Starting subtest: wait-all-snapshot
[111.730996] Subtest wait-all-snapshot: SUCCESS (0.083s)
[111.855227] [028/142] (900s left) gen7_exec_parse (basic-rejected)
[112.103041] Subtest basic-rejected: SKIP (0.000s)
[112.191881] [029/142] (900s left) gem_exec_params (larger-than-life-batch)
[112.415072] Starting subtest: larger-than-life-batch
[114.069896] Subtest larger-than-life-batch: SKIP (1.492s)
[114.182836] [030/142] (898s left) gem_softpin (zero)
[114.563386] Starting subtest: zero
[114.603730] Subtest zero: SUCCESS (0.007s)
[114.693920] [031/142] (898s left) kms_vblank (pipe-a-ts-continuation-idle)
[115.054905] Starting subtest: pipe-A-ts-continuation-idle
[115.317211] Subtest pipe-A-ts-continuation-idle: SUCCESS (0.261s)
[115.661492] [032/142] (897s left) gem_mmap (bad-object)
[115.901281] Starting subtest: bad-object
[115.920412] Subtest bad-object: SUCCESS (0.000s)
[116.008832] [033/142] (896s left) gem_mmap_gtt (zero-extend)
[116.243135] Starting subtest: zero-extend
[116.264719] Subtest zero-extend: SUCCESS (0.000s)
[116.355553] [034/142] (896s left) gem_ctx_persistence (heartbeat-stop)
[116.592936] Starting subtest: heartbeat-stop
[116.735568] Subtest heartbeat-stop: SUCCESS (0.150s)
[116.850230] [035/142] (896s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-180-hflip)
[117.186913] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-180-hflip
[117.272327] Subtest y-tiled-max-hw-stride-64bpp-rotate-180-hflip: SKIP (0.031s)
[117.358407] [036/142] (895s left) kms_chamelium_edid (hdmi-mode-timings)
[117.787467] Subtest hdmi-mode-timings: SKIP (0.000s)
[118.071134] [037/142] (895s left) kms_atomic_interruptible (legacy-setmode)
[118.404597] Starting subtest: legacy-setmode
[118.426481] Starting dynamic subtest: DP-1-pipe-A
[124.929338] Dynamic subtest DP-1-pipe-A: SUCCESS (6.514s)
[124.948247] Subtest legacy-setmode: SUCCESS (6.517s)
[125.281657] [038/142] (888s left) kms_vblank (pipe-d-ts-continuation-modeset)
[125.595046] Subtest pipe-D-ts-continuation-modeset: SKIP (0.000s)
[125.765432] [039/142] (887s left) kms_flip (2x-busy-flip)
[126.065586] Starting subtest: 2x-busy-flip
[126.104044] Subtest 2x-busy-flip: SKIP (0.003s)
[126.212161] [040/142] (887s left) kms_invalid_mode (bad-vtotal)
[126.574196] Starting subtest: bad-vtotal
[126.599328] Starting dynamic subtest: DP-1-pipe-A
[126.623817] Dynamic subtest DP-1-pipe-A: SUCCESS (0.094s)
[126.664598] Starting dynamic subtest: DP-1-pipe-B
[126.689223] Dynamic subtest DP-1-pipe-B: SUCCESS (0.002s)
[126.731939] Starting dynamic subtest: DP-1-pipe-C
[126.756635] Dynamic subtest DP-1-pipe-C: SUCCESS (0.002s)
[126.782413] Subtest bad-vtotal: SUCCESS (0.106s)
[127.006565] [041/142] (886s left) kms_big_fb (linear-64bpp-rotate-180)
[127.368407] Starting subtest: linear-64bpp-rotate-180
[136.202031] Subtest linear-64bpp-rotate-180: SUCCESS (8.877s)
[137.164700] [042/142] (876s left) drm_fdinfo (most-busy-check-all)
[137.403788] Starting subtest: most-busy-check-all
[137.422626] Starting dynamic subtest: rcs0
[137.909793] Dynamic subtest rcs0: SUCCESS (0.524s)
[137.949874] Starting dynamic subtest: bcs0
[138.432077] Dynamic subtest bcs0: SUCCESS (0.519s)
[138.469642] Starting dynamic subtest: vcs0
[138.952098] Dynamic subtest vcs0: SUCCESS (0.520s)
[138.992303] Starting dynamic subtest: vecs0
[139.472700] Dynamic subtest vecs0: SUCCESS (0.520s)
[139.491801] Subtest most-busy-check-all: SUCCESS (2.089s)
[139.579350] [043/142] (874s left) kms_flip (2x-plain-flip)
[139.892664] Starting subtest: 2x-plain-flip
[139.933212] Subtest 2x-plain-flip: SKIP (0.003s)
[140.019349] [044/142] (873s left) kms_universal_plane (universal-plane-pageflip-windowed-pipe-d)
[140.345189] Subtest universal-plane-pageflip-windowed-pipe-D: SKIP (0.000s)
[140.513133] [045/142] (873s left) vgem_basic (busy-fence)
[140.748794] Starting subtest: busy-fence
[140.767793] Subtest busy-fence: SUCCESS (0.001s)
[140.860311] [046/142] (873s left) kms_vblank (pipe-a-wait-forked)
[141.152693] Starting subtest: pipe-A-wait-forked
[143.501500] Subtest pipe-A-wait-forked: SUCCESS (2.338s)
[143.841322] [047/142] (870s left) kms_frontbuffer_tracking (fbc-1p-offscren-pri-shrfb-draw-mmap-wc)
[144.226990] Starting subtest: fbc-1p-offscren-pri-shrfb-draw-mmap-wc
[146.003265] Subtest fbc-1p-offscren-pri-shrfb-draw-mmap-wc: SUCCESS (1.852s)
[146.164776] [048/142] (868s left) sw_sync (alloc_fence_invalid_timeline)
[146.377815] Starting subtest: alloc_fence_invalid_timeline
[146.396892] Subtest alloc_fence_invalid_timeline: SUCCESS (0.000s)
[146.489666] [049/142] (867s left) kms_flip (2x-flip-vs-suspend-interruptible)
[146.782751] Starting subtest: 2x-flip-vs-suspend-interruptible
[146.820885] Subtest 2x-flip-vs-suspend-interruptible: SKIP (0.003s)
[146.916242] [050/142] (867s left) kms_frontbuffer_tracking (psr-2p-scndscrn-shrfb-msflip-blt)
[147.321249] Starting subtest: psr-2p-scndscrn-shrfb-msflip-blt
[147.359614] Subtest psr-2p-scndscrn-shrfb-msflip-blt: SKIP (0.000s)
[147.453587] [051/142] (867s left) prime_self_import (basic-with_one_bo)
[147.664149] Starting subtest: basic-with_one_bo
[147.707777] Subtest basic-with_one_bo: SUCCESS (0.006s)
[147.796135] [052/142] (866s left) syncobj_timeline (multi-wait-submitted-signaled)
[148.029305] Starting subtest: multi-wait-submitted-signaled
[148.051072] Subtest multi-wait-submitted-signaled: SUCCESS (0.002s)
[148.135128] [053/142] (866s left) i915_pm_rpm (modeset-lpsp-stress-no-wait)
[149.936812] Starting subtest: modeset-lpsp-stress-no-wait
[150.243925] Subtest modeset-lpsp-stress-no-wait: SKIP (0.283s)
[150.644753] [054/142] (864s left) kms_cursor_crc (cursor-onscreen-128x42)
[150.966281] Starting subtest: cursor-onscreen-128x42
[150.984986] Starting dynamic subtest: pipe-A-DP-1
[153.322067] Dynamic subtest pipe-A-DP-1: SUCCESS (2.347s)
[153.404335] Starting dynamic subtest: pipe-C-DP-1
[155.817752] Dynamic subtest pipe-C-DP-1: SUCCESS (2.444s)
[155.836957] Subtest cursor-onscreen-128x42: SUCCESS (4.869s)
[156.206294] [055/142] (858s left) gem_ctx_exec (basic)
[156.441092] Starting subtest: basic
[156.461863] Subtest basic: SUCCESS (0.006s)
[156.551325] [056/142] (858s left) gem_exec_fair (basic-pace)
[156.967707] Starting subtest: basic-pace
[156.986771] Starting dynamic subtest: rcs0
[161.640350] Dynamic subtest rcs0: SUCCESS (4.854s)
[161.677089] Starting dynamic subtest: bcs0
[161.714420] Dynamic subtest bcs0: SKIP (0.007s)
[161.748902] Starting dynamic subtest: vcs0
[166.468662] Dynamic subtest vcs0: SUCCESS (4.819s)
[166.504124] Starting dynamic subtest: vecs0
[171.298562] Dynamic subtest vecs0: SUCCESS (4.826s)
[171.319264] Subtest basic-pace: SUCCESS (14.514s)
[171.540747] [057/142] (843s left) syncobj_timeline (invalid-signal-illegal-handle)
[171.743780] Starting subtest: invalid-signal-illegal-handle
[171.762749] Subtest invalid-signal-illegal-handle: SUCCESS (0.000s)
[171.849505] [058/142] (843s left) prime_self_import (basic-llseek-bad)
[172.078203] Starting subtest: basic-llseek-bad
[172.125922] Subtest basic-llseek-bad: SUCCESS (0.004s)
[172.225742] [059/142] (843s left) kms_ccs (pipe-a-missing-ccs-buffer-y_tiled_gen12_mc_ccs)
[172.682809] Starting subtest: pipe-A-missing-ccs-buffer-y_tiled_gen12_mc_ccs
[172.732213] Subtest pipe-A-missing-ccs-buffer-y_tiled_gen12_mc_ccs: SKIP (0.000s)
[173.134349] [060/142] (842s left) i915_pm_rpm (debugfs-read)
[174.900874] Starting subtest: debugfs-read
[178.092510] Subtest debugfs-read: SUCCESS (3.160s)
[178.532919] [061/142] (836s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-180-async-flip)
[178.875470] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-180-async-flip
[180.136209] Subtest y-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SUCCESS (1.288s)
[180.499330] [062/142] (835s left) kms_ccs (pipe-d-crc-sprite-planes-basic-4_tiled_mtl_rc_ccs)
[181.043243] Subtest pipe-D-crc-sprite-planes-basic-4_tiled_mtl_rc_ccs: SKIP (0.000s)
[181.352253] [063/142] (834s left) kms_ccs (pipe-b-bad-aux-stride-y_tiled_ccs)
[181.837751] Starting subtest: pipe-B-bad-aux-stride-y_tiled_ccs
[181.859297] Subtest pipe-B-bad-aux-stride-y_tiled_ccs: SUCCESS (0.002s)
[182.227176] [064/142] (833s left) kms_frontbuffer_tracking (fbc-stridechange)
[182.587505] Starting subtest: fbc-stridechange
[184.159458] Subtest fbc-stridechange: SUCCESS (1.633s)
[184.331114] [065/142] (831s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-onoff)
[184.692597] Starting subtest: psr-1p-primscrn-spr-indfb-onoff
[184.735762] Subtest psr-1p-primscrn-spr-indfb-onoff: SKIP (0.000s)
[184.825839] [066/142] (831s left) kms_big_fb (4-tiled-16bpp-rotate-180)
[185.170672] Starting subtest: 4-tiled-16bpp-rotate-180
[185.214143] Subtest 4-tiled-16bpp-rotate-180: SKIP (0.000s)
[185.303124] [067/142] (830s left) gem_ctx_create (basic-files)
[185.544768] Starting subtest: basic-files
[187.592997] Subtest basic-files: SUCCESS (2.038s)
[187.823901] [068/142] (828s left) kms_flip (absolute-wf_vblank-interruptible)
[188.146877] Starting subtest: absolute-wf_vblank-interruptible
[188.168888] Starting dynamic subtest: A-DP1
[198.958737] Dynamic subtest A-DP1: SUCCESS (10.653s)
[199.011179] Starting dynamic subtest: B-DP1
[209.202490] Dynamic subtest B-DP1: SUCCESS (10.414s)
[209.237940] Starting dynamic subtest: C-DP1
[219.641582] Dynamic subtest C-DP1: SUCCESS (10.437s)
[219.664629] Subtest absolute-wf_vblank-interruptible: SUCCESS (31.516s)
[220.073698] [069/142] (796s left) kms_vblank (pipe-b-query-forked-busy)
[220.368543] Starting subtest: pipe-B-query-forked-busy
[223.173062] Subtest pipe-B-query-forked-busy: SUCCESS (2.794s)
[223.518707] [070/142] (792s left) api_intel_bb (offset-control)
[223.757880] Starting subtest: offset-control
[223.776715] Subtest offset-control: SUCCESS (0.015s)
[223.888988] [071/142] (792s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-32bpp-yftile-downscaling)
[224.192337] Starting subtest: flip-64bpp-yftile-to-32bpp-yftile-downscaling
[224.213889] Starting dynamic subtest: pipe-A-valid-mode
[224.323783] Dynamic subtest pipe-A-valid-mode: SKIP (0.090s)
[224.367255] Subtest flip-64bpp-yftile-to-32bpp-yftile-downscaling: SKIP (0.093s)
[224.626813] [072/142] (791s left) gem_exec_schedule (semaphore-codependency)
[225.021629] Starting subtest: semaphore-codependency
[225.042385] Subtest semaphore-codependency: SUCCESS (0.023s)
[225.271934] [073/142] (791s left) kms_vblank (pipe-c-wait-idle)
[225.544958] Starting subtest: pipe-C-wait-idle
[228.161892] Subtest pipe-C-wait-idle: SUCCESS (2.603s)
[228.508075] [074/142] (788s left) gem_exec_reloc (basic-wc-active)
[228.747782] Starting subtest: basic-wc-active
[228.862536] Subtest basic-wc-active: SUCCESS (0.138s)
[229.072562] [075/142] (787s left) gem_mmap_gtt (hang)
[229.305181] Starting subtest: hang
[234.751566] Subtest hang: SUCCESS (5.472s)
[234.913795] [076/142] (781s left) sysfs_preempt_timeout (idempotent)
[235.152907] Starting subtest: idempotent
[235.174482] Starting dynamic subtest: vecs0
[235.196435] Dynamic subtest vecs0: SUCCESS (0.002s)
[235.233360] Starting dynamic subtest: vcs0
[235.252488] Dynamic subtest vcs0: SUCCESS (0.002s)
[235.288666] Starting dynamic subtest: bcs0
[235.307635] Dynamic subtest bcs0: SUCCESS (0.004s)
[235.344216] Starting dynamic subtest: rcs0
[235.366032] Dynamic subtest rcs0: SUCCESS (0.002s)
[235.387184] Subtest idempotent: SUCCESS (0.020s)
[235.476508] [077/142] (781s left) syncobj_timeline (invalid-multi-wait-all-available-unsubmitted-signaled)
[235.711265] Starting subtest: invalid-multi-wait-all-available-unsubmitted-signaled
[235.731200] Subtest invalid-multi-wait-all-available-unsubmitted-signaled: SUCCESS (0.002s)
[235.817393] [078/142] (781s left) kms_ccs (pipe-b-crc-primary-rotation-180-y_tiled_gen12_mc_ccs)
[236.269217] Starting subtest: pipe-B-crc-primary-rotation-180-y_tiled_gen12_mc_ccs
[236.311042] Subtest pipe-B-crc-primary-rotation-180-y_tiled_gen12_mc_ccs: SKIP (0.002s)
[236.712530] [079/142] (780s left) gem_exec_gttfill (engines)
[236.970872] Starting subtest: engines
[236.996088] Starting dynamic subtest: rcs0
[273.669855] Dynamic subtest rcs0: SUCCESS (36.726s)
[273.706283] Starting dynamic subtest: bcs0
[312.291302] Dynamic subtest bcs0: SUCCESS (38.619s)
[312.326431] Starting dynamic subtest: vcs0
[349.920689] Dynamic subtest vcs0: SUCCESS (37.627s)
[349.957132] Starting dynamic subtest: vecs0
[387.576307] Dynamic subtest vecs0: SUCCESS (37.649s)
[387.597178] Subtest engines: SUCCESS (150.630s)
[387.814993] [080/142] (629s left) kms_vblank (pipe-c-ts-continuation-idle-hang)
[388.305890] Starting subtest: pipe-C-ts-continuation-idle-hang
[396.159623] Subtest pipe-C-ts-continuation-idle-hang: SUCCESS (7.812s)
[396.478999] [081/142] (620s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-move)
[396.872998] Starting subtest: psr-2p-primscrn-spr-indfb-move
[396.910589] Subtest psr-2p-primscrn-spr-indfb-move: SKIP (0.000s)
[397.002858] [082/142] (620s left) perf (missing-sample-flags)
[397.429244] Starting subtest: missing-sample-flags
[397.450228] Subtest missing-sample-flags: SUCCESS (0.001s)
[397.556700] [083/142] (619s left) kms_frontbuffer_tracking (fbcpsr-1p-offscren-pri-indfb-draw-mmap-wc)
[397.937247] Starting subtest: fbcpsr-1p-offscren-pri-indfb-draw-mmap-wc
[397.974936] Subtest fbcpsr-1p-offscren-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[398.067189] [084/142] (619s left) gem_exec_whisper (basic-normal-all)
[398.346708] Starting subtest: basic-normal-all
[406.608155] Subtest basic-normal-all: SUCCESS (8.269s)
[406.818449] [085/142] (610s left) kms_frontbuffer_tracking (psr-slowdraw)
[407.169699] Starting subtest: psr-slowdraw
[407.212509] Subtest psr-slowdraw: SKIP (0.000s)
[407.306827] [086/142] (610s left) perf (invalid-oa-metric-set-id)
[407.624224] Starting subtest: invalid-oa-metric-set-id
[407.663075] Subtest invalid-oa-metric-set-id: SUCCESS (0.058s)
[407.777136] [087/142] (609s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-32bpp-yftileccs-downscaling)
[408.080871] Starting subtest: flip-32bpp-yftile-to-32bpp-yftileccs-downscaling
[408.099823] Starting dynamic subtest: pipe-A-valid-mode
[408.792164] Dynamic subtest pipe-A-valid-mode: SUCCESS (0.703s)
[408.818165] Subtest flip-32bpp-yftile-to-32bpp-yftileccs-downscaling: SUCCESS (0.707s)
[409.150614] [088/142] (608s left) gem_exec_reloc (basic-write-gtt-active)
[409.392524] Starting subtest: basic-write-gtt-active
[409.500527] Subtest basic-write-gtt-active: SUCCESS (0.135s)
[409.712135] [089/142] (608s left) kms_ccs (pipe-a-crc-primary-rotation-180-4_tiled_mtl_rc_ccs)
[410.127030] Starting subtest: pipe-A-crc-primary-rotation-180-4_tiled_mtl_rc_ccs
[410.164591] Subtest pipe-A-crc-primary-rotation-180-4_tiled_mtl_rc_ccs: SKIP (0.001s)
[410.605195] [090/142] (607s left) kms_rotation_crc (primary-x-tiled-reflect-x-0)
[410.908705] Starting subtest: primary-x-tiled-reflect-x-0
[410.948779] Subtest primary-x-tiled-reflect-x-0: SKIP (0.003s)
[411.045746] [091/142] (606s left) drm_read (short-buffer-block)
[411.638202] Starting subtest: short-buffer-block
[411.657080] Subtest short-buffer-block: SUCCESS (0.000s)
[411.775928] [092/142] (606s left) gem_exec_reloc (basic-wc-gtt)
[412.003340] Starting subtest: basic-wc-gtt
[412.025097] Subtest basic-wc-gtt: SUCCESS (0.019s)
[412.206176] [093/142] (605s left) kms_ccs (pipe-c-crc-primary-rotation-180-4_tiled_mtl_rc_ccs)
[412.697737] Starting subtest: pipe-C-crc-primary-rotation-180-4_tiled_mtl_rc_ccs
[412.743377] Subtest pipe-C-crc-primary-rotation-180-4_tiled_mtl_rc_ccs: SKIP (0.001s)
[413.085945] [094/142] (605s left) kms_ccs (pipe-b-bad-pixel-format-y_tiled_ccs)
[413.510712] Starting subtest: pipe-B-bad-pixel-format-y_tiled_ccs
[413.529505] Subtest pipe-B-bad-pixel-format-y_tiled_ccs: SUCCESS (0.001s)
[413.958091] [095/142] (604s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180)
[414.322127] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180
[415.710664] Subtest x-tiled-max-hw-stride-64bpp-rotate-180: SUCCESS (1.422s)
[415.925773] [096/142] (602s left) kms_flip (2x-flip-vs-modeset-vs-hang)
[416.259690] Starting subtest: 2x-flip-vs-modeset-vs-hang
[416.312419] Subtest 2x-flip-vs-modeset-vs-hang: SKIP (0.003s)
[416.425616] [097/142] (602s left) vc4/vc4_perfmon (get-values-invalid-pointer)
[416.736963] Subtest get-values-invalid-pointer: SKIP (0.000s)
[416.829208] [098/142] (601s left) kms_frontbuffer_tracking (fbc-2p-primscrn-indfb-plflip-blt)
[417.186111] Starting subtest: fbc-2p-primscrn-indfb-plflip-blt
[417.228146] Subtest fbc-2p-primscrn-indfb-plflip-blt: SKIP (0.000s)
[417.321310] [099/142] (601s left) kms_vblank (pipe-c-ts-continuation-suspend)
[417.616722] Starting subtest: pipe-C-ts-continuation-suspend
[434.320553] Subtest pipe-C-ts-continuation-suspend: SUCCESS (2.351s)
[440.889232] [100/142] (598s left) i915_suspend (sysfs-reader)
[441.105514] Starting subtest: sysfs-reader
[460.180927] Subtest sysfs-reader: SUCCESS (3.625s)
[465.460586] [101/142] (594s left) kms_cursor_legacy (cursorb-vs-flipb-varying-size)
[465.768001] Starting subtest: cursorB-vs-flipB-varying-size
[465.811184] Subtest cursorB-vs-flipB-varying-size: SKIP (0.002s)
[465.909479] [102/142] (594s left) kms_ccs (pipe-c-crc-primary-basic-4_tiled_mtl_rc_ccs)
[466.400152] Starting subtest: pipe-C-crc-primary-basic-4_tiled_mtl_rc_ccs
[466.440254] Subtest pipe-C-crc-primary-basic-4_tiled_mtl_rc_ccs: SKIP (0.001s)
[466.781644] [103/142] (593s left) kms_setmode (basic)
[467.021291] Starting subtest: basic
[467.176149] Starting dynamic subtest: pipe-A-DP-1
[469.507302] Dynamic subtest pipe-A-DP-1: SUCCESS (2.307s)
[469.635500] Starting dynamic subtest: pipe-B-DP-1
[471.940534] Dynamic subtest pipe-B-DP-1: SUCCESS (2.304s)
[472.049372] Subtest basic: SUCCESS (5.028s)
[472.392309] [104/142] (587s left) kms_frontbuffer_tracking (psr-1p-primscrn-indfb-plflip-blt)
[472.753465] Starting subtest: psr-1p-primscrn-indfb-plflip-blt
[472.795017] Subtest psr-1p-primscrn-indfb-plflip-blt: SKIP (0.000s)
[472.891821] [105/142] (587s left) sw_sync (timeline_closed)
[473.113633] Starting subtest: timeline_closed
[473.132661] Subtest timeline_closed: SUCCESS (0.000s)
[473.225776] [106/142] (587s left) kms_ccs (pipe-b-crc-sprite-planes-basic-y_tiled_gen12_mc_ccs)
[473.705199] Starting subtest: pipe-B-crc-sprite-planes-basic-y_tiled_gen12_mc_ccs
[473.742945] Subtest pipe-B-crc-sprite-planes-basic-y_tiled_gen12_mc_ccs: SKIP (0.005s)
[474.124967] [107/142] (586s left) gem_vm_create (isolation)
[474.364509] Starting subtest: isolation
[474.383376] Subtest isolation: SUCCESS (0.011s)
[474.489403] [108/142] (586s left) gem_mmap_wc (bad-object)
[474.733481] Starting subtest: bad-object
[474.752373] Subtest bad-object: SUCCESS (0.000s)
[474.852486] [109/142] (585s left) gem_compute (compute-square)
[475.055461] Starting subtest: compute-square
[475.098320] Subtest compute-square: SKIP (0.000s)
[475.195875] [110/142] (585s left) kms_ccs (pipe-d-bad-pixel-format-4_tiled_dg2_mc_ccs)
[475.730175] Subtest pipe-D-bad-pixel-format-4_tiled_dg2_mc_ccs: SKIP (0.000s)
[476.040122] [111/142] (584s left) kms_chamelium_hpd (dp-hpd-for-each-pipe)
[476.452787] Subtest dp-hpd-for-each-pipe: SKIP (0.000s)
[476.780088] [112/142] (584s left) kms_plane_cursor (viewport)
[477.084611] Starting subtest: viewport
[477.122821] Starting dynamic subtest: pipe-A-DP-1-size-64
[479.523904] Dynamic subtest pipe-A-DP-1-size-64: SUCCESS (2.447s)
[479.611565] Starting dynamic subtest: pipe-A-DP-1-size-128
[482.052107] Dynamic subtest pipe-A-DP-1-size-128: SUCCESS (2.449s)
[482.130967] Starting dynamic subtest: pipe-A-DP-1-size-256
[484.543381] Dynamic subtest pipe-A-DP-1-size-256: SUCCESS (2.465s)
[484.750808] Starting dynamic subtest: pipe-B-DP-1-size-64
[487.382584] Dynamic subtest pipe-B-DP-1-size-64: SUCCESS (2.689s)
[487.466830] Starting dynamic subtest: pipe-B-DP-1-size-128
[489.863111] Dynamic subtest pipe-B-DP-1-size-128: SUCCESS (2.432s)
[489.957835] Starting dynamic subtest: pipe-B-DP-1-size-256
[492.365314] Dynamic subtest pipe-B-DP-1-size-256: SUCCESS (2.448s)
[492.588556] Starting dynamic subtest: pipe-C-DP-1-size-64
[495.204306] Dynamic subtest pipe-C-DP-1-size-64: SUCCESS (2.689s)
[495.297007] Starting dynamic subtest: pipe-C-DP-1-size-128
[497.717403] Dynamic subtest pipe-C-DP-1-size-128: SUCCESS (2.465s)
[497.806476] Starting dynamic subtest: pipe-C-DP-1-size-256
[500.270296] Dynamic subtest pipe-C-DP-1-size-256: SUCCESS (2.498s)
[500.438113] Subtest viewport: SUCCESS (23.340s)
[500.786056] [113/142] (560s left) perf_pmu (busy)
[501.048411] Starting subtest: busy
[501.071150] Starting dynamic subtest: rcs0
[501.575152] Dynamic subtest rcs0: SUCCESS (0.541s)
[501.621424] Starting dynamic subtest: bcs0
[502.117899] Dynamic subtest bcs0: SUCCESS (0.549s)
[502.161085] Starting dynamic subtest: vcs0
[502.663713] Dynamic subtest vcs0: SUCCESS (0.535s)
[502.708952] Starting dynamic subtest: vecs0
[503.201412] Dynamic subtest vecs0: SUCCESS (0.535s)
[503.223533] Subtest busy: SUCCESS (2.172s)
[503.354837] [114/142] (557s left) kms_ccs (pipe-d-crc-primary-basic-4_tiled_mtl_rc_ccs)
[503.909087] Subtest pipe-D-crc-primary-basic-4_tiled_mtl_rc_ccs: SKIP (0.000s)
[504.242605] [115/142] (557s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-gtt)
[504.600083] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-gtt
[504.641376] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[504.736799] [116/142] (556s left) api_intel_bb (object-reloc-keep-cache)
[504.977972] Starting subtest: object-reloc-keep-cache
[504.997116] Subtest object-reloc-keep-cache: SUCCESS (0.013s)
[505.104827] [117/142] (556s left) kms_vblank (pipe-b-ts-continuation-dpms-suspend)
[505.401388] Starting subtest: pipe-B-ts-continuation-dpms-suspend
[523.111115] Subtest pipe-B-ts-continuation-dpms-suspend: SUCCESS (1.992s)
[529.581581] [118/142] (553s left) perf_pmu (init-sema)
[529.816260] Starting subtest: init-sema
[529.837706] Starting dynamic subtest: rcs0
[529.858605] Dynamic subtest rcs0: SUCCESS (0.003s)
[529.901417] Starting dynamic subtest: bcs0
[529.920410] Dynamic subtest bcs0: SUCCESS (0.001s)
[529.961689] Starting dynamic subtest: vcs0
[529.980376] Dynamic subtest vcs0: SUCCESS (0.001s)
[530.023132] Starting dynamic subtest: vecs0
[530.044525] Dynamic subtest vecs0: SUCCESS (0.001s)
[530.066301] Subtest init-sema: SUCCESS (0.018s)
[530.181541] [119/142] (553s left) gem_render_copy (yf-tiled-to-vebox-linear)
[530.423093] Starting subtest: yf-tiled-to-vebox-linear
[530.460768] Subtest yf-tiled-to-vebox-linear: SKIP (0.000s)
[530.641278] [120/142] (552s left) gem_exec_store (cachelines)
[530.917459] Starting subtest: cachelines
[530.938053] Starting dynamic subtest: rcs0
[530.957315] Dynamic subtest rcs0: SUCCESS (0.044s)
[531.001175] Starting dynamic subtest: bcs0
[531.020219] Dynamic subtest bcs0: SUCCESS (0.033s)
[531.062933] Starting dynamic subtest: vcs0
[531.084714] Dynamic subtest vcs0: SUCCESS (0.033s)
[531.130206] Starting dynamic subtest: vecs0
[531.151716] Dynamic subtest vecs0: SUCCESS (0.025s)
[531.171946] Subtest cachelines: SUCCESS (0.147s)
[531.267026] [121/142] (552s left) gem_exec_balancer (full-late-pulse)
[531.506536] Starting subtest: full-late-pulse
[535.699524] Subtest full-late-pulse: SUCCESS (4.018s)
[539.628902] [122/142] (544s left) kms_plane_scaling (plane-scaler-with-clipping-clamping-rotation)
[539.942123] Starting subtest: plane-scaler-with-clipping-clamping-rotation
[539.961815] Starting dynamic subtest: pipe-A-DP-1
[540.049424] Dynamic subtest pipe-A-DP-1: SKIP (0.095s)
[540.109950] Starting dynamic subtest: pipe-B-DP-1
[540.474101] Dynamic subtest pipe-B-DP-1: SKIP (0.401s)
[540.536197] Starting dynamic subtest: pipe-C-DP-1
[540.851225] Dynamic subtest pipe-C-DP-1: SKIP (0.398s)
[540.894634] Subtest plane-scaler-with-clipping-clamping-rotation: SKIP (0.910s)
[541.268531] [123/142] (542s left) api_intel_allocator (execbuf-with-allocator)
[541.506928] Starting subtest: execbuf-with-allocator
[541.525898] Subtest execbuf-with-allocator: SUCCESS (0.010s)
[541.637768] [124/142] (542s left) syncobj_timeline (multi-wait-for-submit-available-signaled)
[541.875554] Starting subtest: multi-wait-for-submit-available-signaled
[541.897138] Subtest multi-wait-for-submit-available-signaled: SUCCESS (0.002s)
[541.997910] [125/142] (542s left) kms_ccs (pipe-c-bad-pixel-format-y_tiled_gen12_mc_ccs)
[542.476278] Starting subtest: pipe-C-bad-pixel-format-y_tiled_gen12_mc_ccs
[542.518605] Subtest pipe-C-bad-pixel-format-y_tiled_gen12_mc_ccs: SKIP (0.000s)
[542.884659] [126/142] (541s left) gem_bad_reloc (negative-reloc)
[543.110389] Starting subtest: negative-reloc
[543.174523] Subtest negative-reloc: SUCCESS (0.002s)
[543.270115] [127/142] (541s left) kms_psr (psr2_sprite_render)
[543.508460] Subtest psr2_sprite_render: SKIP (0.000s)
[543.601564] [128/142] (540s left) kms_invalid_mode (bad-htotal)
[543.901560] Starting subtest: bad-htotal
[543.923118] Starting dynamic subtest: DP-1-pipe-A
[543.993375] Dynamic subtest DP-1-pipe-A: SUCCESS (0.090s)
[544.036558] Starting dynamic subtest: DP-1-pipe-B
[544.055433] Dynamic subtest DP-1-pipe-B: SUCCESS (0.002s)
[544.098413] Starting dynamic subtest: DP-1-pipe-C
[544.117209] Dynamic subtest DP-1-pipe-C: SUCCESS (0.002s)
[544.138622] Subtest bad-htotal: SUCCESS (0.107s)
[544.351253] [129/142] (540s left) kms_draw_crc (draw-method-mmap-wc)
[544.655074] Starting subtest: draw-method-mmap-wc
[544.675790] Starting dynamic subtest: xrgb8888-untiled
[544.990801] Dynamic subtest xrgb8888-untiled: SUCCESS (0.326s)
[545.034390] Starting dynamic subtest: rgb565-untiled
[545.274043] Dynamic subtest rgb565-untiled: SUCCESS (0.281s)
[545.317314] Starting dynamic subtest: xrgb2101010-untiled
[545.595277] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.314s)
[545.638132] Starting dynamic subtest: xrgb8888-xtiled
[545.804673] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.214s)
[545.848494] Starting dynamic subtest: rgb565-xtiled
[545.998663] Dynamic subtest rgb565-xtiled: SUCCESS (0.197s)
[546.039576] Starting dynamic subtest: xrgb2101010-xtiled
[546.220184] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.214s)
[546.261152] Starting dynamic subtest: xrgb8888-ytiled
[546.440175] Dynamic subtest xrgb8888-ytiled: SUCCESS (0.214s)
[546.482897] Starting dynamic subtest: rgb565-ytiled
[546.637928] Dynamic subtest rgb565-ytiled: SUCCESS (0.197s)
[546.681550] Starting dynamic subtest: xrgb2101010-ytiled
[546.850704] Dynamic subtest xrgb2101010-ytiled: SUCCESS (0.214s)
[546.869792] Subtest draw-method-mmap-wc: SUCCESS (2.195s)
[546.993741] [130/142] (537s left) i915_hangman (hangcheck-unterminated)
[547.226631] Starting subtest: hangcheck-unterminated
[556.774429] Subtest hangcheck-unterminated: SUCCESS (9.555s)
[556.917023] [131/142] (527s left) kms_prop_blob (blob-multiple)
[557.146094] Starting subtest: blob-multiple
[557.167846] Subtest blob-multiple: SUCCESS (0.003s)
[557.278169] [132/142] (527s left) syncobj_wait (invalid-multi-wait-unsubmitted-submitted-signaled)
[557.520696] Starting subtest: invalid-multi-wait-unsubmitted-submitted-signaled
[557.541591] Subtest invalid-multi-wait-unsubmitted-submitted-signaled: SUCCESS (0.001s)
[557.644257] [133/142] (527s left) kms_ccs (pipe-d-bad-pixel-format-4_tiled_dg2_rc_ccs_cc)
[558.200194] Subtest pipe-D-bad-pixel-format-4_tiled_dg2_rc_ccs_cc: SKIP (0.000s)
[558.549246] [134/142] (526s left) v3d/v3d_job_submission (multiple-singlesync-to-multisync)
[558.840347] Subtest multiple-singlesync-to-multisync: SKIP (0.000s)
[558.934185] [135/142] (526s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence)
[559.237723] Starting subtest: nonblocking-crc-frame-sequence
[559.259203] Starting dynamic subtest: pipe-A-DP-1
[559.853616] Dynamic subtest pipe-A-DP-1: SUCCESS (0.600s)
[559.898250] Starting dynamic subtest: pipe-B-DP-1
[560.604497] Dynamic subtest pipe-B-DP-1: SUCCESS (0.762s)
[560.653412] Starting dynamic subtest: pipe-C-DP-1
[561.388946] Dynamic subtest pipe-C-DP-1: SUCCESS (0.779s)
[561.411116] Subtest nonblocking-crc-frame-sequence: SUCCESS (2.156s)
[561.741086] [136/142] (523s left) kms_psr2_sf (overlay-plane-update-continuous-sf)
[561.999918] Subtest overlay-plane-update-continuous-sf: SKIP (0.000s)
[562.098679] [137/142] (523s left) v3d/v3d_submit_cl (multiple-job-submission)
[562.381120] Subtest multiple-job-submission: SKIP (0.000s)
[562.478843] [138/142] (522s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-wc)
[562.837080] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-wc
[562.879559] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[562.977330] [139/142] (522s left) gem_exec_fair (basic-deadline)
[563.397394] Starting subtest: basic-deadline
[580.187541] Subtest basic-deadline: FAIL (15.636s)
[580.283537] [140/142] (505s left) gem_ctx_sseu (invalid-args)
[580.538678] Subtest invalid-args: SKIP (0.000s)
[580.631454] [141/142] (505s left) kms_chamelium_color (ctm-max)
[580.955592] Subtest ctm-max: SKIP (0.000s)
[581.054056] [142/142] (504s left) syncobj_wait (invalid-multi-wait-all-unsubmitted-signaled)
[581.266518] Starting subtest: invalid-multi-wait-all-unsubmitted-signaled
[581.288022] Subtest invalid-multi-wait-all-unsubmitted-signaled: SUCCESS (0.001s)
[581.362711] Closing watchdogs
Done.