[57.792908] Initializing watchdogs
[57.792954]   /dev/watchdog0
[57.806856] [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]
[57.811223] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[57.813566] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[57.817146] [001/131] (960s left) kms_atomic_transition (plane-all-transition)
[57.940697] Starting subtest: plane-all-transition
[57.942987] Starting dynamic subtest: pipe-A-eDP-1
[60.479114] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.540s)
[60.796047] Starting dynamic subtest: pipe-B-eDP-1
[64.042779] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.253s)
[64.340414] Subtest plane-all-transition: SUCCESS (6.398s)
[65.191063] [002/131] (953s left) syncobj_timeline (multi-wait-available-unsubmitted-submitted)
[65.253445] Starting subtest: multi-wait-available-unsubmitted-submitted
[65.256053] Subtest multi-wait-available-unsubmitted-submitted: SUCCESS (0.001s)
[65.392865] [003/131] (953s left) kms_frontbuffer_tracking (fbc-rgb565-draw-mmap-gtt)
[65.495822] Starting subtest: fbc-rgb565-draw-mmap-gtt
[65.499932] Subtest fbc-rgb565-draw-mmap-gtt: SKIP (0.000s)
[65.623085] [004/131] (952s left) gen9_exec_parse (bb-start-param)
[65.698837] Subtest bb-start-param: SKIP (0.000s)
[65.771704] [005/131] (952s left) syncobj_wait (invalid-signal-one-illegal-handle)
[65.821016] Starting subtest: invalid-signal-one-illegal-handle
[65.823094] Subtest invalid-signal-one-illegal-handle: SUCCESS (0.000s)
[65.931449] [006/131] (952s left) kms_psr (fbc-pr-cursor-plane-onoff)
[66.030110] Starting subtest: fbc-pr-cursor-plane-onoff
[66.034398] Subtest fbc-pr-cursor-plane-onoff: SKIP (0.000s)
[66.123187] [007/131] (952s left) syncobj_timeline (etime-single-wait-all-available-unsubmitted)
[66.182080] Starting subtest: etime-single-wait-all-available-unsubmitted
[66.289901] Subtest etime-single-wait-all-available-unsubmitted: SUCCESS (0.106s)
[66.388423] [008/131] (952s left) kms_ccs (crc-sprite-planes-basic-4-tiled-dg2-rc-ccs)
[66.484710] Starting subtest: crc-sprite-planes-basic-4-tiled-dg2-rc-ccs
[66.487062] Starting dynamic subtest: pipe-A-eDP-1
[66.545223] Dynamic subtest pipe-A-eDP-1: SKIP (0.002s)
[66.553774] Starting dynamic subtest: pipe-B-eDP-1
[66.611160] Dynamic subtest pipe-B-eDP-1: SKIP (0.003s)
[66.618973] Starting dynamic subtest: pipe-C-eDP-1
[66.676315] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[66.684050] Starting dynamic subtest: pipe-D-eDP-1
[66.744387] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[66.748659] Subtest crc-sprite-planes-basic-4-tiled-dg2-rc-ccs: SKIP (0.012s)
[68.741855] [009/131] (949s left) syncobj_wait (reset-unsignaled)
[68.806040] Starting subtest: reset-unsignaled
[68.808445] Subtest reset-unsignaled: SUCCESS (0.000s)
[68.938083] [010/131] (949s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-downscaling)
[69.045840] Starting subtest: flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-downscaling
[69.047996] Starting dynamic subtest: pipe-A-default-mode
[69.335939] Dynamic subtest pipe-A-default-mode: SKIP (0.288s)
[69.340680] Subtest flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-downscaling: SKIP (0.290s)
[70.168319] [011/131] (948s left) gem_fenced_exec_thrash (no-spare-fences-interruptible)
[70.242253] Subtest no-spare-fences-interruptible: SKIP (0.000s)
[70.317632] [012/131] (948s left) perf (i915-ref-count)
[70.405547] Starting subtest: i915-ref-count
[70.465527] Subtest i915-ref-count: SUCCESS (0.061s)
[70.522145] [013/131] (948s left) gem_exec_reloc (basic-wc-gtt-active)
[70.586106] Subtest basic-wc-gtt-active: SKIP (0.000s)
[70.666616] [014/131] (948s left) kms_chamelium_hpd (vga-hpd-enable-disable-mode)
[71.071482] Subtest vga-hpd-enable-disable-mode: SKIP (0.000s)
[71.855795] [015/131] (946s left) kms_addfb_basic (bad-pitch-0)
[71.919358] Starting subtest: bad-pitch-0
[71.921402] Subtest bad-pitch-0: SUCCESS (0.000s)
[72.084378] [016/131] (946s left) gem_render_copy (y-tiled-mc-ccs-to-vebox-y-tiled)
[72.150454] Starting subtest: y-tiled-mc-ccs-to-vebox-y-tiled
[72.155255] Subtest y-tiled-mc-ccs-to-vebox-y-tiled: SKIP (0.000s)
[72.353587] [017/131] (946s left) kms_psr2_sf (psr2-overlay-plane-move-continuous-exceed-fully-sf)
[77.317258] Starting subtest: psr2-overlay-plane-move-continuous-exceed-fully-sf
[77.319681] Starting dynamic subtest: pipe-A-eDP-1
[94.511807] Dynamic subtest pipe-A-eDP-1: SUCCESS (17.191s)
[94.522757] Starting dynamic subtest: pipe-B-eDP-1
[111.645708] Dynamic subtest pipe-B-eDP-1: SUCCESS (17.132s)
[111.648166] Subtest psr2-overlay-plane-move-continuous-exceed-fully-sf: SUCCESS (34.327s)
[112.462392] [018/131] (906s left) gem_exec_schedule (semaphore-noskip)
[112.540070] Starting subtest: semaphore-noskip
[112.968640] Subtest semaphore-noskip: SUCCESS (0.434s)
[113.332732] [019/131] (905s left) gem_mmap_gtt (ptrace)
[113.406404] Subtest ptrace: SKIP (0.000s)
[113.465331] [020/131] (905s left) kms_addfb_basic (bad-pitch-256)
[113.526051] Starting subtest: bad-pitch-256
[113.528038] Subtest bad-pitch-256: SUCCESS (0.000s)
[113.697645] [021/131] (905s left) kms_cursor_crc (cursor-offscreen-128x128)
[113.897858] Starting subtest: cursor-offscreen-128x128
[113.900266] Starting dynamic subtest: pipe-A-eDP-1
[115.854126] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.955s)
[115.879281] Starting dynamic subtest: pipe-D-eDP-1
[118.444389] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.570s)
[118.446724] Subtest cursor-offscreen-128x128: SUCCESS (4.549s)
[119.330129] [022/131] (899s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-mmap-cpu)
[119.435058] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-mmap-cpu
[119.439109] Subtest fbc-2p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[119.563279] [023/131] (899s left) gem_exec_gttfill (engines)
[119.632793] Starting subtest: engines
[119.635243] Starting dynamic subtest: rcs0
[142.405078] Dynamic subtest rcs0: SUCCESS (22.771s)
[142.416637] Starting dynamic subtest: bcs0
[165.645817] Dynamic subtest bcs0: SUCCESS (23.236s)
[165.656123] Starting dynamic subtest: vcs0
[188.892695] Dynamic subtest vcs0: SUCCESS (23.245s)
[188.903593] Starting dynamic subtest: vcs1
[212.167329] Dynamic subtest vcs1: SUCCESS (23.274s)
[212.177993] Starting dynamic subtest: vecs0
[235.437263] Dynamic subtest vecs0: SUCCESS (23.265s)
[235.447810] Starting dynamic subtest: ccs0
[258.678066] Dynamic subtest ccs0: SUCCESS (23.239s)
[258.681056] Subtest engines: SUCCESS (139.042s)
[258.893774] [024/131] (760s left) gem_mmap_wc (set-cache-level)
[258.994782] Subtest set-cache-level: SKIP (0.000s)
[259.064127] [025/131] (760s left) kms_ccs (missing-ccs-buffer-4-tiled-mtl-mc-ccs)
[259.170088] Starting subtest: missing-ccs-buffer-4-tiled-mtl-mc-ccs
[259.172377] Starting dynamic subtest: pipe-A-eDP-1
[259.191996] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.019s)
[259.201580] Starting dynamic subtest: pipe-B-eDP-1
[259.220714] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.020s)
[259.228477] Starting dynamic subtest: pipe-C-eDP-1
[259.248350] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.020s)
[259.255977] Starting dynamic subtest: pipe-D-eDP-1
[259.276545] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.020s)
[259.278928] Subtest missing-ccs-buffer-4-tiled-mtl-mc-ccs: SUCCESS (0.083s)
[261.500657] [026/131] (757s left) kms_pipe_b_c_ivb (pipe-b-double-modeset-then-modeset-pipe-c)
[261.569493] Subtest pipe-B-double-modeset-then-modeset-pipe-C: SKIP (0.000s)
[261.627619] [027/131] (757s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip)
[261.742548] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip
[262.556952] Subtest x-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip: SUCCESS (0.816s)
[262.738240] [028/131] (756s left) syncobj_timeline (multi-wait-available-signaled)
[262.810177] Starting subtest: multi-wait-available-signaled
[262.812451] Subtest multi-wait-available-signaled: SUCCESS (0.000s)
[262.934640] [029/131] (756s left) perf_pmu (busy)
[262.977080] Starting subtest: busy
[262.979485] Starting dynamic subtest: rcs0
[263.587444] Dynamic subtest rcs0: SUCCESS (0.611s)
[263.598479] Starting dynamic subtest: bcs0
[264.154845] Dynamic subtest bcs0: SUCCESS (0.565s)
[264.166075] Starting dynamic subtest: vcs0
[265.877508] Dynamic subtest vcs0: SUCCESS (1.719s)
[265.888363] Starting dynamic subtest: vcs1
[267.925823] Dynamic subtest vcs1: SUCCESS (2.046s)
[267.937649] Starting dynamic subtest: vecs0
[269.909631] Dynamic subtest vecs0: SUCCESS (1.981s)
[269.920242] Starting dynamic subtest: ccs0
[270.482600] Dynamic subtest ccs0: SUCCESS (0.572s)
[270.485128] Subtest busy: SUCCESS (7.507s)
[270.621306] [030/131] (748s left) gem_exec_async (forked-writes)
[270.694691] Starting subtest: forked-writes
[270.697019] Starting dynamic subtest: rcs0
[270.725567] Dynamic subtest rcs0: SUCCESS (0.031s)
[270.736713] Starting dynamic subtest: bcs0
[270.752494] Dynamic subtest bcs0: SUCCESS (0.026s)
[270.760707] Starting dynamic subtest: vcs0
[270.774895] Dynamic subtest vcs0: SUCCESS (0.022s)
[270.783326] Starting dynamic subtest: vcs1
[270.796604] Dynamic subtest vcs1: SUCCESS (0.021s)
[270.804851] Starting dynamic subtest: vecs0
[270.819450] Dynamic subtest vecs0: SUCCESS (0.023s)
[270.827734] Starting dynamic subtest: ccs0
[270.843265] Dynamic subtest ccs0: SUCCESS (0.023s)
[270.845603] Subtest forked-writes: SUCCESS (0.149s)
[271.102849] [031/131] (748s left) gem_eio (in-flight-contexts-1us)
[271.330754] Starting subtest: in-flight-contexts-1us
[284.905391] Subtest in-flight-contexts-1us: SUCCESS (13.572s)
[285.115705] [032/131] (734s left) kms_ccs (crc-primary-rotation-180-4-tiled-dg2-rc-ccs)
[285.212923] Starting subtest: crc-primary-rotation-180-4-tiled-dg2-rc-ccs
[285.215240] Starting dynamic subtest: pipe-A-eDP-1
[285.238041] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[285.248467] Starting dynamic subtest: pipe-B-eDP-1
[285.269442] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[285.277418] Starting dynamic subtest: pipe-C-eDP-1
[285.298742] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[285.306905] Starting dynamic subtest: pipe-D-eDP-1
[285.329189] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[285.333762] Subtest crc-primary-rotation-180-4-tiled-dg2-rc-ccs: SKIP (0.005s)
[287.548632] [033/131] (732s left) kms_psr (fbc-psr-primary-mmap-cpu)
[287.659983] Starting subtest: fbc-psr-primary-mmap-cpu
[287.662145] Starting dynamic subtest: eDP-1
[287.666151] Dynamic subtest eDP-1: SKIP (0.000s)
[287.670159] Subtest fbc-psr-primary-mmap-cpu: SKIP (0.001s)
[287.756270] [034/131] (731s left) kms_big_fb (y-tiled-16bpp-rotate-90)
[287.862745] Starting subtest: y-tiled-16bpp-rotate-90
[287.867053] Subtest y-tiled-16bpp-rotate-90: SKIP (0.000s)
[287.984310] [035/131] (731s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-blt)
[288.086792] Starting subtest: psr-2p-primscrn-cur-indfb-draw-blt
[288.091179] Subtest psr-2p-primscrn-cur-indfb-draw-blt: SKIP (0.000s)
[288.195870] [036/131] (731s left) kms_hdr (static-swap)
[288.285799] Starting subtest: static-swap
[288.292154] Subtest static-swap: SKIP (0.000s)
[288.382123] [037/131] (731s left) gem_spin_batch (resubmit)
[288.437458] Starting subtest: resubmit
[288.439853] Starting dynamic subtest: rcs0
[288.444962] Dynamic subtest rcs0: SUCCESS (0.005s)
[288.455306] Starting dynamic subtest: bcs0
[288.457507] Dynamic subtest bcs0: SUCCESS (0.002s)
[288.465713] Starting dynamic subtest: vcs0
[288.467552] Dynamic subtest vcs0: SUCCESS (0.003s)
[288.475542] Starting dynamic subtest: vcs1
[288.477381] Dynamic subtest vcs1: SUCCESS (0.003s)
[288.484937] Starting dynamic subtest: vecs0
[288.486767] Dynamic subtest vecs0: SUCCESS (0.003s)
[288.494310] Starting dynamic subtest: ccs0
[288.496116] Dynamic subtest ccs0: SUCCESS (0.002s)
[288.497883] Subtest resubmit: SUCCESS (0.020s)
[288.732995] [038/131] (731s left) gem_ccs (ctrl-surf-copy)
[288.781788] Starting subtest: ctrl-surf-copy
[288.785508] Subtest ctrl-surf-copy: SKIP (0.000s)
[288.914421] [039/131] (730s left) syncobj_eventfd (timeline-wait-signaled)
[288.965052] Starting subtest: timeline-wait-signaled
[288.966838] Subtest timeline-wait-signaled: SUCCESS (0.000s)
[289.104839] [040/131] (730s left) gem_exec_balancer (parallel-out-fence)
[289.363928] Starting subtest: parallel-out-fence
[290.562336] Subtest parallel-out-fence: SUCCESS (1.196s)
[290.703357] [041/131] (729s left) syncobj_wait (single-wait-all-submitted)
[290.754835] Starting subtest: single-wait-all-submitted
[290.856171] Subtest single-wait-all-submitted: SUCCESS (0.102s)
[290.955023] [042/131] (728s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-shrfb-msflip-blt)
[291.060552] Starting subtest: fbcpsr-1p-primscrn-shrfb-msflip-blt
[298.461127] Subtest fbcpsr-1p-primscrn-shrfb-msflip-blt: SUCCESS (7.403s)
[298.630372] [043/131] (721s left) kms_flip (flip-vs-panning)
[298.722274] Starting subtest: flip-vs-panning
[298.724198] Starting dynamic subtest: A-eDP1
[307.476785] Dynamic subtest A-eDP1: SUCCESS (8.756s)
[307.486666] Starting dynamic subtest: B-eDP1
[316.200466] Dynamic subtest B-eDP1: SUCCESS (8.722s)
[316.210885] Starting dynamic subtest: C-eDP1
[324.909865] Dynamic subtest C-eDP1: SUCCESS (8.708s)
[324.918299] Starting dynamic subtest: D-eDP1
[333.643367] Dynamic subtest D-eDP1: SUCCESS (8.732s)
[333.647411] Subtest flip-vs-panning: SUCCESS (34.926s)
[334.820132] [044/131] (685s left) kms_vblank (ts-continuation-suspend)
[334.931542] Starting subtest: ts-continuation-suspend
[334.934081] Starting dynamic subtest: pipe-A-eDP-1
[350.973065] Dynamic subtest pipe-A-eDP-1: SUCCESS (5.316s)
[350.989012] Starting dynamic subtest: pipe-D-eDP-1
[367.991140] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.214s)
[367.993952] Subtest ts-continuation-suspend: SUCCESS (7.534s)
[368.808044] [045/131] (651s left) gem_lmem_swapping (verify-ccs)
[368.866002] Subtest verify-ccs: SKIP (0.000s)
[368.919274] [046/131] (651s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-blt)
[369.015050] Starting subtest: fbcpsr-rgb565-draw-blt
[376.103763] Subtest fbcpsr-rgb565-draw-blt: SUCCESS (7.082s)
[376.281966] [047/131] (643s left) gem_render_copy (yf-tiled-ccs-to-yf-tiled)
[376.356940] Starting subtest: yf-tiled-ccs-to-yf-tiled
[376.362552] Subtest yf-tiled-ccs-to-yf-tiled: SKIP (0.000s)
[376.563880] [048/131] (643s left) kms_chamelium_frames (hdmi-crc-fast)
[376.952808] Subtest hdmi-crc-fast: SKIP (0.000s)
[377.734857] [049/131] (642s left) kms_chamelium_edid (dp-edid-change-during-suspend)
[378.129002] Subtest dp-edid-change-during-suspend: SKIP (0.000s)
[378.967915] [050/131] (641s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180)
[379.077940] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180
[379.083391] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180: SKIP (0.000s)
[379.207533] [051/131] (641s left) gem_workarounds (suspend-resume-context)
[379.287082] Starting subtest: suspend-resume-context
[395.693950] Subtest suspend-resume-context: SUCCESS (1.208s)
[396.861648] [052/131] (624s left) perf (invalid-remove-userspace-config)
[397.010431] Starting subtest: invalid-remove-userspace-config
[397.020795] Subtest invalid-remove-userspace-config: SUCCESS (0.011s)
[397.061330] [053/131] (624s left) gem_exec_fence (basic-wait-all)
[397.134301] Starting subtest: basic-wait-all
[397.248987] Subtest basic-wait-all: SUCCESS (0.116s)
[399.789194] [FACT gem_exec_fence (basic-wait-all)] new: kernel.kmod_is_loaded.vgem: true
[399.792842] [054/131] (621s left) gem_mmap_gtt (basic-write)
[399.856497] Subtest basic-write: SKIP (0.000s)
[399.936474] [055/131] (621s left) gem_exec_flush (basic-wb-pro-default)
[400.012584] Starting subtest: basic-wb-pro-default
[405.511669] Subtest basic-wb-pro-default: SUCCESS (5.494s)
[405.724079] [056/131] (615s left) gem_userptr_blits (invalid-mmap-offset-unsync)
[405.809986] Subtest invalid-mmap-offset-unsync: SKIP (0.000s)
[405.987034] [057/131] (615s left) kms_frontbuffer_tracking (fbc-2p-pri-indfb-multidraw)
[406.088106] Starting subtest: fbc-2p-pri-indfb-multidraw
[406.093442] Subtest fbc-2p-pri-indfb-multidraw: SKIP (0.000s)
[406.217280] [058/131] (615s left) gem_pxp (create-protected-buffer)
[406.349133] Starting subtest: create-protected-buffer
[406.351624] Subtest create-protected-buffer: SUCCESS (0.000s)
[406.498683] [059/131] (615s left) perf (polling)
[406.597499] Starting subtest: polling
[406.600350] Starting dynamic subtest: 0-rcs0
[416.607209] Dynamic subtest 0-rcs0: SUCCESS (10.002s)
[416.618244] Starting dynamic subtest: 1-vcs0
[426.632010] Dynamic subtest 1-vcs0: SUCCESS (10.018s)
[426.634729] Subtest polling: SUCCESS (20.022s)
[426.684164] [060/131] (594s left) kms_atomic (plane-invalid-params)
[426.795181] Starting subtest: plane-invalid-params
[426.797706] Starting dynamic subtest: pipe-A-eDP-1
[427.197601] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.401s)
[427.200226] Subtest plane-invalid-params: SUCCESS (0.402s)
[428.035525] [061/131] (593s left) kms_prop_blob (basic)
[428.093767] Starting subtest: basic
[428.096019] Subtest basic: SUCCESS (0.000s)
[428.226579] [062/131] (593s left) kms_flip (nonexisting-fb-interruptible)
[428.322210] Starting subtest: nonexisting-fb-interruptible
[428.324786] Starting dynamic subtest: A-eDP1
[429.500535] Dynamic subtest A-eDP1: SUCCESS (1.179s)
[429.510637] Starting dynamic subtest: B-eDP1
[430.633359] Dynamic subtest B-eDP1: SUCCESS (1.133s)
[430.645309] Starting dynamic subtest: C-eDP1
[431.757488] Dynamic subtest C-eDP1: SUCCESS (1.123s)
[431.767704] Starting dynamic subtest: D-eDP1
[432.895243] Dynamic subtest D-eDP1: SUCCESS (1.137s)
[432.897784] Subtest nonexisting-fb-interruptible: SUCCESS (4.581s)
[434.103368] [063/131] (587s left) kms_prop_blob (invalid-get-prop-any)
[434.162618] Starting subtest: invalid-get-prop-any
[434.165767] Subtest invalid-get-prop-any: SUCCESS (0.000s)
[434.299809] [064/131] (587s left) kms_vblank (query-forked-busy)
[434.391600] Starting subtest: query-forked-busy
[434.394089] Starting dynamic subtest: pipe-A-eDP-1
[436.263988] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.875s)
[436.280025] Starting dynamic subtest: pipe-D-eDP-1
[438.825037] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.557s)
[438.827707] Subtest query-forked-busy: SUCCESS (4.436s)
[439.655241] [065/131] (582s left) kms_frontbuffer_tracking (fbc-1p-pri-indfb-multidraw)
[439.761988] Starting subtest: fbc-1p-pri-indfb-multidraw
[453.038439] Subtest fbc-1p-pri-indfb-multidraw: SUCCESS (13.280s)
[454.482974] [066/131] (567s left) kms_plane_scaling (invalid-num-scalers)
[454.594835] Starting subtest: invalid-num-scalers
[454.597491] Starting dynamic subtest: pipe-A-eDP-1-invalid-num-scalers
[454.610256] Dynamic subtest pipe-A-eDP-1-invalid-num-scalers: SUCCESS (0.017s)
[454.620403] Starting dynamic subtest: pipe-B-eDP-1-invalid-num-scalers
[454.643675] Dynamic subtest pipe-B-eDP-1-invalid-num-scalers: SUCCESS (0.031s)
[454.653295] Starting dynamic subtest: pipe-C-eDP-1-invalid-num-scalers
[454.676505] Dynamic subtest pipe-C-eDP-1-invalid-num-scalers: SUCCESS (0.030s)
[454.685761] Starting dynamic subtest: pipe-D-eDP-1-invalid-num-scalers
[454.706140] Dynamic subtest pipe-D-eDP-1-invalid-num-scalers: SUCCESS (0.029s)
[454.708629] Subtest invalid-num-scalers: SUCCESS (0.114s)
[454.846917] [067/131] (567s left) i915_pm_rps (fence-order)
[454.917644] Starting subtest: fence-order
[457.786547] Subtest fence-order: SUCCESS (2.868s)
[457.950415] [068/131] (564s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-pwrite)
[458.054333] Starting subtest: fbc-rgb101010-draw-pwrite
[463.432797] Subtest fbc-rgb101010-draw-pwrite: SUCCESS (5.380s)
[464.576016] [069/131] (557s left) gem_mmap_gtt (fault-concurrent)
[464.644773] Subtest fault-concurrent: SKIP (0.000s)
[464.707149] [070/131] (557s left) gem_ctx_isolation (dirty-switch)
[464.777619] Starting subtest: dirty-switch
[464.780561] Starting dynamic subtest: rcs0
[464.983279] Dynamic subtest rcs0: SUCCESS (0.208s)
[464.994819] Starting dynamic subtest: bcs0
[465.217771] Dynamic subtest bcs0: SUCCESS (0.233s)
[465.229336] Starting dynamic subtest: vcs0
[465.447344] Dynamic subtest vcs0: SUCCESS (0.229s)
[465.458809] Starting dynamic subtest: vcs1
[466.803218] Dynamic subtest vcs1: SUCCESS (1.355s)
[466.813027] Starting dynamic subtest: vecs0
[468.978018] Dynamic subtest vecs0: SUCCESS (2.173s)
[468.988350] Starting dynamic subtest: ccs0
[470.884381] Dynamic subtest ccs0: SUCCESS (1.905s)
[470.887058] Subtest dirty-switch: SUCCESS (6.109s)
[471.167354] [071/131] (551s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-fullscreen)
[471.281609] Starting subtest: psr-2p-primscrn-spr-indfb-fullscreen
[471.286551] Subtest psr-2p-primscrn-spr-indfb-fullscreen: SKIP (0.000s)
[471.417587] [072/131] (550s left) gem_exec_reloc (basic-write-gtt-active)
[471.476014] Subtest basic-write-gtt-active: SKIP (0.000s)
[471.542539] [073/131] (550s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-gtt)
[471.649641] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-gtt
[471.654539] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[471.791209] [074/131] (550s left) kms_frontbuffer_tracking (psr-indfb-scaledprimary)
[471.890687] Starting subtest: psr-indfb-scaledprimary
[477.629408] Subtest psr-indfb-scaledprimary: SUCCESS (5.739s)
[477.799350] [075/131] (544s left) kms_big_fb (x-tiled-8bpp-rotate-0)
[477.906438] Starting subtest: x-tiled-8bpp-rotate-0
[479.142683] Subtest x-tiled-8bpp-rotate-0: SUCCESS (1.235s)
[479.323153] [076/131] (543s left) sysfs_heartbeat_interval (invalid)
[479.397057] Starting subtest: invalid
[479.399162] Starting dynamic subtest: vecs0
[479.401105] Dynamic subtest vecs0: SUCCESS (0.000s)
[479.411419] Starting dynamic subtest: ccs0
[479.413493] Dynamic subtest ccs0: SUCCESS (0.000s)
[479.422799] Starting dynamic subtest: vcs0
[479.424989] Dynamic subtest vcs0: SUCCESS (0.000s)
[479.434050] Starting dynamic subtest: bcs0
[479.436369] Dynamic subtest bcs0: SUCCESS (0.000s)
[479.445573] Starting dynamic subtest: rcs0
[479.447562] Dynamic subtest rcs0: SUCCESS (0.000s)
[479.456637] Starting dynamic subtest: vcs1
[479.459328] Dynamic subtest vcs1: SUCCESS (0.000s)
[479.461583] Subtest invalid: SUCCESS (0.005s)
[479.549300] [077/131] (542s left) perf_pmu (render-node-busy)
[479.612118] Starting subtest: render-node-busy
[479.614212] Starting dynamic subtest: rcs0
[480.196464] Dynamic subtest rcs0: SUCCESS (0.583s)
[480.208890] Starting dynamic subtest: bcs0
[480.764865] Dynamic subtest bcs0: SUCCESS (0.566s)
[480.778782] Starting dynamic subtest: vcs0
[482.667082] Dynamic subtest vcs0: SUCCESS (1.898s)
[482.680815] Starting dynamic subtest: vcs1
[484.650825] Dynamic subtest vcs1: SUCCESS (1.980s)
[484.663793] Starting dynamic subtest: vecs0
[486.634953] Dynamic subtest vecs0: SUCCESS (1.979s)
[486.648612] Starting dynamic subtest: ccs0
[487.197090] Dynamic subtest ccs0: SUCCESS (0.560s)
[487.199704] Subtest render-node-busy: SUCCESS (7.583s)
[487.296849] [078/131] (535s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-onoff)
[487.399703] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-onoff
[494.389586] Subtest fbcpsr-1p-primscrn-cur-indfb-onoff: SUCCESS (6.991s)
[494.565082] [079/131] (527s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-indfb-msflip-blt)
[494.676761] Starting subtest: fbcpsr-2p-scndscrn-indfb-msflip-blt
[494.681764] Subtest fbcpsr-2p-scndscrn-indfb-msflip-blt: SKIP (0.000s)
[494.789003] [080/131] (527s left) gem_exec_fence (syncobj-export)
[495.230770] Starting subtest: syncobj-export
[495.237557] Subtest syncobj-export: SUCCESS (0.005s)
[496.734862] [081/131] (525s left) i915_module_load (resize-bar)
[496.775162] Starting subtest: resize-bar
[496.782533] Subtest resize-bar: SKIP (0.005s)
[496.830355] [082/131] (525s left) template (b)
[496.894583] Starting subtest: B
[496.897447] Subtest B: SUCCESS (0.000s)
[497.028274] [083/131] (525s left) gem_userptr_blits (map-fixed-invalidate-busy)
[497.100794] Starting subtest: map-fixed-invalidate-busy
[497.105152] Subtest map-fixed-invalidate-busy: SKIP (0.000s)
[497.265393] [084/131] (525s left) kms_flip (2x-flip-vs-expired-vblank)
[497.363606] Starting subtest: 2x-flip-vs-expired-vblank
[497.374346] Subtest 2x-flip-vs-expired-vblank: SKIP (0.010s)
[497.515285] [085/131] (525s left) api_intel_bb (crc32)
[497.581578] Starting subtest: crc32
[497.584220] Starting dynamic subtest: rcs0-smem0
[497.876278] Dynamic subtest rcs0-smem0: SUCCESS (0.296s)
[497.887478] Starting dynamic subtest: bcs0-smem0
[498.212533] Dynamic subtest bcs0-smem0: SUCCESS (0.334s)
[498.223211] Starting dynamic subtest: vcs0-smem0
[498.566256] Dynamic subtest vcs0-smem0: SUCCESS (0.351s)
[498.577977] Starting dynamic subtest: vcs1-smem0
[498.956301] Dynamic subtest vcs1-smem0: SUCCESS (0.387s)
[498.968356] Starting dynamic subtest: vecs0-smem0
[499.326265] Dynamic subtest vecs0-smem0: SUCCESS (0.367s)
[499.338565] Starting dynamic subtest: ccs0-smem0
[499.644123] Dynamic subtest ccs0-smem0: SUCCESS (0.315s)
[499.647451] Subtest crc32: SUCCESS (2.066s)
[499.791391] [086/131] (523s left) vgem_basic (dmabuf-export)
[499.839993] Starting subtest: dmabuf-export
[499.878772] Subtest dmabuf-export: SUCCESS (0.040s)
[500.017205] [087/131] (522s left) kms_psr (psr2-sprite-blt)
[500.116488] Starting subtest: psr2-sprite-blt
[500.118952] Starting dynamic subtest: eDP-1
[501.815706] Dynamic subtest eDP-1: SUCCESS (1.698s)
[501.818642] Subtest psr2-sprite-blt: SUCCESS (1.699s)
[502.700117] [088/131] (520s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-mmap-wc)
[502.793628] Starting subtest: psr-2p-primscrn-spr-indfb-draw-mmap-wc
[502.799280] Subtest psr-2p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[502.923241] [089/131] (520s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-mmap-gtt)
[503.023296] Starting subtest: psr-1p-primscrn-pri-indfb-draw-mmap-gtt
[503.028326] Subtest psr-1p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[503.157262] [090/131] (519s left) kms_cursor_legacy (modeset-atomic-cursor-hotspot)
[503.286766] Starting subtest: modeset-atomic-cursor-hotspot
[503.292581] Subtest modeset-atomic-cursor-hotspot: SKIP (0.000s)
[503.457773] [091/131] (519s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-pwrite)
[503.562525] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-pwrite
[508.518767] Subtest fbc-1p-offscreen-pri-indfb-draw-pwrite: SUCCESS (4.961s)
[509.701142] [092/131] (513s left) core_getstats (basic)
[509.761694] Starting subtest: basic
[509.764573] Subtest basic: SUCCESS (0.000s)
[509.897708] [093/131] (513s left) kms_cursor_crc (cursor-random-max-size)
[510.194685] Starting subtest: cursor-random-max-size
[510.201804] Subtest cursor-random-max-size: SKIP (0.000s)
[510.353196] [094/131] (512s left) kms_async_flips (basic-modeset-with-all-modifiers-formats)
[510.460803] Starting subtest: basic-modeset-with-all-modifiers-formats
[510.848606] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-XRGB8888
[511.655835] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-XRGB8888: SUCCESS (0.809s)
[511.665795] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-XRGB2101010
[511.677789] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-XRGB2101010: SUCCESS (0.021s)
[511.687152] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-XRGB16161616F
[511.700074] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-XRGB16161616F: SUCCESS (0.021s)
[511.709763] Starting dynamic subtest: pipe-A-eDP-1-4-RGB565
[511.856239] Dynamic subtest pipe-A-eDP-1-4-RGB565: SUCCESS (0.154s)
[511.866090] Starting dynamic subtest: pipe-A-eDP-1-4-XRGB8888
[511.877785] Dynamic subtest pipe-A-eDP-1-4-XRGB8888: SUCCESS (0.021s)
[511.887611] Starting dynamic subtest: pipe-A-eDP-1-4-XRGB2101010
[511.900212] Dynamic subtest pipe-A-eDP-1-4-XRGB2101010: SUCCESS (0.021s)
[511.909988] Starting dynamic subtest: pipe-A-eDP-1-4-XRGB16161616F
[511.922201] Dynamic subtest pipe-A-eDP-1-4-XRGB16161616F: SUCCESS (0.021s)
[511.931664] Starting dynamic subtest: pipe-A-eDP-1-4-YUYV
[511.943826] Dynamic subtest pipe-A-eDP-1-4-YUYV: SUCCESS (0.022s)
[511.954274] Starting dynamic subtest: pipe-A-eDP-1-4-Y210
[511.966924] Dynamic subtest pipe-A-eDP-1-4-Y210: SUCCESS (0.022s)
[511.976614] Starting dynamic subtest: pipe-A-eDP-1-4-XYUV8888
[511.989008] Dynamic subtest pipe-A-eDP-1-4-XYUV8888: SUCCESS (0.021s)
[511.998645] Starting dynamic subtest: pipe-A-eDP-1-4-XV30
[512.011091] Dynamic subtest pipe-A-eDP-1-4-XV30: SUCCESS (0.021s)
[512.020529] Starting dynamic subtest: pipe-A-eDP-1-4-XV36
[512.033621] Dynamic subtest pipe-A-eDP-1-4-XV36: SUCCESS (0.022s)
[512.046609] Starting dynamic subtest: pipe-A-eDP-1-x-RGB565
[512.189273] Dynamic subtest pipe-A-eDP-1-x-RGB565: SUCCESS (0.154s)
[512.199219] Starting dynamic subtest: pipe-A-eDP-1-x-XRGB8888
[512.210964] Dynamic subtest pipe-A-eDP-1-x-XRGB8888: SUCCESS (0.021s)
[512.223398] Starting dynamic subtest: pipe-A-eDP-1-x-XRGB2101010
[512.233217] Dynamic subtest pipe-A-eDP-1-x-XRGB2101010: SUCCESS (0.021s)
[512.242927] Starting dynamic subtest: pipe-A-eDP-1-x-XRGB16161616F
[512.258087] Dynamic subtest pipe-A-eDP-1-x-XRGB16161616F: SUCCESS (0.022s)
[512.267547] Starting dynamic subtest: pipe-A-eDP-1-x-YUYV
[512.277543] Dynamic subtest pipe-A-eDP-1-x-YUYV: SUCCESS (0.022s)
[512.287123] Starting dynamic subtest: pipe-A-eDP-1-x-Y210
[512.300198] Dynamic subtest pipe-A-eDP-1-x-Y210: SUCCESS (0.022s)
[512.309474] Starting dynamic subtest: pipe-A-eDP-1-x-XYUV8888
[512.322265] Dynamic subtest pipe-A-eDP-1-x-XYUV8888: SUCCESS (0.021s)
[512.332465] Starting dynamic subtest: pipe-A-eDP-1-x-XV30
[512.344367] Dynamic subtest pipe-A-eDP-1-x-XV30: SUCCESS (0.021s)
[512.353685] Starting dynamic subtest: pipe-A-eDP-1-x-XV36
[512.366362] Dynamic subtest pipe-A-eDP-1-x-XV36: SUCCESS (0.022s)
[512.376102] Starting dynamic subtest: pipe-A-eDP-1-linear-RGB565
[512.522564] Dynamic subtest pipe-A-eDP-1-linear-RGB565: SUCCESS (0.155s)
[512.532486] Starting dynamic subtest: pipe-A-eDP-1-linear-XRGB8888
[512.544701] Dynamic subtest pipe-A-eDP-1-linear-XRGB8888: SUCCESS (0.022s)
[512.554515] Starting dynamic subtest: pipe-A-eDP-1-linear-XRGB2101010
[512.567412] Dynamic subtest pipe-A-eDP-1-linear-XRGB2101010: SUCCESS (0.022s)
[512.578620] Starting dynamic subtest: pipe-A-eDP-1-linear-XRGB16161616F
[512.589523] Dynamic subtest pipe-A-eDP-1-linear-XRGB16161616F: SUCCESS (0.022s)
[512.599042] Starting dynamic subtest: pipe-A-eDP-1-linear-YUYV
[512.611597] Dynamic subtest pipe-A-eDP-1-linear-YUYV: SUCCESS (0.021s)
[512.621282] Starting dynamic subtest: pipe-A-eDP-1-linear-Y210
[512.633796] Dynamic subtest pipe-A-eDP-1-linear-Y210: SUCCESS (0.022s)
[512.643206] Starting dynamic subtest: pipe-A-eDP-1-linear-XYUV8888
[512.655793] Dynamic subtest pipe-A-eDP-1-linear-XYUV8888: SUCCESS (0.022s)
[512.665300] Starting dynamic subtest: pipe-A-eDP-1-linear-XV30
[512.678169] Dynamic subtest pipe-A-eDP-1-linear-XV30: SUCCESS (0.022s)
[512.687391] Starting dynamic subtest: pipe-A-eDP-1-linear-XV36
[512.700314] Dynamic subtest pipe-A-eDP-1-linear-XV36: SUCCESS (0.021s)
[513.083295] Subtest basic-modeset-with-all-modifiers-formats: SUCCESS (2.625s)
[513.869942] [095/131] (509s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-blt)
[513.978435] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-blt
[520.860021] Subtest psr-1p-offscreen-pri-shrfb-draw-blt: SUCCESS (6.886s)
[521.033613] [096/131] (502s left) kms_pm_rpm (dpms-lpsp)
[522.872111] Starting subtest: dpms-lpsp
[523.257768] Subtest dpms-lpsp: SUCCESS (0.382s)
[523.371112] [097/131] (499s left) gem_exec_whisper (basic-contexts-forked)
[523.451328] Starting subtest: basic-contexts-forked
[548.042286] Subtest basic-contexts-forked: SUCCESS (24.585s)
[548.252177] [098/131] (475s left) kms_psr (fbc-pr-sprite-plane-move)
[548.357255] Starting subtest: fbc-pr-sprite-plane-move
[548.362491] Subtest fbc-pr-sprite-plane-move: SKIP (0.000s)
[548.457624] [099/131] (474s left) i915_drm_fdinfo (busy-hang)
[548.499797] Starting subtest: busy-hang
[548.502588] Starting dynamic subtest: rcs0
[548.541438] Dynamic subtest rcs0: SKIP (0.040s)
[548.554026] Starting dynamic subtest: bcs0
[548.559329] Dynamic subtest bcs0: SKIP (0.001s)
[548.568841] Starting dynamic subtest: vcs0
[548.574492] Dynamic subtest vcs0: SKIP (0.000s)
[548.584561] Starting dynamic subtest: vcs1
[548.589720] Dynamic subtest vcs1: SKIP (0.000s)
[548.599947] Starting dynamic subtest: vecs0
[548.604805] Dynamic subtest vecs0: SKIP (0.000s)
[548.614605] Starting dynamic subtest: ccs0
[548.619778] Dynamic subtest ccs0: SKIP (0.000s)
[548.624825] Subtest busy-hang: SKIP (0.046s)
[548.663231] [100/131] (474s left) prime_self_import (basic-with_one_bo_two_files)
[548.698625] Starting subtest: basic-with_one_bo_two_files
[548.722791] Subtest basic-with_one_bo_two_files: SUCCESS (0.024s)
[548.855231] [101/131] (474s left) kms_ccs (bad-rotation-90-4-tiled-lnl-ccs)
[548.952502] Starting subtest: bad-rotation-90-4-tiled-lnl-ccs
[548.957509] Subtest bad-rotation-90-4-tiled-lnl-ccs: SKIP (0.000s)
[550.068667] [102/131] (473s left) kms_ccs (bad-aux-stride-4-tiled-mtl-rc-ccs-cc)
[550.163650] Starting subtest: bad-aux-stride-4-tiled-mtl-rc-ccs-cc
[550.166395] Starting dynamic subtest: pipe-A-eDP-1
[550.190592] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[550.202018] Starting dynamic subtest: pipe-B-eDP-1
[550.225697] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[550.237383] Starting dynamic subtest: pipe-C-eDP-1
[550.260357] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[550.269843] Starting dynamic subtest: pipe-D-eDP-1
[550.293410] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[550.295824] Subtest bad-aux-stride-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.008s)
[552.437273] [103/131] (471s left) kms_cursor_crc (cursor-sliding-128x128)
[552.639779] Starting subtest: cursor-sliding-128x128
[552.642488] Starting dynamic subtest: pipe-A-eDP-1
[555.873632] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.231s)
[555.903774] Starting dynamic subtest: pipe-D-eDP-1
[559.833926] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.937s)
[559.836348] Subtest cursor-sliding-128x128: SUCCESS (7.193s)
[560.710242] [104/131] (462s left) kms_addfb_basic (invalid-get-prop)
[560.766314] Starting subtest: invalid-get-prop
[560.768644] Subtest invalid-get-prop: SUCCESS (0.000s)
[560.918005] [105/131] (462s left) gem_readwrite (read-write)
[560.989442] Subtest read-write: SKIP (0.000s)
[561.060167] [106/131] (462s left) gem_eio (create)
[561.298328] Starting subtest: create
[561.644189] Subtest create: SUCCESS (0.345s)
[561.777450] [107/131] (461s left) gem_exercise_blt (fast-copy-emit)
[561.842243] Starting subtest: fast-copy-emit
[561.844493] Starting dynamic subtest: linear-smem-smem-emit
[561.866411] Dynamic subtest linear-smem-smem-emit: SUCCESS (0.024s)
[561.878086] Starting dynamic subtest: xmajor-smem-smem-emit
[561.883871] Dynamic subtest xmajor-smem-smem-emit: SUCCESS (0.017s)
[561.893381] Starting dynamic subtest: tile4-smem-smem-emit
[561.902179] Dynamic subtest tile4-smem-smem-emit: SUCCESS (0.017s)
[561.911623] Starting dynamic subtest: tile64-smem-smem-emit
[561.920109] Dynamic subtest tile64-smem-smem-emit: SUCCESS (0.018s)
[561.922399] Subtest fast-copy-emit: SUCCESS (0.079s)
[562.078165] [108/131] (461s left) kms_plane_scaling (plane-upscale-20x20-with-rotation)
[562.160447] Starting subtest: plane-upscale-20x20-with-rotation
[562.162778] Starting dynamic subtest: pipe-A
[562.385604] Dynamic subtest pipe-A: SUCCESS (0.227s)
[562.395683] Starting dynamic subtest: pipe-B
[563.679717] Dynamic subtest pipe-B: SUCCESS (1.291s)
[563.692192] Starting dynamic subtest: pipe-C
[564.995346] Dynamic subtest pipe-C: SUCCESS (1.314s)
[565.005809] Starting dynamic subtest: pipe-D
[566.318141] Dynamic subtest pipe-D: SUCCESS (1.320s)
[566.321031] Subtest plane-upscale-20x20-with-rotation: SUCCESS (4.159s)
[567.524674] [109/131] (456s left) syncobj_wait (invalid-multi-wait-all-unsubmitted-submitted)
[567.584651] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted
[567.587689] Subtest invalid-multi-wait-all-unsubmitted-submitted: SUCCESS (0.000s)
[567.721594] [110/131] (456s left) gem_exec_schedule (implicit-boths)
[567.801183] Starting subtest: implicit-boths
[567.803080] Starting dynamic subtest: rcs0
[567.907370] Dynamic subtest rcs0: SUCCESS (0.117s)
[567.919832] Starting dynamic subtest: vcs0
[567.999167] Dynamic subtest vcs0: SUCCESS (0.091s)
[568.011628] Starting dynamic subtest: vcs1
[568.078309] Dynamic subtest vcs1: SUCCESS (0.078s)
[568.091724] Starting dynamic subtest: vecs0
[568.173532] Dynamic subtest vecs0: SUCCESS (0.095s)
[568.185318] Starting dynamic subtest: ccs0
[568.272803] Dynamic subtest ccs0: SUCCESS (0.099s)
[568.275693] Subtest implicit-boths: SUCCESS (0.483s)
[569.791244] [111/131] (454s left) kms_psr (psr2-cursor-plane-onoff)
[569.884504] Starting subtest: psr2-cursor-plane-onoff
[569.886914] Starting dynamic subtest: eDP-1
[571.568998] Dynamic subtest eDP-1: SUCCESS (1.685s)
[571.571580] Subtest psr2-cursor-plane-onoff: SUCCESS (1.686s)
[572.385282] [112/131] (451s left) prime_vgem (wait)
[572.466693] Starting subtest: wait
[572.469521] Starting dynamic subtest: rcs0
[572.553779] Dynamic subtest rcs0: SUCCESS (0.089s)
[572.566021] Starting dynamic subtest: bcs0
[572.627729] Dynamic subtest bcs0: SUCCESS (0.072s)
[572.637943] Starting dynamic subtest: vcs0
[572.676471] Dynamic subtest vcs0: SUCCESS (0.047s)
[572.686765] Starting dynamic subtest: vcs1
[572.726303] Dynamic subtest vcs1: SUCCESS (0.049s)
[572.736528] Starting dynamic subtest: vecs0
[572.776770] Dynamic subtest vecs0: SUCCESS (0.050s)
[572.786718] Starting dynamic subtest: ccs0
[572.823796] Dynamic subtest ccs0: SUCCESS (0.046s)
[572.826370] Subtest wait: SUCCESS (0.361s)
[572.973593] [113/131] (451s left) kms_dp_linktrain_fallback (dsc-fallback)
[573.064540] Starting subtest: dsc-fallback
[573.071820] Subtest dsc-fallback: SKIP (0.000s)
[573.164928] [114/131] (450s left) gem_exec_reloc (basic-cpu-gtt-noreloc)
[573.226089] Subtest basic-cpu-gtt-noreloc: SKIP (0.000s)
[573.315862] [115/131] (450s left) gem_create (create-clear)
[573.367382] Starting subtest: create-clear
[573.370201] Starting dynamic subtest: smem0
[606.168397] Dynamic subtest smem0: SUCCESS (32.788s)
[606.170682] Subtest create-clear: SUCCESS (32.790s)
[606.380340] [116/131] (417s left) kms_frontbuffer_tracking (fbc-suspend)
[606.498418] Starting subtest: fbc-suspend
[644.175304] Subtest fbc-suspend: SUCCESS (7.426s)
[645.396280] [117/131] (378s left) kms_cursor_legacy (cursorb-vs-flipa-toggle)
[645.524106] Starting subtest: cursorB-vs-flipA-toggle
[645.528485] Subtest cursorB-vs-flipA-toggle: SKIP (0.001s)
[645.695201] [118/131] (378s left) kms_color (legacy-gamma-reset)
[645.796592] Starting subtest: legacy-gamma-reset
[645.798405] Starting dynamic subtest: pipe-A-eDP-1
[646.172899] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.376s)
[646.183200] Starting dynamic subtest: pipe-B-eDP-1
[646.185471] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.011s)
[646.195306] Starting dynamic subtest: pipe-C-eDP-1
[646.197563] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.012s)
[646.207437] Starting dynamic subtest: pipe-D-eDP-1
[646.209673] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.012s)
[646.211987] Subtest legacy-gamma-reset: SUCCESS (0.414s)
[647.025735] [119/131] (377s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-blt)
[647.133506] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-blt
[647.137497] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[647.249230] [120/131] (377s left) gem_ctx_persistence (legacy-engines-mixed)
[647.313735] Starting subtest: legacy-engines-mixed
[647.315597] Starting dynamic subtest: render
[647.424427] Dynamic subtest render: SUCCESS (0.112s)
[647.442510] Starting dynamic subtest: bsd1
[647.501835] Dynamic subtest bsd1: SUCCESS (0.074s)
[647.514558] Starting dynamic subtest: bsd2
[647.589987] Dynamic subtest bsd2: SUCCESS (0.085s)
[647.602949] Starting dynamic subtest: blt
[647.645439] Dynamic subtest blt: SUCCESS (0.053s)
[647.657597] Starting dynamic subtest: vebox
[647.719490] Dynamic subtest vebox: SUCCESS (0.071s)
[647.721702] Subtest legacy-engines-mixed: SUCCESS (0.409s)
[647.822608] [121/131] (376s left) kms_plane_multiple (tiling-none)
[647.905505] Starting subtest: tiling-none
[647.907345] Starting dynamic subtest: pipe-A-eDP-1
[651.636994] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.727s)
[651.654533] Starting dynamic subtest: pipe-B-eDP-1
[656.153071] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.510s)
[656.163883] Starting dynamic subtest: pipe-C-eDP-1
[660.494018] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.336s)
[660.504555] Starting dynamic subtest: pipe-D-eDP-1
[664.825019] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.327s)
[664.827358] Subtest tiling-none: SUCCESS (16.906s)
[665.667812] [122/131] (358s left) kms_flip (2x-flip-vs-suspend-interruptible)
[665.761749] Starting subtest: 2x-flip-vs-suspend-interruptible
[665.774106] Subtest 2x-flip-vs-suspend-interruptible: SKIP (0.011s)
[665.897743] [123/131] (358s left) i915_pm_rps (thresholds-idle)
[665.965299] Starting subtest: thresholds-idle
[665.969858] Subtest thresholds-idle: SKIP (0.000s)
[666.088002] [124/131] (358s left) kms_rotation_crc (multiplane-rotation-cropping-bottom)
[666.196397] Starting subtest: multiplane-rotation-cropping-bottom
[683.544943] Subtest multiplane-rotation-cropping-bottom: SUCCESS (17.349s)
[683.713291] [125/131] (340s left) kms_big_fb (linear-64bpp-rotate-90)
[683.827841] Starting subtest: linear-64bpp-rotate-90
[683.847044] Subtest linear-64bpp-rotate-90: SKIP (0.019s)
[683.996506] [126/131] (340s left) kms_lease (lease-unleased-crtc)
[684.095864] Starting subtest: lease-unleased-crtc
[684.097734] Starting dynamic subtest: pipe-A-eDP-1
[684.383860] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.288s)
[684.396183] Starting dynamic subtest: pipe-B-eDP-1
[685.104974] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.715s)
[685.115237] Starting dynamic subtest: pipe-C-eDP-1
[685.117434] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.004s)
[685.127250] Starting dynamic subtest: pipe-D-eDP-1
[685.129428] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.004s)
[685.131562] Subtest lease-unleased-crtc: SUCCESS (1.017s)
[685.502717] [127/131] (339s left) kms_flip (flip-vs-panning-interruptible)
[685.616571] Starting subtest: flip-vs-panning-interruptible
[685.619919] Starting dynamic subtest: A-eDP1
[694.286985] Dynamic subtest A-eDP1: SUCCESS (8.666s)
[694.296935] Starting dynamic subtest: B-eDP1
[703.029029] Dynamic subtest B-eDP1: SUCCESS (8.738s)
[703.048917] Starting dynamic subtest: C-eDP1
[711.751962] Dynamic subtest C-eDP1: SUCCESS (8.718s)
[711.768391] Starting dynamic subtest: D-eDP1
[720.477119] Dynamic subtest D-eDP1: SUCCESS (8.721s)
[720.481771] Subtest flip-vs-panning-interruptible: SUCCESS (34.856s)
[721.753749] [128/131] (302s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0-async-flip)
[721.867435] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0-async-flip
[722.502978] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SUCCESS (0.637s)
[722.780413] [129/131] (301s left) api_intel_allocator (open-vm)
[722.848196] Starting subtest: open-vm
[722.850506] Subtest open-vm: SUCCESS (0.003s)
[722.961689] [130/131] (301s left) kms_pipe_crc_basic (hang-read-crc)
[723.068119] Starting subtest: hang-read-crc
[723.070419] Starting dynamic subtest: pipe-A-eDP-1
[725.215630] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.144s)
[725.226779] Starting dynamic subtest: pipe-B-eDP-1
[727.975552] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.758s)
[727.986132] Starting dynamic subtest: pipe-C-eDP-1
[730.612547] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.634s)
[730.623672] Starting dynamic subtest: pipe-D-eDP-1
[733.273816] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.657s)
[733.275854] Subtest hang-read-crc: SUCCESS (10.199s)
[734.146800] [131/131] (290s left) syncobj_timeline (wait-any-interrupted)
[734.210236] Starting subtest: wait-any-interrupted
[734.311390] Subtest wait-any-interrupted: SUCCESS (0.102s)
[734.410035] 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.