[57.929810] Initializing watchdogs
[57.929870]   /dev/watchdog0
[57.945057] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:9a49 Intel Tigerlake (Gen12) TigerLake-LP GT2 [Iris Xe Graphics]
[57.950629] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[57.953692] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[57.955537] [001/133] (960s left) api_intel_bb (offset-control)
[57.990864] Starting subtest: offset-control
[57.998046] Subtest offset-control: SUCCESS (0.007s)
[58.140686] [002/133] (960s left) kms_vblank (ts-continuation-modeset)
[58.226331] Starting subtest: ts-continuation-modeset
[58.227054] Starting dynamic subtest: pipe-A-HDMI-A-1
[58.605258] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.381s)
[58.613085] Starting dynamic subtest: pipe-D-HDMI-A-1
[58.887395] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.280s)
[58.888081] Subtest ts-continuation-modeset: SUCCESS (0.666s)
[59.031627] [003/133] (959s left) kms_big_fb (linear-8bpp-rotate-270)
[59.128032] Starting subtest: linear-8bpp-rotate-270
[59.211216] Subtest linear-8bpp-rotate-270: SKIP (0.083s)
[59.334152] [004/133] (959s left) gem_mmap_wc (bad-object)
[59.366778] Starting subtest: bad-object
[59.367501] Subtest bad-object: SUCCESS (0.000s)
[59.486171] [005/133] (959s left) gem_mmap_gtt (isolation)
[59.518193] Starting subtest: isolation
[59.521045] Subtest isolation: SUCCESS (0.002s)
[59.637668] [006/133] (959s left) kms_ccs (crc-sprite-planes-basic-4-tiled-mtl-rc-ccs-cc)
[59.720772] Starting subtest: crc-sprite-planes-basic-4-tiled-mtl-rc-ccs-cc
[59.721443] Starting dynamic subtest: pipe-A-HDMI-A-1
[59.738373] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.002s)
[59.743708] Starting dynamic subtest: pipe-B-HDMI-A-1
[59.760690] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.002s)
[59.765930] Starting dynamic subtest: pipe-C-HDMI-A-1
[59.782729] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.002s)
[59.787935] Starting dynamic subtest: pipe-D-HDMI-A-1
[59.804543] Dynamic subtest pipe-D-HDMI-A-1: SKIP (0.002s)
[59.805880] Subtest crc-sprite-planes-basic-4-tiled-mtl-rc-ccs-cc: SKIP (0.012s)
[60.009663] [007/133] (958s left) kms_frontbuffer_tracking (fbc-2p-primscrn-shrfb-pgflip-blt)
[60.097358] Starting subtest: fbc-2p-primscrn-shrfb-pgflip-blt
[60.098718] Subtest fbc-2p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[60.215740] [008/133] (958s left) kms_big_fb (4-tiled-64bpp-rotate-0)
[60.307957] Starting subtest: 4-tiled-64bpp-rotate-0
[60.309284] Subtest 4-tiled-64bpp-rotate-0: SKIP (0.000s)
[60.422934] [009/133] (958s left) kms_multipipe_modeset (basic-max-pipe-crc-check)
[60.506747] Starting subtest: basic-max-pipe-crc-check
[60.508129] Subtest basic-max-pipe-crc-check: SKIP (0.000s)
[60.561927] [010/133] (958s left) syncobj_timeline (single-wait-all-signaled)
[60.595985] Starting subtest: single-wait-all-signaled
[60.596961] Subtest single-wait-all-signaled: SUCCESS (0.001s)
[60.705722] [011/133] (958s left) kms_vrr (flip-suspend)
[60.788445] Starting subtest: flip-suspend
[60.790460] Subtest flip-suspend: SKIP (0.000s)
[60.891077] [012/133] (957s left) kms_cursor_legacy (forked-bo)
[60.975050] Starting subtest: forked-bo
[60.975797] Starting dynamic subtest: pipe-A
[66.410732] Dynamic subtest pipe-A: SUCCESS (5.421s)
[66.417441] Starting dynamic subtest: pipe-B
[71.833309] Dynamic subtest pipe-B: SUCCESS (5.432s)
[71.839681] Starting dynamic subtest: pipe-C
[77.268989] Dynamic subtest pipe-C: SUCCESS (5.438s)
[77.279971] Starting dynamic subtest: pipe-D
[82.696955] Dynamic subtest pipe-D: SUCCESS (5.430s)
[82.706328] Starting dynamic subtest: all-pipes
[88.132931] Dynamic subtest all-pipes: SUCCESS (5.436s)
[88.133817] Subtest forked-bo: SUCCESS (27.160s)
[88.200343] [013/133] (930s left) kms_frontbuffer_tracking (psr-1p-primscrn-indfb-pgflip-blt)
[88.290349] Starting subtest: psr-1p-primscrn-indfb-pgflip-blt
[88.291706] Subtest psr-1p-primscrn-indfb-pgflip-blt: SKIP (0.000s)
[88.408173] [014/133] (930s left) kms_atomic (atomic-invalid-params)
[88.490728] Starting subtest: atomic-invalid-params
[88.492824] Starting dynamic subtest: pipe-A-HDMI-A-1
[88.712540] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.221s)
[88.713222] Subtest atomic-invalid-params: SUCCESS (0.222s)
[88.866354] [015/133] (930s left) kms_cursor_crc (cursor-rapid-movement-256x256)
[88.955929] Starting subtest: cursor-rapid-movement-256x256
[88.960534] Starting dynamic subtest: pipe-A-HDMI-A-1
[89.364642] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.404s)
[89.391176] Starting dynamic subtest: pipe-D-HDMI-A-1
[89.706516] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.320s)
[89.707223] Subtest cursor-rapid-movement-256x256: SUCCESS (0.751s)
[89.859497] [016/133] (929s left) kms_properties (crtc-properties-atomic)
[89.944597] Starting subtest: crtc-properties-atomic
[89.945312] Starting dynamic subtest: pipe-A-HDMI-A-1
[90.180126] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.235s)
[90.186275] Starting dynamic subtest: pipe-B-HDMI-A-1
[90.430458] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.249s)
[90.436680] Starting dynamic subtest: pipe-C-HDMI-A-1
[90.681804] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.250s)
[90.687167] Starting dynamic subtest: pipe-D-HDMI-A-1
[90.932334] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.250s)
[90.933046] Subtest crtc-properties-atomic: SUCCESS (0.988s)
[91.084462] [017/133] (927s left) kms_psr (pr-cursor-blt)
[91.173489] Subtest pr-cursor-blt: SKIP (0.000s)
[91.221572] [018/133] (927s left) gem_exec_params (cliprects_ptr-dirt)
[91.259644] Starting subtest: cliprects_ptr-dirt
[91.260341] Subtest cliprects_ptr-dirt: SUCCESS (0.000s)
[91.388791] [019/133] (927s left) kms_psr (psr2-primary-mmap-cpu)
[91.473312] Subtest psr2-primary-mmap-cpu: SKIP (0.000s)
[91.523555] [020/133] (927s left) gem_ctx_persistence (engines-hostile-preempt)
[91.560345] Starting subtest: engines-hostile-preempt
[91.561051] Starting dynamic subtest: rcs0
[91.659824] Dynamic subtest rcs0: SUCCESS (0.099s)
[91.671541] Starting dynamic subtest: bcs0
[91.757365] Dynamic subtest bcs0: SUCCESS (0.097s)
[91.768773] Starting dynamic subtest: vcs0
[91.846418] Dynamic subtest vcs0: SUCCESS (0.089s)
[91.858360] Starting dynamic subtest: vcs1
[91.939426] Dynamic subtest vcs1: SUCCESS (0.093s)
[91.947381] Starting dynamic subtest: vecs0
[92.030470] Dynamic subtest vecs0: SUCCESS (0.090s)
[92.031494] Subtest engines-hostile-preempt: SUCCESS (0.470s)
[92.128293] [021/133] (927s left) kms_pm_backlight (fade)
[92.213160] Subtest fade: SKIP (0.000s)
[92.264417] [022/133] (926s left) syncobj_timeline (etime-multi-wait-all-for-submit-submitted)
[92.298497] Starting subtest: etime-multi-wait-all-for-submit-submitted
[92.407449] Subtest etime-multi-wait-all-for-submit-submitted: SUCCESS (0.107s)
[92.508428] [023/133] (926s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc)
[92.595603] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc
[92.597008] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[92.716807] [024/133] (926s left) kms_flip (2x-flip-vs-absolute-wf_vblank-interruptible)
[92.804443] Starting subtest: 2x-flip-vs-absolute-wf_vblank-interruptible
[92.815021] Subtest 2x-flip-vs-absolute-wf_vblank-interruptible: SKIP (0.009s)
[92.925382] [025/133] (926s left) i915_drm_fdinfo (busy-idle)
[92.961039] Starting subtest: busy-idle
[92.961731] Starting dynamic subtest: rcs0
[93.585183] Dynamic subtest rcs0: SUCCESS (0.624s)
[93.593356] Starting dynamic subtest: bcs0
[94.207892] Dynamic subtest bcs0: SUCCESS (0.622s)
[94.215879] Starting dynamic subtest: vcs0
[94.836217] Dynamic subtest vcs0: SUCCESS (0.628s)
[94.844526] Starting dynamic subtest: vcs1
[95.460308] Dynamic subtest vcs1: SUCCESS (0.624s)
[95.468310] Starting dynamic subtest: vecs0
[96.081778] Dynamic subtest vecs0: SUCCESS (0.617s)
[96.082472] Subtest busy-idle: SUCCESS (3.116s)
[96.177711] [026/133] (923s left) perf_pmu (all-busy-check-all)
[96.214222] Starting subtest: all-busy-check-all
[96.730314] Subtest all-busy-check-all: SUCCESS (0.516s)
[96.833937] [027/133] (922s left) kms_ccs (bad-rotation-90-4-tiled-dg2-rc-ccs)
[96.920144] Starting subtest: bad-rotation-90-4-tiled-dg2-rc-ccs
[96.920858] Starting dynamic subtest: pipe-A-HDMI-A-1
[96.927262] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.000s)
[96.933125] Starting dynamic subtest: pipe-B-HDMI-A-1
[96.939463] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.000s)
[96.945207] Starting dynamic subtest: pipe-C-HDMI-A-1
[96.951797] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.000s)
[96.957544] Starting dynamic subtest: pipe-D-HDMI-A-1
[96.964165] Dynamic subtest pipe-D-HDMI-A-1: SKIP (0.000s)
[96.965452] Subtest bad-rotation-90-4-tiled-dg2-rc-ccs: SKIP (0.004s)
[97.148643] [028/133] (922s left) fbdev (eof)
[97.201991] Starting subtest: eof
[97.202849] Subtest eof: SUCCESS (0.000s)
[97.301547] [029/133] (922s left) kms_plane (pixel-format-yf-tiled-modifier)
[97.384684] Starting subtest: pixel-format-yf-tiled-modifier
[97.386026] Subtest pixel-format-yf-tiled-modifier: SKIP (0.000s)
[97.470130] [030/133] (922s left) kms_chamelium_hpd (hdmi-hpd)
[97.607413] Subtest hdmi-hpd: SKIP (0.000s)
[97.684642] [031/133] (921s left) gem_ctx_param (non-root-set)
[97.718279] Starting subtest: non-root-set
[97.731194] Subtest non-root-set: SUCCESS (0.013s)
[97.836010] [032/133] (921s left) gem_exec_reloc (basic-cpu-wc-active)
[97.873287] Starting subtest: basic-cpu-wc-active
[98.001747] Subtest basic-cpu-wc-active: SUCCESS (0.120s)
[98.138019] [033/133] (921s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-mmap-wc)
[98.225401] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-mmap-wc
[100.145160] Subtest fbc-1p-offscreen-pri-shrfb-draw-mmap-wc: SUCCESS (1.920s)
[100.301879] [034/133] (919s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-32bpp-ytileccs-downscaling)
[100.389341] Starting subtest: flip-32bpp-ytile-to-32bpp-ytileccs-downscaling
[100.390698] Subtest flip-32bpp-ytile-to-32bpp-ytileccs-downscaling: SKIP (0.000s)
[100.491344] [035/133] (919s left) kms_psr (fbc-psr2-dpms)
[100.575975] Subtest fbc-psr2-dpms: SKIP (0.000s)
[100.628977] [036/133] (919s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180-async-flip)
[100.722809] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180-async-flip
[100.724175] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SKIP (0.000s)
[100.852757] [037/133] (919s left) kms_frontbuffer_tracking (psr-2p-scndscrn-indfb-plflip-blt)
[100.940438] Starting subtest: psr-2p-scndscrn-indfb-plflip-blt
[100.941802] Subtest psr-2p-scndscrn-indfb-plflip-blt: SKIP (0.000s)
[101.060107] [038/133] (918s left) kms_flip (flip-vs-panning-interruptible)
[101.148920] Starting subtest: flip-vs-panning-interruptible
[101.151557] Starting dynamic subtest: A-HDMI-A1
[108.847749] Dynamic subtest A-HDMI-A1: SUCCESS (7.696s)
[108.861812] Starting dynamic subtest: B-HDMI-A1
[116.507728] Dynamic subtest B-HDMI-A1: SUCCESS (7.658s)
[116.521575] Starting dynamic subtest: C-HDMI-A1
[124.169978] Dynamic subtest C-HDMI-A1: SUCCESS (7.660s)
[124.177898] Starting dynamic subtest: D-HDMI-A1
[131.831242] Dynamic subtest D-HDMI-A1: SUCCESS (7.661s)
[131.835581] Subtest flip-vs-panning-interruptible: SUCCESS (30.687s)
[132.014628] [039/133] (887s left) perf_pmu (init-busy)
[132.055772] Starting subtest: init-busy
[132.056471] Starting dynamic subtest: rcs0
[132.057196] Dynamic subtest rcs0: SUCCESS (0.001s)
[132.063479] Starting dynamic subtest: bcs0
[132.064236] Dynamic subtest bcs0: SUCCESS (0.000s)
[132.070262] Starting dynamic subtest: vcs0
[132.070950] Dynamic subtest vcs0: SUCCESS (0.000s)
[132.076699] Starting dynamic subtest: vcs1
[132.077381] Dynamic subtest vcs1: SUCCESS (0.000s)
[132.083383] Starting dynamic subtest: vecs0
[132.084113] Dynamic subtest vecs0: SUCCESS (0.000s)
[132.084792] Subtest init-busy: SUCCESS (0.006s)
[132.185950] [040/133] (887s left) syncobj_timeline (multi-wait-for-submit-unsubmitted-submitted-signaled)
[132.221048] Starting subtest: multi-wait-for-submit-unsubmitted-submitted-signaled
[132.221751] Subtest multi-wait-for-submit-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[132.317626] [041/133] (887s left) kms_content_protection (atomic-dpms)
[132.407394] Starting subtest: atomic-dpms
[132.419040] Subtest atomic-dpms: SKIP (0.003s)
[132.526757] [042/133] (887s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-shrfb-msflip-blt)
[132.613371] Starting subtest: fbcpsr-2p-primscrn-shrfb-msflip-blt
[132.614712] Subtest fbcpsr-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[132.735756] [043/133] (887s left) gem_exec_balancer (individual)
[132.776520] Starting subtest: individual
[134.314615] Subtest individual: SUCCESS (1.529s)
[134.519401] [044/133] (885s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-render)
[134.609337] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-render
[137.035999] Subtest fbc-1p-primscrn-pri-shrfb-draw-render: SUCCESS (2.426s)
[137.213974] [045/133] (882s left) kms_lease (page-flip-implicit-plane)
[137.299722] Starting subtest: page-flip-implicit-plane
[137.300402] Starting dynamic subtest: pipe-A-HDMI-A-1
[137.651612] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.350s)
[137.658313] Starting dynamic subtest: pipe-B-HDMI-A-1
[137.883273] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.230s)
[137.889419] Starting dynamic subtest: pipe-C-HDMI-A-1
[138.118153] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.234s)
[138.125996] Starting dynamic subtest: pipe-D-HDMI-A-1
[138.362980] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.244s)
[138.363749] Subtest page-flip-implicit-plane: SUCCESS (1.064s)
[138.491361] [046/133] (881s left) gem_ctx_exec (basic-invalid-context)
[138.526408] Starting subtest: basic-invalid-context
[138.528478] Subtest basic-invalid-context: SUCCESS (0.002s)
[138.662947] [047/133] (881s left) gem_busy (close-race)
[138.704790] Starting subtest: close-race
[160.799473] Subtest close-race: SUCCESS (22.094s)
[161.193123] [FACT gem_busy (close-race)] new: kernel.kmod_is_loaded.vgem: true
[161.196747] [048/133] (859s left) gem_pxp (verify-pxp-stale-buf-optout-execution)
[161.362863] Starting subtest: verify-pxp-stale-buf-optout-execution
[162.427691] Subtest verify-pxp-stale-buf-optout-execution: SUCCESS (1.065s)
[162.549798] [049/133] (857s left) gem_ctx_persistence (heartbeat-hostile)
[162.587892] Starting subtest: heartbeat-hostile
[164.103460] Subtest heartbeat-hostile: SUCCESS (1.515s)
[164.200823] [050/133] (856s left) perf (disabled-read-error)
[164.345960] Starting subtest: disabled-read-error
[164.361170] Subtest disabled-read-error: SUCCESS (0.015s)
[164.399240] [051/133] (856s left) kms_big_fb (yf-tiled-32bpp-rotate-270)
[164.502881] Starting subtest: yf-tiled-32bpp-rotate-270
[164.504352] Subtest yf-tiled-32bpp-rotate-270: SKIP (0.000s)
[164.622551] [052/133] (855s left) kms_psr (psr-sprite-mmap-gtt)
[164.707675] Subtest psr-sprite-mmap-gtt: SKIP (0.000s)
[164.758493] [053/133] (855s left) kms_big_fb (x-tiled-16bpp-rotate-270)
[164.851014] Starting subtest: x-tiled-16bpp-rotate-270
[164.954933] Subtest x-tiled-16bpp-rotate-270: SKIP (0.103s)
[165.097783] [054/133] (855s left) gem_lmem_swapping (parallel-random-engines)
[165.135410] Subtest parallel-random-engines: SKIP (0.000s)
[165.173857] [055/133] (855s left) syncobj_wait (wait-all-for-submit-complex)
[165.207884] Starting subtest: wait-all-for-submit-complex
[165.433266] Subtest wait-all-for-submit-complex: SUCCESS (0.216s)
[165.534721] [056/133] (855s left) kms_atomic_transition (plane-all-modeset-transition-fencing-internal-panels)
[165.619026] Starting subtest: plane-all-modeset-transition-fencing-internal-panels
[165.620435] Subtest plane-all-modeset-transition-fencing-internal-panels: SKIP (0.000s)
[165.726063] [057/133] (854s left) syncobj_basic (bad-destroy)
[165.759700] Starting subtest: bad-destroy
[165.760393] Subtest bad-destroy: SUCCESS (0.000s)
[165.875117] [058/133] (854s left) gem_exec_params (secure-non-root)
[165.911473] Starting subtest: secure-non-root
[165.912851] Subtest secure-non-root: SKIP (0.000s)
[166.045051] [059/133] (854s left) kms_async_flips (alternate-sync-async-flip-atomic)
[166.132712] Starting subtest: alternate-sync-async-flip-atomic
[166.336147] Starting dynamic subtest: pipe-A-HDMI-A-1
[168.433597] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (2.088s)
[168.610592] Starting dynamic subtest: pipe-B-HDMI-A-1
[170.675127] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (2.062s)
[170.824687] Starting dynamic subtest: pipe-C-HDMI-A-1
[172.899332] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (2.072s)
[173.069882] Starting dynamic subtest: pipe-D-HDMI-A-1
[175.147102] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (2.075s)
[175.147895] Subtest alternate-sync-async-flip-atomic: SUCCESS (9.008s)
[175.474175] [060/133] (845s left) kms_ccs (crc-primary-suspend-4-tiled-lnl-ccs)
[175.563842] Starting subtest: crc-primary-suspend-4-tiled-lnl-ccs
[175.565272] Subtest crc-primary-suspend-4-tiled-lnl-ccs: SKIP (0.000s)
[175.732925] [061/133] (845s left) api_intel_bb (blit-noreloc-purge-cache)
[175.767420] Starting subtest: blit-noreloc-purge-cache
[175.774104] Subtest blit-noreloc-purge-cache: SUCCESS (0.007s)
[175.921512] [062/133] (844s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-mmap-cpu)
[176.009042] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-mmap-cpu
[178.417812] Subtest fbc-1p-primscrn-cur-indfb-draw-mmap-cpu: SUCCESS (2.409s)
[178.579574] [063/133] (842s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-onoff)
[178.670768] Starting subtest: fbc-1p-primscrn-spr-indfb-onoff
[181.567370] Subtest fbc-1p-primscrn-spr-indfb-onoff: SUCCESS (2.897s)
[181.767148] [064/133] (839s left) gem_spin_batch (resubmit-all)
[181.809198] Starting subtest: resubmit-all
[181.809926] Starting dynamic subtest: rcs0
[181.814787] Dynamic subtest rcs0: SUCCESS (0.005s)
[181.824088] Starting dynamic subtest: bcs0
[181.824809] Dynamic subtest bcs0: SUCCESS (0.003s)
[181.832306] Starting dynamic subtest: vcs0
[181.833013] Dynamic subtest vcs0: SUCCESS (0.002s)
[181.839923] Starting dynamic subtest: vcs1
[181.840640] Dynamic subtest vcs1: SUCCESS (0.003s)
[181.847125] Starting dynamic subtest: vecs0
[181.847836] Dynamic subtest vecs0: SUCCESS (0.002s)
[181.848522] Subtest resubmit-all: SUCCESS (0.019s)
[182.051544] [065/133] (838s left) perf (oa-exponents)
[182.166692] Starting subtest: oa-exponents
[182.167507] Starting dynamic subtest: 0-rcs0
[185.611753] Dynamic subtest 0-rcs0: SUCCESS (3.436s)
[185.612531] Subtest oa-exponents: SUCCESS (3.437s)
[185.649615] [066/133] (835s left) kms_big_fb (y-tiled-32bpp-rotate-0)
[185.758970] Starting subtest: y-tiled-32bpp-rotate-0
[187.620221] Subtest y-tiled-32bpp-rotate-0: SUCCESS (1.861s)
[187.804331] [067/133] (833s left) kms_color (ctm-red-to-blue)
[187.891439] Starting subtest: ctm-red-to-blue
[187.892202] Starting dynamic subtest: pipe-A-HDMI-A-1
[188.466675] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.575s)
[188.474329] Starting dynamic subtest: pipe-B-HDMI-A-1
[188.921855] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.455s)
[188.930814] Starting dynamic subtest: pipe-C-HDMI-A-1
[189.406914] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.484s)
[189.413944] Starting dynamic subtest: pipe-D-HDMI-A-1
[189.878627] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.470s)
[189.879333] Subtest ctm-red-to-blue: SUCCESS (1.988s)
[190.031814] [068/133] (831s left) syncobj_wait (wait-all-for-submit-snapshot)
[190.067488] Starting subtest: wait-all-for-submit-snapshot
[190.149777] Subtest wait-all-for-submit-snapshot: SUCCESS (0.082s)
[190.261695] [069/133] (830s left) gem_render_copy (y-tiled-mc-ccs-to-yf-tiled-ccs)
[190.300345] Starting subtest: y-tiled-mc-ccs-to-yf-tiled-ccs
[190.301076] Starting dynamic subtest: smem
[190.381050] Dynamic subtest smem: SUCCESS (0.080s)
[190.381815] Subtest y-tiled-mc-ccs-to-yf-tiled-ccs: SUCCESS (0.081s)
[190.623096] [070/133] (830s left) i915_selftest (live)
[191.520915] Starting subtest: live
[191.521840] Starting dynamic subtest: sanitycheck
[192.769461] Dynamic subtest sanitycheck: SUCCESS (1.239s)
[192.778919] Starting dynamic subtest: uncore
[193.968308] Dynamic subtest uncore: SUCCESS (1.197s)
[193.977784] Starting dynamic subtest: workarounds
[195.498467] Dynamic subtest workarounds: SUCCESS (1.528s)
[195.511820] Starting dynamic subtest: gt_engines
[197.263534] Dynamic subtest gt_engines: SUCCESS (1.763s)
[197.272370] Starting dynamic subtest: gt_timelines
[206.571318] Dynamic subtest gt_timelines: SUCCESS (9.306s)
[206.577926] Starting dynamic subtest: gt_contexts
[207.885671] Dynamic subtest gt_contexts: SUCCESS (1.312s)
[207.894961] Starting dynamic subtest: gt_lrc
[212.000559] Dynamic subtest gt_lrc: SUCCESS (4.113s)
[212.007333] Starting dynamic subtest: gt_mocs
[213.322558] Dynamic subtest gt_mocs: SUCCESS (1.320s)
[213.329070] Starting dynamic subtest: gt_pm
[234.593491] Dynamic subtest gt_pm: SUCCESS (21.269s)
[234.604324] Starting dynamic subtest: gt_heartbeat
[235.814338] Dynamic subtest gt_heartbeat: SUCCESS (1.219s)
[235.824775] Starting dynamic subtest: gt_tlb
[239.240632] Dynamic subtest gt_tlb: SUCCESS (3.424s)
[239.247720] Starting dynamic subtest: requests
[247.810490] Dynamic subtest requests: SUCCESS (8.568s)
[247.816664] Starting dynamic subtest: migrate
[252.034208] Dynamic subtest migrate: SUCCESS (4.230s)
[252.050929] Starting dynamic subtest: active
[253.249516] Dynamic subtest active: SUCCESS (1.205s)
[253.263242] Starting dynamic subtest: objects
[254.951391] Dynamic subtest objects: SUCCESS (1.700s)
[254.958456] Starting dynamic subtest: mman
[259.632321] Dynamic subtest mman: SUCCESS (4.679s)
[259.638587] Starting dynamic subtest: dmabuf
[260.848560] Dynamic subtest dmabuf: SUCCESS (1.214s)
[260.855112] Starting dynamic subtest: vma
[262.047710] Dynamic subtest vma: SUCCESS (1.197s)
[262.061219] Starting dynamic subtest: coherency
[264.878367] Dynamic subtest coherency: SUCCESS (2.829s)
[264.887884] Starting dynamic subtest: gtt
[273.208388] Dynamic subtest gtt: SUCCESS (8.328s)
[273.217301] Starting dynamic subtest: gem
[275.420522] Dynamic subtest gem: SUCCESS (2.210s)
[275.429722] Starting dynamic subtest: evict
[277.624635] Dynamic subtest evict: SUCCESS (2.202s)
[277.631017] Starting dynamic subtest: hugepages
[285.314674] Dynamic subtest hugepages: SUCCESS (7.688s)
[285.321383] Starting dynamic subtest: gem_contexts
[300.777474] Dynamic subtest gem_contexts: SUCCESS (15.461s)
[300.788336] Starting dynamic subtest: client
[302.012787] Dynamic subtest client: SUCCESS (1.233s)
[302.022498] Starting dynamic subtest: gem_migrate
[303.191637] Dynamic subtest gem_migrate: SUCCESS (1.177s)
[303.198697] Starting dynamic subtest: reset
[308.100478] Dynamic subtest reset: SUCCESS (4.907s)
[308.107218] Starting dynamic subtest: memory_region
[309.284618] Dynamic subtest memory_region: SUCCESS (1.182s)
[309.294140] Starting dynamic subtest: hangcheck
[339.188537] Dynamic subtest hangcheck: SUCCESS (29.902s)
[339.198191] Starting dynamic subtest: execlists
[352.820552] Dynamic subtest execlists: SUCCESS (13.630s)
[352.829518] Starting dynamic subtest: ring_submission
[354.005731] Dynamic subtest ring_submission: SUCCESS (1.183s)
[354.015257] Starting dynamic subtest: perf
[355.270634] Dynamic subtest perf: SUCCESS (1.263s)
[355.280281] Starting dynamic subtest: slpc
[356.428508] Dynamic subtest slpc: SUCCESS (1.156s)
[356.438217] Starting dynamic subtest: guc
[357.606538] Dynamic subtest guc: SUCCESS (1.176s)
[357.616236] Starting dynamic subtest: guc_multi_lrc
[358.778658] Dynamic subtest guc_multi_lrc: SUCCESS (1.170s)
[358.786015] Starting dynamic subtest: guc_hang
[359.948488] Dynamic subtest guc_hang: SUCCESS (1.168s)
[359.958038] Starting dynamic subtest: late_gt_pm
[361.175452] Dynamic subtest late_gt_pm: SUCCESS (1.225s)
[361.176367] Subtest live: SUCCESS (169.647s)
[361.205182] [FACT i915_selftest (live)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[361.205953] [FACT i915_selftest (live)] deleted: kernel.kmod_is_loaded.i915: true
[361.209794] [071/133] (660s left) gem_exec_schedule (submit-golden-slice)
[362.362368] Starting subtest: submit-golden-slice
[362.364533] Starting dynamic subtest: rcs0
[362.398157] Dynamic subtest rcs0: SUCCESS (0.037s)
[362.407491] Starting dynamic subtest: bcs0
[362.430152] Dynamic subtest bcs0: SUCCESS (0.031s)
[362.439528] Starting dynamic subtest: vcs0
[362.461184] Dynamic subtest vcs0: SUCCESS (0.029s)
[362.471309] Starting dynamic subtest: vcs1
[362.493246] Dynamic subtest vcs1: SUCCESS (0.030s)
[362.501838] Starting dynamic subtest: vecs0
[362.523293] Dynamic subtest vecs0: SUCCESS (0.029s)
[362.524087] Subtest submit-golden-slice: SUCCESS (0.163s)
[362.845467] [FACT gem_exec_schedule (submit-golden-slice)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[362.846780] [FACT gem_exec_schedule (submit-golden-slice)] new: kernel.kmod_is_loaded.i915: true
[362.851973] [072/133] (658s left) kms_psr (fbc-psr-cursor-plane-onoff)
[362.941914] Subtest fbc-psr-cursor-plane-onoff: SKIP (0.000s)
[362.988644] [073/133] (658s left) gem_exec_balancer (persistence)
[363.152384] Starting subtest: persistence
[364.471019] Subtest persistence: SUCCESS (1.311s)
[364.553076] [074/133] (656s left) gem_lmem_swapping (random-engines)
[364.591844] Subtest random-engines: SKIP (0.000s)
[364.639281] [075/133] (656s left) kms_cursor_crc (cursor-sliding-64x21)
[364.745326] Starting subtest: cursor-sliding-64x21
[364.759372] Starting dynamic subtest: pipe-A-HDMI-A-1
[367.157016] Dynamic subtest pipe-A-HDMI-A-1: FAIL (2.229s)
[367.163862] Starting dynamic subtest: pipe-D-HDMI-A-1
[371.139669] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (4.118s)
[371.140353] Subtest cursor-sliding-64x21: FAIL (6.394s)
[371.336931] [076/133] (650s left) sysfs_heartbeat_interval (precise)
[371.376677] Starting subtest: precise
[371.379136] Starting dynamic subtest: vecs0
[372.894545] Dynamic subtest vecs0: SUCCESS (1.517s)
[372.904145] Starting dynamic subtest: vcs0
[374.391629] Dynamic subtest vcs0: SUCCESS (1.495s)
[374.403805] Starting dynamic subtest: bcs0
[375.887353] Dynamic subtest bcs0: SUCCESS (1.494s)
[375.898087] Starting dynamic subtest: rcs0
[377.383736] Dynamic subtest rcs0: SUCCESS (1.494s)
[377.394261] Starting dynamic subtest: vcs1
[378.921469] Dynamic subtest vcs1: SUCCESS (1.535s)
[378.922417] Subtest precise: SUCCESS (7.546s)
[379.012943] [077/133] (642s left) kms_cursor_legacy (2x-long-flip-vs-cursor-atomic)
[379.103906] Starting subtest: 2x-long-flip-vs-cursor-atomic
[379.105985] Subtest 2x-long-flip-vs-cursor-atomic: SKIP (0.002s)
[379.212314] [078/133] (642s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-180-hflip)
[379.306281] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-180-hflip
[380.659818] Subtest y-tiled-max-hw-stride-32bpp-rotate-180-hflip: SUCCESS (1.353s)
[380.823764] [079/133] (640s left) gem_tiled_fence_blits (basic)
[381.032841] Starting subtest: basic
[381.058573] Subtest basic: SUCCESS (0.026s)
[381.216504] [080/133] (640s left) gem_exec_schedule (pi-shared-iova)
[381.433835] Starting subtest: pi-shared-iova
[381.434739] Starting dynamic subtest: rcs0
[381.458629] Dynamic subtest rcs0: SUCCESS (0.026s)
[381.466394] Starting dynamic subtest: bcs0
[381.481435] Dynamic subtest bcs0: SUCCESS (0.022s)
[381.491891] Starting dynamic subtest: vcs0
[381.503373] Dynamic subtest vcs0: SUCCESS (0.021s)
[381.513664] Starting dynamic subtest: vcs1
[381.524352] Dynamic subtest vcs1: SUCCESS (0.020s)
[381.533889] Starting dynamic subtest: vecs0
[381.546938] Dynamic subtest vecs0: SUCCESS (0.020s)
[381.547732] Subtest pi-shared-iova: SUCCESS (0.115s)
[381.751906] [081/133] (639s left) kms_cursor_legacy (flip-vs-cursor-atomic-transitions)
[381.844858] Starting subtest: flip-vs-cursor-atomic-transitions
[392.201585] Subtest flip-vs-cursor-atomic-transitions: SUCCESS (10.357s)
[392.358754] [082/133] (629s left) kms_frontbuffer_tracking (psr-rgb101010-draw-mmap-cpu)
[392.453750] Starting subtest: psr-rgb101010-draw-mmap-cpu
[392.455089] Subtest psr-rgb101010-draw-mmap-cpu: SKIP (0.000s)
[392.567570] [083/133] (629s left) i915_module_load (reload)
[392.599095] Starting subtest: reload
[394.458662] Subtest reload: SUCCESS (1.860s)
[394.494152] [084/133] (627s left) gem_exec_reloc (basic-gtt-cpu-noreloc)
[394.536731] Starting subtest: basic-gtt-cpu-noreloc
[394.540998] Subtest basic-gtt-cpu-noreloc: SUCCESS (0.004s)
[394.695267] [085/133] (627s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-mmap-wc)
[394.783862] Starting subtest: psr-1p-primscrn-spr-indfb-draw-mmap-wc
[394.785283] Subtest psr-1p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[394.923953] [086/133] (626s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-mmap-gtt)
[395.013880] Starting subtest: psr-2p-primscrn-spr-indfb-draw-mmap-gtt
[395.015304] Subtest psr-2p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[395.133376] [087/133] (626s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-pwrite)
[395.224390] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-pwrite
[395.225834] Subtest fbc-2p-scndscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[395.341760] [088/133] (626s left) drm_read (short-buffer-wakeup)
[395.467598] Starting subtest: short-buffer-wakeup
[427.689604] Subtest short-buffer-wakeup: SUCCESS (32.214s)
[427.842291] [089/133] (594s left) kms_draw_crc (draw-method-mmap-gtt)
[427.932774] Starting subtest: draw-method-mmap-gtt
[427.933460] Starting dynamic subtest: xrgb8888-untiled
[428.232401] Dynamic subtest xrgb8888-untiled: SUCCESS (0.300s)
[428.249214] Starting dynamic subtest: rgb565-untiled
[428.535952] Dynamic subtest rgb565-untiled: SUCCESS (0.301s)
[428.552642] Starting dynamic subtest: xrgb2101010-untiled
[428.820471] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.282s)
[428.836510] Starting dynamic subtest: xbgr16161616f-untiled
[429.123827] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.301s)
[429.134255] Starting dynamic subtest: xrgb8888-xtiled
[429.275934] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.150s)
[429.292747] Starting dynamic subtest: rgb565-xtiled
[429.427763] Dynamic subtest rgb565-xtiled: SUCCESS (0.149s)
[429.444635] Starting dynamic subtest: xrgb2101010-xtiled
[429.579204] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.149s)
[429.589776] Starting dynamic subtest: xbgr16161616f-xtiled
[429.712171] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.131s)
[429.728230] Starting dynamic subtest: xrgb8888-ytiled
[429.882966] Dynamic subtest xrgb8888-ytiled: SUCCESS (0.169s)
[429.899051] Starting dynamic subtest: rgb565-ytiled
[430.053604] Dynamic subtest rgb565-ytiled: SUCCESS (0.168s)
[430.064870] Starting dynamic subtest: xrgb2101010-ytiled
[430.186636] Dynamic subtest xrgb2101010-ytiled: SUCCESS (0.131s)
[430.222928] Starting dynamic subtest: xbgr16161616f-ytiled
[430.357464] Dynamic subtest xbgr16161616f-ytiled: SUCCESS (0.169s)
[430.358433] Subtest draw-method-mmap-gtt: SUCCESS (2.426s)
[430.481810] [090/133] (591s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-mmap-cpu)
[430.574828] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-mmap-cpu
[433.013624] Subtest fbc-1p-primscrn-spr-indfb-draw-mmap-cpu: SUCCESS (2.439s)
[433.189936] [091/133] (588s left) syncobj_timeline (host-signal-points)
[433.225724] Starting subtest: host-signal-points
[433.231871] Subtest host-signal-points: SUCCESS (0.007s)
[433.319971] [092/133] (588s left) kms_plane_scaling (plane-scaler-unity-scaling-with-pixel-format)
[433.406966] Starting subtest: plane-scaler-unity-scaling-with-pixel-format
[433.407723] Starting dynamic subtest: pipe-A
[435.935669] Dynamic subtest pipe-A: SUCCESS (2.528s)
[435.957627] Starting dynamic subtest: pipe-B
[438.487192] Dynamic subtest pipe-B: SUCCESS (2.549s)
[438.500695] Starting dynamic subtest: pipe-C
[438.839402] Dynamic subtest pipe-C: SUCCESS (0.348s)
[438.852333] Starting dynamic subtest: pipe-D
[439.185604] Dynamic subtest pipe-D: SUCCESS (0.346s)
[439.188359] Subtest plane-scaler-unity-scaling-with-pixel-format: SUCCESS (5.780s)
[439.374532] [093/133] (582s left) gem_ctx_sseu (invalid-args)
[439.413283] Subtest invalid-args: SKIP (0.000s)
[439.472210] [094/133] (582s left) kms_frontbuffer_tracking (pipe-fbc-rte)
[439.562791] Starting subtest: pipe-fbc-rte
[439.566757] Subtest pipe-fbc-rte: SKIP (0.000s)
[439.677358] [095/133] (582s left) kms_flip (2x-flip-vs-suspend-interruptible)
[439.767305] Starting subtest: 2x-flip-vs-suspend-interruptible
[439.776759] Subtest 2x-flip-vs-suspend-interruptible: SKIP (0.009s)
[439.886174] [096/133] (582s left) gem_exec_gttfill (basic)
[439.929291] Starting subtest: basic
[443.394392] Subtest basic: SUCCESS (3.465s)
[443.608999] [097/133] (578s left) gem_madvise (dontneed-before-exec)
[443.693111] Starting subtest: dontneed-before-exec
[443.696904] Subtest dontneed-before-exec: SUCCESS (0.003s)
[443.833885] [098/133] (578s left) gem_partial_pwrite_pread (reads-uncached)
[443.873750] Starting subtest: reads-uncached
[445.699345] Subtest reads-uncached: SUCCESS (1.826s)
[445.882360] [099/133] (576s left) gem_mmap_gtt (basic-write-gtt)
[445.916469] Starting subtest: basic-write-gtt
[446.053813] Subtest basic-write-gtt: SUCCESS (0.129s)
[446.167585] [100/133] (576s left) kms_frontbuffer_tracking (fbc-1p-primscrn-shrfb-pgflip-blt)
[446.262778] Starting subtest: fbc-1p-primscrn-shrfb-pgflip-blt
[448.717572] Subtest fbc-1p-primscrn-shrfb-pgflip-blt: SUCCESS (2.454s)
[448.916783] [101/133] (573s left) sw_sync (timeline_closed_signaled)
[448.957327] Starting subtest: timeline_closed_signaled
[448.958111] Subtest timeline_closed_signaled: SUCCESS (0.000s)
[449.023995] [102/133] (573s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-pwrite)
[449.116530] Starting subtest: fbcpsr-rgb565-draw-pwrite
[449.117912] Subtest fbcpsr-rgb565-draw-pwrite: SKIP (0.000s)
[449.240659] [103/133] (573s left) kms_cursor_crc (cursor-onscreen-max-size)
[449.336141] Starting subtest: cursor-onscreen-max-size
[449.338139] Subtest cursor-onscreen-max-size: SKIP (0.000s)
[449.448111] [104/133] (573s left) syncobj_wait (multi-wait-for-submit-submitted)
[449.482582] Starting subtest: multi-wait-for-submit-submitted
[449.599853] Subtest multi-wait-for-submit-submitted: SUCCESS (0.108s)
[449.690751] [105/133] (573s left) gem_exec_await (wide-contexts)
[449.765075] Starting subtest: wide-contexts
[471.456301] Subtest wide-contexts: SUCCESS (21.691s)
[471.683503] [106/133] (551s left) gen7_exec_parse (basic-allocation)
[471.768655] Subtest basic-allocation: SKIP (0.000s)
[471.827557] [107/133] (550s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-mmap-gtt)
[471.924939] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-mmap-gtt
[471.926305] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[472.046773] [108/133] (550s left) kms_psr2_sf (pr-cursor-plane-move-continuous-exceed-sf)
[472.134321] Subtest pr-cursor-plane-move-continuous-exceed-sf: SKIP (0.000s)
[472.181349] [109/133] (550s left) kms_frontbuffer_tracking (psr-rgb565-draw-pwrite)
[472.269757] Starting subtest: psr-rgb565-draw-pwrite
[472.271111] Subtest psr-rgb565-draw-pwrite: SKIP (0.000s)
[472.388039] [110/133] (550s left) kms_psr (fbc-pr-cursor-plane-move)
[472.476744] Subtest fbc-pr-cursor-plane-move: SKIP (0.000s)
[472.523372] [111/133] (550s left) syncobj_timeline (invalid-multi-wait-unsubmitted)
[472.564796] Starting subtest: invalid-multi-wait-unsubmitted
[472.565483] Subtest invalid-multi-wait-unsubmitted: SUCCESS (0.000s)
[472.672117] [112/133] (550s left) i915_pm_rpm (debugfs-forcewake-user)
[484.128953] Starting subtest: debugfs-forcewake-user
[495.585226] Subtest debugfs-forcewake-user: SUCCESS (11.458s)
[495.792292] [113/133] (527s left) kms_pm_rpm (pm-tiling)
[507.232864] Starting subtest: pm-tiling
[511.254187] Subtest pm-tiling: SUCCESS (4.022s)
[511.390709] [114/133] (511s left) kms_ccs (random-ccs-data-4-tiled-mtl-mc-ccs)
[511.478061] Starting subtest: random-ccs-data-4-tiled-mtl-mc-ccs
[511.478739] Starting dynamic subtest: pipe-A-HDMI-A-1
[511.485935] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.000s)
[511.493717] Starting dynamic subtest: pipe-B-HDMI-A-1
[511.500830] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.000s)
[511.508491] Starting dynamic subtest: pipe-C-HDMI-A-1
[511.515523] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.000s)
[511.523072] Starting dynamic subtest: pipe-D-HDMI-A-1
[511.530183] Dynamic subtest pipe-D-HDMI-A-1: SKIP (0.000s)
[511.531436] Subtest random-ccs-data-4-tiled-mtl-mc-ccs: SKIP (0.007s)
[511.739240] [115/133] (511s left) gem_mmap_wc (write-gtt-read-wc)
[511.774109] Starting subtest: write-gtt-read-wc
[512.090780] Subtest write-gtt-read-wc: SUCCESS (0.309s)
[512.204684] [116/133] (511s left) kms_invalid_mode (bad-hsync-start)
[512.288922] Starting subtest: bad-hsync-start
[512.289643] Starting dynamic subtest: pipe-A-HDMI-A-1
[512.334066] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.043s)
[512.342313] Starting dynamic subtest: pipe-B-HDMI-A-1
[512.343014] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.001s)
[512.350431] Starting dynamic subtest: pipe-C-HDMI-A-1
[512.351108] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.001s)
[512.358119] Starting dynamic subtest: pipe-D-HDMI-A-1
[512.358785] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.001s)
[512.359420] Subtest bad-hsync-start: SUCCESS (0.053s)
[512.496684] [117/133] (510s left) gem_exec_fence (syncobj-invalid-wait)
[512.833565] Starting subtest: syncobj-invalid-wait
[512.834300] Subtest syncobj-invalid-wait: SUCCESS (0.000s)
[513.164063] [118/133] (510s left) kms_ccs (crc-primary-basic-4-tiled-dg2-rc-ccs-cc)
[513.249134] Starting subtest: crc-primary-basic-4-tiled-dg2-rc-ccs-cc
[513.250933] Starting dynamic subtest: pipe-A-HDMI-A-1
[513.257759] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.001s)
[513.265753] Starting dynamic subtest: pipe-B-HDMI-A-1
[513.272531] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.001s)
[513.280293] Starting dynamic subtest: pipe-C-HDMI-A-1
[513.286998] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.001s)
[513.294455] Starting dynamic subtest: pipe-D-HDMI-A-1
[513.301114] Dynamic subtest pipe-D-HDMI-A-1: SKIP (0.001s)
[513.302420] Subtest crc-primary-basic-4-tiled-dg2-rc-ccs-cc: SKIP (0.010s)
[513.516567] [119/133] (509s left) perf_pmu (semaphore-busy)
[513.554924] Starting subtest: semaphore-busy
[513.555621] Starting dynamic subtest: rcs0
[515.124630] Dynamic subtest rcs0: SUCCESS (1.559s)
[515.135353] Starting dynamic subtest: bcs0
[516.678666] Dynamic subtest bcs0: SUCCESS (1.552s)
[516.689698] Starting dynamic subtest: vcs0
[518.221472] Dynamic subtest vcs0: SUCCESS (1.540s)
[518.232238] Starting dynamic subtest: vcs1
[519.762286] Dynamic subtest vcs1: SUCCESS (1.539s)
[519.773069] Starting dynamic subtest: vecs0
[521.302692] Dynamic subtest vecs0: SUCCESS (1.538s)
[521.303598] Subtest semaphore-busy: SUCCESS (7.739s)
[521.425971] [120/133] (501s left) gem_exec_reloc (basic-write-gtt-active)
[521.463785] Starting subtest: basic-write-gtt-active
[521.593833] Subtest basic-write-gtt-active: SUCCESS (0.121s)
[521.746815] [121/133] (501s left) gen9_exec_parse (bb-start-out)
[521.784915] Subtest bb-start-out: SKIP (0.000s)
[521.827885] [122/133] (501s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size)
[521.914484] Starting subtest: basic-flip-before-cursor-varying-size
[522.979710] Subtest basic-flip-before-cursor-varying-size: SUCCESS (1.065s)
[523.130510] [123/133] (500s left) kms_flip (2x-plain-flip-interruptible)
[523.223434] Starting subtest: 2x-plain-flip-interruptible
[523.232867] Subtest 2x-plain-flip-interruptible: SKIP (0.009s)
[523.344272] [124/133] (500s left) gem_linear_blits (interruptible)
[523.442212] Starting subtest: interruptible
[527.154601] Subtest interruptible: SUCCESS (3.705s)
[527.280792] [125/133] (496s left) kms_prop_blob (blob-multiple)
[527.375164] Starting subtest: blob-multiple
[527.375847] Subtest blob-multiple: SUCCESS (0.001s)
[527.497884] [126/133] (496s left) kms_plane_multiple (tiling-yf)
[527.591049] Starting subtest: tiling-yf
[527.592405] Subtest tiling-yf: SKIP (0.000s)
[527.687301] [127/133] (496s left) kms_plane_scaling (plane-upscale-20x20-with-pixel-format)
[527.774428] Starting subtest: plane-upscale-20x20-with-pixel-format
[527.775365] Starting dynamic subtest: pipe-A
[530.296127] Dynamic subtest pipe-A: SUCCESS (2.522s)
[530.314995] Starting dynamic subtest: pipe-B
[532.826785] Dynamic subtest pipe-B: SUCCESS (2.529s)
[532.848228] Starting dynamic subtest: pipe-C
[533.176898] Dynamic subtest pipe-C: SUCCESS (0.347s)
[533.199013] Starting dynamic subtest: pipe-D
[533.506640] Dynamic subtest pipe-D: SUCCESS (0.327s)
[533.507574] Subtest plane-upscale-20x20-with-pixel-format: SUCCESS (5.734s)
[533.695943] [128/133] (490s left) kms_chamelium_frames (dp-crc-multiple)
[533.824569] Subtest dp-crc-multiple: SKIP (0.000s)
[533.908865] [129/133] (489s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-mmap-wc)
[533.997732] Starting subtest: psr-1p-offscreen-pri-indfb-draw-mmap-wc
[533.999083] Subtest psr-1p-offscreen-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[534.114026] [130/133] (489s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-wc)
[534.201468] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-wc
[534.202851] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[534.322897] [131/133] (489s left) kms_sequence (get-idle)
[534.409842] Starting subtest: get-idle
[534.412038] Starting dynamic subtest: pipe-A-HDMI-A-1
[537.011977] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (2.600s)
[537.021369] Starting dynamic subtest: pipe-B-HDMI-A-1
[539.500387] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (2.487s)
[539.512371] Starting dynamic subtest: pipe-C-HDMI-A-1
[542.005683] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (2.504s)
[542.014619] Starting dynamic subtest: pipe-D-HDMI-A-1
[544.489866] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (2.481s)
[544.490675] Subtest get-idle: SUCCESS (10.080s)
[544.620954] [132/133] (479s left) gem_exec_reloc (basic-active)
[544.663696] Starting subtest: basic-active
[544.664368] Starting dynamic subtest: all-engines
[544.764393] Dynamic subtest all-engines: SUCCESS (0.100s)
[544.776660] Starting dynamic subtest: rcs0
[544.827632] Dynamic subtest rcs0: SUCCESS (0.062s)
[544.839008] Starting dynamic subtest: bcs0
[544.958882] Dynamic subtest bcs0: SUCCESS (0.121s)
[544.968531] Starting dynamic subtest: vcs0
[545.014804] Dynamic subtest vcs0: SUCCESS (0.063s)
[545.026417] Starting dynamic subtest: vcs1
[545.078063] Dynamic subtest vcs1: SUCCESS (0.062s)
[545.087244] Starting dynamic subtest: vecs0
[545.136412] Dynamic subtest vecs0: SUCCESS (0.057s)
[545.137133] Subtest basic-active: SUCCESS (0.473s)
[545.290661] [133/133] (478s left) gem_exec_whisper (basic-fds)
[545.333629] Starting subtest: basic-fds
[548.319114] Subtest basic-fds: SUCCESS (2.985s)
[548.532524] Closing watchdogs
results: parsing output: 0/ for test: api_intel_bb
results: parsing output: 1/ for test: kms_vblank
results: parsing output: 2/ for test: kms_big_fb
results: parsing output: 3/ for test: gem_mmap_wc
results: parsing output: 4/ for test: gem_mmap_gtt
results: parsing output: 5/ for test: kms_ccs
results: parsing output: 6/ for test: kms_frontbuffer_tracking
results: parsing output: 7/ for test: kms_big_fb
results: parsing output: 8/ for test: kms_multipipe_modeset
results: parsing output: 9/ for test: syncobj_timeline
results: parsing output: 10/ for test: kms_vrr
results: parsing output: 11/ for test: kms_cursor_legacy
results: parsing output: 12/ for test: kms_frontbuffer_tracking
results: parsing output: 13/ for test: kms_atomic
results: parsing output: 14/ for test: kms_cursor_crc
results: parsing output: 15/ for test: kms_properties
results: parsing output: 16/ for test: kms_psr
results: parsing output: 17/ for test: gem_exec_params
results: parsing output: 18/ for test: kms_psr
results: parsing output: 19/ for test: gem_ctx_persistence
results: parsing output: 20/ for test: kms_pm_backlight
results: parsing output: 21/ for test: syncobj_timeline
results: parsing output: 22/ for test: kms_frontbuffer_tracking
results: parsing output: 23/ for test: kms_flip
results: parsing output: 24/ for test: i915_drm_fdinfo
results: parsing output: 25/ for test: perf_pmu
results: parsing output: 26/ for test: kms_ccs
results: parsing output: 27/ for test: fbdev
results: parsing output: 28/ for test: kms_plane
results: parsing output: 29/ for test: kms_chamelium_hpd
results: parsing output: 30/ for test: gem_ctx_param
results: parsing output: 31/ for test: gem_exec_reloc
results: parsing output: 32/ for test: kms_frontbuffer_tracking
results: parsing output: 33/ for test: kms_flip_scaled_crc
results: parsing output: 34/ for test: kms_psr
results: parsing output: 35/ for test: kms_big_fb
results: parsing output: 36/ for test: kms_frontbuffer_tracking
results: parsing output: 37/ for test: kms_flip
results: parsing output: 38/ for test: perf_pmu
results: parsing output: 39/ for test: syncobj_timeline
results: parsing output: 40/ for test: kms_content_protection
results: parsing output: 41/ for test: kms_frontbuffer_tracking
results: parsing output: 42/ for test: gem_exec_balancer
results: parsing output: 43/ for test: kms_frontbuffer_tracking
results: parsing output: 44/ for test: kms_lease
results: parsing output: 45/ for test: gem_ctx_exec
results: parsing output: 46/ for test: gem_busy
results: parsing output: 47/ for test: gem_pxp
results: parsing output: 48/ for test: gem_ctx_persistence
results: parsing output: 49/ for test: perf
results: parsing output: 50/ for test: kms_big_fb
results: parsing output: 51/ for test: kms_psr
results: parsing output: 52/ for test: kms_big_fb
results: parsing output: 53/ for test: gem_lmem_swapping
results: parsing output: 54/ for test: syncobj_wait
results: parsing output: 55/ for test: kms_atomic_transition
results: parsing output: 56/ for test: syncobj_basic
results: parsing output: 57/ for test: gem_exec_params
results: parsing output: 58/ for test: kms_async_flips
results: parsing output: 59/ for test: kms_ccs
results: parsing output: 60/ for test: api_intel_bb
results: parsing output: 61/ for test: kms_frontbuffer_tracking
results: parsing output: 62/ for test: kms_frontbuffer_tracking
results: parsing output: 63/ for test: gem_spin_batch
results: parsing output: 64/ for test: perf
results: parsing output: 65/ for test: kms_big_fb
results: parsing output: 66/ for test: kms_color
results: parsing output: 67/ for test: syncobj_wait
results: parsing output: 68/ for test: gem_render_copy
results: parsing output: 69/ for test: i915_selftest
results: parsing output: 70/ for test: gem_exec_schedule
results: parsing output: 71/ for test: kms_psr
results: parsing output: 72/ for test: gem_exec_balancer
results: parsing output: 73/ for test: gem_lmem_swapping
results: parsing output: 74/ for test: kms_cursor_crc
results: parsing output: 75/ for test: sysfs_heartbeat_interval
results: parsing output: 76/ for test: kms_cursor_legacy
results: parsing output: 77/ for test: kms_big_fb
results: parsing output: 78/ for test: gem_tiled_fence_blits
results: parsing output: 79/ for test: gem_exec_schedule
results: parsing output: 80/ for test: kms_cursor_legacy
results: parsing output: 81/ for test: kms_frontbuffer_tracking
results: parsing output: 82/ for test: i915_module_load
results: parsing output: 83/ for test: gem_exec_reloc
results: parsing output: 84/ for test: kms_frontbuffer_tracking
results: parsing output: 85/ for test: kms_frontbuffer_tracking
results: parsing output: 86/ for test: kms_frontbuffer_tracking
results: parsing output: 87/ for test: drm_read
results: parsing output: 88/ for test: kms_draw_crc
results: parsing output: 89/ for test: kms_frontbuffer_tracking
results: parsing output: 90/ for test: syncobj_timeline
results: parsing output: 91/ for test: kms_plane_scaling
results: parsing output: 92/ for test: gem_ctx_sseu
results: parsing output: 93/ for test: kms_frontbuffer_tracking
results: parsing output: 94/ for test: kms_flip
results: parsing output: 95/ for test: gem_exec_gttfill
results: parsing output: 96/ for test: gem_madvise
results: parsing output: 97/ for test: gem_partial_pwrite_pread
results: parsing output: 98/ for test: gem_mmap_gtt
results: parsing output: 99/ for test: kms_frontbuffer_tracking
results: parsing output: 100/ for test: sw_sync
results: parsing output: 101/ for test: kms_frontbuffer_tracking
results: parsing output: 102/ for test: kms_cursor_crc
results: parsing output: 103/ for test: syncobj_wait
results: parsing output: 104/ for test: gem_exec_await
results: parsing output: 105/ for test: gen7_exec_parse
results: parsing output: 106/ for test: kms_frontbuffer_tracking
results: parsing output: 107/ for test: kms_psr2_sf
results: parsing output: 108/ for test: kms_frontbuffer_tracking
results: parsing output: 109/ for test: kms_psr
results: parsing output: 110/ for test: syncobj_timeline
results: parsing output: 111/ for test: i915_pm_rpm
results: parsing output: 112/ for test: kms_pm_rpm
results: parsing output: 113/ for test: kms_ccs
results: parsing output: 114/ for test: gem_mmap_wc
results: parsing output: 115/ for test: kms_invalid_mode
results: parsing output: 116/ for test: gem_exec_fence
results: parsing output: 117/ for test: kms_ccs
results: parsing output: 118/ for test: perf_pmu
results: parsing output: 119/ for test: gem_exec_reloc
results: parsing output: 120/ for test: gen9_exec_parse
results: parsing output: 121/ for test: kms_cursor_legacy
results: parsing output: 122/ for test: kms_flip
results: parsing output: 123/ for test: gem_linear_blits
results: parsing output: 124/ for test: kms_prop_blob
results: parsing output: 125/ for test: kms_plane_multiple
results: parsing output: 126/ for test: kms_plane_scaling
results: parsing output: 127/ for test: kms_chamelium_frames
results: parsing output: 128/ for test: kms_frontbuffer_tracking
results: parsing output: 129/ for test: kms_frontbuffer_tracking
results: parsing output: 130/ for test: kms_sequence
results: parsing output: 131/ for test: gem_exec_reloc
results: parsing output: 132/ for test: gem_exec_whisper
Done.