[55.493493] Initializing watchdogs
[55.493646]   /dev/watchdog0
[55.508284] [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]
[55.512828] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[55.515143] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[55.518984] [001/131] (960s left) gem_exec_schedule (u-independent)
[55.613935] Starting subtest: u-independent
[55.615754] Starting dynamic subtest: rcs0
[56.920875] Dynamic subtest rcs0: SUCCESS (1.311s)
[56.931996] Starting dynamic subtest: vcs0
[58.928513] Dynamic subtest vcs0: SUCCESS (2.008s)
[58.936274] Starting dynamic subtest: vcs1
[60.907843] Dynamic subtest vcs1: SUCCESS (1.979s)
[60.918381] Starting dynamic subtest: vecs0
[62.946906] Dynamic subtest vecs0: SUCCESS (2.039s)
[62.956231] Starting dynamic subtest: ccs0
[64.918664] Dynamic subtest ccs0: SUCCESS (1.971s)
[64.921068] Subtest u-independent: SUCCESS (9.310s)
[65.213939] [002/131] (950s left) gem_exec_params (invalid-flag)
[65.269357] Starting subtest: invalid-flag
[65.271777] Subtest invalid-flag: SUCCESS (0.000s)
[65.366544] [003/131] (950s left) prime_vgem (fence-wait)
[65.469765] Starting subtest: fence-wait
[65.471638] Starting dynamic subtest: rcs0
[66.512786] Dynamic subtest rcs0: SUCCESS (1.041s)
[66.522782] Starting dynamic subtest: bcs0
[67.592681] Dynamic subtest bcs0: SUCCESS (1.080s)
[67.602606] Starting dynamic subtest: vcs0
[68.638432] Dynamic subtest vcs0: SUCCESS (1.045s)
[68.647365] Starting dynamic subtest: vcs1
[69.679790] Dynamic subtest vcs1: SUCCESS (1.040s)
[69.689350] Starting dynamic subtest: vecs0
[70.723266] Dynamic subtest vecs0: SUCCESS (1.043s)
[70.733322] Starting dynamic subtest: ccs0
[71.766624] Dynamic subtest ccs0: SUCCESS (1.043s)
[71.769605] Subtest fence-wait: SUCCESS (6.296s)
[71.971106] [FACT prime_vgem (fence-wait)] new: kernel.kmod_is_loaded.vgem: true
[71.974333] [004/131] (944s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-pwrite)
[72.120502] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-pwrite
[76.580714] Subtest fbc-1p-primscrn-spr-indfb-draw-pwrite: SUCCESS (4.463s)
[77.718930] [005/131] (938s left) core_sysfs (read-all-entries)
[77.767083] Starting subtest: read-all-entries
[77.769632] Subtest read-all-entries: SUCCESS (0.003s)
[77.881735] [006/131] (938s left) perf (whitelisted-registers-userspace-config)
[77.989485] Starting subtest: whitelisted-registers-userspace-config
[77.991764] Subtest whitelisted-registers-userspace-config: SUCCESS (0.001s)
[78.034212] [007/131] (938s left) api_intel_allocator (reloc-allocator)
[78.097844] Starting subtest: reloc-allocator
[78.100275] Starting dynamic subtest: basic
[78.102533] Dynamic subtest basic: SUCCESS (0.003s)
[78.111967] Starting dynamic subtest: parallel-one
[78.114210] Dynamic subtest parallel-one: SUCCESS (0.008s)
[78.121614] Starting dynamic subtest: print
[78.123460] Dynamic subtest print: SUCCESS (0.000s)
[78.130180] Starting dynamic subtest: reuse
[78.132193] Dynamic subtest reuse: SUCCESS (0.000s)
[78.139068] Starting dynamic subtest: fork-reopen-allocator
[78.140867] Dynamic subtest fork-reopen-allocator: SUCCESS (0.010s)
[78.142744] Subtest reloc-allocator: SUCCESS (0.022s)
[78.268466] [008/131] (938s left) gem_exec_balancer (bonded-pair)
[78.331459] Starting subtest: bonded-pair
[78.336167] Subtest bonded-pair: SKIP (0.000s)
[78.636841] [009/131] (937s left) kms_psr (fbc-pr-dpms)
[78.731367] Starting subtest: fbc-pr-dpms
[78.735858] Subtest fbc-pr-dpms: SKIP (0.000s)
[78.808616] [010/131] (937s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-pwrite)
[78.912570] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-pwrite
[85.095715] Subtest fbc-1p-primscrn-pri-shrfb-draw-pwrite: SUCCESS (6.187s)
[86.224058] [011/131] (930s left) kms_frontbuffer_tracking (fbc-shrfb-scaledprimary)
[86.317660] Starting subtest: fbc-shrfb-scaledprimary
[91.409375] Subtest fbc-shrfb-scaledprimary: SUCCESS (5.097s)
[92.613683] [012/131] (923s left) syncobj_timeline (signal-point-0)
[92.678712] Starting subtest: signal-point-0
[92.681231] Subtest signal-point-0: SUCCESS (0.000s)
[92.798253] [013/131] (923s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-move)
[92.910870] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-move
[100.158731] Subtest fbcpsr-1p-primscrn-cur-indfb-move: SUCCESS (7.250s)
[100.303601] [014/131] (916s left) kms_big_fb (linear-64bpp-rotate-180)
[100.414771] Starting subtest: linear-64bpp-rotate-180
[101.891826] Subtest linear-64bpp-rotate-180: SUCCESS (1.478s)
[102.078667] [015/131] (914s left) gem_exec_schedule (independent)
[102.150782] Starting subtest: independent
[102.152925] Starting dynamic subtest: rcs0
[103.895589] Dynamic subtest rcs0: SUCCESS (1.753s)
[103.905858] Starting dynamic subtest: vcs0
[105.989224] Dynamic subtest vcs0: SUCCESS (2.094s)
[105.999628] Starting dynamic subtest: vcs1
[107.953982] Dynamic subtest vcs1: SUCCESS (1.964s)
[107.964888] Starting dynamic subtest: vecs0
[109.949571] Dynamic subtest vecs0: SUCCESS (1.995s)
[109.960268] Starting dynamic subtest: ccs0
[111.895069] Dynamic subtest ccs0: SUCCESS (1.944s)
[111.897906] Subtest independent: SUCCESS (9.752s)
[112.192049] [016/131] (904s left) kms_plane_multiple (2x-tiling-y)
[112.295063] Starting subtest: 2x-tiling-y
[112.299548] Subtest 2x-tiling-y: SKIP (0.000s)
[112.368710] [017/131] (904s left) perf_pmu (pmu-read)
[112.403523] Starting subtest: pmu-read
[112.408230] Subtest pmu-read: SUCCESS (0.002s)
[112.533103] [018/131] (904s left) kms_plane_scaling (plane-scaler-with-clipping-clamping-modifiers)
[112.637098] Starting subtest: plane-scaler-with-clipping-clamping-modifiers
[112.639458] Starting dynamic subtest: pipe-A
[112.978145] Dynamic subtest pipe-A: SUCCESS (0.341s)
[112.988574] Starting dynamic subtest: pipe-B
[114.419881] Dynamic subtest pipe-B: SUCCESS (1.442s)
[114.428276] Starting dynamic subtest: pipe-C
[115.859772] Dynamic subtest pipe-C: SUCCESS (1.439s)
[115.868705] Starting dynamic subtest: pipe-D
[117.301540] Dynamic subtest pipe-D: SUCCESS (1.442s)
[117.303884] Subtest plane-scaler-with-clipping-clamping-modifiers: SUCCESS (4.665s)
[118.468952] [019/131] (898s left) kms_frontbuffer_tracking (fbcpsr-suspend)
[118.569748] Starting subtest: fbcpsr-suspend
[159.175917] Subtest fbcpsr-suspend: SUCCESS (9.840s)
[159.310240] [020/131] (857s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-mmap-gtt)
[159.408092] Starting subtest: psr-2p-primscrn-cur-indfb-draw-mmap-gtt
[159.412193] Subtest psr-2p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[159.515657] [021/131] (857s left) gem_lmem_swapping (heavy-verify-multi)
[159.555979] Subtest heavy-verify-multi: SKIP (0.000s)
[159.601836] [022/131] (857s left) kms_flip (flip-vs-blocking-wf-vblank)
[159.705584] Starting subtest: flip-vs-blocking-wf-vblank
[159.707902] Starting dynamic subtest: A-eDP1
[168.624367] Dynamic subtest A-eDP1: SUCCESS (8.916s)
[168.635121] Starting dynamic subtest: B-eDP1
[177.553722] Dynamic subtest B-eDP1: SUCCESS (8.927s)
[177.561895] Starting dynamic subtest: C-eDP1
[186.517804] Dynamic subtest C-eDP1: SUCCESS (8.916s)
[186.527597] Starting dynamic subtest: D-eDP1
[195.457818] Dynamic subtest D-eDP1: SUCCESS (8.937s)
[195.459831] Subtest flip-vs-blocking-wf-vblank: SUCCESS (35.704s)
[196.639293] [023/131] (820s left) kms_flip (flip-vs-suspend)
[196.740730] Starting subtest: flip-vs-suspend
[196.743039] Starting dynamic subtest: A-eDP1
[245.811896] Dynamic subtest A-eDP1: SUCCESS (4.554s)
[245.820826] Starting dynamic subtest: B-eDP1
[294.810083] Dynamic subtest B-eDP1: SUCCESS (4.343s)
[294.819583] Starting dynamic subtest: C-eDP1
[343.810115] Dynamic subtest C-eDP1: SUCCESS (4.340s)
[343.823225] Starting dynamic subtest: D-eDP1
[392.790935] Dynamic subtest D-eDP1: SUCCESS (4.382s)
[392.809992] Subtest flip-vs-suspend: SUCCESS (17.627s)
[394.037448] [024/131] (622s left) kms_big_fb (linear-16bpp-rotate-90)
[394.158117] Starting subtest: linear-16bpp-rotate-90
[394.179137] Subtest linear-16bpp-rotate-90: SKIP (0.021s)
[394.282639] [025/131] (622s left) gem_softpin (evict-active)
[394.342128] Starting subtest: evict-active
[394.348308] Subtest evict-active: SUCCESS (0.006s)
[394.487150] [026/131] (622s left) i915_hangman (engine-error-state-capture)
[394.551183] Starting subtest: engine-error-state-capture
[394.553439] Starting dynamic subtest: rcs0
[400.089811] Dynamic subtest rcs0: SUCCESS (5.533s)
[400.101492] Starting dynamic subtest: bcs0
[406.042618] Dynamic subtest bcs0: SUCCESS (5.947s)
[406.054707] Starting dynamic subtest: vcs0
[411.114661] Dynamic subtest vcs0: SUCCESS (5.050s)
[411.123127] Starting dynamic subtest: vcs1
[416.987487] Dynamic subtest vcs1: SUCCESS (5.887s)
[416.999073] Starting dynamic subtest: vecs0
[422.042409] Dynamic subtest vecs0: SUCCESS (5.051s)
[422.054599] Starting dynamic subtest: ccs0
[428.059508] Dynamic subtest ccs0: SUCCESS (6.013s)
[428.062838] Subtest engine-error-state-capture: SUCCESS (33.492s)
[428.139182] [027/131] (588s left) gem_exec_reloc (basic-wc-cpu)
[428.193019] Subtest basic-wc-cpu: SKIP (0.000s)
[428.281757] [028/131] (588s left) gem_exec_schedule (semaphore-user)
[428.360499] Starting subtest: semaphore-user
[428.416388] Subtest semaphore-user: SUCCESS (0.061s)
[430.124427] [029/131] (587s left) kms_ccs (crc-primary-rotation-180-4-tiled-mtl-rc-ccs)
[430.224784] Starting subtest: crc-primary-rotation-180-4-tiled-mtl-rc-ccs
[430.227039] Starting dynamic subtest: pipe-A-eDP-1
[431.030499] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.796s)
[431.039100] Starting dynamic subtest: pipe-B-eDP-1
[432.562290] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.526s)
[432.572089] Starting dynamic subtest: pipe-C-eDP-1
[434.105757] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.544s)
[434.114871] Starting dynamic subtest: pipe-D-eDP-1
[435.596725] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.488s)
[435.598863] Subtest crc-primary-rotation-180-4-tiled-mtl-rc-ccs: SUCCESS (5.359s)
[436.784253] [030/131] (580s left) syncobj_timeline (device-submit-unordered)
[436.840669] Starting subtest: device-submit-unordered
[436.842919] Subtest device-submit-unordered: SUCCESS (0.000s)
[436.961648] [031/131] (580s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tile-downscaling)
[437.066500] Starting subtest: flip-64bpp-4tile-to-32bpp-4tile-downscaling
[437.068808] Starting dynamic subtest: pipe-A-default-mode
[438.235753] Dynamic subtest pipe-A-default-mode: SKIP (1.168s)
[438.240512] Subtest flip-64bpp-4tile-to-32bpp-4tile-downscaling: SKIP (1.169s)
[438.391845] [032/131] (578s left) kms_plane_alpha_blend (constant-alpha-mid)
[438.502271] Starting subtest: constant-alpha-mid
[438.795984] Starting dynamic subtest: pipe-A-eDP-1
[439.527207] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.731s)
[439.536215] Starting dynamic subtest: pipe-D-eDP-1
[441.007841] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.479s)
[441.010227] Subtest constant-alpha-mid: SUCCESS (2.505s)
[441.871330] [033/131] (575s left) kms_draw_crc (draw-method-mmap-cpu)
[441.974539] Starting subtest: draw-method-mmap-cpu
[441.976509] Starting dynamic subtest: xrgb8888-untiled
[442.184878] Dynamic subtest xrgb8888-untiled: SUCCESS (0.212s)
[442.194593] Starting dynamic subtest: rgb565-untiled
[442.407092] Dynamic subtest rgb565-untiled: SUCCESS (0.222s)
[442.416110] Starting dynamic subtest: xrgb2101010-untiled
[442.587122] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.177s)
[442.595540] Starting dynamic subtest: xbgr16161616f-untiled
[442.796335] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.211s)
[442.805699] Starting dynamic subtest: xrgb8888-xtiled
[442.917971] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.121s)
[442.926500] Starting dynamic subtest: rgb565-xtiled
[443.029113] Dynamic subtest rgb565-xtiled: SUCCESS (0.111s)
[443.037296] Starting dynamic subtest: xrgb2101010-xtiled
[443.129102] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.098s)
[443.139825] Starting dynamic subtest: xbgr16161616f-xtiled
[443.251410] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.122s)
[443.260219] Starting dynamic subtest: xrgb8888-4tiled
[443.384927] Dynamic subtest xrgb8888-4tiled: SUCCESS (0.133s)
[443.393901] Starting dynamic subtest: rgb565-4tiled
[443.529287] Dynamic subtest rgb565-4tiled: SUCCESS (0.144s)
[443.537777] Starting dynamic subtest: xrgb2101010-4tiled
[443.662876] Dynamic subtest xrgb2101010-4tiled: SUCCESS (0.133s)
[443.671098] Starting dynamic subtest: xbgr16161616f-4tiled
[443.784920] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (0.121s)
[443.786777] Subtest draw-method-mmap-cpu: SUCCESS (1.813s)
[443.877199] [034/131] (573s left) kms_ccs (crc-sprite-planes-basic-4-tiled-dg2-rc-ccs)
[443.972595] Starting subtest: crc-sprite-planes-basic-4-tiled-dg2-rc-ccs
[443.974476] Starting dynamic subtest: pipe-A-eDP-1
[444.022619] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[444.030486] Starting dynamic subtest: pipe-B-eDP-1
[444.075224] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[444.082960] Starting dynamic subtest: pipe-C-eDP-1
[444.127826] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[444.135341] Starting dynamic subtest: pipe-D-eDP-1
[444.180741] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[444.184435] Subtest crc-sprite-planes-basic-4-tiled-dg2-rc-ccs: SKIP (0.009s)
[446.137446] [035/131] (571s left) prime_vgem (basic-read)
[446.198815] Starting subtest: basic-read
[446.211509] Subtest basic-read: SKIP (0.010s)
[446.306324] [036/131] (571s left) kms_pm_backlight (bad-brightness)
[446.404624] Starting subtest: bad-brightness
[446.457449] Starting dynamic subtest: eDP-1
[446.760289] Dynamic subtest eDP-1: SUCCESS (0.305s)
[446.762843] Subtest bad-brightness: SUCCESS (0.358s)
[447.562215] [037/131] (569s left) kms_psr (fbc-psr2-no-drrs)
[447.652160] Starting subtest: fbc-psr2-no-drrs
[447.654388] Starting dynamic subtest: eDP-1
[447.658417] Dynamic subtest eDP-1: SKIP (0.000s)
[447.662492] Subtest fbc-psr2-no-drrs: SKIP (0.001s)
[447.727950] [038/131] (569s left) sw_sync (sync_multi_producer_single_consumer)
[447.759519] Starting subtest: sync_multi_producer_single_consumer
[448.834949] Subtest sync_multi_producer_single_consumer: SUCCESS (1.075s)
[448.897125] [039/131] (568s left) kms_big_fb (y-tiled-8bpp-rotate-180)
[449.007014] Starting subtest: y-tiled-8bpp-rotate-180
[449.011238] Subtest y-tiled-8bpp-rotate-180: SKIP (0.000s)
[449.099806] [040/131] (568s left) gem_pxp (create-regular-context-2)
[449.227710] Starting subtest: create-regular-context-2
[449.229971] Subtest create-regular-context-2: SUCCESS (0.002s)
[449.357115] [041/131] (568s left) syncobj_timeline (etime-multi-wait-for-submit-submitted)
[449.409561] Starting subtest: etime-multi-wait-for-submit-submitted
[449.510259] Subtest etime-multi-wait-for-submit-submitted: SUCCESS (0.102s)
[449.584720] [042/131] (568s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-mmap-wc)
[449.697370] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-mmap-wc
[453.268275] Subtest fbc-1p-primscrn-spr-indfb-draw-mmap-wc: SUCCESS (3.573s)
[454.467442] [043/131] (563s left) syncobj_wait (wait-all-for-submit-delayed-submit)
[454.526008] Starting subtest: wait-all-for-submit-delayed-submit
[454.627705] Subtest wait-all-for-submit-delayed-submit: SUCCESS (0.103s)
[454.717436] [044/131] (563s left) kms_frontbuffer_tracking (fbcpsr-tiling-4)
[454.811791] Starting subtest: fbcpsr-tiling-4
[461.856364] Subtest fbcpsr-tiling-4: SUCCESS (7.043s)
[462.002364] [045/131] (555s left) kms_ccs (ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc)
[462.100894] Starting subtest: ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc
[462.103282] Starting dynamic subtest: pipe-A-eDP-1
[462.123333] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[462.134218] Starting dynamic subtest: pipe-B-eDP-1
[462.153469] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[462.162003] Starting dynamic subtest: pipe-C-eDP-1
[462.181260] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[462.189649] Starting dynamic subtest: pipe-D-eDP-1
[462.208983] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[462.210825] Subtest ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.008s)
[464.255569] [046/131] (553s left) kms_atomic (plane-primary-legacy)
[464.363362] Starting subtest: plane-primary-legacy
[464.365702] Starting dynamic subtest: pipe-A-eDP-1
[464.816926] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.452s)
[464.819475] Subtest plane-primary-legacy: SUCCESS (0.453s)
[465.701826] [047/131] (552s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-16bpp-4tile-upscaling)
[465.796391] Starting subtest: flip-64bpp-4tile-to-16bpp-4tile-upscaling
[465.798720] Starting dynamic subtest: pipe-A-default-mode
[468.539044] Dynamic subtest pipe-A-default-mode: SUCCESS (2.738s)
[468.541493] Subtest flip-64bpp-4tile-to-16bpp-4tile-upscaling: SUCCESS (2.740s)
[469.389472] [048/131] (548s left) kms_pm_rpm (modeset-lpsp-stress)
[471.213275] Starting subtest: modeset-lpsp-stress
[487.957725] Subtest modeset-lpsp-stress: SUCCESS (16.739s)
[488.057439] [049/131] (529s left) kms_psr2_sf (pr-primary-plane-update-sf-dmg-area-big-fb)
[493.089925] Starting subtest: pr-primary-plane-update-sf-dmg-area-big-fb
[493.094693] Subtest pr-primary-plane-update-sf-dmg-area-big-fb: SKIP (0.003s)
[493.929834] [050/131] (524s left) gem_fence_thrash (bo-write-verify-x)
[493.968925] Starting subtest: bo-write-verify-x
[493.988441] Subtest bo-write-verify-x: SKIP (0.017s)
[494.053484] [051/131] (524s left) gem_mmap_offset (close-race)
[494.109058] Starting subtest: close-race
[514.264884] Subtest close-race: SUCCESS (20.100s)
[514.368631] [052/131] (503s left) gem_exec_whisper (basic-contexts-priority-all)
[514.433198] Starting subtest: basic-contexts-priority-all
[539.083321] Subtest basic-contexts-priority-all: SUCCESS (24.586s)
[539.212264] [053/131] (478s left) gem_userptr_blits (set-cache-level)
[539.278726] Starting subtest: set-cache-level
[539.282855] Subtest set-cache-level: SKIP (0.000s)
[539.425194] [054/131] (478s left) i915_query (query-topology-unsupported)
[539.469070] Starting subtest: query-topology-unsupported
[539.473365] Subtest query-topology-unsupported: SKIP (0.000s)
[539.558786] [055/131] (478s left) i915_drm_fdinfo (busy-hang)
[539.598303] Starting subtest: busy-hang
[539.600512] Starting dynamic subtest: rcs0
[539.634899] Dynamic subtest rcs0: SKIP (0.036s)
[539.647483] Starting dynamic subtest: bcs0
[539.651596] Dynamic subtest bcs0: SKIP (0.001s)
[539.660887] Starting dynamic subtest: vcs0
[539.665193] Dynamic subtest vcs0: SKIP (0.001s)
[539.674096] Starting dynamic subtest: vcs1
[539.679402] Dynamic subtest vcs1: SKIP (0.001s)
[539.687843] Starting dynamic subtest: vecs0
[539.691906] Dynamic subtest vecs0: SKIP (0.001s)
[539.701018] Starting dynamic subtest: ccs0
[539.705162] Dynamic subtest ccs0: SKIP (0.001s)
[539.709185] Subtest busy-hang: SKIP (0.045s)
[539.745968] [056/131] (478s left) gem_exec_balancer (parallel-balancer)
[540.007817] Starting subtest: parallel-balancer
[540.892590] Subtest parallel-balancer: SUCCESS (0.884s)
[541.017753] [057/131] (477s left) kms_frontbuffer_tracking (fbc-1p-primscrn-indfb-plflip-blt)
[541.139725] Starting subtest: fbc-1p-primscrn-indfb-plflip-blt
[545.757630] Subtest fbc-1p-primscrn-indfb-plflip-blt: SUCCESS (4.620s)
[546.940108] [058/131] (471s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-gtt)
[547.040179] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-gtt
[547.044653] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[547.154314] [059/131] (471s left) kms_addfb_basic (framebuffer-vs-set-tiling)
[547.209582] Starting subtest: framebuffer-vs-set-tiling
[547.213829] Subtest framebuffer-vs-set-tiling: SKIP (0.000s)
[547.370870] [060/131] (471s left) gem_exec_reloc (basic-cpu)
[547.427807] Subtest basic-cpu: SKIP (0.000s)
[547.525950] [061/131] (470s left) kms_atomic_transition (plane-use-after-nonblocking-unbind)
[547.627337] Starting subtest: plane-use-after-nonblocking-unbind
[547.629613] Starting dynamic subtest: pipe-A-eDP-1
[547.699371] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.074s)
[548.007871] Starting dynamic subtest: pipe-B-eDP-1
[548.833470] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.838s)
[549.129686] Subtest plane-use-after-nonblocking-unbind: SUCCESS (1.504s)
[550.033466] [062/131] (468s left) kms_prime (d3hot)
[550.125089] Subtest D3hot: SKIP (0.000s)
[550.208431] [063/131] (468s left) kms_frontbuffer_tracking (fbcpsr-modesetfrombusy)
[550.312005] Starting subtest: fbcpsr-modesetfrombusy
[556.475260] Subtest fbcpsr-modesetfrombusy: SUCCESS (6.166s)
[556.621846] [064/131] (461s left) i915_pm_rpm (debugfs-forcewake-user)
[558.248811] Starting subtest: debugfs-forcewake-user
[569.650022] Subtest debugfs-forcewake-user: SUCCESS (11.399s)
[570.031591] [065/131] (448s left) gem_ccs (ctrl-surf-copy)
[570.091978] Starting subtest: ctrl-surf-copy
[570.096621] Subtest ctrl-surf-copy: SKIP (0.000s)
[570.190655] [066/131] (448s left) kms_cursor_edge_walk (256x256-left-edge)
[570.283356] Starting subtest: 256x256-left-edge
[570.285639] Starting dynamic subtest: pipe-A-eDP-1
[573.796463] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.511s)
[573.807200] Starting dynamic subtest: pipe-D-eDP-1
[576.917608] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.121s)
[576.920109] Subtest 256x256-left-edge: SUCCESS (6.635s)
[577.727914] [067/131] (441s left) kms_pipe_b_c_ivb (pipe-b-double-modeset-then-modeset-pipe-c)
[577.786327] Subtest pipe-B-double-modeset-then-modeset-pipe-C: SKIP (0.000s)
[577.859806] [068/131] (440s left) syncobj_wait (invalid-multi-wait-unsubmitted-submitted)
[577.914651] Starting subtest: invalid-multi-wait-unsubmitted-submitted
[577.917117] Subtest invalid-multi-wait-unsubmitted-submitted: SUCCESS (0.000s)
[578.039302] [069/131] (440s left) kms_setmode (invalid-clone-exclusive-crtc)
[578.090973] Starting subtest: invalid-clone-exclusive-crtc
[578.097638] Subtest invalid-clone-exclusive-crtc: SKIP (0.000s)
[578.205565] [070/131] (440s left) kms_psr2_sf (fbc-pr-cursor-plane-move-continuous-sf)
[583.218247] Starting subtest: fbc-pr-cursor-plane-move-continuous-sf
[583.223045] Subtest fbc-pr-cursor-plane-move-continuous-sf: SKIP (0.002s)
[584.057545] [071/131] (434s left) kms_scaling_modes (scaling-mode-none)
[584.153310] Starting subtest: scaling-mode-none
[584.155628] Starting dynamic subtest: pipe-A-eDP-1
[584.251092] Dynamic subtest pipe-A-eDP-1: SKIP (0.095s)
[584.261556] Starting dynamic subtest: pipe-B-eDP-1
[584.284610] Dynamic subtest pipe-B-eDP-1: SKIP (0.032s)
[584.294145] Starting dynamic subtest: pipe-C-eDP-1
[584.323615] Dynamic subtest pipe-C-eDP-1: SKIP (0.038s)
[584.333311] Starting dynamic subtest: pipe-D-eDP-1
[584.358153] Dynamic subtest pipe-D-eDP-1: SKIP (0.032s)
[584.362339] Subtest scaling-mode-none: SKIP (0.203s)
[584.481197] [072/131] (434s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-pwrite)
[584.574738] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-pwrite
[593.095414] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-pwrite: SUCCESS (8.522s)
[593.233728] [073/131] (425s left) gem_workarounds (reset-context)
[593.301907] Starting subtest: reset-context
[593.476546] Subtest reset-context: SUCCESS (0.175s)
[593.594591] [074/131] (425s left) kms_flip (absolute-wf_vblank-interruptible)
[593.686107] Starting subtest: absolute-wf_vblank-interruptible
[593.688528] Starting dynamic subtest: A-eDP1
[602.406528] Dynamic subtest A-eDP1: SUCCESS (8.686s)
[602.418436] Starting dynamic subtest: B-eDP1
[611.143275] Dynamic subtest B-eDP1: SUCCESS (8.731s)
[611.156131] Starting dynamic subtest: C-eDP1
[619.880739] Dynamic subtest C-eDP1: SUCCESS (8.720s)
[619.896744] Starting dynamic subtest: D-eDP1
[628.609497] Dynamic subtest D-eDP1: SUCCESS (8.722s)
[628.611905] Subtest absolute-wf_vblank-interruptible: SUCCESS (34.868s)
[629.775778] [075/131] (389s left) kms_flip (flip-vs-panning-vs-hang)
[629.886013] Starting subtest: flip-vs-panning-vs-hang
[629.888412] Starting dynamic subtest: A-eDP1
[681.564674] Dynamic subtest A-eDP1: SUCCESS (51.667s)
[681.575310] Starting dynamic subtest: D-eDP1
[730.592938] Dynamic subtest D-eDP1: SUCCESS (49.118s)
[730.595270] Subtest flip-vs-panning-vs-hang: SUCCESS (100.790s)
[731.812006] [076/131] (287s left) gem_render_copy (y-tiled-mc-ccs-to-vebox-y-tiled)
[731.873108] Starting subtest: y-tiled-mc-ccs-to-vebox-y-tiled
[731.877572] Subtest y-tiled-mc-ccs-to-vebox-y-tiled: SKIP (0.000s)
[732.057456] [077/131] (287s left) gem_ctx_shared (create-shared-gtt)
[732.110711] Starting subtest: create-shared-gtt
[734.314844] Subtest create-shared-gtt: SUCCESS (2.151s)
[734.583296] [078/131] (284s left) i915_query (query-garbage)
[734.636842] Starting subtest: query-garbage
[734.638848] Subtest query-garbage: SUCCESS (0.000s)
[734.755450] [079/131] (284s left) gem_exec_params (invalid-bsd2-flag-on-vebox)
[734.804071] Starting subtest: invalid-bsd2-flag-on-vebox
[734.806214] Subtest invalid-bsd2-flag-on-vebox: SUCCESS (0.000s)
[734.900711] [080/131] (284s left) kms_vblank (query-busy-hang)
[735.003121] Starting subtest: query-busy-hang
[735.005279] Starting dynamic subtest: pipe-A-eDP-1
[762.863320] Dynamic subtest pipe-A-eDP-1: SUCCESS (27.857s)
[762.880114] Starting dynamic subtest: pipe-D-eDP-1
[777.906136] Dynamic subtest pipe-D-eDP-1: SUCCESS (15.039s)
[777.908583] Subtest query-busy-hang: SUCCESS (42.900s)
[778.762254] [081/131] (240s left) kms_frontbuffer_tracking (psr-2p-primscrn-shrfb-msflip-blt)
[778.866994] Starting subtest: psr-2p-primscrn-shrfb-msflip-blt
[778.871366] Subtest psr-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[778.963782] [082/131] (240s left) gem_reg_read (bad-register)
[779.016208] Starting subtest: bad-register
[779.018100] Subtest bad-register: SUCCESS (0.000s)
[779.121696] [083/131] (240s left) kms_cursor_crc (cursor-offscreen-32x10)
[779.277613] Starting subtest: cursor-offscreen-32x10
[779.323677] Subtest cursor-offscreen-32x10: SKIP (0.041s)
[779.624734] [084/131] (239s left) syncobj_timeline (single-wait-available-submitted)
[779.670321] Starting subtest: single-wait-available-submitted
[779.672323] Subtest single-wait-available-submitted: SUCCESS (0.000s)
[779.775545] [085/131] (239s left) gem_ctx_persistence (engines-hostile)
[779.830953] Starting subtest: engines-hostile
[779.832871] Starting dynamic subtest: rcs0
[779.993747] Dynamic subtest rcs0: SUCCESS (0.162s)
[780.006659] Starting dynamic subtest: bcs0
[780.071875] Dynamic subtest bcs0: SUCCESS (0.077s)
[780.083271] Starting dynamic subtest: vcs0
[780.238381] Dynamic subtest vcs0: SUCCESS (0.164s)
[780.251595] Starting dynamic subtest: vcs1
[780.361414] Dynamic subtest vcs1: SUCCESS (0.121s)
[780.373626] Starting dynamic subtest: vecs0
[780.466299] Dynamic subtest vecs0: SUCCESS (0.103s)
[780.477750] Starting dynamic subtest: ccs0
[780.576392] Dynamic subtest ccs0: SUCCESS (0.108s)
[780.578528] Subtest engines-hostile: SUCCESS (0.746s)
[780.658378] [086/131] (238s left) gem_render_copy (mixed-tiled-to-yf-tiled-ccs)
[780.711994] Starting subtest: mixed-tiled-to-yf-tiled-ccs
[780.715874] Subtest mixed-tiled-to-yf-tiled-ccs: SKIP (0.000s)
[780.896626] [087/131] (238s left) gem_wait (write-busy)
[780.957971] Starting subtest: write-busy
[780.960502] Starting dynamic subtest: all-engines
[781.593696] Dynamic subtest all-engines: SUCCESS (0.635s)
[781.611795] Starting dynamic subtest: rcs0
[782.150241] Dynamic subtest rcs0: SUCCESS (0.555s)
[782.165468] Starting dynamic subtest: bcs0
[782.703313] Dynamic subtest bcs0: SUCCESS (0.552s)
[782.720820] Starting dynamic subtest: vcs0
[784.123124] Dynamic subtest vcs0: SUCCESS (1.417s)
[784.139090] Starting dynamic subtest: vcs1
[786.106395] Dynamic subtest vcs1: SUCCESS (1.981s)
[786.121255] Starting dynamic subtest: vecs0
[788.092489] Dynamic subtest vecs0: SUCCESS (1.985s)
[788.109497] Starting dynamic subtest: ccs0
[788.643622] Dynamic subtest ccs0: SUCCESS (0.550s)
[788.646277] Subtest write-busy: SUCCESS (7.686s)
[788.843931] [088/131] (230s left) kms_frontbuffer_tracking (psr-rgb101010-draw-render)
[788.958361] Starting subtest: psr-rgb101010-draw-render
[796.218027] Subtest psr-rgb101010-draw-render: SUCCESS (7.263s)
[796.358568] [089/131] (223s left) perf (gen12-oa-tlb-invalidate)
[796.445656] Starting subtest: gen12-oa-tlb-invalidate
[796.448044] Starting dynamic subtest: 0-rcs0
[806.537643] Dynamic subtest 0-rcs0: SUCCESS (10.040s)
[806.549764] Starting dynamic subtest: 1-vcs0
[816.579812] Dynamic subtest 1-vcs0: SUCCESS (10.044s)
[816.581901] Subtest gen12-oa-tlb-invalidate: SUCCESS (20.086s)
[816.627736] [090/131] (203s left) syncobj_wait (multi-wait-for-submit-signaled)
[816.689855] Starting subtest: multi-wait-for-submit-signaled
[816.692304] Subtest multi-wait-for-submit-signaled: SUCCESS (0.000s)
[816.808351] [091/131] (202s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip)
[816.912984] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip
[816.917448] Subtest y-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SKIP (0.000s)
[817.015059] [092/131] (202s left) gem_render_tiled_blits (basic)
[817.073435] Subtest basic: SKIP (0.000s)
[817.147346] [093/131] (202s left) i915_suspend (forcewake)
[817.198011] Starting subtest: forcewake
[848.806751] Subtest forcewake: SUCCESS (2.159s)
[849.868909] [094/131] (171s left) gem_eio (suspend)
[850.084748] Starting subtest: suspend
[861.884377] Subtest suspend: SUCCESS (11.797s)
[862.042693] [095/131] (158s left) dumb_buffer (create-valid-dumb)
[862.106508] Starting subtest: create-valid-dumb
[862.108420] Subtest create-valid-dumb: SUCCESS (0.000s)
[862.239286] [096/131] (158s left) vgem_basic (busy-fence)
[862.289667] Starting subtest: busy-fence
[862.291542] Subtest busy-fence: SUCCESS (0.000s)
[862.346179] [097/131] (158s left) syncobj_timeline (invalid-wait-bad-flags)
[862.405734] Starting subtest: invalid-wait-bad-flags
[862.408119] Subtest invalid-wait-bad-flags: SUCCESS (0.000s)
[862.519330] [098/131] (158s left) kms_atomic (crtc-invalid-params)
[862.624286] Starting subtest: crtc-invalid-params
[862.626632] Starting dynamic subtest: pipe-A-eDP-1
[862.995006] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.369s)
[862.997317] Subtest crtc-invalid-params: SUCCESS (0.371s)
[863.847307] [099/131] (157s left) kms_psr (fbc-psr-sprite-plane-onoff)
[863.951350] Starting subtest: fbc-psr-sprite-plane-onoff
[863.953653] Starting dynamic subtest: eDP-1
[863.958162] Dynamic subtest eDP-1: SKIP (0.000s)
[863.962682] Subtest fbc-psr-sprite-plane-onoff: SKIP (0.001s)
[864.022818] [100/131] (157s left) gem_exec_fence (syncobj-timeline-invalid-wait)
[864.556646] Starting subtest: syncobj-timeline-invalid-wait
[864.559867] Subtest syncobj-timeline-invalid-wait: SUCCESS (0.004s)
[865.631694] [101/131] (155s left) gem_userptr_blits (map-fixed-invalidate-busy)
[865.702613] Starting subtest: map-fixed-invalidate-busy
[865.707099] Subtest map-fixed-invalidate-busy: SKIP (0.000s)
[865.845557] [102/131] (155s left) kms_chamelium_hpd (dp-hpd-for-each-pipe)
[866.224473] Subtest dp-hpd-for-each-pipe: SKIP (0.000s)
[867.065491] [103/131] (154s left) kms_ccs (random-ccs-data-4-tiled-lnl-ccs)
[867.172211] Starting subtest: random-ccs-data-4-tiled-lnl-ccs
[867.176812] Subtest random-ccs-data-4-tiled-lnl-ccs: SKIP (0.000s)
[868.309672] [104/131] (153s left) kms_color (ctm-green-to-red)
[868.400131] Starting subtest: ctm-green-to-red
[868.402395] Starting dynamic subtest: pipe-A-eDP-1
[869.075859] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.674s)
[869.086912] Starting dynamic subtest: pipe-B-eDP-1
[870.469235] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.391s)
[870.480533] Starting dynamic subtest: pipe-C-eDP-1
[871.746876] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.279s)
[871.758075] Starting dynamic subtest: pipe-D-eDP-1
[873.080312] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.334s)
[873.082744] Subtest ctm-green-to-red: SUCCESS (4.680s)
[873.933882] [105/131] (147s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu)
[874.040814] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu
[874.045010] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[874.148324] [106/131] (147s left) gem_userptr_blits (invalid-null-pointer)
[874.212164] Starting subtest: invalid-null-pointer
[874.214126] Subtest invalid-null-pointer: SUCCESS (0.001s)
[874.340374] [107/131] (147s left) kms_chamelium_color (ctm-negative)
[874.429154] Subtest ctm-negative: SKIP (0.000s)
[874.476617] [108/131] (147s left) kms_hdr (brightness-with-hdr)
[874.566123] Starting subtest: brightness-with-hdr
[874.572615] Subtest brightness-with-hdr: SKIP (0.000s)
[874.638110] [109/131] (146s left) gem_mmap_gtt (fault-concurrent-y)
[874.697607] Subtest fault-concurrent-Y: SKIP (0.000s)
[874.757762] [110/131] (146s left) kms_frontbuffer_tracking (psr-2p-scndscrn-shrfb-pgflip-blt)
[874.858249] Starting subtest: psr-2p-scndscrn-shrfb-pgflip-blt
[874.862512] Subtest psr-2p-scndscrn-shrfb-pgflip-blt: SKIP (0.000s)
[874.981135] [111/131] (146s left) kms_lease (setcrtc-implicit-plane)
[875.074652] Starting subtest: setcrtc-implicit-plane
[875.076740] Starting dynamic subtest: pipe-A-eDP-1
[875.544853] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.468s)
[875.555745] Starting dynamic subtest: pipe-B-eDP-1
[876.664168] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.116s)
[876.678435] Starting dynamic subtest: pipe-C-eDP-1
[877.782730] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.120s)
[877.794689] Starting dynamic subtest: pipe-D-eDP-1
[878.909059] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.122s)
[878.910932] Subtest setcrtc-implicit-plane: SUCCESS (3.831s)
[879.756143] [112/131] (141s left) perf (blocking)
[879.840984] Starting subtest: blocking
[879.843210] Starting dynamic subtest: 0-rcs0
[889.922811] Dynamic subtest 0-rcs0: SUCCESS (10.029s)
[889.934987] Starting dynamic subtest: 1-vcs0
[899.941043] Dynamic subtest 1-vcs0: SUCCESS (10.017s)
[899.943446] Subtest blocking: SUCCESS (20.049s)
[899.982205] [113/131] (121s left) kms_psr (psr-cursor-render)
[900.083016] Starting subtest: psr-cursor-render
[900.085308] Starting dynamic subtest: eDP-1
[901.844988] Dynamic subtest eDP-1: SUCCESS (1.761s)
[901.846816] Subtest psr-cursor-render: SUCCESS (1.762s)
[902.719420] [114/131] (119s left) gem_exec_fence (basic-wait)
[902.899620] Starting subtest: basic-wait
[902.902022] Starting dynamic subtest: rcs0
[902.986104] Dynamic subtest rcs0: SUCCESS (0.086s)
[902.998013] Starting dynamic subtest: bcs0
[903.042416] Dynamic subtest bcs0: SUCCESS (0.055s)
[903.054392] Starting dynamic subtest: vcs0
[903.103638] Dynamic subtest vcs0: SUCCESS (0.059s)
[903.115502] Starting dynamic subtest: vcs1
[903.157391] Dynamic subtest vcs1: SUCCESS (0.052s)
[903.168773] Starting dynamic subtest: vecs0
[903.214376] Dynamic subtest vecs0: SUCCESS (0.056s)
[903.226240] Starting dynamic subtest: ccs0
[903.273465] Dynamic subtest ccs0: SUCCESS (0.057s)
[903.275827] Subtest basic-wait: SUCCESS (0.375s)
[904.657762] [115/131] (117s left) kms_big_fb (yf-tiled-64bpp-rotate-270)
[904.763492] Starting subtest: yf-tiled-64bpp-rotate-270
[904.767569] Subtest yf-tiled-64bpp-rotate-270: SKIP (0.000s)
[904.882170] [116/131] (116s left) kms_cursor_legacy (nonblocking-modeset-vs-cursor-atomic)
[905.004669] Starting subtest: nonblocking-modeset-vs-cursor-atomic
[906.409905] Subtest nonblocking-modeset-vs-cursor-atomic: SUCCESS (1.404s)
[907.208622] [117/131] (114s left) kms_cursor_legacy (cursor-vs-flip-varying-size)
[907.327248] Starting subtest: cursor-vs-flip-varying-size
[937.740431] Subtest cursor-vs-flip-varying-size: SUCCESS (30.414s)
[938.547605] [118/131] ( 83s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180-hflip)
[938.656151] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180-hflip
[939.643299] Subtest x-tiled-max-hw-stride-64bpp-rotate-180-hflip: SUCCESS (0.989s)
[939.803650] [119/131] ( 82s left) gem_exec_await (wide-contexts)
[939.984850] Starting subtest: wide-contexts
[965.463118] Subtest wide-contexts: SUCCESS (25.477s)
[965.657172] [120/131] ( 56s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-mmap-wc)
[965.811721] Starting subtest: fbc-rgb101010-draw-mmap-wc
[970.438310] Subtest fbc-rgb101010-draw-mmap-wc: SUCCESS (4.631s)
[971.566058] [121/131] ( 50s left) gem_exec_nop (basic-parallel)
[971.640681] Starting subtest: basic-parallel
[987.509135] Subtest basic-parallel: SUCCESS (15.880s)
[987.758103] [122/131] ( 34s left) gem_ctx_isolation (nonpriv-switch)
[987.834536] Starting subtest: nonpriv-switch
[987.836917] Starting dynamic subtest: rcs0
[988.197896] Dynamic subtest rcs0: SUCCESS (0.363s)
[988.208626] Starting dynamic subtest: bcs0
[988.567198] Dynamic subtest bcs0: SUCCESS (0.368s)
[988.577495] Starting dynamic subtest: vcs0
[988.920228] Dynamic subtest vcs0: SUCCESS (0.353s)
[988.930827] Starting dynamic subtest: vcs1
[990.834695] Dynamic subtest vcs1: SUCCESS (1.913s)
[990.845498] Starting dynamic subtest: vecs0
[992.873511] Dynamic subtest vecs0: SUCCESS (2.038s)
[992.886401] Starting dynamic subtest: ccs0
[994.890699] Dynamic subtest ccs0: SUCCESS (2.017s)
[994.893157] Subtest nonpriv-switch: SUCCESS (7.057s)
[995.132010] [123/131] ( 26s left) kms_busy (extended-pageflip-hang-oldfb)
[995.237043] Starting subtest: extended-pageflip-hang-oldfb
[995.239359] Starting dynamic subtest: pipe-A
[995.693593] Dynamic subtest pipe-A: SUCCESS (0.454s)
[995.704371] Starting dynamic subtest: pipe-D
[996.856969] Dynamic subtest pipe-D: SUCCESS (1.161s)
[996.859465] Subtest extended-pageflip-hang-oldfb: SUCCESS (1.619s)
[997.706021] [124/131] ( 24s left) kms_cursor_crc (cursor-random-64x21)
[997.904431] Starting subtest: cursor-random-64x21
[997.947863] Subtest cursor-random-64x21: SKIP (0.038s)
[998.190165] [125/131] ( 24s left) i915_pm_rps (reset)
[998.253369] Starting subtest: reset
[998.338894] Subtest reset: FAIL (0.027s)
[998.415883] [126/131] ( 23s left) kms_psr (pr-sprite-render)
[998.519266] Starting subtest: pr-sprite-render
[998.523301] Subtest pr-sprite-render: SKIP (0.000s)
[998.591900] [127/131] ( 23s left) gem_softpin (evict-active-interruptible)
[998.646489] Starting subtest: evict-active-interruptible
[998.651895] Subtest evict-active-interruptible: SUCCESS (0.006s)
[998.798990] [128/131] ( 23s left) kms_writeback (writeback-check-output)
[998.902075] Subtest writeback-check-output: SKIP (0.000s)
[998.949338] [129/131] ( 23s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-pwrite)
[999.056108] Starting subtest: psr-1p-primscrn-pri-indfb-draw-pwrite
[1006.631185] Subtest psr-1p-primscrn-pri-indfb-draw-pwrite: SUCCESS (7.578s)
[1006.745025] [130/131] ( 15s left) gem_render_copy_redux (flink-interruptible)
[1006.815132] Starting subtest: flink-interruptible
[1007.615753] Subtest flink-interruptible: SUCCESS (0.802s)
[1007.744718] [131/131] ( 14s left) kms_cursor_crc (cursor-sliding-64x64)
[1007.916059] Starting subtest: cursor-sliding-64x64
[1007.920147] Starting dynamic subtest: pipe-A-eDP-1
[1011.153648] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.233s)
[1011.184412] Starting dynamic subtest: pipe-D-eDP-1
[1014.988076] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.810s)
[1014.990320] Subtest cursor-sliding-64x64: SUCCESS (7.070s)
[1015.784135] Closing watchdogs
results: parsing output: 0/ for test: gem_exec_schedule
results: parsing output: 1/ for test: gem_exec_params
results: parsing output: 2/ for test: prime_vgem
results: parsing output: 3/ for test: kms_frontbuffer_tracking
results: parsing output: 4/ for test: core_sysfs
results: parsing output: 5/ for test: perf
results: parsing output: 6/ for test: api_intel_allocator
results: parsing output: 7/ for test: gem_exec_balancer
results: parsing output: 8/ for test: kms_psr
results: parsing output: 9/ for test: kms_frontbuffer_tracking
results: parsing output: 10/ for test: kms_frontbuffer_tracking
results: parsing output: 11/ for test: syncobj_timeline
results: parsing output: 12/ for test: kms_frontbuffer_tracking
results: parsing output: 13/ for test: kms_big_fb
results: parsing output: 14/ for test: gem_exec_schedule
results: parsing output: 15/ for test: kms_plane_multiple
results: parsing output: 16/ for test: perf_pmu
results: parsing output: 17/ for test: kms_plane_scaling
results: parsing output: 18/ for test: kms_frontbuffer_tracking
results: parsing output: 19/ for test: kms_frontbuffer_tracking
results: parsing output: 20/ for test: gem_lmem_swapping
results: parsing output: 21/ for test: kms_flip
results: parsing output: 22/ for test: kms_flip
results: parsing output: 23/ for test: kms_big_fb
results: parsing output: 24/ for test: gem_softpin
results: parsing output: 25/ for test: i915_hangman
results: parsing output: 26/ for test: gem_exec_reloc
results: parsing output: 27/ for test: gem_exec_schedule
results: parsing output: 28/ for test: kms_ccs
results: parsing output: 29/ for test: syncobj_timeline
results: parsing output: 30/ for test: kms_flip_scaled_crc
results: parsing output: 31/ for test: kms_plane_alpha_blend
results: parsing output: 32/ for test: kms_draw_crc
results: parsing output: 33/ for test: kms_ccs
results: parsing output: 34/ for test: prime_vgem
results: parsing output: 35/ for test: kms_pm_backlight
results: parsing output: 36/ for test: kms_psr
results: parsing output: 37/ for test: sw_sync
results: parsing output: 38/ for test: kms_big_fb
results: parsing output: 39/ for test: gem_pxp
results: parsing output: 40/ for test: syncobj_timeline
results: parsing output: 41/ for test: kms_frontbuffer_tracking
results: parsing output: 42/ for test: syncobj_wait
results: parsing output: 43/ for test: kms_frontbuffer_tracking
results: parsing output: 44/ for test: kms_ccs
results: parsing output: 45/ for test: kms_atomic
results: parsing output: 46/ for test: kms_flip_scaled_crc
results: parsing output: 47/ for test: kms_pm_rpm
results: parsing output: 48/ for test: kms_psr2_sf
results: parsing output: 49/ for test: gem_fence_thrash
results: parsing output: 50/ for test: gem_mmap_offset
results: parsing output: 51/ for test: gem_exec_whisper
results: parsing output: 52/ for test: gem_userptr_blits
results: parsing output: 53/ for test: i915_query
results: parsing output: 54/ for test: i915_drm_fdinfo
results: parsing output: 55/ for test: gem_exec_balancer
results: parsing output: 56/ for test: kms_frontbuffer_tracking
results: parsing output: 57/ for test: kms_frontbuffer_tracking
results: parsing output: 58/ for test: kms_addfb_basic
results: parsing output: 59/ for test: gem_exec_reloc
results: parsing output: 60/ for test: kms_atomic_transition
results: parsing output: 61/ for test: kms_prime
results: parsing output: 62/ for test: kms_frontbuffer_tracking
results: parsing output: 63/ for test: i915_pm_rpm
results: parsing output: 64/ for test: gem_ccs
results: parsing output: 65/ for test: kms_cursor_edge_walk
results: parsing output: 66/ for test: kms_pipe_b_c_ivb
results: parsing output: 67/ for test: syncobj_wait
results: parsing output: 68/ for test: kms_setmode
results: parsing output: 69/ for test: kms_psr2_sf
results: parsing output: 70/ for test: kms_scaling_modes
results: parsing output: 71/ for test: kms_frontbuffer_tracking
results: parsing output: 72/ for test: gem_workarounds
results: parsing output: 73/ for test: kms_flip
results: parsing output: 74/ for test: kms_flip
results: parsing output: 75/ for test: gem_render_copy
results: parsing output: 76/ for test: gem_ctx_shared
results: parsing output: 77/ for test: i915_query
results: parsing output: 78/ for test: gem_exec_params
results: parsing output: 79/ for test: kms_vblank
results: parsing output: 80/ for test: kms_frontbuffer_tracking
results: parsing output: 81/ for test: gem_reg_read
results: parsing output: 82/ for test: kms_cursor_crc
results: parsing output: 83/ for test: syncobj_timeline
results: parsing output: 84/ for test: gem_ctx_persistence
results: parsing output: 85/ for test: gem_render_copy
results: parsing output: 86/ for test: gem_wait
results: parsing output: 87/ for test: kms_frontbuffer_tracking
results: parsing output: 88/ for test: perf
results: parsing output: 89/ for test: syncobj_wait
results: parsing output: 90/ for test: kms_big_fb
results: parsing output: 91/ for test: gem_render_tiled_blits
results: parsing output: 92/ for test: i915_suspend
results: parsing output: 93/ for test: gem_eio
results: parsing output: 94/ for test: dumb_buffer
results: parsing output: 95/ for test: vgem_basic
results: parsing output: 96/ for test: syncobj_timeline
results: parsing output: 97/ for test: kms_atomic
results: parsing output: 98/ for test: kms_psr
results: parsing output: 99/ for test: gem_exec_fence
results: parsing output: 100/ for test: gem_userptr_blits
results: parsing output: 101/ for test: kms_chamelium_hpd
results: parsing output: 102/ for test: kms_ccs
results: parsing output: 103/ for test: kms_color
results: parsing output: 104/ for test: kms_frontbuffer_tracking
results: parsing output: 105/ for test: gem_userptr_blits
results: parsing output: 106/ for test: kms_chamelium_color
results: parsing output: 107/ for test: kms_hdr
results: parsing output: 108/ for test: gem_mmap_gtt
results: parsing output: 109/ for test: kms_frontbuffer_tracking
results: parsing output: 110/ for test: kms_lease
results: parsing output: 111/ for test: perf
results: parsing output: 112/ for test: kms_psr
results: parsing output: 113/ for test: gem_exec_fence
results: parsing output: 114/ for test: kms_big_fb
results: parsing output: 115/ for test: kms_cursor_legacy
results: parsing output: 116/ for test: kms_cursor_legacy
results: parsing output: 117/ for test: kms_big_fb
results: parsing output: 118/ for test: gem_exec_await
results: parsing output: 119/ for test: kms_frontbuffer_tracking
results: parsing output: 120/ for test: gem_exec_nop
results: parsing output: 121/ for test: gem_ctx_isolation
results: parsing output: 122/ for test: kms_busy
results: parsing output: 123/ for test: kms_cursor_crc
results: parsing output: 124/ for test: i915_pm_rps
results: parsing output: 125/ for test: kms_psr
results: parsing output: 126/ for test: gem_softpin
results: parsing output: 127/ for test: kms_writeback
results: parsing output: 128/ for test: kms_frontbuffer_tracking
results: parsing output: 129/ for test: gem_render_copy_redux
results: parsing output: 130/ for test: kms_cursor_crc
Done.