[64.205507] Initializing watchdogs
[64.205573]   /dev/watchdog0
[64.225454] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:03:00.0: 8086:56a0 Intel Dg2 (Gen12) DG2 [Arc A770]
[64.236496] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[64.240125] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[64.242401] [001/133] (960s left) kms_color (ctm-0-25)
[64.426510] Starting subtest: ctm-0-25
[64.427435] Starting dynamic subtest: pipe-A-DP-3
[66.241184] Dynamic subtest pipe-A-DP-3: SUCCESS (1.814s)
[66.248951] Starting dynamic subtest: pipe-B-DP-3
[67.776564] Dynamic subtest pipe-B-DP-3: SUCCESS (1.535s)
[67.784354] Starting dynamic subtest: pipe-C-DP-3
[69.396211] Dynamic subtest pipe-C-DP-3: SUCCESS (1.619s)
[69.405600] Starting dynamic subtest: pipe-D-DP-3
[71.056809] Dynamic subtest pipe-D-DP-3: SUCCESS (1.661s)
[71.057818] Subtest ctm-0-25: SUCCESS (6.630s)
[71.395377] [002/133] (953s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu)
[71.575891] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu
[71.577548] Subtest fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[71.776083] [003/133] (953s left) gem_exec_balancer (noheartbeat)
[72.165334] Starting subtest: noheartbeat
[72.167523] Subtest noheartbeat: SKIP (0.000s)
[72.301495] [004/133] (952s left) kms_cursor_legacy (cursorb-vs-flipb-atomic-transitions)
[72.476928] Starting subtest: cursorB-vs-flipB-atomic-transitions
[72.478861] Subtest cursorB-vs-flipB-atomic-transitions: SKIP (0.001s)
[72.593601] [005/133] (952s left) kms_busy (extended-pageflip-hang-oldfb)
[72.777456] Starting subtest: extended-pageflip-hang-oldfb
[72.779422] Starting dynamic subtest: pipe-A
[73.035869] Dynamic subtest pipe-A: SUCCESS (0.256s)
[73.057969] Starting dynamic subtest: pipe-D
[73.291243] Dynamic subtest pipe-D: SUCCESS (0.247s)
[73.292272] Subtest extended-pageflip-hang-oldfb: SUCCESS (0.514s)
[73.641199] [006/133] (951s left) kms_draw_crc (draw-method-mmap-wc)
[73.819902] Starting subtest: draw-method-mmap-wc
[73.821659] Subtest draw-method-mmap-wc: SKIP (0.000s)
[74.004291] [007/133] (951s left) kms_content_protection (uevent)
[74.244061] Starting subtest: uevent
[74.278837] Starting dynamic subtest: pipe-A-DP-3
[108.490582] Dynamic subtest pipe-A-DP-3: FAIL (34.165s)
[108.552103] Subtest uevent: FAIL (34.309s)
[108.825098] [008/133] (916s left) kms_cursor_crc (cursor-rapid-movement-32x32)
[109.097389] Starting subtest: cursor-rapid-movement-32x32
[109.148718] Subtest cursor-rapid-movement-32x32: SKIP (0.049s)
[109.624249] [009/133] (915s left) gem_render_copy (y-tiled-ccs-to-y-tiled-ccs)
[109.695515] Starting subtest: y-tiled-ccs-to-y-tiled-ccs
[109.697370] Subtest y-tiled-ccs-to-y-tiled-ccs: SKIP (0.000s)
[109.939937] [010/133] (915s left) gem_exec_fence (syncobj-import)
[110.499741] Starting subtest: syncobj-import
[110.532817] Subtest syncobj-import: SUCCESS (0.033s)
[110.942210] [FACT gem_exec_fence (syncobj-import)] new: kernel.kmod_is_loaded.vgem: true
[110.944167] [011/133] (914s left) gem_exec_flush (basic-wb-pro-default)
[111.027169] Subtest basic-wb-pro-default: SKIP (0.000s)
[111.088594] [012/133] (914s left) gem_exec_schedule (preempt-other)
[111.180071] Starting subtest: preempt-other
[111.180979] Starting dynamic subtest: rcs0
[111.733930] Dynamic subtest rcs0: SUCCESS (0.554s)
[111.742788] Starting dynamic subtest: bcs0
[112.266865] Dynamic subtest bcs0: SUCCESS (0.533s)
[112.275579] Starting dynamic subtest: vcs0
[112.802364] Dynamic subtest vcs0: SUCCESS (0.535s)
[112.810930] Starting dynamic subtest: vcs1
[113.355098] Dynamic subtest vcs1: SUCCESS (0.552s)
[113.364134] Starting dynamic subtest: vecs0
[113.894209] Dynamic subtest vecs0: SUCCESS (0.539s)
[113.902987] Starting dynamic subtest: vecs1
[114.422906] Dynamic subtest vecs1: SUCCESS (0.528s)
[114.431518] Starting dynamic subtest: ccs0
[114.968768] Dynamic subtest ccs0: SUCCESS (0.546s)
[114.969904] Subtest preempt-other: SUCCESS (3.790s)
[115.391981] [013/133] (910s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-blt)
[115.581495] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-blt
[115.583118] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[115.756063] [014/133] (909s left) gem_fence_thrash (bo-write-verify-threaded-y)
[115.801998] Starting subtest: bo-write-verify-threaded-y
[115.836805] Subtest bo-write-verify-threaded-y: SKIP (0.034s)
[115.908175] [015/133] (909s left) kms_addfb_basic (invalid-set-prop-any)
[115.983921] Starting subtest: invalid-set-prop-any
[115.984809] Subtest invalid-set-prop-any: SUCCESS (0.000s)
[116.294034] [016/133] (909s left) gem_pxp (reject-modify-context-protection-off-3)
[118.895160] Starting subtest: reject-modify-context-protection-off-3
[118.898245] Subtest reject-modify-context-protection-off-3: SKIP (0.000s)
[119.042372] [017/133] (906s left) gem_exec_schedule (fairslice-all)
[119.130932] Starting subtest: fairslice-all
[121.249325] Subtest fairslice-all: SUCCESS (2.119s)
[121.661635] [018/133] (904s left) kms_chamelium_edid (dp-mode-timings)
[121.926526] Subtest dp-mode-timings: SKIP (0.000s)
[122.110719] [019/133] (903s left) kms_ccs (crc-primary-rotation-180-4-tiled-mtl-mc-ccs)
[122.295161] Starting subtest: crc-primary-rotation-180-4-tiled-mtl-mc-ccs
[122.296046] Starting dynamic subtest: pipe-A-DP-3
[122.304486] Dynamic subtest pipe-A-DP-3: SKIP (0.001s)
[122.313275] Starting dynamic subtest: pipe-B-DP-3
[122.321532] Dynamic subtest pipe-B-DP-3: SKIP (0.001s)
[122.329970] Starting dynamic subtest: pipe-C-DP-3
[122.338122] Dynamic subtest pipe-C-DP-3: SKIP (0.001s)
[122.346467] Starting dynamic subtest: pipe-D-DP-3
[122.356217] Dynamic subtest pipe-D-DP-3: SKIP (0.001s)
[122.358365] Subtest crc-primary-rotation-180-4-tiled-mtl-mc-ccs: SKIP (0.006s)
[122.766281] [020/133] (903s left) gem_ctx_param (invalid-get-no-zeromap)
[122.852441] Starting subtest: invalid-get-no-zeromap
[122.854260] Subtest invalid-get-no-zeromap: SUCCESS (0.001s)
[123.002489] [021/133] (903s left) kms_frontbuffer_tracking (psr-1p-primscrn-indfb-msflip-blt)
[123.195649] Starting subtest: psr-1p-primscrn-indfb-msflip-blt
[123.197326] Subtest psr-1p-primscrn-indfb-msflip-blt: SKIP (0.000s)
[123.381500] [022/133] (902s left) i915_pm_rps (thresholds-idle)
[123.465226] Starting subtest: thresholds-idle
[123.467047] Subtest thresholds-idle: SKIP (0.000s)
[123.676360] [023/133] (902s left) gem_close (many-handles-one-vma)
[123.757220] Starting subtest: many-handles-one-vma
[123.785513] Subtest many-handles-one-vma: SUCCESS (0.028s)
[123.981142] [024/133] (902s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-shrfb-msflip-blt)
[124.171590] Starting subtest: fbcpsr-2p-primscrn-shrfb-msflip-blt
[124.173239] Subtest fbcpsr-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[124.339838] [025/133] (902s left) kms_chamelium_hpd (hdmi-hpd-with-enabled-mode)
[124.614621] Subtest hdmi-hpd-with-enabled-mode: SKIP (0.000s)
[124.765010] [026/133] (901s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-0-hflip)
[124.963526] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-0-hflip
[124.965256] Subtest y-tiled-max-hw-stride-32bpp-rotate-0-hflip: SKIP (0.000s)
[125.138026] [027/133] (901s left) gem_mmap_offset (clear-via-pagefault)
[125.215074] Starting subtest: clear-via-pagefault
[125.216098] Starting dynamic subtest: lmem0
[149.092766] Dynamic subtest lmem0: SUCCESS (23.871s)
[149.101561] Starting dynamic subtest: smem0
[172.527464] Dynamic subtest smem0: SUCCESS (23.438s)
[172.528384] Subtest clear-via-pagefault: SUCCESS (47.309s)
[172.678702] [028/133] (853s left) kms_pipe_b_c_ivb (disable-pipe-b-enable-pipe-c)
[172.767155] Subtest disable-pipe-B-enable-pipe-C: SKIP (0.000s)
[172.844695] [029/133] (853s left) kms_psr (pr-sprite-render)
[173.026741] Subtest pr-sprite-render: SKIP (0.000s)
[173.090711] [030/133] (853s left) gem_exec_reloc (basic-cpu-read-noreloc)
[173.173151] Subtest basic-cpu-read-noreloc: SKIP (0.000s)
[173.262139] [031/133] (853s left) kms_setmode (basic-clone-single-crtc)
[173.339154] Starting subtest: basic-clone-single-crtc
[173.342073] Subtest basic-clone-single-crtc: SKIP (0.000s)
[173.524262] [032/133] (853s left) gem_exec_alignment (pi-isolated)
[173.607497] Starting subtest: pi-isolated
[190.501298] Subtest pi-isolated: SUCCESS (16.892s)
[191.028039] [033/133] (835s left) gem_ctx_persistence (heartbeat-hang)
[191.158506] Starting subtest: heartbeat-hang
[191.160480] Subtest heartbeat-hang: SKIP (0.000s)
[191.339481] [034/133] (835s left) kms_display_modes (extended-mode-basic)
[191.529764] Starting subtest: extended-mode-basic
[191.533015] Subtest extended-mode-basic: SKIP (0.000s)
[191.592862] [035/133] (835s left) kms_plane (plane-position-hole)
[191.776971] Starting subtest: plane-position-hole
[192.214441] Starting dynamic subtest: pipe-A-plane-1
[192.684975] Dynamic subtest pipe-A-plane-1: SUCCESS (0.470s)
[192.696244] Starting dynamic subtest: pipe-A-plane-2
[193.143057] Dynamic subtest pipe-A-plane-2: SUCCESS (0.458s)
[193.155213] Starting dynamic subtest: pipe-A-plane-3
[193.604982] Dynamic subtest pipe-A-plane-3: SUCCESS (0.462s)
[193.616278] Starting dynamic subtest: pipe-A-plane-4
[194.034216] Dynamic subtest pipe-A-plane-4: SUCCESS (0.429s)
[194.044886] Starting dynamic subtest: pipe-A-plane-5
[194.057232] Dynamic subtest pipe-A-plane-5: SUCCESS (0.022s)
[194.420522] Starting dynamic subtest: pipe-B-plane-1
[194.837836] Dynamic subtest pipe-B-plane-1: SUCCESS (0.428s)
[194.848752] Starting dynamic subtest: pipe-B-plane-2
[195.293601] Dynamic subtest pipe-B-plane-2: SUCCESS (0.456s)
[195.303078] Starting dynamic subtest: pipe-B-plane-3
[195.746632] Dynamic subtest pipe-B-plane-3: SUCCESS (0.453s)
[195.756396] Starting dynamic subtest: pipe-B-plane-4
[196.149603] Dynamic subtest pipe-B-plane-4: SUCCESS (0.403s)
[196.159570] Starting dynamic subtest: pipe-B-plane-5
[196.170599] Dynamic subtest pipe-B-plane-5: SUCCESS (0.020s)
[196.171483] Subtest plane-position-hole: SUCCESS (4.394s)
[196.439586] [036/133] (830s left) kms_pm_backlight (bad-brightness)
[196.625415] Subtest bad-brightness: SKIP (0.000s)
[196.686480] [037/133] (830s left) syncobj_timeline (multi-wait-available-unsubmitted-signaled)
[196.772229] Starting subtest: multi-wait-available-unsubmitted-signaled
[196.773159] Subtest multi-wait-available-unsubmitted-signaled: SUCCESS (0.001s)
[196.907728] [038/133] (830s left) kms_mmap_write_crc (main)
[197.102973] Starting subtest: main
[197.103970] Starting dynamic subtest: pipe-A-DP-3
[200.862268] Dynamic subtest pipe-A-DP-3: SUCCESS (3.758s)
[200.864935] Subtest main: SUCCESS (3.760s)
[201.190140] [039/133] (826s left) gem_spin_batch (resubmit-new-all)
[201.277575] Starting subtest: resubmit-new-all
[201.278502] Starting dynamic subtest: rcs0
[201.315150] Dynamic subtest rcs0: SUCCESS (0.037s)
[201.325081] Starting dynamic subtest: bcs0
[201.325999] Dynamic subtest bcs0: SUCCESS (0.009s)
[201.335443] Starting dynamic subtest: vcs0
[201.336315] Dynamic subtest vcs0: SUCCESS (0.008s)
[201.345915] Starting dynamic subtest: vcs1
[201.346821] Dynamic subtest vcs1: SUCCESS (0.010s)
[201.356528] Starting dynamic subtest: vecs0
[201.357423] Dynamic subtest vecs0: SUCCESS (0.009s)
[201.366742] Starting dynamic subtest: vecs1
[201.367562] Dynamic subtest vecs1: SUCCESS (0.008s)
[201.377240] Starting dynamic subtest: ccs0
[201.378273] Dynamic subtest ccs0: SUCCESS (0.009s)
[201.379297] Subtest resubmit-new-all: SUCCESS (0.093s)
[201.755109] [040/133] (825s left) kms_flip (flip-vs-rmfb-interruptible)
[201.943083] Starting subtest: flip-vs-rmfb-interruptible
[201.946532] Starting dynamic subtest: A-DP3
[209.764972] Dynamic subtest A-DP3: SUCCESS (7.817s)
[209.801846] Starting dynamic subtest: B-DP3
[217.509662] Dynamic subtest B-DP3: SUCCESS (7.741s)
[217.536705] Starting dynamic subtest: C-DP3
[225.264354] Dynamic subtest C-DP3: SUCCESS (7.752s)
[225.300589] Starting dynamic subtest: D-DP3
[233.003190] Dynamic subtest D-DP3: SUCCESS (7.734s)
[233.010571] Subtest flip-vs-rmfb-interruptible: SUCCESS (31.067s)
[233.382781] [041/133] (794s left) kms_rotation_crc (sprite-rotation-180)
[233.568261] Starting subtest: sprite-rotation-180
[243.781791] Subtest sprite-rotation-180: SUCCESS (10.213s)
[244.221455] [042/133] (783s left) gem_exec_alignment (single)
[244.307793] Starting subtest: single
[244.314217] Subtest single: SUCCESS (0.006s)
[244.486433] [043/133] (783s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180-hflip)
[244.681165] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180-hflip
[245.940653] Subtest x-tiled-max-hw-stride-32bpp-rotate-180-hflip: SUCCESS (1.259s)
[246.170302] [044/133] (781s left) kms_frontbuffer_tracking (psr-1p-primscrn-shrfb-plflip-blt)
[246.360952] Starting subtest: psr-1p-primscrn-shrfb-plflip-blt
[246.362696] Subtest psr-1p-primscrn-shrfb-plflip-blt: SKIP (0.000s)
[246.573018] [045/133] (781s left) syncobj_wait (invalid-signal-zero-handles)
[246.651208] Starting subtest: invalid-signal-zero-handles
[246.652135] Subtest invalid-signal-zero-handles: SUCCESS (0.000s)
[246.820313] [046/133] (781s left) kms_async_flips (alternate-sync-async-flip)
[247.009252] Starting subtest: alternate-sync-async-flip
[247.244968] Starting dynamic subtest: pipe-A-DP-3
[249.536698] Dynamic subtest pipe-A-DP-3: SUCCESS (2.292s)
[249.781780] Starting dynamic subtest: pipe-B-DP-3
[251.908615] Dynamic subtest pipe-B-DP-3: SUCCESS (2.137s)
[252.121206] Starting dynamic subtest: pipe-C-DP-3
[254.246565] Dynamic subtest pipe-C-DP-3: SUCCESS (2.134s)
[254.455372] Starting dynamic subtest: pipe-D-DP-3
[256.579819] Dynamic subtest pipe-D-DP-3: SUCCESS (2.133s)
[256.583399] Subtest alternate-sync-async-flip: SUCCESS (9.573s)
[257.080652] [047/133] (770s left) kms_frontbuffer_tracking (fbcpsr-1p-rte)
[257.269841] Starting subtest: fbcpsr-1p-rte
[257.271389] Subtest fbcpsr-1p-rte: SKIP (0.000s)
[257.477660] [048/133] (770s left) perf (gen12-group-exclusive-stream-ctx-handle)
[257.874118] Starting subtest: gen12-group-exclusive-stream-ctx-handle
[257.900455] Subtest gen12-group-exclusive-stream-ctx-handle: SUCCESS (0.026s)
[257.958409] [049/133] (770s left) gem_render_copy_redux (flink-interruptible)
[258.044221] Starting subtest: flink-interruptible
[261.161546] Subtest flink-interruptible: SUCCESS (3.117s)
[261.422785] [050/133] (766s left) gem_userptr_blits (probe)
[261.520273] Starting subtest: probe
[261.647489] Subtest probe: SUCCESS (0.117s)
[261.787232] [051/133] (766s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-shrfb-msflip-blt)
[261.977061] Starting subtest: fbc-2p-scndscrn-shrfb-msflip-blt
[261.978750] Subtest fbc-2p-scndscrn-shrfb-msflip-blt: SKIP (0.000s)
[262.159423] [052/133] (766s left) gem_lmem_swapping (heavy-verify-multi-ccs)
[265.022438] Starting subtest: heavy-verify-multi-ccs
[265.023323] Starting dynamic subtest: lmem0
[277.054140] Dynamic subtest lmem0: SUCCESS (12.033s)
[277.055180] Subtest heavy-verify-multi-ccs: SUCCESS (12.035s)
[278.581360] [FACT gem_lmem_swapping (heavy-verify-multi-ccs)] deleted: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[278.582307] [FACT gem_lmem_swapping (heavy-verify-multi-ccs)] deleted: kernel.kmod_is_loaded.i915: true
[278.584373] [053/133] (749s left) core_getclient (basic)
[280.179889] Starting subtest: basic
[280.180903] Subtest basic: SUCCESS (0.000s)
[280.284890] [FACT core_getclient (basic)] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[280.287498] [FACT core_getclient (basic)] new: kernel.kmod_is_loaded.i915: true
[280.290414] [054/133] (748s left) kms_cursor_crc (cursor-onscreen-128x128)
[280.676605] Starting subtest: cursor-onscreen-128x128
[280.692120] Starting dynamic subtest: pipe-A-DP-3
[283.285308] Dynamic subtest pipe-A-DP-3: SUCCESS (2.592s)
[283.322805] Starting dynamic subtest: pipe-D-DP-3
[286.002746] Dynamic subtest pipe-D-DP-3: SUCCESS (2.689s)
[286.003590] Subtest cursor-onscreen-128x128: SUCCESS (5.326s)
[286.476758] [055/133] (742s left) kms_plane_lowres (tiling-y)
[286.662287] Starting subtest: tiling-y
[286.663987] Subtest tiling-y: SKIP (0.000s)
[286.822058] [056/133] (741s left) api_intel_allocator (gem-pool)
[286.898636] Starting subtest: gem-pool
[286.932386] Subtest gem-pool: SUCCESS (0.035s)
[287.137939] [057/133] (741s left) i915_drm_fdinfo (isolation)
[287.212408] Starting subtest: isolation
[287.213347] Starting dynamic subtest: rcs0
[287.215089] Dynamic subtest rcs0: SKIP (0.000s)
[287.224560] Starting dynamic subtest: bcs0
[287.226509] Dynamic subtest bcs0: SKIP (0.000s)
[287.235502] Starting dynamic subtest: vcs0
[287.237235] Dynamic subtest vcs0: SKIP (0.000s)
[287.246534] Starting dynamic subtest: vcs1
[287.248538] Dynamic subtest vcs1: SKIP (0.000s)
[287.257767] Starting dynamic subtest: vecs0
[287.259770] Dynamic subtest vecs0: SKIP (0.000s)
[287.269100] Starting dynamic subtest: vecs1
[287.271501] Dynamic subtest vecs1: SKIP (0.000s)
[287.280528] Starting dynamic subtest: ccs0
[287.282522] Dynamic subtest ccs0: SKIP (0.014s)
[287.284458] Subtest isolation: SKIP (0.024s)
[287.354912] [058/133] (741s left) gem_exec_parallel (basic)
[287.443457] Starting subtest: basic
[287.444433] Starting dynamic subtest: rcs0
[288.993146] Dynamic subtest rcs0: SUCCESS (1.549s)
[289.003890] Starting dynamic subtest: bcs0
[290.467479] Dynamic subtest bcs0: SUCCESS (1.473s)
[290.480428] Starting dynamic subtest: vcs0
[291.943103] Dynamic subtest vcs0: SUCCESS (1.474s)
[291.953959] Starting dynamic subtest: vcs1
[293.470468] Dynamic subtest vcs1: SUCCESS (1.526s)
[293.483723] Starting dynamic subtest: vecs0
[294.967571] Dynamic subtest vecs0: SUCCESS (1.496s)
[294.980203] Starting dynamic subtest: vecs1
[296.447320] Dynamic subtest vecs1: SUCCESS (1.478s)
[296.458309] Starting dynamic subtest: ccs0
[297.919406] Dynamic subtest ccs0: SUCCESS (1.471s)
[297.920412] Subtest basic: SUCCESS (10.476s)
[298.210592] [059/133] (730s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-mmap-cpu)
[298.401243] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-mmap-cpu
[298.402963] Subtest fbc-2p-scndscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[298.600694] [060/133] (730s left) kms_getfb (getfb-handle-valid)
[298.784736] Starting subtest: getfb-handle-valid
[298.785585] Subtest getfb-handle-valid: SUCCESS (0.000s)
[298.999977] [061/133] (729s left) perf (invalid-remove-userspace-config)
[299.425432] Starting subtest: invalid-remove-userspace-config
[299.434575] Subtest invalid-remove-userspace-config: SUCCESS (0.009s)
[299.485845] [062/133] (729s left) kms_psr2_sf (pr-primary-plane-update-sf-dmg-area)
[299.675484] Subtest pr-primary-plane-update-sf-dmg-area: SKIP (0.000s)
[299.732292] [063/133] (729s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-mmap-cpu)
[299.918167] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-mmap-cpu
[299.919930] Subtest fbc-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[300.122203] [064/133] (729s left) kms_ccs (bad-rotation-90-4-tiled-dg2-rc-ccs-cc)
[300.309274] Starting subtest: bad-rotation-90-4-tiled-dg2-rc-ccs-cc
[300.310178] Starting dynamic subtest: pipe-A-DP-3
[300.318383] Dynamic subtest pipe-A-DP-3: SKIP (0.000s)
[300.327776] Starting dynamic subtest: pipe-B-DP-3
[300.336118] Dynamic subtest pipe-B-DP-3: SKIP (0.000s)
[300.345207] Starting dynamic subtest: pipe-C-DP-3
[300.353239] Dynamic subtest pipe-C-DP-3: SKIP (0.000s)
[300.362633] Starting dynamic subtest: pipe-D-DP-3
[300.372574] Dynamic subtest pipe-D-DP-3: SKIP (0.000s)
[300.374443] Subtest bad-rotation-90-4-tiled-dg2-rc-ccs-cc: SKIP (0.007s)
[300.799419] [065/133] (728s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-blt)
[301.001157] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-blt
[301.002906] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-blt: SKIP (0.000s)
[301.184633] [066/133] (728s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-indfb-msflip-blt)
[301.379026] Starting subtest: fbcpsr-2p-scndscrn-indfb-msflip-blt
[301.380779] Subtest fbcpsr-2p-scndscrn-indfb-msflip-blt: SKIP (0.000s)
[301.532750] [067/133] (727s left) kms_pm_rpm (cursor-dpms)
[303.043698] Starting subtest: cursor-dpms
[303.046187] Subtest cursor-dpms: SKIP (0.000s)
[303.459896] [068/133] (725s left) gem_ccs (block-multicopy-inplace)
[303.547475] Starting subtest: block-multicopy-inplace
[303.549837] Starting dynamic subtest: linear-compressed-compfmt0-smem-lmem0-multicopy
[303.595522] Dynamic subtest linear-compressed-compfmt0-smem-lmem0-multicopy: SUCCESS (0.047s)
[303.606368] Starting dynamic subtest: linear-compressed-compfmt0-lmem0-lmem0-multicopy
[303.695408] Dynamic subtest linear-compressed-compfmt0-lmem0-lmem0-multicopy: SUCCESS (0.099s)
[303.706198] Starting dynamic subtest: xmajor-compressed-compfmt0-smem-lmem0-multicopy
[303.710751] Dynamic subtest xmajor-compressed-compfmt0-smem-lmem0-multicopy: SUCCESS (0.014s)
[303.721578] Starting dynamic subtest: xmajor-compressed-compfmt0-lmem0-lmem0-multicopy
[303.810537] Dynamic subtest xmajor-compressed-compfmt0-lmem0-lmem0-multicopy: SUCCESS (0.099s)
[303.821506] Starting dynamic subtest: tile4-compressed-compfmt0-smem-lmem0-multicopy
[303.826275] Dynamic subtest tile4-compressed-compfmt0-smem-lmem0-multicopy: SUCCESS (0.014s)
[303.837090] Starting dynamic subtest: tile4-compressed-compfmt0-lmem0-lmem0-multicopy
[303.931117] Dynamic subtest tile4-compressed-compfmt0-lmem0-lmem0-multicopy: SUCCESS (0.104s)
[303.941969] Starting dynamic subtest: tile64-compressed-compfmt0-smem-lmem0-multicopy
[303.946492] Dynamic subtest tile64-compressed-compfmt0-smem-lmem0-multicopy: SUCCESS (0.014s)
[303.957288] Starting dynamic subtest: tile64-compressed-compfmt0-lmem0-lmem0-multicopy
[304.046127] Dynamic subtest tile64-compressed-compfmt0-lmem0-lmem0-multicopy: SUCCESS (0.098s)
[304.047076] Subtest block-multicopy-inplace: SUCCESS (0.499s)
[304.220492] [069/133] (725s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0)
[304.416581] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0
[304.418269] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0: SKIP (0.000s)
[304.602710] [070/133] (724s left) kms_cursor_edge_walk (64x64-top-bottom)
[304.789368] Starting subtest: 64x64-top-bottom
[304.790257] Starting dynamic subtest: pipe-A-DP-3
[308.241897] Dynamic subtest pipe-A-DP-3: SUCCESS (3.451s)
[308.251463] Starting dynamic subtest: pipe-D-DP-3
[311.557232] Dynamic subtest pipe-D-DP-3: SUCCESS (3.313s)
[311.558260] Subtest 64x64-top-bottom: SUCCESS (6.768s)
[311.890741] [071/133] (717s left) syncobj_timeline (invalid-single-wait-all-unsubmitted)
[311.966350] Starting subtest: invalid-single-wait-all-unsubmitted
[311.967264] Subtest invalid-single-wait-all-unsubmitted: SUCCESS (0.000s)
[312.140405] [072/133] (717s left) gem_exec_capture (pi)
[312.225846] Starting subtest: pi
[312.226695] Starting dynamic subtest: rcs0
[318.117166] Dynamic subtest rcs0: SUCCESS (5.889s)
[318.129210] Starting dynamic subtest: bcs0
[323.795638] Dynamic subtest bcs0: SUCCESS (5.677s)
[323.805301] Starting dynamic subtest: vcs0
[329.490236] Dynamic subtest vcs0: SUCCESS (5.695s)
[329.499803] Starting dynamic subtest: vcs1
[335.321330] Dynamic subtest vcs1: SUCCESS (5.829s)
[335.331108] Starting dynamic subtest: vecs0
[341.108682] Dynamic subtest vecs0: SUCCESS (5.786s)
[341.118453] Starting dynamic subtest: vecs1
[346.836164] Dynamic subtest vecs1: SUCCESS (5.726s)
[346.846055] Starting dynamic subtest: ccs0
[352.650211] Dynamic subtest ccs0: SUCCESS (5.811s)
[352.651262] Subtest pi: SUCCESS (40.422s)
[352.815499] [073/133] (676s left) kms_plane (pixel-format-y-tiled-gen12-rc-ccs-cc-modifier-source-clamping)
[353.056863] Starting subtest: pixel-format-y-tiled-gen12-rc-ccs-cc-modifier-source-clamping
[353.058545] Subtest pixel-format-y-tiled-gen12-rc-ccs-cc-modifier-source-clamping: SKIP (0.000s)
[353.212791] [074/133] (676s left) kms_hdr (static-swap)
[353.399467] Starting subtest: static-swap
[357.007674] Starting dynamic subtest: pipe-A-DP-3
[358.227806] Dynamic subtest pipe-A-DP-3: SUCCESS (1.219s)
[358.229527] Subtest static-swap: SUCCESS (4.830s)
[358.622970] [075/133] (671s left) syncobj_wait (wait-for-submit-delayed-submit)
[358.712674] Starting subtest: wait-for-submit-delayed-submit
[358.814911] Subtest wait-for-submit-delayed-submit: SUCCESS (0.103s)
[358.948154] [076/133] (671s left) kms_vrr (flip-dpms)
[359.132342] Starting subtest: flip-dpms
[359.134955] Subtest flip-dpms: SKIP (0.000s)
[359.290657] [077/133] (670s left) kms_big_fb (linear-addfb)
[359.488196] Starting subtest: linear-addfb
[359.489185] Subtest linear-addfb: SUCCESS (0.000s)
[359.644671] [078/133] (670s left) kms_addfb_basic (addfb25-bad-modifier)
[359.830395] Starting subtest: addfb25-bad-modifier
[359.831263] Subtest addfb25-bad-modifier: SUCCESS (0.000s)
[360.023440] [079/133] (670s left) kms_psr (psr-sprite-plane-onoff)
[360.206260] Subtest psr-sprite-plane-onoff: SKIP (0.000s)
[360.265383] [080/133] (670s left) kms_psr (fbc-psr-sprite-plane-move)
[360.448686] Subtest fbc-psr-sprite-plane-move: SKIP (0.000s)
[360.515925] [081/133] (669s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-blt)
[360.705114] Starting subtest: fbcpsr-rgb101010-draw-blt
[360.706849] Subtest fbcpsr-rgb101010-draw-blt: SKIP (0.000s)
[360.884183] [082/133] (669s left) kms_prop_blob (invalid-get-prop)
[360.960499] Starting subtest: invalid-get-prop
[360.961382] Subtest invalid-get-prop: SUCCESS (0.000s)
[361.155224] [083/133] (669s left) sysfs_preempt_timeout (idempotent)
[361.246290] Starting subtest: idempotent
[361.247205] Starting dynamic subtest: vecs0
[361.248157] Dynamic subtest vecs0: SUCCESS (0.001s)
[361.257942] Starting dynamic subtest: ccs0
[361.258887] Dynamic subtest ccs0: SUCCESS (0.001s)
[361.268555] Starting dynamic subtest: vcs0
[361.269559] Dynamic subtest vcs0: SUCCESS (0.001s)
[361.279557] Starting dynamic subtest: bcs0
[361.280831] Dynamic subtest bcs0: SUCCESS (0.001s)
[361.290256] Starting dynamic subtest: vecs1
[361.291484] Dynamic subtest vecs1: SUCCESS (0.001s)
[361.301190] Starting dynamic subtest: rcs0
[361.302420] Dynamic subtest rcs0: SUCCESS (0.001s)
[361.311774] Starting dynamic subtest: vcs1
[361.312867] Dynamic subtest vcs1: SUCCESS (0.001s)
[361.314047] Subtest idempotent: SUCCESS (0.013s)
[361.370421] [084/133] (669s left) kms_psr (fbc-pr-primary-page-flip)
[361.556061] Subtest fbc-pr-primary-page-flip: SKIP (0.000s)
[361.615641] [085/133] (669s left) gem_exec_reloc (basic-gtt-active)
[361.699277] Subtest basic-gtt-active: SKIP (0.000s)
[361.783525] [086/133] (668s left) kms_chamelium_color (ctm-0-75)
[361.967364] Subtest ctm-0-75: SKIP (0.000s)
[362.032123] [087/133] (668s left) kms_flip_scaled_crc (flip-64bpp-linear-to-16bpp-linear-upscaling)
[362.216920] Starting subtest: flip-64bpp-linear-to-16bpp-linear-upscaling
[362.219338] Starting dynamic subtest: pipe-A-valid-mode
[364.068959] Dynamic subtest pipe-A-valid-mode: SUCCESS (1.848s)
[364.070356] Subtest flip-64bpp-linear-to-16bpp-linear-upscaling: SUCCESS (1.852s)
[364.391085] [088/133] (666s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-move)
[364.580762] Starting subtest: fbc-1p-primscrn-spr-indfb-move
[368.111864] Subtest fbc-1p-primscrn-spr-indfb-move: SUCCESS (3.532s)
[368.377571] [089/133] (662s left) kms_frontbuffer_tracking (psr-indfb-scaledprimary)
[368.571985] Starting subtest: psr-indfb-scaledprimary
[368.573699] Subtest psr-indfb-scaledprimary: SKIP (0.000s)
[368.761018] [090/133] (662s left) kms_big_fb (linear-max-hw-stride-64bpp-rotate-180-hflip)
[368.955694] Starting subtest: linear-max-hw-stride-64bpp-rotate-180-hflip
[368.957385] Subtest linear-max-hw-stride-64bpp-rotate-180-hflip: SKIP (0.000s)
[369.142614] [091/133] (661s left) syncobj_eventfd (timeline-wait)
[369.221494] Starting subtest: timeline-wait
[369.231823] Subtest timeline-wait: SUCCESS (0.010s)
[369.379897] [092/133] (661s left) gem_sync (basic-store-each)
[369.470718] Starting subtest: basic-store-each
[372.521349] Subtest basic-store-each: SUCCESS (3.050s)
[372.829143] [093/133] (658s left) core_getversion (all-cards)
[372.892254] Starting subtest: all-cards
[372.927494] Subtest all-cards: SUCCESS (0.037s)
[372.988905] [094/133] (658s left) gem_ctx_exec (basic-invalid-context)
[373.071417] Starting subtest: basic-invalid-context
[373.076120] Subtest basic-invalid-context: SUCCESS (0.005s)
[373.262676] [095/133] (658s left) kms_frontbuffer_tracking (fbc-1p-primscrn-shrfb-msflip-blt)
[373.453232] Starting subtest: fbc-1p-primscrn-shrfb-msflip-blt
[376.295602] Subtest fbc-1p-primscrn-shrfb-msflip-blt: SUCCESS (2.843s)
[376.561044] [096/133] (654s left) kms_prop_blob (blob-multiple)
[376.638443] Starting subtest: blob-multiple
[376.669500] Subtest blob-multiple: SUCCESS (0.031s)
[376.877706] [097/133] (654s left) kms_invalid_mode (zero-clock)
[377.072155] Starting subtest: zero-clock
[377.073050] Starting dynamic subtest: pipe-A-DP-3
[377.154203] Dynamic subtest pipe-A-DP-3: SUCCESS (0.081s)
[377.167597] Starting dynamic subtest: pipe-B-DP-3
[377.168784] Dynamic subtest pipe-B-DP-3: SUCCESS (0.001s)
[377.181824] Starting dynamic subtest: pipe-C-DP-3
[377.183033] Dynamic subtest pipe-C-DP-3: SUCCESS (0.001s)
[377.195229] Starting dynamic subtest: pipe-D-DP-3
[377.196162] Dynamic subtest pipe-D-DP-3: SUCCESS (0.001s)
[377.197054] Subtest zero-clock: SUCCESS (0.093s)
[377.456026] [098/133] (654s left) kms_flip_scaled_crc (flip-32bpp-4tile-to-64bpp-4tile-upscaling)
[377.648730] Starting subtest: flip-32bpp-4tile-to-64bpp-4tile-upscaling
[377.651161] Starting dynamic subtest: pipe-A-valid-mode
[380.120639] Dynamic subtest pipe-A-valid-mode: SUCCESS (2.469s)
[380.122091] Subtest flip-32bpp-4tile-to-64bpp-4tile-upscaling: SUCCESS (2.473s)
[380.422821] [099/133] (651s left) kms_ccs (random-ccs-data-4-tiled-dg2-rc-ccs)
[380.621268] Starting subtest: random-ccs-data-4-tiled-dg2-rc-ccs
[380.622162] Starting dynamic subtest: pipe-A-DP-3
[380.631207] Dynamic subtest pipe-A-DP-3: SKIP (0.000s)
[380.641162] Starting dynamic subtest: pipe-B-DP-3
[380.650266] Dynamic subtest pipe-B-DP-3: SKIP (0.000s)
[380.660085] Starting dynamic subtest: pipe-C-DP-3
[380.669006] Dynamic subtest pipe-C-DP-3: SKIP (0.000s)
[380.678823] Starting dynamic subtest: pipe-D-DP-3
[380.689650] Dynamic subtest pipe-D-DP-3: SKIP (0.000s)
[380.691535] Subtest random-ccs-data-4-tiled-dg2-rc-ccs: SKIP (0.007s)
[381.119595] [100/133] (650s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-mmap-gtt)
[381.317063] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-mmap-gtt
[381.318642] Subtest psr-2p-scndscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[381.521110] [101/133] (650s left) gem_tiled_wc
[381.663546] [102/133] (650s left) kms_universal_plane (universal-plane-sanity)
[381.850421] Starting subtest: universal-plane-sanity
[381.851278] Starting dynamic subtest: pipe-A-DP-3
[382.482257] Dynamic subtest pipe-A-DP-3: SUCCESS (0.631s)
[382.500127] Starting dynamic subtest: pipe-B-DP-3
[382.981984] Dynamic subtest pipe-B-DP-3: SUCCESS (0.496s)
[382.998718] Starting dynamic subtest: pipe-C-DP-3
[383.470489] Dynamic subtest pipe-C-DP-3: SUCCESS (0.485s)
[383.485670] Starting dynamic subtest: pipe-D-DP-3
[383.965225] Dynamic subtest pipe-D-DP-3: SUCCESS (0.492s)
[383.966233] Subtest universal-plane-sanity: SUCCESS (2.116s)
[384.280411] [103/133] (647s left) kms_plane_alpha_blend (alpha-opaque-fb)
[384.473419] Starting subtest: alpha-opaque-fb
[384.724366] Starting dynamic subtest: pipe-A-DP-3
[385.254665] Dynamic subtest pipe-A-DP-3: SUCCESS (0.530s)
[385.266055] Starting dynamic subtest: pipe-D-DP-3
[385.832419] Dynamic subtest pipe-D-DP-3: SUCCESS (0.575s)
[385.833288] Subtest alpha-opaque-fb: SUCCESS (1.360s)
[386.165388] [104/133] (645s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt)
[386.357121] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt
[386.358753] Subtest fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[386.524367] [105/133] (645s left) kms_psr (psr2-primary-mmap-gtt)
[386.708350] Subtest psr2-primary-mmap-gtt: SKIP (0.000s)
[386.761409] [106/133] (645s left) gem_exec_schedule (semaphore-codependency)
[386.853497] Starting subtest: semaphore-codependency
[386.897430] Subtest semaphore-codependency: SUCCESS (0.044s)
[387.318799] [107/133] (644s left) gem_pread (bench)
[387.395247] Subtest bench: SKIP (0.000s)
[387.463895] [108/133] (644s left) drm_read (fault-buffer)
[387.719649] Starting subtest: fault-buffer
[387.720536] Subtest fault-buffer: SUCCESS (0.001s)
[387.999419] [109/133] (644s left) kms_frontbuffer_tracking (psr-2p-primscrn-shrfb-pgflip-blt)
[388.190999] Starting subtest: psr-2p-primscrn-shrfb-pgflip-blt
[388.192754] Subtest psr-2p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[388.383875] [110/133] (644s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-render)
[388.574239] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-render
[388.575883] Subtest fbc-2p-scndscrn-pri-shrfb-draw-render: SKIP (0.000s)
[388.737637] [111/133] (643s left) gem_softpin (evict-snoop)
[388.826702] Starting subtest: evict-snoop
[388.828430] Subtest evict-snoop: SKIP (0.000s)
[389.019950] [112/133] (643s left) kms_getfb (getfb-handle-not-fb)
[389.213302] Starting subtest: getfb-handle-not-fb
[389.214179] Subtest getfb-handle-not-fb: SUCCESS (0.000s)
[389.418982] [113/133] (643s left) syncobj_timeline (wait-all-delayed-signal)
[389.504484] Starting subtest: wait-all-delayed-signal
[389.607598] Subtest wait-all-delayed-signal: SUCCESS (0.102s)
[389.726046] [114/133] (643s left) kms_atomic (plane-invalid-params-fence)
[389.910702] Starting subtest: plane-invalid-params-fence
[389.913153] Starting dynamic subtest: pipe-A-DP-3
[390.446794] Dynamic subtest pipe-A-DP-3: SUCCESS (0.534s)
[390.447882] Subtest plane-invalid-params-fence: SUCCESS (0.537s)
[390.749923] [115/133] (642s left) gem_mmap_gtt (coherency)
[390.839439] Subtest coherency: SKIP (0.000s)
[390.921903] [116/133] (642s left) prime_mmap (test_forked_cpu_write)
[390.999715] Starting subtest: test_forked_cpu_write
[391.000601] Starting dynamic subtest: test_forked_cpu_write-smem
[391.008319] Dynamic subtest test_forked_cpu_write-smem: SUCCESS (0.008s)
[391.019783] Starting dynamic subtest: test_forked_cpu_write-lmem0
[391.020643] Dynamic subtest test_forked_cpu_write-lmem0: SUCCESS (0.008s)
[391.021795] Subtest test_forked_cpu_write: SUCCESS (0.018s)
[391.204736] [117/133] (641s left) kms_flip (2x-nonexisting-fb)
[391.390356] Starting subtest: 2x-nonexisting-fb
[391.405877] Subtest 2x-nonexisting-fb: SKIP (0.015s)
[391.598345] [118/133] (641s left) kms_flip (flip-vs-panning-interruptible)
[391.787160] Starting subtest: flip-vs-panning-interruptible
[391.792031] Starting dynamic subtest: A-DP3
[399.618760] Dynamic subtest A-DP3: SUCCESS (7.826s)
[399.654567] Starting dynamic subtest: B-DP3
[407.393118] Dynamic subtest B-DP3: SUCCESS (7.768s)
[407.428327] Starting dynamic subtest: C-DP3
[415.168928] Dynamic subtest C-DP3: SUCCESS (7.770s)
[415.201399] Starting dynamic subtest: D-DP3
[422.946886] Dynamic subtest D-DP3: SUCCESS (7.773s)
[422.955139] Subtest flip-vs-panning-interruptible: SUCCESS (31.167s)
[423.340334] [119/133] (609s left) kms_ccs (ccs-on-another-bo-y-tiled-ccs)
[423.528418] Starting subtest: ccs-on-another-bo-y-tiled-ccs
[423.529267] Starting dynamic subtest: pipe-A-DP-3
[423.537524] Dynamic subtest pipe-A-DP-3: SKIP (0.000s)
[423.547556] Starting dynamic subtest: pipe-B-DP-3
[423.556052] Dynamic subtest pipe-B-DP-3: SKIP (0.000s)
[423.565940] Starting dynamic subtest: pipe-C-DP-3
[423.574012] Dynamic subtest pipe-C-DP-3: SKIP (0.000s)
[423.584036] Starting dynamic subtest: pipe-D-DP-3
[423.593752] Dynamic subtest pipe-D-DP-3: SKIP (0.000s)
[423.595916] Subtest ccs-on-another-bo-y-tiled-ccs: SKIP (0.006s)
[424.030031] [120/133] (609s left) i915_pm_rpm (debugfs-forcewake-user)
[426.048115] Starting subtest: debugfs-forcewake-user
[436.757109] Subtest debugfs-forcewake-user: SUCCESS (10.713s)
[437.165680] [121/133] (596s left) gem_eio (throttle)
[437.481450] Starting subtest: throttle
[438.006459] Subtest throttle: SUCCESS (0.525s)
[438.247716] [122/133] (595s left) gem_ctx_param (invalid-size-set)
[438.325672] Starting subtest: invalid-size-set
[438.327948] Subtest invalid-size-set: SUCCESS (0.001s)
[438.511085] [123/133] (595s left) perf_pmu (pmu-read)
[438.580415] Starting subtest: pmu-read
[438.584302] Subtest pmu-read: SUCCESS (0.004s)
[438.759477] [124/133] (594s left) gem_lmem_swapping (verify-ccs)
[441.524277] Starting subtest: verify-ccs
[441.525362] Starting dynamic subtest: lmem0
[485.881225] Dynamic subtest lmem0: SUCCESS (44.356s)
[485.882146] Subtest verify-ccs: SUCCESS (44.357s)
[487.877640] [FACT gem_lmem_swapping (verify-ccs)] deleted: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[487.878635] [FACT gem_lmem_swapping (verify-ccs)] deleted: kernel.kmod_is_loaded.i915: true
[487.880988] [125/133] (545s left) gen9_exec_parse (batch-invalid-length)
[489.528245] Subtest batch-invalid-length: SKIP (0.000s)
[489.576854] [FACT gen9_exec_parse (batch-invalid-length)] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[489.579550] [FACT gen9_exec_parse (batch-invalid-length)] new: kernel.kmod_is_loaded.i915: true
[489.582108] [126/133] (544s left) gem_softpin (overlap)
[489.676647] Starting subtest: overlap
[492.857493] Subtest overlap: SUCCESS (3.180s)
[493.033280] [127/133] (540s left) kms_big_fb (4-tiled-8bpp-rotate-180)
[493.228951] Starting subtest: 4-tiled-8bpp-rotate-180
[494.773967] Subtest 4-tiled-8bpp-rotate-180: SUCCESS (1.544s)
[495.003182] [128/133] (538s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytilercccs-downscaling)
[495.198600] Starting subtest: flip-64bpp-ytile-to-32bpp-ytilercccs-downscaling
[495.200350] Subtest flip-64bpp-ytile-to-32bpp-ytilercccs-downscaling: SKIP (0.000s)
[495.325866] [129/133] (538s left) kms_psr2_sf (psr2-primary-plane-update-sf-dmg-area)
[495.518008] Subtest psr2-primary-plane-update-sf-dmg-area: SKIP (0.000s)
[495.582347] [130/133] (538s left) i915_pm_freq_api (freq-suspend)
[495.668592] Starting subtest: freq-suspend
[495.669473] Starting dynamic subtest: gt0
[513.939598] Dynamic subtest gt0: SUCCESS (4.009s)
[513.940648] Subtest freq-suspend: SUCCESS (4.011s)
[515.067161] [131/133] (519s left) prime_busy (after)
[515.158808] Starting subtest: after
[515.163679] Starting dynamic subtest: rcs0
[515.229788] Dynamic subtest rcs0: SUCCESS (0.066s)
[515.241220] Starting dynamic subtest: bcs0
[515.283789] Dynamic subtest bcs0: SUCCESS (0.053s)
[515.302016] Starting dynamic subtest: vcs0
[515.324945] Dynamic subtest vcs0: SUCCESS (0.040s)
[515.335935] Starting dynamic subtest: vcs1
[515.365271] Dynamic subtest vcs1: SUCCESS (0.039s)
[515.380946] Starting dynamic subtest: vecs0
[515.405209] Dynamic subtest vecs0: SUCCESS (0.039s)
[515.427347] Starting dynamic subtest: vecs1
[515.447358] Dynamic subtest vecs1: SUCCESS (0.041s)
[515.479399] Starting dynamic subtest: ccs0
[515.490402] Dynamic subtest ccs0: SUCCESS (0.040s)
[515.598292] Subtest after: SUCCESS (0.439s)
[515.784021] [132/133] (519s left) gem_exec_whisper (basic-contexts-forked)
[515.872103] Starting subtest: basic-contexts-forked
[538.457327] Subtest basic-contexts-forked: SUCCESS (22.583s)
[538.741005] [133/133] (496s left) syncobj_timeline (etime-single-wait-all-for-submit-unsubmitted)
[538.816192] Starting subtest: etime-single-wait-all-for-submit-unsubmitted
[538.920664] Subtest etime-single-wait-all-for-submit-unsubmitted: SUCCESS (0.104s)
[539.042810] Closing watchdogs
results: parsing output: 0/ for test: kms_color
results: parsing output: 1/ for test: kms_frontbuffer_tracking
results: parsing output: 2/ for test: gem_exec_balancer
results: parsing output: 3/ for test: kms_cursor_legacy
results: parsing output: 4/ for test: kms_busy
results: parsing output: 5/ for test: kms_draw_crc
results: parsing output: 6/ for test: kms_content_protection
results: parsing output: 7/ for test: kms_cursor_crc
results: parsing output: 8/ for test: gem_render_copy
results: parsing output: 9/ for test: gem_exec_fence
results: parsing output: 10/ for test: gem_exec_flush
results: parsing output: 11/ for test: gem_exec_schedule
results: parsing output: 12/ for test: kms_frontbuffer_tracking
results: parsing output: 13/ for test: gem_fence_thrash
results: parsing output: 14/ for test: kms_addfb_basic
results: parsing output: 15/ for test: gem_pxp
results: parsing output: 16/ for test: gem_exec_schedule
results: parsing output: 17/ for test: kms_chamelium_edid
results: parsing output: 18/ for test: kms_ccs
results: parsing output: 19/ for test: gem_ctx_param
results: parsing output: 20/ for test: kms_frontbuffer_tracking
results: parsing output: 21/ for test: i915_pm_rps
results: parsing output: 22/ for test: gem_close
results: parsing output: 23/ for test: kms_frontbuffer_tracking
results: parsing output: 24/ for test: kms_chamelium_hpd
results: parsing output: 25/ for test: kms_big_fb
results: parsing output: 26/ for test: gem_mmap_offset
results: parsing output: 27/ for test: kms_pipe_b_c_ivb
results: parsing output: 28/ for test: kms_psr
results: parsing output: 29/ for test: gem_exec_reloc
results: parsing output: 30/ for test: kms_setmode
results: parsing output: 31/ for test: gem_exec_alignment
results: parsing output: 32/ for test: gem_ctx_persistence
results: parsing output: 33/ for test: kms_display_modes
results: parsing output: 34/ for test: kms_plane
results: parsing output: 35/ for test: kms_pm_backlight
results: parsing output: 36/ for test: syncobj_timeline
results: parsing output: 37/ for test: kms_mmap_write_crc
results: parsing output: 38/ for test: gem_spin_batch
results: parsing output: 39/ for test: kms_flip
results: parsing output: 40/ for test: kms_rotation_crc
results: parsing output: 41/ for test: gem_exec_alignment
results: parsing output: 42/ for test: kms_big_fb
results: parsing output: 43/ for test: kms_frontbuffer_tracking
results: parsing output: 44/ for test: syncobj_wait
results: parsing output: 45/ for test: kms_async_flips
results: parsing output: 46/ for test: kms_frontbuffer_tracking
results: parsing output: 47/ for test: perf
results: parsing output: 48/ for test: gem_render_copy_redux
results: parsing output: 49/ for test: gem_userptr_blits
results: parsing output: 50/ for test: kms_frontbuffer_tracking
results: parsing output: 51/ for test: gem_lmem_swapping
results: parsing output: 52/ for test: core_getclient
results: parsing output: 53/ for test: kms_cursor_crc
results: parsing output: 54/ for test: kms_plane_lowres
results: parsing output: 55/ for test: api_intel_allocator
results: parsing output: 56/ for test: i915_drm_fdinfo
results: parsing output: 57/ for test: gem_exec_parallel
results: parsing output: 58/ for test: kms_frontbuffer_tracking
results: parsing output: 59/ for test: kms_getfb
results: parsing output: 60/ for test: perf
results: parsing output: 61/ for test: kms_psr2_sf
results: parsing output: 62/ for test: kms_frontbuffer_tracking
results: parsing output: 63/ for test: kms_ccs
results: parsing output: 64/ for test: kms_frontbuffer_tracking
results: parsing output: 65/ for test: kms_frontbuffer_tracking
results: parsing output: 66/ for test: kms_pm_rpm
results: parsing output: 67/ for test: gem_ccs
results: parsing output: 68/ for test: kms_big_fb
results: parsing output: 69/ for test: kms_cursor_edge_walk
results: parsing output: 70/ for test: syncobj_timeline
results: parsing output: 71/ for test: gem_exec_capture
results: parsing output: 72/ for test: kms_plane
results: parsing output: 73/ for test: kms_hdr
results: parsing output: 74/ for test: syncobj_wait
results: parsing output: 75/ for test: kms_vrr
results: parsing output: 76/ for test: kms_big_fb
results: parsing output: 77/ for test: kms_addfb_basic
results: parsing output: 78/ for test: kms_psr
results: parsing output: 79/ for test: kms_psr
results: parsing output: 80/ for test: kms_frontbuffer_tracking
results: parsing output: 81/ for test: kms_prop_blob
results: parsing output: 82/ for test: sysfs_preempt_timeout
results: parsing output: 83/ for test: kms_psr
results: parsing output: 84/ for test: gem_exec_reloc
results: parsing output: 85/ for test: kms_chamelium_color
results: parsing output: 86/ for test: kms_flip_scaled_crc
results: parsing output: 87/ for test: kms_frontbuffer_tracking
results: parsing output: 88/ for test: kms_frontbuffer_tracking
results: parsing output: 89/ for test: kms_big_fb
results: parsing output: 90/ for test: syncobj_eventfd
results: parsing output: 91/ for test: gem_sync
results: parsing output: 92/ for test: core_getversion
results: parsing output: 93/ for test: gem_ctx_exec
results: parsing output: 94/ for test: kms_frontbuffer_tracking
results: parsing output: 95/ for test: kms_prop_blob
results: parsing output: 96/ for test: kms_invalid_mode
results: parsing output: 97/ for test: kms_flip_scaled_crc
results: parsing output: 98/ for test: kms_ccs
results: parsing output: 99/ for test: kms_frontbuffer_tracking
results: parsing output: 100/ for test: gem_tiled_wc
results: parsing output: 101/ for test: kms_universal_plane
results: parsing output: 102/ for test: kms_plane_alpha_blend
results: parsing output: 103/ for test: kms_frontbuffer_tracking
results: parsing output: 104/ for test: kms_psr
results: parsing output: 105/ for test: gem_exec_schedule
results: parsing output: 106/ for test: gem_pread
results: parsing output: 107/ for test: drm_read
results: parsing output: 108/ for test: kms_frontbuffer_tracking
results: parsing output: 109/ for test: kms_frontbuffer_tracking
results: parsing output: 110/ for test: gem_softpin
results: parsing output: 111/ for test: kms_getfb
results: parsing output: 112/ for test: syncobj_timeline
results: parsing output: 113/ for test: kms_atomic
results: parsing output: 114/ for test: gem_mmap_gtt
results: parsing output: 115/ for test: prime_mmap
results: parsing output: 116/ for test: kms_flip
results: parsing output: 117/ for test: kms_flip
results: parsing output: 118/ for test: kms_ccs
results: parsing output: 119/ for test: i915_pm_rpm
results: parsing output: 120/ for test: gem_eio
results: parsing output: 121/ for test: gem_ctx_param
results: parsing output: 122/ for test: perf_pmu
results: parsing output: 123/ for test: gem_lmem_swapping
results: parsing output: 124/ for test: gen9_exec_parse
results: parsing output: 125/ for test: gem_softpin
results: parsing output: 126/ for test: kms_big_fb
results: parsing output: 127/ for test: kms_flip_scaled_crc
results: parsing output: 128/ for test: kms_psr2_sf
results: parsing output: 129/ for test: i915_pm_freq_api
results: parsing output: 130/ for test: prime_busy
results: parsing output: 131/ for test: gem_exec_whisper
results: parsing output: 132/ for test: syncobj_timeline
Done.