[60.667609] Initializing watchdogs
[60.667656]   /dev/watchdog0
[60.681714] [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]
[60.686246] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[60.688531] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[60.691923] [001/131] (960s left) kms_atomic_transition (plane-all-transition)
[60.810059] Starting subtest: plane-all-transition
[60.812394] Starting dynamic subtest: pipe-A-eDP-1
[63.347277] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.539s)
[63.662810] Starting dynamic subtest: pipe-B-eDP-1
[66.878506] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.222s)
[67.176319] Subtest plane-all-transition: SUCCESS (6.363s)
[68.018716] [002/131] (953s left) syncobj_timeline (multi-wait-available-unsubmitted-submitted)
[68.092087] Starting subtest: multi-wait-available-unsubmitted-submitted
[68.094507] Subtest multi-wait-available-unsubmitted-submitted: SUCCESS (0.001s)
[68.229593] [003/131] (953s left) kms_frontbuffer_tracking (fbc-rgb565-draw-mmap-gtt)
[68.330428] Starting subtest: fbc-rgb565-draw-mmap-gtt
[68.334509] Subtest fbc-rgb565-draw-mmap-gtt: SKIP (0.000s)
[68.461211] [004/131] (952s left) gen9_exec_parse (bb-start-param)
[68.531268] Subtest bb-start-param: SKIP (0.000s)
[68.607566] [005/131] (952s left) syncobj_wait (invalid-signal-one-illegal-handle)
[68.674764] Starting subtest: invalid-signal-one-illegal-handle
[68.677029] Subtest invalid-signal-one-illegal-handle: SUCCESS (0.000s)
[68.785306] [006/131] (952s left) kms_psr (fbc-pr-cursor-plane-onoff)
[68.875671] Starting subtest: fbc-pr-cursor-plane-onoff
[68.879773] Subtest fbc-pr-cursor-plane-onoff: SKIP (0.000s)
[68.969559] [007/131] (952s left) syncobj_timeline (etime-single-wait-all-available-unsubmitted)
[69.026039] Starting subtest: etime-single-wait-all-available-unsubmitted
[69.135036] Subtest etime-single-wait-all-available-unsubmitted: SUCCESS (0.107s)
[69.230388] [008/131] (952s left) kms_ccs (crc-sprite-planes-basic-4-tiled-dg2-rc-ccs)
[69.330027] Starting subtest: crc-sprite-planes-basic-4-tiled-dg2-rc-ccs
[69.332462] Starting dynamic subtest: pipe-A-eDP-1
[69.397027] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[69.405987] Starting dynamic subtest: pipe-B-eDP-1
[69.463413] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[69.472058] Starting dynamic subtest: pipe-C-eDP-1
[69.529629] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[69.537794] Starting dynamic subtest: pipe-D-eDP-1
[69.595946] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[69.600581] Subtest crc-sprite-planes-basic-4-tiled-dg2-rc-ccs: SKIP (0.008s)
[71.505343] [009/131] (949s left) syncobj_wait (reset-unsignaled)
[71.570489] Starting subtest: reset-unsignaled
[71.572808] Subtest reset-unsignaled: SUCCESS (0.000s)
[71.706040] [010/131] (949s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-downscaling)
[71.801436] Starting subtest: flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-downscaling
[71.803697] Starting dynamic subtest: pipe-A-default-mode
[72.110168] Dynamic subtest pipe-A-default-mode: SKIP (0.305s)
[72.114844] Subtest flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-downscaling: SKIP (0.306s)
[72.940653] [011/131] (948s left) gem_fenced_exec_thrash (no-spare-fences-interruptible)
[73.012813] Subtest no-spare-fences-interruptible: SKIP (0.000s)
[73.081219] [012/131] (948s left) perf (i915-ref-count)
[73.169278] Starting subtest: i915-ref-count
[73.239396] Subtest i915-ref-count: SUCCESS (0.071s)
[73.293097] [013/131] (948s left) gem_exec_reloc (basic-wc-gtt-active)
[73.356157] Subtest basic-wc-gtt-active: SKIP (0.000s)
[73.425876] [014/131] (948s left) kms_chamelium_hpd (vga-hpd-enable-disable-mode)
[73.810381] Subtest vga-hpd-enable-disable-mode: SKIP (0.000s)
[74.623149] [015/131] (947s left) kms_addfb_basic (bad-pitch-0)
[74.683051] Starting subtest: bad-pitch-0
[74.685385] Subtest bad-pitch-0: SUCCESS (0.000s)
[74.845242] [016/131] (946s left) gem_render_copy (y-tiled-mc-ccs-to-vebox-y-tiled)
[74.899118] Starting subtest: y-tiled-mc-ccs-to-vebox-y-tiled
[74.903722] Subtest y-tiled-mc-ccs-to-vebox-y-tiled: SKIP (0.000s)
[75.099047] [017/131] (946s left) kms_psr2_sf (psr2-overlay-plane-move-continuous-exceed-fully-sf)
[80.098634] Starting subtest: psr2-overlay-plane-move-continuous-exceed-fully-sf
[80.100912] Starting dynamic subtest: pipe-A-eDP-1
[97.291768] Dynamic subtest pipe-A-eDP-1: SUCCESS (17.190s)
[97.300263] Starting dynamic subtest: pipe-B-eDP-1
[114.424233] Dynamic subtest pipe-B-eDP-1: SUCCESS (17.130s)
[114.426567] Subtest psr2-overlay-plane-move-continuous-exceed-fully-sf: SUCCESS (34.324s)
[115.248984] [018/131] (906s left) gem_exec_schedule (semaphore-noskip)
[115.331054] Starting subtest: semaphore-noskip
[115.737864] Subtest semaphore-noskip: SUCCESS (0.413s)
[116.086579] [019/131] (905s left) gem_mmap_gtt (ptrace)
[116.154951] Subtest ptrace: SKIP (0.000s)
[116.217215] [020/131] (905s left) kms_addfb_basic (bad-pitch-256)
[116.270776] Starting subtest: bad-pitch-256
[116.272603] Subtest bad-pitch-256: SUCCESS (0.000s)
[116.456251] [021/131] (905s left) kms_cursor_crc (cursor-offscreen-128x128)
[116.662816] Starting subtest: cursor-offscreen-128x128
[116.667312] Starting dynamic subtest: pipe-A-eDP-1
[118.631285] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.963s)
[118.657431] Starting dynamic subtest: pipe-D-eDP-1
[121.227557] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.573s)
[121.229588] Subtest cursor-offscreen-128x128: SUCCESS (4.562s)
[122.113163] [022/131] (899s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-mmap-cpu)
[122.213137] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-mmap-cpu
[122.217764] Subtest fbc-2p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[122.338637] [023/131] (899s left) gem_exec_gttfill (engines)
[122.390366] Starting subtest: engines
[122.392769] Starting dynamic subtest: rcs0
[145.170590] Dynamic subtest rcs0: SUCCESS (22.776s)
[145.181931] Starting dynamic subtest: bcs0
[168.428325] Dynamic subtest bcs0: SUCCESS (23.255s)
[168.438913] Starting dynamic subtest: vcs0
[191.673467] Dynamic subtest vcs0: SUCCESS (23.243s)
[191.684051] Starting dynamic subtest: vcs1
[214.875433] Dynamic subtest vcs1: SUCCESS (23.200s)
[214.888063] Starting dynamic subtest: vecs0
[238.110305] Dynamic subtest vecs0: SUCCESS (23.233s)
[238.118392] Starting dynamic subtest: ccs0
[261.344856] Dynamic subtest ccs0: SUCCESS (23.232s)
[261.347809] Subtest engines: SUCCESS (138.948s)
[261.556781] [024/131] (760s left) gem_mmap_wc (set-cache-level)
[261.650610] Subtest set-cache-level: SKIP (0.000s)
[261.715532] [025/131] (760s left) kms_ccs (missing-ccs-buffer-4-tiled-mtl-mc-ccs)
[261.823079] Starting subtest: missing-ccs-buffer-4-tiled-mtl-mc-ccs
[261.825439] Starting dynamic subtest: pipe-A-eDP-1
[261.846100] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.020s)
[261.855795] Starting dynamic subtest: pipe-B-eDP-1
[261.876056] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.020s)
[261.884261] Starting dynamic subtest: pipe-C-eDP-1
[261.904272] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.019s)
[261.912369] Starting dynamic subtest: pipe-D-eDP-1
[261.932890] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.020s)
[261.934794] Subtest missing-ccs-buffer-4-tiled-mtl-mc-ccs: SUCCESS (0.083s)
[264.078509] [026/131] (758s left) kms_pipe_b_c_ivb (pipe-b-double-modeset-then-modeset-pipe-c)
[264.136975] Subtest pipe-B-double-modeset-then-modeset-pipe-C: SKIP (0.000s)
[264.203849] [027/131] (757s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip)
[264.330067] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip
[265.141392] Subtest x-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip: SUCCESS (0.815s)
[265.363284] [028/131] (756s left) syncobj_timeline (multi-wait-available-signaled)
[265.430670] Starting subtest: multi-wait-available-signaled
[265.433261] Subtest multi-wait-available-signaled: SUCCESS (0.001s)
[265.566963] [029/131] (756s left) perf_pmu (busy)
[265.614176] Starting subtest: busy
[265.616438] Starting dynamic subtest: rcs0
[266.234410] Dynamic subtest rcs0: SUCCESS (0.621s)
[266.245325] Starting dynamic subtest: bcs0
[266.809883] Dynamic subtest bcs0: SUCCESS (0.574s)
[266.821117] Starting dynamic subtest: vcs0
[267.929298] Dynamic subtest vcs0: SUCCESS (1.117s)
[267.940783] Starting dynamic subtest: vcs1
[269.914608] Dynamic subtest vcs1: SUCCESS (1.982s)
[269.925795] Starting dynamic subtest: vecs0
[271.898312] Dynamic subtest vecs0: SUCCESS (1.982s)
[271.907732] Starting dynamic subtest: ccs0
[272.465398] Dynamic subtest ccs0: SUCCESS (0.566s)
[272.467909] Subtest busy: SUCCESS (6.853s)
[272.605188] [030/131] (749s left) gem_exec_async (forked-writes)
[272.679760] Starting subtest: forked-writes
[272.682240] Starting dynamic subtest: rcs0
[272.713625] Dynamic subtest rcs0: SUCCESS (0.034s)
[272.725706] Starting dynamic subtest: bcs0
[272.736365] Dynamic subtest bcs0: SUCCESS (0.022s)
[272.744637] Starting dynamic subtest: vcs0
[272.763494] Dynamic subtest vcs0: SUCCESS (0.027s)
[272.772525] Starting dynamic subtest: vcs1
[272.786456] Dynamic subtest vcs1: SUCCESS (0.022s)
[272.795598] Starting dynamic subtest: vecs0
[272.809084] Dynamic subtest vecs0: SUCCESS (0.021s)
[272.823346] Starting dynamic subtest: ccs0
[272.835128] Dynamic subtest ccs0: SUCCESS (0.025s)
[272.837373] Subtest forked-writes: SUCCESS (0.156s)
[273.120293] [031/131] (749s left) gem_eio (in-flight-contexts-1us)
[273.346460] Starting subtest: in-flight-contexts-1us
[286.950964] Subtest in-flight-contexts-1us: SUCCESS (13.603s)
[287.153595] [032/131] (735s left) kms_ccs (crc-primary-rotation-180-4-tiled-dg2-rc-ccs)
[287.251280] Starting subtest: crc-primary-rotation-180-4-tiled-dg2-rc-ccs
[287.253580] Starting dynamic subtest: pipe-A-eDP-1
[287.276435] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[287.286415] Starting dynamic subtest: pipe-B-eDP-1
[287.307136] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[287.315945] Starting dynamic subtest: pipe-C-eDP-1
[287.337689] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[287.346152] Starting dynamic subtest: pipe-D-eDP-1
[287.368642] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[287.373260] Subtest crc-primary-rotation-180-4-tiled-dg2-rc-ccs: SKIP (0.005s)
[289.456952] [033/131] (732s left) kms_psr (fbc-psr-primary-mmap-cpu)
[289.549261] Starting subtest: fbc-psr-primary-mmap-cpu
[289.551489] Starting dynamic subtest: eDP-1
[289.555594] Dynamic subtest eDP-1: SKIP (0.000s)
[289.559729] Subtest fbc-psr-primary-mmap-cpu: SKIP (0.001s)
[289.640067] [034/131] (732s left) kms_big_fb (y-tiled-16bpp-rotate-90)
[289.746342] Starting subtest: y-tiled-16bpp-rotate-90
[289.750539] Subtest y-tiled-16bpp-rotate-90: SKIP (0.000s)
[289.871344] [035/131] (732s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-blt)
[289.967580] Starting subtest: psr-2p-primscrn-cur-indfb-draw-blt
[289.971691] Subtest psr-2p-primscrn-cur-indfb-draw-blt: SKIP (0.000s)
[290.090644] [036/131] (732s left) kms_hdr (static-swap)
[290.185870] Starting subtest: static-swap
[290.192633] Subtest static-swap: SKIP (0.001s)
[290.285071] [037/131] (732s left) gem_spin_batch (resubmit)
[290.348133] Starting subtest: resubmit
[290.350553] Starting dynamic subtest: rcs0
[290.355512] Dynamic subtest rcs0: SUCCESS (0.006s)
[290.365805] Starting dynamic subtest: bcs0
[290.368162] Dynamic subtest bcs0: SUCCESS (0.002s)
[290.376300] Starting dynamic subtest: vcs0
[290.377873] Dynamic subtest vcs0: SUCCESS (0.002s)
[290.385364] Starting dynamic subtest: vcs1
[290.387117] Dynamic subtest vcs1: SUCCESS (0.002s)
[290.394681] Starting dynamic subtest: vecs0
[290.396276] Dynamic subtest vecs0: SUCCESS (0.003s)
[290.403893] Starting dynamic subtest: ccs0
[290.405596] Dynamic subtest ccs0: SUCCESS (0.002s)
[290.407203] Subtest resubmit: SUCCESS (0.020s)
[290.637391] [038/131] (731s left) gem_ccs (ctrl-surf-copy)
[290.707077] Starting subtest: ctrl-surf-copy
[290.711022] Subtest ctrl-surf-copy: SKIP (0.000s)
[290.845961] [039/131] (731s left) syncobj_eventfd (timeline-wait-signaled)
[290.912949] Starting subtest: timeline-wait-signaled
[290.915030] Subtest timeline-wait-signaled: SUCCESS (0.000s)
[291.035605] [040/131] (731s left) gem_exec_balancer (parallel-out-fence)
[291.305309] Starting subtest: parallel-out-fence
[292.491358] Subtest parallel-out-fence: SUCCESS (1.186s)
[292.637632] [041/131] (730s left) syncobj_wait (single-wait-all-submitted)
[292.713395] Starting subtest: single-wait-all-submitted
[292.821055] Subtest single-wait-all-submitted: SUCCESS (0.107s)
[292.934267] [042/131] (729s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-shrfb-msflip-blt)
[293.040398] Starting subtest: fbcpsr-1p-primscrn-shrfb-msflip-blt
[300.461952] Subtest fbcpsr-1p-primscrn-shrfb-msflip-blt: SUCCESS (7.422s)
[300.621786] [043/131] (722s left) kms_flip (flip-vs-panning)
[300.736512] Starting subtest: flip-vs-panning
[300.738557] Starting dynamic subtest: A-eDP1
[309.483327] Dynamic subtest A-eDP1: SUCCESS (8.749s)
[309.494214] Starting dynamic subtest: B-eDP1
[318.214751] Dynamic subtest B-eDP1: SUCCESS (8.730s)
[318.225534] Starting dynamic subtest: C-eDP1
[326.928062] Dynamic subtest C-eDP1: SUCCESS (8.711s)
[326.937762] Starting dynamic subtest: D-eDP1
[335.664076] Dynamic subtest D-eDP1: SUCCESS (8.735s)
[335.666162] Subtest flip-vs-panning: SUCCESS (34.933s)
[336.946560] [044/131] (685s left) kms_vblank (ts-continuation-suspend)
[337.053222] Starting subtest: ts-continuation-suspend
[337.055151] Starting dynamic subtest: pipe-A-eDP-1
[353.249585] Dynamic subtest pipe-A-eDP-1: SUCCESS (5.319s)
[353.263995] Starting dynamic subtest: pipe-D-eDP-1
[370.230113] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.173s)
[370.232617] Subtest ts-continuation-suspend: SUCCESS (7.496s)
[371.074966] [045/131] (651s left) gem_lmem_swapping (verify-ccs)
[371.130045] Subtest verify-ccs: SKIP (0.000s)
[371.175363] [046/131] (651s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-blt)
[371.276882] Starting subtest: fbcpsr-rgb565-draw-blt
[378.465228] Subtest fbcpsr-rgb565-draw-blt: SUCCESS (7.172s)
[378.638292] [047/131] (644s left) gem_render_copy (yf-tiled-ccs-to-yf-tiled)
[378.704221] Starting subtest: yf-tiled-ccs-to-yf-tiled
[378.708692] Subtest yf-tiled-ccs-to-yf-tiled: SKIP (0.000s)
[378.912017] [048/131] (644s left) kms_chamelium_frames (hdmi-crc-fast)
[379.302023] Subtest hdmi-crc-fast: SKIP (0.000s)
[380.113681] [049/131] (642s left) kms_chamelium_edid (dp-edid-change-during-suspend)
[380.492620] Subtest dp-edid-change-during-suspend: SKIP (0.000s)
[381.351875] [050/131] (641s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180)
[381.444573] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180
[381.448974] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180: SKIP (0.000s)
[381.566263] [051/131] (641s left) gem_workarounds (suspend-resume-context)
[381.630773] Starting subtest: suspend-resume-context
[397.940416] Subtest suspend-resume-context: SUCCESS (1.231s)
[398.113669] [052/131] (625s left) perf (invalid-remove-userspace-config)
[398.249802] Starting subtest: invalid-remove-userspace-config
[398.258969] Subtest invalid-remove-userspace-config: SUCCESS (0.009s)
[398.296399] [053/131] (624s left) gem_exec_fence (basic-wait-all)
[398.362197] Starting subtest: basic-wait-all
[398.471048] Subtest basic-wait-all: SUCCESS (0.109s)
[400.766344] [FACT gem_exec_fence (basic-wait-all)] new: kernel.kmod_is_loaded.vgem: true
[400.769746] [054/131] (622s left) gem_mmap_gtt (basic-write)
[400.834304] Subtest basic-write: SKIP (0.000s)
[400.898845] [055/131] (622s left) gem_exec_flush (basic-wb-pro-default)
[400.967230] Starting subtest: basic-wb-pro-default
[406.439815] Subtest basic-wb-pro-default: SUCCESS (5.460s)
[406.652821] [056/131] (616s left) gem_userptr_blits (invalid-mmap-offset-unsync)
[406.720018] Subtest invalid-mmap-offset-unsync: SKIP (0.000s)
[406.895904] [057/131] (616s left) kms_frontbuffer_tracking (fbc-2p-pri-indfb-multidraw)
[407.004057] Starting subtest: fbc-2p-pri-indfb-multidraw
[407.008108] Subtest fbc-2p-pri-indfb-multidraw: SKIP (0.000s)
[407.118322] [058/131] (616s left) gem_pxp (create-protected-buffer)
[407.246654] Starting subtest: create-protected-buffer
[407.249110] Subtest create-protected-buffer: SUCCESS (0.000s)
[407.397120] [059/131] (616s left) perf (polling)
[407.509459] Starting subtest: polling
[407.514072] Starting dynamic subtest: 0-rcs0
[417.532327] Dynamic subtest 0-rcs0: SUCCESS (10.010s)
[417.542571] Starting dynamic subtest: 1-vecs0
[427.559028] Dynamic subtest 1-vecs0: SUCCESS (10.019s)
[427.561744] Subtest polling: SUCCESS (20.032s)
[427.647792] [060/131] (595s left) kms_atomic (plane-invalid-params)
[427.748304] Starting subtest: plane-invalid-params
[427.750496] Starting dynamic subtest: pipe-A-eDP-1
[428.146423] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.398s)
[428.148841] Subtest plane-invalid-params: SUCCESS (0.400s)
[429.007523] [061/131] (594s left) kms_prop_blob (basic)
[429.057431] Starting subtest: basic
[429.059841] Subtest basic: SUCCESS (0.000s)
[429.183876] [062/131] (594s left) kms_flip (nonexisting-fb-interruptible)
[429.276706] Starting subtest: nonexisting-fb-interruptible
[429.279019] Starting dynamic subtest: A-eDP1
[430.469618] Dynamic subtest A-eDP1: SUCCESS (1.191s)
[430.480300] Starting dynamic subtest: B-eDP1
[431.609588] Dynamic subtest B-eDP1: SUCCESS (1.139s)
[431.620401] Starting dynamic subtest: C-eDP1
[432.749202] Dynamic subtest C-eDP1: SUCCESS (1.139s)
[432.759505] Starting dynamic subtest: D-eDP1
[433.876530] Dynamic subtest D-eDP1: SUCCESS (1.127s)
[433.882711] Subtest nonexisting-fb-interruptible: SUCCESS (4.605s)
[435.071392] [063/131] (588s left) kms_prop_blob (invalid-get-prop-any)
[435.142436] Starting subtest: invalid-get-prop-any
[435.144894] Subtest invalid-get-prop-any: SUCCESS (0.000s)
[435.278274] [064/131] (588s left) kms_vblank (query-forked-busy)
[435.376680] Starting subtest: query-forked-busy
[435.378852] Starting dynamic subtest: pipe-A-eDP-1
[437.252799] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.874s)
[437.278285] Starting dynamic subtest: pipe-D-eDP-1
[439.817281] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.564s)
[439.820042] Subtest query-forked-busy: SUCCESS (4.443s)
[440.648807] [065/131] (583s left) kms_frontbuffer_tracking (fbc-1p-pri-indfb-multidraw)
[440.749930] Starting subtest: fbc-1p-pri-indfb-multidraw
[453.792782] Subtest fbc-1p-pri-indfb-multidraw: SUCCESS (13.045s)
[455.177518] [066/131] (568s left) kms_plane_scaling (invalid-num-scalers)
[455.281505] Starting subtest: invalid-num-scalers
[455.283715] Starting dynamic subtest: pipe-A-eDP-1-invalid-num-scalers
[455.304425] Dynamic subtest pipe-A-eDP-1-invalid-num-scalers: SUCCESS (0.021s)
[455.314284] Starting dynamic subtest: pipe-B-eDP-1-invalid-num-scalers
[455.335893] Dynamic subtest pipe-B-eDP-1-invalid-num-scalers: SUCCESS (0.031s)
[455.345616] Starting dynamic subtest: pipe-C-eDP-1-invalid-num-scalers
[455.369426] Dynamic subtest pipe-C-eDP-1-invalid-num-scalers: SUCCESS (0.032s)
[455.379582] Starting dynamic subtest: pipe-D-eDP-1-invalid-num-scalers
[455.401229] Dynamic subtest pipe-D-eDP-1-invalid-num-scalers: SUCCESS (0.031s)
[455.403525] Subtest invalid-num-scalers: SUCCESS (0.121s)
[455.524578] [067/131] (568s left) i915_pm_rps (fence-order)
[455.587232] Starting subtest: fence-order
[458.542269] Subtest fence-order: SUCCESS (2.951s)
[458.691222] [068/131] (565s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-pwrite)
[458.799595] Starting subtest: fbc-rgb101010-draw-pwrite
[464.217122] Subtest fbc-rgb101010-draw-pwrite: SUCCESS (5.419s)
[465.373385] [069/131] (558s left) gem_mmap_gtt (fault-concurrent)
[465.455786] Subtest fault-concurrent: SKIP (0.000s)
[465.534154] [070/131] (558s left) gem_ctx_isolation (dirty-switch)
[465.596215] Starting subtest: dirty-switch
[465.598450] Starting dynamic subtest: rcs0
[465.786541] Dynamic subtest rcs0: SUCCESS (0.190s)
[465.798535] Starting dynamic subtest: bcs0
[466.001702] Dynamic subtest bcs0: SUCCESS (0.214s)
[466.013775] Starting dynamic subtest: vcs0
[466.208202] Dynamic subtest vcs0: SUCCESS (0.205s)
[466.220456] Starting dynamic subtest: vcs1
[467.853160] Dynamic subtest vcs1: SUCCESS (1.644s)
[467.865644] Starting dynamic subtest: vecs0
[469.866437] Dynamic subtest vecs0: SUCCESS (2.012s)
[469.878739] Starting dynamic subtest: ccs0
[471.941577] Dynamic subtest ccs0: SUCCESS (2.074s)
[471.943998] Subtest dirty-switch: SUCCESS (6.344s)
[472.219123] [071/131] (551s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-fullscreen)
[472.328155] Starting subtest: psr-2p-primscrn-spr-indfb-fullscreen
[472.332318] Subtest psr-2p-primscrn-spr-indfb-fullscreen: SKIP (0.000s)
[472.451326] [072/131] (551s left) gem_exec_reloc (basic-write-gtt-active)
[472.513328] Subtest basic-write-gtt-active: SKIP (0.000s)
[472.598467] [073/131] (551s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-gtt)
[472.702373] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-gtt
[472.706411] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[472.815844] [074/131] (551s left) kms_frontbuffer_tracking (psr-indfb-scaledprimary)
[472.916094] Starting subtest: psr-indfb-scaledprimary
[478.715191] Subtest psr-indfb-scaledprimary: SUCCESS (5.799s)
[478.866684] [075/131] (545s left) kms_big_fb (x-tiled-8bpp-rotate-0)
[478.973530] Starting subtest: x-tiled-8bpp-rotate-0
[480.176542] Subtest x-tiled-8bpp-rotate-0: SUCCESS (1.203s)
[480.372119] [076/131] (543s left) sysfs_heartbeat_interval (invalid)
[480.439086] Starting subtest: invalid
[480.441057] Starting dynamic subtest: vecs0
[480.442896] Dynamic subtest vecs0: SUCCESS (0.000s)
[480.453364] Starting dynamic subtest: ccs0
[480.455121] Dynamic subtest ccs0: SUCCESS (0.000s)
[480.464170] Starting dynamic subtest: vcs0
[480.465951] Dynamic subtest vcs0: SUCCESS (0.000s)
[480.475402] Starting dynamic subtest: bcs0
[480.477294] Dynamic subtest bcs0: SUCCESS (0.000s)
[480.486891] Starting dynamic subtest: rcs0
[480.488704] Dynamic subtest rcs0: SUCCESS (0.000s)
[480.497927] Starting dynamic subtest: vcs1
[480.499563] Dynamic subtest vcs1: SUCCESS (0.000s)
[480.501159] Subtest invalid: SUCCESS (0.005s)
[480.576356] [077/131] (543s left) perf_pmu (render-node-busy)
[480.664493] Starting subtest: render-node-busy
[480.666697] Starting dynamic subtest: rcs0
[481.228081] Dynamic subtest rcs0: SUCCESS (0.565s)
[481.241298] Starting dynamic subtest: bcs0
[481.790496] Dynamic subtest bcs0: SUCCESS (0.560s)
[481.803196] Starting dynamic subtest: vcs0
[483.657529] Dynamic subtest vcs0: SUCCESS (1.863s)
[483.670184] Starting dynamic subtest: vcs1
[485.641791] Dynamic subtest vcs1: SUCCESS (1.980s)
[485.654447] Starting dynamic subtest: vecs0
[487.624819] Dynamic subtest vecs0: SUCCESS (1.979s)
[487.637313] Starting dynamic subtest: ccs0
[488.191949] Dynamic subtest ccs0: SUCCESS (0.565s)
[488.194400] Subtest render-node-busy: SUCCESS (7.529s)
[488.307515] [078/131] (536s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-onoff)
[488.408700] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-onoff
[495.399772] Subtest fbcpsr-1p-primscrn-cur-indfb-onoff: SUCCESS (6.990s)
[495.556856] [079/131] (528s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-indfb-msflip-blt)
[495.653655] Starting subtest: fbcpsr-2p-scndscrn-indfb-msflip-blt
[495.657660] Subtest fbcpsr-2p-scndscrn-indfb-msflip-blt: SKIP (0.000s)
[495.774774] [080/131] (528s left) gem_exec_fence (syncobj-export)
[496.214390] Starting subtest: syncobj-export
[496.217457] Subtest syncobj-export: SUCCESS (0.006s)
[497.807379] [081/131] (526s left) i915_module_load (resize-bar)
[497.843837] Starting subtest: resize-bar
[497.855056] Subtest resize-bar: SKIP (0.006s)
[497.900265] [082/131] (526s left) template (b)
[497.956864] Starting subtest: B
[497.959140] Subtest B: SUCCESS (0.000s)
[498.101323] [083/131] (526s left) gem_userptr_blits (map-fixed-invalidate-busy)
[498.178302] Starting subtest: map-fixed-invalidate-busy
[498.182426] Subtest map-fixed-invalidate-busy: SKIP (0.000s)
[498.340065] [084/131] (526s left) kms_flip (2x-flip-vs-expired-vblank)
[498.444765] Starting subtest: 2x-flip-vs-expired-vblank
[498.456093] Subtest 2x-flip-vs-expired-vblank: SKIP (0.011s)
[498.586125] [085/131] (526s left) api_intel_bb (crc32)
[498.649161] Starting subtest: crc32
[498.651183] Starting dynamic subtest: rcs0-smem0
[498.955003] Dynamic subtest rcs0-smem0: SUCCESS (0.307s)
[498.967618] Starting dynamic subtest: bcs0-smem0
[499.256527] Dynamic subtest bcs0-smem0: SUCCESS (0.299s)
[499.268612] Starting dynamic subtest: vcs0-smem0
[499.580944] Dynamic subtest vcs0-smem0: SUCCESS (0.322s)
[499.594161] Starting dynamic subtest: vcs1-smem0
[499.931162] Dynamic subtest vcs1-smem0: SUCCESS (0.346s)
[499.943986] Starting dynamic subtest: vecs0-smem0
[500.284553] Dynamic subtest vecs0-smem0: SUCCESS (0.350s)
[500.297815] Starting dynamic subtest: ccs0-smem0
[500.604071] Dynamic subtest ccs0-smem0: SUCCESS (0.315s)
[500.607102] Subtest crc32: SUCCESS (1.958s)
[500.773022] [086/131] (523s left) vgem_basic (dmabuf-export)
[500.822324] Starting subtest: dmabuf-export
[500.846705] Subtest dmabuf-export: SUCCESS (0.025s)
[500.983228] [087/131] (523s left) kms_psr (psr2-sprite-blt)
[501.089573] Starting subtest: psr2-sprite-blt
[501.091832] Starting dynamic subtest: eDP-1
[502.787638] Dynamic subtest eDP-1: SUCCESS (1.697s)
[502.790019] Subtest psr2-sprite-blt: SUCCESS (1.698s)
[503.668529] [088/131] (521s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-mmap-wc)
[503.763715] Starting subtest: psr-2p-primscrn-spr-indfb-draw-mmap-wc
[503.767566] Subtest psr-2p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[503.892742] [089/131] (520s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-mmap-gtt)
[503.981666] Starting subtest: psr-1p-primscrn-pri-indfb-draw-mmap-gtt
[503.985555] Subtest psr-1p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[504.122558] [090/131] (520s left) kms_cursor_legacy (modeset-atomic-cursor-hotspot)
[504.243336] Starting subtest: modeset-atomic-cursor-hotspot
[504.247650] Subtest modeset-atomic-cursor-hotspot: SKIP (0.000s)
[504.409894] [091/131] (520s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-pwrite)
[504.507026] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-pwrite
[509.383508] Subtest fbc-1p-offscreen-pri-indfb-draw-pwrite: SUCCESS (4.879s)
[510.601544] [092/131] (514s left) core_getstats (basic)
[510.654375] Starting subtest: basic
[510.656780] Subtest basic: SUCCESS (0.000s)
[510.784428] [093/131] (514s left) kms_cursor_crc (cursor-random-max-size)
[511.156721] Starting subtest: cursor-random-max-size
[511.163476] Subtest cursor-random-max-size: SKIP (0.000s)
[511.326037] [094/131] (513s left) kms_async_flips (basic-modeset-with-all-modifiers-formats)
[511.428232] Starting subtest: basic-modeset-with-all-modifiers-formats
[511.801360] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-XRGB8888
[512.547856] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-XRGB8888: SUCCESS (0.748s)
[512.557847] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-XRGB2101010
[512.569823] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-XRGB2101010: SUCCESS (0.021s)
[512.579318] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-XRGB16161616F
[512.592145] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-XRGB16161616F: SUCCESS (0.022s)
[512.601650] Starting dynamic subtest: pipe-A-eDP-1-4-RGB565
[512.758711] Dynamic subtest pipe-A-eDP-1-4-RGB565: SUCCESS (0.166s)
[512.768280] Starting dynamic subtest: pipe-A-eDP-1-4-XRGB8888
[512.780730] Dynamic subtest pipe-A-eDP-1-4-XRGB8888: SUCCESS (0.021s)
[512.790640] Starting dynamic subtest: pipe-A-eDP-1-4-XRGB2101010
[512.803206] Dynamic subtest pipe-A-eDP-1-4-XRGB2101010: SUCCESS (0.021s)
[512.812808] Starting dynamic subtest: pipe-A-eDP-1-4-XRGB16161616F
[512.825558] Dynamic subtest pipe-A-eDP-1-4-XRGB16161616F: SUCCESS (0.021s)
[512.835010] Starting dynamic subtest: pipe-A-eDP-1-4-YUYV
[512.848040] Dynamic subtest pipe-A-eDP-1-4-YUYV: SUCCESS (0.021s)
[512.858800] Starting dynamic subtest: pipe-A-eDP-1-4-Y210
[512.870046] Dynamic subtest pipe-A-eDP-1-4-Y210: SUCCESS (0.021s)
[512.880959] Starting dynamic subtest: pipe-A-eDP-1-4-XYUV8888
[512.892139] Dynamic subtest pipe-A-eDP-1-4-XYUV8888: SUCCESS (0.021s)
[512.902400] Starting dynamic subtest: pipe-A-eDP-1-4-XV30
[512.914516] Dynamic subtest pipe-A-eDP-1-4-XV30: SUCCESS (0.021s)
[512.926080] Starting dynamic subtest: pipe-A-eDP-1-4-XV36
[512.936554] Dynamic subtest pipe-A-eDP-1-4-XV36: SUCCESS (0.021s)
[512.946159] Starting dynamic subtest: pipe-A-eDP-1-x-RGB565
[513.103432] Dynamic subtest pipe-A-eDP-1-x-RGB565: SUCCESS (0.166s)
[513.114965] Starting dynamic subtest: pipe-A-eDP-1-x-XRGB8888
[513.125500] Dynamic subtest pipe-A-eDP-1-x-XRGB8888: SUCCESS (0.021s)
[513.135361] Starting dynamic subtest: pipe-A-eDP-1-x-XRGB2101010
[513.147720] Dynamic subtest pipe-A-eDP-1-x-XRGB2101010: SUCCESS (0.021s)
[513.158540] Starting dynamic subtest: pipe-A-eDP-1-x-XRGB16161616F
[513.169851] Dynamic subtest pipe-A-eDP-1-x-XRGB16161616F: SUCCESS (0.021s)
[513.179509] Starting dynamic subtest: pipe-A-eDP-1-x-YUYV
[513.192267] Dynamic subtest pipe-A-eDP-1-x-YUYV: SUCCESS (0.021s)
[513.203166] Starting dynamic subtest: pipe-A-eDP-1-x-Y210
[513.214279] Dynamic subtest pipe-A-eDP-1-x-Y210: SUCCESS (0.021s)
[513.223665] Starting dynamic subtest: pipe-A-eDP-1-x-XYUV8888
[513.236490] Dynamic subtest pipe-A-eDP-1-x-XYUV8888: SUCCESS (0.021s)
[513.246496] Starting dynamic subtest: pipe-A-eDP-1-x-XV30
[513.258602] Dynamic subtest pipe-A-eDP-1-x-XV30: SUCCESS (0.022s)
[513.267633] Starting dynamic subtest: pipe-A-eDP-1-x-XV36
[513.280875] Dynamic subtest pipe-A-eDP-1-x-XV36: SUCCESS (0.022s)
[513.293056] Starting dynamic subtest: pipe-A-eDP-1-linear-RGB565
[513.436953] Dynamic subtest pipe-A-eDP-1-linear-RGB565: SUCCESS (0.155s)
[513.452174] Starting dynamic subtest: pipe-A-eDP-1-linear-XRGB8888
[513.459286] Dynamic subtest pipe-A-eDP-1-linear-XRGB8888: SUCCESS (0.021s)
[513.474200] Starting dynamic subtest: pipe-A-eDP-1-linear-XRGB2101010
[513.481410] Dynamic subtest pipe-A-eDP-1-linear-XRGB2101010: SUCCESS (0.021s)
[513.496088] Starting dynamic subtest: pipe-A-eDP-1-linear-XRGB16161616F
[513.503702] Dynamic subtest pipe-A-eDP-1-linear-XRGB16161616F: SUCCESS (0.021s)
[513.515249] Starting dynamic subtest: pipe-A-eDP-1-linear-YUYV
[513.525313] Dynamic subtest pipe-A-eDP-1-linear-YUYV: SUCCESS (0.021s)
[513.534548] Starting dynamic subtest: pipe-A-eDP-1-linear-Y210
[513.547702] Dynamic subtest pipe-A-eDP-1-linear-Y210: SUCCESS (0.022s)
[513.556991] Starting dynamic subtest: pipe-A-eDP-1-linear-XYUV8888
[513.569880] Dynamic subtest pipe-A-eDP-1-linear-XYUV8888: SUCCESS (0.022s)
[513.578931] Starting dynamic subtest: pipe-A-eDP-1-linear-XV30
[513.592183] Dynamic subtest pipe-A-eDP-1-linear-XV30: SUCCESS (0.022s)
[513.606645] Starting dynamic subtest: pipe-A-eDP-1-linear-XV36
[513.614383] Dynamic subtest pipe-A-eDP-1-linear-XV36: SUCCESS (0.021s)
[514.021509] Subtest basic-modeset-with-all-modifiers-formats: SUCCESS (2.595s)
[514.859849] [095/131] (510s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-blt)
[514.974998] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-blt
[521.812673] Subtest psr-1p-offscreen-pri-shrfb-draw-blt: SUCCESS (6.840s)
[521.996859] [096/131] (503s left) kms_pm_rpm (dpms-lpsp)
[523.829485] Starting subtest: dpms-lpsp
[524.227561] Subtest dpms-lpsp: SUCCESS (0.401s)
[524.340816] [097/131] (500s left) gem_exec_whisper (basic-contexts-forked)
[524.419852] Starting subtest: basic-contexts-forked
[545.304175] Subtest basic-contexts-forked: SUCCESS (20.880s)
[545.512348] [098/131] (479s left) kms_psr (fbc-pr-sprite-plane-move)
[545.606593] Starting subtest: fbc-pr-sprite-plane-move
[545.610628] Subtest fbc-pr-sprite-plane-move: SKIP (0.000s)
[545.707209] [099/131] (479s left) i915_drm_fdinfo (busy-hang)
[545.749504] Starting subtest: busy-hang
[545.751920] Starting dynamic subtest: rcs0
[545.790248] Dynamic subtest rcs0: SKIP (0.038s)
[545.802017] Starting dynamic subtest: bcs0
[545.806082] Dynamic subtest bcs0: SKIP (0.001s)
[545.816628] Starting dynamic subtest: vcs0
[545.821022] Dynamic subtest vcs0: SKIP (0.000s)
[545.830522] Starting dynamic subtest: vcs1
[545.834532] Dynamic subtest vcs1: SKIP (0.000s)
[545.843856] Starting dynamic subtest: vecs0
[545.847944] Dynamic subtest vecs0: SKIP (0.000s)
[545.857533] Starting dynamic subtest: ccs0
[545.861530] Dynamic subtest ccs0: SKIP (0.000s)
[545.865582] Subtest busy-hang: SKIP (0.046s)
[545.902856] [100/131] (479s left) prime_self_import (basic-with_one_bo_two_files)
[545.941261] Starting subtest: basic-with_one_bo_two_files
[545.963189] Subtest basic-with_one_bo_two_files: SUCCESS (0.022s)
[546.079790] [101/131] (479s left) kms_ccs (bad-rotation-90-4-tiled-lnl-ccs)
[546.175629] Starting subtest: bad-rotation-90-4-tiled-lnl-ccs
[546.180186] Subtest bad-rotation-90-4-tiled-lnl-ccs: SKIP (0.000s)
[547.350076] [102/131] (478s left) kms_ccs (bad-aux-stride-4-tiled-mtl-rc-ccs-cc)
[547.448520] Starting subtest: bad-aux-stride-4-tiled-mtl-rc-ccs-cc
[547.450768] Starting dynamic subtest: pipe-A-eDP-1
[547.471181] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[547.482649] Starting dynamic subtest: pipe-B-eDP-1
[547.501901] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[547.511536] Starting dynamic subtest: pipe-C-eDP-1
[547.530822] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[547.541088] Starting dynamic subtest: pipe-D-eDP-1
[547.560126] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[547.562039] Subtest bad-aux-stride-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.008s)
[549.718655] [103/131] (475s left) kms_cursor_crc (cursor-sliding-128x128)
[549.925173] Starting subtest: cursor-sliding-128x128
[549.927528] Starting dynamic subtest: pipe-A-eDP-1
[553.193052] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.265s)
[553.225228] Starting dynamic subtest: pipe-D-eDP-1
[557.077614] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.860s)
[557.080045] Subtest cursor-sliding-128x128: SUCCESS (7.151s)
[557.976999] [104/131] (467s left) kms_addfb_basic (invalid-get-prop)
[558.047512] Starting subtest: invalid-get-prop
[558.050164] Subtest invalid-get-prop: SUCCESS (0.000s)
[558.225440] [105/131] (467s left) gem_readwrite (read-write)
[558.278417] Subtest read-write: SKIP (0.000s)
[558.345936] [106/131] (467s left) gem_eio (create)
[558.576795] Starting subtest: create
[558.931370] Subtest create: SUCCESS (0.353s)
[559.077768] [107/131] (466s left) gem_exercise_blt (fast-copy-emit)
[559.140962] Starting subtest: fast-copy-emit
[559.142815] Starting dynamic subtest: linear-smem-smem-emit
[559.161867] Dynamic subtest linear-smem-smem-emit: SUCCESS (0.021s)
[559.173802] Starting dynamic subtest: xmajor-smem-smem-emit
[559.182577] Dynamic subtest xmajor-smem-smem-emit: SUCCESS (0.020s)
[559.194948] Starting dynamic subtest: tile4-smem-smem-emit
[559.204239] Dynamic subtest tile4-smem-smem-emit: SUCCESS (0.020s)
[559.215897] Starting dynamic subtest: tile64-smem-smem-emit
[559.222394] Dynamic subtest tile64-smem-smem-emit: SUCCESS (0.017s)
[559.224767] Subtest fast-copy-emit: SUCCESS (0.081s)
[559.390869] [108/131] (466s left) kms_plane_scaling (plane-upscale-20x20-with-rotation)
[559.492442] Starting subtest: plane-upscale-20x20-with-rotation
[559.494522] Starting dynamic subtest: pipe-A
[559.719225] Dynamic subtest pipe-A: SUCCESS (0.227s)
[559.732582] Starting dynamic subtest: pipe-B
[561.041604] Dynamic subtest pipe-B: SUCCESS (1.321s)
[561.051684] Starting dynamic subtest: pipe-C
[562.365368] Dynamic subtest pipe-C: SUCCESS (1.323s)
[562.376008] Starting dynamic subtest: pipe-D
[563.691964] Dynamic subtest pipe-D: SUCCESS (1.325s)
[563.694318] Subtest plane-upscale-20x20-with-rotation: SUCCESS (4.199s)
[564.895143] [109/131] (460s left) syncobj_wait (invalid-multi-wait-all-unsubmitted-submitted)
[564.955048] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted
[564.957011] Subtest invalid-multi-wait-all-unsubmitted-submitted: SUCCESS (0.000s)
[565.095845] [110/131] (460s left) gem_exec_schedule (implicit-boths)
[565.167525] Starting subtest: implicit-boths
[565.169347] Starting dynamic subtest: rcs0
[565.269354] Dynamic subtest rcs0: SUCCESS (0.111s)
[565.281452] Starting dynamic subtest: vcs0
[565.349676] Dynamic subtest vcs0: SUCCESS (0.080s)
[565.362410] Starting dynamic subtest: vcs1
[565.431179] Dynamic subtest vcs1: SUCCESS (0.080s)
[565.443277] Starting dynamic subtest: vecs0
[565.511257] Dynamic subtest vecs0: SUCCESS (0.079s)
[565.524540] Starting dynamic subtest: ccs0
[565.606518] Dynamic subtest ccs0: SUCCESS (0.094s)
[565.609299] Subtest implicit-boths: SUCCESS (0.449s)
[566.809269] [111/131] (458s left) kms_psr (psr2-cursor-plane-onoff)
[566.911788] Starting subtest: psr2-cursor-plane-onoff
[566.914097] Starting dynamic subtest: eDP-1
[568.632691] Dynamic subtest eDP-1: SUCCESS (1.721s)
[568.634890] Subtest psr2-cursor-plane-onoff: SUCCESS (1.722s)
[569.450403] [112/131] (456s left) prime_vgem (wait)
[569.523745] Starting subtest: wait
[569.525678] Starting dynamic subtest: rcs0
[569.615943] Dynamic subtest rcs0: SUCCESS (0.094s)
[569.628229] Starting dynamic subtest: bcs0
[569.689674] Dynamic subtest bcs0: SUCCESS (0.073s)
[569.699726] Starting dynamic subtest: vcs0
[569.729550] Dynamic subtest vcs0: SUCCESS (0.039s)
[569.739596] Starting dynamic subtest: vcs1
[569.776731] Dynamic subtest vcs1: SUCCESS (0.046s)
[569.786772] Starting dynamic subtest: vecs0
[569.821136] Dynamic subtest vecs0: SUCCESS (0.044s)
[569.830901] Starting dynamic subtest: ccs0
[569.870188] Dynamic subtest ccs0: SUCCESS (0.048s)
[569.872302] Subtest wait: SUCCESS (0.350s)
[570.042927] [113/131] (455s left) kms_dp_linktrain_fallback (dsc-fallback)
[570.131595] Starting subtest: dsc-fallback
[570.138213] Subtest dsc-fallback: SKIP (0.000s)
[570.230377] [114/131] (455s left) gem_exec_reloc (basic-cpu-gtt-noreloc)
[570.288174] Subtest basic-cpu-gtt-noreloc: SKIP (0.000s)
[570.385922] [115/131] (455s left) gem_create (create-clear)
[570.444849] Starting subtest: create-clear
[570.447745] Starting dynamic subtest: smem0
[603.287110] Dynamic subtest smem0: SUCCESS (32.831s)
[603.289521] Subtest create-clear: SUCCESS (32.832s)
[603.505381] [116/131] (422s left) kms_frontbuffer_tracking (fbc-suspend)
[603.613891] Starting subtest: fbc-suspend
[641.452637] Subtest fbc-suspend: SUCCESS (7.463s)
[642.682518] [117/131] (383s left) kms_cursor_legacy (cursorb-vs-flipa-toggle)
[642.815456] Starting subtest: cursorB-vs-flipA-toggle
[642.819952] Subtest cursorB-vs-flipA-toggle: SKIP (0.001s)
[642.986513] [118/131] (383s left) kms_color (legacy-gamma-reset)
[643.083859] Starting subtest: legacy-gamma-reset
[643.085726] Starting dynamic subtest: pipe-A-eDP-1
[643.468196] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.385s)
[643.478905] Starting dynamic subtest: pipe-B-eDP-1
[643.481237] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.012s)
[643.491318] Starting dynamic subtest: pipe-C-eDP-1
[643.496409] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.012s)
[643.506554] Starting dynamic subtest: pipe-D-eDP-1
[643.508868] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.012s)
[643.511189] Subtest legacy-gamma-reset: SUCCESS (0.424s)
[644.311056] [119/131] (381s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-blt)
[644.411554] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-blt
[644.415874] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[644.543122] [120/131] (381s left) gem_ctx_persistence (legacy-engines-mixed)
[644.618834] Starting subtest: legacy-engines-mixed
[644.621258] Starting dynamic subtest: render
[644.748061] Dynamic subtest render: SUCCESS (0.128s)
[644.762401] Starting dynamic subtest: bsd1
[644.834067] Dynamic subtest bsd1: SUCCESS (0.083s)
[644.847314] Starting dynamic subtest: bsd2
[644.926235] Dynamic subtest bsd2: SUCCESS (0.089s)
[644.943738] Starting dynamic subtest: blt
[645.005563] Dynamic subtest blt: SUCCESS (0.077s)
[645.021824] Starting dynamic subtest: vebox
[645.041208] Dynamic subtest vebox: SUCCESS (0.033s)
[645.043602] Subtest legacy-engines-mixed: SUCCESS (0.422s)
[645.214753] [121/131] (380s left) kms_plane_multiple (tiling-none)
[645.316390] Starting subtest: tiling-none
[645.318258] Starting dynamic subtest: pipe-A-eDP-1
[649.048076] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.723s)
[649.059217] Starting dynamic subtest: pipe-B-eDP-1
[653.452836] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.397s)
[653.463860] Starting dynamic subtest: pipe-C-eDP-1
[657.758652] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.300s)
[657.770179] Starting dynamic subtest: pipe-D-eDP-1
[662.099171] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.336s)
[662.101152] Subtest tiling-none: SUCCESS (16.762s)
[662.921231] [122/131] (363s left) kms_flip (2x-flip-vs-suspend-interruptible)
[663.032860] Starting subtest: 2x-flip-vs-suspend-interruptible
[663.044910] Subtest 2x-flip-vs-suspend-interruptible: SKIP (0.011s)
[663.150617] [123/131] (363s left) i915_pm_rps (thresholds-idle)
[663.221050] Starting subtest: thresholds-idle
[663.225442] Subtest thresholds-idle: SKIP (0.001s)
[663.358378] [124/131] (362s left) kms_rotation_crc (multiplane-rotation-cropping-bottom)
[663.471949] Starting subtest: multiplane-rotation-cropping-bottom
[680.824021] Subtest multiplane-rotation-cropping-bottom: SUCCESS (17.353s)
[681.000062] [125/131] (345s left) kms_big_fb (linear-64bpp-rotate-90)
[681.119347] Starting subtest: linear-64bpp-rotate-90
[681.141596] Subtest linear-64bpp-rotate-90: SKIP (0.021s)
[681.280117] [126/131] (345s left) kms_lease (lease-unleased-crtc)
[681.381214] Starting subtest: lease-unleased-crtc
[681.382978] Starting dynamic subtest: pipe-A-eDP-1
[681.669620] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.288s)
[681.680081] Starting dynamic subtest: pipe-B-eDP-1
[682.446246] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.774s)
[682.457789] Starting dynamic subtest: pipe-C-eDP-1
[682.459962] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.004s)
[682.469988] Starting dynamic subtest: pipe-D-eDP-1
[682.472176] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.006s)
[682.474348] Subtest lease-unleased-crtc: SUCCESS (1.080s)
[682.857328] [127/131] (343s left) kms_flip (flip-vs-panning-interruptible)
[682.958336] Starting subtest: flip-vs-panning-interruptible
[682.960662] Starting dynamic subtest: A-eDP1
[691.639183] Dynamic subtest A-eDP1: SUCCESS (8.678s)
[691.650705] Starting dynamic subtest: B-eDP1
[700.371530] Dynamic subtest B-eDP1: SUCCESS (8.728s)
[700.391866] Starting dynamic subtest: C-eDP1
[709.084897] Dynamic subtest C-eDP1: SUCCESS (8.708s)
[709.097519] Starting dynamic subtest: D-eDP1
[717.820649] Dynamic subtest D-eDP1: SUCCESS (8.731s)
[717.824914] Subtest flip-vs-panning-interruptible: SUCCESS (34.857s)
[719.011033] [128/131] (307s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0-async-flip)
[719.114521] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0-async-flip
[719.727950] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SUCCESS (0.615s)
[719.952591] [129/131] (306s left) api_intel_allocator (open-vm)
[720.001915] Starting subtest: open-vm
[720.004240] Subtest open-vm: SUCCESS (0.003s)
[720.155610] [130/131] (306s left) kms_pipe_crc_basic (hang-read-crc)
[720.246902] Starting subtest: hang-read-crc
[720.248813] Starting dynamic subtest: pipe-A-eDP-1
[722.359126] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.111s)
[722.372687] Starting dynamic subtest: pipe-B-eDP-1
[725.064017] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.703s)
[725.075284] Starting dynamic subtest: pipe-C-eDP-1
[727.687376] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.622s)
[727.699444] Starting dynamic subtest: pipe-D-eDP-1
[730.341448] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.651s)
[730.343940] Subtest hang-read-crc: SUCCESS (10.092s)
[731.196056] [131/131] (295s left) syncobj_timeline (wait-any-interrupted)
[731.262433] Starting subtest: wait-any-interrupted
[731.363677] Subtest wait-any-interrupted: SUCCESS (0.102s)
[731.462779] Closing watchdogs
results: parsing output: 0/ for test: kms_atomic_transition
results: parsing output: 1/ for test: syncobj_timeline
results: parsing output: 2/ for test: kms_frontbuffer_tracking
results: parsing output: 3/ for test: gen9_exec_parse
results: parsing output: 4/ for test: syncobj_wait
results: parsing output: 5/ for test: kms_psr
results: parsing output: 6/ for test: syncobj_timeline
results: parsing output: 7/ for test: kms_ccs
results: parsing output: 8/ for test: syncobj_wait
results: parsing output: 9/ for test: kms_flip_scaled_crc
results: parsing output: 10/ for test: gem_fenced_exec_thrash
results: parsing output: 11/ for test: perf
results: parsing output: 12/ for test: gem_exec_reloc
results: parsing output: 13/ for test: kms_chamelium_hpd
results: parsing output: 14/ for test: kms_addfb_basic
results: parsing output: 15/ for test: gem_render_copy
results: parsing output: 16/ for test: kms_psr2_sf
results: parsing output: 17/ for test: gem_exec_schedule
results: parsing output: 18/ for test: gem_mmap_gtt
results: parsing output: 19/ for test: kms_addfb_basic
results: parsing output: 20/ for test: kms_cursor_crc
results: parsing output: 21/ for test: kms_frontbuffer_tracking
results: parsing output: 22/ for test: gem_exec_gttfill
results: parsing output: 23/ for test: gem_mmap_wc
results: parsing output: 24/ for test: kms_ccs
results: parsing output: 25/ for test: kms_pipe_b_c_ivb
results: parsing output: 26/ for test: kms_big_fb
results: parsing output: 27/ for test: syncobj_timeline
results: parsing output: 28/ for test: perf_pmu
results: parsing output: 29/ for test: gem_exec_async
results: parsing output: 30/ for test: gem_eio
results: parsing output: 31/ for test: kms_ccs
results: parsing output: 32/ for test: kms_psr
results: parsing output: 33/ for test: kms_big_fb
results: parsing output: 34/ for test: kms_frontbuffer_tracking
results: parsing output: 35/ for test: kms_hdr
results: parsing output: 36/ for test: gem_spin_batch
results: parsing output: 37/ for test: gem_ccs
results: parsing output: 38/ for test: syncobj_eventfd
results: parsing output: 39/ for test: gem_exec_balancer
results: parsing output: 40/ for test: syncobj_wait
results: parsing output: 41/ for test: kms_frontbuffer_tracking
results: parsing output: 42/ for test: kms_flip
results: parsing output: 43/ for test: kms_vblank
results: parsing output: 44/ for test: gem_lmem_swapping
results: parsing output: 45/ for test: kms_frontbuffer_tracking
results: parsing output: 46/ for test: gem_render_copy
results: parsing output: 47/ for test: kms_chamelium_frames
results: parsing output: 48/ for test: kms_chamelium_edid
results: parsing output: 49/ for test: kms_big_fb
results: parsing output: 50/ for test: gem_workarounds
results: parsing output: 51/ for test: perf
results: parsing output: 52/ for test: gem_exec_fence
results: parsing output: 53/ for test: gem_mmap_gtt
results: parsing output: 54/ for test: gem_exec_flush
results: parsing output: 55/ for test: gem_userptr_blits
results: parsing output: 56/ for test: kms_frontbuffer_tracking
results: parsing output: 57/ for test: gem_pxp
results: parsing output: 58/ for test: perf
results: parsing output: 59/ for test: kms_atomic
results: parsing output: 60/ for test: kms_prop_blob
results: parsing output: 61/ for test: kms_flip
results: parsing output: 62/ for test: kms_prop_blob
results: parsing output: 63/ for test: kms_vblank
results: parsing output: 64/ for test: kms_frontbuffer_tracking
results: parsing output: 65/ for test: kms_plane_scaling
results: parsing output: 66/ for test: i915_pm_rps
results: parsing output: 67/ for test: kms_frontbuffer_tracking
results: parsing output: 68/ for test: gem_mmap_gtt
results: parsing output: 69/ for test: gem_ctx_isolation
results: parsing output: 70/ for test: kms_frontbuffer_tracking
results: parsing output: 71/ for test: gem_exec_reloc
results: parsing output: 72/ for test: kms_frontbuffer_tracking
results: parsing output: 73/ for test: kms_frontbuffer_tracking
results: parsing output: 74/ for test: kms_big_fb
results: parsing output: 75/ for test: sysfs_heartbeat_interval
results: parsing output: 76/ for test: perf_pmu
results: parsing output: 77/ for test: kms_frontbuffer_tracking
results: parsing output: 78/ for test: kms_frontbuffer_tracking
results: parsing output: 79/ for test: gem_exec_fence
results: parsing output: 80/ for test: i915_module_load
results: parsing output: 81/ for test: template
results: parsing output: 82/ for test: gem_userptr_blits
results: parsing output: 83/ for test: kms_flip
results: parsing output: 84/ for test: api_intel_bb
results: parsing output: 85/ for test: vgem_basic
results: parsing output: 86/ for test: kms_psr
results: parsing output: 87/ for test: kms_frontbuffer_tracking
results: parsing output: 88/ for test: kms_frontbuffer_tracking
results: parsing output: 89/ for test: kms_cursor_legacy
results: parsing output: 90/ for test: kms_frontbuffer_tracking
results: parsing output: 91/ for test: core_getstats
results: parsing output: 92/ for test: kms_cursor_crc
results: parsing output: 93/ for test: kms_async_flips
results: parsing output: 94/ for test: kms_frontbuffer_tracking
results: parsing output: 95/ for test: kms_pm_rpm
results: parsing output: 96/ for test: gem_exec_whisper
results: parsing output: 97/ for test: kms_psr
results: parsing output: 98/ for test: i915_drm_fdinfo
results: parsing output: 99/ for test: prime_self_import
results: parsing output: 100/ for test: kms_ccs
results: parsing output: 101/ for test: kms_ccs
results: parsing output: 102/ for test: kms_cursor_crc
results: parsing output: 103/ for test: kms_addfb_basic
results: parsing output: 104/ for test: gem_readwrite
results: parsing output: 105/ for test: gem_eio
results: parsing output: 106/ for test: gem_exercise_blt
results: parsing output: 107/ for test: kms_plane_scaling
results: parsing output: 108/ for test: syncobj_wait
results: parsing output: 109/ for test: gem_exec_schedule
results: parsing output: 110/ for test: kms_psr
results: parsing output: 111/ for test: prime_vgem
results: parsing output: 112/ for test: kms_dp_linktrain_fallback
results: parsing output: 113/ for test: gem_exec_reloc
results: parsing output: 114/ for test: gem_create
results: parsing output: 115/ for test: kms_frontbuffer_tracking
results: parsing output: 116/ for test: kms_cursor_legacy
results: parsing output: 117/ for test: kms_color
results: parsing output: 118/ for test: kms_frontbuffer_tracking
results: parsing output: 119/ for test: gem_ctx_persistence
results: parsing output: 120/ for test: kms_plane_multiple
results: parsing output: 121/ for test: kms_flip
results: parsing output: 122/ for test: i915_pm_rps
results: parsing output: 123/ for test: kms_rotation_crc
results: parsing output: 124/ for test: kms_big_fb
results: parsing output: 125/ for test: kms_lease
results: parsing output: 126/ for test: kms_flip
results: parsing output: 127/ for test: kms_big_fb
results: parsing output: 128/ for test: api_intel_allocator
results: parsing output: 129/ for test: kms_pipe_crc_basic
results: parsing output: 130/ for test: syncobj_timeline
Done.