[67.582646] Initializing watchdogs
[67.582753]   /dev/watchdog0
[67.622008] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:03:00.0: 8086:4905 Intel Dg1 (Gen12) DG1 [Iris Xe MAX Graphics]
[67.654051] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[67.663838] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[67.667525] [001/132] (960s left) gem_mmap_gtt (hang-busy)
[67.754347] Subtest hang-busy: SKIP (0.000s)
[67.864634] [002/132] (960s left) kms_pm_rpm (basic-pci-d3-state)
[72.050118] Starting subtest: basic-pci-d3-state
[73.286430] Subtest basic-pci-d3-state: SUCCESS (1.239s)
[74.110816] [003/132] (954s left) kms_draw_crc (draw-method-render)
[75.595305] Starting subtest: draw-method-render
[75.596167] Starting dynamic subtest: xrgb8888-untiled
[76.035213] Dynamic subtest xrgb8888-untiled: SUCCESS (0.439s)
[76.069617] Starting dynamic subtest: rgb565-untiled
[76.401990] Dynamic subtest rgb565-untiled: SUCCESS (0.365s)
[76.427655] Starting dynamic subtest: xrgb2101010-untiled
[76.735158] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.332s)
[76.769612] Starting dynamic subtest: xbgr16161616f-untiled
[77.118663] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.382s)
[77.131231] Starting dynamic subtest: xrgb8888-xtiled
[77.285043] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.165s)
[77.319546] Starting dynamic subtest: rgb565-xtiled
[77.484897] Dynamic subtest rgb565-xtiled: SUCCESS (0.198s)
[77.511557] Starting dynamic subtest: xrgb2101010-xtiled
[77.651500] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.165s)
[77.685117] Starting dynamic subtest: xbgr16161616f-xtiled
[77.851368] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.199s)
[77.863114] Starting dynamic subtest: xrgb8888-ytiled
[78.018219] Dynamic subtest xrgb8888-ytiled: SUCCESS (0.165s)
[78.050931] Starting dynamic subtest: rgb565-ytiled
[78.218113] Dynamic subtest rgb565-ytiled: SUCCESS (0.198s)
[78.229955] Starting dynamic subtest: xrgb2101010-ytiled
[78.368263] Dynamic subtest xrgb2101010-ytiled: SUCCESS (0.148s)
[78.401405] Starting dynamic subtest: xbgr16161616f-ytiled
[78.568144] Dynamic subtest xbgr16161616f-ytiled: SUCCESS (0.198s)
[78.570352] Subtest draw-method-render: SUCCESS (2.973s)
[78.799434] [004/132] (949s left) kms_ccs (random-ccs-data-4-tiled-mtl-rc-ccs-cc)
[80.284265] Starting subtest: random-ccs-data-4-tiled-mtl-rc-ccs-cc
[80.285125] Starting dynamic subtest: pipe-A-HDMI-A-3
[80.294973] Dynamic subtest pipe-A-HDMI-A-3: SKIP (0.000s)
[80.302510] Starting dynamic subtest: pipe-B-HDMI-A-3
[80.313600] Dynamic subtest pipe-B-HDMI-A-3: SKIP (0.000s)
[80.320928] Starting dynamic subtest: pipe-C-HDMI-A-3
[80.329173] Dynamic subtest pipe-C-HDMI-A-3: SKIP (0.000s)
[80.336286] Starting dynamic subtest: pipe-D-HDMI-A-3
[80.344960] Dynamic subtest pipe-D-HDMI-A-3: SKIP (0.000s)
[80.346511] Subtest random-ccs-data-4-tiled-mtl-rc-ccs-cc: SKIP (0.006s)
[80.591322] [005/132] (947s left) kms_cursor_legacy (short-flip-before-cursor-toggle)
[82.075457] Starting subtest: short-flip-before-cursor-toggle
[83.084646] Subtest short-flip-before-cursor-toggle: SUCCESS (1.010s)
[83.294087] [006/132] (945s left) syncobj_timeline (multi-wait-for-submit-available-signaled)
[83.339979] Starting subtest: multi-wait-for-submit-available-signaled
[83.340901] Subtest multi-wait-for-submit-available-signaled: SUCCESS (0.001s)
[83.493625] [007/132] (945s left) core_debugfs (read-all-entries)
[83.535931] Starting subtest: read-all-entries
[83.617249] Subtest read-all-entries: SUCCESS (0.081s)
[83.792974] [008/132] (944s left) syncobj_wait (wait-all-delayed-signal)
[83.836249] Starting subtest: wait-all-delayed-signal
[83.940988] Subtest wait-all-delayed-signal: SUCCESS (0.103s)
[84.127664] [009/132] (944s left) syncobj_wait (single-wait-all-submitted)
[84.170464] Starting subtest: single-wait-all-submitted
[84.282501] Subtest single-wait-all-submitted: SUCCESS (0.108s)
[84.480239] [010/132] (944s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-mmap-wc)
[85.968889] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-mmap-wc
[85.970864] Subtest fbc-2p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[86.214381] [011/132] (942s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-mmap-cpu)
[87.702637] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-mmap-cpu
[87.704328] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[87.931670] [012/132] (941s left) gem_pxp (hw-rejects-pxp-context)
[90.502335] Starting subtest: hw-rejects-pxp-context
[90.503236] Subtest hw-rejects-pxp-context: SUCCESS (0.004s)
[90.672362] [013/132] (938s left) gem_exec_whisper (basic-queues-all)
[90.728823] Starting subtest: basic-queues-all
[97.141428] Subtest basic-queues-all: SUCCESS (6.412s)
[97.466228] [014/132] (931s left) syncobj_timeline (single-wait-all-for-submit-available-submitted)
[97.509318] Starting subtest: single-wait-all-for-submit-available-submitted
[97.510303] Subtest single-wait-all-for-submit-available-submitted: SUCCESS (0.000s)
[97.647125] [015/132] (931s left) kms_plane (plane-position-covered)
[99.128267] Starting subtest: plane-position-covered
[99.603069] Starting dynamic subtest: pipe-A-plane-1
[99.981347] Dynamic subtest pipe-A-plane-1: SUCCESS (0.379s)
[99.989454] Starting dynamic subtest: pipe-A-plane-2
[100.377979] Dynamic subtest pipe-A-plane-2: SUCCESS (0.396s)
[100.385982] Starting dynamic subtest: pipe-A-plane-3
[100.772990] Dynamic subtest pipe-A-plane-3: SUCCESS (0.394s)
[100.781143] Starting dynamic subtest: pipe-A-plane-4
[101.166659] Dynamic subtest pipe-A-plane-4: SUCCESS (0.394s)
[101.174650] Starting dynamic subtest: pipe-A-plane-5
[101.562039] Dynamic subtest pipe-A-plane-5: SUCCESS (0.395s)
[101.570111] Starting dynamic subtest: pipe-A-plane-6
[101.956230] Dynamic subtest pipe-A-plane-6: SUCCESS (0.395s)
[101.964561] Starting dynamic subtest: pipe-A-plane-7
[101.978350] Dynamic subtest pipe-A-plane-7: SUCCESS (0.021s)
[102.266278] Starting dynamic subtest: pipe-B-plane-1
[102.598984] Dynamic subtest pipe-B-plane-1: SUCCESS (0.341s)
[102.607279] Starting dynamic subtest: pipe-B-plane-2
[102.971121] Dynamic subtest pipe-B-plane-2: SUCCESS (0.373s)
[102.979440] Starting dynamic subtest: pipe-B-plane-3
[103.363139] Dynamic subtest pipe-B-plane-3: SUCCESS (0.391s)
[103.371375] Starting dynamic subtest: pipe-B-plane-4
[103.756778] Dynamic subtest pipe-B-plane-4: SUCCESS (0.394s)
[103.765189] Starting dynamic subtest: pipe-B-plane-5
[104.113813] Dynamic subtest pipe-B-plane-5: SUCCESS (0.356s)
[104.122169] Starting dynamic subtest: pipe-B-plane-6
[104.506475] Dynamic subtest pipe-B-plane-6: SUCCESS (0.393s)
[104.514690] Starting dynamic subtest: pipe-B-plane-7
[104.530989] Dynamic subtest pipe-B-plane-7: SUCCESS (0.022s)
[104.532246] Subtest plane-position-covered: SUCCESS (5.402s)
[104.816819] [016/132] (924s left) kms_cursor_crc (cursor-sliding-512x170)
[106.591694] Starting subtest: cursor-sliding-512x170
[106.594657] Subtest cursor-sliding-512x170: SKIP (0.001s)
[106.884926] [017/132] (922s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-blt)
[108.374934] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-blt
[108.379415] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-blt: SKIP (0.000s)
[108.641859] [018/132] (921s left) kms_panel_fitting (atomic-fastset)
[110.124240] Starting subtest: atomic-fastset
[110.126230] Subtest atomic-fastset: SKIP (0.000s)
[110.326745] [019/132] (919s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-render)
[111.815447] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-render
[111.817605] Subtest fbc-2p-primscrn-cur-indfb-draw-render: SKIP (0.000s)
[112.065804] [020/132] (917s left) kms_ccs (crc-sprite-planes-basic-4-tiled-bmg-ccs)
[113.548168] Starting subtest: crc-sprite-planes-basic-4-tiled-bmg-ccs
[113.550154] Subtest crc-sprite-planes-basic-4-tiled-bmg-ccs: SKIP (0.000s)
[113.782283] [021/132] (916s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-render)
[115.271100] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-render
[115.273083] Subtest fbc-2p-scndscrn-spr-indfb-draw-render: SKIP (0.000s)
[115.528145] [022/132] (914s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-move)
[117.040318] Starting subtest: psr-1p-primscrn-cur-indfb-move
[117.042037] Subtest psr-1p-primscrn-cur-indfb-move: SKIP (0.000s)
[117.297898] [023/132] (913s left) kms_vblank (query-forked)
[118.780891] Starting subtest: query-forked
[118.782934] Starting dynamic subtest: pipe-A-HDMI-A-3
[121.185199] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (2.402s)
[121.196477] Starting dynamic subtest: pipe-D-HDMI-A-3
[123.430268] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (2.241s)
[123.431064] Subtest query-forked: SUCCESS (4.650s)
[123.660930] [024/132] (906s left) gem_exec_big (single)
[123.709869] Starting subtest: single
[131.075484] Subtest single: SUCCESS (7.362s)
[131.964484] [025/132] (898s left) i915_drm_fdinfo (virtual-busy-idle)
[132.058611] Starting subtest: virtual-busy-idle
[132.060257] Subtest virtual-busy-idle: SKIP (0.000s)
[132.193179] [026/132] (898s left) kms_plane_scaling (plane-scaler-unity-scaling-with-pixel-format)
[133.678913] Starting subtest: plane-scaler-unity-scaling-with-pixel-format
[133.679891] Starting dynamic subtest: pipe-A
[136.201465] Dynamic subtest pipe-A: SUCCESS (2.522s)
[136.217878] Starting dynamic subtest: pipe-B
[138.858737] Dynamic subtest pipe-B: SUCCESS (2.656s)
[138.877020] Starting dynamic subtest: pipe-C
[139.165630] Dynamic subtest pipe-C: SUCCESS (0.306s)
[139.176279] Starting dynamic subtest: pipe-D
[139.455362] Dynamic subtest pipe-D: SUCCESS (0.289s)
[139.456316] Subtest plane-scaler-unity-scaling-with-pixel-format: SUCCESS (5.777s)
[139.717196] [027/132] (890s left) gem_busy (busy)
[139.776661] Starting subtest: busy
[139.777651] Starting dynamic subtest: all-engines
[139.837496] Dynamic subtest all-engines: SUCCESS (0.060s)
[139.846502] Starting dynamic subtest: rcs0
[139.904859] Dynamic subtest rcs0: SUCCESS (0.067s)
[139.915274] Starting dynamic subtest: bcs0
[139.965981] Dynamic subtest bcs0: SUCCESS (0.060s)
[140.002370] Starting dynamic subtest: vcs0
[140.007939] Dynamic subtest vcs0: SUCCESS (0.040s)
[140.021623] Starting dynamic subtest: vcs1
[140.048238] Dynamic subtest vcs1: SUCCESS (0.039s)
[140.057992] Starting dynamic subtest: vecs0
[140.086341] Dynamic subtest vecs0: SUCCESS (0.038s)
[140.087334] Subtest busy: SUCCESS (0.310s)
[140.559881] [028/132] (890s left) syncobj_timeline (wait-all-delayed-signal)
[140.612210] Starting subtest: wait-all-delayed-signal
[140.717192] Subtest wait-all-delayed-signal: SUCCESS (0.102s)
[140.877549] [029/132] (889s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-mmap-gtt)
[142.366444] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-mmap-gtt
[142.368103] Subtest psr-2p-scndscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[142.609390] [030/132] (888s left) kms_psr (psr-primary-page-flip)
[144.110660] Subtest psr-primary-page-flip: SKIP (0.000s)
[144.269062] [031/132] (886s left) api_intel_allocator (two-level-inception)
[144.313053] Starting subtest: two-level-inception
[149.748389] Subtest two-level-inception: SUCCESS (5.432s)
[149.991952] [032/132] (881s left) i915_drm_fdinfo (most-busy-check-all)
[150.039572] Starting subtest: most-busy-check-all
[150.040455] Starting dynamic subtest: rcs0
[150.057044] Dynamic subtest rcs0: SKIP (0.016s)
[150.066100] Starting dynamic subtest: bcs0
[150.068372] Dynamic subtest bcs0: SKIP (0.001s)
[150.077166] Starting dynamic subtest: vcs0
[150.079042] Dynamic subtest vcs0: SKIP (0.000s)
[150.087921] Starting dynamic subtest: vcs1
[150.090401] Dynamic subtest vcs1: SKIP (0.000s)
[150.098665] Starting dynamic subtest: vecs0
[150.100963] Dynamic subtest vecs0: SKIP (0.000s)
[150.103395] Subtest most-busy-check-all: SKIP (0.022s)
[150.229428] [033/132] (881s left) kms_cursor_legacy (cursorb-vs-flipb-atomic-transitions-varying-size)
[151.791924] Starting subtest: cursorB-vs-flipB-atomic-transitions-varying-size
[151.793917] Subtest cursorB-vs-flipB-atomic-transitions-varying-size: SKIP (0.002s)
[152.025994] [034/132] (879s left) gem_ctx_bad_destroy (invalid-pad)
[152.068167] Starting subtest: invalid-pad
[152.069134] Subtest invalid-pad: SUCCESS (0.000s)
[152.263661] [035/132] (879s left) kms_psr (fbc-psr-cursor-blt)
[153.747864] Subtest fbc-psr-cursor-blt: SKIP (0.000s)
[153.817623] [036/132] (877s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-32bpp-ytileccs-upscaling)
[155.300479] Starting subtest: flip-32bpp-ytile-to-32bpp-ytileccs-upscaling
[155.302357] Starting dynamic subtest: pipe-A-valid-mode
[155.402293] Dynamic subtest pipe-A-valid-mode: SKIP (0.098s)
[155.404959] Subtest flip-32bpp-ytile-to-32bpp-ytileccs-upscaling: SKIP (0.100s)
[155.659519] [037/132] (876s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-mmap-cpu)
[157.147039] Starting subtest: psr-2p-primscrn-cur-indfb-draw-mmap-cpu
[157.148918] Subtest psr-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[157.408528] [038/132] (874s left) gem_exec_schedule (preempt-queue-chain)
[157.484086] Subtest preempt-queue-chain: SKIP (0.000s)
[157.900233] [039/132] (874s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-pwrite)
[159.389341] Starting subtest: psr-2p-primscrn-pri-indfb-draw-pwrite
[159.391324] Subtest psr-2p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[159.631357] [040/132] (872s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-mmap-gtt)
[161.118435] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-mmap-gtt
[161.119939] Subtest fbc-2p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[161.358891] [041/132] (870s left) gem_mmap_wc (write-gtt-read-wc)
[161.402148] Subtest write-gtt-read-wc: SKIP (0.000s)
[161.470716] [042/132] (870s left) kms_plane_lowres (tiling-none)
[162.954303] Starting subtest: tiling-none
[162.955278] Starting dynamic subtest: pipe-A-HDMI-A-3
[172.451599] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (9.496s)
[172.549848] Starting dynamic subtest: pipe-B-HDMI-A-3
[181.713785] Dynamic subtest pipe-B-HDMI-A-3: SUCCESS (9.172s)
[181.764708] Starting dynamic subtest: pipe-C-HDMI-A-3
[191.006277] Dynamic subtest pipe-C-HDMI-A-3: SUCCESS (9.249s)
[191.070885] Starting dynamic subtest: pipe-D-HDMI-A-3
[200.245856] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (9.183s)
[200.290899] Subtest tiling-none: SUCCESS (37.337s)
[200.573229] [043/132] (831s left) gem_ctx_param (non-root-set)
[200.619147] Starting subtest: non-root-set
[200.636596] Subtest non-root-set: SUCCESS (0.018s)
[200.812782] [044/132] (831s left) i915_pm_rpm (debugfs-forcewake-user)
[205.036364] Starting subtest: debugfs-forcewake-user
[216.295428] Subtest debugfs-forcewake-user: SUCCESS (11.264s)
[217.185460] [045/132] (815s left) kms_scaling_modes (scaling-mode-full-aspect)
[218.672436] Starting subtest: scaling-mode-full-aspect
[218.677469] Subtest scaling-mode-full-aspect: SKIP (0.002s)
[218.886448] [046/132] (813s left) vgem_basic (bad-pad)
[219.024135] Starting subtest: bad-pad
[219.025048] Subtest bad-pad: SUCCESS (0.000s)
[219.200228] [FACT vgem_basic (bad-pad)] new: kernel.kmod_is_loaded.vgem: true
[219.202932] [047/132] (813s left) kms_psr (psr2-cursor-render)
[220.685520] Subtest psr2-cursor-render: SKIP (0.000s)
[220.765704] [048/132] (812s left) kms_psr2_sf (fbc-pr-overlay-primary-update-sf-dmg-area)
[222.256878] Subtest fbc-pr-overlay-primary-update-sf-dmg-area: SKIP (0.000s)
[222.331905] [049/132] (810s left) kms_ccs (bad-aux-stride-y-tiled-ccs)
[223.815984] Starting subtest: bad-aux-stride-y-tiled-ccs
[223.818505] Starting dynamic subtest: pipe-A-HDMI-A-3
[223.833236] Dynamic subtest pipe-A-HDMI-A-3: SKIP (0.000s)
[223.842136] Starting dynamic subtest: pipe-B-HDMI-A-3
[223.849793] Dynamic subtest pipe-B-HDMI-A-3: SKIP (0.000s)
[223.858381] Starting dynamic subtest: pipe-C-HDMI-A-3
[223.865886] Dynamic subtest pipe-C-HDMI-A-3: SKIP (0.000s)
[223.874213] Starting dynamic subtest: pipe-D-HDMI-A-3
[223.881877] Dynamic subtest pipe-D-HDMI-A-3: SKIP (0.000s)
[223.883387] Subtest bad-aux-stride-y-tiled-ccs: SKIP (0.011s)
[224.142802] [050/132] (808s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-16bpp-ytile-upscaling)
[225.626390] Starting subtest: flip-64bpp-ytile-to-16bpp-ytile-upscaling
[225.627352] Starting dynamic subtest: pipe-A-valid-mode
[226.445314] Dynamic subtest pipe-A-valid-mode: SUCCESS (0.818s)
[226.446183] Subtest flip-64bpp-ytile-to-16bpp-ytile-upscaling: SUCCESS (0.820s)
[226.699336] [051/132] (806s left) gem_ctx_param (invalid-set-no-zeromap)
[226.744329] Starting subtest: invalid-set-no-zeromap
[226.745181] Subtest invalid-set-no-zeromap: SUCCESS (0.000s)
[226.949771] [052/132] (806s left) kms_prop_blob (blob-prop-core)
[226.994766] Starting subtest: blob-prop-core
[226.995604] Subtest blob-prop-core: SUCCESS (0.000s)
[227.194604] [053/132] (806s left) kms_atomic (plane-immutable-zpos)
[228.678227] Starting subtest: plane-immutable-zpos
[228.679638] Starting dynamic subtest: pipe-A-HDMI-A-3
[229.449108] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (0.769s)
[229.449938] Subtest plane-immutable-zpos: SUCCESS (0.772s)
[229.695934] [054/132] (803s left) kms_getfb (getfb2-accept-nv12)
[231.179480] Starting subtest: getfb2-accept-nv12
[231.182102] Subtest getfb2-accept-nv12: SUCCESS (0.002s)
[231.438163] [055/132] (802s left) syncobj_timeline (etime-multi-wait-all-for-submit-submitted-signaled)
[231.483674] Starting subtest: etime-multi-wait-all-for-submit-submitted-signaled
[231.594775] Subtest etime-multi-wait-all-for-submit-submitted-signaled: SUCCESS (0.107s)
[231.789934] [056/132] (801s left) gem_ppgtt (shrink-vs-evict-any)
[231.839484] Starting subtest: shrink-vs-evict-any
[237.897780] Subtest shrink-vs-evict-any: SUCCESS (6.054s)
[238.028262] [057/132] (795s left) kms_cursor_legacy (2x-flip-vs-cursor-legacy)
[239.511331] Starting subtest: 2x-flip-vs-cursor-legacy
[239.514979] Subtest 2x-flip-vs-cursor-legacy: SKIP (0.003s)
[239.739665] [058/132] (794s left) kms_pm_backlight (fade-with-dpms)
[241.224368] Subtest fade-with-dpms: SKIP (0.000s)
[241.395687] [059/132] (792s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-render)
[242.886602] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-render
[242.888473] Subtest fbc-2p-scndscrn-pri-indfb-draw-render: SKIP (0.000s)
[243.135947] [060/132] (791s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-onoff)
[244.625913] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-onoff
[244.628109] Subtest fbcpsr-2p-primscrn-spr-indfb-onoff: SKIP (0.000s)
[244.894325] [061/132] (789s left) kms_psr (fbc-psr-sprite-plane-move)
[246.395310] Subtest fbc-psr-sprite-plane-move: SKIP (0.000s)
[246.481090] [062/132] (787s left) gem_exec_create (basic)
[246.538310] Starting subtest: basic
[246.539322] Starting dynamic subtest: smem
[248.636402] Dynamic subtest smem: SUCCESS (2.097s)
[248.647509] Starting dynamic subtest: lmem0
[250.738759] Dynamic subtest lmem0: SUCCESS (2.101s)
[250.739653] Subtest basic: SUCCESS (4.201s)
[251.027688] [063/132] (783s left) kms_cursor_legacy (basic-flip-after-cursor-legacy)
[252.511582] Starting subtest: basic-flip-after-cursor-legacy
[253.490674] Subtest basic-flip-after-cursor-legacy: SUCCESS (0.979s)
[253.766773] [064/132] (780s left) kms_psr2_sf (psr2-cursor-plane-move-continuous-sf)
[255.258053] Subtest psr2-cursor-plane-move-continuous-sf: SKIP (0.000s)
[255.340544] [065/132] (779s left) kms_ccs (crc-primary-basic-yf-tiled-ccs)
[256.828273] Starting subtest: crc-primary-basic-yf-tiled-ccs
[256.829133] Starting dynamic subtest: pipe-A-HDMI-A-3
[256.836930] Dynamic subtest pipe-A-HDMI-A-3: SKIP (0.001s)
[256.845876] Starting dynamic subtest: pipe-B-HDMI-A-3
[256.853590] Dynamic subtest pipe-B-HDMI-A-3: SKIP (0.001s)
[256.862443] Starting dynamic subtest: pipe-C-HDMI-A-3
[256.870338] Dynamic subtest pipe-C-HDMI-A-3: SKIP (0.001s)
[256.879139] Starting dynamic subtest: pipe-D-HDMI-A-3
[256.887255] Dynamic subtest pipe-D-HDMI-A-3: SKIP (0.001s)
[256.888909] Subtest crc-primary-basic-yf-tiled-ccs: SKIP (0.014s)
[257.144203] [066/132] (777s left) gem_exec_params (rs-invalid)
[257.194302] Starting subtest: rs-invalid
[257.198330] Subtest rs-invalid: SUCCESS (0.003s)
[257.443955] [067/132] (777s left) syncobj_timeline (etime-single-wait-for-submit-unsubmitted)
[257.488494] Starting subtest: etime-single-wait-for-submit-unsubmitted
[257.594070] Subtest etime-single-wait-for-submit-unsubmitted: SUCCESS (0.102s)
[257.797385] [068/132] (777s left) gem_ctx_persistence (process)
[257.847507] Starting subtest: process
[258.025728] Subtest process: SUCCESS (0.178s)
[258.247351] [069/132] (776s left) kms_dirtyfb (default-dirtyfb-ioctl)
[259.731452] Starting subtest: default-dirtyfb-ioctl
[259.734181] Starting dynamic subtest: A-HDMI-A-3
[261.179823] Dynamic subtest A-HDMI-A-3: SUCCESS (1.447s)
[261.180741] Subtest default-dirtyfb-ioctl: SUCCESS (1.449s)
[261.396816] [070/132] (773s left) kms_cursor_crc (cursor-offscreen-128x128)
[263.055846] Starting subtest: cursor-offscreen-128x128
[263.062699] Starting dynamic subtest: pipe-A-HDMI-A-3
[265.599954] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (2.538s)
[265.633874] Starting dynamic subtest: pipe-D-HDMI-A-3
[268.017411] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (2.390s)
[268.018267] Subtest cursor-offscreen-128x128: SUCCESS (4.961s)
[268.484013] [071/132] (766s left) gen3_render_mixed_blits
[268.599239] [072/132] (766s left) kms_color (legacy-gamma-reset)
[270.084301] Starting subtest: legacy-gamma-reset
[270.085184] Starting dynamic subtest: pipe-A-HDMI-A-3
[270.373781] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (0.289s)
[270.384646] Starting dynamic subtest: pipe-B-HDMI-A-3
[270.427706] Dynamic subtest pipe-B-HDMI-A-3: SUCCESS (0.051s)
[270.436839] Starting dynamic subtest: pipe-C-HDMI-A-3
[270.464858] Dynamic subtest pipe-C-HDMI-A-3: SUCCESS (0.037s)
[270.475645] Starting dynamic subtest: pipe-D-HDMI-A-3
[270.503798] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (0.037s)
[270.504844] Subtest legacy-gamma-reset: SUCCESS (0.421s)
[270.713911] [073/132] (764s left) kms_flip (nonexisting-fb-interruptible)
[272.204309] Starting subtest: nonexisting-fb-interruptible
[272.211556] Starting dynamic subtest: A-HDMI-A3
[272.433733] Dynamic subtest A-HDMI-A3: SUCCESS (0.222s)
[272.445231] Starting dynamic subtest: B-HDMI-A3
[272.597109] Dynamic subtest B-HDMI-A3: SUCCESS (0.161s)
[272.607730] Starting dynamic subtest: C-HDMI-A3
[272.747459] Dynamic subtest C-HDMI-A3: SUCCESS (0.149s)
[272.758111] Starting dynamic subtest: D-HDMI-A3
[272.898833] Dynamic subtest D-HDMI-A3: SUCCESS (0.150s)
[272.901376] Subtest nonexisting-fb-interruptible: SUCCESS (0.696s)
[273.217399] [074/132] (762s left) gem_exec_flush (basic-wb-pro-default)
[273.267985] Subtest basic-wb-pro-default: SKIP (0.000s)
[273.368139] [075/132] (762s left) gem_render_copy_redux (interruptible)
[273.418518] Starting subtest: interruptible
[274.261303] Subtest interruptible: SUCCESS (0.843s)
[274.460051] [076/132] (761s left) prime_busy (after-wait)
[274.510709] Starting subtest: after-wait
[274.517402] Starting dynamic subtest: rcs0
[274.551177] Dynamic subtest rcs0: SUCCESS (0.034s)
[274.562057] Starting dynamic subtest: bcs0
[274.604160] Dynamic subtest bcs0: SUCCESS (0.051s)
[274.617544] Starting dynamic subtest: vcs0
[274.643476] Dynamic subtest vcs0: SUCCESS (0.037s)
[274.658643] Starting dynamic subtest: vcs1
[274.685885] Dynamic subtest vcs1: SUCCESS (0.040s)
[274.707413] Starting dynamic subtest: vecs0
[274.729738] Dynamic subtest vecs0: SUCCESS (0.041s)
[274.842354] Subtest after-wait: SUCCESS (0.328s)
[275.048253] [077/132] (760s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted)
[275.093619] Starting subtest: etime-multi-wait-all-available-unsubmitted
[275.202486] Subtest etime-multi-wait-all-available-unsubmitted: SUCCESS (0.105s)
[275.359416] [078/132] (760s left) kms_frontbuffer_tracking (fbcpsr-modesetfrombusy)
[276.849884] Starting subtest: fbcpsr-modesetfrombusy
[276.851571] Subtest fbcpsr-modesetfrombusy: SKIP (0.000s)
[277.111681] [079/132] (758s left) kms_psr (fbc-psr2-cursor-mmap-gtt)
[278.595392] Subtest fbc-psr2-cursor-mmap-gtt: SKIP (0.000s)
[278.666509] [080/132] (757s left) gem_madvise (dontneed-before-pwrite)
[278.708752] Starting subtest: dontneed-before-pwrite
[278.712967] Subtest dontneed-before-pwrite: SKIP (0.003s)
[278.799947] [081/132] (757s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-render)
[280.289473] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-render
[280.291346] Subtest psr-2p-scndscrn-spr-indfb-draw-render: SKIP (0.000s)
[280.550818] [082/132] (755s left) kms_cursor_legacy (2x-flip-vs-cursor-atomic)
[282.035629] Starting subtest: 2x-flip-vs-cursor-atomic
[282.039433] Subtest 2x-flip-vs-cursor-atomic: SKIP (0.003s)
[282.272344] [083/132] (754s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-pwrite)
[283.762092] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-pwrite
[286.440429] Subtest fbc-1p-primscrn-spr-indfb-draw-pwrite: SUCCESS (2.678s)
[286.714232] [084/132] (749s left) gem_madvise (dontneed-before-mmap)
[286.755476] Starting subtest: dontneed-before-mmap
[286.760286] Subtest dontneed-before-mmap: SUCCESS (0.004s)
[286.956442] [085/132] (749s left) gem_ctx_shared (disjoint-timelines)
[287.012437] Starting subtest: disjoint-timelines
[287.056709] Subtest disjoint-timelines: SUCCESS (0.045s)
[287.374605] [086/132] (749s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-wc)
[288.862723] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-wc
[288.864281] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[289.099766] [087/132] (747s left) gem_vm_create (invalid-destroy)
[289.150450] Starting subtest: invalid-destroy
[289.152865] Subtest invalid-destroy: SUCCESS (0.002s)
[289.373887] [088/132] (747s left) kms_big_fb (yf-tiled-16bpp-rotate-180)
[290.880391] Starting subtest: yf-tiled-16bpp-rotate-180
[290.882122] Subtest yf-tiled-16bpp-rotate-180: SKIP (0.000s)
[291.133942] [089/132] (745s left) gem_exec_balancer (invalid-balancer)
[291.190269] Starting subtest: invalid-balancer
[293.220933] Subtest invalid-balancer: SUCCESS (2.027s)
[293.676796] [090/132] (743s left) testdisplay
[300.080760] [091/132] (737s left) syncobj_basic (bad-pad-handle-to-fd)
[300.126315] Starting subtest: bad-pad-handle-to-fd
[300.127139] Subtest bad-pad-handle-to-fd: SUCCESS (0.000s)
[300.308508] [092/132] (736s left) kms_cursor_legacy (cursorb-vs-flipa-atomic-transitions)
[301.794397] Starting subtest: cursorB-vs-flipA-atomic-transitions
[301.798184] Subtest cursorB-vs-flipA-atomic-transitions: SKIP (0.003s)
[301.985923] [093/132] (735s left) kms_ccs (crc-sprite-planes-basic-y-tiled-ccs)
[303.470945] Starting subtest: crc-sprite-planes-basic-y-tiled-ccs
[303.473509] Starting dynamic subtest: pipe-A-HDMI-A-3
[303.497997] Dynamic subtest pipe-A-HDMI-A-3: SKIP (0.003s)
[303.507327] Starting dynamic subtest: pipe-B-HDMI-A-3
[303.532257] Dynamic subtest pipe-B-HDMI-A-3: SKIP (0.003s)
[303.541441] Starting dynamic subtest: pipe-C-HDMI-A-3
[303.567098] Dynamic subtest pipe-C-HDMI-A-3: SKIP (0.003s)
[303.576225] Starting dynamic subtest: pipe-D-HDMI-A-3
[303.601345] Dynamic subtest pipe-D-HDMI-A-3: SKIP (0.003s)
[303.603238] Subtest crc-sprite-planes-basic-y-tiled-ccs: SKIP (0.021s)
[303.808802] [094/132] (733s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-render)
[305.298899] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-render
[305.300573] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-render: SKIP (0.000s)
[305.551553] [095/132] (732s left) kms_big_fb (4-tiled-8bpp-rotate-180)
[307.054896] Starting subtest: 4-tiled-8bpp-rotate-180
[307.056817] Subtest 4-tiled-8bpp-rotate-180: SKIP (0.000s)
[307.316650] [096/132] (730s left) kms_joiner (basic-big-joiner)
[308.803148] Starting subtest: basic-big-joiner
[308.804860] Subtest basic-big-joiner: SKIP (0.000s)
[308.945654] [097/132] (728s left) kms_chamelium_hpd (hdmi-hpd-fast)
[310.473239] Subtest hdmi-hpd-fast: SKIP (0.000s)
[310.584950] [098/132] (727s left) kms_addfb_basic (basic-y-tiled-legacy)
[310.635081] Starting subtest: basic-y-tiled-legacy
[310.636628] Subtest basic-y-tiled-legacy: SKIP (0.000s)
[312.330096] [099/132] (725s left) kms_cursor_legacy (cursor-vs-flip-atomic)
[313.815385] Starting subtest: cursor-vs-flip-atomic
[345.443665] Subtest cursor-vs-flip-atomic: SUCCESS (31.628s)
[345.669357] [100/132] (692s left) gem_partial_pwrite_pread (writes-after-reads-display)
[345.720190] Subtest writes-after-reads-display: SKIP (0.000s)
[345.828890] [101/132] (692s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-shrfb-msflip-blt)
[347.316913] Starting subtest: fbcpsr-1p-primscrn-shrfb-msflip-blt
[347.318556] Subtest fbcpsr-1p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[347.567714] [102/132] (690s left) i915_selftest (mock)
[348.599882] Starting subtest: mock
[348.601053] Starting dynamic subtest: sanitycheck
[349.492589] Dynamic subtest sanitycheck: SUCCESS (0.889s)
[349.524211] Starting dynamic subtest: shmem
[350.376647] Dynamic subtest shmem: SUCCESS (0.877s)
[350.384622] Starting dynamic subtest: fence
[358.012288] Dynamic subtest fence: SUCCESS (7.631s)
[358.030433] Starting dynamic subtest: scatterlist
[359.893189] Dynamic subtest scatterlist: SUCCESS (1.874s)
[359.904438] Starting dynamic subtest: syncmap
[362.734339] Dynamic subtest syncmap: SUCCESS (2.837s)
[362.752588] Starting dynamic subtest: uncore
[363.574217] Dynamic subtest uncore: SUCCESS (0.832s)
[363.608030] Starting dynamic subtest: ring
[364.435943] Dynamic subtest ring: SUCCESS (0.854s)
[364.469277] Starting dynamic subtest: engine
[365.296607] Dynamic subtest engine: SUCCESS (0.853s)
[365.331623] Starting dynamic subtest: timelines
[370.657711] Dynamic subtest timelines: SUCCESS (5.354s)
[370.665817] Starting dynamic subtest: requests
[374.327053] Dynamic subtest requests: SUCCESS (3.665s)
[374.336746] Starting dynamic subtest: objects
[375.294764] Dynamic subtest objects: SUCCESS (0.968s)
[375.304599] Starting dynamic subtest: phys
[376.326816] Dynamic subtest phys: SUCCESS (1.030s)
[376.339865] Starting dynamic subtest: dmabuf
[377.338855] Dynamic subtest dmabuf: SUCCESS (1.010s)
[377.347898] Starting dynamic subtest: vma
[387.702689] Dynamic subtest vma: SUCCESS (10.362s)
[387.713138] Starting dynamic subtest: evict
[389.769952] Dynamic subtest evict: SUCCESS (2.065s)
[389.780859] Starting dynamic subtest: gtt
[393.650900] Dynamic subtest gtt: SUCCESS (3.878s)
[393.661282] Starting dynamic subtest: hugepages
[394.861801] Dynamic subtest hugepages: SUCCESS (1.209s)
[394.872035] Starting dynamic subtest: memory_region
[399.063875] Dynamic subtest memory_region: SUCCESS (4.200s)
[399.064936] Subtest mock: SUCCESS (50.464s)
[399.109605] [FACT i915_selftest (mock)] deleted: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[399.110708] [FACT i915_selftest (mock)] deleted: kernel.kmod_is_loaded.i915: true
[399.112903] [103/132] (639s left) kms_flip (2x-dpms-vs-vblank-race-interruptible)
[403.907382] Starting subtest: 2x-dpms-vs-vblank-race-interruptible
[403.927253] Subtest 2x-dpms-vs-vblank-race-interruptible: SKIP (0.019s)
[404.179510] [FACT kms_flip (2x-dpms-vs-vblank-race-interruptible)] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[404.182882] [FACT kms_flip (2x-dpms-vs-vblank-race-interruptible)] new: kernel.kmod_is_loaded.i915: true
[404.189379] [104/132] (634s left) kms_big_fb (y-tiled-16bpp-rotate-90)
[405.692864] Starting subtest: y-tiled-16bpp-rotate-90
[407.464895] Subtest y-tiled-16bpp-rotate-90: SUCCESS (1.768s)
[407.732821] [105/132] (630s left) kms_ccs (bad-rotation-90-4-tiled-dg2-rc-ccs-cc)
[409.217241] Starting subtest: bad-rotation-90-4-tiled-dg2-rc-ccs-cc
[409.219499] Starting dynamic subtest: pipe-A-HDMI-A-3
[409.227430] Dynamic subtest pipe-A-HDMI-A-3: SKIP (0.000s)
[409.236565] Starting dynamic subtest: pipe-B-HDMI-A-3
[409.244661] Dynamic subtest pipe-B-HDMI-A-3: SKIP (0.000s)
[409.253781] Starting dynamic subtest: pipe-C-HDMI-A-3
[409.261853] Dynamic subtest pipe-C-HDMI-A-3: SKIP (0.000s)
[409.270537] Starting dynamic subtest: pipe-D-HDMI-A-3
[409.278933] Dynamic subtest pipe-D-HDMI-A-3: SKIP (0.000s)
[409.280580] Subtest bad-rotation-90-4-tiled-dg2-rc-ccs-cc: SKIP (0.011s)
[409.542270] [106/132] (629s left) syncobj_wait (multi-wait-submitted-signaled)
[409.588410] Starting subtest: multi-wait-submitted-signaled
[409.589269] Subtest multi-wait-submitted-signaled: SUCCESS (0.000s)
[409.795149] [107/132] (628s left) perf_pmu (init-busy)
[409.847553] Starting subtest: init-busy
[409.848459] Starting dynamic subtest: rcs0
[409.850919] Dynamic subtest rcs0: SUCCESS (0.001s)
[409.860293] Starting dynamic subtest: bcs0
[409.861190] Dynamic subtest bcs0: SUCCESS (0.001s)
[409.870491] Starting dynamic subtest: vcs0
[409.871647] Dynamic subtest vcs0: SUCCESS (0.001s)
[409.880682] Starting dynamic subtest: vcs1
[409.881814] Dynamic subtest vcs1: SUCCESS (0.001s)
[409.890581] Starting dynamic subtest: vecs0
[409.891521] Dynamic subtest vecs0: SUCCESS (0.001s)
[409.892572] Subtest init-busy: SUCCESS (0.012s)
[410.027594] [108/132] (628s left) gem_mmap_gtt (coherency)
[410.072146] Subtest coherency: SKIP (0.000s)
[410.151870] [109/132] (628s left) kms_lease (multimaster-lease)
[411.637288] Starting subtest: multimaster-lease
[411.641346] Subtest multimaster-lease: SUCCESS (0.004s)
[411.862795] [110/132] (627s left) kms_chamelium_frames (hdmi-frame-dump)
[413.398650] Subtest hdmi-frame-dump: SKIP (0.000s)
[413.515708] [111/132] (625s left) gem_workarounds (basic-read-fd)
[413.585083] Starting subtest: basic-read-fd
[413.615247] Subtest basic-read-fd: SUCCESS (0.030s)
[413.875581] [112/132] (625s left) kms_cursor_crc (cursor-offscreen-256x256)
[415.581420] Starting subtest: cursor-offscreen-256x256
[415.586593] Starting dynamic subtest: pipe-A-HDMI-A-3
[418.125310] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (2.538s)
[418.159928] Starting dynamic subtest: pipe-D-HDMI-A-3
[420.559414] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (2.408s)
[420.560206] Subtest cursor-offscreen-256x256: SUCCESS (4.979s)
[420.929755] [113/132] (618s left) gem_exec_schedule (semaphore-user)
[420.989805] Starting subtest: semaphore-user
[421.018509] Subtest semaphore-user: SUCCESS (0.029s)
[421.455659] [114/132] (617s left) kms_big_fb (linear-64bpp-rotate-180)
[422.957968] Starting subtest: linear-64bpp-rotate-180
[425.268471] Subtest linear-64bpp-rotate-180: SUCCESS (2.307s)
[425.485988] [115/132] (613s left) gem_flink_race (flink_close)
[425.528567] Starting subtest: flink_close
[430.558181] Subtest flink_close: SUCCESS (5.030s)
[430.781575] [116/132] (608s left) kms_big_fb (x-tiled-32bpp-rotate-270)
[432.284719] Starting subtest: x-tiled-32bpp-rotate-270
[432.389579] Subtest x-tiled-32bpp-rotate-270: SKIP (0.103s)
[432.606015] [117/132] (607s left) gem_softpin (allocator-evict)
[432.656919] Starting subtest: allocator-evict
[432.658079] Starting dynamic subtest: rcs0
[461.733598] Dynamic subtest rcs0: SUCCESS (29.073s)
[461.743166] Starting dynamic subtest: bcs0
[490.922853] Dynamic subtest bcs0: SUCCESS (29.188s)
[490.932273] Starting dynamic subtest: vcs0
[520.281226] Dynamic subtest vcs0: SUCCESS (29.356s)
[520.290659] Starting dynamic subtest: vcs1
[549.662088] Dynamic subtest vcs1: SUCCESS (29.378s)
[549.671583] Starting dynamic subtest: vecs0
[579.037380] Dynamic subtest vecs0: SUCCESS (29.373s)
[579.038350] Subtest allocator-evict: SUCCESS (146.376s)
[579.233883] [118/132] (460s left) gem_lmem_swapping (random)
[583.829409] Starting subtest: random
[583.830357] Starting dynamic subtest: lmem0
[585.084418] Dynamic subtest lmem0: SUCCESS (1.252s)
[585.085270] Subtest random: SUCCESS (1.253s)
[587.720204] [FACT gem_lmem_swapping (random)] deleted: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[587.721298] [FACT gem_lmem_swapping (random)] deleted: kernel.kmod_is_loaded.i915: true
[587.723474] [119/132] (452s left) gen9_exec_parse (basic-rejected)
[591.088697] Subtest basic-rejected: SKIP (0.000s)
[591.159232] [FACT gen9_exec_parse (basic-rejected)] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[591.162845] [FACT gen9_exec_parse (basic-rejected)] new: kernel.kmod_is_loaded.i915: true
[591.166145] [120/132] (448s left) device_reset (cold-reset-bound)
[591.271770] Starting subtest: cold-reset-bound
[591.273486] Subtest cold-reset-bound: SKIP (0.000s)
[591.476982] [121/132] (448s left) gem_mmap_gtt (basic-short)
[591.522412] Subtest basic-short: SKIP (0.000s)
[591.597149] [122/132] (448s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip)
[593.107344] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip
[593.109327] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip: SKIP (0.001s)
[593.352222] [123/132] (446s left) kms_vblank (wait-busy)
[594.837037] Starting subtest: wait-busy
[594.839621] Starting dynamic subtest: pipe-A-HDMI-A-3
[597.379263] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (2.539s)
[597.391130] Starting dynamic subtest: pipe-D-HDMI-A-3
[599.741336] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (2.357s)
[599.742168] Subtest wait-busy: SUCCESS (4.905s)
[599.975316] [124/132] (440s left) kms_flip (dpms-off-confusion-interruptible)
[601.465598] Starting subtest: dpms-off-confusion-interruptible
[601.472942] Starting dynamic subtest: A-HDMI-A3
[609.345617] Dynamic subtest A-HDMI-A3: SUCCESS (7.872s)
[609.359245] Starting dynamic subtest: B-HDMI-A3
[617.010935] Dynamic subtest B-HDMI-A3: SUCCESS (7.662s)
[617.052833] Starting dynamic subtest: C-HDMI-A3
[624.712065] Dynamic subtest C-HDMI-A3: SUCCESS (7.693s)
[624.723085] Starting dynamic subtest: D-HDMI-A3
[632.380398] Dynamic subtest D-HDMI-A3: SUCCESS (7.666s)
[632.382989] Subtest dpms-off-confusion-interruptible: SUCCESS (30.916s)
[632.665986] [125/132] (407s left) gem_exec_reloc (basic-cpu-gtt)
[632.717080] Subtest basic-cpu-gtt: SKIP (0.000s)
[632.814938] [126/132] (407s left) gem_exec_reloc (basic-softpin)
[632.866547] Subtest basic-softpin: SKIP (0.000s)
[632.967990] [127/132] (407s left) gem_exec_fence (invalid-timeline-fence-array)
[633.547397] Starting subtest: invalid-timeline-fence-array
[633.548211] Subtest invalid-timeline-fence-array: SUCCESS (0.005s)
[633.873908] [128/132] (406s left) gem_render_copy (y-tiled-ccs-to-yf-tiled-ccs)
[633.925712] Starting subtest: y-tiled-ccs-to-yf-tiled-ccs
[633.926492] Starting dynamic subtest: smem
[634.024923] Dynamic subtest smem: SUCCESS (0.099s)
[634.035515] Starting dynamic subtest: lmem0
[635.140541] Dynamic subtest lmem0: SUCCESS (1.111s)
[635.141554] Subtest y-tiled-ccs-to-yf-tiled-ccs: SUCCESS (1.212s)
[635.420781] [129/132] (405s left) gem_exec_store (pages)
[635.475431] Starting subtest: pages
[635.476274] Starting dynamic subtest: rcs0
[635.630275] Dynamic subtest rcs0: SUCCESS (0.154s)
[635.641786] Starting dynamic subtest: bcs0
[635.741905] Dynamic subtest bcs0: SUCCESS (0.110s)
[635.752558] Starting dynamic subtest: vcs0
[635.852884] Dynamic subtest vcs0: SUCCESS (0.110s)
[635.863962] Starting dynamic subtest: vcs1
[635.970863] Dynamic subtest vcs1: SUCCESS (0.117s)
[635.981572] Starting dynamic subtest: vecs0
[636.085933] Dynamic subtest vecs0: SUCCESS (0.114s)
[636.086963] Subtest pages: SUCCESS (0.611s)
[636.391961] [130/132] (404s left) gem_userptr_blits (sync-unmap-after-close)
[636.452490] Starting subtest: sync-unmap-after-close
[636.473801] Subtest sync-unmap-after-close: SUCCESS (0.021s)
[636.700567] [131/132] (404s left) kms_cursor_crc (cursor-rapid-movement-256x85)
[638.428714] Starting subtest: cursor-rapid-movement-256x85
[638.435825] Starting dynamic subtest: pipe-A-HDMI-A-3
[638.861233] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (0.425s)
[638.895494] Starting dynamic subtest: pipe-D-HDMI-A-3
[639.208350] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (0.321s)
[639.209287] Subtest cursor-rapid-movement-256x85: SUCCESS (0.780s)
[639.608323] [132/132] (401s left) gem_cs_tlb (engines)
[639.657532] Starting subtest: engines
[639.658528] Starting dynamic subtest: rcs0
[641.823545] Dynamic subtest rcs0: SUCCESS (2.154s)
[641.834911] Starting dynamic subtest: bcs0
[643.968587] Dynamic subtest bcs0: SUCCESS (2.154s)
[643.978178] Starting dynamic subtest: vcs0
[646.126133] Dynamic subtest vcs0: SUCCESS (2.153s)
[646.135870] Starting dynamic subtest: vcs1
[648.281358] Dynamic subtest vcs1: SUCCESS (2.154s)
[648.290971] Starting dynamic subtest: vecs0
[650.435981] Dynamic subtest vecs0: SUCCESS (2.153s)
[650.436972] Subtest engines: SUCCESS (10.775s)
[650.634888] Closing watchdogs
results: parsing output: 0/ for test: gem_mmap_gtt
results: parsing output: 1/ for test: kms_pm_rpm
results: parsing output: 2/ for test: kms_draw_crc
results: parsing output: 3/ for test: kms_ccs
results: parsing output: 4/ for test: kms_cursor_legacy
results: parsing output: 5/ for test: syncobj_timeline
results: parsing output: 6/ for test: core_debugfs
results: parsing output: 7/ for test: syncobj_wait
results: parsing output: 8/ for test: syncobj_wait
results: parsing output: 9/ for test: kms_frontbuffer_tracking
results: parsing output: 10/ for test: kms_frontbuffer_tracking
results: parsing output: 11/ for test: gem_pxp
results: parsing output: 12/ for test: gem_exec_whisper
results: parsing output: 13/ for test: syncobj_timeline
results: parsing output: 14/ for test: kms_plane
results: parsing output: 15/ for test: kms_cursor_crc
results: parsing output: 16/ for test: kms_frontbuffer_tracking
results: parsing output: 17/ for test: kms_panel_fitting
results: parsing output: 18/ for test: kms_frontbuffer_tracking
results: parsing output: 19/ for test: kms_ccs
results: parsing output: 20/ for test: kms_frontbuffer_tracking
results: parsing output: 21/ for test: kms_frontbuffer_tracking
results: parsing output: 22/ for test: kms_vblank
results: parsing output: 23/ for test: gem_exec_big
results: parsing output: 24/ for test: i915_drm_fdinfo
results: parsing output: 25/ for test: kms_plane_scaling
results: parsing output: 26/ for test: gem_busy
results: parsing output: 27/ for test: syncobj_timeline
results: parsing output: 28/ for test: kms_frontbuffer_tracking
results: parsing output: 29/ for test: kms_psr
results: parsing output: 30/ for test: api_intel_allocator
results: parsing output: 31/ for test: i915_drm_fdinfo
results: parsing output: 32/ for test: kms_cursor_legacy
results: parsing output: 33/ for test: gem_ctx_bad_destroy
results: parsing output: 34/ for test: kms_psr
results: parsing output: 35/ for test: kms_flip_scaled_crc
results: parsing output: 36/ for test: kms_frontbuffer_tracking
results: parsing output: 37/ for test: gem_exec_schedule
results: parsing output: 38/ for test: kms_frontbuffer_tracking
results: parsing output: 39/ for test: kms_frontbuffer_tracking
results: parsing output: 40/ for test: gem_mmap_wc
results: parsing output: 41/ for test: kms_plane_lowres
results: parsing output: 42/ for test: gem_ctx_param
results: parsing output: 43/ for test: i915_pm_rpm
results: parsing output: 44/ for test: kms_scaling_modes
results: parsing output: 45/ for test: vgem_basic
results: parsing output: 46/ for test: kms_psr
results: parsing output: 47/ for test: kms_psr2_sf
results: parsing output: 48/ for test: kms_ccs
results: parsing output: 49/ for test: kms_flip_scaled_crc
results: parsing output: 50/ for test: gem_ctx_param
results: parsing output: 51/ for test: kms_prop_blob
results: parsing output: 52/ for test: kms_atomic
results: parsing output: 53/ for test: kms_getfb
results: parsing output: 54/ for test: syncobj_timeline
results: parsing output: 55/ for test: gem_ppgtt
results: parsing output: 56/ for test: kms_cursor_legacy
results: parsing output: 57/ for test: kms_pm_backlight
results: parsing output: 58/ for test: kms_frontbuffer_tracking
results: parsing output: 59/ for test: kms_frontbuffer_tracking
results: parsing output: 60/ for test: kms_psr
results: parsing output: 61/ for test: gem_exec_create
results: parsing output: 62/ for test: kms_cursor_legacy
results: parsing output: 63/ for test: kms_psr2_sf
results: parsing output: 64/ for test: kms_ccs
results: parsing output: 65/ for test: gem_exec_params
results: parsing output: 66/ for test: syncobj_timeline
results: parsing output: 67/ for test: gem_ctx_persistence
results: parsing output: 68/ for test: kms_dirtyfb
results: parsing output: 69/ for test: kms_cursor_crc
results: parsing output: 70/ for test: gen3_render_mixed_blits
results: parsing output: 71/ for test: kms_color
results: parsing output: 72/ for test: kms_flip
results: parsing output: 73/ for test: gem_exec_flush
results: parsing output: 74/ for test: gem_render_copy_redux
results: parsing output: 75/ for test: prime_busy
results: parsing output: 76/ for test: syncobj_timeline
results: parsing output: 77/ for test: kms_frontbuffer_tracking
results: parsing output: 78/ for test: kms_psr
results: parsing output: 79/ for test: gem_madvise
results: parsing output: 80/ for test: kms_frontbuffer_tracking
results: parsing output: 81/ for test: kms_cursor_legacy
results: parsing output: 82/ for test: kms_frontbuffer_tracking
results: parsing output: 83/ for test: gem_madvise
results: parsing output: 84/ for test: gem_ctx_shared
results: parsing output: 85/ for test: kms_frontbuffer_tracking
results: parsing output: 86/ for test: gem_vm_create
results: parsing output: 87/ for test: kms_big_fb
results: parsing output: 88/ for test: gem_exec_balancer
results: parsing output: 89/ for test: testdisplay
results: parsing output: 90/ for test: syncobj_basic
results: parsing output: 91/ for test: kms_cursor_legacy
results: parsing output: 92/ for test: kms_ccs
results: parsing output: 93/ for test: kms_frontbuffer_tracking
results: parsing output: 94/ for test: kms_big_fb
results: parsing output: 95/ for test: kms_joiner
results: parsing output: 96/ for test: kms_chamelium_hpd
results: parsing output: 97/ for test: kms_addfb_basic
results: parsing output: 98/ for test: kms_cursor_legacy
results: parsing output: 99/ for test: gem_partial_pwrite_pread
results: parsing output: 100/ for test: kms_frontbuffer_tracking
results: parsing output: 101/ for test: i915_selftest
results: parsing output: 102/ for test: kms_flip
results: parsing output: 103/ for test: kms_big_fb
results: parsing output: 104/ for test: kms_ccs
results: parsing output: 105/ for test: syncobj_wait
results: parsing output: 106/ for test: perf_pmu
results: parsing output: 107/ for test: gem_mmap_gtt
results: parsing output: 108/ for test: kms_lease
results: parsing output: 109/ for test: kms_chamelium_frames
results: parsing output: 110/ for test: gem_workarounds
results: parsing output: 111/ for test: kms_cursor_crc
results: parsing output: 112/ for test: gem_exec_schedule
results: parsing output: 113/ for test: kms_big_fb
results: parsing output: 114/ for test: gem_flink_race
results: parsing output: 115/ for test: kms_big_fb
results: parsing output: 116/ for test: gem_softpin
results: parsing output: 117/ for test: gem_lmem_swapping
results: parsing output: 118/ for test: gen9_exec_parse
results: parsing output: 119/ for test: device_reset
results: parsing output: 120/ for test: gem_mmap_gtt
results: parsing output: 121/ for test: kms_big_fb
results: parsing output: 122/ for test: kms_vblank
results: parsing output: 123/ for test: kms_flip
results: parsing output: 124/ for test: gem_exec_reloc
results: parsing output: 125/ for test: gem_exec_reloc
results: parsing output: 126/ for test: gem_exec_fence
results: parsing output: 127/ for test: gem_render_copy
results: parsing output: 128/ for test: gem_exec_store
results: parsing output: 129/ for test: gem_userptr_blits
results: parsing output: 130/ for test: kms_cursor_crc
results: parsing output: 131/ for test: gem_cs_tlb
Done.