[64.818694] Initializing watchdogs
[64.818757]   /dev/watchdog0
[64.837714] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:03:00.0: 8086:56a0 Intel Dg2 (Gen12) DG2 [Arc A770]
[64.848593] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[64.852299] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[64.854972] [001/133] (960s left) core_auth (getclient-master-drop)
[64.899383] Starting subtest: getclient-master-drop
[64.941879] Subtest getclient-master-drop: SUCCESS (0.043s)
[65.100958] [002/133] (960s left) gem_workarounds (reset)
[65.193508] Starting subtest: reset
[65.442707] Subtest reset: SUCCESS (0.249s)
[65.633124] [003/133] (959s left) kms_plane (pixel-format-4-tiled-dg2-rc-ccs-modifier)
[65.840413] Starting subtest: pixel-format-4-tiled-dg2-rc-ccs-modifier
[65.842234] Subtest pixel-format-4-tiled-dg2-rc-ccs-modifier: SKIP (0.000s)
[65.986248] [004/133] (959s left) i915_hangman (hangcheck-unterminated)
[66.071533] Starting subtest: hangcheck-unterminated
[76.164823] Subtest hangcheck-unterminated: SUCCESS (10.093s)
[76.361835] [005/133] (949s left) kms_psr2_sf (fbc-psr2-overlay-plane-update-sf-dmg-area)
[76.546276] Subtest fbc-psr2-overlay-plane-update-sf-dmg-area: SKIP (0.000s)
[76.597517] [006/133] (949s left) gem_exec_whisper (basic-normal-all)
[76.678961] Starting subtest: basic-normal-all
[79.093666] Subtest basic-normal-all: SUCCESS (2.414s)
[79.373681] [007/133] (946s left) kms_psr2_sf (psr2-overlay-plane-move-continuous-exceed-fully-sf)
[79.554073] Subtest psr2-overlay-plane-move-continuous-exceed-fully-sf: SKIP (0.000s)
[79.597658] [008/133] (946s left) dmabuf (all-tests)
[79.642164] Starting subtest: all-tests
[79.643025] Starting dynamic subtest: sanitycheck
[79.733402] Dynamic subtest sanitycheck: SUCCESS (0.091s)
[79.771040] Starting dynamic subtest: dma_fence
[79.950665] Dynamic subtest dma_fence: SUCCESS (0.216s)
[79.984911] Starting dynamic subtest: dma_fence_chain
[89.194367] Dynamic subtest dma_fence_chain: SUCCESS (9.243s)
[89.222609] Starting dynamic subtest: dma_fence_unwrap
[89.275214] Dynamic subtest dma_fence_unwrap: SUCCESS (0.080s)
[89.293549] Starting dynamic subtest: dma_resv
[89.360042] Dynamic subtest dma_resv: SUCCESS (0.084s)
[89.361281] Subtest all-tests: SUCCESS (9.720s)
[89.497762] [009/133] (936s left) gem_render_copy_redux (interruptible)
[89.573364] Starting subtest: interruptible
[90.323224] Subtest interruptible: SUCCESS (0.750s)
[90.507162] [010/133] (935s left) gem_exec_schedule (pi-shared-iova)
[90.729435] Starting subtest: pi-shared-iova
[90.730962] Starting dynamic subtest: rcs0
[91.009149] Dynamic subtest rcs0: SUCCESS (0.280s)
[91.017607] Starting dynamic subtest: bcs0
[91.185733] Dynamic subtest bcs0: SUCCESS (0.176s)
[91.194384] Starting dynamic subtest: vcs0
[91.371838] Dynamic subtest vcs0: SUCCESS (0.186s)
[91.380500] Starting dynamic subtest: vcs1
[91.559465] Dynamic subtest vcs1: SUCCESS (0.188s)
[91.568179] Starting dynamic subtest: vecs0
[91.743572] Dynamic subtest vecs0: SUCCESS (0.184s)
[91.752151] Starting dynamic subtest: vecs1
[91.952121] Dynamic subtest vecs1: SUCCESS (0.208s)
[91.961055] Starting dynamic subtest: ccs0
[92.139501] Dynamic subtest ccs0: SUCCESS (0.187s)
[92.140946] Subtest pi-shared-iova: SUCCESS (1.411s)
[92.484053] [011/133] (933s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-render)
[92.665499] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-render
[92.667214] Subtest psr-2p-scndscrn-pri-indfb-draw-render: SKIP (0.000s)
[92.850967] [012/133] (933s left) gem_render_copy (y-tiled)
[92.928532] Starting subtest: y-tiled
[92.930829] Subtest y-tiled: SKIP (0.000s)
[93.142579] [013/133] (932s left) kms_busy (basic)
[93.325371] Starting subtest: basic
[93.327215] Starting dynamic subtest: flip
[93.930365] Dynamic subtest flip: SUCCESS (0.602s)
[93.948706] Starting dynamic subtest: modeset
[94.833638] Dynamic subtest modeset: SUCCESS (0.904s)
[94.834641] Subtest basic: SUCCESS (1.508s)
[95.154896] [014/133] (930s left) kms_psr (psr2-cursor-blt)
[95.337259] Subtest psr2-cursor-blt: SKIP (0.000s)
[95.395454] [015/133] (930s left) kms_flip (2x-plain-flip-fb-recreate)
[95.575937] Starting subtest: 2x-plain-flip-fb-recreate
[95.590786] Subtest 2x-plain-flip-fb-recreate: SKIP (0.014s)
[95.730167] [016/133] (930s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-fullscreen)
[95.909280] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-fullscreen
[95.910976] Subtest fbcpsr-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s)
[96.120172] [017/133] (930s left) kms_frontbuffer_tracking (fbcpsr-stridechange)
[96.301362] Starting subtest: fbcpsr-stridechange
[96.303046] Subtest fbcpsr-stridechange: SKIP (0.000s)
[96.484959] [018/133] (929s left) gem_mmap_gtt (close-race)
[96.559855] Subtest close-race: SKIP (0.000s)
[96.634483] [019/133] (929s left) perf_pmu (semaphore-wait)
[96.696247] Starting subtest: semaphore-wait
[96.697170] Starting dynamic subtest: rcs0
[97.235715] Dynamic subtest rcs0: SUCCESS (0.538s)
[97.247558] Starting dynamic subtest: bcs0
[97.748938] Dynamic subtest bcs0: SUCCESS (0.512s)
[97.760610] Starting dynamic subtest: vcs0
[98.262739] Dynamic subtest vcs0: SUCCESS (0.513s)
[98.274572] Starting dynamic subtest: vcs1
[98.776560] Dynamic subtest vcs1: SUCCESS (0.513s)
[98.788569] Starting dynamic subtest: vecs0
[99.290177] Dynamic subtest vecs0: SUCCESS (0.513s)
[99.302485] Starting dynamic subtest: vecs1
[99.802870] Dynamic subtest vecs1: SUCCESS (0.512s)
[99.815255] Starting dynamic subtest: ccs0
[100.315927] Dynamic subtest ccs0: SUCCESS (0.512s)
[100.317697] Subtest semaphore-wait: SUCCESS (3.619s)
[100.500444] [020/133] (926s left) kms_rotation_crc (primary-4-tiled-reflect-x-0)
[100.678515] Starting subtest: primary-4-tiled-reflect-x-0
[111.176420] Subtest primary-4-tiled-reflect-x-0: SUCCESS (10.497s)
[111.566521] [021/133] (915s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180-async-flip)
[111.753745] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180-async-flip
[112.454252] Subtest x-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SUCCESS (0.700s)
[112.734398] [022/133] (913s left) kms_frontbuffer_tracking (psr-2p-primscrn-shrfb-msflip-blt)
[112.915442] Starting subtest: psr-2p-primscrn-shrfb-msflip-blt
[112.917130] Subtest psr-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[113.117517] [023/133] (913s left) kms_plane_scaling (plane-upscale-20x20-with-pixel-format)
[113.294668] Starting subtest: plane-upscale-20x20-with-pixel-format
[113.295481] Starting dynamic subtest: pipe-A
[114.936723] Dynamic subtest pipe-A: SUCCESS (1.642s)
[114.950778] Starting dynamic subtest: pipe-B
[116.634957] Dynamic subtest pipe-B: SUCCESS (1.698s)
[116.652711] Starting dynamic subtest: pipe-C
[116.949252] Dynamic subtest pipe-C: SUCCESS (0.314s)
[116.968829] Starting dynamic subtest: pipe-D
[117.261830] Dynamic subtest pipe-D: SUCCESS (0.312s)
[117.262711] Subtest plane-upscale-20x20-with-pixel-format: SUCCESS (3.967s)
[117.625452] [024/133] (909s left) kms_color (ctm-negative)
[117.808484] Starting subtest: ctm-negative
[117.809431] Starting dynamic subtest: pipe-A-DP-3
[118.461320] Dynamic subtest pipe-A-DP-3: SUCCESS (0.650s)
[118.483821] Starting dynamic subtest: pipe-B-DP-3
[119.046072] Dynamic subtest pipe-B-DP-3: SUCCESS (0.585s)
[119.058258] Starting dynamic subtest: pipe-C-DP-3
[119.636877] Dynamic subtest pipe-C-DP-3: SUCCESS (0.590s)
[119.648999] Starting dynamic subtest: pipe-D-DP-3
[120.250623] Dynamic subtest pipe-D-DP-3: SUCCESS (0.613s)
[120.251571] Subtest ctm-negative: SUCCESS (2.442s)
[120.571165] [025/133] (906s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-mmap-cpu)
[120.756466] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-mmap-cpu
[120.758163] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[120.939771] [026/133] (906s left) kms_addfb_basic (too-wide)
[121.118135] Starting subtest: too-wide
[121.119053] Subtest too-wide: SUCCESS (0.000s)
[121.322228] [027/133] (905s left) syncobj_basic (bad-flags-fd-to-handle)
[121.387112] Starting subtest: bad-flags-fd-to-handle
[121.388163] Subtest bad-flags-fd-to-handle: SUCCESS (0.000s)
[121.571051] [028/133] (905s left) kms_ccs (crc-primary-rotation-180-y-tiled-gen12-rc-ccs)
[121.747459] Starting subtest: crc-primary-rotation-180-y-tiled-gen12-rc-ccs
[121.748394] Starting dynamic subtest: pipe-A-DP-3
[121.756761] Dynamic subtest pipe-A-DP-3: SKIP (0.001s)
[121.766682] Starting dynamic subtest: pipe-B-DP-3
[121.775037] Dynamic subtest pipe-B-DP-3: SKIP (0.001s)
[121.784719] Starting dynamic subtest: pipe-C-DP-3
[121.792950] Dynamic subtest pipe-C-DP-3: SKIP (0.001s)
[121.802439] Starting dynamic subtest: pipe-D-DP-3
[121.812578] Dynamic subtest pipe-D-DP-3: SKIP (0.001s)
[121.814405] Subtest crc-primary-rotation-180-y-tiled-gen12-rc-ccs: SKIP (0.007s)
[122.216638] [029/133] (905s left) kms_big_fb (linear-16bpp-rotate-270)
[122.400798] Starting subtest: linear-16bpp-rotate-270
[122.453327] Subtest linear-16bpp-rotate-270: SKIP (0.052s)
[122.664369] [030/133] (904s left) kms_pm_rpm (legacy-planes-dpms)
[125.065297] Starting subtest: legacy-planes-dpms
[125.067117] Starting dynamic subtest: plane-64
[127.819910] Dynamic subtest plane-64: SUCCESS (2.756s)
[127.862963] Starting dynamic subtest: plane-94
[131.030924] Dynamic subtest plane-94: SUCCESS (3.209s)
[131.072542] Starting dynamic subtest: plane-124
[133.818801] Dynamic subtest plane-124: SUCCESS (2.784s)
[133.859778] Starting dynamic subtest: plane-134
[136.598639] Dynamic subtest plane-134: SUCCESS (2.779s)
[136.600343] Subtest legacy-planes-dpms: SUCCESS (11.537s)
[137.037973] [031/133] (890s left) syncobj_timeline (multi-wait-all-available-signaled)
[137.113416] Starting subtest: multi-wait-all-available-signaled
[137.114314] Subtest multi-wait-all-available-signaled: SUCCESS (0.001s)
[137.267069] [032/133] (890s left) gem_pxp (create-regular-buffer)
[139.862882] Starting subtest: create-regular-buffer
[139.865165] Subtest create-regular-buffer: SKIP (0.000s)
[140.021620] [033/133] (887s left) gem_userptr_blits (sync-overlap)
[140.101943] Starting subtest: sync-overlap
[140.102908] Subtest sync-overlap: SUCCESS (0.000s)
[140.296855] [034/133] (887s left) kms_cursor_crc (cursor-offscreen-256x85)
[140.712546] Starting subtest: cursor-offscreen-256x85
[140.716873] Starting dynamic subtest: pipe-A-DP-3
[143.286647] Dynamic subtest pipe-A-DP-3: SUCCESS (2.569s)
[143.337468] Starting dynamic subtest: pipe-D-DP-3
[145.784963] Dynamic subtest pipe-D-DP-3: SUCCESS (2.456s)
[145.785892] Subtest cursor-offscreen-256x85: SUCCESS (5.072s)
[146.158359] [035/133] (881s left) kms_vblank (wait-forked-hang)
[146.335015] Starting subtest: wait-forked-hang
[146.335861] Starting dynamic subtest: pipe-A-DP-3
[172.541665] Dynamic subtest pipe-A-DP-3: SUCCESS (26.204s)
[172.554945] Starting dynamic subtest: pipe-D-DP-3
[197.550405] Dynamic subtest pipe-D-DP-3: SUCCESS (25.005s)
[197.551277] Subtest wait-forked-hang: SUCCESS (51.213s)
[197.880170] [036/133] (829s left) gem_exec_reloc (basic-wc-active)
[197.956237] Subtest basic-wc-active: SKIP (0.000s)
[198.038888] [037/133] (829s left) kms_ccs (ccs-on-another-bo-4-tiled-mtl-rc-ccs)
[198.224108] Starting subtest: ccs-on-another-bo-4-tiled-mtl-rc-ccs
[198.224979] Starting dynamic subtest: pipe-A-DP-3
[198.233015] Dynamic subtest pipe-A-DP-3: SKIP (0.000s)
[198.243299] Starting dynamic subtest: pipe-B-DP-3
[198.251602] Dynamic subtest pipe-B-DP-3: SKIP (0.000s)
[198.261794] Starting dynamic subtest: pipe-C-DP-3
[198.269994] Dynamic subtest pipe-C-DP-3: SKIP (0.000s)
[198.280224] Starting dynamic subtest: pipe-D-DP-3
[198.290983] Dynamic subtest pipe-D-DP-3: SKIP (0.000s)
[198.292942] Subtest ccs-on-another-bo-4-tiled-mtl-rc-ccs: SKIP (0.005s)
[198.720163] [038/133] (829s left) kms_flip (2x-dpms-vs-vblank-race)
[198.904178] Starting subtest: 2x-dpms-vs-vblank-race
[198.919379] Subtest 2x-dpms-vs-vblank-race: SKIP (0.015s)
[199.099491] [039/133] (828s left) kms_psr2_sf (fbc-pr-cursor-plane-move-continuous-exceed-fully-sf)
[199.275641] Subtest fbc-pr-cursor-plane-move-continuous-exceed-fully-sf: SKIP (0.000s)
[199.329271] [040/133] (828s left) kms_atomic (plane-cursor-legacy)
[199.503479] Starting subtest: plane-cursor-legacy
[199.505596] Starting dynamic subtest: pipe-A-DP-3
[200.050247] Dynamic subtest pipe-A-DP-3: SUCCESS (0.545s)
[200.051210] Subtest plane-cursor-legacy: SUCCESS (0.547s)
[200.361548] [041/133] (827s left) gem_partial_pwrite_pread (write-uncached)
[200.436297] Subtest write-uncached: SKIP (0.000s)
[200.524323] [042/133] (827s left) gem_create (create-ext-cpu-access-sanity-check)
[200.706800] Starting subtest: create-ext-cpu-access-sanity-check
[200.714190] Subtest create-ext-cpu-access-sanity-check: SUCCESS (0.008s)
[200.861331] [043/133] (827s left) gem_mmap_gtt (zero-extend)
[200.932066] Subtest zero-extend: SKIP (0.000s)
[201.005941] [044/133] (827s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-16bpp-ytile-downscaling)
[201.182268] Starting subtest: flip-64bpp-ytile-to-16bpp-ytile-downscaling
[201.183987] Subtest flip-64bpp-ytile-to-16bpp-ytile-downscaling: SKIP (0.000s)
[201.320589] [045/133] (827s left) api_intel_allocator (fork-simple-stress)
[201.387301] Starting subtest: fork-simple-stress
[206.805927] Subtest fork-simple-stress: SUCCESS (5.417s)
[207.016430] [046/133] (821s left) kms_big_fb (y-tiled-64bpp-rotate-180)
[207.205305] Starting subtest: y-tiled-64bpp-rotate-180
[207.207136] Subtest y-tiled-64bpp-rotate-180: SKIP (0.000s)
[207.402938] [047/133] (821s left) gem_render_copy (yf-tiled-to-vebox-y-tiled)
[207.479469] Starting subtest: yf-tiled-to-vebox-y-tiled
[207.481362] Subtest yf-tiled-to-vebox-y-tiled: SKIP (0.000s)
[207.739282] [048/133] (820s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-mmap-wc)
[207.920050] Starting subtest: psr-1p-primscrn-spr-indfb-draw-mmap-wc
[207.921789] Subtest psr-1p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[208.106328] [049/133] (820s left) gem_pxp (protected-encrypted-src-copy-not-readible)
[210.703311] Starting subtest: protected-encrypted-src-copy-not-readible
[210.705509] Subtest protected-encrypted-src-copy-not-readible: SKIP (0.000s)
[210.841630] [050/133] (817s left) i915_pm_rps (basic-api)
[210.922198] Starting subtest: basic-api
[210.924074] Subtest basic-api: SKIP (0.000s)
[211.070838] [051/133] (817s left) gem_busy (busy)
[211.150642] Starting subtest: busy
[211.151496] Starting dynamic subtest: all-engines
[211.241296] Dynamic subtest all-engines: SUCCESS (0.090s)
[211.254105] Starting dynamic subtest: rcs0
[211.377734] Dynamic subtest rcs0: SUCCESS (0.136s)
[211.389317] Starting dynamic subtest: bcs0
[211.417457] Dynamic subtest bcs0: SUCCESS (0.039s)
[211.432448] Starting dynamic subtest: vcs0
[211.457228] Dynamic subtest vcs0: SUCCESS (0.039s)
[211.476903] Starting dynamic subtest: vcs1
[211.496944] Dynamic subtest vcs1: SUCCESS (0.039s)
[211.518179] Starting dynamic subtest: vecs0
[211.536703] Dynamic subtest vecs0: SUCCESS (0.039s)
[211.554833] Starting dynamic subtest: vecs1
[211.577497] Dynamic subtest vecs1: SUCCESS (0.039s)
[211.594060] Starting dynamic subtest: ccs0
[211.617695] Dynamic subtest ccs0: SUCCESS (0.040s)
[211.618731] Subtest busy: SUCCESS (0.468s)
[212.046870] [052/133] (816s left) kms_dp_link_training (non-uhbr-sst)
[212.227725] Starting subtest: non-uhbr-sst
[214.392582] Subtest non-uhbr-sst: SUCCESS (2.161s)
[214.601685] [053/133] (814s left) gem_unfence_active_buffers
[214.822966] [054/133] (814s left) kms_dsc (dsc-with-formats)
[215.000558] Starting subtest: dsc-with-formats
[215.016552] Subtest dsc-with-formats: SKIP (0.002s)
[215.116598] [055/133] (813s left) kms_plane_scaling (plane-downscale-factor-0-75-with-rotation)
[215.295123] Starting subtest: plane-downscale-factor-0-75-with-rotation
[215.295838] Starting dynamic subtest: pipe-A
[215.657079] Dynamic subtest pipe-A: SUCCESS (0.362s)
[215.680646] Starting dynamic subtest: pipe-B
[216.136812] Dynamic subtest pipe-B: SUCCESS (0.478s)
[216.163918] Starting dynamic subtest: pipe-C
[216.616741] Dynamic subtest pipe-C: SUCCESS (0.478s)
[216.644354] Starting dynamic subtest: pipe-D
[217.096348] Dynamic subtest pipe-D: SUCCESS (0.478s)
[217.097320] Subtest plane-downscale-factor-0-75-with-rotation: SUCCESS (1.803s)
[217.436163] [056/133] (811s left) kms_cursor_legacy (cursor-vs-flip-toggle)
[217.614168] Starting subtest: cursor-vs-flip-toggle
[250.351617] Subtest cursor-vs-flip-toggle: SUCCESS (32.736s)
[250.652861] [057/133] (778s left) kms_psr (fbc-psr-cursor-blt)
[250.828451] Subtest fbc-psr-cursor-blt: SKIP (0.000s)
[250.883830] [058/133] (778s left) gem_ctx_exec (basic)
[250.957221] Starting subtest: basic
[250.964987] Subtest basic: SUCCESS (0.009s)
[251.151455] [059/133] (778s left) gem_sync (basic-store-all)
[251.230307] Starting subtest: basic-store-all
[255.685734] Subtest basic-store-all: SUCCESS (4.455s)
[255.929134] [060/133] (773s left) kms_flip (2x-blocking-wf_vblank)
[256.105628] Starting subtest: 2x-blocking-wf_vblank
[256.121170] Subtest 2x-blocking-wf_vblank: SKIP (0.015s)
[256.269487] [061/133] (773s left) kms_ccs (bad-pixel-format-4-tiled-dg2-mc-ccs)
[256.447583] Starting subtest: bad-pixel-format-4-tiled-dg2-mc-ccs
[256.449899] Starting dynamic subtest: pipe-A-DP-3
[256.458219] Dynamic subtest pipe-A-DP-3: SKIP (0.000s)
[256.468665] Starting dynamic subtest: pipe-B-DP-3
[256.477110] Dynamic subtest pipe-B-DP-3: SKIP (0.000s)
[256.487462] Starting dynamic subtest: pipe-C-DP-3
[256.495658] Dynamic subtest pipe-C-DP-3: SKIP (0.000s)
[256.506131] Starting dynamic subtest: pipe-D-DP-3
[256.516528] Dynamic subtest pipe-D-DP-3: SKIP (0.000s)
[256.518469] Subtest bad-pixel-format-4-tiled-dg2-mc-ccs: SKIP (0.006s)
[256.933771] [062/133] (772s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-move)
[257.120901] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-move
[257.122583] Subtest fbcpsr-2p-scndscrn-cur-indfb-move: SKIP (0.000s)
[257.301996] [063/133] (772s left) gem_ctx_persistence (idempotent)
[257.380617] Starting subtest: idempotent
[257.381467] Subtest idempotent: SUCCESS (0.000s)
[257.568784] [064/133] (772s left) gem_flink_basic (basic)
[257.637250] Starting subtest: basic
[257.638187] Subtest basic: SUCCESS (0.000s)
[257.767386] [065/133] (772s left) kms_plane (pixel-format-4-tiled-mtl-mc-ccs-modifier)
[257.943426] Starting subtest: pixel-format-4-tiled-mtl-mc-ccs-modifier
[257.945191] Subtest pixel-format-4-tiled-mtl-mc-ccs-modifier: SKIP (0.000s)
[258.100777] [066/133] (771s left) kms_cursor_crc (cursor-random-512x512)
[258.540435] Starting subtest: cursor-random-512x512
[258.543409] Subtest cursor-random-512x512: SKIP (0.001s)
[258.800961] [067/133] (771s left) kms_chamelium_hpd (vga-hpd-enable-disable-mode)
[259.048399] Subtest vga-hpd-enable-disable-mode: SKIP (0.000s)
[259.193940] [068/133] (770s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-onoff)
[259.377890] Starting subtest: fbc-2p-primscrn-cur-indfb-onoff
[259.379549] Subtest fbc-2p-primscrn-cur-indfb-onoff: SKIP (0.000s)
[259.573182] [069/133] (770s left) kms_frontbuffer_tracking (psr-rgb565-draw-render)
[259.755120] Starting subtest: psr-rgb565-draw-render
[259.756812] Subtest psr-rgb565-draw-render: SKIP (0.000s)
[259.954043] [070/133] (770s left) perf (unprivileged-single-ctx-counters)
[260.352250] Starting subtest: unprivileged-single-ctx-counters
[260.353962] Subtest unprivileged-single-ctx-counters: SKIP (0.000s)
[260.429367] [071/133] (769s left) kms_cursor_edge_walk (128x128-top-edge)
[260.609273] Starting subtest: 128x128-top-edge
[260.610177] Starting dynamic subtest: pipe-A-DP-3
[264.075581] Dynamic subtest pipe-A-DP-3: SUCCESS (3.466s)
[264.089132] Starting dynamic subtest: pipe-D-DP-3
[267.388493] Dynamic subtest pipe-D-DP-3: SUCCESS (3.309s)
[267.389479] Subtest 128x128-top-edge: SUCCESS (6.780s)
[267.718178] [072/133] (762s left) i915_drm_fdinfo (memory-info-resident)
[267.781165] Starting subtest: memory-info-resident
[267.782109] Starting dynamic subtest: lmem0
[271.900577] Dynamic subtest lmem0: SUCCESS (4.118s)
[271.933194] Starting dynamic subtest: smem0
[276.399186] Dynamic subtest smem0: SUCCESS (4.492s)
[276.400161] Subtest memory-info-resident: SUCCESS (8.618s)
[276.524059] [073/133] (753s left) kms_pm_rpm (dpms-lpsp)
[278.025945] Starting subtest: dpms-lpsp
[278.028575] Subtest dpms-lpsp: SKIP (0.001s)
[278.450786] [074/133] (752s left) kms_cursor_legacy (cursora-vs-flipa-legacy)
[278.633271] Starting subtest: cursorA-vs-flipA-legacy
[289.575018] Subtest cursorA-vs-flipA-legacy: SUCCESS (10.942s)
[289.897284] [075/133] (740s left) gen9_exec_parse (allowed-single)
[289.969354] Subtest allowed-single: SKIP (0.000s)
[290.045883] [076/133] (740s left) kms_ccs (missing-ccs-buffer-yf-tiled-ccs)
[290.220765] Starting subtest: missing-ccs-buffer-yf-tiled-ccs
[290.223218] Starting dynamic subtest: pipe-A-DP-3
[290.231546] Dynamic subtest pipe-A-DP-3: SKIP (0.000s)
[290.242057] Starting dynamic subtest: pipe-B-DP-3
[290.250248] Dynamic subtest pipe-B-DP-3: SKIP (0.000s)
[290.260562] Starting dynamic subtest: pipe-C-DP-3
[290.268594] Dynamic subtest pipe-C-DP-3: SKIP (0.000s)
[290.279228] Starting dynamic subtest: pipe-D-DP-3
[290.290180] Dynamic subtest pipe-D-DP-3: SKIP (0.000s)
[290.291795] Subtest missing-ccs-buffer-yf-tiled-ccs: SKIP (0.007s)
[290.708431] [077/133] (740s left) kms_big_fb (4-tiled-32bpp-rotate-180)
[290.896168] Starting subtest: 4-tiled-32bpp-rotate-180
[292.733713] Subtest 4-tiled-32bpp-rotate-180: SUCCESS (1.837s)
[292.978145] [078/133] (737s left) kms_lease (simple-lease)
[293.160873] Starting subtest: simple-lease
[293.163297] Starting dynamic subtest: pipe-A-DP-3
[293.625712] Dynamic subtest pipe-A-DP-3: SUCCESS (0.463s)
[293.640509] Starting dynamic subtest: pipe-B-DP-3
[294.027969] Dynamic subtest pipe-B-DP-3: SUCCESS (0.399s)
[294.043763] Starting dynamic subtest: pipe-C-DP-3
[294.410052] Dynamic subtest pipe-C-DP-3: SUCCESS (0.380s)
[294.422346] Starting dynamic subtest: pipe-D-DP-3
[294.797093] Dynamic subtest pipe-D-DP-3: SUCCESS (0.385s)
[294.798103] Subtest simple-lease: SUCCESS (1.637s)
[295.118358] [079/133] (735s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite)
[295.300967] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite
[295.302639] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[295.447639] [080/133] (735s left) gem_userptr_blits (create-destroy-sync)
[295.536301] Starting subtest: create-destroy-sync
[300.557056] Subtest create-destroy-sync: SUCCESS (5.020s)
[300.743911] [081/133] (730s left) gem_exec_whisper (basic-queues-priority)
[300.823605] Starting subtest: basic-queues-priority
[323.332581] Subtest basic-queues-priority: SUCCESS (22.507s)
[323.607908] [082/133] (707s left) gem_exec_fence (expired-history)
[324.153582] Starting subtest: expired-history
[330.797576] Subtest expired-history: SUCCESS (6.644s)
[332.058790] [FACT gem_exec_fence (expired-history)] new: kernel.kmod_is_loaded.vgem: true
[332.061293] [083/133] (699s left) gem_exec_gttfill (all-engines)
[332.155787] Starting subtest: all-engines
[358.506746] Subtest all-engines: SUCCESS (26.350s)
[358.790771] [084/133] (672s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-render)
[359.043116] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-render
[359.044710] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-render: SKIP (0.000s)
[359.203571] [085/133] (672s left) syncobj_timeline (reset-during-wait-for-submit)
[359.297521] Starting subtest: reset-during-wait-for-submit
[359.401466] Subtest reset-during-wait-for-submit: SUCCESS (0.103s)
[359.529606] [086/133] (671s left) kms_vblank (query-forked)
[359.719239] Starting subtest: query-forked
[359.720161] Starting dynamic subtest: pipe-A-DP-3
[362.079608] Dynamic subtest pipe-A-DP-3: SUCCESS (2.360s)
[362.099063] Starting dynamic subtest: pipe-D-DP-3
[364.429290] Dynamic subtest pipe-D-DP-3: SUCCESS (2.345s)
[364.430197] Subtest query-forked: SUCCESS (4.712s)
[364.702103] [087/133] (666s left) i915_selftest (mock)
[365.892813] Starting subtest: mock
[365.893727] Starting dynamic subtest: sanitycheck
[366.774819] Dynamic subtest sanitycheck: SUCCESS (0.880s)
[366.808256] Starting dynamic subtest: shmem
[367.662501] Dynamic subtest shmem: SUCCESS (0.883s)
[367.697142] Starting dynamic subtest: fence
[376.026703] Dynamic subtest fence: SUCCESS (8.359s)
[376.043266] Starting dynamic subtest: scatterlist
[377.859856] Dynamic subtest scatterlist: SUCCESS (1.829s)
[377.875759] Starting dynamic subtest: syncmap
[380.759070] Dynamic subtest syncmap: SUCCESS (2.896s)
[380.774938] Starting dynamic subtest: uncore
[381.629081] Dynamic subtest uncore: SUCCESS (0.866s)
[381.660790] Starting dynamic subtest: ring
[382.514470] Dynamic subtest ring: SUCCESS (0.881s)
[382.544918] Starting dynamic subtest: engine
[383.374382] Dynamic subtest engine: SUCCESS (0.856s)
[383.406570] Starting dynamic subtest: timelines
[388.057762] Dynamic subtest timelines: SUCCESS (4.679s)
[388.069517] Starting dynamic subtest: requests
[390.840846] Dynamic subtest requests: SUCCESS (2.776s)
[390.851064] Starting dynamic subtest: objects
[391.817933] Dynamic subtest objects: SUCCESS (0.980s)
[391.828528] Starting dynamic subtest: phys
[392.819454] Dynamic subtest phys: SUCCESS (1.000s)
[392.830843] Starting dynamic subtest: dmabuf
[393.810069] Dynamic subtest dmabuf: SUCCESS (0.989s)
[393.827382] Starting dynamic subtest: vma
[402.268944] Dynamic subtest vma: SUCCESS (8.457s)
[402.283149] Starting dynamic subtest: evict
[404.144900] Dynamic subtest evict: SUCCESS (1.874s)
[404.154422] Starting dynamic subtest: gtt
[408.157938] Dynamic subtest gtt: SUCCESS (4.012s)
[408.167019] Starting dynamic subtest: hugepages
[409.265902] Dynamic subtest hugepages: SUCCESS (1.107s)
[409.275946] Starting dynamic subtest: memory_region
[412.811058] Dynamic subtest memory_region: SUCCESS (3.544s)
[412.812130] Subtest mock: SUCCESS (46.918s)
[412.870505] [FACT i915_selftest (mock)] deleted: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[412.871810] [FACT i915_selftest (mock)] deleted: kernel.kmod_is_loaded.i915: true
[412.874189] [088/133] (618s left) perf_pmu (busy-check-all)
[414.548286] Starting subtest: busy-check-all
[414.549096] Starting dynamic subtest: rcs0
[415.143459] Dynamic subtest rcs0: SUCCESS (0.596s)
[415.158852] Starting dynamic subtest: bcs0
[415.697595] Dynamic subtest bcs0: SUCCESS (0.552s)
[415.710427] Starting dynamic subtest: vcs0
[416.251630] Dynamic subtest vcs0: SUCCESS (0.552s)
[416.266035] Starting dynamic subtest: vcs1
[416.807199] Dynamic subtest vcs1: SUCCESS (0.551s)
[416.821224] Starting dynamic subtest: vecs0
[417.362339] Dynamic subtest vecs0: SUCCESS (0.551s)
[417.376296] Starting dynamic subtest: vecs1
[417.917673] Dynamic subtest vecs1: SUCCESS (0.551s)
[417.931628] Starting dynamic subtest: ccs0
[418.474532] Dynamic subtest ccs0: SUCCESS (0.552s)
[418.479467] Subtest busy-check-all: SUCCESS (3.930s)
[418.567668] [FACT perf_pmu (busy-check-all)] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[418.570232] [FACT perf_pmu (busy-check-all)] new: kernel.kmod_is_loaded.i915: true
[418.573469] [089/133] (612s left) gem_exec_params (no-blt)
[418.656796] Starting subtest: no-blt
[418.659218] Subtest no-blt: SUCCESS (0.001s)
[418.854145] [090/133] (612s left) kms_multipipe_modeset (basic-max-pipe-crc-check)
[419.040212] Starting subtest: basic-max-pipe-crc-check
[419.042900] Subtest basic-max-pipe-crc-check: SKIP (0.000s)
[419.097316] [091/133] (612s left) perf (gen8-unprivileged-single-ctx-counters)
[419.514869] Starting subtest: gen8-unprivileged-single-ctx-counters
[419.516515] Subtest gen8-unprivileged-single-ctx-counters: SKIP (0.000s)
[419.569351] [092/133] (612s left) kms_rotation_crc (cursor-rotation-180)
[419.757238] Starting subtest: cursor-rotation-180
[420.605331] Subtest cursor-rotation-180: SUCCESS (0.848s)
[420.961886] [093/133] (610s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-shrfb-plflip-blt)
[421.153246] Starting subtest: fbc-2p-scndscrn-shrfb-plflip-blt
[421.154953] Subtest fbc-2p-scndscrn-shrfb-plflip-blt: SKIP (0.000s)
[421.321446] [094/133] (610s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-pwrite)
[421.513011] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-pwrite
[421.514756] Subtest fbc-2p-scndscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[421.713477] [095/133] (610s left) kms_addfb_basic (framebuffer-vs-set-tiling)
[421.792761] Starting subtest: framebuffer-vs-set-tiling
[421.794403] Subtest framebuffer-vs-set-tiling: SKIP (0.000s)
[422.071627] [096/133] (609s left) gem_exec_fence (syncobj-timeline-multiple-ext-nodes)
[422.736509] Starting subtest: syncobj-timeline-multiple-ext-nodes
[422.738230] Subtest syncobj-timeline-multiple-ext-nodes: SUCCESS (0.007s)
[423.081619] [097/133] (609s left) kms_flip (2x-nonexisting-fb-interruptible)
[423.269904] Starting subtest: 2x-nonexisting-fb-interruptible
[423.285182] Subtest 2x-nonexisting-fb-interruptible: SKIP (0.015s)
[423.451898] [098/133] (608s left) kms_psr (psr2-sprite-plane-move)
[423.633996] Subtest psr2-sprite-plane-move: SKIP (0.000s)
[423.712729] [099/133] (608s left) kms_psr (fbc-psr2-cursor-plane-move)
[423.900209] Subtest fbc-psr2-cursor-plane-move: SKIP (0.000s)
[423.958871] [100/133] (608s left) kms_rotation_crc (bad-pixel-format)
[424.148275] Starting subtest: bad-pixel-format
[424.150023] Subtest bad-pixel-format: SKIP (0.001s)
[424.291807] [101/133] (608s left) kms_invalid_mode (bad-vsync-end)
[424.483144] Starting subtest: bad-vsync-end
[424.483992] Starting dynamic subtest: pipe-A-DP-3
[424.556414] Dynamic subtest pipe-A-DP-3: SUCCESS (0.074s)
[424.570415] Starting dynamic subtest: pipe-B-DP-3
[424.571532] Dynamic subtest pipe-B-DP-3: SUCCESS (0.001s)
[424.583550] Starting dynamic subtest: pipe-C-DP-3
[424.584728] Dynamic subtest pipe-C-DP-3: SUCCESS (0.001s)
[424.596422] Starting dynamic subtest: pipe-D-DP-3
[424.597326] Dynamic subtest pipe-D-DP-3: SUCCESS (0.001s)
[424.598248] Subtest bad-vsync-end: SUCCESS (0.084s)
[424.842455] [102/133] (607s left) gem_exec_schedule (preempt-user)
[424.933725] Starting subtest: preempt-user
[424.934588] Starting dynamic subtest: rcs0
[425.001534] Dynamic subtest rcs0: SUCCESS (0.067s)
[425.013913] Starting dynamic subtest: bcs0
[425.037823] Dynamic subtest bcs0: SUCCESS (0.035s)
[425.050436] Starting dynamic subtest: vcs0
[425.074168] Dynamic subtest vcs0: SUCCESS (0.035s)
[425.086371] Starting dynamic subtest: vcs1
[425.110451] Dynamic subtest vcs1: SUCCESS (0.035s)
[425.122353] Starting dynamic subtest: vecs0
[425.146426] Dynamic subtest vecs0: SUCCESS (0.035s)
[425.158478] Starting dynamic subtest: vecs1
[425.184392] Dynamic subtest vecs1: SUCCESS (0.037s)
[425.196381] Starting dynamic subtest: ccs0
[425.222751] Dynamic subtest ccs0: SUCCESS (0.037s)
[425.223578] Subtest preempt-user: SUCCESS (0.290s)
[425.645732] [103/133] (606s left) syncobj_wait (wait-zero-handles)
[425.722371] Starting subtest: wait-zero-handles
[425.723302] Subtest wait-zero-handles: SUCCESS (0.000s)
[425.924366] [104/133] (606s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size)
[426.111401] Starting subtest: basic-flip-before-cursor-varying-size
[427.185857] Subtest basic-flip-before-cursor-varying-size: SUCCESS (1.075s)
[427.478037] [105/133] (605s left) gem_softpin (softpin)
[427.564539] Starting subtest: softpin
[460.009022] Subtest softpin: SUCCESS (32.442s)
[460.177186] [106/133] (572s left) kms_cursor_legacy (2x-cursor-vs-flip-legacy)
[460.364840] Starting subtest: 2x-cursor-vs-flip-legacy
[460.368131] Subtest 2x-cursor-vs-flip-legacy: SKIP (0.002s)
[460.501135] [107/133] (572s left) kms_getfb (getfb-reject-nv12)
[460.687460] Starting subtest: getfb-reject-nv12
[460.688334] Subtest getfb-reject-nv12: SUCCESS (0.002s)
[460.857960] [108/133] (572s left) gem_ctx_persistence (engines-persistence)
[460.943467] Starting subtest: engines-persistence
[460.944438] Starting dynamic subtest: rcs0
[461.772640] Dynamic subtest rcs0: SUCCESS (0.828s)
[461.786786] Starting dynamic subtest: bcs0
[462.536718] Dynamic subtest bcs0: SUCCESS (0.762s)
[462.552396] Starting dynamic subtest: vcs0
[463.296543] Dynamic subtest vcs0: SUCCESS (0.756s)
[463.311150] Starting dynamic subtest: vcs1
[464.064497] Dynamic subtest vcs1: SUCCESS (0.763s)
[464.079059] Starting dynamic subtest: vecs0
[464.838339] Dynamic subtest vecs0: SUCCESS (0.769s)
[464.853044] Starting dynamic subtest: vecs1
[465.606187] Dynamic subtest vecs1: SUCCESS (0.763s)
[465.620812] Starting dynamic subtest: ccs0
[466.378406] Dynamic subtest ccs0: SUCCESS (0.767s)
[466.383305] Subtest engines-persistence: SUCCESS (5.437s)
[466.527619] [109/133] (566s left) gem_tiled_blits (basic)
[466.628591] Subtest basic: SKIP (0.000s)
[466.736327] [110/133] (566s left) kms_chamelium_color (ctm-green-to-red)
[466.925436] Subtest ctm-green-to-red: SKIP (0.000s)
[466.989255] [111/133] (566s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytile-upscaling)
[467.185706] Starting subtest: flip-64bpp-ytile-to-32bpp-ytile-upscaling
[467.187375] Subtest flip-64bpp-ytile-to-32bpp-ytile-upscaling: SKIP (0.000s)
[467.310417] [112/133] (565s left) syncobj_timeline (etime-multi-wait-all-for-submit-available-unsubmitted-submi
[467.389414] Starting subtest: etime-multi-wait-all-for-submit-available-unsubmitted-submitted
[467.494221] Subtest etime-multi-wait-all-for-submit-available-unsubmitted-submitted: SUCCESS (0.104s)
[467.660947] [113/133] (565s left) syncobj_timeline (etime-multi-wait-for-submit-available-unsubmitted)
[467.742497] Starting subtest: etime-multi-wait-for-submit-available-unsubmitted
[467.846145] Subtest etime-multi-wait-for-submit-available-unsubmitted: SUCCESS (0.103s)
[468.026390] [114/133] (565s left) gem_ctx_shared (disjoint-timelines)
[468.129076] Starting subtest: disjoint-timelines
[468.175956] Subtest disjoint-timelines: SUCCESS (0.047s)
[468.528894] [115/133] (564s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-32bpp-yftileccs-downscaling)
[468.714636] Starting subtest: flip-32bpp-yftile-to-32bpp-yftileccs-downscaling
[468.716301] Subtest flip-32bpp-yftile-to-32bpp-yftileccs-downscaling: SKIP (0.000s)
[468.853725] [116/133] (564s left) kms_properties (get_properties-sanity-atomic)
[469.041519] Starting subtest: get_properties-sanity-atomic
[469.045137] Subtest get_properties-sanity-atomic: SUCCESS (0.004s)
[469.186537] [117/133] (564s left) kms_addfb_basic (basic-x-tiled-legacy)
[469.264663] Starting subtest: basic-x-tiled-legacy
[469.266418] Subtest basic-x-tiled-legacy: SKIP (0.000s)
[469.525754] [118/133] (564s left) kms_big_fb (yf-tiled-64bpp-rotate-180)
[469.723857] Starting subtest: yf-tiled-64bpp-rotate-180
[469.725567] Subtest yf-tiled-64bpp-rotate-180: SKIP (0.000s)
[469.925482] [119/133] (563s left) kms_content_protection (lic-type-0-hdcp14)
[470.177461] Starting subtest: lic-type-0-hdcp14
[470.212131] Starting dynamic subtest: pipe-A-DP-3
[591.362110] Dynamic subtest pipe-A-DP-3: FAIL (120.990s)
[591.362933] Subtest lic-type-0-hdcp14: FAIL (121.128s)
[591.599597] [120/133] (442s left) perf_pmu (all-busy-check-all)
[591.670426] Starting subtest: all-busy-check-all
[592.263627] Subtest all-busy-check-all: SUCCESS (0.594s)
[592.496627] [121/133] (441s left) syncobj_timeline (single-wait-all-available-submitted)
[592.570300] Starting subtest: single-wait-all-available-submitted
[592.571204] Subtest single-wait-all-available-submitted: SUCCESS (0.000s)
[592.750914] [122/133] (441s left) prime_vgem (basic-write)
[592.835509] Starting subtest: basic-write
[592.845963] Subtest basic-write: SKIP (0.010s)
[593.051579] [123/133] (440s left) kms_big_fb (x-tiled-16bpp-rotate-90)
[593.257518] Starting subtest: x-tiled-16bpp-rotate-90
[593.317522] Subtest x-tiled-16bpp-rotate-90: SKIP (0.059s)
[593.547594] [124/133] (440s left) kms_cursor_legacy (2x-cursor-vs-flip-atomic)
[593.738283] Starting subtest: 2x-cursor-vs-flip-atomic
[593.740047] Subtest 2x-cursor-vs-flip-atomic: SKIP (0.002s)
[593.871372] [125/133] (440s left) gem_tiled_pread_basic (basic)
[593.955167] Subtest basic: SKIP (0.000s)
[594.029172] [126/133] (440s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-mmap-cpu)
[594.216970] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-mmap-cpu
[594.218675] Subtest psr-2p-scndscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[594.396691] [127/133] (439s left) gem_spin_batch (resubmit-all)
[594.493997] Starting subtest: resubmit-all
[594.494990] Starting dynamic subtest: rcs0
[594.531474] Dynamic subtest rcs0: SUCCESS (0.037s)
[594.544064] Starting dynamic subtest: bcs0
[594.544977] Dynamic subtest bcs0: SUCCESS (0.003s)
[594.556180] Starting dynamic subtest: vcs0
[594.557199] Dynamic subtest vcs0: SUCCESS (0.003s)
[594.568270] Starting dynamic subtest: vcs1
[594.569415] Dynamic subtest vcs1: SUCCESS (0.003s)
[594.580121] Starting dynamic subtest: vecs0
[594.581372] Dynamic subtest vecs0: SUCCESS (0.003s)
[594.591576] Starting dynamic subtest: vecs1
[594.592613] Dynamic subtest vecs1: SUCCESS (0.003s)
[594.603140] Starting dynamic subtest: ccs0
[594.604166] Dynamic subtest ccs0: SUCCESS (0.002s)
[594.605148] Subtest resubmit-all: SUCCESS (0.062s)
[594.866266] [128/133] (439s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-render)
[595.063173] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-render
[595.064919] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-render: SKIP (0.000s)
[595.265480] [129/133] (439s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-mmap-gtt)
[595.453273] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-mmap-gtt
[595.454964] Subtest fbc-1p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[595.625144] [130/133] (438s left) gem_mmap_wc (write-read)
[595.703207] Subtest write-read: SKIP (0.000s)
[595.778130] [131/133] (438s left) perf_pmu (busy-start)
[595.848657] Starting subtest: busy-start
[595.849543] Starting dynamic subtest: rcs0
[598.420767] Dynamic subtest rcs0: SUCCESS (2.571s)
[598.435838] Starting dynamic subtest: bcs0
[600.971698] Dynamic subtest bcs0: SUCCESS (2.546s)
[600.986678] Starting dynamic subtest: vcs0
[603.523911] Dynamic subtest vcs0: SUCCESS (2.547s)
[603.538872] Starting dynamic subtest: vcs1
[606.073734] Dynamic subtest vcs1: SUCCESS (2.545s)
[606.088644] Starting dynamic subtest: vecs0
[608.625702] Dynamic subtest vecs0: SUCCESS (2.547s)
[608.640859] Starting dynamic subtest: vecs1
[611.172696] Dynamic subtest vecs1: SUCCESS (2.542s)
[611.187178] Starting dynamic subtest: ccs0
[613.721750] Dynamic subtest ccs0: SUCCESS (2.544s)
[613.726511] Subtest busy-start: SUCCESS (17.874s)
[613.885547] [132/133] (420s left) gem_exec_balancer (bonded-false-hang)
[614.225427] Starting subtest: bonded-false-hang
[614.227246] Subtest bonded-false-hang: SKIP (0.000s)
[614.403115] [133/133] (420s left) kms_chamelium_frames (hdmi-crc-multiple)
[614.682444] Subtest hdmi-crc-multiple: SKIP (0.000s)
[614.835837] 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.