[58.521497] Initializing watchdogs
[58.521543]   /dev/watchdog0
[58.536345] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics]
[58.541215] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[58.543816] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[58.545721] [001/133] (960s left) kms_dsc (dsc-with-bpc-formats)
[58.639061] Starting subtest: dsc-with-bpc-formats
[58.680689] Subtest dsc-with-bpc-formats: SKIP (0.003s)
[58.715238] [002/133] (960s left) gem_eio (in-flight-contexts-1us)
[58.844453] Starting subtest: in-flight-contexts-1us
[68.328699] Subtest in-flight-contexts-1us: SUCCESS (9.519s)
[68.478237] [003/133] (950s left) kms_ccs (crc-primary-rotation-180-4-tiled-dg2-rc-ccs)
[68.566743] Starting subtest: crc-primary-rotation-180-4-tiled-dg2-rc-ccs
[68.567505] Starting dynamic subtest: pipe-A-eDP-1
[68.583484] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[68.591881] Starting dynamic subtest: pipe-B-eDP-1
[68.600364] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[68.608173] Starting dynamic subtest: pipe-C-eDP-1
[68.616060] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[68.622658] Starting dynamic subtest: pipe-D-eDP-1
[68.630733] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[68.632424] Subtest crc-primary-rotation-180-4-tiled-dg2-rc-ccs: SKIP (0.005s)
[71.114753] [004/133] (948s left) gem_exec_alignment (pi-isolated)
[71.171080] Starting subtest: pi-isolated
[124.843725] Subtest pi-isolated: SUCCESS (53.677s)
[125.751677] [005/133] (893s left) kms_flip (plain-flip-fb-recreate-interruptible)
[125.951720] Starting subtest: plain-flip-fb-recreate-interruptible
[125.953926] Starting dynamic subtest: A-eDP1
[134.806362] Dynamic subtest A-eDP1: SUCCESS (8.852s)
[134.816802] Starting dynamic subtest: B-eDP1
[143.629378] Dynamic subtest B-eDP1: SUCCESS (8.822s)
[143.641105] Starting dynamic subtest: C-eDP1
[152.450115] Dynamic subtest C-eDP1: SUCCESS (8.820s)
[152.459181] Starting dynamic subtest: D-eDP1
[161.274785] Dynamic subtest D-eDP1: SUCCESS (8.823s)
[161.278930] Subtest plain-flip-fb-recreate-interruptible: SUCCESS (35.325s)
[162.453692] [006/133] (856s left) kms_pm_rpm (modeset-lpsp)
[164.482683] Starting subtest: modeset-lpsp
[165.960424] Subtest modeset-lpsp: SUCCESS (1.480s)
[166.039294] [007/133] (853s left) syncobj_timeline (invalid-signal-illegal-point)
[166.112124] Starting subtest: invalid-signal-illegal-point
[166.113186] Subtest invalid-signal-illegal-point: SUCCESS (0.000s)
[166.220421] [008/133] (853s left) kms_dp_link_training (uhbr-mst)
[166.313037] Starting subtest: uhbr-mst
[166.317054] Subtest uhbr-mst: SKIP (0.000s)
[166.378782] [009/133] (852s left) syncobj_timeline (single-wait-available-signaled)
[166.421996] Starting subtest: single-wait-available-signaled
[166.423100] Subtest single-wait-available-signaled: SUCCESS (0.000s)
[166.512987] [010/133] (852s left) kms_vblank (wait-busy-hang)
[166.598433] Starting subtest: wait-busy-hang
[166.599366] Starting dynamic subtest: pipe-A-eDP-1
[193.115376] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.514s)
[193.124271] Starting dynamic subtest: pipe-D-eDP-1
[208.094426] Dynamic subtest pipe-D-eDP-1: SUCCESS (14.977s)
[208.095354] Subtest wait-busy-hang: SUCCESS (41.495s)
[208.949685] [011/133] (810s left) kms_flip (2x-flip-vs-rmfb)
[209.038089] Starting subtest: 2x-flip-vs-rmfb
[209.048558] Subtest 2x-flip-vs-rmfb: SKIP (0.011s)
[209.132716] [012/133] (810s left) syncobj_timeline (32bits-limit)
[209.177856] Starting subtest: 32bits-limit
[209.178822] Subtest 32bits-limit: SUCCESS (0.001s)
[209.276581] [013/133] (810s left) gem_exec_params (invalid-bsd2-flag-on-vebox)
[209.332985] Starting subtest: invalid-bsd2-flag-on-vebox
[209.334082] Subtest invalid-bsd2-flag-on-vebox: SUCCESS (0.000s)
[209.434630] [014/133] (810s left) kms_plane_scaling (2x-scaler-multi-pipe)
[209.529661] Starting subtest: 2x-scaler-multi-pipe
[209.531535] Subtest 2x-scaler-multi-pipe: SKIP (0.001s)
[209.616292] [015/133] (809s left) kms_frontbuffer_tracking (fbc-1p-rte)
[209.708944] Starting subtest: fbc-1p-rte
[215.169472] Subtest fbc-1p-rte: SUCCESS (5.461s)
[216.298661] [016/133] (803s left) i915_drm_fdinfo (virtual-idle)
[216.337132] Starting subtest: virtual-idle
[219.405658] Subtest virtual-idle: SUCCESS (3.058s)
[219.464271] [017/133] (800s left) gem_lmem_swapping (heavy-random)
[219.499875] Subtest heavy-random: SKIP (0.000s)
[219.539861] [018/133] (800s left) kms_plane (pixel-format-linear-modifier)
[219.629867] Starting subtest: pixel-format-linear-modifier
[219.658350] Starting dynamic subtest: pipe-A-plane-0
[223.347429] Dynamic subtest pipe-A-plane-0: SUCCESS (3.689s)
[223.356401] Starting dynamic subtest: pipe-A-plane-3
[225.058991] Dynamic subtest pipe-A-plane-3: SUCCESS (1.711s)
[225.068485] Starting dynamic subtest: pipe-A-plane-5
[225.270248] Dynamic subtest pipe-A-plane-5: SUCCESS (0.209s)
[226.366844] Starting dynamic subtest: pipe-B-plane-0
[230.069516] Dynamic subtest pipe-B-plane-0: SUCCESS (3.711s)
[230.078582] Starting dynamic subtest: pipe-B-plane-3
[231.781092] Dynamic subtest pipe-B-plane-3: SUCCESS (1.710s)
[231.789632] Starting dynamic subtest: pipe-B-plane-5
[231.980623] Dynamic subtest pipe-B-plane-5: SUCCESS (0.200s)
[232.289199] Subtest pixel-format-linear-modifier: SUCCESS (12.659s)
[233.121376] [019/133] (786s left) sw_sync (sync_merge)
[233.153079] Starting subtest: sync_merge
[233.154041] Subtest sync_merge: SUCCESS (0.000s)
[233.197146] [020/133] (786s left) kms_frontbuffer_tracking (fbc-farfromfence-mmap-gtt)
[233.297301] Starting subtest: fbc-farfromfence-mmap-gtt
[233.299271] Subtest fbc-farfromfence-mmap-gtt: SKIP (0.000s)
[233.402236] [021/133] (786s left) gem_render_copy (yf-tiled-mc-ccs-to-vebox-yf-tiled)
[233.453719] Starting subtest: yf-tiled-mc-ccs-to-vebox-yf-tiled
[233.455748] Subtest yf-tiled-mc-ccs-to-vebox-yf-tiled: SKIP (0.000s)
[233.630929] [022/133] (786s left) drm_read (short-buffer-wakeup)
[233.766866] Starting subtest: short-buffer-wakeup
[265.990562] Subtest short-buffer-wakeup: SUCCESS (32.215s)
[266.137099] [023/133] (753s left) gem_exec_schedule (u-semaphore-noskip)
[266.193180] Starting subtest: u-semaphore-noskip
[266.607811] Subtest u-semaphore-noskip: SUCCESS (0.405s)
[266.933998] [024/133] (752s left) i915_pm_rpm (system-suspend-execbuf)
[268.446721] Starting subtest: system-suspend-execbuf
[326.894708] Subtest system-suspend-execbuf: SUCCESS (43.233s)
[327.286029] [025/133] (692s left) gem_exec_fence (submit67)
[327.466985] Starting subtest: submit67
[327.469101] Subtest submit67: SKIP (0.000s)
[329.763906] [FACT gem_exec_fence (submit67)] new: kernel.kmod_is_loaded.vgem: true
[329.766237] [026/133] (690s left) gem_ccs (ctrl-surf-copy-new-ctx)
[329.814006] Starting subtest: ctrl-surf-copy-new-ctx
[329.816191] Subtest ctrl-surf-copy-new-ctx: SKIP (0.000s)
[329.937955] [027/133] (689s left) kms_big_fb (x-tiled-8bpp-rotate-270)
[330.043795] Starting subtest: x-tiled-8bpp-rotate-270
[330.064486] Subtest x-tiled-8bpp-rotate-270: SKIP (0.020s)
[330.175309] [028/133] (689s left) kms_ccs (crc-primary-basic-4-tiled-dg2-rc-ccs)
[330.264350] Starting subtest: crc-primary-basic-4-tiled-dg2-rc-ccs
[330.265477] Starting dynamic subtest: pipe-A-eDP-1
[330.274417] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[330.284233] Starting dynamic subtest: pipe-B-eDP-1
[330.292673] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[330.301834] Starting dynamic subtest: pipe-C-eDP-1
[330.310131] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[330.318761] Starting dynamic subtest: pipe-D-eDP-1
[330.327154] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[330.328841] Subtest crc-primary-basic-4-tiled-dg2-rc-ccs: SKIP (0.005s)
[332.531379] [029/133] (687s left) prime_mmap (test_correct_cpu_write)
[332.587565] Starting subtest: test_correct_cpu_write
[332.588750] Starting dynamic subtest: test_correct_cpu_write-smem
[332.589804] Dynamic subtest test_correct_cpu_write-smem: SUCCESS (0.000s)
[332.590863] Subtest test_correct_cpu_write: SUCCESS (0.001s)
[332.679072] [030/133] (687s left) kms_big_fb (linear-32bpp-rotate-0)
[332.779716] Starting subtest: linear-32bpp-rotate-0
[334.313664] Subtest linear-32bpp-rotate-0: SUCCESS (1.534s)
[334.421191] [031/133] (685s left) gem_readwrite (read-bad-handle)
[334.472310] Subtest read-bad-handle: SKIP (0.000s)
[334.527459] [032/133] (685s left) kms_flip (bo-too-big-interruptible)
[334.617077] Starting subtest: bo-too-big-interruptible
[334.619359] Starting dynamic subtest: A-eDP1
[335.878567] Dynamic subtest A-eDP1: SUCCESS (1.257s)
[335.890850] Starting dynamic subtest: B-eDP1
[337.101550] Dynamic subtest B-eDP1: SUCCESS (1.222s)
[337.114191] Starting dynamic subtest: C-eDP1
[338.348723] Dynamic subtest C-eDP1: SUCCESS (1.244s)
[338.360100] Starting dynamic subtest: D-eDP1
[339.587430] Dynamic subtest D-eDP1: SUCCESS (1.238s)
[339.588424] Subtest bo-too-big-interruptible: SUCCESS (4.971s)
[340.796151] [033/133] (679s left) kms_ccs (crc-sprite-planes-basic-4-tiled-dg2-rc-ccs)
[340.879157] Starting subtest: crc-sprite-planes-basic-4-tiled-dg2-rc-ccs
[340.880007] Starting dynamic subtest: pipe-A-eDP-1
[340.902358] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[340.913324] Starting dynamic subtest: pipe-B-eDP-1
[340.935193] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[340.943612] Starting dynamic subtest: pipe-C-eDP-1
[340.964202] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[340.972667] Starting dynamic subtest: pipe-D-eDP-1
[340.993105] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[340.994666] Subtest crc-sprite-planes-basic-4-tiled-dg2-rc-ccs: SKIP (0.008s)
[343.163851] [034/133] (676s left) gem_mmap_offset (basic-uaf)
[343.215736] Starting subtest: basic-uaf
[343.216716] Subtest basic-uaf: SUCCESS (0.001s)
[343.331018] [035/133] (676s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-indfb-msflip-blt)
[343.419902] Starting subtest: fbc-2p-scndscrn-indfb-msflip-blt
[343.421617] Subtest fbc-2p-scndscrn-indfb-msflip-blt: SKIP (0.000s)
[343.511079] [036/133] (676s left) gem_tiled_blits (basic)
[343.569784] Subtest basic: SKIP (0.000s)
[343.639759] [037/133] (676s left) kms_psr2_sf (pr-cursor-plane-update-sf)
[343.727344] Starting subtest: pr-cursor-plane-update-sf
[343.728872] Subtest pr-cursor-plane-update-sf: SKIP (0.000s)
[343.806749] [038/133] (676s left) kms_chamelium_color (ctm-0-50)
[343.882589] Subtest ctm-0-50: SKIP (0.000s)
[343.921864] [039/133] (676s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-blt)
[344.017538] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-blt
[348.468666] Subtest fbc-1p-primscrn-pri-indfb-draw-blt: SUCCESS (4.452s)
[349.594521] [040/133] (670s left) kms_ccs (bad-rotation-90-4-tiled-dg2-mc-ccs)
[349.680147] Starting subtest: bad-rotation-90-4-tiled-dg2-mc-ccs
[349.680995] Starting dynamic subtest: pipe-A-eDP-1
[349.698461] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[349.707678] Starting dynamic subtest: pipe-B-eDP-1
[349.716257] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[349.725623] Starting dynamic subtest: pipe-C-eDP-1
[349.733420] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[349.742154] Starting dynamic subtest: pipe-D-eDP-1
[349.749787] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[349.751325] Subtest bad-rotation-90-4-tiled-dg2-mc-ccs: SKIP (0.004s)
[351.959407] [041/133] (668s left) vgem_basic (sysfs)
[351.992981] Starting subtest: sysfs
[351.993971] Subtest sysfs: SUCCESS (0.000s)
[352.060154] [042/133] (668s left) perf_pmu (busy-double-start)
[352.106976] Starting subtest: busy-double-start
[352.107719] Starting dynamic subtest: rcs0
[355.717321] Dynamic subtest rcs0: FAIL (3.593s)
[355.727316] Starting dynamic subtest: bcs0
[359.291294] Dynamic subtest bcs0: SUCCESS (3.594s)
[359.303951] Starting dynamic subtest: vcs0
[363.226676] Dynamic subtest vcs0: SUCCESS (3.933s)
[363.239488] Starting dynamic subtest: vcs1
[367.195753] Dynamic subtest vcs1: SUCCESS (3.968s)
[367.207441] Starting dynamic subtest: vecs0
[371.227116] Dynamic subtest vecs0: SUCCESS (4.032s)
[371.238250] Starting dynamic subtest: ccs0
[374.824411] Dynamic subtest ccs0: FAIL (3.566s)
[374.825319] Subtest busy-double-start: FAIL (22.694s)
[374.897187] [043/133] (645s left) gem_mmap_gtt (cpuset-basic-small-copy)
[374.945642] Subtest cpuset-basic-small-copy: SKIP (0.000s)
[375.000571] [044/133] (645s left) perf_pmu (init-wait)
[375.032067] Starting subtest: init-wait
[375.033115] Starting dynamic subtest: rcs0
[375.034103] Dynamic subtest rcs0: SUCCESS (0.002s)
[375.047149] Starting dynamic subtest: bcs0
[375.047972] Dynamic subtest bcs0: SUCCESS (0.000s)
[375.056811] Starting dynamic subtest: vcs0
[375.057718] Dynamic subtest vcs0: SUCCESS (0.000s)
[375.066424] Starting dynamic subtest: vcs1
[375.067298] Dynamic subtest vcs1: SUCCESS (0.001s)
[375.075820] Starting dynamic subtest: vecs0
[375.076878] Dynamic subtest vecs0: SUCCESS (0.000s)
[375.085544] Starting dynamic subtest: ccs0
[375.086444] Dynamic subtest ccs0: SUCCESS (0.000s)
[375.087340] Subtest init-wait: SUCCESS (0.007s)
[375.163875] [045/133] (645s left) kms_cursor_crc (cursor-tearing-position-change)
[375.278681] Starting subtest: cursor-tearing-position-change
[375.279628] Starting dynamic subtest: pipe-A-eDP-1
[375.836565] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.557s)
[375.847003] Starting dynamic subtest: pipe-D-eDP-1
[377.075356] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.237s)
[377.076375] Subtest cursor-tearing-position-change: SUCCESS (1.796s)
[377.912339] [046/133] (642s left) kms_flip (2x-plain-flip-interruptible)
[378.019578] Starting subtest: 2x-plain-flip-interruptible
[378.032301] Subtest 2x-plain-flip-interruptible: SKIP (0.011s)
[378.125323] [047/133] (642s left) kms_chamelium_hpd (dp-hpd-with-enabled-mode)
[378.517392] Subtest dp-hpd-with-enabled-mode: SKIP (0.000s)
[379.309199] [048/133] (641s left) gem_ctx_param (non-root-set)
[379.357460] Starting subtest: non-root-set
[379.373910] Subtest non-root-set: SUCCESS (0.016s)
[379.453905] [049/133] (641s left) gem_mmap_wc (copy)
[379.504905] Subtest copy: SKIP (0.000s)
[379.560607] [050/133] (641s left) kms_big_fb (yf-tiled-64bpp-rotate-270)
[379.652171] Starting subtest: yf-tiled-64bpp-rotate-270
[379.654225] Subtest yf-tiled-64bpp-rotate-270: SKIP (0.000s)
[379.752076] [051/133] (640s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size)
[379.868705] Starting subtest: basic-flip-before-cursor-varying-size
[380.798160] Subtest basic-flip-before-cursor-varying-size: SUCCESS (0.930s)
[381.647573] [052/133] (639s left) gem_exec_balancer (parallel-keep-in-fence)
[381.915275] Starting subtest: parallel-keep-in-fence
[383.166041] Subtest parallel-keep-in-fence: SUCCESS (1.251s)
[383.249723] [053/133] (637s left) kms_psr (pr-no-drrs)
[383.346467] Starting subtest: pr-no-drrs
[383.348339] Subtest pr-no-drrs: SKIP (0.000s)
[383.417999] [054/133] (637s left) kms_fbcon_fbt (fbc)
[383.474849] Starting subtest: fbc
[389.789020] Subtest fbc: SUCCESS (6.305s)
[390.859624] [055/133] (629s left) kms_frontbuffer_tracking (psr-rgb565-draw-blt)
[390.954824] Starting subtest: psr-rgb565-draw-blt
[398.129992] Subtest psr-rgb565-draw-blt: SUCCESS (7.172s)
[398.251902] [056/133] (622s left) syncobj_timeline (invalid-multi-wait-all-unsubmitted)
[398.295510] Starting subtest: invalid-multi-wait-all-unsubmitted
[398.296423] Subtest invalid-multi-wait-all-unsubmitted: SUCCESS (0.000s)
[398.380839] [057/133] (622s left) gem_exec_balancer (invalid-bonds)
[398.440233] Starting subtest: invalid-bonds
[398.442271] Subtest invalid-bonds: SKIP (0.000s)
[398.742115] [058/133] (622s left) gem_exec_schedule (fairslice)
[398.796193] Starting subtest: fairslice
[398.796991] Starting dynamic subtest: rcs0
[400.819370] Dynamic subtest rcs0: SUCCESS (2.020s)
[400.829655] Starting dynamic subtest: bcs0
[402.848732] Dynamic subtest bcs0: SUCCESS (2.022s)
[402.859749] Starting dynamic subtest: vcs0
[404.871448] Dynamic subtest vcs0: SUCCESS (2.021s)
[404.880675] Starting dynamic subtest: vcs1
[406.891471] Dynamic subtest vcs1: SUCCESS (2.019s)
[406.902771] Starting dynamic subtest: vecs0
[408.909790] Dynamic subtest vecs0: SUCCESS (2.017s)
[408.921134] Starting dynamic subtest: ccs0
[410.928395] Dynamic subtest ccs0: SUCCESS (2.020s)
[410.929498] Subtest fairslice: SUCCESS (12.124s)
[411.242049] [059/133] (609s left) api_intel_bb (blit-noreloc-purge-cache)
[411.291775] Starting subtest: blit-noreloc-purge-cache
[411.305039] Subtest blit-noreloc-purge-cache: SUCCESS (0.014s)
[411.439731] [060/133] (609s left) syncobj_wait (wait-all-complex)
[411.488086] Starting subtest: wait-all-complex
[411.711974] Subtest wait-all-complex: SUCCESS (0.215s)
[411.775325] [061/133] (609s left) kms_lease (lease-unleased-crtc)
[411.867897] Starting subtest: lease-unleased-crtc
[411.868733] Starting dynamic subtest: pipe-A-eDP-1
[412.158758] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.290s)
[412.169238] Starting dynamic subtest: pipe-B-eDP-1
[412.958335] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.796s)
[412.969346] Starting dynamic subtest: pipe-C-eDP-1
[412.970407] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.007s)
[412.979471] Starting dynamic subtest: pipe-D-eDP-1
[412.980402] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.004s)
[412.981296] Subtest lease-unleased-crtc: SUCCESS (1.104s)
[413.327285] [062/133] (607s left) kms_chamelium_edid (dp-edid-read)
[413.719543] Subtest dp-edid-read: SKIP (0.000s)
[414.543461] [063/133] (606s left) sysfs_preempt_timeout (idempotent)
[414.591402] Starting subtest: idempotent
[414.592283] Starting dynamic subtest: vecs0
[414.593269] Dynamic subtest vecs0: SUCCESS (0.000s)
[414.602841] Starting dynamic subtest: ccs0
[414.603694] Dynamic subtest ccs0: SUCCESS (0.000s)
[414.612631] Starting dynamic subtest: vcs0
[414.613488] Dynamic subtest vcs0: SUCCESS (0.000s)
[414.622371] Starting dynamic subtest: bcs0
[414.623257] Dynamic subtest bcs0: SUCCESS (0.000s)
[414.632144] Starting dynamic subtest: rcs0
[414.633132] Dynamic subtest rcs0: SUCCESS (0.000s)
[414.641973] Starting dynamic subtest: vcs1
[414.642839] Dynamic subtest vcs1: SUCCESS (0.000s)
[414.643725] Subtest idempotent: SUCCESS (0.006s)
[414.673916] [064/133] (606s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-onoff)
[414.762353] Starting subtest: psr-2p-primscrn-cur-indfb-onoff
[414.764218] Subtest psr-2p-primscrn-cur-indfb-onoff: SKIP (0.000s)
[414.854299] [065/133] (606s left) gem_exec_flush (basic-uc-set-default)
[414.917388] Starting subtest: basic-uc-set-default
[420.374745] Subtest basic-uc-set-default: SUCCESS (5.457s)
[420.567102] [066/133] (600s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip)
[420.683314] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip
[420.685201] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SKIP (0.000s)
[420.782678] [067/133] (600s left) kms_flip_scaled_crc (flip-64bpp-linear-to-32bpp-linear-downscaling)
[420.870855] Starting subtest: flip-64bpp-linear-to-32bpp-linear-downscaling
[420.871771] Starting dynamic subtest: pipe-A-default-mode
[422.030128] Dynamic subtest pipe-A-default-mode: SKIP (1.155s)
[422.032240] Subtest flip-64bpp-linear-to-32bpp-linear-downscaling: SKIP (1.158s)
[422.181590] [068/133] (599s left) perf_pmu (semaphore-wait-idle)
[422.220191] Starting subtest: semaphore-wait-idle
[422.221143] Starting dynamic subtest: rcs0
[422.745788] Dynamic subtest rcs0: SUCCESS (0.514s)
[422.757996] Starting dynamic subtest: bcs0
[423.259010] Dynamic subtest bcs0: SUCCESS (0.510s)
[423.269396] Starting dynamic subtest: vcs0
[423.772494] Dynamic subtest vcs0: SUCCESS (0.510s)
[423.785439] Starting dynamic subtest: vcs1
[424.285159] Dynamic subtest vcs1: SUCCESS (0.510s)
[424.296922] Starting dynamic subtest: vecs0
[424.798519] Dynamic subtest vecs0: SUCCESS (0.510s)
[424.810163] Starting dynamic subtest: ccs0
[425.313466] Dynamic subtest ccs0: SUCCESS (0.512s)
[425.314587] Subtest semaphore-wait-idle: SUCCESS (3.084s)
[426.788336] [069/133] (594s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-blt)
[426.884114] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-blt
[426.885986] Subtest psr-2p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[426.983135] [070/133] (594s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip)
[427.084887] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip
[427.732898] Subtest x-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip: SUCCESS (0.648s)
[427.900544] [071/133] (593s left) kms_addfb_basic (bad-pitch-63)
[427.958739] Starting subtest: bad-pitch-63
[427.959831] Subtest bad-pitch-63: SUCCESS (0.000s)
[428.097988] [072/133] (593s left) kms_cursor_legacy (2x-flip-vs-cursor-legacy)
[428.207404] Starting subtest: 2x-flip-vs-cursor-legacy
[428.210338] Subtest 2x-flip-vs-cursor-legacy: SKIP (0.001s)
[428.347097] [073/133] (593s left) gem_ctx_persistence (saturated-hostile-nopreempt)
[428.398849] Starting subtest: saturated-hostile-nopreempt
[428.399856] Starting dynamic subtest: rcs0
[428.470952] Dynamic subtest rcs0: SKIP (0.072s)
[428.482995] Starting dynamic subtest: bcs0
[428.496898] Dynamic subtest bcs0: SKIP (0.025s)
[428.507475] Starting dynamic subtest: vcs0
[428.512799] Dynamic subtest vcs0: SKIP (0.014s)
[428.522030] Starting dynamic subtest: vcs1
[428.532808] Dynamic subtest vcs1: SKIP (0.019s)
[428.548641] Starting dynamic subtest: vecs0
[428.554919] Dynamic subtest vecs0: SKIP (0.021s)
[428.563952] Starting dynamic subtest: ccs0
[428.575810] Dynamic subtest ccs0: SKIP (0.020s)
[428.577750] Subtest saturated-hostile-nopreempt: SKIP (0.179s)
[428.647780] [074/133] (592s left) kms_pipe_crc_basic (hang-read-crc)
[428.735998] Starting subtest: hang-read-crc
[428.736826] Starting dynamic subtest: pipe-A-eDP-1
[430.890023] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.153s)
[430.900335] Starting dynamic subtest: pipe-B-eDP-1
[433.652185] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.762s)
[433.664742] Starting dynamic subtest: pipe-C-eDP-1
[436.380755] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.727s)
[436.391906] Starting dynamic subtest: pipe-D-eDP-1
[439.053080] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.670s)
[439.053987] Subtest hang-read-crc: SUCCESS (10.318s)
[439.881719] [075/133] (581s left) gem_exec_reloc (basic-write-wc-active)
[439.936368] Subtest basic-write-wc-active: SKIP (0.000s)
[439.996830] [076/133] (581s left) kms_psr (psr2-sprite-blt)
[440.084447] Starting subtest: psr2-sprite-blt
[440.085386] Starting dynamic subtest: eDP-1
[441.778322] Dynamic subtest eDP-1: SUCCESS (1.694s)
[441.779128] Subtest psr2-sprite-blt: SUCCESS (1.695s)
[442.662141] [077/133] (578s left) kms_plane_scaling (plane-scaler-unity-scaling-with-pixel-format)
[442.744081] Starting subtest: plane-scaler-unity-scaling-with-pixel-format
[442.744864] Starting dynamic subtest: pipe-A
[443.872045] Dynamic subtest pipe-A: SUCCESS (1.128s)
[443.881713] Starting dynamic subtest: pipe-B
[446.031755] Dynamic subtest pipe-B: SUCCESS (2.159s)
[446.042746] Starting dynamic subtest: pipe-C
[447.251612] Dynamic subtest pipe-C: SUCCESS (1.219s)
[447.262049] Starting dynamic subtest: pipe-D
[448.504979] Dynamic subtest pipe-D: SUCCESS (1.252s)
[448.505889] Subtest plane-scaler-unity-scaling-with-pixel-format: SUCCESS (5.762s)
[449.681056] [078/133] (571s left) gem_mmap_wc (read-write-distinct)
[449.729735] Subtest read-write-distinct: SKIP (0.000s)
[449.781893] [079/133] (571s left) kms_psr (fbc-psr-primary-mmap-gtt)
[449.861317] Starting subtest: fbc-psr-primary-mmap-gtt
[449.862251] Starting dynamic subtest: eDP-1
[449.864122] Dynamic subtest eDP-1: SKIP (0.000s)
[449.865804] Subtest fbc-psr-primary-mmap-gtt: SKIP (0.001s)
[449.934831] [080/133] (571s left) kms_cursor_crc (cursor-offscreen-64x21)
[450.120256] Starting subtest: cursor-offscreen-64x21
[450.167433] Subtest cursor-offscreen-64x21: SKIP (0.044s)
[450.430716] [081/133] (571s left) kms_psr (fbc-pr-cursor-render)
[450.519650] Starting subtest: fbc-pr-cursor-render
[450.521493] Subtest fbc-pr-cursor-render: SKIP (0.000s)
[450.587832] [082/133] (571s left) kms_plane_scaling (plane-upscale-20x20-with-pixel-format)
[450.668509] Starting subtest: plane-upscale-20x20-with-pixel-format
[450.669386] Starting dynamic subtest: pipe-A
[451.717901] Dynamic subtest pipe-A: SUCCESS (1.050s)
[451.729309] Starting dynamic subtest: pipe-B
[453.792515] Dynamic subtest pipe-B: SUCCESS (2.074s)
[453.803432] Starting dynamic subtest: pipe-C
[454.983671] Dynamic subtest pipe-C: SUCCESS (1.189s)
[454.995628] Starting dynamic subtest: pipe-D
[456.214912] Dynamic subtest pipe-D: SUCCESS (1.230s)
[456.216734] Subtest plane-upscale-20x20-with-pixel-format: SUCCESS (5.549s)
[457.400731] [083/133] (564s left) kms_invalid_mode (uint-max-clock)
[457.495733] Starting subtest: uint-max-clock
[457.496598] Starting dynamic subtest: pipe-A-eDP-1
[457.784357] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.286s)
[457.793887] Starting dynamic subtest: pipe-B-eDP-1
[457.794954] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[457.803926] Starting dynamic subtest: pipe-C-eDP-1
[457.805136] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[457.814233] Starting dynamic subtest: pipe-D-eDP-1
[457.815184] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[457.816155] Subtest uint-max-clock: SUCCESS (0.293s)
[458.639015] [084/133] (563s left) gem_pxp (verify-pxp-key-change-after-suspend-resume)
[458.751436] Starting subtest: verify-pxp-key-change-after-suspend-resume
[466.646895] Subtest verify-pxp-key-change-after-suspend-resume: SUCCESS (7.897s)
[472.799100] [085/133] (555s left) gem_exec_suspend (basic-s0)
[472.875390] Starting subtest: basic-S0
[472.876389] Starting dynamic subtest: smem
[493.986585] Dynamic subtest smem: SUCCESS (6.832s)
[493.987861] Subtest basic-S0: SUCCESS (6.834s)
[500.194933] [086/133] (533s left) kms_cursor_crc (cursor-rapid-movement-128x42)
[500.426591] Starting subtest: cursor-rapid-movement-128x42
[500.471666] Subtest cursor-rapid-movement-128x42: SKIP (0.044s)
[500.659354] [087/133] (533s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-32bpp-yftileccs-upscaling)
[500.748397] Starting subtest: flip-32bpp-yftile-to-32bpp-yftileccs-upscaling
[500.750222] Subtest flip-32bpp-yftile-to-32bpp-yftileccs-upscaling: SKIP (0.000s)
[500.820801] [088/133] (533s left) gen9_exec_parse (bb-chained)
[500.874337] Subtest bb-chained: SKIP (0.000s)
[500.939445] [089/133] (533s left) gem_spin_batch (engines)
[500.995356] Starting subtest: engines
[500.996464] Starting dynamic subtest: rcs0
[504.243021] Dynamic subtest rcs0: SUCCESS (3.276s)
[504.254974] Starting dynamic subtest: bcs0
[507.517891] Dynamic subtest bcs0: SUCCESS (3.261s)
[507.529566] Starting dynamic subtest: vcs0
[510.754889] Dynamic subtest vcs0: SUCCESS (3.252s)
[510.767005] Starting dynamic subtest: vcs1
[513.993438] Dynamic subtest vcs1: SUCCESS (3.248s)
[514.005332] Starting dynamic subtest: vecs0
[517.230977] Dynamic subtest vecs0: SUCCESS (3.242s)
[517.242758] Starting dynamic subtest: ccs0
[520.470296] Dynamic subtest ccs0: SUCCESS (3.242s)
[520.471564] Subtest engines: SUCCESS (19.537s)
[520.663101] [090/133] (513s left) gem_ctx_exec (basic-close-race)
[520.710774] Starting subtest: basic-close-race
[526.429834] Subtest basic-close-race: SUCCESS (5.680s)
[526.510533] [091/133] (507s left) kms_content_protection (atomic-dpms-hdcp14)
[526.655341] Starting subtest: atomic-dpms-hdcp14
[526.657464] Subtest atomic-dpms-hdcp14: SKIP (0.000s)
[526.789445] [092/133] (507s left) kms_color (ctm-0-50)
[526.877257] Starting subtest: ctm-0-50
[526.878150] Starting dynamic subtest: pipe-A-eDP-1
[530.369874] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.495s)
[530.379429] Starting dynamic subtest: pipe-B-eDP-1
[534.688461] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.315s)
[534.699452] Starting dynamic subtest: pipe-C-eDP-1
[538.719636] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.029s)
[538.729494] Starting dynamic subtest: pipe-D-eDP-1
[542.711524] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.990s)
[542.712447] Subtest ctm-0-50: SUCCESS (15.833s)
[543.535407] [093/133] (490s left) kms_busy (extended-modeset-hang-oldfb-with-reset)
[543.630889] Starting subtest: extended-modeset-hang-oldfb-with-reset
[543.632011] Starting dynamic subtest: pipe-A
[555.600676] Dynamic subtest pipe-A: SUCCESS (11.969s)
[555.612158] Starting dynamic subtest: pipe-D
[568.066712] Dynamic subtest pipe-D: SUCCESS (12.467s)
[568.067496] Subtest extended-modeset-hang-oldfb-with-reset: SUCCESS (24.440s)
[568.860163] [094/133] (465s left) kms_cursor_legacy (2x-long-cursor-vs-flip-atomic)
[568.975756] Starting subtest: 2x-long-cursor-vs-flip-atomic
[568.978892] Subtest 2x-long-cursor-vs-flip-atomic: SKIP (0.001s)
[569.117786] [095/133] (465s left) prime_mmap_coherency (read)
[569.169983] Starting subtest: read
[574.590434] Subtest read: SUCCESS (5.375s)
[574.656532] [096/133] (459s left) i915_drm_fdinfo (busy-hang)
[574.689046] Starting subtest: busy-hang
[574.690074] Starting dynamic subtest: rcs0
[574.718693] Dynamic subtest rcs0: SKIP (0.028s)
[574.737607] Starting dynamic subtest: bcs0
[574.739605] Dynamic subtest bcs0: SKIP (0.001s)
[574.748933] Starting dynamic subtest: vcs0
[574.750698] Dynamic subtest vcs0: SKIP (0.001s)
[574.762349] Starting dynamic subtest: vcs1
[574.763943] Dynamic subtest vcs1: SKIP (0.002s)
[574.774454] Starting dynamic subtest: vecs0
[574.776047] Dynamic subtest vecs0: SKIP (0.001s)
[574.786616] Starting dynamic subtest: ccs0
[574.788415] Dynamic subtest ccs0: SKIP (0.001s)
[574.790085] Subtest busy-hang: SKIP (0.039s)
[574.821282] [097/133] (459s left) kms_frontbuffer_tracking (fbcpsr-stridechange)
[574.919322] Starting subtest: fbcpsr-stridechange
[581.256975] Subtest fbcpsr-stridechange: SUCCESS (6.340s)
[581.412583] [098/133] (452s left) kms_cursor_crc (cursor-size-change)
[581.504934] Starting subtest: cursor-size-change
[581.505758] Starting dynamic subtest: pipe-A-eDP-1
[582.305032] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.799s)
[582.315190] Starting dynamic subtest: pipe-D-eDP-1
[583.743703] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.437s)
[583.744824] Subtest cursor-size-change: SUCCESS (2.239s)
[584.529552] [099/133] (449s left) kms_big_fb (4-tiled-addfb-size-overflow)
[584.617085] Starting subtest: 4-tiled-addfb-size-overflow
[584.618096] Subtest 4-tiled-addfb-size-overflow: SUCCESS (0.000s)
[584.709549] [100/133] (449s left) kms_pm_rpm (cursor)
[586.228912] Starting subtest: cursor
[586.231572] Subtest cursor: SKIP (0.000s)
[586.970794] [101/133] (447s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-cpu)
[587.060582] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-cpu
[593.804194] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-cpu: SUCCESS (6.746s)
[593.949932] [102/133] (440s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-mmap-cpu)
[594.039245] Starting subtest: fbcpsr-rgb101010-draw-mmap-cpu
[601.067872] Subtest fbcpsr-rgb101010-draw-mmap-cpu: SUCCESS (7.026s)
[601.189130] [103/133] (433s left) api_intel_bb (destroy-bb)
[601.239395] Starting subtest: destroy-bb
[601.246608] Subtest destroy-bb: SUCCESS (0.008s)
[601.385917] [104/133] (433s left) gem_userptr_blits (probe)
[601.458647] Starting subtest: probe
[601.544315] Subtest probe: SUCCESS (0.085s)
[601.652006] [105/133] (433s left) kms_psr2_sf (fbc-pr-cursor-plane-move-continuous-exceed-sf)
[601.738552] Starting subtest: fbc-pr-cursor-plane-move-continuous-exceed-sf
[601.740149] Subtest fbc-pr-cursor-plane-move-continuous-exceed-sf: SKIP (0.000s)
[601.808886] [106/133] (432s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-blt)
[601.897041] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-blt
[608.750220] Subtest psr-1p-offscreen-pri-shrfb-draw-blt: SUCCESS (6.849s)
[608.917950] [107/133] (425s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-mmap-gtt)
[609.009957] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-mmap-gtt
[609.011519] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[609.115456] [108/133] (425s left) kms_rotation_crc (primary-4-tiled-reflect-x-0)
[609.214600] Starting subtest: primary-4-tiled-reflect-x-0
[616.319015] Subtest primary-4-tiled-reflect-x-0: SUCCESS (7.103s)
[617.543158] [109/133] (417s left) gem_pwrite (basic-self)
[617.590270] Subtest basic-self: SKIP (0.000s)
[617.644134] [110/133] (417s left) kms_cursor_legacy (cursora-vs-flipa-atomic)
[617.761877] Starting subtest: cursorA-vs-flipA-atomic
[628.900734] Subtest cursorA-vs-flipA-atomic: SUCCESS (11.137s)
[629.788652] [111/133] (405s left) syncobj_timeline (multi-wait-for-submit-available-submitted)
[629.841549] Starting subtest: multi-wait-for-submit-available-submitted
[629.842470] Subtest multi-wait-for-submit-available-submitted: SUCCESS (0.000s)
[629.950653] [112/133] (405s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy)
[630.035717] Subtest addfb25-x-tiled-mismatch-legacy: SKIP (0.000s)
[630.134744] [113/133] (404s left) gem_softpin (evict-snoop)
[630.190041] Starting subtest: evict-snoop
[630.192074] Subtest evict-snoop: SKIP (0.000s)
[630.321117] [114/133] (404s left) gem_exec_params (dr1-dirt)
[630.383887] Starting subtest: DR1-dirt
[630.384793] Subtest DR1-dirt: SUCCESS (0.000s)
[630.479049] [115/133] (404s left) gem_exec_nop (basic-sequential)
[630.544152] Starting subtest: basic-sequential
[645.436925] Subtest basic-sequential: SUCCESS (14.896s)
[645.659182] [116/133] (389s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-pwrite)
[645.758171] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-pwrite
[645.760002] Subtest psr-2p-scndscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[645.863898] [117/133] (389s left) vgem_basic (dmabuf-mmap)
[645.903013] Starting subtest: dmabuf-mmap
[645.947635] Subtest dmabuf-mmap: SUCCESS (0.045s)
[646.004937] [118/133] (389s left) kms_psr (fbc-psr2-primary-render)
[646.093979] Starting subtest: fbc-psr2-primary-render
[646.094871] Starting dynamic subtest: eDP-1
[646.096583] Dynamic subtest eDP-1: SKIP (0.000s)
[646.098161] Subtest fbc-psr2-primary-render: SKIP (0.001s)
[646.166973] [119/133] (389s left) kms_atomic (plane-immutable-zpos)
[646.244680] Starting subtest: plane-immutable-zpos
[646.245717] Starting dynamic subtest: pipe-A-eDP-1
[646.901278] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.655s)
[646.902384] Subtest plane-immutable-zpos: SUCCESS (0.657s)
[647.717404] [120/133] (387s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-blt)
[647.800159] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-blt
[647.801775] Subtest fbc-2p-scndscrn-pri-indfb-draw-blt: SKIP (0.000s)
[647.899592] [121/133] (387s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size)
[648.007912] Starting subtest: basic-flip-after-cursor-varying-size
[648.943966] Subtest basic-flip-after-cursor-varying-size: SUCCESS (0.935s)
[649.743382] [122/133] (385s left) kms_atomic_transition (plane-all-transition-nonblocking-fencing)
[649.832999] Starting subtest: plane-all-transition-nonblocking-fencing
[649.833919] Starting dynamic subtest: pipe-A-eDP-1
[652.328952] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.496s)
[652.638900] Starting dynamic subtest: pipe-B-eDP-1
[655.879002] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.249s)
[656.178468] Subtest plane-all-transition-nonblocking-fencing: SUCCESS (6.344s)
[656.997282] [123/133] (378s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-pwrite)
[657.091244] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-pwrite
[657.093083] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[657.186153] [124/133] (378s left) kms_tiled_display (basic-test-pattern)
[657.291503] Subtest basic-test-pattern: SKIP (0.000s)
[657.334195] [125/133] (378s left) kms_plane_lowres (tiling-x)
[657.413140] Starting subtest: tiling-x
[657.414075] Starting dynamic subtest: pipe-A-eDP-1
[657.416046] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[657.717334] Starting dynamic subtest: pipe-B-eDP-1
[657.719225] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[657.728921] Starting dynamic subtest: pipe-C-eDP-1
[657.730777] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[657.740022] Starting dynamic subtest: pipe-D-eDP-1
[657.741872] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[657.743465] Subtest tiling-x: SKIP (0.302s)
[658.534509] [126/133] (376s left) gem_exec_schedule (in-order)
[658.592829] Starting subtest: in-order
[658.593648] Starting dynamic subtest: rcs0
[658.696617] Dynamic subtest rcs0: SUCCESS (0.103s)
[658.706905] Starting dynamic subtest: vcs0
[658.791432] Dynamic subtest vcs0: SUCCESS (0.094s)
[658.804171] Starting dynamic subtest: vcs1
[658.873986] Dynamic subtest vcs1: SUCCESS (0.082s)
[658.886014] Starting dynamic subtest: vecs0
[658.956127] Dynamic subtest vecs0: SUCCESS (0.080s)
[658.966430] Starting dynamic subtest: ccs0
[659.040014] Dynamic subtest ccs0: SUCCESS (0.083s)
[659.041447] Subtest in-order: SUCCESS (0.447s)
[660.021804] [127/133] (375s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-mmap-wc)
[660.108614] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-mmap-wc
[666.763299] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-mmap-wc: SUCCESS (6.657s)
[666.894256] [128/133] (368s left) kms_frontbuffer_tracking (psr-slowdraw)
[666.979647] Starting subtest: psr-slowdraw
[692.348108] Subtest psr-slowdraw: SUCCESS (25.374s)
[692.478382] [129/133] (343s left) syncobj_wait (wait-any-interrupted)
[692.530967] Starting subtest: wait-any-interrupted
[692.637329] Subtest wait-any-interrupted: SUCCESS (0.106s)
[692.725300] [130/133] (342s left) gem_ctx_persistence (engines-queued)
[692.784730] Starting subtest: engines-queued
[692.785565] Starting dynamic subtest: rcs0
[692.871299] Dynamic subtest rcs0: SUCCESS (0.086s)
[692.884933] Starting dynamic subtest: bcs0
[692.910532] Dynamic subtest bcs0: SUCCESS (0.037s)
[692.921683] Starting dynamic subtest: vcs0
[694.911856] Dynamic subtest vcs0: SUCCESS (1.990s)
[694.922190] Starting dynamic subtest: vcs1
[696.959902] Dynamic subtest vcs1: SUCCESS (2.044s)
[696.971211] Starting dynamic subtest: vecs0
[698.945374] Dynamic subtest vecs0: SUCCESS (1.983s)
[698.956142] Starting dynamic subtest: ccs0
[699.105784] Dynamic subtest ccs0: SUCCESS (0.168s)
[699.107077] Subtest engines-queued: SUCCESS (6.323s)
[699.229926] [131/133] (336s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-render)
[699.317704] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-render
[699.319346] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-render: SKIP (0.000s)
[699.411590] [132/133] (336s left) gem_mmap_gtt (medium-copy)
[699.452984] Subtest medium-copy: SKIP (0.000s)
[699.517964] [133/133] (336s left) i915_pm_rps (waitboost)
[699.572962] Starting subtest: waitboost
[705.673856] Subtest waitboost: SUCCESS (6.095s)
[705.778699] Closing watchdogs
results: parsing output: 0/ for test: kms_dsc
results: parsing output: 1/ for test: gem_eio
results: parsing output: 2/ for test: kms_ccs
results: parsing output: 3/ for test: gem_exec_alignment
results: parsing output: 4/ for test: kms_flip
results: parsing output: 5/ for test: kms_pm_rpm
results: parsing output: 6/ for test: syncobj_timeline
results: parsing output: 7/ for test: kms_dp_link_training
results: parsing output: 8/ for test: syncobj_timeline
results: parsing output: 9/ for test: kms_vblank
results: parsing output: 10/ for test: kms_flip
results: parsing output: 11/ for test: syncobj_timeline
results: parsing output: 12/ for test: gem_exec_params
results: parsing output: 13/ for test: kms_plane_scaling
results: parsing output: 14/ for test: kms_frontbuffer_tracking
results: parsing output: 15/ for test: i915_drm_fdinfo
results: parsing output: 16/ for test: gem_lmem_swapping
results: parsing output: 17/ for test: kms_plane
results: parsing output: 18/ for test: sw_sync
results: parsing output: 19/ for test: kms_frontbuffer_tracking
results: parsing output: 20/ for test: gem_render_copy
results: parsing output: 21/ for test: drm_read
results: parsing output: 22/ for test: gem_exec_schedule
results: parsing output: 23/ for test: i915_pm_rpm
results: parsing output: 24/ for test: gem_exec_fence
results: parsing output: 25/ for test: gem_ccs
results: parsing output: 26/ for test: kms_big_fb
results: parsing output: 27/ for test: kms_ccs
results: parsing output: 28/ for test: prime_mmap
results: parsing output: 29/ for test: kms_big_fb
results: parsing output: 30/ for test: gem_readwrite
results: parsing output: 31/ for test: kms_flip
results: parsing output: 32/ for test: kms_ccs
results: parsing output: 33/ for test: gem_mmap_offset
results: parsing output: 34/ for test: kms_frontbuffer_tracking
results: parsing output: 35/ for test: gem_tiled_blits
results: parsing output: 36/ for test: kms_psr2_sf
results: parsing output: 37/ for test: kms_chamelium_color
results: parsing output: 38/ for test: kms_frontbuffer_tracking
results: parsing output: 39/ for test: kms_ccs
results: parsing output: 40/ for test: vgem_basic
results: parsing output: 41/ for test: perf_pmu
results: parsing output: 42/ for test: gem_mmap_gtt
results: parsing output: 43/ for test: perf_pmu
results: parsing output: 44/ for test: kms_cursor_crc
results: parsing output: 45/ for test: kms_flip
results: parsing output: 46/ for test: kms_chamelium_hpd
results: parsing output: 47/ for test: gem_ctx_param
results: parsing output: 48/ for test: gem_mmap_wc
results: parsing output: 49/ for test: kms_big_fb
results: parsing output: 50/ for test: kms_cursor_legacy
results: parsing output: 51/ for test: gem_exec_balancer
results: parsing output: 52/ for test: kms_psr
results: parsing output: 53/ for test: kms_fbcon_fbt
results: parsing output: 54/ for test: kms_frontbuffer_tracking
results: parsing output: 55/ for test: syncobj_timeline
results: parsing output: 56/ for test: gem_exec_balancer
results: parsing output: 57/ for test: gem_exec_schedule
results: parsing output: 58/ for test: api_intel_bb
results: parsing output: 59/ for test: syncobj_wait
results: parsing output: 60/ for test: kms_lease
results: parsing output: 61/ for test: kms_chamelium_edid
results: parsing output: 62/ for test: sysfs_preempt_timeout
results: parsing output: 63/ for test: kms_frontbuffer_tracking
results: parsing output: 64/ for test: gem_exec_flush
results: parsing output: 65/ for test: kms_big_fb
results: parsing output: 66/ for test: kms_flip_scaled_crc
results: parsing output: 67/ for test: perf_pmu
results: parsing output: 68/ for test: kms_frontbuffer_tracking
results: parsing output: 69/ for test: kms_big_fb
results: parsing output: 70/ for test: kms_addfb_basic
results: parsing output: 71/ for test: kms_cursor_legacy
results: parsing output: 72/ for test: gem_ctx_persistence
results: parsing output: 73/ for test: kms_pipe_crc_basic
results: parsing output: 74/ for test: gem_exec_reloc
results: parsing output: 75/ for test: kms_psr
results: parsing output: 76/ for test: kms_plane_scaling
results: parsing output: 77/ for test: gem_mmap_wc
results: parsing output: 78/ for test: kms_psr
results: parsing output: 79/ for test: kms_cursor_crc
results: parsing output: 80/ for test: kms_psr
results: parsing output: 81/ for test: kms_plane_scaling
results: parsing output: 82/ for test: kms_invalid_mode
results: parsing output: 83/ for test: gem_pxp
results: parsing output: 84/ for test: gem_exec_suspend
results: parsing output: 85/ for test: kms_cursor_crc
results: parsing output: 86/ for test: kms_flip_scaled_crc
results: parsing output: 87/ for test: gen9_exec_parse
results: parsing output: 88/ for test: gem_spin_batch
results: parsing output: 89/ for test: gem_ctx_exec
results: parsing output: 90/ for test: kms_content_protection
results: parsing output: 91/ for test: kms_color
results: parsing output: 92/ for test: kms_busy
results: parsing output: 93/ for test: kms_cursor_legacy
results: parsing output: 94/ for test: prime_mmap_coherency
results: parsing output: 95/ for test: i915_drm_fdinfo
results: parsing output: 96/ for test: kms_frontbuffer_tracking
results: parsing output: 97/ for test: kms_cursor_crc
results: parsing output: 98/ for test: kms_big_fb
results: parsing output: 99/ for test: kms_pm_rpm
results: parsing output: 100/ for test: kms_frontbuffer_tracking
results: parsing output: 101/ for test: kms_frontbuffer_tracking
results: parsing output: 102/ for test: api_intel_bb
results: parsing output: 103/ for test: gem_userptr_blits
results: parsing output: 104/ for test: kms_psr2_sf
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_rotation_crc
results: parsing output: 108/ for test: gem_pwrite
results: parsing output: 109/ for test: kms_cursor_legacy
results: parsing output: 110/ for test: syncobj_timeline
results: parsing output: 111/ for test: kms_addfb_basic
results: parsing output: 112/ for test: gem_softpin
results: parsing output: 113/ for test: gem_exec_params
results: parsing output: 114/ for test: gem_exec_nop
results: parsing output: 115/ for test: kms_frontbuffer_tracking
results: parsing output: 116/ for test: vgem_basic
results: parsing output: 117/ for test: kms_psr
results: parsing output: 118/ for test: kms_atomic
results: parsing output: 119/ for test: kms_frontbuffer_tracking
results: parsing output: 120/ for test: kms_cursor_legacy
results: parsing output: 121/ for test: kms_atomic_transition
results: parsing output: 122/ for test: kms_frontbuffer_tracking
results: parsing output: 123/ for test: kms_tiled_display
results: parsing output: 124/ for test: kms_plane_lowres
results: parsing output: 125/ for test: gem_exec_schedule
results: parsing output: 126/ for test: kms_frontbuffer_tracking
results: parsing output: 127/ for test: kms_frontbuffer_tracking
results: parsing output: 128/ for test: syncobj_wait
results: parsing output: 129/ for test: gem_ctx_persistence
results: parsing output: 130/ for test: kms_frontbuffer_tracking
results: parsing output: 131/ for test: gem_mmap_gtt
results: parsing output: 132/ for test: i915_pm_rps
Done.