[66.588077] Initializing watchdogs
[66.588156]   /dev/watchdog0
[66.618654] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:03:00.0: 8086:4905 Intel Dg1 (Gen12) DG1 [Iris Xe MAX Graphics]
[66.633513] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[66.638917] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[66.642079] [001/133] (960s left) sw_sync (timeline_closed)
[66.694350] Starting subtest: timeline_closed
[66.695850] Subtest timeline_closed: SUCCESS (0.000s)
[66.777867] [002/133] (960s left) gem_busy (close-race)
[66.840982] Starting subtest: close-race
[88.945528] Subtest close-race: SUCCESS (22.133s)
[89.501676] [FACT gem_busy (close-race)] new: kernel.kmod_is_loaded.vgem: true
[89.505459] [003/133] (937s left) i915_query (query-topology-garbage-items)
[89.615655] Starting subtest: query-topology-garbage-items
[89.617288] Subtest query-topology-garbage-items: SUCCESS (0.000s)
[89.724941] [004/133] (937s left) gem_userptr_blits (dmabuf-unsync)
[89.795592] Subtest dmabuf-unsync: SKIP (0.000s)
[90.001430] [005/133] (937s left) perf (gen8-unprivileged-single-ctx-counters)
[90.160026] Starting subtest: gen8-unprivileged-single-ctx-counters
[90.162882] Subtest gen8-unprivileged-single-ctx-counters: SKIP (0.000s)
[90.241594] [006/133] (937s left) kms_flip (flip-vs-dpms-off-vs-modeset)
[91.738435] Starting subtest: flip-vs-dpms-off-vs-modeset
[91.744847] Starting dynamic subtest: A-HDMI-A4
[92.635960] Dynamic subtest A-HDMI-A4: SUCCESS (0.891s)
[92.645847] Starting dynamic subtest: B-HDMI-A4
[93.315813] Dynamic subtest B-HDMI-A4: SUCCESS (0.679s)
[93.326043] Starting dynamic subtest: C-HDMI-A4
[94.027815] Dynamic subtest C-HDMI-A4: SUCCESS (0.711s)
[94.037637] Starting dynamic subtest: D-HDMI-A4
[94.735590] Dynamic subtest D-HDMI-A4: SUCCESS (0.708s)
[94.737044] Subtest flip-vs-dpms-off-vs-modeset: SUCCESS (2.997s)
[94.937036] [007/133] (932s left) kms_feature_discovery (chamelium)
[96.429549] Starting subtest: chamelium
[96.432617] Subtest chamelium: SKIP (0.000s)
[96.540118] [008/133] (931s left) kms_atomic_transition (plane-all-modeset-transition)
[98.030388] Starting subtest: plane-all-modeset-transition
[98.031969] Starting dynamic subtest: pipe-A-HDMI-A-4
[109.687278] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (11.651s)
[109.740220] Starting dynamic subtest: pipe-B-HDMI-A-4
[117.704137] Dynamic subtest pipe-B-HDMI-A-4: SUCCESS (7.971s)
[117.720916] Subtest plane-all-modeset-transition: SUCCESS (19.689s)
[117.904991] [009/133] (909s left) gem_tiled_partial_pwrite_pread (reads)
[117.960164] Subtest reads: SKIP (0.000s)
[118.033169] [010/133] (909s left) kms_plane (pixel-format-y-tiled-gen12-rc-ccs-modifier-source-clamping)
[119.538651] Starting subtest: pixel-format-y-tiled-gen12-rc-ccs-modifier-source-clamping
[119.571252] Starting dynamic subtest: pipe-A-plane-0
[120.089325] Dynamic subtest pipe-A-plane-0: SUCCESS (0.518s)
[120.114893] Starting dynamic subtest: pipe-A-plane-3
[120.438398] Dynamic subtest pipe-A-plane-3: SUCCESS (0.348s)
[120.475336] Starting dynamic subtest: pipe-A-plane-5
[120.788470] Dynamic subtest pipe-A-plane-5: SUCCESS (0.349s)
[120.947996] Starting dynamic subtest: pipe-B-plane-0
[121.323073] Dynamic subtest pipe-B-plane-0: SUCCESS (0.383s)
[121.355668] Starting dynamic subtest: pipe-B-plane-3
[121.673643] Dynamic subtest pipe-B-plane-3: SUCCESS (0.349s)
[121.713859] Starting dynamic subtest: pipe-B-plane-5
[122.006952] Dynamic subtest pipe-B-plane-5: SUCCESS (0.332s)
[122.063498] Subtest pixel-format-y-tiled-gen12-rc-ccs-modifier-source-clamping: SUCCESS (2.525s)
[122.246726] [011/133] (905s left) gem_mmap_offset (oob-read)
[122.295501] Starting subtest: oob-read
[122.297107] Subtest oob-read: SUCCESS (0.000s)
[122.468378] [012/133] (905s left) kms_ccs (random-ccs-data-y-tiled-gen12-mc-ccs)
[123.953555] Starting subtest: random-ccs-data-y-tiled-gen12-mc-ccs
[123.954937] Starting dynamic subtest: pipe-A-HDMI-A-4
[123.970279] Dynamic subtest pipe-A-HDMI-A-4: SKIP (0.000s)
[123.980324] Starting dynamic subtest: pipe-B-HDMI-A-4
[123.995929] Dynamic subtest pipe-B-HDMI-A-4: SKIP (0.000s)
[124.005579] Starting dynamic subtest: pipe-C-HDMI-A-4
[124.021844] Dynamic subtest pipe-C-HDMI-A-4: SKIP (0.000s)
[124.031487] Starting dynamic subtest: pipe-D-HDMI-A-4
[124.048487] Dynamic subtest pipe-D-HDMI-A-4: SKIP (0.000s)
[124.051608] Subtest random-ccs-data-y-tiled-gen12-mc-ccs: SKIP (0.006s)
[124.228579] [013/133] (903s left) syncobj_timeline (multi-wait-available-submitted-signaled)
[124.278929] Starting subtest: multi-wait-available-submitted-signaled
[124.280657] Subtest multi-wait-available-submitted-signaled: SUCCESS (0.001s)
[124.414891] [014/133] (903s left) kms_psr2_sf (fbc-pr-overlay-plane-move-continuous-exceed-sf)
[125.901707] Subtest fbc-pr-overlay-plane-move-continuous-exceed-sf: SKIP (0.000s)
[125.975752] [015/133] (902s left) gem_mmap_wc (read)
[126.024995] Subtest read: SKIP (0.000s)
[126.105494] [016/133] (902s left) kms_big_fb (linear-16bpp-rotate-180)
[127.614630] Starting subtest: linear-16bpp-rotate-180
[129.715180] Subtest linear-16bpp-rotate-180: SUCCESS (2.098s)
[129.942820] [017/133] (898s left) kms_psr (fbc-psr2-sprite-render)
[131.430051] Subtest fbc-psr2-sprite-render: SKIP (0.000s)
[131.503142] [018/133] (896s left) gem_eio (in-flight-external)
[131.694402] Starting subtest: in-flight-external
[132.898363] Subtest in-flight-external: SUCCESS (1.204s)
[134.448737] [019/133] (894s left) kms_cursor_crc (cursor-rapid-movement-256x256)
[136.159677] Starting subtest: cursor-rapid-movement-256x256
[136.167384] Starting dynamic subtest: pipe-A-HDMI-A-4
[136.617406] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (0.451s)
[136.648711] Starting dynamic subtest: pipe-D-HDMI-A-4
[136.958809] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (0.319s)
[136.960487] Subtest cursor-rapid-movement-256x256: SUCCESS (0.799s)
[137.380562] [020/133] (891s left) kms_busy (extended-modeset-hang-oldfb-with-reset)
[138.882584] Starting subtest: extended-modeset-hang-oldfb-with-reset
[138.884248] Starting dynamic subtest: pipe-A
[149.225275] Dynamic subtest pipe-A: SUCCESS (10.342s)
[149.237742] Starting dynamic subtest: pipe-D
[159.955168] Dynamic subtest pipe-D: SUCCESS (10.726s)
[159.956683] Subtest extended-modeset-hang-oldfb-with-reset: SUCCESS (21.076s)
[160.141899] [021/133] (868s left) kms_ccs (crc-primary-rotation-180-4-tiled-mtl-rc-ccs)
[161.628535] Starting subtest: crc-primary-rotation-180-4-tiled-mtl-rc-ccs
[161.630027] Starting dynamic subtest: pipe-A-HDMI-A-4
[161.644869] Dynamic subtest pipe-A-HDMI-A-4: SKIP (0.001s)
[161.655778] Starting dynamic subtest: pipe-B-HDMI-A-4
[161.671111] Dynamic subtest pipe-B-HDMI-A-4: SKIP (0.001s)
[161.681576] Starting dynamic subtest: pipe-C-HDMI-A-4
[161.697031] Dynamic subtest pipe-C-HDMI-A-4: SKIP (0.001s)
[161.707605] Starting dynamic subtest: pipe-D-HDMI-A-4
[161.726167] Dynamic subtest pipe-D-HDMI-A-4: SKIP (0.001s)
[161.729396] Subtest crc-primary-rotation-180-4-tiled-mtl-rc-ccs: SKIP (0.010s)
[161.872969] [022/133] (866s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-mmap-gtt)
[163.379292] Starting subtest: fbcpsr-rgb565-draw-mmap-gtt
[163.382752] Subtest fbcpsr-rgb565-draw-mmap-gtt: SKIP (0.000s)
[163.552673] [023/133] (865s left) kms_big_fb (yf-tiled-addfb)
[165.059385] Starting subtest: yf-tiled-addfb
[165.062759] Subtest yf-tiled-addfb: SKIP (0.000s)
[165.235088] [024/133] (863s left) gem_close_race (multigpu-basic-threads)
[165.324254] Starting subtest: multigpu-basic-threads
[165.327848] Subtest multigpu-basic-threads: SKIP (0.000s)
[165.660617] [025/133] (863s left) api_intel_allocator (two-level-inception-interruptible)
[165.706679] Starting subtest: two-level-inception-interruptible
[171.165576] Subtest two-level-inception-interruptible: SUCCESS (5.459s)
[171.365844] [026/133] (857s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-shrfb-plflip-blt)
[172.857514] Starting subtest: fbcpsr-1p-primscrn-shrfb-plflip-blt
[172.860983] Subtest fbcpsr-1p-primscrn-shrfb-plflip-blt: SKIP (0.000s)
[173.036820] [027/133] (856s left) kms_ccs (crc-primary-basic-y-tiled-gen12-mc-ccs)
[174.521436] Starting subtest: crc-primary-basic-y-tiled-gen12-mc-ccs
[174.523112] Starting dynamic subtest: pipe-A-HDMI-A-4
[174.538128] Dynamic subtest pipe-A-HDMI-A-4: SKIP (0.001s)
[174.549221] Starting dynamic subtest: pipe-B-HDMI-A-4
[174.564717] Dynamic subtest pipe-B-HDMI-A-4: SKIP (0.001s)
[174.575601] Starting dynamic subtest: pipe-C-HDMI-A-4
[174.593984] Dynamic subtest pipe-C-HDMI-A-4: SKIP (0.001s)
[174.604883] Starting dynamic subtest: pipe-D-HDMI-A-4
[174.621657] Dynamic subtest pipe-D-HDMI-A-4: SKIP (0.001s)
[174.624881] Subtest crc-primary-basic-y-tiled-gen12-mc-ccs: SKIP (0.010s)
[174.801340] [028/133] (854s left) gem_mmap_wc (copy)
[174.874616] Subtest copy: SKIP (0.000s)
[174.987763] [029/133] (854s left) kms_cursor_legacy (short-busy-flip-before-cursor-atomic-transitions-varying-s
[176.475206] Starting subtest: short-busy-flip-before-cursor-atomic-transitions-varying-size
[176.477864] Subtest short-busy-flip-before-cursor-atomic-transitions-varying-size: SKIP (0.000s)
[176.594336] [030/133] (853s left) kms_big_fb (x-tiled-16bpp-rotate-90)
[178.108834] Starting subtest: x-tiled-16bpp-rotate-90
[178.203117] Subtest x-tiled-16bpp-rotate-90: SKIP (0.093s)
[178.349793] [031/133] (851s left) kms_cursor_crc (cursor-sliding-256x85)
[180.081644] Starting subtest: cursor-sliding-256x85
[180.088811] Starting dynamic subtest: pipe-A-HDMI-A-4
[184.508170] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (4.419s)
[184.539500] Starting dynamic subtest: pipe-D-HDMI-A-4
[188.202660] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (3.671s)
[188.204362] Subtest cursor-sliding-256x85: SUCCESS (8.120s)
[188.458731] [032/133] (841s left) gem_exec_fence (syncobj-invalid-flags)
[188.851410] Starting subtest: syncobj-invalid-flags
[188.852842] Subtest syncobj-invalid-flags: SUCCESS (0.000s)
[189.224889] [033/133] (840s left) kms_flip (dpms-vs-vblank-race-interruptible)
[190.722300] Starting subtest: dpms-vs-vblank-race-interruptible
[190.730604] Starting dynamic subtest: A-HDMI-A4
[193.721424] Dynamic subtest A-HDMI-A4: SUCCESS (2.991s)
[193.732660] Starting dynamic subtest: B-HDMI-A4
[196.713981] Dynamic subtest B-HDMI-A4: SUCCESS (2.990s)
[196.735962] Starting dynamic subtest: C-HDMI-A4
[199.657676] Dynamic subtest C-HDMI-A4: SUCCESS (2.942s)
[199.669295] Starting dynamic subtest: D-HDMI-A4
[202.585250] Dynamic subtest D-HDMI-A4: SUCCESS (2.927s)
[202.586825] Subtest dpms-vs-vblank-race-interruptible: SUCCESS (11.863s)
[202.774136] [034/133] (827s left) kms_addfb_basic (basic-y-tiled-legacy)
[202.848067] Starting subtest: basic-y-tiled-legacy
[202.850924] Subtest basic-y-tiled-legacy: SKIP (0.000s)
[204.454351] [035/133] (825s left) gem_lmem_swapping (heavy-verify-multi)
[208.741333] Starting subtest: heavy-verify-multi
[208.743364] Starting dynamic subtest: lmem0
[223.989757] Dynamic subtest lmem0: SUCCESS (15.245s)
[223.991191] Subtest heavy-verify-multi: SUCCESS (15.246s)
[225.185313] [FACT gem_lmem_swapping (heavy-verify-multi)] deleted: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[225.186505] [FACT gem_lmem_swapping (heavy-verify-multi)] deleted: kernel.kmod_is_loaded.i915: true
[225.189734] [036/133] (804s left) api_intel_bb (misplaced-blitter)
[228.423246] Starting subtest: misplaced-blitter
[228.451869] Subtest misplaced-blitter: SUCCESS (0.031s)
[228.559141] [FACT api_intel_bb (misplaced-blitter)] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[228.562582] [FACT api_intel_bb (misplaced-blitter)] new: kernel.kmod_is_loaded.i915: true
[228.566946] [037/133] (801s left) kms_vblank (query-idle-hang)
[230.085219] Starting subtest: query-idle-hang
[230.089817] Starting dynamic subtest: pipe-A-HDMI-A-4
[256.490816] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (26.403s)
[256.503991] Starting dynamic subtest: pipe-D-HDMI-A-4
[281.500772] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (25.005s)
[281.502133] Subtest query-idle-hang: SUCCESS (51.418s)
[281.680981] [038/133] (748s left) kms_fbcon_fbt (psr-suspend)
[281.734868] Starting subtest: psr-suspend
[281.738053] Subtest psr-suspend: SKIP (0.000s)
[281.931648] [039/133] (748s left) kms_cursor_crc (cursor-offscreen-128x42)
[283.616999] Starting subtest: cursor-offscreen-128x42
[283.624743] Starting dynamic subtest: pipe-A-HDMI-A-4
[286.163148] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (2.539s)
[286.197093] Starting dynamic subtest: pipe-D-HDMI-A-4
[288.576096] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (2.388s)
[288.577561] Subtest cursor-offscreen-128x42: SUCCESS (4.958s)
[288.962903] [040/133] (741s left) kms_ccs (bad-pixel-format-y-tiled-ccs)
[290.448708] Starting subtest: bad-pixel-format-y-tiled-ccs
[290.450086] Starting dynamic subtest: pipe-A-HDMI-A-4
[290.464438] Dynamic subtest pipe-A-HDMI-A-4: SKIP (0.000s)
[290.475050] Starting dynamic subtest: pipe-B-HDMI-A-4
[290.489972] Dynamic subtest pipe-B-HDMI-A-4: SKIP (0.000s)
[290.500135] Starting dynamic subtest: pipe-C-HDMI-A-4
[290.514991] Dynamic subtest pipe-C-HDMI-A-4: SKIP (0.000s)
[290.525153] Starting dynamic subtest: pipe-D-HDMI-A-4
[290.540631] Dynamic subtest pipe-D-HDMI-A-4: SKIP (0.000s)
[290.543715] Subtest bad-pixel-format-y-tiled-ccs: SKIP (0.011s)
[290.691469] [041/133] (739s left) kms_atomic_interruptible (universal-setplane-cursor)
[292.178782] Starting subtest: universal-setplane-cursor
[292.180390] Starting dynamic subtest: pipe-A-HDMI-A-4
[298.369746] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (6.190s)
[298.371073] Subtest universal-setplane-cursor: SUCCESS (6.193s)
[298.554025] [042/133] (731s left) gem_lmem_swapping (verify-ccs)
[302.727423] Starting subtest: verify-ccs
[302.730277] Starting dynamic subtest: lmem0
[302.738273] Dynamic subtest lmem0: SKIP (0.001s)
[302.743270] Subtest verify-ccs: SKIP (0.008s)
[306.495652] [FACT gem_lmem_swapping (verify-ccs)] deleted: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[306.496789] [FACT gem_lmem_swapping (verify-ccs)] deleted: kernel.kmod_is_loaded.i915: true
[306.499976] [043/133] (724s left) gem_workarounds (reset-context)
[309.806394] Starting subtest: reset-context
[309.926345] Subtest reset-context: SUCCESS (0.119s)
[310.034109] [FACT gem_workarounds (reset-context)] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[310.037487] [FACT gem_workarounds (reset-context)] new: kernel.kmod_is_loaded.i915: true
[310.041528] [044/133] (720s left) kms_chamelium_edid (dp-edid-stress-resolution-4k)
[311.586039] Subtest dp-edid-stress-resolution-4k: SKIP (0.000s)
[311.704730] [045/133] (718s left) syncobj_timeline (invalid-multi-wait-unsubmitted-signaled)
[311.757255] Starting subtest: invalid-multi-wait-unsubmitted-signaled
[311.758928] Subtest invalid-multi-wait-unsubmitted-signaled: SUCCESS (0.001s)
[311.871297] [046/133] (718s left) gem_exec_reloc (basic-write-wc-noreloc)
[311.926053] Subtest basic-write-wc-noreloc: SKIP (0.000s)
[312.035599] [047/133] (718s left) gem_userptr_blits (coherency-unsync)
[312.092777] Subtest coherency-unsync: SKIP (0.000s)
[312.306290] [048/133] (718s left) kms_universal_plane (universal-plane-functional)
[313.794419] Starting subtest: universal-plane-functional
[313.796065] Starting dynamic subtest: pipe-A-HDMI-A-4
[315.854124] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (2.058s)
[315.871659] Starting dynamic subtest: pipe-B-HDMI-A-4
[317.789418] Dynamic subtest pipe-B-HDMI-A-4: SUCCESS (1.929s)
[317.821443] Starting dynamic subtest: pipe-C-HDMI-A-4
[319.811538] Dynamic subtest pipe-C-HDMI-A-4: SUCCESS (2.013s)
[319.824908] Starting dynamic subtest: pipe-D-HDMI-A-4
[321.825622] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (2.011s)
[321.827256] Subtest universal-plane-functional: SUCCESS (8.033s)
[321.995275] [049/133] (709s left) kms_big_fb (4-tiled-32bpp-rotate-180)
[323.529152] Starting subtest: 4-tiled-32bpp-rotate-180
[323.532895] Subtest 4-tiled-32bpp-rotate-180: SKIP (0.000s)
[323.699998] [050/133] (707s left) gem_ctx_persistence (engines-persistence)
[323.754444] Starting subtest: engines-persistence
[323.756288] Starting dynamic subtest: rcs0
[324.505061] Dynamic subtest rcs0: SUCCESS (0.750s)
[324.517285] Starting dynamic subtest: bcs0
[325.285721] Dynamic subtest bcs0: SUCCESS (0.779s)
[325.300890] Starting dynamic subtest: vcs0
[326.037932] Dynamic subtest vcs0: SUCCESS (0.750s)
[326.049685] Starting dynamic subtest: vcs1
[326.824740] Dynamic subtest vcs1: SUCCESS (0.785s)
[326.838931] Starting dynamic subtest: vecs0
[327.575709] Dynamic subtest vecs0: SUCCESS (0.749s)
[327.577111] Subtest engines-persistence: SUCCESS (3.822s)
[327.718583] [051/133] (703s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-render)
[329.210899] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-render
[329.213701] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-render: SKIP (0.000s)
[329.393109] [052/133] (701s left) kms_color (ctm-negative)
[330.879253] Starting subtest: ctm-negative
[330.880950] Starting dynamic subtest: pipe-A-HDMI-A-4
[331.600901] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (0.721s)
[331.611888] Starting dynamic subtest: pipe-B-HDMI-A-4
[332.093294] Dynamic subtest pipe-B-HDMI-A-4: SUCCESS (0.490s)
[332.104220] Starting dynamic subtest: pipe-C-HDMI-A-4
[332.579797] Dynamic subtest pipe-C-HDMI-A-4: SUCCESS (0.485s)
[332.591118] Starting dynamic subtest: pipe-D-HDMI-A-4
[333.093348] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (0.512s)
[333.094719] Subtest ctm-negative: SUCCESS (2.214s)
[333.272011] [053/133] (698s left) gem_exec_capture (capture)
[333.329629] Starting subtest: capture
[333.331073] Starting dynamic subtest: rcs0-smem
[334.214671] Dynamic subtest rcs0-smem: SUCCESS (0.885s)
[334.225993] Starting dynamic subtest: rcs0-lmem0
[335.212666] Dynamic subtest rcs0-lmem0: SUCCESS (0.996s)
[335.223504] Starting dynamic subtest: bcs0-smem
[336.074128] Dynamic subtest bcs0-smem: SUCCESS (0.860s)
[336.085109] Starting dynamic subtest: bcs0-lmem0
[336.937899] Dynamic subtest bcs0-lmem0: SUCCESS (0.862s)
[336.948802] Starting dynamic subtest: vcs0-smem
[337.800843] Dynamic subtest vcs0-smem: SUCCESS (0.862s)
[337.811842] Starting dynamic subtest: vcs0-lmem0
[338.660802] Dynamic subtest vcs0-lmem0: SUCCESS (0.858s)
[338.671757] Starting dynamic subtest: vcs1-smem
[340.022098] Dynamic subtest vcs1-smem: SUCCESS (1.360s)
[340.033174] Starting dynamic subtest: vcs1-lmem0
[340.876888] Dynamic subtest vcs1-lmem0: SUCCESS (0.854s)
[340.887946] Starting dynamic subtest: vecs0-smem
[341.807455] Dynamic subtest vecs0-smem: FAIL (0.880s)
[341.817894] Starting dynamic subtest: vecs0-lmem0
[342.795158] Dynamic subtest vecs0-lmem0: FAIL (0.987s)
[342.796962] Subtest capture: FAIL (9.419s)
[342.893759] [054/133] (688s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-mmap-cpu)
[344.396362] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-mmap-cpu
[344.399271] Subtest psr-2p-scndscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[344.555569] [055/133] (686s left) gem_render_copy (yf-tiled-ccs-to-y-tiled-ccs)
[344.615916] Starting subtest: yf-tiled-ccs-to-y-tiled-ccs
[344.617643] Starting dynamic subtest: smem
[344.716319] Dynamic subtest smem: SUCCESS (0.100s)
[344.727553] Starting dynamic subtest: lmem0
[345.830257] Dynamic subtest lmem0: SUCCESS (1.109s)
[345.831947] Subtest yf-tiled-ccs-to-y-tiled-ccs: SUCCESS (1.212s)
[346.094526] [056/133] (685s left) perf (blocking)
[346.220871] Starting subtest: blocking
[346.222544] Starting dynamic subtest: 0-rcs0
[356.266130] Dynamic subtest 0-rcs0: SUCCESS (10.043s)
[356.267830] Subtest blocking: SUCCESS (10.045s)
[356.338471] [057/133] (675s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-mmap-gtt)
[357.833050] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-mmap-gtt
[357.836761] Subtest fbc-2p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[357.978569] [058/133] (673s left) gem_exec_whisper (basic-normal)
[358.048394] Starting subtest: basic-normal
[360.038752] Subtest basic-normal: SUCCESS (1.989s)
[360.271585] [059/133] (671s left) prime_busy (before-wait)
[360.325155] Starting subtest: before-wait
[360.331739] Starting dynamic subtest: rcs0
[360.363981] Dynamic subtest rcs0: SUCCESS (0.032s)
[360.377749] Starting dynamic subtest: bcs0
[360.403584] Dynamic subtest bcs0: SUCCESS (0.038s)
[360.417804] Starting dynamic subtest: vcs0
[360.444984] Dynamic subtest vcs0: SUCCESS (0.040s)
[360.466037] Starting dynamic subtest: vcs1
[360.487828] Dynamic subtest vcs1: SUCCESS (0.040s)
[360.509807] Starting dynamic subtest: vecs0
[360.530041] Dynamic subtest vecs0: SUCCESS (0.040s)
[360.656127] Subtest before-wait: SUCCESS (0.327s)
[360.861690] [060/133] (671s left) gem_exec_balancer (bonded-sync)
[360.922765] Starting subtest: bonded-sync
[360.925898] Subtest bonded-sync: SKIP (0.000s)
[361.404027] [061/133] (670s left) gem_mmap_wc (write-read)
[361.454341] Subtest write-read: SKIP (0.000s)
[361.534728] [062/133] (670s left) sysfs_preempt_timeout (timeout)
[361.588149] Starting subtest: timeout
[361.589748] Starting dynamic subtest: vecs0
[363.191749] Dynamic subtest vecs0: SUCCESS (1.601s)
[363.203505] Starting dynamic subtest: vcs0
[364.724862] Dynamic subtest vcs0: SUCCESS (1.532s)
[364.736440] Starting dynamic subtest: bcs0
[366.230052] Dynamic subtest bcs0: SUCCESS (1.503s)
[366.241628] Starting dynamic subtest: rcs0
[367.731154] Dynamic subtest rcs0: SUCCESS (1.499s)
[367.742710] Starting dynamic subtest: vcs1
[369.188279] Dynamic subtest vcs1: SUCCESS (1.455s)
[369.190057] Subtest timeout: SUCCESS (7.600s)
[369.347473] [063/133] (662s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-render)
[370.843767] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-render
[370.846912] Subtest fbc-2p-primscrn-spr-indfb-draw-render: SKIP (0.000s)
[371.055202] [064/133] (661s left) gem_spin_batch (spin-each)
[371.119909] Starting subtest: spin-each
[374.426647] Subtest spin-each: SUCCESS (3.306s)
[374.753751] [065/133] (657s left) dmabuf_sync_file (export-multiwait)
[374.806856] Starting subtest: export-multiwait
[374.808552] Subtest export-multiwait: SUCCESS (0.000s)
[374.908202] [066/133] (657s left) syncobj_wait (invalid-multi-wait-all-unsubmitted-submitted-signaled)
[374.957889] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted-signaled
[374.959803] Subtest invalid-multi-wait-all-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[375.073824] [067/133] (657s left) gem_pread (exhaustion)
[375.130134] Subtest exhaustion: SKIP (0.000s)
[375.218765] [068/133] (657s left) kms_chamelium_hpd (vga-hpd-fast)
[376.765270] Subtest vga-hpd-fast: SKIP (0.000s)
[376.884664] [069/133] (655s left) kms_frontbuffer_tracking (psr-1p-primscrn-shrfb-plflip-blt)
[378.376945] Starting subtest: psr-1p-primscrn-shrfb-plflip-blt
[378.380308] Subtest psr-1p-primscrn-shrfb-plflip-blt: SKIP (0.000s)
[378.537184] [070/133] (654s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-render)
[380.031998] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-render
[380.034942] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-render: SKIP (0.000s)
[380.214865] [071/133] (652s left) kms_vrr (flipline)
[381.701892] Starting subtest: flipline
[381.706733] Subtest flipline: SKIP (0.000s)
[381.833321] [072/133] (651s left) kms_setmode (invalid-clone-exclusive-crtc)
[381.892283] Starting subtest: invalid-clone-exclusive-crtc
[381.899742] Subtest invalid-clone-exclusive-crtc: SKIP (0.000s)
[382.003617] [073/133] (651s left) i915_hangman (detector)
[382.080673] Starting subtest: detector
[382.082210] Starting dynamic subtest: rcs0
[392.114365] Dynamic subtest rcs0: SUCCESS (10.045s)
[392.145171] Starting dynamic subtest: bcs0
[402.129970] Dynamic subtest bcs0: SUCCESS (10.013s)
[402.141982] Starting dynamic subtest: vcs0
[412.120323] Dynamic subtest vcs0: SUCCESS (9.989s)
[412.151607] Starting dynamic subtest: vcs1
[422.099260] Dynamic subtest vcs1: SUCCESS (9.976s)
[422.111238] Starting dynamic subtest: vecs0
[432.091410] Dynamic subtest vecs0: SUCCESS (9.991s)
[432.093376] Subtest detector: SUCCESS (50.024s)
[432.305417] [074/133] (600s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-16bpp-yftile-downscaling)
[433.793720] Starting subtest: flip-64bpp-yftile-to-16bpp-yftile-downscaling
[433.796860] Subtest flip-64bpp-yftile-to-16bpp-yftile-downscaling: SKIP (0.000s)
[433.908422] [075/133] (599s left) gem_exec_reloc (basic-wc-noreloc)
[433.969301] Subtest basic-wc-noreloc: SKIP (0.000s)
[434.065101] [076/133] (599s left) i915_query (query-topology-matches-eu-total)
[434.113337] Starting subtest: query-topology-matches-eu-total
[434.115117] Subtest query-topology-matches-eu-total: SUCCESS (0.000s)
[434.234826] [077/133] (599s left) kms_setmode (invalid-clone-single-crtc)
[434.282594] Starting subtest: invalid-clone-single-crtc
[434.287395] Subtest invalid-clone-single-crtc: SKIP (0.000s)
[434.404803] [078/133] (599s left) kms_frontbuffer_tracking (psr-2p-primscrn-shrfb-msflip-blt)
[435.895748] Starting subtest: psr-2p-primscrn-shrfb-msflip-blt
[435.898330] Subtest psr-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[436.043960] [079/133] (597s left) kms_atomic (atomic-invalid-params)
[437.538177] Starting subtest: atomic-invalid-params
[437.542626] Starting dynamic subtest: pipe-A-HDMI-A-4
[437.924821] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (0.384s)
[437.926583] Subtest atomic-invalid-params: SUCCESS (0.387s)
[438.104690] [080/133] (595s left) kms_flip_scaled_crc (flip-32bpp-ytileccs-to-64bpp-ytile-downscaling)
[439.607870] Starting subtest: flip-32bpp-ytileccs-to-64bpp-ytile-downscaling
[439.610523] Subtest flip-32bpp-ytileccs-to-64bpp-ytile-downscaling: SKIP (0.000s)
[439.729368] [081/133] (593s left) prime_mmap (test_aperture_limit)
[439.788034] Starting subtest: test_aperture_limit
[439.789540] Starting dynamic subtest: test_aperture_limit-smem
[439.808709] Dynamic subtest test_aperture_limit-smem: SKIP (0.020s)
[439.811877] Subtest test_aperture_limit: SKIP (0.022s)
[439.922998] [082/133] (593s left) gem_userptr_blits (map-fixed-invalidate-overlap-busy)
[439.984688] Starting subtest: map-fixed-invalidate-overlap-busy
[439.987776] Subtest map-fixed-invalidate-overlap-busy: SKIP (0.000s)
[440.230789] [083/133] (593s left) kms_psr (fbc-psr2-cursor-plane-move)
[441.716030] Subtest fbc-psr2-cursor-plane-move: SKIP (0.000s)
[441.898241] [084/133] (592s left) kms_ccs (crc-sprite-planes-basic-4-tiled-mtl-rc-ccs)
[443.386135] Starting subtest: crc-sprite-planes-basic-4-tiled-mtl-rc-ccs
[443.387597] Starting dynamic subtest: pipe-A-HDMI-A-4
[443.427493] Dynamic subtest pipe-A-HDMI-A-4: SKIP (0.003s)
[443.438998] Starting dynamic subtest: pipe-B-HDMI-A-4
[443.479304] Dynamic subtest pipe-B-HDMI-A-4: SKIP (0.003s)
[443.490920] Starting dynamic subtest: pipe-C-HDMI-A-4
[443.536081] Dynamic subtest pipe-C-HDMI-A-4: SKIP (0.003s)
[443.547542] Starting dynamic subtest: pipe-D-HDMI-A-4
[443.600988] Dynamic subtest pipe-D-HDMI-A-4: SKIP (0.003s)
[443.605162] Subtest crc-sprite-planes-basic-4-tiled-mtl-rc-ccs: SKIP (0.022s)
[443.707398] [085/133] (590s left) gem_exec_schedule (submit-early-slice)
[443.772398] Starting subtest: submit-early-slice
[443.773918] Starting dynamic subtest: rcs0
[443.836727] Dynamic subtest rcs0: SUCCESS (0.064s)
[443.848171] Starting dynamic subtest: bcs0
[443.881463] Dynamic subtest bcs0: SUCCESS (0.043s)
[443.893470] Starting dynamic subtest: vcs0
[443.926281] Dynamic subtest vcs0: SUCCESS (0.043s)
[443.938187] Starting dynamic subtest: vcs1
[443.973925] Dynamic subtest vcs1: SUCCESS (0.046s)
[443.985730] Starting dynamic subtest: vecs0
[444.018349] Dynamic subtest vecs0: SUCCESS (0.043s)
[444.019874] Subtest submit-early-slice: SUCCESS (0.247s)
[444.451420] [086/133] (589s left) gem_exec_fence (syncobj-unused-fence)
[444.852598] Starting subtest: syncobj-unused-fence
[444.874236] Subtest syncobj-unused-fence: SUCCESS (0.022s)
[445.377975] [087/133] (588s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-mmap-wc)
[446.874440] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-mmap-wc
[446.877709] Subtest fbc-1p-offscreen-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[447.049703] [088/133] (587s left) gem_wait (write-wait)
[447.114144] Starting subtest: write-wait
[447.115811] Starting dynamic subtest: all-engines
[448.209649] Dynamic subtest all-engines: SUCCESS (1.095s)
[448.225980] Starting dynamic subtest: rcs0
[449.269654] Dynamic subtest rcs0: SUCCESS (1.057s)
[449.286793] Starting dynamic subtest: bcs0
[450.329651] Dynamic subtest bcs0: SUCCESS (1.058s)
[450.346222] Starting dynamic subtest: vcs0
[451.388629] Dynamic subtest vcs0: SUCCESS (1.057s)
[451.405693] Starting dynamic subtest: vcs1
[452.447692] Dynamic subtest vcs1: SUCCESS (1.057s)
[452.465170] Starting dynamic subtest: vecs0
[453.509742] Dynamic subtest vecs0: SUCCESS (1.060s)
[453.511572] Subtest write-wait: SUCCESS (6.397s)
[453.825656] [089/133] (580s left) kms_getfb (getfb-handle-valid)
[455.313594] Starting subtest: getfb-handle-valid
[455.315159] Subtest getfb-handle-valid: SUCCESS (0.000s)
[455.505924] [090/133] (579s left) kms_psr (pr-cursor-mmap-gtt)
[456.994212] Subtest pr-cursor-mmap-gtt: SKIP (0.000s)
[457.081305] [091/133] (577s left) syncobj_wait (wait-for-submit-complex)
[457.132401] Starting subtest: wait-for-submit-complex
[457.192078] Subtest wait-for-submit-complex: SUCCESS (0.062s)
[457.349788] [092/133] (577s left) gem_basic (multigpu-create-close)
[457.397865] Starting subtest: multigpu-create-close
[457.400954] Subtest multigpu-create-close: SKIP (0.000s)
[457.581621] [093/133] (577s left) kms_pm_rpm (pc8-residency)
[461.995185] Starting subtest: pc8-residency
[461.998242] Subtest pc8-residency: SKIP (0.000s)
[462.897727] [094/133] (572s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-mmap-wc)
[464.391551] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-mmap-wc
[464.394551] Subtest fbc-1p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[464.576312] [095/133] (570s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0-async-flip)
[466.083427] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0-async-flip
[466.677826] Subtest x-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SUCCESS (0.595s)
[466.959764] [096/133] (568s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-render)
[468.452559] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-render
[468.455580] Subtest psr-2p-scndscrn-spr-indfb-draw-render: SKIP (0.000s)
[468.608497] [097/133] (566s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24)
[470.100599] Starting subtest: compare-crc-sanitycheck-xr24
[470.104489] Starting dynamic subtest: pipe-A-HDMI-A-4
[470.650368] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (0.547s)
[470.664682] Starting dynamic subtest: pipe-B-HDMI-A-4
[471.047732] Dynamic subtest pipe-B-HDMI-A-4: SUCCESS (0.395s)
[471.063458] Starting dynamic subtest: pipe-C-HDMI-A-4
[471.473080] Dynamic subtest pipe-C-HDMI-A-4: SUCCESS (0.419s)
[471.486669] Starting dynamic subtest: pipe-D-HDMI-A-4
[471.854376] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (0.380s)
[471.856098] Subtest compare-crc-sanitycheck-xr24: SUCCESS (1.754s)
[472.028948] [098/133] (563s left) gem_render_copy (yf-tiled-ccs-to-linear)
[472.083498] Starting subtest: yf-tiled-ccs-to-linear
[472.085173] Starting dynamic subtest: smem
[472.172142] Dynamic subtest smem: SUCCESS (0.088s)
[472.184315] Starting dynamic subtest: lmem0
[472.479901] Dynamic subtest lmem0: SUCCESS (0.303s)
[472.481829] Subtest yf-tiled-ccs-to-linear: SUCCESS (0.394s)
[472.832404] [099/133] (562s left) kms_pm_backlight (fade-with-dpms)
[474.322045] Subtest fade-with-dpms: SKIP (0.000s)
[474.403810] [100/133] (561s left) i915_pm_rpm (gem-pread)
[478.020703] Starting subtest: gem-pread
[479.163833] Subtest gem-pread: SUCCESS (1.141s)
[480.042341] [101/133] (555s left) i915_drm_fdinfo (virtual-busy)
[480.101486] Starting subtest: virtual-busy
[480.104602] Subtest virtual-busy: SKIP (0.000s)
[480.207333] [102/133] (555s left) kms_psr2_sf (pr-cursor-plane-update-sf)
[481.697923] Subtest pr-cursor-plane-update-sf: SKIP (0.000s)
[481.774907] [103/133] (554s left) kms_lease (cursor-implicit-plane)
[483.263855] Starting subtest: cursor-implicit-plane
[483.265562] Starting dynamic subtest: pipe-A-HDMI-A-4
[483.682373] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (0.417s)
[483.695539] Starting dynamic subtest: pipe-B-HDMI-A-4
[483.895303] Dynamic subtest pipe-B-HDMI-A-4: SUCCESS (0.211s)
[483.912132] Starting dynamic subtest: pipe-C-HDMI-A-4
[484.127897] Dynamic subtest pipe-C-HDMI-A-4: SUCCESS (0.228s)
[484.141112] Starting dynamic subtest: pipe-D-HDMI-A-4
[484.349079] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (0.218s)
[484.351690] Subtest cursor-implicit-plane: SUCCESS (1.087s)
[484.534985] [104/133] (551s left) syncobj_timeline (wait-any-complex)
[484.583548] Starting subtest: wait-any-complex
[484.646022] Subtest wait-any-complex: SUCCESS (0.063s)
[484.857436] [105/133] (551s left) gem_ctx_persistence (legacy-engines-mixed-process)
[484.911951] Starting subtest: legacy-engines-mixed-process
[484.913312] Starting dynamic subtest: render
[486.896438] Dynamic subtest render: SUCCESS (1.983s)
[486.910895] Starting dynamic subtest: bsd1
[488.882597] Dynamic subtest bsd1: SUCCESS (1.984s)
[488.897487] Starting dynamic subtest: bsd2
[490.866426] Dynamic subtest bsd2: SUCCESS (1.981s)
[490.881611] Starting dynamic subtest: blt
[492.905675] Dynamic subtest blt: SUCCESS (2.037s)
[492.920337] Starting dynamic subtest: vebox
[494.889604] Dynamic subtest vebox: SUCCESS (1.982s)
[494.891390] Subtest legacy-engines-mixed-process: SUCCESS (9.978s)
[495.011500] [106/133] (541s left) kms_flip (plain-flip-ts-check)
[496.511114] Starting subtest: plain-flip-ts-check
[496.518787] Starting dynamic subtest: A-HDMI-A4
[504.542790] Dynamic subtest A-HDMI-A4: SUCCESS (8.024s)
[504.565274] Starting dynamic subtest: B-HDMI-A4
[512.504796] Dynamic subtest B-HDMI-A4: SUCCESS (7.958s)
[512.528108] Starting dynamic subtest: C-HDMI-A4
[520.479642] Dynamic subtest C-HDMI-A4: SUCCESS (7.967s)
[520.494288] Starting dynamic subtest: D-HDMI-A4
[528.440899] Dynamic subtest D-HDMI-A4: SUCCESS (7.959s)
[528.442463] Subtest plain-flip-ts-check: SUCCESS (31.931s)
[528.679934] [107/133] (507s left) kms_invalid_mode (bad-vsync-start)
[530.166217] Starting subtest: bad-vsync-start
[530.167772] Starting dynamic subtest: pipe-A-HDMI-A-4
[530.203571] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (0.037s)
[530.218159] Starting dynamic subtest: pipe-B-HDMI-A-4
[530.219961] Dynamic subtest pipe-B-HDMI-A-4: SUCCESS (0.001s)
[530.232103] Starting dynamic subtest: pipe-C-HDMI-A-4
[530.233941] Dynamic subtest pipe-C-HDMI-A-4: SUCCESS (0.001s)
[530.245621] Starting dynamic subtest: pipe-D-HDMI-A-4
[530.247196] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (0.001s)
[530.248746] Subtest bad-vsync-start: SUCCESS (0.050s)
[530.395104] [108/133] (505s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size)
[531.882203] Starting subtest: basic-flip-before-cursor-varying-size
[532.896113] Subtest basic-flip-before-cursor-varying-size: SUCCESS (1.013s)
[533.077886] [109/133] (503s left) kms_cursor_legacy (flip-vs-cursor-atomic-transitions-varying-size)
[534.564784] Starting subtest: flip-vs-cursor-atomic-transitions-varying-size
[549.764095] Subtest flip-vs-cursor-atomic-transitions-varying-size: SUCCESS (15.202s)
[549.951765] [110/133] (486s left) gem_softpin (overlap)
[550.011753] Starting subtest: overlap
[553.713970] Subtest overlap: SUCCESS (3.701s)
[553.911721] [111/133] (482s left) kms_psr (psr2-sprite-mmap-gtt)
[555.396392] Subtest psr2-sprite-mmap-gtt: SKIP (0.000s)
[555.480198] [112/133] (481s left) kms_frontbuffer_tracking (psr-suspend)
[557.020448] Starting subtest: psr-suspend
[557.023922] Subtest psr-suspend: SKIP (0.000s)
[557.207293] [113/133] (479s left) kms_psr2_sf (psr2-cursor-plane-update-sf)
[558.696207] Subtest psr2-cursor-plane-update-sf: SKIP (0.000s)
[558.770032] [114/133] (477s left) kms_big_fb (y-tiled-16bpp-rotate-270)
[560.274456] Starting subtest: y-tiled-16bpp-rotate-270
[562.059949] Subtest y-tiled-16bpp-rotate-270: SUCCESS (1.782s)
[562.274167] [115/133] (474s left) syncobj_timeline (etime-multi-wait-all-for-submit-available-unsubmitted)
[562.321791] Starting subtest: etime-multi-wait-all-for-submit-available-unsubmitted
[562.433423] Subtest etime-multi-wait-all-for-submit-available-unsubmitted: SUCCESS (0.108s)
[562.602782] [116/133] (474s left) kms_flip (modeset-vs-vblank-race)
[564.090690] Starting subtest: modeset-vs-vblank-race
[564.097945] Starting dynamic subtest: A-HDMI-A4
[567.181360] Dynamic subtest A-HDMI-A4: SUCCESS (3.084s)
[567.199587] Starting dynamic subtest: B-HDMI-A4
[570.205481] Dynamic subtest B-HDMI-A4: SUCCESS (3.022s)
[570.218543] Starting dynamic subtest: C-HDMI-A4
[573.231965] Dynamic subtest C-HDMI-A4: SUCCESS (3.025s)
[573.246356] Starting dynamic subtest: D-HDMI-A4
[576.270474] Dynamic subtest D-HDMI-A4: SUCCESS (3.037s)
[576.272116] Subtest modeset-vs-vblank-race: SUCCESS (12.182s)
[576.497882] [117/133] (460s left) gem_exec_schedule (smoketest-all)
[576.588440] Starting subtest: smoketest-all
[608.886214] Subtest smoketest-all: SUCCESS (32.285s)
[609.350458] [118/133] (427s left) gem_mmap_gtt (basic-small-copy-odd)
[609.404621] Subtest basic-small-copy-odd: SKIP (0.000s)
[609.491168] [119/133] (427s left) gen9_exec_parse (bb-start-cmd)
[609.558051] Subtest bb-start-cmd: SKIP (0.000s)
[609.641619] [120/133] (427s left) gem_mmap_gtt (basic)
[609.692972] Subtest basic: SKIP (0.000s)
[609.780219] [121/133] (427s left) syncobj_timeline (etime-single-wait-available-unsubmitted)
[609.844164] Starting subtest: etime-single-wait-available-unsubmitted
[609.950544] Subtest etime-single-wait-available-unsubmitted: SUCCESS (0.105s)
[610.118418] [122/133] (427s left) gem_exec_alignment (forked)
[610.172251] Starting subtest: forked
[647.178718] Subtest forked: SUCCESS (37.003s)
[647.439098] [123/133] (390s left) kms_getfb (getfb2-handle-zero)
[648.990839] Starting subtest: getfb2-handle-zero
[648.992173] Subtest getfb2-handle-zero: SUCCESS (0.000s)
[649.180393] [124/133] (388s left) kms_plane_scaling (planes-upscale-factor-0-25-downscale-factor-0-75)
[650.666617] Starting subtest: planes-upscale-factor-0-25-downscale-factor-0-75
[650.668214] Starting dynamic subtest: pipe-A
[650.776908] Dynamic subtest pipe-A: SUCCESS (0.112s)
[650.790048] Starting dynamic subtest: pipe-B
[650.916687] Dynamic subtest pipe-B: SUCCESS (0.139s)
[650.931157] Starting dynamic subtest: pipe-C
[651.057011] Dynamic subtest pipe-C: SUCCESS (0.139s)
[651.069572] Starting dynamic subtest: pipe-D
[651.196472] Dynamic subtest pipe-D: SUCCESS (0.138s)
[651.197986] Subtest planes-upscale-factor-0-25-downscale-factor-0-75: SUCCESS (0.533s)
[651.391447] [125/133] (386s left) kms_content_protection (uevent)
[652.965483] Starting subtest: uevent
[652.980252] Subtest uevent: SKIP (0.006s)
[653.173520] [126/133] (384s left) kms_plane_multiple (2x-tiling-x)
[654.679950] Starting subtest: 2x-tiling-x
[654.682965] Subtest 2x-tiling-x: SKIP (0.000s)
[654.794901] [127/133] (383s left) gem_exec_schedule (preempt-contexts)
[654.881719] Starting subtest: preempt-contexts
[654.883281] Starting dynamic subtest: rcs0
[654.966889] Dynamic subtest rcs0: SUCCESS (0.089s)
[654.979320] Starting dynamic subtest: bcs0
[655.036960] Dynamic subtest bcs0: SUCCESS (0.068s)
[655.049272] Starting dynamic subtest: vcs0
[655.105949] Dynamic subtest vcs0: SUCCESS (0.068s)
[655.120490] Starting dynamic subtest: vcs1
[655.175261] Dynamic subtest vcs1: SUCCESS (0.067s)
[655.191450] Starting dynamic subtest: vecs0
[655.245943] Dynamic subtest vecs0: SUCCESS (0.069s)
[655.247862] Subtest preempt-contexts: SUCCESS (0.370s)
[655.708535] [128/133] (382s left) perf_pmu (most-busy-check-all)
[655.761203] Starting subtest: most-busy-check-all
[655.762846] Starting dynamic subtest: rcs0
[656.339079] Dynamic subtest rcs0: SUCCESS (0.577s)
[656.356231] Starting dynamic subtest: bcs0
[656.889016] Dynamic subtest bcs0: SUCCESS (0.547s)
[656.905891] Starting dynamic subtest: vcs0
[657.437863] Dynamic subtest vcs0: SUCCESS (0.547s)
[657.454593] Starting dynamic subtest: vcs1
[657.986859] Dynamic subtest vcs1: SUCCESS (0.547s)
[658.003845] Starting dynamic subtest: vecs0
[658.537105] Dynamic subtest vecs0: SUCCESS (0.548s)
[658.538581] Subtest most-busy-check-all: SUCCESS (2.777s)
[658.662549] [129/133] (379s left) kms_rotation_crc (multiplane-rotation-cropping-top)
[660.150652] Starting subtest: multiplane-rotation-cropping-top
[707.636681] Subtest multiplane-rotation-cropping-top: SUCCESS (47.489s)
[707.885308] [130/133] (330s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-cpu)
[709.399061] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-cpu
[709.404210] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[709.555736] [131/133] (328s left) syncobj_wait (signal)
[709.611014] Starting subtest: signal
[709.614595] Subtest signal: SUCCESS (0.000s)
[709.722327] [132/133] (328s left) kms_plane (pixel-format-y-tiled-ccs-modifier-source-clamping)
[711.211411] Starting subtest: pixel-format-y-tiled-ccs-modifier-source-clamping
[711.214280] Subtest pixel-format-y-tiled-ccs-modifier-source-clamping: SKIP (0.000s)
[711.326728] [133/133] (327s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-render)
[712.822530] Starting subtest: psr-1p-primscrn-cur-indfb-draw-render
[712.825501] Subtest psr-1p-primscrn-cur-indfb-draw-render: SKIP (0.000s)
[712.991157] Closing watchdogs
results: parsing output: 0/ for test: sw_sync
results: parsing output: 1/ for test: gem_busy
results: parsing output: 2/ for test: i915_query
results: parsing output: 3/ for test: gem_userptr_blits
results: parsing output: 4/ for test: perf
results: parsing output: 5/ for test: kms_flip
results: parsing output: 6/ for test: kms_feature_discovery
results: parsing output: 7/ for test: kms_atomic_transition
results: parsing output: 8/ for test: gem_tiled_partial_pwrite_pread
results: parsing output: 9/ for test: kms_plane
results: parsing output: 10/ for test: gem_mmap_offset
results: parsing output: 11/ for test: kms_ccs
results: parsing output: 12/ for test: syncobj_timeline
results: parsing output: 13/ for test: kms_psr2_sf
results: parsing output: 14/ for test: gem_mmap_wc
results: parsing output: 15/ for test: kms_big_fb
results: parsing output: 16/ for test: kms_psr
results: parsing output: 17/ for test: gem_eio
results: parsing output: 18/ for test: kms_cursor_crc
results: parsing output: 19/ for test: kms_busy
results: parsing output: 20/ for test: kms_ccs
results: parsing output: 21/ for test: kms_frontbuffer_tracking
results: parsing output: 22/ for test: kms_big_fb
results: parsing output: 23/ for test: gem_close_race
results: parsing output: 24/ for test: api_intel_allocator
results: parsing output: 25/ for test: kms_frontbuffer_tracking
results: parsing output: 26/ for test: kms_ccs
results: parsing output: 27/ for test: gem_mmap_wc
results: parsing output: 28/ for test: kms_cursor_legacy
results: parsing output: 29/ for test: kms_big_fb
results: parsing output: 30/ for test: kms_cursor_crc
results: parsing output: 31/ for test: gem_exec_fence
results: parsing output: 32/ for test: kms_flip
results: parsing output: 33/ for test: kms_addfb_basic
results: parsing output: 34/ for test: gem_lmem_swapping
results: parsing output: 35/ for test: api_intel_bb
results: parsing output: 36/ for test: kms_vblank
results: parsing output: 37/ for test: kms_fbcon_fbt
results: parsing output: 38/ for test: kms_cursor_crc
results: parsing output: 39/ for test: kms_ccs
results: parsing output: 40/ for test: kms_atomic_interruptible
results: parsing output: 41/ for test: gem_lmem_swapping
results: parsing output: 42/ for test: gem_workarounds
results: parsing output: 43/ for test: kms_chamelium_edid
results: parsing output: 44/ for test: syncobj_timeline
results: parsing output: 45/ for test: gem_exec_reloc
results: parsing output: 46/ for test: gem_userptr_blits
results: parsing output: 47/ for test: kms_universal_plane
results: parsing output: 48/ for test: kms_big_fb
results: parsing output: 49/ for test: gem_ctx_persistence
results: parsing output: 50/ for test: kms_frontbuffer_tracking
results: parsing output: 51/ for test: kms_color
results: parsing output: 52/ for test: gem_exec_capture
results: parsing output: 53/ for test: kms_frontbuffer_tracking
results: parsing output: 54/ for test: gem_render_copy
results: parsing output: 55/ for test: perf
results: parsing output: 56/ for test: kms_frontbuffer_tracking
results: parsing output: 57/ for test: gem_exec_whisper
results: parsing output: 58/ for test: prime_busy
results: parsing output: 59/ for test: gem_exec_balancer
results: parsing output: 60/ for test: gem_mmap_wc
results: parsing output: 61/ for test: sysfs_preempt_timeout
results: parsing output: 62/ for test: kms_frontbuffer_tracking
results: parsing output: 63/ for test: gem_spin_batch
results: parsing output: 64/ for test: dmabuf_sync_file
results: parsing output: 65/ for test: syncobj_wait
results: parsing output: 66/ for test: gem_pread
results: parsing output: 67/ for test: kms_chamelium_hpd
results: parsing output: 68/ for test: kms_frontbuffer_tracking
results: parsing output: 69/ for test: kms_frontbuffer_tracking
results: parsing output: 70/ for test: kms_vrr
results: parsing output: 71/ for test: kms_setmode
results: parsing output: 72/ for test: i915_hangman
results: parsing output: 73/ for test: kms_flip_scaled_crc
results: parsing output: 74/ for test: gem_exec_reloc
results: parsing output: 75/ for test: i915_query
results: parsing output: 76/ for test: kms_setmode
results: parsing output: 77/ for test: kms_frontbuffer_tracking
results: parsing output: 78/ for test: kms_atomic
results: parsing output: 79/ for test: kms_flip_scaled_crc
results: parsing output: 80/ for test: prime_mmap
results: parsing output: 81/ for test: gem_userptr_blits
results: parsing output: 82/ for test: kms_psr
results: parsing output: 83/ for test: kms_ccs
results: parsing output: 84/ for test: gem_exec_schedule
results: parsing output: 85/ for test: gem_exec_fence
results: parsing output: 86/ for test: kms_frontbuffer_tracking
results: parsing output: 87/ for test: gem_wait
results: parsing output: 88/ for test: kms_getfb
results: parsing output: 89/ for test: kms_psr
results: parsing output: 90/ for test: syncobj_wait
results: parsing output: 91/ for test: gem_basic
results: parsing output: 92/ for test: kms_pm_rpm
results: parsing output: 93/ for test: kms_frontbuffer_tracking
results: parsing output: 94/ for test: kms_big_fb
results: parsing output: 95/ for test: kms_frontbuffer_tracking
results: parsing output: 96/ for test: kms_pipe_crc_basic
results: parsing output: 97/ for test: gem_render_copy
results: parsing output: 98/ for test: kms_pm_backlight
results: parsing output: 99/ for test: i915_pm_rpm
results: parsing output: 100/ for test: i915_drm_fdinfo
results: parsing output: 101/ for test: kms_psr2_sf
results: parsing output: 102/ for test: kms_lease
results: parsing output: 103/ for test: syncobj_timeline
results: parsing output: 104/ for test: gem_ctx_persistence
results: parsing output: 105/ for test: kms_flip
results: parsing output: 106/ for test: kms_invalid_mode
results: parsing output: 107/ for test: kms_cursor_legacy
results: parsing output: 108/ for test: kms_cursor_legacy
results: parsing output: 109/ for test: gem_softpin
results: parsing output: 110/ for test: kms_psr
results: parsing output: 111/ for test: kms_frontbuffer_tracking
results: parsing output: 112/ for test: kms_psr2_sf
results: parsing output: 113/ for test: kms_big_fb
results: parsing output: 114/ for test: syncobj_timeline
results: parsing output: 115/ for test: kms_flip
results: parsing output: 116/ for test: gem_exec_schedule
results: parsing output: 117/ for test: gem_mmap_gtt
results: parsing output: 118/ for test: gen9_exec_parse
results: parsing output: 119/ for test: gem_mmap_gtt
results: parsing output: 120/ for test: syncobj_timeline
results: parsing output: 121/ for test: gem_exec_alignment
results: parsing output: 122/ for test: kms_getfb
results: parsing output: 123/ for test: kms_plane_scaling
results: parsing output: 124/ for test: kms_content_protection
results: parsing output: 125/ for test: kms_plane_multiple
results: parsing output: 126/ for test: gem_exec_schedule
results: parsing output: 127/ for test: perf_pmu
results: parsing output: 128/ for test: kms_rotation_crc
results: parsing output: 129/ for test: kms_frontbuffer_tracking
results: parsing output: 130/ for test: syncobj_wait
results: parsing output: 131/ for test: kms_plane
results: parsing output: 132/ for test: kms_frontbuffer_tracking
Done.