[63.407079] Initializing watchdogs
[63.407141]   /dev/watchdog0
[63.426276] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:03:00.0: 8086:56a0 Intel Dg2 (Gen12) DG2 [Arc A770]
[63.436949] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[63.440608] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[63.443320] [001/133] (960s left) core_auth (getclient-master-drop)
[63.487422] Starting subtest: getclient-master-drop
[63.530048] Subtest getclient-master-drop: SUCCESS (0.043s)
[63.720483] [002/133] (960s left) gem_workarounds (reset)
[63.812165] Starting subtest: reset
[64.032529] Subtest reset: SUCCESS (0.221s)
[64.190384] [003/133] (959s left) kms_plane (pixel-format-4-tiled-dg2-rc-ccs-modifier)
[64.367618] Starting subtest: pixel-format-4-tiled-dg2-rc-ccs-modifier
[64.369397] Subtest pixel-format-4-tiled-dg2-rc-ccs-modifier: SKIP (0.000s)
[64.507160] [004/133] (959s left) i915_hangman (hangcheck-unterminated)
[64.594954] Starting subtest: hangcheck-unterminated
[74.197804] Subtest hangcheck-unterminated: SUCCESS (9.609s)
[74.368054] [005/133] (949s left) kms_psr2_sf (fbc-psr2-overlay-plane-update-sf-dmg-area)
[74.546776] Subtest fbc-psr2-overlay-plane-update-sf-dmg-area: SKIP (0.000s)
[74.596562] [006/133] (949s left) gem_exec_whisper (basic-normal-all)
[74.681537] Starting subtest: basic-normal-all
[77.072189] Subtest basic-normal-all: SUCCESS (2.390s)
[77.370117] [007/133] (946s left) kms_psr2_sf (psr2-overlay-plane-move-continuous-exceed-fully-sf)
[77.552565] Subtest psr2-overlay-plane-move-continuous-exceed-fully-sf: SKIP (0.000s)
[77.613129] [008/133] (946s left) dmabuf (all-tests)
[77.656403] Starting subtest: all-tests
[77.657244] Starting dynamic subtest: sanitycheck
[77.741678] Dynamic subtest sanitycheck: SUCCESS (0.085s)
[77.780463] Starting dynamic subtest: dma_fence
[77.993056] Dynamic subtest dma_fence: SUCCESS (0.250s)
[78.028287] Starting dynamic subtest: dma_fence_chain
[87.558493] Dynamic subtest dma_fence_chain: SUCCESS (9.565s)
[87.587305] Starting dynamic subtest: dma_fence_unwrap
[87.655338] Dynamic subtest dma_fence_unwrap: SUCCESS (0.096s)
[87.674423] Starting dynamic subtest: dma_resv
[87.736847] Dynamic subtest dma_resv: SUCCESS (0.081s)
[87.738206] Subtest all-tests: SUCCESS (10.082s)
[87.883826] [009/133] (936s left) gem_render_copy_redux (interruptible)
[87.956396] Starting subtest: interruptible
[88.723472] Subtest interruptible: SUCCESS (0.767s)
[88.914880] [010/133] (935s left) gem_exec_schedule (pi-shared-iova)
[89.135918] Starting subtest: pi-shared-iova
[89.137489] Starting dynamic subtest: rcs0
[89.413926] Dynamic subtest rcs0: SUCCESS (0.279s)
[89.422518] Starting dynamic subtest: bcs0
[89.591464] Dynamic subtest bcs0: SUCCESS (0.177s)
[89.600455] Starting dynamic subtest: vcs0
[89.777377] Dynamic subtest vcs0: SUCCESS (0.186s)
[89.785954] Starting dynamic subtest: vcs1
[89.964519] Dynamic subtest vcs1: SUCCESS (0.187s)
[89.973144] Starting dynamic subtest: vecs0
[90.150477] Dynamic subtest vecs0: SUCCESS (0.185s)
[90.159122] Starting dynamic subtest: vecs1
[90.337894] Dynamic subtest vecs1: SUCCESS (0.187s)
[90.346598] Starting dynamic subtest: ccs0
[90.524833] Dynamic subtest ccs0: SUCCESS (0.187s)
[90.525660] Subtest pi-shared-iova: SUCCESS (1.390s)
[90.963891] [011/133] (933s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-render)
[91.142401] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-render
[91.144133] Subtest psr-2p-scndscrn-pri-indfb-draw-render: SKIP (0.000s)
[91.331702] [012/133] (933s left) gem_render_copy (y-tiled)
[91.406479] Starting subtest: y-tiled
[91.408562] Subtest y-tiled: SKIP (0.000s)
[91.649245] [013/133] (933s left) kms_busy (basic)
[91.833933] Starting subtest: basic
[91.834887] Starting dynamic subtest: flip
[92.461874] Dynamic subtest flip: SUCCESS (0.626s)
[92.480853] Starting dynamic subtest: modeset
[93.360343] Dynamic subtest modeset: SUCCESS (0.899s)
[93.361301] Subtest basic: SUCCESS (1.526s)
[93.685062] [014/133] (931s left) kms_psr (psr2-cursor-blt)
[93.868472] Subtest psr2-cursor-blt: SKIP (0.000s)
[93.918307] [015/133] (930s left) kms_flip (2x-plain-flip-fb-recreate)
[94.095133] Starting subtest: 2x-plain-flip-fb-recreate
[94.110237] Subtest 2x-plain-flip-fb-recreate: SKIP (0.015s)
[94.249693] [016/133] (930s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-fullscreen)
[94.428413] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-fullscreen
[94.430060] Subtest fbcpsr-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s)
[94.606695] [017/133] (930s left) kms_frontbuffer_tracking (fbcpsr-stridechange)
[94.787524] Starting subtest: fbcpsr-stridechange
[94.789196] Subtest fbcpsr-stridechange: SKIP (0.000s)
[94.949383] [018/133] (930s left) gem_mmap_gtt (close-race)
[95.022709] Subtest close-race: SKIP (0.000s)
[95.131588] [019/133] (929s left) perf_pmu (semaphore-wait)
[95.191991] Starting subtest: semaphore-wait
[95.192899] Starting dynamic subtest: rcs0
[95.731886] Dynamic subtest rcs0: SUCCESS (0.539s)
[95.744259] Starting dynamic subtest: bcs0
[96.245615] Dynamic subtest bcs0: SUCCESS (0.512s)
[96.257476] Starting dynamic subtest: vcs0
[96.759567] Dynamic subtest vcs0: SUCCESS (0.513s)
[96.771586] Starting dynamic subtest: vcs1
[97.274207] Dynamic subtest vcs1: SUCCESS (0.513s)
[97.285526] Starting dynamic subtest: vecs0
[97.787349] Dynamic subtest vecs0: SUCCESS (0.513s)
[97.799270] Starting dynamic subtest: vecs1
[98.300968] Dynamic subtest vecs1: SUCCESS (0.511s)
[98.311169] Starting dynamic subtest: ccs0
[98.809363] Dynamic subtest ccs0: SUCCESS (0.510s)
[98.810282] Subtest semaphore-wait: SUCCESS (3.617s)
[99.015063] [020/133] (926s left) kms_rotation_crc (primary-4-tiled-reflect-x-0)
[99.191259] Starting subtest: primary-4-tiled-reflect-x-0
[109.667384] Subtest primary-4-tiled-reflect-x-0: SUCCESS (10.475s)
[110.072938] [021/133] (915s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180-async-flip)
[110.265412] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180-async-flip
[110.991802] Subtest x-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SUCCESS (0.727s)
[111.270918] [022/133] (914s left) kms_frontbuffer_tracking (psr-2p-primscrn-shrfb-msflip-blt)
[111.456290] Starting subtest: psr-2p-primscrn-shrfb-msflip-blt
[111.458027] Subtest psr-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[111.639521] [023/133] (913s left) kms_plane_scaling (plane-upscale-20x20-with-pixel-format)
[111.819920] Starting subtest: plane-upscale-20x20-with-pixel-format
[111.820756] Starting dynamic subtest: pipe-A
[113.458748] Dynamic subtest pipe-A: SUCCESS (1.638s)
[113.483536] Starting dynamic subtest: pipe-B
[115.187519] Dynamic subtest pipe-B: SUCCESS (1.728s)
[115.206823] Starting dynamic subtest: pipe-C
[115.502019] Dynamic subtest pipe-C: SUCCESS (0.314s)
[115.522327] Starting dynamic subtest: pipe-D
[115.853422] Dynamic subtest pipe-D: SUCCESS (0.351s)
[115.854451] Subtest plane-upscale-20x20-with-pixel-format: SUCCESS (4.034s)
[116.210695] [024/133] (909s left) kms_color (ctm-negative)
[116.392777] Starting subtest: ctm-negative
[116.393640] Starting dynamic subtest: pipe-A-DP-3
[117.072270] Dynamic subtest pipe-A-DP-3: SUCCESS (0.678s)
[117.097633] Starting dynamic subtest: pipe-B-DP-3
[117.692809] Dynamic subtest pipe-B-DP-3: SUCCESS (0.619s)
[117.704857] Starting dynamic subtest: pipe-C-DP-3
[118.265257] Dynamic subtest pipe-C-DP-3: SUCCESS (0.573s)
[118.277221] Starting dynamic subtest: pipe-D-DP-3
[118.876770] Dynamic subtest pipe-D-DP-3: SUCCESS (0.610s)
[118.877625] Subtest ctm-negative: SUCCESS (2.483s)
[119.205214] [025/133] (906s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-mmap-cpu)
[119.388449] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-mmap-cpu
[119.390117] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[119.573725] [026/133] (906s left) kms_addfb_basic (too-wide)
[119.752575] Starting subtest: too-wide
[119.753457] Subtest too-wide: SUCCESS (0.000s)
[119.903816] [027/133] (905s left) syncobj_basic (bad-flags-fd-to-handle)
[119.971302] Starting subtest: bad-flags-fd-to-handle
[119.972207] Subtest bad-flags-fd-to-handle: SUCCESS (0.000s)
[120.145656] [028/133] (905s left) kms_ccs (crc-primary-rotation-180-y-tiled-gen12-rc-ccs)
[120.322157] Starting subtest: crc-primary-rotation-180-y-tiled-gen12-rc-ccs
[120.323055] Starting dynamic subtest: pipe-A-DP-3
[120.331440] Dynamic subtest pipe-A-DP-3: SKIP (0.001s)
[120.341458] Starting dynamic subtest: pipe-B-DP-3
[120.349879] Dynamic subtest pipe-B-DP-3: SKIP (0.001s)
[120.359715] Starting dynamic subtest: pipe-C-DP-3
[120.367740] Dynamic subtest pipe-C-DP-3: SKIP (0.001s)
[120.377654] Starting dynamic subtest: pipe-D-DP-3
[120.387777] Dynamic subtest pipe-D-DP-3: SKIP (0.001s)
[120.389561] Subtest crc-primary-rotation-180-y-tiled-gen12-rc-ccs: SKIP (0.007s)
[120.799318] [029/133] (905s left) kms_big_fb (linear-16bpp-rotate-270)
[120.991259] Starting subtest: linear-16bpp-rotate-270
[121.053608] Subtest linear-16bpp-rotate-270: SKIP (0.062s)
[121.280317] [030/133] (904s left) kms_pm_rpm (legacy-planes-dpms)
[123.079682] Starting subtest: legacy-planes-dpms
[123.081550] Starting dynamic subtest: plane-64
[125.902694] Dynamic subtest plane-64: SUCCESS (2.822s)
[125.943408] Starting dynamic subtest: plane-94
[128.764157] Dynamic subtest plane-94: SUCCESS (2.859s)
[128.807335] Starting dynamic subtest: plane-124
[131.552520] Dynamic subtest plane-124: SUCCESS (2.786s)
[131.564760] Starting dynamic subtest: plane-134
[134.445779] Dynamic subtest plane-134: SUCCESS (2.873s)
[134.457867] Subtest legacy-planes-dpms: SUCCESS (11.350s)
[134.851416] [031/133] (891s left) syncobj_timeline (multi-wait-all-available-signaled)
[134.923166] Starting subtest: multi-wait-all-available-signaled
[134.924043] Subtest multi-wait-all-available-signaled: SUCCESS (0.001s)
[135.068834] [032/133] (891s left) gem_pxp (create-regular-buffer)
[137.665283] Starting subtest: create-regular-buffer
[137.667131] Subtest create-regular-buffer: SKIP (0.000s)
[137.799773] [033/133] (888s left) gem_userptr_blits (sync-overlap)
[137.880433] Starting subtest: sync-overlap
[137.881345] Subtest sync-overlap: SUCCESS (0.000s)
[138.049532] [034/133] (888s left) kms_cursor_crc (cursor-offscreen-256x85)
[138.465129] Starting subtest: cursor-offscreen-256x85
[138.469578] Starting dynamic subtest: pipe-A-DP-3
[141.033819] Dynamic subtest pipe-A-DP-3: SUCCESS (2.564s)
[141.083198] Starting dynamic subtest: pipe-D-DP-3
[143.529144] Dynamic subtest pipe-D-DP-3: SUCCESS (2.455s)
[143.530132] Subtest cursor-offscreen-256x85: SUCCESS (5.064s)
[143.905280] [035/133] (882s left) kms_vblank (wait-forked-hang)
[144.085049] Starting subtest: wait-forked-hang
[144.085964] Starting dynamic subtest: pipe-A-DP-3
[170.574492] Dynamic subtest pipe-A-DP-3: SUCCESS (26.488s)
[170.587690] Starting dynamic subtest: pipe-D-DP-3
[195.569572] Dynamic subtest pipe-D-DP-3: SUCCESS (24.990s)
[195.570495] Subtest wait-forked-hang: SUCCESS (51.484s)
[195.870748] [036/133] (830s left) gem_exec_reloc (basic-wc-active)
[195.950802] Subtest basic-wc-active: SKIP (0.000s)
[196.030903] [037/133] (830s left) kms_ccs (ccs-on-another-bo-4-tiled-mtl-rc-ccs)
[196.215234] Starting subtest: ccs-on-another-bo-4-tiled-mtl-rc-ccs
[196.216150] Starting dynamic subtest: pipe-A-DP-3
[196.224264] Dynamic subtest pipe-A-DP-3: SKIP (0.000s)
[196.234431] Starting dynamic subtest: pipe-B-DP-3
[196.242772] Dynamic subtest pipe-B-DP-3: SKIP (0.000s)
[196.252761] Starting dynamic subtest: pipe-C-DP-3
[196.260848] Dynamic subtest pipe-C-DP-3: SKIP (0.000s)
[196.270672] Starting dynamic subtest: pipe-D-DP-3
[196.281032] Dynamic subtest pipe-D-DP-3: SKIP (0.000s)
[196.282925] Subtest ccs-on-another-bo-4-tiled-mtl-rc-ccs: SKIP (0.005s)
[196.699835] [038/133] (829s left) kms_flip (2x-dpms-vs-vblank-race)
[196.892019] Starting subtest: 2x-dpms-vs-vblank-race
[196.906678] Subtest 2x-dpms-vs-vblank-race: SKIP (0.014s)
[197.069498] [039/133] (829s left) kms_psr2_sf (fbc-pr-cursor-plane-move-continuous-exceed-fully-sf)
[197.248523] Subtest fbc-pr-cursor-plane-move-continuous-exceed-fully-sf: SKIP (0.000s)
[197.307591] [040/133] (829s left) kms_atomic (plane-cursor-legacy)
[197.485309] Starting subtest: plane-cursor-legacy
[197.486196] Starting dynamic subtest: pipe-A-DP-3
[198.009611] Dynamic subtest pipe-A-DP-3: SUCCESS (0.523s)
[198.010474] Subtest plane-cursor-legacy: SUCCESS (0.525s)
[198.324351] [041/133] (828s left) gem_partial_pwrite_pread (write-uncached)
[198.398288] Subtest write-uncached: SKIP (0.000s)
[198.465898] [042/133] (828s left) gem_create (create-ext-cpu-access-sanity-check)
[198.649745] Starting subtest: create-ext-cpu-access-sanity-check
[198.675497] Subtest create-ext-cpu-access-sanity-check: SUCCESS (0.028s)
[198.905226] [043/133] (827s left) gem_mmap_gtt (zero-extend)
[198.973160] Subtest zero-extend: SKIP (0.000s)
[199.034930] [044/133] (827s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-16bpp-ytile-downscaling)
[199.212135] Starting subtest: flip-64bpp-ytile-to-16bpp-ytile-downscaling
[199.213944] Subtest flip-64bpp-ytile-to-16bpp-ytile-downscaling: SKIP (0.000s)
[199.348500] [045/133] (827s left) api_intel_allocator (fork-simple-stress)
[199.416178] Starting subtest: fork-simple-stress
[204.828571] Subtest fork-simple-stress: SUCCESS (5.412s)
[205.066664] [046/133] (822s left) kms_big_fb (y-tiled-64bpp-rotate-180)
[205.252267] Starting subtest: y-tiled-64bpp-rotate-180
[205.254076] Subtest y-tiled-64bpp-rotate-180: SKIP (0.000s)
[205.448385] [047/133] (821s left) gem_render_copy (yf-tiled-to-vebox-y-tiled)
[205.525536] Starting subtest: yf-tiled-to-vebox-y-tiled
[205.527468] Subtest yf-tiled-to-vebox-y-tiled: SKIP (0.000s)
[205.768398] [048/133] (821s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-mmap-wc)
[205.949839] Starting subtest: psr-1p-primscrn-spr-indfb-draw-mmap-wc
[205.951486] Subtest psr-1p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[206.107589] [049/133] (821s left) gem_pxp (protected-encrypted-src-copy-not-readible)
[208.711033] Starting subtest: protected-encrypted-src-copy-not-readible
[208.713415] Subtest protected-encrypted-src-copy-not-readible: SKIP (0.000s)
[208.824486] [050/133] (818s left) i915_pm_rps (basic-api)
[208.901444] Starting subtest: basic-api
[208.903263] Subtest basic-api: SKIP (0.001s)
[209.011933] [051/133] (818s left) gem_busy (busy)
[209.093491] Starting subtest: busy
[209.094603] Starting dynamic subtest: all-engines
[209.198554] Dynamic subtest all-engines: SUCCESS (0.105s)
[209.210769] Starting dynamic subtest: rcs0
[209.300379] Dynamic subtest rcs0: SUCCESS (0.101s)
[209.311222] Starting dynamic subtest: bcs0
[209.358793] Dynamic subtest bcs0: SUCCESS (0.057s)
[209.384249] Starting dynamic subtest: vcs0
[209.401325] Dynamic subtest vcs0: SUCCESS (0.042s)
[209.430803] Starting dynamic subtest: vcs1
[209.444410] Dynamic subtest vcs1: SUCCESS (0.041s)
[209.471063] Starting dynamic subtest: vecs0
[209.486287] Dynamic subtest vecs0: SUCCESS (0.040s)
[209.501872] Starting dynamic subtest: vecs1
[209.527200] Dynamic subtest vecs1: SUCCESS (0.040s)
[209.541188] Starting dynamic subtest: ccs0
[209.566481] Dynamic subtest ccs0: SUCCESS (0.038s)
[209.567523] Subtest busy: SUCCESS (0.473s)
[210.040105] [052/133] (817s left) kms_dp_link_training (non-uhbr-sst)
[210.217055] Starting subtest: non-uhbr-sst
[212.393156] Subtest non-uhbr-sst: SUCCESS (2.168s)
[212.602305] [053/133] (814s left) gem_unfence_active_buffers
[212.831030] [054/133] (814s left) kms_dsc (dsc-with-formats)
[213.007683] Starting subtest: dsc-with-formats
[213.023662] Subtest dsc-with-formats: SKIP (0.002s)
[213.141543] [055/133] (814s left) kms_plane_scaling (plane-downscale-factor-0-75-with-rotation)
[213.321125] Starting subtest: plane-downscale-factor-0-75-with-rotation
[213.321862] Starting dynamic subtest: pipe-A
[213.689801] Dynamic subtest pipe-A: SUCCESS (0.369s)
[213.716547] Starting dynamic subtest: pipe-B
[214.169390] Dynamic subtest pipe-B: SUCCESS (0.478s)
[214.187797] Starting dynamic subtest: pipe-C
[214.650571] Dynamic subtest pipe-C: SUCCESS (0.480s)
[214.665625] Starting dynamic subtest: pipe-D
[215.114504] Dynamic subtest pipe-D: SUCCESS (0.463s)
[215.115661] Subtest plane-downscale-factor-0-75-with-rotation: SUCCESS (1.795s)
[215.489109] [056/133] (812s left) kms_cursor_legacy (cursor-vs-flip-toggle)
[215.671165] Starting subtest: cursor-vs-flip-toggle
[248.435457] Subtest cursor-vs-flip-toggle: SUCCESS (32.764s)
[248.725550] [057/133] (779s left) kms_psr (fbc-psr-cursor-blt)
[248.901427] Subtest fbc-psr-cursor-blt: SKIP (0.000s)
[248.957016] [058/133] (778s left) gem_ctx_exec (basic)
[249.032223] Starting subtest: basic
[249.037531] Subtest basic: SUCCESS (0.006s)
[249.225699] [059/133] (778s left) gem_sync (basic-store-all)
[249.304778] Starting subtest: basic-store-all
[253.755457] Subtest basic-store-all: SUCCESS (4.450s)
[253.996970] [060/133] (773s left) kms_flip (2x-blocking-wf_vblank)
[254.175263] Starting subtest: 2x-blocking-wf_vblank
[254.190262] Subtest 2x-blocking-wf_vblank: SKIP (0.014s)
[254.346511] [061/133] (773s left) kms_ccs (bad-pixel-format-4-tiled-dg2-mc-ccs)
[254.522327] Starting subtest: bad-pixel-format-4-tiled-dg2-mc-ccs
[254.523227] Starting dynamic subtest: pipe-A-DP-3
[254.531575] Dynamic subtest pipe-A-DP-3: SKIP (0.000s)
[254.542115] Starting dynamic subtest: pipe-B-DP-3
[254.550507] Dynamic subtest pipe-B-DP-3: SKIP (0.000s)
[254.560907] Starting dynamic subtest: pipe-C-DP-3
[254.569112] Dynamic subtest pipe-C-DP-3: SKIP (0.000s)
[254.579629] Starting dynamic subtest: pipe-D-DP-3
[254.590377] Dynamic subtest pipe-D-DP-3: SKIP (0.000s)
[254.592477] Subtest bad-pixel-format-4-tiled-dg2-mc-ccs: SKIP (0.006s)
[255.005184] [062/133] (773s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-move)
[255.187970] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-move
[255.189714] Subtest fbcpsr-2p-scndscrn-cur-indfb-move: SKIP (0.000s)
[255.389862] [063/133] (772s left) gem_ctx_persistence (idempotent)
[255.469833] Starting subtest: idempotent
[255.470928] Subtest idempotent: SUCCESS (0.000s)
[255.612836] [064/133] (772s left) gem_flink_basic (basic)
[255.680277] Starting subtest: basic
[255.681201] Subtest basic: SUCCESS (0.000s)
[255.854868] [065/133] (772s left) kms_plane (pixel-format-4-tiled-mtl-mc-ccs-modifier)
[256.030390] Starting subtest: pixel-format-4-tiled-mtl-mc-ccs-modifier
[256.032127] Subtest pixel-format-4-tiled-mtl-mc-ccs-modifier: SKIP (0.000s)
[256.160914] [066/133] (772s left) kms_cursor_crc (cursor-random-512x512)
[256.603944] Starting subtest: cursor-random-512x512
[256.605581] Subtest cursor-random-512x512: SKIP (0.001s)
[256.862053] [067/133] (771s left) kms_chamelium_hpd (vga-hpd-enable-disable-mode)
[257.146076] Subtest vga-hpd-enable-disable-mode: SKIP (0.000s)
[257.304081] [068/133] (771s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-onoff)
[257.488969] Starting subtest: fbc-2p-primscrn-cur-indfb-onoff
[257.490638] Subtest fbc-2p-primscrn-cur-indfb-onoff: SKIP (0.000s)
[257.679511] [069/133] (770s left) kms_frontbuffer_tracking (psr-rgb565-draw-render)
[257.862887] Starting subtest: psr-rgb565-draw-render
[257.864561] Subtest psr-rgb565-draw-render: SKIP (0.000s)
[258.059607] [070/133] (770s left) perf (unprivileged-single-ctx-counters)
[258.503286] Starting subtest: unprivileged-single-ctx-counters
[258.504986] Subtest unprivileged-single-ctx-counters: SKIP (0.000s)
[258.558639] [071/133] (770s left) kms_cursor_edge_walk (128x128-top-edge)
[258.738581] Starting subtest: 128x128-top-edge
[258.740836] Starting dynamic subtest: pipe-A-DP-3
[262.223932] Dynamic subtest pipe-A-DP-3: SUCCESS (3.483s)
[262.234527] Starting dynamic subtest: pipe-D-DP-3
[265.549915] Dynamic subtest pipe-D-DP-3: SUCCESS (3.324s)
[265.550935] Subtest 128x128-top-edge: SUCCESS (6.811s)
[265.858585] [072/133] (762s left) i915_drm_fdinfo (memory-info-resident)
[265.920338] Starting subtest: memory-info-resident
[265.921263] Starting dynamic subtest: lmem0
[269.595948] Dynamic subtest lmem0: SUCCESS (3.675s)
[269.607177] Starting dynamic subtest: smem0
[273.839163] Dynamic subtest smem0: SUCCESS (4.242s)
[273.840142] Subtest memory-info-resident: SUCCESS (7.919s)
[273.997410] [073/133] (754s left) kms_pm_rpm (dpms-lpsp)
[276.109989] Starting subtest: dpms-lpsp
[276.112375] Subtest dpms-lpsp: SKIP (0.001s)
[276.532904] [074/133] (752s left) kms_cursor_legacy (cursora-vs-flipa-legacy)
[276.710264] Starting subtest: cursorA-vs-flipA-legacy
[287.663533] Subtest cursorA-vs-flipA-legacy: SUCCESS (10.953s)
[287.965368] [075/133] (741s left) gen9_exec_parse (allowed-single)
[288.043437] Subtest allowed-single: SKIP (0.000s)
[288.116694] [076/133] (740s left) kms_ccs (missing-ccs-buffer-yf-tiled-ccs)
[288.293922] Starting subtest: missing-ccs-buffer-yf-tiled-ccs
[288.296177] Starting dynamic subtest: pipe-A-DP-3
[288.304859] Dynamic subtest pipe-A-DP-3: SKIP (0.000s)
[288.315441] Starting dynamic subtest: pipe-B-DP-3
[288.323787] Dynamic subtest pipe-B-DP-3: SKIP (0.000s)
[288.334195] Starting dynamic subtest: pipe-C-DP-3
[288.342216] Dynamic subtest pipe-C-DP-3: SKIP (0.000s)
[288.352756] Starting dynamic subtest: pipe-D-DP-3
[288.362780] Dynamic subtest pipe-D-DP-3: SKIP (0.000s)
[288.364917] Subtest missing-ccs-buffer-yf-tiled-ccs: SKIP (0.007s)
[288.759643] [077/133] (740s left) kms_big_fb (4-tiled-32bpp-rotate-180)
[288.959410] Starting subtest: 4-tiled-32bpp-rotate-180
[290.769197] Subtest 4-tiled-32bpp-rotate-180: SUCCESS (1.809s)
[291.031908] [078/133] (738s left) kms_lease (simple-lease)
[291.210404] Starting subtest: simple-lease
[291.211267] Starting dynamic subtest: pipe-A-DP-3
[291.678509] Dynamic subtest pipe-A-DP-3: SUCCESS (0.467s)
[291.696156] Starting dynamic subtest: pipe-B-DP-3
[292.086144] Dynamic subtest pipe-B-DP-3: SUCCESS (0.403s)
[292.098580] Starting dynamic subtest: pipe-C-DP-3
[292.489385] Dynamic subtest pipe-C-DP-3: SUCCESS (0.401s)
[292.502552] Starting dynamic subtest: pipe-D-DP-3
[292.875506] Dynamic subtest pipe-D-DP-3: SUCCESS (0.385s)
[292.876458] Subtest simple-lease: SUCCESS (1.667s)
[293.177880] [079/133] (736s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite)
[293.359202] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite
[293.360938] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[293.517121] [080/133] (735s left) gem_userptr_blits (create-destroy-sync)
[293.606910] Starting subtest: create-destroy-sync
[298.620795] Subtest create-destroy-sync: SUCCESS (5.014s)
[298.791073] [081/133] (730s left) gem_exec_whisper (basic-queues-priority)
[298.873494] Starting subtest: basic-queues-priority
[321.355516] Subtest basic-queues-priority: SUCCESS (22.480s)
[321.637966] [082/133] (707s left) gem_exec_fence (expired-history)
[322.153169] Starting subtest: expired-history
[328.835168] Subtest expired-history: SUCCESS (6.682s)
[330.390530] [FACT gem_exec_fence (expired-history)] new: kernel.kmod_is_loaded.vgem: true
[330.392631] [083/133] (699s left) gem_exec_gttfill (all-engines)
[330.482765] Starting subtest: all-engines
[356.566902] Subtest all-engines: SUCCESS (26.084s)
[356.836961] [084/133] (672s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-render)
[357.075131] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-render
[357.076837] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-render: SKIP (0.000s)
[357.265668] [085/133] (672s left) syncobj_timeline (reset-during-wait-for-submit)
[357.351395] Starting subtest: reset-during-wait-for-submit
[357.454384] Subtest reset-during-wait-for-submit: SUCCESS (0.102s)
[357.609531] [086/133] (672s left) kms_vblank (query-forked)
[357.798289] Starting subtest: query-forked
[357.799194] Starting dynamic subtest: pipe-A-DP-3
[360.144893] Dynamic subtest pipe-A-DP-3: SUCCESS (2.345s)
[360.167937] Starting dynamic subtest: pipe-D-DP-3
[362.490976] Dynamic subtest pipe-D-DP-3: SUCCESS (2.341s)
[362.491916] Subtest query-forked: SUCCESS (4.694s)
[362.763464] [087/133] (667s left) i915_selftest (mock)
[363.901410] Starting subtest: mock
[363.902355] Starting dynamic subtest: sanitycheck
[364.757515] Dynamic subtest sanitycheck: SUCCESS (0.855s)
[364.789969] Starting dynamic subtest: shmem
[365.600480] Dynamic subtest shmem: SUCCESS (0.839s)
[365.635885] Starting dynamic subtest: fence
[373.996414] Dynamic subtest fence: SUCCESS (8.392s)
[374.011068] Starting dynamic subtest: scatterlist
[375.821450] Dynamic subtest scatterlist: SUCCESS (1.822s)
[375.838814] Starting dynamic subtest: syncmap
[378.719105] Dynamic subtest syncmap: SUCCESS (2.894s)
[378.731069] Starting dynamic subtest: uncore
[379.565447] Dynamic subtest uncore: SUCCESS (0.843s)
[379.597538] Starting dynamic subtest: ring
[380.416613] Dynamic subtest ring: SUCCESS (0.847s)
[380.450342] Starting dynamic subtest: engine
[381.273690] Dynamic subtest engine: SUCCESS (0.853s)
[381.307064] Starting dynamic subtest: timelines
[385.911168] Dynamic subtest timelines: SUCCESS (4.634s)
[385.930050] Starting dynamic subtest: requests
[388.748869] Dynamic subtest requests: SUCCESS (2.836s)
[388.758037] Starting dynamic subtest: objects
[389.719886] Dynamic subtest objects: SUCCESS (0.970s)
[389.730668] Starting dynamic subtest: phys
[390.709906] Dynamic subtest phys: SUCCESS (0.989s)
[390.723373] Starting dynamic subtest: dmabuf
[391.682854] Dynamic subtest dmabuf: SUCCESS (0.972s)
[391.694523] Starting dynamic subtest: vma
[399.965990] Dynamic subtest vma: SUCCESS (8.282s)
[399.976633] Starting dynamic subtest: evict
[401.784256] Dynamic subtest evict: SUCCESS (1.817s)
[401.800692] Starting dynamic subtest: gtt
[405.695894] Dynamic subtest gtt: SUCCESS (3.910s)
[405.707046] Starting dynamic subtest: hugepages
[406.809846] Dynamic subtest hugepages: SUCCESS (1.113s)
[406.819918] Starting dynamic subtest: memory_region
[410.267252] Dynamic subtest memory_region: SUCCESS (3.456s)
[410.268367] Subtest mock: SUCCESS (46.366s)
[410.302803] [FACT i915_selftest (mock)] deleted: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[410.303906] [FACT i915_selftest (mock)] deleted: kernel.kmod_is_loaded.i915: true
[410.305946] [088/133] (619s left) perf_pmu (busy-check-all)
[411.997811] Starting subtest: busy-check-all
[411.998839] Starting dynamic subtest: rcs0
[412.598487] Dynamic subtest rcs0: SUCCESS (0.601s)
[412.628952] Starting dynamic subtest: bcs0
[413.168176] Dynamic subtest bcs0: SUCCESS (0.567s)
[413.182358] Starting dynamic subtest: vcs0
[413.723350] Dynamic subtest vcs0: SUCCESS (0.551s)
[413.741696] Starting dynamic subtest: vcs1
[414.282331] Dynamic subtest vcs1: SUCCESS (0.554s)
[414.296364] Starting dynamic subtest: vecs0
[414.837444] Dynamic subtest vecs0: SUCCESS (0.551s)
[414.851495] Starting dynamic subtest: vecs1
[415.392522] Dynamic subtest vecs1: SUCCESS (0.551s)
[415.411187] Starting dynamic subtest: ccs0
[415.953209] Dynamic subtest ccs0: SUCCESS (0.556s)
[415.958035] Subtest busy-check-all: SUCCESS (3.959s)
[416.053184] [FACT perf_pmu (busy-check-all)] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[416.055747] [FACT perf_pmu (busy-check-all)] new: kernel.kmod_is_loaded.i915: true
[416.058378] [089/133] (613s left) gem_exec_params (no-blt)
[416.142964] Starting subtest: no-blt
[416.145160] Subtest no-blt: SUCCESS (0.001s)
[416.357702] [090/133] (613s left) kms_multipipe_modeset (basic-max-pipe-crc-check)
[416.548751] Starting subtest: basic-max-pipe-crc-check
[416.550566] Subtest basic-max-pipe-crc-check: SKIP (0.000s)
[416.602647] [091/133] (613s left) perf (gen8-unprivileged-single-ctx-counters)
[417.047982] Starting subtest: gen8-unprivileged-single-ctx-counters
[417.049671] Subtest gen8-unprivileged-single-ctx-counters: SKIP (0.000s)
[417.107163] [092/133] (613s left) kms_rotation_crc (cursor-rotation-180)
[417.294419] Starting subtest: cursor-rotation-180
[418.145560] Subtest cursor-rotation-180: SUCCESS (0.851s)
[418.585677] [093/133] (611s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-shrfb-plflip-blt)
[418.775936] Starting subtest: fbc-2p-scndscrn-shrfb-plflip-blt
[418.777631] Subtest fbc-2p-scndscrn-shrfb-plflip-blt: SKIP (0.000s)
[418.989033] [094/133] (611s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-pwrite)
[419.179058] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-pwrite
[419.180864] Subtest fbc-2p-scndscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[419.370586] [095/133] (611s left) kms_addfb_basic (framebuffer-vs-set-tiling)
[419.453768] Starting subtest: framebuffer-vs-set-tiling
[419.455431] Subtest framebuffer-vs-set-tiling: SKIP (0.000s)
[419.754404] [096/133] (610s left) gem_exec_fence (syncobj-timeline-multiple-ext-nodes)
[420.416689] Starting subtest: syncobj-timeline-multiple-ext-nodes
[420.418312] Subtest syncobj-timeline-multiple-ext-nodes: SUCCESS (0.006s)
[420.734631] [097/133] (609s left) kms_flip (2x-nonexisting-fb-interruptible)
[420.929305] Starting subtest: 2x-nonexisting-fb-interruptible
[420.943428] Subtest 2x-nonexisting-fb-interruptible: SKIP (0.015s)
[421.106373] [098/133] (609s left) kms_psr (psr2-sprite-plane-move)
[421.299830] Subtest psr2-sprite-plane-move: SKIP (0.000s)
[421.348465] [099/133] (609s left) kms_psr (fbc-psr2-cursor-plane-move)
[421.536821] Subtest fbc-psr2-cursor-plane-move: SKIP (0.000s)
[421.600253] [100/133] (609s left) kms_rotation_crc (bad-pixel-format)
[421.788715] Starting subtest: bad-pixel-format
[421.791854] Subtest bad-pixel-format: SKIP (0.001s)
[421.977573] [101/133] (608s left) kms_invalid_mode (bad-vsync-end)
[422.162537] Starting subtest: bad-vsync-end
[422.163414] Starting dynamic subtest: pipe-A-DP-3
[422.247536] Dynamic subtest pipe-A-DP-3: SUCCESS (0.084s)
[422.263229] Starting dynamic subtest: pipe-B-DP-3
[422.264499] Dynamic subtest pipe-B-DP-3: SUCCESS (0.001s)
[422.278286] Starting dynamic subtest: pipe-C-DP-3
[422.279545] Dynamic subtest pipe-C-DP-3: SUCCESS (0.001s)
[422.292065] Starting dynamic subtest: pipe-D-DP-3
[422.293010] Dynamic subtest pipe-D-DP-3: SUCCESS (0.001s)
[422.293931] Subtest bad-vsync-end: SUCCESS (0.095s)
[422.539541] [102/133] (608s left) gem_exec_schedule (preempt-user)
[422.632195] Starting subtest: preempt-user
[422.633170] Starting dynamic subtest: rcs0
[422.699516] Dynamic subtest rcs0: SUCCESS (0.067s)
[422.711715] Starting dynamic subtest: bcs0
[422.735790] Dynamic subtest bcs0: SUCCESS (0.035s)
[422.748298] Starting dynamic subtest: vcs0
[422.771945] Dynamic subtest vcs0: SUCCESS (0.035s)
[422.784548] Starting dynamic subtest: vcs1
[422.809843] Dynamic subtest vcs1: SUCCESS (0.037s)
[422.821572] Starting dynamic subtest: vecs0
[422.845377] Dynamic subtest vecs0: SUCCESS (0.035s)
[422.857991] Starting dynamic subtest: vecs1
[422.881248] Dynamic subtest vecs1: SUCCESS (0.035s)
[422.894095] Starting dynamic subtest: ccs0
[422.918621] Dynamic subtest ccs0: SUCCESS (0.036s)
[422.919492] Subtest preempt-user: SUCCESS (0.287s)
[423.403653] [103/133] (607s left) syncobj_wait (wait-zero-handles)
[423.480353] Starting subtest: wait-zero-handles
[423.481306] Subtest wait-zero-handles: SUCCESS (0.000s)
[423.622280] [104/133] (607s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size)
[423.810295] Starting subtest: basic-flip-before-cursor-varying-size
[424.875405] Subtest basic-flip-before-cursor-varying-size: SUCCESS (1.064s)
[425.184057] [105/133] (606s left) gem_softpin (softpin)
[425.273877] Starting subtest: softpin
[457.613932] Subtest softpin: SUCCESS (32.339s)
[457.783136] [106/133] (573s left) kms_cursor_legacy (2x-cursor-vs-flip-legacy)
[457.965837] Starting subtest: 2x-cursor-vs-flip-legacy
[457.969204] Subtest 2x-cursor-vs-flip-legacy: SKIP (0.002s)
[458.115354] [107/133] (573s left) kms_getfb (getfb-reject-nv12)
[458.304994] Starting subtest: getfb-reject-nv12
[458.307336] Subtest getfb-reject-nv12: SUCCESS (0.002s)
[458.484514] [108/133] (572s left) gem_ctx_persistence (engines-persistence)
[458.571545] Starting subtest: engines-persistence
[458.572592] Starting dynamic subtest: rcs0
[459.404759] Dynamic subtest rcs0: SUCCESS (0.834s)
[459.419235] Starting dynamic subtest: bcs0
[460.161414] Dynamic subtest bcs0: SUCCESS (0.754s)
[460.177295] Starting dynamic subtest: vcs0
[460.932211] Dynamic subtest vcs0: SUCCESS (0.768s)
[460.947084] Starting dynamic subtest: vcs1
[461.709160] Dynamic subtest vcs1: SUCCESS (0.772s)
[461.723504] Starting dynamic subtest: vecs0
[462.481193] Dynamic subtest vecs0: SUCCESS (0.767s)
[462.495645] Starting dynamic subtest: vecs1
[463.311219] Dynamic subtest vecs1: SUCCESS (0.826s)
[463.326171] Starting dynamic subtest: ccs0
[464.135205] Dynamic subtest ccs0: SUCCESS (0.819s)
[464.139716] Subtest engines-persistence: SUCCESS (5.567s)
[464.366194] [109/133] (567s left) gem_tiled_blits (basic)
[464.452876] Subtest basic: SKIP (0.000s)
[464.569873] [110/133] (567s left) kms_chamelium_color (ctm-green-to-red)
[464.753322] Subtest ctm-green-to-red: SKIP (0.000s)
[464.874118] [111/133] (566s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytile-upscaling)
[465.058753] Starting subtest: flip-64bpp-ytile-to-32bpp-ytile-upscaling
[465.060421] Subtest flip-64bpp-ytile-to-32bpp-ytile-upscaling: SKIP (0.000s)
[465.225062] [112/133] (566s left) syncobj_timeline (etime-multi-wait-all-for-submit-available-unsubmitted-submi
[465.301521] Starting subtest: etime-multi-wait-all-for-submit-available-unsubmitted-submitted
[465.405085] Subtest etime-multi-wait-all-for-submit-available-unsubmitted-submitted: SUCCESS (0.103s)
[465.565266] [113/133] (566s left) syncobj_timeline (etime-multi-wait-for-submit-available-unsubmitted)
[465.642928] Starting subtest: etime-multi-wait-for-submit-available-unsubmitted
[465.750571] Subtest etime-multi-wait-for-submit-available-unsubmitted: SUCCESS (0.106s)
[465.916684] [114/133] (566s left) gem_ctx_shared (disjoint-timelines)
[466.007365] Starting subtest: disjoint-timelines
[466.052603] Subtest disjoint-timelines: SUCCESS (0.045s)
[466.352414] [115/133] (565s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-32bpp-yftileccs-downscaling)
[466.537285] Starting subtest: flip-32bpp-yftile-to-32bpp-yftileccs-downscaling
[466.539031] Subtest flip-32bpp-yftile-to-32bpp-yftileccs-downscaling: SKIP (0.000s)
[466.672419] [116/133] (565s left) kms_properties (get_properties-sanity-atomic)
[466.857275] Starting subtest: get_properties-sanity-atomic
[466.859587] Subtest get_properties-sanity-atomic: SUCCESS (0.003s)
[466.984818] [117/133] (565s left) kms_addfb_basic (basic-x-tiled-legacy)
[467.061541] Starting subtest: basic-x-tiled-legacy
[467.063236] Subtest basic-x-tiled-legacy: SKIP (0.000s)
[467.366464] [118/133] (564s left) kms_big_fb (yf-tiled-64bpp-rotate-180)
[467.572169] Starting subtest: yf-tiled-64bpp-rotate-180
[467.573994] Subtest yf-tiled-64bpp-rotate-180: SKIP (0.000s)
[467.764885] [119/133] (564s left) kms_content_protection (lic-type-0-hdcp14)
[468.016761] Starting subtest: lic-type-0-hdcp14
[468.051553] Starting dynamic subtest: pipe-A-DP-3
[589.194037] Dynamic subtest pipe-A-DP-3: FAIL (120.974s)
[589.194872] Subtest lic-type-0-hdcp14: FAIL (121.100s)
[589.410045] [120/133] (442s left) perf_pmu (all-busy-check-all)
[589.479974] Starting subtest: all-busy-check-all
[590.076824] Subtest all-busy-check-all: SUCCESS (0.596s)
[590.274775] [121/133] (442s left) syncobj_timeline (single-wait-all-available-submitted)
[590.355362] Starting subtest: single-wait-all-available-submitted
[590.356279] Subtest single-wait-all-available-submitted: SUCCESS (0.000s)
[590.526538] [122/133] (442s left) prime_vgem (basic-write)
[590.614495] Starting subtest: basic-write
[590.626391] Subtest basic-write: SKIP (0.011s)
[590.791349] [123/133] (441s left) kms_big_fb (x-tiled-16bpp-rotate-90)
[590.984056] Starting subtest: x-tiled-16bpp-rotate-90
[591.045223] Subtest x-tiled-16bpp-rotate-90: SKIP (0.060s)
[591.244891] [124/133] (441s left) kms_cursor_legacy (2x-cursor-vs-flip-atomic)
[591.436281] Starting subtest: 2x-cursor-vs-flip-atomic
[591.438036] Subtest 2x-cursor-vs-flip-atomic: SKIP (0.002s)
[591.597154] [125/133] (441s left) gem_tiled_pread_basic (basic)
[591.672195] Subtest basic: SKIP (0.000s)
[591.737909] [126/133] (441s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-mmap-cpu)
[591.925942] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-mmap-cpu
[591.927639] Subtest psr-2p-scndscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[592.079129] [127/133] (440s left) gem_spin_batch (resubmit-all)
[592.167018] Starting subtest: resubmit-all
[592.168005] Starting dynamic subtest: rcs0
[592.202217] Dynamic subtest rcs0: SUCCESS (0.035s)
[592.215455] Starting dynamic subtest: bcs0
[592.216408] Dynamic subtest bcs0: SUCCESS (0.003s)
[592.227558] Starting dynamic subtest: vcs0
[592.228501] Dynamic subtest vcs0: SUCCESS (0.003s)
[592.239668] Starting dynamic subtest: vcs1
[592.240818] Dynamic subtest vcs1: SUCCESS (0.003s)
[592.251424] Starting dynamic subtest: vecs0
[592.252538] Dynamic subtest vecs0: SUCCESS (0.003s)
[592.263110] Starting dynamic subtest: vecs1
[592.264139] Dynamic subtest vecs1: SUCCESS (0.003s)
[592.274560] Starting dynamic subtest: ccs0
[592.275629] Dynamic subtest ccs0: SUCCESS (0.002s)
[592.276676] Subtest resubmit-all: SUCCESS (0.059s)
[592.576887] [128/133] (440s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-render)
[592.766035] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-render
[592.767725] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-render: SKIP (0.000s)
[592.935896] [129/133] (440s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-mmap-gtt)
[593.128022] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-mmap-gtt
[593.129660] Subtest fbc-1p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[593.309901] [130/133] (439s left) gem_mmap_wc (write-read)
[593.389244] Subtest write-read: SKIP (0.000s)
[593.454526] [131/133] (439s left) perf_pmu (busy-start)
[593.524863] Starting subtest: busy-start
[593.525792] Starting dynamic subtest: rcs0
[596.100690] Dynamic subtest rcs0: SUCCESS (2.574s)
[596.115696] Starting dynamic subtest: bcs0
[598.651799] Dynamic subtest bcs0: SUCCESS (2.546s)
[598.666671] Starting dynamic subtest: vcs0
[601.202653] Dynamic subtest vcs0: SUCCESS (2.546s)
[601.217648] Starting dynamic subtest: vcs1
[603.754686] Dynamic subtest vcs1: SUCCESS (2.547s)
[603.769868] Starting dynamic subtest: vecs0
[606.306813] Dynamic subtest vecs0: SUCCESS (2.547s)
[606.321930] Starting dynamic subtest: vecs1
[608.858819] Dynamic subtest vecs1: SUCCESS (2.547s)
[608.873842] Starting dynamic subtest: ccs0
[611.409678] Dynamic subtest ccs0: SUCCESS (2.546s)
[611.414429] Subtest busy-start: SUCCESS (17.886s)
[611.594109] [132/133] (421s left) gem_exec_balancer (bonded-false-hang)
[611.944971] Starting subtest: bonded-false-hang
[611.946716] Subtest bonded-false-hang: SKIP (0.000s)
[612.137940] [133/133] (421s left) kms_chamelium_frames (hdmi-crc-multiple)
[612.407799] Subtest hdmi-crc-multiple: SKIP (0.000s)
[612.560667] Closing watchdogs
results: parsing output: 0/ for test: core_auth
results: parsing output: 1/ for test: gem_workarounds
results: parsing output: 2/ for test: kms_plane
results: parsing output: 3/ for test: i915_hangman
results: parsing output: 4/ for test: kms_psr2_sf
results: parsing output: 5/ for test: gem_exec_whisper
results: parsing output: 6/ for test: kms_psr2_sf
results: parsing output: 7/ for test: dmabuf
results: parsing output: 8/ for test: gem_render_copy_redux
results: parsing output: 9/ for test: gem_exec_schedule
results: parsing output: 10/ for test: kms_frontbuffer_tracking
results: parsing output: 11/ for test: gem_render_copy
results: parsing output: 12/ for test: kms_busy
results: parsing output: 13/ for test: kms_psr
results: parsing output: 14/ for test: kms_flip
results: parsing output: 15/ for test: kms_frontbuffer_tracking
results: parsing output: 16/ for test: kms_frontbuffer_tracking
results: parsing output: 17/ for test: gem_mmap_gtt
results: parsing output: 18/ for test: perf_pmu
results: parsing output: 19/ for test: kms_rotation_crc
results: parsing output: 20/ for test: kms_big_fb
results: parsing output: 21/ for test: kms_frontbuffer_tracking
results: parsing output: 22/ for test: kms_plane_scaling
results: parsing output: 23/ for test: kms_color
results: parsing output: 24/ for test: kms_frontbuffer_tracking
results: parsing output: 25/ for test: kms_addfb_basic
results: parsing output: 26/ for test: syncobj_basic
results: parsing output: 27/ for test: kms_ccs
results: parsing output: 28/ for test: kms_big_fb
results: parsing output: 29/ for test: kms_pm_rpm
results: parsing output: 30/ for test: syncobj_timeline
results: parsing output: 31/ for test: gem_pxp
results: parsing output: 32/ for test: gem_userptr_blits
results: parsing output: 33/ for test: kms_cursor_crc
results: parsing output: 34/ for test: kms_vblank
results: parsing output: 35/ for test: gem_exec_reloc
results: parsing output: 36/ for test: kms_ccs
results: parsing output: 37/ for test: kms_flip
results: parsing output: 38/ for test: kms_psr2_sf
results: parsing output: 39/ for test: kms_atomic
results: parsing output: 40/ for test: gem_partial_pwrite_pread
results: parsing output: 41/ for test: gem_create
results: parsing output: 42/ for test: gem_mmap_gtt
results: parsing output: 43/ for test: kms_flip_scaled_crc
results: parsing output: 44/ for test: api_intel_allocator
results: parsing output: 45/ for test: kms_big_fb
results: parsing output: 46/ for test: gem_render_copy
results: parsing output: 47/ for test: kms_frontbuffer_tracking
results: parsing output: 48/ for test: gem_pxp
results: parsing output: 49/ for test: i915_pm_rps
results: parsing output: 50/ for test: gem_busy
results: parsing output: 51/ for test: kms_dp_link_training
results: parsing output: 52/ for test: gem_unfence_active_buffers
results: parsing output: 53/ for test: kms_dsc
results: parsing output: 54/ for test: kms_plane_scaling
results: parsing output: 55/ for test: kms_cursor_legacy
results: parsing output: 56/ for test: kms_psr
results: parsing output: 57/ for test: gem_ctx_exec
results: parsing output: 58/ for test: gem_sync
results: parsing output: 59/ for test: kms_flip
results: parsing output: 60/ for test: kms_ccs
results: parsing output: 61/ for test: kms_frontbuffer_tracking
results: parsing output: 62/ for test: gem_ctx_persistence
results: parsing output: 63/ for test: gem_flink_basic
results: parsing output: 64/ for test: kms_plane
results: parsing output: 65/ for test: kms_cursor_crc
results: parsing output: 66/ for test: kms_chamelium_hpd
results: parsing output: 67/ for test: kms_frontbuffer_tracking
results: parsing output: 68/ for test: kms_frontbuffer_tracking
results: parsing output: 69/ for test: perf
results: parsing output: 70/ for test: kms_cursor_edge_walk
results: parsing output: 71/ for test: i915_drm_fdinfo
results: parsing output: 72/ for test: kms_pm_rpm
results: parsing output: 73/ for test: kms_cursor_legacy
results: parsing output: 74/ for test: gen9_exec_parse
results: parsing output: 75/ for test: kms_ccs
results: parsing output: 76/ for test: kms_big_fb
results: parsing output: 77/ for test: kms_lease
results: parsing output: 78/ for test: kms_frontbuffer_tracking
results: parsing output: 79/ for test: gem_userptr_blits
results: parsing output: 80/ for test: gem_exec_whisper
results: parsing output: 81/ for test: gem_exec_fence
results: parsing output: 82/ for test: gem_exec_gttfill
results: parsing output: 83/ for test: kms_frontbuffer_tracking
results: parsing output: 84/ for test: syncobj_timeline
results: parsing output: 85/ for test: kms_vblank
results: parsing output: 86/ for test: i915_selftest
results: parsing output: 87/ for test: perf_pmu
results: parsing output: 88/ for test: gem_exec_params
results: parsing output: 89/ for test: kms_multipipe_modeset
results: parsing output: 90/ for test: perf
results: parsing output: 91/ for test: kms_rotation_crc
results: parsing output: 92/ for test: kms_frontbuffer_tracking
results: parsing output: 93/ for test: kms_frontbuffer_tracking
results: parsing output: 94/ for test: kms_addfb_basic
results: parsing output: 95/ for test: gem_exec_fence
results: parsing output: 96/ for test: kms_flip
results: parsing output: 97/ for test: kms_psr
results: parsing output: 98/ for test: kms_psr
results: parsing output: 99/ for test: kms_rotation_crc
results: parsing output: 100/ for test: kms_invalid_mode
results: parsing output: 101/ for test: gem_exec_schedule
results: parsing output: 102/ for test: syncobj_wait
results: parsing output: 103/ for test: kms_cursor_legacy
results: parsing output: 104/ for test: gem_softpin
results: parsing output: 105/ for test: kms_cursor_legacy
results: parsing output: 106/ for test: kms_getfb
results: parsing output: 107/ for test: gem_ctx_persistence
results: parsing output: 108/ for test: gem_tiled_blits
results: parsing output: 109/ for test: kms_chamelium_color
results: parsing output: 110/ for test: kms_flip_scaled_crc
results: parsing output: 111/ for test: syncobj_timeline
results: parsing output: 112/ for test: syncobj_timeline
results: parsing output: 113/ for test: gem_ctx_shared
results: parsing output: 114/ for test: kms_flip_scaled_crc
results: parsing output: 115/ for test: kms_properties
results: parsing output: 116/ for test: kms_addfb_basic
results: parsing output: 117/ for test: kms_big_fb
results: parsing output: 118/ for test: kms_content_protection
results: parsing output: 119/ for test: perf_pmu
results: parsing output: 120/ for test: syncobj_timeline
results: parsing output: 121/ for test: prime_vgem
results: parsing output: 122/ for test: kms_big_fb
results: parsing output: 123/ for test: kms_cursor_legacy
results: parsing output: 124/ for test: gem_tiled_pread_basic
results: parsing output: 125/ for test: kms_frontbuffer_tracking
results: parsing output: 126/ for test: gem_spin_batch
results: parsing output: 127/ for test: kms_frontbuffer_tracking
results: parsing output: 128/ for test: kms_frontbuffer_tracking
results: parsing output: 129/ for test: gem_mmap_wc
results: parsing output: 130/ for test: perf_pmu
results: parsing output: 131/ for test: gem_exec_balancer
results: parsing output: 132/ for test: kms_chamelium_frames
Done.