[61.166165] Initializing watchdogs
[61.166208]   /dev/watchdog0
[61.179620] [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]
[61.184242] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[61.186563] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[61.190245] [001/132] (960s left) kms_flip (flip-vs-expired-vblank)
[61.319999] Starting subtest: flip-vs-expired-vblank
[61.322270] Starting dynamic subtest: A-eDP1
[69.993171] Dynamic subtest A-eDP1: SUCCESS (8.712s)
[70.004021] Starting dynamic subtest: B-eDP1
[78.694379] Dynamic subtest B-eDP1: SUCCESS (8.711s)
[78.704401] Starting dynamic subtest: C-eDP1
[87.392935] Dynamic subtest C-eDP1: SUCCESS (8.694s)
[87.405295] Starting dynamic subtest: D-eDP1
[96.028503] Dynamic subtest D-eDP1: SUCCESS (8.634s)
[96.030858] Subtest flip-vs-expired-vblank: SUCCESS (34.758s)
[97.219415] [002/132] (924s left) gem_exec_whisper (basic-contexts-forked)
[97.312190] Starting subtest: basic-contexts-forked
[122.359774] Subtest basic-contexts-forked: SUCCESS (25.041s)
[122.575558] [003/132] (899s left) kms_big_fb (4-tiled-16bpp-rotate-0)
[122.692924] Starting subtest: 4-tiled-16bpp-rotate-0
[124.058776] Subtest 4-tiled-16bpp-rotate-0: SUCCESS (1.367s)
[124.214156] [004/132] (897s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0)
[124.317395] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0
[125.351893] Subtest x-tiled-max-hw-stride-32bpp-rotate-0: SUCCESS (1.034s)
[125.517503] [005/132] (896s left) syncobj_timeline (etime-multi-wait-for-submit-submitted)
[125.569228] Starting subtest: etime-multi-wait-for-submit-submitted
[125.675609] Subtest etime-multi-wait-for-submit-submitted: SUCCESS (0.105s)
[125.768565] [006/132] (896s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-onoff)
[125.874462] Starting subtest: fbc-2p-primscrn-cur-indfb-onoff
[125.878554] Subtest fbc-2p-primscrn-cur-indfb-onoff: SKIP (0.000s)
[125.993272] [007/132] (895s left) syncobj_timeline (multi-wait-all-for-submit-signaled)
[126.068773] Starting subtest: multi-wait-all-for-submit-signaled
[126.070693] Subtest multi-wait-all-for-submit-signaled: SUCCESS (0.001s)
[126.199858] [008/132] (895s left) core_setmaster (master-drop-set-user)
[126.298872] Starting subtest: master-drop-set-user
[126.312899] Subtest master-drop-set-user: SUCCESS (0.014s)
[126.351793] [009/132] (895s left) kms_pm_rpm (system-suspend-idle)
[128.068428] Starting subtest: system-suspend-idle
[148.259029] Subtest system-suspend-idle: SUCCESS (8.098s)
[148.629810] [010/132] (873s left) gem_exec_schedule (pi-ringfull)
[148.836454] Starting subtest: pi-ringfull
[148.838366] Starting dynamic subtest: rcs0
[148.935226] Dynamic subtest rcs0: SUCCESS (0.104s)
[148.952120] Starting dynamic subtest: bcs0
[148.964131] Dynamic subtest bcs0: SUCCESS (0.030s)
[148.978134] Starting dynamic subtest: vcs0
[148.997458] Dynamic subtest vcs0: SUCCESS (0.031s)
[149.011313] Starting dynamic subtest: vcs1
[149.021535] Dynamic subtest vcs1: SUCCESS (0.028s)
[149.033942] Starting dynamic subtest: vecs0
[149.049685] Dynamic subtest vecs0: SUCCESS (0.029s)
[149.062805] Starting dynamic subtest: ccs0
[149.075521] Dynamic subtest ccs0: SUCCESS (0.027s)
[149.077649] Subtest pi-ringfull: SUCCESS (0.250s)
[149.331613] [FACT gem_exec_schedule (pi-ringfull)] new: kernel.kmod_is_loaded.vgem: true
[149.334535] [011/132] (872s left) kms_flip (bo-too-big-interruptible)
[149.426571] Starting subtest: bo-too-big-interruptible
[149.428698] Starting dynamic subtest: A-eDP1
[150.688085] Dynamic subtest A-eDP1: SUCCESS (1.299s)
[150.703185] Starting dynamic subtest: B-eDP1
[151.988647] Dynamic subtest B-eDP1: SUCCESS (1.332s)
[151.999770] Starting dynamic subtest: C-eDP1
[153.299355] Dynamic subtest C-eDP1: SUCCESS (1.339s)
[153.309869] Starting dynamic subtest: D-eDP1
[154.523301] Dynamic subtest D-eDP1: SUCCESS (1.245s)
[154.528212] Subtest bo-too-big-interruptible: SUCCESS (5.226s)
[155.736604] [012/132] (866s left) gem_pread (exhaustion)
[155.798113] Subtest exhaustion: SKIP (0.000s)
[155.862892] [013/132] (866s left) kms_plane_scaling (2x-scaler-multi-pipe)
[155.958781] Starting subtest: 2x-scaler-multi-pipe
[155.963157] Subtest 2x-scaler-multi-pipe: SKIP (0.001s)
[156.083979] [014/132] (866s left) api_intel_bb (blit-reloc-purge-cache)
[156.137483] Starting subtest: blit-reloc-purge-cache
[156.141522] Subtest blit-reloc-purge-cache: SKIP (0.001s)
[156.299459] [015/132] (865s left) syncobj_timeline (single-wait-all-available-submitted)
[156.353588] Starting subtest: single-wait-all-available-submitted
[156.355516] Subtest single-wait-all-available-submitted: SUCCESS (0.000s)
[156.493679] [016/132] (865s left) kms_psr2_sf (psr2-cursor-plane-move-continuous-sf)
[161.445395] Starting subtest: psr2-cursor-plane-move-continuous-sf
[161.447688] Starting dynamic subtest: pipe-A-eDP-1
[172.484489] Dynamic subtest pipe-A-eDP-1: SUCCESS (11.079s)
[172.494964] Starting dynamic subtest: pipe-B-eDP-1
[183.509552] Dynamic subtest pipe-B-eDP-1: SUCCESS (11.027s)
[183.511996] Subtest psr2-cursor-plane-move-continuous-sf: SUCCESS (22.109s)
[184.334003] [017/132] (837s left) kms_cursor_legacy (2x-long-flip-vs-cursor-atomic)
[184.465212] Starting subtest: 2x-long-flip-vs-cursor-atomic
[184.469873] Subtest 2x-long-flip-vs-cursor-atomic: SKIP (0.001s)
[184.631482] [018/132] (837s left) kms_flip (2x-plain-flip-ts-check-interruptible)
[184.716835] Starting subtest: 2x-plain-flip-ts-check-interruptible
[184.727329] Subtest 2x-plain-flip-ts-check-interruptible: SKIP (0.010s)
[184.859513] [019/132] (837s left) gem_exec_nop (basic-sequential)
[184.932683] Starting subtest: basic-sequential
[199.587351] Subtest basic-sequential: SUCCESS (14.664s)
[199.837519] [020/132] (822s left) gem_fence_thrash (bo-write-verify-threaded-none)
[199.873978] Starting subtest: bo-write-verify-threaded-none
[199.899951] Subtest bo-write-verify-threaded-none: SKIP (0.024s)
[199.985947] [021/132] (822s left) prime_mmap_kms (buffer-sharing)
[200.079983] Starting subtest: buffer-sharing
[200.507737] Subtest buffer-sharing: SUCCESS (0.425s)
[201.357429] [022/132] (821s left) gem_userptr_blits (stress-mm)
[201.422982] Starting subtest: stress-mm
[206.789818] Subtest stress-mm: SUCCESS (5.369s)
[206.962368] [023/132] (815s left) kms_pm_backlight (fade)
[207.070910] Starting subtest: fade
[207.149389] Starting dynamic subtest: eDP-1
[209.839660] Dynamic subtest eDP-1: SUCCESS (2.691s)
[209.841597] Subtest fade: SUCCESS (2.768s)
[210.678549] [024/132] (811s left) gem_exec_params (rs-invalid)
[210.754038] Starting subtest: rs-invalid
[210.759096] Subtest rs-invalid: SUCCESS (0.003s)
[210.911435] [025/132] (811s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-shrfb-msflip-blt)
[211.007331] Starting subtest: fbcpsr-2p-scndscrn-shrfb-msflip-blt
[211.011305] Subtest fbcpsr-2p-scndscrn-shrfb-msflip-blt: SKIP (0.000s)
[211.157595] [026/132] (811s left) gem_fence_thrash (bo-write-verify-none)
[211.193290] Starting subtest: bo-write-verify-none
[211.218621] Subtest bo-write-verify-none: SKIP (0.025s)
[211.287159] [027/132] (811s left) gem_workarounds (suspend-resume-context)
[211.371044] Starting subtest: suspend-resume-context
[228.020074] Subtest suspend-resume-context: SUCCESS (1.189s)
[229.187935] [028/132] (794s left) syncobj_wait (wait-all-delayed-signal)
[229.256483] Starting subtest: wait-all-delayed-signal
[229.357856] Subtest wait-all-delayed-signal: SUCCESS (0.107s)
[229.451163] [029/132] (794s left) gem_softpin (evict-active-interruptible)
[229.509016] Starting subtest: evict-active-interruptible
[229.515797] Subtest evict-active-interruptible: SUCCESS (0.007s)
[229.677140] [030/132] (794s left) i915_query (query-regions-garbage-items)
[229.739013] Starting subtest: query-regions-garbage-items
[229.741939] Subtest query-regions-garbage-items: SUCCESS (0.000s)
[229.852242] [031/132] (794s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24)
[229.940818] Starting subtest: compare-crc-sanitycheck-xr24
[229.943402] Starting dynamic subtest: pipe-A-eDP-1
[230.527788] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.611s)
[230.541459] Starting dynamic subtest: pipe-B-eDP-1
[231.722899] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.238s)
[231.733348] Starting dynamic subtest: pipe-C-eDP-1
[232.897972] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.210s)
[232.906728] Starting dynamic subtest: pipe-D-eDP-1
[234.085177] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.212s)
[234.087665] Subtest compare-crc-sanitycheck-xr24: SUCCESS (4.275s)
[234.930947] [032/132] (789s left) kms_psr (fbc-psr2-primary-mmap-gtt)
[235.036852] Starting subtest: fbc-psr2-primary-mmap-gtt
[235.038948] Starting dynamic subtest: eDP-1
[235.043808] Dynamic subtest eDP-1: SKIP (0.000s)
[235.048437] Subtest fbc-psr2-primary-mmap-gtt: SKIP (0.001s)
[235.129612] [033/132] (788s left) gem_ctx_exec (basic-nohangcheck)
[235.191008] Starting subtest: basic-nohangcheck
[235.451082] Subtest basic-nohangcheck: SUCCESS (0.266s)
[235.570603] [034/132] (788s left) gem_render_copy (x-tiled-to-vebox-yf-tiled)
[235.633693] Starting subtest: x-tiled-to-vebox-yf-tiled
[235.639082] Subtest x-tiled-to-vebox-yf-tiled: SKIP (0.000s)
[235.840140] [035/132] (788s left) i915_drm_fdinfo (virtual-busy)
[235.883509] Starting subtest: virtual-busy
[235.888906] Subtest virtual-busy: SKIP (0.000s)
[235.967083] [036/132] (788s left) prime_vgem (busy)
[236.036070] Starting subtest: busy
[236.038727] Starting dynamic subtest: rcs0
[236.090037] Dynamic subtest rcs0: SUCCESS (0.055s)
[236.098883] Starting dynamic subtest: bcs0
[236.167522] Dynamic subtest bcs0: SUCCESS (0.079s)
[236.175749] Starting dynamic subtest: vcs0
[236.214940] Dynamic subtest vcs0: SUCCESS (0.048s)
[236.223907] Starting dynamic subtest: vcs1
[236.261491] Dynamic subtest vcs1: SUCCESS (0.047s)
[236.269782] Starting dynamic subtest: vecs0
[236.307013] Dynamic subtest vecs0: SUCCESS (0.046s)
[236.315063] Starting dynamic subtest: ccs0
[236.353966] Dynamic subtest ccs0: SUCCESS (0.047s)
[236.356580] Subtest busy: SUCCESS (0.324s)
[236.511599] [037/132] (787s left) kms_big_fb (linear-16bpp-rotate-180)
[236.613248] Starting subtest: linear-16bpp-rotate-180
[237.957852] Subtest linear-16bpp-rotate-180: SUCCESS (1.366s)
[238.109349] [038/132] (786s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-16bpp-ytile-downscaling)
[238.202063] Starting subtest: flip-64bpp-ytile-to-16bpp-ytile-downscaling
[238.204326] Starting dynamic subtest: pipe-A-default-mode
[238.487745] Dynamic subtest pipe-A-default-mode: SKIP (0.285s)
[238.493290] Subtest flip-64bpp-ytile-to-16bpp-ytile-downscaling: SKIP (0.286s)
[239.310974] [039/132] (784s left) kms_ccs (bad-rotation-90-4-tiled-mtl-rc-ccs-cc)
[239.411147] Starting subtest: bad-rotation-90-4-tiled-mtl-rc-ccs-cc
[239.413943] Starting dynamic subtest: pipe-A-eDP-1
[239.555855] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.136s)
[239.566959] Starting dynamic subtest: pipe-B-eDP-1
[239.589537] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.009s)
[239.598585] Starting dynamic subtest: pipe-C-eDP-1
[239.619963] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.011s)
[239.628577] Starting dynamic subtest: pipe-D-eDP-1
[239.650955] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.011s)
[239.653142] Subtest bad-rotation-90-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.171s)
[241.834751] [040/132] (782s left) gem_softpin (evict-prime)
[241.900798] Starting subtest: evict-prime
[241.903519] Starting dynamic subtest: rcs0
[243.066129] Dynamic subtest rcs0: SUCCESS (1.174s)
[243.075681] Starting dynamic subtest: bcs0
[244.204924] Dynamic subtest bcs0: SUCCESS (1.145s)
[244.216146] Starting dynamic subtest: vcs0
[245.506003] Dynamic subtest vcs0: SUCCESS (1.306s)
[245.517511] Starting dynamic subtest: vcs1
[247.527260] Dynamic subtest vcs1: SUCCESS (2.029s)
[247.538834] Starting dynamic subtest: vecs0
[249.553127] Dynamic subtest vecs0: SUCCESS (2.031s)
[249.565127] Starting dynamic subtest: ccs0
[250.706707] Dynamic subtest ccs0: SUCCESS (1.155s)
[250.719113] Starting dynamic subtest: all
[252.576202] Dynamic subtest all: SUCCESS (1.872s)
[252.579121] Subtest evict-prime: SUCCESS (10.726s)
[252.679842] [041/132] (771s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-mmap-cpu)
[252.786661] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-mmap-cpu
[259.424158] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-mmap-cpu: SUCCESS (6.653s)
[259.593539] [042/132] (764s left) kms_plane_alpha_blend (alpha-opaque-fb)
[259.684937] Starting subtest: alpha-opaque-fb
[259.964043] Starting dynamic subtest: pipe-A-eDP-1
[260.593062] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.630s)
[260.603857] Starting dynamic subtest: pipe-D-eDP-1
[261.900823] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.304s)
[261.903430] Subtest alpha-opaque-fb: SUCCESS (2.218s)
[262.769254] [043/132] (761s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-mmap-gtt)
[262.884969] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-mmap-gtt
[262.890043] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[262.992733] [044/132] (761s left) kms_ccs (random-ccs-data-4-tiled-dg2-rc-ccs-cc)
[263.096604] Starting subtest: random-ccs-data-4-tiled-dg2-rc-ccs-cc
[263.098898] Starting dynamic subtest: pipe-A-eDP-1
[263.123924] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[263.133371] Starting dynamic subtest: pipe-B-eDP-1
[263.162350] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[263.170716] Starting dynamic subtest: pipe-C-eDP-1
[263.198756] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[263.207406] Starting dynamic subtest: pipe-D-eDP-1
[263.236024] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[263.240934] Subtest random-ccs-data-4-tiled-dg2-rc-ccs-cc: SKIP (0.004s)
[265.414889] [045/132] (759s left) perf_pmu (busy-accuracy-2)
[265.461935] Starting subtest: busy-accuracy-2
[265.464456] Starting dynamic subtest: rcs0
[268.507026] Dynamic subtest rcs0: SUCCESS (3.040s)
[268.518430] Starting dynamic subtest: bcs0
[271.566126] Dynamic subtest bcs0: SUCCESS (3.054s)
[271.577217] Starting dynamic subtest: vcs0
[274.616420] Dynamic subtest vcs0: SUCCESS (3.046s)
[274.628001] Starting dynamic subtest: vcs1
[277.664084] Dynamic subtest vcs1: SUCCESS (3.045s)
[277.675702] Starting dynamic subtest: vecs0
[280.713180] Dynamic subtest vecs0: SUCCESS (3.047s)
[280.723150] Starting dynamic subtest: ccs0
[283.768929] Dynamic subtest ccs0: SUCCESS (3.054s)
[283.771627] Subtest busy-accuracy-2: SUCCESS (18.300s)
[283.912384] [046/132] (740s left) syncobj_wait (invalid-multi-wait-unsubmitted-submitted)
[283.975484] Starting subtest: invalid-multi-wait-unsubmitted-submitted
[283.978025] Subtest invalid-multi-wait-unsubmitted-submitted: SUCCESS (0.000s)
[284.108393] [047/132] (740s left) kms_content_protection (srm)
[284.260753] Starting subtest: srm
[284.265787] Subtest srm: SKIP (0.003s)
[284.402449] [048/132] (740s left) kms_ccs (ccs-on-another-bo-y-tiled-gen12-rc-ccs-cc)
[284.486666] Starting subtest: ccs-on-another-bo-y-tiled-gen12-rc-ccs-cc
[284.489295] Starting dynamic subtest: pipe-A-eDP-1
[284.515797] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[284.525657] Starting dynamic subtest: pipe-B-eDP-1
[284.551009] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[284.559156] Starting dynamic subtest: pipe-C-eDP-1
[284.584903] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[284.593120] Starting dynamic subtest: pipe-D-eDP-1
[284.619597] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[284.624771] Subtest ccs-on-another-bo-y-tiled-gen12-rc-ccs-cc: SKIP (0.004s)
[286.712537] [049/132] (737s left) kms_frontbuffer_tracking (psr-rgb565-draw-mmap-gtt)
[286.813478] Starting subtest: psr-rgb565-draw-mmap-gtt
[286.818947] Subtest psr-rgb565-draw-mmap-gtt: SKIP (0.000s)
[286.971599] [050/132] (737s left) kms_cursor_crc (cursor-onscreen-32x10)
[287.139979] Starting subtest: cursor-onscreen-32x10
[287.184717] Subtest cursor-onscreen-32x10: SKIP (0.038s)
[287.505947] [051/132] (737s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-onoff)
[287.611780] Starting subtest: psr-1p-primscrn-cur-indfb-onoff
[294.534314] Subtest psr-1p-primscrn-cur-indfb-onoff: SUCCESS (6.924s)
[294.688574] [052/132] (730s left) gem_ctx_bad_destroy (double-destroy)
[294.744538] Starting subtest: double-destroy
[294.747188] Subtest double-destroy: SUCCESS (0.000s)
[294.843864] [053/132] (730s left) gem_lmem_swapping (basic)
[294.883572] Subtest basic: SKIP (0.000s)
[294.926213] [054/132] (729s left) gen9_exec_parse (bb-start-cmd)
[294.980208] Subtest bb-start-cmd: SKIP (0.000s)
[295.062761] [055/132] (729s left) sw_sync (sync_multi_timeline_wait)
[295.099409] Starting subtest: sync_multi_timeline_wait
[295.102080] Subtest sync_multi_timeline_wait: SUCCESS (0.000s)
[295.178718] [056/132] (729s left) i915_pm_rc6_residency (rc6-accuracy)
[295.238952] Starting subtest: rc6-accuracy
[295.241449] Starting dynamic subtest: gt0
[298.409394] Dynamic subtest gt0: SUCCESS (3.169s)
[298.421118] Starting dynamic subtest: gt1
[301.580969] Dynamic subtest gt1: SUCCESS (3.169s)
[301.584006] Subtest rc6-accuracy: SUCCESS (6.343s)
[301.679565] [057/132] (723s left) api_intel_bb (simple-bb-ctx)
[301.752398] Starting subtest: simple-bb-ctx
[301.767142] Subtest simple-bb-ctx: SUCCESS (0.017s)
[301.905419] [058/132] (723s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-indfb-pgflip-blt)
[302.011767] Starting subtest: fbcpsr-2p-primscrn-indfb-pgflip-blt
[302.016965] Subtest fbcpsr-2p-primscrn-indfb-pgflip-blt: SKIP (0.000s)
[302.145457] [059/132] (722s left) kms_vblank (crtc-id)
[302.248969] Starting subtest: crtc-id
[302.251393] Starting dynamic subtest: pipe-A-eDP-1
[302.704408] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.457s)
[302.720408] Starting dynamic subtest: pipe-D-eDP-1
[303.829584] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.123s)
[303.832170] Subtest crtc-id: SUCCESS (1.584s)
[304.694302] [060/132] (720s left) gem_basic (bad-close)
[304.755007] Starting subtest: bad-close
[304.760035] Subtest bad-close: SUCCESS (0.000s)
[304.879014] [061/132] (720s left) kms_flip (dpms-vs-vblank-race-interruptible)
[304.979015] Starting subtest: dpms-vs-vblank-race-interruptible
[304.981779] Starting dynamic subtest: A-eDP1
[309.958766] Dynamic subtest A-eDP1: SUCCESS (4.980s)
[309.969260] Starting dynamic subtest: B-eDP1
[314.589624] Dynamic subtest B-eDP1: SUCCESS (4.630s)
[314.604162] Starting dynamic subtest: C-eDP1
[319.191073] Dynamic subtest C-eDP1: SUCCESS (4.602s)
[319.201869] Starting dynamic subtest: D-eDP1
[323.805872] Dynamic subtest D-eDP1: SUCCESS (4.615s)
[323.808665] Subtest dpms-vs-vblank-race-interruptible: SUCCESS (18.835s)
[324.724392] [062/132] (700s left) kms_vblank (wait-forked-busy)
[324.818961] Starting subtest: wait-forked-busy
[324.821700] Starting dynamic subtest: pipe-A-eDP-1
[326.700123] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.880s)
[326.716214] Starting dynamic subtest: pipe-D-eDP-1
[329.244324] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.539s)
[329.246978] Subtest wait-forked-busy: SUCCESS (4.426s)
[330.072065] [063/132] (695s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-pwrite)
[330.177167] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-pwrite
[330.182124] Subtest fbc-2p-scndscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[330.304964] [064/132] (695s left) kms_big_fb (4-tiled-64bpp-rotate-180)
[330.414586] Starting subtest: 4-tiled-64bpp-rotate-180
[331.983017] Subtest 4-tiled-64bpp-rotate-180: SUCCESS (1.569s)
[332.176615] [065/132] (693s left) kms_flip (absolute-wf_vblank-interruptible)
[332.289538] Starting subtest: absolute-wf_vblank-interruptible
[332.291731] Starting dynamic subtest: A-eDP1
[341.010436] Dynamic subtest A-eDP1: SUCCESS (8.717s)
[341.022062] Starting dynamic subtest: B-eDP1
[349.746772] Dynamic subtest B-eDP1: SUCCESS (8.734s)
[349.760300] Starting dynamic subtest: C-eDP1
[358.459757] Dynamic subtest C-eDP1: SUCCESS (8.711s)
[358.468950] Starting dynamic subtest: D-eDP1
[367.188986] Dynamic subtest D-eDP1: SUCCESS (8.729s)
[367.191607] Subtest absolute-wf_vblank-interruptible: SUCCESS (34.900s)
[368.423735] [066/132] (656s left) gem_exec_flush (basic-uc-prw-default)
[368.493934] Starting subtest: basic-uc-prw-default
[373.962108] Subtest basic-uc-prw-default: SUCCESS (5.471s)
[374.172434] [067/132] (651s left) vgem_basic (busy-fence)
[374.222195] Starting subtest: busy-fence
[374.225156] Subtest busy-fence: SUCCESS (0.000s)
[374.303863] [068/132] (651s left) kms_frontbuffer_tracking (psr-rgb565-draw-render)
[374.411895] Starting subtest: psr-rgb565-draw-render
[381.364418] Subtest psr-rgb565-draw-render: SUCCESS (6.957s)
[381.518558] [069/132] (644s left) kms_dp_link_training (uhbr-sst)
[381.626154] Starting subtest: uhbr-sst
[381.636828] Subtest uhbr-sst: SKIP (0.000s)
[381.728066] [070/132] (643s left) kms_universal_plane (disable-primary-vs-flip)
[381.819121] Starting subtest: disable-primary-vs-flip
[381.821801] Starting dynamic subtest: pipe-A-eDP-1
[383.370317] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.549s)
[383.381760] Starting dynamic subtest: pipe-B-eDP-1
[385.539018] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.168s)
[385.548418] Starting dynamic subtest: pipe-C-eDP-1
[387.713814] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.174s)
[387.724246] Starting dynamic subtest: pipe-D-eDP-1
[389.959658] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.244s)
[389.962405] Subtest disable-primary-vs-flip: SUCCESS (8.141s)
[390.773501] [071/132] (634s left) gem_exec_balancer (invalid-balancer)
[390.847884] Starting subtest: invalid-balancer
[391.701509] Subtest invalid-balancer: SUCCESS (0.855s)
[392.030667] [072/132] (633s left) gem_mmap_offset (bad-extensions)
[392.082114] Starting subtest: bad-extensions
[392.084969] Subtest bad-extensions: SUCCESS (0.000s)
[392.229351] [073/132] (633s left) kms_atomic_transition (plane-all-transition)
[392.321057] Starting subtest: plane-all-transition
[392.323919] Starting dynamic subtest: pipe-A-eDP-1
[394.813033] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.494s)
[395.116744] Starting dynamic subtest: pipe-B-eDP-1
[398.381010] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.273s)
[398.679533] Subtest plane-all-transition: SUCCESS (6.360s)
[399.529569] [074/132] (626s left) kms_rotation_crc (multiplane-rotation)
[399.631874] Starting subtest: multiplane-rotation
[417.154815] Subtest multiplane-rotation: SUCCESS (17.527s)
[417.315346] [075/132] (608s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip)
[417.419522] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip
[417.423398] Subtest y-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip: SKIP (0.000s)
[417.548821] [076/132] (608s left) kms_psr2_sf (fbc-psr2-primary-plane-update-sf-dmg-area)
[422.558734] Starting subtest: fbc-psr2-primary-plane-update-sf-dmg-area
[422.560848] Starting dynamic subtest: pipe-A-eDP-1
[423.367904] Dynamic subtest pipe-A-eDP-1: SKIP (0.805s)
[423.379840] Starting dynamic subtest: pipe-B-eDP-1
[424.496181] Dynamic subtest pipe-B-eDP-1: SKIP (1.126s)
[424.501137] Subtest fbc-psr2-primary-plane-update-sf-dmg-area: SKIP (1.935s)
[425.698652] [077/132] (600s left) kms_psr (pr-sprite-blt)
[425.793993] Starting subtest: pr-sprite-blt
[425.799203] Subtest pr-sprite-blt: SKIP (0.000s)
[425.888480] [078/132] (600s left) kms_psr (pr-cursor-render)
[425.981299] Starting subtest: pr-cursor-render
[425.986415] Subtest pr-cursor-render: SKIP (0.000s)
[426.077529] [079/132] (599s left) syncobj_wait (single-wait-all-signaled)
[426.127703] Starting subtest: single-wait-all-signaled
[426.130161] Subtest single-wait-all-signaled: SUCCESS (0.000s)
[426.244246] [080/132] (599s left) kms_chamelium_hpd (dp-hpd-storm)
[426.627045] Subtest dp-hpd-storm: SKIP (0.000s)
[427.405218] [081/132] (598s left) gem_mmap_gtt (basic-write-gtt)
[427.475170] Subtest basic-write-gtt: SKIP (0.000s)
[427.547051] [082/132] (598s left) kms_plane_scaling (plane-scaler-with-clipping-clamping-modifiers)
[427.636127] Starting subtest: plane-scaler-with-clipping-clamping-modifiers
[427.638948] Starting dynamic subtest: pipe-A
[428.019949] Dynamic subtest pipe-A: SUCCESS (0.386s)
[428.032173] Starting dynamic subtest: pipe-B
[429.505475] Dynamic subtest pipe-B: SUCCESS (1.483s)
[429.516134] Starting dynamic subtest: pipe-C
[430.951868] Dynamic subtest pipe-C: SUCCESS (1.446s)
[430.960986] Starting dynamic subtest: pipe-D
[432.384607] Dynamic subtest pipe-D: SUCCESS (1.432s)
[432.387165] Subtest plane-scaler-with-clipping-clamping-modifiers: SUCCESS (4.752s)
[433.566833] [083/132] (592s left) gem_exec_schedule (thriceslice)
[433.647971] Starting subtest: thriceslice
[433.650994] Starting dynamic subtest: rcs0
[433.686727] Dynamic subtest rcs0: SUCCESS (0.053s)
[433.699867] Starting dynamic subtest: bcs0
[433.741894] Dynamic subtest bcs0: SUCCESS (0.053s)
[433.754826] Starting dynamic subtest: vcs0
[433.772703] Dynamic subtest vcs0: SUCCESS (0.029s)
[433.781305] Starting dynamic subtest: vcs1
[433.826326] Dynamic subtest vcs1: SUCCESS (0.053s)
[433.834940] Starting dynamic subtest: vecs0
[433.857493] Dynamic subtest vecs0: SUCCESS (0.030s)
[433.872831] Starting dynamic subtest: ccs0
[433.916283] Dynamic subtest ccs0: SUCCESS (0.056s)
[433.918861] Subtest thriceslice: SUCCESS (0.285s)
[435.591224] [084/132] (590s left) gem_exec_fence (nb-await)
[435.766648] Starting subtest: nb-await
[435.768737] Starting dynamic subtest: rcs0
[435.831104] Dynamic subtest rcs0: SUCCESS (0.068s)
[435.843836] Starting dynamic subtest: bcs0
[435.889287] Dynamic subtest bcs0: SUCCESS (0.056s)
[435.899108] Starting dynamic subtest: vcs0
[435.950224] Dynamic subtest vcs0: SUCCESS (0.059s)
[435.961168] Starting dynamic subtest: vcs1
[436.010845] Dynamic subtest vcs1: SUCCESS (0.060s)
[436.020723] Starting dynamic subtest: vecs0
[436.072954] Dynamic subtest vecs0: SUCCESS (0.061s)
[436.085605] Starting dynamic subtest: ccs0
[436.138115] Dynamic subtest ccs0: SUCCESS (0.063s)
[436.140937] Subtest nb-await: SUCCESS (0.376s)
[437.660504] [085/132] (588s left) gem_userptr_blits (set-cache-level)
[437.723917] Starting subtest: set-cache-level
[437.729147] Subtest set-cache-level: SKIP (0.000s)
[437.866348] [086/132] (588s left) gem_ctx_persistence (hang)
[437.924020] Starting subtest: hang
[437.928817] Subtest hang: SKIP (0.000s)
[438.042126] [087/132] (588s left) kms_psr (psr-cursor-mmap-gtt)
[438.130139] Starting subtest: psr-cursor-mmap-gtt
[438.132836] Starting dynamic subtest: eDP-1
[439.845041] Dynamic subtest eDP-1: SUCCESS (1.717s)
[439.848170] Subtest psr-cursor-mmap-gtt: SUCCESS (1.718s)
[440.740062] [088/132] (585s left) gem_eio (in-flight-contexts-immediate)
[440.967751] Starting subtest: in-flight-contexts-immediate
[454.560404] Subtest in-flight-contexts-immediate: SUCCESS (13.593s)
[454.764370] [089/132] (571s left) kms_async_flips (basic-modeset-with-all-modifiers-formats)
[454.871962] Starting subtest: basic-modeset-with-all-modifiers-formats
[455.257427] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-XRGB8888
[456.004591] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-XRGB8888: SUCCESS (0.748s)
[456.014424] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-XRGB2101010
[456.025541] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-XRGB2101010: SUCCESS (0.020s)
[456.034616] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-XRGB16161616F
[456.047868] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-XRGB16161616F: SUCCESS (0.022s)
[456.056733] Starting dynamic subtest: pipe-A-eDP-1-4-RGB565
[456.214712] Dynamic subtest pipe-A-eDP-1-4-RGB565: SUCCESS (0.166s)
[456.232169] Starting dynamic subtest: pipe-A-eDP-1-4-XRGB8888
[456.238804] Dynamic subtest pipe-A-eDP-1-4-XRGB8888: SUCCESS (0.021s)
[456.248701] Starting dynamic subtest: pipe-A-eDP-1-4-XRGB2101010
[456.259202] Dynamic subtest pipe-A-eDP-1-4-XRGB2101010: SUCCESS (0.022s)
[456.268425] Starting dynamic subtest: pipe-A-eDP-1-4-XRGB16161616F
[456.281619] Dynamic subtest pipe-A-eDP-1-4-XRGB16161616F: SUCCESS (0.022s)
[456.290833] Starting dynamic subtest: pipe-A-eDP-1-4-YUYV
[456.303907] Dynamic subtest pipe-A-eDP-1-4-YUYV: SUCCESS (0.021s)
[456.313007] Starting dynamic subtest: pipe-A-eDP-1-4-Y210
[456.325929] Dynamic subtest pipe-A-eDP-1-4-Y210: SUCCESS (0.021s)
[456.337422] Starting dynamic subtest: pipe-A-eDP-1-4-XYUV8888
[456.347985] Dynamic subtest pipe-A-eDP-1-4-XYUV8888: SUCCESS (0.022s)
[456.357038] Starting dynamic subtest: pipe-A-eDP-1-4-XV30
[456.370687] Dynamic subtest pipe-A-eDP-1-4-XV30: SUCCESS (0.022s)
[456.379782] Starting dynamic subtest: pipe-A-eDP-1-4-XV36
[456.392812] Dynamic subtest pipe-A-eDP-1-4-XV36: SUCCESS (0.020s)
[456.404872] Starting dynamic subtest: pipe-A-eDP-1-x-RGB565
[456.559530] Dynamic subtest pipe-A-eDP-1-x-RGB565: SUCCESS (0.166s)
[456.569177] Starting dynamic subtest: pipe-A-eDP-1-x-XRGB8888
[456.581704] Dynamic subtest pipe-A-eDP-1-x-XRGB8888: SUCCESS (0.021s)
[456.590883] Starting dynamic subtest: pipe-A-eDP-1-x-XRGB2101010
[456.603766] Dynamic subtest pipe-A-eDP-1-x-XRGB2101010: SUCCESS (0.021s)
[456.613443] Starting dynamic subtest: pipe-A-eDP-1-x-XRGB16161616F
[456.626120] Dynamic subtest pipe-A-eDP-1-x-XRGB16161616F: SUCCESS (0.022s)
[456.635197] Starting dynamic subtest: pipe-A-eDP-1-x-YUYV
[456.648395] Dynamic subtest pipe-A-eDP-1-x-YUYV: SUCCESS (0.021s)
[456.657620] Starting dynamic subtest: pipe-A-eDP-1-x-Y210
[456.670118] Dynamic subtest pipe-A-eDP-1-x-Y210: SUCCESS (0.021s)
[456.679053] Starting dynamic subtest: pipe-A-eDP-1-x-XYUV8888
[456.692925] Dynamic subtest pipe-A-eDP-1-x-XYUV8888: SUCCESS (0.021s)
[456.701978] Starting dynamic subtest: pipe-A-eDP-1-x-XV30
[456.715151] Dynamic subtest pipe-A-eDP-1-x-XV30: SUCCESS (0.022s)
[456.724185] Starting dynamic subtest: pipe-A-eDP-1-x-XV36
[456.737031] Dynamic subtest pipe-A-eDP-1-x-XV36: SUCCESS (0.021s)
[456.746535] Starting dynamic subtest: pipe-A-eDP-1-linear-RGB565
[456.915385] Dynamic subtest pipe-A-eDP-1-linear-RGB565: SUCCESS (0.178s)
[456.924499] Starting dynamic subtest: pipe-A-eDP-1-linear-XRGB8888
[456.937120] Dynamic subtest pipe-A-eDP-1-linear-XRGB8888: SUCCESS (0.021s)
[456.946193] Starting dynamic subtest: pipe-A-eDP-1-linear-XRGB2101010
[456.959112] Dynamic subtest pipe-A-eDP-1-linear-XRGB2101010: SUCCESS (0.021s)
[456.967884] Starting dynamic subtest: pipe-A-eDP-1-linear-XRGB16161616F
[456.981628] Dynamic subtest pipe-A-eDP-1-linear-XRGB16161616F: SUCCESS (0.022s)
[456.990398] Starting dynamic subtest: pipe-A-eDP-1-linear-YUYV
[457.003713] Dynamic subtest pipe-A-eDP-1-linear-YUYV: SUCCESS (0.020s)
[457.012435] Starting dynamic subtest: pipe-A-eDP-1-linear-Y210
[457.026390] Dynamic subtest pipe-A-eDP-1-linear-Y210: SUCCESS (0.022s)
[457.035025] Starting dynamic subtest: pipe-A-eDP-1-linear-XYUV8888
[457.048646] Dynamic subtest pipe-A-eDP-1-linear-XYUV8888: SUCCESS (0.022s)
[457.057441] Starting dynamic subtest: pipe-A-eDP-1-linear-XV30
[457.070392] Dynamic subtest pipe-A-eDP-1-linear-XV30: SUCCESS (0.021s)
[457.079033] Starting dynamic subtest: pipe-A-eDP-1-linear-XV36
[457.093776] Dynamic subtest pipe-A-eDP-1-linear-XV36: SUCCESS (0.022s)
[457.476798] Subtest basic-modeset-with-all-modifiers-formats: SUCCESS (2.604s)
[458.309175] [090/132] (568s left) kms_color (ctm-max)
[458.403055] Starting subtest: ctm-max
[458.405371] Starting dynamic subtest: pipe-A-eDP-1
[459.159415] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.756s)
[459.168986] Starting dynamic subtest: pipe-B-eDP-1
[460.590950] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.432s)
[460.600002] Starting dynamic subtest: pipe-C-eDP-1
[461.979291] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.387s)
[461.991151] Starting dynamic subtest: pipe-D-eDP-1
[463.298971] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.318s)
[463.301935] Subtest ctm-max: SUCCESS (4.896s)
[464.135855] [091/132] (562s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-mmap-wc)
[464.248293] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-mmap-wc
[468.513153] Subtest fbc-1p-primscrn-pri-shrfb-draw-mmap-wc: SUCCESS (4.270s)
[469.746507] [092/132] (556s left) gem_render_copy (linear)
[469.831171] Starting subtest: linear
[469.833670] Starting dynamic subtest: smem
[469.873140] Dynamic subtest smem: SUCCESS (0.044s)
[469.875929] Subtest linear: SUCCESS (0.045s)
[470.139836] [093/132] (556s left) gem_userptr_blits (access-control)
[470.216402] Starting subtest: access-control
[470.222021] Subtest access-control: SKIP (0.000s)
[470.377978] [094/132] (556s left) kms_flip (2x-nonexisting-fb)
[470.470891] Starting subtest: 2x-nonexisting-fb
[470.481842] Subtest 2x-nonexisting-fb: SKIP (0.010s)
[470.588638] [095/132] (556s left) gem_ccs (block-copy-compressed)
[470.653601] Starting subtest: block-copy-compressed
[470.658565] Subtest block-copy-compressed: SKIP (0.000s)
[470.773365] [096/132] (555s left) prime_mmap (test_invalid_sync_flags)
[470.837942] Starting subtest: test_invalid_sync_flags
[470.840639] Starting dynamic subtest: test_invalid_sync_flags-smem
[470.842969] Dynamic subtest test_invalid_sync_flags-smem: SUCCESS (0.000s)
[470.845498] Subtest test_invalid_sync_flags: SUCCESS (0.001s)
[470.960759] [097/132] (555s left) gem_exec_params (invalid-bsd-ring)
[471.013858] Starting subtest: invalid-bsd-ring
[471.015888] Subtest invalid-bsd-ring: SUCCESS (0.000s)
[471.142320] [098/132] (555s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-blt)
[471.229688] Starting subtest: psr-1p-primscrn-spr-indfb-draw-blt
[477.951553] Subtest psr-1p-primscrn-spr-indfb-draw-blt: SUCCESS (6.722s)
[478.099535] [099/132] (548s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-blt)
[478.188981] Starting subtest: psr-2p-primscrn-spr-indfb-draw-blt
[478.194130] Subtest psr-2p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[478.316698] [100/132] (548s left) kms_plane (planar-pixel-format-settings)
[478.408492] Starting subtest: planar-pixel-format-settings
[478.447866] Subtest planar-pixel-format-settings: SUCCESS (0.041s)
[478.572625] [101/132] (548s left) syncobj_timeline (wait-for-submit-delayed-submit)
[478.623989] Starting subtest: wait-for-submit-delayed-submit
[478.726019] Subtest wait-for-submit-delayed-submit: SUCCESS (0.103s)
[478.832848] [102/132] (548s left) kms_cursor_crc (cursor-rapid-movement-max-size)
[479.154836] Starting subtest: cursor-rapid-movement-max-size
[479.162778] Subtest cursor-rapid-movement-max-size: SKIP (0.000s)
[479.308977] [103/132] (547s left) kms_cursor_legacy (modeset-atomic-cursor-hotspot)
[479.425860] Starting subtest: modeset-atomic-cursor-hotspot
[479.430444] Subtest modeset-atomic-cursor-hotspot: SKIP (0.000s)
[479.591876] [104/132] (547s left) gem_exec_balancer (parallel-keep-submit-fence)
[479.848007] Starting subtest: parallel-keep-submit-fence
[481.227830] Subtest parallel-keep-submit-fence: SUCCESS (1.382s)
[481.381661] [105/132] (545s left) kms_chamelium_frames (hdmi-crc-nonplanar-formats)
[481.758588] Subtest hdmi-crc-nonplanar-formats: SKIP (0.000s)
[482.566473] [106/132] (544s left) kms_getfb (getfb-addfb-different-handles)
[482.666332] Starting subtest: getfb-addfb-different-handles
[482.668767] Subtest getfb-addfb-different-handles: SUCCESS (0.000s)
[482.792237] [107/132] (544s left) gem_ctx_sseu (invalid-args)
[482.859740] Subtest invalid-args: SKIP (0.000s)
[482.941463] [108/132] (544s left) gem_lmem_swapping (parallel-random-verify)
[482.979982] Subtest parallel-random-verify: SKIP (0.000s)
[483.023737] [109/132] (544s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-move)
[483.120169] Starting subtest: psr-2p-primscrn-spr-indfb-move
[483.124970] Subtest psr-2p-primscrn-spr-indfb-move: SKIP (0.000s)
[483.244778] [110/132] (544s left) gem_exec_reloc (basic-write-cpu-noreloc)
[483.309190] Subtest basic-write-cpu-noreloc: SKIP (0.000s)
[483.399582] [111/132] (543s left) syncobj_timeline (invalid-multi-wait-unsubmitted-signaled)
[483.453001] Starting subtest: invalid-multi-wait-unsubmitted-signaled
[483.455521] Subtest invalid-multi-wait-unsubmitted-signaled: SUCCESS (0.000s)
[483.581313] [112/132] (543s left) i915_hangman (gt-engine-hang)
[483.657689] Starting subtest: gt-engine-hang
[483.659613] Starting dynamic subtest: rcs0
[485.477190] Dynamic subtest rcs0: SUCCESS (1.819s)
[485.490860] Starting dynamic subtest: bcs0
[487.461054] Dynamic subtest bcs0: SUCCESS (1.981s)
[487.474135] Starting dynamic subtest: vcs0
[488.486076] Dynamic subtest vcs0: SUCCESS (1.020s)
[488.496887] Starting dynamic subtest: vcs1
[490.533461] Dynamic subtest vcs1: SUCCESS (2.046s)
[490.545859] Starting dynamic subtest: vecs0
[492.452039] Dynamic subtest vecs0: SUCCESS (1.916s)
[492.465125] Starting dynamic subtest: ccs0
[494.501409] Dynamic subtest ccs0: SUCCESS (2.046s)
[494.504625] Subtest gt-engine-hang: SUCCESS (10.844s)
[494.612349] [113/132] (532s left) gem_mmap (bad-object)
[494.670151] Subtest bad-object: SKIP (0.000s)
[494.739022] [114/132] (532s left) kms_feature_discovery (psr1)
[494.827181] Starting subtest: psr1
[494.829996] Subtest psr1: SUCCESS (0.000s)
[494.927150] [115/132] (532s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-blt)
[495.029723] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-blt
[502.054721] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-blt: SUCCESS (7.027s)
[502.245027] [116/132] (525s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu)
[502.344007] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu
[502.348947] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[502.479751] [117/132] (525s left) gem_mmap_gtt (fault-concurrent)
[502.534000] Subtest fault-concurrent: SKIP (0.000s)
[502.602081] [118/132] (525s left) kms_pm_rpm (legacy-planes-dpms)
[504.625147] Starting subtest: legacy-planes-dpms
[504.628005] Starting dynamic subtest: plane-63
[512.921454] Dynamic subtest plane-63: SUCCESS (8.295s)
[512.933744] Starting dynamic subtest: plane-93
[521.223418] Dynamic subtest plane-93: SUCCESS (8.299s)
[521.235970] Starting dynamic subtest: plane-123
[529.790837] Dynamic subtest plane-123: SUCCESS (8.565s)
[529.801857] Starting dynamic subtest: plane-133
[538.404970] Dynamic subtest plane-133: SUCCESS (8.611s)
[538.408130] Subtest legacy-planes-dpms: SUCCESS (33.781s)
[538.807938] [119/132] (488s left) kms_chamelium_color (ctm-negative)
[538.905731] Subtest ctm-negative: SKIP (0.000s)
[538.950057] [120/132] (488s left) kms_flip_scaled_crc (flip-32bpp-yftileccs-to-64bpp-yftile-upscaling)
[539.049909] Starting subtest: flip-32bpp-yftileccs-to-64bpp-yftile-upscaling
[539.052578] Starting dynamic subtest: pipe-A-default-mode
[539.363137] Dynamic subtest pipe-A-default-mode: SKIP (0.308s)
[539.368814] Subtest flip-32bpp-yftileccs-to-64bpp-yftile-upscaling: SKIP (0.310s)
[540.238219] [121/132] (487s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180)
[540.343184] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180
[541.299954] Subtest x-tiled-max-hw-stride-32bpp-rotate-180: SUCCESS (0.956s)
[541.456903] [122/132] (486s left) kms_ccs (crc-primary-suspend-4-tiled-dg2-rc-ccs-cc)
[541.542117] Starting subtest: crc-primary-suspend-4-tiled-dg2-rc-ccs-cc
[541.544654] Starting dynamic subtest: pipe-A-eDP-1
[541.552812] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[541.562605] Starting dynamic subtest: pipe-B-eDP-1
[541.571080] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[541.580448] Starting dynamic subtest: pipe-C-eDP-1
[541.589561] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[541.598782] Starting dynamic subtest: pipe-D-eDP-1
[541.607423] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[541.611072] Subtest crc-primary-suspend-4-tiled-dg2-rc-ccs-cc: SKIP (0.004s)
[543.723496] [123/132] (484s left) kms_invalid_mode (overflow-vrefresh)
[543.819156] Starting subtest: overflow-vrefresh
[543.821932] Starting dynamic subtest: pipe-A-eDP-1
[544.098982] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.282s)
[544.109201] Starting dynamic subtest: pipe-B-eDP-1
[544.111763] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[544.122183] Starting dynamic subtest: pipe-C-eDP-1
[544.125067] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[544.134705] Starting dynamic subtest: pipe-D-eDP-1
[544.137322] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[544.140178] Subtest overflow-vrefresh: SUCCESS (0.288s)
[544.960917] [124/132] (482s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-0-async-flip)
[545.073217] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-0-async-flip
[545.079005] Subtest y-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SKIP (0.000s)
[545.206070] [125/132] (482s left) kms_psr (fbc-pr-cursor-plane-move)
[545.303880] Starting subtest: fbc-pr-cursor-plane-move
[545.308642] Subtest fbc-pr-cursor-plane-move: SKIP (0.000s)
[545.402414] [126/132] (482s left) prime_busy (before)
[545.478807] Starting subtest: before
[545.485104] Starting dynamic subtest: rcs0
[545.530131] Dynamic subtest rcs0: SUCCESS (0.045s)
[545.541176] Starting dynamic subtest: bcs0
[545.588995] Dynamic subtest bcs0: SUCCESS (0.058s)
[545.599983] Starting dynamic subtest: vcs0
[545.630066] Dynamic subtest vcs0: SUCCESS (0.040s)
[545.639982] Starting dynamic subtest: vcs1
[545.671236] Dynamic subtest vcs1: SUCCESS (0.041s)
[545.681143] Starting dynamic subtest: vecs0
[545.713168] Dynamic subtest vecs0: SUCCESS (0.041s)
[545.722968] Starting dynamic subtest: ccs0
[545.754941] Dynamic subtest ccs0: SUCCESS (0.041s)
[545.862362] Subtest before: SUCCESS (0.383s)
[545.963542] [127/132] (482s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180-async-flip)
[546.058735] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180-async-flip
[546.064022] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SKIP (0.000s)
[546.195273] [128/132] (481s left) kms_hdr (invalid-metadata-sizes)
[546.295003] Starting subtest: invalid-metadata-sizes
[546.303164] Subtest invalid-metadata-sizes: SKIP (0.000s)
[546.395385] [129/132] (481s left) gem_render_copy (y-tiled-ccs-to-yf-tiled)
[546.454136] Starting subtest: y-tiled-ccs-to-yf-tiled
[546.459761] Subtest y-tiled-ccs-to-yf-tiled: SKIP (0.000s)
[546.660621] [130/132] (481s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-pwrite)
[546.764073] Starting subtest: fbcpsr-rgb101010-draw-pwrite
[553.705668] Subtest fbcpsr-rgb101010-draw-pwrite: SUCCESS (6.946s)
[553.844427] [131/132] (474s left) gem_userptr_blits (unsync-unmap)
[553.925726] Subtest unsync-unmap: SKIP (0.000s)
[554.086080] [132/132] (474s left) gem_ccs (suspend-resume)
[554.139642] Starting subtest: suspend-resume
[554.144675] Subtest suspend-resume: SKIP (0.000s)
[554.273975] 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.