[60.145329] Initializing watchdogs
[60.145374]   /dev/watchdog0
[60.158581] [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]
[60.162839] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[60.165152] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[60.168378] [001/132] (960s left) kms_async_flips (async-flip-with-page-flip-events-tiled)
[60.291893] Starting subtest: async-flip-with-page-flip-events-tiled
[60.666880] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs
[63.441112] Dynamic subtest pipe-A-eDP-1-4-rc-ccs: SUCCESS (2.773s)
[63.451718] Starting dynamic subtest: pipe-A-eDP-1-4
[65.616417] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.174s)
[65.626031] Starting dynamic subtest: pipe-A-eDP-1-4
[67.626137] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.010s)
[67.634608] Starting dynamic subtest: pipe-A-eDP-1-x
[69.849491] Dynamic subtest pipe-A-eDP-1-x: SUCCESS (2.223s)
[70.212640] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs
[72.973150] Dynamic subtest pipe-B-eDP-1-4-rc-ccs: SUCCESS (2.766s)
[72.981104] Starting dynamic subtest: pipe-B-eDP-1-4
[75.147896] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.174s)
[75.155423] Starting dynamic subtest: pipe-B-eDP-1-4
[77.158735] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.010s)
[77.168097] Starting dynamic subtest: pipe-B-eDP-1-x
[79.359312] Dynamic subtest pipe-B-eDP-1-x: SUCCESS (2.201s)
[79.752701] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs
[82.501172] Dynamic subtest pipe-C-eDP-1-4-rc-ccs: SUCCESS (2.754s)
[82.508619] Starting dynamic subtest: pipe-C-eDP-1-4
[84.665624] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.163s)
[84.672676] Starting dynamic subtest: pipe-C-eDP-1-4
[86.675835] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.010s)
[86.682938] Starting dynamic subtest: pipe-C-eDP-1-x
[88.843691] Dynamic subtest pipe-C-eDP-1-x: SUCCESS (2.167s)
[89.208537] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs
[91.942582] Dynamic subtest pipe-D-eDP-1-4-rc-ccs: SUCCESS (2.740s)
[91.951558] Starting dynamic subtest: pipe-D-eDP-1-4
[94.117660] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.174s)
[94.126702] Starting dynamic subtest: pipe-D-eDP-1-4
[96.128144] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.010s)
[96.135757] Starting dynamic subtest: pipe-D-eDP-1-x
[98.307078] Dynamic subtest pipe-D-eDP-1-x: SUCCESS (2.179s)
[98.309351] Subtest async-flip-with-page-flip-events-tiled: SUCCESS (38.015s)
[99.531849] [002/132] (921s left) syncobj_timeline (multi-wait-for-submit-signaled)
[99.592665] Starting subtest: multi-wait-for-submit-signaled
[99.594935] Subtest multi-wait-for-submit-signaled: SUCCESS (0.001s)
[99.685917] [003/132] (921s left) kms_big_fb (y-tiled-64bpp-rotate-270)
[99.785928] Starting subtest: y-tiled-64bpp-rotate-270
[99.790532] Subtest y-tiled-64bpp-rotate-270: SKIP (0.000s)
[99.873533] [004/132] (920s left) kms_getfb (getfb-reject-nv12)
[99.972242] Starting subtest: getfb-reject-nv12
[99.974554] Subtest getfb-reject-nv12: SUCCESS (0.001s)
[100.084317] [005/132] (920s left) kms_content_protection (srm)
[100.229833] Starting subtest: srm
[100.237025] Subtest srm: SKIP (0.003s)
[100.371580] [006/132] (920s left) kms_psr (psr-primary-render)
[100.457833] Starting subtest: psr-primary-render
[100.460153] Starting dynamic subtest: eDP-1
[102.232689] Dynamic subtest eDP-1: SUCCESS (1.776s)
[102.235109] Subtest psr-primary-render: SUCCESS (1.776s)
[103.106440] [007/132] (917s left) gem_exec_flush (basic-uc-rw-default)
[103.167443] Starting subtest: basic-uc-rw-default
[108.625960] Subtest basic-uc-rw-default: SUCCESS (5.460s)
[108.814195] [008/132] (912s left) syncobj_timeline (transfer-timeline-point)
[108.873194] Starting subtest: transfer-timeline-point
[108.875421] Subtest transfer-timeline-point: SUCCESS (0.000s)
[108.964113] [009/132] (911s left) gem_mmap_wc (write-read)
[109.021673] Subtest write-read: SKIP (0.000s)
[109.074718] [010/132] (911s left) syncobj_timeline (wait-any-snapshot)
[109.129320] Starting subtest: wait-any-snapshot
[109.209192] Subtest wait-any-snapshot: SUCCESS (0.081s)
[109.282348] [011/132] (911s left) gem_ctx_exec (basic-invalid-context)
[109.335913] Starting subtest: basic-invalid-context
[109.343159] Subtest basic-invalid-context: SUCCESS (0.008s)
[109.472118] [012/132] (911s left) gem_ctx_shared (detached-shared-gtt)
[109.532729] Starting subtest: detached-shared-gtt
[111.688377] Subtest detached-shared-gtt: SUCCESS (2.154s)
[111.948755] [013/132] (909s left) prime_vgem (basic-write)
[112.074340] Starting subtest: basic-write
[112.086071] Subtest basic-write: SKIP (0.010s)
[112.189449] [FACT prime_vgem (basic-write)] new: kernel.kmod_is_loaded.vgem: true
[112.192089] [014/132] (908s left) kms_psr (fbc-pr-cursor-mmap-cpu)
[112.291795] Starting subtest: fbc-pr-cursor-mmap-cpu
[112.295920] Subtest fbc-pr-cursor-mmap-cpu: SKIP (0.000s)
[112.368037] [015/132] (908s left) syncobj_wait (multi-wait-all-for-submit-signaled)
[112.423335] Starting subtest: multi-wait-all-for-submit-signaled
[112.425646] Subtest multi-wait-all-for-submit-signaled: SUCCESS (0.000s)
[112.532638] [016/132] (908s left) kms_vblank (wait-busy)
[112.624878] Starting subtest: wait-busy
[112.627230] Starting dynamic subtest: pipe-A-eDP-1
[114.516120] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.890s)
[114.529235] Starting dynamic subtest: pipe-D-eDP-1
[117.071234] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.553s)
[117.073190] Subtest wait-busy: SUCCESS (4.446s)
[117.870357] [017/132] (903s left) kms_color_pipeline (plane-lut1d-lut1d)
[117.972220] Starting subtest: plane-lut1d-lut1d
[118.120220] Starting dynamic subtest: pipe-A-plane-0
[118.445248] Dynamic subtest pipe-A-plane-0: FAIL (0.155s)
[118.454025] Starting dynamic subtest: pipe-A-plane-1
[118.663337] Dynamic subtest pipe-A-plane-1: FAIL (0.164s)
[118.671649] Starting dynamic subtest: pipe-A-plane-2
[118.899066] Dynamic subtest pipe-A-plane-2: FAIL (0.167s)
[119.877555] Starting dynamic subtest: pipe-B-plane-0
[120.282570] Dynamic subtest pipe-B-plane-0: FAIL (0.141s)
[120.290341] Starting dynamic subtest: pipe-B-plane-1
[120.601761] Dynamic subtest pipe-B-plane-1: FAIL (0.156s)
[120.611707] Starting dynamic subtest: pipe-B-plane-2
[120.921153] Dynamic subtest pipe-B-plane-2: FAIL (0.166s)
[121.497590] Starting dynamic subtest: pipe-C-plane-0
[122.017617] Dynamic subtest pipe-C-plane-0: FAIL (0.162s)
[122.025177] Starting dynamic subtest: pipe-C-plane-1
[122.413460] Dynamic subtest pipe-C-plane-1: FAIL (0.592s)
[122.422228] Starting dynamic subtest: pipe-C-plane-2
[122.784808] Dynamic subtest pipe-C-plane-2: FAIL (0.161s)
[123.622590] Starting dynamic subtest: pipe-D-plane-0
[124.247067] Dynamic subtest pipe-D-plane-0: FAIL (0.162s)
[124.256110] Starting dynamic subtest: pipe-D-plane-1
[124.706249] Dynamic subtest pipe-D-plane-1: FAIL (0.611s)
[124.715167] Starting dynamic subtest: pipe-D-plane-2
[125.144704] Dynamic subtest pipe-D-plane-2: FAIL (0.536s)
[125.227173] Subtest plane-lut1d-lut1d: FAIL (7.254s)
[126.107467] [018/132] (895s left) kms_flip (2x-flip-vs-absolute-wf_vblank-interruptible)
[126.216656] Starting subtest: 2x-flip-vs-absolute-wf_vblank-interruptible
[126.226984] Subtest 2x-flip-vs-absolute-wf_vblank-interruptible: SKIP (0.010s)
[126.315508] [019/132] (895s left) kms_pm_backlight (fade)
[126.406098] Starting subtest: fade
[126.483465] Starting dynamic subtest: eDP-1
[129.174471] Dynamic subtest eDP-1: SUCCESS (2.693s)
[129.176696] Subtest fade: SUCCESS (2.770s)
[130.016554] [020/132] (891s left) gem_pwrite (basic-exhaustion)
[130.071590] Subtest basic-exhaustion: SKIP (0.000s)
[130.133703] [021/132] (891s left) gem_userptr_blits (map-fixed-invalidate-overlap)
[130.194821] Starting subtest: map-fixed-invalidate-overlap
[130.199450] Subtest map-fixed-invalidate-overlap: SKIP (0.000s)
[130.305744] [022/132] (891s left) gem_eio (in-flight-1us)
[130.521193] Starting subtest: in-flight-1us
[138.674087] Subtest in-flight-1us: SUCCESS (8.151s)
[138.800460] [023/132] (882s left) kms_psr2_sf (pr-cursor-plane-move-continuous-exceed-sf)
[138.905177] Starting subtest: pr-cursor-plane-move-continuous-exceed-sf
[138.909182] Subtest pr-cursor-plane-move-continuous-exceed-sf: SKIP (0.000s)
[138.969994] [024/132] (882s left) kms_big_fb (4-tiled-32bpp-rotate-270)
[139.072792] Starting subtest: 4-tiled-32bpp-rotate-270
[139.091819] Subtest 4-tiled-32bpp-rotate-270: SKIP (0.019s)
[139.190607] [025/132] (882s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180-hflip)
[139.291356] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180-hflip
[140.247387] Subtest x-tiled-max-hw-stride-64bpp-rotate-180-hflip: SUCCESS (0.956s)
[140.391300] [026/132] (881s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-mmap-wc)
[140.501609] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-mmap-wc
[140.506092] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[140.592862] [027/132] (881s left) gem_userptr_blits (process-exit)
[140.649528] Starting subtest: process-exit
[140.657466] Subtest process-exit: SUCCESS (0.008s)
[140.797272] [028/132] (880s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-render)
[140.912847] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-render
[140.916707] Subtest fbc-2p-scndscrn-pri-shrfb-draw-render: SKIP (0.000s)
[141.028447] [029/132] (880s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-32bpp-ytileccs-upscaling)
[141.114942] Starting subtest: flip-32bpp-ytile-to-32bpp-ytileccs-upscaling
[141.118390] Subtest flip-32bpp-ytile-to-32bpp-ytileccs-upscaling: SKIP (0.000s)
[141.184553] [030/132] (880s left) gen7_exec_parse (bitmasks)
[141.241894] Subtest bitmasks: SKIP (0.000s)
[141.312629] [031/132] (880s left) gem_spin_batch (legacy)
[141.364850] Starting subtest: legacy
[141.367683] Starting dynamic subtest: default
[144.608924] Dynamic subtest default: SUCCESS (3.238s)
[144.618999] Starting dynamic subtest: render
[147.841194] Dynamic subtest render: SUCCESS (3.231s)
[147.849057] Starting dynamic subtest: bsd
[151.079215] Dynamic subtest bsd: SUCCESS (3.235s)
[151.089264] Starting dynamic subtest: bsd1
[154.317228] Dynamic subtest bsd1: SUCCESS (3.236s)
[154.325153] Starting dynamic subtest: bsd2
[157.551270] Dynamic subtest bsd2: SUCCESS (3.232s)
[157.560187] Starting dynamic subtest: blt
[160.788694] Dynamic subtest blt: SUCCESS (3.235s)
[160.797418] Starting dynamic subtest: vebox
[164.025094] Dynamic subtest vebox: SUCCESS (3.234s)
[164.027553] Subtest legacy: SUCCESS (22.654s)
[165.982741] [032/132] (855s left) kms_ccs (crc-primary-rotation-180-4-tiled-mtl-rc-ccs)
[166.090834] Starting subtest: crc-primary-rotation-180-4-tiled-mtl-rc-ccs
[166.093147] Starting dynamic subtest: pipe-A-eDP-1
[166.942385] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.846s)
[166.949494] Starting dynamic subtest: pipe-B-eDP-1
[168.529722] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.583s)
[168.538647] Starting dynamic subtest: pipe-C-eDP-1
[170.052366] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.523s)
[170.061419] Starting dynamic subtest: pipe-D-eDP-1
[171.578407] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.523s)
[171.580678] Subtest crc-primary-rotation-180-4-tiled-mtl-rc-ccs: SUCCESS (5.479s)
[172.737738] [033/132] (849s left) gem_pxp (protected-raw-src-copy-not-readible)
[172.870055] Starting subtest: protected-raw-src-copy-not-readible
[172.931332] Subtest protected-raw-src-copy-not-readible: SUCCESS (0.063s)
[173.049464] [034/132] (848s left) prime_busy (before-wait)
[173.110789] Starting subtest: before-wait
[173.113066] Starting dynamic subtest: rcs0
[173.142581] Dynamic subtest rcs0: SUCCESS (0.031s)
[173.152083] Starting dynamic subtest: bcs0
[173.194406] Dynamic subtest bcs0: SUCCESS (0.051s)
[173.201670] Starting dynamic subtest: vcs0
[173.233312] Dynamic subtest vcs0: SUCCESS (0.038s)
[173.240433] Starting dynamic subtest: vcs1
[173.271955] Dynamic subtest vcs1: SUCCESS (0.038s)
[173.279063] Starting dynamic subtest: vecs0
[173.310324] Dynamic subtest vecs0: SUCCESS (0.038s)
[173.319382] Starting dynamic subtest: ccs0
[173.351385] Dynamic subtest ccs0: SUCCESS (0.041s)
[173.460112] Subtest before-wait: SUCCESS (0.350s)
[173.535153] [035/132] (848s left) core_auth (basic-auth)
[173.595138] Starting subtest: basic-auth
[173.597505] Subtest basic-auth: SUCCESS (0.001s)
[173.696724] [036/132] (848s left) kms_psr (pr-primary-mmap-gtt)
[173.791817] Starting subtest: pr-primary-mmap-gtt
[173.795798] Subtest pr-primary-mmap-gtt: SKIP (0.000s)
[173.881972] [037/132] (848s left) kms_cursor_legacy (cursora-vs-flipb-varying-size)
[174.000768] Starting subtest: cursorA-vs-flipB-varying-size
[174.005170] Subtest cursorA-vs-flipB-varying-size: SKIP (0.001s)
[174.143398] [038/132] (847s left) kms_cursor_crc (cursor-tearing-framebuffer-change)
[174.259722] Starting subtest: cursor-tearing-framebuffer-change
[174.262086] Starting dynamic subtest: pipe-A-eDP-1
[174.837175] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.574s)
[174.845805] Starting dynamic subtest: pipe-D-eDP-1
[176.061358] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.222s)
[176.063638] Subtest cursor-tearing-framebuffer-change: SUCCESS (1.798s)
[176.892327] [039/132] (845s left) gem_exec_reloc (basic-cpu)
[176.957073] Subtest basic-cpu: SKIP (0.000s)
[177.035742] [040/132] (845s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc)
[177.133588] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc
[177.137732] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[177.235863] [041/132] (844s left) gem_ctx_persistence (legacy-engines-queued)
[177.289513] Starting subtest: legacy-engines-queued
[177.291772] Starting dynamic subtest: render
[177.345709] Dynamic subtest render: SUCCESS (0.055s)
[177.356393] Starting dynamic subtest: bsd1
[178.869067] Dynamic subtest bsd1: SUCCESS (1.520s)
[178.879226] Starting dynamic subtest: bsd2
[180.853198] Dynamic subtest bsd2: SUCCESS (1.981s)
[180.864345] Starting dynamic subtest: blt
[180.911817] Dynamic subtest blt: SUCCESS (0.057s)
[180.921826] Starting dynamic subtest: vebox
[182.901087] Dynamic subtest vebox: SUCCESS (1.986s)
[182.904021] Subtest legacy-engines-queued: SUCCESS (5.611s)
[182.982926] [042/132] (839s left) kms_cursor_crc (cursor-size-change)
[183.085743] Starting subtest: cursor-size-change
[183.087938] Starting dynamic subtest: pipe-A-eDP-1
[183.860454] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.776s)
[183.869361] Starting dynamic subtest: pipe-D-eDP-1
[185.348232] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.486s)
[185.350460] Subtest cursor-size-change: SUCCESS (2.264s)
[186.165705] [043/132] (836s left) syncobj_timeline (32bits-limit)
[186.221850] Starting subtest: 32bits-limit
[186.224078] Subtest 32bits-limit: SUCCESS (0.001s)
[186.335343] [044/132] (836s left) gem_mmap_offset (partial-remap)
[186.392432] Starting subtest: partial-remap
[186.394876] Starting dynamic subtest: smem0
[186.404063] Dynamic subtest smem0: SUCCESS (0.004s)
[186.406081] Subtest partial-remap: SUCCESS (0.004s)
[186.475397] [045/132] (835s left) syncobj_timeline (etime-single-wait-for-submit-submitted)
[186.536230] Starting subtest: etime-single-wait-for-submit-submitted
[186.641789] Subtest etime-single-wait-for-submit-submitted: SUCCESS (0.105s)
[186.718425] [046/132] (835s left) fbdev (read)
[186.767834] Starting subtest: read
[187.291797] Subtest read: SUCCESS (0.522s)
[187.364484] [047/132] (835s left) kms_cursor_crc (cursor-dpms)
[187.483870] Starting subtest: cursor-dpms
[187.486316] Starting dynamic subtest: pipe-A-eDP-1
[190.579617] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.094s)
[190.587684] Starting dynamic subtest: pipe-D-eDP-1
[194.149297] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.567s)
[194.151496] Subtest cursor-dpms: SUCCESS (6.663s)
[194.999793] [048/132] (827s left) kms_cursor_crc (cursor-random-64x21)
[195.196909] Starting subtest: cursor-random-64x21
[195.240339] Subtest cursor-random-64x21: SKIP (0.040s)
[195.491986] [049/132] (827s left) kms_chamelium_color (ctm-green-to-red)
[195.581187] Subtest ctm-green-to-red: SKIP (0.000s)
[195.625568] [050/132] (826s left) kms_dsc (dsc-with-bpc-formats)
[195.721862] Starting subtest: dsc-with-bpc-formats
[195.835566] Subtest dsc-with-bpc-formats: SKIP (0.003s)
[195.872824] [051/132] (826s left) gem_exec_gttfill (multigpu-basic)
[196.056522] Starting subtest: multigpu-basic
[208.127496] Subtest multigpu-basic: SUCCESS (12.074s)
[208.173469] [052/132] (814s left) gem_mmap_gtt (basic-wc)
[208.261673] Subtest basic-wc: SKIP (0.000s)
[208.331856] [053/132] (814s left) i915_query (query-regions-garbage-items)
[208.390846] Starting subtest: query-regions-garbage-items
[208.393116] Subtest query-regions-garbage-items: SUCCESS (0.000s)
[208.500643] [054/132] (814s left) i915_drm_fdinfo (busy-check-all)
[208.541796] Starting subtest: busy-check-all
[208.544127] Starting dynamic subtest: rcs0
[208.548675] Dynamic subtest rcs0: SKIP (0.004s)
[208.559570] Starting dynamic subtest: bcs0
[208.563569] Dynamic subtest bcs0: SKIP (0.000s)
[208.571445] Starting dynamic subtest: vcs0
[208.575639] Dynamic subtest vcs0: SKIP (0.000s)
[208.582737] Starting dynamic subtest: vcs1
[208.586593] Dynamic subtest vcs1: SKIP (0.000s)
[208.593779] Starting dynamic subtest: vecs0
[208.597659] Dynamic subtest vecs0: SKIP (0.000s)
[208.605226] Starting dynamic subtest: ccs0
[208.609390] Dynamic subtest ccs0: SKIP (0.000s)
[208.613501] Subtest busy-check-all: SKIP (0.008s)
[208.653520] [055/132] (814s left) gem_exec_reloc (basic-write-gtt)
[208.711704] Subtest basic-write-gtt: SKIP (0.000s)
[208.780790] [056/132] (814s left) drm_read (short-buffer-block)
[208.973150] Starting subtest: short-buffer-block
[208.975466] Subtest short-buffer-block: SUCCESS (0.000s)
[209.100390] [057/132] (813s left) kms_psr (fbc-pr-suspend)
[209.190822] Starting subtest: fbc-pr-suspend
[209.194502] Subtest fbc-pr-suspend: SKIP (0.000s)
[209.276884] [058/132] (813s left) kms_prime (d3hot)
[209.359764] Subtest D3hot: SKIP (0.000s)
[209.465559] [059/132] (813s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-pwrite)
[209.556881] Starting subtest: psr-2p-primscrn-spr-indfb-draw-pwrite
[209.560683] Subtest psr-2p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[209.648081] [060/132] (813s left) gem_watchdog (default-physical)
[209.716362] Starting subtest: default-physical
[211.476097] Subtest default-physical: SUCCESS (1.768s)
[211.581559] [061/132] (811s left) gem_exec_reloc (basic-wc-cpu-noreloc)
[211.645418] Subtest basic-wc-cpu-noreloc: SKIP (0.000s)
[211.712226] [062/132] (811s left) gem_exec_schedule (reorder-wide)
[211.892639] Subtest reorder-wide: SKIP (0.000s)
[212.078467] [063/132] (811s left) kms_psr (fbc-psr-cursor-blt)
[212.170691] Starting subtest: fbc-psr-cursor-blt
[212.172831] Starting dynamic subtest: eDP-1
[212.176717] Dynamic subtest eDP-1: SKIP (0.000s)
[212.180614] Subtest fbc-psr-cursor-blt: SKIP (0.001s)
[212.241566] [064/132] (810s left) gem_render_copy (y-tiled-to-vebox-y-tiled)
[212.310593] Starting subtest: y-tiled-to-vebox-y-tiled
[212.315069] Subtest y-tiled-to-vebox-y-tiled: SKIP (0.000s)
[212.496454] [065/132] (810s left) kms_chamelium_frames (dp-crc-multiple)
[212.889357] Subtest dp-crc-multiple: SKIP (0.000s)
[213.699402] [066/132] (809s left) gem_exec_schedule (preempt-other-chain)
[213.759486] Starting subtest: preempt-other-chain
[213.761345] Starting dynamic subtest: rcs0
[213.833925] Dynamic subtest rcs0: SUCCESS (0.080s)
[213.847199] Starting dynamic subtest: bcs0
[213.915414] Dynamic subtest bcs0: SUCCESS (0.083s)
[213.923654] Starting dynamic subtest: vcs0
[213.998568] Dynamic subtest vcs0: SUCCESS (0.081s)
[214.008152] Starting dynamic subtest: vcs1
[214.077704] Dynamic subtest vcs1: SUCCESS (0.078s)
[214.087114] Starting dynamic subtest: vecs0
[214.159502] Dynamic subtest vecs0: SUCCESS (0.081s)
[214.169147] Starting dynamic subtest: ccs0
[214.239278] Dynamic subtest ccs0: SUCCESS (0.079s)
[214.242054] Subtest preempt-other-chain: SUCCESS (0.487s)
[215.008368] [067/132] (808s left) gem_lmem_swapping (random)
[215.050849] Subtest random: SKIP (0.000s)
[215.099252] [068/132] (808s left) kms_legacy_colorkey (invalid-plane)
[215.188123] Starting subtest: invalid-plane
[215.190424] Starting dynamic subtest: zero-id
[215.192624] Dynamic subtest zero-id: SUCCESS (0.000s)
[215.201406] Starting dynamic subtest: outrange-id
[215.203296] Dynamic subtest outrange-id: SUCCESS (0.000s)
[215.205208] Subtest invalid-plane: SUCCESS (0.001s)
[215.258694] [069/132] (808s left) gem_exec_suspend (basic-s4-devices)
[215.316358] Starting subtest: basic-S4-devices
[215.318941] Starting dynamic subtest: smem
[226.903075] Dynamic subtest smem: SUCCESS (11.584s)
[226.906950] Subtest basic-S4-devices: SUCCESS (11.586s)
[233.120510] [070/132] (796s left) gem_exec_params (no-blt)
[233.213493] Starting subtest: no-blt
[233.218886] Subtest no-blt: SUCCESS (0.004s)
[233.332912] [071/132] (796s left) syncobj_wait (single-wait-all-for-submit-unsubmitted)
[233.400801] Starting subtest: single-wait-all-for-submit-unsubmitted
[233.506043] Subtest single-wait-all-for-submit-unsubmitted: SUCCESS (0.103s)
[233.583787] [072/132] (795s left) kms_ccs (missing-ccs-buffer-4-tiled-mtl-rc-ccs-cc)
[233.681944] Starting subtest: missing-ccs-buffer-4-tiled-mtl-rc-ccs-cc
[233.684312] Starting dynamic subtest: pipe-A-eDP-1
[233.704712] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[233.714942] Starting dynamic subtest: pipe-B-eDP-1
[233.734781] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[233.743839] Starting dynamic subtest: pipe-C-eDP-1
[233.763166] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[233.772064] Starting dynamic subtest: pipe-D-eDP-1
[233.791181] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[233.793370] Subtest missing-ccs-buffer-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.005s)
[235.953452] [073/132] (793s left) kms_busy (basic-hang)
[236.059215] Starting subtest: basic-hang
[236.061111] Starting dynamic subtest: flip-pipe-A
[236.677122] Dynamic subtest flip-pipe-A: SUCCESS (0.615s)
[236.687607] Starting dynamic subtest: modeset-pipe-A
[240.148740] Dynamic subtest modeset-pipe-A: SUCCESS (3.471s)
[240.158546] Starting dynamic subtest: flip-pipe-D
[241.350058] Dynamic subtest flip-pipe-D: SUCCESS (1.200s)
[241.360382] Starting dynamic subtest: modeset-pipe-D
[244.774215] Dynamic subtest modeset-pipe-D: SUCCESS (3.423s)
[244.776484] Subtest basic-hang: SUCCESS (8.715s)
[245.578024] [074/132] (783s left) gem_softpin (noreloc-interruptible)
[245.645048] Starting subtest: noreloc-interruptible
[251.043256] Subtest noreloc-interruptible: SUCCESS (5.397s)
[251.163916] [075/132] (778s left) kms_rotation_crc (primary-yf-tiled-reflect-x-180)
[251.261230] Starting subtest: primary-yf-tiled-reflect-x-180
[251.321400] Subtest primary-yf-tiled-reflect-x-180: SKIP (0.059s)
[251.424183] [076/132] (778s left) gem_exec_schedule (u-submit-late-slice)
[251.492485] Starting subtest: u-submit-late-slice
[251.494643] Starting dynamic subtest: rcs0
[251.524482] Dynamic subtest rcs0: SUCCESS (0.037s)
[251.536170] Starting dynamic subtest: bcs0
[251.550167] Dynamic subtest bcs0: SUCCESS (0.025s)
[251.560397] Starting dynamic subtest: vcs0
[251.579343] Dynamic subtest vcs0: SUCCESS (0.028s)
[251.588156] Starting dynamic subtest: vcs1
[251.613652] Dynamic subtest vcs1: SUCCESS (0.034s)
[251.622869] Starting dynamic subtest: vecs0
[251.639743] Dynamic subtest vecs0: SUCCESS (0.025s)
[251.648742] Starting dynamic subtest: ccs0
[251.672255] Dynamic subtest ccs0: SUCCESS (0.032s)
[251.674595] Subtest u-submit-late-slice: SUCCESS (0.186s)
[252.969396] [077/132] (776s left) kms_plane_lowres (tiling-yf)
[253.069272] Starting subtest: tiling-yf
[253.073355] Subtest tiling-yf: SKIP (0.000s)
[253.141954] [078/132] (776s left) gem_lmem_swapping (parallel-random-engines)
[253.187434] Subtest parallel-random-engines: SKIP (0.000s)
[253.227321] [079/132] (776s left) kms_setmode (basic)
[253.290961] Starting subtest: basic
[253.616316] Starting dynamic subtest: pipe-A-eDP-1
[255.696910] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.075s)
[256.039664] Starting dynamic subtest: pipe-B-eDP-1
[258.124864] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.089s)
[258.438795] Subtest basic: SUCCESS (5.147s)
[259.280496] [080/132] (770s left) kms_atomic (plane-cursor-legacy)
[259.378326] Starting subtest: plane-cursor-legacy
[259.380626] Starting dynamic subtest: pipe-A-eDP-1
[259.767729] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.389s)
[259.769818] Subtest plane-cursor-legacy: SUCCESS (0.390s)
[260.609725] [081/132] (769s left) gem_sync (basic-store-each)
[260.698869] Starting subtest: basic-store-each
[262.959916] Subtest basic-store-each: SUCCESS (2.271s)
[263.142256] [082/132] (766s left) kms_ccs (bad-rotation-90-4-tiled-dg2-rc-ccs)
[263.243079] Starting subtest: bad-rotation-90-4-tiled-dg2-rc-ccs
[263.245423] Starting dynamic subtest: pipe-A-eDP-1
[263.268346] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[263.279765] Starting dynamic subtest: pipe-B-eDP-1
[263.301296] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[263.309661] Starting dynamic subtest: pipe-C-eDP-1
[263.330369] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[263.338944] Starting dynamic subtest: pipe-D-eDP-1
[263.360534] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[263.364867] Subtest bad-rotation-90-4-tiled-dg2-rc-ccs: SKIP (0.004s)
[265.402148] [083/132] (764s left) kms_atomic_transition (plane-use-after-nonblocking-unbind-fencing)
[265.512273] Starting subtest: plane-use-after-nonblocking-unbind-fencing
[265.514593] Starting dynamic subtest: pipe-A-eDP-1
[265.574150] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.063s)
[265.880937] Starting dynamic subtest: pipe-B-eDP-1
[266.694308] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.822s)
[267.003923] Subtest plane-use-after-nonblocking-unbind-fencing: SUCCESS (1.491s)
[267.863339] [084/132] (762s left) api_intel_bb (object-reloc-purge-cache)
[267.919295] Starting subtest: object-reloc-purge-cache
[267.924711] Subtest object-reloc-purge-cache: SKIP (0.002s)
[268.036154] [085/132] (761s left) i915_pm_rc6_residency (rc6-fence)
[268.099742] Starting subtest: rc6-fence
[268.131254] Starting dynamic subtest: gt0
[280.449154] Dynamic subtest gt0: SUCCESS (12.318s)
[280.460612] Starting dynamic subtest: gt1
[293.908222] Dynamic subtest gt1: SUCCESS (13.456s)
[293.910910] Subtest rc6-fence: SUCCESS (25.810s)
[293.988735] [086/132] (736s left) kms_flip_scaled_crc (flip-32bpp-linear-to-64bpp-linear-downscaling)
[294.104784] Starting subtest: flip-32bpp-linear-to-64bpp-linear-downscaling
[294.107017] Starting dynamic subtest: pipe-A-default-mode
[295.225103] Dynamic subtest pipe-A-default-mode: SKIP (1.118s)
[295.229552] Subtest flip-32bpp-linear-to-64bpp-linear-downscaling: SKIP (1.120s)
[295.378570] [087/132] (734s left) kms_big_fb (yf-tiled-64bpp-rotate-270)
[295.503323] Starting subtest: yf-tiled-64bpp-rotate-270
[295.507398] Subtest yf-tiled-64bpp-rotate-270: SKIP (0.000s)
[295.598939] [088/132] (734s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-mmap-cpu)
[295.700771] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-mmap-cpu
[295.705066] Subtest fbc-2p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[295.828546] [089/132] (734s left) kms_vrr (max-min)
[295.919110] Starting subtest: max-min
[295.925188] Subtest max-min: SKIP (0.000s)
[295.991602] [090/132] (734s left) syncobj_wait (invalid-reset-zero-handles)
[296.037705] Starting subtest: invalid-reset-zero-handles
[296.039788] Subtest invalid-reset-zero-handles: SUCCESS (0.000s)
[296.125563] [091/132] (734s left) syncobj_wait (wait-all-complex)
[296.182532] Starting subtest: wait-all-complex
[296.401181] Subtest wait-all-complex: SUCCESS (0.216s)
[296.484951] [092/132] (733s left) kms_debugfs (display-off-read-all)
[296.590337] Starting subtest: display-off-read-all
[296.877441] Subtest display-off-read-all: SUCCESS (0.289s)
[297.720871] [093/132] (732s left) kms_frontbuffer_tracking (fbc-indfb-scaledprimary)
[297.817669] Starting subtest: fbc-indfb-scaledprimary
[300.784467] Subtest fbc-indfb-scaledprimary: SUCCESS (2.970s)
[301.911777] [094/132] (728s left) gem_mmap_wc (read-write)
[301.970556] Subtest read-write: SKIP (0.000s)
[302.031227] [095/132] (728s left) device_reset (cold-reset-bound)
[302.078890] Starting subtest: cold-reset-bound
[302.083631] Subtest cold-reset-bound: SKIP (0.000s)
[302.156757] [096/132] (728s left) gem_exec_fence (syncobj-import)
[302.615178] Starting subtest: syncobj-import
[302.617535] Subtest syncobj-import: SUCCESS (0.005s)
[303.979267] [097/132] (726s left) syncobj_timeline (multi-wait-all-for-submit-available-submitted)
[304.031333] Starting subtest: multi-wait-all-for-submit-available-submitted
[304.033329] Subtest multi-wait-all-for-submit-available-submitted: SUCCESS (0.000s)
[304.128415] [098/132] (726s left) gem_request_retire (retire-vma-not-inactive)
[304.190023] Starting subtest: retire-vma-not-inactive
[304.248431] Subtest retire-vma-not-inactive: SUCCESS (0.058s)
[304.380497] [099/132] (726s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-mmap-cpu)
[304.479602] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-mmap-cpu
[311.203475] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-mmap-cpu: SUCCESS (6.725s)
[311.335176] [100/132] (719s left) kms_pipe_crc_basic (read-crc-frame-sequence)
[311.436539] Starting subtest: read-crc-frame-sequence
[311.438820] Starting dynamic subtest: pipe-A-eDP-1
[312.139123] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.704s)
[312.149999] Starting dynamic subtest: pipe-B-eDP-1
[313.476915] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.335s)
[313.488168] Starting dynamic subtest: pipe-C-eDP-1
[314.768191] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.291s)
[314.778666] Starting dynamic subtest: pipe-D-eDP-1
[316.102322] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.330s)
[316.104665] Subtest read-crc-frame-sequence: SUCCESS (4.666s)
[316.936157] [101/132] (713s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-pwrite)
[317.034931] Starting subtest: psr-1p-primscrn-pri-indfb-draw-pwrite
[324.676930] Subtest psr-1p-primscrn-pri-indfb-draw-pwrite: SUCCESS (7.646s)
[324.805752] [102/132] (705s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-mmap-wc)
[324.912599] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-mmap-wc
[324.916970] Subtest psr-2p-scndscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[325.024964] [103/132] (705s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-mmap-gtt)
[325.130625] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-mmap-gtt
[325.134804] Subtest fbc-1p-offscreen-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[325.230057] [104/132] (705s left) gem_ctx_persistence (engines-cleanup)
[325.284112] Starting subtest: engines-cleanup
[325.286277] Starting dynamic subtest: rcs0
[325.375563] Dynamic subtest rcs0: SUCCESS (0.091s)
[325.388635] Starting dynamic subtest: bcs0
[325.413676] Dynamic subtest bcs0: SUCCESS (0.036s)
[325.430915] Starting dynamic subtest: vcs0
[325.455761] Dynamic subtest vcs0: SUCCESS (0.041s)
[325.467690] Starting dynamic subtest: vcs1
[325.495474] Dynamic subtest vcs1: SUCCESS (0.038s)
[325.505600] Starting dynamic subtest: vecs0
[325.539549] Dynamic subtest vecs0: SUCCESS (0.042s)
[325.550526] Starting dynamic subtest: ccs0
[325.557225] Dynamic subtest ccs0: SUCCESS (0.016s)
[325.559398] Subtest engines-cleanup: SUCCESS (0.274s)
[325.691778] [105/132] (705s left) kms_psr (psr2-sprite-blt)
[325.796482] Starting subtest: psr2-sprite-blt
[325.798403] Starting dynamic subtest: eDP-1
[327.518156] Dynamic subtest eDP-1: SUCCESS (1.720s)
[327.520116] Subtest psr2-sprite-blt: SUCCESS (1.721s)
[328.377899] [106/132] (702s left) kms_frontbuffer_tracking (fbcpsr-1p-pri-indfb-multidraw)
[328.493645] Starting subtest: fbcpsr-1p-pri-indfb-multidraw
[351.039599] Subtest fbcpsr-1p-pri-indfb-multidraw: SUCCESS (22.548s)
[351.163471] [107/132] (679s left) kms_plane (pixel-format-4-tiled-lnl-ccs-modifier-source-clamping)
[351.268498] Starting subtest: pixel-format-4-tiled-lnl-ccs-modifier-source-clamping
[351.272036] Subtest pixel-format-4-tiled-lnl-ccs-modifier-source-clamping: SKIP (0.000s)
[351.339878] [108/132] (679s left) perf (short-reads)
[351.459073] Starting subtest: short-reads
[351.472551] Subtest short-reads: SUCCESS (0.014s)
[351.518834] [109/132] (679s left) gem_mmap_gtt (basic-copy)
[351.574619] Subtest basic-copy: SKIP (0.000s)
[351.635630] [110/132] (679s left) kms_ccs (ccs-on-another-bo-4-tiled-mtl-mc-ccs)
[351.719663] Starting subtest: ccs-on-another-bo-4-tiled-mtl-mc-ccs
[351.721429] Starting dynamic subtest: pipe-A-eDP-1
[351.741100] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.023s)
[351.751389] Starting dynamic subtest: pipe-B-eDP-1
[351.768383] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.025s)
[351.780170] Starting dynamic subtest: pipe-C-eDP-1
[351.797940] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.021s)
[351.807564] Starting dynamic subtest: pipe-D-eDP-1
[351.824729] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.022s)
[351.826717] Subtest ccs-on-another-bo-4-tiled-mtl-mc-ccs: SUCCESS (0.096s)
[353.955441] [111/132] (677s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-fullscreen)
[354.048693] Starting subtest: psr-1p-primscrn-spr-indfb-fullscreen
[360.764983] Subtest psr-1p-primscrn-spr-indfb-fullscreen: SUCCESS (6.719s)
[360.878134] [112/132] (670s left) gem_userptr_blits (usage-restrictions)
[360.952012] Starting subtest: usage-restrictions
[360.954134] Subtest usage-restrictions: SUCCESS (0.000s)
[361.064176] [113/132] (670s left) kms_cursor_legacy (2x-flip-vs-cursor-legacy)
[361.190328] Starting subtest: 2x-flip-vs-cursor-legacy
[361.194750] Subtest 2x-flip-vs-cursor-legacy: SKIP (0.002s)
[361.342765] [114/132] (669s left) kms_plane_scaling (plane-downscale-factor-0-5-with-modifiers)
[361.441990] Starting subtest: plane-downscale-factor-0-5-with-modifiers
[361.444226] Starting dynamic subtest: pipe-A
[361.461804] Dynamic subtest pipe-A: SKIP (0.017s)
[361.471806] Starting dynamic subtest: pipe-B
[361.491574] Dynamic subtest pipe-B: SKIP (0.030s)
[361.501283] Starting dynamic subtest: pipe-C
[361.523259] Dynamic subtest pipe-C: SKIP (0.030s)
[361.532900] Starting dynamic subtest: pipe-D
[361.554540] Dynamic subtest pipe-D: SKIP (0.030s)
[361.558712] Subtest plane-downscale-factor-0-5-with-modifiers: SKIP (0.109s)
[361.643143] [115/132] (669s left) kms_sequence (get-idle)
[361.734375] Starting subtest: get-idle
[361.735992] Starting dynamic subtest: pipe-A-eDP-1
[363.555612] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.819s)
[363.566193] Starting dynamic subtest: pipe-B-eDP-1
[366.066563] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.507s)
[366.077448] Starting dynamic subtest: pipe-C-eDP-1
[368.491694] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.426s)
[368.503092] Starting dynamic subtest: pipe-D-eDP-1
[370.931895] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.437s)
[370.934162] Subtest get-idle: SUCCESS (9.197s)
[371.734374] [116/132] (659s left) api_intel_allocator (two-level-inception-interruptible)
[371.790022] Starting subtest: two-level-inception-interruptible
[377.195045] Subtest two-level-inception-interruptible: SUCCESS (5.406s)
[377.330296] [117/132] (654s left) kms_plane_scaling (planes-downscale-factor-0-5-unity-scaling)
[377.435916] Starting subtest: planes-downscale-factor-0-5-unity-scaling
[377.438209] Starting dynamic subtest: pipe-A
[377.463110] Dynamic subtest pipe-A: SKIP (0.022s)
[377.472817] Starting dynamic subtest: pipe-B
[377.498084] Dynamic subtest pipe-B: SKIP (0.036s)
[377.507471] Starting dynamic subtest: pipe-C
[377.532790] Dynamic subtest pipe-C: SKIP (0.033s)
[377.542311] Starting dynamic subtest: pipe-D
[377.566501] Dynamic subtest pipe-D: SKIP (0.032s)
[377.570576] Subtest planes-downscale-factor-0-5-unity-scaling: SKIP (0.127s)
[377.665505] [118/132] (653s left) kms_big_fb (x-tiled-8bpp-rotate-90)
[377.762372] Starting subtest: x-tiled-8bpp-rotate-90
[377.787455] Subtest x-tiled-8bpp-rotate-90: SKIP (0.022s)
[377.913870] [119/132] (653s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-indfb-msflip-blt)
[378.006431] Starting subtest: fbcpsr-2p-scndscrn-indfb-msflip-blt
[378.010788] Subtest fbcpsr-2p-scndscrn-indfb-msflip-blt: SKIP (0.000s)
[378.109157] [120/132] (653s left) kms_atomic_transition (plane-all-transition-nonblocking-fencing)
[378.200190] Starting subtest: plane-all-transition-nonblocking-fencing
[378.202395] Starting dynamic subtest: pipe-A-eDP-1
[380.694565] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.496s)
[381.016059] Starting dynamic subtest: pipe-B-eDP-1
[384.268226] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.263s)
[384.569173] Subtest plane-all-transition-nonblocking-fencing: SUCCESS (6.369s)
[385.400204] [121/132] (646s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip)
[385.514298] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip
[386.282622] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SUCCESS (0.770s)
[386.444526] [122/132] (645s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-pwrite)
[386.534604] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-pwrite
[386.538713] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[386.645866] [123/132] (644s left) gem_exec_balancer (hog)
[386.698669] Starting subtest: hog
[386.702965] Subtest hog: SKIP (0.000s)
[387.010983] [124/132] (644s left) perf_pmu (all-busy-check-all)
[387.056515] Starting subtest: all-busy-check-all
[388.886765] Subtest all-busy-check-all: SUCCESS (1.829s)
[389.011057] [125/132] (642s left) kms_prop_blob (invalid-set-prop)
[389.063028] Starting subtest: invalid-set-prop
[389.064948] Subtest invalid-set-prop: SUCCESS (0.000s)
[389.151588] [126/132] (642s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-pwrite)
[389.250467] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-pwrite
[389.254839] Subtest psr-2p-scndscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[389.371248] [127/132] (642s left) gem_exec_balancer (parallel-keep-in-fence)
[389.635476] Starting subtest: parallel-keep-in-fence
[390.702477] Subtest parallel-keep-in-fence: SUCCESS (1.067s)
[390.809293] [128/132] (641s left) kms_invalid_mode (bad-vsync-end)
[390.910666] Starting subtest: bad-vsync-end
[390.913020] Starting dynamic subtest: pipe-A-eDP-1
[391.194299] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.282s)
[391.203923] Starting dynamic subtest: pipe-B-eDP-1
[391.205943] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[391.215555] Starting dynamic subtest: pipe-C-eDP-1
[391.217847] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[391.227567] Starting dynamic subtest: pipe-D-eDP-1
[391.229938] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[391.232294] Subtest bad-vsync-end: SUCCESS (0.288s)
[392.019073] [129/132] (639s left) perf_pmu (busy-idle)
[392.056058] Starting subtest: busy-idle
[392.058583] Starting dynamic subtest: rcs0
[392.750069] Dynamic subtest rcs0: SUCCESS (0.696s)
[392.764105] Starting dynamic subtest: bcs0
[393.418986] Dynamic subtest bcs0: SUCCESS (0.666s)
[393.431382] Starting dynamic subtest: vcs0
[394.902049] Dynamic subtest vcs0: SUCCESS (1.479s)
[394.914899] Starting dynamic subtest: vcs1
[396.886029] Dynamic subtest vcs1: SUCCESS (1.981s)
[396.898904] Starting dynamic subtest: vecs0
[398.933481] Dynamic subtest vecs0: SUCCESS (2.044s)
[398.946544] Starting dynamic subtest: ccs0
[399.598538] Dynamic subtest ccs0: SUCCESS (0.663s)
[399.601191] Subtest busy-idle: SUCCESS (7.546s)
[399.698991] [130/132] (632s left) i915_pm_freq_api (freq-reset-multiple)
[399.763630] Starting subtest: freq-reset-multiple
[399.765852] Starting dynamic subtest: gt0
[408.522675] Dynamic subtest gt0: SUCCESS (8.756s)
[408.532541] Starting dynamic subtest: gt1
[416.602806] Dynamic subtest gt1: SUCCESS (8.080s)
[416.605869] Subtest freq-reset-multiple: SUCCESS (16.838s)
[416.693406] [131/132] (615s left) kms_chamelium_hpd (dp-hpd-after-suspend)
[417.083091] Subtest dp-hpd-after-suspend: SKIP (0.000s)
[417.926858] [132/132] (614s left) vgem_basic (dmabuf-export)
[417.973959] Starting subtest: dmabuf-export
[417.990901] Subtest dmabuf-export: SUCCESS (0.019s)
[418.093750] Closing watchdogs
results: parsing output: 0/ for test: kms_async_flips
results: parsing output: 1/ for test: syncobj_timeline
results: parsing output: 2/ for test: kms_big_fb
results: parsing output: 3/ for test: kms_getfb
results: parsing output: 4/ for test: kms_content_protection
results: parsing output: 5/ for test: kms_psr
results: parsing output: 6/ for test: gem_exec_flush
results: parsing output: 7/ for test: syncobj_timeline
results: parsing output: 8/ for test: gem_mmap_wc
results: parsing output: 9/ for test: syncobj_timeline
results: parsing output: 10/ for test: gem_ctx_exec
results: parsing output: 11/ for test: gem_ctx_shared
results: parsing output: 12/ for test: prime_vgem
results: parsing output: 13/ for test: kms_psr
results: parsing output: 14/ for test: syncobj_wait
results: parsing output: 15/ for test: kms_vblank
results: parsing output: 16/ for test: kms_color_pipeline
results: parsing output: 17/ for test: kms_flip
results: parsing output: 18/ for test: kms_pm_backlight
results: parsing output: 19/ for test: gem_pwrite
results: parsing output: 20/ for test: gem_userptr_blits
results: parsing output: 21/ for test: gem_eio
results: parsing output: 22/ for test: kms_psr2_sf
results: parsing output: 23/ for test: kms_big_fb
results: parsing output: 24/ for test: kms_big_fb
results: parsing output: 25/ for test: kms_frontbuffer_tracking
results: parsing output: 26/ for test: gem_userptr_blits
results: parsing output: 27/ for test: kms_frontbuffer_tracking
results: parsing output: 28/ for test: kms_flip_scaled_crc
results: parsing output: 29/ for test: gen7_exec_parse
results: parsing output: 30/ for test: gem_spin_batch
results: parsing output: 31/ for test: kms_ccs
results: parsing output: 32/ for test: gem_pxp
results: parsing output: 33/ for test: prime_busy
results: parsing output: 34/ for test: core_auth
results: parsing output: 35/ for test: kms_psr
results: parsing output: 36/ for test: kms_cursor_legacy
results: parsing output: 37/ for test: kms_cursor_crc
results: parsing output: 38/ for test: gem_exec_reloc
results: parsing output: 39/ for test: kms_frontbuffer_tracking
results: parsing output: 40/ for test: gem_ctx_persistence
results: parsing output: 41/ for test: kms_cursor_crc
results: parsing output: 42/ for test: syncobj_timeline
results: parsing output: 43/ for test: gem_mmap_offset
results: parsing output: 44/ for test: syncobj_timeline
results: parsing output: 45/ for test: fbdev
results: parsing output: 46/ for test: kms_cursor_crc
results: parsing output: 47/ for test: kms_cursor_crc
results: parsing output: 48/ for test: kms_chamelium_color
results: parsing output: 49/ for test: kms_dsc
results: parsing output: 50/ for test: gem_exec_gttfill
results: parsing output: 51/ for test: gem_mmap_gtt
results: parsing output: 52/ for test: i915_query
results: parsing output: 53/ for test: i915_drm_fdinfo
results: parsing output: 54/ for test: gem_exec_reloc
results: parsing output: 55/ for test: drm_read
results: parsing output: 56/ for test: kms_psr
results: parsing output: 57/ for test: kms_prime
results: parsing output: 58/ for test: kms_frontbuffer_tracking
results: parsing output: 59/ for test: gem_watchdog
results: parsing output: 60/ for test: gem_exec_reloc
results: parsing output: 61/ for test: gem_exec_schedule
results: parsing output: 62/ for test: kms_psr
results: parsing output: 63/ for test: gem_render_copy
results: parsing output: 64/ for test: kms_chamelium_frames
results: parsing output: 65/ for test: gem_exec_schedule
results: parsing output: 66/ for test: gem_lmem_swapping
results: parsing output: 67/ for test: kms_legacy_colorkey
results: parsing output: 68/ for test: gem_exec_suspend
results: parsing output: 69/ for test: gem_exec_params
results: parsing output: 70/ for test: syncobj_wait
results: parsing output: 71/ for test: kms_ccs
results: parsing output: 72/ for test: kms_busy
results: parsing output: 73/ for test: gem_softpin
results: parsing output: 74/ for test: kms_rotation_crc
results: parsing output: 75/ for test: gem_exec_schedule
results: parsing output: 76/ for test: kms_plane_lowres
results: parsing output: 77/ for test: gem_lmem_swapping
results: parsing output: 78/ for test: kms_setmode
results: parsing output: 79/ for test: kms_atomic
results: parsing output: 80/ for test: gem_sync
results: parsing output: 81/ for test: kms_ccs
results: parsing output: 82/ for test: kms_atomic_transition
results: parsing output: 83/ for test: api_intel_bb
results: parsing output: 84/ for test: i915_pm_rc6_residency
results: parsing output: 85/ for test: kms_flip_scaled_crc
results: parsing output: 86/ for test: kms_big_fb
results: parsing output: 87/ for test: kms_frontbuffer_tracking
results: parsing output: 88/ for test: kms_vrr
results: parsing output: 89/ for test: syncobj_wait
results: parsing output: 90/ for test: syncobj_wait
results: parsing output: 91/ for test: kms_debugfs
results: parsing output: 92/ for test: kms_frontbuffer_tracking
results: parsing output: 93/ for test: gem_mmap_wc
results: parsing output: 94/ for test: device_reset
results: parsing output: 95/ for test: gem_exec_fence
results: parsing output: 96/ for test: syncobj_timeline
results: parsing output: 97/ for test: gem_request_retire
results: parsing output: 98/ for test: kms_frontbuffer_tracking
results: parsing output: 99/ for test: kms_pipe_crc_basic
results: parsing output: 100/ for test: kms_frontbuffer_tracking
results: parsing output: 101/ for test: kms_frontbuffer_tracking
results: parsing output: 102/ for test: kms_frontbuffer_tracking
results: parsing output: 103/ for test: gem_ctx_persistence
results: parsing output: 104/ for test: kms_psr
results: parsing output: 105/ for test: kms_frontbuffer_tracking
results: parsing output: 106/ for test: kms_plane
results: parsing output: 107/ for test: perf
results: parsing output: 108/ for test: gem_mmap_gtt
results: parsing output: 109/ for test: kms_ccs
results: parsing output: 110/ for test: kms_frontbuffer_tracking
results: parsing output: 111/ for test: gem_userptr_blits
results: parsing output: 112/ for test: kms_cursor_legacy
results: parsing output: 113/ for test: kms_plane_scaling
results: parsing output: 114/ for test: kms_sequence
results: parsing output: 115/ for test: api_intel_allocator
results: parsing output: 116/ for test: kms_plane_scaling
results: parsing output: 117/ for test: kms_big_fb
results: parsing output: 118/ for test: kms_frontbuffer_tracking
results: parsing output: 119/ for test: kms_atomic_transition
results: parsing output: 120/ for test: kms_big_fb
results: parsing output: 121/ for test: kms_frontbuffer_tracking
results: parsing output: 122/ for test: gem_exec_balancer
results: parsing output: 123/ for test: perf_pmu
results: parsing output: 124/ for test: kms_prop_blob
results: parsing output: 125/ for test: kms_frontbuffer_tracking
results: parsing output: 126/ for test: gem_exec_balancer
results: parsing output: 127/ for test: kms_invalid_mode
results: parsing output: 128/ for test: perf_pmu
results: parsing output: 129/ for test: i915_pm_freq_api
results: parsing output: 130/ for test: kms_chamelium_hpd
results: parsing output: 131/ for test: vgem_basic
Done.