[57.658930] Initializing watchdogs
[57.658977]   /dev/watchdog0
[57.672943] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics]
[57.677306] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[57.679487] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[57.683333] [001/134] (960s left) kms_getfb (getfb-handle-valid)
[57.808025] Starting subtest: getfb-handle-valid
[57.810403] Subtest getfb-handle-valid: SUCCESS (0.000s)
[57.931766] [002/134] (960s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-16bpp-yftile-upscaling)
[58.031357] Starting subtest: flip-64bpp-yftile-to-16bpp-yftile-upscaling
[58.035740] Subtest flip-64bpp-yftile-to-16bpp-yftile-upscaling: SKIP (0.000s)
[58.114618] [003/134] (960s left) kms_plane_scaling (planes-unity-scaling-downscale-factor-0-75)
[58.212398] Starting subtest: planes-unity-scaling-downscale-factor-0-75
[58.214927] Starting dynamic subtest: pipe-A
[58.300158] Dynamic subtest pipe-A: SUCCESS (0.088s)
[58.309480] Starting dynamic subtest: pipe-B
[59.451548] Dynamic subtest pipe-B: SUCCESS (1.150s)
[59.460860] Starting dynamic subtest: pipe-C
[60.559107] Dynamic subtest pipe-C: SUCCESS (1.107s)
[60.568022] Starting dynamic subtest: pipe-D
[61.695501] Dynamic subtest pipe-D: SUCCESS (1.136s)
[61.697969] Subtest planes-unity-scaling-downscale-factor-0-75: SUCCESS (3.483s)
[62.961546] [004/134] (955s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-mmap-gtt)
[63.068645] Starting subtest: fbcpsr-rgb565-draw-mmap-gtt
[63.072641] Subtest fbcpsr-rgb565-draw-mmap-gtt: SKIP (0.000s)
[63.170597] [005/134] (955s left) kms_chamelium_hpd (hdmi-hpd)
[63.561594] Subtest hdmi-hpd: SKIP (0.000s)
[64.354223] [006/134] (954s left) kms_async_flips (invalid-async-flip-atomic)
[64.464069] Starting subtest: invalid-async-flip-atomic
[64.835749] Starting dynamic subtest: pipe-A-eDP-1
[65.707587] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.872s)
[66.063764] Starting dynamic subtest: pipe-B-eDP-1
[66.844212] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.787s)
[67.216188] Starting dynamic subtest: pipe-C-eDP-1
[68.064237] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.854s)
[68.429675] Starting dynamic subtest: pipe-D-eDP-1
[69.274871] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.850s)
[69.277335] Subtest invalid-async-flip-atomic: SUCCESS (4.813s)
[70.418313] [007/134] (947s left) kms_psr (fbc-psr2-sprite-mmap-cpu)
[70.518267] Starting subtest: fbc-psr2-sprite-mmap-cpu
[70.520554] Starting dynamic subtest: eDP-1
[70.525086] Dynamic subtest eDP-1: SKIP (0.000s)
[70.529599] Subtest fbc-psr2-sprite-mmap-cpu: SKIP (0.000s)
[70.602805] [008/134] (947s left) gem_lmem_swapping (heavy-random)
[70.652849] Subtest heavy-random: SKIP (0.000s)
[70.693628] [009/134] (947s left) gem_basic (create-fd-close)
[70.762121] Starting subtest: create-fd-close
[70.766624] Subtest create-fd-close: SUCCESS (0.000s)
[70.887342] [010/134] (947s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-render)
[70.995550] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-render
[70.999846] Subtest fbc-2p-scndscrn-cur-indfb-draw-render: SKIP (0.000s)
[71.092221] [011/134] (947s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-onoff)
[71.207446] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-onoff
[71.211544] Subtest fbcpsr-2p-primscrn-spr-indfb-onoff: SKIP (0.000s)
[71.302247] [012/134] (947s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-onoff)
[71.412140] Starting subtest: fbc-2p-primscrn-spr-indfb-onoff
[71.415563] Subtest fbc-2p-primscrn-spr-indfb-onoff: SKIP (0.000s)
[71.525339] [013/134] (947s left) kms_vblank (crtc-id)
[71.617643] Starting subtest: crtc-id
[71.619783] Starting dynamic subtest: pipe-A-eDP-1
[72.066943] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.447s)
[72.080399] Starting dynamic subtest: pipe-D-eDP-1
[73.250751] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.182s)
[73.253086] Subtest crtc-id: SUCCESS (1.632s)
[74.098538] [014/134] (944s left) kms_flip (2x-wf_vblank-ts-check-interruptible)
[74.195682] Starting subtest: 2x-wf_vblank-ts-check-interruptible
[74.208078] Subtest 2x-wf_vblank-ts-check-interruptible: SKIP (0.011s)
[74.302142] [015/134] (944s left) kms_psr (pr-sprite-mmap-gtt)
[74.399706] Starting subtest: pr-sprite-mmap-gtt
[74.404179] Subtest pr-sprite-mmap-gtt: SKIP (0.000s)
[74.481478] [016/134] (944s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-mmap-gtt)
[74.583664] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-mmap-gtt
[74.588454] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[74.705377] [017/134] (944s left) i915_drm_fdinfo (virtual-busy-idle-all)
[74.746381] Starting subtest: virtual-busy-idle-all
[74.750937] Subtest virtual-busy-idle-all: SKIP (0.000s)
[74.825027] [018/134] (943s left) gem_eio (wait-wedge-1us)
[74.993029] Starting subtest: wait-wedge-1us
[76.923915] Subtest wait-wedge-1us: SUCCESS (1.929s)
[77.061915] [019/134] (941s left) kms_plane_cursor (viewport)
[77.163318] Starting subtest: viewport
[77.167708] Starting dynamic subtest: pipe-A-eDP-1-size-64
[79.744699] Dynamic subtest pipe-A-eDP-1-size-64: SUCCESS (2.580s)
[79.804680] Starting dynamic subtest: pipe-A-eDP-1-size-128
[82.357606] Dynamic subtest pipe-A-eDP-1-size-128: SUCCESS (2.560s)
[82.415790] Starting dynamic subtest: pipe-A-eDP-1-size-256
[84.971511] Dynamic subtest pipe-A-eDP-1-size-256: SUCCESS (2.560s)
[85.317894] Starting dynamic subtest: pipe-B-eDP-1-size-64
[88.551330] Dynamic subtest pipe-B-eDP-1-size-64: SUCCESS (3.244s)
[88.609058] Starting dynamic subtest: pipe-B-eDP-1-size-128
[91.154117] Dynamic subtest pipe-B-eDP-1-size-128: SUCCESS (2.551s)
[91.215453] Starting dynamic subtest: pipe-B-eDP-1-size-256
[93.820835] Dynamic subtest pipe-B-eDP-1-size-256: SUCCESS (2.615s)
[94.168890] Starting dynamic subtest: pipe-C-eDP-1-size-64
[97.100378] Dynamic subtest pipe-C-eDP-1-size-64: SUCCESS (2.941s)
[97.136881] Starting dynamic subtest: pipe-C-eDP-1-size-128
[99.366485] Dynamic subtest pipe-C-eDP-1-size-128: SUCCESS (2.236s)
[99.404540] Starting dynamic subtest: pipe-C-eDP-1-size-256
[101.600278] Dynamic subtest pipe-C-eDP-1-size-256: SUCCESS (2.202s)
[101.927830] Starting dynamic subtest: pipe-D-eDP-1-size-64
[104.803413] Dynamic subtest pipe-D-eDP-1-size-64: SUCCESS (2.884s)
[104.839903] Starting dynamic subtest: pipe-D-eDP-1-size-128
[107.081506] Dynamic subtest pipe-D-eDP-1-size-128: SUCCESS (2.247s)
[107.117824] Starting dynamic subtest: pipe-D-eDP-1-size-256
[109.325092] Dynamic subtest pipe-D-eDP-1-size-256: SUCCESS (2.214s)
[109.647136] Subtest viewport: SUCCESS (32.482s)
[110.486341] [020/134] (908s left) kms_ccs (crc-sprite-planes-basic-4-tiled-dg2-rc-ccs)
[110.581069] Starting subtest: crc-sprite-planes-basic-4-tiled-dg2-rc-ccs
[110.583365] Starting dynamic subtest: pipe-A-eDP-1
[110.642538] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[110.651857] Starting dynamic subtest: pipe-B-eDP-1
[110.709949] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[110.719244] Starting dynamic subtest: pipe-C-eDP-1
[110.776518] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[110.785214] Starting dynamic subtest: pipe-D-eDP-1
[110.841859] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[110.846345] Subtest crc-sprite-planes-basic-4-tiled-dg2-rc-ccs: SKIP (0.009s)
[112.762940] [021/134] (906s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-onoff)
[112.872735] Starting subtest: psr-2p-scndscrn-spr-indfb-onoff
[112.876966] Subtest psr-2p-scndscrn-spr-indfb-onoff: SKIP (0.000s)
[112.972919] [022/134] (905s left) gem_softpin (safe-alignment)
[113.038600] Starting subtest: safe-alignment
[113.063739] Subtest safe-alignment: SUCCESS (0.025s)
[114.949452] [023/134] (904s left) sysfs_heartbeat_interval (precise)
[115.020632] Starting subtest: precise
[115.023026] Starting dynamic subtest: vecs0
[122.905377] Dynamic subtest vecs0: SUCCESS (7.884s)
[122.915742] Starting dynamic subtest: ccs0
[124.187739] Dynamic subtest ccs0: SUCCESS (1.279s)
[124.198466] Starting dynamic subtest: vcs0
[131.941318] Dynamic subtest vcs0: SUCCESS (7.753s)
[131.955603] Starting dynamic subtest: bcs0
[133.131960] Dynamic subtest bcs0: SUCCESS (1.185s)
[133.142256] Starting dynamic subtest: rcs0
[134.309973] Dynamic subtest rcs0: SUCCESS (1.179s)
[134.321060] Starting dynamic subtest: vcs1
[140.903051] Dynamic subtest vcs1: SUCCESS (6.589s)
[140.905869] Subtest precise: SUCCESS (25.882s)
[140.986948] [024/134] (878s left) gem_mmap_wc (close)
[141.050397] Subtest close: SKIP (0.000s)
[141.104498] [025/134] (877s left) gem_exec_balancer (parallel-keep-in-fence)
[141.361513] Starting subtest: parallel-keep-in-fence
[142.485407] Subtest parallel-keep-in-fence: SUCCESS (1.123s)
[142.621370] [026/134] (876s left) kms_invalid_mode (bad-hsync-end)
[142.729356] Starting subtest: bad-hsync-end
[142.731668] Starting dynamic subtest: pipe-A-eDP-1
[143.016544] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.289s)
[143.025085] Starting dynamic subtest: pipe-B-eDP-1
[143.027196] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[143.034402] Starting dynamic subtest: pipe-C-eDP-1
[143.036613] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[143.044062] Starting dynamic subtest: pipe-D-eDP-1
[143.045925] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[143.047870] Subtest bad-hsync-end: SUCCESS (0.295s)
[143.883114] [027/134] (875s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0-async-flip)
[143.989374] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0-async-flip
[144.713383] Subtest x-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SUCCESS (0.726s)
[144.918676] [028/134] (874s left) syncobj_timeline (invalid-signal-illegal-handle)
[144.979074] Starting subtest: invalid-signal-illegal-handle
[144.981495] Subtest invalid-signal-illegal-handle: SUCCESS (0.000s)
[145.111092] [029/134] (874s left) kms_ccs (crc-primary-basic-4-tiled-lnl-ccs)
[145.201152] Starting subtest: crc-primary-basic-4-tiled-lnl-ccs
[145.205644] Subtest crc-primary-basic-4-tiled-lnl-ccs: SKIP (0.000s)
[146.309171] [030/134] (872s left) syncobj_timeline (device-signal-unordered)
[146.378651] Starting subtest: device-signal-unordered
[146.381108] Subtest device-signal-unordered: SUCCESS (0.001s)
[146.507832] [031/134] (872s left) kms_getfb (getfb-reject-nv12)
[146.597062] Starting subtest: getfb-reject-nv12
[146.599441] Subtest getfb-reject-nv12: SUCCESS (0.001s)
[146.743357] [032/134] (872s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-mmap-wc)
[146.849659] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-mmap-wc
[153.893187] Subtest psr-1p-primscrn-pri-shrfb-draw-mmap-wc: SUCCESS (7.046s)
[154.052617] [033/134] (865s left) syncobj_basic (bad-flags-fd-to-handle)
[154.123760] Starting subtest: bad-flags-fd-to-handle
[154.126118] Subtest bad-flags-fd-to-handle: SUCCESS (0.000s)
[154.243303] [034/134] (865s left) kms_psr (psr2-primary-mmap-gtt)
[154.331096] Starting subtest: psr2-primary-mmap-gtt
[154.333293] Starting dynamic subtest: eDP-1
[155.737658] Dynamic subtest eDP-1: SKIP (1.404s)
[155.742404] Subtest psr2-primary-mmap-gtt: SKIP (1.406s)
[155.937176] [035/134] (863s left) gem_partial_pwrite_pread (reads-snoop)
[155.994397] Subtest reads-snoop: SKIP (0.000s)
[156.075835] [036/134] (863s left) i915_drm_fdinfo (memory-info-shared)
[156.114320] Starting subtest: memory-info-shared
[156.116408] Starting dynamic subtest: smem0
[156.176466] Dynamic subtest smem0: SUCCESS (0.064s)
[156.179342] Subtest memory-info-shared: SUCCESS (0.065s)
[156.275062] [037/134] (863s left) gen9_exec_parse (allowed-all)
[156.345611] Subtest allowed-all: SKIP (0.000s)
[156.441496] [038/134] (863s left) kms_psr2_sf (pr-cursor-plane-move-continuous-sf)
[161.555906] Starting subtest: pr-cursor-plane-move-continuous-sf
[161.560214] Subtest pr-cursor-plane-move-continuous-sf: SKIP (0.002s)
[162.418775] [039/134] (857s left) gen7_exec_parse (basic-allocation)
[162.481251] Subtest basic-allocation: SKIP (0.000s)
[162.563521] [040/134] (857s left) gem_bad_reloc (negative-reloc-lut)
[162.627687] Subtest negative-reloc-lut: SKIP (0.000s)
[162.708287] [041/134] (857s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12)
[162.814063] Starting subtest: compare-crc-sanitycheck-nv12
[162.816205] Starting dynamic subtest: pipe-A-eDP-1
[163.565520] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.747s)
[163.573349] Starting dynamic subtest: pipe-B-eDP-1
[164.902745] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.337s)
[164.911453] Starting dynamic subtest: pipe-C-eDP-1
[166.188874] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.283s)
[166.197632] Starting dynamic subtest: pipe-D-eDP-1
[167.411219] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.224s)
[167.413617] Subtest compare-crc-sanitycheck-nv12: SUCCESS (4.598s)
[168.253312] [042/134] (851s left) kms_big_fb (x-tiled-32bpp-rotate-270)
[168.352704] Starting subtest: x-tiled-32bpp-rotate-270
[168.373482] Subtest x-tiled-32bpp-rotate-270: SKIP (0.020s)
[168.518768] [043/134] (851s left) kms_rotation_crc (primary-y-tiled-reflect-x-180)
[168.619166] Starting subtest: primary-y-tiled-reflect-x-180
[168.678857] Subtest primary-y-tiled-reflect-x-180: SKIP (0.059s)
[168.793614] [044/134] (851s left) gem_render_copy (yf-tiled)
[168.858746] Starting subtest: yf-tiled
[168.863104] Subtest yf-tiled: SKIP (0.000s)
[169.051406] [045/134] (850s left) sw_sync (sync_multi_consumer)
[169.086579] Starting subtest: sync_multi_consumer
[169.499007] Subtest sync_multi_consumer: SUCCESS (0.413s)
[169.580128] [046/134] (850s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-180-async-flip)
[169.685419] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-180-async-flip
[169.689472] Subtest y-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SKIP (0.000s)
[169.803010] [047/134] (850s left) kms_flip (flip-vs-suspend)
[169.905184] Starting subtest: flip-vs-suspend
[169.907379] Starting dynamic subtest: A-eDP1
[218.972367] Dynamic subtest A-eDP1: SUCCESS (4.698s)
[218.987370] Starting dynamic subtest: B-eDP1
[267.960103] Dynamic subtest B-eDP1: SUCCESS (4.527s)
[267.970986] Starting dynamic subtest: C-eDP1
[316.958411] Dynamic subtest C-eDP1: SUCCESS (4.540s)
[316.972900] Starting dynamic subtest: D-eDP1
[365.956488] Dynamic subtest D-eDP1: SUCCESS (4.473s)
[365.959041] Subtest flip-vs-suspend: SUCCESS (18.248s)
[367.158766] [048/134] (652s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-render)
[367.262688] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-render
[367.267042] Subtest fbc-2p-primscrn-pri-shrfb-draw-render: SKIP (0.000s)
[367.389170] [049/134] (652s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-indfb-msflip-blt)
[367.501358] Starting subtest: fbc-2p-scndscrn-indfb-msflip-blt
[367.506492] Subtest fbc-2p-scndscrn-indfb-msflip-blt: SKIP (0.000s)
[367.629084] [050/134] (652s left) kms_ccs (bad-pixel-format-4-tiled-mtl-rc-ccs-cc)
[367.729538] Starting subtest: bad-pixel-format-4-tiled-mtl-rc-ccs-cc
[367.732128] Starting dynamic subtest: pipe-A-eDP-1
[367.754420] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[367.764817] Starting dynamic subtest: pipe-B-eDP-1
[367.788449] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[367.797650] Starting dynamic subtest: pipe-C-eDP-1
[367.820442] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[367.828781] Starting dynamic subtest: pipe-D-eDP-1
[367.851664] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[367.854061] Subtest bad-pixel-format-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.005s)
[369.937042] [051/134] (650s left) gem_readwrite (read-write)
[369.996632] Subtest read-write: SKIP (0.000s)
[370.063655] [052/134] (650s left) kms_cursor_crc (cursor-offscreen-256x256)
[370.307786] Starting subtest: cursor-offscreen-256x256
[370.310670] Starting dynamic subtest: pipe-A-eDP-1
[372.273113] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.960s)
[372.301767] Starting dynamic subtest: pipe-D-eDP-1
[374.863350] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.568s)
[374.866046] Subtest cursor-offscreen-256x256: SUCCESS (4.555s)
[375.715220] [053/134] (644s left) kms_sequence (get-idle)
[375.825930] Starting subtest: get-idle
[375.828687] Starting dynamic subtest: pipe-A-eDP-1
[377.628660] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.800s)
[377.639801] Starting dynamic subtest: pipe-B-eDP-1
[380.088646] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.457s)
[380.098580] Starting dynamic subtest: pipe-C-eDP-1
[382.500046] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.410s)
[382.512861] Starting dynamic subtest: pipe-D-eDP-1
[384.944733] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.444s)
[384.947671] Subtest get-idle: SUCCESS (9.118s)
[385.759539] [054/134] (634s left) kms_color (ctm-red-to-blue)
[385.866096] Starting subtest: ctm-red-to-blue
[385.868426] Starting dynamic subtest: pipe-A-eDP-1
[386.600091] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.734s)
[386.609401] Starting dynamic subtest: pipe-B-eDP-1
[388.063294] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.463s)
[388.082708] Starting dynamic subtest: pipe-C-eDP-1
[389.432327] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.370s)
[389.441961] Starting dynamic subtest: pipe-D-eDP-1
[390.777525] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.344s)
[390.780170] Subtest ctm-red-to-blue: SUCCESS (4.914s)
[391.582001] [055/134] (628s left) sw_sync (sync_merge_invalid)
[391.615839] Starting subtest: sync_merge_invalid
[391.646052] Subtest sync_merge_invalid: SUCCESS (0.031s)
[391.712229] [056/134] (628s left) gem_mmap_gtt (cpuset-basic-small-copy-xy)
[391.778441] Subtest cpuset-basic-small-copy-XY: SKIP (0.000s)
[391.838585] [057/134] (628s left) syncobj_timeline (invalid-multi-wait-unsubmitted)
[391.906767] Starting subtest: invalid-multi-wait-unsubmitted
[391.909659] Subtest invalid-multi-wait-unsubmitted: SUCCESS (0.000s)
[392.025112] [058/134] (628s left) kms_pm_rpm (fences)
[393.871910] Starting subtest: fences
[393.876805] Subtest fences: SKIP (0.000s)
[394.327200] [059/134] (626s left) gem_exec_params (rel-constants-invalid-rel-gen5)
[394.389302] Starting subtest: rel-constants-invalid-rel-gen5
[394.391845] Subtest rel-constants-invalid-rel-gen5: SUCCESS (0.000s)
[394.510179] [060/134] (626s left) kms_psr (fbc-psr-no-drrs)
[394.600659] Starting subtest: fbc-psr-no-drrs
[394.603468] Starting dynamic subtest: eDP-1
[394.608592] Dynamic subtest eDP-1: SKIP (0.000s)
[394.613701] Subtest fbc-psr-no-drrs: SKIP (0.001s)
[394.684546] [061/134] (625s left) kms_frontbuffer_tracking (fbc-tiling-4)
[394.775728] Starting subtest: fbc-tiling-4
[399.034652] Subtest fbc-tiling-4: SUCCESS (4.262s)
[400.202299] [062/134] (620s left) gem_eio (wait-immediate)
[400.455473] Starting subtest: wait-immediate
[400.858273] Subtest wait-immediate: SUCCESS (0.404s)
[400.997381] [063/134] (619s left) gem_sync (basic-store-all)
[401.080821] Starting subtest: basic-store-all
[405.699194] Subtest basic-store-all: SUCCESS (4.631s)
[405.895323] [064/134] (614s left) gem_exec_gttfill (all-engines)
[405.971614] Starting subtest: all-engines
[429.694960] Subtest all-engines: SUCCESS (23.723s)
[429.900209] [065/134] (590s left) kms_cdclk (plane-scaling)
[430.051845] Starting subtest: plane-scaling
[430.054682] Starting dynamic subtest: pipe-A-eDP-1
[430.357562] Dynamic subtest pipe-A-eDP-1: SKIP (0.300s)
[430.368093] Starting dynamic subtest: pipe-B-eDP-1
[430.373810] Dynamic subtest pipe-B-eDP-1: SKIP (0.004s)
[430.383586] Starting dynamic subtest: pipe-C-eDP-1
[430.389338] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[430.399229] Starting dynamic subtest: pipe-D-eDP-1
[430.404624] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[430.409784] Subtest plane-scaling: SKIP (0.311s)
[431.232505] [066/134] (589s left) kms_flip (nonblocking-read)
[431.343043] Starting subtest: nonblocking-read
[431.345277] Subtest nonblocking-read: SUCCESS (0.000s)
[431.472637] [067/134] (589s left) kms_dsc (dsc-with-output-formats)
[431.572795] Starting subtest: dsc-with-output-formats
[431.598443] Subtest dsc-with-output-formats: SKIP (0.000s)
[431.656730] [068/134] (589s left) gem_mmap_gtt (big-bo-tiledy)
[431.728764] Subtest big-bo-tiledY: SKIP (0.000s)
[431.794165] [069/134] (589s left) gem_exec_alignment (pi)
[431.853721] Starting subtest: pi
[483.372804] Subtest pi: SUCCESS (51.512s)
[484.574130] [070/134] (536s left) kms_big_fb (4-tiled-8bpp-rotate-270)
[484.728386] Starting subtest: 4-tiled-8bpp-rotate-270
[484.749630] Subtest 4-tiled-8bpp-rotate-270: SKIP (0.020s)
[484.898440] [071/134] (536s left) api_intel_allocator (reopen)
[484.960441] Starting subtest: reopen
[484.963476] Subtest reopen: SUCCESS (0.005s)
[485.125043] [072/134] (535s left) kms_psr (psr-primary-render)
[485.219040] Starting subtest: psr-primary-render
[485.221454] Starting dynamic subtest: eDP-1
[487.030350] Dynamic subtest eDP-1: SUCCESS (1.812s)
[487.033003] Subtest psr-primary-render: SUCCESS (1.813s)
[487.894401] [073/134] (533s left) gem_pxp (create-regular-context-1)
[488.027248] Starting subtest: create-regular-context-1
[488.030085] Subtest create-regular-context-1: SUCCESS (0.002s)
[488.182100] [074/134] (532s left) kms_big_fb (linear-8bpp-rotate-90)
[488.283454] Starting subtest: linear-8bpp-rotate-90
[488.309693] Subtest linear-8bpp-rotate-90: SKIP (0.025s)
[488.436146] [075/134] (532s left) kms_ccs (crc-primary-suspend-4-tiled-mtl-mc-ccs)
[488.542471] Starting subtest: crc-primary-suspend-4-tiled-mtl-mc-ccs
[488.545041] Starting dynamic subtest: pipe-A-eDP-1
[521.224899] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.990s)
[521.234824] Starting dynamic subtest: pipe-B-eDP-1
[554.137673] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.648s)
[554.147526] Starting dynamic subtest: pipe-C-eDP-1
[587.117735] Dynamic subtest pipe-C-eDP-1: SUCCESS (3.700s)
[587.129141] Starting dynamic subtest: pipe-D-eDP-1
[620.108090] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.649s)
[620.110698] Subtest crc-primary-suspend-4-tiled-mtl-mc-ccs: SUCCESS (13.993s)
[621.361615] [076/134] (399s left) kms_psr (fbc-pr-primary-blt)
[621.463489] Starting subtest: fbc-pr-primary-blt
[621.469200] Subtest fbc-pr-primary-blt: SKIP (0.000s)
[621.542763] [077/134] (399s left) gem_ccs (suspend-resume)
[621.606388] Starting subtest: suspend-resume
[621.612193] Subtest suspend-resume: SKIP (0.000s)
[621.714842] [078/134] (399s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-mmap-gtt)
[621.812446] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-mmap-gtt
[621.817422] Subtest fbc-2p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[621.919224] [079/134] (399s left) kms_vrr (seamless-rr-switch-vrr)
[622.017581] Starting subtest: seamless-rr-switch-vrr
[622.025520] Subtest seamless-rr-switch-vrr: SKIP (0.000s)
[622.103407] [080/134] (399s left) kms_addfb_basic (bad-pitch-65536)
[622.172593] Starting subtest: bad-pitch-65536
[622.175356] Subtest bad-pitch-65536: SUCCESS (0.000s)
[622.331944] [081/134] (399s left) gem_exec_schedule (noreorder)
[622.531524] Starting subtest: noreorder
[622.534550] Starting dynamic subtest: rcs0
[622.601948] Dynamic subtest rcs0: SUCCESS (0.070s)
[622.615036] Starting dynamic subtest: vcs0
[624.304303] Dynamic subtest vcs0: SUCCESS (1.697s)
[624.315854] Starting dynamic subtest: vcs1
[626.237395] Dynamic subtest vcs1: SUCCESS (1.928s)
[626.250636] Starting dynamic subtest: vecs0
[628.265605] Dynamic subtest vecs0: SUCCESS (2.025s)
[628.285649] Starting dynamic subtest: ccs0
[628.371098] Dynamic subtest ccs0: SUCCESS (0.103s)
[628.374056] Subtest noreorder: SUCCESS (5.834s)
[628.573838] [082/134] (392s left) gem_ctx_param (invalid-get-engines)
[628.630150] Starting subtest: invalid-get-engines
[628.632628] Subtest invalid-get-engines: SUCCESS (0.001s)
[628.731969] [083/134] (392s left) gem_exec_whisper (basic-fds)
[628.805845] Starting subtest: basic-fds
[636.213073] Subtest basic-fds: SUCCESS (7.397s)
[636.406045] [084/134] (385s left) core_setmaster (master-drop-set-user)
[636.504043] Starting subtest: master-drop-set-user
[636.515586] Subtest master-drop-set-user: SUCCESS (0.015s)
[636.559464] [085/134] (385s left) gem_mmap_wc (set-cache-level)
[636.613359] Subtest set-cache-level: SKIP (0.000s)
[636.669636] [086/134] (384s left) kms_async_flips (alternate-sync-async-flip)
[636.768500] Starting subtest: alternate-sync-async-flip
[637.142717] Starting dynamic subtest: pipe-A-eDP-1
[639.952983] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.809s)
[640.337323] Starting dynamic subtest: pipe-B-eDP-1
[643.084475] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.755s)
[643.463456] Starting dynamic subtest: pipe-C-eDP-1
[646.219560] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.764s)
[646.599051] Starting dynamic subtest: pipe-D-eDP-1
[649.351170] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.761s)
[649.353242] Subtest alternate-sync-async-flip: SUCCESS (12.579s)
[650.525887] [087/134] (371s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-mmap-wc)
[650.635195] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-mmap-wc
[654.944075] Subtest fbc-1p-primscrn-pri-shrfb-draw-mmap-wc: SUCCESS (4.313s)
[656.150475] [088/134] (365s left) api_intel_bb (reset-bb)
[656.211246] Starting subtest: reset-bb
[656.213989] Subtest reset-bb: SUCCESS (0.004s)
[656.357926] [089/134] (365s left) kms_vrr (flip-suspend)
[656.446276] Starting subtest: flip-suspend
[656.453594] Subtest flip-suspend: SKIP (0.000s)
[656.531050] [090/134] (365s left) kms_psr2_sf (fbc-pr-plane-move-sf-dmg-area)
[661.497888] Starting subtest: fbc-pr-plane-move-sf-dmg-area
[661.502850] Subtest fbc-pr-plane-move-sf-dmg-area: SKIP (0.002s)
[662.358893] [091/134] (359s left) kms_plane_multiple (tiling-yf)
[662.452271] Starting subtest: tiling-yf
[662.457290] Subtest tiling-yf: SKIP (0.000s)
[662.538941] [092/134] (359s left) gem_tiled_partial_pwrite_pread (reads)
[662.597390] Subtest reads: SKIP (0.000s)
[662.677627] [093/134] (359s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-render)
[662.784029] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-render
[666.941569] Subtest fbc-1p-offscreen-pri-indfb-draw-render: SUCCESS (4.161s)
[668.068925] [094/134] (353s left) gem_exec_schedule (timeslicing)
[668.146197] Starting subtest: timeslicing
[668.149019] Starting dynamic subtest: rcs0
[668.154873] Dynamic subtest rcs0: SUCCESS (0.021s)
[668.166082] Starting dynamic subtest: bcs0
[668.175107] Dynamic subtest bcs0: SUCCESS (0.021s)
[668.185627] Starting dynamic subtest: vcs0
[668.195564] Dynamic subtest vcs0: SUCCESS (0.020s)
[668.205597] Starting dynamic subtest: vcs1
[668.216421] Dynamic subtest vcs1: SUCCESS (0.020s)
[668.226635] Starting dynamic subtest: vecs0
[668.236569] Dynamic subtest vecs0: SUCCESS (0.019s)
[668.249737] Starting dynamic subtest: ccs0
[668.258470] Dynamic subtest ccs0: SUCCESS (0.021s)
[668.261326] Subtest timeslicing: SUCCESS (0.126s)
[669.318385] [095/134] (352s left) gem_tiled_blits (interruptible)
[669.399137] Subtest interruptible: SKIP (0.000s)
[669.482883] [096/134] (352s left) kms_big_fb (y-tiled-64bpp-rotate-270)
[669.582268] Starting subtest: y-tiled-64bpp-rotate-270
[669.586907] Subtest y-tiled-64bpp-rotate-270: SKIP (0.000s)
[669.726796] [097/134] (352s left) i915_query (hwconfig_table)
[669.794575] Starting subtest: hwconfig_table
[670.143746] Subtest hwconfig_table: SUCCESS (0.001s)
[670.182937] [098/134] (351s left) kms_cursor_legacy (basic-flip-after-cursor-legacy)
[670.309379] Starting subtest: basic-flip-after-cursor-legacy
[671.227311] Subtest basic-flip-after-cursor-legacy: SUCCESS (0.916s)
[672.082680] [099/134] (350s left) sw_sync (sync_busy_fork)
[672.128024] Starting subtest: sync_busy_fork
[673.137065] Subtest sync_busy_fork: SUCCESS (1.010s)
[673.211432] [100/134] (348s left) kms_content_protection (atomic-dpms)
[673.362100] Starting subtest: atomic-dpms
[673.367461] Subtest atomic-dpms: SKIP (0.000s)
[673.507802] [101/134] (348s left) perf (stress-open-close)
[673.641400] Starting subtest: stress-open-close
[673.643745] Starting dynamic subtest: 0-rcs0
[675.807451] Dynamic subtest 0-rcs0: SUCCESS (2.166s)
[675.817011] Starting dynamic subtest: 1-vcs1
[677.971389] Dynamic subtest 1-vcs1: SUCCESS (2.161s)
[677.973856] Subtest stress-open-close: SUCCESS (4.330s)
[678.010462] [102/134] (344s left) gem_mmap_gtt (zero-extend)
[678.059160] Subtest zero-extend: SKIP (0.000s)
[678.129907] [103/134] (344s left) sw_sync (sync_multi_timeline_wait)
[678.165162] Starting subtest: sync_multi_timeline_wait
[678.167179] Subtest sync_multi_timeline_wait: SUCCESS (0.000s)
[678.229748] [104/134] (344s left) gem_render_copy (yf-tiled-ccs-to-yf-tiled-ccs)
[678.295365] Starting subtest: yf-tiled-ccs-to-yf-tiled-ccs
[678.300238] Subtest yf-tiled-ccs-to-yf-tiled-ccs: SKIP (0.000s)
[678.494613] [105/134] (343s left) gem_tiled_fence_blits (normal)
[678.564609] Subtest normal: SKIP (0.000s)
[678.630413] [106/134] (343s left) syncobj_timeline (wait-all-for-submit-delayed-submit)
[678.696754] Starting subtest: wait-all-for-submit-delayed-submit
[678.798331] Subtest wait-all-for-submit-delayed-submit: SUCCESS (0.103s)
[678.892084] [107/134] (343s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-mmap-gtt)
[678.998428] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-mmap-gtt
[679.003357] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[679.122575] [108/134] (343s left) gen3_render_tiledx_blits
[679.256335] [109/134] (343s left) syncobj_timeline (multi-wait-signaled)
[679.319225] Starting subtest: multi-wait-signaled
[679.322006] Subtest multi-wait-signaled: SUCCESS (0.000s)
[679.420928] [110/134] (343s left) kms_cursor_crc (cursor-rapid-movement-32x10)
[679.599140] Starting subtest: cursor-rapid-movement-32x10
[679.648823] Subtest cursor-rapid-movement-32x10: SKIP (0.042s)
[679.938683] [111/134] (342s left) gem_ctx_persistence (legacy-engines-mixed-process)
[679.999593] Starting subtest: legacy-engines-mixed-process
[680.002316] Starting dynamic subtest: render
[681.318089] Dynamic subtest render: SUCCESS (1.317s)
[681.329171] Starting dynamic subtest: bsd1
[683.245848] Dynamic subtest bsd1: SUCCESS (1.925s)
[683.258613] Starting dynamic subtest: bsd2
[685.290948] Dynamic subtest bsd2: SUCCESS (2.042s)
[685.306144] Starting dynamic subtest: blt
[687.259563] Dynamic subtest blt: SUCCESS (1.965s)
[687.271758] Starting dynamic subtest: vebox
[689.256206] Dynamic subtest vebox: SUCCESS (1.994s)
[689.259227] Subtest legacy-engines-mixed-process: SUCCESS (9.254s)
[689.351586] [112/134] (333s left) gem_mmap_gtt (basic-write-cpu-read-gtt)
[689.404833] Subtest basic-write-cpu-read-gtt: SKIP (0.000s)
[689.475761] [113/134] (333s left) kms_pm_rpm (package-g7)
[691.408922] Starting subtest: package-g7
[691.414818] Subtest package-g7: SKIP (0.000s)
[691.804992] [114/134] (330s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-mmap-gtt)
[691.914450] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-mmap-gtt
[691.919451] Subtest psr-2p-scndscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[692.043363] [115/134] (330s left) kms_flip (2x-flip-vs-modeset)
[692.138185] Starting subtest: 2x-flip-vs-modeset
[692.146249] Subtest 2x-flip-vs-modeset: SKIP (0.011s)
[692.277781] [116/134] (330s left) gem_exec_flush (basic-uc-rw-default)
[692.348344] Starting subtest: basic-uc-rw-default
[697.805376] Subtest basic-uc-rw-default: SUCCESS (5.455s)
[698.003907] [117/134] (324s left) kms_frontbuffer_tracking (fbcpsr-2p-rte)
[698.105141] Starting subtest: fbcpsr-2p-rte
[698.109970] Subtest fbcpsr-2p-rte: SKIP (0.000s)
[698.224249] [118/134] (324s left) gem_userptr_blits (map-fixed-invalidate-overlap)
[698.296370] Starting subtest: map-fixed-invalidate-overlap
[698.302312] Subtest map-fixed-invalidate-overlap: SKIP (0.000s)
[698.431480] [119/134] (324s left) kms_plane_scaling (plane-scaler-with-clipping-clamping-pixel-formats)
[698.526021] Starting subtest: plane-scaler-with-clipping-clamping-pixel-formats
[698.528495] Starting dynamic subtest: pipe-A
[698.660886] Dynamic subtest pipe-A: SKIP (0.131s)
[698.673159] Starting dynamic subtest: pipe-B
[699.849090] Dynamic subtest pipe-B: SKIP (1.187s)
[699.859713] Starting dynamic subtest: pipe-C
[701.081576] Dynamic subtest pipe-C: SUCCESS (1.237s)
[701.092005] Starting dynamic subtest: pipe-D
[702.238248] Dynamic subtest pipe-D: SUCCESS (1.156s)
[702.240553] Subtest plane-scaler-with-clipping-clamping-pixel-formats: SUCCESS (3.714s)
[703.450856] [120/134] (319s left) kms_cursor_edge_walk (128x128-left-edge)
[703.560251] Starting subtest: 128x128-left-edge
[703.562502] Starting dynamic subtest: pipe-A-eDP-1
[707.003181] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.440s)
[707.014598] Starting dynamic subtest: pipe-D-eDP-1
[710.125173] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.120s)
[710.127785] Subtest 128x128-left-edge: SUCCESS (6.563s)
[710.942127] [121/134] (312s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180)
[711.050382] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180
[711.055345] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180: SKIP (0.000s)
[711.177743] [122/134] (311s left) gem_exec_balancer (parallel-balancer)
[711.445817] Starting subtest: parallel-balancer
[712.312302] Subtest parallel-balancer: SUCCESS (0.866s)
[712.445837] [123/134] (310s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-pwrite)
[712.538337] Starting subtest: psr-1p-primscrn-pri-indfb-draw-pwrite
[720.185482] Subtest psr-1p-primscrn-pri-indfb-draw-pwrite: SUCCESS (7.649s)
[720.301325] [124/134] (302s left) kms_chamelium_edid (dp-mode-timings)
[720.691113] Subtest dp-mode-timings: SKIP (0.000s)
[721.538734] [125/134] (301s left) i915_pm_rpm (gem-execbuf-stress-pc8)
[723.481209] Starting subtest: gem-execbuf-stress-pc8
[723.524403] Subtest gem-execbuf-stress-pc8: SKIP (0.041s)
[723.863722] [126/134] (299s left) kms_dirtyfb (psr-dirtyfb-ioctl)
[723.959034] Starting subtest: psr-dirtyfb-ioctl
[723.961603] Starting dynamic subtest: A-eDP-1
[727.851590] Dynamic subtest A-eDP-1: SUCCESS (3.891s)
[727.854371] Subtest psr-dirtyfb-ioctl: SUCCESS (3.892s)
[728.653365] [127/134] (294s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-pwrite)
[728.768402] Starting subtest: psr-2p-primscrn-pri-indfb-draw-pwrite
[728.773522] Subtest psr-2p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[728.873397] [128/134] (294s left) kms_plane (pixel-format-4-tiled-mtl-mc-ccs-modifier-source-clamping)
[728.961295] Starting subtest: pixel-format-4-tiled-mtl-mc-ccs-modifier-source-clamping
[728.987789] Starting dynamic subtest: pipe-A-plane-0
[729.420596] Dynamic subtest pipe-A-plane-0: SUCCESS (0.433s)
[729.431583] Starting dynamic subtest: pipe-A-plane-3
[729.676555] Dynamic subtest pipe-A-plane-3: SUCCESS (0.255s)
[729.689221] Starting dynamic subtest: pipe-A-plane-5
[729.693347] Dynamic subtest pipe-A-plane-5: SKIP (0.000s)
[730.733431] Starting dynamic subtest: pipe-B-plane-0
[731.181486] Dynamic subtest pipe-B-plane-0: SUCCESS (0.455s)
[731.194647] Starting dynamic subtest: pipe-B-plane-3
[731.447607] Dynamic subtest pipe-B-plane-3: SUCCESS (0.266s)
[731.458293] Starting dynamic subtest: pipe-B-plane-5
[731.462802] Dynamic subtest pipe-B-plane-5: SKIP (0.000s)
[731.755823] Subtest pixel-format-4-tiled-mtl-mc-ccs-modifier-source-clamping: SUCCESS (2.796s)
[732.619339] [129/134] (290s left) gem_bad_reloc (negative-reloc-bltcopy)
[732.685077] Subtest negative-reloc-bltcopy: SKIP (0.000s)
[732.775437] [130/134] (290s left) gem_exec_fence (submit)
[732.960876] Starting subtest: submit
[732.966409] Subtest submit: SKIP (0.000s)
[734.402469] [FACT gem_exec_fence (submit)] new: kernel.kmod_is_loaded.vgem: true
[734.405825] [131/134] (289s left) perf_pmu (frequency)
[734.447395] Starting subtest: frequency
[734.450550] Starting dynamic subtest: gt0
[736.664026] Dynamic subtest gt0: SUCCESS (2.210s)
[736.675451] Starting dynamic subtest: idle-gt0
[737.168270] Dynamic subtest idle-gt0: SUCCESS (0.504s)
[737.180745] Starting dynamic subtest: gt1
[742.302322] Dynamic subtest gt1: SUCCESS (5.129s)
[742.314267] Starting dynamic subtest: idle-gt1
[742.806361] Dynamic subtest idle-gt1: SUCCESS (0.504s)
[742.809466] Subtest frequency: SUCCESS (8.364s)
[742.942063] [132/134] (280s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-shrfb-msflip-blt)
[743.053074] Starting subtest: fbcpsr-1p-primscrn-shrfb-msflip-blt
[750.454334] Subtest fbcpsr-1p-primscrn-shrfb-msflip-blt: SUCCESS (7.403s)
[750.592285] [133/134] (272s left) perf_pmu (enable-race)
[750.635593] Starting subtest: enable-race
[750.638439] Starting dynamic subtest: rcs0
[763.397403] Dynamic subtest rcs0: SUCCESS (12.761s)
[763.408358] Starting dynamic subtest: bcs0
[776.140413] Dynamic subtest bcs0: SUCCESS (12.739s)
[776.151570] Starting dynamic subtest: vcs0
[791.252010] Dynamic subtest vcs0: SUCCESS (15.104s)
[791.266377] Starting dynamic subtest: vcs1
[807.250858] Dynamic subtest vcs1: SUCCESS (15.991s)
[807.262863] Starting dynamic subtest: vecs0
[823.251291] Dynamic subtest vecs0: SUCCESS (15.993s)
[823.265429] Starting dynamic subtest: ccs0
[836.016575] Dynamic subtest ccs0: SUCCESS (12.760s)
[836.019488] Subtest enable-race: SUCCESS (85.362s)
[836.126472] [134/134] (187s left) gem_caching (read-writes)
[836.198057] Subtest read-writes: SKIP (0.000s)
[836.262141] 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.