[51.698951] Initializing watchdogs
[51.699253]   /dev/watchdog0
[51.731894] [001/142] (960s left) gem_exec_fence (invalid-timeline-fence-array)
[52.766501] Starting subtest: invalid-timeline-fence-array
[52.785495] Subtest invalid-timeline-fence-array: SUCCESS (0.010s)
[53.041685] [002/142] (959s left) kms_ccs (pipe-a-random-ccs-data-4_tiled_mtl_mc_ccs)
[53.564435] Starting subtest: pipe-A-random-ccs-data-4_tiled_mtl_mc_ccs
[53.626728] Subtest pipe-A-random-ccs-data-4_tiled_mtl_mc_ccs: SKIP (0.000s)
[54.180971] [003/142] (958s left) kms_ccs (pipe-d-random-ccs-data-4_tiled_dg2_rc_ccs_cc)
[54.943367] Subtest pipe-D-random-ccs-data-4_tiled_dg2_rc_ccs_cc: SKIP (0.000s)
[55.254704] [004/142] (957s left) gem_render_copy (y-tiled)
[55.574607] Starting subtest: y-tiled
[55.596338] Starting dynamic subtest: smem
[55.878438] Dynamic subtest smem: SUCCESS (0.315s)
[55.899032] Subtest y-tiled: SUCCESS (0.316s)
[56.131621] [005/142] (956s left) kms_flip (2x-flip-vs-suspend)
[56.515198] Starting subtest: 2x-flip-vs-suspend
[56.552814] Subtest 2x-flip-vs-suspend: SKIP (0.003s)
[56.659807] [006/142] (956s left) gem_pxp (protected-encrypted-src-copy-not-readible)
[59.654834] Subtest protected-encrypted-src-copy-not-readible: SKIP (0.000s)
[59.777558] [007/142] (953s left) kms_ccs (pipe-c-bad-rotation-90-yf_tiled_ccs)
[60.421194] Starting subtest: pipe-C-bad-rotation-90-yf_tiled_ccs
[60.464349] Subtest pipe-C-bad-rotation-90-yf_tiled_ccs: SKIP (0.000s)
[60.858185] [008/142] (952s left) kms_content_protection (legacy)
[61.266961] Starting subtest: legacy
[61.461137] Starting dynamic subtest: pipe-A-DP-1
[182.010618] Per-test timeout exceeded. Killing the current test with SIGQUIT.
[189.404442] Closing watchdogs
[189.414342] Initializing watchdogs
[189.414525]   /dev/watchdog0
[189.466535] [009/142] (823s left) kms_fbcon_fbt (psr-suspend)
[189.765816] Starting subtest: psr-suspend
[189.803118] Subtest psr-suspend: SKIP (0.001s)
[189.907637] [010/142] (823s left) kms_ccs (pipe-b-missing-ccs-buffer-y_tiled_gen12_mc_ccs)
[190.497973] Starting subtest: pipe-B-missing-ccs-buffer-y_tiled_gen12_mc_ccs
[190.540612] Subtest pipe-B-missing-ccs-buffer-y_tiled_gen12_mc_ccs: SKIP (0.000s)
[190.987224] [011/142] (822s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-mmap-gtt)
[191.432306] Starting subtest: psr-1p-primscrn-spr-indfb-draw-mmap-gtt
[191.474387] Subtest psr-1p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[191.574599] [012/142] (821s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-onoff)
[192.015294] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-onoff
[192.052564] Subtest fbcpsr-1p-primscrn-cur-indfb-onoff: SKIP (0.000s)
[192.155745] [013/142] (821s left) i915_pm_rc6_residency (media-rc6-accuracy)
[192.589792] Starting subtest: media-rc6-accuracy
[192.631738] Subtest media-rc6-accuracy: SKIP (0.000s)
[192.731166] [014/142] (820s left) gem_ctx_param (invalid-set-no-zeromap)
[193.031048] Starting subtest: invalid-set-no-zeromap
[193.049828] Subtest invalid-set-no-zeromap: SUCCESS (0.000s)
[193.153102] [015/142] (820s left) gem_create (create-ext-cpu-access-sanity-check)
[193.546732] Starting subtest: create-ext-cpu-access-sanity-check
[193.589100] Subtest create-ext-cpu-access-sanity-check: SKIP (0.001s)
[193.690372] [016/142] (820s left) perf (rc6-disable)
[194.159448] Starting subtest: rc6-disable
[194.352556] Subtest rc6-disable: SUCCESS (0.220s)
[194.455731] [017/142] (819s left) kms_big_fb (y-tiled-addfb-size-offset-overflow)
[194.880230] Starting subtest: y-tiled-addfb-size-offset-overflow
[194.917661] Subtest y-tiled-addfb-size-offset-overflow: SKIP (0.000s)
[195.027745] [018/142] (818s left) kms_properties (plane-properties-legacy)
[195.408066] Starting subtest: plane-properties-legacy
[197.400497] Subtest plane-properties-legacy: SUCCESS (1.989s)
[197.772401] [019/142] (816s left) api_intel_allocator (execbuf-with-allocator)
[198.068254] Starting subtest: execbuf-with-allocator
[198.090156] Subtest execbuf-with-allocator: SUCCESS (0.010s)
[198.196536] [020/142] (815s left) gem_tiled_fence_blits (normal)
[199.727860] Starting subtest: normal
[201.752434] Subtest normal: SUCCESS (2.043s)
[201.882600] [021/142] (812s left) syncobj_timeline (single-wait-available-submitted)
[202.327746] Starting subtest: single-wait-available-submitted
[202.346977] Subtest single-wait-available-submitted: SUCCESS (0.001s)
[202.432043] [022/142] (811s left) kms_vblank (pipe-a-wait-forked)
[202.849879] Starting subtest: pipe-A-wait-forked
[205.209621] Subtest pipe-A-wait-forked: SUCCESS (2.347s)
[205.574219] [023/142] (808s left) i915_query (query-regions-garbage-items)
[205.871615] Starting subtest: query-regions-garbage-items
[205.892868] Subtest query-regions-garbage-items: SUCCESS (0.001s)
[205.996363] [024/142] (808s left) gem_userptr_blits (input-checking)
[206.353085] Starting subtest: input-checking
[206.371833] Subtest input-checking: SUCCESS (0.000s)
[206.482159] [025/142] (808s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-mmap-gtt)
[206.923407] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-mmap-gtt
[208.968991] Subtest fbc-1p-primscrn-spr-indfb-draw-mmap-gtt: SUCCESS (2.122s)
[209.132329] [026/142] (805s left) kms_ccs (pipe-a-ccs-on-another-bo-4_tiled_mtl_rc_ccs_cc)
[209.654663] Starting subtest: pipe-A-ccs-on-another-bo-4_tiled_mtl_rc_ccs_cc
[209.703470] Subtest pipe-A-ccs-on-another-bo-4_tiled_mtl_rc_ccs_cc: SKIP (0.000s)
[210.327744] [027/142] (804s left) kms_big_fb (x-tiled-64bpp-rotate-0)
[210.763201] Starting subtest: x-tiled-64bpp-rotate-0
[218.550595] Subtest x-tiled-64bpp-rotate-0: SUCCESS (7.829s)
[219.500367] [028/142] (795s left) kms_frontbuffer_tracking (psr-2p-primscrn-indfb-pgflip-blt)
[219.939869] Starting subtest: psr-2p-primscrn-indfb-pgflip-blt
[219.977141] Subtest psr-2p-primscrn-indfb-pgflip-blt: SKIP (0.000s)
[220.086482] [029/142] (794s left) kms_3d
[220.493222] [030/142] (794s left) gem_ctx_exec (basic)
[220.793737] Starting subtest: basic
[220.814665] Subtest basic: SUCCESS (0.007s)
[220.912228] [031/142] (794s left) kms_vblank (pipe-a-query-idle)
[221.248585] Starting subtest: pipe-A-query-idle
[223.546247] Subtest pipe-A-query-idle: SUCCESS (2.287s)
[223.918527] [032/142] (791s left) kms_chamelium_edid (hdmi-edid-change-during-suspend)
[224.385243] Subtest hdmi-edid-change-during-suspend: SKIP (0.000s)
[224.717790] [033/142] (790s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-render)
[225.139568] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-render
[225.182118] Subtest fbc-2p-scndscrn-cur-indfb-draw-render: SKIP (0.000s)
[225.287132] [034/142] (790s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt)
[225.729227] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt
[227.891178] Subtest fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt: SUCCESS (2.240s)
[228.053649] [035/142] (787s left) kms_ccs (pipe-c-crc-primary-basic-4_tiled_mtl_mc_ccs)
[228.707112] Starting subtest: pipe-C-crc-primary-basic-4_tiled_mtl_mc_ccs
[228.745781] Subtest pipe-C-crc-primary-basic-4_tiled_mtl_mc_ccs: SKIP (0.001s)
[229.124615] [036/142] (786s left) v3d/v3d_submit_csd (bad-pad)
[229.469486] Subtest bad-pad: SKIP (0.000s)
[229.576690] [037/142] (786s left) drm_fdinfo (all-busy-check-all)
[229.871596] Starting subtest: all-busy-check-all
[230.383312] Subtest all-busy-check-all: SUCCESS (0.529s)
[230.506390] [038/142] (785s left) gem_wait (write-wait)
[230.824502] Starting subtest: write-wait
[230.844699] Starting dynamic subtest: all-engines
[231.866412] Dynamic subtest all-engines: SUCCESS (1.043s)
[231.901219] Starting dynamic subtest: rcs0
[232.898209] Dynamic subtest rcs0: SUCCESS (1.030s)
[232.935986] Starting dynamic subtest: bcs0
[233.933778] Dynamic subtest bcs0: SUCCESS (1.037s)
[233.968920] Starting dynamic subtest: vcs0
[234.970676] Dynamic subtest vcs0: SUCCESS (1.029s)
[235.007760] Starting dynamic subtest: vecs0
[235.998746] Dynamic subtest vecs0: SUCCESS (1.031s)
[236.017749] Subtest write-wait: SUCCESS (5.175s)
[236.262162] [039/142] (779s left) syncobj_timeline (invalid-signal-bad-pad)
[236.557093] Starting subtest: invalid-signal-bad-pad
[236.577845] Subtest invalid-signal-bad-pad: SUCCESS (0.000s)
[236.663425] [040/142] (779s left) api_intel_bb (blit-noreloc-keep-cache)
[236.944200] Starting subtest: blit-noreloc-keep-cache
[236.965063] Subtest blit-noreloc-keep-cache: SUCCESS (0.018s)
[237.055143] [041/142] (779s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-pwrite)
[237.495642] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-pwrite
[237.533212] Subtest fbc-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[237.640531] [042/142] (778s left) kms_plane_scaling (planes-upscale-factor-0-25-downscale-factor-0-75)
[238.004487] Starting subtest: planes-upscale-factor-0-25-downscale-factor-0-75
[238.025614] Starting dynamic subtest: pipe-A-DP-1
[238.109223] Dynamic subtest pipe-A-DP-1: SUCCESS (0.089s)
[238.148250] Starting dynamic subtest: pipe-B-DP-1
[238.470238] Dynamic subtest pipe-B-DP-1: SUCCESS (0.356s)
[238.504968] Starting dynamic subtest: pipe-C-DP-1
[238.576888] Dynamic subtest pipe-C-DP-1: SKIP (0.090s)
[238.597907] Subtest planes-upscale-factor-0-25-downscale-factor-0-75: SUCCESS (0.546s)
[239.011460] [043/142] (777s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-64bpp-yftile-downscaling)
[239.391647] Starting subtest: flip-32bpp-yftile-to-64bpp-yftile-downscaling
[239.411159] Starting dynamic subtest: pipe-A-valid-mode
[239.548136] Dynamic subtest pipe-A-valid-mode: SKIP (0.127s)
[239.586737] Subtest flip-32bpp-yftile-to-64bpp-yftile-downscaling: SKIP (0.129s)
[239.885500] [044/142] (776s left) syncobj_wait (reset-unsignaled)
[240.191748] Starting subtest: reset-unsignaled
[240.213256] Subtest reset-unsignaled: SUCCESS (0.000s)
[240.323409] [045/142] (776s left) gem_mmap_wc (fault-concurrent)
[240.645489] Starting subtest: fault-concurrent
[242.294295] Subtest fault-concurrent: SUCCESS (1.683s)
[242.431781] [046/142] (774s left) gem_userptr_blits (vma-merge)
[242.798036] Starting subtest: vma-merge
[263.755859] Subtest vma-merge: FAIL (20.616s)
[263.868258] [047/142] (752s left) kms_ccs (pipe-d-bad-aux-stride-yf_tiled_ccs)
[264.626810] Subtest pipe-D-bad-aux-stride-yf_tiled_ccs: SKIP (0.000s)
[264.964936] [048/142] (751s left) kms_frontbuffer_tracking (fbc-tiling-linear)
[265.406407] Starting subtest: fbc-tiling-linear
[267.245916] Subtest fbc-tiling-linear: SUCCESS (1.932s)
[267.411227] [049/142] (749s left) syncobj_wait (multi-wait-all-for-submit-unsubmitted)
[267.704040] Starting subtest: multi-wait-all-for-submit-unsubmitted
[267.777954] Subtest multi-wait-all-for-submit-unsubmitted: SUCCESS (0.106s)
[267.892998] [050/142] (749s left) syncobj_timeline (etime-multi-wait-all-for-submit-submitted-signaled)
[268.183167] Starting subtest: etime-multi-wait-all-for-submit-submitted-signaled
[268.265853] Subtest etime-multi-wait-all-for-submit-submitted-signaled: SUCCESS (0.109s)
[268.379778] [051/142] (748s left) gem_exec_whisper (basic-queues-forked-all)
[268.716328] Starting subtest: basic-queues-forked-all
[291.472811] Subtest basic-queues-forked-all: SUCCESS (22.788s)
[291.682095] [052/142] (725s left) gem_ctx_bad_destroy (invalid-pad)
[291.971972] Starting subtest: invalid-pad
[291.993171] Subtest invalid-pad: SUCCESS (0.000s)
[292.081801] [053/142] (725s left) gem_mmap_gtt (fault-concurrent-y)
[292.381412] Starting subtest: fault-concurrent-Y
[295.855224] Subtest fault-concurrent-Y: SUCCESS (3.338s)
[296.098737] [054/142] (721s left) prime_busy (hang-wait)
[296.398950] Starting subtest: hang-wait
[296.420669] Starting dynamic subtest: rcs0
[303.077742] Dynamic subtest rcs0: SUCCESS (6.514s)
[303.116154] Starting dynamic subtest: bcs0
[310.117310] Dynamic subtest bcs0: SUCCESS (7.036s)
[310.153228] Starting dynamic subtest: vcs0
[317.031165] Dynamic subtest vcs0: SUCCESS (6.972s)
[317.067145] Starting dynamic subtest: vecs0
[323.966095] Dynamic subtest vecs0: SUCCESS (7.040s)
[323.987040] Subtest hang-wait: SUCCESS (27.569s)
[324.077185] [055/142] (693s left) api_intel_bb (offset-control)
[324.371186] Starting subtest: offset-control
[324.389849] Subtest offset-control: SUCCESS (0.017s)
[324.497765] [056/142] (693s left) gem_exec_flush (basic-wb-ro-default)
[324.835805] Starting subtest: basic-wb-ro-default
[330.437689] Subtest basic-wb-ro-default: SUCCESS (5.494s)
[330.548516] [057/142] (687s left) gem_gpgpu_fill (basic)
[330.847404] Starting subtest: basic
[330.868082] Starting dynamic subtest: smem
[330.887133] Dynamic subtest smem: SUCCESS (0.012s)
[330.906353] Subtest basic: SUCCESS (0.014s)
[330.994638] [058/142] (686s left) kms_flip (dpms-off-confusion-interruptible)
[331.379265] Starting subtest: dpms-off-confusion-interruptible
[331.400067] Starting dynamic subtest: A-DP1
[342.062403] Dynamic subtest A-DP1: SUCCESS (10.515s)
[342.107657] Starting dynamic subtest: B-DP1
[352.361036] Dynamic subtest B-DP1: SUCCESS (10.446s)
[352.401247] Starting dynamic subtest: C-DP1
[362.954577] Dynamic subtest C-DP1: SUCCESS (10.445s)
[362.973366] Subtest dpms-off-confusion-interruptible: SUCCESS (31.418s)
[363.219743] [059/142] (654s left) perf_pmu (busy-idle)
[363.517830] Starting subtest: busy-idle
[363.536594] Starting dynamic subtest: rcs0
[364.156284] Dynamic subtest rcs0: SUCCESS (0.644s)
[364.194657] Starting dynamic subtest: bcs0
[364.791465] Dynamic subtest bcs0: SUCCESS (0.639s)
[364.828700] Starting dynamic subtest: vcs0
[365.433533] Dynamic subtest vcs0: SUCCESS (0.635s)
[365.471989] Starting dynamic subtest: vecs0
[366.066720] Dynamic subtest vecs0: SUCCESS (0.639s)
[366.085456] Subtest busy-idle: SUCCESS (2.564s)
[366.200400] [060/142] (651s left) gem_exec_params (invalid-ring2)
[366.497216] Starting subtest: invalid-ring2
[366.518280] Subtest invalid-ring2: SUCCESS (0.001s)
[366.606771] [061/142] (651s left) gem_exec_async (concurrent-writes)
[366.909485] Starting subtest: concurrent-writes
[366.929755] Starting dynamic subtest: rcs0
[366.949506] Dynamic subtest rcs0: SUCCESS (0.018s)
[366.988602] Starting dynamic subtest: bcs0
[367.007250] Dynamic subtest bcs0: SUCCESS (0.015s)
[367.045877] Starting dynamic subtest: vcs0
[367.067296] Dynamic subtest vcs0: SUCCESS (0.015s)
[367.105341] Starting dynamic subtest: vecs0
[367.126539] Dynamic subtest vecs0: SUCCESS (0.014s)
[367.145188] Subtest concurrent-writes: SUCCESS (0.069s)
[367.233578] [062/142] (650s left) kms_flip (2x-plain-flip-interruptible)
[367.610659] Starting subtest: 2x-plain-flip-interruptible
[367.651152] Subtest 2x-plain-flip-interruptible: SKIP (0.003s)
[367.762420] [063/142] (650s left) kms_big_fb (linear-32bpp-rotate-270)
[368.205626] Starting subtest: linear-32bpp-rotate-270
[368.281178] Subtest linear-32bpp-rotate-270: SKIP (0.077s)
[368.403372] [064/142] (649s left) gem_softpin (noreloc-s3)
[368.702217] Starting subtest: noreloc-S3
[389.867983] Subtest noreloc-S3: SUCCESS (5.524s)
[393.142193] [065/142] (643s left) kms_big_fb (yf-tiled-64bpp-rotate-270)
[393.538448] Starting subtest: yf-tiled-64bpp-rotate-270
[393.581588] Subtest yf-tiled-64bpp-rotate-270: SKIP (0.000s)
[393.696578] [066/142] (643s left) kms_ccs (pipe-b-bad-rotation-90-y_tiled_gen12_rc_ccs_cc)
[394.222935] Starting subtest: pipe-B-bad-rotation-90-y_tiled_gen12_rc_ccs_cc
[394.271003] Subtest pipe-B-bad-rotation-90-y_tiled_gen12_rc_ccs_cc: SKIP (0.000s)
[394.785605] [067/142] (642s left) kms_flip (2x-plain-flip-fb-recreate)
[395.191554] Starting subtest: 2x-plain-flip-fb-recreate
[395.244038] Subtest 2x-plain-flip-fb-recreate: SKIP (0.003s)
[395.390260] [068/142] (642s left) syncobj_timeline (etime-single-wait-for-submit-submitted)
[395.708500] Starting subtest: etime-single-wait-for-submit-submitted
[395.774437] Subtest etime-single-wait-for-submit-submitted: SUCCESS (0.102s)
[395.939799] [069/142] (641s left) kms_ccs (pipe-d-bad-rotation-90-y_tiled_gen12_mc_ccs)
[396.717950] Subtest pipe-D-bad-rotation-90-y_tiled_gen12_mc_ccs: SKIP (0.000s)
[397.043907] [070/142] (640s left) kms_flip (modeset-vs-vblank-race)
[397.419204] Starting subtest: modeset-vs-vblank-race
[397.438103] Starting dynamic subtest: A-DP1
[401.747632] Dynamic subtest A-DP1: SUCCESS (4.360s)
[401.789130] Starting dynamic subtest: B-DP1
[406.076896] Dynamic subtest B-DP1: SUCCESS (4.325s)
[406.120180] Starting dynamic subtest: C-DP1
[410.440642] Dynamic subtest C-DP1: SUCCESS (4.354s)
[410.466209] Subtest modeset-vs-vblank-race: SUCCESS (13.052s)
[410.905457] [071/142] (626s left) v3d/v3d_job_submission (threaded-job-submission)
[411.295462] Subtest threaded-job-submission: SKIP (0.000s)
[411.405670] [072/142] (626s left) kms_vrr (flipline)
[411.773535] Starting subtest: flipline
[411.815624] Subtest flipline: SKIP (0.000s)
[411.929140] [073/142] (626s left) gem_softpin (evict-active)
[412.231236] Starting subtest: evict-active
[412.250045] Subtest evict-active: SUCCESS (0.020s)
[412.394533] [074/142] (625s left) feature_discovery (display-2x)
[412.754035] Starting subtest: display-2x
[412.791794] Subtest display-2x: SKIP (0.000s)
[412.910953] [075/142] (625s left) kms_prop_blob (basic)
[413.203997] Starting subtest: basic
[413.225918] Subtest basic: SUCCESS (0.000s)
[413.340784] [076/142] (625s left) gen9_exec_parse (secure-batches)
[413.637604] Starting subtest: secure-batches
[413.657105] Subtest secure-batches: SUCCESS (0.000s)
[413.896166] [077/142] (624s left) kms_vblank (pipe-d-ts-continuation-modeset-hang)
[414.271206] Subtest pipe-D-ts-continuation-modeset-hang: SKIP (0.000s)
[414.467894] [078/142] (624s left) gem_exec_schedule (preempt-other)
[414.925111] Starting subtest: preempt-other
[414.945044] Starting dynamic subtest: rcs0
[414.964037] Dynamic subtest rcs0: SUCCESS (0.075s)
[415.016833] Starting dynamic subtest: bcs0
[415.035880] Dynamic subtest bcs0: SUCCESS (0.074s)
[415.083253] Starting dynamic subtest: vcs0
[415.104633] Dynamic subtest vcs0: SUCCESS (0.072s)
[415.148020] Starting dynamic subtest: vecs0
[415.168839] Dynamic subtest vecs0: SUCCESS (0.075s)
[415.188482] Subtest preempt-other: SUCCESS (0.308s)
[415.461455] [079/142] (623s left) kms_ccs (pipe-b-crc-sprite-planes-basic-4_tiled_dg2_mc_ccs)
[416.092418] Starting subtest: pipe-B-crc-sprite-planes-basic-4_tiled_dg2_mc_ccs
[416.135204] Subtest pipe-B-crc-sprite-planes-basic-4_tiled_dg2_mc_ccs: SKIP (0.005s)
[416.562870] [080/142] (622s left) gem_render_copy (yf-tiled-to-vebox-linear)
[416.858459] Starting subtest: yf-tiled-to-vebox-linear
[416.901088] Subtest yf-tiled-to-vebox-linear: SKIP (0.000s)
[417.107297] [081/142] (621s left) kms_psr (psr2_cursor_plane_onoff)
[417.423519] Subtest psr2_cursor_plane_onoff: SKIP (0.000s)
[417.542626] [082/142] (621s left) kms_chamelium_hpd (dp-hpd-fast)
[418.014712] Subtest dp-hpd-fast: SKIP (0.000s)
[418.343279] [083/142] (620s left) kms_frontbuffer_tracking (psr-2p-scndscrn-indfb-msflip-blt)
[418.768270] Starting subtest: psr-2p-scndscrn-indfb-msflip-blt
[418.809506] Subtest psr-2p-scndscrn-indfb-msflip-blt: SKIP (0.000s)
[418.922173] [084/142] (620s left) gem_mmap_offset (bad-object)
[419.221684] Starting subtest: bad-object
[419.240434] Subtest bad-object: SUCCESS (0.004s)
[419.357492] [085/142] (620s left) kms_ccs (pipe-d-crc-primary-basic-y_tiled_ccs)
[420.113678] Subtest pipe-D-crc-primary-basic-y_tiled_ccs: SKIP (0.000s)
[420.453912] [086/142] (619s left) vgem_basic (busy-fence)
[420.754535] Starting subtest: busy-fence
[420.775125] Subtest busy-fence: SUCCESS (0.000s)
[420.886769] [087/142] (618s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0-async-flip)
[421.318583] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0-async-flip
[421.356221] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SKIP (0.000s)
[421.470717] [088/142] (618s left) kms_vblank (pipe-a-wait-idle)
[421.827827] Starting subtest: pipe-A-wait-idle
[424.117004] Subtest pipe-A-wait-idle: SUCCESS (2.285s)
[424.487978] [089/142] (615s left) sw_sync (timeline_closed)
[424.771999] Starting subtest: timeline_closed
[424.793098] Subtest timeline_closed: SUCCESS (0.000s)
[424.901937] [090/142] (615s left) kms_cursor_crc (cursor-rapid-movement-32x10)
[425.276983] Starting subtest: cursor-rapid-movement-32x10
[425.407955] Subtest cursor-rapid-movement-32x10: SKIP (0.116s)
[425.541145] [091/142] (614s left) kms_cursor_legacy (single-bo)
[425.905776] Starting subtest: single-bo
[425.924474] Starting dynamic subtest: pipe-A
[431.514508] Dynamic subtest pipe-A: SUCCESS (5.407s)
[431.560397] Starting dynamic subtest: pipe-B
[436.806091] Dynamic subtest pipe-B: SUCCESS (5.405s)
[436.849583] Starting dynamic subtest: pipe-C
[442.139889] Dynamic subtest pipe-C: SUCCESS (5.404s)
[442.183352] Starting dynamic subtest: all-pipes
[447.754505] Dynamic subtest all-pipes: SUCCESS (5.408s)
[447.777622] Subtest single-bo: SUCCESS (21.635s)
[447.884886] [092/142] (592s left) kms_busy (extended-pageflip-hang-newfb)
[448.275284] Starting subtest: extended-pageflip-hang-newfb
[448.295698] Starting dynamic subtest: pipe-A
[452.582146] Dynamic subtest pipe-A: SUCCESS (4.263s)
[452.624081] Starting dynamic subtest: pipe-C
[456.725902] Dynamic subtest pipe-C: SUCCESS (4.022s)
[456.744862] Subtest extended-pageflip-hang-newfb: SUCCESS (8.299s)
[456.968129] [093/142] (583s left) gem_workarounds (suspend-resume-context)
[457.267261] Starting subtest: suspend-resume-context
[474.864422] Subtest suspend-resume-context: SUCCESS (1.230s)
[480.717209] [094/142] (581s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-32bpp-xtile-upscaling)
[481.088246] Starting subtest: flip-64bpp-xtile-to-32bpp-xtile-upscaling
[481.109373] Starting dynamic subtest: pipe-A-valid-mode
[481.523386] Dynamic subtest pipe-A-valid-mode: SKIP (0.405s)
[481.561243] Subtest flip-64bpp-xtile-to-32bpp-xtile-upscaling: SKIP (0.409s)
[481.915655] [095/142] (580s left) gem_mmap_wc (coherency)
[482.208310] Starting subtest: coherency
[482.330226] Subtest coherency: SUCCESS (0.155s)
[482.490872] [096/142] (580s left) syncobj_basic (bad-fd-to-handle)
[482.781736] Starting subtest: bad-fd-to-handle
[482.800625] Subtest bad-fd-to-handle: SUCCESS (0.000s)
[482.921591] [097/142] (579s left) gem_exec_await (wide-all)
[483.394672] Starting subtest: wide-all
[505.367602] Subtest wide-all: SUCCESS (21.947s)
[505.601088] [098/142] (557s left) gem_exec_reloc (basic-gtt-noreloc)
[506.025877] Starting subtest: basic-gtt-noreloc
[506.046923] Subtest basic-gtt-noreloc: SUCCESS (0.012s)
[506.326838] [099/142] (556s left) kms_cursor_crc (cursor-random-32x10)
[506.722760] Starting subtest: cursor-random-32x10
[506.884519] Subtest cursor-random-32x10: SKIP (0.119s)
[507.003449] [100/142] (556s left) i915_pciid
[507.430787] [101/142] (555s left) kms_plane_cursor (viewport)
[507.799555] Starting subtest: viewport
[507.840119] Starting dynamic subtest: pipe-A-DP-1-size-64
[510.220336] Dynamic subtest pipe-A-DP-1-size-64: SUCCESS (2.416s)
[510.308073] Starting dynamic subtest: pipe-A-DP-1-size-128
[512.699625] Dynamic subtest pipe-A-DP-1-size-128: SUCCESS (2.432s)
[512.786438] Starting dynamic subtest: pipe-A-DP-1-size-256
[515.184993] Dynamic subtest pipe-A-DP-1-size-256: SUCCESS (2.432s)
[515.413459] Starting dynamic subtest: pipe-B-DP-1-size-64
[518.011930] Dynamic subtest pipe-B-DP-1-size-64: SUCCESS (2.674s)
[518.115814] Starting dynamic subtest: pipe-B-DP-1-size-128
[520.511181] Dynamic subtest pipe-B-DP-1-size-128: SUCCESS (2.432s)
[520.589660] Starting dynamic subtest: pipe-B-DP-1-size-256
[522.978726] Dynamic subtest pipe-B-DP-1-size-256: SUCCESS (2.432s)
[523.190235] Starting dynamic subtest: pipe-C-DP-1-size-64
[525.791775] Dynamic subtest pipe-C-DP-1-size-64: SUCCESS (2.656s)
[525.887337] Starting dynamic subtest: pipe-C-DP-1-size-128
[528.278231] Dynamic subtest pipe-C-DP-1-size-128: SUCCESS (2.431s)
[528.362935] Starting dynamic subtest: pipe-C-DP-1-size-256
[530.757721] Dynamic subtest pipe-C-DP-1-size-256: SUCCESS (2.432s)
[530.893808] Subtest viewport: SUCCESS (23.093s)
[531.250397] [102/142] (532s left) kms_panel_fitting (legacy)
[531.643952] Starting subtest: legacy
[531.683015] Subtest legacy: SKIP (0.000s)
[531.805723] [103/142] (531s left) gem_exec_schedule (fairslice)
[532.304122] Starting subtest: fairslice
[532.324161] Starting dynamic subtest: rcs0
[534.173574] Dynamic subtest rcs0: SUCCESS (2.025s)
[534.216678] Starting dynamic subtest: bcs0
[536.210991] Dynamic subtest bcs0: SUCCESS (2.029s)
[536.253642] Starting dynamic subtest: vcs0
[538.233790] Dynamic subtest vcs0: SUCCESS (2.025s)
[538.280087] Starting dynamic subtest: vecs0
[540.265248] Dynamic subtest vecs0: SUCCESS (2.024s)
[540.285724] Subtest fairslice: SUCCESS (8.116s)
[540.646337] [104/142] (522s left) gem_exec_fence (parallel)
[541.077992] Starting subtest: parallel
[541.099127] Starting dynamic subtest: rcs0
[543.399149] Dynamic subtest rcs0: SUCCESS (2.149s)
[543.441795] Starting dynamic subtest: bcs0
[545.386732] Dynamic subtest bcs0: SUCCESS (2.155s)
[545.431313] Starting dynamic subtest: vcs0
[547.709785] Dynamic subtest vcs0: SUCCESS (2.149s)
[547.752578] Starting dynamic subtest: vecs0
[549.693948] Dynamic subtest vecs0: SUCCESS (2.151s)
[549.714947] Subtest parallel: SUCCESS (8.616s)
[550.392697] [105/142] (513s left) gem_eio (in-flight-internal-10ms)
[550.737291] Starting subtest: in-flight-internal-10ms
[550.800561] Subtest in-flight-internal-10ms: SUCCESS (0.110s)
[551.047181] [106/142] (512s left) syncobj_wait (multi-wait-submitted)
[551.345540] Starting subtest: multi-wait-submitted
[551.431462] Subtest multi-wait-submitted: SUCCESS (0.109s)
[551.551526] [107/142] (512s left) kms_ccs (pipe-c-crc-sprite-planes-basic-y_tiled_gen12_rc_ccs_cc)
[552.271397] Starting subtest: pipe-C-crc-sprite-planes-basic-y_tiled_gen12_rc_ccs_cc
[552.317819] Subtest pipe-C-crc-sprite-planes-basic-y_tiled_gen12_rc_ccs_cc: SKIP (0.004s)
[552.661483] [108/142] (511s left) sysfs_heartbeat_interval (mixed)
[552.963616] Starting subtest: mixed
[552.985161] Starting dynamic subtest: vecs0
[558.181417] Dynamic subtest vecs0: SUCCESS (5.224s)
[558.225957] Starting dynamic subtest: vcs0
[563.413839] Dynamic subtest vcs0: SUCCESS (5.231s)
[563.457931] Starting dynamic subtest: bcs0
[568.676700] Dynamic subtest bcs0: SUCCESS (5.260s)
[568.720014] Starting dynamic subtest: rcs0
[573.934439] Dynamic subtest rcs0: SUCCESS (5.247s)
[573.954397] Subtest mixed: SUCCESS (20.976s)
[574.047825] [109/142] (490s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-mmap-wc)
[574.488707] Starting subtest: psr-1p-primscrn-cur-indfb-draw-mmap-wc
[574.527458] Subtest psr-1p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[574.646387] [110/142] (489s left) kms_psr (no_drrs)
[574.945790] Subtest no_drrs: SKIP (0.000s)
[575.045764] [111/142] (489s left) prime_self_import (basic-with_fd_dup)
[575.321193] Starting subtest: basic-with_fd_dup
[575.362958] Subtest basic-with_fd_dup: SUCCESS (0.007s)
[575.462571] [112/142] (488s left) gem_set_tiling_vs_blt (untiled-to-tiled)
[575.759557] Starting subtest: untiled-to-tiled
[575.878213] Subtest untiled-to-tiled: SUCCESS (0.116s)
[576.003131] [113/142] (488s left) gem_tiled_partial_pwrite_pread (writes)
[576.302269] Starting subtest: writes
[578.449518] Subtest writes: SUCCESS (2.159s)
[578.587198] [114/142] (486s left) vc4/vc4_tiling (get-after-free)
[578.927820] Subtest get-after-free: SKIP (0.000s)
[579.026816] [115/142] (485s left) kms_psr_stress_test (flip-primary-invalidate-overlay)
[579.346199] Subtest flip-primary-invalidate-overlay: SKIP (0.000s)
[579.440217] [116/142] (485s left) gem_ctx_persistence (engines-mixed-process)
[579.741904] Starting subtest: engines-mixed-process
[579.761316] Starting dynamic subtest: rcs0
[580.102661] Dynamic subtest rcs0: SUCCESS (0.363s)
[580.147089] Starting dynamic subtest: bcs0
[580.453185] Dynamic subtest bcs0: SUCCESS (0.355s)
[580.500554] Starting dynamic subtest: vcs0
[580.811579] Dynamic subtest vcs0: SUCCESS (0.354s)
[580.860566] Starting dynamic subtest: vecs0
[581.171147] Dynamic subtest vecs0: SUCCESS (0.359s)
[581.192741] Subtest engines-mixed-process: SUCCESS (1.442s)
[581.311151] [117/142] (483s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-blt)
[581.734288] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-blt
[581.775840] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-blt: SKIP (0.000s)
[581.891274] [118/142] (483s left) gem_mmap_gtt (basic-short)
[582.191792] Starting subtest: basic-short
[582.231383] Subtest basic-short: SUCCESS (0.053s)
[582.370933] [119/142] (482s left) kms_lease (simple_lease)
[582.738481] Starting subtest: simple_lease
[582.758102] Starting dynamic subtest: pipe-A-DP-1
[583.417806] Dynamic subtest pipe-A-DP-1: SUCCESS (0.660s)
[583.463313] Starting dynamic subtest: pipe-B-DP-1
[583.987021] Dynamic subtest pipe-B-DP-1: SUCCESS (0.584s)
[584.039211] Starting dynamic subtest: pipe-C-DP-1
[584.622396] Dynamic subtest pipe-C-DP-1: SUCCESS (0.609s)
[584.643740] Subtest simple_lease: SUCCESS (1.868s)
[584.972524] [120/142] (480s left) i915_pm_rpm (gem-mmap-type)
[586.854300] Starting subtest: gem-mmap-type
[586.881584] Starting dynamic subtest: gtt-smem0
[589.425450] Dynamic subtest gtt-smem0: SUCCESS (2.550s)
[589.478397] Starting dynamic subtest: wb-smem0
[590.699117] Dynamic subtest wb-smem0: SUCCESS (1.291s)
[590.746594] Starting dynamic subtest: wc-smem0
[592.083579] Dynamic subtest wc-smem0: SUCCESS (1.378s)
[592.131925] Starting dynamic subtest: uc-smem0
[593.457251] Dynamic subtest uc-smem0: SUCCESS (1.376s)
[593.478179] Subtest gem-mmap-type: SUCCESS (6.606s)
[593.739714] [121/142] (471s left) kms_async_flips (invalid-async-flip)
[594.107671] Starting subtest: invalid-async-flip
[594.569485] Starting dynamic subtest: pipe-A-DP-1
[595.445377] Dynamic subtest pipe-A-DP-1: SUCCESS (0.884s)
[595.934478] Starting dynamic subtest: pipe-B-DP-1
[596.143233] Dynamic subtest pipe-B-DP-1: SUCCESS (0.273s)
[596.541752] Starting dynamic subtest: pipe-C-DP-1
[596.777125] Dynamic subtest pipe-C-DP-1: SUCCESS (0.271s)
[596.796097] Subtest invalid-async-flip: SUCCESS (2.671s)
[597.383798] [122/142] (468s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-blt)
[597.833635] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-blt
[597.872045] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[597.991578] [123/142] (467s left) gem_softpin (reverse)
[598.289623] Starting subtest: reverse
[598.310041] Subtest reverse: SUCCESS (0.019s)
[598.465234] [124/142] (467s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-onoff)
[598.889637] Starting subtest: fbc-2p-scndscrn-spr-indfb-onoff
[598.931741] Subtest fbc-2p-scndscrn-spr-indfb-onoff: SKIP (0.000s)
[599.048189] [125/142] (466s left) gem_ctx_shared (q-promotion)
[599.348339] Starting subtest: Q-promotion
[599.367511] Starting dynamic subtest: rcs0
[599.452237] Dynamic subtest rcs0: SUCCESS (0.108s)
[599.508671] Starting dynamic subtest: bcs0
[599.576025] Dynamic subtest bcs0: SUCCESS (0.118s)
[599.620038] Starting dynamic subtest: vcs0
[599.672484] Dynamic subtest vcs0: SUCCESS (0.094s)
[599.720028] Starting dynamic subtest: vecs0
[599.766617] Dynamic subtest vecs0: SUCCESS (0.089s)
[599.787725] Subtest Q-promotion: SUCCESS (0.424s)
[600.050852] [126/142] (465s left) kms_ccs (pipe-b-bad-rotation-90-4_tiled_dg2_mc_ccs)
[600.606810] Starting subtest: pipe-B-bad-rotation-90-4_tiled_dg2_mc_ccs
[600.648121] Subtest pipe-B-bad-rotation-90-4_tiled_dg2_mc_ccs: SKIP (0.000s)
[601.150613] [127/142] (464s left) kms_flip (flip-vs-fences)
[601.551398] Starting subtest: flip-vs-fences
[601.570159] Starting dynamic subtest: A-DP1
[612.404650] Dynamic subtest A-DP1: SUCCESS (10.876s)
[612.448760] Starting dynamic subtest: B-DP1
[623.224091] Dynamic subtest B-DP1: SUCCESS (10.810s)
[623.267706] Starting dynamic subtest: C-DP1
[634.110428] Dynamic subtest C-DP1: SUCCESS (10.723s)
[634.130022] Subtest flip-vs-fences: SUCCESS (32.423s)
[634.449140] [128/142] (431s left) kms_plane_scaling (plane-downscale-with-modifiers-factor-0-5)
[634.821074] Starting subtest: plane-downscale-with-modifiers-factor-0-5
[634.840795] Starting dynamic subtest: pipe-A-DP-1
[636.260157] Dynamic subtest pipe-A-DP-1: SUCCESS (1.425s)
[636.333072] Starting dynamic subtest: pipe-B-DP-1
[637.716244] Dynamic subtest pipe-B-DP-1: SUCCESS (1.455s)
[637.780259] Starting dynamic subtest: pipe-C-DP-1
[638.764773] Dynamic subtest pipe-C-DP-1: SUCCESS (1.053s)
[638.787061] Subtest plane-downscale-with-modifiers-factor-0-5: SUCCESS (3.949s)
[639.225989] [129/142] (426s left) v3d/v3d_wait_bo (unused-bo-0ns)
[639.592017] Subtest unused-bo-0ns: SKIP (0.000s)
[639.705439] [130/142] (426s left) kms_cursor_legacy (flip-vs-cursor-busy-crc-legacy)
[640.074253] Starting subtest: flip-vs-cursor-busy-crc-legacy
[640.960757] Subtest flip-vs-cursor-busy-crc-legacy: SUCCESS (0.874s)
[641.336991] [131/142] (425s left) kms_lease (lease_invalid_crtc)
[641.698668] Starting subtest: lease_invalid_crtc
[641.717931] Starting dynamic subtest: pipe-A-DP-1
[641.737127] Dynamic subtest pipe-A-DP-1: SUCCESS (0.000s)
[641.781063] Starting dynamic subtest: pipe-B-DP-1
[641.800130] Dynamic subtest pipe-B-DP-1: SUCCESS (0.001s)
[641.844843] Starting dynamic subtest: pipe-C-DP-1
[641.867233] Dynamic subtest pipe-C-DP-1: SUCCESS (0.000s)
[641.887932] Subtest lease_invalid_crtc: SUCCESS (0.013s)
[642.005894] [132/142] (424s left) gem_exec_capture (capture-invisible)
[642.311834] Starting subtest: capture-invisible
[642.330964] Starting dynamic subtest: smem0
[642.369053] Dynamic subtest smem0: SKIP (0.000s)
[642.412427] Subtest capture-invisible: SKIP (0.003s)
[642.528713] [133/142] (424s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-mmap-wc)
[642.933407] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-mmap-wc
[642.975650] Subtest psr-2p-scndscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[643.099095] [134/142] (423s left) syncobj_timeline (signal-array)
[643.404292] Starting subtest: signal-array
[643.423244] Subtest signal-array: SUCCESS (0.001s)
[643.541557] [135/142] (423s left) kms_chamelium_hpd (hdmi-hpd-for-each-pipe)
[644.034800] Subtest hdmi-hpd-for-each-pipe: SKIP (0.000s)
[644.376176] [136/142] (422s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-move)
[644.825522] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-move
[644.867585] Subtest fbcpsr-1p-primscrn-spr-indfb-move: SKIP (0.000s)
[644.979985] [137/142] (422s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-indfb-plflip-blt)
[645.432657] Starting subtest: fbcpsr-2p-primscrn-indfb-plflip-blt
[645.470569] Subtest fbcpsr-2p-primscrn-indfb-plflip-blt: SKIP (0.000s)
[645.590736] [138/142] (421s left) gem_exec_schedule (u-semaphore-resolve)
[646.037697] Starting subtest: u-semaphore-resolve
[646.059160] Subtest u-semaphore-resolve: SUCCESS (0.052s)
[646.324947] [139/142] (421s left) kms_big_fb (y-tiled-32bpp-rotate-180)
[646.765853] Starting subtest: y-tiled-32bpp-rotate-180
[651.717335] Subtest y-tiled-32bpp-rotate-180: SUCCESS (4.989s)
[652.279631] [140/142] (415s left) kms_cursor_legacy (basic-flip-after-cursor-legacy)
[652.646322] Starting subtest: basic-flip-after-cursor-legacy
[653.716279] Subtest basic-flip-after-cursor-legacy: SUCCESS (1.077s)
[654.111802] [141/142] (413s left) kms_big_fb (4-tiled-32bpp-rotate-90)
[654.530671] Starting subtest: 4-tiled-32bpp-rotate-90
[654.573890] Subtest 4-tiled-32bpp-rotate-90: SKIP (0.000s)
[654.689944] [142/142] (413s left) kms_ccs (pipe-a-crc-primary-rotation-180-y_tiled_ccs)
[655.151645] Starting subtest: pipe-A-crc-primary-rotation-180-y_tiled_ccs
[655.816318] Subtest pipe-A-crc-primary-rotation-180-y_tiled_ccs: SUCCESS (0.659s)
[656.525070] Closing watchdogs
Done.