[69.123527] Initializing watchdogs
[69.123607]   /dev/watchdog0
[69.154212] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:03:00.0: 8086:4905 Intel Dg1 (Gen12) DG1 [Iris Xe MAX Graphics]
[69.169057] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[69.174342] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[69.177659] [001/133] (960s left) gem_madvise (dontneed-before-mmap)
[69.230957] Starting subtest: dontneed-before-mmap
[69.236415] Subtest dontneed-before-mmap: SUCCESS (0.004s)
[69.426735] [002/133] (960s left) kms_plane_alpha_blend (constant-alpha-mid)
[70.911847] Starting subtest: constant-alpha-mid
[71.302175] Starting dynamic subtest: pipe-A-HDMI-A-1
[71.976017] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.673s)
[71.984576] Starting dynamic subtest: pipe-D-HDMI-A-1
[72.644371] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.667s)
[72.646042] Subtest constant-alpha-mid: SUCCESS (1.731s)
[72.826589] [003/133] (957s left) kms_cursor_crc (cursor-offscreen-256x256)
[74.538466] Starting subtest: cursor-offscreen-256x256
[74.545354] Starting dynamic subtest: pipe-A-HDMI-A-1
[77.069654] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (2.526s)
[77.109352] Starting dynamic subtest: pipe-D-HDMI-A-1
[79.482661] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (2.389s)
[79.484311] Subtest cursor-offscreen-256x256: SUCCESS (4.944s)
[79.859461] [004/133] (950s left) kms_plane (plane-position-hole-dpms)
[81.345539] Starting subtest: plane-position-hole-dpms
[81.784040] Starting dynamic subtest: pipe-A-plane-1
[82.250900] Dynamic subtest pipe-A-plane-1: SUCCESS (0.467s)
[82.259905] Starting dynamic subtest: pipe-A-plane-2
[82.730306] Dynamic subtest pipe-A-plane-2: SUCCESS (0.480s)
[82.739051] Starting dynamic subtest: pipe-A-plane-3
[83.227865] Dynamic subtest pipe-A-plane-3: SUCCESS (0.498s)
[83.236583] Starting dynamic subtest: pipe-A-plane-4
[83.695257] Dynamic subtest pipe-A-plane-4: SUCCESS (0.467s)
[83.704117] Starting dynamic subtest: pipe-A-plane-5
[84.166899] Dynamic subtest pipe-A-plane-5: SUCCESS (0.470s)
[84.176239] Starting dynamic subtest: pipe-A-plane-6
[84.665718] Dynamic subtest pipe-A-plane-6: SUCCESS (0.500s)
[84.674788] Starting dynamic subtest: pipe-A-plane-7
[84.687293] Dynamic subtest pipe-A-plane-7: SUCCESS (0.020s)
[84.973037] Starting dynamic subtest: pipe-B-plane-1
[85.446780] Dynamic subtest pipe-B-plane-1: SUCCESS (0.483s)
[85.455699] Starting dynamic subtest: pipe-B-plane-2
[85.929052] Dynamic subtest pipe-B-plane-2: SUCCESS (0.483s)
[85.937945] Starting dynamic subtest: pipe-B-plane-3
[86.414146] Dynamic subtest pipe-B-plane-3: SUCCESS (0.484s)
[86.423167] Starting dynamic subtest: pipe-B-plane-4
[86.863739] Dynamic subtest pipe-B-plane-4: SUCCESS (0.450s)
[86.873253] Starting dynamic subtest: pipe-B-plane-5
[87.332314] Dynamic subtest pipe-B-plane-5: SUCCESS (0.468s)
[87.341226] Starting dynamic subtest: pipe-B-plane-6
[87.781099] Dynamic subtest pipe-B-plane-6: SUCCESS (0.447s)
[87.791614] Starting dynamic subtest: pipe-B-plane-7
[87.808559] Dynamic subtest pipe-B-plane-7: SUCCESS (0.026s)
[87.810823] Subtest plane-position-hole-dpms: SUCCESS (6.463s)
[87.985226] [005/133] (942s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-fullscreen)
[89.494592] Starting subtest: psr-2p-primscrn-spr-indfb-fullscreen
[89.497797] Subtest psr-2p-primscrn-spr-indfb-fullscreen: SKIP (0.000s)
[89.691847] [006/133] (940s left) i915_getparams_basic (basic-subslice-total)
[89.742146] Starting subtest: basic-subslice-total
[89.745054] Subtest basic-subslice-total: SUCCESS (0.000s)
[89.860946] [007/133] (940s left) syncobj_wait (wait-all-delayed-signal)
[89.908673] Starting subtest: wait-all-delayed-signal
[90.014790] Subtest wait-all-delayed-signal: SUCCESS (0.104s)
[90.170584] [008/133] (940s left) gen7_exec_parse (basic-rejected)
[90.229333] Subtest basic-rejected: SKIP (0.000s)
[90.294985] [009/133] (940s left) syncobj_wait (reset-unsignaled)
[90.342139] Starting subtest: reset-unsignaled
[90.343801] Subtest reset-unsignaled: SUCCESS (0.000s)
[90.459271] [010/133] (939s left) kms_flip (2x-single-buffer-flip-vs-dpms-off-vs-modeset-interruptible)
[91.950873] Starting subtest: 2x-single-buffer-flip-vs-dpms-off-vs-modeset-interruptible
[91.973688] Subtest 2x-single-buffer-flip-vs-dpms-off-vs-modeset-interruptible: SKIP (0.021s)
[92.114308] [011/133] (938s left) kms_psr2_su (page_flip-p010)
[92.164539] Subtest page_flip-P010: SKIP (0.000s)
[92.230062] [012/133] (938s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-pwrite)
[93.722518] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-pwrite
[93.725944] Subtest psr-2p-scndscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[93.911495] [013/133] (936s left) gem_ctx_param (invalid-param-set)
[93.959883] Starting subtest: invalid-param-set
[93.961658] Subtest invalid-param-set: SUCCESS (0.000s)
[94.089570] [014/133] (936s left) syncobj_timeline (multi-wait-for-submit-submitted-signaled)
[94.137424] Starting subtest: multi-wait-for-submit-submitted-signaled
[94.138717] Subtest multi-wait-for-submit-submitted-signaled: SUCCESS (0.001s)
[94.273472] [015/133] (936s left) perf_pmu (rc6)
[94.325048] Starting subtest: rc6
[94.326608] Starting dynamic subtest: gt0
[100.667255] Dynamic subtest gt0: SUCCESS (6.340s)
[100.676611] Starting dynamic subtest: runtime-pm-gt0
[108.290180] Dynamic subtest runtime-pm-gt0: SUCCESS (7.620s)
[108.299753] Starting dynamic subtest: runtime-pm-long-gt0
[120.856093] Dynamic subtest runtime-pm-long-gt0: SUCCESS (12.566s)
[120.865950] Starting dynamic subtest: other-idle-gt0
[120.869267] Dynamic subtest other-idle-gt0: SKIP (0.000s)
[120.870968] Subtest rc6: SUCCESS (26.531s)
[121.842729] [016/133] (909s left) syncobj_basic (bad-flags-fd-to-handle)
[121.889223] Starting subtest: bad-flags-fd-to-handle
[121.890729] Subtest bad-flags-fd-to-handle: SUCCESS (0.000s)
[122.034949] [017/133] (909s left) kms_psr (fbc-psr-primary-page-flip)
[123.521119] Subtest fbc-psr-primary-page-flip: SKIP (0.000s)
[123.590691] [018/133] (907s left) perf (non-sampling-read-error)
[123.672922] Starting subtest: non-sampling-read-error
[123.694794] Subtest non-sampling-read-error: SUCCESS (0.022s)
[123.761700] [019/133] (907s left) kms_frontbuffer_tracking (fbcpsr-stridechange)
[125.275216] Starting subtest: fbcpsr-stridechange
[125.278448] Subtest fbcpsr-stridechange: SKIP (0.000s)
[125.365713] [020/133] (905s left) kms_big_fb (x-tiled-8bpp-rotate-90)
[126.881404] Starting subtest: x-tiled-8bpp-rotate-90
[126.987935] Subtest x-tiled-8bpp-rotate-90: SKIP (0.105s)
[127.110559] [021/133] (904s left) gem_lmem_swapping (massive-random)
[131.271984] Starting subtest: massive-random
[131.275030] Starting dynamic subtest: lmem0
[131.946470] Dynamic subtest lmem0: SUCCESS (0.675s)
[131.948156] Subtest massive-random: SUCCESS (0.676s)
[134.393053] [FACT gem_lmem_swapping (massive-random)] deleted: kernel.kmod_is_loaded.i915: true
[134.395721] [022/133] (897s left) kms_big_fb (y-tiled-16bpp-rotate-270)
[139.024497] Starting subtest: y-tiled-16bpp-rotate-270
[140.789934] Subtest y-tiled-16bpp-rotate-270: SUCCESS (1.765s)
[140.920799] [FACT kms_big_fb (y-tiled-16bpp-rotate-270)] new: kernel.kmod_is_loaded.i915: true
[140.924888] [023/133] (890s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-fullscreen)
[142.419515] Starting subtest: fbc-1p-primscrn-spr-indfb-fullscreen
[144.489920] Subtest fbc-1p-primscrn-spr-indfb-fullscreen: SUCCESS (2.073s)
[144.655131] [024/133] (886s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-indfb-plflip-blt)
[146.147908] Starting subtest: fbcpsr-2p-primscrn-indfb-plflip-blt
[146.151122] Subtest fbcpsr-2p-primscrn-indfb-plflip-blt: SKIP (0.000s)
[146.246336] [025/133] (885s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180-async-flip)
[147.763921] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180-async-flip
[147.766966] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SKIP (0.000s)
[147.854853] [026/133] (883s left) syncobj_wait (invalid-single-wait-unsubmitted)
[147.907830] Starting subtest: invalid-single-wait-unsubmitted
[147.909297] Subtest invalid-single-wait-unsubmitted: SUCCESS (0.000s)
[147.985932] [027/133] (883s left) perf (gen12-mi-rpc)
[148.102443] Starting subtest: gen12-mi-rpc
[148.103992] Starting dynamic subtest: rcs0
[148.148989] Dynamic subtest rcs0: SUCCESS (0.047s)
[148.150595] Subtest gen12-mi-rpc: SUCCESS (0.048s)
[148.216326] [028/133] (883s left) gem_exec_params (dr4-dirt)
[148.302997] Starting subtest: DR4-dirt
[148.304741] Subtest DR4-dirt: SUCCESS (0.000s)
[148.428706] [029/133] (883s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-blt)
[149.923634] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-blt
[149.926888] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-blt: SKIP (0.000s)
[150.034466] [030/133] (881s left) kms_big_fb (linear-64bpp-rotate-90)
[151.554909] Starting subtest: linear-64bpp-rotate-90
[151.630723] Subtest linear-64bpp-rotate-90: SKIP (0.071s)
[151.747216] [031/133] (880s left) kms_psr (pr-primary-mmap-gtt)
[153.234340] Subtest pr-primary-mmap-gtt: SKIP (0.000s)
[153.324395] [032/133] (878s left) kms_psr2_sf (fbc-pr-overlay-plane-update-sf-dmg-area)
[154.826104] Subtest fbc-pr-overlay-plane-update-sf-dmg-area: SKIP (0.000s)
[154.897863] [033/133] (877s left) gem_softpin (overlap)
[154.952740] Starting subtest: overlap
[158.620502] Subtest overlap: SUCCESS (3.665s)
[158.733551] [034/133] (873s left) kms_chamelium_color (ctm-limited-range)
[160.220538] Subtest ctm-limited-range: SKIP (0.000s)
[160.298840] [035/133] (872s left) gem_bad_reloc (negative-reloc-bltcopy)
[160.354705] Subtest negative-reloc-bltcopy: SKIP (0.000s)
[160.446900] [036/133] (871s left) perf_pmu (most-busy-idle-check-all)
[160.498142] Starting subtest: most-busy-idle-check-all
[160.499811] Starting dynamic subtest: rcs0
[161.168842] Dynamic subtest rcs0: SUCCESS (0.670s)
[161.181709] Starting dynamic subtest: bcs0
[161.820311] Dynamic subtest bcs0: SUCCESS (0.650s)
[161.833158] Starting dynamic subtest: vcs0
[162.470737] Dynamic subtest vcs0: SUCCESS (0.649s)
[162.483260] Starting dynamic subtest: vcs1
[163.121837] Dynamic subtest vcs1: SUCCESS (0.650s)
[163.134920] Starting dynamic subtest: vecs0
[163.773760] Dynamic subtest vecs0: SUCCESS (0.651s)
[163.775472] Subtest most-busy-idle-check-all: SUCCESS (3.276s)
[163.857303] [037/133] (868s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling)
[165.347490] Subtest addfb25-framebuffer-vs-set-tiling: SKIP (0.000s)
[165.438583] [038/133] (867s left) gem_pxp (fail-invalid-protected-context)
[168.013934] Starting subtest: fail-invalid-protected-context
[168.017169] Subtest fail-invalid-protected-context: SKIP (0.000s)
[168.081845] [039/133] (864s left) gem_fence_thrash (bo-write-verify-y)
[168.127776] Starting subtest: bo-write-verify-y
[168.132537] Subtest bo-write-verify-y: SKIP (0.003s)
[168.197833] [040/133] (864s left) gem_exec_flush (basic-batch-kernel-default-wb)
[168.250980] Subtest basic-batch-kernel-default-wb: SKIP (0.000s)
[168.352646] [041/133] (864s left) gem_softpin (evict-single-offset)
[168.405307] Starting subtest: evict-single-offset
[205.532724] Subtest evict-single-offset: SUCCESS (37.125s)
[205.619204] [042/133] (827s left) i915_pm_rpm (gem-pread)
[210.037498] Starting subtest: gem-pread
[211.182253] Subtest gem-pread: SUCCESS (1.148s)
[212.029552] [043/133] (820s left) kms_ccs (bad-pixel-format-4-tiled-dg2-mc-ccs)
[213.532186] Starting subtest: bad-pixel-format-4-tiled-dg2-mc-ccs
[213.533808] Starting dynamic subtest: pipe-A-HDMI-A-1
[213.549277] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.000s)
[213.560558] Starting dynamic subtest: pipe-B-HDMI-A-1
[213.576544] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.000s)
[213.587477] Starting dynamic subtest: pipe-C-HDMI-A-1
[213.603969] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.000s)
[213.614860] Starting dynamic subtest: pipe-D-HDMI-A-1
[213.631558] Dynamic subtest pipe-D-HDMI-A-1: SKIP (0.000s)
[213.633977] Subtest bad-pixel-format-4-tiled-dg2-mc-ccs: SKIP (0.008s)
[213.742162] [044/133] (819s left) core_auth (getclient-master-drop)
[213.789539] Starting subtest: getclient-master-drop
[213.792293] Subtest getclient-master-drop: SUCCESS (0.003s)
[213.871979] [045/133] (819s left) api_intel_bb (blit-noreloc-purge-cache)
[213.920695] Starting subtest: blit-noreloc-purge-cache
[213.945578] Subtest blit-noreloc-purge-cache: SUCCESS (0.025s)
[214.061408] [046/133] (819s left) syncobj_timeline (single-wait-available-submitted)
[214.116040] Starting subtest: single-wait-available-submitted
[214.117662] Subtest single-wait-available-submitted: SUCCESS (0.000s)
[214.187384] [047/133] (819s left) gem_exec_balancer (parallel-balancer)
[214.610540] Starting subtest: parallel-balancer
[216.666997] Subtest parallel-balancer: SUCCESS (2.058s)
[216.737664] [048/133] (816s left) gen9_exec_parse (valid-registers)
[216.791591] Subtest valid-registers: SKIP (0.000s)
[216.868552] [049/133] (816s left) prime_self_import (basic-with_fd_dup)
[216.914422] Starting subtest: basic-with_fd_dup
[216.919691] Subtest basic-with_fd_dup: SUCCESS (0.005s)
[217.008679] [050/133] (816s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-180)
[218.519389] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-180
[219.761457] Subtest y-tiled-max-hw-stride-32bpp-rotate-180: SUCCESS (1.242s)
[219.961605] [051/133] (813s left) kms_chamelium_hpd (hdmi-hpd-for-each-pipe)
[221.484995] Subtest hdmi-hpd-for-each-pipe: SKIP (0.000s)
[221.596955] [052/133] (811s left) kms_frontbuffer_tracking (fbc-1p-primscrn-indfb-msflip-blt)
[223.090682] Starting subtest: fbc-1p-primscrn-indfb-msflip-blt
[226.018561] Subtest fbc-1p-primscrn-indfb-msflip-blt: SUCCESS (2.929s)
[226.245650] [053/133] (807s left) kms_flip (2x-busy-flip)
[227.733284] Starting subtest: 2x-busy-flip
[227.755417] Subtest 2x-busy-flip: SKIP (0.021s)
[227.853747] [054/133] (805s left) gem_softpin (noreloc)
[227.909221] Starting subtest: noreloc
[233.417991] Subtest noreloc: SUCCESS (5.506s)
[233.546086] [055/133] (800s left) kms_psr (psr-primary-page-flip)
[235.037191] Subtest psr-primary-page-flip: SKIP (0.000s)
[235.112463] [056/133] (798s left) gem_render_copy (y-tiled-ccs-to-linear)
[235.171093] Starting subtest: y-tiled-ccs-to-linear
[235.172692] Starting dynamic subtest: smem
[235.257395] Dynamic subtest smem: SUCCESS (0.086s)
[235.268450] Starting dynamic subtest: lmem0
[235.565740] Dynamic subtest lmem0: SUCCESS (0.304s)
[235.567267] Subtest y-tiled-ccs-to-linear: SUCCESS (0.392s)
[235.792533] [057/133] (798s left) gem_mmap_gtt (basic-copy)
[235.842130] Subtest basic-copy: SKIP (0.000s)
[235.909996] [058/133] (798s left) kms_cursor_legacy (short-busy-flip-before-cursor-atomic-transitions-varying-s
[237.409204] Starting subtest: short-busy-flip-before-cursor-atomic-transitions-varying-size
[237.412280] Subtest short-busy-flip-before-cursor-atomic-transitions-varying-size: SKIP (0.000s)
[237.586376] [059/133] (796s left) kms_frontbuffer_tracking (fbc-1p-indfb-fliptrack-mmap-gtt)
[239.091527] Starting subtest: fbc-1p-indfb-fliptrack-mmap-gtt
[239.094547] Subtest fbc-1p-indfb-fliptrack-mmap-gtt: SKIP (0.000s)
[239.185784] [060/133] (795s left) i915_suspend (sysfs-reader)
[239.241580] Starting subtest: sysfs-reader
[262.417412] Subtest sysfs-reader: SUCCESS (12.115s)
[266.605646] [061/133] (771s left) gem_exec_schedule (preempt-user)
[266.673822] Starting subtest: preempt-user
[266.675524] Starting dynamic subtest: rcs0
[266.740645] Dynamic subtest rcs0: SUCCESS (0.066s)
[266.754427] Starting dynamic subtest: bcs0
[266.783840] Dynamic subtest bcs0: SUCCESS (0.042s)
[266.797331] Starting dynamic subtest: vcs0
[266.828540] Dynamic subtest vcs0: SUCCESS (0.044s)
[266.842090] Starting dynamic subtest: vcs1
[266.875152] Dynamic subtest vcs1: SUCCESS (0.045s)
[266.888731] Starting dynamic subtest: vecs0
[266.919198] Dynamic subtest vecs0: SUCCESS (0.043s)
[266.920863] Subtest preempt-user: SUCCESS (0.246s)
[267.347518] [062/133] (771s left) gem_mmap_offset (mmap-boundaries)
[267.394735] Starting subtest: mmap-boundaries
[267.396155] Starting dynamic subtest: lmem0
[267.685692] Dynamic subtest lmem0: SUCCESS (0.288s)
[267.698675] Starting dynamic subtest: smem0
[269.495282] Dynamic subtest smem0: SUCCESS (1.809s)
[269.496614] Subtest mmap-boundaries: SUCCESS (2.098s)
[269.792270] [063/133] (768s left) gem_ctx_shared (single-timeline)
[269.850972] Starting subtest: single-timeline
[269.879017] Subtest single-timeline: SUCCESS (0.025s)
[270.142507] [064/133] (768s left) kms_color_pipeline (plane-lut1d-ctm3x4-lut1d)
[271.632892] Starting subtest: plane-lut1d-ctm3x4-lut1d
[271.832846] Starting dynamic subtest: pipe-A-plane-0
[272.081166] Dynamic subtest pipe-A-plane-0: SUCCESS (0.248s)
[272.125629] Starting dynamic subtest: pipe-A-plane-1
[272.297964] Dynamic subtest pipe-A-plane-1: SUCCESS (0.212s)
[272.328513] Starting dynamic subtest: pipe-A-plane-2
[272.497872] Dynamic subtest pipe-A-plane-2: SUCCESS (0.196s)
[272.773590] Starting dynamic subtest: pipe-B-plane-0
[272.926209] Dynamic subtest pipe-B-plane-0: SUCCESS (0.166s)
[272.957203] Starting dynamic subtest: pipe-B-plane-1
[273.112307] Dynamic subtest pipe-B-plane-1: SUCCESS (0.178s)
[273.148066] Starting dynamic subtest: pipe-B-plane-2
[273.325259] Dynamic subtest pipe-B-plane-2: SUCCESS (0.212s)
[273.620851] Starting dynamic subtest: pipe-C-plane-0
[273.784307] Dynamic subtest pipe-C-plane-0: SUCCESS (0.198s)
[273.818312] Starting dynamic subtest: pipe-C-plane-1
[273.998552] Dynamic subtest pipe-C-plane-1: SUCCESS (0.212s)
[274.027045] Starting dynamic subtest: pipe-C-plane-2
[274.198620] Dynamic subtest pipe-C-plane-2: SUCCESS (0.196s)
[274.522247] Starting dynamic subtest: pipe-D-plane-0
[274.700087] Dynamic subtest pipe-D-plane-0: SUCCESS (0.215s)
[274.729513] Starting dynamic subtest: pipe-D-plane-1
[274.911249] Dynamic subtest pipe-D-plane-1: SUCCESS (0.211s)
[274.948430] Starting dynamic subtest: pipe-D-plane-2
[275.127909] Dynamic subtest pipe-D-plane-2: SUCCESS (0.211s)
[275.184082] Subtest plane-lut1d-ctm3x4-lut1d: SUCCESS (3.550s)
[275.321940] [065/133] (763s left) syncobj_basic (bad-fd-to-handle)
[275.384374] Starting subtest: bad-fd-to-handle
[275.386483] Subtest bad-fd-to-handle: SUCCESS (0.000s)
[275.503413] [066/133] (763s left) kms_getfb (getfb2-handle-not-fb)
[276.992584] Starting subtest: getfb2-handle-not-fb
[276.994103] Subtest getfb2-handle-not-fb: SUCCESS (0.000s)
[277.148460] [067/133] (761s left) gem_exec_balancer (semaphore)
[277.209818] Starting subtest: semaphore
[279.271709] Subtest semaphore: SUCCESS (2.064s)
[279.686329] [068/133] (759s left) gem_exec_schedule (lateslice)
[279.748955] Starting subtest: lateslice
[279.750662] Starting dynamic subtest: rcs0
[279.788185] Dynamic subtest rcs0: SUCCESS (0.039s)
[279.801864] Starting dynamic subtest: bcs0
[279.809616] Dynamic subtest bcs0: SUCCESS (0.020s)
[279.823218] Starting dynamic subtest: vcs0
[279.831025] Dynamic subtest vcs0: SUCCESS (0.020s)
[279.844562] Starting dynamic subtest: vcs1
[279.852127] Dynamic subtest vcs1: SUCCESS (0.020s)
[279.865720] Starting dynamic subtest: vecs0
[279.883586] Dynamic subtest vecs0: SUCCESS (0.021s)
[279.885524] Subtest lateslice: SUCCESS (0.126s)
[280.275867] [069/133] (758s left) kms_ccs (crc-sprite-planes-basic-4-tiled-mtl-mc-ccs)
[281.762314] Starting subtest: crc-sprite-planes-basic-4-tiled-mtl-mc-ccs
[281.763733] Starting dynamic subtest: pipe-A-HDMI-A-1
[281.800543] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.003s)
[281.813840] Starting dynamic subtest: pipe-B-HDMI-A-1
[281.853132] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.003s)
[281.866421] Starting dynamic subtest: pipe-C-HDMI-A-1
[281.907811] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.003s)
[281.921013] Starting dynamic subtest: pipe-D-HDMI-A-1
[281.970114] Dynamic subtest pipe-D-HDMI-A-1: SKIP (0.003s)
[281.974101] Subtest crc-sprite-planes-basic-4-tiled-mtl-mc-ccs: SKIP (0.019s)
[282.051509] [070/133] (757s left) kms_joiner (basic-max-non-joiner)
[283.583281] Starting subtest: basic-max-non-joiner
[283.586888] Subtest basic-max-non-joiner: SKIP (0.000s)
[283.650722] [071/133] (755s left) kms_draw_crc (draw-method-render)
[285.139547] Starting subtest: draw-method-render
[285.141078] Starting dynamic subtest: xrgb8888-untiled
[285.537441] Dynamic subtest xrgb8888-untiled: SUCCESS (0.396s)
[285.587273] Starting dynamic subtest: rgb565-untiled
[285.887346] Dynamic subtest rgb565-untiled: SUCCESS (0.344s)
[285.919490] Starting dynamic subtest: xrgb2101010-untiled
[286.220529] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.327s)
[286.268042] Starting dynamic subtest: xbgr16161616f-untiled
[286.604253] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.378s)
[286.653033] Starting dynamic subtest: xrgb8888-xtiled
[286.804184] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.194s)
[286.849434] Starting dynamic subtest: rgb565-xtiled
[287.004223] Dynamic subtest rgb565-xtiled: SUCCESS (0.194s)
[287.053185] Starting dynamic subtest: xrgb2101010-xtiled
[287.187086] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.177s)
[287.233576] Starting dynamic subtest: xbgr16161616f-xtiled
[287.387185] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.194s)
[287.433425] Starting dynamic subtest: xrgb8888-ytiled
[287.587304] Dynamic subtest xrgb8888-ytiled: SUCCESS (0.194s)
[287.633591] Starting dynamic subtest: rgb565-ytiled
[287.787271] Dynamic subtest rgb565-ytiled: SUCCESS (0.194s)
[287.833666] Starting dynamic subtest: xrgb2101010-ytiled
[287.970573] Dynamic subtest xrgb2101010-ytiled: SUCCESS (0.177s)
[288.018328] Starting dynamic subtest: xbgr16161616f-ytiled
[288.170702] Dynamic subtest xbgr16161616f-ytiled: SUCCESS (0.194s)
[288.179376] Subtest draw-method-render: SUCCESS (3.033s)
[288.323169] [072/133] (750s left) gem_ctx_persistence (heartbeat-stop)
[288.379094] Starting subtest: heartbeat-stop
[288.382738] Subtest heartbeat-stop: SKIP (0.000s)
[288.467458] [073/133] (750s left) gem_fenced_exec_thrash (too-many-fences)
[288.528550] Subtest too-many-fences: SKIP (0.000s)
[288.596352] [074/133] (750s left) gem_exec_fence (syncobj-timeline-multiple-ext-nodes)
[289.208079] Starting subtest: syncobj-timeline-multiple-ext-nodes
[289.213302] Subtest syncobj-timeline-multiple-ext-nodes: SUCCESS (0.006s)
[289.530477] [FACT gem_exec_fence (syncobj-timeline-multiple-ext-nodes)] new: kernel.kmod_is_loaded.vgem: true
[289.533996] [075/133] (749s left) kms_rotation_crc (primary-rotation-90)
[291.021182] Starting subtest: primary-rotation-90
[301.564357] Subtest primary-rotation-90: SUCCESS (10.544s)
[301.770786] [076/133] (737s left) gem_wait (await)
[301.836818] Starting subtest: await
[301.838435] Starting dynamic subtest: all-engines
[302.950901] Dynamic subtest all-engines: SUCCESS (1.113s)
[302.969681] Starting dynamic subtest: rcs0
[304.016543] Dynamic subtest rcs0: SUCCESS (1.063s)
[304.032131] Starting dynamic subtest: bcs0
[305.076664] Dynamic subtest bcs0: SUCCESS (1.058s)
[305.092192] Starting dynamic subtest: vcs0
[306.136603] Dynamic subtest vcs0: SUCCESS (1.058s)
[306.152789] Starting dynamic subtest: vcs1
[307.195591] Dynamic subtest vcs1: SUCCESS (1.057s)
[307.218482] Starting dynamic subtest: vecs0
[308.257428] Dynamic subtest vecs0: SUCCESS (1.059s)
[308.263823] Subtest await: SUCCESS (6.423s)
[308.552026] [077/133] (731s left) kms_cursor_crc (cursor-sliding-64x64)
[310.181964] Starting subtest: cursor-sliding-64x64
[310.190742] Starting dynamic subtest: pipe-A-HDMI-A-1
[314.637732] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (4.448s)
[314.672384] Starting dynamic subtest: pipe-D-HDMI-A-1
[318.947071] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (4.287s)
[318.948584] Subtest cursor-sliding-64x64: SUCCESS (8.765s)
[319.414345] [078/133] (720s left) kms_frontbuffer_tracking (psr-rgb101010-draw-mmap-cpu)
[320.911130] Starting subtest: psr-rgb101010-draw-mmap-cpu
[320.914906] Subtest psr-rgb101010-draw-mmap-cpu: SKIP (0.000s)
[321.036245] [079/133] (718s left) syncobj_timeline (etime-single-wait-all-submitted)
[321.088647] Starting subtest: etime-single-wait-all-submitted
[321.192853] Subtest etime-single-wait-all-submitted: SUCCESS (0.105s)
[321.339651] [080/133] (718s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-mmap-wc)
[322.835431] Starting subtest: fbc-rgb101010-draw-mmap-wc
[322.838958] Subtest fbc-rgb101010-draw-mmap-wc: SKIP (0.000s)
[322.989024] [081/133] (717s left) kms_pm_rpm (dpms-mode-unset-lpsp)
[327.111144] Starting subtest: dpms-mode-unset-lpsp
[330.047683] Subtest dpms-mode-unset-lpsp: SUCCESS (2.943s)
[330.963242] [082/133] (709s left) gem_basic (multigpu-create-close)
[331.011769] Starting subtest: multigpu-create-close
[331.015237] Subtest multigpu-create-close: SKIP (0.000s)
[331.091496] [083/133] (709s left) dmabuf_sync_file (import-basic)
[331.156214] Starting subtest: import-basic
[331.160287] Subtest import-basic: SUCCESS (0.003s)
[331.231870] [084/133] (709s left) gem_eio (wait-10ms)
[331.431954] Starting subtest: wait-10ms
[331.901402] Subtest wait-10ms: SUCCESS (0.470s)
[333.424833] [085/133] (706s left) kms_vblank (ts-continuation-dpms-rpm)
[334.914801] Starting subtest: ts-continuation-dpms-rpm
[334.916585] Starting dynamic subtest: pipe-A-HDMI-A-1
[337.357243] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (2.442s)
[337.377675] Starting dynamic subtest: pipe-D-HDMI-A-1
[338.528959] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (1.167s)
[338.530411] Subtest ts-continuation-dpms-rpm: SUCCESS (3.617s)
[338.666107] [086/133] (701s left) kms_cursor_crc (cursor-random-512x512)
[340.415850] Starting subtest: cursor-random-512x512
[340.418964] Subtest cursor-random-512x512: SKIP (0.001s)
[340.611583] [087/133] (699s left) gem_exec_params (no-blt)
[340.664953] Starting subtest: no-blt
[340.666572] Subtest no-blt: SUCCESS (0.001s)
[340.792841] [088/133] (699s left) kms_big_fb (yf-tiled-32bpp-rotate-180)
[342.299749] Starting subtest: yf-tiled-32bpp-rotate-180
[342.303983] Subtest yf-tiled-32bpp-rotate-180: SKIP (0.000s)
[342.492311] [089/133] (698s left) kms_pm_rpm (modeset-non-lpsp-stress-no-wait)
[346.112973] Starting subtest: modeset-non-lpsp-stress-no-wait
[346.897377] Subtest modeset-non-lpsp-stress-no-wait: SKIP (0.790s)
[347.090145] [090/133] (693s left) kms_psr2_sf (psr2-cursor-plane-update-sf)
[348.581522] Subtest psr2-cursor-plane-update-sf: SKIP (0.000s)
[348.653977] [091/133] (692s left) gem_exec_reloc (basic-cpu-wc)
[348.709154] Subtest basic-cpu-wc: SKIP (0.000s)
[348.805192] [092/133] (692s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-pwrite)
[350.300803] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-pwrite
[350.304116] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[350.397731] [093/133] (690s left) syncobj_eventfd (binary-wait)
[350.452850] Starting subtest: binary-wait
[350.461786] Subtest binary-wait: SUCCESS (0.011s)
[350.540319] [094/133] (690s left) kms_rotation_crc (sprite-rotation-180)
[352.026420] Starting subtest: sprite-rotation-180
[362.368552] Subtest sprite-rotation-180: SUCCESS (10.341s)
[362.605000] [095/133] (678s left) kms_psr (fbc-psr2-primary-page-flip)
[364.098024] Subtest fbc-psr2-primary-page-flip: SKIP (0.000s)
[364.165193] [096/133] (677s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-16bpp-xtile-downscaling)
[365.654866] Starting subtest: flip-64bpp-xtile-to-16bpp-xtile-downscaling
[365.656627] Starting dynamic subtest: pipe-A-valid-mode
[366.844612] Dynamic subtest pipe-A-valid-mode: SUCCESS (1.189s)
[366.846619] Subtest flip-64bpp-xtile-to-16bpp-xtile-downscaling: SUCCESS (1.192s)
[366.996196] [097/133] (674s left) gem_ctx_persistence (engines-hang)
[367.049056] Starting subtest: engines-hang
[367.060514] Starting dynamic subtest: rcs0
[367.107548] Dynamic subtest rcs0: SUCCESS (0.058s)
[367.124764] Starting dynamic subtest: bcs0
[367.179140] Dynamic subtest bcs0: SUCCESS (0.070s)
[367.221667] Starting dynamic subtest: vcs0
[367.293664] Dynamic subtest vcs0: SUCCESS (0.111s)
[367.318451] Starting dynamic subtest: vcs1
[367.387038] Dynamic subtest vcs1: SUCCESS (0.090s)
[367.439488] Starting dynamic subtest: vecs0
[367.457775] Dynamic subtest vecs0: SUCCESS (0.064s)
[367.459520] Subtest engines-hang: SUCCESS (0.410s)
[367.584558] [098/133] (673s left) gem_ctx_engines (execute-one)
[367.643787] Starting subtest: execute-one
[370.016000] Subtest execute-one: SUCCESS (2.372s)
[370.284846] [099/133] (671s left) gem_lmem_swapping (verify)
[374.511316] Starting subtest: verify
[374.513148] Starting dynamic subtest: lmem0
[414.969682] Dynamic subtest lmem0: SUCCESS (40.455s)
[414.971219] Subtest verify: SUCCESS (40.457s)
[416.421766] [FACT gem_lmem_swapping (verify)] deleted: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[416.423210] [FACT gem_lmem_swapping (verify)] deleted: kernel.kmod_is_loaded.i915: true
[416.426206] [100/133] (625s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-wc)
[421.006965] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-wc
[421.010210] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[421.106100] [FACT kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-wc)] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[421.111095] [FACT kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-wc)] new: kernel.kmod_is_loaded.i915: true
[421.115652] [101/133] (620s left) kms_big_fb (4-tiled-16bpp-rotate-90)
[422.630830] Starting subtest: 4-tiled-16bpp-rotate-90
[422.633814] Subtest 4-tiled-16bpp-rotate-90: SKIP (0.000s)
[422.766687] [102/133] (619s left) gem_pipe_control_store_loop (reused-buffer)
[422.827568] Starting subtest: reused-buffer
[424.999494] Subtest reused-buffer: SUCCESS (2.171s)
[425.102163] [103/133] (616s left) kms_flip (2x-flip-vs-wf_vblank)
[426.590218] Starting subtest: 2x-flip-vs-wf_vblank
[426.610611] Subtest 2x-flip-vs-wf_vblank: SKIP (0.021s)
[426.716709] [104/133] (615s left) kms_flip (2x-plain-flip-ts-check)
[428.202392] Starting subtest: 2x-plain-flip-ts-check
[428.224960] Subtest 2x-plain-flip-ts-check: SKIP (0.021s)
[428.324081] [105/133] (613s left) gem_pxp (reject-modify-context-protection-off-1)
[430.911672] Starting subtest: reject-modify-context-protection-off-1
[430.914812] Subtest reject-modify-context-protection-off-1: SKIP (0.000s)
[430.991792] [106/133] (611s left) gem_exec_whisper (basic-contexts-forked)
[431.062765] Starting subtest: basic-contexts-forked
[445.402556] Subtest basic-contexts-forked: SUCCESS (14.335s)
[445.606829] [107/133] (596s left) kms_plane_scaling (planes-upscale-20x20-downscale-factor-0-75)
[447.096616] Starting subtest: planes-upscale-20x20-downscale-factor-0-75
[447.098128] Starting dynamic subtest: pipe-A
[447.236499] Dynamic subtest pipe-A: SUCCESS (0.141s)
[447.251964] Starting dynamic subtest: pipe-B
[447.394132] Dynamic subtest pipe-B: SUCCESS (0.156s)
[447.409259] Starting dynamic subtest: pipe-C
[447.534084] Dynamic subtest pipe-C: SUCCESS (0.138s)
[447.549146] Starting dynamic subtest: pipe-D
[447.674062] Dynamic subtest pipe-D: SUCCESS (0.138s)
[447.675549] Subtest planes-upscale-20x20-downscale-factor-0-75: SUCCESS (0.580s)
[447.820571] [108/133] (594s left) kms_chamelium_frames (hdmi-crc-multiple)
[449.357074] Subtest hdmi-crc-multiple: SKIP (0.000s)
[449.476889] [109/133] (592s left) kms_async_flips (crc)
[450.966659] Starting subtest: crc
[451.215510] Starting dynamic subtest: pipe-A-HDMI-A-1
[453.668222] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (2.449s)
[453.863148] Starting dynamic subtest: pipe-B-HDMI-A-1
[456.024105] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (2.170s)
[456.197364] Starting dynamic subtest: pipe-C-HDMI-A-1
[458.355885] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (2.168s)
[458.536939] Starting dynamic subtest: pipe-D-HDMI-A-1
[460.695161] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (2.167s)
[460.696806] Subtest crc: SUCCESS (9.728s)
[460.989867] [110/133] (581s left) syncobj_timeline (invalid-transfer-bad-pad)
[461.041254] Starting subtest: invalid-transfer-bad-pad
[461.042615] Subtest invalid-transfer-bad-pad: SUCCESS (0.000s)
[461.119557] [111/133] (581s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-render)
[462.616875] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-render
[462.622519] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-render: SKIP (0.000s)
[462.813268] [112/133] (579s left) kms_rotation_crc (primary-y-tiled-reflect-x-270)
[464.301693] Starting subtest: primary-y-tiled-reflect-x-270
[474.763397] Subtest primary-y-tiled-reflect-x-270: SUCCESS (10.463s)
[474.988591] [113/133] (567s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-onoff)
[476.485799] Starting subtest: psr-2p-primscrn-cur-indfb-onoff
[476.489344] Subtest psr-2p-primscrn-cur-indfb-onoff: SKIP (0.000s)
[476.598029] [114/133] (566s left) kms_async_flips (test-cursor)
[478.090727] Starting subtest: test-cursor
[478.345769] Starting dynamic subtest: pipe-A-HDMI-A-1
[478.693142] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.347s)
[478.909880] Starting dynamic subtest: pipe-B-HDMI-A-1
[478.966578] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.069s)
[479.125272] Starting dynamic subtest: pipe-C-HDMI-A-1
[479.187103] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.074s)
[479.392596] Starting dynamic subtest: pipe-D-HDMI-A-1
[479.455509] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.075s)
[479.457080] Subtest test-cursor: SUCCESS (1.367s)
[479.796566] [115/133] (563s left) kms_flip (dpms-vs-vblank-race)
[481.286427] Starting subtest: dpms-vs-vblank-race
[481.290277] Starting dynamic subtest: A-HDMI-A1
[484.327138] Dynamic subtest A-HDMI-A1: SUCCESS (3.029s)
[484.342403] Starting dynamic subtest: B-HDMI-A1
[487.347399] Dynamic subtest B-HDMI-A1: SUCCESS (3.025s)
[487.361167] Starting dynamic subtest: C-HDMI-A1
[490.306640] Dynamic subtest C-HDMI-A1: SUCCESS (2.957s)
[490.320390] Starting dynamic subtest: D-HDMI-A1
[493.263374] Dynamic subtest D-HDMI-A1: SUCCESS (2.955s)
[493.267297] Subtest dpms-vs-vblank-race: SUCCESS (11.982s)
[493.427889] [116/133] (549s left) kms_psr (psr2-sprite-render)
[494.962868] Subtest psr2-sprite-render: SKIP (0.000s)
[495.035648] [117/133] (548s left) kms_content_protection (legacy)
[496.580017] Starting subtest: legacy
[496.587903] Subtest legacy: SKIP (0.002s)
[496.737890] [118/133] (546s left) gem_render_copy (yf-tiled-to-vebox-yf-tiled)
[496.792012] Starting subtest: yf-tiled-to-vebox-yf-tiled
[496.793722] Starting dynamic subtest: smem
[496.874900] Dynamic subtest smem: SUCCESS (0.082s)
[496.888692] Starting dynamic subtest: lmem0
[497.631140] Dynamic subtest lmem0: SUCCESS (0.752s)
[497.633027] Subtest yf-tiled-to-vebox-yf-tiled: SUCCESS (0.837s)
[497.860704] [119/133] (545s left) kms_ccs (crc-primary-suspend-4-tiled-dg2-mc-ccs)
[499.357102] Starting subtest: crc-primary-suspend-4-tiled-dg2-mc-ccs
[499.358901] Starting dynamic subtest: pipe-A-HDMI-A-1
[499.366396] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.000s)
[499.380618] Starting dynamic subtest: pipe-B-HDMI-A-1
[499.387895] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.000s)
[499.401262] Starting dynamic subtest: pipe-C-HDMI-A-1
[499.406757] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.000s)
[499.420074] Starting dynamic subtest: pipe-D-HDMI-A-1
[499.425809] Dynamic subtest pipe-D-HDMI-A-1: SKIP (0.000s)
[499.428731] Subtest crc-primary-suspend-4-tiled-dg2-mc-ccs: SKIP (0.011s)
[499.575005] [120/133] (543s left) kms_lease (lease-revoke)
[501.061912] Starting subtest: lease-revoke
[501.063719] Starting dynamic subtest: pipe-A-HDMI-A-1
[501.128246] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.065s)
[501.143798] Starting dynamic subtest: pipe-B-HDMI-A-1
[501.179619] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.048s)
[501.194161] Starting dynamic subtest: pipe-C-HDMI-A-1
[501.230724] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.048s)
[501.245125] Starting dynamic subtest: pipe-D-HDMI-A-1
[501.280091] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.048s)
[501.281651] Subtest lease-revoke: SUCCESS (0.221s)
[501.410617] [121/133] (541s left) syncobj_wait (multi-wait-for-submit-unsubmitted-submitted)
[501.461787] Starting subtest: multi-wait-for-submit-unsubmitted-submitted
[501.570953] Subtest multi-wait-for-submit-unsubmitted-submitted: SUCCESS (0.107s)
[501.717543] [122/133] (541s left) kms_plane_multiple (2x-tiling-x)
[503.205326] Starting subtest: 2x-tiling-x
[503.208067] Subtest 2x-tiling-x: SKIP (0.000s)
[503.286895] [123/133] (540s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-cpu)
[504.781779] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-cpu
[504.785560] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[504.870267] [124/133] (538s left) prime_busy (before-wait)
[504.927967] Starting subtest: before-wait
[504.932456] Starting dynamic subtest: rcs0
[504.965964] Dynamic subtest rcs0: SUCCESS (0.034s)
[504.979762] Starting dynamic subtest: bcs0
[505.006534] Dynamic subtest bcs0: SUCCESS (0.039s)
[505.024571] Starting dynamic subtest: vcs0
[505.047409] Dynamic subtest vcs0: SUCCESS (0.039s)
[505.068469] Starting dynamic subtest: vcs1
[505.089448] Dynamic subtest vcs1: SUCCESS (0.040s)
[505.110545] Starting dynamic subtest: vecs0
[505.129641] Dynamic subtest vecs0: SUCCESS (0.038s)
[505.242545] Subtest before-wait: SUCCESS (0.314s)
[505.389516] [125/133] (538s left) kms_sequence (queue-idle)
[506.876307] Starting subtest: queue-idle
[506.879692] Starting dynamic subtest: pipe-A-HDMI-A-1
[509.257026] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (2.378s)
[509.272642] Starting dynamic subtest: pipe-B-HDMI-A-1
[511.466345] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (2.206s)
[511.482234] Starting dynamic subtest: pipe-C-HDMI-A-1
[513.676516] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (2.207s)
[513.690669] Starting dynamic subtest: pipe-D-HDMI-A-1
[515.891073] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (2.213s)
[515.892609] Subtest queue-idle: SUCCESS (9.015s)
[516.040283] [126/133] (527s left) kms_frontbuffer_tracking (fbc-2p-primscrn-shrfb-pgflip-blt)
[517.533796] Starting subtest: fbc-2p-primscrn-shrfb-pgflip-blt
[517.536958] Subtest fbc-2p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[517.659705] [127/133] (526s left) kms_flip (2x-flip-vs-dpms-on-nop-interruptible)
[519.153134] Starting subtest: 2x-flip-vs-dpms-on-nop-interruptible
[519.176004] Subtest 2x-flip-vs-dpms-on-nop-interruptible: SKIP (0.022s)
[519.252278] [128/133] (524s left) gem_eio (in-flight-1us)
[519.449208] Starting subtest: in-flight-1us
[523.790606] Subtest in-flight-1us: SUCCESS (4.341s)
[525.438393] [129/133] (518s left) kms_ccs (crc-primary-basic-yf-tiled-ccs)
[526.922581] Starting subtest: crc-primary-basic-yf-tiled-ccs
[526.924263] Starting dynamic subtest: pipe-A-HDMI-A-1
[526.941063] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.001s)
[526.955568] Starting dynamic subtest: pipe-B-HDMI-A-1
[526.972840] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.001s)
[526.987231] Starting dynamic subtest: pipe-C-HDMI-A-1
[527.004897] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.001s)
[527.019410] Starting dynamic subtest: pipe-D-HDMI-A-1
[527.037616] Dynamic subtest pipe-D-HDMI-A-1: SKIP (0.001s)
[527.040373] Subtest crc-primary-basic-yf-tiled-ccs: SKIP (0.014s)
[527.136883] [130/133] (517s left) sysfs_heartbeat_interval (invalid)
[527.191105] Starting subtest: invalid
[527.192603] Starting dynamic subtest: vecs0
[527.194079] Dynamic subtest vecs0: SUCCESS (0.000s)
[527.209258] Starting dynamic subtest: vcs0
[527.210963] Dynamic subtest vcs0: SUCCESS (0.000s)
[527.225466] Starting dynamic subtest: bcs0
[527.227112] Dynamic subtest bcs0: SUCCESS (0.000s)
[527.241374] Starting dynamic subtest: rcs0
[527.243111] Dynamic subtest rcs0: SUCCESS (0.000s)
[527.257101] Starting dynamic subtest: vcs1
[527.258763] Dynamic subtest vcs1: SUCCESS (0.000s)
[527.260501] Subtest invalid: SUCCESS (0.010s)
[527.329817] [131/133] (516s left) syncobj_wait (invalid-wait-illegal-handle)
[527.379615] Starting subtest: invalid-wait-illegal-handle
[527.381161] Subtest invalid-wait-illegal-handle: SUCCESS (0.000s)
[527.465967] [132/133] (516s left) kms_plane (pixel-format-4-tiled-mtl-mc-ccs-modifier-source-clamping)
[528.955450] Starting subtest: pixel-format-4-tiled-mtl-mc-ccs-modifier-source-clamping
[528.958715] Subtest pixel-format-4-tiled-mtl-mc-ccs-modifier-source-clamping: SKIP (0.000s)
[529.135275] [133/133] (515s left) gem_exec_parallel (engines)
[529.193128] Starting subtest: engines
[529.194642] Starting dynamic subtest: basic
[530.794943] Dynamic subtest basic: SUCCESS (1.601s)
[530.814624] Starting dynamic subtest: contexts
[534.560652] Dynamic subtest contexts: SUCCESS (3.761s)
[534.575742] Starting dynamic subtest: fds
[538.989755] Dynamic subtest fds: SUCCESS (4.428s)
[539.004533] Starting dynamic subtest: userptr
[540.488538] Dynamic subtest userptr: SUCCESS (1.500s)
[540.490162] Subtest engines: SUCCESS (11.296s)
[540.890773] Closing watchdogs
results: parsing output: 0/ for test: gem_madvise
results: parsing output: 1/ for test: kms_plane_alpha_blend
results: parsing output: 2/ for test: kms_cursor_crc
results: parsing output: 3/ for test: kms_plane
results: parsing output: 4/ for test: kms_frontbuffer_tracking
results: parsing output: 5/ for test: i915_getparams_basic
results: parsing output: 6/ for test: syncobj_wait
results: parsing output: 7/ for test: gen7_exec_parse
results: parsing output: 8/ for test: syncobj_wait
results: parsing output: 9/ for test: kms_flip
results: parsing output: 10/ for test: kms_psr2_su
results: parsing output: 11/ for test: kms_frontbuffer_tracking
results: parsing output: 12/ for test: gem_ctx_param
results: parsing output: 13/ for test: syncobj_timeline
results: parsing output: 14/ for test: perf_pmu
results: parsing output: 15/ for test: syncobj_basic
results: parsing output: 16/ for test: kms_psr
results: parsing output: 17/ for test: perf
results: parsing output: 18/ for test: kms_frontbuffer_tracking
results: parsing output: 19/ for test: kms_big_fb
results: parsing output: 20/ for test: gem_lmem_swapping
results: parsing output: 21/ for test: kms_big_fb
results: parsing output: 22/ for test: kms_frontbuffer_tracking
results: parsing output: 23/ for test: kms_frontbuffer_tracking
results: parsing output: 24/ for test: kms_big_fb
results: parsing output: 25/ for test: syncobj_wait
results: parsing output: 26/ for test: perf
results: parsing output: 27/ for test: gem_exec_params
results: parsing output: 28/ for test: kms_frontbuffer_tracking
results: parsing output: 29/ for test: kms_big_fb
results: parsing output: 30/ for test: kms_psr
results: parsing output: 31/ for test: kms_psr2_sf
results: parsing output: 32/ for test: gem_softpin
results: parsing output: 33/ for test: kms_chamelium_color
results: parsing output: 34/ for test: gem_bad_reloc
results: parsing output: 35/ for test: perf_pmu
results: parsing output: 36/ for test: kms_addfb_basic
results: parsing output: 37/ for test: gem_pxp
results: parsing output: 38/ for test: gem_fence_thrash
results: parsing output: 39/ for test: gem_exec_flush
results: parsing output: 40/ for test: gem_softpin
results: parsing output: 41/ for test: i915_pm_rpm
results: parsing output: 42/ for test: kms_ccs
results: parsing output: 43/ for test: core_auth
results: parsing output: 44/ for test: api_intel_bb
results: parsing output: 45/ for test: syncobj_timeline
results: parsing output: 46/ for test: gem_exec_balancer
results: parsing output: 47/ for test: gen9_exec_parse
results: parsing output: 48/ for test: prime_self_import
results: parsing output: 49/ for test: kms_big_fb
results: parsing output: 50/ for test: kms_chamelium_hpd
results: parsing output: 51/ for test: kms_frontbuffer_tracking
results: parsing output: 52/ for test: kms_flip
results: parsing output: 53/ for test: gem_softpin
results: parsing output: 54/ for test: kms_psr
results: parsing output: 55/ for test: gem_render_copy
results: parsing output: 56/ for test: gem_mmap_gtt
results: parsing output: 57/ for test: kms_cursor_legacy
results: parsing output: 58/ for test: kms_frontbuffer_tracking
results: parsing output: 59/ for test: i915_suspend
results: parsing output: 60/ for test: gem_exec_schedule
results: parsing output: 61/ for test: gem_mmap_offset
results: parsing output: 62/ for test: gem_ctx_shared
results: parsing output: 63/ for test: kms_color_pipeline
results: parsing output: 64/ for test: syncobj_basic
results: parsing output: 65/ for test: kms_getfb
results: parsing output: 66/ for test: gem_exec_balancer
results: parsing output: 67/ for test: gem_exec_schedule
results: parsing output: 68/ for test: kms_ccs
results: parsing output: 69/ for test: kms_joiner
results: parsing output: 70/ for test: kms_draw_crc
results: parsing output: 71/ for test: gem_ctx_persistence
results: parsing output: 72/ for test: gem_fenced_exec_thrash
results: parsing output: 73/ for test: gem_exec_fence
results: parsing output: 74/ for test: kms_rotation_crc
results: parsing output: 75/ for test: gem_wait
results: parsing output: 76/ for test: kms_cursor_crc
results: parsing output: 77/ for test: kms_frontbuffer_tracking
results: parsing output: 78/ for test: syncobj_timeline
results: parsing output: 79/ for test: kms_frontbuffer_tracking
results: parsing output: 80/ for test: kms_pm_rpm
results: parsing output: 81/ for test: gem_basic
results: parsing output: 82/ for test: dmabuf_sync_file
results: parsing output: 83/ for test: gem_eio
results: parsing output: 84/ for test: kms_vblank
results: parsing output: 85/ for test: kms_cursor_crc
results: parsing output: 86/ for test: gem_exec_params
results: parsing output: 87/ for test: kms_big_fb
results: parsing output: 88/ for test: kms_pm_rpm
results: parsing output: 89/ for test: kms_psr2_sf
results: parsing output: 90/ for test: gem_exec_reloc
results: parsing output: 91/ for test: kms_frontbuffer_tracking
results: parsing output: 92/ for test: syncobj_eventfd
results: parsing output: 93/ for test: kms_rotation_crc
results: parsing output: 94/ for test: kms_psr
results: parsing output: 95/ for test: kms_flip_scaled_crc
results: parsing output: 96/ for test: gem_ctx_persistence
results: parsing output: 97/ for test: gem_ctx_engines
results: parsing output: 98/ for test: gem_lmem_swapping
results: parsing output: 99/ for test: kms_frontbuffer_tracking
results: parsing output: 100/ for test: kms_big_fb
results: parsing output: 101/ for test: gem_pipe_control_store_loop
results: parsing output: 102/ for test: kms_flip
results: parsing output: 103/ for test: kms_flip
results: parsing output: 104/ for test: gem_pxp
results: parsing output: 105/ for test: gem_exec_whisper
results: parsing output: 106/ for test: kms_plane_scaling
results: parsing output: 107/ for test: kms_chamelium_frames
results: parsing output: 108/ for test: kms_async_flips
results: parsing output: 109/ for test: syncobj_timeline
results: parsing output: 110/ for test: kms_frontbuffer_tracking
results: parsing output: 111/ for test: kms_rotation_crc
results: parsing output: 112/ for test: kms_frontbuffer_tracking
results: parsing output: 113/ for test: kms_async_flips
results: parsing output: 114/ for test: kms_flip
results: parsing output: 115/ for test: kms_psr
results: parsing output: 116/ for test: kms_content_protection
results: parsing output: 117/ for test: gem_render_copy
results: parsing output: 118/ for test: kms_ccs
results: parsing output: 119/ for test: kms_lease
results: parsing output: 120/ for test: syncobj_wait
results: parsing output: 121/ for test: kms_plane_multiple
results: parsing output: 122/ for test: kms_frontbuffer_tracking
results: parsing output: 123/ for test: prime_busy
results: parsing output: 124/ for test: kms_sequence
results: parsing output: 125/ for test: kms_frontbuffer_tracking
results: parsing output: 126/ for test: kms_flip
results: parsing output: 127/ for test: gem_eio
results: parsing output: 128/ for test: kms_ccs
results: parsing output: 129/ for test: sysfs_heartbeat_interval
results: parsing output: 130/ for test: syncobj_wait
results: parsing output: 131/ for test: kms_plane
results: parsing output: 132/ for test: gem_exec_parallel
Done.