[58.778486] Initializing watchdogs
[58.778532]   /dev/watchdog0
[58.791758] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics]
[58.795984] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[58.798195] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[58.801738] [001/133] (960s left) kms_cursor_legacy (cursora-vs-flipb-atomic-transitions-varying-size)
[58.953904] Starting subtest: cursorA-vs-flipB-atomic-transitions-varying-size
[58.958384] Subtest cursorA-vs-flipB-atomic-transitions-varying-size: SKIP (0.001s)
[59.094680] [002/133] (960s left) gem_ctx_persistence (engines-cleanup)
[59.157089] Starting subtest: engines-cleanup
[59.159487] Starting dynamic subtest: rcs0
[59.219493] Dynamic subtest rcs0: SUCCESS (0.062s)
[59.231155] Starting dynamic subtest: bcs0
[59.262995] Dynamic subtest bcs0: SUCCESS (0.042s)
[59.276316] Starting dynamic subtest: vcs0
[59.302533] Dynamic subtest vcs0: SUCCESS (0.039s)
[59.311659] Starting dynamic subtest: vcs1
[59.341447] Dynamic subtest vcs1: SUCCESS (0.038s)
[59.350063] Starting dynamic subtest: vecs0
[59.379423] Dynamic subtest vecs0: SUCCESS (0.037s)
[59.387234] Starting dynamic subtest: ccs0
[59.416539] Dynamic subtest ccs0: SUCCESS (0.036s)
[59.418905] Subtest engines-cleanup: SUCCESS (0.261s)
[59.488611] [003/133] (959s left) gem_eio (in-flight-internal-immediate)
[59.628409] Starting subtest: in-flight-internal-immediate
[60.922509] Subtest in-flight-internal-immediate: SUCCESS (1.298s)
[61.059230] [004/133] (958s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180-hflip)
[61.157730] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180-hflip
[62.209752] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180-hflip: SUCCESS (1.056s)
[62.331614] [005/133] (957s left) syncobj_wait (invalid-reset-illegal-handle)
[62.386687] Starting subtest: invalid-reset-illegal-handle
[62.389070] Subtest invalid-reset-illegal-handle: SUCCESS (0.000s)
[62.501614] [006/133] (956s left) gem_exec_schedule (preempt-contexts)
[62.566014] Starting subtest: preempt-contexts
[62.567701] Starting dynamic subtest: rcs0
[62.620248] Dynamic subtest rcs0: SUCCESS (0.058s)
[62.632059] Starting dynamic subtest: bcs0
[62.687943] Dynamic subtest bcs0: SUCCESS (0.067s)
[62.698550] Starting dynamic subtest: vcs0
[62.737599] Dynamic subtest vcs0: SUCCESS (0.049s)
[62.747270] Starting dynamic subtest: vcs1
[62.783919] Dynamic subtest vcs1: SUCCESS (0.044s)
[62.792100] Starting dynamic subtest: vecs0
[62.826605] Dynamic subtest vecs0: SUCCESS (0.043s)
[62.836898] Starting dynamic subtest: ccs0
[62.883292] Dynamic subtest ccs0: SUCCESS (0.056s)
[62.885524] Subtest preempt-contexts: SUCCESS (0.321s)
[63.987194] [007/133] (955s left) dumb_buffer (create-clear)
[64.044570] Starting subtest: create-clear
[97.871258] Subtest create-clear: SUCCESS (33.835s)
[97.979879] [008/133] (921s left) gem_fence_thrash (bo-write-verify-threaded-x)
[98.017289] Starting subtest: bo-write-verify-threaded-x
[98.030813] Subtest bo-write-verify-threaded-x: SKIP (0.013s)
[98.088558] [009/133] (921s left) kms_plane (plane-panning-bottom-right)
[98.170583] Starting subtest: plane-panning-bottom-right
[98.172857] Starting dynamic subtest: pipe-A
[99.933471] Dynamic subtest pipe-A: SUCCESS (1.758s)
[99.941942] Starting dynamic subtest: pipe-B
[102.357841] Dynamic subtest pipe-B: SUCCESS (2.426s)
[102.360210] Subtest plane-panning-bottom-right: SUCCESS (4.187s)
[103.188528] [010/133] (916s left) kms_ccs (crc-primary-basic-y-tiled-ccs)
[103.284350] Starting subtest: crc-primary-basic-y-tiled-ccs
[103.286718] Starting dynamic subtest: pipe-A-eDP-1
[103.310053] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[103.322270] Starting dynamic subtest: pipe-B-eDP-1
[103.344159] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[103.351178] Starting dynamic subtest: pipe-C-eDP-1
[103.372073] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[103.379221] Starting dynamic subtest: pipe-D-eDP-1
[103.401274] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[103.405355] Subtest crc-primary-basic-y-tiled-ccs: SKIP (0.004s)
[105.545996] [011/133] (914s left) kms_cursor_legacy (cursora-vs-flipa-legacy)
[105.672314] Starting subtest: cursorA-vs-flipA-legacy
[116.787178] Subtest cursorA-vs-flipA-legacy: SUCCESS (11.114s)
[117.582354] [012/133] (902s left) kms_vblank (ts-continuation-dpms-suspend)
[117.685831] Starting subtest: ts-continuation-dpms-suspend
[117.688175] Starting dynamic subtest: pipe-A-eDP-1
[134.789389] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.966s)
[134.810653] Starting dynamic subtest: pipe-D-eDP-1
[152.779497] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.537s)
[152.781706] Subtest ts-continuation-dpms-suspend: SUCCESS (4.507s)
[153.575467] [013/133] (866s left) syncobj_wait (invalid-reset-one-illegal-handle)
[153.631427] Starting subtest: invalid-reset-one-illegal-handle
[153.633362] Subtest invalid-reset-one-illegal-handle: SUCCESS (0.000s)
[153.718334] [014/133] (866s left) kms_cursor_crc (cursor-rapid-movement-256x85)
[153.964898] Starting subtest: cursor-rapid-movement-256x85
[154.010921] Subtest cursor-rapid-movement-256x85: SKIP (0.043s)
[154.207994] [015/133] (865s left) syncobj_wait (single-wait-submitted)
[154.257578] Starting subtest: single-wait-submitted
[154.366933] Subtest single-wait-submitted: SUCCESS (0.110s)
[154.441340] [016/133] (865s left) kms_chamelium_audio (hdmi-audio-edid)
[154.814805] Subtest hdmi-audio-edid: SKIP (0.000s)
[155.581313] [017/133] (864s left) kms_addfb_basic (too-high)
[155.678525] Starting subtest: too-high
[155.680848] Subtest too-high: SUCCESS (0.000s)
[155.776627] [018/133] (864s left) perf_pmu (render-node-busy)
[155.854501] Starting subtest: render-node-busy
[155.856967] Starting dynamic subtest: rcs0
[156.432091] Dynamic subtest rcs0: SUCCESS (0.583s)
[156.442751] Starting dynamic subtest: bcs0
[156.994747] Dynamic subtest bcs0: SUCCESS (0.566s)
[157.005661] Starting dynamic subtest: vcs0
[158.515005] Dynamic subtest vcs0: SUCCESS (1.528s)
[158.526646] Starting dynamic subtest: vcs1
[160.498508] Dynamic subtest vcs1: SUCCESS (1.994s)
[160.510422] Starting dynamic subtest: vecs0
[162.546117] Dynamic subtest vecs0: SUCCESS (2.056s)
[162.558027] Starting dynamic subtest: ccs0
[163.107669] Dynamic subtest ccs0: SUCCESS (0.564s)
[163.110660] Subtest render-node-busy: SUCCESS (7.296s)
[163.181266] [019/133] (856s left) kms_joiner (basic-big-joiner)
[163.273210] Starting subtest: basic-big-joiner
[163.277356] Subtest basic-big-joiner: SKIP (0.000s)
[163.336832] [020/133] (856s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-mmap-wc)
[163.437832] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-mmap-wc
[163.442130] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[163.528591] [021/133] (856s left) api_intel_allocator (standalone)
[163.585372] Starting subtest: standalone
[163.599432] Subtest standalone: SUCCESS (0.016s)
[163.700502] [022/133] (856s left) prime_self_import (export-vs-gem_close-race)
[163.733087] Starting subtest: export-vs-gem_close-race
[168.842751] Subtest export-vs-gem_close-race: SUCCESS (5.122s)
[168.934615] [023/133] (851s left) gem_exec_schedule (fairslice-all)
[169.014214] Starting subtest: fairslice-all
[171.097328] Subtest fairslice-all: SUCCESS (2.094s)
[172.611248] [024/133] (847s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-render)
[172.717429] Starting subtest: psr-1p-primscrn-spr-indfb-draw-render
[179.497968] Subtest psr-1p-primscrn-spr-indfb-draw-render: SUCCESS (6.791s)
[179.629926] [025/133] (840s left) kms_psr (psr2-sprite-plane-move)
[179.731292] Starting subtest: psr2-sprite-plane-move
[179.733628] Starting dynamic subtest: eDP-1
[181.456592] Dynamic subtest eDP-1: SUCCESS (1.728s)
[181.458927] Subtest psr2-sprite-plane-move: SUCCESS (1.729s)
[182.291783] [026/133] (838s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-blt)
[182.394055] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-blt
[182.398148] Subtest fbc-2p-scndscrn-cur-indfb-draw-blt: SKIP (0.000s)
[182.489937] [027/133] (837s left) gem_mmap_wc (read-write-distinct)
[182.535064] Subtest read-write-distinct: SKIP (0.000s)
[182.599723] [028/133] (837s left) sysfs_heartbeat_interval (precise)
[182.666457] Starting subtest: precise
[182.668713] Starting dynamic subtest: vecs0
[189.560937] Dynamic subtest vecs0: SUCCESS (6.890s)
[189.572683] Starting dynamic subtest: ccs0
[190.640696] Dynamic subtest ccs0: SUCCESS (1.080s)
[190.652033] Starting dynamic subtest: vcs0
[198.513991] Dynamic subtest vcs0: SUCCESS (7.873s)
[198.525507] Starting dynamic subtest: bcs0
[199.630998] Dynamic subtest bcs0: SUCCESS (1.114s)
[199.646306] Starting dynamic subtest: rcs0
[200.666306] Dynamic subtest rcs0: SUCCESS (1.035s)
[200.677505] Starting dynamic subtest: vcs1
[208.495827] Dynamic subtest vcs1: SUCCESS (7.826s)
[208.498342] Subtest precise: SUCCESS (25.826s)
[208.569416] [029/133] (811s left) gem_render_copy (linear-to-vebox-yf-tiled)
[208.633251] Starting subtest: linear-to-vebox-yf-tiled
[208.637848] Subtest linear-to-vebox-yf-tiled: SKIP (0.000s)
[208.821188] [030/133] (811s left) gem_spin_batch (legacy-resubmit-new)
[208.882997] Starting subtest: legacy-resubmit-new
[208.885472] Starting dynamic subtest: default
[208.894572] Dynamic subtest default: SUCCESS (0.011s)
[208.903496] Starting dynamic subtest: render
[208.905366] Dynamic subtest render: SUCCESS (0.006s)
[208.913828] Starting dynamic subtest: bsd
[208.916080] Dynamic subtest bsd: SUCCESS (0.010s)
[208.924601] Starting dynamic subtest: bsd1
[208.926721] Dynamic subtest bsd1: SUCCESS (0.004s)
[208.935041] Starting dynamic subtest: bsd2
[208.936892] Dynamic subtest bsd2: SUCCESS (0.004s)
[208.944854] Starting dynamic subtest: blt
[208.946713] Dynamic subtest blt: SUCCESS (0.007s)
[208.954487] Starting dynamic subtest: vebox
[208.956415] Dynamic subtest vebox: SUCCESS (0.005s)
[208.958374] Subtest legacy-resubmit-new: SUCCESS (0.051s)
[210.583778] [031/133] (809s left) kms_cursor_legacy (short-flip-after-cursor-atomic-transitions)
[210.703914] Starting subtest: short-flip-after-cursor-atomic-transitions
[211.672721] Subtest short-flip-after-cursor-atomic-transitions: SUCCESS (0.968s)
[212.527593] [032/133] (808s left) kms_pm_rpm (dpms-non-lpsp)
[214.656171] Starting subtest: dpms-non-lpsp
[214.661114] Subtest dpms-non-lpsp: SKIP (0.001s)
[215.053476] [033/133] (805s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180-hflip)
[215.164451] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180-hflip
[216.109546] Subtest x-tiled-max-hw-stride-64bpp-rotate-180-hflip: SUCCESS (0.945s)
[216.239937] [034/133] (804s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-render)
[216.338818] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-render
[216.342798] Subtest fbc-2p-primscrn-spr-indfb-draw-render: SKIP (0.000s)
[216.429006] [035/133] (804s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-blt)
[216.526486] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-blt
[216.529807] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-blt: SKIP (0.000s)
[216.628552] [036/133] (804s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-blt)
[216.720985] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-blt
[216.724616] Subtest psr-2p-scndscrn-spr-indfb-draw-blt: SKIP (0.000s)
[216.811601] [037/133] (803s left) prime_self_import (basic-with_one_bo_two_files)
[216.852604] Starting subtest: basic-with_one_bo_two_files
[216.867780] Subtest basic-with_one_bo_two_files: SUCCESS (0.014s)
[216.966877] [038/133] (803s left) kms_psr2_sf (fbc-psr2-cursor-plane-move-continuous-exceed-sf)
[217.063242] Starting subtest: fbc-psr2-cursor-plane-move-continuous-exceed-sf
[217.065111] Starting dynamic subtest: pipe-A-eDP-1
[217.141002] Dynamic subtest pipe-A-eDP-1: SKIP (0.077s)
[217.152199] Starting dynamic subtest: pipe-B-eDP-1
[218.294803] Dynamic subtest pipe-B-eDP-1: SKIP (1.151s)
[218.299109] Subtest fbc-psr2-cursor-plane-move-continuous-exceed-sf: SKIP (1.230s)
[219.478725] [039/133] (801s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip)
[219.580880] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip
[219.585437] Subtest yf-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SKIP (0.000s)
[219.673020] [040/133] (801s left) perf (whitelisted-registers-userspace-config)
[219.809356] Starting subtest: whitelisted-registers-userspace-config
[219.811654] Subtest whitelisted-registers-userspace-config: SUCCESS (0.000s)
[219.846969] [041/133] (801s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-move)
[219.951995] Starting subtest: psr-2p-primscrn-spr-indfb-move
[219.956240] Subtest psr-2p-primscrn-spr-indfb-move: SKIP (0.000s)
[220.029600] [042/133] (800s left) gem_exec_params (invalid-flag)
[220.097041] Starting subtest: invalid-flag
[220.099401] Subtest invalid-flag: SUCCESS (0.000s)
[220.218905] [043/133] (800s left) kms_flip_scaled_crc (flip-32bpp-yftileccs-to-64bpp-yftile-upscaling)
[220.300596] Starting subtest: flip-32bpp-yftileccs-to-64bpp-yftile-upscaling
[220.305083] Subtest flip-32bpp-yftileccs-to-64bpp-yftile-upscaling: SKIP (0.000s)
[220.381503] [044/133] (800s left) kms_properties (get_properties-sanity-non-atomic)
[220.470550] Starting subtest: get_properties-sanity-non-atomic
[220.472209] Subtest get_properties-sanity-non-atomic: SUCCESS (0.002s)
[220.543009] [045/133] (800s left) kms_vblank (accuracy-idle)
[220.623349] Starting subtest: accuracy-idle
[220.625200] Starting dynamic subtest: pipe-A-eDP-1
[222.379336] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.752s)
[222.393582] Starting dynamic subtest: pipe-D-eDP-1
[224.824836] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.443s)
[224.826974] Subtest accuracy-idle: SUCCESS (4.199s)
[225.651325] [046/133] (795s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt)
[225.748008] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt
[225.752150] Subtest fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[225.844578] [047/133] (795s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-move)
[225.942728] Starting subtest: psr-1p-primscrn-cur-indfb-move
[233.343381] Subtest psr-1p-primscrn-cur-indfb-move: SUCCESS (7.406s)
[233.476786] [048/133] (787s left) gem_ctx_persistence (legacy-engines-hostile-preempt)
[233.545334] Starting subtest: legacy-engines-hostile-preempt
[233.547626] Starting dynamic subtest: render
[233.630902] Dynamic subtest render: SUCCESS (0.084s)
[233.642447] Starting dynamic subtest: bsd1
[235.502773] Dynamic subtest bsd1: SUCCESS (1.869s)
[235.514578] Starting dynamic subtest: bsd2
[237.547982] Dynamic subtest bsd2: SUCCESS (2.043s)
[237.559308] Starting dynamic subtest: blt
[237.604048] Dynamic subtest blt: SUCCESS (0.054s)
[237.614620] Starting dynamic subtest: vebox
[239.541273] Dynamic subtest vebox: SUCCESS (1.934s)
[239.543921] Subtest legacy-engines-hostile-preempt: SUCCESS (5.997s)
[239.618489] [049/133] (781s left) gem_tiled_partial_pwrite_pread (reads)
[239.684968] Subtest reads: SKIP (0.000s)
[239.750628] [050/133] (781s left) gem_exec_balancer (semaphore)
[239.809932] Starting subtest: semaphore
[241.518056] Subtest semaphore: SUCCESS (1.707s)
[241.839737] [051/133] (779s left) kms_ccs (missing-ccs-buffer-yf-tiled-ccs)
[241.949472] Starting subtest: missing-ccs-buffer-yf-tiled-ccs
[241.951811] Starting dynamic subtest: pipe-A-eDP-1
[241.974957] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[241.987139] Starting dynamic subtest: pipe-B-eDP-1
[242.008300] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[242.016575] Starting dynamic subtest: pipe-C-eDP-1
[242.038029] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[242.046565] Starting dynamic subtest: pipe-D-eDP-1
[242.068396] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[242.072454] Subtest missing-ccs-buffer-yf-tiled-ccs: SKIP (0.004s)
[244.447498] [052/133] (776s left) gem_mmap_gtt (basic-read-write)
[244.500485] Subtest basic-read-write: SKIP (0.000s)
[244.555860] [053/133] (776s left) i915_power (sanity)
[244.624972] Starting subtest: sanity
[248.667980] Subtest sanity: SUCCESS (4.038s)
[250.555205] [054/133] (770s left) gem_exec_fence (invalid-timeline-fence-array)
[251.145739] Starting subtest: invalid-timeline-fence-array
[251.153733] Subtest invalid-timeline-fence-array: SUCCESS (0.007s)
[252.606498] [FACT gem_exec_fence (invalid-timeline-fence-array)] new: kernel.kmod_is_loaded.vgem: true
[252.610125] [055/133] (768s left) gem_lmem_swapping (verify)
[252.657154] Subtest verify: SKIP (0.000s)
[252.696099] [056/133] (768s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-onoff)
[252.795539] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-onoff
[259.817009] Subtest fbcpsr-1p-primscrn-spr-indfb-onoff: SUCCESS (7.021s)
[259.975922] [057/133] (761s left) gem_exec_reloc (basic-gtt-active)
[260.038476] Subtest basic-gtt-active: SKIP (0.000s)
[260.125563] [058/133] (761s left) gem_lmem_evict (dontneed-evict-race)
[260.166167] Subtest dontneed-evict-race: SKIP (0.000s)
[260.202310] [059/133] (761s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-render)
[260.298402] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-render
[267.169411] Subtest psr-1p-offscreen-pri-shrfb-draw-render: SUCCESS (6.871s)
[267.291149] [060/133] (754s left) i915_drm_fdinfo (busy-check-all)
[267.337373] Starting subtest: busy-check-all
[267.340025] Starting dynamic subtest: rcs0
[267.344462] Dynamic subtest rcs0: SKIP (0.004s)
[267.353830] Starting dynamic subtest: bcs0
[267.358156] Dynamic subtest bcs0: SKIP (0.000s)
[267.366592] Starting dynamic subtest: vcs0
[267.371116] Dynamic subtest vcs0: SKIP (0.000s)
[267.379408] Starting dynamic subtest: vcs1
[267.383908] Dynamic subtest vcs1: SKIP (0.000s)
[267.392184] Starting dynamic subtest: vecs0
[267.396768] Dynamic subtest vecs0: SKIP (0.000s)
[267.405306] Starting dynamic subtest: ccs0
[267.409801] Dynamic subtest ccs0: SKIP (0.000s)
[267.414271] Subtest busy-check-all: SKIP (0.009s)
[267.451196] [061/133] (754s left) intel_hwmon (hwmon-read)
[267.541470] Subtest hwmon-read: SKIP (0.000s)
[267.606254] [062/133] (754s left) gem_exec_create (forked)
[267.670252] Starting subtest: forked
[267.672802] Starting dynamic subtest: smem
[289.459146] Dynamic subtest smem: SUCCESS (21.785s)
[289.462162] Subtest forked: SUCCESS (21.787s)
[289.645820] [063/133] (732s left) gem_exec_whisper (basic-contexts)
[289.716322] Starting subtest: basic-contexts
[297.490457] Subtest basic-contexts: SUCCESS (7.770s)
[297.685658] [064/133] (724s left) kms_content_protection (lic-type-0)
[297.822646] Starting subtest: lic-type-0
[297.827276] Subtest lic-type-0: SKIP (0.000s)
[297.928925] [065/133] (723s left) kms_psr (psr-sprite-render)
[298.028420] Starting subtest: psr-sprite-render
[298.030716] Starting dynamic subtest: eDP-1
[299.820072] Dynamic subtest eDP-1: SUCCESS (1.793s)
[299.822461] Subtest psr-sprite-render: SUCCESS (1.794s)
[300.651042] [066/133] (721s left) syncobj_basic (bad-flags-handle-to-fd)
[300.705392] Starting subtest: bad-flags-handle-to-fd
[300.707782] Subtest bad-flags-handle-to-fd: SUCCESS (0.000s)
[300.804813] [067/133] (721s left) dumb_buffer (map-uaf)
[300.866012] Starting subtest: map-uaf
[300.868005] Subtest map-uaf: SUCCESS (0.005s)
[300.964036] [068/133] (721s left) kms_flip (single-buffer-flip-vs-dpms-off-vs-modeset)
[301.062177] Starting subtest: single-buffer-flip-vs-dpms-off-vs-modeset
[301.064556] Starting dynamic subtest: A-eDP1
[304.675526] Dynamic subtest A-eDP1: SUCCESS (3.615s)
[304.686187] Starting dynamic subtest: B-eDP1
[307.878491] Dynamic subtest B-eDP1: SUCCESS (3.202s)
[307.888287] Starting dynamic subtest: C-eDP1
[310.987095] Dynamic subtest C-eDP1: SUCCESS (3.108s)
[310.996697] Starting dynamic subtest: D-eDP1
[314.120092] Dynamic subtest D-eDP1: SUCCESS (3.133s)
[314.122520] Subtest single-buffer-flip-vs-dpms-off-vs-modeset: SUCCESS (13.065s)
[314.931103] [069/133] (707s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-mmap-cpu)
[315.031417] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-mmap-cpu
[318.962805] Subtest fbc-1p-offscreen-pri-shrfb-draw-mmap-cpu: SUCCESS (3.936s)
[320.105316] [070/133] (701s left) kms_color (ctm-0-25)
[320.202852] Starting subtest: ctm-0-25
[320.204823] Starting dynamic subtest: pipe-A-eDP-1
[323.696472] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.495s)
[323.706368] Starting dynamic subtest: pipe-B-eDP-1
[328.007318] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.312s)
[328.017745] Starting dynamic subtest: pipe-C-eDP-1
[332.046335] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.037s)
[332.055716] Starting dynamic subtest: pipe-D-eDP-1
[336.028009] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.982s)
[336.030318] Subtest ctm-0-25: SUCCESS (15.828s)
[336.855892] [071/133] (685s left) kms_lease (lease-invalid-crtc)
[336.951713] Starting subtest: lease-invalid-crtc
[336.953942] Starting dynamic subtest: pipe-A-eDP-1
[336.956218] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[336.965523] Starting dynamic subtest: pipe-B-eDP-1
[336.967719] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[336.975879] Starting dynamic subtest: pipe-C-eDP-1
[336.978189] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[336.986419] Starting dynamic subtest: pipe-D-eDP-1
[336.988650] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[336.990777] Subtest lease-invalid-crtc: SUCCESS (0.004s)
[337.027495] [072/133] (685s left) gem_userptr_blits (mmap-offset-banned)
[337.087712] Starting subtest: mmap-offset-banned
[337.090088] Starting dynamic subtest: wb
[337.092363] Dynamic subtest wb: SUCCESS (0.000s)
[337.103168] Starting dynamic subtest: wc
[337.105114] Dynamic subtest wc: SUCCESS (0.000s)
[337.113274] Starting dynamic subtest: uc
[337.115136] Dynamic subtest uc: SUCCESS (0.000s)
[337.117016] Subtest mmap-offset-banned: SUCCESS (0.002s)
[337.211878] [073/133] (684s left) kms_plane_multiple (2x-tiling-none)
[337.300352] Starting subtest: 2x-tiling-none
[337.304512] Subtest 2x-tiling-none: SKIP (0.000s)
[337.371884] [074/133] (684s left) kms_ccs (crc-primary-suspend-4-tiled-mtl-rc-ccs-cc)
[337.465695] Starting subtest: crc-primary-suspend-4-tiled-mtl-rc-ccs-cc
[337.468021] Starting dynamic subtest: pipe-A-eDP-1
[354.447603] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.393s)
[354.458221] Starting dynamic subtest: pipe-B-eDP-1
[371.452308] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.479s)
[371.462088] Starting dynamic subtest: pipe-C-eDP-1
[388.389499] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.413s)
[388.399294] Starting dynamic subtest: pipe-D-eDP-1
[405.436745] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.400s)
[405.438994] Subtest crc-primary-suspend-4-tiled-mtl-rc-ccs-cc: SUCCESS (8.690s)
[406.583576] [075/133] (615s left) kms_psr (fbc-pr-cursor-plane-move)
[406.703856] Starting subtest: fbc-pr-cursor-plane-move
[406.707774] Subtest fbc-pr-cursor-plane-move: SKIP (0.000s)
[406.775567] [076/133] (615s left) syncobj_eventfd (binary-wait)
[406.832353] Starting subtest: binary-wait
[406.840395] Subtest binary-wait: SUCCESS (0.010s)
[406.942198] [077/133] (615s left) kms_flip (flip-vs-rmfb-interruptible)
[407.035381] Starting subtest: flip-vs-rmfb-interruptible
[407.037644] Starting dynamic subtest: A-eDP1
[415.665256] Dynamic subtest A-eDP1: SUCCESS (8.687s)
[415.679544] Starting dynamic subtest: B-eDP1
[424.334882] Dynamic subtest B-eDP1: SUCCESS (8.688s)
[424.346907] Starting dynamic subtest: C-eDP1
[433.039902] Dynamic subtest C-eDP1: SUCCESS (8.712s)
[433.054034] Starting dynamic subtest: D-eDP1
[441.644848] Dynamic subtest D-eDP1: SUCCESS (8.600s)
[441.650092] Subtest flip-vs-rmfb-interruptible: SUCCESS (34.703s)
[442.842677] [078/133] (579s left) kms_chamelium_hpd (dp-hpd-storm)
[443.251158] Subtest dp-hpd-storm: SKIP (0.000s)
[444.044807] [079/133] (578s left) api_intel_bb (object-noreloc-purge-cache-simple)
[444.095686] Starting subtest: object-noreloc-purge-cache-simple
[444.098442] Subtest object-noreloc-purge-cache-simple: SUCCESS (0.005s)
[444.218547] [080/133] (578s left) kms_flip (2x-wf_vblank-ts-check-interruptible)
[444.307609] Starting subtest: 2x-wf_vblank-ts-check-interruptible
[444.318242] Subtest 2x-wf_vblank-ts-check-interruptible: SKIP (0.010s)
[444.394340] [081/133] (578s left) kms_plane (pixel-format-4-tiled-modifier)
[444.476033] Starting subtest: pixel-format-4-tiled-modifier
[444.503361] Starting dynamic subtest: pipe-A-plane-0
[445.135659] Dynamic subtest pipe-A-plane-0: SUCCESS (0.633s)
[445.145262] Starting dynamic subtest: pipe-A-plane-3
[445.535754] Dynamic subtest pipe-A-plane-3: SUCCESS (0.399s)
[445.545738] Starting dynamic subtest: pipe-A-plane-5
[445.549479] Dynamic subtest pipe-A-plane-5: SKIP (0.000s)
[446.641688] Starting dynamic subtest: pipe-B-plane-0
[447.300383] Dynamic subtest pipe-B-plane-0: SUCCESS (0.666s)
[447.309431] Starting dynamic subtest: pipe-B-plane-3
[447.733477] Dynamic subtest pipe-B-plane-3: SUCCESS (0.432s)
[447.744840] Starting dynamic subtest: pipe-B-plane-5
[447.748496] Dynamic subtest pipe-B-plane-5: SKIP (0.000s)
[448.057606] Subtest pixel-format-4-tiled-modifier: SUCCESS (3.581s)
[448.916176] [082/133] (573s left) gem_pwrite (basic-exhaustion)
[448.982886] Subtest basic-exhaustion: SKIP (0.000s)
[449.047321] [083/133] (573s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-pwrite)
[449.135472] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-pwrite
[455.900905] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-pwrite: SUCCESS (6.769s)
[456.025857] [084/133] (566s left) gem_workarounds (suspend-resume-fd)
[456.089294] Starting subtest: suspend-resume-fd
[472.254760] Subtest suspend-resume-fd: SUCCESS (1.183s)
[472.393630] [085/133] (550s left) kms_psr (pr-sprite-render)
[472.504466] Starting subtest: pr-sprite-render
[472.508983] Subtest pr-sprite-render: SKIP (0.000s)
[472.580548] [086/133] (550s left) syncobj_timeline (etime-single-wait-all-for-submit-unsubmitted)
[472.633102] Starting subtest: etime-single-wait-all-for-submit-unsubmitted
[472.736579] Subtest etime-single-wait-all-for-submit-unsubmitted: SUCCESS (0.102s)
[472.812040] [087/133] (549s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-mmap-cpu)
[472.913418] Starting subtest: psr-2p-primscrn-spr-indfb-draw-mmap-cpu
[472.918026] Subtest psr-2p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[473.007694] [088/133] (549s left) kms_plane_alpha_blend (constant-alpha-max)
[473.105239] Starting subtest: constant-alpha-max
[473.394961] Starting dynamic subtest: pipe-A-eDP-1
[474.480193] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.096s)
[474.490832] Starting dynamic subtest: pipe-D-eDP-1
[476.088826] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.624s)
[476.090822] Subtest constant-alpha-max: SUCCESS (3.017s)
[476.927523] [089/133] (545s left) gem_exec_fence (basic-busy-all)
[476.996345] Starting subtest: basic-busy-all
[477.087857] Subtest basic-busy-all: SUCCESS (0.094s)
[478.969923] [090/133] (543s left) sw_sync (alloc_merge_fence)
[479.005176] Starting subtest: alloc_merge_fence
[479.007970] Subtest alloc_merge_fence: SUCCESS (0.001s)
[479.063902] [091/133] (543s left) perf_pmu (semaphore-wait-idle)
[479.109443] Starting subtest: semaphore-wait-idle
[479.111959] Starting dynamic subtest: rcs0
[479.621314] Dynamic subtest rcs0: SUCCESS (0.517s)
[479.635557] Starting dynamic subtest: bcs0
[480.137917] Dynamic subtest bcs0: SUCCESS (0.516s)
[480.150793] Starting dynamic subtest: vcs0
[480.654960] Dynamic subtest vcs0: SUCCESS (0.518s)
[480.677205] Starting dynamic subtest: vcs1
[481.169104] Dynamic subtest vcs1: SUCCESS (0.514s)
[481.181363] Starting dynamic subtest: vecs0
[481.683962] Dynamic subtest vecs0: SUCCESS (0.514s)
[481.695215] Starting dynamic subtest: ccs0
[482.200577] Dynamic subtest ccs0: SUCCESS (0.515s)
[482.203335] Subtest semaphore-wait-idle: SUCCESS (3.111s)
[482.319546] [092/133] (540s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-pwrite)
[482.425073] Starting subtest: fbcpsr-rgb101010-draw-pwrite
[489.401110] Subtest fbcpsr-rgb101010-draw-pwrite: SUCCESS (6.997s)
[489.505193] [093/133] (533s left) syncobj_timeline (multi-wait-all-available-signaled)
[489.561596] Starting subtest: multi-wait-all-available-signaled
[489.564173] Subtest multi-wait-all-available-signaled: SUCCESS (0.000s)
[489.655648] [094/133] (533s left) kms_pm_rpm (universal-planes)
[491.194023] Starting subtest: universal-planes
[491.196501] Starting dynamic subtest: plane-34
[499.474191] Dynamic subtest plane-34: SUCCESS (8.292s)
[499.485611] Starting dynamic subtest: plane-64
[507.774836] Dynamic subtest plane-64: SUCCESS (8.299s)
[507.787493] Starting dynamic subtest: plane-94
[516.092884] Dynamic subtest plane-94: SUCCESS (8.314s)
[516.105627] Starting dynamic subtest: plane-124
[524.411386] Dynamic subtest plane-124: SUCCESS (8.316s)
[524.424471] Starting dynamic subtest: plane-134
[532.811775] Dynamic subtest plane-134: SUCCESS (8.399s)
[532.825093] Starting dynamic subtest: plane-144
[541.151932] Dynamic subtest plane-144: SUCCESS (8.340s)
[541.154694] Subtest universal-planes: SUCCESS (49.978s)
[541.539262] [095/133] (481s left) kms_big_fb (x-tiled-8bpp-rotate-180)
[541.657209] Starting subtest: x-tiled-8bpp-rotate-180
[542.904811] Subtest x-tiled-8bpp-rotate-180: SUCCESS (1.248s)
[543.025418] [096/133] (480s left) kms_flip_scaled_crc (flip-32bpp-ytileccs-to-64bpp-ytile-upscaling)
[543.111820] Starting subtest: flip-32bpp-ytileccs-to-64bpp-ytile-upscaling
[543.115708] Subtest flip-32bpp-ytileccs-to-64bpp-ytile-upscaling: SKIP (0.000s)
[543.183918] [097/133] (479s left) kms_busy (extended-pageflip-hang-newfb)
[543.283536] Starting subtest: extended-pageflip-hang-newfb
[543.285760] Starting dynamic subtest: pipe-A
[569.655973] Dynamic subtest pipe-A: SUCCESS (26.380s)
[569.666345] Starting dynamic subtest: pipe-D
[584.638340] Dynamic subtest pipe-D: SUCCESS (14.974s)
[584.640700] Subtest extended-pageflip-hang-newfb: SUCCESS (41.359s)
[585.486628] [098/133] (437s left) i915_drm_fdinfo (virtual-busy-idle-all)
[585.533941] Starting subtest: virtual-busy-idle-all
[585.539401] Subtest virtual-busy-idle-all: SKIP (0.000s)
[585.624475] [099/133] (437s left) kms_cursor_crc (cursor-sliding-32x32)
[585.772468] Starting subtest: cursor-sliding-32x32
[585.820290] Subtest cursor-sliding-32x32: SKIP (0.040s)
[586.105813] [100/133] (437s left) gem_exec_balancer (full-pulse)
[586.177030] Starting subtest: full-pulse
[590.735017] Subtest full-pulse: SUCCESS (4.560s)
[591.070064] [101/133] (432s left) kms_rotation_crc (primary-yf-tiled-reflect-x-270)
[591.166046] Starting subtest: primary-yf-tiled-reflect-x-270
[591.171194] Subtest primary-yf-tiled-reflect-x-270: SKIP (0.001s)
[591.239559] [102/133] (432s left) kms_feature_discovery (display-3x)
[591.335964] Starting subtest: display-3x
[591.341945] Subtest display-3x: SKIP (0.000s)
[591.424028] [103/133] (432s left) kms_flip (2x-plain-flip-fb-recreate)
[591.523813] Starting subtest: 2x-plain-flip-fb-recreate
[591.532563] Subtest 2x-plain-flip-fb-recreate: SKIP (0.010s)
[591.613845] [104/133] (431s left) syncobj_timeline (reset-multiple-signaled)
[591.665514] Starting subtest: reset-multiple-signaled
[591.668231] Subtest reset-multiple-signaled: SUCCESS (0.001s)
[591.769276] [105/133] (431s left) kms_plane_scaling (plane-upscale-20x20-with-modifiers)
[591.866385] Starting subtest: plane-upscale-20x20-with-modifiers
[591.868762] Starting dynamic subtest: pipe-A
[592.202227] Dynamic subtest pipe-A: SUCCESS (0.337s)
[592.217775] Starting dynamic subtest: pipe-B
[593.588869] Dynamic subtest pipe-B: SUCCESS (1.385s)
[593.598460] Starting dynamic subtest: pipe-C
[595.031960] Dynamic subtest pipe-C: SUCCESS (1.442s)
[595.041779] Starting dynamic subtest: pipe-D
[596.467747] Dynamic subtest pipe-D: SUCCESS (1.434s)
[596.470457] Subtest plane-upscale-20x20-with-modifiers: SUCCESS (4.604s)
[597.645287] [106/133] (425s left) gem_exec_schedule (submit-early-slice)
[597.709586] Starting subtest: submit-early-slice
[597.711988] Starting dynamic subtest: rcs0
[597.744212] Dynamic subtest rcs0: SUCCESS (0.045s)
[597.754312] Starting dynamic subtest: bcs0
[597.785886] Dynamic subtest bcs0: SUCCESS (0.040s)
[597.795587] Starting dynamic subtest: vcs0
[597.827885] Dynamic subtest vcs0: SUCCESS (0.041s)
[597.839700] Starting dynamic subtest: vcs1
[597.868971] Dynamic subtest vcs1: SUCCESS (0.041s)
[597.878260] Starting dynamic subtest: vecs0
[597.911076] Dynamic subtest vecs0: SUCCESS (0.041s)
[597.921936] Starting dynamic subtest: ccs0
[597.952705] Dynamic subtest ccs0: SUCCESS (0.041s)
[597.955584] Subtest submit-early-slice: SUCCESS (0.255s)
[598.971864] [107/133] (424s left) gem_ctx_shared (exec-single-timeline)
[599.039099] Starting subtest: exec-single-timeline
[599.042073] Starting dynamic subtest: rcs0
[600.140325] Dynamic subtest rcs0: SUCCESS (1.080s)
[600.154916] Starting dynamic subtest: bcs0
[601.209606] Dynamic subtest bcs0: SUCCESS (1.087s)
[601.222791] Starting dynamic subtest: vcs0
[602.298612] Dynamic subtest vcs0: SUCCESS (1.086s)
[602.314119] Starting dynamic subtest: vcs1
[603.386568] Dynamic subtest vcs1: SUCCESS (1.085s)
[603.398746] Starting dynamic subtest: vecs0
[604.473241] Dynamic subtest vecs0: SUCCESS (1.084s)
[604.486233] Starting dynamic subtest: ccs0
[605.563016] Dynamic subtest ccs0: SUCCESS (1.086s)
[605.566301] Subtest exec-single-timeline: SUCCESS (6.524s)
[605.769143] [108/133] (417s left) kms_psr2_sf (pr-cursor-plane-move-continuous-sf)
[605.884747] Starting subtest: pr-cursor-plane-move-continuous-sf
[605.890040] Subtest pr-cursor-plane-move-continuous-sf: SKIP (0.000s)
[605.953090] [109/133] (417s left) kms_ccs (bad-rotation-90-4-tiled-dg2-mc-ccs)
[606.046620] Starting subtest: bad-rotation-90-4-tiled-dg2-mc-ccs
[606.049182] Starting dynamic subtest: pipe-A-eDP-1
[606.074507] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[606.084667] Starting dynamic subtest: pipe-B-eDP-1
[606.107349] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[606.115821] Starting dynamic subtest: pipe-C-eDP-1
[606.137969] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[606.146181] Starting dynamic subtest: pipe-D-eDP-1
[606.168656] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[606.173128] Subtest bad-rotation-90-4-tiled-dg2-mc-ccs: SKIP (0.005s)
[608.232432] [110/133] (415s left) gem_create (create-massive)
[608.285716] Starting subtest: create-massive
[608.288191] Subtest create-massive: SUCCESS (0.000s)
[608.485989] [111/133] (415s left) kms_psr (fbc-psr-cursor-render)
[608.590694] Starting subtest: fbc-psr-cursor-render
[608.593186] Starting dynamic subtest: eDP-1
[608.598914] Dynamic subtest eDP-1: SKIP (0.000s)
[608.603899] Subtest fbc-psr-cursor-render: SKIP (0.001s)
[608.665611] [112/133] (415s left) syncobj_basic (create-signaled)
[608.734347] Starting subtest: create-signaled
[608.736838] Subtest create-signaled: SUCCESS (0.000s)
[608.825213] [113/133] (415s left) syncobj_timeline (single-wait-available-submitted)
[608.880210] Starting subtest: single-wait-available-submitted
[608.882806] Subtest single-wait-available-submitted: SUCCESS (0.000s)
[608.975272] [114/133] (414s left) core_auth (many-magics)
[609.038908] Starting subtest: many-magics
[609.929058] Subtest many-magics: SUCCESS (0.892s)
[610.097718] [115/133] (413s left) syncobj_wait (reset-unsignaled)
[610.154271] Starting subtest: reset-unsignaled
[610.156884] Subtest reset-unsignaled: SUCCESS (0.000s)
[610.275645] [116/133] (413s left) gem_exec_parallel (fds)
[610.341256] Starting subtest: fds
[610.344328] Starting dynamic subtest: rcs0
[614.807138] Dynamic subtest rcs0: SUCCESS (4.465s)
[614.820838] Starting dynamic subtest: bcs0
[619.216206] Dynamic subtest bcs0: SUCCESS (4.406s)
[619.228646] Starting dynamic subtest: vcs0
[624.890603] Dynamic subtest vcs0: SUCCESS (5.672s)
[624.900448] Starting dynamic subtest: vcs1
[629.091347] Dynamic subtest vcs1: SUCCESS (4.200s)
[629.103800] Starting dynamic subtest: vecs0
[633.175951] Dynamic subtest vecs0: SUCCESS (4.083s)
[633.188543] Starting dynamic subtest: ccs0
[638.035129] Dynamic subtest ccs0: SUCCESS (4.859s)
[638.038228] Subtest fds: SUCCESS (27.698s)
[638.230939] [117/133] (385s left) gen9_exec_parse (bb-start-cmd)
[638.297372] Subtest bb-start-cmd: SKIP (0.000s)
[638.366383] [118/133] (385s left) kms_frontbuffer_tracking (fbcpsr-tiling-4)
[638.475037] Starting subtest: fbcpsr-tiling-4
[645.537572] Subtest fbcpsr-tiling-4: SUCCESS (7.068s)
[645.648429] [119/133] (378s left) kms_hdmi_inject (inject-audio)
[646.011792] Starting subtest: inject-audio
[646.289086] Subtest inject-audio: SUCCESS (0.280s)
[646.846211] [120/133] (377s left) kms_cursor_crc (cursor-offscreen-256x85)
[647.105204] Starting subtest: cursor-offscreen-256x85
[647.148144] Subtest cursor-offscreen-256x85: SKIP (0.040s)
[647.357871] [121/133] (376s left) kms_big_fb (linear-32bpp-rotate-270)
[647.465269] Starting subtest: linear-32bpp-rotate-270
[647.484374] Subtest linear-32bpp-rotate-270: SKIP (0.019s)
[647.602043] [122/133] (376s left) kms_big_fb (y-tiled-32bpp-rotate-0)
[647.693261] Starting subtest: y-tiled-32bpp-rotate-0
[647.698084] Subtest y-tiled-32bpp-rotate-0: SKIP (0.000s)
[647.783098] [123/133] (376s left) kms_chamelium_color (gamma)
[647.883805] Subtest gamma: SKIP (0.000s)
[647.929509] [124/133] (376s left) i915_pm_rps (basic-api)
[647.979932] Starting subtest: basic-api
[647.984927] Subtest basic-api: SKIP (0.001s)
[648.078905] [125/133] (376s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling)
[648.168877] Subtest addfb25-framebuffer-vs-set-tiling: SKIP (0.000s)
[648.256933] [126/133] (376s left) gem_mmap_gtt (ptrace)
[648.310612] Subtest ptrace: SKIP (0.000s)
[648.378060] [127/133] (376s left) perf (gen12-oa-tlb-invalidate)
[648.474756] Starting subtest: gen12-oa-tlb-invalidate
[648.476937] Starting dynamic subtest: 0-rcs0
[658.514651] Dynamic subtest 0-rcs0: SUCCESS (10.040s)
[658.524857] Starting dynamic subtest: 1-vcs0
[668.560464] Dynamic subtest 1-vcs0: SUCCESS (10.048s)
[668.563483] Subtest gen12-oa-tlb-invalidate: SUCCESS (20.090s)
[668.615531] [128/133] (355s left) kms_cursor_legacy (single-move)
[668.739990] Starting subtest: single-move
[668.742645] Starting dynamic subtest: pipe-A
[674.120484] Dynamic subtest pipe-A: SUCCESS (5.379s)
[674.133180] Starting dynamic subtest: pipe-B
[679.500874] Dynamic subtest pipe-B: SUCCESS (5.379s)
[679.512916] Starting dynamic subtest: pipe-C
[684.880523] Dynamic subtest pipe-C: SUCCESS (5.379s)
[684.893071] Starting dynamic subtest: pipe-D
[690.260232] Dynamic subtest pipe-D: SUCCESS (5.379s)
[690.271942] Starting dynamic subtest: all-pipes
[695.646001] Dynamic subtest all-pipes: SUCCESS (5.385s)
[695.648996] Subtest single-move: SUCCESS (26.913s)
[695.793557] [129/133] (328s left) kms_async_flips (test-time-stamp)
[695.881928] Starting subtest: test-time-stamp
[696.255937] Starting dynamic subtest: pipe-A-eDP-1
[697.098068] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.839s)
[697.483133] Starting dynamic subtest: pipe-B-eDP-1
[698.230207] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.756s)
[698.600983] Starting dynamic subtest: pipe-C-eDP-1
[699.361171] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.765s)
[699.730452] Starting dynamic subtest: pipe-D-eDP-1
[700.494141] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.769s)
[700.497145] Subtest test-time-stamp: SUCCESS (4.610s)
[701.644787] [130/133] (322s left) gem_render_copy (y-tiled-to-vebox-y-tiled)
[701.709082] Starting subtest: y-tiled-to-vebox-y-tiled
[701.714792] Subtest y-tiled-to-vebox-y-tiled: SKIP (0.000s)
[701.903265] [131/133] (322s left) syncobj_wait (wait-all-for-submit-snapshot)
[701.961139] Starting subtest: wait-all-for-submit-snapshot
[702.041458] Subtest wait-all-for-submit-snapshot: SUCCESS (0.082s)
[702.119271] [132/133] (322s left) kms_psr (fbc-psr2-cursor-plane-move)
[702.204758] Starting subtest: fbc-psr2-cursor-plane-move
[702.207178] Starting dynamic subtest: eDP-1
[702.211997] Dynamic subtest eDP-1: SKIP (0.000s)
[702.217067] Subtest fbc-psr2-cursor-plane-move: SKIP (0.001s)
[702.285998] [133/133] (322s left) sw_sync (sync_merge_same)
[702.318076] Starting subtest: sync_merge_same
[702.321003] Subtest sync_merge_same: SUCCESS (0.000s)
[702.368355] Closing watchdogs
results: parsing output: 0/ for test: kms_cursor_legacy
results: parsing output: 1/ for test: gem_ctx_persistence
results: parsing output: 2/ for test: gem_eio
results: parsing output: 3/ for test: kms_big_fb
results: parsing output: 4/ for test: syncobj_wait
results: parsing output: 5/ for test: gem_exec_schedule
results: parsing output: 6/ for test: dumb_buffer
results: parsing output: 7/ for test: gem_fence_thrash
results: parsing output: 8/ for test: kms_plane
results: parsing output: 9/ for test: kms_ccs
results: parsing output: 10/ for test: kms_cursor_legacy
results: parsing output: 11/ for test: kms_vblank
results: parsing output: 12/ for test: syncobj_wait
results: parsing output: 13/ for test: kms_cursor_crc
results: parsing output: 14/ for test: syncobj_wait
results: parsing output: 15/ for test: kms_chamelium_audio
results: parsing output: 16/ for test: kms_addfb_basic
results: parsing output: 17/ for test: perf_pmu
results: parsing output: 18/ for test: kms_joiner
results: parsing output: 19/ for test: kms_frontbuffer_tracking
results: parsing output: 20/ for test: api_intel_allocator
results: parsing output: 21/ for test: prime_self_import
results: parsing output: 22/ for test: gem_exec_schedule
results: parsing output: 23/ for test: kms_frontbuffer_tracking
results: parsing output: 24/ for test: kms_psr
results: parsing output: 25/ for test: kms_frontbuffer_tracking
results: parsing output: 26/ for test: gem_mmap_wc
results: parsing output: 27/ for test: sysfs_heartbeat_interval
results: parsing output: 28/ for test: gem_render_copy
results: parsing output: 29/ for test: gem_spin_batch
results: parsing output: 30/ for test: kms_cursor_legacy
results: parsing output: 31/ for test: kms_pm_rpm
results: parsing output: 32/ for test: kms_big_fb
results: parsing output: 33/ for test: kms_frontbuffer_tracking
results: parsing output: 34/ for test: kms_frontbuffer_tracking
results: parsing output: 35/ for test: kms_frontbuffer_tracking
results: parsing output: 36/ for test: prime_self_import
results: parsing output: 37/ for test: kms_psr2_sf
results: parsing output: 38/ for test: kms_big_fb
results: parsing output: 39/ for test: perf
results: parsing output: 40/ for test: kms_frontbuffer_tracking
results: parsing output: 41/ for test: gem_exec_params
results: parsing output: 42/ for test: kms_flip_scaled_crc
results: parsing output: 43/ for test: kms_properties
results: parsing output: 44/ for test: kms_vblank
results: parsing output: 45/ for test: kms_frontbuffer_tracking
results: parsing output: 46/ for test: kms_frontbuffer_tracking
results: parsing output: 47/ for test: gem_ctx_persistence
results: parsing output: 48/ for test: gem_tiled_partial_pwrite_pread
results: parsing output: 49/ for test: gem_exec_balancer
results: parsing output: 50/ for test: kms_ccs
results: parsing output: 51/ for test: gem_mmap_gtt
results: parsing output: 52/ for test: i915_power
results: parsing output: 53/ for test: gem_exec_fence
results: parsing output: 54/ for test: gem_lmem_swapping
results: parsing output: 55/ for test: kms_frontbuffer_tracking
results: parsing output: 56/ for test: gem_exec_reloc
results: parsing output: 57/ for test: gem_lmem_evict
results: parsing output: 58/ for test: kms_frontbuffer_tracking
results: parsing output: 59/ for test: i915_drm_fdinfo
results: parsing output: 60/ for test: intel_hwmon
results: parsing output: 61/ for test: gem_exec_create
results: parsing output: 62/ for test: gem_exec_whisper
results: parsing output: 63/ for test: kms_content_protection
results: parsing output: 64/ for test: kms_psr
results: parsing output: 65/ for test: syncobj_basic
results: parsing output: 66/ for test: dumb_buffer
results: parsing output: 67/ for test: kms_flip
results: parsing output: 68/ for test: kms_frontbuffer_tracking
results: parsing output: 69/ for test: kms_color
results: parsing output: 70/ for test: kms_lease
results: parsing output: 71/ for test: gem_userptr_blits
results: parsing output: 72/ for test: kms_plane_multiple
results: parsing output: 73/ for test: kms_ccs
results: parsing output: 74/ for test: kms_psr
results: parsing output: 75/ for test: syncobj_eventfd
results: parsing output: 76/ for test: kms_flip
results: parsing output: 77/ for test: kms_chamelium_hpd
results: parsing output: 78/ for test: api_intel_bb
results: parsing output: 79/ for test: kms_flip
results: parsing output: 80/ for test: kms_plane
results: parsing output: 81/ for test: gem_pwrite
results: parsing output: 82/ for test: kms_frontbuffer_tracking
results: parsing output: 83/ for test: gem_workarounds
results: parsing output: 84/ for test: kms_psr
results: parsing output: 85/ for test: syncobj_timeline
results: parsing output: 86/ for test: kms_frontbuffer_tracking
results: parsing output: 87/ for test: kms_plane_alpha_blend
results: parsing output: 88/ for test: gem_exec_fence
results: parsing output: 89/ for test: sw_sync
results: parsing output: 90/ for test: perf_pmu
results: parsing output: 91/ for test: kms_frontbuffer_tracking
results: parsing output: 92/ for test: syncobj_timeline
results: parsing output: 93/ for test: kms_pm_rpm
results: parsing output: 94/ for test: kms_big_fb
results: parsing output: 95/ for test: kms_flip_scaled_crc
results: parsing output: 96/ for test: kms_busy
results: parsing output: 97/ for test: i915_drm_fdinfo
results: parsing output: 98/ for test: kms_cursor_crc
results: parsing output: 99/ for test: gem_exec_balancer
results: parsing output: 100/ for test: kms_rotation_crc
results: parsing output: 101/ for test: kms_feature_discovery
results: parsing output: 102/ for test: kms_flip
results: parsing output: 103/ for test: syncobj_timeline
results: parsing output: 104/ for test: kms_plane_scaling
results: parsing output: 105/ for test: gem_exec_schedule
results: parsing output: 106/ for test: gem_ctx_shared
results: parsing output: 107/ for test: kms_psr2_sf
results: parsing output: 108/ for test: kms_ccs
results: parsing output: 109/ for test: gem_create
results: parsing output: 110/ for test: kms_psr
results: parsing output: 111/ for test: syncobj_basic
results: parsing output: 112/ for test: syncobj_timeline
results: parsing output: 113/ for test: core_auth
results: parsing output: 114/ for test: syncobj_wait
results: parsing output: 115/ for test: gem_exec_parallel
results: parsing output: 116/ for test: gen9_exec_parse
results: parsing output: 117/ for test: kms_frontbuffer_tracking
results: parsing output: 118/ for test: kms_hdmi_inject
results: parsing output: 119/ for test: kms_cursor_crc
results: parsing output: 120/ for test: kms_big_fb
results: parsing output: 121/ for test: kms_big_fb
results: parsing output: 122/ for test: kms_chamelium_color
results: parsing output: 123/ for test: i915_pm_rps
results: parsing output: 124/ for test: kms_addfb_basic
results: parsing output: 125/ for test: gem_mmap_gtt
results: parsing output: 126/ for test: perf
results: parsing output: 127/ for test: kms_cursor_legacy
results: parsing output: 128/ for test: kms_async_flips
results: parsing output: 129/ for test: gem_render_copy
results: parsing output: 130/ for test: syncobj_wait
results: parsing output: 131/ for test: kms_psr
results: parsing output: 132/ for test: sw_sync
Done.