[58.775593] Initializing watchdogs
[58.775646]   /dev/watchdog0
[58.789680] [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.794168] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[58.796397] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[58.799952] [001/134] (960s left) kms_getfb (getfb-handle-valid)
[58.924373] Starting subtest: getfb-handle-valid
[58.926661] Subtest getfb-handle-valid: SUCCESS (0.000s)
[59.045948] [002/134] (960s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-16bpp-yftile-upscaling)
[59.150833] Starting subtest: flip-64bpp-yftile-to-16bpp-yftile-upscaling
[59.154863] Subtest flip-64bpp-yftile-to-16bpp-yftile-upscaling: SKIP (0.000s)
[59.229604] [003/134] (960s left) kms_plane_scaling (planes-unity-scaling-downscale-factor-0-75)
[59.324876] Starting subtest: planes-unity-scaling-downscale-factor-0-75
[59.327314] Starting dynamic subtest: pipe-A
[59.412940] Dynamic subtest pipe-A: SUCCESS (0.088s)
[59.421651] Starting dynamic subtest: pipe-B
[60.582644] Dynamic subtest pipe-B: SUCCESS (1.175s)
[60.591855] Starting dynamic subtest: pipe-C
[61.685664] Dynamic subtest pipe-C: SUCCESS (1.107s)
[61.694134] Starting dynamic subtest: pipe-D
[62.822532] Dynamic subtest pipe-D: SUCCESS (1.140s)
[62.824913] Subtest planes-unity-scaling-downscale-factor-0-75: SUCCESS (3.512s)
[63.991865] [004/134] (955s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-mmap-gtt)
[64.105094] Starting subtest: fbcpsr-rgb565-draw-mmap-gtt
[64.108911] Subtest fbcpsr-rgb565-draw-mmap-gtt: SKIP (0.000s)
[64.224664] [005/134] (955s left) kms_chamelium_hpd (hdmi-hpd)
[64.605686] Subtest hdmi-hpd: SKIP (0.000s)
[65.390602] [006/134] (954s left) kms_async_flips (invalid-async-flip-atomic)
[65.480407] Starting subtest: invalid-async-flip-atomic
[65.869369] Starting dynamic subtest: pipe-A-eDP-1
[66.650350] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.784s)
[67.034344] Starting dynamic subtest: pipe-B-eDP-1
[67.793315] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.768s)
[68.150620] Starting dynamic subtest: pipe-C-eDP-1
[68.998644] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.859s)
[69.349884] Starting dynamic subtest: pipe-D-eDP-1
[70.120906] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.779s)
[70.123311] Subtest invalid-async-flip-atomic: SUCCESS (4.650s)
[71.272582] [007/134] (948s left) kms_psr (fbc-psr2-sprite-mmap-cpu)
[71.372634] Starting subtest: fbc-psr2-sprite-mmap-cpu
[71.374517] Starting dynamic subtest: eDP-1
[71.378502] Dynamic subtest eDP-1: SKIP (0.000s)
[71.382493] Subtest fbc-psr2-sprite-mmap-cpu: SKIP (0.000s)
[71.449966] [008/134] (948s left) gem_lmem_swapping (heavy-random)
[71.496341] Subtest heavy-random: SKIP (0.000s)
[71.540696] [009/134] (948s left) gem_basic (create-fd-close)
[71.594639] Starting subtest: create-fd-close
[71.598711] Subtest create-fd-close: SUCCESS (0.000s)
[71.691357] [010/134] (947s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-render)
[71.794443] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-render
[71.798614] Subtest fbc-2p-scndscrn-cur-indfb-draw-render: SKIP (0.000s)
[71.906511] [011/134] (947s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-onoff)
[72.014686] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-onoff
[72.018758] Subtest fbcpsr-2p-primscrn-spr-indfb-onoff: SKIP (0.000s)
[72.143436] [012/134] (947s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-onoff)
[72.251734] Starting subtest: fbc-2p-primscrn-spr-indfb-onoff
[72.255215] Subtest fbc-2p-primscrn-spr-indfb-onoff: SKIP (0.000s)
[72.371652] [013/134] (947s left) kms_vblank (crtc-id)
[72.462205] Starting subtest: crtc-id
[72.464074] Starting dynamic subtest: pipe-A-eDP-1
[72.911907] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.451s)
[72.923768] Starting dynamic subtest: pipe-D-eDP-1
[74.021682] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.107s)
[74.023975] Subtest crtc-id: SUCCESS (1.561s)
[74.853951] [014/134] (944s left) kms_flip (2x-wf_vblank-ts-check-interruptible)
[74.951614] Starting subtest: 2x-wf_vblank-ts-check-interruptible
[74.963929] Subtest 2x-wf_vblank-ts-check-interruptible: SKIP (0.011s)
[75.074993] [015/134] (944s left) kms_psr (pr-sprite-mmap-gtt)
[75.167373] Starting subtest: pr-sprite-mmap-gtt
[75.171976] Subtest pr-sprite-mmap-gtt: SKIP (0.000s)
[75.248233] [016/134] (944s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-mmap-gtt)
[75.366412] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-mmap-gtt
[75.370362] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[75.493320] [017/134] (944s left) i915_drm_fdinfo (virtual-busy-idle-all)
[75.537794] Starting subtest: virtual-busy-idle-all
[75.542312] Subtest virtual-busy-idle-all: SKIP (0.000s)
[75.618664] [018/134] (944s left) gem_eio (wait-wedge-1us)
[75.786252] Starting subtest: wait-wedge-1us
[76.934562] Subtest wait-wedge-1us: SUCCESS (1.149s)
[77.100546] [019/134] (942s left) kms_plane_cursor (viewport)
[77.195774] Starting subtest: viewport
[77.200241] Starting dynamic subtest: pipe-A-eDP-1-size-64
[79.757421] Dynamic subtest pipe-A-eDP-1-size-64: SUCCESS (2.561s)
[79.816366] Starting dynamic subtest: pipe-A-eDP-1-size-128
[82.404991] Dynamic subtest pipe-A-eDP-1-size-128: SUCCESS (2.596s)
[82.461964] Starting dynamic subtest: pipe-A-eDP-1-size-256
[85.038917] Dynamic subtest pipe-A-eDP-1-size-256: SUCCESS (2.583s)
[85.385806] Starting dynamic subtest: pipe-B-eDP-1-size-64
[88.720913] Dynamic subtest pipe-B-eDP-1-size-64: SUCCESS (3.347s)
[88.778846] Starting dynamic subtest: pipe-B-eDP-1-size-128
[91.346034] Dynamic subtest pipe-B-eDP-1-size-128: SUCCESS (2.573s)
[91.403995] Starting dynamic subtest: pipe-B-eDP-1-size-256
[93.990061] Dynamic subtest pipe-B-eDP-1-size-256: SUCCESS (2.594s)
[94.336513] Starting dynamic subtest: pipe-C-eDP-1-size-64
[97.315274] Dynamic subtest pipe-C-eDP-1-size-64: SUCCESS (2.988s)
[97.353848] Starting dynamic subtest: pipe-C-eDP-1-size-128
[99.593123] Dynamic subtest pipe-C-eDP-1-size-128: SUCCESS (2.247s)
[99.632178] Starting dynamic subtest: pipe-C-eDP-1-size-256
[101.949716] Dynamic subtest pipe-C-eDP-1-size-256: SUCCESS (2.326s)
[102.289293] Starting dynamic subtest: pipe-D-eDP-1-size-64
[105.195238] Dynamic subtest pipe-D-eDP-1-size-64: SUCCESS (2.916s)
[105.231821] Starting dynamic subtest: pipe-D-eDP-1-size-128
[107.439492] Dynamic subtest pipe-D-eDP-1-size-128: SUCCESS (2.214s)
[107.478813] Starting dynamic subtest: pipe-D-eDP-1-size-256
[109.750547] Dynamic subtest pipe-D-eDP-1-size-256: SUCCESS (2.281s)
[110.070873] Subtest viewport: SUCCESS (32.873s)
[110.885424] [020/134] (909s left) kms_ccs (crc-sprite-planes-basic-4-tiled-dg2-rc-ccs)
[110.997084] Starting subtest: crc-sprite-planes-basic-4-tiled-dg2-rc-ccs
[110.999625] Starting dynamic subtest: pipe-A-eDP-1
[111.057289] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[111.066791] Starting dynamic subtest: pipe-B-eDP-1
[111.123185] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[111.132238] Starting dynamic subtest: pipe-C-eDP-1
[111.190450] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[111.199918] Starting dynamic subtest: pipe-D-eDP-1
[111.258117] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[111.262399] Subtest crc-sprite-planes-basic-4-tiled-dg2-rc-ccs: SKIP (0.009s)
[113.339504] [021/134] (906s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-onoff)
[113.432504] Starting subtest: psr-2p-scndscrn-spr-indfb-onoff
[113.436570] Subtest psr-2p-scndscrn-spr-indfb-onoff: SKIP (0.000s)
[113.554769] [022/134] (906s left) gem_softpin (safe-alignment)
[113.614366] Starting subtest: safe-alignment
[113.645690] Subtest safe-alignment: SUCCESS (0.031s)
[114.952336] [023/134] (905s left) sysfs_heartbeat_interval (precise)
[115.025892] Starting subtest: precise
[115.027825] Starting dynamic subtest: vecs0
[122.930666] Dynamic subtest vecs0: SUCCESS (7.906s)
[122.941594] Starting dynamic subtest: ccs0
[124.145082] Dynamic subtest ccs0: SUCCESS (1.212s)
[124.154885] Starting dynamic subtest: vcs0
[131.951101] Dynamic subtest vcs0: SUCCESS (7.802s)
[131.967174] Starting dynamic subtest: bcs0
[133.188776] Dynamic subtest bcs0: SUCCESS (1.236s)
[133.199167] Starting dynamic subtest: rcs0
[134.359958] Dynamic subtest rcs0: SUCCESS (1.170s)
[134.370629] Starting dynamic subtest: vcs1
[141.934708] Dynamic subtest vcs1: SUCCESS (7.570s)
[141.937465] Subtest precise: SUCCESS (26.910s)
[142.024234] [024/134] (878s left) gem_mmap_wc (close)
[142.091837] Subtest close: SKIP (0.000s)
[142.183901] [025/134] (878s left) gem_exec_balancer (parallel-keep-in-fence)
[142.444038] Starting subtest: parallel-keep-in-fence
[143.571269] Subtest parallel-keep-in-fence: SUCCESS (1.127s)
[143.686457] [026/134] (876s left) kms_invalid_mode (bad-hsync-end)
[143.792979] Starting subtest: bad-hsync-end
[143.795516] Starting dynamic subtest: pipe-A-eDP-1
[144.083481] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.292s)
[144.091762] Starting dynamic subtest: pipe-B-eDP-1
[144.093666] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[144.100885] Starting dynamic subtest: pipe-C-eDP-1
[144.102725] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[144.110628] Starting dynamic subtest: pipe-D-eDP-1
[144.112782] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[144.114978] Subtest bad-hsync-end: SUCCESS (0.298s)
[144.960074] [027/134] (875s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0-async-flip)
[145.073682] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0-async-flip
[145.797671] Subtest x-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SUCCESS (0.726s)
[146.005306] [028/134] (874s left) syncobj_timeline (invalid-signal-illegal-handle)
[146.070705] Starting subtest: invalid-signal-illegal-handle
[146.072957] Subtest invalid-signal-illegal-handle: SUCCESS (0.000s)
[146.198039] [029/134] (874s left) kms_ccs (crc-primary-basic-4-tiled-lnl-ccs)
[146.293520] Starting subtest: crc-primary-basic-4-tiled-lnl-ccs
[146.297862] Subtest crc-primary-basic-4-tiled-lnl-ccs: SKIP (0.000s)
[147.386974] [030/134] (873s left) syncobj_timeline (device-signal-unordered)
[147.448895] Starting subtest: device-signal-unordered
[147.451467] Subtest device-signal-unordered: SUCCESS (0.001s)
[147.569203] [031/134] (872s left) kms_getfb (getfb-reject-nv12)
[147.658687] Starting subtest: getfb-reject-nv12
[147.660924] Subtest getfb-reject-nv12: SUCCESS (0.001s)
[147.774726] [032/134] (872s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-mmap-wc)
[147.870189] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-mmap-wc
[154.973866] Subtest psr-1p-primscrn-pri-shrfb-draw-mmap-wc: SUCCESS (7.105s)
[155.100082] [033/134] (865s left) syncobj_basic (bad-flags-fd-to-handle)
[155.153445] Starting subtest: bad-flags-fd-to-handle
[155.155621] Subtest bad-flags-fd-to-handle: SUCCESS (0.000s)
[155.259022] [034/134] (865s left) kms_psr (psr2-primary-mmap-gtt)
[155.338991] Starting subtest: psr2-primary-mmap-gtt
[155.341322] Starting dynamic subtest: eDP-1
[156.789096] Dynamic subtest eDP-1: SKIP (1.447s)
[156.793903] Subtest psr2-primary-mmap-gtt: SKIP (1.450s)
[156.963602] [035/134] (863s left) gem_partial_pwrite_pread (reads-snoop)
[157.037305] Subtest reads-snoop: SKIP (0.000s)
[157.117764] [036/134] (863s left) i915_drm_fdinfo (memory-info-shared)
[157.164686] Starting subtest: memory-info-shared
[157.166912] Starting dynamic subtest: smem0
[157.242030] Dynamic subtest smem0: SUCCESS (0.078s)
[157.244747] Subtest memory-info-shared: SUCCESS (0.079s)
[157.327442] [037/134] (863s left) gen9_exec_parse (allowed-all)
[157.396018] Subtest allowed-all: SKIP (0.000s)
[157.474315] [038/134] (863s left) kms_psr2_sf (pr-cursor-plane-move-continuous-sf)
[162.489663] Starting subtest: pr-cursor-plane-move-continuous-sf
[162.494230] Subtest pr-cursor-plane-move-continuous-sf: SKIP (0.002s)
[163.359581] [039/134] (857s left) gen7_exec_parse (basic-allocation)
[163.433299] Subtest basic-allocation: SKIP (0.000s)
[163.524517] [040/134] (857s left) gem_bad_reloc (negative-reloc-lut)
[163.591539] Subtest negative-reloc-lut: SKIP (0.000s)
[163.682361] [041/134] (857s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12)
[163.779546] Starting subtest: compare-crc-sanitycheck-nv12
[163.781733] Starting dynamic subtest: pipe-A-eDP-1
[164.473146] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.693s)
[164.485896] Starting dynamic subtest: pipe-B-eDP-1
[165.739725] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.266s)
[165.750459] Starting dynamic subtest: pipe-C-eDP-1
[166.936657] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.195s)
[166.952400] Starting dynamic subtest: pipe-D-eDP-1
[168.169249] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.229s)
[168.171512] Subtest compare-crc-sanitycheck-nv12: SUCCESS (4.389s)
[169.001120] [042/134] (851s left) kms_big_fb (x-tiled-32bpp-rotate-270)
[169.103554] Starting subtest: x-tiled-32bpp-rotate-270
[169.122750] Subtest x-tiled-32bpp-rotate-270: SKIP (0.019s)
[169.277242] [043/134] (851s left) kms_rotation_crc (primary-y-tiled-reflect-x-180)
[169.376143] Starting subtest: primary-y-tiled-reflect-x-180
[169.448182] Subtest primary-y-tiled-reflect-x-180: SKIP (0.071s)
[169.561576] [044/134] (851s left) gem_render_copy (yf-tiled)
[169.618505] Starting subtest: yf-tiled
[169.622982] Subtest yf-tiled: SKIP (0.000s)
[169.810010] [045/134] (851s left) sw_sync (sync_multi_consumer)
[169.853972] Starting subtest: sync_multi_consumer
[170.283532] Subtest sync_multi_consumer: SUCCESS (0.434s)
[170.361921] [046/134] (850s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-180-async-flip)
[170.455501] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-180-async-flip
[170.459700] Subtest y-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SKIP (0.000s)
[170.576852] [047/134] (850s left) kms_flip (flip-vs-suspend)
[170.668284] Starting subtest: flip-vs-suspend
[170.670522] Starting dynamic subtest: A-eDP1
[220.060539] Dynamic subtest A-eDP1: SUCCESS (4.667s)
[220.069686] Starting dynamic subtest: B-eDP1
[269.048941] Dynamic subtest B-eDP1: SUCCESS (4.506s)
[269.059744] Starting dynamic subtest: C-eDP1
[318.054782] Dynamic subtest C-eDP1: SUCCESS (4.529s)
[318.063777] Starting dynamic subtest: D-eDP1
[367.051893] Dynamic subtest D-eDP1: SUCCESS (4.591s)
[367.056884] Subtest flip-vs-suspend: SUCCESS (18.300s)
[368.242822] [048/134] (652s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-render)
[368.344551] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-render
[368.348652] Subtest fbc-2p-primscrn-pri-shrfb-draw-render: SKIP (0.000s)
[368.446292] [049/134] (652s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-indfb-msflip-blt)
[368.551724] Starting subtest: fbc-2p-scndscrn-indfb-msflip-blt
[368.555710] Subtest fbc-2p-scndscrn-indfb-msflip-blt: SKIP (0.000s)
[368.667778] [050/134] (652s left) kms_ccs (bad-pixel-format-4-tiled-mtl-rc-ccs-cc)
[368.768185] Starting subtest: bad-pixel-format-4-tiled-mtl-rc-ccs-cc
[368.770286] Starting dynamic subtest: pipe-A-eDP-1
[368.789897] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[368.799540] Starting dynamic subtest: pipe-B-eDP-1
[368.818686] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[368.827590] Starting dynamic subtest: pipe-C-eDP-1
[368.846815] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[368.855417] Starting dynamic subtest: pipe-D-eDP-1
[368.875160] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[368.877135] Subtest bad-pixel-format-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.006s)
[371.076758] [051/134] (650s left) gem_readwrite (read-write)
[371.150404] Subtest read-write: SKIP (0.000s)
[371.218776] [052/134] (650s left) kms_cursor_crc (cursor-offscreen-256x256)
[371.443761] Starting subtest: cursor-offscreen-256x256
[371.449236] Starting dynamic subtest: pipe-A-eDP-1
[373.368781] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.930s)
[373.398660] Starting dynamic subtest: pipe-D-eDP-1
[375.967100] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.584s)
[375.969350] Subtest cursor-offscreen-256x256: SUCCESS (4.540s)
[376.838444] [053/134] (644s left) kms_sequence (get-idle)
[376.950217] Starting subtest: get-idle
[376.952471] Starting dynamic subtest: pipe-A-eDP-1
[378.778478] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.834s)
[378.788197] Starting dynamic subtest: pipe-B-eDP-1
[381.268097] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.492s)
[381.277220] Starting dynamic subtest: pipe-C-eDP-1
[383.711021] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.443s)
[383.721153] Starting dynamic subtest: pipe-D-eDP-1
[386.134028] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.427s)
[386.136258] Subtest get-idle: SUCCESS (9.201s)
[386.959324] [054/134] (634s left) kms_color (ctm-red-to-blue)
[387.066554] Starting subtest: ctm-red-to-blue
[387.068809] Starting dynamic subtest: pipe-A-eDP-1
[387.800267] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.734s)
[387.809741] Starting dynamic subtest: pipe-B-eDP-1
[389.244670] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.446s)
[389.253470] Starting dynamic subtest: pipe-C-eDP-1
[390.622423] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.376s)
[390.632066] Starting dynamic subtest: pipe-D-eDP-1
[391.947555] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.326s)
[391.950032] Subtest ctm-red-to-blue: SUCCESS (4.887s)
[392.763270] [055/134] (628s left) sw_sync (sync_merge_invalid)
[392.804858] Starting subtest: sync_merge_invalid
[392.824207] Subtest sync_merge_invalid: SUCCESS (0.020s)
[392.895361] [056/134] (628s left) gem_mmap_gtt (cpuset-basic-small-copy-xy)
[392.953760] Subtest cpuset-basic-small-copy-XY: SKIP (0.000s)
[393.017289] [057/134] (628s left) syncobj_timeline (invalid-multi-wait-unsubmitted)
[393.072866] Starting subtest: invalid-multi-wait-unsubmitted
[393.074841] Subtest invalid-multi-wait-unsubmitted: SUCCESS (0.000s)
[393.178888] [058/134] (628s left) kms_pm_rpm (fences)
[395.411955] Starting subtest: fences
[395.416544] Subtest fences: SKIP (0.000s)
[395.807475] [059/134] (625s left) gem_exec_params (rel-constants-invalid-rel-gen5)
[395.878649] Starting subtest: rel-constants-invalid-rel-gen5
[395.881094] Subtest rel-constants-invalid-rel-gen5: SUCCESS (0.000s)
[395.993553] [060/134] (625s left) kms_psr (fbc-psr-no-drrs)
[396.093150] Starting subtest: fbc-psr-no-drrs
[396.095411] Starting dynamic subtest: eDP-1
[396.099518] Dynamic subtest eDP-1: SKIP (0.000s)
[396.103619] Subtest fbc-psr-no-drrs: SKIP (0.001s)
[396.209971] [061/134] (625s left) kms_frontbuffer_tracking (fbc-tiling-4)
[396.316994] Starting subtest: fbc-tiling-4
[400.528495] Subtest fbc-tiling-4: SUCCESS (4.218s)
[401.699502] [062/134] (620s left) gem_eio (wait-immediate)
[401.942756] Starting subtest: wait-immediate
[402.341082] Subtest wait-immediate: SUCCESS (0.398s)
[402.509701] [063/134] (619s left) gem_sync (basic-store-all)
[402.581907] Starting subtest: basic-store-all
[406.809218] Subtest basic-store-all: SUCCESS (4.239s)
[407.005905] [064/134] (614s left) gem_exec_gttfill (all-engines)
[407.069335] Starting subtest: all-engines
[431.206511] Subtest all-engines: SUCCESS (24.147s)
[431.415207] [065/134] (590s left) kms_cdclk (plane-scaling)
[431.561262] Starting subtest: plane-scaling
[431.563559] Starting dynamic subtest: pipe-A-eDP-1
[431.860598] Dynamic subtest pipe-A-eDP-1: SKIP (0.297s)
[431.870529] Starting dynamic subtest: pipe-B-eDP-1
[431.875209] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[431.884387] Starting dynamic subtest: pipe-C-eDP-1
[431.889419] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[431.898658] Starting dynamic subtest: pipe-D-eDP-1
[431.902982] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[431.907148] Subtest plane-scaling: SKIP (0.305s)
[432.700904] [066/134] (589s left) kms_flip (nonblocking-read)
[432.789077] Starting subtest: nonblocking-read
[432.791054] Subtest nonblocking-read: SUCCESS (0.000s)
[432.935507] [067/134] (588s left) kms_dsc (dsc-with-output-formats)
[433.034782] Starting subtest: dsc-with-output-formats
[433.056227] Subtest dsc-with-output-formats: SKIP (0.000s)
[433.119435] [068/134] (588s left) gem_mmap_gtt (big-bo-tiledy)
[433.174662] Subtest big-bo-tiledY: SKIP (0.000s)
[433.246021] [069/134] (588s left) gem_exec_alignment (pi)
[433.304350] Starting subtest: pi
[483.658193] Subtest pi: SUCCESS (50.376s)
[484.700541] [070/134] (537s left) kms_big_fb (4-tiled-8bpp-rotate-270)
[484.852760] Starting subtest: 4-tiled-8bpp-rotate-270
[484.876870] Subtest 4-tiled-8bpp-rotate-270: SKIP (0.021s)
[484.988722] [071/134] (537s left) api_intel_allocator (reopen)
[485.051069] Starting subtest: reopen
[485.053783] Subtest reopen: SUCCESS (0.005s)
[485.213700] [072/134] (536s left) kms_psr (psr-primary-render)
[485.311521] Starting subtest: psr-primary-render
[485.313763] Starting dynamic subtest: eDP-1
[487.055980] Dynamic subtest eDP-1: SUCCESS (1.746s)
[487.058255] Subtest psr-primary-render: SUCCESS (1.747s)
[487.931087] [073/134] (534s left) gem_pxp (create-regular-context-1)
[488.057160] Starting subtest: create-regular-context-1
[488.059615] Subtest create-regular-context-1: SUCCESS (0.002s)
[488.201913] [074/134] (534s left) kms_big_fb (linear-8bpp-rotate-90)
[488.306847] Starting subtest: linear-8bpp-rotate-90
[488.328518] Subtest linear-8bpp-rotate-90: SKIP (0.021s)
[488.463711] [075/134] (533s left) kms_ccs (crc-primary-suspend-4-tiled-mtl-mc-ccs)
[488.563548] Starting subtest: crc-primary-suspend-4-tiled-mtl-mc-ccs
[488.565745] Starting dynamic subtest: pipe-A-eDP-1
[521.301074] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.949s)
[521.310728] Starting dynamic subtest: pipe-B-eDP-1
[554.219793] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.710s)
[554.229247] Starting dynamic subtest: pipe-C-eDP-1
[590.180181] Dynamic subtest pipe-C-eDP-1: SUCCESS (6.697s)
[590.189551] Starting dynamic subtest: pipe-D-eDP-1
[623.229231] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.642s)
[623.231874] Subtest crc-primary-suspend-4-tiled-mtl-mc-ccs: SUCCESS (17.002s)
[624.435883] [076/134] (397s left) kms_psr (fbc-pr-primary-blt)
[624.554943] Starting subtest: fbc-pr-primary-blt
[624.559405] Subtest fbc-pr-primary-blt: SKIP (0.000s)
[624.637384] [077/134] (397s left) gem_ccs (suspend-resume)
[624.719223] Starting subtest: suspend-resume
[624.724053] Subtest suspend-resume: SKIP (0.000s)
[624.850205] [078/134] (397s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-mmap-gtt)
[624.970303] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-mmap-gtt
[624.975399] Subtest fbc-2p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[625.080196] [079/134] (397s left) kms_vrr (seamless-rr-switch-vrr)
[625.185789] Starting subtest: seamless-rr-switch-vrr
[625.193157] Subtest seamless-rr-switch-vrr: SKIP (0.000s)
[625.264520] [080/134] (397s left) kms_addfb_basic (bad-pitch-65536)
[625.328105] Starting subtest: bad-pitch-65536
[625.330813] Subtest bad-pitch-65536: SUCCESS (0.001s)
[625.488341] [081/134] (397s left) gem_exec_schedule (noreorder)
[625.676839] Starting subtest: noreorder
[625.679275] Starting dynamic subtest: rcs0
[625.767374] Dynamic subtest rcs0: SUCCESS (0.092s)
[625.779560] Starting dynamic subtest: vcs0
[627.117896] Dynamic subtest vcs0: SUCCESS (1.370s)
[627.130813] Starting dynamic subtest: vcs1
[629.104256] Dynamic subtest vcs1: SUCCESS (2.010s)
[629.118955] Starting dynamic subtest: vecs0
[631.136068] Dynamic subtest vecs0: SUCCESS (2.050s)
[631.149419] Starting dynamic subtest: ccs0
[631.202683] Dynamic subtest ccs0: SUCCESS (0.066s)
[631.205640] Subtest noreorder: SUCCESS (5.601s)
[631.395793] [082/134] (391s left) gem_ctx_param (invalid-get-engines)
[631.465249] Starting subtest: invalid-get-engines
[631.468051] Subtest invalid-get-engines: SUCCESS (0.001s)
[631.594441] [083/134] (390s left) gem_exec_whisper (basic-fds)
[631.660567] Starting subtest: basic-fds
[639.031169] Subtest basic-fds: SUCCESS (7.409s)
[639.225190] [084/134] (383s left) core_setmaster (master-drop-set-user)
[639.329734] Starting subtest: master-drop-set-user
[639.343866] Subtest master-drop-set-user: SUCCESS (0.014s)
[639.381684] [085/134] (383s left) gem_mmap_wc (set-cache-level)
[639.435602] Subtest set-cache-level: SKIP (0.000s)
[639.490886] [086/134] (383s left) kms_async_flips (alternate-sync-async-flip)
[639.591219] Starting subtest: alternate-sync-async-flip
[639.971882] Starting dynamic subtest: pipe-A-eDP-1
[642.766274] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.802s)
[643.133992] Starting dynamic subtest: pipe-B-eDP-1
[645.881714] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.762s)
[646.255102] Starting dynamic subtest: pipe-C-eDP-1
[649.004957] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.763s)
[649.369239] Starting dynamic subtest: pipe-D-eDP-1
[652.127544] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.770s)
[652.129905] Subtest alternate-sync-async-flip: SUCCESS (12.563s)
[653.316309] [087/134] (369s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-mmap-wc)
[653.431277] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-mmap-wc
[657.656044] Subtest fbc-1p-primscrn-pri-shrfb-draw-mmap-wc: SUCCESS (4.226s)
[658.827335] [088/134] (363s left) api_intel_bb (reset-bb)
[658.890025] Starting subtest: reset-bb
[658.892730] Subtest reset-bb: SUCCESS (0.004s)
[659.025724] [089/134] (363s left) kms_vrr (flip-suspend)
[659.114793] Starting subtest: flip-suspend
[659.122480] Subtest flip-suspend: SKIP (0.000s)
[659.199657] [090/134] (363s left) kms_psr2_sf (fbc-pr-plane-move-sf-dmg-area)
[664.178714] Starting subtest: fbc-pr-plane-move-sf-dmg-area
[664.184407] Subtest fbc-pr-plane-move-sf-dmg-area: SKIP (0.002s)
[665.050773] [091/134] (357s left) kms_plane_multiple (tiling-yf)
[665.158142] Starting subtest: tiling-yf
[665.162898] Subtest tiling-yf: SKIP (0.000s)
[665.242741] [092/134] (357s left) gem_tiled_partial_pwrite_pread (reads)
[665.315590] Subtest reads: SKIP (0.000s)
[665.391640] [093/134] (357s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-render)
[665.500577] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-render
[669.748778] Subtest fbc-1p-offscreen-pri-indfb-draw-render: SUCCESS (4.251s)
[670.948763] [094/134] (352s left) gem_exec_schedule (timeslicing)
[671.028208] Starting subtest: timeslicing
[671.031176] Starting dynamic subtest: rcs0
[671.037451] Dynamic subtest rcs0: SUCCESS (0.022s)
[671.048206] Starting dynamic subtest: bcs0
[671.056087] Dynamic subtest bcs0: SUCCESS (0.021s)
[671.066380] Starting dynamic subtest: vcs0
[671.078327] Dynamic subtest vcs0: SUCCESS (0.021s)
[671.089588] Starting dynamic subtest: vcs1
[671.097693] Dynamic subtest vcs1: SUCCESS (0.019s)
[671.108165] Starting dynamic subtest: vecs0
[671.121437] Dynamic subtest vecs0: SUCCESS (0.022s)
[671.131451] Starting dynamic subtest: ccs0
[671.144997] Dynamic subtest ccs0: SUCCESS (0.022s)
[671.147697] Subtest timeslicing: SUCCESS (0.133s)
[673.159175] [095/134] (349s left) gem_tiled_blits (interruptible)
[673.219965] Subtest interruptible: SKIP (0.000s)
[673.289022] [096/134] (349s left) kms_big_fb (y-tiled-64bpp-rotate-270)
[673.386246] Starting subtest: y-tiled-64bpp-rotate-270
[673.392209] Subtest y-tiled-64bpp-rotate-270: SKIP (0.000s)
[673.479663] [097/134] (349s left) i915_query (hwconfig_table)
[673.540721] Starting subtest: hwconfig_table
[673.894178] Subtest hwconfig_table: SUCCESS (0.001s)
[673.934565] [098/134] (349s left) kms_cursor_legacy (basic-flip-after-cursor-legacy)
[674.057804] Starting subtest: basic-flip-after-cursor-legacy
[674.969223] Subtest basic-flip-after-cursor-legacy: SUCCESS (0.912s)
[675.863656] [099/134] (347s left) sw_sync (sync_busy_fork)
[675.904199] Starting subtest: sync_busy_fork
[676.915380] Subtest sync_busy_fork: SUCCESS (1.013s)
[677.005557] [100/134] (346s left) kms_content_protection (atomic-dpms)
[677.150392] Starting subtest: atomic-dpms
[677.155877] Subtest atomic-dpms: SKIP (0.000s)
[677.285508] [101/134] (346s left) perf (stress-open-close)
[677.436265] Starting subtest: stress-open-close
[677.439238] Starting dynamic subtest: 0-rcs0
[679.604168] Dynamic subtest 0-rcs0: SUCCESS (2.171s)
[679.614386] Starting dynamic subtest: 1-vecs0
[681.765731] Dynamic subtest 1-vecs0: SUCCESS (2.161s)
[681.767962] Subtest stress-open-close: SUCCESS (4.334s)
[681.805902] [102/134] (341s left) gem_mmap_gtt (zero-extend)
[681.872008] Subtest zero-extend: SKIP (0.000s)
[681.933499] [103/134] (341s left) sw_sync (sync_multi_timeline_wait)
[681.967247] Starting subtest: sync_multi_timeline_wait
[681.969245] Subtest sync_multi_timeline_wait: SUCCESS (0.000s)
[682.022549] [104/134] (341s left) gem_render_copy (yf-tiled-ccs-to-yf-tiled-ccs)
[682.077667] Starting subtest: yf-tiled-ccs-to-yf-tiled-ccs
[682.082067] Subtest yf-tiled-ccs-to-yf-tiled-ccs: SKIP (0.000s)
[682.277219] [105/134] (341s left) gem_tiled_fence_blits (normal)
[682.343287] Subtest normal: SKIP (0.000s)
[682.434680] [106/134] (341s left) syncobj_timeline (wait-all-for-submit-delayed-submit)
[682.489382] Starting subtest: wait-all-for-submit-delayed-submit
[682.590950] Subtest wait-all-for-submit-delayed-submit: SUCCESS (0.103s)
[682.680752] [107/134] (340s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-mmap-gtt)
[682.780207] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-mmap-gtt
[682.785258] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[682.920336] [108/134] (340s left) gen3_render_tiledx_blits
[683.041759] [109/134] (340s left) syncobj_timeline (multi-wait-signaled)
[683.095065] Starting subtest: multi-wait-signaled
[683.097319] Subtest multi-wait-signaled: SUCCESS (0.000s)
[683.198745] [110/134] (340s left) kms_cursor_crc (cursor-rapid-movement-32x10)
[683.371119] Starting subtest: cursor-rapid-movement-32x10
[683.416410] Subtest cursor-rapid-movement-32x10: SKIP (0.044s)
[683.693738] [111/134] (340s left) gem_ctx_persistence (legacy-engines-mixed-process)
[683.749268] Starting subtest: legacy-engines-mixed-process
[683.751302] Starting dynamic subtest: render
[685.109879] Dynamic subtest render: SUCCESS (1.356s)
[685.120939] Starting dynamic subtest: bsd1
[687.082777] Dynamic subtest bsd1: SUCCESS (1.974s)
[687.094272] Starting dynamic subtest: bsd2
[689.120991] Dynamic subtest bsd2: SUCCESS (2.037s)
[689.133514] Starting dynamic subtest: blt
[691.116717] Dynamic subtest blt: SUCCESS (1.994s)
[691.130277] Starting dynamic subtest: vebox
[693.098458] Dynamic subtest vebox: SUCCESS (1.980s)
[693.101450] Subtest legacy-engines-mixed-process: SUCCESS (9.351s)
[693.191154] [112/134] (330s left) gem_mmap_gtt (basic-write-cpu-read-gtt)
[693.262144] Subtest basic-write-cpu-read-gtt: SKIP (0.000s)
[693.328007] [113/134] (330s left) kms_pm_rpm (package-g7)
[695.257868] Starting subtest: package-g7
[695.262935] Subtest package-g7: SKIP (0.000s)
[695.687130] [114/134] (328s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-mmap-gtt)
[695.814280] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-mmap-gtt
[695.819927] Subtest psr-2p-scndscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[695.958081] [115/134] (327s left) kms_flip (2x-flip-vs-modeset)
[696.059684] Starting subtest: 2x-flip-vs-modeset
[696.071189] Subtest 2x-flip-vs-modeset: SKIP (0.011s)
[696.163505] [116/134] (327s left) gem_exec_flush (basic-uc-rw-default)
[696.231971] Starting subtest: basic-uc-rw-default
[701.686131] Subtest basic-uc-rw-default: SUCCESS (5.452s)
[701.883225] [117/134] (322s left) kms_frontbuffer_tracking (fbcpsr-2p-rte)
[701.989337] Starting subtest: fbcpsr-2p-rte
[701.994996] Subtest fbcpsr-2p-rte: SKIP (0.000s)
[702.108658] [118/134] (321s left) gem_userptr_blits (map-fixed-invalidate-overlap)
[702.172379] Starting subtest: map-fixed-invalidate-overlap
[702.177343] Subtest map-fixed-invalidate-overlap: SKIP (0.000s)
[702.313728] [119/134] (321s left) kms_plane_scaling (plane-scaler-with-clipping-clamping-pixel-formats)
[702.404298] Starting subtest: plane-scaler-with-clipping-clamping-pixel-formats
[702.406659] Starting dynamic subtest: pipe-A
[702.526906] Dynamic subtest pipe-A: SKIP (0.119s)
[702.544800] Starting dynamic subtest: pipe-B
[703.719004] Dynamic subtest pipe-B: SKIP (1.189s)
[703.730900] Starting dynamic subtest: pipe-C
[704.878137] Dynamic subtest pipe-C: SUCCESS (1.167s)
[704.895822] Starting dynamic subtest: pipe-D
[706.091184] Dynamic subtest pipe-D: SUCCESS (1.212s)
[706.094067] Subtest plane-scaler-with-clipping-clamping-pixel-formats: SUCCESS (3.690s)
[707.280828] [120/134] (316s left) kms_cursor_edge_walk (128x128-left-edge)
[707.383177] Starting subtest: 128x128-left-edge
[707.385716] Starting dynamic subtest: pipe-A-eDP-1
[710.846148] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.462s)
[710.859380] Starting dynamic subtest: pipe-D-eDP-1
[713.987141] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.141s)
[713.989831] Subtest 128x128-left-edge: SUCCESS (6.606s)
[714.793592] [121/134] (309s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180)
[714.905571] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180
[714.911105] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180: SKIP (0.000s)
[715.023682] [122/134] (309s left) gem_exec_balancer (parallel-balancer)
[715.278699] Starting subtest: parallel-balancer
[716.160552] Subtest parallel-balancer: SUCCESS (0.882s)
[716.289329] [123/134] (307s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-pwrite)
[716.392867] Starting subtest: psr-1p-primscrn-pri-indfb-draw-pwrite
[724.051085] Subtest psr-1p-primscrn-pri-indfb-draw-pwrite: SUCCESS (7.659s)
[724.160744] [124/134] (300s left) kms_chamelium_edid (dp-mode-timings)
[724.553083] Subtest dp-mode-timings: SKIP (0.000s)
[725.329916] [125/134] (299s left) i915_pm_rpm (gem-execbuf-stress-pc8)
[727.261295] Starting subtest: gem-execbuf-stress-pc8
[727.303251] Subtest gem-execbuf-stress-pc8: SKIP (0.041s)
[727.641222] [126/134] (296s left) kms_dirtyfb (psr-dirtyfb-ioctl)
[727.734317] Starting subtest: psr-dirtyfb-ioctl
[727.737133] Starting dynamic subtest: A-eDP-1
[731.646340] Dynamic subtest A-eDP-1: SUCCESS (3.911s)
[731.649256] Subtest psr-dirtyfb-ioctl: SUCCESS (3.913s)
[732.461085] [127/134] (291s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-pwrite)
[732.562560] Starting subtest: psr-2p-primscrn-pri-indfb-draw-pwrite
[732.567405] Subtest psr-2p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[732.656987] [128/134] (291s left) kms_plane (pixel-format-4-tiled-mtl-mc-ccs-modifier-source-clamping)
[732.752665] Starting subtest: pixel-format-4-tiled-mtl-mc-ccs-modifier-source-clamping
[732.779390] Starting dynamic subtest: pipe-A-plane-0
[733.214212] Dynamic subtest pipe-A-plane-0: SUCCESS (0.433s)
[733.224962] Starting dynamic subtest: pipe-A-plane-3
[733.467426] Dynamic subtest pipe-A-plane-3: SUCCESS (0.254s)
[733.477409] Starting dynamic subtest: pipe-A-plane-5
[733.481817] Dynamic subtest pipe-A-plane-5: SKIP (0.000s)
[734.543380] Starting dynamic subtest: pipe-B-plane-0
[734.990886] Dynamic subtest pipe-B-plane-0: SUCCESS (0.455s)
[735.001309] Starting dynamic subtest: pipe-B-plane-3
[735.258404] Dynamic subtest pipe-B-plane-3: SUCCESS (0.266s)
[735.269046] Starting dynamic subtest: pipe-B-plane-5
[735.274324] Dynamic subtest pipe-B-plane-5: SKIP (0.000s)
[735.569585] Subtest pixel-format-4-tiled-mtl-mc-ccs-modifier-source-clamping: SUCCESS (2.816s)
[736.431385] [129/134] (288s left) gem_bad_reloc (negative-reloc-bltcopy)
[736.492573] Subtest negative-reloc-bltcopy: SKIP (0.000s)
[736.574798] [130/134] (287s left) gem_exec_fence (submit)
[736.749455] Starting subtest: submit
[736.755179] Subtest submit: SKIP (0.000s)
[738.139963] [FACT gem_exec_fence (submit)] new: kernel.kmod_is_loaded.vgem: true
[738.143812] [131/134] (286s left) perf_pmu (frequency)
[738.185225] Starting subtest: frequency
[738.187865] Starting dynamic subtest: gt0
[740.329272] Dynamic subtest gt0: SUCCESS (2.136s)
[740.342393] Starting dynamic subtest: idle-gt0
[740.833420] Dynamic subtest idle-gt0: SUCCESS (0.504s)
[740.846378] Starting dynamic subtest: gt1
[745.092303] Dynamic subtest gt1: SUCCESS (4.253s)
[745.105434] Starting dynamic subtest: idle-gt1
[745.627795] Dynamic subtest idle-gt1: SUCCESS (0.536s)
[745.630660] Subtest frequency: SUCCESS (7.446s)
[745.746434] [132/134] (278s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-shrfb-msflip-blt)
[745.853798] Starting subtest: fbcpsr-1p-primscrn-shrfb-msflip-blt
[753.247049] Subtest fbcpsr-1p-primscrn-shrfb-msflip-blt: SUCCESS (7.397s)
[753.407538] [133/134] (271s left) perf_pmu (enable-race)
[753.451673] Starting subtest: enable-race
[753.454245] Starting dynamic subtest: rcs0
[766.234485] Dynamic subtest rcs0: SUCCESS (12.783s)
[766.247691] Starting dynamic subtest: bcs0
[778.975464] Dynamic subtest bcs0: SUCCESS (12.742s)
[778.986201] Starting dynamic subtest: vcs0
[794.069206] Dynamic subtest vcs0: SUCCESS (15.093s)
[794.082455] Starting dynamic subtest: vcs1
[810.069242] Dynamic subtest vcs1: SUCCESS (16.000s)
[810.082515] Starting dynamic subtest: vecs0
[826.068822] Dynamic subtest vecs0: SUCCESS (16.000s)
[826.082497] Starting dynamic subtest: ccs0
[838.816450] Dynamic subtest ccs0: SUCCESS (12.749s)
[838.819382] Subtest enable-race: SUCCESS (85.378s)
[838.942228] [134/134] (185s left) gem_caching (read-writes)
[839.022709] Subtest read-writes: SKIP (0.000s)
[839.113726] 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.