[56.255339] Initializing watchdogs
[56.255383]   /dev/watchdog0
[56.268566] [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]
[56.273255] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[56.275492] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[56.279739] [001/134] (960s left) kms_getfb (getfb-handle-valid)
[56.419688] Starting subtest: getfb-handle-valid
[56.422035] Subtest getfb-handle-valid: SUCCESS (0.000s)
[56.546160] [002/134] (960s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-16bpp-yftile-upscaling)
[56.648269] Starting subtest: flip-64bpp-yftile-to-16bpp-yftile-upscaling
[56.652761] Subtest flip-64bpp-yftile-to-16bpp-yftile-upscaling: SKIP (0.000s)
[56.730325] [003/134] (960s left) kms_plane_scaling (planes-unity-scaling-downscale-factor-0-75)
[56.827429] Starting subtest: planes-unity-scaling-downscale-factor-0-75
[56.829768] Starting dynamic subtest: pipe-A
[56.913345] Dynamic subtest pipe-A: SUCCESS (0.087s)
[56.921115] Starting dynamic subtest: pipe-B
[58.091706] Dynamic subtest pipe-B: SUCCESS (1.177s)
[58.109473] Starting dynamic subtest: pipe-C
[59.199745] Dynamic subtest pipe-C: SUCCESS (1.108s)
[59.207916] Starting dynamic subtest: pipe-D
[60.340560] Dynamic subtest pipe-D: SUCCESS (1.140s)
[60.342930] Subtest planes-unity-scaling-downscale-factor-0-75: SUCCESS (3.515s)
[61.514653] [004/134] (955s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-mmap-gtt)
[61.610591] Starting subtest: fbcpsr-rgb565-draw-mmap-gtt
[61.615063] Subtest fbcpsr-rgb565-draw-mmap-gtt: SKIP (0.000s)
[61.732882] [005/134] (955s left) kms_chamelium_hpd (hdmi-hpd)
[62.131112] Subtest hdmi-hpd: SKIP (0.000s)
[62.901587] [006/134] (954s left) kms_async_flips (invalid-async-flip-atomic)
[63.005171] Starting subtest: invalid-async-flip-atomic
[63.386906] Starting dynamic subtest: pipe-A-eDP-1
[64.254347] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.867s)
[64.611800] Starting dynamic subtest: pipe-B-eDP-1
[65.379582] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.774s)
[65.732354] Starting dynamic subtest: pipe-C-eDP-1
[66.501687] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.774s)
[66.852316] Starting dynamic subtest: pipe-D-eDP-1
[67.641069] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.793s)
[67.643441] Subtest invalid-async-flip-atomic: SUCCESS (4.639s)
[68.881163] [007/134] (948s left) kms_psr (fbc-psr2-sprite-mmap-cpu)
[68.992653] Starting subtest: fbc-psr2-sprite-mmap-cpu
[68.994836] Starting dynamic subtest: eDP-1
[68.999169] Dynamic subtest eDP-1: SKIP (0.000s)
[69.003545] Subtest fbc-psr2-sprite-mmap-cpu: SKIP (0.000s)
[69.078344] [008/134] (947s left) gem_lmem_swapping (heavy-random)
[69.116702] Subtest heavy-random: SKIP (0.000s)
[69.156445] [009/134] (947s left) gem_basic (create-fd-close)
[69.204852] Starting subtest: create-fd-close
[69.209073] Subtest create-fd-close: SUCCESS (0.000s)
[69.311900] [010/134] (947s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-render)
[69.400234] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-render
[69.404328] Subtest fbc-2p-scndscrn-cur-indfb-draw-render: SKIP (0.000s)
[69.522255] [011/134] (947s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-onoff)
[69.616376] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-onoff
[69.620697] Subtest fbcpsr-2p-primscrn-spr-indfb-onoff: SKIP (0.000s)
[69.751702] [012/134] (947s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-onoff)
[69.853911] Starting subtest: fbc-2p-primscrn-spr-indfb-onoff
[69.857249] Subtest fbc-2p-primscrn-spr-indfb-onoff: SKIP (0.000s)
[69.979394] [013/134] (947s left) kms_vblank (crtc-id)
[70.076100] Starting subtest: crtc-id
[70.078043] Starting dynamic subtest: pipe-A-eDP-1
[70.521638] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.444s)
[70.535017] Starting dynamic subtest: pipe-D-eDP-1
[71.596116] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.073s)
[71.598413] Subtest crtc-id: SUCCESS (1.520s)
[72.433728] [014/134] (944s left) kms_flip (2x-wf_vblank-ts-check-interruptible)
[72.534221] Starting subtest: 2x-wf_vblank-ts-check-interruptible
[72.545387] Subtest 2x-wf_vblank-ts-check-interruptible: SKIP (0.011s)
[72.632928] [015/134] (944s left) kms_psr (pr-sprite-mmap-gtt)
[72.740665] Starting subtest: pr-sprite-mmap-gtt
[72.744791] Subtest pr-sprite-mmap-gtt: SKIP (0.000s)
[72.823344] [016/134] (944s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-mmap-gtt)
[72.935046] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-mmap-gtt
[72.939222] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[73.052539] [017/134] (944s left) i915_drm_fdinfo (virtual-busy-idle-all)
[73.098606] Starting subtest: virtual-busy-idle-all
[73.103304] Subtest virtual-busy-idle-all: SKIP (0.000s)
[73.175039] [018/134] (944s left) gem_eio (wait-wedge-1us)
[73.336314] Starting subtest: wait-wedge-1us
[74.940868] Subtest wait-wedge-1us: SUCCESS (1.604s)
[75.108682] [019/134] (942s left) kms_plane_cursor (viewport)
[75.201134] Starting subtest: viewport
[75.205851] Starting dynamic subtest: pipe-A-eDP-1-size-64
[77.703030] Dynamic subtest pipe-A-eDP-1-size-64: SUCCESS (2.500s)
[77.770473] Starting dynamic subtest: pipe-A-eDP-1-size-128
[80.315443] Dynamic subtest pipe-A-eDP-1-size-128: SUCCESS (2.560s)
[80.374396] Starting dynamic subtest: pipe-A-eDP-1-size-256
[82.896510] Dynamic subtest pipe-A-eDP-1-size-256: SUCCESS (2.529s)
[83.252938] Starting dynamic subtest: pipe-B-eDP-1-size-64
[86.499964] Dynamic subtest pipe-B-eDP-1-size-64: SUCCESS (3.253s)
[86.563102] Starting dynamic subtest: pipe-B-eDP-1-size-128
[88.999966] Dynamic subtest pipe-B-eDP-1-size-128: SUCCESS (2.449s)
[89.056754] Starting dynamic subtest: pipe-B-eDP-1-size-256
[91.535689] Dynamic subtest pipe-B-eDP-1-size-256: SUCCESS (2.485s)
[91.894831] Starting dynamic subtest: pipe-C-eDP-1-size-64
[94.684971] Dynamic subtest pipe-C-eDP-1-size-64: SUCCESS (2.801s)
[94.719822] Starting dynamic subtest: pipe-C-eDP-1-size-128
[96.861501] Dynamic subtest pipe-C-eDP-1-size-128: SUCCESS (2.147s)
[96.897087] Starting dynamic subtest: pipe-C-eDP-1-size-256
[99.006545] Dynamic subtest pipe-C-eDP-1-size-256: SUCCESS (2.114s)
[99.334648] Starting dynamic subtest: pipe-D-eDP-1-size-64
[102.154316] Dynamic subtest pipe-D-eDP-1-size-64: SUCCESS (2.827s)
[102.190892] Starting dynamic subtest: pipe-D-eDP-1-size-128
[104.299343] Dynamic subtest pipe-D-eDP-1-size-128: SUCCESS (2.114s)
[104.336100] Starting dynamic subtest: pipe-D-eDP-1-size-256
[106.444736] Dynamic subtest pipe-D-eDP-1-size-256: SUCCESS (2.114s)
[106.775313] Subtest viewport: SUCCESS (31.568s)
[107.585110] [020/134] (909s left) kms_ccs (crc-sprite-planes-basic-4-tiled-dg2-rc-ccs)
[107.685605] Starting subtest: crc-sprite-planes-basic-4-tiled-dg2-rc-ccs
[107.687720] Starting dynamic subtest: pipe-A-eDP-1
[107.744044] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[107.753071] Starting dynamic subtest: pipe-B-eDP-1
[107.808815] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[107.817376] Starting dynamic subtest: pipe-C-eDP-1
[107.874113] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[107.883404] Starting dynamic subtest: pipe-D-eDP-1
[107.939835] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[107.944217] Subtest crc-sprite-planes-basic-4-tiled-dg2-rc-ccs: SKIP (0.008s)
[109.945841] [021/134] (907s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-onoff)
[110.047373] Starting subtest: psr-2p-scndscrn-spr-indfb-onoff
[110.051754] Subtest psr-2p-scndscrn-spr-indfb-onoff: SKIP (0.000s)
[110.166339] [022/134] (907s left) gem_softpin (safe-alignment)
[110.223182] Starting subtest: safe-alignment
[110.246100] Subtest safe-alignment: SUCCESS (0.023s)
[111.938974] [023/134] (905s left) sysfs_heartbeat_interval (precise)
[112.004017] Starting subtest: precise
[112.006351] Starting dynamic subtest: vecs0
[119.918184] Dynamic subtest vecs0: SUCCESS (7.913s)
[119.928116] Starting dynamic subtest: ccs0
[121.178767] Dynamic subtest ccs0: SUCCESS (1.257s)
[121.188855] Starting dynamic subtest: vcs0
[128.946748] Dynamic subtest vcs0: SUCCESS (7.765s)
[128.962604] Starting dynamic subtest: bcs0
[130.135760] Dynamic subtest bcs0: SUCCESS (1.188s)
[130.147944] Starting dynamic subtest: rcs0
[131.311338] Dynamic subtest rcs0: SUCCESS (1.175s)
[131.325048] Starting dynamic subtest: vcs1
[138.901561] Dynamic subtest vcs1: SUCCESS (7.586s)
[138.904051] Subtest precise: SUCCESS (26.896s)
[138.989103] [024/134] (878s left) gem_mmap_wc (close)
[139.057570] Subtest close: SKIP (0.000s)
[139.111757] [025/134] (878s left) gem_exec_balancer (parallel-keep-in-fence)
[139.367784] Starting subtest: parallel-keep-in-fence
[140.483384] Subtest parallel-keep-in-fence: SUCCESS (1.116s)
[140.603486] [026/134] (877s left) kms_invalid_mode (bad-hsync-end)
[140.701799] Starting subtest: bad-hsync-end
[140.703887] Starting dynamic subtest: pipe-A-eDP-1
[140.994193] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.294s)
[141.002057] Starting dynamic subtest: pipe-B-eDP-1
[141.004179] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[141.011262] Starting dynamic subtest: pipe-C-eDP-1
[141.013427] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[141.020282] Starting dynamic subtest: pipe-D-eDP-1
[141.022132] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[141.024409] Subtest bad-hsync-end: SUCCESS (0.300s)
[141.888271] [027/134] (875s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0-async-flip)
[141.998345] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0-async-flip
[142.677761] Subtest x-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SUCCESS (0.681s)
[142.897819] [028/134] (874s left) syncobj_timeline (invalid-signal-illegal-handle)
[142.953349] Starting subtest: invalid-signal-illegal-handle
[142.955698] Subtest invalid-signal-illegal-handle: SUCCESS (0.000s)
[143.072055] [029/134] (874s left) kms_ccs (crc-primary-basic-4-tiled-lnl-ccs)
[143.169428] Starting subtest: crc-primary-basic-4-tiled-lnl-ccs
[143.173685] Subtest crc-primary-basic-4-tiled-lnl-ccs: SKIP (0.000s)
[144.308019] [030/134] (873s left) syncobj_timeline (device-signal-unordered)
[144.366511] Starting subtest: device-signal-unordered
[144.368491] Subtest device-signal-unordered: SUCCESS (0.001s)
[144.482129] [031/134] (873s left) kms_getfb (getfb-reject-nv12)
[144.583572] Starting subtest: getfb-reject-nv12
[144.585785] Subtest getfb-reject-nv12: SUCCESS (0.001s)
[144.709714] [032/134] (873s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-mmap-wc)
[144.814830] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-mmap-wc
[151.788376] Subtest psr-1p-primscrn-pri-shrfb-draw-mmap-wc: SUCCESS (6.978s)
[151.908701] [033/134] (866s left) syncobj_basic (bad-flags-fd-to-handle)
[151.970193] Starting subtest: bad-flags-fd-to-handle
[151.972503] Subtest bad-flags-fd-to-handle: SUCCESS (0.000s)
[152.088060] [034/134] (865s left) kms_psr (psr2-primary-mmap-gtt)
[152.179715] Starting subtest: psr2-primary-mmap-gtt
[152.181937] Starting dynamic subtest: eDP-1
[153.653762] Dynamic subtest eDP-1: SKIP (1.471s)
[153.658812] Subtest psr2-primary-mmap-gtt: SKIP (1.473s)
[153.848456] [035/134] (864s left) gem_partial_pwrite_pread (reads-snoop)
[153.911823] Subtest reads-snoop: SKIP (0.000s)
[153.993766] [036/134] (864s left) i915_drm_fdinfo (memory-info-shared)
[154.030388] Starting subtest: memory-info-shared
[154.032633] Starting dynamic subtest: smem0
[154.089758] Dynamic subtest smem0: SUCCESS (0.062s)
[154.092171] Subtest memory-info-shared: SUCCESS (0.063s)
[154.171590] [037/134] (863s left) gen9_exec_parse (allowed-all)
[154.232333] Subtest allowed-all: SKIP (0.000s)
[154.298679] [038/134] (863s left) kms_psr2_sf (pr-cursor-plane-move-continuous-sf)
[159.256065] Starting subtest: pr-cursor-plane-move-continuous-sf
[159.260555] Subtest pr-cursor-plane-move-continuous-sf: SKIP (0.002s)
[160.126424] [039/134] (858s left) gen7_exec_parse (basic-allocation)
[160.179817] Subtest basic-allocation: SKIP (0.000s)
[160.254382] [040/134] (858s left) gem_bad_reloc (negative-reloc-lut)
[160.313456] Subtest negative-reloc-lut: SKIP (0.000s)
[160.406468] [041/134] (857s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12)
[160.493704] Starting subtest: compare-crc-sanitycheck-nv12
[160.495821] Starting dynamic subtest: pipe-A-eDP-1
[161.166225] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.671s)
[161.174856] Starting dynamic subtest: pipe-B-eDP-1
[162.403887] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.236s)
[162.412087] Starting dynamic subtest: pipe-C-eDP-1
[163.586073] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.181s)
[163.593600] Starting dynamic subtest: pipe-D-eDP-1
[164.817884] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.230s)
[164.819869] Subtest compare-crc-sanitycheck-nv12: SUCCESS (4.324s)
[165.666016] [042/134] (852s left) kms_big_fb (x-tiled-32bpp-rotate-270)
[165.760720] Starting subtest: x-tiled-32bpp-rotate-270
[165.780810] Subtest x-tiled-32bpp-rotate-270: SKIP (0.020s)
[165.914665] [043/134] (852s left) kms_rotation_crc (primary-y-tiled-reflect-x-180)
[166.012843] Starting subtest: primary-y-tiled-reflect-x-180
[166.071840] Subtest primary-y-tiled-reflect-x-180: SKIP (0.059s)
[166.183319] [044/134] (852s left) gem_render_copy (yf-tiled)
[166.246193] Starting subtest: yf-tiled
[166.250629] Subtest yf-tiled: SKIP (0.000s)
[166.438999] [045/134] (852s left) sw_sync (sync_multi_consumer)
[166.475555] Starting subtest: sync_multi_consumer
[166.910638] Subtest sync_multi_consumer: SUCCESS (0.439s)
[166.985528] [046/134] (851s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-180-async-flip)
[167.083097] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-180-async-flip
[167.087257] Subtest y-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SKIP (0.000s)
[167.199318] [047/134] (851s left) kms_flip (flip-vs-suspend)
[167.299020] Starting subtest: flip-vs-suspend
[167.301368] Starting dynamic subtest: A-eDP1
[216.413302] Dynamic subtest A-eDP1: SUCCESS (4.643s)
[216.427133] Starting dynamic subtest: B-eDP1
[265.415677] Dynamic subtest B-eDP1: SUCCESS (4.527s)
[265.424450] Starting dynamic subtest: C-eDP1
[314.413781] Dynamic subtest C-eDP1: SUCCESS (4.516s)
[314.423161] Starting dynamic subtest: D-eDP1
[363.419735] Dynamic subtest D-eDP1: SUCCESS (4.592s)
[363.425972] Subtest flip-vs-suspend: SUCCESS (18.288s)
[364.702474] [048/134] (653s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-render)
[364.807542] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-render
[364.812768] Subtest fbc-2p-primscrn-pri-shrfb-draw-render: SKIP (0.000s)
[364.925015] [049/134] (653s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-indfb-msflip-blt)
[365.024437] Starting subtest: fbc-2p-scndscrn-indfb-msflip-blt
[365.029228] Subtest fbc-2p-scndscrn-indfb-msflip-blt: SKIP (0.000s)
[365.127343] [050/134] (653s left) kms_ccs (bad-pixel-format-4-tiled-mtl-rc-ccs-cc)
[365.224455] Starting subtest: bad-pixel-format-4-tiled-mtl-rc-ccs-cc
[365.227002] Starting dynamic subtest: pipe-A-eDP-1
[365.251374] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[365.262012] Starting dynamic subtest: pipe-B-eDP-1
[365.285479] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[365.293971] Starting dynamic subtest: pipe-C-eDP-1
[365.316941] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[365.325181] Starting dynamic subtest: pipe-D-eDP-1
[365.347977] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[365.350304] Subtest bad-pixel-format-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.007s)
[367.387849] [051/134] (651s left) gem_readwrite (read-write)
[367.460933] Subtest read-write: SKIP (0.000s)
[367.531867] [052/134] (651s left) kms_cursor_crc (cursor-offscreen-256x256)
[367.775932] Starting subtest: cursor-offscreen-256x256
[367.782056] Starting dynamic subtest: pipe-A-eDP-1
[369.726422] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.944s)
[369.753768] Starting dynamic subtest: pipe-D-eDP-1
[372.309888] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.563s)
[372.312784] Subtest cursor-offscreen-256x256: SUCCESS (4.532s)
[373.184116] [053/134] (645s left) kms_sequence (get-idle)
[373.286233] Starting subtest: get-idle
[373.288735] Starting dynamic subtest: pipe-A-eDP-1
[375.098331] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.810s)
[375.106967] Starting dynamic subtest: pipe-B-eDP-1
[377.539515] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.437s)
[377.548931] Starting dynamic subtest: pipe-C-eDP-1
[379.963758] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.425s)
[379.973596] Starting dynamic subtest: pipe-D-eDP-1
[382.398445] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.430s)
[382.400738] Subtest get-idle: SUCCESS (9.107s)
[383.213796] [054/134] (635s left) kms_color (ctm-red-to-blue)
[383.316711] Starting subtest: ctm-red-to-blue
[383.318831] Starting dynamic subtest: pipe-A-eDP-1
[384.036205] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.721s)
[384.045907] Starting dynamic subtest: pipe-B-eDP-1
[385.448730] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.409s)
[385.457568] Starting dynamic subtest: pipe-C-eDP-1
[386.831454] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.383s)
[386.839639] Starting dynamic subtest: pipe-D-eDP-1
[388.151258] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.319s)
[388.153870] Subtest ctm-red-to-blue: SUCCESS (4.835s)
[388.968145] [055/134] (629s left) sw_sync (sync_merge_invalid)
[389.006835] Starting subtest: sync_merge_invalid
[389.032793] Subtest sync_merge_invalid: SUCCESS (0.024s)
[389.117606] [056/134] (629s left) gem_mmap_gtt (cpuset-basic-small-copy-xy)
[389.179261] Subtest cpuset-basic-small-copy-XY: SKIP (0.000s)
[389.246890] [057/134] (629s left) syncobj_timeline (invalid-multi-wait-unsubmitted)
[389.310508] Starting subtest: invalid-multi-wait-unsubmitted
[389.313140] Subtest invalid-multi-wait-unsubmitted: SUCCESS (0.000s)
[389.447997] [058/134] (629s left) kms_pm_rpm (fences)
[390.985767] Starting subtest: fences
[390.991031] Subtest fences: SKIP (0.000s)
[391.712264] [059/134] (627s left) gem_exec_params (rel-constants-invalid-rel-gen5)
[391.773291] Starting subtest: rel-constants-invalid-rel-gen5
[391.775877] Subtest rel-constants-invalid-rel-gen5: SUCCESS (0.000s)
[391.896970] [060/134] (627s left) kms_psr (fbc-psr-no-drrs)
[391.991756] Starting subtest: fbc-psr-no-drrs
[391.994030] Starting dynamic subtest: eDP-1
[391.998864] Dynamic subtest eDP-1: SKIP (0.000s)
[392.003783] Subtest fbc-psr-no-drrs: SKIP (0.001s)
[392.077734] [061/134] (627s left) kms_frontbuffer_tracking (fbc-tiling-4)
[392.188936] Starting subtest: fbc-tiling-4
[396.478830] Subtest fbc-tiling-4: SUCCESS (4.294s)
[397.616807] [062/134] (621s left) gem_eio (wait-immediate)
[397.847778] Starting subtest: wait-immediate
[398.239306] Subtest wait-immediate: SUCCESS (0.392s)
[398.394348] [063/134] (620s left) gem_sync (basic-store-all)
[398.474573] Starting subtest: basic-store-all
[403.043044] Subtest basic-store-all: SUCCESS (4.582s)
[403.241364] [064/134] (615s left) gem_exec_gttfill (all-engines)
[403.331001] Starting subtest: all-engines
[427.074211] Subtest all-engines: SUCCESS (23.737s)
[427.274036] [065/134] (591s left) kms_cdclk (plane-scaling)
[427.424504] Starting subtest: plane-scaling
[427.426978] Starting dynamic subtest: pipe-A-eDP-1
[427.716423] Dynamic subtest pipe-A-eDP-1: SKIP (0.289s)
[427.726365] Starting dynamic subtest: pipe-B-eDP-1
[427.731483] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[427.740448] Starting dynamic subtest: pipe-C-eDP-1
[427.745721] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[427.754933] Starting dynamic subtest: pipe-D-eDP-1
[427.759850] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[427.764907] Subtest plane-scaling: SKIP (0.297s)
[428.542706] [066/134] (590s left) kms_flip (nonblocking-read)
[428.662038] Starting subtest: nonblocking-read
[428.664766] Subtest nonblocking-read: SUCCESS (0.000s)
[428.753846] [067/134] (590s left) kms_dsc (dsc-with-output-formats)
[428.855812] Starting subtest: dsc-with-output-formats
[428.882195] Subtest dsc-with-output-formats: SKIP (0.002s)
[428.943990] [068/134] (590s left) gem_mmap_gtt (big-bo-tiledy)
[429.003483] Subtest big-bo-tiledY: SKIP (0.000s)
[429.064262] [069/134] (590s left) gem_exec_alignment (pi)
[429.134995] Starting subtest: pi
[477.914258] Subtest pi: SUCCESS (48.766s)
[478.951154] [070/134] (540s left) kms_big_fb (4-tiled-8bpp-rotate-270)
[479.110257] Starting subtest: 4-tiled-8bpp-rotate-270
[479.131817] Subtest 4-tiled-8bpp-rotate-270: SKIP (0.021s)
[479.275240] [071/134] (540s left) api_intel_allocator (reopen)
[479.329406] Starting subtest: reopen
[479.332626] Subtest reopen: SUCCESS (0.004s)
[479.467379] [072/134] (540s left) kms_psr (psr-primary-render)
[479.578832] Starting subtest: psr-primary-render
[479.581006] Starting dynamic subtest: eDP-1
[481.324498] Dynamic subtest eDP-1: SUCCESS (1.746s)
[481.326911] Subtest psr-primary-render: SUCCESS (1.747s)
[482.190773] [073/134] (537s left) gem_pxp (create-regular-context-1)
[482.329868] Starting subtest: create-regular-context-1
[482.332775] Subtest create-regular-context-1: SUCCESS (0.001s)
[482.460659] [074/134] (537s left) kms_big_fb (linear-8bpp-rotate-90)
[482.574360] Starting subtest: linear-8bpp-rotate-90
[482.595762] Subtest linear-8bpp-rotate-90: SKIP (0.021s)
[482.739297] [075/134] (536s left) kms_ccs (crc-primary-suspend-4-tiled-mtl-mc-ccs)
[482.837779] Starting subtest: crc-primary-suspend-4-tiled-mtl-mc-ccs
[482.839888] Starting dynamic subtest: pipe-A-eDP-1
[515.666863] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.985s)
[515.676417] Starting dynamic subtest: pipe-B-eDP-1
[548.586608] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.795s)
[548.596451] Starting dynamic subtest: pipe-C-eDP-1
[581.570877] Dynamic subtest pipe-C-eDP-1: SUCCESS (3.718s)
[581.580697] Starting dynamic subtest: pipe-D-eDP-1
[614.566521] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.671s)
[614.569531] Subtest crc-primary-suspend-4-tiled-mtl-mc-ccs: SUCCESS (14.174s)
[615.784014] [076/134] (403s left) kms_psr (fbc-pr-primary-blt)
[615.893322] Starting subtest: fbc-pr-primary-blt
[615.898432] Subtest fbc-pr-primary-blt: SKIP (0.000s)
[615.977503] [077/134] (403s left) gem_ccs (suspend-resume)
[616.036172] Starting subtest: suspend-resume
[616.041401] Subtest suspend-resume: SKIP (0.000s)
[616.144554] [078/134] (403s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-mmap-gtt)
[616.244194] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-mmap-gtt
[616.249537] Subtest fbc-2p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[616.363020] [079/134] (403s left) kms_vrr (seamless-rr-switch-vrr)
[616.446170] Starting subtest: seamless-rr-switch-vrr
[616.453367] Subtest seamless-rr-switch-vrr: SKIP (0.000s)
[616.527431] [080/134] (403s left) kms_addfb_basic (bad-pitch-65536)
[616.589606] Starting subtest: bad-pitch-65536
[616.592331] Subtest bad-pitch-65536: SUCCESS (0.000s)
[616.759320] [081/134] (403s left) gem_exec_schedule (noreorder)
[616.950377] Starting subtest: noreorder
[616.953456] Starting dynamic subtest: rcs0
[617.020706] Dynamic subtest rcs0: SUCCESS (0.071s)
[617.032438] Starting dynamic subtest: vcs0
[618.274284] Dynamic subtest vcs0: SUCCESS (1.248s)
[618.285063] Starting dynamic subtest: vcs1
[620.264750] Dynamic subtest vcs1: SUCCESS (1.985s)
[620.276700] Starting dynamic subtest: vecs0
[622.199318] Dynamic subtest vecs0: SUCCESS (1.930s)
[622.210694] Starting dynamic subtest: ccs0
[622.258524] Dynamic subtest ccs0: SUCCESS (0.058s)
[622.261421] Subtest noreorder: SUCCESS (5.303s)
[622.456894] [082/134] (397s left) gem_ctx_param (invalid-get-engines)
[622.512446] Starting subtest: invalid-get-engines
[622.515449] Subtest invalid-get-engines: SUCCESS (0.001s)
[622.622768] [083/134] (397s left) gem_exec_whisper (basic-fds)
[622.692533] Starting subtest: basic-fds
[630.256067] Subtest basic-fds: SUCCESS (7.557s)
[630.452179] [084/134] (389s left) core_setmaster (master-drop-set-user)
[630.547713] Starting subtest: master-drop-set-user
[630.563119] Subtest master-drop-set-user: SUCCESS (0.015s)
[630.599908] [085/134] (389s left) gem_mmap_wc (set-cache-level)
[630.666189] Subtest set-cache-level: SKIP (0.000s)
[630.733976] [086/134] (389s left) kms_async_flips (alternate-sync-async-flip)
[630.841319] Starting subtest: alternate-sync-async-flip
[631.218901] Starting dynamic subtest: pipe-A-eDP-1
[633.977512] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.759s)
[634.351142] Starting dynamic subtest: pipe-B-eDP-1
[637.106409] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.762s)
[637.486517] Starting dynamic subtest: pipe-C-eDP-1
[640.226381] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.747s)
[640.596129] Starting dynamic subtest: pipe-D-eDP-1
[643.361310] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.772s)
[643.363436] Subtest alternate-sync-async-flip: SUCCESS (12.517s)
[644.556045] [087/134] (375s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-mmap-wc)
[644.656246] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-mmap-wc
[648.865419] Subtest fbc-1p-primscrn-pri-shrfb-draw-mmap-wc: SUCCESS (4.212s)
[650.058552] [088/134] (370s left) api_intel_bb (reset-bb)
[650.130521] Starting subtest: reset-bb
[650.133422] Subtest reset-bb: SUCCESS (0.004s)
[650.279072] [089/134] (369s left) kms_vrr (flip-suspend)
[650.379199] Starting subtest: flip-suspend
[650.386764] Subtest flip-suspend: SKIP (0.000s)
[650.459162] [090/134] (369s left) kms_psr2_sf (fbc-pr-plane-move-sf-dmg-area)
[655.500561] Starting subtest: fbc-pr-plane-move-sf-dmg-area
[655.506517] Subtest fbc-pr-plane-move-sf-dmg-area: SKIP (0.002s)
[656.372141] [091/134] (363s left) kms_plane_multiple (tiling-yf)
[656.479975] Starting subtest: tiling-yf
[656.484439] Subtest tiling-yf: SKIP (0.000s)
[656.562734] [092/134] (363s left) gem_tiled_partial_pwrite_pread (reads)
[656.636321] Subtest reads: SKIP (0.000s)
[656.722966] [093/134] (363s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-render)
[656.837821] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-render
[661.009718] Subtest fbc-1p-offscreen-pri-indfb-draw-render: SUCCESS (4.174s)
[662.173696] [094/134] (358s left) gem_exec_schedule (timeslicing)
[662.258360] Starting subtest: timeslicing
[662.261039] Starting dynamic subtest: rcs0
[662.269131] Dynamic subtest rcs0: SUCCESS (0.022s)
[662.280221] Starting dynamic subtest: bcs0
[662.289196] Dynamic subtest bcs0: SUCCESS (0.019s)
[662.298547] Starting dynamic subtest: vcs0
[662.311138] Dynamic subtest vcs0: SUCCESS (0.021s)
[662.320142] Starting dynamic subtest: vcs1
[662.332528] Dynamic subtest vcs1: SUCCESS (0.021s)
[662.341530] Starting dynamic subtest: vecs0
[662.354262] Dynamic subtest vecs0: SUCCESS (0.021s)
[662.363369] Starting dynamic subtest: ccs0
[662.374505] Dynamic subtest ccs0: SUCCESS (0.020s)
[662.377294] Subtest timeslicing: SUCCESS (0.129s)
[664.362372] [095/134] (356s left) gem_tiled_blits (interruptible)
[664.447532] Subtest interruptible: SKIP (0.000s)
[664.517051] [096/134] (355s left) kms_big_fb (y-tiled-64bpp-rotate-270)
[664.623113] Starting subtest: y-tiled-64bpp-rotate-270
[664.628358] Subtest y-tiled-64bpp-rotate-270: SKIP (0.000s)
[664.741638] [097/134] (355s left) i915_query (hwconfig_table)
[664.803275] Starting subtest: hwconfig_table
[665.111204] Subtest hwconfig_table: SUCCESS (0.001s)
[665.150876] [098/134] (355s left) kms_cursor_legacy (basic-flip-after-cursor-legacy)
[665.273770] Starting subtest: basic-flip-after-cursor-legacy
[666.187294] Subtest basic-flip-after-cursor-legacy: SUCCESS (0.912s)
[666.999802] [099/134] (353s left) sw_sync (sync_busy_fork)
[667.044401] Starting subtest: sync_busy_fork
[668.053391] Subtest sync_busy_fork: SUCCESS (1.010s)
[668.130146] [100/134] (352s left) kms_content_protection (atomic-dpms)
[668.273399] Starting subtest: atomic-dpms
[668.279016] Subtest atomic-dpms: SKIP (0.000s)
[668.402854] [101/134] (352s left) perf (stress-open-close)
[668.533232] Starting subtest: stress-open-close
[668.535447] Starting dynamic subtest: 0-rcs0
[670.703182] Dynamic subtest 0-rcs0: SUCCESS (2.169s)
[670.713519] Starting dynamic subtest: 1-vecs0
[672.864351] Dynamic subtest 1-vecs0: SUCCESS (2.160s)
[672.866414] Subtest stress-open-close: SUCCESS (4.330s)
[672.904689] [102/134] (347s left) gem_mmap_gtt (zero-extend)
[672.969015] Subtest zero-extend: SKIP (0.000s)
[673.044575] [103/134] (347s left) sw_sync (sync_multi_timeline_wait)
[673.079298] Starting subtest: sync_multi_timeline_wait
[673.082004] Subtest sync_multi_timeline_wait: SUCCESS (0.000s)
[673.159272] [104/134] (347s left) gem_render_copy (yf-tiled-ccs-to-yf-tiled-ccs)
[673.234986] Starting subtest: yf-tiled-ccs-to-yf-tiled-ccs
[673.239924] Subtest yf-tiled-ccs-to-yf-tiled-ccs: SKIP (0.000s)
[673.432660] [105/134] (347s left) gem_tiled_fence_blits (normal)
[673.496074] Subtest normal: SKIP (0.000s)
[673.560915] [106/134] (347s left) syncobj_timeline (wait-all-for-submit-delayed-submit)
[673.624303] Starting subtest: wait-all-for-submit-delayed-submit
[673.725633] Subtest wait-all-for-submit-delayed-submit: SUCCESS (0.103s)
[673.819891] [107/134] (347s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-mmap-gtt)
[673.933458] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-mmap-gtt
[673.938196] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[674.054422] [108/134] (346s left) gen3_render_tiledx_blits
[674.167250] [109/134] (346s left) syncobj_timeline (multi-wait-signaled)
[674.218902] Starting subtest: multi-wait-signaled
[674.221374] Subtest multi-wait-signaled: SUCCESS (0.000s)
[674.349732] [110/134] (346s left) kms_cursor_crc (cursor-rapid-movement-32x10)
[674.503879] Starting subtest: cursor-rapid-movement-32x10
[674.550051] Subtest cursor-rapid-movement-32x10: SKIP (0.041s)
[674.829684] [111/134] (346s left) gem_ctx_persistence (legacy-engines-mixed-process)
[674.894003] Starting subtest: legacy-engines-mixed-process
[674.896209] Starting dynamic subtest: render
[676.256731] Dynamic subtest render: SUCCESS (1.361s)
[676.270394] Starting dynamic subtest: bsd1
[678.237549] Dynamic subtest bsd1: SUCCESS (1.976s)
[678.248302] Starting dynamic subtest: bsd2
[680.302918] Dynamic subtest bsd2: SUCCESS (2.062s)
[680.314832] Starting dynamic subtest: blt
[682.259107] Dynamic subtest blt: SUCCESS (1.953s)
[682.270118] Starting dynamic subtest: vebox
[684.278980] Dynamic subtest vebox: SUCCESS (2.017s)
[684.282040] Subtest legacy-engines-mixed-process: SUCCESS (9.380s)
[684.370433] [112/134] (336s left) gem_mmap_gtt (basic-write-cpu-read-gtt)
[684.434359] Subtest basic-write-cpu-read-gtt: SKIP (0.000s)
[684.502722] [113/134] (336s left) kms_pm_rpm (package-g7)
[686.434566] Starting subtest: package-g7
[686.440204] Subtest package-g7: SKIP (0.000s)
[686.811040] [114/134] (334s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-mmap-gtt)
[686.907287] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-mmap-gtt
[686.912405] Subtest psr-2p-scndscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[687.036218] [115/134] (334s left) kms_flip (2x-flip-vs-modeset)
[687.148575] Starting subtest: 2x-flip-vs-modeset
[687.157777] Subtest 2x-flip-vs-modeset: SKIP (0.010s)
[687.251159] [116/134] (334s left) gem_exec_flush (basic-uc-rw-default)
[687.315831] Starting subtest: basic-uc-rw-default
[692.774283] Subtest basic-uc-rw-default: SUCCESS (5.455s)
[692.988722] [117/134] (328s left) kms_frontbuffer_tracking (fbcpsr-2p-rte)
[693.100504] Starting subtest: fbcpsr-2p-rte
[693.105939] Subtest fbcpsr-2p-rte: SKIP (0.000s)
[693.210175] [118/134] (328s left) gem_userptr_blits (map-fixed-invalidate-overlap)
[693.279197] Starting subtest: map-fixed-invalidate-overlap
[693.284174] Subtest map-fixed-invalidate-overlap: SKIP (0.000s)
[693.439398] [119/134] (328s left) kms_plane_scaling (plane-scaler-with-clipping-clamping-pixel-formats)
[693.542537] Starting subtest: plane-scaler-with-clipping-clamping-pixel-formats
[693.545308] Starting dynamic subtest: pipe-A
[693.655227] Dynamic subtest pipe-A: SKIP (0.108s)
[693.665151] Starting dynamic subtest: pipe-B
[694.872823] Dynamic subtest pipe-B: SKIP (1.216s)
[694.882439] Starting dynamic subtest: pipe-C
[696.033387] Dynamic subtest pipe-C: SUCCESS (1.166s)
[696.043059] Starting dynamic subtest: pipe-D
[697.250248] Dynamic subtest pipe-D: SUCCESS (1.216s)
[697.252698] Subtest plane-scaler-with-clipping-clamping-pixel-formats: SUCCESS (3.709s)
[698.452633] [120/134] (323s left) kms_cursor_edge_walk (128x128-left-edge)
[698.542502] Starting subtest: 128x128-left-edge
[698.545178] Starting dynamic subtest: pipe-A-eDP-1
[702.011573] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.468s)
[702.021552] Starting dynamic subtest: pipe-D-eDP-1
[705.142304] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.127s)
[705.144890] Subtest 128x128-left-edge: SUCCESS (6.598s)
[705.950762] [121/134] (315s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180)
[706.070307] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180
[706.075390] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180: SKIP (0.000s)
[706.182711] [122/134] (315s left) gem_exec_balancer (parallel-balancer)
[706.451319] Starting subtest: parallel-balancer
[707.287196] Subtest parallel-balancer: SUCCESS (0.839s)
[707.415984] [123/134] (314s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-pwrite)
[707.516267] Starting subtest: psr-1p-primscrn-pri-indfb-draw-pwrite
[715.073675] Subtest psr-1p-primscrn-pri-indfb-draw-pwrite: SUCCESS (7.565s)
[715.214711] [124/134] (306s left) kms_chamelium_edid (dp-mode-timings)
[715.597401] Subtest dp-mode-timings: SKIP (0.000s)
[716.439231] [125/134] (305s left) i915_pm_rpm (gem-execbuf-stress-pc8)
[718.475548] Starting subtest: gem-execbuf-stress-pc8
[718.517396] Subtest gem-execbuf-stress-pc8: SKIP (0.040s)
[718.865159] [126/134] (302s left) kms_dirtyfb (psr-dirtyfb-ioctl)
[718.979827] Starting subtest: psr-dirtyfb-ioctl
[718.982243] Starting dynamic subtest: A-eDP-1
[722.933029] Dynamic subtest A-eDP-1: SUCCESS (3.957s)
[722.935724] Subtest psr-dirtyfb-ioctl: SUCCESS (3.958s)
[723.739857] [127/134] (298s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-pwrite)
[723.841454] Starting subtest: psr-2p-primscrn-pri-indfb-draw-pwrite
[723.847555] Subtest psr-2p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[723.940911] [128/134] (297s left) kms_plane (pixel-format-4-tiled-mtl-mc-ccs-modifier-source-clamping)
[724.045307] Starting subtest: pixel-format-4-tiled-mtl-mc-ccs-modifier-source-clamping
[724.071693] Starting dynamic subtest: pipe-A-plane-0
[724.504126] Dynamic subtest pipe-A-plane-0: SUCCESS (0.433s)
[724.513897] Starting dynamic subtest: pipe-A-plane-3
[724.770530] Dynamic subtest pipe-A-plane-3: SUCCESS (0.266s)
[724.780249] Starting dynamic subtest: pipe-A-plane-5
[724.784645] Dynamic subtest pipe-A-plane-5: SKIP (0.000s)
[725.912376] Starting dynamic subtest: pipe-B-plane-0
[726.338083] Dynamic subtest pipe-B-plane-0: SUCCESS (0.433s)
[726.347527] Starting dynamic subtest: pipe-B-plane-3
[726.596425] Dynamic subtest pipe-B-plane-3: SUCCESS (0.255s)
[726.608513] Starting dynamic subtest: pipe-B-plane-5
[726.613853] Dynamic subtest pipe-B-plane-5: SKIP (0.000s)
[726.901301] Subtest pixel-format-4-tiled-mtl-mc-ccs-modifier-source-clamping: SUCCESS (2.859s)
[727.785911] [129/134] (294s left) gem_bad_reloc (negative-reloc-bltcopy)
[727.854310] Subtest negative-reloc-bltcopy: SKIP (0.000s)
[727.935112] [130/134] (293s left) gem_exec_fence (submit)
[728.111028] Starting subtest: submit
[728.116531] Subtest submit: SKIP (0.000s)
[730.357615] [FACT gem_exec_fence (submit)] new: kernel.kmod_is_loaded.vgem: true
[730.361212] [131/134] (291s left) perf_pmu (frequency)
[730.404332] Starting subtest: frequency
[730.407006] Starting dynamic subtest: gt0
[732.560385] Dynamic subtest gt0: SUCCESS (2.150s)
[732.572695] Starting dynamic subtest: idle-gt0
[733.063670] Dynamic subtest idle-gt0: SUCCESS (0.504s)
[733.075556] Starting dynamic subtest: gt1
[737.263765] Dynamic subtest gt1: SUCCESS (4.195s)
[737.276335] Starting dynamic subtest: idle-gt1
[737.767892] Dynamic subtest idle-gt1: SUCCESS (0.504s)
[737.770803] Subtest frequency: SUCCESS (7.369s)
[737.893245] [132/134] (284s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-shrfb-msflip-blt)
[737.996314] Starting subtest: fbcpsr-1p-primscrn-shrfb-msflip-blt
[745.582675] Subtest fbcpsr-1p-primscrn-shrfb-msflip-blt: SUCCESS (7.591s)
[745.742264] [133/134] (276s left) perf_pmu (enable-race)
[745.789652] Starting subtest: enable-race
[745.792336] Starting dynamic subtest: rcs0
[758.572514] Dynamic subtest rcs0: SUCCESS (12.785s)
[758.583503] Starting dynamic subtest: bcs0
[771.317826] Dynamic subtest bcs0: SUCCESS (12.742s)
[771.329673] Starting dynamic subtest: vcs0
[787.280820] Dynamic subtest vcs0: SUCCESS (15.958s)
[787.292288] Starting dynamic subtest: vcs1
[803.217987] Dynamic subtest vcs1: SUCCESS (15.930s)
[803.239980] Starting dynamic subtest: vecs0
[819.218361] Dynamic subtest vecs0: SUCCESS (15.993s)
[819.231809] Starting dynamic subtest: ccs0
[831.969508] Dynamic subtest ccs0: SUCCESS (12.746s)
[831.972561] Subtest enable-race: SUCCESS (86.168s)
[832.103098] [134/134] (189s left) gem_caching (read-writes)
[832.172883] Subtest read-writes: SKIP (0.000s)
[832.255338] Closing watchdogs
results: parsing output: 0/ for test: kms_getfb
results: parsing output: 1/ for test: kms_flip_scaled_crc
results: parsing output: 2/ for test: kms_plane_scaling
results: parsing output: 3/ for test: kms_frontbuffer_tracking
results: parsing output: 4/ for test: kms_chamelium_hpd
results: parsing output: 5/ for test: kms_async_flips
results: parsing output: 6/ for test: kms_psr
results: parsing output: 7/ for test: gem_lmem_swapping
results: parsing output: 8/ for test: gem_basic
results: parsing output: 9/ for test: kms_frontbuffer_tracking
results: parsing output: 10/ for test: kms_frontbuffer_tracking
results: parsing output: 11/ for test: kms_frontbuffer_tracking
results: parsing output: 12/ for test: kms_vblank
results: parsing output: 13/ for test: kms_flip
results: parsing output: 14/ for test: kms_psr
results: parsing output: 15/ for test: kms_frontbuffer_tracking
results: parsing output: 16/ for test: i915_drm_fdinfo
results: parsing output: 17/ for test: gem_eio
results: parsing output: 18/ for test: kms_plane_cursor
results: parsing output: 19/ for test: kms_ccs
results: parsing output: 20/ for test: kms_frontbuffer_tracking
results: parsing output: 21/ for test: gem_softpin
results: parsing output: 22/ for test: sysfs_heartbeat_interval
results: parsing output: 23/ for test: gem_mmap_wc
results: parsing output: 24/ for test: gem_exec_balancer
results: parsing output: 25/ for test: kms_invalid_mode
results: parsing output: 26/ for test: kms_big_fb
results: parsing output: 27/ for test: syncobj_timeline
results: parsing output: 28/ for test: kms_ccs
results: parsing output: 29/ for test: syncobj_timeline
results: parsing output: 30/ for test: kms_getfb
results: parsing output: 31/ for test: kms_frontbuffer_tracking
results: parsing output: 32/ for test: syncobj_basic
results: parsing output: 33/ for test: kms_psr
results: parsing output: 34/ for test: gem_partial_pwrite_pread
results: parsing output: 35/ for test: i915_drm_fdinfo
results: parsing output: 36/ for test: gen9_exec_parse
results: parsing output: 37/ for test: kms_psr2_sf
results: parsing output: 38/ for test: gen7_exec_parse
results: parsing output: 39/ for test: gem_bad_reloc
results: parsing output: 40/ for test: kms_pipe_crc_basic
results: parsing output: 41/ for test: kms_big_fb
results: parsing output: 42/ for test: kms_rotation_crc
results: parsing output: 43/ for test: gem_render_copy
results: parsing output: 44/ for test: sw_sync
results: parsing output: 45/ for test: kms_big_fb
results: parsing output: 46/ for test: kms_flip
results: parsing output: 47/ for test: kms_frontbuffer_tracking
results: parsing output: 48/ for test: kms_frontbuffer_tracking
results: parsing output: 49/ for test: kms_ccs
results: parsing output: 50/ for test: gem_readwrite
results: parsing output: 51/ for test: kms_cursor_crc
results: parsing output: 52/ for test: kms_sequence
results: parsing output: 53/ for test: kms_color
results: parsing output: 54/ for test: sw_sync
results: parsing output: 55/ for test: gem_mmap_gtt
results: parsing output: 56/ for test: syncobj_timeline
results: parsing output: 57/ for test: kms_pm_rpm
results: parsing output: 58/ for test: gem_exec_params
results: parsing output: 59/ for test: kms_psr
results: parsing output: 60/ for test: kms_frontbuffer_tracking
results: parsing output: 61/ for test: gem_eio
results: parsing output: 62/ for test: gem_sync
results: parsing output: 63/ for test: gem_exec_gttfill
results: parsing output: 64/ for test: kms_cdclk
results: parsing output: 65/ for test: kms_flip
results: parsing output: 66/ for test: kms_dsc
results: parsing output: 67/ for test: gem_mmap_gtt
results: parsing output: 68/ for test: gem_exec_alignment
results: parsing output: 69/ for test: kms_big_fb
results: parsing output: 70/ for test: api_intel_allocator
results: parsing output: 71/ for test: kms_psr
results: parsing output: 72/ for test: gem_pxp
results: parsing output: 73/ for test: kms_big_fb
results: parsing output: 74/ for test: kms_ccs
results: parsing output: 75/ for test: kms_psr
results: parsing output: 76/ for test: gem_ccs
results: parsing output: 77/ for test: kms_frontbuffer_tracking
results: parsing output: 78/ for test: kms_vrr
results: parsing output: 79/ for test: kms_addfb_basic
results: parsing output: 80/ for test: gem_exec_schedule
results: parsing output: 81/ for test: gem_ctx_param
results: parsing output: 82/ for test: gem_exec_whisper
results: parsing output: 83/ for test: core_setmaster
results: parsing output: 84/ for test: gem_mmap_wc
results: parsing output: 85/ for test: kms_async_flips
results: parsing output: 86/ for test: kms_frontbuffer_tracking
results: parsing output: 87/ for test: api_intel_bb
results: parsing output: 88/ for test: kms_vrr
results: parsing output: 89/ for test: kms_psr2_sf
results: parsing output: 90/ for test: kms_plane_multiple
results: parsing output: 91/ for test: gem_tiled_partial_pwrite_pread
results: parsing output: 92/ for test: kms_frontbuffer_tracking
results: parsing output: 93/ for test: gem_exec_schedule
results: parsing output: 94/ for test: gem_tiled_blits
results: parsing output: 95/ for test: kms_big_fb
results: parsing output: 96/ for test: i915_query
results: parsing output: 97/ for test: kms_cursor_legacy
results: parsing output: 98/ for test: sw_sync
results: parsing output: 99/ for test: kms_content_protection
results: parsing output: 100/ for test: perf
results: parsing output: 101/ for test: gem_mmap_gtt
results: parsing output: 102/ for test: sw_sync
results: parsing output: 103/ for test: gem_render_copy
results: parsing output: 104/ for test: gem_tiled_fence_blits
results: parsing output: 105/ for test: syncobj_timeline
results: parsing output: 106/ for test: kms_frontbuffer_tracking
results: parsing output: 107/ for test: gen3_render_tiledx_blits
results: parsing output: 108/ for test: syncobj_timeline
results: parsing output: 109/ for test: kms_cursor_crc
results: parsing output: 110/ for test: gem_ctx_persistence
results: parsing output: 111/ for test: gem_mmap_gtt
results: parsing output: 112/ for test: kms_pm_rpm
results: parsing output: 113/ for test: kms_frontbuffer_tracking
results: parsing output: 114/ for test: kms_flip
results: parsing output: 115/ for test: gem_exec_flush
results: parsing output: 116/ for test: kms_frontbuffer_tracking
results: parsing output: 117/ for test: gem_userptr_blits
results: parsing output: 118/ for test: kms_plane_scaling
results: parsing output: 119/ for test: kms_cursor_edge_walk
results: parsing output: 120/ for test: kms_big_fb
results: parsing output: 121/ for test: gem_exec_balancer
results: parsing output: 122/ for test: kms_frontbuffer_tracking
results: parsing output: 123/ for test: kms_chamelium_edid
results: parsing output: 124/ for test: i915_pm_rpm
results: parsing output: 125/ for test: kms_dirtyfb
results: parsing output: 126/ for test: kms_frontbuffer_tracking
results: parsing output: 127/ for test: kms_plane
results: parsing output: 128/ for test: gem_bad_reloc
results: parsing output: 129/ for test: gem_exec_fence
results: parsing output: 130/ for test: perf_pmu
results: parsing output: 131/ for test: kms_frontbuffer_tracking
results: parsing output: 132/ for test: perf_pmu
results: parsing output: 133/ for test: gem_caching
Done.