[58.519194] Initializing watchdogs
[58.519245]   /dev/watchdog0
[58.535193] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics]
[58.539695] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[58.541963] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[58.544099] [001/133] (960s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-pwrite)
[58.654298] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-pwrite
[58.655807] Subtest fbc-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[58.759406] [002/133] (960s left) syncobj_wait (reset-multiple-signaled)
[58.825612] Starting subtest: reset-multiple-signaled
[58.826619] Subtest reset-multiple-signaled: SUCCESS (0.001s)
[58.946785] [003/133] (960s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-onoff)
[59.038874] Starting subtest: fbc-2p-primscrn-spr-indfb-onoff
[59.040653] Subtest fbc-2p-primscrn-spr-indfb-onoff: SKIP (0.000s)
[59.151397] [004/133] (959s left) gem_wait (invalid-flags)
[59.203515] Starting subtest: invalid-flags
[59.204521] Subtest invalid-flags: SUCCESS (0.000s)
[59.433419] [005/133] (959s left) kms_flip (blocking-wf_vblank)
[59.520080] Starting subtest: blocking-wf_vblank
[59.521074] Starting dynamic subtest: A-eDP1
[68.508339] Dynamic subtest A-eDP1: SUCCESS (8.987s)
[68.519229] Starting dynamic subtest: B-eDP1
[77.445962] Dynamic subtest B-eDP1: SUCCESS (8.934s)
[77.459168] Starting dynamic subtest: C-eDP1
[86.368435] Dynamic subtest C-eDP1: SUCCESS (8.921s)
[86.375856] Starting dynamic subtest: D-eDP1
[95.300449] Dynamic subtest D-eDP1: SUCCESS (8.926s)
[95.301504] Subtest blocking-wf_vblank: SUCCESS (35.778s)
[96.516328] [006/133] (922s left) gem_pxp (create-protected-buffer)
[96.642543] Starting subtest: create-protected-buffer
[96.643687] Subtest create-protected-buffer: SUCCESS (0.000s)
[96.750536] [007/133] (922s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-0-hflip)
[96.863688] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-0-hflip
[96.865490] Subtest yf-tiled-max-hw-stride-32bpp-rotate-0-hflip: SKIP (0.000s)
[96.974756] [008/133] (922s left) kms_chamelium_edid (hdmi-edid-change-during-suspend)
[97.356526] Subtest hdmi-edid-change-during-suspend: SKIP (0.000s)
[98.119412] [009/133] (921s left) syncobj_wait (wait-any-interrupted)
[98.189283] Starting subtest: wait-any-interrupted
[98.292389] Subtest wait-any-interrupted: SUCCESS (0.101s)
[98.367307] [010/133] (920s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180)
[98.458132] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180
[99.414370] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180: SUCCESS (0.957s)
[99.575523] [011/133] (919s left) kms_big_fb (linear-max-hw-stride-32bpp-rotate-0-hflip)
[99.670784] Starting subtest: linear-max-hw-stride-32bpp-rotate-0-hflip
[99.672681] Subtest linear-max-hw-stride-32bpp-rotate-0-hflip: SKIP (0.000s)
[99.780244] [012/133] (919s left) gem_ctx_persistence (heartbeat-close)
[99.831211] Starting subtest: heartbeat-close
[99.833092] Subtest heartbeat-close: SKIP (0.000s)
[99.956765] [013/133] (919s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-64bpp-yftile-upscaling)
[100.039033] Starting subtest: flip-32bpp-yftile-to-64bpp-yftile-upscaling
[100.040953] Subtest flip-32bpp-yftile-to-64bpp-yftile-upscaling: SKIP (0.000s)
[100.123377] [014/133] (919s left) perf (whitelisted-registers-userspace-config)
[100.240044] Starting subtest: whitelisted-registers-userspace-config
[100.240955] Subtest whitelisted-registers-userspace-config: SUCCESS (0.000s)
[100.277614] [015/133] (919s left) kms_cursor_legacy (basic-flip-before-cursor-legacy)
[100.390838] Starting subtest: basic-flip-before-cursor-legacy
[101.303091] Subtest basic-flip-before-cursor-legacy: SUCCESS (0.912s)
[102.192414] [016/133] (917s left) syncobj_wait (single-wait-for-submit-unsubmitted)
[102.239410] Starting subtest: single-wait-for-submit-unsubmitted
[102.347616] Subtest single-wait-for-submit-unsubmitted: SUCCESS (0.105s)
[102.423517] [017/133] (917s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-mmap-gtt)
[102.510695] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-mmap-gtt
[102.512365] Subtest psr-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[102.637665] [018/133] (916s left) kms_frontbuffer_tracking (fbc-1p-primscrn-indfb-pgflip-blt)
[102.735531] Starting subtest: fbc-1p-primscrn-indfb-pgflip-blt
[107.160542] Subtest fbc-1p-primscrn-indfb-pgflip-blt: SUCCESS (4.426s)
[108.286680] [019/133] (911s left) kms_plane (pixel-format-y-tiled-gen12-rc-ccs-cc-modifier)
[108.385044] Starting subtest: pixel-format-y-tiled-gen12-rc-ccs-cc-modifier
[108.412567] Starting dynamic subtest: pipe-A-plane-0
[108.414240] Dynamic subtest pipe-A-plane-0: SKIP (0.000s)
[108.419840] Starting dynamic subtest: pipe-A-plane-3
[108.421515] Dynamic subtest pipe-A-plane-3: SKIP (0.000s)
[108.429380] Starting dynamic subtest: pipe-A-plane-5
[108.431775] Dynamic subtest pipe-A-plane-5: SKIP (0.000s)
[109.474803] Starting dynamic subtest: pipe-B-plane-0
[109.476739] Dynamic subtest pipe-B-plane-0: SKIP (0.000s)
[109.482364] Starting dynamic subtest: pipe-B-plane-3
[109.484120] Dynamic subtest pipe-B-plane-3: SKIP (0.000s)
[109.489610] Starting dynamic subtest: pipe-B-plane-5
[109.491367] Dynamic subtest pipe-B-plane-5: SKIP (0.000s)
[109.775489] Subtest pixel-format-y-tiled-gen12-rc-ccs-cc-modifier: SKIP (1.389s)
[110.653598] [020/133] (908s left) kms_flip (2x-busy-flip)
[110.745225] Starting subtest: 2x-busy-flip
[110.755680] Subtest 2x-busy-flip: SKIP (0.011s)
[110.839231] [021/133] (908s left) kms_psr (fbc-pr-sprite-plane-move)
[110.923999] Starting subtest: fbc-pr-sprite-plane-move
[110.925713] Subtest fbc-pr-sprite-plane-move: SKIP (0.000s)
[110.998113] [022/133] (908s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-pwrite)
[111.085268] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-pwrite
[119.568029] Subtest psr-1p-primscrn-pri-shrfb-draw-pwrite: SUCCESS (8.484s)
[119.660394] [023/133] (900s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite)
[119.760836] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite
[119.762747] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[119.867670] [024/133] (899s left) i915_drm_fdinfo (memory-info-resident)
[119.904591] Starting subtest: memory-info-resident
[119.905547] Starting dynamic subtest: smem0
[122.515856] Dynamic subtest smem0: SUCCESS (2.611s)
[122.518014] Subtest memory-info-resident: SUCCESS (2.611s)
[122.593680] [025/133] (897s left) dmabuf_sync_file (export-wait-after-attach)
[122.676192] Starting subtest: export-wait-after-attach
[122.677211] Subtest export-wait-after-attach: SUCCESS (0.001s)
[122.738294] [FACT dmabuf_sync_file (export-wait-after-attach)] new: kernel.kmod_is_loaded.vgem: true
[122.740098] [026/133] (897s left) syncobj_timeline (multi-wait-for-submit-available-unsubmitted-submitted)
[122.809120] Starting subtest: multi-wait-for-submit-available-unsubmitted-submitted
[122.810096] Subtest multi-wait-for-submit-available-unsubmitted-submitted: SUCCESS (0.000s)
[122.928501] [027/133] (896s left) kms_cursor_legacy (flip-vs-cursor-legacy)
[123.046948] Starting subtest: flip-vs-cursor-legacy
[130.260987] Subtest flip-vs-cursor-legacy: SUCCESS (7.213s)
[131.127791] [028/133] (888s left) gem_render_copy (yf-tiled-ccs-to-x-tiled)
[131.186997] Starting subtest: yf-tiled-ccs-to-x-tiled
[131.188914] Subtest yf-tiled-ccs-to-x-tiled: SKIP (0.000s)
[131.373552] [029/133] (888s left) kms_lease (lease-again)
[131.460839] Starting subtest: lease-again
[131.461798] Starting dynamic subtest: pipe-A-eDP-1
[131.464093] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.002s)
[131.472747] Starting dynamic subtest: pipe-B-eDP-1
[131.473666] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.002s)
[131.479293] Starting dynamic subtest: pipe-C-eDP-1
[131.480122] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.002s)
[131.485791] Starting dynamic subtest: pipe-D-eDP-1
[131.486707] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.002s)
[131.487580] Subtest lease-again: SUCCESS (0.011s)
[131.581663] [030/133] (888s left) kms_chamelium_audio (dp-audio)
[131.974207] Subtest dp-audio: SKIP (0.000s)
[132.738405] [031/133] (887s left) prime_vgem (basic-read)
[132.807192] Starting subtest: basic-read
[132.813220] Subtest basic-read: SKIP (0.005s)
[132.905376] [032/133] (887s left) perf (create-destroy-userspace-config)
[133.015159] Starting subtest: create-destroy-userspace-config
[133.034272] Subtest create-destroy-userspace-config: SUCCESS (0.020s)
[133.068363] [033/133] (886s left) kms_sequence (get-busy)
[133.158233] Starting subtest: get-busy
[133.159217] Starting dynamic subtest: pipe-A-eDP-1
[135.095631] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.938s)
[135.102175] Starting dynamic subtest: pipe-B-eDP-1
[137.675169] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.578s)
[137.681782] Starting dynamic subtest: pipe-C-eDP-1
[140.286565] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.610s)
[140.293358] Starting dynamic subtest: pipe-D-eDP-1
[142.832984] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.546s)
[142.833962] Subtest get-busy: SUCCESS (9.676s)
[143.634238] [034/133] (876s left) kms_ccs (missing-ccs-buffer-y-tiled-gen12-mc-ccs)
[143.735870] Starting subtest: missing-ccs-buffer-y-tiled-gen12-mc-ccs
[143.736869] Starting dynamic subtest: pipe-A-eDP-1
[143.765074] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[143.772911] Starting dynamic subtest: pipe-B-eDP-1
[143.780872] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[143.786812] Starting dynamic subtest: pipe-C-eDP-1
[143.795079] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[143.800754] Starting dynamic subtest: pipe-D-eDP-1
[143.809451] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[143.811068] Subtest missing-ccs-buffer-y-tiled-gen12-mc-ccs: SKIP (0.003s)
[145.901159] [035/133] (874s left) gem_exec_reloc (basic-gtt-wc)
[145.959382] Subtest basic-gtt-wc: SKIP (0.000s)
[146.033494] [036/133] (874s left) i915_pm_rps (thresholds-idle-park)
[146.097324] Starting subtest: thresholds-idle-park
[146.099397] Subtest thresholds-idle-park: SKIP (0.001s)
[146.205410] [037/133] (873s left) perf (non-sampling-read-error)
[146.299367] Starting subtest: non-sampling-read-error
[146.307377] Subtest non-sampling-read-error: SUCCESS (0.008s)
[146.346654] [038/133] (873s left) perf (low-oa-exponent-permissions)
[146.430475] Starting subtest: low-oa-exponent-permissions
[146.468115] Subtest low-oa-exponent-permissions: SUCCESS (0.038s)
[146.504599] [039/133] (873s left) kms_atomic (plane-cursor-legacy)
[146.594101] Starting subtest: plane-cursor-legacy
[146.594980] Starting dynamic subtest: pipe-A-eDP-1
[146.978407] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.384s)
[146.979368] Subtest plane-cursor-legacy: SUCCESS (0.385s)
[147.834172] [040/133] (872s left) kms_frontbuffer_tracking (psr-slowdraw)
[147.935739] Starting subtest: psr-slowdraw
[173.050803] Subtest psr-slowdraw: SUCCESS (25.114s)
[173.200607] [041/133] (847s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip)
[173.304668] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip
[173.962699] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip: SUCCESS (0.659s)
[174.152882] [042/133] (846s left) kms_psr2_sf (fbc-psr2-overlay-plane-move-continuous-sf)
[174.246683] Starting subtest: fbc-psr2-overlay-plane-move-continuous-sf
[174.247617] Starting dynamic subtest: pipe-A-eDP-1
[174.333985] Dynamic subtest pipe-A-eDP-1: SKIP (0.087s)
[174.340884] Starting dynamic subtest: pipe-B-eDP-1
[175.522234] Dynamic subtest pipe-B-eDP-1: SKIP (1.187s)
[175.523951] Subtest fbc-psr2-overlay-plane-move-continuous-sf: SKIP (1.276s)
[176.715297] [043/133] (843s left) kms_psr2_sf (fbc-psr2-cursor-plane-move-continuous-sf)
[176.811827] Starting subtest: fbc-psr2-cursor-plane-move-continuous-sf
[176.812751] Starting dynamic subtest: pipe-A-eDP-1
[176.887511] Dynamic subtest pipe-A-eDP-1: SKIP (0.076s)
[176.895335] Starting dynamic subtest: pipe-B-eDP-1
[177.978383] Dynamic subtest pipe-B-eDP-1: SKIP (1.090s)
[177.980042] Subtest fbc-psr2-cursor-plane-move-continuous-sf: SKIP (1.168s)
[179.177852] [044/133] (841s left) kms_pm_rpm (modeset-non-lpsp)
[181.094335] Starting subtest: modeset-non-lpsp
[182.238338] Subtest modeset-non-lpsp: SKIP (1.146s)
[182.615979] [045/133] (837s left) kms_atomic_transition (plane-all-modeset-transition-fencing)
[182.716904] Starting subtest: plane-all-modeset-transition-fencing
[182.718829] Subtest plane-all-modeset-transition-fencing: SKIP (0.000s)
[182.828341] [046/133] (837s left) i915_drm_fdinfo (virtual-busy-idle-all)
[182.870273] Starting subtest: virtual-busy-idle-all
[182.872221] Subtest virtual-busy-idle-all: SKIP (0.000s)
[182.946517] [047/133] (837s left) kms_addfb_basic (legacy-format)
[183.006715] Starting subtest: legacy-format
[183.024355] Subtest legacy-format: SUCCESS (0.017s)
[183.160997] [048/133] (837s left) gem_exec_schedule (implicit-read-write)
[183.225574] Starting subtest: implicit-read-write
[183.226534] Starting dynamic subtest: rcs0
[183.335459] Dynamic subtest rcs0: SUCCESS (0.109s)
[183.344750] Starting dynamic subtest: vcs0
[183.418919] Dynamic subtest vcs0: SUCCESS (0.082s)
[183.427675] Starting dynamic subtest: vcs1
[183.500060] Dynamic subtest vcs1: SUCCESS (0.080s)
[183.509516] Starting dynamic subtest: vecs0
[183.574363] Dynamic subtest vecs0: SUCCESS (0.074s)
[183.583035] Starting dynamic subtest: ccs0
[183.658114] Dynamic subtest ccs0: SUCCESS (0.083s)
[183.659519] Subtest implicit-read-write: SUCCESS (0.433s)
[185.033802] [049/133] (835s left) kms_plane_scaling (plane-upscale-factor-0-25-with-rotation)
[185.122230] Starting subtest: plane-upscale-factor-0-25-with-rotation
[185.123098] Starting dynamic subtest: pipe-A
[185.348573] Dynamic subtest pipe-A: SUCCESS (0.227s)
[185.355243] Starting dynamic subtest: pipe-B
[186.679830] Dynamic subtest pipe-B: SUCCESS (1.331s)
[186.686381] Starting dynamic subtest: pipe-C
[188.019574] Dynamic subtest pipe-C: SUCCESS (1.339s)
[188.026271] Starting dynamic subtest: pipe-D
[189.345057] Dynamic subtest pipe-D: SUCCESS (1.325s)
[189.345977] Subtest plane-upscale-factor-0-25-with-rotation: SUCCESS (4.224s)
[190.534194] [050/133] (830s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-pwrite)
[190.636726] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-pwrite
[195.067520] Subtest fbc-1p-primscrn-cur-indfb-draw-pwrite: SUCCESS (4.431s)
[196.274509] [051/133] (824s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip)
[196.373227] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip
[196.374963] Subtest y-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip: SKIP (0.000s)
[196.498024] [052/133] (824s left) sysfs_timeslice_duration (invalid)
[196.564929] Starting subtest: invalid
[196.565959] Starting dynamic subtest: vecs0
[196.566961] Dynamic subtest vecs0: SUCCESS (0.000s)
[196.574461] Starting dynamic subtest: ccs0
[196.575352] Dynamic subtest ccs0: SUCCESS (0.000s)
[196.581187] Starting dynamic subtest: vcs0
[196.582054] Dynamic subtest vcs0: SUCCESS (0.000s)
[196.587911] Starting dynamic subtest: bcs0
[196.588783] Dynamic subtest bcs0: SUCCESS (0.000s)
[196.594610] Starting dynamic subtest: rcs0
[196.595518] Dynamic subtest rcs0: SUCCESS (0.000s)
[196.601356] Starting dynamic subtest: vcs1
[196.602253] Dynamic subtest vcs1: SUCCESS (0.000s)
[196.603098] Subtest invalid: SUCCESS (0.005s)
[196.691449] [053/133] (823s left) perf (stress-open-close)
[196.791058] Starting subtest: stress-open-close
[196.792144] Starting dynamic subtest: 0-rcs0
[198.972685] Dynamic subtest 0-rcs0: SUCCESS (2.181s)
[198.980186] Starting dynamic subtest: 1-vecs0
[201.140134] Dynamic subtest 1-vecs0: SUCCESS (2.166s)
[201.141173] Subtest stress-open-close: SUCCESS (4.349s)
[201.174548] [054/133] (819s left) kms_frontbuffer_tracking (fbcpsr-1p-pri-indfb-multidraw)
[201.283260] Starting subtest: fbcpsr-1p-pri-indfb-multidraw
[223.649504] Subtest fbcpsr-1p-pri-indfb-multidraw: SUCCESS (22.366s)
[223.825828] [055/133] (796s left) gem_eio (in-flight-10ms)
[224.066403] Starting subtest: in-flight-10ms
[232.991974] Subtest in-flight-10ms: SUCCESS (8.924s)
[233.186215] [056/133] (787s left) gem_ctx_engines (none)
[233.246732] Starting subtest: none
[233.247784] Subtest none: SUCCESS (0.001s)
[233.442446] [057/133] (787s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-onoff)
[233.539815] Starting subtest: psr-2p-primscrn-spr-indfb-onoff
[233.541714] Subtest psr-2p-primscrn-spr-indfb-onoff: SKIP (0.000s)
[233.663127] [058/133] (787s left) gem_eio (create)
[233.892384] Starting subtest: create
[234.237092] Subtest create: SUCCESS (0.344s)
[234.395167] [059/133] (786s left) gem_exec_fence (syncobj-timeline-invalid-flags)
[234.923972] Starting subtest: syncobj-timeline-invalid-flags
[234.925498] Subtest syncobj-timeline-invalid-flags: SUCCESS (0.000s)
[236.011117] [060/133] (784s left) gem_exec_fence (syncobj-timeline-unused-fence)
[236.534511] Starting subtest: syncobj-timeline-unused-fence
[236.539721] Subtest syncobj-timeline-unused-fence: SUCCESS (0.008s)
[238.029910] [061/133] (782s left) syncobj_timeline (wait-any-interrupted)
[238.093962] Starting subtest: wait-any-interrupted
[238.198745] Subtest wait-any-interrupted: SUCCESS (0.102s)
[238.276908] [062/133] (782s left) syncobj_timeline (invalid-query-bad-pad)
[238.334992] Starting subtest: invalid-query-bad-pad
[238.335906] Subtest invalid-query-bad-pad: SUCCESS (0.000s)
[238.449727] [063/133] (782s left) gem_partial_pwrite_pread (reads-uncached)
[238.516141] Subtest reads-uncached: SKIP (0.000s)
[238.598502] [064/133] (782s left) kms_cursor_crc (cursor-onscreen-128x42)
[238.828876] Starting subtest: cursor-onscreen-128x42
[238.868058] Subtest cursor-onscreen-128x42: SKIP (0.037s)
[239.106460] [065/133] (781s left) kms_fbcon_fbt (fbc-suspend)
[239.163852] Starting subtest: fbc-suspend
[289.257823] Subtest fbc-suspend: SUCCESS (19.887s)
[290.556544] [066/133] (730s left) kms_plane_alpha_blend (alpha-7efc)
[290.652811] Starting subtest: alpha-7efc
[290.945128] Starting dynamic subtest: pipe-A-eDP-1
[291.530286] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.584s)
[291.555490] Starting dynamic subtest: pipe-D-eDP-1
[292.896774] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.347s)
[292.897589] Subtest alpha-7efc: SUCCESS (2.242s)
[293.752807] [067/133] (727s left) gem_exec_whisper (basic-normal-all)
[293.815720] Starting subtest: basic-normal-all
[295.904416] Subtest basic-normal-all: SUCCESS (2.086s)
[296.095151] [068/133] (725s left) gem_spin_batch (spin-all)
[296.157666] Starting subtest: spin-all
[296.171632] Subtest spin-all: SUCCESS (0.014s)
[298.181697] [069/133] (723s left) kms_pwrite_crc
[299.787985] [070/133] (721s left) kms_ccs (bad-aux-stride-y-tiled-gen12-mc-ccs)
[299.873323] Starting subtest: bad-aux-stride-y-tiled-gen12-mc-ccs
[299.874178] Starting dynamic subtest: pipe-A-eDP-1
[299.882039] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[299.889676] Starting dynamic subtest: pipe-B-eDP-1
[299.897602] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[299.905209] Starting dynamic subtest: pipe-C-eDP-1
[299.912928] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[299.920172] Starting dynamic subtest: pipe-D-eDP-1
[299.928029] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[299.929574] Subtest bad-aux-stride-y-tiled-gen12-mc-ccs: SKIP (0.005s)
[302.075147] [071/133] (719s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-16bpp-ytile-downscaling)
[302.164485] Starting subtest: flip-64bpp-ytile-to-16bpp-ytile-downscaling
[302.166165] Subtest flip-64bpp-ytile-to-16bpp-ytile-downscaling: SKIP (0.000s)
[302.248268] [072/133] (719s left) api_intel_bb (render)
[302.309148] Starting subtest: render
[302.310132] Starting dynamic subtest: render-none-512
[302.414414] Dynamic subtest render-none-512: SUCCESS (0.103s)
[302.424419] Starting dynamic subtest: render-none-1024
[302.793801] Dynamic subtest render-none-1024: SUCCESS (0.378s)
[302.805712] Starting dynamic subtest: render-x-512
[302.879711] Dynamic subtest render-x-512: SUCCESS (0.087s)
[302.890233] Starting dynamic subtest: render-x-1024
[303.223455] Dynamic subtest render-x-1024: SUCCESS (0.343s)
[303.232602] Starting dynamic subtest: render-y-512
[303.310180] Dynamic subtest render-y-512: SUCCESS (0.085s)
[303.320368] Starting dynamic subtest: render-y-1024
[303.656720] Dynamic subtest render-y-1024: SUCCESS (0.344s)
[303.658086] Subtest render: SUCCESS (1.347s)
[303.807718] [073/133] (717s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-0-hflip)
[303.907015] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-0-hflip
[303.908560] Subtest y-tiled-max-hw-stride-32bpp-rotate-0-hflip: SKIP (0.000s)
[304.013954] [074/133] (717s left) gem_render_copy (y-tiled-to-vebox-linear)
[304.078606] Starting subtest: y-tiled-to-vebox-linear
[304.080192] Subtest y-tiled-to-vebox-linear: SKIP (0.000s)
[304.262051] [075/133] (717s left) syncobj_timeline (etime-single-wait-submitted)
[304.333051] Starting subtest: etime-single-wait-submitted
[304.441167] Subtest etime-single-wait-submitted: SUCCESS (0.105s)
[304.522182] [076/133] (716s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-mmap-cpu)
[304.628076] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-mmap-cpu
[308.700368] Subtest fbc-1p-offscreen-pri-indfb-draw-mmap-cpu: SUCCESS (4.071s)
[309.903434] [077/133] (711s left) syncobj_wait (reset-during-wait-for-submit)
[309.950714] Starting subtest: reset-during-wait-for-submit
[310.055402] Subtest reset-during-wait-for-submit: SUCCESS (0.103s)
[310.135839] [078/133] (711s left) kms_ccs (crc-primary-suspend-y-tiled-gen12-rc-ccs)
[310.228117] Starting subtest: crc-primary-suspend-y-tiled-gen12-rc-ccs
[310.229158] Starting dynamic subtest: pipe-A-eDP-1
[310.232743] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[310.241031] Starting dynamic subtest: pipe-B-eDP-1
[310.244607] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[310.252643] Starting dynamic subtest: pipe-C-eDP-1
[310.256200] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[310.264170] Starting dynamic subtest: pipe-D-eDP-1
[310.267784] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[310.269514] Subtest crc-primary-suspend-y-tiled-gen12-rc-ccs: SKIP (0.005s)
[312.446726] [079/133] (709s left) syncobj_timeline (32bits-limit)
[312.511481] Starting subtest: 32bits-limit
[312.512445] Subtest 32bits-limit: SUCCESS (0.001s)
[312.635140] [080/133] (708s left) gem_exec_fence (basic-await)
[312.812261] Starting subtest: basic-await
[312.813501] Starting dynamic subtest: rcs0
[312.906885] Dynamic subtest rcs0: SUCCESS (0.095s)
[312.917180] Starting dynamic subtest: bcs0
[312.981372] Dynamic subtest bcs0: SUCCESS (0.073s)
[312.991850] Starting dynamic subtest: vcs0
[313.058679] Dynamic subtest vcs0: SUCCESS (0.074s)
[313.070126] Starting dynamic subtest: vcs1
[313.133820] Dynamic subtest vcs1: SUCCESS (0.076s)
[313.144018] Starting dynamic subtest: vecs0
[313.207622] Dynamic subtest vecs0: SUCCESS (0.072s)
[313.218849] Starting dynamic subtest: ccs0
[313.283255] Dynamic subtest ccs0: SUCCESS (0.074s)
[313.284979] Subtest basic-await: SUCCESS (0.472s)
[315.206467] [081/133] (706s left) gem_mmap_offset (perf)
[315.266225] Starting subtest: perf
[315.267204] Starting dynamic subtest: smem0
[315.637111] Dynamic subtest smem0: SUCCESS (0.369s)
[315.638644] Subtest perf: SUCCESS (0.370s)
[315.787323] [082/133] (705s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-mmap-cpu)
[315.886473] Starting subtest: psr-1p-offscreen-pri-indfb-draw-mmap-cpu
[322.395121] Subtest psr-1p-offscreen-pri-indfb-draw-mmap-cpu: SUCCESS (6.508s)
[322.513994] [083/133] (699s left) gen9_exec_parse (basic-rejected)
[322.579043] Subtest basic-rejected: SKIP (0.000s)
[322.649741] [084/133] (699s left) kms_cursor_crc (cursor-sliding-64x21)
[322.833955] Starting subtest: cursor-sliding-64x21
[322.873617] Subtest cursor-sliding-64x21: SKIP (0.037s)
[323.134540] [085/133] (698s left) kms_content_protection (atomic-hdcp14)
[323.279989] Starting subtest: atomic-hdcp14
[323.281724] Subtest atomic-hdcp14: SKIP (0.000s)
[323.427755] [086/133] (698s left) vgem_basic (dmabuf-mmap)
[323.470103] Starting subtest: dmabuf-mmap
[323.479720] Subtest dmabuf-mmap: SUCCESS (0.010s)
[323.545401] [087/133] (698s left) kms_invalid_mode (zero-hdisplay)
[323.642548] Starting subtest: zero-hdisplay
[323.643746] Starting dynamic subtest: pipe-A-eDP-1
[323.930640] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.288s)
[323.943478] Starting dynamic subtest: pipe-B-eDP-1
[323.944503] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[323.952055] Starting dynamic subtest: pipe-C-eDP-1
[323.953033] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[323.960511] Starting dynamic subtest: pipe-D-eDP-1
[323.961364] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[323.962212] Subtest zero-hdisplay: SUCCESS (0.294s)
[324.807170] [088/133] (696s left) kms_pm_rpm (basic-rte)
[324.835572] Starting subtest: basic-rte
[327.761797] Subtest basic-rte: SUCCESS (2.927s)
[329.551703] [089/133] (692s left) gem_exec_whisper (basic-queues-all)
[329.612120] Starting subtest: basic-queues-all
[339.934314] Subtest basic-queues-all: SUCCESS (10.321s)
[340.124772] [090/133] (681s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-blt)
[340.231006] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-blt
[347.100129] Subtest psr-1p-offscreen-pri-shrfb-draw-blt: SUCCESS (6.866s)
[347.245818] [091/133] (674s left) gem_busy (parallel)
[347.432582] Starting subtest: parallel
[347.433484] Starting dynamic subtest: rcs0
[349.141788] Dynamic subtest rcs0: SUCCESS (1.706s)
[349.153264] Starting dynamic subtest: bcs0
[351.125798] Dynamic subtest bcs0: SUCCESS (1.981s)
[351.136661] Starting dynamic subtest: vcs0
[353.110272] Dynamic subtest vcs0: SUCCESS (1.982s)
[353.121220] Starting dynamic subtest: vcs1
[355.093054] Dynamic subtest vcs1: SUCCESS (1.979s)
[355.104054] Starting dynamic subtest: vecs0
[357.141003] Dynamic subtest vecs0: SUCCESS (2.045s)
[357.151578] Starting dynamic subtest: ccs0
[359.125807] Dynamic subtest ccs0: SUCCESS (1.982s)
[359.127394] Subtest parallel: SUCCESS (11.692s)
[359.380054] [092/133] (662s left) gem_exec_params (invalid-bsd2-flag-on-vebox)
[359.443063] Starting subtest: invalid-bsd2-flag-on-vebox
[359.444023] Subtest invalid-bsd2-flag-on-vebox: SUCCESS (0.000s)
[359.558292] [093/133] (662s left) kms_psr (fbc-pr-cursor-render)
[359.655603] Starting subtest: fbc-pr-cursor-render
[359.657332] Subtest fbc-pr-cursor-render: SKIP (0.000s)
[359.731719] [094/133] (662s left) kms_psr (pr-sprite-mmap-cpu)
[359.826594] Starting subtest: pr-sprite-mmap-cpu
[359.828171] Subtest pr-sprite-mmap-cpu: SKIP (0.000s)
[359.911072] [095/133] (662s left) perf_pmu (init-sema)
[359.940559] Starting subtest: init-sema
[359.941606] Starting dynamic subtest: rcs0
[359.944294] Dynamic subtest rcs0: SUCCESS (0.002s)
[359.952991] Starting dynamic subtest: bcs0
[359.954027] Dynamic subtest bcs0: SUCCESS (0.000s)
[359.961763] Starting dynamic subtest: vcs0
[359.962633] Dynamic subtest vcs0: SUCCESS (0.001s)
[359.970277] Starting dynamic subtest: vcs1
[359.971226] Dynamic subtest vcs1: SUCCESS (0.001s)
[359.979129] Starting dynamic subtest: vecs0
[359.980146] Dynamic subtest vecs0: SUCCESS (0.001s)
[359.987816] Starting dynamic subtest: ccs0
[359.988804] Dynamic subtest ccs0: SUCCESS (0.000s)
[359.989752] Subtest init-sema: SUCCESS (0.010s)
[360.083285] [096/133] (661s left) gem_exec_flush (basic-uc-ro-default)
[360.146265] Starting subtest: basic-uc-ro-default
[365.603975] Subtest basic-uc-ro-default: SUCCESS (5.457s)
[365.801742] [097/133] (656s left) kms_flip (flip-vs-expired-vblank-interruptible)
[365.908060] Starting subtest: flip-vs-expired-vblank-interruptible
[365.910308] Starting dynamic subtest: A-eDP1
[374.546948] Dynamic subtest A-eDP1: SUCCESS (8.636s)
[374.556558] Starting dynamic subtest: B-eDP1
[383.187048] Dynamic subtest B-eDP1: SUCCESS (8.638s)
[383.196499] Starting dynamic subtest: C-eDP1
[391.807440] Dynamic subtest C-eDP1: SUCCESS (8.618s)
[391.820478] Starting dynamic subtest: D-eDP1
[400.434382] Dynamic subtest D-eDP1: SUCCESS (8.624s)
[400.438097] Subtest flip-vs-expired-vblank-interruptible: SUCCESS (34.528s)
[401.636773] [098/133] (620s left) i915_pm_rpm (debugfs-read)
[403.266441] Starting subtest: debugfs-read
[404.414367] Subtest debugfs-read: SUCCESS (1.148s)
[404.818656] [099/133] (617s left) kms_color_pipeline (plane-lut1d-pre-ctm3x4)
[404.913926] Starting subtest: plane-lut1d-pre-ctm3x4
[404.927413] Starting dynamic subtest: pipe-A-eDP-1
[405.416021] Dynamic subtest pipe-A-eDP-1: FAIL (0.347s)
[406.393177] Starting dynamic subtest: pipe-B-eDP-1
[406.878806] Dynamic subtest pipe-B-eDP-1: FAIL (0.302s)
[407.710368] Starting dynamic subtest: pipe-C-eDP-1
[408.172804] Dynamic subtest pipe-C-eDP-1: FAIL (0.246s)
[409.036685] Starting dynamic subtest: pipe-D-eDP-1
[409.518264] Dynamic subtest pipe-D-eDP-1: FAIL (0.269s)
[409.595237] Subtest plane-lut1d-pre-ctm3x4: FAIL (4.682s)
[410.427804] [100/133] (611s left) gem_exec_params (invalid-ring2)
[410.502105] Starting subtest: invalid-ring2
[410.503098] Subtest invalid-ring2: SUCCESS (0.000s)
[410.614032] [101/133] (611s left) gem_mmap_gtt (close-race)
[410.667786] Subtest close-race: SKIP (0.000s)
[410.725886] [102/133] (611s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-shrfb-pgflip-blt)
[410.828658] Starting subtest: fbcpsr-2p-primscrn-shrfb-pgflip-blt
[410.831536] Subtest fbcpsr-2p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[410.942530] [103/133] (611s left) prime_mmap (test_forked)
[410.996925] Starting subtest: test_forked
[410.997856] Starting dynamic subtest: test_forked-smem
[411.036541] Dynamic subtest test_forked-smem: SUCCESS (0.040s)
[411.037893] Subtest test_forked: SUCCESS (0.042s)
[411.167652] [104/133] (611s left) kms_cursor_crc (cursor-random-256x85)
[411.461167] Starting subtest: cursor-random-256x85
[411.535927] Subtest cursor-random-256x85: SKIP (0.070s)
[411.709707] [105/133] (610s left) kms_draw_crc (draw-method-mmap-gtt)
[411.816187] Starting subtest: draw-method-mmap-gtt
[411.818018] Subtest draw-method-mmap-gtt: SKIP (0.000s)
[411.935859] [106/133] (610s left) gem_ctx_create (basic-files)
[412.007283] Starting subtest: basic-files
[414.015562] Subtest basic-files: SUCCESS (2.008s)
[415.275822] [107/133] (607s left) kms_plane_scaling (plane-scaler-unity-scaling-with-modifiers)
[415.375845] Starting subtest: plane-scaler-unity-scaling-with-modifiers
[415.376786] Starting dynamic subtest: pipe-A
[415.736970] Dynamic subtest pipe-A: SUCCESS (0.362s)
[415.745072] Starting dynamic subtest: pipe-B
[417.150107] Dynamic subtest pipe-B: SUCCESS (1.412s)
[417.160995] Starting dynamic subtest: pipe-C
[418.535636] Dynamic subtest pipe-C: SUCCESS (1.385s)
[418.543863] Starting dynamic subtest: pipe-D
[419.963155] Dynamic subtest pipe-D: SUCCESS (1.426s)
[419.964098] Subtest plane-scaler-unity-scaling-with-modifiers: SUCCESS (4.589s)
[421.142925] [108/133] (601s left) kms_ccs (ccs-on-another-bo-y-tiled-ccs)
[421.239516] Starting subtest: ccs-on-another-bo-y-tiled-ccs
[421.240400] Starting dynamic subtest: pipe-A-eDP-1
[421.248696] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[421.256647] Starting dynamic subtest: pipe-B-eDP-1
[421.264884] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[421.273219] Starting dynamic subtest: pipe-C-eDP-1
[421.281443] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[421.289108] Starting dynamic subtest: pipe-D-eDP-1
[421.297496] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[421.299166] Subtest ccs-on-another-bo-y-tiled-ccs: SKIP (0.005s)
[423.423413] [109/133] (599s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-render)
[423.533287] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-render
[423.534990] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-render: SKIP (0.000s)
[423.668675] [110/133] (598s left) gem_ctx_param (invalid-get-engines)
[423.723906] Starting subtest: invalid-get-engines
[423.724879] Subtest invalid-get-engines: SUCCESS (0.001s)
[423.834932] [111/133] (598s left) gem_exec_schedule (u-fairslice-all)
[423.893531] Starting subtest: u-fairslice-all
[425.956795] Subtest u-fairslice-all: SUCCESS (2.064s)
[427.203643] [112/133] (595s left) api_intel_bb (blit-reloc-purge-cache)
[427.268396] Starting subtest: blit-reloc-purge-cache
[427.270498] Subtest blit-reloc-purge-cache: SKIP (0.001s)
[427.416624] [113/133] (595s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip)
[427.519457] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip
[428.312600] Subtest x-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SUCCESS (0.793s)
[428.592755] [114/133] (594s left) kms_chamelium_hpd (hdmi-hpd-with-enabled-mode)
[428.977089] Subtest hdmi-hpd-with-enabled-mode: SKIP (0.000s)
[429.814544] [115/133] (592s left) kms_frontbuffer_tracking (fbcpsr-stridechange)
[429.910066] Starting subtest: fbcpsr-stridechange
[436.088923] Subtest fbcpsr-stridechange: SUCCESS (6.178s)
[436.278607] [116/133] (586s left) kms_plane (pixel-format-4-tiled-dg2-mc-ccs-modifier)
[436.378972] Starting subtest: pixel-format-4-tiled-dg2-mc-ccs-modifier
[436.408143] Starting dynamic subtest: pipe-A-plane-0
[436.410141] Dynamic subtest pipe-A-plane-0: SKIP (0.000s)
[436.419796] Starting dynamic subtest: pipe-A-plane-3
[436.421582] Dynamic subtest pipe-A-plane-3: SKIP (0.000s)
[436.429529] Starting dynamic subtest: pipe-A-plane-5
[436.431244] Dynamic subtest pipe-A-plane-5: SKIP (0.000s)
[437.471461] Starting dynamic subtest: pipe-B-plane-0
[437.473055] Dynamic subtest pipe-B-plane-0: SKIP (0.000s)
[437.480961] Starting dynamic subtest: pipe-B-plane-3
[437.482578] Dynamic subtest pipe-B-plane-3: SKIP (0.000s)
[437.490258] Starting dynamic subtest: pipe-B-plane-5
[437.491917] Dynamic subtest pipe-B-plane-5: SKIP (0.000s)
[437.776851] Subtest pixel-format-4-tiled-dg2-mc-ccs-modifier: SKIP (1.397s)
[438.646627] [117/133] (584s left) gem_exec_balancer (nop)
[438.705170] Starting subtest: nop
[485.320058] Subtest nop: SUCCESS (46.610s)
[485.640533] [118/133] (537s left) gem_mmap_gtt (big-bo-tiledy)
[485.694164] Subtest big-bo-tiledY: SKIP (0.000s)
[485.761332] [119/133] (537s left) gem_pread (uncached)
[485.826214] Subtest uncached: SKIP (0.000s)
[485.898122] [120/133] (537s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-render)
[485.995827] Starting subtest: psr-2p-primscrn-spr-indfb-draw-render
[485.997540] Subtest psr-2p-primscrn-spr-indfb-draw-render: SKIP (0.000s)
[486.107384] [121/133] (536s left) kms_dp_link_training (non-uhbr-sst)
[486.204792] Starting subtest: non-uhbr-sst
[486.208625] Subtest non-uhbr-sst: SKIP (0.000s)
[486.286408] [122/133] (536s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-mmap-wc)
[486.379808] Starting subtest: fbcpsr-rgb565-draw-mmap-wc
[493.155389] Subtest fbcpsr-rgb565-draw-mmap-wc: SUCCESS (6.776s)
[493.293579] [123/133] (529s left) gem_mmap_gtt (basic-read)
[493.357423] Subtest basic-read: SKIP (0.000s)
[493.428576] [124/133] (529s left) syncobj_wait (multi-wait-all-submitted-signaled)
[493.493490] Starting subtest: multi-wait-all-submitted-signaled
[493.601266] Subtest multi-wait-all-submitted-signaled: SUCCESS (0.104s)
[493.682802] [125/133] (529s left) kms_psr (fbc-psr2-suspend)
[493.776912] Starting subtest: fbc-psr2-suspend
[493.777884] Starting dynamic subtest: eDP-1
[493.779653] Dynamic subtest eDP-1: SKIP (0.000s)
[493.781415] Subtest fbc-psr2-suspend: SKIP (0.001s)
[493.871308] [126/133] (529s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-pwrite)
[493.963039] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-pwrite
[493.964702] Subtest fbc-2p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[494.089838] [127/133] (529s left) gem_mmap_gtt (basic-small-copy-odd)
[494.144392] Subtest basic-small-copy-odd: SKIP (0.000s)
[494.208721] [128/133] (529s left) perf_pmu (busy)
[494.246170] Starting subtest: busy
[494.247070] Starting dynamic subtest: rcs0
[494.830257] Dynamic subtest rcs0: SUCCESS (0.584s)
[494.843081] Starting dynamic subtest: bcs0
[495.401923] Dynamic subtest bcs0: SUCCESS (0.570s)
[495.413705] Starting dynamic subtest: vcs0
[497.109025] Dynamic subtest vcs0: SUCCESS (1.702s)
[497.120907] Starting dynamic subtest: vcs1
[499.093002] Dynamic subtest vcs1: SUCCESS (1.981s)
[499.104392] Starting dynamic subtest: vecs0
[501.139992] Dynamic subtest vecs0: SUCCESS (2.044s)
[501.150408] Starting dynamic subtest: ccs0
[501.708311] Dynamic subtest ccs0: SUCCESS (0.568s)
[501.709695] Subtest busy: SUCCESS (7.463s)
[501.831987] [129/133] (521s left) kms_psr (psr2-primary-mmap-cpu)
[501.944401] Starting subtest: psr2-primary-mmap-cpu
[501.946746] Starting dynamic subtest: eDP-1
[503.655705] Dynamic subtest eDP-1: SUCCESS (1.709s)
[503.656640] Subtest psr2-primary-mmap-cpu: SUCCESS (1.712s)
[504.545222] [130/133] (518s left) kms_vblank (wait-idle-hang)
[504.641745] Starting subtest: wait-idle-hang
[504.643860] Starting dynamic subtest: pipe-A-eDP-1
[530.907769] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.264s)
[530.917833] Starting dynamic subtest: pipe-D-eDP-1
[545.888648] Dynamic subtest pipe-D-eDP-1: SUCCESS (14.979s)
[545.890972] Subtest wait-idle-hang: SUCCESS (41.249s)
[546.715621] [131/133] (476s left) kms_scaling_modes (scaling-mode-full)
[546.808706] Starting subtest: scaling-mode-full
[546.809659] Starting dynamic subtest: pipe-A-eDP-1
[546.902746] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.094s)
[546.913327] Starting dynamic subtest: pipe-B-eDP-1
[548.022887] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.118s)
[548.033689] Starting dynamic subtest: pipe-C-eDP-1
[549.153925] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.129s)
[549.173126] Starting dynamic subtest: pipe-D-eDP-1
[550.316053] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.161s)
[550.316936] Subtest scaling-mode-full: SUCCESS (3.508s)
[551.547943] [132/133] (471s left) gem_wait (write-busy)
[551.613415] Starting subtest: write-busy
[551.614375] Starting dynamic subtest: all-engines
[552.229016] Dynamic subtest all-engines: SUCCESS (0.617s)
[552.248482] Starting dynamic subtest: rcs0
[552.783231] Dynamic subtest rcs0: SUCCESS (0.552s)
[552.799987] Starting dynamic subtest: bcs0
[553.332905] Dynamic subtest bcs0: SUCCESS (0.549s)
[553.347919] Starting dynamic subtest: vcs0
[555.091704] Dynamic subtest vcs0: SUCCESS (1.756s)
[555.106738] Starting dynamic subtest: vcs1
[557.140914] Dynamic subtest vcs1: SUCCESS (2.046s)
[557.155900] Starting dynamic subtest: vecs0
[559.124324] Dynamic subtest vecs0: SUCCESS (1.981s)
[559.139901] Starting dynamic subtest: ccs0
[559.673119] Dynamic subtest ccs0: SUCCESS (0.549s)
[559.674229] Subtest write-busy: SUCCESS (8.062s)
[559.875810] [133/133] (463s left) gem_exec_flush (basic-wb-rw-before-default)
[559.958672] Starting subtest: basic-wb-rw-before-default
[565.450090] Subtest basic-wb-rw-before-default: SUCCESS (5.491s)
[565.651695] Closing watchdogs
results: parsing output: 0/ for test: kms_frontbuffer_tracking
results: parsing output: 1/ for test: syncobj_wait
results: parsing output: 2/ for test: kms_frontbuffer_tracking
results: parsing output: 3/ for test: gem_wait
results: parsing output: 4/ for test: kms_flip
results: parsing output: 5/ for test: gem_pxp
results: parsing output: 6/ for test: kms_big_fb
results: parsing output: 7/ for test: kms_chamelium_edid
results: parsing output: 8/ for test: syncobj_wait
results: parsing output: 9/ for test: kms_big_fb
results: parsing output: 10/ for test: kms_big_fb
results: parsing output: 11/ for test: gem_ctx_persistence
results: parsing output: 12/ for test: kms_flip_scaled_crc
results: parsing output: 13/ for test: perf
results: parsing output: 14/ for test: kms_cursor_legacy
results: parsing output: 15/ for test: syncobj_wait
results: parsing output: 16/ for test: kms_frontbuffer_tracking
results: parsing output: 17/ for test: kms_frontbuffer_tracking
results: parsing output: 18/ for test: kms_plane
results: parsing output: 19/ for test: kms_flip
results: parsing output: 20/ for test: kms_psr
results: parsing output: 21/ for test: kms_frontbuffer_tracking
results: parsing output: 22/ for test: kms_frontbuffer_tracking
results: parsing output: 23/ for test: i915_drm_fdinfo
results: parsing output: 24/ for test: dmabuf_sync_file
results: parsing output: 25/ for test: syncobj_timeline
results: parsing output: 26/ for test: kms_cursor_legacy
results: parsing output: 27/ for test: gem_render_copy
results: parsing output: 28/ for test: kms_lease
results: parsing output: 29/ for test: kms_chamelium_audio
results: parsing output: 30/ for test: prime_vgem
results: parsing output: 31/ for test: perf
results: parsing output: 32/ for test: kms_sequence
results: parsing output: 33/ for test: kms_ccs
results: parsing output: 34/ for test: gem_exec_reloc
results: parsing output: 35/ for test: i915_pm_rps
results: parsing output: 36/ for test: perf
results: parsing output: 37/ for test: perf
results: parsing output: 38/ for test: kms_atomic
results: parsing output: 39/ for test: kms_frontbuffer_tracking
results: parsing output: 40/ for test: kms_big_fb
results: parsing output: 41/ for test: kms_psr2_sf
results: parsing output: 42/ for test: kms_psr2_sf
results: parsing output: 43/ for test: kms_pm_rpm
results: parsing output: 44/ for test: kms_atomic_transition
results: parsing output: 45/ for test: i915_drm_fdinfo
results: parsing output: 46/ for test: kms_addfb_basic
results: parsing output: 47/ for test: gem_exec_schedule
results: parsing output: 48/ for test: kms_plane_scaling
results: parsing output: 49/ for test: kms_frontbuffer_tracking
results: parsing output: 50/ for test: kms_big_fb
results: parsing output: 51/ for test: sysfs_timeslice_duration
results: parsing output: 52/ for test: perf
results: parsing output: 53/ for test: kms_frontbuffer_tracking
results: parsing output: 54/ for test: gem_eio
results: parsing output: 55/ for test: gem_ctx_engines
results: parsing output: 56/ for test: kms_frontbuffer_tracking
results: parsing output: 57/ for test: gem_eio
results: parsing output: 58/ for test: gem_exec_fence
results: parsing output: 59/ for test: gem_exec_fence
results: parsing output: 60/ for test: syncobj_timeline
results: parsing output: 61/ for test: syncobj_timeline
results: parsing output: 62/ for test: gem_partial_pwrite_pread
results: parsing output: 63/ for test: kms_cursor_crc
results: parsing output: 64/ for test: kms_fbcon_fbt
results: parsing output: 65/ for test: kms_plane_alpha_blend
results: parsing output: 66/ for test: gem_exec_whisper
results: parsing output: 67/ for test: gem_spin_batch
results: parsing output: 68/ for test: kms_pwrite_crc
results: parsing output: 69/ for test: kms_ccs
results: parsing output: 70/ for test: kms_flip_scaled_crc
results: parsing output: 71/ for test: api_intel_bb
results: parsing output: 72/ for test: kms_big_fb
results: parsing output: 73/ for test: gem_render_copy
results: parsing output: 74/ for test: syncobj_timeline
results: parsing output: 75/ for test: kms_frontbuffer_tracking
results: parsing output: 76/ for test: syncobj_wait
results: parsing output: 77/ for test: kms_ccs
results: parsing output: 78/ for test: syncobj_timeline
results: parsing output: 79/ for test: gem_exec_fence
results: parsing output: 80/ for test: gem_mmap_offset
results: parsing output: 81/ for test: kms_frontbuffer_tracking
results: parsing output: 82/ for test: gen9_exec_parse
results: parsing output: 83/ for test: kms_cursor_crc
results: parsing output: 84/ for test: kms_content_protection
results: parsing output: 85/ for test: vgem_basic
results: parsing output: 86/ for test: kms_invalid_mode
results: parsing output: 87/ for test: kms_pm_rpm
results: parsing output: 88/ for test: gem_exec_whisper
results: parsing output: 89/ for test: kms_frontbuffer_tracking
results: parsing output: 90/ for test: gem_busy
results: parsing output: 91/ for test: gem_exec_params
results: parsing output: 92/ for test: kms_psr
results: parsing output: 93/ for test: kms_psr
results: parsing output: 94/ for test: perf_pmu
results: parsing output: 95/ for test: gem_exec_flush
results: parsing output: 96/ for test: kms_flip
results: parsing output: 97/ for test: i915_pm_rpm
results: parsing output: 98/ for test: kms_color_pipeline
results: parsing output: 99/ for test: gem_exec_params
results: parsing output: 100/ for test: gem_mmap_gtt
results: parsing output: 101/ for test: kms_frontbuffer_tracking
results: parsing output: 102/ for test: prime_mmap
results: parsing output: 103/ for test: kms_cursor_crc
results: parsing output: 104/ for test: kms_draw_crc
results: parsing output: 105/ for test: gem_ctx_create
results: parsing output: 106/ for test: kms_plane_scaling
results: parsing output: 107/ for test: kms_ccs
results: parsing output: 108/ for test: kms_frontbuffer_tracking
results: parsing output: 109/ for test: gem_ctx_param
results: parsing output: 110/ for test: gem_exec_schedule
results: parsing output: 111/ for test: api_intel_bb
results: parsing output: 112/ for test: kms_big_fb
results: parsing output: 113/ for test: kms_chamelium_hpd
results: parsing output: 114/ for test: kms_frontbuffer_tracking
results: parsing output: 115/ for test: kms_plane
results: parsing output: 116/ for test: gem_exec_balancer
results: parsing output: 117/ for test: gem_mmap_gtt
results: parsing output: 118/ for test: gem_pread
results: parsing output: 119/ for test: kms_frontbuffer_tracking
results: parsing output: 120/ for test: kms_dp_link_training
results: parsing output: 121/ for test: kms_frontbuffer_tracking
results: parsing output: 122/ for test: gem_mmap_gtt
results: parsing output: 123/ for test: syncobj_wait
results: parsing output: 124/ for test: kms_psr
results: parsing output: 125/ for test: kms_frontbuffer_tracking
results: parsing output: 126/ for test: gem_mmap_gtt
results: parsing output: 127/ for test: perf_pmu
results: parsing output: 128/ for test: kms_psr
results: parsing output: 129/ for test: kms_vblank
results: parsing output: 130/ for test: kms_scaling_modes
results: parsing output: 131/ for test: gem_wait
results: parsing output: 132/ for test: gem_exec_flush
Done.