[56.989739] Initializing watchdogs
[56.989787]   /dev/watchdog0
[57.004676] [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.009590] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[57.011844] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[57.015083] [001/133] (960s left) kms_getfb (getfb2-handle-protection)
[57.150247] Starting subtest: getfb2-handle-protection
[57.181540] Subtest getfb2-handle-protection: SUCCESS (0.032s)
[57.314502] [002/133] (960s left) gem_ctx_persistence (smoketest)
[57.380835] Starting subtest: smoketest
[97.907839] Subtest smoketest: SUCCESS (40.500s)
[97.996075] [003/133] (919s left) kms_cursor_edge_walk (64x64-top-bottom)
[98.084131] Starting subtest: 64x64-top-bottom
[98.086527] Starting dynamic subtest: pipe-A-eDP-1
[101.560662] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.477s)
[101.569271] Starting dynamic subtest: pipe-D-eDP-1
[104.675177] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.113s)
[104.677431] Subtest 64x64-top-bottom: SUCCESS (6.592s)
[105.498600] [004/133] (912s left) sysfs_timeslice_duration (duration)
[105.558318] Starting subtest: duration
[105.560808] Starting dynamic subtest: vecs0
[119.796726] Dynamic subtest vecs0: SUCCESS (14.233s)
[119.807259] Starting dynamic subtest: ccs0
[132.974527] Dynamic subtest ccs0: SUCCESS (13.178s)
[132.984302] Starting dynamic subtest: vcs0
[147.827803] Dynamic subtest vcs0: SUCCESS (14.850s)
[147.837885] Starting dynamic subtest: bcs0
[160.963620] Dynamic subtest bcs0: SUCCESS (13.135s)
[160.974109] Starting dynamic subtest: rcs0
[174.116606] Dynamic subtest rcs0: SUCCESS (13.151s)
[174.126091] Starting dynamic subtest: vcs1
[187.893042] Dynamic subtest vcs1: SUCCESS (13.772s)
[187.896303] Subtest duration: SUCCESS (82.328s)
[187.976956] [005/133] (829s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-mmap-wc)
[188.096556] Starting subtest: fbcpsr-rgb565-draw-mmap-wc
[194.834822] Subtest fbcpsr-rgb565-draw-mmap-wc: SUCCESS (6.740s)
[194.982312] [006/133] (822s left) kms_ccs (crc-primary-basic-4-tiled-bmg-ccs)
[195.095105] Starting subtest: crc-primary-basic-4-tiled-bmg-ccs
[195.099736] Subtest crc-primary-basic-4-tiled-bmg-ccs: SKIP (0.000s)
[196.255359] [007/133] (821s left) kms_atomic_transition (plane-all-modeset-transition-fencing)
[196.351409] Starting subtest: plane-all-modeset-transition-fencing
[196.355385] Subtest plane-all-modeset-transition-fencing: SKIP (0.000s)
[196.438341] [008/133] (821s left) gem_mmap_gtt (cpuset-big-copy-xy)
[196.497512] Subtest cpuset-big-copy-XY: SKIP (0.000s)
[196.562324] [009/133] (821s left) i915_hangman (error-state-basic)
[196.634495] Starting subtest: error-state-basic
[196.745590] Subtest error-state-basic: SUCCESS (0.112s)
[196.829655] [010/133] (821s left) kms_cursor_crc (cursor-offscreen-32x32)
[196.977740] Starting subtest: cursor-offscreen-32x32
[197.024170] Subtest cursor-offscreen-32x32: SKIP (0.041s)
[197.331641] [011/133] (820s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence)
[197.433047] Starting subtest: nonblocking-crc-frame-sequence
[197.435058] Starting dynamic subtest: pipe-A-eDP-1
[198.170489] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.735s)
[198.179398] Starting dynamic subtest: pipe-B-eDP-1
[199.533928] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.364s)
[199.543455] Starting dynamic subtest: pipe-C-eDP-1
[200.939318] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.402s)
[200.948757] Starting dynamic subtest: pipe-D-eDP-1
[202.311457] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.372s)
[202.313714] Subtest nonblocking-crc-frame-sequence: SUCCESS (4.878s)
[203.188353] [012/133] (814s left) perf (oa-formats)
[203.322674] Starting subtest: oa-formats
[203.324986] Starting dynamic subtest: 0-rcs0
[203.337076] Dynamic subtest 0-rcs0: SUCCESS (0.015s)
[203.344442] Starting dynamic subtest: 1-vecs0
[203.358811] Dynamic subtest 1-vecs0: SUCCESS (0.021s)
[203.361063] Subtest oa-formats: SUCCESS (0.037s)
[203.404793] [013/133] (814s left) syncobj_wait (wait-delayed-signal)
[203.464975] Starting subtest: wait-delayed-signal
[203.567060] Subtest wait-delayed-signal: SUCCESS (0.102s)
[203.655151] [014/133] (814s left) kms_psr2_sf (pr-overlay-plane-move-continuous-sf)
[203.751542] Starting subtest: pr-overlay-plane-move-continuous-sf
[203.755811] Subtest pr-overlay-plane-move-continuous-sf: SKIP (0.000s)
[203.825830] [015/133] (814s left) kms_big_fb (x-tiled-addfb-size-offset-overflow)
[203.939701] Starting subtest: x-tiled-addfb-size-offset-overflow
[203.941938] Subtest x-tiled-addfb-size-offset-overflow: SUCCESS (0.000s)
[204.086206] [016/133] (813s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-mmap-wc)
[204.191394] Starting subtest: psr-2p-primscrn-cur-indfb-draw-mmap-wc
[204.195323] Subtest psr-2p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[204.318610] [017/133] (813s left) gem_workarounds (reset-fd)
[204.387673] Starting subtest: reset-fd
[204.541170] Subtest reset-fd: SUCCESS (0.153s)
[204.670158] [018/133] (813s left) gem_exec_schedule (u-semaphore-resolve)
[204.743621] Starting subtest: u-semaphore-resolve
[204.774173] Subtest u-semaphore-resolve: SUCCESS (0.036s)
[205.126829] [019/133] (813s left) gem_userptr_blits (sync-unmap-after-close)
[205.197064] Starting subtest: sync-unmap-after-close
[205.204619] Subtest sync-unmap-after-close: SUCCESS (0.011s)
[205.342170] [020/133] (812s left) kms_invalid_mode (zero-vdisplay)
[205.438040] Starting subtest: zero-vdisplay
[205.440217] Starting dynamic subtest: pipe-A-eDP-1
[205.720548] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.285s)
[205.729933] Starting dynamic subtest: pipe-B-eDP-1
[205.732292] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[205.739674] Starting dynamic subtest: pipe-C-eDP-1
[205.742105] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[205.749673] Starting dynamic subtest: pipe-D-eDP-1
[205.751969] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[205.754316] Subtest zero-vdisplay: SUCCESS (0.289s)
[206.531099] [021/133] (811s left) kms_setmode (basic-clone-single-crtc)
[206.583204] Starting subtest: basic-clone-single-crtc
[206.590224] Subtest basic-clone-single-crtc: SKIP (0.000s)
[206.698427] [022/133] (811s left) kms_flip (flip-vs-suspend)
[206.784328] Starting subtest: flip-vs-suspend
[206.786616] Starting dynamic subtest: A-eDP1
[240.693709] Dynamic subtest A-eDP1: SUCCESS (4.330s)
[240.702633] Starting dynamic subtest: B-eDP1
[274.698829] Dynamic subtest B-eDP1: SUCCESS (4.182s)
[274.709830] Starting dynamic subtest: C-eDP1
[308.693267] Dynamic subtest C-eDP1: SUCCESS (4.224s)
[308.706979] Starting dynamic subtest: D-eDP1
[342.704050] Dynamic subtest D-eDP1: SUCCESS (4.196s)
[342.708638] Subtest flip-vs-suspend: SUCCESS (16.940s)
[352.911174] [023/133] (674s left) kms_rotation_crc (primary-4-tiled-reflect-x-180)
[353.024722] Starting subtest: primary-4-tiled-reflect-x-180
[360.082257] Subtest primary-4-tiled-reflect-x-180: SUCCESS (7.001s)
[361.336111] [024/133] (666s left) core_setmaster (master-drop-set-shared-fd)
[361.419054] Starting subtest: master-drop-set-shared-fd
[361.440803] Subtest master-drop-set-shared-fd: SUCCESS (0.022s)
[361.478859] [025/133] (665s left) kms_chamelium_hpd (vga-hpd-for-each-pipe)
[361.866585] Subtest vga-hpd-for-each-pipe: SKIP (0.000s)
[362.646903] [026/133] (664s left) kms_pm_rpm (cursor)
[364.177907] Starting subtest: cursor
[364.183109] Subtest cursor: SKIP (0.000s)
[364.937245] [027/133] (662s left) gem_exec_store (dword)
[365.010496] Starting subtest: dword
[365.012855] Starting dynamic subtest: rcs0
[365.125075] Dynamic subtest rcs0: SUCCESS (0.114s)
[365.136813] Starting dynamic subtest: bcs0
[365.169333] Dynamic subtest bcs0: SUCCESS (0.042s)
[365.179627] Starting dynamic subtest: vcs0
[365.210979] Dynamic subtest vcs0: SUCCESS (0.040s)
[365.221281] Starting dynamic subtest: vcs1
[365.252001] Dynamic subtest vcs1: SUCCESS (0.039s)
[365.261958] Starting dynamic subtest: vecs0
[365.293938] Dynamic subtest vecs0: SUCCESS (0.040s)
[365.303730] Starting dynamic subtest: ccs0
[365.335164] Dynamic subtest ccs0: SUCCESS (0.040s)
[365.337523] Subtest dword: SUCCESS (0.326s)
[365.531812] [028/133] (662s left) kms_big_fb (x-tiled-16bpp-rotate-0)
[365.635166] Starting subtest: x-tiled-16bpp-rotate-0
[366.861371] Subtest x-tiled-16bpp-rotate-0: SUCCESS (1.223s)
[367.020737] [029/133] (660s left) kms_flip (2x-blocking-absolute-wf_vblank-interruptible)
[367.121805] Starting subtest: 2x-blocking-absolute-wf_vblank-interruptible
[367.133364] Subtest 2x-blocking-absolute-wf_vblank-interruptible: SKIP (0.011s)
[367.218854] [030/133] (660s left) kms_frontbuffer_tracking (psr-1p-primscrn-indfb-plflip-blt)
[367.318897] Starting subtest: psr-1p-primscrn-indfb-plflip-blt
[374.818337] Subtest psr-1p-primscrn-indfb-plflip-blt: SUCCESS (7.488s)
[374.953987] [031/133] (652s left) api_intel_allocator (default-alignment)
[375.007846] Starting subtest: default-alignment
[375.010111] Subtest default-alignment: SUCCESS (0.003s)
[375.122216] [032/133] (652s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytilercccs-downscaling)
[375.211060] Starting subtest: flip-64bpp-ytile-to-32bpp-ytilercccs-downscaling
[375.215455] Subtest flip-64bpp-ytile-to-32bpp-ytilercccs-downscaling: SKIP (0.000s)
[375.305228] [033/133] (652s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip)
[375.416780] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip
[376.052322] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SUCCESS (0.637s)
[376.252178] [034/133] (651s left) gen9_exec_parse (valid-registers)
[376.318440] Subtest valid-registers: SKIP (0.000s)
[376.412913] [035/133] (651s left) kms_feature_discovery (chamelium)
[376.509941] Starting subtest: chamelium
[376.514539] Subtest chamelium: SKIP (0.000s)
[376.608121] [036/133] (651s left) perf (whitelisted-registers-userspace-config)
[376.722378] Starting subtest: whitelisted-registers-userspace-config
[376.724749] Subtest whitelisted-registers-userspace-config: SUCCESS (0.001s)
[376.761418] [037/133] (651s left) kms_pm_rpm (legacy-planes)
[379.102807] Starting subtest: legacy-planes
[379.104974] Starting dynamic subtest: plane-64
[387.504527] Dynamic subtest plane-64: SUCCESS (8.398s)
[387.515778] Starting dynamic subtest: plane-94
[395.766579] Dynamic subtest plane-94: SUCCESS (8.254s)
[395.778251] Starting dynamic subtest: plane-124
[404.380518] Dynamic subtest plane-124: SUCCESS (8.608s)
[404.391383] Starting dynamic subtest: plane-134
[412.658795] Dynamic subtest plane-134: SUCCESS (8.272s)
[412.661570] Subtest legacy-planes: SUCCESS (33.541s)
[413.050100] [038/133] (614s left) syncobj_wait (multi-wait-all-for-submit-unsubmitted)
[413.125672] Starting subtest: multi-wait-all-for-submit-unsubmitted
[413.227929] Subtest multi-wait-all-for-submit-unsubmitted: SUCCESS (0.102s)
[413.329715] [039/133] (614s left) kms_big_fb (y-tiled-8bpp-rotate-0)
[413.447240] Starting subtest: y-tiled-8bpp-rotate-0
[413.451794] Subtest y-tiled-8bpp-rotate-0: SKIP (0.000s)
[413.585953] [040/133] (614s left) syncobj_timeline (multi-wait-for-submit-available-unsubmitted-submitted-signa
[413.648634] Starting subtest: multi-wait-for-submit-available-unsubmitted-submitted-signaled
[413.650972] Subtest multi-wait-for-submit-available-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[413.754245] [041/133] (614s left) kms_content_protection (dp-mst-lic-type-0-hdcp14)
[413.905141] Starting subtest: dp-mst-lic-type-0-hdcp14
[413.909918] Subtest dp-mst-lic-type-0-hdcp14: SKIP (0.000s)
[414.070752] [042/133] (614s left) kms_async_flips (test-cursor)
[414.169356] Starting subtest: test-cursor
[414.173506] Subtest test-cursor: SKIP (0.000s)
[415.402368] [043/133] (612s left) kms_setmode (invalid-clone-single-crtc)
[415.470650] Starting subtest: invalid-clone-single-crtc
[415.477399] Subtest invalid-clone-single-crtc: SKIP (0.000s)
[415.609389] [044/133] (612s left) syncobj_timeline (invalid-multi-wait-all-unsubmitted-signaled)
[415.672277] Starting subtest: invalid-multi-wait-all-unsubmitted-signaled
[415.674477] Subtest invalid-multi-wait-all-unsubmitted-signaled: SUCCESS (0.000s)
[415.778596] [045/133] (612s left) gem_unfence_active_buffers
[415.947732] [046/133] (612s left) gem_pxp (verify-pxp-stale-ctx-execution)
[416.066573] Starting subtest: verify-pxp-stale-ctx-execution
[417.128567] Subtest verify-pxp-stale-ctx-execution: SUCCESS (1.060s)
[417.288306] [047/133] (611s left) kms_pipe_b_c_ivb (disable-pipe-b-enable-pipe-c)
[417.356162] Subtest disable-pipe-B-enable-pipe-C: SKIP (0.000s)
[417.426854] [048/133] (610s left) perf (sysctl-defaults)
[417.497675] Starting subtest: sysctl-defaults
[417.499467] Subtest sysctl-defaults: SUCCESS (0.000s)
[417.557056] [049/133] (610s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-pwrite)
[417.662517] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-pwrite
[417.667017] Subtest fbc-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[417.789707] [050/133] (610s left) gem_create (create-clear)
[417.854309] Starting subtest: create-clear
[417.856611] Starting dynamic subtest: smem0
[450.705455] Dynamic subtest smem0: SUCCESS (32.836s)
[450.707389] Subtest create-clear: SUCCESS (32.838s)
[450.908298] [051/133] (577s left) syncobj_wait (invalid-signal-zero-handles)
[450.959081] Starting subtest: invalid-signal-zero-handles
[450.961414] Subtest invalid-signal-zero-handles: SUCCESS (0.000s)
[451.054983] [052/133] (577s left) syncobj_wait (multi-wait-all-for-submit-unsubmitted-signaled)
[451.110598] Starting subtest: multi-wait-all-for-submit-unsubmitted-signaled
[451.219947] Subtest multi-wait-all-for-submit-unsubmitted-signaled: SUCCESS (0.107s)
[451.328641] [053/133] (577s left) gem_exec_reloc (basic-range)
[451.377455] Subtest basic-range: SKIP (0.000s)
[451.460439] [054/133] (577s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-blt)
[451.575242] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-blt
[451.579308] Subtest psr-2p-scndscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[451.699613] [055/133] (577s left) kms_psr (fbc-psr-sprite-render)
[451.791040] Starting subtest: fbc-psr-sprite-render
[451.793259] Starting dynamic subtest: eDP-1
[451.797243] Dynamic subtest eDP-1: SKIP (0.000s)
[451.801274] Subtest fbc-psr-sprite-render: SKIP (0.001s)
[451.873510] [056/133] (576s left) syncobj_wait (signal)
[451.936982] Starting subtest: signal
[451.939346] Subtest signal: SUCCESS (0.000s)
[452.063291] [057/133] (576s left) kms_frontbuffer_tracking (fbc-shrfb-scaledprimary)
[452.168400] Starting subtest: fbc-shrfb-scaledprimary
[455.186497] Subtest fbc-shrfb-scaledprimary: SUCCESS (3.023s)
[456.387886] [058/133] (572s left) kms_cursor_crc (cursor-size-change)
[456.481834] Starting subtest: cursor-size-change
[456.484136] Starting dynamic subtest: pipe-A-eDP-1
[457.282082] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.799s)
[457.291269] Starting dynamic subtest: pipe-D-eDP-1
[458.704533] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.421s)
[458.706814] Subtest cursor-size-change: SUCCESS (2.223s)
[459.534738] [059/133] (569s left) kms_addfb_basic (addfb25-y-tiled-legacy)
[459.635949] Starting subtest: addfb25-y-tiled-legacy
[459.638261] Subtest addfb25-y-tiled-legacy: SUCCESS (0.000s)
[459.757227] [060/133] (569s left) i915_query (query-regions-sanity-check)
[459.818228] Starting subtest: query-regions-sanity-check
[459.829509] Subtest query-regions-sanity-check: SUCCESS (0.013s)
[459.991320] [061/133] (568s left) gem_render_copy (y-tiled-ccs-to-linear)
[460.052166] Starting subtest: y-tiled-ccs-to-linear
[460.056826] Subtest y-tiled-ccs-to-linear: SKIP (0.000s)
[460.246990] [062/133] (568s left) gem_exec_fence (long-history)
[460.737987] Starting subtest: long-history
[467.622421] Subtest long-history: SUCCESS (6.887s)
[469.536335] [FACT gem_exec_fence (long-history)] new: kernel.kmod_is_loaded.vgem: true
[469.539576] [063/133] (559s left) kms_vblank (query-forked-hang)
[469.650956] Starting subtest: query-forked-hang
[469.653212] Starting dynamic subtest: pipe-A-eDP-1
[495.712129] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.060s)
[495.727275] Starting dynamic subtest: pipe-D-eDP-1
[520.686629] Dynamic subtest pipe-D-eDP-1: SUCCESS (24.970s)
[520.689409] Subtest query-forked-hang: SUCCESS (51.034s)
[521.578728] [064/133] (507s left) gem_softpin (evict-prime-sanity-check)
[521.638289] Starting subtest: evict-prime-sanity-check
[521.640740] Starting dynamic subtest: rcs0
[522.812422] Dynamic subtest rcs0: SUCCESS (1.173s)
[522.823037] Starting dynamic subtest: bcs0
[523.973798] Dynamic subtest bcs0: SUCCESS (1.159s)
[523.984397] Starting dynamic subtest: vcs0
[525.878693] Dynamic subtest vcs0: SUCCESS (1.900s)
[525.890604] Starting dynamic subtest: vcs1
[527.821604] Dynamic subtest vcs1: SUCCESS (1.940s)
[527.833077] Starting dynamic subtest: vecs0
[529.869257] Dynamic subtest vecs0: SUCCESS (2.045s)
[529.881005] Starting dynamic subtest: ccs0
[531.041164] Dynamic subtest ccs0: SUCCESS (1.170s)
[531.052068] Starting dynamic subtest: all
[532.190450] Dynamic subtest all: SUCCESS (1.146s)
[532.193183] Subtest evict-prime-sanity-check: SUCCESS (10.550s)
[532.297960] [065/133] (496s left) sw_sync (sync_busy)
[532.343095] Starting subtest: sync_busy
[532.345582] Subtest sync_busy: SUCCESS (0.003s)
[532.436051] [066/133] (496s left) kms_cursor_crc (cursor-rapid-movement-256x256)
[532.674199] Starting subtest: cursor-rapid-movement-256x256
[532.679053] Starting dynamic subtest: pipe-A-eDP-1
[533.218838] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.540s)
[533.253041] Starting dynamic subtest: pipe-D-eDP-1
[534.401957] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.160s)
[534.404128] Subtest cursor-rapid-movement-256x256: SUCCESS (1.725s)
[535.259798] [067/133] (493s left) kms_chamelium_edid (dp-edid-change-during-suspend)
[535.632796] Subtest dp-edid-change-during-suspend: SKIP (0.000s)
[536.451318] [068/133] (492s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-mmap-cpu)
[536.547650] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-mmap-cpu
[543.127166] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-mmap-cpu: SUCCESS (6.580s)
[543.299426] [069/133] (485s left) perf_pmu (busy-idle)
[543.341650] Starting subtest: busy-idle
[543.343761] Starting dynamic subtest: rcs0
[544.049557] Dynamic subtest rcs0: SUCCESS (0.708s)
[544.061430] Starting dynamic subtest: bcs0
[544.721691] Dynamic subtest bcs0: SUCCESS (0.669s)
[544.733346] Starting dynamic subtest: vcs0
[545.887115] Dynamic subtest vcs0: SUCCESS (1.161s)
[545.898727] Starting dynamic subtest: vcs1
[547.872116] Dynamic subtest vcs1: SUCCESS (1.981s)
[547.884374] Starting dynamic subtest: vecs0
[549.919645] Dynamic subtest vecs0: SUCCESS (2.044s)
[549.931687] Starting dynamic subtest: ccs0
[550.585214] Dynamic subtest ccs0: SUCCESS (0.664s)
[550.587744] Subtest busy-idle: SUCCESS (7.243s)
[550.733924] [070/133] (478s left) gem_userptr_blits (invalid-mmap-offset-unsync)
[550.810471] Subtest invalid-mmap-offset-unsync: SKIP (0.000s)
[550.961743] [071/133] (478s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-blt)
[551.082458] Starting subtest: psr-2p-primscrn-pri-indfb-draw-blt
[551.086506] Subtest psr-2p-primscrn-pri-indfb-draw-blt: SKIP (0.000s)
[551.191842] [072/133] (478s left) prime_busy (hang)
[551.256941] Starting subtest: hang
[551.259184] Starting dynamic subtest: rcs0
[577.415343] Dynamic subtest rcs0: SUCCESS (26.147s)
[577.426272] Starting dynamic subtest: bcs0
[584.553938] Dynamic subtest bcs0: SUCCESS (7.142s)
[584.563525] Starting dynamic subtest: vcs0
[591.532926] Dynamic subtest vcs0: SUCCESS (6.977s)
[591.544062] Starting dynamic subtest: vcs1
[598.572127] Dynamic subtest vcs1: SUCCESS (7.039s)
[598.583102] Starting dynamic subtest: vecs0
[605.545217] Dynamic subtest vecs0: SUCCESS (6.977s)
[605.556966] Starting dynamic subtest: ccs0
[619.384928] Dynamic subtest ccs0: SUCCESS (13.836s)
[619.387031] Subtest hang: SUCCESS (68.125s)
[619.513622] [073/133] (409s left) kms_frontbuffer_tracking (psr-rgb101010-draw-mmap-cpu)
[619.615408] Starting subtest: psr-rgb101010-draw-mmap-cpu
[626.683222] Subtest psr-rgb101010-draw-mmap-cpu: SUCCESS (7.069s)
[626.821052] [074/133] (402s left) syncobj_timeline (single-wait-all-for-submit-available-signaled)
[626.887228] Starting subtest: single-wait-all-for-submit-available-signaled
[626.889628] Subtest single-wait-all-for-submit-available-signaled: SUCCESS (0.000s)
[626.994314] [075/133] (402s left) kms_getfb (getfb-handle-not-fb)
[627.098952] Starting subtest: getfb-handle-not-fb
[627.101314] Subtest getfb-handle-not-fb: SUCCESS (0.000s)
[627.231288] [076/133] (402s left) kms_plane (plane-panning-bottom-right-suspend)
[627.323040] Starting subtest: plane-panning-bottom-right-suspend
[627.325390] Starting dynamic subtest: pipe-A
[645.094651] Dynamic subtest pipe-A: SUCCESS (3.292s)
[645.105236] Starting dynamic subtest: pipe-B
[664.084031] Dynamic subtest pipe-B: SUCCESS (3.906s)
[664.086577] Subtest plane-panning-bottom-right-suspend: SUCCESS (7.201s)
[675.910449] [077/133] (364s left) gem_userptr_blits (stress-mm-invalidate-close-overlap)
[675.987100] Starting subtest: stress-mm-invalidate-close-overlap
[678.152720] Subtest stress-mm-invalidate-close-overlap: SUCCESS (2.148s)
[678.319885] [078/133] (362s left) fbdev (read)
[678.367240] Starting subtest: read
[678.901437] Subtest read: SUCCESS (0.526s)
[678.978353] [079/133] (361s left) kms_chamelium_color (ctm-0-75)
[679.089476] Subtest ctm-0-75: SKIP (0.000s)
[679.138400] [080/133] (361s left) gem_ctx_shared (disjoint-timelines)
[679.192896] Starting subtest: disjoint-timelines
[679.233270] Subtest disjoint-timelines: SUCCESS (0.037s)
[679.523346] [081/133] (361s left) gem_ppgtt (shrink-vs-evict-pinned)
[679.581900] Starting subtest: shrink-vs-evict-pinned
[687.441481] Subtest shrink-vs-evict-pinned: SUCCESS (7.805s)
[687.559145] [082/133] (353s left) kms_frontbuffer_tracking (fbc-2p-primscrn-shrfb-msflip-blt)
[687.670167] Starting subtest: fbc-2p-primscrn-shrfb-msflip-blt
[687.675653] Subtest fbc-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[687.782042] [083/133] (353s left) perf (gen12-oa-tlb-invalidate)
[687.873216] Starting subtest: gen12-oa-tlb-invalidate
[687.876214] Starting dynamic subtest: 0-rcs0
[697.892763] Dynamic subtest 0-rcs0: SUCCESS (9.994s)
[697.904284] Starting dynamic subtest: 1-vcs1
[707.953233] Dynamic subtest 1-vcs1: SUCCESS (10.049s)
[707.956287] Subtest gen12-oa-tlb-invalidate: SUCCESS (20.046s)
[708.005711] [084/133] (332s left) kms_ccs (crc-primary-rotation-180-y-tiled-gen12-mc-ccs)
[708.093083] Starting subtest: crc-primary-rotation-180-y-tiled-gen12-mc-ccs
[708.095887] Starting dynamic subtest: pipe-A-eDP-1
[708.122010] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[708.132358] Starting dynamic subtest: pipe-B-eDP-1
[708.158712] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[708.168866] Starting dynamic subtest: pipe-C-eDP-1
[708.195057] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[708.204725] Starting dynamic subtest: pipe-D-eDP-1
[708.231425] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[708.236208] Subtest crc-primary-rotation-180-y-tiled-gen12-mc-ccs: SKIP (0.006s)
[710.363906] [085/133] (330s left) gem_exec_schedule (noreorder-priority)
[710.552428] Starting subtest: noreorder-priority
[710.554922] Starting dynamic subtest: rcs0
[711.709222] Dynamic subtest rcs0: SUCCESS (1.159s)
[711.722092] Starting dynamic subtest: vcs0
[713.413681] Dynamic subtest vcs0: SUCCESS (1.701s)
[713.427304] Starting dynamic subtest: vcs1
[715.507977] Dynamic subtest vcs1: SUCCESS (2.091s)
[715.521246] Starting dynamic subtest: vecs0
[717.493755] Dynamic subtest vecs0: SUCCESS (1.984s)
[717.510869] Starting dynamic subtest: ccs0
[718.675143] Dynamic subtest ccs0: SUCCESS (1.179s)
[718.678211] Subtest noreorder-priority: SUCCESS (8.128s)
[718.876581] [086/133] (322s left) gem_mmap_wc (fault-concurrent)
[718.947392] Subtest fault-concurrent: SKIP (0.000s)
[719.010104] [087/133] (322s left) gen9_exec_parse (batch-invalid-length)
[719.077043] Subtest batch-invalid-length: SKIP (0.000s)
[719.146792] [088/133] (322s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180-async-flip)
[719.257364] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180-async-flip
[720.025780] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SUCCESS (0.770s)
[720.205693] [089/133] (321s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip)
[720.309264] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip
[720.314874] Subtest y-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SKIP (0.000s)
[720.442607] [090/133] (320s left) kms_universal_plane (universal-plane-pageflip-windowed)
[720.534672] Starting subtest: universal-plane-pageflip-windowed
[720.537287] Starting dynamic subtest: pipe-A-eDP-1
[721.117234] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.582s)
[721.129328] Starting dynamic subtest: pipe-B-eDP-1
[722.377230] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.259s)
[722.389063] Starting dynamic subtest: pipe-C-eDP-1
[723.588687] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.210s)
[723.600030] Starting dynamic subtest: pipe-D-eDP-1
[724.822828] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.231s)
[724.825463] Subtest universal-plane-pageflip-windowed: SUCCESS (4.288s)
[725.691417] [091/133] (315s left) syncobj_wait (multi-wait-for-submit-unsubmitted-submitted-signaled)
[725.749167] Starting subtest: multi-wait-for-submit-unsubmitted-submitted-signaled
[725.752056] Subtest multi-wait-for-submit-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[725.927937] [092/133] (315s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-mmap-cpu)
[726.035112] Starting subtest: fbc-rgb101010-draw-mmap-cpu
[730.662362] Subtest fbc-rgb101010-draw-mmap-cpu: SUCCESS (4.632s)
[731.868465] [093/133] (309s left) kms_cursor_legacy (2x-cursor-vs-flip-atomic)
[732.005938] Starting subtest: 2x-cursor-vs-flip-atomic
[732.010894] Subtest 2x-cursor-vs-flip-atomic: SKIP (0.001s)
[732.164131] [094/133] (309s left) drm_read (fault-buffer)
[732.308989] Starting subtest: fault-buffer
[732.311972] Subtest fault-buffer: SUCCESS (0.001s)
[732.450086] [095/133] (309s left) kms_psr (fbc-psr2-basic)
[732.546072] Starting subtest: fbc-psr2-basic
[732.549019] Starting dynamic subtest: eDP-1
[732.554025] Dynamic subtest eDP-1: SKIP (0.000s)
[732.559000] Subtest fbc-psr2-basic: SKIP (0.001s)
[732.644423] [096/133] (308s left) kms_ccs (bad-rotation-90-4-tiled-mtl-mc-ccs)
[732.735007] Starting subtest: bad-rotation-90-4-tiled-mtl-mc-ccs
[732.737769] Starting dynamic subtest: pipe-A-eDP-1
[733.153561] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.421s)
[733.165727] Starting dynamic subtest: pipe-B-eDP-1
[733.185929] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.003s)
[733.195460] Starting dynamic subtest: pipe-C-eDP-1
[733.215258] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.003s)
[733.224244] Starting dynamic subtest: pipe-D-eDP-1
[733.243926] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.004s)
[733.245894] Subtest bad-rotation-90-4-tiled-mtl-mc-ccs: SUCCESS (0.436s)
[735.429539] [097/133] (306s left) kms_psr2_sf (psr2-primary-plane-update-sf-dmg-area-big-fb)
[735.530748] Starting subtest: psr2-primary-plane-update-sf-dmg-area-big-fb
[735.533381] Starting dynamic subtest: pipe-A-eDP-1
[742.071793] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.545s)
[742.082964] Starting dynamic subtest: pipe-B-eDP-1
[749.045902] Dynamic subtest pipe-B-eDP-1: SUCCESS (6.967s)
[749.048256] Subtest psr2-primary-plane-update-sf-dmg-area-big-fb: SUCCESS (13.515s)
[749.907779] [098/133] (291s left) kms_cursor_legacy (cursorb-vs-flipa-atomic-transitions)
[750.039774] Starting subtest: cursorB-vs-flipA-atomic-transitions
[750.044376] Subtest cursorB-vs-flipA-atomic-transitions: SKIP (0.001s)
[750.197582] [099/133] (291s left) gem_exec_await (wide-all)
[750.411275] Starting subtest: wide-all
[773.376230] Subtest wide-all: SUCCESS (22.956s)
[773.594844] [100/133] (268s left) kms_rotation_crc (primary-rotation-180)
[773.749165] Starting subtest: primary-rotation-180
[781.133791] Subtest primary-rotation-180: SUCCESS (7.388s)
[782.400942] [101/133] (259s left) gem_mmap_offset (blt-coherency)
[782.470887] Starting subtest: blt-coherency
[782.476226] Subtest blt-coherency: SUCCESS (0.008s)
[782.635545] [102/133] (259s left) api_intel_bb (object-noreloc-keep-cache-simple)
[782.701141] Starting subtest: object-noreloc-keep-cache-simple
[782.703784] Subtest object-noreloc-keep-cache-simple: SUCCESS (0.006s)
[782.860915] [103/133] (259s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-blt)
[782.967045] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-blt
[786.769243] Subtest fbc-1p-primscrn-spr-indfb-draw-blt: SUCCESS (3.808s)
[787.927023] [104/133] (254s left) gem_sync (basic-store-all)
[788.009925] Starting subtest: basic-store-all
[791.114708] Subtest basic-store-all: SUCCESS (3.117s)
[791.318573] [105/133] (250s left) kms_ccs (crc-sprite-planes-basic-4-tiled-dg2-rc-ccs)
[791.413296] Starting subtest: crc-sprite-planes-basic-4-tiled-dg2-rc-ccs
[791.415709] Starting dynamic subtest: pipe-A-eDP-1
[791.474984] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[791.485237] Starting dynamic subtest: pipe-B-eDP-1
[791.551660] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[791.561860] Starting dynamic subtest: pipe-C-eDP-1
[791.628216] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[791.639247] Starting dynamic subtest: pipe-D-eDP-1
[791.706643] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[791.711524] Subtest crc-sprite-planes-basic-4-tiled-dg2-rc-ccs: SKIP (0.009s)
[793.593328] [106/133] (248s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-cpu)
[793.707605] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-cpu
[793.712848] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[793.844861] [107/133] (248s left) kms_frontbuffer_tracking (fbcpsr-2p-indfb-fliptrack-mmap-gtt)
[793.953231] Starting subtest: fbcpsr-2p-indfb-fliptrack-mmap-gtt
[793.958960] Subtest fbcpsr-2p-indfb-fliptrack-mmap-gtt: SKIP (0.000s)
[794.072676] [108/133] (248s left) kms_plane (pixel-format-yf-tiled-modifier-source-clamping)
[794.170188] Starting subtest: pixel-format-yf-tiled-modifier-source-clamping
[794.196447] Starting dynamic subtest: pipe-A-plane-0
[794.201655] Dynamic subtest pipe-A-plane-0: SKIP (0.000s)
[794.212804] Starting dynamic subtest: pipe-A-plane-3
[794.217820] Dynamic subtest pipe-A-plane-3: SKIP (0.000s)
[794.229135] Starting dynamic subtest: pipe-A-plane-5
[794.234536] Dynamic subtest pipe-A-plane-5: SKIP (0.000s)
[795.285053] Starting dynamic subtest: pipe-B-plane-0
[795.290223] Dynamic subtest pipe-B-plane-0: SKIP (0.000s)
[795.300361] Starting dynamic subtest: pipe-B-plane-3
[795.305996] Dynamic subtest pipe-B-plane-3: SKIP (0.000s)
[795.315908] Starting dynamic subtest: pipe-B-plane-5
[795.320795] Dynamic subtest pipe-B-plane-5: SKIP (0.000s)
[795.602051] Subtest pixel-format-yf-tiled-modifier-source-clamping: SKIP (1.430s)
[796.478405] [109/133] (245s left) gem_exec_fence (basic-busy)
[796.656195] Starting subtest: basic-busy
[796.658943] Starting dynamic subtest: rcs0
[796.753260] Dynamic subtest rcs0: SUCCESS (0.097s)
[796.765562] Starting dynamic subtest: bcs0
[796.815369] Dynamic subtest bcs0: SUCCESS (0.060s)
[796.827249] Starting dynamic subtest: vcs0
[796.872993] Dynamic subtest vcs0: SUCCESS (0.056s)
[796.883810] Starting dynamic subtest: vcs1
[796.941501] Dynamic subtest vcs1: SUCCESS (0.066s)
[796.953239] Starting dynamic subtest: vecs0
[797.001048] Dynamic subtest vecs0: SUCCESS (0.058s)
[797.012771] Starting dynamic subtest: ccs0
[797.058015] Dynamic subtest ccs0: SUCCESS (0.054s)
[797.060945] Subtest basic-busy: SUCCESS (0.403s)
[798.549282] [110/133] (243s left) gem_exec_whisper (basic-queues-all)
[798.619536] Starting subtest: basic-queues-all
[809.267530] Subtest basic-queues-all: SUCCESS (10.645s)
[809.464605] [111/133] (232s left) syncobj_eventfd (invalid-illegal-handle)
[809.538083] Starting subtest: invalid-illegal-handle
[809.541032] Subtest invalid-illegal-handle: SUCCESS (0.000s)
[809.664290] [112/133] (232s left) syncobj_timeline (invalid-single-wait-unsubmitted)
[809.723841] Starting subtest: invalid-single-wait-unsubmitted
[809.726504] Subtest invalid-single-wait-unsubmitted: SUCCESS (0.000s)
[809.831735] [113/133] (232s left) gem_render_copy (yf-tiled-to-vebox-yf-tiled)
[809.894402] Starting subtest: yf-tiled-to-vebox-yf-tiled
[809.899133] Subtest yf-tiled-to-vebox-yf-tiled: SKIP (0.000s)
[810.095420] [114/133] (232s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-mmap-wc)
[810.217211] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-mmap-wc
[810.222106] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[810.336687] [115/133] (232s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-onoff)
[810.435493] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-onoff
[810.440485] Subtest fbcpsr-2p-primscrn-spr-indfb-onoff: SKIP (0.000s)
[810.543879] [116/133] (231s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-pwrite)
[810.647239] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-pwrite
[810.651992] Subtest fbc-2p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[810.740024] [117/133] (231s left) kms_plane_scaling (planes-upscale-20x20-downscale-factor-0-75)
[810.834852] Starting subtest: planes-upscale-20x20-downscale-factor-0-75
[810.837371] Starting dynamic subtest: pipe-A
[810.857235] Dynamic subtest pipe-A: SKIP (0.018s)
[810.867931] Starting dynamic subtest: pipe-B
[810.887886] Dynamic subtest pipe-B: SKIP (0.031s)
[810.897721] Starting dynamic subtest: pipe-C
[810.923939] Dynamic subtest pipe-C: SKIP (0.033s)
[810.934208] Starting dynamic subtest: pipe-D
[810.954142] Dynamic subtest pipe-D: SKIP (0.030s)
[810.958909] Subtest planes-upscale-20x20-downscale-factor-0-75: SKIP (0.114s)
[811.075605] [118/133] (231s left) gem_flink_basic (bad-open)
[811.127366] Starting subtest: bad-open
[811.130567] Subtest bad-open: SUCCESS (0.000s)
[811.239368] [119/133] (231s left) kms_big_fb (yf-tiled-8bpp-rotate-90)
[811.344151] Starting subtest: yf-tiled-8bpp-rotate-90
[811.349045] Subtest yf-tiled-8bpp-rotate-90: SKIP (0.000s)
[811.465544] [120/133] (231s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-pwrite)
[811.554007] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-pwrite
[815.967596] Subtest fbc-1p-primscrn-cur-indfb-draw-pwrite: SUCCESS (4.416s)
[817.184889] [121/133] (225s left) kms_plane_multiple (2x-tiling-4)
[817.290020] Starting subtest: 2x-tiling-4
[817.295119] Subtest 2x-tiling-4: SKIP (0.000s)
[817.373557] [122/133] (225s left) i915_pm_rpm (system-suspend-execbuf)
[819.649826] Starting subtest: system-suspend-execbuf
[878.234890] Subtest system-suspend-execbuf: SUCCESS (43.054s)
[878.628256] [123/133] (164s left) gem_exec_balancer (indices)
[878.697054] Starting subtest: indices
[880.932606] Subtest indices: SUCCESS (2.233s)
[881.259452] [124/133] (161s left) kms_psr (pr-cursor-plane-onoff)
[881.362814] Starting subtest: pr-cursor-plane-onoff
[881.367189] Subtest pr-cursor-plane-onoff: SKIP (0.000s)
[881.450273] [125/133] (161s left) kms_color (gamma)
[881.552979] Starting subtest: gamma
[881.555119] Starting dynamic subtest: pipe-A-eDP-1
[882.250550] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.697s)
[882.261047] Starting dynamic subtest: pipe-B-eDP-1
[883.621283] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.373s)
[883.632192] Starting dynamic subtest: pipe-C-eDP-1
[884.972263] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.348s)
[884.982880] Starting dynamic subtest: pipe-D-eDP-1
[886.295731] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.322s)
[886.298028] Subtest gamma: SUCCESS (4.743s)
[887.138465] [126/133] (155s left) kms_flip (flip-vs-fences)
[887.231004] Starting subtest: flip-vs-fences
[887.235389] Subtest flip-vs-fences: SKIP (0.000s)
[887.365680] [127/133] (155s left) kms_psr2_sf (fbc-pr-primary-plane-update-sf-dmg-area)
[887.472598] Starting subtest: fbc-pr-primary-plane-update-sf-dmg-area
[887.477005] Subtest fbc-pr-primary-plane-update-sf-dmg-area: SKIP (0.000s)
[887.556439] [128/133] (155s left) kms_cursor_legacy (short-busy-flip-before-cursor-toggle)
[887.691237] Starting subtest: short-busy-flip-before-cursor-toggle
[887.695581] Subtest short-busy-flip-before-cursor-toggle: SKIP (0.000s)
[887.848143] [129/133] (155s left) kms_flip_scaled_crc (flip-64bpp-linear-to-16bpp-linear-upscaling)
[887.953979] Starting subtest: flip-64bpp-linear-to-16bpp-linear-upscaling
[887.956086] Starting dynamic subtest: pipe-A-default-mode
[890.676642] Dynamic subtest pipe-A-default-mode: SUCCESS (2.722s)
[890.679260] Subtest flip-64bpp-linear-to-16bpp-linear-upscaling: SUCCESS (2.724s)
[891.538741] [130/133] (151s left) kms_psr (psr2-primary-mmap-gtt)
[891.644873] Starting subtest: psr2-primary-mmap-gtt
[891.647052] Starting dynamic subtest: eDP-1
[893.120695] Dynamic subtest eDP-1: SKIP (1.473s)
[893.125467] Subtest psr2-primary-mmap-gtt: SKIP (1.476s)
[893.265061] [131/133] (149s left) gem_ctx_persistence (engines-hostile-preempt)
[893.323214] Starting subtest: engines-hostile-preempt
[893.325162] Starting dynamic subtest: rcs0
[893.431482] Dynamic subtest rcs0: SUCCESS (0.111s)
[893.444312] Starting dynamic subtest: bcs0
[893.496855] Dynamic subtest bcs0: SUCCESS (0.063s)
[893.509535] Starting dynamic subtest: vcs0
[894.964137] Dynamic subtest vcs0: SUCCESS (1.464s)
[894.975485] Starting dynamic subtest: vcs1
[896.986636] Dynamic subtest vcs1: SUCCESS (2.020s)
[896.999382] Starting dynamic subtest: vecs0
[899.033233] Dynamic subtest vecs0: SUCCESS (2.044s)
[899.044890] Starting dynamic subtest: ccs0
[899.121800] Dynamic subtest ccs0: SUCCESS (0.088s)
[899.124393] Subtest engines-hostile-preempt: SUCCESS (5.803s)
[899.228466] [132/133] (143s left) gem_exec_schedule (fairslice)
[899.310559] Starting subtest: fairslice
[899.312887] Starting dynamic subtest: rcs0
[901.335290] Dynamic subtest rcs0: SUCCESS (2.027s)
[901.346768] Starting dynamic subtest: bcs0
[903.357452] Dynamic subtest bcs0: SUCCESS (2.022s)
[903.369423] Starting dynamic subtest: vcs0
[905.378313] Dynamic subtest vcs0: SUCCESS (2.018s)
[905.389656] Starting dynamic subtest: vcs1
[907.398744] Dynamic subtest vcs1: SUCCESS (2.020s)
[907.409813] Starting dynamic subtest: vecs0
[909.417572] Dynamic subtest vecs0: SUCCESS (2.019s)
[909.427546] Starting dynamic subtest: ccs0
[911.438396] Dynamic subtest ccs0: SUCCESS (2.020s)
[911.440516] Subtest fairslice: SUCCESS (12.131s)
[911.750785] [133/133] (131s left) kms_lease (atomic-implicit-crtc)
[911.852621] Starting subtest: atomic-implicit-crtc
[911.854803] Starting dynamic subtest: pipe-A-eDP-1
[911.866037] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[911.879363] Starting dynamic subtest: pipe-B-eDP-1
[911.890206] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.010s)
[911.900153] Starting dynamic subtest: pipe-C-eDP-1
[911.910428] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.010s)
[911.920100] Starting dynamic subtest: pipe-D-eDP-1
[911.930427] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.009s)
[911.932473] Subtest atomic-implicit-crtc: SUCCESS (0.037s)
[912.011415] Closing watchdogs
results: parsing output: 0/ for test: kms_getfb
results: parsing output: 1/ for test: gem_ctx_persistence
results: parsing output: 2/ for test: kms_cursor_edge_walk
results: parsing output: 3/ for test: sysfs_timeslice_duration
results: parsing output: 4/ for test: kms_frontbuffer_tracking
results: parsing output: 5/ for test: kms_ccs
results: parsing output: 6/ for test: kms_atomic_transition
results: parsing output: 7/ for test: gem_mmap_gtt
results: parsing output: 8/ for test: i915_hangman
results: parsing output: 9/ for test: kms_cursor_crc
results: parsing output: 10/ for test: kms_pipe_crc_basic
results: parsing output: 11/ for test: perf
results: parsing output: 12/ for test: syncobj_wait
results: parsing output: 13/ for test: kms_psr2_sf
results: parsing output: 14/ for test: kms_big_fb
results: parsing output: 15/ for test: kms_frontbuffer_tracking
results: parsing output: 16/ for test: gem_workarounds
results: parsing output: 17/ for test: gem_exec_schedule
results: parsing output: 18/ for test: gem_userptr_blits
results: parsing output: 19/ for test: kms_invalid_mode
results: parsing output: 20/ for test: kms_setmode
results: parsing output: 21/ for test: kms_flip
results: parsing output: 22/ for test: kms_rotation_crc
results: parsing output: 23/ for test: core_setmaster
results: parsing output: 24/ for test: kms_chamelium_hpd
results: parsing output: 25/ for test: kms_pm_rpm
results: parsing output: 26/ for test: gem_exec_store
results: parsing output: 27/ for test: kms_big_fb
results: parsing output: 28/ for test: kms_flip
results: parsing output: 29/ for test: kms_frontbuffer_tracking
results: parsing output: 30/ for test: api_intel_allocator
results: parsing output: 31/ for test: kms_flip_scaled_crc
results: parsing output: 32/ for test: kms_big_fb
results: parsing output: 33/ for test: gen9_exec_parse
results: parsing output: 34/ for test: kms_feature_discovery
results: parsing output: 35/ for test: perf
results: parsing output: 36/ for test: kms_pm_rpm
results: parsing output: 37/ for test: syncobj_wait
results: parsing output: 38/ for test: kms_big_fb
results: parsing output: 39/ for test: syncobj_timeline
results: parsing output: 40/ for test: kms_content_protection
results: parsing output: 41/ for test: kms_async_flips
results: parsing output: 42/ for test: kms_setmode
results: parsing output: 43/ for test: syncobj_timeline
results: parsing output: 44/ for test: gem_unfence_active_buffers
results: parsing output: 45/ for test: gem_pxp
results: parsing output: 46/ for test: kms_pipe_b_c_ivb
results: parsing output: 47/ for test: perf
results: parsing output: 48/ for test: kms_frontbuffer_tracking
results: parsing output: 49/ for test: gem_create
results: parsing output: 50/ for test: syncobj_wait
results: parsing output: 51/ for test: syncobj_wait
results: parsing output: 52/ for test: gem_exec_reloc
results: parsing output: 53/ for test: kms_frontbuffer_tracking
results: parsing output: 54/ for test: kms_psr
results: parsing output: 55/ for test: syncobj_wait
results: parsing output: 56/ for test: kms_frontbuffer_tracking
results: parsing output: 57/ for test: kms_cursor_crc
results: parsing output: 58/ for test: kms_addfb_basic
results: parsing output: 59/ for test: i915_query
results: parsing output: 60/ for test: gem_render_copy
results: parsing output: 61/ for test: gem_exec_fence
results: parsing output: 62/ for test: kms_vblank
results: parsing output: 63/ for test: gem_softpin
results: parsing output: 64/ for test: sw_sync
results: parsing output: 65/ for test: kms_cursor_crc
results: parsing output: 66/ for test: kms_chamelium_edid
results: parsing output: 67/ for test: kms_frontbuffer_tracking
results: parsing output: 68/ for test: perf_pmu
results: parsing output: 69/ for test: gem_userptr_blits
results: parsing output: 70/ for test: kms_frontbuffer_tracking
results: parsing output: 71/ for test: prime_busy
results: parsing output: 72/ for test: kms_frontbuffer_tracking
results: parsing output: 73/ for test: syncobj_timeline
results: parsing output: 74/ for test: kms_getfb
results: parsing output: 75/ for test: kms_plane
results: parsing output: 76/ for test: gem_userptr_blits
results: parsing output: 77/ for test: fbdev
results: parsing output: 78/ for test: kms_chamelium_color
results: parsing output: 79/ for test: gem_ctx_shared
results: parsing output: 80/ for test: gem_ppgtt
results: parsing output: 81/ for test: kms_frontbuffer_tracking
results: parsing output: 82/ for test: perf
results: parsing output: 83/ for test: kms_ccs
results: parsing output: 84/ for test: gem_exec_schedule
results: parsing output: 85/ for test: gem_mmap_wc
results: parsing output: 86/ for test: gen9_exec_parse
results: parsing output: 87/ for test: kms_big_fb
results: parsing output: 88/ for test: kms_big_fb
results: parsing output: 89/ for test: kms_universal_plane
results: parsing output: 90/ for test: syncobj_wait
results: parsing output: 91/ for test: kms_frontbuffer_tracking
results: parsing output: 92/ for test: kms_cursor_legacy
results: parsing output: 93/ for test: drm_read
results: parsing output: 94/ for test: kms_psr
results: parsing output: 95/ for test: kms_ccs
results: parsing output: 96/ for test: kms_psr2_sf
results: parsing output: 97/ for test: kms_cursor_legacy
results: parsing output: 98/ for test: gem_exec_await
results: parsing output: 99/ for test: kms_rotation_crc
results: parsing output: 100/ for test: gem_mmap_offset
results: parsing output: 101/ for test: api_intel_bb
results: parsing output: 102/ for test: kms_frontbuffer_tracking
results: parsing output: 103/ for test: gem_sync
results: parsing output: 104/ for test: kms_ccs
results: parsing output: 105/ for test: kms_frontbuffer_tracking
results: parsing output: 106/ for test: kms_frontbuffer_tracking
results: parsing output: 107/ for test: kms_plane
results: parsing output: 108/ for test: gem_exec_fence
results: parsing output: 109/ for test: gem_exec_whisper
results: parsing output: 110/ for test: syncobj_eventfd
results: parsing output: 111/ for test: syncobj_timeline
results: parsing output: 112/ for test: gem_render_copy
results: parsing output: 113/ for test: kms_frontbuffer_tracking
results: parsing output: 114/ for test: kms_frontbuffer_tracking
results: parsing output: 115/ for test: kms_frontbuffer_tracking
results: parsing output: 116/ for test: kms_plane_scaling
results: parsing output: 117/ for test: gem_flink_basic
results: parsing output: 118/ for test: kms_big_fb
results: parsing output: 119/ for test: kms_frontbuffer_tracking
results: parsing output: 120/ for test: kms_plane_multiple
results: parsing output: 121/ for test: i915_pm_rpm
results: parsing output: 122/ for test: gem_exec_balancer
results: parsing output: 123/ for test: kms_psr
results: parsing output: 124/ for test: kms_color
results: parsing output: 125/ for test: kms_flip
results: parsing output: 126/ for test: kms_psr2_sf
results: parsing output: 127/ for test: kms_cursor_legacy
results: parsing output: 128/ for test: kms_flip_scaled_crc
results: parsing output: 129/ for test: kms_psr
results: parsing output: 130/ for test: gem_ctx_persistence
results: parsing output: 131/ for test: gem_exec_schedule
results: parsing output: 132/ for test: kms_lease
Done.