[58.053499] Initializing watchdogs
[58.053544]   /dev/watchdog0
[58.067080] [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.071320] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[58.073530] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[58.077169] [001/133] (960s left) drm_read (short-buffer-nonblock)
[58.281751] Starting subtest: short-buffer-nonblock
[58.284051] Subtest short-buffer-nonblock: SUCCESS (0.000s)
[58.401395] [002/133] (960s left) gem_render_copy (y-tiled-mc-ccs-to-vebox-y-tiled)
[58.473127] Starting subtest: y-tiled-mc-ccs-to-vebox-y-tiled
[58.477593] Subtest y-tiled-mc-ccs-to-vebox-y-tiled: SKIP (0.000s)
[58.653975] [003/133] (959s left) syncobj_timeline (wait-for-submit-delayed-submit)
[58.706058] Starting subtest: wait-for-submit-delayed-submit
[58.810559] Subtest wait-for-submit-delayed-submit: SUCCESS (0.104s)
[58.879302] [004/133] (959s left) kms_addfb_basic (bo-too-small-due-to-tiling)
[58.985944] Starting subtest: bo-too-small-due-to-tiling
[58.990323] Subtest bo-too-small-due-to-tiling: SKIP (0.000s)
[59.075945] [005/133] (959s left) gem_ctx_persistence (userptr)
[59.145850] Starting subtest: userptr
[59.343546] Subtest userptr: SUCCESS (0.197s)
[59.416700] [006/133] (959s left) syncobj_timeline (invalid-query-one-illegal-handle)
[59.474937] Starting subtest: invalid-query-one-illegal-handle
[59.477371] Subtest invalid-query-one-illegal-handle: SUCCESS (0.001s)
[59.573491] [007/133] (959s left) kms_pm_backlight (fade)
[59.661698] Starting subtest: fade
[59.709537] Starting dynamic subtest: eDP-1
[62.190872] Dynamic subtest eDP-1: SUCCESS (2.479s)
[62.193419] Subtest fade: SUCCESS (2.529s)
[63.012187] [008/133] (955s left) kms_ccs (crc-primary-suspend-4-tiled-mtl-rc-ccs-cc)
[63.115138] Starting subtest: crc-primary-suspend-4-tiled-mtl-rc-ccs-cc
[63.117409] Starting dynamic subtest: pipe-A-eDP-1
[79.679719] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.523s)
[79.689760] Starting dynamic subtest: pipe-B-eDP-1
[96.644402] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.423s)
[96.654671] Starting dynamic subtest: pipe-C-eDP-1
[113.638626] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.419s)
[113.647791] Starting dynamic subtest: pipe-D-eDP-1
[130.619576] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.314s)
[130.621900] Subtest crc-primary-suspend-4-tiled-mtl-rc-ccs-cc: SUCCESS (8.684s)
[131.842192] [009/133] (887s left) gem_exec_suspend (basic-s3)
[131.903951] Starting subtest: basic-S3
[131.906489] Starting dynamic subtest: smem
[152.399064] Dynamic subtest smem: SUCCESS (6.799s)
[152.402167] Subtest basic-S3: SUCCESS (6.801s)
[152.579315] [010/133] (866s left) sw_sync (sync_random_merge)
[152.620422] Starting subtest: sync_random_merge
[152.666903] Subtest sync_random_merge: SUCCESS (0.047s)
[152.727307] [011/133] (866s left) kms_dirtyfb (drrs-dirtyfb-ioctl)
[152.814635] Starting subtest: drrs-dirtyfb-ioctl
[152.830031] Subtest drrs-dirtyfb-ioctl: SKIP (0.001s)
[152.916928] [012/133] (866s left) syncobj_timeline (multi-wait-for-submit-signaled)
[152.975192] Starting subtest: multi-wait-for-submit-signaled
[152.977948] Subtest multi-wait-for-submit-signaled: SUCCESS (0.000s)
[153.066210] [013/133] (865s left) fbdev (nullptr)
[153.107489] Starting subtest: nullptr
[153.109971] Subtest nullptr: SUCCESS (0.000s)
[153.161655] [014/133] (865s left) kms_joiner (switch-modeset-ultra-joiner-big-joiner)
[153.264959] Starting subtest: switch-modeset-ultra-joiner-big-joiner
[153.269932] Subtest switch-modeset-ultra-joiner-big-joiner: SKIP (0.000s)
[153.327217] [015/133] (865s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-pwrite)
[153.434798] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-pwrite
[153.439677] Subtest fbc-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[153.530171] [016/133] (865s left) kms_plane (pixel-format-yf-tiled-ccs-modifier-source-clamping)
[153.625685] Starting subtest: pixel-format-yf-tiled-ccs-modifier-source-clamping
[153.630064] Subtest pixel-format-yf-tiled-ccs-modifier-source-clamping: SKIP (0.000s)
[153.693877] [017/133] (865s left) prime_busy (hang)
[153.767129] Starting subtest: hang
[153.769313] Starting dynamic subtest: rcs0
[179.947646] Dynamic subtest rcs0: SUCCESS (26.167s)
[179.958515] Starting dynamic subtest: bcs0
[187.102045] Dynamic subtest bcs0: SUCCESS (7.151s)
[187.111779] Starting dynamic subtest: vcs0
[194.072116] Dynamic subtest vcs0: SUCCESS (6.967s)
[194.082126] Starting dynamic subtest: vcs1
[201.049852] Dynamic subtest vcs1: SUCCESS (6.978s)
[201.060162] Starting dynamic subtest: vecs0
[208.085295] Dynamic subtest vecs0: SUCCESS (7.032s)
[208.096044] Starting dynamic subtest: ccs0
[221.928147] Dynamic subtest ccs0: SUCCESS (13.836s)
[221.931228] Subtest hang: SUCCESS (68.136s)
[222.041127] [018/133] (797s left) syncobj_timeline (single-wait-all-for-submit-available-submitted)
[222.094185] Starting subtest: single-wait-all-for-submit-available-submitted
[222.096819] Subtest single-wait-all-for-submit-available-submitted: SUCCESS (0.000s)
[222.208395] [019/133] (797s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted-signaled)
[222.272550] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted-signaled
[222.378763] Subtest etime-multi-wait-all-for-submit-unsubmitted-signaled: SUCCESS (0.106s)
[222.470670] [020/133] (796s left) gem_spin_batch (resubmit-new)
[222.541542] Starting subtest: resubmit-new
[222.544869] Starting dynamic subtest: rcs0
[222.557771] Dynamic subtest rcs0: SUCCESS (0.016s)
[222.567322] Starting dynamic subtest: bcs0
[222.569910] Dynamic subtest bcs0: SUCCESS (0.010s)
[222.578208] Starting dynamic subtest: vcs0
[222.580700] Dynamic subtest vcs0: SUCCESS (0.008s)
[222.589719] Starting dynamic subtest: vcs1
[222.592255] Dynamic subtest vcs1: SUCCESS (0.010s)
[222.600407] Starting dynamic subtest: vecs0
[222.602305] Dynamic subtest vecs0: SUCCESS (0.009s)
[222.609689] Starting dynamic subtest: ccs0
[222.612130] Dynamic subtest ccs0: SUCCESS (0.014s)
[222.614920] Subtest resubmit-new: SUCCESS (0.069s)
[224.441407] [021/133] (794s left) kms_big_fb (yf-tiled-32bpp-rotate-270)
[224.543485] Starting subtest: yf-tiled-32bpp-rotate-270
[224.548792] Subtest yf-tiled-32bpp-rotate-270: SKIP (0.000s)
[224.636258] [022/133] (794s left) gem_mmap_offset (blt-coherency)
[224.708868] Starting subtest: blt-coherency
[224.713931] Subtest blt-coherency: SUCCESS (0.008s)
[224.828276] [023/133] (794s left) gem_readwrite (read-write)
[224.884944] Subtest read-write: SKIP (0.000s)
[224.947281] [024/133] (794s left) kms_big_fb (4-tiled-16bpp-rotate-0)
[225.053457] Starting subtest: 4-tiled-16bpp-rotate-0
[226.287472] Subtest 4-tiled-16bpp-rotate-0: SUCCESS (1.234s)
[226.408439] [025/133] (793s left) perf_pmu (invalid-init)
[226.455774] Starting subtest: invalid-init
[226.458404] Subtest invalid-init: SUCCESS (0.000s)
[226.563619] [026/133] (792s left) kms_psr2_sf (fbc-psr2-overlay-plane-move-continuous-sf)
[226.666471] Starting subtest: fbc-psr2-overlay-plane-move-continuous-sf
[226.668543] Starting dynamic subtest: pipe-A-eDP-1
[226.764938] Dynamic subtest pipe-A-eDP-1: SKIP (0.101s)
[226.774524] Starting dynamic subtest: pipe-B-eDP-1
[227.912584] Dynamic subtest pipe-B-eDP-1: SKIP (1.145s)
[227.917369] Subtest fbc-psr2-overlay-plane-move-continuous-sf: SKIP (1.248s)
[229.104271] [027/133] (790s left) kms_plane_scaling (plane-downscale-factor-0-75-with-rotation)
[229.195813] Starting subtest: plane-downscale-factor-0-75-with-rotation
[229.198476] Starting dynamic subtest: pipe-A
[229.426025] Dynamic subtest pipe-A: SUCCESS (0.230s)
[229.434631] Starting dynamic subtest: pipe-B
[230.697229] Dynamic subtest pipe-B: SUCCESS (1.270s)
[230.706168] Starting dynamic subtest: pipe-C
[232.038973] Dynamic subtest pipe-C: SUCCESS (1.341s)
[232.047576] Starting dynamic subtest: pipe-D
[233.345002] Dynamic subtest pipe-D: SUCCESS (1.305s)
[233.347981] Subtest plane-downscale-factor-0-75-with-rotation: SUCCESS (4.148s)
[234.535437] [028/133] (785s left) api_intel_bb (full-batch)
[234.590178] Starting subtest: full-batch
[234.595431] Subtest full-batch: SUCCESS (0.007s)
[234.707357] [029/133] (784s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-blt)
[234.802124] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-blt
[242.103898] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-blt: SUCCESS (7.302s)
[242.236420] [030/133] (777s left) kms_addfb_basic (invalid-get-prop-any)
[242.303145] Starting subtest: invalid-get-prop-any
[242.305867] Subtest invalid-get-prop-any: SUCCESS (0.000s)
[242.432482] [031/133] (777s left) kms_psr2_sf (fbc-pr-overlay-plane-update-continuous-sf)
[242.541966] Starting subtest: fbc-pr-overlay-plane-update-continuous-sf
[242.547437] Subtest fbc-pr-overlay-plane-update-continuous-sf: SKIP (0.000s)
[242.631025] [032/133] (777s left) gem_lmem_swapping (parallel-random)
[242.686002] Subtest parallel-random: SKIP (0.000s)
[242.729162] [033/133] (777s left) gem_exec_reloc (basic-gtt-wc)
[242.782056] Subtest basic-gtt-wc: SKIP (0.000s)
[242.851204] [034/133] (777s left) syncobj_timeline (etime-single-wait-all-available-unsubmitted)
[242.899725] Starting subtest: etime-single-wait-all-available-unsubmitted
[243.000615] Subtest etime-single-wait-all-available-unsubmitted: SUCCESS (0.102s)
[243.076339] [035/133] (776s left) kms_psr (fbc-pr-cursor-mmap-cpu)
[243.167603] Starting subtest: fbc-pr-cursor-mmap-cpu
[243.172402] Subtest fbc-pr-cursor-mmap-cpu: SKIP (0.000s)
[243.237015] [036/133] (776s left) kms_frontbuffer_tracking (psr-rgb565-draw-mmap-wc)
[243.334553] Starting subtest: psr-rgb565-draw-mmap-wc
[250.128989] Subtest psr-rgb565-draw-mmap-wc: SUCCESS (6.797s)
[250.229678] [037/133] (769s left) kms_vblank (query-forked)
[250.320817] Starting subtest: query-forked
[250.322970] Starting dynamic subtest: pipe-A-eDP-1
[252.140677] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.819s)
[252.156938] Starting dynamic subtest: pipe-D-eDP-1
[254.677521] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.537s)
[254.680152] Subtest query-forked: SUCCESS (4.360s)
[255.526411] [038/133] (764s left) sw_sync (sync_expired_merge)
[255.566124] Starting subtest: sync_expired_merge
[256.640322] Subtest sync_expired_merge: SUCCESS (1.074s)
[256.711902] [039/133] (763s left) gen9_exec_parse (allowed-single)
[256.773136] Subtest allowed-single: SKIP (0.000s)
[256.850102] [040/133] (763s left) gem_mmap (short-mmap)
[256.904132] Subtest short-mmap: SKIP (0.000s)
[256.967136] [041/133] (763s left) kms_frontbuffer_tracking (psr-2p-primscrn-shrfb-msflip-blt)
[257.055272] Starting subtest: psr-2p-primscrn-shrfb-msflip-blt
[257.059771] Subtest psr-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[257.152418] [042/133] (763s left) gem_exec_schedule (preempt-self)
[257.222827] Starting subtest: preempt-self
[257.225395] Starting dynamic subtest: rcs0
[257.233000] Dynamic subtest rcs0: SUCCESS (0.021s)
[257.243660] Starting dynamic subtest: bcs0
[257.255152] Dynamic subtest bcs0: SUCCESS (0.022s)
[257.266567] Starting dynamic subtest: vcs0
[257.277999] Dynamic subtest vcs0: SUCCESS (0.022s)
[257.286179] Starting dynamic subtest: vcs1
[257.295189] Dynamic subtest vcs1: SUCCESS (0.017s)
[257.303206] Starting dynamic subtest: vecs0
[257.316053] Dynamic subtest vecs0: SUCCESS (0.021s)
[257.324299] Starting dynamic subtest: ccs0
[257.333172] Dynamic subtest ccs0: SUCCESS (0.017s)
[257.336025] Subtest preempt-self: SUCCESS (0.122s)
[258.484039] [043/133] (761s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-blt)
[258.589559] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-blt
[258.594813] Subtest psr-2p-scndscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[258.677721] [044/133] (761s left) gem_exec_capture (pi)
[258.751441] Starting subtest: pi
[258.753792] Starting dynamic subtest: rcs0
[262.915183] Dynamic subtest rcs0: SUCCESS (4.167s)
[262.925991] Starting dynamic subtest: bcs0
[266.746142] Dynamic subtest bcs0: SUCCESS (3.832s)
[266.755068] Starting dynamic subtest: vcs0
[270.578429] Dynamic subtest vcs0: SUCCESS (3.831s)
[270.589047] Starting dynamic subtest: vcs1
[274.429496] Dynamic subtest vcs1: SUCCESS (3.851s)
[274.440153] Starting dynamic subtest: vecs0
[278.353964] Dynamic subtest vecs0: SUCCESS (3.924s)
[278.366145] Starting dynamic subtest: ccs0
[282.230122] Dynamic subtest ccs0: SUCCESS (3.875s)
[282.233018] Subtest pi: SUCCESS (23.487s)
[282.311889] [045/133] (738s left) kms_psr (pr-sprite-blt)
[282.465722] Starting subtest: pr-sprite-blt
[282.470812] Subtest pr-sprite-blt: SKIP (0.000s)
[282.533961] [046/133] (737s left) gem_exec_fence (syncobj-backward-timeline-chain-engines)
[283.107765] Starting subtest: syncobj-backward-timeline-chain-engines
[283.227824] Subtest syncobj-backward-timeline-chain-engines: SUCCESS (0.120s)
[284.444653] [FACT gem_exec_fence (syncobj-backward-timeline-chain-engines)] new: kernel.kmod_is_loaded.vgem: true
[284.448278] [047/133] (735s left) gem_partial_pwrite_pread (write)
[284.501516] Subtest write: SKIP (0.000s)
[284.556195] [048/133] (735s left) prime_self_import (basic-with_one_bo_two_files)
[284.592645] Starting subtest: basic-with_one_bo_two_files
[284.609135] Subtest basic-with_one_bo_two_files: SUCCESS (0.017s)
[284.694622] [049/133] (735s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-mmap-wc)
[284.805124] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-mmap-wc
[288.760601] Subtest fbc-1p-offscreen-pri-indfb-draw-mmap-wc: SUCCESS (3.962s)
[289.914244] [050/133] (730s left) i915_drm_fdinfo (busy)
[289.955990] Starting subtest: busy
[289.959187] Starting dynamic subtest: rcs0
[289.982450] Dynamic subtest rcs0: SKIP (0.023s)
[289.993299] Starting dynamic subtest: bcs0
[289.998523] Dynamic subtest bcs0: SKIP (0.000s)
[290.007362] Starting dynamic subtest: vcs0
[290.012939] Dynamic subtest vcs0: SKIP (0.000s)
[290.022013] Starting dynamic subtest: vcs1
[290.027903] Dynamic subtest vcs1: SKIP (0.000s)
[290.038140] Starting dynamic subtest: vecs0
[290.043851] Dynamic subtest vecs0: SKIP (0.000s)
[290.053036] Starting dynamic subtest: ccs0
[290.058936] Dynamic subtest ccs0: SKIP (0.000s)
[290.064401] Subtest busy: SKIP (0.027s)
[290.102473] [051/133] (730s left) gem_vm_create (execbuf)
[290.173728] Starting subtest: execbuf
[290.181295] Subtest execbuf: SUCCESS (0.009s)
[290.304236] [052/133] (730s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-pwrite)
[290.398919] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-pwrite
[295.762151] Subtest fbc-1p-primscrn-pri-indfb-draw-pwrite: SUCCESS (5.368s)
[296.900100] [053/133] (723s left) syncobj_wait (multi-wait-all-submitted-signaled)
[296.958845] Starting subtest: multi-wait-all-submitted-signaled
[297.066319] Subtest multi-wait-all-submitted-signaled: SUCCESS (0.106s)
[297.142451] [054/133] (723s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-onoff)
[297.256956] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-onoff
[304.360914] Subtest fbcpsr-1p-primscrn-spr-indfb-onoff: SUCCESS (7.108s)
[304.498473] [055/133] (716s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip)
[304.596667] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip
[304.601730] Subtest y-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip: SKIP (0.000s)
[304.695430] [056/133] (716s left) kms_rmfb (rmfb-ioctl)
[304.783988] Starting subtest: rmfb-ioctl
[304.786389] Starting dynamic subtest: pipe-A-eDP-1
[304.887789] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.107s)
[304.898777] Starting dynamic subtest: pipe-B-eDP-1
[306.078313] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.188s)
[306.088951] Starting dynamic subtest: pipe-C-eDP-1
[307.215004] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.136s)
[307.225811] Starting dynamic subtest: pipe-D-eDP-1
[308.341663] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.125s)
[308.344451] Subtest rmfb-ioctl: SUCCESS (3.561s)
[309.477838] [057/133] (711s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-cpu)
[309.581955] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-cpu
[309.587076] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[309.675517] [058/133] (711s left) gem_partial_pwrite_pread (writes-after-reads-snoop)
[309.724925] Subtest writes-after-reads-snoop: SKIP (0.000s)
[309.806522] [059/133] (711s left) kms_cursor_legacy (cursorb-vs-flipb-atomic)
[309.921514] Starting subtest: cursorB-vs-flipB-atomic
[309.926862] Subtest cursorB-vs-flipB-atomic: SKIP (0.001s)
[310.078008] [060/133] (710s left) kms_vblank (ts-continuation-idle)
[310.169980] Starting subtest: ts-continuation-idle
[310.172938] Starting dynamic subtest: pipe-A-eDP-1
[310.573977] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.402s)
[310.589068] Starting dynamic subtest: pipe-D-eDP-1
[311.692174] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.114s)
[311.695154] Subtest ts-continuation-idle: SUCCESS (1.519s)
[312.553724] [061/133] (708s left) kms_invalid_mode (clock-too-high)
[312.650891] Starting subtest: clock-too-high
[312.653476] Starting dynamic subtest: pipe-A-eDP-1
[312.658507] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[312.667940] Starting dynamic subtest: pipe-B-eDP-1
[312.672994] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[312.682134] Starting dynamic subtest: pipe-C-eDP-1
[312.686855] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[312.695149] Starting dynamic subtest: pipe-D-eDP-1
[312.699910] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[312.704710] Subtest clock-too-high: SKIP (0.004s)
[312.743459] [062/133] (708s left) kms_big_fb (x-tiled-32bpp-rotate-180)
[312.833954] Starting subtest: x-tiled-32bpp-rotate-180
[314.190819] Subtest x-tiled-32bpp-rotate-180: SUCCESS (1.357s)
[314.348575] [063/133] (706s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-render)
[314.446698] Starting subtest: psr-1p-primscrn-cur-indfb-draw-render
[321.272754] Subtest psr-1p-primscrn-cur-indfb-draw-render: SUCCESS (6.828s)
[321.411992] [064/133] (699s left) kms_flip (flip-vs-dpms-on-nop)
[321.507881] Starting subtest: flip-vs-dpms-on-nop
[321.510264] Starting dynamic subtest: A-eDP1
[323.373064] Dynamic subtest A-eDP1: SUCCESS (1.866s)
[323.383941] Starting dynamic subtest: B-eDP1
[325.210963] Dynamic subtest B-eDP1: SUCCESS (1.837s)
[325.227400] Starting dynamic subtest: C-eDP1
[327.132151] Dynamic subtest C-eDP1: SUCCESS (1.917s)
[327.141921] Starting dynamic subtest: D-eDP1
[328.963986] Dynamic subtest D-eDP1: SUCCESS (1.830s)
[328.970324] Subtest flip-vs-dpms-on-nop: SUCCESS (7.464s)
[330.143899] [065/133] (691s left) gem_exec_reloc (basic-cpu-gtt-active)
[330.202123] Subtest basic-cpu-gtt-active: SKIP (0.000s)
[330.263427] [066/133] (690s left) kms_cursor_crc (cursor-rapid-movement-128x128)
[330.483151] Starting subtest: cursor-rapid-movement-128x128
[330.486137] Starting dynamic subtest: pipe-A-eDP-1
[331.040515] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.554s)
[331.072046] Starting dynamic subtest: pipe-D-eDP-1
[332.259339] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.195s)
[332.261933] Subtest cursor-rapid-movement-128x128: SUCCESS (1.775s)
[333.111836] [067/133] (688s left) kms_ccs (missing-ccs-buffer-y-tiled-gen12-rc-ccs)
[333.208963] Starting subtest: missing-ccs-buffer-y-tiled-gen12-rc-ccs
[333.211487] Starting dynamic subtest: pipe-A-eDP-1
[333.237046] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[333.247273] Starting dynamic subtest: pipe-B-eDP-1
[333.273644] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[333.282944] Starting dynamic subtest: pipe-C-eDP-1
[333.307948] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[333.317116] Starting dynamic subtest: pipe-D-eDP-1
[333.343262] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[333.348006] Subtest missing-ccs-buffer-y-tiled-gen12-rc-ccs: SKIP (0.004s)
[335.463504] [068/133] (685s left) kms_panel_fitting (legacy)
[335.557932] Starting subtest: legacy
[335.560178] Starting dynamic subtest: pipe-A-eDP-1
[336.145974] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.590s)
[336.172829] Starting dynamic subtest: pipe-B-eDP-1
[337.769811] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.603s)
[337.796170] Starting dynamic subtest: pipe-C-eDP-1
[339.346421] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.556s)
[339.373180] Starting dynamic subtest: pipe-D-eDP-1
[340.906938] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.540s)
[340.909570] Subtest legacy: SUCCESS (5.350s)
[342.108012] [069/133] (679s left) kms_big_fb (y-tiled-64bpp-rotate-0)
[342.212123] Starting subtest: y-tiled-64bpp-rotate-0
[342.217569] Subtest y-tiled-64bpp-rotate-0: SKIP (0.000s)
[342.314517] [070/133] (679s left) kms_frontbuffer_tracking (fbcpsr-2p-rte)
[342.414126] Starting subtest: fbcpsr-2p-rte
[342.419063] Subtest fbcpsr-2p-rte: SKIP (0.000s)
[342.504397] [071/133] (678s left) i915_hangman (engine-engine-error)
[342.569354] Starting subtest: engine-engine-error
[342.571889] Starting dynamic subtest: rcs0
[344.364126] Dynamic subtest rcs0: SUCCESS (1.795s)
[344.376966] Starting dynamic subtest: bcs0
[346.348981] Dynamic subtest bcs0: SUCCESS (1.981s)
[346.361126] Starting dynamic subtest: vcs0
[348.396542] Dynamic subtest vcs0: SUCCESS (2.044s)
[348.410901] Starting dynamic subtest: vcs1
[350.316386] Dynamic subtest vcs1: SUCCESS (1.917s)
[350.327853] Starting dynamic subtest: vecs0
[352.365141] Dynamic subtest vecs0: SUCCESS (2.045s)
[352.377802] Starting dynamic subtest: ccs0
[354.348532] Dynamic subtest ccs0: SUCCESS (1.980s)
[354.351461] Subtest engine-engine-error: SUCCESS (11.779s)
[354.430996] [072/133] (667s left) kms_cursor_crc (cursor-sliding-64x64)
[354.618936] Starting subtest: cursor-sliding-64x64
[354.622178] Starting dynamic subtest: pipe-A-eDP-1
[357.857863] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.234s)
[357.888395] Starting dynamic subtest: pipe-D-eDP-1
[361.732079] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.856s)
[361.734694] Subtest cursor-sliding-64x64: SUCCESS (7.115s)
[362.587183] [073/133] (658s left) gem_render_copy (x-tiled-to-vebox-y-tiled)
[362.651924] Starting subtest: x-tiled-to-vebox-y-tiled
[362.657080] Subtest x-tiled-to-vebox-y-tiled: SKIP (0.000s)
[362.831398] [074/133] (658s left) kms_psr (fbc-psr2-cursor-blt)
[362.921552] Starting subtest: fbc-psr2-cursor-blt
[362.923865] Starting dynamic subtest: eDP-1
[362.928180] Dynamic subtest eDP-1: SKIP (0.000s)
[362.932453] Subtest fbc-psr2-cursor-blt: SKIP (0.001s)
[362.997232] [075/133] (658s left) gem_ctx_param (basic-default)
[363.047733] Starting subtest: basic-default
[363.050378] Subtest basic-default: SUCCESS (0.000s)
[363.123534] [076/133] (658s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-blt)
[363.214057] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-blt
[367.595854] Subtest fbc-1p-primscrn-pri-shrfb-draw-blt: SUCCESS (4.385s)
[368.792336] [077/133] (652s left) i915_suspend (sysfs-reader)
[368.848812] Starting subtest: sysfs-reader
[386.455894] Subtest sysfs-reader: SUCCESS (3.129s)
[386.516809] [078/133] (635s left) perf (non-zero-reason)
[386.654699] Starting subtest: non-zero-reason
[386.656609] Starting dynamic subtest: 0-rcs0
[391.953928] Dynamic subtest 0-rcs0: SUCCESS (5.288s)
[391.966506] Starting dynamic subtest: 1-vcs1
[395.820255] Dynamic subtest 1-vcs1: SUCCESS (3.861s)
[395.823182] Subtest non-zero-reason: SUCCESS (9.151s)
[395.869794] [079/133] (625s left) gem_exec_nop (basic-series)
[395.933067] Starting subtest: basic-series
[410.330420] Subtest basic-series: SUCCESS (14.396s)
[410.565510] [080/133] (611s left) gem_lmem_swapping (verify-ccs)
[410.611319] Subtest verify-ccs: SKIP (0.000s)
[410.651500] [081/133] (611s left) gem_exec_reloc (basic-write-wc)
[410.709985] Subtest basic-write-wc: SKIP (0.000s)
[410.794730] [082/133] (611s left) kms_content_protection (dp-mst-type-1-suspend-resume)
[410.930625] Starting subtest: dp-mst-type-1-suspend-resume
[410.935053] Subtest dp-mst-type-1-suspend-resume: SKIP (0.000s)
[411.053037] [083/133] (610s left) syncobj_wait (invalid-single-wait-all-unsubmitted)
[411.111405] Starting subtest: invalid-single-wait-all-unsubmitted
[411.113726] Subtest invalid-single-wait-all-unsubmitted: SUCCESS (0.000s)
[411.225900] [084/133] (610s left) kms_color_pipeline (plane-lut1d-ctm3x4)
[411.324522] Starting subtest: plane-lut1d-ctm3x4
[411.448267] Starting dynamic subtest: pipe-A-plane-0
[411.748307] Dynamic subtest pipe-A-plane-0: FAIL (0.159s)
[411.759320] Starting dynamic subtest: pipe-A-plane-1
[411.942113] Dynamic subtest pipe-A-plane-1: FAIL (0.159s)
[411.952397] Starting dynamic subtest: pipe-A-plane-2
[412.163753] Dynamic subtest pipe-A-plane-2: FAIL (0.177s)
[413.157964] Starting dynamic subtest: pipe-B-plane-0
[413.575484] Dynamic subtest pipe-B-plane-0: FAIL (0.141s)
[413.589584] Starting dynamic subtest: pipe-B-plane-1
[413.906050] Dynamic subtest pipe-B-plane-1: FAIL (0.165s)
[413.916390] Starting dynamic subtest: pipe-B-plane-2
[414.230286] Dynamic subtest pipe-B-plane-2: FAIL (0.166s)
[415.294116] Starting dynamic subtest: pipe-C-plane-0
[415.790002] Dynamic subtest pipe-C-plane-0: FAIL (0.129s)
[415.801386] Starting dynamic subtest: pipe-C-plane-1
[416.198889] Dynamic subtest pipe-C-plane-1: FAIL (0.605s)
[416.208086] Starting dynamic subtest: pipe-C-plane-2
[416.570330] Dynamic subtest pipe-C-plane-2: FAIL (0.158s)
[417.420249] Starting dynamic subtest: pipe-D-plane-0
[418.000874] Dynamic subtest pipe-D-plane-0: FAIL (0.129s)
[418.010635] Starting dynamic subtest: pipe-D-plane-1
[418.466413] Dynamic subtest pipe-D-plane-1: FAIL (0.600s)
[418.476547] Starting dynamic subtest: pipe-D-plane-2
[418.913915] Dynamic subtest pipe-D-plane-2: FAIL (0.561s)
[419.019243] Subtest plane-lut1d-ctm3x4: FAIL (7.695s)
[419.821615] [085/133] (602s left) kms_pm_rpm (package-g7)
[422.062116] Starting subtest: package-g7
[422.067284] Subtest package-g7: SKIP (0.000s)
[422.448683] [086/133] (599s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite)
[422.543132] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite
[422.549613] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[422.640480] [087/133] (599s left) kms_cursor_legacy (2x-flip-vs-cursor-atomic)
[422.752591] Starting subtest: 2x-flip-vs-cursor-atomic
[422.757255] Subtest 2x-flip-vs-cursor-atomic: SKIP (0.001s)
[422.902018] [088/133] (599s left) syncobj_wait (invalid-reset-zero-handles)
[422.955694] Starting subtest: invalid-reset-zero-handles
[422.958253] Subtest invalid-reset-zero-handles: SUCCESS (0.000s)
[423.058014] [089/133] (599s left) kms_cursor_legacy (short-flip-before-cursor-atomic-transitions-varying-size)
[423.176522] Starting subtest: short-flip-before-cursor-atomic-transitions-varying-size
[424.133517] Subtest short-flip-before-cursor-atomic-transitions-varying-size: SUCCESS (0.958s)
[424.951165] [090/133] (597s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-onoff)
[425.040459] Starting subtest: fbc-1p-primscrn-cur-indfb-onoff
[428.937474] Subtest fbc-1p-primscrn-cur-indfb-onoff: SUCCESS (3.901s)
[430.071036] [091/133] (592s left) kms_atomic_interruptible (legacy-pageflip)
[430.170372] Starting subtest: legacy-pageflip
[430.172615] Starting dynamic subtest: pipe-A-eDP-1
[437.572839] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.402s)
[437.575032] Subtest legacy-pageflip: SUCCESS (7.403s)
[438.433589] [092/133] (583s left) kms_cursor_legacy (cursora-vs-flipa-toggle)
[438.562871] Starting subtest: cursorA-vs-flipA-toggle
[449.693344] Subtest cursorA-vs-flipA-toggle: SUCCESS (11.126s)
[450.542322] [093/133] (571s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-mmap-wc)
[450.640861] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-mmap-wc
[457.248267] Subtest psr-1p-offscreen-pri-shrfb-draw-mmap-wc: SUCCESS (6.608s)
[457.365268] [094/133] (565s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-onoff)
[457.455135] Starting subtest: fbc-2p-scndscrn-cur-indfb-onoff
[457.459975] Subtest fbc-2p-scndscrn-cur-indfb-onoff: SKIP (0.000s)
[457.554544] [095/133] (564s left) gem_exec_schedule (fairslice-all)
[457.625657] Starting subtest: fairslice-all
[459.678269] Subtest fairslice-all: SUCCESS (2.061s)
[460.963988] [096/133] (561s left) i915_pm_rc6_residency (media-rc6-accuracy)
[461.022019] Starting subtest: media-rc6-accuracy
[461.027032] Subtest media-rc6-accuracy: SKIP (0.000s)
[461.144436] [097/133] (561s left) gem_exec_schedule (u-submit-golden-slice)
[461.219442] Starting subtest: u-submit-golden-slice
[461.221885] Starting dynamic subtest: rcs0
[461.263097] Dynamic subtest rcs0: SUCCESS (0.051s)
[461.275772] Starting dynamic subtest: bcs0
[461.303260] Dynamic subtest bcs0: SUCCESS (0.039s)
[461.312846] Starting dynamic subtest: vcs0
[461.357816] Dynamic subtest vcs0: SUCCESS (0.053s)
[461.370221] Starting dynamic subtest: vcs1
[461.400744] Dynamic subtest vcs1: SUCCESS (0.043s)
[461.411539] Starting dynamic subtest: vecs0
[461.446501] Dynamic subtest vecs0: SUCCESS (0.045s)
[461.457833] Starting dynamic subtest: ccs0
[461.486288] Dynamic subtest ccs0: SUCCESS (0.039s)
[461.488526] Subtest u-submit-golden-slice: SUCCESS (0.275s)
[462.963524] [098/133] (559s left) kms_flip (blocking-wf_vblank)
[463.059337] Starting subtest: blocking-wf_vblank
[463.061646] Starting dynamic subtest: A-eDP1
[472.028446] Dynamic subtest A-eDP1: SUCCESS (8.967s)
[472.044940] Starting dynamic subtest: B-eDP1
[480.968987] Dynamic subtest B-eDP1: SUCCESS (8.936s)
[480.979898] Starting dynamic subtest: C-eDP1
[489.878097] Dynamic subtest C-eDP1: SUCCESS (8.909s)
[489.887175] Starting dynamic subtest: D-eDP1
[498.807664] Dynamic subtest D-eDP1: SUCCESS (8.930s)
[498.812854] Subtest blocking-wf_vblank: SUCCESS (35.753s)
[500.031631] [099/133] (522s left) kms_cdclk (mode-transition)
[500.130333] Starting subtest: mode-transition
[500.132641] Starting dynamic subtest: pipe-A-eDP-1
[500.422568] Dynamic subtest pipe-A-eDP-1: SKIP (0.289s)
[500.431813] Starting dynamic subtest: pipe-B-eDP-1
[500.436483] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[500.445073] Starting dynamic subtest: pipe-C-eDP-1
[500.449708] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[500.458246] Starting dynamic subtest: pipe-D-eDP-1
[500.462398] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[500.466433] Subtest mode-transition: SKIP (0.297s)
[501.263469] [100/133] (521s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-0-async-flip)
[501.373441] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-0-async-flip
[502.130405] Subtest 4-tiled-max-hw-stride-64bpp-rotate-0-async-flip: SUCCESS (0.759s)
[502.295303] [101/133] (520s left) kms_ccs (bad-rotation-90-y-tiled-ccs)
[502.377671] Starting subtest: bad-rotation-90-y-tiled-ccs
[502.379958] Starting dynamic subtest: pipe-A-eDP-1
[502.402761] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[502.415378] Starting dynamic subtest: pipe-B-eDP-1
[502.436675] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[502.445406] Starting dynamic subtest: pipe-C-eDP-1
[502.466837] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[502.475551] Starting dynamic subtest: pipe-D-eDP-1
[502.497265] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[502.501357] Subtest bad-rotation-90-y-tiled-ccs: SKIP (0.004s)
[504.635681] [102/133] (518s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-blt)
[504.732642] Starting subtest: psr-2p-primscrn-cur-indfb-draw-blt
[504.736852] Subtest psr-2p-primscrn-cur-indfb-draw-blt: SKIP (0.000s)
[504.826986] [103/133] (517s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-gtt)
[504.913092] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-gtt
[504.917470] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[505.002317] [104/133] (517s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip)
[505.104543] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip
[505.108643] Subtest yf-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SKIP (0.000s)
[505.206626] [105/133] (517s left) kms_chamelium_edid (dp-edid-read)
[505.580746] Subtest dp-edid-read: SKIP (0.000s)
[506.356799] [106/133] (516s left) kms_addfb_basic (unused-offsets)
[506.413128] Starting subtest: unused-offsets
[506.415593] Subtest unused-offsets: SUCCESS (0.000s)
[506.543321] [107/133] (516s left) kms_chamelium_hpd (dp-hpd-fast)
[506.931320] Subtest dp-hpd-fast: SKIP (0.000s)
[507.781738] [108/133] (515s left) kms_plane_alpha_blend (coverage-7efc)
[507.873472] Starting subtest: coverage-7efc
[508.150671] Starting dynamic subtest: pipe-A-eDP-1
[508.732664] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.579s)
[508.756005] Starting dynamic subtest: pipe-D-eDP-1
[510.011389] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.262s)
[510.013705] Subtest coverage-7efc: SUCCESS (2.140s)
[510.870022] [109/133] (512s left) api_intel_allocator (fork-simple-stress-signal)
[510.924027] Starting subtest: fork-simple-stress-signal
[516.329520] Subtest fork-simple-stress-signal: SUCCESS (5.403s)
[516.454760] [110/133] (506s left) gem_ctx_persistence (engines-hostile)
[516.530407] Starting subtest: engines-hostile
[516.532529] Starting dynamic subtest: rcs0
[516.683994] Dynamic subtest rcs0: SUCCESS (0.155s)
[516.697249] Starting dynamic subtest: bcs0
[516.797125] Dynamic subtest bcs0: SUCCESS (0.111s)
[516.808951] Starting dynamic subtest: vcs0
[516.898063] Dynamic subtest vcs0: SUCCESS (0.099s)
[516.909818] Starting dynamic subtest: vcs1
[517.000639] Dynamic subtest vcs1: SUCCESS (0.100s)
[517.011453] Starting dynamic subtest: vecs0
[517.105946] Dynamic subtest vecs0: SUCCESS (0.103s)
[517.117174] Starting dynamic subtest: ccs0
[517.208282] Dynamic subtest ccs0: SUCCESS (0.100s)
[517.210619] Subtest engines-hostile: SUCCESS (0.682s)
[517.319934] [111/133] (505s left) kms_flip_scaled_crc (flip-64bpp-linear-to-32bpp-linear-downscaling)
[517.411282] Starting subtest: flip-64bpp-linear-to-32bpp-linear-downscaling
[517.413361] Starting dynamic subtest: pipe-A-default-mode
[518.548275] Dynamic subtest pipe-A-default-mode: SKIP (1.134s)
[518.552853] Subtest flip-64bpp-linear-to-32bpp-linear-downscaling: SKIP (1.136s)
[518.690567] [112/133] (504s left) kms_psr (psr2-sprite-mmap-gtt)
[518.774843] Starting subtest: psr2-sprite-mmap-gtt
[518.777108] Starting dynamic subtest: eDP-1
[520.206857] Dynamic subtest eDP-1: SKIP (1.428s)
[520.211914] Subtest psr2-sprite-mmap-gtt: SKIP (1.431s)
[520.360381] [113/133] (502s left) gem_pwrite (basic-random)
[520.420391] Subtest basic-random: SKIP (0.000s)
[520.480001] [114/133] (502s left) perf_pmu (event-wait)
[520.517080] Starting subtest: event-wait
[520.519338] Starting dynamic subtest: rcs0
[520.523460] Dynamic subtest rcs0: SKIP (0.000s)
[520.527503] Subtest event-wait: SKIP (0.001s)
[520.611340] [115/133] (502s left) kms_plane_lowres (tiling-yf)
[520.698276] Starting subtest: tiling-yf
[520.702523] Subtest tiling-yf: SKIP (0.000s)
[520.771846] [116/133] (502s left) kms_plane_scaling (planes-upscale-factor-0-25-downscale-factor-0-75)
[520.864504] Starting subtest: planes-upscale-factor-0-25-downscale-factor-0-75
[520.866912] Starting dynamic subtest: pipe-A
[520.887077] Dynamic subtest pipe-A: SKIP (0.019s)
[520.896402] Starting dynamic subtest: pipe-B
[520.920194] Dynamic subtest pipe-B: SKIP (0.031s)
[520.929662] Starting dynamic subtest: pipe-C
[520.953124] Dynamic subtest pipe-C: SKIP (0.031s)
[520.962110] Starting dynamic subtest: pipe-D
[520.982654] Dynamic subtest pipe-D: SKIP (0.031s)
[520.987005] Subtest planes-upscale-factor-0-25-downscale-factor-0-75: SKIP (0.116s)
[521.088381] [117/133] (502s left) gem_exec_balancer (bonded-dual)
[521.154586] Starting subtest: bonded-dual
[521.159222] Subtest bonded-dual: SKIP (0.000s)
[521.450607] [118/133] (501s left) syncobj_wait (invalid-reset-illegal-handle)
[521.501573] Starting subtest: invalid-reset-illegal-handle
[521.503956] Subtest invalid-reset-illegal-handle: SUCCESS (0.000s)
[521.579652] [119/133] (501s left) kms_psr (fbc-psr-cursor-render)
[521.676446] Starting subtest: fbc-psr-cursor-render
[521.678767] Starting dynamic subtest: eDP-1
[521.682966] Dynamic subtest eDP-1: SKIP (0.000s)
[521.687194] Subtest fbc-psr-cursor-render: SKIP (0.001s)
[521.761714] [120/133] (501s left) gem_exec_schedule (independent)
[521.832794] Starting subtest: independent
[521.834835] Starting dynamic subtest: rcs0
[523.870444] Dynamic subtest rcs0: SUCCESS (2.048s)
[523.883286] Starting dynamic subtest: vcs0
[525.932724] Dynamic subtest vcs0: SUCCESS (2.058s)
[525.946995] Starting dynamic subtest: vcs1
[527.912791] Dynamic subtest vcs1: SUCCESS (1.978s)
[527.924645] Starting dynamic subtest: vecs0
[529.894092] Dynamic subtest vecs0: SUCCESS (1.979s)
[529.906659] Starting dynamic subtest: ccs0
[531.869812] Dynamic subtest ccs0: SUCCESS (1.973s)
[531.872763] Subtest independent: SUCCESS (10.048s)
[532.167593] [121/133] (491s left) kms_psr (psr-sprite-render)
[532.276262] Starting subtest: psr-sprite-render
[532.278608] Starting dynamic subtest: eDP-1
[534.058429] Dynamic subtest eDP-1: SUCCESS (1.779s)
[534.060705] Subtest psr-sprite-render: SUCCESS (1.781s)
[534.891877] [122/133] (488s left) gem_exec_flush (basic-wb-pro-default)
[534.955173] Starting subtest: basic-wb-pro-default
[540.432411] Subtest basic-wb-pro-default: SUCCESS (5.476s)
[540.618630] [123/133] (483s left) device_reset (unbind-cold-reset-rebind)
[540.670391] Starting subtest: unbind-cold-reset-rebind
[540.675164] Subtest unbind-cold-reset-rebind: SKIP (0.000s)
[540.743332] [124/133] (482s left) kms_ccs (bad-pixel-format-4-tiled-dg2-rc-ccs)
[540.839190] Starting subtest: bad-pixel-format-4-tiled-dg2-rc-ccs
[540.841476] Starting dynamic subtest: pipe-A-eDP-1
[540.864196] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[540.875835] Starting dynamic subtest: pipe-B-eDP-1
[540.897332] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[540.906058] Starting dynamic subtest: pipe-C-eDP-1
[540.927521] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[540.936330] Starting dynamic subtest: pipe-D-eDP-1
[540.958252] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[540.962257] Subtest bad-pixel-format-4-tiled-dg2-rc-ccs: SKIP (0.004s)
[543.159530] [125/133] (480s left) gem_mmap_wc (write-cpu-read-wc)
[543.215755] Subtest write-cpu-read-wc: SKIP (0.000s)
[543.272484] [126/133] (480s left) kms_dp_link_training (uhbr-sst)
[543.358294] Starting subtest: uhbr-sst
[543.366525] Subtest uhbr-sst: SKIP (0.000s)
[543.433013] [127/133] (480s left) kms_cursor_crc (cursor-onscreen-128x42)
[543.632128] Starting subtest: cursor-onscreen-128x42
[543.678853] Subtest cursor-onscreen-128x42: SKIP (0.041s)
[543.872731] [128/133] (479s left) kms_addfb_basic (addfb25-4-tiled)
[543.964481] Starting subtest: addfb25-4-tiled
[543.966347] Subtest addfb25-4-tiled: SUCCESS (0.000s)
[544.046629] [129/133] (479s left) gem_create (create-ext-cpu-access-sanity-check)
[544.218969] Starting subtest: create-ext-cpu-access-sanity-check
[544.223827] Subtest create-ext-cpu-access-sanity-check: SKIP (0.001s)
[544.293290] [130/133] (479s left) gem_exec_suspend (basic-s4-devices)
[544.354938] Starting subtest: basic-S4-devices
[544.357306] Starting dynamic subtest: smem
[555.871589] Dynamic subtest smem: SUCCESS (11.511s)
[555.875761] Subtest basic-S4-devices: SUCCESS (11.514s)
[563.071885] [131/133] (467s left) gem_ctx_shared (q-promotion)
[563.143932] Starting subtest: Q-promotion
[563.146283] Starting dynamic subtest: rcs0
[563.307203] Dynamic subtest rcs0: SUCCESS (0.161s)
[563.318309] Starting dynamic subtest: vcs0
[563.448224] Dynamic subtest vcs0: SUCCESS (0.139s)
[563.464896] Starting dynamic subtest: vcs1
[563.568736] Dynamic subtest vcs1: SUCCESS (0.118s)
[563.584841] Starting dynamic subtest: vecs0
[563.676505] Dynamic subtest vecs0: SUCCESS (0.109s)
[563.692964] Starting dynamic subtest: ccs0
[563.804289] Dynamic subtest ccs0: SUCCESS (0.125s)
[563.806844] Subtest Q-promotion: SUCCESS (0.659s)
[564.998929] [132/133] (466s left) gem_eio (unwedge-stress)
[565.240240] Starting subtest: unwedge-stress
[565.242399] Starting dynamic subtest: render
[570.150726] Dynamic subtest render: SUCCESS (4.908s)
[570.167802] Starting dynamic subtest: bsd1
[588.361430] Dynamic subtest bsd1: SUCCESS (18.207s)
[588.378501] Starting dynamic subtest: bsd2
[612.369031] Dynamic subtest bsd2: SUCCESS (24.003s)
[612.385992] Starting dynamic subtest: blt
[612.390167] Dynamic subtest blt: SKIP (0.000s)
[612.400845] Starting dynamic subtest: vebox
[632.397793] Dynamic subtest vebox: SUCCESS (20.024s)
[632.399852] Subtest unwedge-stress: SUCCESS (67.147s)
[633.878516] [133/133] (397s left) kms_big_fb (4-tiled-32bpp-rotate-90)
[633.980057] Starting subtest: 4-tiled-32bpp-rotate-90
[634.001015] Subtest 4-tiled-32bpp-rotate-90: SKIP (0.021s)
[634.123922] Closing watchdogs
results: parsing output: 0/ for test: drm_read
results: parsing output: 1/ for test: gem_render_copy
results: parsing output: 2/ for test: syncobj_timeline
results: parsing output: 3/ for test: kms_addfb_basic
results: parsing output: 4/ for test: gem_ctx_persistence
results: parsing output: 5/ for test: syncobj_timeline
results: parsing output: 6/ for test: kms_pm_backlight
results: parsing output: 7/ for test: kms_ccs
results: parsing output: 8/ for test: gem_exec_suspend
results: parsing output: 9/ for test: sw_sync
results: parsing output: 10/ for test: kms_dirtyfb
results: parsing output: 11/ for test: syncobj_timeline
results: parsing output: 12/ for test: fbdev
results: parsing output: 13/ for test: kms_joiner
results: parsing output: 14/ for test: kms_frontbuffer_tracking
results: parsing output: 15/ for test: kms_plane
results: parsing output: 16/ for test: prime_busy
results: parsing output: 17/ for test: syncobj_timeline
results: parsing output: 18/ for test: syncobj_timeline
results: parsing output: 19/ for test: gem_spin_batch
results: parsing output: 20/ for test: kms_big_fb
results: parsing output: 21/ for test: gem_mmap_offset
results: parsing output: 22/ for test: gem_readwrite
results: parsing output: 23/ for test: kms_big_fb
results: parsing output: 24/ for test: perf_pmu
results: parsing output: 25/ for test: kms_psr2_sf
results: parsing output: 26/ for test: kms_plane_scaling
results: parsing output: 27/ for test: api_intel_bb
results: parsing output: 28/ for test: kms_frontbuffer_tracking
results: parsing output: 29/ for test: kms_addfb_basic
results: parsing output: 30/ for test: kms_psr2_sf
results: parsing output: 31/ for test: gem_lmem_swapping
results: parsing output: 32/ for test: gem_exec_reloc
results: parsing output: 33/ for test: syncobj_timeline
results: parsing output: 34/ for test: kms_psr
results: parsing output: 35/ for test: kms_frontbuffer_tracking
results: parsing output: 36/ for test: kms_vblank
results: parsing output: 37/ for test: sw_sync
results: parsing output: 38/ for test: gen9_exec_parse
results: parsing output: 39/ for test: gem_mmap
results: parsing output: 40/ for test: kms_frontbuffer_tracking
results: parsing output: 41/ for test: gem_exec_schedule
results: parsing output: 42/ for test: kms_frontbuffer_tracking
results: parsing output: 43/ for test: gem_exec_capture
results: parsing output: 44/ for test: kms_psr
results: parsing output: 45/ for test: gem_exec_fence
results: parsing output: 46/ for test: gem_partial_pwrite_pread
results: parsing output: 47/ for test: prime_self_import
results: parsing output: 48/ for test: kms_frontbuffer_tracking
results: parsing output: 49/ for test: i915_drm_fdinfo
results: parsing output: 50/ for test: gem_vm_create
results: parsing output: 51/ for test: kms_frontbuffer_tracking
results: parsing output: 52/ for test: syncobj_wait
results: parsing output: 53/ for test: kms_frontbuffer_tracking
results: parsing output: 54/ for test: kms_big_fb
results: parsing output: 55/ for test: kms_rmfb
results: parsing output: 56/ for test: kms_frontbuffer_tracking
results: parsing output: 57/ for test: gem_partial_pwrite_pread
results: parsing output: 58/ for test: kms_cursor_legacy
results: parsing output: 59/ for test: kms_vblank
results: parsing output: 60/ for test: kms_invalid_mode
results: parsing output: 61/ for test: kms_big_fb
results: parsing output: 62/ for test: kms_frontbuffer_tracking
results: parsing output: 63/ for test: kms_flip
results: parsing output: 64/ for test: gem_exec_reloc
results: parsing output: 65/ for test: kms_cursor_crc
results: parsing output: 66/ for test: kms_ccs
results: parsing output: 67/ for test: kms_panel_fitting
results: parsing output: 68/ for test: kms_big_fb
results: parsing output: 69/ for test: kms_frontbuffer_tracking
results: parsing output: 70/ for test: i915_hangman
results: parsing output: 71/ for test: kms_cursor_crc
results: parsing output: 72/ for test: gem_render_copy
results: parsing output: 73/ for test: kms_psr
results: parsing output: 74/ for test: gem_ctx_param
results: parsing output: 75/ for test: kms_frontbuffer_tracking
results: parsing output: 76/ for test: i915_suspend
results: parsing output: 77/ for test: perf
results: parsing output: 78/ for test: gem_exec_nop
results: parsing output: 79/ for test: gem_lmem_swapping
results: parsing output: 80/ for test: gem_exec_reloc
results: parsing output: 81/ for test: kms_content_protection
results: parsing output: 82/ for test: syncobj_wait
results: parsing output: 83/ for test: kms_color_pipeline
results: parsing output: 84/ for test: kms_pm_rpm
results: parsing output: 85/ for test: kms_frontbuffer_tracking
results: parsing output: 86/ for test: kms_cursor_legacy
results: parsing output: 87/ for test: syncobj_wait
results: parsing output: 88/ for test: kms_cursor_legacy
results: parsing output: 89/ for test: kms_frontbuffer_tracking
results: parsing output: 90/ for test: kms_atomic_interruptible
results: parsing output: 91/ for test: kms_cursor_legacy
results: parsing output: 92/ for test: kms_frontbuffer_tracking
results: parsing output: 93/ for test: kms_frontbuffer_tracking
results: parsing output: 94/ for test: gem_exec_schedule
results: parsing output: 95/ for test: i915_pm_rc6_residency
results: parsing output: 96/ for test: gem_exec_schedule
results: parsing output: 97/ for test: kms_flip
results: parsing output: 98/ for test: kms_cdclk
results: parsing output: 99/ for test: kms_big_fb
results: parsing output: 100/ for test: kms_ccs
results: parsing output: 101/ for test: kms_frontbuffer_tracking
results: parsing output: 102/ for test: kms_frontbuffer_tracking
results: parsing output: 103/ for test: kms_big_fb
results: parsing output: 104/ for test: kms_chamelium_edid
results: parsing output: 105/ for test: kms_addfb_basic
results: parsing output: 106/ for test: kms_chamelium_hpd
results: parsing output: 107/ for test: kms_plane_alpha_blend
results: parsing output: 108/ for test: api_intel_allocator
results: parsing output: 109/ for test: gem_ctx_persistence
results: parsing output: 110/ for test: kms_flip_scaled_crc
results: parsing output: 111/ for test: kms_psr
results: parsing output: 112/ for test: gem_pwrite
results: parsing output: 113/ for test: perf_pmu
results: parsing output: 114/ for test: kms_plane_lowres
results: parsing output: 115/ for test: kms_plane_scaling
results: parsing output: 116/ for test: gem_exec_balancer
results: parsing output: 117/ for test: syncobj_wait
results: parsing output: 118/ for test: kms_psr
results: parsing output: 119/ for test: gem_exec_schedule
results: parsing output: 120/ for test: kms_psr
results: parsing output: 121/ for test: gem_exec_flush
results: parsing output: 122/ for test: device_reset
results: parsing output: 123/ for test: kms_ccs
results: parsing output: 124/ for test: gem_mmap_wc
results: parsing output: 125/ for test: kms_dp_link_training
results: parsing output: 126/ for test: kms_cursor_crc
results: parsing output: 127/ for test: kms_addfb_basic
results: parsing output: 128/ for test: gem_create
results: parsing output: 129/ for test: gem_exec_suspend
results: parsing output: 130/ for test: gem_ctx_shared
results: parsing output: 131/ for test: gem_eio
results: parsing output: 132/ for test: kms_big_fb
Done.