[51.395489] Initializing watchdogs
[51.395534]   /dev/watchdog0
[51.409347] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics]
[51.413660] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[51.415905] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[51.418826] [001/132] (960s left) kms_flip (flip-vs-expired-vblank)
[51.556780] Starting subtest: flip-vs-expired-vblank
[51.558915] Starting dynamic subtest: A-eDP1
[60.265195] Dynamic subtest A-eDP1: SUCCESS (8.779s)
[60.276813] Starting dynamic subtest: B-eDP1
[68.940895] Dynamic subtest B-eDP1: SUCCESS (8.695s)
[68.947702] Starting dynamic subtest: C-eDP1
[77.654134] Dynamic subtest C-eDP1: SUCCESS (8.719s)
[77.664775] Starting dynamic subtest: D-eDP1
[86.275864] Dynamic subtest D-eDP1: SUCCESS (8.620s)
[86.278545] Subtest flip-vs-expired-vblank: SUCCESS (34.822s)
[87.477299] [002/132] (924s left) gem_exec_whisper (basic-contexts-forked)
[87.552433] Starting subtest: basic-contexts-forked
[111.531101] Subtest basic-contexts-forked: SUCCESS (23.974s)
[111.731654] [003/132] (900s left) kms_big_fb (4-tiled-16bpp-rotate-0)
[111.852822] Starting subtest: 4-tiled-16bpp-rotate-0
[113.108033] Subtest 4-tiled-16bpp-rotate-0: SUCCESS (1.257s)
[113.363636] [004/132] (898s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0)
[113.458951] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0
[114.459826] Subtest x-tiled-max-hw-stride-32bpp-rotate-0: SUCCESS (1.000s)
[114.639923] [005/132] (897s left) syncobj_timeline (etime-multi-wait-for-submit-submitted)
[114.694287] Starting subtest: etime-multi-wait-for-submit-submitted
[114.800409] Subtest etime-multi-wait-for-submit-submitted: SUCCESS (0.103s)
[114.899545] [006/132] (897s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-onoff)
[114.998484] Starting subtest: fbc-2p-primscrn-cur-indfb-onoff
[115.003040] Subtest fbc-2p-primscrn-cur-indfb-onoff: SKIP (0.000s)
[115.107534] [007/132] (897s left) syncobj_timeline (multi-wait-all-for-submit-signaled)
[115.165617] Starting subtest: multi-wait-all-for-submit-signaled
[115.167983] Subtest multi-wait-all-for-submit-signaled: SUCCESS (0.000s)
[115.293845] [008/132] (896s left) core_setmaster (master-drop-set-user)
[115.393461] Starting subtest: master-drop-set-user
[115.418091] Subtest master-drop-set-user: SUCCESS (0.027s)
[115.466859] [009/132] (896s left) kms_pm_rpm (system-suspend-idle)
[117.077030] Starting subtest: system-suspend-idle
[136.615825] Subtest system-suspend-idle: SUCCESS (8.427s)
[137.002009] [010/132] (875s left) gem_exec_schedule (pi-ringfull)
[137.196233] Starting subtest: pi-ringfull
[137.198515] Starting dynamic subtest: rcs0
[137.332745] Dynamic subtest rcs0: SUCCESS (0.141s)
[137.345678] Starting dynamic subtest: bcs0
[137.359118] Dynamic subtest bcs0: SUCCESS (0.027s)
[137.371844] Starting dynamic subtest: vcs0
[137.385597] Dynamic subtest vcs0: SUCCESS (0.027s)
[137.398161] Starting dynamic subtest: vcs1
[137.411593] Dynamic subtest vcs1: SUCCESS (0.026s)
[137.424156] Starting dynamic subtest: vecs0
[137.436889] Dynamic subtest vecs0: SUCCESS (0.025s)
[137.449262] Starting dynamic subtest: ccs0
[137.462370] Dynamic subtest ccs0: SUCCESS (0.026s)
[137.464536] Subtest pi-ringfull: SUCCESS (0.273s)
[137.699578] [FACT gem_exec_schedule (pi-ringfull)] new: kernel.kmod_is_loaded.vgem: true
[137.702644] [011/132] (874s left) kms_flip (bo-too-big-interruptible)
[137.806562] Starting subtest: bo-too-big-interruptible
[137.809970] Starting dynamic subtest: A-eDP1
[139.085231] Dynamic subtest A-eDP1: SUCCESS (1.293s)
[139.096063] Starting dynamic subtest: B-eDP1
[140.307933] Dynamic subtest B-eDP1: SUCCESS (1.237s)
[140.318243] Starting dynamic subtest: C-eDP1
[141.547042] Dynamic subtest C-eDP1: SUCCESS (1.251s)
[141.559079] Starting dynamic subtest: D-eDP1
[142.786420] Dynamic subtest D-eDP1: SUCCESS (1.250s)
[142.791483] Subtest bo-too-big-interruptible: SUCCESS (5.042s)
[144.010011] [012/132] (868s left) gem_pread (exhaustion)
[144.066299] Subtest exhaustion: SKIP (0.000s)
[144.137519] [013/132] (868s left) kms_plane_scaling (2x-scaler-multi-pipe)
[144.240493] Starting subtest: 2x-scaler-multi-pipe
[144.244868] Subtest 2x-scaler-multi-pipe: SKIP (0.001s)
[144.375396] [014/132] (868s left) api_intel_bb (blit-reloc-purge-cache)
[144.446135] Starting subtest: blit-reloc-purge-cache
[144.450521] Subtest blit-reloc-purge-cache: SKIP (0.001s)
[144.611231] [015/132] (867s left) syncobj_timeline (single-wait-all-available-submitted)
[144.666297] Starting subtest: single-wait-all-available-submitted
[144.668866] Subtest single-wait-all-available-submitted: SUCCESS (0.000s)
[144.808761] [016/132] (867s left) kms_psr2_sf (psr2-cursor-plane-move-continuous-sf)
[149.832725] Starting subtest: psr2-cursor-plane-move-continuous-sf
[149.835096] Starting dynamic subtest: pipe-A-eDP-1
[160.907177] Dynamic subtest pipe-A-eDP-1: SUCCESS (11.097s)
[160.915777] Starting dynamic subtest: pipe-B-eDP-1
[171.956818] Dynamic subtest pipe-B-eDP-1: SUCCESS (11.050s)
[171.959141] Subtest psr2-cursor-plane-move-continuous-sf: SUCCESS (22.151s)
[172.856632] [017/132] (839s left) kms_cursor_legacy (2x-long-flip-vs-cursor-atomic)
[172.984957] Starting subtest: 2x-long-flip-vs-cursor-atomic
[172.989560] Subtest 2x-long-flip-vs-cursor-atomic: SKIP (0.001s)
[173.154091] [018/132] (839s left) kms_flip (2x-plain-flip-ts-check-interruptible)
[173.252469] Starting subtest: 2x-plain-flip-ts-check-interruptible
[173.266205] Subtest 2x-plain-flip-ts-check-interruptible: SKIP (0.012s)
[173.365698] [019/132] (839s left) gem_exec_nop (basic-sequential)
[173.447343] Starting subtest: basic-sequential
[188.585472] Subtest basic-sequential: SUCCESS (15.150s)
[188.837179] [020/132] (823s left) gem_fence_thrash (bo-write-verify-threaded-none)
[188.873291] Starting subtest: bo-write-verify-threaded-none
[188.895731] Subtest bo-write-verify-threaded-none: SKIP (0.021s)
[188.966321] [021/132] (823s left) prime_mmap_kms (buffer-sharing)
[189.070442] Starting subtest: buffer-sharing
[189.523917] Subtest buffer-sharing: SUCCESS (0.455s)
[190.384136] [022/132] (822s left) gem_userptr_blits (stress-mm)
[190.460120] Starting subtest: stress-mm
[195.827227] Subtest stress-mm: SUCCESS (5.369s)
[196.012449] [023/132] (816s left) kms_pm_backlight (fade)
[196.117404] Starting subtest: fade
[196.168701] Starting dynamic subtest: eDP-1
[198.833291] Dynamic subtest eDP-1: SUCCESS (2.664s)
[198.835747] Subtest fade: SUCCESS (2.717s)
[199.709843] [024/132] (813s left) gem_exec_params (rs-invalid)
[199.786282] Starting subtest: rs-invalid
[199.791376] Subtest rs-invalid: SUCCESS (0.003s)
[199.935800] [025/132] (812s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-shrfb-msflip-blt)
[200.028719] Starting subtest: fbcpsr-2p-scndscrn-shrfb-msflip-blt
[200.032794] Subtest fbcpsr-2p-scndscrn-shrfb-msflip-blt: SKIP (0.000s)
[200.141082] [026/132] (812s left) gem_fence_thrash (bo-write-verify-none)
[200.174581] Starting subtest: bo-write-verify-none
[200.197601] Subtest bo-write-verify-none: SKIP (0.021s)
[200.263556] [027/132] (812s left) gem_workarounds (suspend-resume-context)
[200.316216] Starting subtest: suspend-resume-context
[217.113210] Subtest suspend-resume-context: SUCCESS (1.946s)
[217.280739] [028/132] (795s left) syncobj_wait (wait-all-delayed-signal)
[217.350923] Starting subtest: wait-all-delayed-signal
[217.455021] Subtest wait-all-delayed-signal: SUCCESS (0.103s)
[217.558106] [029/132] (795s left) gem_softpin (evict-active-interruptible)
[217.623589] Starting subtest: evict-active-interruptible
[217.630281] Subtest evict-active-interruptible: SUCCESS (0.007s)
[217.800849] [030/132] (795s left) i915_query (query-regions-garbage-items)
[217.858764] Starting subtest: query-regions-garbage-items
[217.861024] Subtest query-regions-garbage-items: SUCCESS (0.000s)
[217.996402] [031/132] (795s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24)
[218.095135] Starting subtest: compare-crc-sanitycheck-xr24
[218.097441] Starting dynamic subtest: pipe-A-eDP-1
[218.698211] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.615s)
[218.707296] Starting dynamic subtest: pipe-B-eDP-1
[219.992867] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.317s)
[220.002670] Starting dynamic subtest: pipe-C-eDP-1
[221.172706] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.196s)
[221.182134] Starting dynamic subtest: pipe-D-eDP-1
[222.392678] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.234s)
[222.394886] Subtest compare-crc-sanitycheck-xr24: SUCCESS (4.367s)
[223.241884] [032/132] (789s left) kms_psr (fbc-psr2-primary-mmap-gtt)
[223.349437] Starting subtest: fbc-psr2-primary-mmap-gtt
[223.351607] Starting dynamic subtest: eDP-1
[223.355580] Dynamic subtest eDP-1: SKIP (0.000s)
[223.359608] Subtest fbc-psr2-primary-mmap-gtt: SKIP (0.001s)
[223.443196] [033/132] (789s left) gem_ctx_exec (basic-nohangcheck)
[223.502683] Starting subtest: basic-nohangcheck
[223.743196] Subtest basic-nohangcheck: SUCCESS (0.244s)
[223.896224] [034/132] (789s left) gem_render_copy (x-tiled-to-vebox-yf-tiled)
[223.950845] Starting subtest: x-tiled-to-vebox-yf-tiled
[223.955187] Subtest x-tiled-to-vebox-yf-tiled: SKIP (0.000s)
[224.155578] [035/132] (789s left) i915_drm_fdinfo (virtual-busy)
[224.195408] Starting subtest: virtual-busy
[224.199764] Subtest virtual-busy: SKIP (0.000s)
[224.288908] [036/132] (789s left) prime_vgem (busy)
[224.376775] Starting subtest: busy
[224.379276] Starting dynamic subtest: rcs0
[224.433856] Dynamic subtest rcs0: SUCCESS (0.058s)
[224.442465] Starting dynamic subtest: bcs0
[224.508767] Dynamic subtest bcs0: SUCCESS (0.075s)
[224.517610] Starting dynamic subtest: vcs0
[224.553764] Dynamic subtest vcs0: SUCCESS (0.045s)
[224.562454] Starting dynamic subtest: vcs1
[224.599316] Dynamic subtest vcs1: SUCCESS (0.045s)
[224.608183] Starting dynamic subtest: vecs0
[224.647669] Dynamic subtest vecs0: SUCCESS (0.048s)
[224.656548] Starting dynamic subtest: ccs0
[224.690473] Dynamic subtest ccs0: SUCCESS (0.043s)
[224.692686] Subtest busy: SUCCESS (0.317s)
[224.851224] [037/132] (788s left) kms_big_fb (linear-16bpp-rotate-180)
[224.962149] Starting subtest: linear-16bpp-rotate-180
[226.252621] Subtest linear-16bpp-rotate-180: SUCCESS (1.301s)
[226.420088] [038/132] (786s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-16bpp-ytile-downscaling)
[226.519635] Starting subtest: flip-64bpp-ytile-to-16bpp-ytile-downscaling
[226.521630] Starting dynamic subtest: pipe-A-default-mode
[226.825526] Dynamic subtest pipe-A-default-mode: SKIP (0.304s)
[226.829918] Subtest flip-64bpp-ytile-to-16bpp-ytile-downscaling: SKIP (0.305s)
[227.636640] [039/132] (785s left) kms_ccs (bad-rotation-90-4-tiled-mtl-rc-ccs-cc)
[227.731840] Starting subtest: bad-rotation-90-4-tiled-mtl-rc-ccs-cc
[227.734137] Starting dynamic subtest: pipe-A-eDP-1
[227.880286] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.141s)
[227.891434] Starting dynamic subtest: pipe-B-eDP-1
[227.910829] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.009s)
[227.919787] Starting dynamic subtest: pipe-C-eDP-1
[227.939450] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.010s)
[227.947970] Starting dynamic subtest: pipe-D-eDP-1
[227.967202] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.011s)
[227.969069] Subtest bad-rotation-90-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.176s)
[230.183260] [040/132] (783s left) gem_softpin (evict-prime)
[230.247560] Starting subtest: evict-prime
[230.249947] Starting dynamic subtest: rcs0
[231.418896] Dynamic subtest rcs0: SUCCESS (1.176s)
[231.430186] Starting dynamic subtest: bcs0
[232.579088] Dynamic subtest bcs0: SUCCESS (1.163s)
[232.590672] Starting dynamic subtest: vcs0
[233.929504] Dynamic subtest vcs0: SUCCESS (1.351s)
[233.941262] Starting dynamic subtest: vcs1
[235.913646] Dynamic subtest vcs1: SUCCESS (1.988s)
[235.928248] Starting dynamic subtest: vecs0
[237.863276] Dynamic subtest vecs0: SUCCESS (1.953s)
[237.874641] Starting dynamic subtest: ccs0
[238.994931] Dynamic subtest ccs0: SUCCESS (1.134s)
[239.006403] Starting dynamic subtest: all
[240.905414] Dynamic subtest all: SUCCESS (1.911s)
[240.907951] Subtest evict-prime: SUCCESS (10.685s)
[241.008416] [041/132] (772s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-mmap-cpu)
[241.115202] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-mmap-cpu
[247.924649] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-mmap-cpu: SUCCESS (6.820s)
[248.072723] [042/132] (765s left) kms_plane_alpha_blend (alpha-opaque-fb)
[248.175156] Starting subtest: alpha-opaque-fb
[248.461672] Starting dynamic subtest: pipe-A-eDP-1
[249.066453] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.604s)
[249.085665] Starting dynamic subtest: pipe-D-eDP-1
[250.434502] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.366s)
[250.436770] Subtest alpha-opaque-fb: SUCCESS (2.261s)
[251.254468] [043/132] (762s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-mmap-gtt)
[251.359134] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-mmap-gtt
[251.363088] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[251.482005] [044/132] (762s left) kms_ccs (random-ccs-data-4-tiled-dg2-rc-ccs-cc)
[251.577712] Starting subtest: random-ccs-data-4-tiled-dg2-rc-ccs-cc
[251.580036] Starting dynamic subtest: pipe-A-eDP-1
[251.604058] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[251.613245] Starting dynamic subtest: pipe-B-eDP-1
[251.636064] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[251.644547] Starting dynamic subtest: pipe-C-eDP-1
[251.667162] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[251.675235] Starting dynamic subtest: pipe-D-eDP-1
[251.698165] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[251.702035] Subtest random-ccs-data-4-tiled-dg2-rc-ccs-cc: SKIP (0.004s)
[253.912751] [045/132] (759s left) perf_pmu (busy-accuracy-2)
[253.955559] Starting subtest: busy-accuracy-2
[253.957730] Starting dynamic subtest: rcs0
[256.994533] Dynamic subtest rcs0: SUCCESS (3.038s)
[257.005304] Starting dynamic subtest: bcs0
[260.053636] Dynamic subtest bcs0: SUCCESS (3.057s)
[260.063927] Starting dynamic subtest: vcs0
[263.107561] Dynamic subtest vcs0: SUCCESS (3.053s)
[263.118304] Starting dynamic subtest: vcs1
[266.150452] Dynamic subtest vcs1: SUCCESS (3.042s)
[266.160641] Starting dynamic subtest: vecs0
[269.192629] Dynamic subtest vecs0: SUCCESS (3.042s)
[269.203400] Starting dynamic subtest: ccs0
[272.252244] Dynamic subtest ccs0: SUCCESS (3.059s)
[272.254674] Subtest busy-accuracy-2: SUCCESS (18.300s)
[272.392773] [046/132] (741s left) syncobj_wait (invalid-multi-wait-unsubmitted-submitted)
[272.461467] Starting subtest: invalid-multi-wait-unsubmitted-submitted
[272.463929] Subtest invalid-multi-wait-unsubmitted-submitted: SUCCESS (0.000s)
[272.599468] [047/132] (741s left) kms_content_protection (srm)
[272.749717] Starting subtest: srm
[272.756762] Subtest srm: SKIP (0.003s)
[272.913114] [048/132] (740s left) kms_ccs (ccs-on-another-bo-y-tiled-gen12-rc-ccs-cc)
[273.007663] Starting subtest: ccs-on-another-bo-y-tiled-gen12-rc-ccs-cc
[273.009796] Starting dynamic subtest: pipe-A-eDP-1
[273.032391] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[273.043977] Starting dynamic subtest: pipe-B-eDP-1
[273.065399] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[273.074600] Starting dynamic subtest: pipe-C-eDP-1
[273.096173] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[273.105094] Starting dynamic subtest: pipe-D-eDP-1
[273.126923] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[273.131015] Subtest ccs-on-another-bo-y-tiled-gen12-rc-ccs-cc: SKIP (0.004s)
[275.271864] [049/132] (738s left) kms_frontbuffer_tracking (psr-rgb565-draw-mmap-gtt)
[275.375359] Starting subtest: psr-rgb565-draw-mmap-gtt
[275.379513] Subtest psr-rgb565-draw-mmap-gtt: SKIP (0.000s)
[275.495740] [050/132] (738s left) kms_cursor_crc (cursor-onscreen-32x10)
[275.651436] Starting subtest: cursor-onscreen-32x10
[275.696446] Subtest cursor-onscreen-32x10: SKIP (0.041s)
[276.001530] [051/132] (737s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-onoff)
[276.096294] Starting subtest: psr-1p-primscrn-cur-indfb-onoff
[283.101104] Subtest psr-1p-primscrn-cur-indfb-onoff: SUCCESS (7.009s)
[283.247745] [052/132] (730s left) gem_ctx_bad_destroy (double-destroy)
[283.304779] Starting subtest: double-destroy
[283.307068] Subtest double-destroy: SUCCESS (0.000s)
[283.405838] [053/132] (730s left) gem_lmem_swapping (basic)
[283.445097] Subtest basic: SKIP (0.000s)
[283.486078] [054/132] (730s left) gen9_exec_parse (bb-start-cmd)
[283.546947] Subtest bb-start-cmd: SKIP (0.000s)
[283.637440] [055/132] (730s left) sw_sync (sync_multi_timeline_wait)
[283.668700] Starting subtest: sync_multi_timeline_wait
[283.671037] Subtest sync_multi_timeline_wait: SUCCESS (0.000s)
[283.745718] [056/132] (730s left) i915_pm_rc6_residency (rc6-accuracy)
[283.804508] Starting subtest: rc6-accuracy
[283.806457] Starting dynamic subtest: gt0
[286.976198] Dynamic subtest gt0: SUCCESS (3.169s)
[286.986302] Starting dynamic subtest: gt1
[290.148449] Dynamic subtest gt1: SUCCESS (3.168s)
[290.150910] Subtest rc6-accuracy: SUCCESS (6.343s)
[290.255485] [057/132] (723s left) api_intel_bb (simple-bb-ctx)
[290.311466] Starting subtest: simple-bb-ctx
[290.326415] Subtest simple-bb-ctx: SUCCESS (0.017s)
[290.492463] [058/132] (723s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-indfb-pgflip-blt)
[290.600174] Starting subtest: fbcpsr-2p-primscrn-indfb-pgflip-blt
[290.604124] Subtest fbcpsr-2p-primscrn-indfb-pgflip-blt: SKIP (0.000s)
[290.741287] [059/132] (723s left) kms_vblank (crtc-id)
[290.851144] Starting subtest: crtc-id
[290.853055] Starting dynamic subtest: pipe-A-eDP-1
[291.299585] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.448s)
[291.313108] Starting dynamic subtest: pipe-D-eDP-1
[292.408601] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.106s)
[292.410732] Subtest crtc-id: SUCCESS (1.558s)
[293.302128] [060/132] (721s left) gem_basic (bad-close)
[293.364920] Starting subtest: bad-close
[293.369336] Subtest bad-close: SUCCESS (0.000s)
[293.543018] [061/132] (720s left) kms_flip (dpms-vs-vblank-race-interruptible)
[293.646498] Starting subtest: dpms-vs-vblank-race-interruptible
[293.648667] Starting dynamic subtest: A-eDP1
[298.611372] Dynamic subtest A-eDP1: SUCCESS (4.960s)
[298.621293] Starting dynamic subtest: B-eDP1
[303.217852] Dynamic subtest B-eDP1: SUCCESS (4.605s)
[303.227683] Starting dynamic subtest: C-eDP1
[307.841003] Dynamic subtest C-eDP1: SUCCESS (4.622s)
[307.850284] Starting dynamic subtest: D-eDP1
[312.451262] Dynamic subtest D-eDP1: SUCCESS (4.610s)
[312.453143] Subtest dpms-vs-vblank-race-interruptible: SUCCESS (18.807s)
[313.342855] [062/132] (701s left) kms_vblank (wait-forked-busy)
[313.449661] Starting subtest: wait-forked-busy
[313.451834] Starting dynamic subtest: pipe-A-eDP-1
[315.334378] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.885s)
[315.348839] Starting dynamic subtest: pipe-D-eDP-1
[317.876115] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.539s)
[317.878303] Subtest wait-forked-busy: SUCCESS (4.429s)
[318.703496] [063/132] (695s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-pwrite)
[318.805043] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-pwrite
[318.809312] Subtest fbc-2p-scndscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[318.935706] [064/132] (695s left) kms_big_fb (4-tiled-64bpp-rotate-180)
[319.034758] Starting subtest: 4-tiled-64bpp-rotate-180
[320.480136] Subtest 4-tiled-64bpp-rotate-180: SUCCESS (1.445s)
[320.691939] [065/132] (693s left) kms_flip (absolute-wf_vblank-interruptible)
[320.794018] Starting subtest: absolute-wf_vblank-interruptible
[320.796290] Starting dynamic subtest: A-eDP1
[329.536820] Dynamic subtest A-eDP1: SUCCESS (8.743s)
[329.545899] Starting dynamic subtest: B-eDP1
[338.258715] Dynamic subtest B-eDP1: SUCCESS (8.723s)
[338.269397] Starting dynamic subtest: C-eDP1
[346.978455] Dynamic subtest C-eDP1: SUCCESS (8.721s)
[346.992539] Starting dynamic subtest: D-eDP1
[355.702966] Dynamic subtest D-eDP1: SUCCESS (8.726s)
[355.709032] Subtest absolute-wf_vblank-interruptible: SUCCESS (34.923s)
[356.939180] [066/132] (657s left) gem_exec_flush (basic-uc-prw-default)
[357.013215] Starting subtest: basic-uc-prw-default
[362.475865] Subtest basic-uc-prw-default: SUCCESS (5.465s)
[362.697706] [067/132] (651s left) vgem_basic (busy-fence)
[362.736806] Starting subtest: busy-fence
[362.739165] Subtest busy-fence: SUCCESS (0.000s)
[362.817352] [068/132] (651s left) kms_frontbuffer_tracking (psr-rgb565-draw-render)
[362.921370] Starting subtest: psr-rgb565-draw-render
[369.972831] Subtest psr-rgb565-draw-render: SUCCESS (7.056s)
[370.136428] [069/132] (644s left) kms_dp_link_training (uhbr-sst)
[370.232069] Starting subtest: uhbr-sst
[370.240528] Subtest uhbr-sst: SKIP (0.000s)
[370.333252] [070/132] (644s left) kms_universal_plane (disable-primary-vs-flip)
[370.431227] Starting subtest: disable-primary-vs-flip
[370.433497] Starting dynamic subtest: pipe-A-eDP-1
[372.016931] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.587s)
[372.026867] Starting dynamic subtest: pipe-B-eDP-1
[374.261458] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.242s)
[374.271289] Starting dynamic subtest: pipe-C-eDP-1
[376.493704] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.233s)
[376.503391] Starting dynamic subtest: pipe-D-eDP-1
[378.664246] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.169s)
[378.666682] Subtest disable-primary-vs-flip: SUCCESS (8.237s)
[379.487508] [071/132] (635s left) gem_exec_balancer (invalid-balancer)
[379.554485] Starting subtest: invalid-balancer
[380.436953] Subtest invalid-balancer: SUCCESS (0.881s)
[380.778586] [072/132] (634s left) gem_mmap_offset (bad-extensions)
[380.840671] Starting subtest: bad-extensions
[380.843150] Subtest bad-extensions: SUCCESS (0.000s)
[380.975242] [073/132] (633s left) kms_atomic_transition (plane-all-transition)
[381.072070] Starting subtest: plane-all-transition
[381.074357] Starting dynamic subtest: pipe-A-eDP-1
[383.564010] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.495s)
[383.871046] Starting dynamic subtest: pipe-B-eDP-1
[387.086890] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.228s)
[387.385575] Subtest plane-all-transition: SUCCESS (6.316s)
[388.239465] [074/132] (626s left) kms_rotation_crc (multiplane-rotation)
[388.346331] Starting subtest: multiplane-rotation
[405.906765] Subtest multiplane-rotation: SUCCESS (17.571s)
[406.060194] [075/132] (608s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip)
[406.176208] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip
[406.179796] Subtest y-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip: SKIP (0.000s)
[406.289340] [076/132] (608s left) kms_psr2_sf (fbc-psr2-primary-plane-update-sf-dmg-area)
[411.282367] Starting subtest: fbc-psr2-primary-plane-update-sf-dmg-area
[411.284293] Starting dynamic subtest: pipe-A-eDP-1
[412.084543] Dynamic subtest pipe-A-eDP-1: SKIP (0.800s)
[412.093853] Starting dynamic subtest: pipe-B-eDP-1
[413.312049] Dynamic subtest pipe-B-eDP-1: SKIP (1.226s)
[413.316630] Subtest fbc-psr2-primary-plane-update-sf-dmg-area: SKIP (2.031s)
[414.525239] [077/132] (600s left) kms_psr (pr-sprite-blt)
[414.626489] Starting subtest: pr-sprite-blt
[414.630715] Subtest pr-sprite-blt: SKIP (0.000s)
[414.723193] [078/132] (600s left) kms_psr (pr-cursor-render)
[414.821284] Starting subtest: pr-cursor-render
[414.825246] Subtest pr-cursor-render: SKIP (0.000s)
[414.919494] [079/132] (600s left) syncobj_wait (single-wait-all-signaled)
[414.970049] Starting subtest: single-wait-all-signaled
[414.972216] Subtest single-wait-all-signaled: SUCCESS (0.000s)
[415.099880] [080/132] (600s left) kms_chamelium_hpd (dp-hpd-storm)
[415.497337] Subtest dp-hpd-storm: SKIP (0.000s)
[416.322134] [081/132] (598s left) gem_mmap_gtt (basic-write-gtt)
[416.394007] Subtest basic-write-gtt: SKIP (0.000s)
[416.462924] [082/132] (598s left) kms_plane_scaling (plane-scaler-with-clipping-clamping-modifiers)
[416.581295] Starting subtest: plane-scaler-with-clipping-clamping-modifiers
[416.583669] Starting dynamic subtest: pipe-A
[416.941668] Dynamic subtest pipe-A: SUCCESS (0.362s)
[416.953468] Starting dynamic subtest: pipe-B
[418.350042] Dynamic subtest pipe-B: SUCCESS (1.407s)
[418.359702] Starting dynamic subtest: pipe-C
[419.761754] Dynamic subtest pipe-C: SUCCESS (1.411s)
[419.778197] Starting dynamic subtest: pipe-D
[421.252861] Dynamic subtest pipe-D: SUCCESS (1.490s)
[421.255248] Subtest plane-scaler-with-clipping-clamping-modifiers: SUCCESS (4.676s)
[422.492492] [083/132] (592s left) gem_exec_schedule (thriceslice)
[422.561364] Starting subtest: thriceslice
[422.563339] Starting dynamic subtest: rcs0
[422.584387] Dynamic subtest rcs0: SUCCESS (0.033s)
[422.595925] Starting dynamic subtest: bcs0
[422.614457] Dynamic subtest bcs0: SUCCESS (0.029s)
[422.623494] Starting dynamic subtest: vcs0
[422.665503] Dynamic subtest vcs0: SUCCESS (0.050s)
[422.676849] Starting dynamic subtest: vcs1
[422.696951] Dynamic subtest vcs1: SUCCESS (0.029s)
[422.706102] Starting dynamic subtest: vecs0
[422.725666] Dynamic subtest vecs0: SUCCESS (0.028s)
[422.735142] Starting dynamic subtest: ccs0
[422.757145] Dynamic subtest ccs0: SUCCESS (0.030s)
[422.759440] Subtest thriceslice: SUCCESS (0.207s)
[423.084396] [084/132] (592s left) gem_exec_fence (nb-await)
[423.266682] Starting subtest: nb-await
[423.269080] Starting dynamic subtest: rcs0
[423.335183] Dynamic subtest rcs0: SUCCESS (0.068s)
[423.344917] Starting dynamic subtest: bcs0
[423.395510] Dynamic subtest bcs0: SUCCESS (0.059s)
[423.407625] Starting dynamic subtest: vcs0
[423.455271] Dynamic subtest vcs0: SUCCESS (0.057s)
[423.465736] Starting dynamic subtest: vcs1
[423.514228] Dynamic subtest vcs1: SUCCESS (0.057s)
[423.525078] Starting dynamic subtest: vecs0
[423.574503] Dynamic subtest vecs0: SUCCESS (0.058s)
[423.585714] Starting dynamic subtest: ccs0
[423.631440] Dynamic subtest ccs0: SUCCESS (0.057s)
[423.633766] Subtest nb-await: SUCCESS (0.366s)
[425.032449] [085/132] (590s left) gem_userptr_blits (set-cache-level)
[425.106125] Starting subtest: set-cache-level
[425.110524] Subtest set-cache-level: SKIP (0.000s)
[425.286205] [086/132] (590s left) gem_ctx_persistence (hang)
[425.352369] Starting subtest: hang
[425.357335] Subtest hang: SKIP (0.000s)
[425.497171] [087/132] (589s left) kms_psr (psr-cursor-mmap-gtt)
[425.594882] Starting subtest: psr-cursor-mmap-gtt
[425.597166] Starting dynamic subtest: eDP-1
[427.369181] Dynamic subtest eDP-1: SUCCESS (1.773s)
[427.371510] Subtest psr-cursor-mmap-gtt: SUCCESS (1.775s)
[428.257086] [088/132] (587s left) gem_eio (in-flight-contexts-immediate)
[428.495581] Starting subtest: in-flight-contexts-immediate
[439.925625] Subtest in-flight-contexts-immediate: SUCCESS (11.433s)
[440.128894] [089/132] (575s left) kms_async_flips (basic-modeset-with-all-modifiers-formats)
[440.239380] Starting subtest: basic-modeset-with-all-modifiers-formats
[440.626108] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-XRGB8888
[441.408869] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-XRGB8888: SUCCESS (0.785s)
[441.419018] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-XRGB2101010
[441.430679] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-XRGB2101010: SUCCESS (0.021s)
[441.441530] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-XRGB16161616F
[441.452926] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-XRGB16161616F: SUCCESS (0.021s)
[441.467859] Starting dynamic subtest: pipe-A-eDP-1-4-RGB565
[441.608465] Dynamic subtest pipe-A-eDP-1-4-RGB565: SUCCESS (0.154s)
[441.618146] Starting dynamic subtest: pipe-A-eDP-1-4-XRGB8888
[441.630920] Dynamic subtest pipe-A-eDP-1-4-XRGB8888: SUCCESS (0.022s)
[441.640140] Starting dynamic subtest: pipe-A-eDP-1-4-XRGB2101010
[441.652844] Dynamic subtest pipe-A-eDP-1-4-XRGB2101010: SUCCESS (0.021s)
[441.661674] Starting dynamic subtest: pipe-A-eDP-1-4-XRGB16161616F
[441.675055] Dynamic subtest pipe-A-eDP-1-4-XRGB16161616F: SUCCESS (0.021s)
[441.683753] Starting dynamic subtest: pipe-A-eDP-1-4-YUYV
[441.697139] Dynamic subtest pipe-A-eDP-1-4-YUYV: SUCCESS (0.021s)
[441.706126] Starting dynamic subtest: pipe-A-eDP-1-4-Y210
[441.719565] Dynamic subtest pipe-A-eDP-1-4-Y210: SUCCESS (0.022s)
[441.728643] Starting dynamic subtest: pipe-A-eDP-1-4-XYUV8888
[441.741501] Dynamic subtest pipe-A-eDP-1-4-XYUV8888: SUCCESS (0.021s)
[441.751243] Starting dynamic subtest: pipe-A-eDP-1-4-XV30
[441.763926] Dynamic subtest pipe-A-eDP-1-4-XV30: SUCCESS (0.021s)
[441.773053] Starting dynamic subtest: pipe-A-eDP-1-4-XV36
[441.786215] Dynamic subtest pipe-A-eDP-1-4-XV36: SUCCESS (0.021s)
[441.795299] Starting dynamic subtest: pipe-A-eDP-1-x-RGB565
[441.953005] Dynamic subtest pipe-A-eDP-1-x-RGB565: SUCCESS (0.166s)
[441.962702] Starting dynamic subtest: pipe-A-eDP-1-x-XRGB8888
[441.975072] Dynamic subtest pipe-A-eDP-1-x-XRGB8888: SUCCESS (0.021s)
[441.984238] Starting dynamic subtest: pipe-A-eDP-1-x-XRGB2101010
[441.997386] Dynamic subtest pipe-A-eDP-1-x-XRGB2101010: SUCCESS (0.022s)
[442.007636] Starting dynamic subtest: pipe-A-eDP-1-x-XRGB16161616F
[442.019573] Dynamic subtest pipe-A-eDP-1-x-XRGB16161616F: SUCCESS (0.021s)
[442.028835] Starting dynamic subtest: pipe-A-eDP-1-x-YUYV
[442.041812] Dynamic subtest pipe-A-eDP-1-x-YUYV: SUCCESS (0.020s)
[442.051167] Starting dynamic subtest: pipe-A-eDP-1-x-Y210
[442.064054] Dynamic subtest pipe-A-eDP-1-x-Y210: SUCCESS (0.020s)
[442.073429] Starting dynamic subtest: pipe-A-eDP-1-x-XYUV8888
[442.086201] Dynamic subtest pipe-A-eDP-1-x-XYUV8888: SUCCESS (0.020s)
[442.095069] Starting dynamic subtest: pipe-A-eDP-1-x-XV30
[442.108132] Dynamic subtest pipe-A-eDP-1-x-XV30: SUCCESS (0.021s)
[442.116929] Starting dynamic subtest: pipe-A-eDP-1-x-XV36
[442.130203] Dynamic subtest pipe-A-eDP-1-x-XV36: SUCCESS (0.022s)
[442.138898] Starting dynamic subtest: pipe-A-eDP-1-linear-RGB565
[442.285732] Dynamic subtest pipe-A-eDP-1-linear-RGB565: SUCCESS (0.155s)
[442.295088] Starting dynamic subtest: pipe-A-eDP-1-linear-XRGB8888
[442.308270] Dynamic subtest pipe-A-eDP-1-linear-XRGB8888: SUCCESS (0.021s)
[442.316934] Starting dynamic subtest: pipe-A-eDP-1-linear-XRGB2101010
[442.330435] Dynamic subtest pipe-A-eDP-1-linear-XRGB2101010: SUCCESS (0.022s)
[442.339550] Starting dynamic subtest: pipe-A-eDP-1-linear-XRGB16161616F
[442.352448] Dynamic subtest pipe-A-eDP-1-linear-XRGB16161616F: SUCCESS (0.021s)
[442.361276] Starting dynamic subtest: pipe-A-eDP-1-linear-YUYV
[442.374761] Dynamic subtest pipe-A-eDP-1-linear-YUYV: SUCCESS (0.021s)
[442.384007] Starting dynamic subtest: pipe-A-eDP-1-linear-Y210
[442.397021] Dynamic subtest pipe-A-eDP-1-linear-Y210: SUCCESS (0.021s)
[442.406177] Starting dynamic subtest: pipe-A-eDP-1-linear-XYUV8888
[442.419294] Dynamic subtest pipe-A-eDP-1-linear-XYUV8888: SUCCESS (0.022s)
[442.429067] Starting dynamic subtest: pipe-A-eDP-1-linear-XV30
[442.441293] Dynamic subtest pipe-A-eDP-1-linear-XV30: SUCCESS (0.021s)
[442.450180] Starting dynamic subtest: pipe-A-eDP-1-linear-XV36
[442.463717] Dynamic subtest pipe-A-eDP-1-linear-XV36: SUCCESS (0.021s)
[442.845833] Subtest basic-modeset-with-all-modifiers-formats: SUCCESS (2.609s)
[443.710204] [090/132] (571s left) kms_color (ctm-max)
[443.808154] Starting subtest: ctm-max
[443.810440] Starting dynamic subtest: pipe-A-eDP-1
[444.526877] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.718s)
[444.538177] Starting dynamic subtest: pipe-B-eDP-1
[445.905248] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.381s)
[445.915182] Starting dynamic subtest: pipe-C-eDP-1
[447.275562] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.366s)
[447.285652] Starting dynamic subtest: pipe-D-eDP-1
[448.607221] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.330s)
[448.609229] Subtest ctm-max: SUCCESS (4.799s)
[449.436861] [091/132] (566s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-mmap-wc)
[449.544943] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-mmap-wc
[453.790998] Subtest fbc-1p-primscrn-pri-shrfb-draw-mmap-wc: SUCCESS (4.252s)
[454.944880] [092/132] (560s left) gem_render_copy (linear)
[455.005244] Starting subtest: linear
[455.007177] Starting dynamic subtest: smem
[455.043552] Dynamic subtest smem: SUCCESS (0.041s)
[455.045932] Subtest linear: SUCCESS (0.042s)
[455.254550] [093/132] (560s left) gem_userptr_blits (access-control)
[455.335900] Starting subtest: access-control
[455.340047] Subtest access-control: SKIP (0.000s)
[455.483163] [094/132] (560s left) kms_flip (2x-nonexisting-fb)
[455.579138] Starting subtest: 2x-nonexisting-fb
[455.589129] Subtest 2x-nonexisting-fb: SKIP (0.011s)
[455.708849] [095/132] (560s left) gem_ccs (block-copy-compressed)
[455.775061] Starting subtest: block-copy-compressed
[455.779334] Subtest block-copy-compressed: SKIP (0.000s)
[455.914388] [096/132] (559s left) prime_mmap (test_invalid_sync_flags)
[455.972116] Starting subtest: test_invalid_sync_flags
[455.973977] Starting dynamic subtest: test_invalid_sync_flags-smem
[455.975896] Dynamic subtest test_invalid_sync_flags-smem: SUCCESS (0.000s)
[455.977780] Subtest test_invalid_sync_flags: SUCCESS (0.001s)
[456.100841] [097/132] (559s left) gem_exec_params (invalid-bsd-ring)
[456.164822] Starting subtest: invalid-bsd-ring
[456.166920] Subtest invalid-bsd-ring: SUCCESS (0.000s)
[456.289083] [098/132] (559s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-blt)
[456.382570] Starting subtest: psr-1p-primscrn-spr-indfb-draw-blt
[463.222272] Subtest psr-1p-primscrn-spr-indfb-draw-blt: SUCCESS (6.844s)
[463.417675] [099/132] (552s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-blt)
[463.527599] Starting subtest: psr-2p-primscrn-spr-indfb-draw-blt
[463.531720] Subtest psr-2p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[463.664248] [100/132] (552s left) kms_plane (planar-pixel-format-settings)
[463.755647] Starting subtest: planar-pixel-format-settings
[463.796619] Subtest planar-pixel-format-settings: SUCCESS (0.042s)
[463.932374] [101/132] (552s left) syncobj_timeline (wait-for-submit-delayed-submit)
[463.994595] Starting subtest: wait-for-submit-delayed-submit
[464.095876] Subtest wait-for-submit-delayed-submit: SUCCESS (0.102s)
[464.197227] [102/132] (551s left) kms_cursor_crc (cursor-rapid-movement-max-size)
[464.545114] Starting subtest: cursor-rapid-movement-max-size
[464.550672] Subtest cursor-rapid-movement-max-size: SKIP (0.000s)
[464.721492] [103/132] (551s left) kms_cursor_legacy (modeset-atomic-cursor-hotspot)
[464.863306] Starting subtest: modeset-atomic-cursor-hotspot
[464.867061] Subtest modeset-atomic-cursor-hotspot: SKIP (0.000s)
[465.033095] [104/132] (551s left) gem_exec_balancer (parallel-keep-submit-fence)
[465.298817] Starting subtest: parallel-keep-submit-fence
[466.505208] Subtest parallel-keep-submit-fence: SUCCESS (1.210s)
[466.639269] [105/132] (549s left) kms_chamelium_frames (hdmi-crc-nonplanar-formats)
[467.069209] Subtest hdmi-crc-nonplanar-formats: SKIP (0.000s)
[467.856044] [106/132] (548s left) kms_getfb (getfb-addfb-different-handles)
[467.952327] Starting subtest: getfb-addfb-different-handles
[467.954659] Subtest getfb-addfb-different-handles: SUCCESS (0.000s)
[468.088403] [107/132] (548s left) gem_ctx_sseu (invalid-args)
[468.154058] Subtest invalid-args: SKIP (0.000s)
[468.214207] [108/132] (548s left) gem_lmem_swapping (parallel-random-verify)
[468.254051] Subtest parallel-random-verify: SKIP (0.000s)
[468.296150] [109/132] (548s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-move)
[468.390705] Starting subtest: psr-2p-primscrn-spr-indfb-move
[468.395164] Subtest psr-2p-primscrn-spr-indfb-move: SKIP (0.000s)
[468.519208] [110/132] (547s left) gem_exec_reloc (basic-write-cpu-noreloc)
[468.583444] Subtest basic-write-cpu-noreloc: SKIP (0.000s)
[468.681289] [111/132] (547s left) syncobj_timeline (invalid-multi-wait-unsubmitted-signaled)
[468.733767] Starting subtest: invalid-multi-wait-unsubmitted-signaled
[468.736179] Subtest invalid-multi-wait-unsubmitted-signaled: SUCCESS (0.001s)
[468.873508] [112/132] (547s left) i915_hangman (gt-engine-hang)
[468.939951] Starting subtest: gt-engine-hang
[468.941953] Starting dynamic subtest: rcs0
[470.852013] Dynamic subtest rcs0: SUCCESS (1.912s)
[470.864797] Starting dynamic subtest: bcs0
[472.838062] Dynamic subtest bcs0: SUCCESS (1.983s)
[472.851082] Starting dynamic subtest: vcs0
[474.820582] Dynamic subtest vcs0: SUCCESS (1.980s)
[474.833525] Starting dynamic subtest: vcs1
[476.805426] Dynamic subtest vcs1: SUCCESS (1.982s)
[476.818769] Starting dynamic subtest: vecs0
[478.853383] Dynamic subtest vecs0: SUCCESS (2.046s)
[478.866067] Starting dynamic subtest: ccs0
[480.837893] Dynamic subtest ccs0: SUCCESS (1.982s)
[480.841084] Subtest gt-engine-hang: SUCCESS (11.904s)
[480.943174] [113/132] (535s left) gem_mmap (bad-object)
[481.009959] Subtest bad-object: SKIP (0.000s)
[481.082998] [114/132] (535s left) kms_feature_discovery (psr1)
[481.190142] Starting subtest: psr1
[481.192356] Subtest psr1: SUCCESS (0.000s)
[481.286914] [115/132] (535s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-blt)
[481.392633] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-blt
[488.259355] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-blt: SUCCESS (6.869s)
[488.433426] [116/132] (528s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu)
[488.537970] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu
[488.542133] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[488.683246] [117/132] (528s left) gem_mmap_gtt (fault-concurrent)
[488.740791] Subtest fault-concurrent: SKIP (0.000s)
[488.807718] [118/132] (527s left) kms_pm_rpm (legacy-planes-dpms)
[491.041520] Starting subtest: legacy-planes-dpms
[491.044063] Starting dynamic subtest: plane-63
[499.632697] Dynamic subtest plane-63: SUCCESS (8.594s)
[499.645058] Starting dynamic subtest: plane-93
[508.311675] Dynamic subtest plane-93: SUCCESS (8.679s)
[508.326229] Starting dynamic subtest: plane-123
[516.633453] Dynamic subtest plane-123: SUCCESS (8.323s)
[516.659735] Starting dynamic subtest: plane-133
[525.294517] Dynamic subtest plane-133: SUCCESS (8.661s)
[525.297224] Subtest legacy-planes-dpms: SUCCESS (34.268s)
[525.680702] [119/132] (491s left) kms_chamelium_color (ctm-negative)
[525.780753] Subtest ctm-negative: SKIP (0.000s)
[525.836086] [120/132] (491s left) kms_flip_scaled_crc (flip-32bpp-yftileccs-to-64bpp-yftile-upscaling)
[525.924994] Starting subtest: flip-32bpp-yftileccs-to-64bpp-yftile-upscaling
[525.927288] Starting dynamic subtest: pipe-A-default-mode
[526.230444] Dynamic subtest pipe-A-default-mode: SKIP (0.303s)
[526.238324] Subtest flip-32bpp-yftileccs-to-64bpp-yftile-upscaling: SKIP (0.305s)
[527.106955] [121/132] (489s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180)
[527.217484] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180
[528.184267] Subtest x-tiled-max-hw-stride-32bpp-rotate-180: SUCCESS (0.968s)
[528.366100] [122/132] (488s left) kms_ccs (crc-primary-suspend-4-tiled-dg2-rc-ccs-cc)
[528.457930] Starting subtest: crc-primary-suspend-4-tiled-dg2-rc-ccs-cc
[528.459798] Starting dynamic subtest: pipe-A-eDP-1
[528.467005] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[528.477059] Starting dynamic subtest: pipe-B-eDP-1
[528.484495] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[528.493635] Starting dynamic subtest: pipe-C-eDP-1
[528.500617] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[528.509496] Starting dynamic subtest: pipe-D-eDP-1
[528.516305] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[528.519639] Subtest crc-primary-suspend-4-tiled-dg2-rc-ccs-cc: SKIP (0.008s)
[530.666429] [123/132] (486s left) kms_invalid_mode (overflow-vrefresh)
[530.761485] Starting subtest: overflow-vrefresh
[530.763823] Starting dynamic subtest: pipe-A-eDP-1
[531.045209] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.284s)
[531.060745] Starting dynamic subtest: pipe-B-eDP-1
[531.063152] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[531.078136] Starting dynamic subtest: pipe-C-eDP-1
[531.080172] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[531.092045] Starting dynamic subtest: pipe-D-eDP-1
[531.094734] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[531.097170] Subtest overflow-vrefresh: SUCCESS (0.289s)
[531.895187] [124/132] (485s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-0-async-flip)
[532.008218] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-0-async-flip
[532.012950] Subtest y-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SKIP (0.000s)
[532.144547] [125/132] (484s left) kms_psr (fbc-pr-cursor-plane-move)
[532.244903] Starting subtest: fbc-pr-cursor-plane-move
[532.249328] Subtest fbc-pr-cursor-plane-move: SKIP (0.000s)
[532.343238] [126/132] (484s left) prime_busy (before)
[532.394179] Starting subtest: before
[532.398974] Starting dynamic subtest: rcs0
[532.434300] Dynamic subtest rcs0: SUCCESS (0.036s)
[532.445332] Starting dynamic subtest: bcs0
[532.495896] Dynamic subtest bcs0: SUCCESS (0.061s)
[532.505777] Starting dynamic subtest: vcs0
[532.536523] Dynamic subtest vcs0: SUCCESS (0.040s)
[532.546758] Starting dynamic subtest: vcs1
[532.577585] Dynamic subtest vcs1: SUCCESS (0.039s)
[532.587126] Starting dynamic subtest: vecs0
[532.619547] Dynamic subtest vecs0: SUCCESS (0.041s)
[532.629405] Starting dynamic subtest: ccs0
[532.660444] Dynamic subtest ccs0: SUCCESS (0.040s)
[532.769014] Subtest before: SUCCESS (0.373s)
[532.869245] [127/132] (484s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180-async-flip)
[532.977757] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180-async-flip
[532.982301] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SKIP (0.000s)
[533.106645] [128/132] (484s left) kms_hdr (invalid-metadata-sizes)
[533.212119] Starting subtest: invalid-metadata-sizes
[533.218325] Subtest invalid-metadata-sizes: SKIP (0.000s)
[533.308997] [129/132] (483s left) gem_render_copy (y-tiled-ccs-to-yf-tiled)
[533.365216] Starting subtest: y-tiled-ccs-to-yf-tiled
[533.369773] Subtest y-tiled-ccs-to-yf-tiled: SKIP (0.000s)
[533.573044] [130/132] (483s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-pwrite)
[533.663034] Starting subtest: fbcpsr-rgb101010-draw-pwrite
[540.799551] Subtest fbcpsr-rgb101010-draw-pwrite: SUCCESS (7.143s)
[540.934224] [131/132] (476s left) gem_userptr_blits (unsync-unmap)
[541.008159] Subtest unsync-unmap: SKIP (0.000s)
[541.168267] [132/132] (476s left) gem_ccs (suspend-resume)
[541.238120] Starting subtest: suspend-resume
[541.242565] Subtest suspend-resume: SKIP (0.000s)
[541.402365] Closing watchdogs
results: parsing output: 0/ for test: kms_flip
results: parsing output: 1/ for test: gem_exec_whisper
results: parsing output: 2/ for test: kms_big_fb
results: parsing output: 3/ for test: kms_big_fb
results: parsing output: 4/ for test: syncobj_timeline
results: parsing output: 5/ for test: kms_frontbuffer_tracking
results: parsing output: 6/ for test: syncobj_timeline
results: parsing output: 7/ for test: core_setmaster
results: parsing output: 8/ for test: kms_pm_rpm
results: parsing output: 9/ for test: gem_exec_schedule
results: parsing output: 10/ for test: kms_flip
results: parsing output: 11/ for test: gem_pread
results: parsing output: 12/ for test: kms_plane_scaling
results: parsing output: 13/ for test: api_intel_bb
results: parsing output: 14/ for test: syncobj_timeline
results: parsing output: 15/ for test: kms_psr2_sf
results: parsing output: 16/ for test: kms_cursor_legacy
results: parsing output: 17/ for test: kms_flip
results: parsing output: 18/ for test: gem_exec_nop
results: parsing output: 19/ for test: gem_fence_thrash
results: parsing output: 20/ for test: prime_mmap_kms
results: parsing output: 21/ for test: gem_userptr_blits
results: parsing output: 22/ for test: kms_pm_backlight
results: parsing output: 23/ for test: gem_exec_params
results: parsing output: 24/ for test: kms_frontbuffer_tracking
results: parsing output: 25/ for test: gem_fence_thrash
results: parsing output: 26/ for test: gem_workarounds
results: parsing output: 27/ for test: syncobj_wait
results: parsing output: 28/ for test: gem_softpin
results: parsing output: 29/ for test: i915_query
results: parsing output: 30/ for test: kms_pipe_crc_basic
results: parsing output: 31/ for test: kms_psr
results: parsing output: 32/ for test: gem_ctx_exec
results: parsing output: 33/ for test: gem_render_copy
results: parsing output: 34/ for test: i915_drm_fdinfo
results: parsing output: 35/ for test: prime_vgem
results: parsing output: 36/ for test: kms_big_fb
results: parsing output: 37/ for test: kms_flip_scaled_crc
results: parsing output: 38/ for test: kms_ccs
results: parsing output: 39/ for test: gem_softpin
results: parsing output: 40/ for test: kms_frontbuffer_tracking
results: parsing output: 41/ for test: kms_plane_alpha_blend
results: parsing output: 42/ for test: kms_frontbuffer_tracking
results: parsing output: 43/ for test: kms_ccs
results: parsing output: 44/ for test: perf_pmu
results: parsing output: 45/ for test: syncobj_wait
results: parsing output: 46/ for test: kms_content_protection
results: parsing output: 47/ for test: kms_ccs
results: parsing output: 48/ for test: kms_frontbuffer_tracking
results: parsing output: 49/ for test: kms_cursor_crc
results: parsing output: 50/ for test: kms_frontbuffer_tracking
results: parsing output: 51/ for test: gem_ctx_bad_destroy
results: parsing output: 52/ for test: gem_lmem_swapping
results: parsing output: 53/ for test: gen9_exec_parse
results: parsing output: 54/ for test: sw_sync
results: parsing output: 55/ for test: i915_pm_rc6_residency
results: parsing output: 56/ for test: api_intel_bb
results: parsing output: 57/ for test: kms_frontbuffer_tracking
results: parsing output: 58/ for test: kms_vblank
results: parsing output: 59/ for test: gem_basic
results: parsing output: 60/ for test: kms_flip
results: parsing output: 61/ for test: kms_vblank
results: parsing output: 62/ for test: kms_frontbuffer_tracking
results: parsing output: 63/ for test: kms_big_fb
results: parsing output: 64/ for test: kms_flip
results: parsing output: 65/ for test: gem_exec_flush
results: parsing output: 66/ for test: vgem_basic
results: parsing output: 67/ for test: kms_frontbuffer_tracking
results: parsing output: 68/ for test: kms_dp_link_training
results: parsing output: 69/ for test: kms_universal_plane
results: parsing output: 70/ for test: gem_exec_balancer
results: parsing output: 71/ for test: gem_mmap_offset
results: parsing output: 72/ for test: kms_atomic_transition
results: parsing output: 73/ for test: kms_rotation_crc
results: parsing output: 74/ for test: kms_big_fb
results: parsing output: 75/ for test: kms_psr2_sf
results: parsing output: 76/ for test: kms_psr
results: parsing output: 77/ for test: kms_psr
results: parsing output: 78/ for test: syncobj_wait
results: parsing output: 79/ for test: kms_chamelium_hpd
results: parsing output: 80/ for test: gem_mmap_gtt
results: parsing output: 81/ for test: kms_plane_scaling
results: parsing output: 82/ for test: gem_exec_schedule
results: parsing output: 83/ for test: gem_exec_fence
results: parsing output: 84/ for test: gem_userptr_blits
results: parsing output: 85/ for test: gem_ctx_persistence
results: parsing output: 86/ for test: kms_psr
results: parsing output: 87/ for test: gem_eio
results: parsing output: 88/ for test: kms_async_flips
results: parsing output: 89/ for test: kms_color
results: parsing output: 90/ for test: kms_frontbuffer_tracking
results: parsing output: 91/ for test: gem_render_copy
results: parsing output: 92/ for test: gem_userptr_blits
results: parsing output: 93/ for test: kms_flip
results: parsing output: 94/ for test: gem_ccs
results: parsing output: 95/ for test: prime_mmap
results: parsing output: 96/ for test: gem_exec_params
results: parsing output: 97/ for test: kms_frontbuffer_tracking
results: parsing output: 98/ for test: kms_frontbuffer_tracking
results: parsing output: 99/ for test: kms_plane
results: parsing output: 100/ for test: syncobj_timeline
results: parsing output: 101/ for test: kms_cursor_crc
results: parsing output: 102/ for test: kms_cursor_legacy
results: parsing output: 103/ for test: gem_exec_balancer
results: parsing output: 104/ for test: kms_chamelium_frames
results: parsing output: 105/ for test: kms_getfb
results: parsing output: 106/ for test: gem_ctx_sseu
results: parsing output: 107/ for test: gem_lmem_swapping
results: parsing output: 108/ for test: kms_frontbuffer_tracking
results: parsing output: 109/ for test: gem_exec_reloc
results: parsing output: 110/ for test: syncobj_timeline
results: parsing output: 111/ for test: i915_hangman
results: parsing output: 112/ for test: gem_mmap
results: parsing output: 113/ for test: kms_feature_discovery
results: parsing output: 114/ for test: kms_frontbuffer_tracking
results: parsing output: 115/ for test: kms_frontbuffer_tracking
results: parsing output: 116/ for test: gem_mmap_gtt
results: parsing output: 117/ for test: kms_pm_rpm
results: parsing output: 118/ for test: kms_chamelium_color
results: parsing output: 119/ for test: kms_flip_scaled_crc
results: parsing output: 120/ for test: kms_big_fb
results: parsing output: 121/ for test: kms_ccs
results: parsing output: 122/ for test: kms_invalid_mode
results: parsing output: 123/ for test: kms_big_fb
results: parsing output: 124/ for test: kms_psr
results: parsing output: 125/ for test: prime_busy
results: parsing output: 126/ for test: kms_big_fb
results: parsing output: 127/ for test: kms_hdr
results: parsing output: 128/ for test: gem_render_copy
results: parsing output: 129/ for test: kms_frontbuffer_tracking
results: parsing output: 130/ for test: gem_userptr_blits
results: parsing output: 131/ for test: gem_ccs
Done.