[58.012213] Initializing watchdogs
[58.012258]   /dev/watchdog0
[58.025627] [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]
[58.029754] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[58.031993] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[58.035395] [001/132] (960s left) kms_flip (flip-vs-expired-vblank)
[58.165676] Starting subtest: flip-vs-expired-vblank
[58.167598] Starting dynamic subtest: A-eDP1
[66.906767] Dynamic subtest A-eDP1: SUCCESS (8.719s)
[66.920906] Starting dynamic subtest: B-eDP1
[75.557776] Dynamic subtest B-eDP1: SUCCESS (8.642s)
[75.565993] Starting dynamic subtest: C-eDP1
[84.180547] Dynamic subtest C-eDP1: SUCCESS (8.620s)
[84.189135] Starting dynamic subtest: D-eDP1
[92.806661] Dynamic subtest D-eDP1: SUCCESS (8.624s)
[92.811485] Subtest flip-vs-expired-vblank: SUCCESS (34.614s)
[94.003427] [002/132] (924s left) gem_exec_whisper (basic-contexts-forked)
[94.077304] Starting subtest: basic-contexts-forked
[117.486834] Subtest basic-contexts-forked: SUCCESS (23.402s)
[117.691170] [003/132] (900s left) kms_big_fb (4-tiled-16bpp-rotate-0)
[117.810734] Starting subtest: 4-tiled-16bpp-rotate-0
[119.122362] Subtest 4-tiled-16bpp-rotate-0: SUCCESS (1.312s)
[119.263660] [004/132] (899s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0)
[119.376440] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0
[120.344467] Subtest x-tiled-max-hw-stride-32bpp-rotate-0: SUCCESS (0.967s)
[120.476168] [005/132] (898s left) syncobj_timeline (etime-multi-wait-for-submit-submitted)
[120.545378] Starting subtest: etime-multi-wait-for-submit-submitted
[120.649069] Subtest etime-multi-wait-for-submit-submitted: SUCCESS (0.103s)
[120.771988] [006/132] (897s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-onoff)
[120.871261] Starting subtest: fbc-2p-primscrn-cur-indfb-onoff
[120.875459] Subtest fbc-2p-primscrn-cur-indfb-onoff: SKIP (0.000s)
[121.029369] [007/132] (897s left) syncobj_timeline (multi-wait-all-for-submit-signaled)
[121.106505] Starting subtest: multi-wait-all-for-submit-signaled
[121.108923] Subtest multi-wait-all-for-submit-signaled: SUCCESS (0.000s)
[121.229010] [008/132] (897s left) core_setmaster (master-drop-set-user)
[121.326886] Starting subtest: master-drop-set-user
[121.341423] Subtest master-drop-set-user: SUCCESS (0.015s)
[121.375805] [009/132] (897s left) kms_pm_rpm (system-suspend-idle)
[123.101616] Starting subtest: system-suspend-idle
[142.709716] Subtest system-suspend-idle: SUCCESS (8.271s)
[143.102920] [010/132] (875s left) gem_exec_schedule (pi-ringfull)
[143.313733] Starting subtest: pi-ringfull
[143.316031] Starting dynamic subtest: rcs0
[143.431859] Dynamic subtest rcs0: SUCCESS (0.119s)
[143.445429] Starting dynamic subtest: bcs0
[143.462322] Dynamic subtest bcs0: SUCCESS (0.030s)
[143.475986] Starting dynamic subtest: vcs0
[143.489826] Dynamic subtest vcs0: SUCCESS (0.027s)
[143.503050] Starting dynamic subtest: vcs1
[143.516588] Dynamic subtest vcs1: SUCCESS (0.026s)
[143.528691] Starting dynamic subtest: vecs0
[143.544477] Dynamic subtest vecs0: SUCCESS (0.027s)
[143.556874] Starting dynamic subtest: ccs0
[143.571587] Dynamic subtest ccs0: SUCCESS (0.026s)
[143.573851] Subtest pi-ringfull: SUCCESS (0.257s)
[143.819204] [FACT gem_exec_schedule (pi-ringfull)] new: kernel.kmod_is_loaded.vgem: true
[143.822712] [011/132] (875s left) kms_flip (bo-too-big-interruptible)
[143.939512] Starting subtest: bo-too-big-interruptible
[143.942108] Starting dynamic subtest: A-eDP1
[145.246539] Dynamic subtest A-eDP1: SUCCESS (1.291s)
[145.256832] Starting dynamic subtest: B-eDP1
[146.513595] Dynamic subtest B-eDP1: SUCCESS (1.253s)
[146.524413] Starting dynamic subtest: C-eDP1
[147.747235] Dynamic subtest C-eDP1: SUCCESS (1.223s)
[147.756871] Starting dynamic subtest: D-eDP1
[148.983582] Dynamic subtest D-eDP1: SUCCESS (1.226s)
[148.986143] Subtest bo-too-big-interruptible: SUCCESS (4.999s)
[150.223657] [012/132] (868s left) gem_pread (exhaustion)
[150.281941] Subtest exhaustion: SKIP (0.000s)
[150.341825] [013/132] (868s left) kms_plane_scaling (2x-scaler-multi-pipe)
[150.441657] Starting subtest: 2x-scaler-multi-pipe
[150.446025] Subtest 2x-scaler-multi-pipe: SKIP (0.001s)
[150.574239] [014/132] (868s left) api_intel_bb (blit-reloc-purge-cache)
[150.641002] Starting subtest: blit-reloc-purge-cache
[150.645400] Subtest blit-reloc-purge-cache: SKIP (0.001s)
[150.777748] [015/132] (868s left) syncobj_timeline (single-wait-all-available-submitted)
[150.839628] Starting subtest: single-wait-all-available-submitted
[150.841922] Subtest single-wait-all-available-submitted: SUCCESS (0.000s)
[150.974263] [016/132] (868s left) kms_psr2_sf (psr2-cursor-plane-move-continuous-sf)
[156.009125] Starting subtest: psr2-cursor-plane-move-continuous-sf
[156.011532] Starting dynamic subtest: pipe-A-eDP-1
[167.094293] Dynamic subtest pipe-A-eDP-1: SUCCESS (11.063s)
[167.103834] Starting dynamic subtest: pipe-B-eDP-1
[178.127724] Dynamic subtest pipe-B-eDP-1: SUCCESS (11.027s)
[178.130116] Subtest psr2-cursor-plane-move-continuous-sf: SUCCESS (22.094s)
[178.945734] [017/132] (840s left) kms_cursor_legacy (2x-long-flip-vs-cursor-atomic)
[179.077268] Starting subtest: 2x-long-flip-vs-cursor-atomic
[179.081795] Subtest 2x-long-flip-vs-cursor-atomic: SKIP (0.001s)
[179.245523] [018/132] (839s left) kms_flip (2x-plain-flip-ts-check-interruptible)
[179.338776] Starting subtest: 2x-plain-flip-ts-check-interruptible
[179.350294] Subtest 2x-plain-flip-ts-check-interruptible: SKIP (0.011s)
[179.485900] [019/132] (839s left) gem_exec_nop (basic-sequential)
[179.575837] Starting subtest: basic-sequential
[194.681305] Subtest basic-sequential: SUCCESS (15.114s)
[194.946751] [020/132] (824s left) gem_fence_thrash (bo-write-verify-threaded-none)
[194.983579] Starting subtest: bo-write-verify-threaded-none
[194.997832] Subtest bo-write-verify-threaded-none: SKIP (0.014s)
[195.066145] [021/132] (824s left) prime_mmap_kms (buffer-sharing)
[195.164972] Starting subtest: buffer-sharing
[195.618363] Subtest buffer-sharing: SUCCESS (0.455s)
[196.485291] [022/132] (822s left) gem_userptr_blits (stress-mm)
[196.553878] Starting subtest: stress-mm
[201.937876] Subtest stress-mm: SUCCESS (5.369s)
[202.076937] [023/132] (817s left) kms_pm_backlight (fade)
[202.200974] Starting subtest: fade
[202.250844] Starting dynamic subtest: eDP-1
[204.940025] Dynamic subtest eDP-1: SUCCESS (2.686s)
[204.942508] Subtest fade: SUCCESS (2.738s)
[205.798229] [024/132] (813s left) gem_exec_params (rs-invalid)
[205.861535] Starting subtest: rs-invalid
[205.863900] Subtest rs-invalid: SUCCESS (0.003s)
[206.005992] [025/132] (813s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-shrfb-msflip-blt)
[206.114761] Starting subtest: fbcpsr-2p-scndscrn-shrfb-msflip-blt
[206.119292] Subtest fbcpsr-2p-scndscrn-shrfb-msflip-blt: SKIP (0.000s)
[206.243199] [026/132] (813s left) gem_fence_thrash (bo-write-verify-none)
[206.278299] Starting subtest: bo-write-verify-none
[206.308232] Subtest bo-write-verify-none: SKIP (0.027s)
[206.374686] [027/132] (813s left) gem_workarounds (suspend-resume-context)
[206.441128] Starting subtest: suspend-resume-context
[222.141184] Subtest suspend-resume-context: SUCCESS (2.002s)
[223.323023] [028/132] (797s left) syncobj_wait (wait-all-delayed-signal)
[223.387089] Starting subtest: wait-all-delayed-signal
[223.493206] Subtest wait-all-delayed-signal: SUCCESS (0.100s)
[223.587586] [029/132] (797s left) gem_softpin (evict-active-interruptible)
[223.650507] Starting subtest: evict-active-interruptible
[223.657871] Subtest evict-active-interruptible: SUCCESS (0.007s)
[223.824083] [030/132] (796s left) i915_query (query-regions-garbage-items)
[223.883890] Starting subtest: query-regions-garbage-items
[223.886205] Subtest query-regions-garbage-items: SUCCESS (0.000s)
[224.022522] [031/132] (796s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24)
[224.118209] Starting subtest: compare-crc-sanitycheck-xr24
[224.120396] Starting dynamic subtest: pipe-A-eDP-1
[224.729845] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.600s)
[224.738991] Starting dynamic subtest: pipe-B-eDP-1
[226.070378] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.320s)
[226.080647] Starting dynamic subtest: pipe-C-eDP-1
[227.306976] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.222s)
[227.317627] Starting dynamic subtest: pipe-D-eDP-1
[228.549376] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.226s)
[228.551385] Subtest compare-crc-sanitycheck-xr24: SUCCESS (4.372s)
[229.439515] [032/132] (791s left) kms_psr (fbc-psr2-primary-mmap-gtt)
[229.544487] Starting subtest: fbc-psr2-primary-mmap-gtt
[229.546806] Starting dynamic subtest: eDP-1
[229.550983] Dynamic subtest eDP-1: SKIP (0.000s)
[229.555155] Subtest fbc-psr2-primary-mmap-gtt: SKIP (0.001s)
[229.643597] [033/132] (791s left) gem_ctx_exec (basic-nohangcheck)
[229.703928] Starting subtest: basic-nohangcheck
[229.964165] Subtest basic-nohangcheck: SUCCESS (0.259s)
[230.097955] [034/132] (790s left) gem_render_copy (x-tiled-to-vebox-yf-tiled)
[230.168793] Starting subtest: x-tiled-to-vebox-yf-tiled
[230.172995] Subtest x-tiled-to-vebox-yf-tiled: SKIP (0.000s)
[230.376338] [035/132] (790s left) i915_drm_fdinfo (virtual-busy)
[230.420804] Starting subtest: virtual-busy
[230.425259] Subtest virtual-busy: SKIP (0.000s)
[230.510268] [036/132] (790s left) prime_vgem (busy)
[230.593270] Starting subtest: busy
[230.595548] Starting dynamic subtest: rcs0
[230.653719] Dynamic subtest rcs0: SUCCESS (0.060s)
[230.662726] Starting dynamic subtest: bcs0
[230.729700] Dynamic subtest bcs0: SUCCESS (0.074s)
[230.738317] Starting dynamic subtest: vcs0
[230.775572] Dynamic subtest vcs0: SUCCESS (0.046s)
[230.784027] Starting dynamic subtest: vcs1
[230.820007] Dynamic subtest vcs1: SUCCESS (0.044s)
[230.828325] Starting dynamic subtest: vecs0
[230.868421] Dynamic subtest vecs0: SUCCESS (0.048s)
[230.876792] Starting dynamic subtest: ccs0
[230.915767] Dynamic subtest ccs0: SUCCESS (0.046s)
[230.918066] Subtest busy: SUCCESS (0.321s)
[231.072323] [037/132] (789s left) kms_big_fb (linear-16bpp-rotate-180)
[231.185967] Starting subtest: linear-16bpp-rotate-180
[232.583566] Subtest linear-16bpp-rotate-180: SUCCESS (1.388s)
[232.750136] [038/132] (788s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-16bpp-ytile-downscaling)
[232.844711] Starting subtest: flip-64bpp-ytile-to-16bpp-ytile-downscaling
[232.846579] Starting dynamic subtest: pipe-A-default-mode
[233.138153] Dynamic subtest pipe-A-default-mode: SKIP (0.289s)
[233.142958] Subtest flip-64bpp-ytile-to-16bpp-ytile-downscaling: SKIP (0.290s)
[233.994454] [039/132] (787s left) kms_ccs (bad-rotation-90-4-tiled-mtl-rc-ccs-cc)
[234.081023] Starting subtest: bad-rotation-90-4-tiled-mtl-rc-ccs-cc
[234.083295] Starting dynamic subtest: pipe-A-eDP-1
[234.244314] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.152s)
[234.255393] Starting dynamic subtest: pipe-B-eDP-1
[234.274933] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.010s)
[234.284291] Starting dynamic subtest: pipe-C-eDP-1
[234.302741] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.010s)
[234.311066] Starting dynamic subtest: pipe-D-eDP-1
[234.330031] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.010s)
[234.331916] Subtest bad-rotation-90-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.185s)
[236.570670] [040/132] (784s left) gem_softpin (evict-prime)
[236.637874] Starting subtest: evict-prime
[236.640143] Starting dynamic subtest: rcs0
[237.807603] Dynamic subtest rcs0: SUCCESS (1.168s)
[237.818294] Starting dynamic subtest: bcs0
[238.969585] Dynamic subtest bcs0: SUCCESS (1.157s)
[238.980915] Starting dynamic subtest: vcs0
[240.859500] Dynamic subtest vcs0: SUCCESS (1.882s)
[240.872745] Starting dynamic subtest: vcs1
[242.907721] Dynamic subtest vcs1: SUCCESS (2.043s)
[242.917695] Starting dynamic subtest: vecs0
[244.889051] Dynamic subtest vecs0: SUCCESS (1.976s)
[244.900657] Starting dynamic subtest: ccs0
[246.050901] Dynamic subtest ccs0: SUCCESS (1.159s)
[246.061767] Starting dynamic subtest: all
[247.897804] Dynamic subtest all: SUCCESS (1.842s)
[247.900301] Subtest evict-prime: SUCCESS (11.238s)
[248.009991] [041/132] (773s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-mmap-cpu)
[248.130486] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-mmap-cpu
[254.761461] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-mmap-cpu: SUCCESS (6.637s)
[254.930388] [042/132] (766s left) kms_plane_alpha_blend (alpha-opaque-fb)
[255.031006] Starting subtest: alpha-opaque-fb
[255.313650] Starting dynamic subtest: pipe-A-eDP-1
[256.011065] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.697s)
[256.020094] Starting dynamic subtest: pipe-D-eDP-1
[257.337936] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.324s)
[257.340243] Subtest alpha-opaque-fb: SUCCESS (2.308s)
[258.187975] [043/132] (763s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-mmap-gtt)
[258.298890] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-mmap-gtt
[258.303106] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[258.433561] [044/132] (762s left) kms_ccs (random-ccs-data-4-tiled-dg2-rc-ccs-cc)
[258.524457] Starting subtest: random-ccs-data-4-tiled-dg2-rc-ccs-cc
[258.526842] Starting dynamic subtest: pipe-A-eDP-1
[258.550992] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[258.562701] Starting dynamic subtest: pipe-B-eDP-1
[258.585363] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[258.593633] Starting dynamic subtest: pipe-C-eDP-1
[258.616396] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[258.624741] Starting dynamic subtest: pipe-D-eDP-1
[258.647483] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[258.651350] Subtest random-ccs-data-4-tiled-dg2-rc-ccs-cc: SKIP (0.003s)
[260.756832] [045/132] (760s left) perf_pmu (busy-accuracy-2)
[260.796328] Starting subtest: busy-accuracy-2
[260.798583] Starting dynamic subtest: rcs0
[263.839734] Dynamic subtest rcs0: SUCCESS (3.042s)
[263.851081] Starting dynamic subtest: bcs0
[266.899622] Dynamic subtest bcs0: SUCCESS (3.058s)
[266.910516] Starting dynamic subtest: vcs0
[269.945568] Dynamic subtest vcs0: SUCCESS (3.044s)
[269.955495] Starting dynamic subtest: vcs1
[272.988797] Dynamic subtest vcs1: SUCCESS (3.041s)
[272.998307] Starting dynamic subtest: vecs0
[276.035760] Dynamic subtest vecs0: SUCCESS (3.044s)
[276.046432] Starting dynamic subtest: ccs0
[279.101486] Dynamic subtest ccs0: SUCCESS (3.063s)
[279.103929] Subtest busy-accuracy-2: SUCCESS (18.303s)
[279.259628] [046/132] (742s left) syncobj_wait (invalid-multi-wait-unsubmitted-submitted)
[279.334818] Starting subtest: invalid-multi-wait-unsubmitted-submitted
[279.337092] Subtest invalid-multi-wait-unsubmitted-submitted: SUCCESS (0.000s)
[279.446930] [047/132] (742s left) kms_content_protection (srm)
[279.596397] Starting subtest: srm
[279.603854] Subtest srm: SKIP (0.002s)
[279.746605] [048/132] (741s left) kms_ccs (ccs-on-another-bo-y-tiled-gen12-rc-ccs-cc)
[279.853010] Starting subtest: ccs-on-another-bo-y-tiled-gen12-rc-ccs-cc
[279.855279] Starting dynamic subtest: pipe-A-eDP-1
[279.877988] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[279.888676] Starting dynamic subtest: pipe-B-eDP-1
[279.910378] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[279.918517] Starting dynamic subtest: pipe-C-eDP-1
[279.940412] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[279.949466] Starting dynamic subtest: pipe-D-eDP-1
[279.971595] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[279.975616] Subtest ccs-on-another-bo-y-tiled-gen12-rc-ccs-cc: SKIP (0.006s)
[282.029217] [049/132] (739s left) kms_frontbuffer_tracking (psr-rgb565-draw-mmap-gtt)
[282.142286] Starting subtest: psr-rgb565-draw-mmap-gtt
[282.146742] Subtest psr-rgb565-draw-mmap-gtt: SKIP (0.000s)
[282.276484] [050/132] (739s left) kms_cursor_crc (cursor-onscreen-32x10)
[282.432012] Starting subtest: cursor-onscreen-32x10
[282.477761] Subtest cursor-onscreen-32x10: SKIP (0.039s)
[282.791229] [051/132] (738s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-onoff)
[282.904815] Starting subtest: psr-1p-primscrn-cur-indfb-onoff
[289.856116] Subtest psr-1p-primscrn-cur-indfb-onoff: SUCCESS (6.954s)
[290.013853] [052/132] (731s left) gem_ctx_bad_destroy (double-destroy)
[290.077592] Starting subtest: double-destroy
[290.080364] Subtest double-destroy: SUCCESS (0.000s)
[290.181213] [053/132] (731s left) gem_lmem_swapping (basic)
[290.218546] Subtest basic: SKIP (0.000s)
[290.258776] [054/132] (731s left) gen9_exec_parse (bb-start-cmd)
[290.329746] Subtest bb-start-cmd: SKIP (0.000s)
[290.417534] [055/132] (731s left) sw_sync (sync_multi_timeline_wait)
[290.462031] Starting subtest: sync_multi_timeline_wait
[290.464250] Subtest sync_multi_timeline_wait: SUCCESS (0.000s)
[290.542044] [056/132] (731s left) i915_pm_rc6_residency (rc6-accuracy)
[290.597785] Starting subtest: rc6-accuracy
[290.599903] Starting dynamic subtest: gt0
[293.769216] Dynamic subtest gt0: SUCCESS (3.169s)
[293.780494] Starting dynamic subtest: gt1
[296.939348] Dynamic subtest gt1: SUCCESS (3.168s)
[296.942083] Subtest rc6-accuracy: SUCCESS (6.342s)
[297.042830] [057/132] (724s left) api_intel_bb (simple-bb-ctx)
[297.112505] Starting subtest: simple-bb-ctx
[297.123047] Subtest simple-bb-ctx: SUCCESS (0.014s)
[297.303306] [058/132] (724s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-indfb-pgflip-blt)
[297.413023] Starting subtest: fbcpsr-2p-primscrn-indfb-pgflip-blt
[297.417412] Subtest fbcpsr-2p-primscrn-indfb-pgflip-blt: SKIP (0.000s)
[297.541025] [059/132] (724s left) kms_vblank (crtc-id)
[297.639389] Starting subtest: crtc-id
[297.641650] Starting dynamic subtest: pipe-A-eDP-1
[298.089116] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.450s)
[298.102345] Starting dynamic subtest: pipe-D-eDP-1
[299.248722] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.156s)
[299.250877] Subtest crtc-id: SUCCESS (1.610s)
[300.110030] [060/132] (721s left) gem_basic (bad-close)
[300.175182] Starting subtest: bad-close
[300.179617] Subtest bad-close: SUCCESS (0.000s)
[300.299707] [061/132] (721s left) kms_flip (dpms-vs-vblank-race-interruptible)
[300.395277] Starting subtest: dpms-vs-vblank-race-interruptible
[300.397601] Starting dynamic subtest: A-eDP1
[305.388733] Dynamic subtest A-eDP1: SUCCESS (4.989s)
[305.398055] Starting dynamic subtest: B-eDP1
[308.892590] Dynamic subtest B-eDP1: SUCCESS (3.502s)
[308.901741] Starting dynamic subtest: C-eDP1
[313.505693] Dynamic subtest C-eDP1: SUCCESS (4.609s)
[313.515459] Starting dynamic subtest: D-eDP1
[318.115408] Dynamic subtest D-eDP1: SUCCESS (4.610s)
[318.117863] Subtest dpms-vs-vblank-race-interruptible: SUCCESS (17.721s)
[319.023279] [062/132] (703s left) kms_vblank (wait-forked-busy)
[319.127638] Starting subtest: wait-forked-busy
[319.129517] Starting dynamic subtest: pipe-A-eDP-1
[321.004634] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.875s)
[321.020543] Starting dynamic subtest: pipe-D-eDP-1
[323.565010] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.559s)
[323.567399] Subtest wait-forked-busy: SUCCESS (4.438s)
[324.386797] [063/132] (697s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-pwrite)
[324.486730] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-pwrite
[324.490997] Subtest fbc-2p-scndscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[324.622764] [064/132] (697s left) kms_big_fb (4-tiled-64bpp-rotate-180)
[324.728639] Starting subtest: 4-tiled-64bpp-rotate-180
[326.274540] Subtest 4-tiled-64bpp-rotate-180: SUCCESS (1.545s)
[326.500983] [065/132] (695s left) kms_flip (absolute-wf_vblank-interruptible)
[326.598134] Starting subtest: absolute-wf_vblank-interruptible
[326.600377] Starting dynamic subtest: A-eDP1
[335.325928] Dynamic subtest A-eDP1: SUCCESS (8.724s)
[335.334631] Starting dynamic subtest: B-eDP1
[344.053289] Dynamic subtest B-eDP1: SUCCESS (8.724s)
[344.066266] Starting dynamic subtest: C-eDP1
[352.768061] Dynamic subtest C-eDP1: SUCCESS (8.710s)
[352.777297] Starting dynamic subtest: D-eDP1
[361.499870] Dynamic subtest D-eDP1: SUCCESS (8.728s)
[361.506129] Subtest absolute-wf_vblank-interruptible: SUCCESS (34.899s)
[362.737781] [066/132] (659s left) gem_exec_flush (basic-uc-prw-default)
[362.805021] Starting subtest: basic-uc-prw-default
[368.262575] Subtest basic-uc-prw-default: SUCCESS (5.456s)
[368.474801] [067/132] (653s left) vgem_basic (busy-fence)
[368.522395] Starting subtest: busy-fence
[368.524304] Subtest busy-fence: SUCCESS (0.000s)
[368.603279] [068/132] (653s left) kms_frontbuffer_tracking (psr-rgb565-draw-render)
[368.702690] Starting subtest: psr-rgb565-draw-render
[375.709502] Subtest psr-rgb565-draw-render: SUCCESS (7.007s)
[375.859533] [069/132] (646s left) kms_dp_link_training (uhbr-sst)
[375.950776] Starting subtest: uhbr-sst
[375.959214] Subtest uhbr-sst: SKIP (0.000s)
[376.052467] [070/132] (646s left) kms_universal_plane (disable-primary-vs-flip)
[376.157686] Starting subtest: disable-primary-vs-flip
[376.160103] Starting dynamic subtest: pipe-A-eDP-1
[377.706578] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.543s)
[377.716473] Starting dynamic subtest: pipe-B-eDP-1
[379.859635] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.153s)
[379.868485] Starting dynamic subtest: pipe-C-eDP-1
[382.037152] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.176s)
[382.049198] Starting dynamic subtest: pipe-D-eDP-1
[384.198203] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.159s)
[384.200617] Subtest disable-primary-vs-flip: SUCCESS (8.038s)
[385.022835] [071/132] (637s left) gem_exec_balancer (invalid-balancer)
[385.097065] Starting subtest: invalid-balancer
[385.968522] Subtest invalid-balancer: SUCCESS (0.869s)
[386.312879] [072/132] (636s left) gem_mmap_offset (bad-extensions)
[386.380211] Starting subtest: bad-extensions
[386.382505] Subtest bad-extensions: SUCCESS (0.000s)
[386.514971] [073/132] (636s left) kms_atomic_transition (plane-all-transition)
[386.612633] Starting subtest: plane-all-transition
[386.614857] Starting dynamic subtest: pipe-A-eDP-1
[389.106362] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.494s)
[389.418720] Starting dynamic subtest: pipe-B-eDP-1
[392.634973] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.224s)
[392.942958] Subtest plane-all-transition: SUCCESS (6.330s)
[393.786470] [074/132] (628s left) kms_rotation_crc (multiplane-rotation)
[393.877658] Starting subtest: multiplane-rotation
[411.285331] Subtest multiplane-rotation: SUCCESS (17.404s)
[411.435095] [075/132] (611s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip)
[411.543101] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip
[411.546795] Subtest y-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip: SKIP (0.000s)
[411.653473] [076/132] (611s left) kms_psr2_sf (fbc-psr2-primary-plane-update-sf-dmg-area)
[416.636364] Starting subtest: fbc-psr2-primary-plane-update-sf-dmg-area
[416.638491] Starting dynamic subtest: pipe-A-eDP-1
[417.452735] Dynamic subtest pipe-A-eDP-1: SKIP (0.814s)
[417.462409] Starting dynamic subtest: pipe-B-eDP-1
[418.576482] Dynamic subtest pipe-B-eDP-1: SKIP (1.121s)
[418.581032] Subtest fbc-psr2-primary-plane-update-sf-dmg-area: SKIP (1.940s)
[419.784296] [077/132] (602s left) kms_psr (pr-sprite-blt)
[419.882438] Starting subtest: pr-sprite-blt
[419.887368] Subtest pr-sprite-blt: SKIP (0.000s)
[419.975300] [078/132] (602s left) kms_psr (pr-cursor-render)
[420.077418] Starting subtest: pr-cursor-render
[420.081286] Subtest pr-cursor-render: SKIP (0.000s)
[420.172162] [079/132] (602s left) syncobj_wait (single-wait-all-signaled)
[420.231656] Starting subtest: single-wait-all-signaled
[420.233785] Subtest single-wait-all-signaled: SUCCESS (0.000s)
[420.367001] [080/132] (602s left) kms_chamelium_hpd (dp-hpd-storm)
[420.765351] Subtest dp-hpd-storm: SKIP (0.000s)
[421.568554] [081/132] (601s left) gem_mmap_gtt (basic-write-gtt)
[421.642243] Subtest basic-write-gtt: SKIP (0.000s)
[421.709270] [082/132] (601s left) kms_plane_scaling (plane-scaler-with-clipping-clamping-modifiers)
[421.813251] Starting subtest: plane-scaler-with-clipping-clamping-modifiers
[421.815477] Starting dynamic subtest: pipe-A
[422.177395] Dynamic subtest pipe-A: SUCCESS (0.365s)
[422.188489] Starting dynamic subtest: pipe-B
[423.581224] Dynamic subtest pipe-B: SUCCESS (1.403s)
[423.590540] Starting dynamic subtest: pipe-C
[425.006734] Dynamic subtest pipe-C: SUCCESS (1.425s)
[425.016318] Starting dynamic subtest: pipe-D
[426.457243] Dynamic subtest pipe-D: SUCCESS (1.450s)
[426.460118] Subtest plane-scaler-with-clipping-clamping-modifiers: SUCCESS (4.648s)
[427.637289] [083/132] (595s left) gem_exec_schedule (thriceslice)
[427.706739] Starting subtest: thriceslice
[427.708690] Starting dynamic subtest: rcs0
[427.749371] Dynamic subtest rcs0: SUCCESS (0.051s)
[427.759638] Starting dynamic subtest: bcs0
[427.780095] Dynamic subtest bcs0: SUCCESS (0.029s)
[427.788434] Starting dynamic subtest: vcs0
[427.830427] Dynamic subtest vcs0: SUCCESS (0.049s)
[427.841445] Starting dynamic subtest: vcs1
[427.860381] Dynamic subtest vcs1: SUCCESS (0.028s)
[427.871947] Starting dynamic subtest: vecs0
[427.888684] Dynamic subtest vecs0: SUCCESS (0.027s)
[427.897833] Starting dynamic subtest: ccs0
[427.917994] Dynamic subtest ccs0: SUCCESS (0.028s)
[427.920293] Subtest thriceslice: SUCCESS (0.220s)
[428.246343] [084/132] (594s left) gem_exec_fence (nb-await)
[428.433268] Starting subtest: nb-await
[428.435754] Starting dynamic subtest: rcs0
[428.498723] Dynamic subtest rcs0: SUCCESS (0.065s)
[428.511375] Starting dynamic subtest: bcs0
[428.556049] Dynamic subtest bcs0: SUCCESS (0.056s)
[428.567271] Starting dynamic subtest: vcs0
[428.614718] Dynamic subtest vcs0: SUCCESS (0.057s)
[428.625941] Starting dynamic subtest: vcs1
[428.673734] Dynamic subtest vcs1: SUCCESS (0.056s)
[428.684711] Starting dynamic subtest: vecs0
[428.732196] Dynamic subtest vecs0: SUCCESS (0.057s)
[428.743275] Starting dynamic subtest: ccs0
[428.790368] Dynamic subtest ccs0: SUCCESS (0.056s)
[428.793116] Subtest nb-await: SUCCESS (0.358s)
[431.050076] [085/132] (591s left) gem_userptr_blits (set-cache-level)
[431.117725] Starting subtest: set-cache-level
[431.122192] Subtest set-cache-level: SKIP (0.000s)
[431.307868] [086/132] (591s left) gem_ctx_persistence (hang)
[431.375748] Starting subtest: hang
[431.380177] Subtest hang: SKIP (0.000s)
[431.525219] [087/132] (591s left) kms_psr (psr-cursor-mmap-gtt)
[431.620554] Starting subtest: psr-cursor-mmap-gtt
[431.622825] Starting dynamic subtest: eDP-1
[433.317722] Dynamic subtest eDP-1: SUCCESS (1.697s)
[433.319999] Subtest psr-cursor-mmap-gtt: SUCCESS (1.698s)
[434.207794] [088/132] (588s left) gem_eio (in-flight-contexts-immediate)
[434.429511] Starting subtest: in-flight-contexts-immediate
[445.908161] Subtest in-flight-contexts-immediate: SUCCESS (11.480s)
[446.087862] [089/132] (577s left) kms_async_flips (basic-modeset-with-all-modifiers-formats)
[446.188039] Starting subtest: basic-modeset-with-all-modifiers-formats
[446.557600] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-XRGB8888
[447.347085] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-XRGB8888: SUCCESS (0.791s)
[447.356314] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-XRGB2101010
[447.369241] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-XRGB2101010: SUCCESS (0.021s)
[447.377741] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-XRGB16161616F
[447.391737] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-XRGB16161616F: SUCCESS (0.021s)
[447.403372] Starting dynamic subtest: pipe-A-eDP-1-4-RGB565
[447.547339] Dynamic subtest pipe-A-eDP-1-4-RGB565: SUCCESS (0.155s)
[447.557201] Starting dynamic subtest: pipe-A-eDP-1-4-XRGB8888
[447.569551] Dynamic subtest pipe-A-eDP-1-4-XRGB8888: SUCCESS (0.021s)
[447.579452] Starting dynamic subtest: pipe-A-eDP-1-4-XRGB2101010
[447.591734] Dynamic subtest pipe-A-eDP-1-4-XRGB2101010: SUCCESS (0.021s)
[447.600342] Starting dynamic subtest: pipe-A-eDP-1-4-XRGB16161616F
[447.614221] Dynamic subtest pipe-A-eDP-1-4-XRGB16161616F: SUCCESS (0.021s)
[447.629910] Starting dynamic subtest: pipe-A-eDP-1-4-YUYV
[447.636212] Dynamic subtest pipe-A-eDP-1-4-YUYV: SUCCESS (0.021s)
[447.645492] Starting dynamic subtest: pipe-A-eDP-1-4-Y210
[447.658430] Dynamic subtest pipe-A-eDP-1-4-Y210: SUCCESS (0.021s)
[447.666900] Starting dynamic subtest: pipe-A-eDP-1-4-XYUV8888
[447.680625] Dynamic subtest pipe-A-eDP-1-4-XYUV8888: SUCCESS (0.021s)
[447.689234] Starting dynamic subtest: pipe-A-eDP-1-4-XV30
[447.702567] Dynamic subtest pipe-A-eDP-1-4-XV30: SUCCESS (0.021s)
[447.711276] Starting dynamic subtest: pipe-A-eDP-1-4-XV36
[447.725010] Dynamic subtest pipe-A-eDP-1-4-XV36: SUCCESS (0.022s)
[447.733727] Starting dynamic subtest: pipe-A-eDP-1-x-RGB565
[447.869627] Dynamic subtest pipe-A-eDP-1-x-RGB565: SUCCESS (0.144s)
[447.879534] Starting dynamic subtest: pipe-A-eDP-1-x-XRGB8888
[447.891839] Dynamic subtest pipe-A-eDP-1-x-XRGB8888: SUCCESS (0.021s)
[447.901787] Starting dynamic subtest: pipe-A-eDP-1-x-XRGB2101010
[447.913929] Dynamic subtest pipe-A-eDP-1-x-XRGB2101010: SUCCESS (0.021s)
[447.922434] Starting dynamic subtest: pipe-A-eDP-1-x-XRGB16161616F
[447.936175] Dynamic subtest pipe-A-eDP-1-x-XRGB16161616F: SUCCESS (0.021s)
[447.944714] Starting dynamic subtest: pipe-A-eDP-1-x-YUYV
[447.958464] Dynamic subtest pipe-A-eDP-1-x-YUYV: SUCCESS (0.022s)
[447.966945] Starting dynamic subtest: pipe-A-eDP-1-x-Y210
[447.980655] Dynamic subtest pipe-A-eDP-1-x-Y210: SUCCESS (0.021s)
[447.989087] Starting dynamic subtest: pipe-A-eDP-1-x-XYUV8888
[448.003110] Dynamic subtest pipe-A-eDP-1-x-XYUV8888: SUCCESS (0.021s)
[448.011594] Starting dynamic subtest: pipe-A-eDP-1-x-XV30
[448.025021] Dynamic subtest pipe-A-eDP-1-x-XV30: SUCCESS (0.021s)
[448.033585] Starting dynamic subtest: pipe-A-eDP-1-x-XV36
[448.047012] Dynamic subtest pipe-A-eDP-1-x-XV36: SUCCESS (0.022s)
[448.055630] Starting dynamic subtest: pipe-A-eDP-1-linear-RGB565
[448.203252] Dynamic subtest pipe-A-eDP-1-linear-RGB565: SUCCESS (0.155s)
[448.212563] Starting dynamic subtest: pipe-A-eDP-1-linear-XRGB8888
[448.225698] Dynamic subtest pipe-A-eDP-1-linear-XRGB8888: SUCCESS (0.021s)
[448.236561] Starting dynamic subtest: pipe-A-eDP-1-linear-XRGB2101010
[448.247669] Dynamic subtest pipe-A-eDP-1-linear-XRGB2101010: SUCCESS (0.022s)
[448.256354] Starting dynamic subtest: pipe-A-eDP-1-linear-XRGB16161616F
[448.269914] Dynamic subtest pipe-A-eDP-1-linear-XRGB16161616F: SUCCESS (0.022s)
[448.278757] Starting dynamic subtest: pipe-A-eDP-1-linear-YUYV
[448.292091] Dynamic subtest pipe-A-eDP-1-linear-YUYV: SUCCESS (0.021s)
[448.301252] Starting dynamic subtest: pipe-A-eDP-1-linear-Y210
[448.314316] Dynamic subtest pipe-A-eDP-1-linear-Y210: SUCCESS (0.022s)
[448.322948] Starting dynamic subtest: pipe-A-eDP-1-linear-XYUV8888
[448.336231] Dynamic subtest pipe-A-eDP-1-linear-XYUV8888: SUCCESS (0.021s)
[448.344536] Starting dynamic subtest: pipe-A-eDP-1-linear-XV30
[448.358351] Dynamic subtest pipe-A-eDP-1-linear-XV30: SUCCESS (0.021s)
[448.366617] Starting dynamic subtest: pipe-A-eDP-1-linear-XV36
[448.380554] Dynamic subtest pipe-A-eDP-1-linear-XV36: SUCCESS (0.021s)
[448.772947] Subtest basic-modeset-with-all-modifiers-formats: SUCCESS (2.587s)
[449.564095] [090/132] (573s left) kms_color (ctm-max)
[449.658263] Starting subtest: ctm-max
[449.660503] Starting dynamic subtest: pipe-A-eDP-1
[450.402830] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.743s)
[450.412696] Starting dynamic subtest: pipe-B-eDP-1
[451.866722] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.465s)
[451.876338] Starting dynamic subtest: pipe-C-eDP-1
[453.248485] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.382s)
[453.260154] Starting dynamic subtest: pipe-D-eDP-1
[454.567615] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.318s)
[454.570054] Subtest ctm-max: SUCCESS (4.911s)
[455.410065] [091/132] (567s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-mmap-wc)
[455.508030] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-mmap-wc
[459.852912] Subtest fbc-1p-primscrn-pri-shrfb-draw-mmap-wc: SUCCESS (4.348s)
[461.012673] [092/132] (562s left) gem_render_copy (linear)
[461.074008] Starting subtest: linear
[461.076372] Starting dynamic subtest: smem
[461.117802] Dynamic subtest smem: SUCCESS (0.044s)
[461.120371] Subtest linear: SUCCESS (0.044s)
[461.329020] [093/132] (562s left) gem_userptr_blits (access-control)
[461.413468] Starting subtest: access-control
[461.418068] Subtest access-control: SKIP (0.000s)
[461.580968] [094/132] (561s left) kms_flip (2x-nonexisting-fb)
[461.671061] Starting subtest: 2x-nonexisting-fb
[461.678516] Subtest 2x-nonexisting-fb: SKIP (0.010s)
[461.783125] [095/132] (561s left) gem_ccs (block-copy-compressed)
[461.841224] Starting subtest: block-copy-compressed
[461.845949] Subtest block-copy-compressed: SKIP (0.000s)
[461.984801] [096/132] (561s left) prime_mmap (test_invalid_sync_flags)
[462.039635] Starting subtest: test_invalid_sync_flags
[462.041994] Starting dynamic subtest: test_invalid_sync_flags-smem
[462.044224] Dynamic subtest test_invalid_sync_flags-smem: SUCCESS (0.000s)
[462.046468] Subtest test_invalid_sync_flags: SUCCESS (0.001s)
[462.165706] [097/132] (561s left) gem_exec_params (invalid-bsd-ring)
[462.215987] Starting subtest: invalid-bsd-ring
[462.218428] Subtest invalid-bsd-ring: SUCCESS (0.000s)
[462.344576] [098/132] (561s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-blt)
[462.444568] Starting subtest: psr-1p-primscrn-spr-indfb-draw-blt
[469.215005] Subtest psr-1p-primscrn-spr-indfb-draw-blt: SUCCESS (6.773s)
[469.407739] [099/132] (554s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-blt)
[469.511845] Starting subtest: psr-2p-primscrn-spr-indfb-draw-blt
[469.516244] Subtest psr-2p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[469.662211] [100/132] (554s left) kms_plane (planar-pixel-format-settings)
[469.766899] Starting subtest: planar-pixel-format-settings
[469.807782] Subtest planar-pixel-format-settings: SUCCESS (0.043s)
[469.937709] [101/132] (553s left) syncobj_timeline (wait-for-submit-delayed-submit)
[470.008358] Starting subtest: wait-for-submit-delayed-submit
[470.112117] Subtest wait-for-submit-delayed-submit: SUCCESS (0.103s)
[470.214105] [102/132] (553s left) kms_cursor_crc (cursor-rapid-movement-max-size)
[470.529636] Starting subtest: cursor-rapid-movement-max-size
[470.536245] Subtest cursor-rapid-movement-max-size: SKIP (0.000s)
[470.694139] [103/132] (553s left) kms_cursor_legacy (modeset-atomic-cursor-hotspot)
[470.816276] Starting subtest: modeset-atomic-cursor-hotspot
[470.820804] Subtest modeset-atomic-cursor-hotspot: SKIP (0.000s)
[470.983779] [104/132] (552s left) gem_exec_balancer (parallel-keep-submit-fence)
[471.232320] Starting subtest: parallel-keep-submit-fence
[472.410586] Subtest parallel-keep-submit-fence: SUCCESS (1.178s)
[472.544292] [105/132] (551s left) kms_chamelium_frames (hdmi-crc-nonplanar-formats)
[472.937307] Subtest hdmi-crc-nonplanar-formats: SKIP (0.000s)
[473.790245] [106/132] (550s left) kms_getfb (getfb-addfb-different-handles)
[473.895454] Starting subtest: getfb-addfb-different-handles
[473.897798] Subtest getfb-addfb-different-handles: SUCCESS (0.000s)
[474.018149] [107/132] (549s left) gem_ctx_sseu (invalid-args)
[474.085558] Subtest invalid-args: SKIP (0.000s)
[474.172588] [108/132] (549s left) gem_lmem_swapping (parallel-random-verify)
[474.211226] Subtest parallel-random-verify: SKIP (0.000s)
[474.256573] [109/132] (549s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-move)
[474.357827] Starting subtest: psr-2p-primscrn-spr-indfb-move
[474.362198] Subtest psr-2p-primscrn-spr-indfb-move: SKIP (0.000s)
[474.491799] [110/132] (549s left) gem_exec_reloc (basic-write-cpu-noreloc)
[474.545716] Subtest basic-write-cpu-noreloc: SKIP (0.000s)
[474.618547] [111/132] (549s left) syncobj_timeline (invalid-multi-wait-unsubmitted-signaled)
[474.669568] Starting subtest: invalid-multi-wait-unsubmitted-signaled
[474.671734] Subtest invalid-multi-wait-unsubmitted-signaled: SUCCESS (0.000s)
[474.810572] [112/132] (549s left) i915_hangman (gt-engine-hang)
[474.885994] Starting subtest: gt-engine-hang
[474.887537] Starting dynamic subtest: rcs0
[476.893494] Dynamic subtest rcs0: SUCCESS (2.003s)
[476.905179] Starting dynamic subtest: bcs0
[478.873184] Dynamic subtest bcs0: SUCCESS (1.979s)
[478.886136] Starting dynamic subtest: vcs0
[480.857245] Dynamic subtest vcs0: SUCCESS (1.981s)
[480.869043] Starting dynamic subtest: vcs1
[482.841708] Dynamic subtest vcs1: SUCCESS (1.981s)
[482.853588] Starting dynamic subtest: vecs0
[484.889159] Dynamic subtest vecs0: SUCCESS (2.045s)
[484.903171] Starting dynamic subtest: ccs0
[486.888461] Dynamic subtest ccs0: SUCCESS (1.979s)
[486.892948] Subtest gt-engine-hang: SUCCESS (11.985s)
[487.038865] [113/132] (537s left) gem_mmap (bad-object)
[487.105359] Subtest bad-object: SKIP (0.000s)
[487.171178] [114/132] (537s left) kms_feature_discovery (psr1)
[487.261839] Starting subtest: psr1
[487.263724] Subtest psr1: SUCCESS (0.000s)
[487.366335] [115/132] (536s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-blt)
[487.467605] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-blt
[494.507414] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-blt: SUCCESS (7.040s)
[494.704929] [116/132] (529s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu)
[494.788737] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu
[494.793095] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[494.911069] [117/132] (529s left) gem_mmap_gtt (fault-concurrent)
[494.979123] Subtest fault-concurrent: SKIP (0.000s)
[495.051349] [118/132] (529s left) kms_pm_rpm (legacy-planes-dpms)
[497.070078] Starting subtest: legacy-planes-dpms
[497.072355] Starting dynamic subtest: plane-63
[505.655008] Dynamic subtest plane-63: SUCCESS (8.587s)
[505.667094] Starting dynamic subtest: plane-93
[514.392074] Dynamic subtest plane-93: SUCCESS (8.732s)
[514.404892] Starting dynamic subtest: plane-123
[522.993874] Dynamic subtest plane-123: SUCCESS (8.600s)
[523.008447] Starting dynamic subtest: plane-133
[531.797040] Dynamic subtest plane-133: SUCCESS (8.797s)
[531.799755] Subtest legacy-planes-dpms: SUCCESS (34.725s)
[532.194876] [119/132] (492s left) kms_chamelium_color (ctm-negative)
[532.279340] Subtest ctm-negative: SKIP (0.000s)
[532.322832] [120/132] (492s left) kms_flip_scaled_crc (flip-32bpp-yftileccs-to-64bpp-yftile-upscaling)
[532.415800] Starting subtest: flip-32bpp-yftileccs-to-64bpp-yftile-upscaling
[532.417977] Starting dynamic subtest: pipe-A-default-mode
[532.716674] Dynamic subtest pipe-A-default-mode: SKIP (0.297s)
[532.720988] Subtest flip-32bpp-yftileccs-to-64bpp-yftile-upscaling: SKIP (0.299s)
[533.639852] [121/132] (490s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180)
[533.738952] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180
[534.728718] Subtest x-tiled-max-hw-stride-32bpp-rotate-180: SUCCESS (0.989s)
[534.874730] [122/132] (489s left) kms_ccs (crc-primary-suspend-4-tiled-dg2-rc-ccs-cc)
[534.963677] Starting subtest: crc-primary-suspend-4-tiled-dg2-rc-ccs-cc
[534.965551] Starting dynamic subtest: pipe-A-eDP-1
[534.973118] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[534.982903] Starting dynamic subtest: pipe-B-eDP-1
[534.990452] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[534.999234] Starting dynamic subtest: pipe-C-eDP-1
[535.006123] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[535.014602] Starting dynamic subtest: pipe-D-eDP-1
[535.021602] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[535.025056] Subtest crc-primary-suspend-4-tiled-dg2-rc-ccs-cc: SKIP (0.004s)
[537.269179] [123/132] (487s left) kms_invalid_mode (overflow-vrefresh)
[537.367027] Starting subtest: overflow-vrefresh
[537.369247] Starting dynamic subtest: pipe-A-eDP-1
[537.649470] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.286s)
[537.658517] Starting dynamic subtest: pipe-B-eDP-1
[537.660482] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[537.668770] Starting dynamic subtest: pipe-C-eDP-1
[537.670645] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[537.679229] Starting dynamic subtest: pipe-D-eDP-1
[537.681426] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[537.683702] Subtest overflow-vrefresh: SUCCESS (0.291s)
[538.492549] [124/132] (486s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-0-async-flip)
[538.598887] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-0-async-flip
[538.603233] Subtest y-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SKIP (0.000s)
[538.718155] [125/132] (486s left) kms_psr (fbc-pr-cursor-plane-move)
[538.813234] Starting subtest: fbc-pr-cursor-plane-move
[538.817482] Subtest fbc-pr-cursor-plane-move: SKIP (0.000s)
[538.915245] [126/132] (485s left) prime_busy (before)
[538.968647] Starting subtest: before
[538.973280] Starting dynamic subtest: rcs0
[538.995479] Dynamic subtest rcs0: SUCCESS (0.024s)
[539.005773] Starting dynamic subtest: bcs0
[539.069351] Dynamic subtest bcs0: SUCCESS (0.073s)
[539.079945] Starting dynamic subtest: vcs0
[539.109236] Dynamic subtest vcs0: SUCCESS (0.039s)
[539.118186] Starting dynamic subtest: vcs1
[539.150617] Dynamic subtest vcs1: SUCCESS (0.041s)
[539.159310] Starting dynamic subtest: vecs0
[539.192458] Dynamic subtest vecs0: SUCCESS (0.041s)
[539.200992] Starting dynamic subtest: ccs0
[539.233763] Dynamic subtest ccs0: SUCCESS (0.041s)
[539.342126] Subtest before: SUCCESS (0.372s)
[539.443699] [127/132] (485s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180-async-flip)
[539.539702] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180-async-flip
[539.544072] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SKIP (0.000s)
[539.673234] [128/132] (485s left) kms_hdr (invalid-metadata-sizes)
[539.755514] Starting subtest: invalid-metadata-sizes
[539.761910] Subtest invalid-metadata-sizes: SKIP (0.000s)
[539.854103] [129/132] (485s left) gem_render_copy (y-tiled-ccs-to-yf-tiled)
[539.910440] Starting subtest: y-tiled-ccs-to-yf-tiled
[539.914871] Subtest y-tiled-ccs-to-yf-tiled: SKIP (0.000s)
[540.112137] [130/132] (484s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-pwrite)
[540.219359] Starting subtest: fbcpsr-rgb101010-draw-pwrite
[547.137842] Subtest fbcpsr-rgb101010-draw-pwrite: SUCCESS (6.920s)
[547.287313] [131/132] (477s left) gem_userptr_blits (unsync-unmap)
[547.356057] Subtest unsync-unmap: SKIP (0.000s)
[547.517433] [132/132] (477s left) gem_ccs (suspend-resume)
[547.576781] Starting subtest: suspend-resume
[547.581255] Subtest suspend-resume: SKIP (0.000s)
[547.699949] 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.