[37.632338] Initializing watchdogs
[37.632611]   /dev/watchdog0
[37.648813] [001/142] (960s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-render)
[37.925798] Starting subtest: psr-2p-primscrn-pri-indfb-draw-render
[37.928576] Subtest psr-2p-primscrn-pri-indfb-draw-render: SKIP (0.000s)
[38.027996] [002/142] (960s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-mmap-cpu)
[38.269267] Starting subtest: fbc-rgb101010-draw-mmap-cpu
[40.994054] Subtest fbc-rgb101010-draw-mmap-cpu: SUCCESS (2.726s)
[41.128064] [003/142] (957s left) syncobj_timeline (multi-wait-for-submit-unsubmitted-signaled)
[41.280133] Starting subtest: multi-wait-for-submit-unsubmitted-signaled
[41.283364] Subtest multi-wait-for-submit-unsubmitted-signaled: SUCCESS (0.002s)
[41.357483] [004/142] (956s left) kms_vblank (pipe-a-wait-forked-hang)
[41.596884] Starting subtest: pipe-A-wait-forked-hang
[49.007912] Subtest pipe-A-wait-forked-hang: SUCCESS (7.411s)
[49.354989] [005/142] (948s left) syncobj_wait (single-wait-all-for-submit-signaled)
[49.503428] Starting subtest: single-wait-all-for-submit-signaled
[49.504977] Subtest single-wait-all-for-submit-signaled: SUCCESS (0.000s)
[49.583696] [006/142] (948s left) kms_ccs (pipe-a-crc-primary-basic-yf_tiled_ccs)
[49.922572] Starting subtest: pipe-A-crc-primary-basic-yf_tiled_ccs
[50.832923] Subtest pipe-A-crc-primary-basic-yf_tiled_ccs: SUCCESS (0.910s)
[51.420383] [007/142] (946s left) kms_atomic (plane-invalid-params)
[51.782187] Starting subtest: plane-invalid-params
[51.936701] Subtest plane-invalid-params: SUCCESS (0.155s)
[52.365508] [008/142] (946s left) gem_vm_create (execbuf)
[52.544517] Starting subtest: execbuf
[52.563661] Subtest execbuf: SUCCESS (0.019s)
[52.699431] [009/142] (945s left) perf_pmu (busy-idle-no-semaphores)
[52.853106] Starting subtest: busy-idle-no-semaphores
[52.854852] Starting dynamic subtest: rcs0
[53.484643] Dynamic subtest rcs0: SUCCESS (0.636s)
[53.501897] Starting dynamic subtest: bcs0
[54.115318] Dynamic subtest bcs0: SUCCESS (0.630s)
[54.131428] Starting dynamic subtest: vcs0
[54.744630] Dynamic subtest vcs0: SUCCESS (0.627s)
[54.759436] Starting dynamic subtest: vecs0
[55.379565] Dynamic subtest vecs0: SUCCESS (0.634s)
[55.381059] Subtest busy-idle-no-semaphores: SUCCESS (2.530s)
[55.482046] [010/142] (942s left) kms_ccs (pipe-a-missing-ccs-buffer-4_tiled_mtl_mc_ccs)
[55.836810] Starting subtest: pipe-A-missing-ccs-buffer-4_tiled_mtl_mc_ccs
[55.839817] Subtest pipe-A-missing-ccs-buffer-4_tiled_mtl_mc_ccs: SKIP (0.000s)
[56.283626] [011/142] (942s left) kms_addfb_basic (bad-pitch-32)
[56.427115] Starting subtest: bad-pitch-32
[56.428498] Subtest bad-pitch-32: SUCCESS (0.000s)
[56.613711] [012/142] (941s left) gem_mmap_gtt (ptrace)
[56.753158] Starting subtest: ptrace
[57.051423] Subtest ptrace: SUCCESS (0.297s)
[57.151721] [013/142] (941s left) i915_pm_freq_api (freq-suspend)
[57.300420] Subtest freq-suspend: SKIP (0.000s)
[57.353121] [014/142] (941s left) kms_ccs (pipe-d-bad-rotation-90-y_tiled_gen12_rc_ccs_cc)
[57.829202] Subtest pipe-D-bad-rotation-90-y_tiled_gen12_rc_ccs_cc: SKIP (0.000s)
[58.139951] [015/142] (940s left) kms_ccs (pipe-d-crc-primary-basic-y_tiled_ccs)
[58.613842] Subtest pipe-D-crc-primary-basic-y_tiled_ccs: SKIP (0.000s)
[58.918905] [016/142] (939s left) prime_mmap (test_dup)
[59.061163] Starting subtest: test_dup
[59.062399] Starting dynamic subtest: test_dup-smem
[59.065425] Dynamic subtest test_dup-smem: SUCCESS (0.006s)
[59.067254] Subtest test_dup: SUCCESS (0.007s)
[59.166096] [017/142] (939s left) syncobj_wait (wait-all-for-submit-complex)
[59.306404] Starting subtest: wait-all-for-submit-complex
[59.523996] Subtest wait-all-for-submit-complex: SUCCESS (0.216s)
[59.601255] [018/142] (939s left) perf_pmu (most-busy-check-all)
[59.746652] Starting subtest: most-busy-check-all
[59.748210] Starting dynamic subtest: rcs0
[60.275659] Dynamic subtest rcs0: SUCCESS (0.529s)
[60.290757] Starting dynamic subtest: bcs0
[60.800644] Dynamic subtest bcs0: SUCCESS (0.525s)
[60.818188] Starting dynamic subtest: vcs0
[61.327617] Dynamic subtest vcs0: SUCCESS (0.527s)
[61.346306] Starting dynamic subtest: vecs0
[61.858264] Dynamic subtest vecs0: SUCCESS (0.530s)
[61.862962] Subtest most-busy-check-all: SUCCESS (2.111s)
[61.955563] [019/142] (936s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-move)
[62.208264] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-move
[62.210793] Subtest fbcpsr-2p-primscrn-spr-indfb-move: SKIP (0.000s)
[62.300209] [020/142] (936s left) kms_ccs (pipe-b-crc-primary-basic-y_tiled_gen12_rc_ccs_cc)
[62.685796] Starting subtest: pipe-B-crc-primary-basic-y_tiled_gen12_rc_ccs_cc
[62.688495] Subtest pipe-B-crc-primary-basic-y_tiled_gen12_rc_ccs_cc: SKIP (0.001s)
[63.086562] [021/142] (935s left) syncobj_timeline (wait-for-submit-complex)
[63.228313] Starting subtest: wait-for-submit-complex
[63.293980] Subtest wait-for-submit-complex: SUCCESS (0.064s)
[63.370253] [022/142] (935s left) kms_big_fb (linear-32bpp-rotate-180)
[63.626642] Starting subtest: linear-32bpp-rotate-180
[69.486599] Subtest linear-32bpp-rotate-180: SUCCESS (5.859s)
[70.020684] [023/142] (928s left) gem_ctx_persistence (engines-hang)
[70.172829] Starting subtest: engines-hang
[70.174359] Starting dynamic subtest: rcs0
[70.209650] Dynamic subtest rcs0: SUCCESS (0.037s)
[70.226679] Starting dynamic subtest: bcs0
[70.230630] Dynamic subtest bcs0: SKIP (0.004s)
[70.246387] Starting dynamic subtest: vcs0
[70.262217] Dynamic subtest vcs0: SUCCESS (0.047s)
[70.280979] Starting dynamic subtest: vecs0
[70.304797] Dynamic subtest vecs0: SUCCESS (0.040s)
[70.306234] Subtest engines-hang: SUCCESS (0.131s)
[70.386232] [024/142] (928s left) prime_vgem (fence-write-hang)
[70.633339] Subtest fence-write-hang: SKIP (0.000s)
[70.743159] [025/142] (928s left) kms_chamelium_frames (hdmi-aspect-ratio)
[71.087639] Subtest hdmi-aspect-ratio: SKIP (0.000s)
[71.361425] [026/142] (927s left) i915_pm_rps (fence-order)
[71.507492] Starting subtest: fence-order
[74.704408] Subtest fence-order: SUCCESS (3.193s)
[74.922158] [027/142] (924s left) kms_invalid_mode (zero-clock)
[75.164468] Starting subtest: zero-clock
[75.165829] Starting dynamic subtest: DP-1-pipe-A
[75.273672] Dynamic subtest DP-1-pipe-A: SUCCESS (0.110s)
[75.291054] Starting dynamic subtest: DP-1-pipe-B
[75.292255] Dynamic subtest DP-1-pipe-B: SUCCESS (0.002s)
[75.307609] Starting dynamic subtest: DP-1-pipe-C
[75.308961] Dynamic subtest DP-1-pipe-C: SUCCESS (0.002s)
[75.310221] Subtest zero-clock: SUCCESS (0.122s)
[75.624595] [028/142] (923s left) perf_pmu (invalid-init)
[75.773061] Starting subtest: invalid-init
[75.774554] Subtest invalid-init: SUCCESS (0.001s)
[75.859206] [029/142] (923s left) kms_cursor_legacy (basic-busy-flip-before-cursor-varying-size)
[76.094646] Starting subtest: basic-busy-flip-before-cursor-varying-size
[76.097231] Subtest basic-busy-flip-before-cursor-varying-size: SKIP (0.000s)
[76.176030] [030/142] (923s left) kms_content_protection (atomic)
[76.444568] Starting subtest: atomic
[76.476425] Starting dynamic subtest: pipe-A-DP-1
[197.122728] Per-test timeout exceeded. Killing the current test with SIGQUIT.
[197.647510] Closing watchdogs
[197.655525] Initializing watchdogs
[197.655697]   /dev/watchdog0
[197.676067] [031/142] (801s left) v3d/v3d_submit_cl (bad-multisync-pad)
[197.876367] Subtest bad-multisync-pad: SKIP (0.000s)
[197.943139] [032/142] (801s left) kms_big_fb (x-tiled-32bpp-rotate-180)
[198.199991] Starting subtest: x-tiled-32bpp-rotate-180
[203.125345] Subtest x-tiled-32bpp-rotate-180: SUCCESS (4.924s)
[203.644134] [033/142] (795s left) kms_cursor_legacy (flip-vs-cursor-toggle)
[203.902082] Starting subtest: flip-vs-cursor-toggle
[223.187467] Subtest flip-vs-cursor-toggle: SUCCESS (19.286s)
[223.524886] [034/142] (775s left) gem_create (create-ext-placement-sanity-check)
[223.796856] Starting subtest: create-ext-placement-sanity-check
[223.805354] Subtest create-ext-placement-sanity-check: SUCCESS (0.008s)
[223.891786] [035/142] (775s left) gem_eio (in-flight-internal-10ms)
[224.065269] Starting subtest: in-flight-internal-10ms
[224.168957] Subtest in-flight-internal-10ms: SUCCESS (0.106s)
[224.374825] [036/142] (775s left) kms_vblank (pipe-c-query-forked-busy)
[224.614932] Starting subtest: pipe-C-query-forked-busy
[227.421202] Subtest pipe-C-query-forked-busy: SUCCESS (2.805s)
[227.758257] [037/142] (771s left) kms_vblank (pipe-d-ts-continuation-modeset)
[227.993698] Subtest pipe-D-ts-continuation-modeset: SKIP (0.000s)
[228.072312] [038/142] (771s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-wc)
[228.317217] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-wc
[228.319856] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[228.420525] [039/142] (771s left) vc4/vc4_label_bo (set-kernel-name)
[228.619901] Subtest set-kernel-name: SKIP (0.000s)
[228.687931] [040/142] (770s left) gem_close (many-handles-one-vma)
[228.832998] Starting subtest: many-handles-one-vma
[228.920821] Subtest many-handles-one-vma: SUCCESS (0.087s)
[229.036775] [041/142] (770s left) gem_mmap_gtt (medium-copy-odd)
[229.176838] Starting subtest: medium-copy-odd
[236.014104] Subtest medium-copy-odd: SUCCESS (6.838s)
[236.124978] [042/142] (763s left) kms_cursor_crc (cursor-offscreen-256x85)
[236.512490] Starting subtest: cursor-offscreen-256x85
[236.525295] Starting dynamic subtest: pipe-A-DP-1
[239.250624] Dynamic subtest pipe-A-DP-1: SUCCESS (2.725s)
[239.343495] Starting dynamic subtest: pipe-C-DP-1
[241.927769] Dynamic subtest pipe-C-DP-1: SUCCESS (2.602s)
[241.929083] Subtest cursor-offscreen-256x85: SUCCESS (5.413s)
[242.278624] [043/142] (757s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-blt)
[242.533300] Starting subtest: fbcpsr-rgb565-draw-blt
[242.535867] Subtest fbcpsr-rgb565-draw-blt: SKIP (0.000s)
[242.628158] [044/142] (757s left) gem_ctx_persistence (legacy-engines-persistence)
[242.779426] Starting subtest: legacy-engines-persistence
[242.783051] Starting dynamic subtest: render
[243.565672] Dynamic subtest render: SUCCESS (0.782s)
[243.584971] Starting dynamic subtest: bsd
[244.339066] Dynamic subtest bsd: SUCCESS (0.771s)
[244.360253] Starting dynamic subtest: blt
[245.100108] Dynamic subtest blt: SUCCESS (0.759s)
[245.119606] Starting dynamic subtest: vebox
[245.874954] Dynamic subtest vebox: SUCCESS (0.772s)
[245.876491] Subtest legacy-engines-persistence: SUCCESS (3.095s)
[245.961671] [045/142] (753s left) kms_flip_scaled_crc (flip-64bpp-linear-to-32bpp-linear-upscaling)
[246.209834] Starting subtest: flip-64bpp-linear-to-32bpp-linear-upscaling
[246.211342] Starting dynamic subtest: pipe-A-valid-mode
[246.657586] Dynamic subtest pipe-A-valid-mode: SKIP (0.446s)
[246.661042] Subtest flip-64bpp-linear-to-32bpp-linear-upscaling: SKIP (0.448s)
[247.023838] [046/142] (752s left) syncobj_wait (multi-wait-all-for-submit-signaled)
[247.175766] Starting subtest: multi-wait-all-for-submit-signaled
[247.177601] Subtest multi-wait-all-for-submit-signaled: SUCCESS (0.001s)
[247.255581] [047/142] (752s left) kms_cursor_legacy (single-move)
[247.490318] Starting subtest: single-move
[247.492103] Starting dynamic subtest: pipe-A
[252.899464] Dynamic subtest pipe-A: SUCCESS (5.407s)
[252.917664] Starting dynamic subtest: pipe-B
[258.308449] Dynamic subtest pipe-B: SUCCESS (5.406s)
[258.326705] Starting dynamic subtest: pipe-C
[263.717985] Dynamic subtest pipe-C: SUCCESS (5.407s)
[263.736687] Starting dynamic subtest: all-pipes
[269.126730] Dynamic subtest all-pipes: SUCCESS (5.408s)
[269.128228] Subtest single-move: SUCCESS (21.635s)
[269.223605] [048/142] (730s left) kms_frontbuffer_tracking (basic)
[269.470140] Starting subtest: basic
[272.350229] Subtest basic: SUCCESS (2.881s)
[272.474352] [049/142] (727s left) gem_exec_schedule (fairslice)
[272.648235] Starting subtest: fairslice
[272.649730] Starting dynamic subtest: rcs0
[274.683084] Dynamic subtest rcs0: SUCCESS (2.032s)
[274.702592] Starting dynamic subtest: bcs0
[276.717914] Dynamic subtest bcs0: SUCCESS (2.032s)
[276.738406] Starting dynamic subtest: vcs0
[278.744975] Dynamic subtest vcs0: SUCCESS (2.027s)
[278.764237] Starting dynamic subtest: vecs0
[280.772161] Dynamic subtest vecs0: SUCCESS (2.025s)
[280.773475] Subtest fairslice: SUCCESS (8.121s)
[281.106595] [050/142] (718s left) kms_flip (2x-plain-flip-fb-recreate-interruptible)
[281.341401] Starting subtest: 2x-plain-flip-fb-recreate-interruptible
[281.346046] Subtest 2x-plain-flip-fb-recreate-interruptible: SKIP (0.003s)
[281.439307] [051/142] (718s left) gen9_exec_parse (allowed-all)
[281.605063] Starting subtest: allowed-all
[281.608950] Subtest allowed-all: SUCCESS (0.003s)
[281.823592] [052/142] (718s left) kms_plane_lowres (tiling-y)
[282.057475] Starting subtest: tiling-y
[282.058816] Starting dynamic subtest: pipe-A-DP-1
[288.404305] Dynamic subtest pipe-A-DP-1: SUCCESS (6.346s)
[288.519822] Starting dynamic subtest: pipe-B-DP-1
[294.718066] Dynamic subtest pipe-B-DP-1: SUCCESS (6.212s)
[294.848790] Starting dynamic subtest: pipe-C-DP-1
[299.067042] Dynamic subtest pipe-C-DP-1: SUCCESS (4.237s)
[299.162700] Subtest tiling-y: SUCCESS (17.104s)
[299.630734] [053/142] (700s left) kms_atomic_transition (plane-all-modeset-transition-internal-panels)
[299.879393] Starting subtest: plane-all-modeset-transition-internal-panels
[299.882146] Subtest plane-all-modeset-transition-internal-panels: SKIP (0.000s)
[299.962627] [054/142] (700s left) i915_hwmon (hwmon-read)
[300.104707] Subtest hwmon-read: SKIP (0.000s)
[300.161939] [055/142] (700s left) kms_ccs (pipe-b-bad-aux-stride-y_tiled_gen12_mc_ccs)
[300.573988] Starting subtest: pipe-B-bad-aux-stride-y_tiled_gen12_mc_ccs
[300.576740] Subtest pipe-B-bad-aux-stride-y_tiled_gen12_mc_ccs: SKIP (0.000s)
[300.954688] [056/142] (699s left) perf (create-destroy-userspace-config)
[301.239198] Starting subtest: create-destroy-userspace-config
[301.329623] Subtest create-destroy-userspace-config: SUCCESS (0.090s)
[301.372741] [057/142] (698s left) kms_ccs (pipe-a-bad-aux-stride-y_tiled_gen12_rc_ccs_cc)
[301.748151] Starting subtest: pipe-A-bad-aux-stride-y_tiled_gen12_rc_ccs_cc
[301.750895] Subtest pipe-A-bad-aux-stride-y_tiled_gen12_rc_ccs_cc: SKIP (0.000s)
[302.181752] [058/142] (698s left) kms_flip (2x-flip-vs-fences)
[302.403802] Starting subtest: 2x-flip-vs-fences
[302.406312] Subtest 2x-flip-vs-fences: SKIP (0.003s)
[302.515884] [059/142] (697s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-mmap-cpu)
[302.760706] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-mmap-cpu
[302.763407] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[302.864957] [060/142] (697s left) kms_flip (2x-flip-vs-rmfb)
[303.088613] Starting subtest: 2x-flip-vs-rmfb
[303.091197] Subtest 2x-flip-vs-rmfb: SKIP (0.003s)
[303.198395] [061/142] (697s left) gem_lmem_swapping (heavy-random)
[303.348325] Subtest heavy-random: SKIP (0.000s)
[303.398861] [062/142] (697s left) kms_ccs (pipe-c-crc-sprite-planes-basic-y_tiled_gen12_rc_ccs)
[303.860157] Starting subtest: pipe-C-crc-sprite-planes-basic-y_tiled_gen12_rc_ccs
[303.865872] Subtest pipe-C-crc-sprite-planes-basic-y_tiled_gen12_rc_ccs: SKIP (0.005s)
[304.176691] [063/142] (696s left) gem_userptr_blits (map-fixed-invalidate-overlap)
[304.363961] Starting subtest: map-fixed-invalidate-overlap
[304.365308] Starting dynamic subtest: gtt
[304.626946] Dynamic subtest gtt: SUCCESS (0.263s)
[304.647190] Starting dynamic subtest: wb
[304.803964] Dynamic subtest wb: SUCCESS (0.175s)
[304.827184] Starting dynamic subtest: wc
[304.987890] Dynamic subtest wc: SUCCESS (0.181s)
[305.008153] Starting dynamic subtest: uc
[305.165190] Dynamic subtest uc: SUCCESS (0.175s)
[305.166850] Subtest map-fixed-invalidate-overlap: SUCCESS (0.804s)
[305.310746] [064/142] (695s left) kms_flip (basic-plain-flip)
[305.539619] Starting subtest: basic-plain-flip
[305.540940] Starting dynamic subtest: A-DP1
[306.723497] Dynamic subtest A-DP1: SUCCESS (1.183s)
[306.749857] Starting dynamic subtest: B-DP1
[307.848629] Dynamic subtest B-DP1: SUCCESS (1.122s)
[307.872252] Starting dynamic subtest: C-DP1
[308.974038] Dynamic subtest C-DP1: SUCCESS (1.123s)
[308.978306] Subtest basic-plain-flip: SUCCESS (3.440s)
[309.411651] [065/142] (691s left) gem_exec_balancer (invalid-bonds)
[309.579303] Starting subtest: invalid-bonds
[309.593867] Subtest invalid-bonds: SUCCESS (0.015s)
[313.606753] [066/142] (687s left) gem_exec_balancer (parallel-keep-submit-fence)
[317.739778] Subtest parallel-keep-submit-fence: SKIP (0.000s)
[317.839105] [067/142] (682s left) v3d/v3d_submit_csd (bad-pad)
[318.036144] Subtest bad-pad: SKIP (0.000s)
[318.107826] [068/142] (682s left) syncobj_timeline (invalid-transfer-illegal-handle)
[318.252879] Starting subtest: invalid-transfer-illegal-handle
[318.254718] Subtest invalid-transfer-illegal-handle: SUCCESS (0.000s)
[318.338315] [069/142] (682s left) v3d/v3d_get_bo_offset (get-bad-handle)
[318.535668] Subtest get-bad-handle: SKIP (0.000s)
[318.605500] [070/142] (682s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-mmap-wc)
[318.848385] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-mmap-wc
[318.850994] Subtest fbc-2p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[318.939162] [071/142] (681s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-blt)
[319.183683] Starting subtest: psr-1p-primscrn-spr-indfb-draw-blt
[319.186403] Subtest psr-1p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[319.289168] [072/142] (681s left) kms_chamelium_hpd (vga-hpd-fast)
[319.633944] Subtest vga-hpd-fast: SKIP (0.000s)
[319.936708] [073/142] (680s left) gem_exec_reloc (basic-gtt-cpu-active)
[320.093458] Starting subtest: basic-gtt-cpu-active
[320.231836] Subtest basic-gtt-cpu-active: SUCCESS (0.137s)
[320.412882] [074/142] (680s left) syncobj_timeline (etime-single-wait-all-for-submit-available-unsubmitted)
[320.557032] Starting subtest: etime-single-wait-all-for-submit-available-unsubmitted
[320.669765] Subtest etime-single-wait-all-for-submit-available-unsubmitted: SUCCESS (0.108s)
[320.763928] [075/142] (680s left) kms_ccs (pipe-d-missing-ccs-buffer-4_tiled_mtl_rc_ccs)
[321.246498] Subtest pipe-D-missing-ccs-buffer-4_tiled_mtl_rc_ccs: SKIP (0.000s)
[321.567949] [076/142] (679s left) gem_exec_fence (syncobj-timeline-chain-engines)
[322.334437] Starting subtest: syncobj-timeline-chain-engines
[322.459874] Subtest syncobj-timeline-chain-engines: SUCCESS (0.126s)
[322.686441] [077/142] (678s left) gem_eio (create)
[322.847218] Starting subtest: create
[322.886728] Subtest create: SUCCESS (0.038s)
[323.083902] [078/142] (678s left) drm_fdinfo (virtual-idle)
[323.233475] Starting subtest: virtual-idle
[325.264701] Subtest virtual-idle: SUCCESS (2.028s)
[325.350767] [079/142] (675s left) kms_vblank (pipe-b-wait-idle-hang)
[325.594787] Starting subtest: pipe-B-wait-idle-hang
[332.968257] Subtest pipe-B-wait-idle-hang: SUCCESS (7.374s)
[333.298353] [080/142] (667s left) i915_pm_rpm (modeset-lpsp)
[335.131743] Starting subtest: modeset-lpsp
[335.509160] Subtest modeset-lpsp: SKIP (0.374s)
[335.997907] [081/142] (665s left) gem_mmap_gtt (fault-concurrent)
[336.139857] Starting subtest: fault-concurrent
[339.619442] Subtest fault-concurrent: SUCCESS (3.479s)
[339.795892] [082/142] (661s left) gem_mmap_wc (bad-size)
[339.941341] Starting subtest: bad-size
[339.943395] Subtest bad-size: SUCCESS (0.001s)
[340.049063] [083/142] (661s left) gem_mmap_gtt (basic-small-bo-tiledx)
[340.188919] Starting subtest: basic-small-bo-tiledX
[342.130920] Subtest basic-small-bo-tiledX: SUCCESS (1.940s)
[342.289371] [084/142] (659s left) kms_frontbuffer_tracking (fbc-1p-offscren-pri-indfb-draw-mmap-wc)
[342.667714] Starting subtest: fbc-1p-offscren-pri-indfb-draw-mmap-wc
[344.510280] Subtest fbc-1p-offscren-pri-indfb-draw-mmap-wc: SUCCESS (1.847s)
[344.646861] [085/142] (656s left) kms_frontbuffer_tracking (psr-2p-scndscrn-indfb-plflip-blt)
[344.891956] Starting subtest: psr-2p-scndscrn-indfb-plflip-blt
[344.895388] Subtest psr-2p-scndscrn-indfb-plflip-blt: SKIP (0.000s)
[344.997476] [086/142] (656s left) kms_ccs (pipe-c-ccs-on-another-bo-4_tiled_mtl_rc_ccs_cc)
[345.463254] Starting subtest: pipe-C-ccs-on-another-bo-4_tiled_mtl_rc_ccs_cc
[345.466069] Subtest pipe-C-ccs-on-another-bo-4_tiled_mtl_rc_ccs_cc: SKIP (0.000s)
[345.816304] [087/142] (655s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-mmap-cpu)
[346.064049] Starting subtest: psr-2p-primscrn-spr-indfb-draw-mmap-cpu
[346.066896] Subtest psr-2p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[346.164575] [088/142] (655s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-32bpp-xtile-upscaling)
[346.411945] Starting subtest: flip-64bpp-xtile-to-32bpp-xtile-upscaling
[346.413364] Starting dynamic subtest: pipe-A-valid-mode
[346.861818] Dynamic subtest pipe-A-valid-mode: SKIP (0.445s)
[346.866448] Subtest flip-64bpp-xtile-to-32bpp-xtile-upscaling: SKIP (0.450s)
[347.230924] [089/142] (654s left) kms_ccs (pipe-b-random-ccs-data-y_tiled_ccs)
[347.622352] Starting subtest: pipe-B-random-ccs-data-y_tiled_ccs
[348.079834] Subtest pipe-B-random-ccs-data-y_tiled_ccs: SUCCESS (0.456s)
[348.548378] [090/142] (653s left) kms_flip (2x-plain-flip)
[348.768786] Starting subtest: 2x-plain-flip
[348.771274] Subtest 2x-plain-flip: SKIP (0.003s)
[348.880212] [091/142] (652s left) gem_exec_fence (basic-wait)
[349.186127] Starting subtest: basic-wait
[349.187486] Starting dynamic subtest: rcs0
[349.216844] Dynamic subtest rcs0: SUCCESS (0.029s)
[349.242826] Starting dynamic subtest: bcs0
[349.247617] Dynamic subtest bcs0: SUCCESS (0.025s)
[349.268583] Starting dynamic subtest: vcs0
[349.274159] Dynamic subtest vcs0: SUCCESS (0.024s)
[349.295722] Starting dynamic subtest: vecs0
[349.307694] Dynamic subtest vecs0: SUCCESS (0.032s)
[349.309722] Subtest basic-wait: SUCCESS (0.123s)
[349.979738] [092/142] (651s left) syncobj_wait (invalid-multi-wait-unsubmitted-submitted-signaled)
[350.137070] Starting subtest: invalid-multi-wait-unsubmitted-submitted-signaled
[350.138731] Subtest invalid-multi-wait-unsubmitted-submitted-signaled: SUCCESS (0.001s)
[350.229403] [093/142] (651s left) kms_busy (extended-pageflip-hang-newfb)
[350.473171] Starting subtest: extended-pageflip-hang-newfb
[350.477959] Starting dynamic subtest: pipe-A
[355.035716] Dynamic subtest pipe-A: SUCCESS (4.559s)
[355.061940] Starting dynamic subtest: pipe-C
[359.004607] Dynamic subtest pipe-C: SUCCESS (3.960s)
[359.006615] Subtest extended-pageflip-hang-newfb: SUCCESS (8.532s)
[359.371837] [094/142] (642s left) gem_render_copy (y-tiled-ccs-to-y-tiled-ccs)
[359.532730] Starting subtest: y-tiled-ccs-to-y-tiled-ccs
[359.534287] Starting dynamic subtest: smem
[359.845327] Dynamic subtest smem: SUCCESS (0.311s)
[359.846968] Subtest y-tiled-ccs-to-y-tiled-ccs: SUCCESS (0.314s)
[360.055755] [095/142] (641s left) kms_properties (connector-properties-legacy)
[360.288508] Starting subtest: connector-properties-legacy
[362.570036] Subtest connector-properties-legacy: SUCCESS (2.283s)
[362.890242] [096/142] (638s left) gem_exec_whisper (basic-contexts-priority-all)
[363.060832] Starting subtest: basic-contexts-priority-all
[386.927678] Subtest basic-contexts-priority-all: SUCCESS (23.864s)
[387.136730] [097/142] (614s left) kms_plane_scaling (plane-upscale-with-rotation-factor-0-25)
[387.379027] Starting subtest: plane-upscale-with-rotation-factor-0-25
[387.383161] Starting dynamic subtest: pipe-A-DP-1
[387.451378] Dynamic subtest pipe-A-DP-1: SKIP (0.066s)
[387.472339] Starting dynamic subtest: pipe-B-DP-1
[387.807292] Dynamic subtest pipe-B-DP-1: SKIP (0.350s)
[387.835731] Starting dynamic subtest: pipe-C-DP-1
[388.157413] Dynamic subtest pipe-C-DP-1: SKIP (0.347s)
[388.160105] Subtest plane-upscale-with-rotation-factor-0-25: SKIP (0.779s)
[388.576846] [098/142] (613s left) syncobj_timeline (etime-multi-wait-all-for-submit-available-unsubmitted-signa
[388.722273] Starting subtest: etime-multi-wait-all-for-submit-available-unsubmitted-signaled
[388.826417] Subtest etime-multi-wait-all-for-submit-available-unsubmitted-signaled: SUCCESS (0.103s)
[388.911604] [099/142] (613s left) kms_getfb (getfb2-handle-closed)
[389.056874] Starting subtest: getfb2-handle-closed
[389.058766] Subtest getfb2-handle-closed: SUCCESS (0.000s)
[389.161718] [100/142] (612s left) api_intel_bb (blit-reloc-keep-cache)
[389.305989] Starting subtest: blit-reloc-keep-cache
[389.322505] Subtest blit-reloc-keep-cache: SUCCESS (0.019s)
[389.428428] [101/142] (612s left) i915_query (query-regions-sanity-check)
[389.571307] Starting subtest: query-regions-sanity-check
[389.609445] Subtest query-regions-sanity-check: SUCCESS (0.038s)
[389.726859] [102/142] (612s left) dumb_buffer (map-uaf)
[389.867637] Starting subtest: map-uaf
[389.936746] Subtest map-uaf: SUCCESS (0.070s)
[390.076168] [103/142] (612s left) gem_exec_schedule (semaphore-noskip)
[390.252086] Starting subtest: semaphore-noskip
[390.493069] Subtest semaphore-noskip: SUCCESS (0.244s)
[390.843123] [104/142] (611s left) kms_ccs (pipe-b-ccs-on-another-bo-y_tiled_gen12_rc_ccs_cc)
[391.260194] Starting subtest: pipe-B-ccs-on-another-bo-y_tiled_gen12_rc_ccs_cc
[391.262772] Subtest pipe-B-ccs-on-another-bo-y_tiled_gen12_rc_ccs_cc: SKIP (0.000s)
[391.637613] [105/142] (610s left) core_hotunplug (unbind-rebind)
[391.848501] Starting subtest: unbind-rebind
[395.539592] Subtest unbind-rebind: SUCCESS (3.691s)
[395.589110] [106/142] (606s left) kms_plane_scaling (plane-scaler-with-rotation-unity-scaling)
[395.841591] Starting subtest: plane-scaler-with-rotation-unity-scaling
[395.845858] Starting dynamic subtest: pipe-A-DP-1
[395.962385] Dynamic subtest pipe-A-DP-1: SKIP (0.114s)
[395.986180] Starting dynamic subtest: pipe-B-DP-1
[396.365361] Dynamic subtest pipe-B-DP-1: SKIP (0.399s)
[396.392780] Starting dynamic subtest: pipe-C-DP-1
[396.772980] Dynamic subtest pipe-C-DP-1: SKIP (0.403s)
[396.776078] Subtest plane-scaler-with-rotation-unity-scaling: SKIP (0.932s)
[397.181390] [107/142] (605s left) kms_addfb_basic (unused-handle)
[397.323605] Starting subtest: unused-handle
[397.325110] Subtest unused-handle: SUCCESS (0.000s)
[397.529930] [108/142] (604s left) gem_sync (basic-many-each)
[397.703036] Starting subtest: basic-many-each
[400.095193] Subtest basic-many-each: SUCCESS (2.392s)
[400.298969] [109/142] (602s left) prime_mmap (test_forked_cpu_write)
[400.442112] Starting subtest: test_forked_cpu_write
[400.443584] Starting dynamic subtest: test_forked_cpu_write-smem
[400.477748] Dynamic subtest test_forked_cpu_write-smem: SUCCESS (0.035s)
[400.479671] Subtest test_forked_cpu_write: SUCCESS (0.038s)
[400.563464] [110/142] (601s left) kms_psr2_su (page_flip-nv12)
[400.708493] Subtest page_flip-NV12: SKIP (0.000s)
[400.765617] [111/142] (601s left) kms_rotation_crc (multiplane-rotation-cropping-bottom)
[401.012540] Starting subtest: multiplane-rotation-cropping-bottom
[415.009313] Subtest multiplane-rotation-cropping-bottom: SUCCESS (13.997s)
[415.130786] [112/142] (587s left) kms_ccs (pipe-c-bad-aux-stride-y_tiled_gen12_mc_ccs)
[415.601854] Starting subtest: pipe-C-bad-aux-stride-y_tiled_gen12_mc_ccs
[415.604888] Subtest pipe-C-bad-aux-stride-y_tiled_gen12_mc_ccs: SKIP (0.000s)
[415.928299] [113/142] (586s left) kms_atomic_transition (plane-all-modeset-transition-fencing)
[416.162923] Starting subtest: plane-all-modeset-transition-fencing
[416.164435] Starting dynamic subtest: pipe-A-DP-1
[474.124404] Dynamic subtest pipe-A-DP-1: SUCCESS (57.959s)
[474.250574] Starting dynamic subtest: pipe-B-DP-1
[531.862103] Dynamic subtest pipe-B-DP-1: SUCCESS (57.638s)
[531.956721] Subtest plane-all-modeset-transition-fencing: SUCCESS (115.795s)
[532.310220] [114/142] (470s left) kms_pipe_b_c_ivb (pipe-b-dpms-off-modeset-pipe-c)
[532.465823] Subtest pipe-B-dpms-off-modeset-pipe-C: SKIP (0.000s)
[532.525723] [115/142] (470s left) perf_pmu (all-busy-check-all)
[532.673188] Starting subtest: all-busy-check-all
[533.200828] Subtest all-busy-check-all: SUCCESS (0.526s)
[533.289662] [116/142] (469s left) kms_prop_blob (blob-multiple)
[533.433245] Starting subtest: blob-multiple
[533.434532] Subtest blob-multiple: SUCCESS (0.003s)
[533.524374] [117/142] (469s left) kms_ccs (pipe-d-random-ccs-data-y_tiled_ccs)
[533.987430] Subtest pipe-D-random-ccs-data-y_tiled_ccs: SKIP (0.000s)
[534.315755] [118/142] (468s left) kms_big_fb (y-tiled-32bpp-rotate-270)
[534.582441] Starting subtest: y-tiled-32bpp-rotate-270
[539.452851] Subtest y-tiled-32bpp-rotate-270: SUCCESS (4.869s)
[540.013726] [119/142] (462s left) kms_vblank (pipe-b-wait-forked-busy)
[540.265607] Starting subtest: pipe-B-wait-forked-busy
[543.089268] Subtest pipe-B-wait-forked-busy: SUCCESS (2.823s)
[543.438545] [120/142] (459s left) tools_test (sysfs_l3_parity)
[543.583782] Starting subtest: sysfs_l3_parity
[543.781942] Subtest sysfs_l3_parity: SKIP (0.203s)
[543.854753] [121/142] (459s left) kms_vblank (pipe-d-query-forked-busy)
[544.091480] Subtest pipe-D-query-forked-busy: SKIP (0.000s)
[544.171278] [122/142] (458s left) gem_exec_reloc (basic-write-cpu-noreloc)
[544.327638] Starting subtest: basic-write-cpu-noreloc
[544.332402] Subtest basic-write-cpu-noreloc: SUCCESS (0.007s)
[544.520957] [123/142] (458s left) kms_frontbuffer_tracking (fbc-rgb565-draw-mmap-gtt)
[544.770694] Starting subtest: fbc-rgb565-draw-mmap-gtt
[546.927633] Subtest fbc-rgb565-draw-mmap-gtt: SUCCESS (2.157s)
[547.070115] [124/142] (456s left) kms_big_fb (yf-tiled-32bpp-rotate-90)
[547.328919] Starting subtest: yf-tiled-32bpp-rotate-90
[552.177457] Subtest yf-tiled-32bpp-rotate-90: SUCCESS (4.847s)
[552.721610] [125/142] (450s left) prime_vgem (basic-read)
[552.873731] Starting subtest: basic-read
[552.938517] Subtest basic-read: SUCCESS (0.064s)
[553.056173] [126/142] (450s left) gem_pxp (reject-modify-context-protection-off-2)
[555.716732] Subtest reject-modify-context-protection-off-2: SKIP (0.000s)
[555.805217] [127/142] (447s left) kms_plane_alpha_blend (constant-alpha-min)
[556.053785] Starting subtest: constant-alpha-min
[556.368348] Starting dynamic subtest: pipe-A-DP-1
[557.058225] Dynamic subtest pipe-A-DP-1: SUCCESS (0.689s)
[557.084966] Starting dynamic subtest: pipe-C-DP-1
[557.984583] Dynamic subtest pipe-C-DP-1: SUCCESS (0.920s)
[557.985882] Subtest constant-alpha-min: SUCCESS (1.933s)
[558.365549] [128/142] (444s left) kms_frontbuffer_tracking (psr-rgb101010-draw-pwrite)
[558.612195] Starting subtest: psr-rgb101010-draw-pwrite
[558.615230] Subtest psr-rgb101010-draw-pwrite: SKIP (0.000s)
[558.732360] [129/142] (444s left) kms_ccs (pipe-c-missing-ccs-buffer-yf_tiled_ccs)
[559.198971] Starting subtest: pipe-C-missing-ccs-buffer-yf_tiled_ccs
[559.201682] Subtest pipe-C-missing-ccs-buffer-yf_tiled_ccs: SKIP (0.000s)
[559.555815] [130/142] (443s left) vc4/vc4_purgeable_bo (mark-unpurgeable-twice)
[559.762153] Subtest mark-unpurgeable-twice: SKIP (0.000s)
[559.837170] [131/142] (443s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-mmap-gtt)
[560.081068] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-mmap-gtt
[560.084070] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[560.187194] [132/142] (443s left) kms_big_fb (4-tiled-8bpp-rotate-270)
[560.446149] Starting subtest: 4-tiled-8bpp-rotate-270
[560.449179] Subtest 4-tiled-8bpp-rotate-270: SKIP (0.000s)
[560.553581] [133/142] (442s left) syncobj_wait (multi-wait-all-for-submit-submitted-signaled)
[560.695111] Starting subtest: multi-wait-all-for-submit-submitted-signaled
[560.805327] Subtest multi-wait-all-for-submit-submitted-signaled: SUCCESS (0.106s)
[560.887560] [134/142] (442s left) syncobj_timeline (reset-signaled)
[561.032200] Starting subtest: reset-signaled
[561.033791] Subtest reset-signaled: SUCCESS (0.001s)
[561.120190] [135/142] (442s left) gem_exec_store (dword)
[561.290898] Starting subtest: dword
[561.292511] Starting dynamic subtest: rcs0
[561.333405] Dynamic subtest rcs0: SUCCESS (0.037s)
[561.357294] Starting dynamic subtest: bcs0
[561.358872] Dynamic subtest bcs0: SUCCESS (0.018s)
[561.382740] Starting dynamic subtest: vcs0
[561.384265] Dynamic subtest vcs0: SUCCESS (0.021s)
[561.406469] Starting dynamic subtest: vecs0
[561.412312] Dynamic subtest vecs0: SUCCESS (0.030s)
[561.413651] Subtest dword: SUCCESS (0.120s)
[561.621868] [136/142] (442s left) gem_workarounds (basic-read-fd)
[561.796772] Starting subtest: basic-read-fd
[561.819938] Subtest basic-read-fd: SUCCESS (0.023s)
[561.937343] [137/142] (441s left) gem_sync (basic-store-each)
[562.107632] Starting subtest: basic-store-each
[564.623147] Subtest basic-store-each: SUCCESS (2.517s)
[564.840343] [138/142] (438s left) gem_softpin (allocator-basic)
[564.991855] Starting subtest: allocator-basic
[565.235115] Subtest allocator-basic: SUCCESS (0.243s)
[565.369562] [139/142] (438s left) kms_frontbuffer_tracking (psr-1p-offscren-pri-shrfb-draw-mmap-gtt)
[565.613071] Starting subtest: psr-1p-offscren-pri-shrfb-draw-mmap-gtt
[565.615997] Subtest psr-1p-offscren-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[565.719965] [140/142] (438s left) kms_cursor_crc (cursor-rapid-movement-512x512)
[565.973978] Starting subtest: cursor-rapid-movement-512x512
[565.979880] Subtest cursor-rapid-movement-512x512: SKIP (0.003s)
[566.087924] [141/142] (437s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip)
[566.353449] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip
[566.356755] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip: SKIP (0.000s)
[566.454393] [142/142] (437s left) kms_flip_event_leak (basic)
[566.692685] Starting subtest: basic
[566.694148] Starting dynamic subtest: pipe-A-DP-1
[566.992885] Dynamic subtest pipe-A-DP-1: SUCCESS (0.296s)
[567.025693] Starting dynamic subtest: pipe-B-DP-1
[567.450390] Dynamic subtest pipe-B-DP-1: SUCCESS (0.451s)
[567.483955] Starting dynamic subtest: pipe-C-DP-1
[567.906431] Dynamic subtest pipe-C-DP-1: SUCCESS (0.454s)
[567.908127] Subtest basic: SUCCESS (1.214s)
[568.244594] Closing watchdogs
Done.